Jan 26 18:02:06 odl01 rsyslogd: [origin software="rsyslogd" swVersion="8.16.0" x-pid="1084" x-info="http://www.rsyslog.com"] start
Jan 26 18:02:06 odl01 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 ]
Jan 26 18:02:06 odl01 rsyslogd: rsyslogd's groupid changed to 108
Jan 26 18:02:06 odl01 rsyslogd: rsyslogd's userid changed to 104
Jan 26 18:02:06 odl01 systemd-modules-load[381]: Inserted module 'iscsi_tcp'
Jan 26 18:02:06 odl01 loadkeys[369]: Loading /etc/console-setup/cached.kmap.gz
Jan 26 18:02:06 odl01 systemd[1]: Started Nameserver information manager.
Jan 26 18:02:06 odl01 systemd-modules-load[381]: Inserted module 'ib_iser'
Jan 26 18:02:06 odl01 systemd[1]: Started Load Kernel Modules.
Jan 26 18:02:06 odl01 systemd[1]: Mounting FUSE Control File System...
Jan 26 18:02:06 odl01 systemd[1]: Starting Apply Kernel Variables...
Jan 26 18:02:06 odl01 systemd[1]: Started LVM2 metadata daemon.
Jan 26 18:02:06 odl01 systemd[1]: Starting Create Static Device Nodes in /dev...
Jan 26 18:02:06 odl01 systemd[1]: Starting Initial cloud-init job (pre-networking)...
Jan 26 18:02:06 odl01 systemd[1]: Starting Load/Save Random Seed...
Jan 26 18:02:06 odl01 systemd[1]: Starting udev Coldplug all Devices...
Jan 26 18:02:06 odl01 systemd[1]: Starting Flush Journal to Persistent Storage...
Jan 26 18:02:06 odl01 systemd[1]: Mounted FUSE Control File System.
Jan 26 18:02:06 odl01 systemd[1]: Started Apply Kernel Variables.
Jan 26 18:02:06 odl01 systemd[1]: Started Load/Save Random Seed.
Jan 26 18:02:06 odl01 kernel: [    0.000000] Initializing cgroup subsys cpuset
Jan 26 18:02:06 odl01 kernel: [    0.000000] Initializing cgroup subsys cpu
Jan 26 18:02:06 odl01 systemd[1]: Started Flush Journal to Persistent Storage.
Jan 26 18:02:06 odl01 kernel: [    0.000000] Initializing cgroup subsys cpuacct
Jan 26 18:02:06 odl01 kernel: [    0.000000] Linux version 4.4.0-112-generic (buildd@lgw01-amd64-010) (gcc version 5.4.0 20160609 (Ubuntu 5.4.0-6ubuntu1~16.04.5) ) #135-Ubuntu SMP Fri Jan 19 11:48:36 UTC 2018 (Ubuntu 4.4.0-112.135-generic 4.4.98)
Jan 26 18:02:06 odl01 kernel: [    0.000000] Command line: BOOT_IMAGE=/boot/vmlinuz-4.4.0-112-generic root=LABEL=cloudimg-rootfs ro console=tty1 console=ttyS0
Jan 26 18:02:06 odl01 kernel: [    0.000000] KERNEL supported cpus:
Jan 26 18:02:06 odl01 kernel: [    0.000000]   Intel GenuineIntel
Jan 26 18:02:06 odl01 kernel: [    0.000000]   AMD AuthenticAMD
Jan 26 18:02:06 odl01 systemd[1]: Started Create Static Device Nodes in /dev.
Jan 26 18:02:06 odl01 kernel: [    0.000000]   Centaur CentaurHauls
Jan 26 18:02:06 odl01 kernel: [    0.000000] x86/fpu: xstate_offset[2]:  576, xstate_sizes[2]:  256
Jan 26 18:02:06 odl01 kernel: [    0.000000] x86/fpu: Supporting XSAVE feature 0x01: 'x87 floating point registers'
Jan 26 18:02:06 odl01 systemd[1]: Starting udev Kernel Device Manager...
Jan 26 18:02:06 odl01 kernel: [    0.000000] x86/fpu: Supporting XSAVE feature 0x02: 'SSE registers'
Jan 26 18:02:06 odl01 kernel: [    0.000000] x86/fpu: Supporting XSAVE feature 0x04: 'AVX registers'
Jan 26 18:02:06 odl01 kernel: [    0.000000] x86/fpu: Enabled xstate features 0x7, context size is 832 bytes, using 'standard' format.
Jan 26 18:02:06 odl01 kernel: [    0.000000] x86/fpu: Using 'eager' FPU context switches.
Jan 26 18:02:06 odl01 systemd[1]: Started udev Coldplug all Devices.
Jan 26 18:02:06 odl01 kernel: [    0.000000] e820: BIOS-provided physical RAM map:
Jan 26 18:02:06 odl01 systemd[1]: Started udev Kernel Device Manager.
Jan 26 18:02:06 odl01 kernel: [    0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable
Jan 26 18:02:06 odl01 kernel: [    0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved
Jan 26 18:02:06 odl01 kernel: [    0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved
Jan 26 18:02:06 odl01 kernel: [    0.000000] BIOS-e820: [mem 0x0000000000100000-0x00000000bffdefff] usable
Jan 26 18:02:06 odl01 systemd[1]: Started Dispatch Password Requests to Console Directory Watch.
Jan 26 18:02:06 odl01 kernel: [    0.000000] BIOS-e820: [mem 0x00000000bffdf000-0x00000000bfffffff] reserved
Jan 26 18:02:06 odl01 kernel: [    0.000000] BIOS-e820: [mem 0x00000000feffc000-0x00000000feffffff] reserved
Jan 26 18:02:06 odl01 systemd[1]: Found device /dev/ttyS0.
Jan 26 18:02:06 odl01 kernel: [    0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved
Jan 26 18:02:06 odl01 kernel: [    0.000000] BIOS-e820: [mem 0x0000000100000000-0x000000017fffffff] usable
Jan 26 18:02:06 odl01 kernel: [    0.000000] NX (Execute Disable) protection: active
Jan 26 18:02:06 odl01 kernel: [    0.000000] SMBIOS 2.8 present.
Jan 26 18:02:06 odl01 kernel: [    0.000000] DMI: QEMU Standard PC (i440FX + PIIX, 1996), BIOS Ubuntu-1.8.2-1ubuntu1 04/01/2014
Jan 26 18:02:06 odl01 kernel: [    0.000000] Hypervisor detected: KVM
Jan 26 18:02:06 odl01 systemd[1]: Started Monitoring of LVM2 mirrors, snapshots etc. using dmeventd or progress polling.
Jan 26 18:02:06 odl01 kernel: [    0.000000] e820: update [mem 0x00000000-0x00000fff] usable ==> reserved
Jan 26 18:02:06 odl01 kernel: [    0.000000] e820: remove [mem 0x000a0000-0x000fffff] usable
Jan 26 18:02:06 odl01 kernel: [    0.000000] e820: last_pfn = 0x180000 max_arch_pfn = 0x400000000
Jan 26 18:02:06 odl01 kernel: [    0.000000] MTRR default type: write-back
Jan 26 18:02:06 odl01 systemd[1]: Reached target Local File Systems (Pre).
Jan 26 18:02:06 odl01 kernel: [    0.000000] MTRR fixed ranges enabled:
Jan 26 18:02:06 odl01 kernel: [    0.000000]   00000-9FFFF write-back
Jan 26 18:02:06 odl01 systemd[1]: Reached target Local File Systems.
Jan 26 18:02:06 odl01 kernel: [    0.000000]   A0000-BFFFF uncachable
Jan 26 18:02:06 odl01 kernel: [    0.000000]   C0000-FFFFF write-protect
Jan 26 18:02:06 odl01 systemd[1]: Starting Commit a transient machine-id on disk...
Jan 26 18:02:06 odl01 kernel: [    0.000000] MTRR variable ranges enabled:
Jan 26 18:02:06 odl01 kernel: [    0.000000]   0 base 00C0000000 mask FFC0000000 uncachable
Jan 26 18:02:06 odl01 systemd[1]: Starting Tell Plymouth To Write Out Runtime Data...
Jan 26 18:02:06 odl01 kernel: [    0.000000]   1 disabled
Jan 26 18:02:06 odl01 kernel: [    0.000000]   2 disabled
Jan 26 18:02:06 odl01 kernel: [    0.000000]   3 disabled
Jan 26 18:02:06 odl01 kernel: [    0.000000]   4 disabled
Jan 26 18:02:06 odl01 systemd[1]: Starting Create Volatile Files and Directories...
Jan 26 18:02:06 odl01 kernel: [    0.000000]   5 disabled
Jan 26 18:02:06 odl01 kernel: [    0.000000]   6 disabled
Jan 26 18:02:06 odl01 kernel: [    0.000000]   7 disabled
Jan 26 18:02:06 odl01 systemd[1]: Starting LSB: AppArmor initialization...
Jan 26 18:02:06 odl01 kernel: [    0.000000] x86/PAT: Configuration [0-7]: WB  WC  UC- UC  WB  WC  UC- WT  
Jan 26 18:02:06 odl01 kernel: [    0.000000] e820: last_pfn = 0xbffdf max_arch_pfn = 0x400000000
Jan 26 18:02:06 odl01 kernel: [    0.000000] found SMP MP-table at [mem 0x000f65b0-0x000f65bf] mapped at [ffff8800000f65b0]
Jan 26 18:02:06 odl01 kernel: [    0.000000] Scanning 1 areas for low memory corruption
Jan 26 18:02:06 odl01 kernel: [    0.000000] Base memory trampoline at [ffff880000099000] 99000 size 24576
Jan 26 18:02:06 odl01 kernel: [    0.000000] Using GB pages for direct mapping
Jan 26 18:02:06 odl01 systemd-tmpfiles[497]: [/usr/lib/tmpfiles.d/var.conf:14] Duplicate line for path "/var/log", ignoring.
Jan 26 18:02:06 odl01 kernel: [    0.000000] BRK [0x02215000, 0x02215fff] PGTABLE
Jan 26 18:02:06 odl01 kernel: [    0.000000] BRK [0x02216000, 0x02216fff] PGTABLE
Jan 26 18:02:06 odl01 kernel: [    0.000000] BRK [0x02217000, 0x02217fff] PGTABLE
Jan 26 18:02:06 odl01 systemd[1]: Starting Set console font and keymap...
Jan 26 18:02:06 odl01 kernel: [    0.000000] RAMDISK: [mem 0x36adc000-0x37565fff]
Jan 26 18:02:06 odl01 kernel: [    0.000000] ACPI: Early table checksum verification disabled
Jan 26 18:02:06 odl01 kernel: [    0.000000] ACPI: RSDP 0x00000000000F6560 000014 (v00 BOCHS )
Jan 26 18:02:06 odl01 systemd[1]: Started Tell Plymouth To Write Out Runtime Data.
Jan 26 18:02:06 odl01 kernel: [    0.000000] ACPI: RSDT 0x00000000BFFE1497 000030 (v01 BOCHS  BXPCRSDT 00000001 BXPC 00000001)
Jan 26 18:02:06 odl01 kernel: [    0.000000] ACPI: FACP 0x00000000BFFE0954 000074 (v01 BOCHS  BXPCFACP 00000001 BXPC 00000001)
Jan 26 18:02:06 odl01 kernel: [    0.000000] ACPI: DSDT 0x00000000BFFDFD80 000BD4 (v01 BOCHS  BXPCDSDT 00000001 BXPC 00000001)
Jan 26 18:02:06 odl01 kernel: [    0.000000] ACPI: FACS 0x00000000BFFDFD40 000040
Jan 26 18:02:06 odl01 systemd[1]: Started Commit a transient machine-id on disk.
Jan 26 18:02:06 odl01 kernel: [    0.000000] ACPI: SSDT 0x00000000BFFE09C8 000A3F (v01 BOCHS  BXPCSSDT 00000001 BXPC 00000001)
Jan 26 18:02:06 odl01 kernel: [    0.000000] ACPI: APIC 0x00000000BFFE1407 000090 (v01 BOCHS  BXPCAPIC 00000001 BXPC 00000001)
Jan 26 18:02:06 odl01 kernel: [    0.000000] ACPI: Local APIC address 0xfee00000
Jan 26 18:02:06 odl01 systemd[1]: Listening on Load/Save RF Kill Switch Status /dev/rfkill Watch.
Jan 26 18:02:06 odl01 kernel: [    0.000000] No NUMA configuration found
Jan 26 18:02:06 odl01 kernel: [    0.000000] Faking a node at [mem 0x0000000000000000-0x000000017fffffff]
Jan 26 18:02:06 odl01 kernel: [    0.000000] NODE_DATA(0) allocated [mem 0x17fff9000-0x17fffdfff]
Jan 26 18:02:06 odl01 kernel: [    0.000000] kvm-clock: Using msrs 4b564d01 and 4b564d00
Jan 26 18:02:06 odl01 systemd[1]: Started Create Volatile Files and Directories.
Jan 26 18:02:06 odl01 kernel: [    0.000000] kvm-clock: cpu 0, msr 1:7fff1001, primary cpu clock
Jan 26 18:02:06 odl01 kernel: [    0.000000] kvm-clock: using sched offset of 768558956 cycles
Jan 26 18:02:06 odl01 apparmor[498]:  * Starting AppArmor profiles
Jan 26 18:02:06 odl01 kernel: [    0.000000] clocksource: kvm-clock: mask: 0xffffffffffffffff max_cycles: 0x1cd42e4dffb, max_idle_ns: 881590591483 ns
Jan 26 18:02:06 odl01 kernel: [    0.000000] Zone ranges:
Jan 26 18:02:06 odl01 systemd[1]: Starting Network Time Synchronization...
Jan 26 18:02:06 odl01 kernel: [    0.000000]   DMA      [mem 0x0000000000001000-0x0000000000ffffff]
Jan 26 18:02:06 odl01 kernel: [    0.000000]   DMA32    [mem 0x0000000001000000-0x00000000ffffffff]
Jan 26 18:02:06 odl01 systemd[1]: Starting Update UTMP about System Boot/Shutdown...
Jan 26 18:02:06 odl01 kernel: [    0.000000]   Normal   [mem 0x0000000100000000-0x000000017fffffff]
Jan 26 18:02:06 odl01 kernel: [    0.000000]   Device   empty
Jan 26 18:02:06 odl01 kernel: [    0.000000] Movable zone start for each node
Jan 26 18:02:06 odl01 kernel: [    0.000000] Early memory node ranges
Jan 26 18:02:06 odl01 kernel: [    0.000000]   node   0: [mem 0x0000000000001000-0x000000000009efff]
Jan 26 18:02:06 odl01 kernel: [    0.000000]   node   0: [mem 0x0000000000100000-0x00000000bffdefff]
Jan 26 18:02:06 odl01 systemd[1]: Started Network Time Synchronization.
Jan 26 18:02:06 odl01 kernel: [    0.000000]   node   0: [mem 0x0000000100000000-0x000000017fffffff]
Jan 26 18:02:06 odl01 kernel: [    0.000000] Initmem setup node 0 [mem 0x0000000000001000-0x000000017fffffff]
Jan 26 18:02:06 odl01 kernel: [    0.000000] On node 0 totalpages: 1310589
Jan 26 18:02:06 odl01 kernel: [    0.000000]   DMA zone: 64 pages used for memmap
Jan 26 18:02:06 odl01 kernel: [    0.000000]   DMA zone: 21 pages reserved
Jan 26 18:02:06 odl01 kernel: [    0.000000]   DMA zone: 3998 pages, LIFO batch:0
Jan 26 18:02:06 odl01 systemd[1]: Reached target System Time Synchronized.
Jan 26 18:02:06 odl01 kernel: [    0.000000]   DMA32 zone: 12224 pages used for memmap
Jan 26 18:02:06 odl01 kernel: [    0.000000]   DMA32 zone: 782303 pages, LIFO batch:31
Jan 26 18:02:06 odl01 kernel: [    0.000000]   Normal zone: 8192 pages used for memmap
Jan 26 18:02:06 odl01 kernel: [    0.000000]   Normal zone: 524288 pages, LIFO batch:31
Jan 26 18:02:06 odl01 systemd[1]: Started Update UTMP about System Boot/Shutdown.
Jan 26 18:02:06 odl01 kernel: [    0.000000] ACPI: PM-Timer IO Port: 0x608
Jan 26 18:02:06 odl01 kernel: [    0.000000] ACPI: Local APIC address 0xfee00000
Jan 26 18:02:06 odl01 kernel: [    0.000000] ACPI: LAPIC_NMI (acpi_id[0xff] dfl dfl lint[0x1])
Jan 26 18:02:06 odl01 kernel: [    0.000000] IOAPIC[0]: apic_id 0, version 17, address 0xfec00000, GSI 0-23
Jan 26 18:02:06 odl01 apparmor[498]: Skipping profile in /etc/apparmor.d/disable: usr.sbin.rsyslogd
Jan 26 18:02:06 odl01 kernel: [    0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 0 global_irq 2 dfl dfl)
Jan 26 18:02:06 odl01 kernel: [    0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 5 global_irq 5 high level)
Jan 26 18:02:06 odl01 kernel: [    0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 9 global_irq 9 high level)
Jan 26 18:02:06 odl01 apparmor[498]:    ...done.
Jan 26 18:02:06 odl01 kernel: [    0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 10 global_irq 10 high level)
Jan 26 18:02:06 odl01 kernel: [    0.000000] ACPI: INT_SRC_OVR (bus 0 bus_irq 11 global_irq 11 high level)
Jan 26 18:02:06 odl01 kernel: [    0.000000] ACPI: IRQ0 used by override.
Jan 26 18:02:06 odl01 kernel: [    0.000000] ACPI: IRQ5 used by override.
Jan 26 18:02:06 odl01 systemd[1]: Started LSB: AppArmor initialization.
Jan 26 18:02:06 odl01 kernel: [    0.000000] ACPI: IRQ9 used by override.
Jan 26 18:02:06 odl01 kernel: [    0.000000] ACPI: IRQ10 used by override.
Jan 26 18:02:06 odl01 kernel: [    0.000000] ACPI: IRQ11 used by override.
Jan 26 18:02:06 odl01 kernel: [    0.000000] Using ACPI (MADT) for SMP configuration information
Jan 26 18:02:06 odl01 kernel: [    0.000000] smpboot: Allowing 4 CPUs, 0 hotplug CPUs
Jan 26 18:02:06 odl01 kernel: [    0.000000] PM: Registered nosave memory: [mem 0x00000000-0x00000fff]
Jan 26 18:02:06 odl01 cloud-init[427]: Cloud-init v. 17.1 running 'init-local' at Fri, 26 Jan 2018 18:02:01 +0000. Up 7.30 seconds.
Jan 26 18:02:06 odl01 kernel: [    0.000000] PM: Registered nosave memory: [mem 0x0009f000-0x0009ffff]
Jan 26 18:02:06 odl01 kernel: [    0.000000] PM: Registered nosave memory: [mem 0x000a0000-0x000effff]
Jan 26 18:02:06 odl01 systemd[1]: Started Set console font and keymap.
Jan 26 18:02:06 odl01 kernel: [    0.000000] PM: Registered nosave memory: [mem 0x000f0000-0x000fffff]
Jan 26 18:02:06 odl01 kernel: [    0.000000] PM: Registered nosave memory: [mem 0xbffdf000-0xbfffffff]
Jan 26 18:02:06 odl01 kernel: [    0.000000] PM: Registered nosave memory: [mem 0xc0000000-0xfeffbfff]
Jan 26 18:02:06 odl01 systemd[1]: Started Initial cloud-init job (pre-networking).
Jan 26 18:02:06 odl01 kernel: [    0.000000] PM: Registered nosave memory: [mem 0xfeffc000-0xfeffffff]
Jan 26 18:02:06 odl01 kernel: [    0.000000] PM: Registered nosave memory: [mem 0xff000000-0xfffbffff]
Jan 26 18:02:06 odl01 kernel: [    0.000000] PM: Registered nosave memory: [mem 0xfffc0000-0xffffffff]
Jan 26 18:02:06 odl01 systemd[1]: Reached target Network (Pre).
Jan 26 18:02:06 odl01 kernel: [    0.000000] e820: [mem 0xc0000000-0xfeffbfff] available for PCI devices
Jan 26 18:02:06 odl01 kernel: [    0.000000] Booting paravirtualized kernel on KVM
Jan 26 18:02:06 odl01 kernel: [    0.000000] clocksource: refined-jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645519600211568 ns
Jan 26 18:02:06 odl01 kernel: [    0.000000] setup_percpu: NR_CPUS:512 nr_cpumask_bits:512 nr_cpu_ids:4 nr_node_ids:1
Jan 26 18:02:06 odl01 systemd[1]: Starting Raise network interfaces...
Jan 26 18:02:06 odl01 kernel: [    0.000000] PERCPU: Embedded 34 pages/cpu @ffff88017fc00000 s99544 r8192 d31528 u524288
Jan 26 18:02:06 odl01 systemd[1]: Created slice system-getty.slice.
Jan 26 18:02:06 odl01 dhclient[875]: Internet Systems Consortium DHCP Client 4.3.3
Jan 26 18:02:06 odl01 ifup[811]: Internet Systems Consortium DHCP Client 4.3.3
Jan 26 18:02:06 odl01 dhclient[875]: Copyright 2004-2015 Internet Systems Consortium.
Jan 26 18:02:06 odl01 ifup[811]: Copyright 2004-2015 Internet Systems Consortium.
Jan 26 18:02:06 odl01 dhclient[875]: All rights reserved.
Jan 26 18:02:06 odl01 ifup[811]: All rights reserved.
Jan 26 18:02:06 odl01 dhclient[875]: For info, please visit https://www.isc.org/software/dhcp/
Jan 26 18:02:06 odl01 ifup[811]: For info, please visit https://www.isc.org/software/dhcp/
Jan 26 18:02:06 odl01 dhclient[875]: 
Jan 26 18:02:06 odl01 dhclient[875]: Listening on LPF/ens3/52:54:00:38:be:11
Jan 26 18:02:06 odl01 kernel: [    0.000000] pcpu-alloc: s99544 r8192 d31528 u524288 alloc=1*2097152
Jan 26 18:02:06 odl01 kernel: [    0.000000] pcpu-alloc: [0] 0 1 2 3 
Jan 26 18:02:06 odl01 ifup[811]: Listening on LPF/ens3/52:54:00:38:be:11
Jan 26 18:02:06 odl01 kernel: [    0.000000] KVM setup async PF for cpu 0
Jan 26 18:02:06 odl01 kernel: [    0.000000] kvm-stealtime: cpu 0, msr 17fc101c0
Jan 26 18:02:06 odl01 kernel: [    0.000000] PV qspinlock hash table entries: 256 (order: 0, 4096 bytes)
Jan 26 18:02:06 odl01 kernel: [    0.000000] Built 1 zonelists in Node order, mobility grouping on.  Total pages: 1290088
Jan 26 18:02:06 odl01 dhclient[875]: Sending on   LPF/ens3/52:54:00:38:be:11
Jan 26 18:02:06 odl01 kernel: [    0.000000] Policy zone: Normal
Jan 26 18:02:06 odl01 kernel: [    0.000000] Kernel command line: BOOT_IMAGE=/boot/vmlinuz-4.4.0-112-generic root=LABEL=cloudimg-rootfs ro console=tty1 console=ttyS0
Jan 26 18:02:06 odl01 kernel: [    0.000000] PID hash table entries: 4096 (order: 3, 32768 bytes)
Jan 26 18:02:06 odl01 kernel: [    0.000000] Calgary: detecting Calgary via BIOS EBDA area
Jan 26 18:02:06 odl01 ifup[811]: Sending on   LPF/ens3/52:54:00:38:be:11
Jan 26 18:02:06 odl01 kernel: [    0.000000] Calgary: Unable to locate Rio Grande table in EBDA - bailing!
Jan 26 18:02:06 odl01 kernel: [    0.000000] Memory: 5064112K/5242356K available (8499K kernel code, 1309K rwdata, 3988K rodata, 1508K init, 1316K bss, 178244K reserved, 0K cma-reserved)
Jan 26 18:02:06 odl01 dhclient[875]: Sending on   Socket/fallback
Jan 26 18:02:06 odl01 kernel: [    0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1
Jan 26 18:02:06 odl01 kernel: [    0.000000] Kernel/User page tables isolation: enabled
Jan 26 18:02:06 odl01 kernel: [    0.000000] Hierarchical RCU implementation.
Jan 26 18:02:06 odl01 kernel: [    0.000000] 	Build-time adjustment of leaf fanout to 64.
Jan 26 18:02:06 odl01 kernel: [    0.000000] 	RCU restricting CPUs from NR_CPUS=512 to nr_cpu_ids=4.
Jan 26 18:02:06 odl01 kernel: [    0.000000] RCU: Adjusting geometry for rcu_fanout_leaf=64, nr_cpu_ids=4
Jan 26 18:02:06 odl01 kernel: [    0.000000] NR_IRQS:33024 nr_irqs:456 16
Jan 26 18:02:06 odl01 kernel: [    0.000000] Console: colour VGA+ 80x25
Jan 26 18:02:06 odl01 ifup[811]: Sending on   Socket/fallback
Jan 26 18:02:06 odl01 kernel: [    0.000000] console [tty1] enabled
Jan 26 18:02:06 odl01 kernel: [    0.000000] console [ttyS0] enabled
Jan 26 18:02:06 odl01 kernel: [    0.000000] tsc: Detected 2799.998 MHz processor
Jan 26 18:02:06 odl01 kernel: [    0.198433] Calibrating delay loop (skipped) preset value.. 5599.99 BogoMIPS (lpj=11199992)
Jan 26 18:02:06 odl01 dhclient[875]: DHCPDISCOVER on ens3 to 255.255.255.255 port 67 interval 3 (xid=0x8b6d6721)
Jan 26 18:02:06 odl01 kernel: [    0.199878] pid_max: default: 32768 minimum: 301
Jan 26 18:02:06 odl01 kernel: [    0.200671] ACPI: Core revision 20150930
Jan 26 18:02:06 odl01 kernel: [    0.202419] ACPI: 2 ACPI AML tables successfully acquired and loaded
Jan 26 18:02:06 odl01 kernel: [    0.203587] Security Framework initialized
Jan 26 18:02:06 odl01 ifup[811]: DHCPDISCOVER on ens3 to 255.255.255.255 port 67 interval 3 (xid=0x8b6d6721)
Jan 26 18:02:06 odl01 kernel: [    0.204297] Yama: becoming mindful.
Jan 26 18:02:06 odl01 dhclient[875]: DHCPREQUEST of 10.20.0.34 on ens3 to 255.255.255.255 port 67 (xid=0x21676d8b)
Jan 26 18:02:06 odl01 kernel: [    0.204948] AppArmor: AppArmor initialized
Jan 26 18:02:06 odl01 kernel: [    0.206966] Dentry cache hash table entries: 1048576 (order: 11, 8388608 bytes)
Jan 26 18:02:06 odl01 kernel: [    0.211881] Inode-cache hash table entries: 524288 (order: 10, 4194304 bytes)
Jan 26 18:02:06 odl01 kernel: [    0.214601] Mount-cache hash table entries: 16384 (order: 5, 131072 bytes)
Jan 26 18:02:06 odl01 kernel: [    0.215709] Mountpoint-cache hash table entries: 16384 (order: 5, 131072 bytes)
Jan 26 18:02:06 odl01 kernel: [    0.217654] Initializing cgroup subsys io
Jan 26 18:02:06 odl01 ifup[811]: DHCPREQUEST of 10.20.0.34 on ens3 to 255.255.255.255 port 67 (xid=0x21676d8b)
Jan 26 18:02:06 odl01 kernel: [    0.218697] Initializing cgroup subsys memory
Jan 26 18:02:06 odl01 kernel: [    0.219452] Initializing cgroup subsys devices
Jan 26 18:02:06 odl01 kernel: [    0.220210] Initializing cgroup subsys freezer
Jan 26 18:02:06 odl01 kernel: [    0.220963] Initializing cgroup subsys net_cls
Jan 26 18:02:06 odl01 dhclient[875]: DHCPOFFER of 10.20.0.34 from 10.20.0.1
Jan 26 18:02:06 odl01 kernel: [    0.221741] Initializing cgroup subsys perf_event
Jan 26 18:02:06 odl01 kernel: [    0.222558] Initializing cgroup subsys net_prio
Jan 26 18:02:06 odl01 ifup[811]: DHCPOFFER of 10.20.0.34 from 10.20.0.1
Jan 26 18:02:06 odl01 kernel: [    0.223336] Initializing cgroup subsys hugetlb
Jan 26 18:02:06 odl01 kernel: [    0.224094] Initializing cgroup subsys pids
Jan 26 18:02:06 odl01 kernel: [    0.224897] FEATURE SPEC_CTRL Not Present
Jan 26 18:02:06 odl01 kernel: [    0.226405] mce: CPU supports 10 MCE banks
Jan 26 18:02:06 odl01 kernel: [    0.227171] Last level iTLB entries: 4KB 0, 2MB 0, 4MB 0
Jan 26 18:02:06 odl01 dhclient[875]: DHCPACK of 10.20.0.34 from 10.20.0.1
Jan 26 18:02:06 odl01 kernel: [    0.228038] Last level dTLB entries: 4KB 0, 2MB 0, 4MB 0, 1GB 0
Jan 26 18:02:06 odl01 kernel: [    0.230667] Freeing SMP alternatives memory: 32K
Jan 26 18:02:06 odl01 kernel: [    0.239694] ftrace: allocating 32180 entries in 126 pages
Jan 26 18:02:06 odl01 kernel: [    0.276130] smpboot: APIC(0) Converting physical 0 to logical package 0
Jan 26 18:02:06 odl01 kernel: [    0.277201] smpboot: APIC(1) Converting physical 1 to logical package 1
Jan 26 18:02:06 odl01 kernel: [    0.278576] smpboot: APIC(2) Converting physical 2 to logical package 2
Jan 26 18:02:06 odl01 ifup[811]: DHCPACK of 10.20.0.34 from 10.20.0.1
Jan 26 18:02:06 odl01 kernel: [    0.279620] smpboot: APIC(3) Converting physical 3 to logical package 3
Jan 26 18:02:06 odl01 kernel: [    0.280662] smpboot: Max logical packages: 4
Jan 26 18:02:06 odl01 dhclient[875]: bound to 10.20.0.34 -- renewal in 1445 seconds.
Jan 26 18:02:06 odl01 kernel: [    0.281559] x2apic enabled
Jan 26 18:02:06 odl01 kernel: [    0.282633] Switched APIC routing to physical x2apic.
Jan 26 18:02:06 odl01 kernel: [    0.284263] ..TIMER: vector=0x30 apic1=0 pin1=2 apic2=-1 pin2=-1
Jan 26 18:02:06 odl01 kernel: [    0.285382] TSC deadline timer enabled
Jan 26 18:02:06 odl01 kernel: [    0.285386] smpboot: CPU0: Intel(R) Xeon(R) CPU E5-2680 v2 @ 2.80GHz (family: 0x6, model: 0x3e, stepping: 0x4)
Jan 26 18:02:06 odl01 ifup[811]: bound to 10.20.0.34 -- renewal in 1445 seconds.
Jan 26 18:02:06 odl01 kernel: [    0.287413] Performance Events: 16-deep LBR, IvyBridge events, Intel PMU driver.
Jan 26 18:02:06 odl01 kernel: [    0.296472] ... version:                2
Jan 26 18:02:06 odl01 kernel: [    0.297257] ... bit width:              48
Jan 26 18:02:06 odl01 kernel: [    0.298654] ... generic registers:      4
Jan 26 18:02:06 odl01 kernel: [    0.299442] ... value mask:             0000ffffffffffff
Jan 26 18:02:06 odl01 systemd[1]: Started Raise network interfaces.
Jan 26 18:02:06 odl01 kernel: [    0.300429] ... max period:             000000007fffffff
Jan 26 18:02:06 odl01 kernel: [    0.301409] ... fixed-purpose events:   3
Jan 26 18:02:06 odl01 kernel: [    0.302801] ... event mask:             000000070000000f
Jan 26 18:02:06 odl01 kernel: [    0.304727] KVM setup paravirtual spinlock
Jan 26 18:02:06 odl01 kernel: [    0.306310] x86: Booting SMP configuration:
Jan 26 18:02:06 odl01 systemd[1]: Reached target Network.
Jan 26 18:02:06 odl01 kernel: [    0.307133] .... node  #0, CPUs:      #1
Jan 26 18:02:06 odl01 kernel: [    0.308035] kvm-clock: cpu 1, msr 1:7fff1041, secondary cpu clock
Jan 26 18:02:06 odl01 systemd[1]: Starting Initial cloud-init job (metadata service crawler)...
Jan 26 18:02:06 odl01 kernel: [    0.329713] KVM setup async PF for cpu 1
Jan 26 18:02:06 odl01 kernel: [    0.330261]  #2
Jan 26 18:02:06 odl01 kernel: [    0.330261] kvm-clock: cpu 2, msr 1:7fff1081, secondary cpu clock
Jan 26 18:02:06 odl01 kernel: [    0.332480] kvm-stealtime: cpu 1, msr 17fc901c0
Jan 26 18:02:06 odl01 kernel: [    0.351987] KVM setup async PF for cpu 2
Jan 26 18:02:06 odl01 kernel: [    0.352177]  #3
Jan 26 18:02:06 odl01 kernel: [    0.352177] kvm-clock: cpu 3, msr 1:7fff10c1, secondary cpu clock
Jan 26 18:02:06 odl01 kernel: [    0.354404] kvm-stealtime: cpu 2, msr 17fd101c0
Jan 26 18:02:06 odl01 kernel: [    0.373075] x86: Booted up 1 node, 4 CPUs
Jan 26 18:02:06 odl01 kernel: [    0.373078] KVM setup async PF for cpu 3
Jan 26 18:02:06 odl01 kernel: [    0.373082] kvm-stealtime: cpu 3, msr 17fd901c0
Jan 26 18:02:06 odl01 kernel: [    0.375585] smpboot: Total of 4 processors activated (22399.98 BogoMIPS)
Jan 26 18:02:06 odl01 kernel: [    0.377691] devtmpfs: initialized
Jan 26 18:02:06 odl01 kernel: [    0.380685] evm: security.selinux
Jan 26 18:02:06 odl01 kernel: [    0.381315] evm: security.SMACK64
Jan 26 18:02:06 odl01 kernel: [    0.381941] evm: security.SMACK64EXEC
Jan 26 18:02:06 odl01 kernel: [    0.382591] evm: security.SMACK64TRANSMUTE
Jan 26 18:02:06 odl01 kernel: [    0.383304] evm: security.SMACK64MMAP
Jan 26 18:02:06 odl01 kernel: [    0.383954] evm: security.ima
Jan 26 18:02:06 odl01 kernel: [    0.384514] evm: security.capability
Jan 26 18:02:06 odl01 kernel: [    0.385361] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 7645041785100000 ns
Jan 26 18:02:06 odl01 kernel: [    0.387291] futex hash table entries: 1024 (order: 4, 65536 bytes)
Jan 26 18:02:06 odl01 kernel: [    0.388381] pinctrl core: initialized pinctrl subsystem
Jan 26 18:02:06 odl01 kernel: [    0.389400] RTC time: 18:01:54, date: 01/26/18
Jan 26 18:02:06 odl01 kernel: [    0.391339] NET: Registered protocol family 16
Jan 26 18:02:06 odl01 kernel: [    0.401397] cpuidle: using governor ladder
Jan 26 18:02:06 odl01 kernel: [    0.413455] cpuidle: using governor menu
Jan 26 18:02:06 odl01 kernel: [    0.414576] PCCT header not found.
Jan 26 18:02:06 odl01 kernel: [    0.415398] ACPI: bus type PCI registered
Jan 26 18:02:06 odl01 kernel: [    0.416104] acpiphp: ACPI Hot Plug PCI Controller Driver version: 0.5
Jan 26 18:02:06 odl01 kernel: [    0.417264] PCI: Using configuration type 1 for base access
Jan 26 18:02:06 odl01 kernel: [    0.418375] core: PMU erratum BJ122, BV98, HSD29 workaround disabled, HT off
Jan 26 18:02:06 odl01 kernel: [    0.430915] ACPI: Added _OSI(Module Device)
Jan 26 18:02:06 odl01 kernel: [    0.431652] ACPI: Added _OSI(Processor Device)
Jan 26 18:02:06 odl01 kernel: [    0.432404] ACPI: Added _OSI(3.0 _SCP Extensions)
Jan 26 18:02:06 odl01 kernel: [    0.433189] ACPI: Added _OSI(Processor Aggregator Device)
Jan 26 18:02:06 odl01 kernel: [    0.436233] ACPI: Interpreter enabled
Jan 26 18:02:06 odl01 kernel: [    0.437226] ACPI: (supports S0 S5)
Jan 26 18:02:06 odl01 kernel: [    0.438158] ACPI: Using IOAPIC for interrupt routing
Jan 26 18:02:06 odl01 kernel: [    0.439400] PCI: Using host bridge windows from ACPI; if necessary, use "pci=nocrs" and report a bug
Jan 26 18:02:06 odl01 kernel: [    0.445082] ACPI: PCI Root Bridge [PCI0] (domain 0000 [bus 00-ff])
Jan 26 18:02:06 odl01 kernel: [    0.446614] acpi PNP0A03:00: _OSC: OS supports [ASPM ClockPM Segments MSI]
Jan 26 18:02:06 odl01 kernel: [    0.447693] acpi PNP0A03:00: _OSC failed (AE_NOT_FOUND); disabling ASPM
Jan 26 18:02:06 odl01 kernel: [    0.448737] acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended PCI configuration space under this bridge.
Jan 26 18:02:06 odl01 kernel: [    0.450787] acpiphp: Slot [3] registered
Jan 26 18:02:06 odl01 kernel: [    0.451505] acpiphp: Slot [4] registered
Jan 26 18:02:06 odl01 kernel: [    0.452232] acpiphp: Slot [5] registered
Jan 26 18:02:06 odl01 kernel: [    0.452953] acpiphp: Slot [6] registered
Jan 26 18:02:06 odl01 kernel: [    0.453677] acpiphp: Slot [7] registered
Jan 26 18:02:06 odl01 kernel: [    0.454418] acpiphp: Slot [9] registered
Jan 26 18:02:06 odl01 kernel: [    0.455138] acpiphp: Slot [10] registered
Jan 26 18:02:06 odl01 kernel: [    0.455858] acpiphp: Slot [11] registered
Jan 26 18:02:06 odl01 kernel: [    0.456578] acpiphp: Slot [12] registered
Jan 26 18:02:06 odl01 kernel: [    0.457294] acpiphp: Slot [13] registered
Jan 26 18:02:06 odl01 kernel: [    0.458024] acpiphp: Slot [14] registered
Jan 26 18:02:06 odl01 kernel: [    0.458737] acpiphp: Slot [15] registered
Jan 26 18:02:06 odl01 kernel: [    0.459444] acpiphp: Slot [16] registered
Jan 26 18:02:06 odl01 kernel: [    0.460159] acpiphp: Slot [17] registered
Jan 26 18:02:06 odl01 kernel: [    0.460882] acpiphp: Slot [18] registered
Jan 26 18:02:06 odl01 kernel: [    0.461593] acpiphp: Slot [19] registered
Jan 26 18:02:06 odl01 kernel: [    0.462308] acpiphp: Slot [20] registered
Jan 26 18:02:06 odl01 kernel: [    0.463019] acpiphp: Slot [21] registered
Jan 26 18:02:06 odl01 kernel: [    0.463739] acpiphp: Slot [22] registered
Jan 26 18:02:06 odl01 kernel: [    0.464448] acpiphp: Slot [23] registered
Jan 26 18:02:06 odl01 kernel: [    0.465169] acpiphp: Slot [24] registered
Jan 26 18:02:06 odl01 cloud-init[963]: Cloud-init v. 17.1 running 'init' at Fri, 26 Jan 2018 18:02:05 +0000. Up 10.69 seconds.
Jan 26 18:02:06 odl01 cloud-init[963]: ci-info: ++++++++++++++++++++++++++++++++++++++Net device info++++++++++++++++++++++++++++++++++++++
Jan 26 18:02:06 odl01 cloud-init[963]: ci-info: +--------+-------+----------------------------+---------------+-------+-------------------+
Jan 26 18:02:06 odl01 cloud-init[963]: ci-info: | Device |   Up  |          Address           |      Mask     | Scope |     Hw-Address    |
Jan 26 18:02:06 odl01 cloud-init[963]: ci-info: +--------+-------+----------------------------+---------------+-------+-------------------+
Jan 26 18:02:06 odl01 cloud-init[963]: ci-info: |  ens3  |  True |         10.20.0.34         | 255.255.255.0 |   .   | 52:54:00:38:be:11 |
Jan 26 18:02:06 odl01 kernel: [    0.465892] acpiphp: Slot [25] registered
Jan 26 18:02:06 odl01 kernel: [    0.466607] acpiphp: Slot [26] registered
Jan 26 18:02:06 odl01 kernel: [    0.467325] acpiphp: Slot [27] registered
Jan 26 18:02:06 odl01 cloud-init[963]: ci-info: |  ens3  |  True | fe80::5054:ff:fe38:be11/64 |       .       |  link | 52:54:00:38:be:11 |
Jan 26 18:02:06 odl01 kernel: [    0.468042] acpiphp: Slot [28] registered
Jan 26 18:02:06 odl01 kernel: [    0.468756] acpiphp: Slot [29] registered
Jan 26 18:02:06 odl01 kernel: [    0.469474] acpiphp: Slot [30] registered
Jan 26 18:02:06 odl01 kernel: [    0.470198] acpiphp: Slot [31] registered
Jan 26 18:02:06 odl01 cloud-init[963]: ci-info: |  ens4  | False |             .              |       .       |   .   | 52:54:00:1e:81:f7 |
Jan 26 18:02:06 odl01 kernel: [    0.470903] PCI host bridge to bus 0000:00
Jan 26 18:02:06 odl01 kernel: [    0.471613] pci_bus 0000:00: root bus resource [io  0x0000-0x0cf7 window]
Jan 26 18:02:06 odl01 cloud-init[963]: ci-info: |  ens5  | False |             .              |       .       |   .   | 52:54:00:52:fe:4c |
Jan 26 18:02:06 odl01 kernel: [    0.472660] pci_bus 0000:00: root bus resource [io  0x0d00-0xffff window]
Jan 26 18:02:06 odl01 kernel: [    0.473716] pci_bus 0000:00: root bus resource [mem 0x000a0000-0x000bffff window]
Jan 26 18:02:06 odl01 kernel: [    0.475275] pci_bus 0000:00: root bus resource [mem 0xc0000000-0xfebfffff window]
Jan 26 18:02:06 odl01 kernel: [    0.476533] pci_bus 0000:00: root bus resource [bus 00-ff]
Jan 26 18:02:06 odl01 kernel: [    0.477459] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000
Jan 26 18:02:06 odl01 cloud-init[963]: ci-info: |  ens6  | False |             .              |       .       |   .   | 52:54:00:97:77:0d |
Jan 26 18:02:06 odl01 kernel: [    0.477833] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100
Jan 26 18:02:06 odl01 kernel: [    0.478287] pci 0000:00:01.1: [8086:7010] type 00 class 0x010180
Jan 26 18:02:06 odl01 cloud-init[963]: ci-info: |   lo   |  True |         127.0.0.1          |   255.0.0.0   |   .   |         .         |
Jan 26 18:02:06 odl01 kernel: [    0.485677] pci 0000:00:01.1: reg 0x20: [io  0xc140-0xc14f]
Jan 26 18:02:06 odl01 kernel: [    0.489116] pci 0000:00:01.1: legacy IDE quirk: reg 0x10: [io  0x01f0-0x01f7]
Jan 26 18:02:06 odl01 kernel: [    0.491853] pci 0000:00:01.1: legacy IDE quirk: reg 0x14: [io  0x03f6]
Jan 26 18:02:06 odl01 kernel: [    0.492879] pci 0000:00:01.1: legacy IDE quirk: reg 0x18: [io  0x0170-0x0177]
Jan 26 18:02:06 odl01 cloud-init[963]: ci-info: |   lo   |  True |          ::1/128           |       .       |  host |         .         |
Jan 26 18:02:06 odl01 kernel: [    0.494295] pci 0000:00:01.1: legacy IDE quirk: reg 0x1c: [io  0x0376]
Jan 26 18:02:06 odl01 kernel: [    0.495570] pci 0000:00:01.3: [8086:7113] type 00 class 0x068000
Jan 26 18:02:06 odl01 kernel: [    0.495939] pci 0000:00:01.3: quirk: [io  0x0600-0x063f] claimed by PIIX4 ACPI
Jan 26 18:02:06 odl01 kernel: [    0.497265] pci 0000:00:01.3: quirk: [io  0x0700-0x070f] claimed by PIIX4 SMB
Jan 26 18:02:06 odl01 cloud-init[963]: ci-info: +--------+-------+----------------------------+---------------+-------+-------------------+
Jan 26 18:02:06 odl01 kernel: [    0.498652] pci 0000:00:02.0: [1013:00b8] type 00 class 0x030000
Jan 26 18:02:06 odl01 kernel: [    0.501456] pci 0000:00:02.0: reg 0x10: [mem 0xfc000000-0xfdffffff pref]
Jan 26 18:02:06 odl01 cloud-init[963]: ci-info: ++++++++++++++++++++++++++++Route IPv4 info++++++++++++++++++++++++++++
Jan 26 18:02:06 odl01 kernel: [    0.504566] pci 0000:00:02.0: reg 0x14: [mem 0xfebd0000-0xfebd0fff]
Jan 26 18:02:06 odl01 kernel: [    0.520784] pci 0000:00:02.0: reg 0x30: [mem 0xfebc0000-0xfebcffff pref]
Jan 26 18:02:06 odl01 kernel: [    0.520982] pci 0000:00:03.0: [1af4:1000] type 00 class 0x020000
Jan 26 18:02:06 odl01 kernel: [    0.523596] pci 0000:00:03.0: reg 0x10: [io  0xc040-0xc05f]
Jan 26 18:02:06 odl01 kernel: [    0.525756] pci 0000:00:03.0: reg 0x14: [mem 0xfebd1000-0xfebd1fff]
Jan 26 18:02:06 odl01 kernel: [    0.540102] pci 0000:00:03.0: reg 0x30: [mem 0xfeac0000-0xfeafffff pref]
Jan 26 18:02:06 odl01 cloud-init[963]: ci-info: +-------+-------------+-----------+---------------+-----------+-------+
Jan 26 18:02:06 odl01 kernel: [    0.543260] pci 0000:00:04.0: [1af4:1000] type 00 class 0x020000
Jan 26 18:02:06 odl01 cloud-init[963]: ci-info: | Route | Destination |  Gateway  |    Genmask    | Interface | Flags |
Jan 26 18:02:06 odl01 kernel: [    0.545515] pci 0000:00:04.0: reg 0x10: [io  0xc060-0xc07f]
Jan 26 18:02:06 odl01 kernel: [    0.548682] pci 0000:00:04.0: reg 0x14: [mem 0xfebd2000-0xfebd2fff]
Jan 26 18:02:06 odl01 cloud-init[963]: ci-info: +-------+-------------+-----------+---------------+-----------+-------+
Jan 26 18:02:06 odl01 kernel: [    0.563816] pci 0000:00:04.0: reg 0x30: [mem 0xfeb00000-0xfeb3ffff pref]
Jan 26 18:02:06 odl01 cloud-init[963]: ci-info: |   0   |   0.0.0.0   | 10.20.0.1 |    0.0.0.0    |    ens3   |   UG  |
Jan 26 18:02:06 odl01 kernel: [    0.564052] pci 0000:00:05.0: [1af4:1000] type 00 class 0x020000
Jan 26 18:02:06 odl01 kernel: [    0.568554] pci 0000:00:05.0: reg 0x10: [io  0xc080-0xc09f]
Jan 26 18:02:06 odl01 cloud-init[963]: ci-info: |   1   |  10.20.0.0  |  0.0.0.0  | 255.255.255.0 |    ens3   |   U   |
Jan 26 18:02:06 odl01 kernel: [    0.572564] pci 0000:00:05.0: reg 0x14: [mem 0xfebd3000-0xfebd3fff]
Jan 26 18:02:06 odl01 kernel: [    0.587015] pci 0000:00:05.0: reg 0x30: [mem 0xfeb40000-0xfeb7ffff pref]
Jan 26 18:02:06 odl01 kernel: [    0.587266] pci 0000:00:06.0: [1af4:1000] type 00 class 0x020000
Jan 26 18:02:06 odl01 rsyslogd-2039: Could not open output pipe '/dev/xconsole':: No such file or directory [v8.16.0 try http://www.rsyslog.com/e/2039 ]
Jan 26 18:02:06 odl01 cloud-init[963]: ci-info: +-------+-------------+-----------+---------------+-----------+-------+
Jan 26 18:02:06 odl01 kernel: [    0.589433] pci 0000:00:06.0: reg 0x10: [io  0xc0a0-0xc0bf]
Jan 26 18:02:06 odl01 kernel: [    0.593641] pci 0000:00:06.0: reg 0x14: [mem 0xfebd4000-0xfebd4fff]
Jan 26 18:02:06 odl01 cloud-init[963]: Generating public/private rsa key pair.
Jan 26 18:02:06 odl01 kernel: [    0.607381] pci 0000:00:06.0: reg 0x30: [mem 0xfeb80000-0xfebbffff pref]
Jan 26 18:02:06 odl01 cloud-init[963]: Your identification has been saved in /etc/ssh/ssh_host_rsa_key.
Jan 26 18:02:06 odl01 kernel: [    0.609402] pci 0000:00:07.0: [1af4:1001] type 00 class 0x010000
Jan 26 18:02:06 odl01 kernel: [    0.611885] pci 0000:00:07.0: reg 0x10: [io  0xc000-0xc03f]
Jan 26 18:02:06 odl01 kernel: [    0.614768] pci 0000:00:07.0: reg 0x14: [mem 0xfebd5000-0xfebd5fff]
Jan 26 18:02:06 odl01 cloud-init[963]: Your public key has been saved in /etc/ssh/ssh_host_rsa_key.pub.
Jan 26 18:02:06 odl01 kernel: [    0.628527] pci 0000:00:08.0: [8086:2934] type 00 class 0x0c0300
Jan 26 18:02:06 odl01 kernel: [    0.635978] pci 0000:00:08.0: reg 0x20: [io  0xc0c0-0xc0df]
Jan 26 18:02:06 odl01 cloud-init[963]: The key fingerprint is:
Jan 26 18:02:06 odl01 kernel: [    0.638690] pci 0000:00:08.1: [8086:2935] type 00 class 0x0c0300
Jan 26 18:02:06 odl01 kernel: [    0.645002] pci 0000:00:08.1: reg 0x20: [io  0xc0e0-0xc0ff]
Jan 26 18:02:06 odl01 kernel: [    0.649669] pci 0000:00:08.2: [8086:2936] type 00 class 0x0c0300
Jan 26 18:02:06 odl01 kernel: [    0.656492] pci 0000:00:08.2: reg 0x20: [io  0xc100-0xc11f]
Jan 26 18:02:06 odl01 kernel: [    0.660909] pci 0000:00:08.7: [8086:293a] type 00 class 0x0c0320
Jan 26 18:02:06 odl01 cloud-init[963]: SHA256:s03rGzvF3UF76IuXPvVDtHKoxmoIsxjF5H+iZBV9YGw root@odl01
Jan 26 18:02:06 odl01 kernel: [    0.662388] pci 0000:00:08.7: reg 0x10: [mem 0xfebd6000-0xfebd6fff]
Jan 26 18:02:06 odl01 cloud-init[963]: The key's randomart image is:
Jan 26 18:02:06 odl01 kernel: [    0.669169] pci 0000:00:09.0: [1af4:1002] type 00 class 0x00ff00
Jan 26 18:02:06 odl01 kernel: [    0.670321] pci 0000:00:09.0: reg 0x10: [io  0xc120-0xc13f]
Jan 26 18:02:06 odl01 kernel: [    0.680183] ACPI: PCI Interrupt Link [LNKA] (IRQs 5 *10 11)
Jan 26 18:02:06 odl01 kernel: [    0.681690] ACPI: PCI Interrupt Link [LNKB] (IRQs 5 *10 11)
Jan 26 18:02:06 odl01 kernel: [    0.684511] ACPI: PCI Interrupt Link [LNKC] (IRQs 5 10 *11)
Jan 26 18:02:06 odl01 cloud-init[963]: +---[RSA 2048]----+
Jan 26 18:02:06 odl01 kernel: [    0.686258] ACPI: PCI Interrupt Link [LNKD] (IRQs 5 10 *11)
Jan 26 18:02:06 odl01 kernel: [    0.687600] ACPI: PCI Interrupt Link [LNKS] (IRQs *9)
Jan 26 18:02:06 odl01 kernel: [    0.689094] ACPI: Enabled 16 GPEs in block 00 to 0F
Jan 26 18:02:06 odl01 kernel: [    0.690625] vgaarb: setting as boot device: PCI:0000:00:02.0
Jan 26 18:02:06 odl01 cloud-init[963]: |        oo.      |
Jan 26 18:02:06 odl01 kernel: [    0.691574] vgaarb: device added: PCI:0000:00:02.0,decodes=io+mem,owns=io+mem,locks=none
Jan 26 18:02:06 odl01 kernel: [    0.692967] vgaarb: loaded
Jan 26 18:02:06 odl01 kernel: [    0.693515] vgaarb: bridge control possible 0000:00:02.0
Jan 26 18:02:06 odl01 cloud-init[963]: |     . ..E .   . |
Jan 26 18:02:06 odl01 kernel: [    0.694700] SCSI subsystem initialized
Jan 26 18:02:06 odl01 kernel: [    0.695500] libata version 3.00 loaded.
Jan 26 18:02:06 odl01 kernel: [    0.695524] ACPI: bus type USB registered
Jan 26 18:02:06 odl01 kernel: [    0.696272] usbcore: registered new interface driver usbfs
Jan 26 18:02:06 odl01 cloud-init[963]: |    +   o .   ...|
Jan 26 18:02:06 odl01 kernel: [    0.697200] usbcore: registered new interface driver hub
Jan 26 18:02:06 odl01 kernel: [    0.698698] usbcore: registered new device driver usb
Jan 26 18:02:06 odl01 cloud-init[963]: |     + .      .+.|
Jan 26 18:02:06 odl01 kernel: [    0.699759] PCI: Using ACPI for IRQ routing
Jan 26 18:02:06 odl01 kernel: [    0.700489] PCI: pci_cache_line_size set to 64 bytes
Jan 26 18:02:06 odl01 kernel: [    0.700683] e820: reserve RAM buffer [mem 0x0009fc00-0x0009ffff]
Jan 26 18:02:06 odl01 kernel: [    0.700685] e820: reserve RAM buffer [mem 0xbffdf000-0xbfffffff]
Jan 26 18:02:06 odl01 cloud-init[963]: |    . o S .. oo.+|
Jan 26 18:02:06 odl01 kernel: [    0.700811] NetLabel: Initializing
Jan 26 18:02:06 odl01 cloud-init[963]: |   . = o * .ooo+o|
Jan 26 18:02:06 odl01 kernel: [    0.701440] NetLabel:  domain hash size = 128
Jan 26 18:02:06 odl01 cloud-init[963]: |    = = = =...++.|
Jan 26 18:02:06 odl01 kernel: [    0.702470] NetLabel:  protocols = UNLABELED CIPSOv4
Jan 26 18:02:06 odl01 kernel: [    0.703306] NetLabel:  unlabeled traffic allowed by default
Jan 26 18:02:06 odl01 kernel: [    0.704344] amd_nb: Cannot enumerate AMD northbridges
Jan 26 18:02:06 odl01 kernel: [    0.705244] clocksource: Switched to clocksource kvm-clock
Jan 26 18:02:06 odl01 cloud-init[963]: |   . o . o.*. =..|
Jan 26 18:02:06 odl01 kernel: [    0.713991] AppArmor: AppArmor Filesystem Enabled
Jan 26 18:02:06 odl01 cloud-init[963]: |        ..*o o...|
Jan 26 18:02:06 odl01 kernel: [    0.714853] pnp: PnP ACPI init
Jan 26 18:02:06 odl01 kernel: [    0.715493] pnp 00:00: Plug and Play ACPI device, IDs PNP0b00 (active)
Jan 26 18:02:06 odl01 kernel: [    0.715524] pnp 00:01: Plug and Play ACPI device, IDs PNP0303 (active)
Jan 26 18:02:06 odl01 kernel: [    0.715550] pnp 00:02: Plug and Play ACPI device, IDs PNP0f13 (active)
Jan 26 18:02:06 odl01 cloud-init[963]: +----[SHA256]-----+
Jan 26 18:02:06 odl01 kernel: [    0.715573] pnp 00:03: [dma 2]
Jan 26 18:02:06 odl01 kernel: [    0.715588] pnp 00:03: Plug and Play ACPI device, IDs PNP0700 (active)
Jan 26 18:02:06 odl01 cloud-init[963]: Generating public/private dsa key pair.
Jan 26 18:02:06 odl01 kernel: [    0.715655] pnp 00:04: Plug and Play ACPI device, IDs PNP0501 (active)
Jan 26 18:02:06 odl01 kernel: [    0.715830] pnp: PnP ACPI: found 5 devices
Jan 26 18:02:06 odl01 kernel: [    0.724077] clocksource: acpi_pm: mask: 0xffffff max_cycles: 0xffffff, max_idle_ns: 2085701024 ns
Jan 26 18:02:06 odl01 kernel: [    0.725555] pci_bus 0000:00: resource 4 [io  0x0000-0x0cf7 window]
Jan 26 18:02:06 odl01 cloud-init[963]: Your identification has been saved in /etc/ssh/ssh_host_dsa_key.
Jan 26 18:02:06 odl01 kernel: [    0.725557] pci_bus 0000:00: resource 5 [io  0x0d00-0xffff window]
Jan 26 18:02:06 odl01 kernel: [    0.725559] pci_bus 0000:00: resource 6 [mem 0x000a0000-0x000bffff window]
Jan 26 18:02:06 odl01 kernel: [    0.725560] pci_bus 0000:00: resource 7 [mem 0xc0000000-0xfebfffff window]
Jan 26 18:02:06 odl01 kernel: [    0.725592] NET: Registered protocol family 2
Jan 26 18:02:06 odl01 kernel: [    0.727531] TCP established hash table entries: 65536 (order: 7, 524288 bytes)
Jan 26 18:02:06 odl01 cloud-init[963]: Your public key has been saved in /etc/ssh/ssh_host_dsa_key.pub.
Jan 26 18:02:06 odl01 kernel: [    0.728874] TCP bind hash table entries: 65536 (order: 8, 1048576 bytes)
Jan 26 18:02:06 odl01 kernel: [    0.730307] TCP: Hash tables configured (established 65536 bind 65536)
Jan 26 18:02:06 odl01 kernel: [    0.731365] UDP hash table entries: 4096 (order: 5, 131072 bytes)
Jan 26 18:02:06 odl01 cloud-init[963]: The key fingerprint is:
Jan 26 18:02:06 odl01 kernel: [    0.732348] UDP-Lite hash table entries: 4096 (order: 5, 131072 bytes)
Jan 26 18:02:06 odl01 kernel: [    0.733429] NET: Registered protocol family 1
Jan 26 18:02:06 odl01 kernel: [    0.734492] pci 0000:00:00.0: Limiting direct PCI/PCI transfers
Jan 26 18:02:06 odl01 cloud-init[963]: SHA256:nZrmHaPl7BImduKa1u0AqJnHQbx5H5dFN9x4xPvlFrs root@odl01
Jan 26 18:02:06 odl01 kernel: [    0.735457] pci 0000:00:01.0: PIIX3: Enabling Passive Release
Jan 26 18:02:06 odl01 kernel: [    0.736394] pci 0000:00:01.0: Activating ISA DMA hang workarounds
Jan 26 18:02:06 odl01 kernel: [    0.737401] pci 0000:00:02.0: Video device with shadowed ROM
Jan 26 18:02:06 odl01 cloud-init[963]: The key's randomart image is:
Jan 26 18:02:06 odl01 kernel: [    0.763255] ACPI: PCI Interrupt Link [LNKD] enabled at IRQ 11
Jan 26 18:02:06 odl01 kernel: [    0.814790] ACPI: PCI Interrupt Link [LNKA] enabled at IRQ 10
Jan 26 18:02:06 odl01 kernel: [    0.865742] ACPI: PCI Interrupt Link [LNKB] enabled at IRQ 10
Jan 26 18:02:06 odl01 cloud-init[963]: +---[DSA 1024]----+
Jan 26 18:02:06 odl01 kernel: [    0.918758] ACPI: PCI Interrupt Link [LNKC] enabled at IRQ 11
Jan 26 18:02:06 odl01 kernel: [    0.946173] PCI: CLS 0 bytes, default 64
Jan 26 18:02:06 odl01 kernel: [    0.946230] Unpacking initramfs...
Jan 26 18:02:06 odl01 kernel: [    2.945480] Freeing initrd memory: 10792K
Jan 26 18:02:06 odl01 kernel: [    2.946373] PCI-DMA: Using software bounce buffering for IO (SWIOTLB)
Jan 26 18:02:06 odl01 cloud-init[963]: |          ..o=.  |
Jan 26 18:02:06 odl01 kernel: [    2.947389] software IO TLB [mem 0xbbfdf000-0xbffdf000] (64MB) mapped at [ffff8800bbfdf000-ffff8800bffdefff]
Jan 26 18:02:06 odl01 kernel: [    2.952368] Scanning for low memory corruption every 60 seconds
Jan 26 18:02:06 odl01 kernel: [    2.954434] audit: initializing netlink subsys (disabled)
Jan 26 18:02:06 odl01 cloud-init[963]: | .       . .o.+  |
Jan 26 18:02:06 odl01 cloud-init[963]: |  o       .  . . |
Jan 26 18:02:06 odl01 cloud-init[963]: | . +     + .  ...|
Jan 26 18:02:06 odl01 cloud-init[963]: |  = o . S o    o+|
Jan 26 18:02:06 odl01 cloud-init[963]: | = o o+o+o     .+|
Jan 26 18:02:06 odl01 cloud-init[963]: |+ o  +o*+.+    ..|
Jan 26 18:02:06 odl01 cloud-init[963]: | .  ..o+o* o   E |
Jan 26 18:02:06 odl01 cloud-init[963]: |   .o. .+o=      |
Jan 26 18:02:06 odl01 cloud-init[963]: +----[SHA256]-----+
Jan 26 18:02:06 odl01 cloud-init[963]: Generating public/private ecdsa key pair.
Jan 26 18:02:06 odl01 cloud-init[963]: Your identification has been saved in /etc/ssh/ssh_host_ecdsa_key.
Jan 26 18:02:06 odl01 cloud-init[963]: Your public key has been saved in /etc/ssh/ssh_host_ecdsa_key.pub.
Jan 26 18:02:06 odl01 cloud-init[963]: The key fingerprint is:
Jan 26 18:02:06 odl01 kernel: [    2.956203] audit: type=2000 audit(1516989717.199:1): initialized
Jan 26 18:02:06 odl01 cloud-init[963]: SHA256:SYUHpKF7i69Njt9K+TndCr2YYfkRnp4dvmKmajfbXj0 root@odl01
Jan 26 18:02:06 odl01 kernel: [    2.958684] Initialise system trusted keyring
Jan 26 18:02:06 odl01 kernel: [    2.960595] HugeTLB registered 1 GB page size, pre-allocated 0 pages
Jan 26 18:02:06 odl01 kernel: [    2.962311] HugeTLB registered 2 MB page size, pre-allocated 0 pages
Jan 26 18:02:06 odl01 kernel: [    2.966967] zbud: loaded
Jan 26 18:02:06 odl01 cloud-init[963]: The key's randomart image is:
Jan 26 18:02:06 odl01 kernel: [    2.967775] VFS: Disk quotas dquot_6.6.0
Jan 26 18:02:06 odl01 cloud-init[963]: +---[ECDSA 256]---+
Jan 26 18:02:06 odl01 kernel: [    2.968506] VFS: Dquot-cache hash table entries: 512 (order 0, 4096 bytes)
Jan 26 18:02:06 odl01 cloud-init[963]: |      ..oo.      |
Jan 26 18:02:06 odl01 kernel: [    2.969816] squashfs: version 4.0 (2009/01/31) Phillip Lougher
Jan 26 18:02:06 odl01 kernel: [    2.971330] fuse init (API version 7.23)
Jan 26 18:02:06 odl01 kernel: [    2.972162] Key type big_key registered
Jan 26 18:02:06 odl01 kernel: [    2.972872] Allocating IMA MOK and blacklist keyrings.
Jan 26 18:02:06 odl01 kernel: [    2.974547] Key type asymmetric registered
Jan 26 18:02:06 odl01 kernel: [    2.975271] Asymmetric key parser 'x509' registered
Jan 26 18:02:06 odl01 cloud-init[963]: |     . o...      |
Jan 26 18:02:06 odl01 kernel: [    2.976117] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 249)
Jan 26 18:02:06 odl01 kernel: [    2.977424] io scheduler noop registered
Jan 26 18:02:06 odl01 kernel: [    2.978419] io scheduler deadline registered (default)
Jan 26 18:02:06 odl01 kernel: [    2.979299] io scheduler cfq registered
Jan 26 18:02:06 odl01 cloud-init[963]: |    . . ..       |
Jan 26 18:02:06 odl01 kernel: [    2.980064] pci_hotplug: PCI Hot Plug PCI Core version: 0.5
Jan 26 18:02:06 odl01 kernel: [    2.980968] pciehp: PCI Express Hot Plug Controller Driver version: 0.4
Jan 26 18:02:06 odl01 cloud-init[963]: |     . . .       |
Jan 26 18:02:06 odl01 kernel: [    2.982064] intel_idle: does not run on family 6 model 62
Jan 26 18:02:06 odl01 kernel: [    2.982132] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input0
Jan 26 18:02:06 odl01 kernel: [    2.983393] ACPI: Power Button [PWRF]
Jan 26 18:02:06 odl01 cloud-init[963]: |    . . S .      |
Jan 26 18:02:06 odl01 kernel: [    2.984289] GHES: HEST is not enabled!
Jan 26 18:02:06 odl01 cloud-init[963]: |     o o + o .   |
Jan 26 18:02:06 odl01 kernel: [    3.009260] virtio-pci 0000:00:03.0: virtio_pci: leaving for legacy driver
Jan 26 18:02:06 odl01 kernel: [    3.035933] virtio-pci 0000:00:04.0: virtio_pci: leaving for legacy driver
Jan 26 18:02:06 odl01 kernel: [    3.065035] virtio-pci 0000:00:05.0: virtio_pci: leaving for legacy driver
Jan 26 18:02:06 odl01 kernel: [    3.091333] virtio-pci 0000:00:06.0: virtio_pci: leaving for legacy driver
Jan 26 18:02:06 odl01 kernel: [    3.117685] virtio-pci 0000:00:07.0: virtio_pci: leaving for legacy driver
Jan 26 18:02:06 odl01 kernel: [    3.144276] virtio-pci 0000:00:09.0: virtio_pci: leaving for legacy driver
Jan 26 18:02:06 odl01 cloud-init[963]: |    . = =.=.o E  |
Jan 26 18:02:06 odl01 kernel: [    3.147289] Serial: 8250/16550 driver, 32 ports, IRQ sharing enabled
Jan 26 18:02:06 odl01 cloud-init[963]: |     B.++X=B.. . |
Jan 26 18:02:06 odl01 kernel: [    3.171914] 00:04: ttyS0 at I/O 0x3f8 (irq = 4, base_baud = 115200) is a 16550A
Jan 26 18:02:06 odl01 kernel: [    3.174576] Linux agpgart interface v0.103
Jan 26 18:02:06 odl01 kernel: [    3.176911] loop: module loaded
Jan 26 18:02:06 odl01 cloud-init[963]: |    o+B+OOOo+.   |
Jan 26 18:02:06 odl01 kernel: [    3.178932]  vda: vda1
Jan 26 18:02:06 odl01 kernel: [    3.179648] ata_piix 0000:00:01.1: version 2.13
Jan 26 18:02:06 odl01 cloud-init[963]: +----[SHA256]-----+
Jan 26 18:02:06 odl01 kernel: [    3.180884] scsi host0: ata_piix
Jan 26 18:02:06 odl01 kernel: [    3.181656] scsi host1: ata_piix
Jan 26 18:02:06 odl01 kernel: [    3.182598] ata1: PATA max MWDMA2 cmd 0x1f0 ctl 0x3f6 bmdma 0xc140 irq 14
Jan 26 18:02:06 odl01 kernel: [    3.183653] ata2: PATA max MWDMA2 cmd 0x170 ctl 0x376 bmdma 0xc148 irq 15
Jan 26 18:02:06 odl01 kernel: [    3.184771] libphy: Fixed MDIO Bus: probed
Jan 26 18:02:06 odl01 cloud-init[963]: Generating public/private ed25519 key pair.
Jan 26 18:02:06 odl01 kernel: [    3.185614] tun: Universal TUN/TAP device driver, 1.6
Jan 26 18:02:06 odl01 kernel: [    3.186464] tun: (C) 1999-2004 Max Krasnyansky <maxk@qualcomm.com>
Jan 26 18:02:06 odl01 kernel: [    3.190756] PPP generic driver version 2.4.2
Jan 26 18:02:06 odl01 cloud-init[963]: Your identification has been saved in /etc/ssh/ssh_host_ed25519_key.
Jan 26 18:02:06 odl01 kernel: [    3.191549] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver
Jan 26 18:02:06 odl01 kernel: [    3.192579] ehci-pci: EHCI PCI platform driver
Jan 26 18:02:06 odl01 kernel: [    3.218948] ehci-pci 0000:00:08.7: EHCI Host Controller
Jan 26 18:02:06 odl01 kernel: [    3.219823] ehci-pci 0000:00:08.7: new USB bus registered, assigned bus number 1
Jan 26 18:02:06 odl01 cloud-init[963]: Your public key has been saved in /etc/ssh/ssh_host_ed25519_key.pub.
Jan 26 18:02:06 odl01 kernel: [    3.231960] ehci-pci 0000:00:08.7: irq 11, io mem 0xfebd6000
Jan 26 18:02:06 odl01 kernel: [    3.241327] ehci-pci 0000:00:08.7: USB 2.0 started, EHCI 1.00
Jan 26 18:02:06 odl01 cloud-init[963]: The key fingerprint is:
Jan 26 18:02:06 odl01 kernel: [    3.243177] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002
Jan 26 18:02:06 odl01 kernel: [    3.244830] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1
Jan 26 18:02:06 odl01 kernel: [    3.246782] usb usb1: Product: EHCI Host Controller
Jan 26 18:02:06 odl01 cloud-init[963]: SHA256:O9DgWkOUXtaEpvN6kGboRO535MtA/IcXwlBA1NqlhEo root@odl01
Jan 26 18:02:06 odl01 kernel: [    3.248046] usb usb1: Manufacturer: Linux 4.4.0-112-generic ehci_hcd
Jan 26 18:02:06 odl01 kernel: [    3.249615] usb usb1: SerialNumber: 0000:00:08.7
Jan 26 18:02:06 odl01 kernel: [    3.250988] hub 1-0:1.0: USB hub found
Jan 26 18:02:06 odl01 kernel: [    3.252059] hub 1-0:1.0: 6 ports detected
Jan 26 18:02:06 odl01 cloud-init[963]: The key's randomart image is:
Jan 26 18:02:06 odl01 kernel: [    3.253459] ehci-platform: EHCI generic platform driver
Jan 26 18:02:06 odl01 kernel: [    3.255037] ohci_hcd: USB 1.1 'Open' Host Controller (OHCI) Driver
Jan 26 18:02:06 odl01 cloud-init[963]: +--[ED25519 256]--+
Jan 26 18:02:06 odl01 kernel: [    3.256025] ohci-pci: OHCI PCI platform driver
Jan 26 18:02:06 odl01 kernel: [    3.256799] ohci-platform: OHCI generic platform driver
Jan 26 18:02:06 odl01 kernel: [    3.257676] uhci_hcd: USB Universal Host Controller Interface driver
Jan 26 18:02:06 odl01 kernel: [    3.285955] uhci_hcd 0000:00:08.0: UHCI Host Controller
Jan 26 18:02:06 odl01 kernel: [    3.286830] uhci_hcd 0000:00:08.0: new USB bus registered, assigned bus number 2
Jan 26 18:02:06 odl01 cloud-init[963]: |     o==.+.      |
Jan 26 18:02:06 odl01 kernel: [    3.288100] uhci_hcd 0000:00:08.0: detected 2 ports
Jan 26 18:02:06 odl01 kernel: [    3.288956] uhci_hcd 0000:00:08.0: irq 11, io base 0x0000c0c0
Jan 26 18:02:06 odl01 kernel: [    3.290524] usb usb2: New USB device found, idVendor=1d6b, idProduct=0001
Jan 26 18:02:06 odl01 kernel: [    3.291587] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1
Jan 26 18:02:06 odl01 kernel: [    3.292819] usb usb2: Product: UHCI Host Controller
Jan 26 18:02:06 odl01 cloud-init[963]: |    E.o.B o      |
Jan 26 18:02:06 odl01 kernel: [    3.293648] usb usb2: Manufacturer: Linux 4.4.0-112-generic uhci_hcd
Jan 26 18:02:06 odl01 kernel: [    3.294652] usb usb2: SerialNumber: 0000:00:08.0
Jan 26 18:02:06 odl01 cloud-init[963]: |   . o+O o       |
Jan 26 18:02:06 odl01 kernel: [    3.295512] hub 2-0:1.0: USB hub found
Jan 26 18:02:06 odl01 kernel: [    3.296220] hub 2-0:1.0: 2 ports detected
Jan 26 18:02:06 odl01 kernel: [    3.323050] uhci_hcd 0000:00:08.1: UHCI Host Controller
Jan 26 18:02:06 odl01 kernel: [    3.323947] uhci_hcd 0000:00:08.1: new USB bus registered, assigned bus number 3
Jan 26 18:02:06 odl01 cloud-init[963]: |    o+==o        |
Jan 26 18:02:06 odl01 cloud-init[963]: |   o .B+S .      |
Jan 26 18:02:06 odl01 kernel: [    3.325255] uhci_hcd 0000:00:08.1: detected 2 ports
Jan 26 18:02:06 odl01 kernel: [    3.326707] uhci_hcd 0000:00:08.1: irq 10, io base 0x0000c0e0
Jan 26 18:02:06 odl01 cloud-init[963]: |    ++=+o+ .     |
Jan 26 18:02:06 odl01 kernel: [    3.327691] usb usb3: New USB device found, idVendor=1d6b, idProduct=0001
Jan 26 18:02:06 odl01 kernel: [    3.328762] usb usb3: New USB device strings: Mfr=3, Product=2, SerialNumber=1
Jan 26 18:02:06 odl01 kernel: [    3.330037] usb usb3: Product: UHCI Host Controller
Jan 26 18:02:06 odl01 kernel: [    3.330873] usb usb3: Manufacturer: Linux 4.4.0-112-generic uhci_hcd
Jan 26 18:02:06 odl01 kernel: [    3.331883] usb usb3: SerialNumber: 0000:00:08.1
Jan 26 18:02:06 odl01 cloud-init[963]: |   +.o.== o      |
Jan 26 18:02:06 odl01 kernel: [    3.332876] hub 3-0:1.0: USB hub found
Jan 26 18:02:06 odl01 cloud-init[963]: |    o oo++       |
Jan 26 18:02:06 odl01 kernel: [    3.333582] hub 3-0:1.0: 2 ports detected
Jan 26 18:02:06 odl01 kernel: [    3.337690] ata1.01: NODEV after polling detection
Jan 26 18:02:06 odl01 kernel: [    3.338788] ata1.00: ATAPI: QEMU DVD-ROM, 2.5+, max UDMA/100
Jan 26 18:02:06 odl01 cloud-init[963]: |     . oo.       |
Jan 26 18:02:06 odl01 kernel: [    3.340106] ata1.00: configured for MWDMA2
Jan 26 18:02:06 odl01 kernel: [    3.341360] scsi 0:0:0:0: CD-ROM            QEMU     QEMU DVD-ROM     2.5+ PQ: 0 ANSI: 5
Jan 26 18:02:06 odl01 cloud-init[963]: +----[SHA256]-----+
Jan 26 18:02:06 odl01 kernel: [    3.343547] sr 0:0:0:0: [sr0] scsi3-mmc drive: 4x/4x cd/rw xa/form2 tray
Jan 26 18:02:06 odl01 kernel: [    3.344624] cdrom: Uniform CD-ROM driver Revision: 3.20
Jan 26 18:02:06 odl01 systemd[1]: Started Initial cloud-init job (metadata service crawler).
Jan 26 18:02:06 odl01 kernel: [    3.345600] sr 0:0:0:0: Attached scsi CD-ROM sr0
Jan 26 18:02:06 odl01 kernel: [    3.345648] sr 0:0:0:0: Attached scsi generic sg0 type 5
Jan 26 18:02:06 odl01 kernel: [    3.360999] uhci_hcd 0000:00:08.2: UHCI Host Controller
Jan 26 18:02:06 odl01 kernel: [    3.362503] uhci_hcd 0000:00:08.2: new USB bus registered, assigned bus number 4
Jan 26 18:02:06 odl01 cron[1060]: (CRON) INFO (pidfile fd = 3)
Jan 26 18:02:06 odl01 kernel: [    3.363781] uhci_hcd 0000:00:08.2: detected 2 ports
Jan 26 18:02:06 odl01 kernel: [    3.364640] uhci_hcd 0000:00:08.2: irq 10, io base 0x0000c100
Jan 26 18:02:06 odl01 kernel: [    3.365629] usb usb4: New USB device found, idVendor=1d6b, idProduct=0001
Jan 26 18:02:06 odl01 kernel: [    3.367012] usb usb4: New USB device strings: Mfr=3, Product=2, SerialNumber=1
Jan 26 18:02:06 odl01 kernel: [    3.368270] usb usb4: Product: UHCI Host Controller
Jan 26 18:02:06 odl01 kernel: [    3.369106] usb usb4: Manufacturer: Linux 4.4.0-112-generic uhci_hcd
Jan 26 18:02:06 odl01 systemd[1]: Reached target Network is Online.
Jan 26 18:02:06 odl01 kernel: [    3.370149] usb usb4: SerialNumber: 0000:00:08.2
Jan 26 18:02:06 odl01 kernel: [    3.371219] hub 4-0:1.0: USB hub found
Jan 26 18:02:06 odl01 acpid: starting up with netlink and the input layer
Jan 26 18:02:06 odl01 kernel: [    3.371955] hub 4-0:1.0: 2 ports detected
Jan 26 18:02:06 odl01 kernel: [    3.372813] i8042: PNP: PS/2 Controller [PNP0303:KBD,PNP0f13:MOU] at 0x60,0x64 irq 1,12
Jan 26 18:02:06 odl01 kernel: [    3.376100] serio: i8042 KBD port at 0x60,0x64 irq 1
Jan 26 18:02:06 odl01 kernel: [    3.377441] serio: i8042 AUX port at 0x60,0x64 irq 12
Jan 26 18:02:06 odl01 systemd[1]: Starting iSCSI initiator daemon (iscsid)...
Jan 26 18:02:06 odl01 kernel: [    3.379116] mousedev: PS/2 mouse device common for all mice
Jan 26 18:02:06 odl01 kernel: [    3.380807] rtc_cmos 00:00: RTC can wake from S4
Jan 26 18:02:06 odl01 acpid: 1 rule loaded
Jan 26 18:02:06 odl01 kernel: [    3.382657] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input1
Jan 26 18:02:06 odl01 kernel: [    3.385003] rtc_cmos 00:00: rtc core: registered rtc_cmos as rtc0
Jan 26 18:02:06 odl01 kernel: [    3.387611] rtc_cmos 00:00: alarms up to one day, 114 bytes nvram
Jan 26 18:02:06 odl01 systemd[1]: Reached target Cloud-config availability.
Jan 26 18:02:06 odl01 kernel: [    3.388590] i2c /dev entries driver
Jan 26 18:02:06 odl01 acpid: waiting for events: event logging is off
Jan 26 18:02:06 odl01 kernel: [    3.389291] device-mapper: uevent: version 1.0.3
Jan 26 18:02:06 odl01 kernel: [    3.390140] device-mapper: ioctl: 4.34.0-ioctl (2015-10-28) initialised: dm-devel@redhat.com
Jan 26 18:02:06 odl01 kernel: [    3.391561] ledtrig-cpu: registered to indicate activity on CPUs
Jan 26 18:02:06 odl01 kernel: [    3.393009] NET: Registered protocol family 10
Jan 26 18:02:06 odl01 kernel: [    3.394079] NET: Registered protocol family 17
Jan 26 18:02:06 odl01 kernel: [    3.394870] Key type dns_resolver registered
Jan 26 18:02:06 odl01 systemd[1]: Reached target System Initialization.
Jan 26 18:02:06 odl01 kernel: [    3.395828] microcode: CPU0 sig=0x306e4, pf=0x1, revision=0x1
Jan 26 18:02:06 odl01 kernel: [    3.396795] microcode: CPU1 sig=0x306e4, pf=0x1, revision=0x1
Jan 26 18:02:06 odl01 kernel: [    3.398720] microcode: CPU2 sig=0x306e4, pf=0x1, revision=0x1
Jan 26 18:02:06 odl01 kernel: [    3.399721] microcode: CPU3 sig=0x306e4, pf=0x1, revision=0x1
Jan 26 18:02:06 odl01 kernel: [    3.400704] microcode: Microcode Update Driver: v2.01 <tigran@aivazian.fsnet.co.uk>, Peter Oruba
Jan 26 18:02:06 odl01 cron[1060]: (CRON) INFO (Running @reboot jobs)
Jan 26 18:02:06 odl01 kernel: [    3.402332] registered taskstats version 1
Jan 26 18:02:06 odl01 kernel: [    3.403090] Loading compiled-in X.509 certificates
Jan 26 18:02:06 odl01 systemd[1]: Started Daily apt download activities.
Jan 26 18:02:06 odl01 systemd[1]: Listening on D-Bus System Message Bus Socket.
Jan 26 18:02:06 odl01 lxcfs[1065]: hierarchies:
Jan 26 18:02:06 odl01 lxcfs[1065]:   0: fd:   5: memory
Jan 26 18:02:06 odl01 lxcfs[1065]:   1: fd:   6: hugetlb
Jan 26 18:02:06 odl01 lxcfs[1065]:   2: fd:   7: perf_event
Jan 26 18:02:06 odl01 lxcfs[1065]:   3: fd:   8: cpuset
Jan 26 18:02:06 odl01 lxcfs[1065]:   4: fd:   9: cpu,cpuacct
Jan 26 18:02:06 odl01 lxcfs[1065]:   5: fd:  10: freezer
Jan 26 18:02:06 odl01 lxcfs[1065]:   6: fd:  11: net_cls,net_prio
Jan 26 18:02:06 odl01 kernel: [    3.404672] Loaded X.509 cert 'Build time autogenerated kernel key: 4c603087bab8f0a02cb3b4e1fb4c40f507e71ef1'
Jan 26 18:02:06 odl01 lxcfs[1065]:   7: fd:  12: blkio
Jan 26 18:02:06 odl01 kernel: [    3.406336] zswap: loaded using pool lzo/zbud
Jan 26 18:02:06 odl01 kernel: [    3.408870] Key type trusted registered
Jan 26 18:02:06 odl01 kernel: [    3.413268] Key type encrypted registered
Jan 26 18:02:06 odl01 lxcfs[1065]:   8: fd:  13: devices
Jan 26 18:02:06 odl01 kernel: [    3.414305] AppArmor: AppArmor sha1 policy hashing enabled
Jan 26 18:02:06 odl01 kernel: [    3.415212] ima: No TPM chip found, activating TPM-bypass!
Jan 26 18:02:06 odl01 kernel: [    3.416125] evm: HMAC attrs: 0x1
Jan 26 18:02:06 odl01 lxcfs[1065]:   9: fd:  14: pids
Jan 26 18:02:06 odl01 kernel: [    3.417078]   Magic number: 2:793:39
Jan 26 18:02:06 odl01 kernel: [    3.417742] bdi 7:4: hash matches
Jan 26 18:02:06 odl01 kernel: [    3.418815] rtc_cmos 00:00: setting system clock to 2018-01-26 18:01:57 UTC (1516989717)
Jan 26 18:02:06 odl01 lxcfs[1065]:  10: fd:  15: name=systemd
Jan 26 18:02:06 odl01 kernel: [    3.420294] BIOS EDD facility v0.16 2004-Jun-25, 0 devices found
Jan 26 18:02:06 odl01 systemd[1]: Started ACPI Events Check.
Jan 26 18:02:06 odl01 kernel: [    3.421264] EDD information not available.
Jan 26 18:02:06 odl01 kernel: [    3.422878] PM: Hibernation image not present or could not be loaded.
Jan 26 18:02:06 odl01 systemd[1]: Reached target Paths.
Jan 26 18:02:06 odl01 kernel: [    3.424551] Freeing unused kernel memory: 1508K
Jan 26 18:02:06 odl01 kernel: [    3.425405] Write protecting the kernel read-only data: 14336k
Jan 26 18:02:06 odl01 systemd[1]: Started Daily apt upgrade and clean activities.
Jan 26 18:02:06 odl01 kernel: [    3.427302] Freeing unused kernel memory: 1728K
Jan 26 18:02:06 odl01 systemd[1]: Started Timer to automatically refresh installed snaps.
Jan 26 18:02:06 odl01 kernel: [    3.428459] Freeing unused kernel memory: 108K
Jan 26 18:02:06 odl01 kernel: [    3.443440] random: systemd-udevd: uninitialized urandom read (16 bytes read, 2 bits of entropy available)
Jan 26 18:02:06 odl01 kernel: [    3.444161] random: udevadm: uninitialized urandom read (16 bytes read, 2 bits of entropy available)
Jan 26 18:02:06 odl01 systemd[1]: Listening on UUID daemon activation socket.
Jan 26 18:02:06 odl01 kernel: [    3.444183] random: udevadm: uninitialized urandom read (16 bytes read, 2 bits of entropy available)
Jan 26 18:02:06 odl01 kernel: [    3.448595] random: systemd-udevd: uninitialized urandom read (16 bytes read, 2 bits of entropy available)
Jan 26 18:02:06 odl01 systemd[1]: Starting Socket activation for snappy daemon.
Jan 26 18:02:06 odl01 kernel: [    3.450498] random: systemd-udevd: uninitialized urandom read (16 bytes read, 2 bits of entropy available)
Jan 26 18:02:06 odl01 kernel: [    3.452094] random: systemd-udevd: uninitialized urandom read (16 bytes read, 2 bits of entropy available)
Jan 26 18:02:06 odl01 kernel: [    3.453345] random: udevadm: uninitialized urandom read (16 bytes read, 2 bits of entropy available)
Jan 26 18:02:06 odl01 systemd[1]: Starting LXD - unix socket.
Jan 26 18:02:06 odl01 kernel: [    3.453388] random: udevadm: uninitialized urandom read (16 bytes read, 2 bits of entropy available)
Jan 26 18:02:06 odl01 kernel: [    3.453640] random: udevadm: uninitialized urandom read (16 bytes read, 2 bits of entropy available)
Jan 26 18:02:06 odl01 kernel: [    3.453697] random: udevadm: uninitialized urandom read (16 bytes read, 2 bits of entropy available)
Jan 26 18:02:06 odl01 kernel: [    3.483526] virtio_net virtio0 ens3: renamed from eth0
Jan 26 18:02:06 odl01 kernel: [    3.489718] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input4
Jan 26 18:02:06 odl01 systemd[1]: Listening on ACPID Listen Socket.
Jan 26 18:02:06 odl01 kernel: [    3.491738] input: VirtualPS/2 VMware VMMouse as /devices/platform/i8042/serio1/input/input3
Jan 26 18:02:06 odl01 kernel: [    3.497973] virtio_net virtio1 ens4: renamed from eth1
Jan 26 18:02:06 odl01 kernel: [    3.508208] AVX version of gcm_enc/dec engaged.
Jan 26 18:02:06 odl01 systemd[1]: Started Daily Cleanup of Temporary Directories.
Jan 26 18:02:06 odl01 kernel: [    3.509092] AES CTR mode by8 optimization enabled
Jan 26 18:02:06 odl01 kernel: [    3.517546] virtio_net virtio3 ens6: renamed from eth3
Jan 26 18:02:06 odl01 kernel: [    3.517694] FDC 0 is a S82078B
Jan 26 18:02:06 odl01 kernel: [    3.533513] virtio_net virtio2 ens5: renamed from eth2
Jan 26 18:02:06 odl01 systemd[1]: Reached target Timers.
Jan 26 18:02:06 odl01 kernel: [    3.949492] clocksource: tsc: mask: 0xffffffffffffffff max_cycles: 0x285c3ee517e, max_idle_ns: 440795257231 ns
Jan 26 18:02:06 odl01 systemd[1]: Listening on Socket activation for snappy daemon.
Jan 26 18:02:06 odl01 kernel: [    4.810981] md: linear personality registered for level -1
Jan 26 18:02:06 odl01 kernel: [    4.815519] md: multipath personality registered for level -4
Jan 26 18:02:06 odl01 kernel: [    4.818891] md: raid0 personality registered for level 0
Jan 26 18:02:06 odl01 kernel: [    4.822501] md: raid1 personality registered for level 1
Jan 26 18:02:06 odl01 systemd[1]: Listening on LXD - unix socket.
Jan 26 18:02:06 odl01 kernel: [    4.893252] raid6: sse2x1   gen()  7190 MB/s
Jan 26 18:02:06 odl01 kernel: [    4.961256] raid6: sse2x1   xor()  5677 MB/s
Jan 26 18:02:06 odl01 systemd[1]: Reached target Sockets.
Jan 26 18:02:06 odl01 kernel: [    5.029255] raid6: sse2x2   gen()  8910 MB/s
Jan 26 18:02:06 odl01 kernel: [    5.097252] raid6: sse2x2   xor()  6115 MB/s
Jan 26 18:02:06 odl01 kernel: [    5.165257] raid6: sse2x4   gen() 10230 MB/s
Jan 26 18:02:06 odl01 kernel: [    5.233252] raid6: sse2x4   xor()  7268 MB/s
Jan 26 18:02:06 odl01 kernel: [    5.234821] raid6: using algorithm sse2x4 gen() 10230 MB/s
Jan 26 18:02:06 odl01 kernel: [    5.235695] raid6: .... xor() 7268 MB/s, rmw enabled
Jan 26 18:02:06 odl01 rsyslogd-2007: action 'action 11' suspended, next retry is Fri Jan 26 18:02:36 2018 [v8.16.0 try http://www.rsyslog.com/e/2007 ]
Jan 26 18:02:06 odl01 systemd[1]: Reached target Basic System.
Jan 26 18:02:06 odl01 kernel: [    5.236500] raid6: using ssse3x2 recovery algorithm
Jan 26 18:02:06 odl01 kernel: [    5.239241] xor: automatically using best checksumming function:
Jan 26 18:02:06 odl01 systemd[1]: Started ACPI event daemon.
Jan 26 18:02:06 odl01 kernel: [    5.277262]    avx       : 18087.000 MB/sec
Jan 26 18:02:06 odl01 kernel: [    5.279328] async_tx: api initialized (async)
Jan 26 18:02:06 odl01 kernel: [    5.288060] md: raid6 personality registered for level 6
Jan 26 18:02:06 odl01 systemd[1]: Starting Pollinate to seed the pseudo random number generator...
Jan 26 18:02:06 odl01 kernel: [    5.288943] md: raid5 personality registered for level 5
Jan 26 18:02:06 odl01 kernel: [    5.289812] md: raid4 personality registered for level 4
Jan 26 18:02:06 odl01 systemd[1]: Starting Accounts Service...
Jan 26 18:02:06 odl01 kernel: [    5.298789] md: raid10 personality registered for level 10
Jan 26 18:02:06 odl01 kernel: [    5.339510] Btrfs loaded
Jan 26 18:02:06 odl01 kernel: [    5.380920] EXT4-fs (vda1): mounted filesystem with ordered data mode. Opts: (null)
Jan 26 18:02:06 odl01 systemd[1]: Started Regular background program processing daemon.
Jan 26 18:02:06 odl01 kernel: [    5.899883] EXT4-fs (vda1): re-mounted. Opts: (null)
Jan 26 18:02:06 odl01 systemd[1]: Started Deferred execution scheduler.
Jan 26 18:02:06 odl01 kernel: [    6.066516] Loading iSCSI transport class v2.0-870.
Jan 26 18:02:06 odl01 kernel: [    6.081492] iscsi: registered transport (tcp)
Jan 26 18:02:06 odl01 kernel: [    6.125831] iscsi: registered transport (iser)
Jan 26 18:02:06 odl01 systemd[1]: Started FUSE filesystem for LXC.
Jan 26 18:02:06 odl01 kernel: [    7.025519] ppdev: user-space parallel port driver
Jan 26 18:02:06 odl01 kernel: [    7.147726] audit: type=1400 audit(1516989721.224:2): apparmor="STATUS" operation="profile_load" profile="unconfined" name="/usr/bin/lxc-start" pid=713 comm="apparmor_parser"
Jan 26 18:02:06 odl01 systemd[1]: Starting LSB: Record successful boot for GRUB...
Jan 26 18:02:06 odl01 systemd[1]: Starting /etc/rc.local Compatibility...
Jan 26 18:02:06 odl01 systemd[1]: Starting Login Service...
Jan 26 18:02:06 odl01 kernel: [    7.349554] audit: type=1400 audit(1516989721.428:3): apparmor="STATUS" operation="profile_load" profile="unconfined" name="/usr/lib/lxd/lxd-bridge-proxy" pid=712 comm="apparmor_parser"
Jan 26 18:02:06 odl01 kernel: [    7.462405] audit: type=1400 audit(1516989721.540:4): apparmor="STATUS" operation="profile_load" profile="unconfined" name="/sbin/dhclient" pid=714 comm="apparmor_parser"
Jan 26 18:02:06 odl01 kernel: [    7.462751] audit: type=1400 audit(1516989721.540:5): apparmor="STATUS" operation="profile_load" profile="unconfined" name="/usr/lib/NetworkManager/nm-dhcp-client.action" pid=714 comm="apparmor_parser"
Jan 26 18:02:06 odl01 systemd[1]: Starting Apply the settings specified in cloud-config...
Jan 26 18:02:06 odl01 kernel: [    7.463068] audit: type=1400 audit(1516989721.540:6): apparmor="STATUS" operation="profile_load" profile="unconfined" name="/usr/lib/NetworkManager/nm-dhcp-helper" pid=714 comm="apparmor_parser"
Jan 26 18:02:06 odl01 kernel: [    7.463373] audit: type=1400 audit(1516989721.540:7): apparmor="STATUS" operation="profile_load" profile="unconfined" name="/usr/lib/connman/scripts/dhclient-script" pid=714 comm="apparmor_parser"
Jan 26 18:02:06 odl01 systemd[1]: Started Unattended Upgrades Shutdown.
Jan 26 18:02:06 odl01 kernel: [    7.494342] audit: type=1400 audit(1516989721.572:8): apparmor="STATUS" operation="profile_load" profile="unconfined" name="/usr/lib/snapd/snap-confine" pid=716 comm="apparmor_parser"
Jan 26 18:02:06 odl01 kernel: [    7.494536] audit: type=1400 audit(1516989721.572:9): apparmor="STATUS" operation="profile_load" profile="unconfined" name="/usr/lib/snapd/snap-confine//mount-namespace-capture-helper" pid=716 comm="apparmor_parser"
Jan 26 18:02:06 odl01 kernel: [    7.494691] audit: type=1400 audit(1516989721.572:10): apparmor="STATUS" operation="profile_load" profile="unconfined" name="/usr/lib/snapd/snap-confine//snap_update_ns" pid=716 comm="apparmor_parser"
Jan 26 18:02:06 odl01 kernel: [    7.710545] ISO 9660 Extensions: Microsoft Joliet Level 3
Jan 26 18:02:06 odl01 systemd[1]: Starting LSB: MD monitoring daemon...
Jan 26 18:02:06 odl01 kernel: [    7.712564] ISO 9660 Extensions: RRIP_1991A
Jan 26 18:02:06 odl01 systemd[1]: Starting The Salt Minion...
Jan 26 18:02:06 odl01 kernel: [   11.552781] EXT4-fs (vda1): resizing filesystem from 786171 to 26214139 blocks
Jan 26 18:02:06 odl01 kernel: [   11.597264] EXT4-fs (vda1): resized filesystem to 26214139
Jan 26 18:02:06 odl01 systemd[1]: Starting System Logging Service...
Jan 26 18:02:06 odl01 kernel: [   12.467216] cgroup: new mount options do not match the existing superblock, will be ignored
Jan 26 18:02:06 odl01 systemd[1]: Starting LXD - container startup/shutdown...
Jan 26 18:02:06 odl01 systemd[1]: Started D-Bus System Message Bus.
Jan 26 18:02:06 odl01 pollinate[1054]: client sent challenge to [https://entropy.ubuntu.com/]
Jan 26 18:02:06 odl01 dbus[1089]: [system] AppArmor D-Bus mediation is enabled
Jan 26 18:02:06 odl01 systemd[1]: Starting Snappy daemon...
Jan 26 18:02:06 odl01 systemd[1]: Started System Logging Service.
Jan 26 18:02:06 odl01 systemd[1]: Started /etc/rc.local Compatibility.
Jan 26 18:02:06 odl01 mdadm[1079]:  * Starting MD monitoring service mdadm --monitor
Jan 26 18:02:06 odl01 iscsid: iSCSI logger with pid=1151 started!
Jan 26 18:02:06 odl01 systemd[1]: Started iSCSI initiator daemon (iscsid).
Jan 26 18:02:06 odl01 systemd[1]: Starting Login to default iSCSI targets...
Jan 26 18:02:06 odl01 systemd[1]: Started Login Service.
Jan 26 18:02:06 odl01 dbus[1089]: [system] Activating via systemd: service name='org.freedesktop.PolicyKit1' unit='polkitd.service'
Jan 26 18:02:06 odl01 systemd[1]: Starting Authenticate and Authorize Users to Run Privileged Tasks...
Jan 26 18:02:06 odl01 mdadm[1079]:    ...done.
Jan 26 18:02:06 odl01 systemd[1]: Started LSB: MD monitoring daemon.
Jan 26 18:02:06 odl01 iscsiadm[1161]: iscsiadm: No records found
Jan 26 18:02:06 odl01 systemd[1]: Started Login to default iSCSI targets.
Jan 26 18:02:06 odl01 systemd[1]: Reached target Remote File Systems (Pre).
Jan 26 18:02:06 odl01 systemd[1]: Reached target Remote File Systems.
Jan 26 18:02:06 odl01 systemd[1]: Starting LSB: daemon to balance interrupts for SMP systems...
Jan 26 18:02:06 odl01 systemd[1]: Starting LSB: automatic crash report generation...
Jan 26 18:02:06 odl01 systemd[1]: Starting Permit User Sessions...
Jan 26 18:02:06 odl01 systemd[1]: Starting LSB: Set the CPU Frequency Scaling governor to "ondemand"...
Jan 26 18:02:06 odl01 systemd[1]: Started LSB: Record successful boot for GRUB.
Jan 26 18:02:06 odl01 systemd[1]: Started Permit User Sessions.
Jan 26 18:02:06 odl01 polkitd[1166]: started daemon version 0.105 using authority implementation `local' version `0.105'
Jan 26 18:02:06 odl01 dbus[1089]: [system] Successfully activated service 'org.freedesktop.PolicyKit1'
Jan 26 18:02:06 odl01 systemd[1]: Started Authenticate and Authorize Users to Run Privileged Tasks.
Jan 26 18:02:06 odl01 accounts-daemon[1055]: started daemon version 0.6.40
Jan 26 18:02:06 odl01 systemd[1]: Started Accounts Service.
Jan 26 18:02:06 odl01 apport[1184]:  * Starting automatic crash report generation: apport
Jan 26 18:02:06 odl01 systemd[1]: Starting Terminate Plymouth Boot Screen...
Jan 26 18:02:06 odl01 systemd[1]: Starting Hold until boot process finishes up...
Jan 26 18:02:06 odl01 systemd[1]: Started LSB: Set the CPU Frequency Scaling governor to "ondemand".
Jan 26 18:02:06 odl01 systemd[1]: Started Hold until boot process finishes up.
Jan 26 18:02:06 odl01 systemd[1]: Started Terminate Plymouth Boot Screen.
Jan 26 18:02:07 odl01 irqbalance[1180]:  * Starting SMP IRQ Balancer: irqbalance
Jan 26 18:02:07 odl01 systemd[1]: Starting Set console scheme...
Jan 26 18:02:07 odl01 systemd[1]: Started Getty on tty1.
Jan 26 18:02:07 odl01 systemd[1]: Started Serial Getty on ttyS0.
Jan 26 18:02:07 odl01 systemd[1]: Reached target Login Prompts.
Jan 26 18:02:07 odl01 apport[1184]:    ...done.
Jan 26 18:02:07 odl01 systemd[1]: Started LSB: automatic crash report generation.
Jan 26 18:02:07 odl01 systemd[1]: Started Set console scheme.
Jan 26 18:02:07 odl01 irqbalance[1180]:    ...done.
Jan 26 18:02:07 odl01 systemd[1]: Started LSB: daemon to balance interrupts for SMP systems.
Jan 26 18:02:07 odl01 cloud-init[1077]: Generating locales (this might take a while)...
Jan 26 18:02:07 odl01 kernel: [   13.025449] random: nonblocking pool is initialized
Jan 26 18:02:07 odl01 systemd[1]: Started LXD - container startup/shutdown.
Jan 26 18:02:07 odl01 snapd[1138]: AppArmor status: apparmor is enabled and all features are available
Jan 26 18:02:07 odl01 snapd[1138]: 2018/01/26 18:02:07.328463 daemon.go:306: started snapd/2.29.4.2 (series 16; classic) ubuntu/16.04 (amd64) linux/4.4.0-112-generic.
Jan 26 18:02:07 odl01 systemd[1]: Started Snappy daemon.
Jan 26 18:02:07 odl01 pollinate[1054]: client verified challenge/response with [https://entropy.ubuntu.com/]
Jan 26 18:02:07 odl01 pollinate[1054]: client hashed response from [https://entropy.ubuntu.com/]
Jan 26 18:02:07 odl01 pollinate[1054]: client successfully seeded [/dev/urandom]
Jan 26 18:02:07 odl01 systemd[1]: Started Pollinate to seed the pseudo random number generator.
Jan 26 18:02:07 odl01 systemd[1]: Starting OpenBSD Secure Shell server...
Jan 26 18:02:07 odl01 systemd[1]: Started OpenBSD Secure Shell server.
Jan 26 18:02:07 odl01 systemd[1]: Started The Salt Minion.
Jan 26 18:02:07 odl01 systemd[1]: Reached target Multi-User System.
Jan 26 18:02:07 odl01 systemd[1]: Reached target Graphical Interface.
Jan 26 18:02:07 odl01 systemd[1]: Starting Update UTMP about System Runlevel Changes...
Jan 26 18:02:07 odl01 systemd[1]: Started Update UTMP about System Runlevel Changes.
Jan 26 18:02:07 odl01 iscsid: iSCSI daemon with pid=1152 started!
Jan 26 18:02:08 odl01 cloud-init[1077]:   en_US.UTF-8... done
Jan 26 18:02:08 odl01 cloud-init[1077]: Generation complete.
Jan 26 18:02:08 odl01 cloud-init[1077]: Cloud-init v. 17.1 running 'modules:config' at Fri, 26 Jan 2018 18:02:06 +0000. Up 12.37 seconds.
Jan 26 18:02:08 odl01 systemd[1]: Started Apply the settings specified in cloud-config.
Jan 26 18:02:08 odl01 systemd[1]: Starting Execute cloud user/final scripts...
Jan 26 18:02:08 odl01 salt-minion[1081]: [ERROR   ] DNS lookup or connection check of 'salt' failed.
Jan 26 18:02:08 odl01 salt-minion[1081]: [ERROR   ] Master hostname: 'salt' not found or not responsive. Retrying in 30 seconds
Jan 26 18:02:09 odl01 systemd[1]: Stopping The Salt Minion...
Jan 26 18:02:09 odl01 salt-minion[1081]: [WARNING ] Minion received a SIGTERM. Exiting.
Jan 26 18:02:09 odl01 salt-minion[1081]: The Salt Minion is shutdown. Minion received a SIGTERM. Exited.
Jan 26 18:02:09 odl01 systemd[1]: Stopped The Salt Minion.
Jan 26 18:02:09 odl01 systemd[1]: Starting The Salt Minion...
Jan 26 18:02:09 odl01 systemd[1]: Started The Salt Minion.
Jan 26 18:02:09 odl01 ec2: 
Jan 26 18:02:09 odl01 ec2: #############################################################
Jan 26 18:02:09 odl01 ec2: -----BEGIN SSH HOST KEY FINGERPRINTS-----
Jan 26 18:02:09 odl01 ec2: 1024 SHA256:nZrmHaPl7BImduKa1u0AqJnHQbx5H5dFN9x4xPvlFrs root@odl01 (DSA)
Jan 26 18:02:09 odl01 ec2: 256 SHA256:SYUHpKF7i69Njt9K+TndCr2YYfkRnp4dvmKmajfbXj0 root@odl01 (ECDSA)
Jan 26 18:02:09 odl01 ec2: 256 SHA256:O9DgWkOUXtaEpvN6kGboRO535MtA/IcXwlBA1NqlhEo root@odl01 (ED25519)
Jan 26 18:02:09 odl01 ec2: 2048 SHA256:s03rGzvF3UF76IuXPvVDtHKoxmoIsxjF5H+iZBV9YGw root@odl01 (RSA)
Jan 26 18:02:09 odl01 ec2: -----END SSH HOST KEY FINGERPRINTS-----
Jan 26 18:02:09 odl01 ec2: #############################################################
Jan 26 18:02:09 odl01 cloud-init[1328]: Cloud-init v. 17.1 running 'modules:final' at Fri, 26 Jan 2018 18:02:08 +0000. Up 14.49 seconds.
Jan 26 18:02:09 odl01 cloud-init[1328]: Cloud-init v. 17.1 finished at Fri, 26 Jan 2018 18:02:09 +0000. Datasource DataSourceNoCloud [seed=/dev/sr0][dsmode=net].  Up 14.86 seconds
Jan 26 18:02:09 odl01 systemd[1]: Started Execute cloud user/final scripts.
Jan 26 18:02:09 odl01 systemd[1]: Reached target Cloud-init target.
Jan 26 18:02:09 odl01 systemd[1]: Startup finished in 5.219s (kernel) + 9.720s (userspace) = 14.940s.
Jan 26 18:02:31 odl01 systemd-timesyncd[636]: Synchronized to time server 91.189.91.157:123 (ntp.ubuntu.com).
Jan 26 18:06:19 odl01 salt-minion[1349]: [WARNING ] /usr/lib/python2.7/dist-packages/salt/utils/templates.py:73: DeprecationWarning: Starting in 2015.5, cmd.run uses python_shell=False by default, which doesn't support shellisms (pipes, env variables, etc). cmd.run is currently aliased to cmd.shell to prevent breakage. Please switch to cmd.shell or set python_shell=True to avoid breakage in the future, when this aliasing is removed.
Jan 26 18:06:28 odl01 systemd[1]: Started /usr/bin/apt-get -q -y -o DPkg::Options::=--force-confold -o DPkg::Options::=--force-confdef install python-oauth python-psutil python-m2crypto.
Jan 26 18:06:31 odl01 salt-minion[1349]: [ERROR   ] Command 'while true; do salt-call saltutil.running|grep fun: && continue; salt-call --local service.restart salt-minion; break; done' failed with return code: None
Jan 26 18:06:33 odl01 salt-minion[1349]: [INFO    ] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
Jan 26 18:06:33 odl01 salt-minion[1349]: [INFO    ] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
Jan 26 18:06:34 odl01 salt-minion[1349]: [INFO    ] Executing command ['systemd-run', '--scope', 'systemctl', 'restart', 'salt-minion.service'] in directory '/root'
Jan 26 18:06:34 odl01 systemd[1]: Started /bin/systemctl restart salt-minion.service.
Jan 26 18:06:34 odl01 systemd[1]: Stopping The Salt Minion...
Jan 26 18:06:34 odl01 salt-minion[1349]: [WARNING ] Minion received a SIGTERM. Exiting.
Jan 26 18:06:34 odl01 salt-minion[1349]: The Salt Minion is shutdown. Minion received a SIGTERM. Exited.
Jan 26 18:06:34 odl01 systemd[1]: Stopped The Salt Minion.
Jan 26 18:06:34 odl01 systemd[1]: Starting The Salt Minion...
Jan 26 18:06:34 odl01 systemd[1]: Started The Salt Minion.
Jan 26 18:06:34 odl01 salt-minion[2105]: [INFO    ] Setting up the Salt Minion "odl01.virtual-mcp-ocata-odl-router-noha.local"
Jan 26 18:06:35 odl01 salt-minion[2105]: [INFO    ] Starting up the Salt Minion
Jan 26 18:06:35 odl01 salt-minion[2105]: [INFO    ] Starting pull socket on /var/run/salt/minion/minion_event_85dcaba890_pull.ipc
Jan 26 18:06:35 odl01 salt-minion[2105]: [INFO    ] Creating minion process manager
Jan 26 18:06:36 odl01 salt-minion[2105]: [INFO    ] Executing command ['date', '+%z'] in directory '/root'
Jan 26 18:06:36 odl01 salt-minion[2105]: [INFO    ] Updating job settings for scheduled job: __mine_interval
Jan 26 18:06:36 odl01 salt-minion[2105]: [INFO    ] Added mine.update to scheduler
Jan 26 18:06:36 odl01 salt-minion[2105]: [INFO    ] Minion is starting as user 'root'
Jan 26 18:06:36 odl01 salt-minion[2105]: [INFO    ] Minion is ready to receive requests!
Jan 26 18:06:37 odl01 salt-minion[2105]: [INFO    ] Running scheduled job: __mine_interval
Jan 26 18:07:12 odl01 salt-minion[2105]: [INFO    ] User sudo_ubuntu Executing command state.sls with jid 20180126180712668307
Jan 26 18:07:12 odl01 salt-minion[2105]: [INFO    ] Starting a new job with PID 2200
Jan 26 18:07:15 odl01 salt-minion[2105]: [INFO    ] Loading fresh modules for state activity
Jan 26 18:07:15 odl01 salt-minion[2105]: [INFO    ] Fetching file from saltenv 'base', ** done ** 'linux/init.sls'
Jan 26 18:07:15 odl01 salt-minion[2105]: [INFO    ] Fetching file from saltenv 'base', ** done ** 'linux/system/init.sls'
Jan 26 18:07:15 odl01 salt-minion[2105]: [INFO    ] Fetching file from saltenv 'base', ** done ** 'linux/system/env.sls'
Jan 26 18:07:15 odl01 salt-minion[2105]: [INFO    ] Fetching file from saltenv 'base', ** done ** 'linux/system/profile.sls'
Jan 26 18:07:15 odl01 salt-minion[2105]: [INFO    ] Fetching file from saltenv 'base', ** done ** 'linux/system/repo.sls'
Jan 26 18:07:16 odl01 salt-minion[2105]: [INFO    ] Fetching file from saltenv 'base', ** done ** 'linux/system/package.sls'
Jan 26 18:07:16 odl01 salt-minion[2105]: [INFO    ] Fetching file from saltenv 'base', ** done ** 'linux/system/timezone.sls'
Jan 26 18:07:16 odl01 salt-minion[2105]: [INFO    ] Fetching file from saltenv 'base', ** done ** 'linux/system/kernel.sls'
Jan 26 18:07:16 odl01 salt-minion[2105]: [INFO    ] Fetching file from saltenv 'base', ** done ** 'linux/system/cpu.sls'
Jan 26 18:07:16 odl01 salt-minion[2105]: [INFO    ] Fetching file from saltenv 'base', ** done ** 'linux/system/sysfs.sls'
Jan 26 18:07:16 odl01 salt-minion[2105]: [INFO    ] Fetching file from saltenv 'base', ** done ** 'linux/system/locale.sls'
Jan 26 18:07:16 odl01 salt-minion[2105]: [INFO    ] Fetching file from saltenv 'base', ** done ** 'linux/system/user.sls'
Jan 26 18:07:16 odl01 salt-minion[2105]: [INFO    ] Fetching file from saltenv 'base', ** done ** 'linux/system/group.sls'
Jan 26 18:07:16 odl01 salt-minion[2105]: [INFO    ] Fetching file from saltenv 'base', ** done ** 'linux/system/limit.sls'
Jan 26 18:07:17 odl01 salt-minion[2105]: [INFO    ] Fetching file from saltenv 'base', ** done ** 'linux/system/systemd.sls'
Jan 26 18:07:17 odl01 salt-minion[2105]: [INFO    ] Fetching file from saltenv 'base', ** done ** 'linux/system/apt.sls'
Jan 26 18:07:17 odl01 salt-minion[2105]: [INFO    ] Fetching file from saltenv 'base', ** done ** 'linux/network/init.sls'
Jan 26 18:07:17 odl01 salt-minion[2105]: [INFO    ] Fetching file from saltenv 'base', ** done ** 'linux/network/hostname.sls'
Jan 26 18:07:17 odl01 salt-minion[2105]: [INFO    ] Fetching file from saltenv 'base', ** done ** 'linux/network/host.sls'
Jan 26 18:07:17 odl01 salt-minion[2105]: [INFO    ] Fetching file from saltenv 'base', ** done ** 'linux/network/interface.sls'
Jan 26 18:07:17 odl01 salt-minion[2105]: [INFO    ] Fetching file from saltenv 'base', ** done ** 'linux/network/proxy.sls'
Jan 26 18:07:17 odl01 salt-minion[2105]: [INFO    ] Fetching file from saltenv 'base', ** done ** 'linux/storage/init.sls'
Jan 26 18:07:17 odl01 salt-minion[2105]: [INFO    ] Running state [/etc/environment] at time 18:07:17.989504
Jan 26 18:07:17 odl01 salt-minion[2105]: [INFO    ] Executing state file.blockreplace for /etc/environment
Jan 26 18:07:17 odl01 salt-minion[2105]: [INFO    ] File changed:
Jan 26 18:07:17 odl01 salt-minion[2105]: ---
Jan 26 18:07:17 odl01 salt-minion[2105]: +++
Jan 26 18:07:17 odl01 salt-minion[2105]: @@ -1 +1,4 @@
Jan 26 18:07:17 odl01 salt-minion[2105]:  PATH="/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/games:/usr/local/games"
Jan 26 18:07:17 odl01 salt-minion[2105]: +# SALT MANAGED VARIABLES - DO NOT EDIT - START
Jan 26 18:07:18 odl01 salt-minion[2105]: +# +# SALT MANAGED VARIABLES - END
Jan 26 18:07:18 odl01 salt-minion[2105]: [INFO    ] Completed state [/etc/environment] at time 18:07:18.000331 duration_in_ms=10.828
Jan 26 18:07:18 odl01 salt-minion[2105]: [INFO    ] Running state [/etc/profile.d] at time 18:07:18.000762
Jan 26 18:07:18 odl01 salt-minion[2105]: [INFO    ] Executing state file.directory for /etc/profile.d
Jan 26 18:07:18 odl01 salt-minion[2105]: [INFO    ] Directory /etc/profile.d is in the correct state
Jan 26 18:07:18 odl01 salt-minion[2105]: [INFO    ] Completed state [/etc/profile.d] at time 18:07:18.003352 duration_in_ms=2.59
Jan 26 18:07:18 odl01 salt-minion[2105]: [INFO    ] Running state [/etc/apt/apt.conf.d/99compression-workaround-salt] at time 18:07:18.478712
Jan 26 18:07:18 odl01 salt-minion[2105]: [INFO    ] Executing state file.managed for /etc/apt/apt.conf.d/99compression-workaround-salt
Jan 26 18:07:18 odl01 salt-minion[2105]: [INFO    ] Fetching file from saltenv 'base', ** done ** 'linux/files/apt.conf'
Jan 26 18:07:18 odl01 salt-minion[2105]: [INFO    ] File changed:
Jan 26 18:07:18 odl01 salt-minion[2105]: New file
Jan 26 18:07:18 odl01 salt-minion[2105]: [INFO    ] Completed state [/etc/apt/apt.conf.d/99compression-workaround-salt] at time 18:07:18.509444 duration_in_ms=30.732
Jan 26 18:07:18 odl01 salt-minion[2105]: [INFO    ] Running state [/etc/apt/apt.conf.d/99prefer_ipv4-salt] at time 18:07:18.510450
Jan 26 18:07:18 odl01 salt-minion[2105]: [INFO    ] Executing state file.managed for /etc/apt/apt.conf.d/99prefer_ipv4-salt
Jan 26 18:07:18 odl01 salt-minion[2105]: [INFO    ] File changed:
Jan 26 18:07:18 odl01 salt-minion[2105]: New file
Jan 26 18:07:18 odl01 salt-minion[2105]: [INFO    ] Completed state [/etc/apt/apt.conf.d/99prefer_ipv4-salt] at time 18:07:18.526530 duration_in_ms=16.08
Jan 26 18:07:18 odl01 salt-minion[2105]: [INFO    ] Running state [linux_repo_prereq_pkgs] at time 18:07:18.527528
Jan 26 18:07:18 odl01 salt-minion[2105]: [INFO    ] Executing state pkg.installed for linux_repo_prereq_pkgs
Jan 26 18:07:18 odl01 salt-minion[2105]: [INFO    ] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
Jan 26 18:07:18 odl01 salt-minion[2105]: [INFO    ] All specified packages are already installed
Jan 26 18:07:18 odl01 salt-minion[2105]: [INFO    ] Completed state [linux_repo_prereq_pkgs] at time 18:07:18.863714 duration_in_ms=336.185
Jan 26 18:07:18 odl01 salt-minion[2105]: [INFO    ] Running state [/etc/apt/apt.conf.d/99proxies-salt-mk_openstack] at time 18:07:18.864243
Jan 26 18:07:18 odl01 salt-minion[2105]: [INFO    ] Executing state file.absent for /etc/apt/apt.conf.d/99proxies-salt-mk_openstack
Jan 26 18:07:18 odl01 salt-minion[2105]: [INFO    ] File /etc/apt/apt.conf.d/99proxies-salt-mk_openstack is not present
Jan 26 18:07:18 odl01 salt-minion[2105]: [INFO    ] Completed state [/etc/apt/apt.conf.d/99proxies-salt-mk_openstack] at time 18:07:18.865729 duration_in_ms=1.486
Jan 26 18:07:18 odl01 salt-minion[2105]: [INFO    ] Running state [/etc/apt/preferences.d/mk_openstack] at time 18:07:18.866144
Jan 26 18:07:18 odl01 salt-minion[2105]: [INFO    ] Executing state file.managed for /etc/apt/preferences.d/mk_openstack
Jan 26 18:07:18 odl01 salt-minion[2105]: [INFO    ] Fetching file from saltenv 'base', ** done ** 'linux/files/preferences_repo'
Jan 26 18:07:18 odl01 salt-minion[2105]: [INFO    ] File changed:
Jan 26 18:07:18 odl01 salt-minion[2105]: New file
Jan 26 18:07:18 odl01 salt-minion[2105]: [INFO    ] Completed state [/etc/apt/preferences.d/mk_openstack] at time 18:07:18.959648 duration_in_ms=93.502
Jan 26 18:07:18 odl01 salt-minion[2105]: [INFO    ] Running state [deb [arch=amd64] http://apt.mirantis.com/xenial/ 2017.12 ocata] at time 18:07:18.963182
Jan 26 18:07:18 odl01 salt-minion[2105]: [INFO    ] Executing state pkgrepo.managed for deb [arch=amd64] http://apt.mirantis.com/xenial/ 2017.12 ocata
Jan 26 18:07:19 odl01 salt-minion[2105]: [INFO    ] Executing command ['apt-key', 'add', '/var/cache/salt/minion/extrn_files/base/apt.mirantis.com/public.gpg'] in directory '/root'
Jan 26 18:07:19 odl01 salt-minion[2105]: [INFO    ] Executing command ['apt-get', '-q', 'update'] in directory '/root'
Jan 26 18:07:22 odl01 salt-minion[2105]: [INFO    ] User sudo_ubuntu Executing command saltutil.find_job with jid 20180126180722761295
Jan 26 18:07:22 odl01 salt-minion[2105]: [INFO    ] Starting a new job with PID 2682
Jan 26 18:07:22 odl01 salt-minion[2105]: [INFO    ] Returning information for job: 20180126180722761295
Jan 26 18:07:23 odl01 salt-minion[2105]: [INFO    ] {'repo': 'deb [arch=amd64] http://apt.mirantis.com/xenial 2017.12 ocata'}
Jan 26 18:07:23 odl01 salt-minion[2105]: [INFO    ] Completed state [deb [arch=amd64] http://apt.mirantis.com/xenial/ 2017.12 ocata] at time 18:07:23.280988 duration_in_ms=4317.805
Jan 26 18:07:23 odl01 salt-minion[2105]: [INFO    ] Running state [/etc/apt/apt.conf.d/99proxies-salt-mirantis_openstack] at time 18:07:23.281527
Jan 26 18:07:23 odl01 salt-minion[2105]: [INFO    ] Executing state file.absent for /etc/apt/apt.conf.d/99proxies-salt-mirantis_openstack
Jan 26 18:07:23 odl01 salt-minion[2105]: [INFO    ] File /etc/apt/apt.conf.d/99proxies-salt-mirantis_openstack is not present
Jan 26 18:07:23 odl01 salt-minion[2105]: [INFO    ] Completed state [/etc/apt/apt.conf.d/99proxies-salt-mirantis_openstack] at time 18:07:23.283021 duration_in_ms=1.494
Jan 26 18:07:23 odl01 salt-minion[2105]: [INFO    ] Running state [/etc/apt/preferences.d/mirantis_openstack] at time 18:07:23.283447
Jan 26 18:07:23 odl01 salt-minion[2105]: [INFO    ] Executing state file.managed for /etc/apt/preferences.d/mirantis_openstack
Jan 26 18:07:23 odl01 salt-minion[2105]: [INFO    ] File changed:
Jan 26 18:07:23 odl01 salt-minion[2105]: New file
Jan 26 18:07:23 odl01 salt-minion[2105]: [INFO    ] Completed state [/etc/apt/preferences.d/mirantis_openstack] at time 18:07:23.373969 duration_in_ms=90.521
Jan 26 18:07:23 odl01 salt-minion[2105]: [INFO    ] Running state [deb http://mirror.fuel-infra.org/mcp-repos/ocata/xenial ocata main] at time 18:07:23.374992
Jan 26 18:07:23 odl01 salt-minion[2105]: [INFO    ] Executing state pkgrepo.managed for deb http://mirror.fuel-infra.org/mcp-repos/ocata/xenial ocata main
Jan 26 18:07:23 odl01 salt-minion[2105]: [INFO    ] Executing command ['apt-key', 'add', '/var/cache/salt/minion/extrn_files/base/mirror.fuel-infra.org/mcp-repos/ocata/xenial/archive-mcpocata.key'] in directory '/root'
Jan 26 18:07:24 odl01 salt-minion[2105]: [INFO    ] Executing command ['apt-get', '-q', 'update'] in directory '/root'
Jan 26 18:07:27 odl01 salt-minion[2105]: [INFO    ] {'repo': 'deb http://mirror.fuel-infra.org/mcp-repos/ocata/xenial ocata main'}
Jan 26 18:07:27 odl01 salt-minion[2105]: [INFO    ] Completed state [deb http://mirror.fuel-infra.org/mcp-repos/ocata/xenial ocata main] at time 18:07:27.680858 duration_in_ms=4305.866
Jan 26 18:07:27 odl01 salt-minion[2105]: [INFO    ] Running state [/etc/apt/apt.conf.d/99proxies-salt-uca] at time 18:07:27.681183
Jan 26 18:07:27 odl01 salt-minion[2105]: [INFO    ] Executing state file.absent for /etc/apt/apt.conf.d/99proxies-salt-uca
Jan 26 18:07:27 odl01 salt-minion[2105]: [INFO    ] File /etc/apt/apt.conf.d/99proxies-salt-uca is not present
Jan 26 18:07:27 odl01 salt-minion[2105]: [INFO    ] Completed state [/etc/apt/apt.conf.d/99proxies-salt-uca] at time 18:07:27.682706 duration_in_ms=1.523
Jan 26 18:07:27 odl01 salt-minion[2105]: [INFO    ] Running state [/etc/apt/preferences.d/uca] at time 18:07:27.683126
Jan 26 18:07:27 odl01 salt-minion[2105]: [INFO    ] Executing state file.absent for /etc/apt/preferences.d/uca
Jan 26 18:07:27 odl01 salt-minion[2105]: [INFO    ] File /etc/apt/preferences.d/uca is not present
Jan 26 18:07:27 odl01 salt-minion[2105]: [INFO    ] Completed state [/etc/apt/preferences.d/uca] at time 18:07:27.684380 duration_in_ms=1.255
Jan 26 18:07:27 odl01 salt-minion[2105]: [INFO    ] Running state [deb http://ubuntu-cloud.archive.canonical.com/ubuntu xenial-updates/ocata main] at time 18:07:27.685344
Jan 26 18:07:27 odl01 salt-minion[2105]: [INFO    ] Executing state pkgrepo.managed for deb http://ubuntu-cloud.archive.canonical.com/ubuntu xenial-updates/ocata main
Jan 26 18:07:27 odl01 salt-minion[2105]: [INFO    ] Executing command ['apt-key', 'export', 'EC4926EA'] in directory '/root'
Jan 26 18:07:27 odl01 salt-minion[2105]: [INFO    ] Executing command ['apt-key', 'adv', '--keyserver', 'keyserver.ubuntu.com', '--logger-fd', '1', '--recv-keys', 'EC4926EA'] in directory '/root'
Jan 26 18:07:28 odl01 salt-minion[2105]: [INFO    ] Executing command ['apt-get', '-q', 'update'] in directory '/root'
Jan 26 18:07:31 odl01 salt-minion[2105]: [INFO    ] {'repo': 'deb http://ubuntu-cloud.archive.canonical.com/ubuntu xenial-updates/ocata main'}
Jan 26 18:07:31 odl01 salt-minion[2105]: [INFO    ] Completed state [deb http://ubuntu-cloud.archive.canonical.com/ubuntu xenial-updates/ocata main] at time 18:07:31.912204 duration_in_ms=4226.86
Jan 26 18:07:31 odl01 salt-minion[2105]: [INFO    ] Running state [/etc/apt/apt.conf.d/99proxies-salt-mcp_extra] at time 18:07:31.912517
Jan 26 18:07:31 odl01 salt-minion[2105]: [INFO    ] Executing state file.absent for /etc/apt/apt.conf.d/99proxies-salt-mcp_extra
Jan 26 18:07:31 odl01 salt-minion[2105]: [INFO    ] File /etc/apt/apt.conf.d/99proxies-salt-mcp_extra is not present
Jan 26 18:07:31 odl01 salt-minion[2105]: [INFO    ] Completed state [/etc/apt/apt.conf.d/99proxies-salt-mcp_extra] at time 18:07:31.913422 duration_in_ms=0.905
Jan 26 18:07:31 odl01 salt-minion[2105]: [INFO    ] Running state [/etc/apt/preferences.d/mcp_extra] at time 18:07:31.915043
Jan 26 18:07:31 odl01 salt-minion[2105]: [INFO    ] Executing state file.managed for /etc/apt/preferences.d/mcp_extra
Jan 26 18:07:32 odl01 salt-minion[2105]: [INFO    ] File changed:
Jan 26 18:07:32 odl01 salt-minion[2105]: New file
Jan 26 18:07:32 odl01 salt-minion[2105]: [INFO    ] Completed state [/etc/apt/preferences.d/mcp_extra] at time 18:07:32.006256 duration_in_ms=91.213
Jan 26 18:07:32 odl01 salt-minion[2105]: [INFO    ] Running state [deb [arch=amd64] http://apt.mirantis.com/xenial/ 2017.12 extra] at time 18:07:32.007054
Jan 26 18:07:32 odl01 salt-minion[2105]: [INFO    ] Executing state pkgrepo.managed for deb [arch=amd64] http://apt.mirantis.com/xenial/ 2017.12 extra
Jan 26 18:07:32 odl01 salt-minion[2105]: [INFO    ] Executing command ['apt-key', 'add', '/var/cache/salt/minion/extrn_files/base/apt.mirantis.com/public.gpg'] in directory '/root'
Jan 26 18:07:32 odl01 salt-minion[2105]: [INFO    ] Executing command ['apt-get', '-q', 'update'] in directory '/root'
Jan 26 18:07:32 odl01 salt-minion[2105]: [INFO    ] User sudo_ubuntu Executing command saltutil.find_job with jid 20180126180732781644
Jan 26 18:07:32 odl01 salt-minion[2105]: [INFO    ] Starting a new job with PID 4135
Jan 26 18:07:32 odl01 salt-minion[2105]: [INFO    ] Returning information for job: 20180126180732781644
Jan 26 18:07:36 odl01 salt-minion[2105]: [INFO    ] {'repo': 'deb [arch=amd64] http://apt.mirantis.com/xenial 2017.12 extra'}
Jan 26 18:07:36 odl01 salt-minion[2105]: [INFO    ] Completed state [deb [arch=amd64] http://apt.mirantis.com/xenial/ 2017.12 extra] at time 18:07:36.195749 duration_in_ms=4188.694
Jan 26 18:07:36 odl01 salt-minion[2105]: [INFO    ] Running state [linux_extra_packages_purged] at time 18:07:36.196282
Jan 26 18:07:36 odl01 salt-minion[2105]: [INFO    ] Executing state pkg.purged for linux_extra_packages_purged
Jan 26 18:07:36 odl01 salt-minion[2105]: [INFO    ] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', 'purge', 'cloud-init', 'unattended-upgrades'] in directory '/root'
Jan 26 18:07:36 odl01 systemd[1]: Started /usr/bin/apt-get -q -y purge cloud-init unattended-upgrades.
Jan 26 18:07:36 odl01 systemd[1]: Stopped Apply the settings specified in cloud-config.
Jan 26 18:07:36 odl01 systemd[1]: Stopped target Cloud-config availability.
Jan 26 18:07:36 odl01 systemd[1]: Stopped Execute cloud user/final scripts.
Jan 26 18:07:36 odl01 systemd[1]: Stopped Initial cloud-init job (pre-networking).
Jan 26 18:07:36 odl01 systemd[1]: Stopped Initial cloud-init job (metadata service crawler).
Jan 26 18:07:36 odl01 systemd[1]: Stopped target Cloud-init target.
Jan 26 18:07:36 odl01 systemd[1]: Reloading.
Jan 26 18:07:36 odl01 systemd[1]: Started ACPI event daemon.
Jan 26 18:07:37 odl01 systemd[1]: Reloading.
Jan 26 18:07:37 odl01 systemd[1]: Started ACPI event daemon.
Jan 26 18:07:37 odl01 systemd[1]: Reloading.
Jan 26 18:07:37 odl01 systemd[1]: Started ACPI event daemon.
Jan 26 18:07:37 odl01 systemd[1]: Reloading.
Jan 26 18:07:37 odl01 systemd[1]: Started ACPI event daemon.
Jan 26 18:07:37 odl01 systemd[1]: Reloading.
Jan 26 18:07:37 odl01 systemd[1]: Started ACPI event daemon.
Jan 26 18:07:37 odl01 systemd[1]: Reloading.
Jan 26 18:07:37 odl01 systemd[1]: Started ACPI event daemon.
Jan 26 18:07:37 odl01 systemd[1]: Reloading.
Jan 26 18:07:37 odl01 systemd[1]: Started ACPI event daemon.
Jan 26 18:07:37 odl01 systemd[1]: Stopping Unattended Upgrades Shutdown...
Jan 26 18:07:37 odl01 systemd[1]: Stopped Unattended Upgrades Shutdown.
Jan 26 18:07:37 odl01 systemd[1]: Reloading.
Jan 26 18:07:37 odl01 systemd[1]: Started ACPI event daemon.
Jan 26 18:07:38 odl01 systemd[1]: Reloading.
Jan 26 18:07:38 odl01 systemd[1]: Started ACPI event daemon.
Jan 26 18:07:38 odl01 systemd[1]: Reloading.
Jan 26 18:07:38 odl01 systemd[1]: Started ACPI event daemon.
Jan 26 18:07:38 odl01 systemd[1]: Reloading.
Jan 26 18:07:38 odl01 systemd[1]: Started ACPI event daemon.
Jan 26 18:07:38 odl01 systemd[1]: Reloading.
Jan 26 18:07:38 odl01 systemd[1]: Started ACPI event daemon.
Jan 26 18:07:38 odl01 systemd[1]: Reloading.
Jan 26 18:07:38 odl01 systemd[1]: Started ACPI event daemon.
Jan 26 18:07:38 odl01 systemd[1]: Reloading.
Jan 26 18:07:38 odl01 systemd[1]: Started ACPI event daemon.
Jan 26 18:07:38 odl01 systemd[1]: Reloading.
Jan 26 18:07:38 odl01 systemd[1]: Started ACPI event daemon.
Jan 26 18:07:40 odl01 salt-minion[2105]: [INFO    ] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
Jan 26 18:07:40 odl01 salt-minion[2105]: [INFO    ] {'removed': {}, 'installed': {'cloud-init': {'new': '', 'old': '17.1-46-g7acc9e68-0ubuntu1~16.04.1'}, 'ec2-init': {'new': '', 'old': '1'}, 'unattended-upgrades': {'new': '', 'old': '0.90ubuntu0.9'}}}
Jan 26 18:07:40 odl01 salt-minion[2105]: [INFO    ] Loading fresh modules for state activity
Jan 26 18:07:40 odl01 salt-minion[2105]: [INFO    ] Completed state [linux_extra_packages_purged] at time 18:07:40.219857 duration_in_ms=4023.575
Jan 26 18:07:40 odl01 salt-minion[2105]: [INFO    ] Running state [linux_extra_packages_latest] at time 18:07:40.229021
Jan 26 18:07:40 odl01 salt-minion[2105]: [INFO    ] Executing state pkg.latest for linux_extra_packages_latest
Jan 26 18:07:40 odl01 salt-minion[2105]: [INFO    ] Executing command ['apt-cache', '-q', 'policy', 'mcelog'] in directory '/root'
Jan 26 18:07:40 odl01 salt-minion[2105]: [INFO    ] Executing command ['dpkg', '--get-selections', '*'] in directory '/root'
Jan 26 18:07:40 odl01 salt-minion[2105]: [INFO    ] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'mcelog'] in directory '/root'
Jan 26 18:07:40 odl01 systemd[1]: Started /usr/bin/apt-get -q -y -o DPkg::Options::=--force-confold -o DPkg::Options::=--force-confdef install mcelog.
Jan 26 18:07:41 odl01 systemd[1]: Reloading.
Jan 26 18:07:41 odl01 systemd[1]: Started ACPI event daemon.
Jan 26 18:07:41 odl01 systemd[1]: Reloading.
Jan 26 18:07:41 odl01 systemd[1]: Started ACPI event daemon.
Jan 26 18:07:42 odl01 systemd[1]: Reloading.
Jan 26 18:07:42 odl01 systemd[1]: Started ACPI event daemon.
Jan 26 18:07:42 odl01 systemd[1]: Starting LSB: Machine Check Exceptions (MCE) collector & decoder...
Jan 26 18:07:42 odl01 mcelog: Warning: cpu 0 offline?, imc_log not set#012: No such file or directory
Jan 26 18:07:42 odl01 mcelog: Warning: cpu 1 offline?, imc_log not set#012: No such file or directory
Jan 26 18:07:42 odl01 mcelog: Warning: cpu 2 offline?, imc_log not set#012: No such file or directory
Jan 26 18:07:42 odl01 mcelog[5325]: Starting Machine Check Exceptions decoder: mcelog.
Jan 26 18:07:42 odl01 mcelog: Warning: cpu 3 offline?, imc_log not set#012: No such file or directory
Jan 26 18:07:42 odl01 systemd[1]: Started LSB: Machine Check Exceptions (MCE) collector & decoder.
Jan 26 18:07:42 odl01 systemd[1]: Reloading.
Jan 26 18:07:42 odl01 systemd[1]: Started ACPI event daemon.
Jan 26 18:07:42 odl01 salt-minion[2105]: [INFO    ] User sudo_ubuntu Executing command saltutil.find_job with jid 20180126180742794515
Jan 26 18:07:42 odl01 salt-minion[2105]: [INFO    ] Starting a new job with PID 5380
Jan 26 18:07:42 odl01 salt-minion[2105]: [INFO    ] Returning information for job: 20180126180742794515
Jan 26 18:07:43 odl01 salt-minion[2105]: [INFO    ] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
Jan 26 18:07:43 odl01 salt-minion[2105]: [INFO    ] Made the following changes:
Jan 26 18:07:43 odl01 salt-minion[2105]: 'mcelog' changed from 'absent' to '128+dfsg-1'
Jan 26 18:07:43 odl01 salt-minion[2105]: [INFO    ] Loading fresh modules for state activity
Jan 26 18:07:43 odl01 salt-minion[2105]: [INFO    ] Completed state [linux_extra_packages_latest] at time 18:07:43.414612 duration_in_ms=3185.59
Jan 26 18:07:43 odl01 salt-minion[2105]: [INFO    ] Running state [UTC] at time 18:07:43.418376
Jan 26 18:07:43 odl01 salt-minion[2105]: [INFO    ] Executing state timezone.system for UTC
Jan 26 18:07:43 odl01 salt-minion[2105]: [INFO    ] Executing command ['timedatectl'] in directory '/root'
Jan 26 18:07:43 odl01 dbus[1089]: [system] Activating via systemd: service name='org.freedesktop.timedate1' unit='dbus-org.freedesktop.timedate1.service'
Jan 26 18:07:43 odl01 systemd[1]: Starting Time & Date Service...
Jan 26 18:07:43 odl01 dbus[1089]: [system] Successfully activated service 'org.freedesktop.timedate1'
Jan 26 18:07:43 odl01 systemd[1]: Started Time & Date Service.
Jan 26 18:07:43 odl01 salt-minion[2105]: [INFO    ] Executing command ['timedatectl'] in directory '/root'
Jan 26 18:07:43 odl01 salt-minion[2105]: [INFO    ] Executing command 'timedatectl set-timezone UTC' in directory '/root'
Jan 26 18:07:43 odl01 systemd-timedated[5393]: Changed time zone to 'UTC'.
Jan 26 18:07:43 odl01 salt-minion[2105]: [INFO    ] {'timezone': 'UTC'}
Jan 26 18:07:43 odl01 salt-minion[2105]: [INFO    ] Completed state [UTC] at time 18:07:43.515727 duration_in_ms=97.35
Jan 26 18:07:43 odl01 salt-minion[2105]: [INFO    ] Running state [nf_conntrack] at time 18:07:43.519864
Jan 26 18:07:43 odl01 salt-minion[2105]: [INFO    ] Executing state kmod.present for nf_conntrack
Jan 26 18:07:43 odl01 salt-minion[2105]: [INFO    ] Executing command 'lsmod' in directory '/root'
Jan 26 18:07:43 odl01 salt-minion[2105]: [INFO    ] Executing command 'lsmod' in directory '/root'
Jan 26 18:07:43 odl01 salt-minion[2105]: [INFO    ] Executing command 'modprobe nf_conntrack' in directory '/root'
Jan 26 18:07:43 odl01 salt-minion[2105]: [INFO    ] Executing command 'lsmod' in directory '/root'
Jan 26 18:07:43 odl01 kernel: [  349.153567] nf_conntrack version 0.5.0 (65536 buckets, 262144 max)
Jan 26 18:07:43 odl01 salt-minion[2105]: [INFO    ] {'nf_conntrack': 'loaded'}
Jan 26 18:07:43 odl01 salt-minion[2105]: [INFO    ] Completed state [nf_conntrack] at time 18:07:43.669601 duration_in_ms=149.736
Jan 26 18:07:43 odl01 salt-minion[2105]: [INFO    ] Running state [kernel.panic] at time 18:07:43.672455
Jan 26 18:07:43 odl01 salt-minion[2105]: [INFO    ] Executing state sysctl.present for kernel.panic
Jan 26 18:07:43 odl01 salt-minion[2105]: [INFO    ] Executing command 'sysctl -a' in directory '/root'
Jan 26 18:07:43 odl01 systemd[1]: proc-sys-fs-binfmt_misc.automount: Got automount request for /proc/sys/fs/binfmt_misc, triggered by 5430 (sysctl)
Jan 26 18:07:43 odl01 systemd[1]: Mounting Arbitrary Executable File Formats File System...
Jan 26 18:07:43 odl01 systemd[1]: Mounted Arbitrary Executable File Formats File System.
Jan 26 18:07:43 odl01 kernel: [  349.228993] sysctl_ibrs_enabled = 0, sysctl_ibpb_enabled = 0
Jan 26 18:07:43 odl01 kernel: [  349.228997] use_ibrs = 0, use_ibpb = 4
Jan 26 18:07:43 odl01 kernel: [  349.228998] read cpu 0 ibrs val 0
Jan 26 18:07:43 odl01 kernel: [  349.228999] read cpu 1 ibrs val 0
Jan 26 18:07:43 odl01 kernel: [  349.229000] read cpu 2 ibrs val 0
Jan 26 18:07:43 odl01 kernel: [  349.229001] read cpu 3 ibrs val 0
Jan 26 18:07:43 odl01 kernel: [  349.229003] sysctl_ibrs_enabled = 0, sysctl_ibpb_enabled = 0
Jan 26 18:07:43 odl01 kernel: [  349.229004] use_ibrs = 0, use_ibpb = 4
Jan 26 18:07:43 odl01 kernel: [  349.229004] read cpu 0 ibrs val 0
Jan 26 18:07:43 odl01 kernel: [  349.229005] read cpu 1 ibrs val 0
Jan 26 18:07:43 odl01 kernel: [  349.229006] read cpu 2 ibrs val 0
Jan 26 18:07:43 odl01 kernel: [  349.229007] read cpu 3 ibrs val 0
Jan 26 18:07:43 odl01 kernel: [  349.242096] nr_pdflush_threads exported in /proc is scheduled for removal
Jan 26 18:07:43 odl01 salt-minion[2105]: [INFO    ] Executing command 'sysctl -w kernel.panic="60"' in directory '/root'
Jan 26 18:07:43 odl01 salt-minion[2105]: [INFO    ] {'kernel.panic': 60}
Jan 26 18:07:43 odl01 salt-minion[2105]: [INFO    ] Completed state [kernel.panic] at time 18:07:43.734256 duration_in_ms=61.8
Jan 26 18:07:43 odl01 salt-minion[2105]: [INFO    ] Running state [net.ipv4.tcp_keepalive_probes] at time 18:07:43.734808
Jan 26 18:07:43 odl01 salt-minion[2105]: [INFO    ] Executing state sysctl.present for net.ipv4.tcp_keepalive_probes
Jan 26 18:07:43 odl01 salt-minion[2105]: [INFO    ] Executing command 'sysctl -a' in directory '/root'
Jan 26 18:07:43 odl01 kernel: [  349.267616] sysctl_ibrs_enabled = 0, sysctl_ibpb_enabled = 0
Jan 26 18:07:43 odl01 kernel: [  349.267619] use_ibrs = 4, use_ibpb = 4
Jan 26 18:07:43 odl01 kernel: [  349.267620] read cpu 0 ibrs val 0
Jan 26 18:07:43 odl01 kernel: [  349.267621] read cpu 1 ibrs val 0
Jan 26 18:07:43 odl01 kernel: [  349.267622] read cpu 2 ibrs val 0
Jan 26 18:07:43 odl01 kernel: [  349.267623] read cpu 3 ibrs val 0
Jan 26 18:07:43 odl01 kernel: [  349.267625] sysctl_ibrs_enabled = 0, sysctl_ibpb_enabled = 0
Jan 26 18:07:43 odl01 kernel: [  349.267626] use_ibrs = 4, use_ibpb = 4
Jan 26 18:07:43 odl01 kernel: [  349.267627] read cpu 0 ibrs val 0
Jan 26 18:07:43 odl01 kernel: [  349.267627] read cpu 1 ibrs val 0
Jan 26 18:07:43 odl01 kernel: [  349.267628] read cpu 2 ibrs val 0
Jan 26 18:07:43 odl01 kernel: [  349.267629] read cpu 3 ibrs val 0
Jan 26 18:07:43 odl01 salt-minion[2105]: [INFO    ] Executing command 'sysctl -w net.ipv4.tcp_keepalive_probes="8"' in directory '/root'
Jan 26 18:07:43 odl01 salt-minion[2105]: [INFO    ] {'net.ipv4.tcp_keepalive_probes': 8}
Jan 26 18:07:43 odl01 salt-minion[2105]: [INFO    ] Completed state [net.ipv4.tcp_keepalive_probes] at time 18:07:43.774116 duration_in_ms=39.308
Jan 26 18:07:43 odl01 salt-minion[2105]: [INFO    ] Running state [fs.file-max] at time 18:07:43.774742
Jan 26 18:07:43 odl01 salt-minion[2105]: [INFO    ] Executing state sysctl.present for fs.file-max
Jan 26 18:07:43 odl01 salt-minion[2105]: [INFO    ] Executing command 'sysctl -a' in directory '/root'
Jan 26 18:07:43 odl01 kernel: [  349.308202] sysctl_ibrs_enabled = 0, sysctl_ibpb_enabled = 0
Jan 26 18:07:43 odl01 kernel: [  349.308206] use_ibrs = 4, use_ibpb = 4
Jan 26 18:07:43 odl01 kernel: [  349.308207] read cpu 0 ibrs val 0
Jan 26 18:07:43 odl01 kernel: [  349.308208] read cpu 1 ibrs val 0
Jan 26 18:07:43 odl01 kernel: [  349.308209] read cpu 2 ibrs val 0
Jan 26 18:07:43 odl01 kernel: [  349.308209] read cpu 3 ibrs val 0
Jan 26 18:07:43 odl01 kernel: [  349.308211] sysctl_ibrs_enabled = 0, sysctl_ibpb_enabled = 0
Jan 26 18:07:43 odl01 kernel: [  349.308212] use_ibrs = 4, use_ibpb = 4
Jan 26 18:07:43 odl01 kernel: [  349.308213] read cpu 0 ibrs val 0
Jan 26 18:07:43 odl01 kernel: [  349.308214] read cpu 1 ibrs val 0
Jan 26 18:07:43 odl01 kernel: [  349.308215] read cpu 2 ibrs val 0
Jan 26 18:07:43 odl01 kernel: [  349.308216] read cpu 3 ibrs val 0
Jan 26 18:07:43 odl01 salt-minion[2105]: [INFO    ] Executing command 'sysctl -w fs.file-max="124165"' in directory '/root'
Jan 26 18:07:43 odl01 salt-minion[2105]: [INFO    ] {'fs.file-max': 124165}
Jan 26 18:07:43 odl01 salt-minion[2105]: [INFO    ] Completed state [fs.file-max] at time 18:07:43.813066 duration_in_ms=38.324
Jan 26 18:07:43 odl01 salt-minion[2105]: [INFO    ] Running state [net.core.somaxconn] at time 18:07:43.813584
Jan 26 18:07:43 odl01 salt-minion[2105]: [INFO    ] Executing state sysctl.present for net.core.somaxconn
Jan 26 18:07:43 odl01 salt-minion[2105]: [INFO    ] Executing command 'sysctl -a' in directory '/root'
Jan 26 18:07:43 odl01 kernel: [  349.348395] sysctl_ibrs_enabled = 0, sysctl_ibpb_enabled = 0
Jan 26 18:07:43 odl01 kernel: [  349.348399] use_ibrs = 4, use_ibpb = 4
Jan 26 18:07:43 odl01 kernel: [  349.348400] read cpu 0 ibrs val 0
Jan 26 18:07:43 odl01 kernel: [  349.348401] read cpu 1 ibrs val 0
Jan 26 18:07:43 odl01 kernel: [  349.348401] read cpu 2 ibrs val 0
Jan 26 18:07:43 odl01 kernel: [  349.348402] read cpu 3 ibrs val 0
Jan 26 18:07:43 odl01 kernel: [  349.348404] sysctl_ibrs_enabled = 0, sysctl_ibpb_enabled = 0
Jan 26 18:07:43 odl01 kernel: [  349.348405] use_ibrs = 4, use_ibpb = 4
Jan 26 18:07:43 odl01 kernel: [  349.348406] read cpu 0 ibrs val 0
Jan 26 18:07:43 odl01 kernel: [  349.348407] read cpu 1 ibrs val 0
Jan 26 18:07:43 odl01 kernel: [  349.348408] read cpu 2 ibrs val 0
Jan 26 18:07:43 odl01 kernel: [  349.348408] read cpu 3 ibrs val 0
Jan 26 18:07:43 odl01 salt-minion[2105]: [INFO    ] Executing command 'sysctl -w net.core.somaxconn="4096"' in directory '/root'
Jan 26 18:07:43 odl01 salt-minion[2105]: [INFO    ] {'net.core.somaxconn': 4096}
Jan 26 18:07:43 odl01 salt-minion[2105]: [INFO    ] Completed state [net.core.somaxconn] at time 18:07:43.857176 duration_in_ms=43.591
Jan 26 18:07:43 odl01 salt-minion[2105]: [INFO    ] Running state [net.ipv4.tcp_max_syn_backlog] at time 18:07:43.858015
Jan 26 18:07:43 odl01 salt-minion[2105]: [INFO    ] Executing state sysctl.present for net.ipv4.tcp_max_syn_backlog
Jan 26 18:07:43 odl01 salt-minion[2105]: [INFO    ] Executing command 'sysctl -a' in directory '/root'
Jan 26 18:07:43 odl01 kernel: [  349.392559] sysctl_ibrs_enabled = 0, sysctl_ibpb_enabled = 0
Jan 26 18:07:43 odl01 kernel: [  349.392563] use_ibrs = 4, use_ibpb = 4
Jan 26 18:07:43 odl01 kernel: [  349.392564] read cpu 0 ibrs val 0
Jan 26 18:07:43 odl01 kernel: [  349.392565] read cpu 1 ibrs val 0
Jan 26 18:07:43 odl01 kernel: [  349.392566] read cpu 2 ibrs val 0
Jan 26 18:07:43 odl01 kernel: [  349.392566] read cpu 3 ibrs val 0
Jan 26 18:07:43 odl01 kernel: [  349.392568] sysctl_ibrs_enabled = 0, sysctl_ibpb_enabled = 0
Jan 26 18:07:43 odl01 kernel: [  349.392569] use_ibrs = 4, use_ibpb = 4
Jan 26 18:07:43 odl01 kernel: [  349.392570] read cpu 0 ibrs val 0
Jan 26 18:07:43 odl01 kernel: [  349.392571] read cpu 1 ibrs val 0
Jan 26 18:07:43 odl01 kernel: [  349.392572] read cpu 2 ibrs val 0
Jan 26 18:07:43 odl01 kernel: [  349.392572] read cpu 3 ibrs val 0
Jan 26 18:07:43 odl01 salt-minion[2105]: [INFO    ] Executing command 'sysctl -w net.ipv4.tcp_max_syn_backlog="8192"' in directory '/root'
Jan 26 18:07:43 odl01 salt-minion[2105]: [INFO    ] {'net.ipv4.tcp_max_syn_backlog': 8192}
Jan 26 18:07:43 odl01 salt-minion[2105]: [INFO    ] Completed state [net.ipv4.tcp_max_syn_backlog] at time 18:07:43.897145 duration_in_ms=39.129
Jan 26 18:07:43 odl01 salt-minion[2105]: [INFO    ] Running state [net.ipv4.tcp_tw_reuse] at time 18:07:43.898248
Jan 26 18:07:43 odl01 salt-minion[2105]: [INFO    ] Executing state sysctl.present for net.ipv4.tcp_tw_reuse
Jan 26 18:07:43 odl01 salt-minion[2105]: [INFO    ] Executing command 'sysctl -a' in directory '/root'
Jan 26 18:07:43 odl01 kernel: [  349.432263] sysctl_ibrs_enabled = 0, sysctl_ibpb_enabled = 0
Jan 26 18:07:43 odl01 kernel: [  349.432266] use_ibrs = 4, use_ibpb = 4
Jan 26 18:07:43 odl01 kernel: [  349.432267] read cpu 0 ibrs val 0
Jan 26 18:07:43 odl01 kernel: [  349.432268] read cpu 1 ibrs val 0
Jan 26 18:07:43 odl01 kernel: [  349.432269] read cpu 2 ibrs val 0
Jan 26 18:07:43 odl01 kernel: [  349.432270] read cpu 3 ibrs val 0
Jan 26 18:07:43 odl01 kernel: [  349.432272] sysctl_ibrs_enabled = 0, sysctl_ibpb_enabled = 0
Jan 26 18:07:43 odl01 kernel: [  349.432273] use_ibrs = 4, use_ibpb = 4
Jan 26 18:07:43 odl01 kernel: [  349.432274] read cpu 0 ibrs val 0
Jan 26 18:07:43 odl01 kernel: [  349.432275] read cpu 1 ibrs val 0
Jan 26 18:07:43 odl01 kernel: [  349.432275] read cpu 2 ibrs val 0
Jan 26 18:07:43 odl01 kernel: [  349.432276] read cpu 3 ibrs val 0
Jan 26 18:07:43 odl01 salt-minion[2105]: [INFO    ] Executing command 'sysctl -w net.ipv4.tcp_tw_reuse="1"' in directory '/root'
Jan 26 18:07:43 odl01 salt-minion[2105]: [INFO    ] {'net.ipv4.tcp_tw_reuse': 1}
Jan 26 18:07:43 odl01 salt-minion[2105]: [INFO    ] Completed state [net.ipv4.tcp_tw_reuse] at time 18:07:43.939950 duration_in_ms=41.701
Jan 26 18:07:43 odl01 salt-minion[2105]: [INFO    ] Running state [net.ipv4.tcp_congestion_control] at time 18:07:43.940707
Jan 26 18:07:43 odl01 salt-minion[2105]: [INFO    ] Executing state sysctl.present for net.ipv4.tcp_congestion_control
Jan 26 18:07:43 odl01 salt-minion[2105]: [INFO    ] Executing command 'sysctl -a' in directory '/root'
Jan 26 18:07:43 odl01 kernel: [  349.475992] sysctl_ibrs_enabled = 0, sysctl_ibpb_enabled = 0
Jan 26 18:07:43 odl01 kernel: [  349.475994] use_ibrs = 4, use_ibpb = 4
Jan 26 18:07:43 odl01 kernel: [  349.475996] read cpu 0 ibrs val 0
Jan 26 18:07:43 odl01 kernel: [  349.475996] read cpu 1 ibrs val 0
Jan 26 18:07:43 odl01 kernel: [  349.475997] read cpu 2 ibrs val 0
Jan 26 18:07:43 odl01 kernel: [  349.475998] read cpu 3 ibrs val 0
Jan 26 18:07:43 odl01 kernel: [  349.476000] sysctl_ibrs_enabled = 0, sysctl_ibpb_enabled = 0
Jan 26 18:07:43 odl01 kernel: [  349.476001] use_ibrs = 4, use_ibpb = 4
Jan 26 18:07:43 odl01 kernel: [  349.476002] read cpu 0 ibrs val 0
Jan 26 18:07:43 odl01 kernel: [  349.476002] read cpu 1 ibrs val 0
Jan 26 18:07:43 odl01 kernel: [  349.476003] read cpu 2 ibrs val 0
Jan 26 18:07:43 odl01 kernel: [  349.476004] read cpu 3 ibrs val 0
Jan 26 18:07:43 odl01 salt-minion[2105]: [INFO    ] Executing command 'sysctl -w net.ipv4.tcp_congestion_control="yeah"' in directory '/root'
Jan 26 18:07:43 odl01 salt-minion[2105]: [INFO    ] {'net.ipv4.tcp_congestion_control': 'yeah'}
Jan 26 18:07:43 odl01 salt-minion[2105]: [INFO    ] Completed state [net.ipv4.tcp_congestion_control] at time 18:07:43.988241 duration_in_ms=47.533
Jan 26 18:07:43 odl01 salt-minion[2105]: [INFO    ] Running state [net.ipv4.tcp_retries2] at time 18:07:43.988597
Jan 26 18:07:43 odl01 salt-minion[2105]: [INFO    ] Executing state sysctl.present for net.ipv4.tcp_retries2
Jan 26 18:07:43 odl01 salt-minion[2105]: [INFO    ] Executing command 'sysctl -a' in directory '/root'
Jan 26 18:07:44 odl01 kernel: [  349.524878] sysctl_ibrs_enabled = 0, sysctl_ibpb_enabled = 0
Jan 26 18:07:44 odl01 kernel: [  349.524882] use_ibrs = 4, use_ibpb = 4
Jan 26 18:07:44 odl01 kernel: [  349.524883] read cpu 0 ibrs val 0
Jan 26 18:07:44 odl01 kernel: [  349.524885] read cpu 1 ibrs val 0
Jan 26 18:07:44 odl01 kernel: [  349.524886] read cpu 2 ibrs val 0
Jan 26 18:07:44 odl01 kernel: [  349.524887] read cpu 3 ibrs val 0
Jan 26 18:07:44 odl01 kernel: [  349.524890] sysctl_ibrs_enabled = 0, sysctl_ibpb_enabled = 0
Jan 26 18:07:44 odl01 kernel: [  349.524891] use_ibrs = 4, use_ibpb = 4
Jan 26 18:07:44 odl01 kernel: [  349.524892] read cpu 0 ibrs val 0
Jan 26 18:07:44 odl01 kernel: [  349.524893] read cpu 1 ibrs val 0
Jan 26 18:07:44 odl01 kernel: [  349.524894] read cpu 2 ibrs val 0
Jan 26 18:07:44 odl01 kernel: [  349.524895] read cpu 3 ibrs val 0
Jan 26 18:07:44 odl01 salt-minion[2105]: [INFO    ] Executing command 'sysctl -w net.ipv4.tcp_retries2="5"' in directory '/root'
Jan 26 18:07:44 odl01 salt-minion[2105]: [INFO    ] {'net.ipv4.tcp_retries2': 5}
Jan 26 18:07:44 odl01 salt-minion[2105]: [INFO    ] Completed state [net.ipv4.tcp_retries2] at time 18:07:44.037314 duration_in_ms=48.716
Jan 26 18:07:44 odl01 salt-minion[2105]: [INFO    ] Running state [net.ipv4.tcp_fin_timeout] at time 18:07:44.038409
Jan 26 18:07:44 odl01 salt-minion[2105]: [INFO    ] Executing state sysctl.present for net.ipv4.tcp_fin_timeout
Jan 26 18:07:44 odl01 salt-minion[2105]: [INFO    ] Executing command 'sysctl -a' in directory '/root'
Jan 26 18:07:44 odl01 kernel: [  349.572294] sysctl_ibrs_enabled = 0, sysctl_ibpb_enabled = 0
Jan 26 18:07:44 odl01 kernel: [  349.572297] use_ibrs = 4, use_ibpb = 4
Jan 26 18:07:44 odl01 kernel: [  349.572298] read cpu 0 ibrs val 0
Jan 26 18:07:44 odl01 kernel: [  349.572299] read cpu 1 ibrs val 0
Jan 26 18:07:44 odl01 kernel: [  349.572300] read cpu 2 ibrs val 0
Jan 26 18:07:44 odl01 kernel: [  349.572300] read cpu 3 ibrs val 0
Jan 26 18:07:44 odl01 kernel: [  349.572302] sysctl_ibrs_enabled = 0, sysctl_ibpb_enabled = 0
Jan 26 18:07:44 odl01 kernel: [  349.572303] use_ibrs = 4, use_ibpb = 4
Jan 26 18:07:44 odl01 kernel: [  349.572304] read cpu 0 ibrs val 0
Jan 26 18:07:44 odl01 kernel: [  349.572305] read cpu 1 ibrs val 0
Jan 26 18:07:44 odl01 kernel: [  349.572306] read cpu 2 ibrs val 0
Jan 26 18:07:44 odl01 kernel: [  349.572306] read cpu 3 ibrs val 0
Jan 26 18:07:44 odl01 salt-minion[2105]: [INFO    ] Executing command 'sysctl -w net.ipv4.tcp_fin_timeout="30"' in directory '/root'
Jan 26 18:07:44 odl01 salt-minion[2105]: [INFO    ] {'net.ipv4.tcp_fin_timeout': 30}
Jan 26 18:07:44 odl01 salt-minion[2105]: [INFO    ] Completed state [net.ipv4.tcp_fin_timeout] at time 18:07:44.078175 duration_in_ms=39.766
Jan 26 18:07:44 odl01 salt-minion[2105]: [INFO    ] Running state [net.ipv4.tcp_slow_start_after_idle] at time 18:07:44.078853
Jan 26 18:07:44 odl01 salt-minion[2105]: [INFO    ] Executing state sysctl.present for net.ipv4.tcp_slow_start_after_idle
Jan 26 18:07:44 odl01 salt-minion[2105]: [INFO    ] Executing command 'sysctl -a' in directory '/root'
Jan 26 18:07:44 odl01 kernel: [  349.612700] sysctl_ibrs_enabled = 0, sysctl_ibpb_enabled = 0
Jan 26 18:07:44 odl01 kernel: [  349.612702] use_ibrs = 4, use_ibpb = 4
Jan 26 18:07:44 odl01 kernel: [  349.612704] read cpu 0 ibrs val 0
Jan 26 18:07:44 odl01 kernel: [  349.612704] read cpu 1 ibrs val 0
Jan 26 18:07:44 odl01 kernel: [  349.612705] read cpu 2 ibrs val 0
Jan 26 18:07:44 odl01 kernel: [  349.612706] read cpu 3 ibrs val 0
Jan 26 18:07:44 odl01 kernel: [  349.612708] sysctl_ibrs_enabled = 0, sysctl_ibpb_enabled = 0
Jan 26 18:07:44 odl01 kernel: [  349.612709] use_ibrs = 4, use_ibpb = 4
Jan 26 18:07:44 odl01 kernel: [  349.612710] read cpu 0 ibrs val 0
Jan 26 18:07:44 odl01 kernel: [  349.612711] read cpu 1 ibrs val 0
Jan 26 18:07:44 odl01 kernel: [  349.612711] read cpu 2 ibrs val 0
Jan 26 18:07:44 odl01 kernel: [  349.612712] read cpu 3 ibrs val 0
Jan 26 18:07:44 odl01 salt-minion[2105]: [INFO    ] Executing command 'sysctl -w net.ipv4.tcp_slow_start_after_idle="0"' in directory '/root'
Jan 26 18:07:44 odl01 salt-minion[2105]: [INFO    ] {'net.ipv4.tcp_slow_start_after_idle': 0}
Jan 26 18:07:44 odl01 salt-minion[2105]: [INFO    ] Completed state [net.ipv4.tcp_slow_start_after_idle] at time 18:07:44.116481 duration_in_ms=37.628
Jan 26 18:07:44 odl01 salt-minion[2105]: [INFO    ] Running state [vm.swappiness] at time 18:07:44.116980
Jan 26 18:07:44 odl01 salt-minion[2105]: [INFO    ] Executing state sysctl.present for vm.swappiness
Jan 26 18:07:44 odl01 salt-minion[2105]: [INFO    ] Executing command 'sysctl -a' in directory '/root'
Jan 26 18:07:44 odl01 kernel: [  349.654873] sysctl_ibrs_enabled = 0, sysctl_ibpb_enabled = 0
Jan 26 18:07:44 odl01 kernel: [  349.654878] use_ibrs = 4, use_ibpb = 4
Jan 26 18:07:44 odl01 kernel: [  349.654880] read cpu 0 ibrs val 0
Jan 26 18:07:44 odl01 kernel: [  349.654882] read cpu 1 ibrs val 0
Jan 26 18:07:44 odl01 kernel: [  349.654884] read cpu 2 ibrs val 0
Jan 26 18:07:44 odl01 kernel: [  349.654886] read cpu 3 ibrs val 0
Jan 26 18:07:44 odl01 kernel: [  349.654890] sysctl_ibrs_enabled = 0, sysctl_ibpb_enabled = 0
Jan 26 18:07:44 odl01 kernel: [  349.654892] use_ibrs = 4, use_ibpb = 4
Jan 26 18:07:44 odl01 kernel: [  349.654894] read cpu 0 ibrs val 0
Jan 26 18:07:44 odl01 kernel: [  349.654895] read cpu 1 ibrs val 0
Jan 26 18:07:44 odl01 kernel: [  349.654897] read cpu 2 ibrs val 0
Jan 26 18:07:44 odl01 kernel: [  349.654899] read cpu 3 ibrs val 0
Jan 26 18:07:44 odl01 salt-minion[2105]: [INFO    ] Executing command 'sysctl -w vm.swappiness="10"' in directory '/root'
Jan 26 18:07:44 odl01 salt-minion[2105]: [INFO    ] {'vm.swappiness': 10}
Jan 26 18:07:44 odl01 salt-minion[2105]: [INFO    ] Completed state [vm.swappiness] at time 18:07:44.163010 duration_in_ms=46.03
Jan 26 18:07:44 odl01 salt-minion[2105]: [INFO    ] Running state [net.ipv4.tcp_keepalive_intvl] at time 18:07:44.163527
Jan 26 18:07:44 odl01 salt-minion[2105]: [INFO    ] Executing state sysctl.present for net.ipv4.tcp_keepalive_intvl
Jan 26 18:07:44 odl01 salt-minion[2105]: [INFO    ] Executing command 'sysctl -a' in directory '/root'
Jan 26 18:07:44 odl01 kernel: [  349.697145] sysctl_ibrs_enabled = 0, sysctl_ibpb_enabled = 0
Jan 26 18:07:44 odl01 kernel: [  349.697148] use_ibrs = 4, use_ibpb = 4
Jan 26 18:07:44 odl01 kernel: [  349.697149] read cpu 0 ibrs val 0
Jan 26 18:07:44 odl01 kernel: [  349.697150] read cpu 1 ibrs val 0
Jan 26 18:07:44 odl01 kernel: [  349.697151] read cpu 2 ibrs val 0
Jan 26 18:07:44 odl01 kernel: [  349.697152] read cpu 3 ibrs val 0
Jan 26 18:07:44 odl01 kernel: [  349.697154] sysctl_ibrs_enabled = 0, sysctl_ibpb_enabled = 0
Jan 26 18:07:44 odl01 kernel: [  349.697155] use_ibrs = 4, use_ibpb = 4
Jan 26 18:07:44 odl01 kernel: [  349.697156] read cpu 0 ibrs val 0
Jan 26 18:07:44 odl01 kernel: [  349.697157] read cpu 1 ibrs val 0
Jan 26 18:07:44 odl01 kernel: [  349.697157] read cpu 2 ibrs val 0
Jan 26 18:07:44 odl01 kernel: [  349.697158] read cpu 3 ibrs val 0
Jan 26 18:07:44 odl01 salt-minion[2105]: [INFO    ] Executing command 'sysctl -w net.ipv4.tcp_keepalive_intvl="3"' in directory '/root'
Jan 26 18:07:44 odl01 salt-minion[2105]: [INFO    ] {'net.ipv4.tcp_keepalive_intvl': 3}
Jan 26 18:07:44 odl01 salt-minion[2105]: [INFO    ] Completed state [net.ipv4.tcp_keepalive_intvl] at time 18:07:44.200497 duration_in_ms=36.971
Jan 26 18:07:44 odl01 salt-minion[2105]: [INFO    ] Running state [net.ipv4.neigh.default.gc_thresh1] at time 18:07:44.201010
Jan 26 18:07:44 odl01 salt-minion[2105]: [INFO    ] Executing state sysctl.present for net.ipv4.neigh.default.gc_thresh1
Jan 26 18:07:44 odl01 salt-minion[2105]: [INFO    ] Executing command 'sysctl -a' in directory '/root'
Jan 26 18:07:44 odl01 kernel: [  349.734800] sysctl_ibrs_enabled = 0, sysctl_ibpb_enabled = 0
Jan 26 18:07:44 odl01 kernel: [  349.734803] use_ibrs = 4, use_ibpb = 4
Jan 26 18:07:44 odl01 kernel: [  349.734804] read cpu 0 ibrs val 0
Jan 26 18:07:44 odl01 kernel: [  349.734805] read cpu 1 ibrs val 0
Jan 26 18:07:44 odl01 kernel: [  349.734806] read cpu 2 ibrs val 0
Jan 26 18:07:44 odl01 kernel: [  349.734806] read cpu 3 ibrs val 0
Jan 26 18:07:44 odl01 kernel: [  349.734808] sysctl_ibrs_enabled = 0, sysctl_ibpb_enabled = 0
Jan 26 18:07:44 odl01 kernel: [  349.734809] use_ibrs = 4, use_ibpb = 4
Jan 26 18:07:44 odl01 kernel: [  349.734810] read cpu 0 ibrs val 0
Jan 26 18:07:44 odl01 kernel: [  349.734811] read cpu 1 ibrs val 0
Jan 26 18:07:44 odl01 kernel: [  349.734812] read cpu 2 ibrs val 0
Jan 26 18:07:44 odl01 kernel: [  349.734812] read cpu 3 ibrs val 0
Jan 26 18:07:44 odl01 salt-minion[2105]: [INFO    ] Executing command 'sysctl -w net.ipv4.neigh.default.gc_thresh1="4096"' in directory '/root'
Jan 26 18:07:44 odl01 salt-minion[2105]: [INFO    ] {'net.ipv4.neigh.default.gc_thresh1': 4096}
Jan 26 18:07:44 odl01 salt-minion[2105]: [INFO    ] Completed state [net.ipv4.neigh.default.gc_thresh1] at time 18:07:44.241404 duration_in_ms=40.393
Jan 26 18:07:44 odl01 salt-minion[2105]: [INFO    ] Running state [net.ipv4.neigh.default.gc_thresh2] at time 18:07:44.242376
Jan 26 18:07:44 odl01 salt-minion[2105]: [INFO    ] Executing state sysctl.present for net.ipv4.neigh.default.gc_thresh2
Jan 26 18:07:44 odl01 salt-minion[2105]: [INFO    ] Executing command 'sysctl -a' in directory '/root'
Jan 26 18:07:44 odl01 kernel: [  349.777389] sysctl_ibrs_enabled = 0, sysctl_ibpb_enabled = 0
Jan 26 18:07:44 odl01 kernel: [  349.777393] use_ibrs = 4, use_ibpb = 4
Jan 26 18:07:44 odl01 kernel: [  349.777394] read cpu 0 ibrs val 0
Jan 26 18:07:44 odl01 kernel: [  349.777395] read cpu 1 ibrs val 0
Jan 26 18:07:44 odl01 kernel: [  349.777396] read cpu 2 ibrs val 0
Jan 26 18:07:44 odl01 kernel: [  349.777397] read cpu 3 ibrs val 0
Jan 26 18:07:44 odl01 kernel: [  349.777399] sysctl_ibrs_enabled = 0, sysctl_ibpb_enabled = 0
Jan 26 18:07:44 odl01 kernel: [  349.777400] use_ibrs = 4, use_ibpb = 4
Jan 26 18:07:44 odl01 kernel: [  349.777400] read cpu 0 ibrs val 0
Jan 26 18:07:44 odl01 kernel: [  349.777401] read cpu 1 ibrs val 0
Jan 26 18:07:44 odl01 kernel: [  349.777402] read cpu 2 ibrs val 0
Jan 26 18:07:44 odl01 kernel: [  349.777403] read cpu 3 ibrs val 0
Jan 26 18:07:44 odl01 salt-minion[2105]: [INFO    ] Executing command 'sysctl -w net.ipv4.neigh.default.gc_thresh2="8192"' in directory '/root'
Jan 26 18:07:44 odl01 salt-minion[2105]: [INFO    ] {'net.ipv4.neigh.default.gc_thresh2': 8192}
Jan 26 18:07:44 odl01 salt-minion[2105]: [INFO    ] Completed state [net.ipv4.neigh.default.gc_thresh2] at time 18:07:44.285418 duration_in_ms=43.042
Jan 26 18:07:44 odl01 salt-minion[2105]: [INFO    ] Running state [net.ipv4.neigh.default.gc_thresh3] at time 18:07:44.287436
Jan 26 18:07:44 odl01 salt-minion[2105]: [INFO    ] Executing state sysctl.present for net.ipv4.neigh.default.gc_thresh3
Jan 26 18:07:44 odl01 salt-minion[2105]: [INFO    ] Executing command 'sysctl -a' in directory '/root'
Jan 26 18:07:44 odl01 kernel: [  349.822890] sysctl_ibrs_enabled = 0, sysctl_ibpb_enabled = 0
Jan 26 18:07:44 odl01 kernel: [  349.822893] use_ibrs = 4, use_ibpb = 4
Jan 26 18:07:44 odl01 kernel: [  349.822894] read cpu 0 ibrs val 0
Jan 26 18:07:44 odl01 kernel: [  349.822895] read cpu 1 ibrs val 0
Jan 26 18:07:44 odl01 kernel: [  349.822896] read cpu 2 ibrs val 0
Jan 26 18:07:44 odl01 kernel: [  349.822896] read cpu 3 ibrs val 0
Jan 26 18:07:44 odl01 kernel: [  349.822898] sysctl_ibrs_enabled = 0, sysctl_ibpb_enabled = 0
Jan 26 18:07:44 odl01 kernel: [  349.822899] use_ibrs = 4, use_ibpb = 4
Jan 26 18:07:44 odl01 kernel: [  349.822900] read cpu 0 ibrs val 0
Jan 26 18:07:44 odl01 kernel: [  349.822901] read cpu 1 ibrs val 0
Jan 26 18:07:44 odl01 kernel: [  349.822902] read cpu 2 ibrs val 0
Jan 26 18:07:44 odl01 kernel: [  349.822903] read cpu 3 ibrs val 0
Jan 26 18:07:44 odl01 salt-minion[2105]: [INFO    ] Executing command 'sysctl -w net.ipv4.neigh.default.gc_thresh3="16384"' in directory '/root'
Jan 26 18:07:44 odl01 salt-minion[2105]: [INFO    ] {'net.ipv4.neigh.default.gc_thresh3': 16384}
Jan 26 18:07:44 odl01 salt-minion[2105]: [INFO    ] Completed state [net.ipv4.neigh.default.gc_thresh3] at time 18:07:44.330550 duration_in_ms=43.113
Jan 26 18:07:44 odl01 salt-minion[2105]: [INFO    ] Running state [net.core.netdev_max_backlog] at time 18:07:44.330884
Jan 26 18:07:44 odl01 salt-minion[2105]: [INFO    ] Executing state sysctl.present for net.core.netdev_max_backlog
Jan 26 18:07:44 odl01 salt-minion[2105]: [INFO    ] Executing command 'sysctl -a' in directory '/root'
Jan 26 18:07:44 odl01 kernel: [  349.863648] sysctl_ibrs_enabled = 0, sysctl_ibpb_enabled = 0
Jan 26 18:07:44 odl01 kernel: [  349.863651] use_ibrs = 4, use_ibpb = 4
Jan 26 18:07:44 odl01 kernel: [  349.863652] read cpu 0 ibrs val 0
Jan 26 18:07:44 odl01 kernel: [  349.863653] read cpu 1 ibrs val 0
Jan 26 18:07:44 odl01 kernel: [  349.863654] read cpu 2 ibrs val 0
Jan 26 18:07:44 odl01 kernel: [  349.863655] read cpu 3 ibrs val 0
Jan 26 18:07:44 odl01 kernel: [  349.863657] sysctl_ibrs_enabled = 0, sysctl_ibpb_enabled = 0
Jan 26 18:07:44 odl01 kernel: [  349.863658] use_ibrs = 4, use_ibpb = 4
Jan 26 18:07:44 odl01 kernel: [  349.863659] read cpu 0 ibrs val 0
Jan 26 18:07:44 odl01 kernel: [  349.863659] read cpu 1 ibrs val 0
Jan 26 18:07:44 odl01 kernel: [  349.863660] read cpu 2 ibrs val 0
Jan 26 18:07:44 odl01 kernel: [  349.863661] read cpu 3 ibrs val 0
Jan 26 18:07:44 odl01 salt-minion[2105]: [INFO    ] Executing command 'sysctl -w net.core.netdev_max_backlog="261144"' in directory '/root'
Jan 26 18:07:44 odl01 salt-minion[2105]: [INFO    ] {'net.core.netdev_max_backlog': 261144}
Jan 26 18:07:44 odl01 salt-minion[2105]: [INFO    ] Completed state [net.core.netdev_max_backlog] at time 18:07:44.372764 duration_in_ms=41.88
Jan 26 18:07:44 odl01 salt-minion[2105]: [INFO    ] Running state [net.ipv4.tcp_keepalive_time] at time 18:07:44.373095
Jan 26 18:07:44 odl01 salt-minion[2105]: [INFO    ] Executing state sysctl.present for net.ipv4.tcp_keepalive_time
Jan 26 18:07:44 odl01 salt-minion[2105]: [INFO    ] Executing command 'sysctl -a' in directory '/root'
Jan 26 18:07:44 odl01 kernel: [  349.907527] sysctl_ibrs_enabled = 0, sysctl_ibpb_enabled = 0
Jan 26 18:07:44 odl01 kernel: [  349.907531] use_ibrs = 4, use_ibpb = 4
Jan 26 18:07:44 odl01 kernel: [  349.907532] read cpu 0 ibrs val 0
Jan 26 18:07:44 odl01 kernel: [  349.907533] read cpu 1 ibrs val 0
Jan 26 18:07:44 odl01 kernel: [  349.907534] read cpu 2 ibrs val 0
Jan 26 18:07:44 odl01 kernel: [  349.907534] read cpu 3 ibrs val 0
Jan 26 18:07:44 odl01 kernel: [  349.907537] sysctl_ibrs_enabled = 0, sysctl_ibpb_enabled = 0
Jan 26 18:07:44 odl01 kernel: [  349.907537] use_ibrs = 4, use_ibpb = 4
Jan 26 18:07:44 odl01 kernel: [  349.907538] read cpu 0 ibrs val 0
Jan 26 18:07:44 odl01 kernel: [  349.907539] read cpu 1 ibrs val 0
Jan 26 18:07:44 odl01 kernel: [  349.907540] read cpu 2 ibrs val 0
Jan 26 18:07:44 odl01 kernel: [  349.907541] read cpu 3 ibrs val 0
Jan 26 18:07:44 odl01 salt-minion[2105]: [INFO    ] Executing command 'sysctl -w net.ipv4.tcp_keepalive_time="30"' in directory '/root'
Jan 26 18:07:44 odl01 salt-minion[2105]: [INFO    ] {'net.ipv4.tcp_keepalive_time': 30}
Jan 26 18:07:44 odl01 salt-minion[2105]: [INFO    ] Completed state [net.ipv4.tcp_keepalive_time] at time 18:07:44.415793 duration_in_ms=42.697
Jan 26 18:07:44 odl01 salt-minion[2105]: [INFO    ] Running state [net.nf_conntrack_max] at time 18:07:44.416119
Jan 26 18:07:44 odl01 salt-minion[2105]: [INFO    ] Executing state sysctl.present for net.nf_conntrack_max
Jan 26 18:07:44 odl01 salt-minion[2105]: [INFO    ] Executing command 'sysctl -a' in directory '/root'
Jan 26 18:07:44 odl01 kernel: [  349.950969] sysctl_ibrs_enabled = 0, sysctl_ibpb_enabled = 0
Jan 26 18:07:44 odl01 kernel: [  349.950973] use_ibrs = 4, use_ibpb = 4
Jan 26 18:07:44 odl01 kernel: [  349.950974] read cpu 0 ibrs val 0
Jan 26 18:07:44 odl01 kernel: [  349.950975] read cpu 1 ibrs val 0
Jan 26 18:07:44 odl01 kernel: [  349.950976] read cpu 2 ibrs val 0
Jan 26 18:07:44 odl01 kernel: [  349.950976] read cpu 3 ibrs val 0
Jan 26 18:07:44 odl01 kernel: [  349.950979] sysctl_ibrs_enabled = 0, sysctl_ibpb_enabled = 0
Jan 26 18:07:44 odl01 kernel: [  349.950979] use_ibrs = 4, use_ibpb = 4
Jan 26 18:07:44 odl01 kernel: [  349.950980] read cpu 0 ibrs val 0
Jan 26 18:07:44 odl01 kernel: [  349.950981] read cpu 1 ibrs val 0
Jan 26 18:07:44 odl01 kernel: [  349.950982] read cpu 2 ibrs val 0
Jan 26 18:07:44 odl01 kernel: [  349.950983] read cpu 3 ibrs val 0
Jan 26 18:07:44 odl01 salt-minion[2105]: [INFO    ] Executing command 'sysctl -w net.nf_conntrack_max="1048576"' in directory '/root'
Jan 26 18:07:44 odl01 salt-minion[2105]: [INFO    ] {'net.nf_conntrack_max': 1048576}
Jan 26 18:07:44 odl01 salt-minion[2105]: [INFO    ] Completed state [net.nf_conntrack_max] at time 18:07:44.461049 duration_in_ms=44.929
Jan 26 18:07:44 odl01 salt-minion[2105]: [INFO    ] Running state [linux_sysfs_package] at time 18:07:44.472075
Jan 26 18:07:44 odl01 salt-minion[2105]: [INFO    ] Executing state pkg.installed for linux_sysfs_package
Jan 26 18:07:44 odl01 salt-minion[2105]: [INFO    ] Executing command ['apt-cache', '-q', 'policy', 'sysfsutils'] in directory '/root'
Jan 26 18:07:44 odl01 salt-minion[2105]: [INFO    ] Executing command ['apt-get', '-q', 'update'] in directory '/root'
Jan 26 18:07:46 odl01 salt-minion[2105]: [INFO    ] Executing command ['dpkg', '--get-selections', '*'] in directory '/root'
Jan 26 18:07:46 odl01 salt-minion[2105]: [INFO    ] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'sysfsutils'] in directory '/root'
Jan 26 18:07:46 odl01 systemd[1]: Started /usr/bin/apt-get -q -y -o DPkg::Options::=--force-confold -o DPkg::Options::=--force-confdef install sysfsutils.
Jan 26 18:07:47 odl01 systemd[1]: Reloading.
Jan 26 18:07:47 odl01 systemd[1]: Started ACPI event daemon.
Jan 26 18:07:48 odl01 systemd[1]: Reloading.
Jan 26 18:07:48 odl01 systemd[1]: Started ACPI event daemon.
Jan 26 18:07:48 odl01 systemd[1]: Reloading.
Jan 26 18:07:48 odl01 systemd[1]: Started ACPI event daemon.
Jan 26 18:07:48 odl01 systemd[1]: Starting LSB: Set sysfs variables from /etc/sysfs.conf...
Jan 26 18:07:48 odl01 sysfsutils[6146]:  * Setting sysfs variables...
Jan 26 18:07:48 odl01 sysfsutils[6146]:    ...done.
Jan 26 18:07:48 odl01 systemd[1]: Started LSB: Set sysfs variables from /etc/sysfs.conf.
Jan 26 18:07:48 odl01 systemd[1]: Reloading.
Jan 26 18:07:48 odl01 systemd[1]: Started ACPI event daemon.
Jan 26 18:07:49 odl01 salt-minion[2105]: [INFO    ] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
Jan 26 18:07:49 odl01 salt-minion[2105]: [INFO    ] Made the following changes:
Jan 26 18:07:49 odl01 salt-minion[2105]: 'libsysfs2' changed from 'absent' to '2.1.0+repack-4'
Jan 26 18:07:49 odl01 salt-minion[2105]: 'sysfsutils' changed from 'absent' to '2.1.0+repack-4'
Jan 26 18:07:49 odl01 salt-minion[2105]: [INFO    ] Loading fresh modules for state activity
Jan 26 18:07:49 odl01 salt-minion[2105]: [INFO    ] Completed state [linux_sysfs_package] at time 18:07:49.850852 duration_in_ms=5378.776
Jan 26 18:07:49 odl01 salt-minion[2105]: [INFO    ] Running state [/etc/sysfs.d] at time 18:07:49.854981
Jan 26 18:07:49 odl01 salt-minion[2105]: [INFO    ] Executing state file.directory for /etc/sysfs.d
Jan 26 18:07:49 odl01 salt-minion[2105]: [INFO    ] Directory /etc/sysfs.d is in the correct state
Jan 26 18:07:49 odl01 salt-minion[2105]: [INFO    ] Completed state [/etc/sysfs.d] at time 18:07:49.859274 duration_in_ms=4.293
Jan 26 18:07:49 odl01 salt-minion[2105]: [INFO    ] Running state [ondemand] at time 18:07:49.906429
Jan 26 18:07:49 odl01 salt-minion[2105]: [INFO    ] Executing state service.dead for ondemand
Jan 26 18:07:49 odl01 salt-minion[2105]: [INFO    ] Executing command ['systemctl', 'status', 'ondemand.service', '-n', '0'] in directory '/root'
Jan 26 18:07:49 odl01 salt-minion[2105]: [INFO    ] Executing command ['systemctl', 'is-active', 'ondemand.service'] in directory '/root'
Jan 26 18:07:49 odl01 salt-minion[2105]: [INFO    ] Executing command ['systemctl', 'is-enabled', 'ondemand.service'] in directory '/root'
Jan 26 18:07:49 odl01 salt-minion[2105]: [INFO    ] Executing command ['systemd-run', '--scope', 'systemctl', 'stop', 'ondemand.service'] in directory '/root'
Jan 26 18:07:49 odl01 systemd[1]: Started /bin/systemctl stop ondemand.service.
Jan 26 18:07:50 odl01 systemd[1]: Stopping LSB: Set the CPU Frequency Scaling governor to "ondemand"...
Jan 26 18:07:50 odl01 systemd[1]: Stopped LSB: Set the CPU Frequency Scaling governor to "ondemand".
Jan 26 18:07:50 odl01 salt-minion[2105]: [INFO    ] Executing command ['systemctl', 'is-active', 'ondemand.service'] in directory '/root'
Jan 26 18:07:50 odl01 salt-minion[2105]: [INFO    ] Executing command ['systemctl', 'is-enabled', 'ondemand.service'] in directory '/root'
Jan 26 18:07:50 odl01 salt-minion[2105]: [INFO    ] Executing command ['systemctl', 'is-enabled', 'ondemand.service'] in directory '/root'
Jan 26 18:07:50 odl01 salt-minion[2105]: [INFO    ] Executing command ['systemd-run', '--scope', '/usr/sbin/update-rc.d', '-f', 'ondemand', 'remove'] in directory '/root'
Jan 26 18:07:50 odl01 systemd[1]: Started /usr/sbin/update-rc.d -f ondemand remove.
Jan 26 18:07:50 odl01 systemd[1]: Reloading.
Jan 26 18:07:50 odl01 systemd[1]: Started ACPI event daemon.
Jan 26 18:07:50 odl01 salt-minion[2105]: [INFO    ] Executing command ['systemctl', 'is-enabled', 'ondemand.service'] in directory '/root'
Jan 26 18:07:50 odl01 salt-minion[2105]: [INFO    ] Executing command 'runlevel' in directory '/root'
Jan 26 18:07:50 odl01 salt-minion[2105]: [INFO    ] {'ondemand': True}
Jan 26 18:07:50 odl01 salt-minion[2105]: [INFO    ] Completed state [ondemand] at time 18:07:50.261212 duration_in_ms=354.782
Jan 26 18:07:50 odl01 salt-minion[2105]: [INFO    ] Running state [cs_CZ.UTF-8] at time 18:07:50.267042
Jan 26 18:07:50 odl01 salt-minion[2105]: [INFO    ] Executing state locale.present for cs_CZ.UTF-8
Jan 26 18:07:50 odl01 salt-minion[2105]: [INFO    ] Executing command 'locale -a' in directory '/root'
Jan 26 18:07:50 odl01 salt-minion[2105]: [INFO    ] Executing command ['locale-gen', 'cs_CZ.utf8'] in directory '/root'
Jan 26 18:07:50 odl01 salt-minion[2105]: [INFO    ] {'locale': 'cs_CZ.UTF-8'}
Jan 26 18:07:50 odl01 salt-minion[2105]: [INFO    ] Completed state [cs_CZ.UTF-8] at time 18:07:50.992265 duration_in_ms=725.222
Jan 26 18:07:50 odl01 salt-minion[2105]: [INFO    ] Running state [en_US.UTF-8] at time 18:07:50.992992
Jan 26 18:07:50 odl01 salt-minion[2105]: [INFO    ] Executing state locale.present for en_US.UTF-8
Jan 26 18:07:50 odl01 salt-minion[2105]: [INFO    ] Executing command 'locale -a' in directory '/root'
Jan 26 18:07:51 odl01 salt-minion[2105]: [INFO    ] Locale en_US.UTF-8 is already present
Jan 26 18:07:51 odl01 salt-minion[2105]: [INFO    ] Completed state [en_US.UTF-8] at time 18:07:51.011121 duration_in_ms=18.13
Jan 26 18:07:51 odl01 salt-minion[2105]: [INFO    ] Running state [en_US.UTF-8] at time 18:07:51.012580
Jan 26 18:07:51 odl01 salt-minion[2105]: [INFO    ] Executing state locale.system for en_US.UTF-8
Jan 26 18:07:51 odl01 salt-minion[2105]: [INFO    ] Executing command 'localectl' in directory '/root'
Jan 26 18:07:51 odl01 dbus[1089]: [system] Activating via systemd: service name='org.freedesktop.locale1' unit='dbus-org.freedesktop.locale1.service'
Jan 26 18:07:51 odl01 systemd[1]: Starting Locale Service...
Jan 26 18:07:51 odl01 dbus[1089]: [system] Successfully activated service 'org.freedesktop.locale1'
Jan 26 18:07:51 odl01 salt-minion[2105]: [INFO    ] System locale en_US.UTF-8 already set
Jan 26 18:07:51 odl01 salt-minion[2105]: [INFO    ] Completed state [en_US.UTF-8] at time 18:07:51.063552 duration_in_ms=50.973
Jan 26 18:07:51 odl01 systemd[1]: Started Locale Service.
Jan 26 18:07:51 odl01 salt-minion[2105]: [INFO    ] Running state [root] at time 18:07:51.065608
Jan 26 18:07:51 odl01 salt-minion[2105]: [INFO    ] Executing state user.present for root
Jan 26 18:07:51 odl01 salt-minion[2105]: [INFO    ] User root is present and up to date
Jan 26 18:07:51 odl01 salt-minion[2105]: [INFO    ] Completed state [root] at time 18:07:51.072863 duration_in_ms=7.255
Jan 26 18:07:51 odl01 salt-minion[2105]: [INFO    ] Running state [/root] at time 18:07:51.073768
Jan 26 18:07:51 odl01 salt-minion[2105]: [INFO    ] Executing state file.directory for /root
Jan 26 18:07:51 odl01 salt-minion[2105]: [INFO    ] Directory /root is in the correct state
Jan 26 18:07:51 odl01 salt-minion[2105]: [INFO    ] Completed state [/root] at time 18:07:51.074924 duration_in_ms=1.156
Jan 26 18:07:51 odl01 salt-minion[2105]: [INFO    ] Running state [/etc/sudoers.d/90-salt-user-root] at time 18:07:51.075147
Jan 26 18:07:51 odl01 salt-minion[2105]: [INFO    ] Executing state file.absent for /etc/sudoers.d/90-salt-user-root
Jan 26 18:07:51 odl01 salt-minion[2105]: [INFO    ] File /etc/sudoers.d/90-salt-user-root is not present
Jan 26 18:07:51 odl01 salt-minion[2105]: [INFO    ] Completed state [/etc/sudoers.d/90-salt-user-root] at time 18:07:51.075845 duration_in_ms=0.698
Jan 26 18:07:51 odl01 salt-minion[2105]: [INFO    ] Running state [/etc/security/limits.d/90-salt-default.conf] at time 18:07:51.076068
Jan 26 18:07:51 odl01 salt-minion[2105]: [INFO    ] Executing state file.managed for /etc/security/limits.d/90-salt-default.conf
Jan 26 18:07:51 odl01 salt-minion[2105]: [INFO    ] Fetching file from saltenv 'base', ** done ** 'linux/files/limits.conf'
Jan 26 18:07:51 odl01 salt-minion[2105]: [INFO    ] File changed:
Jan 26 18:07:51 odl01 salt-minion[2105]: New file
Jan 26 18:07:51 odl01 salt-minion[2105]: [INFO    ] Completed state [/etc/security/limits.d/90-salt-default.conf] at time 18:07:51.205377 duration_in_ms=129.309
Jan 26 18:07:51 odl01 salt-minion[2105]: [INFO    ] Running state [/etc/systemd/system.conf.d/90-salt.conf] at time 18:07:51.205617
Jan 26 18:07:51 odl01 salt-minion[2105]: [INFO    ] Executing state file.managed for /etc/systemd/system.conf.d/90-salt.conf
Jan 26 18:07:51 odl01 salt-minion[2105]: [INFO    ] Fetching file from saltenv 'base', ** done ** 'linux/files/systemd.conf'
Jan 26 18:07:51 odl01 salt-minion[2105]: [INFO    ] File changed:
Jan 26 18:07:51 odl01 salt-minion[2105]: New file
Jan 26 18:07:51 odl01 salt-minion[2105]: [INFO    ] Completed state [/etc/systemd/system.conf.d/90-salt.conf] at time 18:07:51.309686 duration_in_ms=104.068
Jan 26 18:07:51 odl01 salt-minion[2105]: [INFO    ] Running state [service.systemctl_reload] at time 18:07:51.311155
Jan 26 18:07:51 odl01 salt-minion[2105]: [INFO    ] Executing state module.wait for service.systemctl_reload
Jan 26 18:07:51 odl01 salt-minion[2105]: [INFO    ] No changes made for service.systemctl_reload
Jan 26 18:07:51 odl01 salt-minion[2105]: [INFO    ] Completed state [service.systemctl_reload] at time 18:07:51.311832 duration_in_ms=0.677
Jan 26 18:07:51 odl01 salt-minion[2105]: [INFO    ] Running state [service.systemctl_reload] at time 18:07:51.312019
Jan 26 18:07:51 odl01 salt-minion[2105]: [INFO    ] Executing state module.mod_watch for service.systemctl_reload
Jan 26 18:07:51 odl01 salt-minion[2105]: [INFO    ] Executing command ['systemctl', '--system', 'daemon-reload'] in directory '/root'
Jan 26 18:07:51 odl01 systemd[1]: Reloading.
Jan 26 18:07:51 odl01 systemd[1]: Started ACPI event daemon.
Jan 26 18:07:51 odl01 salt-minion[2105]: [INFO    ] {'ret': True}
Jan 26 18:07:51 odl01 salt-minion[2105]: [INFO    ] Completed state [service.systemctl_reload] at time 18:07:51.381587 duration_in_ms=69.568
Jan 26 18:07:51 odl01 salt-minion[2105]: [INFO    ] Running state [/etc/hostname] at time 18:07:51.382274
Jan 26 18:07:51 odl01 salt-minion[2105]: [INFO    ] Executing state file.managed for /etc/hostname
Jan 26 18:07:51 odl01 salt-minion[2105]: [INFO    ] Fetching file from saltenv 'base', ** done ** 'linux/files/hostname'
Jan 26 18:07:51 odl01 salt-minion[2105]: [INFO    ] File /etc/hostname is in the correct state
Jan 26 18:07:51 odl01 salt-minion[2105]: [INFO    ] Completed state [/etc/hostname] at time 18:07:51.404078 duration_in_ms=21.804
Jan 26 18:07:51 odl01 salt-minion[2105]: [INFO    ] Running state [hostname odl01] at time 18:07:51.405919
Jan 26 18:07:51 odl01 salt-minion[2105]: [INFO    ] Executing state cmd.wait for hostname odl01
Jan 26 18:07:51 odl01 salt-minion[2105]: [INFO    ] No changes made for hostname odl01
Jan 26 18:07:51 odl01 salt-minion[2105]: [INFO    ] Completed state [hostname odl01] at time 18:07:51.406628 duration_in_ms=0.709
Jan 26 18:07:51 odl01 salt-minion[2105]: [INFO    ] Running state [cfg] at time 18:07:51.407721
Jan 26 18:07:51 odl01 salt-minion[2105]: [INFO    ] Executing state host.present for cfg
Jan 26 18:07:51 odl01 salt-minion[2105]: [INFO    ] {'host': 'cfg'}
Jan 26 18:07:51 odl01 salt-minion[2105]: [INFO    ] Completed state [cfg] at time 18:07:51.410308 duration_in_ms=2.587
Jan 26 18:07:51 odl01 salt-minion[2105]: [INFO    ] Running state [cfg.virtual-mcp-ocata-odl-router-noha.local] at time 18:07:51.410569
Jan 26 18:07:51 odl01 salt-minion[2105]: [INFO    ] Executing state host.present for cfg.virtual-mcp-ocata-odl-router-noha.local
Jan 26 18:07:51 odl01 salt-minion[2105]: [INFO    ] {'host': 'cfg.virtual-mcp-ocata-odl-router-noha.local'}
Jan 26 18:07:51 odl01 salt-minion[2105]: [INFO    ] Completed state [cfg.virtual-mcp-ocata-odl-router-noha.local] at time 18:07:51.411733 duration_in_ms=1.164
Jan 26 18:07:51 odl01 salt-minion[2105]: [INFO    ] Running state [odl01] at time 18:07:51.411956
Jan 26 18:07:51 odl01 salt-minion[2105]: [INFO    ] Executing state host.present for odl01
Jan 26 18:07:51 odl01 salt-minion[2105]: [INFO    ] {'host': 'odl01'}
Jan 26 18:07:51 odl01 salt-minion[2105]: [INFO    ] Completed state [odl01] at time 18:07:51.413110 duration_in_ms=1.154
Jan 26 18:07:51 odl01 salt-minion[2105]: [INFO    ] Running state [odl01.virtual-mcp-ocata-odl-router-noha.local] at time 18:07:51.413336
Jan 26 18:07:51 odl01 salt-minion[2105]: [INFO    ] Executing state host.present for odl01.virtual-mcp-ocata-odl-router-noha.local
Jan 26 18:07:51 odl01 salt-minion[2105]: [INFO    ] {'host': 'odl01.virtual-mcp-ocata-odl-router-noha.local'}
Jan 26 18:07:51 odl01 salt-minion[2105]: [INFO    ] Completed state [odl01.virtual-mcp-ocata-odl-router-noha.local] at time 18:07:51.415657 duration_in_ms=2.32
Jan 26 18:07:51 odl01 salt-minion[2105]: [INFO    ] Running state [gtw01] at time 18:07:51.415881
Jan 26 18:07:51 odl01 salt-minion[2105]: [INFO    ] Executing state host.present for gtw01
Jan 26 18:07:51 odl01 salt-minion[2105]: [INFO    ] {'host': 'gtw01'}
Jan 26 18:07:51 odl01 salt-minion[2105]: [INFO    ] Completed state [gtw01] at time 18:07:51.417040 duration_in_ms=1.159
Jan 26 18:07:51 odl01 salt-minion[2105]: [INFO    ] Running state [gtw01.virtual-mcp-ocata-odl-router-noha.local] at time 18:07:51.417266
Jan 26 18:07:51 odl01 salt-minion[2105]: [INFO    ] Executing state host.present for gtw01.virtual-mcp-ocata-odl-router-noha.local
Jan 26 18:07:51 odl01 salt-minion[2105]: [INFO    ] {'host': 'gtw01.virtual-mcp-ocata-odl-router-noha.local'}
Jan 26 18:07:51 odl01 salt-minion[2105]: [INFO    ] Completed state [gtw01.virtual-mcp-ocata-odl-router-noha.local] at time 18:07:51.418455 duration_in_ms=1.189
Jan 26 18:07:51 odl01 salt-minion[2105]: [INFO    ] Running state [ctl] at time 18:07:51.418705
Jan 26 18:07:51 odl01 salt-minion[2105]: [INFO    ] Executing state host.present for ctl
Jan 26 18:07:51 odl01 salt-minion[2105]: [INFO    ] {'host': 'ctl'}
Jan 26 18:07:51 odl01 salt-minion[2105]: [INFO    ] Completed state [ctl] at time 18:07:51.419883 duration_in_ms=1.178
Jan 26 18:07:51 odl01 salt-minion[2105]: [INFO    ] Running state [ctl.virtual-mcp-ocata-odl-router-noha.local] at time 18:07:51.420103
Jan 26 18:07:51 odl01 salt-minion[2105]: [INFO    ] Executing state host.present for ctl.virtual-mcp-ocata-odl-router-noha.local
Jan 26 18:07:51 odl01 salt-minion[2105]: [INFO    ] {'host': 'ctl.virtual-mcp-ocata-odl-router-noha.local'}
Jan 26 18:07:51 odl01 salt-minion[2105]: [INFO    ] Completed state [ctl.virtual-mcp-ocata-odl-router-noha.local] at time 18:07:51.421272 duration_in_ms=1.169
Jan 26 18:07:51 odl01 salt-minion[2105]: [INFO    ] Running state [ctl01] at time 18:07:51.421494
Jan 26 18:07:51 odl01 salt-minion[2105]: [INFO    ] Executing state host.present for ctl01
Jan 26 18:07:51 odl01 salt-minion[2105]: [INFO    ] {'host': 'ctl01'}
Jan 26 18:07:51 odl01 salt-minion[2105]: [INFO    ] Completed state [ctl01] at time 18:07:51.422694 duration_in_ms=1.2
Jan 26 18:07:51 odl01 salt-minion[2105]: [INFO    ] Running state [ctl01.virtual-mcp-ocata-odl-router-noha.local] at time 18:07:51.422909
Jan 26 18:07:51 odl01 salt-minion[2105]: [INFO    ] Executing state host.present for ctl01.virtual-mcp-ocata-odl-router-noha.local
Jan 26 18:07:51 odl01 salt-minion[2105]: [INFO    ] {'host': 'ctl01.virtual-mcp-ocata-odl-router-noha.local'}
Jan 26 18:07:51 odl01 salt-minion[2105]: [INFO    ] Completed state [ctl01.virtual-mcp-ocata-odl-router-noha.local] at time 18:07:51.424096 duration_in_ms=1.187
Jan 26 18:07:51 odl01 salt-minion[2105]: [INFO    ] Running state [cmp01] at time 18:07:51.424314
Jan 26 18:07:51 odl01 salt-minion[2105]: [INFO    ] Executing state host.present for cmp01
Jan 26 18:07:51 odl01 salt-minion[2105]: [INFO    ] {'host': 'cmp01'}
Jan 26 18:07:51 odl01 salt-minion[2105]: [INFO    ] Completed state [cmp01] at time 18:07:51.425480 duration_in_ms=1.166
Jan 26 18:07:51 odl01 salt-minion[2105]: [INFO    ] Running state [cmp01.virtual-mcp-ocata-odl-router-noha.local] at time 18:07:51.425703
Jan 26 18:07:51 odl01 salt-minion[2105]: [INFO    ] Executing state host.present for cmp01.virtual-mcp-ocata-odl-router-noha.local
Jan 26 18:07:51 odl01 salt-minion[2105]: [INFO    ] {'host': 'cmp01.virtual-mcp-ocata-odl-router-noha.local'}
Jan 26 18:07:51 odl01 salt-minion[2105]: [INFO    ] Completed state [cmp01.virtual-mcp-ocata-odl-router-noha.local] at time 18:07:51.428064 duration_in_ms=2.361
Jan 26 18:07:51 odl01 salt-minion[2105]: [INFO    ] Running state [cmp02] at time 18:07:51.428284
Jan 26 18:07:51 odl01 salt-minion[2105]: [INFO    ] Executing state host.present for cmp02
Jan 26 18:07:51 odl01 salt-minion[2105]: [INFO    ] {'host': 'cmp02'}
Jan 26 18:07:51 odl01 salt-minion[2105]: [INFO    ] Completed state [cmp02] at time 18:07:51.429481 duration_in_ms=1.198
Jan 26 18:07:51 odl01 salt-minion[2105]: [INFO    ] Running state [cmp02.virtual-mcp-ocata-odl-router-noha.local] at time 18:07:51.429699
Jan 26 18:07:51 odl01 salt-minion[2105]: [INFO    ] Executing state host.present for cmp02.virtual-mcp-ocata-odl-router-noha.local
Jan 26 18:07:51 odl01 salt-minion[2105]: [INFO    ] {'host': 'cmp02.virtual-mcp-ocata-odl-router-noha.local'}
Jan 26 18:07:51 odl01 salt-minion[2105]: [INFO    ] Completed state [cmp02.virtual-mcp-ocata-odl-router-noha.local] at time 18:07:51.430954 duration_in_ms=1.255
Jan 26 18:07:51 odl01 salt-minion[2105]: [INFO    ] Running state [cfg01] at time 18:07:51.431177
Jan 26 18:07:51 odl01 salt-minion[2105]: [INFO    ] Executing state host.present for cfg01
Jan 26 18:07:51 odl01 salt-minion[2105]: [INFO    ] {'host': 'cfg01'}
Jan 26 18:07:51 odl01 salt-minion[2105]: [INFO    ] Completed state [cfg01] at time 18:07:51.432383 duration_in_ms=1.206
Jan 26 18:07:51 odl01 salt-minion[2105]: [INFO    ] Running state [cfg01.virtual-mcp-ocata-odl-router-noha.local] at time 18:07:51.432601
Jan 26 18:07:51 odl01 salt-minion[2105]: [INFO    ] Executing state host.present for cfg01.virtual-mcp-ocata-odl-router-noha.local
Jan 26 18:07:51 odl01 salt-minion[2105]: [INFO    ] {'host': 'cfg01.virtual-mcp-ocata-odl-router-noha.local'}
Jan 26 18:07:51 odl01 salt-minion[2105]: [INFO    ] Completed state [cfg01.virtual-mcp-ocata-odl-router-noha.local] at time 18:07:51.434327 duration_in_ms=1.726
Jan 26 18:07:51 odl01 salt-minion[2105]: [INFO    ] Running state [ens4] at time 18:07:51.439899
Jan 26 18:07:51 odl01 salt-minion[2105]: [INFO    ] Executing state network.managed for ens4
Jan 26 18:07:51 odl01 salt-minion[2105]: [INFO    ] Executing command ['ifup', 'ens4'] in directory '/root'
Jan 26 18:07:51 odl01 systemd[1]: Reloading OpenBSD Secure Shell server.
Jan 26 18:07:51 odl01 systemd[1]: Reloaded OpenBSD Secure Shell server.
Jan 26 18:07:52 odl01 salt-minion[2105]: [INFO    ] {'interface': 'Added network interface.', 'status': 'Interface ens4 is up'}
Jan 26 18:07:52 odl01 salt-minion[2105]: [INFO    ] Completed state [ens4] at time 18:07:52.218722 duration_in_ms=778.823
Jan 26 18:07:52 odl01 salt-minion[2105]: [INFO    ] Running state [/etc/profile.d/proxy.sh] at time 18:07:52.219033
Jan 26 18:07:52 odl01 salt-minion[2105]: [INFO    ] Executing state file.absent for /etc/profile.d/proxy.sh
Jan 26 18:07:52 odl01 salt-minion[2105]: [INFO    ] File /etc/profile.d/proxy.sh is not present
Jan 26 18:07:52 odl01 salt-minion[2105]: [INFO    ] Completed state [/etc/profile.d/proxy.sh] at time 18:07:52.219886 duration_in_ms=0.853
Jan 26 18:07:52 odl01 salt-minion[2105]: [INFO    ] Running state [/etc/apt/apt.conf.d/95proxies] at time 18:07:52.220111
Jan 26 18:07:52 odl01 salt-minion[2105]: [INFO    ] Executing state file.absent for /etc/apt/apt.conf.d/95proxies
Jan 26 18:07:52 odl01 salt-minion[2105]: [INFO    ] File /etc/apt/apt.conf.d/95proxies is not present
Jan 26 18:07:52 odl01 salt-minion[2105]: [INFO    ] Completed state [/etc/apt/apt.conf.d/95proxies] at time 18:07:52.220806 duration_in_ms=0.695
Jan 26 18:07:52 odl01 salt-minion[2105]: [INFO    ] Returning information for job: 20180126180712668307
Jan 26 18:08:11 odl01 salt-minion[2105]: [INFO    ] User sudo_ubuntu Executing command pkg.upgrade with jid 20180126180811278414
Jan 26 18:08:11 odl01 salt-minion[2105]: [INFO    ] Starting a new job with PID 6449
Jan 26 18:08:11 odl01 salt-minion[2105]: [INFO    ] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
Jan 26 18:08:11 odl01 salt-minion[2105]: [INFO    ] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'upgrade'] in directory '/root'
Jan 26 18:08:11 odl01 systemd[1]: Started /usr/bin/apt-get -q -y -o DPkg::Options::=--force-confold -o DPkg::Options::=--force-confdef upgrade.
Jan 26 18:08:13 odl01 dbus[1089]: [system] Reloaded configuration
Jan 26 18:08:15 odl01 dbus[1089]: message repeated 3 times: [ [system] Reloaded configuration]
Jan 26 18:08:17 odl01 salt-minion[2105]: [INFO    ] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
Jan 26 18:08:17 odl01 salt-minion[2105]: [INFO    ] Returning information for job: 20180126180811278414
Jan 26 18:08:18 odl01 salt-minion[2105]: [INFO    ] User sudo_ubuntu Executing command state.sls with jid 20180126180818563055
Jan 26 18:08:18 odl01 salt-minion[2105]: [INFO    ] Starting a new job with PID 7243
Jan 26 18:08:20 odl01 salt-minion[2105]: [INFO    ] Loading fresh modules for state activity
Jan 26 18:08:20 odl01 salt-minion[2105]: [INFO    ] Fetching file from saltenv 'base', ** done ** 'ntp/init.sls'
Jan 26 18:08:20 odl01 salt-minion[2105]: [INFO    ] Fetching file from saltenv 'base', ** done ** 'ntp/client.sls'
Jan 26 18:08:20 odl01 salt-minion[2105]: [INFO    ] Fetching file from saltenv 'base', ** done ** 'ntp/server.sls'
Jan 26 18:08:21 odl01 salt-minion[2105]: [INFO    ] Running state [ntp] at time 18:08:21.181912
Jan 26 18:08:21 odl01 salt-minion[2105]: [INFO    ] Executing state pkg.installed for ntp
Jan 26 18:08:21 odl01 salt-minion[2105]: [INFO    ] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
Jan 26 18:08:21 odl01 salt-minion[2105]: [INFO    ] Executing command ['apt-cache', '-q', 'policy', 'ntp'] in directory '/root'
Jan 26 18:08:21 odl01 salt-minion[2105]: [INFO    ] Executing command ['apt-get', '-q', 'update'] in directory '/root'
Jan 26 18:08:23 odl01 salt-minion[2105]: [INFO    ] Executing command ['dpkg', '--get-selections', '*'] in directory '/root'
Jan 26 18:08:23 odl01 salt-minion[2105]: [INFO    ] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'ntp'] in directory '/root'
Jan 26 18:08:23 odl01 systemd[1]: Started /usr/bin/apt-get -q -y -o DPkg::Options::=--force-confold -o DPkg::Options::=--force-confdef install ntp.
Jan 26 18:08:24 odl01 systemd[1]: Reloading.
Jan 26 18:08:24 odl01 systemd[1]: Started ACPI event daemon.
Jan 26 18:08:25 odl01 systemd[1]: Reloading.
Jan 26 18:08:25 odl01 systemd[1]: Started ACPI event daemon.
Jan 26 18:08:25 odl01 systemd[1]: Reloading.
Jan 26 18:08:25 odl01 systemd[1]: Started ACPI event daemon.
Jan 26 18:08:25 odl01 systemd[1]: Starting LSB: Start NTP daemon...
Jan 26 18:08:25 odl01 ntp[8302]:  * Starting NTP server ntpd
Jan 26 18:08:25 odl01 ntpd[8312]: ntpd 4.2.8p4@1.3265-o Thu Sep  7 20:43:09 UTC 2017 (1): Starting
Jan 26 18:08:25 odl01 ntpd[8312]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 112:116
Jan 26 18:08:25 odl01 ntp[8302]:    ...done.
Jan 26 18:08:25 odl01 systemd[1]: Started LSB: Start NTP daemon.
Jan 26 18:08:25 odl01 kernel: [  391.158921] audit_printk_skb: 15 callbacks suppressed
Jan 26 18:08:25 odl01 kernel: [  391.158924] audit: type=1400 audit(1516990105.633:16): apparmor="STATUS" operation="profile_load" profile="unconfined" name="/usr/sbin/ntpd" pid=8324 comm="apparmor_parser"
Jan 26 18:08:25 odl01 ntpd[8315]: proto: precision = 0.061 usec (-24)
Jan 26 18:08:25 odl01 ntpd[8315]: Listen and drop on 0 v6wildcard [::]:123
Jan 26 18:08:25 odl01 ntpd[8315]: Listen and drop on 1 v4wildcard 0.0.0.0:123
Jan 26 18:08:25 odl01 ntpd[8315]: Listen normally on 2 lo 127.0.0.1:123
Jan 26 18:08:25 odl01 ntpd[8315]: Listen normally on 3 ens3 10.20.0.34:123
Jan 26 18:08:25 odl01 ntpd[8315]: Listen normally on 4 ens4 172.16.10.111:123
Jan 26 18:08:25 odl01 ntpd[8315]: Listen normally on 5 lo [::1]:123
Jan 26 18:08:25 odl01 ntpd[8315]: Listen normally on 6 ens3 [fe80::5054:ff:fe38:be11%2]:123
Jan 26 18:08:25 odl01 ntpd[8315]: Listen normally on 7 ens4 [fe80::5054:ff:fe1e:81f7%3]:123
Jan 26 18:08:25 odl01 ntpd[8315]: Listening on routing socket on fd #24 for interface updates
Jan 26 18:08:25 odl01 systemd[1]: Reloading.
Jan 26 18:08:25 odl01 systemd[1]: Started ACPI event daemon.
Jan 26 18:08:26 odl01 ntpd[8315]: Soliciting pool server 162.210.111.4
Jan 26 18:08:26 odl01 salt-minion[2105]: [INFO    ] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
Jan 26 18:08:27 odl01 salt-minion[2105]: [INFO    ] Made the following changes:
Jan 26 18:08:27 odl01 salt-minion[2105]: 'ntp' changed from 'absent' to '1:4.2.8p4+dfsg-3ubuntu5.7'
Jan 26 18:08:27 odl01 salt-minion[2105]: 'libopts25' changed from 'absent' to '1:5.18.7-3'
Jan 26 18:08:27 odl01 salt-minion[2105]: [INFO    ] Loading fresh modules for state activity
Jan 26 18:08:27 odl01 salt-minion[2105]: [INFO    ] Completed state [ntp] at time 18:08:27.076807 duration_in_ms=5894.895
Jan 26 18:08:27 odl01 salt-minion[2105]: [INFO    ] Running state [/etc/ntp.conf] at time 18:08:27.080513
Jan 26 18:08:27 odl01 salt-minion[2105]: [INFO    ] Executing state file.managed for /etc/ntp.conf
Jan 26 18:08:27 odl01 salt-minion[2105]: [INFO    ] Fetching file from saltenv 'base', ** done ** 'ntp/files/ntp.conf'
Jan 26 18:08:27 odl01 salt-minion[2105]: [INFO    ] File changed:
Jan 26 18:08:27 odl01 salt-minion[2105]: ---
Jan 26 18:08:27 odl01 salt-minion[2105]: +++
Jan 26 18:08:27 odl01 salt-minion[2105]: @@ -1,66 +1,24 @@
Jan 26 18:08:27 odl01 salt-minion[2105]: -# /etc/ntp.conf, configuration for ntpd; see ntp.conf(5) for help
Jan 26 18:08:27 odl01 salt-minion[2105]:  
Jan 26 18:08:27 odl01 salt-minion[2105]: -driftfile /var/lib/ntp/ntp.drift
Jan 26 18:08:27 odl01 salt-minion[2105]:  
Jan 26 18:08:27 odl01 salt-minion[2105]: -# Enable this if you want statistics to be logged.
Jan 26 18:08:27 odl01 salt-minion[2105]: -#statsdir /var/log/ntpstats/
Jan 26 18:08:27 odl01 salt-minion[2105]: +# ntpd will only synchronize your clock.
Jan 26 18:08:27 odl01 salt-minion[2105]:  
Jan 26 18:08:27 odl01 salt-minion[2105]: -statistics loopstats peerstats clockstats
Jan 26 18:08:27 odl01 salt-minion[2105]: -filegen loopstats file loopstats type day enable
Jan 26 18:08:27 odl01 salt-minion[2105]: -filegen peerstats file peerstats type day enable
Jan 26 18:08:27 odl01 salt-minion[2105]: -filegen clockstats file clockstats type day enable
Jan 26 18:08:27 odl01 salt-minion[2105]: +# For details, see:
Jan 26 18:08:27 odl01 salt-minion[2105]: +# - the ntp.conf man page
Jan 26 18:08:27 odl01 salt-minion[2105]: +# - http://support.ntp.org/bin/view/Support/GettingStarted
Jan 26 18:08:27 odl01 salt-minion[2105]: +# - https://wiki.archlinux.org/index.php/Network_Time_Protocol_daemon
Jan 26 18:08:27 odl01 salt-minion[2105]:  
Jan 26 18:08:27 odl01 salt-minion[2105]: -# Specify one or more NTP servers.
Jan 26 18:08:27 odl01 salt-minion[2105]: +# Associate to cloud NTP pool servers
Jan 26 18:08:27 odl01 salt-minion[2105]: +server 1.se.pool.ntp.org iburst
Jan 26 18:08:27 odl01 salt-minion[2105]: +server 0.se.pool.ntp.org
Jan 26 18:08:27 odl01 salt-minion[2105]:  
Jan 26 18:08:27 odl01 salt-minion[2105]: -# Use servers from the NTP Pool Project. Approved by Ubuntu Technical Board
Jan 26 18:08:27 odl01 salt-minion[2105]: -# on 2011-02-08 (LP: #104525). See http://www.pool.ntp.org/join.html for
Jan 26 18:08:27 odl01 salt-minion[2105]: -# more information.
Jan 26 18:08:27 odl01 salt-minion[2105]: -pool 0.ubuntu.pool.ntp.org iburst
Jan 26 18:08:27 odl01 salt-minion[2105]: -pool 1.ubuntu.pool.ntp.org iburst
Jan 26 18:08:27 odl01 salt-minion[2105]: -pool 2.ubuntu.pool.ntp.org iburst
Jan 26 18:08:27 odl01 salt-minion[2105]: -pool 3.ubuntu.pool.ntp.org iburst
Jan 26 18:08:27 odl01 salt-minion[2105]: -
Jan 26 18:08:27 odl01 salt-minion[2105]: -# Use Ubuntu's ntp server as a fallback.
Jan 26 18:08:27 odl01 salt-minion[2105]: -pool ntp.ubuntu.com
Jan 26 18:08:27 odl01 salt-minion[2105]: -
Jan 26 18:08:27 odl01 salt-minion[2105]: -# Access control configuration; see /usr/share/doc/ntp-doc/html/accopt.html for
Jan 26 18:08:27 odl01 salt-minion[2105]: -# details.  The web page <http://support.ntp.org/bin/view/Support/AccessRestrictions>
Jan 26 18:08:27 odl01 salt-minion[2105]: -# might also be helpful.
Jan 26 18:08:27 odl01 salt-minion[2105]: -#
Jan 26 18:08:27 odl01 salt-minion[2105]: -# Note that "restrict" applies to both servers and clients, so a configuration
Jan 26 18:08:27 odl01 salt-minion[2105]: -# that might be intended to block requests from certain clients could also end
Jan 26 18:08:27 odl01 salt-minion[2105]: -# up blocking replies from your own upstream servers.
Jan 26 18:08:27 odl01 salt-minion[2105]: -
Jan 26 18:08:27 odl01 salt-minion[2105]: -# By default, exchange time with everybody, but don't allow configuration.
Jan 26 18:08:27 odl01 salt-minion[2105]: -restrict -4 default kod notrap nomodify nopeer noquery limited
Jan 26 18:08:27 odl01 salt-minion[2105]: -restrict -6 default kod notrap nomodify nopeer noquery limited
Jan 26 18:08:27 odl01 salt-minion[2105]: -
Jan 26 18:08:27 odl01 salt-minion[2105]: -# Local users may interrogate the ntp server more closely.
Jan 26 18:08:27 odl01 salt-minion[2105]: +# Only allow read-only access from localhost
Jan 26 18:08:27 odl01 salt-minion[2105]: +restrict default noquery nopeer
Jan 26 18:08:27 odl01 salt-minion[2105]:  restrict 127.0.0.1
Jan 26 18:08:27 odl01 salt-minion[2105]:  restrict ::1
Jan 26 18:08:27 odl01 salt-minion[2105]:  
Jan 26 18:08:27 odl01 salt-minion[2105]: -# Needed for adding pool entries
Jan 26 18:08:27 odl01 salt-minion[2105]: -restrict source notrap nomodify noquery
Jan 26 18:08:27 odl01 salt-minion[2105]: -
Jan 26 18:08:27 odl01 salt-minion[2105]: -# Clients from this (example!) subnet have unlimited access, but only if
Jan 26 18:08:27 odl01 salt-minion[2105]: -# cryptographically authenticated.
Jan 26 18:08:27 odl01 salt-minion[2105]: -#restrict 192.168.123.0 mask 255.255.255.0 notrust
Jan 26 18:08:27 odl01 salt-minion[2105]: +# mode7 is required for collectd monitoring
Jan 26 18:08:27 odl01 salt-minion[2105]:  
Jan 26 18:08:27 odl01 salt-minion[2105]:  
Jan 26 18:08:27 odl01 salt-minion[2105]: -# If you want to provide time to your local subnet, change the next line.
Jan 26 18:08:27 odl01 salt-minion[2105]: -# (Again, the address is an example only.)
Jan 26 18:08:27 odl01 salt-minion[2105]: -#broadcast 192.168.123.255
Jan 26 18:08:27 odl01 salt-minion[2105]: -
Jan 26 18:08:27 odl01 salt-minion[2105]: -# If you want to listen to time broadcasts on your local subnet, de-comment the
Jan 26 18:08:27 odl01 salt-minion[2105]: -# next lines.  Please do this only if you trust everybody on the network!
Jan 26 18:08:27 odl01 salt-minion[2105]: -#disable auth
Jan 26 18:08:27 odl01 salt-minion[2105]: -#broadcastclient
Jan 26 18:08:27 odl01 salt-minion[2105]: -
Jan 26 18:08:27 odl01 salt-minion[2105]: -#Changes recquired to use pps synchonisation as explained in documentation:
Jan 26 18:08:27 odl01 salt-minion[2105]: -#http://www.ntp.org/ntpfaq/NTP-s-config-adv.htm#AEN3918
Jan 26 18:08:27 odl01 salt-minion[2105]: -
Jan 26 18:08:27 odl01 salt-minion[2105]: -#server 127.127.8.1 mode 135 prefer    # Meinberg GPS167 with PPS
Jan 26 18:08:27 odl01 salt-minion[2105]: -#fudge 127.127.8.1 time1 0.0042        # relative to PPS for my hardware
Jan 26 18:08:27 odl01 salt-minion[2105]: -
Jan 26 18:08:27 odl01 salt-minion[2105]: -#server 127.127.22.1                   # ATOM(PPS)
Jan 26 18:08:27 odl01 salt-minion[2105]: -#fudge 127.127.22.1 flag3 1            # enable PPS API
Jan 26 18:08:27 odl01 salt-minion[2105]: +# Location of drift file
Jan 26 18:08:27 odl01 salt-minion[2105]: +driftfile /var/lib/ntp/ntp.drift
Jan 26 18:08:27 odl01 salt-minion[2105]: +logfile /var/log/ntp.log
Jan 26 18:08:27 odl01 salt-minion[2105]: [INFO    ] Completed state [/etc/ntp.conf] at time 18:08:27.168631 duration_in_ms=88.118
Jan 26 18:08:27 odl01 salt-minion[2105]: [INFO    ] Running state [ntp] at time 18:08:27.208512
Jan 26 18:08:27 odl01 salt-minion[2105]: [INFO    ] Executing state service.running for ntp
Jan 26 18:08:27 odl01 salt-minion[2105]: [INFO    ] Executing command ['systemctl', 'status', 'ntp.service', '-n', '0'] in directory '/root'
Jan 26 18:08:27 odl01 salt-minion[2105]: [INFO    ] Executing command ['systemctl', 'is-active', 'ntp.service'] in directory '/root'
Jan 26 18:08:27 odl01 salt-minion[2105]: [INFO    ] Executing command ['systemctl', 'is-enabled', 'ntp.service'] in directory '/root'
Jan 26 18:08:27 odl01 salt-minion[2105]: [INFO    ] The service ntp is already running
Jan 26 18:08:27 odl01 salt-minion[2105]: [INFO    ] Completed state [ntp] at time 18:08:27.258036 duration_in_ms=49.525
Jan 26 18:08:27 odl01 salt-minion[2105]: [INFO    ] Running state [ntp] at time 18:08:27.258300
Jan 26 18:08:27 odl01 salt-minion[2105]: [INFO    ] Executing state service.mod_watch for ntp
Jan 26 18:08:27 odl01 salt-minion[2105]: [INFO    ] Executing command ['systemctl', 'is-active', 'ntp.service'] in directory '/root'
Jan 26 18:08:27 odl01 salt-minion[2105]: [INFO    ] Executing command ['systemctl', 'is-enabled', 'ntp.service'] in directory '/root'
Jan 26 18:08:27 odl01 salt-minion[2105]: [INFO    ] Executing command ['systemd-run', '--scope', 'systemctl', 'restart', 'ntp.service'] in directory '/root'
Jan 26 18:08:27 odl01 systemd[1]: Started /bin/systemctl restart ntp.service.
Jan 26 18:08:27 odl01 systemd[1]: Stopping LSB: Start NTP daemon...
Jan 26 18:08:27 odl01 ntp[8435]:  * Stopping NTP server ntpd
Jan 26 18:08:27 odl01 ntpd[8315]: ntpd exiting on signal 15 (Terminated)
Jan 26 18:08:27 odl01 ntpd[8315]: 162.210.111.4 local addr 10.20.0.34 -> <null>
Jan 26 18:08:27 odl01 ntp[8435]:    ...done.
Jan 26 18:08:27 odl01 systemd[1]: Stopped LSB: Start NTP daemon.
Jan 26 18:08:27 odl01 systemd[1]: Starting LSB: Start NTP daemon...
Jan 26 18:08:27 odl01 ntp[8448]:  * Starting NTP server ntpd
Jan 26 18:08:27 odl01 ntpd[8457]: ntpd 4.2.8p4@1.3265-o Thu Sep  7 20:43:09 UTC 2017 (1): Starting
Jan 26 18:08:27 odl01 ntpd[8457]: Command line: /usr/sbin/ntpd -p /var/run/ntpd.pid -g -u 112:116
Jan 26 18:08:27 odl01 ntp[8448]:    ...done.
Jan 26 18:08:27 odl01 systemd[1]: Started LSB: Start NTP daemon.
Jan 26 18:08:27 odl01 salt-minion[2105]: [INFO    ] {'ntp': True}
Jan 26 18:08:27 odl01 salt-minion[2105]: [INFO    ] Completed state [ntp] at time 18:08:27.384620 duration_in_ms=126.32
Jan 26 18:08:27 odl01 salt-minion[2105]: [INFO    ] Returning information for job: 20180126180818563055
Jan 26 18:08:27 odl01 ntpd[8460]: proto: precision = 0.061 usec (-24)
Jan 26 18:08:27 odl01 ntpd[8460]: switching logging to file /var/log/ntp.log
Jan 26 18:08:30 odl01 salt-minion[2105]: [INFO    ] User sudo_ubuntu Executing command state.sls with jid 20180126180830839859
Jan 26 18:08:30 odl01 salt-minion[2105]: [INFO    ] Starting a new job with PID 8468
Jan 26 18:08:31 odl01 salt-minion[2105]: [INFO    ] Loading fresh modules for state activity
Jan 26 18:08:31 odl01 salt-minion[2105]: [INFO    ] Fetching file from saltenv 'base', ** done ** 'opendaylight/init.sls'
Jan 26 18:08:31 odl01 salt-minion[2105]: [INFO    ] Fetching file from saltenv 'base', ** done ** 'opendaylight/server.sls'
Jan 26 18:08:31 odl01 salt-minion[2105]: [INFO    ] Fetching file from saltenv 'base', ** done ** 'opendaylight/map.jinja'
Jan 26 18:08:31 odl01 salt-minion[2105]: [INFO    ] Running state [apt-key adv --keyserver keyserver.ubuntu.com --recv 44C05248] at time 18:08:31.428397
Jan 26 18:08:31 odl01 salt-minion[2105]: [INFO    ] Executing state cmd.run for apt-key adv --keyserver keyserver.ubuntu.com --recv 44C05248
Jan 26 18:08:31 odl01 salt-minion[2105]: [INFO    ] Executing command 'apt-key adv --keyserver keyserver.ubuntu.com --recv 44C05248' in directory '/root'
Jan 26 18:08:31 odl01 salt-minion[2105]: [INFO    ] {'pid': 8475, 'retcode': 0, 'stderr': 'gpg: requesting key 44C05248 from hkp server keyserver.ubuntu.com\ngpg: key 44C05248: public key "Launchpad PPA for ODL Team" imported\ngpg: Total number processed: 1\ngpg:               imported: 1  (RSA: 1)', 'stdout': 'Executing: /tmp/tmp.gqB6gRRhBA/gpg.1.sh --keyserver\nkeyserver.ubuntu.com\n--recv\n44C05248'}
Jan 26 18:08:31 odl01 salt-minion[2105]: [INFO    ] Completed state [apt-key adv --keyserver keyserver.ubuntu.com --recv 44C05248] at time 18:08:31.734467 duration_in_ms=306.07
Jan 26 18:08:31 odl01 salt-minion[2105]: [INFO    ] Running state [deb http://ppa.launchpad.net/odl-team/nitrogen/ubuntu xenial main] at time 18:08:31.756805
Jan 26 18:08:31 odl01 salt-minion[2105]: [INFO    ] Executing state pkgrepo.managed for deb http://ppa.launchpad.net/odl-team/nitrogen/ubuntu xenial main
Jan 26 18:08:31 odl01 salt-minion[2105]: [INFO    ] Executing command ['apt-get', '-q', 'update'] in directory '/root'
Jan 26 18:08:35 odl01 salt-minion[2105]: [INFO    ] {'repo': 'deb http://ppa.launchpad.net/odl-team/nitrogen/ubuntu xenial main'}
Jan 26 18:08:35 odl01 salt-minion[2105]: [INFO    ] Completed state [deb http://ppa.launchpad.net/odl-team/nitrogen/ubuntu xenial main] at time 18:08:35.804737 duration_in_ms=4047.932
Jan 26 18:08:36 odl01 salt-minion[2105]: [INFO    ] Running state [opendaylight] at time 18:08:36.220893
Jan 26 18:08:36 odl01 salt-minion[2105]: [INFO    ] Executing state pkg.installed for opendaylight
Jan 26 18:08:36 odl01 salt-minion[2105]: [INFO    ] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
Jan 26 18:08:36 odl01 salt-minion[2105]: [INFO    ] Executing command ['apt-cache', '-q', 'policy', 'opendaylight'] in directory '/root'
Jan 26 18:08:36 odl01 salt-minion[2105]: [INFO    ] Executing command ['apt-get', '-q', 'update'] in directory '/root'
Jan 26 18:08:38 odl01 salt-minion[2105]: [INFO    ] Executing command ['dpkg', '--get-selections', '*'] in directory '/root'
Jan 26 18:08:38 odl01 salt-minion[2105]: [INFO    ] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'opendaylight'] in directory '/root'
Jan 26 18:08:38 odl01 systemd[1]: Started /usr/bin/apt-get -q -y -o DPkg::Options::=--force-confold -o DPkg::Options::=--force-confdef install opendaylight.
Jan 26 18:08:40 odl01 salt-minion[2105]: [INFO    ] User sudo_ubuntu Executing command saltutil.find_job with jid 20180126180840929103
Jan 26 18:08:40 odl01 salt-minion[2105]: [INFO    ] Starting a new job with PID 9487
Jan 26 18:08:40 odl01 salt-minion[2105]: [INFO    ] Returning information for job: 20180126180840929103
Jan 26 18:08:51 odl01 salt-minion[2105]: [INFO    ] User sudo_ubuntu Executing command saltutil.find_job with jid 20180126180851145270
Jan 26 18:08:51 odl01 salt-minion[2105]: [INFO    ] Starting a new job with PID 9492
Jan 26 18:08:51 odl01 salt-minion[2105]: [INFO    ] Returning information for job: 20180126180851145270
Jan 26 18:09:01 odl01 salt-minion[2105]: [INFO    ] User sudo_ubuntu Executing command saltutil.find_job with jid 20180126180901367586
Jan 26 18:09:01 odl01 salt-minion[2105]: [INFO    ] Starting a new job with PID 9497
Jan 26 18:09:01 odl01 salt-minion[2105]: [INFO    ] Returning information for job: 20180126180901367586
Jan 26 18:09:11 odl01 salt-minion[2105]: [INFO    ] User sudo_ubuntu Executing command saltutil.find_job with jid 20180126180911573935
Jan 26 18:09:11 odl01 salt-minion[2105]: [INFO    ] Starting a new job with PID 9502
Jan 26 18:09:11 odl01 salt-minion[2105]: [INFO    ] Returning information for job: 20180126180911573935
Jan 26 18:09:21 odl01 salt-minion[2105]: [INFO    ] User sudo_ubuntu Executing command saltutil.find_job with jid 20180126180921790921
Jan 26 18:09:21 odl01 salt-minion[2105]: [INFO    ] Starting a new job with PID 9507
Jan 26 18:09:21 odl01 salt-minion[2105]: [INFO    ] Returning information for job: 20180126180921790921
Jan 26 18:09:32 odl01 salt-minion[2105]: [INFO    ] User sudo_ubuntu Executing command saltutil.find_job with jid 20180126180932005486
Jan 26 18:09:32 odl01 salt-minion[2105]: [INFO    ] Starting a new job with PID 9512
Jan 26 18:09:32 odl01 salt-minion[2105]: [INFO    ] Returning information for job: 20180126180932005486
Jan 26 18:09:42 odl01 salt-minion[2105]: [INFO    ] User sudo_ubuntu Executing command saltutil.find_job with jid 20180126180942217056
Jan 26 18:09:42 odl01 salt-minion[2105]: [INFO    ] Starting a new job with PID 9517
Jan 26 18:09:42 odl01 salt-minion[2105]: [INFO    ] Returning information for job: 20180126180942217056
Jan 26 18:09:52 odl01 salt-minion[2105]: [INFO    ] User sudo_ubuntu Executing command saltutil.find_job with jid 20180126180952243203
Jan 26 18:09:52 odl01 salt-minion[2105]: [INFO    ] Starting a new job with PID 9522
Jan 26 18:09:52 odl01 salt-minion[2105]: [INFO    ] Returning information for job: 20180126180952243203
Jan 26 18:10:02 odl01 salt-minion[2105]: [INFO    ] User sudo_ubuntu Executing command saltutil.find_job with jid 20180126181002459193
Jan 26 18:10:02 odl01 salt-minion[2105]: [INFO    ] Starting a new job with PID 9527
Jan 26 18:10:02 odl01 salt-minion[2105]: [INFO    ] Returning information for job: 20180126181002459193
Jan 26 18:10:12 odl01 salt-minion[2105]: [INFO    ] User sudo_ubuntu Executing command saltutil.find_job with jid 20180126181012674713
Jan 26 18:10:12 odl01 salt-minion[2105]: [INFO    ] Starting a new job with PID 9532
Jan 26 18:10:12 odl01 salt-minion[2105]: [INFO    ] Returning information for job: 20180126181012674713
Jan 26 18:10:22 odl01 salt-minion[2105]: [INFO    ] User sudo_ubuntu Executing command saltutil.find_job with jid 20180126181022904897
Jan 26 18:10:22 odl01 salt-minion[2105]: [INFO    ] Starting a new job with PID 9537
Jan 26 18:10:22 odl01 salt-minion[2105]: [INFO    ] Returning information for job: 20180126181022904897
Jan 26 18:10:33 odl01 salt-minion[2105]: [INFO    ] User sudo_ubuntu Executing command saltutil.find_job with jid 20180126181033128950
Jan 26 18:10:33 odl01 salt-minion[2105]: [INFO    ] Starting a new job with PID 9542
Jan 26 18:10:33 odl01 salt-minion[2105]: [INFO    ] Returning information for job: 20180126181033128950
Jan 26 18:10:43 odl01 salt-minion[2105]: [INFO    ] User sudo_ubuntu Executing command saltutil.find_job with jid 20180126181043148985
Jan 26 18:10:43 odl01 salt-minion[2105]: [INFO    ] Starting a new job with PID 9547
Jan 26 18:10:43 odl01 salt-minion[2105]: [INFO    ] Returning information for job: 20180126181043148985
Jan 26 18:10:53 odl01 salt-minion[2105]: [INFO    ] User sudo_ubuntu Executing command saltutil.find_job with jid 20180126181053179906
Jan 26 18:10:53 odl01 salt-minion[2105]: [INFO    ] Starting a new job with PID 9552
Jan 26 18:10:53 odl01 salt-minion[2105]: [INFO    ] Returning information for job: 20180126181053179906
Jan 26 18:11:03 odl01 salt-minion[2105]: [INFO    ] User sudo_ubuntu Executing command saltutil.find_job with jid 20180126181103202470
Jan 26 18:11:03 odl01 salt-minion[2105]: [INFO    ] Starting a new job with PID 9557
Jan 26 18:11:03 odl01 salt-minion[2105]: [INFO    ] Returning information for job: 20180126181103202470
Jan 26 18:11:13 odl01 salt-minion[2105]: [INFO    ] User sudo_ubuntu Executing command saltutil.find_job with jid 20180126181113224099
Jan 26 18:11:13 odl01 salt-minion[2105]: [INFO    ] Starting a new job with PID 9562
Jan 26 18:11:13 odl01 salt-minion[2105]: [INFO    ] Returning information for job: 20180126181113224099
Jan 26 18:11:23 odl01 salt-minion[2105]: [INFO    ] User sudo_ubuntu Executing command saltutil.find_job with jid 20180126181123244462
Jan 26 18:11:23 odl01 salt-minion[2105]: [INFO    ] Starting a new job with PID 9567
Jan 26 18:11:23 odl01 salt-minion[2105]: [INFO    ] Returning information for job: 20180126181123244462
Jan 26 18:11:33 odl01 salt-minion[2105]: [INFO    ] User sudo_ubuntu Executing command saltutil.find_job with jid 20180126181133272685
Jan 26 18:11:33 odl01 salt-minion[2105]: [INFO    ] Starting a new job with PID 9572
Jan 26 18:11:33 odl01 salt-minion[2105]: [INFO    ] Returning information for job: 20180126181133272685
Jan 26 18:11:43 odl01 salt-minion[2105]: [INFO    ] User sudo_ubuntu Executing command saltutil.find_job with jid 20180126181143314108
Jan 26 18:11:43 odl01 salt-minion[2105]: [INFO    ] Starting a new job with PID 9577
Jan 26 18:11:43 odl01 salt-minion[2105]: [INFO    ] Returning information for job: 20180126181143314108
Jan 26 18:11:53 odl01 salt-minion[2105]: [INFO    ] User sudo_ubuntu Executing command saltutil.find_job with jid 20180126181153349338
Jan 26 18:11:53 odl01 salt-minion[2105]: [INFO    ] Starting a new job with PID 9582
Jan 26 18:11:53 odl01 salt-minion[2105]: [INFO    ] Returning information for job: 20180126181153349338
Jan 26 18:12:03 odl01 salt-minion[2105]: [INFO    ] User sudo_ubuntu Executing command saltutil.find_job with jid 20180126181203381029
Jan 26 18:12:03 odl01 salt-minion[2105]: [INFO    ] Starting a new job with PID 9587
Jan 26 18:12:03 odl01 salt-minion[2105]: [INFO    ] Returning information for job: 20180126181203381029
Jan 26 18:12:13 odl01 salt-minion[2105]: [INFO    ] User sudo_ubuntu Executing command saltutil.find_job with jid 20180126181213417121
Jan 26 18:12:13 odl01 salt-minion[2105]: [INFO    ] Starting a new job with PID 9592
Jan 26 18:12:13 odl01 salt-minion[2105]: [INFO    ] Returning information for job: 20180126181213417121
Jan 26 18:12:23 odl01 salt-minion[2105]: [INFO    ] User sudo_ubuntu Executing command saltutil.find_job with jid 20180126181223448808
Jan 26 18:12:23 odl01 salt-minion[2105]: [INFO    ] Starting a new job with PID 9597
Jan 26 18:12:23 odl01 salt-minion[2105]: [INFO    ] Returning information for job: 20180126181223448808
Jan 26 18:12:33 odl01 salt-minion[2105]: [INFO    ] User sudo_ubuntu Executing command saltutil.find_job with jid 20180126181233480502
Jan 26 18:12:33 odl01 salt-minion[2105]: [INFO    ] Starting a new job with PID 9602
Jan 26 18:12:33 odl01 salt-minion[2105]: [INFO    ] Returning information for job: 20180126181233480502
Jan 26 18:12:43 odl01 salt-minion[2105]: [INFO    ] User sudo_ubuntu Executing command saltutil.find_job with jid 20180126181243518494
Jan 26 18:12:43 odl01 salt-minion[2105]: [INFO    ] Starting a new job with PID 9607
Jan 26 18:12:43 odl01 salt-minion[2105]: [INFO    ] Returning information for job: 20180126181243518494
Jan 26 18:12:53 odl01 salt-minion[2105]: [INFO    ] User sudo_ubuntu Executing command saltutil.find_job with jid 20180126181253561515
Jan 26 18:12:53 odl01 salt-minion[2105]: [INFO    ] Starting a new job with PID 9612
Jan 26 18:12:53 odl01 salt-minion[2105]: [INFO    ] Returning information for job: 20180126181253561515
Jan 26 18:13:03 odl01 salt-minion[2105]: [INFO    ] User sudo_ubuntu Executing command saltutil.find_job with jid 20180126181303606698
Jan 26 18:13:03 odl01 salt-minion[2105]: [INFO    ] Starting a new job with PID 9617
Jan 26 18:13:03 odl01 salt-minion[2105]: [INFO    ] Returning information for job: 20180126181303606698
Jan 26 18:13:13 odl01 salt-minion[2105]: [INFO    ] User sudo_ubuntu Executing command saltutil.find_job with jid 20180126181313673097
Jan 26 18:13:13 odl01 salt-minion[2105]: [INFO    ] Starting a new job with PID 9622
Jan 26 18:13:13 odl01 salt-minion[2105]: [INFO    ] Returning information for job: 20180126181313673097
Jan 26 18:13:23 odl01 salt-minion[2105]: [INFO    ] User sudo_ubuntu Executing command saltutil.find_job with jid 20180126181323729386
Jan 26 18:13:23 odl01 salt-minion[2105]: [INFO    ] Starting a new job with PID 9627
Jan 26 18:13:23 odl01 salt-minion[2105]: [INFO    ] Returning information for job: 20180126181323729386
Jan 26 18:13:33 odl01 salt-minion[2105]: [INFO    ] User sudo_ubuntu Executing command saltutil.find_job with jid 20180126181333778186
Jan 26 18:13:33 odl01 salt-minion[2105]: [INFO    ] Starting a new job with PID 9632
Jan 26 18:13:33 odl01 salt-minion[2105]: [INFO    ] Returning information for job: 20180126181333778186
Jan 26 18:13:43 odl01 salt-minion[2105]: [INFO    ] User sudo_ubuntu Executing command saltutil.find_job with jid 20180126181343848948
Jan 26 18:13:43 odl01 salt-minion[2105]: [INFO    ] Starting a new job with PID 9637
Jan 26 18:13:43 odl01 salt-minion[2105]: [INFO    ] Returning information for job: 20180126181343848948
Jan 26 18:13:53 odl01 salt-minion[2105]: [INFO    ] User sudo_ubuntu Executing command saltutil.find_job with jid 20180126181353921937
Jan 26 18:13:53 odl01 salt-minion[2105]: [INFO    ] Starting a new job with PID 9642
Jan 26 18:13:53 odl01 salt-minion[2105]: [INFO    ] Returning information for job: 20180126181353921937
Jan 26 18:14:04 odl01 salt-minion[2105]: [INFO    ] User sudo_ubuntu Executing command saltutil.find_job with jid 20180126181404001176
Jan 26 18:14:04 odl01 salt-minion[2105]: [INFO    ] Starting a new job with PID 9647
Jan 26 18:14:04 odl01 salt-minion[2105]: [INFO    ] Returning information for job: 20180126181404001176
Jan 26 18:14:14 odl01 salt-minion[2105]: [INFO    ] User sudo_ubuntu Executing command saltutil.find_job with jid 20180126181414060661
Jan 26 18:14:14 odl01 salt-minion[2105]: [INFO    ] Starting a new job with PID 9867
Jan 26 18:14:14 odl01 salt-minion[2105]: [INFO    ] Returning information for job: 20180126181414060661
Jan 26 18:14:24 odl01 salt-minion[2105]: [INFO    ] User sudo_ubuntu Executing command saltutil.find_job with jid 20180126181424112139
Jan 26 18:14:24 odl01 salt-minion[2105]: [INFO    ] Starting a new job with PID 9872
Jan 26 18:14:24 odl01 salt-minion[2105]: [INFO    ] Returning information for job: 20180126181424112139
Jan 26 18:14:33 odl01 systemd[1]: Reloading.
Jan 26 18:14:33 odl01 systemd[1]: Started ACPI event daemon.
Jan 26 18:14:34 odl01 salt-minion[2105]: [INFO    ] User sudo_ubuntu Executing command saltutil.find_job with jid 20180126181434172819
Jan 26 18:14:34 odl01 salt-minion[2105]: [INFO    ] Starting a new job with PID 10835
Jan 26 18:14:34 odl01 salt-minion[2105]: [INFO    ] Returning information for job: 20180126181434172819
Jan 26 18:14:34 odl01 systemd[1]: Reloading.
Jan 26 18:14:34 odl01 systemd[1]: Started ACPI event daemon.
Jan 26 18:14:34 odl01 systemd[1]: Reloading.
Jan 26 18:14:34 odl01 systemd[1]: Started ACPI event daemon.
Jan 26 18:14:36 odl01 systemd[1]: Reloading.
Jan 26 18:14:36 odl01 systemd[1]: Started ACPI event daemon.
Jan 26 18:14:36 odl01 systemd[1]: Reloading.
Jan 26 18:14:36 odl01 systemd[1]: Started ACPI event daemon.
Jan 26 18:14:36 odl01 systemd[1]: Starting OpenDaylight SDN Controller...
Jan 26 18:14:36 odl01 systemd[1]: Started OpenDaylight SDN Controller.
Jan 26 18:14:36 odl01 systemd[1]: Reloading.
Jan 26 18:14:36 odl01 systemd[1]: Started ACPI event daemon.
Jan 26 18:14:38 odl01 salt-minion[2105]: [INFO    ] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
Jan 26 18:14:38 odl01 salt-minion[2105]: [INFO    ] Made the following changes:
Jan 26 18:14:38 odl01 salt-minion[2105]: 'java-common' changed from 'absent' to '0.56ubuntu2'
Jan 26 18:14:38 odl01 salt-minion[2105]: 'libxtst6' changed from 'absent' to '2:1.2.2-1'
Jan 26 18:14:38 odl01 salt-minion[2105]: 'liblcms2-2' changed from 'absent' to '2.6-3ubuntu2'
Jan 26 18:14:38 odl01 salt-minion[2105]: 'openjdk-8-jre-headless' changed from 'absent' to '8u151-b12-0ubuntu0.16.04.2'
Jan 26 18:14:38 odl01 salt-minion[2105]: 'libxrender1' changed from 'absent' to '1:0.9.9-0ubuntu1'
Jan 26 18:14:38 odl01 salt-minion[2105]: 'libavahi-common3' changed from 'absent' to '0.6.32~rc+dfsg-1ubuntu2'
Jan 26 18:14:38 odl01 salt-minion[2105]: 'libnspr4' changed from 'absent' to '2:4.13.1-0ubuntu0.16.04.1'
Jan 26 18:14:38 odl01 salt-minion[2105]: 'libfontconfig' changed from 'absent' to '1'
Jan 26 18:14:38 odl01 salt-minion[2105]: 'fonts-dejavu-core' changed from 'absent' to '2.35-1'
Jan 26 18:14:38 odl01 salt-minion[2105]: 'libnss3-nssdb' changed from 'absent' to '2:3.28.4-0ubuntu0.16.04.3'
Jan 26 18:14:38 odl01 salt-minion[2105]: 'java8-runtime-headless' changed from 'absent' to '1'
Jan 26 18:14:38 odl01 salt-minion[2105]: 'libcups2' changed from 'absent' to '2.1.3-4ubuntu0.3'
Jan 26 18:14:38 odl01 salt-minion[2105]: 'libjpeg-turbo8' changed from 'absent' to '1.4.2-0ubuntu3'
Jan 26 18:14:38 odl01 salt-minion[2105]: 'libavahi-client3' changed from 'absent' to '0.6.32~rc+dfsg-1ubuntu2'
Jan 26 18:14:38 odl01 salt-minion[2105]: 'libnss3' changed from 'absent' to '2:3.28.4-0ubuntu0.16.04.3'
Jan 26 18:14:38 odl01 salt-minion[2105]: 'libpcsclite1' changed from 'absent' to '1.8.14-1ubuntu1.16.04.1'
Jan 26 18:14:38 odl01 salt-minion[2105]: 'java7-runtime-headless' changed from 'absent' to '1'
Jan 26 18:14:38 odl01 salt-minion[2105]: 'ca-certificates-java' changed from 'absent' to '20160321ubuntu1'
Jan 26 18:14:38 odl01 salt-minion[2105]: 'java2-runtime-headless' changed from 'absent' to '1'
Jan 26 18:14:38 odl01 salt-minion[2105]: 'fontconfig-config' changed from 'absent' to '2.11.94-0ubuntu1.1'
Jan 26 18:14:38 odl01 salt-minion[2105]: 'libavahi-common-data' changed from 'absent' to '0.6.32~rc+dfsg-1ubuntu2'
Jan 26 18:14:38 odl01 salt-minion[2105]: 'libxi6' changed from 'absent' to '2:1.7.6-1'
Jan 26 18:14:38 odl01 salt-minion[2105]: 'java5-runtime-headless' changed from 'absent' to '1'
Jan 26 18:14:38 odl01 salt-minion[2105]: 'java6-runtime-headless' changed from 'absent' to '1'
Jan 26 18:14:38 odl01 salt-minion[2105]: 'x11-common' changed from 'absent' to '1:7.7+13ubuntu3'
Jan 26 18:14:38 odl01 salt-minion[2105]: 'libjpeg8' changed from 'absent' to '8c-2ubuntu8'
Jan 26 18:14:38 odl01 salt-minion[2105]: 'opendaylight' changed from 'absent' to '7.0.0-1ppa2'
Jan 26 18:14:38 odl01 salt-minion[2105]: 'libfontconfig1' changed from 'absent' to '2.11.94-0ubuntu1.1'
Jan 26 18:14:38 odl01 salt-minion[2105]: [INFO    ] Loading fresh modules for state activity
Jan 26 18:14:38 odl01 salt-minion[2105]: [INFO    ] Completed state [opendaylight] at time 18:14:38.815479 duration_in_ms=362594.586
Jan 26 18:14:38 odl01 salt-minion[2105]: [INFO    ] Running state [/opt/opendaylight/etc/jetty.xml] at time 18:14:38.866630
Jan 26 18:14:38 odl01 salt-minion[2105]: [INFO    ] Executing state file.managed for /opt/opendaylight/etc/jetty.xml
Jan 26 18:14:38 odl01 salt-minion[2105]: [INFO    ] Fetching file from saltenv 'base', ** done ** 'opendaylight/files/jetty.xml'
Jan 26 18:14:38 odl01 salt-minion[2105]: [INFO    ] File changed:
Jan 26 18:14:38 odl01 salt-minion[2105]: ---
Jan 26 18:14:38 odl01 salt-minion[2105]: +++
Jan 26 18:14:38 odl01 salt-minion[2105]: @@ -79,7 +79,7 @@
Jan 26 18:14:38 odl01 salt-minion[2105]:                          </Item>
Jan 26 18:14:38 odl01 salt-minion[2105]:                      </Array>
Jan 26 18:14:38 odl01 salt-minion[2105]:                  </Arg>
Jan 26 18:14:38 odl01 salt-minion[2105]: -                <Set name="host">
Jan 26 18:14:38 odl01 salt-minion[2105]: +                <Set name="host">172.16.10.111
Jan 26 18:14:38 odl01 salt-minion[2105]:                      <Property name="jetty.host"/>
Jan 26 18:14:38 odl01 salt-minion[2105]:                  </Set>
Jan 26 18:14:38 odl01 salt-minion[2105]:                  <Set name="port">
Jan 26 18:14:38 odl01 salt-minion[2105]: @@ -110,11 +110,11 @@
Jan 26 18:14:38 odl01 salt-minion[2105]:                          </Item>
Jan 26 18:14:38 odl01 salt-minion[2105]:                      </Array>
Jan 26 18:14:38 odl01 salt-minion[2105]:                  </Arg>
Jan 26 18:14:38 odl01 salt-minion[2105]: -                <Set name="host">
Jan 26 18:14:38 odl01 salt-minion[2105]: +                <Set name="host">172.16.10.111
Jan 26 18:14:38 odl01 salt-minion[2105]:                      <Property name="jetty.host"/>
Jan 26 18:14:38 odl01 salt-minion[2105]:                  </Set>
Jan 26 18:14:38 odl01 salt-minion[2105]:                  <Set name="port">
Jan 26 18:14:38 odl01 salt-minion[2105]: -                    <Property name="jetty.port" default="8080"/>
Jan 26 18:14:38 odl01 salt-minion[2105]: +                    <Property name="jetty.port" default="8282"/>
Jan 26 18:14:38 odl01 salt-minion[2105]:                  </Set>
Jan 26 18:14:38 odl01 salt-minion[2105]:                  <Set name="idleTimeout">
Jan 26 18:14:38 odl01 salt-minion[2105]:                      <Property name="http.timeout" default="300000"/>
Jan 26 18:14:38 odl01 salt-minion[2105]: [INFO    ] Completed state [/opt/opendaylight/etc/jetty.xml] at time 18:14:38.942876 duration_in_ms=76.247
Jan 26 18:14:38 odl01 salt-minion[2105]: [INFO    ] Running state [/opt/opendaylight/bin/setenv] at time 18:14:38.943272
Jan 26 18:14:38 odl01 salt-minion[2105]: [INFO    ] Executing state file.managed for /opt/opendaylight/bin/setenv
Jan 26 18:14:38 odl01 salt-minion[2105]: [INFO    ] Fetching file from saltenv 'base', ** done ** 'opendaylight/files/setenv.shell'
Jan 26 18:14:39 odl01 salt-minion[2105]: [INFO    ] File changed:
Jan 26 18:14:39 odl01 salt-minion[2105]: ---
Jan 26 18:14:39 odl01 salt-minion[2105]: +++
Jan 26 18:14:39 odl01 salt-minion[2105]: @@ -1,46 +1,15 @@
Jan 26 18:14:39 odl01 salt-minion[2105]: -#!/bin/sh
Jan 26 18:14:39 odl01 salt-minion[2105]: -#
Jan 26 18:14:39 odl01 salt-minion[2105]: -#    Licensed to the Apache Software Foundation (ASF) under one or more
Jan 26 18:14:39 odl01 salt-minion[2105]: -#    contributor license agreements.  See the NOTICE file distributed with
Jan 26 18:14:39 odl01 salt-minion[2105]: -#    this work for additional information regarding copyright ownership.
Jan 26 18:14:39 odl01 salt-minion[2105]: -#    The ASF licenses this file to You under the Apache License, Version 2.0
Jan 26 18:14:39 odl01 salt-minion[2105]: -#    (the "License"); you may not use this file except in compliance with
Jan 26 18:14:39 odl01 salt-minion[2105]: -#    the License.  You may obtain a copy of the License at
Jan 26 18:14:39 odl01 salt-minion[2105]: -#
Jan 26 18:14:39 odl01 salt-minion[2105]: -#       http://www.apache.org/licenses/LICENSE-2.0
Jan 26 18:14:39 odl01 salt-minion[2105]: -#
Jan 26 18:14:39 odl01 salt-minion[2105]: -#    Unless required by applicable law or agreed to in writing, software
Jan 26 18:14:39 odl01 salt-minion[2105]: -#    distributed under the License is distributed on an "AS IS" BASIS,
Jan 26 18:14:39 odl01 salt-minion[2105]: -#    WITHOUT WARRANTIES OR CONDITIONS OF ANY KIND, either express or implied.
Jan 26 18:14:39 odl01 salt-minion[2105]: -#    See the License for the specific language governing permissions and
Jan 26 18:14:39 odl01 salt-minion[2105]: -#    limitations under the License.
Jan 26 18:14:39 odl01 salt-minion[2105]: -#
Jan 26 18:14:39 odl01 salt-minion[2105]: -
Jan 26 18:14:39 odl01 salt-minion[2105]: -#
Jan 26 18:14:39 odl01 salt-minion[2105]: -# handle specific scripts; the SCRIPT_NAME is exactly the name of the Karaf
Jan 26 18:14:39 odl01 salt-minion[2105]: -# script: client, instance, shell, start, status, stop, karaf
Jan 26 18:14:39 odl01 salt-minion[2105]: -#
Jan 26 18:14:39 odl01 salt-minion[2105]: -# if [ "$KARAF_SCRIPT" == "SCRIPT_NAME" ]; then
Jan 26 18:14:39 odl01 salt-minion[2105]: -#   Actions go here...
Jan 26 18:14:39 odl01 salt-minion[2105]: -# fi
Jan 26 18:14:39 odl01 salt-minion[2105]: -
Jan 26 18:14:39 odl01 salt-minion[2105]: -#
Jan 26 18:14:39 odl01 salt-minion[2105]: -# general settings which should be applied for all scripts go here; please keep
Jan 26 18:14:39 odl01 salt-minion[2105]: -# in mind that it is possible that scripts might be executed more than once, e.g.
Jan 26 18:14:39 odl01 salt-minion[2105]: -# in example of the start script where the start script is executed first and the
Jan 26 18:14:39 odl01 salt-minion[2105]: -# karaf script afterwards.
Jan 26 18:14:39 odl01 salt-minion[2105]: -#
Jan 26 18:14:39 odl01 salt-minion[2105]: -
Jan 26 18:14:39 odl01 salt-minion[2105]: -#
Jan 26 18:14:39 odl01 salt-minion[2105]: -# The following section shows the possible configuration options for the default
Jan 26 18:14:39 odl01 salt-minion[2105]: -# karaf scripts
Jan 26 18:14:39 odl01 salt-minion[2105]: -#
Jan 26 18:14:39 odl01 salt-minion[2105]: -# export JAVA_HOME # Location of Java installation
Jan 26 18:14:39 odl01 salt-minion[2105]: -# export JAVA_MIN_MEM # Minimum memory for the JVM
Jan 26 18:14:39 odl01 salt-minion[2105]: -# export JAVA_MAX_MEM # Maximum memory for the JVM
Jan 26 18:14:39 odl01 salt-minion[2105]: +##############################################################################
Jan 26 18:14:39 odl01 salt-minion[2105]: +# Copyright (c) 2017 Mirantis Inc. and others.
Jan 26 18:14:39 odl01 salt-minion[2105]: +# All rights reserved. This program and the accompanying materials
Jan 26 18:14:39 odl01 salt-minion[2105]: +# are made available under the terms of the Apache License, Version 2.0
Jan 26 18:14:39 odl01 salt-minion[2105]: +# which accompanies this distribution, and is available at
Jan 26 18:14:39 odl01 salt-minion[2105]: +# http://www.apache.org/licenses/LICENSE-2.0
Jan 26 18:14:39 odl01 salt-minion[2105]: +############################################################################### export JAVA_HOME # Location of Java installation
Jan 26 18:14:39 odl01 salt-minion[2105]: +export JAVA_MIN_MEM=3g # Minimum memory for the JVM
Jan 26 18:14:39 odl01 salt-minion[2105]: +export JAVA_MAX_MEM=3g # Maximum memory for the JVM
Jan 26 18:14:39 odl01 salt-minion[2105]:  # export JAVA_PERM_MEM # Minimum perm memory for the JVM
Jan 26 18:14:39 odl01 salt-minion[2105]: -# export JAVA_MAX_PERM_MEM # Maximum perm memory for the JVM
Jan 26 18:14:39 odl01 salt-minion[2105]: -# export EXTRA_JAVA_OPTS # Additional JVM options
Jan 26 18:14:39 odl01 salt-minion[2105]: +export JAVA_MAX_PERM_MEM=512m # Maximum perm memory for the JVM
Jan 26 18:14:39 odl01 salt-minion[2105]: +export EXTRA_JAVA_OPTS='-Djava.net.preferIPv4Stack=true -XX:+UseG1GC' # Additional JVM options
Jan 26 18:14:39 odl01 salt-minion[2105]:  # export KARAF_HOME # Karaf home folder
Jan 26 18:14:39 odl01 salt-minion[2105]:  # export KARAF_DATA # Karaf data folder
Jan 26 18:14:39 odl01 salt-minion[2105]:  # export KARAF_BASE # Karaf base folder
Jan 26 18:14:39 odl01 salt-minion[2105]: @@ -48,7 +17,4 @@
Jan 26 18:14:39 odl01 salt-minion[2105]:  # export KARAF_OPTS # Additional available Karaf options
Jan 26 18:14:39 odl01 salt-minion[2105]:  # export KARAF_DEBUG # Enable debug mode
Jan 26 18:14:39 odl01 salt-minion[2105]:  # export KARAF_REDIRECT # Enable/set the std/err redirection when using bin/start
Jan 26 18:14:39 odl01 salt-minion[2105]: -# export KARAF_NOROOT # Prevent execution as root if set to true
Jan 26 18:14:39 odl01 salt-minion[2105]: -if [ "x$JAVA_MAX_MEM" = "x" ]; then
Jan 26 18:14:39 odl01 salt-minion[2105]: -    export JAVA_MAX_MEM="2048m"
Jan 26 18:14:39 odl01 salt-minion[2105]: -fi
Jan 26 18:14:39 odl01 salt-minion[2105]: +
Jan 26 18:14:39 odl01 salt-minion[2105]: [INFO    ] Completed state [/opt/opendaylight/bin/setenv] at time 18:14:39.010372 duration_in_ms=67.099
Jan 26 18:14:39 odl01 salt-minion[2105]: [INFO    ] Running state [/opt/opendaylight/etc/org.apache.karaf.features.cfg] at time 18:14:39.014863
Jan 26 18:14:39 odl01 salt-minion[2105]: [INFO    ] Executing state ini.options_present for /opt/opendaylight/etc/org.apache.karaf.features.cfg
Jan 26 18:14:39 odl01 salt-minion[2105]: [INFO    ] {'featuresBoot': {'after': 'standard,wrap,ssh,odl-restconf-all,odl-aaa-authn,odl-dlux-all,odl-mdsal-apidocs,odl-netvirt-openstack', 'before': '\\\n    standard, \\\n    wrap'}}
Jan 26 18:14:39 odl01 salt-minion[2105]: [INFO    ] Completed state [/opt/opendaylight/etc/org.apache.karaf.features.cfg] at time 18:14:39.036228 duration_in_ms=21.365
Jan 26 18:14:39 odl01 salt-minion[2105]: [INFO    ] Running state [/opt/opendaylight/etc/org.ops4j.pax.web.cfg] at time 18:14:39.036827
Jan 26 18:14:39 odl01 salt-minion[2105]: [INFO    ] Executing state ini.options_present for /opt/opendaylight/etc/org.ops4j.pax.web.cfg
Jan 26 18:14:39 odl01 salt-minion[2105]: [INFO    ] {'org.ops4j.pax.web.listening.addresses': {'after': '172.16.10.111', 'before': None}}
Jan 26 18:14:39 odl01 salt-minion[2105]: [INFO    ] Completed state [/opt/opendaylight/etc/org.ops4j.pax.web.cfg] at time 18:14:39.038872 duration_in_ms=2.045
Jan 26 18:14:39 odl01 salt-minion[2105]: [INFO    ] Running state [/opt/opendaylight/etc/custom.properties] at time 18:14:39.039374
Jan 26 18:14:39 odl01 salt-minion[2105]: [INFO    ] Executing state ini.options_present for /opt/opendaylight/etc/custom.properties
Jan 26 18:14:39 odl01 salt-minion[2105]: [INFO    ] {'ovsdb.l3.fwd.enabled': {'after': 'yes', 'before': None}, 'ovsdb.of.version': {'after': '1.3', 'before': None}}
Jan 26 18:14:39 odl01 salt-minion[2105]: [INFO    ] Completed state [/opt/opendaylight/etc/custom.properties] at time 18:14:39.068249 duration_in_ms=28.875
Jan 26 18:14:39 odl01 salt-minion[2105]: [INFO    ] Running state [opendaylight] at time 18:14:39.068953
Jan 26 18:14:39 odl01 salt-minion[2105]: [INFO    ] Executing state service.running for opendaylight
Jan 26 18:14:39 odl01 salt-minion[2105]: [INFO    ] Executing command ['systemctl', 'status', 'opendaylight.service', '-n', '0'] in directory '/root'
Jan 26 18:14:39 odl01 salt-minion[2105]: [INFO    ] Executing command ['systemctl', 'is-active', 'opendaylight.service'] in directory '/root'
Jan 26 18:14:39 odl01 salt-minion[2105]: [INFO    ] Executing command ['systemctl', 'is-enabled', 'opendaylight.service'] in directory '/root'
Jan 26 18:14:39 odl01 salt-minion[2105]: [INFO    ] The service opendaylight is already running
Jan 26 18:14:39 odl01 salt-minion[2105]: [INFO    ] Completed state [opendaylight] at time 18:14:39.127662 duration_in_ms=58.707
Jan 26 18:14:39 odl01 salt-minion[2105]: [INFO    ] Running state [opendaylight] at time 18:14:39.128115
Jan 26 18:14:39 odl01 salt-minion[2105]: [INFO    ] Executing state service.mod_watch for opendaylight
Jan 26 18:14:39 odl01 salt-minion[2105]: [INFO    ] Executing command ['systemctl', 'is-active', 'opendaylight.service'] in directory '/root'
Jan 26 18:14:39 odl01 salt-minion[2105]: [INFO    ] Executing command ['systemctl', 'is-enabled', 'opendaylight.service'] in directory '/root'
Jan 26 18:14:39 odl01 salt-minion[2105]: [INFO    ] Executing command ['systemd-run', '--scope', 'systemctl', 'restart', 'opendaylight.service'] in directory '/root'
Jan 26 18:14:39 odl01 systemd[1]: Started /bin/systemctl restart opendaylight.service.
Jan 26 18:14:39 odl01 systemd[1]: Stopping OpenDaylight SDN Controller...
Jan 26 18:14:39 odl01 systemd[1]: Stopped OpenDaylight SDN Controller.
Jan 26 18:14:39 odl01 systemd[1]: Starting OpenDaylight SDN Controller...
Jan 26 18:14:39 odl01 systemd[1]: Started OpenDaylight SDN Controller.
Jan 26 18:14:39 odl01 salt-minion[2105]: [INFO    ] {'opendaylight': True}
Jan 26 18:14:39 odl01 salt-minion[2105]: [INFO    ] Completed state [opendaylight] at time 18:14:39.602695 duration_in_ms=474.579
Jan 26 18:14:39 odl01 salt-minion[2105]: [INFO    ] Returning information for job: 20180126180830839859
Jan 26 18:17:01 odl01 CRON[13028]: (root) CMD (   cd / && run-parts --report /etc/cron.hourly)
Jan 26 18:17:01 odl01 systemd[1]: Starting Cleanup of Temporary Directories...
Jan 26 18:17:01 odl01 systemd-tmpfiles[13027]: [/usr/lib/tmpfiles.d/var.conf:14] Duplicate line for path "/var/log", ignoring.
Jan 26 18:17:01 odl01 systemd[1]: Started Cleanup of Temporary Directories.
Jan 26 18:26:09 odl01 dhclient[908]: DHCPREQUEST of 10.20.0.34 on ens3 to 10.20.0.1 port 67 (xid=0x21676d8b)
Jan 26 18:26:09 odl01 dhclient[908]: DHCPACK of 10.20.0.34 from 10.20.0.1
Jan 26 18:26:09 odl01 dhclient[908]: bound to 10.20.0.34 -- renewal in 1345 seconds.
Jan 26 18:34:08 odl01 salt-minion[2105]: [INFO    ] User sudo_ubuntu Executing command cp.push_dir with jid 20180126183408900328
Jan 26 18:34:08 odl01 salt-minion[2105]: [INFO    ] Starting a new job with PID 13570
Jan 26 18:34:09 odl01 salt-minion[2105]: [INFO    ] Returning information for job: 20180126183408900328
Jan 26 18:48:34 odl01 dhclient[908]: DHCPREQUEST of 10.20.0.34 on ens3 to 10.20.0.1 port 67 (xid=0x21676d8b)
Jan 26 18:48:34 odl01 dhclient[908]: DHCPACK of 10.20.0.34 from 10.20.0.1
Jan 26 18:48:34 odl01 dhclient[908]: bound to 10.20.0.34 -- renewal in 1432 seconds.
Jan 26 19:06:37 odl01 salt-minion[2105]: [INFO    ] Running scheduled job: __mine_interval
Jan 26 19:12:26 odl01 dhclient[908]: DHCPREQUEST of 10.20.0.34 on ens3 to 10.20.0.1 port 67 (xid=0x21676d8b)
Jan 26 19:12:26 odl01 dhclient[908]: DHCPACK of 10.20.0.34 from 10.20.0.1
Jan 26 19:12:26 odl01 dhclient[908]: bound to 10.20.0.34 -- renewal in 1188 seconds.
Jan 26 19:17:01 odl01 CRON[14208]: (root) CMD (   cd / && run-parts --report /etc/cron.hourly)
Jan 26 19:32:14 odl01 dhclient[908]: DHCPREQUEST of 10.20.0.34 on ens3 to 10.20.0.1 port 67 (xid=0x21676d8b)
Jan 26 19:32:14 odl01 dhclient[908]: DHCPACK of 10.20.0.34 from 10.20.0.1
Jan 26 19:32:14 odl01 dhclient[908]: bound to 10.20.0.34 -- renewal in 1506 seconds.
Jan 26 19:57:20 odl01 dhclient[908]: DHCPREQUEST of 10.20.0.34 on ens3 to 10.20.0.1 port 67 (xid=0x21676d8b)
Jan 26 19:57:20 odl01 dhclient[908]: DHCPACK of 10.20.0.34 from 10.20.0.1
Jan 26 19:57:20 odl01 dhclient[908]: bound to 10.20.0.34 -- renewal in 1285 seconds.
Jan 26 20:06:37 odl01 salt-minion[2105]: [INFO    ] Running scheduled job: __mine_interval
Jan 26 20:17:01 odl01 CRON[14878]: (root) CMD (   cd / && run-parts --report /etc/cron.hourly)
Jan 26 20:18:45 odl01 dhclient[908]: DHCPREQUEST of 10.20.0.34 on ens3 to 10.20.0.1 port 67 (xid=0x21676d8b)
Jan 26 20:18:45 odl01 dhclient[908]: DHCPACK of 10.20.0.34 from 10.20.0.1
Jan 26 20:18:45 odl01 dhclient[908]: bound to 10.20.0.34 -- renewal in 1427 seconds.
Jan 26 20:42:32 odl01 dhclient[908]: DHCPREQUEST of 10.20.0.34 on ens3 to 10.20.0.1 port 67 (xid=0x21676d8b)
Jan 26 20:42:32 odl01 dhclient[908]: DHCPACK of 10.20.0.34 from 10.20.0.1
Jan 26 20:42:32 odl01 dhclient[908]: bound to 10.20.0.34 -- renewal in 1619 seconds.
Jan 26 20:56:01 odl01 CRON[15221]: (root) CMD (   test -x /etc/cron.daily/popularity-contest && /etc/cron.daily/popularity-contest --crond)
Jan 26 21:06:37 odl01 salt-minion[2105]: [INFO    ] Running scheduled job: __mine_interval
Jan 26 21:09:31 odl01 dhclient[908]: DHCPREQUEST of 10.20.0.34 on ens3 to 10.20.0.1 port 67 (xid=0x21676d8b)
Jan 26 21:09:31 odl01 dhclient[908]: DHCPACK of 10.20.0.34 from 10.20.0.1
Jan 26 21:09:31 odl01 dhclient[908]: bound to 10.20.0.34 -- renewal in 1329 seconds.
Jan 26 21:17:01 odl01 CRON[15424]: (root) CMD (   cd / && run-parts --report /etc/cron.hourly)
Jan 26 21:31:40 odl01 dhclient[908]: DHCPREQUEST of 10.20.0.34 on ens3 to 10.20.0.1 port 67 (xid=0x21676d8b)
Jan 26 21:31:40 odl01 dhclient[908]: DHCPACK of 10.20.0.34 from 10.20.0.1
Jan 26 21:31:40 odl01 dhclient[908]: bound to 10.20.0.34 -- renewal in 1450 seconds.
Jan 26 21:54:07 odl01 kernel: [13933.680901] hrtimer: interrupt took 1321840 ns
Jan 26 21:55:51 odl01 dhclient[908]: DHCPREQUEST of 10.20.0.34 on ens3 to 10.20.0.1 port 67 (xid=0x21676d8b)
Jan 26 21:55:51 odl01 dhclient[908]: DHCPACK of 10.20.0.34 from 10.20.0.1
Jan 26 21:55:51 odl01 dhclient[908]: bound to 10.20.0.34 -- renewal in 1603 seconds.
Jan 26 22:06:37 odl01 salt-minion[2105]: [INFO    ] Running scheduled job: __mine_interval
Jan 26 22:17:01 odl01 CRON[16236]: (root) CMD (   cd / && run-parts --report /etc/cron.hourly)
Jan 26 22:22:34 odl01 dhclient[908]: DHCPREQUEST of 10.20.0.34 on ens3 to 10.20.0.1 port 67 (xid=0x21676d8b)
Jan 26 22:22:34 odl01 dhclient[908]: DHCPACK of 10.20.0.34 from 10.20.0.1
Jan 26 22:22:34 odl01 dhclient[908]: bound to 10.20.0.34 -- renewal in 1569 seconds.
Jan 26 22:48:43 odl01 dhclient[908]: DHCPREQUEST of 10.20.0.34 on ens3 to 10.20.0.1 port 67 (xid=0x21676d8b)
Jan 26 22:48:43 odl01 dhclient[908]: DHCPACK of 10.20.0.34 from 10.20.0.1
Jan 26 22:48:43 odl01 dhclient[908]: bound to 10.20.0.34 -- renewal in 1225 seconds.
Jan 26 23:06:37 odl01 salt-minion[2105]: [INFO    ] Running scheduled job: __mine_interval
Jan 26 23:09:08 odl01 dhclient[908]: DHCPREQUEST of 10.20.0.34 on ens3 to 10.20.0.1 port 67 (xid=0x21676d8b)
Jan 26 23:09:08 odl01 dhclient[908]: DHCPACK of 10.20.0.34 from 10.20.0.1
Jan 26 23:09:08 odl01 dhclient[908]: bound to 10.20.0.34 -- renewal in 1409 seconds.
Jan 26 23:13:11 odl01 salt-minion[2105]: [INFO    ] User sudo_ubuntu Executing command cp.push_dir with jid 20180126231311233461
Jan 26 23:13:11 odl01 salt-minion[2105]: [INFO    ] Starting a new job with PID 17038
