* BUG: physmap modprobe & rmmod
@ 2010-04-02 20:40 Randy Dunlap
2010-04-02 21:47 ` Randy Dunlap
0 siblings, 1 reply; 5+ messages in thread
From: Randy Dunlap @ 2010-04-02 20:40 UTC (permalink / raw)
To: lkml; +Cc: David Woodhouse, linux-mtd
[-- Attachment #1: Type: text/plain, Size: 4297 bytes --]
2.6.34-rc2 kernel:
Boot up on a common PC, then: modprobe physmap ; rmmod physmap
and bang.
[ 127.836202] calling init_mtd+0x0/0x88 [mtd] @ 3566
[ 127.841742] initcall init_mtd+0x0/0x88 [mtd] returned 0 after 514 usecs
[ 127.863465] calling physmap_init+0x0/0x49 [physmap] @ 3566
[ 127.869454] physmap-flash.0: failed to claim resource 0
[ 127.874760] initcall physmap_init+0x0/0x49 [physmap] returned 0 after 5450 usecs
[ 150.353495] BUG: unable to handle kernel NULL pointer dereference at 0000000000000008
[ 150.354142] IP: [<ffffffff8137c655>] device_pm_remove+0xcb/0xff
[ 150.354142] PGD 6d931067 PUD 6da98067 PMD 0
[ 150.354142] Oops: 0002 [#1] SMP
[ 150.354142] last sysfs file: /sys/devices/pci0000:00/0000:00:1d.1/usb3/3-1/3-1.3/devnum
[ 150.354142] CPU 1
[ 150.354142] Modules linked in: physmap(-) mtd chipreg map_funcs ipt_MASQUERADE iptable_nat nf_nat nfsd sco bridge lockd nfs_acl stp auth_rpcgss llc exportfs bnep l2cap crc16 bluetooth rfkill sunrpc ipt_REJECT nf_conntrack_ipv4 nf_defrag_ipv4 iptable_filter ip_tables ip6t_REJECT xt_tcpudp nf_conntrack_ipv6 xt_state nf_conntrack ip6table_filter ip6_tables x_tables ipv6 p4_clockmod freq_table speedstep_lib dm_mirror dm_region_hash dm_log dm_multipath scsi_dh dm_mod kvm uinput snd_intel8x0 joydev snd_ac97_codec ac97_bus snd_seq snd_seq_device usbhid snd_pcm snd_timer led_class snd psmouse iTCO_wdt i2c_i801 rtc_cmos iTCO_vendor_support evdev ppdev parport_pc serio_raw parport sg rtc_core i2c_core rtc_lib pcspkr soundcore snd_page_alloc rng_core button thermal intel_agp thermal_sys agpgart hwmon sr_mod cdrom dcdbas ata_generic pata_acpi ata_piix libata ide_pci_generic ide_core sd_mod scsi_mod crc_t10dif ext3 jbd mbcache uhci_hcd ohci_hcd ssb mmc_core pcmcia pcmcia_core ehci_hcd!
usbcore nls_base [last unloaded: processor]
[ 150.354142]
[ 150.354142] Pid: 3575, comm: rmmod Not tainted 2.6.34-rc2 #2 0HH807/OptiPlex GX620
[ 150.354142] RIP: 0010:[<ffffffff8137c655>] [<ffffffff8137c655>] device_pm_remove+0xcb/0xff
[ 150.354142] RSP: 0018:ffff88006d96de48 EFLAGS: 00010202
[ 150.354142] RAX: ffffffffa02f8960 RBX: ffffffffa02f8880 RCX: 0000000000000000
[ 150.354142] RDX: 0000000000000000 RSI: ffffffff81ab6940 RDI: ffffffff81ab6940
[ 150.354142] RBP: ffff88006d96de58 R08: 0000000000000001 R09: 0000000000000000
[ 150.354142] R10: ffffffff81ab69b0 R11: 0000000000000000 R12: ffffffff81ab5b00
[ 150.354142] R13: 00007ffff41a5f60 R14: 0000000000000000 R15: 0000000000000001
[ 150.354142] FS: 00007f05a3e8c6f0(0000) GS:ffff880005600000(0000) knlGS:0000000000000000
[ 150.354142] CS: 0010 DS: 0000 ES: 0000 CR0: 000000008005003b
[ 150.354142] CR2: 0000000000000008 CR3: 000000007b21d000 CR4: 00000000000006e0
[ 150.354142] DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000
[ 150.354142] DR3: 0000000000000000 DR6: 00000000ffff0ff0 DR7: 0000000000000400
[ 150.354142] Process rmmod (pid: 3575, threadinfo ffff88006d96c000, task ffff88006daa8000)
[ 150.354142] Stack:
[ 150.354142] ffff88006d96de58 ffffffffa02f8880 ffff88006d96de88 ffffffff8136f54f
[ 150.354142] <0> 0000000000000000 0000000000000000 ffffffffa02f8870 00007ffff41a5f60
[ 150.354142] <0> ffff88006d96dea8 ffffffff813765b5 ffffffffa02f8870 0000000000000000
[ 150.354142] Call Trace:
[ 150.354142] [<ffffffff8136f54f>] device_del+0x59/0x24e
[ 150.354142] [<ffffffff813765b5>] platform_device_del+0x2d/0x89
[ 150.354142] [<ffffffff81376dbf>] platform_device_unregister+0x1d/0x37
[ 150.354142] [<ffffffffa02f8604>] physmap_exit+0x1c/0x38 [physmap]
[ 150.354142] [<ffffffff810b38f2>] sys_delete_module+0x2cd/0x391
[ 150.354142] [<ffffffff814d24a7>] ? lockdep_sys_exit_thunk+0x35/0x67
[ 150.354142] [<ffffffff810dd36a>] ? audit_syscall_entry+0x172/0x1a5
[ 150.354142] [<ffffffff8100c6f2>] system_call_fastpath+0x16/0x1b
[ 150.354142] Code: 33 59 01 e8 c4 49 15 00 48 ff 05 9f 33 59 01 48 8d 83 e0 00 00 00 48 c7 c7 40 69 ab 81 48 8b 8b e0 00 00 00 48 8b 93 e8 00 00 00 <48> 89 51 08 48 89 0a 48 89 83 e8 00 00 00 48 89 83 e0 00 00 00
[ 150.354142] RIP [<ffffffff8137c655>] device_pm_remove+0xcb/0xff
[ 150.354142] RSP <ffff88006d96de48>
[ 150.354142] CR2: 0000000000000008
[ 150.800000] ---[ end trace 9a6eaeb4fd0889df ]---
Full kernel log attached.
---
~Randy
[-- Attachment #2: physmap.log --]
[-- Type: application/octet-stream, Size: 116525 bytes --]
[ 0.000000] Initializing cgroup subsys cpuset
[ 0.000000] Linux version 2.6.34-rc2 (rdunlap@control.site) (gcc version 4.4.1 20090725 (Red Hat 4.4.1-2) (GCC) ) #2 SMP Wed Mar 24 16:26:38 PDT 2010
[ 0.000000] Command line: ro root=/dev/sda6 selinux=0 debug ignore_loglevel initcall_debug printk.time=1 print_fatal_signals=1 kern=2634rc2 console=ttyS0,115200n8 console=tty0
[ 0.000000] BIOS-provided physical RAM map:
[ 0.000000] BIOS-e820: 0000000000000000 - 00000000000a0000 (usable)
[ 0.000000] BIOS-e820: 00000000000f0000 - 0000000000100000 (reserved)
[ 0.000000] BIOS-e820: 0000000000100000 - 000000007f686c00 (usable)
[ 0.000000] BIOS-e820: 000000007f686c00 - 000000007f688c00 (ACPI NVS)
[ 0.000000] BIOS-e820: 000000007f688c00 - 000000007f68ac00 (ACPI data)
[ 0.000000] BIOS-e820: 000000007f68ac00 - 0000000080000000 (reserved)
[ 0.000000] BIOS-e820: 00000000f0000000 - 00000000f4000000 (reserved)
[ 0.000000] BIOS-e820: 00000000fec00000 - 00000000fed00400 (reserved)
[ 0.000000] BIOS-e820: 00000000fed20000 - 00000000feda0000 (reserved)
[ 0.000000] BIOS-e820: 00000000fee00000 - 00000000fef00000 (reserved)
[ 0.000000] BIOS-e820: 00000000ffb00000 - 0000000100000000 (reserved)
[ 0.000000] debug: ignoring loglevel setting.
[ 0.000000] NX (Execute Disable) protection: active
[ 0.000000] DMI 2.3 present.
[ 0.000000] e820 update range: 0000000000000000 - 0000000000001000 (usable) ==> (reserved)
[ 0.000000] e820 remove range: 00000000000a0000 - 0000000000100000 (usable)
[ 0.000000] No AGP bridge found
[ 0.000000] last_pfn = 0x7f686 max_arch_pfn = 0x400000000
[ 0.000000] MTRR default type: uncachable
[ 0.000000] MTRR fixed ranges enabled:
[ 0.000000] 00000-9FFFF write-back
[ 0.000000] A0000-BFFFF uncachable
[ 0.000000] C0000-CFFFF write-protect
[ 0.000000] D0000-EFFFF uncachable
[ 0.000000] F0000-FFFFF write-protect
[ 0.000000] MTRR variable ranges enabled:
[ 0.000000] 0 base 000000000 mask F80000000 write-back
[ 0.000000] 1 base 07F800000 mask FFF800000 uncachable
[ 0.000000] 2 base 07F700000 mask FFFF00000 uncachable
[ 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] e820 update range: 0000000000001000 - 0000000000010000 (usable) ==> (reserved)
[ 0.000000] Scanning 1 areas for low memory corruption
[ 0.000000] modified physical RAM map:
[ 0.000000] modified: 0000000000000000 - 0000000000010000 (reserved)
[ 0.000000] modified: 0000000000010000 - 00000000000a0000 (usable)
[ 0.000000] modified: 00000000000f0000 - 0000000000100000 (reserved)
[ 0.000000] modified: 0000000000100000 - 000000007f686c00 (usable)
[ 0.000000] modified: 000000007f686c00 - 000000007f688c00 (ACPI NVS)
[ 0.000000] modified: 000000007f688c00 - 000000007f68ac00 (ACPI data)
[ 0.000000] modified: 000000007f68ac00 - 0000000080000000 (reserved)
[ 0.000000] modified: 00000000f0000000 - 00000000f4000000 (reserved)
[ 0.000000] modified: 00000000fec00000 - 00000000fed00400 (reserved)
[ 0.000000] modified: 00000000fed20000 - 00000000feda0000 (reserved)
[ 0.000000] modified: 00000000fee00000 - 00000000fef00000 (reserved)
[ 0.000000] modified: 00000000ffb00000 - 0000000100000000 (reserved)
[ 0.000000] initial memory mapped : 0 - 20000000
[ 0.000000] found SMP MP-table at [ffff8800000fe710] fe710
[ 0.000000] init_memory_mapping: 0000000000000000-000000007f686000
[ 0.000000] 0000000000 - 007f600000 page 2M
[ 0.000000] 007f600000 - 007f686000 page 4k
[ 0.000000] kernel direct mapping tables up to 7f686000 @ 16000-1a000
[ 0.000000] RAMDISK: 37c13000 - 37fefb72
[ 0.000000] ACPI: RSDP 00000000000feb00 00024 (v02 DELL )
[ 0.000000] ACPI: XSDT 00000000000fd24f 0005C (v01 DELL GX620 00000007 ASL 00000061)
[ 0.000000] ACPI: FACP 00000000000fd347 000F4 (v03 DELL GX620 00000007 ASL 00000061)
[ 0.000000] ACPI: DSDT 00000000fffd32f4 03D69 (v01 DELL dt_ex 00001000 INTL 20050309)
[ 0.000000] ACPI: FACS 000000007f686c00 00040
[ 0.000000] ACPI: SSDT 00000000fffd717c 000AA (v01 DELL st_ex 00001000 INTL 20050309)
[ 0.000000] ACPI: APIC 00000000000fd43b 00072 (v01 DELL GX620 00000007 ASL 00000061)
[ 0.000000] ACPI: BOOT 00000000000fd4ad 00028 (v01 DELL GX620 00000007 ASL 00000061)
[ 0.000000] ACPI: ASF! 00000000000fd4d5 00067 (v16 DELL GX620 00000007 ASL 00000061)
[ 0.000000] ACPI: MCFG 00000000000fd53c 0003E (v01 DELL GX620 00000007 ASL 00000061)
[ 0.000000] ACPI: HPET 00000000000fd57a 00038 (v01 DELL GX620 00000007 ASL 00000061)
[ 0.000000] ACPI: Local APIC address 0xfee00000
[ 0.000000] No NUMA configuration found
[ 0.000000] Faking a node at 0000000000000000-000000007f686000
[ 0.000000] Initmem setup node 0 0000000000000000-000000007f686000
[ 0.000000] NODE_DATA [00000000029a0240 - 00000000029b523f]
[ 0.000000] bootmap [00000000029b6000 - 00000000029c5ed7] pages 10
[ 0.000000] (13/32 early reservations) ==> bootmem [0000000000 - 007f686000]
[ 0.000000] #0 [0001000000 - 000299f780] TEXT DATA BSS ==> [0001000000 - 000299f780]
[ 0.000000] #1 [0037c13000 - 0037fefb72] RAMDISK ==> [0037c13000 - 0037fefb72]
[ 0.000000] #2 [00029a0000 - 00029a021c] BRK ==> [00029a0000 - 00029a021c]
[ 0.000000] #3 [00000fe720 - 0000100000] BIOS reserved ==> [00000fe720 - 0000100000]
[ 0.000000] #4 [00000fe710 - 00000fe720] MP-table mpf ==> [00000fe710 - 00000fe720]
[ 0.000000] #5 [000009fc00 - 00000f0000] BIOS reserved ==> [000009fc00 - 00000f0000]
[ 0.000000] #6 [00000f0284 - 00000fe710] BIOS reserved ==> [00000f0284 - 00000fe710]
[ 0.000000] #7 [00000f0000 - 00000f0284] MP-table mpc ==> [00000f0000 - 00000f0284]
[ 0.000000] #8 [0000010000 - 0000012000] TRAMPOLINE ==> [0000010000 - 0000012000]
[ 0.000000] #9 [0000012000 - 0000016000] ACPI WAKEUP ==> [0000012000 - 0000016000]
[ 0.000000] #10 [0000016000 - 0000018000] PGTABLE ==> [0000016000 - 0000018000]
[ 0.000000] #11 [00029a0240 - 00029b5240] NODE_DATA ==> [00029a0240 - 00029b5240]
[ 0.000000] #12 [00029b6000 - 00029c6000] BOOTMAP ==> [00029b6000 - 00029c6000]
[ 0.000000] [ffffea0000000000-ffffea0001bfffff] PMD -> [ffff880003200000-ffff880004dfffff] on node 0
[ 0.000000] Zone PFN ranges:
[ 0.000000] DMA 0x00000010 -> 0x00001000
[ 0.000000] DMA32 0x00001000 -> 0x00100000
[ 0.000000] Normal empty
[ 0.000000] Movable zone start PFN for each node
[ 0.000000] early_node_map[2] active PFN ranges
[ 0.000000] 0: 0x00000010 -> 0x000000a0
[ 0.000000] 0: 0x00000100 -> 0x0007f686
[ 0.000000] On node 0 totalpages: 521750
[ 0.000000] DMA zone: 56 pages used for memmap
[ 0.000000] DMA zone: 103 pages reserved
[ 0.000000] DMA zone: 3825 pages, LIFO batch:0
[ 0.000000] DMA32 zone: 7079 pages used for memmap
[ 0.000000] DMA32 zone: 510687 pages, LIFO batch:31
[ 0.000000] ACPI: PM-Timer IO Port: 0x808
[ 0.000000] ACPI: Local APIC address 0xfee00000
[ 0.000000] ACPI: LAPIC (acpi_id[0x01] lapic_id[0x00] enabled)
[ 0.000000] ACPI: LAPIC (acpi_id[0x02] lapic_id[0x01] enabled)
[ 0.000000] ACPI: LAPIC (acpi_id[0x03] lapic_id[0x05] disabled)
[ 0.000000] ACPI: LAPIC (acpi_id[0x04] lapic_id[0x07] disabled)
[ 0.000000] ACPI: LAPIC_NMI (acpi_id[0xff] high level lint[0x1])
[ 0.000000] ACPI: IOAPIC (id[0x08] address[0xfec00000] gsi_base[0])
[ 0.000000] IOAPIC[0]: apic_id 8, version 32, address 0xfec00000, GSI 0-23
[ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl)
[ 0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level)
[ 0.000000] ACPI: IRQ0 used by override.
[ 0.000000] ACPI: IRQ2 used by override.
[ 0.000000] ACPI: IRQ9 used by override.
[ 0.000000] Using ACPI (MADT) for SMP configuration information
[ 0.000000] ACPI: HPET id: 0x8086a201 base: 0xfed00000
[ 0.000000] SMP: Allowing 4 CPUs, 2 hotplug CPUs
[ 0.000000] nr_irqs_gsi: 24
[ 0.000000] PM: Registered nosave memory: 00000000000a0000 - 00000000000f0000
[ 0.000000] PM: Registered nosave memory: 00000000000f0000 - 0000000000100000
[ 0.000000] Allocating PCI resources starting at 80000000 (gap: 80000000:70000000)
[ 0.000000] Booting paravirtualized kernel on bare hardware
[ 0.000000] setup_percpu: NR_CPUS:16 nr_cpumask_bits:16 nr_cpu_ids:4 nr_node_ids:1
[ 0.000000] PERCPU: Embedded 478 pages/cpu @ffff880005400000 s1926568 r8192 d23128 u2097152
[ 0.000000] pcpu-alloc: s1926568 r8192 d23128 u2097152 alloc=1*2097152
[ 0.000000] pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3
[ 0.000000] Built 1 zonelists in Node order, mobility grouping on. Total pages: 514512
[ 0.000000] Policy zone: DMA32
[ 0.000000] Kernel command line: ro root=/dev/sda6 selinux=0 debug ignore_loglevel initcall_debug printk.time=1 print_fatal_signals=1 kern=2634rc2 console=ttyS0,115200n8 console=tty0
[ 0.000000] PID hash table entries: 4096 (order: 3, 32768 bytes)
[ 0.000000] Checking aperture...
[ 0.000000] No AGP bridge found
[ 0.000000] Memory: 2019648k/2087448k available (4978k kernel code, 448k absent, 67352k reserved, 6966k data, 2836k init)
[ 0.000000] SLUB: Genslabs=14, HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1
[ 0.000000] Hierarchical RCU implementation.
[ 0.000000] RCU-based detection of stalled CPUs is enabled.
[ 0.000000] NR_IRQS:4352 nr_irqs:440
[ 0.000000] Console: colour VGA+ 80x25
[ 0.000000] console [tty0] enabled
[ 0.000000] console [ttyS0] enabled
[ 0.000000] Lock dependency validator: Copyright (c) 2006 Red Hat, Inc., Ingo Molnar
[ 0.000000] ... MAX_LOCKDEP_SUBCLASSES: 8
[ 0.000000] ... MAX_LOCK_DEPTH: 48
[ 0.000000] ... MAX_LOCKDEP_KEYS: 8191
[ 0.000000] ... CLASSHASH_SIZE: 4096
[ 0.000000] ... MAX_LOCKDEP_ENTRIES: 16384
[ 0.000000] ... MAX_LOCKDEP_CHAINS: 32768
[ 0.000000] ... CHAINHASH_SIZE: 16384
[ 0.000000] memory used by lock dependency info: 6335 kB
[ 0.000000] per task-struct memory footprint: 2688 bytes
[ 0.000000] allocated 20971520 bytes of page_cgroup
[ 0.000000] please try 'cgroup_disable=memory' option if you don't want memory cgroups
[ 0.000000] hpet clockevent registered
[ 0.000000] Fast TSC calibration using PIT
[ 0.000000] Detected 2992.418 MHz processor.
[ 0.003012] Calibrating delay loop (skipped), value calculated using timer frequency.. 5984.83 BogoMIPS (lpj=2992418)
[ 0.005183] Security Framework initialized
[ 0.006027] SELinux: Disabled at boot.
[ 0.007585] Dentry cache hash table entries: 262144 (order: 9, 2097152 bytes)
[ 0.009477] Inode-cache hash table entries: 131072 (order: 8, 1048576 bytes)
[ 0.011262] Mount-cache hash table entries: 256
[ 0.014423] Initializing cgroup subsys ns
[ 0.015028] Initializing cgroup subsys cpuacct
[ 0.016028] Initializing cgroup subsys memory
[ 0.017179] Initializing cgroup subsys devices
[ 0.018014] Initializing cgroup subsys freezer
[ 0.019012] Initializing cgroup subsys net_cls
[ 0.020012] Initializing cgroup subsys blkio
[ 0.022044] CPU: Physical Processor ID: 0
[ 0.023009] CPU: Processor Core ID: 0
[ 0.024012] mce: CPU supports 4 MCE banks
[ 0.025026] CPU0: Thermal monitoring enabled (TM1)
[ 0.026015] using mwait in idle threads.
[ 0.027010] Performance Events: no PMU driver, software events only.
[ 0.031338] ACPI: Core revision 20100121
[ 0.199576] ftrace: converting mcount calls to 0f 1f 44 00 00
[ 0.200012] ftrace: allocating 17556 entries in 69 pages
[ 0.203422] Setting APIC routing to flat
[ 0.204514] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1
[ 0.215135] CPU0: Intel(R) Pentium(R) D CPU 3.00GHz stepping 04
[ 0.219999] calling migration_init+0x0/0x7c @ 1
[ 0.220233] initcall migration_init+0x0/0x7c returned 0 after 0 usecs
[ 0.221008] calling spawn_ksoftirqd+0x0/0x7d @ 1
[ 0.222154] initcall spawn_ksoftirqd+0x0/0x7d returned 0 after 0 usecs
[ 0.223010] calling init_call_single_data+0x0/0xe2 @ 1
[ 0.224012] initcall init_call_single_data+0x0/0xe2 returned 0 after 0 usecs
[ 0.225008] calling spawn_softlockup_task+0x0/0xa8 @ 1
[ 0.226128] initcall spawn_softlockup_task+0x0/0xa8 returned 0 after 0 usecs
[ 0.227008] calling relay_init+0x0/0x22 @ 1
[ 0.228033] initcall relay_init+0x0/0x22 returned 0 after 0 usecs
[ 0.229008] calling tracer_alloc_buffers+0x0/0x2c2 @ 1
[ 0.230156] initcall tracer_alloc_buffers+0x0/0x2c2 returned 0 after 0 usecs
[ 0.231008] calling init_trace_printk+0x0/0x20 @ 1
[ 0.232008] initcall init_trace_printk+0x0/0x20 returned 0 after 0 usecs
[ 0.233008] calling trace_workqueue_early_init+0x0/0x1a1 @ 1
[ 0.235040] initcall trace_workqueue_early_init+0x0/0x1a1 returned 0 after 976 usecs
[ 0.237382] lockdep: fixing up alternatives.
[ 0.238137] Booting Node 0, Processors #1
[ 0.312082] Brought up 2 CPUs
[ 0.313011] Total of 2 processors activated (11969.59 BogoMIPS).
[ 0.316722] devtmpfs: initialized
[ 0.318060] khelper used greatest stack depth: 6032 bytes left
[ 0.318998] khelper used greatest stack depth: 5488 bytes left
[ 0.330900] gcov: version magic: 0x34303452
[ 0.333031] calling init_mmap_min_addr+0x0/0x39 @ 1
[ 0.334011] initcall init_mmap_min_addr+0x0/0x39 returned 0 after 0 usecs
[ 0.336010] calling init_cpufreq_transition_notifier_list+0x0/0x29 @ 1
[ 0.337055] initcall init_cpufreq_transition_notifier_list+0x0/0x29 returned 0 after 0 usecs
[ 0.339064] calling net_ns_init+0x0/0x15e @ 1
[ 0.340244] initcall net_ns_init+0x0/0x15e returned 0 after 0 usecs
[ 0.341055] calling e820_mark_nvs_memory+0x0/0x5c @ 1
[ 0.342015] initcall e820_mark_nvs_memory+0x0/0x5c returned 0 after 0 usecs
[ 0.343009] calling cpufreq_tsc+0x0/0x28 @ 1
[ 0.344010] initcall cpufreq_tsc+0x0/0x28 returned 0 after 0 usecs
[ 0.345015] calling pci_reboot_init+0x0/0x22 @ 1
[ 0.346012] initcall pci_reboot_init+0x0/0x22 returned 0 after 0 usecs
[ 0.347009] calling init_lapic_sysfs+0x0/0x52 @ 1
[ 0.349508] initcall init_lapic_sysfs+0x0/0x52 returned 0 after 976 usecs
[ 0.350035] calling init_smp_flush+0x0/0x53 @ 1
[ 0.351011] initcall init_smp_flush+0x0/0x53 returned 0 after 0 usecs
[ 0.352011] calling alloc_frozen_cpus+0x0/0x14 @ 1
[ 0.353009] initcall alloc_frozen_cpus+0x0/0x14 returned 0 after 0 usecs
[ 0.354014] calling sysctl_init+0x0/0x47 @ 1
[ 0.355372] initcall sysctl_init+0x0/0x47 returned 0 after 0 usecs
[ 0.356009] calling ksysfs_init+0x0/0xe7 @ 1
[ 0.357073] initcall ksysfs_init+0x0/0xe7 returned 0 after 0 usecs
[ 0.358053] calling async_init+0x0/0x8c @ 1
[ 0.359160] initcall async_init+0x0/0x8c returned 0 after 0 usecs
[ 0.360028] calling init_jiffies_clocksource+0x0/0x20 @ 1
[ 0.361015] initcall init_jiffies_clocksource+0x0/0x20 returned 0 after 0 usecs
[ 0.362009] calling pm_init+0x0/0x97 @ 1
[ 0.363225] initcall pm_init+0x0/0x97 returned 0 after 0 usecs
[ 0.364016] calling pm_disk_init+0x0/0x27 @ 1
[ 0.365029] initcall pm_disk_init+0x0/0x27 returned 0 after 0 usecs
[ 0.366012] calling swsusp_header_init+0x0/0x46 @ 1
[ 0.367012] initcall swsusp_header_init+0x0/0x46 returned 0 after 0 usecs
[ 0.368009] calling init_ftrace_syscalls+0x0/0xfc @ 1
[ 0.371157] initcall init_ftrace_syscalls+0x0/0xfc returned 0 after 1953 usecs
[ 0.372009] calling init_hw_breakpoint+0x0/0x20 @ 1
[ 0.373013] initcall init_hw_breakpoint+0x0/0x20 returned 0 after 0 usecs
[ 0.374014] calling init_zero_pfn+0x0/0x43 @ 1
[ 0.375010] initcall init_zero_pfn+0x0/0x43 returned 0 after 0 usecs
[ 0.376009] calling filelock_init+0x0/0x3c @ 1
[ 0.377024] initcall filelock_init+0x0/0x3c returned 0 after 0 usecs
[ 0.378016] calling init_misc_binfmt+0x0/0x6c @ 1
[ 0.379032] initcall init_misc_binfmt+0x0/0x6c returned 0 after 0 usecs
[ 0.380009] calling init_script_binfmt+0x0/0x22 @ 1
[ 0.381011] initcall init_script_binfmt+0x0/0x22 returned 0 after 0 usecs
[ 0.382014] calling init_elf_binfmt+0x0/0x22 @ 1
[ 0.383010] initcall init_elf_binfmt+0x0/0x22 returned 0 after 0 usecs
[ 0.384009] calling init_compat_elf_binfmt+0x0/0x22 @ 1
[ 0.385011] initcall init_compat_elf_binfmt+0x0/0x22 returned 0 after 0 usecs
[ 0.386015] calling debugfs_init+0x0/0x85 @ 1
[ 0.387026] initcall debugfs_init+0x0/0x85 returned 0 after 0 usecs
[ 0.388012] calling securityfs_init+0x0/0x7c @ 1
[ 0.389023] initcall securityfs_init+0x0/0x7c returned 0 after 0 usecs
[ 0.390009] calling random32_init+0x0/0x119 @ 1
[ 0.391011] initcall random32_init+0x0/0x119 returned 0 after 0 usecs
[ 0.392010] calling gnttab_init+0x0/0x208 @ 1
[ 0.393010] initcall gnttab_init+0x0/0x208 returned -19 after 0 usecs
[ 0.394010] calling regulator_init+0x0/0x43 @ 1
[ 0.395007] regulator: core version 0.5
[ 0.397169] initcall regulator_init+0x0/0x43 returned 0 after 1953 usecs
[ 0.398012] calling cpufreq_core_init+0x0/0xc5 @ 1
[ 0.399026] initcall cpufreq_core_init+0x0/0xc5 returned 0 after 0 usecs
[ 0.400010] calling cpuidle_init+0x0/0x5e @ 1
[ 0.401026] initcall cpuidle_init+0x0/0x5e returned 0 after 0 usecs
[ 0.402014] calling sock_init+0x0/0x9d @ 1
[ 0.404271] initcall sock_init+0x0/0x9d returned 0 after 0 usecs
[ 0.405012] calling net_inuse_init+0x0/0x3b @ 1
[ 0.406019] initcall net_inuse_init+0x0/0x3b returned 0 after 0 usecs
[ 0.407009] calling netpoll_init+0x0/0x22 @ 1
[ 0.408015] initcall netpoll_init+0x0/0x22 returned 0 after 0 usecs
[ 0.409013] calling netlink_proto_init+0x0/0x1be @ 1
[ 0.410082] NET: Registered protocol family 16
[ 0.411106] initcall netlink_proto_init+0x0/0x1be returned 0 after 976 usecs
[ 0.412012] calling bdi_class_init+0x0/0x56 @ 1
[ 0.413519] initcall bdi_class_init+0x0/0x56 returned 0 after 0 usecs
[ 0.414013] calling kobject_uevent_init+0x0/0x77 @ 1
[ 0.415036] initcall kobject_uevent_init+0x0/0x77 returned 0 after 0 usecs
[ 0.416009] calling gpiolib_sysfs_init+0x0/0xed @ 1
[ 0.418071] initcall gpiolib_sysfs_init+0x0/0xed returned 0 after 976 usecs
[ 0.419012] calling pcibus_class_init+0x0/0x27 @ 1
[ 0.420418] initcall pcibus_class_init+0x0/0x27 returned 0 after 0 usecs
[ 0.421012] calling pci_driver_init+0x0/0x20 @ 1
[ 0.422444] initcall pci_driver_init+0x0/0x20 returned 0 after 0 usecs
[ 0.423012] calling backlight_class_init+0x0/0x79 @ 1
[ 0.424397] initcall backlight_class_init+0x0/0x79 returned 0 after 0 usecs
[ 0.425012] calling xenbus_probe_init+0x0/0x180 @ 1
[ 0.426012] initcall xenbus_probe_init+0x0/0x180 returned -19 after 0 usecs
[ 0.427009] calling tty_class_init+0x0/0x4b @ 1
[ 0.429173] initcall tty_class_init+0x0/0x4b returned 0 after 976 usecs
[ 0.430013] calling vtconsole_class_init+0x0/0x113 @ 1
[ 0.432119] initcall vtconsole_class_init+0x0/0x113 returned 0 after 976 usecs
[ 0.433012] calling register_node_type+0x0/0x49 @ 1
[ 0.434416] initcall register_node_type+0x0/0x49 returned 0 after 0 usecs
[ 0.435013] calling spi_init+0x0/0x11d @ 1
[ 0.436836] initcall spi_init+0x0/0x11d returned 0 after 0 usecs
[ 0.437012] calling amd_postcore_init+0x0/0xc6 @ 1
[ 0.438012] initcall amd_postcore_init+0x0/0xc6 returned 0 after 0 usecs
[ 0.439009] calling arch_kdebugfs_init+0x0/0x3a6 @ 1
[ 0.440132] initcall arch_kdebugfs_init+0x0/0x3a6 returned 0 after 0 usecs
[ 0.441014] calling mtrr_if_init+0x0/0x8d @ 1
[ 0.442030] initcall mtrr_if_init+0x0/0x8d returned 0 after 0 usecs
[ 0.443011] calling ffh_cstate_init+0x0/0x41 @ 1
[ 0.444017] initcall ffh_cstate_init+0x0/0x41 returned 0 after 0 usecs
[ 0.445009] calling acpi_pci_init+0x0/0xa6 @ 1
[ 0.446021] ACPI: bus type pci registered
[ 0.447014] initcall acpi_pci_init+0x0/0xa6 returned 0 after 976 usecs
[ 0.448009] calling setup_vcpu_hotplug_event+0x0/0x39 @ 1
[ 0.449010] initcall setup_vcpu_hotplug_event+0x0/0x39 returned -19 after 0 usecs
[ 0.450009] calling dmi_id_init+0x0/0x499 @ 1
[ 0.452739] initcall dmi_id_init+0x0/0x499 returned 0 after 976 usecs
[ 0.453012] calling dma_bus_init+0x0/0x5b @ 1
[ 0.455253] initcall dma_bus_init+0x0/0x5b returned 0 after 976 usecs
[ 0.456012] calling dma_channel_table_init+0x0/0x11a @ 1
[ 0.457037] initcall dma_channel_table_init+0x0/0x11a returned 0 after 0 usecs
[ 0.458009] calling pci_arch_init+0x0/0xc6 @ 1
[ 0.459060] PCI: MMCONFIG for domain 0000 [bus 00-3f] at [mem 0xf0000000-0xf3ffffff] (base 0xf0000000)
[ 0.460011] PCI: MMCONFIG at [mem 0xf0000000-0xf3ffffff] reserved in E820
[ 0.497127] PCI: Using configuration type 1 for base access
[ 0.498019] initcall pci_arch_init+0x0/0xc6 returned 0 after 38085 usecs
[ 0.499009] calling topology_init+0x0/0xe4 @ 1
[ 0.501823] initcall topology_init+0x0/0xe4 returned 0 after 976 usecs
[ 0.502011] calling mtrr_init_finialize+0x0/0x70 @ 1
[ 0.503038] initcall mtrr_init_finialize+0x0/0x70 returned 0 after 0 usecs
[ 0.504009] calling param_sysfs_init+0x0/0x356 @ 1
[ 0.527609] initcall param_sysfs_init+0x0/0x356 returned 0 after 21484 usecs
[ 0.528014] calling pm_sysrq_init+0x0/0x2c @ 1
[ 0.529028] initcall pm_sysrq_init+0x0/0x2c returned 0 after 0 usecs
[ 0.530009] calling audit_watch_init+0x0/0x4b @ 1
[ 0.531014] initcall audit_watch_init+0x0/0x4b returned 0 after 0 usecs
[ 0.532015] calling init_slow_work+0x0/0x5a @ 1
[ 0.533010] initcall init_slow_work+0x0/0x5a returned 0 after 0 usecs
[ 0.534009] calling default_bdi_init+0x0/0x113 @ 1
[ 0.536927] initcall default_bdi_init+0x0/0x113 returned 0 after 976 usecs
[ 0.537012] calling init_bio+0x0/0x115 @ 1
[ 0.538497] bio: create slab <bio-0> at 0
[ 0.539160] initcall init_bio+0x0/0x115 returned 0 after 976 usecs
[ 0.540011] calling fsnotify_init+0x0/0x2e @ 1
[ 0.541015] initcall fsnotify_init+0x0/0x2e returned 0 after 0 usecs
[ 0.542010] calling fsnotify_notification_init+0x0/0x84 @ 1
[ 0.543039] initcall fsnotify_notification_init+0x0/0x84 returned 0 after 0 usecs
[ 0.544012] calling cryptomgr_init+0x0/0x20 @ 1
[ 0.545011] initcall cryptomgr_init+0x0/0x20 returned 0 after 0 usecs
[ 0.546009] calling blk_settings_init+0x0/0x31 @ 1
[ 0.547010] initcall blk_settings_init+0x0/0x31 returned 0 after 0 usecs
[ 0.548014] calling blk_ioc_init+0x0/0x38 @ 1
[ 0.549025] initcall blk_ioc_init+0x0/0x38 returned 0 after 0 usecs
[ 0.550012] calling blk_softirq_init+0x0/0x9d @ 1
[ 0.551014] initcall blk_softirq_init+0x0/0x9d returned 0 after 0 usecs
[ 0.552009] calling blk_iopoll_setup+0x0/0x9d @ 1
[ 0.553011] initcall blk_iopoll_setup+0x0/0x9d returned 0 after 0 usecs
[ 0.554013] calling genhd_device_init+0x0/0x92 @ 1
[ 0.556395] initcall genhd_device_init+0x0/0x92 returned 0 after 976 usecs
[ 0.557011] calling blk_dev_integrity_init+0x0/0x38 @ 1
[ 0.558021] initcall blk_dev_integrity_init+0x0/0x38 returned 0 after 0 usecs
[ 0.559009] calling gpiolib_debugfs_init+0x0/0x32 @ 1
[ 0.560044] initcall gpiolib_debugfs_init+0x0/0x32 returned 0 after 0 usecs
[ 0.561014] calling pci_slot_init+0x0/0x6d @ 1
[ 0.562024] initcall pci_slot_init+0x0/0x6d returned 0 after 0 usecs
[ 0.563009] calling fbmem_init+0x0/0xd0 @ 1
[ 0.565321] initcall fbmem_init+0x0/0xd0 returned 0 after 976 usecs
[ 0.566010] calling acpi_init+0x0/0x1be @ 1
[ 0.576096] ACPI: EC: Look up EC in DSDT
[ 0.625267] ACPI: BIOS _OSI(Linux) query ignored
[ 0.646912] ACPI: Interpreter enabled
[ 0.647010] ACPI: (supports S0 S1 S3 S4 S5)
[ 0.650388] ACPI: Using IOAPIC for interrupt routing
[ 0.784142] initcall acpi_init+0x0/0x1be returned 0 after 211914 usecs
[ 0.785011] calling dock_init+0x0/0xde @ 1
[ 0.793119] ACPI: ACPI Dock Station Driver: 1 docks/bays found
[ 0.794013] initcall dock_init+0x0/0xde returned 0 after 7812 usecs
[ 0.795012] calling acpi_pci_root_init+0x0/0x52 @ 1
[ 0.796010] PCI: Ignoring host bridge windows from ACPI; if necessary, use "pci=use_crs" and report a bug
[ 0.804090] ACPI: PCI Root Bridge [PCI0] (0000:00)
[ 0.819845] pci_root PNP0A03:00: host bridge window [io 0x0000-0x0cf7] (ignored)
[ 0.820016] pci_root PNP0A03:00: host bridge window [io 0x0d00-0xffff] (ignored)
[ 0.821008] pci_root PNP0A03:00: host bridge window [mem 0x000a0000-0x000bffff] (ignored)
[ 0.822008] pci_root PNP0A03:00: host bridge window [mem 0x000c0000-0x000effff] (ignored)
[ 0.823008] pci_root PNP0A03:00: host bridge window [mem 0x000f0000-0x000fffff] (ignored)
[ 0.824014] pci_root PNP0A03:00: host bridge window [mem 0x80000000-0xefffffff] (ignored)
[ 0.825008] pci_root PNP0A03:00: host bridge window [mem 0xf4000000-0xfebfffff] (ignored)
[ 0.826008] pci_root PNP0A03:00: host bridge window [mem 0xffa80800-0xffa80bff] (ignored)
[ 0.827457] pci 0000:00:01.0: PME# supported from D0 D3hot D3cold
[ 0.828019] pci 0000:00:01.0: PME# disabled
[ 0.829116] pci 0000:00:02.0: reg 10: [mem 0xfeb00000-0xfeb7ffff]
[ 0.830021] pci 0000:00:02.0: reg 14: [io 0xe898-0xe89f]
[ 0.831020] pci 0000:00:02.0: reg 18: [mem 0xe0000000-0xefffffff pref]
[ 0.832018] pci 0000:00:02.0: reg 1c: [mem 0xfeac0000-0xfeafffff]
[ 0.833170] pci 0000:00:02.1: reg 10: [mem 0xfeb80000-0xfebfffff]
[ 0.834437] pci 0000:00:1c.0: PME# supported from D0 D3hot D3cold
[ 0.835015] pci 0000:00:1c.0: PME# disabled
[ 0.836240] pci 0000:00:1c.1: PME# supported from D0 D3hot D3cold
[ 0.837012] pci 0000:00:1c.1: PME# disabled
[ 0.838164] pci 0000:00:1d.0: reg 20: [io 0xff80-0xff9f]
[ 0.839156] pci 0000:00:1d.1: reg 20: [io 0xff60-0xff7f]
[ 0.840178] pci 0000:00:1d.2: reg 20: [io 0xff40-0xff5f]
[ 0.841157] pci 0000:00:1d.3: reg 20: [io 0xff20-0xff3f]
[ 0.842153] pci 0000:00:1d.7: reg 10: [mem 0xffa80800-0xffa80bff]
[ 0.843137] pci 0000:00:1d.7: PME# supported from D0 D3hot D3cold
[ 0.844013] pci 0000:00:1d.7: PME# disabled
[ 0.845257] pci 0000:00:1e.2: reg 10: [io 0xec00-0xecff]
[ 0.846019] pci 0000:00:1e.2: reg 14: [io 0xe8c0-0xe8ff]
[ 0.847019] pci 0000:00:1e.2: reg 18: [mem 0xfeabfa00-0xfeabfbff]
[ 0.848019] pci 0000:00:1e.2: reg 1c: [mem 0xfeabf900-0xfeabf9ff]
[ 0.849084] pci 0000:00:1e.2: PME# supported from D0 D3hot D3cold
[ 0.850013] pci 0000:00:1e.2: PME# disabled
[ 0.851206] pci 0000:00:1f.0: quirk: [io 0x0800-0x087f] claimed by ICH6 ACPI/GPIO/TCO
[ 0.852013] pci 0000:00:1f.0: quirk: [io 0x0880-0x08bf] claimed by ICH6 GPIO
[ 0.853011] pci 0000:00:1f.0: ICH7 LPC Generic IO decode 1 PIO at 0c00 (mask 007f)
[ 0.854011] pci 0000:00:1f.0: ICH7 LPC Generic IO decode 2 PIO at 00e0 (mask 0007)
[ 0.855126] pci 0000:00:1f.1: reg 10: [io 0x01f0-0x01f7]
[ 0.856019] pci 0000:00:1f.1: reg 14: [io 0x03f4-0x03f7]
[ 0.857019] pci 0000:00:1f.1: reg 18: [io 0x0170-0x0177]
[ 0.858020] pci 0000:00:1f.1: reg 1c: [io 0x0374-0x0377]
[ 0.859020] pci 0000:00:1f.1: reg 20: [io 0xffa0-0xffaf]
[ 0.860170] pci 0000:00:1f.2: reg 10: [io 0xfe00-0xfe07]
[ 0.861019] pci 0000:00:1f.2: reg 14: [io 0xfe10-0xfe13]
[ 0.862019] pci 0000:00:1f.2: reg 18: [io 0xfe20-0xfe27]
[ 0.863019] pci 0000:00:1f.2: reg 1c: [io 0xfe30-0xfe33]
[ 0.864019] pci 0000:00:1f.2: reg 20: [io 0xfea0-0xfeaf]
[ 0.866021] pci 0000:00:1f.2: PME# supported from D3hot
[ 0.867013] pci 0000:00:1f.2: PME# disabled
[ 0.868130] pci 0000:00:1f.3: reg 20: [io 0xe8a0-0xe8bf]
[ 0.869219] pci 0000:00:01.0: PCI bridge to [bus 01-01]
[ 0.870014] pci 0000:00:01.0: bridge window [io f000 - 0000] reg reading
[ 0.871013] pci 0000:00:01.0: bridge window [mem 0xfe900000-0xfe9fffff]
[ 0.872017] pci 0000:00:01.0: bridge window [mem 0xfff00000 - 000fffff pref] reg reading
[ 0.873251] pci 0000:02:00.0: reg 10: [mem 0xfe8f0000-0xfe8fffff 64bit]
[ 0.874180] pci 0000:02:00.0: PME# supported from D3hot D3cold
[ 0.875014] pci 0000:02:00.0: PME# disabled
[ 0.876041] pci 0000:02:00.0: disabling ASPM on pre-1.1 PCIe device. You can enable it with 'pcie_aspm=force'
[ 0.877054] pci 0000:00:1c.0: PCI bridge to [bus 02-02]
[ 0.878013] pci 0000:00:1c.0: bridge window [io f000 - 0000] reg reading
[ 0.879015] pci 0000:00:1c.0: bridge window [mem 0xfe800000-0xfe8fffff]
[ 0.880019] pci 0000:00:1c.0: bridge window [mem 0xfff00000 - 000fffff pref] reg reading
[ 0.881135] pci 0000:00:1c.1: PCI bridge to [bus 03-03]
[ 0.882013] pci 0000:00:1c.1: bridge window [io f000 - 0000] reg reading
[ 0.883013] pci 0000:00:1c.1: bridge window [mem 0xfe700000-0xfe7fffff]
[ 0.884019] pci 0000:00:1c.1: bridge window [mem 0xfff00000 - 000fffff pref] reg reading
[ 0.885208] pci 0000:00:1e.0: PCI bridge to [bus 04-04] (subtractive decode)
[ 0.886014] pci 0000:00:1e.0: bridge window [io f000 - 0000] reg reading
[ 0.887014] pci 0000:00:1e.0: bridge window [mem 0xfff00000 - 0x000fffff] reg reading
[ 0.888018] pci 0000:00:1e.0: bridge window [mem 0xfff00000 - 000fffff pref] reg reading
[ 0.889010] pci 0000:00:1e.0: bridge window [io 0x0000-0xffff] (subtractive decode)
[ 0.890010] pci 0000:00:1e.0: bridge window [mem 0x00000000-0xffffffffffffffff] (subtractive decode)
[ 0.892030] ACPI: PCI Interrupt Routing Table [\_SB_.PCI0._PRT]
[ 0.897612] ACPI: PCI Interrupt Routing Table [\_SB_.PCI0.PCI4._PRT]
[ 0.901472] ACPI: PCI Interrupt Routing Table [\_SB_.PCI0.PCI2._PRT]
[ 0.903578] ACPI: PCI Interrupt Routing Table [\_SB_.PCI0.PCI3._PRT]
[ 0.905242] ACPI: PCI Interrupt Routing Table [\_SB_.PCI0.PCI1._PRT]
[ 2.220601] initcall acpi_pci_root_init+0x0/0x52 returned 0 after 1390625 usecs
[ 2.228013] calling acpi_pci_link_init+0x0/0x7c @ 1
[ 2.233807] ACPI: PCI Interrupt Link [LNKA] (IRQs 3 4 5 6 7 9 10 *11 12 15)
[ 2.242277] ACPI: PCI Interrupt Link [LNKB] (IRQs 3 4 5 6 7 9 *10 11 12 15)
[ 2.250694] ACPI: PCI Interrupt Link [LNKC] (IRQs *3 4 5 6 7 9 10 11 12 15)
[ 2.258788] ACPI: PCI Interrupt Link [LNKD] (IRQs 3 4 5 6 7 9 10 11 12 15) *0, disabled.
[ 2.267813] ACPI: PCI Interrupt Link [LNKE] (IRQs 3 4 *5 6 7 9 10 11 12 15)
[ 2.276210] ACPI: PCI Interrupt Link [LNKF] (IRQs 3 4 5 6 7 *9 10 11 12 15)
[ 2.284659] ACPI: PCI Interrupt Link [LNKG] (IRQs 3 4 *5 6 7 9 10 11 12 15)
[ 2.293060] ACPI: PCI Interrupt Link [LNKH] (IRQs 3 4 5 6 7 9 *10 11 12 15)
[ 2.301679] initcall acpi_pci_link_init+0x0/0x7c returned 0 after 66406 usecs
[ 2.308012] calling pnp_init+0x0/0x20 @ 1
[ 2.313450] initcall pnp_init+0x0/0x20 returned 0 after 0 usecs
[ 2.319013] calling setup_shutdown_event+0x0/0x22 @ 1
[ 2.324011] initcall setup_shutdown_event+0x0/0x22 returned 0 after 0 usecs
[ 2.331010] calling balloon_init+0x0/0x2a5 @ 1
[ 2.336011] initcall balloon_init+0x0/0x2a5 returned -19 after 0 usecs
[ 2.342010] calling misc_init+0x0/0xf6 @ 1
[ 2.347521] initcall misc_init+0x0/0xf6 returned 0 after 0 usecs
[ 2.353013] calling vga_arb_device_init+0x0/0xbf @ 1
[ 2.359421] vgaarb: device added: PCI:0000:00:02.0,decodes=io+mem,owns=io+mem,locks=none
[ 2.367150] vgaarb: loaded
[ 2.370013] initcall vga_arb_device_init+0x0/0xbf returned 0 after 11718 usecs
[ 2.378031] calling cn_init+0x0/0xd6 @ 1
[ 2.382126] initcall cn_init+0x0/0xd6 returned 0 after 0 usecs
[ 2.388010] calling ezx_pcap_init+0x0/0x20 @ 1
[ 2.393065] initcall ezx_pcap_init+0x0/0x20 returned 0 after 976 usecs
[ 2.399011] calling phy_init+0x0/0x5a @ 1
[ 2.406836] initcall phy_init+0x0/0x5a returned 0 after 976 usecs
[ 2.413011] calling serio_init+0x0/0xda @ 1
[ 2.418197] initcall serio_init+0x0/0xda returned 0 after 976 usecs
[ 2.424013] calling input_init+0x0/0x1db @ 1
[ 2.429565] initcall input_init+0x0/0x1db returned 0 after 0 usecs
[ 2.435013] calling power_supply_class_init+0x0/0x4b @ 1
[ 2.441534] initcall power_supply_class_init+0x0/0x4b returned 0 after 0 usecs
[ 2.448013] calling pci_subsys_init+0x0/0x16a @ 1
[ 2.453008] PCI: Using ACPI for IRQ routing
[ 2.458010] PCI: pci_cache_line_size set to 64 bytes
[ 2.463268] reserve RAM buffer: 000000007f686c00 - 000000007fffffff initcall pci_subsys_init+0x0/0x16a returned 0 after 15625 usecs
[ 2.475009] calling proto_init+0x0/0x20 @ 1
[ 2.479030] initcall proto_init+0x0/0x20 returned 0 after 0 usecs
[ 2.486010] calling net_dev_init+0x0/0x254 @ 1
[ 2.491825] initcall net_dev_init+0x0/0x254 returned 0 after 976 usecs
[ 2.498012] calling neigh_init+0x0/0x9b @ 1
[ 2.502011] initcall neigh_init+0x0/0x9b returned 0 after 0 usecs
[ 2.509016] calling fib_rules_init+0x0/0xfa @ 1
[ 2.513016] initcall fib_rules_init+0x0/0xfa returned 0 after 0 usecs
[ 2.520010] calling pktsched_init+0x0/0x130 @ 1
[ 2.524045] initcall pktsched_init+0x0/0x130 returned 0 after 0 usecs
[ 2.531010] calling tc_filter_init+0x0/0x68 @ 1
[ 2.536010] initcall tc_filter_init+0x0/0x68 returned 0 after 0 usecs
[ 2.542009] calling tc_action_init+0x0/0x68 @ 1
[ 2.547010] initcall tc_action_init+0x0/0x68 returned 0 after 0 usecs
[ 2.553009] calling genl_init+0x0/0xeb @ 1
[ 2.557126] initcall genl_init+0x0/0xeb returned 0 after 976 usecs
[ 2.564010] calling cipso_v4_init+0x0/0xbe @ 1
[ 2.568032] initcall cipso_v4_init+0x0/0xbe returned 0 after 0 usecs
[ 2.575010] calling wireless_nlevent_init+0x0/0x20 @ 1
[ 2.580013] initcall wireless_nlevent_init+0x0/0x20 returned 0 after 0 usecs
[ 2.587010] calling netlbl_init+0x0/0xdc @ 1
[ 2.592007] NetLabel: Initializing
[ 2.595007] NetLabel: domain hash size = 128
[ 2.600006] NetLabel: protocols = UNLABELED CIPSOv4
[ 2.605161] NetLabel: unlabeled traffic allowed by default
[ 2.610010] initcall netlbl_init+0x0/0xdc returned 0 after 17578 usecs
[ 2.617010] calling sysctl_init+0x0/0x72 @ 1
[ 2.621015] initcall sysctl_init+0x0/0x72 returned 0 after 0 usecs
[ 2.628010] calling xen_mc_debugfs+0x0/0x166 @ 1
[ 2.632243] initcall xen_mc_debugfs+0x0/0x166 returned 0 after 976 usecs
[ 2.639009] calling xen_mmu_debugfs+0x0/0x36e @ 1
[ 2.644548] initcall xen_mmu_debugfs+0x0/0x36e returned 0 after 976 usecs
[ 2.652010] calling xen_spinlock_debugfs+0x0/0x2e2 @ 1
[ 2.657252] initcall xen_spinlock_debugfs+0x0/0x2e2 returned 0 after 0 usecs
[ 2.665010] calling print_ICs+0x0/0x7a4 @ 1
[ 2.669010] initcall print_ICs+0x0/0x7a4 returned 0 after 0 usecs
[ 2.675009] calling hpet_late_init+0x0/0xea @ 1
[ 2.680013] HPET: 3 timers in total, 0 timers will be used for per-cpu timer
[ 2.687014] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0
[ 2.691875] hpet0: 3 comparators, 64-bit 14.318180 MHz counter
[ 2.701175] initcall hpet_late_init+0x0/0xea returned 0 after 20507 usecs
[ 2.708012] calling init_k8_nbs+0x0/0x44 @ 1
[ 2.712183] initcall init_k8_nbs+0x0/0x44 returned 0 after 0 usecs
[ 2.719011] calling clocksource_done_booting+0x0/0x96 @ 1
[ 2.724014] Switching to clocksource tsc
[ 2.729555] initcall clocksource_done_booting+0x0/0x96 returned 0 after 5211 usecs
[ 2.737100] calling ftrace_init_debugfs+0x0/0x2f1 @ 1
[ 2.742742] initcall ftrace_init_debugfs+0x0/0x2f1 returned 0 after 390 usecs
[ 2.749978] calling rb_init_debugfs+0x0/0x44 @ 1
[ 2.754821] initcall rb_init_debugfs+0x0/0x44 returned 0 after 21 usecs
[ 2.761535] calling tracer_init_debugfs+0x0/0x4a5 @ 1
[ 2.768345] initcall tracer_init_debugfs+0x0/0x4a5 returned 0 after 1529 usecs
[ 2.775728] calling init_trace_printk_function_export+0x0/0x4d @ 1
[ 2.782120] initcall init_trace_printk_function_export+0x0/0x4d returned 0 after 21 usecs
[ 2.790458] calling stat_workqueue_init+0x0/0x49 @ 1
[ 2.795639] initcall stat_workqueue_init+0x0/0x49 returned 0 after 27 usecs
[ 2.802699] calling event_trace_init+0x0/0x2ea @ 1
[ 2.937675] initcall event_trace_init+0x0/0x2ea returned 0 after 126941 usecs
[ 2.944920] calling init_kprobe_trace+0x0/0xbc @ 1
[ 2.949977] initcall init_kprobe_trace+0x0/0xbc returned 0 after 60 usecs
[ 2.956884] calling init_pipe_fs+0x0/0x76 @ 1
[ 2.961577] initcall init_pipe_fs+0x0/0x76 returned 0 after 141 usecs
[ 2.968119] calling eventpoll_init+0x0/0x10d @ 1
[ 2.972977] initcall eventpoll_init+0x0/0x10d returned 0 after 51 usecs
[ 2.979706] calling anon_inode_init+0x0/0x18a @ 1
[ 2.984715] initcall anon_inode_init+0x0/0x18a returned 0 after 112 usecs
[ 2.991604] calling tomoyo_initerface_init+0x0/0x171 @ 1
[ 2.997105] initcall tomoyo_initerface_init+0x0/0x171 returned 0 after 0 usecs
[ 3.004509] calling blk_scsi_ioctl_init+0x0/0x488 @ 1
[ 3.009751] initcall blk_scsi_ioctl_init+0x0/0x488 returned 0 after 0 usecs
[ 3.016813] calling acpi_event_init+0x0/0xe1 @ 1
[ 3.021753] initcall acpi_event_init+0x0/0xe1 returned 0 after 131 usecs
[ 3.028554] calling pnpacpi_init+0x0/0xd5 @ 1
[ 3.033099] pnp: PnP ACPI init
[ 3.036324] ACPI: bus type pnp registered
[ 3.054197] pnp 00:01: disabling [io 0x0800-0x085f] because it overlaps 0000:00:1f.0 BAR 13 [io 0x0800-0x087f]
[ 3.064537] pnp 00:01: disabling [io 0x0860-0x08ff] because it overlaps 0000:00:1f.0 BAR 13 [io 0x0800-0x087f]
[ 3.135364] pnp: PnP ACPI: found 10 devices
[ 3.139657] ACPI: ACPI bus type pnp unregistered
[ 3.144377] initcall pnpacpi_init+0x0/0xd5 returned 0 after 108665 usecs
[ 3.151179] calling pnp_system_init+0x0/0x20 @ 1
[ 3.156078] system 00:01: [io 0x0c00-0x0c7f] has been reserved
[ 3.162158] system 00:08: [mem 0x00000000-0x0009ffff] could not be reserved
[ 3.169229] system 00:08: [mem 0x00100000-0x00ffffff] could not be reserved
[ 3.176298] system 00:08: [mem 0x01000000-0x7f686bff] could not be reserved
[ 3.183368] system 00:08: [mem 0x000f0000-0x000fffff] could not be reserved
[ 3.190432] system 00:08: [mem 0x000c0000-0x000cffff] has been reserved
[ 3.197157] system 00:08: [mem 0xfec00000-0xfecfffff] could not be reserved
[ 3.204223] system 00:08: [mem 0xfee00000-0xfeefffff] has been reserved
[ 3.210941] system 00:08: [mem 0xfed20000-0xfed9ffff] has been reserved
[ 3.217673] system 00:08: [mem 0xffb00000-0xffbfffff] has been reserved
[ 3.224391] system 00:08: [mem 0xffc00000-0xffffffff] has been reserved
[ 3.231165] system 00:09: [io 0x0100-0x01fe] could not be reserved
[ 3.237535] system 00:09: [io 0x0200-0x0277] has been reserved
[ 3.243558] system 00:09: [io 0x0280-0x02e7] has been reserved
[ 3.249581] system 00:09: [io 0x02f0-0x02f7] has been reserved
[ 3.255610] system 00:09: [io 0x0300-0x0377] could not be reserved
[ 3.261981] system 00:09: [io 0x0380-0x03bb] has been reserved
[ 3.268052] system 00:09: [io 0x03c0-0x03e7] could not be reserved
[ 3.274428] system 00:09: [io 0x03f6-0x03f7] could not be reserved
[ 3.280798] system 00:09: [io 0x0400-0x04cf] has been reserved
[ 3.286822] system 00:09: [io 0x04d2-0x057f] has been reserved
[ 3.292847] system 00:09: [io 0x0580-0x0677] has been reserved
[ 3.298873] system 00:09: [io 0x0680-0x0777] has been reserved
[ 3.304898] system 00:09: [io 0x0780-0x07bb] has been reserved
[ 3.310928] system 00:09: [io 0x07c0-0x07ff] has been reserved
[ 3.316964] system 00:09: [io 0x08e0-0x08ff] has been reserved
[ 3.323002] system 00:09: [io 0x0900-0x09fe] has been reserved
[ 3.329053] system 00:09: [io 0x0a00-0x0afe] has been reserved
[ 3.335076] system 00:09: [io 0x0b00-0x0bfe] has been reserved
[ 3.341101] system 00:09: [io 0x0c80-0x0caf] has been reserved
[ 3.347125] system 00:09: [io 0x0cb0-0x0cbf] has been reserved
[ 3.353149] system 00:09: [io 0x0cc0-0x0cf7] has been reserved
[ 3.359173] system 00:09: [io 0x0d00-0x0dfe] has been reserved
[ 3.365199] system 00:09: [io 0x0e00-0x0efe] has been reserved
[ 3.371224] system 00:09: [io 0x0f00-0x0ffe] has been reserved
[ 3.377247] system 00:09: [io 0x2000-0x20fe] has been reserved
[ 3.383272] system 00:09: [io 0x2100-0x21fe] has been reserved
[ 3.389296] system 00:09: [io 0x2200-0x22fe] has been reserved
[ 3.395318] system 00:09: [io 0x2300-0x23fe] has been reserved
[ 3.401344] system 00:09: [io 0x2400-0x24fe] has been reserved
[ 3.407371] system 00:09: [io 0x2500-0x25fe] has been reserved
[ 3.413408] system 00:09: [io 0x2600-0x26fe] has been reserved
[ 3.419432] system 00:09: [io 0x2700-0x27fe] has been reserved
[ 3.425457] system 00:09: [io 0x2800-0x28fe] has been reserved
[ 3.431482] system 00:09: [io 0x2900-0x29fe] has been reserved
[ 3.437507] system 00:09: [io 0x2a00-0x2afe] has been reserved
[ 3.443533] system 00:09: [io 0x2b00-0x2bfe] has been reserved
[ 3.449557] system 00:09: [io 0x2c00-0x2cfe] has been reserved
[ 3.455584] system 00:09: [io 0x2d00-0x2dfe] has been reserved
[ 3.461609] system 00:09: [io 0x2e00-0x2efe] has been reserved
[ 3.467632] system 00:09: [io 0x2f00-0x2ffe] has been reserved
[ 3.473659] system 00:09: [io 0x5000-0x50fe] has been reserved
[ 3.479683] system 00:09: [io 0x5100-0x51fe] has been reserved
[ 3.485725] system 00:09: [io 0x5200-0x52fe] has been reserved
[ 3.491752] system 00:09: [io 0x5300-0x53fe] has been reserved
[ 3.497779] system 00:09: [io 0x5400-0x54fe] has been reserved
[ 3.503805] system 00:09: [io 0x5500-0x55fe] has been reserved
[ 3.509830] system 00:09: [io 0x5600-0x56fe] has been reserved
[ 3.515854] system 00:09: [io 0x5700-0x57fe] has been reserved
[ 3.521881] system 00:09: [io 0x5800-0x58fe] has been reserved
[ 3.527905] system 00:09: [io 0x5900-0x59fe] has been reserved
[ 3.533937] system 00:09: [io 0x5a00-0x5afe] has been reserved
[ 3.539975] system 00:09: [io 0x5b00-0x5bfe] has been reserved
[ 3.546017] system 00:09: [io 0x5c00-0x5cfe] has been reserved
[ 3.552056] system 00:09: [io 0x5d00-0x5dfe] has been reserved
[ 3.558079] system 00:09: [io 0x5e00-0x5efe] has been reserved
[ 3.564104] system 00:09: [io 0x5f00-0x5ffe] has been reserved
[ 3.570137] system 00:09: [io 0x6000-0x60fe] has been reserved
[ 3.576164] system 00:09: [io 0x6100-0x61fe] has been reserved
[ 3.582189] system 00:09: [io 0x6200-0x62fe] has been reserved
[ 3.588215] system 00:09: [io 0x6300-0x63fe] has been reserved
[ 3.594255] system 00:09: [io 0x6400-0x64fe] has been reserved
[ 3.600282] system 00:09: [io 0x6500-0x65fe] has been reserved
[ 3.606308] system 00:09: [io 0x6600-0x66fe] has been reserved
[ 3.612335] system 00:09: [io 0x6700-0x67fe] has been reserved
[ 3.618362] system 00:09: [io 0x6800-0x68fe] has been reserved
[ 3.624388] system 00:09: [io 0x6900-0x69fe] has been reserved
[ 3.630411] system 00:09: [io 0x6a00-0x6afe] has been reserved
[ 3.636437] system 00:09: [io 0x6b00-0x6bfe] has been reserved
[ 3.642463] system 00:09: [io 0x6c00-0x6cfe] has been reserved
[ 3.650306] system 00:09: [io 0x6d00-0x6dfe] has been reserved
[ 3.656333] system 00:09: [io 0x6e00-0x6efe] has been reserved
[ 3.662359] system 00:09: [io 0x6f00-0x6ffe] has been reserved
[ 3.668386] system 00:09: [io 0xa000-0xa0fe] has been reserved
[ 3.674411] system 00:09: [io 0xa100-0xa1fe] has been reserved
[ 3.680440] system 00:09: [io 0xa200-0xa2fe] has been reserved
[ 3.686463] system 00:09: [io 0xa300-0xa3fe] has been reserved
[ 3.692488] system 00:09: [io 0xa400-0xa4fe] has been reserved
[ 3.698516] system 00:09: [io 0xa500-0xa5fe] has been reserved
[ 3.704542] system 00:09: [io 0xa600-0xa6fe] has been reserved
[ 3.710568] system 00:09: [io 0xa700-0xa7fe] has been reserved
[ 3.716593] system 00:09: [io 0xa800-0xa8fe] has been reserved
[ 3.722619] system 00:09: [io 0xa900-0xa9fe] has been reserved
[ 3.728647] system 00:09: [io 0xaa00-0xaafe] has been reserved
[ 3.734675] system 00:09: [io 0xab00-0xabfe] has been reserved
[ 3.740701] system 00:09: [io 0xac00-0xacfe] has been reserved
[ 3.746729] system 00:09: [io 0xad00-0xadfe] has been reserved
[ 3.752755] system 00:09: [io 0xae00-0xaefe] has been reserved
[ 3.758781] system 00:09: [io 0xaf00-0xaffe] has been reserved
[ 3.764820] system 00:09: [mem 0xf0000000-0xf3ffffff] has been reserved
[ 3.771537] system 00:09: [mem 0xfeda0000-0xfedacfff] has been reserved
[ 3.778671] initcall pnp_system_init+0x0/0x20 returned 0 after 608087 usecs
[ 3.785757] calling chr_dev_init+0x0/0x10c @ 1
[ 3.796454] initcall chr_dev_init+0x0/0x10c returned 0 after 5906 usecs
[ 3.803177] calling firmware_class_init+0x0/0xb1 @ 1
[ 3.808739] initcall firmware_class_init+0x0/0xb1 returned 0 after 397 usecs
[ 3.815902] calling cpufreq_gov_performance_init+0x0/0x20 @ 1
[ 3.821865] initcall cpufreq_gov_performance_init+0x0/0x20 returned 0 after 22 usecs
[ 3.829788] calling init_acpi_pm_clocksource+0x0/0x160 @ 1
[ 3.839992] initcall init_acpi_pm_clocksource+0x0/0x160 returned 0 after 4423 usecs
[ 3.847839] calling pcibios_assign_resources+0x0/0xb5 @ 1
[ 3.853589] PCI: max bus depth: 1 pci_try_num: 2
[ 3.858399] pci 0000:00:1c.0: BAR 15: assigned [mem 0x80000000-0x801fffff 64bit pref]
[ 3.866398] pci 0000:00:1c.1: BAR 15: assigned [mem 0x80200000-0x803fffff 64bit pref]
[ 3.874393] pci 0000:00:1c.0: BAR 13: assigned [io 0x1000-0x1fff]
[ 3.880680] pci 0000:00:1c.1: BAR 13: assigned [io 0x3000-0x3fff]
[ 3.886961] pci 0000:00:01.0: PCI bridge to [bus 01-01]
[ 3.892297] pci 0000:00:01.0: bridge window [io disabled]
[ 3.898063] pci 0000:00:01.0: bridge window [mem 0xfe900000-0xfe9fffff]
[ 3.904952] pci 0000:00:01.0: bridge window [mem pref disabled]
[ 3.911169] pci 0000:00:1c.0: PCI bridge to [bus 02-02]
[ 3.916500] pci 0000:00:1c.0: bridge window [io 0x1000-0x1fff]
[ 3.922701] pci 0000:00:1c.0: bridge window [mem 0xfe800000-0xfe8fffff]
[ 3.929593] pci 0000:00:1c.0: bridge window [mem 0x80000000-0x801fffff 64bit pref]
[ 3.937513] pci 0000:00:1c.1: PCI bridge to [bus 03-03]
[ 3.942837] pci 0000:00:1c.1: bridge window [io 0x3000-0x3fff]
[ 3.949060] pci 0000:00:1c.1: bridge window [mem 0xfe700000-0xfe7fffff]
[ 3.955954] pci 0000:00:1c.1: bridge window [mem 0x80200000-0x803fffff 64bit pref]
[ 3.963886] pci 0000:00:1e.0: PCI bridge to [bus 04-04]
[ 3.969212] pci 0000:00:1e.0: bridge window [io disabled]
[ 3.974978] pci 0000:00:1e.0: bridge window [mem disabled]
[ 3.980755] pci 0000:00:1e.0: bridge window [mem pref disabled]
[ 3.987001] alloc irq_desc for 16 on node -1
[ 3.987934] alloc kstat_irqs on node -1
[ 3.995678] pci 0000:00:01.0: PCI INT A -> GSI 16 (level, low) -> IRQ 16
[ 4.002482] pci 0000:00:01.0: setting latency timer to 64
[ 4.008016] pci 0000:00:1c.0: PCI INT A -> GSI 16 (level, low) -> IRQ 16
[ 4.014833] pci 0000:00:1c.0: setting latency timer to 64
[ 4.020355] alloc irq_desc for 17 on node -1
[ 4.021323] alloc kstat_irqs on node -1
[ 4.029006] pci 0000:00:1c.1: PCI INT B -> GSI 17 (level, low) -> IRQ 17
[ 4.035824] pci 0000:00:1c.1: setting latency timer to 64
[ 4.041338] pci 0000:00:1e.0: setting latency timer to 64
[ 4.046843] pci_bus 0000:00: resource 0 [io 0x0000-0xffff]
[ 4.052517] pci_bus 0000:00: resource 1 [mem 0x00000000-0xffffffffffffffff]
[ 4.059575] pci_bus 0000:01: resource 1 [mem 0xfe900000-0xfe9fffff]
[ 4.065943] pci_bus 0000:02: resource 0 [io 0x1000-0x1fff]
[ 4.071625] pci_bus 0000:02: resource 1 [mem 0xfe800000-0xfe8fffff]
[ 4.077993] pci_bus 0000:02: resource 2 [mem 0x80000000-0x801fffff 64bit pref]
[ 4.085399] pci_bus 0000:03: resource 0 [io 0x3000-0x3fff]
[ 4.091072] pci_bus 0000:03: resource 1 [mem 0xfe700000-0xfe7fffff]
[ 4.097441] pci_bus 0000:03: resource 2 [mem 0x80200000-0x803fffff 64bit pref]
[ 4.104832] pci_bus 0000:04: resource 4 [io 0x0000-0xffff]
[ 4.110506] pci_bus 0000:04: resource 5 [mem 0x00000000-0xffffffffffffffff]
[ 4.117571] initcall pcibios_assign_resources+0x0/0xb5 returned 0 after 257953 usecs
[ 4.125483] calling sysctl_core_init+0x0/0x54 @ 1
[ 4.130463] initcall sysctl_core_init+0x0/0x54 returned 0 after 85 usecs
[ 4.137265] calling inet_init+0x0/0x387 @ 1
[ 4.141734] NET: Registered protocol family 2
[ 4.146788] IP route cache hash table entries: 65536 (order: 7, 524288 bytes)
[ 4.157053] TCP established hash table entries: 262144 (order: 10, 4194304 bytes)
[ 4.167855] TCP bind hash table entries: 65536 (order: 10, 4718592 bytes)
[ 4.181936] TCP: Hash tables configured (established 262144 bind 65536)
[ 4.188743] TCP reno registered
[ 4.192079] UDP hash table entries: 1024 (order: 5, 163840 bytes)
[ 4.198548] UDP-Lite hash table entries: 1024 (order: 5, 163840 bytes)
[ 4.206069] initcall inet_init+0x0/0x387 returned 0 after 62910 usecs
[ 4.212617] calling af_unix_init+0x0/0x7f @ 1
[ 4.217178] NET: Registered protocol family 1
[ 4.221685] initcall af_unix_init+0x0/0x7f returned 0 after 4416 usecs
[ 4.228315] calling pci_apply_final_quirks+0x0/0x16c @ 1
[ 4.233867] pci 0000:00:02.0: Boot video device
[ 4.238813] PCI: CLS 64 bytes, default 64
[ 4.242926] initcall pci_apply_final_quirks+0x0/0x16c returned 0 after 8896 usecs
[ 4.250588] calling populate_rootfs+0x0/0x18b @ 1
[ 4.256365] Unpacking initramfs...
[ 4.432429] Freeing initrd memory: 3954k freed
[ 4.439192] initcall populate_rootfs+0x0/0x18b returned 0 after 179389 usecs
[ 4.446347] calling pci_iommu_init+0x0/0x5b @ 1
[ 4.451068] initcall pci_iommu_init+0x0/0x5b returned 0 after 1 usecs
[ 4.457608] calling calgary_fixup_tce_spaces+0x0/0x169 @ 1
[ 4.463284] initcall calgary_fixup_tce_spaces+0x0/0x169 returned -19 after 0 usecs
[ 4.471045] calling i8259A_init_sysfs+0x0/0x3e @ 1
[ 4.477032] initcall i8259A_init_sysfs+0x0/0x3e returned 0 after 942 usecs
[ 4.484353] calling vsyscall_init+0x0/0x6c @ 1
[ 4.489780] initcall vsyscall_init+0x0/0x6c returned 0 after 677 usecs
[ 4.496410] calling sbf_init+0x0/0x18b @ 1
[ 4.500698] Simple Boot Flag at 0x7a set to 0x1
[ 4.505333] initcall sbf_init+0x0/0x18b returned 0 after 4528 usecs
[ 4.511706] calling i8237A_init_sysfs+0x0/0x3e @ 1
[ 4.517534] initcall i8237A_init_sysfs+0x0/0x3e returned 0 after 826 usecs
[ 4.524529] calling add_rtc_cmos+0x0/0xea @ 1
[ 4.529079] initcall add_rtc_cmos+0x0/0xea returned 0 after 4 usecs
[ 4.535451] calling cache_sysfs_init+0x0/0x98 @ 1
[ 4.543233] initcall cache_sysfs_init+0x0/0x98 returned 0 after 2818 usecs
[ 4.550217] calling mcheck_init_device+0x0/0x13a @ 1
[ 4.557651] initcall mcheck_init_device+0x0/0x13a returned 0 after 2220 usecs
[ 4.564892] calling threshold_init_device+0x0/0xc0 @ 1
[ 4.570222] initcall threshold_init_device+0x0/0xc0 returned 0 after 1 usecs
[ 4.577373] calling thermal_throttle_init_device+0x0/0xf4 @ 1
[ 4.583392] initcall thermal_throttle_init_device+0x0/0xf4 returned 0 after 81 usecs
[ 4.591300] calling ioapic_init_sysfs+0x0/0x10f @ 1
[ 4.597256] initcall ioapic_init_sysfs+0x0/0x10f returned 0 after 865 usecs
[ 4.604329] calling add_pcspkr+0x0/0x3a @ 1
[ 4.609225] initcall add_pcspkr+0x0/0x3a returned 0 after 510 usecs
[ 4.615603] calling start_periodic_check_for_corruption+0x0/0x61 @ 1
[ 4.622141] Scanning for low memory corruption every 60 seconds
[ 4.628175] initcall start_periodic_check_for_corruption+0x0/0x61 returned 0 after 5889 usecs
[ 4.636864] calling audit_classes_init+0x0/0xfc @ 1
[ 4.642024] initcall audit_classes_init+0x0/0xfc returned 0 after 93 usecs
[ 4.649031] calling pt_dump_init+0x0/0x4a @ 1
[ 4.653631] initcall pt_dump_init+0x0/0x4a returned 0 after 33 usecs
[ 4.660088] calling init_vdso_vars+0x0/0x207 @ 1
[ 4.664917] initcall init_vdso_vars+0x0/0x207 returned 0 after 19 usecs
[ 4.671647] calling ia32_binfmt_init+0x0/0x14 @ 1
[ 4.676570] initcall ia32_binfmt_init+0x0/0x14 returned 0 after 27 usecs
[ 4.683371] calling sysenter_setup+0x0/0x2d0 @ 1
[ 4.688183] initcall sysenter_setup+0x0/0x2d0 returned 0 after 4 usecs
[ 4.694809] calling init_aout_binfmt+0x0/0x22 @ 1
[ 4.699702] initcall init_aout_binfmt+0x0/0x22 returned 0 after 1 usecs
[ 4.706416] calling init_sched_debug_procfs+0x0/0x46 @ 1
[ 4.711941] initcall init_sched_debug_procfs+0x0/0x46 returned 0 after 23 usecs
[ 4.719430] calling proc_schedstat_init+0x0/0x30 @ 1
[ 4.724600] initcall proc_schedstat_init+0x0/0x30 returned 0 after 14 usecs
[ 4.731665] calling proc_execdomains_init+0x0/0x30 @ 1
[ 4.737006] initcall proc_execdomains_init+0x0/0x30 returned 0 after 14 usecs
[ 4.744258] calling ioresources_init+0x0/0x51 @ 1
[ 4.749180] initcall ioresources_init+0x0/0x51 returned 0 after 27 usecs
[ 4.755983] calling uid_cache_init+0x0/0xc4 @ 1
[ 4.760764] initcall uid_cache_init+0x0/0xc4 returned 0 after 45 usecs
[ 4.767400] calling init_posix_timers+0x0/0x1b2 @ 1
[ 4.772481] initcall init_posix_timers+0x0/0x1b2 returned 0 after 13 usecs
[ 4.779456] calling init_posix_cpu_timers+0x0/0x10f @ 1
[ 4.784867] initcall init_posix_cpu_timers+0x0/0x10f returned 0 after 0 usecs
[ 4.792102] calling nsproxy_cache_init+0x0/0x3b @ 1
[ 4.797184] initcall nsproxy_cache_init+0x0/0x3b returned 0 after 12 usecs
[ 4.804160] calling create_proc_profile+0x0/0x301 @ 1
[ 4.809400] initcall create_proc_profile+0x0/0x301 returned 0 after 0 usecs
[ 4.816463] calling timekeeping_init_device+0x0/0x3e @ 1
[ 4.822810] initcall timekeeping_init_device+0x0/0x3e returned 0 after 821 usecs
[ 4.830391] calling init_clocksource_sysfs+0x0/0x88 @ 1
[ 4.836658] initcall init_clocksource_sysfs+0x0/0x88 returned 0 after 831 usecs
[ 4.844143] calling init_timer_list_procfs+0x0/0x46 @ 1
[ 4.851389] initcall init_timer_list_procfs+0x0/0x46 returned 0 after 15 usecs
[ 4.858775] calling init_tstats_procfs+0x0/0x46 @ 1
[ 4.863858] initcall init_tstats_procfs+0x0/0x46 returned 0 after 14 usecs
[ 4.870834] calling lockdep_proc_init+0x0/0x7b @ 1
[ 4.875857] initcall lockdep_proc_init+0x0/0x7b returned 0 after 40 usecs
[ 4.882744] calling futex_init+0x0/0xa3 @ 1
[ 4.887163] initcall futex_init+0x0/0xa3 returned 0 after 43 usecs
[ 4.893444] calling proc_dma_init+0x0/0x30 @ 1
[ 4.898090] initcall proc_dma_init+0x0/0x30 returned 0 after 14 usecs
[ 4.904632] calling proc_modules_init+0x0/0x30 @ 1
[ 4.909630] initcall proc_modules_init+0x0/0x30 returned 0 after 14 usecs
[ 4.916518] calling kallsyms_init+0x0/0x33 @ 1
[ 4.921186] initcall kallsyms_init+0x0/0x33 returned 0 after 33 usecs
[ 4.927729] calling snapshot_device_init+0x0/0x20 @ 1
[ 4.933523] initcall snapshot_device_init+0x0/0x20 returned 0 after 537 usecs
[ 4.940774] calling crash_save_vmcoreinfo_init+0x0/0x593 @ 1
[ 4.946667] initcall crash_save_vmcoreinfo_init+0x0/0x593 returned 0 after 41 usecs
[ 4.954491] calling crash_notes_memory_init+0x0/0x52 @ 1
[ 4.960000] initcall crash_notes_memory_init+0x0/0x52 returned 0 after 7 usecs
[ 4.967403] calling pid_namespaces_init+0x0/0x3b @ 1
[ 4.972599] initcall pid_namespaces_init+0x0/0x3b returned 0 after 42 usecs
[ 4.979662] calling ikconfig_init+0x0/0x4e @ 1
[ 4.984309] initcall ikconfig_init+0x0/0x4e returned 0 after 16 usecs
[ 4.990850] calling audit_init+0x0/0x1ac @ 1
[ 4.995309] audit: initializing netlink socket (disabled)
[ 5.000914] type=2000 audit(1270214127.000:1): initialized
[ 5.006527] initcall audit_init+0x0/0x1ac returned 0 after 10953 usecs
[ 5.013155] calling gcov_init+0x0/0x20 @ 1
[ 5.017443] initcall gcov_init+0x0/0x20 returned 0 after 1 usecs
[ 5.023552] calling gcov_fs_init+0x0/0x10d @ 1
[ 5.202654] initcall gcov_fs_init+0x0/0x10d returned 0 after 170374 usecs
[ 5.209551] calling audit_tree_init+0x0/0x7a @ 1
[ 5.214364] initcall audit_tree_init+0x0/0x7a returned 0 after 7 usecs
[ 5.220991] calling init_kprobes+0x0/0x220 @ 1
[ 5.240042] initcall init_kprobes+0x0/0x220 returned 0 after 14060 usecs
[ 5.246844] calling hung_task_init+0x0/0x76 @ 1
[ 5.251763] initcall hung_task_init+0x0/0x76 returned 0 after 191 usecs
[ 5.258493] calling rcuclassic_trace_init+0x0/0x15d @ 1
[ 5.264162] initcall rcuclassic_trace_init+0x0/0x15d returned 0 after 246 usecs
[ 5.271637] calling utsname_sysctl_init+0x0/0x22 @ 1
[ 5.276918] initcall utsname_sysctl_init+0x0/0x22 returned 0 after 124 usecs
[ 5.284086] calling init_tracepoints+0x0/0x25 @ 1
[ 5.288979] initcall init_tracepoints+0x0/0x25 returned 0 after 0 usecs
[ 5.295709] calling init_lstats_procfs+0x0/0x33 @ 1
[ 5.300802] initcall init_lstats_procfs+0x0/0x33 returned 0 after 24 usecs
[ 5.307779] calling ftrace_mod_cmd_init+0x0/0x20 @ 1
[ 5.312980] initcall ftrace_mod_cmd_init+0x0/0x20 returned 0 after 47 usecs
[ 5.320056] calling init_events+0x0/0xa4 @ 1
[ 5.324530] initcall init_events+0x0/0xa4 returned 0 after 13 usecs
[ 5.330898] calling init_sched_switch_trace+0x0/0x20 @ 1
[ 5.336407] initcall init_sched_switch_trace+0x0/0x20 returned 0 after 4 usecs
[ 5.343791] calling init_stack_trace+0x0/0x20 @ 1
[ 5.348689] initcall init_stack_trace+0x0/0x20 returned 0 after 2 usecs
[ 5.355403] calling init_function_trace+0x0/0x71 @ 1
[ 5.360564] initcall init_function_trace+0x0/0x71 returned 0 after 5 usecs
[ 5.367538] calling init_wakeup_tracer+0x0/0x4d @ 1
[ 5.372610] initcall init_wakeup_tracer+0x0/0x4d returned 0 after 4 usecs
[ 5.379497] calling stack_trace_init+0x0/0x95 @ 1
[ 5.384436] initcall stack_trace_init+0x0/0x95 returned 0 after 47 usecs
[ 5.391237] calling init_graph_trace+0x0/0x40 @ 1
[ 5.396141] initcall init_graph_trace+0x0/0x40 returned 0 after 3 usecs
[ 5.402854] calling init_kmem_tracer+0x0/0xaf @ 1
[ 5.407754] initcall init_kmem_tracer+0x0/0xaf returned 0 after 5 usecs
[ 5.414465] calling init_blk_tracer+0x0/0x8f @ 1
[ 5.419275] initcall init_blk_tracer+0x0/0x8f returned 0 after 4 usecs
[ 5.425903] calling perf_event_sysfs_init+0x0/0x27 @ 1
[ 5.431259] initcall perf_event_sysfs_init+0x0/0x27 returned 0 after 23 usecs
[ 5.438495] calling init_per_zone_wmark_min+0x0/0xc0 @ 1
[ 5.444213] initcall init_per_zone_wmark_min+0x0/0xc0 returned 0 after 209 usecs
[ 5.451777] calling kswapd_init+0x0/0xad @ 1
[ 5.456437] initcall kswapd_init+0x0/0xad returned 0 after 196 usecs
[ 5.462906] calling setup_vmstat+0x0/0x104 @ 1
[ 5.467617] initcall setup_vmstat+0x0/0x104 returned 0 after 66 usecs
[ 5.474158] calling mm_sysfs_init+0x0/0x43 @ 1
[ 5.478807] initcall mm_sysfs_init+0x0/0x43 returned 0 after 15 usecs
[ 5.485345] calling proc_vmalloc_init+0x0/0x33 @ 1
[ 5.490342] initcall proc_vmalloc_init+0x0/0x33 returned 0 after 15 usecs
[ 5.497231] calling procswaps_init+0x0/0x30 @ 1
[ 5.501966] initcall procswaps_init+0x0/0x30 returned 0 after 16 usecs
[ 5.508607] calling hugetlb_init+0x0/0x560 @ 1
[ 5.513243] HugeTLB registered 2 MB page size, pre-allocated 0 pages
[ 5.519796] initcall hugetlb_init+0x0/0x560 returned 0 after 6403 usecs
[ 5.526513] calling ksm_init+0x0/0x314 @ 1
[ 5.531188] initcall ksm_init+0x0/0x314 returned 0 after 377 usecs
[ 5.537508] calling slab_proc_init+0x0/0x33 @ 1
[ 5.542256] initcall slab_proc_init+0x0/0x33 returned 0 after 20 usecs
[ 5.548885] calling slab_sysfs_init+0x0/0x157 @ 1
[ 5.626297] initcall slab_sysfs_init+0x0/0x157 returned 0 after 70813 usecs
[ 5.633378] calling fasync_init+0x0/0x38 @ 1
[ 5.638539] initcall fasync_init+0x0/0x38 returned 0 after 683 usecs
[ 5.645051] calling proc_filesystems_init+0x0/0x30 @ 1
[ 5.650420] initcall proc_filesystems_init+0x0/0x30 returned 0 after 20 usecs
[ 5.657654] calling dnotify_init+0x0/0xa3 @ 1
[ 5.663655] initcall dnotify_init+0x0/0xa3 returned 0 after 1414 usecs
[ 5.670287] calling inotify_setup+0x0/0x19 @ 1
[ 5.674920] initcall inotify_setup+0x0/0x19 returned 0 after 0 usecs
[ 5.681390] calling inotify_user_setup+0x0/0x85 @ 1
[ 5.687950] initcall inotify_user_setup+0x0/0x85 returned 0 after 1455 usecs
[ 5.695141] calling aio_setup+0x0/0x11d @ 1
[ 5.701470] initcall aio_setup+0x0/0x11d returned 0 after 1908 usecs
[ 5.707943] calling proc_locks_init+0x0/0x30 @ 1
[ 5.712790] initcall proc_locks_init+0x0/0x30 returned 0 after 29 usecs
[ 5.719508] calling init_sys32_ioctl+0x0/0x36 @ 1
[ 5.724562] initcall init_sys32_ioctl+0x0/0x36 returned 0 after 154 usecs
[ 5.731450] calling dquot_init+0x0/0x121 @ 1
[ 5.735909] VFS: Disk quotas dquot_6.5.2
[ 5.740895] Dquot-cache hash table entries: 512 (order 0, 4096 bytes)
[ 5.747469] initcall dquot_init+0x0/0x121 returned 0 after 11286 usecs
[ 5.754099] calling quota_init+0x0/0x42 @ 1
[ 5.758526] initcall quota_init+0x0/0x42 returned 0 after 52 usecs
[ 5.764805] calling proc_cmdline_init+0x0/0x30 @ 1
[ 5.769801] initcall proc_cmdline_init+0x0/0x30 returned 0 after 16 usecs
[ 5.776688] calling proc_cpuinfo_init+0x0/0x30 @ 1
[ 5.781686] initcall proc_cpuinfo_init+0x0/0x30 returned 0 after 15 usecs
[ 5.788576] calling proc_devices_init+0x0/0x30 @ 1
[ 5.793573] initcall proc_devices_init+0x0/0x30 returned 0 after 15 usecs
[ 5.800462] calling proc_interrupts_init+0x0/0x30 @ 1
[ 5.805717] initcall proc_interrupts_init+0x0/0x30 returned 0 after 15 usecs
[ 5.812866] calling proc_loadavg_init+0x0/0x30 @ 1
[ 5.817862] initcall proc_loadavg_init+0x0/0x30 returned 0 after 16 usecs
[ 5.824751] calling proc_meminfo_init+0x0/0x30 @ 1
[ 5.829749] initcall proc_meminfo_init+0x0/0x30 returned 0 after 16 usecs
[ 5.836634] calling proc_stat_init+0x0/0x30 @ 1
[ 5.841369] initcall proc_stat_init+0x0/0x30 returned 0 after 16 usecs
[ 5.847998] calling proc_uptime_init+0x0/0x30 @ 1
[ 5.852926] initcall proc_uptime_init+0x0/0x30 returned 0 after 16 usecs
[ 5.859738] calling proc_version_init+0x0/0x30 @ 1
[ 5.864733] initcall proc_version_init+0x0/0x30 returned 0 after 16 usecs
[ 5.871620] calling proc_softirqs_init+0x0/0x30 @ 1
[ 5.876702] initcall proc_softirqs_init+0x0/0x30 returned 0 after 16 usecs
[ 5.883677] calling proc_kcore_init+0x0/0xf7 @ 1
[ 5.888518] initcall proc_kcore_init+0x0/0xf7 returned 0 after 32 usecs
[ 5.895232] calling vmcore_init+0x0/0x4e1 @ 1
[ 5.899779] initcall vmcore_init+0x0/0x4e1 returned 0 after 0 usecs
[ 5.906146] calling proc_kmsg_init+0x0/0x33 @ 1
[ 5.910902] initcall proc_kmsg_init+0x0/0x33 returned 0 after 32 usecs
[ 5.917536] calling proc_page_init+0x0/0x57 @ 1
[ 5.922288] initcall proc_page_init+0x0/0x57 returned 0 after 31 usecs
[ 5.928914] calling init_devpts_fs+0x0/0x76 @ 1
[ 5.933789] initcall init_devpts_fs+0x0/0x76 returned 0 after 137 usecs
[ 5.940503] calling init_ramfs_fs+0x0/0x20 @ 1
[ 5.945144] initcall init_ramfs_fs+0x0/0x20 returned 0 after 2 usecs
[ 5.951602] calling init_hugetlbfs_fs+0x0/0xf1 @ 1
[ 5.957451] initcall init_hugetlbfs_fs+0x0/0xf1 returned 0 after 848 usecs
[ 5.964430] calling ipc_init+0x0/0x59 @ 1
[ 5.968650] msgmni has been set to 3952
[ 5.972624] initcall ipc_init+0x0/0x59 returned 0 after 3902 usecs
[ 5.978904] calling ipc_sysctl_init+0x0/0x22 @ 1
[ 5.983920] initcall ipc_sysctl_init+0x0/0x22 returned 0 after 202 usecs
[ 5.990736] calling init_mqueue_fs+0x0/0x128 @ 1
[ 5.996484] initcall init_mqueue_fs+0x0/0x128 returned 0 after 919 usecs
[ 6.003297] calling key_proc_init+0x0/0x7e @ 1
[ 6.007965] initcall key_proc_init+0x0/0x7e returned 0 after 33 usecs
[ 6.014517] calling selinux_nf_ip_init+0x0/0x95 @ 1
[ 6.019583] initcall selinux_nf_ip_init+0x0/0x95 returned 0 after 0 usecs
[ 6.026470] calling init_sel_fs+0x0/0x9b @ 1
[ 6.030932] initcall init_sel_fs+0x0/0x9b returned 0 after 0 usecs
[ 6.037225] calling selnl_init+0x0/0x69 @ 1
[ 6.041630] initcall selnl_init+0x0/0x69 returned 0 after 32 usecs
[ 6.047912] calling sel_netif_init+0x0/0xa0 @ 1
[ 6.052641] initcall sel_netif_init+0x0/0xa0 returned 0 after 0 usecs
[ 6.059184] calling sel_netnode_init+0x0/0xaa @ 1
[ 6.064077] initcall sel_netnode_init+0x0/0xaa returned 0 after 0 usecs
[ 6.070791] calling sel_netport_init+0x0/0xaa @ 1
[ 6.075684] initcall sel_netport_init+0x0/0xaa returned 0 after 0 usecs
[ 6.082396] calling aurule_init+0x0/0x4c @ 1
[ 6.086857] initcall aurule_init+0x0/0x4c returned 0 after 2 usecs
[ 6.093140] calling init_smk_fs+0x0/0xc6 @ 1
[ 6.097597] initcall init_smk_fs+0x0/0xc6 returned 0 after 0 usecs
[ 6.103878] calling crypto_wq_init+0x0/0x4c @ 1
[ 6.109010] initcall crypto_wq_init+0x0/0x4c returned 0 after 402 usecs
[ 6.115748] calling crypto_algapi_init+0x0/0x1b @ 1
[ 6.120941] initcall crypto_algapi_init+0x0/0x1b returned 0 after 117 usecs
[ 6.128045] calling skcipher_module_init+0x0/0x4e @ 1
[ 6.135092] initcall skcipher_module_init+0x0/0x4e returned 0 after 0 usecs
[ 6.142161] calling chainiv_module_init+0x0/0x20 @ 1
[ 6.147360] initcall chainiv_module_init+0x0/0x20 returned 0 after 38 usecs
[ 6.154439] calling eseqiv_module_init+0x0/0x20 @ 1
[ 6.159517] initcall eseqiv_module_init+0x0/0x20 returned 0 after 6 usecs
[ 6.166414] calling hmac_module_init+0x0/0x20 @ 1
[ 6.171317] initcall hmac_module_init+0x0/0x20 returned 0 after 5 usecs
[ 6.178039] calling md5_mod_init+0x0/0x20 @ 1
[ 6.182892] initcall md5_mod_init+0x0/0x20 returned 0 after 289 usecs
[ 6.189477] calling sha1_generic_mod_init+0x0/0x20 @ 1
[ 6.195100] initcall sha1_generic_mod_init+0x0/0x20 returned 0 after 280 usecs
[ 6.202520] calling krng_mod_init+0x0/0x20 @ 1
[ 6.207349] alg: No test for stdrng (krng)
[ 6.211647] initcall krng_mod_init+0x0/0x20 returned 0 after 4378 usecs
[ 6.218396] calling proc_genhd_init+0x0/0x51 @ 1
[ 6.223246] initcall proc_genhd_init+0x0/0x51 returned 0 after 36 usecs
[ 6.229968] calling bsg_init+0x0/0x1ae @ 1
[ 6.235567] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 254)
[ 6.243172] initcall bsg_init+0x0/0x1ae returned 0 after 8701 usecs
[ 6.249546] calling init_cgroup_blkio+0x0/0x20 @ 1
[ 6.254531] initcall init_cgroup_blkio+0x0/0x20 returned 0 after 0 usecs
[ 6.261338] calling noop_init+0x0/0x22 @ 1
[ 6.265649] io scheduler noop registered
[ 6.269680] initcall noop_init+0x0/0x22 returned 0 after 3955 usecs
[ 6.276054] calling deadline_init+0x0/0x22 @ 1
[ 6.280695] io scheduler deadline registered
[ 6.285073] initcall deadline_init+0x0/0x22 returned 0 after 4274 usecs
[ 6.291798] calling cfq_init+0x0/0xed @ 1
[ 6.297525] io scheduler cfq registered (default)
[ 6.302401] initcall cfq_init+0x0/0xed returned 0 after 6248 usecs
[ 6.308690] calling percpu_counter_startup+0x0/0x2e @ 1
[ 6.314160] initcall percpu_counter_startup+0x0/0x2e returned 0 after 47 usecs
[ 6.321599] calling dynamic_debug_init+0x0/0x1aa @ 1
[ 6.327240] initcall dynamic_debug_init+0x0/0x1aa returned 0 after 473 usecs
[ 6.334395] calling lnw_gpio_init+0x0/0x29 @ 1
[ 6.339567] initcall lnw_gpio_init+0x0/0x29 returned 0 after 518 usecs
[ 6.346216] calling ucb1400_gpio_init+0x0/0x20 @ 1
[ 6.351646] initcall ucb1400_gpio_init+0x0/0x20 returned 0 after 429 usecs
[ 6.358649] calling pci_proc_init+0x0/0x94 @ 1
[ 6.363780] initcall pci_proc_init+0x0/0x94 returned 0 after 480 usecs
[ 6.370428] calling pcie_portdrv_init+0x0/0x90 @ 1
[ 6.375946] pcieport 0000:00:01.0: setting latency timer to 64
[ 6.382046] alloc irq_desc for 24 on node -1
[ 6.383005] alloc kstat_irqs on node -1
[ 6.390750] pcieport 0000:00:01.0: irq 24 for MSI/MSI-X
[ 6.397324] pcieport 0000:00:1c.0: setting latency timer to 64
[ 6.403469] alloc irq_desc for 25 on node -1
[ 6.404251] alloc kstat_irqs on node -1
[ 6.412175] pcieport 0000:00:1c.0: irq 25 for MSI/MSI-X
[ 6.419276] pcieport 0000:00:1c.1: setting latency timer to 64
[ 6.425352] alloc irq_desc for 26 on node -1
[ 6.426203] alloc kstat_irqs on node -1
[ 6.434112] pcieport 0000:00:1c.1: irq 26 for MSI/MSI-X
[ 6.441671] initcall pcie_portdrv_init+0x0/0x90 returned 0 after 64703 usecs
[ 6.448936] calling aer_service_init+0x0/0x50 @ 1
[ 6.454351] initcall aer_service_init+0x0/0x50 returned 0 after 502 usecs
[ 6.461269] calling pcie_pme_service_init+0x0/0x37 @ 1
[ 6.466640] pcieport 0000:00:01.0: Requesting control of PCIe PME from ACPI BIOS
[ 6.474245] pcieport 0000:00:01.0: Failed to receive control of PCIe PME service: no _OSC support
[ 6.483336] pcie_pme: probe of 0000:00:01.0:pcie01 failed with error -13
[ 6.490207] pcieport 0000:00:1c.0: Requesting control of PCIe PME from ACPI BIOS
[ 6.497785] pcieport 0000:00:1c.0: Failed to receive control of PCIe PME service: no _OSC support
[ 6.506856] pcie_pme: probe of 0000:00:1c.0:pcie01 failed with error -13
[ 6.513688] pcieport 0000:00:1c.1: Requesting control of PCIe PME from ACPI BIOS
[ 6.521258] pcieport 0000:00:1c.1: Failed to receive control of PCIe PME service: no _OSC support
[ 6.530306] pcie_pme: probe of 0000:00:1c.1:pcie01 failed with error -13
[ 6.537536] initcall pcie_pme_service_init+0x0/0x37 returned 0 after 69269 usecs
[ 6.545110] calling ioapic_init+0x0/0x29 @ 1
[ 6.550127] initcall ioapic_init+0x0/0x29 returned 0 after 520 usecs
[ 6.556624] calling vesafb_init+0x0/0x30f @ 1
[ 6.562224] initcall vesafb_init+0x0/0x30f returned 0 after 1020 usecs
[ 6.568913] calling efifb_init+0x0/0x2be @ 1
[ 6.573388] initcall efifb_init+0x0/0x2be returned -19 after 5 usecs
[ 6.579847] calling acpi_reserve_resources+0x0/0x141 @ 1
[ 6.585372] initcall acpi_reserve_resources+0x0/0x141 returned 0 after 17 usecs
[ 6.592857] calling irqrouter_init_sysfs+0x0/0x62 @ 1
[ 6.598944] initcall irqrouter_init_sysfs+0x0/0x62 returned 0 after 821 usecs
[ 6.606202] calling hypervisor_subsys_init+0x0/0x35 @ 1
[ 6.611621] initcall hypervisor_subsys_init+0x0/0x35 returned -19 after 0 usecs
[ 6.619101] calling hyper_sysfs_init+0x0/0x174 @ 1
[ 6.624091] initcall hyper_sysfs_init+0x0/0x174 returned -19 after 0 usecs
[ 6.631078] calling rand_initialize+0x0/0x4d @ 1
[ 6.635932] initcall rand_initialize+0x0/0x4d returned 0 after 37 usecs
[ 6.642659] calling tty_init+0x0/0x15a @ 1
[ 6.689188] initcall tty_init+0x0/0x15a returned 0 after 41242 usecs
[ 6.695924] calling pty_init+0x0/0x603 @ 1
[ 7.015570] initcall pty_init+0x0/0x603 returned 0 after 307954 usecs
[ 7.022279] calling sysrq_init+0x0/0x33 @ 1
[ 7.026724] initcall sysrq_init+0x0/0x33 returned 0 after 61 usecs
[ 7.033127] calling xen_init+0x0/0xd9 @ 1
[ 7.037342] initcall xen_init+0x0/0xd9 returned -19 after 0 usecs
[ 7.043542] calling hpet_init+0x0/0xab @ 1
[ 7.048935] initcall hpet_init+0x0/0xab returned 0 after 1073 usecs
[ 7.055320] calling init_tis+0x0/0xe2 @ 1
[ 7.060110] initcall init_tis+0x0/0xe2 returned 0 after 570 usecs
[ 7.066322] calling cn_proc_init+0x0/0x5b @ 1
[ 7.070970] initcall cn_proc_init+0x0/0x5b returned 0 after 93 usecs
[ 7.077469] calling serial8250_init+0x0/0x222 @ 1
[ 7.082365] Serial: 8250/16550 driver, 4 ports, IRQ sharing enabled
[ 7.089447] async_waiting @ 1
[ 7.092553] async_continuing @ 1 after 20 usec
[ 7.219181] async_waiting @ 1
[ 7.222254] async_continuing @ 1 after 1 usec
[ 7.348218] serial8250: ttyS0 at I/O 0x3f8 (irq = 4) is a 16550A
[ 7.357427] initcall serial8250_init+0x0/0x222 returned 0 after 268611 usecs
[ 7.364676] calling serial8250_pnp_init+0x0/0x20 @ 1
[ 7.371805] 00:07: ttyS0 at I/O 0x3f8 (irq = 4) is a 16550A
[ 7.378665] initcall serial8250_pnp_init+0x0/0x20 returned 0 after 8619 usecs
[ 7.385948] calling serial8250_pci_init+0x0/0x29 @ 1
[ 7.391718] initcall serial8250_pci_init+0x0/0x29 returned 0 after 596 usecs
[ 7.398957] calling topology_sysfs_init+0x0/0x8e @ 1
[ 7.404257] initcall topology_sysfs_init+0x0/0x8e returned 0 after 134 usecs
[ 7.411528] calling init_kgdbts+0x0/0x2d @ 1
[ 7.415998] initcall init_kgdbts+0x0/0x2d returned 0 after 2 usecs
[ 7.422284] calling mac_hid_init+0x0/0x3c @ 1
[ 7.426940] initcall mac_hid_init+0x0/0x3c returned 0 after 99 usecs
[ 7.433440] calling fixed_mdio_bus_init+0x0/0x13a @ 1
[ 7.439758] Fixed MDIO Bus: probed
[ 7.443285] initcall fixed_mdio_bus_init+0x0/0x13a returned 0 after 4494 usecs
[ 7.450680] calling tg3_init+0x0/0x29 @ 1
[ 7.454999] tg3.c:v3.108 (February 17, 2010)
[ 7.459463] tg3 0000:02:00.0: PCI INT A -> GSI 16 (level, low) -> IRQ 16
[ 7.466315] tg3 0000:02:00.0: setting latency timer to 64
[ 7.482617] tg3 0000:02:00.0: eth0: Tigon3 [partno(BCM5751PKFBG) rev 4001] (PCI Express) MAC address 00:18:8b:01:d2:2b
[ 7.493484] tg3 0000:02:00.0: eth0: attached PHY is 5750 (10/100/1000Base-T Ethernet) (WireSpeed[1])
[ 7.502789] tg3 0000:02:00.0: eth0: RXcsums[1] LinkChgREG[0] MIirq[0] ASF[0] TSOcap[1]
[ 7.510884] tg3 0000:02:00.0: eth0: dma_rwctrl[76180000] dma_mask[64-bit]
[ 7.518292] initcall tg3_init+0x0/0x29 returned 0 after 61921 usecs
[ 7.524674] calling bnx2_init+0x0/0x29 @ 1
[ 7.529499] initcall bnx2_init+0x0/0x29 returned 0 after 519 usecs
[ 7.535791] calling net_olddevs_init+0x0/0x11c @ 1
[ 7.540785] initcall net_olddevs_init+0x0/0x11c returned 0 after 7 usecs
[ 7.547592] calling init_netconsole+0x0/0x32c @ 1
[ 7.552499] console [netcon0] enabled
[ 7.556288] netconsole: network logging started
[ 7.560928] initcall init_netconsole+0x0/0x32c returned 0 after 8240 usecs
[ 7.567907] calling i8042_init+0x0/0x50e @ 1
[ 7.574353] PNP: No PS/2 controller found. Probing ports directly.
[ 7.584154] serio: i8042 KBD port at 0x60,0x64 irq 1
[ 7.589250] serio: i8042 AUX port at 0x60,0x64 irq 12
[ 7.595111] initcall i8042_init+0x0/0x50e returned 0 after 22203 usecs
[ 7.601779] calling mousedev_init+0x0/0xd8 @ 1
[ 7.607854] mice: PS/2 mouse device common for all mice
[ 7.613307] initcall mousedev_init+0x0/0xd8 returned 0 after 6725 usecs
[ 7.620029] calling atkbd_init+0x0/0x3c @ 1
[ 7.624942] initcall atkbd_init+0x0/0x3c returned 0 after 519 usecs
[ 7.631414] calling init_ladder+0x0/0x20 @ 1
[ 7.636038] cpuidle: using governor ladder
[ 7.640267] initcall init_ladder+0x0/0x20 returned 0 after 4235 usecs
[ 7.646813] calling ledtrig_ide_init+0x0/0x29 @ 1
[ 7.651769] initcall ledtrig_ide_init+0x0/0x29 returned 0 after 37 usecs
[ 7.658573] calling hid_init+0x0/0xac @ 1
[ 7.663744] initcall hid_init+0x0/0xac returned 0 after 947 usecs
[ 7.669951] calling flow_cache_init+0x0/0x20d @ 1
[ 7.675636] initcall flow_cache_init+0x0/0x20d returned 0 after 753 usecs
[ 7.682537] calling blackhole_module_init+0x0/0x20 @ 1
[ 7.687871] initcall blackhole_module_init+0x0/0x20 returned 0 after 2 usecs
[ 7.695067] calling init_cgroup_cls+0x0/0x20 @ 1
[ 7.699896] initcall init_cgroup_cls+0x0/0x20 returned 0 after 21 usecs
[ 7.706627] calling sysctl_ipv4_init+0x0/0x75 @ 1
[ 7.714253] initcall sysctl_ipv4_init+0x0/0x75 returned 0 after 2667 usecs
[ 7.721227] calling init_syncookies+0x0/0x27 @ 1
[ 7.726099] initcall init_syncookies+0x0/0x27 returned 0 after 49 usecs
[ 7.732815] calling ipv4_netfilter_init+0x0/0x25 @ 1
[ 7.739741] initcall ipv4_netfilter_init+0x0/0x25 returned 0 after 20 usecs
[ 7.746802] calling cubictcp_register+0x0/0x76 @ 1
[ 7.751782] TCP cubic registered
[ 7.755114] initcall cubictcp_register+0x0/0x76 returned 0 after 3252 usecs
[ 7.762175] calling packet_init+0x0/0x71 @ 1
[ 7.766634] NET: Registered protocol family 17
[ 7.771215] initcall packet_init+0x0/0x71 returned 0 after 4475 usecs
[ 7.777758] calling dsa_init_module+0x0/0x22 @ 1
[ 7.782567] initcall dsa_init_module+0x0/0x22 returned 0 after 3 usecs
[ 7.789194] calling edsa_init_module+0x0/0x22 @ 1
[ 7.794089] initcall edsa_init_module+0x0/0x22 returned 0 after 1 usecs
[ 7.800803] calling trailer_init_module+0x0/0x22 @ 1
[ 7.805957] initcall trailer_init_module+0x0/0x22 returned 0 after 1 usecs
[ 7.812943] calling mv88e6060_init+0x0/0x22 @ 1
[ 7.817696] initcall mv88e6060_init+0x0/0x22 returned 0 after 19 usecs
[ 7.824325] calling mv88e6123_61_65_init+0x0/0x22 @ 1
[ 7.829567] initcall mv88e6123_61_65_init+0x0/0x22 returned 0 after 1 usecs
[ 7.836629] calling mv88e6131_init+0x0/0x22 @ 1
[ 7.841353] initcall mv88e6131_init+0x0/0x22 returned 0 after 2 usecs
[ 7.847895] calling dsa_init_module+0x0/0x20 @ 1
[ 7.853204] initcall dsa_init_module+0x0/0x20 returned 0 after 490 usecs
[ 7.860030] calling dcbnl_init+0x0/0x47 @ 1
[ 7.864413] initcall dcbnl_init+0x0/0x47 returned 0 after 0 usecs
[ 7.870610] calling tboot_late_init+0x0/0x2d5 @ 1
[ 7.875504] initcall tboot_late_init+0x0/0x2d5 returned 0 after 0 usecs
[ 7.882218] calling mcheck_debugfs_init+0x0/0x60 @ 1
[ 7.887424] initcall mcheck_debugfs_init+0x0/0x60 returned 0 after 50 usecs
[ 7.894485] calling severities_debugfs_init+0x0/0x5e @ 1
[ 7.900015] initcall severities_debugfs_init+0x0/0x5e returned 0 after 27 usecs
[ 7.907503] calling hpet_insert_resource+0x0/0x3a @ 1
[ 7.912749] initcall hpet_insert_resource+0x0/0x3a returned 0 after 3 usecs
[ 7.919812] calling update_mp_table+0x0/0x85c @ 1
[ 7.924704] initcall update_mp_table+0x0/0x85c returned 0 after 0 usecs
[ 7.931420] calling lapic_insert_resource+0x0/0x55 @ 1
[ 7.936750] initcall lapic_insert_resource+0x0/0x55 returned 0 after 2 usecs
[ 7.943901] calling init_lapic_nmi_sysfs+0x0/0x65 @ 1
[ 7.949146] initcall init_lapic_nmi_sysfs+0x0/0x65 returned 0 after 0 usecs
[ 7.956208] calling io_apic_bug_finalize+0x0/0x29 @ 1
[ 7.961449] initcall io_apic_bug_finalize+0x0/0x29 returned 0 after 0 usecs
[ 7.968510] calling check_early_ioremap_leak+0x0/0x91 @ 1
[ 7.974098] initcall check_early_ioremap_leak+0x0/0x91 returned 0 after 0 usecs
[ 7.981572] calling pat_memtype_list_init+0x0/0x47 @ 1
[ 7.986925] initcall pat_memtype_list_init+0x0/0x47 returned 0 after 24 usecs
[ 7.994173] calling sched_init_debug+0x0/0x32 @ 1
[ 7.999088] initcall sched_init_debug+0x0/0x32 returned 0 after 22 usecs
[ 8.005897] calling init_oops_id+0x0/0x4b @ 1
[ 8.010458] initcall init_oops_id+0x0/0x4b returned 0 after 8 usecs
[ 8.016826] calling disable_boot_consoles+0x0/0x67 @ 1
[ 8.022154] initcall disable_boot_consoles+0x0/0x67 returned 0 after 0 usecs
[ 8.029303] calling pm_qos_power_init+0x0/0xb9 @ 1
[ 8.036059] initcall pm_qos_power_init+0x0/0xb9 returned 0 after 1728 usecs
[ 8.043156] calling software_resume+0x0/0x4b2 @ 1
[ 8.048074] initcall software_resume+0x0/0x4b2 returned -2 after 20 usecs
[ 8.054961] initcall software_resume+0x0/0x4b2 returned with error code -2
[ 8.062046] calling debugfs_kprobe_init+0x0/0xd4 @ 1
[ 8.067271] initcall debugfs_kprobe_init+0x0/0xd4 returned 0 after 72 usecs
[ 8.074333] calling taskstats_init+0x0/0xe0 @ 1
[ 8.079110] registered taskstats version 1
[ 8.083309] initcall taskstats_init+0x0/0xe0 returned 0 after 4155 usecs
[ 8.090111] calling clear_boot_tracer+0x0/0x44 @ 1
[ 8.095090] initcall clear_boot_tracer+0x0/0x44 returned 0 after 0 usecs
[ 8.101891] calling max_swapfiles_check+0x0/0xf @ 1
[ 8.106958] initcall max_swapfiles_check+0x0/0xf returned 0 after 0 usecs
[ 8.113860] calling init_ima+0x0/0x23 @ 1
[ 8.118060] No TPM chip found, activating TPM-bypass!
[ 8.123579] initcall init_ima+0x0/0x23 returned 0 after 5388 usecs
[ 8.129862] calling random32_reseed+0x0/0xdc @ 1
[ 8.134713] initcall random32_reseed+0x0/0xdc returned 0 after 43 usecs
[ 8.141427] calling pci_resource_alignment_sysfs_init+0x0/0x27 @ 1
[ 8.147804] initcall pci_resource_alignment_sysfs_init+0x0/0x27 returned 0 after 9 usecs
[ 8.156054] calling pci_sysfs_init+0x0/0x7b @ 1
[ 8.161703] initcall pci_sysfs_init+0x0/0x7b returned 0 after 905 usecs
[ 8.168417] calling boot_wait_for_devices+0x0/0x27 @ 1
[ 8.173745] initcall boot_wait_for_devices+0x0/0x27 returned 0 after 0 usecs
[ 8.180897] calling regulator_init_complete+0x0/0x1de @ 1
[ 8.186509] initcall regulator_init_complete+0x0/0x1de returned 0 after 20 usecs
[ 8.194070] calling seqgen_init+0x0/0x1d @ 1
[ 8.198556] initcall seqgen_init+0x0/0x1d returned 0 after 25 usecs
[ 8.204923] calling hd_init+0x0/0x3f9 @ 1
[ 8.209265] hd: no drives specified - use hd=cyl,head,sectors on kernel command line
[ 8.217371] initcall hd_init+0x0/0x3f9 returned -1 after 8038 usecs
[ 8.223740] initcall hd_init+0x0/0x3f9 returned with error code -1
[ 8.230107] calling memmap_init+0x0/0x5b @ 1
[ 8.234853] initcall memmap_init+0x0/0x5b returned 0 after 279 usecs
[ 8.241309] calling pci_mmcfg_late_insert_resources+0x0/0x97 @ 1
[ 8.247507] initcall pci_mmcfg_late_insert_resources+0x0/0x97 returned 0 after 2 usecs
[ 8.255587] calling init_net_drop_monitor+0x0/0x209 @ 1
[ 8.260999] Initalizing network drop monitor service
[ 8.266201] initcall init_net_drop_monitor+0x0/0x209 returned 0 after 5076 usecs
[ 8.273763] calling tcp_congestion_default+0x0/0x20 @ 1
[ 8.279180] initcall tcp_congestion_default+0x0/0x20 returned 0 after 2 usecs
[ 8.286415] calling ip_auto_config+0x0/0x1302 @ 1
[ 8.291332] initcall ip_auto_config+0x0/0x1302 returned 0 after 21 usecs
[ 8.298141] calling initialize_hashrnd+0x0/0x27 @ 1
[ 8.303217] initcall initialize_hashrnd+0x0/0x27 returned 0 after 8 usecs
[ 8.310482] async_waiting @ 1
[ 8.313556] async_continuing @ 1 after 1 usec
[ 8.318122] Freeing unused kernel memory: 2836k freed
[ 8.324849] Write protecting the kernel read-only data: 10240k
[ 8.332047] Freeing unused kernel memory: 1148k freed
[ 8.339320] Freeing unused kernel memory: 1656k freed
[ 8.853929] calling usb_init+0x0/0x270 [usbcore] @ 1016
[ 8.859806] usbcore: registered new interface driver usbfs
[ 8.865781] usbcore: registered new interface driver hub
[ 8.871591] usbcore: registered new device driver usb
[ 8.876768] initcall usb_init+0x0/0x270 [usbcore] returned 0 after 16977 usecs
[ 8.889767] calling ehci_hcd_init+0x0/0x136 [ehci_hcd] @ 1016
[ 8.895724] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver
[ 8.902474] alloc irq_desc for 21 on node -1
[ 8.903342] alloc kstat_irqs on node -1
[ 8.911148] ehci_hcd 0000:00:1d.7: PCI INT A -> GSI 21 (level, low) -> IRQ 21
[ 8.918434] ehci_hcd 0000:00:1d.7: setting latency timer to 64
[ 8.924369] ehci_hcd 0000:00:1d.7: EHCI Host Controller
[ 8.930032] ehci_hcd 0000:00:1d.7: new USB bus registered, assigned bus number 1
[ 8.937724] ehci_hcd 0000:00:1d.7: using broken periodic workaround
[ 8.944113] ehci_hcd 0000:00:1d.7: debug port 1
[ 8.952646] ehci_hcd 0000:00:1d.7: cache line size of 64 is not supported
[ 8.959620] ehci_hcd 0000:00:1d.7: irq 21, io mem 0xffa80800
[ 8.975040] ehci_hcd 0000:00:1d.7: USB 2.0 started, EHCI 1.00
[ 8.981280] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002
[ 8.988168] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[ 8.995556] usb usb1: Product: EHCI Host Controller
[ 9.000538] usb usb1: Manufacturer: Linux 2.6.34-rc2 ehci_hcd
[ 9.006385] usb usb1: SerialNumber: 0000:00:1d.7
[ 9.012291] hub 1-0:1.0: USB hub found
[ 9.016202] hub 1-0:1.0: 8 ports detected
[ 9.021474] initcall ehci_hcd_init+0x0/0x136 [ehci_hcd] returned 0 after 122795 usecs
[ 9.029875] modprobe used greatest stack depth: 4512 bytes left
[ 9.047084] calling init_pcmcia_cs+0x0/0x4b [pcmcia_core] @ 1018
[ 9.053475] initcall init_pcmcia_cs+0x0/0x4b [pcmcia_core] returned 0 after 170 usecs
[ 9.069340] calling init_pcmcia_bus+0x0/0x9d [pcmcia] @ 1018
[ 9.075458] initcall init_pcmcia_bus+0x0/0x9d [pcmcia] returned 0 after 247 usecs
[ 9.098036] calling mmc_init+0x0/0xd8 [mmc_core] @ 1018
[ 9.104171] initcall mmc_init+0x0/0xd8 [mmc_core] returned 0 after 681 usecs
[ 9.122982] calling ssb_modinit+0x0/0xb1 [ssb] @ 1018
[ 9.128672] initcall ssb_modinit+0x0/0xb1 [ssb] returned 0 after 420 usecs
[ 9.141322] calling ohci_hcd_mod_init+0x0/0x135 [ohci_hcd] @ 1018
[ 9.147617] ohci_hcd: USB 1.1 'Open' Host Controller (OHCI) Driver
[ 9.154330] initcall ohci_hcd_mod_init+0x0/0x135 [ohci_hcd] returned 0 after 6551 usecs
[ 9.172294] calling uhci_hcd_init+0x0/0x12b [uhci_hcd] @ 1020
[ 9.178243] uhci_hcd: USB Universal Host Controller Interface driver
[ 9.185255] uhci_hcd 0000:00:1d.0: PCI INT A -> GSI 21 (level, low) -> IRQ 21
[ 9.192536] uhci_hcd 0000:00:1d.0: setting latency timer to 64
[ 9.198489] uhci_hcd 0000:00:1d.0: UHCI Host Controller
[ 9.203883] uhci_hcd 0000:00:1d.0: new USB bus registered, assigned bus number 2
[ 9.211531] uhci_hcd 0000:00:1d.0: irq 21, io base 0x0000ff80
[ 9.217659] usb usb2: New USB device found, idVendor=1d6b, idProduct=0001
[ 9.224561] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[ 9.231950] usb usb2: Product: UHCI Host Controller
[ 9.236928] usb usb2: Manufacturer: Linux 2.6.34-rc2 uhci_hcd
[ 9.242776] usb usb2: SerialNumber: 0000:00:1d.0
[ 9.248809] hub 2-0:1.0: USB hub found
[ 9.252752] hub 2-0:1.0: 2 ports detected
[ 9.257722] alloc irq_desc for 22 on node -1
[ 9.258130] alloc kstat_irqs on node -1
[ 9.266388] uhci_hcd 0000:00:1d.1: PCI INT B -> GSI 22 (level, low) -> IRQ 22
[ 9.273653] uhci_hcd 0000:00:1d.1: setting latency timer to 64
[ 9.279588] uhci_hcd 0000:00:1d.1: UHCI Host Controller
[ 9.284970] uhci_hcd 0000:00:1d.1: new USB bus registered, assigned bus number 3
[ 9.294485] uhci_hcd 0000:00:1d.1: irq 22, io base 0x0000ff60
[ 9.300841] usb usb3: New USB device found, idVendor=1d6b, idProduct=0001
[ 9.307737] usb usb3: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[ 9.315126] usb usb3: Product: UHCI Host Controller
[ 9.320103] usb usb3: Manufacturer: Linux 2.6.34-rc2 uhci_hcd
[ 9.325950] usb usb3: SerialNumber: 0000:00:1d.1
[ 9.331573] hub 3-0:1.0: USB hub found
[ 9.335454] hub 3-0:1.0: 2 ports detected
[ 9.340399] alloc irq_desc for 18 on node -1
[ 9.341131] alloc kstat_irqs on node -1
[ 9.349066] uhci_hcd 0000:00:1d.2: PCI INT C -> GSI 18 (level, low) -> IRQ 18
[ 9.356728] uhci_hcd 0000:00:1d.2: setting latency timer to 64
[ 9.362672] uhci_hcd 0000:00:1d.2: UHCI Host Controller
[ 9.368092] uhci_hcd 0000:00:1d.2: new USB bus registered, assigned bus number 4
[ 9.375792] uhci_hcd 0000:00:1d.2: irq 18, io base 0x0000ff40
[ 9.381915] usb usb4: New USB device found, idVendor=1d6b, idProduct=0001
[ 9.388819] usb usb4: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[ 9.396201] usb usb4: Product: UHCI Host Controller
[ 9.401180] usb usb4: Manufacturer: Linux 2.6.34-rc2 uhci_hcd
[ 9.407056] usb usb4: SerialNumber: 0000:00:1d.2
[ 9.412699] hub 4-0:1.0: USB hub found
[ 9.416584] hub 4-0:1.0: 2 ports detected
[ 9.421480] alloc irq_desc for 23 on node -1
[ 9.422134] alloc kstat_irqs on node -1
[ 9.430154] uhci_hcd 0000:00:1d.3: PCI INT D -> GSI 23 (level, low) -> IRQ 23
[ 9.437409] uhci_hcd 0000:00:1d.3: setting latency timer to 64
[ 9.443359] uhci_hcd 0000:00:1d.3: UHCI Host Controller
[ 9.448841] uhci_hcd 0000:00:1d.3: new USB bus registered, assigned bus number 5
[ 9.456610] uhci_hcd 0000:00:1d.3: irq 23, io base 0x0000ff20
[ 9.462723] usb usb5: New USB device found, idVendor=1d6b, idProduct=0001
[ 9.469613] usb usb5: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[ 9.477000] usb usb5: Product: UHCI Host Controller
[ 9.481997] usb usb5: Manufacturer: Linux 2.6.34-rc2 uhci_hcd
[ 9.487860] usb usb5: SerialNumber: 0000:00:1d.3
[ 9.493521] hub 5-0:1.0: USB hub found
[ 9.497407] hub 5-0:1.0: 2 ports detected
[ 9.502489] initcall uhci_hcd_init+0x0/0x12b [uhci_hcd] returned 0 after 316633 usecs
[ 9.510882] modprobe used greatest stack depth: 4232 bytes left
[ 9.526904] calling init_mbcache+0x0/0x22 [mbcache] @ 1021
[ 9.532618] initcall init_mbcache+0x0/0x22 [mbcache] returned 0 after 6 usecs
[ 9.548562] calling journal_init+0x0/0x114 [jbd] @ 1021
[ 9.555748] initcall journal_init+0x0/0x114 [jbd] returned 0 after 1709 usecs
[ 9.579352] calling init_ext3_fs+0x0/0xbf [ext3] @ 1021
[ 9.585724] initcall init_ext3_fs+0x0/0xbf [ext3] returned 0 after 916 usecs
[ 9.631972] calling init_scsi+0x0/0x131 [scsi_mod] @ 1023
[ 9.641112] SCSI subsystem initialized
[ 9.644995] initcall init_scsi+0x0/0x131 [scsi_mod] returned 0 after 7231 usecs
[ 9.653235] usb 3-1: new full speed USB device using uhci_hcd and address 2
[ 9.665854] calling init_sd+0x0/0x227 [sd_mod] @ 1024
[ 9.671908] initcall init_sd+0x0/0x227 [sd_mod] returned 0 after 758 usecs
[ 9.708486] calling ide_init+0x0/0xcc [ide_core] @ 1025
[ 9.713916] Uniform Multi-Platform E-IDE driver
[ 9.718911] initcall ide_init+0x0/0xcc [ide_core] returned 0 after 4866 usecs
[ 9.733563] calling generic_ide_init+0x0/0x2e [ide_pci_generic] @ 1026
[ 9.740695] initcall generic_ide_init+0x0/0x2e [ide_pci_generic] returned 0 after 346 usecs
[ 9.784789] calling ata_init+0x0/0x470 [libata] @ 1027
[ 9.790880] libata version 3.00 loaded.
[ 9.794917] initcall ata_init+0x0/0x470 [libata] returned 0 after 4572 usecs
[ 9.813299] calling piix_init+0x0/0x45 [ata_piix] @ 1031
[ 9.818987] ata_piix 0000:00:1f.1: version 2.13
[ 9.823760] ata_piix 0000:00:1f.1: PCI INT A -> GSI 16 (level, low) -> IRQ 16
[ 9.831347] ata_piix 0000:00:1f.1: setting latency timer to 64
[ 9.837348] usb 3-1: New USB device found, idVendor=413c, idProduct=1003
[ 9.837734] scsi0 : ata_piix
[ 9.839321] scsi1 : ata_piix
[ 9.845641] ata1: PATA max UDMA/100 cmd 0x1f0 ctl 0x3f6 bmdma 0xffa0 irq 14
[ 9.845646] ata2: PATA max UDMA/100 cmd 0x170 ctl 0x376 bmdma 0xffa8 irq 15
[ 9.845743] alloc irq_desc for 20 on node -1
[ 9.845748] alloc kstat_irqs on node -1
[ 9.845768] ata_piix 0000:00:1f.2: PCI INT C -> GSI 20 (level, low) -> IRQ 20
[ 9.845783] ata_piix 0000:00:1f.2: MAP [ P0 P2 P1 P3 ]
[ 9.846611] ata2: port disabled. ignoring.
[ 9.890356] usb 3-1: New USB device strings: Mfr=1, Product=2, SerialNumber=0
[ 9.897586] usb 3-1: Product: Dell USB Keyboard Hub
[ 9.902563] usb 3-1: Manufacturer: Dell
[ 9.914968] hub 3-1:1.0: USB hub found
[ 9.919763] hub 3-1:1.0: 3 ports detected
[ 9.996090] ata_piix 0000:00:1f.2: setting latency timer to 64
[ 10.002680] scsi2 : ata_piix
[ 10.006111] ata1.00: ATAPI: HL-DT-STDVD+-RW GSA-H21N, A105, max UDMA/33
[ 10.013634] scsi3 : ata_piix
[ 10.017162] ata3: SATA max UDMA/133 cmd 0xfe00 ctl 0xfe10 bmdma 0xfea0 irq 20
[ 10.024397] ata4: SATA max UDMA/133 cmd 0xfe20 ctl 0xfe30 bmdma 0xfea8 irq 20
[ 10.025590] ata1.00: configured for UDMA/33
[ 10.037034] initcall piix_init+0x0/0x45 [ata_piix] returned 0 after 213020 usecs
[ 10.039473] scsi 0:0:0:0: CD-ROM HL-DT-ST DVD+-RW GSA-H21N A105 PQ: 0 ANSI: 5
[ 10.190445] ata3.00: ATA-7: WDC WD2500JS-75NCB3, 10.02E04, max UDMA/133
[ 10.197183] ata3.00: 488281250 sectors, multi 8: LBA48 NCQ (depth 0/32)
[ 10.207390] ata3.00: configured for UDMA/133
[ 10.211861] usb 3-1.1: new full speed USB device using uhci_hcd and address 3
[ 10.212377] scsi 2:0:0:0: Direct-Access ATA WDC WD2500JS-75N 10.0 PQ: 0 ANSI: 5
[ 10.213952] sd 2:0:0:0: [sda] 488281250 512-byte logical blocks: (250 GB/232 GiB)
[ 10.214412] sd 2:0:0:0: [sda] Write Protect is off
[ 10.214417] sd 2:0:0:0: [sda] Mode Sense: 00 3a 00 00
[ 10.214598] sd 2:0:0:0: [sda] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA
[ 10.215807] sda: sda1 sda2 sda3 sda4 < sda5 sda6 >
[ 10.290714] sd 2:0:0:0: [sda] Attached SCSI disk
[ 10.380788] usb 3-1.1: New USB device found, idVendor=413c, idProduct=2010
[ 10.387784] usb 3-1.1: New USB device strings: Mfr=1, Product=3, SerialNumber=0
[ 10.395262] usb 3-1.1: Product: Dell USB Keyboard
[ 10.400068] usb 3-1.1: Manufacturer: Dell
[ 10.480791] usb 3-1.3: new low speed USB device using uhci_hcd and address 4
[ 10.614801] usb 3-1.3: New USB device found, idVendor=046d, idProduct=c016
[ 10.621796] usb 3-1.3: New USB device strings: Mfr=1, Product=2, SerialNumber=0
[ 10.629282] usb 3-1.3: Product: Optical USB Mouse
[ 10.634091] usb 3-1.3: Manufacturer: Logitech
[ 11.844217] calling pacpi_init+0x0/0x2e [pata_acpi] @ 1040
[ 11.850225] initcall pacpi_init+0x0/0x2e [pata_acpi] returned 0 after 309 usecs
[ 11.866615] calling ata_generic_init+0x0/0x2e [ata_generic] @ 1041
[ 11.873292] initcall ata_generic_init+0x0/0x2e [ata_generic] returned 0 after 267 usecs
[ 11.887371] calling wait_scan_init+0x0/0x1b [scsi_wait_scan] @ 1042
[ 11.893872] initcall wait_scan_init+0x0/0x1b [scsi_wait_scan] returned 0 after 3 usecs
[ 12.171494] kjournald starting. Commit interval 5 seconds
[ 12.171648] EXT3-fs (sda6): mounted filesystem with writeback data mode
[ 12.558330] modprobe used greatest stack depth: 3672 bytes left
[ 14.491255] udev: starting version 141
[ 14.495286] udev: deprecated sysfs layout; update the kernel or disable CONFIG_SYSFS_DEPRECATED; some udev features will not work correctly
[ 15.045929] calling dcdbas_init+0x0/0xb2 [dcdbas] @ 1148
[ 15.074809] dcdbas dcdbas: Dell Systems Management Base Driver (version 5.6.0-3.2)
[ 15.082654] initcall dcdbas_init+0x0/0xb2 [dcdbas] returned 0 after 30403 usecs
[ 15.281653] calling cdrom_init+0x0/0x1b [cdrom] @ 1196
[ 15.307811] initcall cdrom_init+0x0/0x1b [cdrom] returned 0 after 20173 usecs
[ 15.422612] calling init_sr+0x0/0x72 [sr_mod] @ 1196
[ 15.454777] sr0: scsi3-mmc drive: 48x/48x writer cd/rw xa/form2 cdda tray
[ 15.461738] Uniform CD-ROM driver Revision: 3.20
[ 15.499985] sr 0:0:0:0: Attached scsi CD-ROM sr0
[ 15.524130] initcall init_sr+0x0/0x72 [sr_mod] returned 0 after 93970 usecs
[ 18.713421] calling hwmon_init+0x0/0x186 [hwmon] @ 2003
[ 18.733892] initcall hwmon_init+0x0/0x186 [hwmon] returned 0 after 14642 usecs
[ 18.888768] calling thermal_init+0x0/0x88 [thermal_sys] @ 2001
[ 18.897874] calling agp_init+0x0/0x3b [agpgart] @ 2017
[ 18.903306] Linux agpgart interface v0.103
[ 18.907510] initcall thermal_init+0x0/0x88 [thermal_sys] returned 0 after 12046 usecs
[ 18.915634] initcall agp_init+0x0/0x3b [agpgart] returned 0 after 12032 usecs
[ 18.994744] calling acpi_thermal_init+0x0/0xb7 [thermal] @ 2008
[ 19.007585] calling acpi_button_init+0x0/0x7d [button] @ 2005
[ 19.016600] calling agp_intel_init+0x0/0x45 [intel_agp] @ 2017
[ 19.036572] initcall acpi_thermal_init+0x0/0xb7 [thermal] returned 0 after 34703 usecs
[ 19.047970] input: Power Button as /class/input/input0
[ 19.067841] agpgart-intel 0000:00:00.0: Intel 945G Chipset
[ 19.085337] ACPI: Power Button [VBTN]
[ 19.099423] agpgart-intel 0000:00:00.0: detected 7932K stolen memory
[ 19.101605] input: Power Button as /class/input/input1
[ 19.101627] ACPI: Power Button [PWRF]
[ 19.101746] initcall acpi_button_init+0x0/0x7d [button] returned 0 after 85919 usecs
[ 19.202050] calling acpi_processor_init+0x0/0x159 [processor] @ 2002
[ 19.249541] agpgart-intel 0000:00:00.0: AGP aperture is 256M @ 0xe0000000
[ 19.275341] calling snd_mem_init+0x0/0x3a [snd_page_alloc] @ 2093
[ 19.288679] initcall agp_intel_init+0x0/0x45 [intel_agp] returned 0 after 259723 usecs
[ 19.293516] initcall acpi_processor_init+0x0/0x159 [processor] returned 0 after 82799 usecs
[ 19.316221] calling mod_init+0x0/0x383 [intel_rng] @ 2094
[ 19.318047] initcall snd_mem_init+0x0/0x3a [snd_page_alloc] returned 0 after 35463 usecs
[ 19.338579] calling init_soundcore+0x0/0xd9 [soundcore] @ 2093
[ 19.354242] initcall init_soundcore+0x0/0xd9 [soundcore] returned 0 after 8899 usecs
[ 19.379957] intel_rng: Firmware space is locked read-only. If you can't or
[ 19.379963] intel_rng: don't want to disable this in firmware setup, and if
[ 19.379965] intel_rng: you are certain that your system has a functional
[ 19.379969] intel_rng: RNG, try using the 'no_fwh_detect' option.
[ 19.407316] initcall mod_init+0x0/0x383 [intel_rng] returned -16 after 73399 usecs
[ 19.415100] initcall mod_init+0x0/0x383 [intel_rng] returned with error code -16
[ 19.495490] calling pcspkr_init+0x0/0x20 [pcspkr] @ 2132
[ 19.501572] input: PC Speaker as /class/input/input2
[ 19.507284] initcall pcspkr_init+0x0/0x20 [pcspkr] returned 0 after 6064 usecs
[ 19.573749] calling i2c_init+0x0/0xba [i2c_core] @ 2130
[ 19.579913] initcall i2c_init+0x0/0xba [i2c_core] returned 0 after 650 usecs
[ 19.594706] calling rtc_init+0x0/0xa0 [rtc_core] @ 2083
[ 19.600452] initcall rtc_init+0x0/0xa0 [rtc_core] returned 0 after 148 usecs
[ 19.637701] calling init_sg+0x0/0x1a7 [sg] @ 2126
[ 19.648286] sr 0:0:0:0: Attached scsi generic sg0 type 5
[ 19.655246] sd 2:0:0:0: Attached scsi generic sg1 type 0
[ 19.661727] initcall init_sg+0x0/0x1a7 [sg] returned 0 after 18565 usecs
[ 19.670298] calling parport_default_proc_register+0x0/0x29 [parport] @ 2074
[ 19.680371] initcall parport_default_proc_register+0x0/0x29 [parport] returned 0 after 2791 usecs
[ 19.716780] calling serio_raw_init+0x0/0x2e [serio_raw] @ 2144
[ 19.723071] initcall serio_raw_init+0x0/0x2e [serio_raw] returned 0 after 213 usecs
[ 19.765006] calling parport_pc_init+0x0/0x7fa [parport_pc] @ 2074
[ 19.773624] parport_pc 00:06: reported by Plug and Play ACPI
[ 19.779587] parport0: PC-style at 0x378 (0x778), irq 7, using FIFO [PCSPP,TRISTATE,COMPAT,ECP]
[ 19.801331] calling ppdev_init+0x0/0x128 [ppdev] @ 2216
[ 19.821282] calling evdev_init+0x0/0x20 [evdev] @ 2172
[ 19.828092] initcall evdev_init+0x0/0x20 [evdev] returned 0 after 1379 usecs
[ 19.885954] initcall parport_pc_init+0x0/0x7fa [parport_pc] returned 0 after 111932 usecs
[ 19.916968] ppdev: user-space parallel port driver
[ 19.922160] initcall ppdev_init+0x0/0x128 [ppdev] returned 0 after 112675 usecs
[ 20.011183] calling iTCO_vendor_init_module+0x0/0x2a [iTCO_vendor_support] @ 2094
[ 20.018974] iTCO_vendor_support: vendor-support=0
[ 20.023801] initcall iTCO_vendor_init_module+0x0/0x2a [iTCO_vendor_support] returned 0 after 4711 usecs
[ 20.046399] calling cmos_init+0x0/0xad [rtc_cmos] @ 2083
[ 20.052369] rtc_cmos 00:05: RTC can wake from S4
[ 20.060663] calling i2c_i801_init+0x0/0x106 [i2c_i801] @ 2130
[ 20.061468] rtc_cmos 00:05: rtc core: registered rtc_cmos as rtc0
[ 20.061553] rtc0: alarms up to one day, 242 bytes nvram, hpet irqs
[ 20.061681] initcall cmos_init+0x0/0xad [rtc_cmos] returned 0 after 9338 usecs
[ 20.087969] i801_smbus 0000:00:1f.3: PCI INT B -> GSI 17 (level, low) -> IRQ 17
[ 20.096239] initcall i2c_i801_init+0x0/0x106 [i2c_i801] returned 0 after 9294 usecs
[ 20.142969] calling iTCO_wdt_init_module+0x0/0x9b [iTCO_wdt] @ 2094
[ 20.149474] iTCO_wdt: Intel TCO WatchDog Timer Driver v1.05
[ 20.156048] iTCO_wdt: unable to reset NO_REBOOT flag, platform may have disabled it
[ 20.164125] initcall iTCO_wdt_init_module+0x0/0x9b [iTCO_wdt] returned 0 after 14299 usecs
[ 20.205822] calling psmouse_init+0x0/0xc1 [psmouse] @ 2144
[ 20.213179] initcall psmouse_init+0x0/0xc1 [psmouse] returned 0 after 1424 usecs
[ 20.265222] calling leds_init+0x0/0x60 [led_class] @ 2094
[ 20.292218] calling alsa_sound_init+0x0/0xce [snd] @ 2093
[ 20.293917] initcall leds_init+0x0/0x60 [led_class] returned 0 after 2925 usecs
[ 20.306004] initcall alsa_sound_init+0x0/0xce [snd] returned 0 after 486 usecs
[ 20.358988] calling nas_gpio_init+0x0/0x31f [leds_ss4200] @ 2094
[ 20.365279] leds_ss4200: no LED devices found
[ 20.369808] initcall nas_gpio_init+0x0/0x31f [leds_ss4200] returned -19 after 4420 usecs
[ 20.384713] calling alsa_timer_init+0x0/0x21d [snd_timer] @ 2093
[ 20.392370] initcall alsa_timer_init+0x0/0x21d [snd_timer] returned 0 after 1340 usecs
[ 20.498759] calling alsa_pcm_init+0x0/0xa9 [snd_pcm] @ 2272
[ 20.504696] initcall alsa_pcm_init+0x0/0xa9 [snd_pcm] returned 0 after 130 usecs
[ 20.522516] calling hid_init+0x0/0x149 [usbhid] @ 2197
[ 20.535045] usbcore: registered new interface driver hiddev
[ 20.549248] input: Dell Dell USB Keyboard as /class/input/input3
[ 20.556775] generic-usb 0003:413C:2010.0001: input,hidraw0: USB HID v1.10 Keyboard [Dell Dell USB Keyboard] on usb-0000:00:1d.1-1.1/input0
[ 20.583990] calling alsa_seq_device_init+0x0/0x87 [snd_seq_device] @ 2275
[ 20.591239] initcall alsa_seq_device_init+0x0/0x87 [snd_seq_device] returned 0 after 50 usecs
[ 20.601344] input: Dell Dell USB Keyboard as /class/input/input4
[ 20.609359] generic-usb 0003:413C:2010.0002: input,hidraw1: USB HID v1.10 Device [Dell Dell USB Keyboard] on usb-0000:00:1d.1-1.1/input1
[ 20.638690] input: Logitech Optical USB Mouse as /class/input/input5
[ 20.654627] generic-usb 0003:046D:C016.0003: input,hidraw2: USB HID v1.10 Mouse [Logitech Optical USB Mouse] on usb-0000:00:1d.1-1.3/input0
[ 20.683059] calling alsa_seq_init+0x0/0xae [snd_seq] @ 2275
[ 20.694039] usbcore: registered new interface driver usbhid
[ 20.699795] usbhid: USB HID core driver
[ 20.703994] initcall hid_init+0x0/0x149 [usbhid] returned 0 after 171915 usecs
[ 20.717660] initcall alsa_seq_init+0x0/0xae [snd_seq] returned 0 after 27791 usecs
[ 20.768471] calling ac97_bus_init+0x0/0x20 [ac97_bus] @ 2093
[ 20.782766] initcall ac97_bus_init+0x0/0x20 [ac97_bus] returned 0 after 8199 usecs
[ 20.871659] calling alsa_ac97_init+0x0/0xf [snd_ac97_codec] @ 2093
[ 20.878072] initcall alsa_ac97_init+0x0/0xf [snd_ac97_codec] returned 0 after 0 usecs
[ 20.885258] calling joydev_init+0x0/0x20 [joydev] @ 2313
[ 20.885275] initcall joydev_init+0x0/0x20 [joydev] returned 0 after 7 usecs
[ 20.937068] calling alsa_card_intel8x0_init+0x0/0x2e [snd_intel8x0] @ 2093
[ 20.944709] Intel ICH 0000:00:1e.2: PCI INT A -> GSI 23 (level, low) -> IRQ 23
[ 20.952230] Intel ICH 0000:00:1e.2: setting latency timer to 64
[ 21.323571] intel8x0: white list rate for 1028:01ad is 48000
[ 21.332961] initcall alsa_card_intel8x0_init+0x0/0x2e [snd_intel8x0] returned 0 after 379591 usecs
[ 21.476161] calling uinput_init+0x0/0x20 [uinput] @ 2336
[ 21.482220] initcall uinput_init+0x0/0x20 [uinput] returned 0 after 477 usecs
[ 21.680843] calling irqfd_module_init+0x0/0x4f [kvm] @ 2341
[ 21.686862] initcall irqfd_module_init+0x0/0x4f [kvm] returned 0 after 222 usecs
[ 21.748972] calling vmx_init+0x0/0x30d [kvm_intel] @ 2341
[ 21.754611] kvm: disabled by bios
[ 21.758063] initcall vmx_init+0x0/0x30d [kvm_intel] returned -95 after 3378 usecs
[ 21.765721] initcall vmx_init+0x0/0x30d [kvm_intel] returned with error code -95
[ 21.854994] calling wait_scan_init+0x0/0x1b [scsi_wait_scan] @ 2355
[ 21.861529] initcall wait_scan_init+0x0/0x1b [scsi_wait_scan] returned 0 after 3 usecs
[ 22.473353] calling dm_init+0x0/0x70 [dm_mod] @ 2362
[ 22.481591] device-mapper: uevent: version 1.0.3
[ 22.496491] device-mapper: ioctl: 4.17.0-ioctl (2010-03-05) initialised: dm-devel@redhat.com
[ 22.505508] initcall dm_init+0x0/0x70 [dm_mod] returned 0 after 26335 usecs
[ 22.566698] calling scsi_dh_init+0x0/0x5b [scsi_dh] @ 2373
[ 22.572596] initcall scsi_dh_init+0x0/0x5b [scsi_dh] returned 0 after 149 usecs
[ 22.624352] calling dm_multipath_init+0x0/0x1ce [dm_multipath] @ 2373
[ 22.632317] device-mapper: multipath: version 1.1.1 loaded
[ 22.637943] initcall dm_multipath_init+0x0/0x1ce [dm_multipath] returned 0 after 6725 usecs
[ 22.709724] calling dm_dirty_log_init+0x0/0x91 [dm_log] @ 2382
[ 22.715918] initcall dm_dirty_log_init+0x0/0x91 [dm_log] returned 0 after 97 usecs
[ 22.790741] calling dm_mirror_init+0x0/0xb3 [dm_mirror] @ 2382
[ 22.797644] initcall dm_mirror_init+0x0/0xb3 [dm_mirror] returned 0 after 787 usecs
[ 24.250330] EXT3-fs (sda6): using internal journal
[ 24.465882] kjournald starting. Commit interval 5 seconds
[ 24.471895] EXT3-fs (sda1): using internal journal
[ 24.476898] EXT3-fs (sda1): mounted filesystem with writeback data mode
[ 24.510220] kjournald starting. Commit interval 5 seconds
[ 24.512524] EXT3-fs (sda3): using internal journal
[ 24.512549] EXT3-fs (sda3): mounted filesystem with writeback data mode
[ 24.550498] kjournald starting. Commit interval 5 seconds
[ 24.550846] EXT3-fs (sda5): using internal journal
[ 24.550867] EXT3-fs (sda5): mounted filesystem with writeback data mode
[ 25.471909] Adding 4194300k swap on /dev/sda2. Priority:-1 extents:1 across:4194300k
[ 31.238865] calling acpi_cpufreq_init+0x0/0x12c [acpi_cpufreq] @ 2527
[ 31.245789] initcall acpi_cpufreq_init+0x0/0x12c [acpi_cpufreq] returned -19 after 230 usecs
[ 31.331762] calling cpufreq_p4_init+0x0/0x8f [p4_clockmod] @ 2545
[ 31.338512] p4-clockmod: P4/Xeon(TM) CPU On-Demand Clock Modulation available
[ 31.345788] initcall cpufreq_p4_init+0x0/0x8f [p4_clockmod] returned 0 after 7510 usecs
[ 31.907396] calling inet6_init+0x0/0x521 [ipv6] @ 2576
[ 31.916629] NET: Registered protocol family 10
[ 31.953710] lo: Disabled Privacy Extensions
[ 31.963697] initcall inet6_init+0x0/0x521 [ipv6] returned 0 after 49674 usecs
[ 32.005731] calling xt_init+0x0/0x1ef [x_tables] @ 2588
[ 32.011253] initcall xt_init+0x0/0x1ef [x_tables] returned 0 after 60 usecs
[ 32.046692] calling ip6_tables_init+0x0/0x130 [ip6_tables] @ 2588
[ 32.053228] ip6_tables: (C) 2000-2006 Netfilter Core Team
[ 32.058744] initcall ip6_tables_init+0x0/0x130 [ip6_tables] returned 0 after 5569 usecs
[ 32.084505] calling ip6table_filter_init+0x0/0xab [ip6table_filter] @ 2592
[ 32.091806] initcall ip6table_filter_init+0x0/0xab [ip6table_filter] returned 0 after 184 usecs
[ 32.208773] calling nf_conntrack_standalone_init+0x0/0x20 [nf_conntrack] @ 2595
[ 32.216351] nf_conntrack version 0.5.0 (16384 buckets, 65536 max)
[ 32.223957] CONFIG_NF_CT_ACCT is deprecated and will be removed soon. Please use
[ 32.231572] nf_conntrack.acct=1 kernel parameter, acct=1 nf_conntrack module option or
[ 32.239653] sysctl net.netfilter.nf_conntrack_acct=1 to enable it.
[ 32.246664] initcall nf_conntrack_standalone_init+0x0/0x20 [nf_conntrack] returned 0 after 29595 usecs
[ 32.273315] calling state_mt_init+0x0/0x25 [xt_state] @ 2595
[ 32.279215] initcall state_mt_init+0x0/0x25 [xt_state] returned 0 after 6 usecs
[ 32.322158] calling nf_conntrack_l3proto_ipv6_init+0x0/0x1d0 [nf_conntrack_ipv6] @ 2601
[ 32.331827] initcall nf_conntrack_l3proto_ipv6_init+0x0/0x1d0 [nf_conntrack_ipv6] returned 0 after 1325 usecs
[ 32.364618] calling tcpudp_mt_init+0x0/0x25 [xt_tcpudp] @ 2604
[ 32.370708] initcall tcpudp_mt_init+0x0/0x25 [xt_tcpudp] returned 0 after 15 usecs
[ 32.403117] calling reject_tg6_init+0x0/0x20 [ip6t_REJECT] @ 2607
[ 32.409463] initcall reject_tg6_init+0x0/0x20 [ip6t_REJECT] returned 0 after 8 usecs
[ 32.533659] calling ip_tables_init+0x0/0x130 [ip_tables] @ 2622
[ 32.539956] ip_tables: (C) 2000-2006 Netfilter Core Team
[ 32.545397] initcall ip_tables_init+0x0/0x130 [ip_tables] returned 0 after 5386 usecs
[ 32.574818] calling iptable_filter_init+0x0/0xab [iptable_filter] @ 2625
[ 32.581869] initcall iptable_filter_init+0x0/0xab [iptable_filter] returned 0 after 86 usecs
[ 32.614821] calling nf_defrag_init+0x0/0x25 [nf_defrag_ipv4] @ 2628
[ 32.621341] initcall nf_defrag_init+0x0/0x25 [nf_defrag_ipv4] returned 0 after 10 usecs
[ 32.664100] calling nf_conntrack_l3proto_ipv4_init+0x0/0x21e [nf_conntrack_ipv4] @ 2628
[ 32.674097] initcall nf_conntrack_l3proto_ipv4_init+0x0/0x21e [nf_conntrack_ipv4] returned 0 after 1652 usecs
[ 32.701784] calling reject_tg_init+0x0/0x20 [ipt_REJECT] @ 2632
[ 32.707998] initcall reject_tg_init+0x0/0x20 [ipt_REJECT] returned 0 after 34 usecs
[ 37.191880] calling init_sunrpc+0x0/0xbc [sunrpc] @ 2970
[ 37.202712] RPC: Registered udp transport module.
[ 37.207664] RPC: Registered tcp transport module.
[ 37.212526] RPC: Registered tcp NFSv4.1 backchannel transport module.
[ 37.219218] initcall init_sunrpc+0x0/0xbc [sunrpc] returned 0 after 21202 usecs
[ 37.418459] calling rfkill_init+0x0/0xdf [rfkill] @ 2998
[ 37.430083] initcall rfkill_init+0x0/0xdf [rfkill] returned 0 after 5859 usecs
[ 37.600633] calling bt_init+0x0/0x9b [bluetooth] @ 2998
[ 37.606314] Bluetooth: Core ver 2.15
[ 37.611292] NET: Registered protocol family 31
[ 37.615884] Bluetooth: HCI device and connection manager initialized
[ 37.622562] Bluetooth: HCI socket layer initialized
[ 37.627601] initcall bt_init+0x0/0x9b [bluetooth] returned 0 after 20775 usecs
[ 37.715560] calling l2cap_init+0x0/0x155 [l2cap] @ 3033
[ 37.725468] Bluetooth: L2CAP ver 2.14
[ 37.729281] Bluetooth: L2CAP socket layer initialized
[ 37.734459] initcall l2cap_init+0x0/0x155 [l2cap] returned 0 after 13070 usecs
[ 37.795586] calling bnep_init+0x0/0xca [bnep] @ 3039
[ 37.800847] Bluetooth: BNEP (Ethernet Emulation) ver 1.3
[ 37.806299] Bluetooth: BNEP filters: protocol multicast
[ 37.811680] initcall bnep_init+0x0/0xca [bnep] returned 0 after 10572 usecs
[ 37.880676] calling llc_init+0x0/0x74 [llc] @ 3048
[ 37.885737] initcall llc_init+0x0/0x74 [llc] returned 0 after 3 usecs
[ 37.952147] calling init_rpcsec_gss+0x0/0x7e [auth_rpcgss] @ 3046
[ 37.959593] initcall init_rpcsec_gss+0x0/0x7e [auth_rpcgss] returned 0 after 1004 usecs
[ 38.243957] calling init_nlm+0x0/0x3c [lockd] @ 3046
[ 38.249904] initcall init_nlm+0x0/0x3c [lockd] returned 0 after 689 usecs
[ 38.282302] calling br_init+0x0/0x163 [bridge] @ 3048
[ 38.291806] Bridge firewalling registered
[ 38.296416] initcall br_init+0x0/0x163 [bridge] returned 0 after 8589 usecs
[ 38.430066] calling sco_init+0x0/0x15c [sco] @ 3062
[ 38.435489] Bluetooth: SCO (Voice Link) ver 0.6
[ 38.440206] Bluetooth: SCO socket layer initialized
[ 38.445354] initcall sco_init+0x0/0x15c [sco] returned 0 after 9850 usecs
[ 38.485962] calling init_nfsd+0x0/0x1af [nfsd] @ 3057
[ 38.491255] Installing knfsd (copyright (C) 1996 okir@monad.swb.de).
[ 38.509769] initcall init_nfsd+0x0/0x1af [nfsd] returned 0 after 18059 usecs
[ 38.603047] NFSD: Using /var/lib/nfs/v4recovery as the NFSv4 state recovery directory
[ 38.615437] NFSD: starting 90-second grace period
[ 38.623899] rpc.nfsd used greatest stack depth: 3232 bytes left
[ 39.625438] virbr0: starting userspace STP failed, starting kernel STP
[ 40.200130] calling nf_nat_init+0x0/0x1a4 [nf_nat] @ 3218
[ 40.205971] initcall nf_nat_init+0x0/0x1a4 [nf_nat] returned 0 after 216 usecs
[ 40.239804] calling nf_nat_standalone_init+0x0/0xda [iptable_nat] @ 3218
[ 40.248378] initcall nf_nat_standalone_init+0x0/0xda [iptable_nat] returned 0 after 1637 usecs
[ 40.285694] calling masquerade_tg_init+0x0/0x5c [ipt_MASQUERADE] @ 3222
[ 40.334077] ADDRCONF(NETDEV_UP): eth0: link is not ready
[ 40.348962] initcall masquerade_tg_init+0x0/0x5c [ipt_MASQUERADE] returned 0 after 55072 usecs
[ 40.934455] lo: Disabled Privacy Extensions
[ 42.198426] tg3 0000:02:00.0: eth0: Link is up at 100 Mbps, full duplex
[ 42.205085] tg3 0000:02:00.0: eth0: Flow control is on for TX and on for RX
[ 42.212510] ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready
[ 50.447029] virbr0: no IPv6 routers present
[ 52.991025] eth0: no IPv6 routers present
[ 127.836202] calling init_mtd+0x0/0x88 [mtd] @ 3566
[ 127.841742] initcall init_mtd+0x0/0x88 [mtd] returned 0 after 514 usecs
[ 127.863465] calling physmap_init+0x0/0x49 [physmap] @ 3566
[ 127.869454] physmap-flash.0: failed to claim resource 0
[ 127.874760] initcall physmap_init+0x0/0x49 [physmap] returned 0 after 5450 usecs
[ 150.353495] BUG: unable to handle kernel NULL pointer dereference at 0000000000000008
[ 150.354142] IP: [<ffffffff8137c655>] device_pm_remove+0xcb/0xff
[ 150.354142] PGD 6d931067 PUD 6da98067 PMD 0
[ 150.354142] Oops: 0002 [#1] SMP
[ 150.354142] last sysfs file: /sys/devices/pci0000:00/0000:00:1d.1/usb3/3-1/3-1.3/devnum
[ 150.354142] CPU 1
[ 150.354142] Modules linked in: physmap(-) mtd chipreg map_funcs ipt_MASQUERADE iptable_nat nf_nat nfsd sco bridge lockd nfs_acl stp auth_rpcgss llc exportfs bnep l2cap crc16 bluetooth rfkill sunrpc ipt_REJECT nf_conntrack_ipv4 nf_defrag_ipv4 iptable_filter ip_tables ip6t_REJECT xt_tcpudp nf_conntrack_ipv6 xt_state nf_conntrack ip6table_filter ip6_tables x_tables ipv6 p4_clockmod freq_table speedstep_lib dm_mirror dm_region_hash dm_log dm_multipath scsi_dh dm_mod kvm uinput snd_intel8x0 joydev snd_ac97_codec ac97_bus snd_seq snd_seq_device usbhid snd_pcm snd_timer led_class snd psmouse iTCO_wdt i2c_i801 rtc_cmos iTCO_vendor_support evdev ppdev parport_pc serio_raw parport sg rtc_core i2c_core rtc_lib pcspkr soundcore snd_page_alloc rng_core button thermal intel_agp thermal_sys agpgart hwmon sr_mod cdrom dcdbas ata_generic pata_acpi ata_piix libata ide_pci_generic ide_core sd_mod scsi_mod crc_t10dif ext3 jbd mbcache uhci_hcd ohci_hcd ssb mmc_core pcmcia pcmcia_core ehci_hcd usbcore nls_base [last unloaded: processor]
[ 150.354142]
[ 150.354142] Pid: 3575, comm: rmmod Not tainted 2.6.34-rc2 #2 0HH807/OptiPlex GX620
[ 150.354142] RIP: 0010:[<ffffffff8137c655>] [<ffffffff8137c655>] device_pm_remove+0xcb/0xff
[ 150.354142] RSP: 0018:ffff88006d96de48 EFLAGS: 00010202
[ 150.354142] RAX: ffffffffa02f8960 RBX: ffffffffa02f8880 RCX: 0000000000000000
[ 150.354142] RDX: 0000000000000000 RSI: ffffffff81ab6940 RDI: ffffffff81ab6940
[ 150.354142] RBP: ffff88006d96de58 R08: 0000000000000001 R09: 0000000000000000
[ 150.354142] R10: ffffffff81ab69b0 R11: 0000000000000000 R12: ffffffff81ab5b00
[ 150.354142] R13: 00007ffff41a5f60 R14: 0000000000000000 R15: 0000000000000001
[ 150.354142] FS: 00007f05a3e8c6f0(0000) GS:ffff880005600000(0000) knlGS:0000000000000000
[ 150.354142] CS: 0010 DS: 0000 ES: 0000 CR0: 000000008005003b
[ 150.354142] CR2: 0000000000000008 CR3: 000000007b21d000 CR4: 00000000000006e0
[ 150.354142] DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000
[ 150.354142] DR3: 0000000000000000 DR6: 00000000ffff0ff0 DR7: 0000000000000400
[ 150.354142] Process rmmod (pid: 3575, threadinfo ffff88006d96c000, task ffff88006daa8000)
[ 150.354142] Stack:
[ 150.354142] ffff88006d96de58 ffffffffa02f8880 ffff88006d96de88 ffffffff8136f54f
[ 150.354142] <0> 0000000000000000 0000000000000000 ffffffffa02f8870 00007ffff41a5f60
[ 150.354142] <0> ffff88006d96dea8 ffffffff813765b5 ffffffffa02f8870 0000000000000000
[ 150.354142] Call Trace:
[ 150.354142] [<ffffffff8136f54f>] device_del+0x59/0x24e
[ 150.354142] [<ffffffff813765b5>] platform_device_del+0x2d/0x89
[ 150.354142] [<ffffffff81376dbf>] platform_device_unregister+0x1d/0x37
[ 150.354142] [<ffffffffa02f8604>] physmap_exit+0x1c/0x38 [physmap]
[ 150.354142] [<ffffffff810b38f2>] sys_delete_module+0x2cd/0x391
[ 150.354142] [<ffffffff814d24a7>] ? lockdep_sys_exit_thunk+0x35/0x67
[ 150.354142] [<ffffffff810dd36a>] ? audit_syscall_entry+0x172/0x1a5
[ 150.354142] [<ffffffff8100c6f2>] system_call_fastpath+0x16/0x1b
[ 150.354142] Code: 33 59 01 e8 c4 49 15 00 48 ff 05 9f 33 59 01 48 8d 83 e0 00 00 00 48 c7 c7 40 69 ab 81 48 8b 8b e0 00 00 00 48 8b 93 e8 00 00 00 <48> 89 51 08 48 89 0a 48 89 83 e8 00 00 00 48 89 83 e0 00 00 00
[ 150.354142] RIP [<ffffffff8137c655>] device_pm_remove+0xcb/0xff
[ 150.354142] RSP <ffff88006d96de48>
[ 150.354142] CR2: 0000000000000008
[ 150.800000] ---[ end trace 9a6eaeb4fd0889df ]---
^ permalink raw reply [flat|nested] 5+ messages in thread
* Re: BUG: physmap modprobe & rmmod
2010-04-02 20:40 BUG: physmap modprobe & rmmod Randy Dunlap
@ 2010-04-02 21:47 ` Randy Dunlap
2010-04-02 22:09 ` Carl-Daniel Hailfinger
2010-04-02 22:16 ` H Hartley Sweeten
0 siblings, 2 replies; 5+ messages in thread
From: Randy Dunlap @ 2010-04-02 21:47 UTC (permalink / raw)
To: lkml; +Cc: David Woodhouse, linux-mtd
On Fri, 2 Apr 2010 13:40:58 -0700 Randy Dunlap wrote:
> 2.6.34-rc2 kernel:
>
> Boot up on a common PC, then: modprobe physmap ; rmmod physmap
> and bang.
>
> [ 127.836202] calling init_mtd+0x0/0x88 [mtd] @ 3566
> [ 127.841742] initcall init_mtd+0x0/0x88 [mtd] returned 0 after 514 usecs
> [ 127.863465] calling physmap_init+0x0/0x49 [physmap] @ 3566
> [ 127.869454] physmap-flash.0: failed to claim resource 0
> [ 127.874760] initcall physmap_init+0x0/0x49 [physmap] returned 0 after 5450 usecs
> [ 150.353495] BUG: unable to handle kernel NULL pointer dereference at 0000000000000008
> [ 150.354142] IP: [<ffffffff8137c655>] device_pm_remove+0xcb/0xff
> [ 150.354142] PGD 6d931067 PUD 6da98067 PMD 0
> [ 150.354142] Oops: 0002 [#1] SMP
> [ 150.354142] last sysfs file: /sys/devices/pci0000:00/0000:00:1d.1/usb3/3-1/3-1.3/devnum
> [ 150.354142] CPU 1
> [ 150.354142] Modules linked in: physmap(-) mtd chipreg map_funcs ipt_MASQUERADE iptable_nat nf_nat nfsd sco bridge lockd nfs_acl stp auth_rpcgss llc exportfs bnep l2cap crc16 bluetooth rfkill sunrpc ipt_REJECT nf_conntrack_ipv4 nf_defrag_ipv4 iptable_filter ip_tables ip6t_REJECT xt_tcpudp nf_conntrack_ipv6 xt_state nf_conntrack ip6table_filter ip6_tables x_tables ipv6 p4_clockmod freq_table speedstep_lib dm_mirror dm_region_hash dm_log dm_multipath scsi_dh dm_mod kvm uinput snd_intel8x0 joydev snd_ac97_codec ac97_bus snd_seq snd_seq_device usbhid snd_pcm snd_timer led_class snd psmouse iTCO_wdt i2c_i801 rtc_cmos iTCO_vendor_support evdev ppdev parport_pc serio_raw parport sg rtc_core i2c_core rtc_lib pcspkr soundcore snd_page_alloc rng_core button thermal intel_agp thermal_sys agpgart hwmon sr_mod cdrom dcdbas ata_generic pata_acpi ata_piix libata ide_pci_generic ide_core sd_mod scsi_mod crc_t10dif ext3 jbd mbcache uhci_hcd ohci_hcd ssb mmc_core pcmcia pcmcia_core ehci_h!
cd!
> usbcore nls_base [last unloaded: processor]
> [ 150.354142]
> [ 150.354142] Pid: 3575, comm: rmmod Not tainted 2.6.34-rc2 #2 0HH807/OptiPlex GX620
> [ 150.354142] RIP: 0010:[<ffffffff8137c655>] [<ffffffff8137c655>] device_pm_remove+0xcb/0xff
> [ 150.354142] RSP: 0018:ffff88006d96de48 EFLAGS: 00010202
> [ 150.354142] RAX: ffffffffa02f8960 RBX: ffffffffa02f8880 RCX: 0000000000000000
> [ 150.354142] RDX: 0000000000000000 RSI: ffffffff81ab6940 RDI: ffffffff81ab6940
> [ 150.354142] RBP: ffff88006d96de58 R08: 0000000000000001 R09: 0000000000000000
> [ 150.354142] R10: ffffffff81ab69b0 R11: 0000000000000000 R12: ffffffff81ab5b00
> [ 150.354142] R13: 00007ffff41a5f60 R14: 0000000000000000 R15: 0000000000000001
> [ 150.354142] FS: 00007f05a3e8c6f0(0000) GS:ffff880005600000(0000) knlGS:0000000000000000
> [ 150.354142] CS: 0010 DS: 0000 ES: 0000 CR0: 000000008005003b
> [ 150.354142] CR2: 0000000000000008 CR3: 000000007b21d000 CR4: 00000000000006e0
> [ 150.354142] DR0: 0000000000000000 DR1: 0000000000000000 DR2: 0000000000000000
> [ 150.354142] DR3: 0000000000000000 DR6: 00000000ffff0ff0 DR7: 0000000000000400
> [ 150.354142] Process rmmod (pid: 3575, threadinfo ffff88006d96c000, task ffff88006daa8000)
> [ 150.354142] Stack:
> [ 150.354142] ffff88006d96de58 ffffffffa02f8880 ffff88006d96de88 ffffffff8136f54f
> [ 150.354142] <0> 0000000000000000 0000000000000000 ffffffffa02f8870 00007ffff41a5f60
> [ 150.354142] <0> ffff88006d96dea8 ffffffff813765b5 ffffffffa02f8870 0000000000000000
> [ 150.354142] Call Trace:
> [ 150.354142] [<ffffffff8136f54f>] device_del+0x59/0x24e
> [ 150.354142] [<ffffffff813765b5>] platform_device_del+0x2d/0x89
> [ 150.354142] [<ffffffff81376dbf>] platform_device_unregister+0x1d/0x37
> [ 150.354142] [<ffffffffa02f8604>] physmap_exit+0x1c/0x38 [physmap]
> [ 150.354142] [<ffffffff810b38f2>] sys_delete_module+0x2cd/0x391
> [ 150.354142] [<ffffffff814d24a7>] ? lockdep_sys_exit_thunk+0x35/0x67
> [ 150.354142] [<ffffffff810dd36a>] ? audit_syscall_entry+0x172/0x1a5
> [ 150.354142] [<ffffffff8100c6f2>] system_call_fastpath+0x16/0x1b
> [ 150.354142] Code: 33 59 01 e8 c4 49 15 00 48 ff 05 9f 33 59 01 48 8d 83 e0 00 00 00 48 c7 c7 40 69 ab 81 48 8b 8b e0 00 00 00 48 8b 93 e8 00 00 00 <48> 89 51 08 48 89 0a 48 89 83 e8 00 00 00 48 89 83 e0 00 00 00
> [ 150.354142] RIP [<ffffffff8137c655>] device_pm_remove+0xcb/0xff
> [ 150.354142] RSP <ffff88006d96de48>
> [ 150.354142] CR2: 0000000000000008
> [ 150.800000] ---[ end trace 9a6eaeb4fd0889df ]---
This is with close to an allmodconfig on x86_64, including:
CONFIG_MTD_PHYSMAP=m
CONFIG_MTD_PHYSMAP_COMPAT=y
CONFIG_MTD_PHYSMAP_START=0x8000000
CONFIG_MTD_PHYSMAP_LEN=0
CONFIG_MTD_PHYSMAP_BANKWIDTH=2
---
~Randy
^ permalink raw reply [flat|nested] 5+ messages in thread
* Re: BUG: physmap modprobe & rmmod
2010-04-02 21:47 ` Randy Dunlap
@ 2010-04-02 22:09 ` Carl-Daniel Hailfinger
2010-04-02 22:16 ` H Hartley Sweeten
1 sibling, 0 replies; 5+ messages in thread
From: Carl-Daniel Hailfinger @ 2010-04-02 22:09 UTC (permalink / raw)
To: Randy Dunlap; +Cc: linux-mtd, David Woodhouse, lkml
On 02.04.2010 23:47, Randy Dunlap wrote:
> On Fri, 2 Apr 2010 13:40:58 -0700 Randy Dunlap wrote:
>
>
>> 2.6.34-rc2 kernel:
>>
>> Boot up on a common PC, then: modprobe physmap ; rmmod physmap
>> and bang.
>>
> This is with close to an allmodconfig on x86_64, including:
>
> CONFIG_MTD_PHYSMAP=m
> CONFIG_MTD_PHYSMAP_COMPAT=y
> CONFIG_MTD_PHYSMAP_START=0x8000000
> CONFIG_MTD_PHYSMAP_LEN=0
> CONFIG_MTD_PHYSMAP_BANKWIDTH=2
>
Forgive me if this sounds weird, but I was under the impression that
most people who want to reflash their BIOS on x86 (most prominent
physmap usecase on x86) are using a pure userspace solution with
flashrom <http://www.flashrom.org/> nowadays.
flashrom has the advantage of not needing a kernel recompile if you want
support for new chips/chipsets. flashrom doesn't use MTD and accesses
/dev/mem instead. AFAIK flashrom supports BIOS/EFI/... flashing on all
x86 chipsets which are supported by MTD, and on a few other x86 chipsets
(and network/storage/graphics cards) which are not supported by MTD.
Regards,
Carl-Daniel
^ permalink raw reply [flat|nested] 5+ messages in thread
* RE: BUG: physmap modprobe & rmmod
2010-04-02 21:47 ` Randy Dunlap
2010-04-02 22:09 ` Carl-Daniel Hailfinger
@ 2010-04-02 22:16 ` H Hartley Sweeten
2010-04-02 22:41 ` H Hartley Sweeten
1 sibling, 1 reply; 5+ messages in thread
From: H Hartley Sweeten @ 2010-04-02 22:16 UTC (permalink / raw)
To: Randy Dunlap, lkml; +Cc: linux-mtd@lists.infradead.org, David Woodhouse
On Friday, April 02, 2010 2:47 PM, Randy Dunlap wrote:
>> 2.6.34-rc2 kernel:
>>
>> Boot up on a common PC, then: modprobe physmap ; rmmod physmap
>> and bang.
[snip]
> This is with close to an allmodconfig on x86_64, including:
>
> CONFIG_MTD_PHYSMAP=m
> CONFIG_MTD_PHYSMAP_COMPAT=y
> CONFIG_MTD_PHYSMAP_START=0x8000000
> CONFIG_MTD_PHYSMAP_LEN=0
> CONFIG_MTD_PHYSMAP_BANKWIDTH=2
That's probably the cause of the BUG.
If your not run-time calling physmap_configure(), your resource will
be created as:
static struct physmap_flash_data physmap_flash_data = {
.width = CONFIG_MTD_PHYSMAP_BANKWIDTH,
};
static struct resource physmap_flash_resource = {
.start = CONFIG_MTD_PHYSMAP_START,
.end = CONFIG_MTD_PHYSMAP_START + CONFIG_MTD_PHYSMAP_LEN - 1,
.flags = IORESOURCE_MEM,
};
In other words:
static struct physmap_flash_data physmap_flash_data = {
.width = 2,
};
static struct resource physmap_flash_resource = {
.start = 0x8000000,
.end = 0x8000000 + 0 - 1,
.flags = IORESOURCE_MEM,
};
I don't think your even getting into the physmap_flash_probe routine.
Your probably getting the BUG after:
platform_device_register(&physmap_flash);
Which eventually gets to platform_device_add which is giving you the
message:
> [ 127.869454] physmap-flash.0: failed to claim resource 0
Try this patch to see if it fixes your BUG.
---
mtd/maps/physmap: catch failure to register MTD_PHYSMAP_COMPAT device
If the default Kconfig values are used with MTD_PHYSMAP_COMPAT you end
up with a IORESOURCE_MEM of 0 size. This causes platform_device_add
to fail during the platform_device_register call.
Catch this failure during the physmap_init.
Signed-off-by: H Hartley Sweeten <hsweeten@visionengravers.com>
---
diff --git a/drivers/mtd/maps/physmap.c b/drivers/mtd/maps/physmap.c
index d9603f7..426461a 100644
--- a/drivers/mtd/maps/physmap.c
+++ b/drivers/mtd/maps/physmap.c
@@ -264,8 +264,11 @@ static int __init physmap_init(void)
err = platform_driver_register(&physmap_flash_driver);
#ifdef CONFIG_MTD_PHYSMAP_COMPAT
- if (err == 0)
- platform_device_register(&physmap_flash);
+ if (err == 0) {
+ err = platform_device_register(&physmap_flash);
+ if (err)
+ platform_driver_unregister(&physmap_flash_driver);
+ }
#endif
return err;
^ permalink raw reply related [flat|nested] 5+ messages in thread
* RE: BUG: physmap modprobe & rmmod
2010-04-02 22:16 ` H Hartley Sweeten
@ 2010-04-02 22:41 ` H Hartley Sweeten
0 siblings, 0 replies; 5+ messages in thread
From: H Hartley Sweeten @ 2010-04-02 22:41 UTC (permalink / raw)
To: Randy Dunlap, lkml; +Cc: David Woodhouse, linux-mtd@lists.infradead.org
On Friday, April 02, 2010 3:16 PM, H Hartley Sweeten wrote:
> On Friday, April 02, 2010 2:47 PM, Randy Dunlap wrote:
>>> 2.6.34-rc2 kernel:
>>>
>>> Boot up on a common PC, then: modprobe physmap ; rmmod physmap
>>> and bang.
>
> [snip]
>
>> This is with close to an allmodconfig on x86_64, including:
>>
>> CONFIG_MTD_PHYSMAP=m
>> CONFIG_MTD_PHYSMAP_COMPAT=y
>> CONFIG_MTD_PHYSMAP_START=0x8000000
>> CONFIG_MTD_PHYSMAP_LEN=0
>> CONFIG_MTD_PHYSMAP_BANKWIDTH=2
>
> That's probably the cause of the BUG.
>
> If your not run-time calling physmap_configure(), your resource will
> be created as:
>
> static struct physmap_flash_data physmap_flash_data = {
> .width = CONFIG_MTD_PHYSMAP_BANKWIDTH,
> };
>
> static struct resource physmap_flash_resource = {
> .start = CONFIG_MTD_PHYSMAP_START,
> .end = CONFIG_MTD_PHYSMAP_START + CONFIG_MTD_PHYSMAP_LEN - 1,
> .flags = IORESOURCE_MEM,
> };
>
> In other words:
>
> static struct physmap_flash_data physmap_flash_data = {
> .width = 2,
> };
>
> static struct resource physmap_flash_resource = {
> .start = 0x8000000,
> .end = 0x8000000 + 0 - 1,
> .flags = IORESOURCE_MEM,
> };
I traced this down to kernel/resource.c. When __request_resource
is finally called, because of the platform_device_register, it ends
up returning a conflict due to:
resource_size_t start = new->start;
resource_size_t end = new->end;
struct resource *tmp, **p;
if (end < start)
return root;
This ends up causing an -EBUSY error code. The patch below should
be correct to fix this.
I changed the commit message a bit.
---
mtd/maps/physmap: catch failure to register MTD_PHYSMAP_COMPAT device
If the default Kconfig values are used with MTD_PHYSMAP_COMPAT you end
up with a resource where end < start. This causes __request_resource to
return a conflict which then returns an -EBUSY error code. The current
physmap.c code just assumes that the platfom_device_register will always
succeed.
Catch this failure during the physmap_init and propogate the error.
Signed-off-by: H Hartley Sweeten <hsweeten@visionengravers.com>
---
diff --git a/drivers/mtd/maps/physmap.c b/drivers/mtd/maps/physmap.c
index d9603f7..426461a 100644
--- a/drivers/mtd/maps/physmap.c
+++ b/drivers/mtd/maps/physmap.c
@@ -264,8 +264,11 @@ static int __init physmap_init(void)
err = platform_driver_register(&physmap_flash_driver);
#ifdef CONFIG_MTD_PHYSMAP_COMPAT
- if (err == 0)
- platform_device_register(&physmap_flash);
+ if (err == 0) {
+ err = platform_device_register(&physmap_flash);
+ if (err)
+ platform_driver_unregister(&physmap_flash_driver);
+ }
#endif
return err;
______________________________________________________
Linux MTD discussion mailing list
http://lists.infradead.org/mailman/listinfo/linux-mtd/
^ permalink raw reply related [flat|nested] 5+ messages in thread
end of thread, other threads:[~2010-04-02 22:41 UTC | newest]
Thread overview: 5+ messages (download: mbox.gz follow: Atom feed
-- links below jump to the message on this page --
2010-04-02 20:40 BUG: physmap modprobe & rmmod Randy Dunlap
2010-04-02 21:47 ` Randy Dunlap
2010-04-02 22:09 ` Carl-Daniel Hailfinger
2010-04-02 22:16 ` H Hartley Sweeten
2010-04-02 22:41 ` H Hartley Sweeten
This is a public inbox, see mirroring instructions
for how to clone and mirror all data and code used for this inbox;
as well as URLs for NNTP newsgroup(s).