2018-05-11 04:01:41,650 [salt.loaded.int.module.cmdmod][ERROR   ][1870] 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
2018-05-11 04:01:45,129 [salt.loaded.int.module.cmdmod][INFO    ][2441] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2018-05-11 04:01:45,159 [salt.loaded.int.module.cmdmod][INFO    ][2441] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2018-05-11 04:01:45,210 [salt.loaded.int.module.cmdmod][INFO    ][2441] Executing command ['systemd-run', '--scope', 'systemctl', 'restart', 'salt-minion.service'] in directory '/root'
2018-05-11 04:01:45,247 [salt.utils.parsers][WARNING ][1662] Minion received a SIGTERM. Exiting.
2018-05-11 04:01:45,767 [salt.cli.daemons ][INFO    ][2517] Setting up the Salt Minion "odl01.mcp-pike-odl-ha.local"
2018-05-11 04:01:45,867 [salt.cli.daemons ][INFO    ][2517] Starting up the Salt Minion
2018-05-11 04:01:45,868 [salt.utils.event ][INFO    ][2517] Starting pull socket on /var/run/salt/minion/minion_event_6c7e1bdd60_pull.ipc
2018-05-11 04:01:46,579 [salt.minion      ][INFO    ][2517] Creating minion process manager
2018-05-11 04:01:47,750 [salt.loader.192.168.11.2.int.module.cmdmod][INFO    ][2517] Executing command ['date', '+%z'] in directory '/root'
2018-05-11 04:01:47,783 [salt.utils.schedule][INFO    ][2517] Updating job settings for scheduled job: __mine_interval
2018-05-11 04:01:47,793 [salt.minion      ][INFO    ][2517] Added mine.update to scheduler
2018-05-11 04:01:47,808 [salt.minion      ][INFO    ][2517] Minion is starting as user 'root'
2018-05-11 04:01:47,830 [salt.minion      ][INFO    ][2517] Minion is ready to receive requests!
2018-05-11 04:01:48,833 [salt.utils.schedule][INFO    ][2517] Running scheduled job: __mine_interval
2018-05-11 04:03:14,542 [salt.minion      ][INFO    ][2517] User sudo_ubuntu Executing command state.apply with jid 20180511040314534297
2018-05-11 04:03:14,570 [salt.minion      ][INFO    ][2612] Starting a new job with PID 2612
2018-05-11 04:03:17,496 [salt.state       ][INFO    ][2612] Loading fresh modules for state activity
2018-05-11 04:03:17,630 [salt.fileclient  ][INFO    ][2612] Fetching file from saltenv 'base', ** done ** 'linux/init.sls'
2018-05-11 04:03:17,701 [salt.fileclient  ][INFO    ][2612] Fetching file from saltenv 'base', ** done ** 'linux/system/init.sls'
2018-05-11 04:03:17,899 [salt.fileclient  ][INFO    ][2612] Fetching file from saltenv 'base', ** done ** 'linux/system/env.sls'
2018-05-11 04:03:18,079 [salt.fileclient  ][INFO    ][2612] Fetching file from saltenv 'base', ** done ** 'linux/system/profile.sls'
2018-05-11 04:03:18,195 [salt.fileclient  ][INFO    ][2612] Fetching file from saltenv 'base', ** done ** 'linux/system/repo.sls'
2018-05-11 04:03:18,335 [salt.fileclient  ][INFO    ][2612] Fetching file from saltenv 'base', ** done ** 'linux/system/package.sls'
2018-05-11 04:03:18,413 [salt.fileclient  ][INFO    ][2612] Fetching file from saltenv 'base', ** done ** 'linux/system/timezone.sls'
2018-05-11 04:03:18,489 [salt.fileclient  ][INFO    ][2612] Fetching file from saltenv 'base', ** done ** 'linux/system/kernel.sls'
2018-05-11 04:03:18,672 [salt.fileclient  ][INFO    ][2612] Fetching file from saltenv 'base', ** done ** 'linux/system/cpu.sls'
2018-05-11 04:03:18,744 [salt.fileclient  ][INFO    ][2612] Fetching file from saltenv 'base', ** done ** 'linux/system/sysfs.sls'
2018-05-11 04:03:18,816 [salt.fileclient  ][INFO    ][2612] Fetching file from saltenv 'base', ** done ** 'linux/system/locale.sls'
2018-05-11 04:03:18,902 [salt.fileclient  ][INFO    ][2612] Fetching file from saltenv 'base', ** done ** 'linux/system/user.sls'
2018-05-11 04:03:19,007 [salt.fileclient  ][INFO    ][2612] Fetching file from saltenv 'base', ** done ** 'linux/system/group.sls'
2018-05-11 04:03:19,101 [salt.fileclient  ][INFO    ][2612] Fetching file from saltenv 'base', ** done ** 'linux/system/limit.sls'
2018-05-11 04:03:19,174 [salt.fileclient  ][INFO    ][2612] Fetching file from saltenv 'base', ** done ** 'linux/system/systemd.sls'
2018-05-11 04:03:19,285 [salt.fileclient  ][INFO    ][2612] Fetching file from saltenv 'base', ** done ** 'linux/system/apt.sls'
2018-05-11 04:03:19,369 [salt.fileclient  ][INFO    ][2612] Fetching file from saltenv 'base', ** done ** 'linux/network/init.sls'
2018-05-11 04:03:19,970 [salt.fileclient  ][INFO    ][2612] Fetching file from saltenv 'base', ** done ** 'linux/network/hostname.sls'
2018-05-11 04:03:20,068 [salt.fileclient  ][INFO    ][2612] Fetching file from saltenv 'base', ** done ** 'linux/network/host.sls'
2018-05-11 04:03:20,182 [salt.fileclient  ][INFO    ][2612] Fetching file from saltenv 'base', ** done ** 'linux/network/interface.sls'
2018-05-11 04:03:20,364 [salt.fileclient  ][INFO    ][2612] Fetching file from saltenv 'base', ** done ** 'linux/network/proxy.sls'
2018-05-11 04:03:20,487 [salt.fileclient  ][INFO    ][2612] Fetching file from saltenv 'base', ** done ** 'linux/storage/init.sls'
2018-05-11 04:03:20,583 [salt.fileclient  ][INFO    ][2612] Fetching file from saltenv 'base', ** done ** 'ntp/init.sls'
2018-05-11 04:03:20,599 [salt.fileclient  ][INFO    ][2612] Fetching file from saltenv 'base', ** done ** 'ntp/client.sls'
2018-05-11 04:03:20,635 [salt.fileclient  ][INFO    ][2612] Fetching file from saltenv 'base', ** done ** 'ntp/server.sls'
2018-05-11 04:03:20,662 [salt.state       ][INFO    ][2612] Running state [/etc/environment] at time 04:03:20.662818
2018-05-11 04:03:20,663 [salt.state       ][INFO    ][2612] Executing state file.blockreplace for /etc/environment
2018-05-11 04:03:20,669 [salt.state       ][INFO    ][2612] File changed:
--- 
+++ 
@@ -1 +1,4 @@
 PATH="/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/games:/usr/local/games"
+# SALT MANAGED VARIABLES - DO NOT EDIT - START
+# +# SALT MANAGED VARIABLES - END

2018-05-11 04:03:20,670 [salt.state       ][INFO    ][2612] Completed state [/etc/environment] at time 04:03:20.670413 duration_in_ms=7.595
2018-05-11 04:03:20,670 [salt.state       ][INFO    ][2612] Running state [/etc/profile.d] at time 04:03:20.670798
2018-05-11 04:03:20,671 [salt.state       ][INFO    ][2612] Executing state file.directory for /etc/profile.d
2018-05-11 04:03:20,679 [salt.state       ][INFO    ][2612] Directory /etc/profile.d is in the correct state
2018-05-11 04:03:20,679 [salt.state       ][INFO    ][2612] Completed state [/etc/profile.d] at time 04:03:20.679491 duration_in_ms=8.693
2018-05-11 04:03:21,147 [salt.state       ][INFO    ][2612] Running state [/etc/apt/apt.conf.d/99prefer_ipv4-salt] at time 04:03:21.147015
2018-05-11 04:03:21,147 [salt.state       ][INFO    ][2612] Executing state file.managed for /etc/apt/apt.conf.d/99prefer_ipv4-salt
2018-05-11 04:03:21,174 [salt.fileclient  ][INFO    ][2612] Fetching file from saltenv 'base', ** done ** 'linux/files/apt.conf'
2018-05-11 04:03:21,180 [salt.state       ][INFO    ][2612] File changed:
New file
2018-05-11 04:03:21,180 [salt.state       ][INFO    ][2612] Completed state [/etc/apt/apt.conf.d/99prefer_ipv4-salt] at time 04:03:21.180773 duration_in_ms=33.758
2018-05-11 04:03:21,181 [salt.state       ][INFO    ][2612] Running state [linux_repo_prereq_pkgs] at time 04:03:21.181490
2018-05-11 04:03:21,181 [salt.state       ][INFO    ][2612] Executing state pkg.installed for linux_repo_prereq_pkgs
2018-05-11 04:03:21,182 [salt.loaded.int.module.cmdmod][INFO    ][2612] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2018-05-11 04:03:21,507 [salt.state       ][INFO    ][2612] All specified packages are already installed
2018-05-11 04:03:21,508 [salt.state       ][INFO    ][2612] Completed state [linux_repo_prereq_pkgs] at time 04:03:21.508227 duration_in_ms=326.736
2018-05-11 04:03:21,508 [salt.state       ][INFO    ][2612] Running state [/etc/apt/apt.conf.d/99proxies-salt-uca-staging] at time 04:03:21.508726
2018-05-11 04:03:21,509 [salt.state       ][INFO    ][2612] Executing state file.absent for /etc/apt/apt.conf.d/99proxies-salt-uca-staging
2018-05-11 04:03:21,509 [salt.state       ][INFO    ][2612] File /etc/apt/apt.conf.d/99proxies-salt-uca-staging is not present
2018-05-11 04:03:21,510 [salt.state       ][INFO    ][2612] Completed state [/etc/apt/apt.conf.d/99proxies-salt-uca-staging] at time 04:03:21.510135 duration_in_ms=1.409
2018-05-11 04:03:21,510 [salt.state       ][INFO    ][2612] Running state [/etc/apt/preferences.d/uca-staging] at time 04:03:21.510508
2018-05-11 04:03:21,510 [salt.state       ][INFO    ][2612] Executing state file.absent for /etc/apt/preferences.d/uca-staging
2018-05-11 04:03:21,511 [salt.state       ][INFO    ][2612] File /etc/apt/preferences.d/uca-staging is not present
2018-05-11 04:03:21,511 [salt.state       ][INFO    ][2612] Completed state [/etc/apt/preferences.d/uca-staging] at time 04:03:21.511659 duration_in_ms=1.151
2018-05-11 04:03:21,513 [salt.state       ][INFO    ][2612] Running state [apt-key adv --keyserver keyserver.ubuntu.com --recv 9F68104E] at time 04:03:21.513437
2018-05-11 04:03:21,513 [salt.state       ][INFO    ][2612] Executing state cmd.run for apt-key adv --keyserver keyserver.ubuntu.com --recv 9F68104E
2018-05-11 04:03:21,514 [salt.loaded.int.module.cmdmod][INFO    ][2612] Executing command 'apt-key adv --keyserver keyserver.ubuntu.com --recv 9F68104E' in directory '/root'
2018-05-11 04:03:22,151 [salt.state       ][INFO    ][2612] {'pid': 2671, 'retcode': 0, 'stderr': 'gpg: requesting key 9F68104E from hkp server keyserver.ubuntu.com\ngpg: key 9F68104E: public key "Launchpad PPA for Ubuntu Cloud Archive Team" imported\ngpg: Total number processed: 1\ngpg:               imported: 1  (RSA: 1)', 'stdout': 'Executing: /tmp/tmp.0YPebAndsd/gpg.1.sh --keyserver\nkeyserver.ubuntu.com\n--recv\n9F68104E'}
2018-05-11 04:03:22,153 [salt.state       ][INFO    ][2612] Completed state [apt-key adv --keyserver keyserver.ubuntu.com --recv 9F68104E] at time 04:03:22.153360 duration_in_ms=639.921
2018-05-11 04:03:22,190 [salt.state       ][INFO    ][2612] Running state [deb http://ppa.launchpad.net/ubuntu-cloud-archive/pike-staging/ubuntu xenial main] at time 04:03:22.190682
2018-05-11 04:03:22,191 [salt.state       ][INFO    ][2612] Executing state pkgrepo.managed for deb http://ppa.launchpad.net/ubuntu-cloud-archive/pike-staging/ubuntu xenial main
2018-05-11 04:03:22,315 [salt.loaded.int.module.cmdmod][INFO    ][2612] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2018-05-11 04:03:24,654 [salt.minion      ][INFO    ][2517] User sudo_ubuntu Executing command saltutil.find_job with jid 20180511040324636283
2018-05-11 04:03:24,689 [salt.minion      ][INFO    ][3099] Starting a new job with PID 3099
2018-05-11 04:03:24,711 [salt.minion      ][INFO    ][3099] Returning information for job: 20180511040324636283
2018-05-11 04:03:26,164 [salt.state       ][INFO    ][2612] {'repo': 'deb http://ppa.launchpad.net/ubuntu-cloud-archive/pike-staging/ubuntu xenial main'}
2018-05-11 04:03:26,165 [salt.state       ][INFO    ][2612] Completed state [deb http://ppa.launchpad.net/ubuntu-cloud-archive/pike-staging/ubuntu xenial main] at time 04:03:26.165332 duration_in_ms=3974.651
2018-05-11 04:03:26,166 [salt.state       ][INFO    ][2612] Running state [/etc/apt/apt.conf.d/99proxies-salt-uca] at time 04:03:26.166266
2018-05-11 04:03:26,167 [salt.state       ][INFO    ][2612] Executing state file.absent for /etc/apt/apt.conf.d/99proxies-salt-uca
2018-05-11 04:03:26,168 [salt.state       ][INFO    ][2612] File /etc/apt/apt.conf.d/99proxies-salt-uca is not present
2018-05-11 04:03:26,169 [salt.state       ][INFO    ][2612] Completed state [/etc/apt/apt.conf.d/99proxies-salt-uca] at time 04:03:26.169447 duration_in_ms=3.181
2018-05-11 04:03:26,170 [salt.state       ][INFO    ][2612] Running state [/etc/apt/preferences.d/uca] at time 04:03:26.170312
2018-05-11 04:03:26,171 [salt.state       ][INFO    ][2612] Executing state file.absent for /etc/apt/preferences.d/uca
2018-05-11 04:03:26,172 [salt.state       ][INFO    ][2612] File /etc/apt/preferences.d/uca is not present
2018-05-11 04:03:26,173 [salt.state       ][INFO    ][2612] Completed state [/etc/apt/preferences.d/uca] at time 04:03:26.173032 duration_in_ms=2.72
2018-05-11 04:03:26,173 [salt.state       ][INFO    ][2612] Running state [apt-key adv --keyserver keyserver.ubuntu.com --recv EC4926EA] at time 04:03:26.173931
2018-05-11 04:03:26,174 [salt.state       ][INFO    ][2612] Executing state cmd.run for apt-key adv --keyserver keyserver.ubuntu.com --recv EC4926EA
2018-05-11 04:03:26,176 [salt.loaded.int.module.cmdmod][INFO    ][2612] Executing command 'apt-key adv --keyserver keyserver.ubuntu.com --recv EC4926EA' in directory '/root'
2018-05-11 04:03:26,564 [salt.state       ][INFO    ][2612] {'pid': 3107, 'retcode': 0, 'stderr': 'gpg: requesting key EC4926EA from hkp server keyserver.ubuntu.com\ngpg: key EC4926EA: public key "Canonical Cloud Archive Signing Key <ftpmaster@canonical.com>" imported\ngpg: Total number processed: 1\ngpg:               imported: 1  (RSA: 1)', 'stdout': 'Executing: /tmp/tmp.XJos2Nf9Qe/gpg.1.sh --keyserver\nkeyserver.ubuntu.com\n--recv\nEC4926EA'}
2018-05-11 04:03:26,565 [salt.state       ][INFO    ][2612] Completed state [apt-key adv --keyserver keyserver.ubuntu.com --recv EC4926EA] at time 04:03:26.565590 duration_in_ms=391.66
2018-05-11 04:03:26,567 [salt.state       ][INFO    ][2612] Running state [deb http://ubuntu-cloud.archive.canonical.com/ubuntu xenial-updates/pike main] at time 04:03:26.567803
2018-05-11 04:03:26,568 [salt.state       ][INFO    ][2612] Executing state pkgrepo.managed for deb http://ubuntu-cloud.archive.canonical.com/ubuntu xenial-updates/pike main
2018-05-11 04:03:26,639 [salt.loaded.int.module.cmdmod][INFO    ][2612] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2018-05-11 04:03:30,932 [salt.state       ][INFO    ][2612] {'repo': 'deb http://ubuntu-cloud.archive.canonical.com/ubuntu xenial-updates/pike main'}
2018-05-11 04:03:30,933 [salt.state       ][INFO    ][2612] Completed state [deb http://ubuntu-cloud.archive.canonical.com/ubuntu xenial-updates/pike main] at time 04:03:30.933354 duration_in_ms=4365.551
2018-05-11 04:03:30,942 [salt.state       ][INFO    ][2612] Running state [UTC] at time 04:03:30.942745
2018-05-11 04:03:30,943 [salt.state       ][INFO    ][2612] Executing state timezone.system for UTC
2018-05-11 04:03:30,943 [salt.loaded.int.module.cmdmod][INFO    ][2612] Executing command ['timedatectl'] in directory '/root'
2018-05-11 04:03:31,025 [salt.loaded.int.module.cmdmod][INFO    ][2612] Executing command ['timedatectl'] in directory '/root'
2018-05-11 04:03:31,038 [salt.loaded.int.module.cmdmod][INFO    ][2612] Executing command 'timedatectl set-timezone UTC' in directory '/root'
2018-05-11 04:03:31,058 [salt.state       ][INFO    ][2612] {'timezone': 'UTC'}
2018-05-11 04:03:31,059 [salt.state       ][INFO    ][2612] Completed state [UTC] at time 04:03:31.059362 duration_in_ms=116.617
2018-05-11 04:03:31,067 [salt.state       ][INFO    ][2612] Running state [nf_conntrack] at time 04:03:31.067776
2018-05-11 04:03:31,068 [salt.state       ][INFO    ][2612] Executing state kmod.present for nf_conntrack
2018-05-11 04:03:31,069 [salt.loaded.int.module.cmdmod][INFO    ][2612] Executing command 'lsmod' in directory '/root'
2018-05-11 04:03:31,882 [salt.loaded.int.module.cmdmod][INFO    ][2612] Executing command 'lsmod' in directory '/root'
2018-05-11 04:03:31,903 [salt.loaded.int.module.cmdmod][INFO    ][2612] Executing command 'modprobe nf_conntrack' in directory '/root'
2018-05-11 04:03:31,938 [salt.loaded.int.module.cmdmod][INFO    ][2612] Executing command 'lsmod' in directory '/root'
2018-05-11 04:03:32,024 [salt.state       ][INFO    ][2612] {'nf_conntrack': 'loaded'}
2018-05-11 04:03:32,024 [salt.state       ][INFO    ][2612] Completed state [nf_conntrack] at time 04:03:32.024597 duration_in_ms=956.827
2018-05-11 04:03:32,028 [salt.state       ][INFO    ][2612] Running state [kernel.panic] at time 04:03:32.028954
2018-05-11 04:03:32,029 [salt.state       ][INFO    ][2612] Executing state sysctl.present for kernel.panic
2018-05-11 04:03:32,043 [salt.loaded.int.module.cmdmod][INFO    ][2612] Executing command 'sysctl -a' in directory '/root'
2018-05-11 04:03:32,106 [salt.loaded.int.module.cmdmod][INFO    ][2612] Executing command 'sysctl -w kernel.panic="60"' in directory '/root'
2018-05-11 04:03:32,118 [salt.state       ][INFO    ][2612] {'kernel.panic': 60}
2018-05-11 04:03:32,119 [salt.state       ][INFO    ][2612] Completed state [kernel.panic] at time 04:03:32.119196 duration_in_ms=90.24
2018-05-11 04:03:32,119 [salt.state       ][INFO    ][2612] Running state [net.ipv4.tcp_keepalive_probes] at time 04:03:32.119550
2018-05-11 04:03:32,119 [salt.state       ][INFO    ][2612] Executing state sysctl.present for net.ipv4.tcp_keepalive_probes
2018-05-11 04:03:32,120 [salt.loaded.int.module.cmdmod][INFO    ][2612] Executing command 'sysctl -a' in directory '/root'
2018-05-11 04:03:32,151 [salt.loaded.int.module.cmdmod][INFO    ][2612] Executing command 'sysctl -w net.ipv4.tcp_keepalive_probes="8"' in directory '/root'
2018-05-11 04:03:32,166 [salt.state       ][INFO    ][2612] {'net.ipv4.tcp_keepalive_probes': 8}
2018-05-11 04:03:32,167 [salt.state       ][INFO    ][2612] Completed state [net.ipv4.tcp_keepalive_probes] at time 04:03:32.167211 duration_in_ms=47.661
2018-05-11 04:03:32,167 [salt.state       ][INFO    ][2612] Running state [fs.file-max] at time 04:03:32.167532
2018-05-11 04:03:32,167 [salt.state       ][INFO    ][2612] Executing state sysctl.present for fs.file-max
2018-05-11 04:03:32,168 [salt.loaded.int.module.cmdmod][INFO    ][2612] Executing command 'sysctl -a' in directory '/root'
2018-05-11 04:03:32,195 [salt.loaded.int.module.cmdmod][INFO    ][2612] Executing command 'sysctl -w fs.file-max="124165"' in directory '/root'
2018-05-11 04:03:32,210 [salt.state       ][INFO    ][2612] {'fs.file-max': 124165}
2018-05-11 04:03:32,210 [salt.state       ][INFO    ][2612] Completed state [fs.file-max] at time 04:03:32.210879 duration_in_ms=43.346
2018-05-11 04:03:32,211 [salt.state       ][INFO    ][2612] Running state [net.core.somaxconn] at time 04:03:32.211179
2018-05-11 04:03:32,211 [salt.state       ][INFO    ][2612] Executing state sysctl.present for net.core.somaxconn
2018-05-11 04:03:32,212 [salt.loaded.int.module.cmdmod][INFO    ][2612] Executing command 'sysctl -a' in directory '/root'
2018-05-11 04:03:32,248 [salt.loaded.int.module.cmdmod][INFO    ][2612] Executing command 'sysctl -w net.core.somaxconn="4096"' in directory '/root'
2018-05-11 04:03:32,259 [salt.state       ][INFO    ][2612] {'net.core.somaxconn': 4096}
2018-05-11 04:03:32,260 [salt.state       ][INFO    ][2612] Completed state [net.core.somaxconn] at time 04:03:32.260134 duration_in_ms=48.954
2018-05-11 04:03:32,260 [salt.state       ][INFO    ][2612] Running state [net.ipv4.tcp_max_syn_backlog] at time 04:03:32.260434
2018-05-11 04:03:32,260 [salt.state       ][INFO    ][2612] Executing state sysctl.present for net.ipv4.tcp_max_syn_backlog
2018-05-11 04:03:32,261 [salt.loaded.int.module.cmdmod][INFO    ][2612] Executing command 'sysctl -a' in directory '/root'
2018-05-11 04:03:32,287 [salt.loaded.int.module.cmdmod][INFO    ][2612] Executing command 'sysctl -w net.ipv4.tcp_max_syn_backlog="8192"' in directory '/root'
2018-05-11 04:03:32,300 [salt.state       ][INFO    ][2612] {'net.ipv4.tcp_max_syn_backlog': 8192}
2018-05-11 04:03:32,301 [salt.state       ][INFO    ][2612] Completed state [net.ipv4.tcp_max_syn_backlog] at time 04:03:32.301070 duration_in_ms=40.635
2018-05-11 04:03:32,301 [salt.state       ][INFO    ][2612] Running state [net.ipv4.tcp_tw_reuse] at time 04:03:32.301482
2018-05-11 04:03:32,301 [salt.state       ][INFO    ][2612] Executing state sysctl.present for net.ipv4.tcp_tw_reuse
2018-05-11 04:03:32,302 [salt.loaded.int.module.cmdmod][INFO    ][2612] Executing command 'sysctl -a' in directory '/root'
2018-05-11 04:03:32,328 [salt.loaded.int.module.cmdmod][INFO    ][2612] Executing command 'sysctl -w net.ipv4.tcp_tw_reuse="1"' in directory '/root'
2018-05-11 04:03:32,340 [salt.state       ][INFO    ][2612] {'net.ipv4.tcp_tw_reuse': 1}
2018-05-11 04:03:32,340 [salt.state       ][INFO    ][2612] Completed state [net.ipv4.tcp_tw_reuse] at time 04:03:32.340653 duration_in_ms=39.171
2018-05-11 04:03:32,341 [salt.state       ][INFO    ][2612] Running state [net.ipv4.tcp_congestion_control] at time 04:03:32.341078
2018-05-11 04:03:32,341 [salt.state       ][INFO    ][2612] Executing state sysctl.present for net.ipv4.tcp_congestion_control
2018-05-11 04:03:32,342 [salt.loaded.int.module.cmdmod][INFO    ][2612] Executing command 'sysctl -a' in directory '/root'
2018-05-11 04:03:32,370 [salt.loaded.int.module.cmdmod][INFO    ][2612] Executing command 'sysctl -w net.ipv4.tcp_congestion_control="yeah"' in directory '/root'
2018-05-11 04:03:32,403 [salt.state       ][INFO    ][2612] {'net.ipv4.tcp_congestion_control': 'yeah'}
2018-05-11 04:03:32,404 [salt.state       ][INFO    ][2612] Completed state [net.ipv4.tcp_congestion_control] at time 04:03:32.404053 duration_in_ms=62.974
2018-05-11 04:03:32,404 [salt.state       ][INFO    ][2612] Running state [net.ipv4.tcp_retries2] at time 04:03:32.404785
2018-05-11 04:03:32,405 [salt.state       ][INFO    ][2612] Executing state sysctl.present for net.ipv4.tcp_retries2
2018-05-11 04:03:32,406 [salt.loaded.int.module.cmdmod][INFO    ][2612] Executing command 'sysctl -a' in directory '/root'
2018-05-11 04:03:32,453 [salt.loaded.int.module.cmdmod][INFO    ][2612] Executing command 'sysctl -w net.ipv4.tcp_retries2="5"' in directory '/root'
2018-05-11 04:03:32,472 [salt.state       ][INFO    ][2612] {'net.ipv4.tcp_retries2': 5}
2018-05-11 04:03:32,473 [salt.state       ][INFO    ][2612] Completed state [net.ipv4.tcp_retries2] at time 04:03:32.472955 duration_in_ms=68.17
2018-05-11 04:03:32,473 [salt.state       ][INFO    ][2612] Running state [net.core.netdev_max_backlog] at time 04:03:32.473538
2018-05-11 04:03:32,474 [salt.state       ][INFO    ][2612] Executing state sysctl.present for net.core.netdev_max_backlog
2018-05-11 04:03:32,475 [salt.loaded.int.module.cmdmod][INFO    ][2612] Executing command 'sysctl -a' in directory '/root'
2018-05-11 04:03:32,522 [salt.loaded.int.module.cmdmod][INFO    ][2612] Executing command 'sysctl -w net.core.netdev_max_backlog="261144"' in directory '/root'
2018-05-11 04:03:32,536 [salt.state       ][INFO    ][2612] {'net.core.netdev_max_backlog': 261144}
2018-05-11 04:03:32,537 [salt.state       ][INFO    ][2612] Completed state [net.core.netdev_max_backlog] at time 04:03:32.536925 duration_in_ms=63.388
2018-05-11 04:03:32,537 [salt.state       ][INFO    ][2612] Running state [net.ipv4.tcp_slow_start_after_idle] at time 04:03:32.537283
2018-05-11 04:03:32,537 [salt.state       ][INFO    ][2612] Executing state sysctl.present for net.ipv4.tcp_slow_start_after_idle
2018-05-11 04:03:32,538 [salt.loaded.int.module.cmdmod][INFO    ][2612] Executing command 'sysctl -a' in directory '/root'
2018-05-11 04:03:32,570 [salt.loaded.int.module.cmdmod][INFO    ][2612] Executing command 'sysctl -w net.ipv4.tcp_slow_start_after_idle="0"' in directory '/root'
2018-05-11 04:03:32,594 [salt.state       ][INFO    ][2612] {'net.ipv4.tcp_slow_start_after_idle': 0}
2018-05-11 04:03:32,594 [salt.state       ][INFO    ][2612] Completed state [net.ipv4.tcp_slow_start_after_idle] at time 04:03:32.594882 duration_in_ms=57.599
2018-05-11 04:03:32,595 [salt.state       ][INFO    ][2612] Running state [vm.swappiness] at time 04:03:32.595234
2018-05-11 04:03:32,595 [salt.state       ][INFO    ][2612] Executing state sysctl.present for vm.swappiness
2018-05-11 04:03:32,596 [salt.loaded.int.module.cmdmod][INFO    ][2612] Executing command 'sysctl -a' in directory '/root'
2018-05-11 04:03:32,651 [salt.loaded.int.module.cmdmod][INFO    ][2612] Executing command 'sysctl -w vm.swappiness="10"' in directory '/root'
2018-05-11 04:03:32,671 [salt.state       ][INFO    ][2612] {'vm.swappiness': 10}
2018-05-11 04:03:32,671 [salt.state       ][INFO    ][2612] Completed state [vm.swappiness] at time 04:03:32.671570 duration_in_ms=76.336
2018-05-11 04:03:32,671 [salt.state       ][INFO    ][2612] Running state [net.ipv4.tcp_keepalive_intvl] at time 04:03:32.671881
2018-05-11 04:03:32,672 [salt.state       ][INFO    ][2612] Executing state sysctl.present for net.ipv4.tcp_keepalive_intvl
2018-05-11 04:03:32,672 [salt.loaded.int.module.cmdmod][INFO    ][2612] Executing command 'sysctl -a' in directory '/root'
2018-05-11 04:03:32,717 [salt.loaded.int.module.cmdmod][INFO    ][2612] Executing command 'sysctl -w net.ipv4.tcp_keepalive_intvl="3"' in directory '/root'
2018-05-11 04:03:32,734 [salt.state       ][INFO    ][2612] {'net.ipv4.tcp_keepalive_intvl': 3}
2018-05-11 04:03:32,735 [salt.state       ][INFO    ][2612] Completed state [net.ipv4.tcp_keepalive_intvl] at time 04:03:32.735142 duration_in_ms=63.26
2018-05-11 04:03:32,735 [salt.state       ][INFO    ][2612] Running state [net.ipv4.neigh.default.gc_thresh1] at time 04:03:32.735600
2018-05-11 04:03:32,735 [salt.state       ][INFO    ][2612] Executing state sysctl.present for net.ipv4.neigh.default.gc_thresh1
2018-05-11 04:03:32,736 [salt.loaded.int.module.cmdmod][INFO    ][2612] Executing command 'sysctl -a' in directory '/root'
2018-05-11 04:03:32,796 [salt.loaded.int.module.cmdmod][INFO    ][2612] Executing command 'sysctl -w net.ipv4.neigh.default.gc_thresh1="4096"' in directory '/root'
2018-05-11 04:03:32,816 [salt.state       ][INFO    ][2612] {'net.ipv4.neigh.default.gc_thresh1': 4096}
2018-05-11 04:03:32,816 [salt.state       ][INFO    ][2612] Completed state [net.ipv4.neigh.default.gc_thresh1] at time 04:03:32.816607 duration_in_ms=81.006
2018-05-11 04:03:32,817 [salt.state       ][INFO    ][2612] Running state [net.ipv4.neigh.default.gc_thresh2] at time 04:03:32.817184
2018-05-11 04:03:32,817 [salt.state       ][INFO    ][2612] Executing state sysctl.present for net.ipv4.neigh.default.gc_thresh2
2018-05-11 04:03:32,818 [salt.loaded.int.module.cmdmod][INFO    ][2612] Executing command 'sysctl -a' in directory '/root'
2018-05-11 04:03:32,877 [salt.loaded.int.module.cmdmod][INFO    ][2612] Executing command 'sysctl -w net.ipv4.neigh.default.gc_thresh2="8192"' in directory '/root'
2018-05-11 04:03:32,898 [salt.state       ][INFO    ][2612] {'net.ipv4.neigh.default.gc_thresh2': 8192}
2018-05-11 04:03:32,898 [salt.state       ][INFO    ][2612] Completed state [net.ipv4.neigh.default.gc_thresh2] at time 04:03:32.898893 duration_in_ms=81.709
2018-05-11 04:03:32,899 [salt.state       ][INFO    ][2612] Running state [net.ipv4.neigh.default.gc_thresh3] at time 04:03:32.899333
2018-05-11 04:03:32,899 [salt.state       ][INFO    ][2612] Executing state sysctl.present for net.ipv4.neigh.default.gc_thresh3
2018-05-11 04:03:32,900 [salt.loaded.int.module.cmdmod][INFO    ][2612] Executing command 'sysctl -a' in directory '/root'
2018-05-11 04:03:32,934 [salt.loaded.int.module.cmdmod][INFO    ][2612] Executing command 'sysctl -w net.ipv4.neigh.default.gc_thresh3="16384"' in directory '/root'
2018-05-11 04:03:32,959 [salt.state       ][INFO    ][2612] {'net.ipv4.neigh.default.gc_thresh3': 16384}
2018-05-11 04:03:32,959 [salt.state       ][INFO    ][2612] Completed state [net.ipv4.neigh.default.gc_thresh3] at time 04:03:32.959524 duration_in_ms=60.19
2018-05-11 04:03:32,959 [salt.state       ][INFO    ][2612] Running state [net.ipv4.tcp_fin_timeout] at time 04:03:32.959840
2018-05-11 04:03:32,960 [salt.state       ][INFO    ][2612] Executing state sysctl.present for net.ipv4.tcp_fin_timeout
2018-05-11 04:03:32,960 [salt.loaded.int.module.cmdmod][INFO    ][2612] Executing command 'sysctl -a' in directory '/root'
2018-05-11 04:03:33,014 [salt.loaded.int.module.cmdmod][INFO    ][2612] Executing command 'sysctl -w net.ipv4.tcp_fin_timeout="30"' in directory '/root'
2018-05-11 04:03:33,036 [salt.state       ][INFO    ][2612] {'net.ipv4.tcp_fin_timeout': 30}
2018-05-11 04:03:33,036 [salt.state       ][INFO    ][2612] Completed state [net.ipv4.tcp_fin_timeout] at time 04:03:33.036698 duration_in_ms=76.856
2018-05-11 04:03:33,037 [salt.state       ][INFO    ][2612] Running state [net.ipv4.tcp_keepalive_time] at time 04:03:33.037140
2018-05-11 04:03:33,037 [salt.state       ][INFO    ][2612] Executing state sysctl.present for net.ipv4.tcp_keepalive_time
2018-05-11 04:03:33,038 [salt.loaded.int.module.cmdmod][INFO    ][2612] Executing command 'sysctl -a' in directory '/root'
2018-05-11 04:03:33,078 [salt.loaded.int.module.cmdmod][INFO    ][2612] Executing command 'sysctl -w net.ipv4.tcp_keepalive_time="30"' in directory '/root'
2018-05-11 04:03:33,098 [salt.state       ][INFO    ][2612] {'net.ipv4.tcp_keepalive_time': 30}
2018-05-11 04:03:33,098 [salt.state       ][INFO    ][2612] Completed state [net.ipv4.tcp_keepalive_time] at time 04:03:33.098692 duration_in_ms=61.552
2018-05-11 04:03:33,099 [salt.state       ][INFO    ][2612] Running state [net.nf_conntrack_max] at time 04:03:33.099152
2018-05-11 04:03:33,099 [salt.state       ][INFO    ][2612] Executing state sysctl.present for net.nf_conntrack_max
2018-05-11 04:03:33,102 [salt.loaded.int.module.cmdmod][INFO    ][2612] Executing command 'sysctl -a' in directory '/root'
2018-05-11 04:03:33,141 [salt.loaded.int.module.cmdmod][INFO    ][2612] Executing command 'sysctl -w net.nf_conntrack_max="1048576"' in directory '/root'
2018-05-11 04:03:33,153 [salt.state       ][INFO    ][2612] {'net.nf_conntrack_max': 1048576}
2018-05-11 04:03:33,154 [salt.state       ][INFO    ][2612] Completed state [net.nf_conntrack_max] at time 04:03:33.154307 duration_in_ms=55.155
2018-05-11 04:03:33,154 [salt.state       ][INFO    ][2612] Running state [linux_sysfs_package] at time 04:03:33.154754
2018-05-11 04:03:33,155 [salt.state       ][INFO    ][2612] Executing state pkg.installed for linux_sysfs_package
2018-05-11 04:03:33,170 [salt.loaded.int.module.cmdmod][INFO    ][2612] Executing command ['apt-cache', '-q', 'policy', 'sysfsutils'] in directory '/root'
2018-05-11 04:03:33,221 [salt.loaded.int.module.cmdmod][INFO    ][2612] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2018-05-11 04:03:34,736 [salt.minion      ][INFO    ][2517] User sudo_ubuntu Executing command saltutil.find_job with jid 20180511040334728854
2018-05-11 04:03:34,785 [salt.minion      ][INFO    ][3989] Starting a new job with PID 3989
2018-05-11 04:03:34,810 [salt.minion      ][INFO    ][3989] Returning information for job: 20180511040334728854
2018-05-11 04:03:34,881 [salt.loaded.int.module.cmdmod][INFO    ][2612] Executing command ['dpkg', '--get-selections', '*'] in directory '/root'
2018-05-11 04:03:34,913 [salt.loaded.int.module.cmdmod][INFO    ][2612] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'sysfsutils'] in directory '/root'
2018-05-11 04:03:42,294 [salt.loaded.int.module.cmdmod][INFO    ][2612] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2018-05-11 04:03:42,341 [salt.state       ][INFO    ][2612] Made the following changes:
'libsysfs2' changed from 'absent' to '2.1.0+repack-4'
'sysfsutils' changed from 'absent' to '2.1.0+repack-4'

2018-05-11 04:03:42,360 [salt.state       ][INFO    ][2612] Loading fresh modules for state activity
2018-05-11 04:03:42,385 [salt.state       ][INFO    ][2612] Completed state [linux_sysfs_package] at time 04:03:42.385392 duration_in_ms=9230.636
2018-05-11 04:03:42,389 [salt.state       ][INFO    ][2612] Running state [/etc/sysfs.d] at time 04:03:42.389728
2018-05-11 04:03:42,390 [salt.state       ][INFO    ][2612] Executing state file.directory for /etc/sysfs.d
2018-05-11 04:03:42,393 [salt.state       ][INFO    ][2612] Directory /etc/sysfs.d is in the correct state
2018-05-11 04:03:42,393 [salt.state       ][INFO    ][2612] Completed state [/etc/sysfs.d] at time 04:03:42.393345 duration_in_ms=3.617
2018-05-11 04:03:42,708 [salt.state       ][INFO    ][2612] Running state [ondemand] at time 04:03:42.708431
2018-05-11 04:03:42,709 [salt.state       ][INFO    ][2612] Executing state service.dead for ondemand
2018-05-11 04:03:42,710 [salt.loaded.int.module.cmdmod][INFO    ][2612] Executing command ['systemctl', 'status', 'ondemand.service', '-n', '0'] in directory '/root'
2018-05-11 04:03:42,730 [salt.loaded.int.module.cmdmod][INFO    ][2612] Executing command ['systemctl', 'is-active', 'ondemand.service'] in directory '/root'
2018-05-11 04:03:42,748 [salt.loaded.int.module.cmdmod][INFO    ][2612] Executing command ['systemctl', 'is-enabled', 'ondemand.service'] in directory '/root'
2018-05-11 04:03:42,778 [salt.loaded.int.module.cmdmod][INFO    ][2612] Executing command ['systemd-run', '--scope', 'systemctl', 'stop', 'ondemand.service'] in directory '/root'
2018-05-11 04:03:42,866 [salt.loaded.int.module.cmdmod][INFO    ][2612] Executing command ['systemctl', 'is-active', 'ondemand.service'] in directory '/root'
2018-05-11 04:03:42,887 [salt.loaded.int.module.cmdmod][INFO    ][2612] Executing command ['systemctl', 'is-enabled', 'ondemand.service'] in directory '/root'
2018-05-11 04:03:42,917 [salt.loaded.int.module.cmdmod][INFO    ][2612] Executing command ['systemctl', 'is-enabled', 'ondemand.service'] in directory '/root'
2018-05-11 04:03:42,940 [salt.loaded.int.module.cmdmod][INFO    ][2612] Executing command ['systemd-run', '--scope', '/usr/sbin/update-rc.d', '-f', 'ondemand', 'remove'] in directory '/root'
2018-05-11 04:03:43,110 [salt.loaded.int.module.cmdmod][INFO    ][2612] Executing command ['systemctl', 'is-enabled', 'ondemand.service'] in directory '/root'
2018-05-11 04:03:43,134 [salt.loaded.int.module.cmdmod][INFO    ][2612] Executing command 'runlevel' in directory '/root'
2018-05-11 04:03:43,151 [salt.state       ][INFO    ][2612] {'ondemand': True}
2018-05-11 04:03:43,152 [salt.state       ][INFO    ][2612] Completed state [ondemand] at time 04:03:43.152355 duration_in_ms=443.925
2018-05-11 04:03:43,163 [salt.state       ][INFO    ][2612] Running state [cs_CZ.UTF-8] at time 04:03:43.163584
2018-05-11 04:03:43,163 [salt.state       ][INFO    ][2612] Executing state locale.present for cs_CZ.UTF-8
2018-05-11 04:03:43,164 [salt.loaded.int.module.cmdmod][INFO    ][2612] Executing command 'locale -a' in directory '/root'
2018-05-11 04:03:43,184 [salt.loaded.int.module.cmdmod][INFO    ][2612] Executing command ['locale-gen', 'cs_CZ.utf8'] in directory '/root'
2018-05-11 04:03:43,924 [salt.state       ][INFO    ][2612] {'locale': 'cs_CZ.UTF-8'}
2018-05-11 04:03:43,924 [salt.state       ][INFO    ][2612] Completed state [cs_CZ.UTF-8] at time 04:03:43.924593 duration_in_ms=761.008
2018-05-11 04:03:43,925 [salt.state       ][INFO    ][2612] Running state [en_US.UTF-8] at time 04:03:43.925198
2018-05-11 04:03:43,925 [salt.state       ][INFO    ][2612] Executing state locale.present for en_US.UTF-8
2018-05-11 04:03:43,926 [salt.loaded.int.module.cmdmod][INFO    ][2612] Executing command 'locale -a' in directory '/root'
2018-05-11 04:03:43,950 [salt.state       ][INFO    ][2612] Locale en_US.UTF-8 is already present
2018-05-11 04:03:43,951 [salt.state       ][INFO    ][2612] Completed state [en_US.UTF-8] at time 04:03:43.951745 duration_in_ms=26.544
2018-05-11 04:03:43,954 [salt.state       ][INFO    ][2612] Running state [en_US.UTF-8] at time 04:03:43.954787
2018-05-11 04:03:43,955 [salt.state       ][INFO    ][2612] Executing state locale.system for en_US.UTF-8
2018-05-11 04:03:43,956 [salt.loaded.int.module.cmdmod][INFO    ][2612] Executing command 'localectl' in directory '/root'
2018-05-11 04:03:44,044 [salt.state       ][INFO    ][2612] System locale en_US.UTF-8 already set
2018-05-11 04:03:44,045 [salt.state       ][INFO    ][2612] Completed state [en_US.UTF-8] at time 04:03:44.044964 duration_in_ms=90.176
2018-05-11 04:03:44,053 [salt.state       ][INFO    ][2612] Running state [root] at time 04:03:44.053154
2018-05-11 04:03:44,053 [salt.state       ][INFO    ][2612] Executing state group.present for root
2018-05-11 04:03:44,054 [salt.state       ][INFO    ][2612] Group root is present and up to date
2018-05-11 04:03:44,054 [salt.state       ][INFO    ][2612] Completed state [root] at time 04:03:44.054854 duration_in_ms=1.699
2018-05-11 04:03:44,064 [salt.state       ][INFO    ][2612] Running state [root] at time 04:03:44.064031
2018-05-11 04:03:44,064 [salt.state       ][INFO    ][2612] Executing state user.present for root
2018-05-11 04:03:44,066 [salt.state       ][INFO    ][2612] User root is present and up to date
2018-05-11 04:03:44,066 [salt.state       ][INFO    ][2612] Completed state [root] at time 04:03:44.066609 duration_in_ms=2.578
2018-05-11 04:03:44,067 [salt.state       ][INFO    ][2612] Running state [/root] at time 04:03:44.067759
2018-05-11 04:03:44,068 [salt.state       ][INFO    ][2612] Executing state file.directory for /root
2018-05-11 04:03:44,069 [salt.state       ][INFO    ][2612] Directory /root is in the correct state
2018-05-11 04:03:44,069 [salt.state       ][INFO    ][2612] Completed state [/root] at time 04:03:44.069334 duration_in_ms=1.574
2018-05-11 04:03:44,069 [salt.state       ][INFO    ][2612] Running state [/etc/sudoers.d/90-salt-user-root] at time 04:03:44.069675
2018-05-11 04:03:44,070 [salt.state       ][INFO    ][2612] Executing state file.absent for /etc/sudoers.d/90-salt-user-root
2018-05-11 04:03:44,070 [salt.state       ][INFO    ][2612] File /etc/sudoers.d/90-salt-user-root is not present
2018-05-11 04:03:44,070 [salt.state       ][INFO    ][2612] Completed state [/etc/sudoers.d/90-salt-user-root] at time 04:03:44.070755 duration_in_ms=1.08
2018-05-11 04:03:44,071 [salt.state       ][INFO    ][2612] Running state [ubuntu] at time 04:03:44.071098
2018-05-11 04:03:44,071 [salt.state       ][INFO    ][2612] Executing state group.present for ubuntu
2018-05-11 04:03:44,071 [salt.state       ][INFO    ][2612] Group ubuntu is present and up to date
2018-05-11 04:03:44,072 [salt.state       ][INFO    ][2612] Completed state [ubuntu] at time 04:03:44.072191 duration_in_ms=1.092
2018-05-11 04:03:44,073 [salt.state       ][INFO    ][2612] Running state [ubuntu] at time 04:03:44.073180
2018-05-11 04:03:44,073 [salt.state       ][INFO    ][2612] Executing state user.present for ubuntu
2018-05-11 04:03:44,076 [salt.state       ][INFO    ][2612] {'passwd': 'XXX-REDACTED-XXX'}
2018-05-11 04:03:44,077 [salt.state       ][INFO    ][2612] Completed state [ubuntu] at time 04:03:44.077214 duration_in_ms=4.033
2018-05-11 04:03:44,078 [salt.state       ][INFO    ][2612] Running state [/home/ubuntu] at time 04:03:44.078278
2018-05-11 04:03:44,078 [salt.state       ][INFO    ][2612] Executing state file.directory for /home/ubuntu
2018-05-11 04:03:44,079 [salt.state       ][INFO    ][2612] {'mode': '0700'}
2018-05-11 04:03:44,080 [salt.state       ][INFO    ][2612] Completed state [/home/ubuntu] at time 04:03:44.079988 duration_in_ms=1.709
2018-05-11 04:03:44,080 [salt.state       ][INFO    ][2612] Running state [/etc/sudoers.d/90-salt-user-ubuntu] at time 04:03:44.080866
2018-05-11 04:03:44,081 [salt.state       ][INFO    ][2612] Executing state file.managed for /etc/sudoers.d/90-salt-user-ubuntu
2018-05-11 04:03:44,109 [salt.fileclient  ][INFO    ][2612] Fetching file from saltenv 'base', ** done ** 'linux/files/sudoer'
2018-05-11 04:03:44,113 [salt.loaded.int.module.cmdmod][INFO    ][2612] Executing command '/usr/sbin/visudo -c -f /tmp/tmp4KmGRY' in directory '/root'
2018-05-11 04:03:44,161 [salt.state       ][INFO    ][2612] File changed:
New file
2018-05-11 04:03:44,162 [salt.state       ][INFO    ][2612] Completed state [/etc/sudoers.d/90-salt-user-ubuntu] at time 04:03:44.161950 duration_in_ms=81.083
2018-05-11 04:03:44,162 [salt.state       ][INFO    ][2612] Running state [/etc/security/limits.d/90-salt-default.conf] at time 04:03:44.162700
2018-05-11 04:03:44,163 [salt.state       ][INFO    ][2612] Executing state file.managed for /etc/security/limits.d/90-salt-default.conf
2018-05-11 04:03:44,202 [salt.fileclient  ][INFO    ][2612] Fetching file from saltenv 'base', ** done ** 'linux/files/limits.conf'
2018-05-11 04:03:44,292 [salt.state       ][INFO    ][2612] File changed:
New file
2018-05-11 04:03:44,292 [salt.state       ][INFO    ][2612] Completed state [/etc/security/limits.d/90-salt-default.conf] at time 04:03:44.292445 duration_in_ms=129.745
2018-05-11 04:03:44,292 [salt.state       ][INFO    ][2612] Running state [/etc/systemd/system.conf.d/90-salt.conf] at time 04:03:44.292807
2018-05-11 04:03:44,293 [salt.state       ][INFO    ][2612] Executing state file.managed for /etc/systemd/system.conf.d/90-salt.conf
2018-05-11 04:03:44,321 [salt.fileclient  ][INFO    ][2612] Fetching file from saltenv 'base', ** done ** 'linux/files/systemd.conf'
2018-05-11 04:03:44,391 [salt.state       ][INFO    ][2612] File changed:
New file
2018-05-11 04:03:44,391 [salt.state       ][INFO    ][2612] Completed state [/etc/systemd/system.conf.d/90-salt.conf] at time 04:03:44.391664 duration_in_ms=98.857
2018-05-11 04:03:44,393 [salt.state       ][INFO    ][2612] Running state [service.systemctl_reload] at time 04:03:44.393307
2018-05-11 04:03:44,393 [salt.state       ][INFO    ][2612] Executing state module.wait for service.systemctl_reload
2018-05-11 04:03:44,393 [salt.state       ][INFO    ][2612] No changes made for service.systemctl_reload
2018-05-11 04:03:44,394 [salt.state       ][INFO    ][2612] Completed state [service.systemctl_reload] at time 04:03:44.394159 duration_in_ms=0.851
2018-05-11 04:03:44,394 [salt.state       ][INFO    ][2612] Running state [service.systemctl_reload] at time 04:03:44.394410
2018-05-11 04:03:44,394 [salt.state       ][INFO    ][2612] Executing state module.mod_watch for service.systemctl_reload
2018-05-11 04:03:44,395 [salt.loaded.int.module.cmdmod][INFO    ][2612] Executing command ['systemctl', '--system', 'daemon-reload'] in directory '/root'
2018-05-11 04:03:44,514 [salt.state       ][INFO    ][2612] {'ret': True}
2018-05-11 04:03:44,516 [salt.state       ][INFO    ][2612] Completed state [service.systemctl_reload] at time 04:03:44.515900 duration_in_ms=121.488
2018-05-11 04:03:44,516 [salt.state       ][INFO    ][2612] Running state [/etc/hostname] at time 04:03:44.516813
2018-05-11 04:03:44,517 [salt.state       ][INFO    ][2612] Executing state file.managed for /etc/hostname
2018-05-11 04:03:44,548 [salt.fileclient  ][INFO    ][2612] Fetching file from saltenv 'base', ** done ** 'linux/files/hostname'
2018-05-11 04:03:44,555 [salt.state       ][INFO    ][2612] File changed:
--- 
+++ 
@@ -1 +1 @@
-ubuntu
+odl01

2018-05-11 04:03:44,556 [salt.state       ][INFO    ][2612] Completed state [/etc/hostname] at time 04:03:44.556052 duration_in_ms=39.238
2018-05-11 04:03:44,559 [salt.state       ][INFO    ][2612] Running state [hostname odl01] at time 04:03:44.559471
2018-05-11 04:03:44,559 [salt.state       ][INFO    ][2612] Executing state cmd.wait for hostname odl01
2018-05-11 04:03:44,560 [salt.state       ][INFO    ][2612] No changes made for hostname odl01
2018-05-11 04:03:44,560 [salt.state       ][INFO    ][2612] Completed state [hostname odl01] at time 04:03:44.560697 duration_in_ms=1.226
2018-05-11 04:03:44,561 [salt.state       ][INFO    ][2612] Running state [hostname odl01] at time 04:03:44.561013
2018-05-11 04:03:44,561 [salt.state       ][INFO    ][2612] Executing state cmd.mod_watch for hostname odl01
2018-05-11 04:03:44,562 [salt.loaded.int.module.cmdmod][INFO    ][2612] Executing command 'hostname odl01' in directory '/root'
2018-05-11 04:03:44,589 [salt.state       ][INFO    ][2612] {'pid': 4601, 'retcode': 0, 'stderr': '', 'stdout': ''}
2018-05-11 04:03:44,590 [salt.state       ][INFO    ][2612] Completed state [hostname odl01] at time 04:03:44.590078 duration_in_ms=29.064
2018-05-11 04:03:44,592 [salt.state       ][INFO    ][2612] Running state [mdb02] at time 04:03:44.592282
2018-05-11 04:03:44,592 [salt.state       ][INFO    ][2612] Executing state host.present for mdb02
2018-05-11 04:03:44,594 [salt.state       ][INFO    ][2612] {'host': 'mdb02'}
2018-05-11 04:03:44,594 [salt.state       ][INFO    ][2612] Completed state [mdb02] at time 04:03:44.594905 duration_in_ms=2.623
2018-05-11 04:03:44,595 [salt.state       ][INFO    ][2612] Running state [mdb02.mcp-pike-odl-ha.local] at time 04:03:44.595320
2018-05-11 04:03:44,595 [salt.state       ][INFO    ][2612] Executing state host.present for mdb02.mcp-pike-odl-ha.local
2018-05-11 04:03:44,597 [salt.state       ][INFO    ][2612] {'host': 'mdb02.mcp-pike-odl-ha.local'}
2018-05-11 04:03:44,597 [salt.state       ][INFO    ][2612] Completed state [mdb02.mcp-pike-odl-ha.local] at time 04:03:44.597918 duration_in_ms=2.598
2018-05-11 04:03:44,598 [salt.state       ][INFO    ][2612] Running state [mdb03] at time 04:03:44.598308
2018-05-11 04:03:44,598 [salt.state       ][INFO    ][2612] Executing state host.present for mdb03
2018-05-11 04:03:44,603 [salt.state       ][INFO    ][2612] {'host': 'mdb03'}
2018-05-11 04:03:44,603 [salt.state       ][INFO    ][2612] Completed state [mdb03] at time 04:03:44.603853 duration_in_ms=5.545
2018-05-11 04:03:44,604 [salt.state       ][INFO    ][2612] Running state [mdb03.mcp-pike-odl-ha.local] at time 04:03:44.604201
2018-05-11 04:03:44,604 [salt.state       ][INFO    ][2612] Executing state host.present for mdb03.mcp-pike-odl-ha.local
2018-05-11 04:03:44,609 [salt.state       ][INFO    ][2612] {'host': 'mdb03.mcp-pike-odl-ha.local'}
2018-05-11 04:03:44,609 [salt.state       ][INFO    ][2612] Completed state [mdb03.mcp-pike-odl-ha.local] at time 04:03:44.609882 duration_in_ms=5.681
2018-05-11 04:03:44,610 [salt.state       ][INFO    ][2612] Running state [mdb01] at time 04:03:44.610218
2018-05-11 04:03:44,610 [salt.state       ][INFO    ][2612] Executing state host.present for mdb01
2018-05-11 04:03:44,621 [salt.state       ][INFO    ][2612] {'host': 'mdb01'}
2018-05-11 04:03:44,622 [salt.state       ][INFO    ][2612] Completed state [mdb01] at time 04:03:44.622029 duration_in_ms=11.81
2018-05-11 04:03:44,622 [salt.state       ][INFO    ][2612] Running state [mdb01.mcp-pike-odl-ha.local] at time 04:03:44.622370
2018-05-11 04:03:44,622 [salt.state       ][INFO    ][2612] Executing state host.present for mdb01.mcp-pike-odl-ha.local
2018-05-11 04:03:44,633 [salt.state       ][INFO    ][2612] {'host': 'mdb01.mcp-pike-odl-ha.local'}
2018-05-11 04:03:44,633 [salt.state       ][INFO    ][2612] Completed state [mdb01.mcp-pike-odl-ha.local] at time 04:03:44.633895 duration_in_ms=11.524
2018-05-11 04:03:44,634 [salt.state       ][INFO    ][2612] Running state [mdb] at time 04:03:44.634267
2018-05-11 04:03:44,634 [salt.state       ][INFO    ][2612] Executing state host.present for mdb
2018-05-11 04:03:44,645 [salt.state       ][INFO    ][2612] {'host': 'mdb'}
2018-05-11 04:03:44,645 [salt.state       ][INFO    ][2612] Completed state [mdb] at time 04:03:44.645892 duration_in_ms=11.624
2018-05-11 04:03:44,646 [salt.state       ][INFO    ][2612] Running state [mdb.mcp-pike-odl-ha.local] at time 04:03:44.646256
2018-05-11 04:03:44,646 [salt.state       ][INFO    ][2612] Executing state host.present for mdb.mcp-pike-odl-ha.local
2018-05-11 04:03:44,657 [salt.state       ][INFO    ][2612] {'host': 'mdb.mcp-pike-odl-ha.local'}
2018-05-11 04:03:44,658 [salt.state       ][INFO    ][2612] Completed state [mdb.mcp-pike-odl-ha.local] at time 04:03:44.657968 duration_in_ms=11.712
2018-05-11 04:03:44,658 [salt.state       ][INFO    ][2612] Running state [cfg01] at time 04:03:44.658331
2018-05-11 04:03:44,658 [salt.state       ][INFO    ][2612] Executing state host.present for cfg01
2018-05-11 04:03:44,681 [salt.state       ][INFO    ][2612] {'host': 'cfg01'}
2018-05-11 04:03:44,682 [salt.state       ][INFO    ][2612] Completed state [cfg01] at time 04:03:44.682161 duration_in_ms=23.829
2018-05-11 04:03:44,682 [salt.state       ][INFO    ][2612] Running state [cfg01.mcp-pike-odl-ha.local] at time 04:03:44.682526
2018-05-11 04:03:44,682 [salt.state       ][INFO    ][2612] Executing state host.present for cfg01.mcp-pike-odl-ha.local
2018-05-11 04:03:44,687 [salt.state       ][INFO    ][2612] {'host': 'cfg01.mcp-pike-odl-ha.local'}
2018-05-11 04:03:44,688 [salt.state       ][INFO    ][2612] Completed state [cfg01.mcp-pike-odl-ha.local] at time 04:03:44.688087 duration_in_ms=5.56
2018-05-11 04:03:44,688 [salt.state       ][INFO    ][2612] Running state [prx01] at time 04:03:44.688406
2018-05-11 04:03:44,688 [salt.state       ][INFO    ][2612] Executing state host.present for prx01
2018-05-11 04:03:44,694 [salt.state       ][INFO    ][2612] {'host': 'prx01'}
2018-05-11 04:03:44,694 [salt.state       ][INFO    ][2612] Completed state [prx01] at time 04:03:44.694369 duration_in_ms=5.962
2018-05-11 04:03:44,694 [salt.state       ][INFO    ][2612] Running state [prx01.mcp-pike-odl-ha.local] at time 04:03:44.694847
2018-05-11 04:03:44,695 [salt.state       ][INFO    ][2612] Executing state host.present for prx01.mcp-pike-odl-ha.local
2018-05-11 04:03:44,699 [salt.state       ][INFO    ][2612] {'host': 'prx01.mcp-pike-odl-ha.local'}
2018-05-11 04:03:44,700 [salt.state       ][INFO    ][2612] Completed state [prx01.mcp-pike-odl-ha.local] at time 04:03:44.700206 duration_in_ms=5.359
2018-05-11 04:03:44,700 [salt.state       ][INFO    ][2612] Running state [kvm01] at time 04:03:44.700632
2018-05-11 04:03:44,701 [salt.state       ][INFO    ][2612] Executing state host.present for kvm01
2018-05-11 04:03:44,705 [salt.state       ][INFO    ][2612] {'host': 'kvm01'}
2018-05-11 04:03:44,706 [salt.state       ][INFO    ][2612] Completed state [kvm01] at time 04:03:44.706221 duration_in_ms=5.589
2018-05-11 04:03:44,706 [salt.state       ][INFO    ][2612] Running state [kvm01.mcp-pike-odl-ha.local] at time 04:03:44.706633
2018-05-11 04:03:44,707 [salt.state       ][INFO    ][2612] Executing state host.present for kvm01.mcp-pike-odl-ha.local
2018-05-11 04:03:44,711 [salt.state       ][INFO    ][2612] {'host': 'kvm01.mcp-pike-odl-ha.local'}
2018-05-11 04:03:44,712 [salt.state       ][INFO    ][2612] Completed state [kvm01.mcp-pike-odl-ha.local] at time 04:03:44.712106 duration_in_ms=5.473
2018-05-11 04:03:44,712 [salt.state       ][INFO    ][2612] Running state [kvm03] at time 04:03:44.712446
2018-05-11 04:03:44,712 [salt.state       ][INFO    ][2612] Executing state host.present for kvm03
2018-05-11 04:03:44,717 [salt.state       ][INFO    ][2612] {'host': 'kvm03'}
2018-05-11 04:03:44,718 [salt.state       ][INFO    ][2612] Completed state [kvm03] at time 04:03:44.718173 duration_in_ms=5.727
2018-05-11 04:03:44,718 [salt.state       ][INFO    ][2612] Running state [kvm03.mcp-pike-odl-ha.local] at time 04:03:44.718526
2018-05-11 04:03:44,718 [salt.state       ][INFO    ][2612] Executing state host.present for kvm03.mcp-pike-odl-ha.local
2018-05-11 04:03:44,725 [salt.state       ][INFO    ][2612] {'host': 'kvm03.mcp-pike-odl-ha.local'}
2018-05-11 04:03:44,725 [salt.state       ][INFO    ][2612] Completed state [kvm03.mcp-pike-odl-ha.local] at time 04:03:44.725528 duration_in_ms=7.002
2018-05-11 04:03:44,725 [salt.state       ][INFO    ][2612] Running state [kvm02] at time 04:03:44.725877
2018-05-11 04:03:44,726 [salt.state       ][INFO    ][2612] Executing state host.present for kvm02
2018-05-11 04:03:44,731 [salt.state       ][INFO    ][2612] {'host': 'kvm02'}
2018-05-11 04:03:44,731 [salt.state       ][INFO    ][2612] Completed state [kvm02] at time 04:03:44.731512 duration_in_ms=5.635
2018-05-11 04:03:44,731 [salt.state       ][INFO    ][2612] Running state [kvm02.mcp-pike-odl-ha.local] at time 04:03:44.731832
2018-05-11 04:03:44,732 [salt.state       ][INFO    ][2612] Executing state host.present for kvm02.mcp-pike-odl-ha.local
2018-05-11 04:03:44,737 [salt.state       ][INFO    ][2612] {'host': 'kvm02.mcp-pike-odl-ha.local'}
2018-05-11 04:03:44,737 [salt.state       ][INFO    ][2612] Completed state [kvm02.mcp-pike-odl-ha.local] at time 04:03:44.737803 duration_in_ms=5.97
2018-05-11 04:03:44,738 [salt.state       ][INFO    ][2612] Running state [dbs] at time 04:03:44.738174
2018-05-11 04:03:44,738 [salt.state       ][INFO    ][2612] Executing state host.present for dbs
2018-05-11 04:03:44,743 [salt.state       ][INFO    ][2612] {'host': 'dbs'}
2018-05-11 04:03:44,743 [salt.state       ][INFO    ][2612] Completed state [dbs] at time 04:03:44.743598 duration_in_ms=5.424
2018-05-11 04:03:44,743 [salt.state       ][INFO    ][2612] Running state [dbs.mcp-pike-odl-ha.local] at time 04:03:44.743918
2018-05-11 04:03:44,744 [salt.state       ][INFO    ][2612] Executing state host.present for dbs.mcp-pike-odl-ha.local
2018-05-11 04:03:44,749 [salt.state       ][INFO    ][2612] {'host': 'dbs.mcp-pike-odl-ha.local'}
2018-05-11 04:03:44,749 [salt.state       ][INFO    ][2612] Completed state [dbs.mcp-pike-odl-ha.local] at time 04:03:44.749773 duration_in_ms=5.854
2018-05-11 04:03:44,750 [salt.state       ][INFO    ][2612] Running state [prx] at time 04:03:44.750138
2018-05-11 04:03:44,750 [salt.state       ][INFO    ][2612] Executing state host.present for prx
2018-05-11 04:03:44,755 [salt.state       ][INFO    ][2612] {'host': 'prx'}
2018-05-11 04:03:44,755 [salt.state       ][INFO    ][2612] Completed state [prx] at time 04:03:44.755604 duration_in_ms=5.466
2018-05-11 04:03:44,755 [salt.state       ][INFO    ][2612] Running state [prx.mcp-pike-odl-ha.local] at time 04:03:44.755921
2018-05-11 04:03:44,756 [salt.state       ][INFO    ][2612] Executing state host.present for prx.mcp-pike-odl-ha.local
2018-05-11 04:03:44,761 [salt.state       ][INFO    ][2612] {'host': 'prx.mcp-pike-odl-ha.local'}
2018-05-11 04:03:44,761 [salt.state       ][INFO    ][2612] Completed state [prx.mcp-pike-odl-ha.local] at time 04:03:44.761544 duration_in_ms=5.623
2018-05-11 04:03:44,761 [salt.state       ][INFO    ][2612] Running state [prx02] at time 04:03:44.761847
2018-05-11 04:03:44,762 [salt.state       ][INFO    ][2612] Executing state host.present for prx02
2018-05-11 04:03:44,767 [salt.state       ][INFO    ][2612] {'host': 'prx02'}
2018-05-11 04:03:44,767 [salt.state       ][INFO    ][2612] Completed state [prx02] at time 04:03:44.767531 duration_in_ms=5.685
2018-05-11 04:03:44,767 [salt.state       ][INFO    ][2612] Running state [prx02.mcp-pike-odl-ha.local] at time 04:03:44.767830
2018-05-11 04:03:44,768 [salt.state       ][INFO    ][2612] Executing state host.present for prx02.mcp-pike-odl-ha.local
2018-05-11 04:03:44,773 [salt.state       ][INFO    ][2612] {'host': 'prx02.mcp-pike-odl-ha.local'}
2018-05-11 04:03:44,773 [salt.state       ][INFO    ][2612] Completed state [prx02.mcp-pike-odl-ha.local] at time 04:03:44.773543 duration_in_ms=5.712
2018-05-11 04:03:44,773 [salt.state       ][INFO    ][2612] Running state [msg02] at time 04:03:44.773832
2018-05-11 04:03:44,774 [salt.state       ][INFO    ][2612] Executing state host.present for msg02
2018-05-11 04:03:44,779 [salt.state       ][INFO    ][2612] {'host': 'msg02'}
2018-05-11 04:03:44,779 [salt.state       ][INFO    ][2612] Completed state [msg02] at time 04:03:44.779547 duration_in_ms=5.714
2018-05-11 04:03:44,779 [salt.state       ][INFO    ][2612] Running state [msg02.mcp-pike-odl-ha.local] at time 04:03:44.779832
2018-05-11 04:03:44,780 [salt.state       ][INFO    ][2612] Executing state host.present for msg02.mcp-pike-odl-ha.local
2018-05-11 04:03:44,785 [salt.state       ][INFO    ][2612] {'host': 'msg02.mcp-pike-odl-ha.local'}
2018-05-11 04:03:44,785 [salt.state       ][INFO    ][2612] Completed state [msg02.mcp-pike-odl-ha.local] at time 04:03:44.785524 duration_in_ms=5.692
2018-05-11 04:03:44,785 [salt.state       ][INFO    ][2612] Running state [msg03] at time 04:03:44.785805
2018-05-11 04:03:44,786 [salt.state       ][INFO    ][2612] Executing state host.present for msg03
2018-05-11 04:03:44,791 [salt.state       ][INFO    ][2612] {'host': 'msg03'}
2018-05-11 04:03:44,791 [salt.state       ][INFO    ][2612] Completed state [msg03] at time 04:03:44.791562 duration_in_ms=5.757
2018-05-11 04:03:44,791 [salt.state       ][INFO    ][2612] Running state [msg03.mcp-pike-odl-ha.local] at time 04:03:44.791834
2018-05-11 04:03:44,792 [salt.state       ][INFO    ][2612] Executing state host.present for msg03.mcp-pike-odl-ha.local
2018-05-11 04:03:44,815 [salt.state       ][INFO    ][2612] {'host': 'msg03.mcp-pike-odl-ha.local'}
2018-05-11 04:03:44,815 [salt.state       ][INFO    ][2612] Completed state [msg03.mcp-pike-odl-ha.local] at time 04:03:44.815850 duration_in_ms=24.016
2018-05-11 04:03:44,816 [salt.state       ][INFO    ][2612] Running state [msg01] at time 04:03:44.816141
2018-05-11 04:03:44,816 [salt.state       ][INFO    ][2612] Executing state host.present for msg01
2018-05-11 04:03:44,821 [salt.state       ][INFO    ][2612] {'host': 'msg01'}
2018-05-11 04:03:44,821 [salt.state       ][INFO    ][2612] Completed state [msg01] at time 04:03:44.821522 duration_in_ms=5.381
2018-05-11 04:03:44,821 [salt.state       ][INFO    ][2612] Running state [msg01.mcp-pike-odl-ha.local] at time 04:03:44.821792
2018-05-11 04:03:44,822 [salt.state       ][INFO    ][2612] Executing state host.present for msg01.mcp-pike-odl-ha.local
2018-05-11 04:03:44,833 [salt.state       ][INFO    ][2612] {'host': 'msg01.mcp-pike-odl-ha.local'}
2018-05-11 04:03:44,833 [salt.state       ][INFO    ][2612] Completed state [msg01.mcp-pike-odl-ha.local] at time 04:03:44.833582 duration_in_ms=11.789
2018-05-11 04:03:44,833 [salt.state       ][INFO    ][2612] Running state [msg] at time 04:03:44.833849
2018-05-11 04:03:44,834 [salt.state       ][INFO    ][2612] Executing state host.present for msg
2018-05-11 04:03:44,839 [salt.state       ][INFO    ][2612] {'host': 'msg'}
2018-05-11 04:03:44,839 [salt.state       ][INFO    ][2612] Completed state [msg] at time 04:03:44.839465 duration_in_ms=5.615
2018-05-11 04:03:44,839 [salt.state       ][INFO    ][2612] Running state [msg.mcp-pike-odl-ha.local] at time 04:03:44.839701
2018-05-11 04:03:44,839 [salt.state       ][INFO    ][2612] Executing state host.present for msg.mcp-pike-odl-ha.local
2018-05-11 04:03:44,847 [salt.state       ][INFO    ][2612] {'host': 'msg.mcp-pike-odl-ha.local'}
2018-05-11 04:03:44,847 [salt.state       ][INFO    ][2612] Completed state [msg.mcp-pike-odl-ha.local] at time 04:03:44.847495 duration_in_ms=7.794
2018-05-11 04:03:44,847 [salt.state       ][INFO    ][2612] Running state [cfg01] at time 04:03:44.847740
2018-05-11 04:03:44,847 [salt.state       ][INFO    ][2612] Executing state host.present for cfg01
2018-05-11 04:03:44,848 [salt.state       ][INFO    ][2612] Host cfg01 (10.167.4.11) already present
2018-05-11 04:03:44,848 [salt.state       ][INFO    ][2612] Completed state [cfg01] at time 04:03:44.848557 duration_in_ms=0.817
2018-05-11 04:03:44,848 [salt.state       ][INFO    ][2612] Running state [cfg01.mcp-pike-odl-ha.local] at time 04:03:44.848785
2018-05-11 04:03:44,849 [salt.state       ][INFO    ][2612] Executing state host.present for cfg01.mcp-pike-odl-ha.local
2018-05-11 04:03:44,849 [salt.state       ][INFO    ][2612] Host cfg01.mcp-pike-odl-ha.local (10.167.4.11) already present
2018-05-11 04:03:44,849 [salt.state       ][INFO    ][2612] Completed state [cfg01.mcp-pike-odl-ha.local] at time 04:03:44.849615 duration_in_ms=0.83
2018-05-11 04:03:44,849 [salt.state       ][INFO    ][2612] Running state [cmp002] at time 04:03:44.849838
2018-05-11 04:03:44,850 [salt.state       ][INFO    ][2612] Executing state host.present for cmp002
2018-05-11 04:03:44,853 [salt.state       ][INFO    ][2612] {'host': 'cmp002'}
2018-05-11 04:03:44,853 [salt.state       ][INFO    ][2612] Completed state [cmp002] at time 04:03:44.853484 duration_in_ms=3.646
2018-05-11 04:03:44,853 [salt.state       ][INFO    ][2612] Running state [cmp002.mcp-pike-odl-ha.local] at time 04:03:44.853730
2018-05-11 04:03:44,854 [salt.state       ][INFO    ][2612] Executing state host.present for cmp002.mcp-pike-odl-ha.local
2018-05-11 04:03:44,856 [salt.minion      ][INFO    ][2517] User sudo_ubuntu Executing command saltutil.find_job with jid 20180511040344846745
2018-05-11 04:03:44,859 [salt.state       ][INFO    ][2612] {'host': 'cmp002.mcp-pike-odl-ha.local'}
2018-05-11 04:03:44,859 [salt.state       ][INFO    ][2612] Completed state [cmp002.mcp-pike-odl-ha.local] at time 04:03:44.859741 duration_in_ms=6.011
2018-05-11 04:03:44,859 [salt.state       ][INFO    ][2612] Running state [cmp001] at time 04:03:44.859958
2018-05-11 04:03:44,860 [salt.state       ][INFO    ][2612] Executing state host.present for cmp001
2018-05-11 04:03:44,871 [salt.state       ][INFO    ][2612] {'host': 'cmp001'}
2018-05-11 04:03:44,872 [salt.state       ][INFO    ][2612] Completed state [cmp001] at time 04:03:44.872404 duration_in_ms=12.444
2018-05-11 04:03:44,873 [salt.state       ][INFO    ][2612] Running state [cmp001.mcp-pike-odl-ha.local] at time 04:03:44.873017
2018-05-11 04:03:44,873 [salt.state       ][INFO    ][2612] Executing state host.present for cmp001.mcp-pike-odl-ha.local
2018-05-11 04:03:44,880 [salt.minion      ][INFO    ][4605] Starting a new job with PID 4605
2018-05-11 04:03:44,883 [salt.state       ][INFO    ][2612] {'host': 'cmp001.mcp-pike-odl-ha.local'}
2018-05-11 04:03:44,887 [salt.state       ][INFO    ][2612] Completed state [cmp001.mcp-pike-odl-ha.local] at time 04:03:44.887130 duration_in_ms=14.112
2018-05-11 04:03:44,888 [salt.state       ][INFO    ][2612] Running state [dbs01] at time 04:03:44.887943
2018-05-11 04:03:44,888 [salt.state       ][INFO    ][2612] Executing state host.present for dbs01
2018-05-11 04:03:44,895 [salt.state       ][INFO    ][2612] {'host': 'dbs01'}
2018-05-11 04:03:44,896 [salt.state       ][INFO    ][2612] Completed state [dbs01] at time 04:03:44.896393 duration_in_ms=8.45
2018-05-11 04:03:44,897 [salt.state       ][INFO    ][2612] Running state [dbs01.mcp-pike-odl-ha.local] at time 04:03:44.897010
2018-05-11 04:03:44,897 [salt.state       ][INFO    ][2612] Executing state host.present for dbs01.mcp-pike-odl-ha.local
2018-05-11 04:03:44,907 [salt.state       ][INFO    ][2612] {'host': 'dbs01.mcp-pike-odl-ha.local'}
2018-05-11 04:03:44,908 [salt.state       ][INFO    ][2612] Completed state [dbs01.mcp-pike-odl-ha.local] at time 04:03:44.908190 duration_in_ms=11.18
2018-05-11 04:03:44,908 [salt.state       ][INFO    ][2612] Running state [dbs02] at time 04:03:44.908736
2018-05-11 04:03:44,909 [salt.state       ][INFO    ][2612] Executing state host.present for dbs02
2018-05-11 04:03:44,909 [salt.minion      ][INFO    ][4605] Returning information for job: 20180511040344846745
2018-05-11 04:03:44,913 [salt.state       ][INFO    ][2612] {'host': 'dbs02'}
2018-05-11 04:03:44,913 [salt.state       ][INFO    ][2612] Completed state [dbs02] at time 04:03:44.913841 duration_in_ms=5.106
2018-05-11 04:03:44,914 [salt.state       ][INFO    ][2612] Running state [dbs02.mcp-pike-odl-ha.local] at time 04:03:44.914233
2018-05-11 04:03:44,914 [salt.state       ][INFO    ][2612] Executing state host.present for dbs02.mcp-pike-odl-ha.local
2018-05-11 04:03:44,925 [salt.state       ][INFO    ][2612] {'host': 'dbs02.mcp-pike-odl-ha.local'}
2018-05-11 04:03:44,926 [salt.state       ][INFO    ][2612] Completed state [dbs02.mcp-pike-odl-ha.local] at time 04:03:44.925983 duration_in_ms=11.749
2018-05-11 04:03:44,926 [salt.state       ][INFO    ][2612] Running state [dbs03] at time 04:03:44.926346
2018-05-11 04:03:44,926 [salt.state       ][INFO    ][2612] Executing state host.present for dbs03
2018-05-11 04:03:44,949 [salt.state       ][INFO    ][2612] {'host': 'dbs03'}
2018-05-11 04:03:44,949 [salt.state       ][INFO    ][2612] Completed state [dbs03] at time 04:03:44.949728 duration_in_ms=23.382
2018-05-11 04:03:44,949 [salt.state       ][INFO    ][2612] Running state [dbs03.mcp-pike-odl-ha.local] at time 04:03:44.949929
2018-05-11 04:03:44,950 [salt.state       ][INFO    ][2612] Executing state host.present for dbs03.mcp-pike-odl-ha.local
2018-05-11 04:03:44,955 [salt.state       ][INFO    ][2612] {'host': 'dbs03.mcp-pike-odl-ha.local'}
2018-05-11 04:03:44,955 [salt.state       ][INFO    ][2612] Completed state [dbs03.mcp-pike-odl-ha.local] at time 04:03:44.955411 duration_in_ms=5.482
2018-05-11 04:03:44,955 [salt.state       ][INFO    ][2612] Running state [odl01] at time 04:03:44.955586
2018-05-11 04:03:44,955 [salt.state       ][INFO    ][2612] Executing state host.present for odl01
2018-05-11 04:03:44,961 [salt.state       ][INFO    ][2612] {'host': 'odl01'}
2018-05-11 04:03:44,961 [salt.state       ][INFO    ][2612] Completed state [odl01] at time 04:03:44.961377 duration_in_ms=5.791
2018-05-11 04:03:44,961 [salt.state       ][INFO    ][2612] Running state [odl01.mcp-pike-odl-ha.local] at time 04:03:44.961545
2018-05-11 04:03:44,961 [salt.state       ][INFO    ][2612] Executing state host.present for odl01.mcp-pike-odl-ha.local
2018-05-11 04:03:44,967 [salt.state       ][INFO    ][2612] {'host': 'odl01.mcp-pike-odl-ha.local'}
2018-05-11 04:03:44,967 [salt.state       ][INFO    ][2612] Completed state [odl01.mcp-pike-odl-ha.local] at time 04:03:44.967467 duration_in_ms=5.922
2018-05-11 04:03:44,967 [salt.state       ][INFO    ][2612] Running state [mas01] at time 04:03:44.967646
2018-05-11 04:03:44,967 [salt.state       ][INFO    ][2612] Executing state host.present for mas01
2018-05-11 04:03:44,997 [salt.state       ][INFO    ][2612] {'host': 'mas01'}
2018-05-11 04:03:44,998 [salt.state       ][INFO    ][2612] Completed state [mas01] at time 04:03:44.997993 duration_in_ms=30.346
2018-05-11 04:03:44,998 [salt.state       ][INFO    ][2612] Running state [mas01.mcp-pike-odl-ha.local] at time 04:03:44.998305
2018-05-11 04:03:44,998 [salt.state       ][INFO    ][2612] Executing state host.present for mas01.mcp-pike-odl-ha.local
2018-05-11 04:03:45,003 [salt.state       ][INFO    ][2612] {'host': 'mas01.mcp-pike-odl-ha.local'}
2018-05-11 04:03:45,003 [salt.state       ][INFO    ][2612] Completed state [mas01.mcp-pike-odl-ha.local] at time 04:03:45.003690 duration_in_ms=5.384
2018-05-11 04:03:45,004 [salt.state       ][INFO    ][2612] Running state [ctl02] at time 04:03:45.003991
2018-05-11 04:03:45,004 [salt.state       ][INFO    ][2612] Executing state host.present for ctl02
2018-05-11 04:03:45,009 [salt.state       ][INFO    ][2612] {'host': 'ctl02'}
2018-05-11 04:03:45,009 [salt.state       ][INFO    ][2612] Completed state [ctl02] at time 04:03:45.009799 duration_in_ms=5.807
2018-05-11 04:03:45,010 [salt.state       ][INFO    ][2612] Running state [ctl02.mcp-pike-odl-ha.local] at time 04:03:45.010102
2018-05-11 04:03:45,010 [salt.state       ][INFO    ][2612] Executing state host.present for ctl02.mcp-pike-odl-ha.local
2018-05-11 04:03:45,019 [salt.state       ][INFO    ][2612] {'host': 'ctl02.mcp-pike-odl-ha.local'}
2018-05-11 04:03:45,019 [salt.state       ][INFO    ][2612] Completed state [ctl02.mcp-pike-odl-ha.local] at time 04:03:45.019459 duration_in_ms=9.356
2018-05-11 04:03:45,019 [salt.state       ][INFO    ][2612] Running state [ctl03] at time 04:03:45.019864
2018-05-11 04:03:45,020 [salt.state       ][INFO    ][2612] Executing state host.present for ctl03
2018-05-11 04:03:45,031 [salt.state       ][INFO    ][2612] {'host': 'ctl03'}
2018-05-11 04:03:45,031 [salt.state       ][INFO    ][2612] Completed state [ctl03] at time 04:03:45.031599 duration_in_ms=11.736
2018-05-11 04:03:45,031 [salt.state       ][INFO    ][2612] Running state [ctl03.mcp-pike-odl-ha.local] at time 04:03:45.031910
2018-05-11 04:03:45,032 [salt.state       ][INFO    ][2612] Executing state host.present for ctl03.mcp-pike-odl-ha.local
2018-05-11 04:03:45,037 [salt.state       ][INFO    ][2612] {'host': 'ctl03.mcp-pike-odl-ha.local'}
2018-05-11 04:03:45,037 [salt.state       ][INFO    ][2612] Completed state [ctl03.mcp-pike-odl-ha.local] at time 04:03:45.037408 duration_in_ms=5.497
2018-05-11 04:03:45,037 [salt.state       ][INFO    ][2612] Running state [ctl01] at time 04:03:45.037819
2018-05-11 04:03:45,038 [salt.state       ][INFO    ][2612] Executing state host.present for ctl01
2018-05-11 04:03:45,049 [salt.state       ][INFO    ][2612] {'host': 'ctl01'}
2018-05-11 04:03:45,049 [salt.state       ][INFO    ][2612] Completed state [ctl01] at time 04:03:45.049823 duration_in_ms=12.003
2018-05-11 04:03:45,050 [salt.state       ][INFO    ][2612] Running state [ctl01.mcp-pike-odl-ha.local] at time 04:03:45.050252
2018-05-11 04:03:45,050 [salt.state       ][INFO    ][2612] Executing state host.present for ctl01.mcp-pike-odl-ha.local
2018-05-11 04:03:45,055 [salt.state       ][INFO    ][2612] {'host': 'ctl01.mcp-pike-odl-ha.local'}
2018-05-11 04:03:45,055 [salt.state       ][INFO    ][2612] Completed state [ctl01.mcp-pike-odl-ha.local] at time 04:03:45.055579 duration_in_ms=5.328
2018-05-11 04:03:45,056 [salt.state       ][INFO    ][2612] Running state [ctl] at time 04:03:45.055955
2018-05-11 04:03:45,056 [salt.state       ][INFO    ][2612] Executing state host.present for ctl
2018-05-11 04:03:45,061 [salt.state       ][INFO    ][2612] {'host': 'ctl'}
2018-05-11 04:03:45,061 [salt.state       ][INFO    ][2612] Completed state [ctl] at time 04:03:45.061281 duration_in_ms=5.326
2018-05-11 04:03:45,061 [salt.state       ][INFO    ][2612] Running state [ctl.mcp-pike-odl-ha.local] at time 04:03:45.061578
2018-05-11 04:03:45,061 [salt.state       ][INFO    ][2612] Executing state host.present for ctl.mcp-pike-odl-ha.local
2018-05-11 04:03:45,073 [salt.state       ][INFO    ][2612] {'host': 'ctl.mcp-pike-odl-ha.local'}
2018-05-11 04:03:45,073 [salt.state       ][INFO    ][2612] Completed state [ctl.mcp-pike-odl-ha.local] at time 04:03:45.073629 duration_in_ms=12.049
2018-05-11 04:03:45,074 [salt.state       ][INFO    ][2612] Running state [/etc/network/interfaces.d/50-cloud-init.cfg] at time 04:03:45.074070
2018-05-11 04:03:45,074 [salt.state       ][INFO    ][2612] Executing state file.absent for /etc/network/interfaces.d/50-cloud-init.cfg
2018-05-11 04:03:45,075 [salt.state       ][INFO    ][2612] {'removed': '/etc/network/interfaces.d/50-cloud-init.cfg'}
2018-05-11 04:03:45,075 [salt.state       ][INFO    ][2612] Completed state [/etc/network/interfaces.d/50-cloud-init.cfg] at time 04:03:45.075550 duration_in_ms=1.48
2018-05-11 04:03:45,085 [salt.state       ][INFO    ][2612] Running state [ens2] at time 04:03:45.085568
2018-05-11 04:03:45,086 [salt.state       ][INFO    ][2612] Executing state network.managed for ens2
2018-05-11 04:03:45,216 [salt.loaded.int.module.cmdmod][INFO    ][2612] Executing command ['ifdown', 'ens2'] in directory '/root'
2018-05-11 04:03:46,474 [salt.loaded.int.module.cmdmod][INFO    ][2612] Executing command ['ifup', 'ens2'] in directory '/root'
2018-05-11 04:03:47,846 [salt.state       ][INFO    ][2612] {'interface': 'Added network interface.', 'status': 'Interface ens2 restart to validate'}
2018-05-11 04:03:47,847 [salt.state       ][INFO    ][2612] Completed state [ens2] at time 04:03:47.847471 duration_in_ms=2761.902
2018-05-11 04:03:47,848 [salt.state       ][INFO    ][2612] Running state [ens3] at time 04:03:47.848234
2018-05-11 04:03:47,848 [salt.state       ][INFO    ][2612] Executing state network.managed for ens3
2018-05-11 04:03:47,902 [salt.loaded.int.module.cmdmod][INFO    ][2612] Executing command ['ifup', 'ens3'] in directory '/root'
2018-05-11 04:03:48,724 [salt.state       ][INFO    ][2612] {'interface': 'Added network interface.', 'status': 'Interface ens3 is up'}
2018-05-11 04:03:48,726 [salt.state       ][INFO    ][2612] Completed state [ens3] at time 04:03:48.725895 duration_in_ms=877.659
2018-05-11 04:03:48,726 [salt.state       ][INFO    ][2612] Running state [/etc/profile.d/proxy.sh] at time 04:03:48.726869
2018-05-11 04:03:48,727 [salt.state       ][INFO    ][2612] Executing state file.absent for /etc/profile.d/proxy.sh
2018-05-11 04:03:48,729 [salt.state       ][INFO    ][2612] File /etc/profile.d/proxy.sh is not present
2018-05-11 04:03:48,729 [salt.state       ][INFO    ][2612] Completed state [/etc/profile.d/proxy.sh] at time 04:03:48.729822 duration_in_ms=2.952
2018-05-11 04:03:48,730 [salt.state       ][INFO    ][2612] Running state [/etc/apt/apt.conf.d/95proxies] at time 04:03:48.730658
2018-05-11 04:03:48,731 [salt.state       ][INFO    ][2612] Executing state file.absent for /etc/apt/apt.conf.d/95proxies
2018-05-11 04:03:48,732 [salt.state       ][INFO    ][2612] File /etc/apt/apt.conf.d/95proxies is not present
2018-05-11 04:03:48,733 [salt.state       ][INFO    ][2612] Completed state [/etc/apt/apt.conf.d/95proxies] at time 04:03:48.733237 duration_in_ms=2.578
2018-05-11 04:03:48,735 [salt.state       ][INFO    ][2612] Running state [ntp] at time 04:03:48.735881
2018-05-11 04:03:48,736 [salt.state       ][INFO    ][2612] Executing state pkg.installed for ntp
2018-05-11 04:03:48,832 [salt.loaded.int.module.cmdmod][INFO    ][2612] Executing command ['dpkg', '--get-selections', '*'] in directory '/root'
2018-05-11 04:03:48,864 [salt.loaded.int.module.cmdmod][INFO    ][2612] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'ntp'] in directory '/root'
2018-05-11 04:03:55,073 [salt.minion      ][INFO    ][2517] User sudo_ubuntu Executing command saltutil.find_job with jid 20180511040355062802
2018-05-11 04:03:55,099 [salt.minion      ][INFO    ][5642] Starting a new job with PID 5642
2018-05-11 04:03:55,120 [salt.minion      ][INFO    ][5642] Returning information for job: 20180511040355062802
2018-05-11 04:03:56,701 [salt.loaded.int.module.cmdmod][INFO    ][2612] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2018-05-11 04:03:56,756 [salt.state       ][INFO    ][2612] Made the following changes:
'ntp' changed from 'absent' to '1:4.2.8p4+dfsg-3ubuntu5.8'
'libopts25' changed from 'absent' to '1:5.18.7-3'

2018-05-11 04:03:56,791 [salt.state       ][INFO    ][2612] Loading fresh modules for state activity
2018-05-11 04:03:56,841 [salt.state       ][INFO    ][2612] Completed state [ntp] at time 04:03:56.840945 duration_in_ms=8105.064
2018-05-11 04:03:56,846 [salt.state       ][INFO    ][2612] Running state [/etc/ntp.conf] at time 04:03:56.846122
2018-05-11 04:03:56,846 [salt.state       ][INFO    ][2612] Executing state file.managed for /etc/ntp.conf
2018-05-11 04:03:56,881 [salt.fileclient  ][INFO    ][2612] Fetching file from saltenv 'base', ** done ** 'ntp/files/ntp.conf'
2018-05-11 04:03:56,950 [salt.state       ][INFO    ][2612] File changed:
--- 
+++ 
@@ -1,66 +1,26 @@
-# /etc/ntp.conf, configuration for ntpd; see ntp.conf(5) for help
 
-driftfile /var/lib/ntp/ntp.drift
 
-# Enable this if you want statistics to be logged.
-#statsdir /var/log/ntpstats/
+# ntpd will only synchronize your clock.
 
-statistics loopstats peerstats clockstats
-filegen loopstats file loopstats type day enable
-filegen peerstats file peerstats type day enable
-filegen clockstats file clockstats type day enable
+# For details, see:
+# - the ntp.conf man page
+# - http://support.ntp.org/bin/view/Support/GettingStarted
+# - https://wiki.archlinux.org/index.php/Network_Time_Protocol_daemon
 
-# Specify one or more NTP servers.
+# Associate to cloud NTP pool servers
+server 1.pool.ntp.org iburst
+server 0.pool.ntp.org
 
-# Use servers from the NTP Pool Project. Approved by Ubuntu Technical Board
-# on 2011-02-08 (LP: #104525). See http://www.pool.ntp.org/join.html for
-# more information.
-pool 0.ubuntu.pool.ntp.org iburst
-pool 1.ubuntu.pool.ntp.org iburst
-pool 2.ubuntu.pool.ntp.org iburst
-pool 3.ubuntu.pool.ntp.org iburst
+# Exchange time with everybody, but don't allow configuration.
+restrict -4 default kod notrap nomodify nopeer noquery
+restrict -6 default kod notrap nomodify nopeer noquery
 
-# Use Ubuntu's ntp server as a fallback.
-pool ntp.ubuntu.com
-
-# Access control configuration; see /usr/share/doc/ntp-doc/html/accopt.html for
-# details.  The web page <http://support.ntp.org/bin/view/Support/AccessRestrictions>
-# might also be helpful.
-#
-# Note that "restrict" applies to both servers and clients, so a configuration
-# that might be intended to block requests from certain clients could also end
-# up blocking replies from your own upstream servers.
-
-# By default, exchange time with everybody, but don't allow configuration.
-restrict -4 default kod notrap nomodify nopeer noquery limited
-restrict -6 default kod notrap nomodify nopeer noquery limited
-
-# Local users may interrogate the ntp server more closely.
+# Only allow read-only access from localhost
 restrict 127.0.0.1
 restrict ::1
 
-# Needed for adding pool entries
-restrict source notrap nomodify noquery
+# mode7 is required for collectd monitoring
 
-# Clients from this (example!) subnet have unlimited access, but only if
-# cryptographically authenticated.
-#restrict 192.168.123.0 mask 255.255.255.0 notrust
-
-
-# If you want to provide time to your local subnet, change the next line.
-# (Again, the address is an example only.)
-#broadcast 192.168.123.255
-
-# If you want to listen to time broadcasts on your local subnet, de-comment the
-# next lines.  Please do this only if you trust everybody on the network!
-#disable auth
-#broadcastclient
-
-#Changes recquired to use pps synchonisation as explained in documentation:
-#http://www.ntp.org/ntpfaq/NTP-s-config-adv.htm#AEN3918
-
-#server 127.127.8.1 mode 135 prefer    # Meinberg GPS167 with PPS
-#fudge 127.127.8.1 time1 0.0042        # relative to PPS for my hardware
-
-#server 127.127.22.1                   # ATOM(PPS)
-#fudge 127.127.22.1 flag3 1            # enable PPS API
+# Location of drift file
+driftfile /var/lib/ntp/ntp.drift
+logfile /var/log/ntp.log

2018-05-11 04:03:56,951 [salt.state       ][INFO    ][2612] Completed state [/etc/ntp.conf] at time 04:03:56.951560 duration_in_ms=105.438
2018-05-11 04:03:57,232 [salt.state       ][INFO    ][2612] Running state [ntp] at time 04:03:57.232024
2018-05-11 04:03:57,232 [salt.state       ][INFO    ][2612] Executing state service.running for ntp
2018-05-11 04:03:57,232 [salt.loaded.int.module.cmdmod][INFO    ][2612] Executing command ['systemctl', 'status', 'ntp.service', '-n', '0'] in directory '/root'
2018-05-11 04:03:57,252 [salt.loaded.int.module.cmdmod][INFO    ][2612] Executing command ['systemctl', 'is-active', 'ntp.service'] in directory '/root'
2018-05-11 04:03:57,280 [salt.loaded.int.module.cmdmod][INFO    ][2612] Executing command ['systemctl', 'is-enabled', 'ntp.service'] in directory '/root'
2018-05-11 04:03:57,308 [salt.state       ][INFO    ][2612] The service ntp is already running
2018-05-11 04:03:57,309 [salt.state       ][INFO    ][2612] Completed state [ntp] at time 04:03:57.309578 duration_in_ms=77.553
2018-05-11 04:03:57,310 [salt.state       ][INFO    ][2612] Running state [ntp] at time 04:03:57.310006
2018-05-11 04:03:57,310 [salt.state       ][INFO    ][2612] Executing state service.mod_watch for ntp
2018-05-11 04:03:57,311 [salt.loaded.int.module.cmdmod][INFO    ][2612] Executing command ['systemctl', 'is-active', 'ntp.service'] in directory '/root'
2018-05-11 04:03:57,330 [salt.loaded.int.module.cmdmod][INFO    ][2612] Executing command ['systemctl', 'is-enabled', 'ntp.service'] in directory '/root'
2018-05-11 04:03:57,356 [salt.loaded.int.module.cmdmod][INFO    ][2612] Executing command ['systemd-run', '--scope', 'systemctl', 'restart', 'ntp.service'] in directory '/root'
2018-05-11 04:03:57,435 [salt.state       ][INFO    ][2612] {'ntp': True}
2018-05-11 04:03:57,435 [salt.state       ][INFO    ][2612] Completed state [ntp] at time 04:03:57.435472 duration_in_ms=125.465
2018-05-11 04:03:57,439 [salt.minion      ][INFO    ][2612] Returning information for job: 20180511040314534297
2018-05-11 04:04:36,141 [salt.minion      ][INFO    ][2517] User sudo_ubuntu Executing command state.apply with jid 20180511040436129538
2018-05-11 04:04:36,182 [salt.minion      ][INFO    ][5819] Starting a new job with PID 5819
2018-05-11 04:04:39,203 [salt.state       ][INFO    ][5819] Loading fresh modules for state activity
2018-05-11 04:04:42,406 [salt.state       ][INFO    ][5819] Running state [/etc/environment] at time 04:04:42.406081
2018-05-11 04:04:42,406 [salt.state       ][INFO    ][5819] Executing state file.blockreplace for /etc/environment
2018-05-11 04:04:42,416 [salt.state       ][INFO    ][5819] File changed:
--- 
+++ 
@@ -1,3 +1,4 @@
 PATH="/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/games:/usr/local/games"
 # SALT MANAGED VARIABLES - DO NOT EDIT - START
+# 
 # # SALT MANAGED VARIABLES - END

2018-05-11 04:04:42,416 [salt.state       ][INFO    ][5819] Completed state [/etc/environment] at time 04:04:42.416318 duration_in_ms=10.238
2018-05-11 04:04:42,416 [salt.state       ][INFO    ][5819] Running state [/etc/profile.d] at time 04:04:42.416642
2018-05-11 04:04:42,416 [salt.state       ][INFO    ][5819] Executing state file.directory for /etc/profile.d
2018-05-11 04:04:42,418 [salt.state       ][INFO    ][5819] Directory /etc/profile.d is in the correct state
2018-05-11 04:04:42,418 [salt.state       ][INFO    ][5819] Completed state [/etc/profile.d] at time 04:04:42.418908 duration_in_ms=2.266
2018-05-11 04:04:42,906 [salt.state       ][INFO    ][5819] Running state [/etc/apt/apt.conf.d/99prefer_ipv4-salt] at time 04:04:42.906130
2018-05-11 04:04:42,906 [salt.state       ][INFO    ][5819] Executing state file.managed for /etc/apt/apt.conf.d/99prefer_ipv4-salt
2018-05-11 04:04:42,933 [salt.state       ][INFO    ][5819] File /etc/apt/apt.conf.d/99prefer_ipv4-salt is in the correct state
2018-05-11 04:04:42,934 [salt.state       ][INFO    ][5819] Completed state [/etc/apt/apt.conf.d/99prefer_ipv4-salt] at time 04:04:42.934109 duration_in_ms=27.98
2018-05-11 04:04:42,934 [salt.state       ][INFO    ][5819] Running state [linux_repo_prereq_pkgs] at time 04:04:42.934586
2018-05-11 04:04:42,934 [salt.state       ][INFO    ][5819] Executing state pkg.installed for linux_repo_prereq_pkgs
2018-05-11 04:04:42,935 [salt.loaded.int.module.cmdmod][INFO    ][5819] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2018-05-11 04:04:43,325 [salt.state       ][INFO    ][5819] All specified packages are already installed
2018-05-11 04:04:43,325 [salt.state       ][INFO    ][5819] Completed state [linux_repo_prereq_pkgs] at time 04:04:43.325802 duration_in_ms=391.214
2018-05-11 04:04:43,326 [salt.state       ][INFO    ][5819] Running state [/etc/apt/apt.conf.d/99proxies-salt-uca-staging] at time 04:04:43.326093
2018-05-11 04:04:43,326 [salt.state       ][INFO    ][5819] Executing state file.absent for /etc/apt/apt.conf.d/99proxies-salt-uca-staging
2018-05-11 04:04:43,326 [salt.state       ][INFO    ][5819] File /etc/apt/apt.conf.d/99proxies-salt-uca-staging is not present
2018-05-11 04:04:43,326 [salt.state       ][INFO    ][5819] Completed state [/etc/apt/apt.conf.d/99proxies-salt-uca-staging] at time 04:04:43.326858 duration_in_ms=0.765
2018-05-11 04:04:43,327 [salt.state       ][INFO    ][5819] Running state [/etc/apt/preferences.d/uca-staging] at time 04:04:43.327027
2018-05-11 04:04:43,327 [salt.state       ][INFO    ][5819] Executing state file.absent for /etc/apt/preferences.d/uca-staging
2018-05-11 04:04:43,327 [salt.state       ][INFO    ][5819] File /etc/apt/preferences.d/uca-staging is not present
2018-05-11 04:04:43,327 [salt.state       ][INFO    ][5819] Completed state [/etc/apt/preferences.d/uca-staging] at time 04:04:43.327556 duration_in_ms=0.529
2018-05-11 04:04:43,329 [salt.state       ][INFO    ][5819] Running state [apt-key adv --keyserver keyserver.ubuntu.com --recv 9F68104E] at time 04:04:43.329127
2018-05-11 04:04:43,329 [salt.state       ][INFO    ][5819] Executing state cmd.run for apt-key adv --keyserver keyserver.ubuntu.com --recv 9F68104E
2018-05-11 04:04:43,329 [salt.loaded.int.module.cmdmod][INFO    ][5819] Executing command 'apt-key adv --keyserver keyserver.ubuntu.com --recv 9F68104E' in directory '/root'
2018-05-11 04:04:43,626 [salt.state       ][INFO    ][5819] {'pid': 5877, 'retcode': 0, 'stderr': 'gpg: requesting key 9F68104E from hkp server keyserver.ubuntu.com\ngpg: key 9F68104E: "Launchpad PPA for Ubuntu Cloud Archive Team" not changed\ngpg: Total number processed: 1\ngpg:              unchanged: 1', 'stdout': 'Executing: /tmp/tmp.w5sODVzVC2/gpg.1.sh --keyserver\nkeyserver.ubuntu.com\n--recv\n9F68104E'}
2018-05-11 04:04:43,626 [salt.state       ][INFO    ][5819] Completed state [apt-key adv --keyserver keyserver.ubuntu.com --recv 9F68104E] at time 04:04:43.626704 duration_in_ms=297.576
2018-05-11 04:04:43,630 [salt.state       ][INFO    ][5819] Running state [deb http://ppa.launchpad.net/ubuntu-cloud-archive/pike-staging/ubuntu xenial main] at time 04:04:43.630262
2018-05-11 04:04:43,630 [salt.state       ][INFO    ][5819] Executing state pkgrepo.managed for deb http://ppa.launchpad.net/ubuntu-cloud-archive/pike-staging/ubuntu xenial main
2018-05-11 04:04:43,662 [salt.state       ][INFO    ][5819] Package repo 'deb http://ppa.launchpad.net/ubuntu-cloud-archive/pike-staging/ubuntu xenial main' already configured
2018-05-11 04:04:43,662 [salt.state       ][INFO    ][5819] Completed state [deb http://ppa.launchpad.net/ubuntu-cloud-archive/pike-staging/ubuntu xenial main] at time 04:04:43.662887 duration_in_ms=32.625
2018-05-11 04:04:43,663 [salt.state       ][INFO    ][5819] Running state [/etc/apt/apt.conf.d/99proxies-salt-uca] at time 04:04:43.663336
2018-05-11 04:04:43,663 [salt.state       ][INFO    ][5819] Executing state file.absent for /etc/apt/apt.conf.d/99proxies-salt-uca
2018-05-11 04:04:43,664 [salt.state       ][INFO    ][5819] File /etc/apt/apt.conf.d/99proxies-salt-uca is not present
2018-05-11 04:04:43,664 [salt.state       ][INFO    ][5819] Completed state [/etc/apt/apt.conf.d/99proxies-salt-uca] at time 04:04:43.664614 duration_in_ms=1.277
2018-05-11 04:04:43,665 [salt.state       ][INFO    ][5819] Running state [/etc/apt/preferences.d/uca] at time 04:04:43.665015
2018-05-11 04:04:43,665 [salt.state       ][INFO    ][5819] Executing state file.absent for /etc/apt/preferences.d/uca
2018-05-11 04:04:43,665 [salt.state       ][INFO    ][5819] File /etc/apt/preferences.d/uca is not present
2018-05-11 04:04:43,666 [salt.state       ][INFO    ][5819] Completed state [/etc/apt/preferences.d/uca] at time 04:04:43.666132 duration_in_ms=1.117
2018-05-11 04:04:43,666 [salt.state       ][INFO    ][5819] Running state [apt-key adv --keyserver keyserver.ubuntu.com --recv EC4926EA] at time 04:04:43.666496
2018-05-11 04:04:43,666 [salt.state       ][INFO    ][5819] Executing state cmd.run for apt-key adv --keyserver keyserver.ubuntu.com --recv EC4926EA
2018-05-11 04:04:43,667 [salt.loaded.int.module.cmdmod][INFO    ][5819] Executing command 'apt-key adv --keyserver keyserver.ubuntu.com --recv EC4926EA' in directory '/root'
2018-05-11 04:04:43,927 [salt.state       ][INFO    ][5819] {'pid': 5985, 'retcode': 0, 'stderr': 'gpg: requesting key EC4926EA from hkp server keyserver.ubuntu.com\ngpg: key EC4926EA: "Canonical Cloud Archive Signing Key <ftpmaster@canonical.com>" not changed\ngpg: Total number processed: 1\ngpg:              unchanged: 1', 'stdout': 'Executing: /tmp/tmp.SXi5CiTOzL/gpg.1.sh --keyserver\nkeyserver.ubuntu.com\n--recv\nEC4926EA'}
2018-05-11 04:04:43,928 [salt.state       ][INFO    ][5819] Completed state [apt-key adv --keyserver keyserver.ubuntu.com --recv EC4926EA] at time 04:04:43.928311 duration_in_ms=261.815
2018-05-11 04:04:43,929 [salt.state       ][INFO    ][5819] Running state [deb http://ubuntu-cloud.archive.canonical.com/ubuntu xenial-updates/pike main] at time 04:04:43.929618
2018-05-11 04:04:43,930 [salt.state       ][INFO    ][5819] Executing state pkgrepo.managed for deb http://ubuntu-cloud.archive.canonical.com/ubuntu xenial-updates/pike main
2018-05-11 04:04:44,011 [salt.state       ][INFO    ][5819] Package repo 'deb http://ubuntu-cloud.archive.canonical.com/ubuntu xenial-updates/pike main' already configured
2018-05-11 04:04:44,012 [salt.state       ][INFO    ][5819] Completed state [deb http://ubuntu-cloud.archive.canonical.com/ubuntu xenial-updates/pike main] at time 04:04:44.012439 duration_in_ms=82.821
2018-05-11 04:04:44,013 [salt.state       ][INFO    ][5819] Running state [UTC] at time 04:04:44.013200
2018-05-11 04:04:44,013 [salt.state       ][INFO    ][5819] Executing state timezone.system for UTC
2018-05-11 04:04:44,014 [salt.loaded.int.module.cmdmod][INFO    ][5819] Executing command ['timedatectl'] in directory '/root'
2018-05-11 04:04:44,043 [salt.loaded.int.module.cmdmod][INFO    ][5819] Executing command ['timedatectl'] in directory '/root'
2018-05-11 04:04:44,058 [salt.state       ][INFO    ][5819] Timezone UTC already set, UTC already set to UTC
2018-05-11 04:04:44,059 [salt.state       ][INFO    ][5819] Completed state [UTC] at time 04:04:44.059171 duration_in_ms=45.97
2018-05-11 04:04:44,061 [salt.state       ][INFO    ][5819] Running state [nf_conntrack] at time 04:04:44.061043
2018-05-11 04:04:44,061 [salt.state       ][INFO    ][5819] Executing state kmod.present for nf_conntrack
2018-05-11 04:04:44,062 [salt.loaded.int.module.cmdmod][INFO    ][5819] Executing command 'lsmod' in directory '/root'
2018-05-11 04:04:44,089 [salt.state       ][INFO    ][5819] Kernel module nf_conntrack is already present
2018-05-11 04:04:44,090 [salt.state       ][INFO    ][5819] Completed state [nf_conntrack] at time 04:04:44.090375 duration_in_ms=29.33
2018-05-11 04:04:44,092 [salt.state       ][INFO    ][5819] Running state [kernel.panic] at time 04:04:44.092616
2018-05-11 04:04:44,093 [salt.state       ][INFO    ][5819] Executing state sysctl.present for kernel.panic
2018-05-11 04:04:44,116 [salt.loaded.int.module.cmdmod][INFO    ][5819] Executing command 'sysctl -a' in directory '/root'
2018-05-11 04:04:44,165 [salt.state       ][INFO    ][5819] Sysctl value kernel.panic = 60 is already set
2018-05-11 04:04:44,166 [salt.state       ][INFO    ][5819] Completed state [kernel.panic] at time 04:04:44.166021 duration_in_ms=73.406
2018-05-11 04:04:44,166 [salt.state       ][INFO    ][5819] Running state [net.ipv4.tcp_keepalive_probes] at time 04:04:44.166445
2018-05-11 04:04:44,166 [salt.state       ][INFO    ][5819] Executing state sysctl.present for net.ipv4.tcp_keepalive_probes
2018-05-11 04:04:44,167 [salt.loaded.int.module.cmdmod][INFO    ][5819] Executing command 'sysctl -a' in directory '/root'
2018-05-11 04:04:44,206 [salt.state       ][INFO    ][5819] Sysctl value net.ipv4.tcp_keepalive_probes = 8 is already set
2018-05-11 04:04:44,207 [salt.state       ][INFO    ][5819] Completed state [net.ipv4.tcp_keepalive_probes] at time 04:04:44.206953 duration_in_ms=40.506
2018-05-11 04:04:44,207 [salt.state       ][INFO    ][5819] Running state [fs.file-max] at time 04:04:44.207535
2018-05-11 04:04:44,208 [salt.state       ][INFO    ][5819] Executing state sysctl.present for fs.file-max
2018-05-11 04:04:44,208 [salt.loaded.int.module.cmdmod][INFO    ][5819] Executing command 'sysctl -a' in directory '/root'
2018-05-11 04:04:44,243 [salt.state       ][INFO    ][5819] Sysctl value fs.file-max = 124165 is already set
2018-05-11 04:04:44,244 [salt.state       ][INFO    ][5819] Completed state [fs.file-max] at time 04:04:44.244671 duration_in_ms=37.135
2018-05-11 04:04:44,245 [salt.state       ][INFO    ][5819] Running state [net.core.somaxconn] at time 04:04:44.245481
2018-05-11 04:04:44,246 [salt.state       ][INFO    ][5819] Executing state sysctl.present for net.core.somaxconn
2018-05-11 04:04:44,247 [salt.loaded.int.module.cmdmod][INFO    ][5819] Executing command 'sysctl -a' in directory '/root'
2018-05-11 04:04:44,284 [salt.state       ][INFO    ][5819] Sysctl value net.core.somaxconn = 4096 is already set
2018-05-11 04:04:44,285 [salt.state       ][INFO    ][5819] Completed state [net.core.somaxconn] at time 04:04:44.285007 duration_in_ms=39.526
2018-05-11 04:04:44,285 [salt.state       ][INFO    ][5819] Running state [net.ipv4.tcp_max_syn_backlog] at time 04:04:44.285592
2018-05-11 04:04:44,286 [salt.state       ][INFO    ][5819] Executing state sysctl.present for net.ipv4.tcp_max_syn_backlog
2018-05-11 04:04:44,287 [salt.loaded.int.module.cmdmod][INFO    ][5819] Executing command 'sysctl -a' in directory '/root'
2018-05-11 04:04:44,319 [salt.state       ][INFO    ][5819] Sysctl value net.ipv4.tcp_max_syn_backlog = 8192 is already set
2018-05-11 04:04:44,320 [salt.state       ][INFO    ][5819] Completed state [net.ipv4.tcp_max_syn_backlog] at time 04:04:44.320153 duration_in_ms=34.562
2018-05-11 04:04:44,320 [salt.state       ][INFO    ][5819] Running state [net.ipv4.tcp_tw_reuse] at time 04:04:44.320559
2018-05-11 04:04:44,320 [salt.state       ][INFO    ][5819] Executing state sysctl.present for net.ipv4.tcp_tw_reuse
2018-05-11 04:04:44,321 [salt.loaded.int.module.cmdmod][INFO    ][5819] Executing command 'sysctl -a' in directory '/root'
2018-05-11 04:04:44,353 [salt.state       ][INFO    ][5819] Sysctl value net.ipv4.tcp_tw_reuse = 1 is already set
2018-05-11 04:04:44,353 [salt.state       ][INFO    ][5819] Completed state [net.ipv4.tcp_tw_reuse] at time 04:04:44.353701 duration_in_ms=33.142
2018-05-11 04:04:44,354 [salt.state       ][INFO    ][5819] Running state [net.ipv4.tcp_congestion_control] at time 04:04:44.354039
2018-05-11 04:04:44,354 [salt.state       ][INFO    ][5819] Executing state sysctl.present for net.ipv4.tcp_congestion_control
2018-05-11 04:04:44,354 [salt.loaded.int.module.cmdmod][INFO    ][5819] Executing command 'sysctl -a' in directory '/root'
2018-05-11 04:04:44,389 [salt.state       ][INFO    ][5819] Sysctl value net.ipv4.tcp_congestion_control = yeah is already set
2018-05-11 04:04:44,390 [salt.state       ][INFO    ][5819] Completed state [net.ipv4.tcp_congestion_control] at time 04:04:44.390020 duration_in_ms=35.98
2018-05-11 04:04:44,390 [salt.state       ][INFO    ][5819] Running state [net.ipv4.tcp_retries2] at time 04:04:44.390426
2018-05-11 04:04:44,390 [salt.state       ][INFO    ][5819] Executing state sysctl.present for net.ipv4.tcp_retries2
2018-05-11 04:04:44,391 [salt.loaded.int.module.cmdmod][INFO    ][5819] Executing command 'sysctl -a' in directory '/root'
2018-05-11 04:04:44,425 [salt.state       ][INFO    ][5819] Sysctl value net.ipv4.tcp_retries2 = 5 is already set
2018-05-11 04:04:44,426 [salt.state       ][INFO    ][5819] Completed state [net.ipv4.tcp_retries2] at time 04:04:44.426116 duration_in_ms=35.688
2018-05-11 04:04:44,426 [salt.state       ][INFO    ][5819] Running state [net.core.netdev_max_backlog] at time 04:04:44.426596
2018-05-11 04:04:44,427 [salt.state       ][INFO    ][5819] Executing state sysctl.present for net.core.netdev_max_backlog
2018-05-11 04:04:44,427 [salt.loaded.int.module.cmdmod][INFO    ][5819] Executing command 'sysctl -a' in directory '/root'
2018-05-11 04:04:44,460 [salt.state       ][INFO    ][5819] Sysctl value net.core.netdev_max_backlog = 261144 is already set
2018-05-11 04:04:44,460 [salt.state       ][INFO    ][5819] Completed state [net.core.netdev_max_backlog] at time 04:04:44.460690 duration_in_ms=34.093
2018-05-11 04:04:44,461 [salt.state       ][INFO    ][5819] Running state [net.ipv4.tcp_slow_start_after_idle] at time 04:04:44.461176
2018-05-11 04:04:44,461 [salt.state       ][INFO    ][5819] Executing state sysctl.present for net.ipv4.tcp_slow_start_after_idle
2018-05-11 04:04:44,462 [salt.loaded.int.module.cmdmod][INFO    ][5819] Executing command 'sysctl -a' in directory '/root'
2018-05-11 04:04:44,493 [salt.state       ][INFO    ][5819] Sysctl value net.ipv4.tcp_slow_start_after_idle = 0 is already set
2018-05-11 04:04:44,494 [salt.state       ][INFO    ][5819] Completed state [net.ipv4.tcp_slow_start_after_idle] at time 04:04:44.494256 duration_in_ms=33.079
2018-05-11 04:04:44,494 [salt.state       ][INFO    ][5819] Running state [vm.swappiness] at time 04:04:44.494729
2018-05-11 04:04:44,495 [salt.state       ][INFO    ][5819] Executing state sysctl.present for vm.swappiness
2018-05-11 04:04:44,496 [salt.loaded.int.module.cmdmod][INFO    ][5819] Executing command 'sysctl -a' in directory '/root'
2018-05-11 04:04:44,525 [salt.state       ][INFO    ][5819] Sysctl value vm.swappiness = 10 is already set
2018-05-11 04:04:44,526 [salt.state       ][INFO    ][5819] Completed state [vm.swappiness] at time 04:04:44.526376 duration_in_ms=31.646
2018-05-11 04:04:44,526 [salt.state       ][INFO    ][5819] Running state [net.ipv4.tcp_keepalive_intvl] at time 04:04:44.526819
2018-05-11 04:04:44,527 [salt.state       ][INFO    ][5819] Executing state sysctl.present for net.ipv4.tcp_keepalive_intvl
2018-05-11 04:04:44,528 [salt.loaded.int.module.cmdmod][INFO    ][5819] Executing command 'sysctl -a' in directory '/root'
2018-05-11 04:04:44,558 [salt.state       ][INFO    ][5819] Sysctl value net.ipv4.tcp_keepalive_intvl = 3 is already set
2018-05-11 04:04:44,559 [salt.state       ][INFO    ][5819] Completed state [net.ipv4.tcp_keepalive_intvl] at time 04:04:44.559138 duration_in_ms=32.318
2018-05-11 04:04:44,559 [salt.state       ][INFO    ][5819] Running state [net.ipv4.neigh.default.gc_thresh1] at time 04:04:44.559641
2018-05-11 04:04:44,560 [salt.state       ][INFO    ][5819] Executing state sysctl.present for net.ipv4.neigh.default.gc_thresh1
2018-05-11 04:04:44,560 [salt.loaded.int.module.cmdmod][INFO    ][5819] Executing command 'sysctl -a' in directory '/root'
2018-05-11 04:04:44,597 [salt.state       ][INFO    ][5819] Sysctl value net.ipv4.neigh.default.gc_thresh1 = 4096 is already set
2018-05-11 04:04:44,597 [salt.state       ][INFO    ][5819] Completed state [net.ipv4.neigh.default.gc_thresh1] at time 04:04:44.597468 duration_in_ms=37.826
2018-05-11 04:04:44,598 [salt.state       ][INFO    ][5819] Running state [net.ipv4.neigh.default.gc_thresh2] at time 04:04:44.597959
2018-05-11 04:04:44,598 [salt.state       ][INFO    ][5819] Executing state sysctl.present for net.ipv4.neigh.default.gc_thresh2
2018-05-11 04:04:44,599 [salt.loaded.int.module.cmdmod][INFO    ][5819] Executing command 'sysctl -a' in directory '/root'
2018-05-11 04:04:44,635 [salt.state       ][INFO    ][5819] Sysctl value net.ipv4.neigh.default.gc_thresh2 = 8192 is already set
2018-05-11 04:04:44,636 [salt.state       ][INFO    ][5819] Completed state [net.ipv4.neigh.default.gc_thresh2] at time 04:04:44.636144 duration_in_ms=38.184
2018-05-11 04:04:44,636 [salt.state       ][INFO    ][5819] Running state [net.ipv4.neigh.default.gc_thresh3] at time 04:04:44.636616
2018-05-11 04:04:44,637 [salt.state       ][INFO    ][5819] Executing state sysctl.present for net.ipv4.neigh.default.gc_thresh3
2018-05-11 04:04:44,637 [salt.loaded.int.module.cmdmod][INFO    ][5819] Executing command 'sysctl -a' in directory '/root'
2018-05-11 04:04:44,684 [salt.state       ][INFO    ][5819] Sysctl value net.ipv4.neigh.default.gc_thresh3 = 16384 is already set
2018-05-11 04:04:44,684 [salt.state       ][INFO    ][5819] Completed state [net.ipv4.neigh.default.gc_thresh3] at time 04:04:44.684724 duration_in_ms=48.107
2018-05-11 04:04:44,685 [salt.state       ][INFO    ][5819] Running state [net.ipv4.tcp_fin_timeout] at time 04:04:44.685067
2018-05-11 04:04:44,685 [salt.state       ][INFO    ][5819] Executing state sysctl.present for net.ipv4.tcp_fin_timeout
2018-05-11 04:04:44,685 [salt.loaded.int.module.cmdmod][INFO    ][5819] Executing command 'sysctl -a' in directory '/root'
2018-05-11 04:04:44,713 [salt.state       ][INFO    ][5819] Sysctl value net.ipv4.tcp_fin_timeout = 30 is already set
2018-05-11 04:04:44,713 [salt.state       ][INFO    ][5819] Completed state [net.ipv4.tcp_fin_timeout] at time 04:04:44.713324 duration_in_ms=28.256
2018-05-11 04:04:44,713 [salt.state       ][INFO    ][5819] Running state [net.ipv4.tcp_keepalive_time] at time 04:04:44.713630
2018-05-11 04:04:44,713 [salt.state       ][INFO    ][5819] Executing state sysctl.present for net.ipv4.tcp_keepalive_time
2018-05-11 04:04:44,714 [salt.loaded.int.module.cmdmod][INFO    ][5819] Executing command 'sysctl -a' in directory '/root'
2018-05-11 04:04:44,772 [salt.state       ][INFO    ][5819] Sysctl value net.ipv4.tcp_keepalive_time = 30 is already set
2018-05-11 04:04:44,772 [salt.state       ][INFO    ][5819] Completed state [net.ipv4.tcp_keepalive_time] at time 04:04:44.772388 duration_in_ms=58.756
2018-05-11 04:04:44,772 [salt.state       ][INFO    ][5819] Running state [net.nf_conntrack_max] at time 04:04:44.772706
2018-05-11 04:04:44,772 [salt.state       ][INFO    ][5819] Executing state sysctl.present for net.nf_conntrack_max
2018-05-11 04:04:44,773 [salt.loaded.int.module.cmdmod][INFO    ][5819] Executing command 'sysctl -a' in directory '/root'
2018-05-11 04:04:44,821 [salt.state       ][INFO    ][5819] Sysctl value net.nf_conntrack_max = 1048576 is already set
2018-05-11 04:04:44,821 [salt.state       ][INFO    ][5819] Completed state [net.nf_conntrack_max] at time 04:04:44.821519 duration_in_ms=48.813
2018-05-11 04:04:44,821 [salt.state       ][INFO    ][5819] Running state [linux_sysfs_package] at time 04:04:44.821852
2018-05-11 04:04:44,822 [salt.state       ][INFO    ][5819] Executing state pkg.installed for linux_sysfs_package
2018-05-11 04:04:44,827 [salt.state       ][INFO    ][5819] All specified packages are already installed
2018-05-11 04:04:44,827 [salt.state       ][INFO    ][5819] Completed state [linux_sysfs_package] at time 04:04:44.827601 duration_in_ms=5.749
2018-05-11 04:04:44,828 [salt.state       ][INFO    ][5819] Running state [/etc/sysfs.d] at time 04:04:44.828593
2018-05-11 04:04:44,828 [salt.state       ][INFO    ][5819] Executing state file.directory for /etc/sysfs.d
2018-05-11 04:04:44,829 [salt.state       ][INFO    ][5819] Directory /etc/sysfs.d is in the correct state
2018-05-11 04:04:44,829 [salt.state       ][INFO    ][5819] Completed state [/etc/sysfs.d] at time 04:04:44.829527 duration_in_ms=0.934
2018-05-11 04:04:44,830 [salt.state       ][INFO    ][5819] Running state [ondemand] at time 04:04:44.830170
2018-05-11 04:04:44,830 [salt.state       ][INFO    ][5819] Executing state service.dead for ondemand
2018-05-11 04:04:44,830 [salt.loaded.int.module.cmdmod][INFO    ][5819] Executing command ['systemctl', 'status', 'ondemand.service', '-n', '0'] in directory '/root'
2018-05-11 04:04:44,846 [salt.loaded.int.module.cmdmod][INFO    ][5819] Executing command ['systemctl', 'is-active', 'ondemand.service'] in directory '/root'
2018-05-11 04:04:44,864 [salt.loaded.int.module.cmdmod][INFO    ][5819] Executing command ['systemctl', 'is-enabled', 'ondemand.service'] in directory '/root'
2018-05-11 04:04:44,886 [salt.loaded.int.module.cmdmod][INFO    ][5819] Executing command 'runlevel' in directory '/root'
2018-05-11 04:04:44,903 [salt.state       ][INFO    ][5819] The service ondemand is already dead
2018-05-11 04:04:44,903 [salt.state       ][INFO    ][5819] Completed state [ondemand] at time 04:04:44.903531 duration_in_ms=73.361
2018-05-11 04:04:44,904 [salt.state       ][INFO    ][5819] Running state [cs_CZ.UTF-8] at time 04:04:44.904375
2018-05-11 04:04:44,904 [salt.state       ][INFO    ][5819] Executing state locale.present for cs_CZ.UTF-8
2018-05-11 04:04:44,905 [salt.loaded.int.module.cmdmod][INFO    ][5819] Executing command 'locale -a' in directory '/root'
2018-05-11 04:04:44,919 [salt.state       ][INFO    ][5819] Locale cs_CZ.UTF-8 is already present
2018-05-11 04:04:44,919 [salt.state       ][INFO    ][5819] Completed state [cs_CZ.UTF-8] at time 04:04:44.919504 duration_in_ms=15.129
2018-05-11 04:04:44,919 [salt.state       ][INFO    ][5819] Running state [en_US.UTF-8] at time 04:04:44.919834
2018-05-11 04:04:44,920 [salt.state       ][INFO    ][5819] Executing state locale.present for en_US.UTF-8
2018-05-11 04:04:44,920 [salt.loaded.int.module.cmdmod][INFO    ][5819] Executing command 'locale -a' in directory '/root'
2018-05-11 04:04:44,933 [salt.state       ][INFO    ][5819] Locale en_US.UTF-8 is already present
2018-05-11 04:04:44,934 [salt.state       ][INFO    ][5819] Completed state [en_US.UTF-8] at time 04:04:44.934207 duration_in_ms=14.373
2018-05-11 04:04:44,935 [salt.state       ][INFO    ][5819] Running state [en_US.UTF-8] at time 04:04:44.935517
2018-05-11 04:04:44,935 [salt.state       ][INFO    ][5819] Executing state locale.system for en_US.UTF-8
2018-05-11 04:04:44,936 [salt.loaded.int.module.cmdmod][INFO    ][5819] Executing command 'localectl' in directory '/root'
2018-05-11 04:04:44,964 [salt.state       ][INFO    ][5819] System locale en_US.UTF-8 already set
2018-05-11 04:04:44,964 [salt.state       ][INFO    ][5819] Completed state [en_US.UTF-8] at time 04:04:44.964754 duration_in_ms=29.237
2018-05-11 04:04:44,965 [salt.state       ][INFO    ][5819] Running state [root] at time 04:04:44.965729
2018-05-11 04:04:44,966 [salt.state       ][INFO    ][5819] Executing state group.present for root
2018-05-11 04:04:44,966 [salt.state       ][INFO    ][5819] Group root is present and up to date
2018-05-11 04:04:44,966 [salt.state       ][INFO    ][5819] Completed state [root] at time 04:04:44.966652 duration_in_ms=0.923
2018-05-11 04:04:44,968 [salt.state       ][INFO    ][5819] Running state [root] at time 04:04:44.968770
2018-05-11 04:04:44,969 [salt.state       ][INFO    ][5819] Executing state user.present for root
2018-05-11 04:04:44,970 [salt.state       ][INFO    ][5819] User root is present and up to date
2018-05-11 04:04:44,970 [salt.state       ][INFO    ][5819] Completed state [root] at time 04:04:44.970301 duration_in_ms=1.53
2018-05-11 04:04:44,971 [salt.state       ][INFO    ][5819] Running state [/root] at time 04:04:44.971044
2018-05-11 04:04:44,971 [salt.state       ][INFO    ][5819] Executing state file.directory for /root
2018-05-11 04:04:44,971 [salt.state       ][INFO    ][5819] Directory /root is in the correct state
2018-05-11 04:04:44,972 [salt.state       ][INFO    ][5819] Completed state [/root] at time 04:04:44.972150 duration_in_ms=1.106
2018-05-11 04:04:44,972 [salt.state       ][INFO    ][5819] Running state [/etc/sudoers.d/90-salt-user-root] at time 04:04:44.972349
2018-05-11 04:04:44,972 [salt.state       ][INFO    ][5819] Executing state file.absent for /etc/sudoers.d/90-salt-user-root
2018-05-11 04:04:44,972 [salt.state       ][INFO    ][5819] File /etc/sudoers.d/90-salt-user-root is not present
2018-05-11 04:04:44,973 [salt.state       ][INFO    ][5819] Completed state [/etc/sudoers.d/90-salt-user-root] at time 04:04:44.972965 duration_in_ms=0.616
2018-05-11 04:04:44,973 [salt.state       ][INFO    ][5819] Running state [ubuntu] at time 04:04:44.973154
2018-05-11 04:04:44,973 [salt.state       ][INFO    ][5819] Executing state group.present for ubuntu
2018-05-11 04:04:44,973 [salt.state       ][INFO    ][5819] Group ubuntu is present and up to date
2018-05-11 04:04:44,973 [salt.state       ][INFO    ][5819] Completed state [ubuntu] at time 04:04:44.973753 duration_in_ms=0.599
2018-05-11 04:04:44,974 [salt.state       ][INFO    ][5819] Running state [ubuntu] at time 04:04:44.974382
2018-05-11 04:04:44,974 [salt.state       ][INFO    ][5819] Executing state user.present for ubuntu
2018-05-11 04:04:44,975 [salt.state       ][INFO    ][5819] User ubuntu is present and up to date
2018-05-11 04:04:44,975 [salt.state       ][INFO    ][5819] Completed state [ubuntu] at time 04:04:44.975660 duration_in_ms=1.278
2018-05-11 04:04:44,976 [salt.state       ][INFO    ][5819] Running state [/home/ubuntu] at time 04:04:44.976361
2018-05-11 04:04:44,976 [salt.state       ][INFO    ][5819] Executing state file.directory for /home/ubuntu
2018-05-11 04:04:44,977 [salt.state       ][INFO    ][5819] Directory /home/ubuntu is in the correct state
2018-05-11 04:04:44,977 [salt.state       ][INFO    ][5819] Completed state [/home/ubuntu] at time 04:04:44.977330 duration_in_ms=0.97
2018-05-11 04:04:44,977 [salt.state       ][INFO    ][5819] Running state [/etc/sudoers.d/90-salt-user-ubuntu] at time 04:04:44.977909
2018-05-11 04:04:44,978 [salt.state       ][INFO    ][5819] Executing state file.managed for /etc/sudoers.d/90-salt-user-ubuntu
2018-05-11 04:04:45,002 [salt.state       ][INFO    ][5819] File /etc/sudoers.d/90-salt-user-ubuntu is in the correct state
2018-05-11 04:04:45,002 [salt.state       ][INFO    ][5819] Completed state [/etc/sudoers.d/90-salt-user-ubuntu] at time 04:04:45.002877 duration_in_ms=24.967
2018-05-11 04:04:45,003 [salt.state       ][INFO    ][5819] Running state [/etc/security/limits.d/90-salt-default.conf] at time 04:04:45.003107
2018-05-11 04:04:45,003 [salt.state       ][INFO    ][5819] Executing state file.managed for /etc/security/limits.d/90-salt-default.conf
2018-05-11 04:04:45,108 [salt.state       ][INFO    ][5819] File /etc/security/limits.d/90-salt-default.conf is in the correct state
2018-05-11 04:04:45,108 [salt.state       ][INFO    ][5819] Completed state [/etc/security/limits.d/90-salt-default.conf] at time 04:04:45.108502 duration_in_ms=105.394
2018-05-11 04:04:45,108 [salt.state       ][INFO    ][5819] Running state [/etc/systemd/system.conf.d/90-salt.conf] at time 04:04:45.108757
2018-05-11 04:04:45,109 [salt.state       ][INFO    ][5819] Executing state file.managed for /etc/systemd/system.conf.d/90-salt.conf
2018-05-11 04:04:45,195 [salt.state       ][INFO    ][5819] File /etc/systemd/system.conf.d/90-salt.conf is in the correct state
2018-05-11 04:04:45,195 [salt.state       ][INFO    ][5819] Completed state [/etc/systemd/system.conf.d/90-salt.conf] at time 04:04:45.195609 duration_in_ms=86.852
2018-05-11 04:04:45,196 [salt.state       ][INFO    ][5819] Running state [service.systemctl_reload] at time 04:04:45.196773
2018-05-11 04:04:45,197 [salt.state       ][INFO    ][5819] Executing state module.wait for service.systemctl_reload
2018-05-11 04:04:45,197 [salt.state       ][INFO    ][5819] No changes made for service.systemctl_reload
2018-05-11 04:04:45,197 [salt.state       ][INFO    ][5819] Completed state [service.systemctl_reload] at time 04:04:45.197417 duration_in_ms=0.644
2018-05-11 04:04:45,197 [salt.state       ][INFO    ][5819] Running state [/etc/hostname] at time 04:04:45.197612
2018-05-11 04:04:45,197 [salt.state       ][INFO    ][5819] Executing state file.managed for /etc/hostname
2018-05-11 04:04:45,213 [salt.state       ][INFO    ][5819] File /etc/hostname is in the correct state
2018-05-11 04:04:45,213 [salt.state       ][INFO    ][5819] Completed state [/etc/hostname] at time 04:04:45.213285 duration_in_ms=15.673
2018-05-11 04:04:45,214 [salt.state       ][INFO    ][5819] Running state [hostname odl01] at time 04:04:45.214022
2018-05-11 04:04:45,214 [salt.state       ][INFO    ][5819] Executing state cmd.wait for hostname odl01
2018-05-11 04:04:45,214 [salt.state       ][INFO    ][5819] No changes made for hostname odl01
2018-05-11 04:04:45,214 [salt.state       ][INFO    ][5819] Completed state [hostname odl01] at time 04:04:45.214653 duration_in_ms=0.631
2018-05-11 04:04:45,215 [salt.state       ][INFO    ][5819] Running state [mdb02] at time 04:04:45.215115
2018-05-11 04:04:45,215 [salt.state       ][INFO    ][5819] Executing state host.present for mdb02
2018-05-11 04:04:45,215 [salt.state       ][INFO    ][5819] Host mdb02 (10.167.4.33) already present
2018-05-11 04:04:45,215 [salt.state       ][INFO    ][5819] Completed state [mdb02] at time 04:04:45.215931 duration_in_ms=0.816
2018-05-11 04:04:45,216 [salt.state       ][INFO    ][5819] Running state [mdb02.mcp-pike-odl-ha.local] at time 04:04:45.216121
2018-05-11 04:04:45,216 [salt.state       ][INFO    ][5819] Executing state host.present for mdb02.mcp-pike-odl-ha.local
2018-05-11 04:04:45,216 [salt.state       ][INFO    ][5819] Host mdb02.mcp-pike-odl-ha.local (10.167.4.33) already present
2018-05-11 04:04:45,216 [salt.state       ][INFO    ][5819] Completed state [mdb02.mcp-pike-odl-ha.local] at time 04:04:45.216833 duration_in_ms=0.711
2018-05-11 04:04:45,217 [salt.state       ][INFO    ][5819] Running state [mdb03] at time 04:04:45.217025
2018-05-11 04:04:45,217 [salt.state       ][INFO    ][5819] Executing state host.present for mdb03
2018-05-11 04:04:45,217 [salt.state       ][INFO    ][5819] Host mdb03 (10.167.4.34) already present
2018-05-11 04:04:45,217 [salt.state       ][INFO    ][5819] Completed state [mdb03] at time 04:04:45.217720 duration_in_ms=0.695
2018-05-11 04:04:45,217 [salt.state       ][INFO    ][5819] Running state [mdb03.mcp-pike-odl-ha.local] at time 04:04:45.217908
2018-05-11 04:04:45,218 [salt.state       ][INFO    ][5819] Executing state host.present for mdb03.mcp-pike-odl-ha.local
2018-05-11 04:04:45,218 [salt.state       ][INFO    ][5819] Host mdb03.mcp-pike-odl-ha.local (10.167.4.34) already present
2018-05-11 04:04:45,218 [salt.state       ][INFO    ][5819] Completed state [mdb03.mcp-pike-odl-ha.local] at time 04:04:45.218605 duration_in_ms=0.697
2018-05-11 04:04:45,218 [salt.state       ][INFO    ][5819] Running state [mdb01] at time 04:04:45.218791
2018-05-11 04:04:45,218 [salt.state       ][INFO    ][5819] Executing state host.present for mdb01
2018-05-11 04:04:45,219 [salt.state       ][INFO    ][5819] Host mdb01 (10.167.4.32) already present
2018-05-11 04:04:45,219 [salt.state       ][INFO    ][5819] Completed state [mdb01] at time 04:04:45.219517 duration_in_ms=0.725
2018-05-11 04:04:45,219 [salt.state       ][INFO    ][5819] Running state [mdb01.mcp-pike-odl-ha.local] at time 04:04:45.219704
2018-05-11 04:04:45,219 [salt.state       ][INFO    ][5819] Executing state host.present for mdb01.mcp-pike-odl-ha.local
2018-05-11 04:04:45,220 [salt.state       ][INFO    ][5819] Host mdb01.mcp-pike-odl-ha.local (10.167.4.32) already present
2018-05-11 04:04:45,220 [salt.state       ][INFO    ][5819] Completed state [mdb01.mcp-pike-odl-ha.local] at time 04:04:45.220402 duration_in_ms=0.698
2018-05-11 04:04:45,220 [salt.state       ][INFO    ][5819] Running state [mdb] at time 04:04:45.220589
2018-05-11 04:04:45,220 [salt.state       ][INFO    ][5819] Executing state host.present for mdb
2018-05-11 04:04:45,221 [salt.state       ][INFO    ][5819] Host mdb (10.167.4.31) already present
2018-05-11 04:04:45,221 [salt.state       ][INFO    ][5819] Completed state [mdb] at time 04:04:45.221298 duration_in_ms=0.709
2018-05-11 04:04:45,221 [salt.state       ][INFO    ][5819] Running state [mdb.mcp-pike-odl-ha.local] at time 04:04:45.221486
2018-05-11 04:04:45,221 [salt.state       ][INFO    ][5819] Executing state host.present for mdb.mcp-pike-odl-ha.local
2018-05-11 04:04:45,222 [salt.state       ][INFO    ][5819] Host mdb.mcp-pike-odl-ha.local (10.167.4.31) already present
2018-05-11 04:04:45,222 [salt.state       ][INFO    ][5819] Completed state [mdb.mcp-pike-odl-ha.local] at time 04:04:45.222181 duration_in_ms=0.695
2018-05-11 04:04:45,222 [salt.state       ][INFO    ][5819] Running state [cfg01] at time 04:04:45.222368
2018-05-11 04:04:45,222 [salt.state       ][INFO    ][5819] Executing state host.present for cfg01
2018-05-11 04:04:45,222 [salt.state       ][INFO    ][5819] Host cfg01 (10.167.4.11) already present
2018-05-11 04:04:45,223 [salt.state       ][INFO    ][5819] Completed state [cfg01] at time 04:04:45.223064 duration_in_ms=0.696
2018-05-11 04:04:45,223 [salt.state       ][INFO    ][5819] Running state [cfg01.mcp-pike-odl-ha.local] at time 04:04:45.223267
2018-05-11 04:04:45,223 [salt.state       ][INFO    ][5819] Executing state host.present for cfg01.mcp-pike-odl-ha.local
2018-05-11 04:04:45,223 [salt.state       ][INFO    ][5819] Host cfg01.mcp-pike-odl-ha.local (10.167.4.11) already present
2018-05-11 04:04:45,224 [salt.state       ][INFO    ][5819] Completed state [cfg01.mcp-pike-odl-ha.local] at time 04:04:45.223990 duration_in_ms=0.723
2018-05-11 04:04:45,224 [salt.state       ][INFO    ][5819] Running state [prx01] at time 04:04:45.224176
2018-05-11 04:04:45,224 [salt.state       ][INFO    ][5819] Executing state host.present for prx01
2018-05-11 04:04:45,224 [salt.state       ][INFO    ][5819] Host prx01 (10.167.4.14) already present
2018-05-11 04:04:45,224 [salt.state       ][INFO    ][5819] Completed state [prx01] at time 04:04:45.224888 duration_in_ms=0.711
2018-05-11 04:04:45,225 [salt.state       ][INFO    ][5819] Running state [prx01.mcp-pike-odl-ha.local] at time 04:04:45.225076
2018-05-11 04:04:45,225 [salt.state       ][INFO    ][5819] Executing state host.present for prx01.mcp-pike-odl-ha.local
2018-05-11 04:04:45,225 [salt.state       ][INFO    ][5819] Host prx01.mcp-pike-odl-ha.local (10.167.4.14) already present
2018-05-11 04:04:45,225 [salt.state       ][INFO    ][5819] Completed state [prx01.mcp-pike-odl-ha.local] at time 04:04:45.225823 duration_in_ms=0.747
2018-05-11 04:04:45,226 [salt.state       ][INFO    ][5819] Running state [kvm01] at time 04:04:45.226016
2018-05-11 04:04:45,226 [salt.state       ][INFO    ][5819] Executing state host.present for kvm01
2018-05-11 04:04:45,226 [salt.state       ][INFO    ][5819] Host kvm01 (10.167.4.20) already present
2018-05-11 04:04:45,226 [salt.state       ][INFO    ][5819] Completed state [kvm01] at time 04:04:45.226717 duration_in_ms=0.701
2018-05-11 04:04:45,226 [salt.state       ][INFO    ][5819] Running state [kvm01.mcp-pike-odl-ha.local] at time 04:04:45.226909
2018-05-11 04:04:45,227 [salt.state       ][INFO    ][5819] Executing state host.present for kvm01.mcp-pike-odl-ha.local
2018-05-11 04:04:45,227 [salt.state       ][INFO    ][5819] Host kvm01.mcp-pike-odl-ha.local (10.167.4.20) already present
2018-05-11 04:04:45,227 [salt.state       ][INFO    ][5819] Completed state [kvm01.mcp-pike-odl-ha.local] at time 04:04:45.227664 duration_in_ms=0.756
2018-05-11 04:04:45,227 [salt.state       ][INFO    ][5819] Running state [kvm03] at time 04:04:45.227862
2018-05-11 04:04:45,228 [salt.state       ][INFO    ][5819] Executing state host.present for kvm03
2018-05-11 04:04:45,228 [salt.state       ][INFO    ][5819] Host kvm03 (10.167.4.22) already present
2018-05-11 04:04:45,228 [salt.state       ][INFO    ][5819] Completed state [kvm03] at time 04:04:45.228557 duration_in_ms=0.695
2018-05-11 04:04:45,228 [salt.state       ][INFO    ][5819] Running state [kvm03.mcp-pike-odl-ha.local] at time 04:04:45.228736
2018-05-11 04:04:45,228 [salt.state       ][INFO    ][5819] Executing state host.present for kvm03.mcp-pike-odl-ha.local
2018-05-11 04:04:45,229 [salt.state       ][INFO    ][5819] Host kvm03.mcp-pike-odl-ha.local (10.167.4.22) already present
2018-05-11 04:04:45,229 [salt.state       ][INFO    ][5819] Completed state [kvm03.mcp-pike-odl-ha.local] at time 04:04:45.229597 duration_in_ms=0.86
2018-05-11 04:04:45,229 [salt.state       ][INFO    ][5819] Running state [kvm02] at time 04:04:45.229790
2018-05-11 04:04:45,229 [salt.state       ][INFO    ][5819] Executing state host.present for kvm02
2018-05-11 04:04:45,230 [salt.state       ][INFO    ][5819] Host kvm02 (10.167.4.21) already present
2018-05-11 04:04:45,230 [salt.state       ][INFO    ][5819] Completed state [kvm02] at time 04:04:45.230488 duration_in_ms=0.697
2018-05-11 04:04:45,230 [salt.state       ][INFO    ][5819] Running state [kvm02.mcp-pike-odl-ha.local] at time 04:04:45.230673
2018-05-11 04:04:45,230 [salt.state       ][INFO    ][5819] Executing state host.present for kvm02.mcp-pike-odl-ha.local
2018-05-11 04:04:45,231 [salt.state       ][INFO    ][5819] Host kvm02.mcp-pike-odl-ha.local (10.167.4.21) already present
2018-05-11 04:04:45,231 [salt.state       ][INFO    ][5819] Completed state [kvm02.mcp-pike-odl-ha.local] at time 04:04:45.231393 duration_in_ms=0.72
2018-05-11 04:04:45,231 [salt.state       ][INFO    ][5819] Running state [dbs] at time 04:04:45.231583
2018-05-11 04:04:45,231 [salt.state       ][INFO    ][5819] Executing state host.present for dbs
2018-05-11 04:04:45,232 [salt.state       ][INFO    ][5819] Host dbs (10.167.4.23) already present
2018-05-11 04:04:45,232 [salt.state       ][INFO    ][5819] Completed state [dbs] at time 04:04:45.232282 duration_in_ms=0.699
2018-05-11 04:04:45,232 [salt.state       ][INFO    ][5819] Running state [dbs.mcp-pike-odl-ha.local] at time 04:04:45.232473
2018-05-11 04:04:45,232 [salt.state       ][INFO    ][5819] Executing state host.present for dbs.mcp-pike-odl-ha.local
2018-05-11 04:04:45,233 [salt.state       ][INFO    ][5819] Host dbs.mcp-pike-odl-ha.local (10.167.4.23) already present
2018-05-11 04:04:45,233 [salt.state       ][INFO    ][5819] Completed state [dbs.mcp-pike-odl-ha.local] at time 04:04:45.233192 duration_in_ms=0.718
2018-05-11 04:04:45,233 [salt.state       ][INFO    ][5819] Running state [prx] at time 04:04:45.233383
2018-05-11 04:04:45,233 [salt.state       ][INFO    ][5819] Executing state host.present for prx
2018-05-11 04:04:45,233 [salt.state       ][INFO    ][5819] Host prx (10.167.4.13) already present
2018-05-11 04:04:45,234 [salt.state       ][INFO    ][5819] Completed state [prx] at time 04:04:45.234083 duration_in_ms=0.701
2018-05-11 04:04:45,234 [salt.state       ][INFO    ][5819] Running state [prx.mcp-pike-odl-ha.local] at time 04:04:45.234276
2018-05-11 04:04:45,234 [salt.state       ][INFO    ][5819] Executing state host.present for prx.mcp-pike-odl-ha.local
2018-05-11 04:04:45,234 [salt.state       ][INFO    ][5819] Host prx.mcp-pike-odl-ha.local (10.167.4.13) already present
2018-05-11 04:04:45,235 [salt.state       ][INFO    ][5819] Completed state [prx.mcp-pike-odl-ha.local] at time 04:04:45.234973 duration_in_ms=0.697
2018-05-11 04:04:45,235 [salt.state       ][INFO    ][5819] Running state [prx02] at time 04:04:45.235164
2018-05-11 04:04:45,235 [salt.state       ][INFO    ][5819] Executing state host.present for prx02
2018-05-11 04:04:45,235 [salt.state       ][INFO    ][5819] Host prx02 (10.167.4.15) already present
2018-05-11 04:04:45,235 [salt.state       ][INFO    ][5819] Completed state [prx02] at time 04:04:45.235910 duration_in_ms=0.746
2018-05-11 04:04:45,236 [salt.state       ][INFO    ][5819] Running state [prx02.mcp-pike-odl-ha.local] at time 04:04:45.236103
2018-05-11 04:04:45,236 [salt.state       ][INFO    ][5819] Executing state host.present for prx02.mcp-pike-odl-ha.local
2018-05-11 04:04:45,236 [salt.state       ][INFO    ][5819] Host prx02.mcp-pike-odl-ha.local (10.167.4.15) already present
2018-05-11 04:04:45,236 [salt.state       ][INFO    ][5819] Completed state [prx02.mcp-pike-odl-ha.local] at time 04:04:45.236821 duration_in_ms=0.718
2018-05-11 04:04:45,237 [salt.state       ][INFO    ][5819] Running state [msg02] at time 04:04:45.237017
2018-05-11 04:04:45,237 [salt.state       ][INFO    ][5819] Executing state host.present for msg02
2018-05-11 04:04:45,237 [salt.state       ][INFO    ][5819] Host msg02 (10.167.4.29) already present
2018-05-11 04:04:45,237 [salt.state       ][INFO    ][5819] Completed state [msg02] at time 04:04:45.237714 duration_in_ms=0.697
2018-05-11 04:04:45,237 [salt.state       ][INFO    ][5819] Running state [msg02.mcp-pike-odl-ha.local] at time 04:04:45.237900
2018-05-11 04:04:45,238 [salt.state       ][INFO    ][5819] Executing state host.present for msg02.mcp-pike-odl-ha.local
2018-05-11 04:04:45,238 [salt.state       ][INFO    ][5819] Host msg02.mcp-pike-odl-ha.local (10.167.4.29) already present
2018-05-11 04:04:45,238 [salt.state       ][INFO    ][5819] Completed state [msg02.mcp-pike-odl-ha.local] at time 04:04:45.238586 duration_in_ms=0.686
2018-05-11 04:04:45,238 [salt.state       ][INFO    ][5819] Running state [msg03] at time 04:04:45.238774
2018-05-11 04:04:45,238 [salt.state       ][INFO    ][5819] Executing state host.present for msg03
2018-05-11 04:04:45,239 [salt.state       ][INFO    ][5819] Host msg03 (10.167.4.30) already present
2018-05-11 04:04:45,239 [salt.state       ][INFO    ][5819] Completed state [msg03] at time 04:04:45.239479 duration_in_ms=0.705
2018-05-11 04:04:45,239 [salt.state       ][INFO    ][5819] Running state [msg03.mcp-pike-odl-ha.local] at time 04:04:45.239663
2018-05-11 04:04:45,239 [salt.state       ][INFO    ][5819] Executing state host.present for msg03.mcp-pike-odl-ha.local
2018-05-11 04:04:45,240 [salt.state       ][INFO    ][5819] Host msg03.mcp-pike-odl-ha.local (10.167.4.30) already present
2018-05-11 04:04:45,240 [salt.state       ][INFO    ][5819] Completed state [msg03.mcp-pike-odl-ha.local] at time 04:04:45.240343 duration_in_ms=0.68
2018-05-11 04:04:45,240 [salt.state       ][INFO    ][5819] Running state [msg01] at time 04:04:45.240530
2018-05-11 04:04:45,240 [salt.state       ][INFO    ][5819] Executing state host.present for msg01
2018-05-11 04:04:45,241 [salt.state       ][INFO    ][5819] Host msg01 (10.167.4.28) already present
2018-05-11 04:04:45,241 [salt.state       ][INFO    ][5819] Completed state [msg01] at time 04:04:45.241222 duration_in_ms=0.691
2018-05-11 04:04:45,241 [salt.state       ][INFO    ][5819] Running state [msg01.mcp-pike-odl-ha.local] at time 04:04:45.241410
2018-05-11 04:04:45,241 [salt.state       ][INFO    ][5819] Executing state host.present for msg01.mcp-pike-odl-ha.local
2018-05-11 04:04:45,241 [salt.state       ][INFO    ][5819] Host msg01.mcp-pike-odl-ha.local (10.167.4.28) already present
2018-05-11 04:04:45,242 [salt.state       ][INFO    ][5819] Completed state [msg01.mcp-pike-odl-ha.local] at time 04:04:45.242088 duration_in_ms=0.678
2018-05-11 04:04:45,242 [salt.state       ][INFO    ][5819] Running state [msg] at time 04:04:45.242274
2018-05-11 04:04:45,242 [salt.state       ][INFO    ][5819] Executing state host.present for msg
2018-05-11 04:04:45,242 [salt.state       ][INFO    ][5819] Host msg (10.167.4.27) already present
2018-05-11 04:04:45,242 [salt.state       ][INFO    ][5819] Completed state [msg] at time 04:04:45.242953 duration_in_ms=0.679
2018-05-11 04:04:45,243 [salt.state       ][INFO    ][5819] Running state [msg.mcp-pike-odl-ha.local] at time 04:04:45.243140
2018-05-11 04:04:45,243 [salt.state       ][INFO    ][5819] Executing state host.present for msg.mcp-pike-odl-ha.local
2018-05-11 04:04:45,243 [salt.state       ][INFO    ][5819] Host msg.mcp-pike-odl-ha.local (10.167.4.27) already present
2018-05-11 04:04:45,243 [salt.state       ][INFO    ][5819] Completed state [msg.mcp-pike-odl-ha.local] at time 04:04:45.243874 duration_in_ms=0.734
2018-05-11 04:04:45,244 [salt.state       ][INFO    ][5819] Running state [cfg01] at time 04:04:45.244063
2018-05-11 04:04:45,244 [salt.state       ][INFO    ][5819] Executing state host.present for cfg01
2018-05-11 04:04:45,244 [salt.state       ][INFO    ][5819] Host cfg01 (10.167.4.11) already present
2018-05-11 04:04:45,244 [salt.state       ][INFO    ][5819] Completed state [cfg01] at time 04:04:45.244759 duration_in_ms=0.696
2018-05-11 04:04:45,244 [salt.state       ][INFO    ][5819] Running state [cfg01.mcp-pike-odl-ha.local] at time 04:04:45.244954
2018-05-11 04:04:45,245 [salt.state       ][INFO    ][5819] Executing state host.present for cfg01.mcp-pike-odl-ha.local
2018-05-11 04:04:45,245 [salt.state       ][INFO    ][5819] Host cfg01.mcp-pike-odl-ha.local (10.167.4.11) already present
2018-05-11 04:04:45,245 [salt.state       ][INFO    ][5819] Completed state [cfg01.mcp-pike-odl-ha.local] at time 04:04:45.245642 duration_in_ms=0.687
2018-05-11 04:04:45,245 [salt.state       ][INFO    ][5819] Running state [cmp002] at time 04:04:45.245828
2018-05-11 04:04:45,246 [salt.state       ][INFO    ][5819] Executing state host.present for cmp002
2018-05-11 04:04:45,246 [salt.state       ][INFO    ][5819] Host cmp002 (10.167.4.53) already present
2018-05-11 04:04:45,246 [salt.state       ][INFO    ][5819] Completed state [cmp002] at time 04:04:45.246510 duration_in_ms=0.682
2018-05-11 04:04:45,246 [salt.state       ][INFO    ][5819] Running state [cmp002.mcp-pike-odl-ha.local] at time 04:04:45.246700
2018-05-11 04:04:45,246 [salt.state       ][INFO    ][5819] Executing state host.present for cmp002.mcp-pike-odl-ha.local
2018-05-11 04:04:45,249 [salt.state       ][INFO    ][5819] Host cmp002.mcp-pike-odl-ha.local (10.167.4.53) already present
2018-05-11 04:04:45,249 [salt.state       ][INFO    ][5819] Completed state [cmp002.mcp-pike-odl-ha.local] at time 04:04:45.249569 duration_in_ms=2.869
2018-05-11 04:04:45,249 [salt.state       ][INFO    ][5819] Running state [cmp001] at time 04:04:45.249753
2018-05-11 04:04:45,249 [salt.state       ][INFO    ][5819] Executing state host.present for cmp001
2018-05-11 04:04:45,250 [salt.state       ][INFO    ][5819] Host cmp001 (10.167.4.52) already present
2018-05-11 04:04:45,250 [salt.state       ][INFO    ][5819] Completed state [cmp001] at time 04:04:45.250438 duration_in_ms=0.686
2018-05-11 04:04:45,250 [salt.state       ][INFO    ][5819] Running state [cmp001.mcp-pike-odl-ha.local] at time 04:04:45.250626
2018-05-11 04:04:45,250 [salt.state       ][INFO    ][5819] Executing state host.present for cmp001.mcp-pike-odl-ha.local
2018-05-11 04:04:45,251 [salt.state       ][INFO    ][5819] Host cmp001.mcp-pike-odl-ha.local (10.167.4.52) already present
2018-05-11 04:04:45,251 [salt.state       ][INFO    ][5819] Completed state [cmp001.mcp-pike-odl-ha.local] at time 04:04:45.251359 duration_in_ms=0.733
2018-05-11 04:04:45,251 [salt.state       ][INFO    ][5819] Running state [dbs01] at time 04:04:45.251554
2018-05-11 04:04:45,251 [salt.state       ][INFO    ][5819] Executing state host.present for dbs01
2018-05-11 04:04:45,252 [salt.state       ][INFO    ][5819] Host dbs01 (10.167.4.24) already present
2018-05-11 04:04:45,252 [salt.state       ][INFO    ][5819] Completed state [dbs01] at time 04:04:45.252238 duration_in_ms=0.684
2018-05-11 04:04:45,252 [salt.state       ][INFO    ][5819] Running state [dbs01.mcp-pike-odl-ha.local] at time 04:04:45.252426
2018-05-11 04:04:45,252 [salt.state       ][INFO    ][5819] Executing state host.present for dbs01.mcp-pike-odl-ha.local
2018-05-11 04:04:45,252 [salt.state       ][INFO    ][5819] Host dbs01.mcp-pike-odl-ha.local (10.167.4.24) already present
2018-05-11 04:04:45,253 [salt.state       ][INFO    ][5819] Completed state [dbs01.mcp-pike-odl-ha.local] at time 04:04:45.253124 duration_in_ms=0.698
2018-05-11 04:04:45,253 [salt.state       ][INFO    ][5819] Running state [dbs02] at time 04:04:45.253318
2018-05-11 04:04:45,253 [salt.state       ][INFO    ][5819] Executing state host.present for dbs02
2018-05-11 04:04:45,253 [salt.state       ][INFO    ][5819] Host dbs02 (10.167.4.25) already present
2018-05-11 04:04:45,254 [salt.state       ][INFO    ][5819] Completed state [dbs02] at time 04:04:45.253975 duration_in_ms=0.656
2018-05-11 04:04:45,254 [salt.state       ][INFO    ][5819] Running state [dbs02.mcp-pike-odl-ha.local] at time 04:04:45.254162
2018-05-11 04:04:45,254 [salt.state       ][INFO    ][5819] Executing state host.present for dbs02.mcp-pike-odl-ha.local
2018-05-11 04:04:45,254 [salt.state       ][INFO    ][5819] Host dbs02.mcp-pike-odl-ha.local (10.167.4.25) already present
2018-05-11 04:04:45,254 [salt.state       ][INFO    ][5819] Completed state [dbs02.mcp-pike-odl-ha.local] at time 04:04:45.254822 duration_in_ms=0.659
2018-05-11 04:04:45,255 [salt.state       ][INFO    ][5819] Running state [dbs03] at time 04:04:45.255002
2018-05-11 04:04:45,255 [salt.state       ][INFO    ][5819] Executing state host.present for dbs03
2018-05-11 04:04:45,255 [salt.state       ][INFO    ][5819] Host dbs03 (10.167.4.26) already present
2018-05-11 04:04:45,255 [salt.state       ][INFO    ][5819] Completed state [dbs03] at time 04:04:45.255692 duration_in_ms=0.69
2018-05-11 04:04:45,255 [salt.state       ][INFO    ][5819] Running state [dbs03.mcp-pike-odl-ha.local] at time 04:04:45.255872
2018-05-11 04:04:45,256 [salt.state       ][INFO    ][5819] Executing state host.present for dbs03.mcp-pike-odl-ha.local
2018-05-11 04:04:45,256 [salt.state       ][INFO    ][5819] Host dbs03.mcp-pike-odl-ha.local (10.167.4.26) already present
2018-05-11 04:04:45,256 [salt.state       ][INFO    ][5819] Completed state [dbs03.mcp-pike-odl-ha.local] at time 04:04:45.256530 duration_in_ms=0.657
2018-05-11 04:04:45,256 [salt.state       ][INFO    ][5819] Running state [odl01] at time 04:04:45.256711
2018-05-11 04:04:45,256 [salt.state       ][INFO    ][5819] Executing state host.present for odl01
2018-05-11 04:04:45,257 [salt.state       ][INFO    ][5819] Host odl01 (10.167.4.39) already present
2018-05-11 04:04:45,257 [salt.state       ][INFO    ][5819] Completed state [odl01] at time 04:04:45.257378 duration_in_ms=0.666
2018-05-11 04:04:45,257 [salt.state       ][INFO    ][5819] Running state [odl01.mcp-pike-odl-ha.local] at time 04:04:45.257559
2018-05-11 04:04:45,257 [salt.state       ][INFO    ][5819] Executing state host.present for odl01.mcp-pike-odl-ha.local
2018-05-11 04:04:45,258 [salt.state       ][INFO    ][5819] Host odl01.mcp-pike-odl-ha.local (10.167.4.39) already present
2018-05-11 04:04:45,258 [salt.state       ][INFO    ][5819] Completed state [odl01.mcp-pike-odl-ha.local] at time 04:04:45.258221 duration_in_ms=0.661
2018-05-11 04:04:45,258 [salt.state       ][INFO    ][5819] Running state [file.replace] at time 04:04:45.258962
2018-05-11 04:04:45,259 [salt.state       ][INFO    ][5819] Executing state module.run for file.replace
2018-05-11 04:04:46,251 [salt.minion      ][INFO    ][2517] User sudo_ubuntu Executing command saltutil.find_job with jid 20180511040446230451
2018-05-11 04:04:46,297 [salt.minion      ][INFO    ][6152] Starting a new job with PID 6152
2018-05-11 04:04:46,540 [salt.minion      ][INFO    ][6152] Returning information for job: 20180511040446230451
2018-05-11 04:04:47,683 [salt.loaded.int.module.cmdmod][INFO    ][5819] Executing command ['git', '--version'] in directory '/root'
2018-05-11 04:04:47,818 [salt.loaded.int.module.cmdmod][INFO    ][5819] Executing command 'grep -q "odl01 odl01.mcp-pike-odl-ha.local" /etc/hosts' in directory '/root'
2018-05-11 04:04:47,851 [salt.state       ][INFO    ][5819] {'ret': '--- \n+++ \n@@ -27,7 +27,7 @@\n 10.167.4.24\t\tdbs01 dbs01.mcp-pike-odl-ha.local\n 10.167.4.25\t\tdbs02 dbs02.mcp-pike-odl-ha.local\n 10.167.4.26\t\tdbs03 dbs03.mcp-pike-odl-ha.local\n-10.167.4.39\t\todl01 odl01.mcp-pike-odl-ha.local\n+10.167.4.39\t\todl01.mcp-pike-odl-ha.local odl01\n 10.167.4.12\t\tmas01 mas01.mcp-pike-odl-ha.local\n 10.167.4.37\t\tctl02 ctl02.mcp-pike-odl-ha.local\n 10.167.4.38\t\tctl03 ctl03.mcp-pike-odl-ha.local\n'}
2018-05-11 04:04:47,852 [salt.state       ][INFO    ][5819] Completed state [file.replace] at time 04:04:47.852307 duration_in_ms=2593.343
2018-05-11 04:04:47,853 [salt.state       ][INFO    ][5819] Running state [mas01] at time 04:04:47.853009
2018-05-11 04:04:47,853 [salt.state       ][INFO    ][5819] Executing state host.present for mas01
2018-05-11 04:04:47,859 [salt.state       ][INFO    ][5819] Host mas01 (10.167.4.12) already present
2018-05-11 04:04:47,859 [salt.state       ][INFO    ][5819] Completed state [mas01] at time 04:04:47.859385 duration_in_ms=6.375
2018-05-11 04:04:47,859 [salt.state       ][INFO    ][5819] Running state [mas01.mcp-pike-odl-ha.local] at time 04:04:47.859774
2018-05-11 04:04:47,860 [salt.state       ][INFO    ][5819] Executing state host.present for mas01.mcp-pike-odl-ha.local
2018-05-11 04:04:47,860 [salt.state       ][INFO    ][5819] Host mas01.mcp-pike-odl-ha.local (10.167.4.12) already present
2018-05-11 04:04:47,861 [salt.state       ][INFO    ][5819] Completed state [mas01.mcp-pike-odl-ha.local] at time 04:04:47.861106 duration_in_ms=1.332
2018-05-11 04:04:47,861 [salt.state       ][INFO    ][5819] Running state [ctl02] at time 04:04:47.861452
2018-05-11 04:04:47,861 [salt.state       ][INFO    ][5819] Executing state host.present for ctl02
2018-05-11 04:04:47,862 [salt.state       ][INFO    ][5819] Host ctl02 (10.167.4.37) already present
2018-05-11 04:04:47,862 [salt.state       ][INFO    ][5819] Completed state [ctl02] at time 04:04:47.862717 duration_in_ms=1.265
2018-05-11 04:04:47,863 [salt.state       ][INFO    ][5819] Running state [ctl02.mcp-pike-odl-ha.local] at time 04:04:47.863048
2018-05-11 04:04:47,863 [salt.state       ][INFO    ][5819] Executing state host.present for ctl02.mcp-pike-odl-ha.local
2018-05-11 04:04:47,864 [salt.state       ][INFO    ][5819] Host ctl02.mcp-pike-odl-ha.local (10.167.4.37) already present
2018-05-11 04:04:47,864 [salt.state       ][INFO    ][5819] Completed state [ctl02.mcp-pike-odl-ha.local] at time 04:04:47.864328 duration_in_ms=1.28
2018-05-11 04:04:47,864 [salt.state       ][INFO    ][5819] Running state [ctl03] at time 04:04:47.864660
2018-05-11 04:04:47,865 [salt.state       ][INFO    ][5819] Executing state host.present for ctl03
2018-05-11 04:04:47,865 [salt.state       ][INFO    ][5819] Host ctl03 (10.167.4.38) already present
2018-05-11 04:04:47,865 [salt.state       ][INFO    ][5819] Completed state [ctl03] at time 04:04:47.865914 duration_in_ms=1.254
2018-05-11 04:04:47,866 [salt.state       ][INFO    ][5819] Running state [ctl03.mcp-pike-odl-ha.local] at time 04:04:47.866251
2018-05-11 04:04:47,866 [salt.state       ][INFO    ][5819] Executing state host.present for ctl03.mcp-pike-odl-ha.local
2018-05-11 04:04:47,867 [salt.state       ][INFO    ][5819] Host ctl03.mcp-pike-odl-ha.local (10.167.4.38) already present
2018-05-11 04:04:47,867 [salt.state       ][INFO    ][5819] Completed state [ctl03.mcp-pike-odl-ha.local] at time 04:04:47.867548 duration_in_ms=1.298
2018-05-11 04:04:47,867 [salt.state       ][INFO    ][5819] Running state [ctl01] at time 04:04:47.867880
2018-05-11 04:04:47,868 [salt.state       ][INFO    ][5819] Executing state host.present for ctl01
2018-05-11 04:04:47,868 [salt.state       ][INFO    ][5819] Host ctl01 (10.167.4.36) already present
2018-05-11 04:04:47,869 [salt.state       ][INFO    ][5819] Completed state [ctl01] at time 04:04:47.869293 duration_in_ms=1.412
2018-05-11 04:04:47,869 [salt.state       ][INFO    ][5819] Running state [ctl01.mcp-pike-odl-ha.local] at time 04:04:47.869692
2018-05-11 04:04:47,870 [salt.state       ][INFO    ][5819] Executing state host.present for ctl01.mcp-pike-odl-ha.local
2018-05-11 04:04:47,870 [salt.state       ][INFO    ][5819] Host ctl01.mcp-pike-odl-ha.local (10.167.4.36) already present
2018-05-11 04:04:47,871 [salt.state       ][INFO    ][5819] Completed state [ctl01.mcp-pike-odl-ha.local] at time 04:04:47.871213 duration_in_ms=1.521
2018-05-11 04:04:47,871 [salt.state       ][INFO    ][5819] Running state [ctl] at time 04:04:47.871651
2018-05-11 04:04:47,872 [salt.state       ][INFO    ][5819] Executing state host.present for ctl
2018-05-11 04:04:47,872 [salt.state       ][INFO    ][5819] Host ctl (10.167.4.35) already present
2018-05-11 04:04:47,873 [salt.state       ][INFO    ][5819] Completed state [ctl] at time 04:04:47.873083 duration_in_ms=1.432
2018-05-11 04:04:47,873 [salt.state       ][INFO    ][5819] Running state [ctl.mcp-pike-odl-ha.local] at time 04:04:47.873422
2018-05-11 04:04:47,873 [salt.state       ][INFO    ][5819] Executing state host.present for ctl.mcp-pike-odl-ha.local
2018-05-11 04:04:47,874 [salt.state       ][INFO    ][5819] Host ctl.mcp-pike-odl-ha.local (10.167.4.35) already present
2018-05-11 04:04:47,874 [salt.state       ][INFO    ][5819] Completed state [ctl.mcp-pike-odl-ha.local] at time 04:04:47.874629 duration_in_ms=1.208
2018-05-11 04:04:47,875 [salt.state       ][INFO    ][5819] Running state [/etc/network/interfaces.d/50-cloud-init.cfg] at time 04:04:47.874955
2018-05-11 04:04:47,875 [salt.state       ][INFO    ][5819] Executing state file.absent for /etc/network/interfaces.d/50-cloud-init.cfg
2018-05-11 04:04:47,875 [salt.state       ][INFO    ][5819] File /etc/network/interfaces.d/50-cloud-init.cfg is not present
2018-05-11 04:04:47,876 [salt.state       ][INFO    ][5819] Completed state [/etc/network/interfaces.d/50-cloud-init.cfg] at time 04:04:47.876001 duration_in_ms=1.046
2018-05-11 04:04:47,876 [salt.state       ][INFO    ][5819] Running state [ens2] at time 04:04:47.876314
2018-05-11 04:04:47,876 [salt.state       ][INFO    ][5819] Executing state network.managed for ens2
2018-05-11 04:04:48,544 [salt.state       ][INFO    ][5819] Interface ens2 is up to date.
2018-05-11 04:04:48,544 [salt.state       ][INFO    ][5819] Completed state [ens2] at time 04:04:48.544433 duration_in_ms=668.119
2018-05-11 04:04:48,544 [salt.state       ][INFO    ][5819] Running state [ens3] at time 04:04:48.544832
2018-05-11 04:04:48,545 [salt.state       ][INFO    ][5819] Executing state network.managed for ens3
2018-05-11 04:04:49,115 [salt.state       ][INFO    ][5819] Interface ens3 is up to date.
2018-05-11 04:04:49,115 [salt.state       ][INFO    ][5819] Completed state [ens3] at time 04:04:49.115946 duration_in_ms=571.117
2018-05-11 04:04:49,116 [salt.state       ][INFO    ][5819] Running state [/etc/profile.d/proxy.sh] at time 04:04:49.116183
2018-05-11 04:04:49,116 [salt.state       ][INFO    ][5819] Executing state file.absent for /etc/profile.d/proxy.sh
2018-05-11 04:04:49,116 [salt.state       ][INFO    ][5819] File /etc/profile.d/proxy.sh is not present
2018-05-11 04:04:49,116 [salt.state       ][INFO    ][5819] Completed state [/etc/profile.d/proxy.sh] at time 04:04:49.116903 duration_in_ms=0.719
2018-05-11 04:04:49,117 [salt.state       ][INFO    ][5819] Running state [/etc/apt/apt.conf.d/95proxies] at time 04:04:49.117071
2018-05-11 04:04:49,117 [salt.state       ][INFO    ][5819] Executing state file.absent for /etc/apt/apt.conf.d/95proxies
2018-05-11 04:04:49,117 [salt.state       ][INFO    ][5819] File /etc/apt/apt.conf.d/95proxies is not present
2018-05-11 04:04:49,117 [salt.state       ][INFO    ][5819] Completed state [/etc/apt/apt.conf.d/95proxies] at time 04:04:49.117569 duration_in_ms=0.498
2018-05-11 04:04:49,117 [salt.state       ][INFO    ][5819] Running state [ntp] at time 04:04:49.117729
2018-05-11 04:04:49,117 [salt.state       ][INFO    ][5819] Executing state pkg.installed for ntp
2018-05-11 04:04:49,122 [salt.state       ][INFO    ][5819] All specified packages are already installed
2018-05-11 04:04:49,122 [salt.state       ][INFO    ][5819] Completed state [ntp] at time 04:04:49.122583 duration_in_ms=4.854
2018-05-11 04:04:49,123 [salt.state       ][INFO    ][5819] Running state [/etc/ntp.conf] at time 04:04:49.123547
2018-05-11 04:04:49,123 [salt.state       ][INFO    ][5819] Executing state file.managed for /etc/ntp.conf
2018-05-11 04:04:49,180 [salt.state       ][INFO    ][5819] File /etc/ntp.conf is in the correct state
2018-05-11 04:04:49,180 [salt.state       ][INFO    ][5819] Completed state [/etc/ntp.conf] at time 04:04:49.180569 duration_in_ms=57.021
2018-05-11 04:04:49,181 [salt.state       ][INFO    ][5819] Running state [ntp] at time 04:04:49.181311
2018-05-11 04:04:49,181 [salt.state       ][INFO    ][5819] Executing state service.running for ntp
2018-05-11 04:04:49,182 [salt.loaded.int.module.cmdmod][INFO    ][5819] Executing command ['systemctl', 'status', 'ntp.service', '-n', '0'] in directory '/root'
2018-05-11 04:04:49,199 [salt.loaded.int.module.cmdmod][INFO    ][5819] Executing command ['systemctl', 'is-active', 'ntp.service'] in directory '/root'
2018-05-11 04:04:49,211 [salt.loaded.int.module.cmdmod][INFO    ][5819] Executing command ['systemctl', 'is-enabled', 'ntp.service'] in directory '/root'
2018-05-11 04:04:49,234 [salt.state       ][INFO    ][5819] The service ntp is already running
2018-05-11 04:04:49,235 [salt.state       ][INFO    ][5819] Completed state [ntp] at time 04:04:49.235291 duration_in_ms=53.979
2018-05-11 04:04:49,238 [salt.minion      ][INFO    ][5819] Returning information for job: 20180511040436129538
2018-05-11 04:05:16,210 [salt.minion      ][INFO    ][2517] User sudo_ubuntu Executing command ssh.set_auth_key with jid 20180511040516195165
2018-05-11 04:05:16,249 [salt.minion      ][INFO    ][6321] Starting a new job with PID 6321
2018-05-11 04:05:16,268 [salt.loader.192.168.11.2.int.module.ssh][WARNING ][6321] Public Key hashing currently defaults to "md5". This will change to "sha256" in the Nitrogen release.
2018-05-11 04:05:16,273 [salt.minion      ][INFO    ][6321] Returning information for job: 20180511040516195165
2018-05-11 04:05:42,850 [salt.minion      ][INFO    ][2517] User sudo_ubuntu Executing command pkg.upgrade with jid 20180511040542839254
2018-05-11 04:05:42,896 [salt.minion      ][INFO    ][6326] Starting a new job with PID 6326
2018-05-11 04:05:42,937 [salt.loader.192.168.11.2.int.module.cmdmod][INFO    ][6326] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2018-05-11 04:05:43,316 [salt.loader.192.168.11.2.int.module.cmdmod][INFO    ][6326] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'upgrade'] in directory '/root'
2018-05-11 04:05:52,960 [salt.minion      ][INFO    ][2517] User sudo_ubuntu Executing command saltutil.find_job with jid 20180511040552944380
2018-05-11 04:05:52,992 [salt.minion      ][INFO    ][6598] Starting a new job with PID 6598
2018-05-11 04:05:53,022 [salt.minion      ][INFO    ][6598] Returning information for job: 20180511040552944380
2018-05-11 04:06:03,031 [salt.minion      ][INFO    ][2517] User sudo_ubuntu Executing command saltutil.find_job with jid 20180511040603016018
2018-05-11 04:06:03,075 [salt.minion      ][INFO    ][6746] Starting a new job with PID 6746
2018-05-11 04:06:03,093 [salt.minion      ][INFO    ][6746] Returning information for job: 20180511040603016018
2018-05-11 04:06:13,123 [salt.minion      ][INFO    ][2517] User sudo_ubuntu Executing command saltutil.find_job with jid 20180511040613111968
2018-05-11 04:06:13,158 [salt.minion      ][INFO    ][7448] Starting a new job with PID 7448
2018-05-11 04:06:13,185 [salt.minion      ][INFO    ][7448] Returning information for job: 20180511040613111968
2018-05-11 04:06:14,386 [salt.loader.192.168.11.2.int.module.cmdmod][INFO    ][6326] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2018-05-11 04:06:14,436 [salt.minion      ][INFO    ][6326] Returning information for job: 20180511040542839254
2018-05-11 04:06:43,537 [salt.minion      ][INFO    ][2517] User sudo_ubuntu Executing command state.sls with jid 20180511040643531141
2018-05-11 04:06:43,558 [salt.minion      ][INFO    ][7485] Starting a new job with PID 7485
2018-05-11 04:06:45,235 [salt.state       ][INFO    ][7485] Loading fresh modules for state activity
2018-05-11 04:06:45,311 [salt.fileclient  ][INFO    ][7485] Fetching file from saltenv 'base', ** done ** 'opendaylight/init.sls'
2018-05-11 04:06:45,352 [salt.fileclient  ][INFO    ][7485] Fetching file from saltenv 'base', ** done ** 'opendaylight/server.sls'
2018-05-11 04:06:45,402 [salt.fileclient  ][INFO    ][7485] Fetching file from saltenv 'base', ** done ** 'opendaylight/map.jinja'
2018-05-11 04:06:45,513 [salt.state       ][INFO    ][7485] Running state [apt-key adv --keyserver keyserver.ubuntu.com --recv 44C05248] at time 04:06:45.513853
2018-05-11 04:06:45,514 [salt.state       ][INFO    ][7485] Executing state cmd.run for apt-key adv --keyserver keyserver.ubuntu.com --recv 44C05248
2018-05-11 04:06:45,515 [salt.loaded.int.module.cmdmod][INFO    ][7485] Executing command 'apt-key adv --keyserver keyserver.ubuntu.com --recv 44C05248' in directory '/root'
2018-05-11 04:06:46,100 [salt.state       ][INFO    ][7485] {'pid': 7492, '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.0KvpweV9TN/gpg.1.sh --keyserver\nkeyserver.ubuntu.com\n--recv\n44C05248'}
2018-05-11 04:06:46,101 [salt.state       ][INFO    ][7485] Completed state [apt-key adv --keyserver keyserver.ubuntu.com --recv 44C05248] at time 04:06:46.100900 duration_in_ms=587.046
2018-05-11 04:06:46,148 [salt.state       ][INFO    ][7485] Running state [deb http://ppa.launchpad.net/odl-team/oxygen/ubuntu xenial main] at time 04:06:46.148887
2018-05-11 04:06:46,149 [salt.state       ][INFO    ][7485] Executing state pkgrepo.managed for deb http://ppa.launchpad.net/odl-team/oxygen/ubuntu xenial main
2018-05-11 04:06:46,252 [salt.loaded.int.module.cmdmod][INFO    ][7485] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2018-05-11 04:06:51,150 [salt.state       ][INFO    ][7485] {'repo': 'deb http://ppa.launchpad.net/odl-team/oxygen/ubuntu xenial main'}
2018-05-11 04:06:51,151 [salt.state       ][INFO    ][7485] Completed state [deb http://ppa.launchpad.net/odl-team/oxygen/ubuntu xenial main] at time 04:06:51.151525 duration_in_ms=5002.639
2018-05-11 04:06:51,588 [salt.state       ][INFO    ][7485] Running state [service.mask] at time 04:06:51.588694
2018-05-11 04:06:51,589 [salt.state       ][INFO    ][7485] Executing state module.run for service.mask
2018-05-11 04:06:51,590 [salt.loaded.int.module.cmdmod][INFO    ][7485] Executing command ['systemctl', 'status', 'opendaylight.service', '-n', '0'] in directory '/root'
2018-05-11 04:06:51,640 [salt.loaded.int.module.cmdmod][INFO    ][7485] Executing command ['systemd-run', '--scope', 'systemctl', 'mask', 'opendaylight.service'] in directory '/root'
2018-05-11 04:06:51,851 [salt.state       ][INFO    ][7485] {'ret': True}
2018-05-11 04:06:51,852 [salt.state       ][INFO    ][7485] Completed state [service.mask] at time 04:06:51.852648 duration_in_ms=263.953
2018-05-11 04:06:51,854 [salt.state       ][INFO    ][7485] Running state [opendaylight] at time 04:06:51.853921
2018-05-11 04:06:51,854 [salt.state       ][INFO    ][7485] Executing state pkg.installed for opendaylight
2018-05-11 04:06:51,856 [salt.loaded.int.module.cmdmod][INFO    ][7485] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2018-05-11 04:06:52,308 [salt.loaded.int.module.cmdmod][INFO    ][7485] Executing command ['apt-cache', '-q', 'policy', 'opendaylight'] in directory '/root'
2018-05-11 04:06:52,407 [salt.loaded.int.module.cmdmod][INFO    ][7485] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2018-05-11 04:06:53,644 [salt.minion      ][INFO    ][2517] User sudo_ubuntu Executing command saltutil.find_job with jid 20180511040653631758
2018-05-11 04:06:53,666 [salt.minion      ][INFO    ][8430] Starting a new job with PID 8430
2018-05-11 04:06:53,694 [salt.minion      ][INFO    ][8430] Returning information for job: 20180511040653631758
2018-05-11 04:06:54,497 [salt.loaded.int.module.cmdmod][INFO    ][7485] Executing command ['dpkg', '--get-selections', '*'] in directory '/root'
2018-05-11 04:06:54,521 [salt.loaded.int.module.cmdmod][INFO    ][7485] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'opendaylight'] in directory '/root'
2018-05-11 04:07:03,874 [salt.minion      ][INFO    ][2517] User sudo_ubuntu Executing command saltutil.find_job with jid 20180511040703863041
2018-05-11 04:07:03,897 [salt.minion      ][INFO    ][8463] Starting a new job with PID 8463
2018-05-11 04:07:03,925 [salt.minion      ][INFO    ][8463] Returning information for job: 20180511040703863041
2018-05-11 04:07:14,103 [salt.minion      ][INFO    ][2517] User sudo_ubuntu Executing command saltutil.find_job with jid 20180511040714093333
2018-05-11 04:07:14,125 [salt.minion      ][INFO    ][8468] Starting a new job with PID 8468
2018-05-11 04:07:14,154 [salt.minion      ][INFO    ][8468] Returning information for job: 20180511040714093333
2018-05-11 04:07:24,337 [salt.minion      ][INFO    ][2517] User sudo_ubuntu Executing command saltutil.find_job with jid 20180511040724324871
2018-05-11 04:07:24,359 [salt.minion      ][INFO    ][8473] Starting a new job with PID 8473
2018-05-11 04:07:24,387 [salt.minion      ][INFO    ][8473] Returning information for job: 20180511040724324871
2018-05-11 04:07:34,570 [salt.minion      ][INFO    ][2517] User sudo_ubuntu Executing command saltutil.find_job with jid 20180511040734559510
2018-05-11 04:07:34,592 [salt.minion      ][INFO    ][8478] Starting a new job with PID 8478
2018-05-11 04:07:34,620 [salt.minion      ][INFO    ][8478] Returning information for job: 20180511040734559510
2018-05-11 04:07:44,797 [salt.minion      ][INFO    ][2517] User sudo_ubuntu Executing command saltutil.find_job with jid 20180511040744788300
2018-05-11 04:07:44,819 [salt.minion      ][INFO    ][8483] Starting a new job with PID 8483
2018-05-11 04:07:44,849 [salt.minion      ][INFO    ][8483] Returning information for job: 20180511040744788300
2018-05-11 04:07:55,030 [salt.minion      ][INFO    ][2517] User sudo_ubuntu Executing command saltutil.find_job with jid 20180511040755018266
2018-05-11 04:07:55,052 [salt.minion      ][INFO    ][8589] Starting a new job with PID 8589
2018-05-11 04:07:55,081 [salt.minion      ][INFO    ][8589] Returning information for job: 20180511040755018266
2018-05-11 04:08:05,085 [salt.minion      ][INFO    ][2517] User sudo_ubuntu Executing command saltutil.find_job with jid 20180511040805073018
2018-05-11 04:08:05,106 [salt.minion      ][INFO    ][8594] Starting a new job with PID 8594
2018-05-11 04:08:05,135 [salt.minion      ][INFO    ][8594] Returning information for job: 20180511040805073018
2018-05-11 04:08:15,110 [salt.minion      ][INFO    ][2517] User sudo_ubuntu Executing command saltutil.find_job with jid 20180511040815096790
2018-05-11 04:08:15,131 [salt.minion      ][INFO    ][8599] Starting a new job with PID 8599
2018-05-11 04:08:15,162 [salt.minion      ][INFO    ][8599] Returning information for job: 20180511040815096790
2018-05-11 04:08:25,137 [salt.minion      ][INFO    ][2517] User sudo_ubuntu Executing command saltutil.find_job with jid 20180511040825125050
2018-05-11 04:08:25,157 [salt.minion      ][INFO    ][8604] Starting a new job with PID 8604
2018-05-11 04:08:25,186 [salt.minion      ][INFO    ][8604] Returning information for job: 20180511040825125050
2018-05-11 04:08:35,166 [salt.minion      ][INFO    ][2517] User sudo_ubuntu Executing command saltutil.find_job with jid 20180511040835153949
2018-05-11 04:08:35,185 [salt.minion      ][INFO    ][8609] Starting a new job with PID 8609
2018-05-11 04:08:35,212 [salt.minion      ][INFO    ][8609] Returning information for job: 20180511040835153949
2018-05-11 04:08:45,193 [salt.minion      ][INFO    ][2517] User sudo_ubuntu Executing command saltutil.find_job with jid 20180511040845180265
2018-05-11 04:08:45,214 [salt.minion      ][INFO    ][8614] Starting a new job with PID 8614
2018-05-11 04:08:45,242 [salt.minion      ][INFO    ][8614] Returning information for job: 20180511040845180265
2018-05-11 04:08:55,224 [salt.minion      ][INFO    ][2517] User sudo_ubuntu Executing command saltutil.find_job with jid 20180511040855211209
2018-05-11 04:08:55,246 [salt.minion      ][INFO    ][8619] Starting a new job with PID 8619
2018-05-11 04:08:55,276 [salt.minion      ][INFO    ][8619] Returning information for job: 20180511040855211209
2018-05-11 04:09:05,260 [salt.minion      ][INFO    ][2517] User sudo_ubuntu Executing command saltutil.find_job with jid 20180511040905249717
2018-05-11 04:09:05,282 [salt.minion      ][INFO    ][8624] Starting a new job with PID 8624
2018-05-11 04:09:05,312 [salt.minion      ][INFO    ][8624] Returning information for job: 20180511040905249717
2018-05-11 04:09:15,298 [salt.minion      ][INFO    ][2517] User sudo_ubuntu Executing command saltutil.find_job with jid 20180511040915287390
2018-05-11 04:09:15,321 [salt.minion      ][INFO    ][8629] Starting a new job with PID 8629
2018-05-11 04:09:15,352 [salt.minion      ][INFO    ][8629] Returning information for job: 20180511040915287390
2018-05-11 04:09:25,334 [salt.minion      ][INFO    ][2517] User sudo_ubuntu Executing command saltutil.find_job with jid 20180511040925326973
2018-05-11 04:09:25,356 [salt.minion      ][INFO    ][8634] Starting a new job with PID 8634
2018-05-11 04:09:25,386 [salt.minion      ][INFO    ][8634] Returning information for job: 20180511040925326973
2018-05-11 04:09:35,378 [salt.minion      ][INFO    ][2517] User sudo_ubuntu Executing command saltutil.find_job with jid 20180511040935368590
2018-05-11 04:09:35,398 [salt.minion      ][INFO    ][8639] Starting a new job with PID 8639
2018-05-11 04:09:35,425 [salt.minion      ][INFO    ][8639] Returning information for job: 20180511040935368590
2018-05-11 04:09:45,424 [salt.minion      ][INFO    ][2517] User sudo_ubuntu Executing command saltutil.find_job with jid 20180511040945409758
2018-05-11 04:09:45,446 [salt.minion      ][INFO    ][8644] Starting a new job with PID 8644
2018-05-11 04:09:45,475 [salt.minion      ][INFO    ][8644] Returning information for job: 20180511040945409758
2018-05-11 04:09:55,480 [salt.minion      ][INFO    ][2517] User sudo_ubuntu Executing command saltutil.find_job with jid 20180511040955468130
2018-05-11 04:09:55,502 [salt.minion      ][INFO    ][8649] Starting a new job with PID 8649
2018-05-11 04:09:55,530 [salt.minion      ][INFO    ][8649] Returning information for job: 20180511040955468130
2018-05-11 04:10:05,534 [salt.minion      ][INFO    ][2517] User sudo_ubuntu Executing command saltutil.find_job with jid 20180511041005522750
2018-05-11 04:10:05,557 [salt.minion      ][INFO    ][8654] Starting a new job with PID 8654
2018-05-11 04:10:05,587 [salt.minion      ][INFO    ][8654] Returning information for job: 20180511041005522750
2018-05-11 04:10:15,600 [salt.minion      ][INFO    ][2517] User sudo_ubuntu Executing command saltutil.find_job with jid 20180511041015587173
2018-05-11 04:10:15,622 [salt.minion      ][INFO    ][8659] Starting a new job with PID 8659
2018-05-11 04:10:15,650 [salt.minion      ][INFO    ][8659] Returning information for job: 20180511041015587173
2018-05-11 04:10:25,657 [salt.minion      ][INFO    ][2517] User sudo_ubuntu Executing command saltutil.find_job with jid 20180511041025649096
2018-05-11 04:10:25,679 [salt.minion      ][INFO    ][8664] Starting a new job with PID 8664
2018-05-11 04:10:25,708 [salt.minion      ][INFO    ][8664] Returning information for job: 20180511041025649096
2018-05-11 04:10:35,721 [salt.minion      ][INFO    ][2517] User sudo_ubuntu Executing command saltutil.find_job with jid 20180511041035712732
2018-05-11 04:10:35,745 [salt.minion      ][INFO    ][8669] Starting a new job with PID 8669
2018-05-11 04:10:35,773 [salt.minion      ][INFO    ][8669] Returning information for job: 20180511041035712732
2018-05-11 04:10:45,791 [salt.minion      ][INFO    ][2517] User sudo_ubuntu Executing command saltutil.find_job with jid 20180511041045781434
2018-05-11 04:10:45,812 [salt.minion      ][INFO    ][8674] Starting a new job with PID 8674
2018-05-11 04:10:45,839 [salt.minion      ][INFO    ][8674] Returning information for job: 20180511041045781434
2018-05-11 04:10:55,859 [salt.minion      ][INFO    ][2517] User sudo_ubuntu Executing command saltutil.find_job with jid 20180511041055853451
2018-05-11 04:10:55,881 [salt.minion      ][INFO    ][8679] Starting a new job with PID 8679
2018-05-11 04:10:55,909 [salt.minion      ][INFO    ][8679] Returning information for job: 20180511041055853451
2018-05-11 04:11:05,918 [salt.minion      ][INFO    ][2517] User sudo_ubuntu Executing command saltutil.find_job with jid 20180511041105914335
2018-05-11 04:11:05,940 [salt.minion      ][INFO    ][8684] Starting a new job with PID 8684
2018-05-11 04:11:05,969 [salt.minion      ][INFO    ][8684] Returning information for job: 20180511041105914335
2018-05-11 04:11:15,983 [salt.minion      ][INFO    ][2517] User sudo_ubuntu Executing command saltutil.find_job with jid 20180511041115974478
2018-05-11 04:11:16,005 [salt.minion      ][INFO    ][8689] Starting a new job with PID 8689
2018-05-11 04:11:16,033 [salt.minion      ][INFO    ][8689] Returning information for job: 20180511041115974478
2018-05-11 04:11:26,077 [salt.minion      ][INFO    ][2517] User sudo_ubuntu Executing command saltutil.find_job with jid 20180511041126068840
2018-05-11 04:11:26,099 [salt.minion      ][INFO    ][8694] Starting a new job with PID 8694
2018-05-11 04:11:26,128 [salt.minion      ][INFO    ][8694] Returning information for job: 20180511041126068840
2018-05-11 04:11:36,187 [salt.minion      ][INFO    ][2517] User sudo_ubuntu Executing command saltutil.find_job with jid 20180511041136177144
2018-05-11 04:11:36,210 [salt.minion      ][INFO    ][8699] Starting a new job with PID 8699
2018-05-11 04:11:36,239 [salt.minion      ][INFO    ][8699] Returning information for job: 20180511041136177144
2018-05-11 04:11:46,287 [salt.minion      ][INFO    ][2517] User sudo_ubuntu Executing command saltutil.find_job with jid 20180511041146278040
2018-05-11 04:11:46,308 [salt.minion      ][INFO    ][8704] Starting a new job with PID 8704
2018-05-11 04:11:46,335 [salt.minion      ][INFO    ][8704] Returning information for job: 20180511041146278040
2018-05-11 04:11:56,400 [salt.minion      ][INFO    ][2517] User sudo_ubuntu Executing command saltutil.find_job with jid 20180511041156385585
2018-05-11 04:11:56,422 [salt.minion      ][INFO    ][8709] Starting a new job with PID 8709
2018-05-11 04:11:56,454 [salt.minion      ][INFO    ][8709] Returning information for job: 20180511041156385585
2018-05-11 04:12:06,501 [salt.minion      ][INFO    ][2517] User sudo_ubuntu Executing command saltutil.find_job with jid 20180511041206493648
2018-05-11 04:12:06,523 [salt.minion      ][INFO    ][8714] Starting a new job with PID 8714
2018-05-11 04:12:06,552 [salt.minion      ][INFO    ][8714] Returning information for job: 20180511041206493648
2018-05-11 04:12:16,618 [salt.minion      ][INFO    ][2517] User sudo_ubuntu Executing command saltutil.find_job with jid 20180511041216607105
2018-05-11 04:12:16,640 [salt.minion      ][INFO    ][8719] Starting a new job with PID 8719
2018-05-11 04:12:16,669 [salt.minion      ][INFO    ][8719] Returning information for job: 20180511041216607105
2018-05-11 04:12:26,736 [salt.minion      ][INFO    ][2517] User sudo_ubuntu Executing command saltutil.find_job with jid 20180511041226726598
2018-05-11 04:12:26,758 [salt.minion      ][INFO    ][8734] Starting a new job with PID 8734
2018-05-11 04:12:26,786 [salt.minion      ][INFO    ][8734] Returning information for job: 20180511041226726598
2018-05-11 04:12:36,846 [salt.minion      ][INFO    ][2517] User sudo_ubuntu Executing command saltutil.find_job with jid 20180511041236836071
2018-05-11 04:12:36,867 [salt.minion      ][INFO    ][8739] Starting a new job with PID 8739
2018-05-11 04:12:36,897 [salt.minion      ][INFO    ][8739] Returning information for job: 20180511041236836071
2018-05-11 04:12:46,957 [salt.minion      ][INFO    ][2517] User sudo_ubuntu Executing command saltutil.find_job with jid 20180511041246948449
2018-05-11 04:12:46,980 [salt.minion      ][INFO    ][8744] Starting a new job with PID 8744
2018-05-11 04:12:47,008 [salt.minion      ][INFO    ][8744] Returning information for job: 20180511041246948449
2018-05-11 04:12:57,079 [salt.minion      ][INFO    ][2517] User sudo_ubuntu Executing command saltutil.find_job with jid 20180511041257069367
2018-05-11 04:12:57,100 [salt.minion      ][INFO    ][8749] Starting a new job with PID 8749
2018-05-11 04:12:57,131 [salt.minion      ][INFO    ][8749] Returning information for job: 20180511041257069367
2018-05-11 04:13:07,204 [salt.minion      ][INFO    ][2517] User sudo_ubuntu Executing command saltutil.find_job with jid 20180511041307194902
2018-05-11 04:13:07,225 [salt.minion      ][INFO    ][8755] Starting a new job with PID 8755
2018-05-11 04:13:07,253 [salt.minion      ][INFO    ][8755] Returning information for job: 20180511041307194902
2018-05-11 04:13:17,327 [salt.minion      ][INFO    ][2517] User sudo_ubuntu Executing command saltutil.find_job with jid 20180511041317319027
2018-05-11 04:13:17,349 [salt.minion      ][INFO    ][8760] Starting a new job with PID 8760
2018-05-11 04:13:17,379 [salt.minion      ][INFO    ][8760] Returning information for job: 20180511041317319027
2018-05-11 04:13:27,460 [salt.minion      ][INFO    ][2517] User sudo_ubuntu Executing command saltutil.find_job with jid 20180511041327452123
2018-05-11 04:13:27,483 [salt.minion      ][INFO    ][8765] Starting a new job with PID 8765
2018-05-11 04:13:27,511 [salt.minion      ][INFO    ][8765] Returning information for job: 20180511041327452123
2018-05-11 04:13:37,605 [salt.minion      ][INFO    ][2517] User sudo_ubuntu Executing command saltutil.find_job with jid 20180511041337593408
2018-05-11 04:13:37,628 [salt.minion      ][INFO    ][8770] Starting a new job with PID 8770
2018-05-11 04:13:37,658 [salt.minion      ][INFO    ][8770] Returning information for job: 20180511041337593408
2018-05-11 04:13:47,762 [salt.minion      ][INFO    ][2517] User sudo_ubuntu Executing command saltutil.find_job with jid 20180511041347748993
2018-05-11 04:13:47,786 [salt.minion      ][INFO    ][8775] Starting a new job with PID 8775
2018-05-11 04:13:47,814 [salt.minion      ][INFO    ][8775] Returning information for job: 20180511041347748993
2018-05-11 04:13:57,914 [salt.minion      ][INFO    ][2517] User sudo_ubuntu Executing command saltutil.find_job with jid 20180511041357900780
2018-05-11 04:13:57,938 [salt.minion      ][INFO    ][8796] Starting a new job with PID 8796
2018-05-11 04:13:57,971 [salt.minion      ][INFO    ][8796] Returning information for job: 20180511041357900780
2018-05-11 04:14:08,077 [salt.minion      ][INFO    ][2517] User sudo_ubuntu Executing command saltutil.find_job with jid 20180511041408063360
2018-05-11 04:14:08,098 [salt.minion      ][INFO    ][8801] Starting a new job with PID 8801
2018-05-11 04:14:08,128 [salt.minion      ][INFO    ][8801] Returning information for job: 20180511041408063360
2018-05-11 04:14:18,232 [salt.minion      ][INFO    ][2517] User sudo_ubuntu Executing command saltutil.find_job with jid 20180511041418216278
2018-05-11 04:14:18,252 [salt.minion      ][INFO    ][8806] Starting a new job with PID 8806
2018-05-11 04:14:18,280 [salt.minion      ][INFO    ][8806] Returning information for job: 20180511041418216278
2018-05-11 04:14:28,397 [salt.minion      ][INFO    ][2517] User sudo_ubuntu Executing command saltutil.find_job with jid 20180511041428378456
2018-05-11 04:14:28,418 [salt.minion      ][INFO    ][8811] Starting a new job with PID 8811
2018-05-11 04:14:28,448 [salt.minion      ][INFO    ][8811] Returning information for job: 20180511041428378456
2018-05-11 04:14:38,573 [salt.minion      ][INFO    ][2517] User sudo_ubuntu Executing command saltutil.find_job with jid 20180511041438556036
2018-05-11 04:14:38,595 [salt.minion      ][INFO    ][8816] Starting a new job with PID 8816
2018-05-11 04:14:38,625 [salt.minion      ][INFO    ][8816] Returning information for job: 20180511041438556036
2018-05-11 04:14:48,757 [salt.minion      ][INFO    ][2517] User sudo_ubuntu Executing command saltutil.find_job with jid 20180511041448735982
2018-05-11 04:14:48,779 [salt.minion      ][INFO    ][8821] Starting a new job with PID 8821
2018-05-11 04:14:48,808 [salt.minion      ][INFO    ][8821] Returning information for job: 20180511041448735982
2018-05-11 04:14:58,943 [salt.minion      ][INFO    ][2517] User sudo_ubuntu Executing command saltutil.find_job with jid 20180511041458922417
2018-05-11 04:14:58,966 [salt.minion      ][INFO    ][8826] Starting a new job with PID 8826
2018-05-11 04:14:58,994 [salt.minion      ][INFO    ][8826] Returning information for job: 20180511041458922417
2018-05-11 04:15:09,127 [salt.minion      ][INFO    ][2517] User sudo_ubuntu Executing command saltutil.find_job with jid 20180511041509111542
2018-05-11 04:15:09,149 [salt.minion      ][INFO    ][8831] Starting a new job with PID 8831
2018-05-11 04:15:09,179 [salt.minion      ][INFO    ][8831] Returning information for job: 20180511041509111542
2018-05-11 04:15:19,322 [salt.minion      ][INFO    ][2517] User sudo_ubuntu Executing command saltutil.find_job with jid 20180511041519303366
2018-05-11 04:15:19,344 [salt.minion      ][INFO    ][8836] Starting a new job with PID 8836
2018-05-11 04:15:19,374 [salt.minion      ][INFO    ][8836] Returning information for job: 20180511041519303366
2018-05-11 04:15:29,537 [salt.minion      ][INFO    ][2517] User sudo_ubuntu Executing command saltutil.find_job with jid 20180511041529514004
2018-05-11 04:15:29,558 [salt.minion      ][INFO    ][8841] Starting a new job with PID 8841
2018-05-11 04:15:29,589 [salt.minion      ][INFO    ][8841] Returning information for job: 20180511041529514004
2018-05-11 04:15:39,762 [salt.minion      ][INFO    ][2517] User sudo_ubuntu Executing command saltutil.find_job with jid 20180511041539734112
2018-05-11 04:15:39,785 [salt.minion      ][INFO    ][8846] Starting a new job with PID 8846
2018-05-11 04:15:39,814 [salt.minion      ][INFO    ][8846] Returning information for job: 20180511041539734112
2018-05-11 04:15:49,962 [salt.minion      ][INFO    ][2517] User sudo_ubuntu Executing command saltutil.find_job with jid 20180511041549940216
2018-05-11 04:15:49,983 [salt.minion      ][INFO    ][8851] Starting a new job with PID 8851
2018-05-11 04:15:50,012 [salt.minion      ][INFO    ][8851] Returning information for job: 20180511041549940216
2018-05-11 04:16:00,193 [salt.minion      ][INFO    ][2517] User sudo_ubuntu Executing command saltutil.find_job with jid 20180511041600169349
2018-05-11 04:16:00,214 [salt.minion      ][INFO    ][8856] Starting a new job with PID 8856
2018-05-11 04:16:00,244 [salt.minion      ][INFO    ][8856] Returning information for job: 20180511041600169349
2018-05-11 04:16:10,423 [salt.minion      ][INFO    ][2517] User sudo_ubuntu Executing command saltutil.find_job with jid 20180511041610400276
2018-05-11 04:16:10,446 [salt.minion      ][INFO    ][8861] Starting a new job with PID 8861
2018-05-11 04:16:10,477 [salt.minion      ][INFO    ][8861] Returning information for job: 20180511041610400276
2018-05-11 04:16:20,665 [salt.minion      ][INFO    ][2517] User sudo_ubuntu Executing command saltutil.find_job with jid 20180511041620642559
2018-05-11 04:16:20,686 [salt.minion      ][INFO    ][8866] Starting a new job with PID 8866
2018-05-11 04:16:20,714 [salt.minion      ][INFO    ][8866] Returning information for job: 20180511041620642559
2018-05-11 04:16:30,910 [salt.minion      ][INFO    ][2517] User sudo_ubuntu Executing command saltutil.find_job with jid 20180511041630887248
2018-05-11 04:16:30,931 [salt.minion      ][INFO    ][8871] Starting a new job with PID 8871
2018-05-11 04:16:30,956 [salt.minion      ][INFO    ][8871] Returning information for job: 20180511041630887248
2018-05-11 04:16:40,947 [salt.minion      ][INFO    ][2517] User sudo_ubuntu Executing command saltutil.find_job with jid 20180511041640927392
2018-05-11 04:16:40,970 [salt.minion      ][INFO    ][8876] Starting a new job with PID 8876
2018-05-11 04:16:41,000 [salt.minion      ][INFO    ][8876] Returning information for job: 20180511041640927392
2018-05-11 04:16:50,991 [salt.minion      ][INFO    ][2517] User sudo_ubuntu Executing command saltutil.find_job with jid 20180511041650969359
2018-05-11 04:16:51,013 [salt.minion      ][INFO    ][8881] Starting a new job with PID 8881
2018-05-11 04:16:51,043 [salt.minion      ][INFO    ][8881] Returning information for job: 20180511041650969359
2018-05-11 04:17:01,049 [salt.minion      ][INFO    ][2517] User sudo_ubuntu Executing command saltutil.find_job with jid 20180511041701029135
2018-05-11 04:17:01,072 [salt.minion      ][INFO    ][8892] Starting a new job with PID 8892
2018-05-11 04:17:01,100 [salt.minion      ][INFO    ][8892] Returning information for job: 20180511041701029135
2018-05-11 04:17:11,110 [salt.minion      ][INFO    ][2517] User sudo_ubuntu Executing command saltutil.find_job with jid 20180511041711091306
2018-05-11 04:17:11,132 [salt.minion      ][INFO    ][8910] Starting a new job with PID 8910
2018-05-11 04:17:11,162 [salt.minion      ][INFO    ][8910] Returning information for job: 20180511041711091306
2018-05-11 04:17:21,332 [salt.minion      ][INFO    ][2517] User sudo_ubuntu Executing command saltutil.find_job with jid 20180511041721312462
2018-05-11 04:17:21,353 [salt.minion      ][INFO    ][8915] Starting a new job with PID 8915
2018-05-11 04:17:21,382 [salt.minion      ][INFO    ][8915] Returning information for job: 20180511041721312462
2018-05-11 04:17:31,396 [salt.minion      ][INFO    ][2517] User sudo_ubuntu Executing command saltutil.find_job with jid 20180511041731374376
2018-05-11 04:17:31,418 [salt.minion      ][INFO    ][8920] Starting a new job with PID 8920
2018-05-11 04:17:31,448 [salt.minion      ][INFO    ][8920] Returning information for job: 20180511041731374376
2018-05-11 04:17:41,481 [salt.minion      ][INFO    ][2517] User sudo_ubuntu Executing command saltutil.find_job with jid 20180511041741463877
2018-05-11 04:17:41,502 [salt.minion      ][INFO    ][8925] Starting a new job with PID 8925
2018-05-11 04:17:41,529 [salt.minion      ][INFO    ][8925] Returning information for job: 20180511041741463877
2018-05-11 04:17:51,565 [salt.minion      ][INFO    ][2517] User sudo_ubuntu Executing command saltutil.find_job with jid 20180511041751548349
2018-05-11 04:17:51,587 [salt.minion      ][INFO    ][8930] Starting a new job with PID 8930
2018-05-11 04:17:51,616 [salt.minion      ][INFO    ][8930] Returning information for job: 20180511041751548349
2018-05-11 04:18:01,657 [salt.minion      ][INFO    ][2517] User sudo_ubuntu Executing command saltutil.find_job with jid 20180511041801638504
2018-05-11 04:18:01,681 [salt.minion      ][INFO    ][8935] Starting a new job with PID 8935
2018-05-11 04:18:01,712 [salt.minion      ][INFO    ][8935] Returning information for job: 20180511041801638504
2018-05-11 04:18:11,769 [salt.minion      ][INFO    ][2517] User sudo_ubuntu Executing command saltutil.find_job with jid 20180511041811748779
2018-05-11 04:18:11,792 [salt.minion      ][INFO    ][8940] Starting a new job with PID 8940
2018-05-11 04:18:11,823 [salt.minion      ][INFO    ][8940] Returning information for job: 20180511041811748779
2018-05-11 04:18:21,874 [salt.minion      ][INFO    ][2517] User sudo_ubuntu Executing command saltutil.find_job with jid 20180511041821856641
2018-05-11 04:18:21,897 [salt.minion      ][INFO    ][8945] Starting a new job with PID 8945
2018-05-11 04:18:21,925 [salt.minion      ][INFO    ][8945] Returning information for job: 20180511041821856641
2018-05-11 04:18:31,986 [salt.minion      ][INFO    ][2517] User sudo_ubuntu Executing command saltutil.find_job with jid 20180511041831968864
2018-05-11 04:18:32,009 [salt.minion      ][INFO    ][8950] Starting a new job with PID 8950
2018-05-11 04:18:32,038 [salt.minion      ][INFO    ][8950] Returning information for job: 20180511041831968864
2018-05-11 04:18:42,113 [salt.minion      ][INFO    ][2517] User sudo_ubuntu Executing command saltutil.find_job with jid 20180511041842090197
2018-05-11 04:18:42,135 [salt.minion      ][INFO    ][8955] Starting a new job with PID 8955
2018-05-11 04:18:42,166 [salt.minion      ][INFO    ][8955] Returning information for job: 20180511041842090197
2018-05-11 04:18:52,240 [salt.minion      ][INFO    ][2517] User sudo_ubuntu Executing command saltutil.find_job with jid 20180511041852224714
2018-05-11 04:18:52,263 [salt.minion      ][INFO    ][8960] Starting a new job with PID 8960
2018-05-11 04:18:52,294 [salt.minion      ][INFO    ][8960] Returning information for job: 20180511041852224714
2018-05-11 04:19:02,350 [salt.minion      ][INFO    ][2517] User sudo_ubuntu Executing command saltutil.find_job with jid 20180511041902331246
2018-05-11 04:19:02,372 [salt.minion      ][INFO    ][8965] Starting a new job with PID 8965
2018-05-11 04:19:02,403 [salt.minion      ][INFO    ][8965] Returning information for job: 20180511041902331246
2018-05-11 04:19:12,502 [salt.minion      ][INFO    ][2517] User sudo_ubuntu Executing command saltutil.find_job with jid 20180511041912482644
2018-05-11 04:19:12,524 [salt.minion      ][INFO    ][8971] Starting a new job with PID 8971
2018-05-11 04:19:12,555 [salt.minion      ][INFO    ][8971] Returning information for job: 20180511041912482644
2018-05-11 04:19:22,658 [salt.minion      ][INFO    ][2517] User sudo_ubuntu Executing command saltutil.find_job with jid 20180511041922643167
2018-05-11 04:19:22,682 [salt.minion      ][INFO    ][8976] Starting a new job with PID 8976
2018-05-11 04:19:22,714 [salt.minion      ][INFO    ][8976] Returning information for job: 20180511041922643167
2018-05-11 04:19:32,827 [salt.minion      ][INFO    ][2517] User sudo_ubuntu Executing command saltutil.find_job with jid 20180511041932808804
2018-05-11 04:19:32,850 [salt.minion      ][INFO    ][8981] Starting a new job with PID 8981
2018-05-11 04:19:32,881 [salt.minion      ][INFO    ][8981] Returning information for job: 20180511041932808804
2018-05-11 04:19:43,010 [salt.minion      ][INFO    ][2517] User sudo_ubuntu Executing command saltutil.find_job with jid 20180511041942990666
2018-05-11 04:19:43,032 [salt.minion      ][INFO    ][8986] Starting a new job with PID 8986
2018-05-11 04:19:43,067 [salt.minion      ][INFO    ][8986] Returning information for job: 20180511041942990666
2018-05-11 04:19:53,202 [salt.minion      ][INFO    ][2517] User sudo_ubuntu Executing command saltutil.find_job with jid 20180511041953184716
2018-05-11 04:19:53,226 [salt.minion      ][INFO    ][8991] Starting a new job with PID 8991
2018-05-11 04:19:53,255 [salt.minion      ][INFO    ][8991] Returning information for job: 20180511041953184716
2018-05-11 04:20:03,404 [salt.minion      ][INFO    ][2517] User sudo_ubuntu Executing command saltutil.find_job with jid 20180511042003385710
2018-05-11 04:20:03,428 [salt.minion      ][INFO    ][8996] Starting a new job with PID 8996
2018-05-11 04:20:03,457 [salt.minion      ][INFO    ][8996] Returning information for job: 20180511042003385710
2018-05-11 04:20:13,623 [salt.minion      ][INFO    ][2517] User sudo_ubuntu Executing command saltutil.find_job with jid 20180511042013602858
2018-05-11 04:20:13,644 [salt.minion      ][INFO    ][9001] Starting a new job with PID 9001
2018-05-11 04:20:13,672 [salt.minion      ][INFO    ][9001] Returning information for job: 20180511042013602858
2018-05-11 04:20:23,853 [salt.minion      ][INFO    ][2517] User sudo_ubuntu Executing command saltutil.find_job with jid 20180511042023826915
2018-05-11 04:20:23,876 [salt.minion      ][INFO    ][9166] Starting a new job with PID 9166
2018-05-11 04:20:23,906 [salt.minion      ][INFO    ][9166] Returning information for job: 20180511042023826915
2018-05-11 04:20:34,086 [salt.minion      ][INFO    ][2517] User sudo_ubuntu Executing command saltutil.find_job with jid 20180511042034067942
2018-05-11 04:20:34,102 [salt.minion      ][INFO    ][9226] Starting a new job with PID 9226
2018-05-11 04:20:34,115 [salt.minion      ][INFO    ][9226] Returning information for job: 20180511042034067942
2018-05-11 04:20:44,304 [salt.minion      ][INFO    ][2517] User sudo_ubuntu Executing command saltutil.find_job with jid 20180511042044282186
2018-05-11 04:20:44,331 [salt.minion      ][INFO    ][9231] Starting a new job with PID 9231
2018-05-11 04:20:44,358 [salt.minion      ][INFO    ][9231] Returning information for job: 20180511042044282186
2018-05-11 04:20:54,349 [salt.minion      ][INFO    ][2517] User sudo_ubuntu Executing command saltutil.find_job with jid 20180511042054330207
2018-05-11 04:20:54,370 [salt.minion      ][INFO    ][9841] Starting a new job with PID 9841
2018-05-11 04:20:54,397 [salt.minion      ][INFO    ][9841] Returning information for job: 20180511042054330207
2018-05-11 04:21:04,604 [salt.minion      ][INFO    ][2517] User sudo_ubuntu Executing command saltutil.find_job with jid 20180511042104584075
2018-05-11 04:21:04,623 [salt.minion      ][INFO    ][11121] Starting a new job with PID 11121
2018-05-11 04:21:04,641 [salt.minion      ][INFO    ][11121] Returning information for job: 20180511042104584075
2018-05-11 04:21:08,868 [salt.loaded.int.module.cmdmod][INFO    ][7485] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2018-05-11 04:21:08,937 [salt.state       ][INFO    ][7485] Made the following changes:
'java-common' changed from 'absent' to '0.56ubuntu2'
'libxtst6' changed from 'absent' to '2:1.2.2-1'
'liblcms2-2' changed from 'absent' to '2.6-3ubuntu2'
'openjdk-8-jre-headless' changed from 'absent' to '8u171-b11-0ubuntu0.16.04.1'
'libxrender1' changed from 'absent' to '1:0.9.9-0ubuntu1'
'libavahi-common3' changed from 'absent' to '0.6.32~rc+dfsg-1ubuntu2.2'
'libnspr4' changed from 'absent' to '2:4.13.1-0ubuntu0.16.04.1'
'libfontconfig' changed from 'absent' to '1'
'fonts-dejavu-core' changed from 'absent' to '2.35-1'
'libnss3-nssdb' changed from 'absent' to '2:3.28.4-0ubuntu0.16.04.3'
'java8-runtime-headless' changed from 'absent' to '1'
'libcups2' changed from 'absent' to '2.1.3-4ubuntu0.4'
'libjpeg-turbo8' changed from 'absent' to '1.4.2-0ubuntu3'
'libavahi-client3' changed from 'absent' to '0.6.32~rc+dfsg-1ubuntu2.2'
'libnss3' changed from 'absent' to '2:3.28.4-0ubuntu0.16.04.3'
'libpcsclite1' changed from 'absent' to '1.8.14-1ubuntu1.16.04.1'
'java7-runtime-headless' changed from 'absent' to '1'
'ca-certificates-java' changed from 'absent' to '20160321ubuntu1'
'java2-runtime-headless' changed from 'absent' to '1'
'fontconfig-config' changed from 'absent' to '2.11.94-0ubuntu1.1'
'libavahi-common-data' changed from 'absent' to '0.6.32~rc+dfsg-1ubuntu2.2'
'libxi6' changed from 'absent' to '2:1.7.6-1'
'java5-runtime-headless' changed from 'absent' to '1'
'java6-runtime-headless' changed from 'absent' to '1'
'x11-common' changed from 'absent' to '1:7.7+13ubuntu3'
'libjpeg8' changed from 'absent' to '8c-2ubuntu8'
'opendaylight' changed from 'absent' to '8.0.0-1ppa1'
'libfontconfig1' changed from 'absent' to '2.11.94-0ubuntu1.1'

2018-05-11 04:21:08,974 [salt.state       ][INFO    ][7485] Loading fresh modules for state activity
2018-05-11 04:21:09,013 [salt.state       ][INFO    ][7485] Completed state [opendaylight] at time 04:21:09.013680 duration_in_ms=857159.757
2018-05-11 04:21:09,382 [salt.state       ][INFO    ][7485] Running state [/opt/opendaylight/etc/jetty.xml] at time 04:21:09.382030
2018-05-11 04:21:09,382 [salt.state       ][INFO    ][7485] Executing state file.managed for /opt/opendaylight/etc/jetty.xml
2018-05-11 04:21:09,447 [salt.fileclient  ][INFO    ][7485] Fetching file from saltenv 'base', ** done ** 'opendaylight/files/jetty.xml'
2018-05-11 04:21:09,510 [salt.state       ][INFO    ][7485] File changed:
--- 
+++ 
@@ -79,11 +79,11 @@
                         </Item>
                     </Array>
                 </Arg>
-                <Set name="host">
+                <Set name="host">10.167.4.39
                     <Property name="jetty.host"/>
                 </Set>
                 <Set name="port">
-                    <Property name="jetty.port" default="8181"/>
+                    <Property name="jetty.port" default="8282"/>
                 </Set>
                 <Set name="idleTimeout">
                     <Property name="http.timeout" default="300000"/>

2018-05-11 04:21:09,511 [salt.state       ][INFO    ][7485] Completed state [/opt/opendaylight/etc/jetty.xml] at time 04:21:09.511157 duration_in_ms=129.126
2018-05-11 04:21:09,511 [salt.state       ][INFO    ][7485] Running state [/opt/opendaylight/bin/setenv] at time 04:21:09.511754
2018-05-11 04:21:09,512 [salt.state       ][INFO    ][7485] Executing state file.managed for /opt/opendaylight/bin/setenv
2018-05-11 04:21:09,585 [salt.fileclient  ][INFO    ][7485] Fetching file from saltenv 'base', ** done ** 'opendaylight/files/setenv.shell'
2018-05-11 04:21:09,652 [salt.state       ][INFO    ][7485] File changed:
--- 
+++ 
@@ -1,46 +1,15 @@
-#!/bin/sh
-#
-#    Licensed to the Apache Software Foundation (ASF) under one or more
-#    contributor license agreements.  See the NOTICE file distributed with
-#    this work for additional information regarding copyright ownership.
-#    The ASF licenses this file to You under the Apache License, Version 2.0
-#    (the "License"); you may not use this file except in compliance with
-#    the License.  You may obtain a copy of the License at
-#
-#       http://www.apache.org/licenses/LICENSE-2.0
-#
-#    Unless required by applicable law or agreed to in writing, software
-#    distributed under the License is distributed on an "AS IS" BASIS,
-#    WITHOUT WARRANTIES OR CONDITIONS OF ANY KIND, either express or implied.
-#    See the License for the specific language governing permissions and
-#    limitations under the License.
-#
-
-#
-# handle specific scripts; the SCRIPT_NAME is exactly the name of the Karaf
-# script: client, instance, shell, start, status, stop, karaf
-#
-# if [ "${KARAF_SCRIPT}" == "SCRIPT_NAME" ]; then
-#   Actions go here...
-# fi
-
-#
-# general settings which should be applied for all scripts go here; please keep
-# in mind that it is possible that scripts might be executed more than once, e.g.
-# in example of the start script where the start script is executed first and the
-# karaf script afterwards.
-#
-
-#
-# The following section shows the possible configuration options for the default 
-# karaf scripts
-#
-# export JAVA_HOME # Location of Java installation
-# export JAVA_MIN_MEM # Minimum memory for the JVM
-# export JAVA_MAX_MEM # Maximum memory for the JVM
+##############################################################################
+# Copyright (c) 2017 Mirantis Inc. and others.
+# All rights reserved. This program and the accompanying materials
+# are made available under the terms of the Apache License, Version 2.0
+# which accompanies this distribution, and is available at
+# http://www.apache.org/licenses/LICENSE-2.0
+############################################################################### export JAVA_HOME # Location of Java installation
+export JAVA_MIN_MEM=6g # Minimum memory for the JVM
+export JAVA_MAX_MEM=6g # Maximum memory for the JVM
 # export JAVA_PERM_MEM # Minimum perm memory for the JVM
-# export JAVA_MAX_PERM_MEM # Maximum perm memory for the JVM
-# export EXTRA_JAVA_OPTS # Additional JVM options
+export JAVA_MAX_PERM_MEM=512m # Maximum perm memory for the JVM
+export EXTRA_JAVA_OPTS='-Djava.net.preferIPv4Stack=true -XX:+UseG1GC' # Additional JVM options
 # export KARAF_HOME # Karaf home folder
 # export KARAF_DATA # Karaf data folder
 # export KARAF_BASE # Karaf base folder
@@ -48,7 +17,3 @@
 # export KARAF_OPTS # Additional available Karaf options
 # export KARAF_DEBUG # Enable debug mode
 # export KARAF_REDIRECT # Enable/set the std/err redirection when using bin/start
-# export KARAF_NOROOT # Prevent execution as root if set to true
-if [ "x$JAVA_MAX_MEM" = "x" ]; then
-    export JAVA_MAX_MEM="2048m"
-fi

2018-05-11 04:21:09,652 [salt.state       ][INFO    ][7485] Completed state [/opt/opendaylight/bin/setenv] at time 04:21:09.652772 duration_in_ms=141.018
2018-05-11 04:21:09,654 [salt.state       ][INFO    ][7485] Running state [/opt/opendaylight/etc/org.apache.karaf.features.cfg] at time 04:21:09.654324
2018-05-11 04:21:09,655 [salt.state       ][INFO    ][7485] Executing state ini.options_present for /opt/opendaylight/etc/org.apache.karaf.features.cfg
2018-05-11 04:21:09,691 [salt.state       ][INFO    ][7485] {'featuresBoot': {'after': 'standard,wrap,ssh,odl-restconf-all,odl-aaa-authn,odl-netvirt-openstack', 'before': '2e29bcc5-60c3-463f-871f-0b938ef2c8bf'}}
2018-05-11 04:21:09,692 [salt.state       ][INFO    ][7485] Completed state [/opt/opendaylight/etc/org.apache.karaf.features.cfg] at time 04:21:09.691975 duration_in_ms=37.652
2018-05-11 04:21:09,692 [salt.state       ][INFO    ][7485] Running state [/opt/opendaylight/etc/org.ops4j.pax.web.cfg] at time 04:21:09.692418
2018-05-11 04:21:09,692 [salt.state       ][INFO    ][7485] Executing state ini.options_present for /opt/opendaylight/etc/org.ops4j.pax.web.cfg
2018-05-11 04:21:09,693 [salt.state       ][INFO    ][7485] {'org.osgi.service.http.port': {'after': '8282', 'before': '8181'}, 'org.ops4j.pax.web.listening.addresses': {'after': '10.167.4.39', 'before': None}}
2018-05-11 04:21:09,694 [salt.state       ][INFO    ][7485] Completed state [/opt/opendaylight/etc/org.ops4j.pax.web.cfg] at time 04:21:09.694198 duration_in_ms=1.779
2018-05-11 04:21:09,694 [salt.state       ][INFO    ][7485] Running state [/opt/opendaylight/etc/custom.properties] at time 04:21:09.694644
2018-05-11 04:21:09,695 [salt.state       ][INFO    ][7485] Executing state ini.options_present for /opt/opendaylight/etc/custom.properties
2018-05-11 04:21:09,729 [salt.state       ][INFO    ][7485] {'ovsdb.l3.fwd.enabled': {'after': 'yes', 'before': None}, 'ovsdb.of.version': {'after': '1.3', 'before': None}}
2018-05-11 04:21:09,730 [salt.state       ][INFO    ][7485] Completed state [/opt/opendaylight/etc/custom.properties] at time 04:21:09.730050 duration_in_ms=35.407
2018-05-11 04:21:09,730 [salt.state       ][INFO    ][7485] Running state [opendaylight] at time 04:21:09.730643
2018-05-11 04:21:09,731 [salt.state       ][INFO    ][7485] Executing state service.running for opendaylight
2018-05-11 04:21:09,731 [salt.state       ][ERROR   ][7485] The named service opendaylight is not available
2018-05-11 04:21:09,732 [salt.state       ][INFO    ][7485] Completed state [opendaylight] at time 04:21:09.732043 duration_in_ms=1.4
2018-05-11 04:21:09,732 [salt.state       ][INFO    ][7485] Running state [opendaylight] at time 04:21:09.732296
2018-05-11 04:21:09,732 [salt.state       ][INFO    ][7485] Executing state service.mod_watch for opendaylight
2018-05-11 04:21:09,733 [salt.loaded.int.module.cmdmod][INFO    ][7485] Executing command ['systemctl', 'is-active', 'opendaylight.service'] in directory '/root'
2018-05-11 04:21:09,761 [salt.loaded.int.module.cmdmod][INFO    ][7485] Executing command ['systemd-run', '--scope', 'systemctl', 'stop', 'opendaylight.service'] in directory '/root'
2018-05-11 04:21:09,823 [salt.loaded.int.module.cmdmod][INFO    ][7485] Executing command ['systemctl', 'is-enabled', 'opendaylight.service'] in directory '/root'
2018-05-11 04:21:09,836 [salt.loaded.int.module.cmdmod][INFO    ][7485] Executing command ['systemd-run', '--scope', 'systemctl', 'unmask', 'opendaylight.service'] in directory '/root'
2018-05-11 04:21:09,961 [salt.loaded.int.module.cmdmod][INFO    ][7485] Executing command ['systemd-run', '--scope', 'systemctl', 'start', 'opendaylight.service'] in directory '/root'
2018-05-11 04:21:10,020 [salt.state       ][INFO    ][7485] {'opendaylight': True}
2018-05-11 04:21:10,021 [salt.state       ][INFO    ][7485] Completed state [opendaylight] at time 04:21:10.021037 duration_in_ms=288.74
2018-05-11 04:21:10,024 [salt.minion      ][INFO    ][7485] Returning information for job: 20180511040643531141
2018-05-11 04:21:10,982 [salt.minion      ][INFO    ][2517] User sudo_ubuntu Executing command pillar.get with jid 20180511042110962965
2018-05-11 04:21:11,002 [salt.minion      ][INFO    ][12324] Starting a new job with PID 12324
2018-05-11 04:21:11,009 [salt.minion      ][INFO    ][12324] Returning information for job: 20180511042110962965
2018-05-11 04:21:11,709 [salt.minion      ][INFO    ][2517] User sudo_ubuntu Executing command pillar.get with jid 20180511042111694994
2018-05-11 04:21:11,729 [salt.minion      ][INFO    ][12334] Starting a new job with PID 12334
2018-05-11 04:21:11,735 [salt.minion      ][INFO    ][12334] Returning information for job: 20180511042111694994
2018-05-11 05:01:48,833 [salt.utils.schedule][INFO    ][2517] Running scheduled job: __mine_interval
2018-05-11 05:45:27,433 [salt.minion      ][INFO    ][2517] User sudo_ubuntu Executing command cp.push_dir with jid 20180511054527430845
2018-05-11 05:45:27,468 [salt.minion      ][INFO    ][13649] Starting a new job with PID 13649
