* Ingo Molnar wrote: > * Peter Zijlstra wrote: > > > Subject: mutex: enable spinning for DEBUG_MUTEX > > From: Johannes Weiner > > Date: Thu, 15 Jan 2009 15:57:38 +0100 > > > > Spinning with CONFIG_DEBUG_MUTEX is possible but care must > > be taken with the debug checks vs. racy access to the lock > > owner field. This commit crashed all my testboxes - 32-bit and 64-bit ones alike. One (32-bit) crashlog is below - the hang seems to be around this place: [ 45.056031] [] ? common_interrupt+0x2e/0x34 [ 45.056031] [] ? relay_open_buf+0x24d/0x34f [ 45.056031] [] ? mutex_spin_on_owner+0x8e/0xc1 [ 45.056031] [] ? mutex_lock_nested+0x5e/0x595 [ 45.056031] [] ? trace_hardirqs_on+0xb/0xd [ 45.056031] [] ? kprobe_target+0x0/0x15 [ 45.056031] [] ? register_kprobe+0x19f/0x4f4 Config attached. Ingo [ 0.000000] Linux version 2.6.29-rc5-tip (mingo@venus) (gcc version 4.2.2) #208 SMP Thu Feb 19 12:56:31 CET 2009 [ 0.000000] KERNEL supported cpus: [ 0.000000] Intel GenuineIntel [ 0.000000] AMD AuthenticAMD [ 0.000000] Centaur CentaurHauls [ 0.000000] Transmeta GenuineTMx86 [ 0.000000] Transmeta TransmetaCPU [ 0.000000] UMC UMC UMC UMC [ 0.000000] BIOS-provided physical RAM map: [ 0.000000] BIOS-e820: 0000000000000000 - 000000000009fc00 (usable) [ 0.000000] BIOS-e820: 000000000009fc00 - 00000000000a0000 (reserved) [ 0.000000] BIOS-e820: 00000000000f0000 - 0000000000100000 (reserved) [ 0.000000] BIOS-e820: 0000000000100000 - 000000003fff0000 (usable) [ 0.000000] BIOS-e820: 000000003fff0000 - 000000003fff3000 (ACPI NVS) [ 0.000000] BIOS-e820: 000000003fff3000 - 0000000040000000 (ACPI data) [ 0.000000] BIOS-e820: 00000000fec00000 - 0000000100000000 (reserved) [ 0.000000] console [earlyser0] enabled [ 0.000000] debug: ignoring loglevel setting. [ 0.000000] using polling idle threads. [ 0.000000] DMI 2.3 present. [ 0.000000] last_pfn = 0x3fff0 max_arch_pfn = 0x100000 [ 0.000000] kernel direct mapping tables up to 377fe000 @ 7000-c000 [ 0.000000] 135MB HIGHMEM available. [ 0.000000] 887MB LOWMEM available. [ 0.000000] mapped low ram: 0 - 377fe000 [ 0.000000] low ram: 00000000 - 377fe000 [ 0.000000] bootmap 00008000 - 0000ef00 [ 0.000000] (8 early reservations) ==> bootmem [0000000000 - 00377fe000] [ 0.000000] #0 [0000000000 - 0000001000] BIOS data page ==> [0000000000 - 0000001000] [ 0.000000] #1 [0000001000 - 0000002000] EX TRAMPOLINE ==> [0000001000 - 0000002000] [ 0.000000] #2 [0000006000 - 0000007000] TRAMPOLINE ==> [0000006000 - 0000007000] [ 0.000000] #3 [0000100000 - 00017e683c] TEXT DATA BSS ==> [0000100000 - 00017e683c] [ 0.000000] #4 [00017e7000 - 00017ef000] INIT_PG_TABLE ==> [00017e7000 - 00017ef000] [ 0.000000] #5 [000009f000 - 0000100000] BIOS reserved ==> [000009f000 - 0000100000] [ 0.000000] #6 [0000007000 - 0000008000] PGTABLE ==> [0000007000 - 0000008000] [ 0.000000] #7 [0000008000 - 000000f000] BOOTMAP ==> [0000008000 - 000000f000] [ 0.000000] Scan SMP from c0000000 for 1024 bytes. [ 0.000000] Scan SMP from c009fc00 for 1024 bytes. [ 0.000000] Scan SMP from c00f0000 for 65536 bytes. [ 0.000000] found SMP MP-table at [c00f4f90] f4f90 [ 0.000000] Zone PFN ranges: [ 0.000000] DMA 0x00000000 -> 0x00001000 [ 0.000000] Normal 0x00001000 -> 0x000377fe [ 0.000000] HighMem 0x000377fe -> 0x0003fff0 [ 0.000000] Movable zone start PFN for each node [ 0.000000] early_node_map[2] active PFN ranges [ 0.000000] 0: 0x00000000 -> 0x0000009f [ 0.000000] 0: 0x00000100 -> 0x0003fff0 [ 0.000000] On node 0 totalpages: 262031 [ 0.000000] free_area_init_node: node 0, pgdat c0dee7e0, node_mem_map c17ef000 [ 0.000000] DMA zone: 52 pages used for memmap [ 0.000000] DMA zone: 0 pages reserved [ 0.000000] DMA zone: 3947 pages, LIFO batch:0 [ 0.000000] Normal zone: 2834 pages used for memmap [ 0.000000] Normal zone: 220396 pages, LIFO batch:31 [ 0.000000] HighMem zone: 442 pages used for memmap [ 0.000000] HighMem zone: 34360 pages, LIFO batch:7 [ 0.000000] Using APIC driver default [ 0.000000] Intel MultiProcessor Specification v1.4 [ 0.000000] Virtual Wire compatibility mode. [ 0.000000] MPTABLE: OEM ID: OEM00000 [ 0.000000] MPTABLE: Product ID: PROD00000000 [ 0.000000] MPTABLE: APIC at: 0xFEE00000 [ 0.000000] Processor #0 (Bootup-CPU) [ 0.000000] Processor #1 [ 0.000000] Processor #2 [ 0.000000] Processor #3 [ 0.000000] Bus #0 is PCI [ 0.000000] Bus #1 is PCI [ 0.000000] Bus #2 is PCI [ 0.000000] Bus #3 is PCI [ 0.000000] Bus #4 is PCI [ 0.000000] Bus #5 is ISA [ 0.000000] I/O APIC #4 Version 17 at 0xFEC00000. [ 0.000000] Int: type 0, pol 3, trig 3, bus 00, IRQ 7d, APIC ID 4, APIC INT 11 [ 0.000000] Int: type 0, pol 3, trig 3, bus 00, IRQ 7f, APIC ID 4, APIC INT 13 [ 0.000000] Int: type 0, pol 3, trig 3, bus 00, IRQ 7e, APIC ID 4, APIC INT 17 [ 0.000000] Int: type 0, pol 3, trig 3, bus 00, IRQ 7d, APIC ID 4, APIC INT 11 [ 0.000000] Int: type 0, pol 3, trig 3, bus 01, IRQ 00, APIC ID 4, APIC INT 16 [ 0.000000] Int: type 0, pol 3, trig 3, bus 04, IRQ 1c, APIC ID 4, APIC INT 10 [ 0.000000] Int: type 0, pol 3, trig 3, bus 04, IRQ 0c, APIC ID 4, APIC INT 13 [ 0.000000] Int: type 0, pol 3, trig 3, bus 04, IRQ 10, APIC ID 4, APIC INT 10 [ 0.000000] Int: type 0, pol 3, trig 3, bus 03, IRQ 10, APIC ID 4, APIC INT 12 [ 0.000000] Int: type 0, pol 3, trig 3, bus 03, IRQ 11, APIC ID 4, APIC INT 12 [ 0.000000] Int: type 0, pol 3, trig 3, bus 00, IRQ 7c, APIC ID 4, APIC INT 10 [ 0.000000] Int: type 3, pol 0, trig 0, bus 05, IRQ 00, APIC ID 4, APIC INT 00 [ 0.000000] Int: type 0, pol 0, trig 0, bus 05, IRQ 01, APIC ID 4, APIC INT 01 [ 0.000000] Int: type 0, pol 0, trig 0, bus 05, IRQ 00, APIC ID 4, APIC INT 02 [ 0.000000] Int: type 0, pol 0, trig 0, bus 05, IRQ 03, APIC ID 4, APIC INT 03 [ 0.000000] Int: type 0, pol 0, trig 0, bus 05, IRQ 04, APIC ID 4, APIC INT 04 [ 0.000000] Int: type 0, pol 0, trig 0, bus 05, IRQ 06, APIC ID 4, APIC INT 06 [ 0.000000] Int: type 0, pol 0, trig 0, bus 05, IRQ 07, APIC ID 4, APIC INT 07 [ 0.000000] Int: type 0, pol 1, trig 1, bus 05, IRQ 08, APIC ID 4, APIC INT 08 [ 0.000000] Int: type 0, pol 0, trig 0, bus 05, IRQ 0d, APIC ID 4, APIC INT 0d [ 0.000000] Int: type 0, pol 0, trig 0, bus 05, IRQ 0e, APIC ID 4, APIC INT 0e [ 0.000000] Int: type 0, pol 0, trig 0, bus 05, IRQ 0f, APIC ID 4, APIC INT 0f [ 0.000000] Lint: type 3, pol 0, trig 0, bus 00, IRQ 00, APIC ID ff, APIC LINT 00 [ 0.000000] Lint: type 1, pol 0, trig 0, bus 00, IRQ 00, APIC ID ff, APIC LINT 01 [ 0.000000] Enabling APIC mode: Flat. Using 1 I/O APICs [ 0.000000] Processors: 4 [ 0.000000] SMP: Allowing 4 CPUs, 0 hotplug CPUs [ 0.000000] mapped APIC to ffffb000 (fee00000) [ 0.000000] mapped IOAPIC to ffffa000 (fec00000) [ 0.000000] nr_irqs_gsi: 24 [ 0.000000] Allocating PCI resources starting at 50000000 (gap: 40000000:bec00000) [ 0.000000] NR_CPUS:32 nr_cpumask_bits:32 nr_cpu_ids:4 nr_node_ids:1 [ 0.000000] PERCPU: Allocating 36864 bytes of per cpu data [ 0.000000] Built 1 zonelists in Zone order, mobility grouping on. Total pages: 258703 [ 0.000000] Kernel command line: root=/dev/sda3 debug earlyprintk=serial,ttyS0,115200,keep initcall_debug apic=verbose ignore_loglevel highres=0 nmi_watchdog=0 nolapic_timer idle=mwait idle=poll nopat notsc pci=nomsi [ 0.000000] notsc: Kernel compiled with CONFIG_X86_TSC, cannot disable TSC completely. [ 0.000000] Enabling fast FPU save and restore... done. [ 0.000000] Enabling unmasked SIMD FPU exception support... done. [ 0.000000] Initializing CPU#0 [ 0.000000] RCU-based detection of stalled CPUs is enabled. [ 0.000000] NR_IRQS:2304 nr_irqs:440 [ 0.000000] CPU 0 irqstacks, hard=c10ea000 soft=c10ca000 [ 0.000000] PID hash table entries: 4096 (order: 12, 16384 bytes) [ 0.000000] Fast TSC calibration using PIT [ 0.000000] Detected 2378.879 MHz processor. [ 0.000000] Console: colour VGA+ 80x25 [ 0.000000] console [tty0] 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: 8192 [ 0.000000] ... MAX_LOCKDEP_CHAINS: 16384 [ 0.000000] ... CHAINHASH_SIZE: 8192 [ 0.000000] memory used by lock dependency info: 2847 kB [ 0.000000] per task-struct memory footprint: 1152 bytes [ 0.000000] ------------------------ [ 0.000000] | Locking API testsuite: [ 0.000000] ---------------------------------------------------------------------------- [ 0.000000] | spin |wlock |rlock |mutex | wsem | rsem | [ 0.000000] -------------------------------------------------------------------------- [ 0.000000] A-A deadlock: ok | ok | ok | ok | ok | ok | [ 0.000000] A-B-B-A deadlock: ok | ok | ok | ok | ok | ok | [ 0.000000] A-B-B-C-C-A deadlock: ok | ok | ok | ok | ok | ok | [ 0.000000] A-B-C-A-B-C deadlock: ok | ok | ok | ok | ok | ok | [ 0.000000] A-B-B-C-C-D-D-A deadlock: ok | ok | ok | ok | ok | ok | [ 0.000000] A-B-C-D-B-D-D-A deadlock: ok | ok | ok | ok | ok | ok | [ 0.000000] A-B-C-D-B-C-D-A deadlock: ok | ok | ok | ok | ok | ok | [ 0.000000] double unlock: ok | ok | ok | ok | ok | ok | [ 0.000000] initialize held: ok | ok | ok | ok | ok | ok | [ 0.000000] bad unlock order: ok | ok | ok | ok | ok | ok | [ 0.000000] -------------------------------------------------------------------------- [ 0.000000] recursive read-lock: | ok | | ok | [ 0.000000] recursive read-lock #2: | ok | | ok | [ 0.000000] mixed read-write-lock: | ok | | ok | [ 0.000000] mixed write-read-lock: | ok | | ok | [ 0.000000] -------------------------------------------------------------------------- [ 0.000000] hard-irqs-on + irq-safe-A/12: ok | ok | ok | [ 0.000000] soft-irqs-on + irq-safe-A/12: ok | ok | ok | [ 0.000000] hard-irqs-on + irq-safe-A/21: ok | ok | ok | [ 0.000000] soft-irqs-on + irq-safe-A/21: ok | ok | ok | [ 0.000000] sirq-safe-A => hirqs-on/12: ok | ok | ok | [ 0.000000] sirq-safe-A => hirqs-on/21: ok | ok | ok | [ 0.000000] hard-safe-A + irqs-on/12: ok | ok | ok | [ 0.000000] soft-safe-A + irqs-on/12: ok | ok | ok | [ 0.000000] hard-safe-A + irqs-on/21: ok | ok | ok | [ 0.000000] soft-safe-A + irqs-on/21: ok | ok | ok | [ 0.000000] hard-safe-A + unsafe-B #1/123: ok | ok | ok | [ 0.000000] soft-safe-A + unsafe-B #1/123: ok | ok | ok | [ 0.000000] hard-safe-A + unsafe-B #1/132: ok | ok | ok | [ 0.000000] soft-safe-A + unsafe-B #1/132: ok | ok | ok | [ 0.000000] hard-safe-A + unsafe-B #1/213: ok | ok | ok | [ 0.000000] soft-safe-A + unsafe-B #1/213: ok | ok | ok | [ 0.000000] hard-safe-A + unsafe-B #1/231: ok | ok | ok | [ 0.000000] soft-safe-A + unsafe-B #1/231: ok | ok | ok | [ 0.000000] hard-safe-A + unsafe-B #1/312: ok | ok | ok | [ 0.000000] soft-safe-A + unsafe-B #1/312: ok | ok | ok | [ 0.000000] hard-safe-A + unsafe-B #1/321: ok | ok | ok | [ 0.000000] soft-safe-A + unsafe-B #1/321: ok | ok | ok | [ 0.000000] hard-safe-A + unsafe-B #2/123: ok | ok | ok | [ 0.000000] soft-safe-A + unsafe-B #2/123: ok | ok | ok | [ 0.000000] hard-safe-A + unsafe-B #2/132: ok | ok | ok | [ 0.000000] soft-safe-A + unsafe-B #2/132: ok | ok | ok | [ 0.000000] hard-safe-A + unsafe-B #2/213: ok | ok | ok | [ 0.000000] soft-safe-A + unsafe-B #2/213: ok | ok | ok | [ 0.000000] hard-safe-A + unsafe-B #2/231: ok | ok | ok | [ 0.000000] soft-safe-A + unsafe-B #2/231: ok | ok | ok | [ 0.000000] hard-safe-A + unsafe-B #2/312: ok | ok | ok | [ 0.000000] soft-safe-A + unsafe-B #2/312: ok | ok | ok | [ 0.000000] hard-safe-A + unsafe-B #2/321: ok | ok | ok | [ 0.000000] soft-safe-A + unsafe-B #2/321: ok | ok | ok | [ 0.000000] hard-irq lock-inversion/123: ok | ok | ok | [ 0.000000] soft-irq lock-inversion/123: ok | ok | ok | [ 0.000000] hard-irq lock-inversion/132: ok | ok | ok | [ 0.000000] soft-irq lock-inversion/132: ok | ok | ok | [ 0.000000] hard-irq lock-inversion/213: ok | ok | ok | [ 0.000000] soft-irq lock-inversion/213: ok | ok | ok | [ 0.000000] hard-irq lock-inversion/231: ok | ok | ok | [ 0.000000] soft-irq lock-inversion/231: ok | ok | ok | [ 0.000000] hard-irq lock-inversion/312: ok | ok | ok | [ 0.000000] soft-irq lock-inversion/312: ok | ok | ok | [ 0.000000] hard-irq lock-inversion/321: ok | ok | ok | [ 0.000000] soft-irq lock-inversion/321: ok | ok | ok | [ 0.000000] hard-irq read-recursion/123: ok | [ 0.000000] soft-irq read-recursion/123: ok | [ 0.000000] hard-irq read-recursion/132: ok | [ 0.000000] soft-irq read-recursion/132: ok | [ 0.000000] hard-irq read-recursion/213: ok | [ 0.000000] soft-irq read-recursion/213: ok | [ 0.000000] hard-irq read-recursion/231: ok | [ 0.000000] soft-irq read-recursion/231: ok | [ 0.000000] hard-irq read-recursion/312: ok | [ 0.000000] soft-irq read-recursion/312: ok | [ 0.000000] hard-irq read-recursion/321: ok | [ 0.000000] soft-irq read-recursion/321: ok | [ 0.000000] ------------------------------------------------------- [ 0.000000] Good, all 218 testcases passed! | [ 0.000000] --------------------------------- [ 0.000000] Dentry cache hash table entries: 131072 (order: 7, 524288 bytes) [ 0.000000] Inode-cache hash table entries: 65536 (order: 6, 262144 bytes) [ 0.000000] allocated 5242560 bytes of page_cgroup [ 0.000000] please try cgroup_disable=memory option if you don't want [ 0.000000] Memory: 1004816k/1048512k available (7895k kernel code, 42980k reserved, 7727k data, 508k init, 139208k highmem) [ 0.000000] virtual kernel memory layout: [ 0.000000] fixmap : 0xffe19000 - 0xfffff000 (1944 kB) [ 0.000000] pkmap : 0xff800000 - 0xffc00000 (4096 kB) [ 0.000000] vmalloc : 0xf7ffe000 - 0xff7fe000 ( 120 MB) [ 0.000000] lowmem : 0xc0000000 - 0xf77fe000 ( 887 MB) [ 0.000000] .init : 0xc1048000 - 0xc10c7000 ( 508 kB) [ 0.000000] .data : 0xc08b5f52 - 0xc1041b90 (7727 kB) [ 0.000000] .text : 0xc0100000 - 0xc08b5f52 (7895 kB) [ 0.000000] Checking if this processor honours the WP bit even in supervisor mode...Ok. [ 0.000000] SLUB: Genslabs=12, HWalign=128, Order=0-3, MinObjects=0, CPUs=4, Nodes=1 [ 0.004000] Calibrating delay loop... 3153.92 BogoMIPS (lpj=6307840) [ 0.112000] Security Framework initialized [ 0.116000] SELinux: Initializing. [ 0.120000] SELinux: Starting in enforcing mode [ 0.124000] Mount-cache hash table entries: 512 [ 0.132001] Initializing cgroup subsys ns [ 0.136001] Initializing cgroup subsys cpuacct [ 0.140001] Initializing cgroup subsys memory [ 0.144001] Initializing cgroup subsys devices [ 0.148001] Initializing cgroup subsys freezer [ 0.152001] CPU: Trace cache: 12K uops, L1 D cache: 8K [ 0.160001] CPU: L2 cache: 512K [ 0.160001] [ds] using Netburst configuration [ 0.164001] CPU: Physical Processor ID: 0 [ 0.164001] CPU: Processor Core ID: 0 [ 0.168001] WARNING: polling idle and HT enabled, performance may degrade. [ 0.172001] Checking 'hlt' instruction... OK. [ 0.192001] ftrace: converting mcount calls to 0f 1f 44 00 00 [ 0.196001] ftrace: allocating 19906 entries in 79 pages [ 0.208001] enabled ExtINT on CPU#0 [ 0.212001] ExtINT not setup in hardware but reported by MP table [ 0.216001] ENABLING IO-APIC IRQs [ 0.220001] Setting 4 in the phys_id_present_map [ 0.224001] ...changing IO-APIC physical APIC ID to 4 ... ok. [ 0.228001] init IO_APIC IRQs [ 0.228001] 4-0 (apicid-pin) not connected [ 0.236001] IOAPIC[0]: Set routing entry (4-1 -> 0x31 -> IRQ 1 Mode:0 Active:0) [ 0.240001] IOAPIC[0]: Set routing entry (4-2 -> 0x30 -> IRQ 0 Mode:0 Active:0) [ 0.244001] IOAPIC[0]: Set routing entry (4-3 -> 0x33 -> IRQ 3 Mode:0 Active:0) [ 0.248001] IOAPIC[0]: Set routing entry (4-4 -> 0x34 -> IRQ 4 Mode:0 Active:0) [ 0.252001] 4-5 (apicid-pin) not connected [ 0.256001] IOAPIC[0]: Set routing entry (4-6 -> 0x36 -> IRQ 6 Mode:0 Active:0) [ 0.260001] IOAPIC[0]: Set routing entry (4-7 -> 0x37 -> IRQ 7 Mode:0 Active:0) [ 0.264001] IOAPIC[0]: Set routing entry (4-8 -> 0x38 -> IRQ 8 Mode:0 Active:0) [ 0.268001] 4-9 4-10 4-11 4-12 (apicid-pin) not connected [ 0.276001] IOAPIC[0]: Set routing entry (4-13 -> 0x3d -> IRQ 13 Mode:0 Active:0) [ 0.280001] IOAPIC[0]: Set routing entry (4-14 -> 0x3e -> IRQ 14 Mode:0 Active:0) [ 0.284001] IOAPIC[0]: Set routing entry (4-15 -> 0x3f -> IRQ 15 Mode:0 Active:0) [ 0.288001] alloc irq_desc for 16 on cpu 0 node 0 [ 0.288001] alloc kstat_irqs on cpu 0 node 0 [ 0.292001] IOAPIC[0]: Set routing entry (4-16 -> 0x49 -> IRQ 16 Mode:1 Active:1) [ 0.296001] alloc irq_desc for 17 on cpu 0 node 0 [ 0.296001] alloc kstat_irqs on cpu 0 node 0 [ 0.300001] IOAPIC[0]: Set routing entry (4-17 -> 0x51 -> IRQ 17 Mode:1 Active:1) [ 0.304001] alloc irq_desc for 18 on cpu 0 node 0 [ 0.304001] alloc kstat_irqs on cpu 0 node 0 [ 0.308001] IOAPIC[0]: Set routing entry (4-18 -> 0x59 -> IRQ 18 Mode:1 Active:1) [ 0.312001] alloc irq_desc for 19 on cpu 0 node 0 [ 0.312001] alloc kstat_irqs on cpu 0 node 0 [ 0.316001] IOAPIC[0]: Set routing entry (4-19 -> 0x61 -> IRQ 19 Mode:1 Active:1) [ 0.320001] 4-20 4-21 (apicid-pin) not connected [ 0.324001] alloc irq_desc for 22 on cpu 0 node 0 [ 0.324001] alloc kstat_irqs on cpu 0 node 0 [ 0.328001] IOAPIC[0]: Set routing entry (4-22 -> 0x69 -> IRQ 22 Mode:1 Active:1) [ 0.332001] alloc irq_desc for 23 on cpu 0 node 0 [ 0.332001] alloc kstat_irqs on cpu 0 node 0 [ 0.336001] IOAPIC[0]: Set routing entry (4-23 -> 0x71 -> IRQ 23 Mode:1 Active:1) [ 0.340001] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=0 pin2=0 [ 0.384001] CPU0: Intel(R) XEON(TM) CPU 2.40GHz stepping 04 [ 0.392001] Disabling APIC timer [ 0.400001] calling migration_init+0x0/0x6e @ 1 [ 0.404001] initcall migration_init+0x0/0x6e returned 1 after 0 usecs [ 0.408001] initcall migration_init+0x0/0x6e returned with error code 1 [ 0.412001] calling spawn_ksoftirqd+0x0/0x6a @ 1 [ 0.416001] initcall spawn_ksoftirqd+0x0/0x6a returned 0 after 0 usecs [ 0.420001] calling init_call_single_data+0x0/0x6b @ 1 [ 0.424001] initcall init_call_single_data+0x0/0x6b returned 0 after 0 usecs [ 0.428001] calling spawn_softlockup_task+0x0/0x79 @ 1 [ 0.432001] initcall spawn_softlockup_task+0x0/0x79 returned 0 after 0 usecs [ 0.436001] calling relay_init+0x0/0x11 @ 1 [ 0.440001] initcall relay_init+0x0/0x11 returned 0 after 0 usecs [ 0.444001] calling tracer_alloc_buffers+0x0/0x179 @ 1 [ 0.456001] initcall tracer_alloc_buffers+0x0/0x179 returned 0 after 7812 usecs [ 0.460001] calling perf_counter_init+0x0/0x27 @ 1 [ 0.464001] initcall perf_counter_init+0x0/0x27 returned 0 after 0 usecs [ 0.468001] lockdep: fixing up alternatives. [ 0.472001] CPU 1 irqstacks, hard=c10eb000 soft=c10cb000 [ 0.476001] Booting processor 1 APIC 0x1 ip 0x6000 [ 0.004000] Initializing CPU#1 [ 0.004000] masked ExtINT on CPU#1 [ 0.004000] Calibrating delay loop... 3170.30 BogoMIPS (lpj=6340608) [ 0.004000] CPU: Trace cache: 12K uops, L1 D cache: 8K [ 0.004000] CPU: L2 cache: 512K [ 0.004000] [ds] using Netburst configuration [ 0.004000] CPU: Physical Processor ID: 3 [ 0.004000] CPU: Processor Core ID: 0 [ 0.004000] WARNING: polling idle and HT enabled, performance may degrade. [ 0.596001] CPU1: Intel(R) XEON(TM) CPU 2.40GHz stepping 04 [ 0.604001] checking TSC synchronization [CPU#0 -> CPU#1]: passed. [ 0.612001] lockdep: fixing up alternatives. [ 0.616001] CPU 2 irqstacks, hard=c10ec000 soft=c10cc000 [ 0.620001] Booting processor 2 APIC 0x2 ip 0x6000 [ 0.004000] Initializing CPU#2 [ 0.004000] masked ExtINT on CPU#2 [ 0.004000] Calibrating delay loop... 1585.15 BogoMIPS (lpj=3170304) [ 0.004000] CPU: Trace cache: 12K uops, L1 D cache: 8K [ 0.004000] CPU: L2 cache: 512K [ 0.004000] [ds] using Netburst configuration [ 0.004000] CPU: Physical Processor ID: 0 [ 0.004000] CPU: Processor Core ID: 0 [ 0.004000] WARNING: polling idle and HT enabled, performance may degrade. [ 0.736002] CPU2: Intel(R) XEON(TM) CPU 2.40GHz stepping 04 [ 0.744002] checking TSC synchronization [CPU#0 -> CPU#2]: passed. [ 0.752002] lockdep: fixing up alternatives. [ 0.756002] CPU 3 irqstacks, hard=c10ed000 soft=c10cd000 [ 0.760002] Booting processor 3 APIC 0x3 ip 0x6000 [ 0.004000] Initializing CPU#3 [ 0.004000] masked ExtINT on CPU#3 [ 0.004000] Calibrating delay loop... 2342.91 BogoMIPS (lpj=4685824) [ 0.004000] CPU: Trace cache: 12K uops, L1 D cache: 8K [ 0.004000] CPU: L2 cache: 512K [ 0.004000] [ds] using Netburst configuration [ 0.004000] CPU: Physical Processor ID: 3 [ 0.004000] CPU: Processor Core ID: 0 [ 0.004000] WARNING: polling idle and HT enabled, performance may degrade. [ 0.876002] CPU3: Intel(R) XEON(TM) CPU 2.40GHz stepping 04 [ 0.884002] checking TSC synchronization [CPU#0 -> CPU#3]: passed. [ 0.888002] Brought up 4 CPUs [ 0.892002] Total of 4 processors activated (10252.28 BogoMIPS). [ 0.896002] device: 'platform': device_add [ 0.900002] PM: Adding info for No Bus:platform [ 0.904002] khelper used greatest stack depth: 2696 bytes left [ 0.904002] bus: 'platform': registered [ 0.904002] Registering sysdev class 'cpu' [ 0.908002] calling init_cpufreq_transition_notifier_list+0x0/0x18 @ 1 [ 0.908002] initcall init_cpufreq_transition_notifier_list+0x0/0x18 returned 0 after 0 usecs [ 0.908002] calling net_ns_init+0x0/0xd1 @ 1 [ 0.908002] net_namespace: 1164 bytes [ 0.908002] initcall net_ns_init+0x0/0xd1 returned 0 after 0 usecs [ 0.908002] calling cpufreq_tsc+0x0/0x41 @ 1 [ 0.908002] initcall cpufreq_tsc+0x0/0x41 returned 0 after 0 usecs [ 0.908002] calling reboot_init+0x0/0x11 @ 1 [ 0.908002] initcall reboot_init+0x0/0x11 returned 0 after 0 usecs [ 0.908002] calling print_banner+0x0/0xd @ 1 [ 0.908002] Booting paravirtualized kernel on bare hardware [ 0.908002] initcall print_banner+0x0/0xd returned 0 after 0 usecs [ 0.908002] calling init_smp_flush+0x0/0x2f @ 1 [ 0.908002] initcall init_smp_flush+0x0/0x2f returned 0 after 0 usecs [ 0.908002] calling alloc_frozen_cpus+0x0/0x12 @ 1 [ 0.908002] initcall alloc_frozen_cpus+0x0/0x12 returned 0 after 0 usecs [ 0.908002] calling sysctl_init+0x0/0x13 @ 1 [ 0.908002] initcall sysctl_init+0x0/0x13 returned 0 after 0 usecs [ 0.908002] calling ksysfs_init+0x0/0x101 @ 1 [ 0.968002] initcall ksysfs_init+0x0/0x101 returned 0 after 58593 usecs [ 0.968002] calling async_init+0x0/0x96 @ 1 [ 0.968002] initcall async_init+0x0/0x96 returned 0 after 0 usecs [ 0.968002] calling init_jiffies_clocksource+0x0/0xf @ 1 [ 0.968002] initcall init_jiffies_clocksource+0x0/0xf returned 0 after 0 usecs [ 0.968002] calling pm_init+0x0/0x37 @ 1 [ 0.968002] initcall pm_init+0x0/0x37 returned 0 after 0 usecs [ 0.968002] calling filelock_init+0x0/0x27 @ 1 [ 0.968002] initcall filelock_init+0x0/0x27 returned 0 after 0 usecs [ 0.968002] calling init_aout_binfmt+0x0/0xf @ 1 [ 0.968002] initcall init_aout_binfmt+0x0/0xf returned 0 after 0 usecs [ 0.968002] calling init_misc_binfmt+0x0/0x4f @ 1 [ 0.968002] initcall init_misc_binfmt+0x0/0x4f returned 0 after 0 usecs [ 0.968002] calling init_script_binfmt+0x0/0xf @ 1 [ 0.968002] initcall init_script_binfmt+0x0/0xf returned 0 after 0 usecs [ 0.968002] calling init_elf_binfmt+0x0/0xf @ 1 [ 0.968002] initcall init_elf_binfmt+0x0/0xf returned 0 after 0 usecs [ 0.968002] calling debugfs_init+0x0/0x5d @ 1 [ 0.968002] initcall debugfs_init+0x0/0x5d returned 0 after 0 usecs [ 0.968002] calling securityfs_init+0x0/0x5d @ 1 [ 0.968002] initcall securityfs_init+0x0/0x5d returned 0 after 0 usecs [ 0.968002] calling random32_init+0x0/0xbc @ 1 [ 0.968002] initcall random32_init+0x0/0xbc returned 0 after 0 usecs [ 0.968002] calling regulator_init+0x0/0x23 @ 1 [ 0.968002] regulator: core version 0.5 [ 0.968002] device class 'regulator': registering [ 1.164003] initcall regulator_init+0x0/0x23 returned 0 after 191406 usecs [ 1.168003] calling cpufreq_core_init+0x0/0x72 @ 1 [ 1.172003] initcall cpufreq_core_init+0x0/0x72 returned 0 after 0 usecs [ 1.176003] calling virtio_init+0x0/0x30 @ 1 [ 1.180003] bus: 'virtio': registered [ 1.184003] initcall virtio_init+0x0/0x30 returned 0 after 3906 usecs [ 1.188003] calling sock_init+0x0/0x65 @ 1 [ 1.192003] initcall sock_init+0x0/0x65 returned 0 after 0 usecs [ 1.196003] calling net_inuse_init+0x0/0x2b @ 1 [ 1.200003] initcall net_inuse_init+0x0/0x2b returned 0 after 0 usecs [ 1.204003] calling netpoll_init+0x0/0x39 @ 1 [ 1.208003] initcall netpoll_init+0x0/0x39 returned 0 after 0 usecs [ 1.212003] calling netlink_proto_init+0x0/0x165 @ 1 [ 1.216003] NET: Registered protocol family 16 [ 1.224003] initcall netlink_proto_init+0x0/0x165 returned 0 after 7812 usecs [ 1.228003] calling bdi_class_init+0x0/0x35 @ 1 [ 1.236003] device class 'bdi': registering [ 1.240003] initcall bdi_class_init+0x0/0x35 returned 0 after 3906 usecs [ 1.244003] calling kobject_uevent_init+0x0/0x4b @ 1 [ 1.248003] initcall kobject_uevent_init+0x0/0x4b returned 0 after 0 usecs [ 1.252003] calling gpiolib_sysfs_init+0x0/0x90 @ 1 [ 1.256003] device class 'gpio': registering [ 1.260003] initcall gpiolib_sysfs_init+0x0/0x90 returned 0 after 3906 usecs [ 1.264003] calling pcibus_class_init+0x0/0x14 @ 1 [ 1.268003] device class 'pci_bus': registering [ 1.272003] initcall pcibus_class_init+0x0/0x14 returned 0 after 3906 usecs [ 1.276003] calling pci_driver_init+0x0/0xf @ 1 [ 1.280003] bus: 'pci': registered [ 1.284003] initcall pci_driver_init+0x0/0xf returned 0 after 3906 usecs [ 1.288003] calling backlight_class_init+0x0/0x7c @ 1 [ 1.292003] device class 'backlight': registering [ 1.296003] initcall backlight_class_init+0x0/0x7c returned 0 after 3906 usecs [ 1.300003] calling video_output_class_init+0x0/0x14 @ 1 [ 1.304003] device class 'video_output': registering [ 1.308003] initcall video_output_class_init+0x0/0x14 returned 0 after 3906 usecs [ 1.312003] calling tty_class_init+0x0/0x4e @ 1 [ 1.316003] device class 'tty': registering [ 1.320003] initcall tty_class_init+0x0/0x4e returned 0 after 3906 usecs [ 1.324003] calling vtconsole_class_init+0x0/0x125 @ 1 [ 1.328003] device class 'vtconsole': registering [ 1.332003] device: 'vtcon0': device_add [ 1.336003] PM: Adding info for No Bus:vtcon0 [ 1.340003] initcall vtconsole_class_init+0x0/0x125 returned 0 after 11718 usecs [ 1.344003] calling i2c_init+0x0/0x7e @ 1 [ 1.348003] bus: 'i2c': registered [ 1.352003] device class 'i2c-adapter': registering [ 1.360003] bus: 'i2c': add driver dummy [ 1.364003] i2c-core: driver [dummy] registered [ 1.368003] initcall i2c_init+0x0/0x7e returned 0 after 19531 usecs [ 1.372003] calling lguest_devices_init+0x0/0x187 @ 1 [ 1.376003] initcall lguest_devices_init+0x0/0x187 returned 0 after 0 usecs [ 1.380003] calling amd_postcore_init+0x0/0x95 @ 1 [ 1.384003] initcall amd_postcore_init+0x0/0x95 returned 0 after 0 usecs [ 1.388003] calling arch_kdebugfs_init+0x0/0x356 @ 1 [ 1.392003] initcall arch_kdebugfs_init+0x0/0x356 returned 0 after 0 usecs [ 1.396003] calling init_pit_clocksource+0x0/0xaa @ 1 [ 1.400003] initcall init_pit_clocksource+0x0/0xaa returned 0 after 0 usecs [ 1.404003] calling kdump_buf_page_init+0x0/0x6d @ 1 [ 1.408003] initcall kdump_buf_page_init+0x0/0x6d returned 0 after 0 usecs [ 1.412003] calling dmi_id_init+0x0/0x3d0 @ 1 [ 1.416003] device class 'dmi': registering [ 1.424003] device: 'id': device_add [ 1.424003] PM: Adding info for No Bus:id [ 1.432003] initcall dmi_id_init+0x0/0x3d0 returned 0 after 15625 usecs [ 1.436003] calling dma_bus_init+0x0/0x32 @ 1 [ 1.440003] device class 'dma': registering [ 1.444003] initcall dma_bus_init+0x0/0x32 returned 0 after 3906 usecs [ 1.448003] calling dma_channel_table_init+0x0/0x113 @ 1 [ 1.452003] initcall dma_channel_table_init+0x0/0x113 returned 0 after 0 usecs [ 1.456003] calling dca_init+0x0/0x19 @ 1 [ 1.460003] dca service started, version 1.8 [ 1.464003] device class 'dca': registering [ 1.468003] initcall dca_init+0x0/0x19 returned 0 after 7812 usecs [ 1.472003] calling pci_arch_init+0x0/0x6a @ 1 [ 1.476003] PCI: PCI BIOS revision 2.10 entry at 0xfb3b0, last bus=4 [ 1.480003] PCI: Using configuration type 1 for base access [ 1.484003] initcall pci_arch_init+0x0/0x6a returned 0 after 7812 usecs [ 1.488003] calling topology_init+0x0/0x49 @ 1 [ 1.492003] Registering sys device of class 'cpu' [ 1.496003] Registering sys device 'cpu0' [ 1.500003] Registering sys device of class 'cpu' [ 1.504003] Registering sys device 'cpu1' [ 1.508003] Registering sys device of class 'cpu' [ 1.512003] Registering sys device 'cpu2' [ 1.516003] Registering sys device of class 'cpu' [ 1.520003] Registering sys device 'cpu3' [ 1.524003] initcall topology_init+0x0/0x49 returned 0 after 31250 usecs [ 1.528003] calling mca_init+0x0/0x430 @ 1 [ 1.532003] bus: 'MCA': registered [ 1.536003] initcall mca_init+0x0/0x430 returned -19 after 3906 usecs [ 1.540003] calling param_sysfs_init+0x0/0x27c @ 1 [ 1.728004] initcall param_sysfs_init+0x0/0x27c returned 0 after 179687 usecs [ 1.732004] calling pm_sysrq_init+0x0/0x1b @ 1 [ 1.736004] initcall pm_sysrq_init+0x0/0x1b returned 0 after 0 usecs [ 1.740004] calling readahead_init+0x0/0x3d @ 1 [ 1.748004] device: 'default': device_add [ 1.752004] PM: Adding info for No Bus:default [ 1.756004] initcall readahead_init+0x0/0x3d returned 0 after 7812 usecs [ 1.760004] calling init_bio+0x0/0x101 @ 1 [ 1.764004] bio: create slab at 0 [ 1.768004] initcall init_bio+0x0/0x101 returned 0 after 3906 usecs [ 1.772004] calling integrity_init+0x0/0x43 @ 1 [ 1.776004] initcall integrity_init+0x0/0x43 returned 0 after 0 usecs [ 1.780004] calling cryptomgr_init+0x0/0x45 @ 1 [ 1.784004] initcall cryptomgr_init+0x0/0x45 returned 0 after 0 usecs [ 1.788004] calling blk_settings_init+0x0/0x1d @ 1 [ 1.792004] initcall blk_settings_init+0x0/0x1d returned 0 after 0 usecs [ 1.796004] calling blk_ioc_init+0x0/0x24 @ 1 [ 1.800004] initcall blk_ioc_init+0x0/0x24 returned 0 after 0 usecs [ 1.804004] calling blk_softirq_init+0x0/0x6e @ 1 [ 1.808004] initcall blk_softirq_init+0x0/0x6e returned 0 after 0 usecs [ 1.812004] calling genhd_device_init+0x0/0x77 @ 1 [ 1.820004] device class 'block': registering [ 1.824004] initcall genhd_device_init+0x0/0x77 returned 0 after 3906 usecs [ 1.828004] calling blk_dev_integrity_init+0x0/0x24 @ 1 [ 1.832004] initcall blk_dev_integrity_init+0x0/0x24 returned 0 after 0 usecs [ 1.836004] calling gpiolib_debugfs_init+0x0/0x1f @ 1 [ 1.840004] initcall gpiolib_debugfs_init+0x0/0x1f returned 0 after 0 usecs [ 1.844004] calling pca953x_init+0x0/0x11 @ 1 [ 1.848004] bus: 'i2c': add driver pca953x [ 1.852004] i2c-core: driver [pca953x] registered [ 1.856004] initcall pca953x_init+0x0/0x11 returned 0 after 7812 usecs [ 1.860004] calling pci_slot_init+0x0/0x4c @ 1 [ 1.864004] initcall pci_slot_init+0x0/0x4c returned 0 after 0 usecs [ 1.868004] calling pnp_init+0x0/0xf @ 1 [ 1.876004] bus: 'pnp': registered [ 1.876004] initcall pnp_init+0x0/0xf returned 0 after 3906 usecs [ 1.880004] calling misc_init+0x0/0xba @ 1 [ 1.884004] device class 'misc': registering [ 1.888004] initcall misc_init+0x0/0xba returned 0 after 3906 usecs [ 1.892004] calling phy_init+0x0/0x45 @ 1 [ 1.896004] device class 'mdio_bus': registering [ 1.900004] bus: 'mdio_bus': registered [ 1.904004] bus: 'mdio_bus': add driver Generic PHY [ 1.908004] initcall phy_init+0x0/0x45 returned 0 after 11718 usecs [ 1.912004] calling init_scsi+0x0/0xe1 @ 1 [ 1.916004] device class 'scsi_host': registering [ 1.924004] bus: 'scsi': registered [ 1.924004] device class 'scsi_device': registering [ 1.928004] SCSI subsystem initialized [ 1.932004] initcall init_scsi+0x0/0xe1 returned 0 after 15625 usecs [ 1.936004] calling ata_init+0x0/0x39e @ 1 [ 1.944004] libata version 3.00 loaded. [ 1.948004] initcall ata_init+0x0/0x39e returned 0 after 7812 usecs [ 1.952004] calling init_pcmcia_cs+0x0/0x28 @ 1 [ 1.956004] device class 'pcmcia_socket': registering [ 1.960004] initcall init_pcmcia_cs+0x0/0x28 returned 0 after 3906 usecs [ 1.964004] calling usb_init+0x0/0x1e2 @ 1 [ 1.968004] bus: 'usb': registered [ 1.972004] device class 'usb_host': registering [ 1.980004] bus: 'usb': add driver usbfs [ 1.984004] usbcore: registered new interface driver usbfs [ 1.988004] device class 'usb_device': registering [ 1.992004] bus: 'usb': add driver hub [ 1.996004] usbcore: registered new interface driver hub [ 2.000004] bus: 'usb': add driver usb [ 2.004004] usbcore: registered new device driver usb [ 2.008004] initcall usb_init+0x0/0x1e2 returned 0 after 39062 usecs [ 2.012004] calling serio_init+0x0/0xc1 @ 1 [ 2.016004] bus: 'serio': registered [ 2.020004] initcall serio_init+0x0/0xc1 returned 0 after 3906 usecs [ 2.024004] calling gameport_init+0x0/0xc1 @ 1 [ 2.028004] bus: 'gameport': registered [ 2.032004] initcall gameport_init+0x0/0xc1 returned 0 after 3906 usecs [ 2.036004] calling input_init+0x0/0x136 @ 1 [ 2.040004] device class 'input': registering [ 2.048004] initcall input_init+0x0/0x136 returned 0 after 7812 usecs [ 2.052004] calling power_supply_class_init+0x0/0x55 @ 1 [ 2.056004] device class 'power_supply': registering [ 2.060004] initcall power_supply_class_init+0x0/0x55 returned 0 after 3906 usecs [ 2.064004] calling leds_init+0x0/0x5c @ 1 [ 2.068004] device class 'leds': registering [ 2.072004] initcall leds_init+0x0/0x5c returned 0 after 3906 usecs [ 2.076004] calling ac97_bus_init+0x0/0xf @ 1 [ 2.080004] bus: 'ac97': registered [ 2.084004] initcall ac97_bus_init+0x0/0xf returned 0 after 3906 usecs [ 2.088004] calling pci_subsys_init+0x0/0x135 @ 1 [ 2.092004] PCI: Probing PCI hardware [ 2.096004] PCI: Probing PCI hardware (bus 00) [ 2.104004] device: 'pci0000:00': device_add [ 2.108004] PM: Adding info for No Bus:pci0000:00 [ 2.112004] device: '0000:00': device_add [ 2.116004] PM: Adding info for No Bus:0000:00 [ 2.120004] PCI: Scanning bus 0000:00 [ 2.124004] pci 0000:00:00.0: found [8086:2531] class 000600 header type 00 [ 2.128004] pci 0000:00:00.0: reg 10 32bit mmio: [0xd8000000-0xdbffffff] [ 2.132004] pci 0000:00:01.0: found [8086:2532] class 000604 header type 01 [ 2.136004] pci 0000:00:02.0: found [8086:2533] class 000604 header type 01 [ 2.140004] pci 0000:00:1e.0: found [8086:244e] class 000604 header type 01 [ 2.144004] pci 0000:00:1f.0: found [8086:2440] class 000601 header type 00 [ 2.152004] pci 0000:00:1f.1: found [8086:244b] class 000101 header type 00 [ 2.156004] pci 0000:00:1f.1: reg 20 io port: [0xf000-0xf00f] [ 2.160004] pci 0000:00:1f.2: found [8086:2442] class 000c03 header type 00 [ 2.168004] pci 0000:00:1f.2: reg 20 io port: [0xd000-0xd01f] [ 2.172004] pci 0000:00:1f.3: found [8086:2443] class 000c05 header type 00 [ 2.176004] pci 0000:00:1f.3: reg 20 io port: [0x500-0x50f] [ 2.180004] pci 0000:00:1f.4: found [8086:2444] class 000c03 header type 00 [ 2.184004] pci 0000:00:1f.4: reg 20 io port: [0xd800-0xd81f] [ 2.188004] pci 0000:00:1f.5: found [8086:2445] class 000401 header type 00 [ 2.192004] pci 0000:00:1f.5: reg 10 io port: [0xdc00-0xdcff] [ 2.196004] pci 0000:00:1f.5: reg 14 io port: [0xe000-0xe03f] [ 2.200004] PCI: Fixups for bus 0000:00 [ 2.204004] pci 0000:00:01.0: scanning behind bridge, config 010100, pass 0 [ 2.208004] PCI: Scanning bus 0000:01 [ 2.212005] pci 0000:01:00.0: found [1002:5157] class 000300 header type 00 [ 2.216005] pci 0000:01:00.0: reg 10 32bit mmio: [0xd0000000-0xd7ffffff] [ 2.220005] pci 0000:01:00.0: reg 14 io port: [0xa000-0xa0ff] [ 2.224005] pci 0000:01:00.0: reg 18 32bit mmio: [0xdd000000-0xdd00ffff] [ 2.228005] pci 0000:01:00.0: reg 30 32bit mmio: [0x000000-0x01ffff] [ 2.232005] pci 0000:01:00.0: supports D1 D2 [ 2.236005] PCI: Fixups for bus 0000:01 [ 2.240005] pci 0000:00:01.0: bridge io port: [0xa000-0xafff] [ 2.244005] pci 0000:00:01.0: bridge 32bit mmio: [0xdc000000-0xddffffff] [ 2.248005] pci 0000:00:01.0: bridge 32bit mmio pref: [0xd0000000-0xd7ffffff] [ 2.252005] PCI: Bus scan for 0000:01 returning with max=01 [ 2.256005] pci 0000:00:02.0: scanning behind bridge, config 030200, pass 0 [ 2.260005] PCI: Scanning bus 0000:02 [ 2.264005] pci 0000:02:1f.0: found [8086:1360] class 000604 header type 01 [ 2.268005] PCI: Fixups for bus 0000:02 [ 2.272005] pci 0000:00:02.0: bridge io port: [0xb000-0xbfff] [ 2.276005] pci 0000:00:02.0: bridge 32bit mmio: [0xde000000-0xdfffffff] [ 2.280005] pci 0000:02:1f.0: scanning behind bridge, config 030302, pass 0 [ 2.284005] PCI: Scanning bus 0000:03 [ 2.288005] pci 0000:03:00.0: found [8086:1161] class 000800 header type 00 [ 2.292005] pci 0000:03:00.0: reg 10 32bit mmio: [0xdf001000-0xdf001fff] [ 2.296005] pci 0000:03:04.0: found [9005:00cf] class 000100 header type 00 [ 2.300005] pci 0000:03:04.0: reg 10 io port: [0xb000-0xb0ff] [ 2.304005] pci 0000:03:04.0: reg 14 64bit mmio: [0xdf000000-0xdf000fff] [ 2.308005] pci 0000:03:04.0: reg 30 32bit mmio: [0x000000-0x01ffff] [ 2.312005] pci 0000:03:04.1: found [9005:00cf] class 000100 header type 00 [ 2.316005] pci 0000:03:04.1: reg 10 io port: [0xb400-0xb4ff] [ 2.320005] pci 0000:03:04.1: reg 14 64bit mmio: [0xdf002000-0xdf002fff] [ 2.324005] pci 0000:03:04.1: reg 30 32bit mmio: [0x000000-0x01ffff] [ 2.328005] PCI: Fixups for bus 0000:03 [ 2.332005] pci 0000:02:1f.0: bridge io port: [0xb000-0xbfff] [ 2.336005] pci 0000:02:1f.0: bridge 32bit mmio: [0xde000000-0xdfffffff] [ 2.340005] PCI: Bus scan for 0000:03 returning with max=03 [ 2.344005] pci 0000:02:1f.0: scanning behind bridge, config 030302, pass 1 [ 2.348005] PCI: Bus scan for 0000:02 returning with max=03 [ 2.352005] pci 0000:00:1e.0: scanning behind bridge, config 040400, pass 0 [ 2.356005] PCI: Scanning bus 0000:04 [ 2.360005] pci 0000:04:03.0: found [8086:1229] class 000200 header type 00 [ 2.364005] pci 0000:04:03.0: reg 10 32bit mmio: [0xe1241000-0xe1241fff] [ 2.368005] pci 0000:04:03.0: reg 14 io port: [0xc000-0xc03f] [ 2.372005] pci 0000:04:03.0: reg 18 32bit mmio: [0xe1000000-0xe10fffff] [ 2.376005] pci 0000:04:03.0: reg 30 32bit mmio: [0x000000-0x0fffff] [ 2.380005] pci 0000:04:03.0: supports D1 D2 [ 2.384005] pci 0000:04:03.0: PME# supported from D0 D1 D2 D3hot D3cold [ 2.388005] pci 0000:04:03.0: PME# disabled [ 2.392005] pci 0000:04:04.0: found [8086:1229] class 000200 header type 00 [ 2.396005] pci 0000:04:04.0: reg 10 32bit mmio: [0xe1240000-0xe1240fff] [ 2.400005] pci 0000:04:04.0: reg 14 io port: [0xc400-0xc43f] [ 2.404005] pci 0000:04:04.0: reg 18 32bit mmio: [0xe1100000-0xe11fffff] [ 2.408005] pci 0000:04:04.0: reg 30 32bit mmio: [0x000000-0x0fffff] [ 2.416005] pci 0000:04:04.0: supports D1 D2 [ 2.420005] pci 0000:04:04.0: PME# supported from D0 D1 D2 D3hot D3cold [ 2.424005] pci 0000:04:04.0: PME# disabled [ 2.428005] pci 0000:04:07.0: found [8086:100c] class 000200 header type 00 [ 2.432005] pci 0000:04:07.0: reg 10 32bit mmio: [0xe1200000-0xe121ffff] [ 2.436005] pci 0000:04:07.0: reg 14 32bit mmio: [0xe1220000-0xe123ffff] [ 2.440005] pci 0000:04:07.0: reg 18 io port: [0xc800-0xc81f] [ 2.444005] pci 0000:04:07.0: reg 30 32bit mmio: [0x000000-0x01ffff] [ 2.448005] pci 0000:04:07.0: PME# supported from D0 D3hot D3cold [ 2.452005] pci 0000:04:07.0: PME# disabled [ 2.456005] PCI: Fixups for bus 0000:04 [ 2.460005] pci 0000:00:1e.0: bridge io port: [0xc000-0xcfff] [ 2.464005] pci 0000:00:1e.0: bridge 32bit mmio: [0xe0000000-0xe1ffffff] [ 2.468005] PCI: Bus scan for 0000:04 returning with max=04 [ 2.472005] pci 0000:00:01.0: scanning behind bridge, config 010100, pass 1 [ 2.476005] pci 0000:00:02.0: scanning behind bridge, config 030200, pass 1 [ 2.480005] pci 0000:00:1e.0: scanning behind bridge, config 040400, pass 1 [ 2.484005] PCI: Bus scan for 0000:00 returning with max=04 [ 2.488005] device: '0000:00:00.0': device_add [ 2.492005] bus: 'pci': add device 0000:00:00.0 [ 2.496005] PM: Adding info for pci:0000:00:00.0 [ 2.500005] device: '0000:00:01.0': device_add [ 2.504005] bus: 'pci': add device 0000:00:01.0 [ 2.508005] PM: Adding info for pci:0000:00:01.0 [ 2.512005] device: '0000:00:02.0': device_add [ 2.516005] bus: 'pci': add device 0000:00:02.0 [ 2.520005] PM: Adding info for pci:0000:00:02.0 [ 2.524005] device: '0000:00:1e.0': device_add [ 2.528005] bus: 'pci': add device 0000:00:1e.0 [ 2.532005] PM: Adding info for pci:0000:00:1e.0 [ 2.536005] device: '0000:00:1f.0': device_add [ 2.540005] bus: 'pci': add device 0000:00:1f.0 [ 2.548005] PM: Adding info for pci:0000:00:1f.0 [ 2.552005] device: '0000:00:1f.1': device_add [ 2.556005] bus: 'pci': add device 0000:00:1f.1 [ 2.560005] PM: Adding info for pci:0000:00:1f.1 [ 2.564005] device: '0000:00:1f.2': device_add [ 2.568005] bus: 'pci': add device 0000:00:1f.2 [ 2.572005] PM: Adding info for pci:0000:00:1f.2 [ 2.576005] device: '0000:00:1f.3': device_add [ 2.580005] bus: 'pci': add device 0000:00:1f.3 [ 2.584005] PM: Adding info for pci:0000:00:1f.3 [ 2.588005] device: '0000:00:1f.4': device_add [ 2.592005] bus: 'pci': add device 0000:00:1f.4 [ 2.596005] PM: Adding info for pci:0000:00:1f.4 [ 2.600005] device: '0000:00:1f.5': device_add [ 2.604005] bus: 'pci': add device 0000:00:1f.5 [ 2.608005] PM: Adding info for pci:0000:00:1f.5 [ 2.612005] device: '0000:01:00.0': device_add [ 2.620005] bus: 'pci': add device 0000:01:00.0 [ 2.624005] PM: Adding info for pci:0000:01:00.0 [ 2.628005] device: '0000:01': device_add [ 2.632005] PM: Adding info for No Bus:0000:01 [ 2.636005] device: '0000:02:1f.0': device_add [ 2.640005] bus: 'pci': add device 0000:02:1f.0 [ 2.644005] PM: Adding info for pci:0000:02:1f.0 [ 2.648005] device: '0000:03:00.0': device_add [ 2.652005] bus: 'pci': add device 0000:03:00.0 [ 2.656005] PM: Adding info for pci:0000:03:00.0 [ 2.660005] device: '0000:03:04.0': device_add [ 2.664005] bus: 'pci': add device 0000:03:04.0 [ 2.668005] PM: Adding info for pci:0000:03:04.0 [ 2.672005] device: '0000:03:04.1': device_add [ 2.676005] bus: 'pci': add device 0000:03:04.1 [ 2.680005] PM: Adding info for pci:0000:03:04.1 [ 2.684005] device: '0000:03': device_add [ 2.688005] PM: Adding info for No Bus:0000:03 [ 2.692005] device: '0000:02': device_add [ 2.696005] PM: Adding info for No Bus:0000:02 [ 2.700005] device: '0000:04:03.0': device_add [ 2.704005] bus: 'pci': add device 0000:04:03.0 [ 2.708005] PM: Adding info for pci:0000:04:03.0 [ 2.712005] device: '0000:04:04.0': device_add [ 2.716005] bus: 'pci': add device 0000:04:04.0 [ 2.720005] PM: Adding info for pci:0000:04:04.0 [ 2.724005] device: '0000:04:07.0': device_add [ 2.728005] bus: 'pci': add device 0000:04:07.0 [ 2.732005] PM: Adding info for pci:0000:04:07.0 [ 2.736005] device: '0000:04': device_add [ 2.740005] PM: Adding info for No Bus:0000:04 [ 2.748005] pci 0000:00:1f.0: PIIX/ICH IRQ router [8086:2440] [ 2.752005] pci 0000:00:1f.2: PCI->APIC IRQ transform: INT D -> IRQ 19 [ 2.756005] pci 0000:00:1f.3: PCI->APIC IRQ transform: INT B -> IRQ 17 [ 2.760005] pci 0000:00:1f.4: PCI->APIC IRQ transform: INT C -> IRQ 23 [ 2.764005] pci 0000:00:1f.5: PCI->APIC IRQ transform: INT B -> IRQ 17 [ 2.768005] pci 0000:01:00.0: PCI->APIC IRQ transform: INT A -> IRQ 22 [ 2.772005] pci 0000:03:04.0: PCI->APIC IRQ transform: INT A -> IRQ 18 [ 2.776005] pci 0000:03:04.1: PCI->APIC IRQ transform: INT B -> IRQ 18 [ 2.780006] pci 0000:04:03.0: PCI->APIC IRQ transform: INT A -> IRQ 19 [ 2.784006] pci 0000:04:04.0: PCI->APIC IRQ transform: INT A -> IRQ 16 [ 2.788006] pci 0000:04:07.0: PCI->APIC IRQ transform: INT A -> IRQ 16 [ 2.792006] initcall pci_subsys_init+0x0/0x135 returned 0 after 683594 usecs [ 2.796006] calling proto_init+0x0/0xf @ 1 [ 2.800006] initcall proto_init+0x0/0xf returned 0 after 0 usecs [ 2.804006] calling net_dev_init+0x0/0x1c2 @ 1 [ 2.808006] device class 'net': registering [ 2.812006] device: 'lo': device_add [ 2.816006] PM: Adding info for No Bus:lo [ 2.824006] initcall net_dev_init+0x0/0x1c2 returned 0 after 15625 usecs [ 2.828006] calling neigh_init+0x0/0x66 @ 1 [ 2.832006] initcall neigh_init+0x0/0x66 returned 0 after 0 usecs [ 2.836006] calling pktsched_init+0x0/0xa9 @ 1 [ 2.840006] initcall pktsched_init+0x0/0xa9 returned 0 after 0 usecs [ 2.844006] calling tc_filter_init+0x0/0x43 @ 1 [ 2.848006] initcall tc_filter_init+0x0/0x43 returned 0 after 0 usecs [ 2.852006] calling tc_action_init+0x0/0x43 @ 1 [ 2.856006] initcall tc_action_init+0x0/0x43 returned 0 after 0 usecs [ 2.860006] calling genl_init+0x0/0xe7 @ 1 [ 2.880006] initcall genl_init+0x0/0xe7 returned 0 after 15625 usecs [ 2.884006] calling cipso_v4_init+0x0/0x8f @ 1 [ 2.888006] initcall cipso_v4_init+0x0/0x8f returned 0 after 0 usecs [ 2.892006] calling wanrouter_init+0x0/0x50 @ 1 [ 2.896006] Sangoma WANPIPE Router v1.1 (c) 1995-2000 Sangoma Technologies Inc. [ 2.900006] initcall wanrouter_init+0x0/0x50 returned 0 after 3906 usecs [ 2.904006] calling wireless_nlevent_init+0x0/0x39 @ 1 [ 2.908006] initcall wireless_nlevent_init+0x0/0x39 returned 0 after 0 usecs [ 2.912006] calling cfg80211_init+0x0/0xa4 @ 1 [ 2.916006] device class 'ieee80211': registering [ 2.936006] Registering platform device 'regulatory.0'. Parent at platform [ 2.940006] device: 'regulatory.0': device_add [ 2.944006] bus: 'platform': add device regulatory.0 [ 2.948006] PM: Adding info for platform:regulatory.0 [ 2.952006] cfg80211: Using static regulatory domain info [ 2.956006] cfg80211: Regulatory domain: US [ 2.960006] (start_freq - end_freq @ bandwidth), (max_antenna_gain, max_eirp) [ 2.964006] (2402000 KHz - 2472000 KHz @ 40000 KHz), (600 mBi, 2700 mBm) [ 2.968006] (5170000 KHz - 5190000 KHz @ 40000 KHz), (600 mBi, 2300 mBm) [ 2.972006] (5190000 KHz - 5210000 KHz @ 40000 KHz), (600 mBi, 2300 mBm) [ 2.976006] (5210000 KHz - 5230000 KHz @ 40000 KHz), (600 mBi, 2300 mBm) [ 2.980006] (5230000 KHz - 5330000 KHz @ 40000 KHz), (600 mBi, 2300 mBm) [ 2.984006] (5735000 KHz - 5835000 KHz @ 40000 KHz), (600 mBi, 3000 mBm) [ 2.988006] cfg80211: Calling CRDA for country: US [ 2.992006] initcall cfg80211_init+0x0/0xa4 returned 0 after 74218 usecs [ 2.996006] calling ieee80211_init+0x0/0xc @ 1 [ 3.000006] initcall ieee80211_init+0x0/0xc returned 0 after 0 usecs [ 3.004006] calling netlbl_init+0x0/0xa6 @ 1 [ 3.008006] NetLabel: Initializing [ 3.012006] NetLabel: domain hash size = 128 [ 3.016006] NetLabel: protocols = UNLABELED CIPSOv4 [ 3.020006] NetLabel: unlabeled traffic allowed by default [ 3.024006] initcall netlbl_init+0x0/0xa6 returned 0 after 15625 usecs [ 3.028006] calling sysctl_init+0x0/0x49 @ 1 [ 3.032006] initcall sysctl_init+0x0/0x49 returned 0 after 0 usecs [ 3.036006] calling pci_iommu_init+0x0/0xc @ 1 [ 3.040006] initcall pci_iommu_init+0x0/0xc returned 0 after 0 usecs [ 3.044006] calling print_all_ICs+0x0/0x4ce @ 1 [ 3.048006] [ 3.048006] printing PIC contents [ 3.052006] ... PIC IMR: fffb [ 3.052006] ... PIC IRR: 0001 [ 3.056006] ... PIC ISR: 0000 [ 3.056006] ... PIC ELCR: 1e20 [ 3.060006] [ 3.060006] printing local APIC contents on CPU#0/0: [ 3.060006] ... APIC ID: 00000000 (0) [ 3.060006] ... APIC VERSION: 00050014 [ 3.060006] ... APIC TASKPRI: 00000000 (00) [ 3.060006] ... APIC PROCPRI: 00000000 [ 3.060006] ... APIC LDR: 01000000 [ 3.060006] ... APIC DFR: ffffffff [ 3.060006] ... APIC SPIV: 000001ff [ 3.060006] ... APIC ISR field: [ 3.060006] 0123456789abcdef0123456789abcdef [ 3.060006] 00000000000000000000000000000000 [ 3.060006] 00000000000000000000000000000000 [ 3.060006] 00000000000000000000000000000000 [ 3.060006] 00000000000000000000000000000000 [ 3.060006] 00000000000000000000000000000000 [ 3.060006] 00000000000000000000000000000000 [ 3.060006] 00000000000000000000000000000000 [ 3.060006] 00000000000000000000000000000000 [ 3.060006] ... APIC TMR field: [ 3.060006] 0123456789abcdef0123456789abcdef [ 3.060006] 00000000000000000000000000000000 [ 3.060006] 00000000000000000000000000000000 [ 3.060006] 00000000000000000000000000000000 [ 3.060006] 00000000000000000000000000000000 [ 3.060006] 00000000000000000000000000000000 [ 3.060006] 00000000000000000000000000000000 [ 3.060006] 00000000000000000000000000000000 [ 3.060006] 00000000000000000000000000000000 [ 3.060006] ... APIC IRR field: [ 3.060006] 0123456789abcdef0123456789abcdef [ 3.060006] 00000000000000000000000000000000 [ 3.060006] 00000000000000001000000000000000 [ 3.060006] 00000000000000000000000000000000 [ 3.060006] 00000000000000000000000000000000 [ 3.060006] 00000000000000000000000000000000 [ 3.060006] 00000000000000000000000000000000 [ 3.060006] 00000000000000000000000000000000 [ 3.060006] 00000000000000000000000000000000 [ 3.060006] ... APIC ESR: 00000000 [ 3.060006] ... APIC ICR: 000008ef [ 3.060006] ... APIC ICR2: 0e000000 [ 3.060006] ... APIC LVTT: 000100ef [ 3.060006] ... APIC LVTPC: 00010000 [ 3.060006] ... APIC LVT0: 00010700 [ 3.060006] ... APIC LVT1: 00000400 [ 3.060006] ... APIC LVTERR: 000000fe [ 3.060006] ... APIC TMICT: 00000000 [ 3.060006] ... APIC TMCCT: 00000000 [ 3.060006] ... APIC TDCR: 00000000 [ 3.060006] [ 3.064006] [ 3.064006] printing local APIC contents on CPU#1/1: [ 3.068006] ... APIC ID: 01000000 (1) [ 3.068006] ... APIC VERSION: 00050014 [ 3.068006] ... APIC TASKPRI: 00000000 (00) [ 3.068006] ... APIC PROCPRI: 00000000 [ 3.068006] ... APIC LDR: 02000000 [ 3.068006] ... APIC DFR: ffffffff [ 3.068006] ... APIC SPIV: 000001ff [ 3.068006] ... APIC ISR field: [ 3.068006] 0123456789abcdef0123456789abcdef [ 3.068006] 00000000000000000000000000000000 [ 3.068006] 00000000000000000000000000000000 [ 3.068006] 00000000000000000000000000000000 [ 3.068006] 00000000000000000000000000000000 [ 3.068006] 00000000000000000000000000000000 [ 3.068006] 00000000000000000000000000000000 [ 3.068006] 00000000000000000000000000000000 [ 3.068006] 00000000000000000000000000000000 [ 3.068006] ... APIC TMR field: [ 3.068006] 0123456789abcdef0123456789abcdef [ 3.068006] 00000000000000000000000000000000 [ 3.068006] 00000000000000000000000000000000 [ 3.068006] 00000000000000000000000000000000 [ 3.068006] 00000000000000000000000000000000 [ 3.068006] 00000000000000000000000000000000 [ 3.068006] 00000000000000000000000000000000 [ 3.068006] 00000000000000000000000000000000 [ 3.068006] 00000000000000000000000000000000 [ 3.068006] ... APIC IRR field: [ 3.068006] 0123456789abcdef0123456789abcdef [ 3.068006] 00000000000000000000000000000000 [ 3.068006] 00000000000000000000000000000000 [ 3.068006] 00000000000000000000000000000000 [ 3.068006] 00000000000000000000000000000000 [ 3.068006] 00000000000000000000000000000000 [ 3.068006] 00000000000000000000000000000000 [ 3.068006] 00000000000000000000000000000000 [ 3.068006] 00000000000000010000000000000000 [ 3.068006] ... APIC ESR: 00000000 [ 3.068006] ... APIC ICR: 00000000 [ 3.068006] ... APIC ICR2: 00000000 [ 3.068006] ... APIC LVTT: 000100ef [ 3.068006] ... APIC LVTPC: 00010000 [ 3.068006] ... APIC LVT0: 00010700 [ 3.068006] ... APIC LVT1: 00010400 [ 3.068006] ... APIC LVTERR: 000000fe [ 3.068006] ... APIC TMICT: 00000000 [ 3.068006] ... APIC TMCCT: 00000000 [ 3.068006] ... APIC TDCR: 00000000 [ 3.068006] [ 3.260006] [ 3.260006] printing local APIC contents on CPU#2/2: [ 3.264007] ... APIC ID: 02000000 (2) [ 3.264007] ... APIC VERSION: 00050014 [ 3.264007] ... APIC TASKPRI: 00000000 (00) [ 3.264007] ... APIC PROCPRI: 00000000 [ 3.264007] ... APIC LDR: 04000000 [ 3.264007] ... APIC DFR: ffffffff [ 3.264007] ... APIC SPIV: 000001ff [ 3.264007] ... APIC ISR field: [ 3.264007] 0123456789abcdef0123456789abcdef [ 3.264007] 00000000000000000000000000000000 [ 3.264007] 00000000000000000000000000000000 [ 3.264007] 00000000000000000000000000000000 [ 3.264007] 00000000000000000000000000000000 [ 3.264007] 00000000000000000000000000000000 [ 3.264007] 00000000000000000000000000000000 [ 3.264007] 00000000000000000000000000000000 [ 3.264007] 00000000000000000000000000000000 [ 3.264007] ... APIC TMR field: [ 3.264007] 0123456789abcdef0123456789abcdef [ 3.264007] 00000000000000000000000000000000 [ 3.264007] 00000000000000000000000000000000 [ 3.264007] 00000000000000000000000000000000 [ 3.264007] 00000000000000000000000000000000 [ 3.264007] 00000000000000000000000000000000 [ 3.264007] 00000000000000000000000000000000 [ 3.264007] 00000000000000000000000000000000 [ 3.264007] 00000000000000000000000000000000 [ 3.264007] ... APIC IRR field: [ 3.264007] 0123456789abcdef0123456789abcdef [ 3.264007] 00000000000000000000000000000000 [ 3.264007] 00000000000000000000000000000000 [ 3.264007] 00000000000000000000000000000000 [ 3.264007] 00000000000000000000000000000000 [ 3.264007] 00000000000000000000000000000000 [ 3.264007] 00000000000000000000000000000000 [ 3.264007] 00000000000000000000000000000000 [ 3.264007] 00000000000000010000000000000000 [ 3.264007] ... APIC ESR: 00000000 [ 3.264007] ... APIC ICR: 00000000 [ 3.264007] ... APIC ICR2: 00000000 [ 3.264007] ... APIC LVTT: 000100ef [ 3.264007] ... APIC LVTPC: 00010000 [ 3.264007] ... APIC LVT0: 00010700 [ 3.264007] ... APIC LVT1: 00010400 [ 3.264007] ... APIC LVTERR: 000000fe [ 3.264007] ... APIC TMICT: 00000000 [ 3.264007] ... APIC TMCCT: 00000000 [ 3.264007] ... APIC TDCR: 00000000 [ 3.264007] [ 3.460007] [ 3.460007] printing local APIC contents on CPU#3/3: [ 3.464007] ... APIC ID: 03000000 (3) [ 3.464007] ... APIC VERSION: 00050014 [ 3.464007] ... APIC TASKPRI: 00000000 (00) [ 3.464007] ... APIC PROCPRI: 00000000 [ 3.464007] ... APIC LDR: 08000000 [ 3.464007] ... APIC DFR: ffffffff [ 3.464007] ... APIC SPIV: 000001ff [ 3.464007] ... APIC ISR field: [ 3.464007] 0123456789abcdef0123456789abcdef [ 3.464007] 00000000000000000000000000000000 [ 3.464007] 00000000000000000000000000000000 [ 3.464007] 00000000000000000000000000000000 [ 3.464007] 00000000000000000000000000000000 [ 3.464007] 00000000000000000000000000000000 [ 3.464007] 00000000000000000000000000000000 [ 3.464007] 00000000000000000000000000000000 [ 3.464007] 00000000000000000000000000000000 [ 3.464007] ... APIC TMR field: [ 3.464007] 0123456789abcdef0123456789abcdef [ 3.464007] 00000000000000000000000000000000 [ 3.464007] 00000000000000000000000000000000 [ 3.464007] 00000000000000000000000000000000 [ 3.464007] 00000000000000000000000000000000 [ 3.464007] 00000000000000000000000000000000 [ 3.464007] 00000000000000000000000000000000 [ 3.464007] 00000000000000000000000000000000 [ 3.464007] 00000000000000000000000000000000 [ 3.464007] ... APIC IRR field: [ 3.464007] 0123456789abcdef0123456789abcdef [ 3.464007] 00000000000000000000000000000000 [ 3.464007] 00000000000000000000000000000000 [ 3.464007] 00000000000000000000000000000000 [ 3.464007] 00000000000000000000000000000000 [ 3.464007] 00000000000000000000000000000000 [ 3.464007] 00000000000000000000000000000000 [ 3.464007] 00000000000000000000000000000000 [ 3.464007] 00000000000000010000000000000000 [ 3.464007] ... APIC ESR: 00000000 [ 3.464007] ... APIC ICR: 00000000 [ 3.464007] ... APIC ICR2: 00000000 [ 3.464007] ... APIC LVTT: 000100ef [ 3.464007] ... APIC LVTPC: 00010000 [ 3.464007] ... APIC LVT0: 00010700 [ 3.464007] ... APIC LVT1: 00010400 [ 3.464007] ... APIC LVTERR: 000000fe [ 3.464007] ... APIC TMICT: 00000000 [ 3.464007] ... APIC TMCCT: 00000000 [ 3.464007] ... APIC TDCR: 00000000 [ 3.464007] [ 3.656007] number of MP IRQ sources: 21. [ 3.660007] number of IO-APIC #4 registers: 24. [ 3.664007] testing the IO APIC....................... [ 3.668007] [ 3.672007] IO APIC #4...... [ 3.672007] .... register #00: 04000000 [ 3.676007] ....... : physical APIC id: 04 [ 3.680007] ....... : Delivery Type: 0 [ 3.684007] ....... : LTS : 0 [ 3.688007] .... register #01: 00178020 [ 3.692007] ....... : max redirection entries: 0017 [ 3.696007] ....... : PRQ implemented: 1 [ 3.700007] ....... : IO APIC version: 0020 [ 3.704007] .... register #02: 00000000 [ 3.708007] ....... : arbitration: 00 [ 3.712007] .... register #03: 00000001 [ 3.716007] ....... : Boot DT : 1 [ 3.720007] .... IRQ redirection table: [ 3.724007] NR Dst Mask Trig IRR Pol Stat Dmod Deli Vect: [ 3.728007] 00 000 1 0 0 0 0 0 0 00 [ 3.732007] 01 00F 0 0 0 0 0 1 1 31 [ 3.740007] 02 00F 0 0 0 0 0 1 1 30 [ 3.744007] 03 00F 0 0 0 0 0 1 1 33 [ 3.748007] 04 00F 0 0 0 0 0 1 1 34 [ 3.756007] 05 000 1 0 0 0 0 0 0 00 [ 3.760007] 06 00F 0 0 0 0 0 1 1 36 [ 3.764007] 07 00F 0 0 0 0 0 1 1 37 [ 3.772007] 08 00F 0 0 0 0 0 1 1 38 [ 3.776007] 09 000 1 0 0 0 0 0 0 00 [ 3.780007] 0a 000 1 0 0 0 0 0 0 00 [ 3.784007] 0b 000 1 0 0 0 0 0 0 00 [ 3.792007] 0c 000 1 0 0 0 0 0 0 00 [ 3.796007] 0d 00F 0 0 0 0 0 1 1 3D [ 3.800007] 0e 00F 0 0 0 0 0 1 1 3E [ 3.808007] 0f 00F 0 0 0 0 0 1 1 3F [ 3.812007] 10 00F 1 1 0 1 0 1 1 49 [ 3.816007] 11 00F 1 1 0 1 0 1 1 51 [ 3.824007] 12 00F 1 1 0 1 0 1 1 59 [ 3.828007] 13 00F 1 1 0 1 0 1 1 61 [ 3.832007] 14 000 1 0 0 0 0 0 0 00 [ 3.836007] 15 000 1 0 0 0 0 0 0 00 [ 3.844007] 16 00F 1 1 0 1 0 1 1 69 [ 3.848007] 17 00F 1 1 0 1 0 1 1 71 [ 3.852007] IRQ to pin mappings: [ 3.856007] IRQ0 -> 0:2 [ 3.860007] IRQ1 -> 0:1 [ 3.860007] IRQ3 -> 0:3 [ 3.864007] IRQ4 -> 0:4 [ 3.868007] IRQ6 -> 0:6 [ 3.868007] IRQ7 -> 0:7 [ 3.872007] IRQ8 -> 0:8 [ 3.872007] IRQ13 -> 0:13 [ 3.876007] IRQ14 -> 0:14 [ 3.880007] IRQ15 -> 0:15 [ 3.880007] IRQ16 -> 0:16 [ 3.884007] IRQ17 -> 0:17 [ 3.888007] IRQ18 -> 0:18 [ 3.888007] IRQ19 -> 0:19 [ 3.892007] IRQ22 -> 0:22 [ 3.896007] IRQ23 -> 0:23 [ 3.896007] .................................... done. [ 3.900007] initcall print_all_ICs+0x0/0x4ce returned 0 after 832032 usecs [ 3.904007] calling init_kmmio+0x0/0x23 @ 1 [ 3.908007] initcall init_kmmio+0x0/0x23 returned 0 after 0 usecs [ 3.912007] calling clocksource_done_booting+0x0/0x11 @ 1 [ 3.916007] initcall clocksource_done_booting+0x0/0x11 returned 0 after 0 usecs [ 3.920007] calling ftrace_init_debugfs+0x0/0xe7 @ 1 [ 3.924007] initcall ftrace_init_debugfs+0x0/0xe7 returned 0 after 0 usecs [ 3.928007] calling rb_init_debugfs+0x0/0x38 @ 1 [ 3.932007] initcall rb_init_debugfs+0x0/0x38 returned 0 after 0 usecs [ 3.936007] calling tracer_init_debugfs+0x0/0x272 @ 1 [ 3.940007] initcall tracer_init_debugfs+0x0/0x272 returned 0 after 0 usecs [ 3.944007] calling all_annotated_branch_stats+0x0/0x27 @ 1 [ 3.948007] Warning: could not register all branches stats [ 3.952007] initcall all_annotated_branch_stats+0x0/0x27 returned 1 after 3906 usecs [ 3.956007] initcall all_annotated_branch_stats+0x0/0x27 returned with error code 1 [ 3.960007] calling init_annotated_branch_stats+0x0/0x27 @ 1 [ 3.964007] Warning: could not register annotated branches stats [ 3.968007] initcall init_annotated_branch_stats+0x0/0x27 returned 1 after 3906 usecs [ 3.972007] initcall init_annotated_branch_stats+0x0/0x27 returned with error code 1 [ 3.976008] calling init_pipe_fs+0x0/0x76 @ 1 [ 3.980008] initcall init_pipe_fs+0x0/0x76 returned 0 after 0 usecs [ 3.984008] calling init_mnt_writers+0x0/0x7d @ 1 [ 3.988008] initcall init_mnt_writers+0x0/0x7d returned 0 after 0 usecs [ 3.992008] calling eventpoll_init+0x0/0x98 @ 1 [ 3.996008] initcall eventpoll_init+0x0/0x98 returned 0 after 0 usecs [ 4.000008] calling anon_inode_init+0x0/0x15b @ 1 [ 4.004008] initcall anon_inode_init+0x0/0x15b returned 0 after 0 usecs [ 4.008008] calling pnpbios_init+0x0/0x46a @ 1 [ 4.012008] PnPBIOS: Scanning system for PnP BIOS support... [ 4.020008] PnPBIOS: Found PnP BIOS installation structure at 0xc00fbe20 [ 4.024008] PnPBIOS: PnP BIOS version 1.0, entry 0xf0000:0xbe50, dseg 0xf0000 [ 4.028008] device: 'pnp0': device_add [ 4.032008] PM: Adding info for No Bus:pnp0 [ 4.036008] device: '00:00': device_add [ 4.040008] bus: 'pnp': add device 00:00 [ 4.044008] PM: Adding info for pnp:00:00 [ 4.048008] device: '00:01': device_add [ 4.052008] bus: 'pnp': add device 00:01 [ 4.056008] PM: Adding info for pnp:00:01 [ 4.060008] device: '00:02': device_add [ 4.064008] bus: 'pnp': add device 00:02 [ 4.068008] PM: Adding info for pnp:00:02 [ 4.072008] device: '00:03': device_add [ 4.076008] bus: 'pnp': add device 00:03 [ 4.080008] PM: Adding info for pnp:00:03 [ 4.084008] device: '00:04': device_add [ 4.088008] bus: 'pnp': add device 00:04 [ 4.092008] PM: Adding info for pnp:00:04 [ 4.096008] device: '00:05': device_add [ 4.100008] bus: 'pnp': add device 00:05 [ 4.104008] PM: Adding info for pnp:00:05 [ 4.112008] device: '00:06': device_add [ 4.116008] bus: 'pnp': add device 00:06 [ 4.120008] PM: Adding info for pnp:00:06 [ 4.124008] device: '00:07': device_add [ 4.128008] bus: 'pnp': add device 00:07 [ 4.132008] PM: Adding info for pnp:00:07 [ 4.136008] pnp 00:08: mem resource (0x0-0x9ffff) overlaps 0000:04:03.0 BAR 6 (0x0-0xfffff), disabling [ 4.140008] pnp 00:08: mem resource (0x0-0x9ffff) overlaps 0000:04:04.0 BAR 6 (0x0-0xfffff), disabling [ 4.144008] device: '00:08': device_add [ 4.148008] bus: 'pnp': add device 00:08 [ 4.152008] PM: Adding info for pnp:00:08 [ 4.160008] pnp 00:09: mem resource (0xf0000-0xf3fff) overlaps 0000:04:03.0 BAR 6 (0x0-0xfffff), disabling [ 4.164008] pnp 00:09: mem resource (0xf4000-0xf7fff) overlaps 0000:04:03.0 BAR 6 (0x0-0xfffff), disabling [ 4.168008] pnp 00:09: mem resource (0xf8000-0xfffff) overlaps 0000:04:03.0 BAR 6 (0x0-0xfffff), disabling [ 4.172008] pnp 00:09: mem resource (0xd5800-0xd7fff) overlaps 0000:04:03.0 BAR 6 (0x0-0xfffff), disabling [ 4.176008] pnp 00:09: mem resource (0xf0000-0xf3fff) overlaps 0000:04:04.0 BAR 6 (0x0-0xfffff), disabling [ 4.180008] pnp 00:09: mem resource (0xf4000-0xf7fff) overlaps 0000:04:04.0 BAR 6 (0x0-0xfffff), disabling [ 4.184008] pnp 00:09: mem resource (0xf8000-0xfffff) overlaps 0000:04:04.0 BAR 6 (0x0-0xfffff), disabling [ 4.188008] pnp 00:09: mem resource (0xd5800-0xd7fff) overlaps 0000:04:04.0 BAR 6 (0x0-0xfffff), disabling [ 4.192008] device: '00:09': device_add [ 4.196008] bus: 'pnp': add device 00:09 [ 4.200008] PM: Adding info for pnp:00:09 [ 4.204008] device: '00:0a': device_add [ 4.208008] bus: 'pnp': add device 00:0a [ 4.212008] PM: Adding info for pnp:00:0a [ 4.216008] device: '00:0c': device_add [ 4.220008] bus: 'pnp': add device 00:0c [ 4.224008] PM: Adding info for pnp:00:0c [ 4.228008] device: '00:0d': device_add [ 4.232008] bus: 'pnp': add device 00:0d [ 4.236008] PM: Adding info for pnp:00:0d [ 4.240008] device: '00:0f': device_add [ 4.244008] bus: 'pnp': add device 00:0f [ 4.248008] PM: Adding info for pnp:00:0f [ 4.252008] device: '00:10': device_add [ 4.256008] bus: 'pnp': add device 00:10 [ 4.260008] PM: Adding info for pnp:00:10 [ 4.268008] PnPBIOS: 15 nodes reported by PnP BIOS; 15 recorded by driver [ 4.272008] initcall pnpbios_init+0x0/0x46a returned 0 after 253906 usecs [ 4.276008] calling pnp_system_init+0x0/0xf @ 1 [ 4.280008] bus: 'pnp': add driver system [ 4.284008] bus: 'pnp': driver_probe_device: matched device 00:08 with driver system [ 4.288008] bus: 'pnp': really_probe: probing driver system with device 00:08 [ 4.292008] system 00:08: iomem range 0xffb00000-0xffb7ffff has been reserved [ 4.296008] system 00:08: iomem range 0xfff00000-0xffffffff has been reserved [ 4.300008] system 00:08: iomem range 0xfec00000-0xfecfffff has been reserved [ 4.304008] system 00:08: iomem range 0xfee00000-0xfee0ffff has been reserved [ 4.308008] system 00:08: iomem range 0x100000-0xffffff could not be reserved [ 4.312008] driver: '00:08': driver_bound: bound to device 'system' [ 4.316008] bus: 'pnp': really_probe: bound device 00:08 to driver system [ 4.320008] bus: 'pnp': driver_probe_device: matched device 00:09 with driver system [ 4.324008] bus: 'pnp': really_probe: probing driver system with device 00:09 [ 4.328008] driver: '00:09': driver_bound: bound to device 'system' [ 4.332008] bus: 'pnp': really_probe: bound device 00:09 to driver system [ 4.336008] initcall pnp_system_init+0x0/0xf returned 0 after 54687 usecs [ 4.340008] calling chr_dev_init+0x0/0xa7 @ 1 [ 4.344008] device class 'mem': registering [ 4.348008] device: 'mem': device_add [ 4.352008] PM: Adding info for No Bus:mem [ 4.356008] device: 'null': device_add [ 4.360008] PM: Adding info for No Bus:null [ 4.368008] device: 'port': device_add [ 4.372008] PM: Adding info for No Bus:port [ 4.376008] device: 'zero': device_add [ 4.380008] PM: Adding info for No Bus:zero [ 4.384008] device: 'full': device_add [ 4.388008] PM: Adding info for No Bus:full [ 4.392008] device: 'random': device_add [ 4.396008] PM: Adding info for No Bus:random [ 4.400008] device: 'urandom': device_add [ 4.404008] PM: Adding info for No Bus:urandom [ 4.408008] device: 'kmsg': device_add [ 4.412008] PM: Adding info for No Bus:kmsg [ 4.416008] device: 'oldmem': device_add [ 4.420008] PM: Adding info for No Bus:oldmem [ 4.424008] initcall chr_dev_init+0x0/0xa7 returned 0 after 78125 usecs [ 4.428008] calling firmware_class_init+0x0/0x7b @ 1 [ 4.432008] device class 'firmware': registering [ 4.436008] initcall firmware_class_init+0x0/0x7b returned 0 after 3906 usecs [ 4.440008] calling cpufreq_gov_performance_init+0x0/0xf @ 1 [ 4.444008] initcall cpufreq_gov_performance_init+0x0/0xf returned 0 after 0 usecs [ 4.448008] calling ssb_modinit+0x0/0x7d @ 1 [ 4.452008] bus: 'ssb': registered [ 4.456008] bus: 'pci': add driver b43-pci-bridge [ 4.460008] initcall ssb_modinit+0x0/0x7d returned 0 after 7812 usecs [ 4.464008] calling pcibios_assign_resources+0x0/0xa5 @ 1 [ 4.468008] pci 0000:01:00.0: BAR 6: got res [0xdc000000-0xdc01ffff] bus [0xdc000000-0xdc01ffff] flags 0x27200 [ 4.472008] pci 0000:00:01.0: PCI bridge, secondary bus 0000:01 [ 4.476008] pci 0000:00:01.0: IO window: 0xa000-0xafff [ 4.484008] pci 0000:00:01.0: MEM window: 0xdc000000-0xddffffff [ 4.488008] pci 0000:00:01.0: PREFETCH window: 0x000000d0000000-0x000000d7ffffff [ 4.492008] pci 0000:03:04.0: BAR 6: got res [0x50000000-0x5001ffff] bus [0x50000000-0x5001ffff] flags 0x27200 [ 4.496008] pci 0000:03:04.1: BAR 6: got res [0x50020000-0x5003ffff] bus [0x50020000-0x5003ffff] flags 0x27200 [ 4.500008] pci 0000:02:1f.0: PCI bridge, secondary bus 0000:03 [ 4.504008] pci 0000:02:1f.0: IO window: 0xb000-0xbfff [ 4.508008] pci 0000:02:1f.0: MEM window: 0xde000000-0xdfffffff [ 4.512008] pci 0000:02:1f.0: PREFETCH window: 0x00000050000000-0x000000500fffff [ 4.516008] pci 0000:00:02.0: PCI bridge, secondary bus 0000:02 [ 4.520008] pci 0000:00:02.0: IO window: 0xb000-0xbfff [ 4.524008] pci 0000:00:02.0: MEM window: 0xde000000-0xdfffffff [ 4.528008] pci 0000:00:02.0: PREFETCH window: 0x00000050000000-0x000000500fffff [ 4.532008] pci 0000:04:03.0: BAR 6: got res [0x50100000-0x501fffff] bus [0x50100000-0x501fffff] flags 0x27200 [ 4.536008] pci 0000:04:04.0: BAR 6: got res [0x50200000-0x502fffff] bus [0x50200000-0x502fffff] flags 0x27200 [ 4.540008] pci 0000:04:07.0: BAR 6: got res [0x50300000-0x5031ffff] bus [0x50300000-0x5031ffff] flags 0x27200 [ 4.544008] pci 0000:00:1e.0: PCI bridge, secondary bus 0000:04 [ 4.548008] pci 0000:00:1e.0: IO window: 0xc000-0xcfff [ 4.552008] pci 0000:00:1e.0: MEM window: 0xe0000000-0xe1ffffff [ 4.556008] pci 0000:00:1e.0: PREFETCH window: 0x00000050100000-0x000000503fffff [ 4.560008] pci 0000:02:1f.0: setting latency timer to 64 [ 4.564008] pci 0000:00:1e.0: setting latency timer to 64 [ 4.568008] pci_bus 0000:00: resource 0 io: [0x00-0xffff] [ 4.572008] pci_bus 0000:00: resource 1 mem: [0x000000-0xffffffff] [ 4.576008] pci_bus 0000:01: resource 0 io: [0xa000-0xafff] [ 4.580008] pci_bus 0000:01: resource 1 mem: [0xdc000000-0xddffffff] [ 4.584008] pci_bus 0000:01: resource 2 mem: [0xd0000000-0xd7ffffff] [ 4.588008] pci_bus 0000:01: resource 3 mem: [0x0-0x0] [ 4.592008] pci_bus 0000:02: resource 0 io: [0xb000-0xbfff] [ 4.596008] pci_bus 0000:02: resource 1 mem: [0xde000000-0xdfffffff] [ 4.600008] pci_bus 0000:02: resource 2 mem: [0x50000000-0x500fffff] [ 4.604008] pci_bus 0000:02: resource 3 mem: [0x0-0x0] [ 4.608008] pci_bus 0000:03: resource 0 io: [0xb000-0xbfff] [ 4.612009] pci_bus 0000:03: resource 1 mem: [0xde000000-0xdfffffff] [ 4.616009] pci_bus 0000:03: resource 2 mem: [0x50000000-0x500fffff] [ 4.620009] pci_bus 0000:03: resource 3 mem: [0x0-0x0] [ 4.624009] pci_bus 0000:04: resource 0 io: [0xc000-0xcfff] [ 4.628009] pci_bus 0000:04: resource 1 mem: [0xe0000000-0xe1ffffff] [ 4.632009] pci_bus 0000:04: resource 2 mem: [0x50100000-0x503fffff] [ 4.636009] pci_bus 0000:04: resource 3 mem: [0x0-0x0] [ 4.640009] initcall pcibios_assign_resources+0x0/0xa5 returned 0 after 167969 usecs [ 4.644009] calling sysctl_core_init+0x0/0x2d @ 1 [ 4.648009] initcall sysctl_core_init+0x0/0x2d returned 0 after 0 usecs [ 4.652009] calling inet_init+0x0/0x27e @ 1 [ 4.656009] NET: Registered protocol family 2 [ 4.708009] IP route cache hash table entries: 32768 (order: 5, 131072 bytes) [ 4.716009] TCP established hash table entries: 131072 (order: 8, 1048576 bytes) [ 4.720009] TCP bind hash table entries: 65536 (order: 9, 2097152 bytes) [ 4.744009] TCP: Hash tables configured (established 131072 bind 65536) [ 4.748009] TCP reno registered [ 4.764009] initcall inet_init+0x0/0x27e returned 0 after 105468 usecs [ 4.768009] calling af_unix_init+0x0/0x53 @ 1 [ 4.772009] NET: Registered protocol family 1 [ 4.776009] initcall af_unix_init+0x0/0x53 returned 0 after 3906 usecs [ 4.780009] calling populate_rootfs+0x0/0xc5 @ 1 [ 4.788009] initcall populate_rootfs+0x0/0xc5 returned 0 after 3906 usecs [ 4.792009] calling i8259A_init_sysfs+0x0/0x2b @ 1 [ 4.796009] Registering sysdev class 'i8259' [ 4.800009] Registering sys device of class 'i8259' [ 4.804009] Registering sys device 'i82590' [ 4.808009] initcall i8259A_init_sysfs+0x0/0x2b returned 0 after 11718 usecs [ 4.812009] calling sbf_init+0x0/0x11f @ 1 [ 4.816009] initcall sbf_init+0x0/0x11f returned 0 after 0 usecs [ 4.820009] calling i8237A_init_sysfs+0x0/0x2b @ 1 [ 4.824009] Registering sysdev class 'i8237' [ 4.828009] Registering sys device of class 'i8237' [ 4.832009] Registering sys device 'i82370' [ 4.836009] initcall i8237A_init_sysfs+0x0/0x2b returned 0 after 11718 usecs [ 4.840009] calling add_rtc_cmos+0x0/0x8a @ 1 [ 4.844009] initcall add_rtc_cmos+0x0/0x8a returned 0 after 0 usecs [ 4.848009] calling cache_sysfs_init+0x0/0x89 @ 1 [ 4.852009] initcall cache_sysfs_init+0x0/0x89 returned 0 after 0 usecs [ 4.856009] calling cpufreq_gx_init+0x0/0x1b4 @ 1 [ 4.860009] initcall cpufreq_gx_init+0x0/0x1b4 returned -19 after 0 usecs [ 4.864009] calling speedstep_init+0x0/0x157 @ 1 [ 4.868009] initcall speedstep_init+0x0/0x157 returned -19 after 0 usecs [ 4.872009] calling msr_init+0x0/0x149 @ 1 [ 4.876009] device class 'msr': registering [ 4.880009] device: 'msr0': device_add [ 4.884009] PM: Adding info for No Bus:msr0 [ 4.888009] device: 'msr1': device_add [ 4.892009] PM: Adding info for No Bus:msr1 [ 4.900009] device: 'msr2': device_add [ 4.904009] PM: Adding info for No Bus:msr2 [ 4.908009] device: 'msr3': device_add [ 4.912009] PM: Adding info for No Bus:msr3 [ 4.916009] initcall msr_init+0x0/0x149 returned 0 after 39062 usecs [ 4.920009] calling apm_init+0x0/0x4c1 @ 1 [ 4.924009] apm: BIOS version 1.2 Flags 0x07 (Driver version 1.16ac) [ 4.928009] apm: disabled - APM is not SMP safe. [ 4.932009] initcall apm_init+0x0/0x4c1 returned -19 after 7812 usecs [ 4.936009] calling init_lapic_sysfs+0x0/0x44 @ 1 [ 4.940009] Registering sysdev class 'lapic' [ 4.944009] Registering sys device of class 'lapic' [ 4.948009] Registering sys device 'lapic0' [ 4.952009] initcall init_lapic_sysfs+0x0/0x44 returned 0 after 11718 usecs [ 4.956009] calling ioapic_init_sysfs+0x0/0xb9 @ 1 [ 4.960009] Registering sysdev class 'ioapic' [ 4.968009] Registering sys device of class 'ioapic' [ 4.972009] Registering sys device 'ioapic0' [ 4.976009] initcall ioapic_init_sysfs+0x0/0xb9 returned 0 after 15625 usecs [ 4.980009] calling init_vmi_clocksource+0x0/0xf4 @ 1 [ 4.984009] initcall init_vmi_clocksource+0x0/0xf4 returned 0 after 0 usecs [ 4.988009] calling add_pcspkr+0x0/0x45 @ 1 [ 4.992009] Registering platform device 'pcspkr'. Parent at platform [ 4.996009] device: 'pcspkr': device_add [ 5.000009] bus: 'platform': add device pcspkr [ 5.004009] PM: Adding info for platform:pcspkr [ 5.008009] initcall add_pcspkr+0x0/0x45 returned 0 after 15625 usecs [ 5.012009] calling scx200_init+0x0/0x20 @ 1 [ 5.016009] scx200: NatSemi SCx200 Driver [ 5.020009] bus: 'pci': add driver scx200 [ 5.028009] initcall scx200_init+0x0/0x20 returned 0 after 11718 usecs [ 5.032009] calling start_periodic_check_for_corruption+0x0/0x4a @ 1 [ 5.036009] initcall start_periodic_check_for_corruption+0x0/0x4a returned 0 after 0 usecs [ 5.040009] calling start_pageattr_test+0x0/0x74 @ 1 [ 5.044009] initcall start_pageattr_test+0x0/0x74 returned 0 after 0 usecs [ 5.048009] calling init+0x0/0xf @ 1 [ 5.052009] initcall init+0x0/0xf returned 0 after 0 usecs [ 5.056009] calling proc_execdomains_init+0x0/0x1c @ 1 [ 5.060009] initcall proc_execdomains_init+0x0/0x1c returned 0 after 0 usecs [ 5.068009] calling ioresources_init+0x0/0x31 @ 1 [ 5.072009] initcall ioresources_init+0x0/0x31 returned 0 after 0 usecs [ 5.076009] calling uid_cache_init+0x0/0x5c @ 1 [ 5.080009] initcall uid_cache_init+0x0/0x5c returned 0 after 0 usecs [ 5.084009] calling init_posix_timers+0x0/0xac @ 1 [ 5.088009] initcall init_posix_timers+0x0/0xac returned 0 after 0 usecs [ 5.092009] calling init_posix_cpu_timers+0x0/0x90 @ 1 [ 5.096009] initcall init_posix_cpu_timers+0x0/0x90 returned 0 after 0 usecs [ 5.100009] calling nsproxy_cache_init+0x0/0x27 @ 1 [ 5.104009] initcall nsproxy_cache_init+0x0/0x27 returned 0 after 0 usecs [ 5.108009] calling create_proc_profile+0x0/0x259 @ 1 [ 5.112009] initcall create_proc_profile+0x0/0x259 returned 0 after 0 usecs [ 5.116009] calling timekeeping_init_device+0x0/0x2b @ 1 [ 5.120009] Registering sysdev class 'timekeeping' [ 5.124009] Registering sys device of class 'timekeeping' [ 5.128009] Registering sys device 'timekeeping0' [ 5.132009] initcall timekeeping_init_device+0x0/0x2b returned 0 after 11718 usecs [ 5.136009] calling init_clocksource_sysfs+0x0/0x6d @ 1 [ 5.140009] Registering sysdev class 'clocksource' [ 5.144009] Registering sys device of class 'clocksource' [ 5.148009] Registering sys device 'clocksource0' [ 5.152009] initcall init_clocksource_sysfs+0x0/0x6d returned 0 after 11718 usecs [ 5.156009] calling init_timer_list_procfs+0x0/0x38 @ 1 [ 5.160009] initcall init_timer_list_procfs+0x0/0x38 returned 0 after 0 usecs [ 5.164009] calling init_tstats_procfs+0x0/0x38 @ 1 [ 5.168009] initcall init_tstats_procfs+0x0/0x38 returned 0 after 0 usecs [ 5.172009] calling lockdep_proc_init+0x0/0x4f @ 1 [ 5.176009] initcall lockdep_proc_init+0x0/0x4f returned 0 after 0 usecs [ 5.180009] calling futex_init+0x0/0x7d @ 1 [ 5.184009] initcall futex_init+0x0/0x7d returned 0 after 0 usecs [ 5.188009] calling proc_dma_init+0x0/0x1c @ 1 [ 5.192009] initcall proc_dma_init+0x0/0x1c returned 0 after 0 usecs [ 5.196009] calling proc_modules_init+0x0/0x1c @ 1 [ 5.200009] initcall proc_modules_init+0x0/0x1c returned 0 after 0 usecs [ 5.204009] calling percpu_modinit+0x0/0xa1 @ 1 [ 5.208009] initcall percpu_modinit+0x0/0xa1 returned 0 after 0 usecs [ 5.212009] calling kallsyms_init+0x0/0x1f @ 1 [ 5.216009] initcall kallsyms_init+0x0/0x1f returned 0 after 0 usecs [ 5.220009] calling pid_namespaces_init+0x0/0x27 @ 1 [ 5.224009] initcall pid_namespaces_init+0x0/0x27 returned 0 after 0 usecs [ 5.228009] calling audit_init+0x0/0x182 @ 1 [ 5.232009] audit: initializing netlink socket (disabled) [ 5.236009] type=2000 audit(1235057932.236:1): initialized [ 5.240009] initcall audit_init+0x0/0x182 returned 0 after 7812 usecs [ 5.244009] calling audit_tree_init+0x0/0x60 @ 1 [ 5.248009] initcall audit_tree_init+0x0/0x60 returned 0 after 0 usecs [ 5.252009] calling init_kprobes+0x0/0x191 @ 1 [ 5.288010] Kprobe smoke test started [ 5.356010] ------------[ cut here ]------------ [ 5.356010] WARNING: at kernel/lockdep.c:2870 check_flags+0x5c/0x166() [ 5.356010] Hardware name: P4DC6 [ 5.356010] Modules linked in: [ 5.356010] Pid: 1, comm: swapper Not tainted 2.6.29-rc5-tip #208 [ 5.356010] Call Trace: [ 5.356010] [] warn_slowpath+0x95/0xab [ 5.356010] [] ? add_lock_to_list+0x74/0xa6 [ 5.356010] [] ? validate_chain+0xa36/0xbef [ 5.356010] [] ? validate_chain+0xba1/0xbef [ 5.356010] [] ? __lock_acquire+0x712/0x768 [ 5.356010] [] check_flags+0x5c/0x166 [ 5.356010] [] lock_acquire+0x34/0x8b [ 5.356010] [] mutex_lock_nested+0x3f/0x595 [ 5.356010] [] ? unregister_kretprobes+0x26/0x158 [ 5.356010] [] ? trampoline_handler+0x12c/0x19e [ 5.356010] [] ? init_test_probes+0x42a/0x5ef [ 5.356010] [] unregister_kretprobes+0x26/0x158 [ 5.356010] [] unregister_kretprobe+0x16/0x18 [ 5.356010] [] init_test_probes+0x434/0x5ef [ 5.356010] [] init_kprobes+0x187/0x191 [ 5.356010] [] ? debug_check_no_locks_freed+0x10d/0x12d [ 5.356010] [] ? trace_hardirqs_on_caller+0x124/0x163 [ 5.356010] [] ? jiffies_read+0x8/0x14 [ 5.356010] [] ? getnstimeofday+0xac/0x137 [ 5.356010] [] ? ktime_get_ts+0x6d/0x72 [ 5.356010] [] ? ktime_get+0x18/0x34 [ 5.356010] [] ? init_kprobes+0x0/0x191 [ 5.356010] [] do_one_initcall+0x78/0x1dc [ 5.356010] [] ? number+0x1a0/0x36e [ 5.356010] [] ? trace_hardirqs_on+0xb/0xd [ 5.356010] [] ? trace_hardirqs_on_caller+0x124/0x163 [ 5.356010] [] ? vsnprintf+0xacc/0xb52 [ 5.356010] [] ? __lock_acquire+0x712/0x768 [ 5.356010] [] ? debug_check_no_locks_freed+0x106/0x12d [ 5.356010] [] ? __lock_acquire+0x712/0x768 [ 5.356010] [] ? _raw_spin_unlock+0x167/0x16f [ 5.356010] [] ? _spin_unlock+0x22/0x25 [ 5.356010] [] ? proc_register+0x208/0x212 [ 5.356010] [] ? create_proc_entry+0xae/0xda [ 5.356010] [] ? init_irq_proc+0x85/0x94 [ 5.356010] [] kernel_init+0x140/0x1ad [ 5.356010] [] ? kernel_init+0x0/0x1ad [ 5.356010] [] kernel_thread_helper+0x7/0x10 [ 5.356010] ---[ end trace a7919e7f17c0a725 ]--- [ 5.356010] possible reason: unannotated irqs-off. [ 5.356010] irq event stamp: 222111 [ 5.356010] hardirqs last enabled at (222111): [] _spin_unlock_irqrestore+0x4d/0x59 [ 5.356010] hardirqs last disabled at (222110): [] _spin_lock_irqsave+0x1f/0x44 [ 5.356010] softirqs last enabled at (221796): [] __do_softirq+0x182/0x19e [ 5.356010] softirqs last disabled at (221791): [] do_softirq+0x7e/0x16f [ 35.044031] CPA self-test: [ 35.044031] 4k 2046 large 220 gb 0 x 2266[c0000000-f77fd000] miss 0 [ 35.152031] 4k 182270 large 44 gb 0 x 182314[c0000000-f77fd000] miss 0 [ 35.228031] 4k 182270 large 44 gb 0 x 182314[c0000000-f77fd000] miss 0 [ 35.232031] ok. [ 45.056031] INFO: RCU detected CPU 0 stall (t=4294903560/2500 jiffies) [ 45.056031] Pid: 1, comm: swapper Tainted: G W 2.6.29-rc5-tip #208 [ 45.056031] Call Trace: [ 45.056031] [] __rcu_pending+0x5b/0x284 [ 45.056031] [] rcu_pending+0x21/0x4c [ 45.056031] [] update_process_times+0x30/0x61 [ 45.056031] [] tick_periodic+0x79/0x85 [ 45.056031] [] tick_handle_periodic+0x1e/0x7f [ 45.056031] [] tick_do_broadcast+0x3f/0x7d [ 45.056031] [] tick_do_periodic_broadcast+0x2e/0x3a [ 45.056031] [] tick_handle_periodic_broadcast+0x12/0x75 [ 45.056031] [] timer_interrupt+0x4d/0x83 [ 45.056031] [] handle_IRQ_event+0x33/0x80 [ 45.056031] [] handle_edge_irq+0x168/0x1bc [ 45.056031] [] ? handle_edge_irq+0x0/0x1bc [ 45.056031] [] ? do_IRQ+0x45/0xa6 [ 45.056031] [] ? common_interrupt+0x2e/0x34 [ 45.056031] [] ? relay_open_buf+0x24d/0x34f [ 45.056031] [] ? mutex_spin_on_owner+0x8e/0xc1 [ 45.056031] [] ? mutex_lock_nested+0x5e/0x595 [ 45.056031] [] ? trace_hardirqs_on+0xb/0xd [ 45.056031] [] ? kprobe_target+0x0/0x15 [ 45.056031] [] ? register_kprobe+0x19f/0x4f4 [ 45.056031] [] ? register_kretprobe+0x17a/0x1e2 [ 45.056031] [] ? register_kretprobes+0x36/0x73 [ 45.056031] [] ? init_test_probes+0x4b4/0x5ef [ 45.056031] [] ? init_kprobes+0x187/0x191 [ 45.056031] [] ? debug_check_no_locks_freed+0x10d/0x12d [ 45.056031] [] ? trace_hardirqs_on_caller+0x124/0x163 [ 45.056031] [] ? jiffies_read+0x8/0x14 [ 45.056031] [] ? getnstimeofday+0xac/0x137 [ 45.056031] [] ? ktime_get_ts+0x6d/0x72 [ 45.056031] [] ? ktime_get+0x18/0x34 [ 45.056031] [] ? init_kprobes+0x0/0x191 [ 45.056031] [] ? do_one_initcall+0x78/0x1dc [ 45.056031] [] ? number+0x1a0/0x36e [ 45.056031] [] ? trace_hardirqs_on+0xb/0xd [ 45.056031] [] ? trace_hardirqs_on_caller+0x124/0x163 [ 45.056031] [] ? vsnprintf+0xacc/0xb52 [ 45.056031] [] ? __lock_acquire+0x712/0x768 [ 45.056031] [] ? debug_check_no_locks_freed+0x106/0x12d [ 45.056031] [] ? __lock_acquire+0x712/0x768 [ 45.056031] [] ? _raw_spin_unlock+0x167/0x16f [ 45.056031] [] ? _spin_unlock+0x22/0x25 [ 45.056031] [] ? proc_register+0x208/0x212 [ 45.056031] [] ? create_proc_entry+0xae/0xda [ 45.056031] [] ? init_irq_proc+0x85/0x94 [ 45.056031] [] ? kernel_init+0x140/0x1ad [ 45.056031] [] ? kernel_init+0x0/0x1ad [ 45.056031] [] ? kernel_thread_helper+0x7/0x10 [ 75.056031] INFO: RCU detected CPU 0 stall (t=4294911060/10000 jiffies) [ 75.056031] Pid: 1, comm: swapper Tainted: G W 2.6.29-rc5-tip #208 [ 75.056031] Call Trace: [ 75.056031] [] __rcu_pending+0x5b/0x284 [ 75.056031] [] rcu_pending+0x21/0x4c [ 75.056031] [] update_process_times+0x30/0x61 [ 75.056031] [] tick_periodic+0x79/0x85 [ 75.056031] [] tick_handle_periodic+0x1e/0x7f [ 75.056031] [] tick_do_broadcast+0x3f/0x7d [ 75.056031] [] tick_do_periodic_broadcast+0x2e/0x3a [ 75.056031] [] tick_handle_periodic_broadcast+0x12/0x75 [ 75.056031] [] timer_interrupt+0x4d/0x83 [ 75.056031] [] handle_IRQ_event+0x33/0x80 [ 75.056031] [] handle_edge_irq+0x168/0x1bc [ 75.056031] [] ? handle_edge_irq+0x0/0x1bc [ 75.056031] [] ? do_IRQ+0x45/0xa6 [ 75.056031] [] ? common_interrupt+0x2e/0x34 [ 75.056031] [] ? relay_open_buf+0x2aa/0x34f [ 75.056031] [] ? mutex_spin_on_owner+0x9d/0xc1 [ 75.056031] [] ? mutex_lock_nested+0x5e/0x595 [ 75.056031] [] ? trace_hardirqs_on+0xb/0xd [ 75.056031] [] ? kprobe_target+0x0/0x15 [ 75.056031] [] ? register_kprobe+0x19f/0x4f4 [ 75.056031] [] ? register_kretprobe+0x17a/0x1e2 [ 75.056031] [] ? register_kretprobes+0x36/0x73 [ 75.056031] [] ? init_test_probes+0x4b4/0x5ef [ 75.056031] [] ? init_kprobes+0x187/0x191 [ 75.056031] [] ? debug_check_no_locks_freed+0x10d/0x12d [ 75.056031] [] ? trace_hardirqs_on_caller+0x124/0x163 [ 75.056031] [] ? jiffies_read+0x8/0x14 [ 75.056031] [] ? getnstimeofday+0xac/0x137 [ 75.056031] [] ? ktime_get_ts+0x6d/0x72 [ 75.056031] [] ? ktime_get+0x18/0x34 [ 75.056031] [] ? init_kprobes+0x0/0x191 [ 75.056031] [] ? do_one_initcall+0x78/0x1dc [ 75.056031] [] ? number+0x1a0/0x36e [ 75.056031] [] ? trace_hardirqs_on+0xb/0xd [ 75.056031] [] ? trace_hardirqs_on_caller+0x124/0x163 [ 75.056031] [] ? vsnprintf+0xacc/0xb52 [ 75.056031] [] ? __lock_acquire+0x712/0x768 [ 75.056031] [] ? debug_check_no_locks_freed+0x106/0x12d [ 75.056031] [] ? __lock_acquire+0x712/0x768 [ 75.056031] [] ? _raw_spin_unlock+0x167/0x16f [ 75.056031] [] ? _spin_unlock+0x22/0x25 [ 75.056031] [] ? proc_register+0x208/0x212 [ 75.056031] [] ? create_proc_entry+0xae/0xda [ 75.056031] [] ? init_irq_proc+0x85/0x94 [ 75.056031] [] ? kernel_init+0x140/0x1ad [ 75.056031] [] ? kernel_init+0x0/0x1ad [ 75.056031] [] ? kernel_thread_helper+0x7/0x10 [ 105.468031] INFO: RCU detected CPU 0 stall (t=4294918663/2500 jiffies) [ 105.468031] Pid: 1, comm: swapper Tainted: G W 2.6.29-rc5-tip #208 [ 105.468031] Call Trace: [ 105.468031] [] __rcu_pending+0x5b/0x284 [ 105.468031] [] rcu_pending+0x21/0x4c [ 105.468031] [] update_process_times+0x30/0x61 [ 105.468031] [] tick_periodic+0x79/0x85 [ 105.468031] [] tick_handle_periodic+0x1e/0x7f [ 105.468031] [] tick_do_broadcast+0x3f/0x7d [ 105.468031] [] tick_do_periodic_broadcast+0x2e/0x3a [ 105.468031] [] tick_handle_periodic_broadcast+0x12/0x75 [ 105.468031] [] timer_interrupt+0x4d/0x83 [ 105.468031] [] handle_IRQ_event+0x33/0x80 [ 105.468031] [] handle_edge_irq+0x168/0x1bc [ 105.468031] [] ? handle_edge_irq+0x0/0x1bc [ 105.468031] [] ? do_IRQ+0x45/0xa6 [ 105.468031] [] ? common_interrupt+0x2e/0x34 [ 105.468031] [] ? mutex_spin_on_owner+0x9d/0xc1 [ 105.468031] [] ? mutex_lock_nested+0x5e/0x595 [ 105.468031] [] ? default_wake_function+0x0/0x12 [ 105.468031] [] ? free_insn_slot+0x1a/0xe4 [ 105.468031] [] ? arch_remove_kprobe+0x21/0x33 [ 105.468031] [] ? __unregister_kprobe_bottom+0x19/0x4f [ 105.468031] [] ? unregister_kretprobes+0x91/0x158 [ 105.468031] [] ? init_test_probes+0x567/0x5ef [ 105.468031] [] ? init_kprobes+0x187/0x191 [ 105.468031] [] ? debug_check_no_locks_freed+0x10d/0x12d [ 105.468031] [] ? trace_hardirqs_on_caller+0x124/0x163 [ 105.468031] [] ? jiffies_read+0x8/0x14 [ 105.468031] [] ? getnstimeofday+0xac/0x137 [ 105.468031] [] ? ktime_get_ts+0x6d/0x72 [ 105.468031] [] ? ktime_get+0x18/0x34 [ 105.468031] [] ? init_kprobes+0x0/0x191 [ 105.468031] [] ? do_one_initcall+0x78/0x1dc [ 105.468031] [] ? number+0x1a0/0x36e [ 105.468031] [] ? trace_hardirqs_on+0xb/0xd [ 105.468031] [] ? trace_hardirqs_on_caller+0x124/0x163 [ 105.468031] [] ? vsnprintf+0xacc/0xb52 [ 105.468031] [] ? __lock_acquire+0x712/0x768 [ 105.468031] [] ? debug_check_no_locks_freed+0x106/0x12d [ 105.468031] [] ? __lock_acquire+0x712/0x768 [ 105.468031] [] ? _raw_spin_unlock+0x167/0x16f [ 105.468031] [] ? _spin_unlock+0x22/0x25 [ 105.468031] [] ? proc_register+0x208/0x212 [ 105.468031] [] ? create_proc_entry+0xae/0xda [ 105.468031] [] ? init_irq_proc+0x85/0x94 [ 105.468031] [] ? kernel_init+0x140/0x1ad [ 105.468031] [] ? kernel_init+0x0/0x1ad [ 105.468031] [] ? kernel_thread_helper+0x7/0x10