Linux Archive

Linux Archive (http://www.linux-archive.org/)
-   Debian Kernel (http://www.linux-archive.org/debian-kernel/)
-   -   Bug#631287: BUG during access to hiddev (APC UPS) (http://www.linux-archive.org/debian-kernel/542891-bug-631287-bug-during-access-hiddev-apc-ups.html)

Dmitry Eremin-Solenikov 06-22-2011 03:24 PM

Bug#631287: BUG during access to hiddev (APC UPS)
 
Package: linux-image-2.6.32-5-686-bigmem
Version: 2.6.32-34squeeze1
Severity: important

After upgrading to squeeze I've started receiving the following BUG in dmesg
when apcupsd tries to access hid device for my UPS (APC SmartUPS 3000,
connected via USB).

[ 42.745031] usb 2-2: new low speed USB device using uhci_hcd and address 4
[ 42.938593] usb 2-2: New USB device found, idVendor=051d, idProduct=0002
[ 42.938599] usb 2-2: New USB device strings: Mfr=3, Product=1, SerialNumber=2
[ 42.938603] usb 2-2: Product: Smart-UPS 3000 RM FW:666.6.I USB FW:2.4
[ 42.938607] usb 2-2: Manufacturer: American Power Conversion
[ 42.938610] usb 2-2: SerialNumber: CS0533110332
[ 42.938754] usb 2-2: configuration #1 chosen from 1 choice
[ 45.380361] generic-usb 0003:051D:0002.0005: hiddev0,hidraw0: USB HID v1.10 Device [American Power Conversion Smart-UPS 3000 RM FW:666.6.I USB FW:2.4] on u
sb-0000:00:1d.0-2/input0
[ 48.268044] usb 2-2: USB disconnect, address 4
[ 48.269572] /tmp/buildd/linux-2.6-2.6.32/debian/build/source_i386_none/drivers/hid/usbhid/hid-core.c: usb_submit_urb(ctrl) failed
[ 48.731053] BUG: unable to handle kernel NULL pointer dereference at (null)
[ 48.731193] IP: [<f843db27>] hiddev_ioctl+0x26/0x56f [usbhid]
[ 48.731294] *pdpt = 000000003587c001 *pde = 0000000000000000
[ 48.731424] Oops: 0000 [#1] SMP
[ 48.731549] last sysfs file: /sys/devices/pci0000:00/0000:00:1d.0/usb2/2-2/2-2:1.0/0003:051D:0002.0005/hidraw/hidraw0/uevent
[ 48.731619] Modules linked in: microcode xfs exportfs eeprom ipmi_devintf st(+) ch(+) ipmi_si ipmi_msghandler mptctl psmouse dm_snapshot snd_pcm snd_timer
parport_pc snd soundcore snd_page_alloc parport i2c_i801 pcspkr e752x_edac shpchp joydev evdev serio_raw container i2c_core rng_core pci_hotplug button edac_c
ore processor ext3 jbd mbcache dm_mod sr_mod cdrom sg sd_mod crc_t10dif ata_generic usbhid hid aic7xxx ata_piix uhci_hcd libata mptspi megaraid_mbox mptscsih
mptbase ehci_hcd floppy tg3 megaraid_mm scsi_transport_spi libphy thermal thermal_sys scsi_mod usbcore nls_base [last unloaded: scsi_wait_scan]
[ 48.734244]
[ 48.734295] Pid: 1390, comm: apcupsd Not tainted (2.6.32-5-686-bigmem #1) D1889
[ 48.734361] EIP: 0060:[<f843db27>] EFLAGS: 00010286 CPU: 0
[ 48.734419] EIP is at hiddev_ioctl+0x26/0x56f [usbhid]
[ 48.734473] EAX: 00000000 EBX: 400c4807 ECX: bffb50d4 EDX: fffffffb
[ 48.734528] ESI: f65dd5c0 EDI: f645a000 EBP: bffb50d4 ESP: f5f8bea0
[ 48.734584] DS: 007b ES: 007b FS: 00d8 GS: 00e0 SS: 0068
[ 48.734639] Process apcupsd (pid: 1390, ti=f5f8a000 task=f5dc1100 task.ti=f5f8a000)
[ 48.734703] Stack:
[ 48.734752] c1031658 f5b20000 c143de20 f5ff9e00 c2608e20 f5ff9e00 c127e933 c13a4ba0
[ 48.735023] <0> c143959c c143de20 c143de20 c1439354 f5dc12bc c2608e20 00000000 00000000
[ 48.735023] <0> 00000296 00000292 0000c350 f5dc1100 c26045cc f5f8bf44 c104d131 f5f8bf44
[ 48.735023] Call Trace:
[ 48.735023] [<c1031658>] ? finish_task_switch+0x34/0x95
[ 48.735023] [<c127e933>] ? schedule+0x7a4/0x7f1
[ 48.735023] [<c104d131>] ? lock_hrtimer_base+0x15/0x2f
[ 48.735023] [<c104d1af>] ? hrtimer_try_to_cancel+0x2f/0x35
[ 48.735023] [<c104d1bf>] ? hrtimer_cancel+0xa/0x14
[ 48.735023] [<f843db01>] ? hiddev_ioctl+0x0/0x56f [usbhid]
[ 48.735023] [<c10c53d4>] ? vfs_ioctl+0x1c/0x5f
[ 48.735023] [<c10c5968>] ? do_vfs_ioctl+0x4aa/0x4e5
[ 48.735023] [<c104cae6>] ? hrtimer_wakeup+0x0/0x18
[ 48.735023] [<c10517e0>] ? getnstimeofday+0x4d/0xc9
[ 48.735023] [<c1051896>] ? do_gettimeofday+0xf/0x29
[ 48.735023] [<c10c59e4>] ? sys_ioctl+0x41/0x58
[ 48.735023] [<c100813b>] ? sysenter_do_call+0x12/0x28
[ 48.735023] Code: 5b 5e 5f 5d c3 55 89 cd 57 56 53 89 d3 83 ec 7c 8b 40 70 ba fb ff ff ff 89 44 24 04 8b b0 10 c0 00 00 8b 7e 28 8b 87 54 0c 00 00 <8b> 08 8b 87 a0 0e 00 00 89 04 24 83 3e 00 0f 84 2b 05 00 00 81
[ 48.735023] EIP: [<f843db27>] hiddev_ioctl+0x26/0x56f [usbhid] SS:ESP 0068:f5f8bea0
[ 48.735023] CR2: 0000000000000000
[ 48.739373] ---[ end trace 650ff9964d1a683e ]---

Full dmesg will be attached to this message.

-- System Information:
Debian Release: wheezy/sid
APT prefers testing-proposed-updates
APT policy: (500, 'testing-proposed-updates'), (500, 'stable-updates'), (500, 'unstable'), (500, 'testing')
Architecture: i386 (i686)

Kernel: Linux 2.6.39-2-686-pae (SMP w/2 CPU cores)
Locale: LANG=ru_RU.utf8, LC_CTYPE=ru_RU.utf8 (charmap=UTF-8)
Shell: /bin/sh linked to /bin/bash

--
With best wishes
Dmitry

[ 0.000000] Initializing cgroup subsys cpuset
[ 0.000000] Initializing cgroup subsys cpu
[ 0.000000] Linux version 2.6.32-5-686-bigmem (Debian 2.6.32-34squeeze1) (dannf@debian.org) (gcc version 4.3.5 (Debian 4.3.5-4) ) #1 SMP Wed May 18 07:33:52 UTC 2011
[ 0.000000] KERNEL supported cpus:
[ 0.000000] Intel GenuineIntel
[ 0.000000] AMD AuthenticAMD
[ 0.000000] NSC Geode by NSC
[ 0.000000] Cyrix CyrixInstead
[ 0.000000] Centaur CentaurHauls
[ 0.000000] Transmeta GenuineTMx86
[ 0.000000] Transmeta TransmetaCPU
[ 0.000000] UMC UMC UMC UMC
[ 0.000000] BIOS-provided physical RAM map:
[ 0.000000] BIOS-e820: 0000000000000000 - 000000000009a800 (usable)
[ 0.000000] BIOS-e820: 000000000009a800 - 00000000000a0000 (reserved)
[ 0.000000] BIOS-e820: 00000000000e0000 - 0000000000100000 (reserved)
[ 0.000000] BIOS-e820: 0000000000100000 - 000000007fef0000 (usable)
[ 0.000000] BIOS-e820: 000000007fef0000 - 000000007fefb000 (ACPI data)
[ 0.000000] BIOS-e820: 000000007fefb000 - 000000007ff00000 (ACPI NVS)
[ 0.000000] BIOS-e820: 000000007ff00000 - 000000007ff80000 (usable)
[ 0.000000] BIOS-e820: 000000007ff80000 - 0000000080000000 (reserved)
[ 0.000000] BIOS-e820: 00000000e0000000 - 00000000f0000000 (reserved)
[ 0.000000] BIOS-e820: 00000000fec00000 - 00000000fed00400 (reserved)
[ 0.000000] BIOS-e820: 00000000fee00000 - 00000000fef00000 (reserved)
[ 0.000000] BIOS-e820: 00000000ffb00000 - 00000000ffc00000 (reserved)
[ 0.000000] BIOS-e820: 00000000fff00000 - 0000000100000000 (reserved)
[ 0.000000] DMI present.
[ 0.000000] Phoenix BIOS detected: BIOS may corrupt low RAM, working around it.
[ 0.000000] e820 update range: 0000000000000000 - 0000000000010000 (usable) ==> (reserved)
[ 0.000000] last_pfn = 0x7ff80 max_arch_pfn = 0x1000000
[ 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-C7FFF write-protect
[ 0.000000] C8000-DFFFF uncachable
[ 0.000000] E0000-FFFFF write-protect
[ 0.000000] MTRR variable ranges enabled:
[ 0.000000] 0 base 000000000 mask F80000000 write-back
[ 0.000000] 1 base 07FF80000 mask FFFF80000 uncachable
[ 0.000000] 2 disabled
[ 0.000000] 3 disabled
[ 0.000000] 4 disabled
[ 0.000000] 5 disabled
[ 0.000000] 6 disabled
[ 0.000000] 7 disabled
[ 0.000000] x86 PAT enabled: cpu 0, old 0x7040600070406, new 0x7010600070106
[ 0.000000] initial memory mapped : 0 - 01a00000
[ 0.000000] init_memory_mapping: 0000000000000000-00000000377fe000
[ 0.000000] NX (Execute Disable) protection: active
[ 0.000000] 0000000000 - 0000200000 page 4k
[ 0.000000] 0000200000 - 0037600000 page 2M
[ 0.000000] 0037600000 - 00377fe000 page 4k
[ 0.000000] kernel direct mapping tables up to 377fe000 @ 10000-17000
[ 0.000000] RAMDISK: 376d3000 - 37fefdda
[ 0.000000] Allocated new RAMDISK: 00100000 - 00a1cdda
[ 0.000000] Move RAMDISK from 00000000376d3000 - 0000000037fefdd9 to 00100000 - 00a1cdd9
[ 0.000000] ACPI: RSDP 000f6ba0 00024 (v02 PTLTD )
[ 0.000000] ACPI: XSDT 7fef5381 0004C (v01 PTLTD ? XSDT 06040001 LTP 00000000)
[ 0.000000] ACPI: FACP 7fef5441 000F4 (v03 FSC 06040001 000F4240)
[ 0.000000] ACPI: DSDT 7fef5535 0597B (v01 FSC D1649 06040001 MSFT 02000002)
[ 0.000000] ACPI: FACS 7fefbfc0 00040
[ 0.000000] ACPI: SPCR 7fefaeb0 00050 (v01 PTLTD $UCRTBL$ 06040001 PTL 00000001)
[ 0.000000] ACPI: MCFG 7fefaf00 00040 (v01 PTLTD MCFG 06040001 LTP 00000000)
[ 0.000000] ACPI: APIC 7fefaf40 00098 (v01 PTLTD ? APIC 06040001 LTP 00000000)
[ 0.000000] ACPI: BOOT 7fefafd8 00028 (v01 PTLTD $SBFTBL$ 06040001 LTP 00000001)
[ 0.000000] ACPI: Local APIC address 0xfee00000
[ 0.000000] 1159MB HIGHMEM available.
[ 0.000000] 887MB LOWMEM available.
[ 0.000000] mapped low ram: 0 - 377fe000
[ 0.000000] low ram: 0 - 377fe000
[ 0.000000] node 0 low ram: 00000000 - 377fe000
[ 0.000000] node 0 bootmap 00014000 - 0001af00
[ 0.000000] (9 early reservations) ==> bootmem [0000000000 - 00377fe000]
[ 0.000000] #0 [0000000000 - 0000001000] BIOS data page ==> [0000000000 - 0000001000]
[ 0.000000] #1 [0000001000 - 0000002000] EX TRAMPOLINE ==> [0000001000 - 0000002000]
[ 0.000000] #2 [0000006000 - 0000007000] TRAMPOLINE ==> [0000006000 - 0000007000]
[ 0.000000] #3 [0001000000 - 00014ff3f4] TEXT DATA BSS ==> [0001000000 - 00014ff3f4]
[ 0.000000] #4 [000009a800 - 0000100000] BIOS reserved ==> [000009a800 - 0000100000]
[ 0.000000] #5 [0001500000 - 000150d1b0] BRK ==> [0001500000 - 000150d1b0]
[ 0.000000] #6 [0000010000 - 0000014000] PGTABLE ==> [0000010000 - 0000014000]
[ 0.000000] #7 [0000100000 - 0000a1cdda] NEW RAMDISK ==> [0000100000 - 0000a1cdda]
[ 0.000000] #8 [0000014000 - 000001b000] BOOTMAP ==> [0000014000 - 000001b000]
[ 0.000000] found SMP MP-table at [c00f6c10] f6c10
[ 0.000000] Zone PFN ranges:
[ 0.000000] DMA 0x00000010 -> 0x00001000
[ 0.000000] Normal 0x00001000 -> 0x000377fe
[ 0.000000] HighMem 0x000377fe -> 0x0007ff80
[ 0.000000] Movable zone start PFN for each node
[ 0.000000] early_node_map[3] active PFN ranges
[ 0.000000] 0: 0x00000010 -> 0x0000009a
[ 0.000000] 0: 0x00000100 -> 0x0007fef0
[ 0.000000] 0: 0x0007ff00 -> 0x0007ff80
[ 0.000000] On node 0 totalpages: 524026
[ 0.000000] free_area_init_node: node 0, pgdat c13d2100, node_mem_map c150f200
[ 0.000000] DMA zone: 32 pages used for memmap
[ 0.000000] DMA zone: 0 pages reserved
[ 0.000000] DMA zone: 3946 pages, LIFO batch:0
[ 0.000000] Normal zone: 1744 pages used for memmap
[ 0.000000] Normal zone: 221486 pages, LIFO batch:31
[ 0.000000] HighMem zone: 2320 pages used for memmap
[ 0.000000] HighMem zone: 294498 pages, LIFO batch:31
[ 0.000000] Using APIC driver default
[ 0.000000] ACPI: PM-Timer IO Port: 0xf008
[ 0.000000] ACPI: Local APIC address 0xfee00000
[ 0.000000] ACPI: LAPIC (acpi_id[0x00] lapic_id[0x00] enabled)
[ 0.000000] ACPI: LAPIC (acpi_id[0x01] lapic_id[0x01] enabled)
[ 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: IOAPIC (id[0x03] address[0xfec80000] gsi_base[24])
[ 0.000000] IOAPIC[1]: apic_id 3, version 32, address 0xfec80000, GSI 24-47
[ 0.000000] ACPI: IOAPIC (id[0x04] address[0xfec80800] gsi_base[48])
[ 0.000000] IOAPIC[2]: apic_id 4, version 32, address 0xfec80800, GSI 48-71
[ 0.000000] ACPI: IOAPIC (id[0x05] address[0xfec84000] gsi_base[72])
[ 0.000000] IOAPIC[3]: apic_id 5, version 32, address 0xfec84000, GSI 72-95
[ 0.000000] ACPI: IOAPIC (id[0x06] address[0xfec84800] gsi_base[96])
[ 0.000000] IOAPIC[4]: apic_id 6, version 32, address 0xfec84800, GSI 96-119
[ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 high edge)
[ 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] SMP: Allowing 2 CPUs, 0 hotplug CPUs
[ 0.000000] nr_irqs_gsi: 120
[ 0.000000] PM: Registered nosave memory: 000000000009a000 - 000000000009b000
[ 0.000000] PM: Registered nosave memory: 000000000009b000 - 00000000000a0000
[ 0.000000] PM: Registered nosave memory: 00000000000a0000 - 00000000000e0000
[ 0.000000] PM: Registered nosave memory: 00000000000e0000 - 0000000000100000
[ 0.000000] Allocating PCI resources starting at 80000000 (gap: 80000000:60000000)
[ 0.000000] Booting paravirtualized kernel on bare hardware
[ 0.000000] NR_CPUS:32 nr_cpumask_bits:32 nr_cpu_ids:2 nr_node_ids:1
[ 0.000000] PERCPU: Embedded 15 pages/cpu @c2600000 s37688 r0 d23752 u1048576
[ 0.000000] pcpu-alloc: s37688 r0 d23752 u1048576 alloc=1*2097152
[ 0.000000] pcpu-alloc: [0] 0 1
[ 0.000000] Built 1 zonelists in Zone order, mobility grouping on. Total pages: 519930
[ 0.000000] Kernel command line: BOOT_IMAGE=/boot/vmlinuz-2.6.32-5-686-bigmem root=UUID=0e4ac9a7-9111-43ff-b284-241456b95d67 ro quiet
[ 0.000000] PID hash table entries: 4096 (order: 2, 16384 bytes)
[ 0.000000] Dentry cache hash table entries: 131072 (order: 7, 524288 bytes)
[ 0.000000] Inode-cache hash table entries: 65536 (order: 6, 262144 bytes)
[ 0.000000] Enabling fast FPU save and restore... done.
[ 0.000000] Enabling unmasked SIMD FPU exception support... done.
[ 0.000000] Initializing CPU#0
[ 0.000000] Initializing HighMem for node 0 (000377fe:0007ff80)
[ 0.000000] Memory: 2063248k/2096640k available (2573k kernel code, 31884k reserved, 1378k data, 396k init, 1187272k highmem)
[ 0.000000] virtual kernel memory layout:
[ 0.000000] fixmap : 0xffd56000 - 0xfffff000 (2724 kB)
[ 0.000000] pkmap : 0xff800000 - 0xffa00000 (2048 kB)
[ 0.000000] vmalloc : 0xf7ffe000 - 0xff7fe000 ( 120 MB)
[ 0.000000] lowmem : 0xc0000000 - 0xf77fe000 ( 887 MB)
[ 0.000000] .init : 0xc13dc000 - 0xc143f000 ( 396 kB)
[ 0.000000] .data : 0xc128359d - 0xc13dbeb0 (1378 kB)
[ 0.000000] .text : 0xc1000000 - 0xc128359d (2573 kB)
[ 0.000000] Checking if this processor honours the WP bit even in supervisor mode...Ok.
[ 0.000000] SLUB: Genslabs=13, HWalign=128, Order=0-3, MinObjects=0, CPUs=2, Nodes=1
[ 0.000000] Hierarchical RCU implementation.
[ 0.000000] NR_IRQS:1280
[ 0.000000] Extended CMOS year: 2000
[ 0.000000] Console: colour VGA+ 80x25
[ 0.000000] console [tty0] enabled
[ 0.000000] Fast TSC calibration using PIT
[ 0.000000] Detected 3000.176 MHz processor.
[ 0.004005] Calibrating delay loop (skipped), value calculated using timer frequency.. 6000.35 BogoMIPS (lpj=12000704)
[ 0.004025] Security Framework initialized
[ 0.004032] SELinux: Disabled at boot.
[ 0.004041] Mount-cache hash table entries: 512
[ 0.004197] Initializing cgroup subsys ns
[ 0.004202] Initializing cgroup subsys cpuacct
[ 0.004207] Initializing cgroup subsys devices
[ 0.004210] Initializing cgroup subsys freezer
[ 0.004213] Initializing cgroup subsys net_cls
[ 0.004247] CPU: Trace cache: 12K uops, L1 D cache: 16K
[ 0.004250] CPU: L2 cache: 2048K
[ 0.004254] CPU: Physical Processor ID: 0
[ 0.004256] CPU: Processor Core ID: 0
[ 0.004260] mce: CPU supports 4 MCE banks
[ 0.004274] CPU0: Thermal monitoring enabled (TM1)
[ 0.004279] using mwait in idle threads.
[ 0.004289] Performance Events: no PMU driver, software events only.
[ 0.004298] Checking 'hlt' instruction... OK.
[ 0.021613] ACPI: Core revision 20090903
[ 0.032073] Enabling APIC mode: Flat. Using 5 I/O APICs
[ 0.032592] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1
[ 0.074193] CPU0: Intel(R) Xeon(TM) CPU 3.00GHz stepping 03
[ 0.076001] Booting processor 1 APIC 0x1 ip 0x6000
[ 0.008000] Initializing CPU#1
[ 0.008000] CPU: Trace cache: 12K uops, L1 D cache: 16K
[ 0.008000] CPU: L2 cache: 2048K
[ 0.008000] CPU: Physical Processor ID: 0
[ 0.008000] CPU: Processor Core ID: 0
[ 0.008000] CPU1: Thermal monitoring enabled (TM1)
[ 0.160120] CPU1: Intel(R) Xeon(TM) CPU 3.00GHz stepping 03
[ 0.160131] checking TSC synchronization [CPU#0 -> CPU#1]: passed.
[ 0.164083] Brought up 2 CPUs
[ 0.164089] Total of 2 processors activated (12000.94 BogoMIPS).
[ 0.165021] CPU0 attaching sched-domain:
[ 0.165026] domain 0: span 0-1 level SIBLING
[ 0.165030] groups: 0 (cpu_power = 589) 1 (cpu_power = 589)
[ 0.165038] domain 1: span 0-1 level MC
[ 0.165041] groups: 0-1 (cpu_power = 1178)
[ 0.165048] CPU1 attaching sched-domain:
[ 0.165050] domain 0: span 0-1 level SIBLING
[ 0.165053] groups: 1 (cpu_power = 589) 0 (cpu_power = 589)
[ 0.165060] domain 1: span 0-1 level MC
[ 0.165063] groups: 0-1 (cpu_power = 1178)
[ 0.165168] devtmpfs: initialized
[ 0.165168] regulator: core version 0.5
[ 0.165168] NET: Registered protocol family 16
[ 0.165168] ACPI: bus type pci registered
[ 0.165168] PCI: Found Intel Corporation E7520 Memory Controller Hub with MMCONFIG support.
[ 0.165168] PCI: MCFG configuration 0: base e0000000 segment 0 buses 0 - 255
[ 0.165168] PCI: MCFG area at e0000000 reserved in E820
[ 0.165168] PCI: Using MMCONFIG for extended config space
[ 0.165168] PCI: Using configuration type 1 for base access
[ 0.165168] bio: create slab <bio-0> at 0
[ 0.165168] ACPI: EC: Look up EC in DSDT
[ 0.172679] ACPI: Interpreter enabled
[ 0.172685] ACPI: (supports S0 S1 S4 S5)
[ 0.172712] ACPI: Using IOAPIC for interrupt routing
[ 0.179394] ACPI: No dock devices found.
[ 0.179511] ACPI: PCI Root Bridge [PCI0] (0000:00)
[ 0.179676] pci 0000:00:02.0: PME# supported from D0 D3hot D3cold
[ 0.179681] pci 0000:00:02.0: PME# disabled
[ 0.179751] pci 0000:00:04.0: PME# supported from D0 D3hot D3cold
[ 0.179756] pci 0000:00:04.0: PME# disabled
[ 0.179827] pci 0000:00:05.0: PME# supported from D0 D3hot D3cold
[ 0.179832] pci 0000:00:05.0: PME# disabled
[ 0.179907] pci 0000:00:06.0: PME# supported from D0 D3hot D3cold
[ 0.179912] pci 0000:00:06.0: PME# disabled
[ 0.179985] pci 0000:00:1d.0: reg 20 io port: [0x1000-0x101f]
[ 0.180052] pci 0000:00:1d.1: reg 20 io port: [0x1400-0x141f]
[ 0.180107] pci 0000:00:1d.2: reg 20 io port: [0x1800-0x181f]
[ 0.180162] pci 0000:00:1d.3: reg 20 io port: [0x1c00-0x1c1f]
[ 0.180225] pci 0000:00:1d.7: reg 10 32bit mmio: [0xde100000-0xde1003ff]
[ 0.180285] pci 0000:00:1d.7: PME# supported from D0 D3hot D3cold
[ 0.180291] pci 0000:00:1d.7: PME# disabled
[ 0.180382] pci 0000:00:1f.0: Force enabled HPET at 0xfed00000
[ 0.180390] pci 0000:00:1f.0: quirk: region f000-f07f claimed by ICH4 ACPI/GPIO/TCO
[ 0.180396] pci 0000:00:1f.0: quirk: region f180-f1bf claimed by ICH4 GPIO
[ 0.180421] pci 0000:00:1f.1: reg 10 io port: [0x00-0x07]
[ 0.180429] pci 0000:00:1f.1: reg 14 io port: [0x00-0x03]
[ 0.180437] pci 0000:00:1f.1: reg 18 io port: [0x00-0x07]
[ 0.180444] pci 0000:00:1f.1: reg 1c io port: [0x00-0x03]
[ 0.180452] pci 0000:00:1f.1: reg 20 io port: [0x2400-0x240f]
[ 0.180460] pci 0000:00:1f.1: reg 24 32bit mmio: [0x000000-0x0003ff]
[ 0.180515] pci 0000:00:1f.3: reg 20 io port: [0x2000-0x201f]
[ 0.180593] pci 0000:01:00.0: PME# supported from D0 D3hot D3cold
[ 0.180598] pci 0000:01:00.0: PME# disabled
[ 0.180662] pci 0000:01:00.2: PME# supported from D0 D3hot D3cold
[ 0.180666] pci 0000:01:00.2: PME# disabled
[ 0.180687] pci 0000:01:00.0: disabling ASPM on pre-1.1 PCIe device. You can enable it with 'pcie_aspm=force'
[ 0.180751] pci 0000:00:02.0: bridge io port: [0x3000-0x3fff]
[ 0.180756] pci 0000:00:02.0: bridge 32bit mmio: [0xde200000-0xde4fffff]
[ 0.180812] pci 0000:02:08.0: reg 10 io port: [0x3000-0x30ff]
[ 0.180824] pci 0000:02:08.0: reg 14 64bit mmio: [0xde210000-0xde21ffff]
[ 0.180835] pci 0000:02:08.0: reg 1c 64bit mmio: [0xde200000-0xde20ffff]
[ 0.180847] pci 0000:02:08.0: reg 30 32bit mmio pref: [0x000000-0x0fffff]
[ 0.180872] pci 0000:02:08.0: supports D1 D2
[ 0.180918] pci 0000:02:08.1: reg 10 io port: [0x3400-0x34ff]
[ 0.180930] pci 0000:02:08.1: reg 14 64bit mmio: [0xde230000-0xde23ffff]
[ 0.180941] pci 0000:02:08.1: reg 1c 64bit mmio: [0xde220000-0xde22ffff]
[ 0.180953] pci 0000:02:08.1: reg 30 32bit mmio pref: [0x000000-0x0fffff]
[ 0.180977] pci 0000:02:08.1: supports D1 D2
[ 0.181029] pci 0000:01:00.0: bridge io port: [0x3000-0x3fff]
[ 0.181034] pci 0000:01:00.0: bridge 32bit mmio: [0xde200000-0xde4fffff]
[ 0.181147] pci 0000:04:00.0: reg 10 64bit mmio: [0xde500000-0xde50ffff]
[ 0.181210] pci 0000:04:00.0: PME# supported from D3hot D3cold
[ 0.181215] pci 0000:04:00.0: PME# disabled
[ 0.181242] pci 0000:04:00.0: disabling ASPM on pre-1.1 PCIe device. You can enable it with 'pcie_aspm=force'
[ 0.181321] pci 0000:00:04.0: bridge 32bit mmio: [0xde500000-0xde5fffff]
[ 0.181380] pci 0000:05:00.0: reg 10 64bit mmio: [0xde600000-0xde60ffff]
[ 0.181443] pci 0000:05:00.0: PME# supported from D3hot D3cold
[ 0.181449] pci 0000:05:00.0: PME# disabled
[ 0.181475] pci 0000:05:00.0: disabling ASPM on pre-1.1 PCIe device. You can enable it with 'pcie_aspm=force'
[ 0.181555] pci 0000:00:05.0: bridge 32bit mmio: [0xde600000-0xde6fffff]
[ 0.181596] pci 0000:06:00.0: PXH quirk detected; SHPC device MSI disabled
[ 0.181608] pci 0000:06:00.0: reg 10 64bit mmio: [0xde700000-0xde700fff]
[ 0.181639] pci 0000:06:00.0: PME# supported from D0 D3hot D3cold
[ 0.181643] pci 0000:06:00.0: PME# disabled
[ 0.181686] pci 0000:06:00.2: PXH quirk detected; SHPC device MSI disabled
[ 0.181722] pci 0000:06:00.2: PME# supported from D0 D3hot D3cold
[ 0.181727] pci 0000:06:00.2: PME# disabled
[ 0.181747] pci 0000:06:00.0: disabling ASPM on pre-1.1 PCIe device. You can enable it with 'pcie_aspm=force'
[ 0.181809] pci 0000:00:06.0: bridge io port: [0x4000-0x4fff]
[ 0.181814] pci 0000:00:06.0: bridge 32bit mmio: [0xde700000-0xde8fffff]
[ 0.181821] pci 0000:00:06.0: bridge 64bit mmio pref: [0xde000000-0xde0fffff]
[ 0.181911] pci 0000:08:0b.0: reg 10 io port: [0x4000-0x40ff]
[ 0.181923] pci 0000:08:0b.0: reg 14 64bit mmio: [0xde800000-0xde800fff]
[ 0.181943] pci 0000:08:0b.0: reg 30 32bit mmio pref: [0x000000-0x01ffff]
[ 0.182000] pci 0000:08:0c.0: reg 10 32bit mmio pref: [0xde000000-0xde00ffff]
[ 0.182037] pci 0000:08:0c.0: reg 30 32bit mmio pref: [0x000000-0x01ffff]
[ 0.182091] pci 0000:06:00.2: bridge io port: [0x4000-0x4fff]
[ 0.182096] pci 0000:06:00.2: bridge 32bit mmio: [0xde800000-0xde8fffff]
[ 0.182103] pci 0000:06:00.2: bridge 64bit mmio pref: [0xde000000-0xde0fffff]
[ 0.182153] pci 0000:09:05.0: reg 10 32bit mmio: [0xdf000000-0xdfffffff]
[ 0.182161] pci 0000:09:05.0: reg 14 io port: [0x5000-0x50ff]
[ 0.182169] pci 0000:09:05.0: reg 18 32bit mmio: [0xde900000-0xde900fff]
[ 0.182191] pci 0000:09:05.0: reg 30 32bit mmio pref: [0x000000-0x01ffff]
[ 0.182211] pci 0000:09:05.0: supports D1 D2
[ 0.182253] pci 0000:00:1e.0: transparent bridge
[ 0.182259] pci 0000:00:1e.0: bridge io port: [0x5000-0x5fff]
[ 0.182264] pci 0000:00:1e.0: bridge 32bit mmio: [0xde900000-0xdfffffff]
[ 0.182290] pci_bus 0000:00: on NUMA node 0
[ 0.182295] ACPI: PCI Interrupt Routing Table [\_SB_.PCI0._PRT]
[ 0.182610] ACPI: PCI Interrupt Routing Table [\_SB_.PCI0.PEA0.DOB0._PRT]
[ 0.182723] ACPI: PCI Interrupt Routing Table [\_SB_.PCI0.PEA0.DOB2._PRT]
[ 0.182970] ACPI: PCI Interrupt Routing Table [\_SB_.PCI0.PEC0.PXH0._PRT]
[ 0.183135] ACPI: PCI Interrupt Routing Table [\_SB_.PCI0.PEC0.PXH2._PRT]
[ 0.187413] ACPI: PCI Interrupt Link [LNKA] (IRQs 3 4 5 6 7 9 10 *11 12 14 15)
[ 0.187562] ACPI: PCI Interrupt Link [LNKB] (IRQs 3 4 5 6 7 *9 10 11 12 14 15)
[ 0.187707] ACPI: PCI Interrupt Link [LNKC] (IRQs 3 4 *5 6 7 9 10 11 12 14 15)
[ 0.187853] ACPI: PCI Interrupt Link [LNKD] (IRQs 3 4 5 6 7 9 *10 11 12 14 15)
[ 0.187977] ACPI: PCI Interrupt Link [LNKE] (IRQs 3 4 5 6 7 9 10 11 12 14 15) *0, disabled.
[ 0.188111] ACPI: PCI Interrupt Link [LNKF] (IRQs 3 4 5 6 7 9 10 11 12 14 15) *0, disabled.
[ 0.188235] ACPI: PCI Interrupt Link [LNKG] (IRQs 3 4 5 6 7 9 10 11 12 14 15) *0, disabled.
[ 0.188381] ACPI: PCI Interrupt Link [LNKH] (IRQs 3 4 5 6 7 *9 10 11 12 14 15)
[ 0.188529] vgaarb: device added: PCI:0000:09:05.0,decodes=io+mem,owns=io+mem,locks= none
[ 0.188533] vgaarb: loaded
[ 0.188557] PCI: Using ACPI for IRQ routing
[ 0.188557] hpet clockevent registered
[ 0.188557] HPET: 3 timers in total, 0 timers will be used for per-cpu timer
[ 0.188557] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0
[ 0.188557] hpet0: 3 comparators, 64-bit 14.318180 MHz counter
[ 0.192030] Switching to clocksource tsc
[ 0.193596] pnp: PnP ACPI init
[ 0.193613] ACPI: bus type pnp registered
[ 0.196375] pnp: PnP ACPI: found 12 devices
[ 0.196378] ACPI: ACPI bus type pnp unregistered
[ 0.196384] PnPBIOS: Disabled by ACPI PNP
[ 0.196397] system 00:02: ioport range 0x4d0-0x4d1 has been reserved
[ 0.196402] system 00:02: ioport range 0xca2-0xca3 has been reserved
[ 0.196406] system 00:02: ioport range 0xca4-0xca5 has been reserved
[ 0.196413] system 00:02: ioport range 0xf000-0xf07f has been reserved
[ 0.196417] system 00:02: ioport range 0xf100-0xf10f has been reserved
[ 0.196421] system 00:02: ioport range 0xf180-0xf1bf has been reserved
[ 0.196425] system 00:02: ioport range 0x800-0x87f has been reserved
[ 0.196429] system 00:02: ioport range 0xf820-0xf82f has been reserved
[ 0.196433] system 00:02: ioport range 0xfe00-0xfe00 has been reserved
[ 0.196438] system 00:02: iomem range 0xfee00000-0xfeefffff has been reserved
[ 0.196443] system 00:02: iomem range 0xfec00000-0xfecfffff could not be reserved
[ 0.231301] pci 0000:01:00.0: PCI bridge, secondary bus 0000:02
[ 0.231306] pci 0000:01:00.0: IO window: 0x3000-0x3fff
[ 0.231312] pci 0000:01:00.0: MEM window: 0xde200000-0xde4fffff
[ 0.231317] pci 0000:01:00.0: PREFETCH window: 0x80000000-0x801fffff
[ 0.231324] pci 0000:01:00.2: PCI bridge, secondary bus 0000:03
[ 0.231327] pci 0000:01:00.2: IO window: disabled
[ 0.231332] pci 0000:01:00.2: MEM window: disabled
[ 0.231336] pci 0000:01:00.2: PREFETCH window: disabled
[ 0.231343] pci 0000:00:02.0: PCI bridge, secondary bus 0000:01
[ 0.231347] pci 0000:00:02.0: IO window: 0x3000-0x3fff
[ 0.231353] pci 0000:00:02.0: MEM window: 0xde200000-0xde4fffff
[ 0.231358] pci 0000:00:02.0: PREFETCH window: 0x80000000-0x801fffff
[ 0.231364] pci 0000:00:04.0: PCI bridge, secondary bus 0000:04
[ 0.231367] pci 0000:00:04.0: IO window: disabled
[ 0.231373] pci 0000:00:04.0: MEM window: 0xde500000-0xde5fffff
[ 0.231377] pci 0000:00:04.0: PREFETCH window: disabled
[ 0.231384] pci 0000:00:05.0: PCI bridge, secondary bus 0000:05
[ 0.231386] pci 0000:00:05.0: IO window: disabled
[ 0.231392] pci 0000:00:05.0: MEM window: 0xde600000-0xde6fffff
[ 0.231396] pci 0000:00:05.0: PREFETCH window: disabled
[ 0.231403] pci 0000:06:00.0: PCI bridge, secondary bus 0000:07
[ 0.231406] pci 0000:06:00.0: IO window: disabled
[ 0.231411] pci 0000:06:00.0: MEM window: disabled
[ 0.231415] pci 0000:06:00.0: PREFETCH window: disabled
[ 0.231423] pci 0000:06:00.2: PCI bridge, secondary bus 0000:08
[ 0.231427] pci 0000:06:00.2: IO window: 0x4000-0x4fff
[ 0.231432] pci 0000:06:00.2: MEM window: 0xde800000-0xde8fffff
[ 0.231438] pci 0000:06:00.2: PREFETCH window: 0x000000de000000-0x000000de0fffff
[ 0.231444] pci 0000:00:06.0: PCI bridge, secondary bus 0000:06
[ 0.231448] pci 0000:00:06.0: IO window: 0x4000-0x4fff
[ 0.231454] pci 0000:00:06.0: MEM window: 0xde700000-0xde8fffff
[ 0.231459] pci 0000:00:06.0: PREFETCH window: 0x000000de000000-0x000000de0fffff
[ 0.231467] pci 0000:00:1e.0: PCI bridge, secondary bus 0000:09
[ 0.231471] pci 0000:00:1e.0: IO window: 0x5000-0x5fff
[ 0.231477] pci 0000:00:1e.0: MEM window: 0xde900000-0xdfffffff
[ 0.231483] pci 0000:00:1e.0: PREFETCH window: 0x80200000-0x802fffff
[ 0.231502] pci 0000:00:02.0: PCI INT A -> GSI 16 (level, low) -> IRQ 16
[ 0.231508] pci 0000:00:02.0: setting latency timer to 64
[ 0.231520] pci 0000:01:00.0: setting latency timer to 64
[ 0.231531] pci 0000:01:00.2: setting latency timer to 64
[ 0.231542] pci 0000:00:04.0: PCI INT A -> GSI 16 (level, low) -> IRQ 16
[ 0.231547] pci 0000:00:04.0: setting latency timer to 64
[ 0.231556] pci 0000:00:05.0: PCI INT A -> GSI 16 (level, low) -> IRQ 16
[ 0.231561] pci 0000:00:05.0: setting latency timer to 64
[ 0.231570] pci 0000:00:06.0: PCI INT A -> GSI 16 (level, low) -> IRQ 16
[ 0.231574] pci 0000:00:06.0: setting latency timer to 64
[ 0.231585] pci 0000:06:00.0: PCI INT A -> GSI 16 (level, low) -> IRQ 16
[ 0.231590] pci 0000:06:00.0: setting latency timer to 64
[ 0.231599] pci 0000:06:00.2: setting latency timer to 64
[ 0.231607] pci 0000:00:1e.0: setting latency timer to 64
[ 0.231613] pci_bus 0000:00: resource 0 io: [0x00-0xffff]
[ 0.231617] pci_bus 0000:00: resource 1 mem: [0x000000-0xffffffffffffffff]
[ 0.231621] pci_bus 0000:01: resource 0 io: [0x3000-0x3fff]
[ 0.231624] pci_bus 0000:01: resource 1 mem: [0xde200000-0xde4fffff]
[ 0.231628] pci_bus 0000:01: resource 2 pref mem [0x80000000-0x801fffff]
[ 0.231632] pci_bus 0000:02: resource 0 io: [0x3000-0x3fff]
[ 0.231635] pci_bus 0000:02: resource 1 mem: [0xde200000-0xde4fffff]
[ 0.231639] pci_bus 0000:02: resource 2 pref mem [0x80000000-0x801fffff]
[ 0.231643] pci_bus 0000:04: resource 1 mem: [0xde500000-0xde5fffff]
[ 0.231646] pci_bus 0000:05: resource 1 mem: [0xde600000-0xde6fffff]
[ 0.231650] pci_bus 0000:06: resource 0 io: [0x4000-0x4fff]
[ 0.231653] pci_bus 0000:06: resource 1 mem: [0xde700000-0xde8fffff]
[ 0.231657] pci_bus 0000:06: resource 2 pref mem [0xde000000-0xde0fffff]
[ 0.231660] pci_bus 0000:08: resource 0 io: [0x4000-0x4fff]
[ 0.231664] pci_bus 0000:08: resource 1 mem: [0xde800000-0xde8fffff]
[ 0.231681] pci_bus 0000:08: resource 2 pref mem [0xde000000-0xde0fffff]
[ 0.231685] pci_bus 0000:09: resource 0 io: [0x5000-0x5fff]
[ 0.231689] pci_bus 0000:09: resource 1 mem: [0xde900000-0xdfffffff]
[ 0.231692] pci_bus 0000:09: resource 2 pref mem [0x80200000-0x802fffff]
[ 0.231696] pci_bus 0000:09: resource 3 io: [0x00-0xffff]
[ 0.231699] pci_bus 0000:09: resource 4 mem: [0x000000-0xffffffffffffffff]
[ 0.231738] NET: Registered protocol family 2
[ 0.231853] IP route cache hash table entries: 32768 (order: 5, 131072 bytes)
[ 0.232253] TCP established hash table entries: 131072 (order: 8, 1048576 bytes)
[ 0.232748] TCP bind hash table entries: 65536 (order: 7, 524288 bytes)
[ 0.233001] TCP: Hash tables configured (established 131072 bind 65536)
[ 0.233005] TCP reno registered
[ 0.233091] NET: Registered protocol family 1
[ 0.233249] pci 0000:01:00.0: rerouting interrupts for [8086:0330]
[ 0.233255] pci 0000:01:00.2: rerouting interrupts for [8086:0332]
[ 0.233265] pci 0000:06:00.0: rerouting interrupts for [8086:0329]
[ 0.233270] pci 0000:06:00.2: rerouting interrupts for [8086:032a]
[ 0.233279] pci 0000:09:05.0: Boot video device
[ 0.233344] Unpacking initramfs...
[ 0.560025] Freeing initrd memory: 9331k freed
[ 0.566112] Simple Boot Flag at 0x5c set to 0x1
[ 0.566490] audit: initializing netlink socket (disabled)
[ 0.566507] type=2000 audit(1308769914.563:1): initialized
[ 0.570371] highmem bounce pool size: 64 pages
[ 0.570379] HugeTLB registered 2 MB page size, pre-allocated 0 pages
[ 0.572248] VFS: Disk quotas dquot_6.5.2
[ 0.572326] Dquot-cache hash table entries: 1024 (order 0, 4096 bytes)
[ 0.572436] msgmni has been set to 1731
[ 0.572718] alg: No test for stdrng (krng)
[ 0.572795] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 253)
[ 0.572800] io scheduler noop registered
[ 0.572803] io scheduler anticipatory registered
[ 0.572806] io scheduler deadline registered
[ 0.572854] io scheduler cfq registered (default)
[ 0.573024] pcieport 0000:00:02.0: irq 120 for MSI/MSI-X
[ 0.573034] pcieport 0000:00:02.0: setting latency timer to 64
[ 0.573164] pcieport 0000:00:04.0: irq 121 for MSI/MSI-X
[ 0.573173] pcieport 0000:00:04.0: setting latency timer to 64
[ 0.573298] pcieport 0000:00:05.0: irq 122 for MSI/MSI-X
[ 0.573307] pcieport 0000:00:05.0: setting latency timer to 64
[ 0.573436] pcieport 0000:00:06.0: irq 123 for MSI/MSI-X
[ 0.573446] pcieport 0000:00:06.0: setting latency timer to 64
[ 0.573591] aer 0000:00:02.0:pcie02: AER service couldn't init device: no _OSC support
[ 0.573602] aer 0000:00:04.0:pcie02: AER service couldn't init device: no _OSC support
[ 0.573611] aer 0000:00:05.0:pcie02: AER service couldn't init device: no _OSC support
[ 0.573619] aer 0000:00:06.0:pcie02: AER service couldn't init device: no _OSC support
[ 0.573769] isapnp: Scanning for PnP cards...
[ 0.927719] isapnp: No Plug & Play device found
[ 0.929565] Linux agpgart interface v0.103
[ 0.929747] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled
[ 0.929845] serial8250: ttyS0 at I/O 0x3f8 (irq = 4) is a 16550A
[ 0.929945] serial8250: ttyS1 at I/O 0x2f8 (irq = 3) is a 16550A
[ 0.930328] 00:0a: ttyS1 at I/O 0x2f8 (irq = 3) is a 16550A
[ 0.930474] 00:0b: ttyS0 at I/O 0x3f8 (irq = 4) is a 16550A
[ 0.930630] PNP: PS/2 Controller [PNP0303:KEYB] at 0x60,0x64 irq 1
[ 0.930633] PNP: PS/2 appears to have AUX port disabled, if this is incorrect please boot with i8042.nopnp
[ 0.931144] serio: i8042 KBD port at 0x60,0x64 irq 1
[ 0.931241] mice: PS/2 mouse device common for all mice
[ 0.931296] rtc_cmos 00:04: RTC can wake from S4
[ 0.931346] rtc_cmos 00:04: rtc core: registered rtc_cmos as rtc0
[ 0.931370] rtc0: alarms up to one month, y3k, 114 bytes nvram, hpet irqs
[ 0.931388] cpuidle: using governor ladder
[ 0.931391] cpuidle: using governor menu
[ 0.931397] No iBFT detected.
[ 0.931870] TCP cubic registered
[ 0.932025] NET: Registered protocol family 10
[ 0.933212] Mobile IPv6
[ 0.933216] NET: Registered protocol family 17
[ 0.933234] Using IPI No-Shortcut mode
[ 0.933321] PM: Resume from disk failed.
[ 0.933336] registered taskstats version 1
[ 0.933798] rtc_cmos 00:04: setting system clock to 2011-06-22 19:11:55 UTC (1308769915)
[ 0.933855] Initalizing network drop monitor service
[ 0.933885] Freeing unused kernel memory: 396k freed
[ 0.934145] Write protecting the kernel text: 2576k
[ 0.934186] Write protecting the kernel read-only data: 924k
[ 0.956784] udev[56]: starting version 164
[ 1.167912] usbcore: registered new interface driver usbfs
[ 1.167979] usbcore: registered new interface driver hub
[ 1.168069] usbcore: registered new device driver usb
[ 1.192830] SCSI subsystem initialized
[ 1.211696] megaraid cmm: 2.20.2.7 (Release Date: Sun Jul 16 00:01:03 EST 2006)
[ 1.219754] tg3.c:v3.102 (September 1, 2009)
[ 1.219785] tg3 0000:04:00.0: PCI INT A -> GSI 16 (level, low) -> IRQ 16
[ 1.219803] tg3 0000:04:00.0: setting latency timer to 64
[ 1.228063] Floppy drive(s): fd0 is 1.44M
[ 1.228891] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver
[ 1.228941] ehci_hcd 0000:00:1d.7: PCI INT D -> GSI 23 (level, low) -> IRQ 23
[ 1.228964] ehci_hcd 0000:00:1d.7: setting latency timer to 64
[ 1.228970] ehci_hcd 0000:00:1d.7: EHCI Host Controller
[ 1.229015] ehci_hcd 0000:00:1d.7: new USB bus registered, assigned bus number 1
[ 1.229063] ehci_hcd 0000:00:1d.7: debug port 1
[ 1.232957] ehci_hcd 0000:00:1d.7: cache line size of 128 is not supported
[ 1.232978] ehci_hcd 0000:00:1d.7: irq 23, io mem 0xde100000
[ 1.237070] Fusion MPT base driver 3.04.12
[ 1.237075] Copyright (c) 1999-2008 LSI Corporation
[ 1.247158] eth0: Tigon3 [partno(BCM95721) rev 4101] (PCI Express) MAC address 00:19:99:12:e8:fa
[ 1.247165] eth0: attached PHY is 5750 (10/100/1000Base-T Ethernet) (WireSpeed[1])
[ 1.247171] eth0: RXcsums[1] LinkChgREG[0] MIirq[0] ASF[1] TSOcap[1]
[ 1.247175] eth0: dma_rwctrl[76180000] dma_mask[64-bit]
[ 1.247208] tg3 0000:05:00.0: PCI INT A -> GSI 16 (level, low) -> IRQ 16
[ 1.247219] tg3 0000:05:00.0: setting latency timer to 64
[ 1.249411] FDC 0 is a post-1991 82077
[ 1.249449] ehci_hcd 0000:00:1d.7: USB 2.0 started, EHCI 1.00
[ 1.249496] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002
[ 1.249502] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[ 1.249507] usb usb1: Product: EHCI Host Controller
[ 1.249511] usb usb1: Manufacturer: Linux 2.6.32-5-686-bigmem ehci_hcd
[ 1.249515] usb usb1: SerialNumber: 0000:00:1d.7
[ 1.249731] usb usb1: configuration #1 chosen from 1 choice
[ 1.249847] hub 1-0:1.0: USB hub found
[ 1.249861] hub 1-0:1.0: 8 ports detected
[ 1.257923] megaraid: 2.20.5.1 (Release Date: Thu Nov 16 15:32:35 EST 2006)
[ 1.257953] megaraid: probe new device 0x1000:0x1960:0x1000:0x0518: bus 8:slot 12:func 0
[ 1.257976] megaraid 0000:08:0c.0: PCI INT A -> GSI 99 (level, low) -> IRQ 99
[ 1.260789] Fusion MPT SPI Host driver 3.04.12
[ 1.260844] mptspi 0000:02:08.0: PCI INT A -> GSI 24 (level, low) -> IRQ 24
[ 1.260958] mptbase: ioc0: Initiating bringup
[ 1.295819] eth1: Tigon3 [partno(BCM95721) rev 4101] (PCI Express) MAC address 00:19:99:12:46:e3
[ 1.295826] eth1: attached PHY is 5750 (10/100/1000Base-T Ethernet) (WireSpeed[1])
[ 1.295831] eth1: RXcsums[1] LinkChgREG[0] MIirq[0] ASF[0] TSOcap[1]
[ 1.295836] eth1: dma_rwctrl[76180000] dma_mask[64-bit]
[ 1.298565] uhci_hcd: USB Universal Host Controller Interface driver
[ 1.298629] uhci_hcd 0000:00:1d.0: PCI INT A -> GSI 16 (level, low) -> IRQ 16
[ 1.298643] uhci_hcd 0000:00:1d.0: setting latency timer to 64
[ 1.298650] uhci_hcd 0000:00:1d.0: UHCI Host Controller
[ 1.298671] uhci_hcd 0000:00:1d.0: new USB bus registered, assigned bus number 2
[ 1.298714] uhci_hcd 0000:00:1d.0: irq 16, io base 0x00001000
[ 1.298775] usb usb2: New USB device found, idVendor=1d6b, idProduct=0001
[ 1.298781] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[ 1.298786] usb usb2: Product: UHCI Host Controller
[ 1.298791] usb usb2: Manufacturer: Linux 2.6.32-5-686-bigmem uhci_hcd
[ 1.298795] usb usb2: SerialNumber: 0000:00:1d.0
[ 1.299205] usb usb2: configuration #1 chosen from 1 choice
[ 1.299273] hub 2-0:1.0: USB hub found
[ 1.299285] hub 2-0:1.0: 2 ports detected
[ 1.299383] uhci_hcd 0000:00:1d.1: PCI INT B -> GSI 19 (level, low) -> IRQ 19
[ 1.299395] uhci_hcd 0000:00:1d.1: setting latency timer to 64
[ 1.299402] uhci_hcd 0000:00:1d.1: UHCI Host Controller
[ 1.299420] uhci_hcd 0000:00:1d.1: new USB bus registered, assigned bus number 3
[ 1.299730] uhci_hcd 0000:00:1d.1: irq 19, io base 0x00001400
[ 1.299792] usb usb3: New USB device found, idVendor=1d6b, idProduct=0001
[ 1.299798] usb usb3: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[ 1.299803] usb usb3: Product: UHCI Host Controller
[ 1.299807] usb usb3: Manufacturer: Linux 2.6.32-5-686-bigmem uhci_hcd
[ 1.299812] usb usb3: SerialNumber: 0000:00:1d.1
[ 1.299940] usb usb3: configuration #1 chosen from 1 choice
[ 1.300016] hub 3-0:1.0: USB hub found
[ 1.300030] hub 3-0:1.0: 2 ports detected
[ 1.300122] uhci_hcd 0000:00:1d.2: PCI INT C -> GSI 18 (level, low) -> IRQ 18
[ 1.300134] uhci_hcd 0000:00:1d.2: setting latency timer to 64
[ 1.300140] uhci_hcd 0000:00:1d.2: UHCI Host Controller
[ 1.300159] uhci_hcd 0000:00:1d.2: new USB bus registered, assigned bus number 4
[ 1.300197] uhci_hcd 0000:00:1d.2: irq 18, io base 0x00001800
[ 1.300254] usb usb4: New USB device found, idVendor=1d6b, idProduct=0001
[ 1.300260] usb usb4: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[ 1.300266] usb usb4: Product: UHCI Host Controller
[ 1.300272] usb usb4: Manufacturer: Linux 2.6.32-5-686-bigmem uhci_hcd
[ 1.300276] usb usb4: SerialNumber: 0000:00:1d.2
[ 1.300414] usb usb4: configuration #1 chosen from 1 choice
[ 1.300469] hub 4-0:1.0: USB hub found
[ 1.300483] hub 4-0:1.0: 2 ports detected
[ 1.300565] uhci_hcd 0000:00:1d.3: PCI INT A -> GSI 16 (level, low) -> IRQ 16
[ 1.300576] uhci_hcd 0000:00:1d.3: setting latency timer to 64
[ 1.300581] uhci_hcd 0000:00:1d.3: UHCI Host Controller
[ 1.300597] uhci_hcd 0000:00:1d.3: new USB bus registered, assigned bus number 5
[ 1.300629] uhci_hcd 0000:00:1d.3: irq 16, io base 0x00001c00
[ 1.300687] usb usb5: New USB device found, idVendor=1d6b, idProduct=0001
[ 1.300693] usb usb5: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[ 1.300697] usb usb5: Product: UHCI Host Controller
[ 1.300702] usb usb5: Manufacturer: Linux 2.6.32-5-686-bigmem uhci_hcd
[ 1.300706] usb usb5: SerialNumber: 0000:00:1d.3
[ 1.300830] usb usb5: configuration #1 chosen from 1 choice
[ 1.300887] hub 5-0:1.0: USB hub found
[ 1.300901] hub 5-0:1.0: 2 ports detected
[ 1.303282] libata version 3.00 loaded.
[ 1.309054] megaraid: fw version:[1F42] bios version:[G302]
[ 1.309587] ata_piix 0000:00:1f.1: version 2.13
[ 1.309610] ata_piix 0000:00:1f.1: PCI INT A -> GSI 18 (level, low) -> IRQ 18
[ 1.309675] ata_piix 0000:00:1f.1: setting latency timer to 64
[ 1.309785] scsi0 : ata_piix
[ 1.309927] scsi1 : ata_piix
[ 1.310773] ata1: PATA max UDMA/100 cmd 0x1f0 ctl 0x3f6 bmdma 0x2400 irq 14
[ 1.310778] ata2: PATA max UDMA/100 cmd 0x170 ctl 0x376 bmdma 0x2408 irq 15
[ 1.349215] scsi2 : LSI Logic MegaRAID driver
[ 1.349385] aic7xxx 0000:08:0b.0: PCI INT A -> GSI 98 (level, low) -> IRQ 98
[ 1.349437] scsi[2]: scanning scsi channel 0 [Phy 0] for non-raid devices
[ 1.476297] ata2.00: ATAPI: HL-DT-STCD-RW/DVD DRIVE GCC-4244N, 1.00, max UDMA/33
[ 1.492209] ata2.00: configured for UDMA/33
[ 1.493139] scsi: waiting for bus probes to complete ...
[ 1.772011] ioc0: LSI53C1030 C0: Capabilities={Initiator}
[ 1.879176] scsi 2:0:8:0: Processor QLogic GEM359 1.10 PQ: 0 ANSI: 2
[ 1.908015] usb 2-2: new low speed USB device using uhci_hcd and address 2
[ 2.101640] usb 2-2: New USB device found, idVendor=051d, idProduct=0002
[ 2.101645] usb 2-2: New USB device strings: Mfr=3, Product=1, SerialNumber=2
[ 2.101649] usb 2-2: Product: Smart-UPS 3000 RM FW:666.6.I USB FW:2.4
[ 2.101652] usb 2-2: Manufacturer: American Power Conversion
[ 2.101655] usb 2-2: SerialNumber: CS0533110332
[ 2.101779] usb 2-2: configuration #1 chosen from 1 choice
[ 2.383729] scsi4 : ioc0: LSI53C1030 C0, FwRev=01033000h, Ports=1, MaxQ=222, IRQ=24
[ 2.763728] mptspi 0000:02:08.1: PCI INT B -> GSI 25 (level, low) -> IRQ 25
[ 2.763844] mptbase: ioc1: Initiating bringup
[ 3.137405] scsi[2]: scanning scsi channel 1 [Phy 1] for non-raid devices
[ 3.352015] usb 3-2: new low speed USB device using uhci_hcd and address 2
[ 3.509369] usb 3-2: New USB device found, idVendor=0566, idProduct=3107
[ 3.509374] usb 3-2: New USB device strings: Mfr=0, Product=0, SerialNumber=0
[ 3.509491] usb 3-2: configuration #1 chosen from 1 choice
[ 3.523553] usbcore: registered new interface driver hiddev
[ 3.657521] scsi 2:1:8:0: Processor QLogic GEM359 1.10 PQ: 0 ANSI: 2
[ 4.304013] ioc1: LSI53C1030 C0: Capabilities={Initiator}
[ 4.914717] scsi5 : ioc1: LSI53C1030 C0, FwRev=01033000h, Ports=1, MaxQ=222, IRQ=25
[ 4.922645] scsi[2]: scanning scsi channel 2 [virtual] for logical drives
[ 4.923086] scsi 2:2:0:0: Direct-Access MegaRAID LD 0 RAID5 1537G 1F42 PQ: 0 ANSI: 2
[ 4.933000] scsi 1:0:0:0: CD-ROM HL-DT-ST RW/DVD GCC-4244N 1.00 PQ: 0 ANSI: 5
[ 4.951976] sd 2:2:0:0: [sda] 3149414400 512-byte logical blocks: (1.61 TB/1.46 TiB)
[ 4.952030] sd 2:2:0:0: [sda] Write Protect is off
[ 4.952037] sd 2:2:0:0: [sda] Mode Sense: 00 00 00 00
[ 4.952059] sd 2:2:0:0: [sda] Asking for cache data failed
[ 4.952110] sd 2:2:0:0: [sda] Assuming drive cache: write through
[ 4.952399] sd 2:2:0:0: [sda] Asking for cache data failed
[ 4.952449] sd 2:2:0:0: [sda] Assuming drive cache: write through
[ 4.952498] sda: sda1 sda2 sda3
[ 4.954137] sd 2:2:0:0: [sda] Asking for cache data failed
[ 4.954185] sd 2:2:0:0: [sda] Assuming drive cache: write through
[ 4.954234] sd 2:2:0:0: [sda] Attached SCSI disk
[ 4.955220] scsi 2:0:8:0: Attached scsi generic sg0 type 3
[ 4.955983] scsi 2:1:8:0: Attached scsi generic sg1 type 3
[ 4.956110] sd 2:2:0:0: Attached scsi generic sg2 type 0
[ 4.956221] scsi 1:0:0:0: Attached scsi generic sg3 type 5
[ 4.977402] sr0: scsi3-mmc drive: 24x/24x writer cd/rw xa/form2 cdda tray
[ 4.977408] Uniform CD-ROM driver Revision: 3.20
[ 4.977565] sr 1:0:0:0: Attached scsi CD-ROM sr0
[ 6.042075] generic-usb 0003:051D:0002.0001: hiddev0,hidraw0: USB HID v1.10 Device [American Power Conversion Smart-UPS 3000 RM FW:666.6.I USB FW:2.4] on usb-0000:00:1d.0-2/input0
[ 6.055202] input: HID 0566:3107 as /devices/pci0000:00/0000:00:1d.1/usb3/3-2/3-2:1.0/input/input0
[ 6.055273] generic-usb 0003:0566:3107.0002: input,hidraw1: USB HID v1.10 Keyboard [HID 0566:3107] on usb-0000:00:1d.1-2/input0
[ 6.079030] input: HID 0566:3107 as /devices/pci0000:00/0000:00:1d.1/usb3/3-2/3-2:1.1/input/input1
[ 6.079105] generic-usb 0003:0566:3107.0003: input,hidraw2: USB HID v1.10 Device [HID 0566:3107] on usb-0000:00:1d.1-2/input1
[ 6.079145] usbcore: registered new interface driver usbhid
[ 6.079151] usbhid: v2.6:USB HID core driver
[ 6.354966] scsi 4:0:1:0: Direct-Access LSILOGIC 1030 IM 1000 PQ: 0 ANSI: 2
[ 7.356235] scsi 4:0:8:0: Processor SDR GEM318P 1 PQ: 0 ANSI: 2
[ 7.356250] scsi target4:0:8: Beginning Domain Validation
[ 7.357758] scsi target4:0:8: Ending Domain Validation
[ 7.357815] scsi target4:0:8: asynchronous
[ 9.118701] scsi 4:1:1:0: Direct-Access FUJITSU MAW3147NC 5203 PQ: 0 ANSI: 3
[ 9.119654] mptbase: ioc0: RAID STATUS CHANGE for VolumeID 1
[ 9.119658] mptbase: ioc0: volume is now optimal, enabled, quiesced
[ 9.119983] mptbase: ioc0: RAID STATUS CHANGE for PhysDisk 0 id=1
[ 9.119986] mptbase: ioc0: PhysDisk is now online, quiesced
[ 9.120298] mptbase: ioc0: RAID STATUS CHANGE for PhysDisk 1 id=1
[ 9.120301] mptbase: ioc0: PhysDisk is now online, quiesced
[ 9.120374] scsi target4:1:1: Beginning Domain Validation
[ 9.429888] scsi target4:1:1: Ending Domain Validation
[ 9.430763] mptbase: ioc0: RAID STATUS CHANGE for VolumeID 1
[ 9.430767] mptbase: ioc0: volume is now optimal, enabled
[ 9.431091] mptbase: ioc0: RAID STATUS CHANGE for PhysDisk 0 id=1
[ 9.431094] mptbase: ioc0: PhysDisk is now online
[ 9.431403] mptbase: ioc0: RAID STATUS CHANGE for PhysDisk 1 id=1
[ 9.431407] mptbase: ioc0: PhysDisk is now online
[ 9.432067] scsi target4:1:1: FAST-160 WIDE SCSI 320.0 MB/s DT IU RTI WRFLOW PCOMP (6.25 ns, offset 127)
[ 9.436143] scsi 4:1:4:0: Direct-Access FUJITSU MAW3147NC 5203 PQ: 0 ANSI: 3
[ 9.437095] mptbase: ioc0: RAID STATUS CHANGE for VolumeID 1
[ 9.437100] mptbase: ioc0: volume is now optimal, enabled, quiesced
[ 9.437425] mptbase: ioc0: RAID STATUS CHANGE for PhysDisk 0 id=1
[ 9.437429] mptbase: ioc0: PhysDisk is now online, quiesced
[ 9.437738] mptbase: ioc0: RAID STATUS CHANGE for PhysDisk 1 id=1
[ 9.437741] mptbase: ioc0: PhysDisk is now online, quiesced
[ 9.437818] scsi target4:1:4: Beginning Domain Validation
[ 9.751279] scsi target4:1:4: Ending Domain Validation
[ 9.752153] mptbase: ioc0: RAID STATUS CHANGE for VolumeID 1
[ 9.752157] mptbase: ioc0: volume is now optimal, enabled
[ 9.752480] mptbase: ioc0: RAID STATUS CHANGE for PhysDisk 0 id=1
[ 9.752483] mptbase: ioc0: PhysDisk is now online
[ 9.752794] mptbase: ioc0: RAID STATUS CHANGE for PhysDisk 1 id=1
[ 9.752797] mptbase: ioc0: PhysDisk is now online
[ 9.753454] scsi target4:1:4: FAST-160 WIDE SCSI 320.0 MB/s DT IU RTI WRFLOW PCOMP (6.25 ns, offset 127)
[ 9.754485] sd 4:0:1:0: Attached scsi generic sg4 type 0
[ 9.754941] scsi 4:0:8:0: Attached scsi generic sg5 type 3
[ 9.755253] scsi 4:1:1:0: Attached scsi generic sg6 type 0
[ 9.755555] scsi 4:1:4:0: Attached scsi generic sg7 type 0
[ 9.762209] sd 4:0:1:0: [sdb] 286310400 512-byte logical blocks: (146 GB/136 GiB)
[ 9.763346] sd 4:0:1:0: [sdb] Write Protect is off
[ 9.763354] sd 4:0:1:0: [sdb] Mode Sense: 03 00 00 08
[ 9.764552] sd 4:0:1:0: [sdb] Write cache: disabled, read cache: enabled, doesn't support DPO or FUA
[ 9.765711] sdb: sdb1 sdb2 sdb3
[ 9.779050] sd 4:0:1:0: [sdb] Attached SCSI disk
[ 16.560022] scsi3 : Adaptec AIC7XXX EISA/VLB/PCI SCSI HBA DRIVER, Rev 7.0
[ 16.560025] <Adaptec 29160 Ultra160 SCSI adapter>
[ 16.560027] aic7892: Ultra160 Wide Channel A, SCSI Id=7, 32/253 SCBs
[ 16.560029]
[ 16.598369] scsi 3:0:0:0: Medium Changer EXABYTE Exabyte 221L 3.6 PQ: 0 ANSI: 2
[ 16.598390] scsi target3:0:0: Beginning Domain Validation
[ 16.609123] device-mapper: uevent: version 1.0.3
[ 16.609341] device-mapper: ioctl: 4.15.0-ioctl (2009-04-01) initialised: dm-devel@redhat.com
[ 16.635992] EXT3-fs: INFO: recovery required on readonly filesystem.
[ 16.635997] EXT3-fs: write access will be enabled during recovery.
[ 16.713783] scsi target3:0:0: Ending Domain Validation
[ 16.754551] scsi 3:0:1:0: Sequential-Access IBM ULTRIUM-TD3 54K1 PQ: 0 ANSI: 3
[ 16.754557] scsi 3:0:1:0: Information Units disabled by blacklist
[ 16.754567] scsi target3:0:1: Beginning Domain Validation
[ 16.759810] scsi target3:0:1: wide asynchronous
[ 16.763947] scsi target3:0:1: FAST-80 WIDE SCSI 160.0 MB/s DT (12.5 ns, offset 127)
[ 16.782694] scsi target3:0:1: Domain Validation skipping write tests
[ 16.782698] scsi target3:0:1: Ending Domain Validation
[ 16.818800] kjournald starting. Commit interval 5 seconds
[ 16.818811] EXT3-fs: recovery complete.
[ 16.830972] EXT3-fs: mounted filesystem with ordered data mode.
[ 17.512399] udev[391]: starting version 164
[ 17.706292] processor LNXCPU:00: registered as cooling_device0
[ 17.706408] processor LNXCPU:02: registered as cooling_device1
[ 17.769109] input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input2
[ 17.769123] ACPI: Power Button [PWRB]
[ 17.769291] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input3
[ 17.769300] ACPI: Power Button [PWRF]
[ 17.770910] EDAC MC: Ver: 2.1.0 May 18 2011
[ 17.791013] pci_hotplug: PCI Hot Plug PCI Core version: 0.5
[ 17.828952] shpchp 0000:06:00.0: HPC vendor_id 8086 device_id 329 ss_vid 0 ss_did 0
[ 17.829051] shpchp 0000:06:00.0: Can't get msi for the hotplug controller
[ 17.829057] shpchp 0000:06:00.0: Use INTx for the hotplug controller
[ 17.836673] input: PC Speaker as /devices/platform/pcspkr/input/input4
[ 17.837044] Contact your BIOS vendor to see if the E752x error registers can be safely un-hidden
[ 17.847263] i801_smbus 0000:00:1f.3: PCI INT B -> GSI 17 (level, low) -> IRQ 17
[ 17.853426] shpchp: Standard Hot Plug PCI Controller Driver version: 0.4
[ 17.885084] intel_rng: FWH not detected
[ 17.940737] parport_pc 00:09: reported by Plug and Play ACPI
[ 17.940767] parport0: PC-style at 0x378, irq 7 [PCSPP,TRISTATE,EPP]
[ 18.109099] Error: Driver 'pcspkr' is already registered, aborting...
[ 19.767352] Adding 6610736k swap on /dev/sdb3. Priority:-1 extents:1 across:6610736k
[ 19.899065] EXT3 FS on sdb1, internal journal
[ 19.984810] Fusion MPT misc device (ioctl) driver 3.04.12
[ 19.985093] mptctl: Registered with Fusion MPT base driver
[ 19.985100] mptctl: /dev/mptctl @ (major,minor=10,220)
[ 20.003522] ipmi message handler version 39.2
[ 20.012174] IPMI System Interface driver.
[ 20.012183] ipmi_si: Trying SMBIOS-specified kcs state machine at i/o address 0xca2, slave address 0x24, irq 0
[ 20.116753] scsi 3:0:0:0: Attached scsi generic sg8 type 8
[ 20.116982] scsi 3:0:1:0: Attached scsi generic sg9 type 1
[ 20.148035] SCSI Media Changer driver v0.25
[ 20.152644] st: Version 20081215, fixed bufsize 32768, s/g segs 256
[ 20.173246] ch0: type #1 (mt): 0x56+1 [medium transport]
[ 20.173252] ch0: type #2 (st): 0x1+21 [storage]
[ 20.173256] ch0: type #3 (ie): 0x51+1 [import/export]
[ 20.173260] ch0: type #4 (dt): 0x52+1 [data transfer]
[ 20.190212] ch0: dt 0x52: not this SCSI bus
[ 20.190216] ch0: INITIALIZE ELEMENT STATUS, may take some time ...
[ 20.234839] ipmi: Found new BMC (man_id: 0x002880, prod_id: 0x0000, dev_id: 0x00)
[ 20.234856] IPMI kcs interface initialized
[ 20.239501] ipmi device interface
[ 20.389194] smsc47m1: Found SMSC LPC47M10x/LPC47M112/LPC47M13x
[ 20.389255] ACPI: I/O resource smsc47m1 [0x800-0x87f] conflicts with ACPI region SSWC [0x800-0x87f]
[ 20.389328] ACPI: If an ACPI driver is available for this device, you should use it instead of the native driver
[ 21.427861] SGI XFS with ACLs, security attributes, realtime, large block/inode numbers, no debug enabled
[ 21.429511] SGI XFS Quota Management subsystem
[ 21.452147] XFS mounting filesystem dm-1
[ 21.611144] Starting XFS recovery on filesystem: dm-1 (logdev: internal)
[ 21.718630] Ending XFS recovery on filesystem: dm-1 (logdev: internal)
[ 21.729198] kjournald starting. Commit interval 5 seconds
[ 21.739241] EXT3 FS on sdb2, internal journal
[ 21.739249] EXT3-fs: mounted filesystem with ordered data mode.
[ 21.760004] XFS mounting filesystem dm-13
[ 21.923463] Starting XFS recovery on filesystem: dm-13 (logdev: internal)
[ 22.538960] Ending XFS recovery on filesystem: dm-13 (logdev: internal)
[ 22.564746] XFS mounting filesystem dm-5
[ 22.715031] Starting XFS recovery on filesystem: dm-5 (logdev: internal)
[ 22.830002] Ending XFS recovery on filesystem: dm-5 (logdev: internal)
[ 22.846361] XFS mounting filesystem dm-9
[ 23.008757] Starting XFS recovery on filesystem: dm-9 (logdev: internal)
[ 23.577439] Ending XFS recovery on filesystem: dm-9 (logdev: internal)
[ 23.591006] XFS mounting filesystem dm-16
[ 23.715030] Starting XFS recovery on filesystem: dm-16 (logdev: internal)
[ 23.899097] Ending XFS recovery on filesystem: dm-16 (logdev: internal)
[ 23.919574] kjournald starting. Commit interval 5 seconds
[ 23.928215] EXT3 FS on dm-17, internal journal
[ 23.928223] EXT3-fs: mounted filesystem with ordered data mode.
[ 24.659925] ADDRCONF(NETDEV_UP): siemens: link is not ready
[ 25.320087] ADDRCONF(NETDEV_UP): snt: link is not ready
[ 25.922429] microcode: CPU0 sig=0xf43, pf=0x1, revision=0x5
[ 25.922439] platform microcode: firmware: requesting intel-ucode/0f-04-03
[ 25.949676] microcode: CPU1 sig=0xf43, pf=0x1, revision=0x5
[ 25.949687] platform microcode: firmware: requesting intel-ucode/0f-04-03
[ 25.953616] Microcode Update Driver: v2.00 <tigran@aivazian.fsnet.co.uk>, Peter Oruba
[ 26.296170] tg3: siemens: Link is up at 100 Mbps, full duplex.
[ 26.296174] tg3: siemens: Flow control is on for TX and on for RX.
[ 26.296333] ADDRCONF(NETDEV_CHANGE): siemens: link becomes ready
[ 27.003373] tg3: snt: Link is up at 100 Mbps, full duplex.
[ 27.003377] tg3: snt: Flow control is on for TX and on for RX.
[ 27.003522] ADDRCONF(NETDEV_CHANGE): snt: link becomes ready
[ 29.168045] usb 2-2: USB disconnect, address 2
[ 29.171446] /tmp/buildd/linux-2.6-2.6.32/debian/build/source_i386_none/drivers/hid/usbhid/hid-core.c: usb_submit_urb(ctrl) failed
[ 33.620033] usb 2-2: new low speed USB device using uhci_hcd and address 3
[ 33.813959] usb 2-2: New USB device found, idVendor=051d, idProduct=0002
[ 33.813965] usb 2-2: New USB device strings: Mfr=3, Product=1, SerialNumber=2
[ 33.813970] usb 2-2: Product: Smart-UPS 3000 RM FW:666.6.I USB FW:2.4
[ 33.813974] usb 2-2: Manufacturer: American Power Conversion
[ 33.813977] usb 2-2: SerialNumber: CS0533110332
[ 33.814127] usb 2-2: configuration #1 chosen from 1 choice
[ 36.147735] generic-usb 0003:051D:0002.0004: hiddev0,hidraw0: USB HID v1.10 Device [American Power Conversion Smart-UPS 3000 RM FW:666.6.I USB FW:2.4] on usb-0000:00:1d.0-2/input0
[ 37.149006] siemens: no IPv6 routers present
[ 37.245005] snt: no IPv6 routers present
[ 38.345062] usb 2-2: USB disconnect, address 3
[ 42.745031] usb 2-2: new low speed USB device using uhci_hcd and address 4
[ 42.938593] usb 2-2: New USB device found, idVendor=051d, idProduct=0002
[ 42.938599] usb 2-2: New USB device strings: Mfr=3, Product=1, SerialNumber=2
[ 42.938603] usb 2-2: Product: Smart-UPS 3000 RM FW:666.6.I USB FW:2.4
[ 42.938607] usb 2-2: Manufacturer: American Power Conversion
[ 42.938610] usb 2-2: SerialNumber: CS0533110332
[ 42.938754] usb 2-2: configuration #1 chosen from 1 choice
[ 45.380361] generic-usb 0003:051D:0002.0005: hiddev0,hidraw0: USB HID v1.10 Device [American Power Conversion Smart-UPS 3000 RM FW:666.6.I USB FW:2.4] on usb-0000:00:1d.0-2/input0
[ 48.268044] usb 2-2: USB disconnect, address 4
[ 48.269572] /tmp/buildd/linux-2.6-2.6.32/debian/build/source_i386_none/drivers/hid/usbhid/hid-core.c: usb_submit_urb(ctrl) failed
[ 48.731053] BUG: unable to handle kernel NULL pointer dereference at (null)
[ 48.731193] IP: [<f843db27>] hiddev_ioctl+0x26/0x56f [usbhid]
[ 48.731294] *pdpt = 000000003587c001 *pde = 0000000000000000
[ 48.731424] Oops: 0000 [#1] SMP
[ 48.731549] last sysfs file: /sys/devices/pci0000:00/0000:00:1d.0/usb2/2-2/2-2:1.0/0003:051D:0002.0005/hidraw/hidraw0/uevent
[ 48.731619] Modules linked in: microcode xfs exportfs eeprom ipmi_devintf st(+) ch(+) ipmi_si ipmi_msghandler mptctl psmouse dm_snapshot snd_pcm snd_timer parport_pc snd soundcore snd_page_alloc parport i2c_i801 pcspkr e752x_edac shpchp joydev evdev serio_raw container i2c_core rng_core pci_hotplug button edac_core processor ext3 jbd mbcache dm_mod sr_mod cdrom sg sd_mod crc_t10dif ata_generic usbhid hid aic7xxx ata_piix uhci_hcd libata mptspi megaraid_mbox mptscsih mptbase ehci_hcd floppy tg3 megaraid_mm scsi_transport_spi libphy thermal thermal_sys scsi_mod usbcore nls_base [last unloaded: scsi_wait_scan]
[ 48.734244]
[ 48.734295] Pid: 1390, comm: apcupsd Not tainted (2.6.32-5-686-bigmem #1) D1889
[ 48.734361] EIP: 0060:[<f843db27>] EFLAGS: 00010286 CPU: 0
[ 48.734419] EIP is at hiddev_ioctl+0x26/0x56f [usbhid]
[ 48.734473] EAX: 00000000 EBX: 400c4807 ECX: bffb50d4 EDX: fffffffb
[ 48.734528] ESI: f65dd5c0 EDI: f645a000 EBP: bffb50d4 ESP: f5f8bea0
[ 48.734584] DS: 007b ES: 007b FS: 00d8 GS: 00e0 SS: 0068
[ 48.734639] Process apcupsd (pid: 1390, ti=f5f8a000 task=f5dc1100 task.ti=f5f8a000)
[ 48.734703] Stack:
[ 48.734752] c1031658 f5b20000 c143de20 f5ff9e00 c2608e20 f5ff9e00 c127e933 c13a4ba0
[ 48.735023] <0> c143959c c143de20 c143de20 c1439354 f5dc12bc c2608e20 00000000 00000000
[ 48.735023] <0> 00000296 00000292 0000c350 f5dc1100 c26045cc f5f8bf44 c104d131 f5f8bf44
[ 48.735023] Call Trace:
[ 48.735023] [<c1031658>] ? finish_task_switch+0x34/0x95
[ 48.735023] [<c127e933>] ? schedule+0x7a4/0x7f1
[ 48.735023] [<c104d131>] ? lock_hrtimer_base+0x15/0x2f
[ 48.735023] [<c104d1af>] ? hrtimer_try_to_cancel+0x2f/0x35
[ 48.735023] [<c104d1bf>] ? hrtimer_cancel+0xa/0x14
[ 48.735023] [<f843db01>] ? hiddev_ioctl+0x0/0x56f [usbhid]
[ 48.735023] [<c10c53d4>] ? vfs_ioctl+0x1c/0x5f
[ 48.735023] [<c10c5968>] ? do_vfs_ioctl+0x4aa/0x4e5
[ 48.735023] [<c104cae6>] ? hrtimer_wakeup+0x0/0x18
[ 48.735023] [<c10517e0>] ? getnstimeofday+0x4d/0xc9
[ 48.735023] [<c1051896>] ? do_gettimeofday+0xf/0x29
[ 48.735023] [<c10c59e4>] ? sys_ioctl+0x41/0x58
[ 48.735023] [<c100813b>] ? sysenter_do_call+0x12/0x28
[ 48.735023] Code: 5b 5e 5f 5d c3 55 89 cd 57 56 53 89 d3 83 ec 7c 8b 40 70 ba fb ff ff ff 89 44 24 04 8b b0 10 c0 00 00 8b 7e 28 8b 87 54 0c 00 00 <8b> 08 8b 87 a0 0e 00 00 89 04 24 83 3e 00 0f 84 2b 05 00 00 81
[ 48.735023] EIP: [<f843db27>] hiddev_ioctl+0x26/0x56f [usbhid] SS:ESP 0068:f5f8bea0
[ 48.735023] CR2: 0000000000000000
[ 48.739373] ---[ end trace 650ff9964d1a683e ]---
[ 52.796015] usb 2-2: new low speed USB device using uhci_hcd and address 5
[ 52.990953] usb 2-2: New USB device found, idVendor=051d, idProduct=0002
[ 52.991011] usb 2-2: New USB device strings: Mfr=3, Product=1, SerialNumber=2
[ 52.991072] usb 2-2: Product: Smart-UPS 3000 RM FW:666.6.I USB FW:2.4
[ 52.991128] usb 2-2: Manufacturer: American Power Conversion
[ 52.991182] usb 2-2: SerialNumber: CS0533110332
[ 52.991366] usb 2-2: configuration #1 chosen from 1 choice
[ 55.475708] generic-usb 0003:051D:0002.0006: hiddev0,hidraw0: USB HID v1.10 Device [American Power Conversion Smart-UPS 3000 RM FW:666.6.I USB FW:2.4] on usb-0000:00:1d.0-2/input0
[ 57.441037] usb 2-2: USB disconnect, address 5
[ 61.904022] usb 2-2: new low speed USB device using uhci_hcd and address 6
[ 62.098960] usb 2-2: New USB device found, idVendor=051d, idProduct=0002
[ 62.099021] usb 2-2: New USB device strings: Mfr=3, Product=1, SerialNumber=2
[ 62.099081] usb 2-2: Product: Smart-UPS 3000 RM FW:666.6.I USB FW:2.4
[ 62.099137] usb 2-2: Manufacturer: American Power Conversion
[ 62.099192] usb 2-2: SerialNumber: CS0533110332
[ 62.099380] usb 2-2: configuration #1 chosen from 1 choice
[ 64.651753] generic-usb 0003:051D:0002.0007: hiddev0,hidraw0: USB HID v1.10 Device [American Power Conversion Smart-UPS 3000 RM FW:666.6.I USB FW:2.4] on usb-0000:00:1d.0-2/input0
[ 66.121039] usb 2-2: USB disconnect, address 6
[ 70.648015] usb 2-2: new low speed USB device using uhci_hcd and address 7
[ 70.842961] usb 2-2: New USB device found, idVendor=051d, idProduct=0002
[ 70.843022] usb 2-2: New USB device strings: Mfr=3, Product=1, SerialNumber=2
[ 70.843085] usb 2-2: Product: Smart-UPS 3000 RM FW:666.6.I USB FW:2.4
[ 70.843142] usb 2-2: Manufacturer: American Power Conversion
[ 70.843196] usb 2-2: SerialNumber: CS0533110332
[ 70.843378] usb 2-2: configuration #1 chosen from 1 choice
[ 71.970369] ch0: ... finished
[ 71.970426] ch 3:0:0:0: Attached scsi changer ch0
[ 71.970990] st 3:0:1:0: Attached scsi tape st0
[ 71.971050] st 3:0:1:0: st0: try direct i/o: yes (alignment 4 B)
[ 71.981346] osst :I: Tape driver with OnStream support version 0.99.4
[ 71.981350] osst :I: $Id: osst.c,v 1.73 2005/01/01 21:13:34 wriede Exp $
[ 73.219800] generic-usb 0003:051D:0002.0008: hiddev0,hidraw0: USB HID v1.10 Device [American Power Conversion Smart-UPS 3000 RM FW:666.6.I USB FW:2.4] on usb-0000:00:1d.0-2/input0
[ 79.173263] vboxdrv: Found 2 processor cores.
[ 79.173442] vboxdrv: fAsync=0 offMin=0x4a8 offMax=0x179d
[ 79.173580] vboxdrv: TSC mode is 'synchronous', kernel timer mode is 'normal'.
[ 79.173650] vboxdrv: Successfully loaded version 3.2.12 (interface 0x00140001).

Dmitry Eremin-Solenikov 06-22-2011 03:24 PM

Bug#631287: BUG during access to hiddev (APC UPS)
 
Package: linux-image-2.6.32-5-686-bigmem
Version: 2.6.32-34squeeze1
Severity: important

After upgrading to squeeze I've started receiving the following BUG in dmesg
when apcupsd tries to access hid device for my UPS (APC SmartUPS 3000,
connected via USB).

[ 42.745031] usb 2-2: new low speed USB device using uhci_hcd and address 4
[ 42.938593] usb 2-2: New USB device found, idVendor=051d, idProduct=0002
[ 42.938599] usb 2-2: New USB device strings: Mfr=3, Product=1, SerialNumber=2
[ 42.938603] usb 2-2: Product: Smart-UPS 3000 RM FW:666.6.I USB FW:2.4
[ 42.938607] usb 2-2: Manufacturer: American Power Conversion
[ 42.938610] usb 2-2: SerialNumber: CS0533110332
[ 42.938754] usb 2-2: configuration #1 chosen from 1 choice
[ 45.380361] generic-usb 0003:051D:0002.0005: hiddev0,hidraw0: USB HID v1.10 Device [American Power Conversion Smart-UPS 3000 RM FW:666.6.I USB FW:2.4] on u
sb-0000:00:1d.0-2/input0
[ 48.268044] usb 2-2: USB disconnect, address 4
[ 48.269572] /tmp/buildd/linux-2.6-2.6.32/debian/build/source_i386_none/drivers/hid/usbhid/hid-core.c: usb_submit_urb(ctrl) failed
[ 48.731053] BUG: unable to handle kernel NULL pointer dereference at (null)
[ 48.731193] IP: [<f843db27>] hiddev_ioctl+0x26/0x56f [usbhid]
[ 48.731294] *pdpt = 000000003587c001 *pde = 0000000000000000
[ 48.731424] Oops: 0000 [#1] SMP
[ 48.731549] last sysfs file: /sys/devices/pci0000:00/0000:00:1d.0/usb2/2-2/2-2:1.0/0003:051D:0002.0005/hidraw/hidraw0/uevent
[ 48.731619] Modules linked in: microcode xfs exportfs eeprom ipmi_devintf st(+) ch(+) ipmi_si ipmi_msghandler mptctl psmouse dm_snapshot snd_pcm snd_timer
parport_pc snd soundcore snd_page_alloc parport i2c_i801 pcspkr e752x_edac shpchp joydev evdev serio_raw container i2c_core rng_core pci_hotplug button edac_c
ore processor ext3 jbd mbcache dm_mod sr_mod cdrom sg sd_mod crc_t10dif ata_generic usbhid hid aic7xxx ata_piix uhci_hcd libata mptspi megaraid_mbox mptscsih
mptbase ehci_hcd floppy tg3 megaraid_mm scsi_transport_spi libphy thermal thermal_sys scsi_mod usbcore nls_base [last unloaded: scsi_wait_scan]
[ 48.734244]
[ 48.734295] Pid: 1390, comm: apcupsd Not tainted (2.6.32-5-686-bigmem #1) D1889
[ 48.734361] EIP: 0060:[<f843db27>] EFLAGS: 00010286 CPU: 0
[ 48.734419] EIP is at hiddev_ioctl+0x26/0x56f [usbhid]
[ 48.734473] EAX: 00000000 EBX: 400c4807 ECX: bffb50d4 EDX: fffffffb
[ 48.734528] ESI: f65dd5c0 EDI: f645a000 EBP: bffb50d4 ESP: f5f8bea0
[ 48.734584] DS: 007b ES: 007b FS: 00d8 GS: 00e0 SS: 0068
[ 48.734639] Process apcupsd (pid: 1390, ti=f5f8a000 task=f5dc1100 task.ti=f5f8a000)
[ 48.734703] Stack:
[ 48.734752] c1031658 f5b20000 c143de20 f5ff9e00 c2608e20 f5ff9e00 c127e933 c13a4ba0
[ 48.735023] <0> c143959c c143de20 c143de20 c1439354 f5dc12bc c2608e20 00000000 00000000
[ 48.735023] <0> 00000296 00000292 0000c350 f5dc1100 c26045cc f5f8bf44 c104d131 f5f8bf44
[ 48.735023] Call Trace:
[ 48.735023] [<c1031658>] ? finish_task_switch+0x34/0x95
[ 48.735023] [<c127e933>] ? schedule+0x7a4/0x7f1
[ 48.735023] [<c104d131>] ? lock_hrtimer_base+0x15/0x2f
[ 48.735023] [<c104d1af>] ? hrtimer_try_to_cancel+0x2f/0x35
[ 48.735023] [<c104d1bf>] ? hrtimer_cancel+0xa/0x14
[ 48.735023] [<f843db01>] ? hiddev_ioctl+0x0/0x56f [usbhid]
[ 48.735023] [<c10c53d4>] ? vfs_ioctl+0x1c/0x5f
[ 48.735023] [<c10c5968>] ? do_vfs_ioctl+0x4aa/0x4e5
[ 48.735023] [<c104cae6>] ? hrtimer_wakeup+0x0/0x18
[ 48.735023] [<c10517e0>] ? getnstimeofday+0x4d/0xc9
[ 48.735023] [<c1051896>] ? do_gettimeofday+0xf/0x29
[ 48.735023] [<c10c59e4>] ? sys_ioctl+0x41/0x58
[ 48.735023] [<c100813b>] ? sysenter_do_call+0x12/0x28
[ 48.735023] Code: 5b 5e 5f 5d c3 55 89 cd 57 56 53 89 d3 83 ec 7c 8b 40 70 ba fb ff ff ff 89 44 24 04 8b b0 10 c0 00 00 8b 7e 28 8b 87 54 0c 00 00 <8b> 08 8b 87 a0 0e 00 00 89 04 24 83 3e 00 0f 84 2b 05 00 00 81
[ 48.735023] EIP: [<f843db27>] hiddev_ioctl+0x26/0x56f [usbhid] SS:ESP 0068:f5f8bea0
[ 48.735023] CR2: 0000000000000000
[ 48.739373] ---[ end trace 650ff9964d1a683e ]---

Full dmesg will be attached to this message.

-- System Information:
Debian Release: wheezy/sid
APT prefers testing-proposed-updates
APT policy: (500, 'testing-proposed-updates'), (500, 'stable-updates'), (500, 'unstable'), (500, 'testing')
Architecture: i386 (i686)

Kernel: Linux 2.6.39-2-686-pae (SMP w/2 CPU cores)
Locale: LANG=ru_RU.utf8, LC_CTYPE=ru_RU.utf8 (charmap=UTF-8)
Shell: /bin/sh linked to /bin/bash

--
With best wishes
Dmitry

[ 0.000000] Initializing cgroup subsys cpuset
[ 0.000000] Initializing cgroup subsys cpu
[ 0.000000] Linux version 2.6.32-5-686-bigmem (Debian 2.6.32-34squeeze1) (dannf@debian.org) (gcc version 4.3.5 (Debian 4.3.5-4) ) #1 SMP Wed May 18 07:33:52 UTC 2011
[ 0.000000] KERNEL supported cpus:
[ 0.000000] Intel GenuineIntel
[ 0.000000] AMD AuthenticAMD
[ 0.000000] NSC Geode by NSC
[ 0.000000] Cyrix CyrixInstead
[ 0.000000] Centaur CentaurHauls
[ 0.000000] Transmeta GenuineTMx86
[ 0.000000] Transmeta TransmetaCPU
[ 0.000000] UMC UMC UMC UMC
[ 0.000000] BIOS-provided physical RAM map:
[ 0.000000] BIOS-e820: 0000000000000000 - 000000000009a800 (usable)
[ 0.000000] BIOS-e820: 000000000009a800 - 00000000000a0000 (reserved)
[ 0.000000] BIOS-e820: 00000000000e0000 - 0000000000100000 (reserved)
[ 0.000000] BIOS-e820: 0000000000100000 - 000000007fef0000 (usable)
[ 0.000000] BIOS-e820: 000000007fef0000 - 000000007fefb000 (ACPI data)
[ 0.000000] BIOS-e820: 000000007fefb000 - 000000007ff00000 (ACPI NVS)
[ 0.000000] BIOS-e820: 000000007ff00000 - 000000007ff80000 (usable)
[ 0.000000] BIOS-e820: 000000007ff80000 - 0000000080000000 (reserved)
[ 0.000000] BIOS-e820: 00000000e0000000 - 00000000f0000000 (reserved)
[ 0.000000] BIOS-e820: 00000000fec00000 - 00000000fed00400 (reserved)
[ 0.000000] BIOS-e820: 00000000fee00000 - 00000000fef00000 (reserved)
[ 0.000000] BIOS-e820: 00000000ffb00000 - 00000000ffc00000 (reserved)
[ 0.000000] BIOS-e820: 00000000fff00000 - 0000000100000000 (reserved)
[ 0.000000] DMI present.
[ 0.000000] Phoenix BIOS detected: BIOS may corrupt low RAM, working around it.
[ 0.000000] e820 update range: 0000000000000000 - 0000000000010000 (usable) ==> (reserved)
[ 0.000000] last_pfn = 0x7ff80 max_arch_pfn = 0x1000000
[ 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-C7FFF write-protect
[ 0.000000] C8000-DFFFF uncachable
[ 0.000000] E0000-FFFFF write-protect
[ 0.000000] MTRR variable ranges enabled:
[ 0.000000] 0 base 000000000 mask F80000000 write-back
[ 0.000000] 1 base 07FF80000 mask FFFF80000 uncachable
[ 0.000000] 2 disabled
[ 0.000000] 3 disabled
[ 0.000000] 4 disabled
[ 0.000000] 5 disabled
[ 0.000000] 6 disabled
[ 0.000000] 7 disabled
[ 0.000000] x86 PAT enabled: cpu 0, old 0x7040600070406, new 0x7010600070106
[ 0.000000] initial memory mapped : 0 - 01a00000
[ 0.000000] init_memory_mapping: 0000000000000000-00000000377fe000
[ 0.000000] NX (Execute Disable) protection: active
[ 0.000000] 0000000000 - 0000200000 page 4k
[ 0.000000] 0000200000 - 0037600000 page 2M
[ 0.000000] 0037600000 - 00377fe000 page 4k
[ 0.000000] kernel direct mapping tables up to 377fe000 @ 10000-17000
[ 0.000000] RAMDISK: 376d3000 - 37fefdda
[ 0.000000] Allocated new RAMDISK: 00100000 - 00a1cdda
[ 0.000000] Move RAMDISK from 00000000376d3000 - 0000000037fefdd9 to 00100000 - 00a1cdd9
[ 0.000000] ACPI: RSDP 000f6ba0 00024 (v02 PTLTD )
[ 0.000000] ACPI: XSDT 7fef5381 0004C (v01 PTLTD ? XSDT 06040001 LTP 00000000)
[ 0.000000] ACPI: FACP 7fef5441 000F4 (v03 FSC 06040001 000F4240)
[ 0.000000] ACPI: DSDT 7fef5535 0597B (v01 FSC D1649 06040001 MSFT 02000002)
[ 0.000000] ACPI: FACS 7fefbfc0 00040
[ 0.000000] ACPI: SPCR 7fefaeb0 00050 (v01 PTLTD $UCRTBL$ 06040001 PTL 00000001)
[ 0.000000] ACPI: MCFG 7fefaf00 00040 (v01 PTLTD MCFG 06040001 LTP 00000000)
[ 0.000000] ACPI: APIC 7fefaf40 00098 (v01 PTLTD ? APIC 06040001 LTP 00000000)
[ 0.000000] ACPI: BOOT 7fefafd8 00028 (v01 PTLTD $SBFTBL$ 06040001 LTP 00000001)
[ 0.000000] ACPI: Local APIC address 0xfee00000
[ 0.000000] 1159MB HIGHMEM available.
[ 0.000000] 887MB LOWMEM available.
[ 0.000000] mapped low ram: 0 - 377fe000
[ 0.000000] low ram: 0 - 377fe000
[ 0.000000] node 0 low ram: 00000000 - 377fe000
[ 0.000000] node 0 bootmap 00014000 - 0001af00
[ 0.000000] (9 early reservations) ==> bootmem [0000000000 - 00377fe000]
[ 0.000000] #0 [0000000000 - 0000001000] BIOS data page ==> [0000000000 - 0000001000]
[ 0.000000] #1 [0000001000 - 0000002000] EX TRAMPOLINE ==> [0000001000 - 0000002000]
[ 0.000000] #2 [0000006000 - 0000007000] TRAMPOLINE ==> [0000006000 - 0000007000]
[ 0.000000] #3 [0001000000 - 00014ff3f4] TEXT DATA BSS ==> [0001000000 - 00014ff3f4]
[ 0.000000] #4 [000009a800 - 0000100000] BIOS reserved ==> [000009a800 - 0000100000]
[ 0.000000] #5 [0001500000 - 000150d1b0] BRK ==> [0001500000 - 000150d1b0]
[ 0.000000] #6 [0000010000 - 0000014000] PGTABLE ==> [0000010000 - 0000014000]
[ 0.000000] #7 [0000100000 - 0000a1cdda] NEW RAMDISK ==> [0000100000 - 0000a1cdda]
[ 0.000000] #8 [0000014000 - 000001b000] BOOTMAP ==> [0000014000 - 000001b000]
[ 0.000000] found SMP MP-table at [c00f6c10] f6c10
[ 0.000000] Zone PFN ranges:
[ 0.000000] DMA 0x00000010 -> 0x00001000
[ 0.000000] Normal 0x00001000 -> 0x000377fe
[ 0.000000] HighMem 0x000377fe -> 0x0007ff80
[ 0.000000] Movable zone start PFN for each node
[ 0.000000] early_node_map[3] active PFN ranges
[ 0.000000] 0: 0x00000010 -> 0x0000009a
[ 0.000000] 0: 0x00000100 -> 0x0007fef0
[ 0.000000] 0: 0x0007ff00 -> 0x0007ff80
[ 0.000000] On node 0 totalpages: 524026
[ 0.000000] free_area_init_node: node 0, pgdat c13d2100, node_mem_map c150f200
[ 0.000000] DMA zone: 32 pages used for memmap
[ 0.000000] DMA zone: 0 pages reserved
[ 0.000000] DMA zone: 3946 pages, LIFO batch:0
[ 0.000000] Normal zone: 1744 pages used for memmap
[ 0.000000] Normal zone: 221486 pages, LIFO batch:31
[ 0.000000] HighMem zone: 2320 pages used for memmap
[ 0.000000] HighMem zone: 294498 pages, LIFO batch:31
[ 0.000000] Using APIC driver default
[ 0.000000] ACPI: PM-Timer IO Port: 0xf008
[ 0.000000] ACPI: Local APIC address 0xfee00000
[ 0.000000] ACPI: LAPIC (acpi_id[0x00] lapic_id[0x00] enabled)
[ 0.000000] ACPI: LAPIC (acpi_id[0x01] lapic_id[0x01] enabled)
[ 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: IOAPIC (id[0x03] address[0xfec80000] gsi_base[24])
[ 0.000000] IOAPIC[1]: apic_id 3, version 32, address 0xfec80000, GSI 24-47
[ 0.000000] ACPI: IOAPIC (id[0x04] address[0xfec80800] gsi_base[48])
[ 0.000000] IOAPIC[2]: apic_id 4, version 32, address 0xfec80800, GSI 48-71
[ 0.000000] ACPI: IOAPIC (id[0x05] address[0xfec84000] gsi_base[72])
[ 0.000000] IOAPIC[3]: apic_id 5, version 32, address 0xfec84000, GSI 72-95
[ 0.000000] ACPI: IOAPIC (id[0x06] address[0xfec84800] gsi_base[96])
[ 0.000000] IOAPIC[4]: apic_id 6, version 32, address 0xfec84800, GSI 96-119
[ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 high edge)
[ 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] SMP: Allowing 2 CPUs, 0 hotplug CPUs
[ 0.000000] nr_irqs_gsi: 120
[ 0.000000] PM: Registered nosave memory: 000000000009a000 - 000000000009b000
[ 0.000000] PM: Registered nosave memory: 000000000009b000 - 00000000000a0000
[ 0.000000] PM: Registered nosave memory: 00000000000a0000 - 00000000000e0000
[ 0.000000] PM: Registered nosave memory: 00000000000e0000 - 0000000000100000
[ 0.000000] Allocating PCI resources starting at 80000000 (gap: 80000000:60000000)
[ 0.000000] Booting paravirtualized kernel on bare hardware
[ 0.000000] NR_CPUS:32 nr_cpumask_bits:32 nr_cpu_ids:2 nr_node_ids:1
[ 0.000000] PERCPU: Embedded 15 pages/cpu @c2600000 s37688 r0 d23752 u1048576
[ 0.000000] pcpu-alloc: s37688 r0 d23752 u1048576 alloc=1*2097152
[ 0.000000] pcpu-alloc: [0] 0 1
[ 0.000000] Built 1 zonelists in Zone order, mobility grouping on. Total pages: 519930
[ 0.000000] Kernel command line: BOOT_IMAGE=/boot/vmlinuz-2.6.32-5-686-bigmem root=UUID=0e4ac9a7-9111-43ff-b284-241456b95d67 ro quiet
[ 0.000000] PID hash table entries: 4096 (order: 2, 16384 bytes)
[ 0.000000] Dentry cache hash table entries: 131072 (order: 7, 524288 bytes)
[ 0.000000] Inode-cache hash table entries: 65536 (order: 6, 262144 bytes)
[ 0.000000] Enabling fast FPU save and restore... done.
[ 0.000000] Enabling unmasked SIMD FPU exception support... done.
[ 0.000000] Initializing CPU#0
[ 0.000000] Initializing HighMem for node 0 (000377fe:0007ff80)
[ 0.000000] Memory: 2063248k/2096640k available (2573k kernel code, 31884k reserved, 1378k data, 396k init, 1187272k highmem)
[ 0.000000] virtual kernel memory layout:
[ 0.000000] fixmap : 0xffd56000 - 0xfffff000 (2724 kB)
[ 0.000000] pkmap : 0xff800000 - 0xffa00000 (2048 kB)
[ 0.000000] vmalloc : 0xf7ffe000 - 0xff7fe000 ( 120 MB)
[ 0.000000] lowmem : 0xc0000000 - 0xf77fe000 ( 887 MB)
[ 0.000000] .init : 0xc13dc000 - 0xc143f000 ( 396 kB)
[ 0.000000] .data : 0xc128359d - 0xc13dbeb0 (1378 kB)
[ 0.000000] .text : 0xc1000000 - 0xc128359d (2573 kB)
[ 0.000000] Checking if this processor honours the WP bit even in supervisor mode...Ok.
[ 0.000000] SLUB: Genslabs=13, HWalign=128, Order=0-3, MinObjects=0, CPUs=2, Nodes=1
[ 0.000000] Hierarchical RCU implementation.
[ 0.000000] NR_IRQS:1280
[ 0.000000] Extended CMOS year: 2000
[ 0.000000] Console: colour VGA+ 80x25
[ 0.000000] console [tty0] enabled
[ 0.000000] Fast TSC calibration using PIT
[ 0.000000] Detected 3000.176 MHz processor.
[ 0.004005] Calibrating delay loop (skipped), value calculated using timer frequency.. 6000.35 BogoMIPS (lpj=12000704)
[ 0.004025] Security Framework initialized
[ 0.004032] SELinux: Disabled at boot.
[ 0.004041] Mount-cache hash table entries: 512
[ 0.004197] Initializing cgroup subsys ns
[ 0.004202] Initializing cgroup subsys cpuacct
[ 0.004207] Initializing cgroup subsys devices
[ 0.004210] Initializing cgroup subsys freezer
[ 0.004213] Initializing cgroup subsys net_cls
[ 0.004247] CPU: Trace cache: 12K uops, L1 D cache: 16K
[ 0.004250] CPU: L2 cache: 2048K
[ 0.004254] CPU: Physical Processor ID: 0
[ 0.004256] CPU: Processor Core ID: 0
[ 0.004260] mce: CPU supports 4 MCE banks
[ 0.004274] CPU0: Thermal monitoring enabled (TM1)
[ 0.004279] using mwait in idle threads.
[ 0.004289] Performance Events: no PMU driver, software events only.
[ 0.004298] Checking 'hlt' instruction... OK.
[ 0.021613] ACPI: Core revision 20090903
[ 0.032073] Enabling APIC mode: Flat. Using 5 I/O APICs
[ 0.032592] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1
[ 0.074193] CPU0: Intel(R) Xeon(TM) CPU 3.00GHz stepping 03
[ 0.076001] Booting processor 1 APIC 0x1 ip 0x6000
[ 0.008000] Initializing CPU#1
[ 0.008000] CPU: Trace cache: 12K uops, L1 D cache: 16K
[ 0.008000] CPU: L2 cache: 2048K
[ 0.008000] CPU: Physical Processor ID: 0
[ 0.008000] CPU: Processor Core ID: 0
[ 0.008000] CPU1: Thermal monitoring enabled (TM1)
[ 0.160120] CPU1: Intel(R) Xeon(TM) CPU 3.00GHz stepping 03
[ 0.160131] checking TSC synchronization [CPU#0 -> CPU#1]: passed.
[ 0.164083] Brought up 2 CPUs
[ 0.164089] Total of 2 processors activated (12000.94 BogoMIPS).
[ 0.165021] CPU0 attaching sched-domain:
[ 0.165026] domain 0: span 0-1 level SIBLING
[ 0.165030] groups: 0 (cpu_power = 589) 1 (cpu_power = 589)
[ 0.165038] domain 1: span 0-1 level MC
[ 0.165041] groups: 0-1 (cpu_power = 1178)
[ 0.165048] CPU1 attaching sched-domain:
[ 0.165050] domain 0: span 0-1 level SIBLING
[ 0.165053] groups: 1 (cpu_power = 589) 0 (cpu_power = 589)
[ 0.165060] domain 1: span 0-1 level MC
[ 0.165063] groups: 0-1 (cpu_power = 1178)
[ 0.165168] devtmpfs: initialized
[ 0.165168] regulator: core version 0.5
[ 0.165168] NET: Registered protocol family 16
[ 0.165168] ACPI: bus type pci registered
[ 0.165168] PCI: Found Intel Corporation E7520 Memory Controller Hub with MMCONFIG support.
[ 0.165168] PCI: MCFG configuration 0: base e0000000 segment 0 buses 0 - 255
[ 0.165168] PCI: MCFG area at e0000000 reserved in E820
[ 0.165168] PCI: Using MMCONFIG for extended config space
[ 0.165168] PCI: Using configuration type 1 for base access
[ 0.165168] bio: create slab <bio-0> at 0
[ 0.165168] ACPI: EC: Look up EC in DSDT
[ 0.172679] ACPI: Interpreter enabled
[ 0.172685] ACPI: (supports S0 S1 S4 S5)
[ 0.172712] ACPI: Using IOAPIC for interrupt routing
[ 0.179394] ACPI: No dock devices found.
[ 0.179511] ACPI: PCI Root Bridge [PCI0] (0000:00)
[ 0.179676] pci 0000:00:02.0: PME# supported from D0 D3hot D3cold
[ 0.179681] pci 0000:00:02.0: PME# disabled
[ 0.179751] pci 0000:00:04.0: PME# supported from D0 D3hot D3cold
[ 0.179756] pci 0000:00:04.0: PME# disabled
[ 0.179827] pci 0000:00:05.0: PME# supported from D0 D3hot D3cold
[ 0.179832] pci 0000:00:05.0: PME# disabled
[ 0.179907] pci 0000:00:06.0: PME# supported from D0 D3hot D3cold
[ 0.179912] pci 0000:00:06.0: PME# disabled
[ 0.179985] pci 0000:00:1d.0: reg 20 io port: [0x1000-0x101f]
[ 0.180052] pci 0000:00:1d.1: reg 20 io port: [0x1400-0x141f]
[ 0.180107] pci 0000:00:1d.2: reg 20 io port: [0x1800-0x181f]
[ 0.180162] pci 0000:00:1d.3: reg 20 io port: [0x1c00-0x1c1f]
[ 0.180225] pci 0000:00:1d.7: reg 10 32bit mmio: [0xde100000-0xde1003ff]
[ 0.180285] pci 0000:00:1d.7: PME# supported from D0 D3hot D3cold
[ 0.180291] pci 0000:00:1d.7: PME# disabled
[ 0.180382] pci 0000:00:1f.0: Force enabled HPET at 0xfed00000
[ 0.180390] pci 0000:00:1f.0: quirk: region f000-f07f claimed by ICH4 ACPI/GPIO/TCO
[ 0.180396] pci 0000:00:1f.0: quirk: region f180-f1bf claimed by ICH4 GPIO
[ 0.180421] pci 0000:00:1f.1: reg 10 io port: [0x00-0x07]
[ 0.180429] pci 0000:00:1f.1: reg 14 io port: [0x00-0x03]
[ 0.180437] pci 0000:00:1f.1: reg 18 io port: [0x00-0x07]
[ 0.180444] pci 0000:00:1f.1: reg 1c io port: [0x00-0x03]
[ 0.180452] pci 0000:00:1f.1: reg 20 io port: [0x2400-0x240f]
[ 0.180460] pci 0000:00:1f.1: reg 24 32bit mmio: [0x000000-0x0003ff]
[ 0.180515] pci 0000:00:1f.3: reg 20 io port: [0x2000-0x201f]
[ 0.180593] pci 0000:01:00.0: PME# supported from D0 D3hot D3cold
[ 0.180598] pci 0000:01:00.0: PME# disabled
[ 0.180662] pci 0000:01:00.2: PME# supported from D0 D3hot D3cold
[ 0.180666] pci 0000:01:00.2: PME# disabled
[ 0.180687] pci 0000:01:00.0: disabling ASPM on pre-1.1 PCIe device. You can enable it with 'pcie_aspm=force'
[ 0.180751] pci 0000:00:02.0: bridge io port: [0x3000-0x3fff]
[ 0.180756] pci 0000:00:02.0: bridge 32bit mmio: [0xde200000-0xde4fffff]
[ 0.180812] pci 0000:02:08.0: reg 10 io port: [0x3000-0x30ff]
[ 0.180824] pci 0000:02:08.0: reg 14 64bit mmio: [0xde210000-0xde21ffff]
[ 0.180835] pci 0000:02:08.0: reg 1c 64bit mmio: [0xde200000-0xde20ffff]
[ 0.180847] pci 0000:02:08.0: reg 30 32bit mmio pref: [0x000000-0x0fffff]
[ 0.180872] pci 0000:02:08.0: supports D1 D2
[ 0.180918] pci 0000:02:08.1: reg 10 io port: [0x3400-0x34ff]
[ 0.180930] pci 0000:02:08.1: reg 14 64bit mmio: [0xde230000-0xde23ffff]
[ 0.180941] pci 0000:02:08.1: reg 1c 64bit mmio: [0xde220000-0xde22ffff]
[ 0.180953] pci 0000:02:08.1: reg 30 32bit mmio pref: [0x000000-0x0fffff]
[ 0.180977] pci 0000:02:08.1: supports D1 D2
[ 0.181029] pci 0000:01:00.0: bridge io port: [0x3000-0x3fff]
[ 0.181034] pci 0000:01:00.0: bridge 32bit mmio: [0xde200000-0xde4fffff]
[ 0.181147] pci 0000:04:00.0: reg 10 64bit mmio: [0xde500000-0xde50ffff]
[ 0.181210] pci 0000:04:00.0: PME# supported from D3hot D3cold
[ 0.181215] pci 0000:04:00.0: PME# disabled
[ 0.181242] pci 0000:04:00.0: disabling ASPM on pre-1.1 PCIe device. You can enable it with 'pcie_aspm=force'
[ 0.181321] pci 0000:00:04.0: bridge 32bit mmio: [0xde500000-0xde5fffff]
[ 0.181380] pci 0000:05:00.0: reg 10 64bit mmio: [0xde600000-0xde60ffff]
[ 0.181443] pci 0000:05:00.0: PME# supported from D3hot D3cold
[ 0.181449] pci 0000:05:00.0: PME# disabled
[ 0.181475] pci 0000:05:00.0: disabling ASPM on pre-1.1 PCIe device. You can enable it with 'pcie_aspm=force'
[ 0.181555] pci 0000:00:05.0: bridge 32bit mmio: [0xde600000-0xde6fffff]
[ 0.181596] pci 0000:06:00.0: PXH quirk detected; SHPC device MSI disabled
[ 0.181608] pci 0000:06:00.0: reg 10 64bit mmio: [0xde700000-0xde700fff]
[ 0.181639] pci 0000:06:00.0: PME# supported from D0 D3hot D3cold
[ 0.181643] pci 0000:06:00.0: PME# disabled
[ 0.181686] pci 0000:06:00.2: PXH quirk detected; SHPC device MSI disabled
[ 0.181722] pci 0000:06:00.2: PME# supported from D0 D3hot D3cold
[ 0.181727] pci 0000:06:00.2: PME# disabled
[ 0.181747] pci 0000:06:00.0: disabling ASPM on pre-1.1 PCIe device. You can enable it with 'pcie_aspm=force'
[ 0.181809] pci 0000:00:06.0: bridge io port: [0x4000-0x4fff]
[ 0.181814] pci 0000:00:06.0: bridge 32bit mmio: [0xde700000-0xde8fffff]
[ 0.181821] pci 0000:00:06.0: bridge 64bit mmio pref: [0xde000000-0xde0fffff]
[ 0.181911] pci 0000:08:0b.0: reg 10 io port: [0x4000-0x40ff]
[ 0.181923] pci 0000:08:0b.0: reg 14 64bit mmio: [0xde800000-0xde800fff]
[ 0.181943] pci 0000:08:0b.0: reg 30 32bit mmio pref: [0x000000-0x01ffff]
[ 0.182000] pci 0000:08:0c.0: reg 10 32bit mmio pref: [0xde000000-0xde00ffff]
[ 0.182037] pci 0000:08:0c.0: reg 30 32bit mmio pref: [0x000000-0x01ffff]
[ 0.182091] pci 0000:06:00.2: bridge io port: [0x4000-0x4fff]
[ 0.182096] pci 0000:06:00.2: bridge 32bit mmio: [0xde800000-0xde8fffff]
[ 0.182103] pci 0000:06:00.2: bridge 64bit mmio pref: [0xde000000-0xde0fffff]
[ 0.182153] pci 0000:09:05.0: reg 10 32bit mmio: [0xdf000000-0xdfffffff]
[ 0.182161] pci 0000:09:05.0: reg 14 io port: [0x5000-0x50ff]
[ 0.182169] pci 0000:09:05.0: reg 18 32bit mmio: [0xde900000-0xde900fff]
[ 0.182191] pci 0000:09:05.0: reg 30 32bit mmio pref: [0x000000-0x01ffff]
[ 0.182211] pci 0000:09:05.0: supports D1 D2
[ 0.182253] pci 0000:00:1e.0: transparent bridge
[ 0.182259] pci 0000:00:1e.0: bridge io port: [0x5000-0x5fff]
[ 0.182264] pci 0000:00:1e.0: bridge 32bit mmio: [0xde900000-0xdfffffff]
[ 0.182290] pci_bus 0000:00: on NUMA node 0
[ 0.182295] ACPI: PCI Interrupt Routing Table [\_SB_.PCI0._PRT]
[ 0.182610] ACPI: PCI Interrupt Routing Table [\_SB_.PCI0.PEA0.DOB0._PRT]
[ 0.182723] ACPI: PCI Interrupt Routing Table [\_SB_.PCI0.PEA0.DOB2._PRT]
[ 0.182970] ACPI: PCI Interrupt Routing Table [\_SB_.PCI0.PEC0.PXH0._PRT]
[ 0.183135] ACPI: PCI Interrupt Routing Table [\_SB_.PCI0.PEC0.PXH2._PRT]
[ 0.187413] ACPI: PCI Interrupt Link [LNKA] (IRQs 3 4 5 6 7 9 10 *11 12 14 15)
[ 0.187562] ACPI: PCI Interrupt Link [LNKB] (IRQs 3 4 5 6 7 *9 10 11 12 14 15)
[ 0.187707] ACPI: PCI Interrupt Link [LNKC] (IRQs 3 4 *5 6 7 9 10 11 12 14 15)
[ 0.187853] ACPI: PCI Interrupt Link [LNKD] (IRQs 3 4 5 6 7 9 *10 11 12 14 15)
[ 0.187977] ACPI: PCI Interrupt Link [LNKE] (IRQs 3 4 5 6 7 9 10 11 12 14 15) *0, disabled.
[ 0.188111] ACPI: PCI Interrupt Link [LNKF] (IRQs 3 4 5 6 7 9 10 11 12 14 15) *0, disabled.
[ 0.188235] ACPI: PCI Interrupt Link [LNKG] (IRQs 3 4 5 6 7 9 10 11 12 14 15) *0, disabled.
[ 0.188381] ACPI: PCI Interrupt Link [LNKH] (IRQs 3 4 5 6 7 *9 10 11 12 14 15)
[ 0.188529] vgaarb: device added: PCI:0000:09:05.0,decodes=io+mem,owns=io+mem,locks= none
[ 0.188533] vgaarb: loaded
[ 0.188557] PCI: Using ACPI for IRQ routing
[ 0.188557] hpet clockevent registered
[ 0.188557] HPET: 3 timers in total, 0 timers will be used for per-cpu timer
[ 0.188557] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0
[ 0.188557] hpet0: 3 comparators, 64-bit 14.318180 MHz counter
[ 0.192030] Switching to clocksource tsc
[ 0.193596] pnp: PnP ACPI init
[ 0.193613] ACPI: bus type pnp registered
[ 0.196375] pnp: PnP ACPI: found 12 devices
[ 0.196378] ACPI: ACPI bus type pnp unregistered
[ 0.196384] PnPBIOS: Disabled by ACPI PNP
[ 0.196397] system 00:02: ioport range 0x4d0-0x4d1 has been reserved
[ 0.196402] system 00:02: ioport range 0xca2-0xca3 has been reserved
[ 0.196406] system 00:02: ioport range 0xca4-0xca5 has been reserved
[ 0.196413] system 00:02: ioport range 0xf000-0xf07f has been reserved
[ 0.196417] system 00:02: ioport range 0xf100-0xf10f has been reserved
[ 0.196421] system 00:02: ioport range 0xf180-0xf1bf has been reserved
[ 0.196425] system 00:02: ioport range 0x800-0x87f has been reserved
[ 0.196429] system 00:02: ioport range 0xf820-0xf82f has been reserved
[ 0.196433] system 00:02: ioport range 0xfe00-0xfe00 has been reserved
[ 0.196438] system 00:02: iomem range 0xfee00000-0xfeefffff has been reserved
[ 0.196443] system 00:02: iomem range 0xfec00000-0xfecfffff could not be reserved
[ 0.231301] pci 0000:01:00.0: PCI bridge, secondary bus 0000:02
[ 0.231306] pci 0000:01:00.0: IO window: 0x3000-0x3fff
[ 0.231312] pci 0000:01:00.0: MEM window: 0xde200000-0xde4fffff
[ 0.231317] pci 0000:01:00.0: PREFETCH window: 0x80000000-0x801fffff
[ 0.231324] pci 0000:01:00.2: PCI bridge, secondary bus 0000:03
[ 0.231327] pci 0000:01:00.2: IO window: disabled
[ 0.231332] pci 0000:01:00.2: MEM window: disabled
[ 0.231336] pci 0000:01:00.2: PREFETCH window: disabled
[ 0.231343] pci 0000:00:02.0: PCI bridge, secondary bus 0000:01
[ 0.231347] pci 0000:00:02.0: IO window: 0x3000-0x3fff
[ 0.231353] pci 0000:00:02.0: MEM window: 0xde200000-0xde4fffff
[ 0.231358] pci 0000:00:02.0: PREFETCH window: 0x80000000-0x801fffff
[ 0.231364] pci 0000:00:04.0: PCI bridge, secondary bus 0000:04
[ 0.231367] pci 0000:00:04.0: IO window: disabled
[ 0.231373] pci 0000:00:04.0: MEM window: 0xde500000-0xde5fffff
[ 0.231377] pci 0000:00:04.0: PREFETCH window: disabled
[ 0.231384] pci 0000:00:05.0: PCI bridge, secondary bus 0000:05
[ 0.231386] pci 0000:00:05.0: IO window: disabled
[ 0.231392] pci 0000:00:05.0: MEM window: 0xde600000-0xde6fffff
[ 0.231396] pci 0000:00:05.0: PREFETCH window: disabled
[ 0.231403] pci 0000:06:00.0: PCI bridge, secondary bus 0000:07
[ 0.231406] pci 0000:06:00.0: IO window: disabled
[ 0.231411] pci 0000:06:00.0: MEM window: disabled
[ 0.231415] pci 0000:06:00.0: PREFETCH window: disabled
[ 0.231423] pci 0000:06:00.2: PCI bridge, secondary bus 0000:08
[ 0.231427] pci 0000:06:00.2: IO window: 0x4000-0x4fff
[ 0.231432] pci 0000:06:00.2: MEM window: 0xde800000-0xde8fffff
[ 0.231438] pci 0000:06:00.2: PREFETCH window: 0x000000de000000-0x000000de0fffff
[ 0.231444] pci 0000:00:06.0: PCI bridge, secondary bus 0000:06
[ 0.231448] pci 0000:00:06.0: IO window: 0x4000-0x4fff
[ 0.231454] pci 0000:00:06.0: MEM window: 0xde700000-0xde8fffff
[ 0.231459] pci 0000:00:06.0: PREFETCH window: 0x000000de000000-0x000000de0fffff
[ 0.231467] pci 0000:00:1e.0: PCI bridge, secondary bus 0000:09
[ 0.231471] pci 0000:00:1e.0: IO window: 0x5000-0x5fff
[ 0.231477] pci 0000:00:1e.0: MEM window: 0xde900000-0xdfffffff
[ 0.231483] pci 0000:00:1e.0: PREFETCH window: 0x80200000-0x802fffff
[ 0.231502] pci 0000:00:02.0: PCI INT A -> GSI 16 (level, low) -> IRQ 16
[ 0.231508] pci 0000:00:02.0: setting latency timer to 64
[ 0.231520] pci 0000:01:00.0: setting latency timer to 64
[ 0.231531] pci 0000:01:00.2: setting latency timer to 64
[ 0.231542] pci 0000:00:04.0: PCI INT A -> GSI 16 (level, low) -> IRQ 16
[ 0.231547] pci 0000:00:04.0: setting latency timer to 64
[ 0.231556] pci 0000:00:05.0: PCI INT A -> GSI 16 (level, low) -> IRQ 16
[ 0.231561] pci 0000:00:05.0: setting latency timer to 64
[ 0.231570] pci 0000:00:06.0: PCI INT A -> GSI 16 (level, low) -> IRQ 16
[ 0.231574] pci 0000:00:06.0: setting latency timer to 64
[ 0.231585] pci 0000:06:00.0: PCI INT A -> GSI 16 (level, low) -> IRQ 16
[ 0.231590] pci 0000:06:00.0: setting latency timer to 64
[ 0.231599] pci 0000:06:00.2: setting latency timer to 64
[ 0.231607] pci 0000:00:1e.0: setting latency timer to 64
[ 0.231613] pci_bus 0000:00: resource 0 io: [0x00-0xffff]
[ 0.231617] pci_bus 0000:00: resource 1 mem: [0x000000-0xffffffffffffffff]
[ 0.231621] pci_bus 0000:01: resource 0 io: [0x3000-0x3fff]
[ 0.231624] pci_bus 0000:01: resource 1 mem: [0xde200000-0xde4fffff]
[ 0.231628] pci_bus 0000:01: resource 2 pref mem [0x80000000-0x801fffff]
[ 0.231632] pci_bus 0000:02: resource 0 io: [0x3000-0x3fff]
[ 0.231635] pci_bus 0000:02: resource 1 mem: [0xde200000-0xde4fffff]
[ 0.231639] pci_bus 0000:02: resource 2 pref mem [0x80000000-0x801fffff]
[ 0.231643] pci_bus 0000:04: resource 1 mem: [0xde500000-0xde5fffff]
[ 0.231646] pci_bus 0000:05: resource 1 mem: [0xde600000-0xde6fffff]
[ 0.231650] pci_bus 0000:06: resource 0 io: [0x4000-0x4fff]
[ 0.231653] pci_bus 0000:06: resource 1 mem: [0xde700000-0xde8fffff]
[ 0.231657] pci_bus 0000:06: resource 2 pref mem [0xde000000-0xde0fffff]
[ 0.231660] pci_bus 0000:08: resource 0 io: [0x4000-0x4fff]
[ 0.231664] pci_bus 0000:08: resource 1 mem: [0xde800000-0xde8fffff]
[ 0.231681] pci_bus 0000:08: resource 2 pref mem [0xde000000-0xde0fffff]
[ 0.231685] pci_bus 0000:09: resource 0 io: [0x5000-0x5fff]
[ 0.231689] pci_bus 0000:09: resource 1 mem: [0xde900000-0xdfffffff]
[ 0.231692] pci_bus 0000:09: resource 2 pref mem [0x80200000-0x802fffff]
[ 0.231696] pci_bus 0000:09: resource 3 io: [0x00-0xffff]
[ 0.231699] pci_bus 0000:09: resource 4 mem: [0x000000-0xffffffffffffffff]
[ 0.231738] NET: Registered protocol family 2
[ 0.231853] IP route cache hash table entries: 32768 (order: 5, 131072 bytes)
[ 0.232253] TCP established hash table entries: 131072 (order: 8, 1048576 bytes)
[ 0.232748] TCP bind hash table entries: 65536 (order: 7, 524288 bytes)
[ 0.233001] TCP: Hash tables configured (established 131072 bind 65536)
[ 0.233005] TCP reno registered
[ 0.233091] NET: Registered protocol family 1
[ 0.233249] pci 0000:01:00.0: rerouting interrupts for [8086:0330]
[ 0.233255] pci 0000:01:00.2: rerouting interrupts for [8086:0332]
[ 0.233265] pci 0000:06:00.0: rerouting interrupts for [8086:0329]
[ 0.233270] pci 0000:06:00.2: rerouting interrupts for [8086:032a]
[ 0.233279] pci 0000:09:05.0: Boot video device
[ 0.233344] Unpacking initramfs...
[ 0.560025] Freeing initrd memory: 9331k freed
[ 0.566112] Simple Boot Flag at 0x5c set to 0x1
[ 0.566490] audit: initializing netlink socket (disabled)
[ 0.566507] type=2000 audit(1308769914.563:1): initialized
[ 0.570371] highmem bounce pool size: 64 pages
[ 0.570379] HugeTLB registered 2 MB page size, pre-allocated 0 pages
[ 0.572248] VFS: Disk quotas dquot_6.5.2
[ 0.572326] Dquot-cache hash table entries: 1024 (order 0, 4096 bytes)
[ 0.572436] msgmni has been set to 1731
[ 0.572718] alg: No test for stdrng (krng)
[ 0.572795] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 253)
[ 0.572800] io scheduler noop registered
[ 0.572803] io scheduler anticipatory registered
[ 0.572806] io scheduler deadline registered
[ 0.572854] io scheduler cfq registered (default)
[ 0.573024] pcieport 0000:00:02.0: irq 120 for MSI/MSI-X
[ 0.573034] pcieport 0000:00:02.0: setting latency timer to 64
[ 0.573164] pcieport 0000:00:04.0: irq 121 for MSI/MSI-X
[ 0.573173] pcieport 0000:00:04.0: setting latency timer to 64
[ 0.573298] pcieport 0000:00:05.0: irq 122 for MSI/MSI-X
[ 0.573307] pcieport 0000:00:05.0: setting latency timer to 64
[ 0.573436] pcieport 0000:00:06.0: irq 123 for MSI/MSI-X
[ 0.573446] pcieport 0000:00:06.0: setting latency timer to 64
[ 0.573591] aer 0000:00:02.0:pcie02: AER service couldn't init device: no _OSC support
[ 0.573602] aer 0000:00:04.0:pcie02: AER service couldn't init device: no _OSC support
[ 0.573611] aer 0000:00:05.0:pcie02: AER service couldn't init device: no _OSC support
[ 0.573619] aer 0000:00:06.0:pcie02: AER service couldn't init device: no _OSC support
[ 0.573769] isapnp: Scanning for PnP cards...
[ 0.927719] isapnp: No Plug & Play device found
[ 0.929565] Linux agpgart interface v0.103
[ 0.929747] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled
[ 0.929845] serial8250: ttyS0 at I/O 0x3f8 (irq = 4) is a 16550A
[ 0.929945] serial8250: ttyS1 at I/O 0x2f8 (irq = 3) is a 16550A
[ 0.930328] 00:0a: ttyS1 at I/O 0x2f8 (irq = 3) is a 16550A
[ 0.930474] 00:0b: ttyS0 at I/O 0x3f8 (irq = 4) is a 16550A
[ 0.930630] PNP: PS/2 Controller [PNP0303:KEYB] at 0x60,0x64 irq 1
[ 0.930633] PNP: PS/2 appears to have AUX port disabled, if this is incorrect please boot with i8042.nopnp
[ 0.931144] serio: i8042 KBD port at 0x60,0x64 irq 1
[ 0.931241] mice: PS/2 mouse device common for all mice
[ 0.931296] rtc_cmos 00:04: RTC can wake from S4
[ 0.931346] rtc_cmos 00:04: rtc core: registered rtc_cmos as rtc0
[ 0.931370] rtc0: alarms up to one month, y3k, 114 bytes nvram, hpet irqs
[ 0.931388] cpuidle: using governor ladder
[ 0.931391] cpuidle: using governor menu
[ 0.931397] No iBFT detected.
[ 0.931870] TCP cubic registered
[ 0.932025] NET: Registered protocol family 10
[ 0.933212] Mobile IPv6
[ 0.933216] NET: Registered protocol family 17
[ 0.933234] Using IPI No-Shortcut mode
[ 0.933321] PM: Resume from disk failed.
[ 0.933336] registered taskstats version 1
[ 0.933798] rtc_cmos 00:04: setting system clock to 2011-06-22 19:11:55 UTC (1308769915)
[ 0.933855] Initalizing network drop monitor service
[ 0.933885] Freeing unused kernel memory: 396k freed
[ 0.934145] Write protecting the kernel text: 2576k
[ 0.934186] Write protecting the kernel read-only data: 924k
[ 0.956784] udev[56]: starting version 164
[ 1.167912] usbcore: registered new interface driver usbfs
[ 1.167979] usbcore: registered new interface driver hub
[ 1.168069] usbcore: registered new device driver usb
[ 1.192830] SCSI subsystem initialized
[ 1.211696] megaraid cmm: 2.20.2.7 (Release Date: Sun Jul 16 00:01:03 EST 2006)
[ 1.219754] tg3.c:v3.102 (September 1, 2009)
[ 1.219785] tg3 0000:04:00.0: PCI INT A -> GSI 16 (level, low) -> IRQ 16
[ 1.219803] tg3 0000:04:00.0: setting latency timer to 64
[ 1.228063] Floppy drive(s): fd0 is 1.44M
[ 1.228891] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver
[ 1.228941] ehci_hcd 0000:00:1d.7: PCI INT D -> GSI 23 (level, low) -> IRQ 23
[ 1.228964] ehci_hcd 0000:00:1d.7: setting latency timer to 64
[ 1.228970] ehci_hcd 0000:00:1d.7: EHCI Host Controller
[ 1.229015] ehci_hcd 0000:00:1d.7: new USB bus registered, assigned bus number 1
[ 1.229063] ehci_hcd 0000:00:1d.7: debug port 1
[ 1.232957] ehci_hcd 0000:00:1d.7: cache line size of 128 is not supported
[ 1.232978] ehci_hcd 0000:00:1d.7: irq 23, io mem 0xde100000
[ 1.237070] Fusion MPT base driver 3.04.12
[ 1.237075] Copyright (c) 1999-2008 LSI Corporation
[ 1.247158] eth0: Tigon3 [partno(BCM95721) rev 4101] (PCI Express) MAC address 00:19:99:12:e8:fa
[ 1.247165] eth0: attached PHY is 5750 (10/100/1000Base-T Ethernet) (WireSpeed[1])
[ 1.247171] eth0: RXcsums[1] LinkChgREG[0] MIirq[0] ASF[1] TSOcap[1]
[ 1.247175] eth0: dma_rwctrl[76180000] dma_mask[64-bit]
[ 1.247208] tg3 0000:05:00.0: PCI INT A -> GSI 16 (level, low) -> IRQ 16
[ 1.247219] tg3 0000:05:00.0: setting latency timer to 64
[ 1.249411] FDC 0 is a post-1991 82077
[ 1.249449] ehci_hcd 0000:00:1d.7: USB 2.0 started, EHCI 1.00
[ 1.249496] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002
[ 1.249502] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[ 1.249507] usb usb1: Product: EHCI Host Controller
[ 1.249511] usb usb1: Manufacturer: Linux 2.6.32-5-686-bigmem ehci_hcd
[ 1.249515] usb usb1: SerialNumber: 0000:00:1d.7
[ 1.249731] usb usb1: configuration #1 chosen from 1 choice
[ 1.249847] hub 1-0:1.0: USB hub found
[ 1.249861] hub 1-0:1.0: 8 ports detected
[ 1.257923] megaraid: 2.20.5.1 (Release Date: Thu Nov 16 15:32:35 EST 2006)
[ 1.257953] megaraid: probe new device 0x1000:0x1960:0x1000:0x0518: bus 8:slot 12:func 0
[ 1.257976] megaraid 0000:08:0c.0: PCI INT A -> GSI 99 (level, low) -> IRQ 99
[ 1.260789] Fusion MPT SPI Host driver 3.04.12
[ 1.260844] mptspi 0000:02:08.0: PCI INT A -> GSI 24 (level, low) -> IRQ 24
[ 1.260958] mptbase: ioc0: Initiating bringup
[ 1.295819] eth1: Tigon3 [partno(BCM95721) rev 4101] (PCI Express) MAC address 00:19:99:12:46:e3
[ 1.295826] eth1: attached PHY is 5750 (10/100/1000Base-T Ethernet) (WireSpeed[1])
[ 1.295831] eth1: RXcsums[1] LinkChgREG[0] MIirq[0] ASF[0] TSOcap[1]
[ 1.295836] eth1: dma_rwctrl[76180000] dma_mask[64-bit]
[ 1.298565] uhci_hcd: USB Universal Host Controller Interface driver
[ 1.298629] uhci_hcd 0000:00:1d.0: PCI INT A -> GSI 16 (level, low) -> IRQ 16
[ 1.298643] uhci_hcd 0000:00:1d.0: setting latency timer to 64
[ 1.298650] uhci_hcd 0000:00:1d.0: UHCI Host Controller
[ 1.298671] uhci_hcd 0000:00:1d.0: new USB bus registered, assigned bus number 2
[ 1.298714] uhci_hcd 0000:00:1d.0: irq 16, io base 0x00001000
[ 1.298775] usb usb2: New USB device found, idVendor=1d6b, idProduct=0001
[ 1.298781] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[ 1.298786] usb usb2: Product: UHCI Host Controller
[ 1.298791] usb usb2: Manufacturer: Linux 2.6.32-5-686-bigmem uhci_hcd
[ 1.298795] usb usb2: SerialNumber: 0000:00:1d.0
[ 1.299205] usb usb2: configuration #1 chosen from 1 choice
[ 1.299273] hub 2-0:1.0: USB hub found
[ 1.299285] hub 2-0:1.0: 2 ports detected
[ 1.299383] uhci_hcd 0000:00:1d.1: PCI INT B -> GSI 19 (level, low) -> IRQ 19
[ 1.299395] uhci_hcd 0000:00:1d.1: setting latency timer to 64
[ 1.299402] uhci_hcd 0000:00:1d.1: UHCI Host Controller
[ 1.299420] uhci_hcd 0000:00:1d.1: new USB bus registered, assigned bus number 3
[ 1.299730] uhci_hcd 0000:00:1d.1: irq 19, io base 0x00001400
[ 1.299792] usb usb3: New USB device found, idVendor=1d6b, idProduct=0001
[ 1.299798] usb usb3: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[ 1.299803] usb usb3: Product: UHCI Host Controller
[ 1.299807] usb usb3: Manufacturer: Linux 2.6.32-5-686-bigmem uhci_hcd
[ 1.299812] usb usb3: SerialNumber: 0000:00:1d.1
[ 1.299940] usb usb3: configuration #1 chosen from 1 choice
[ 1.300016] hub 3-0:1.0: USB hub found
[ 1.300030] hub 3-0:1.0: 2 ports detected
[ 1.300122] uhci_hcd 0000:00:1d.2: PCI INT C -> GSI 18 (level, low) -> IRQ 18
[ 1.300134] uhci_hcd 0000:00:1d.2: setting latency timer to 64
[ 1.300140] uhci_hcd 0000:00:1d.2: UHCI Host Controller
[ 1.300159] uhci_hcd 0000:00:1d.2: new USB bus registered, assigned bus number 4
[ 1.300197] uhci_hcd 0000:00:1d.2: irq 18, io base 0x00001800
[ 1.300254] usb usb4: New USB device found, idVendor=1d6b, idProduct=0001
[ 1.300260] usb usb4: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[ 1.300266] usb usb4: Product: UHCI Host Controller
[ 1.300272] usb usb4: Manufacturer: Linux 2.6.32-5-686-bigmem uhci_hcd
[ 1.300276] usb usb4: SerialNumber: 0000:00:1d.2
[ 1.300414] usb usb4: configuration #1 chosen from 1 choice
[ 1.300469] hub 4-0:1.0: USB hub found
[ 1.300483] hub 4-0:1.0: 2 ports detected
[ 1.300565] uhci_hcd 0000:00:1d.3: PCI INT A -> GSI 16 (level, low) -> IRQ 16
[ 1.300576] uhci_hcd 0000:00:1d.3: setting latency timer to 64
[ 1.300581] uhci_hcd 0000:00:1d.3: UHCI Host Controller
[ 1.300597] uhci_hcd 0000:00:1d.3: new USB bus registered, assigned bus number 5
[ 1.300629] uhci_hcd 0000:00:1d.3: irq 16, io base 0x00001c00
[ 1.300687] usb usb5: New USB device found, idVendor=1d6b, idProduct=0001
[ 1.300693] usb usb5: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[ 1.300697] usb usb5: Product: UHCI Host Controller
[ 1.300702] usb usb5: Manufacturer: Linux 2.6.32-5-686-bigmem uhci_hcd
[ 1.300706] usb usb5: SerialNumber: 0000:00:1d.3
[ 1.300830] usb usb5: configuration #1 chosen from 1 choice
[ 1.300887] hub 5-0:1.0: USB hub found
[ 1.300901] hub 5-0:1.0: 2 ports detected
[ 1.303282] libata version 3.00 loaded.
[ 1.309054] megaraid: fw version:[1F42] bios version:[G302]
[ 1.309587] ata_piix 0000:00:1f.1: version 2.13
[ 1.309610] ata_piix 0000:00:1f.1: PCI INT A -> GSI 18 (level, low) -> IRQ 18
[ 1.309675] ata_piix 0000:00:1f.1: setting latency timer to 64
[ 1.309785] scsi0 : ata_piix
[ 1.309927] scsi1 : ata_piix
[ 1.310773] ata1: PATA max UDMA/100 cmd 0x1f0 ctl 0x3f6 bmdma 0x2400 irq 14
[ 1.310778] ata2: PATA max UDMA/100 cmd 0x170 ctl 0x376 bmdma 0x2408 irq 15
[ 1.349215] scsi2 : LSI Logic MegaRAID driver
[ 1.349385] aic7xxx 0000:08:0b.0: PCI INT A -> GSI 98 (level, low) -> IRQ 98
[ 1.349437] scsi[2]: scanning scsi channel 0 [Phy 0] for non-raid devices
[ 1.476297] ata2.00: ATAPI: HL-DT-STCD-RW/DVD DRIVE GCC-4244N, 1.00, max UDMA/33
[ 1.492209] ata2.00: configured for UDMA/33
[ 1.493139] scsi: waiting for bus probes to complete ...
[ 1.772011] ioc0: LSI53C1030 C0: Capabilities={Initiator}
[ 1.879176] scsi 2:0:8:0: Processor QLogic GEM359 1.10 PQ: 0 ANSI: 2
[ 1.908015] usb 2-2: new low speed USB device using uhci_hcd and address 2
[ 2.101640] usb 2-2: New USB device found, idVendor=051d, idProduct=0002
[ 2.101645] usb 2-2: New USB device strings: Mfr=3, Product=1, SerialNumber=2
[ 2.101649] usb 2-2: Product: Smart-UPS 3000 RM FW:666.6.I USB FW:2.4
[ 2.101652] usb 2-2: Manufacturer: American Power Conversion
[ 2.101655] usb 2-2: SerialNumber: CS0533110332
[ 2.101779] usb 2-2: configuration #1 chosen from 1 choice
[ 2.383729] scsi4 : ioc0: LSI53C1030 C0, FwRev=01033000h, Ports=1, MaxQ=222, IRQ=24
[ 2.763728] mptspi 0000:02:08.1: PCI INT B -> GSI 25 (level, low) -> IRQ 25
[ 2.763844] mptbase: ioc1: Initiating bringup
[ 3.137405] scsi[2]: scanning scsi channel 1 [Phy 1] for non-raid devices
[ 3.352015] usb 3-2: new low speed USB device using uhci_hcd and address 2
[ 3.509369] usb 3-2: New USB device found, idVendor=0566, idProduct=3107
[ 3.509374] usb 3-2: New USB device strings: Mfr=0, Product=0, SerialNumber=0
[ 3.509491] usb 3-2: configuration #1 chosen from 1 choice
[ 3.523553] usbcore: registered new interface driver hiddev
[ 3.657521] scsi 2:1:8:0: Processor QLogic GEM359 1.10 PQ: 0 ANSI: 2
[ 4.304013] ioc1: LSI53C1030 C0: Capabilities={Initiator}
[ 4.914717] scsi5 : ioc1: LSI53C1030 C0, FwRev=01033000h, Ports=1, MaxQ=222, IRQ=25
[ 4.922645] scsi[2]: scanning scsi channel 2 [virtual] for logical drives
[ 4.923086] scsi 2:2:0:0: Direct-Access MegaRAID LD 0 RAID5 1537G 1F42 PQ: 0 ANSI: 2
[ 4.933000] scsi 1:0:0:0: CD-ROM HL-DT-ST RW/DVD GCC-4244N 1.00 PQ: 0 ANSI: 5
[ 4.951976] sd 2:2:0:0: [sda] 3149414400 512-byte logical blocks: (1.61 TB/1.46 TiB)
[ 4.952030] sd 2:2:0:0: [sda] Write Protect is off
[ 4.952037] sd 2:2:0:0: [sda] Mode Sense: 00 00 00 00
[ 4.952059] sd 2:2:0:0: [sda] Asking for cache data failed
[ 4.952110] sd 2:2:0:0: [sda] Assuming drive cache: write through
[ 4.952399] sd 2:2:0:0: [sda] Asking for cache data failed
[ 4.952449] sd 2:2:0:0: [sda] Assuming drive cache: write through
[ 4.952498] sda: sda1 sda2 sda3
[ 4.954137] sd 2:2:0:0: [sda] Asking for cache data failed
[ 4.954185] sd 2:2:0:0: [sda] Assuming drive cache: write through
[ 4.954234] sd 2:2:0:0: [sda] Attached SCSI disk
[ 4.955220] scsi 2:0:8:0: Attached scsi generic sg0 type 3
[ 4.955983] scsi 2:1:8:0: Attached scsi generic sg1 type 3
[ 4.956110] sd 2:2:0:0: Attached scsi generic sg2 type 0
[ 4.956221] scsi 1:0:0:0: Attached scsi generic sg3 type 5
[ 4.977402] sr0: scsi3-mmc drive: 24x/24x writer cd/rw xa/form2 cdda tray
[ 4.977408] Uniform CD-ROM driver Revision: 3.20
[ 4.977565] sr 1:0:0:0: Attached scsi CD-ROM sr0
[ 6.042075] generic-usb 0003:051D:0002.0001: hiddev0,hidraw0: USB HID v1.10 Device [American Power Conversion Smart-UPS 3000 RM FW:666.6.I USB FW:2.4] on usb-0000:00:1d.0-2/input0
[ 6.055202] input: HID 0566:3107 as /devices/pci0000:00/0000:00:1d.1/usb3/3-2/3-2:1.0/input/input0
[ 6.055273] generic-usb 0003:0566:3107.0002: input,hidraw1: USB HID v1.10 Keyboard [HID 0566:3107] on usb-0000:00:1d.1-2/input0
[ 6.079030] input: HID 0566:3107 as /devices/pci0000:00/0000:00:1d.1/usb3/3-2/3-2:1.1/input/input1
[ 6.079105] generic-usb 0003:0566:3107.0003: input,hidraw2: USB HID v1.10 Device [HID 0566:3107] on usb-0000:00:1d.1-2/input1
[ 6.079145] usbcore: registered new interface driver usbhid
[ 6.079151] usbhid: v2.6:USB HID core driver
[ 6.354966] scsi 4:0:1:0: Direct-Access LSILOGIC 1030 IM 1000 PQ: 0 ANSI: 2
[ 7.356235] scsi 4:0:8:0: Processor SDR GEM318P 1 PQ: 0 ANSI: 2
[ 7.356250] scsi target4:0:8: Beginning Domain Validation
[ 7.357758] scsi target4:0:8: Ending Domain Validation
[ 7.357815] scsi target4:0:8: asynchronous
[ 9.118701] scsi 4:1:1:0: Direct-Access FUJITSU MAW3147NC 5203 PQ: 0 ANSI: 3
[ 9.119654] mptbase: ioc0: RAID STATUS CHANGE for VolumeID 1
[ 9.119658] mptbase: ioc0: volume is now optimal, enabled, quiesced
[ 9.119983] mptbase: ioc0: RAID STATUS CHANGE for PhysDisk 0 id=1
[ 9.119986] mptbase: ioc0: PhysDisk is now online, quiesced
[ 9.120298] mptbase: ioc0: RAID STATUS CHANGE for PhysDisk 1 id=1
[ 9.120301] mptbase: ioc0: PhysDisk is now online, quiesced
[ 9.120374] scsi target4:1:1: Beginning Domain Validation
[ 9.429888] scsi target4:1:1: Ending Domain Validation
[ 9.430763] mptbase: ioc0: RAID STATUS CHANGE for VolumeID 1
[ 9.430767] mptbase: ioc0: volume is now optimal, enabled
[ 9.431091] mptbase: ioc0: RAID STATUS CHANGE for PhysDisk 0 id=1
[ 9.431094] mptbase: ioc0: PhysDisk is now online
[ 9.431403] mptbase: ioc0: RAID STATUS CHANGE for PhysDisk 1 id=1
[ 9.431407] mptbase: ioc0: PhysDisk is now online
[ 9.432067] scsi target4:1:1: FAST-160 WIDE SCSI 320.0 MB/s DT IU RTI WRFLOW PCOMP (6.25 ns, offset 127)
[ 9.436143] scsi 4:1:4:0: Direct-Access FUJITSU MAW3147NC 5203 PQ: 0 ANSI: 3
[ 9.437095] mptbase: ioc0: RAID STATUS CHANGE for VolumeID 1
[ 9.437100] mptbase: ioc0: volume is now optimal, enabled, quiesced
[ 9.437425] mptbase: ioc0: RAID STATUS CHANGE for PhysDisk 0 id=1
[ 9.437429] mptbase: ioc0: PhysDisk is now online, quiesced
[ 9.437738] mptbase: ioc0: RAID STATUS CHANGE for PhysDisk 1 id=1
[ 9.437741] mptbase: ioc0: PhysDisk is now online, quiesced
[ 9.437818] scsi target4:1:4: Beginning Domain Validation
[ 9.751279] scsi target4:1:4: Ending Domain Validation
[ 9.752153] mptbase: ioc0: RAID STATUS CHANGE for VolumeID 1
[ 9.752157] mptbase: ioc0: volume is now optimal, enabled
[ 9.752480] mptbase: ioc0: RAID STATUS CHANGE for PhysDisk 0 id=1
[ 9.752483] mptbase: ioc0: PhysDisk is now online
[ 9.752794] mptbase: ioc0: RAID STATUS CHANGE for PhysDisk 1 id=1
[ 9.752797] mptbase: ioc0: PhysDisk is now online
[ 9.753454] scsi target4:1:4: FAST-160 WIDE SCSI 320.0 MB/s DT IU RTI WRFLOW PCOMP (6.25 ns, offset 127)
[ 9.754485] sd 4:0:1:0: Attached scsi generic sg4 type 0
[ 9.754941] scsi 4:0:8:0: Attached scsi generic sg5 type 3
[ 9.755253] scsi 4:1:1:0: Attached scsi generic sg6 type 0
[ 9.755555] scsi 4:1:4:0: Attached scsi generic sg7 type 0
[ 9.762209] sd 4:0:1:0: [sdb] 286310400 512-byte logical blocks: (146 GB/136 GiB)
[ 9.763346] sd 4:0:1:0: [sdb] Write Protect is off
[ 9.763354] sd 4:0:1:0: [sdb] Mode Sense: 03 00 00 08
[ 9.764552] sd 4:0:1:0: [sdb] Write cache: disabled, read cache: enabled, doesn't support DPO or FUA
[ 9.765711] sdb: sdb1 sdb2 sdb3
[ 9.779050] sd 4:0:1:0: [sdb] Attached SCSI disk
[ 16.560022] scsi3 : Adaptec AIC7XXX EISA/VLB/PCI SCSI HBA DRIVER, Rev 7.0
[ 16.560025] <Adaptec 29160 Ultra160 SCSI adapter>
[ 16.560027] aic7892: Ultra160 Wide Channel A, SCSI Id=7, 32/253 SCBs
[ 16.560029]
[ 16.598369] scsi 3:0:0:0: Medium Changer EXABYTE Exabyte 221L 3.6 PQ: 0 ANSI: 2
[ 16.598390] scsi target3:0:0: Beginning Domain Validation
[ 16.609123] device-mapper: uevent: version 1.0.3
[ 16.609341] device-mapper: ioctl: 4.15.0-ioctl (2009-04-01) initialised: dm-devel@redhat.com
[ 16.635992] EXT3-fs: INFO: recovery required on readonly filesystem.
[ 16.635997] EXT3-fs: write access will be enabled during recovery.
[ 16.713783] scsi target3:0:0: Ending Domain Validation
[ 16.754551] scsi 3:0:1:0: Sequential-Access IBM ULTRIUM-TD3 54K1 PQ: 0 ANSI: 3
[ 16.754557] scsi 3:0:1:0: Information Units disabled by blacklist
[ 16.754567] scsi target3:0:1: Beginning Domain Validation
[ 16.759810] scsi target3:0:1: wide asynchronous
[ 16.763947] scsi target3:0:1: FAST-80 WIDE SCSI 160.0 MB/s DT (12.5 ns, offset 127)
[ 16.782694] scsi target3:0:1: Domain Validation skipping write tests
[ 16.782698] scsi target3:0:1: Ending Domain Validation
[ 16.818800] kjournald starting. Commit interval 5 seconds
[ 16.818811] EXT3-fs: recovery complete.
[ 16.830972] EXT3-fs: mounted filesystem with ordered data mode.
[ 17.512399] udev[391]: starting version 164
[ 17.706292] processor LNXCPU:00: registered as cooling_device0
[ 17.706408] processor LNXCPU:02: registered as cooling_device1
[ 17.769109] input: Power Button as /devices/LNXSYSTM:00/LNXSYBUS:00/PNP0C0C:00/input/input2
[ 17.769123] ACPI: Power Button [PWRB]
[ 17.769291] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input3
[ 17.769300] ACPI: Power Button [PWRF]
[ 17.770910] EDAC MC: Ver: 2.1.0 May 18 2011
[ 17.791013] pci_hotplug: PCI Hot Plug PCI Core version: 0.5
[ 17.828952] shpchp 0000:06:00.0: HPC vendor_id 8086 device_id 329 ss_vid 0 ss_did 0
[ 17.829051] shpchp 0000:06:00.0: Can't get msi for the hotplug controller
[ 17.829057] shpchp 0000:06:00.0: Use INTx for the hotplug controller
[ 17.836673] input: PC Speaker as /devices/platform/pcspkr/input/input4
[ 17.837044] Contact your BIOS vendor to see if the E752x error registers can be safely un-hidden
[ 17.847263] i801_smbus 0000:00:1f.3: PCI INT B -> GSI 17 (level, low) -> IRQ 17
[ 17.853426] shpchp: Standard Hot Plug PCI Controller Driver version: 0.4
[ 17.885084] intel_rng: FWH not detected
[ 17.940737] parport_pc 00:09: reported by Plug and Play ACPI
[ 17.940767] parport0: PC-style at 0x378, irq 7 [PCSPP,TRISTATE,EPP]
[ 18.109099] Error: Driver 'pcspkr' is already registered, aborting...
[ 19.767352] Adding 6610736k swap on /dev/sdb3. Priority:-1 extents:1 across:6610736k
[ 19.899065] EXT3 FS on sdb1, internal journal
[ 19.984810] Fusion MPT misc device (ioctl) driver 3.04.12
[ 19.985093] mptctl: Registered with Fusion MPT base driver
[ 19.985100] mptctl: /dev/mptctl @ (major,minor=10,220)
[ 20.003522] ipmi message handler version 39.2
[ 20.012174] IPMI System Interface driver.
[ 20.012183] ipmi_si: Trying SMBIOS-specified kcs state machine at i/o address 0xca2, slave address 0x24, irq 0
[ 20.116753] scsi 3:0:0:0: Attached scsi generic sg8 type 8
[ 20.116982] scsi 3:0:1:0: Attached scsi generic sg9 type 1
[ 20.148035] SCSI Media Changer driver v0.25
[ 20.152644] st: Version 20081215, fixed bufsize 32768, s/g segs 256
[ 20.173246] ch0: type #1 (mt): 0x56+1 [medium transport]
[ 20.173252] ch0: type #2 (st): 0x1+21 [storage]
[ 20.173256] ch0: type #3 (ie): 0x51+1 [import/export]
[ 20.173260] ch0: type #4 (dt): 0x52+1 [data transfer]
[ 20.190212] ch0: dt 0x52: not this SCSI bus
[ 20.190216] ch0: INITIALIZE ELEMENT STATUS, may take some time ...
[ 20.234839] ipmi: Found new BMC (man_id: 0x002880, prod_id: 0x0000, dev_id: 0x00)
[ 20.234856] IPMI kcs interface initialized
[ 20.239501] ipmi device interface
[ 20.389194] smsc47m1: Found SMSC LPC47M10x/LPC47M112/LPC47M13x
[ 20.389255] ACPI: I/O resource smsc47m1 [0x800-0x87f] conflicts with ACPI region SSWC [0x800-0x87f]
[ 20.389328] ACPI: If an ACPI driver is available for this device, you should use it instead of the native driver
[ 21.427861] SGI XFS with ACLs, security attributes, realtime, large block/inode numbers, no debug enabled
[ 21.429511] SGI XFS Quota Management subsystem
[ 21.452147] XFS mounting filesystem dm-1
[ 21.611144] Starting XFS recovery on filesystem: dm-1 (logdev: internal)
[ 21.718630] Ending XFS recovery on filesystem: dm-1 (logdev: internal)
[ 21.729198] kjournald starting. Commit interval 5 seconds
[ 21.739241] EXT3 FS on sdb2, internal journal
[ 21.739249] EXT3-fs: mounted filesystem with ordered data mode.
[ 21.760004] XFS mounting filesystem dm-13
[ 21.923463] Starting XFS recovery on filesystem: dm-13 (logdev: internal)
[ 22.538960] Ending XFS recovery on filesystem: dm-13 (logdev: internal)
[ 22.564746] XFS mounting filesystem dm-5
[ 22.715031] Starting XFS recovery on filesystem: dm-5 (logdev: internal)
[ 22.830002] Ending XFS recovery on filesystem: dm-5 (logdev: internal)
[ 22.846361] XFS mounting filesystem dm-9
[ 23.008757] Starting XFS recovery on filesystem: dm-9 (logdev: internal)
[ 23.577439] Ending XFS recovery on filesystem: dm-9 (logdev: internal)
[ 23.591006] XFS mounting filesystem dm-16
[ 23.715030] Starting XFS recovery on filesystem: dm-16 (logdev: internal)
[ 23.899097] Ending XFS recovery on filesystem: dm-16 (logdev: internal)
[ 23.919574] kjournald starting. Commit interval 5 seconds
[ 23.928215] EXT3 FS on dm-17, internal journal
[ 23.928223] EXT3-fs: mounted filesystem with ordered data mode.
[ 24.659925] ADDRCONF(NETDEV_UP): siemens: link is not ready
[ 25.320087] ADDRCONF(NETDEV_UP): snt: link is not ready
[ 25.922429] microcode: CPU0 sig=0xf43, pf=0x1, revision=0x5
[ 25.922439] platform microcode: firmware: requesting intel-ucode/0f-04-03
[ 25.949676] microcode: CPU1 sig=0xf43, pf=0x1, revision=0x5
[ 25.949687] platform microcode: firmware: requesting intel-ucode/0f-04-03
[ 25.953616] Microcode Update Driver: v2.00 <tigran@aivazian.fsnet.co.uk>, Peter Oruba
[ 26.296170] tg3: siemens: Link is up at 100 Mbps, full duplex.
[ 26.296174] tg3: siemens: Flow control is on for TX and on for RX.
[ 26.296333] ADDRCONF(NETDEV_CHANGE): siemens: link becomes ready
[ 27.003373] tg3: snt: Link is up at 100 Mbps, full duplex.
[ 27.003377] tg3: snt: Flow control is on for TX and on for RX.
[ 27.003522] ADDRCONF(NETDEV_CHANGE): snt: link becomes ready
[ 29.168045] usb 2-2: USB disconnect, address 2
[ 29.171446] /tmp/buildd/linux-2.6-2.6.32/debian/build/source_i386_none/drivers/hid/usbhid/hid-core.c: usb_submit_urb(ctrl) failed
[ 33.620033] usb 2-2: new low speed USB device using uhci_hcd and address 3
[ 33.813959] usb 2-2: New USB device found, idVendor=051d, idProduct=0002
[ 33.813965] usb 2-2: New USB device strings: Mfr=3, Product=1, SerialNumber=2
[ 33.813970] usb 2-2: Product: Smart-UPS 3000 RM FW:666.6.I USB FW:2.4
[ 33.813974] usb 2-2: Manufacturer: American Power Conversion
[ 33.813977] usb 2-2: SerialNumber: CS0533110332
[ 33.814127] usb 2-2: configuration #1 chosen from 1 choice
[ 36.147735] generic-usb 0003:051D:0002.0004: hiddev0,hidraw0: USB HID v1.10 Device [American Power Conversion Smart-UPS 3000 RM FW:666.6.I USB FW:2.4] on usb-0000:00:1d.0-2/input0
[ 37.149006] siemens: no IPv6 routers present
[ 37.245005] snt: no IPv6 routers present
[ 38.345062] usb 2-2: USB disconnect, address 3
[ 42.745031] usb 2-2: new low speed USB device using uhci_hcd and address 4
[ 42.938593] usb 2-2: New USB device found, idVendor=051d, idProduct=0002
[ 42.938599] usb 2-2: New USB device strings: Mfr=3, Product=1, SerialNumber=2
[ 42.938603] usb 2-2: Product: Smart-UPS 3000 RM FW:666.6.I USB FW:2.4
[ 42.938607] usb 2-2: Manufacturer: American Power Conversion
[ 42.938610] usb 2-2: SerialNumber: CS0533110332
[ 42.938754] usb 2-2: configuration #1 chosen from 1 choice
[ 45.380361] generic-usb 0003:051D:0002.0005: hiddev0,hidraw0: USB HID v1.10 Device [American Power Conversion Smart-UPS 3000 RM FW:666.6.I USB FW:2.4] on usb-0000:00:1d.0-2/input0
[ 48.268044] usb 2-2: USB disconnect, address 4
[ 48.269572] /tmp/buildd/linux-2.6-2.6.32/debian/build/source_i386_none/drivers/hid/usbhid/hid-core.c: usb_submit_urb(ctrl) failed
[ 48.731053] BUG: unable to handle kernel NULL pointer dereference at (null)
[ 48.731193] IP: [<f843db27>] hiddev_ioctl+0x26/0x56f [usbhid]
[ 48.731294] *pdpt = 000000003587c001 *pde = 0000000000000000
[ 48.731424] Oops: 0000 [#1] SMP
[ 48.731549] last sysfs file: /sys/devices/pci0000:00/0000:00:1d.0/usb2/2-2/2-2:1.0/0003:051D:0002.0005/hidraw/hidraw0/uevent
[ 48.731619] Modules linked in: microcode xfs exportfs eeprom ipmi_devintf st(+) ch(+) ipmi_si ipmi_msghandler mptctl psmouse dm_snapshot snd_pcm snd_timer parport_pc snd soundcore snd_page_alloc parport i2c_i801 pcspkr e752x_edac shpchp joydev evdev serio_raw container i2c_core rng_core pci_hotplug button edac_core processor ext3 jbd mbcache dm_mod sr_mod cdrom sg sd_mod crc_t10dif ata_generic usbhid hid aic7xxx ata_piix uhci_hcd libata mptspi megaraid_mbox mptscsih mptbase ehci_hcd floppy tg3 megaraid_mm scsi_transport_spi libphy thermal thermal_sys scsi_mod usbcore nls_base [last unloaded: scsi_wait_scan]
[ 48.734244]
[ 48.734295] Pid: 1390, comm: apcupsd Not tainted (2.6.32-5-686-bigmem #1) D1889
[ 48.734361] EIP: 0060:[<f843db27>] EFLAGS: 00010286 CPU: 0
[ 48.734419] EIP is at hiddev_ioctl+0x26/0x56f [usbhid]
[ 48.734473] EAX: 00000000 EBX: 400c4807 ECX: bffb50d4 EDX: fffffffb
[ 48.734528] ESI: f65dd5c0 EDI: f645a000 EBP: bffb50d4 ESP: f5f8bea0
[ 48.734584] DS: 007b ES: 007b FS: 00d8 GS: 00e0 SS: 0068
[ 48.734639] Process apcupsd (pid: 1390, ti=f5f8a000 task=f5dc1100 task.ti=f5f8a000)
[ 48.734703] Stack:
[ 48.734752] c1031658 f5b20000 c143de20 f5ff9e00 c2608e20 f5ff9e00 c127e933 c13a4ba0
[ 48.735023] <0> c143959c c143de20 c143de20 c1439354 f5dc12bc c2608e20 00000000 00000000
[ 48.735023] <0> 00000296 00000292 0000c350 f5dc1100 c26045cc f5f8bf44 c104d131 f5f8bf44
[ 48.735023] Call Trace:
[ 48.735023] [<c1031658>] ? finish_task_switch+0x34/0x95
[ 48.735023] [<c127e933>] ? schedule+0x7a4/0x7f1
[ 48.735023] [<c104d131>] ? lock_hrtimer_base+0x15/0x2f
[ 48.735023] [<c104d1af>] ? hrtimer_try_to_cancel+0x2f/0x35
[ 48.735023] [<c104d1bf>] ? hrtimer_cancel+0xa/0x14
[ 48.735023] [<f843db01>] ? hiddev_ioctl+0x0/0x56f [usbhid]
[ 48.735023] [<c10c53d4>] ? vfs_ioctl+0x1c/0x5f
[ 48.735023] [<c10c5968>] ? do_vfs_ioctl+0x4aa/0x4e5
[ 48.735023] [<c104cae6>] ? hrtimer_wakeup+0x0/0x18
[ 48.735023] [<c10517e0>] ? getnstimeofday+0x4d/0xc9
[ 48.735023] [<c1051896>] ? do_gettimeofday+0xf/0x29
[ 48.735023] [<c10c59e4>] ? sys_ioctl+0x41/0x58
[ 48.735023] [<c100813b>] ? sysenter_do_call+0x12/0x28
[ 48.735023] Code: 5b 5e 5f 5d c3 55 89 cd 57 56 53 89 d3 83 ec 7c 8b 40 70 ba fb ff ff ff 89 44 24 04 8b b0 10 c0 00 00 8b 7e 28 8b 87 54 0c 00 00 <8b> 08 8b 87 a0 0e 00 00 89 04 24 83 3e 00 0f 84 2b 05 00 00 81
[ 48.735023] EIP: [<f843db27>] hiddev_ioctl+0x26/0x56f [usbhid] SS:ESP 0068:f5f8bea0
[ 48.735023] CR2: 0000000000000000
[ 48.739373] ---[ end trace 650ff9964d1a683e ]---
[ 52.796015] usb 2-2: new low speed USB device using uhci_hcd and address 5
[ 52.990953] usb 2-2: New USB device found, idVendor=051d, idProduct=0002
[ 52.991011] usb 2-2: New USB device strings: Mfr=3, Product=1, SerialNumber=2
[ 52.991072] usb 2-2: Product: Smart-UPS 3000 RM FW:666.6.I USB FW:2.4
[ 52.991128] usb 2-2: Manufacturer: American Power Conversion
[ 52.991182] usb 2-2: SerialNumber: CS0533110332
[ 52.991366] usb 2-2: configuration #1 chosen from 1 choice
[ 55.475708] generic-usb 0003:051D:0002.0006: hiddev0,hidraw0: USB HID v1.10 Device [American Power Conversion Smart-UPS 3000 RM FW:666.6.I USB FW:2.4] on usb-0000:00:1d.0-2/input0
[ 57.441037] usb 2-2: USB disconnect, address 5
[ 61.904022] usb 2-2: new low speed USB device using uhci_hcd and address 6
[ 62.098960] usb 2-2: New USB device found, idVendor=051d, idProduct=0002
[ 62.099021] usb 2-2: New USB device strings: Mfr=3, Product=1, SerialNumber=2
[ 62.099081] usb 2-2: Product: Smart-UPS 3000 RM FW:666.6.I USB FW:2.4
[ 62.099137] usb 2-2: Manufacturer: American Power Conversion
[ 62.099192] usb 2-2: SerialNumber: CS0533110332
[ 62.099380] usb 2-2: configuration #1 chosen from 1 choice
[ 64.651753] generic-usb 0003:051D:0002.0007: hiddev0,hidraw0: USB HID v1.10 Device [American Power Conversion Smart-UPS 3000 RM FW:666.6.I USB FW:2.4] on usb-0000:00:1d.0-2/input0
[ 66.121039] usb 2-2: USB disconnect, address 6
[ 70.648015] usb 2-2: new low speed USB device using uhci_hcd and address 7
[ 70.842961] usb 2-2: New USB device found, idVendor=051d, idProduct=0002
[ 70.843022] usb 2-2: New USB device strings: Mfr=3, Product=1, SerialNumber=2
[ 70.843085] usb 2-2: Product: Smart-UPS 3000 RM FW:666.6.I USB FW:2.4
[ 70.843142] usb 2-2: Manufacturer: American Power Conversion
[ 70.843196] usb 2-2: SerialNumber: CS0533110332
[ 70.843378] usb 2-2: configuration #1 chosen from 1 choice
[ 71.970369] ch0: ... finished
[ 71.970426] ch 3:0:0:0: Attached scsi changer ch0
[ 71.970990] st 3:0:1:0: Attached scsi tape st0
[ 71.971050] st 3:0:1:0: st0: try direct i/o: yes (alignment 4 B)
[ 71.981346] osst :I: Tape driver with OnStream support version 0.99.4
[ 71.981350] osst :I: $Id: osst.c,v 1.73 2005/01/01 21:13:34 wriede Exp $
[ 73.219800] generic-usb 0003:051D:0002.0008: hiddev0,hidraw0: USB HID v1.10 Device [American Power Conversion Smart-UPS 3000 RM FW:666.6.I USB FW:2.4] on usb-0000:00:1d.0-2/input0
[ 79.173263] vboxdrv: Found 2 processor cores.
[ 79.173442] vboxdrv: fAsync=0 offMin=0x4a8 offMax=0x179d
[ 79.173580] vboxdrv: TSC mode is 'synchronous', kernel timer mode is 'normal'.
[ 79.173650] vboxdrv: Successfully loaded version 3.2.12 (interface 0x00140001).

Ben Hutchings 06-23-2011 03:27 AM

Bug#631287: BUG during access to hiddev (APC UPS)
 
On Wed, 2011-06-22 at 19:24 +0400, Dmitry Eremin-Solenikov wrote:
> Package: linux-image-2.6.32-5-686-bigmem
> Version: 2.6.32-34squeeze1
> Severity: important
>
> After upgrading to squeeze I've started receiving the following BUG in dmesg
> when apcupsd tries to access hid device for my UPS (APC SmartUPS 3000,
> connected via USB).
[...]

There have been some changes to this driver in later versions that are
supposed to fix this. However it still looks like there are some broken
cases, so I'll try to deal with them as well rather than fixing only
part of the problem.

Ben.

--
Ben Hutchings
Editing code like this is akin to sticking plasters on the bleeding stump
of a severed limb. - me, 29 June 1999

Jonathan Nieder 11-26-2011 05:43 AM

Bug#631287: BUG during access to hiddev (APC UPS)
 
Ben Hutchings wrote:
> On Wed, 2011-06-22 at 19:24 +0400, Dmitry Eremin-Solenikov wrote:

>> After upgrading to squeeze I've started receiving the following BUG in dmesg
>> when apcupsd tries to access hid device for my UPS (APC SmartUPS 3000,
>> connected via USB).
> [...]
>
> There have been some changes to this driver in later versions that are
> supposed to fix this. However it still looks like there are some broken
> cases, so I'll try to deal with them as well rather than fixing only
> part of the problem.

v2.6.38-rc1~442^2~20 (HID: Fix race between disconnect and hiddev_ioctl,
2010-12-06) seems to follow a sane approach.

Follow-up fixes:

. v2.6.38-rc1~442^2~19 (HID: Consolidate device existence checks in
hiddev_ioctl, 2010-12-06)
. v3.0-rc1~345^2^3 (HID: hiddev: fix race between hiddev_disconnect and
hiddev_release, 2011-05-20)
. v3.0-rc4~20^2~6 (HID: hiddev: fix potential use-after-free,
2011-05-24)
. v3.0-rc4~20^2~4 (HID: hiddev: fix use after free in hiddev_release,
2011-05-26)

Dmitry, I assume you can still reproduce this. Could you try a 3.x.y
kernel from sid? The only packages needed from outside squeeze aside
from linux-image-3.1.0-1-686-pae itself are linux-base and
initramfs-tools.

Hope that helps,
Jonathan



--
To UNSUBSCRIBE, email to debian-kernel-REQUEST@lists.debian.org
with a subject of "unsubscribe". Trouble? Contact listmaster@lists.debian.org
Archive: 20111126064330.GA20836@elie.hsd1.il.comcast.net">h ttp://lists.debian.org/20111126064330.GA20836@elie.hsd1.il.comcast.net

Dmitry Eremin-Solenikov 11-28-2011 05:53 PM

Bug#631287: BUG during access to hiddev (APC UPS)
 
Hello, colleagues,

On Sat, Nov 26, 2011 at 10:43 AM, Jonathan Nieder <jrnieder@gmail.com> wrote:
> Ben Hutchings wrote:
>> On Wed, 2011-06-22 at 19:24 +0400, Dmitry Eremin-Solenikov wrote:
>
>>> After upgrading to squeeze I've started receiving the following BUG in dmesg
>>> when apcupsd tries to access hid device for my UPS (APC SmartUPS 3000,
>>> connected via USB).
>> [...]
>>
>> There have been some changes to this driver in later versions that are
>> supposed to fix this. *However it still looks like there are some broken
>> cases, so I'll try to deal with them as well rather than fixing only
>> part of the problem.
>
> v2.6.38-rc1~442^2~20 (HID: Fix race between disconnect and hiddev_ioctl,
> 2010-12-06) seems to follow a sane approach.
>
> Follow-up fixes:
>
> . v2.6.38-rc1~442^2~19 (HID: Consolidate device existence checks in
> *hiddev_ioctl, 2010-12-06)
> . v3.0-rc1~345^2^3 (HID: hiddev: fix race between hiddev_disconnect and
> *hiddev_release, 2011-05-20)
> . v3.0-rc4~20^2~6 (HID: hiddev: fix potential use-after-free,
> *2011-05-24)
> . v3.0-rc4~20^2~4 (HID: hiddev: fix use after free in hiddev_release,
> *2011-05-26)
>
> Dmitry, I assume you can still reproduce this. *Could you try a 3.x.y
> kernel from sid? *The only packages needed from outside squeeze aside
> from linux-image-3.1.0-1-686-pae itself are linux-base and
> initramfs-tools.

Unfortunately I cannot try reproducing this error, as I don't have access
to this hardware anymore. The problem was easily reproducible though
by using apcupsd together with any USB APC ups.

--
With best wishes
Dmitry



--
To UNSUBSCRIBE, email to debian-kernel-REQUEST@lists.debian.org
with a subject of "unsubscribe". Trouble? Contact listmaster@lists.debian.org
Archive: CALT56yNYP1b3Vuu7wYta8TsSejXtwZtihLiKOHnqY6X5tfrbr A@mail.gmail.com">http://lists.debian.org/CALT56yNYP1b3Vuu7wYta8TsSejXtwZtihLiKOHnqY6X5tfrbr A@mail.gmail.com

Jonathan Nieder 11-29-2011 07:30 AM

Bug#631287: BUG during access to hiddev (APC UPS)
 
Hi Stefan et al,

I'd like to ask a favor. The following kernel bug is stalled for lack
of access to a USB APC UPS. Do you know of anyone who could reproduce
it and confirm the fix?

Dmitry Eremin-Solenikov wrote[1]:

> After upgrading to squeeze I've started receiving the following BUG in dmesg
> when apcupsd tries to access hid device for my UPS (APC SmartUPS 3000,
> connected via USB).
[...]
> usb 2-2: USB disconnect, address 4
> [...]/drivers/hid/usbhid/hid-core.c: usb_submit_urb(ctrl) failed
> BUG: unable to handle kernel NULL pointer dereference at (null)
> IP: [<f843db27>] hiddev_ioctl+0x26/0x56f [usbhid]

And later:

> Unfortunately I cannot try reproducing this error, as I don't have access
> to this hardware anymore. The problem was easily reproducible though
> by using apcupsd together with any USB APC ups.

If someone has a USB APC UPS, we would like to learn the following
from her:

1. confirm that this bug affects your system, using the kernel from
squeeze
2. confirm that it is fixed using the kernel from sid. (The only
packages from outside squeeze needed for this test aside from the
kernel image itself are linux-base and initramfs-tools.)
3. test the relevant patches (attached) on top of a 2.6.32.y kernel,
as described at [2].

Any subset would be useful already. Thanks much for keeping the
userspace support well maintained.

Looking forward to your thoughts,
Jonathan

[1] http://bugs.debian.org/631287
[2] http://kernel-handbook.alioth.debian.org/ch-common-tasks.html
From: Chris Ball <cjb@laptop.org>
Date: Thu, 12 Aug 2010 19:07:40 -0400
Subject: HID: hiddev: protect against disconnect/NULL-dereference race

commit 7032269e87ade34cc12891675371fa2ac150a620 upstream

One of our users reports consistently hitting a NULL dereference that
resolves to the "hid_to_usb_dev(hid);" call in hiddev_ioctl(), when
disconnecting a Lego WeDo USB HID device from an OLPC XO running
Scratch software. There's a FIXME comment and a guard against the
dereference, but that happens farther down the function than the
initial dereference does.

This patch moves the call to be below the guard, and the user reports
that it fixes the problem for him. OLPC bug report:
http://dev.laptop.org/ticket/10174

Signed-off-by: Chris Ball <cjb@laptop.org>
Signed-off-by: Jiri Kosina <jkosina@suse.cz>
Signed-off-by: Jonathan Nieder <jrnieder@gmail.com>
---
drivers/hid/usbhid/hiddev.c | 6 ++++--
1 files changed, 4 insertions(+), 2 deletions(-)

diff --git a/drivers/hid/usbhid/hiddev.c b/drivers/hid/usbhid/hiddev.c
index 8b6ee247bfe4..cb3f35594bfa 100644
--- a/drivers/hid/usbhid/hiddev.c
+++ b/drivers/hid/usbhid/hiddev.c
@@ -594,7 +594,7 @@ static long hiddev_ioctl(struct file *file, unsigned int cmd, unsigned long arg)
struct hiddev_list *list = file->private_data;
struct hiddev *hiddev = list->hiddev;
struct hid_device *hid = hiddev->hid;
- struct usb_device *dev = hid_to_usb_dev(hid);
+ struct usb_device *dev;
struct hiddev_collection_info cinfo;
struct hiddev_report_info rinfo;
struct hiddev_field_info finfo;
@@ -608,9 +608,11 @@ static long hiddev_ioctl(struct file *file, unsigned int cmd, unsigned long arg)
/* Called without BKL by compat methods so no BKL taken */

/* FIXME: Who or what stop this racing with a disconnect ?? */
- if (!hiddev->exist)
+ if (!hiddev->exist || !hid)
return -EIO;

+ dev = hid_to_usb_dev(hid);
+
switch (cmd) {

case HIDIOCGVERSION:
--
1.7.8.rc3

From: Valentine Barshak <vbarshak@mvista.com>
Date: Mon, 6 Dec 2010 17:51:41 +0300
Subject: HID: Fix race between disconnect and hiddev_ioctl

commit 1a8e8fab790ea7af81b8f964fdec706ad1ec2271 upstream

A USB HID device can be disconnected at any time.
If this happens right before or while hiddev_ioctl is in progress,
the hiddev_ioctl tries to access invalid hiddev->hid pointer.
When the hid device is disconnected, the hiddev_disconnect()
ends up with a call to hid_device_release() which frees
hid_device, but doesn't set the hiddev->hid pointer to NULL.
If the deallocated memory region has been re-used by the kernel,
this can cause a crash or memory corruption.

Since disconnect can happen at any time, we can't initialize
struct hid_device *hid = hiddev->hid at the beginning of ioctl
and then use it.

This change checks hiddev->exist flag while holding
the existancelock and uses hid_device only if it exists.

Signed-off-by: Valentine Barshak <vbarshak@mvista.com>
Signed-off-by: Jiri Kosina <jkosina@suse.cz>
Signed-off-by: Jonathan Nieder <jrnieder@gmail.com>
---
drivers/hid/usbhid/hiddev.c | 168 +++++++++++++++++++++++++++++++++----------
1 files changed, 131 insertions(+), 37 deletions(-)

diff --git a/drivers/hid/usbhid/hiddev.c b/drivers/hid/usbhid/hiddev.c
index cb3f35594bfa..b26ebcb23e8c 100644
--- a/drivers/hid/usbhid/hiddev.c
+++ b/drivers/hid/usbhid/hiddev.c
@@ -593,7 +593,7 @@ static long hiddev_ioctl(struct file *file, unsigned int cmd, unsigned long arg)
{
struct hiddev_list *list = file->private_data;
struct hiddev *hiddev = list->hiddev;
- struct hid_device *hid = hiddev->hid;
+ struct hid_device *hid;
struct usb_device *dev;
struct hiddev_collection_info cinfo;
struct hiddev_report_info rinfo;
@@ -601,26 +601,33 @@ static long hiddev_ioctl(struct file *file, unsigned int cmd, unsigned long arg)
struct hiddev_devinfo dinfo;
struct hid_report *report;
struct hid_field *field;
- struct usbhid_device *usbhid = hid->driver_data;
+ struct usbhid_device *usbhid;
void __user *user_arg = (void __user *)arg;
int i, r;
-
+
/* Called without BKL by compat methods so no BKL taken */

/* FIXME: Who or what stop this racing with a disconnect ?? */
- if (!hiddev->exist || !hid)
+ if (!hiddev->exist)
return -EIO;

- dev = hid_to_usb_dev(hid);
-
switch (cmd) {

case HIDIOCGVERSION:
return put_user(HID_VERSION, (int __user *)arg);

case HIDIOCAPPLICATION:
- if (arg < 0 || arg >= hid->maxapplication)
- return -EINVAL;
+ mutex_lock(&hiddev->existancelock);
+ if (!hiddev->exist) {
+ r = -ENODEV;
+ goto ret_unlock;
+ }
+
+ hid = hiddev->hid;
+ if (arg < 0 || arg >= hid->maxapplication) {
+ r = -EINVAL;
+ goto ret_unlock;
+ }

for (i = 0; i < hid->maxcollection; i++)
if (hid->collection[i].type ==
@@ -628,11 +635,22 @@ static long hiddev_ioctl(struct file *file, unsigned int cmd, unsigned long arg)
break;

if (i == hid->maxcollection)
- return -EINVAL;
-
- return hid->collection[i].usage;
+ r = -EINVAL;
+ else
+ r = hid->collection[i].usage;
+ goto ret_unlock;

case HIDIOCGDEVINFO:
+ mutex_lock(&hiddev->existancelock);
+ if (!hiddev->exist) {
+ r = -ENODEV;
+ goto ret_unlock;
+ }
+
+ hid = hiddev->hid;
+ dev = hid_to_usb_dev(hid);
+ usbhid = hid->driver_data;
+
dinfo.bustype = BUS_USB;
dinfo.busnum = dev->bus->busnum;
dinfo.devnum = dev->devnum;
@@ -641,6 +659,8 @@ static long hiddev_ioctl(struct file *file, unsigned int cmd, unsigned long arg)
dinfo.product = le16_to_cpu(dev->descriptor.idProduct);
dinfo.version = le16_to_cpu(dev->descriptor.bcdDevice);
dinfo.num_applications = hid->maxapplication;
+ mutex_unlock(&hiddev->existancelock);
+
if (copy_to_user(user_arg, &dinfo, sizeof(dinfo)))
return -EFAULT;

@@ -674,6 +694,7 @@ static long hiddev_ioctl(struct file *file, unsigned int cmd, unsigned long arg)
r = hiddev_ioctl_string(hiddev, cmd, user_arg);
else
r = -ENODEV;
+ret_unlock:
mutex_unlock(&hiddev->existancelock);
return r;

@@ -683,6 +704,7 @@ static long hiddev_ioctl(struct file *file, unsigned int cmd, unsigned long arg)
mutex_unlock(&hiddev->existancelock);
return -ENODEV;
}
+ hid = hiddev->hid;
usbhid_init_reports(hid);
mutex_unlock(&hiddev->existancelock);

@@ -695,14 +717,21 @@ static long hiddev_ioctl(struct file *file, unsigned int cmd, unsigned long arg)
if (rinfo.report_type == HID_REPORT_TYPE_OUTPUT)
return -EINVAL;

- if ((report = hiddev_lookup_report(hid, &rinfo)) == NULL)
- return -EINVAL;
-
mutex_lock(&hiddev->existancelock);
- if (hiddev->exist) {
- usbhid_submit_report(hid, report, USB_DIR_IN);
- usbhid_wait_io(hid);
+ if (!hiddev->exist) {
+ r = -ENODEV;
+ goto ret_unlock;
}
+
+ hid = hiddev->hid;
+ report = hiddev_lookup_report(hid, &rinfo);
+ if (report == NULL) {
+ r = -EINVAL;
+ goto ret_unlock;
+ }
+
+ usbhid_submit_report(hid, report, USB_DIR_IN);
+ usbhid_wait_io(hid);
mutex_unlock(&hiddev->existancelock);

return 0;
@@ -714,14 +743,21 @@ static long hiddev_ioctl(struct file *file, unsigned int cmd, unsigned long arg)
if (rinfo.report_type == HID_REPORT_TYPE_INPUT)
return -EINVAL;

- if ((report = hiddev_lookup_report(hid, &rinfo)) == NULL)
- return -EINVAL;
-
mutex_lock(&hiddev->existancelock);
- if (hiddev->exist) {
- usbhid_submit_report(hid, report, USB_DIR_OUT);
- usbhid_wait_io(hid);
+ if (!hiddev->exist) {
+ r = -ENODEV;
+ goto ret_unlock;
}
+
+ hid = hiddev->hid;
+ report = hiddev_lookup_report(hid, &rinfo);
+ if (report == NULL) {
+ r = -EINVAL;
+ goto ret_unlock;
+ }
+
+ usbhid_submit_report(hid, report, USB_DIR_OUT);
+ usbhid_wait_io(hid);
mutex_unlock(&hiddev->existancelock);

return 0;
@@ -730,10 +766,21 @@ static long hiddev_ioctl(struct file *file, unsigned int cmd, unsigned long arg)
if (copy_from_user(&rinfo, user_arg, sizeof(rinfo)))
return -EFAULT;

- if ((report = hiddev_lookup_report(hid, &rinfo)) == NULL)
- return -EINVAL;
+ mutex_lock(&hiddev->existancelock);
+ if (!hiddev->exist) {
+ r = -ENODEV;
+ goto ret_unlock;
+ }
+
+ hid = hiddev->hid;
+ report = hiddev_lookup_report(hid, &rinfo);
+ if (report == NULL) {
+ r = -EINVAL;
+ goto ret_unlock;
+ }

rinfo.num_fields = report->maxfield;
+ mutex_unlock(&hiddev->existancelock);

if (copy_to_user(user_arg, &rinfo, sizeof(rinfo)))
return -EFAULT;
@@ -745,11 +792,23 @@ static long hiddev_ioctl(struct file *file, unsigned int cmd, unsigned long arg)
return -EFAULT;
rinfo.report_type = finfo.report_type;
rinfo.report_id = finfo.report_id;
- if ((report = hiddev_lookup_report(hid, &rinfo)) == NULL)
- return -EINVAL;
+ mutex_lock(&hiddev->existancelock);
+ if (!hiddev->exist) {
+ r = -ENODEV;
+ goto ret_unlock;
+ }

- if (finfo.field_index >= report->maxfield)
- return -EINVAL;
+ hid = hiddev->hid;
+ report = hiddev_lookup_report(hid, &rinfo);
+ if (report == NULL) {
+ r = -EINVAL;
+ goto ret_unlock;
+ }
+
+ if (finfo.field_index >= report->maxfield) {
+ r = -EINVAL;
+ goto ret_unlock;
+ }

field = report->field[finfo.field_index];
memset(&finfo, 0, sizeof(finfo));
@@ -767,6 +826,7 @@ static long hiddev_ioctl(struct file *file, unsigned int cmd, unsigned long arg)
finfo.physical_maximum = field->physical_maximum;
finfo.unit_exponent = field->unit_exponent;
finfo.unit = field->unit;
+ mutex_unlock(&hiddev->existancelock);

if (copy_to_user(user_arg, &finfo, sizeof(finfo)))
return -EFAULT;
@@ -792,12 +852,22 @@ static long hiddev_ioctl(struct file *file, unsigned int cmd, unsigned long arg)
if (copy_from_user(&cinfo, user_arg, sizeof(cinfo)))
return -EFAULT;

- if (cinfo.index >= hid->maxcollection)
- return -EINVAL;
+ mutex_lock(&hiddev->existancelock);
+ if (!hiddev->exist) {
+ r = -ENODEV;
+ goto ret_unlock;
+ }
+
+ hid = hiddev->hid;
+ if (cinfo.index >= hid->maxcollection) {
+ r = -EINVAL;
+ goto ret_unlock;
+ }

cinfo.type = hid->collection[cinfo.index].type;
cinfo.usage = hid->collection[cinfo.index].usage;
cinfo.level = hid->collection[cinfo.index].level;
+ mutex_lock(&hiddev->existancelock);

if (copy_to_user(user_arg, &cinfo, sizeof(cinfo)))
return -EFAULT;
@@ -810,24 +880,48 @@ static long hiddev_ioctl(struct file *file, unsigned int cmd, unsigned long arg)

if (_IOC_NR(cmd) == _IOC_NR(HIDIOCGNAME(0))) {
int len;
- if (!hid->name)
- return 0;
+
+ mutex_lock(&hiddev->existancelock);
+ if (!hiddev->exist) {
+ r = -ENODEV;
+ goto ret_unlock;
+ }
+
+ hid = hiddev->hid;
+ if (!hid->name) {
+ r = 0;
+ goto ret_unlock;
+ }
+
len = strlen(hid->name) + 1;
if (len > _IOC_SIZE(cmd))
len = _IOC_SIZE(cmd);
- return copy_to_user(user_arg, hid->name, len) ?
+ r = copy_to_user(user_arg, hid->name, len) ?
-EFAULT : len;
+ goto ret_unlock;
}

if (_IOC_NR(cmd) == _IOC_NR(HIDIOCGPHYS(0))) {
int len;
- if (!hid->phys)
- return 0;
+
+ mutex_lock(&hiddev->existancelock);
+ if (!hiddev->exist) {
+ r = -ENODEV;
+ goto ret_unlock;
+ }
+
+ hid = hiddev->hid;
+ if (!hid->phys) {
+ r = 0;
+ goto ret_unlock;
+ }
+
len = strlen(hid->phys) + 1;
if (len > _IOC_SIZE(cmd))
len = _IOC_SIZE(cmd);
- return copy_to_user(user_arg, hid->phys, len) ?
+ r = copy_to_user(user_arg, hid->phys, len) ?
-EFAULT : len;
+ goto ret_unlock;
}
}
return -EINVAL;
--
1.7.8.rc3

From: Valentine Barshak <vbarshak@mvista.com>
Date: Mon, 6 Dec 2010 18:16:11 +0300
Subject: HID: Consolidate device existence checks in hiddev_ioctl

commit 33d6eb570b1f3fe5ba93cef465c5be66535c2c9a upstream

Currently, if the device has been removed before hiddev_ioctl(),
the -EIO is returned. If it's removed while hiddev_ioctl() is in
progress, some commands are still processed fine, others
return -ENODEV. This change takes the "existancelock" before
processing ioctl commands and releases it at the end.
If the device has been removed, always returns -ENODEV.

Signed-off-by: Valentine Barshak <vbarshak@mvista.com>
Signed-off-by: Jiri Kosina <jkosina@suse.cz>
Signed-off-by: Jonathan Nieder <jrnieder@gmail.com>
---
drivers/hid/usbhid/hiddev.c | 287 +++++++++++++++---------------------------
1 files changed, 103 insertions(+), 184 deletions(-)

diff --git a/drivers/hid/usbhid/hiddev.c b/drivers/hid/usbhid/hiddev.c
index b26ebcb23e8c..f4e9200b02fc 100644
--- a/drivers/hid/usbhid/hiddev.c
+++ b/drivers/hid/usbhid/hiddev.c
@@ -594,221 +594,167 @@ static long hiddev_ioctl(struct file *file, unsigned int cmd, unsigned long arg)
struct hiddev_list *list = file->private_data;
struct hiddev *hiddev = list->hiddev;
struct hid_device *hid;
- struct usb_device *dev;
struct hiddev_collection_info cinfo;
struct hiddev_report_info rinfo;
struct hiddev_field_info finfo;
struct hiddev_devinfo dinfo;
struct hid_report *report;
struct hid_field *field;
- struct usbhid_device *usbhid;
void __user *user_arg = (void __user *)arg;
- int i, r;
+ int i, r = -EINVAL;

/* Called without BKL by compat methods so no BKL taken */

- /* FIXME: Who or what stop this racing with a disconnect ?? */
- if (!hiddev->exist)
- return -EIO;
+ mutex_lock(&hiddev->existancelock);
+ if (!hiddev->exist) {
+ r = -ENODEV;
+ goto ret_unlock;
+ }
+
+ hid = hiddev->hid;

switch (cmd) {

case HIDIOCGVERSION:
- return put_user(HID_VERSION, (int __user *)arg);
+ r = put_user(HID_VERSION, (int __user *)arg) ?
+ -EFAULT : 0;
+ break;

case HIDIOCAPPLICATION:
- mutex_lock(&hiddev->existancelock);
- if (!hiddev->exist) {
- r = -ENODEV;
- goto ret_unlock;
- }
-
- hid = hiddev->hid;
- if (arg < 0 || arg >= hid->maxapplication) {
- r = -EINVAL;
- goto ret_unlock;
- }
+ if (arg < 0 || arg >= hid->maxapplication)
+ break;

for (i = 0; i < hid->maxcollection; i++)
if (hid->collection[i].type ==
HID_COLLECTION_APPLICATION && arg-- == 0)
break;

- if (i == hid->maxcollection)
- r = -EINVAL;
- else
+ if (i < hid->maxcollection)
r = hid->collection[i].usage;
- goto ret_unlock;
+ break;

case HIDIOCGDEVINFO:
- mutex_lock(&hiddev->existancelock);
- if (!hiddev->exist) {
- r = -ENODEV;
- goto ret_unlock;
+ {
+ struct usb_device *dev = hid_to_usb_dev(hid);
+ struct usbhid_device *usbhid = hid->driver_data;
+
+ dinfo.bustype = BUS_USB;
+ dinfo.busnum = dev->bus->busnum;
+ dinfo.devnum = dev->devnum;
+ dinfo.ifnum = usbhid->ifnum;
+ dinfo.vendor = le16_to_cpu(dev->descriptor.idVendor);
+ dinfo.product = le16_to_cpu(dev->descriptor.idProduct);
+ dinfo.version = le16_to_cpu(dev->descriptor.bcdDevice);
+ dinfo.num_applications = hid->maxapplication;
+
+ r = copy_to_user(user_arg, &dinfo, sizeof(dinfo)) ?
+ -EFAULT : 0;
+ break;
}

- hid = hiddev->hid;
- dev = hid_to_usb_dev(hid);
- usbhid = hid->driver_data;
-
- dinfo.bustype = BUS_USB;
- dinfo.busnum = dev->bus->busnum;
- dinfo.devnum = dev->devnum;
- dinfo.ifnum = usbhid->ifnum;
- dinfo.vendor = le16_to_cpu(dev->descriptor.idVendor);
- dinfo.product = le16_to_cpu(dev->descriptor.idProduct);
- dinfo.version = le16_to_cpu(dev->descriptor.bcdDevice);
- dinfo.num_applications = hid->maxapplication;
- mutex_unlock(&hiddev->existancelock);
-
- if (copy_to_user(user_arg, &dinfo, sizeof(dinfo)))
- return -EFAULT;
-
- return 0;
-
case HIDIOCGFLAG:
- if (put_user(list->flags, (int __user *)arg))
- return -EFAULT;
-
- return 0;
+ r = put_user(list->flags, (int __user *)arg) ?
+ -EFAULT : 0;
+ break;

case HIDIOCSFLAG:
{
int newflags;
- if (get_user(newflags, (int __user *)arg))
- return -EFAULT;
+
+ if (get_user(newflags, (int __user *)arg)) {
+ r = -EFAULT;
+ break;
+ }

if ((newflags & ~HIDDEV_FLAGS) != 0 ||
((newflags & HIDDEV_FLAG_REPORT) != 0 &&
(newflags & HIDDEV_FLAG_UREF) == 0))
- return -EINVAL;
+ break;

list->flags = newflags;

- return 0;
+ r = 0;
+ break;
}

case HIDIOCGSTRING:
- mutex_lock(&hiddev->existancelock);
- if (hiddev->exist)
- r = hiddev_ioctl_string(hiddev, cmd, user_arg);
- else
- r = -ENODEV;
-ret_unlock:
- mutex_unlock(&hiddev->existancelock);
- return r;
+ r = hiddev_ioctl_string(hiddev, cmd, user_arg);
+ break;

case HIDIOCINITREPORT:
- mutex_lock(&hiddev->existancelock);
- if (!hiddev->exist) {
- mutex_unlock(&hiddev->existancelock);
- return -ENODEV;
- }
- hid = hiddev->hid;
usbhid_init_reports(hid);
- mutex_unlock(&hiddev->existancelock);
-
- return 0;
+ r = 0;
+ break;

case HIDIOCGREPORT:
- if (copy_from_user(&rinfo, user_arg, sizeof(rinfo)))
- return -EFAULT;
+ if (copy_from_user(&rinfo, user_arg, sizeof(rinfo))) {
+ r = -EFAULT;
+ break;
+ }

if (rinfo.report_type == HID_REPORT_TYPE_OUTPUT)
- return -EINVAL;
+ break;

- mutex_lock(&hiddev->existancelock);
- if (!hiddev->exist) {
- r = -ENODEV;
- goto ret_unlock;
- }
-
- hid = hiddev->hid;
report = hiddev_lookup_report(hid, &rinfo);
- if (report == NULL) {
- r = -EINVAL;
- goto ret_unlock;
- }
+ if (report == NULL)
+ break;

usbhid_submit_report(hid, report, USB_DIR_IN);
usbhid_wait_io(hid);
- mutex_unlock(&hiddev->existancelock);

- return 0;
+ r = 0;
+ break;

case HIDIOCSREPORT:
- if (copy_from_user(&rinfo, user_arg, sizeof(rinfo)))
- return -EFAULT;
+ if (copy_from_user(&rinfo, user_arg, sizeof(rinfo))) {
+ r = -EFAULT;
+ break;
+ }

if (rinfo.report_type == HID_REPORT_TYPE_INPUT)
- return -EINVAL;
+ break;

- mutex_lock(&hiddev->existancelock);
- if (!hiddev->exist) {
- r = -ENODEV;
- goto ret_unlock;
- }
-
- hid = hiddev->hid;
report = hiddev_lookup_report(hid, &rinfo);
- if (report == NULL) {
- r = -EINVAL;
- goto ret_unlock;
- }
+ if (report == NULL)
+ break;

usbhid_submit_report(hid, report, USB_DIR_OUT);
usbhid_wait_io(hid);
- mutex_unlock(&hiddev->existancelock);

- return 0;
+ r = 0;
+ break;

case HIDIOCGREPORTINFO:
- if (copy_from_user(&rinfo, user_arg, sizeof(rinfo)))
- return -EFAULT;
-
- mutex_lock(&hiddev->existancelock);
- if (!hiddev->exist) {
- r = -ENODEV;
- goto ret_unlock;
+ if (copy_from_user(&rinfo, user_arg, sizeof(rinfo))) {
+ r = -EFAULT;
+ break;
}

- hid = hiddev->hid;
report = hiddev_lookup_report(hid, &rinfo);
- if (report == NULL) {
- r = -EINVAL;
- goto ret_unlock;
- }
+ if (report == NULL)
+ break;

rinfo.num_fields = report->maxfield;
- mutex_unlock(&hiddev->existancelock);

- if (copy_to_user(user_arg, &rinfo, sizeof(rinfo)))
- return -EFAULT;
-
- return 0;
+ r = copy_to_user(user_arg, &rinfo, sizeof(rinfo)) ?
+ -EFAULT : 0;
+ break;

case HIDIOCGFIELDINFO:
- if (copy_from_user(&finfo, user_arg, sizeof(finfo)))
- return -EFAULT;
+ if (copy_from_user(&finfo, user_arg, sizeof(finfo))) {
+ r = -EFAULT;
+ break;
+ }
+
rinfo.report_type = finfo.report_type;
rinfo.report_id = finfo.report_id;
- mutex_lock(&hiddev->existancelock);
- if (!hiddev->exist) {
- r = -ENODEV;
- goto ret_unlock;
- }

- hid = hiddev->hid;
report = hiddev_lookup_report(hid, &rinfo);
- if (report == NULL) {
- r = -EINVAL;
- goto ret_unlock;
- }
+ if (report == NULL)
+ break;

- if (finfo.field_index >= report->maxfield) {
- r = -EINVAL;
- goto ret_unlock;
- }
+ if (finfo.field_index >= report->maxfield)
+ break;

field = report->field[finfo.field_index];
memset(&finfo, 0, sizeof(finfo));
@@ -826,12 +772,10 @@ ret_unlock:
finfo.physical_maximum = field->physical_maximum;
finfo.unit_exponent = field->unit_exponent;
finfo.unit = field->unit;
- mutex_unlock(&hiddev->existancelock);

- if (copy_to_user(user_arg, &finfo, sizeof(finfo)))
- return -EFAULT;
-
- return 0;
+ r = copy_to_user(user_arg, &finfo, sizeof(finfo)) ?
+ -EFAULT : 0;
+ break;

case HIDIOCGUCODE:
/* fall through */
@@ -840,57 +784,36 @@ ret_unlock:
case HIDIOCGUSAGES:
case HIDIOCSUSAGES:
case HIDIOCGCOLLECTIONINDEX:
- mutex_lock(&hiddev->existancelock);
- if (hiddev->exist)
- r = hiddev_ioctl_usage(hiddev, cmd, user_arg);
- else
- r = -ENODEV;
- mutex_unlock(&hiddev->existancelock);
- return r;
+ r = hiddev_ioctl_usage(hiddev, cmd, user_arg);
+ break;

case HIDIOCGCOLLECTIONINFO:
- if (copy_from_user(&cinfo, user_arg, sizeof(cinfo)))
- return -EFAULT;
-
- mutex_lock(&hiddev->existancelock);
- if (!hiddev->exist) {
- r = -ENODEV;
- goto ret_unlock;
+ if (copy_from_user(&cinfo, user_arg, sizeof(cinfo))) {
+ r = -EFAULT;
+ break;
}

- hid = hiddev->hid;
- if (cinfo.index >= hid->maxcollection) {
- r = -EINVAL;
- goto ret_unlock;
- }
+ if (cinfo.index >= hid->maxcollection)
+ break;

cinfo.type = hid->collection[cinfo.index].type;
cinfo.usage = hid->collection[cinfo.index].usage;
cinfo.level = hid->collection[cinfo.index].level;
- mutex_lock(&hiddev->existancelock);

- if (copy_to_user(user_arg, &cinfo, sizeof(cinfo)))
- return -EFAULT;
- return 0;
+ r = copy_to_user(user_arg, &cinfo, sizeof(cinfo)) ?
+ -EFAULT : 0;
+ break;

default:
-
if (_IOC_TYPE(cmd) != 'H' || _IOC_DIR(cmd) != _IOC_READ)
- return -EINVAL;
+ break;

if (_IOC_NR(cmd) == _IOC_NR(HIDIOCGNAME(0))) {
int len;

- mutex_lock(&hiddev->existancelock);
- if (!hiddev->exist) {
- r = -ENODEV;
- goto ret_unlock;
- }
-
- hid = hiddev->hid;
if (!hid->name) {
r = 0;
- goto ret_unlock;
+ break;
}

len = strlen(hid->name) + 1;
@@ -898,22 +821,15 @@ ret_unlock:
len = _IOC_SIZE(cmd);
r = copy_to_user(user_arg, hid->name, len) ?
-EFAULT : len;
- goto ret_unlock;
+ break;
}

if (_IOC_NR(cmd) == _IOC_NR(HIDIOCGPHYS(0))) {
int len;

- mutex_lock(&hiddev->existancelock);
- if (!hiddev->exist) {
- r = -ENODEV;
- goto ret_unlock;
- }
-
- hid = hiddev->hid;
if (!hid->phys) {
r = 0;
- goto ret_unlock;
+ break;
}

len = strlen(hid->phys) + 1;
@@ -921,10 +837,13 @@ ret_unlock:
len = _IOC_SIZE(cmd);
r = copy_to_user(user_arg, hid->phys, len) ?
-EFAULT : len;
- goto ret_unlock;
+ break;
}
}
- return -EINVAL;
+
+ret_unlock:
+ mutex_unlock(&hiddev->existancelock);
+ return r;
}

#ifdef CONFIG_COMPAT
--
1.7.8.rc3

From: Jiri Kosina <jkosina@suse.cz>
Date: Fri, 20 May 2011 10:50:13 +0200
Subject: HID: hiddev: fix race between hiddev_disconnect and hiddev_release

commit 6cb4b040795c555c7ab4b1ba29b0dba2b5a42beb upstream

When hiddev_disconnect() runs with chardev open, it will proceed with
usbhid_close(). When userspace in parallel runs the hiddev_release(),
it sees !hiddev->exists (as it has been already set so by
hiddev_disconnect()) and kfrees hiddev while hiddev_disconnect() hasn't
finished yet.

Serialize the access to hiddev->exists and hiddev->open by existancelock.

Reported-by: mike-@cinci.rr.com
Signed-off-by: Jiri Kosina <jkosina@suse.cz>
Signed-off-by: Jonathan Nieder <jrnieder@gmail.com>
---
drivers/hid/usbhid/hiddev.c | 10 ++++++++--
1 files changed, 8 insertions(+), 2 deletions(-)

diff --git a/drivers/hid/usbhid/hiddev.c b/drivers/hid/usbhid/hiddev.c
index f4e9200b02fc..d89368a7533c 100644
--- a/drivers/hid/usbhid/hiddev.c
+++ b/drivers/hid/usbhid/hiddev.c
@@ -245,6 +245,7 @@ static int hiddev_release(struct inode * inode, struct file * file)
list_del(&list->node);
spin_unlock_irqrestore(&list->hiddev->list_lock, flags);

+ mutex_lock(&list->hiddev->existancelock);
if (!--list->hiddev->open) {
if (list->hiddev->exist) {
usbhid_close(list->hiddev->hid);
@@ -255,6 +256,7 @@ static int hiddev_release(struct inode * inode, struct file * file)
}

kfree(list);
+ mutex_unlock(&list->hiddev->existancelock);

return 0;
}
@@ -302,18 +304,22 @@ static int hiddev_open(struct inode *inode, struct file *file)
list_add_tail(&list->node, &hiddev_table[i]->list);
spin_unlock_irq(&list->hiddev->list_lock);

+ mutex_lock(&list->hiddev->existancelock);
if (!list->hiddev->open++)
if (list->hiddev->exist) {
struct hid_device *hid = hiddev_table[i]->hid;
res = usbhid_get_power(hid);
if (res < 0) {
res = -EIO;
- goto bail;
+ goto bail_unlock;
}
usbhid_open(hid);
}
+ mutex_unlock(&list->hiddev->existancelock);

return 0;
+bail_unlock:
+ mutex_unlock(&list->hiddev->existancelock);
bail:
file->private_data = NULL;
kfree(list);
@@ -942,7 +948,6 @@ void hiddev_disconnect(struct hid_device *hid)

mutex_lock(&hiddev->existancelock);
hiddev->exist = 0;
- mutex_unlock(&hiddev->existancelock);

hiddev_table[hiddev->hid->minor - HIDDEV_MINOR_BASE] = NULL;
usb_deregister_dev(usbhid->intf, &hiddev_class);
@@ -953,6 +958,7 @@ void hiddev_disconnect(struct hid_device *hid)
} else {
kfree(hiddev);
}
+ mutex_unlock(&hiddev->existancelock);
}

/* Currently this driver is a USB driver. It's not a conventional one in
--
1.7.8.rc3

From: Jiri Kosina <jkosina@suse.cz>
Date: Tue, 24 May 2011 11:43:18 +0200
Subject: HID: hiddev: fix potential use-after-free

commit 7f77897ef2b6a5ee4eb8bc24fe8b1f3eab254328 upstream

Commit 6cb4b040795 ("HID: hiddev: fix race between hiddev_disconnect
and hiddev_release") made it possible to access hiddev (for unlocking
the existance mutex) once hiddev has been kfreed.

Change the order so that this can not happen (always unlock the mutex first,
it is needed only to protect access to ->exist and ->open).

Signed-off-by: Jiri Kosina <jkosina@suse.cz>
Signed-off-by: Jonathan Nieder <jrnieder@gmail.com>
---
drivers/hid/usbhid/hiddev.c | 3 ++-
1 files changed, 2 insertions(+), 1 deletions(-)

diff --git a/drivers/hid/usbhid/hiddev.c b/drivers/hid/usbhid/hiddev.c
index d89368a7533c..c6efd3c20145 100644
--- a/drivers/hid/usbhid/hiddev.c
+++ b/drivers/hid/usbhid/hiddev.c
@@ -953,12 +953,13 @@ void hiddev_disconnect(struct hid_device *hid)
usb_deregister_dev(usbhid->intf, &hiddev_class);

if (hiddev->open) {
+ mutex_unlock(&hiddev->existancelock);
usbhid_close(hiddev->hid);
wake_up_interruptible(&hiddev->wait);
} else {
+ mutex_unlock(&hiddev->existancelock);
kfree(hiddev);
}
- mutex_unlock(&hiddev->existancelock);
}

/* Currently this driver is a USB driver. It's not a conventional one in
--
1.7.8.rc3

From: Dan Carpenter <error27@gmail.com>
Date: Thu, 26 May 2011 11:49:16 +0300
Subject: HID: hiddev: fix use after free in hiddev_release

commit 5c699d7d3f94ee1dd934edea889b32f8279a4e65 upstream

There are a couple use after free bugs here.

Signed-off-by: Dan Carpenter <error27@gmail.com>
[jkosina@suse.cz: removed already fixed hunk]
Signed-off-by: Jiri Kosina <jkosina@suse.cz>
Signed-off-by: Jonathan Nieder <jrnieder@gmail.com>
---
drivers/hid/usbhid/hiddev.c | 5 ++++-
1 files changed, 4 insertions(+), 1 deletions(-)

diff --git a/drivers/hid/usbhid/hiddev.c b/drivers/hid/usbhid/hiddev.c
index c6efd3c20145..b4b87e831f14 100644
--- a/drivers/hid/usbhid/hiddev.c
+++ b/drivers/hid/usbhid/hiddev.c
@@ -251,12 +251,15 @@ static int hiddev_release(struct inode * inode, struct file * file)
usbhid_close(list->hiddev->hid);
usbhid_put_power(list->hiddev->hid);
} else {
+ mutex_unlock(&list->hiddev->existancelock);
kfree(list->hiddev);
+ kfree(list);
+ return 0;
}
}

- kfree(list);
mutex_unlock(&list->hiddev->existancelock);
+ kfree(list);

return 0;
}
--
1.7.8.rc3

Steven Chamberlain 04-04-2012 10:25 PM

Bug#631287: BUG during access to hiddev (APC UPS)
 
On 04/04/12 23:00, Jonathan Nieder wrote:
> While I have your attention: does the patch series in #631287 seem to
> prevent the BUG as advertised without any noticeable unpleasant
> side-effects? How long have you been testing it?

I've been running a 2.6.32-41 kernel with those patches for 8 days, but
all I can say is that I haven't noticed any *new* issues.


My USB-attached APC UPS is working exactly as before, although still
affected by #409349 (control queue full).

I have never experienced the #631287 BUG to date, so I can't say if the
patches really made an improvement. I would plug/unplug the UPS a few
times to check for this, except:

> USER PID %CPU %MEM VSZ RSS TTY STAT START TIME COMMAND
> root 1068 0.0 0.0 0 0 ? D Mar28 0:00 [khubd]
> root 8488 0.0 0.0 12704 220 ? Ds Mar29 0:00 /sbin/apcupsd

I've not rebooted since the last time I last experienced #409349, and it
seems the UPS was not even detected when I plugged it back in just now.


Sometime, perhaps in a few weeks when this box is retired from
production use, I should repeatedly plug/unplug the UPS:

* on an unpatched kernel, to make sure my specific hardware was affected
in the first place
* on the patched kernel, to make sure the patches have really fixed it

Regards,
--
Steven Chamberlain
steven@pyro.eu.org



--
To UNSUBSCRIBE, email to debian-kernel-REQUEST@lists.debian.org
with a subject of "unsubscribe". Trouble? Contact listmaster@lists.debian.org
Archive: 4F7CCA70.1030207@pyro.eu.org">http://lists.debian.org/4F7CCA70.1030207@pyro.eu.org

Jonathan Nieder 04-04-2012 11:37 PM

Bug#631287: BUG during access to hiddev (APC UPS)
 
Steven Chamberlain wrote:

> I've been running a 2.6.32-41 kernel with those patches for 8 days, but
> all I can say is that I haven't noticed any *new* issues.
>
> My USB-attached APC UPS is working exactly as before, although still
> affected by #409349 (control queue full).
>
> I have never experienced the #631287 BUG to date, so I can't say if the
> patches really made an improvement.

Thanks much for testing. Very useful.

> I would plug/unplug the UPS a few
> times to check for this, except:

No problem. (Hopefully someone who experienced the problem might
report back, or if not, we might apply the patches anyway after
reading the code more carefully.)

Ciao,
Jonathan



--
To UNSUBSCRIBE, email to debian-kernel-REQUEST@lists.debian.org
with a subject of "unsubscribe". Trouble? Contact listmaster@lists.debian.org
Archive: 20120404233754.GH17985@burratino">http://lists.debian.org/20120404233754.GH17985@burratino


All times are GMT. The time now is 06:44 PM.

VBulletin, Copyright ©2000 - 2014, Jelsoft Enterprises Ltd.
Content Relevant URLs by vBSEO ©2007, Crawlability, Inc.