We are having one server machine (ubuntu 16.04 OS) with 10 VMs.
When the server is rebooted, some VMs got failed to boot with systemd/dbus error messages.
Rebooting the affected VMs resolves this issue.
Jan 30 20:40:02 VM systemd[1]: Failed to subscribe to NameOwnerChanged signal for 'org.freedesktop.DisplayManager': Connection timed out
Jan 30 20:40:02 VM systemd[1]: Failed to subscribe to NameOwnerChanged signal for 'org.freedesktop.NetworkManager': Connection timed out
Jan 30 20:40:02 VM systemd[1]: Failed to subscribe to NameOwnerChanged signal for 'org.freedesktop.login1': Connection timed out
Jan 30 20:40:02 VM systemd[1]: Failed to subscribe to NameOwnerChanged signal for 'org.freedesktop.Accounts': Connection timed out
Jan 30 20:40:02 VM systemd[1]: Failed to subscribe to NameOwnerChanged signal for 'org.freedesktop.Avahi': Connection timed out
Jan 30 20:40:02 VM systemd[1]: Failed to subscribe to NameOwnerChanged signal for 'org.freedesktop.ModemManager1': Connection timed out
Jan 30 20:40:02 VM systemd[1]: Failed to subscribe to activation signal: Connection timed out
Jan 30 20:40:02 VM systemd[1]: Failed to register name: Connection timed out
Jan 30 20:40:02 VM systemd[1]: Failed to set up API bus: Connection timed out
Jan 30 20:40:02 VM systemd[1]: Failed to subscribe to NameOwnerChanged signal for 'org.freedesktop.NetworkManager': Connection timed out
Jan 30 20:40:02 VM systemd[1]: Failed to subscribe to NameOwnerChanged signal for 'org.freedesktop.login1': Connection timed out
Jan 30 20:40:02 VM systemd[1]: Failed to subscribe to NameOwnerChanged signal for 'org.freedesktop.Accounts': Connection timed out
Jan 30 20:40:02 VM systemd[1]: Failed to subscribe to NameOwnerChanged signal for 'org.freedesktop.Avahi': Connection timed out
Jan 30 20:40:02 VM systemd[1]: Failed to subscribe to NameOwnerChanged signal for 'org.freedesktop.ModemManager1': Connection timed out
Jan 30 20:40:02 VM systemd[1]: Failed to subscribe to activation signal: Connection timed out
Jan 30 20:40:02 VM systemd[1]: Failed to register name: Connection timed out
Jan 30 20:40:02 VM systemd[1]: Failed to set up API bus: Connection timed out
an 30 20:40:32 VM dbus[1009]: [system] Failed to activate service 'org.freedesktop.systemd1': timed out
Jan 30 20:40:32 VM systemd-logind[998]: Failed to enable subscription: Failed to activate service 'org.freedesktop.systemd1': timed out
Jan 30 20:40:32 VM systemd-logind[998]: Failed to fully start up daemon: Connection timed out
Jan 30 20:40:32 VM systemd-logind[998]: Failed to enable subscription: Failed to activate service 'org.freedesktop.systemd1': timed out
Jan 30 20:40:32 VM systemd-logind[998]: Failed to fully start up daemon: Connection timed out
Host machine specifications:-
OS : Ubuntu 16.04
Kernel : 4.15.0-47-generic
CPUs : 48 ( 2*12*2)
RAM : 64G
VM specifications:-
OS : Ubuntu 16.04
Kernel : 4.13.16
CPUs : 8
RAM : 4G
Attached the full log file.
Kindly help us to resolve this issue with a permanent fix.
With Best Regards,
M A PRIYANKA
VVDN Technologies Pvt Ltd
Cell : +91 8489574081 | Skype : priyankamathavan27
Disclaimer: © 2019 VVDN Technologies Pvt. Ltd. This e-mail contains PRIVILEGED AND CONFIDENTIAL INFORMATION intended solely for the use of the addressee(s). If you are not the intended recipient, please notify the sender by e-mail and delete the original message. Further, you are not to copy, disclose, or distribute this e-mail or its contents to any other person and any such actions are unlawful.
-- Logs begin at Wed 2019-01-30 20:38:29 IST, end at Wed 2019-01-30 20:55:40 IST. -- Jan 30 20:38:29 VM systemd-journald[442]: Runtime journal (/run/log/journal/) is 7.4M, max 59.5M, 52.1M free. Jan 30 20:38:29 VM kernel: random: get_random_bytes called from start_kernel+0x42/0x509 with crng_init=0 Jan 30 20:38:29 VM kernel: Linux version 4.13.16 (root@vvdn-HP-Laptop-15-bs1xx) (gcc version 5.4.0 20160609 (Ubuntu 5.4.0-6ubuntu1~16.04.10)) #1 SMP Thu Aug 23 12:25:32 IST 2018 (Ubuntu 4.13.0-45.50~16.04.1-generic 4.13.16) Jan 30 20:38:29 VM kernel: Command line: BOOT_IMAGE=/boot/vmlinuz-4.13.16 root=UUID=3f198ee9-95f7-41fb-a42a-b6c9e258b2ce ro quiet splash vt.handoff=7 Jan 30 20:38:29 VM kernel: KERNEL supported cpus: Jan 30 20:38:29 VM kernel: Intel GenuineIntel Jan 30 20:38:29 VM kernel: AMD AuthenticAMD Jan 30 20:38:29 VM kernel: Centaur CentaurHauls Jan 30 20:38:29 VM kernel: x86/fpu: Supporting XSAVE feature 0x001: 'x87 floating point registers' Jan 30 20:38:29 VM kernel: x86/fpu: Supporting XSAVE feature 0x002: 'SSE registers' Jan 30 20:38:29 VM kernel: x86/fpu: Supporting XSAVE feature 0x004: 'AVX registers' Jan 30 20:38:29 VM kernel: x86/fpu: xstate_offset[2]: 576, xstate_sizes[2]: 256 Jan 30 20:38:29 VM kernel: x86/fpu: Enabled xstate features 0x7, context size is 832 bytes, using 'standard' format. Jan 30 20:38:29 VM kernel: e820: BIOS-provided physical RAM map: Jan 30 20:38:29 VM kernel: BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable Jan 30 20:38:29 VM kernel: BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved Jan 30 20:38:29 VM kernel: BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved Jan 30 20:38:29 VM kernel: BIOS-e820: [mem 0x0000000000100000-0x00000000bffdefff] usable Jan 30 20:38:29 VM kernel: BIOS-e820: [mem 0x00000000bffdf000-0x00000000bfffffff] reserved Jan 30 20:38:29 VM kernel: BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved Jan 30 20:38:29 VM kernel: BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved Jan 30 20:38:29 VM kernel: BIOS-e820: [mem 0x0000000100000000-0x00000001bfffffff] usable Jan 30 20:38:29 VM kernel: NX (Execute Disable) protection: active Jan 30 20:38:29 VM kernel: random: fast init done Jan 30 20:38:29 VM kernel: SMBIOS 2.8 present. Jan 30 20:38:29 VM kernel: DMI: QEMU Standard PC (i440FX + PIIX, 1996), BIOS Ubuntu-1.8.2-1ubuntu1 04/01/2014 Jan 30 20:38:29 VM kernel: Hypervisor detected: KVM Jan 30 20:38:29 VM kernel: tsc: Fast TSC calibration using PIT Jan 30 20:38:29 VM kernel: e820: update [mem 0x00000000-0x00000fff] usable ==> reserved Jan 30 20:38:29 VM kernel: e820: remove [mem 0x000a0000-0x000fffff] usable Jan 30 20:38:29 VM kernel: e820: last_pfn = 0x1c0000 max_arch_pfn = 0x400000000 Jan 30 20:38:29 VM kernel: MTRR default type: write-back Jan 30 20:38:29 VM kernel: MTRR fixed ranges enabled: Jan 30 20:38:29 VM kernel: 00000-9FFFF write-back Jan 30 20:38:29 VM kernel: A0000-BFFFF uncachable Jan 30 20:38:29 VM kernel: C0000-FFFFF write-protect Jan 30 20:38:29 VM kernel: MTRR variable ranges enabled: Jan 30 20:38:29 VM kernel: 0 base 00C0000000 mask FFC0000000 uncachable Jan 30 20:38:29 VM kernel: 1 disabled Jan 30 20:38:29 VM kernel: 2 disabled Jan 30 20:38:29 VM kernel: 3 disabled Jan 30 20:38:29 VM kernel: 4 disabled Jan 30 20:38:29 VM kernel: 5 disabled Jan 30 20:38:29 VM kernel: 6 disabled Jan 30 20:38:29 VM kernel: 7 disabled Jan 30 20:38:29 VM kernel: x86/PAT: Configuration [0-7]: WB WC UC- UC WB WC UC- WT Jan 30 20:38:29 VM kernel: e820: last_pfn = 0xbffdf max_arch_pfn = 0x400000000 Jan 30 20:38:29 VM kernel: found SMP MP-table at [mem 0x000f6410-0x000f641f] mapped at [ffff9960800f6410] Jan 30 20:38:29 VM kernel: Scanning 1 areas for low memory corruption Jan 30 20:38:29 VM kernel: Base memory trampoline at [ffff996080099000] 99000 size 24576 Jan 30 20:38:29 VM kernel: BRK [0x16772b000, 0x16772bfff] PGTABLE Jan 30 20:38:29 VM kernel: BRK [0x16772c000, 0x16772cfff] PGTABLE Jan 30 20:38:29 VM kernel: BRK [0x16772d000, 0x16772dfff] PGTABLE Jan 30 20:38:29 VM kernel: BRK [0x16772e000, 0x16772efff] PGTABLE Jan 30 20:38:29 VM kernel: BRK [0x16772f000, 0x16772ffff] PGTABLE Jan 30 20:38:29 VM kernel: BRK [0x167730000, 0x167730fff] PGTABLE Jan 30 20:38:29 VM kernel: BRK [0x167731000, 0x167731fff] PGTABLE Jan 30 20:38:29 VM kernel: BRK [0x167732000, 0x167732fff] PGTABLE Jan 30 20:38:29 VM kernel: RAMDISK: [mem 0x32106000-0x3507afff] Jan 30 20:38:29 VM kernel: ACPI: Early table checksum verification disabled Jan 30 20:38:29 VM kernel: ACPI: RSDP 0x00000000000F63C0 000014 (v00 BOCHS ) Jan 30 20:38:29 VM kernel: ACPI: RSDT 0x00000000BFFE151D 000030 (v01 BOCHS BXPCRSDT 00000001 BXPC 00000001) Jan 30 20:38:29 VM kernel: ACPI: FACP 0x00000000BFFE03D4 000074 (v01 BOCHS BXPCFACP 00000001 BXPC 00000001) Jan 30 20:38:29 VM kernel: ACPI: DSDT 0x00000000BFFDF800 000BD4 (v01 BOCHS BXPCDSDT 00000001 BXPC 00000001) Jan 30 20:38:29 VM kernel: ACPI: FACS 0x00000000BFFDF7C0 000040 Jan 30 20:38:29 VM kernel: ACPI: SSDT 0x00000000BFFE0448 000FA5 (v01 BOCHS BXPCSSDT 00000001 BXPC 00000001) Jan 30 20:38:29 VM kernel: ACPI: APIC 0x00000000BFFE13ED 000130 (v01 BOCHS BXPCAPIC 00000001 BXPC 00000001) Jan 30 20:38:29 VM kernel: ACPI: Local APIC address 0xfee00000 Jan 30 20:38:29 VM kernel: No NUMA configuration found Jan 30 20:38:29 VM kernel: Faking a node at [mem 0x0000000000000000-0x00000001bfffffff] Jan 30 20:38:29 VM kernel: NODE_DATA(0) allocated [mem 0x1bffd3000-0x1bfffdfff] Jan 30 20:38:29 VM kernel: kvm-clock: Using msrs 4b564d01 and 4b564d00 Jan 30 20:38:29 VM kernel: kvm-clock: cpu 0, msr 1:bff53001, primary cpu clock Jan 30 20:38:29 VM kernel: kvm-clock: using sched offset of 21496169263 cycles Jan 30 20:38:29 VM kernel: clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns Jan 30 20:38:29 VM kernel: Zone ranges: Jan 30 20:38:29 VM kernel: DMA [mem 0x0000000000001000-0x0000000000ffffff] Jan 30 20:38:29 VM kernel: DMA32 [mem 0x0000000001000000-0x00000000ffffffff] Jan 30 20:38:29 VM kernel: Normal [mem 0x0000000100000000-0x00000001bfffffff] Jan 30 20:38:29 VM kernel: Device empty Jan 30 20:38:29 VM kernel: Movable zone start for each node Jan 30 20:38:29 VM kernel: Early memory node ranges Jan 30 20:38:29 VM kernel: node 0: [mem 0x0000000000001000-0x000000000009efff] Jan 30 20:38:29 VM kernel: node 0: [mem 0x0000000000100000-0x00000000bffdefff] Jan 30 20:38:29 VM kernel: node 0: [mem 0x0000000100000000-0x00000001bfffffff] Jan 30 20:38:29 VM kernel: Initmem setup node 0 [mem 0x0000000000001000-0x00000001bfffffff] Jan 30 20:38:29 VM kernel: On node 0 totalpages: 1572733 Jan 30 20:38:29 VM kernel: DMA zone: 64 pages used for memmap Jan 30 20:38:29 VM kernel: DMA zone: 21 pages reserved Jan 30 20:38:29 VM kernel: DMA zone: 3998 pages, LIFO batch:0 Jan 30 20:38:29 VM kernel: DMA32 zone: 12224 pages used for memmap Jan 30 20:38:29 VM kernel: DMA32 zone: 782303 pages, LIFO batch:31 Jan 30 20:38:29 VM kernel: Normal zone: 12288 pages used for memmap Jan 30 20:38:29 VM kernel: Normal zone: 786432 pages, LIFO batch:31 Jan 30 20:38:29 VM kernel: ACPI: PM-Timer IO Port: 0x608 Jan 30 20:38:29 VM kernel: ACPI: Local APIC address 0xfee00000 Jan 30 20:38:29 VM kernel: ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1]) Jan 30 20:38:29 VM kernel: IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23 Jan 30 20:38:29 VM kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl) Jan 30 20:38:29 VM kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level) Jan 30 20:38:29 VM kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level) Jan 30 20:38:29 VM kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level) Jan 30 20:38:29 VM kernel: ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level) Jan 30 20:38:29 VM kernel: ACPI: IRQ0 used by override. Jan 30 20:38:29 VM kernel: ACPI: IRQ5 used by override. Jan 30 20:38:29 VM kernel: ACPI: IRQ9 used by override. Jan 30 20:38:29 VM kernel: ACPI: IRQ10 used by override. Jan 30 20:38:29 VM kernel: ACPI: IRQ11 used by override. Jan 30 20:38:29 VM kernel: Using ACPI (MADT) for SMP configuration information Jan 30 20:38:29 VM kernel: smpboot: Allowing 24 CPUs, 0 hotplug CPUs Jan 30 20:38:29 VM kernel: PM: Registered nosave memory: [mem 0x00000000-0x00000fff] Jan 30 20:38:29 VM kernel: PM: Registered nosave memory: [mem 0x0009f000-0x0009ffff] Jan 30 20:38:29 VM kernel: PM: Registered nosave memory: [mem 0x000a0000-0x000effff] Jan 30 20:38:29 VM kernel: PM: Registered nosave memory: [mem 0x000f0000-0x000fffff] Jan 30 20:38:29 VM kernel: PM: Registered nosave memory: [mem 0xbffdf000-0xbfffffff] Jan 30 20:38:29 VM kernel: PM: Registered nosave memory: [mem 0xc0000000-0xfeffbfff] Jan 30 20:38:29 VM kernel: PM: Registered nosave memory: [mem 0xfeffc000-0xfeffffff] Jan 30 20:38:29 VM kernel: PM: Registered nosave memory: [mem 0xff000000-0xfffbffff] Jan 30 20:38:29 VM kernel: PM: Registered nosave memory: [mem 0xfffc0000-0xffffffff] Jan 30 20:38:29 VM kernel: e820: [mem 0xc0000000-0xfeffbfff] available for PCI devices Jan 30 20:38:29 VM kernel: Booting paravirtualized kernel on KVM Jan 30 20:38:29 VM kernel: clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645519600211568 ns Jan 30 20:38:29 VM kernel: setup_percpu: NR_CPUS:8192 nr_cpumask_bits:24 nr_cpu_ids:24 nr_node_ids:1 Jan 30 20:38:29 VM kernel: percpu: Embedded 45 pages/cpu @ffff996239000000 s146584 r8192 d29544 u262144 Jan 30 20:38:29 VM kernel: pcpu-alloc: s146584 r8192 d29544 u262144 alloc=1*2097152 Jan 30 20:38:29 VM kernel: pcpu-alloc: [0] 00 01 02 03 04 05 06 07 [0] 08 09 10 11 12 13 14 15 Jan 30 20:38:29 VM kernel: pcpu-alloc: [0] 16 17 18 19 20 21 22 23 Jan 30 20:38:29 VM kernel: KVM setup async PF for cpu 0 Jan 30 20:38:29 VM kernel: kvm-stealtime: cpu 0, msr 1b90161c0 Jan 30 20:38:29 VM kernel: Built 1 zonelists in Node order, mobility grouping on. Total pages: 1548136 Jan 30 20:38:29 VM kernel: Policy zone: Normal Jan 30 20:38:29 VM kernel: Kernel command line: BOOT_IMAGE=/boot/vmlinuz-4.13.16 root=UUID=3f198ee9-95f7-41fb-a42a-b6c9e258b2ce ro quiet splash vt.handoff=7 Jan 30 20:38:29 VM kernel: PID hash table entries: 4096 (order: 3, 32768 bytes) Jan 30 20:38:29 VM kernel: Calgary: detecting Calgary via BIOS EBDA area Jan 30 20:38:29 VM kernel: Calgary: Unable to locate Rio Grande table in EBDA - bailing! Jan 30 20:38:29 VM kernel: Memory: 6047052K/6290932K available (12300K kernel code, 2480K rwdata, 3952K rodata, 2364K init, 2372K bss, 243880K reserved, 0K cma-reserved) Jan 30 20:38:29 VM kernel: SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=24, Nodes=1 Jan 30 20:38:29 VM kernel: Kernel/User page tables isolation: enabled Jan 30 20:38:29 VM kernel: ftrace: allocating 37708 entries in 148 pages Jan 30 20:38:29 VM kernel: Hierarchical RCU implementation. Jan 30 20:38:29 VM kernel: RCU restricting CPUs from NR_CPUS=8192 to nr_cpu_ids=24. Jan 30 20:38:29 VM kernel: Tasks RCU enabled. Jan 30 20:38:29 VM kernel: RCU: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=24 Jan 30 20:38:29 VM kernel: NR_IRQS: 524544, nr_irqs: 616, preallocated irqs: 16 Jan 30 20:38:29 VM kernel: vt handoff: transparent VT on vt#7 Jan 30 20:38:29 VM kernel: Console: colour VGA+ 80x25 Jan 30 20:38:29 VM kernel: console [tty0] enabled Jan 30 20:38:29 VM kernel: tsc: Detected 2095.076 MHz processor Jan 30 20:38:29 VM kernel: Calibrating delay loop (skipped) preset value.. 4190.15 BogoMIPS (lpj=8380304) Jan 30 20:38:29 VM kernel: pid_max: default: 32768 minimum: 301 Jan 30 20:38:29 VM kernel: ACPI: Core revision 20170531 Jan 30 20:38:29 VM kernel: ACPI: 2 ACPI AML tables successfully acquired and loaded Jan 30 20:38:29 VM kernel: Security Framework initialized Jan 30 20:38:29 VM kernel: Yama: becoming mindful. Jan 30 20:38:29 VM kernel: AppArmor: AppArmor initialized Jan 30 20:38:29 VM kernel: Dentry cache hash table entries: 1048576 (order: 11, 8388608 bytes) Jan 30 20:38:29 VM kernel: Inode-cache hash table entries: 524288 (order: 10, 4194304 bytes) Jan 30 20:38:29 VM kernel: Mount-cache hash table entries: 16384 (order: 5, 131072 bytes) Jan 30 20:38:29 VM kernel: Mountpoint-cache hash table entries: 16384 (order: 5, 131072 bytes) Jan 30 20:38:29 VM kernel: FEATURE SPEC_CTRL Present Jan 30 20:38:29 VM kernel: mce: CPU supports 10 MCE banks Jan 30 20:38:29 VM kernel: Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0 Jan 30 20:38:29 VM kernel: Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0 Jan 30 20:38:29 VM kernel: Spectre V2 mitigation: Mitigation: Full generic retpoline Jan 30 20:38:29 VM kernel: Spectre V2 mitigation: Speculation control IBPB supported IBRS supported Jan 30 20:38:29 VM kernel: Spectre V2 mitigation: Retpoline compiled kernel. Defaulting IBRS to disabled Jan 30 20:38:29 VM kernel: Speculative Store Bypass: Vulnerable Jan 30 20:38:29 VM kernel: Freeing SMP alternatives memory: 36K Jan 30 20:38:29 VM kernel: smpboot: Max logical packages: 24 Jan 30 20:38:29 VM kernel: x2apic enabled Jan 30 20:38:29 VM kernel: Switched APIC routing to physical x2apic. Jan 30 20:38:29 VM kernel: ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1 Jan 30 20:38:29 VM kernel: TSC deadline timer enabled Jan 30 20:38:29 VM kernel: smpboot: CPU0: Intel Core Processor (Broadwell, IBRS) (family: 0x6, model: 0x3d, stepping: 0x2) Jan 30 20:38:29 VM kernel: Performance Events: unsupported p6 CPU model 61 no PMU driver, software events only. Jan 30 20:38:29 VM kernel: Hierarchical SRCU implementation. Jan 30 20:38:29 VM kernel: smp: Bringing up secondary CPUs ... Jan 30 20:38:29 VM kernel: x86: Booting SMP configuration: Jan 30 20:38:29 VM kernel: .... node #0, CPUs: #1 Jan 30 20:38:29 VM kernel: kvm-clock: cpu 1, msr 1:bff53041, secondary cpu clock Jan 30 20:38:29 VM kernel: KVM setup async PF for cpu 1 Jan 30 20:38:29 VM kernel: kvm-stealtime: cpu 1, msr 1b90561c0 Jan 30 20:38:29 VM kernel: #2 Jan 30 20:38:29 VM kernel: kvm-clock: cpu 2, msr 1:bff53081, secondary cpu clock Jan 30 20:38:29 VM kernel: KVM setup async PF for cpu 2 Jan 30 20:38:29 VM kernel: kvm-stealtime: cpu 2, msr 1b90961c0 Jan 30 20:38:29 VM kernel: #3 Jan 30 20:38:29 VM kernel: kvm-clock: cpu 3, msr 1:bff530c1, secondary cpu clock Jan 30 20:38:29 VM kernel: KVM setup async PF for cpu 3 Jan 30 20:38:29 VM kernel: kvm-stealtime: cpu 3, msr 1b90d61c0 Jan 30 20:38:29 VM kernel: #4 Jan 30 20:38:29 VM kernel: kvm-clock: cpu 4, msr 1:bff53101, secondary cpu clock Jan 30 20:38:29 VM kernel: KVM setup async PF for cpu 4 Jan 30 20:38:29 VM kernel: kvm-stealtime: cpu 4, msr 1b91161c0 Jan 30 20:38:29 VM kernel: #5 Jan 30 20:38:29 VM kernel: kvm-clock: cpu 5, msr 1:bff53141, secondary cpu clock Jan 30 20:38:29 VM kernel: KVM setup async PF for cpu 5 Jan 30 20:38:29 VM kernel: kvm-stealtime: cpu 5, msr 1b91561c0 Jan 30 20:38:29 VM kernel: #6 Jan 30 20:38:29 VM kernel: kvm-clock: cpu 6, msr 1:bff53181, secondary cpu clock Jan 30 20:38:29 VM kernel: KVM setup async PF for cpu 6 Jan 30 20:38:29 VM kernel: kvm-stealtime: cpu 6, msr 1b91961c0 Jan 30 20:38:29 VM kernel: #7 Jan 30 20:38:29 VM kernel: kvm-clock: cpu 7, msr 1:bff531c1, secondary cpu clock Jan 30 20:38:29 VM kernel: KVM setup async PF for cpu 7 Jan 30 20:38:29 VM kernel: kvm-stealtime: cpu 7, msr 1b91d61c0 Jan 30 20:38:29 VM kernel: #8 Jan 30 20:38:29 VM kernel: kvm-clock: cpu 8, msr 1:bff53201, secondary cpu clock Jan 30 20:38:29 VM kernel: KVM setup async PF for cpu 8 Jan 30 20:38:29 VM kernel: kvm-stealtime: cpu 8, msr 1b92161c0 Jan 30 20:38:29 VM kernel: #9 Jan 30 20:38:29 VM kernel: kvm-clock: cpu 9, msr 1:bff53241, secondary cpu clock Jan 30 20:38:29 VM kernel: KVM setup async PF for cpu 9 Jan 30 20:38:29 VM kernel: kvm-stealtime: cpu 9, msr 1b92561c0 Jan 30 20:38:29 VM kernel: #10 Jan 30 20:38:29 VM kernel: kvm-clock: cpu 10, msr 1:bff53281, secondary cpu clock Jan 30 20:38:29 VM kernel: KVM setup async PF for cpu 10 Jan 30 20:38:29 VM kernel: kvm-stealtime: cpu 10, msr 1b92961c0 Jan 30 20:38:29 VM kernel: #11 Jan 30 20:38:29 VM kernel: kvm-clock: cpu 11, msr 1:bff532c1, secondary cpu clock Jan 30 20:38:29 VM kernel: KVM setup async PF for cpu 11 Jan 30 20:38:29 VM kernel: kvm-stealtime: cpu 11, msr 1b92d61c0 Jan 30 20:38:29 VM kernel: #12 Jan 30 20:38:29 VM kernel: kvm-clock: cpu 12, msr 1:bff53301, secondary cpu clock Jan 30 20:38:29 VM kernel: KVM setup async PF for cpu 12 Jan 30 20:38:29 VM kernel: kvm-stealtime: cpu 12, msr 1b93161c0 Jan 30 20:38:29 VM kernel: #13 Jan 30 20:38:29 VM kernel: kvm-clock: cpu 13, msr 1:bff53341, secondary cpu clock Jan 30 20:38:29 VM kernel: KVM setup async PF for cpu 13 Jan 30 20:38:29 VM kernel: kvm-stealtime: cpu 13, msr 1b93561c0 Jan 30 20:38:29 VM kernel: #14 Jan 30 20:38:29 VM kernel: kvm-clock: cpu 14, msr 1:bff53381, secondary cpu clock Jan 30 20:38:29 VM kernel: KVM setup async PF for cpu 14 Jan 30 20:38:29 VM kernel: kvm-stealtime: cpu 14, msr 1b93961c0 Jan 30 20:38:29 VM kernel: #15 Jan 30 20:38:29 VM kernel: kvm-clock: cpu 15, msr 1:bff533c1, secondary cpu clock Jan 30 20:38:29 VM kernel: KVM setup async PF for cpu 15 Jan 30 20:38:29 VM kernel: kvm-stealtime: cpu 15, msr 1b93d61c0 Jan 30 20:38:29 VM kernel: #16 Jan 30 20:38:29 VM kernel: kvm-clock: cpu 16, msr 1:bff53401, secondary cpu clock Jan 30 20:38:29 VM kernel: KVM setup async PF for cpu 16 Jan 30 20:38:29 VM kernel: kvm-stealtime: cpu 16, msr 1b94161c0 Jan 30 20:38:29 VM kernel: #17 Jan 30 20:38:29 VM kernel: kvm-clock: cpu 17, msr 1:bff53441, secondary cpu clock Jan 30 20:38:29 VM kernel: KVM setup async PF for cpu 17 Jan 30 20:38:29 VM kernel: kvm-stealtime: cpu 17, msr 1b94561c0 Jan 30 20:38:29 VM kernel: #18 Jan 30 20:38:29 VM kernel: kvm-clock: cpu 18, msr 1:bff53481, secondary cpu clock Jan 30 20:38:29 VM kernel: KVM setup async PF for cpu 18 Jan 30 20:38:29 VM kernel: kvm-stealtime: cpu 18, msr 1b94961c0 Jan 30 20:38:29 VM kernel: #19 Jan 30 20:38:29 VM kernel: kvm-clock: cpu 19, msr 1:bff534c1, secondary cpu clock Jan 30 20:38:29 VM kernel: KVM setup async PF for cpu 19 Jan 30 20:38:29 VM kernel: kvm-stealtime: cpu 19, msr 1b94d61c0 Jan 30 20:38:29 VM kernel: #20 Jan 30 20:38:29 VM kernel: kvm-clock: cpu 20, msr 1:bff53501, secondary cpu clock Jan 30 20:38:29 VM kernel: KVM setup async PF for cpu 20 Jan 30 20:38:29 VM kernel: kvm-stealtime: cpu 20, msr 1b95161c0 Jan 30 20:38:29 VM kernel: #21 Jan 30 20:38:29 VM kernel: kvm-clock: cpu 21, msr 1:bff53541, secondary cpu clock Jan 30 20:38:29 VM kernel: KVM setup async PF for cpu 21 Jan 30 20:38:29 VM kernel: kvm-stealtime: cpu 21, msr 1b95561c0 Jan 30 20:38:29 VM kernel: #22 Jan 30 20:38:29 VM kernel: kvm-clock: cpu 22, msr 1:bff53581, secondary cpu clock Jan 30 20:38:29 VM kernel: KVM setup async PF for cpu 22 Jan 30 20:38:29 VM kernel: kvm-stealtime: cpu 22, msr 1b95961c0 Jan 30 20:38:29 VM kernel: #23 Jan 30 20:38:29 VM kernel: kvm-clock: cpu 23, msr 1:bff535c1, secondary cpu clock Jan 30 20:38:29 VM kernel: KVM setup async PF for cpu 23 Jan 30 20:38:29 VM kernel: kvm-stealtime: cpu 23, msr 1b95d61c0 Jan 30 20:38:29 VM kernel: smp: Brought up 1 node, 24 CPUs Jan 30 20:38:29 VM kernel: smpboot: Total of 24 processors activated (100563.64 BogoMIPS) Jan 30 20:38:29 VM kernel: devtmpfs: initialized Jan 30 20:38:29 VM kernel: x86/mm: Memory block size: 128MB Jan 30 20:38:29 VM kernel: evm: security.selinux Jan 30 20:38:29 VM kernel: evm: security.SMACK64 Jan 30 20:38:29 VM kernel: evm: security.SMACK64EXEC Jan 30 20:38:29 VM kernel: evm: security.SMACK64TRANSMUTE Jan 30 20:38:29 VM kernel: evm: security.SMACK64MMAP Jan 30 20:38:29 VM kernel: evm: security.ima Jan 30 20:38:29 VM kernel: evm: security.capability Jan 30 20:38:29 VM kernel: clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns Jan 30 20:38:29 VM kernel: futex hash table entries: 8192 (order: 7, 524288 bytes) Jan 30 20:38:29 VM kernel: pinctrl core: initialized pinctrl subsystem Jan 30 20:38:29 VM kernel: RTC time: 15:07:53, date: 01/30/19 Jan 30 20:38:29 VM kernel: NET: Registered protocol family 16 Jan 30 20:38:29 VM kernel: cpuidle: using governor ladder Jan 30 20:38:29 VM kernel: cpuidle: using governor menu Jan 30 20:38:29 VM kernel: PCCT header not found. Jan 30 20:38:29 VM kernel: ACPI: bus type PCI registered Jan 30 20:38:29 VM kernel: acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5 Jan 30 20:38:29 VM kernel: PCI: Using configuration type 1 for base access Jan 30 20:38:29 VM kernel: HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages Jan 30 20:38:29 VM kernel: ACPI: Added _OSI(Module Device) Jan 30 20:38:29 VM kernel: ACPI: Added _OSI(Processor Device) Jan 30 20:38:29 VM kernel: ACPI: Added _OSI(3.0 _SCP Extensions) Jan 30 20:38:29 VM kernel: ACPI: Added _OSI(Processor Aggregator Device) Jan 30 20:38:29 VM kernel: ACPI: Interpreter enabled Jan 30 20:38:29 VM kernel: ACPI: (supports S0 S5) Jan 30 20:38:29 VM kernel: ACPI: Using IOAPIC for interrupt routing Jan 30 20:38:29 VM kernel: PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug Jan 30 20:38:29 VM kernel: ACPI: Enabled 16 GPEs in block 00 to 0F Jan 30 20:38:29 VM kernel: ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff]) Jan 30 20:38:29 VM kernel: acpi PNP0A03:00: _OSC: OS supports [ASPM ClockPM Segments MSI] Jan 30 20:38:29 VM kernel: acpi PNP0A03:00: _OSC failed (AE_NOT_FOUND); disabling ASPM Jan 30 20:38:29 VM kernel: acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended PCI configuration space under this bridge. Jan 30 20:38:29 VM kernel: acpiphp: Slot [3] registered Jan 30 20:38:29 VM kernel: acpiphp: Slot [4] registered Jan 30 20:38:29 VM kernel: acpiphp: Slot [5] registered Jan 30 20:38:29 VM kernel: acpiphp: Slot [6] registered Jan 30 20:38:29 VM kernel: acpiphp: Slot [7] registered Jan 30 20:38:29 VM kernel: acpiphp: Slot [8] registered Jan 30 20:38:29 VM kernel: acpiphp: Slot [10] registered Jan 30 20:38:29 VM kernel: acpiphp: Slot [11] registered Jan 30 20:38:29 VM kernel: acpiphp: Slot [12] registered Jan 30 20:38:29 VM kernel: acpiphp: Slot [13] registered Jan 30 20:38:29 VM kernel: acpiphp: Slot [14] registered Jan 30 20:38:29 VM kernel: acpiphp: Slot [15] registered Jan 30 20:38:29 VM kernel: acpiphp: Slot [16] registered Jan 30 20:38:29 VM kernel: acpiphp: Slot [17] registered Jan 30 20:38:29 VM kernel: acpiphp: Slot [18] registered Jan 30 20:38:29 VM kernel: acpiphp: Slot [19] registered Jan 30 20:38:29 VM kernel: acpiphp: Slot [20] registered Jan 30 20:38:29 VM kernel: acpiphp: Slot [21] registered Jan 30 20:38:29 VM kernel: acpiphp: Slot [22] registered Jan 30 20:38:29 VM kernel: acpiphp: Slot [23] registered Jan 30 20:38:29 VM kernel: acpiphp: Slot [24] registered Jan 30 20:38:29 VM kernel: acpiphp: Slot [25] registered Jan 30 20:38:29 VM kernel: acpiphp: Slot [26] registered Jan 30 20:38:29 VM kernel: acpiphp: Slot [27] registered Jan 30 20:38:29 VM kernel: acpiphp: Slot [28] registered Jan 30 20:38:29 VM kernel: acpiphp: Slot [29] registered Jan 30 20:38:29 VM kernel: acpiphp: Slot [30] registered Jan 30 20:38:29 VM kernel: acpiphp: Slot [31] registered Jan 30 20:38:29 VM kernel: PCI host bridge to bus 0000:00 Jan 30 20:38:29 VM kernel: pci_bus 0000:00: root bus resource [io 0x0000-0x0cf7 window] Jan 30 20:38:29 VM kernel: pci_bus 0000:00: root bus resource [io 0x0d00-0xffff window] Jan 30 20:38:29 VM kernel: pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window] Jan 30 20:38:29 VM kernel: pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window] Jan 30 20:38:29 VM kernel: pci_bus 0000:00: root bus resource [bus 00-ff] Jan 30 20:38:29 VM kernel: pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 Jan 30 20:38:29 VM kernel: pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 Jan 30 20:38:29 VM kernel: pci 0000:00:01.1: [8086:7010] type 00 class 0x010180 Jan 30 20:38:29 VM kernel: pci 0000:00:01.1: reg 0x20: [io 0xc180-0xc18f] Jan 30 20:38:29 VM kernel: pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io 0x01f0-0x01f7] Jan 30 20:38:29 VM kernel: pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io 0x03f6] Jan 30 20:38:29 VM kernel: pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io 0x0170-0x0177] Jan 30 20:38:29 VM kernel: pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io 0x0376] Jan 30 20:38:29 VM kernel: pci 0000:00:01.3: [8086:7113] type 00 class 0x068000 Jan 30 20:38:29 VM kernel: pci 0000:00:01.3: quirk: [io 0x0600-0x063f] claimed by PIIX4 ACPI Jan 30 20:38:29 VM kernel: pci 0000:00:01.3: quirk: [io 0x0700-0x070f] claimed by PIIX4 SMB Jan 30 20:38:29 VM kernel: pci 0000:00:02.0: [1b36:0100] type 00 class 0x030000 Jan 30 20:38:29 VM kernel: pci 0000:00:02.0: reg 0x10: [mem 0xf4000000-0xf7ffffff] Jan 30 20:38:29 VM kernel: pci 0000:00:02.0: reg 0x14: [mem 0xf8000000-0xfbffffff] Jan 30 20:38:29 VM kernel: pci 0000:00:02.0: reg 0x18: [mem 0xfc094000-0xfc095fff] Jan 30 20:38:29 VM kernel: pci 0000:00:02.0: reg 0x1c: [io 0xc080-0xc09f] Jan 30 20:38:29 VM kernel: pci 0000:00:02.0: reg 0x30: [mem 0xfc080000-0xfc08ffff pref] Jan 30 20:38:29 VM kernel: pci 0000:00:03.0: [1af4:1009] type 00 class 0x000200 Jan 30 20:38:29 VM kernel: pci 0000:00:03.0: reg 0x10: [io 0xc000-0xc03f] Jan 30 20:38:29 VM kernel: pci 0000:00:03.0: reg 0x14: [mem 0xfc096000-0xfc096fff] Jan 30 20:38:29 VM kernel: pci 0000:00:04.0: [1af4:1009] type 00 class 0x000200 Jan 30 20:38:29 VM kernel: pci 0000:00:04.0: reg 0x10: [io 0xc040-0xc07f] Jan 30 20:38:29 VM kernel: pci 0000:00:04.0: reg 0x14: [mem 0xfc097000-0xfc097fff] Jan 30 20:38:29 VM kernel: pci 0000:00:05.0: [1af4:1000] type 00 class 0x020000 Jan 30 20:38:29 VM kernel: pci 0000:00:05.0: reg 0x10: [io 0xc0a0-0xc0bf] Jan 30 20:38:29 VM kernel: pci 0000:00:05.0: reg 0x14: [mem 0xfc098000-0xfc098fff] Jan 30 20:38:29 VM kernel: pci 0000:00:05.0: reg 0x30: [mem 0xfc000000-0xfc03ffff pref] Jan 30 20:38:29 VM kernel: pci 0000:00:06.0: [1af4:1000] type 00 class 0x020000 Jan 30 20:38:29 VM kernel: pci 0000:00:06.0: reg 0x10: [io 0xc0c0-0xc0df] Jan 30 20:38:29 VM kernel: pci 0000:00:06.0: reg 0x14: [mem 0xfc099000-0xfc099fff] Jan 30 20:38:29 VM kernel: pci 0000:00:06.0: reg 0x30: [mem 0xfc040000-0xfc07ffff pref] Jan 30 20:38:29 VM kernel: pci 0000:00:07.0: [8086:2668] type 00 class 0x040300 Jan 30 20:38:29 VM kernel: pci 0000:00:07.0: reg 0x10: [mem 0xfc090000-0xfc093fff] Jan 30 20:38:29 VM kernel: pci 0000:00:08.0: [1af4:1003] type 00 class 0x078000 Jan 30 20:38:29 VM kernel: pci 0000:00:08.0: reg 0x10: [io 0xc0e0-0xc0ff] Jan 30 20:38:29 VM kernel: pci 0000:00:08.0: reg 0x14: [mem 0xfc09a000-0xfc09afff] Jan 30 20:38:29 VM kernel: pci 0000:00:09.0: [8086:2934] type 00 class 0x0c0300 Jan 30 20:38:29 VM kernel: pci 0000:00:09.0: reg 0x20: [io 0xc100-0xc11f] Jan 30 20:38:29 VM kernel: pci 0000:00:09.1: [8086:2935] type 00 class 0x0c0300 Jan 30 20:38:29 VM kernel: pci 0000:00:09.1: reg 0x20: [io 0xc120-0xc13f] Jan 30 20:38:29 VM kernel: pci 0000:00:09.2: [8086:2936] type 00 class 0x0c0300 Jan 30 20:38:29 VM kernel: pci 0000:00:09.2: reg 0x20: [io 0xc140-0xc15f] Jan 30 20:38:29 VM kernel: pci 0000:00:09.7: [8086:293a] type 00 class 0x0c0320 Jan 30 20:38:29 VM kernel: pci 0000:00:09.7: reg 0x10: [mem 0xfc09b000-0xfc09bfff] Jan 30 20:38:29 VM kernel: pci 0000:00:0a.0: [1af4:1002] type 00 class 0x00ff00 Jan 30 20:38:29 VM kernel: pci 0000:00:0a.0: reg 0x10: [io 0xc160-0xc17f] Jan 30 20:38:29 VM kernel: pci 0000:00:0b.0: [1af4:1001] type 00 class 0x010000 Jan 30 20:38:29 VM kernel: pci 0000:00:0b.0: reg 0x10: [io 0x0000-0x003f] Jan 30 20:38:29 VM kernel: pci 0000:00:0b.0: reg 0x14: [mem 0x00000000-0x00000fff] Jan 30 20:38:29 VM kernel: ACPI: PCI Interrupt Link [LNKA] (IRQs 5 *10 11) Jan 30 20:38:29 VM kernel: ACPI: PCI Interrupt Link [LNKB] (IRQs 5 *10 11) Jan 30 20:38:29 VM kernel: ACPI: PCI Interrupt Link [LNKC] (IRQs 5 10 *11) Jan 30 20:38:29 VM kernel: ACPI: PCI Interrupt Link [LNKD] (IRQs 5 10 *11) Jan 30 20:38:29 VM kernel: ACPI: PCI Interrupt Link [LNKS] (IRQs *9) Jan 30 20:38:29 VM kernel: SCSI subsystem initialized Jan 30 20:38:29 VM kernel: libata version 3.00 loaded. Jan 30 20:38:29 VM kernel: pci 0000:00:02.0: vgaarb: setting as boot VGA device Jan 30 20:38:29 VM kernel: pci 0000:00:02.0: vgaarb: VGA device added: decodes=io+mem,owns=io+mem,locks=none Jan 30 20:38:29 VM kernel: pci 0000:00:02.0: vgaarb: bridge control possible Jan 30 20:38:29 VM kernel: vgaarb: loaded Jan 30 20:38:29 VM kernel: ACPI: bus type USB registered Jan 30 20:38:29 VM kernel: usbcore: registered new interface driver usbfs Jan 30 20:38:29 VM kernel: usbcore: registered new interface driver hub Jan 30 20:38:29 VM kernel: usbcore: registered new device driver usb Jan 30 20:38:29 VM kernel: EDAC MC: Ver: 3.0.0 Jan 30 20:38:29 VM kernel: PCI: Using ACPI for IRQ routing Jan 30 20:38:29 VM kernel: PCI: pci_cache_line_size set to 64 bytes Jan 30 20:38:29 VM kernel: e820: reserve RAM buffer [mem 0x0009fc00-0x0009ffff] Jan 30 20:38:29 VM kernel: e820: reserve RAM buffer [mem 0xbffdf000-0xbfffffff] Jan 30 20:38:29 VM kernel: NetLabel: Initializing Jan 30 20:38:29 VM kernel: NetLabel: domain hash size = 128 Jan 30 20:38:29 VM kernel: NetLabel: protocols = UNLABELED CIPSOv4 CALIPSO Jan 30 20:38:29 VM kernel: NetLabel: unlabeled traffic allowed by default Jan 30 20:38:29 VM kernel: clocksource: Switched to clocksource kvm-clock Jan 30 20:38:29 VM kernel: VFS: Disk quotas dquot_6.6.0 Jan 30 20:38:29 VM kernel: VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes) Jan 30 20:38:29 VM kernel: AppArmor: AppArmor Filesystem Enabled Jan 30 20:38:29 VM kernel: pnp: PnP ACPI init Jan 30 20:38:29 VM kernel: pnp 00:00: Plug and Play ACPI device, IDs PNP0b00 (active) Jan 30 20:38:29 VM kernel: pnp 00:01: Plug and Play ACPI device, IDs PNP0303 (active) Jan 30 20:38:29 VM kernel: pnp 00:02: Plug and Play ACPI device, IDs PNP0f13 (active) Jan 30 20:38:29 VM kernel: pnp 00:03: [dma 2] Jan 30 20:38:29 VM kernel: pnp 00:03: Plug and Play ACPI device, IDs PNP0700 (active) Jan 30 20:38:29 VM kernel: pnp 00:04: Plug and Play ACPI device, IDs PNP0501 (active) Jan 30 20:38:29 VM kernel: pnp: PnP ACPI: found 5 devices Jan 30 20:38:29 VM kernel: clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns Jan 30 20:38:29 VM kernel: pci 0000:00:0b.0: BAR 1: assigned [mem 0xc0000000-0xc0000fff] Jan 30 20:38:29 VM kernel: pci 0000:00:0b.0: BAR 0: assigned [io 0x1000-0x103f] Jan 30 20:38:29 VM kernel: pci_bus 0000:00: resource 4 [io 0x0000-0x0cf7 window] Jan 30 20:38:29 VM kernel: pci_bus 0000:00: resource 5 [io 0x0d00-0xffff window] Jan 30 20:38:29 VM kernel: pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window] Jan 30 20:38:29 VM kernel: pci_bus 0000:00: resource 7 [mem 0xc0000000-0xfebfffff window] Jan 30 20:38:29 VM kernel: NET: Registered protocol family 2 Jan 30 20:38:29 VM kernel: TCP established hash table entries: 65536 (order: 7, 524288 bytes) Jan 30 20:38:29 VM kernel: TCP bind hash table entries: 65536 (order: 8, 1048576 bytes) Jan 30 20:38:29 VM kernel: TCP: Hash tables configured (established 65536 bind 65536) Jan 30 20:38:29 VM kernel: UDP hash table entries: 4096 (order: 5, 131072 bytes) Jan 30 20:38:29 VM kernel: UDP-Lite hash table entries: 4096 (order: 5, 131072 bytes) Jan 30 20:38:29 VM kernel: NET: Registered protocol family 1 Jan 30 20:38:29 VM kernel: pci 0000:00:00.0: Limiting direct PCI/PCI transfers Jan 30 20:38:29 VM kernel: pci 0000:00:01.0: PIIX3: Enabling Passive Release Jan 30 20:38:29 VM kernel: pci 0000:00:01.0: Activating ISA DMA hang workarounds Jan 30 20:38:29 VM kernel: pci 0000:00:02.0: Video device with shadowed ROM at [mem 0x000c0000-0x000dffff] Jan 30 20:38:29 VM kernel: ACPI: PCI Interrupt Link [LNKA] enabled at IRQ 10 Jan 30 20:38:29 VM kernel: ACPI: PCI Interrupt Link [LNKB] enabled at IRQ 11 Jan 30 20:38:29 VM kernel: ACPI: PCI Interrupt Link [LNKC] enabled at IRQ 11 Jan 30 20:38:29 VM kernel: ACPI: PCI Interrupt Link [LNKD] enabled at IRQ 10 Jan 30 20:38:29 VM kernel: PCI: CLS 0 bytes, default 64 Jan 30 20:38:29 VM kernel: Unpacking initramfs... Jan 30 20:38:29 VM kernel: Freeing initrd memory: 48596K Jan 30 20:38:29 VM kernel: PCI-DMA: Using software bounce buffering for IO (SWIOTLB) Jan 30 20:38:29 VM kernel: software IO TLB [mem 0xbbfdf000-0xbffdf000] (64MB) mapped at [ffff99613bfdf000-ffff99613ffdefff] Jan 30 20:38:29 VM kernel: Scanning for low memory corruption every 60 seconds Jan 30 20:38:29 VM kernel: audit: initializing netlink subsys (disabled) Jan 30 20:38:29 VM kernel: audit: type=2000 audit(1548860874.518:1): state=initialized audit_enabled=0 res=1 Jan 30 20:38:29 VM kernel: Initialise system trusted keyrings Jan 30 20:38:29 VM kernel: Key type blacklist registered Jan 30 20:38:29 VM kernel: workingset: timestamp_bits=36 max_order=21 bucket_order=0 Jan 30 20:38:29 VM kernel: zbud: loaded Jan 30 20:38:29 VM kernel: squashfs: version 4.0 (2009/01/31) Phillip Lougher Jan 30 20:38:29 VM kernel: fuse init (API version 7.26) Jan 30 20:38:29 VM kernel: Key type asymmetric registered Jan 30 20:38:29 VM kernel: Asymmetric key parser 'x509' registered Jan 30 20:38:29 VM kernel: Block layer SCSI generic (bsg) driver version 0.4 loaded (major 247) Jan 30 20:38:29 VM kernel: io scheduler noop registered Jan 30 20:38:29 VM kernel: io scheduler deadline registered Jan 30 20:38:29 VM kernel: io scheduler cfq registered (default) Jan 30 20:38:29 VM kernel: intel_idle: does not run on family 6 model 61 Jan 30 20:38:29 VM kernel: input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input0 Jan 30 20:38:29 VM kernel: ACPI: Power Button [PWRF] Jan 30 20:38:29 VM kernel: GHES: HEST is not enabled! Jan 30 20:38:29 VM kernel: virtio-pci 0000:00:03.0: virtio_pci: leaving for legacy driver Jan 30 20:38:29 VM kernel: virtio-pci 0000:00:04.0: virtio_pci: leaving for legacy driver Jan 30 20:38:29 VM kernel: virtio-pci 0000:00:05.0: virtio_pci: leaving for legacy driver Jan 30 20:38:29 VM kernel: virtio-pci 0000:00:06.0: virtio_pci: leaving for legacy driver Jan 30 20:38:29 VM kernel: virtio-pci 0000:00:08.0: virtio_pci: leaving for legacy driver Jan 30 20:38:29 VM kernel: virtio-pci 0000:00:0a.0: virtio_pci: leaving for legacy driver Jan 30 20:38:29 VM kernel: virtio-pci 0000:00:0b.0: enabling device (0000 -> 0003) Jan 30 20:38:29 VM kernel: virtio-pci 0000:00:0b.0: virtio_pci: leaving for legacy driver Jan 30 20:38:29 VM kernel: Serial: 8250/16550 driver, 32 ports, IRQ sharing enabled Jan 30 20:38:29 VM kernel: 00:04: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A Jan 30 20:38:29 VM kernel: Linux agpgart interface v0.103 Jan 30 20:38:29 VM kernel: loop: module loaded Jan 30 20:38:29 VM kernel: ata_piix 0000:00:01.1: version 2.13 Jan 30 20:38:29 VM kernel: scsi host0: ata_piix Jan 30 20:38:29 VM kernel: scsi host1: ata_piix Jan 30 20:38:29 VM kernel: ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc180 irq 14 Jan 30 20:38:29 VM kernel: ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc188 irq 15 Jan 30 20:38:29 VM kernel: libphy: Fixed MDIO Bus: probed Jan 30 20:38:29 VM kernel: PPP generic driver version 2.4.2 Jan 30 20:38:29 VM kernel: ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver Jan 30 20:38:29 VM kernel: ehci-pci: EHCI PCI platform driver Jan 30 20:38:29 VM kernel: ehci-pci 0000:00:09.7: EHCI Host Controller Jan 30 20:38:29 VM kernel: ehci-pci 0000:00:09.7: new USB bus registered, assigned bus number 1 Jan 30 20:38:29 VM kernel: ehci-pci 0000:00:09.7: irq 10, io mem 0xfc09b000 Jan 30 20:38:29 VM kernel: ehci-pci 0000:00:09.7: USB 2.0 started, EHCI 1.00 Jan 30 20:38:29 VM kernel: usb usb1: New USB device found, idVendor=1d6b, idProduct=0002 Jan 30 20:38:29 VM kernel: usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 Jan 30 20:38:29 VM kernel: usb usb1: Product: EHCI Host Controller Jan 30 20:38:29 VM kernel: usb usb1: Manufacturer: Linux 4.13.16 ehci_hcd Jan 30 20:38:29 VM kernel: usb usb1: SerialNumber: 0000:00:09.7 Jan 30 20:38:29 VM kernel: hub 1-0:1.0: USB hub found Jan 30 20:38:29 VM kernel: hub 1-0:1.0: 6 ports detected Jan 30 20:38:29 VM kernel: ehci-platform: EHCI generic platform driver Jan 30 20:38:29 VM kernel: ohci_hcd: USB 1.1 'Open' Host Controller (OHCI) Driver Jan 30 20:38:29 VM kernel: ohci-pci: OHCI PCI platform driver Jan 30 20:38:29 VM kernel: ohci-platform: OHCI generic platform driver Jan 30 20:38:29 VM kernel: uhci_hcd: USB Universal Host Controller Interface driver Jan 30 20:38:29 VM kernel: uhci_hcd 0000:00:09.0: UHCI Host Controller Jan 30 20:38:29 VM kernel: uhci_hcd 0000:00:09.0: new USB bus registered, assigned bus number 2 Jan 30 20:38:29 VM kernel: uhci_hcd 0000:00:09.0: detected 2 ports Jan 30 20:38:29 VM kernel: uhci_hcd 0000:00:09.0: irq 10, io base 0x0000c100 Jan 30 20:38:29 VM kernel: usb usb2: New USB device found, idVendor=1d6b, idProduct=0001 Jan 30 20:38:29 VM kernel: usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1 Jan 30 20:38:29 VM kernel: usb usb2: Product: UHCI Host Controller Jan 30 20:38:29 VM kernel: usb usb2: Manufacturer: Linux 4.13.16 uhci_hcd Jan 30 20:38:29 VM kernel: usb usb2: SerialNumber: 0000:00:09.0 Jan 30 20:38:29 VM kernel: hub 2-0:1.0: USB hub found Jan 30 20:38:29 VM kernel: hub 2-0:1.0: 2 ports detected Jan 30 20:38:29 VM kernel: uhci_hcd 0000:00:09.1: UHCI Host Controller Jan 30 20:38:29 VM kernel: uhci_hcd 0000:00:09.1: new USB bus registered, assigned bus number 3 Jan 30 20:38:29 VM kernel: uhci_hcd 0000:00:09.1: detected 2 ports Jan 30 20:38:29 VM kernel: uhci_hcd 0000:00:09.1: irq 11, io base 0x0000c120 Jan 30 20:38:29 VM kernel: usb usb3: New USB device found, idVendor=1d6b, idProduct=0001 Jan 30 20:38:29 VM kernel: usb usb3: New USB device strings: Mfr=3, Product=2, SerialNumber=1 Jan 30 20:38:29 VM kernel: usb usb3: Product: UHCI Host Controller Jan 30 20:38:29 VM kernel: usb usb3: Manufacturer: Linux 4.13.16 uhci_hcd Jan 30 20:38:29 VM kernel: usb usb3: SerialNumber: 0000:00:09.1 Jan 30 20:38:29 VM kernel: hub 3-0:1.0: USB hub found Jan 30 20:38:29 VM kernel: hub 3-0:1.0: 2 ports detected Jan 30 20:38:29 VM kernel: uhci_hcd 0000:00:09.2: UHCI Host Controller Jan 30 20:38:29 VM kernel: uhci_hcd 0000:00:09.2: new USB bus registered, assigned bus number 4 Jan 30 20:38:29 VM kernel: uhci_hcd 0000:00:09.2: detected 2 ports Jan 30 20:38:29 VM kernel: uhci_hcd 0000:00:09.2: irq 11, io base 0x0000c140 Jan 30 20:38:29 VM kernel: usb usb4: New USB device found, idVendor=1d6b, idProduct=0001 Jan 30 20:38:29 VM kernel: usb usb4: New USB device strings: Mfr=3, Product=2, SerialNumber=1 Jan 30 20:38:29 VM kernel: usb usb4: Product: UHCI Host Controller Jan 30 20:38:29 VM kernel: usb usb4: Manufacturer: Linux 4.13.16 uhci_hcd Jan 30 20:38:29 VM kernel: usb usb4: SerialNumber: 0000:00:09.2 Jan 30 20:38:29 VM kernel: hub 4-0:1.0: USB hub found Jan 30 20:38:29 VM kernel: hub 4-0:1.0: 2 ports detected Jan 30 20:38:29 VM kernel: i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12 Jan 30 20:38:29 VM kernel: serio: i8042 KBD port at 0x60,0x64 irq 1 Jan 30 20:38:29 VM kernel: serio: i8042 AUX port at 0x60,0x64 irq 12 Jan 30 20:38:29 VM kernel: mousedev: PS/2 mouse device common for all mice Jan 30 20:38:29 VM kernel: rtc_cmos 00:00: RTC can wake from S4 Jan 30 20:38:29 VM kernel: rtc_cmos 00:00: rtc core: registered rtc_cmos as rtc0 Jan 30 20:38:29 VM kernel: rtc_cmos 00:00: alarms up to one day, 114 bytes nvram Jan 30 20:38:29 VM kernel: input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input1 Jan 30 20:38:29 VM kernel: i2c /dev entries driver Jan 30 20:38:29 VM kernel: device-mapper: uevent: version 1.0.3 Jan 30 20:38:29 VM kernel: device-mapper: ioctl: 4.37.0-ioctl (2017-09-20) initialised: dm-devel@xxxxxxxxxx Jan 30 20:38:29 VM kernel: ledtrig-cpu: registered to indicate activity on CPUs Jan 30 20:38:29 VM kernel: NET: Registered protocol family 10 Jan 30 20:38:29 VM kernel: ata1.01: NODEV after polling detection Jan 30 20:38:29 VM kernel: ata1.00: ATA-7: QEMU HARDDISK, 2.5+, max UDMA/100 Jan 30 20:38:29 VM kernel: ata1.00: 41943040 sectors, multi 16: LBA48 Jan 30 20:38:29 VM kernel: ata1.00: configured for MWDMA2 Jan 30 20:38:29 VM kernel: scsi 0:0:0:0: Direct-Access ATA QEMU HARDDISK 2.5+ PQ: 0 ANSI: 5 Jan 30 20:38:29 VM kernel: sd 0:0:0:0: [sda] 41943040 512-byte logical blocks: (21.5 GB/20.0 GiB) Jan 30 20:38:29 VM kernel: sd 0:0:0:0: Attached scsi generic sg0 type 0 Jan 30 20:38:29 VM kernel: sd 0:0:0:0: [sda] Write Protect is off Jan 30 20:38:29 VM kernel: sd 0:0:0:0: [sda] Mode Sense: 00 3a 00 00 Jan 30 20:38:29 VM kernel: sd 0:0:0:0: [sda] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA Jan 30 20:38:29 VM kernel: Segment Routing with IPv6 Jan 30 20:38:29 VM kernel: NET: Registered protocol family 17 Jan 30 20:38:29 VM kernel: Key type dns_resolver registered Jan 30 20:38:29 VM kernel: sda: sda1 sda2 < sda5 sda6 > Jan 30 20:38:29 VM kernel: sd 0:0:0:0: [sda] Attached SCSI disk Jan 30 20:38:29 VM kernel: RAS: Correctable Errors collector initialized. Jan 30 20:38:29 VM kernel: sched_clock: Marking stable (2305343433, 0)->(3132052187, -826708754) Jan 30 20:38:29 VM kernel: registered taskstats version 1 Jan 30 20:38:29 VM kernel: Loading compiled-in X.509 certificates Jan 30 20:38:29 VM kernel: Loaded X.509 cert 'Build time autogenerated kernel key: 4727b567f18436aaabb1bdc7ca170a2c416c4d67' Jan 30 20:38:29 VM kernel: zswap: loaded using pool lzo/zbud Jan 30 20:38:29 VM kernel: Key type big_key registered Jan 30 20:38:29 VM kernel: Key type trusted registered Jan 30 20:38:29 VM kernel: Key type encrypted registered Jan 30 20:38:29 VM kernel: AppArmor: AppArmor sha1 policy hashing enabled Jan 30 20:38:29 VM kernel: ima: No TPM chip found, activating TPM-bypass! (rc=-19) Jan 30 20:38:29 VM kernel: evm: HMAC attrs: 0x1 Jan 30 20:38:29 VM kernel: Magic number: 3:878:134 Jan 30 20:38:29 VM kernel: virtio-pci 0000:00:03.0: hash matches Jan 30 20:38:29 VM kernel: acpi device:09: hash matches Jan 30 20:38:29 VM kernel: rtc_cmos 00:00: setting system clock to 2019-01-30 15:07:55 UTC (1548860875) Jan 30 20:38:29 VM kernel: BIOS EDD facility v0.16 2004-Jun-25, 0 devices found Jan 30 20:38:29 VM kernel: EDD information not available. Jan 30 20:38:29 VM kernel: PM: Hibernation image not present or could not be loaded. Jan 30 20:38:29 VM kernel: Freeing unused kernel memory: 2364K Jan 30 20:38:29 VM kernel: Write protecting the kernel read-only data: 18432k Jan 30 20:38:29 VM kernel: Freeing unused kernel memory: 2024K Jan 30 20:38:29 VM kernel: Freeing unused kernel memory: 144K Jan 30 20:38:29 VM kernel: x86/mm: Checked W+X mappings: passed, no W+X pages found. Jan 30 20:38:29 VM kernel: x86/mm: Checking user space page tables Jan 30 20:38:29 VM kernel: x86/mm: Checked W+X mappings: passed, no W+X pages found. Jan 30 20:38:29 VM kernel: FDC 0 is a S82078B Jan 30 20:38:29 VM kernel: input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input4 Jan 30 20:38:29 VM kernel: input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input3 Jan 30 20:38:29 VM kernel: virtio_net virtio3 ens6: renamed from eth1 Jan 30 20:38:29 VM kernel: virtio_net virtio2 ens5: renamed from eth0 Jan 30 20:38:29 VM kernel: [drm] Device Version 0.0 Jan 30 20:38:29 VM kernel: [drm] Compression level 0 log level 0 Jan 30 20:38:29 VM kernel: [drm] 12286 io pages at offset 0x1000000 Jan 30 20:38:29 VM kernel: [drm] 16777216 byte draw area at offset 0x0 Jan 30 20:38:29 VM kernel: [drm] RAM header offset: 0x3ffe000 Jan 30 20:38:29 VM kernel: [TTM] Zone kernel: Available graphics memory: 3050108 kiB Jan 30 20:38:29 VM kernel: [TTM] Zone dma32: Available graphics memory: 2097152 kiB Jan 30 20:38:29 VM kernel: [TTM] Initializing pool allocator Jan 30 20:38:29 VM kernel: [TTM] Initializing DMA pool allocator Jan 30 20:38:29 VM kernel: [drm] qxl: 16M of VRAM memory size Jan 30 20:38:29 VM kernel: [drm] qxl: 63M of IO pages memory ready (VRAM domain) Jan 30 20:38:29 VM kernel: [drm] qxl: 64M of Surface memory size Jan 30 20:38:29 VM kernel: [drm] main mem slot 1 [f4000000,3ffe000] Jan 30 20:38:29 VM kernel: [drm] surface mem slot 2 [f8000000,4000000] Jan 30 20:38:29 VM kernel: [drm] fb mappable at 0xF4000000, size 3145728 Jan 30 20:38:29 VM kernel: [drm] fb: depth 24, pitch 4096, width 1024, height 768 Jan 30 20:38:29 VM kernel: fbcon: qxldrmfb (fb0) is primary device Jan 30 20:38:29 VM kernel: Console: switching to colour frame buffer device 128x48 Jan 30 20:38:29 VM kernel: qxl 0000:00:02.0: fb0: qxldrmfb frame buffer device Jan 30 20:38:29 VM kernel: [drm] Initialized qxl 0.1.0 20120117 for 0000:00:02.0 on minor 0 Jan 30 20:38:29 VM kernel: clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x1e33052aadd, max_idle_ns: 440795310221 ns Jan 30 20:38:29 VM kernel: EXT4-fs (sda6): mounted filesystem with ordered data mode. Opts: (null) Jan 30 20:38:29 VM kernel: random: crng init done Jan 30 20:38:29 VM systemd[1]: systemd 229 running in system mode. (+PAM +AUDIT +SELINUX +IMA +APPARMOR +SMACK +SYSVINIT +UTMP +LIBCRYPTSETUP +GCRYPT +GNUTLS +ACL +XZ -LZ4 +SECCOMP +BLKID +ELFUTILS +KMOD -IDN) Jan 30 20:38:29 VM systemd[1]: Detected virtualization qemu. Jan 30 20:38:29 VM systemd[1]: Detected architecture x86-64. Jan 30 20:38:29 VM systemd[1]: Set hostname to <VM>. Jan 30 20:38:29 VM systemd[1]: Listening on /dev/initctl Compatibility Named Pipe. Jan 30 20:38:29 VM systemd[1]: Reached target User and Group Name Lookups. Jan 30 20:38:29 VM systemd[1]: Listening on Journal Socket. Jan 30 20:38:29 VM systemd[1]: Listening on Journal Socket (/dev/log). Jan 30 20:38:29 VM systemd[1]: Listening on Journal Audit Socket. Jan 30 20:38:29 VM systemd[1]: Listening on fsck to fsckd communication Socket. Jan 30 20:38:29 VM systemd[1]: Started Forward Password Requests to Wall Directory Watch. Jan 30 20:38:29 VM systemd[1]: Set up automount Arbitrary Executable File Formats File System Automount Point. Jan 30 20:38:29 VM systemd[1]: Listening on Syslog Socket. Jan 30 20:38:29 VM systemd[1]: Listening on udev Kernel Socket. Jan 30 20:38:29 VM kernel: lp: driver loaded but no devices found Jan 30 20:38:29 VM systemd[1]: Mounted POSIX Message Queue File System. Jan 30 20:38:29 VM systemd[1]: Mounted Huge Pages File System. Jan 30 20:38:29 VM systemd[1]: Mounted Debug File System. Jan 30 20:38:29 VM kernel: ppdev: user-space parallel port driver Jan 30 20:38:29 VM systemd[1]: Started Load Kernel Modules. Jan 30 20:38:29 VM systemd[1]: Mounting FUSE Control File System... Jan 30 20:38:29 VM systemd[1]: Mounting Configuration File System... Jan 30 20:38:29 VM systemd[1]: Starting Apply Kernel Variables... Jan 30 20:38:29 VM systemd[1]: Mounted Configuration File System. Jan 30 20:38:29 VM systemd[1]: Mounted FUSE Control File System. Jan 30 20:38:29 VM systemd-journald[442]: Journal started Jan 30 20:38:29 VM systemd-modules-load[439]: Inserted module 'lp' Jan 30 20:38:29 VM systemd[1]: Started Journal Service. Jan 30 20:38:29 VM systemd-modules-load[439]: Inserted module 'ppdev' Jan 30 20:38:29 VM systemd-modules-load[439]: Inserted module 'parport_pc' Jan 30 20:38:29 VM loadkeys[441]: Loading /etc/console-setup/cached.kmap.gz Jan 30 20:38:29 VM systemd[1]: Started Set console keymap. Jan 30 20:38:30 VM systemd[1]: Started Apply Kernel Variables. Jan 30 20:38:30 VM systemd[1]: Started Create Static Device Nodes in /dev. Jan 30 20:38:30 VM systemd[1]: Starting udev Kernel Device Manager... Jan 30 20:38:33 VM systemd[1]: Started udev Kernel Device Manager. Jan 30 20:38:33 VM systemd[1]: Starting Remount Root and Kernel File Systems... Jan 30 20:38:33 VM kernel: EXT4-fs (sda6): re-mounted. Opts: errors=remount-ro Jan 30 20:38:33 VM systemd[1]: Started Remount Root and Kernel File Systems. Jan 30 20:38:33 VM systemd[1]: Reached target Local File Systems (Pre). Jan 30 20:38:33 VM systemd[1]: tmp.mount: Directory /tmp to mount over is not empty, mounting anyway. Jan 30 20:38:33 VM systemd[1]: Mounting /tmp... Jan 30 20:38:33 VM systemd[1]: Starting Flush Journal to Persistent Storage... Jan 30 20:38:33 VM systemd[1]: Starting udev Coldplug all Devices... Jan 30 20:38:33 VM systemd[1]: Starting Load/Save Random Seed... Jan 30 20:38:34 VM systemd[1]: Started Flush Journal to Persistent Storage. Jan 30 20:38:34 VM systemd[1]: Started udev Coldplug all Devices. Jan 30 20:38:34 VM systemd[1]: Starting Show Plymouth Boot Screen... Jan 30 20:38:34 VM systemd[1]: Found device /dev/ttyS0. Jan 30 20:38:36 VM systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch. Jan 30 20:38:36 VM systemd[1]: Started Load/Save Random Seed. Jan 30 20:38:38 VM kernel: EXT4-fs (loop0): mounted filesystem with ordered data mode. Opts: (null) Jan 30 20:38:38 VM systemd[1]: Mounted /tmp. Jan 30 20:38:38 VM systemd[1]: Reached target Local File Systems. Jan 30 20:38:38 VM systemd[1]: Starting Tell Plymouth To Write Out Runtime Data... Jan 30 20:38:38 VM systemd[1]: Starting Create Volatile Files and Directories... Jan 30 20:38:38 VM systemd[1]: Starting LSB: ebtables ruleset management... Jan 30 20:38:38 VM systemd-tmpfiles[595]: [/usr/lib/tmpfiles.d/var.conf:14] Duplicate line for path "/var/log", ignoring. Jan 30 20:38:39 VM systemd[1]: Starting Clean up any mess left by 0dns-up... Jan 30 20:38:39 VM systemd[1]: Starting Set console font and keymap... Jan 30 20:38:39 VM systemd[1]: Starting LSB: AppArmor initialization... Jan 30 20:38:39 VM systemd[1]: Starting Enable support for additional executable binary formats... Jan 30 20:38:40 VM kernel: piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 0 Jan 30 20:38:41 VM kernel: 9pnet: Installing 9P2000 support Jan 30 20:38:42 VM systemd[1]: Started Tell Plymouth To Write Out Runtime Data. Jan 30 20:38:43 VM systemd[1]: proc-sys-fs-binfmt_misc.automount: Got automount request for /proc/sys/fs/binfmt_misc, triggered by 600 (update-binfmts) Jan 30 20:38:43 VM systemd[1]: Mounting Arbitrary Executable File Formats File System... Jan 30 20:38:44 VM systemd[1]: Started Show Plymouth Boot Screen. Jan 30 20:38:44 VM systemd[1]: Started Forward Password Requests to Plymouth Directory Watch. Jan 30 20:38:45 VM systemd[1]: Mounted Arbitrary Executable File Formats File System. Jan 30 20:38:46 VM kernel: AVX2 version of gcm_enc/dec engaged. Jan 30 20:38:46 VM kernel: AES CTR mode by8 optimization enabled Jan 30 20:38:46 VM systemd[1]: Started Clean up any mess left by 0dns-up. Jan 30 20:38:46 VM systemd[1]: Starting Nameserver information manager... Jan 30 20:38:47 VM systemd[1]: Started Nameserver information manager. Jan 30 20:38:47 VM systemd[1]: Reached target Network (Pre). Jan 30 20:38:51 VM systemd[1]: Started Enable support for additional executable binary formats. Jan 30 20:38:51 VM systemd[1]: Started Create Volatile Files and Directories. Jan 30 20:38:51 VM systemd[1]: Starting Update UTMP about System Boot/Shutdown... Jan 30 20:38:52 VM systemd[1]: Starting Network Time Synchronization... Jan 30 20:38:54 VM kernel: snd_hda_codec_generic hdaudioC0D0: autoconfig for Generic: line_outs=1 (0x3/0x0/0x0/0x0/0x0) type:line Jan 30 20:38:54 VM kernel: snd_hda_codec_generic hdaudioC0D0: speaker_outs=0 (0x0/0x0/0x0/0x0/0x0) Jan 30 20:38:54 VM kernel: snd_hda_codec_generic hdaudioC0D0: hp_outs=0 (0x0/0x0/0x0/0x0/0x0) Jan 30 20:38:54 VM kernel: snd_hda_codec_generic hdaudioC0D0: mono: mono_out=0x0 Jan 30 20:38:54 VM kernel: snd_hda_codec_generic hdaudioC0D0: inputs: Jan 30 20:38:54 VM kernel: snd_hda_codec_generic hdaudioC0D0: Line=0x5 Jan 30 20:38:56 VM systemd[1]: Started Network Time Synchronization. Jan 30 20:38:56 VM systemd[1]: Reached target System Time Synchronized. Jan 30 20:38:56 VM systemd[1]: Reached target Sound Card. Jan 30 20:39:01 VM systemd[1]: Started Update UTMP about System Boot/Shutdown. Jan 30 20:39:03 VM systemd[1]: Started Set console font and keymap. Jan 30 20:39:03 VM systemd[1]: Created slice system-getty.slice. Jan 30 20:39:04 VM systemd[1]: Started LSB: ebtables ruleset management. Jan 30 20:39:06 VM apparmor[599]: * Starting AppArmor profiles Jan 30 20:39:20 VM systemd[1]: Found device QEMU_HARDDISK 5. Jan 30 20:39:20 VM systemd[1]: Activating swap /dev/disk/by-uuid/521fd4c1-8d9c-45d0-b46b-cfebac3420ce... Jan 30 20:39:21 VM kernel: Adding 1998844k swap on /dev/sda5. Priority:-1 extents:1 across:1998844k FS Jan 30 20:39:21 VM systemd[1]: Activated swap /dev/disk/by-uuid/521fd4c1-8d9c-45d0-b46b-cfebac3420ce. Jan 30 20:39:21 VM systemd[1]: Reached target Swap. Jan 30 20:39:22 VM apparmor[599]: Skipping profile in /etc/apparmor.d/disable: usr.sbin.rsyslogd Jan 30 20:39:27 VM audit[949]: AVC apparmor="STATUS" operation="profile_load" profile="unconfined" name="/usr/lib/snapd/snap-confine" pid=949 comm="apparmor_parser" Jan 30 20:39:27 VM audit[949]: AVC apparmor="STATUS" operation="profile_load" profile="unconfined" name="/usr/lib/snapd/snap-confine//mount-namespace-capture-helper" pid=949 comm="apparmor_parser" Jan 30 20:39:27 VM kernel: audit: type=1400 audit(1548860967.297:2): apparmor="STATUS" operation="profile_load" profile="unconfined" name="/usr/lib/snapd/snap-confine" pid=949 comm="apparmor_parser" Jan 30 20:39:27 VM kernel: audit: type=1400 audit(1548860967.297:3): apparmor="STATUS" operation="profile_load" profile="unconfined" name="/usr/lib/snapd/snap-confine//mount-namespace-capture-helper" pid=949 comm="apparmor_parser" Jan 30 20:39:27 VM audit[953]: AVC apparmor="STATUS" operation="profile_load" profile="unconfined" name="/usr/sbin/ippusbxd" pid=953 comm="apparmor_parser" Jan 30 20:39:27 VM kernel: audit: type=1400 audit(1548860967.817:4): apparmor="STATUS" operation="profile_load" profile="unconfined" name="/usr/sbin/ippusbxd" pid=953 comm="apparmor_parser" Jan 30 20:39:28 VM audit[950]: AVC apparmor="STATUS" operation="profile_load" profile="unconfined" name="/usr/sbin/cups-browsed" pid=950 comm="apparmor_parser" Jan 30 20:39:28 VM kernel: audit: type=1400 audit(1548860968.113:5): apparmor="STATUS" operation="profile_load" profile="unconfined" name="/usr/sbin/cups-browsed" pid=950 comm="apparmor_parser" Jan 30 20:39:28 VM audit[945]: AVC apparmor="STATUS" operation="profile_load" profile="unconfined" name="/usr/lib/lightdm/lightdm-guest-session" pid=945 comm="apparmor_parser" Jan 30 20:39:28 VM audit[945]: AVC apparmor="STATUS" operation="profile_load" profile="unconfined" name="/usr/lib/lightdm/lightdm-guest-session//chromium" pid=945 comm="apparmor_parser" Jan 30 20:39:28 VM kernel: audit: type=1400 audit(1548860968.128:6): apparmor="STATUS" operation="profile_load" profile="unconfined" name="/usr/lib/lightdm/lightdm-guest-session" pid=945 comm="apparmor_parser" Jan 30 20:39:28 VM kernel: audit: type=1400 audit(1548860968.128:7): apparmor="STATUS" operation="profile_load" profile="unconfined" name="/usr/lib/lightdm/lightdm-guest-session//chromium" pid=945 comm="apparmor_parser" Jan 30 20:39:28 VM audit[955]: AVC apparmor="STATUS" operation="profile_load" profile="unconfined" name="/usr/sbin/tcpdump" pid=955 comm="apparmor_parser" Jan 30 20:39:28 VM kernel: audit: type=1400 audit(1548860968.907:8): apparmor="STATUS" operation="profile_load" profile="unconfined" name="/usr/sbin/tcpdump" pid=955 comm="apparmor_parser" Jan 30 20:39:29 VM audit[951]: AVC apparmor="STATUS" operation="profile_load" profile="unconfined" name="/usr/lib/cups/backend/cups-pdf" pid=951 comm="apparmor_parser" Jan 30 20:39:29 VM audit[951]: AVC apparmor="STATUS" operation="profile_load" profile="unconfined" name="/usr/sbin/cupsd" pid=951 comm="apparmor_parser" Jan 30 20:39:29 VM audit[951]: AVC apparmor="STATUS" operation="profile_load" profile="unconfined" name="/usr/sbin/cupsd//third_party" pid=951 comm="apparmor_parser" Jan 30 20:39:29 VM kernel: audit: type=1400 audit(1548860969.116:9): apparmor="STATUS" operation="profile_load" profile="unconfined" name="/usr/lib/cups/backend/cups-pdf" pid=951 comm="apparmor_parser" Jan 30 20:39:29 VM kernel: audit: type=1400 audit(1548860969.116:10): apparmor="STATUS" operation="profile_load" profile="unconfined" name="/usr/sbin/cupsd" pid=951 comm="apparmor_parser" Jan 30 20:39:29 VM kernel: audit: type=1400 audit(1548860969.116:11): apparmor="STATUS" operation="profile_load" profile="unconfined" name="/usr/sbin/cupsd//third_party" pid=951 comm="apparmor_parser" Jan 30 20:39:29 VM audit[946]: AVC apparmor="STATUS" operation="profile_load" profile="unconfined" name="/sbin/dhclient" pid=946 comm="apparmor_parser" Jan 30 20:39:29 VM audit[946]: AVC apparmor="STATUS" operation="profile_load" profile="unconfined" name="/usr/lib/NetworkManager/nm-dhcp-client.action" pid=946 comm="apparmor_parser" Jan 30 20:39:29 VM audit[946]: AVC apparmor="STATUS" operation="profile_load" profile="unconfined" name="/usr/lib/NetworkManager/nm-dhcp-helper" pid=946 comm="apparmor_parser" Jan 30 20:39:29 VM audit[946]: AVC apparmor="STATUS" operation="profile_load" profile="unconfined" name="/usr/lib/connman/scripts/dhclient-script" pid=946 comm="apparmor_parser" Jan 30 20:39:29 VM audit[952]: AVC apparmor="STATUS" operation="profile_load" profile="unconfined" name="/usr/sbin/dhcpd" pid=952 comm="apparmor_parser" Jan 30 20:39:30 VM audit[947]: AVC apparmor="STATUS" operation="profile_load" profile="unconfined" name="/usr/bin/evince" pid=947 comm="apparmor_parser" Jan 30 20:39:30 VM audit[947]: AVC apparmor="STATUS" operation="profile_load" profile="unconfined" name="/usr/bin/evince//sanitized_helper" pid=947 comm="apparmor_parser" Jan 30 20:39:30 VM audit[947]: AVC apparmor="STATUS" operation="profile_load" profile="unconfined" name="/usr/bin/evince-previewer" pid=947 comm="apparmor_parser" Jan 30 20:39:30 VM audit[947]: AVC apparmor="STATUS" operation="profile_load" profile="unconfined" name="/usr/bin/evince-previewer//sanitized_helper" pid=947 comm="apparmor_parser" Jan 30 20:39:30 VM audit[947]: AVC apparmor="STATUS" operation="profile_load" profile="unconfined" name="/usr/bin/evince-thumbnailer" pid=947 comm="apparmor_parser" Jan 30 20:39:30 VM audit[947]: AVC apparmor="STATUS" operation="profile_load" profile="unconfined" name="/usr/bin/evince-thumbnailer//sanitized_helper" pid=947 comm="apparmor_parser" Jan 30 20:39:31 VM audit[948]: AVC apparmor="STATUS" operation="profile_load" profile="unconfined" name="webbrowser-app" pid=948 comm="apparmor_parser" Jan 30 20:39:31 VM audit[948]: AVC apparmor="STATUS" operation="profile_load" profile="unconfined" name="webbrowser-app//oxide_helper" pid=948 comm="apparmor_parser" Jan 30 20:39:34 VM apparmor[599]: ...done. Jan 30 20:39:34 VM systemd[1]: Started LSB: AppArmor initialization. Jan 30 20:39:34 VM systemd[1]: Starting Raise network interfaces... Jan 30 20:39:34 VM systemd[1]: Reached target System Initialization. Jan 30 20:39:35 VM systemd[1]: Started Timer to automatically refresh installed snaps. Jan 30 20:39:35 VM systemd[1]: Starting Socket activation for snappy daemon. Jan 30 20:39:35 VM systemd[1]: Listening on ACPID Listen Socket. Jan 30 20:39:35 VM systemd[1]: Started ACPI Events Check. Jan 30 20:39:35 VM systemd[1]: Started CUPS Scheduler. Jan 30 20:39:35 VM systemd[1]: Reached target Paths. Jan 30 20:39:35 VM systemd[1]: Listening on CUPS Scheduler. Jan 30 20:39:35 VM systemd[1]: Listening on Avahi mDNS/DNS-SD Stack Activation Socket. Jan 30 20:39:35 VM systemd[1]: Listening on D-Bus System Message Bus Socket. Jan 30 20:39:35 VM systemd[1]: Listening on UUID daemon activation socket. Jan 30 20:39:35 VM systemd[1]: Started Daily Cleanup of Temporary Directories. Jan 30 20:39:35 VM systemd[1]: Listening on Socket activation for snappy daemon. Jan 30 20:39:35 VM systemd[1]: Reached target Sockets. Jan 30 20:39:35 VM systemd[1]: Reached target Basic System. Jan 30 20:39:35 VM systemd[1]: Starting LSB: automatic crash report generation... Jan 30 20:39:35 VM systemd[1]: Starting Detect the available GPUs and deal with any system changes... Jan 30 20:39:35 VM systemd[1]: Starting System Logging Service... Jan 30 20:39:35 VM systemd[1]: Starting Modem Manager... Jan 30 20:39:35 VM systemd[1]: Starting Avahi mDNS/DNS-SD Stack... Jan 30 20:39:37 VM gpu-manager[977]: /etc/modprobe.d is not a file Jan 30 20:39:37 VM systemd[1]: Started ACPI event daemon. Jan 30 20:39:37 VM systemd[1]: Started CUPS Scheduler. Jan 30 20:39:37 VM gpu-manager[977]: /etc/modprobe.d is not a file Jan 30 20:39:37 VM gpu-manager[977]: /etc/modprobe.d is not a file Jan 30 20:39:37 VM gpu-manager[977]: /etc/modprobe.d is not a file Jan 30 20:39:37 VM gpu-manager[977]: /etc/modprobe.d is not a file Jan 30 20:39:37 VM gpu-manager[977]: Error: can't open /lib/modules/4.13.16/updates/dkms Jan 30 20:39:37 VM gpu-manager[977]: Error: can't open /lib/modules/4.13.16/updates/dkms Jan 30 20:39:37 VM systemd[1]: Started Regular background program processing daemon. Jan 30 20:39:37 VM systemd[1]: Starting LSB: Record successful boot for GRUB... Jan 30 20:39:37 VM systemd[1]: Starting Restore /etc/resolv.conf if the system crashed before the ppp link was shut down... Jan 30 20:39:37 VM systemd[1]: Starting Login Service... Jan 30 20:39:37 VM systemd[1]: Starting Permit User Sessions... Jan 30 20:39:37 VM systemd[1]: Starting LSB: daemon to balance interrupts for SMP systems... Jan 30 20:39:37 VM systemd[1]: Started Deferred execution scheduler. Jan 30 20:39:37 VM systemd[1]: Starting Save/Restore Sound Card State... Jan 30 20:39:37 VM systemd[1]: Starting LSB: Speech Dispatcher... Jan 30 20:39:37 VM systemd[1]: Started Run anacron jobs. Jan 30 20:39:37 VM systemd[1]: Starting Accounts Service... Jan 30 20:39:37 VM systemd[1]: Starting LSB: Set the CPU Frequency Scaling governor to "ondemand"... Jan 30 20:39:37 VM systemd[1]: Started D-Bus System Message Bus. Jan 30 20:39:39 VM acpid[983]: starting up with netlink and the input layer Jan 30 20:39:43 VM cron[994]: (CRON) INFO (pidfile fd = 3) Jan 30 20:39:45 VM anacron[1005]: Anacron 2.3 started on 2019-01-30 Jan 30 20:39:51 VM cron[994]: (CRON) INFO (Running @reboot jobs) Jan 30 20:39:53 VM anacron[1005]: Will run job `cron.daily' in 5 min. Jan 30 20:39:53 VM anacron[1005]: Will run job `cron.weekly' in 10 min. Jan 30 20:39:53 VM anacron[1005]: Will run job `cron.monthly' in 15 min. Jan 30 20:39:53 VM anacron[1005]: Jobs will be executed sequentially Jan 30 20:39:53 VM avahi-daemon[980]: Found user 'avahi' (UID 111) and group 'avahi' (GID 120). Jan 30 20:39:53 VM avahi-daemon[980]: Successfully dropped root privileges. Jan 30 20:39:53 VM avahi-daemon[980]: avahi-daemon 0.6.32-rc starting up. Jan 30 20:39:55 VM acpid[983]: 9 rules loaded Jan 30 20:39:55 VM acpid[983]: waiting for events: event logging is off Jan 30 20:39:58 VM ModemManager[979]: <info> ModemManager (version 1.4.12) starting in system bus... Jan 30 20:40:02 VM gpu-manager[977]: update-alternatives: error: no alternatives for x86_64-linux-gnu_gfxcore_conf Jan 30 20:40:02 VM systemd[1]: Failed to subscribe to NameOwnerChanged signal for 'org.freedesktop.DisplayManager': Connection timed out Jan 30 20:40:02 VM systemd[1]: Failed to subscribe to NameOwnerChanged signal for 'org.freedesktop.NetworkManager': Connection timed out Jan 30 20:40:02 VM systemd[1]: Failed to subscribe to NameOwnerChanged signal for 'org.freedesktop.login1': Connection timed out Jan 30 20:40:02 VM systemd[1]: Failed to subscribe to NameOwnerChanged signal for 'org.freedesktop.Accounts': Connection timed out Jan 30 20:40:02 VM systemd[1]: Failed to subscribe to NameOwnerChanged signal for 'org.freedesktop.Avahi': Connection timed out Jan 30 20:40:02 VM systemd[1]: Failed to subscribe to NameOwnerChanged signal for 'org.freedesktop.ModemManager1': Connection timed out Jan 30 20:40:02 VM systemd[1]: Failed to subscribe to activation signal: Connection timed out Jan 30 20:40:02 VM systemd[1]: Failed to register name: Connection timed out Jan 30 20:40:02 VM systemd[1]: Failed to set up API bus: Connection timed out Jan 30 20:40:02 VM systemd[1]: Network Manager is not active. Jan 30 20:40:02 VM systemd[1]: Dependency failed for Network Manager Wait Online. Jan 30 20:40:02 VM systemd[1]: NetworkManager-wait-online.service: Job NetworkManager-wait-online.service/start failed with result 'dependency'. Jan 30 20:40:02 VM systemd[1]: Started Snappy daemon. Jan 30 20:40:02 VM systemd[1]: Starting Auto import assertions from block devices... Jan 30 20:40:02 VM systemd[1]: Started Restore /etc/resolv.conf if the system crashed before the ppp link was shut down. Jan 30 20:40:02 VM systemd[1]: Started Permit User Sessions. Jan 30 20:40:02 VM systemd[1]: Started Save/Restore Sound Card State. Jan 30 20:40:03 VM snap[1063]: auto-import is disabled on classic Jan 30 20:40:03 VM systemd[1]: Started Auto import assertions from block devices. Jan 30 20:40:03 VM systemd[1]: Started Detect the available GPUs and deal with any system changes. Jan 30 20:40:03 VM systemd[1]: Looping too fast. Throttling execution a little. Jan 30 20:40:04 VM systemd[1]: Started System Logging Service. Jan 30 20:40:04 VM systemd[1]: Looping too fast. Throttling execution a little. Jan 30 20:40:05 VM systemd[1]: Looping too fast. Throttling execution a little. Jan 30 20:40:07 VM systemd[1]: Looping too fast. Throttling execution a little. Jan 30 20:40:07 VM dbus[1009]: [system] AppArmor D-Bus mediation is enabled Jan 30 20:40:07 VM avahi-daemon[980]: Successfully called chroot(). Jan 30 20:40:07 VM avahi-daemon[980]: Successfully dropped remaining capabilities. Jan 30 20:40:07 VM avahi-daemon[980]: No service file found in /etc/avahi/services. Jan 30 20:40:07 VM avahi-daemon[980]: Network interface enumeration completed. Jan 30 20:40:07 VM avahi-daemon[980]: Server startup complete. Host name is VM.local. Local service cookie is 2371528958. Jan 30 20:40:08 VM dbus[1009]: [system] Activating systemd to hand-off: service name='org.freedesktop.PolicyKit1' unit='polkitd.service' Jan 30 20:40:08 VM systemd[1]: Starting Light Display Manager... Jan 30 20:40:11 VM dbus[1009]: [system] Activating systemd to hand-off: service name='org.freedesktop.login1' unit='dbus-org.freedesktop.login1.service' Jan 30 20:40:16 VM /usr/lib/snapd/snapd[1062]: daemon.go:250: DEBUG: init done in 964.62µs Jan 30 20:40:16 VM /usr/lib/snapd/snapd[1062]: daemon.go:251: started snapd/2.25 (series 16; classic) ubuntu/16.04 (amd64) linux/4.13.16. Jan 30 20:40:16 VM snapd[1062]: 2019/01/30 20:40:16.699898 daemon.go:251: started snapd/2.25 (series 16; classic) ubuntu/16.04 (amd64) linux/4.13.16. Jan 30 20:40:16 VM systemd[1]: Received SIGRTMIN+20 from PID 663 (plymouthd). Jan 30 20:40:16 VM /usr/lib/snapd/snapd[1062]: snapmgr.go:496: DEBUG: Next refresh scheduled for 2019-01-30 20:40:16.971548129 +0530 IST. Jan 30 20:40:16 VM systemd[1]: Started LSB: automatic crash report generation. Jan 30 20:40:17 VM irqbalance[1000]: * Starting SMP IRQ Balancer: irqbalance Jan 30 20:40:17 VM /usr/lib/snapd/snapd[1062]: snapmgr.go:411: Cannot prepare auto-refresh change: Post https://search.apps.ubuntu.com/api/v1/snaps/metadata: dial tcp: lookup search.apps.ubuntu.com on [::1]:53: read udp [::1]:42272->[::1]:53: read: connection refused Jan 30 20:40:17 VM snapd[1062]: 2019/01/30 20:40:17.176060 snapmgr.go:411: Cannot prepare auto-refresh change: Post https://search.apps.ubuntu.com/api/v1/snaps/metadata: dial tcp: lookup search.apps.ubuntu.com on [::1]:53: read udp [::1]:42272->[::1]:53: read: connection refused Jan 30 20:40:17 VM snapd[1062]: 2019/01/30 20:40:17.176241 stateengine.go:98: state ensure error: Post https://search.apps.ubuntu.com/api/v1/snaps/metadata: dial tcp: lookup search.apps.ubuntu.com on [::1]:53: read udp [::1]:42272->[::1]:53: read: connection refused Jan 30 20:40:17 VM /usr/lib/snapd/snapd[1062]: stateengine.go:98: state ensure error: Post https://search.apps.ubuntu.com/api/v1/snaps/metadata: dial tcp: lookup search.apps.ubuntu.com on [::1]:53: read udp [::1]:42272->[::1]:53: read: connection refused Jan 30 20:40:17 VM speech-dispatcher[1003]: * speech-dispatcher disabled; edit /etc/default/speech-dispatcher Jan 30 20:40:17 VM systemd[1]: Started LSB: Speech Dispatcher. Jan 30 20:40:17 VM systemd[1]: Started LSB: Set the CPU Frequency Scaling governor to "ondemand". Jan 30 20:40:17 VM irqbalance[1000]: ...done. Jan 30 20:40:17 VM systemd[1]: Started LSB: daemon to balance interrupts for SMP systems. Jan 30 20:40:17 VM ifup[972]: ifquery: recursion detected for interface lo in post-up phase Jan 30 20:40:17 VM systemd[1]: Started Raise network interfaces. Jan 30 20:40:17 VM systemd[1]: Reached target Network. Jan 30 20:40:17 VM systemd[1]: Reached target Network is Online. Jan 30 20:40:17 VM systemd[1]: Started Daily apt download activities. Jan 30 20:40:17 VM systemd[1]: Started Daily apt upgrade and clean activities. Jan 30 20:40:17 VM systemd[1]: Reached target Timers. Jan 30 20:40:17 VM systemd[1]: Starting LSB: Router Advertising Daemon... Jan 30 20:40:17 VM systemd[1]: Starting LSB: ipvsadm daemon... Jan 30 20:40:17 VM kernel: FS-Cache: Loaded Jan 30 20:40:17 VM kernel: 9p: Installing v9fs 9p2000 file system support Jan 30 20:40:17 VM kernel: FS-Cache: Netfs '9p' registered for caching Jan 30 20:40:17 VM systemd[1]: Started ISC DHCP IPv6 relay. Jan 30 20:40:17 VM sh[1206]: No interface defined in /etc/default/isc-dhcp-relay6! - Aborting... Jan 30 20:40:17 VM systemd[1]: Started crash report submission daemon. Jan 30 20:40:17 VM systemd[1]: Starting OpenBSD Secure Shell server... Jan 30 20:40:17 VM systemd[1]: Starting /etc/rc.local Compatibility... Jan 30 20:40:17 VM systemd[1]: Started Unattended Upgrades Shutdown. Jan 30 20:40:17 VM systemd[1]: Starting Daily apt download activities... Jan 30 20:40:17 VM radvd[1190]: Starting radvd: Jan 30 20:40:17 VM radvd[1190]: * /etc/radvd.conf does not exist or is empty. Jan 30 20:40:17 VM radvd[1190]: * See /usr/share/doc/radvd/README.Debian Jan 30 20:40:17 VM radvd[1190]: * radvd will *not* be started. Jan 30 20:40:17 VM systemd[1]: Started LSB: Router Advertising Daemon. Jan 30 20:40:18 VM systemd[1]: Started /etc/rc.local Compatibility. Jan 30 20:40:18 VM systemd[1]: Starting Hold until boot process finishes up... Jan 30 20:40:18 VM ipvsadm[1191]: * ipvsadm is not configured to run. Please edit /etc/default/ipvsadm Jan 30 20:40:18 VM systemd[1]: Started LSB: ipvsadm daemon. Jan 30 20:40:18 VM systemd[1]: Started LSB: Record successful boot for GRUB. Jan 30 20:40:19 VM sshd[1244]: Server listening on 0.0.0.0 port 22. Jan 30 20:40:19 VM sshd[1244]: Server listening on :: port 22. Jan 30 20:40:19 VM systemd[1]: Started OpenBSD Secure Shell server. Jan 30 20:40:23 VM dhclient[1265]: Internet Systems Consortium DHCP Client 4.3.3 Jan 30 20:40:23 VM dhclient[1265]: Copyright 2004-2015 Internet Systems Consortium. Jan 30 20:40:23 VM dhclient[1265]: All rights reserved. Jan 30 20:40:23 VM dhclient[1265]: For info, please visit https://www.isc.org/software/dhcp/ Jan 30 20:40:23 VM dhclient[1265]: Jan 30 20:40:23 VM whoopsie[1209]: [20:40:23] Using lock path: /var/lock/whoopsie/lock Jan 30 20:40:23 VM whoopsie[1209]: [20:40:23] Could not get the Network Manager state: Jan 30 20:40:23 VM whoopsie[1209]: [20:40:23] GDBus.Error:org.freedesktop.DBus.Error.ServiceUnknown: The name org.freedesktop.NetworkManager was not provided by any .service files Jan 30 20:40:24 VM root[1277]: /etc/dhcp/dhclient-enter-hooks.d/avahi-autoipd returned non-zero exit status 1 Jan 30 20:40:25 VM dhclient[1265]: Listening on LPF/ens5/52:54:00:cc:00:02 Jan 30 20:40:25 VM dhclient[1265]: Sending on LPF/ens5/52:54:00:cc:00:02 Jan 30 20:40:25 VM dhclient[1265]: Sending on Socket/fallback Jan 30 20:40:25 VM dhclient[1265]: DHCPDISCOVER on ens5 to 255.255.255.255 port 67 interval 3 (xid=0x7a9be132) Jan 30 20:40:25 VM dhclient[1265]: DHCPREQUEST of 192.168.123.12 on ens5 to 255.255.255.255 port 67 (xid=0x32e19b7a) Jan 30 20:40:25 VM dhclient[1265]: DHCPOFFER of 192.168.123.12 from 192.168.123.1 Jan 30 20:40:25 VM dhclient[1265]: DHCPACK of 192.168.123.12 from 192.168.123.1 Jan 30 20:40:25 VM root[1305]: /etc/dhcp/dhclient-enter-hooks.d/avahi-autoipd returned non-zero exit status 1 Jan 30 20:40:25 VM avahi-daemon[980]: Joining mDNS multicast group on interface ens5.IPv4 with address 192.168.123.12. Jan 30 20:40:25 VM avahi-daemon[980]: New relevant interface ens5.IPv4 for mDNS. Jan 30 20:40:25 VM avahi-daemon[980]: Registering new address record for 192.168.123.12 on ens5.IPv4. Jan 30 20:40:25 VM avahi-daemon[980]: Host name conflict, retrying with VM-2 Jan 30 20:40:25 VM avahi-daemon[980]: Registering new address record for 192.168.123.12 on ens5.IPv4. Jan 30 20:40:25 VM avahi-daemon[980]: Joining mDNS multicast group on interface ens5.IPv6 with address fe80::5054:ff:fecc:2. Jan 30 20:40:25 VM avahi-daemon[980]: New relevant interface ens5.IPv6 for mDNS. Jan 30 20:40:25 VM avahi-daemon[980]: Registering new address record for fe80::5054:ff:fecc:2 on ens5.*. Jan 30 20:40:25 VM dhclient[1265]: bound to 192.168.123.12 -- renewal in 1355 seconds. Jan 30 20:40:26 VM avahi-daemon[980]: Withdrawing address record for 192.168.123.12 on ens5. Jan 30 20:40:26 VM avahi-daemon[980]: Host name conflict, retrying with VM-3 Jan 30 20:40:26 VM avahi-daemon[980]: Registering new address record for fe80::5054:ff:fecc:2 on ens5.*. Jan 30 20:40:26 VM avahi-daemon[980]: Registering new address record for 192.168.123.12 on ens5.IPv4. Jan 30 20:40:26 VM systemd[1]: Reloading OpenBSD Secure Shell server. Jan 30 20:40:26 VM sshd[1244]: Received SIGHUP; restarting. Jan 30 20:40:26 VM systemd[1]: Reloaded OpenBSD Secure Shell server. Jan 30 20:40:26 VM sshd[1244]: Server listening on 0.0.0.0 port 22. Jan 30 20:40:26 VM sshd[1244]: Server listening on :: port 22. Jan 30 20:40:26 VM dhclient[1444]: Internet Systems Consortium DHCP Client 4.3.3 Jan 30 20:40:26 VM dhclient[1444]: Copyright 2004-2015 Internet Systems Consortium. Jan 30 20:40:26 VM dhclient[1444]: All rights reserved. Jan 30 20:40:26 VM dhclient[1444]: For info, please visit https://www.isc.org/software/dhcp/ Jan 30 20:40:26 VM dhclient[1444]: Jan 30 20:40:26 VM root[1450]: /etc/dhcp/dhclient-enter-hooks.d/avahi-autoipd returned non-zero exit status 1 Jan 30 20:40:26 VM dhclient[1444]: Listening on LPF/ens6/52:54:00:11:06:03 Jan 30 20:40:26 VM dhclient[1444]: Sending on LPF/ens6/52:54:00:11:06:03 Jan 30 20:40:26 VM dhclient[1444]: Sending on Socket/fallback Jan 30 20:40:26 VM dhclient[1444]: DHCPDISCOVER on ens6 to 255.255.255.255 port 67 interval 3 (xid=0xd143103) Jan 30 20:40:26 VM dhclient[1444]: DHCPREQUEST of 192.168.240.210 on ens6 to 255.255.255.255 port 67 (xid=0x331140d) Jan 30 20:40:26 VM dhclient[1444]: DHCPOFFER of 192.168.240.210 from 192.168.240.1 Jan 30 20:40:26 VM dhclient[1444]: DHCPACK of 192.168.240.210 from 192.168.240.1 Jan 30 20:40:26 VM root[1469]: /etc/dhcp/dhclient-enter-hooks.d/avahi-autoipd returned non-zero exit status 1 Jan 30 20:40:26 VM avahi-daemon[980]: Joining mDNS multicast group on interface ens6.IPv4 with address 192.168.240.210. Jan 30 20:40:26 VM avahi-daemon[980]: New relevant interface ens6.IPv4 for mDNS. Jan 30 20:40:26 VM avahi-daemon[980]: Registering new address record for 192.168.240.210 on ens6.IPv4. Jan 30 20:40:27 VM avahi-daemon[980]: Withdrawing address record for 192.168.240.210 on ens6. Jan 30 20:40:27 VM avahi-daemon[980]: Withdrawing address record for 192.168.123.12 on ens5. Jan 30 20:40:27 VM avahi-daemon[980]: Host name conflict, retrying with VM-4 Jan 30 20:40:27 VM avahi-daemon[980]: Registering new address record for 192.168.240.210 on ens6.IPv4. Jan 30 20:40:27 VM avahi-daemon[980]: Registering new address record for fe80::5054:ff:fecc:2 on ens5.*. Jan 30 20:40:27 VM avahi-daemon[980]: Registering new address record for 192.168.123.12 on ens5.IPv4. Jan 30 20:40:28 VM avahi-daemon[980]: Withdrawing address record for 192.168.240.210 on ens6. Jan 30 20:40:28 VM avahi-daemon[980]: Withdrawing address record for fe80::5054:ff:fecc:2 on ens5. Jan 30 20:40:28 VM avahi-daemon[980]: Host name conflict, retrying with VM-5 Jan 30 20:40:28 VM avahi-daemon[980]: Registering new address record for 192.168.240.210 on ens6.IPv4. Jan 30 20:40:28 VM avahi-daemon[980]: Registering new address record for fe80::5054:ff:fecc:2 on ens5.*. Jan 30 20:40:28 VM avahi-daemon[980]: Registering new address record for 192.168.123.12 on ens5.IPv4. Jan 30 20:40:28 VM whoopsie[1209]: [20:40:28] Cannot reach: https://daisy.ubuntu.com Jan 30 20:40:28 VM whoopsie[1209]: [20:40:28] offline Jan 30 20:40:28 VM avahi-daemon[980]: Joining mDNS multicast group on interface ens6.IPv6 with address fe80::5054:ff:fe11:603. Jan 30 20:40:28 VM avahi-daemon[980]: New relevant interface ens6.IPv6 for mDNS. Jan 30 20:40:28 VM avahi-daemon[980]: Registering new address record for fe80::5054:ff:fe11:603 on ens6.*. Jan 30 20:40:29 VM avahi-daemon[980]: Withdrawing address record for 192.168.240.210 on ens6. Jan 30 20:40:29 VM avahi-daemon[980]: Withdrawing address record for fe80::5054:ff:fecc:2 on ens5. Jan 30 20:40:29 VM avahi-daemon[980]: Withdrawing address record for 192.168.123.12 on ens5. Jan 30 20:40:29 VM avahi-daemon[980]: Host name conflict, retrying with VM-6 Jan 30 20:40:29 VM avahi-daemon[980]: Registering new address record for fe80::5054:ff:fe11:603 on ens6.*. Jan 30 20:40:29 VM avahi-daemon[980]: Registering new address record for 192.168.240.210 on ens6.IPv4. Jan 30 20:40:29 VM avahi-daemon[980]: Registering new address record for fe80::5054:ff:fecc:2 on ens5.*. Jan 30 20:40:29 VM avahi-daemon[980]: Registering new address record for 192.168.123.12 on ens5.IPv4. Jan 30 20:40:29 VM avahi-daemon[980]: Withdrawing address record for fe80::5054:ff:fe11:603 on ens6. Jan 30 20:40:29 VM avahi-daemon[980]: Withdrawing address record for 192.168.240.210 on ens6. Jan 30 20:40:29 VM avahi-daemon[980]: Withdrawing address record for 192.168.123.12 on ens5. Jan 30 20:40:29 VM avahi-daemon[980]: Host name conflict, retrying with VM-7 Jan 30 20:40:29 VM avahi-daemon[980]: Registering new address record for fe80::5054:ff:fe11:603 on ens6.*. Jan 30 20:40:29 VM avahi-daemon[980]: Registering new address record for 192.168.240.210 on ens6.IPv4. Jan 30 20:40:29 VM avahi-daemon[980]: Registering new address record for fe80::5054:ff:fecc:2 on ens5.*. Jan 30 20:40:29 VM avahi-daemon[980]: Registering new address record for 192.168.123.12 on ens5.IPv4. Jan 30 20:40:30 VM avahi-daemon[980]: Leaving mDNS multicast group on interface ens6.IPv6 with address fe80::5054:ff:fe11:603. Jan 30 20:40:30 VM avahi-daemon[980]: Joining mDNS multicast group on interface ens6.IPv6 with address fd17:5821:95c0:0:5054:ff:fe11:603. Jan 30 20:40:30 VM avahi-daemon[980]: Registering new address record for fd17:5821:95c0:0:5054:ff:fe11:603 on ens6.*. Jan 30 20:40:30 VM avahi-daemon[980]: Withdrawing address record for fe80::5054:ff:fe11:603 on ens6. Jan 30 20:40:30 VM systemd-timesyncd[776]: Synchronized to time server 212.26.18.43:123 (asia.pool.ntp.org). Jan 30 20:40:31 VM avahi-daemon[980]: Withdrawing address record for 192.168.240.210 on ens6. Jan 30 20:40:31 VM avahi-daemon[980]: Withdrawing address record for fe80::5054:ff:fecc:2 on ens5. Jan 30 20:40:31 VM avahi-daemon[980]: Withdrawing address record for 192.168.123.12 on ens5. Jan 30 20:40:31 VM avahi-daemon[980]: Host name conflict, retrying with VM-8 Jan 30 20:40:31 VM avahi-daemon[980]: Registering new address record for fd17:5821:95c0:0:5054:ff:fe11:603 on ens6.*. Jan 30 20:40:31 VM avahi-daemon[980]: Registering new address record for 192.168.240.210 on ens6.IPv4. Jan 30 20:40:31 VM avahi-daemon[980]: Registering new address record for fe80::5054:ff:fecc:2 on ens5.*. Jan 30 20:40:31 VM avahi-daemon[980]: Registering new address record for 192.168.123.12 on ens5.IPv4. Jan 30 20:40:31 VM dhclient[1444]: bound to 192.168.240.210 -- renewal in 16723 seconds. Jan 30 20:40:31 VM systemd[1]: Reloading OpenBSD Secure Shell server. Jan 30 20:40:31 VM sshd[1244]: Received SIGHUP; restarting. Jan 30 20:40:31 VM systemd[1]: Reloaded OpenBSD Secure Shell server. Jan 30 20:40:31 VM sshd[1244]: Server listening on 0.0.0.0 port 22. Jan 30 20:40:31 VM sshd[1244]: Server listening on :: port 22. Jan 30 20:40:32 VM avahi-daemon[980]: Withdrawing address record for fd17:5821:95c0:0:5054:ff:fe11:603 on ens6. Jan 30 20:40:32 VM avahi-daemon[980]: Withdrawing address record for 192.168.240.210 on ens6. Jan 30 20:40:32 VM avahi-daemon[980]: Withdrawing address record for 192.168.123.12 on ens5. Jan 30 20:40:32 VM avahi-daemon[980]: Host name conflict, retrying with VM-9 Jan 30 20:40:32 VM avahi-daemon[980]: Registering new address record for fd17:5821:95c0:0:5054:ff:fe11:603 on ens6.*. Jan 30 20:40:32 VM avahi-daemon[980]: Registering new address record for 192.168.240.210 on ens6.IPv4. Jan 30 20:40:32 VM avahi-daemon[980]: Registering new address record for fe80::5054:ff:fecc:2 on ens5.*. Jan 30 20:40:32 VM avahi-daemon[980]: Registering new address record for 192.168.123.12 on ens5.IPv4. Jan 30 20:40:32 VM dhclient[1619]: Created duid \000\001\000\001#\344z\350RT\000\021\006\003. Jan 30 20:40:32 VM dhclient[1619]: XMT: Solicit on ens6, interval 1030ms. Jan 30 20:40:32 VM dhclient[1619]: RCV: Advertise message on ens6 from fe80::5054:ff:fe11:c02. Jan 30 20:40:32 VM dhclient[1619]: IA_NA status code NoAddrsAvail: "No addresses available for this interface." Jan 30 20:40:32 VM dhclient[1619]: RCV: Advertise message on ens6 from fe80::c66e:1fff:fef4:c6e4. Jan 30 20:40:32 VM dbus[1009]: [system] Failed to activate service 'org.freedesktop.systemd1': timed out Jan 30 20:40:32 VM systemd-logind[998]: Failed to enable subscription: Failed to activate service 'org.freedesktop.systemd1': timed out Jan 30 20:40:32 VM systemd-logind[998]: Failed to fully start up daemon: Connection timed out Jan 30 20:40:32 VM systemd[1]: systemd-logind.service: Main process exited, code=exited, status=1/FAILURE Jan 30 20:40:32 VM systemd[1]: Failed to start Login Service. Jan 30 20:40:32 VM systemd[1]: systemd-logind.service: Unit entered failed state. Jan 30 20:40:32 VM systemd[1]: systemd-logind.service: Failed with result 'exit-code'. Jan 30 20:40:32 VM systemd[1]: systemd-logind.service: Service has no hold-off time, scheduling restart. Jan 30 20:40:32 VM systemd[1]: Stopped Login Service. Jan 30 20:40:32 VM systemd[1]: Starting Login Service... Jan 30 20:40:33 VM dbus[1009]: [system] Failed to activate service 'org.freedesktop.PolicyKit1': timed out Jan 30 20:40:33 VM accounts-daemon[1006]: ** (accounts-daemon:1006): CRITICAL **: error getting polkit authority: Error initializing authority: Error calling StartServiceByName for org.freedesktop.PolicyKit1: GDBus.Error:org.freedesktop.DBus.Error.TimedOut: Failed to activate service 'org.freedesktop.PolicyKit1': timed out Jan 30 20:40:33 VM accounts-daemon[1006]: Failed to initialize daemon Jan 30 20:40:33 VM ModemManager[979]: <warn> failed to create PolicyKit authority: 'Error initializing authority: Error calling StartServiceByName for org.freedesktop.PolicyKit1: GDBus.Error:org.freedesktop.DBus.Error.TimedOut: Failed to activate service 'org.freedesktop.PolicyKit1': timed out' Jan 30 20:40:33 VM systemd[1]: Started Accounts Service. Jan 30 20:40:33 VM dhclient[1619]: XMT: Request on ens6, interval 940ms. Jan 30 20:40:33 VM dhclient[1619]: RCV: Reply message on ens6 from fe80::c66e:1fff:fef4:c6e4. Jan 30 20:40:34 VM systemd[1]: Reloading OpenBSD Secure Shell server. Jan 30 20:40:34 VM sshd[1244]: Received SIGHUP; restarting. Jan 30 20:40:34 VM systemd[1]: Reloaded OpenBSD Secure Shell server. Jan 30 20:40:34 VM sshd[1244]: Server listening on 0.0.0.0 port 22. Jan 30 20:40:34 VM sshd[1244]: Server listening on :: port 22. Jan 30 20:40:34 VM systemd[1]: Stopping Nameserver information manager... Jan 30 20:40:34 VM systemd[1]: Stopped Nameserver information manager. Jan 30 20:40:34 VM systemd[1]: Starting Nameserver information manager... Jan 30 20:40:34 VM systemd[1]: Started Nameserver information manager. Jan 30 20:40:34 VM avahi-daemon[980]: Server startup complete. Host name is VM-9.local. Local service cookie is 2371528958. Jan 30 20:40:34 VM kernel: EXT4-fs (vda): mounted filesystem with ordered data mode. Opts: (null) Jan 30 20:40:35 VM avahi-daemon[980]: Registering new address record for fd17:5821:95c0::1ce on ens6.*. Jan 30 20:40:36 VM ModemManager[979]: <info> Couldn't find support for device at '/sys/devices/pci0000:00/0000:00:05.0': not supported by any plugin Jan 30 20:40:36 VM ModemManager[979]: <info> Couldn't find support for device at '/sys/devices/pci0000:00/0000:00:06.0': not supported by any plugin Jan 30 20:40:36 VM dbus[1009]: [system] Activating systemd to hand-off: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service' Jan 30 20:40:36 VM dbus[1009]: [system] Failed to activate service 'org.freedesktop.login1': timed out Jan 30 20:40:36 VM lightdm[1109]: ** (lightdm:1109): WARNING **: Failed to get list of logind seats: GDBus.Error:org.freedesktop.DBus.Error.TimedOut: Failed to activate service 'org.freedesktop.login1': timed out Jan 30 20:40:37 VM systemd[1]: Received SIGRTMIN+21 from PID 663 (plymouthd). Jan 30 20:40:37 VM systemd[1]: Started Hold until boot process finishes up. Jan 30 20:40:37 VM systemd[1]: Started Getty on tty1. Jan 30 20:40:37 VM systemd[1]: Starting Set console scheme... Jan 30 20:40:37 VM systemd[1]: Started Serial Getty on ttyS0. Jan 30 20:40:37 VM systemd[1]: Reached target Login Prompts. Jan 30 20:40:37 VM dbus[1009]: [system] Connection has not authenticated soon enough, closing it (auth_timeout=30000ms, elapsed: 30000ms) Jan 30 20:40:37 VM dbus[1009]: [system] Activating systemd to hand-off: service name='org.freedesktop.Accounts' unit='accounts-daemon.service' Jan 30 20:40:37 VM systemd[1]: Started Set console scheme. Jan 30 20:40:57 VM dbus[1009]: [system] Failed to activate service 'org.freedesktop.systemd1': timed out Jan 30 20:40:57 VM systemd-logind[1640]: Failed to enable subscription: Failed to activate service 'org.freedesktop.systemd1': timed out Jan 30 20:40:57 VM systemd-logind[1640]: Failed to fully start up daemon: Connection timed out Jan 30 20:40:57 VM systemd[1]: systemd-logind.service: Main process exited, code=exited, status=1/FAILURE Jan 30 20:40:57 VM systemd[1]: Failed to start Login Service. Jan 30 20:40:57 VM systemd[1]: systemd-logind.service: Unit entered failed state. Jan 30 20:40:57 VM systemd[1]: systemd-logind.service: Failed with result 'exit-code'. Jan 30 20:40:57 VM systemd[1]: systemd-logind.service: Service has no hold-off time, scheduling restart. Jan 30 20:40:57 VM systemd[1]: Stopped Login Service. Jan 30 20:40:57 VM systemd[1]: Starting Login Service... Jan 30 20:41:01 VM dbus[1009]: [system] Failed to activate service 'org.freedesktop.timedate1': timed out Jan 30 20:41:02 VM dbus[1009]: [system] Failed to activate service 'org.freedesktop.Accounts': timed out Jan 30 20:41:02 VM lightdm[1109]: ** (lightdm:1109): WARNING **: Error getting user list from org.freedesktop.Accounts: GDBus.Error:org.freedesktop.DBus.Error.TimedOut: Failed to activate service 'org.freedesktop.Accounts': timed out Jan 30 20:41:22 VM dbus[1009]: [system] Failed to activate service 'org.freedesktop.systemd1': timed out Jan 30 20:41:22 VM systemd-logind[1845]: Failed to enable subscription: Failed to activate service 'org.freedesktop.systemd1': timed out Jan 30 20:41:22 VM systemd-logind[1845]: Failed to fully start up daemon: Connection timed out Jan 30 20:41:22 VM systemd[1]: systemd-logind.service: Main process exited, code=exited, status=1/FAILURE Jan 30 20:41:22 VM systemd[1]: Failed to start Login Service. Jan 30 20:41:22 VM systemd[1]: systemd-logind.service: Unit entered failed state. Jan 30 20:41:22 VM systemd[1]: systemd-logind.service: Failed with result 'exit-code'. Jan 30 20:41:22 VM systemd[1]: systemd-logind.service: Service has no hold-off time, scheduling restart. Jan 30 20:41:22 VM systemd[1]: Stopped Login Service. Jan 30 20:41:22 VM systemd[1]: Starting Login Service... Jan 30 20:41:29 VM lightdm[1884]: PAM unable to dlopen(pam_kwallet.so): /lib/security/pam_kwallet.so: cannot open shared object file: No such file or directory Jan 30 20:41:29 VM lightdm[1884]: PAM adding faulty module: pam_kwallet.so Jan 30 20:41:29 VM lightdm[1884]: PAM unable to dlopen(pam_kwallet5.so): /lib/security/pam_kwallet5.so: cannot open shared object file: No such file or directory Jan 30 20:41:29 VM lightdm[1884]: PAM adding faulty module: pam_kwallet5.so Jan 30 20:41:29 VM dbus[1009]: [system] Activating systemd to hand-off: service name='org.freedesktop.Accounts' unit='accounts-daemon.service' Jan 30 20:41:45 VM login[1839]: pam_unix(login:session): session opened for user root by LOGIN(uid=0) Jan 30 20:41:45 VM dbus[1009]: [system] Activating systemd to hand-off: service name='org.freedesktop.login1' unit='dbus-org.freedesktop.login1.service' Jan 30 20:41:47 VM dbus[1009]: [system] Failed to activate service 'org.freedesktop.systemd1': timed out Jan 30 20:41:47 VM systemd-logind[1878]: Failed to enable subscription: Failed to activate service 'org.freedesktop.systemd1': timed out Jan 30 20:41:47 VM systemd-logind[1878]: Failed to fully start up daemon: Connection timed out Jan 30 20:41:47 VM systemd[1]: systemd-logind.service: Main process exited, code=exited, status=1/FAILURE Jan 30 20:41:47 VM systemd[1]: Failed to start Login Service. Jan 30 20:41:47 VM systemd[1]: systemd-logind.service: Unit entered failed state. Jan 30 20:41:47 VM systemd[1]: systemd-logind.service: Failed with result 'exit-code'. Jan 30 20:41:47 VM systemd[1]: systemd-logind.service: Service has no hold-off time, scheduling restart. Jan 30 20:41:47 VM systemd[1]: Stopped Login Service. Jan 30 20:41:47 VM systemd[1]: Starting Login Service... Jan 30 20:41:54 VM dbus[1009]: [system] Failed to activate service 'org.freedesktop.Accounts': timed out Jan 30 20:41:54 VM lightdm[1109]: ** (process:1884): WARNING **: Error getting user list from org.freedesktop.Accounts: GDBus.Error:org.freedesktop.DBus.Error.TimedOut: Failed to activate service 'org.freedesktop.Accounts': timed out Jan 30 20:41:54 VM lightdm[1884]: pam_unix(lightdm-greeter:session): session opened for user lightdm by (uid=0) Jan 30 20:42:10 VM dbus[1009]: [system] Failed to activate service 'org.freedesktop.login1': timed out Jan 30 20:42:10 VM lightdm[1884]: pam_systemd(lightdm-greeter:session): Failed to create session: Failed to activate service 'org.freedesktop.login1': timed out Jan 30 20:42:10 VM login[1839]: pam_systemd(login:session): Failed to create session: Failed to activate service 'org.freedesktop.login1': timed out Jan 30 20:42:10 VM login[2380]: ROOT LOGIN on '/dev/ttyS0' Jan 30 20:42:12 VM org.a11y.atspi.Registry[2409]: SpiRegistry daemon is running with well-known name - org.a11y.atspi.Registry Jan 30 20:42:12 VM dbus[1009]: [system] Failed to activate service 'org.freedesktop.systemd1': timed out Jan 30 20:42:12 VM systemd-logind[2021]: Failed to enable subscription: Failed to activate service 'org.freedesktop.systemd1': timed out Jan 30 20:42:12 VM systemd-logind[2021]: Failed to fully start up daemon: Connection timed out Jan 30 20:42:12 VM systemd[1]: systemd-logind.service: Main process exited, code=exited, status=1/FAILURE Jan 30 20:42:12 VM systemd[1]: Failed to start Login Service. Jan 30 20:42:12 VM systemd[1]: systemd-logind.service: Unit entered failed state. Jan 30 20:42:12 VM systemd[1]: systemd-logind.service: Failed with result 'exit-code'. Jan 30 20:42:12 VM systemd[1]: systemd-logind.service: Service has no hold-off time, scheduling restart. Jan 30 20:42:12 VM systemd[1]: Stopped Login Service. Jan 30 20:42:12 VM systemd[1]: Starting Login Service... Jan 30 20:42:12 VM dbus[1009]: [system] Activating systemd to hand-off: service name='org.freedesktop.login1' unit='dbus-org.freedesktop.login1.service' Jan 30 20:42:14 VM sudo[2454]: root : TTY=ttyS0 ; PWD=/root ; USER=root ; COMMAND=/usr/bin/vim /etc/passwd Jan 30 20:42:14 VM sudo[2454]: pam_unix(sudo:session): session opened for user root by root(uid=0) Jan 30 20:42:17 VM sudo[2454]: pam_unix(sudo:session): session closed for user root Jan 30 20:42:22 VM kernel: serial8250: too much work for irq4 Jan 30 20:42:22 VM kernel: serial8250: too much work for irq4 Jan 30 20:42:25 VM kernel: serial8250: too much work for irq4 Jan 30 20:42:25 VM kernel: serial8250: too much work for irq4 Jan 30 20:42:27 VM kernel: serial8250: too much work for irq4 Jan 30 20:42:27 VM kernel: serial8250: too much work for irq4 Jan 30 20:42:37 VM kernel: serial8250: too much work for irq4 Jan 30 20:42:37 VM kernel: serial8250: too much work for irq4 Jan 30 20:42:37 VM systemd-logind[2447]: Failed to enable subscription: Connection timed out Jan 30 20:42:37 VM systemd-logind[2447]: Failed to fully start up daemon: Connection timed out Jan 30 20:42:37 VM dbus[1009]: [system] Failed to activate service 'org.freedesktop.systemd1': timed out Jan 30 20:42:37 VM systemd[1]: systemd-logind.service: Main process exited, code=exited, status=1/FAILURE Jan 30 20:42:37 VM systemd[1]: Failed to start Login Service. Jan 30 20:42:37 VM systemd[1]: systemd-logind.service: Unit entered failed state. Jan 30 20:42:37 VM systemd[1]: systemd-logind.service: Failed with result 'exit-code'. Jan 30 20:42:37 VM systemd[1]: systemd-logind.service: Service has no hold-off time, scheduling restart. Jan 30 20:42:37 VM systemd[1]: Stopped Login Service. Jan 30 20:42:37 VM systemd[1]: Starting Login Service... Jan 30 20:42:37 VM dbus[1009]: [system] Failed to activate service 'org.freedesktop.login1': timed out Jan 30 20:42:38 VM dbus[1009]: [system] Activating systemd to hand-off: service name='org.freedesktop.Accounts' unit='accounts-daemon.service' Jan 30 20:42:38 VM kernel: serial8250: too much work for irq4 Jan 30 20:42:38 VM kernel: serial8250: too much work for irq4 Jan 30 20:42:50 VM kernel: serial8250: too much work for irq4 Jan 30 20:42:50 VM kernel: serial8250: too much work for irq4 Jan 30 20:43:02 VM dbus[1009]: [system] Failed to activate service 'org.freedesktop.systemd1': timed out Jan 30 20:43:02 VM systemd-logind[2464]: Failed to enable subscription: Failed to activate service 'org.freedesktop.systemd1': timed out Jan 30 20:43:02 VM systemd-logind[2464]: Failed to fully start up daemon: Connection timed out Jan 30 20:43:02 VM systemd[1]: systemd-logind.service: Main process exited, code=exited, status=1/FAILURE Jan 30 20:43:02 VM systemd[1]: Failed to start Login Service. Jan 30 20:43:02 VM systemd[1]: systemd-logind.service: Unit entered failed state. Jan 30 20:43:02 VM systemd[1]: systemd-logind.service: Failed with result 'exit-code'. Jan 30 20:43:02 VM systemd[1]: systemd-logind.service: Service has no hold-off time, scheduling restart. Jan 30 20:43:02 VM systemd[1]: Stopped Login Service. Jan 30 20:43:02 VM systemd[1]: Starting Login Service... Jan 30 20:43:03 VM dbus[1009]: [system] Failed to activate service 'org.freedesktop.Accounts': timed out Jan 30 20:43:03 VM lightdm[2476]: PAM unable to dlopen(pam_kwallet.so): /lib/security/pam_kwallet.so: cannot open shared object file: No such file or directory Jan 30 20:43:03 VM lightdm[2476]: PAM adding faulty module: pam_kwallet.so Jan 30 20:43:03 VM lightdm[2476]: PAM unable to dlopen(pam_kwallet5.so): /lib/security/pam_kwallet5.so: cannot open shared object file: No such file or directory Jan 30 20:43:03 VM lightdm[2476]: PAM adding faulty module: pam_kwallet5.so Jan 30 20:43:04 VM dbus[1009]: [system] Activating systemd to hand-off: service name='org.freedesktop.login1' unit='dbus-org.freedesktop.login1.service' Jan 30 20:43:04 VM dbus[1009]: [system] Activating systemd to hand-off: service name='org.freedesktop.Accounts' unit='accounts-daemon.service' Jan 30 20:43:04 VM dbus[1009]: [system] Activating systemd to hand-off: service name='org.bluez' unit='dbus-org.bluez.service' Jan 30 20:43:05 VM dbus[1009]: [system] Activating systemd to hand-off: service name='org.freedesktop.RealtimeKit1' unit='rtkit-daemon.service' Jan 30 20:43:06 VM kernel: serial8250: too much work for irq4 Jan 30 20:43:06 VM kernel: serial8250: too much work for irq4 Jan 30 20:43:18 VM systemd[1]: Started Daily apt download activities. Jan 30 20:43:18 VM systemd[1]: Starting Daily apt upgrade and clean activities... Jan 30 20:43:27 VM dbus[1009]: [system] Failed to activate service 'org.freedesktop.systemd1': timed out Jan 30 20:43:27 VM systemd-logind[2474]: Failed to enable subscription: Failed to activate service 'org.freedesktop.systemd1': timed out Jan 30 20:43:27 VM systemd-logind[2474]: Failed to fully start up daemon: Connection timed out Jan 30 20:43:27 VM systemd[1]: systemd-logind.service: Main process exited, code=exited, status=1/FAILURE Jan 30 20:43:27 VM systemd[1]: Failed to start Login Service. Jan 30 20:43:27 VM systemd[1]: systemd-logind.service: Unit entered failed state. Jan 30 20:43:27 VM systemd[1]: systemd-logind.service: Failed with result 'exit-code'. Jan 30 20:43:27 VM systemd[1]: systemd-logind.service: Service has no hold-off time, scheduling restart. Jan 30 20:43:27 VM systemd[1]: Stopped Login Service. Jan 30 20:43:27 VM systemd[1]: Starting Login Service... Jan 30 20:43:29 VM dbus[1009]: [system] Failed to activate service 'org.freedesktop.login1': timed out Jan 30 20:43:29 VM dbus[1009]: [system] Failed to activate service 'org.freedesktop.Accounts': timed out Jan 30 20:43:29 VM dbus[1009]: [system] Activating systemd to hand-off: service name='org.freedesktop.Accounts' unit='accounts-daemon.service' Jan 30 20:43:29 VM dbus[1009]: [system] Activating systemd to hand-off: service name='org.freedesktop.UPower' unit='upower.service' Jan 30 20:43:29 VM dbus[1009]: [system] Failed to activate service 'org.bluez': timed out Jan 30 20:43:30 VM dbus[1009]: [system] Failed to activate service 'org.freedesktop.RealtimeKit1': timed out Jan 30 20:43:30 VM dbus[1009]: [system] Activating systemd to hand-off: service name='org.freedesktop.RealtimeKit1' unit='rtkit-daemon.service' Jan 30 20:43:44 VM kernel: serial8250: too much work for irq4 Jan 30 20:43:44 VM kernel: serial8250: too much work for irq4 Jan 30 20:43:45 VM kernel: serial8250: too much work for irq4 Jan 30 20:43:45 VM kernel: serial8250: too much work for irq4 Jan 30 20:43:52 VM dbus[1009]: [system] Failed to activate service 'org.freedesktop.systemd1': timed out Jan 30 20:43:52 VM systemd-logind[2598]: Failed to enable subscription: Failed to activate service 'org.freedesktop.systemd1': timed out Jan 30 20:43:52 VM systemd-logind[2598]: Failed to fully start up daemon: Connection timed out Jan 30 20:43:52 VM systemd[1]: systemd-logind.service: Main process exited, code=exited, status=1/FAILURE Jan 30 20:43:52 VM systemd[1]: Failed to start Login Service. Jan 30 20:43:52 VM systemd[1]: systemd-logind.service: Unit entered failed state. Jan 30 20:43:52 VM systemd[1]: systemd-logind.service: Failed with result 'exit-code'. Jan 30 20:43:52 VM systemd[1]: systemd-logind.service: Service has no hold-off time, scheduling restart. Jan 30 20:43:52 VM systemd[1]: Stopped Login Service. Jan 30 20:43:52 VM systemd[1]: Starting Login Service... Jan 30 20:43:54 VM dbus[1009]: [system] Failed to activate service 'org.freedesktop.Accounts': timed out Jan 30 20:43:54 VM dbus[1009]: [system] Failed to activate service 'org.freedesktop.UPower': timed out Jan 30 20:43:54 VM dbus[1009]: [system] Activating systemd to hand-off: service name='org.freedesktop.ColorManager' unit='colord.service' Jan 30 20:43:54 VM dbus[1009]: [system] Activating systemd to hand-off: service name='org.freedesktop.Accounts' unit='accounts-daemon.service' Jan 30 20:43:55 VM dbus[1009]: [system] Failed to activate service 'org.freedesktop.RealtimeKit1': timed out Jan 30 20:43:55 VM dbus[1009]: [system] Activating systemd to hand-off: service name='org.freedesktop.RealtimeKit1' unit='rtkit-daemon.service' Jan 30 20:44:17 VM kernel: serial8250: too much work for irq4 Jan 30 20:44:17 VM systemd-logind[2617]: Failed to enable subscription: Connection timed out Jan 30 20:44:17 VM systemd-logind[2617]: Failed to fully start up daemon: Connection timed out Jan 30 20:44:18 VM dbus[1009]: [system] Failed to activate service 'org.freedesktop.systemd1': timed out Jan 30 20:44:18 VM kernel: serial8250: too much work for irq4 Jan 30 20:44:18 VM systemd[1]: systemd-logind.service: Main process exited, code=exited, status=1/FAILURE Jan 30 20:44:18 VM systemd[1]: Failed to start Login Service. Jan 30 20:44:18 VM systemd[1]: systemd-logind.service: Unit entered failed state. Jan 30 20:44:18 VM systemd[1]: systemd-logind.service: Failed with result 'exit-code'. Jan 30 20:44:18 VM systemd[1]: systemd-logind.service: Service has no hold-off time, scheduling restart. Jan 30 20:44:18 VM systemd[1]: Stopped Login Service. Jan 30 20:44:18 VM systemd[1]: Starting Login Service... Jan 30 20:44:19 VM dbus[1009]: [system] Failed to activate service 'org.freedesktop.ColorManager': timed out Jan 30 20:44:19 VM dbus[1009]: [system] Failed to activate service 'org.freedesktop.Accounts': timed out Jan 30 20:44:19 VM dbus[1009]: [system] Activating systemd to hand-off: service name='org.freedesktop.Accounts' unit='accounts-daemon.service' Jan 30 20:44:20 VM dbus[1009]: [system] Failed to activate service 'org.freedesktop.RealtimeKit1': timed out Jan 30 20:44:20 VM dbus[1009]: [system] Activating systemd to hand-off: service name='org.freedesktop.RealtimeKit1' unit='rtkit-daemon.service' Jan 30 20:44:43 VM dbus[1009]: [system] Failed to activate service 'org.freedesktop.systemd1': timed out Jan 30 20:44:43 VM systemd-logind[2650]: Failed to enable subscription: Failed to activate service 'org.freedesktop.systemd1': timed out Jan 30 20:44:43 VM systemd-logind[2650]: Failed to fully start up daemon: Connection timed out Jan 30 20:44:43 VM systemd[1]: systemd-logind.service: Main process exited, code=exited, status=1/FAILURE Jan 30 20:44:43 VM systemd[1]: Failed to start Login Service. Jan 30 20:44:43 VM systemd[1]: systemd-logind.service: Unit entered failed state. Jan 30 20:44:43 VM systemd[1]: systemd-logind.service: Failed with result 'exit-code'. Jan 30 20:44:43 VM systemd[1]: systemd-logind.service: Service has no hold-off time, scheduling restart. Jan 30 20:44:43 VM systemd[1]: Stopped Login Service. Jan 30 20:44:43 VM systemd[1]: Starting Login Service... Jan 30 20:44:44 VM dbus[1009]: [system] Failed to activate service 'org.freedesktop.Accounts': timed out Jan 30 20:44:44 VM dbus[1009]: [system] Activating systemd to hand-off: service name='org.freedesktop.Accounts' unit='accounts-daemon.service' Jan 30 20:44:45 VM dbus[1009]: [system] Failed to activate service 'org.freedesktop.RealtimeKit1': timed out Jan 30 20:44:45 VM dbus[1009]: [system] Activating systemd to hand-off: service name='org.freedesktop.RealtimeKit1' unit='rtkit-daemon.service' Jan 30 20:44:45 VM anacron[1005]: Job `cron.daily' started Jan 30 20:44:45 VM anacron[2714]: Updated timestamp for job `cron.daily' to 2019-01-30 Jan 30 20:44:51 VM cracklib[2740]: no dictionary update necessary. Jan 30 20:45:03 VM kernel: serial8250: too much work for irq4 Jan 30 20:45:03 VM kernel: serial8250: too much work for irq4 Jan 30 20:45:04 VM kernel: serial8250: too much work for irq4 Jan 30 20:45:04 VM kernel: serial8250: too much work for irq4 Jan 30 20:45:06 VM systemd[1]: Stopping CUPS Scheduler... Jan 30 20:45:07 VM systemd[1]: Stopped CUPS Scheduler. Jan 30 20:45:07 VM systemd[1]: Started CUPS Scheduler. Jan 30 20:45:08 VM dbus[1009]: [system] Failed to activate service 'org.freedesktop.systemd1': timed out Jan 30 20:45:08 VM systemd-logind[2698]: Failed to enable subscription: Failed to activate service 'org.freedesktop.systemd1': timed out Jan 30 20:45:08 VM systemd-logind[2698]: Failed to fully start up daemon: Connection timed out Jan 30 20:45:08 VM systemd[1]: systemd-logind.service: Main process exited, code=exited, status=1/FAILURE Jan 30 20:45:08 VM systemd[1]: Failed to start Login Service. Jan 30 20:45:08 VM systemd[1]: systemd-logind.service: Unit entered failed state. Jan 30 20:45:08 VM systemd[1]: systemd-logind.service: Failed with result 'exit-code'. Jan 30 20:45:08 VM systemd[1]: systemd-logind.service: Service has no hold-off time, scheduling restart. Jan 30 20:45:08 VM systemd[1]: Stopped Login Service. Jan 30 20:45:08 VM systemd[1]: Starting Login Service... Jan 30 20:45:09 VM dbus[1009]: [system] Failed to activate service 'org.freedesktop.Accounts': timed out Jan 30 20:45:09 VM dbus[1009]: [system] Activating systemd to hand-off: service name='org.freedesktop.Accounts' unit='accounts-daemon.service' Jan 30 20:45:10 VM dbus[1009]: [system] Failed to activate service 'org.freedesktop.RealtimeKit1': timed out Jan 30 20:45:10 VM dbus[1009]: [system] Activating systemd to hand-off: service name='org.freedesktop.RealtimeKit1' unit='rtkit-daemon.service' Jan 30 20:45:24 VM kernel: serial8250: too much work for irq4 Jan 30 20:45:24 VM kernel: serial8250: too much work for irq4 Jan 30 20:45:33 VM dbus[1009]: [system] Failed to activate service 'org.freedesktop.systemd1': timed out Jan 30 20:45:33 VM systemd-logind[2785]: Failed to enable subscription: Failed to activate service 'org.freedesktop.systemd1': timed out Jan 30 20:45:33 VM systemd-logind[2785]: Failed to fully start up daemon: Connection timed out Jan 30 20:45:33 VM systemd[1]: systemd-logind.service: Main process exited, code=exited, status=1/FAILURE Jan 30 20:45:33 VM systemd[1]: Failed to start Login Service. Jan 30 20:45:33 VM systemd[1]: systemd-logind.service: Unit entered failed state. Jan 30 20:45:33 VM systemd[1]: systemd-logind.service: Failed with result 'exit-code'. Jan 30 20:45:33 VM systemd[1]: systemd-logind.service: Service has no hold-off time, scheduling restart. Jan 30 20:45:33 VM systemd[1]: Stopped Login Service. Jan 30 20:45:33 VM systemd[1]: Starting Login Service... Jan 30 20:45:34 VM dbus[1009]: [system] Failed to activate service 'org.freedesktop.Accounts': timed out Jan 30 20:45:35 VM dbus[1009]: [system] Failed to activate service 'org.freedesktop.RealtimeKit1': timed out Jan 30 20:45:35 VM dbus[1009]: [system] Activating systemd to hand-off: service name='org.freedesktop.RealtimeKit1' unit='rtkit-daemon.service' Jan 30 20:45:35 VM dbus[1009]: [system] Activating systemd to hand-off: service name='org.freedesktop.Accounts' unit='accounts-daemon.service' Jan 30 20:45:35 VM kernel: serial8250: too much work for irq4 Jan 30 20:45:35 VM kernel: serial8250: too much work for irq4 Jan 30 20:45:37 VM kernel: serial8250: too much work for irq4 Jan 30 20:45:37 VM kernel: serial8250: too much work for irq4 Jan 30 20:45:48 VM kernel: serial8250: too much work for irq4 Jan 30 20:45:48 VM kernel: serial8250: too much work for irq4 Jan 30 20:45:50 VM kernel: serial8250: too much work for irq4 Jan 30 20:45:50 VM kernel: serial8250: too much work for irq4 Jan 30 20:45:58 VM dbus[1009]: [system] Failed to activate service 'org.freedesktop.systemd1': timed out Jan 30 20:45:58 VM systemd-logind[2808]: Failed to enable subscription: Failed to activate service 'org.freedesktop.systemd1': timed out Jan 30 20:45:58 VM systemd-logind[2808]: Failed to fully start up daemon: Connection timed out Jan 30 20:45:58 VM systemd[1]: systemd-logind.service: Main process exited, code=exited, status=1/FAILURE Jan 30 20:45:58 VM systemd[1]: Failed to start Login Service. Jan 30 20:45:58 VM systemd[1]: systemd-logind.service: Unit entered failed state. Jan 30 20:45:58 VM systemd[1]: systemd-logind.service: Failed with result 'exit-code'. Jan 30 20:45:58 VM systemd[1]: systemd-logind.service: Service has no hold-off time, scheduling restart. Jan 30 20:45:58 VM systemd[1]: Stopped Login Service. Jan 30 20:45:58 VM systemd[1]: Starting Login Service... Jan 30 20:46:00 VM dbus[1009]: [system] Failed to activate service 'org.freedesktop.RealtimeKit1': timed out Jan 30 20:46:00 VM dbus[1009]: [system] Activating systemd to hand-off: service name='org.freedesktop.RealtimeKit1' unit='rtkit-daemon.service' Jan 30 20:46:00 VM dbus[1009]: [system] Failed to activate service 'org.freedesktop.Accounts': timed out Jan 30 20:46:00 VM dbus[1009]: [system] Activating systemd to hand-off: service name='org.freedesktop.Accounts' unit='accounts-daemon.service' Jan 30 20:46:11 VM systemd[1]: Stopped Daily apt upgrade and clean activities. Jan 30 20:46:11 VM systemd[1]: Stopped Daily apt download activities. Jan 30 20:46:12 VM kernel: serial8250: too much work for irq4 Jan 30 20:46:12 VM kernel: serial8250: too much work for irq4 Jan 30 20:46:14 VM kernel: serial8250: too much work for irq4 Jan 30 20:46:14 VM kernel: serial8250: too much work for irq4 Jan 30 20:46:14 VM systemd[1]: Reloading. Jan 30 20:46:15 VM systemd[1]: Failed to register Manager vtable: File exists Jan 30 20:46:15 VM systemd[1]: Failed to set up API bus: File exists Jan 30 20:46:15 VM systemd[1]: Started CUPS Scheduler. Jan 30 20:46:15 VM systemd[1]: Started ACPI event daemon. Jan 30 20:46:18 VM kernel: serial8250: too much work for irq4 Jan 30 20:46:18 VM kernel: serial8250: too much work for irq4 Jan 30 20:46:23 VM dbus[1009]: [system] Failed to activate service 'org.freedesktop.systemd1': timed out Jan 30 20:46:23 VM systemd-logind[2843]: Failed to enable subscription: Failed to activate service 'org.freedesktop.systemd1': timed out Jan 30 20:46:23 VM systemd-logind[2843]: Failed to fully start up daemon: Connection timed out Jan 30 20:46:23 VM systemd[1]: systemd-logind.service: Main process exited, code=exited, status=1/FAILURE Jan 30 20:46:23 VM systemd[1]: Failed to start Login Service. Jan 30 20:46:23 VM systemd[1]: systemd-logind.service: Unit entered failed state. Jan 30 20:46:23 VM systemd[1]: systemd-logind.service: Failed with result 'exit-code'. Jan 30 20:46:23 VM systemd[1]: systemd-logind.service: Service has no hold-off time, scheduling restart. Jan 30 20:46:23 VM systemd[1]: Stopped Login Service. Jan 30 20:46:23 VM systemd[1]: Starting Login Service... Jan 30 20:46:25 VM dbus[1009]: [system] Failed to activate service 'org.freedesktop.RealtimeKit1': timed out Jan 30 20:46:25 VM dbus[1009]: [system] Activating systemd to hand-off: service name='org.freedesktop.RealtimeKit1' unit='rtkit-daemon.service' Jan 30 20:46:25 VM kernel: serial8250: too much work for irq4 Jan 30 20:46:25 VM dbus[1009]: [system] Failed to activate service 'org.freedesktop.Accounts': timed out Jan 30 20:46:25 VM kernel: serial8250: too much work for irq4 Jan 30 20:46:25 VM dbus[1009]: [system] Activating systemd to hand-off: service name='org.freedesktop.Accounts' unit='accounts-daemon.service' Jan 30 20:46:39 VM systemd[1]: Reloading. Jan 30 20:46:39 VM systemd[1]: Failed to register Manager vtable: File exists Jan 30 20:46:39 VM systemd[1]: Failed to set up API bus: File exists Jan 30 20:46:39 VM systemd[1]: Started CUPS Scheduler. Jan 30 20:46:39 VM systemd[1]: Started ACPI event daemon. Jan 30 20:46:39 VM systemd[1]: Started Daily apt upgrade and clean activities. Jan 30 20:46:39 VM systemd[1]: Started Daily apt download activities. Jan 30 20:46:45 VM sudo[3783]: root : TTY=ttyS0 ; PWD=/root ; USER=root ; COMMAND=/usr/bin/vim /etc/passwd Jan 30 20:46:45 VM sudo[3783]: pam_unix(sudo:session): session opened for user root by root(uid=0) Jan 30 20:46:48 VM dbus[1009]: [system] Failed to activate service 'org.freedesktop.systemd1': timed out Jan 30 20:46:48 VM systemd-logind[3133]: Failed to enable subscription: Failed to activate service 'org.freedesktop.systemd1': timed out Jan 30 20:46:48 VM systemd-logind[3133]: Failed to fully start up daemon: Connection timed out Jan 30 20:46:48 VM systemd[1]: systemd-logind.service: Main process exited, code=exited, status=1/FAILURE Jan 30 20:46:48 VM systemd[1]: Failed to start Login Service. Jan 30 20:46:48 VM systemd[1]: systemd-logind.service: Unit entered failed state. Jan 30 20:46:48 VM systemd[1]: systemd-logind.service: Failed with result 'exit-code'. Jan 30 20:46:48 VM systemd[1]: systemd-logind.service: Service has no hold-off time, scheduling restart. Jan 30 20:46:48 VM systemd[1]: Stopped Login Service. Jan 30 20:46:48 VM systemd[1]: Starting Login Service... Jan 30 20:46:49 VM sudo[3783]: pam_unix(sudo:session): session closed for user root Jan 30 20:46:50 VM dbus[1009]: [system] Failed to activate service 'org.freedesktop.RealtimeKit1': timed out Jan 30 20:46:50 VM dbus[1009]: [system] Activating systemd to hand-off: service name='org.freedesktop.RealtimeKit1' unit='rtkit-daemon.service' Jan 30 20:46:50 VM dbus[1009]: [system] Failed to activate service 'org.freedesktop.Accounts': timed out Jan 30 20:46:50 VM dbus[1009]: [system] Activating systemd to hand-off: service name='org.freedesktop.Accounts' unit='accounts-daemon.service' Jan 30 20:47:00 VM dbus[1009]: [system] Reloaded configuration Jan 30 20:47:00 VM dbus[1009]: [system] Reloaded configuration Jan 30 20:47:01 VM dbus[1009]: [system] Reloaded configuration Jan 30 20:47:01 VM dbus[1009]: [system] Reloaded configuration Jan 30 20:47:01 VM dbus[1009]: [system] Reloaded configuration Jan 30 20:47:01 VM dbus[1009]: [system] Reloaded configuration Jan 30 20:47:04 VM dbus[1009]: [system] Reloaded configuration Jan 30 20:47:04 VM dbus[1009]: [system] Reloaded configuration Jan 30 20:47:05 VM dbus[1009]: [system] Reloaded configuration Jan 30 20:47:08 VM kernel: serial8250: too much work for irq4 Jan 30 20:47:08 VM kernel: serial8250: too much work for irq4 Jan 30 20:47:09 VM dbus[1009]: [system] Reloaded configuration Jan 30 20:47:09 VM dbus[1009]: [system] Reloaded configuration Jan 30 20:47:09 VM dbus[1009]: [system] Reloaded configuration Jan 30 20:47:10 VM dbus[1009]: [system] Reloaded configuration Jan 30 20:47:10 VM dbus[1009]: [system] Reloaded configuration Jan 30 20:47:10 VM dbus[1009]: [system] Reloaded configuration Jan 30 20:47:10 VM dbus[1009]: [system] Reloaded configuration Jan 30 20:47:10 VM dbus[1009]: [system] Reloaded configuration Jan 30 20:47:11 VM systemd[1]: Reloading. Jan 30 20:47:11 VM systemd[1]: Failed to register Manager vtable: File exists Jan 30 20:47:11 VM systemd[1]: Failed to set up API bus: File exists Jan 30 20:47:11 VM systemd[1]: Started CUPS Scheduler. Jan 30 20:47:11 VM systemd[1]: Started ACPI event daemon. Jan 30 20:47:11 VM systemd[1]: Reloading. Jan 30 20:47:11 VM systemd[1]: Failed to register Manager vtable: File exists Jan 30 20:47:11 VM systemd[1]: Failed to set up API bus: File exists Jan 30 20:47:11 VM systemd[1]: Started CUPS Scheduler. Jan 30 20:47:11 VM systemd[1]: Started ACPI event daemon. Jan 30 20:47:11 VM kernel: serial8250: too much work for irq4 Jan 30 20:47:11 VM kernel: serial8250: too much work for irq4 Jan 30 20:47:11 VM systemd[1]: Reloading. Jan 30 20:47:11 VM systemd[1]: Failed to register Manager vtable: File exists Jan 30 20:47:11 VM systemd[1]: Failed to set up API bus: File exists Jan 30 20:47:11 VM systemd[1]: Started CUPS Scheduler. Jan 30 20:47:11 VM systemd[1]: Started ACPI event daemon. Jan 30 20:47:11 VM systemd[1]: Reexecuting. Jan 30 20:47:12 VM kernel: systemd: 21 output lines suppressed due to ratelimiting Jan 30 20:47:12 VM systemd[1]: systemd 229 running in system mode. (+PAM +AUDIT +SELINUX +IMA +APPARMOR +SMACK +SYSVINIT +UTMP +LIBCRYPTSETUP +GCRYPT +GNUTLS +ACL +XZ -LZ4 +SECCOMP +BLKID +ELFUTILS +KMOD -IDN) Jan 30 20:47:12 VM systemd[1]: Detected virtualization qemu. Jan 30 20:47:12 VM systemd[1]: Detected architecture x86-64. Jan 30 20:47:12 VM dbus[1009]: [system] Successfully activated service 'org.freedesktop.systemd1' Jan 30 20:47:12 VM systemd-logind[3919]: New seat seat0. Jan 30 20:47:12 VM systemd-logind[3919]: Watching system buttons on /dev/input/event0 (Power Button) Jan 30 20:47:12 VM systemd[1]: Started Login Service. Jan 30 20:47:12 VM systemd[1]: Starting Accounts Service... Jan 30 20:47:12 VM systemd[1]: Starting RealtimeKit Scheduling Policy Service... Jan 30 20:47:12 VM systemd[1]: Started ACPI event daemon. Jan 30 20:47:12 VM systemd[1]: Started CUPS Scheduler. Jan 30 20:47:12 VM dbus[1009]: [system] Activating via systemd: service name='org.freedesktop.PolicyKit1' unit='polkitd.service' Jan 30 20:47:12 VM systemd[1]: Starting Authenticate and Authorize Users to Run Privileged Tasks... Jan 30 20:47:12 VM systemd[1]: Stopping Network Time Synchronization... Jan 30 20:47:12 VM systemd[1]: Stopped Network Time Synchronization. Jan 30 20:47:12 VM systemd[1]: Starting Network Time Synchronization... Jan 30 20:47:12 VM systemd[1]: Started Network Time Synchronization. Jan 30 20:47:12 VM dbus[1009]: [system] Successfully activated service 'org.freedesktop.RealtimeKit1' Jan 30 20:47:12 VM systemd[1]: Started RealtimeKit Scheduling Policy Service. Jan 30 20:47:12 VM rtkit-daemon[5461]: Successfully called chroot. Jan 30 20:47:12 VM rtkit-daemon[5461]: Successfully dropped privileges. Jan 30 20:47:12 VM rtkit-daemon[5461]: Successfully limited resources. Jan 30 20:47:12 VM rtkit-daemon[5461]: Running. Jan 30 20:47:12 VM rtkit-daemon[5461]: Canary thread running. Jan 30 20:47:12 VM rtkit-daemon[5461]: Watchdog thread running. Jan 30 20:47:12 VM systemd[1]: Started Trigger resolvconf update for networkd DNS. Jan 30 20:47:12 VM systemd-timesyncd[5471]: Synchronized to time server 139.59.50.38:123 (in.pool.ntp.org). Jan 30 20:47:12 VM polkitd[5465]: started daemon version 0.105 using authority implementation `local' version `0.105' Jan 30 20:47:12 VM dbus[1009]: [system] Successfully activated service 'org.freedesktop.PolicyKit1' Jan 30 20:47:12 VM systemd[1]: Started Authenticate and Authorize Users to Run Privileged Tasks. Jan 30 20:47:12 VM accounts-daemon[5460]: started daemon version 0.6.40 Jan 30 20:47:12 VM dbus[1009]: [system] Successfully activated service 'org.freedesktop.Accounts' Jan 30 20:47:12 VM systemd[1]: Started Accounts Service. Jan 30 20:47:12 VM kernel: serial8250: too much work for irq4 Jan 30 20:47:12 VM kernel: serial8250: too much work for irq4 Jan 30 20:47:13 VM dbus[1009]: [system] Activating via systemd: service name='org.bluez' unit='dbus-org.bluez.service' Jan 30 20:47:13 VM pulseaudio[5540]: [pulseaudio] pid.c: Daemon already running. Jan 30 20:47:13 VM kernel: serial8250: too much work for irq4 Jan 30 20:47:13 VM kernel: serial8250: too much work for irq4 Jan 30 20:47:14 VM kernel: serial8250: too much work for irq4 Jan 30 20:47:14 VM kernel: serial8250: too much work for irq4 Jan 30 20:47:16 VM systemd[1]: Reloading. Jan 30 20:47:16 VM systemd[1]: Started ACPI event daemon. Jan 30 20:47:16 VM systemd[1]: Started CUPS Scheduler. Jan 30 20:47:17 VM systemd[1]: Reloading. Jan 30 20:47:18 VM systemd[1]: Started ACPI event daemon. Jan 30 20:47:18 VM systemd[1]: Started CUPS Scheduler. Jan 30 20:47:20 VM kernel: serial8250: too much work for irq4 Jan 30 20:47:20 VM kernel: serial8250: too much work for irq4 Jan 30 20:47:21 VM kernel: serial8250: too much work for irq4 Jan 30 20:47:21 VM kernel: serial8250: too much work for irq4 Jan 30 20:47:24 VM anacron[1005]: Job `cron.daily' terminated Jan 30 20:47:35 VM kernel: serial8250: too much work for irq4 Jan 30 20:47:35 VM kernel: serial8250: too much work for irq4 Jan 30 20:47:37 VM kernel: serial8250: too much work for irq4 Jan 30 20:47:37 VM kernel: serial8250: too much work for irq4 Jan 30 20:47:38 VM pulseaudio[2548]: [pulseaudio] bluez5-util.c: GetManagedObjects() failed: org.freedesktop.DBus.Error.NoReply: Did not receive a reply. Possible causes include: the remote application did not send a reply, the message bus security policy blocked the reply, the reply timeout expired, or the network connection was broken. Jan 30 20:47:38 VM dbus[1009]: [system] Failed to activate service 'org.bluez': timed out Jan 30 20:47:39 VM kernel: serial8250: too much work for irq4 Jan 30 20:47:39 VM kernel: serial8250: too much work for irq4 Jan 30 20:47:42 VM systemd[1]: Reloading. Jan 30 20:47:42 VM systemd[1]: Started ACPI event daemon. Jan 30 20:47:42 VM systemd[1]: Started CUPS Scheduler. Jan 30 20:47:42 VM dbus[1009]: [system] Reloaded configuration Jan 30 20:47:42 VM dbus[1009]: [system] Reloaded configuration Jan 30 20:47:42 VM dbus[1009]: [system] Reloaded configuration Jan 30 20:47:42 VM dbus[1009]: [system] Reloaded configuration Jan 30 20:47:42 VM dbus[1009]: [system] Reloaded configuration Jan 30 20:47:48 VM systemd[1]: Reloading. Jan 30 20:47:49 VM systemd[1]: Started ACPI event daemon. Jan 30 20:47:49 VM systemd[1]: Started CUPS Scheduler. Jan 30 20:47:49 VM systemd[1]: Stopping Unattended Upgrades Shutdown... Jan 30 20:48:27 VM kernel: serial8250: too much work for irq4 Jan 30 20:48:27 VM kernel: serial8250: too much work for irq4 Jan 30 20:48:28 VM kernel: serial8250: too much work for irq4 Jan 30 20:48:28 VM kernel: serial8250: too much work for irq4 Jan 30 20:48:43 VM kernel: serial8250: too much work for irq4 Jan 30 20:48:43 VM kernel: serial8250: too much work for irq4 Jan 30 20:49:45 VM anacron[1005]: Job `cron.weekly' started Jan 30 20:49:45 VM anacron[7237]: Updated timestamp for job `cron.weekly' to 2019-01-30 Jan 30 20:49:45 VM kernel: serial8250: too much work for irq4 Jan 30 20:49:45 VM kernel: serial8250: too much work for irq4 Jan 30 20:49:50 VM anacron[1005]: Job `cron.weekly' terminated (mailing output) Jan 30 20:49:50 VM anacron[1005]: Can't find sendmail at /usr/sbin/sendmail, not mailing output Jan 30 20:49:50 VM anacron[1005]: anacron: Can't find sendmail at /usr/sbin/sendmail, not mailing output Jan 30 20:50:03 VM systemd-timesyncd[5471]: Timed out waiting for reply from 139.59.50.38:123 (in.pool.ntp.org). Jan 30 20:50:03 VM systemd-timesyncd[5471]: Synchronized to time server 183.177.72.201:123 (asia.pool.ntp.org). Jan 30 20:50:24 VM kernel: serial8250: too much work for irq4 Jan 30 20:50:24 VM kernel: serial8250: too much work for irq4 Jan 30 20:50:41 VM kernel: serial8250: too much work for irq4 Jan 30 20:50:41 VM kernel: serial8250: too much work for irq4 Jan 30 20:50:42 VM kernel: serial8250: too much work for irq4 Jan 30 20:50:42 VM kernel: serial8250: too much work for irq4 Jan 30 20:51:33 VM kernel: serial8250: too much work for irq4 Jan 30 20:51:33 VM kernel: serial8250: too much work for irq4 Jan 30 20:52:15 VM kernel: serial8250: too much work for irq4 Jan 30 20:52:15 VM kernel: serial8250: too much work for irq4 Jan 30 20:52:16 VM kernel: serial8250: too much work for irq4 Jan 30 20:52:16 VM kernel: serial8250: too much work for irq4 Jan 30 20:52:36 VM kernel: serial8250: too much work for irq4 Jan 30 20:52:36 VM kernel: serial8250: too much work for irq4 Jan 30 20:52:43 VM kernel: serial8250: too much work for irq4 Jan 30 20:52:43 VM kernel: serial8250: too much work for irq4 Jan 30 20:52:49 VM kernel: serial8250: too much work for irq4 Jan 30 20:52:49 VM kernel: serial8250: too much work for irq4 Jan 30 20:52:53 VM systemd[1]: Starting Cleanup of Temporary Directories... Jan 30 20:52:53 VM systemd-tmpfiles[8049]: [/usr/lib/tmpfiles.d/var.conf:14] Duplicate line for path "/var/log", ignoring. Jan 30 20:52:53 VM systemd[1]: Started Cleanup of Temporary Directories. Jan 30 20:53:46 VM kernel: serial8250: too much work for irq4 Jan 30 20:53:46 VM kernel: serial8250: too much work for irq4 Jan 30 20:53:47 VM kernel: serial8250: too much work for irq4 Jan 30 20:53:47 VM kernel: serial8250: too much work for irq4 Jan 30 20:54:28 VM kernel: serial8250: too much work for irq4 Jan 30 20:54:28 VM kernel: serial8250: too much work for irq4 Jan 30 20:54:29 VM kernel: serial8250: too much work for irq4 Jan 30 20:54:29 VM kernel: serial8250: too much work for irq4 Jan 30 20:54:35 VM systemd[1]: ModemManager.service: Start operation timed out. Terminating. Jan 30 20:54:35 VM ModemManager[979]: <info> Caught signal, shutting down... Jan 30 20:54:35 VM systemd[1]: avahi-daemon.service: Start operation timed out. Terminating. Jan 30 20:54:35 VM avahi-daemon[980]: Got SIGTERM, quitting. Jan 30 20:54:35 VM avahi-daemon[980]: Leaving mDNS multicast group on interface ens6.IPv6 with address fd17:5821:95c0:0:5054:ff:fe11:603. Jan 30 20:54:35 VM avahi-daemon[980]: Leaving mDNS multicast group on interface ens6.IPv4 with address 192.168.240.210. Jan 30 20:54:35 VM avahi-daemon[980]: Leaving mDNS multicast group on interface ens5.IPv6 with address fe80::5054:ff:fecc:2. Jan 30 20:54:35 VM avahi-daemon[980]: Leaving mDNS multicast group on interface ens5.IPv4 with address 192.168.123.12. Jan 30 20:54:35 VM avahi-daemon[980]: avahi-daemon 0.6.32-rc exiting. Jan 30 20:54:35 VM systemd[1]: Failed to start Avahi mDNS/DNS-SD Stack. Jan 30 20:54:35 VM systemd[1]: avahi-daemon.service: Unit entered failed state. Jan 30 20:54:35 VM systemd[1]: avahi-daemon.service: Failed with result 'timeout'. Jan 30 20:54:35 VM ModemManager[979]: <info> ModemManager is shut down Jan 30 20:54:35 VM systemd[1]: Started Make remote CUPS printers available locally. Jan 30 20:54:35 VM systemd[1]: Failed to start Modem Manager. Jan 30 20:54:35 VM systemd[1]: ModemManager.service: Unit entered failed state. Jan 30 20:54:35 VM systemd[1]: ModemManager.service: Failed with result 'timeout'. Jan 30 20:54:35 VM dbus[1009]: [system] Activating via systemd: service name='org.freedesktop.Avahi' unit='dbus-org.freedesktop.Avahi.service' Jan 30 20:54:35 VM systemd[1]: Starting Avahi mDNS/DNS-SD Stack... Jan 30 20:54:35 VM avahi-daemon[8089]: Process 980 died: No such process; trying to remove PID file. (/var/run/avahi-daemon//pid) Jan 30 20:54:35 VM avahi-daemon[8089]: Found user 'avahi' (UID 111) and group 'avahi' (GID 120). Jan 30 20:54:35 VM avahi-daemon[8089]: Successfully dropped root privileges. Jan 30 20:54:35 VM avahi-daemon[8089]: avahi-daemon 0.6.32-rc starting up. Jan 30 20:54:35 VM dbus[1009]: [system] Successfully activated service 'org.freedesktop.Avahi' Jan 30 20:54:35 VM systemd[1]: Started Avahi mDNS/DNS-SD Stack. Jan 30 20:54:35 VM avahi-daemon[8089]: Successfully called chroot(). Jan 30 20:54:35 VM avahi-daemon[8089]: Successfully dropped remaining capabilities. Jan 30 20:54:35 VM avahi-daemon[8089]: No service file found in /etc/avahi/services. Jan 30 20:54:35 VM avahi-daemon[8089]: Joining mDNS multicast group on interface ens6.IPv6 with address fd17:5821:95c0:0:5054:ff:fe11:603. Jan 30 20:54:35 VM avahi-daemon[8089]: New relevant interface ens6.IPv6 for mDNS. Jan 30 20:54:35 VM avahi-daemon[8089]: Joining mDNS multicast group on interface ens6.IPv4 with address 192.168.240.210. Jan 30 20:54:35 VM avahi-daemon[8089]: New relevant interface ens6.IPv4 for mDNS. Jan 30 20:54:35 VM avahi-daemon[8089]: Joining mDNS multicast group on interface ens5.IPv6 with address fe80::5054:ff:fecc:2. Jan 30 20:54:35 VM avahi-daemon[8089]: New relevant interface ens5.IPv6 for mDNS. Jan 30 20:54:35 VM avahi-daemon[8089]: Joining mDNS multicast group on interface ens5.IPv4 with address 192.168.123.12. Jan 30 20:54:35 VM avahi-daemon[8089]: New relevant interface ens5.IPv4 for mDNS. Jan 30 20:54:35 VM avahi-daemon[8089]: Network interface enumeration completed. Jan 30 20:54:35 VM avahi-daemon[8089]: Registering new address record for fd17:5821:95c0:0:5054:ff:fe11:603 on ens6.*. Jan 30 20:54:35 VM avahi-daemon[8089]: Registering new address record for fd17:5821:95c0::1ce on ens6.*. Jan 30 20:54:35 VM avahi-daemon[8089]: Registering new address record for 192.168.240.210 on ens6.IPv4. Jan 30 20:54:35 VM avahi-daemon[8089]: Registering new address record for fe80::5054:ff:fecc:2 on ens5.*. Jan 30 20:54:35 VM avahi-daemon[8089]: Registering new address record for 192.168.123.12 on ens5.IPv4. Jan 30 20:54:36 VM avahi-daemon[8089]: Withdrawing address record for fd17:5821:95c0:0:5054:ff:fe11:603 on ens6. Jan 30 20:54:36 VM avahi-daemon[8089]: Withdrawing address record for fd17:5821:95c0::1ce on ens6. Jan 30 20:54:36 VM avahi-daemon[8089]: Withdrawing address record for 192.168.240.210 on ens6. Jan 30 20:54:36 VM avahi-daemon[8089]: Withdrawing address record for 192.168.123.12 on ens5. Jan 30 20:54:36 VM avahi-daemon[8089]: Host name conflict, retrying with VM-2 Jan 30 20:54:36 VM avahi-daemon[8089]: Registering new address record for fd17:5821:95c0:0:5054:ff:fe11:603 on ens6.*. Jan 30 20:54:36 VM avahi-daemon[8089]: Registering new address record for fd17:5821:95c0::1ce on ens6.*. Jan 30 20:54:36 VM avahi-daemon[8089]: Registering new address record for 192.168.240.210 on ens6.IPv4. Jan 30 20:54:36 VM avahi-daemon[8089]: Registering new address record for fe80::5054:ff:fecc:2 on ens5.*. Jan 30 20:54:36 VM avahi-daemon[8089]: Registering new address record for 192.168.123.12 on ens5.IPv4. Jan 30 20:54:37 VM avahi-daemon[8089]: Withdrawing address record for fd17:5821:95c0:0:5054:ff:fe11:603 on ens6. Jan 30 20:54:37 VM avahi-daemon[8089]: Withdrawing address record for fd17:5821:95c0::1ce on ens6. Jan 30 20:54:37 VM avahi-daemon[8089]: Withdrawing address record for 192.168.240.210 on ens6. Jan 30 20:54:37 VM avahi-daemon[8089]: Withdrawing address record for 192.168.123.12 on ens5. Jan 30 20:54:37 VM avahi-daemon[8089]: Host name conflict, retrying with VM-3 Jan 30 20:54:37 VM avahi-daemon[8089]: Registering new address record for fd17:5821:95c0:0:5054:ff:fe11:603 on ens6.*. Jan 30 20:54:37 VM avahi-daemon[8089]: Registering new address record for fd17:5821:95c0::1ce on ens6.*. Jan 30 20:54:37 VM avahi-daemon[8089]: Registering new address record for 192.168.240.210 on ens6.IPv4. Jan 30 20:54:37 VM avahi-daemon[8089]: Registering new address record for fe80::5054:ff:fecc:2 on ens5.*. Jan 30 20:54:37 VM avahi-daemon[8089]: Registering new address record for 192.168.123.12 on ens5.IPv4. Jan 30 20:54:38 VM avahi-daemon[8089]: Withdrawing address record for fd17:5821:95c0:0:5054:ff:fe11:603 on ens6. Jan 30 20:54:38 VM avahi-daemon[8089]: Withdrawing address record for fd17:5821:95c0::1ce on ens6. Jan 30 20:54:38 VM avahi-daemon[8089]: Withdrawing address record for 192.168.240.210 on ens6. Jan 30 20:54:38 VM avahi-daemon[8089]: Withdrawing address record for 192.168.123.12 on ens5. Jan 30 20:54:38 VM avahi-daemon[8089]: Host name conflict, retrying with VM-4 Jan 30 20:54:38 VM avahi-daemon[8089]: Registering new address record for fd17:5821:95c0:0:5054:ff:fe11:603 on ens6.*. Jan 30 20:54:38 VM avahi-daemon[8089]: Registering new address record for fd17:5821:95c0::1ce on ens6.*. Jan 30 20:54:38 VM avahi-daemon[8089]: Registering new address record for 192.168.240.210 on ens6.IPv4. Jan 30 20:54:38 VM avahi-daemon[8089]: Registering new address record for fe80::5054:ff:fecc:2 on ens5.*. Jan 30 20:54:38 VM avahi-daemon[8089]: Registering new address record for 192.168.123.12 on ens5.IPv4. Jan 30 20:54:39 VM avahi-daemon[8089]: Withdrawing address record for fd17:5821:95c0:0:5054:ff:fe11:603 on ens6. Jan 30 20:54:39 VM avahi-daemon[8089]: Withdrawing address record for fd17:5821:95c0::1ce on ens6. Jan 30 20:54:39 VM avahi-daemon[8089]: Withdrawing address record for 192.168.240.210 on ens6. Jan 30 20:54:39 VM avahi-daemon[8089]: Withdrawing address record for 192.168.123.12 on ens5. Jan 30 20:54:39 VM avahi-daemon[8089]: Host name conflict, retrying with VM-5 Jan 30 20:54:39 VM avahi-daemon[8089]: Registering new address record for fd17:5821:95c0:0:5054:ff:fe11:603 on ens6.*. Jan 30 20:54:39 VM avahi-daemon[8089]: Registering new address record for fd17:5821:95c0::1ce on ens6.*. Jan 30 20:54:39 VM avahi-daemon[8089]: Registering new address record for 192.168.240.210 on ens6.IPv4. Jan 30 20:54:39 VM avahi-daemon[8089]: Registering new address record for fe80::5054:ff:fecc:2 on ens5.*. Jan 30 20:54:39 VM avahi-daemon[8089]: Registering new address record for 192.168.123.12 on ens5.IPv4. Jan 30 20:54:40 VM avahi-daemon[8089]: Withdrawing address record for fd17:5821:95c0:0:5054:ff:fe11:603 on ens6. Jan 30 20:54:40 VM avahi-daemon[8089]: Withdrawing address record for fd17:5821:95c0::1ce on ens6. Jan 30 20:54:40 VM avahi-daemon[8089]: Withdrawing address record for 192.168.240.210 on ens6. Jan 30 20:54:40 VM avahi-daemon[8089]: Withdrawing address record for 192.168.123.12 on ens5. Jan 30 20:54:40 VM avahi-daemon[8089]: Host name conflict, retrying with VM-6 Jan 30 20:54:40 VM avahi-daemon[8089]: Registering new address record for fd17:5821:95c0:0:5054:ff:fe11:603 on ens6.*. Jan 30 20:54:40 VM avahi-daemon[8089]: Registering new address record for fd17:5821:95c0::1ce on ens6.*. Jan 30 20:54:40 VM avahi-daemon[8089]: Registering new address record for 192.168.240.210 on ens6.IPv4. Jan 30 20:54:40 VM avahi-daemon[8089]: Registering new address record for fe80::5054:ff:fecc:2 on ens5.*. Jan 30 20:54:40 VM avahi-daemon[8089]: Registering new address record for 192.168.123.12 on ens5.IPv4. Jan 30 20:54:41 VM avahi-daemon[8089]: Withdrawing address record for fd17:5821:95c0:0:5054:ff:fe11:603 on ens6. Jan 30 20:54:41 VM avahi-daemon[8089]: Withdrawing address record for fd17:5821:95c0::1ce on ens6. Jan 30 20:54:41 VM avahi-daemon[8089]: Withdrawing address record for 192.168.240.210 on ens6. Jan 30 20:54:41 VM avahi-daemon[8089]: Withdrawing address record for 192.168.123.12 on ens5. Jan 30 20:54:41 VM avahi-daemon[8089]: Host name conflict, retrying with VM-7 Jan 30 20:54:41 VM avahi-daemon[8089]: Registering new address record for fd17:5821:95c0:0:5054:ff:fe11:603 on ens6.*. Jan 30 20:54:41 VM avahi-daemon[8089]: Registering new address record for fd17:5821:95c0::1ce on ens6.*. Jan 30 20:54:41 VM avahi-daemon[8089]: Registering new address record for 192.168.240.210 on ens6.IPv4. Jan 30 20:54:41 VM avahi-daemon[8089]: Registering new address record for fe80::5054:ff:fecc:2 on ens5.*. Jan 30 20:54:41 VM avahi-daemon[8089]: Registering new address record for 192.168.123.12 on ens5.IPv4. Jan 30 20:54:42 VM avahi-daemon[8089]: Withdrawing address record for fd17:5821:95c0:0:5054:ff:fe11:603 on ens6. Jan 30 20:54:42 VM avahi-daemon[8089]: Withdrawing address record for fd17:5821:95c0::1ce on ens6. Jan 30 20:54:42 VM avahi-daemon[8089]: Withdrawing address record for 192.168.240.210 on ens6. Jan 30 20:54:42 VM avahi-daemon[8089]: Withdrawing address record for 192.168.123.12 on ens5. Jan 30 20:54:42 VM avahi-daemon[8089]: Host name conflict, retrying with VM-8 Jan 30 20:54:42 VM avahi-daemon[8089]: Registering new address record for fd17:5821:95c0:0:5054:ff:fe11:603 on ens6.*. Jan 30 20:54:42 VM avahi-daemon[8089]: Registering new address record for fd17:5821:95c0::1ce on ens6.*. Jan 30 20:54:42 VM avahi-daemon[8089]: Registering new address record for 192.168.240.210 on ens6.IPv4. Jan 30 20:54:42 VM avahi-daemon[8089]: Registering new address record for fe80::5054:ff:fecc:2 on ens5.*. Jan 30 20:54:42 VM avahi-daemon[8089]: Registering new address record for 192.168.123.12 on ens5.IPv4. Jan 30 20:54:43 VM avahi-daemon[8089]: Withdrawing address record for fd17:5821:95c0:0:5054:ff:fe11:603 on ens6. Jan 30 20:54:43 VM avahi-daemon[8089]: Withdrawing address record for fd17:5821:95c0::1ce on ens6. Jan 30 20:54:43 VM avahi-daemon[8089]: Withdrawing address record for 192.168.240.210 on ens6. Jan 30 20:54:43 VM avahi-daemon[8089]: Withdrawing address record for 192.168.123.12 on ens5. Jan 30 20:54:43 VM avahi-daemon[8089]: Host name conflict, retrying with VM-9 Jan 30 20:54:43 VM avahi-daemon[8089]: Registering new address record for fd17:5821:95c0:0:5054:ff:fe11:603 on ens6.*. Jan 30 20:54:43 VM avahi-daemon[8089]: Registering new address record for fd17:5821:95c0::1ce on ens6.*. Jan 30 20:54:43 VM avahi-daemon[8089]: Registering new address record for 192.168.240.210 on ens6.IPv4. Jan 30 20:54:43 VM avahi-daemon[8089]: Registering new address record for fe80::5054:ff:fecc:2 on ens5.*. Jan 30 20:54:43 VM avahi-daemon[8089]: Registering new address record for 192.168.123.12 on ens5.IPv4. Jan 30 20:54:44 VM avahi-daemon[8089]: Server startup complete. Host name is VM-9.local. Local service cookie is 1667207648. Jan 30 20:54:45 VM anacron[1005]: Job `cron.monthly' started Jan 30 20:54:45 VM anacron[1005]: Job `cron.monthly' terminated Jan 30 20:54:45 VM anacron[1005]: Normal exit (3 jobs run) Jan 30 20:55:10 VM systemd[1]: lightdm.service: Start operation timed out. Terminating. Jan 30 20:55:10 VM org.a11y.atspi.Registry[2409]: XIO: fatal IO error 11 (Resource temporarily unavailable) on X server ":0" Jan 30 20:55:10 VM org.gtk.vfs.Daemon[2401]: A connection to the bus can't be made Jan 30 20:55:10 VM lightdm[1884]: pam_unix(lightdm-greeter:session): session closed for user lightdm Jan 30 20:55:10 VM systemd[1]: Failed to start Light Display Manager. Jan 30 20:55:10 VM systemd[1]: lightdm.service: Unit entered failed state. Jan 30 20:55:10 VM systemd[1]: lightdm.service: Triggering OnFailure= dependencies. Jan 30 20:55:10 VM systemd[1]: lightdm.service: Failed with result 'timeout'. Jan 30 20:55:10 VM systemd[1]: Starting Auto import assertions from block devices... Jan 30 20:55:10 VM systemd[1]: Starting Modem Manager... Jan 30 20:55:10 VM systemd[1]: Started Run anacron jobs. Jan 30 20:55:10 VM systemd[1]: Starting Clean up any mess left by 0dns-up... Jan 30 20:55:10 VM anacron[8115]: Anacron 2.3 started on 2019-01-30 Jan 30 20:55:10 VM systemd[1]: Starting Restore /etc/resolv.conf if the system crashed before the ppp link was shut down... Jan 30 20:55:10 VM anacron[8115]: Normal exit (0 jobs run) Jan 30 20:55:10 VM systemd[1]: Starting Terminate Plymouth Boot Screen... Jan 30 20:55:10 VM mkdir[8118]: /bin/mkdir: cannot create directory â??/var/run/pppconfigâ??: File exists Jan 30 20:55:10 VM ModemManager[8114]: <info> ModemManager (version 1.4.12) starting in system bus... Jan 30 20:55:10 VM systemd[1]: Stopped target Graphical Interface. Jan 30 20:55:10 VM systemd[1]: Starting Hold until boot process finishes up... Jan 30 20:55:10 VM systemd[1]: Started ISC DHCP IPv6 relay. Jan 30 20:55:10 VM systemd[1]: dns-clean.service: Control process exited, code=exited status=1 Jan 30 20:55:10 VM systemd[1]: Failed to start Clean up any mess left by 0dns-up. Jan 30 20:55:10 VM systemd[1]: dns-clean.service: Unit entered failed state. Jan 30 20:55:10 VM systemd[1]: dns-clean.service: Failed with result 'exit-code'. Jan 30 20:55:10 VM sh[8125]: No interface defined in /etc/default/isc-dhcp-relay6! - Aborting... Jan 30 20:55:10 VM systemd[1]: Started Restore /etc/resolv.conf if the system crashed before the ppp link was shut down. Jan 30 20:55:10 VM systemd[1]: Started Hold until boot process finishes up. Jan 30 20:55:10 VM snap[8112]: auto-import is disabled on classic Jan 30 20:55:10 VM systemd[1]: Started Terminate Plymouth Boot Screen. Jan 30 20:55:10 VM systemd[1]: Started Auto import assertions from block devices. Jan 30 20:55:10 VM systemd[1]: Started Modem Manager. Jan 30 20:55:10 VM systemd[1]: Started X.org diagnosis failsafe. Jan 30 20:55:10 VM systemd[1]: Reloading. Jan 30 20:55:10 VM systemd[1]: lightdm.service: Service hold-off time over, scheduling restart. Jan 30 20:55:10 VM systemd[1]: Stopped Light Display Manager. Jan 30 20:55:10 VM systemd[1]: Starting Detect the available GPUs and deal with any system changes... Jan 30 20:55:10 VM systemd[1]: Started ACPI event daemon. Jan 30 20:55:10 VM systemd[1]: Started CUPS Scheduler. Jan 30 20:55:10 VM gpu-manager[8175]: /etc/modprobe.d is not a file Jan 30 20:55:10 VM gpu-manager[8175]: /etc/modprobe.d is not a file Jan 30 20:55:10 VM gpu-manager[8175]: /etc/modprobe.d is not a file Jan 30 20:55:10 VM gpu-manager[8175]: /etc/modprobe.d is not a file Jan 30 20:55:10 VM gpu-manager[8175]: /etc/modprobe.d is not a file Jan 30 20:55:10 VM gpu-manager[8175]: Error: can't open /lib/modules/4.13.16/updates/dkms Jan 30 20:55:10 VM gpu-manager[8175]: Error: can't open /lib/modules/4.13.16/updates/dkms Jan 30 20:55:10 VM gpu-manager[8175]: update-alternatives: error: no alternatives for x86_64-linux-gnu_gfxcore_conf Jan 30 20:55:10 VM systemd[1]: Started Detect the available GPUs and deal with any system changes. Jan 30 20:55:10 VM systemd[1]: Starting Light Display Manager... Jan 30 20:55:10 VM systemd[1]: Started Light Display Manager. Jan 30 20:55:11 VM lightdm[8234]: PAM unable to dlopen(pam_kwallet.so): /lib/security/pam_kwallet.so: cannot open shared object file: No such file or directory Jan 30 20:55:11 VM lightdm[8234]: PAM adding faulty module: pam_kwallet.so Jan 30 20:55:11 VM lightdm[8234]: PAM unable to dlopen(pam_kwallet5.so): /lib/security/pam_kwallet5.so: cannot open shared object file: No such file or directory Jan 30 20:55:11 VM lightdm[8234]: PAM adding faulty module: pam_kwallet5.so Jan 30 20:55:11 VM lightdm[8234]: pam_unix(lightdm-greeter:session): session opened for user lightdm by (uid=0) Jan 30 20:55:11 VM systemd[1]: Created slice User Slice of lightdm. Jan 30 20:55:11 VM systemd[1]: Starting User Manager for UID 108... Jan 30 20:55:11 VM systemd-logind[3919]: New session c1 of user lightdm. Jan 30 20:55:11 VM systemd[1]: Started Session c1 of user lightdm. Jan 30 20:55:11 VM systemd[8237]: pam_unix(systemd-user:session): session opened for user lightdm by (uid=0) Jan 30 20:55:11 VM systemd[8237]: Reached target Paths. Jan 30 20:55:11 VM systemd[8237]: Reached target Timers. Jan 30 20:55:11 VM systemd[8237]: Reached target Sockets. Jan 30 20:55:11 VM systemd[8237]: Reached target Basic System. Jan 30 20:55:11 VM systemd[8237]: Reached target Default. Jan 30 20:55:11 VM systemd[8237]: Startup finished in 25ms. Jan 30 20:55:11 VM systemd[1]: Started User Manager for UID 108. Jan 30 20:55:11 VM org.a11y.atspi.Registry[8259]: SpiRegistry daemon is running with well-known name - org.a11y.atspi.Registry Jan 30 20:55:11 VM lightdm[8302]: PAM unable to dlopen(pam_kwallet.so): /lib/security/pam_kwallet.so: cannot open shared object file: No such file or directory Jan 30 20:55:11 VM lightdm[8302]: PAM adding faulty module: pam_kwallet.so Jan 30 20:55:11 VM lightdm[8302]: PAM unable to dlopen(pam_kwallet5.so): /lib/security/pam_kwallet5.so: cannot open shared object file: No such file or directory Jan 30 20:55:11 VM lightdm[8302]: PAM adding faulty module: pam_kwallet5.so Jan 30 20:55:11 VM dbus[1009]: [system] Activating via systemd: service name='org.bluez' unit='dbus-org.bluez.service' Jan 30 20:55:11 VM rtkit-daemon[5461]: Successfully made thread 8364 of process 8364 (n/a) owned by '108' high priority at nice level -11. Jan 30 20:55:11 VM rtkit-daemon[5461]: Supervising 1 threads of 1 processes of 1 users. Jan 30 20:55:11 VM pulseaudio[8364]: [pulseaudio] alsa-util.c: Disabling timer-based scheduling because running inside a VM. Jan 30 20:55:11 VM rtkit-daemon[5461]: Supervising 1 threads of 1 processes of 1 users. Jan 30 20:55:11 VM rtkit-daemon[5461]: Successfully made thread 8380 of process 8364 (n/a) owned by '108' RT at priority 5. Jan 30 20:55:11 VM rtkit-daemon[5461]: Supervising 2 threads of 1 processes of 1 users. Jan 30 20:55:11 VM pulseaudio[8364]: [pulseaudio] alsa-util.c: Disabling timer-based scheduling because running inside a VM. Jan 30 20:55:11 VM rtkit-daemon[5461]: Supervising 2 threads of 1 processes of 1 users. Jan 30 20:55:11 VM rtkit-daemon[5461]: Successfully made thread 8381 of process 8364 (n/a) owned by '108' RT at priority 5. Jan 30 20:55:11 VM rtkit-daemon[5461]: Supervising 3 threads of 1 processes of 1 users. Jan 30 20:55:11 VM rtkit-daemon[5461]: Successfully made thread 8383 of process 8383 (n/a) owned by '108' high priority at nice level -11. Jan 30 20:55:11 VM rtkit-daemon[5461]: Supervising 4 threads of 2 processes of 1 users. Jan 30 20:55:11 VM pulseaudio[8383]: [pulseaudio] pid.c: Daemon already running. Jan 30 20:55:11 VM dbus[1009]: [system] Activating via systemd: service name='org.freedesktop.UPower' unit='upower.service' Jan 30 20:55:11 VM systemd[1]: Starting Daemon for power management... Jan 30 20:55:11 VM dbus[1009]: [system] Successfully activated service 'org.freedesktop.UPower' Jan 30 20:55:11 VM systemd[1]: Started Daemon for power management. Jan 30 20:55:11 VM dbus[1009]: [system] Activating via systemd: service name='org.freedesktop.ColorManager' unit='colord.service' Jan 30 20:55:11 VM systemd[1]: Starting Manage, Install and Generate Color Profiles... Jan 30 20:55:12 VM colord[8401]: (colord:8401): Cd-WARNING **: failed to get edid data: EDID length is too small Jan 30 20:55:12 VM dbus[1009]: [system] Successfully activated service 'org.freedesktop.ColorManager' Jan 30 20:55:12 VM systemd[1]: Started Manage, Install and Generate Color Profiles. Jan 30 20:55:13 VM ModemManager[8114]: <info> Couldn't find support for device at '/sys/devices/pci0000:00/0000:00:05.0': not supported by any plugin Jan 30 20:55:13 VM ModemManager[8114]: <info> Couldn't find support for device at '/sys/devices/pci0000:00/0000:00:06.0': not supported by any plugin Jan 30 20:55:15 VM failsafeXServer[8149]: expr: non-integer argument Jan 30 20:55:15 VM failsafeXServer[8149]: /usr/share/xdiagnose/failsafeXServer: line 87: [: -lt: unary operator expected Jan 30 20:55:15 VM failsafeXServer[8149]: xinit /usr/share/xdiagnose/failsafeXinit /etc/X11/xorg.conf.failsafe -- /usr/bin/X -br -once -config /etc/X11/xorg.conf.failsafe -logfile /var/log/Xorg.failsafe.log Jan 30 20:55:16 VM failsafeXServer[8149]: (EE) Jan 30 20:55:16 VM failsafeXServer[8149]: Fatal server error: Jan 30 20:55:16 VM failsafeXServer[8149]: (EE) Server is already active for display 0 Jan 30 20:55:16 VM failsafeXServer[8149]: If this server is no longer running, remove /tmp/.X0-lock Jan 30 20:55:16 VM failsafeXServer[8149]: and start again. Jan 30 20:55:16 VM failsafeXServer[8149]: (EE) Jan 30 20:55:16 VM failsafeXServer[8149]: (EE) Jan 30 20:55:16 VM failsafeXServer[8149]: Please consult the The X.Org Foundation support Jan 30 20:55:16 VM failsafeXServer[8149]: at http://wiki.x.org Jan 30 20:55:16 VM failsafeXServer[8149]: for help. Jan 30 20:55:16 VM failsafeXServer[8149]: (EE) Jan 30 20:55:17 VM /usr/lib/snapd/snapd[1062]: snapmgr.go:422: No snaps to auto-refresh found Jan 30 20:55:17 VM snapd[1062]: 2019/01/30 20:55:17.410764 snapmgr.go:422: No snaps to auto-refresh found Jan 30 20:55:31 VM failsafeXServer[8149]: No protocol specified Jan 30 20:55:31 VM failsafeXServer[8149]: xinit: giving up Jan 30 20:55:31 VM failsafeXServer[8149]: xinit: unable to connect to X server: Resource temporarily unavailable Jan 30 20:55:31 VM failsafeXServer[8149]: xinit: server error Jan 30 20:55:34 VM kernel: serial8250: too much work for irq4 Jan 30 20:55:34 VM kernel: serial8250: too much work for irq4 Jan 30 20:55:36 VM dbus[1009]: [system] Failed to activate service 'org.bluez': timed out Jan 30 20:55:36 VM pulseaudio[8364]: [pulseaudio] bluez5-util.c: GetManagedObjects() failed: org.freedesktop.DBus.Error.TimedOut: Failed to activate service 'org.bluez': timed out Jan 30 20:55:40 VM kernel: serial8250: too much work for irq4 Jan 30 20:55:40 VM kernel: serial8250: too much work for irq4
_______________________________________________ libvirt-users mailing list libvirt-users@xxxxxxxxxx https://www.redhat.com/mailman/listinfo/libvirt-users
