Bug 1619616 - System hang when booting with ftrace=functio_graph in kernel commandline for 4.18.1-300
Summary: System hang when booting with ftrace=functio_graph in kernel commandline for ...
Keywords:
Status: NEW
Alias: None
Product: Fedora
Classification: Fedora
Component: kernel
Version: rawhide
Hardware: Unspecified
OS: Unspecified
unspecified
unspecified
Target Milestone: ---
Assignee: Kernel Maintainer List
QA Contact: Fedora Extras Quality Assurance
URL:
Whiteboard:
Depends On:
Blocks:
TreeView+ depends on / blocked
 
Reported: 2018-08-21 10:08 UTC by Zamir SUN
Modified: 2018-08-21 10:08 UTC (History)
16 users (show)

Fixed In Version:
Doc Type: If docs needed, set a value
Doc Text:
Clone Of:
Environment:
Last Closed:


Attachments (Terms of Use)

Description Zamir SUN 2018-08-21 10:08:16 UTC
Description of problem:
System hang when booting with ftrace=functio_graph in kernel commandline for 4.18.1-300 

Version-Release number of selected component (if applicable):
4.18.1-300 

How reproducible:


Steps to Reproduce:
1. grubby --args="ftrace=function_graph" --update-kernel=/boot/vmlinuz-$(uname -r)
2. reboot
3.

Actual results:
System can't boot in a reasonable time

Expected results:
System boot fine and ftrace function_graph tracer enabled by default

Additional info:
This can be reproduced on x86_64 (in a kvm guest). System did not boot for about 3 hours.

[    0.000000] Linux version 4.18.1-300.fc29.x86_64 (mockbuild@bkernel02.phx2.fedoraproject.org) (gcc version 8.2.1 20180801 (Red Hat 8.2.1-2) (GCC)) #1 SMP Thu Aug 16 17:10:34 UTC 2018 
[    0.000000] Command line: BOOT_IMAGE=/vmlinuz-4.18.1-300.fc29.x86_64 root=/dev/mapper/fedora_hp--dl380pgen8--02--vm--7-root ro resume=/dev/mapper/fedora_hp--dl380pgen8--02--vm--7-swap rd.lvm.lv=fedora_hp-dl380pgen8-02-vm-7/root rd.lvm.lv=fedora_hp-dl380pgen8-02-vm-7/swap console=ttyS0,115200n81 LANG=en_US.UTF-8 crashkernel=161M  ftrace=function_graph 
[    0.000000] Disabled fast string operations 
[    0.000000] x86/fpu: x87 FPU will use FXSAVE 
[    0.000000] BIOS-provided physical RAM map: 
[    0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009dbff] usable 
[    0.000000] BIOS-e820: [mem 0x000000000009dc00-0x000000000009ffff] reserved 
[    0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved 
[    0.000000] BIOS-e820: [mem 0x0000000000100000-0x00000000dfffcfff] usable 
[    0.000000] BIOS-e820: [mem 0x00000000dfffd000-0x00000000dfffffff] reserved 
[    0.000000] BIOS-e820: [mem 0x00000000fffbc000-0x00000000ffffffff] reserved 
[    0.000000] BIOS-e820: [mem 0x0000000100000000-0x000000011fffffff] usable 
[    0.000000] NX (Execute Disable) protection: active 
[    0.000000] SMBIOS 2.4 present. 
[    0.000000] DMI: Red Hat KVM, BIOS 0.5.1 01/01/2007 
[    0.000000] Hypervisor detected: KVM 
[    0.000000] last_pfn = 0x120000 max_arch_pfn = 0x400000000 
[    0.000000] x86/PAT: PAT not supported by CPU. 
[    0.000000] x86/PAT: Configuration [0-7]: WB  WT  UC- UC  WB  WT  UC- UC   
[    0.000000] last_pfn = 0xdfffd max_arch_pfn = 0x400000000 
[    0.000000] found SMP MP-table at [mem 0x000fda30-0x000fda3f] mapped at [(____ptrval____)] 
[    0.000000] iBFT found at 0x9aff0. 
[    0.000000] RAMDISK: [mem 0x353ee000-0x369eefff] 
[    0.000000] ACPI: Early table checksum verification disabled 
[    0.000000] ACPI: RSDP 0x00000000000FD9E0 000014 (v00 BOCHS ) 
[    0.000000] ACPI: RSDT 0x00000000DFFFD590 000034 (v01 BOCHS  BXPCRSDT 00000001 BXPC 00000001) 
[    0.000000] ACPI: FACP 0x00000000DFFFFDF0 000074 (v01 BOCHS  BXPCFACP 00000001 BXPC 00000001) 
[    0.000000] ACPI: DSDT 0x00000000DFFFD8D0 0024A2 (v01 BXPC   BXDSDT   00000001 INTL 20090123) 
[    0.000000] ACPI: FACS 0x00000000DFFFFD80 000040 
[    0.000000] ACPI: SSDT 0x00000000DFFFD7D0 0000FF (v01 BOCHS  BXPCSSDT 00000001 BXPC 00000001) 
[    0.000000] ACPI: APIC 0x00000000DFFFD6E0 000080 (v01 BOCHS  BXPCAPIC 00000001 BXPC 00000001) 
[    0.000000] ACPI: SSDT 0x00000000DFFFD5D0 00010F (v01 BXPC   BXSSDTPC 00000001 INTL 20090123) 
[    0.000000] No NUMA configuration found 
[    0.000000] Faking a node at [mem 0x0000000000000000-0x000000011fffffff] 
[    0.000000] NODE_DATA(0) allocated [mem 0x11ffd1000-0x11fffbfff] 
[    0.000000] Reserving 161MB of memory at 688MB for crashkernel (System RAM: 4095MB) 
[    0.000000] kvm-clock: cpu 0, msr 1:1ffc0001, primary cpu clock 
[    0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00 
[    0.000000] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns 
[    0.000000] Zone ranges: 
[    0.000000]   DMA      [mem 0x0000000000001000-0x0000000000ffffff] 
[    0.000000]   DMA32    [mem 0x0000000001000000-0x00000000ffffffff] 
[    0.000000]   Normal   [mem 0x0000000100000000-0x000000011fffffff] 
[    0.000000]   Device   empty 
[    0.000000] Movable zone start for each node 
[    0.000000] Early memory node ranges 
[    0.000000]   node   0: [mem 0x0000000000001000-0x000000000009cfff] 
[    0.000000]   node   0: [mem 0x0000000000100000-0x00000000dfffcfff] 
[    0.000000]   node   0: [mem 0x0000000100000000-0x000000011fffffff] 
[    0.000000] Reserved but unavailable: 103 pages 
[    0.000000] Initmem setup node 0 [mem 0x0000000000001000-0x000000011fffffff] 
[    0.000000] ACPI: PM-Timer IO Port: 0xb008 
[    0.000000] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) 
[    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 5 global_irq 5 high level) 
[    0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) 
[    0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) 
[    0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) 
[    0.000000] Using ACPI (MADT) for SMP configuration information 
[    0.000000] smpboot: Allowing 2 CPUs, 0 hotplug CPUs 
[    0.000000] PM: Registered nosave memory: [mem 0x00000000-0x00000fff] 
[    0.000000] PM: Registered nosave memory: [mem 0x0009d000-0x0009dfff] 
[    0.000000] PM: Registered nosave memory: [mem 0x0009e000-0x0009ffff] 
[    0.000000] PM: Registered nosave memory: [mem 0x000a0000-0x000effff] 
[    0.000000] PM: Registered nosave memory: [mem 0x000f0000-0x000fffff] 
[    0.000000] PM: Registered nosave memory: [mem 0xdfffd000-0xdfffffff] 
[    0.000000] PM: Registered nosave memory: [mem 0xe0000000-0xfffbbfff] 
[    0.000000] PM: Registered nosave memory: [mem 0xfffbc000-0xffffffff] 
[    0.000000] [mem 0xe0000000-0xfffbbfff] available for PCI devices 
[    0.000000] Booting paravirtualized kernel on KVM 
[    0.000000] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1910969940391419 ns 
[    0.000000] random: get_random_bytes called from start_kernel+0x93/0x558 with crng_init=0 
[    0.000000] setup_percpu: NR_CPUS:1024 nr_cpumask_bits:2 nr_cpu_ids:2 nr_node_ids:1 
[    0.000000] percpu: Embedded 45 pages/cpu @(____ptrval____) s147456 r8192 d28672 u1048576 
[    0.000000] kvm-stealtime: cpu 0, msr 11fc23040 
[    0.000000] Built 1 zonelists, mobility grouping on.  Total pages: 1032066 
[    0.000000] Policy zone: Normal 
[    0.000000] Kernel command line: BOOT_IMAGE=/vmlinuz-4.18.1-300.fc29.x86_64 root=/dev/mapper/fedora_hp--dl380pgen8--02--vm--7-root ro resume=/dev/mapper/fedora_hp--dl380pgen8--02--vm--7-swap rd.lvm.lv=fedora_hp-dl380pgen8-02-vm-7/root rd.lvm.lv=fedora_hp-dl380pgen8-02-vm-7/swap console=ttyS0,115200n81 LANG=en_US.UTF-8 crashkernel=161M  ftrace=function_graph 
[    0.000000] Memory: 3846880K/4193892K available (12300K kernel code, 1619K rwdata, 4052K rodata, 2156K init, 1336K bss, 347012K reserved, 0K cma-reserved) 
[    0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=2, Nodes=1 
[    0.000000] Kernel/User page tables isolation: enabled 
[    0.000000] ftrace: allocating 37953 entries in 149 pages 
[    0.001000] Hierarchical RCU implementation. 
[    0.001000] 	RCU restricting CPUs from NR_CPUS=1024 to nr_cpu_ids=2. 
[    0.001000] 	Tasks RCU enabled. 
[    0.001000] RCU: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=2 
[    0.001000] NR_IRQS: 65792, nr_irqs: 440, preallocated irqs: 16 
[    0.001000] Console: colour VGA+ 80x25 
[    0.001000] console [ttyS0] enabled 
[    0.001000] ACPI: Core revision 20180531 
[    0.001008] APIC: Switch to symmetric I/O mode setup 
[    0.002496] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 
[    0.003000] tsc: Detected 2892.748 MHz processor 
[    0.003000] clocksource: tsc-early: mask: 0xffffffffffffffff max_cycles: 0x29b28086dab, max_idle_ns: 440795279059 ns 
[    0.003004] Calibrating delay loop (skipped) preset value.. 5785.49 BogoMIPS (lpj=2892748) 
[    0.004002] pid_max: default: 32768 minimum: 301 
[    0.004429] Security Framework initialized 
[    0.004787] Yama: becoming mindful. 
[    0.005005] SELinux:  Initializing. 
[    0.007771] Dentry cache hash table entries: 524288 (order: 10, 4194304 bytes) 
[    0.009512] Inode-cache hash table entries: 262144 (order: 9, 2097152 bytes) 
[    0.010047] Mount-cache hash table entries: 8192 (order: 4, 65536 bytes) 
[    0.010664] Mountpoint-cache hash table entries: 8192 (order: 4, 65536 bytes) 
[    0.011264] Disabled fast string operations 
[    0.013000] mce: CPU supports 10 MCE banks 
[    0.021002] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0 
[    0.022002] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0 
[    0.023003] Spectre V2 : Mitigation: Full generic retpoline 
[    0.027002] Spectre V2 : Spectre v2 / SpectreRSB mitigation: Filling RSB on context switch 
[    0.031002] Speculative Store Bypass: Vulnerable 
[    0.033105] Freeing SMP alternatives memory: 36K 
[    0.035000] smpboot: CPU0: Intel QEMU Virtual CPU version (cpu64-rhel6) (family: 0x6, model: 0xd, stepping: 0x3) 
[    0.035162] Performance Events: PMU not available due to virtualization, using software events only. 
[    0.037079] Hierarchical SRCU implementation. 
[    0.038258] NMI watchdog: Perf event create on CPU 0 failed with -2 
[    0.038798] NMI watchdog: Perf NMI watchdog permanently disabled 
[    0.039134] smp: Bringing up secondary CPUs ... 
[    0.040825] x86: Booting SMP configuration: 
[    0.041003] .... node  #0, CPUs:      #1 
[    0.001000] kvm-clock: cpu 1, msr 1:1ffc0041, secondary cpu clock 
[    0.001000] Disabled fast string operations 
[    0.066065] kvm-stealtime: cpu 1, msr 11fd23040 
[    0.067004] smp: Brought up 1 node, 2 CPUs 
[    0.067443] smpboot: Max logical packages: 2 
[    0.067893] smpboot: Total of 2 processors activated (11570.99 BogoMIPS) 
[    0.069247] devtmpfs: initialized 
[    0.069398] x86/mm: Memory block size: 128MB 
[    0.071056] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275000 ns 
[    0.072008] futex hash table entries: 512 (order: 3, 32768 bytes) 
[    0.072677] Starting tracer 'function_graph' 
[    0.234660] pinctrl core: initialized pinctrl subsystem 
[    0.238160] RTC time:  6:35:01, date: 08/21/18 
[    0.241196] NET: Registered protocol family 16 
[    0.245457] audit: initializing netlink subsys (disabled) 
[    0.248813] audit: type=2000 audit(1534828271.896:1): state=initialized audit_enabled=0 res=1 
[    0.251053] cpuidle: using governor menu 
[    0.254583] ACPI: bus type PCI registered 
[    0.255030] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 
[    0.257798] PCI: Using configuration type 1 for base access 
[    0.294454] HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages 
[    0.297488] cryptd: max_cpu_qlen set to 1000 
[    0.301080] ACPI: Added _OSI(Module Device) 
[    0.301636] ACPI: Added _OSI(Processor Device) 
[    0.302030] ACPI: Added _OSI(3.0 _SCP Extensions) 
[    0.303030] ACPI: Added _OSI(Processor Aggregator Device) 
[    0.303684] ACPI: Added _OSI(Linux-Dell-Video) 
[    0.368172] ACPI: 3 ACPI AML tables successfully acquired and loaded 
[    0.401608] ACPI: Interpreter enabled 
[    0.402216] ACPI: (supports S0 S5) 
[    0.402669] ACPI: Using IOAPIC for interrupt routing 
[    0.403178] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug 
[    0.408415] ACPI: Enabled 16 GPEs in block 00 to 0F 
[    0.508635] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) 
[    0.509046] acpi PNP0A03:00: _OSC: OS supports [ASPM ClockPM Segments MSI] 
[    0.510090] acpi PNP0A03:00: _OSC failed (AE_NOT_FOUND); disabling ASPM 
[    0.511181] acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended PCI configuration space under this bridge. 
[    0.527592] acpiphp: Slot [1] registered 
[    0.528387] acpiphp: Slot [2] registered 
[    0.529485] acpiphp: Slot [3] registered 
[    0.530383] acpiphp: Slot [4] registered 
[    0.531342] acpiphp: Slot [5] registered 
[    0.532301] acpiphp: Slot [6] registered 
[    0.533263] acpiphp: Slot [7] registered 
[    0.534157] acpiphp: Slot [8] registered 
[    0.535055] acpiphp: Slot [9] registered 
[    0.535872] acpiphp: Slot [10] registered 
[    0.536355] acpiphp: Slot [11] registered 
[    0.537351] acpiphp: Slot [12] registered 
[    0.538351] acpiphp: Slot [13] registered 
[    0.539291] acpiphp: Slot [14] registered 
[    0.540223] acpiphp: Slot [15] registered 
[    0.541102] acpiphp: Slot [16] registered 
[    0.541948] acpiphp: Slot [17] registered 
[    0.542356] acpiphp: Slot [18] registered 
[    0.543351] acpiphp: Slot [19] registered 
[    0.544365] acpiphp: Slot [20] registered 
[    0.545365] acpiphp: Slot [21] registered 
[    0.546338] acpiphp: Slot [22] registered 
[    0.547221] acpiphp: Slot [23] registered 
[    0.548136] acpiphp: Slot [24] registered 
[    0.548949] acpiphp: Slot [25] registered 
[    0.549348] acpiphp: Slot [26] registered 
[    0.550399] acpiphp: Slot [27] registered 
[    0.551342] acpiphp: Slot [28] registered 
[    0.552342] acpiphp: Slot [29] registered 
[    0.553240] acpiphp: Slot [30] registered 
[    0.554113] acpiphp: Slot [31] registered 
[    0.557917] PCI host bridge to bus 0000:00 
[    0.558030] pci_bus 0000:00: root bus resource [io  0x0000-0x0cf7 window] 
[    0.559029] pci_bus 0000:00: root bus resource [io  0x0d00-0xffff window] 
[    0.560029] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] 
[    0.560921] pci_bus 0000:00: root bus resource [mem 0xe0000000-0xfebfffff window] 
[    0.561913] pci_bus 0000:00: root bus resource [bus 00-ff] 
[    0.571340] pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io  0x01f0-0x01f7] 
[    0.572027] pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io  0x03f6] 
[    0.572784] pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io  0x0170-0x0177] 
[    0.573026] pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io  0x0376] 
[    0.583022] pci 0000:00:01.3: quirk: [io  0xb000-0xb03f] claimed by PIIX4 ACPI 
[    0.583895] pci 0000:00:01.3: quirk: [io  0xb100-0xb10f] claimed by PIIX4 SMB 
[    0.664517] ACPI: PCI Interrupt Link [LNKA] (IRQs 5 *10 11) 
[    0.667117] ACPI: PCI Interrupt Link [LNKB] (IRQs 5 *10 11) 
[    0.669603] ACPI: PCI Interrupt Link [LNKC] (IRQs 5 10 *11) 
[    0.672211] ACPI: PCI Interrupt Link [LNKD] (IRQs 5 10 *11) 
[    0.673911] ACPI: PCI Interrupt Link [LNKS] (IRQs *9) 
[    0.681338] pci 0000:00:02.0: vgaarb: setting as boot VGA device 
[    0.682000] pci 0000:00:02.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none 
[    0.683034] pci 0000:00:02.0: vgaarb: bridge control possible 
[    0.683710] vgaarb: loaded 
[    0.685896] SCSI subsystem initialized 
[    0.687419] ACPI: bus type USB registered 
[    0.688304] usbcore: registered new interface driver usbfs 
[    0.689159] usbcore: registered new interface driver hub 
[    0.691180] usbcore: registered new device driver usb 
[    0.692342] pps_core: LinuxPPS API ver. 1 registered 
[    0.693029] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it> 
[    0.695066] PTP clock support registered 
[    0.696425] EDAC MC: Ver: 3.0.0 
[    0.699219] PCI: Using ACPI for IRQ routing 
[    0.702342] NetLabel: Initializing 
[    0.703027] NetLabel:  domain hash size = 128 
[    0.704026] NetLabel:  protocols = UNLABELED CIPSOv4 CALIPSO 
[    0.705230] NetLabel:  unlabeled traffic allowed by default 
[    0.709158] clocksource: Switched to clocksource kvm-clock 
[    1.043058] VFS: Disk quotas dquot_6.6.0 
[    1.044224] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) 
[    1.046425] pnp: PnP ACPI init 
[    1.057685] pnp: PnP ACPI: found 5 devices 
[    1.088646] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns 
[    1.093170] NET: Registered protocol family 2 
[    1.095733] tcp_listen_portaddr_hash hash table entries: 2048 (order: 3, 32768 bytes) 
[    1.097642] TCP established hash table entries: 32768 (order: 6, 262144 bytes) 
[    1.099721] TCP bind hash table entries: 32768 (order: 7, 524288 bytes) 
[    1.101351] TCP: Hash tables configured (established 32768 bind 32768) 
[    1.103120] UDP hash table entries: 2048 (order: 4, 65536 bytes) 
[    1.104452] UDP-Lite hash table entries: 2048 (order: 4, 65536 bytes) 
[    1.106630] NET: Registered protocol family 1 
[    1.107703] pci 0000:00:00.0: Limiting direct PCI/PCI transfers 
[    1.109053] pci 0000:00:01.0: PIIX3: Enabling Passive Release 
[    1.110159] pci 0000:00:01.0: Activating ISA DMA hang workarounds 
[    1.118680] PCI Interrupt Link [LNKD] enabled at IRQ 11 
[    1.125487] pci 0000:00:01.2: quirk_usb_early_handoff+0x0/0x6c3 took 14194 usecs 
[    1.127381] pci 0000:00:02.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff] 
[    1.129119] Unpacking initramfs... 
[    2.183194] Freeing initrd memory: 22532K 
[    2.183794] PCI-DMA: Using software bounce buffering for IO (SWIOTLB) 
[    2.184707] software IO TLB [mem 0xdbffd000-0xdfffd000] (64MB) mapped at [(____ptrval____)-(____ptrval____)] 
[    2.187392] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x29b28086dab, max_idle_ns: 440795279059 ns 
[    2.197703] Initialise system trusted keyrings 
[    2.198397] Key type blacklist registered 
[    2.199545] workingset: timestamp_bits=36 max_order=20 bucket_order=0 
[    2.234998] zbud: loaded 
[    2.244135] pstore: using deflate compression 
[    2.413740] alg: No test for 842 (842-generic) 
[    2.414901] alg: No test for 842 (842-scomp) 
[    2.478792] NET: Registered protocol family 38 
[    2.479559] Key type asymmetric registered 
[    2.480390] Asymmetric key parser 'x509' registered 
[    2.481613] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 244) 
[    2.483192] io scheduler noop registered 
[    2.483716] io scheduler deadline registered 
[    2.485408] io scheduler cfq registered (default) 
[    2.486002] io scheduler mq-deadline registered 
[    2.487164] atomic64_test: passed for x86-64 platform with CX8 and with SSE 
[    2.489995] shpchp: Standard Hot Plug PCI Controller Driver version: 0.4 
[    2.492472] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input0 
[    2.493511] ACPI: Power Button [PWRF] 
[    2.505663] PCI Interrupt Link [LNKC] enabled at IRQ 10 
[    2.506369] virtio-pci 0000:00:03.0: virtio_pci: leaving for legacy driver 
[    2.513371] virtio-pci 0000:00:04.0: virtio_pci: leaving for legacy driver 
[    2.523306] PCI Interrupt Link [LNKA] enabled at IRQ 10 
[    2.524006] virtio-pci 0000:00:05.0: virtio_pci: leaving for legacy driver 
[    2.526098] Serial: 8250/16550 driver, 32 ports, IRQ sharing enabled 
[    2.548911] 00:04: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A 
[    2.583194] Non-volatile memory driver v1.3 
[    2.584247] Linux agpgart interface v0.103 
[    2.594479] scsi host0: ata_piix 
[    2.596735] scsi host1: ata_piix 
[    2.597752] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc000 irq 14 
[    2.598573] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc008 irq 15 
[    2.600974] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver 
[    2.601886] ehci-pci: EHCI PCI platform driver 
[    2.602654] ohci_hcd: USB 1.1 'Open' Host Controller (OHCI) Driver 
[    2.603452] ohci-pci: OHCI PCI platform driver 
[    2.604116] uhci_hcd: USB Universal Host Controller Interface driver 
[    2.610911] uhci_hcd 0000:00:01.2: UHCI Host Controller 
[    2.612123] uhci_hcd 0000:00:01.2: new USB bus registered, assigned bus number 1 
[    2.613133] uhci_hcd 0000:00:01.2: detected 2 ports 
[    2.613901] uhci_hcd 0000:00:01.2: irq 11, io base 0x0000c020 
[    2.615540] usb usb1: New USB device found, idVendor=1d6b, idProduct=0001, bcdDevice= 4.18 
[    2.616557] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 
[    2.617492] usb usb1: Product: UHCI Host Controller 
[    2.618096] usb usb1: Manufacturer: Linux 4.18.1-300.fc29.x86_64 uhci_hcd 
[    2.618887] usb usb1: SerialNumber: 0000:00:01.2 
[    2.620909] hub 1-0:1.0: USB hub found 
[    2.621586] hub 1-0:1.0: 2 ports detected 
[    2.623851] usbcore: registered new interface driver usbserial_generic 
[    2.624761] usbserial: USB Serial support registered for generic 
[    2.625898] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 
[    2.627996] serio: i8042 KBD port at 0x60,0x64 irq 1 
[    2.628669] serio: i8042 AUX port at 0x60,0x64 irq 12 
[    2.630960] mousedev: PS/2 mouse device common for all mice 
[    2.633919] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input1 
[    2.635535] rtc_cmos 00:00: RTC can wake from S4 
[    2.638298] rtc_cmos 00:00: registered as rtc0 
[    2.638345] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input4 
[    2.639344] rtc_cmos 00:00: alarms up to one day, 114 bytes nvram 
[    2.642299] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input3 
[    2.642440] device-mapper: uevent: version 1.0.3 
[    2.645429] device-mapper: ioctl: 4.39.0-ioctl (2018-04-03) initialised: dm-devel@redhat.com 
[    2.648603] hidraw: raw HID events driver (C) Jiri Kosina 
[    2.649931] usbcore: registered new interface driver usbhid 
[    2.650979] usbhid: USB HID core driver 
[    2.652239] drop_monitor: Initializing network drop monitor service 
[    2.654102] Initializing XFRM netlink socket 
[    2.657255] NET: Registered protocol family 10 
[    2.684616] Segment Routing with IPv6 
[    2.685648] mip6: Mobile IPv6 
[    2.686293] NET: Registered protocol family 17 
[    2.691247] RAS: Correctable Errors collector initialized. 
[    2.695082] registered taskstats version 1 
[    2.695904] Loading compiled-in X.509 certificates 
[    2.754461] Loaded X.509 cert 'Fedora kernel signing key: 666258f70aac6f2f628bce983bf9b90d01c76da1' 
[    2.756632] zswap: loaded using pool lzo/zbud 
[    2.782759] Key type big_key registered 
[    2.805322] Key type encrypted registered 
[    2.806771] ima: No TPM chip found, activating TPM-bypass! (rc=-19) 
[    2.808248] ima: Allocated hash algorithm: sha1 
[    2.814646]   Magic number: 14:254:570 
[    2.815944] rtc_cmos 00:00: setting system clock to 2018-08-21 06:35:04 UTC (1534833304) 
[    2.818166] Unstable clock detected, switching default tracing clock to "global" 
[    2.818166] If you want to keep using the local clock, then add: 
[    2.818166]   "trace_clock=local" 
[    2.818166] on the kernel command line 
[    2.847574] Freeing unused kernel memory: 2156K 
[    2.852213] Write protecting the kernel read-only data: 18432k 
[    2.862282] Freeing unused kernel memory: 2012K 
[    2.866112] Freeing unused kernel memory: 44K 
[    3.291848] x86/mm: Checked W+X mappings: passed, no W+X pages found. 
[    3.293381] x86/mm: Checking user space page tables 
[    3.714824] x86/mm: Checked W+X mappings: passed, no W+X pages found. 
[    3.716392] rodata_test: all tests were successful 
[    3.819670] systemd[1]: systemd 238 running in system mode. (+PAM +AUDIT +SELINUX +IMA -APPARMOR +SMACK +SYSVINIT +UTMP +LIBCRYPTSETUP +GCRYPT +GNUTLS +ACL +XZ +LZ4 +SECCOMP +BLKID +ELFUTILS +KMOD +IDN2 -IDN +PCRE2 default-hierarchy=hybrid) 
[    3.825246] systemd[1]: Detected virtualization kvm. 
[    3.826333] systemd[1]: Detected architecture x86-64. 
[    3.827405] systemd[1]: Running in initial RAM disk. 
 
Welcome to       
Fedora 28 (Twenty Eight) dracut-048-14.git20180726.fc28 (Initramfs)   
! 
 
[    3.859326] systemd[1]: Set hostname to <hp-dl380pgen8-02-vm-7.lab.bos.redhat.com>. 
[    4.403109] random: systemd: uninitialized urandom read (16 bytes read) 
[    4.405674] systemd[1]: Listening on udev Control Socket. 
[      
  OK     
] Listening on udev Control Socket. 
[    4.408550] random: systemd: uninitialized urandom read (16 bytes read) 
[    4.430742] systemd[1]: Created slice system-systemd\x2dhibernate\x2dresume.slice. 
[      
  OK     
] Created slice system-systemd\x2dhibernate\x2dresume.slice. 
[    4.433978] random: systemd: uninitialized urandom read (16 bytes read) 
[    4.437270] systemd[1]: Listening on Journal Socket. 
[      
  OK     
] Listening on Journal Socket. 
[    4.455282] systemd[1]: Starting Setup Virtual Console... 
         Starting Setup Virtual Console... 
[    4.463560] systemd[1]: Listening on Journal Audit Socket. 
[      
  OK     
] Listening on Journal Audit Socket. 
         Starting dracut cmdline hook... 
         Starting Create list of required st…ce nodes for the current kernel... 
[      
  OK     
] Listening on udev Kernel Socket. 
[      
  OK     
] Reached target Timers. 
         Starting Apply Kernel Variables... 
[      
  OK     
] Reached target Slices. 
[      
  OK     
] Listening on Journal Socket (/dev/log). 
         Starting Journal Service... 
[      
  OK     
] Reached target Sockets. 
[      
  OK     
] Reached target Swap. 
[      
  OK     
] Started Create list of required sta…vice nodes for the current kernel. 
[    4.913536] audit: type=1130 audit(1534833306.597:2): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=kmod-static-nodes comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' 
[      
  OK     
] Started Apply Kernel Variables. 
[    4.955861] audit: type=1130 audit(1534833306.639:3): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-sysctl comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' 
         Starting Create Static Device Nodes in /dev... 
[      
  OK     
] Started Create Static Device Nodes in /dev. 
[    5.230715] audit: type=1130 audit(1534833306.914:4): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-tmpfiles-setup-dev comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' 
[      
  OK     
] Started Journal Service. 
[    5.423611] audit: type=1130 audit(1534833307.107:5): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-journald comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' 
[      
  OK     
] Started Setup Virtual Console. 
[    5.953612] audit: type=1130 audit(1534833307.637:6): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-vconsole-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' 
[    5.957386] audit: type=1131 audit(1534833307.637:7): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-vconsole-setup comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' 
[      
  OK     
] Started dracut cmdline hook. 
[    6.484253] audit: type=1130 audit(1534833308.167:8): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-cmdline comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' 
         Starting dracut pre-udev hook... 
[      
  OK     
] Started dracut pre-udev hook. 
[    6.780137] audit: type=1130 audit(1534833308.463:9): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=dracut-pre-udev comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' 
         Starting udev Kernel Device Manager... 
[      
  OK     
] Started udev Kernel Device Manager. 
[    6.892646] audit: type=1130 audit(1534833308.576:10): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-udevd comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' 
         Starting udev Coldplug all Devices... 
         Mounting Kernel Configuration File System... 
[      
  OK     
] Mounted Kernel Configuration File System. 
[      
  OK     
] Started udev Coldplug all Devices. 
[    8.515739] audit: type=1130 audit(1534833310.199:11): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=systemd-udev-trigger comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' 
         Starting Show Plymouth Boot Screen... 
         Starting dracut initqueue hook... 
[    8.732112] audit: type=1130 audit(1534833310.415:12): pid=1 uid=0 auid=4294967295 ses=4294967295 subj=kernel msg='unit=plymouth-start comm="systemd" exe="/usr/lib/systemd/systemd" hostname=? addr=? terminal=? res=success' 
[      
  OK     
] Started Show Plymouth Boot Screen. [    8.737274] random: fast init done 
 
[      
  OK     
] Started Forward Password Requests to Plymouth Directory Watch.  
[      
  OK     
] Reached target Paths.


Note You need to log in before you can comment on or make changes to this bug.