Re: Still seeing hangs in xlog_grant_log_space

Chris J Arges
2012-05-18T16:53:39Z

[-- Attachment #1: Type: text/plain, Size: 1403 bytes --]

On 05/17/2012 03:55 PM, Chris J Arges wrote:
> On 05/16/2012 01:42 PM, Ben Myers wrote:
>> Hey Chris,
>>
>> On Thu, May 10, 2012 at 04:11:27PM +0000, Chris J Arges wrote:
>>> <snip>
>>>> Canonical attached them to the bug report that they filed yesterday:
>>>> http://oss.sgi.com/bugzilla/show_bug.cgi?id=922
>>>>
>>>> ...Juerg
>>>>
>>>
>>> Hello,
>>> I am able to reproduce this bug with the instructions posted in this bug. Let me
>>> know what I can do to help.
>>
>> The bug shows:
>>
>> |This has been tested on the following kernels which all exhibit the same
>> |failures:
>> |- 3.2.0-24 (Ubuntu Precise)
>> |- 3.4.0-rc4
>> |- 3.0.29
>> |- 3.1.10
>> |- 3.2.15
>> |- 3.3.2
>>
>> Can you find an older kernel that isn't broken?
>>
> Tested with Ubuntu Lucid 2.6.32-38-generic #38 (upstream 2.6.32.52), so
> far I am able to run the test for 5 hours, which on the same machine I
> have typically been able to reproduce in 2 hours. Will continue to run
> this, and on another system to verify.
>

Tested with Ubuntu Lucid 2.6.32-38-generic #38 (upstream 2.6.32.52).
This also fails, attaching the dmesg output as the backtrace looks
similar. Let me know if you'd like me to try any other versions.

The first test I did with lucid, it ran for 7 hours, and I stopped the
test. This morning I re-ran and it failed within 10 minutes. I guess I
got lucky the second time.

> --chris
>
>> -Ben
>>
>

[-- Attachment #2: lucid-2.6.32-xfs-hang.dmesg --]
[-- Type: text/plain, Size: 68856 bytes --]

[ 0.000000] Initializing cgroup subsys cpuset
[ 0.000000] Initializing cgroup subsys cpu
[ 0.000000] Linux version 2.6.32-38-generic (buildd@allspice) (gcc version 4.4.3 (Ubuntu 4.4.3-4ubuntu5) ) #83-Ubuntu SMP Wed Jan 4 11:12:07 UTC 2012 (Ubuntu 2.6.32-38.83-generic 2.6.32.52+drm33.21)
[ 0.000000] Command line: noprompt cdrom-detect/try-usb=true file=/cdrom/preseed/ubuntu.seed boot=casper initrd=/casper/initrd.lz quiet splash -- BOOT_IMAGE=/casper/vmlinuz
[ 0.000000] KERNEL supported cpus:
[ 0.000000] Intel GenuineIntel
[ 0.000000] AMD AuthenticAMD
[ 0.000000] Centaur CentaurHauls
[ 0.000000] BIOS-provided physical RAM map:
[ 0.000000] BIOS-e820: 0000000000000000 - 000000000009d800 (usable)
[ 0.000000] BIOS-e820: 000000000009d800 - 00000000000a0000 (reserved)
[ 0.000000] BIOS-e820: 00000000000e0000 - 0000000000100000 (reserved)
[ 0.000000] BIOS-e820: 0000000000100000 - 0000000020000000 (usable)
[ 0.000000] BIOS-e820: 0000000020000000 - 0000000020200000 (reserved)
[ 0.000000] BIOS-e820: 0000000020200000 - 0000000040000000 (usable)
[ 0.000000] BIOS-e820: 0000000040000000 - 0000000040200000 (reserved)
[ 0.000000] BIOS-e820: 0000000040200000 - 00000000da99f000 (usable)
[ 0.000000] BIOS-e820: 00000000da99f000 - 00000000dae9f000 (reserved)
[ 0.000000] BIOS-e820: 00000000dae9f000 - 00000000daf9f000 (ACPI NVS)
[ 0.000000] BIOS-e820: 00000000daf9f000 - 00000000dafff000 (ACPI data)
[ 0.000000] BIOS-e820: 00000000dafff000 - 00000000db000000 (usable)
[ 0.000000] BIOS-e820: 00000000db000000 - 00000000dfa00000 (reserved)
[ 0.000000] BIOS-e820: 00000000f8000000 - 00000000fc000000 (reserved)
[ 0.000000] BIOS-e820: 00000000fec00000 - 00000000fec01000 (reserved)
[ 0.000000] BIOS-e820: 00000000fed08000 - 00000000fed09000 (reserved)
[ 0.000000] BIOS-e820: 00000000fed10000 - 00000000fed1a000 (reserved)
[ 0.000000] BIOS-e820: 00000000fed1c000 - 00000000fed20000 (reserved)
[ 0.000000] BIOS-e820: 00000000fee00000 - 00000000fee01000 (reserved)
[ 0.000000] BIOS-e820: 00000000ffd20000 - 0000000100000000 (reserved)
[ 0.000000] BIOS-e820: 0000000100000000 - 000000021e600000 (usable)
[ 0.000000] BIOS-e820: 000000021e600000 - 000000021e800000 (reserved)
[ 0.000000] DMI 2.6 present.
[ 0.000000] last_pfn = 0x21e600 max_arch_pfn = 0x400000000
[ 0.000000] MTRR default type: uncachable
[ 0.000000] MTRR fixed ranges enabled:
[ 0.000000] 00000-9FFFF write-back
[ 0.000000] A0000-BFFFF uncachable
[ 0.000000] C0000-FFFFF write-protect
[ 0.000000] MTRR variable ranges enabled:
[ 0.000000] 0 base 0FFC00000 mask FFFC00000 write-protect
[ 0.000000] 1 base 000000000 mask F80000000 write-back
[ 0.000000] 2 base 080000000 mask FC0000000 write-back
[ 0.000000] 3 base 0C0000000 mask FE0000000 write-back
[ 0.000000] 4 base 0DC000000 mask FFC000000 uncachable
[ 0.000000] 5 base 0DB000000 mask FFF000000 uncachable
[ 0.000000] 6 base 100000000 mask F00000000 write-back
[ 0.000000] 7 base 200000000 mask FE0000000 write-back
[ 0.000000] 8 base 21F000000 mask FFF000000 uncachable
[ 0.000000] 9 base 21E800000 mask FFF800000 uncachable
[ 0.000000] x86 PAT enabled: cpu 0, old 0x7040600070406, new 0x7010600070106
[ 0.000000] last_pfn = 0xdb000 max_arch_pfn = 0x400000000
[ 0.000000] e820 update range: 0000000000001000 - 0000000000006000 (usable) ==> (reserved)
[ 0.000000] Scanning 1 areas for low memory corruption
[ 0.000000] modified physical RAM map:
[ 0.000000] modified: 0000000000000000 - 0000000000001000 (usable)
[ 0.000000] modified: 0000000000001000 - 0000000000006000 (reserved)
[ 0.000000] modified: 0000000000006000 - 000000000009d800 (usable)
[ 0.000000] modified: 000000000009d800 - 00000000000a0000 (reserved)
[ 0.000000] modified: 00000000000e0000 - 0000000000100000 (reserved)
[ 0.000000] modified: 0000000000100000 - 0000000020000000 (usable)
[ 0.000000] modified: 0000000020000000 - 0000000020200000 (reserved)
[ 0.000000] modified: 0000000020200000 - 0000000040000000 (usable)
[ 0.000000] modified: 0000000040000000 - 0000000040200000 (reserved)
[ 0.000000] modified: 0000000040200000 - 00000000da99f000 (usable)
[ 0.000000] modified: 00000000da99f000 - 00000000dae9f000 (reserved)
[ 0.000000] modified: 00000000dae9f000 - 00000000daf9f000 (ACPI NVS)
[ 0.000000] modified: 00000000daf9f000 - 00000000dafff000 (ACPI data)
[ 0.000000] modified: 00000000dafff000 - 00000000db000000 (usable)
[ 0.000000] modified: 00000000db000000 - 00000000dfa00000 (reserved)
[ 0.000000] modified: 00000000f8000000 - 00000000fc000000 (reserved)
[ 0.000000] modified: 00000000fec00000 - 00000000fec01000 (reserved)
[ 0.000000] modified: 00000000fed08000 - 00000000fed09000 (reserved)
[ 0.000000] modified: 00000000fed10000 - 00000000fed1a000 (reserved)
[ 0.000000] modified: 00000000fed1c000 - 00000000fed20000 (reserved)
[ 0.000000] modified: 00000000fee00000 - 00000000fee01000 (reserved)
[ 0.000000] modified: 00000000ffd20000 - 0000000100000000 (reserved)
[ 0.000000] modified: 0000000100000000 - 000000021e600000 (usable)
[ 0.000000] modified: 000000021e600000 - 000000021e800000 (reserved)
[ 0.000000] initial memory mapped : 0 - 20000000
[ 0.000000] init_memory_mapping: 0000000000000000-00000000db000000
[ 0.000000] NX (Execute Disable) protection: active
[ 0.000000] 0000000000 - 00db000000 page 2M
[ 0.000000] kernel direct mapping tables up to db000000 @ 8000-d000
[ 0.000000] init_memory_mapping: 0000000100000000-000000021e600000
[ 0.000000] NX (Execute Disable) protection: active
[ 0.000000] 0100000000 - 021e600000 page 2M
[ 0.000000] kernel direct mapping tables up to 21e600000 @ b000-15000
[ 0.000000] RAMDISK: 1f690000 - 1fffe884
[ 0.000000] ACPI: RSDP 00000000000f00e0 00024 (v02 LENOVO)
[ 0.000000] ACPI: XSDT 00000000daffe120 000AC (v01 LENOVO TP-8D 00001250 PTEC 00000002)
[ 0.000000] ACPI: FACP 00000000dafe7000 000F4 (v04 LENOVO TP-8D 00001250 PTL 00000002)
[ 0.000000] ACPI: DSDT 00000000dafea000 0F6A7 (v01 LENOVO TP-8D 00001250 INTL 20061109)
[ 0.000000] ACPI: FACS 00000000daf2d000 00040
[ 0.000000] ACPI: SLIC 00000000daffd000 00176 (v01 LENOVO TP-8D 00001250 PTEC 00000001)
[ 0.000000] ACPI: SSDT 00000000daffc000 00249 (v01 LENOVO TP-SSDT2 00000200 INTL 20061109)
[ 0.000000] ACPI: SSDT 00000000daffb000 00033 (v01 LENOVO TP-SSDT1 00000100 INTL 20061109)
[ 0.000000] ACPI: SSDT 00000000daffa000 007D1 (v01 LENOVO SataAhci 00001000 INTL 20061109)
[ 0.000000] ACPI: HPET 00000000dafe6000 00038 (v01 LENOVO TP-8D 00001250 PTL 00000002)
[ 0.000000] ACPI: APIC 00000000dafe5000 00098 (v01 LENOVO TP-8D 00001250 PTL 00000002)
[ 0.000000] ACPI: MCFG 00000000dafe4000 0003C (v01 LENOVO TP-8D 00001250 PTL 00000002)
[ 0.000000] ACPI: ECDT 00000000dafe3000 00052 (v01 LENOVO TP-8D 00001250 PTL 00000002)
[ 0.000000] ACPI: ASF! 00000000dafe9000 000A5 (v32 LENOVO TP-8D 00001250 PTL 00000002)
[ 0.000000] ACPI: TCPA 00000000dafe2000 00032 (v02 PTL LENOVO 06040000 LNVO 00000001)
[ 0.000000] ACPI: SSDT 00000000dafe1000 00A27 (v01 PmRef Cpu0Ist 00003000 INTL 20061109)
[ 0.000000] ACPI: SSDT 00000000dafe0000 00996 (v01 PmRef CpuPm 00003000 INTL 20061109)
[ 0.000000] ACPI: DMAR 00000000dafdf000 000E8 (v01 INTEL SNB 00000001 INTL 00000001)
[ 0.000000] ACPI: UEFI 00000000dafde000 0003E (v01 LENOVO TP-8D 00001250 PTL 00000002)
[ 0.000000] ACPI: UEFI 00000000dafdd000 00042 (v01 PTL COMBUF 00000001 PTL 00000001)
[ 0.000000] ACPI: UEFI 00000000dafdc000 00292 (v01 LENOVO TP-8D 00001250 PTL 00000002)
[ 0.000000] ACPI: Local APIC address 0xfee00000
[ 0.000000] No NUMA configuration found
[ 0.000000] Faking a node at 0000000000000000-000000021e600000
[ 0.000000] Bootmem setup node 0 0000000000000000-000000021e600000
[ 0.000000] NODE_DATA [0000000000010000 - 0000000000014fff]
[ 0.000000] bootmap [0000000000015000 - 0000000000058cbf] pages 44
[ 0.000000] (8 early reservations) ==> bootmem [0000000000 - 021e600000]
[ 0.000000] #0 [0000000000 - 0000001000] BIOS data page ==> [0000000000 - 0000001000]
[ 0.000000] #1 [0000006000 - 0000008000] TRAMPOLINE ==> [0000006000 - 0000008000]
[ 0.000000] #2 [0001000000 - 0001a35ac4] TEXT DATA BSS ==> [0001000000 - 0001a35ac4]
[ 0.000000] #3 [001f690000 - 001fffe884] RAMDISK ==> [001f690000 - 001fffe884]
[ 0.000000] #4 [000009d800 - 0000100000] BIOS reserved ==> [000009d800 - 0000100000]
[ 0.000000] #5 [0001a36000 - 0001a360ed] BRK ==> [0001a36000 - 0001a360ed]
[ 0.000000] #6 [0000008000 - 000000b000] PGTABLE ==> [0000008000 - 000000b000]
[ 0.000000] #7 [000000b000 - 0000010000] PGTABLE ==> [000000b000 - 0000010000]
[ 0.000000] [ffffea0000000000-ffffea00077fffff] PMD -> [ffff88002c600000-ffff8800337fffff] on node 0
[ 0.000000] Zone PFN ranges:
[ 0.000000] DMA 0x00000000 -> 0x00001000
[ 0.000000] DMA32 0x00001000 -> 0x00100000
[ 0.000000] Normal 0x00100000 -> 0x0021e600
[ 0.000000] Movable zone start PFN for each node
[ 0.000000] early_node_map[7] active PFN ranges
[ 0.000000] 0: 0x00000000 -> 0x00000001
[ 0.000000] 0: 0x00000006 -> 0x0000009d
[ 0.000000] 0: 0x00000100 -> 0x00020000
[ 0.000000] 0: 0x00020200 -> 0x00040000
[ 0.000000] 0: 0x00040200 -> 0x000da99f
[ 0.000000] 0: 0x000dafff -> 0x000db000
[ 0.000000] 0: 0x00100000 -> 0x0021e600
[ 0.000000] On node 0 totalpages: 2067256
[ 0.000000] DMA zone: 56 pages used for memmap
[ 0.000000] DMA zone: 109 pages reserved
[ 0.000000] DMA zone: 3827 pages, LIFO batch:0
[ 0.000000] DMA32 zone: 14280 pages used for memmap
[ 0.000000] DMA32 zone: 875992 pages, LIFO batch:31
[ 0.000000] Normal zone: 16037 pages used for memmap
[ 0.000000] Normal zone: 1156955 pages, LIFO batch:31
[ 0.000000] ACPI: PM-Timer IO Port: 0x408
[ 0.000000] ACPI: Local APIC address 0xfee00000
[ 0.000000] ACPI: LAPIC (acpi_id[0x01] lapic_id[0x00] enabled)
[ 0.000000] ACPI: LAPIC (acpi_id[0x02] lapic_id[0x01] enabled)
[ 0.000000] ACPI: LAPIC (acpi_id[0x03] lapic_id[0x02] enabled)
[ 0.000000] ACPI: LAPIC (acpi_id[0x04] lapic_id[0x03] enabled)
[ 0.000000] ACPI: LAPIC (acpi_id[0x05] lapic_id[0x00] disabled)
[ 0.000000] ACPI: LAPIC (acpi_id[0x06] lapic_id[0x00] disabled)
[ 0.000000] ACPI: LAPIC (acpi_id[0x07] lapic_id[0x00] disabled)
[ 0.000000] ACPI: LAPIC (acpi_id[0x08] lapic_id[0x00] disabled)
[ 0.000000] ACPI: LAPIC_NMI (acpi_id[0x00] high edge lint[0x1])
[ 0.000000] ACPI: LAPIC_NMI (acpi_id[0x01] high edge lint[0x1])
[ 0.000000] ACPI: IOAPIC (id[0x02] address[0xfec00000] gsi_base[0])
[ 0.000000] IOAPIC[0]: apic_id 2, version 32, address 0xfec00000, GSI 0-23
[ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl)
[ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level)
[ 0.000000] ACPI: IRQ0 used by override.
[ 0.000000] ACPI: IRQ2 used by override.
[ 0.000000] ACPI: IRQ9 used by override.
[ 0.000000] Using ACPI (MADT) for SMP configuration information
[ 0.000000] ACPI: HPET id: 0x8086a301 base: 0xfed00000
[ 0.000000] SMP: Allowing 8 CPUs, 4 hotplug CPUs
[ 0.000000] nr_irqs_gsi: 24
[ 0.000000] PM: Registered nosave memory: 0000000000001000 - 0000000000006000
[ 0.000000] PM: Registered nosave memory: 000000000009d000 - 000000000009e000
[ 0.000000] PM: Registered nosave memory: 000000000009e000 - 00000000000a0000
[ 0.000000] PM: Registered nosave memory: 00000000000a0000 - 00000000000e0000
[ 0.000000] PM: Registered nosave memory: 00000000000e0000 - 0000000000100000
[ 0.000000] PM: Registered nosave memory: 0000000020000000 - 0000000020200000
[ 0.000000] PM: Registered nosave memory: 0000000040000000 - 0000000040200000
[ 0.000000] PM: Registered nosave memory: 00000000da99f000 - 00000000dae9f000
[ 0.000000] PM: Registered nosave memory: 00000000dae9f000 - 00000000daf9f000
[ 0.000000] PM: Registered nosave memory: 00000000daf9f000 - 00000000dafff000
[ 0.000000] PM: Registered nosave memory: 00000000db000000 - 00000000dfa00000
[ 0.000000] PM: Registered nosave memory: 00000000dfa00000 - 00000000f8000000
[ 0.000000] PM: Registered nosave memory: 00000000f8000000 - 00000000fc000000
[ 0.000000] PM: Registered nosave memory: 00000000fc000000 - 00000000fec00000
[ 0.000000] PM: Registered nosave memory: 00000000fec00000 - 00000000fec01000
[ 0.000000] PM: Registered nosave memory: 00000000fec01000 - 00000000fed08000
[ 0.000000] PM: Registered nosave memory: 00000000fed08000 - 00000000fed09000
[ 0.000000] PM: Registered nosave memory: 00000000fed09000 - 00000000fed10000
[ 0.000000] PM: Registered nosave memory: 00000000fed10000 - 00000000fed1a000
[ 0.000000] PM: Registered nosave memory: 00000000fed1a000 - 00000000fed1c000
[ 0.000000] PM: Registered nosave memory: 00000000fed1c000 - 00000000fed20000
[ 0.000000] PM: Registered nosave memory: 00000000fed20000 - 00000000fee00000
[ 0.000000] PM: Registered nosave memory: 00000000fee00000 - 00000000fee01000
[ 0.000000] PM: Registered nosave memory: 00000000fee01000 - 00000000ffd20000
[ 0.000000] PM: Registered nosave memory: 00000000ffd20000 - 0000000100000000
[ 0.000000] Allocating PCI resources starting at dfa00000 (gap: dfa00000:18600000)
[ 0.000000] Booting paravirtualized kernel on bare hardware
[ 0.000000] NR_CPUS:64 nr_cpumask_bits:64 nr_cpu_ids:8 nr_node_ids:1
[ 0.000000] PERCPU: Embedded 30 pages/cpu @ffff88002c200000 s91608 r8192 d23080 u262144
[ 0.000000] pcpu-alloc: s91608 r8192 d23080 u262144 alloc=1*2097152
[ 0.000000] pcpu-alloc: [0] 0 1 2 3 4 5 6 7
[ 0.000000] Built 1 zonelists in Zone order, mobility grouping on. Total pages: 2036774
[ 0.000000] Policy zone: Normal
[ 0.000000] Kernel command line: noprompt cdrom-detect/try-usb=true file=/cdrom/preseed/ubuntu.seed boot=casper initrd=/casper/initrd.lz quiet splash -- BOOT_IMAGE=/casper/vmlinuz
[ 0.000000] PID hash table entries: 4096 (order: 3, 32768 bytes)
[ 0.000000] Initializing CPU#0
[ 0.000000] xsave/xrstor: enabled xstate_bv 0x7, cntxt size 0x340
[ 0.000000] Checking aperture...
[ 0.000000] No AGP bridge found
[ 0.000000] Calgary: detecting Calgary via BIOS EBDA area
[ 0.000000] Calgary: Unable to locate Rio Grande table in EBDA - bailing!
[ 0.000000] PCI-DMA: Using software bounce buffering for IO (SWIOTLB)
[ 0.000000] Placing 64MB software IO TLB between ffff880024000000 - ffff880028000000
[ 0.000000] software IO TLB at phys 0x24000000 - 0x28000000
[ 0.000000] Memory: 8064904k/8886272k available (5436k kernel code, 617248k absent, 204120k reserved, 2982k data, 884k init)
[ 0.000000] SLUB: Genslabs=14, HWalign=64, Order=0-3, MinObjects=0, CPUs=8, Nodes=1
[ 0.000000] Hierarchical RCU implementation.
[ 0.000000] NR_IRQS:4352 nr_irqs:472
[ 0.000000] Extended CMOS year: 2000
[ 0.000000] Console: colour VGA+ 80x25
[ 0.000000] console [tty0] enabled
[ 0.000000] allocated 83886080 bytes of page_cgroup
[ 0.000000] please try 'cgroup_disable=memory' option if you don't want memory cgroups
[ 0.000000] hpet clockevent registered
[ 0.000000] Fast TSC calibration using PIT
[ 0.010000] Detected 2491.853 MHz processor.
[ 0.000003] Calibrating delay loop (skipped), value calculated using timer frequency.. 4983.70 BogoMIPS (lpj=24918530)
[ 0.000017] Security Framework initialized
[ 0.000028] AppArmor: AppArmor initialized
[ 0.000595] Dentry cache hash table entries: 1048576 (order: 11, 8388608 bytes)
[ 0.002213] Inode-cache hash table entries: 524288 (order: 10, 4194304 bytes)
[ 0.002888] Mount-cache hash table entries: 256
[ 0.002970] Initializing cgroup subsys ns
[ 0.002973] Initializing cgroup subsys cpuacct
[ 0.002975] Initializing cgroup subsys memory
[ 0.002979] Initializing cgroup subsys devices
[ 0.002981] Initializing cgroup subsys freezer
[ 0.002983] Initializing cgroup subsys net_cls
[ 0.002997] CPU: Physical Processor ID: 0
[ 0.002998] CPU: Processor Core ID: 0
[ 0.003002] CPU: L1 I cache: 32K, L1 D cache: 32K
[ 0.003003] CPU: L2 cache: 256K
[ 0.003004] CPU: L3 cache: 3072K
[ 0.003007] CPU 0/0x0 -> Node 0
[ 0.003009] mce: CPU supports 7 MCE banks
[ 0.003019] CPU0: Thermal monitoring enabled (TM1)
[ 0.003021] CPU 0 MCA banks CMCI:0 CMCI:1 CMCI:3 CMCI:5 CMCI:6
[ 0.003030] using mwait in idle threads.
[ 0.003031] Performance Events: Nehalem/Corei7 events, Intel PMU driver.
[ 0.003035] ... version: 3
[ 0.003036] ... bit width: 48
[ 0.003037] ... generic registers: 4
[ 0.003038] ... value mask: 0000ffffffffffff
[ 0.003040] ... max period: 000000007fffffff
[ 0.003041] ... fixed-purpose events: 3
[ 0.003042] ... event mask: 000000070000000f
[ 0.005291] ACPI: Core revision 20090903
[ 0.023306] ftrace: converting mcount calls to 0f 1f 44 00 00
[ 0.023309] ftrace: allocating 22567 entries in 89 pages
[ 0.031442] Not enabling x2apic, Intr-remapping init failed.
[ 0.031445] Setting APIC routing to flat
[ 0.031789] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1
[ 0.131568] CPU0: Intel(R) Core(TM) i5-2520M CPU @ 2.50GHz stepping 07
[ 0.247700] Booting processor 1 APIC 0x1 ip 0x6000
[ 0.258022] Initializing CPU#1
[ 0.407246] CPU: Physical Processor ID: 0
[ 0.407248] CPU: Processor Core ID: 0
[ 0.407250] CPU: L1 I cache: 32K, L1 D cache: 32K
[ 0.407252] CPU: L2 cache: 256K
[ 0.407253] CPU: L3 cache: 3072K
[ 0.407256] CPU 1/0x1 -> Node 0
[ 0.407268] CPU1: Thermal monitoring enabled (TM1)
[ 0.407270] CPU 1 MCA banks SHD:0 SHD:1 SHD:3 SHD:5 SHD:6
[ 0.407348] CPU1: Intel(R) Core(TM) i5-2520M CPU @ 2.50GHz stepping 07
[ 0.407357] checking TSC synchronization [CPU#0 -> CPU#1]: passed.
[ 0.427385] Booting processor 2 APIC 0x2 ip 0x6000
[ 0.437684] Initializing CPU#2
[ 0.586837] CPU: Physical Processor ID: 0
[ 0.586838] CPU: Processor Core ID: 1
[ 0.586840] CPU: L1 I cache: 32K, L1 D cache: 32K
[ 0.586842] CPU: L2 cache: 256K
[ 0.586842] CPU: L3 cache: 3072K
[ 0.586844] CPU 2/0x2 -> Node 0
[ 0.586855] CPU2: Thermal monitoring enabled (TM1)
[ 0.586857] CPU 2 MCA banks CMCI:0 CMCI:1 CMCI:3 SHD:5 SHD:6
[ 0.586914] CPU2: Intel(R) Core(TM) i5-2520M CPU @ 2.50GHz stepping 07
[ 0.586921] checking TSC synchronization [CPU#0 -> CPU#2]: passed.
[ 0.606946] Booting processor 3 APIC 0x3 ip 0x6000
[ 0.617245] Initializing CPU#3
[ 0.766427] CPU: Physical Processor ID: 0
[ 0.766428] CPU: Processor Core ID: 1
[ 0.766430] CPU: L1 I cache: 32K, L1 D cache: 32K
[ 0.766431] CPU: L2 cache: 256K
[ 0.766432] CPU: L3 cache: 3072K
[ 0.766434] CPU 3/0x3 -> Node 0
[ 0.766444] CPU3: Thermal monitoring enabled (TM1)
[ 0.766446] CPU 3 MCA banks SHD:0 SHD:1 SHD:3 SHD:5 SHD:6
[ 0.766469] CPU3: Intel(R) Core(TM) i5-2520M CPU @ 2.50GHz stepping 07
[ 0.766476] checking TSC synchronization [CPU#0 -> CPU#3]: passed.
[ 0.786448] Brought up 4 CPUs
[ 0.786449] Total of 4 processors activated (19935.08 BogoMIPS).
[ 0.788648] CPU0 attaching sched-domain:
[ 0.788651] domain 0: span 0-1 level SIBLING
[ 0.788653] groups: 0 (cpu_power = 589) 1 (cpu_power = 589)
[ 0.788657] domain 1: span 0-3 level MC
[ 0.788658] groups: 0-1 (cpu_power = 1178) 2-3 (cpu_power = 1178)
[ 0.788664] CPU1 attaching sched-domain:
[ 0.788665] domain 0: span 0-1 level SIBLING
[ 0.788666] groups: 1 (cpu_power = 589) 0 (cpu_power = 589)
[ 0.788670] domain 1: span 0-3 level MC
[ 0.788671] groups: 0-1 (cpu_power = 1178) 2-3 (cpu_power = 1178)
[ 0.788674] CPU2 attaching sched-domain:
[ 0.788676] domain 0: span 2-3 level SIBLING
[ 0.788677] groups: 2 (cpu_power = 589) 3 (cpu_power = 589)
[ 0.788680] domain 1: span 0-3 level MC
[ 0.788681] groups: 2-3 (cpu_power = 1178) 0-1 (cpu_power = 1178)
[ 0.788685] CPU3 attaching sched-domain:
[ 0.788686] domain 0: span 2-3 level SIBLING
[ 0.788687] groups: 3 (cpu_power = 589) 2 (cpu_power = 589)
[ 0.788690] domain 1: span 0-3 level MC
[ 0.788692] groups: 2-3 (cpu_power = 1178) 0-1 (cpu_power = 1178)
[ 0.788883] devtmpfs: initialized
[ 0.789117] regulator: core version 0.5
[ 0.789141] Time: 16:40:10 Date: 05/18/12
[ 0.789171] NET: Registered protocol family 16
[ 0.789240] Trying to unpack rootfs image as initramfs...
[ 0.789252] ACPI FADT declares the system doesn't support PCIe ASPM, so disable it
[ 0.789254] ACPI: bus type pci registered
[ 0.789472] PCI: MCFG configuration 0: base f8000000 segment 0 buses 0 - 63
[ 0.789474] PCI: MCFG area at f8000000 reserved in E820
[ 0.791029] PCI: Using MMCONFIG at f8000000 - fbffffff
[ 0.791030] PCI: Using configuration type 1 for base access
[ 0.791609] bio: create slab <bio-0> at 0
[ 0.792672] ACPI: EC: EC description table is found, configuring boot EC
[ 0.798776] ACPI: BIOS _OSI(Linux) query ignored
[ 0.802120] ACPI: Interpreter enabled
[ 0.802123] ACPI: (supports S0 S3 S4 S5)
[ 0.802144] ACPI: Using IOAPIC for interrupt routing
[ 0.808802] ACPI: EC: GPE = 0x11, I/O: command/status = 0x66, data = 0x62
[ 0.808966] ACPI: Power Resource [PUBS] (on)
[ 0.810841] ACPI: ACPI Dock Station Driver: 3 docks/bays found
[ 0.811028] ACPI: PCI Root Bridge [PCI0] (0000:00)
[ 0.811095] pci 0000:00:02.0: reg 10 64bit mmio: [0xf0000000-0xf03fffff]
[ 0.811100] pci 0000:00:02.0: reg 18 64bit mmio pref: [0xe0000000-0xefffffff]
[ 0.811103] pci 0000:00:02.0: reg 20 io port: [0x5000-0x503f]
[ 0.811176] pci 0000:00:16.0: reg 10 64bit mmio: [0xf2525000-0xf252500f]
[ 0.811222] pci 0000:00:16.0: PME# supported from D0 D3hot D3cold
[ 0.811226] pci 0000:00:16.0: PME# disabled
[ 0.811277] pci 0000:00:19.0: reg 10 32bit mmio: [0xf2500000-0xf251ffff]
[ 0.811283] pci 0000:00:19.0: reg 14 32bit mmio: [0xf252b000-0xf252bfff]
[ 0.811289] pci 0000:00:19.0: reg 18 io port: [0x5080-0x509f]
[ 0.811327] pci 0000:00:19.0: PME# supported from D0 D3hot D3cold
[ 0.811331] pci 0000:00:19.0: PME# disabled
[ 0.811378] pci 0000:00:1a.0: reg 10 32bit mmio: [0xf252a000-0xf252a3ff]
[ 0.811431] pci 0000:00:1a.0: PME# supported from D0 D3hot D3cold
[ 0.811435] pci 0000:00:1a.0: PME# disabled
[ 0.811475] pci 0000:00:1b.0: reg 10 64bit mmio: [0xf2520000-0xf2523fff]
[ 0.811516] pci 0000:00:1b.0: PME# supported from D0 D3hot D3cold
[ 0.811520] pci 0000:00:1b.0: PME# disabled
[ 0.811587] pci 0000:00:1c.0: PME# supported from D0 D3hot D3cold
[ 0.811591] pci 0000:00:1c.0: PME# disabled
[ 0.811659] pci 0000:00:1c.1: PME# supported from D0 D3hot D3cold
[ 0.811663] pci 0000:00:1c.1: PME# disabled
[ 0.811733] pci 0000:00:1c.3: PME# supported from D0 D3hot D3cold
[ 0.811736] pci 0000:00:1c.3: PME# disabled
[ 0.811839] pci 0000:00:1c.4: PME# supported from D0 D3hot D3cold
[ 0.811842] pci 0000:00:1c.4: PME# disabled
[ 0.811904] pci 0000:00:1d.0: reg 10 32bit mmio: [0xf2529000-0xf25293ff]
[ 0.811956] pci 0000:00:1d.0: PME# supported from D0 D3hot D3cold
[ 0.811960] pci 0000:00:1d.0: PME# disabled
[ 0.812094] pci 0000:00:1f.2: reg 10 io port: [0x50a8-0x50af]
[ 0.812100] pci 0000:00:1f.2: reg 14 io port: [0x50bc-0x50bf]
[ 0.812106] pci 0000:00:1f.2: reg 18 io port: [0x50a0-0x50a7]
[ 0.812111] pci 0000:00:1f.2: reg 1c io port: [0x50b8-0x50bb]
[ 0.812117] pci 0000:00:1f.2: reg 20 io port: [0x5060-0x507f]
[ 0.812123] pci 0000:00:1f.2: reg 24 32bit mmio: [0xf2528000-0xf25287ff]
[ 0.812152] pci 0000:00:1f.2: PME# supported from D3hot
[ 0.812156] pci 0000:00:1f.2: PME# disabled
[ 0.812184] pci 0000:00:1f.3: reg 10 64bit mmio: [0xf2524000-0xf25240ff]
[ 0.812197] pci 0000:00:1f.3: reg 20 io port: [0xefa0-0xefbf]
[ 0.812359] pci 0000:03:00.0: reg 10 64bit mmio: [0xf2400000-0xf2401fff]
[ 0.812486] pci 0000:03:00.0: PME# supported from D0 D3hot D3cold
[ 0.812493] pci 0000:03:00.0: PME# disabled
[ 0.812562] pci 0000:00:1c.1: bridge 32bit mmio: [0xf2400000-0xf24fffff]
[ 0.812605] pci 0000:00:1c.3: bridge io port: [0x4000-0x4fff]
[ 0.812609] pci 0000:00:1c.3: bridge 32bit mmio: [0xf1c00000-0xf23fffff]
[ 0.812615] pci 0000:00:1c.3: bridge 64bit mmio pref: [0xf0400000-0xf0bfffff]
[ 0.812837] pci 0000:0d:00.0: reg 10 32bit mmio: [0xf1400000-0xf14000ff]
[ 0.812953] pci 0000:0d:00.0: supports D1 D2
[ 0.812954] pci 0000:0d:00.0: PME# supported from D0 D1 D2 D3hot D3cold
[ 0.812960] pci 0000:0d:00.0: PME# disabled
[ 0.813039] pci 0000:00:1c.4: bridge io port: [0x3000-0x3fff]
[ 0.813043] pci 0000:00:1c.4: bridge 32bit mmio: [0xf1400000-0xf1bfffff]
[ 0.813052] pci 0000:00:1c.4: bridge 64bit mmio pref: [0xf0c00000-0xf13fffff]
[ 0.813077] ACPI: PCI Interrupt Routing Table [\_SB_.PCI0._PRT]
[ 0.813199] ACPI: PCI Interrupt Routing Table [\_SB_.PCI0.EXP1._PRT]
[ 0.813255] ACPI: PCI Interrupt Routing Table [\_SB_.PCI0.EXP2._PRT]
[ 0.813309] ACPI: PCI Interrupt Routing Table [\_SB_.PCI0.EXP4._PRT]
[ 0.813372] ACPI: PCI Interrupt Routing Table [\_SB_.PCI0.EXP5._PRT]
[ 0.816139] ACPI: PCI Interrupt Link [LNKA] (IRQs 3 4 5 6 7 9 10 *11)
[ 0.816293] ACPI: PCI Interrupt Link [LNKB] (IRQs 3 4 5 6 *7 9 10 11)
[ 0.816447] ACPI: PCI Interrupt Link [LNKC] (IRQs 3 4 5 6 7 9 10 *11)
[ 0.816596] ACPI: PCI Interrupt Link [LNKD] (IRQs 3 4 5 6 7 9 10 *11)
[ 0.816743] ACPI: PCI Interrupt Link [LNKE] (IRQs 3 4 5 6 7 9 *10 11)
[ 0.816880] ACPI: PCI Interrupt Link [LNKF] (IRQs 3 4 5 6 7 9 10 11) *0, disabled.
[ 0.817026] ACPI: PCI Interrupt Link [LNKG] (IRQs 3 4 5 6 *7 9 10 11)
[ 0.817173] ACPI: PCI Interrupt Link [LNKH] (IRQs 3 4 5 6 7 9 *10 11)
[ 0.817270] vgaarb: device added: PCI:0000:00:02.0,decodes=io+mem,owns=io+mem,locks=none
[ 0.817276] vgaarb: loaded
[ 0.817351] SCSI subsystem initialized
[ 0.817434] libata version 3.00 loaded.
[ 0.817490] usbcore: registered new interface driver usbfs
[ 0.817497] usbcore: registered new interface driver hub
[ 0.817517] usbcore: registered new device driver usb
[ 0.817633] ACPI: WMI: Mapper loaded
[ 0.817634] PCI: Using ACPI for IRQ routing
[ 0.818034] NetLabel: Initializing
[ 0.818035] NetLabel: domain hash size = 128
[ 0.818036] NetLabel: protocols = UNLABELED CIPSOv4
[ 0.818045] NetLabel: unlabeled traffic allowed by default
[ 0.818079] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0, 0, 0, 0, 0, 0
[ 0.818084] hpet0: 8 comparators, 64-bit 14.318180 MHz counter
[ 0.820093] Switching to clocksource tsc
[ 2.689543] AppArmor: AppArmor Filesystem Enabled
[ 2.689555] pnp: PnP ACPI init
[ 2.689567] ACPI: bus type pnp registered
[ 2.691958] pnp: PnP ACPI: found 11 devices
[ 2.691961] ACPI: ACPI bus type pnp unregistered
[ 2.691976] system 00:00: iomem range 0x0-0x9ffff could not be reserved
[ 2.691978] system 00:00: iomem range 0xc0000-0xc3fff has been reserved
[ 2.691980] system 00:00: iomem range 0xc4000-0xc7fff has been reserved
[ 2.691982] system 00:00: iomem range 0xc8000-0xcbfff has been reserved
[ 2.691984] system 00:00: iomem range 0xcc000-0xcffff has been reserved
[ 2.691985] system 00:00: iomem range 0xd0000-0xd3fff has been reserved
[ 2.691987] system 00:00: iomem range 0xd4000-0xd7fff has been reserved
[ 2.691992] system 00:00: iomem range 0xd8000-0xdbfff has been reserved
[ 2.691994] system 00:00: iomem range 0xdc000-0xdffff has been reserved
[ 2.691996] system 00:00: iomem range 0xe0000-0xe3fff could not be reserved
[ 2.691998] system 00:00: iomem range 0xe4000-0xe7fff could not be reserved
[ 2.691999] system 00:00: iomem range 0xe8000-0xebfff could not be reserved
[ 2.692001] system 00:00: iomem range 0xec000-0xeffff could not be reserved
[ 2.692003] system 00:00: iomem range 0xf0000-0xfffff could not be reserved
[ 2.692005] system 00:00: iomem range 0x100000-0xdf9fffff could not be reserved
[ 2.692008] system 00:00: iomem range 0xfec00000-0xfed3ffff could not be reserved
[ 2.692010] system 00:00: iomem range 0xfed4c000-0xffffffff could not be reserved
[ 2.692018] system 00:02: ioport range 0x400-0x47f has been reserved
[ 2.692020] system 00:02: ioport range 0x500-0x57f has been reserved
[ 2.692022] system 00:02: ioport range 0x800-0x80f has been reserved
[ 2.692024] system 00:02: ioport range 0x15e0-0x15ef has been reserved
[ 2.692026] system 00:02: ioport range 0x1600-0x167f has been reserved
[ 2.692028] system 00:02: iomem range 0xf8000000-0xfbffffff has been reserved
[ 2.692030] system 00:02: iomem range 0x0-0xfff could not be reserved
[ 2.692052] system 00:02: iomem range 0xfed1c000-0xfed1ffff has been reserved
[ 2.692054] system 00:02: iomem range 0xfed10000-0xfed13fff has been reserved
[ 2.692056] system 00:02: iomem range 0xfed18000-0xfed18fff has been reserved
[ 2.692059] system 00:02: iomem range 0xfed19000-0xfed19fff has been reserved
[ 2.692061] system 00:02: iomem range 0xfed45000-0xfed4bfff has been reserved
[ 2.696756] pci 0000:00:1c.0: PCI bridge, secondary bus 0000:02
[ 2.696758] pci 0000:00:1c.0: IO window: disabled
[ 2.696763] pci 0000:00:1c.0: MEM window: disabled
[ 2.696767] pci 0000:00:1c.0: PREFETCH window: disabled
[ 2.696774] pci 0000:00:1c.1: PCI bridge, secondary bus 0000:03
[ 2.696775] pci 0000:00:1c.1: IO window: disabled
[ 2.696780] pci 0000:00:1c.1: MEM window: 0xf2400000-0xf24fffff
[ 2.696784] pci 0000:00:1c.1: PREFETCH window: disabled
[ 2.696790] pci 0000:00:1c.3: PCI bridge, secondary bus 0000:05
[ 2.696793] pci 0000:00:1c.3: IO window: 0x4000-0x4fff
[ 2.696798] pci 0000:00:1c.3: MEM window: 0xf1c00000-0xf23fffff
[ 2.696803] pci 0000:00:1c.3: PREFETCH window: 0x000000f0400000-0x000000f0bfffff
[ 2.696809] pci 0000:00:1c.4: PCI bridge, secondary bus 0000:0d
[ 2.696813] pci 0000:00:1c.4: IO window: 0x3000-0x3fff
[ 2.696819] pci 0000:00:1c.4: MEM window: 0xf1400000-0xf1bfffff
[ 2.696824] pci 0000:00:1c.4: PREFETCH window: 0x000000f0c00000-0x000000f13fffff
[ 2.696844] alloc irq_desc for 16 on node -1
[ 2.696846] alloc kstat_irqs on node -1
[ 2.696852] pci 0000:00:1c.0: PCI INT A -> GSI 16 (level, low) -> IRQ 16
[ 2.696859] pci 0000:00:1c.0: setting latency timer to 64
[ 2.696868] alloc irq_desc for 17 on node -1
[ 2.696870] alloc kstat_irqs on node -1
[ 2.696872] pci 0000:00:1c.1: PCI INT B -> GSI 17 (level, low) -> IRQ 17
[ 2.696876] pci 0000:00:1c.1: setting latency timer to 64
[ 2.696885] alloc irq_desc for 19 on node -1
[ 2.696886] alloc kstat_irqs on node -1
[ 2.696888] pci 0000:00:1c.3: PCI INT D -> GSI 19 (level, low) -> IRQ 19
[ 2.696892] pci 0000:00:1c.3: setting latency timer to 64
[ 2.696903] pci 0000:00:1c.4: PCI INT A -> GSI 16 (level, low) -> IRQ 16
[ 2.696908] pci 0000:00:1c.4: setting latency timer to 64
[ 2.696912] pci_bus 0000:00: resource 0 io: [0x00-0xffff]
[ 2.696914] pci_bus 0000:00: resource 1 mem: [0x000000-0xffffffffffffffff]
[ 2.696916] pci_bus 0000:03: resource 1 mem: [0xf2400000-0xf24fffff]
[ 2.696918] pci_bus 0000:05: resource 0 io: [0x4000-0x4fff]
[ 2.696919] pci_bus 0000:05: resource 1 mem: [0xf1c00000-0xf23fffff]
[ 2.696921] pci_bus 0000:05: resource 2 pref mem [0xf0400000-0xf0bfffff]
[ 2.696923] pci_bus 0000:0d: resource 0 io: [0x3000-0x3fff]
[ 2.696924] pci_bus 0000:0d: resource 1 mem: [0xf1400000-0xf1bfffff]
[ 2.696926] pci_bus 0000:0d: resource 2 pref mem [0xf0c00000-0xf13fffff]
[ 2.696951] NET: Registered protocol family 2
[ 2.697145] IP route cache hash table entries: 262144 (order: 9, 2097152 bytes)
[ 2.698847] TCP established hash table entries: 524288 (order: 11, 8388608 bytes)
[ 2.700221] TCP bind hash table entries: 65536 (order: 8, 1048576 bytes)
[ 2.700376] TCP: Hash tables configured (established 524288 bind 65536)
[ 2.700378] TCP reno registered
[ 2.700452] NET: Registered protocol family 1
[ 2.700464] pci 0000:00:02.0: Boot video device
[ 2.700752] Scanning for low memory corruption every 60 seconds
[ 2.700847] audit: initializing netlink socket (disabled)
[ 2.700854] type=2000 audit(1337359212.553:1): initialized
[ 2.707785] HugeTLB registered 2 MB page size, pre-allocated 0 pages
[ 2.708756] VFS: Disk quotas dquot_6.5.2
[ 2.708794] Dquot-cache hash table entries: 512 (order 0, 4096 bytes)
[ 2.709181] fuse init (API version 7.13)
[ 2.709235] msgmni has been set to 15751
[ 2.709399] alg: No test for stdrng (krng)
[ 2.709436] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 253)
[ 2.709438] io scheduler noop registered
[ 2.709439] io scheduler anticipatory registered
[ 2.709440] io scheduler deadline registered
[ 2.709481] io scheduler cfq registered (default)
[ 2.709587] alloc irq_desc for 24 on node -1
[ 2.709589] alloc kstat_irqs on node -1
[ 2.709599] pcieport 0000:00:1c.0: irq 24 for MSI/MSI-X
[ 2.709609] pcieport 0000:00:1c.0: setting latency timer to 64
[ 2.709708] alloc irq_desc for 25 on node -1
[ 2.709709] alloc kstat_irqs on node -1
[ 2.709716] pcieport 0000:00:1c.1: irq 25 for MSI/MSI-X
[ 2.709724] pcieport 0000:00:1c.1: setting latency timer to 64
[ 2.709821] alloc irq_desc for 26 on node -1
[ 2.709822] alloc kstat_irqs on node -1
[ 2.709829] pcieport 0000:00:1c.3: irq 26 for MSI/MSI-X
[ 2.709837] pcieport 0000:00:1c.3: setting latency timer to 64
[ 2.709968] alloc irq_desc for 27 on node -1
[ 2.709970] alloc kstat_irqs on node -1
[ 2.709979] pcieport 0000:00:1c.4: irq 27 for MSI/MSI-X
[ 2.709990] pcieport 0000:00:1c.4: setting latency timer to 64
[ 2.710079] pci_hotplug: PCI Hot Plug PCI Core version: 0.5
[ 2.710092] Firmware did not grant requested _OSC control
[ 2.710111] Firmware did not grant requested _OSC control
[ 2.710134] Firmware did not grant requested _OSC control
[ 2.710149] Firmware did not grant requested _OSC control
[ 2.710163] pciehp: PCI Express Hot Plug Controller Driver version: 0.4
[ 2.710355] ACPI: AC Adapter [AC] (on-line)
[ 2.710408] input: Lid Switch as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0D:00/input/input0
[ 2.710569] ACPI: Lid Switch [LID]
[ 2.710596] input: Sleep Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0E:00/input/input1
[ 2.710600] ACPI: Sleep Button [SLPB]
[ 2.710634] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input2
[ 2.710636] ACPI: Power Button [PWRF]
[ 2.711402] ACPI: SSDT 00000000dae8c018 008C0 (v01 PmRef Cpu0Cst 00003001 INTL 20061109)
[ 2.712328] processor LNXCPU:00: registered as cooling_device0
[ 2.712749] ACPI: SSDT 00000000dae8da98 00303 (v01 PmRef ApIst 00003000 INTL 20061109)
[ 2.713173] ACPI: SSDT 00000000dae8bd98 00119 (v01 PmRef ApCst 00003000 INTL 20061109)
[ 2.714024] processor LNXCPU:01: registered as cooling_device1
[ 2.974193] processor LNXCPU:02: registered as cooling_device2
[ 2.975242] processor LNXCPU:03: registered as cooling_device3
[ 2.977488] Freeing initrd memory: 9658k freed
[ 2.979467] thermal LNXTHERM:01: registered as thermal_zone0
[ 2.979474] ACPI: Thermal Zone [THM0] (64 C)
[ 2.981085] Linux agpgart interface v0.103
[ 2.981107] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled
[ 2.982442] brd: module loaded
[ 2.982881] loop: module loaded
[ 2.982960] input: Macintosh mouse button emulation as /devices/virtual/input/input3
[ 2.983444] Fixed MDIO Bus: probed
[ 2.983512] PPP generic driver version 2.4.2
[ 2.983533] tun: Universal TUN/TAP device driver, 1.6
[ 2.983534] tun: (C) 1999-2004 Max Krasnyansky <maxk@qualcomm.com>
[ 2.983631] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver
[ 2.984871] ehci_hcd 0000:00:1a.0: power state changed by ACPI to D0
[ 2.986671] ehci_hcd 0000:00:1a.0: power state changed by ACPI to D0
[ 2.986679] ehci_hcd 0000:00:1a.0: PCI INT A -> GSI 16 (level, low) -> IRQ 16
[ 2.986714] ehci_hcd 0000:00:1a.0: setting latency timer to 64
[ 2.986736] ehci_hcd 0000:00:1a.0: EHCI Host Controller
[ 2.986792] ehci_hcd 0000:00:1a.0: new USB bus registered, assigned bus number 1
[ 2.986821] ehci_hcd 0000:00:1a.0: debug port 2
[ 2.990694] ehci_hcd 0000:00:1a.0: cache line size of 32 is not supported
[ 2.990707] ehci_hcd 0000:00:1a.0: irq 16, io mem 0xf252a000
[ 2.994328] ACPI: Battery Slot [BAT0] (battery present)
[ 3.007668] ehci_hcd 0000:00:1a.0: USB 2.0 started, EHCI 1.00
[ 3.007819] usb usb1: configuration #1 chosen from 1 choice
[ 3.007838] hub 1-0:1.0: USB hub found
[ 3.007844] hub 1-0:1.0: 3 ports detected
[ 3.008079] ehci_hcd 0000:00:1d.0: power state changed by ACPI to D0
[ 3.008241] ehci_hcd 0000:00:1d.0: power state changed by ACPI to D0
[ 3.008247] alloc irq_desc for 23 on node -1
[ 3.008249] alloc kstat_irqs on node -1
[ 3.008253] ehci_hcd 0000:00:1d.0: PCI INT A -> GSI 23 (level, low) -> IRQ 23
[ 3.008263] ehci_hcd 0000:00:1d.0: setting latency timer to 64
[ 3.008266] ehci_hcd 0000:00:1d.0: EHCI Host Controller
[ 3.008291] ehci_hcd 0000:00:1d.0: new USB bus registered, assigned bus number 2
[ 3.008314] ehci_hcd 0000:00:1d.0: debug port 2
[ 3.012191] ehci_hcd 0000:00:1d.0: cache line size of 32 is not supported
[ 3.012201] ehci_hcd 0000:00:1d.0: irq 23, io mem 0xf2529000
[ 3.027616] ehci_hcd 0000:00:1d.0: USB 2.0 started, EHCI 1.00
[ 3.027761] usb usb2: configuration #1 chosen from 1 choice
[ 3.027777] hub 2-0:1.0: USB hub found
[ 3.027781] hub 2-0:1.0: 3 ports detected
[ 3.027815] ohci_hcd: USB 1.1 'Open' Host Controller (OHCI) Driver
[ 3.027823] uhci_hcd: USB Universal Host Controller Interface driver
[ 3.027865] PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12
[ 3.031439] serio: i8042 KBD port at 0x60,0x64 irq 1
[ 3.031444] serio: i8042 AUX port at 0x60,0x64 irq 12
[ 3.031512] mice: PS/2 mouse device common for all mice
[ 3.031586] rtc_cmos 00:07: RTC can wake from S4
[ 3.031612] rtc_cmos 00:07: rtc core: registered rtc_cmos as rtc0
[ 3.031639] rtc0: alarms up to one month, y3k, 114 bytes nvram, hpet irqs
[ 3.031715] device-mapper: uevent: version 1.0.3
[ 3.031779] device-mapper: ioctl: 4.15.0-ioctl (2009-04-01) initialised: dm-devel@redhat.com
[ 3.031845] device-mapper: multipath: version 1.1.0 loaded
[ 3.031847] device-mapper: multipath round-robin: version 1.0.0 loaded
[ 3.032059] cpuidle: using governor ladder
[ 3.032169] cpuidle: using governor menu
[ 3.032378] TCP cubic registered
[ 3.032476] NET: Registered protocol family 10
[ 3.032920] NET: Registered protocol family 17
[ 3.035676] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input4
[ 3.040284] PM: Resume from disk failed.
[ 3.040292] registered taskstats version 1
[ 3.040711] Magic number: 12:176:692
[ 3.040792] rtc_cmos 00:07: setting system clock to 2012-05-18 16:40:13 UTC (1337359213)
[ 3.040794] BIOS EDD facility v0.16 2004-Jun-25, 0 devices found
[ 3.040795] EDD information not available.
[ 3.040858] Freeing unused kernel memory: 884k freed
[ 3.040957] Write protecting the kernel read-only data: 7716k
[ 3.052794] udev: starting version 151
[ 3.064733] vga16fb: initializing
[ 3.064736] vga16fb: mapped to 0xffff8800000a0000
[ 3.064779] fb0: VGA16 VGA frame buffer device
[ 3.069101] ahci 0000:00:1f.2: version 3.0
[ 3.069118] ahci 0000:00:1f.2: PCI INT B -> GSI 19 (level, low) -> IRQ 19
[ 3.069163] alloc irq_desc for 28 on node -1
[ 3.069165] alloc kstat_irqs on node -1
[ 3.069175] ahci 0000:00:1f.2: irq 28 for MSI/MSI-X
[ 3.069203] ahci: SSS flag set, parallel bus scan disabled
[ 3.087539] ahci 0000:00:1f.2: AHCI 0001.0300 32 slots 6 ports 6 Gbps 0x13 impl SATA mode
[ 3.087543] ahci 0000:00:1f.2: flags: 64bit ncq sntf ilck stag pm led clo pio slum part ems sxs apst
[ 3.087549] ahci 0000:00:1f.2: setting latency timer to 64
[ 3.128065] scsi0 : ahci
[ 3.128162] scsi1 : ahci
[ 3.128215] scsi2 : ahci
[ 3.128267] scsi3 : ahci
[ 3.128317] scsi4 : ahci
[ 3.128363] scsi5 : ahci
[ 3.129401] ata1: SATA max UDMA/133 abar m2048@0xf2528000 port 0xf2528100 irq 28
[ 3.129404] ata2: SATA max UDMA/133 abar m2048@0xf2528000 port 0xf2528180 irq 28
[ 3.129405] ata3: DUMMY
[ 3.129406] ata4: DUMMY
[ 3.129408] ata5: SATA max UDMA/133 abar m2048@0xf2528000 port 0xf2528300 irq 28
[ 3.129409] ata6: DUMMY
[ 3.161700] Console: switching to colour frame buffer device 80x30
[ 3.327618] usb 1-1: new high speed USB device using ehci_hcd and address 2
[ 3.477234] ata1: SATA link up 3.0 Gbps (SStatus 123 SControl 300)
[ 3.477242] usb 1-1: configuration #1 chosen from 1 choice
[ 3.477334] hub 1-1:1.0: USB hub found
[ 3.477468] hub 1-1:1.0: 6 ports detected
[ 3.478134] ata1.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded
[ 3.478137] ata1.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out
[ 3.478139] ata1.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out
[ 3.479017] ata1.00: ATA-8: HITACHI HTS723232A7A364, EC2ZB70R, max UDMA/100
[ 3.479026] ata1.00: 625142448 sectors, multi 16: LBA48 NCQ (depth 31/32), AA
[ 3.480131] ata1.00: ACPI cmd ef/02:00:00:00:00:a0 (SET FEATURES) succeeded
[ 3.480139] ata1.00: ACPI cmd f5/00:00:00:00:00:a0 (SECURITY FREEZE LOCK) filtered out
[ 3.480146] ata1.00: ACPI cmd ef/10:03:00:00:00:a0 (SET FEATURES) filtered out
[ 3.480995] ata1.00: configured for UDMA/100
[ 3.506732] scsi 0:0:0:0: Direct-Access ATA HITACHI HTS72323 EC2Z PQ: 0 ANSI: 5
[ 3.506855] sd 0:0:0:0: Attached scsi generic sg0 type 0
[ 3.506877] sd 0:0:0:0: [sda] 625142448 512-byte logical blocks: (320 GB/298 GiB)
[ 3.506916] sd 0:0:0:0: [sda] Write Protect is off
[ 3.506918] sd 0:0:0:0: [sda] Mode Sense: 00 3a 00 00
[ 3.506930] sd 0:0:0:0: [sda] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA
[ 3.507003] sda:
[ 3.606332] usb 2-1: new high speed USB device using ehci_hcd and address 2
[ 3.756652] usb 2-1: configuration #1 chosen from 1 choice
[ 3.756855] hub 2-1:1.0: USB hub found
[ 3.756921] hub 2-1:1.0: 8 ports detected
[ 3.835931] usb 1-1.3: new full speed USB device using ehci_hcd and address 3
[ 3.835972] sda1 sda2 < sda5 > sda3
[ 3.860292] sd 0:0:0:0: [sda] Attached SCSI disk
[ 3.875737] ata2: SATA link down (SStatus 0 SControl 300)
[ 3.956971] usb 1-1.3: configuration #1 chosen from 1 choice
[ 4.045430] usb 1-1.6: new high speed USB device using ehci_hcd and address 4
[ 4.171817] usb 1-1.6: configuration #1 chosen from 1 choice
[ 4.244894] ata5: SATA link down (SStatus 0 SControl 300)
[ 4.245135] usb 2-1.2: new high speed USB device using ehci_hcd and address 3
[ 4.366453] usb 2-1.2: configuration #1 chosen from 1 choice
[ 4.370262] Initializing USB Mass Storage driver...
[ 4.370442] scsi6 : SCSI emulation for USB Mass Storage devices
[ 4.370545] usb-storage: device found at 3
[ 4.370546] usb-storage: waiting for device to settle before scanning
[ 4.370553] usbcore: registered new interface driver usb-storage
[ 4.370555] USB Mass Storage support registered.
[ 4.727336] xor: automatically using best checksumming function: generic_sse
[ 4.774230] generic_sse: 14178.800 MB/sec
[ 4.774232] xor: using function: generic_sse (14178.800 MB/sec)
[ 4.775554] device-mapper: dm-raid45: initialized v0.2594b
[ 4.989448] EXT4-fs (sda1): mounted filesystem with ordered data mode
[ 9.353456] usb-storage: device scan complete
[ 9.353975] scsi 6:0:0:0: Direct-Access Real-Way RW8021 PENDRIVE 1.0 PQ: 0 ANSI: 2
[ 9.354686] sd 6:0:0:0: Attached scsi generic sg1 type 0
[ 9.355404] sd 6:0:0:0: [sdb] 2004992 512-byte logical blocks: (1.02 GB/979 MiB)
[ 9.356006] sd 6:0:0:0: [sdb] Write Protect is off
[ 9.356013] sd 6:0:0:0: [sdb] Mode Sense: 0b 00 00 08
[ 9.356018] sd 6:0:0:0: [sdb] Assuming drive cache: write through
[ 9.358354] sd 6:0:0:0: [sdb] Assuming drive cache: write through
[ 9.358362] sdb: sdb1
[ 9.361517] sd 6:0:0:0: [sdb] Assuming drive cache: write through
[ 9.361529] sd 6:0:0:0: [sdb] Attached SCSI removable disk
[ 9.757460] aufs 2-standalone.tree-20091207
[ 9.766680] squashfs: version 4.0 (2009/01/31) Phillip Lougher
[ 17.825928] udev: starting version 151
[ 18.125424] cfg80211: Calling CRDA to update world regulatory domain
[ 18.209240] Linux video capture interface: v2.00
[ 18.274884] uvcvideo: Found UVC 1.00 device Integrated Camera (04f2:b217)
[ 18.275312] Non-volatile memory driver v1.3
[ 18.276577] input: Integrated Camera as /devices/pci0000:00/0000:00:1a.0/usb1/1-1/1-1.6/1-1.6:1.0/input/input5
[ 18.276616] usbcore: registered new interface driver uvcvideo
[ 18.276618] USB Video Class driver (v0.1.0)
[ 18.332858] iwlagn: Intel(R) Wireless WiFi Link AGN driver for Linux, 1.3.27k
[ 18.332860] iwlagn: Copyright(c) 2003-2009 Intel Corporation
[ 18.332905] iwlagn 0000:03:00.0: PCI INT A -> GSI 17 (level, low) -> IRQ 17
[ 18.332913] iwlagn 0000:03:00.0: setting latency timer to 64
[ 18.332954] iwlagn 0000:03:00.0: Detected Intel Wireless WiFi Link 1000 Series BGN REV=0x6C
[ 18.340168] tpm_tis 00:0a: 1.2 TPM (device-id 0x0, rev-id 78)
[ 18.341325] thinkpad_acpi: ThinkPad ACPI Extras v0.24
[ 18.341328] thinkpad_acpi: http://ibm-acpi.sf.net/
[ 18.341329] thinkpad_acpi: ThinkPad BIOS 8DET55WW (1.25 ), EC unknown
[ 18.341331] thinkpad_acpi: Lenovo ThinkPad X220, model 42872WU
[ 18.341920] thinkpad_acpi: radio switch found; radios are enabled
[ 18.342176] thinkpad_acpi: possible tablet mode switch found; ThinkPad in laptop mode
[ 18.342457] thinkpad_acpi: This ThinkPad has standard ACPI backlight brightness control, supported by the ACPI video driver
[ 18.342459] thinkpad_acpi: Disabling thinkpad-acpi brightness events by default...
[ 18.350832] thinkpad_acpi: rfkill switch tpacpi_bluetooth_sw: radio is blocked
[ 18.351738] Registered led device: tpacpi::thinklight
[ 18.351849] Registered led device: tpacpi::power
[ 18.352149] Registered led device: tpacpi::standby
[ 18.352268] Registered led device: tpacpi::thinkvantage
[ 18.352544] thinkpad_acpi: Standard ACPI backlight interface available, not loading native one.
[ 18.353091] thinkpad_acpi: Console audio control enabled, mode: monitor (read only)
[ 18.357607] input: ThinkPad Extra Buttons as /devices/platform/thinkpad_acpi/input/input6
[ 18.366035] iwlagn 0000:03:00.0: Tunable channels: 13 802.11bg, 0 802.11a channels
[ 18.366089] alloc irq_desc for 29 on node -1
[ 18.366091] alloc kstat_irqs on node -1
[ 18.366107] iwlagn 0000:03:00.0: irq 29 for MSI/MSI-X
[ 18.385167] cfg80211: World regulatory domain updated:
[ 18.385170] (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp)
[ 18.385173] (2402000 KHz - 2472000 KHz @ 40000 KHz), (300 mBi, 2000 mBm)
[ 18.385175] (2457000 KHz - 2482000 KHz @ 20000 KHz), (300 mBi, 2000 mBm)
[ 18.385177] (2474000 KHz - 2494000 KHz @ 20000 KHz), (300 mBi, 2000 mBm)
[ 18.385179] (5170000 KHz - 5250000 KHz @ 40000 KHz), (300 mBi, 2000 mBm)
[ 18.385181] (5735000 KHz - 5835000 KHz @ 40000 KHz), (300 mBi, 2000 mBm)
[ 18.421475] phy0: Selected rate control algorithm 'iwl-agn-rs'
[ 18.479524] iwlagn 0000:03:00.0: firmware: requesting iwlwifi-1000-3.ucode
[ 18.533209] iwlagn 0000:03:00.0: loaded firmware version 128.50.3.1
[ 18.614789] alloc irq_desc for 22 on node -1
[ 18.614792] alloc kstat_irqs on node -1
[ 18.614798] HDA Intel 0000:00:1b.0: PCI INT A -> GSI 22 (level, low) -> IRQ 22
[ 18.614849] HDA Intel 0000:00:1b.0: setting latency timer to 64
[ 18.626989] Registered led device: iwl-phy0::radio
[ 18.627041] Registered led device: iwl-phy0::assoc
[ 18.627055] Registered led device: iwl-phy0::RX
[ 18.627081] Registered led device: iwl-phy0::TX
[ 18.652850] ADDRCONF(NETDEV_UP): wlan0: link is not ready
[ 18.757860] lp: driver loaded but no devices found
[ 18.769510] ppdev: user-space parallel port driver
[ 18.801947] Unable to query Synaptics hardware.
[ 18.831644] usb 1-1.4: new full speed USB device using ehci_hcd and address 5
[ 18.946926] usb 1-1.4: configuration #1 chosen from 1 choice
[ 18.972175] Bluetooth: Core ver 2.15
[ 18.972229] NET: Registered protocol family 31
[ 18.972231] Bluetooth: HCI device and connection manager initialized
[ 18.972233] Bluetooth: HCI socket layer initialized
[ 18.988322] Bluetooth: Generic Bluetooth USB driver ver 0.6
[ 18.988773] usbcore: registered new interface driver btusb
[ 19.044668] Bluetooth: L2CAP ver 2.14
[ 19.044670] Bluetooth: L2CAP socket layer initialized
[ 19.104588] Bluetooth: BNEP (Ethernet Emulation) ver 1.3
[ 19.104590] Bluetooth: BNEP filters: protocol multicast
[ 19.153873] Bridge firewalling registered
[ 19.170539] Bluetooth: SCO (Voice Link) ver 0.6
[ 19.170541] Bluetooth: SCO socket layer initialized
[ 19.245834] Bluetooth: RFCOMM TTY layer initialized
[ 19.245839] Bluetooth: RFCOMM socket layer initialized
[ 19.245840] Bluetooth: RFCOMM ver 1.11
[ 19.351209] CPU0 attaching NULL sched-domain.
[ 19.351214] CPU1 attaching NULL sched-domain.
[ 19.351217] CPU2 attaching NULL sched-domain.
[ 19.351219] CPU3 attaching NULL sched-domain.
[ 19.376986] input: PS/2 Synaptics TouchPad as /devices/platform/i8042/serio1/input/input7
[ 19.422107] CPU0 attaching sched-domain:
[ 19.422110] domain 0: span 0-1 level SIBLING
[ 19.422112] groups: 0 (cpu_power = 589) 1 (cpu_power = 589)
[ 19.422115] domain 1: span 0-3 level MC
[ 19.422116] groups: 0-1 (cpu_power = 1178) 2-3 (cpu_power = 1178)
[ 19.422120] CPU1 attaching sched-domain:
[ 19.422121] domain 0: span 0-1 level SIBLING
[ 19.422123] groups: 1 (cpu_power = 589) 0 (cpu_power = 589)
[ 19.422125] domain 1: span 0-3 level MC
[ 19.422126] groups: 0-1 (cpu_power = 1178) 2-3 (cpu_power = 1178)
[ 19.422130] CPU2 attaching sched-domain:
[ 19.422131] domain 0: span 2-3 level SIBLING
[ 19.422132] groups: 2 (cpu_power = 589) 3 (cpu_power = 589)
[ 19.422134] domain 1: span 0-3 level MC
[ 19.422135] groups: 2-3 (cpu_power = 1178) 0-1 (cpu_power = 1178)
[ 19.422138] CPU3 attaching sched-domain:
[ 19.422139] domain 0: span 2-3 level SIBLING
[ 19.422140] groups: 3 (cpu_power = 589) 2 (cpu_power = 589)
[ 19.422143] domain 1: span 0-3 level MC
[ 19.422144] groups: 2-3 (cpu_power = 1178) 0-1 (cpu_power = 1178)
[ 19.422403] CPU0 attaching NULL sched-domain.
[ 19.422405] CPU1 attaching NULL sched-domain.
[ 19.422406] CPU2 attaching NULL sched-domain.
[ 19.422407] CPU3 attaching NULL sched-domain.
[ 19.471883] CPU0 attaching sched-domain:
[ 19.471886] domain 0: span 0-1 level SIBLING
[ 19.471889] groups: 0 (cpu_power = 589) 1 (cpu_power = 589)
[ 19.471894] domain 1: span 0-3 level MC
[ 19.471896] groups: 0-1 (cpu_power = 1178) 2-3 (cpu_power = 1178)
[ 19.471902] CPU1 attaching sched-domain:
[ 19.471904] domain 0: span 0-1 level SIBLING
[ 19.471906] groups: 1 (cpu_power = 589) 0 (cpu_power = 589)
[ 19.471911] domain 1: span 0-3 level MC
[ 19.471912] groups: 0-1 (cpu_power = 1178) 2-3 (cpu_power = 1178)
[ 19.471918] CPU2 attaching sched-domain:
[ 19.471919] domain 0: span 2-3 level SIBLING
[ 19.471921] groups: 2 (cpu_power = 589) 3 (cpu_power = 589)
[ 19.471926] domain 1: span 0-3 level MC
[ 19.471928] groups: 2-3 (cpu_power = 1178) 0-1 (cpu_power = 1178)
[ 19.471933] CPU3 attaching sched-domain:
[ 19.471934] domain 0: span 2-3 level SIBLING
[ 19.471936] groups: 3 (cpu_power = 589) 2 (cpu_power = 589)
[ 19.471941] domain 1: span 0-3 level MC
[ 19.471942] groups: 2-3 (cpu_power = 1178) 0-1 (cpu_power = 1178)
[ 23.838033] CPU0 attaching NULL sched-domain.
[ 23.838036] CPU1 attaching NULL sched-domain.
[ 23.838037] CPU2 attaching NULL sched-domain.
[ 23.838039] CPU3 attaching NULL sched-domain.
[ 23.890608] CPU0 attaching sched-domain:
[ 23.890611] domain 0: span 0-1 level SIBLING
[ 23.890613] groups: 0 (cpu_power = 589) 1 (cpu_power = 589)
[ 23.890616] domain 1: span 0-3 level MC
[ 23.890617] groups: 0-1 (cpu_power = 1178) 2-3 (cpu_power = 1178)
[ 23.890622] CPU1 attaching sched-domain:
[ 23.890623] domain 0: span 0-1 level SIBLING
[ 23.890624] groups: 1 (cpu_power = 589) 0 (cpu_power = 589)
[ 23.890627] domain 1: span 0-3 level MC
[ 23.890628] groups: 0-1 (cpu_power = 1178) 2-3 (cpu_power = 1178)
[ 23.890631] CPU2 attaching sched-domain:
[ 23.890632] domain 0: span 2-3 level SIBLING
[ 23.890633] groups: 2 (cpu_power = 589) 3 (cpu_power = 589)
[ 23.890636] domain 1: span 0-3 level MC
[ 23.890637] groups: 2-3 (cpu_power = 1178) 0-1 (cpu_power = 1178)
[ 23.890640] CPU3 attaching sched-domain:
[ 23.890641] domain 0: span 2-3 level SIBLING
[ 23.890642] groups: 3 (cpu_power = 589) 2 (cpu_power = 589)
[ 23.890645] domain 1: span 0-3 level MC
[ 23.890646] groups: 2-3 (cpu_power = 1178) 0-1 (cpu_power = 1178)
[ 23.890907] CPU0 attaching NULL sched-domain.
[ 23.890909] CPU1 attaching NULL sched-domain.
[ 23.890910] CPU2 attaching NULL sched-domain.
[ 23.890911] CPU3 attaching NULL sched-domain.
[ 23.950560] CPU0 attaching sched-domain:
[ 23.950564] domain 0: span 0-1 level SIBLING
[ 23.950567] groups: 0 (cpu_power = 589) 1 (cpu_power = 589)
[ 23.950572] domain 1: span 0-3 level MC
[ 23.950574] groups: 0-1 (cpu_power = 1178) 2-3 (cpu_power = 1178)
[ 23.950581] CPU1 attaching sched-domain:
[ 23.950583] domain 0: span 0-1 level SIBLING
[ 23.950585] groups: 1 (cpu_power = 589) 0 (cpu_power = 589)
[ 23.950589] domain 1: span 0-3 level MC
[ 23.950591] groups: 0-1 (cpu_power = 1178) 2-3 (cpu_power = 1178)
[ 23.950597] CPU2 attaching sched-domain:
[ 23.950598] domain 0: span 2-3 level SIBLING
[ 23.950600] groups: 2 (cpu_power = 589) 3 (cpu_power = 589)
[ 23.950605] domain 1: span 0-3 level MC
[ 23.950607] groups: 2-3 (cpu_power = 1178) 0-1 (cpu_power = 1178)
[ 23.950612] CPU3 attaching sched-domain:
[ 23.950614] domain 0: span 2-3 level SIBLING
[ 23.950616] groups: 3 (cpu_power = 589) 2 (cpu_power = 589)
[ 23.950620] domain 1: span 0-3 level MC
[ 23.950622] groups: 2-3 (cpu_power = 1178) 0-1 (cpu_power = 1178)
[ 71.172915] SGI XFS with ACLs, security attributes, realtime, large block/inode numbers, no debug enabled
[ 71.173819] SGI XFS Quota Management subsystem
[ 71.241675] XFS mounting filesystem sda3
[ 71.602949] Ending clean XFS mount for filesystem: sda3
[ 242.149938] INFO: task copy-files:3386 blocked for more than 120 seconds.
[ 242.149946] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
[ 242.149951] copy-files D 0000000000000000 0 3386 3337 0x00000000
[ 242.149961] ffff880214b17c88 0000000000000086 0000000000015c00 0000000000015c00
[ 242.149970] ffff880208e43198 ffff880214b17fd8 0000000000015c00 ffff880208e42de0
[ 242.149978] 0000000000015c00 ffff880214b17fd8 0000000000015c00 ffff880208e43198
[ 242.149986] Call Trace:
[ 242.150027] [<ffffffffa034d103>] xlog_grant_log_space+0x173/0x3f0 [xfs]
[ 242.150055] [<ffffffffa035fa4a>] ? kmem_zone_zalloc+0x3a/0x50 [xfs]
[ 242.150066] [<ffffffff8105cd70>] ? default_wake_function+0x0/0x20
[ 242.150095] [<ffffffffa034d454>] xfs_log_reserve+0xd4/0xe0 [xfs]
[ 242.150124] [<ffffffffa0357b20>] xfs_trans_reserve+0xa0/0x210 [xfs]
[ 242.150151] [<ffffffffa035ca45>] xfs_free_eofblocks+0x185/0x2a0 [xfs]
[ 242.150179] [<ffffffffa035d578>] xfs_release+0x128/0x1f0 [xfs]
[ 242.150207] [<ffffffffa0364f35>] xfs_file_release+0x15/0x20 [xfs]
[ 242.150217] [<ffffffff81145ea5>] __fput+0xf5/0x210
[ 242.150225] [<ffffffff81145fe5>] fput+0x25/0x30
[ 242.150232] [<ffffffff8114210d>] filp_close+0x5d/0x90
[ 242.150239] [<ffffffff811421f7>] sys_close+0xb7/0x120
[ 242.150249] [<ffffffff810121b2>] system_call_fastpath+0x16/0x1b
[ 242.150255] INFO: task copy-files:3387 blocked for more than 120 seconds.
[ 242.150259] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
[ 242.150263] copy-files D 0000000000000000 0 3387 3337 0x00000000
[ 242.150271] ffff8802149cbd38 0000000000000086 0000000000015c00 0000000000015c00
[ 242.150279] ffff880208e44888 ffff8802149cbfd8 0000000000015c00 ffff880208e444d0
[ 242.150286] 0000000000015c00 ffff8802149cbfd8 0000000000015c00 ffff880208e44888
[ 242.150293] Call Trace:
[ 242.150304] [<ffffffff81546477>] __mutex_lock_slowpath+0xf7/0x180
[ 242.150313] [<ffffffff81145c1a>] ? get_empty_filp+0x7a/0x170
[ 242.150321] [<ffffffff8154635b>] mutex_lock+0x2b/0x50
[ 242.150329] [<ffffffff81152d49>] do_filp_open+0x3d9/0xba0
[ 242.150336] [<ffffffff81148b74>] ? cp_new_stat+0xe4/0x100
[ 242.150345] [<ffffffff8115e7fa>] ? alloc_fd+0x10a/0x150
[ 242.150352] [<ffffffff811422c9>] do_sys_open+0x69/0x170
[ 242.150359] [<ffffffff81142410>] sys_open+0x20/0x30
[ 242.150367] [<ffffffff810121b2>] system_call_fastpath+0x16/0x1b
[ 242.150373] INFO: task copy-files:3390 blocked for more than 120 seconds.
[ 242.150377] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
[ 242.150381] copy-files D 0000000000000000 0 3390 3337 0x00000000
[ 242.150388] ffff880212051c88 0000000000000086 0000000000015c00 0000000000015c00
[ 242.150395] ffff8801ed7903b8 ffff880212051fd8 0000000000015c00 ffff8801ed790000
[ 242.150403] 0000000000015c00 ffff880212051fd8 0000000000015c00 ffff8801ed7903b8
[ 242.150410] Call Trace:
[ 242.150438] [<ffffffffa034d103>] xlog_grant_log_space+0x173/0x3f0 [xfs]
[ 242.150465] [<ffffffffa035fa4a>] ? kmem_zone_zalloc+0x3a/0x50 [xfs]
[ 242.150472] [<ffffffff8105cd70>] ? default_wake_function+0x0/0x20
[ 242.150500] [<ffffffffa034d454>] xfs_log_reserve+0xd4/0xe0 [xfs]
[ 242.150529] [<ffffffffa0357b20>] xfs_trans_reserve+0xa0/0x210 [xfs]
[ 242.150556] [<ffffffffa035ca45>] xfs_free_eofblocks+0x185/0x2a0 [xfs]
[ 242.150583] [<ffffffffa035d578>] xfs_release+0x128/0x1f0 [xfs]
[ 242.150610] [<ffffffffa0364f35>] xfs_file_release+0x15/0x20 [xfs]
[ 242.150618] [<ffffffff81145ea5>] __fput+0xf5/0x210
[ 242.150626] [<ffffffff81145fe5>] fput+0x25/0x30
[ 242.150632] [<ffffffff8114210d>] filp_close+0x5d/0x90
[ 242.150639] [<ffffffff811421f7>] sys_close+0xb7/0x120
[ 242.150647] [<ffffffff810121b2>] system_call_fastpath+0x16/0x1b
[ 242.150653] INFO: task copy-files:3391 blocked for more than 120 seconds.
[ 242.150657] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
[ 242.150661] copy-files D 00000000ffffffff 0 3391 3337 0x00000000
[ 242.150668] ffff880208eafd38 0000000000000086 0000000000015c00 0000000000015c00
[ 242.150675] ffff8802103ec888 ffff880208eaffd8 0000000000015c00 ffff8802103ec4d0
[ 242.150683] 0000000000015c00 ffff880208eaffd8 0000000000015c00 ffff8802103ec888
[ 242.150690] Call Trace:
[ 242.150699] [<ffffffff81546477>] __mutex_lock_slowpath+0xf7/0x180
[ 242.150707] [<ffffffff81145c1a>] ? get_empty_filp+0x7a/0x170
[ 242.150715] [<ffffffff8154635b>] mutex_lock+0x2b/0x50
[ 242.150723] [<ffffffff81152d49>] do_filp_open+0x3d9/0xba0
[ 242.150729] [<ffffffff81148b74>] ? cp_new_stat+0xe4/0x100
[ 242.150737] [<ffffffff8115e7fa>] ? alloc_fd+0x10a/0x150
[ 242.150744] [<ffffffff811422c9>] do_sys_open+0x69/0x170
[ 242.150751] [<ffffffff81142410>] sys_open+0x20/0x30
[ 242.150759] [<ffffffff810121b2>] system_call_fastpath+0x16/0x1b
[ 242.150765] INFO: task copy-files:3394 blocked for more than 120 seconds.
[ 242.150768] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
[ 242.150773] copy-files D ffff8801f2b08f10 0 3394 3337 0x00000000
[ 242.150780] ffff8801ed697d38 0000000000000086 0000000000015c00 0000000000015c00
[ 242.150787] ffff88021402c888 ffff8801ed697fd8 0000000000015c00 ffff88021402c4d0
[ 242.150794] 0000000000015c00 ffff8801ed697fd8 0000000000015c00 ffff88021402c888
[ 242.150801] Call Trace:
[ 242.150809] [<ffffffff81546477>] __mutex_lock_slowpath+0xf7/0x180
[ 242.150818] [<ffffffff8154635b>] mutex_lock+0x2b/0x50
[ 242.150825] [<ffffffff81152d49>] do_filp_open+0x3d9/0xba0
[ 242.150831] [<ffffffff81148b74>] ? cp_new_stat+0xe4/0x100
[ 242.150839] [<ffffffff8115e7fa>] ? alloc_fd+0x10a/0x150
[ 242.150846] [<ffffffff811422c9>] do_sys_open+0x69/0x170
[ 242.150853] [<ffffffff81142410>] sys_open+0x20/0x30
[ 242.150861] [<ffffffff810121b2>] system_call_fastpath+0x16/0x1b
[ 242.150866] INFO: task copy-files:3395 blocked for more than 120 seconds.
[ 242.150870] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
[ 242.150874] copy-files D 0000000000000000 0 3395 3337 0x00000000
[ 242.150881] ffff8801ed68f7a8 0000000000000086 0000000000015c00 0000000000015c00
[ 242.150888] ffff880214b44888 ffff8801ed68ffd8 0000000000015c00 ffff880214b444d0
[ 242.150895] 0000000000015c00 ffff8801ed68ffd8 0000000000015c00 ffff880214b44888
[ 242.150902] Call Trace:
[ 242.150930] [<ffffffffa034d103>] xlog_grant_log_space+0x173/0x3f0 [xfs]
[ 242.150957] [<ffffffffa035fa4a>] ? kmem_zone_zalloc+0x3a/0x50 [xfs]
[ 242.150963] [<ffffffff8105cd70>] ? default_wake_function+0x0/0x20
[ 242.150991] [<ffffffffa034d454>] xfs_log_reserve+0xd4/0xe0 [xfs]
[ 242.151019] [<ffffffffa0357b20>] xfs_trans_reserve+0xa0/0x210 [xfs]
[ 242.151048] [<ffffffffa0357e8f>] ? xfs_trans_alloc+0x9f/0xb0 [xfs]
[ 242.151077] [<ffffffffa03472cc>] xfs_iomap_write_allocate+0x25c/0x3c0 [xfs]
[ 242.151107] [<ffffffffa0358929>] ? xfs_trans_unlocked_item+0x39/0x60 [xfs]
[ 242.151136] [<ffffffffa0347f8b>] xfs_iomap+0x2ab/0x2e0 [xfs]
[ 242.151163] [<ffffffffa036067d>] xfs_map_blocks+0x2d/0x40 [xfs]
[ 242.151190] [<ffffffffa0361a7a>] xfs_page_state_convert+0x3da/0x720 [xfs]
[ 242.151200] [<ffffffff812b9f05>] ? radix_tree_gang_lookup_tag_slot+0x95/0xe0
[ 242.151209] [<ffffffff810f4581>] ? generic_perform_write+0x161/0x1d0
[ 242.151235] [<ffffffffa0361f2a>] xfs_vm_writepage+0x7a/0x130 [xfs]
[ 242.151244] [<ffffffff8110e0f5>] ? __dec_zone_page_state+0x35/0x40
[ 242.151253] [<ffffffff810fcf07>] __writepage+0x17/0x40
[ 242.151259] [<ffffffff810fe08f>] write_cache_pages+0x1df/0x3e0
[ 242.151268] [<ffffffff810fcef0>] ? __writepage+0x0/0x40
[ 242.151275] [<ffffffff810fe2b4>] generic_writepages+0x24/0x30
[ 242.151301] [<ffffffffa0360d1d>] xfs_vm_writepages+0x5d/0x80 [xfs]
[ 242.151307] [<ffffffff810fe2e1>] do_writepages+0x21/0x40
[ 242.151315] [<ffffffff810f556b>] __filemap_fdatawrite_range+0x5b/0x60
[ 242.151323] [<ffffffff810f589f>] filemap_fdatawrite+0x1f/0x30
[ 242.151349] [<ffffffffa0365199>] xfs_flush_pages+0xa9/0xc0 [xfs]
[ 242.151375] [<ffffffffa035d5cf>] xfs_release+0x17f/0x1f0 [xfs]
[ 242.151401] [<ffffffffa0364f35>] xfs_file_release+0x15/0x20 [xfs]
[ 242.151410] [<ffffffff81145ea5>] __fput+0xf5/0x210
[ 242.151417] [<ffffffff81145fe5>] fput+0x25/0x30
[ 242.151424] [<ffffffff8114210d>] filp_close+0x5d/0x90
[ 242.151431] [<ffffffff811421f7>] sys_close+0xb7/0x120
[ 242.151439] [<ffffffff810121b2>] system_call_fastpath+0x16/0x1b
[ 242.151445] INFO: task copy-files:3398 blocked for more than 120 seconds.
[ 242.151449] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
[ 242.151453] copy-files D 0000000000000000 0 3398 3337 0x00000000
[ 242.151460] ffff8801ed4adc88 0000000000000086 0000000000015c00 0000000000015c00
[ 242.151467] ffff8802105b9aa8 ffff8801ed4adfd8 0000000000015c00 ffff8802105b96f0
[ 242.151474] 0000000000015c00 ffff8801ed4adfd8 0000000000015c00 ffff8802105b9aa8
[ 242.151481] Call Trace:
[ 242.151509] [<ffffffffa034d103>] xlog_grant_log_space+0x173/0x3f0 [xfs]
[ 242.151535] [<ffffffffa035fa4a>] ? kmem_zone_zalloc+0x3a/0x50 [xfs]
[ 242.151542] [<ffffffff8105cd70>] ? default_wake_function+0x0/0x20
[ 242.151570] [<ffffffffa034d454>] xfs_log_reserve+0xd4/0xe0 [xfs]
[ 242.151599] [<ffffffffa0357b20>] xfs_trans_reserve+0xa0/0x210 [xfs]
[ 242.151625] [<ffffffffa035ca45>] xfs_free_eofblocks+0x185/0x2a0 [xfs]
[ 242.151652] [<ffffffffa035d578>] xfs_release+0x128/0x1f0 [xfs]
[ 242.151679] [<ffffffffa0364f35>] xfs_file_release+0x15/0x20 [xfs]
[ 242.151687] [<ffffffff81145ea5>] __fput+0xf5/0x210
[ 242.151694] [<ffffffff81145fe5>] fput+0x25/0x30
[ 242.151701] [<ffffffff8114210d>] filp_close+0x5d/0x90
[ 242.151728] [<ffffffff811421f7>] sys_close+0xb7/0x120
[ 242.151737] [<ffffffff810121b2>] system_call_fastpath+0x16/0x1b
[ 242.151743] INFO: task copy-files:3399 blocked for more than 120 seconds.
[ 242.151746] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
[ 242.151751] copy-files D 0000000000000000 0 3399 3337 0x00000000
[ 242.151758] ffff8802149afd38 0000000000000086 0000000000015c00 0000000000015c00
[ 242.151765] ffff8802105bb198 ffff8802149affd8 0000000000015c00 ffff8802105bade0
[ 242.151776] 0000000000015c00 ffff8802149affd8 0000000000015c00 ffff8802105bb198
[ 242.151794] Call Trace:
[ 242.151806] [<ffffffff81546477>] __mutex_lock_slowpath+0xf7/0x180
[ 242.151818] [<ffffffff81145c1a>] ? get_empty_filp+0x7a/0x170
[ 242.151831] [<ffffffff8154635b>] mutex_lock+0x2b/0x50
[ 242.151843] [<ffffffff81152d49>] do_filp_open+0x3d9/0xba0
[ 242.151853] [<ffffffff81148b74>] ? cp_new_stat+0xe4/0x100
[ 242.151866] [<ffffffff8115e7fa>] ? alloc_fd+0x10a/0x150
[ 242.151878] [<ffffffff811422c9>] do_sys_open+0x69/0x170
[ 242.151890] [<ffffffff81142410>] sys_open+0x20/0x30
[ 242.151902] [<ffffffff810121b2>] system_call_fastpath+0x16/0x1b
[ 242.151912] INFO: task copy-files:3401 blocked for more than 120 seconds.
[ 242.151919] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
[ 242.151928] copy-files D 0000000000000001 0 3401 3337 0x00000008
[ 242.151942] ffff8801ed4efcf8 0000000000000086 0000000000015c00 0000000000015c00
[ 242.151960] ffff8802105bdf78 ffff8801ed4effd8 0000000000015c00 ffff8802105bdbc0
[ 242.151978] 0000000000015c00 ffff8801ed4effd8 0000000000015c00 ffff8802105bdf78
[ 242.151995] Call Trace:
[ 242.152006] [<ffffffff81546477>] __mutex_lock_slowpath+0xf7/0x180
[ 242.152019] [<ffffffff8154635b>] mutex_lock+0x2b/0x50
[ 242.152030] [<ffffffff8114e923>] lock_rename+0xd3/0xe0
[ 242.152043] [<ffffffff81151d13>] sys_renameat+0x113/0x280
[ 242.152055] [<ffffffff81155280>] ? filldir+0x0/0xe0
[ 242.152069] [<ffffffff81145fe5>] ? fput+0x25/0x30
[ 242.152080] [<ffffffff8114210d>] ? filp_close+0x5d/0x90
[ 242.152092] [<ffffffff81151e9b>] sys_rename+0x1b/0x20
[ 242.152104] [<ffffffff810121b2>] system_call_fastpath+0x16/0x1b
[ 242.152113] INFO: task copy-files:3402 blocked for more than 120 seconds.
[ 242.152121] "echo 0 > /proc/sys/kernel/hung_task_timeout_secs" disables this message.
[ 242.152129] copy-files D 0000000000000000 0 3402 3337 0x00000000
[ 242.152143] ffff880208e09c88 0000000000000086 0000000000015c00 0000000000015c00
[ 242.152161] ffff8801ed6b03b8 ffff880208e09fd8 0000000000015c00 ffff8801ed6b0000
[ 242.152178] 0000000000015c00 ffff880208e09fd8 0000000000015c00 ffff8801ed6b03b8
[ 242.152196] Call Trace:
[ 242.152227] [<ffffffffa034d103>] xlog_grant_log_space+0x173/0x3f0 [xfs]
[ 242.152258] [<ffffffffa035fa4a>] ? kmem_zone_zalloc+0x3a/0x50 [xfs]
[ 242.152270] [<ffffffff8105cd70>] ? default_wake_function+0x0/0x20
[ 242.152302] [<ffffffffa034d454>] xfs_log_reserve+0xd4/0xe0 [xfs]
[ 242.152335] [<ffffffffa0357b20>] xfs_trans_reserve+0xa0/0x210 [xfs]
[ 242.152367] [<ffffffffa035ca45>] xfs_free_eofblocks+0x185/0x2a0 [xfs]
[ 242.152398] [<ffffffffa035d578>] xfs_release+0x128/0x1f0 [xfs]
[ 242.152429] [<ffffffffa0364f35>] xfs_file_release+0x15/0x20 [xfs]
[ 242.152442] [<ffffffff81145ea5>] __fput+0xf5/0x210
[ 242.152454] [<ffffffff81145fe5>] fput+0x25/0x30
[ 242.152464] [<ffffffff8114210d>] filp_close+0x5d/0x90
[ 242.152475] [<ffffffff811421f7>] sys_close+0xb7/0x120
[ 242.152488] [<ffffffff810121b2>] system_call_fastpath+0x16/0x1b

[-- Attachment #3: Type: text/plain, Size: 121 bytes --]