| Summary: |
System hang when booting with ftrace=functio_graph in kernel commandline for 4.18.1-300 |
| Product: |
[Fedora] Fedora
|
Reporter: |
Zamir SUN <sztsian> |
| Component: |
kernel | Assignee: |
Kernel Maintainer List <kernel-maint> |
| Status: |
NEW
---
|
QA Contact: |
Fedora Extras Quality Assurance <extras-qa> |
| Severity: |
unspecified
|
Docs Contact: |
|
| Priority: |
unspecified
|
|
|
| Version: |
rawhide | CC: |
airlied, bskeggs, ewk, hdegoede, ichavero, itamar, jarodwilson, jglisse, john.j5live, jonathan, josef, kernel-maint, linville, mchehab, mjg59, steved
|
| Target Milestone: |
--- | |
|
| Target Release: |
--- | |
|
| Hardware: |
Unspecified | |
|
| OS: |
Unspecified | |
|
| Whiteboard: |
|
|
Fixed In Version:
|
|
Doc Type:
|
If docs needed, set a value
|
|---|
|
Doc Text:
|
|
Story Points:
|
---
|
|---|
|
Clone Of:
|
|
Environment:
|
|
|---|
|
Last Closed:
|
|
Type:
|
Bug
|
|---|
|
Regression:
|
---
|
Mount Type:
|
---
|
|---|
|
Documentation:
|
---
|
CRM:
|
|
|---|
|
Verified Versions:
|
|
Category:
|
---
|
|---|
|
oVirt Team:
|
---
|
RHEL 7.3 requirements from Atomic Host:
|
|
|---|
|
Cloudforms Team:
|
---
|
Target Upstream Version:
|
|
|---|
|
Embargoed:
|
|
| |
|---|
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.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> [ 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 [ 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.