May 25 04:03:03 ubuntu rsyslogd: [origin software="rsyslogd" swVersion="8.16.0" x-pid="1134" x-info="http://www.rsyslog.com"] start
May 25 04:03:03 ubuntu systemd[1]: Started Create list of required static device nodes for the current kernel.
May 25 04:03:03 ubuntu systemd[1]: Started Uncomplicated firewall.
May 25 04:03:03 ubuntu systemd[1]: Started Remount Root and Kernel File Systems.
May 25 04:03:03 ubuntu systemd[1]: Started Nameserver information manager.
May 25 04:03:03 ubuntu systemd[1]: Starting udev Coldplug all Devices...
May 25 04:03:03 ubuntu loadkeys[387]: Loading /etc/console-setup/cached.kmap.gz
May 25 04:03:03 ubuntu systemd[1]: Starting Load/Save Random Seed...
May 25 04:03:03 ubuntu systemd[1]: Starting Create Static Device Nodes in /dev...
May 25 04:03:03 ubuntu systemd-modules-load[394]: Inserted module 'iscsi_tcp'
May 25 04:03:03 ubuntu systemd[1]: Starting Flush Journal to Persistent Storage...
May 25 04:03:03 ubuntu systemd[1]: Started Set console keymap.
May 25 04:03:03 ubuntu systemd[1]: Started LVM2 metadata daemon.
May 25 04:03:03 ubuntu systemd[1]: Started Flush Journal to Persistent Storage.
May 25 04:03:03 ubuntu kernel: [    0.000000] random: get_random_bytes called from start_kernel+0x42/0x507 with crng_init=0
May 25 04:03:03 ubuntu systemd[1]: Started Load/Save Random Seed.
May 25 04:03:03 ubuntu systemd[1]: Started udev Coldplug all Devices.
May 25 04:03:03 ubuntu kernel: [    0.000000] Linux version 4.13.0-43-generic (buildd@lcy01-amd64-029) (gcc version 5.4.0 20160609 (Ubuntu 5.4.0-6ubuntu1~16.04.9)) #48~16.04.1-Ubuntu SMP Thu May 17 12:56:46 UTC 2018 (Ubuntu 4.13.0-43.48~16.04.1-generic 4.13.16)
May 25 04:03:03 ubuntu kernel: [    0.000000] Command line: BOOT_IMAGE=/boot/vmlinuz-4.13.0-43-generic root=UUID=84ce5b56-30b1-4479-a864-7296bb549cec ro console=tty1 console=ttyS0
May 25 04:03:03 ubuntu kernel: [    0.000000] KERNEL supported cpus:
May 25 04:03:03 ubuntu kernel: [    0.000000]   Intel GenuineIntel
May 25 04:03:03 ubuntu kernel: [    0.000000]   AMD AuthenticAMD
May 25 04:03:03 ubuntu kernel: [    0.000000]   Centaur CentaurHauls
May 25 04:03:03 ubuntu kernel: [    0.000000] x86/fpu: x87 FPU will use FXSAVE
May 25 04:03:03 ubuntu kernel: [    0.000000] e820: BIOS-provided physical RAM map:
May 25 04:03:03 ubuntu kernel: [    0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable
May 25 04:03:03 ubuntu kernel: [    0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved
May 25 04:03:03 ubuntu kernel: [    0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved
May 25 04:03:03 ubuntu kernel: [    0.000000] BIOS-e820: [mem 0x0000000000100000-0x00000000bffdbfff] usable
May 25 04:03:03 ubuntu kernel: [    0.000000] BIOS-e820: [mem 0x00000000bffdc000-0x00000000bfffffff] reserved
May 25 04:03:03 ubuntu kernel: [    0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved
May 25 04:03:03 ubuntu kernel: [    0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved
May 25 04:03:03 ubuntu kernel: [    0.000000] BIOS-e820: [mem 0x0000000100000000-0x000000033fffffff] usable
May 25 04:03:03 ubuntu kernel: [    0.000000] NX (Execute Disable) protection: active
May 25 04:03:03 ubuntu kernel: [    0.000000] random: fast init done
May 25 04:03:03 ubuntu kernel: [    0.000000] SMBIOS 2.8 present.
May 25 04:03:03 ubuntu kernel: [    0.000000] DMI: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.10.2-1ubuntu1~cloud0 04/01/2014
May 25 04:03:03 ubuntu kernel: [    0.000000] Hypervisor detected: KVM
May 25 04:03:03 ubuntu kernel: [    0.000000] tsc: Fast TSC calibration using PIT
May 25 04:03:03 ubuntu kernel: [    0.000000] e820: update [mem 0x00000000-0x00000fff] usable ==> reserved
May 25 04:03:03 ubuntu kernel: [    0.000000] e820: remove [mem 0x000a0000-0x000fffff] usable
May 25 04:03:03 ubuntu kernel: [    0.000000] e820: last_pfn = 0x340000 max_arch_pfn = 0x400000000
May 25 04:03:03 ubuntu kernel: [    0.000000] MTRR default type: write-back
May 25 04:03:03 ubuntu kernel: [    0.000000] MTRR fixed ranges enabled:
May 25 04:03:03 ubuntu kernel: [    0.000000]   00000-9FFFF write-back
May 25 04:03:03 ubuntu kernel: [    0.000000]   A0000-BFFFF uncachable
May 25 04:03:03 ubuntu kernel: [    0.000000]   C0000-FFFFF write-protect
May 25 04:03:03 ubuntu kernel: [    0.000000] MTRR variable ranges enabled:
May 25 04:03:03 ubuntu kernel: [    0.000000]   0 base 00C0000000 mask FFC0000000 uncachable
May 25 04:03:03 ubuntu kernel: [    0.000000]   1 disabled
May 25 04:03:03 ubuntu kernel: [    0.000000]   2 disabled
May 25 04:03:03 ubuntu kernel: [    0.000000]   3 disabled
May 25 04:03:03 ubuntu kernel: [    0.000000]   4 disabled
May 25 04:03:03 ubuntu kernel: [    0.000000]   5 disabled
May 25 04:03:03 ubuntu kernel: [    0.000000]   6 disabled
May 25 04:03:03 ubuntu kernel: [    0.000000]   7 disabled
May 25 04:03:03 ubuntu kernel: [    0.000000] x86/PAT: PAT not supported by CPU.
May 25 04:03:03 ubuntu kernel: [    0.000000] x86/PAT: Configuration [0-7]: WB  WT  UC- UC  WB  WT  UC- UC  
May 25 04:03:03 ubuntu kernel: [    0.000000] e820: last_pfn = 0xbffdc max_arch_pfn = 0x400000000
May 25 04:03:03 ubuntu kernel: [    0.000000] found SMP MP-table at [mem 0x000f69f0-0x000f69ff] mapped at [ffff9fd4800f69f0]
May 25 04:03:03 ubuntu kernel: [    0.000000] Scanning 1 areas for low memory corruption
May 25 04:03:03 ubuntu kernel: [    0.000000] Base memory trampoline at [ffff9fd480099000] 99000 size 24576
May 25 04:03:03 ubuntu kernel: [    0.000000] BRK [0x134b2c000, 0x134b2cfff] PGTABLE
May 25 04:03:03 ubuntu kernel: [    0.000000] BRK [0x134b2d000, 0x134b2dfff] PGTABLE
May 25 04:03:03 ubuntu kernel: [    0.000000] BRK [0x134b2e000, 0x134b2efff] PGTABLE
May 25 04:03:03 ubuntu kernel: [    0.000000] BRK [0x134b2f000, 0x134b2ffff] PGTABLE
May 25 04:03:03 ubuntu kernel: [    0.000000] BRK [0x134b30000, 0x134b30fff] PGTABLE
May 25 04:03:03 ubuntu kernel: [    0.000000] BRK [0x134b31000, 0x134b31fff] PGTABLE
May 25 04:03:03 ubuntu kernel: [    0.000000] BRK [0x134b32000, 0x134b32fff] PGTABLE
May 25 04:03:03 ubuntu kernel: [    0.000000] BRK [0x134b33000, 0x134b33fff] PGTABLE
May 25 04:03:03 ubuntu kernel: [    0.000000] RAMDISK: [mem 0x321e4000-0x350e9fff]
May 25 04:03:03 ubuntu kernel: [    0.000000] ACPI: Early table checksum verification disabled
May 25 04:03:03 ubuntu kernel: [    0.000000] ACPI: RSDP 0x00000000000F69A0 000014 (v00 BOCHS )
May 25 04:03:03 ubuntu kernel: [    0.000000] ACPI: RSDT 0x00000000BFFE13FD 000030 (v01 BOCHS  BXPCRSDT 00000001 BXPC 00000001)
May 25 04:03:03 ubuntu kernel: [    0.000000] ACPI: FACP 0x00000000BFFE1241 000074 (v01 BOCHS  BXPCFACP 00000001 BXPC 00000001)
May 25 04:03:03 ubuntu kernel: [    0.000000] ACPI: DSDT 0x00000000BFFDFD80 0014C1 (v01 BOCHS  BXPCDSDT 00000001 BXPC 00000001)
May 25 04:03:03 ubuntu kernel: [    0.000000] ACPI: FACS 0x00000000BFFDFD40 000040
May 25 04:03:03 ubuntu kernel: [    0.000000] ACPI: APIC 0x00000000BFFE1335 000090 (v01 BOCHS  BXPCAPIC 00000001 BXPC 00000001)
May 25 04:03:03 ubuntu kernel: [    0.000000] ACPI: HPET 0x00000000BFFE13C5 000038 (v01 BOCHS  BXPCHPET 00000001 BXPC 00000001)
May 25 04:03:03 ubuntu kernel: [    0.000000] ACPI: Local APIC address 0xfee00000
May 25 04:03:03 ubuntu kernel: [    0.000000] No NUMA configuration found
May 25 04:03:03 ubuntu kernel: [    0.000000] Faking a node at [mem 0x0000000000000000-0x000000033fffffff]
May 25 04:03:03 ubuntu kernel: [    0.000000] NODE_DATA(0) allocated [mem 0x33ffcd000-0x33fff7fff]
May 25 04:03:03 ubuntu kernel: [    0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00
May 25 04:03:03 ubuntu kernel: [    0.000000] kvm-clock: cpu 0, msr 3:3ff4d001, primary cpu clock
May 25 04:03:03 ubuntu kernel: [    0.000000] kvm-clock: using sched offset of 370964946369 cycles
May 25 04:03:03 ubuntu kernel: [    0.000000] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns
May 25 04:03:03 ubuntu kernel: [    0.000000] Zone ranges:
May 25 04:03:03 ubuntu kernel: [    0.000000]   DMA      [mem 0x0000000000001000-0x0000000000ffffff]
May 25 04:03:03 ubuntu kernel: [    0.000000]   DMA32    [mem 0x0000000001000000-0x00000000ffffffff]
May 25 04:03:03 ubuntu kernel: [    0.000000]   Normal   [mem 0x0000000100000000-0x000000033fffffff]
May 25 04:03:03 ubuntu kernel: [    0.000000]   Device   empty
May 25 04:03:03 ubuntu kernel: [    0.000000] Movable zone start for each node
May 25 04:03:03 ubuntu kernel: [    0.000000] Early memory node ranges
May 25 04:03:03 ubuntu kernel: [    0.000000]   node   0: [mem 0x0000000000001000-0x000000000009efff]
May 25 04:03:03 ubuntu kernel: [    0.000000]   node   0: [mem 0x0000000000100000-0x00000000bffdbfff]
May 25 04:03:03 ubuntu kernel: [    0.000000]   node   0: [mem 0x0000000100000000-0x000000033fffffff]
May 25 04:03:03 ubuntu kernel: [    0.000000] Initmem setup node 0 [mem 0x0000000000001000-0x000000033fffffff]
May 25 04:03:03 ubuntu kernel: [    0.000000] On node 0 totalpages: 3145594
May 25 04:03:03 ubuntu kernel: [    0.000000]   DMA zone: 64 pages used for memmap
May 25 04:03:03 ubuntu kernel: [    0.000000]   DMA zone: 21 pages reserved
May 25 04:03:03 ubuntu kernel: [    0.000000]   DMA zone: 3998 pages, LIFO batch:0
May 25 04:03:03 ubuntu kernel: [    0.000000]   DMA32 zone: 12224 pages used for memmap
May 25 04:03:03 ubuntu kernel: [    0.000000]   DMA32 zone: 782300 pages, LIFO batch:31
May 25 04:03:03 ubuntu kernel: [    0.000000]   Normal zone: 36864 pages used for memmap
May 25 04:03:03 ubuntu kernel: [    0.000000]   Normal zone: 2359296 pages, LIFO batch:31
May 25 04:03:03 ubuntu kernel: [    0.000000] ACPI: PM-Timer IO Port: 0x608
May 25 04:03:03 ubuntu kernel: [    0.000000] ACPI: Local APIC address 0xfee00000
May 25 04:03:03 ubuntu kernel: [    0.000000] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1])
May 25 04:03:03 ubuntu kernel: [    0.000000] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23
May 25 04:03:03 ubuntu kernel: [    0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl)
May 25 04:03:03 ubuntu kernel: [    0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level)
May 25 04:03:03 ubuntu kernel: [    0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level)
May 25 04:03:03 ubuntu kernel: [    0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level)
May 25 04:03:03 ubuntu kernel: [    0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level)
May 25 04:03:03 ubuntu kernel: [    0.000000] ACPI: IRQ0 used by override.
May 25 04:03:03 ubuntu kernel: [    0.000000] ACPI: IRQ5 used by override.
May 25 04:03:03 ubuntu kernel: [    0.000000] ACPI: IRQ9 used by override.
May 25 04:03:03 ubuntu kernel: [    0.000000] ACPI: IRQ10 used by override.
May 25 04:03:03 ubuntu kernel: [    0.000000] ACPI: IRQ11 used by override.
May 25 04:03:03 ubuntu kernel: [    0.000000] Using ACPI (MADT) for SMP configuration information
May 25 04:03:03 ubuntu kernel: [    0.000000] ACPI: HPET id: 0x8086a201 base: 0xfed00000
May 25 04:03:03 ubuntu kernel: [    0.000000] smpboot: Allowing 4 CPUs, 0 hotplug CPUs
May 25 04:03:03 ubuntu kernel: [    0.000000] PM: Registered nosave memory: [mem 0x00000000-0x00000fff]
May 25 04:03:03 ubuntu kernel: [    0.000000] PM: Registered nosave memory: [mem 0x0009f000-0x0009ffff]
May 25 04:03:03 ubuntu kernel: [    0.000000] PM: Registered nosave memory: [mem 0x000a0000-0x000effff]
May 25 04:03:03 ubuntu kernel: [    0.000000] PM: Registered nosave memory: [mem 0x000f0000-0x000fffff]
May 25 04:03:03 ubuntu kernel: [    0.000000] PM: Registered nosave memory: [mem 0xbffdc000-0xbfffffff]
May 25 04:03:03 ubuntu kernel: [    0.000000] PM: Registered nosave memory: [mem 0xc0000000-0xfeffbfff]
May 25 04:03:03 ubuntu kernel: [    0.000000] PM: Registered nosave memory: [mem 0xfeffc000-0xfeffffff]
May 25 04:03:03 ubuntu kernel: [    0.000000] PM: Registered nosave memory: [mem 0xff000000-0xfffbffff]
May 25 04:03:03 ubuntu kernel: [    0.000000] PM: Registered nosave memory: [mem 0xfffc0000-0xffffffff]
May 25 04:03:03 ubuntu kernel: [    0.000000] e820: [mem 0xc0000000-0xfeffbfff] available for PCI devices
May 25 04:03:03 ubuntu kernel: [    0.000000] Booting paravirtualized kernel on KVM
May 25 04:03:03 ubuntu kernel: [    0.000000] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645519600211568 ns
May 25 04:03:03 ubuntu kernel: [    0.000000] setup_percpu: NR_CPUS:8192 nr_cpumask_bits:4 nr_cpu_ids:4 nr_node_ids:1
May 25 04:03:03 ubuntu kernel: [    0.000000] percpu: Embedded 45 pages/cpu @ffff9fd7bfc00000 s146584 r8192 d29544 u524288
May 25 04:03:03 ubuntu systemd[1]: Started Create Static Device Nodes in /dev.
May 25 04:03:03 ubuntu systemd[1]: Starting udev Kernel Device Manager...
May 25 04:03:03 ubuntu systemd-modules-load[394]: Inserted module 'ib_iser'
May 25 04:03:03 ubuntu systemd[1]: Started Load Kernel Modules.
May 25 04:03:03 ubuntu systemd[1]: Mounting FUSE Control File System...
May 25 04:03:03 ubuntu systemd[1]: Starting Apply Kernel Variables...
May 25 04:03:03 ubuntu systemd[1]: Mounting Configuration File System...
May 25 04:03:03 ubuntu systemd[1]: Mounted FUSE Control File System.
May 25 04:03:03 ubuntu systemd[1]: Mounted Configuration File System.
May 25 04:03:03 ubuntu systemd[1]: Started Apply Kernel Variables.
May 25 04:03:03 ubuntu kernel: [    0.000000] pcpu-alloc: s146584 r8192 d29544 u524288 alloc=1*2097152
May 25 04:03:03 ubuntu systemd[1]: Started udev Kernel Device Manager.
May 25 04:03:03 ubuntu kernel: [    0.000000] pcpu-alloc: [0] 0 1 2 3 
May 25 04:03:03 ubuntu kernel: [    0.000000] KVM setup async PF for cpu 0
May 25 04:03:03 ubuntu systemd[1]: Started Dispatch Password Requests to Console Directory Watch.
May 25 04:03:03 ubuntu kernel: [    0.000000] kvm-stealtime: cpu 0, msr 33fc161c0
May 25 04:03:03 ubuntu systemd[1]: Found device /dev/ttyS0.
May 25 04:03:03 ubuntu kernel: [    0.000000] Built 1 zonelists in Node order, mobility grouping on.  Total pages: 3096421
May 25 04:03:03 ubuntu systemd[1]: Started Monitoring of LVM2 mirrors, snapshots etc. using dmeventd or progress polling.
May 25 04:03:03 ubuntu kernel: [    0.000000] Policy zone: Normal
May 25 04:03:03 ubuntu kernel: [    0.000000] Kernel command line: BOOT_IMAGE=/boot/vmlinuz-4.13.0-43-generic root=UUID=84ce5b56-30b1-4479-a864-7296bb549cec ro console=tty1 console=ttyS0
May 25 04:03:03 ubuntu kernel: [    0.000000] PID hash table entries: 4096 (order: 3, 32768 bytes)
May 25 04:03:03 ubuntu systemd[1]: Reached target Local File Systems (Pre).
May 25 04:03:03 ubuntu kernel: [    0.000000] Calgary: detecting Calgary via BIOS EBDA area
May 25 04:03:03 ubuntu kernel: [    0.000000] Calgary: Unable to locate Rio Grande table in EBDA - bailing!
May 25 04:03:03 ubuntu kernel: [    0.000000] Memory: 12244216K/12582376K available (12300K kernel code, 2481K rwdata, 4012K rodata, 2368K init, 2372K bss, 338160K reserved, 0K cma-reserved)
May 25 04:03:03 ubuntu systemd[1]: Reached target Local File Systems.
May 25 04:03:03 ubuntu systemd[1]: Starting Set console font and keymap...
May 25 04:03:03 ubuntu kernel: [    0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1
May 25 04:03:03 ubuntu systemd[1]: Starting Commit a transient machine-id on disk...
May 25 04:03:03 ubuntu kernel: [    0.000000] Kernel/User page tables isolation: enabled
May 25 04:03:03 ubuntu kernel: [    0.000000] ftrace: allocating 37873 entries in 148 pages
May 25 04:03:03 ubuntu systemd[1]: Starting Create Volatile Files and Directories...
May 25 04:03:03 ubuntu kernel: [    0.004000] Hierarchical RCU implementation.
May 25 04:03:03 ubuntu kernel: [    0.004000] 	RCU restricting CPUs from NR_CPUS=8192 to nr_cpu_ids=4.
May 25 04:03:03 ubuntu kernel: [    0.004000] 	Tasks RCU enabled.
May 25 04:03:03 ubuntu systemd[1]: Starting Tell Plymouth To Write Out Runtime Data...
May 25 04:03:03 ubuntu systemd[1]: Starting Initial cloud-init job (pre-networking)...
May 25 04:03:03 ubuntu kernel: [    0.004000] RCU: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4
May 25 04:03:03 ubuntu systemd-tmpfiles[478]: [/usr/lib/tmpfiles.d/var.conf:14] Duplicate line for path "/var/log", ignoring.
May 25 04:03:03 ubuntu kernel: [    0.004000] NR_IRQS: 524544, nr_irqs: 456, preallocated irqs: 16
May 25 04:03:03 ubuntu kernel: [    0.004000] Console: colour VGA+ 80x25
May 25 04:03:03 ubuntu systemd[1]: Starting LSB: AppArmor initialization...
May 25 04:03:03 ubuntu kernel: [    0.004000] console [tty1] enabled
May 25 04:03:03 ubuntu kernel: [    0.004000] console [ttyS0] enabled
May 25 04:03:03 ubuntu systemd[1]: Started Commit a transient machine-id on disk.
May 25 04:03:03 ubuntu kernel: [    0.004000] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns
May 25 04:03:03 ubuntu systemd[1]: Started Tell Plymouth To Write Out Runtime Data.
May 25 04:03:03 ubuntu kernel: [    0.004000] hpet clockevent registered
May 25 04:03:03 ubuntu rsyslogd-2222: command 'KLogPermitNonKernelFacility' is currently not permitted - did you already set it via a RainerScript command (v6+ config)? [v8.16.0 try http://www.rsyslog.com/e/2222 ]
May 25 04:03:03 ubuntu kernel: [    0.004005] tsc: Detected 3491.912 MHz processor
May 25 04:03:03 ubuntu kernel: [    0.004656] Calibrating delay loop (skipped) preset value.. 6983.82 BogoMIPS (lpj=13967648)
May 25 04:03:03 ubuntu kernel: [    0.005147] pid_max: default: 32768 minimum: 301
May 25 04:03:03 ubuntu kernel: [    0.005791] ACPI: Core revision 20170531
May 25 04:03:03 ubuntu systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.
May 25 04:03:03 ubuntu rsyslogd: rsyslogd's groupid changed to 108
May 25 04:03:03 ubuntu rsyslogd: rsyslogd's userid changed to 104
May 25 04:03:03 ubuntu kernel: [    0.006875] ACPI: 1 ACPI AML tables successfully acquired and loaded
May 25 04:03:03 ubuntu kernel: [    0.008020] Security Framework initialized
May 25 04:03:03 ubuntu systemd[1]: Started Create Volatile Files and Directories.
May 25 04:03:03 ubuntu kernel: [    0.008603] Yama: becoming mindful.
May 25 04:03:03 ubuntu systemd[1]: Starting Update UTMP about System Boot/Shutdown...
May 25 04:03:03 ubuntu kernel: [    0.009116] AppArmor: AppArmor initialized
May 25 04:03:03 ubuntu kernel: [    0.015527] Dentry cache hash table entries: 2097152 (order: 12, 16777216 bytes)
May 25 04:03:03 ubuntu kernel: [    0.018741] Inode-cache hash table entries: 1048576 (order: 11, 8388608 bytes)
May 25 04:03:03 ubuntu systemd[1]: Starting Network Time Synchronization...
May 25 04:03:03 ubuntu systemd[1]: Started Update UTMP about System Boot/Shutdown.
May 25 04:03:03 ubuntu kernel: [    0.020032] Mount-cache hash table entries: 32768 (order: 6, 262144 bytes)
May 25 04:03:03 ubuntu kernel: [    0.021007] Mountpoint-cache hash table entries: 32768 (order: 6, 262144 bytes)
May 25 04:03:03 ubuntu systemd[1]: Started Network Time Synchronization.
May 25 04:03:03 ubuntu kernel: [    0.022705] CPU: Physical Processor ID: 0
May 25 04:03:03 ubuntu kernel: [    0.023396] FEATURE SPEC_CTRL Not Present
May 25 04:03:03 ubuntu kernel: [    0.024004] mce: CPU supports 10 MCE banks
May 25 04:03:03 ubuntu systemd[1]: Reached target System Time Synchronized.
May 25 04:03:03 ubuntu kernel: [    0.024610] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0
May 25 04:03:03 ubuntu apparmor[482]:  * Starting AppArmor profiles
May 25 04:03:03 ubuntu apparmor[482]: Skipping profile in /etc/apparmor.d/disable: usr.sbin.rsyslogd
May 25 04:03:03 ubuntu kernel: [    0.025376] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0
May 25 04:03:03 ubuntu kernel: [    0.026188] Spectre V2 mitigation: Mitigation: Full generic retpoline
May 25 04:03:03 ubuntu apparmor[482]:    ...done.
May 25 04:03:03 ubuntu kernel: [    0.027061] Spectre V2 mitigation: Speculation control IBPB not-supported IBRS not-supported
May 25 04:03:03 ubuntu systemd[1]: Started LSB: AppArmor initialization.
May 25 04:03:03 ubuntu kernel: [    0.027062] Speculative Store Bypass: Vulnerable
May 25 04:03:03 ubuntu kernel: [    0.028773] Freeing SMP alternatives memory: 36K
May 25 04:03:03 ubuntu systemd[1]: Started Set console font and keymap.
May 25 04:03:03 ubuntu kernel: [    0.030544] smpboot: Max logical packages: 4
May 25 04:03:03 ubuntu systemd[1]: Created slice system-getty.slice.
May 25 04:03:03 ubuntu kernel: [    0.031279] x2apic enabled
May 25 04:03:03 ubuntu cloud-init[481]: Cloud-init v. 18.2 running 'init-local' at Fri, 25 May 2018 04:02:51 +0000. Up 7.23 seconds.
May 25 04:03:03 ubuntu kernel: [    0.032004] Switched APIC routing to physical x2apic.
May 25 04:03:03 ubuntu kernel: [    0.033328] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1
May 25 04:03:03 ubuntu kernel: [    0.036000] smpboot: CPU0: Intel QEMU Virtual CPU version 2.5+ (family: 0x6, model: 0x6, stepping: 0x3)
May 25 04:03:03 ubuntu systemd[1]: Started Initial cloud-init job (pre-networking).
May 25 04:03:03 ubuntu kernel: [    0.036000] Performance Events: PMU not available due to virtualization, using software events only.
May 25 04:03:03 ubuntu systemd[1]: Reached target Network (Pre).
May 25 04:03:03 ubuntu kernel: [    0.036000] Hierarchical SRCU implementation.
May 25 04:03:03 ubuntu systemd[1]: Starting Raise network interfaces...
May 25 04:03:03 ubuntu kernel: [    0.036377] smp: Bringing up secondary CPUs ...
May 25 04:03:03 ubuntu kernel: [    0.037179] x86: Booting SMP configuration:
May 25 04:03:03 ubuntu dhclient[850]: Internet Systems Consortium DHCP Client 4.3.3
May 25 04:03:03 ubuntu kernel: [    0.037859] .... node  #0, CPUs:      #1
May 25 04:03:03 ubuntu kernel: [    0.004000] kvm-clock: cpu 1, msr 3:3ff4d041, secondary cpu clock
May 25 04:03:03 ubuntu ifup[776]: Internet Systems Consortium DHCP Client 4.3.3
May 25 04:03:03 ubuntu kernel: [    0.044027] KVM setup async PF for cpu 1
May 25 04:03:03 ubuntu ifup[776]: Copyright 2004-2015 Internet Systems Consortium.
May 25 04:03:03 ubuntu kernel: [    0.045018] kvm-stealtime: cpu 1, msr 33fc961c0
May 25 04:03:03 ubuntu ifup[776]: All rights reserved.
May 25 04:03:03 ubuntu kernel: [    0.046111]  #2
May 25 04:03:03 ubuntu ifup[776]: For info, please visit https://www.isc.org/software/dhcp/
May 25 04:03:03 ubuntu kernel: [    0.004000] kvm-clock: cpu 2, msr 3:3ff4d081, secondary cpu clock
May 25 04:03:03 ubuntu kernel: [    0.052021] KVM setup async PF for cpu 2
May 25 04:03:03 ubuntu kernel: [    0.052841] kvm-stealtime: cpu 2, msr 33fd161c0
May 25 04:03:03 ubuntu kernel: [    0.053737]  #3
May 25 04:03:03 ubuntu dhclient[850]: Copyright 2004-2015 Internet Systems Consortium.
May 25 04:03:03 ubuntu dhclient[850]: All rights reserved.
May 25 04:03:03 ubuntu kernel: [    0.004000] kvm-clock: cpu 3, msr 3:3ff4d0c1, secondary cpu clock
May 25 04:03:03 ubuntu kernel: [    0.060041] KVM setup async PF for cpu 3
May 25 04:03:03 ubuntu kernel: [    0.061397] kvm-stealtime: cpu 3, msr 33fd961c0
May 25 04:03:03 ubuntu dhclient[850]: For info, please visit https://www.isc.org/software/dhcp/
May 25 04:03:03 ubuntu kernel: [    0.064004] smp: Brought up 1 node, 4 CPUs
May 25 04:03:03 ubuntu dhclient[850]: 
May 25 04:03:03 ubuntu kernel: [    0.065312] smpboot: Total of 4 processors activated (27935.29 BogoMIPS)
May 25 04:03:03 ubuntu dhclient[850]: Listening on LPF/ens2/ac:de:48:3f:ae:3f
May 25 04:03:03 ubuntu ifup[776]: Listening on LPF/ens2/ac:de:48:3f:ae:3f
May 25 04:03:03 ubuntu kernel: [    0.067159] devtmpfs: initialized
May 25 04:03:03 ubuntu ifup[776]: Sending on   LPF/ens2/ac:de:48:3f:ae:3f
May 25 04:03:03 ubuntu kernel: [    0.068048] x86/mm: Memory block size: 128MB
May 25 04:03:03 ubuntu kernel: [    0.069564] evm: security.selinux
May 25 04:03:03 ubuntu kernel: [    0.070192] evm: security.SMACK64
May 25 04:03:03 ubuntu kernel: [    0.070809] evm: security.SMACK64EXEC
May 25 04:03:03 ubuntu dhclient[850]: Sending on   LPF/ens2/ac:de:48:3f:ae:3f
May 25 04:03:03 ubuntu kernel: [    0.072002] evm: security.SMACK64TRANSMUTE
May 25 04:03:03 ubuntu ifup[776]: Sending on   Socket/fallback
May 25 04:03:03 ubuntu ifup[776]: DHCPDISCOVER on ens2 to 255.255.255.255 port 67 interval 3 (xid=0x32ffdd31)
May 25 04:03:03 ubuntu kernel: [    0.072800] evm: security.SMACK64MMAP
May 25 04:03:03 ubuntu dhclient[850]: Sending on   Socket/fallback
May 25 04:03:03 ubuntu kernel: [    0.073497] evm: security.ima
May 25 04:03:03 ubuntu kernel: [    0.074066] evm: security.capability
May 25 04:03:03 ubuntu kernel: [    0.074759] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns
May 25 04:03:03 ubuntu dhclient[850]: DHCPDISCOVER on ens2 to 255.255.255.255 port 67 interval 3 (xid=0x32ffdd31)
May 25 04:03:03 ubuntu kernel: [    0.076013] futex hash table entries: 1024 (order: 4, 65536 bytes)
May 25 04:03:03 ubuntu dhclient[850]: DHCPDISCOVER on ens2 to 255.255.255.255 port 67 interval 8 (xid=0x32ffdd31)
May 25 04:03:03 ubuntu kernel: [    0.077224] pinctrl core: initialized pinctrl subsystem
May 25 04:03:03 ubuntu ifup[776]: DHCPDISCOVER on ens2 to 255.255.255.255 port 67 interval 8 (xid=0x32ffdd31)
May 25 04:03:03 ubuntu kernel: [    0.078297] RTC time:  4:02:44, date: 05/25/18
May 25 04:03:03 ubuntu dhclient[850]: DHCPREQUEST of 192.168.11.25 on ens2 to 255.255.255.255 port 67 (xid=0x31ddff32)
May 25 04:03:03 ubuntu kernel: [    0.080012] NET: Registered protocol family 16
May 25 04:03:03 ubuntu kernel: [    0.081028] cpuidle: using governor ladder
May 25 04:03:03 ubuntu kernel: [    0.081028] cpuidle: using governor menu
May 25 04:03:03 ubuntu kernel: [    0.081520] PCCT header not found.
May 25 04:03:03 ubuntu kernel: [    0.082282] ACPI: bus type PCI registered
May 25 04:03:03 ubuntu ifup[776]: DHCPREQUEST of 192.168.11.25 on ens2 to 255.255.255.255 port 67 (xid=0x31ddff32)
May 25 04:03:03 ubuntu ifup[776]: DHCPOFFER of 192.168.11.25 from 192.168.11.3
May 25 04:03:03 ubuntu kernel: [    0.084003] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5
May 25 04:03:03 ubuntu dhclient[850]: DHCPOFFER of 192.168.11.25 from 192.168.11.3
May 25 04:03:03 ubuntu kernel: [    0.085288] PCI: Using configuration type 1 for base access
May 25 04:03:03 ubuntu dhclient[850]: DHCPACK of 192.168.11.25 from 192.168.11.3
May 25 04:03:03 ubuntu kernel: [    0.086302] HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages
May 25 04:03:03 ubuntu kernel: [    0.088068] ACPI: Added _OSI(Module Device)
May 25 04:03:03 ubuntu kernel: [    0.088885] ACPI: Added _OSI(Processor Device)
May 25 04:03:03 ubuntu ifup[776]: DHCPACK of 192.168.11.25 from 192.168.11.3
May 25 04:03:03 ubuntu systemd[1]: Stopping Network Time Synchronization...
May 25 04:03:03 ubuntu kernel: [    0.089669] ACPI: Added _OSI(3.0 _SCP Extensions)
May 25 04:03:03 ubuntu systemd[1]: Stopped Network Time Synchronization.
May 25 04:03:03 ubuntu kernel: [    0.090493] ACPI: Added _OSI(Processor Aggregator Device)
May 25 04:03:03 ubuntu kernel: [    0.093611] ACPI: Interpreter enabled
May 25 04:03:03 ubuntu kernel: [    0.094304] ACPI: (supports S0 S3 S4 S5)
May 25 04:03:03 ubuntu systemd[1]: Starting Network Time Synchronization...
May 25 04:03:03 ubuntu kernel: [    0.095009] ACPI: Using IOAPIC for interrupt routing
May 25 04:03:03 ubuntu kernel: [    0.096013] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug
May 25 04:03:03 ubuntu systemd[1]: Started Network Time Synchronization.
May 25 04:03:03 ubuntu kernel: [    0.097693] ACPI: Enabled 2 GPEs in block 00 to 0F
May 25 04:03:03 ubuntu dhclient[850]: bound to 192.168.11.25 -- renewal in 284 seconds.
May 25 04:03:03 ubuntu kernel: [    0.101156] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])
May 25 04:03:03 ubuntu kernel: [    0.102251] acpi PNP0A03:00: _OSC: OS supports [ASPM ClockPM Segments MSI]
May 25 04:03:03 ubuntu kernel: [    0.103434] acpi PNP0A03:00: _OSC failed (AE_NOT_FOUND); disabling ASPM
May 25 04:03:03 ubuntu ifup[776]: bound to 192.168.11.25 -- renewal in 284 seconds.
May 25 04:03:03 ubuntu kernel: [    0.104008] acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended PCI configuration space under this bridge.
May 25 04:03:03 ubuntu systemd[1]: Started Raise network interfaces.
May 25 04:03:03 ubuntu kernel: [    0.106136] acpiphp: Slot [2] registered
May 25 04:03:03 ubuntu systemd[1]: Starting Initial cloud-init job (metadata service crawler)...
May 25 04:03:03 ubuntu systemd[1]: Reached target Network.
May 25 04:03:03 ubuntu kernel: [    0.106862] acpiphp: Slot [3] registered
May 25 04:03:03 ubuntu kernel: [    0.108018] acpiphp: Slot [4] registered
May 25 04:03:03 ubuntu kernel: [    0.108759] acpiphp: Slot [5] registered
May 25 04:03:03 ubuntu systemd[1]: Time has been changed
May 25 04:03:03 ubuntu kernel: [    0.109481] acpiphp: Slot [6] registered
May 25 04:03:03 ubuntu kernel: [    0.110182] acpiphp: Slot [7] registered
May 25 04:03:03 ubuntu kernel: [    0.110881] acpiphp: Slot [8] registered
May 25 04:03:03 ubuntu systemd-timesyncd[894]: Synchronized to time server 91.189.89.198:123 (91.189.89.198).
May 25 04:03:03 ubuntu kernel: [    0.111587] acpiphp: Slot [9] registered
May 25 04:03:03 ubuntu kernel: [    0.112016] acpiphp: Slot [10] registered
May 25 04:03:03 ubuntu kernel: [    0.112761] acpiphp: Slot [11] registered
May 25 04:03:03 ubuntu kernel: [    0.113516] acpiphp: Slot [12] registered
May 25 04:03:03 ubuntu kernel: [    0.114241] acpiphp: Slot [13] registered
May 25 04:03:03 ubuntu kernel: [    0.114974] acpiphp: Slot [14] registered
May 25 04:03:03 ubuntu kernel: [    0.116016] acpiphp: Slot [15] registered
May 25 04:03:03 ubuntu kernel: [    0.116769] acpiphp: Slot [16] registered
May 25 04:03:03 ubuntu kernel: [    0.117534] acpiphp: Slot [17] registered
May 25 04:03:03 ubuntu kernel: [    0.118275] acpiphp: Slot [18] registered
May 25 04:03:03 ubuntu kernel: [    0.119021] acpiphp: Slot [19] registered
May 25 04:03:03 ubuntu kernel: [    0.120016] acpiphp: Slot [20] registered
May 25 04:03:03 ubuntu kernel: [    0.120785] acpiphp: Slot [21] registered
May 25 04:03:03 ubuntu kernel: [    0.121552] acpiphp: Slot [22] registered
May 25 04:03:03 ubuntu kernel: [    0.122296] acpiphp: Slot [23] registered
May 25 04:03:03 ubuntu kernel: [    0.123044] acpiphp: Slot [24] registered
May 25 04:03:03 ubuntu kernel: [    0.123787] acpiphp: Slot [25] registered
May 25 04:03:03 ubuntu kernel: [    0.124016] acpiphp: Slot [26] registered
May 25 04:03:03 ubuntu kernel: [    0.124792] acpiphp: Slot [27] registered
May 25 04:03:03 ubuntu kernel: [    0.125536] acpiphp: Slot [28] registered
May 25 04:03:03 ubuntu kernel: [    0.126283] acpiphp: Slot [29] registered
May 25 04:03:03 ubuntu kernel: [    0.127031] acpiphp: Slot [30] registered
May 25 04:03:03 ubuntu kernel: [    0.128018] acpiphp: Slot [31] registered
May 25 04:03:03 ubuntu kernel: [    0.128780] PCI host bridge to bus 0000:00
May 25 04:03:03 ubuntu kernel: [    0.129541] pci_bus 0000:00: root bus resource [io  0x0000-0x0cf7 window]
May 25 04:03:03 ubuntu kernel: [    0.130738] pci_bus 0000:00: root bus resource [io  0x0d00-0xffff window]
May 25 04:03:03 ubuntu cloud-init[966]: Cloud-init v. 18.2 running 'init' at Fri, 25 May 2018 04:02:58 +0000. Up 13.33 seconds.
May 25 04:03:03 ubuntu cloud-init[966]: ci-info: +++++++++++++++++++++++++++++++++++++++Net device info+++++++++++++++++++++++++++++++++++++++
May 25 04:03:03 ubuntu cloud-init[966]: ci-info: +--------+-------+------------------------------+---------------+-------+-------------------+
May 25 04:03:03 ubuntu cloud-init[966]: ci-info: | Device |   Up  |           Address            |      Mask     | Scope |     Hw-Address    |
May 25 04:03:03 ubuntu cloud-init[966]: ci-info: +--------+-------+------------------------------+---------------+-------+-------------------+
May 25 04:03:03 ubuntu cloud-init[966]: ci-info: |  ens2  |  True |        192.168.11.25         | 255.255.255.0 |   .   | ac:de:48:3f:ae:3f |
May 25 04:03:03 ubuntu cloud-init[966]: ci-info: |  ens2  |  True | fe80::aede:48ff:fe3f:ae3f/64 |       .       |  link | ac:de:48:3f:ae:3f |
May 25 04:03:03 ubuntu cloud-init[966]: ci-info: |  ens3  | False |              .               |       .       |   .   | ac:de:48:ef:90:96 |
May 25 04:03:03 ubuntu cloud-init[966]: ci-info: |   lo   |  True |          127.0.0.1           |   255.0.0.0   |   .   |         .         |
May 25 04:03:03 ubuntu cloud-init[966]: ci-info: |   lo   |  True |           ::1/128            |       .       |  host |         .         |
May 25 04:03:03 ubuntu cloud-init[966]: ci-info: +--------+-------+------------------------------+---------------+-------+-------------------+
May 25 04:03:03 ubuntu cloud-init[966]: ci-info: ++++++++++++++++++++++++++++++Route IPv4 info++++++++++++++++++++++++++++++
May 25 04:03:03 ubuntu cloud-init[966]: ci-info: +-------+--------------+--------------+---------------+-----------+-------+
May 25 04:03:03 ubuntu cloud-init[966]: ci-info: | Route | Destination  |   Gateway    |    Genmask    | Interface | Flags |
May 25 04:03:03 ubuntu cloud-init[966]: ci-info: +-------+--------------+--------------+---------------+-----------+-------+
May 25 04:03:03 ubuntu cloud-init[966]: ci-info: |   0   |   0.0.0.0    | 192.168.11.3 |    0.0.0.0    |    ens2   |   UG  |
May 25 04:03:03 ubuntu cloud-init[966]: ci-info: |   1   | 192.168.11.0 |   0.0.0.0    | 255.255.255.0 |    ens2   |   U   |
May 25 04:03:03 ubuntu cloud-init[966]: ci-info: +-------+--------------+--------------+---------------+-----------+-------+
May 25 04:03:03 ubuntu cloud-init[966]: Generating public/private rsa key pair.
May 25 04:03:03 ubuntu cloud-init[966]: Your identification has been saved in /etc/ssh/ssh_host_rsa_key.
May 25 04:03:03 ubuntu cloud-init[966]: Your public key has been saved in /etc/ssh/ssh_host_rsa_key.pub.
May 25 04:03:03 ubuntu cloud-init[966]: The key fingerprint is:
May 25 04:03:03 ubuntu cloud-init[966]: SHA256:1JxmHeYrE/1L1fakkxdEaLqkFzveQOH2sFz2KRJvh8c root@ubuntu
May 25 04:03:03 ubuntu cloud-init[966]: The key's randomart image is:
May 25 04:03:03 ubuntu cloud-init[966]: +---[RSA 2048]----+
May 25 04:03:03 ubuntu cloud-init[966]: |            o oo |
May 25 04:03:03 ubuntu cloud-init[966]: |         o B +. .|
May 25 04:03:03 ubuntu cloud-init[966]: |        . O B  .=|
May 25 04:03:03 ubuntu kernel: [    0.132003] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window]
May 25 04:03:03 ubuntu cloud-init[966]: |       . o @ = *o|
May 25 04:03:03 ubuntu kernel: [    0.133352] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window]
May 25 04:03:03 ubuntu kernel: [    0.134663] pci_bus 0000:00: root bus resource [bus 00-ff]
May 25 04:03:03 ubuntu cloud-init[966]: |        S O & X +|
May 25 04:03:03 ubuntu cloud-init[966]: |         . % B E |
May 25 04:03:03 ubuntu kernel: [    0.136003] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000
May 25 04:03:03 ubuntu cloud-init[966]: |          o * =  |
May 25 04:03:03 ubuntu kernel: [    0.136272] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100
May 25 04:03:03 ubuntu kernel: [    0.136588] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180
May 25 04:03:03 ubuntu cloud-init[966]: |           . .   |
May 25 04:03:03 ubuntu kernel: [    0.140501] pci 0000:00:01.1: reg 0x20: [io  0xc0e0-0xc0ef]
May 25 04:03:03 ubuntu kernel: [    0.142513] pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io  0x01f0-0x01f7]
May 25 04:03:03 ubuntu cloud-init[966]: |                 |
May 25 04:03:03 ubuntu kernel: [    0.144003] pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io  0x03f6]
May 25 04:03:03 ubuntu cloud-init[966]: +----[SHA256]-----+
May 25 04:03:03 ubuntu kernel: [    0.145144] pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io  0x0170-0x0177]
May 25 04:03:03 ubuntu cloud-init[966]: Generating public/private dsa key pair.
May 25 04:03:03 ubuntu kernel: [    0.146302] pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io  0x0376]
May 25 04:03:03 ubuntu cloud-init[966]: Your identification has been saved in /etc/ssh/ssh_host_dsa_key.
May 25 04:03:03 ubuntu kernel: [    0.148116] pci 0000:00:01.2: [8086:7020] type 00 class 0x0c0300
May 25 04:03:03 ubuntu cloud-init[966]: Your public key has been saved in /etc/ssh/ssh_host_dsa_key.pub.
May 25 04:03:03 ubuntu kernel: [    0.151630] pci 0000:00:01.2: reg 0x20: [io  0xc040-0xc05f]
May 25 04:03:03 ubuntu kernel: [    0.153304] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000
May 25 04:03:03 ubuntu cloud-init[966]: The key fingerprint is:
May 25 04:03:03 ubuntu kernel: [    0.153537] pci 0000:00:01.3: quirk: [io  0x0600-0x063f] claimed by PIIX4 ACPI
May 25 04:03:03 ubuntu cloud-init[966]: SHA256:Xn1RYaZ3HbCKJcX11uISIVoFhNa//zMEcHHfclLcDpc root@ubuntu
May 25 04:03:03 ubuntu kernel: [    0.154722] pci 0000:00:01.3: quirk: [io  0x0700-0x070f] claimed by PIIX4 SMB
May 25 04:03:03 ubuntu cloud-init[966]: The key's randomart image is:
May 25 04:03:03 ubuntu kernel: [    0.156181] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000
May 25 04:03:03 ubuntu kernel: [    0.159419] pci 0000:00:02.0: reg 0x10: [io  0xc060-0xc07f]
May 25 04:03:03 ubuntu kernel: [    0.160884] pci 0000:00:02.0: reg 0x14: [mem 0xfebc0000-0xfebc0fff]
May 25 04:03:03 ubuntu cloud-init[966]: +---[DSA 1024]----+
May 25 04:03:03 ubuntu kernel: [    0.168005] pci 0000:00:02.0: reg 0x20: [mem 0xfebec000-0xfebeffff 64bit pref]
May 25 04:03:03 ubuntu cloud-init[966]: |         +*+++oB*|
May 25 04:03:03 ubuntu kernel: [    0.172003] pci 0000:00:02.0: reg 0x30: [mem 0xfeb40000-0xfeb7ffff pref]
May 25 04:03:03 ubuntu kernel: [    0.172372] pci 0000:00:03.0: [1af4:1000] type 00 class 0x020000
May 25 04:03:03 ubuntu kernel: [    0.174383] pci 0000:00:03.0: reg 0x10: [io  0xc080-0xc09f]
May 25 04:03:03 ubuntu cloud-init[966]: |        ooo+ oOEX|
May 25 04:03:03 ubuntu kernel: [    0.176003] pci 0000:00:03.0: reg 0x14: [mem 0xfebc1000-0xfebc1fff]
May 25 04:03:03 ubuntu kernel: [    0.183255] pci 0000:00:03.0: reg 0x20: [mem 0xfebf0000-0xfebf3fff 64bit pref]
May 25 04:03:03 ubuntu kernel: [    0.184961] pci 0000:00:03.0: reg 0x30: [mem 0xfeb80000-0xfebbffff pref]
May 25 04:03:03 ubuntu cloud-init[966]: |       ... o+o=BB|
May 25 04:03:03 ubuntu cloud-init[966]: |          +.o+o*o|
May 25 04:03:03 ubuntu kernel: [    0.185334] pci 0000:00:04.0: [1af4:1001] type 00 class 0x010000
May 25 04:03:03 ubuntu kernel: [    0.188003] pci 0000:00:04.0: reg 0x10: [io  0xc000-0xc03f]
May 25 04:03:03 ubuntu cloud-init[966]: |        S...o.+  |
May 25 04:03:03 ubuntu kernel: [    0.189893] pci 0000:00:04.0: reg 0x14: [mem 0xfebc2000-0xfebc2fff]
May 25 04:03:03 ubuntu kernel: [    0.196937] pci 0000:00:04.0: reg 0x20: [mem 0xfebf4000-0xfebf7fff 64bit pref]
May 25 04:03:03 ubuntu kernel: [    0.199127] pci 0000:00:05.0: [1af4:1002] type 00 class 0x00ff00
May 25 04:03:03 ubuntu cloud-init[966]: |       . .  .o . |
May 25 04:03:03 ubuntu kernel: [    0.200693] pci 0000:00:05.0: reg 0x10: [io  0xc0a0-0xc0bf]
May 25 04:03:03 ubuntu cloud-init[966]: |        .    ..  |
May 25 04:03:03 ubuntu cloud-init[966]: |              .o |
May 25 04:03:03 ubuntu kernel: [    0.205967] pci 0000:00:05.0: reg 0x20: [mem 0xfebf8000-0xfebfbfff 64bit pref]
May 25 04:03:03 ubuntu kernel: [    0.209001] pci 0000:00:06.0: [1af4:1005] type 00 class 0x00ff00
May 25 04:03:03 ubuntu kernel: [    0.210305] pci 0000:00:06.0: reg 0x10: [io  0xc0c0-0xc0df]
May 25 04:03:03 ubuntu kernel: [    0.216003] pci 0000:00:06.0: reg 0x20: [mem 0xfebfc000-0xfebfffff 64bit pref]
May 25 04:03:03 ubuntu kernel: [    0.217953] ACPI: PCI Interrupt Link [LNKA] (IRQs 5 *10 11)
May 25 04:03:03 ubuntu cloud-init[966]: |               .+|
May 25 04:03:03 ubuntu kernel: [    0.220101] ACPI: PCI Interrupt Link [LNKB] (IRQs 5 *10 11)
May 25 04:03:03 ubuntu cloud-init[966]: +----[SHA256]-----+
May 25 04:03:03 ubuntu kernel: [    0.221044] ACPI: PCI Interrupt Link [LNKC] (IRQs 5 10 *11)
May 25 04:03:03 ubuntu cloud-init[966]: Generating public/private ecdsa key pair.
May 25 04:03:03 ubuntu kernel: [    0.222070] ACPI: PCI Interrupt Link [LNKD] (IRQs 5 10 *11)
May 25 04:03:03 ubuntu cloud-init[966]: Your identification has been saved in /etc/ssh/ssh_host_ecdsa_key.
May 25 04:03:03 ubuntu kernel: [    0.223124] ACPI: PCI Interrupt Link [LNKS] (IRQs *9)
May 25 04:03:03 ubuntu kernel: [    0.224425] SCSI subsystem initialized
May 25 04:03:03 ubuntu kernel: [    0.225225] libata version 3.00 loaded.
May 25 04:03:03 ubuntu cloud-init[966]: Your public key has been saved in /etc/ssh/ssh_host_ecdsa_key.pub.
May 25 04:03:03 ubuntu kernel: [    0.225225] vgaarb: loaded
May 25 04:03:03 ubuntu kernel: [    0.225225] ACPI: bus type USB registered
May 25 04:03:03 ubuntu cloud-init[966]: The key fingerprint is:
May 25 04:03:03 ubuntu kernel: [    0.225318] usbcore: registered new interface driver usbfs
May 25 04:03:03 ubuntu kernel: [    0.226347] usbcore: registered new interface driver hub
May 25 04:03:03 ubuntu kernel: [    0.228023] usbcore: registered new device driver usb
May 25 04:03:03 ubuntu cloud-init[966]: SHA256:7BqLs1ySUQph/pc9w5gk0s8qep/J9yG3eclSiFy1YSs root@ubuntu
May 25 04:03:03 ubuntu kernel: [    0.229042] EDAC MC: Ver: 3.0.0
May 25 04:03:03 ubuntu cloud-init[966]: The key's randomart image is:
May 25 04:03:03 ubuntu kernel: [    0.229042] PCI: Using ACPI for IRQ routing
May 25 04:03:03 ubuntu cloud-init[966]: +---[ECDSA 256]---+
May 25 04:03:03 ubuntu kernel: [    0.229042] PCI: pci_cache_line_size set to 64 bytes
May 25 04:03:03 ubuntu cloud-init[966]: |  o              |
May 25 04:03:03 ubuntu kernel: [    0.229042] e820: reserve RAM buffer [mem 0x0009fc00-0x0009ffff]
May 25 04:03:03 ubuntu kernel: [    0.229042] e820: reserve RAM buffer [mem 0xbffdc000-0xbfffffff]
May 25 04:03:03 ubuntu kernel: [    0.229042] NetLabel: Initializing
May 25 04:03:03 ubuntu cloud-init[966]: | o o      +      |
May 25 04:03:03 ubuntu kernel: [    0.232002] NetLabel:  domain hash size = 128
May 25 04:03:03 ubuntu cloud-init[966]: |  + o o  o +     |
May 25 04:03:03 ubuntu kernel: [    0.232838] NetLabel:  protocols = UNLABELED CIPSOv4 CALIPSO
May 25 04:03:03 ubuntu cloud-init[966]: |   + B BE o      |
May 25 04:03:03 ubuntu kernel: [    0.233881] NetLabel:  unlabeled traffic allowed by default
May 25 04:03:03 ubuntu kernel: [    0.234869] HPET: 3 timers in total, 0 timers will be used for per-cpu timer
May 25 04:03:03 ubuntu cloud-init[966]: |    +.BoSo       |
May 25 04:03:03 ubuntu kernel: [    0.236012] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0
May 25 04:03:03 ubuntu cloud-init[966]: |     =o..o.      |
May 25 04:03:03 ubuntu kernel: [    0.236882] hpet0: 3 comparators, 64-bit 100.000000 MHz counter
May 25 04:03:03 ubuntu kernel: [    0.244047] clocksource: Switched to clocksource kvm-clock
May 25 04:03:03 ubuntu cloud-init[966]: |  . + + +o .     |
May 25 04:03:03 ubuntu cloud-init[966]: | ..+.*.*.++      |
May 25 04:03:03 ubuntu rsyslogd-2039: Could not open output pipe '/dev/xconsole':: No such file or directory [v8.16.0 try http://www.rsyslog.com/e/2039 ]
May 25 04:03:03 ubuntu cloud-init[966]: |.. .O+o.+o       |
May 25 04:03:03 ubuntu kernel: [    0.253996] VFS: Disk quotas dquot_6.6.0
May 25 04:03:03 ubuntu kernel: [    0.254756] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)
May 25 04:03:03 ubuntu cloud-init[966]: +----[SHA256]-----+
May 25 04:03:03 ubuntu kernel: [    0.256043] AppArmor: AppArmor Filesystem Enabled
May 25 04:03:03 ubuntu kernel: [    0.256928] pnp: PnP ACPI init
May 25 04:03:03 ubuntu kernel: [    0.257561] pnp 00:00: Plug and Play ACPI device, IDs PNP0b00 (active)
May 25 04:03:03 ubuntu cloud-init[966]: Generating public/private ed25519 key pair.
May 25 04:03:03 ubuntu kernel: [    0.257586] pnp 00:01: Plug and Play ACPI device, IDs PNP0303 (active)
May 25 04:03:03 ubuntu cloud-init[966]: Your identification has been saved in /etc/ssh/ssh_host_ed25519_key.
May 25 04:03:03 ubuntu cloud-init[966]: Your public key has been saved in /etc/ssh/ssh_host_ed25519_key.pub.
May 25 04:03:03 ubuntu cloud-init[966]: The key fingerprint is:
May 25 04:03:03 ubuntu cloud-init[966]: SHA256:SxUblj++1enyiv3r2gfL3hRlnH4S9p7JslsJIzATkaM root@ubuntu
May 25 04:03:03 ubuntu kernel: [    0.257606] pnp 00:02: Plug and Play ACPI device, IDs PNP0f13 (active)
May 25 04:03:03 ubuntu cloud-init[966]: The key's randomart image is:
May 25 04:03:03 ubuntu kernel: [    0.257614] pnp 00:03: [dma 2]
May 25 04:03:03 ubuntu cloud-init[966]: +--[ED25519 256]--+
May 25 04:03:03 ubuntu kernel: [    0.257622] pnp 00:03: Plug and Play ACPI device, IDs PNP0700 (active)
May 25 04:03:03 ubuntu kernel: [    0.257679] pnp 00:04: Plug and Play ACPI device, IDs PNP0501 (active)
May 25 04:03:03 ubuntu cloud-init[966]: |         o*.     |
May 25 04:03:03 ubuntu kernel: [    0.257810] pnp: PnP ACPI: found 5 devices
May 25 04:03:03 ubuntu cloud-init[966]: |         +o+   ..|
May 25 04:03:03 ubuntu kernel: [    0.265837] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns
May 25 04:03:03 ubuntu cloud-init[966]: |        .++.  o.+|
May 25 04:03:03 ubuntu kernel: [    0.267331] pci_bus 0000:00: resource 4 [io  0x0000-0x0cf7 window]
May 25 04:03:03 ubuntu kernel: [    0.267332] pci_bus 0000:00: resource 5 [io  0x0d00-0xffff window]
May 25 04:03:03 ubuntu cloud-init[966]: |       E .+ o..+.|
May 25 04:03:03 ubuntu kernel: [    0.267334] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window]
May 25 04:03:03 ubuntu kernel: [    0.267335] pci_bus 0000:00: resource 7 [mem 0xc0000000-0xfebfffff window]
May 25 04:03:03 ubuntu cloud-init[966]: |        S  o +.++|
May 25 04:03:03 ubuntu kernel: [    0.267374] NET: Registered protocol family 2
May 25 04:03:03 ubuntu cloud-init[966]: |       . .  o *+B|
May 25 04:03:03 ubuntu cloud-init[966]: |        .    =.Oo|
May 25 04:03:03 ubuntu kernel: [    0.268303] TCP established hash table entries: 131072 (order: 8, 1048576 bytes)
May 25 04:03:03 ubuntu cloud-init[966]: |            +.B+.|
May 25 04:03:03 ubuntu kernel: [    0.270190] TCP bind hash table entries: 65536 (order: 8, 1048576 bytes)
May 25 04:03:03 ubuntu kernel: [    0.271399] TCP: Hash tables configured (established 131072 bind 65536)
May 25 04:03:03 ubuntu kernel: [    0.272582] UDP hash table entries: 8192 (order: 6, 262144 bytes)
May 25 04:03:03 ubuntu kernel: [    0.273665] UDP-Lite hash table entries: 8192 (order: 6, 262144 bytes)
May 25 04:03:03 ubuntu cloud-init[966]: |           . BX*+|
May 25 04:03:03 ubuntu kernel: [    0.274829] NET: Registered protocol family 1
May 25 04:03:03 ubuntu cloud-init[966]: +----[SHA256]-----+
May 25 04:03:03 ubuntu systemd[1]: Started Initial cloud-init job (metadata service crawler).
May 25 04:03:03 ubuntu kernel: [    0.275615] pci 0000:00:00.0: Limiting direct PCI/PCI transfers
May 25 04:03:03 ubuntu iscsid: iSCSI logger with pid=1095 started!
May 25 04:03:03 ubuntu kernel: [    0.276676] pci 0000:00:01.0: PIIX3: Enabling Passive Release
May 25 04:03:03 ubuntu kernel: [    0.277701] pci 0000:00:01.0: Activating ISA DMA hang workarounds
May 25 04:03:03 ubuntu systemd[1]: Reached target Cloud-config availability.
May 25 04:03:03 ubuntu kernel: [    0.296495] ACPI: PCI Interrupt Link [LNKD] enabled at IRQ 11
May 25 04:03:03 ubuntu cron[1115]: (CRON) INFO (pidfile fd = 3)
May 25 04:03:03 ubuntu kernel: [    0.315556] PCI: CLS 0 bytes, default 64
May 25 04:03:03 ubuntu kernel: [    0.315587] Unpacking initramfs...
May 25 04:03:03 ubuntu systemd[1]: Reached target Network is Online.
May 25 04:03:03 ubuntu kernel: [    0.826403] Freeing initrd memory: 48152K
May 25 04:03:03 ubuntu acpid: starting up with netlink and the input layer
May 25 04:03:03 ubuntu kernel: [    0.827131] PCI-DMA: Using software bounce buffering for IO (SWIOTLB)
May 25 04:03:03 ubuntu kernel: [    0.828110] software IO TLB [mem 0xbbfdc000-0xbffdc000] (64MB) mapped at [ffff9fd53bfdc000-ffff9fd53ffdbfff]
May 25 04:03:03 ubuntu kernel: [    0.829740] Scanning for low memory corruption every 60 seconds
May 25 04:03:03 ubuntu systemd[1]: Starting iSCSI initiator daemon (iscsid)...
May 25 04:03:03 ubuntu kernel: [    0.830982] audit: initializing netlink subsys (disabled)
May 25 04:03:03 ubuntu kernel: [    0.831952] audit: type=2000 audit(1527220965.768:1): state=initialized audit_enabled=0 res=1
May 25 04:03:03 ubuntu systemd[1]: Reached target System Initialization.
May 25 04:03:03 ubuntu systemd[1]: Listening on UUID daemon activation socket.
May 25 04:03:03 ubuntu kernel: [    0.832147] Initialise system trusted keyrings
May 25 04:03:03 ubuntu systemd[1]: Started ACPI Events Check.
May 25 04:03:03 ubuntu kernel: [    0.832155] Key type blacklist registered
May 25 04:03:03 ubuntu kernel: [    0.832234] workingset: timestamp_bits=36 max_order=22 bucket_order=0
May 25 04:03:03 ubuntu kernel: [    0.833135] zbud: loaded
May 25 04:03:03 ubuntu kernel: [    0.833532] squashfs: version 4.0 (2009/01/31) Phillip Lougher
May 25 04:03:03 ubuntu systemd[1]: Reached target Paths.
May 25 04:03:03 ubuntu systemd[1]: Starting Socket activation for snappy daemon.
May 25 04:03:03 ubuntu kernel: [    0.836047] fuse init (API version 7.26)
May 25 04:03:03 ubuntu kernel: [    0.837942] Key type asymmetric registered
May 25 04:03:03 ubuntu systemd[1]: Listening on ACPID Listen Socket.
May 25 04:03:03 ubuntu kernel: [    0.837943] Asymmetric key parser 'x509' registered
May 25 04:03:03 ubuntu kernel: [    0.837969] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 247)
May 25 04:03:03 ubuntu kernel: [    0.838000] io scheduler noop registered
May 25 04:03:03 ubuntu kernel: [    0.838001] io scheduler deadline registered
May 25 04:03:03 ubuntu systemd[1]: Listening on D-Bus System Message Bus Socket.
May 25 04:03:03 ubuntu systemd[1]: Starting LXD - unix socket.
May 25 04:03:03 ubuntu kernel: [    0.838027] io scheduler cfq registered (default)
May 25 04:03:03 ubuntu kernel: [    0.850489] intel_idle: does not run on family 6 model 6
May 25 04:03:03 ubuntu systemd[1]: Started Daily Cleanup of Temporary Directories.
May 25 04:03:03 ubuntu kernel: [    0.850540] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input0
May 25 04:03:03 ubuntu kernel: [    0.852043] ACPI: Power Button [PWRF]
May 25 04:03:03 ubuntu kernel: [    0.852939] GHES: HEST is not enabled!
May 25 04:03:03 ubuntu systemd[1]: Started Daily apt download activities.
May 25 04:03:03 ubuntu kernel: [    0.870741] ACPI: PCI Interrupt Link [LNKB] enabled at IRQ 10
May 25 04:03:03 ubuntu systemd[1]: Started Daily apt upgrade and clean activities.
May 25 04:03:03 ubuntu systemd[1]: Reached target Timers.
May 25 04:03:03 ubuntu kernel: [    0.889757] ACPI: PCI Interrupt Link [LNKC] enabled at IRQ 11
May 25 04:03:03 ubuntu rsyslogd-2007: action 'action 11' suspended, next retry is Fri May 25 04:03:33 2018 [v8.16.0 try http://www.rsyslog.com/e/2007 ]
May 25 04:03:03 ubuntu kernel: [    0.926081] ACPI: PCI Interrupt Link [LNKA] enabled at IRQ 10
May 25 04:03:03 ubuntu systemd[1]: Listening on Socket activation for snappy daemon.
May 25 04:03:03 ubuntu kernel: [    0.945968] Serial: 8250/16550 driver, 32 ports, IRQ sharing enabled
May 25 04:03:03 ubuntu kernel: [    0.969007] 00:04: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A
May 25 04:03:03 ubuntu kernel: [    0.971501] Linux agpgart interface v0.103
May 25 04:03:03 ubuntu systemd[1]: Listening on LXD - unix socket.
May 25 04:03:03 ubuntu kernel: [    0.974329] loop: module loaded
May 25 04:03:03 ubuntu systemd[1]: Reached target Sockets.
May 25 04:03:03 ubuntu systemd[1]: Reached target Basic System.
May 25 04:03:03 ubuntu systemd[1]: Started ACPI event daemon.
May 25 04:03:03 ubuntu systemd[1]: Starting /etc/rc.local Compatibility...
May 25 04:03:03 ubuntu systemd[1]: Starting The Salt Minion...
May 25 04:03:03 ubuntu systemd[1]: Starting Pollinate to seed the pseudo random number generator...
May 25 04:03:03 ubuntu kernel: [    0.974986] ata_piix 0000:00:01.1: version 2.13
May 25 04:03:03 ubuntu kernel: [    0.975769] scsi host0: ata_piix
May 25 04:03:03 ubuntu systemd[1]: Started Regular background program processing daemon.
May 25 04:03:03 ubuntu systemd[1]: Started Deferred execution scheduler.
May 25 04:03:03 ubuntu systemd[1]: Starting Thermal Daemon Service...
May 25 04:03:03 ubuntu systemd[1]: Starting Apply the settings specified in cloud-config...
May 25 04:03:03 ubuntu systemd[1]: Starting Login Service...
May 25 04:03:03 ubuntu systemd[1]: Starting System Logging Service...
May 25 04:03:03 ubuntu systemd[1]: Starting Accounts Service...
May 25 04:03:03 ubuntu systemd[1]: Started Unattended Upgrades Shutdown.
May 25 04:03:03 ubuntu systemd[1]: Starting LXD - container startup/shutdown...
May 25 04:03:03 ubuntu systemd[1]: Starting LSB: Record successful boot for GRUB...
May 25 04:03:03 ubuntu systemd[1]: Started FUSE filesystem for LXC.
May 25 04:03:03 ubuntu systemd[1]: Starting LSB: MD monitoring daemon...
May 25 04:03:03 ubuntu systemd[1]: Started D-Bus System Message Bus.
May 25 04:03:03 ubuntu acpid: 1 rule loaded
May 25 04:03:03 ubuntu acpid: waiting for events: event logging is off
May 25 04:03:03 ubuntu cron[1115]: (CRON) INFO (Running @reboot jobs)
May 25 04:03:03 ubuntu lxcfs[1143]: hierarchies:
May 25 04:03:03 ubuntu lxcfs[1143]:   0: fd:   5: hugetlb
May 25 04:03:03 ubuntu lxcfs[1143]:   1: fd:   6: devices
May 25 04:03:03 ubuntu lxcfs[1143]:   2: fd:   7: perf_event
May 25 04:03:03 ubuntu lxcfs[1143]:   3: fd:   8: memory
May 25 04:03:03 ubuntu lxcfs[1143]:   4: fd:   9: rdma
May 25 04:03:03 ubuntu lxcfs[1143]:   5: fd:  10: freezer
May 25 04:03:03 ubuntu lxcfs[1143]:   6: fd:  11: blkio
May 25 04:03:03 ubuntu lxcfs[1143]:   7: fd:  12: net_cls,net_prio
May 25 04:03:03 ubuntu lxcfs[1143]:   8: fd:  13: cpuset
May 25 04:03:03 ubuntu lxcfs[1143]:   9: fd:  14: pids
May 25 04:03:03 ubuntu lxcfs[1143]:  10: fd:  15: cpu,cpuacct
May 25 04:03:03 ubuntu lxcfs[1143]:  11: fd:  16: name=systemd
May 25 04:03:03 ubuntu kernel: [    0.976509] scsi host1: ata_piix
May 25 04:03:03 ubuntu kernel: [    0.977116] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc0e0 irq 14
May 25 04:03:03 ubuntu kernel: [    0.978249] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc0e8 irq 15
May 25 04:03:03 ubuntu kernel: [    0.979443] libphy: Fixed MDIO Bus: probed
May 25 04:03:03 ubuntu kernel: [    0.980458] tun: Universal TUN/TAP device driver, 1.6
May 25 04:03:03 ubuntu kernel: [    0.981512] PPP generic driver version 2.4.2
May 25 04:03:03 ubuntu kernel: [    0.982293] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver
May 25 04:03:03 ubuntu kernel: [    0.983398] ehci-pci: EHCI PCI platform driver
May 25 04:03:03 ubuntu kernel: [    0.984188] ehci-platform: EHCI generic platform driver
May 25 04:03:03 ubuntu kernel: [    0.985089] ohci_hcd: USB 1.1 'Open' Host Controller (OHCI) Driver
May 25 04:03:03 ubuntu kernel: [    0.986333] ohci-pci: OHCI PCI platform driver
May 25 04:03:03 ubuntu kernel: [    0.987151] ohci-platform: OHCI generic platform driver
May 25 04:03:03 ubuntu kernel: [    0.988121] uhci_hcd: USB Universal Host Controller Interface driver
May 25 04:03:03 ubuntu kernel: [    1.006990] uhci_hcd 0000:00:01.2: UHCI Host Controller
May 25 04:03:03 ubuntu kernel: [    1.007971] uhci_hcd 0000:00:01.2: new USB bus registered, assigned bus number 1
May 25 04:03:03 ubuntu kernel: [    1.009365] uhci_hcd 0000:00:01.2: detected 2 ports
May 25 04:03:03 ubuntu kernel: [    1.010296] uhci_hcd 0000:00:01.2: irq 11, io base 0x0000c040
May 25 04:03:03 ubuntu kernel: [    1.011351] usb usb1: New USB device found, idVendor=1d6b, idProduct=0001
May 25 04:03:03 ubuntu kernel: [    1.012596] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1
May 25 04:03:03 ubuntu kernel: [    1.013889] usb usb1: Product: UHCI Host Controller
May 25 04:03:03 ubuntu kernel: [    1.014748] usb usb1: Manufacturer: Linux 4.13.0-43-generic uhci_hcd
May 25 04:03:03 ubuntu kernel: [    1.015852] usb usb1: SerialNumber: 0000:00:01.2
May 25 04:03:03 ubuntu kernel: [    1.016911] hub 1-0:1.0: USB hub found
May 25 04:03:03 ubuntu kernel: [    1.017632] hub 1-0:1.0: 2 ports detected
May 25 04:03:03 ubuntu kernel: [    1.018424] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12
May 25 04:03:03 ubuntu kernel: [    1.020253] serio: i8042 KBD port at 0x60,0x64 irq 1
May 25 04:03:03 ubuntu kernel: [    1.021142] serio: i8042 AUX port at 0x60,0x64 irq 12
May 25 04:03:03 ubuntu kernel: [    1.022116] mousedev: PS/2 mouse device common for all mice
May 25 04:03:03 ubuntu kernel: [    1.023234] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input1
May 25 04:03:03 ubuntu kernel: [    1.024909] rtc_cmos 00:00: RTC can wake from S4
May 25 04:03:03 ubuntu kernel: [    1.025877] rtc_cmos 00:00: rtc core: registered rtc_cmos as rtc0
May 25 04:03:03 ubuntu kernel: [    1.027008] rtc_cmos 00:00: alarms up to one day, y3k, 114 bytes nvram, hpet irqs
May 25 04:03:03 ubuntu kernel: [    1.028287] i2c /dev entries driver
May 25 04:03:03 ubuntu kernel: [    1.028932] device-mapper: uevent: version 1.0.3
May 25 04:03:03 ubuntu kernel: [    1.029805] device-mapper: ioctl: 4.37.0-ioctl (2017-09-20) initialised: dm-devel@redhat.com
May 25 04:03:03 ubuntu kernel: [    1.031371] ledtrig-cpu: registered to indicate activity on CPUs
May 25 04:03:03 ubuntu kernel: [    1.032768] NET: Registered protocol family 10
May 25 04:03:03 ubuntu kernel: [    1.040758] Segment Routing with IPv6
May 25 04:03:03 ubuntu kernel: [    1.041446] NET: Registered protocol family 17
May 25 04:03:03 ubuntu kernel: [    1.042204] Key type dns_resolver registered
May 25 04:03:03 ubuntu kernel: [    1.043272] RAS: Correctable Errors collector initialized.
May 25 04:03:03 ubuntu kernel: [    1.044268] sched_clock: Marking stable (1044255566, 0)->(1442385554, -398129988)
May 25 04:03:03 ubuntu kernel: [    1.045849] registered taskstats version 1
May 25 04:03:03 ubuntu kernel: [    1.046593] Loading compiled-in X.509 certificates
May 25 04:03:03 ubuntu kernel: [    1.051095] Loaded X.509 cert 'Build time autogenerated kernel key: a287497b044864e8c1d63effe2112eb278f4c334'
May 25 04:03:03 ubuntu kernel: [    1.052790] zswap: loaded using pool lzo/zbud
May 25 04:03:03 ubuntu kernel: [    1.057975] Key type big_key registered
May 25 04:03:03 ubuntu kernel: [    1.058674] Key type trusted registered
May 25 04:03:03 ubuntu kernel: [    1.062277] Key type encrypted registered
May 25 04:03:03 ubuntu kernel: [    1.063007] AppArmor: AppArmor sha1 policy hashing enabled
May 25 04:03:03 ubuntu kernel: [    1.063911] ima: No TPM chip found, activating TPM-bypass! (rc=-19)
May 25 04:03:03 ubuntu kernel: [    1.064989] evm: HMAC attrs: 0x1
May 25 04:03:03 ubuntu kernel: [    1.065783]   Magic number: 2:256:10
May 25 04:03:03 ubuntu kernel: [    1.066512] memory memory54: hash matches
May 25 04:03:03 ubuntu kernel: [    1.067336] rtc_cmos 00:00: setting system clock to 2018-05-25 04:02:45 UTC (1527220965)
May 25 04:03:03 ubuntu kernel: [    1.068903] BIOS EDD facility v0.16 2004-Jun-25, 0 devices found
May 25 04:03:03 ubuntu kernel: [    1.070031] EDD information not available.
May 25 04:03:03 ubuntu kernel: [    1.070809] PM: Hibernation image not present or could not be loaded.
May 25 04:03:03 ubuntu kernel: [    1.143364] Freeing unused kernel memory: 2368K
May 25 04:03:03 ubuntu kernel: [    1.144706] Write protecting the kernel read-only data: 18432k
May 25 04:03:03 ubuntu kernel: [    1.147309] Freeing unused kernel memory: 2024K
May 25 04:03:03 ubuntu kernel: [    1.148913] Freeing unused kernel memory: 84K
May 25 04:03:03 ubuntu kernel: [    1.152380] x86/mm: Checked W+X mappings: passed, no W+X pages found.
May 25 04:03:03 ubuntu kernel: [    1.154199] x86/mm: Checking user space page tables
May 25 04:03:03 ubuntu kernel: [    1.157496] x86/mm: Checked W+X mappings: passed, no W+X pages found.
May 25 04:03:03 ubuntu kernel: [    1.263453] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input4
May 25 04:03:03 ubuntu kernel: [    1.267280] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input3
May 25 04:03:03 ubuntu kernel: [    1.276752]  vda: vda1
May 25 04:03:03 ubuntu kernel: [    1.292598] FDC 0 is a S82078B
May 25 04:03:03 ubuntu kernel: [    1.315389] virtio_net virtio0 ens2: renamed from eth0
May 25 04:03:03 ubuntu kernel: [    1.340445] virtio_net virtio1 ens3: renamed from eth1
May 25 04:03:03 ubuntu kernel: [    1.852160] tsc: Refined TSC clocksource calibration: 3491.913 MHz
May 25 04:03:03 ubuntu kernel: [    1.854657] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x3255790e5ea, max_idle_ns: 440795224414 ns
May 25 04:03:03 ubuntu kernel: [    2.604058] raid6: sse2x1   gen()  7217 MB/s
May 25 04:03:03 ubuntu kernel: [    2.652066] raid6: sse2x1   xor()  8046 MB/s
May 25 04:03:03 ubuntu kernel: [    2.700070] raid6: sse2x2   gen() 12841 MB/s
May 25 04:03:03 ubuntu kernel: [    2.748075] raid6: sse2x2   xor()  9163 MB/s
May 25 04:03:03 ubuntu kernel: [    2.796062] raid6: sse2x4   gen() 15478 MB/s
May 25 04:03:03 ubuntu kernel: [    2.844065] raid6: sse2x4   xor() 10762 MB/s
May 25 04:03:03 ubuntu kernel: [    2.844813] raid6: using algorithm sse2x4 gen() 15478 MB/s
May 25 04:03:03 ubuntu kernel: [    2.845749] raid6: .... xor() 10762 MB/s, rmw enabled
May 25 04:03:03 ubuntu kernel: [    2.846612] raid6: using intx1 recovery algorithm
May 25 04:03:03 ubuntu kernel: [    2.849807] xor: measuring software checksum speed
May 25 04:03:03 ubuntu kernel: [    2.888072]    prefetch64-sse:  9011.000 MB/sec
May 25 04:03:03 ubuntu kernel: [    2.928060]    generic_sse: 10293.000 MB/sec
May 25 04:03:03 ubuntu kernel: [    2.928922] xor: using function: generic_sse (10293.000 MB/sec)
May 25 04:03:03 ubuntu kernel: [    2.931450] async_tx: api initialized (async)
May 25 04:03:03 ubuntu kernel: [    2.991899] Btrfs loaded, crc32c=crc32c-generic
May 25 04:03:03 ubuntu kernel: [    3.059383] EXT4-fs (vda1): mounted filesystem with ordered data mode. Opts: (null)
May 25 04:03:03 ubuntu kernel: [    4.357130] EXT4-fs (vda1): re-mounted. Opts: (null)
May 25 04:03:03 ubuntu kernel: [    4.372193] Loading iSCSI transport class v2.0-870.
May 25 04:03:03 ubuntu kernel: [    4.416953] iscsi: registered transport (tcp)
May 25 04:03:03 ubuntu kernel: [    4.515216] iscsi: registered transport (iser)
May 25 04:03:03 ubuntu kernel: [    4.701884] piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 0
May 25 04:03:03 ubuntu kernel: [    4.702705] random: crng init done
May 25 04:03:03 ubuntu kernel: [    5.040790] ppdev: user-space parallel port driver
May 25 04:03:03 ubuntu kernel: [    6.038909] audit: type=1400 audit(1527220970.471:2): apparmor="STATUS" operation="profile_load" profile="unconfined" name="/usr/bin/lxc-start" pid=667 comm="apparmor_parser"
May 25 04:03:03 ubuntu kernel: [    6.164510] audit: type=1400 audit(1527220970.597:3): apparmor="STATUS" operation="profile_load" profile="unconfined" name="/usr/lib/lxd/lxd-bridge-proxy" pid=669 comm="apparmor_parser"
May 25 04:03:03 ubuntu kernel: [    6.244648] audit: type=1400 audit(1527220970.677:4): apparmor="STATUS" operation="profile_load" profile="unconfined" name="/usr/lib/snapd/snap-confine" pid=672 comm="apparmor_parser"
May 25 04:03:03 ubuntu kernel: [    6.244910] audit: type=1400 audit(1527220970.677:5): apparmor="STATUS" operation="profile_load" profile="unconfined" name="/usr/lib/snapd/snap-confine//mount-namespace-capture-helper" pid=672 comm="apparmor_parser"
May 25 04:03:03 ubuntu kernel: [    6.311199] audit: type=1400 audit(1527220970.743:6): apparmor="STATUS" operation="profile_load" profile="unconfined" name="/usr/sbin/tcpdump" pid=681 comm="apparmor_parser"
May 25 04:03:03 ubuntu kernel: [    6.315635] audit: type=1400 audit(1527220970.748:7): apparmor="STATUS" operation="profile_load" profile="unconfined" name="/sbin/dhclient" pid=670 comm="apparmor_parser"
May 25 04:03:03 ubuntu kernel: [    6.316935] audit: type=1400 audit(1527220970.749:8): apparmor="STATUS" operation="profile_load" profile="unconfined" name="/usr/lib/NetworkManager/nm-dhcp-client.action" pid=670 comm="apparmor_parser"
May 25 04:03:03 ubuntu kernel: [    6.318149] audit: type=1400 audit(1527220970.750:9): apparmor="STATUS" operation="profile_load" profile="unconfined" name="/usr/lib/NetworkManager/nm-dhcp-helper" pid=670 comm="apparmor_parser"
May 25 04:03:03 ubuntu kernel: [    6.319320] audit: type=1400 audit(1527220970.751:10): apparmor="STATUS" operation="profile_load" profile="unconfined" name="/usr/lib/connman/scripts/dhclient-script" pid=670 comm="apparmor_parser"
May 25 04:03:03 ubuntu kernel: [    6.336122] audit: type=1400 audit(1527220970.768:11): apparmor="STATUS" operation="profile_load" profile="unconfined" name="lxc-container-default" pid=668 comm="apparmor_parser"
May 25 04:03:03 ubuntu kernel: [   14.590119] EXT4-fs (vda1): resizing filesystem from 576000 to 12799739 blocks
May 25 04:03:03 ubuntu kernel: [   15.029066] EXT4-fs (vda1): resized filesystem to 12799739
May 25 04:03:03 ubuntu kernel: [   17.866273] new mount options do not match the existing superblock, will be ignored
May 25 04:03:03 ubuntu pollinate[1113]: client sent challenge to [https://entropy.ubuntu.com/]
May 25 04:03:03 ubuntu cloud-init[1130]: Generating locales (this might take a while)...
May 25 04:03:03 ubuntu dbus[1146]: [system] AppArmor D-Bus mediation is enabled
May 25 04:03:03 ubuntu systemd[1]: Starting Snappy daemon...
May 25 04:03:03 ubuntu systemd[1]: Started System Logging Service.
May 25 04:03:03 ubuntu systemd[1]: Started iSCSI initiator daemon (iscsid).
May 25 04:03:03 ubuntu systemd[1]: Started /etc/rc.local Compatibility.
May 25 04:03:03 ubuntu thermald[1126]: NO RAPL sysfs present
May 25 04:03:03 ubuntu thermald[1126]: 13 CPUID levels; family:model:stepping 0x6:6:3 (6:6:3)
May 25 04:03:03 ubuntu thermald[1126]:  Need Linux PowerCap sysfs
May 25 04:03:03 ubuntu systemd[1]: Started Thermal Daemon Service.
May 25 04:03:03 ubuntu mdadm[1144]:  * Starting MD monitoring service mdadm --monitor
May 25 04:03:03 ubuntu systemd[1]: Starting Login to default iSCSI targets...
May 25 04:03:03 ubuntu systemd[1]: Started Login Service.
May 25 04:03:03 ubuntu iscsid: iSCSI daemon with pid=1096 started!
May 25 04:03:03 ubuntu iscsiadm[1314]: iscsiadm: No records found
May 25 04:03:03 ubuntu dbus[1146]: [system] Activating via systemd: service name='org.freedesktop.PolicyKit1' unit='polkitd.service'
May 25 04:03:03 ubuntu mdadm[1144]:    ...done.
May 25 04:03:03 ubuntu systemd[1]: Started LSB: MD monitoring daemon.
May 25 04:03:03 ubuntu thermald[1126]: Unsupported cpu model, use thermal-conf.xml file or run with --ignore-cpuid-check
May 25 04:03:03 ubuntu thermald[1126]: THD engine start failed
May 25 04:03:03 ubuntu systemd[1]: Starting Authenticate and Authorize Users to Run Privileged Tasks...
May 25 04:03:04 ubuntu systemd[1]: Started Login to default iSCSI targets.
May 25 04:03:04 ubuntu systemd[1]: Reached target Remote File Systems (Pre).
May 25 04:03:04 ubuntu systemd[1]: Reached target Remote File Systems.
May 25 04:03:04 ubuntu systemd[1]: Starting LSB: Set the CPU Frequency Scaling governor to "ondemand"...
May 25 04:03:04 ubuntu systemd[1]: Starting Permit User Sessions...
May 25 04:03:04 ubuntu systemd[1]: Starting LSB: automatic crash report generation...
May 25 04:03:04 ubuntu systemd[1]: Starting LSB: daemon to balance interrupts for SMP systems...
May 25 04:03:04 ubuntu systemd[1]: Started LSB: Set the CPU Frequency Scaling governor to "ondemand".
May 25 04:03:04 ubuntu systemd[1]: Started Permit User Sessions.
May 25 04:03:04 ubuntu systemd[1]: Starting Terminate Plymouth Boot Screen...
May 25 04:03:04 ubuntu systemd[1]: Starting Hold until boot process finishes up...
May 25 04:03:04 ubuntu systemd[1]: Started Terminate Plymouth Boot Screen.
May 25 04:03:04 ubuntu systemd[1]: Started Hold until boot process finishes up.
May 25 04:03:04 ubuntu systemd[1]: Started Serial Getty on ttyS0.
May 25 04:03:04 ubuntu systemd[1]: Started Getty on tty1.
May 25 04:03:04 ubuntu systemd[1]: Reached target Login Prompts.
May 25 04:03:04 ubuntu irqbalance[1355]:  * Starting SMP IRQ Balancer: irqbalance
May 25 04:03:04 ubuntu systemd[1]: Starting Set console scheme...
May 25 04:03:04 ubuntu apport[1347]:  * Starting automatic crash report generation: apport
May 25 04:03:04 ubuntu systemd[1]: Started LSB: Record successful boot for GRUB.
May 25 04:03:04 ubuntu systemd[1]: Started Set console scheme.
May 25 04:03:04 ubuntu apport[1347]:    ...done.
May 25 04:03:04 ubuntu systemd[1]: Started LSB: automatic crash report generation.
May 25 04:03:04 ubuntu irqbalance[1355]:    ...done.
May 25 04:03:04 ubuntu systemd[1]: Started LSB: daemon to balance interrupts for SMP systems.
May 25 04:03:04 ubuntu polkitd[1329]: started daemon version 0.105 using authority implementation `local' version `0.105'
May 25 04:03:04 ubuntu dbus[1146]: [system] Successfully activated service 'org.freedesktop.PolicyKit1'
May 25 04:03:04 ubuntu systemd[1]: Started Authenticate and Authorize Users to Run Privileged Tasks.
May 25 04:03:04 ubuntu accounts-daemon[1136]: started daemon version 0.6.40
May 25 04:03:04 ubuntu systemd[1]: Started Accounts Service.
May 25 04:03:04 ubuntu systemd[1]: Started LXD - container startup/shutdown.
May 25 04:03:04 ubuntu snapd[1283]: AppArmor status: apparmor is enabled and all features are available
May 25 04:03:04 ubuntu snapd[1283]: 2018/05/25 04:03:04.664860 helpers.go:115: error trying to compare the snap system key: system-key missing on disk
May 25 04:03:04 ubuntu snapd[1283]: 2018/05/25 04:03:04.734195 daemon.go:323: started snapd/2.32.3.2 (series 16; classic) ubuntu/16.04 (amd64) linux/4.13.0-43-generic.
May 25 04:03:04 ubuntu systemd[1]: Started Snappy daemon.
May 25 04:03:04 ubuntu cloud-init[1130]:   en_US.UTF-8... done
May 25 04:03:04 ubuntu cloud-init[1130]: Generation complete.
May 25 04:03:05 ubuntu pollinate[1113]: client verified challenge/response with [https://entropy.ubuntu.com/]
May 25 04:03:05 ubuntu pollinate[1113]: client hashed response from [https://entropy.ubuntu.com/]
May 25 04:03:05 ubuntu pollinate[1113]: client successfully seeded [/dev/urandom]
May 25 04:03:05 ubuntu systemd[1]: Started Pollinate to seed the pseudo random number generator.
May 25 04:03:05 ubuntu systemd[1]: Starting OpenBSD Secure Shell server...
May 25 04:03:05 ubuntu systemd[1]: Started OpenBSD Secure Shell server.
May 25 04:03:05 ubuntu systemd[1]: Started The Salt Minion.
May 25 04:03:05 ubuntu systemd[1]: Reached target Multi-User System.
May 25 04:03:05 ubuntu systemd[1]: Reached target Graphical Interface.
May 25 04:03:05 ubuntu systemd[1]: Starting Update UTMP about System Runlevel Changes...
May 25 04:03:05 ubuntu systemd[1]: Started Update UTMP about System Runlevel Changes.
May 25 04:03:05 ubuntu cloud-init[1130]: Cloud-init v. 18.2 running 'modules:config' at Fri, 25 May 2018 04:03:03 +0000. Up 17.93 seconds.
May 25 04:03:05 ubuntu systemd[1]: Started Apply the settings specified in cloud-config.
May 25 04:03:05 ubuntu systemd[1]: Starting Execute cloud user/final scripts...
May 25 04:03:06 ubuntu ec2: 
May 25 04:03:06 ubuntu ec2: #############################################################
May 25 04:03:06 ubuntu ec2: -----BEGIN SSH HOST KEY FINGERPRINTS-----
May 25 04:03:06 ubuntu ec2: 1024 SHA256:Xn1RYaZ3HbCKJcX11uISIVoFhNa//zMEcHHfclLcDpc root@ubuntu (DSA)
May 25 04:03:06 ubuntu ec2: 256 SHA256:7BqLs1ySUQph/pc9w5gk0s8qep/J9yG3eclSiFy1YSs root@ubuntu (ECDSA)
May 25 04:03:06 ubuntu ec2: 256 SHA256:SxUblj++1enyiv3r2gfL3hRlnH4S9p7JslsJIzATkaM root@ubuntu (ED25519)
May 25 04:03:06 ubuntu ec2: 2048 SHA256:1JxmHeYrE/1L1fakkxdEaLqkFzveQOH2sFz2KRJvh8c root@ubuntu (RSA)
May 25 04:03:06 ubuntu ec2: -----END SSH HOST KEY FINGERPRINTS-----
May 25 04:03:06 ubuntu ec2: #############################################################
May 25 04:03:06 ubuntu cloud-init[1575]: Cloud-init v. 18.2 running 'modules:final' at Fri, 25 May 2018 04:03:06 +0000. Up 21.13 seconds.
May 25 04:03:06 ubuntu cloud-init[1575]: ci-info: no authorized ssh keys fingerprints found for user ubuntu.
May 25 04:03:06 ubuntu cloud-init[1575]: Cloud-init v. 18.2 finished at Fri, 25 May 2018 04:03:06 +0000. Datasource DataSourceNone.  Up 21.38 seconds
May 25 04:03:06 ubuntu cloud-init[1575]: 2018-05-25 04:03:06,577 - cc_final_message.py[WARNING]: Used fallback datasource
May 25 04:03:06 ubuntu systemd[1]: Started Execute cloud user/final scripts.
May 25 04:03:06 ubuntu systemd[1]: Reached target Cloud-init target.
May 25 04:03:06 ubuntu systemd[1]: Startup finished in 3.523s (kernel) + 17.965s (userspace) = 21.488s.
May 25 04:03:46 ubuntu salt-minion[1105]: [ERROR   ] Exception encountered when attempting to inspect frame in dependency decorator: list index out of range
May 25 04:03:47 ubuntu salt-minion[1105]: message repeated 12 times: [ [ERROR   ] Exception encountered when attempting to inspect frame in dependency decorator: list index out of range]
May 25 04:04:09 ubuntu systemd[1]: Started /usr/bin/apt-get -q -y -o DPkg::Options::=--force-confold -o DPkg::Options::=--force-confdef install python-oauth python-psutil python-m2crypto.
May 25 04:04:17 ubuntu systemd[1]: Started /usr/bin/apt-get -q -y -o DPkg::Options::=--force-confold -o DPkg::Options::=--force-confdef install python-keystoneclient.
May 25 04:05:11 ubuntu systemd[1]: Started /usr/bin/apt-get -q -y -o DPkg::Options::=--force-confold -o DPkg::Options::=--force-confdef install python-openstackclient.
May 25 04:05:32 ubuntu salt-minion[1105]: [ERROR   ] Command 'while true; do salt-call saltutil.running|grep fun: && continue; salt-call --local service.restart salt-minion; break; done' failed with return code: None
May 25 04:05:34 ubuntu salt-minion[1105]:       fun:
May 25 04:05:58 ubuntu salt-minion[1105]: message repeated 13 times: [       fun:]
May 25 04:06:00 ubuntu systemd[1]: Started /usr/bin/apt-get -q -y -o DPkg::Options::=--force-confold -o DPkg::Options::=--force-confdef install python-cryptography python-pymysql.
May 25 04:06:00 ubuntu salt-minion[1105]:       fun:
May 25 04:06:06 ubuntu salt-minion[1105]: message repeated 3 times: [       fun:]
May 25 04:06:06 ubuntu salt-minion[1105]: Traceback (most recent call last):
May 25 04:06:06 ubuntu salt-minion[1105]:   File "/usr/bin/salt-call", line 11, in <module>
May 25 04:06:06 ubuntu salt-minion[1105]:     salt_call()
May 25 04:06:06 ubuntu salt-minion[1105]:   File "/usr/lib/python2.7/dist-packages/salt/scripts.py", line 374, in salt_call
May 25 04:06:06 ubuntu salt-minion[1105]:     import salt.cli.call
May 25 04:06:06 ubuntu salt-minion[1105]:   File "/usr/lib/python2.7/dist-packages/salt/cli/call.py", line 9, in <module>
May 25 04:06:06 ubuntu salt-minion[1105]:     import salt.cli.caller
May 25 04:06:06 ubuntu salt-minion[1105]:   File "/usr/lib/python2.7/dist-packages/salt/cli/caller.py", line 19, in <module>
May 25 04:06:06 ubuntu salt-minion[1105]:     import salt.minion
May 25 04:06:06 ubuntu salt-minion[1105]:   File "/usr/lib/python2.7/dist-packages/salt/minion.py", line 90, in <module>
May 25 04:06:06 ubuntu salt-minion[1105]:     import salt.pillar
May 25 04:06:06 ubuntu salt-minion[1105]:   File "/usr/lib/python2.7/dist-packages/salt/pillar/__init__.py", line 16, in <module>
May 25 04:06:06 ubuntu salt-minion[1105]:     import salt.fileclient
May 25 04:06:06 ubuntu salt-minion[1105]:   File "/usr/lib/python2.7/dist-packages/salt/fileclient.py", line 32, in <module>
May 25 04:06:06 ubuntu salt-minion[1105]:     import salt.utils.http
May 25 04:06:06 ubuntu salt-minion[1105]:   File "/usr/lib/python2.7/dist-packages/salt/utils/http.py", line 70, in <module>
May 25 04:06:06 ubuntu salt-minion[1105]:     import requests
May 25 04:06:06 ubuntu salt-minion[1105]:   File "/usr/lib/python2.7/dist-packages/requests/__init__.py", line 53, in <module>
May 25 04:06:06 ubuntu salt-minion[1105]:     from .packages.urllib3.contrib import pyopenssl
May 25 04:06:06 ubuntu salt-minion[1105]:   File "/usr/lib/python2.7/dist-packages/urllib3/contrib/pyopenssl.py", line 54, in <module>
May 25 04:06:06 ubuntu salt-minion[1105]:     import OpenSSL.SSL
May 25 04:06:06 ubuntu salt-minion[1105]:   File "/usr/lib/python2.7/dist-packages/OpenSSL/__init__.py", line 8, in <module>
May 25 04:06:06 ubuntu salt-minion[1105]:     from OpenSSL import rand, crypto, SSL
May 25 04:06:06 ubuntu salt-minion[1105]:   File "/usr/lib/python2.7/dist-packages/OpenSSL/SSL.py", line 112, in <module>
May 25 04:06:06 ubuntu salt-minion[1105]:     if _lib.Cryptography_HAS_SSL_ST:
May 25 04:06:06 ubuntu salt-minion[1105]: AttributeError: 'module' object has no attribute 'Cryptography_HAS_SSL_ST'
May 25 04:06:07 ubuntu salt-minion[1105]: Traceback (most recent call last):
May 25 04:06:07 ubuntu salt-minion[1105]:   File "/usr/bin/salt-call", line 11, in <module>
May 25 04:06:07 ubuntu salt-minion[1105]:     salt_call()
May 25 04:06:07 ubuntu salt-minion[1105]:   File "/usr/lib/python2.7/dist-packages/salt/scripts.py", line 374, in salt_call
May 25 04:06:07 ubuntu salt-minion[1105]:     import salt.cli.call
May 25 04:06:07 ubuntu salt-minion[1105]:   File "/usr/lib/python2.7/dist-packages/salt/cli/call.py", line 9, in <module>
May 25 04:06:07 ubuntu salt-minion[1105]:     import salt.cli.caller
May 25 04:06:07 ubuntu salt-minion[1105]:   File "/usr/lib/python2.7/dist-packages/salt/cli/caller.py", line 19, in <module>
May 25 04:06:07 ubuntu salt-minion[1105]:     import salt.minion
May 25 04:06:07 ubuntu salt-minion[1105]:   File "/usr/lib/python2.7/dist-packages/salt/minion.py", line 90, in <module>
May 25 04:06:07 ubuntu salt-minion[1105]:     import salt.pillar
May 25 04:06:07 ubuntu salt-minion[1105]:   File "/usr/lib/python2.7/dist-packages/salt/pillar/__init__.py", line 16, in <module>
May 25 04:06:07 ubuntu salt-minion[1105]:     import salt.fileclient
May 25 04:06:07 ubuntu salt-minion[1105]:   File "/usr/lib/python2.7/dist-packages/salt/fileclient.py", line 32, in <module>
May 25 04:06:07 ubuntu salt-minion[1105]:     import salt.utils.http
May 25 04:06:07 ubuntu salt-minion[1105]:   File "/usr/lib/python2.7/dist-packages/salt/utils/http.py", line 70, in <module>
May 25 04:06:07 ubuntu salt-minion[1105]:     import requests
May 25 04:06:07 ubuntu salt-minion[1105]:   File "/usr/lib/python2.7/dist-packages/requests/__init__.py", line 53, in <module>
May 25 04:06:07 ubuntu salt-minion[1105]:     from .packages.urllib3.contrib import pyopenssl
May 25 04:06:07 ubuntu salt-minion[1105]:   File "/usr/lib/python2.7/dist-packages/urllib3/contrib/pyopenssl.py", line 54, in <module>
May 25 04:06:07 ubuntu salt-minion[1105]:     import OpenSSL.SSL
May 25 04:06:07 ubuntu salt-minion[1105]:   File "/usr/lib/python2.7/dist-packages/OpenSSL/__init__.py", line 8, in <module>
May 25 04:06:07 ubuntu salt-minion[1105]:     from OpenSSL import rand, crypto, SSL
May 25 04:06:07 ubuntu salt-minion[1105]:   File "/usr/lib/python2.7/dist-packages/OpenSSL/SSL.py", line 112, in <module>
May 25 04:06:07 ubuntu salt-minion[1105]:     if _lib.Cryptography_HAS_SSL_ST:
May 25 04:06:07 ubuntu salt-minion[1105]: AttributeError: 'module' object has no attribute 'Cryptography_HAS_SSL_ST'
May 25 04:06:13 ubuntu dbus[1146]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service'
May 25 04:06:13 ubuntu systemd[1]: Starting Time & Date Service...
May 25 04:06:13 ubuntu dbus[1146]: [system] Successfully activated service 'org.freedesktop.timedate1'
May 25 04:06:13 ubuntu systemd[1]: Started Time & Date Service.
May 25 04:06:13 ubuntu systemd-timedated[8960]: Changed time zone to 'UTC'.
May 25 04:06:14 ubuntu kernel: [  209.286880] nf_conntrack version 0.5.0 (65536 buckets, 262144 max)
May 25 04:06:14 ubuntu systemd[1]: proc-sys-fs-binfmt_misc.automount: Got automount request for /proc/sys/fs/binfmt_misc, triggered by 9016 (sysctl)
May 25 04:06:14 ubuntu systemd[1]: Mounting Arbitrary Executable File Formats File System...
May 25 04:06:14 ubuntu systemd[1]: Mounted Arbitrary Executable File Formats File System.
May 25 04:06:14 ubuntu kernel: [  209.433731] nr_pdflush_threads exported in /proc is scheduled for removal
May 25 04:06:17 ubuntu systemd[1]: Started /usr/bin/apt-get -q -y -o DPkg::Options::=--force-confold -o DPkg::Options::=--force-confdef install sysfsutils.
May 25 04:06:20 ubuntu systemd[1]: Reloading.
May 25 04:06:20 ubuntu systemd[1]: Started ACPI event daemon.
May 25 04:06:22 ubuntu systemd[1]: Reloading.
May 25 04:06:22 ubuntu systemd[1]: Started ACPI event daemon.
May 25 04:06:22 ubuntu systemd[1]: Reloading.
May 25 04:06:22 ubuntu systemd[1]: Started ACPI event daemon.
May 25 04:06:22 ubuntu systemd[1]: Starting LSB: Set sysfs variables from /etc/sysfs.conf...
May 25 04:06:22 ubuntu sysfsutils[9820]:  * Setting sysfs variables...
May 25 04:06:22 ubuntu sysfsutils[9820]:    ...done.
May 25 04:06:22 ubuntu systemd[1]: Started LSB: Set sysfs variables from /etc/sysfs.conf.
May 25 04:06:22 ubuntu systemd[1]: Reloading.
May 25 04:06:22 ubuntu systemd[1]: Started ACPI event daemon.
May 25 04:06:24 ubuntu systemd[1]: Started /bin/systemctl stop ondemand.service.
May 25 04:06:24 ubuntu systemd[1]: Stopping LSB: Set the CPU Frequency Scaling governor to "ondemand"...
May 25 04:06:24 ubuntu systemd[1]: Stopped LSB: Set the CPU Frequency Scaling governor to "ondemand".
May 25 04:06:24 ubuntu systemd[1]: Started /usr/sbin/update-rc.d -f ondemand remove.
May 25 04:06:24 ubuntu systemd[1]: Reloading.
May 25 04:06:24 ubuntu systemd[1]: Started ACPI event daemon.
May 25 04:06:25 ubuntu dbus[1146]: [system] Activating via systemd: service name='org.freedesktop.locale1' unit='dbus-org.freedesktop.locale1.service'
May 25 04:06:25 ubuntu systemd[1]: Starting Locale Service...
May 25 04:06:25 ubuntu dbus[1146]: [system] Successfully activated service 'org.freedesktop.locale1'
May 25 04:06:25 ubuntu systemd[1]: Started Locale Service.
May 25 04:06:26 ubuntu systemd[1]: Reloading.
May 25 04:06:26 ubuntu systemd[1]: Started ACPI event daemon.
May 25 04:06:27 ubuntu dhclient[10128]: Killed old client process
May 25 04:06:28 ubuntu dhclient[10128]: Internet Systems Consortium DHCP Client 4.3.3
May 25 04:06:28 ubuntu dhclient[10128]: Copyright 2004-2015 Internet Systems Consortium.
May 25 04:06:28 ubuntu dhclient[10128]: All rights reserved.
May 25 04:06:28 ubuntu dhclient[10128]: For info, please visit https://www.isc.org/software/dhcp/
May 25 04:06:28 ubuntu dhclient[10128]: 
May 25 04:06:28 ubuntu dhclient[10128]: Listening on LPF/ens2/ac:de:48:3f:ae:3f
May 25 04:06:28 ubuntu dhclient[10128]: Sending on   LPF/ens2/ac:de:48:3f:ae:3f
May 25 04:06:28 ubuntu dhclient[10128]: Sending on   Socket/fallback
May 25 04:06:28 ubuntu dhclient[10128]: DHCPRELEASE on ens2 to 192.168.11.3 port 67 (xid=0x2c9d850f)
May 25 04:06:28 ubuntu systemd[1]: Stopping Network Time Synchronization...
May 25 04:06:28 ubuntu systemd[1]: Stopped Network Time Synchronization.
May 25 04:06:28 ubuntu systemd[1]: Starting Network Time Synchronization...
May 25 04:06:28 ubuntu systemd[1]: Started Network Time Synchronization.
May 25 04:06:28 ubuntu dhclient[10173]: Internet Systems Consortium DHCP Client 4.3.3
May 25 04:06:28 ubuntu dhclient[10173]: Copyright 2004-2015 Internet Systems Consortium.
May 25 04:06:28 ubuntu dhclient[10173]: All rights reserved.
May 25 04:06:28 ubuntu dhclient[10173]: For info, please visit https://www.isc.org/software/dhcp/
May 25 04:06:28 ubuntu dhclient[10173]: 
May 25 04:06:28 ubuntu dhclient[10173]: Listening on LPF/ens2/ac:de:48:3f:ae:3f
May 25 04:06:28 ubuntu dhclient[10173]: Sending on   LPF/ens2/ac:de:48:3f:ae:3f
May 25 04:06:28 ubuntu dhclient[10173]: Sending on   Socket/fallback
May 25 04:06:28 ubuntu dhclient[10173]: DHCPDISCOVER on ens2 to 255.255.255.255 port 67 interval 3 (xid=0x94997f7c)
May 25 04:06:29 ubuntu dhclient[10173]: DHCPREQUEST of 192.168.11.25 on ens2 to 255.255.255.255 port 67 (xid=0x7c7f9994)
May 25 04:06:29 ubuntu dhclient[10173]: DHCPOFFER of 192.168.11.25 from 192.168.11.3
May 25 04:06:29 ubuntu dhclient[10173]: DHCPACK of 192.168.11.25 from 192.168.11.3
May 25 04:06:29 ubuntu systemd[1]: Stopping Network Time Synchronization...
May 25 04:06:29 ubuntu systemd[1]: Stopped Network Time Synchronization.
May 25 04:06:29 ubuntu systemd[1]: Starting Network Time Synchronization...
May 25 04:06:29 ubuntu systemd[1]: Started Network Time Synchronization.
May 25 04:06:29 ubuntu dhclient[10173]: bound to 192.168.11.25 -- renewal in 237 seconds.
May 25 04:06:29 ubuntu systemd[1]: Reloading OpenBSD Secure Shell server.
May 25 04:06:29 ubuntu systemd[1]: Reloaded OpenBSD Secure Shell server.
May 25 04:06:29 ubuntu systemd-timesyncd[10213]: Synchronized to time server 91.189.89.198:123 (91.189.89.198).
May 25 04:06:29 ubuntu systemd[1]: Reloading OpenBSD Secure Shell server.
May 25 04:06:29 ubuntu systemd[1]: Reloaded OpenBSD Secure Shell server.
May 25 04:06:30 ubuntu systemd[1]: Started /usr/bin/apt-get -q -y -o DPkg::Options::=--force-confold -o DPkg::Options::=--force-confdef install ntp.
May 25 04:06:32 ubuntu systemd[1]: Reloading.
May 25 04:06:33 ubuntu systemd[1]: Started ACPI event daemon.
May 25 04:06:35 ubuntu systemd[1]: Reloading.
May 25 04:06:35 ubuntu systemd[1]: Started ACPI event daemon.
May 25 04:06:35 ubuntu systemd[1]: Reloading.
May 25 04:06:35 ubuntu systemd[1]: Started ACPI event daemon.
May 25 04:06:35 ubuntu systemd[1]: Starting LSB: Start NTP daemon...
May 25 04:06:35 ubuntu ntp[11098]:  * Starting NTP server ntpd
May 25 04:06:35 ubuntu ntpd[11119]: ntpd 4.2.8p4@1.3265-o Wed Feb 14 14:56:29 UTC 2018 (1): Starting
May 25 04:06:35 ubuntu ntpd[11119]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 112:116
May 25 04:06:35 ubuntu ntp[11098]:    ...done.
May 25 04:06:35 ubuntu systemd[1]: Started LSB: Start NTP daemon.
May 25 04:06:35 ubuntu ntpd[11123]: proto: precision = 0.048 usec (-24)
May 25 04:06:35 ubuntu kernel: [  230.519238] kauditd_printk_skb: 3 callbacks suppressed
May 25 04:06:35 ubuntu kernel: [  230.519240] audit: type=1400 audit(1527221195.700:15): apparmor="STATUS" operation="profile_load" profile="unconfined" name="/usr/sbin/ntpd" pid=11132 comm="apparmor_parser"
May 25 04:06:35 ubuntu ntpd[11123]: Listen and drop on 0 v6wildcard [::]:123
May 25 04:06:35 ubuntu ntpd[11123]: Listen and drop on 1 v4wildcard 0.0.0.0:123
May 25 04:06:35 ubuntu ntpd[11123]: Listen normally on 2 lo 127.0.0.1:123
May 25 04:06:35 ubuntu ntpd[11123]: Listen normally on 3 ens2 192.168.11.25:123
May 25 04:06:35 ubuntu ntpd[11123]: Listen normally on 4 ens3 10.167.4.38:123
May 25 04:06:35 ubuntu ntpd[11123]: Listen normally on 5 lo [::1]:123
May 25 04:06:35 ubuntu ntpd[11123]: Listen normally on 6 ens2 [fe80::aede:48ff:fe3f:ae3f%2]:123
May 25 04:06:35 ubuntu ntpd[11123]: Listen normally on 7 ens3 [fe80::aede:48ff:feef:9096%3]:123
May 25 04:06:35 ubuntu ntpd[11123]: Listening on routing socket on fd #24 for interface updates
May 25 04:06:35 ubuntu systemd[1]: Reloading.
May 25 04:06:36 ubuntu systemd[1]: Started ACPI event daemon.
May 25 04:06:36 ubuntu ntpd[11123]: Soliciting pool server 45.79.1.70
May 25 04:06:37 ubuntu ntpd[11123]: Soliciting pool server 74.82.59.150
May 25 04:06:37 ubuntu ntpd[11123]: Soliciting pool server 107.191.112.226
May 25 04:06:37 ubuntu systemd[1]: Started /bin/systemctl restart ntp.service.
May 25 04:06:38 ubuntu systemd[1]: Stopping LSB: Start NTP daemon...
May 25 04:06:38 ubuntu ntp[11246]:  * Stopping NTP server ntpd
May 25 04:06:38 ubuntu ntpd[11123]: ntpd exiting on signal 15 (Terminated)
May 25 04:06:38 ubuntu ntpd[11123]: 45.79.1.70 local addr 192.168.11.25 -> <null>
May 25 04:06:38 ubuntu ntpd[11123]: 107.191.112.226 local addr 192.168.11.25 -> <null>
May 25 04:06:38 ubuntu ntpd[11123]: 74.82.59.150 local addr 192.168.11.25 -> <null>
May 25 04:06:38 ubuntu ntp[11246]:    ...done.
May 25 04:06:38 ubuntu systemd[1]: Stopped LSB: Start NTP daemon.
May 25 04:06:38 ubuntu systemd[1]: Starting LSB: Start NTP daemon...
May 25 04:06:38 ubuntu ntp[11257]:  * Starting NTP server ntpd
May 25 04:06:38 ubuntu ntpd[11274]: ntpd 4.2.8p4@1.3265-o Wed Feb 14 14:56:29 UTC 2018 (1): Starting
May 25 04:06:38 ubuntu ntpd[11274]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 112:116
May 25 04:06:38 ubuntu ntp[11257]:    ...done.
May 25 04:06:38 ubuntu systemd[1]: Started LSB: Start NTP daemon.
May 25 04:06:38 ubuntu ntpd[11279]: proto: precision = 0.049 usec (-24)
May 25 04:06:38 ubuntu ntpd[11279]: restrict 0.0.0.0: KOD does nothing without LIMITED.
May 25 04:06:38 ubuntu ntpd[11279]: restrict ::: KOD does nothing without LIMITED.
May 25 04:06:38 ubuntu ntpd[11279]: Listen and drop on 0 v6wildcard [::]:123
May 25 04:06:38 ubuntu ntpd[11279]: Listen and drop on 1 v4wildcard 0.0.0.0:123
May 25 04:06:38 ubuntu ntpd[11279]: Listen normally on 2 lo 127.0.0.1:123
May 25 04:06:38 ubuntu ntpd[11279]: Listen normally on 3 ens2 192.168.11.25:123
May 25 04:06:38 ubuntu ntpd[11279]: Listen normally on 4 ens3 10.167.4.38:123
May 25 04:06:38 ubuntu ntpd[11279]: Listen normally on 5 lo [::1]:123
May 25 04:06:38 ubuntu ntpd[11279]: Listen normally on 6 ens2 [fe80::aede:48ff:fe3f:ae3f%2]:123
May 25 04:06:38 ubuntu ntpd[11279]: Listen normally on 7 ens3 [fe80::aede:48ff:feef:9096%3]:123
May 25 04:06:38 ubuntu ntpd[11279]: Listening on routing socket on fd #24 for interface updates
May 25 04:07:22 ubuntu dbus[1146]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service'
May 25 04:07:22 ubuntu systemd[1]: Starting Time & Date Service...
May 25 04:07:22 ubuntu dbus[1146]: [system] Successfully activated service 'org.freedesktop.timedate1'
May 25 04:07:22 ubuntu systemd[1]: Started Time & Date Service.
May 25 04:07:23 ubuntu dbus[1146]: [system] Activating via systemd: service name='org.freedesktop.locale1' unit='dbus-org.freedesktop.locale1.service'
May 25 04:07:23 ubuntu systemd[1]: Starting Locale Service...
May 25 04:07:23 ubuntu dbus[1146]: [system] Successfully activated service 'org.freedesktop.locale1'
May 25 04:07:23 ubuntu systemd[1]: Started Locale Service.
May 25 04:08:07 ubuntu salt-minion[1105]: [WARNING ] Public Key hashing currently defaults to "md5". This will change to "sha256" in the Nitrogen release.
May 25 04:08:34 ubuntu systemd[1]: Started /usr/bin/apt-get -q -y -o DPkg::Options::=--force-confold -o DPkg::Options::=--force-confdef upgrade.
May 25 04:08:41 ubuntu systemd[1]: Reloading.
May 25 04:08:41 ubuntu systemd[1]: Started ACPI event daemon.
May 25 04:08:41 ubuntu systemd[1]: Reloading.
May 25 04:08:41 ubuntu systemd[1]: Started ACPI event daemon.
May 25 04:08:42 ubuntu systemd[1]: Reloading.
May 25 04:08:42 ubuntu systemd[1]: Started ACPI event daemon.
May 25 04:08:46 ubuntu dbus[1146]: [system] Reloaded configuration
May 25 04:08:46 ubuntu dbus[1146]: [system] Reloaded configuration
May 25 04:09:14 ubuntu systemd[1]: Reloading.
May 25 04:09:15 ubuntu systemd[1]: Started ACPI event daemon.
May 25 04:09:15 ubuntu dbus[1146]: [system] Reloaded configuration
May 25 04:09:16 ubuntu systemd[1]: Reloading.
May 25 04:09:16 ubuntu systemd[1]: Started ACPI event daemon.
May 25 04:09:17 ubuntu systemd[1]: Reloading.
May 25 04:09:17 ubuntu systemd[1]: Started ACPI event daemon.
May 25 04:09:18 ubuntu dbus[1146]: [system] Reloaded configuration
May 25 04:10:26 ubuntu dhclient[10234]: DHCPREQUEST of 192.168.11.25 on ens2 to 192.168.11.3 port 67 (xid=0x7c7f9994)
May 25 04:10:26 ubuntu dhclient[10234]: DHCPACK of 192.168.11.25 from 192.168.11.3
May 25 04:10:26 ubuntu systemd[1]: Stopping LSB: Start NTP daemon...
May 25 04:10:26 ubuntu ntp[14511]:  * Stopping NTP server ntpd
May 25 04:10:26 ubuntu ntpd[11279]: ntpd exiting on signal 15 (Terminated)
May 25 04:10:26 ubuntu ntp[14511]:    ...done.
May 25 04:10:26 ubuntu ntpd[11279]: 66.228.58.20 local addr 192.168.11.25 -> <null>
May 25 04:10:26 ubuntu ntpd[11279]: 171.66.97.126 local addr 192.168.11.25 -> <null>
May 25 04:10:26 ubuntu systemd[1]: Stopped LSB: Start NTP daemon.
May 25 04:10:26 ubuntu systemd[1]: Starting LSB: Start NTP daemon...
May 25 04:10:26 ubuntu ntp[14523]:  * Starting NTP server ntpd
May 25 04:10:26 ubuntu ntpd[14537]: ntpd 4.2.8p4@1.3265-o Wed Feb 14 14:56:29 UTC 2018 (1): Starting
May 25 04:10:26 ubuntu ntpd[14537]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -c /var/lib/ntp/ntp.conf.dhcp -u 112:116
May 25 04:10:26 ubuntu ntp[14523]:    ...done.
May 25 04:10:26 ubuntu systemd[1]: Started LSB: Start NTP daemon.
May 25 04:10:26 ubuntu dhclient[10234]: bound to 192.168.11.25 -- renewal in 301 seconds.
May 25 04:10:26 ubuntu ntpd[14540]: proto: precision = 0.048 usec (-24)
May 25 04:10:26 ubuntu ntpd[14540]: restrict 0.0.0.0: KOD does nothing without LIMITED.
May 25 04:10:26 ubuntu ntpd[14540]: restrict ::: KOD does nothing without LIMITED.
May 25 04:10:26 ubuntu ntpd[14540]: Listen and drop on 0 v6wildcard [::]:123
May 25 04:10:26 ubuntu ntpd[14540]: Listen and drop on 1 v4wildcard 0.0.0.0:123
May 25 04:10:26 ubuntu ntpd[14540]: Listen normally on 2 lo 127.0.0.1:123
May 25 04:10:26 ubuntu ntpd[14540]: Listen normally on 3 ens2 192.168.11.25:123
May 25 04:10:26 ubuntu ntpd[14540]: Listen normally on 4 ens3 10.167.4.38:123
May 25 04:10:26 ubuntu ntpd[14540]: Listen normally on 5 lo [::1]:123
May 25 04:10:26 ubuntu ntpd[14540]: Listen normally on 6 ens2 [fe80::aede:48ff:fe3f:ae3f%2]:123
May 25 04:10:26 ubuntu ntpd[14540]: Listen normally on 7 ens3 [fe80::aede:48ff:feef:9096%3]:123
May 25 04:10:26 ubuntu ntpd[14540]: Listening on routing socket on fd #24 for interface updates
May 25 04:15:27 ubuntu dhclient[10234]: DHCPREQUEST of 192.168.11.25 on ens2 to 192.168.11.3 port 67 (xid=0x7c7f9994)
May 25 04:15:27 ubuntu dhclient[10234]: DHCPACK of 192.168.11.25 from 192.168.11.3
May 25 04:15:27 ubuntu dhclient[10234]: bound to 192.168.11.25 -- renewal in 259 seconds.
May 25 04:17:01 ubuntu CRON[14567]: (root) CMD (   cd / && run-parts --report /etc/cron.hourly)
May 25 04:18:16 ubuntu systemd[1]: Starting Cleanup of Temporary Directories...
May 25 04:18:16 ubuntu systemd-tmpfiles[14570]: [/usr/lib/tmpfiles.d/var.conf:14] Duplicate line for path "/var/log", ignoring.
May 25 04:18:17 ubuntu systemd[1]: Started Cleanup of Temporary Directories.
May 25 04:19:22 ubuntu systemd[1]: Started /usr/bin/apt-get -q -y -o DPkg::Options::=--force-confold -o DPkg::Options::=--force-confdef install keepalived.
May 25 04:19:26 ubuntu systemd[1]: Reloading.
May 25 04:19:26 ubuntu systemd[1]: Started ACPI event daemon.
May 25 04:19:27 ubuntu systemd[1]: Reloading.
May 25 04:19:27 ubuntu systemd[1]: Started ACPI event daemon.
May 25 04:19:27 ubuntu systemd[1]: Reloading.
May 25 04:19:27 ubuntu systemd[1]: Started ACPI event daemon.
May 25 04:19:28 ubuntu systemd[1]: Reloading.
May 25 04:19:28 ubuntu systemd[1]: Started ACPI event daemon.
May 25 04:19:28 ubuntu systemd[1]: Reloading.
May 25 04:19:28 ubuntu systemd[1]: Started ACPI event daemon.
May 25 04:19:28 ubuntu systemd[1]: Reloading.
May 25 04:19:28 ubuntu systemd[1]: Started ACPI event daemon.
May 25 04:19:28 ubuntu systemd[1]: Starting LSB: ipvsadm daemon...
May 25 04:19:28 ubuntu ipvsadm[15844]:  * ipvsadm is not configured to run. Please edit /etc/default/ipvsadm
May 25 04:19:28 ubuntu systemd[1]: Started LSB: ipvsadm daemon.
May 25 04:19:28 ubuntu systemd[1]: Reloading.
May 25 04:19:29 ubuntu systemd[1]: Started ACPI event daemon.
May 25 04:19:31 ubuntu systemd[1]: Started /bin/systemctl start keepalived.service.
May 25 04:19:31 ubuntu systemd[1]: Starting Keepalive Daemon (LVS and VRRP)...
May 25 04:19:31 ubuntu Keepalived[15979]: Starting Keepalived v1.2.19 (03/13,2017)
May 25 04:19:31 ubuntu Keepalived[15986]: Starting Healthcheck child process, pid=15989
May 25 04:19:31 ubuntu Keepalived[15986]: Starting VRRP child process, pid=15990
May 25 04:19:31 ubuntu Keepalived_healthcheckers[15989]: Initializing ipvs 2.6
May 25 04:19:31 ubuntu Keepalived_vrrp[15990]: Registering Kernel netlink reflector
May 25 04:19:31 ubuntu systemd[1]: Started Keepalive Daemon (LVS and VRRP).
May 25 04:19:31 ubuntu Keepalived_vrrp[15990]: Registering Kernel netlink command channel
May 25 04:19:31 ubuntu Keepalived_vrrp[15990]: Registering gratuitous ARP shared channel
May 25 04:19:31 ubuntu Keepalived_vrrp[15990]: Opening file '/etc/keepalived/keepalived.conf'.
May 25 04:19:31 ubuntu Keepalived_vrrp[15990]: Configuration is using : 63556 Bytes
May 25 04:19:31 ubuntu Keepalived_vrrp[15990]: Using LinkWatch kernel netlink reflector...
May 25 04:19:31 ubuntu Keepalived_vrrp[15990]: VRRP_Instance(VIP) Entering BACKUP STATE
May 25 04:19:31 ubuntu Keepalived_healthcheckers[15989]: Registering Kernel netlink reflector
May 25 04:19:31 ubuntu kernel: [ 1006.385028] IPVS: Registered protocols (TCP, UDP, SCTP, AH, ESP)
May 25 04:19:31 ubuntu kernel: [ 1006.385096] IPVS: Connection hash table configured (size=4096, memory=64Kbytes)
May 25 04:19:31 ubuntu kernel: [ 1006.385851] IPVS: ipvs loaded.
May 25 04:19:31 ubuntu Keepalived_healthcheckers[15989]: Registering Kernel netlink command channel
May 25 04:19:31 ubuntu Keepalived_healthcheckers[15989]: Opening file '/etc/keepalived/keepalived.conf'.
May 25 04:19:31 ubuntu Keepalived_healthcheckers[15989]: Configuration is using : 8420 Bytes
May 25 04:19:31 ubuntu Keepalived_healthcheckers[15989]: Using LinkWatch kernel netlink reflector...
May 25 04:19:35 ubuntu Keepalived_vrrp[15990]: VRRP_Instance(VIP) Transition to MASTER STATE
May 25 04:19:36 ubuntu Keepalived_vrrp[15990]: VRRP_Instance(VIP) Entering MASTER STATE
May 25 04:19:37 ubuntu ntpd[14540]: Listen normally on 8 ens3 10.167.4.35:123
May 25 04:19:37 ubuntu ntpd[14540]: new interface(s) found: waking up resolver
May 25 04:19:46 ubuntu dhclient[10234]: DHCPREQUEST of 192.168.11.25 on ens2 to 192.168.11.3 port 67 (xid=0x7c7f9994)
May 25 04:19:46 ubuntu dhclient[10234]: DHCPACK of 192.168.11.25 from 192.168.11.3
May 25 04:19:46 ubuntu dhclient[10234]: bound to 192.168.11.25 -- renewal in 284 seconds.
May 25 04:24:30 ubuntu dhclient[10234]: DHCPREQUEST of 192.168.11.25 on ens2 to 192.168.11.3 port 67 (xid=0x7c7f9994)
May 25 04:24:30 ubuntu dhclient[10234]: DHCPACK of 192.168.11.25 from 192.168.11.3
May 25 04:24:30 ubuntu dhclient[10234]: bound to 192.168.11.25 -- renewal in 295 seconds.
May 25 04:29:26 ubuntu dhclient[10234]: DHCPREQUEST of 192.168.11.25 on ens2 to 192.168.11.3 port 67 (xid=0x7c7f9994)
May 25 04:29:26 ubuntu dhclient[10234]: DHCPACK of 192.168.11.25 from 192.168.11.3
May 25 04:29:26 ubuntu dhclient[10234]: bound to 192.168.11.25 -- renewal in 245 seconds.
May 25 04:30:08 ubuntu salt-minion[1105]: [WARNING ] /usr/lib/python2.7/dist-packages/salt/utils/templates.py:73: DeprecationWarning: Starting in 2015.5, cmd.run uses python_shell=False by default, which doesn't support shellisms (pipes, env variables, etc). cmd.run is currently aliased to cmd.shell to prevent breakage. Please switch to cmd.shell or set python_shell=True to avoid breakage in the future, when this aliasing is removed.
May 25 04:30:12 ubuntu systemd[1]: Started /usr/bin/apt-get -q -y -o DPkg::Options::=--force-confold -o DPkg::Options::=--force-confdef install glusterfs-client.
May 25 04:30:19 ubuntu systemd[1]: Started /bin/systemctl start var-lib-glance-images.mount.
May 25 04:30:19 ubuntu systemd[1]: Mounting GlusterFS File System (10.167.4.19:/glance)...
May 25 04:30:20 ubuntu systemd[1]: Mounted GlusterFS File System (10.167.4.19:/glance).
May 25 04:30:20 ubuntu systemd[1]: Started /bin/systemctl enable var-lib-glance-images.mount.
May 25 04:30:20 ubuntu systemd[1]: Reloading.
May 25 04:30:20 ubuntu systemd[1]: Started ACPI event daemon.
May 25 04:30:20 ubuntu systemd[1]: Started /bin/systemctl start var-lib-keystone-fernet\x2dkeys.mount.
May 25 04:30:20 ubuntu systemd[1]: Mounting GlusterFS File System (10.167.4.19:/keystone-keys)...
May 25 04:30:20 ubuntu systemd[1]: Mounted GlusterFS File System (10.167.4.19:/keystone-keys).
May 25 04:30:20 ubuntu systemd[1]: Started /bin/systemctl enable var-lib-keystone-fernet\x2dkeys.mount.
May 25 04:30:20 ubuntu systemd[1]: Reloading.
May 25 04:30:20 ubuntu systemd[1]: Started ACPI event daemon.
May 25 04:30:21 ubuntu systemd[1]: Started /bin/systemctl start var-lib-keystone-credential\x2dkeys.mount.
May 25 04:30:21 ubuntu systemd[1]: Mounting GlusterFS File System (10.167.4.19:/keystone-credential-keys)...
May 25 04:30:21 ubuntu systemd[1]: Mounted GlusterFS File System (10.167.4.19:/keystone-credential-keys).
May 25 04:30:21 ubuntu systemd[1]: Started /bin/systemctl enable var-lib-keystone-credential\x2dkeys.mount.
May 25 04:30:21 ubuntu systemd[1]: Reloading.
May 25 04:30:21 ubuntu systemd[1]: Started ACPI event daemon.
May 25 04:33:32 ubuntu dhclient[10234]: DHCPREQUEST of 192.168.11.25 on ens2 to 192.168.11.3 port 67 (xid=0x7c7f9994)
May 25 04:33:32 ubuntu dhclient[10234]: DHCPACK of 192.168.11.25 from 192.168.11.3
May 25 04:33:32 ubuntu dhclient[10234]: bound to 192.168.11.25 -- renewal in 236 seconds.
May 25 04:36:43 ubuntu systemd[1]: Started /usr/bin/apt-get -q -y -o DPkg::Options::=--force-confold -o DPkg::Options::=--force-confdef install memcached.
May 25 04:36:44 ubuntu systemd[1]: Reloading.
May 25 04:36:44 ubuntu systemd[1]: Started ACPI event daemon.
May 25 04:36:46 ubuntu systemd[1]: Reloading.
May 25 04:36:46 ubuntu systemd[1]: Started ACPI event daemon.
May 25 04:36:46 ubuntu systemd[1]: Reloading.
May 25 04:36:46 ubuntu systemd[1]: Started ACPI event daemon.
May 25 04:36:46 ubuntu systemd[1]: Reloading.
May 25 04:36:46 ubuntu systemd[1]: Started ACPI event daemon.
May 25 04:36:46 ubuntu systemd[1]: Started memcached daemon.
May 25 04:36:46 ubuntu systemd[1]: Reloading.
May 25 04:36:46 ubuntu systemd[1]: Started ACPI event daemon.
May 25 04:36:49 ubuntu systemd[1]: Started /usr/bin/apt-get -q -y -o DPkg::Options::=--force-confold -o DPkg::Options::=--force-confdef install python-memcache.
May 25 04:36:52 ubuntu systemd[1]: Started /bin/systemctl restart memcached.service.
May 25 04:36:52 ubuntu systemd[1]: Stopping memcached daemon...
May 25 04:36:52 ubuntu systemd-memcached-wrapper[18417]: Signal handled: Terminated.
May 25 04:36:52 ubuntu systemd[1]: Stopped memcached daemon.
May 25 04:36:52 ubuntu systemd[1]: Started memcached daemon.
May 25 04:37:08 ubuntu systemd[1]: Started /usr/bin/apt-get -q -y -o DPkg::Options::=--force-confold -o DPkg::Options::=--force-confdef install haproxy.
May 25 04:37:10 ubuntu systemd[1]: Reloading.
May 25 04:37:10 ubuntu systemd[1]: Started ACPI event daemon.
May 25 04:37:12 ubuntu systemd[1]: Reloading.
May 25 04:37:13 ubuntu systemd[1]: Started ACPI event daemon.
May 25 04:37:13 ubuntu systemd[1]: Reloading.
May 25 04:37:13 ubuntu systemd[1]: Started ACPI event daemon.
May 25 04:37:13 ubuntu systemd[1]: Reloading.
May 25 04:37:13 ubuntu systemd[1]: Started ACPI event daemon.
May 25 04:37:13 ubuntu systemd[1]: Starting HAProxy Load Balancer...
May 25 04:37:13 ubuntu systemd[1]: Started HAProxy Load Balancer.
May 25 04:37:13 ubuntu haproxy-systemd-wrapper[19506]: haproxy-systemd-wrapper: executing /usr/sbin/haproxy -f /etc/haproxy/haproxy.cfg -p /run/haproxy.pid -Ds
May 25 04:37:13 ubuntu systemd[1]: Reloading.
May 25 04:37:13 ubuntu systemd[1]: Started ACPI event daemon.
May 25 04:37:15 ubuntu systemd[1]: Started /usr/bin/apt-get -q -y -o DPkg::Options::=--force-confold -o DPkg::Options::=--force-confdef install socat.
May 25 04:37:19 ubuntu systemd[1]: Started /bin/systemctl restart haproxy.service.
May 25 04:37:19 ubuntu systemd[1]: Stopping HAProxy Load Balancer...
May 25 04:37:19 ubuntu haproxy-systemd-wrapper[19506]: haproxy-systemd-wrapper: SIGINT -> 19515
May 25 04:37:19 ubuntu haproxy-systemd-wrapper[19506]: haproxy-systemd-wrapper: exit, haproxy RC=0
May 25 04:37:19 ubuntu systemd[1]: Stopped HAProxy Load Balancer.
May 25 04:37:19 ubuntu systemd[1]: Starting HAProxy Load Balancer...
May 25 04:37:19 ubuntu systemd[1]: Started HAProxy Load Balancer.
May 25 04:37:19 ubuntu haproxy-systemd-wrapper[19923]: haproxy-systemd-wrapper: executing /usr/sbin/haproxy -f /etc/haproxy/haproxy.cfg -p /run/haproxy.pid -Ds
May 25 04:37:19 ubuntu haproxy[19925]: Proxy keystone_public_api started.
May 25 04:37:19 ubuntu haproxy[19925]: Proxy keystone_public_api started.
May 25 04:37:19 ubuntu haproxy[19925]: Proxy nova_api started.
May 25 04:37:19 ubuntu haproxy[19925]: Proxy nova_api started.
May 25 04:37:19 ubuntu haproxy[19925]: Proxy nova_placement_api started.
May 25 04:37:19 ubuntu haproxy[19925]: Proxy nova_placement_api started.
May 25 04:37:19 ubuntu haproxy[19925]: Proxy keystone_admin_api started.
May 25 04:37:19 ubuntu haproxy[19925]: Proxy keystone_admin_api started.
May 25 04:37:19 ubuntu haproxy[19925]: Proxy glance_registry_api started.
May 25 04:37:19 ubuntu haproxy[19925]: Proxy glance_registry_api started.
May 25 04:37:19 ubuntu haproxy[19925]: Proxy heat_cloudwatch_api started.
May 25 04:37:19 ubuntu haproxy[19925]: Proxy heat_cloudwatch_api started.
May 25 04:37:19 ubuntu haproxy[19925]: Proxy cinder_api started.
May 25 04:37:19 ubuntu haproxy[19925]: Proxy cinder_api started.
May 25 04:37:19 ubuntu haproxy[19925]: Proxy nova_novnc started.
May 25 04:37:19 ubuntu haproxy[19925]: Proxy nova_novnc started.
May 25 04:37:19 ubuntu haproxy[19925]: Proxy designate_api started.
May 25 04:37:19 ubuntu haproxy[19925]: Proxy designate_api started.
May 25 04:37:19 ubuntu haproxy[19925]: Proxy glance_api started.
May 25 04:37:19 ubuntu haproxy[19925]: Proxy glance_api started.
May 25 04:37:19 ubuntu haproxy[19925]: Proxy heat_api started.
May 25 04:37:19 ubuntu haproxy[19925]: Proxy heat_api started.
May 25 04:37:19 ubuntu haproxy[19925]: Proxy heat_cfn_api started.
May 25 04:37:19 ubuntu haproxy[19925]: Proxy heat_cfn_api started.
May 25 04:37:19 ubuntu haproxy[19925]: Proxy nova_metadata_api started.
May 25 04:37:19 ubuntu haproxy[19925]: Proxy nova_metadata_api started.
May 25 04:37:19 ubuntu haproxy[19925]: Proxy neutron_api started.
May 25 04:37:19 ubuntu haproxy[19925]: Proxy neutron_api started.
May 25 04:37:23 ubuntu systemd[1]: Started /bin/systemctl restart rsyslog.service.
May 25 04:37:23 ubuntu rsyslogd: [origin software="rsyslogd" swVersion="8.16.0" x-pid="1134" x-info="http://www.rsyslog.com"] exiting on signal 15.
May 25 04:37:23 ctl03 rsyslogd: [origin software="rsyslogd" swVersion="8.16.0" x-pid="19974" x-info="http://www.rsyslog.com"] start
May 25 04:37:23 ctl03 rsyslogd-2222: command 'KLogPermitNonKernelFacility' is currently not permitted - did you already set it via a RainerScript command (v6+ config)? [v8.16.0 try http://www.rsyslog.com/e/2222 ]
May 25 04:37:23 ctl03 rsyslogd-2307: warning: ~ action is deprecated, consider using the 'stop' statement instead [v8.16.0 try http://www.rsyslog.com/e/2307 ]
May 25 04:37:23 ctl03 rsyslogd: rsyslogd's groupid changed to 108
May 25 04:37:23 ctl03 rsyslogd: rsyslogd's userid changed to 104
May 25 04:37:23 ctl03 systemd[1]: Stopping System Logging Service...
May 25 04:37:23 ctl03 systemd[1]: Stopped System Logging Service.
May 25 04:37:23 ctl03 systemd[1]: Starting System Logging Service...
May 25 04:37:23 ctl03 systemd[1]: Started System Logging Service.
May 25 04:37:23 ctl03 rsyslogd-2039: Could not open output pipe '/dev/xconsole':: No such file or directory [v8.16.0 try http://www.rsyslog.com/e/2039 ]
May 25 04:37:23 ctl03 rsyslogd-2007: action 'action 13' suspended, next retry is Fri May 25 04:37:53 2018 [v8.16.0 try http://www.rsyslog.com/e/2007 ]
May 25 04:37:28 ctl03 dhclient[10234]: DHCPREQUEST of 192.168.11.25 on ens2 to 192.168.11.3 port 67 (xid=0x7c7f9994)
May 25 04:37:28 ctl03 dhclient[10234]: DHCPACK of 192.168.11.25 from 192.168.11.3
May 25 04:37:28 ctl03 dhclient[10234]: bound to 192.168.11.25 -- renewal in 286 seconds.
May 25 04:40:20 ctl03 systemd[1]: Started /usr/bin/apt-get -q -y -o DPkg::Options::=--force-confold -o DPkg::Options::=--force-confdef install keystone.
May 25 04:40:52 ctl03 systemd[1]: Reloading.
May 25 04:40:52 ctl03 systemd[1]: Started ACPI event daemon.
May 25 04:41:01 ctl03 systemd[1]: Reloading.
May 25 04:41:01 ctl03 systemd[1]: Started ACPI event daemon.
May 25 04:41:01 ctl03 systemd[1]: Reloading.
May 25 04:41:01 ctl03 systemd[1]: Started ACPI event daemon.
May 25 04:41:01 ctl03 systemd[1]: Reloading.
May 25 04:41:01 ctl03 systemd[1]: Started ACPI event daemon.
May 25 04:41:01 ctl03 systemd[1]: Starting LSB: Apache2 web server...
May 25 04:41:01 ctl03 apache2[22256]:  * Starting Apache httpd web server apache2
May 25 04:41:03 ctl03 apache2[22256]:  *
May 25 04:41:03 ctl03 systemd[1]: Started LSB: Apache2 web server.
May 25 04:41:05 ctl03 libapache2-mod-wsgi: apache2_invoke: Enable module wsgi
May 25 04:41:05 ctl03 systemd[1]: Reloading.
May 25 04:41:05 ctl03 systemd[1]: Started ACPI event daemon.
May 25 04:41:05 ctl03 systemd[1]: Stopping LSB: Apache2 web server...
May 25 04:41:05 ctl03 apache2[22463]:  * Stopping Apache httpd web server apache2
May 25 04:41:06 ctl03 apache2[22463]:  *
May 25 04:41:06 ctl03 systemd[1]: Stopped LSB: Apache2 web server.
May 25 04:41:06 ctl03 systemd[1]: Starting LSB: Apache2 web server...
May 25 04:41:06 ctl03 apache2[22486]:  * Starting Apache httpd web server apache2
May 25 04:41:07 ctl03 apache2[22486]:  *
May 25 04:41:07 ctl03 systemd[1]: Started LSB: Apache2 web server.
May 25 04:41:30 ctl03 keystone: apache2_invoke: Enable site keystone.conf
May 25 04:41:30 ctl03 systemd[1]: Reloading.
May 25 04:41:30 ctl03 systemd[1]: Started ACPI event daemon.
May 25 04:41:30 ctl03 systemd[1]: Reloading LSB: Apache2 web server.
May 25 04:41:30 ctl03 apache2[23200]:  * Reloading Apache httpd web server apache2
May 25 04:41:30 ctl03 apache2[23200]:  *
May 25 04:41:30 ctl03 systemd[1]: Reloaded LSB: Apache2 web server.
May 25 04:41:30 ctl03 systemd[1]: Reloading.
May 25 04:41:30 ctl03 systemd[1]: Started ACPI event daemon.
May 25 04:41:33 ctl03 systemd[1]: Started /usr/bin/apt-get -q -y -o DPkg::Options::=--force-confold -o DPkg::Options::=--force-confdef install python-psycopg2.
May 25 04:41:38 ctl03 systemd[1]: Started /usr/bin/apt-get -q -y -o DPkg::Options::=--force-confold -o DPkg::Options::=--force-confdef install python-mysqldb.
May 25 04:41:43 ctl03 systemd[1]: Started /usr/bin/apt-get -q -y -o DPkg::Options::=--force-confold -o DPkg::Options::=--force-confdef install mysql-client.
May 25 04:41:51 ctl03 salt-minion[1105]: [WARNING ] State for file: /etc/keystone/policy.json - Neither 'source' nor 'contents' nor 'contents_pillar' nor 'contents_grains' was defined, yet 'replace' was set to 'True'. As there is no source to replace the file with, 'replace' has been set to 'False' to avoid reading the file unnecessarily.
May 25 04:41:52 ctl03 systemd[1]: Started /bin/systemctl reload apache2.service.
May 25 04:41:52 ctl03 systemd[1]: Reloading LSB: Apache2 web server.
May 25 04:41:52 ctl03 apache2[24427]:  * Reloading Apache httpd web server apache2
May 25 04:41:52 ctl03 apache2[24427]:  *
May 25 04:41:52 ctl03 systemd[1]: Reloaded LSB: Apache2 web server.
May 25 04:42:14 ctl03 dhclient[10234]: DHCPREQUEST of 192.168.11.25 on ens2 to 192.168.11.3 port 67 (xid=0x7c7f9994)
May 25 04:42:14 ctl03 dhclient[10234]: DHCPACK of 192.168.11.25 from 192.168.11.3
May 25 04:42:14 ctl03 dhclient[10234]: bound to 192.168.11.25 -- renewal in 301 seconds.
May 25 04:43:42 ctl03 systemd[1]: Started /bin/systemctl restart apache2.service.
May 25 04:43:42 ctl03 systemd[1]: Stopping LSB: Apache2 web server...
May 25 04:43:42 ctl03 apache2[24736]:  * Stopping Apache httpd web server apache2
May 25 04:43:43 ctl03 apache2[24736]:  *
May 25 04:43:43 ctl03 systemd[1]: Stopped LSB: Apache2 web server.
May 25 04:43:43 ctl03 systemd[1]: Starting LSB: Apache2 web server...
May 25 04:43:43 ctl03 apache2[24768]:  * Starting Apache httpd web server apache2
May 25 04:43:45 ctl03 apache2[24768]:  *
May 25 04:43:45 ctl03 systemd[1]: Started LSB: Apache2 web server.
May 25 04:43:59 ctl03 salt-minion[1105]: [WARNING ] State for file: /etc/keystone/policy.json - Neither 'source' nor 'contents' nor 'contents_pillar' nor 'contents_grains' was defined, yet 'replace' was set to 'True'. As there is no source to replace the file with, 'replace' has been set to 'False' to avoid reading the file unnecessarily.
May 25 04:45:35 ctl03 systemd[1]: Started /usr/bin/apt-get -q -y -o DPkg::Options::=--force-confold -o DPkg::Options::=--force-confdef install glance.
May 25 04:45:46 ctl03 systemd[1]: Reloading.
May 25 04:45:47 ctl03 systemd[1]: Started ACPI event daemon.
May 25 04:45:55 ctl03 systemd[1]: Reloading.
May 25 04:45:55 ctl03 systemd[1]: Started ACPI event daemon.
May 25 04:45:55 ctl03 systemd[1]: Reloading.
May 25 04:45:55 ctl03 systemd[1]: Started ACPI event daemon.
May 25 04:45:55 ctl03 systemd[1]: Reloading.
May 25 04:45:56 ctl03 systemd[1]: Started ACPI event daemon.
May 25 04:45:56 ctl03 systemd[1]: Starting OpenStack Image Service API...
May 25 04:45:56 ctl03 systemd[1]: Started OpenStack Image Service API.
May 25 04:45:56 ctl03 systemd[1]: Reloading.
May 25 04:45:56 ctl03 systemd[1]: Started ACPI event daemon.
May 25 04:45:56 ctl03 systemd[1]: Reloading.
May 25 04:45:56 ctl03 systemd[1]: Started ACPI event daemon.
May 25 04:45:56 ctl03 systemd[1]: Reloading.
May 25 04:45:57 ctl03 systemd[1]: Started ACPI event daemon.
May 25 04:45:57 ctl03 systemd[1]: Starting OpenStack Image Service Registry...
May 25 04:45:57 ctl03 systemd[1]: Started OpenStack Image Service Registry.
May 25 04:45:57 ctl03 glance-api[26328]: /usr/lib/python2.7/dist-packages/paste/deploy/loadwsgi.py:22: DeprecationWarning: Parameters to load are deprecated.  Call .resolve and .require separately.
May 25 04:45:57 ctl03 glance-api[26328]:   return pkg_resources.EntryPoint.parse("x=" + s).load(False)
May 25 04:45:57 ctl03 glance-api[26328]: /usr/lib/python2.7/dist-packages/paste/deploy/loadwsgi.py:22: DeprecationWarning: Parameters to load are deprecated.  Call .resolve and .require separately.
May 25 04:45:57 ctl03 glance-api[26328]:   return pkg_resources.EntryPoint.parse("x=" + s).load(False)
May 25 04:45:57 ctl03 glance-api[26328]: /usr/lib/python2.7/dist-packages/paste/deploy/loadwsgi.py:22: DeprecationWarning: Parameters to load are deprecated.  Call .resolve and .require separately.
May 25 04:45:57 ctl03 glance-api[26328]:   return pkg_resources.EntryPoint.parse("x=" + s).load(False)
May 25 04:45:57 ctl03 glance-api[26328]: /usr/lib/python2.7/dist-packages/paste/deploy/loadwsgi.py:22: DeprecationWarning: Parameters to load are deprecated.  Call .resolve and .require separately.
May 25 04:45:57 ctl03 glance-api[26328]:   return pkg_resources.EntryPoint.parse("x=" + s).load(False)
May 25 04:45:57 ctl03 glance-api[26328]: /usr/lib/python2.7/dist-packages/paste/deploy/loadwsgi.py:22: DeprecationWarning: Parameters to load are deprecated.  Call .resolve and .require separately.
May 25 04:45:57 ctl03 glance-api[26328]:   return pkg_resources.EntryPoint.parse("x=" + s).load(False)
May 25 04:45:57 ctl03 glance-api[26328]: /usr/lib/python2.7/dist-packages/paste/deploy/loadwsgi.py:22: DeprecationWarning: Parameters to load are deprecated.  Call .resolve and .require separately.
May 25 04:45:57 ctl03 glance-api[26328]:   return pkg_resources.EntryPoint.parse("x=" + s).load(False)
May 25 04:45:57 ctl03 glance-api[26328]: /usr/lib/python2.7/dist-packages/paste/deploy/loadwsgi.py:22: DeprecationWarning: Parameters to load are deprecated.  Call .resolve and .require separately.
May 25 04:45:57 ctl03 glance-api[26328]:   return pkg_resources.EntryPoint.parse("x=" + s).load(False)
May 25 04:45:57 ctl03 glance-api[26328]: /usr/lib/python2.7/dist-packages/paste/deploy/loadwsgi.py:22: DeprecationWarning: Parameters to load are deprecated.  Call .resolve and .require separately.
May 25 04:45:57 ctl03 glance-api[26328]:   return pkg_resources.EntryPoint.parse("x=" + s).load(False)
May 25 04:45:57 ctl03 systemd[1]: Reloading.
May 25 04:45:57 ctl03 systemd[1]: Started ACPI event daemon.
May 25 04:45:57 ctl03 glance-api[26328]: /usr/lib/python2.7/dist-packages/paste/deploy/loadwsgi.py:22: DeprecationWarning: Parameters to load are deprecated.  Call .resolve and .require separately.
May 25 04:45:57 ctl03 glance-api[26328]:   return pkg_resources.EntryPoint.parse("x=" + s).load(False)
May 25 04:45:57 ctl03 glance-api[26328]: /usr/lib/python2.7/dist-packages/paste/deploy/loadwsgi.py:22: DeprecationWarning: Parameters to load are deprecated.  Call .resolve and .require separately.
May 25 04:45:57 ctl03 glance-api[26328]:   return pkg_resources.EntryPoint.parse("x=" + s).load(False)
May 25 04:45:57 ctl03 glance-api[26328]: /usr/lib/python2.7/dist-packages/paste/deploy/util.py:55: DeprecationWarning: Using function/method 'Healthcheck.factory()' is deprecated: The healthcheck middleware must now be configured as an application, not as a filter
May 25 04:45:57 ctl03 glance-api[26328]:   val = callable(*args, **kw)
May 25 04:45:57 ctl03 glance-api[26328]: /usr/lib/python2.7/dist-packages/oslo_middleware/cors.py:136: DeprecationWarning: Method 'CORS.set_latent()' has moved to 'CORS.set_defaults()': CORS.set_latent has been deprecated in favor of oslo_middleware.cors.set_defaults
May 25 04:45:57 ctl03 glance-api[26328]:   allow_methods=sanitize(self.conf.get('latent_allow_methods'))
May 25 04:45:58 ctl03 glance-registry[26453]: /usr/lib/python2.7/dist-packages/paste/deploy/loadwsgi.py:22: DeprecationWarning: Parameters to load are deprecated.  Call .resolve and .require separately.
May 25 04:45:58 ctl03 glance-registry[26453]:   return pkg_resources.EntryPoint.parse("x=" + s).load(False)
May 25 04:45:58 ctl03 glance-registry[26453]: /usr/lib/python2.7/dist-packages/paste/deploy/loadwsgi.py:22: DeprecationWarning: Parameters to load are deprecated.  Call .resolve and .require separately.
May 25 04:45:58 ctl03 glance-registry[26453]:   return pkg_resources.EntryPoint.parse("x=" + s).load(False)
May 25 04:45:58 ctl03 glance-registry[26453]: /usr/lib/python2.7/dist-packages/paste/deploy/loadwsgi.py:22: DeprecationWarning: Parameters to load are deprecated.  Call .resolve and .require separately.
May 25 04:45:58 ctl03 glance-registry[26453]:   return pkg_resources.EntryPoint.parse("x=" + s).load(False)
May 25 04:45:58 ctl03 glance-registry[26453]: /usr/lib/python2.7/dist-packages/paste/deploy/loadwsgi.py:22: DeprecationWarning: Parameters to load are deprecated.  Call .resolve and .require separately.
May 25 04:45:58 ctl03 glance-registry[26453]:   return pkg_resources.EntryPoint.parse("x=" + s).load(False)
May 25 04:45:58 ctl03 glance-registry[26453]: /usr/lib/python2.7/dist-packages/paste/deploy/util.py:55: DeprecationWarning: Using function/method 'Healthcheck.factory()' is deprecated: The healthcheck middleware must now be configured as an application, not as a filter
May 25 04:45:58 ctl03 glance-registry[26453]:   val = callable(*args, **kw)
May 25 04:46:00 ctl03 systemd[1]: Started /bin/systemctl restart glance-api.service.
May 25 04:46:00 ctl03 systemd[1]: Stopping OpenStack Image Service API...
May 25 04:46:00 ctl03 systemd[1]: Stopped OpenStack Image Service API.
May 25 04:46:00 ctl03 systemd[1]: Starting OpenStack Image Service API...
May 25 04:46:00 ctl03 systemd[1]: Started OpenStack Image Service API.
May 25 04:46:01 ctl03 systemd[1]: Started /bin/systemctl restart glance-registry.service.
May 25 04:46:01 ctl03 systemd[1]: Stopping OpenStack Image Service Registry...
May 25 04:46:01 ctl03 systemd[1]: Stopped OpenStack Image Service Registry.
May 25 04:46:01 ctl03 systemd[1]: Starting OpenStack Image Service Registry...
May 25 04:46:01 ctl03 systemd[1]: Started OpenStack Image Service Registry.
May 25 04:46:02 ctl03 glance-api[26613]: /usr/lib/python2.7/dist-packages/paste/deploy/loadwsgi.py:22: DeprecationWarning: Parameters to load are deprecated.  Call .resolve and .require separately.
May 25 04:46:02 ctl03 glance-api[26613]:   return pkg_resources.EntryPoint.parse("x=" + s).load(False)
May 25 04:46:02 ctl03 glance-api[26613]: /usr/lib/python2.7/dist-packages/paste/deploy/loadwsgi.py:22: DeprecationWarning: Parameters to load are deprecated.  Call .resolve and .require separately.
May 25 04:46:02 ctl03 glance-api[26613]:   return pkg_resources.EntryPoint.parse("x=" + s).load(False)
May 25 04:46:02 ctl03 glance-api[26613]: /usr/lib/python2.7/dist-packages/paste/deploy/loadwsgi.py:22: DeprecationWarning: Parameters to load are deprecated.  Call .resolve and .require separately.
May 25 04:46:02 ctl03 glance-api[26613]:   return pkg_resources.EntryPoint.parse("x=" + s).load(False)
May 25 04:46:02 ctl03 glance-api[26613]: /usr/lib/python2.7/dist-packages/paste/deploy/loadwsgi.py:22: DeprecationWarning: Parameters to load are deprecated.  Call .resolve and .require separately.
May 25 04:46:02 ctl03 glance-api[26613]:   return pkg_resources.EntryPoint.parse("x=" + s).load(False)
May 25 04:46:02 ctl03 glance-api[26613]: /usr/lib/python2.7/dist-packages/paste/deploy/loadwsgi.py:22: DeprecationWarning: Parameters to load are deprecated.  Call .resolve and .require separately.
May 25 04:46:02 ctl03 glance-api[26613]:   return pkg_resources.EntryPoint.parse("x=" + s).load(False)
May 25 04:46:02 ctl03 glance-api[26613]: /usr/lib/python2.7/dist-packages/paste/deploy/loadwsgi.py:22: DeprecationWarning: Parameters to load are deprecated.  Call .resolve and .require separately.
May 25 04:46:02 ctl03 glance-api[26613]:   return pkg_resources.EntryPoint.parse("x=" + s).load(False)
May 25 04:46:02 ctl03 glance-api[26613]: /usr/lib/python2.7/dist-packages/paste/deploy/loadwsgi.py:22: DeprecationWarning: Parameters to load are deprecated.  Call .resolve and .require separately.
May 25 04:46:02 ctl03 glance-api[26613]:   return pkg_resources.EntryPoint.parse("x=" + s).load(False)
May 25 04:46:02 ctl03 glance-api[26613]: /usr/lib/python2.7/dist-packages/paste/deploy/loadwsgi.py:22: DeprecationWarning: Parameters to load are deprecated.  Call .resolve and .require separately.
May 25 04:46:02 ctl03 glance-api[26613]:   return pkg_resources.EntryPoint.parse("x=" + s).load(False)
May 25 04:46:02 ctl03 glance-api[26613]: /usr/lib/python2.7/dist-packages/paste/deploy/loadwsgi.py:22: DeprecationWarning: Parameters to load are deprecated.  Call .resolve and .require separately.
May 25 04:46:02 ctl03 glance-api[26613]:   return pkg_resources.EntryPoint.parse("x=" + s).load(False)
May 25 04:46:02 ctl03 glance-registry[26671]: /usr/lib/python2.7/dist-packages/paste/deploy/loadwsgi.py:22: DeprecationWarning: Parameters to load are deprecated.  Call .resolve and .require separately.
May 25 04:46:02 ctl03 glance-registry[26671]:   return pkg_resources.EntryPoint.parse("x=" + s).load(False)
May 25 04:46:02 ctl03 glance-registry[26671]: /usr/lib/python2.7/dist-packages/paste/deploy/loadwsgi.py:22: DeprecationWarning: Parameters to load are deprecated.  Call .resolve and .require separately.
May 25 04:46:02 ctl03 glance-registry[26671]:   return pkg_resources.EntryPoint.parse("x=" + s).load(False)
May 25 04:46:02 ctl03 glance-registry[26671]: /usr/lib/python2.7/dist-packages/paste/deploy/loadwsgi.py:22: DeprecationWarning: Parameters to load are deprecated.  Call .resolve and .require separately.
May 25 04:46:02 ctl03 glance-registry[26671]:   return pkg_resources.EntryPoint.parse("x=" + s).load(False)
May 25 04:46:02 ctl03 glance-registry[26671]: /usr/lib/python2.7/dist-packages/paste/deploy/loadwsgi.py:22: DeprecationWarning: Parameters to load are deprecated.  Call .resolve and .require separately.
May 25 04:46:02 ctl03 glance-registry[26671]:   return pkg_resources.EntryPoint.parse("x=" + s).load(False)
May 25 04:46:02 ctl03 glance-api[26613]: /usr/lib/python2.7/dist-packages/paste/deploy/loadwsgi.py:22: DeprecationWarning: Parameters to load are deprecated.  Call .resolve and .require separately.
May 25 04:46:02 ctl03 glance-api[26613]:   return pkg_resources.EntryPoint.parse("x=" + s).load(False)
May 25 04:46:02 ctl03 glance-api[26613]: /usr/lib/python2.7/dist-packages/paste/deploy/util.py:55: DeprecationWarning: Using function/method 'Healthcheck.factory()' is deprecated: The healthcheck middleware must now be configured as an application, not as a filter
May 25 04:46:02 ctl03 glance-api[26613]:   val = callable(*args, **kw)
May 25 04:46:02 ctl03 glance-registry[26671]: /usr/lib/python2.7/dist-packages/paste/deploy/loadwsgi.py:22: DeprecationWarning: Parameters to load are deprecated.  Call .resolve and .require separately.
May 25 04:46:02 ctl03 glance-registry[26671]:   return pkg_resources.EntryPoint.parse("x=" + s).load(False)
May 25 04:46:02 ctl03 glance-api[26613]: /usr/lib/python2.7/dist-packages/oslo_middleware/cors.py:201: DeprecationWarning: Multiple configuration blocks are deprecated and will be removed in future versions. Please consolidate your configuration in the [cors] configuration block.
May 25 04:46:02 ctl03 glance-api[26613]:   debtcollector.deprecate('Multiple configuration blocks are '
May 25 04:46:02 ctl03 glance-api[26613]: /usr/lib/python2.7/dist-packages/oslo_middleware/cors.py:136: DeprecationWarning: Method 'CORS.set_latent()' has moved to 'CORS.set_defaults()': CORS.set_latent has been deprecated in favor of oslo_middleware.cors.set_defaults
May 25 04:46:02 ctl03 glance-api[26613]:   allow_methods=sanitize(self.conf.get('latent_allow_methods'))
May 25 04:46:02 ctl03 glance-registry[26671]: /usr/lib/python2.7/dist-packages/paste/deploy/util.py:55: DeprecationWarning: Using function/method 'Healthcheck.factory()' is deprecated: The healthcheck middleware must now be configured as an application, not as a filter
May 25 04:46:02 ctl03 glance-registry[26671]:   val = callable(*args, **kw)
May 25 04:47:15 ctl03 dhclient[10234]: DHCPREQUEST of 192.168.11.25 on ens2 to 192.168.11.3 port 67 (xid=0x7c7f9994)
May 25 04:47:15 ctl03 dhclient[10234]: DHCPACK of 192.168.11.25 from 192.168.11.3
May 25 04:47:15 ctl03 dhclient[10234]: bound to 192.168.11.25 -- renewal in 244 seconds.
May 25 04:51:19 ctl03 dhclient[10234]: DHCPREQUEST of 192.168.11.25 on ens2 to 192.168.11.3 port 67 (xid=0x7c7f9994)
May 25 04:51:19 ctl03 dhclient[10234]: DHCPACK of 192.168.11.25 from 192.168.11.3
May 25 04:51:19 ctl03 dhclient[10234]: bound to 192.168.11.25 -- renewal in 233 seconds.
May 25 04:52:37 ctl03 systemd[1]: Started /usr/bin/apt-get -q -y -o DPkg::Options::=--force-confold -o DPkg::Options::=--force-confdef install nova-common.
May 25 04:53:36 ctl03 systemd[1]: Started /usr/bin/apt-get -q -y -o DPkg::Options::=--force-confold -o DPkg::Options::=--force-confdef install nova-consoleproxy.
May 25 04:53:38 ctl03 systemd[1]: Reloading.
May 25 04:53:38 ctl03 systemd[1]: Started ACPI event daemon.
May 25 04:53:40 ctl03 systemd[1]: Reloading.
May 25 04:53:40 ctl03 systemd[1]: Started ACPI event daemon.
May 25 04:53:40 ctl03 systemd[1]: Reloading.
May 25 04:53:40 ctl03 systemd[1]: Started ACPI event daemon.
May 25 04:53:40 ctl03 systemd[1]: Starting LSB: Nova novncproxy server...
May 25 04:53:41 ctl03 nova-novncproxy[29538]:  * Starting OpenStack Compute novncproxy nova-novncproxy
May 25 04:53:41 ctl03 nova-novncproxy[29538]:    ...done.
May 25 04:53:41 ctl03 systemd[1]: Started LSB: Nova novncproxy server.
May 25 04:53:41 ctl03 systemd[1]: Reloading.
May 25 04:53:41 ctl03 systemd[1]: Started ACPI event daemon.
May 25 04:53:41 ctl03 systemd[1]: Reloading.
May 25 04:53:41 ctl03 systemd[1]: Started ACPI event daemon.
May 25 04:53:41 ctl03 systemd[1]: Starting LSB: Nova Spice HTML5 Proxy...
May 25 04:53:41 ctl03 systemd[1]: Started LSB: Nova Spice HTML5 Proxy.
May 25 04:53:41 ctl03 systemd[1]: Reloading.
May 25 04:53:41 ctl03 systemd[1]: Started ACPI event daemon.
May 25 04:53:41 ctl03 systemd[1]: Reloading.
May 25 04:53:41 ctl03 systemd[1]: Started ACPI event daemon.
May 25 04:53:41 ctl03 systemd[1]: Starting LSB: Nova XVP VNC proxy...
May 25 04:53:42 ctl03 systemd[1]: Started LSB: Nova XVP VNC proxy.
May 25 04:53:42 ctl03 systemd[1]: Reloading.
May 25 04:53:42 ctl03 systemd[1]: Started ACPI event daemon.
May 25 04:53:44 ctl03 systemd[1]: Started /usr/bin/apt-get -q -y -o DPkg::Options::=--force-confold -o DPkg::Options::=--force-confdef install nova-api.
May 25 04:53:46 ctl03 systemd[1]: Reloading.
May 25 04:53:46 ctl03 systemd[1]: Started ACPI event daemon.
May 25 04:53:47 ctl03 systemd[1]: Reloading.
May 25 04:53:47 ctl03 systemd[1]: Started ACPI event daemon.
May 25 04:53:47 ctl03 systemd[1]: Reloading.
May 25 04:53:47 ctl03 systemd[1]: Started ACPI event daemon.
May 25 04:53:47 ctl03 systemd[1]: Reloading.
May 25 04:53:47 ctl03 systemd[1]: Started ACPI event daemon.
May 25 04:53:47 ctl03 systemd[1]: Starting OpenStack Compute API...
May 25 04:53:47 ctl03 systemd[1]: Started OpenStack Compute API.
May 25 04:53:48 ctl03 systemd[1]: Reloading.
May 25 04:53:48 ctl03 systemd[1]: Started ACPI event daemon.
May 25 04:53:50 ctl03 systemd[1]: Started /usr/bin/apt-get -q -y -o DPkg::Options::=--force-confold -o DPkg::Options::=--force-confdef install nova-conductor.
May 25 04:53:51 ctl03 systemd[1]: Reloading.
May 25 04:53:51 ctl03 systemd[1]: Started ACPI event daemon.
May 25 04:53:52 ctl03 systemd[1]: nova-api.service: Main process exited, code=exited, status=1/FAILURE
May 25 04:53:52 ctl03 systemd[1]: nova-api.service: Unit entered failed state.
May 25 04:53:52 ctl03 systemd[1]: nova-api.service: Failed with result 'exit-code'.
May 25 04:53:52 ctl03 systemd[1]: nova-api.service: Service hold-off time over, scheduling restart.
May 25 04:53:52 ctl03 systemd[1]: Stopped OpenStack Compute API.
May 25 04:53:52 ctl03 systemd[1]: Starting OpenStack Compute API...
May 25 04:53:52 ctl03 systemd[1]: Started OpenStack Compute API.
May 25 04:53:53 ctl03 systemd[1]: Reloading.
May 25 04:53:53 ctl03 systemd[1]: Started ACPI event daemon.
May 25 04:53:53 ctl03 systemd[1]: Reloading.
May 25 04:53:53 ctl03 systemd[1]: Started ACPI event daemon.
May 25 04:53:53 ctl03 systemd[1]: Reloading.
May 25 04:53:53 ctl03 systemd[1]: Started ACPI event daemon.
May 25 04:53:53 ctl03 systemd[1]: Starting OpenStack Compute Conductor...
May 25 04:53:53 ctl03 systemd[1]: Started OpenStack Compute Conductor.
May 25 04:53:53 ctl03 systemd[1]: Reloading.
May 25 04:53:53 ctl03 systemd[1]: Started ACPI event daemon.
May 25 04:53:56 ctl03 systemd[1]: Started /usr/bin/apt-get -q -y -o DPkg::Options::=--force-confold -o DPkg::Options::=--force-confdef install nova-consoleauth.
May 25 04:53:56 ctl03 systemd[1]: nova-api.service: Main process exited, code=exited, status=1/FAILURE
May 25 04:53:56 ctl03 systemd[1]: nova-api.service: Unit entered failed state.
May 25 04:53:56 ctl03 systemd[1]: nova-api.service: Failed with result 'exit-code'.
May 25 04:53:56 ctl03 systemd[1]: nova-api.service: Service hold-off time over, scheduling restart.
May 25 04:53:56 ctl03 systemd[1]: Stopped OpenStack Compute API.
May 25 04:53:56 ctl03 systemd[1]: Starting OpenStack Compute API...
May 25 04:53:56 ctl03 systemd[1]: Started OpenStack Compute API.
May 25 04:53:57 ctl03 systemd[1]: Reloading.
May 25 04:53:57 ctl03 systemd[1]: Started ACPI event daemon.
May 25 04:53:58 ctl03 systemd[1]: Reloading.
May 25 04:53:59 ctl03 systemd[1]: Started ACPI event daemon.
May 25 04:53:59 ctl03 systemd[1]: Reloading.
May 25 04:53:59 ctl03 systemd[1]: Started ACPI event daemon.
May 25 04:53:59 ctl03 systemd[1]: Reloading.
May 25 04:53:59 ctl03 systemd[1]: Started ACPI event daemon.
May 25 04:53:59 ctl03 systemd[1]: Starting OpenStack Compute Console...
May 25 04:53:59 ctl03 systemd[1]: Started OpenStack Compute Console.
May 25 04:53:59 ctl03 systemd[1]: Reloading.
May 25 04:53:59 ctl03 systemd[1]: Started ACPI event daemon.
May 25 04:54:01 ctl03 systemd[1]: nova-api.service: Main process exited, code=exited, status=1/FAILURE
May 25 04:54:01 ctl03 systemd[1]: nova-api.service: Unit entered failed state.
May 25 04:54:01 ctl03 systemd[1]: nova-api.service: Failed with result 'exit-code'.
May 25 04:54:01 ctl03 systemd[1]: nova-api.service: Service hold-off time over, scheduling restart.
May 25 04:54:01 ctl03 systemd[1]: Stopped OpenStack Compute API.
May 25 04:54:01 ctl03 systemd[1]: Starting OpenStack Compute API...
May 25 04:54:01 ctl03 systemd[1]: Started OpenStack Compute API.
May 25 04:54:02 ctl03 systemd[1]: Started /usr/bin/apt-get -q -y -o DPkg::Options::=--force-confold -o DPkg::Options::=--force-confdef install nova-doc.
May 25 04:54:05 ctl03 systemd[1]: nova-api.service: Main process exited, code=exited, status=1/FAILURE
May 25 04:54:05 ctl03 systemd[1]: nova-api.service: Unit entered failed state.
May 25 04:54:05 ctl03 systemd[1]: nova-api.service: Failed with result 'exit-code'.
May 25 04:54:06 ctl03 systemd[1]: nova-api.service: Service hold-off time over, scheduling restart.
May 25 04:54:06 ctl03 systemd[1]: Stopped OpenStack Compute API.
May 25 04:54:06 ctl03 systemd[1]: Starting OpenStack Compute API...
May 25 04:54:06 ctl03 systemd[1]: Started OpenStack Compute API.
May 25 04:54:06 ctl03 systemd[1]: Started /usr/bin/apt-get -q -y -o DPkg::Options::=--force-confold -o DPkg::Options::=--force-confdef install nova-scheduler.
May 25 04:54:07 ctl03 systemd[1]: Reloading.
May 25 04:54:07 ctl03 systemd[1]: Started ACPI event daemon.
May 25 04:54:09 ctl03 systemd[1]: Reloading.
May 25 04:54:09 ctl03 systemd[1]: Started ACPI event daemon.
May 25 04:54:09 ctl03 systemd[1]: Reloading.
May 25 04:54:09 ctl03 systemd[1]: Started ACPI event daemon.
May 25 04:54:09 ctl03 systemd[1]: Reloading.
May 25 04:54:09 ctl03 systemd[1]: Started ACPI event daemon.
May 25 04:54:09 ctl03 systemd[1]: Starting OpenStack Compute Scheduler...
May 25 04:54:09 ctl03 systemd[1]: Started OpenStack Compute Scheduler.
May 25 04:54:09 ctl03 systemd[1]: Reloading.
May 25 04:54:09 ctl03 systemd[1]: Started ACPI event daemon.
May 25 04:54:11 ctl03 systemd[1]: nova-api.service: Main process exited, code=exited, status=1/FAILURE
May 25 04:54:11 ctl03 systemd[1]: nova-api.service: Unit entered failed state.
May 25 04:54:11 ctl03 systemd[1]: nova-api.service: Failed with result 'exit-code'.
May 25 04:54:11 ctl03 systemd[1]: nova-api.service: Service hold-off time over, scheduling restart.
May 25 04:54:11 ctl03 systemd[1]: Stopped OpenStack Compute API.
May 25 04:54:11 ctl03 systemd[1]: Starting OpenStack Compute API...
May 25 04:54:11 ctl03 systemd[1]: Started OpenStack Compute API.
May 25 04:54:12 ctl03 systemd[1]: nova-scheduler.service: Main process exited, code=exited, status=1/FAILURE
May 25 04:54:12 ctl03 systemd[1]: nova-scheduler.service: Unit entered failed state.
May 25 04:54:12 ctl03 systemd[1]: nova-scheduler.service: Failed with result 'exit-code'.
May 25 04:54:12 ctl03 systemd[1]: nova-scheduler.service: Service hold-off time over, scheduling restart.
May 25 04:54:12 ctl03 systemd[1]: Stopped OpenStack Compute Scheduler.
May 25 04:54:12 ctl03 systemd[1]: Starting OpenStack Compute Scheduler...
May 25 04:54:12 ctl03 systemd[1]: Started OpenStack Compute Scheduler.
May 25 04:54:15 ctl03 systemd[1]: nova-api.service: Main process exited, code=exited, status=1/FAILURE
May 25 04:54:15 ctl03 systemd[1]: nova-api.service: Unit entered failed state.
May 25 04:54:15 ctl03 systemd[1]: nova-api.service: Failed with result 'exit-code'.
May 25 04:54:15 ctl03 nova-scheduler[32097]: Traceback (most recent call last):
May 25 04:54:15 ctl03 nova-scheduler[32097]:   File "/usr/lib/python2.7/dist-packages/eventlet/hubs/poll.py", line 115, in wait
May 25 04:54:15 ctl03 nova-scheduler[32097]:     listener.cb(fileno)
May 25 04:54:15 ctl03 nova-scheduler[32097]:   File "/usr/lib/python2.7/dist-packages/nova/utils.py", line 1030, in context_wrapper
May 25 04:54:15 ctl03 nova-scheduler[32097]:     func(*args, **kwargs)
May 25 04:54:15 ctl03 nova-scheduler[32097]:   File "/usr/lib/python2.7/dist-packages/nova/scheduler/host_manager.py", line 430, in _async_init_instance_info
May 25 04:54:15 ctl03 nova-scheduler[32097]:     cctxt).objects
May 25 04:54:15 ctl03 nova-scheduler[32097]:   File "/usr/lib/python2.7/dist-packages/oslo_versionedobjects/base.py", line 184, in wrapper
May 25 04:54:15 ctl03 nova-scheduler[32097]:     result = fn(cls, context, *args, **kwargs)
May 25 04:54:15 ctl03 nova-scheduler[32097]:   File "/usr/lib/python2.7/dist-packages/nova/objects/compute_node.py", line 389, in get_all
May 25 04:54:15 ctl03 nova-scheduler[32097]:     db_computes = db.compute_node_get_all(context)
May 25 04:54:15 ctl03 nova-scheduler[32097]:   File "/usr/lib/python2.7/dist-packages/nova/db/api.py", line 260, in compute_node_get_all
May 25 04:54:15 ctl03 nova-scheduler[32097]:     return IMPL.compute_node_get_all(context)
May 25 04:54:15 ctl03 nova-scheduler[32097]:   File "/usr/lib/python2.7/dist-packages/nova/db/sqlalchemy/api.py", line 265, in wrapped
May 25 04:54:15 ctl03 nova-scheduler[32097]:     return f(context, *args, **kwargs)
May 25 04:54:15 ctl03 nova-scheduler[32097]:   File "/usr/lib/python2.7/dist-packages/nova/db/sqlalchemy/api.py", line 719, in compute_node_get_all
May 25 04:54:15 ctl03 nova-scheduler[32097]:     return _compute_node_fetchall(context)
May 25 04:54:15 ctl03 nova-scheduler[32097]:   File "/usr/lib/python2.7/dist-packages/nova/db/sqlalchemy/api.py", line 664, in _compute_node_fetchall
May 25 04:54:15 ctl03 nova-scheduler[32097]:     results = conn.execute(select).fetchall()
May 25 04:54:15 ctl03 nova-scheduler[32097]:   File "/usr/lib/python2.7/dist-packages/sqlalchemy/engine/base.py", line 914, in execute
May 25 04:54:15 ctl03 nova-scheduler[32097]:     return meth(self, multiparams, params)
May 25 04:54:15 ctl03 nova-scheduler[32097]:   File "/usr/lib/python2.7/dist-packages/sqlalchemy/sql/elements.py", line 323, in _execute_on_connection
May 25 04:54:15 ctl03 nova-scheduler[32097]:     return connection._execute_clauseelement(self, multiparams, params)
May 25 04:54:15 ctl03 nova-scheduler[32097]:   File "/usr/lib/python2.7/dist-packages/sqlalchemy/engine/base.py", line 1010, in _execute_clauseelement
May 25 04:54:15 ctl03 nova-scheduler[32097]:     compiled_sql, distilled_params
May 25 04:54:15 ctl03 nova-scheduler[32097]:   File "/usr/lib/python2.7/dist-packages/sqlalchemy/engine/base.py", line 1146, in _execute_context
May 25 04:54:15 ctl03 nova-scheduler[32097]:     context)
May 25 04:54:15 ctl03 nova-scheduler[32097]:   File "/usr/lib/python2.7/dist-packages/sqlalchemy/engine/base.py", line 1337, in _handle_dbapi_exception
May 25 04:54:15 ctl03 nova-scheduler[32097]:     util.raise_from_cause(newraise, exc_info)
May 25 04:54:15 ctl03 nova-scheduler[32097]:   File "/usr/lib/python2.7/dist-packages/sqlalchemy/util/compat.py", line 202, in raise_from_cause
May 25 04:54:15 ctl03 nova-scheduler[32097]:     reraise(type(exception), exception, tb=exc_tb, cause=cause)
May 25 04:54:15 ctl03 nova-scheduler[32097]:   File "/usr/lib/python2.7/dist-packages/sqlalchemy/engine/base.py", line 1139, in _execute_context
May 25 04:54:15 ctl03 nova-scheduler[32097]:     context)
May 25 04:54:15 ctl03 nova-scheduler[32097]:   File "/usr/lib/python2.7/dist-packages/sqlalchemy/engine/default.py", line 450, in do_execute
May 25 04:54:15 ctl03 nova-scheduler[32097]:     cursor.execute(statement, parameters)
May 25 04:54:15 ctl03 nova-scheduler[32097]:   File "/usr/lib/python2.7/dist-packages/pymysql/cursors.py", line 167, in execute
May 25 04:54:15 ctl03 nova-scheduler[32097]:     result = self._query(query)
May 25 04:54:15 ctl03 nova-scheduler[32097]:   File "/usr/lib/python2.7/dist-packages/pymysql/cursors.py", line 323, in _query
May 25 04:54:15 ctl03 nova-scheduler[32097]:     conn.query(q)
May 25 04:54:15 ctl03 nova-scheduler[32097]:   File "/usr/lib/python2.7/dist-packages/pymysql/connections.py", line 836, in query
May 25 04:54:15 ctl03 nova-scheduler[32097]:     self._affected_rows = self._read_query_result(unbuffered=unbuffered)
May 25 04:54:15 ctl03 nova-scheduler[32097]:   File "/usr/lib/python2.7/dist-packages/pymysql/connections.py", line 1020, in _read_query_result
May 25 04:54:15 ctl03 nova-scheduler[32097]:     result.read()
May 25 04:54:15 ctl03 nova-scheduler[32097]:   File "/usr/lib/python2.7/dist-packages/pymysql/connections.py", line 1303, in read
May 25 04:54:15 ctl03 nova-scheduler[32097]:     first_packet = self.connection._read_packet()
May 25 04:54:15 ctl03 nova-scheduler[32097]:   File "/usr/lib/python2.7/dist-packages/pymysql/connections.py", line 982, in _read_packet
May 25 04:54:15 ctl03 nova-scheduler[32097]:     packet.check_error()
May 25 04:54:15 ctl03 nova-scheduler[32097]:   File "/usr/lib/python2.7/dist-packages/pymysql/connections.py", line 394, in check_error
May 25 04:54:15 ctl03 nova-scheduler[32097]:     err.raise_mysql_exception(self._data)
May 25 04:54:15 ctl03 nova-scheduler[32097]:   File "/usr/lib/python2.7/dist-packages/pymysql/err.py", line 120, in raise_mysql_exception
May 25 04:54:15 ctl03 nova-scheduler[32097]:     _check_mysql_exception(errinfo)
May 25 04:54:15 ctl03 nova-scheduler[32097]:   File "/usr/lib/python2.7/dist-packages/pymysql/err.py", line 112, in _check_mysql_exception
May 25 04:54:15 ctl03 nova-scheduler[32097]:     raise errorclass(errno, errorvalue)
May 25 04:54:15 ctl03 nova-scheduler[32097]: ProgrammingError: (pymysql.err.ProgrammingError) (1146, u"Table 'nova_cell0.compute_nodes' doesn't exist") [SQL: u'SELECT cn.created_at, cn.updated_at, cn.deleted_at, cn.deleted, cn.id, cn.service_id, cn.host, cn.uuid, cn.vcpus, cn.memory_mb, cn.local_gb, cn.vcpus_used, cn.memory_mb_used, cn.local_gb_used, cn.hypervisor_type, cn.hypervisor_version, cn.hypervisor_hostname, cn.free_ram_mb, cn.free_disk_gb, cn.current_workload, cn.running_vms, cn.cpu_info, cn.disk_available_least, cn.host_ip, cn.supported_instances, cn.metrics, cn.pci_stats, cn.extra_resources, cn.stats, cn.numa_topology, cn.ram_allocation_ratio, cn.cpu_allocation_ratio, cn.disk_allocation_ratio, cn.mapped \nFROM compute_nodes AS cn \nWHERE cn.deleted = %(deleted_1)s ORDER BY cn.id ASC'] [parameters: {u'deleted_1': 0}]
May 25 04:54:15 ctl03 nova-scheduler[32097]: Removing descriptor: 6
May 25 04:54:15 ctl03 nova-scheduler[32097]: Exception AssertionError: AssertionError('do not call blocking functions from the mainloop',) in <function <lambda> at 0x7f5987b712a8> ignored
May 25 04:54:15 ctl03 systemd[1]: nova-api.service: Service hold-off time over, scheduling restart.
May 25 04:54:15 ctl03 systemd[1]: Stopped OpenStack Compute API.
May 25 04:54:15 ctl03 systemd[1]: Starting OpenStack Compute API...
May 25 04:54:15 ctl03 systemd[1]: Started OpenStack Compute API.
May 25 04:55:12 ctl03 dhclient[10234]: DHCPREQUEST of 192.168.11.25 on ens2 to 192.168.11.3 port 67 (xid=0x7c7f9994)
May 25 04:55:12 ctl03 dhclient[10234]: DHCPACK of 192.168.11.25 from 192.168.11.3
May 25 04:55:12 ctl03 dhclient[10234]: bound to 192.168.11.25 -- renewal in 262 seconds.
May 25 04:55:40 ctl03 systemd[1]: Started /usr/bin/apt-get -q -y -o DPkg::Options::=--force-confold -o DPkg::Options::=--force-confdef install nova-placement-api.
May 25 04:55:42 ctl03 nova-placement-api: apache2_invoke: Enable site nova-placement-api.conf
May 25 04:55:42 ctl03 systemd[1]: Reloading.
May 25 04:55:42 ctl03 systemd[1]: Started ACPI event daemon.
May 25 04:55:42 ctl03 systemd[1]: Reloading LSB: Apache2 web server.
May 25 04:55:42 ctl03 apache2[32516]:  * Reloading Apache httpd web server apache2
May 25 04:55:42 ctl03 apache2[32516]:  *
May 25 04:55:42 ctl03 systemd[1]: Reloaded LSB: Apache2 web server.
May 25 04:56:01 ctl03 systemd[1]: Started /bin/systemctl restart apache2.service.
May 25 04:56:01 ctl03 systemd[1]: Stopping LSB: Apache2 web server...
May 25 04:56:01 ctl03 apache2[500]:  * Stopping Apache httpd web server apache2
May 25 04:56:02 ctl03 apache2[500]:  *
May 25 04:56:02 ctl03 systemd[1]: Stopped LSB: Apache2 web server.
May 25 04:56:02 ctl03 systemd[1]: Starting LSB: Apache2 web server...
May 25 04:56:02 ctl03 apache2[543]:  * Starting Apache httpd web server apache2
May 25 04:56:03 ctl03 apache2[543]:  *
May 25 04:56:03 ctl03 systemd[1]: Started LSB: Apache2 web server.
May 25 04:56:03 ctl03 systemd[1]: Started /bin/systemctl restart nova-api.service.
May 25 04:56:04 ctl03 systemd[1]: Stopping OpenStack Compute API...
May 25 04:56:05 ctl03 systemd[1]: Stopped OpenStack Compute API.
May 25 04:56:05 ctl03 systemd[1]: Starting OpenStack Compute API...
May 25 04:56:05 ctl03 systemd[1]: Started OpenStack Compute API.
May 25 04:56:05 ctl03 systemd[1]: Started /bin/systemctl start nova-consoleauth.service.
May 25 04:56:05 ctl03 systemd[1]: Starting OpenStack Compute Console...
May 25 04:56:05 ctl03 systemd[1]: Started OpenStack Compute Console.
May 25 04:56:05 ctl03 systemd[1]: Started /bin/systemctl restart nova-scheduler.service.
May 25 04:56:05 ctl03 systemd[1]: Stopping OpenStack Compute Scheduler...
May 25 04:56:15 ctl03 systemd[1]: Stopped OpenStack Compute Scheduler.
May 25 04:56:15 ctl03 systemd[1]: Starting OpenStack Compute Scheduler...
May 25 04:56:15 ctl03 systemd[1]: Started OpenStack Compute Scheduler.
May 25 04:56:15 ctl03 systemd[1]: Started /bin/systemctl restart nova-conductor.service.
May 25 04:56:15 ctl03 systemd[1]: Stopping OpenStack Compute Conductor...
May 25 04:56:16 ctl03 nova-conductor[30697]: Exception TypeError: "'NoneType' object is not callable" in <bound method _SocketDuckForFd.__del__ of _SocketDuckForFd:4> ignored
May 25 04:56:16 ctl03 systemd[1]: Stopped OpenStack Compute Conductor.
May 25 04:56:16 ctl03 systemd[1]: Starting OpenStack Compute Conductor...
May 25 04:56:16 ctl03 systemd[1]: Started OpenStack Compute Conductor.
May 25 04:56:16 ctl03 systemd[1]: Started /bin/systemctl restart nova-novncproxy.service.
May 25 04:56:16 ctl03 systemd[1]: Stopping LSB: Nova novncproxy server...
May 25 04:56:16 ctl03 nova-novncproxy[1185]:  * Stopping OpenStack Compute novncproxy nova-novncproxy
May 25 04:56:16 ctl03 nova-novncproxy[1185]: start-stop-daemon: warning: failed to kill 29566: No such process
May 25 04:56:16 ctl03 nova-novncproxy[1185]:    ...done.
May 25 04:56:16 ctl03 systemd[1]: Stopped LSB: Nova novncproxy server.
May 25 04:56:16 ctl03 systemd[1]: Starting LSB: Nova novncproxy server...
May 25 04:56:16 ctl03 nova-novncproxy[1204]:  * Starting OpenStack Compute novncproxy nova-novncproxy
May 25 04:56:16 ctl03 nova-novncproxy[1204]:    ...done.
May 25 04:56:16 ctl03 systemd[1]: Started LSB: Nova novncproxy server.
May 25 04:59:34 ctl03 dhclient[10234]: DHCPREQUEST of 192.168.11.25 on ens2 to 192.168.11.3 port 67 (xid=0x7c7f9994)
May 25 04:59:34 ctl03 dhclient[10234]: DHCPACK of 192.168.11.25 from 192.168.11.3
May 25 04:59:34 ctl03 dhclient[10234]: bound to 192.168.11.25 -- renewal in 228 seconds.
May 25 05:00:14 ctl03 systemd[1]: Started /usr/bin/apt-get -q -y -o DPkg::Options::=--force-confold -o DPkg::Options::=--force-confdef install heat-api.
May 25 05:00:27 ctl03 systemd[1]: Reloading.
May 25 05:00:28 ctl03 systemd[1]: Started ACPI event daemon.
May 25 05:00:38 ctl03 systemd[1]: Reloading.
May 25 05:00:38 ctl03 systemd[1]: Started ACPI event daemon.
May 25 05:00:38 ctl03 systemd[1]: Reloading.
May 25 05:00:39 ctl03 systemd[1]: Started ACPI event daemon.
May 25 05:00:39 ctl03 systemd[1]: Reloading.
May 25 05:00:39 ctl03 systemd[1]: Started ACPI event daemon.
May 25 05:00:39 ctl03 systemd[1]: Starting Heat API...
May 25 05:00:39 ctl03 systemd[1]: Started Heat API.
May 25 05:00:39 ctl03 systemd[1]: Reloading.
May 25 05:00:39 ctl03 systemd[1]: Started ACPI event daemon.
May 25 05:00:42 ctl03 systemd[1]: Started /usr/bin/apt-get -q -y -o DPkg::Options::=--force-confold -o DPkg::Options::=--force-confdef install heat-api-cfn.
May 25 05:00:43 ctl03 systemd[1]: Reloading.
May 25 05:00:43 ctl03 systemd[1]: Started ACPI event daemon.
May 25 05:00:44 ctl03 systemd[1]: Reloading.
May 25 05:00:44 ctl03 systemd[1]: Started ACPI event daemon.
May 25 05:00:44 ctl03 systemd[1]: Reloading.
May 25 05:00:44 ctl03 systemd[1]: Started ACPI event daemon.
May 25 05:00:44 ctl03 systemd[1]: Reloading.
May 25 05:00:44 ctl03 systemd[1]: Started ACPI event daemon.
May 25 05:00:45 ctl03 systemd[1]: Starting Heat API...
May 25 05:00:45 ctl03 systemd[1]: Started Heat API.
May 25 05:00:45 ctl03 systemd[1]: Reloading.
May 25 05:00:45 ctl03 systemd[1]: Started ACPI event daemon.
May 25 05:00:47 ctl03 systemd[1]: Started /usr/bin/apt-get -q -y -o DPkg::Options::=--force-confold -o DPkg::Options::=--force-confdef install heat-engine.
May 25 05:00:48 ctl03 systemd[1]: Reloading.
May 25 05:00:49 ctl03 systemd[1]: Started ACPI event daemon.
May 25 05:00:50 ctl03 systemd[1]: Reloading.
May 25 05:00:50 ctl03 systemd[1]: Started ACPI event daemon.
May 25 05:00:50 ctl03 systemd[1]: Reloading.
May 25 05:00:50 ctl03 systemd[1]: Started ACPI event daemon.
May 25 05:00:50 ctl03 systemd[1]: Reloading.
May 25 05:00:50 ctl03 systemd[1]: Started ACPI event daemon.
May 25 05:00:50 ctl03 systemd[1]: Starting Heat Engine...
May 25 05:00:50 ctl03 systemd[1]: Started Heat Engine.
May 25 05:00:50 ctl03 systemd[1]: Reloading.
May 25 05:00:50 ctl03 systemd[1]: Started ACPI event daemon.
May 25 05:00:52 ctl03 heat-engine[3197]: /usr/lib/python2.7/dist-packages/barbicanclient/__init__.py:61: UserWarning: The containers module is moved to barbicanclient/v1 directory, direct import of barbicanclient.containers will be deprecated. Please import barbicanclient.v1.containers instead.
May 25 05:00:52 ctl03 heat-engine[3197]:   % (name, name, name))
May 25 05:00:53 ctl03 systemd[1]: Started /usr/bin/apt-get -q -y -o DPkg::Options::=--force-confold -o DPkg::Options::=--force-confdef install heat-api-cloudwatch.
May 25 05:00:54 ctl03 systemd[1]: Reloading.
May 25 05:00:54 ctl03 systemd[1]: Started ACPI event daemon.
May 25 05:00:55 ctl03 systemd[1]: Reloading.
May 25 05:00:55 ctl03 systemd[1]: Started ACPI event daemon.
May 25 05:00:55 ctl03 systemd[1]: Reloading.
May 25 05:00:55 ctl03 systemd[1]: Started ACPI event daemon.
May 25 05:00:55 ctl03 systemd[1]: Reloading.
May 25 05:00:55 ctl03 systemd[1]: Started ACPI event daemon.
May 25 05:00:55 ctl03 systemd[1]: Starting Heat API...
May 25 05:00:56 ctl03 systemd[1]: Started Heat API.
May 25 05:00:56 ctl03 systemd[1]: Reloading.
May 25 05:00:56 ctl03 systemd[1]: Started ACPI event daemon.
May 25 05:01:03 ctl03 systemd[1]: Started /bin/systemctl restart heat-api.service.
May 25 05:01:03 ctl03 systemd[1]: Stopping Heat API...
May 25 05:01:03 ctl03 systemd[1]: Stopped Heat API.
May 25 05:01:03 ctl03 systemd[1]: Starting Heat API...
May 25 05:01:03 ctl03 systemd[1]: Started Heat API.
May 25 05:01:03 ctl03 systemd[1]: Started /bin/systemctl restart heat-api-cfn.service.
May 25 05:01:03 ctl03 systemd[1]: Stopping Heat API...
May 25 05:01:03 ctl03 systemd[1]: Stopped Heat API.
May 25 05:01:03 ctl03 systemd[1]: Starting Heat API...
May 25 05:01:03 ctl03 systemd[1]: Started Heat API.
May 25 05:01:03 ctl03 systemd[1]: Started /bin/systemctl restart heat-engine.service.
May 25 05:01:03 ctl03 systemd[1]: Stopping Heat Engine...
May 25 05:01:04 ctl03 systemd[1]: Stopped Heat Engine.
May 25 05:01:04 ctl03 systemd[1]: Starting Heat Engine...
May 25 05:01:04 ctl03 systemd[1]: Started Heat Engine.
May 25 05:01:04 ctl03 systemd[1]: Started /bin/systemctl restart heat-api-cloudwatch.service.
May 25 05:01:04 ctl03 systemd[1]: Stopping Heat API...
May 25 05:01:04 ctl03 systemd[1]: Stopped Heat API.
May 25 05:01:04 ctl03 systemd[1]: Starting Heat API...
May 25 05:01:04 ctl03 systemd[1]: Started Heat API.
May 25 05:01:05 ctl03 heat-engine[3777]: /usr/lib/python2.7/dist-packages/barbicanclient/__init__.py:61: UserWarning: The containers module is moved to barbicanclient/v1 directory, direct import of barbicanclient.containers will be deprecated. Please import barbicanclient.v1.containers instead.
May 25 05:01:05 ctl03 heat-engine[3777]:   % (name, name, name))
May 25 05:01:06 ctl03 heat-engine[3777]: /usr/lib/python2.7/dist-packages/sqlalchemy/sql/sqltypes.py:185: SAWarning: Unicode type received non-unicode bind param value 'data-processing-cluster'. (this warning may be suppressed after 10 occurrences)
May 25 05:01:06 ctl03 heat-engine[3777]:   (util.ellipses_string(value),))
May 25 05:01:06 ctl03 heat-engine[3777]: /usr/lib/python2.7/dist-packages/sqlalchemy/sql/sqltypes.py:185: SAWarning: Unicode type received non-unicode bind param value 'data-processing-cluster'. (this warning may be suppressed after 10 occurrences)
May 25 05:01:06 ctl03 heat-engine[3777]:   (util.ellipses_string(value),))
May 25 05:01:06 ctl03 heat-engine[3777]: /usr/lib/python2.7/dist-packages/sqlalchemy/sql/sqltypes.py:185: SAWarning: Unicode type received non-unicode bind param value 'data-processing-cluster'. (this warning may be suppressed after 10 occurrences)
May 25 05:01:06 ctl03 heat-engine[3777]:   (util.ellipses_string(value),))
May 25 05:01:06 ctl03 heat-engine[3777]: /usr/lib/python2.7/dist-packages/sqlalchemy/sql/sqltypes.py:185: SAWarning: Unicode type received non-unicode bind param value 'data-processing-cluster'. (this warning may be suppressed after 10 occurrences)
May 25 05:01:06 ctl03 heat-engine[3777]:   (util.ellipses_string(value),))
May 25 05:03:22 ctl03 dhclient[10234]: DHCPREQUEST of 192.168.11.25 on ens2 to 192.168.11.3 port 67 (xid=0x7c7f9994)
May 25 05:03:22 ctl03 dhclient[10234]: DHCPACK of 192.168.11.25 from 192.168.11.3
May 25 05:03:22 ctl03 dhclient[10234]: bound to 192.168.11.25 -- renewal in 271 seconds.
May 25 05:05:14 ctl03 systemd[1]: Started /usr/bin/apt-get -q -y -o DPkg::Options::=--force-confold -o DPkg::Options::=--force-confdef install cinder-api.
May 25 05:05:20 ctl03 systemd[1]: Reloading.
May 25 05:05:20 ctl03 systemd[1]: Started ACPI event daemon.
May 25 05:05:23 ctl03 systemd[1]: Reloading.
May 25 05:05:23 ctl03 systemd[1]: Started ACPI event daemon.
May 25 05:05:23 ctl03 systemd[1]: Reloading.
May 25 05:05:23 ctl03 systemd[1]: Started ACPI event daemon.
May 25 05:05:23 ctl03 systemd[1]: Starting LSB: Start LIO targets...
May 25 05:05:33 ctl03 rtslib-fb-targetctl[5084]:  * Loading rstlib-fb targetctl targetctl
May 25 05:05:34 ctl03 kernel: [ 3768.876350] Rounding down aligned max_sectors from 4294967295 to 4294967288
May 25 05:05:34 ctl03 rtslib-fb-targetctl[5084]:    ...done.
May 25 05:05:34 ctl03 systemd[1]: Started LSB: Start LIO targets.
May 25 05:05:37 ctl03 cinder-api: apache2_invoke: Enable configuration cinder-wsgi
May 25 05:05:37 ctl03 systemd[1]: Reloading.
May 25 05:05:37 ctl03 systemd[1]: Started ACPI event daemon.
May 25 05:05:37 ctl03 systemd[1]: Reloading LSB: Apache2 web server.
May 25 05:05:37 ctl03 apache2[5224]:  * Reloading Apache httpd web server apache2
May 25 05:05:37 ctl03 apache2[5224]:  *
May 25 05:05:37 ctl03 systemd[1]: Reloaded LSB: Apache2 web server.
May 25 05:05:37 ctl03 systemd[1]: Reloading.
May 25 05:05:38 ctl03 systemd[1]: Started ACPI event daemon.
May 25 05:05:40 ctl03 systemd[1]: Started /usr/bin/apt-get -q -y -o DPkg::Options::=--force-confold -o DPkg::Options::=--force-confdef install cinder-scheduler.
May 25 05:05:42 ctl03 systemd[1]: Reloading.
May 25 05:05:42 ctl03 systemd[1]: Started ACPI event daemon.
May 25 05:05:43 ctl03 systemd[1]: Reloading.
May 25 05:05:43 ctl03 systemd[1]: Started ACPI event daemon.
May 25 05:05:43 ctl03 systemd[1]: Reloading.
May 25 05:05:43 ctl03 systemd[1]: Started ACPI event daemon.
May 25 05:05:43 ctl03 systemd[1]: Reloading.
May 25 05:05:43 ctl03 systemd[1]: Started ACPI event daemon.
May 25 05:05:43 ctl03 systemd[1]: Starting OpenStack Cinder Scheduler...
May 25 05:05:43 ctl03 systemd[1]: Started OpenStack Cinder Scheduler.
May 25 05:05:43 ctl03 systemd[1]: Reloading.
May 25 05:05:43 ctl03 systemd[1]: Started ACPI event daemon.
May 25 05:05:46 ctl03 systemd[1]: cinder-scheduler.service: Main process exited, code=exited, status=1/FAILURE
May 25 05:05:46 ctl03 systemd[1]: cinder-scheduler.service: Unit entered failed state.
May 25 05:05:46 ctl03 systemd[1]: cinder-scheduler.service: Failed with result 'exit-code'.
May 25 05:05:46 ctl03 systemd[1]: cinder-scheduler.service: Service hold-off time over, scheduling restart.
May 25 05:05:46 ctl03 systemd[1]: Stopped OpenStack Cinder Scheduler.
May 25 05:05:46 ctl03 systemd[1]: Starting OpenStack Cinder Scheduler...
May 25 05:05:46 ctl03 systemd[1]: Started OpenStack Cinder Scheduler.
May 25 05:05:54 ctl03 systemd[1]: Started /bin/systemctl restart apache2.service.
May 25 05:05:54 ctl03 systemd[1]: Stopping LSB: Apache2 web server...
May 25 05:05:54 ctl03 apache2[6212]:  * Stopping Apache httpd web server apache2
May 25 05:05:55 ctl03 apache2[6212]:  *
May 25 05:05:55 ctl03 systemd[1]: Stopped LSB: Apache2 web server.
May 25 05:05:55 ctl03 systemd[1]: Starting LSB: Apache2 web server...
May 25 05:05:55 ctl03 apache2[6254]:  * Starting Apache httpd web server apache2
May 25 05:05:56 ctl03 apache2[6254]:  *
May 25 05:05:56 ctl03 systemd[1]: Started LSB: Apache2 web server.
May 25 05:05:56 ctl03 systemd[1]: Started /bin/systemctl restart cinder-scheduler.service.
May 25 05:05:56 ctl03 systemd[1]: Stopping OpenStack Cinder Scheduler...
May 25 05:06:04 ctl03 systemd[1]: Stopped OpenStack Cinder Scheduler.
May 25 05:06:04 ctl03 systemd[1]: Starting OpenStack Cinder Scheduler...
May 25 05:06:04 ctl03 systemd[1]: Started OpenStack Cinder Scheduler.
May 25 05:07:53 ctl03 dhclient[10234]: DHCPREQUEST of 192.168.11.25 on ens2 to 192.168.11.3 port 67 (xid=0x7c7f9994)
May 25 05:07:54 ctl03 dhclient[10234]: DHCPACK of 192.168.11.25 from 192.168.11.3
May 25 05:07:54 ctl03 dhclient[10234]: bound to 192.168.11.25 -- renewal in 252 seconds.
May 25 05:12:07 ctl03 dhclient[10234]: DHCPREQUEST of 192.168.11.25 on ens2 to 192.168.11.3 port 67 (xid=0x7c7f9994)
May 25 05:12:07 ctl03 dhclient[10234]: DHCPACK of 192.168.11.25 from 192.168.11.3
May 25 05:12:07 ctl03 dhclient[10234]: bound to 192.168.11.25 -- renewal in 228 seconds.
May 25 05:15:55 ctl03 dhclient[10234]: DHCPREQUEST of 192.168.11.25 on ens2 to 192.168.11.3 port 67 (xid=0x7c7f9994)
May 25 05:15:55 ctl03 dhclient[10234]: DHCPACK of 192.168.11.25 from 192.168.11.3
May 25 05:15:55 ctl03 dhclient[10234]: bound to 192.168.11.25 -- renewal in 259 seconds.
May 25 05:17:01 ctl03 CRON[7030]: (root) CMD (   cd / && run-parts --report /etc/cron.hourly)
May 25 05:17:09 ctl03 systemd[1]: Started /usr/bin/apt-get -q -y -o DPkg::Options::=--force-confold -o DPkg::Options::=--force-confdef install python-networking-odl.
May 25 05:17:26 ctl03 systemd[1]: Started /usr/bin/apt-get -q -y -o DPkg::Options::=--force-confold -o DPkg::Options::=--force-confdef install neutron-server.
May 25 05:17:30 ctl03 systemd[1]: Reloading.
May 25 05:17:30 ctl03 systemd[1]: Started ACPI event daemon.
May 25 05:17:32 ctl03 systemd[1]: Reloading.
May 25 05:17:32 ctl03 systemd[1]: Started ACPI event daemon.
May 25 05:17:33 ctl03 systemd[1]: Reloading.
May 25 05:17:33 ctl03 systemd[1]: Started ACPI event daemon.
May 25 05:17:33 ctl03 systemd[1]: Reloading.
May 25 05:17:33 ctl03 systemd[1]: Started ACPI event daemon.
May 25 05:17:35 ctl03 systemd[1]: Started /usr/bin/apt-get -q -y -o DPkg::Options::=--force-confold -o DPkg::Options::=--force-confdef install python-neutron-lbaas.
May 25 05:17:43 ctl03 systemd[1]: Started /bin/systemctl start neutron-server.service.
May 25 05:17:43 ctl03 systemd[1]: Starting OpenStack Neutron Server...
May 25 05:17:43 ctl03 systemd[1]: Started OpenStack Neutron Server.
May 25 05:17:43 ctl03 neutron-server[8556]: Guru meditation now registers SIGUSR1 and SIGUSR2 by default for backward compatibility. SIGUSR1 will no longer be registered in a future release, so please use SIGUSR2 to generate reports.
May 25 05:20:14 ctl03 dhclient[10234]: DHCPREQUEST of 192.168.11.25 on ens2 to 192.168.11.3 port 67 (xid=0x7c7f9994)
May 25 05:20:14 ctl03 dhclient[10234]: DHCPACK of 192.168.11.25 from 192.168.11.3
May 25 05:20:15 ctl03 dhclient[10234]: bound to 192.168.11.25 -- renewal in 238 seconds.
May 25 05:24:13 ctl03 dhclient[10234]: DHCPREQUEST of 192.168.11.25 on ens2 to 192.168.11.3 port 67 (xid=0x7c7f9994)
May 25 05:24:13 ctl03 dhclient[10234]: DHCPACK of 192.168.11.25 from 192.168.11.3
May 25 05:24:13 ctl03 dhclient[10234]: bound to 192.168.11.25 -- renewal in 288 seconds.
May 25 05:29:01 ctl03 dhclient[10234]: DHCPREQUEST of 192.168.11.25 on ens2 to 192.168.11.3 port 67 (xid=0x7c7f9994)
May 25 05:29:01 ctl03 dhclient[10234]: DHCPACK of 192.168.11.25 from 192.168.11.3
May 25 05:29:01 ctl03 dhclient[10234]: bound to 192.168.11.25 -- renewal in 246 seconds.
May 25 05:33:07 ctl03 dhclient[10234]: DHCPREQUEST of 192.168.11.25 on ens2 to 192.168.11.3 port 67 (xid=0x7c7f9994)
May 25 05:33:07 ctl03 dhclient[10234]: DHCPACK of 192.168.11.25 from 192.168.11.3
May 25 05:33:07 ctl03 dhclient[10234]: bound to 192.168.11.25 -- renewal in 283 seconds.
May 25 05:37:50 ctl03 dhclient[10234]: DHCPREQUEST of 192.168.11.25 on ens2 to 192.168.11.3 port 67 (xid=0x7c7f9994)
May 25 05:37:50 ctl03 dhclient[10234]: DHCPACK of 192.168.11.25 from 192.168.11.3
May 25 05:37:50 ctl03 dhclient[10234]: bound to 192.168.11.25 -- renewal in 291 seconds.
May 25 05:42:41 ctl03 dhclient[10234]: DHCPREQUEST of 192.168.11.25 on ens2 to 192.168.11.3 port 67 (xid=0x7c7f9994)
May 25 05:42:42 ctl03 dhclient[10234]: DHCPACK of 192.168.11.25 from 192.168.11.3
May 25 05:42:42 ctl03 dhclient[10234]: bound to 192.168.11.25 -- renewal in 247 seconds.
May 25 05:46:49 ctl03 dhclient[10234]: DHCPREQUEST of 192.168.11.25 on ens2 to 192.168.11.3 port 67 (xid=0x7c7f9994)
May 25 05:46:49 ctl03 dhclient[10234]: DHCPACK of 192.168.11.25 from 192.168.11.3
May 25 05:46:49 ctl03 dhclient[10234]: bound to 192.168.11.25 -- renewal in 297 seconds.
May 25 05:51:46 ctl03 dhclient[10234]: DHCPREQUEST of 192.168.11.25 on ens2 to 192.168.11.3 port 67 (xid=0x7c7f9994)
May 25 05:51:46 ctl03 dhclient[10234]: DHCPACK of 192.168.11.25 from 192.168.11.3
May 25 05:51:46 ctl03 dhclient[10234]: bound to 192.168.11.25 -- renewal in 247 seconds.
May 25 05:54:26 ctl03 systemd[1]: Started /bin/systemctl restart glance-api.service.
May 25 05:54:26 ctl03 systemd[1]: Stopping OpenStack Image Service API...
May 25 05:54:26 ctl03 systemd[1]: Stopped OpenStack Image Service API.
May 25 05:54:26 ctl03 systemd[1]: Starting OpenStack Image Service API...
May 25 05:54:26 ctl03 systemd[1]: Started OpenStack Image Service API.
May 25 05:54:28 ctl03 glance-api[8735]: /usr/lib/python2.7/dist-packages/paste/deploy/loadwsgi.py:22: DeprecationWarning: Parameters to load are deprecated.  Call .resolve and .require separately.
May 25 05:54:28 ctl03 glance-api[8735]:   return pkg_resources.EntryPoint.parse("x=" + s).load(False)
May 25 05:54:28 ctl03 glance-api[8735]: /usr/lib/python2.7/dist-packages/paste/deploy/loadwsgi.py:22: DeprecationWarning: Parameters to load are deprecated.  Call .resolve and .require separately.
May 25 05:54:28 ctl03 glance-api[8735]:   return pkg_resources.EntryPoint.parse("x=" + s).load(False)
May 25 05:54:28 ctl03 glance-api[8735]: /usr/lib/python2.7/dist-packages/paste/deploy/loadwsgi.py:22: DeprecationWarning: Parameters to load are deprecated.  Call .resolve and .require separately.
May 25 05:54:28 ctl03 glance-api[8735]:   return pkg_resources.EntryPoint.parse("x=" + s).load(False)
May 25 05:54:28 ctl03 glance-api[8735]: /usr/lib/python2.7/dist-packages/paste/deploy/loadwsgi.py:22: DeprecationWarning: Parameters to load are deprecated.  Call .resolve and .require separately.
May 25 05:54:28 ctl03 glance-api[8735]:   return pkg_resources.EntryPoint.parse("x=" + s).load(False)
May 25 05:54:28 ctl03 glance-api[8735]: /usr/lib/python2.7/dist-packages/paste/deploy/loadwsgi.py:22: DeprecationWarning: Parameters to load are deprecated.  Call .resolve and .require separately.
May 25 05:54:28 ctl03 glance-api[8735]:   return pkg_resources.EntryPoint.parse("x=" + s).load(False)
May 25 05:54:28 ctl03 glance-api[8735]: /usr/lib/python2.7/dist-packages/paste/deploy/loadwsgi.py:22: DeprecationWarning: Parameters to load are deprecated.  Call .resolve and .require separately.
May 25 05:54:28 ctl03 glance-api[8735]:   return pkg_resources.EntryPoint.parse("x=" + s).load(False)
May 25 05:54:28 ctl03 glance-api[8735]: /usr/lib/python2.7/dist-packages/paste/deploy/loadwsgi.py:22: DeprecationWarning: Parameters to load are deprecated.  Call .resolve and .require separately.
May 25 05:54:28 ctl03 glance-api[8735]:   return pkg_resources.EntryPoint.parse("x=" + s).load(False)
May 25 05:54:28 ctl03 glance-api[8735]: /usr/lib/python2.7/dist-packages/paste/deploy/loadwsgi.py:22: DeprecationWarning: Parameters to load are deprecated.  Call .resolve and .require separately.
May 25 05:54:28 ctl03 glance-api[8735]:   return pkg_resources.EntryPoint.parse("x=" + s).load(False)
May 25 05:54:28 ctl03 glance-api[8735]: /usr/lib/python2.7/dist-packages/paste/deploy/loadwsgi.py:22: DeprecationWarning: Parameters to load are deprecated.  Call .resolve and .require separately.
May 25 05:54:28 ctl03 glance-api[8735]:   return pkg_resources.EntryPoint.parse("x=" + s).load(False)
May 25 05:54:28 ctl03 glance-api[8735]: /usr/lib/python2.7/dist-packages/paste/deploy/loadwsgi.py:22: DeprecationWarning: Parameters to load are deprecated.  Call .resolve and .require separately.
May 25 05:54:28 ctl03 glance-api[8735]:   return pkg_resources.EntryPoint.parse("x=" + s).load(False)
May 25 05:54:28 ctl03 glance-api[8735]: /usr/lib/python2.7/dist-packages/paste/deploy/loadwsgi.py:22: DeprecationWarning: Parameters to load are deprecated.  Call .resolve and .require separately.
May 25 05:54:28 ctl03 glance-api[8735]:   return pkg_resources.EntryPoint.parse("x=" + s).load(False)
May 25 05:54:28 ctl03 glance-api[8735]: /usr/lib/python2.7/dist-packages/paste/deploy/util.py:55: DeprecationWarning: Using function/method 'Healthcheck.factory()' is deprecated: The healthcheck middleware must now be configured as an application, not as a filter
May 25 05:54:28 ctl03 glance-api[8735]:   val = callable(*args, **kw)
May 25 05:54:28 ctl03 glance-api[8735]: /usr/lib/python2.7/dist-packages/oslo_middleware/cors.py:201: DeprecationWarning: Multiple configuration blocks are deprecated and will be removed in future versions. Please consolidate your configuration in the [cors] configuration block.
May 25 05:54:28 ctl03 glance-api[8735]:   debtcollector.deprecate('Multiple configuration blocks are '
May 25 05:54:28 ctl03 glance-api[8735]: /usr/lib/python2.7/dist-packages/oslo_middleware/cors.py:136: DeprecationWarning: Method 'CORS.set_latent()' has moved to 'CORS.set_defaults()': CORS.set_latent has been deprecated in favor of oslo_middleware.cors.set_defaults
May 25 05:54:28 ctl03 glance-api[8735]:   allow_methods=sanitize(self.conf.get('latent_allow_methods'))
