SignOfZeta
n00b
Joined: 12 Aug 2005
Posts: 63
Location: New England
|
 Posted: Tue Apr 19, 2016 10:37 pm Post subject: hardened-sources-4.4.2 won't boot on Hyper-V, RCU error |
 |
|
I created a Hyper-V Gen1 version 5.0 virtual machine, and I configured a kernel with =hardened-sources-4.4.2. But, my kernel won't boot. When I hook up a serial console, this is what I get:
| Code: | [ 0.000000] Initializing cgroup subsys cpuset
[ 0.000000] Initializing cgroup subsys cpu
[ 0.000000] Initializing cgroup subsys cpuacct
[ 0.000000] Linux version 4.4.2-hardened (root@livecd) (gcc version 4.9.3 (Gentoo Hardened 4.9.3 p1.5, pie-0.6.4) ) #6 SMP Tue Apr 19 18:23:06 EDT 2016
[ 0.000000] Command line: BOOT_IMAGE=/vmlinuz-4.4.2-hardened root=/dev/sda3 ro rootfstype=ext4 elevator=noop console=tty0 console=ttyS0
[ 0.000000] x86/fpu: Legacy x87 FPU detected.
[ 0.000000] x86/fpu: Using 'lazy' FPU context switches.
[ 0.000000] e820: BIOS-provided physical RAM map:
[ 0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable
[ 0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved
[ 0.000000] BIOS-e820: [mem 0x00000000000e0000-0x00000000000fffff] reserved
[ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x000000003ffeffff] usable
[ 0.000000] BIOS-e820: [mem 0x000000003fff0000-0x000000003fffefff] ACPI data
[ 0.000000] BIOS-e820: [mem 0x000000003ffff000-0x000000003fffffff] ACPI NVS
[ 0.000000] NX (Execute Disable) protection: active
[ 0.000000] SMBIOS 2.3 present.
[ 0.000000] Hypervisor detected: Microsoft HyperV
[ 0.000000] HyperV: features 0xe7f, hints 0x2c
[ 0.000000] HyperV: LAPIC Timer Frequency: 0x30d40
[ 0.000000] clocksource: hyperv_clocksource: mask: 0xffffffffffffffff max_cycles: 0x24e6a1710, max_idle_ns: 440795202120 ns
[ 0.000000] tsc: Marking TSC unstable due to running on Hyper-V
[ 0.000000] e820: last_pfn = 0x3fff0 max_arch_pfn = 0x400000000
[ 0.000000] x86/PAT: Configuration [0-7]: WB WC UC- UC WB WC UC- WT
[ 0.000000] found SMP MP-table at [mem 0x000ff780-0x000ff78f] mapped at [ffff8800000ff780]
[ 0.000000] ACPI: Early table checksum verification disabled
[ 0.000000] ACPI: RSDP 0x00000000000F56F0 000014 (v00 ACPIAM)
[ 0.000000] ACPI: RSDT 0x000000003FFF0000 000040 (v01 VRTUAL MICROSFT 02001622 MSFT 00000097)
[ 0.000000] ACPI: FACP 0x000000003FFF0200 000081 (v02 VRTUAL MICROSFT 02001622 MSFT 00000097)
[ 0.000000] ACPI: DSDT 0x000000003FFF1724 0033BE (v01 MSFTVM MSFTVM02 00000002 INTL 02002026)
[ 0.000000] ACPI: FACS 0x000000003FFFF000 000040
[ 0.000000] ACPI: WAET 0x000000003FFF1480 000028 (v01 VRTUAL MICROSFT 02001622 MSFT 00000097)
[ 0.000000] ACPI: SLIC 0x000000003FFF14C0 000176 (v01 VRTUAL MICROSFT 02001622 MSFT 00000097)
[ 0.000000] ACPI: OEM0 0x000000003FFF16C0 000064 (v01 VRTUAL MICROSFT 02001622 MSFT 00000097)
[ 0.000000] ACPI: SRAT 0x000000003FFF0600 0000F0 (v02 VRTUAL MICROSFT 00000001 MSFT 00000001)
[ 0.000000] ACPI: APIC 0x000000003FFF0300 00024C (v01 VRTUAL MICROSFT 02001622 MSFT 00000097)
[ 0.000000] ACPI: OEMB 0x000000003FFFF040 000064 (v01 VRTUAL MICROSFT 02001622 MSFT 00000097)
[ 0.000000] SRAT: PXM 0 -> APIC 0x00 -> Node 0
[ 0.000000] SRAT: PXM 0 -> APIC 0x01 -> Node 0
[ 0.000000] SRAT: Node 0 PXM 0 [mem 0x00000000-0x3fffffff]
[ 0.000000] SRAT: Node 0 PXM 0 [mem 0x40200000-0xf7ffffff] hotplug
[ 0.000000] SRAT: Node 0 PXM 0 [mem 0x100000000-0xfdfffffff] hotplug
[ 0.000000] SRAT: Node 0 PXM 0 [mem 0x1000000000-0xffffffffff] hotplug
[ 0.000000] NODE_DATA(0) allocated [mem 0x3ffed000-0x3ffeffff]
[ 0.000000] Zone ranges:
[ 0.000000] DMA [mem 0x0000000000001000-0x0000000000ffffff]
[ 0.000000] DMA32 [mem 0x0000000001000000-0x000000003ffeffff]
[ 0.000000] Normal empty
[ 0.000000] Movable zone start for each node
[ 0.000000] Early memory node ranges
[ 0.000000] node 0: [mem 0x0000000000001000-0x000000000009efff]
[ 0.000000] node 0: [mem 0x0000000000100000-0x000000003ffeffff]
[ 0.000000] Initmem setup node 0 [mem 0x0000000000001000-0x000000003ffeffff]
[ 0.000000] ACPI: PM-Timer IO Port: 0x408
[ 0.000000] IOAPIC[0]: apic_id 0, version 17, 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] Using ACPI (MADT) for SMP configuration information
[ 0.000000] smpboot: Allowing 2 CPUs, 0 hotplug CPUs
[ 0.000000] e820: [mem 0x40000000-0xffffffff] available for PCI devices
[ 0.000000] Booting paravirtualized kernel on bare hardware
[ 0.000000] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns
[ 0.000000] setup_percpu: NR_CPUS:16 nr_cpumask_bits:16 nr_cpu_ids:2 nr_node_ids:1
[ 0.000000] PERCPU: Embedded 28 pages/cpu @ffff88003fc00000 s76056 r8192 d30440 u1048576
[ 0.000000] Built 1 zonelists in Node order, mobility grouping on. Total pages: 257913
[ 0.000000] Policy zone: DMA32
[ 0.000000] Kernel command line: BOOT_IMAGE=/vmlinuz-4.4.2-hardened-vectro-20160419 root=/dev/sda3 ro rootfstype=ext4 elevator=noop console=tty0 console=ttyS0
[ 0.000000] PID hash table entries: 4096 (order: 3, 32768 bytes)
[ 0.000000] Memory: 1022744K/1048120K available (4221K kernel code, 848K rwdata, 1776K rodata, 860K init, 664K bss, 25376K reserved, 0K cma-reserved)
[ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1
[ 0.000000] Hierarchical RCU implementation.
[ 0.000000] Build-time adjustment of leaf fanout to 64.
[ 0.000000] RCU restricting CPUs from NR_CPUS=16 to nr_cpu_ids=2.
[ 0.000000] RCU: Adjusting geometry for rcu_fanout_leaf=64, nr_cpu_ids=2
[ 0.000000] NR_IRQS:4352 nr_irqs:440 16
[ 0.000000] Console: colour VGA+ 80x25
[ 0.000000] console [tty0] enabled
[ 0.000000] console [ttyS0] enabled
[ 0.000000] tsc: Fast TSC calibration failed
[ 0.000000] tsc: Unable to calibrate against PIT
[ 0.000000] tsc: using PMTIMER reference calibration
[ 0.000000] tsc: Detected 2799.947 MHz processor
[ 0.007011] Calibrating delay loop (skipped), value calculated using timer frequency.. 5599.89 BogoMIPS (lpj=2799947)
[ 0.009019] pid_max: default: 32768 minimum: 501
[ 0.010033] ACPI: Core revision 20150930
[ 0.013525] ACPI: 1 ACPI AML tables successfully acquired and loaded
[ 0.016028] Security Framework initialized
[ 0.017017] SELinux: Initializing.
[ 0.018089] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes)
[ 0.019188] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes)
[ 0.020095] Mount-cache hash table entries: 2048 (order: 2, 16384 bytes)
[ 0.021034] Mountpoint-cache hash table entries: 2048 (order: 2, 16384 bytes)
[ 0.022240] Initializing cgroup subsys freezer
[ 0.023111] CPU: Physical Processor ID: 0
[ 0.024017] CPU: Processor Core ID: 0
[ 0.025021] Last level iTLB entries: 4KB 512, 2MB 7, 4MB 7
[ 0.026017] Last level dTLB entries: 4KB 512, 2MB 32, 4MB 32, 1GB 0
[ 0.029175] Freeing SMP alternatives memory: 12K (ffffffff9e78c000 - ffffffff9e78f000)
[ 0.052000] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1
[ 0.052083] smpboot: CPU0: Intel(R) Xeon(R) CPU X5560 @ 2.80GHz (family: 0x6, model: 0x1a, stepping: 0x5)
[ 0.056028] Performance Events: unsupported p6 CPU model 26 no PMU driver, software events only.
[ 0.059225] x86: Booting SMP configuration:
[ 0.060003] .... node #0, CPUs: #1
[ 0.064025] x86: Booted up 1 node, 2 CPUs
[ 0.065004] smpboot: Total of 2 processors activated (11199.78 BogoMIPS)
[ 0.070196] devtmpfs: initialized
[ 0.075134] evm: security.selinux
[ 0.076003] evm: security.ima
[ 0.077005] evm: security.capability
[ 0.078171] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns
[ 0.079181] NET: Registered protocol family 16
[ 0.085020] cpuidle: using governor ladder
[ 0.091011] cpuidle: using governor menu
[ 0.092065] ACPI: bus type PCI registered
[ 0.093004] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5
[ 0.094289] PCI: Using configuration type 1 for base access
[ 0.097519] ACPI: Added _OSI(Module Device)
[ 0.098011] ACPI: Added _OSI(Processor Device)
[ 0.099005] ACPI: Added _OSI(3.0 _SCP Extensions)
[ 0.100004] ACPI: Added _OSI(Processor Aggregator Device)
[ 0.105060] ACPI: Interpreter enabled
[ 0.106008] ACPI: (supports S0 S5)
[ 0.107003] ACPI: Using IOAPIC for interrupt routing
[ 0.108044] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug
[ 0.118982] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])
[ 0.119009] acpi PNP0A03:00: _OSC: OS supports [ASPM ClockPM Segments MSI]
[ 0.120008] acpi PNP0A03:00: _OSC failed (AE_NOT_FOUND); disabling ASPM
[ 0.121012] acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended PCI configuration space under this bridge.
[ 0.122207] PCI host bridge to bus 0000:00
[ 0.123006] pci_bus 0000:00: root bus resource [mem 0xfe0000000-0xfffffffff window]
[ 0.124004] pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window]
[ 0.125009] pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window]
[ 0.127005] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window]
[ 0.128009] pci_bus 0000:00: root bus resource [mem 0xf8000000-0xfffbffff window]
[ 0.129004] pci_bus 0000:00: root bus resource [bus 00-ff]
[ 0.136326] pci 0000:00:07.1: legacy IDE quirk: reg 0x10: [io 0x01f0-0x01f7]
[ 0.137006] pci 0000:00:07.1: legacy IDE quirk: reg 0x14: [io 0x03f6]
[ 0.138004] pci 0000:00:07.1: legacy IDE quirk: reg 0x18: [io 0x0170-0x0177]
[ 0.139004] pci 0000:00:07.1: legacy IDE quirk: reg 0x1c: [io 0x0376]
[ 0.140452] * Found PM-Timer Bug on the chipset. Due to workarounds for a bug,
[ 0.140452] * this clock source is slow. Consider trying other clock sources
[ 0.142931] pci 0000:00:07.3: quirk: [io 0x0400-0x043f] claimed by PIIX4 ACPI
[ 0.151502] ACPI: PCI Interrupt Link [LNKA] (IRQs 3 4 5 7 9 10 *11 12 14 15)
[ 0.162191] ACPI: PCI Interrupt Link [LNKB] (IRQs 3 4 5 7 9 10 11 12 14 15) *0, disabled.
[ 0.176213] ACPI: PCI Interrupt Link [LNKC] (IRQs 3 4 5 7 9 10 11 12 14 15) *0, disabled.
[ 0.189178] ACPI: PCI Interrupt Link [LNKD] (IRQs 3 4 5 7 9 10 11 12 14 15) *0, disabled.
[ 0.202192] ACPI: Enabled 1 GPEs in block 00 to 0F
[ 0.204116] vgaarb: setting as boot device: PCI:0000:00:08.0
[ 0.205000] vgaarb: device added: PCI:0000:00:08.0,decodes=io+mem,owns=io+mem,locks=none
[ 0.206012] vgaarb: loaded
[ 0.208010] vgaarb: bridge control possible 0000:00:08.0
[ 0.210021] SCSI subsystem initialized
[ 0.212240] clocksource: hyperv_clocksource_tsc_page: mask: 0xffffffffffffffff max_cycles: 0x24e6a1710, max_idle_ns: 440795202120 ns
[ 21.216000] INFO: rcu_sched self-detected stall on CPU
[ 21.216000] 0-...: (20999 ticks this GP) idle=05b/140000000000001/0 softirq=40/40 fqs=6856
[ 21.216000] (t=21000 jiffies g=-283 c=-284 q=54)
[ 21.216000] Task dump for CPU 0:
[ 21.216000] swapper/0 R running task 0 1 0 0x00000008
[ 21.216000] 0000000000000000 ffff88003fc03e60 ffffffff9e08ab1a 0000000000000000
[ 21.216000] ffffffff9e635e40 ffff88003fc03e78 ffffffff9e08c375 ffffffff9e635e40
[ 21.216000] ffff88003fc03ea8 ffffffff9e0a4cb5 ffffffff9e635e40 ffff88003fc12500
[ 21.216000] Call Trace:
[ 21.216000] <IRQ> [<ffffffff9e08ab1a>] sched_show_task+0xc0/0xc5
[ 21.216000] [<ffffffff9e08c375>] dump_cpu_task+0x34/0x37
[ 21.216000] [<ffffffff9e0a4cb5>] rcu_dump_cpu_stacks+0x6a/0x8c
[ 21.216000] [<ffffffff9e0a7913>] rcu_check_callbacks+0x21a/0x5d1
[ 21.216000] [<ffffffff9e0aa9e3>] update_process_times+0x2a/0x4f
[ 21.216000] [<ffffffff9e0b4888>] tick_periodic+0x69/0x75
[ 21.216000] [<ffffffff9e0b48b4>] tick_handle_periodic+0x20/0x61
[ 21.216000] [<ffffffff9e34effb>] vmbus_isr+0x71/0xbb
[ 21.216000] [<ffffffff9e024578>] hyperv_vector_handler+0x34/0x44
[ 21.216000] [<ffffffff9e41d344>] hyperv_callback_vector+0x84/0x90
[ 21.216000] <EOI> [<ffffffff9e34f736>] ? hv_post_message+0x90/0x97
[ 21.216000] [<ffffffff9e34fea2>] vmbus_post_msg+0x34/0x9b
[ 21.216000] [<ffffffff9e350123>] vmbus_connect+0x21a/0x3d7
[ 21.216000] [<ffffffff9e700c01>] ? clockevent_i8253_init+0x5d/0x5d
[ 21.216000] [<ffffffff9e700cf4>] hv_acpi_init+0xf3/0x187
[ 21.216000] [<ffffffff9e0004d1>] do_one_initcall+0xe4/0x161
[ 21.216000] [<ffffffff9e6c8fe4>] kernel_init_freeable+0x160/0x1f4
[ 21.216000] [<ffffffff9e412fd2>] ? rest_init+0x79/0x79
[ 21.216000] [<ffffffff9e412fdb>] kernel_init+0x9/0xd5
[ 21.216000] [<ffffffff9e41bc8e>] ret_from_fork+0x3e/0x70
[ 21.216000] [<ffffffff9e412fd2>] ? rest_init+0x79/0x79
[ 32.531028] random: nonblocking pool is initialized9 |
The RCU stack dump repeats every 60 seconds or so, but save for that urandom line, that's about as far as it gets. Can anyone point me in the right direction? |
|
Kernel & Hardware
