Sep  1 22:07:46 ubuntu rsyslogd: [origin software="rsyslogd" swVersion="8.16.0" x-pid="1092" x-info="http://www.rsyslog.com"] start
Sep  1 22:07:46 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 ]
Sep  1 22:07:46 ubuntu rsyslogd: rsyslogd's groupid changed to 108
Sep  1 22:07:46 ubuntu rsyslogd: rsyslogd's userid changed to 104
Sep  1 22:07:46 ubuntu systemd[1]: Starting Flush Journal to Persistent Storage...
Sep  1 22:07:46 ubuntu systemd-modules-load[373]: Inserted module 'iscsi_tcp'
Sep  1 22:07:46 ubuntu systemd[1]: Started LVM2 metadata daemon.
Sep  1 22:07:46 ubuntu systemd[1]: Started udev Coldplug all Devices.
Sep  1 22:07:46 ubuntu systemd[1]: Started Flush Journal to Persistent Storage.
Sep  1 22:07:46 ubuntu loadkeys[381]: Loading /etc/console-setup/cached.kmap.gz
Sep  1 22:07:46 ubuntu systemd[1]: Started Set console keymap.
Sep  1 22:07:46 ubuntu systemd[1]: Started Create Static Device Nodes in /dev.
Sep  1 22:07:46 ubuntu systemd[1]: Starting udev Kernel Device Manager...
Sep  1 22:07:46 ubuntu systemd-modules-load[373]: Inserted module 'ib_iser'
Sep  1 22:07:46 ubuntu systemd[1]: Started Load Kernel Modules.
Sep  1 22:07:46 ubuntu systemd[1]: Mounting FUSE Control File System...
Sep  1 22:07:46 ubuntu systemd[1]: Starting Apply Kernel Variables...
Sep  1 22:07:46 ubuntu systemd[1]: Mounting Configuration File System...
Sep  1 22:07:46 ubuntu systemd[1]: Mounted FUSE Control File System.
Sep  1 22:07:46 ubuntu systemd[1]: Mounted Configuration File System.
Sep  1 22:07:46 ubuntu systemd[1]: Started Apply Kernel Variables.
Sep  1 22:07:46 ubuntu systemd[1]: Started Monitoring of LVM2 mirrors, snapshots etc. using dmeventd or progress polling.
Sep  1 22:07:46 ubuntu systemd[1]: Started udev Kernel Device Manager.
Sep  1 22:07:46 ubuntu systemd[1]: Started Dispatch Password Requests to Console Directory Watch.
Sep  1 22:07:46 ubuntu systemd[1]: Reached target Local File Systems (Pre).
Sep  1 22:07:46 ubuntu systemd[1]: Reached target Local File Systems.
Sep  1 22:07:46 ubuntu systemd[1]: Starting Set console font and keymap...
Sep  1 22:07:46 ubuntu systemd[1]: Starting Initial cloud-init job (pre-networking)...
Sep  1 22:07:46 ubuntu systemd[1]: Starting Create Volatile Files and Directories...
Sep  1 22:07:46 ubuntu systemd[1]: Starting Tell Plymouth To Write Out Runtime Data...
Sep  1 22:07:46 ubuntu systemd-tmpfiles[464]: [/usr/lib/tmpfiles.d/var.conf:14] Duplicate line for path "/var/log", ignoring.
Sep  1 22:07:46 ubuntu systemd[1]: Starting Commit a transient machine-id on disk...
Sep  1 22:07:46 ubuntu systemd[1]: Starting LSB: AppArmor initialization...
Sep  1 22:07:46 ubuntu systemd[1]: Started Tell Plymouth To Write Out Runtime Data.
Sep  1 22:07:46 ubuntu systemd[1]: Started Commit a transient machine-id on disk.
Sep  1 22:07:46 ubuntu systemd[1]: Started Create Volatile Files and Directories.
Sep  1 22:07:46 ubuntu systemd[1]: Starting Update UTMP about System Boot/Shutdown...
Sep  1 22:07:46 ubuntu systemd[1]: Starting Network Time Synchronization...
Sep  1 22:07:46 ubuntu systemd[1]: Started Update UTMP about System Boot/Shutdown.
Sep  1 22:07:46 ubuntu systemd[1]: Found device /dev/ttyS0.
Sep  1 22:07:46 ubuntu systemd[1]: Started Network Time Synchronization.
Sep  1 22:07:46 ubuntu systemd[1]: Reached target System Time Synchronized.
Sep  1 22:07:46 ubuntu systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.
Sep  1 22:07:46 ubuntu apparmor[467]:  * Starting AppArmor profiles
Sep  1 22:07:46 ubuntu systemd[1]: Started Set console font and keymap.
Sep  1 22:07:46 ubuntu systemd[1]: Created slice system-getty.slice.
Sep  1 22:07:46 ubuntu apparmor[467]: Skipping profile in /etc/apparmor.d/disable: usr.sbin.rsyslogd
Sep  1 22:07:46 ubuntu apparmor[467]:    ...done.
Sep  1 22:07:46 ubuntu systemd[1]: Started LSB: AppArmor initialization.
Sep  1 22:07:46 ubuntu cloud-init[463]: Cloud-init v. 18.3-9-g2e62cb8a-0ubuntu1~16.04.2 running 'init-local' at Sat, 01 Sep 2018 22:07:36 +0000. Up 15.23 seconds.
Sep  1 22:07:46 ubuntu systemd[1]: Started Initial cloud-init job (pre-networking).
Sep  1 22:07:46 ubuntu systemd[1]: Reached target Network (Pre).
Sep  1 22:07:46 ubuntu systemd[1]: Starting Raise network interfaces...
Sep  1 22:07:46 ubuntu dhclient[807]: Internet Systems Consortium DHCP Client 4.3.3
Sep  1 22:07:46 ubuntu ifup[715]: Internet Systems Consortium DHCP Client 4.3.3
Sep  1 22:07:46 ubuntu dhclient[807]: Copyright 2004-2015 Internet Systems Consortium.
Sep  1 22:07:46 ubuntu ifup[715]: Copyright 2004-2015 Internet Systems Consortium.
Sep  1 22:07:46 ubuntu dhclient[807]: All rights reserved.
Sep  1 22:07:46 ubuntu ifup[715]: All rights reserved.
Sep  1 22:07:46 ubuntu dhclient[807]: For info, please visit https://www.isc.org/software/dhcp/
Sep  1 22:07:46 ubuntu ifup[715]: For info, please visit https://www.isc.org/software/dhcp/
Sep  1 22:07:46 ubuntu dhclient[807]: 
Sep  1 22:07:46 ubuntu dhclient[807]: Listening on LPF/ens2/ac:de:48:3c:44:b9
Sep  1 22:07:46 ubuntu ifup[715]: Listening on LPF/ens2/ac:de:48:3c:44:b9
Sep  1 22:07:46 ubuntu dhclient[807]: Sending on   LPF/ens2/ac:de:48:3c:44:b9
Sep  1 22:07:46 ubuntu ifup[715]: Sending on   LPF/ens2/ac:de:48:3c:44:b9
Sep  1 22:07:46 ubuntu dhclient[807]: Sending on   Socket/fallback
Sep  1 22:07:46 ubuntu ifup[715]: Sending on   Socket/fallback
Sep  1 22:07:46 ubuntu dhclient[807]: DHCPDISCOVER on ens2 to 255.255.255.255 port 67 interval 3 (xid=0xec399673)
Sep  1 22:07:46 ubuntu ifup[715]: DHCPDISCOVER on ens2 to 255.255.255.255 port 67 interval 3 (xid=0xec399673)
Sep  1 22:07:46 ubuntu dhclient[807]: DHCPREQUEST of 192.168.11.54 on ens2 to 255.255.255.255 port 67 (xid=0x739639ec)
Sep  1 22:07:46 ubuntu ifup[715]: DHCPREQUEST of 192.168.11.54 on ens2 to 255.255.255.255 port 67 (xid=0x739639ec)
Sep  1 22:07:46 ubuntu dhclient[807]: DHCPOFFER of 192.168.11.54 from 192.168.11.3
Sep  1 22:07:46 ubuntu ifup[715]: DHCPOFFER of 192.168.11.54 from 192.168.11.3
Sep  1 22:07:46 ubuntu dhclient[807]: DHCPACK of 192.168.11.54 from 192.168.11.3
Sep  1 22:07:46 ubuntu ifup[715]: DHCPACK of 192.168.11.54 from 192.168.11.3
Sep  1 22:07:46 ubuntu systemd[1]: Stopping Network Time Synchronization...
Sep  1 22:07:46 ubuntu kernel: [    0.000000] Linux version 4.15.0-33-generic (buildd@lgw01-amd64-010) (gcc version 5.4.0 20160609 (Ubuntu 5.4.0-6ubuntu1~16.04.10)) #36~16.04.1-Ubuntu SMP Wed Aug 15 17:21:05 UTC 2018 (Ubuntu 4.15.0-33.36~16.04.1-generic 4.15.18)
Sep  1 22:07:46 ubuntu kernel: [    0.000000] Command line: BOOT_IMAGE=/boot/vmlinuz-4.15.0-33-generic root=UUID=4e0b126d-f842-4ae8-bd4b-7ebf2cd44df6 ro console=tty1 console=ttyS0
Sep  1 22:07:46 ubuntu kernel: [    0.000000] KERNEL supported cpus:
Sep  1 22:07:46 ubuntu kernel: [    0.000000]   Intel GenuineIntel
Sep  1 22:07:46 ubuntu kernel: [    0.000000]   AMD AuthenticAMD
Sep  1 22:07:46 ubuntu kernel: [    0.000000]   Centaur CentaurHauls
Sep  1 22:07:46 ubuntu kernel: [    0.000000] x86/fpu: x87 FPU will use FXSAVE
Sep  1 22:07:46 ubuntu kernel: [    0.000000] e820: BIOS-provided physical RAM map:
Sep  1 22:07:46 ubuntu kernel: [    0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable
Sep  1 22:07:46 ubuntu kernel: [    0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved
Sep  1 22:07:46 ubuntu kernel: [    0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved
Sep  1 22:07:46 ubuntu kernel: [    0.000000] BIOS-e820: [mem 0x0000000000100000-0x00000000bffdbfff] usable
Sep  1 22:07:46 ubuntu kernel: [    0.000000] BIOS-e820: [mem 0x00000000bffdc000-0x00000000bfffffff] reserved
Sep  1 22:07:46 ubuntu kernel: [    0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved
Sep  1 22:07:46 ubuntu kernel: [    0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved
Sep  1 22:07:46 ubuntu kernel: [    0.000000] BIOS-e820: [mem 0x0000000100000000-0x000000033fffffff] usable
Sep  1 22:07:46 ubuntu kernel: [    0.000000] NX (Execute Disable) protection: active
Sep  1 22:07:46 ubuntu kernel: [    0.000000] SMBIOS 2.8 present.
Sep  1 22:07:46 ubuntu kernel: [    0.000000] DMI: QEMU Standard PC (i440FX + PIIX, 1996), BIOS 1.10.2-1ubuntu1~cloud0 04/01/2014
Sep  1 22:07:46 ubuntu kernel: [    0.000000] Hypervisor detected: KVM
Sep  1 22:07:46 ubuntu kernel: [    0.000000] e820: update [mem 0x00000000-0x00000fff] usable ==> reserved
Sep  1 22:07:46 ubuntu kernel: [    0.000000] e820: remove [mem 0x000a0000-0x000fffff] usable
Sep  1 22:07:46 ubuntu kernel: [    0.000000] e820: last_pfn = 0x340000 max_arch_pfn = 0x400000000
Sep  1 22:07:46 ubuntu kernel: [    0.000000] MTRR default type: write-back
Sep  1 22:07:46 ubuntu kernel: [    0.000000] MTRR fixed ranges enabled:
Sep  1 22:07:46 ubuntu kernel: [    0.000000]   00000-9FFFF write-back
Sep  1 22:07:46 ubuntu kernel: [    0.000000]   A0000-BFFFF uncachable
Sep  1 22:07:46 ubuntu kernel: [    0.000000]   C0000-FFFFF write-protect
Sep  1 22:07:46 ubuntu kernel: [    0.000000] MTRR variable ranges enabled:
Sep  1 22:07:46 ubuntu kernel: [    0.000000]   0 base 00C0000000 mask FFC0000000 uncachable
Sep  1 22:07:46 ubuntu kernel: [    0.000000]   1 disabled
Sep  1 22:07:46 ubuntu kernel: [    0.000000]   2 disabled
Sep  1 22:07:46 ubuntu kernel: [    0.000000]   3 disabled
Sep  1 22:07:46 ubuntu kernel: [    0.000000]   4 disabled
Sep  1 22:07:46 ubuntu kernel: [    0.000000]   5 disabled
Sep  1 22:07:46 ubuntu kernel: [    0.000000]   6 disabled
Sep  1 22:07:46 ubuntu kernel: [    0.000000]   7 disabled
Sep  1 22:07:46 ubuntu kernel: [    0.000000] x86/PAT: PAT not supported by CPU.
Sep  1 22:07:46 ubuntu kernel: [    0.000000] x86/PAT: Configuration [0-7]: WB  WT  UC- UC  WB  WT  UC- UC  
Sep  1 22:07:46 ubuntu kernel: [    0.000000] e820: last_pfn = 0xbffdc max_arch_pfn = 0x400000000
Sep  1 22:07:46 ubuntu kernel: [    0.000000] found SMP MP-table at [mem 0x000f69f0-0x000f69ff] mapped at [        (ptrval)]
Sep  1 22:07:46 ubuntu kernel: [    0.000000] Scanning 1 areas for low memory corruption
Sep  1 22:07:46 ubuntu kernel: [    0.000000] Base memory trampoline at [        (ptrval)] 99000 size 24576
Sep  1 22:07:46 ubuntu kernel: [    0.000000] BRK [0x2fd73d000, 0x2fd73dfff] PGTABLE
Sep  1 22:07:46 ubuntu kernel: [    0.000000] BRK [0x2fd73e000, 0x2fd73efff] PGTABLE
Sep  1 22:07:46 ubuntu kernel: [    0.000000] BRK [0x2fd73f000, 0x2fd73ffff] PGTABLE
Sep  1 22:07:46 ubuntu kernel: [    0.000000] BRK [0x2fd740000, 0x2fd740fff] PGTABLE
Sep  1 22:07:46 ubuntu kernel: [    0.000000] BRK [0x2fd741000, 0x2fd741fff] PGTABLE
Sep  1 22:07:46 ubuntu kernel: [    0.000000] BRK [0x2fd742000, 0x2fd742fff] PGTABLE
Sep  1 22:07:46 ubuntu kernel: [    0.000000] BRK [0x2fd743000, 0x2fd743fff] PGTABLE
Sep  1 22:07:46 ubuntu kernel: [    0.000000] BRK [0x2fd744000, 0x2fd744fff] PGTABLE
Sep  1 22:07:46 ubuntu kernel: [    0.000000] RAMDISK: [mem 0x318ea000-0x34c6cfff]
Sep  1 22:07:46 ubuntu kernel: [    0.000000] ACPI: Early table checksum verification disabled
Sep  1 22:07:46 ubuntu kernel: [    0.000000] ACPI: RSDP 0x00000000000F69A0 000014 (v00 BOCHS )
Sep  1 22:07:46 ubuntu kernel: [    0.000000] ACPI: RSDT 0x00000000BFFE142B 000030 (v01 BOCHS  BXPCRSDT 00000001 BXPC 00000001)
Sep  1 22:07:46 ubuntu kernel: [    0.000000] ACPI: FACP 0x00000000BFFE126F 000074 (v01 BOCHS  BXPCFACP 00000001 BXPC 00000001)
Sep  1 22:07:46 ubuntu kernel: [    0.000000] ACPI: DSDT 0x00000000BFFDFD80 0014EF (v01 BOCHS  BXPCDSDT 00000001 BXPC 00000001)
Sep  1 22:07:46 ubuntu kernel: [    0.000000] ACPI: FACS 0x00000000BFFDFD40 000040
Sep  1 22:07:46 ubuntu kernel: [    0.000000] ACPI: APIC 0x00000000BFFE1363 000090 (v01 BOCHS  BXPCAPIC 00000001 BXPC 00000001)
Sep  1 22:07:46 ubuntu kernel: [    0.000000] ACPI: HPET 0x00000000BFFE13F3 000038 (v01 BOCHS  BXPCHPET 00000001 BXPC 00000001)
Sep  1 22:07:46 ubuntu kernel: [    0.000000] ACPI: Local APIC address 0xfee00000
Sep  1 22:07:46 ubuntu kernel: [    0.000000] No NUMA configuration found
Sep  1 22:07:46 ubuntu kernel: [    0.000000] Faking a node at [mem 0x0000000000000000-0x000000033fffffff]
Sep  1 22:07:46 ubuntu kernel: [    0.000000] NODE_DATA(0) allocated [mem 0x33ffcd000-0x33fff7fff]
Sep  1 22:07:46 ubuntu kernel: [    0.000000] kvm-clock: cpu 0, msr 3:3ff4c001, primary cpu clock
Sep  1 22:07:46 ubuntu kernel: [    0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00
Sep  1 22:07:46 ubuntu kernel: [    0.000000] kvm-clock: using sched offset of 2515878406 cycles
Sep  1 22:07:46 ubuntu kernel: [    0.000000] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns
Sep  1 22:07:46 ubuntu kernel: [    0.000000] Zone ranges:
Sep  1 22:07:46 ubuntu kernel: [    0.000000]   DMA      [mem 0x0000000000001000-0x0000000000ffffff]
Sep  1 22:07:46 ubuntu kernel: [    0.000000]   DMA32    [mem 0x0000000001000000-0x00000000ffffffff]
Sep  1 22:07:46 ubuntu kernel: [    0.000000]   Normal   [mem 0x0000000100000000-0x000000033fffffff]
Sep  1 22:07:46 ubuntu kernel: [    0.000000]   Device   empty
Sep  1 22:07:46 ubuntu kernel: [    0.000000] Movable zone start for each node
Sep  1 22:07:46 ubuntu kernel: [    0.000000] Early memory node ranges
Sep  1 22:07:46 ubuntu kernel: [    0.000000]   node   0: [mem 0x0000000000001000-0x000000000009efff]
Sep  1 22:07:46 ubuntu kernel: [    0.000000]   node   0: [mem 0x0000000000100000-0x00000000bffdbfff]
Sep  1 22:07:46 ubuntu kernel: [    0.000000]   node   0: [mem 0x0000000100000000-0x000000033fffffff]
Sep  1 22:07:46 ubuntu kernel: [    0.000000] Initmem setup node 0 [mem 0x0000000000001000-0x000000033fffffff]
Sep  1 22:07:46 ubuntu kernel: [    0.000000] On node 0 totalpages: 3145594
Sep  1 22:07:46 ubuntu kernel: [    0.000000]   DMA zone: 64 pages used for memmap
Sep  1 22:07:46 ubuntu kernel: [    0.000000]   DMA zone: 21 pages reserved
Sep  1 22:07:46 ubuntu kernel: [    0.000000]   DMA zone: 3998 pages, LIFO batch:0
Sep  1 22:07:46 ubuntu kernel: [    0.000000]   DMA32 zone: 12224 pages used for memmap
Sep  1 22:07:46 ubuntu kernel: [    0.000000]   DMA32 zone: 782300 pages, LIFO batch:31
Sep  1 22:07:46 ubuntu kernel: [    0.000000]   Normal zone: 36864 pages used for memmap
Sep  1 22:07:46 ubuntu kernel: [    0.000000]   Normal zone: 2359296 pages, LIFO batch:31
Sep  1 22:07:46 ubuntu kernel: [    0.000000] Reserved but unavailable: 98 pages
Sep  1 22:07:46 ubuntu kernel: [    0.000000] ACPI: PM-Timer IO Port: 0x608
Sep  1 22:07:46 ubuntu kernel: [    0.000000] ACPI: Local APIC address 0xfee00000
Sep  1 22:07:46 ubuntu kernel: [    0.000000] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1])
Sep  1 22:07:46 ubuntu kernel: [    0.000000] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23
Sep  1 22:07:46 ubuntu kernel: [    0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl)
Sep  1 22:07:46 ubuntu kernel: [    0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level)
Sep  1 22:07:46 ubuntu kernel: [    0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level)
Sep  1 22:07:46 ubuntu kernel: [    0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level)
Sep  1 22:07:46 ubuntu kernel: [    0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level)
Sep  1 22:07:46 ubuntu kernel: [    0.000000] ACPI: IRQ0 used by override.
Sep  1 22:07:46 ubuntu kernel: [    0.000000] ACPI: IRQ5 used by override.
Sep  1 22:07:46 ubuntu kernel: [    0.000000] ACPI: IRQ9 used by override.
Sep  1 22:07:46 ubuntu kernel: [    0.000000] ACPI: IRQ10 used by override.
Sep  1 22:07:46 ubuntu kernel: [    0.000000] ACPI: IRQ11 used by override.
Sep  1 22:07:46 ubuntu kernel: [    0.000000] Using ACPI (MADT) for SMP configuration information
Sep  1 22:07:46 ubuntu kernel: [    0.000000] ACPI: HPET id: 0x8086a201 base: 0xfed00000
Sep  1 22:07:46 ubuntu kernel: [    0.000000] smpboot: Allowing 4 CPUs, 0 hotplug CPUs
Sep  1 22:07:46 ubuntu kernel: [    0.000000] PM: Registered nosave memory: [mem 0x00000000-0x00000fff]
Sep  1 22:07:46 ubuntu kernel: [    0.000000] PM: Registered nosave memory: [mem 0x0009f000-0x0009ffff]
Sep  1 22:07:46 ubuntu kernel: [    0.000000] PM: Registered nosave memory: [mem 0x000a0000-0x000effff]
Sep  1 22:07:46 ubuntu kernel: [    0.000000] PM: Registered nosave memory: [mem 0x000f0000-0x000fffff]
Sep  1 22:07:46 ubuntu kernel: [    0.000000] PM: Registered nosave memory: [mem 0xbffdc000-0xbfffffff]
Sep  1 22:07:46 ubuntu kernel: [    0.000000] PM: Registered nosave memory: [mem 0xc0000000-0xfeffbfff]
Sep  1 22:07:46 ubuntu kernel: [    0.000000] PM: Registered nosave memory: [mem 0xfeffc000-0xfeffffff]
Sep  1 22:07:46 ubuntu kernel: [    0.000000] PM: Registered nosave memory: [mem 0xff000000-0xfffbffff]
Sep  1 22:07:46 ubuntu kernel: [    0.000000] PM: Registered nosave memory: [mem 0xfffc0000-0xffffffff]
Sep  1 22:07:46 ubuntu kernel: [    0.000000] e820: [mem 0xc0000000-0xfeffbfff] available for PCI devices
Sep  1 22:07:46 ubuntu kernel: [    0.000000] Booting paravirtualized kernel on KVM
Sep  1 22:07:46 ubuntu kernel: [    0.000000] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645519600211568 ns
Sep  1 22:07:46 ubuntu kernel: [    0.000000] random: get_random_bytes called from start_kernel+0x99/0x51b with crng_init=0
Sep  1 22:07:46 ubuntu kernel: [    0.000000] setup_percpu: NR_CPUS:8192 nr_cpumask_bits:4 nr_cpu_ids:4 nr_node_ids:1
Sep  1 22:07:46 ubuntu kernel: [    0.000000] percpu: Embedded 46 pages/cpu @        (ptrval) s151552 r8192 d28672 u524288
Sep  1 22:07:46 ubuntu kernel: [    0.000000] pcpu-alloc: s151552 r8192 d28672 u524288 alloc=1*2097152
Sep  1 22:07:46 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 ]
Sep  1 22:07:46 ubuntu rsyslogd-2007: action 'action 11' suspended, next retry is Sat Sep  1 22:08:16 2018 [v8.16.0 try http://www.rsyslog.com/e/2007 ]
Sep  1 22:07:46 ubuntu systemd[1]: Stopped Network Time Synchronization.
Sep  1 22:07:46 ubuntu systemd[1]: Starting Network Time Synchronization...
Sep  1 22:07:46 ubuntu systemd[1]: Started Network Time Synchronization.
Sep  1 22:07:46 ubuntu kernel: [    0.000000] pcpu-alloc: [0] 0 1 2 3 
Sep  1 22:07:46 ubuntu kernel: [    0.000000] KVM setup async PF for cpu 0
Sep  1 22:07:46 ubuntu dhclient[807]: bound to 192.168.11.54 -- renewal in 282 seconds.
Sep  1 22:07:46 ubuntu kernel: [    0.000000] kvm-stealtime: cpu 0, msr 33fc24040
Sep  1 22:07:46 ubuntu kernel: [    0.000000] Built 1 zonelists, mobility grouping on.  Total pages: 3096421
Sep  1 22:07:46 ubuntu kernel: [    0.000000] Policy zone: Normal
Sep  1 22:07:46 ubuntu ifup[715]: bound to 192.168.11.54 -- renewal in 282 seconds.
Sep  1 22:07:46 ubuntu kernel: [    0.000000] Kernel command line: BOOT_IMAGE=/boot/vmlinuz-4.15.0-33-generic root=UUID=4e0b126d-f842-4ae8-bd4b-7ebf2cd44df6 ro console=tty1 console=ttyS0
Sep  1 22:07:46 ubuntu kernel: [    0.000000] Calgary: detecting Calgary via BIOS EBDA area
Sep  1 22:07:46 ubuntu kernel: [    0.000000] Calgary: Unable to locate Rio Grande table in EBDA - bailing!
Sep  1 22:07:46 ubuntu kernel: [    0.000000] Memory: 12237528K/12582376K available (12300K kernel code, 2469K rwdata, 4252K rodata, 2404K init, 2416K bss, 344848K reserved, 0K cma-reserved)
Sep  1 22:07:46 ubuntu kernel: [    0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1
Sep  1 22:07:46 ubuntu kernel: [    0.000000] Kernel/User page tables isolation: enabled
Sep  1 22:07:46 ubuntu systemd[1]: Started Raise network interfaces.
Sep  1 22:07:46 ubuntu kernel: [    0.000000] ftrace: allocating 39127 entries in 153 pages
Sep  1 22:07:46 ubuntu systemd[1]: Reached target Network.
Sep  1 22:07:46 ubuntu kernel: [    0.004000] Hierarchical RCU implementation.
Sep  1 22:07:46 ubuntu kernel: [    0.004000] 	RCU restricting CPUs from NR_CPUS=8192 to nr_cpu_ids=4.
Sep  1 22:07:46 ubuntu kernel: [    0.004000] 	Tasks RCU enabled.
Sep  1 22:07:46 ubuntu systemd[1]: Starting Initial cloud-init job (metadata service crawler)...
Sep  1 22:07:46 ubuntu cloud-init[948]: Cloud-init v. 18.3-9-g2e62cb8a-0ubuntu1~16.04.2 running 'init' at Sat, 01 Sep 2018 22:07:40 +0000. Up 19.10 seconds.
Sep  1 22:07:46 ubuntu cloud-init[948]: ci-info: +++++++++++++++++++++++++++++++++++++++Net device info++++++++++++++++++++++++++++++++++++++++
Sep  1 22:07:46 ubuntu cloud-init[948]: ci-info: +--------+-------+------------------------------+---------------+--------+-------------------+
Sep  1 22:07:46 ubuntu cloud-init[948]: ci-info: | Device |   Up  |           Address            |      Mask     | Scope  |     Hw-Address    |
Sep  1 22:07:46 ubuntu cloud-init[948]: ci-info: +--------+-------+------------------------------+---------------+--------+-------------------+
Sep  1 22:07:46 ubuntu cloud-init[948]: ci-info: |  ens2  |  True |        192.168.11.54         | 255.255.255.0 | global | ac:de:48:3c:44:b9 |
Sep  1 22:07:46 ubuntu cloud-init[948]: ci-info: |  ens2  |  True | fe80::aede:48ff:fe3c:44b9/64 |       .       |  link  | ac:de:48:3c:44:b9 |
Sep  1 22:07:46 ubuntu cloud-init[948]: ci-info: |  ens3  | False |              .               |       .       |   .    | ac:de:48:a0:e6:43 |
Sep  1 22:07:46 ubuntu cloud-init[948]: ci-info: |   lo   |  True |          127.0.0.1           |   255.0.0.0   |  host  |         .         |
Sep  1 22:07:46 ubuntu cloud-init[948]: ci-info: |   lo   |  True |           ::1/128            |       .       |  host  |         .         |
Sep  1 22:07:46 ubuntu cloud-init[948]: ci-info: +--------+-------+------------------------------+---------------+--------+-------------------+
Sep  1 22:07:46 ubuntu cloud-init[948]: ci-info: ++++++++++++++++++++++++++++++Route IPv4 info++++++++++++++++++++++++++++++
Sep  1 22:07:46 ubuntu cloud-init[948]: ci-info: +-------+--------------+--------------+---------------+-----------+-------+
Sep  1 22:07:46 ubuntu cloud-init[948]: ci-info: | Route | Destination  |   Gateway    |    Genmask    | Interface | Flags |
Sep  1 22:07:46 ubuntu cloud-init[948]: ci-info: +-------+--------------+--------------+---------------+-----------+-------+
Sep  1 22:07:46 ubuntu cloud-init[948]: ci-info: |   0   |   0.0.0.0    | 192.168.11.3 |    0.0.0.0    |    ens2   |   UG  |
Sep  1 22:07:46 ubuntu cloud-init[948]: ci-info: |   1   | 192.168.11.0 |   0.0.0.0    | 255.255.255.0 |    ens2   |   U   |
Sep  1 22:07:46 ubuntu cloud-init[948]: ci-info: +-------+--------------+--------------+---------------+-----------+-------+
Sep  1 22:07:46 ubuntu cloud-init[948]: ci-info: +++++++++++++++++++Route IPv6 info+++++++++++++++++++
Sep  1 22:07:46 ubuntu kernel: [    0.004000] RCU: Adjusting geometry for rcu_fanout_leaf=16, nr_cpu_ids=4
Sep  1 22:07:46 ubuntu cloud-init[948]: ci-info: +-------+-------------+---------+-----------+-------+
Sep  1 22:07:46 ubuntu kernel: [    0.004000] NR_IRQS: 524544, nr_irqs: 456, preallocated irqs: 16
Sep  1 22:07:46 ubuntu cloud-init[948]: ci-info: | Route | Destination | Gateway | Interface | Flags |
Sep  1 22:07:46 ubuntu kernel: [    0.004000] Console: colour VGA+ 80x25
Sep  1 22:07:46 ubuntu cloud-init[948]: ci-info: +-------+-------------+---------+-----------+-------+
Sep  1 22:07:46 ubuntu kernel: [    0.004000] console [tty1] enabled
Sep  1 22:07:46 ubuntu kernel: [    0.004000] console [ttyS0] enabled
Sep  1 22:07:46 ubuntu kernel: [    0.004000] ACPI: Core revision 20170831
Sep  1 22:07:46 ubuntu kernel: [    0.004000] ACPI: 1 ACPI AML tables successfully acquired and loaded
Sep  1 22:07:46 ubuntu cloud-init[948]: ci-info: |   0   |  fe80::/64  |    ::   |    ens2   |   U   |
Sep  1 22:07:46 ubuntu kernel: [    0.004000] clocksource: hpet: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604467 ns
Sep  1 22:07:46 ubuntu kernel: [    0.004000] hpet clockevent registered
Sep  1 22:07:46 ubuntu cloud-init[948]: ci-info: |   2   |    local    |    ::   |    ens2   |   U   |
Sep  1 22:07:46 ubuntu kernel: [    0.004004] APIC: Switch to symmetric I/O mode setup
Sep  1 22:07:46 ubuntu kernel: [    0.005028] x2apic enabled
Sep  1 22:07:46 ubuntu cloud-init[948]: ci-info: |   3   |   ff00::/8  |    ::   |    ens2   |   U   |
Sep  1 22:07:46 ubuntu kernel: [    0.005706] Switched APIC routing to physical x2apic.
Sep  1 22:07:46 ubuntu kernel: [    0.007300] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1
Sep  1 22:07:46 ubuntu cloud-init[948]: ci-info: +-------+-------------+---------+-----------+-------+
Sep  1 22:07:46 ubuntu kernel: [    0.008000] tsc: Detected 3491.912 MHz processor
Sep  1 22:07:46 ubuntu kernel: [    0.008000] Calibrating delay loop (skipped) preset value.. 6983.82 BogoMIPS (lpj=13967648)
Sep  1 22:07:46 ubuntu cloud-init[948]: Generating public/private rsa key pair.
Sep  1 22:07:46 ubuntu kernel: [    0.008000] pid_max: default: 32768 minimum: 301
Sep  1 22:07:46 ubuntu kernel: [    0.008000] Security Framework initialized
Sep  1 22:07:46 ubuntu kernel: [    0.008002] Yama: becoming mindful.
Sep  1 22:07:46 ubuntu kernel: [    0.008640] AppArmor: AppArmor initialized
Sep  1 22:07:46 ubuntu cloud-init[948]: Your identification has been saved in /etc/ssh/ssh_host_rsa_key.
Sep  1 22:07:46 ubuntu kernel: [    0.013854] Dentry cache hash table entries: 2097152 (order: 12, 16777216 bytes)
Sep  1 22:07:46 ubuntu cloud-init[948]: Your public key has been saved in /etc/ssh/ssh_host_rsa_key.pub.
Sep  1 22:07:46 ubuntu kernel: [    0.017265] Inode-cache hash table entries: 1048576 (order: 11, 8388608 bytes)
Sep  1 22:07:46 ubuntu kernel: [    0.018535] Mount-cache hash table entries: 32768 (order: 6, 262144 bytes)
Sep  1 22:07:46 ubuntu kernel: [    0.020019] Mountpoint-cache hash table entries: 32768 (order: 6, 262144 bytes)
Sep  1 22:07:46 ubuntu kernel: [    0.021894] mce: CPU supports 10 MCE banks
Sep  1 22:07:46 ubuntu kernel: [    0.022654] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0
Sep  1 22:07:46 ubuntu cloud-init[948]: The key fingerprint is:
Sep  1 22:07:46 ubuntu kernel: [    0.023631] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0
Sep  1 22:07:46 ubuntu cloud-init[948]: SHA256:UoKNoLSjLMK61PFUNeS/LdU8dMD5pOEPTw9XbsO9v/Y root@ubuntu
Sep  1 22:07:46 ubuntu kernel: [    0.024002] Spectre V2 : Mitigation: Full generic retpoline
Sep  1 22:07:46 ubuntu kernel: [    0.025058] Speculative Store Bypass: Vulnerable
Sep  1 22:07:46 ubuntu kernel: [    0.026032] Freeing SMP alternatives memory: 36K
Sep  1 22:07:46 ubuntu kernel: [    0.032000] smpboot: CPU0: Intel QEMU Virtual CPU version 2.5+ (family: 0x6, model: 0x6, stepping: 0x3)
Sep  1 22:07:46 ubuntu kernel: [    0.032000] Performance Events: PMU not available due to virtualization, using software events only.
Sep  1 22:07:46 ubuntu kernel: [    0.032030] Hierarchical SRCU implementation.
Sep  1 22:07:46 ubuntu kernel: [    0.033330] NMI watchdog: Perf event create on CPU 0 failed with -2
Sep  1 22:07:46 ubuntu cloud-init[948]: The key's randomart image is:
Sep  1 22:07:46 ubuntu kernel: [    0.034532] NMI watchdog: Perf NMI watchdog permanently disabled
Sep  1 22:07:46 ubuntu kernel: [    0.035641] smp: Bringing up secondary CPUs ...
Sep  1 22:07:46 ubuntu kernel: [    0.036067] x86: Booting SMP configuration:
Sep  1 22:07:46 ubuntu cloud-init[948]: +---[RSA 2048]----+
Sep  1 22:07:46 ubuntu kernel: [    0.036852] .... node  #0, CPUs:      #1
Sep  1 22:07:46 ubuntu kernel: [    0.004000] kvm-clock: cpu 1, msr 3:3ff4c041, secondary cpu clock
Sep  1 22:07:46 ubuntu kernel: [    0.044043] KVM setup async PF for cpu 1
Sep  1 22:07:46 ubuntu cloud-init[948]: | ..     .+   ... |
Sep  1 22:07:46 ubuntu kernel: [    0.044987] kvm-stealtime: cpu 1, msr 33fca4040
Sep  1 22:07:46 ubuntu kernel: [    0.046031]  #2
Sep  1 22:07:46 ubuntu cloud-init[948]: |.... +  o .   +.o|
Sep  1 22:07:46 ubuntu cloud-init[948]: |.o  o o...   ..B+|
Sep  1 22:07:46 ubuntu cloud-init[948]: |+ .   .o  .   OoO|
Sep  1 22:07:46 ubuntu cloud-init[948]: |+o . .. S  . . %+|
Sep  1 22:07:46 ubuntu cloud-init[948]: |+ . +  .    +  .=|
Sep  1 22:07:46 ubuntu cloud-init[948]: |.. . .     o .  .|
Sep  1 22:07:46 ubuntu cloud-init[948]: |..          .  ..|
Sep  1 22:07:46 ubuntu cloud-init[948]: |.             ..E|
Sep  1 22:07:46 ubuntu cloud-init[948]: +----[SHA256]-----+
Sep  1 22:07:46 ubuntu cloud-init[948]: Generating public/private dsa key pair.
Sep  1 22:07:46 ubuntu cloud-init[948]: Your identification has been saved in /etc/ssh/ssh_host_dsa_key.
Sep  1 22:07:46 ubuntu cloud-init[948]: Your public key has been saved in /etc/ssh/ssh_host_dsa_key.pub.
Sep  1 22:07:46 ubuntu cloud-init[948]: The key fingerprint is:
Sep  1 22:07:46 ubuntu cloud-init[948]: SHA256:nHeh22QGCP4zBhMGKiaemh9Es00g4A1ekbVbJHO2WOc root@ubuntu
Sep  1 22:07:46 ubuntu cloud-init[948]: The key's randomart image is:
Sep  1 22:07:46 ubuntu kernel: [    0.004000] kvm-clock: cpu 2, msr 3:3ff4c081, secondary cpu clock
Sep  1 22:07:46 ubuntu cloud-init[948]: +---[DSA 1024]----+
Sep  1 22:07:46 ubuntu cloud-init[948]: |+..o==+= .       |
Sep  1 22:07:46 ubuntu cloud-init[948]: |o.++ oXo+.       |
Sep  1 22:07:46 ubuntu kernel: [    0.052030] KVM setup async PF for cpu 2
Sep  1 22:07:46 ubuntu cloud-init[948]: |o++..o+o.E. .    |
Sep  1 22:07:46 ubuntu kernel: [    0.052684] kvm-stealtime: cpu 2, msr 33fd24040
Sep  1 22:07:46 ubuntu cloud-init[948]: |+o.=  o= . o .   |
Sep  1 22:07:46 ubuntu kernel: [    0.053637]  #3
Sep  1 22:07:46 ubuntu cloud-init[948]: | oo ..  S o =    |
Sep  1 22:07:46 ubuntu kernel: [    0.004000] kvm-clock: cpu 3, msr 3:3ff4c0c1, secondary cpu clock
Sep  1 22:07:46 ubuntu cloud-init[948]: |.o     . + B     |
Sep  1 22:07:46 ubuntu kernel: [    0.060025] KVM setup async PF for cpu 3
Sep  1 22:07:46 ubuntu kernel: [    0.060833] kvm-stealtime: cpu 3, msr 33fda4040
Sep  1 22:07:46 ubuntu cloud-init[948]: |o .       . .    |
Sep  1 22:07:46 ubuntu kernel: [    0.061896] smp: Brought up 1 node, 4 CPUs
Sep  1 22:07:46 ubuntu cloud-init[948]: | . .             |
Sep  1 22:07:46 ubuntu kernel: [    0.061896] smpboot: Max logical packages: 4
Sep  1 22:07:46 ubuntu kernel: [    0.064004] smpboot: Total of 4 processors activated (27935.29 BogoMIPS)
Sep  1 22:07:46 ubuntu kernel: [    0.065961] devtmpfs: initialized
Sep  1 22:07:46 ubuntu kernel: [    0.065961] x86/mm: Memory block size: 128MB
Sep  1 22:07:46 ubuntu cloud-init[948]: |  .              |
Sep  1 22:07:46 ubuntu kernel: [    0.068741] evm: security.selinux
Sep  1 22:07:46 ubuntu kernel: [    0.069513] evm: security.SMACK64
Sep  1 22:07:46 ubuntu kernel: [    0.070229] evm: security.SMACK64EXEC
Sep  1 22:07:46 ubuntu cloud-init[948]: +----[SHA256]-----+
Sep  1 22:07:46 ubuntu cloud-init[948]: Generating public/private ecdsa key pair.
Sep  1 22:07:46 ubuntu kernel: [    0.071011] evm: security.SMACK64TRANSMUTE
Sep  1 22:07:46 ubuntu cloud-init[948]: Your identification has been saved in /etc/ssh/ssh_host_ecdsa_key.
Sep  1 22:07:46 ubuntu kernel: [    0.072003] evm: security.SMACK64MMAP
Sep  1 22:07:46 ubuntu cloud-init[948]: Your public key has been saved in /etc/ssh/ssh_host_ecdsa_key.pub.
Sep  1 22:07:46 ubuntu kernel: [    0.072651] evm: security.apparmor
Sep  1 22:07:46 ubuntu kernel: [    0.073260] evm: security.ima
Sep  1 22:07:46 ubuntu cloud-init[948]: The key fingerprint is:
Sep  1 22:07:46 ubuntu kernel: [    0.073793] evm: security.capability
Sep  1 22:07:46 ubuntu kernel: [    0.074463] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns
Sep  1 22:07:46 ubuntu cloud-init[948]: SHA256:1tQPH0aMINVgoCUzzrvulxqMRKVmweEHQrzF6QOezcM root@ubuntu
Sep  1 22:07:46 ubuntu kernel: [    0.076008] futex hash table entries: 1024 (order: 4, 65536 bytes)
Sep  1 22:07:46 ubuntu cloud-init[948]: The key's randomart image is:
Sep  1 22:07:46 ubuntu cloud-init[948]: +---[ECDSA 256]---+
Sep  1 22:07:46 ubuntu kernel: [    0.077113] pinctrl core: initialized pinctrl subsystem
Sep  1 22:07:46 ubuntu cloud-init[948]: | ooo+o= +o=+ o.  |
Sep  1 22:07:46 ubuntu kernel: [    0.078574] RTC time: 22:07:21, date: 09/01/18
Sep  1 22:07:46 ubuntu kernel: [    0.080161] NET: Registered protocol family 16
Sep  1 22:07:46 ubuntu cloud-init[948]: |  oo=B * o .o..  |
Sep  1 22:07:46 ubuntu kernel: [    0.080993] audit: initializing netlink subsys (disabled)
Sep  1 22:07:46 ubuntu cloud-init[948]: | . X* =   . o o  |
Sep  1 22:07:46 ubuntu kernel: [    0.081941] audit: type=2000 audit(1535839642.580:1): state=initialized audit_enabled=0 res=1
Sep  1 22:07:46 ubuntu kernel: [    0.084010] cpuidle: using governor ladder
Sep  1 22:07:46 ubuntu kernel: [    0.084796] cpuidle: using governor menu
Sep  1 22:07:46 ubuntu cloud-init[948]: |  ++E. . o   = . |
Sep  1 22:07:46 ubuntu kernel: [    0.085655] ACPI: bus type PCI registered
Sep  1 22:07:46 ubuntu kernel: [    0.086393] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5
Sep  1 22:07:46 ubuntu kernel: [    0.088090] PCI: Using configuration type 1 for base access
Sep  1 22:07:46 ubuntu cloud-init[948]: |    .o. S .   o  |
Sep  1 22:07:46 ubuntu kernel: [    0.089087] HugeTLB registered 2.00 MiB page size, pre-allocated 0 pages
Sep  1 22:07:46 ubuntu kernel: [    0.092070] ACPI: Added _OSI(Module Device)
Sep  1 22:07:46 ubuntu kernel: [    0.092793] ACPI: Added _OSI(Processor Device)
Sep  1 22:07:46 ubuntu kernel: [    0.093689] ACPI: Added _OSI(3.0 _SCP Extensions)
Sep  1 22:07:46 ubuntu kernel: [    0.094636] ACPI: Added _OSI(Processor Aggregator Device)
Sep  1 22:07:46 ubuntu cloud-init[948]: |   . o o         |
Sep  1 22:07:46 ubuntu kernel: [    0.096003] ACPI: Added _OSI(Linux-Dell-Video)
Sep  1 22:07:46 ubuntu kernel: [    0.098039] ACPI: Interpreter enabled
Sep  1 22:07:46 ubuntu cloud-init[948]: |    . +  .       |
Sep  1 22:07:46 ubuntu kernel: [    0.098739] ACPI: (supports S0 S3 S4 S5)
Sep  1 22:07:46 ubuntu kernel: [    0.099464] ACPI: Using IOAPIC for interrupt routing
Sep  1 22:07:46 ubuntu kernel: [    0.100013] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug
Sep  1 22:07:46 ubuntu kernel: [    0.101719] ACPI: Enabled 2 GPEs in block 00 to 0F
Sep  1 22:07:46 ubuntu cloud-init[948]: |     . .o        |
Sep  1 22:07:46 ubuntu kernel: [    0.105375] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])
Sep  1 22:07:46 ubuntu kernel: [    0.106624] acpi PNP0A03:00: _OSC: OS supports [ASPM ClockPM Segments MSI]
Sep  1 22:07:46 ubuntu kernel: [    0.108006] acpi PNP0A03:00: _OSC failed (AE_NOT_FOUND); disabling ASPM
Sep  1 22:07:46 ubuntu cloud-init[948]: |     .+o         |
Sep  1 22:07:46 ubuntu kernel: [    0.109420] acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended PCI configuration space under this bridge.
Sep  1 22:07:46 ubuntu kernel: [    0.112109] acpiphp: Slot [2] registered
Sep  1 22:07:46 ubuntu cloud-init[948]: +----[SHA256]-----+
Sep  1 22:07:46 ubuntu kernel: [    0.112994] acpiphp: Slot [3] registered
Sep  1 22:07:46 ubuntu kernel: [    0.113888] acpiphp: Slot [4] registered
Sep  1 22:07:46 ubuntu kernel: [    0.114769] acpiphp: Slot [5] registered
Sep  1 22:07:46 ubuntu cloud-init[948]: Generating public/private ed25519 key pair.
Sep  1 22:07:46 ubuntu kernel: [    0.115649] acpiphp: Slot [6] registered
Sep  1 22:07:46 ubuntu kernel: [    0.116029] acpiphp: Slot [7] registered
Sep  1 22:07:46 ubuntu cloud-init[948]: Your identification has been saved in /etc/ssh/ssh_host_ed25519_key.
Sep  1 22:07:46 ubuntu kernel: [    0.116885] acpiphp: Slot [8] registered
Sep  1 22:07:46 ubuntu kernel: [    0.117732] acpiphp: Slot [9] registered
Sep  1 22:07:46 ubuntu cloud-init[948]: Your public key has been saved in /etc/ssh/ssh_host_ed25519_key.pub.
Sep  1 22:07:46 ubuntu kernel: [    0.118574] acpiphp: Slot [10] registered
Sep  1 22:07:46 ubuntu kernel: [    0.119426] acpiphp: Slot [11] registered
Sep  1 22:07:46 ubuntu kernel: [    0.120028] acpiphp: Slot [12] registered
Sep  1 22:07:46 ubuntu kernel: [    0.120887] acpiphp: Slot [13] registered
Sep  1 22:07:46 ubuntu cloud-init[948]: The key fingerprint is:
Sep  1 22:07:46 ubuntu kernel: [    0.121747] acpiphp: Slot [14] registered
Sep  1 22:07:46 ubuntu kernel: [    0.122596] acpiphp: Slot [15] registered
Sep  1 22:07:46 ubuntu kernel: [    0.124027] acpiphp: Slot [16] registered
Sep  1 22:07:46 ubuntu kernel: [    0.124889] acpiphp: Slot [17] registered
Sep  1 22:07:46 ubuntu kernel: [    0.125756] acpiphp: Slot [18] registered
Sep  1 22:07:46 ubuntu kernel: [    0.126606] acpiphp: Slot [19] registered
Sep  1 22:07:46 ubuntu kernel: [    0.127464] acpiphp: Slot [20] registered
Sep  1 22:07:46 ubuntu cloud-init[948]: SHA256:KLNutI5OdS8ITJAxK9XHQewdwxa7wOCGHAy+zjMr8SY root@ubuntu
Sep  1 22:07:46 ubuntu kernel: [    0.128028] acpiphp: Slot [21] registered
Sep  1 22:07:46 ubuntu kernel: [    0.128903] acpiphp: Slot [22] registered
Sep  1 22:07:46 ubuntu kernel: [    0.129782] acpiphp: Slot [23] registered
Sep  1 22:07:46 ubuntu kernel: [    0.130652] acpiphp: Slot [24] registered
Sep  1 22:07:46 ubuntu kernel: [    0.132019] acpiphp: Slot [25] registered
Sep  1 22:07:46 ubuntu kernel: [    0.132890] acpiphp: Slot [26] registered
Sep  1 22:07:46 ubuntu kernel: [    0.133756] acpiphp: Slot [27] registered
Sep  1 22:07:46 ubuntu cloud-init[948]: The key's randomart image is:
Sep  1 22:07:46 ubuntu kernel: [    0.134627] acpiphp: Slot [28] registered
Sep  1 22:07:46 ubuntu cloud-init[948]: +--[ED25519 256]--+
Sep  1 22:07:46 ubuntu kernel: [    0.135491] acpiphp: Slot [29] registered
Sep  1 22:07:46 ubuntu kernel: [    0.136027] acpiphp: Slot [30] registered
Sep  1 22:07:46 ubuntu cloud-init[948]: |==o..+oo..       |
Sep  1 22:07:46 ubuntu kernel: [    0.136899] acpiphp: Slot [31] registered
Sep  1 22:07:46 ubuntu kernel: [    0.137748] PCI host bridge to bus 0000:00
Sep  1 22:07:46 ubuntu kernel: [    0.138599] pci_bus 0000:00: root bus resource [io  0x0000-0x0cf7 window]
Sep  1 22:07:46 ubuntu cloud-init[948]: |o*.+.o+ =.       |
Sep  1 22:07:46 ubuntu cloud-init[948]: |o.+ oooo.o       |
Sep  1 22:07:46 ubuntu cloud-init[948]: |.o..  .o..       |
Sep  1 22:07:46 ubuntu cloud-init[948]: | .o + o S        |
Sep  1 22:07:46 ubuntu cloud-init[948]: |+  o.* .         |
Sep  1 22:07:46 ubuntu cloud-init[948]: | B..o.. .        |
Sep  1 22:07:46 ubuntu cloud-init[948]: |E.*oo  .         |
Sep  1 22:07:46 ubuntu cloud-init[948]: |.=ooo            |
Sep  1 22:07:46 ubuntu cloud-init[948]: +----[SHA256]-----+
Sep  1 22:07:46 ubuntu systemd[1]: Started Initial cloud-init job (metadata service crawler).
Sep  1 22:07:46 ubuntu systemd[1]: Reached target Cloud-config availability.
Sep  1 22:07:46 ubuntu systemd[1]: Reached target Network is Online.
Sep  1 22:07:46 ubuntu systemd[1]: Starting iSCSI initiator daemon (iscsid)...
Sep  1 22:07:46 ubuntu systemd[1]: Reached target System Initialization.
Sep  1 22:07:46 ubuntu systemd[1]: Starting Socket activation for snappy daemon.
Sep  1 22:07:46 ubuntu kernel: [    0.140002] pci_bus 0000:00: root bus resource [io  0x0d00-0xffff window]
Sep  1 22:07:46 ubuntu systemd[1]: Started Daily Cleanup of Temporary Directories.
Sep  1 22:07:46 ubuntu kernel: [    0.141385] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window]
Sep  1 22:07:46 ubuntu kernel: [    0.142890] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window]
Sep  1 22:07:46 ubuntu systemd[1]: Listening on D-Bus System Message Bus Socket.
Sep  1 22:07:46 ubuntu kernel: [    0.144002] pci_bus 0000:00: root bus resource [mem 0x340000000-0x3bfffffff window]
Sep  1 22:07:46 ubuntu kernel: [    0.145549] pci_bus 0000:00: root bus resource [bus 00-ff]
Sep  1 22:07:46 ubuntu kernel: [    0.146687] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000
Sep  1 22:07:46 ubuntu kernel: [    0.147007] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100
Sep  1 22:07:46 ubuntu kernel: [    0.148111] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180
Sep  1 22:07:46 ubuntu kernel: [    0.150011] pci 0000:00:01.1: reg 0x20: [io  0xc0e0-0xc0ef]
Sep  1 22:07:46 ubuntu systemd[1]: Started Daily apt download activities.
Sep  1 22:07:46 ubuntu kernel: [    0.150771] pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io  0x01f0-0x01f7]
Sep  1 22:07:46 ubuntu kernel: [    0.152003] pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io  0x03f6]
Sep  1 22:07:46 ubuntu systemd[1]: Started Daily apt upgrade and clean activities.
Sep  1 22:07:46 ubuntu kernel: [    0.153398] pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io  0x0170-0x0177]
Sep  1 22:07:46 ubuntu systemd[1]: Listening on UUID daemon activation socket.
Sep  1 22:07:46 ubuntu kernel: [    0.154914] pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io  0x0376]
Sep  1 22:07:46 ubuntu systemd[1]: Starting LXD - unix socket.
Sep  1 22:07:46 ubuntu kernel: [    0.156127] pci 0000:00:01.2: [8086:7020] type 00 class 0x0c0300
Sep  1 22:07:46 ubuntu systemd[1]: Listening on ACPID Listen Socket.
Sep  1 22:07:46 ubuntu kernel: [    0.159036] pci 0000:00:01.2: reg 0x20: [io  0xc040-0xc05f]
Sep  1 22:07:46 ubuntu systemd[1]: Started ACPI Events Check.
Sep  1 22:07:46 ubuntu kernel: [    0.160288] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000
Sep  1 22:07:46 ubuntu kernel: [    0.160580] pci 0000:00:01.3: quirk: [io  0x0600-0x063f] claimed by PIIX4 ACPI
Sep  1 22:07:46 ubuntu systemd[1]: Reached target Paths.
Sep  1 22:07:46 ubuntu kernel: [    0.162180] pci 0000:00:01.3: quirk: [io  0x0700-0x070f] claimed by PIIX4 SMB
Sep  1 22:07:46 ubuntu kernel: [    0.163963] pci 0000:00:02.0: [1af4:1000] type 00 class 0x020000
Sep  1 22:07:46 ubuntu kernel: [    0.164889] pci 0000:00:02.0: reg 0x10: [io  0xc060-0xc07f]
Sep  1 22:07:46 ubuntu systemd[1]: Reached target Timers.
Sep  1 22:07:46 ubuntu kernel: [    0.165658] pci 0000:00:02.0: reg 0x14: [mem 0xfeb80000-0xfeb80fff]
Sep  1 22:07:46 ubuntu kernel: [    0.168618] pci 0000:00:02.0: reg 0x20: [mem 0xfebec000-0xfebeffff 64bit pref]
Sep  1 22:07:46 ubuntu kernel: [    0.169798] pci 0000:00:02.0: reg 0x30: [mem 0xfea80000-0xfeafffff pref]
Sep  1 22:07:46 ubuntu kernel: [    0.171426] pci 0000:00:03.0: [1af4:1000] type 00 class 0x020000
Sep  1 22:07:46 ubuntu systemd[1]: Listening on Socket activation for snappy daemon.
Sep  1 22:07:46 ubuntu systemd[1]: Listening on LXD - unix socket.
Sep  1 22:07:46 ubuntu kernel: [    0.172436] pci 0000:00:03.0: reg 0x10: [io  0xc080-0xc09f]
Sep  1 22:07:46 ubuntu systemd[1]: Reached target Sockets.
Sep  1 22:07:46 ubuntu kernel: [    0.173320] pci 0000:00:03.0: reg 0x14: [mem 0xfeb81000-0xfeb81fff]
Sep  1 22:07:46 ubuntu systemd[1]: Reached target Basic System.
Sep  1 22:07:46 ubuntu kernel: [    0.176003] pci 0000:00:03.0: reg 0x20: [mem 0xfebf0000-0xfebf3fff 64bit pref]
Sep  1 22:07:46 ubuntu kernel: [    0.177060] pci 0000:00:03.0: reg 0x30: [mem 0xfeb00000-0xfeb7ffff pref]
Sep  1 22:07:46 ubuntu systemd[1]: Started Regular background program processing daemon.
Sep  1 22:07:46 ubuntu kernel: [    0.177586] pci 0000:00:04.0: [1af4:1001] type 00 class 0x010000
Sep  1 22:07:46 ubuntu systemd[1]: Starting System Logging Service...
Sep  1 22:07:46 ubuntu kernel: [    0.179140] pci 0000:00:04.0: reg 0x10: [io  0xc000-0xc03f]
Sep  1 22:07:46 ubuntu kernel: [    0.180903] pci 0000:00:04.0: reg 0x14: [mem 0xfeb82000-0xfeb82fff]
Sep  1 22:07:46 ubuntu kernel: [    0.187278] pci 0000:00:04.0: reg 0x20: [mem 0xfebf4000-0xfebf7fff 64bit pref]
Sep  1 22:07:46 ubuntu systemd[1]: Starting Accounts Service...
Sep  1 22:07:46 ubuntu kernel: [    0.188610] pci 0000:00:05.0: [1af4:1002] type 00 class 0x00ff00
Sep  1 22:07:46 ubuntu kernel: [    0.189524] pci 0000:00:05.0: reg 0x10: [io  0xc0a0-0xc0bf]
Sep  1 22:07:46 ubuntu kernel: [    0.192719] pci 0000:00:05.0: reg 0x20: [mem 0xfebf8000-0xfebfbfff 64bit pref]
Sep  1 22:07:46 ubuntu kernel: [    0.195697] pci 0000:00:06.0: [1af4:1005] type 00 class 0x00ff00
Sep  1 22:07:46 ubuntu cron[1085]: (CRON) INFO (pidfile fd = 3)
Sep  1 22:07:46 ubuntu kernel: [    0.196507] pci 0000:00:06.0: reg 0x10: [io  0xc0c0-0xc0df]
Sep  1 22:07:46 ubuntu kernel: [    0.198650] pci 0000:00:06.0: reg 0x20: [mem 0xfebfc000-0xfebfffff 64bit pref]
Sep  1 22:07:46 ubuntu systemd[1]: Starting The Salt Minion...
Sep  1 22:07:46 ubuntu kernel: [    0.200011] ACPI: PCI Interrupt Link [LNKA] (IRQs 5 *10 11)
Sep  1 22:07:46 ubuntu kernel: [    0.201172] ACPI: PCI Interrupt Link [LNKB] (IRQs 5 *10 11)
Sep  1 22:07:46 ubuntu kernel: [    0.202265] ACPI: PCI Interrupt Link [LNKC] (IRQs 5 10 *11)
Sep  1 22:07:46 ubuntu systemd[1]: Starting Login Service...
Sep  1 22:07:46 ubuntu kernel: [    0.203344] ACPI: PCI Interrupt Link [LNKD] (IRQs 5 10 *11)
Sep  1 22:07:46 ubuntu kernel: [    0.204043] ACPI: PCI Interrupt Link [LNKS] (IRQs *9)
Sep  1 22:07:46 ubuntu kernel: [    0.205445] SCSI subsystem initialized
Sep  1 22:07:46 ubuntu kernel: [    0.206846] libata version 3.00 loaded.
Sep  1 22:07:46 ubuntu iscsid: iSCSI logger with pid=1110 started!
Sep  1 22:07:46 ubuntu systemd[1]: Starting LSB: MD monitoring daemon...
Sep  1 22:07:46 ubuntu systemd[1]: Started ACPI event daemon.
Sep  1 22:07:46 ubuntu kernel: [    0.206846] vgaarb: loaded
Sep  1 22:07:46 ubuntu systemd[1]: Starting LSB: Record successful boot for GRUB...
Sep  1 22:07:46 ubuntu kernel: [    0.206846] ACPI: bus type USB registered
Sep  1 22:07:46 ubuntu kernel: [    0.208026] usbcore: registered new interface driver usbfs
Sep  1 22:07:46 ubuntu systemd[1]: Started Deferred execution scheduler.
Sep  1 22:07:46 ubuntu kernel: [    0.209055] usbcore: registered new interface driver hub
Sep  1 22:07:46 ubuntu systemd[1]: Started D-Bus System Message Bus.
Sep  1 22:07:46 ubuntu cron[1085]: (CRON) INFO (Running @reboot jobs)
Sep  1 22:07:46 ubuntu kernel: [    0.210027] usbcore: registered new device driver usb
Sep  1 22:07:46 ubuntu acpid: starting up with netlink and the input layer
Sep  1 22:07:46 ubuntu kernel: [    0.210999] EDAC MC: Ver: 3.0.0
Sep  1 22:07:46 ubuntu kernel: [    0.212157] PCI: Using ACPI for IRQ routing
Sep  1 22:07:46 ubuntu kernel: [    0.212810] PCI: pci_cache_line_size set to 64 bytes
Sep  1 22:07:46 ubuntu acpid: 1 rule loaded
Sep  1 22:07:46 ubuntu kernel: [    0.212924] e820: reserve RAM buffer [mem 0x0009fc00-0x0009ffff]
Sep  1 22:07:46 ubuntu acpid: waiting for events: event logging is off
Sep  1 22:07:46 ubuntu kernel: [    0.212925] e820: reserve RAM buffer [mem 0xbffdc000-0xbfffffff]
Sep  1 22:07:46 ubuntu kernel: [    0.213014] NetLabel: Initializing
Sep  1 22:07:46 ubuntu kernel: [    0.213651] NetLabel:  domain hash size = 128
Sep  1 22:07:46 ubuntu kernel: [    0.214465] NetLabel:  protocols = UNLABELED CIPSOv4 CALIPSO
Sep  1 22:07:46 ubuntu kernel: [    0.216015] NetLabel:  unlabeled traffic allowed by default
Sep  1 22:07:46 ubuntu kernel: [    0.217022] HPET: 3 timers in total, 0 timers will be used for per-cpu timer
Sep  1 22:07:46 ubuntu kernel: [    0.217612] hpet0: at MMIO 0xfed00000, IRQs 2, 8, 0
Sep  1 22:07:46 ubuntu kernel: [    0.218495] hpet0: 3 comparators, 64-bit 100.000000 MHz counter
Sep  1 22:07:46 ubuntu kernel: [    0.225045] clocksource: Switched to clocksource kvm-clock
Sep  1 22:07:46 ubuntu kernel: [    0.233730] VFS: Disk quotas dquot_6.6.0
Sep  1 22:07:46 ubuntu kernel: [    0.234534] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)
Sep  1 22:07:46 ubuntu kernel: [    0.235892] AppArmor: AppArmor Filesystem Enabled
Sep  1 22:07:46 ubuntu kernel: [    0.236805] pnp: PnP ACPI init
Sep  1 22:07:46 ubuntu kernel: [    0.237436] pnp 00:00: Plug and Play ACPI device, IDs PNP0b00 (active)
Sep  1 22:07:46 ubuntu kernel: [    0.237469] pnp 00:01: Plug and Play ACPI device, IDs PNP0303 (active)
Sep  1 22:07:46 ubuntu kernel: [    0.237488] pnp 00:02: Plug and Play ACPI device, IDs PNP0f13 (active)
Sep  1 22:07:46 ubuntu kernel: [    0.237497] pnp 00:03: [dma 2]
Sep  1 22:07:46 ubuntu kernel: [    0.237508] pnp 00:03: Plug and Play ACPI device, IDs PNP0700 (active)
Sep  1 22:07:46 ubuntu kernel: [    0.237579] pnp 00:04: Plug and Play ACPI device, IDs PNP0501 (active)
Sep  1 22:07:46 ubuntu kernel: [    0.237757] pnp: PnP ACPI: found 5 devices
Sep  1 22:07:46 ubuntu kernel: [    0.245640] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns
Sep  1 22:07:46 ubuntu kernel: [    0.247260] pci_bus 0000:00: resource 4 [io  0x0000-0x0cf7 window]
Sep  1 22:07:46 ubuntu kernel: [    0.247261] pci_bus 0000:00: resource 5 [io  0x0d00-0xffff window]
Sep  1 22:07:46 ubuntu kernel: [    0.247263] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window]
Sep  1 22:07:46 ubuntu kernel: [    0.247264] pci_bus 0000:00: resource 7 [mem 0xc0000000-0xfebfffff window]
Sep  1 22:07:46 ubuntu kernel: [    0.247265] pci_bus 0000:00: resource 8 [mem 0x340000000-0x3bfffffff window]
Sep  1 22:07:46 ubuntu kernel: [    0.247309] NET: Registered protocol family 2
Sep  1 22:07:46 ubuntu kernel: [    0.248253] TCP established hash table entries: 131072 (order: 8, 1048576 bytes)
Sep  1 22:07:46 ubuntu kernel: [    0.250203] TCP bind hash table entries: 65536 (order: 8, 1048576 bytes)
Sep  1 22:07:46 ubuntu kernel: [    0.251509] TCP: Hash tables configured (established 131072 bind 65536)
Sep  1 22:07:46 ubuntu kernel: [    0.252805] UDP hash table entries: 8192 (order: 6, 262144 bytes)
Sep  1 22:07:46 ubuntu kernel: [    0.253963] UDP-Lite hash table entries: 8192 (order: 6, 262144 bytes)
Sep  1 22:07:46 ubuntu kernel: [    0.255180] NET: Registered protocol family 1
Sep  1 22:07:46 ubuntu kernel: [    0.256019] pci 0000:00:00.0: Limiting direct PCI/PCI transfers
Sep  1 22:07:46 ubuntu kernel: [    0.257094] pci 0000:00:01.0: PIIX3: Enabling Passive Release
Sep  1 22:07:46 ubuntu kernel: [    0.258208] pci 0000:00:01.0: Activating ISA DMA hang workarounds
Sep  1 22:07:46 ubuntu kernel: [    0.279616] ACPI: PCI Interrupt Link [LNKD] enabled at IRQ 11
Sep  1 22:07:46 ubuntu kernel: [    0.301106] PCI: CLS 0 bytes, default 64
Sep  1 22:07:46 ubuntu kernel: [    0.301136] Unpacking initramfs...
Sep  1 22:07:46 ubuntu kernel: [    0.838359] Freeing initrd memory: 52748K
Sep  1 22:07:46 ubuntu kernel: [    0.839302] PCI-DMA: Using software bounce buffering for IO (SWIOTLB)
Sep  1 22:07:46 ubuntu kernel: [    0.841436] software IO TLB [mem 0xbbfdc000-0xbffdc000] (64MB) mapped at [        (ptrval)-        (ptrval)]
Sep  1 22:07:46 ubuntu kernel: [    0.844149] Scanning for low memory corruption every 60 seconds
Sep  1 22:07:46 ubuntu kernel: [    0.845868] Initialise system trusted keyrings
Sep  1 22:07:46 ubuntu kernel: [    0.846792] Key type blacklist registered
Sep  1 22:07:46 ubuntu kernel: [    0.847861] workingset: timestamp_bits=36 max_order=22 bucket_order=0
Sep  1 22:07:46 ubuntu kernel: [    0.853476] zbud: loaded
Sep  1 22:07:46 ubuntu kernel: [    0.855517] squashfs: version 4.0 (2009/01/31) Phillip Lougher
Sep  1 22:07:46 ubuntu kernel: [    0.857727] fuse init (API version 7.26)
Sep  1 22:07:46 ubuntu kernel: [    0.861871] Key type asymmetric registered
Sep  1 22:07:46 ubuntu kernel: [    0.863299] Asymmetric key parser 'x509' registered
Sep  1 22:07:46 ubuntu kernel: [    0.864392] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 246)
Sep  1 22:07:46 ubuntu kernel: [    0.866219] io scheduler noop registered
Sep  1 22:07:46 ubuntu kernel: [    0.867183] io scheduler deadline registered
Sep  1 22:07:46 ubuntu kernel: [    0.868276] io scheduler cfq registered (default)
Sep  1 22:07:46 ubuntu kernel: [    0.869693] intel_idle: does not run on family 6 model 6
Sep  1 22:07:46 ubuntu kernel: [    0.869767] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input0
Sep  1 22:07:46 ubuntu kernel: [    0.871588] ACPI: Power Button [PWRF]
Sep  1 22:07:46 ubuntu kernel: [    0.894361] ACPI: PCI Interrupt Link [LNKB] enabled at IRQ 10
Sep  1 22:07:46 ubuntu kernel: [    0.918160] ACPI: PCI Interrupt Link [LNKC] enabled at IRQ 11
Sep  1 22:07:46 ubuntu kernel: [    0.964021] ACPI: PCI Interrupt Link [LNKA] enabled at IRQ 10
Sep  1 22:07:46 ubuntu kernel: [    0.989199] Serial: 8250/16550 driver, 32 ports, IRQ sharing enabled
Sep  1 22:07:46 ubuntu kernel: [    1.013311] 00:04: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A
Sep  1 22:07:46 ubuntu kernel: [    1.016740] Linux agpgart interface v0.103
Sep  1 22:07:46 ubuntu kernel: [    1.019642] loop: module loaded
Sep  1 22:07:46 ubuntu kernel: [    1.020505] ata_piix 0000:00:01.1: version 2.13
Sep  1 22:07:46 ubuntu kernel: [    1.021144] scsi host0: ata_piix
Sep  1 22:07:46 ubuntu kernel: [    1.022080] scsi host1: ata_piix
Sep  1 22:07:46 ubuntu kernel: [    1.022919] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc0e0 irq 14
Sep  1 22:07:46 ubuntu kernel: [    1.024365] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc0e8 irq 15
Sep  1 22:07:46 ubuntu kernel: [    1.025684] libphy: Fixed MDIO Bus: probed
Sep  1 22:07:46 ubuntu kernel: [    1.026746] tun: Universal TUN/TAP device driver, 1.6
Sep  1 22:07:46 ubuntu kernel: [    1.027951] PPP generic driver version 2.4.2
Sep  1 22:07:46 ubuntu kernel: [    1.028952] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver
Sep  1 22:07:46 ubuntu kernel: [    1.030296] ehci-pci: EHCI PCI platform driver
Sep  1 22:07:46 ubuntu kernel: [    1.031271] ehci-platform: EHCI generic platform driver
Sep  1 22:07:46 ubuntu kernel: [    1.032369] ohci_hcd: USB 1.1 'Open' Host Controller (OHCI) Driver
Sep  1 22:07:46 ubuntu kernel: [    1.033643] ohci-pci: OHCI PCI platform driver
Sep  1 22:07:46 ubuntu kernel: [    1.034483] ohci-platform: OHCI generic platform driver
Sep  1 22:07:46 ubuntu kernel: [    1.035242] uhci_hcd: USB Universal Host Controller Interface driver
Sep  1 22:07:46 ubuntu kernel: [    1.057638] uhci_hcd 0000:00:01.2: UHCI Host Controller
Sep  1 22:07:46 ubuntu kernel: [    1.058821] uhci_hcd 0000:00:01.2: new USB bus registered, assigned bus number 1
Sep  1 22:07:46 ubuntu kernel: [    1.060475] uhci_hcd 0000:00:01.2: detected 2 ports
Sep  1 22:07:46 ubuntu kernel: [    1.061648] uhci_hcd 0000:00:01.2: irq 11, io base 0x0000c040
Sep  1 22:07:46 ubuntu kernel: [    1.062967] usb usb1: New USB device found, idVendor=1d6b, idProduct=0001
Sep  1 22:07:46 ubuntu kernel: [    1.064464] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1
Sep  1 22:07:46 ubuntu kernel: [    1.066061] usb usb1: Product: UHCI Host Controller
Sep  1 22:07:46 ubuntu kernel: [    1.067170] usb usb1: Manufacturer: Linux 4.15.0-33-generic uhci_hcd
Sep  1 22:07:46 ubuntu kernel: [    1.068692] usb usb1: SerialNumber: 0000:00:01.2
Sep  1 22:07:46 ubuntu kernel: [    1.069954] hub 1-0:1.0: USB hub found
Sep  1 22:07:46 ubuntu kernel: [    1.070900] hub 1-0:1.0: 2 ports detected
Sep  1 22:07:46 ubuntu kernel: [    1.071969] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12
Sep  1 22:07:46 ubuntu kernel: [    1.074050] serio: i8042 KBD port at 0x60,0x64 irq 1
Sep  1 22:07:46 ubuntu kernel: [    1.075002] serio: i8042 AUX port at 0x60,0x64 irq 12
Sep  1 22:07:46 ubuntu kernel: [    1.076149] mousedev: PS/2 mouse device common for all mice
Sep  1 22:07:46 ubuntu kernel: [    1.077469] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input1
Sep  1 22:07:46 ubuntu kernel: [    1.079201] rtc_cmos 00:00: RTC can wake from S4
Sep  1 22:07:46 ubuntu kernel: [    1.080462] rtc_cmos 00:00: rtc core: registered rtc_cmos as rtc0
Sep  1 22:07:46 ubuntu kernel: [    1.081693] rtc_cmos 00:00: alarms up to one day, y3k, 114 bytes nvram, hpet irqs
Sep  1 22:07:46 ubuntu kernel: [    1.083143] i2c /dev entries driver
Sep  1 22:07:46 ubuntu kernel: [    1.083850] device-mapper: uevent: version 1.0.3
Sep  1 22:07:46 ubuntu kernel: [    1.084904] device-mapper: ioctl: 4.37.0-ioctl (2017-09-20) initialised: dm-devel@redhat.com
Sep  1 22:07:46 ubuntu kernel: [    1.086656] ledtrig-cpu: registered to indicate activity on CPUs
Sep  1 22:07:46 ubuntu kernel: [    1.088157] NET: Registered protocol family 10
Sep  1 22:07:46 ubuntu kernel: [    1.096750] Segment Routing with IPv6
Sep  1 22:07:46 ubuntu kernel: [    1.097629] NET: Registered protocol family 17
Sep  1 22:07:46 ubuntu kernel: [    1.098499] Key type dns_resolver registered
Sep  1 22:07:46 ubuntu kernel: [    1.099791] RAS: Correctable Errors collector initialized.
Sep  1 22:07:46 ubuntu kernel: [    1.100848] sched_clock: Marking stable (1100830061, 0)->(1512472923, -411642862)
Sep  1 22:07:46 ubuntu kernel: [    1.102471] registered taskstats version 1
Sep  1 22:07:46 ubuntu kernel: [    1.103332] Loading compiled-in X.509 certificates
Sep  1 22:07:46 ubuntu kernel: [    1.108062] Loaded X.509 cert 'Build time autogenerated kernel key: d918b280ed158d77154089242222928ec1ab43e6'
Sep  1 22:07:46 ubuntu kernel: [    1.110284] zswap: loaded using pool lzo/zbud
Sep  1 22:07:46 ubuntu kernel: [    1.117365] Key type big_key registered
Sep  1 22:07:46 ubuntu kernel: [    1.118289] Key type trusted registered
Sep  1 22:07:46 ubuntu kernel: [    1.121515] Key type encrypted registered
Sep  1 22:07:46 ubuntu kernel: [    1.122544] AppArmor: AppArmor sha1 policy hashing enabled
Sep  1 22:07:46 ubuntu kernel: [    1.123911] ima: No TPM chip found, activating TPM-bypass! (rc=-19)
Sep  1 22:07:46 ubuntu kernel: [    1.125407] evm: HMAC attrs: 0x1
Sep  1 22:07:46 ubuntu kernel: [    1.126631]   Magic number: 2:492:147
Sep  1 22:07:46 ubuntu kernel: [    1.127585] acpi device:18: hash matches
Sep  1 22:07:46 ubuntu kernel: [    1.128716] rtc_cmos 00:00: setting system clock to 2018-09-01 22:07:22 UTC (1535839642)
Sep  1 22:07:46 ubuntu kernel: [    1.130708] BIOS EDD facility v0.16 2004-Jun-25, 0 devices found
Sep  1 22:07:46 ubuntu kernel: [    1.132210] EDD information not available.
Sep  1 22:07:46 ubuntu kernel: [    1.189957] Freeing unused kernel memory: 2404K
Sep  1 22:07:46 ubuntu kernel: [    1.200093] Write protecting the kernel read-only data: 20480k
Sep  1 22:07:46 ubuntu kernel: [    1.203158] Freeing unused kernel memory: 2008K
Sep  1 22:07:46 ubuntu kernel: [    1.211651] Freeing unused kernel memory: 1892K
Sep  1 22:07:46 ubuntu kernel: [    1.217493] x86/mm: Checked W+X mappings: passed, no W+X pages found.
Sep  1 22:07:46 ubuntu kernel: [    1.219231] x86/mm: Checking user space page tables
Sep  1 22:07:46 ubuntu kernel: [    1.224790] x86/mm: Checked W+X mappings: passed, no W+X pages found.
Sep  1 22:07:46 ubuntu kernel: [    1.247271] random: systemd-udevd: uninitialized urandom read (16 bytes read)
Sep  1 22:07:46 ubuntu kernel: [    1.249111] random: udevadm: uninitialized urandom read (16 bytes read)
Sep  1 22:07:46 ubuntu kernel: [    1.249156] random: udevadm: uninitialized urandom read (16 bytes read)
Sep  1 22:07:46 ubuntu kernel: [    1.312637] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input4
Sep  1 22:07:46 ubuntu kernel: [    1.315980] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input3
Sep  1 22:07:46 ubuntu kernel: [    1.328306] FDC 0 is a S82078B
Sep  1 22:07:46 ubuntu kernel: [    1.337019] virtio_net virtio0 ens2: renamed from eth0
Sep  1 22:07:46 ubuntu kernel: [    1.360568] virtio_net virtio1 ens3: renamed from eth1
Sep  1 22:07:46 ubuntu kernel: [    1.368407]  vda: vda1
Sep  1 22:07:46 ubuntu kernel: [    1.856277] tsc: Refined TSC clocksource calibration: 3491.918 MHz
Sep  1 22:07:46 ubuntu kernel: [    1.859261] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x32557e011f1, max_idle_ns: 440795267134 ns
Sep  1 22:07:46 ubuntu kernel: [    2.716026] raid6: sse2x1   gen() 10191 MB/s
Sep  1 22:07:46 ubuntu kernel: [    2.764019] raid6: sse2x1   xor()  8354 MB/s
Sep  1 22:07:46 ubuntu kernel: [    2.812023] raid6: sse2x2   gen() 13228 MB/s
Sep  1 22:07:46 ubuntu kernel: [    2.860018] raid6: sse2x2   xor()  9161 MB/s
Sep  1 22:07:46 ubuntu kernel: [    2.908023] raid6: sse2x4   gen() 15021 MB/s
Sep  1 22:07:46 ubuntu kernel: [    2.956023] raid6: sse2x4   xor() 10165 MB/s
Sep  1 22:07:46 ubuntu kernel: [    2.956899] raid6: using algorithm sse2x4 gen() 15021 MB/s
Sep  1 22:07:46 ubuntu kernel: [    2.957974] raid6: .... xor() 10165 MB/s, rmw enabled
Sep  1 22:07:46 ubuntu kernel: [    2.958975] raid6: using intx1 recovery algorithm
Sep  1 22:07:46 ubuntu kernel: [    2.960785] xor: measuring software checksum speed
Sep  1 22:07:46 ubuntu kernel: [    3.000020]    prefetch64-sse: 22420.000 MB/sec
Sep  1 22:07:46 ubuntu kernel: [    3.040017]    generic_sse: 20536.000 MB/sec
Sep  1 22:07:46 ubuntu kernel: [    3.040847] xor: using function: prefetch64-sse (22420.000 MB/sec)
Sep  1 22:07:46 ubuntu kernel: [    3.042891] async_tx: api initialized (async)
Sep  1 22:07:46 ubuntu kernel: [    3.084464] Btrfs loaded, crc32c=crc32c-generic
Sep  1 22:07:46 ubuntu kernel: [    3.421150] EXT4-fs (vda1): mounted filesystem with ordered data mode. Opts: (null)
Sep  1 22:07:46 ubuntu kernel: [    4.395045] random: fast init done
Sep  1 22:07:46 ubuntu kernel: [    6.835562] EXT4-fs (vda1): re-mounted. Opts: (null)
Sep  1 22:07:46 ubuntu kernel: [    6.995418] Loading iSCSI transport class v2.0-870.
Sep  1 22:07:46 ubuntu kernel: [    7.228047] iscsi: registered transport (tcp)
Sep  1 22:07:46 ubuntu kernel: [    7.602035] iscsi: registered transport (iser)
Sep  1 22:07:46 ubuntu kernel: [    8.918385] random: crng init done
Sep  1 22:07:46 ubuntu kernel: [    8.918388] random: 7 urandom warning(s) missed due to ratelimiting
Sep  1 22:07:46 ubuntu kernel: [    9.038390] piix4_smbus 0000:00:01.3: SMBus Host Controller at 0x700, revision 0
Sep  1 22:07:46 ubuntu kernel: [   10.590593] audit: type=1400 audit(1535839651.956:2): apparmor="STATUS" operation="profile_load" profile="unconfined" name="/usr/bin/lxc-start" pid=644 comm="apparmor_parser"
Sep  1 22:07:46 ubuntu kernel: [   10.650947] audit: type=1400 audit(1535839652.016:3): apparmor="STATUS" operation="profile_load" profile="unconfined" name="/usr/lib/lxd/lxd-bridge-proxy" pid=645 comm="apparmor_parser"
Sep  1 22:07:46 ubuntu kernel: [   10.749255] audit: type=1400 audit(1535839652.116:4): apparmor="STATUS" operation="profile_load" profile="unconfined" name="/sbin/dhclient" pid=643 comm="apparmor_parser"
Sep  1 22:07:46 ubuntu kernel: [   10.749548] audit: type=1400 audit(1535839652.116:5): apparmor="STATUS" operation="profile_load" profile="unconfined" name="/usr/lib/NetworkManager/nm-dhcp-client.action" pid=643 comm="apparmor_parser"
Sep  1 22:07:46 ubuntu kernel: [   10.749896] audit: type=1400 audit(1535839652.116:6): apparmor="STATUS" operation="profile_load" profile="unconfined" name="/usr/lib/NetworkManager/nm-dhcp-helper" pid=643 comm="apparmor_parser"
Sep  1 22:07:46 ubuntu kernel: [   10.750227] audit: type=1400 audit(1535839652.116:7): apparmor="STATUS" operation="profile_load" profile="unconfined" name="/usr/lib/connman/scripts/dhclient-script" pid=643 comm="apparmor_parser"
Sep  1 22:07:46 ubuntu kernel: [   10.783247] audit: type=1400 audit(1535839652.148:8): apparmor="STATUS" operation="profile_load" profile="unconfined" name="lxc-container-default" pid=646 comm="apparmor_parser"
Sep  1 22:07:46 ubuntu kernel: [   10.783701] audit: type=1400 audit(1535839652.148:9): apparmor="STATUS" operation="profile_load" profile="unconfined" name="lxc-container-default-cgns" pid=646 comm="apparmor_parser"
Sep  1 22:07:46 ubuntu kernel: [   10.784142] audit: type=1400 audit(1535839652.152:10): apparmor="STATUS" operation="profile_load" profile="unconfined" name="lxc-container-default-with-mounting" pid=646 comm="apparmor_parser"
Sep  1 22:07:46 ubuntu kernel: [   10.784607] audit: type=1400 audit(1535839652.152:11): apparmor="STATUS" operation="profile_load" profile="unconfined" name="lxc-container-default-with-nesting" pid=646 comm="apparmor_parser"
Sep  1 22:07:46 ubuntu kernel: [   21.022724] EXT4-fs (vda1): resizing filesystem from 576000 to 12799739 blocks
Sep  1 22:07:46 ubuntu kernel: [   22.246926] EXT4-fs (vda1): resized filesystem to 12799739
Sep  1 22:07:46 ubuntu dbus[1151]: [system] AppArmor D-Bus mediation is enabled
Sep  1 22:07:46 ubuntu systemd[1]: Started Unattended Upgrades Shutdown.
Sep  1 22:07:46 ubuntu systemd[1]: Starting Thermal Daemon Service...
Sep  1 22:07:46 ubuntu systemd[1]: Starting LXD - container startup/shutdown...
Sep  1 22:07:46 ubuntu systemd[1]: Starting Pollinate to seed the pseudo random number generator...
Sep  1 22:07:46 ubuntu systemd[1]: Starting Snappy daemon...
Sep  1 22:07:46 ubuntu systemd[1]: Starting /etc/rc.local Compatibility...
Sep  1 22:07:46 ubuntu systemd[1]: Started FUSE filesystem for LXC.
Sep  1 22:07:46 ubuntu systemd[1]: Started System Logging Service.
Sep  1 22:07:46 ubuntu systemd[1]: Started iSCSI initiator daemon (iscsid).
Sep  1 22:07:46 ubuntu systemd[1]: Started /etc/rc.local Compatibility.
Sep  1 22:07:46 ubuntu systemd[1]: Starting Login to default iSCSI targets...
Sep  1 22:07:46 ubuntu mdadm[1117]:  * Starting MD monitoring service mdadm --monitor
Sep  1 22:07:46 ubuntu systemd[1]: Started Login Service.
Sep  1 22:07:46 ubuntu iscsiadm[1257]: iscsiadm: No records found
Sep  1 22:07:46 ubuntu kernel: [   25.622744] new mount options do not match the existing superblock, will be ignored
Sep  1 22:07:47 ubuntu mdadm[1117]:    ...done.
Sep  1 22:07:47 ubuntu systemd[1]: Started Login to default iSCSI targets.
Sep  1 22:07:47 ubuntu systemd[1]: Started LSB: MD monitoring daemon.
Sep  1 22:07:47 ubuntu lxcfs[1237]: hierarchies:
Sep  1 22:07:47 ubuntu lxcfs[1237]:   0: fd:   5: devices
Sep  1 22:07:47 ubuntu lxcfs[1237]:   1: fd:   6: hugetlb
Sep  1 22:07:47 ubuntu lxcfs[1237]:   2: fd:   7: perf_event
Sep  1 22:07:47 ubuntu lxcfs[1237]:   3: fd:   8: cpuset
Sep  1 22:07:47 ubuntu lxcfs[1237]:   4: fd:   9: cpu,cpuacct
Sep  1 22:07:47 ubuntu lxcfs[1237]:   5: fd:  10: freezer
Sep  1 22:07:47 ubuntu lxcfs[1237]:   6: fd:  11: blkio
Sep  1 22:07:47 ubuntu lxcfs[1237]:   7: fd:  12: pids
Sep  1 22:07:47 ubuntu lxcfs[1237]:   8: fd:  13: rdma
Sep  1 22:07:47 ubuntu lxcfs[1237]:   9: fd:  14: memory
Sep  1 22:07:47 ubuntu lxcfs[1237]:  10: fd:  15: net_cls,net_prio
Sep  1 22:07:47 ubuntu lxcfs[1237]:  11: fd:  16: name=systemd
Sep  1 22:07:47 ubuntu systemd[1]: Reached target Remote File Systems (Pre).
Sep  1 22:07:47 ubuntu systemd[1]: Reached target Remote File Systems.
Sep  1 22:07:47 ubuntu systemd[1]: Starting LSB: automatic crash report generation...
Sep  1 22:07:47 ubuntu systemd[1]: Starting Permit User Sessions...
Sep  1 22:07:47 ubuntu systemd[1]: Starting LSB: daemon to balance interrupts for SMP systems...
Sep  1 22:07:47 ubuntu dbus[1151]: [system] Activating via systemd: service name='org.freedesktop.PolicyKit1' unit='polkitd.service'
Sep  1 22:07:47 ubuntu systemd[1]: Starting LSB: Set the CPU Frequency Scaling governor to "ondemand"...
Sep  1 22:07:47 ubuntu systemd[1]: Starting Authenticate and Authorize Users to Run Privileged Tasks...
Sep  1 22:07:47 ubuntu systemd[1]: Started LSB: Set the CPU Frequency Scaling governor to "ondemand".
Sep  1 22:07:47 ubuntu systemd[1]: Started Permit User Sessions.
Sep  1 22:07:47 ubuntu systemd[1]: Starting Terminate Plymouth Boot Screen...
Sep  1 22:07:47 ubuntu systemd[1]: Starting Hold until boot process finishes up...
Sep  1 22:07:47 ubuntu systemd[1]: Started Hold until boot process finishes up.
Sep  1 22:07:47 ubuntu systemd[1]: Starting Set console scheme...
Sep  1 22:07:47 ubuntu systemd[1]: Started Getty on tty1.
Sep  1 22:07:47 ubuntu systemd[1]: Started Serial Getty on ttyS0.
Sep  1 22:07:47 ubuntu systemd[1]: Reached target Login Prompts.
Sep  1 22:07:47 ubuntu systemd[1]: Started Terminate Plymouth Boot Screen.
Sep  1 22:07:47 ubuntu systemd[1]: Started Set console scheme.
Sep  1 22:07:47 ubuntu irqbalance[1290]:  * Starting SMP IRQ Balancer: irqbalance
Sep  1 22:07:47 ubuntu pollinate[1219]: client sent challenge to [https://entropy.ubuntu.com/]
Sep  1 22:07:47 ubuntu apport[1282]:  * Starting automatic crash report generation: apport
Sep  1 22:07:47 ubuntu systemd[1]: Started LSB: Record successful boot for GRUB.
Sep  1 22:07:47 ubuntu apport[1282]:    ...done.
Sep  1 22:07:47 ubuntu systemd[1]: Started LSB: automatic crash report generation.
Sep  1 22:07:47 ubuntu irqbalance[1290]:    ...done.
Sep  1 22:07:47 ubuntu systemd[1]: Started LSB: daemon to balance interrupts for SMP systems.
Sep  1 22:07:47 ubuntu systemd[1]: Started Thermal Daemon Service.
Sep  1 22:07:47 ubuntu polkitd[1323]: started daemon version 0.105 using authority implementation `local' version `0.105'
Sep  1 22:07:47 ubuntu dbus[1151]: [system] Successfully activated service 'org.freedesktop.PolicyKit1'
Sep  1 22:07:47 ubuntu systemd[1]: Started Authenticate and Authorize Users to Run Privileged Tasks.
Sep  1 22:07:47 ubuntu accounts-daemon[1094]: started daemon version 0.6.40
Sep  1 22:07:47 ubuntu systemd[1]: Started Accounts Service.
Sep  1 22:07:47 ubuntu thermald[1208]: NO RAPL sysfs present
Sep  1 22:07:47 ubuntu thermald[1208]: 13 CPUID levels; family:model:stepping 0x6:6:3 (6:6:3)
Sep  1 22:07:47 ubuntu thermald[1208]:  Need Linux PowerCap sysfs
Sep  1 22:07:47 ubuntu thermald[1208]: Unsupported cpu model, use thermal-conf.xml file or run with --ignore-cpuid-check
Sep  1 22:07:47 ubuntu thermald[1208]: THD engine start failed
Sep  1 22:07:47 ubuntu iscsid: iSCSI daemon with pid=1111 started!
Sep  1 22:07:47 ubuntu systemd[1]: Started LXD - container startup/shutdown.
Sep  1 22:07:47 ubuntu snapd[1227]: AppArmor status: apparmor is enabled and all features are available
Sep  1 22:07:48 ubuntu snapd[1227]: 2018/09/01 22:07:48.069316 helpers.go:119: error trying to compare the snap system key: system-key missing on disk
Sep  1 22:07:48 ubuntu snapd[1227]: 2018/09/01 22:07:48.120960 daemon.go:343: started snapd/2.34.2 (series 16; classic) ubuntu/16.04 (amd64) linux/4.15.0-33-generic.
Sep  1 22:07:48 ubuntu systemd[1]: Started Snappy daemon.
Sep  1 22:07:48 ubuntu systemd[1]: Starting Wait until snapd is fully seeded...
Sep  1 22:07:48 ubuntu pollinate[1219]: client verified challenge/response with [https://entropy.ubuntu.com/]
Sep  1 22:07:48 ubuntu pollinate[1219]: client hashed response from [https://entropy.ubuntu.com/]
Sep  1 22:07:48 ubuntu pollinate[1219]: client successfully seeded [/dev/urandom]
Sep  1 22:07:48 ubuntu systemd[1]: Started Pollinate to seed the pseudo random number generator.
Sep  1 22:07:48 ubuntu systemd[1]: Starting OpenBSD Secure Shell server...
Sep  1 22:07:48 ubuntu systemd[1]: Started OpenBSD Secure Shell server.
Sep  1 22:07:48 ubuntu systemd[1]: Started The Salt Minion.
Sep  1 22:07:50 ubuntu systemd-timesyncd[858]: Timed out waiting for reply from 91.189.94.4:123 (91.189.94.4).
Sep  1 22:07:51 ubuntu systemd[1]: Started Wait until snapd is fully seeded.
Sep  1 22:07:51 ubuntu systemd[1]: Reached target Multi-User System.
Sep  1 22:07:51 ubuntu systemd[1]: Reached target Graphical Interface.
Sep  1 22:07:51 ubuntu systemd[1]: Starting Update UTMP about System Runlevel Changes...
Sep  1 22:07:51 ubuntu systemd[1]: Starting Apply the settings specified in cloud-config...
Sep  1 22:07:51 ubuntu systemd[1]: Started Update UTMP about System Runlevel Changes.
Sep  1 22:07:51 ubuntu cloud-init[1617]: Generating locales (this might take a while)...
Sep  1 22:07:52 ubuntu cloud-init[1617]:   en_US.UTF-8... done
Sep  1 22:07:52 ubuntu cloud-init[1617]: Generation complete.
Sep  1 22:07:53 ubuntu cloud-init[1617]: Cloud-init v. 18.3-9-g2e62cb8a-0ubuntu1~16.04.2 running 'modules:config' at Sat, 01 Sep 2018 22:07:51 +0000. Up 30.09 seconds.
Sep  1 22:07:53 ubuntu systemd[1]: Started Apply the settings specified in cloud-config.
Sep  1 22:07:53 ubuntu systemd[1]: Starting Execute cloud user/final scripts...
Sep  1 22:07:53 ubuntu ec2: 
Sep  1 22:07:53 ubuntu ec2: #############################################################
Sep  1 22:07:53 ubuntu ec2: -----BEGIN SSH HOST KEY FINGERPRINTS-----
Sep  1 22:07:53 ubuntu ec2: 1024 SHA256:nHeh22QGCP4zBhMGKiaemh9Es00g4A1ekbVbJHO2WOc root@ubuntu (DSA)
Sep  1 22:07:53 ubuntu ec2: 256 SHA256:1tQPH0aMINVgoCUzzrvulxqMRKVmweEHQrzF6QOezcM root@ubuntu (ECDSA)
Sep  1 22:07:53 ubuntu ec2: 256 SHA256:KLNutI5OdS8ITJAxK9XHQewdwxa7wOCGHAy+zjMr8SY root@ubuntu (ED25519)
Sep  1 22:07:53 ubuntu ec2: 2048 SHA256:UoKNoLSjLMK61PFUNeS/LdU8dMD5pOEPTw9XbsO9v/Y root@ubuntu (RSA)
Sep  1 22:07:53 ubuntu ec2: -----END SSH HOST KEY FINGERPRINTS-----
Sep  1 22:07:53 ubuntu ec2: #############################################################
Sep  1 22:07:53 ubuntu cloud-init[1740]: Cloud-init v. 18.3-9-g2e62cb8a-0ubuntu1~16.04.2 running 'modules:final' at Sat, 01 Sep 2018 22:07:53 +0000. Up 32.10 seconds.
Sep  1 22:07:53 ubuntu cloud-init[1740]: ci-info: no authorized ssh keys fingerprints found for user ubuntu.
Sep  1 22:07:53 ubuntu cloud-init[1740]: Cloud-init v. 18.3-9-g2e62cb8a-0ubuntu1~16.04.2 finished at Sat, 01 Sep 2018 22:07:53 +0000. Datasource DataSourceNone.  Up 32.29 seconds
Sep  1 22:07:53 ubuntu cloud-init[1740]: 2018-09-01 22:07:53,670 - cc_final_message.py[WARNING]: Used fallback datasource
Sep  1 22:07:53 ubuntu systemd[1]: Started Execute cloud user/final scripts.
Sep  1 22:07:53 ubuntu systemd[1]: Reached target Cloud-init target.
Sep  1 22:07:53 ubuntu systemd[1]: Startup finished in 4.148s (kernel) + 28.213s (userspace) = 32.362s.
Sep  1 22:08:00 ubuntu systemd-timesyncd[858]: Timed out waiting for reply from 91.189.89.199:123 (91.189.89.199).
Sep  1 22:08:01 ubuntu systemd[1]: Time has been changed
Sep  1 22:08:01 ubuntu systemd-timesyncd[858]: Synchronized to time server 91.189.91.157:123 (91.189.91.157).
Sep  1 22:08:32 ubuntu salt-minion[1104]: [ERROR   ] Exception encountered when attempting to inspect frame in dependency decorator: list index out of range
Sep  1 22:08:38 ubuntu salt-minion[1104]: message repeated 56 times: [ [ERROR   ] Exception encountered when attempting to inspect frame in dependency decorator: list index out of range]
Sep  1 22:09:02 ubuntu systemd[1]: Started /usr/bin/apt-get -q -y -o DPkg::Options::=--force-confold -o DPkg::Options::=--force-confdef install python-oauth python-m2crypto.
Sep  1 22:09:11 ubuntu systemd[1]: Started /usr/bin/apt-get -q -y -o DPkg::Options::=--force-confold -o DPkg::Options::=--force-confdef install python-netaddr.
Sep  1 22:09:20 ubuntu systemd[1]: Started /usr/bin/apt-get -q -y -o DPkg::Options::=--force-confold -o DPkg::Options::=--force-confdef install python-keystoneclient.
Sep  1 22:10:07 ubuntu systemd[1]: Started /usr/bin/apt-get -q -y -o DPkg::Options::=--force-confold -o DPkg::Options::=--force-confdef install python-openstackclient.
Sep  1 22:10:22 ubuntu salt-minion[1104]: [WARNING ] The function "module.run" is using its deprecated version and will expire in version "Sodium".
Sep  1 22:10:25 ubuntu salt-minion[1104]:       fun:
Sep  1 22:10:38 ubuntu salt-minion[1104]: message repeated 6 times: [       fun:]
Sep  1 22:10:38 ubuntu salt-minion[1104]: [WARNING ] The function "module.run" is using its deprecated version and will expire in version "Sodium".
Sep  1 22:10:39 ubuntu salt-minion[1104]:       fun:
Sep  1 22:10:41 ubuntu salt-minion[1104]:       fun:
Sep  1 22:10:42 ubuntu systemd[1]: Started /usr/bin/apt-get -q -y -o DPkg::Options::=--force-confold -o DPkg::Options::=--force-confdef install python-tornado python-pymysql python-cryptography.
Sep  1 22:10:43 ubuntu salt-minion[1104]:       fun:
Sep  1 22:10:54 ubuntu salt-minion[1104]: message repeated 6 times: [       fun:]
Sep  1 22:10:55 ubuntu salt-minion[1104]: Traceback (most recent call last):
Sep  1 22:10:55 ubuntu salt-minion[1104]:   File "/usr/bin/salt-call", line 11, in <module>
Sep  1 22:10:55 ubuntu salt-minion[1104]:     salt_call()
Sep  1 22:10:55 ubuntu salt-minion[1104]:   File "/usr/lib/python2.7/dist-packages/salt/scripts.py", line 391, in salt_call
Sep  1 22:10:55 ubuntu salt-minion[1104]:     import salt.cli.call
Sep  1 22:10:55 ubuntu salt-minion[1104]:   File "/usr/lib/python2.7/dist-packages/salt/cli/call.py", line 9, in <module>
Sep  1 22:10:55 ubuntu salt-minion[1104]:     import salt.cli.caller
Sep  1 22:10:55 ubuntu salt-minion[1104]:   File "/usr/lib/python2.7/dist-packages/salt/cli/caller.py", line 19, in <module>
Sep  1 22:10:55 ubuntu salt-minion[1104]:     import salt.minion
Sep  1 22:10:55 ubuntu salt-minion[1104]:   File "/usr/lib/python2.7/dist-packages/salt/minion.py", line 78, in <module>
Sep  1 22:10:55 ubuntu salt-minion[1104]:     import salt.pillar
Sep  1 22:10:55 ubuntu salt-minion[1104]:   File "/usr/lib/python2.7/dist-packages/salt/pillar/__init__.py", line 18, in <module>
Sep  1 22:10:55 ubuntu salt-minion[1104]:     import salt.fileclient
Sep  1 22:10:55 ubuntu salt-minion[1104]:   File "/usr/lib/python2.7/dist-packages/salt/fileclient.py", line 29, in <module>
Sep  1 22:10:55 ubuntu salt-minion[1104]:     import salt.utils.templates
Sep  1 22:10:55 ubuntu salt-minion[1104]:   File "/usr/lib/python2.7/dist-packages/salt/utils/templates.py", line 31, in <module>
Sep  1 22:10:55 ubuntu salt-minion[1104]:     import salt.utils.http
Sep  1 22:10:55 ubuntu salt-minion[1104]:   File "/usr/lib/python2.7/dist-packages/salt/utils/http.py", line 71, in <module>
Sep  1 22:10:55 ubuntu salt-minion[1104]:     import requests
Sep  1 22:10:55 ubuntu salt-minion[1104]:   File "/usr/lib/python2.7/dist-packages/requests/__init__.py", line 53, in <module>
Sep  1 22:10:55 ubuntu salt-minion[1104]:     from .packages.urllib3.contrib import pyopenssl
Sep  1 22:10:55 ubuntu salt-minion[1104]:   File "/usr/lib/python2.7/dist-packages/urllib3/contrib/pyopenssl.py", line 54, in <module>
Sep  1 22:10:55 ubuntu salt-minion[1104]:     import OpenSSL.SSL
Sep  1 22:10:55 ubuntu salt-minion[1104]:   File "/usr/lib/python2.7/dist-packages/OpenSSL/__init__.py", line 8, in <module>
Sep  1 22:10:55 ubuntu salt-minion[1104]:     from OpenSSL import rand, crypto, SSL
Sep  1 22:10:55 ubuntu salt-minion[1104]:   File "/usr/lib/python2.7/dist-packages/OpenSSL/SSL.py", line 112, in <module>
Sep  1 22:10:55 ubuntu salt-minion[1104]:     if _lib.Cryptography_HAS_SSL_ST:
Sep  1 22:10:55 ubuntu salt-minion[1104]: AttributeError: 'module' object has no attribute 'Cryptography_HAS_SSL_ST'
Sep  1 22:10:55 ubuntu salt-minion[1104]: Traceback (most recent call last):
Sep  1 22:10:55 ubuntu salt-minion[1104]:   File "/usr/bin/salt-call", line 11, in <module>
Sep  1 22:10:55 ubuntu salt-minion[1104]:     salt_call()
Sep  1 22:10:55 ubuntu salt-minion[1104]:   File "/usr/lib/python2.7/dist-packages/salt/scripts.py", line 391, in salt_call
Sep  1 22:10:55 ubuntu salt-minion[1104]:     import salt.cli.call
Sep  1 22:10:55 ubuntu salt-minion[1104]:   File "/usr/lib/python2.7/dist-packages/salt/cli/call.py", line 9, in <module>
Sep  1 22:10:55 ubuntu salt-minion[1104]:     import salt.cli.caller
Sep  1 22:10:55 ubuntu salt-minion[1104]:   File "/usr/lib/python2.7/dist-packages/salt/cli/caller.py", line 19, in <module>
Sep  1 22:10:55 ubuntu salt-minion[1104]:     import salt.minion
Sep  1 22:10:55 ubuntu salt-minion[1104]:   File "/usr/lib/python2.7/dist-packages/salt/minion.py", line 78, in <module>
Sep  1 22:10:55 ubuntu salt-minion[1104]:     import salt.pillar
Sep  1 22:10:55 ubuntu salt-minion[1104]:   File "/usr/lib/python2.7/dist-packages/salt/pillar/__init__.py", line 18, in <module>
Sep  1 22:10:55 ubuntu salt-minion[1104]:     import salt.fileclient
Sep  1 22:10:55 ubuntu salt-minion[1104]:   File "/usr/lib/python2.7/dist-packages/salt/fileclient.py", line 29, in <module>
Sep  1 22:10:55 ubuntu salt-minion[1104]:     import salt.utils.templates
Sep  1 22:10:55 ubuntu salt-minion[1104]:   File "/usr/lib/python2.7/dist-packages/salt/utils/templates.py", line 31, in <module>
Sep  1 22:10:55 ubuntu salt-minion[1104]:     import salt.utils.http
Sep  1 22:10:55 ubuntu salt-minion[1104]:   File "/usr/lib/python2.7/dist-packages/salt/utils/http.py", line 71, in <module>
Sep  1 22:10:55 ubuntu salt-minion[1104]:     import requests
Sep  1 22:10:55 ubuntu salt-minion[1104]:   File "/usr/lib/python2.7/dist-packages/requests/__init__.py", line 53, in <module>
Sep  1 22:10:55 ubuntu salt-minion[1104]:     from .packages.urllib3.contrib import pyopenssl
Sep  1 22:10:55 ubuntu salt-minion[1104]:   File "/usr/lib/python2.7/dist-packages/urllib3/contrib/pyopenssl.py", line 54, in <module>
Sep  1 22:10:55 ubuntu salt-minion[1104]:     import OpenSSL.SSL
Sep  1 22:10:55 ubuntu salt-minion[1104]:   File "/usr/lib/python2.7/dist-packages/OpenSSL/__init__.py", line 8, in <module>
Sep  1 22:10:55 ubuntu salt-minion[1104]:     from OpenSSL import rand, crypto, SSL
Sep  1 22:10:55 ubuntu salt-minion[1104]:   File "/usr/lib/python2.7/dist-packages/OpenSSL/SSL.py", line 112, in <module>
Sep  1 22:10:55 ubuntu salt-minion[1104]:     if _lib.Cryptography_HAS_SSL_ST:
Sep  1 22:10:55 ubuntu salt-minion[1104]: AttributeError: 'module' object has no attribute 'Cryptography_HAS_SSL_ST'
Sep  1 22:11:12 ubuntu dbus[1151]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service'
Sep  1 22:11:12 ubuntu systemd[1]: Starting Time & Date Service...
Sep  1 22:11:12 ubuntu dbus[1151]: [system] Successfully activated service 'org.freedesktop.timedate1'
Sep  1 22:11:12 ubuntu systemd[1]: Started Time & Date Service.
Sep  1 22:11:12 ubuntu kernel: [  230.130438] nf_conntrack version 0.5.0 (65536 buckets, 262144 max)
Sep  1 22:11:16 ubuntu systemd[1]: Started /usr/bin/apt-get -q -y -o DPkg::Options::=--force-confold -o DPkg::Options::=--force-confdef install sysfsutils.
Sep  1 22:11:20 ubuntu systemd[1]: Reloading.
Sep  1 22:11:20 ubuntu systemd[1]: Started ACPI event daemon.
Sep  1 22:11:23 ubuntu systemd[1]: Reloading.
Sep  1 22:11:23 ubuntu systemd[1]: Started ACPI event daemon.
Sep  1 22:11:24 ubuntu systemd[1]: Reloading.
Sep  1 22:11:24 ubuntu systemd[1]: Started ACPI event daemon.
Sep  1 22:11:24 ubuntu systemd[1]: Starting LSB: Set sysfs variables from /etc/sysfs.conf...
Sep  1 22:11:24 ubuntu sysfsutils[8970]:  * Setting sysfs variables...
Sep  1 22:11:24 ubuntu sysfsutils[8970]:    ...done.
Sep  1 22:11:24 ubuntu systemd[1]: Started LSB: Set sysfs variables from /etc/sysfs.conf.
Sep  1 22:11:24 ubuntu systemd[1]: Reloading.
Sep  1 22:11:24 ubuntu systemd[1]: Started ACPI event daemon.
Sep  1 22:11:27 ubuntu systemd[1]: Started /bin/systemctl stop ondemand.service.
Sep  1 22:11:27 ubuntu systemd[1]: Stopping LSB: Set the CPU Frequency Scaling governor to "ondemand"...
Sep  1 22:11:27 ubuntu systemd[1]: Stopped LSB: Set the CPU Frequency Scaling governor to "ondemand".
Sep  1 22:11:27 ubuntu systemd[1]: Started /usr/sbin/update-rc.d -f ondemand remove.
Sep  1 22:11:27 ubuntu systemd[1]: Reloading.
Sep  1 22:11:27 ubuntu systemd[1]: Started ACPI event daemon.
Sep  1 22:11:28 ubuntu dbus[1151]: [system] Activating via systemd: service name='org.freedesktop.locale1' unit='dbus-org.freedesktop.locale1.service'
Sep  1 22:11:28 ubuntu systemd[1]: Starting Locale Service...
Sep  1 22:11:28 ubuntu dbus[1151]: [system] Successfully activated service 'org.freedesktop.locale1'
Sep  1 22:11:28 ubuntu systemd[1]: Started Locale Service.
Sep  1 22:11:29 ubuntu salt-minion[1104]: [WARNING ] The function "module.run" is using its deprecated version and will expire in version "Sodium".
Sep  1 22:11:29 ubuntu systemd[1]: Reloading.
Sep  1 22:11:29 ubuntu systemd[1]: Started ACPI event daemon.
Sep  1 22:11:30 ubuntu systemd[1]: Reloading OpenBSD Secure Shell server.
Sep  1 22:11:30 ubuntu systemd[1]: Reloaded OpenBSD Secure Shell server.
Sep  1 22:11:31 ubuntu systemd[1]: Started /bin/systemctl enable networking.service.
Sep  1 22:11:31 ubuntu systemd[1]: Reloading.
Sep  1 22:11:31 ubuntu systemd[1]: Started ACPI event daemon.
Sep  1 22:11:31 ubuntu systemd[1]: Reloading.
Sep  1 22:11:31 ubuntu systemd[1]: Started ACPI event daemon.
Sep  1 22:11:31 ubuntu systemd[1]: Reloading.
Sep  1 22:11:31 ubuntu systemd[1]: Started ACPI event daemon.
Sep  1 22:11:31 ubuntu salt-minion[1104]: [WARNING ] The network state sls is requiring a reboot of the system to properly apply network configuration.
Sep  1 22:11:32 ubuntu systemd[1]: Started /usr/bin/apt-get -q -y -o DPkg::Options::=--force-confold -o DPkg::Options::=--force-confdef install ntp.
Sep  1 22:11:34 ubuntu systemd[1]: Reloading.
Sep  1 22:11:34 ubuntu systemd[1]: Started ACPI event daemon.
Sep  1 22:11:35 ubuntu systemd[1]: Reloading.
Sep  1 22:11:35 ubuntu systemd[1]: Started ACPI event daemon.
Sep  1 22:11:35 ubuntu systemd[1]: Reloading.
Sep  1 22:11:35 ubuntu systemd[1]: Started ACPI event daemon.
Sep  1 22:11:35 ubuntu systemd[1]: Starting LSB: Start NTP daemon...
Sep  1 22:11:35 ubuntu ntp[10192]:  * Starting NTP server ntpd
Sep  1 22:11:35 ubuntu ntpd[10216]: ntpd 4.2.8p4@1.3265-o Fri Jul  6 20:10:51 UTC 2018 (1): Starting
Sep  1 22:11:35 ubuntu ntpd[10216]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 112:116
Sep  1 22:11:35 ubuntu ntp[10192]:    ...done.
Sep  1 22:11:35 ubuntu systemd[1]: Started LSB: Start NTP daemon.
Sep  1 22:11:36 ubuntu kernel: [  253.297534] kauditd_printk_skb: 3 callbacks suppressed
Sep  1 22:11:36 ubuntu kernel: [  253.297536] audit: type=1400 audit(1535839896.046:15): apparmor="STATUS" operation="profile_load" profile="unconfined" name="/usr/sbin/ntpd" pid=10229 comm="apparmor_parser"
Sep  1 22:11:36 ubuntu ntpd[10220]: proto: precision = 0.048 usec (-24)
Sep  1 22:11:36 ubuntu ntpd[10220]: Listen and drop on 0 v6wildcard [::]:123
Sep  1 22:11:36 ubuntu ntpd[10220]: Listen and drop on 1 v4wildcard 0.0.0.0:123
Sep  1 22:11:36 ubuntu ntpd[10220]: Listen normally on 2 lo 127.0.0.1:123
Sep  1 22:11:36 ubuntu ntpd[10220]: Listen normally on 3 ens2 192.168.11.54:123
Sep  1 22:11:36 ubuntu ntpd[10220]: Listen normally on 4 ens3 10.167.4.38:123
Sep  1 22:11:36 ubuntu ntpd[10220]: Listen normally on 5 lo [::1]:123
Sep  1 22:11:36 ubuntu ntpd[10220]: Listen normally on 6 ens2 [fe80::aede:48ff:fe3c:44b9%2]:123
Sep  1 22:11:36 ubuntu ntpd[10220]: Listen normally on 7 ens3 [fe80::aede:48ff:fea0:e643%3]:123
Sep  1 22:11:36 ubuntu ntpd[10220]: Listening on routing socket on fd #24 for interface updates
Sep  1 22:11:36 ubuntu systemd[1]: Reloading.
Sep  1 22:11:36 ubuntu systemd[1]: Started ACPI event daemon.
Sep  1 22:11:37 ubuntu ntpd[10220]: Soliciting pool server 108.61.73.244
Sep  1 22:11:38 ubuntu ntpd[10220]: Soliciting pool server 45.63.11.93
Sep  1 22:11:38 ubuntu ntpd[10220]: Soliciting pool server 45.33.48.4
Sep  1 22:11:38 ubuntu systemd[1]: Started /bin/systemctl restart ntp.service.
Sep  1 22:11:38 ubuntu systemd[1]: Stopping LSB: Start NTP daemon...
Sep  1 22:11:38 ubuntu ntp[10362]:  * Stopping NTP server ntpd
Sep  1 22:11:38 ubuntu ntpd[10220]: ntpd exiting on signal 15 (Terminated)
Sep  1 22:11:38 ubuntu ntp[10362]:    ...done.
Sep  1 22:11:38 ubuntu ntpd[10220]: 108.61.73.244 local addr 192.168.11.54 -> <null>
Sep  1 22:11:38 ubuntu ntpd[10220]: 45.33.48.4 local addr 192.168.11.54 -> <null>
Sep  1 22:11:38 ubuntu ntpd[10220]: 45.63.11.93 local addr 192.168.11.54 -> <null>
Sep  1 22:11:38 ubuntu systemd[1]: Stopped LSB: Start NTP daemon.
Sep  1 22:11:38 ubuntu systemd[1]: Starting LSB: Start NTP daemon...
Sep  1 22:11:38 ubuntu ntp[10374]:  * Starting NTP server ntpd
Sep  1 22:11:38 ubuntu ntpd[10395]: ntpd 4.2.8p4@1.3265-o Fri Jul  6 20:10:51 UTC 2018 (1): Starting
Sep  1 22:11:38 ubuntu ntpd[10395]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 112:116
Sep  1 22:11:38 ubuntu ntp[10374]:    ...done.
Sep  1 22:11:38 ubuntu systemd[1]: Started LSB: Start NTP daemon.
Sep  1 22:11:38 ubuntu ntpd[10398]: proto: precision = 0.048 usec (-24)
Sep  1 22:11:38 ubuntu ntpd[10398]: restrict 0.0.0.0: KOD does nothing without LIMITED.
Sep  1 22:11:38 ubuntu ntpd[10398]: restrict ::: KOD does nothing without LIMITED.
Sep  1 22:11:38 ubuntu ntpd[10398]: Listen and drop on 0 v6wildcard [::]:123
Sep  1 22:11:38 ubuntu ntpd[10398]: Listen and drop on 1 v4wildcard 0.0.0.0:123
Sep  1 22:11:38 ubuntu ntpd[10398]: Listen normally on 2 lo 127.0.0.1:123
Sep  1 22:11:38 ubuntu ntpd[10398]: Listen normally on 3 ens2 192.168.11.54:123
Sep  1 22:11:38 ubuntu ntpd[10398]: Listen normally on 4 ens3 10.167.4.38:123
Sep  1 22:11:38 ubuntu ntpd[10398]: Listen normally on 5 lo [::1]:123
Sep  1 22:11:38 ubuntu ntpd[10398]: Listen normally on 6 ens2 [fe80::aede:48ff:fe3c:44b9%2]:123
Sep  1 22:11:38 ubuntu ntpd[10398]: Listen normally on 7 ens3 [fe80::aede:48ff:fea0:e643%3]:123
Sep  1 22:11:38 ubuntu ntpd[10398]: Listening on routing socket on fd #24 for interface updates
Sep  1 22:12:24 ubuntu dhclient[871]: DHCPREQUEST of 192.168.11.54 on ens2 to 192.168.11.3 port 67 (xid=0x739639ec)
Sep  1 22:12:24 ubuntu dhclient[871]: DHCPACK of 192.168.11.54 from 192.168.11.3
Sep  1 22:12:24 ubuntu systemd[1]: Stopping LSB: Start NTP daemon...
Sep  1 22:12:24 ubuntu ntp[10508]:  * Stopping NTP server ntpd
Sep  1 22:12:24 ubuntu ntpd[10398]: ntpd exiting on signal 15 (Terminated)
Sep  1 22:12:24 ubuntu ntpd[10398]: 216.6.2.70 local addr 192.168.11.54 -> <null>
Sep  1 22:12:24 ubuntu ntpd[10398]: 108.61.73.243 local addr 192.168.11.54 -> <null>
Sep  1 22:12:24 ubuntu ntp[10508]:    ...done.
Sep  1 22:12:24 ubuntu systemd[1]: Stopped LSB: Start NTP daemon.
Sep  1 22:12:24 ubuntu systemd[1]: Starting LSB: Start NTP daemon...
Sep  1 22:12:24 ubuntu ntp[10520]:  * Starting NTP server ntpd
Sep  1 22:12:24 ubuntu ntpd[10542]: ntpd 4.2.8p4@1.3265-o Fri Jul  6 20:10:51 UTC 2018 (1): Starting
Sep  1 22:12:24 ubuntu ntpd[10542]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -c /var/lib/ntp/ntp.conf.dhcp -u 112:116
Sep  1 22:12:24 ubuntu ntp[10520]:    ...done.
Sep  1 22:12:24 ubuntu systemd[1]: Started LSB: Start NTP daemon.
Sep  1 22:12:24 ubuntu dhclient[871]: bound to 192.168.11.54 -- renewal in 286 seconds.
Sep  1 22:12:24 ubuntu ntpd[10545]: proto: precision = 0.045 usec (-24)
Sep  1 22:12:24 ubuntu ntpd[10545]: restrict 0.0.0.0: KOD does nothing without LIMITED.
Sep  1 22:12:24 ubuntu ntpd[10545]: restrict ::: KOD does nothing without LIMITED.
Sep  1 22:12:24 ubuntu ntpd[10545]: Listen and drop on 0 v6wildcard [::]:123
Sep  1 22:12:24 ubuntu ntpd[10545]: Listen and drop on 1 v4wildcard 0.0.0.0:123
Sep  1 22:12:24 ubuntu ntpd[10545]: Listen normally on 2 lo 127.0.0.1:123
Sep  1 22:12:24 ubuntu ntpd[10545]: Listen normally on 3 ens2 192.168.11.54:123
Sep  1 22:12:24 ubuntu ntpd[10545]: Listen normally on 4 ens3 10.167.4.38:123
Sep  1 22:12:24 ubuntu ntpd[10545]: Listen normally on 5 lo [::1]:123
Sep  1 22:12:24 ubuntu ntpd[10545]: Listen normally on 6 ens2 [fe80::aede:48ff:fe3c:44b9%2]:123
Sep  1 22:12:24 ubuntu ntpd[10545]: Listen normally on 7 ens3 [fe80::aede:48ff:fea0:e643%3]:123
Sep  1 22:12:24 ubuntu ntpd[10545]: Listening on routing socket on fd #24 for interface updates
Sep  1 22:12:24 ubuntu systemd[1]: Started /usr/bin/apt-get -q -y -o DPkg::Options::=--force-confold -o DPkg::Options::=--force-confdef dist-upgrade.
Sep  1 22:12:41 ubuntu dbus[1151]: [system] Reloaded configuration
Sep  1 22:14:15 ubuntu dbus[1151]: message repeated 3 times: [ [system] Reloaded configuration]
Sep  1 22:15:21 ubuntu systemd[1]: Started /usr/bin/apt-get -q -y -o DPkg::Options::=--force-confold -o DPkg::Options::=--force-confdef install keepalived.
Sep  1 22:15:24 ubuntu dbus[1151]: [system] Reloaded configuration
Sep  1 22:15:24 ubuntu dbus[1151]: [system] Reloaded configuration
Sep  1 22:15:25 ubuntu systemd[1]: Reloading.
Sep  1 22:15:25 ubuntu systemd[1]: Started ACPI event daemon.
Sep  1 22:15:25 ubuntu dbus[1151]: [system] Reloaded configuration
Sep  1 22:15:26 ubuntu systemd[1]: Reloading.
Sep  1 22:15:26 ubuntu systemd[1]: Started ACPI event daemon.
Sep  1 22:15:26 ubuntu systemd[1]: Reloading.
Sep  1 22:15:27 ubuntu systemd[1]: Started ACPI event daemon.
Sep  1 22:15:27 ubuntu systemd[1]: Starting LSB: ipvsadm daemon...
Sep  1 22:15:27 ubuntu ipvsadm[13667]:  * ipvsadm is not configured to run. Please edit /etc/default/ipvsadm
Sep  1 22:15:27 ubuntu systemd[1]: Started LSB: ipvsadm daemon.
Sep  1 22:15:27 ubuntu dbus[1151]: [system] Reloaded configuration
Sep  1 22:15:27 ubuntu systemd[1]: Reloading.
Sep  1 22:15:27 ubuntu systemd[1]: Started ACPI event daemon.
Sep  1 22:15:27 ubuntu systemd[1]: Reloading.
Sep  1 22:15:27 ubuntu systemd[1]: Started ACPI event daemon.
Sep  1 22:15:27 ubuntu systemd[1]: Reloading.
Sep  1 22:15:27 ubuntu systemd[1]: Started ACPI event daemon.
Sep  1 22:15:27 ubuntu systemd[1]: Reloading.
Sep  1 22:15:28 ubuntu systemd[1]: Started ACPI event daemon.
Sep  1 22:15:28 ubuntu dbus[1151]: [system] Reloaded configuration
Sep  1 22:15:30 ubuntu systemd[1]: Started /bin/systemctl start keepalived.service.
Sep  1 22:15:30 ubuntu systemd[1]: Starting Keepalive Daemon (LVS and VRRP)...
Sep  1 22:15:30 ubuntu Keepalived[13897]: Starting Keepalived v1.3.9 (10/21,2017)
Sep  1 22:15:30 ubuntu Keepalived[13897]: Opening file '/etc/keepalived/keepalived.conf'.
Sep  1 22:15:30 ubuntu Keepalived[13907]: Starting Healthcheck child process, pid=13909
Sep  1 22:15:30 ubuntu Keepalived_healthcheckers[13909]: Opening file '/etc/keepalived/keepalived.conf'.
Sep  1 22:15:30 ubuntu Keepalived[13907]: Starting VRRP child process, pid=13912
Sep  1 22:15:30 ubuntu Keepalived_vrrp[13912]: Registering Kernel netlink reflector
Sep  1 22:15:30 ubuntu Keepalived_vrrp[13912]: Registering Kernel netlink command channel
Sep  1 22:15:30 ubuntu systemd[1]: Started Keepalive Daemon (LVS and VRRP).
Sep  1 22:15:30 ubuntu Keepalived_vrrp[13912]: Registering gratuitous ARP shared channel
Sep  1 22:15:30 ubuntu Keepalived_vrrp[13912]: Opening file '/etc/keepalived/keepalived.conf'.
Sep  1 22:15:30 ubuntu Keepalived_vrrp[13912]: Using LinkWatch kernel netlink reflector...
Sep  1 22:15:30 ubuntu Keepalived_vrrp[13912]: VRRP_Instance(VIP) Entering BACKUP STATE
Sep  1 22:15:33 ubuntu Keepalived_vrrp[13912]: VRRP_Instance(VIP) Transition to MASTER STATE
Sep  1 22:15:34 ubuntu Keepalived_vrrp[13912]: VRRP_Instance(VIP) Entering MASTER STATE
Sep  1 22:15:36 ubuntu ntpd[10545]: Listen normally on 8 ens3 10.167.4.35:123
Sep  1 22:15:36 ubuntu ntpd[10545]: new interface(s) found: waking up resolver
Sep  1 22:17:01 ubuntu CRON[13933]: (root) CMD (   cd / && run-parts --report /etc/cron.hourly)
Sep  1 22:17:10 ubuntu dhclient[871]: DHCPREQUEST of 192.168.11.54 on ens2 to 192.168.11.3 port 67 (xid=0x739639ec)
Sep  1 22:17:10 ubuntu dhclient[871]: DHCPACK of 192.168.11.54 from 192.168.11.3
Sep  1 22:17:10 ubuntu dhclient[871]: bound to 192.168.11.54 -- renewal in 248 seconds.
Sep  1 22:21:18 ubuntu dhclient[871]: DHCPREQUEST of 192.168.11.54 on ens2 to 192.168.11.3 port 67 (xid=0x739639ec)
Sep  1 22:21:18 ubuntu dhclient[871]: DHCPACK of 192.168.11.54 from 192.168.11.3
Sep  1 22:21:18 ubuntu dhclient[871]: bound to 192.168.11.54 -- renewal in 228 seconds.
Sep  1 22:22:45 ubuntu systemd[1]: Starting Cleanup of Temporary Directories...
Sep  1 22:22:45 ubuntu systemd-tmpfiles[13961]: [/usr/lib/tmpfiles.d/var.conf:14] Duplicate line for path "/var/log", ignoring.
Sep  1 22:22:45 ubuntu systemd[1]: Started Cleanup of Temporary Directories.
Sep  1 22:25:06 ubuntu dhclient[871]: DHCPREQUEST of 192.168.11.54 on ens2 to 192.168.11.3 port 67 (xid=0x739639ec)
Sep  1 22:25:06 ubuntu dhclient[871]: DHCPACK of 192.168.11.54 from 192.168.11.3
Sep  1 22:25:06 ubuntu dhclient[871]: bound to 192.168.11.54 -- renewal in 247 seconds.
Sep  1 22:25:30 ubuntu systemd[1]: Started /usr/bin/apt-get -q -y -o DPkg::Options::=--force-confold -o DPkg::Options::=--force-confdef install glusterfs-client.
Sep  1 22:25:37 ubuntu systemd[1]: Started /bin/systemctl start var-lib-glance-images.mount.
Sep  1 22:25:37 ubuntu systemd[1]: Mounting GlusterFS File System (10.167.4.19:/glance)...
Sep  1 22:25:37 ubuntu systemd[1]: Mounted GlusterFS File System (10.167.4.19:/glance).
Sep  1 22:25:37 ubuntu systemd[1]: Started /bin/systemctl enable var-lib-glance-images.mount.
Sep  1 22:25:37 ubuntu systemd[1]: Reloading.
Sep  1 22:25:37 ubuntu systemd[1]: Started ACPI event daemon.
Sep  1 22:25:38 ubuntu systemd[1]: Started /bin/systemctl start var-lib-keystone-fernet\x2dkeys.mount.
Sep  1 22:25:38 ubuntu systemd[1]: Mounting GlusterFS File System (10.167.4.19:/keystone-keys)...
Sep  1 22:25:38 ubuntu systemd[1]: Mounted GlusterFS File System (10.167.4.19:/keystone-keys).
Sep  1 22:25:38 ubuntu systemd[1]: Started /bin/systemctl enable var-lib-keystone-fernet\x2dkeys.mount.
Sep  1 22:25:38 ubuntu systemd[1]: Reloading.
Sep  1 22:25:38 ubuntu systemd[1]: Started ACPI event daemon.
Sep  1 22:25:38 ubuntu systemd[1]: Started /bin/systemctl start var-lib-keystone-credential\x2dkeys.mount.
Sep  1 22:25:38 ubuntu systemd[1]: Mounting GlusterFS File System (10.167.4.19:/keystone-credential-keys)...
Sep  1 22:25:38 ubuntu systemd[1]: Mounted GlusterFS File System (10.167.4.19:/keystone-credential-keys).
Sep  1 22:25:38 ubuntu systemd[1]: Started /bin/systemctl enable var-lib-keystone-credential\x2dkeys.mount.
Sep  1 22:25:38 ubuntu systemd[1]: Reloading.
Sep  1 22:25:38 ubuntu systemd[1]: Started ACPI event daemon.
Sep  1 22:29:13 ubuntu dhclient[871]: DHCPREQUEST of 192.168.11.54 on ens2 to 192.168.11.3 port 67 (xid=0x739639ec)
Sep  1 22:29:13 ubuntu dhclient[871]: DHCPACK of 192.168.11.54 from 192.168.11.3
Sep  1 22:29:13 ubuntu dhclient[871]: bound to 192.168.11.54 -- renewal in 237 seconds.
Sep  1 22:31:23 ubuntu systemd[1]: Started /usr/bin/apt-get -q -y -o DPkg::Options::=--force-confold -o DPkg::Options::=--force-confdef install memcached.
Sep  1 22:31:24 ubuntu systemd[1]: Reloading.
Sep  1 22:31:25 ubuntu systemd[1]: Started ACPI event daemon.
Sep  1 22:31:26 ubuntu systemd[1]: Reloading.
Sep  1 22:31:26 ubuntu systemd[1]: Started ACPI event daemon.
Sep  1 22:31:26 ubuntu systemd[1]: Reloading.
Sep  1 22:31:26 ubuntu systemd[1]: Started ACPI event daemon.
Sep  1 22:31:26 ubuntu systemd[1]: Reloading.
Sep  1 22:31:26 ubuntu systemd[1]: Started ACPI event daemon.
Sep  1 22:31:27 ubuntu systemd[1]: Started memcached daemon.
Sep  1 22:31:27 ubuntu systemd[1]: Reloading.
Sep  1 22:31:27 ubuntu systemd[1]: Started ACPI event daemon.
Sep  1 22:31:29 ubuntu systemd[1]: Started /usr/bin/apt-get -q -y -o DPkg::Options::=--force-confold -o DPkg::Options::=--force-confdef install python-memcache.
Sep  1 22:31:31 ubuntu systemd[1]: Started /bin/systemctl restart memcached.service.
Sep  1 22:31:31 ubuntu systemd[1]: Stopping memcached daemon...
Sep  1 22:31:31 ubuntu systemd-memcached-wrapper[16309]: Signal handled: Terminated.
Sep  1 22:31:31 ubuntu systemd[1]: Stopped memcached daemon.
Sep  1 22:31:31 ubuntu systemd[1]: Started memcached daemon.
Sep  1 22:31:37 ubuntu systemd[1]: Started /usr/bin/apt-get -q -y -o DPkg::Options::=--force-confold -o DPkg::Options::=--force-confdef install haproxy.
Sep  1 22:31:41 ubuntu systemd[1]: Reloading.
Sep  1 22:31:41 ubuntu systemd[1]: Started ACPI event daemon.
Sep  1 22:31:43 ubuntu systemd[1]: Reloading.
Sep  1 22:31:43 ubuntu systemd[1]: Started ACPI event daemon.
Sep  1 22:31:43 ubuntu systemd[1]: Reloading.
Sep  1 22:31:43 ubuntu systemd[1]: Started ACPI event daemon.
Sep  1 22:31:43 ubuntu systemd[1]: Reloading.
Sep  1 22:31:43 ubuntu systemd[1]: Started ACPI event daemon.
Sep  1 22:31:43 ubuntu systemd[1]: Starting HAProxy Load Balancer...
Sep  1 22:31:43 ubuntu systemd[1]: Started HAProxy Load Balancer.
Sep  1 22:31:43 ubuntu haproxy-systemd-wrapper[17367]: haproxy-systemd-wrapper: executing /usr/sbin/haproxy -f /etc/haproxy/haproxy.cfg -p /run/haproxy.pid -Ds
Sep  1 22:31:43 ubuntu systemd[1]: Reloading.
Sep  1 22:31:44 ubuntu systemd[1]: Started ACPI event daemon.
Sep  1 22:31:46 ubuntu systemd[1]: Started /usr/bin/apt-get -q -y -o DPkg::Options::=--force-confold -o DPkg::Options::=--force-confdef install socat.
Sep  1 22:31:49 ubuntu systemd[1]: Started /bin/systemctl restart haproxy.service.
Sep  1 22:31:49 ubuntu systemd[1]: Stopping HAProxy Load Balancer...
Sep  1 22:31:49 ubuntu haproxy-systemd-wrapper[17367]: haproxy-systemd-wrapper: SIGINT -> 17374
Sep  1 22:31:49 ubuntu haproxy-systemd-wrapper[17367]: haproxy-systemd-wrapper: exit, haproxy RC=0
Sep  1 22:31:49 ubuntu systemd[1]: Stopped HAProxy Load Balancer.
Sep  1 22:31:49 ubuntu systemd[1]: Starting HAProxy Load Balancer...
Sep  1 22:31:49 ubuntu systemd[1]: Started HAProxy Load Balancer.
Sep  1 22:31:49 ubuntu haproxy-systemd-wrapper[17787]: haproxy-systemd-wrapper: executing /usr/sbin/haproxy -f /etc/haproxy/haproxy.cfg -p /run/haproxy.pid -Ds
Sep  1 22:31:49 ubuntu haproxy[17790]: Proxy keystone_public_api started.
Sep  1 22:31:49 ubuntu haproxy[17790]: Proxy keystone_public_api started.
Sep  1 22:31:49 ubuntu haproxy[17790]: Proxy nova_api started.
Sep  1 22:31:49 ubuntu haproxy[17790]: Proxy nova_api started.
Sep  1 22:31:49 ubuntu haproxy[17790]: Proxy placement_api started.
Sep  1 22:31:49 ubuntu haproxy[17790]: Proxy placement_api started.
Sep  1 22:31:49 ubuntu haproxy[17790]: Proxy keystone_admin_api started.
Sep  1 22:31:49 ubuntu haproxy[17790]: Proxy keystone_admin_api started.
Sep  1 22:31:49 ubuntu haproxy[17790]: Proxy cinder_api started.
Sep  1 22:31:49 ubuntu haproxy[17790]: Proxy cinder_api started.
Sep  1 22:31:49 ubuntu haproxy[17790]: Proxy glance_registry_api started.
Sep  1 22:31:49 ubuntu haproxy[17790]: Proxy glance_registry_api started.
Sep  1 22:31:49 ubuntu haproxy[17790]: Proxy heat_cfn_api started.
Sep  1 22:31:49 ubuntu haproxy[17790]: Proxy heat_cfn_api started.
Sep  1 22:31:49 ubuntu haproxy[17790]: Proxy nova_novnc started.
Sep  1 22:31:49 ubuntu haproxy[17790]: Proxy nova_novnc started.
Sep  1 22:31:49 ubuntu haproxy[17790]: Proxy designate_api started.
Sep  1 22:31:49 ubuntu haproxy[17790]: Proxy designate_api started.
Sep  1 22:31:49 ubuntu haproxy[17790]: Proxy glance_api started.
Sep  1 22:31:49 ubuntu haproxy[17790]: Proxy glance_api started.
Sep  1 22:31:49 ubuntu haproxy[17790]: Proxy heat_api started.
Sep  1 22:31:49 ubuntu haproxy[17790]: Proxy heat_api started.
Sep  1 22:31:49 ubuntu haproxy[17790]: Proxy barbican-api started.
Sep  1 22:31:49 ubuntu haproxy[17790]: Proxy barbican-api started.
Sep  1 22:31:49 ubuntu haproxy[17790]: Proxy nova_metadata_api started.
Sep  1 22:31:49 ubuntu haproxy[17790]: Proxy nova_metadata_api started.
Sep  1 22:31:49 ubuntu haproxy[17790]: Proxy barbican-admin-api started.
Sep  1 22:31:49 ubuntu haproxy[17790]: Proxy barbican-admin-api started.
Sep  1 22:31:49 ubuntu haproxy[17790]: Proxy neutron_api started.
Sep  1 22:31:49 ubuntu haproxy[17790]: Proxy neutron_api started.
Sep  1 22:31:52 ubuntu systemd[1]: Started /bin/systemctl restart rsyslog.service.
Sep  1 22:31:52 ubuntu rsyslogd: [origin software="rsyslogd" swVersion="8.16.0" x-pid="1092" x-info="http://www.rsyslog.com"] exiting on signal 15.
Sep  1 22:31:52 ctl03 rsyslogd: [origin software="rsyslogd" swVersion="8.16.0" x-pid="17840" x-info="http://www.rsyslog.com"] start
Sep  1 22:31:52 ctl03 systemd[1]: Stopping System Logging Service...
Sep  1 22:31:52 ctl03 systemd[1]: Stopped System Logging Service.
Sep  1 22:31:52 ctl03 systemd[1]: Starting System Logging Service...
Sep  1 22:31:52 ctl03 systemd[1]: Started System Logging Service.
Sep  1 22:31:52 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 ]
Sep  1 22:31:52 ctl03 rsyslogd-2307: warning: ~ action is deprecated, consider using the 'stop' statement instead [v8.16.0 try http://www.rsyslog.com/e/2307 ]
Sep  1 22:31:52 ctl03 rsyslogd: rsyslogd's groupid changed to 108
Sep  1 22:31:52 ctl03 rsyslogd: rsyslogd's userid changed to 104
Sep  1 22:31:52 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 ]
Sep  1 22:31:52 ctl03 rsyslogd-2007: action 'action 13' suspended, next retry is Sat Sep  1 22:32:22 2018 [v8.16.0 try http://www.rsyslog.com/e/2007 ]
Sep  1 22:33:10 ctl03 dhclient[871]: DHCPREQUEST of 192.168.11.54 on ens2 to 192.168.11.3 port 67 (xid=0x739639ec)
Sep  1 22:33:10 ctl03 dhclient[871]: DHCPACK of 192.168.11.54 from 192.168.11.3
Sep  1 22:33:10 ctl03 dhclient[871]: bound to 192.168.11.54 -- renewal in 247 seconds.
Sep  1 22:35:31 ctl03 systemd[1]: Started /usr/bin/apt-get -q -y -o DPkg::Options::=--force-confold -o DPkg::Options::=--force-confdef install keystone.
Sep  1 22:35:56 ctl03 systemd[1]: Reloading.
Sep  1 22:35:56 ctl03 systemd[1]: Started ACPI event daemon.
Sep  1 22:36:03 ctl03 systemd[1]: Reloading.
Sep  1 22:36:03 ctl03 systemd[1]: Started ACPI event daemon.
Sep  1 22:36:03 ctl03 systemd[1]: Reloading.
Sep  1 22:36:03 ctl03 systemd[1]: Started ACPI event daemon.
Sep  1 22:36:03 ctl03 systemd[1]: Reloading.
Sep  1 22:36:04 ctl03 systemd[1]: Started ACPI event daemon.
Sep  1 22:36:04 ctl03 systemd[1]: Starting LSB: Apache2 web server...
Sep  1 22:36:04 ctl03 apache2[19866]:  * Starting Apache httpd web server apache2
Sep  1 22:36:04 ctl03 apache2[19866]: AH00558: apache2: Could not reliably determine the server's fully qualified domain name, using 10.167.4.38. Set the 'ServerName' directive globally to suppress this message
Sep  1 22:36:05 ctl03 apache2[19866]:  *
Sep  1 22:36:05 ctl03 systemd[1]: Started LSB: Apache2 web server.
Sep  1 22:36:06 ctl03 libapache2-mod-wsgi: apache2_invoke: Enable module wsgi
Sep  1 22:36:06 ctl03 systemd[1]: Reloading.
Sep  1 22:36:06 ctl03 systemd[1]: Started ACPI event daemon.
Sep  1 22:36:06 ctl03 systemd[1]: Stopping LSB: Apache2 web server...
Sep  1 22:36:06 ctl03 apache2[20062]:  * Stopping Apache httpd web server apache2
Sep  1 22:36:07 ctl03 apache2[20062]:  *
Sep  1 22:36:07 ctl03 systemd[1]: Stopped LSB: Apache2 web server.
Sep  1 22:36:07 ctl03 systemd[1]: Starting LSB: Apache2 web server...
Sep  1 22:36:07 ctl03 apache2[20085]:  * Starting Apache httpd web server apache2
Sep  1 22:36:07 ctl03 apache2[20085]: AH00558: apache2: Could not reliably determine the server's fully qualified domain name, using 10.167.4.38. Set the 'ServerName' directive globally to suppress this message
Sep  1 22:36:08 ctl03 apache2[20085]:  *
Sep  1 22:36:08 ctl03 systemd[1]: Started LSB: Apache2 web server.
Sep  1 22:36:23 ctl03 systemd[1]: Reloading.
Sep  1 22:36:23 ctl03 systemd[1]: Started ACPI event daemon.
Sep  1 22:36:25 ctl03 systemd[1]: Started /usr/bin/apt-get -q -y -o DPkg::Options::=--force-confold -o DPkg::Options::=--force-confdef install python-psycopg2.
Sep  1 22:36:29 ctl03 systemd[1]: Started /usr/bin/apt-get -q -y -o DPkg::Options::=--force-confold -o DPkg::Options::=--force-confdef install python-mysqldb.
Sep  1 22:36:34 ctl03 systemd[1]: Started /usr/bin/apt-get -q -y -o DPkg::Options::=--force-confold -o DPkg::Options::=--force-confdef install mysql-client.
Sep  1 22:36:41 ctl03 salt-minion[1104]: [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.
Sep  1 22:36:42 ctl03 systemd[1]: Started /bin/systemctl reload apache2.service.
Sep  1 22:36:42 ctl03 systemd[1]: Reloading LSB: Apache2 web server.
Sep  1 22:36:42 ctl03 apache2[21686]:  * Reloading Apache httpd web server apache2
Sep  1 22:36:42 ctl03 apache2[21686]:  *
Sep  1 22:36:42 ctl03 systemd[1]: Reloaded LSB: Apache2 web server.
Sep  1 22:36:52 ctl03 systemd[1]: Started /bin/systemctl restart apache2.service.
Sep  1 22:36:52 ctl03 systemd[1]: Stopping LSB: Apache2 web server...
Sep  1 22:36:52 ctl03 apache2[21991]:  * Stopping Apache httpd web server apache2
Sep  1 22:36:53 ctl03 apache2[21991]:  *
Sep  1 22:36:53 ctl03 systemd[1]: Stopped LSB: Apache2 web server.
Sep  1 22:36:53 ctl03 systemd[1]: Starting LSB: Apache2 web server...
Sep  1 22:36:53 ctl03 apache2[22023]:  * Starting Apache httpd web server apache2
Sep  1 22:36:53 ctl03 apache2[22023]: AH00558: apache2: Could not reliably determine the server's fully qualified domain name, using 10.167.4.38. Set the 'ServerName' directive globally to suppress this message
Sep  1 22:36:54 ctl03 apache2[22023]:  *
Sep  1 22:36:54 ctl03 systemd[1]: Started LSB: Apache2 web server.
Sep  1 22:37:17 ctl03 dhclient[871]: DHCPREQUEST of 192.168.11.54 on ens2 to 192.168.11.3 port 67 (xid=0x739639ec)
Sep  1 22:37:17 ctl03 dhclient[871]: DHCPACK of 192.168.11.54 from 192.168.11.3
Sep  1 22:37:17 ctl03 dhclient[871]: bound to 192.168.11.54 -- renewal in 227 seconds.
Sep  1 22:37:27 ctl03 salt-minion[1104]: [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.
Sep  1 22:41:04 ctl03 dhclient[871]: DHCPREQUEST of 192.168.11.54 on ens2 to 192.168.11.3 port 67 (xid=0x739639ec)
Sep  1 22:41:04 ctl03 dhclient[871]: DHCPACK of 192.168.11.54 from 192.168.11.3
Sep  1 22:41:04 ctl03 dhclient[871]: bound to 192.168.11.54 -- renewal in 249 seconds.
Sep  1 22:42:58 ctl03 systemd[1]: Started /usr/bin/apt-get -q -y -o DPkg::Options::=--force-confold -o DPkg::Options::=--force-confdef install glance.
Sep  1 22:43:09 ctl03 systemd[1]: Reloading.
Sep  1 22:43:09 ctl03 systemd[1]: Started ACPI event daemon.
Sep  1 22:43:16 ctl03 systemd[1]: Reloading.
Sep  1 22:43:16 ctl03 systemd[1]: Started ACPI event daemon.
Sep  1 22:43:16 ctl03 systemd[1]: Reloading.
Sep  1 22:43:16 ctl03 systemd[1]: Started ACPI event daemon.
Sep  1 22:43:16 ctl03 systemd[1]: Reloading.
Sep  1 22:43:16 ctl03 systemd[1]: Started ACPI event daemon.
Sep  1 22:43:16 ctl03 systemd[1]: Starting OpenStack Image Service API...
Sep  1 22:43:17 ctl03 systemd[1]: Started OpenStack Image Service API.
Sep  1 22:43:17 ctl03 systemd[1]: Reloading.
Sep  1 22:43:17 ctl03 systemd[1]: Started ACPI event daemon.
Sep  1 22:43:17 ctl03 systemd[1]: Reloading.
Sep  1 22:43:17 ctl03 systemd[1]: Started ACPI event daemon.
Sep  1 22:43:17 ctl03 systemd[1]: Reloading.
Sep  1 22:43:17 ctl03 glance-api[23594]: /usr/lib/python2.7/dist-packages/paste/deploy/loadwsgi.py:22: DeprecationWarning: Parameters to load are deprecated.  Call .resolve and .require separately.
Sep  1 22:43:17 ctl03 glance-api[23594]:   return pkg_resources.EntryPoint.parse("x=" + s).load(False)
Sep  1 22:43:17 ctl03 glance-api[23594]: /usr/lib/python2.7/dist-packages/paste/deploy/loadwsgi.py:22: DeprecationWarning: Parameters to load are deprecated.  Call .resolve and .require separately.
Sep  1 22:43:17 ctl03 glance-api[23594]:   return pkg_resources.EntryPoint.parse("x=" + s).load(False)
Sep  1 22:43:17 ctl03 glance-api[23594]: /usr/lib/python2.7/dist-packages/paste/deploy/loadwsgi.py:22: DeprecationWarning: Parameters to load are deprecated.  Call .resolve and .require separately.
Sep  1 22:43:17 ctl03 glance-api[23594]:   return pkg_resources.EntryPoint.parse("x=" + s).load(False)
Sep  1 22:43:17 ctl03 glance-api[23594]: /usr/lib/python2.7/dist-packages/paste/deploy/loadwsgi.py:22: DeprecationWarning: Parameters to load are deprecated.  Call .resolve and .require separately.
Sep  1 22:43:17 ctl03 glance-api[23594]:   return pkg_resources.EntryPoint.parse("x=" + s).load(False)
Sep  1 22:43:17 ctl03 glance-api[23594]: /usr/lib/python2.7/dist-packages/paste/deploy/loadwsgi.py:22: DeprecationWarning: Parameters to load are deprecated.  Call .resolve and .require separately.
Sep  1 22:43:17 ctl03 glance-api[23594]:   return pkg_resources.EntryPoint.parse("x=" + s).load(False)
Sep  1 22:43:17 ctl03 glance-api[23594]: /usr/lib/python2.7/dist-packages/paste/deploy/loadwsgi.py:22: DeprecationWarning: Parameters to load are deprecated.  Call .resolve and .require separately.
Sep  1 22:43:17 ctl03 glance-api[23594]:   return pkg_resources.EntryPoint.parse("x=" + s).load(False)
Sep  1 22:43:17 ctl03 glance-api[23594]: /usr/lib/python2.7/dist-packages/paste/deploy/loadwsgi.py:22: DeprecationWarning: Parameters to load are deprecated.  Call .resolve and .require separately.
Sep  1 22:43:17 ctl03 glance-api[23594]:   return pkg_resources.EntryPoint.parse("x=" + s).load(False)
Sep  1 22:43:17 ctl03 glance-api[23594]: /usr/lib/python2.7/dist-packages/paste/deploy/loadwsgi.py:22: DeprecationWarning: Parameters to load are deprecated.  Call .resolve and .require separately.
Sep  1 22:43:17 ctl03 glance-api[23594]:   return pkg_resources.EntryPoint.parse("x=" + s).load(False)
Sep  1 22:43:17 ctl03 systemd[1]: Started ACPI event daemon.
Sep  1 22:43:17 ctl03 systemd[1]: Starting OpenStack Image Service Registry...
Sep  1 22:43:17 ctl03 systemd[1]: Started OpenStack Image Service Registry.
Sep  1 22:43:18 ctl03 systemd[1]: Reloading.
Sep  1 22:43:18 ctl03 glance-api[23594]: /usr/lib/python2.7/dist-packages/paste/deploy/loadwsgi.py:22: DeprecationWarning: Parameters to load are deprecated.  Call .resolve and .require separately.
Sep  1 22:43:18 ctl03 glance-api[23594]:   return pkg_resources.EntryPoint.parse("x=" + s).load(False)
Sep  1 22:43:18 ctl03 glance-api[23594]: /usr/lib/python2.7/dist-packages/paste/deploy/loadwsgi.py:22: DeprecationWarning: Parameters to load are deprecated.  Call .resolve and .require separately.
Sep  1 22:43:18 ctl03 glance-api[23594]:   return pkg_resources.EntryPoint.parse("x=" + s).load(False)
Sep  1 22:43:18 ctl03 glance-api[23594]: /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
Sep  1 22:43:18 ctl03 glance-api[23594]:   val = callable(*args, **kw)
Sep  1 22:43:18 ctl03 systemd[1]: Started ACPI event daemon.
Sep  1 22:43:18 ctl03 glance-registry[23720]: /usr/lib/python2.7/dist-packages/paste/deploy/loadwsgi.py:22: DeprecationWarning: Parameters to load are deprecated.  Call .resolve and .require separately.
Sep  1 22:43:18 ctl03 glance-registry[23720]:   return pkg_resources.EntryPoint.parse("x=" + s).load(False)
Sep  1 22:43:18 ctl03 glance-registry[23720]: /usr/lib/python2.7/dist-packages/paste/deploy/loadwsgi.py:22: DeprecationWarning: Parameters to load are deprecated.  Call .resolve and .require separately.
Sep  1 22:43:18 ctl03 glance-registry[23720]:   return pkg_resources.EntryPoint.parse("x=" + s).load(False)
Sep  1 22:43:18 ctl03 glance-registry[23720]: /usr/lib/python2.7/dist-packages/paste/deploy/loadwsgi.py:22: DeprecationWarning: Parameters to load are deprecated.  Call .resolve and .require separately.
Sep  1 22:43:18 ctl03 glance-registry[23720]:   return pkg_resources.EntryPoint.parse("x=" + s).load(False)
Sep  1 22:43:18 ctl03 glance-registry[23720]: /usr/lib/python2.7/dist-packages/paste/deploy/loadwsgi.py:22: DeprecationWarning: Parameters to load are deprecated.  Call .resolve and .require separately.
Sep  1 22:43:18 ctl03 glance-registry[23720]:   return pkg_resources.EntryPoint.parse("x=" + s).load(False)
Sep  1 22:43:18 ctl03 glance-registry[23720]: /usr/lib/python2.7/dist-packages/glance/registry/api/__init__.py:36: DeprecationWarning: Glance Registry service has been deprecated for removal.
Sep  1 22:43:18 ctl03 glance-registry[23720]:   debtcollector.deprecate("Glance Registry service has been "
Sep  1 22:43:18 ctl03 glance-registry[23720]: /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
Sep  1 22:43:18 ctl03 glance-registry[23720]:   val = callable(*args, **kw)
Sep  1 22:43:23 ctl03 systemd[1]: Started /bin/systemctl restart glance-api.service.
Sep  1 22:43:23 ctl03 systemd[1]: Stopping OpenStack Image Service API...
Sep  1 22:43:23 ctl03 systemd[1]: Stopped OpenStack Image Service API.
Sep  1 22:43:23 ctl03 systemd[1]: Starting OpenStack Image Service API...
Sep  1 22:43:23 ctl03 systemd[1]: Started OpenStack Image Service API.
Sep  1 22:43:23 ctl03 systemd[1]: Started /bin/systemctl restart glance-registry.service.
Sep  1 22:43:23 ctl03 systemd[1]: Stopping OpenStack Image Service Registry...
Sep  1 22:43:23 ctl03 systemd[1]: Stopped OpenStack Image Service Registry.
Sep  1 22:43:23 ctl03 systemd[1]: Starting OpenStack Image Service Registry...
Sep  1 22:43:23 ctl03 systemd[1]: Started OpenStack Image Service Registry.
Sep  1 22:43:23 ctl03 crontab[23954]: (root) LIST (glance)
Sep  1 22:43:23 ctl03 salt-minion[1104]: [ERROR   ] Command '['crontab', '-u', 'glance', '-l']' failed with return code: 1
Sep  1 22:43:23 ctl03 salt-minion[1104]: [ERROR   ] stderr: no crontab for glance
Sep  1 22:43:23 ctl03 salt-minion[1104]: [ERROR   ] retcode: 1
Sep  1 22:43:23 ctl03 crontab[23975]: (root) REPLACE (glance)
Sep  1 22:43:23 ctl03 crontab[23976]: (root) LIST (glance)
Sep  1 22:43:23 ctl03 crontab[23977]: (root) REPLACE (glance)
Sep  1 22:43:24 ctl03 glance-api[23887]: /usr/lib/python2.7/dist-packages/paste/deploy/loadwsgi.py:22: DeprecationWarning: Parameters to load are deprecated.  Call .resolve and .require separately.
Sep  1 22:43:24 ctl03 glance-api[23887]:   return pkg_resources.EntryPoint.parse("x=" + s).load(False)
Sep  1 22:43:24 ctl03 glance-api[23887]: /usr/lib/python2.7/dist-packages/paste/deploy/loadwsgi.py:22: DeprecationWarning: Parameters to load are deprecated.  Call .resolve and .require separately.
Sep  1 22:43:24 ctl03 glance-api[23887]:   return pkg_resources.EntryPoint.parse("x=" + s).load(False)
Sep  1 22:43:24 ctl03 glance-api[23887]: /usr/lib/python2.7/dist-packages/paste/deploy/loadwsgi.py:22: DeprecationWarning: Parameters to load are deprecated.  Call .resolve and .require separately.
Sep  1 22:43:24 ctl03 glance-api[23887]:   return pkg_resources.EntryPoint.parse("x=" + s).load(False)
Sep  1 22:43:24 ctl03 glance-api[23887]: /usr/lib/python2.7/dist-packages/paste/deploy/loadwsgi.py:22: DeprecationWarning: Parameters to load are deprecated.  Call .resolve and .require separately.
Sep  1 22:43:24 ctl03 glance-api[23887]:   return pkg_resources.EntryPoint.parse("x=" + s).load(False)
Sep  1 22:43:24 ctl03 glance-api[23887]: /usr/lib/python2.7/dist-packages/paste/deploy/loadwsgi.py:22: DeprecationWarning: Parameters to load are deprecated.  Call .resolve and .require separately.
Sep  1 22:43:24 ctl03 glance-api[23887]:   return pkg_resources.EntryPoint.parse("x=" + s).load(False)
Sep  1 22:43:24 ctl03 glance-api[23887]: /usr/lib/python2.7/dist-packages/paste/deploy/loadwsgi.py:22: DeprecationWarning: Parameters to load are deprecated.  Call .resolve and .require separately.
Sep  1 22:43:24 ctl03 glance-api[23887]:   return pkg_resources.EntryPoint.parse("x=" + s).load(False)
Sep  1 22:43:24 ctl03 glance-api[23887]: /usr/lib/python2.7/dist-packages/paste/deploy/loadwsgi.py:22: DeprecationWarning: Parameters to load are deprecated.  Call .resolve and .require separately.
Sep  1 22:43:24 ctl03 glance-api[23887]:   return pkg_resources.EntryPoint.parse("x=" + s).load(False)
Sep  1 22:43:24 ctl03 glance-api[23887]: /usr/lib/python2.7/dist-packages/paste/deploy/loadwsgi.py:22: DeprecationWarning: Parameters to load are deprecated.  Call .resolve and .require separately.
Sep  1 22:43:24 ctl03 glance-api[23887]:   return pkg_resources.EntryPoint.parse("x=" + s).load(False)
Sep  1 22:43:24 ctl03 glance-api[23887]: /usr/lib/python2.7/dist-packages/paste/deploy/loadwsgi.py:22: DeprecationWarning: Parameters to load are deprecated.  Call .resolve and .require separately.
Sep  1 22:43:24 ctl03 glance-api[23887]:   return pkg_resources.EntryPoint.parse("x=" + s).load(False)
Sep  1 22:43:24 ctl03 glance-registry[23942]: /usr/lib/python2.7/dist-packages/paste/deploy/loadwsgi.py:22: DeprecationWarning: Parameters to load are deprecated.  Call .resolve and .require separately.
Sep  1 22:43:24 ctl03 glance-registry[23942]:   return pkg_resources.EntryPoint.parse("x=" + s).load(False)
Sep  1 22:43:24 ctl03 glance-registry[23942]: /usr/lib/python2.7/dist-packages/paste/deploy/loadwsgi.py:22: DeprecationWarning: Parameters to load are deprecated.  Call .resolve and .require separately.
Sep  1 22:43:24 ctl03 glance-registry[23942]:   return pkg_resources.EntryPoint.parse("x=" + s).load(False)
Sep  1 22:43:24 ctl03 glance-registry[23942]: /usr/lib/python2.7/dist-packages/paste/deploy/loadwsgi.py:22: DeprecationWarning: Parameters to load are deprecated.  Call .resolve and .require separately.
Sep  1 22:43:24 ctl03 glance-registry[23942]:   return pkg_resources.EntryPoint.parse("x=" + s).load(False)
Sep  1 22:43:24 ctl03 glance-registry[23942]: /usr/lib/python2.7/dist-packages/paste/deploy/loadwsgi.py:22: DeprecationWarning: Parameters to load are deprecated.  Call .resolve and .require separately.
Sep  1 22:43:24 ctl03 glance-registry[23942]:   return pkg_resources.EntryPoint.parse("x=" + s).load(False)
Sep  1 22:43:24 ctl03 glance-registry[23942]: /usr/lib/python2.7/dist-packages/paste/deploy/loadwsgi.py:22: DeprecationWarning: Parameters to load are deprecated.  Call .resolve and .require separately.
Sep  1 22:43:24 ctl03 glance-registry[23942]:   return pkg_resources.EntryPoint.parse("x=" + s).load(False)
Sep  1 22:43:24 ctl03 glance-api[23887]: /usr/lib/python2.7/dist-packages/paste/deploy/loadwsgi.py:22: DeprecationWarning: Parameters to load are deprecated.  Call .resolve and .require separately.
Sep  1 22:43:24 ctl03 glance-api[23887]:   return pkg_resources.EntryPoint.parse("x=" + s).load(False)
Sep  1 22:43:24 ctl03 glance-api[23887]: /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
Sep  1 22:43:24 ctl03 glance-api[23887]:   val = callable(*args, **kw)
Sep  1 22:43:24 ctl03 glance-registry[23942]: /usr/lib/python2.7/dist-packages/glance/registry/api/__init__.py:36: DeprecationWarning: Glance Registry service has been deprecated for removal.
Sep  1 22:43:24 ctl03 glance-registry[23942]:   debtcollector.deprecate("Glance Registry service has been "
Sep  1 22:43:24 ctl03 glance-registry[23942]: /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
Sep  1 22:43:24 ctl03 glance-registry[23942]:   val = callable(*args, **kw)
Sep  1 22:45:13 ctl03 dhclient[871]: DHCPREQUEST of 192.168.11.54 on ens2 to 192.168.11.3 port 67 (xid=0x739639ec)
Sep  1 22:45:13 ctl03 dhclient[871]: DHCPACK of 192.168.11.54 from 192.168.11.3
Sep  1 22:45:13 ctl03 dhclient[871]: bound to 192.168.11.54 -- renewal in 256 seconds.
Sep  1 22:49:29 ctl03 dhclient[871]: DHCPREQUEST of 192.168.11.54 on ens2 to 192.168.11.3 port 67 (xid=0x739639ec)
Sep  1 22:49:29 ctl03 dhclient[871]: DHCPACK of 192.168.11.54 from 192.168.11.3
Sep  1 22:49:29 ctl03 dhclient[871]: bound to 192.168.11.54 -- renewal in 278 seconds.
Sep  1 22:50:25 ctl03 systemd[1]: Started /usr/bin/apt-get -q -y -o DPkg::Options::=--force-confold -o DPkg::Options::=--force-confdef install nova-common.
Sep  1 22:51:19 ctl03 systemd[1]: Started /usr/bin/apt-get -q -y -o DPkg::Options::=--force-confold -o DPkg::Options::=--force-confdef install nova-consoleproxy.
Sep  1 22:51:21 ctl03 systemd[1]: Reloading.
Sep  1 22:51:22 ctl03 systemd[1]: Started ACPI event daemon.
Sep  1 22:51:23 ctl03 systemd[1]: Reloading.
Sep  1 22:51:23 ctl03 systemd[1]: Started ACPI event daemon.
Sep  1 22:51:23 ctl03 systemd[1]: Reloading.
Sep  1 22:51:23 ctl03 systemd[1]: Started ACPI event daemon.
Sep  1 22:51:23 ctl03 systemd[1]: Starting LSB: Nova novncproxy server...
Sep  1 22:51:23 ctl03 nova-novncproxy[26753]:  * Starting OpenStack Compute novncproxy nova-novncproxy
Sep  1 22:51:23 ctl03 nova-novncproxy[26753]:    ...done.
Sep  1 22:51:23 ctl03 systemd[1]: Started LSB: Nova novncproxy server.
Sep  1 22:51:23 ctl03 systemd[1]: Reloading.
Sep  1 22:51:23 ctl03 systemd[1]: Started ACPI event daemon.
Sep  1 22:51:23 ctl03 systemd[1]: Reloading.
Sep  1 22:51:23 ctl03 systemd[1]: Started ACPI event daemon.
Sep  1 22:51:23 ctl03 systemd[1]: Starting LSB: Nova Spice HTML5 Proxy...
Sep  1 22:51:23 ctl03 systemd[1]: Started LSB: Nova Spice HTML5 Proxy.
Sep  1 22:51:23 ctl03 systemd[1]: Reloading.
Sep  1 22:51:23 ctl03 systemd[1]: Started ACPI event daemon.
Sep  1 22:51:23 ctl03 systemd[1]: Reloading.
Sep  1 22:51:24 ctl03 systemd[1]: Started ACPI event daemon.
Sep  1 22:51:24 ctl03 systemd[1]: Starting LSB: Nova XVP VNC proxy...
Sep  1 22:51:24 ctl03 systemd[1]: Started LSB: Nova XVP VNC proxy.
Sep  1 22:51:24 ctl03 systemd[1]: Reloading.
Sep  1 22:51:24 ctl03 systemd[1]: Started ACPI event daemon.
Sep  1 22:51:26 ctl03 systemd[1]: Started /usr/bin/apt-get -q -y -o DPkg::Options::=--force-confold -o DPkg::Options::=--force-confdef install nova-api.
Sep  1 22:51:27 ctl03 systemd[1]: Reloading.
Sep  1 22:51:27 ctl03 systemd[1]: Started ACPI event daemon.
Sep  1 22:51:28 ctl03 systemd[1]: Reloading.
Sep  1 22:51:28 ctl03 systemd[1]: Started ACPI event daemon.
Sep  1 22:51:28 ctl03 systemd[1]: Reloading.
Sep  1 22:51:28 ctl03 systemd[1]: Started ACPI event daemon.
Sep  1 22:51:28 ctl03 systemd[1]: Reloading.
Sep  1 22:51:28 ctl03 systemd[1]: Started ACPI event daemon.
Sep  1 22:51:28 ctl03 systemd[1]: Starting OpenStack Compute API...
Sep  1 22:51:28 ctl03 systemd[1]: Started OpenStack Compute API.
Sep  1 22:51:29 ctl03 systemd[1]: Reloading.
Sep  1 22:51:29 ctl03 systemd[1]: Started ACPI event daemon.
Sep  1 22:51:30 ctl03 nova-api[27391]: /usr/lib/python2.7/dist-packages/oslo_db/sqlalchemy/enginefacade.py:332: NotSupportedWarning: Configuration option(s) ['use_tpool'] not supported
Sep  1 22:51:30 ctl03 nova-api[27391]:   exception.NotSupportedWarning
Sep  1 22:51:31 ctl03 systemd[1]: Started /usr/bin/apt-get -q -y -o DPkg::Options::=--force-confold -o DPkg::Options::=--force-confdef install nova-conductor.
Sep  1 22:51:31 ctl03 systemd[1]: nova-api.service: Main process exited, code=exited, status=1/FAILURE
Sep  1 22:51:31 ctl03 systemd[1]: nova-api.service: Unit entered failed state.
Sep  1 22:51:31 ctl03 systemd[1]: nova-api.service: Failed with result 'exit-code'.
Sep  1 22:51:32 ctl03 systemd[1]: nova-api.service: Service hold-off time over, scheduling restart.
Sep  1 22:51:32 ctl03 systemd[1]: Stopped OpenStack Compute API.
Sep  1 22:51:32 ctl03 systemd[1]: Starting OpenStack Compute API...
Sep  1 22:51:32 ctl03 systemd[1]: Started OpenStack Compute API.
Sep  1 22:51:32 ctl03 systemd[1]: Reloading.
Sep  1 22:51:32 ctl03 systemd[1]: Started ACPI event daemon.
Sep  1 22:51:33 ctl03 systemd[1]: Reloading.
Sep  1 22:51:33 ctl03 nova-api[27572]: /usr/lib/python2.7/dist-packages/oslo_db/sqlalchemy/enginefacade.py:332: NotSupportedWarning: Configuration option(s) ['use_tpool'] not supported
Sep  1 22:51:33 ctl03 nova-api[27572]:   exception.NotSupportedWarning
Sep  1 22:51:33 ctl03 systemd[1]: Started ACPI event daemon.
Sep  1 22:51:33 ctl03 systemd[1]: Reloading.
Sep  1 22:51:33 ctl03 systemd[1]: Started ACPI event daemon.
Sep  1 22:51:33 ctl03 systemd[1]: Reloading.
Sep  1 22:51:33 ctl03 systemd[1]: Started ACPI event daemon.
Sep  1 22:51:33 ctl03 systemd[1]: Starting OpenStack Compute Conductor...
Sep  1 22:51:33 ctl03 systemd[1]: Started OpenStack Compute Conductor.
Sep  1 22:51:33 ctl03 systemd[1]: Reloading.
Sep  1 22:51:33 ctl03 systemd[1]: Started ACPI event daemon.
Sep  1 22:51:34 ctl03 nova-conductor[27902]: /usr/lib/python2.7/dist-packages/oslo_db/sqlalchemy/enginefacade.py:332: NotSupportedWarning: Configuration option(s) ['use_tpool'] not supported
Sep  1 22:51:34 ctl03 nova-conductor[27902]:   exception.NotSupportedWarning
Sep  1 22:51:35 ctl03 systemd[1]: nova-api.service: Main process exited, code=exited, status=1/FAILURE
Sep  1 22:51:35 ctl03 systemd[1]: nova-api.service: Unit entered failed state.
Sep  1 22:51:35 ctl03 systemd[1]: nova-api.service: Failed with result 'exit-code'.
Sep  1 22:51:35 ctl03 systemd[1]: nova-api.service: Service hold-off time over, scheduling restart.
Sep  1 22:51:35 ctl03 systemd[1]: Stopped OpenStack Compute API.
Sep  1 22:51:35 ctl03 systemd[1]: Starting OpenStack Compute API...
Sep  1 22:51:35 ctl03 systemd[1]: Started OpenStack Compute API.
Sep  1 22:51:35 ctl03 systemd[1]: Started /usr/bin/apt-get -q -y -o DPkg::Options::=--force-confold -o DPkg::Options::=--force-confdef install nova-consoleauth.
Sep  1 22:51:36 ctl03 nova-api[28017]: /usr/lib/python2.7/dist-packages/oslo_db/sqlalchemy/enginefacade.py:332: NotSupportedWarning: Configuration option(s) ['use_tpool'] not supported
Sep  1 22:51:36 ctl03 nova-api[28017]:   exception.NotSupportedWarning
Sep  1 22:51:36 ctl03 systemd[1]: Reloading.
Sep  1 22:51:37 ctl03 systemd[1]: Started ACPI event daemon.
Sep  1 22:51:37 ctl03 systemd[1]: Reloading.
Sep  1 22:51:37 ctl03 systemd[1]: Started ACPI event daemon.
Sep  1 22:51:37 ctl03 systemd[1]: Reloading.
Sep  1 22:51:37 ctl03 systemd[1]: Started ACPI event daemon.
Sep  1 22:51:37 ctl03 systemd[1]: Reloading.
Sep  1 22:51:37 ctl03 systemd[1]: Started ACPI event daemon.
Sep  1 22:51:37 ctl03 systemd[1]: Starting OpenStack Compute Console...
Sep  1 22:51:38 ctl03 systemd[1]: Started OpenStack Compute Console.
Sep  1 22:51:38 ctl03 systemd[1]: Reloading.
Sep  1 22:51:38 ctl03 systemd[1]: Started ACPI event daemon.
Sep  1 22:51:38 ctl03 systemd[1]: nova-api.service: Main process exited, code=exited, status=1/FAILURE
Sep  1 22:51:38 ctl03 systemd[1]: nova-api.service: Unit entered failed state.
Sep  1 22:51:38 ctl03 systemd[1]: nova-api.service: Failed with result 'exit-code'.
Sep  1 22:51:38 ctl03 systemd[1]: nova-api.service: Service hold-off time over, scheduling restart.
Sep  1 22:51:38 ctl03 systemd[1]: Stopped OpenStack Compute API.
Sep  1 22:51:38 ctl03 systemd[1]: Starting OpenStack Compute API...
Sep  1 22:51:38 ctl03 systemd[1]: Started OpenStack Compute API.
Sep  1 22:51:39 ctl03 nova-consoleauth[28386]: /usr/lib/python2.7/dist-packages/oslo_db/sqlalchemy/enginefacade.py:332: NotSupportedWarning: Configuration option(s) ['use_tpool'] not supported
Sep  1 22:51:39 ctl03 nova-consoleauth[28386]:   exception.NotSupportedWarning
Sep  1 22:51:39 ctl03 nova-api[28446]: /usr/lib/python2.7/dist-packages/oslo_db/sqlalchemy/enginefacade.py:332: NotSupportedWarning: Configuration option(s) ['use_tpool'] not supported
Sep  1 22:51:39 ctl03 nova-api[28446]:   exception.NotSupportedWarning
Sep  1 22:51:40 ctl03 systemd[1]: Started /usr/bin/apt-get -q -y -o DPkg::Options::=--force-confold -o DPkg::Options::=--force-confdef install nova-doc.
Sep  1 22:51:41 ctl03 systemd[1]: nova-api.service: Main process exited, code=exited, status=1/FAILURE
Sep  1 22:51:41 ctl03 systemd[1]: nova-api.service: Unit entered failed state.
Sep  1 22:51:41 ctl03 systemd[1]: nova-api.service: Failed with result 'exit-code'.
Sep  1 22:51:41 ctl03 systemd[1]: nova-api.service: Service hold-off time over, scheduling restart.
Sep  1 22:51:41 ctl03 systemd[1]: Stopped OpenStack Compute API.
Sep  1 22:51:41 ctl03 systemd[1]: Starting OpenStack Compute API...
Sep  1 22:51:41 ctl03 systemd[1]: Started OpenStack Compute API.
Sep  1 22:51:42 ctl03 nova-api[28604]: /usr/lib/python2.7/dist-packages/oslo_db/sqlalchemy/enginefacade.py:332: NotSupportedWarning: Configuration option(s) ['use_tpool'] not supported
Sep  1 22:51:42 ctl03 nova-api[28604]:   exception.NotSupportedWarning
Sep  1 22:51:43 ctl03 systemd[1]: Started /usr/bin/apt-get -q -y -o DPkg::Options::=--force-confold -o DPkg::Options::=--force-confdef install nova-scheduler.
Sep  1 22:51:44 ctl03 systemd[1]: nova-api.service: Main process exited, code=exited, status=1/FAILURE
Sep  1 22:51:44 ctl03 systemd[1]: nova-api.service: Unit entered failed state.
Sep  1 22:51:44 ctl03 systemd[1]: nova-api.service: Failed with result 'exit-code'.
Sep  1 22:51:45 ctl03 systemd[1]: nova-api.service: Service hold-off time over, scheduling restart.
Sep  1 22:51:45 ctl03 systemd[1]: Stopped OpenStack Compute API.
Sep  1 22:51:45 ctl03 systemd[1]: Starting OpenStack Compute API...
Sep  1 22:51:45 ctl03 systemd[1]: Started OpenStack Compute API.
Sep  1 22:51:45 ctl03 systemd[1]: Reloading.
Sep  1 22:51:45 ctl03 systemd[1]: Started ACPI event daemon.
Sep  1 22:51:46 ctl03 nova-api[28942]: /usr/lib/python2.7/dist-packages/oslo_db/sqlalchemy/enginefacade.py:332: NotSupportedWarning: Configuration option(s) ['use_tpool'] not supported
Sep  1 22:51:46 ctl03 nova-api[28942]:   exception.NotSupportedWarning
Sep  1 22:51:46 ctl03 systemd[1]: Reloading.
Sep  1 22:51:46 ctl03 systemd[1]: Started ACPI event daemon.
Sep  1 22:51:46 ctl03 systemd[1]: Reloading.
Sep  1 22:51:46 ctl03 systemd[1]: Started ACPI event daemon.
Sep  1 22:51:46 ctl03 systemd[1]: Reloading.
Sep  1 22:51:46 ctl03 systemd[1]: Started ACPI event daemon.
Sep  1 22:51:46 ctl03 systemd[1]: Starting OpenStack Compute Scheduler...
Sep  1 22:51:46 ctl03 systemd[1]: Started OpenStack Compute Scheduler.
Sep  1 22:51:46 ctl03 systemd[1]: Reloading.
Sep  1 22:51:46 ctl03 systemd[1]: Started ACPI event daemon.
Sep  1 22:51:47 ctl03 nova-scheduler[29097]: /usr/lib/python2.7/dist-packages/oslo_db/sqlalchemy/enginefacade.py:332: NotSupportedWarning: Configuration option(s) ['use_tpool'] not supported
Sep  1 22:51:47 ctl03 nova-scheduler[29097]:   exception.NotSupportedWarning
Sep  1 22:51:48 ctl03 systemd[1]: nova-api.service: Main process exited, code=exited, status=1/FAILURE
Sep  1 22:51:48 ctl03 systemd[1]: nova-api.service: Unit entered failed state.
Sep  1 22:51:48 ctl03 systemd[1]: nova-api.service: Failed with result 'exit-code'.
Sep  1 22:51:48 ctl03 systemd[1]: nova-api.service: Service hold-off time over, scheduling restart.
Sep  1 22:51:48 ctl03 systemd[1]: Stopped OpenStack Compute API.
Sep  1 22:51:48 ctl03 systemd[1]: Starting OpenStack Compute API...
Sep  1 22:51:48 ctl03 systemd[1]: Started OpenStack Compute API.
Sep  1 22:51:48 ctl03 systemd[1]: nova-scheduler.service: Main process exited, code=exited, status=1/FAILURE
Sep  1 22:51:48 ctl03 systemd[1]: nova-scheduler.service: Unit entered failed state.
Sep  1 22:51:48 ctl03 systemd[1]: nova-scheduler.service: Failed with result 'exit-code'.
Sep  1 22:51:49 ctl03 systemd[1]: nova-scheduler.service: Service hold-off time over, scheduling restart.
Sep  1 22:51:49 ctl03 systemd[1]: Stopped OpenStack Compute Scheduler.
Sep  1 22:51:49 ctl03 systemd[1]: Starting OpenStack Compute Scheduler...
Sep  1 22:51:49 ctl03 systemd[1]: Started OpenStack Compute Scheduler.
Sep  1 22:51:49 ctl03 nova-api[29205]: /usr/lib/python2.7/dist-packages/oslo_db/sqlalchemy/enginefacade.py:332: NotSupportedWarning: Configuration option(s) ['use_tpool'] not supported
Sep  1 22:51:49 ctl03 nova-api[29205]:   exception.NotSupportedWarning
Sep  1 22:51:50 ctl03 nova-scheduler[29260]: /usr/lib/python2.7/dist-packages/oslo_db/sqlalchemy/enginefacade.py:332: NotSupportedWarning: Configuration option(s) ['use_tpool'] not supported
Sep  1 22:51:50 ctl03 nova-scheduler[29260]:   exception.NotSupportedWarning
Sep  1 22:51:59 ctl03 systemd[1]: Started /bin/systemctl restart nova-api.service.
Sep  1 22:51:59 ctl03 systemd[1]: Stopping OpenStack Compute API...
Sep  1 22:51:59 ctl03 systemd[1]: Stopped OpenStack Compute API.
Sep  1 22:51:59 ctl03 systemd[1]: Starting OpenStack Compute API...
Sep  1 22:51:59 ctl03 systemd[1]: Started OpenStack Compute API.
Sep  1 22:51:59 ctl03 systemd[1]: Started /bin/systemctl start nova-consoleauth.service.
Sep  1 22:51:59 ctl03 systemd[1]: Starting OpenStack Compute Console...
Sep  1 22:51:59 ctl03 systemd[1]: Started OpenStack Compute Console.
Sep  1 22:51:59 ctl03 systemd[1]: Started /bin/systemctl restart nova-scheduler.service.
Sep  1 22:51:59 ctl03 systemd[1]: Stopping OpenStack Compute Scheduler...
Sep  1 22:52:00 ctl03 nova-api[29374]: /usr/lib/python2.7/dist-packages/oslo_db/sqlalchemy/enginefacade.py:332: NotSupportedWarning: Configuration option(s) ['use_tpool'] not supported
Sep  1 22:52:00 ctl03 nova-api[29374]:   exception.NotSupportedWarning
Sep  1 22:52:00 ctl03 nova-consoleauth[29424]: /usr/lib/python2.7/dist-packages/oslo_db/sqlalchemy/enginefacade.py:332: NotSupportedWarning: Configuration option(s) ['use_tpool'] not supported
Sep  1 22:52:00 ctl03 nova-consoleauth[29424]:   exception.NotSupportedWarning
Sep  1 22:52:06 ctl03 systemd[1]: Stopped OpenStack Compute Scheduler.
Sep  1 22:52:06 ctl03 systemd[1]: Starting OpenStack Compute Scheduler...
Sep  1 22:52:06 ctl03 systemd[1]: Started OpenStack Compute Scheduler.
Sep  1 22:52:06 ctl03 systemd[1]: Started /bin/systemctl restart nova-conductor.service.
Sep  1 22:52:06 ctl03 systemd[1]: Stopping OpenStack Compute Conductor...
Sep  1 22:52:06 ctl03 nova-conductor[27902]: Exception TypeError: "'NoneType' object is not callable" in <bound method _SocketDuckForFd.__del__ of _SocketDuckForFd:4> ignored
Sep  1 22:52:06 ctl03 systemd[1]: Stopped OpenStack Compute Conductor.
Sep  1 22:52:06 ctl03 systemd[1]: Starting OpenStack Compute Conductor...
Sep  1 22:52:06 ctl03 systemd[1]: Started OpenStack Compute Conductor.
Sep  1 22:52:07 ctl03 systemd[1]: Started /bin/systemctl restart nova-novncproxy.service.
Sep  1 22:52:07 ctl03 systemd[1]: Stopping LSB: Nova novncproxy server...
Sep  1 22:52:07 ctl03 nova-novncproxy[29632]:  * Stopping OpenStack Compute novncproxy nova-novncproxy
Sep  1 22:52:07 ctl03 nova-novncproxy[29632]: start-stop-daemon: warning: failed to kill 26780: No such process
Sep  1 22:52:07 ctl03 nova-novncproxy[29632]:    ...done.
Sep  1 22:52:07 ctl03 systemd[1]: Stopped LSB: Nova novncproxy server.
Sep  1 22:52:07 ctl03 systemd[1]: Starting LSB: Nova novncproxy server...
Sep  1 22:52:07 ctl03 nova-novncproxy[29648]:  * Starting OpenStack Compute novncproxy nova-novncproxy
Sep  1 22:52:07 ctl03 nova-novncproxy[29648]:    ...done.
Sep  1 22:52:07 ctl03 systemd[1]: Started LSB: Nova novncproxy server.
Sep  1 22:52:07 ctl03 nova-scheduler[29514]: /usr/lib/python2.7/dist-packages/oslo_db/sqlalchemy/enginefacade.py:332: NotSupportedWarning: Configuration option(s) ['use_tpool'] not supported
Sep  1 22:52:07 ctl03 nova-scheduler[29514]:   exception.NotSupportedWarning
Sep  1 22:52:07 ctl03 nova-conductor[29572]: /usr/lib/python2.7/dist-packages/oslo_db/sqlalchemy/enginefacade.py:332: NotSupportedWarning: Configuration option(s) ['use_tpool'] not supported
Sep  1 22:52:07 ctl03 nova-conductor[29572]:   exception.NotSupportedWarning
Sep  1 22:52:09 ctl03 systemd[1]: Started /usr/bin/apt-get -q -y -o DPkg::Options::=--force-confold -o DPkg::Options::=--force-confdef install nova-placement-api.
Sep  1 22:52:20 ctl03 systemd[1]: Started /bin/systemctl restart apache2.service.
Sep  1 22:52:20 ctl03 systemd[1]: Stopping LSB: Apache2 web server...
Sep  1 22:52:20 ctl03 apache2[29890]:  * Stopping Apache httpd web server apache2
Sep  1 22:52:21 ctl03 apache2[29890]:  *
Sep  1 22:52:21 ctl03 systemd[1]: Stopped LSB: Apache2 web server.
Sep  1 22:52:21 ctl03 systemd[1]: Starting LSB: Apache2 web server...
Sep  1 22:52:21 ctl03 apache2[29927]:  * Starting Apache httpd web server apache2
Sep  1 22:52:21 ctl03 apache2[29927]: AH00558: apache2: Could not reliably determine the server's fully qualified domain name, using 10.167.4.38. Set the 'ServerName' directive globally to suppress this message
Sep  1 22:52:22 ctl03 apache2[29927]:  *
Sep  1 22:52:22 ctl03 systemd[1]: Started LSB: Apache2 web server.
Sep  1 22:54:07 ctl03 dhclient[871]: DHCPREQUEST of 192.168.11.54 on ens2 to 192.168.11.3 port 67 (xid=0x739639ec)
Sep  1 22:54:07 ctl03 dhclient[871]: DHCPACK of 192.168.11.54 from 192.168.11.3
Sep  1 22:54:07 ctl03 dhclient[871]: bound to 192.168.11.54 -- renewal in 262 seconds.
Sep  1 22:54:11 ctl03 systemd[1]: Started /usr/bin/apt-get -q -y -o DPkg::Options::=--force-confold -o DPkg::Options::=--force-confdef install heat-api.
Sep  1 22:54:21 ctl03 systemd[1]: Reloading.
Sep  1 22:54:22 ctl03 systemd[1]: Started ACPI event daemon.
Sep  1 22:54:29 ctl03 systemd[1]: Reloading.
Sep  1 22:54:29 ctl03 systemd[1]: Started ACPI event daemon.
Sep  1 22:54:29 ctl03 systemd[1]: Reloading.
Sep  1 22:54:29 ctl03 systemd[1]: Started ACPI event daemon.
Sep  1 22:54:29 ctl03 systemd[1]: Reloading.
Sep  1 22:54:29 ctl03 systemd[1]: Started ACPI event daemon.
Sep  1 22:54:29 ctl03 systemd[1]: Starting Heat API...
Sep  1 22:54:29 ctl03 systemd[1]: Started Heat API.
Sep  1 22:54:29 ctl03 systemd[1]: Reloading.
Sep  1 22:54:30 ctl03 systemd[1]: Started ACPI event daemon.
Sep  1 22:54:32 ctl03 systemd[1]: Started /usr/bin/apt-get -q -y -o DPkg::Options::=--force-confold -o DPkg::Options::=--force-confdef install heat-api-cfn.
Sep  1 22:54:33 ctl03 systemd[1]: Reloading.
Sep  1 22:54:33 ctl03 systemd[1]: Started ACPI event daemon.
Sep  1 22:54:34 ctl03 systemd[1]: Reloading.
Sep  1 22:54:34 ctl03 systemd[1]: Started ACPI event daemon.
Sep  1 22:54:34 ctl03 systemd[1]: Reloading.
Sep  1 22:54:34 ctl03 systemd[1]: Started ACPI event daemon.
Sep  1 22:54:34 ctl03 systemd[1]: Reloading.
Sep  1 22:54:34 ctl03 systemd[1]: Started ACPI event daemon.
Sep  1 22:54:34 ctl03 systemd[1]: Starting Heat API...
Sep  1 22:54:34 ctl03 systemd[1]: Started Heat API.
Sep  1 22:54:34 ctl03 systemd[1]: Reloading.
Sep  1 22:54:34 ctl03 systemd[1]: Started ACPI event daemon.
Sep  1 22:54:36 ctl03 systemd[1]: Started /usr/bin/apt-get -q -y -o DPkg::Options::=--force-confold -o DPkg::Options::=--force-confdef install heat-engine.
Sep  1 22:54:38 ctl03 systemd[1]: Reloading.
Sep  1 22:54:38 ctl03 systemd[1]: Started ACPI event daemon.
Sep  1 22:54:38 ctl03 systemd[1]: Reloading.
Sep  1 22:54:38 ctl03 systemd[1]: Started ACPI event daemon.
Sep  1 22:54:39 ctl03 systemd[1]: Reloading.
Sep  1 22:54:39 ctl03 systemd[1]: Started ACPI event daemon.
Sep  1 22:54:39 ctl03 systemd[1]: Reloading.
Sep  1 22:54:39 ctl03 systemd[1]: Started ACPI event daemon.
Sep  1 22:54:39 ctl03 systemd[1]: Starting Heat Engine...
Sep  1 22:54:39 ctl03 systemd[1]: Started Heat Engine.
Sep  1 22:54:39 ctl03 systemd[1]: Reloading.
Sep  1 22:54:39 ctl03 systemd[1]: Started ACPI event daemon.
Sep  1 22:54:45 ctl03 systemd[1]: Started /bin/systemctl restart heat-api.service.
Sep  1 22:54:45 ctl03 systemd[1]: Stopping Heat API...
Sep  1 22:54:45 ctl03 systemd[1]: Stopped Heat API.
Sep  1 22:54:45 ctl03 systemd[1]: Starting Heat API...
Sep  1 22:54:45 ctl03 systemd[1]: Started Heat API.
Sep  1 22:54:45 ctl03 systemd[1]: Started /bin/systemctl restart heat-api-cfn.service.
Sep  1 22:54:45 ctl03 systemd[1]: Stopping Heat API...
Sep  1 22:54:45 ctl03 systemd[1]: Stopped Heat API.
Sep  1 22:54:45 ctl03 systemd[1]: Starting Heat API...
Sep  1 22:54:45 ctl03 systemd[1]: Started Heat API.
Sep  1 22:54:45 ctl03 systemd[1]: Started /bin/systemctl restart heat-engine.service.
Sep  1 22:54:45 ctl03 systemd[1]: Stopping Heat Engine...
Sep  1 22:54:45 ctl03 systemd[1]: Stopped Heat Engine.
Sep  1 22:54:45 ctl03 systemd[1]: Starting Heat Engine...
Sep  1 22:54:45 ctl03 systemd[1]: Started Heat Engine.
Sep  1 22:54:47 ctl03 heat-engine[32301]: /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)
Sep  1 22:54:47 ctl03 heat-engine[32301]:   (util.ellipses_string(value),))
Sep  1 22:54:47 ctl03 heat-engine[32301]: /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)
Sep  1 22:54:47 ctl03 heat-engine[32301]:   (util.ellipses_string(value),))
Sep  1 22:54:47 ctl03 heat-engine[32301]: /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)
Sep  1 22:54:47 ctl03 heat-engine[32301]:   (util.ellipses_string(value),))
Sep  1 22:54:47 ctl03 heat-engine[32301]: /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)
Sep  1 22:54:47 ctl03 heat-engine[32301]:   (util.ellipses_string(value),))
Sep  1 22:57:13 ctl03 systemd[1]: Started /usr/bin/apt-get -q -y -o DPkg::Options::=--force-confold -o DPkg::Options::=--force-confdef install cinder-scheduler.
Sep  1 22:57:18 ctl03 systemd[1]: Reloading.
Sep  1 22:57:18 ctl03 systemd[1]: Started ACPI event daemon.
Sep  1 22:57:21 ctl03 systemd[1]: Reloading.
Sep  1 22:57:21 ctl03 systemd[1]: Started ACPI event daemon.
Sep  1 22:57:21 ctl03 systemd[1]: Reloading.
Sep  1 22:57:21 ctl03 systemd[1]: Started ACPI event daemon.
Sep  1 22:57:21 ctl03 systemd[1]: Starting LSB: Start LIO targets...
Sep  1 22:57:31 ctl03 rtslib-fb-targetctl[1055]:  * Loading rstlib-fb targetctl targetctl
Sep  1 22:57:31 ctl03 kernel: [ 3009.041777] Rounding down aligned max_sectors from 4294967295 to 4294967288
Sep  1 22:57:31 ctl03 rtslib-fb-targetctl[1055]:    ...done.
Sep  1 22:57:31 ctl03 systemd[1]: Started LSB: Start LIO targets.
Sep  1 22:57:34 ctl03 systemd[1]: Reloading.
Sep  1 22:57:34 ctl03 systemd[1]: Started ACPI event daemon.
Sep  1 22:57:34 ctl03 systemd[1]: Reloading.
Sep  1 22:57:34 ctl03 systemd[1]: Started ACPI event daemon.
Sep  1 22:57:34 ctl03 systemd[1]: Reloading.
Sep  1 22:57:34 ctl03 systemd[1]: Started ACPI event daemon.
Sep  1 22:57:34 ctl03 systemd[1]: Starting OpenStack Cinder Scheduler...
Sep  1 22:57:34 ctl03 systemd[1]: Started OpenStack Cinder Scheduler.
Sep  1 22:57:34 ctl03 systemd[1]: Reloading.
Sep  1 22:57:35 ctl03 systemd[1]: Started ACPI event daemon.
Sep  1 22:57:36 ctl03 systemd[1]: cinder-scheduler.service: Main process exited, code=exited, status=1/FAILURE
Sep  1 22:57:36 ctl03 systemd[1]: cinder-scheduler.service: Unit entered failed state.
Sep  1 22:57:36 ctl03 systemd[1]: cinder-scheduler.service: Failed with result 'exit-code'.
Sep  1 22:57:36 ctl03 systemd[1]: cinder-scheduler.service: Service hold-off time over, scheduling restart.
Sep  1 22:57:36 ctl03 systemd[1]: Stopped OpenStack Cinder Scheduler.
Sep  1 22:57:36 ctl03 systemd[1]: Starting OpenStack Cinder Scheduler...
Sep  1 22:57:36 ctl03 systemd[1]: Started OpenStack Cinder Scheduler.
Sep  1 22:57:43 ctl03 systemd[1]: Started /bin/systemctl restart apache2.service.
Sep  1 22:57:43 ctl03 systemd[1]: Stopping LSB: Apache2 web server...
Sep  1 22:57:43 ctl03 apache2[1424]:  * Stopping Apache httpd web server apache2
Sep  1 22:57:45 ctl03 apache2[1424]:  *
Sep  1 22:57:45 ctl03 systemd[1]: Stopped LSB: Apache2 web server.
Sep  1 22:57:45 ctl03 systemd[1]: Starting LSB: Apache2 web server...
Sep  1 22:57:45 ctl03 apache2[1463]:  * Starting Apache httpd web server apache2
Sep  1 22:57:45 ctl03 apache2[1463]: AH00558: apache2: Could not reliably determine the server's fully qualified domain name, using 10.167.4.38. Set the 'ServerName' directive globally to suppress this message
Sep  1 22:57:46 ctl03 apache2[1463]:  *
Sep  1 22:57:46 ctl03 systemd[1]: Started LSB: Apache2 web server.
Sep  1 22:57:46 ctl03 systemd[1]: Started /bin/systemctl restart cinder-scheduler.service.
Sep  1 22:57:46 ctl03 systemd[1]: Stopping OpenStack Cinder Scheduler...
Sep  1 22:57:53 ctl03 systemd[1]: Stopped OpenStack Cinder Scheduler.
Sep  1 22:57:53 ctl03 systemd[1]: Starting OpenStack Cinder Scheduler...
Sep  1 22:57:53 ctl03 systemd[1]: Started OpenStack Cinder Scheduler.
Sep  1 22:58:29 ctl03 dhclient[871]: DHCPREQUEST of 192.168.11.54 on ens2 to 192.168.11.3 port 67 (xid=0x739639ec)
Sep  1 22:58:29 ctl03 dhclient[871]: DHCPACK of 192.168.11.54 from 192.168.11.3
Sep  1 22:58:29 ctl03 dhclient[871]: bound to 192.168.11.54 -- renewal in 265 seconds.
Sep  1 23:02:54 ctl03 dhclient[871]: DHCPREQUEST of 192.168.11.54 on ens2 to 192.168.11.3 port 67 (xid=0x739639ec)
Sep  1 23:02:54 ctl03 dhclient[871]: DHCPACK of 192.168.11.54 from 192.168.11.3
Sep  1 23:02:54 ctl03 dhclient[871]: bound to 192.168.11.54 -- renewal in 251 seconds.
Sep  1 23:03:29 ctl03 systemd[1]: Started /usr/bin/apt-get -q -y -o DPkg::Options::=--force-confold -o DPkg::Options::=--force-confdef install neutron-server.
Sep  1 23:03:38 ctl03 systemd[1]: Reloading.
Sep  1 23:03:39 ctl03 systemd[1]: Started ACPI event daemon.
Sep  1 23:03:45 ctl03 systemd[1]: Reloading.
Sep  1 23:03:45 ctl03 systemd[1]: Started ACPI event daemon.
Sep  1 23:03:45 ctl03 systemd[1]: Reloading.
Sep  1 23:03:45 ctl03 systemd[1]: Started ACPI event daemon.
Sep  1 23:03:46 ctl03 systemd[1]: Reloading.
Sep  1 23:03:46 ctl03 systemd[1]: Started ACPI event daemon.
Sep  1 23:03:48 ctl03 systemd[1]: Started /usr/bin/apt-get -q -y -o DPkg::Options::=--force-confold -o DPkg::Options::=--force-confdef install python-neutron-lbaas.
Sep  1 23:03:54 ctl03 systemd[1]: Started /bin/systemctl start neutron-server.service.
Sep  1 23:03:54 ctl03 systemd[1]: Starting OpenStack Neutron Server...
Sep  1 23:03:54 ctl03 systemd[1]: Started OpenStack Neutron Server.
Sep  1 23:07:05 ctl03 dhclient[871]: DHCPREQUEST of 192.168.11.54 on ens2 to 192.168.11.3 port 67 (xid=0x739639ec)
Sep  1 23:07:05 ctl03 dhclient[871]: DHCPACK of 192.168.11.54 from 192.168.11.3
Sep  1 23:07:05 ctl03 dhclient[871]: bound to 192.168.11.54 -- renewal in 237 seconds.
Sep  1 23:09:20 ctl03 systemd[1]: Started /usr/bin/apt-get -q -y -o DPkg::Options::=--force-confold -o DPkg::Options::=--force-confdef install barbican-api.
Sep  1 23:09:27 ctl03 systemd[1]: Started /usr/bin/apt-get -q -y -o DPkg::Options::=--force-confold -o DPkg::Options::=--force-confdef install barbican-keystone-listener.
Sep  1 23:09:28 ctl03 systemd[1]: Reloading.
Sep  1 23:09:28 ctl03 systemd[1]: Started ACPI event daemon.
Sep  1 23:09:29 ctl03 systemd[1]: Reloading.
Sep  1 23:09:29 ctl03 systemd[1]: Started ACPI event daemon.
Sep  1 23:09:29 ctl03 systemd[1]: Reloading.
Sep  1 23:09:29 ctl03 systemd[1]: Started ACPI event daemon.
Sep  1 23:09:29 ctl03 systemd[1]: Reloading.
Sep  1 23:09:29 ctl03 systemd[1]: Started ACPI event daemon.
Sep  1 23:09:29 ctl03 systemd[1]: Starting OpenStack Barbican Keystone Event Listener...
Sep  1 23:09:29 ctl03 systemd[1]: Started OpenStack Barbican Keystone Event Listener.
Sep  1 23:09:30 ctl03 systemd[1]: Reloading.
Sep  1 23:09:30 ctl03 systemd[1]: Started ACPI event daemon.
Sep  1 23:09:32 ctl03 systemd[1]: Started /usr/bin/apt-get -q -y -o DPkg::Options::=--force-confold -o DPkg::Options::=--force-confdef install barbican-worker.
Sep  1 23:09:33 ctl03 systemd[1]: Reloading.
Sep  1 23:09:33 ctl03 systemd[1]: Started ACPI event daemon.
Sep  1 23:09:33 ctl03 systemd[1]: Reloading.
Sep  1 23:09:34 ctl03 systemd[1]: Started ACPI event daemon.
Sep  1 23:09:34 ctl03 systemd[1]: Reloading.
Sep  1 23:09:34 ctl03 systemd[1]: Started ACPI event daemon.
Sep  1 23:09:34 ctl03 systemd[1]: Reloading.
Sep  1 23:09:34 ctl03 systemd[1]: Started ACPI event daemon.
Sep  1 23:09:34 ctl03 systemd[1]: Starting OpenStack Barbican Key Management Workers...
Sep  1 23:09:34 ctl03 systemd[1]: Started OpenStack Barbican Key Management Workers.
Sep  1 23:09:34 ctl03 systemd[1]: Reloading.
Sep  1 23:09:34 ctl03 systemd[1]: Started ACPI event daemon.
Sep  1 23:09:39 ctl03 systemd[1]: Started /bin/systemctl restart apache2.service.
Sep  1 23:09:39 ctl03 systemd[1]: Stopping LSB: Apache2 web server...
Sep  1 23:09:39 ctl03 apache2[5058]:  * Stopping Apache httpd web server apache2
Sep  1 23:09:40 ctl03 apache2[5058]:  *
Sep  1 23:09:40 ctl03 systemd[1]: Stopped LSB: Apache2 web server.
Sep  1 23:09:40 ctl03 systemd[1]: Starting LSB: Apache2 web server...
Sep  1 23:09:40 ctl03 apache2[5099]:  * Starting Apache httpd web server apache2
Sep  1 23:09:40 ctl03 apache2[5099]: AH00558: apache2: Could not reliably determine the server's fully qualified domain name, using 10.167.4.38. Set the 'ServerName' directive globally to suppress this message
Sep  1 23:09:41 ctl03 apache2[5099]:  *
Sep  1 23:09:41 ctl03 systemd[1]: Started LSB: Apache2 web server.
Sep  1 23:09:41 ctl03 systemd[1]: Started /bin/systemctl start barbican-keystone-listener.service.
Sep  1 23:09:41 ctl03 systemd[1]: Starting OpenStack Barbican Keystone Event Listener...
Sep  1 23:09:41 ctl03 systemd[1]: Started OpenStack Barbican Keystone Event Listener.
Sep  1 23:09:41 ctl03 systemd[1]: Started /bin/systemctl stop barbican-worker.service.
Sep  1 23:09:41 ctl03 systemd[1]: Stopping OpenStack Barbican Key Management Workers...
Sep  1 23:09:56 ctl03 systemd[1]: barbican-worker.service: State 'stop-sigterm' timed out. Killing.
Sep  1 23:09:56 ctl03 systemd[1]: barbican-worker.service: Main process exited, code=killed, status=9/KILL
Sep  1 23:09:56 ctl03 systemd[1]: Stopped OpenStack Barbican Key Management Workers.
Sep  1 23:09:56 ctl03 systemd[1]: barbican-worker.service: Unit entered failed state.
Sep  1 23:09:56 ctl03 systemd[1]: barbican-worker.service: Failed with result 'signal'.
Sep  1 23:09:56 ctl03 systemd[1]: Started /bin/systemctl disable barbican-worker.service.
Sep  1 23:09:56 ctl03 systemd[1]: Reloading.
Sep  1 23:09:56 ctl03 systemd[1]: Started ACPI event daemon.
Sep  1 23:09:56 ctl03 systemd[1]: Reloading.
Sep  1 23:09:57 ctl03 systemd[1]: Started ACPI event daemon.
Sep  1 23:09:57 ctl03 systemd[1]: Reloading.
Sep  1 23:09:57 ctl03 systemd[1]: Started ACPI event daemon.
Sep  1 23:11:02 ctl03 dhclient[871]: DHCPREQUEST of 192.168.11.54 on ens2 to 192.168.11.3 port 67 (xid=0x739639ec)
Sep  1 23:11:02 ctl03 dhclient[871]: DHCPACK of 192.168.11.54 from 192.168.11.3
Sep  1 23:11:03 ctl03 dhclient[871]: bound to 192.168.11.54 -- renewal in 294 seconds.
Sep  1 23:15:56 ctl03 dhclient[871]: DHCPREQUEST of 192.168.11.54 on ens2 to 192.168.11.3 port 67 (xid=0x739639ec)
Sep  1 23:15:56 ctl03 dhclient[871]: DHCPACK of 192.168.11.54 from 192.168.11.3
Sep  1 23:15:56 ctl03 dhclient[871]: bound to 192.168.11.54 -- renewal in 239 seconds.
Sep  1 23:17:01 ctl03 CRON[5718]: (root) CMD (   cd / && run-parts --report /etc/cron.hourly)
Sep  1 23:19:55 ctl03 dhclient[871]: DHCPREQUEST of 192.168.11.54 on ens2 to 192.168.11.3 port 67 (xid=0x739639ec)
Sep  1 23:19:56 ctl03 dhclient[871]: DHCPACK of 192.168.11.54 from 192.168.11.3
Sep  1 23:19:56 ctl03 dhclient[871]: bound to 192.168.11.54 -- renewal in 264 seconds.
Sep  1 23:24:20 ctl03 dhclient[871]: DHCPREQUEST of 192.168.11.54 on ens2 to 192.168.11.3 port 67 (xid=0x739639ec)
Sep  1 23:24:21 ctl03 dhclient[871]: DHCPACK of 192.168.11.54 from 192.168.11.3
Sep  1 23:24:21 ctl03 dhclient[871]: bound to 192.168.11.54 -- renewal in 236 seconds.
Sep  1 23:25:41 ctl03 nova-api[29374]: /usr/lib/python2.7/dist-packages/sqlalchemy/sql/default_comparator.py:153: SAWarning: The IN-predicate on "instance_mappings.instance_uuid" was invoked with an empty sequence. This results in a contradiction, which nonetheless can be expensive to evaluate.  Consider alternative strategies for improved performance.
Sep  1 23:25:41 ctl03 nova-api[29374]:   'strategies for improved performance.' % expr)
Sep  1 23:28:17 ctl03 dhclient[871]: DHCPREQUEST of 192.168.11.54 on ens2 to 192.168.11.3 port 67 (xid=0x739639ec)
Sep  1 23:28:17 ctl03 dhclient[871]: DHCPACK of 192.168.11.54 from 192.168.11.3
Sep  1 23:28:17 ctl03 dhclient[871]: bound to 192.168.11.54 -- renewal in 236 seconds.
Sep  1 23:30:40 ctl03 nova-api[29374]: /usr/lib/python2.7/dist-packages/sqlalchemy/sql/default_comparator.py:153: SAWarning: The IN-predicate on "instance_mappings.instance_uuid" was invoked with an empty sequence. This results in a contradiction, which nonetheless can be expensive to evaluate.  Consider alternative strategies for improved performance.
Sep  1 23:30:40 ctl03 nova-api[29374]:   'strategies for improved performance.' % expr)
Sep  1 23:31:08 ctl03 systemd[1]: Started /bin/systemctl restart glance-api.service.
Sep  1 23:31:09 ctl03 systemd[1]: Stopping OpenStack Image Service API...
Sep  1 23:31:09 ctl03 systemd[1]: Stopped OpenStack Image Service API.
Sep  1 23:31:09 ctl03 systemd[1]: Starting OpenStack Image Service API...
Sep  1 23:31:09 ctl03 systemd[1]: Started OpenStack Image Service API.
Sep  1 23:31:09 ctl03 glance-api[5797]: /usr/lib/python2.7/dist-packages/paste/deploy/loadwsgi.py:22: DeprecationWarning: Parameters to load are deprecated.  Call .resolve and .require separately.
Sep  1 23:31:09 ctl03 glance-api[5797]:   return pkg_resources.EntryPoint.parse("x=" + s).load(False)
Sep  1 23:31:09 ctl03 glance-api[5797]: /usr/lib/python2.7/dist-packages/paste/deploy/loadwsgi.py:22: DeprecationWarning: Parameters to load are deprecated.  Call .resolve and .require separately.
Sep  1 23:31:09 ctl03 glance-api[5797]:   return pkg_resources.EntryPoint.parse("x=" + s).load(False)
Sep  1 23:31:09 ctl03 glance-api[5797]: /usr/lib/python2.7/dist-packages/paste/deploy/loadwsgi.py:22: DeprecationWarning: Parameters to load are deprecated.  Call .resolve and .require separately.
Sep  1 23:31:09 ctl03 glance-api[5797]:   return pkg_resources.EntryPoint.parse("x=" + s).load(False)
Sep  1 23:31:09 ctl03 glance-api[5797]: /usr/lib/python2.7/dist-packages/paste/deploy/loadwsgi.py:22: DeprecationWarning: Parameters to load are deprecated.  Call .resolve and .require separately.
Sep  1 23:31:09 ctl03 glance-api[5797]:   return pkg_resources.EntryPoint.parse("x=" + s).load(False)
Sep  1 23:31:09 ctl03 glance-api[5797]: /usr/lib/python2.7/dist-packages/paste/deploy/loadwsgi.py:22: DeprecationWarning: Parameters to load are deprecated.  Call .resolve and .require separately.
Sep  1 23:31:09 ctl03 glance-api[5797]:   return pkg_resources.EntryPoint.parse("x=" + s).load(False)
Sep  1 23:31:09 ctl03 glance-api[5797]: /usr/lib/python2.7/dist-packages/paste/deploy/loadwsgi.py:22: DeprecationWarning: Parameters to load are deprecated.  Call .resolve and .require separately.
Sep  1 23:31:09 ctl03 glance-api[5797]:   return pkg_resources.EntryPoint.parse("x=" + s).load(False)
Sep  1 23:31:09 ctl03 glance-api[5797]: /usr/lib/python2.7/dist-packages/paste/deploy/loadwsgi.py:22: DeprecationWarning: Parameters to load are deprecated.  Call .resolve and .require separately.
Sep  1 23:31:09 ctl03 glance-api[5797]:   return pkg_resources.EntryPoint.parse("x=" + s).load(False)
Sep  1 23:31:10 ctl03 glance-api[5797]: /usr/lib/python2.7/dist-packages/paste/deploy/loadwsgi.py:22: DeprecationWarning: Parameters to load are deprecated.  Call .resolve and .require separately.
Sep  1 23:31:10 ctl03 glance-api[5797]:   return pkg_resources.EntryPoint.parse("x=" + s).load(False)
Sep  1 23:31:10 ctl03 glance-api[5797]: /usr/lib/python2.7/dist-packages/paste/deploy/loadwsgi.py:22: DeprecationWarning: Parameters to load are deprecated.  Call .resolve and .require separately.
Sep  1 23:31:10 ctl03 glance-api[5797]:   return pkg_resources.EntryPoint.parse("x=" + s).load(False)
Sep  1 23:31:10 ctl03 glance-api[5797]: /usr/lib/python2.7/dist-packages/paste/deploy/loadwsgi.py:22: DeprecationWarning: Parameters to load are deprecated.  Call .resolve and .require separately.
Sep  1 23:31:10 ctl03 glance-api[5797]:   return pkg_resources.EntryPoint.parse("x=" + s).load(False)
Sep  1 23:31:10 ctl03 glance-api[5797]: /usr/lib/python2.7/dist-packages/paste/deploy/loadwsgi.py:22: DeprecationWarning: Parameters to load are deprecated.  Call .resolve and .require separately.
Sep  1 23:31:10 ctl03 glance-api[5797]:   return pkg_resources.EntryPoint.parse("x=" + s).load(False)
Sep  1 23:31:10 ctl03 glance-api[5797]: /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
Sep  1 23:31:10 ctl03 glance-api[5797]:   val = callable(*args, **kw)
