2018-02-22 04:13:30,897 [salt.loaded.int.module.cmdmod][ERROR   ][1435] 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-02-22 04:13:34,322 [salt.loaded.int.module.cmdmod][INFO    ][1964] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2018-02-22 04:13:34,348 [salt.loaded.int.module.cmdmod][INFO    ][1964] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2018-02-22 04:13:34,388 [salt.loaded.int.module.cmdmod][INFO    ][1964] Executing command ['systemd-run', '--scope', 'systemctl', 'restart', 'salt-minion.service'] in directory '/root'
2018-02-22 04:13:34,426 [salt.utils.parsers][WARNING ][1204] Minion received a SIGTERM. Exiting.
2018-02-22 04:13:35,299 [salt.cli.daemons ][INFO    ][2013] Setting up the Salt Minion "odl01.mcp-pike-odl-ha.local"
2018-02-22 04:13:35,390 [salt.cli.daemons ][INFO    ][2013] Starting up the Salt Minion
2018-02-22 04:13:35,391 [salt.utils.event ][INFO    ][2013] Starting pull socket on /var/run/salt/minion/minion_event_6c7e1bdd60_pull.ipc
2018-02-22 04:13:36,096 [salt.minion      ][INFO    ][2013] Creating minion process manager
2018-02-22 04:13:37,192 [salt.loader.192.168.11.2.int.module.cmdmod][INFO    ][2013] Executing command ['date', '+%z'] in directory '/root'
2018-02-22 04:13:37,226 [salt.utils.schedule][INFO    ][2013] Updating job settings for scheduled job: __mine_interval
2018-02-22 04:13:37,229 [salt.minion      ][INFO    ][2013] Added mine.update to scheduler
2018-02-22 04:13:37,235 [salt.minion      ][INFO    ][2013] Minion is starting as user 'root'
2018-02-22 04:13:37,257 [salt.minion      ][INFO    ][2013] Minion is ready to receive requests!
2018-02-22 04:13:38,260 [salt.utils.schedule][INFO    ][2013] Running scheduled job: __mine_interval
2018-02-22 04:14:22,871 [salt.minion      ][INFO    ][2013] User sudo_ubuntu Executing command state.apply with jid 20180222041423961567
2018-02-22 04:14:22,901 [salt.minion      ][INFO    ][2104] Starting a new job with PID 2104
2018-02-22 04:14:26,622 [salt.state       ][INFO    ][2104] Loading fresh modules for state activity
2018-02-22 04:14:26,864 [salt.fileclient  ][INFO    ][2104] Fetching file from saltenv 'base', ** done ** 'linux/init.sls'
2018-02-22 04:14:26,919 [salt.fileclient  ][INFO    ][2104] Fetching file from saltenv 'base', ** done ** 'linux/system/init.sls'
2018-02-22 04:14:27,062 [salt.fileclient  ][INFO    ][2104] Fetching file from saltenv 'base', ** done ** 'linux/system/env.sls'
2018-02-22 04:14:27,187 [salt.fileclient  ][INFO    ][2104] Fetching file from saltenv 'base', ** done ** 'linux/system/profile.sls'
2018-02-22 04:14:27,302 [salt.fileclient  ][INFO    ][2104] Fetching file from saltenv 'base', ** done ** 'linux/system/repo.sls'
2018-02-22 04:14:27,481 [salt.fileclient  ][INFO    ][2104] Fetching file from saltenv 'base', ** done ** 'linux/system/package.sls'
2018-02-22 04:14:27,590 [salt.fileclient  ][INFO    ][2104] Fetching file from saltenv 'base', ** done ** 'linux/system/timezone.sls'
2018-02-22 04:14:27,690 [salt.fileclient  ][INFO    ][2104] Fetching file from saltenv 'base', ** done ** 'linux/system/kernel.sls'
2018-02-22 04:14:27,834 [salt.fileclient  ][INFO    ][2104] Fetching file from saltenv 'base', ** done ** 'linux/system/cpu.sls'
2018-02-22 04:14:27,940 [salt.fileclient  ][INFO    ][2104] Fetching file from saltenv 'base', ** done ** 'linux/system/sysfs.sls'
2018-02-22 04:14:28,049 [salt.fileclient  ][INFO    ][2104] Fetching file from saltenv 'base', ** done ** 'linux/system/locale.sls'
2018-02-22 04:14:28,270 [salt.fileclient  ][INFO    ][2104] Fetching file from saltenv 'base', ** done ** 'linux/system/user.sls'
2018-02-22 04:14:28,403 [salt.fileclient  ][INFO    ][2104] Fetching file from saltenv 'base', ** done ** 'linux/system/group.sls'
2018-02-22 04:14:28,519 [salt.fileclient  ][INFO    ][2104] Fetching file from saltenv 'base', ** done ** 'linux/system/limit.sls'
2018-02-22 04:14:28,624 [salt.fileclient  ][INFO    ][2104] Fetching file from saltenv 'base', ** done ** 'linux/system/systemd.sls'
2018-02-22 04:14:28,736 [salt.fileclient  ][INFO    ][2104] Fetching file from saltenv 'base', ** done ** 'linux/system/apt.sls'
2018-02-22 04:14:28,876 [salt.fileclient  ][INFO    ][2104] Fetching file from saltenv 'base', ** done ** 'linux/network/init.sls'
2018-02-22 04:14:28,987 [salt.fileclient  ][INFO    ][2104] Fetching file from saltenv 'base', ** done ** 'linux/network/hostname.sls'
2018-02-22 04:14:29,095 [salt.fileclient  ][INFO    ][2104] Fetching file from saltenv 'base', ** done ** 'linux/network/host.sls'
2018-02-22 04:14:29,263 [salt.fileclient  ][INFO    ][2104] Fetching file from saltenv 'base', ** done ** 'linux/network/interface.sls'
2018-02-22 04:14:29,441 [salt.fileclient  ][INFO    ][2104] Fetching file from saltenv 'base', ** done ** 'linux/network/proxy.sls'
2018-02-22 04:14:29,742 [salt.fileclient  ][INFO    ][2104] Fetching file from saltenv 'base', ** done ** 'linux/storage/init.sls'
2018-02-22 04:14:29,863 [salt.fileclient  ][INFO    ][2104] Fetching file from saltenv 'base', ** done ** 'ntp/init.sls'
2018-02-22 04:14:29,883 [salt.fileclient  ][INFO    ][2104] Fetching file from saltenv 'base', ** done ** 'ntp/client.sls'
2018-02-22 04:14:29,929 [salt.fileclient  ][INFO    ][2104] Fetching file from saltenv 'base', ** done ** 'ntp/server.sls'
2018-02-22 04:14:29,964 [salt.state       ][INFO    ][2104] Running state [/etc/environment] at time 04:14:29.964742
2018-02-22 04:14:29,965 [salt.state       ][INFO    ][2104] Executing state file.blockreplace for /etc/environment
2018-02-22 04:14:29,974 [salt.state       ][INFO    ][2104] 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-02-22 04:14:29,975 [salt.state       ][INFO    ][2104] Completed state [/etc/environment] at time 04:14:29.975894 duration_in_ms=11.152
2018-02-22 04:14:29,976 [salt.state       ][INFO    ][2104] Running state [/etc/profile.d] at time 04:14:29.976371
2018-02-22 04:14:29,976 [salt.state       ][INFO    ][2104] Executing state file.directory for /etc/profile.d
2018-02-22 04:14:29,978 [salt.state       ][INFO    ][2104] Directory /etc/profile.d is in the correct state
2018-02-22 04:14:29,979 [salt.state       ][INFO    ][2104] Completed state [/etc/profile.d] at time 04:14:29.979528 duration_in_ms=3.156
2018-02-22 04:14:30,501 [salt.state       ][INFO    ][2104] Running state [/etc/apt/apt.conf.d/99compression-workaround-salt] at time 04:14:30.501816
2018-02-22 04:14:30,502 [salt.state       ][INFO    ][2104] Executing state file.managed for /etc/apt/apt.conf.d/99compression-workaround-salt
2018-02-22 04:14:30,532 [salt.fileclient  ][INFO    ][2104] Fetching file from saltenv 'base', ** done ** 'linux/files/apt.conf'
2018-02-22 04:14:30,541 [salt.state       ][INFO    ][2104] File changed:
New file
2018-02-22 04:14:30,542 [salt.state       ][INFO    ][2104] Completed state [/etc/apt/apt.conf.d/99compression-workaround-salt] at time 04:14:30.542258 duration_in_ms=40.441
2018-02-22 04:14:30,542 [salt.state       ][INFO    ][2104] Running state [/etc/apt/apt.conf.d/99prefer_ipv4-salt] at time 04:14:30.542679
2018-02-22 04:14:30,543 [salt.state       ][INFO    ][2104] Executing state file.managed for /etc/apt/apt.conf.d/99prefer_ipv4-salt
2018-02-22 04:14:30,564 [salt.state       ][INFO    ][2104] File changed:
New file
2018-02-22 04:14:30,564 [salt.state       ][INFO    ][2104] Completed state [/etc/apt/apt.conf.d/99prefer_ipv4-salt] at time 04:14:30.564684 duration_in_ms=22.005
2018-02-22 04:14:30,566 [salt.state       ][INFO    ][2104] Running state [linux_repo_prereq_pkgs] at time 04:14:30.566197
2018-02-22 04:14:30,566 [salt.state       ][INFO    ][2104] Executing state pkg.installed for linux_repo_prereq_pkgs
2018-02-22 04:14:30,567 [salt.loaded.int.module.cmdmod][INFO    ][2104] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2018-02-22 04:14:30,937 [salt.state       ][INFO    ][2104] All specified packages are already installed
2018-02-22 04:14:30,939 [salt.state       ][INFO    ][2104] Completed state [linux_repo_prereq_pkgs] at time 04:14:30.939221 duration_in_ms=373.023
2018-02-22 04:14:30,940 [salt.state       ][INFO    ][2104] Running state [/etc/apt/apt.conf.d/99proxies-salt-uca] at time 04:14:30.939770
2018-02-22 04:14:30,940 [salt.state       ][INFO    ][2104] Executing state file.absent for /etc/apt/apt.conf.d/99proxies-salt-uca
2018-02-22 04:14:30,941 [salt.state       ][INFO    ][2104] File /etc/apt/apt.conf.d/99proxies-salt-uca is not present
2018-02-22 04:14:30,941 [salt.state       ][INFO    ][2104] Completed state [/etc/apt/apt.conf.d/99proxies-salt-uca] at time 04:14:30.941672 duration_in_ms=1.902
2018-02-22 04:14:30,942 [salt.state       ][INFO    ][2104] Running state [/etc/apt/preferences.d/uca] at time 04:14:30.942648
2018-02-22 04:14:30,943 [salt.state       ][INFO    ][2104] Executing state file.absent for /etc/apt/preferences.d/uca
2018-02-22 04:14:30,944 [salt.state       ][INFO    ][2104] File /etc/apt/preferences.d/uca is not present
2018-02-22 04:14:30,944 [salt.state       ][INFO    ][2104] Completed state [/etc/apt/preferences.d/uca] at time 04:14:30.944802 duration_in_ms=2.153
2018-02-22 04:14:30,946 [salt.state       ][INFO    ][2104] Running state [apt-key adv --keyserver keyserver.ubuntu.com --recv EC4926EA] at time 04:14:30.946879
2018-02-22 04:14:30,947 [salt.state       ][INFO    ][2104] Executing state cmd.run for apt-key adv --keyserver keyserver.ubuntu.com --recv EC4926EA
2018-02-22 04:14:30,948 [salt.loaded.int.module.cmdmod][INFO    ][2104] Executing command 'apt-key adv --keyserver keyserver.ubuntu.com --recv EC4926EA' in directory '/root'
2018-02-22 04:14:31,242 [salt.state       ][INFO    ][2104] {'pid': 2162, '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.QDGrmu9w4G/gpg.1.sh --keyserver\nkeyserver.ubuntu.com\n--recv\nEC4926EA'}
2018-02-22 04:14:31,243 [salt.state       ][INFO    ][2104] Completed state [apt-key adv --keyserver keyserver.ubuntu.com --recv EC4926EA] at time 04:14:31.243885 duration_in_ms=297.005
2018-02-22 04:14:31,250 [salt.state       ][INFO    ][2104] Running state [deb http://ubuntu-cloud.archive.canonical.com/ubuntu xenial-updates/pike main] at time 04:14:31.250457
2018-02-22 04:14:31,251 [salt.state       ][INFO    ][2104] Executing state pkgrepo.managed for deb http://ubuntu-cloud.archive.canonical.com/ubuntu xenial-updates/pike main
2018-02-22 04:14:31,357 [salt.loaded.int.module.cmdmod][INFO    ][2104] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2018-02-22 04:14:32,923 [salt.minion      ][INFO    ][2013] User sudo_ubuntu Executing command saltutil.find_job with jid 20180222041434009194
2018-02-22 04:14:32,941 [salt.minion      ][INFO    ][2584] Starting a new job with PID 2584
2018-02-22 04:14:32,963 [salt.minion      ][INFO    ][2584] Returning information for job: 20180222041434009194
2018-02-22 04:14:35,139 [salt.state       ][INFO    ][2104] {'repo': 'deb http://ubuntu-cloud.archive.canonical.com/ubuntu xenial-updates/pike main'}
2018-02-22 04:14:35,140 [salt.state       ][INFO    ][2104] Completed state [deb http://ubuntu-cloud.archive.canonical.com/ubuntu xenial-updates/pike main] at time 04:14:35.140498 duration_in_ms=3890.04
2018-02-22 04:14:35,141 [salt.state       ][INFO    ][2104] Running state [linux_extra_packages_purged] at time 04:14:35.141364
2018-02-22 04:14:35,141 [salt.state       ][INFO    ][2104] Executing state pkg.purged for linux_extra_packages_purged
2018-02-22 04:14:35,180 [salt.loaded.int.module.cmdmod][INFO    ][2104] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', 'purge', 'cloud-init', 'unattended-upgrades'] in directory '/root'
2018-02-22 04:14:39,698 [salt.loaded.int.module.cmdmod][INFO    ][2104] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2018-02-22 04:14:39,746 [salt.state       ][INFO    ][2104] {'removed': {}, 'installed': {'cloud-init': {'new': '', 'old': '17.1-46-g7acc9e68-0ubuntu1~16.04.1'}, 'ec2-init': {'new': '', 'old': '1'}, 'unattended-upgrades': {'new': '', 'old': '0.90ubuntu0.9'}}}
2018-02-22 04:14:39,770 [salt.state       ][INFO    ][2104] Loading fresh modules for state activity
2018-02-22 04:14:39,807 [salt.state       ][INFO    ][2104] Completed state [linux_extra_packages_purged] at time 04:14:39.807680 duration_in_ms=4666.316
2018-02-22 04:14:39,814 [salt.state       ][INFO    ][2104] Running state [linux_extra_packages_latest] at time 04:14:39.814491
2018-02-22 04:14:39,815 [salt.state       ][INFO    ][2104] Executing state pkg.latest for linux_extra_packages_latest
2018-02-22 04:14:40,363 [salt.loaded.int.module.cmdmod][INFO    ][2104] Executing command ['apt-cache', '-q', 'policy', 'mcelog'] in directory '/root'
2018-02-22 04:14:40,442 [salt.loaded.int.module.cmdmod][INFO    ][2104] Executing command ['dpkg', '--get-selections', '*'] in directory '/root'
2018-02-22 04:14:40,486 [salt.loaded.int.module.cmdmod][INFO    ][2104] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'mcelog'] in directory '/root'
2018-02-22 04:14:42,978 [salt.minion      ][INFO    ][2013] User sudo_ubuntu Executing command saltutil.find_job with jid 20180222041444069587
2018-02-22 04:14:42,995 [salt.minion      ][INFO    ][3739] Starting a new job with PID 3739
2018-02-22 04:14:43,017 [salt.minion      ][INFO    ][3739] Returning information for job: 20180222041444069587
2018-02-22 04:14:43,434 [salt.loaded.int.module.cmdmod][INFO    ][2104] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2018-02-22 04:14:43,472 [salt.state       ][INFO    ][2104] Made the following changes:
'mcelog' changed from 'absent' to '128+dfsg-1'

2018-02-22 04:14:43,491 [salt.state       ][INFO    ][2104] Loading fresh modules for state activity
2018-02-22 04:14:43,575 [salt.state       ][INFO    ][2104] Completed state [linux_extra_packages_latest] at time 04:14:43.575866 duration_in_ms=3761.375
2018-02-22 04:14:43,579 [salt.state       ][INFO    ][2104] Running state [UTC] at time 04:14:43.579415
2018-02-22 04:14:43,579 [salt.state       ][INFO    ][2104] Executing state timezone.system for UTC
2018-02-22 04:14:43,582 [salt.loaded.int.module.cmdmod][INFO    ][2104] Executing command ['timedatectl'] in directory '/root'
2018-02-22 04:14:43,651 [salt.loaded.int.module.cmdmod][INFO    ][2104] Executing command ['timedatectl'] in directory '/root'
2018-02-22 04:14:43,681 [salt.loaded.int.module.cmdmod][INFO    ][2104] Executing command 'timedatectl set-timezone UTC' in directory '/root'
2018-02-22 04:14:43,703 [salt.state       ][INFO    ][2104] {'timezone': 'UTC'}
2018-02-22 04:14:43,704 [salt.state       ][INFO    ][2104] Completed state [UTC] at time 04:14:43.704390 duration_in_ms=124.974
2018-02-22 04:14:43,709 [salt.state       ][INFO    ][2104] Running state [nf_conntrack] at time 04:14:43.709843
2018-02-22 04:14:43,710 [salt.state       ][INFO    ][2104] Executing state kmod.present for nf_conntrack
2018-02-22 04:14:43,710 [salt.loaded.int.module.cmdmod][INFO    ][2104] Executing command 'lsmod' in directory '/root'
2018-02-22 04:14:43,814 [salt.loaded.int.module.cmdmod][INFO    ][2104] Executing command 'lsmod' in directory '/root'
2018-02-22 04:14:43,836 [salt.loaded.int.module.cmdmod][INFO    ][2104] Executing command 'modprobe nf_conntrack' in directory '/root'
2018-02-22 04:14:43,863 [salt.loaded.int.module.cmdmod][INFO    ][2104] Executing command 'lsmod' in directory '/root'
2018-02-22 04:14:43,912 [salt.state       ][INFO    ][2104] {'nf_conntrack': 'loaded'}
2018-02-22 04:14:43,912 [salt.state       ][INFO    ][2104] Completed state [nf_conntrack] at time 04:14:43.912579 duration_in_ms=202.735
2018-02-22 04:14:43,919 [salt.state       ][INFO    ][2104] Running state [kernel.panic] at time 04:14:43.919805
2018-02-22 04:14:43,920 [salt.state       ][INFO    ][2104] Executing state sysctl.present for kernel.panic
2018-02-22 04:14:43,921 [salt.loaded.int.module.cmdmod][INFO    ][2104] Executing command 'sysctl -a' in directory '/root'
2018-02-22 04:14:43,998 [salt.loaded.int.module.cmdmod][INFO    ][2104] Executing command 'sysctl -w kernel.panic="60"' in directory '/root'
2018-02-22 04:14:44,015 [salt.state       ][INFO    ][2104] {'kernel.panic': 60}
2018-02-22 04:14:44,015 [salt.state       ][INFO    ][2104] Completed state [kernel.panic] at time 04:14:44.015677 duration_in_ms=95.871
2018-02-22 04:14:44,016 [salt.state       ][INFO    ][2104] Running state [net.ipv4.tcp_keepalive_probes] at time 04:14:44.016359
2018-02-22 04:14:44,016 [salt.state       ][INFO    ][2104] Executing state sysctl.present for net.ipv4.tcp_keepalive_probes
2018-02-22 04:14:44,018 [salt.loaded.int.module.cmdmod][INFO    ][2104] Executing command 'sysctl -a' in directory '/root'
2018-02-22 04:14:44,052 [salt.loaded.int.module.cmdmod][INFO    ][2104] Executing command 'sysctl -w net.ipv4.tcp_keepalive_probes="8"' in directory '/root'
2018-02-22 04:14:44,069 [salt.state       ][INFO    ][2104] {'net.ipv4.tcp_keepalive_probes': 8}
2018-02-22 04:14:44,070 [salt.state       ][INFO    ][2104] Completed state [net.ipv4.tcp_keepalive_probes] at time 04:14:44.069921 duration_in_ms=53.56
2018-02-22 04:14:44,070 [salt.state       ][INFO    ][2104] Running state [fs.file-max] at time 04:14:44.070344
2018-02-22 04:14:44,070 [salt.state       ][INFO    ][2104] Executing state sysctl.present for fs.file-max
2018-02-22 04:14:44,071 [salt.loaded.int.module.cmdmod][INFO    ][2104] Executing command 'sysctl -a' in directory '/root'
2018-02-22 04:14:44,103 [salt.loaded.int.module.cmdmod][INFO    ][2104] Executing command 'sysctl -w fs.file-max="124165"' in directory '/root'
2018-02-22 04:14:44,116 [salt.state       ][INFO    ][2104] {'fs.file-max': 124165}
2018-02-22 04:14:44,117 [salt.state       ][INFO    ][2104] Completed state [fs.file-max] at time 04:14:44.117271 duration_in_ms=46.927
2018-02-22 04:14:44,117 [salt.state       ][INFO    ][2104] Running state [net.core.somaxconn] at time 04:14:44.117683
2018-02-22 04:14:44,118 [salt.state       ][INFO    ][2104] Executing state sysctl.present for net.core.somaxconn
2018-02-22 04:14:44,118 [salt.loaded.int.module.cmdmod][INFO    ][2104] Executing command 'sysctl -a' in directory '/root'
2018-02-22 04:14:44,151 [salt.loaded.int.module.cmdmod][INFO    ][2104] Executing command 'sysctl -w net.core.somaxconn="4096"' in directory '/root'
2018-02-22 04:14:44,167 [salt.state       ][INFO    ][2104] {'net.core.somaxconn': 4096}
2018-02-22 04:14:44,168 [salt.state       ][INFO    ][2104] Completed state [net.core.somaxconn] at time 04:14:44.168192 duration_in_ms=50.508
2018-02-22 04:14:44,169 [salt.state       ][INFO    ][2104] Running state [net.ipv4.tcp_max_syn_backlog] at time 04:14:44.169441
2018-02-22 04:14:44,169 [salt.state       ][INFO    ][2104] Executing state sysctl.present for net.ipv4.tcp_max_syn_backlog
2018-02-22 04:14:44,170 [salt.loaded.int.module.cmdmod][INFO    ][2104] Executing command 'sysctl -a' in directory '/root'
2018-02-22 04:14:44,208 [salt.loaded.int.module.cmdmod][INFO    ][2104] Executing command 'sysctl -w net.ipv4.tcp_max_syn_backlog="8192"' in directory '/root'
2018-02-22 04:14:44,227 [salt.state       ][INFO    ][2104] {'net.ipv4.tcp_max_syn_backlog': 8192}
2018-02-22 04:14:44,228 [salt.state       ][INFO    ][2104] Completed state [net.ipv4.tcp_max_syn_backlog] at time 04:14:44.227986 duration_in_ms=58.544
2018-02-22 04:14:44,228 [salt.state       ][INFO    ][2104] Running state [net.ipv4.tcp_tw_reuse] at time 04:14:44.228351
2018-02-22 04:14:44,228 [salt.state       ][INFO    ][2104] Executing state sysctl.present for net.ipv4.tcp_tw_reuse
2018-02-22 04:14:44,229 [salt.loaded.int.module.cmdmod][INFO    ][2104] Executing command 'sysctl -a' in directory '/root'
2018-02-22 04:14:44,265 [salt.loaded.int.module.cmdmod][INFO    ][2104] Executing command 'sysctl -w net.ipv4.tcp_tw_reuse="1"' in directory '/root'
2018-02-22 04:14:44,282 [salt.state       ][INFO    ][2104] {'net.ipv4.tcp_tw_reuse': 1}
2018-02-22 04:14:44,282 [salt.state       ][INFO    ][2104] Completed state [net.ipv4.tcp_tw_reuse] at time 04:14:44.282831 duration_in_ms=54.479
2018-02-22 04:14:44,283 [salt.state       ][INFO    ][2104] Running state [net.ipv4.tcp_congestion_control] at time 04:14:44.283265
2018-02-22 04:14:44,283 [salt.state       ][INFO    ][2104] Executing state sysctl.present for net.ipv4.tcp_congestion_control
2018-02-22 04:14:44,284 [salt.loaded.int.module.cmdmod][INFO    ][2104] Executing command 'sysctl -a' in directory '/root'
2018-02-22 04:14:44,320 [salt.loaded.int.module.cmdmod][INFO    ][2104] Executing command 'sysctl -w net.ipv4.tcp_congestion_control="yeah"' in directory '/root'
2018-02-22 04:14:44,343 [salt.state       ][INFO    ][2104] {'net.ipv4.tcp_congestion_control': 'yeah'}
2018-02-22 04:14:44,344 [salt.state       ][INFO    ][2104] Completed state [net.ipv4.tcp_congestion_control] at time 04:14:44.344182 duration_in_ms=60.917
2018-02-22 04:14:44,344 [salt.state       ][INFO    ][2104] Running state [net.ipv4.tcp_retries2] at time 04:14:44.344588
2018-02-22 04:14:44,344 [salt.state       ][INFO    ][2104] Executing state sysctl.present for net.ipv4.tcp_retries2
2018-02-22 04:14:44,345 [salt.loaded.int.module.cmdmod][INFO    ][2104] Executing command 'sysctl -a' in directory '/root'
2018-02-22 04:14:44,383 [salt.loaded.int.module.cmdmod][INFO    ][2104] Executing command 'sysctl -w net.ipv4.tcp_retries2="5"' in directory '/root'
2018-02-22 04:14:44,400 [salt.state       ][INFO    ][2104] {'net.ipv4.tcp_retries2': 5}
2018-02-22 04:14:44,401 [salt.state       ][INFO    ][2104] Completed state [net.ipv4.tcp_retries2] at time 04:14:44.401852 duration_in_ms=57.263
2018-02-22 04:14:44,402 [salt.state       ][INFO    ][2104] Running state [net.core.netdev_max_backlog] at time 04:14:44.402781
2018-02-22 04:14:44,403 [salt.state       ][INFO    ][2104] Executing state sysctl.present for net.core.netdev_max_backlog
2018-02-22 04:14:44,404 [salt.loaded.int.module.cmdmod][INFO    ][2104] Executing command 'sysctl -a' in directory '/root'
2018-02-22 04:14:44,440 [salt.loaded.int.module.cmdmod][INFO    ][2104] Executing command 'sysctl -w net.core.netdev_max_backlog="261144"' in directory '/root'
2018-02-22 04:14:44,457 [salt.state       ][INFO    ][2104] {'net.core.netdev_max_backlog': 261144}
2018-02-22 04:14:44,458 [salt.state       ][INFO    ][2104] Completed state [net.core.netdev_max_backlog] at time 04:14:44.458155 duration_in_ms=55.372
2018-02-22 04:14:44,458 [salt.state       ][INFO    ][2104] Running state [net.ipv4.tcp_slow_start_after_idle] at time 04:14:44.458556
2018-02-22 04:14:44,458 [salt.state       ][INFO    ][2104] Executing state sysctl.present for net.ipv4.tcp_slow_start_after_idle
2018-02-22 04:14:44,459 [salt.loaded.int.module.cmdmod][INFO    ][2104] Executing command 'sysctl -a' in directory '/root'
2018-02-22 04:14:44,494 [salt.loaded.int.module.cmdmod][INFO    ][2104] Executing command 'sysctl -w net.ipv4.tcp_slow_start_after_idle="0"' in directory '/root'
2018-02-22 04:14:44,507 [salt.state       ][INFO    ][2104] {'net.ipv4.tcp_slow_start_after_idle': 0}
2018-02-22 04:14:44,508 [salt.state       ][INFO    ][2104] Completed state [net.ipv4.tcp_slow_start_after_idle] at time 04:14:44.508149 duration_in_ms=49.593
2018-02-22 04:14:44,508 [salt.state       ][INFO    ][2104] Running state [vm.swappiness] at time 04:14:44.508559
2018-02-22 04:14:44,509 [salt.state       ][INFO    ][2104] Executing state sysctl.present for vm.swappiness
2018-02-22 04:14:44,510 [salt.loaded.int.module.cmdmod][INFO    ][2104] Executing command 'sysctl -a' in directory '/root'
2018-02-22 04:14:44,544 [salt.loaded.int.module.cmdmod][INFO    ][2104] Executing command 'sysctl -w vm.swappiness="10"' in directory '/root'
2018-02-22 04:14:44,560 [salt.state       ][INFO    ][2104] {'vm.swappiness': 10}
2018-02-22 04:14:44,561 [salt.state       ][INFO    ][2104] Completed state [vm.swappiness] at time 04:14:44.560963 duration_in_ms=52.403
2018-02-22 04:14:44,561 [salt.state       ][INFO    ][2104] Running state [net.ipv4.tcp_keepalive_intvl] at time 04:14:44.561344
2018-02-22 04:14:44,561 [salt.state       ][INFO    ][2104] Executing state sysctl.present for net.ipv4.tcp_keepalive_intvl
2018-02-22 04:14:44,562 [salt.loaded.int.module.cmdmod][INFO    ][2104] Executing command 'sysctl -a' in directory '/root'
2018-02-22 04:14:44,596 [salt.loaded.int.module.cmdmod][INFO    ][2104] Executing command 'sysctl -w net.ipv4.tcp_keepalive_intvl="3"' in directory '/root'
2018-02-22 04:14:44,613 [salt.state       ][INFO    ][2104] {'net.ipv4.tcp_keepalive_intvl': 3}
2018-02-22 04:14:44,614 [salt.state       ][INFO    ][2104] Completed state [net.ipv4.tcp_keepalive_intvl] at time 04:14:44.614684 duration_in_ms=53.339
2018-02-22 04:14:44,615 [salt.state       ][INFO    ][2104] Running state [net.ipv4.neigh.default.gc_thresh1] at time 04:14:44.615602
2018-02-22 04:14:44,616 [salt.state       ][INFO    ][2104] Executing state sysctl.present for net.ipv4.neigh.default.gc_thresh1
2018-02-22 04:14:44,617 [salt.loaded.int.module.cmdmod][INFO    ][2104] Executing command 'sysctl -a' in directory '/root'
2018-02-22 04:14:44,658 [salt.loaded.int.module.cmdmod][INFO    ][2104] Executing command 'sysctl -w net.ipv4.neigh.default.gc_thresh1="4096"' in directory '/root'
2018-02-22 04:14:44,674 [salt.state       ][INFO    ][2104] {'net.ipv4.neigh.default.gc_thresh1': 4096}
2018-02-22 04:14:44,675 [salt.state       ][INFO    ][2104] Completed state [net.ipv4.neigh.default.gc_thresh1] at time 04:14:44.674941 duration_in_ms=59.338
2018-02-22 04:14:44,676 [salt.state       ][INFO    ][2104] Running state [net.ipv4.neigh.default.gc_thresh2] at time 04:14:44.676086
2018-02-22 04:14:44,676 [salt.state       ][INFO    ][2104] Executing state sysctl.present for net.ipv4.neigh.default.gc_thresh2
2018-02-22 04:14:44,677 [salt.loaded.int.module.cmdmod][INFO    ][2104] Executing command 'sysctl -a' in directory '/root'
2018-02-22 04:14:44,716 [salt.loaded.int.module.cmdmod][INFO    ][2104] Executing command 'sysctl -w net.ipv4.neigh.default.gc_thresh2="8192"' in directory '/root'
2018-02-22 04:14:44,733 [salt.state       ][INFO    ][2104] {'net.ipv4.neigh.default.gc_thresh2': 8192}
2018-02-22 04:14:44,734 [salt.state       ][INFO    ][2104] Completed state [net.ipv4.neigh.default.gc_thresh2] at time 04:14:44.734011 duration_in_ms=57.925
2018-02-22 04:14:44,734 [salt.state       ][INFO    ][2104] Running state [net.ipv4.neigh.default.gc_thresh3] at time 04:14:44.734473
2018-02-22 04:14:44,734 [salt.state       ][INFO    ][2104] Executing state sysctl.present for net.ipv4.neigh.default.gc_thresh3
2018-02-22 04:14:44,735 [salt.loaded.int.module.cmdmod][INFO    ][2104] Executing command 'sysctl -a' in directory '/root'
2018-02-22 04:14:44,776 [salt.loaded.int.module.cmdmod][INFO    ][2104] Executing command 'sysctl -w net.ipv4.neigh.default.gc_thresh3="16384"' in directory '/root'
2018-02-22 04:14:44,793 [salt.state       ][INFO    ][2104] {'net.ipv4.neigh.default.gc_thresh3': 16384}
2018-02-22 04:14:44,793 [salt.state       ][INFO    ][2104] Completed state [net.ipv4.neigh.default.gc_thresh3] at time 04:14:44.793482 duration_in_ms=59.009
2018-02-22 04:14:44,793 [salt.state       ][INFO    ][2104] Running state [net.ipv4.tcp_fin_timeout] at time 04:14:44.793914
2018-02-22 04:14:44,794 [salt.state       ][INFO    ][2104] Executing state sysctl.present for net.ipv4.tcp_fin_timeout
2018-02-22 04:14:44,795 [salt.loaded.int.module.cmdmod][INFO    ][2104] Executing command 'sysctl -a' in directory '/root'
2018-02-22 04:14:44,838 [salt.loaded.int.module.cmdmod][INFO    ][2104] Executing command 'sysctl -w net.ipv4.tcp_fin_timeout="30"' in directory '/root'
2018-02-22 04:14:44,862 [salt.state       ][INFO    ][2104] {'net.ipv4.tcp_fin_timeout': 30}
2018-02-22 04:14:44,862 [salt.state       ][INFO    ][2104] Completed state [net.ipv4.tcp_fin_timeout] at time 04:14:44.862730 duration_in_ms=68.815
2018-02-22 04:14:44,863 [salt.state       ][INFO    ][2104] Running state [net.ipv4.tcp_keepalive_time] at time 04:14:44.863194
2018-02-22 04:14:44,863 [salt.state       ][INFO    ][2104] Executing state sysctl.present for net.ipv4.tcp_keepalive_time
2018-02-22 04:14:44,866 [salt.loaded.int.module.cmdmod][INFO    ][2104] Executing command 'sysctl -a' in directory '/root'
2018-02-22 04:14:44,912 [salt.loaded.int.module.cmdmod][INFO    ][2104] Executing command 'sysctl -w net.ipv4.tcp_keepalive_time="30"' in directory '/root'
2018-02-22 04:14:44,935 [salt.state       ][INFO    ][2104] {'net.ipv4.tcp_keepalive_time': 30}
2018-02-22 04:14:44,936 [salt.state       ][INFO    ][2104] Completed state [net.ipv4.tcp_keepalive_time] at time 04:14:44.935987 duration_in_ms=72.792
2018-02-22 04:14:44,937 [salt.state       ][INFO    ][2104] Running state [net.nf_conntrack_max] at time 04:14:44.936856
2018-02-22 04:14:44,938 [salt.state       ][INFO    ][2104] Executing state sysctl.present for net.nf_conntrack_max
2018-02-22 04:14:44,939 [salt.loaded.int.module.cmdmod][INFO    ][2104] Executing command 'sysctl -a' in directory '/root'
2018-02-22 04:14:44,983 [salt.loaded.int.module.cmdmod][INFO    ][2104] Executing command 'sysctl -w net.nf_conntrack_max="1048576"' in directory '/root'
2018-02-22 04:14:45,004 [salt.state       ][INFO    ][2104] {'net.nf_conntrack_max': 1048576}
2018-02-22 04:14:45,005 [salt.state       ][INFO    ][2104] Completed state [net.nf_conntrack_max] at time 04:14:45.005222 duration_in_ms=68.366
2018-02-22 04:14:45,013 [salt.state       ][INFO    ][2104] Running state [linux_sysfs_package] at time 04:14:45.013783
2018-02-22 04:14:45,014 [salt.state       ][INFO    ][2104] Executing state pkg.installed for linux_sysfs_package
2018-02-22 04:14:45,491 [salt.loaded.int.module.cmdmod][INFO    ][2104] Executing command ['apt-cache', '-q', 'policy', 'sysfsutils'] in directory '/root'
2018-02-22 04:14:45,570 [salt.loaded.int.module.cmdmod][INFO    ][2104] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2018-02-22 04:14:47,570 [salt.loaded.int.module.cmdmod][INFO    ][2104] Executing command ['dpkg', '--get-selections', '*'] in directory '/root'
2018-02-22 04:14:47,603 [salt.loaded.int.module.cmdmod][INFO    ][2104] 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-02-22 04:14:50,684 [salt.loaded.int.module.cmdmod][INFO    ][2104] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2018-02-22 04:14:50,741 [salt.state       ][INFO    ][2104] 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-02-22 04:14:50,765 [salt.state       ][INFO    ][2104] Loading fresh modules for state activity
2018-02-22 04:14:50,804 [salt.state       ][INFO    ][2104] Completed state [linux_sysfs_package] at time 04:14:50.804061 duration_in_ms=5790.277
2018-02-22 04:14:50,808 [salt.state       ][INFO    ][2104] Running state [/etc/sysfs.d] at time 04:14:50.808032
2018-02-22 04:14:50,808 [salt.state       ][INFO    ][2104] Executing state file.directory for /etc/sysfs.d
2018-02-22 04:14:50,813 [salt.state       ][INFO    ][2104] Directory /etc/sysfs.d is in the correct state
2018-02-22 04:14:50,814 [salt.state       ][INFO    ][2104] Completed state [/etc/sysfs.d] at time 04:14:50.814175 duration_in_ms=6.142
2018-02-22 04:14:51,221 [salt.state       ][INFO    ][2104] Running state [ondemand] at time 04:14:51.221657
2018-02-22 04:14:51,222 [salt.state       ][INFO    ][2104] Executing state service.dead for ondemand
2018-02-22 04:14:51,227 [salt.loaded.int.module.cmdmod][INFO    ][2104] Executing command ['systemctl', 'status', 'ondemand.service', '-n', '0'] in directory '/root'
2018-02-22 04:14:51,251 [salt.loaded.int.module.cmdmod][INFO    ][2104] Executing command ['systemctl', 'is-active', 'ondemand.service'] in directory '/root'
2018-02-22 04:14:51,276 [salt.loaded.int.module.cmdmod][INFO    ][2104] Executing command ['systemctl', 'is-enabled', 'ondemand.service'] in directory '/root'
2018-02-22 04:14:51,305 [salt.loaded.int.module.cmdmod][INFO    ][2104] Executing command ['systemd-run', '--scope', 'systemctl', 'stop', 'ondemand.service'] in directory '/root'
2018-02-22 04:14:51,396 [salt.loaded.int.module.cmdmod][INFO    ][2104] Executing command ['systemctl', 'is-active', 'ondemand.service'] in directory '/root'
2018-02-22 04:14:51,415 [salt.loaded.int.module.cmdmod][INFO    ][2104] Executing command ['systemctl', 'is-enabled', 'ondemand.service'] in directory '/root'
2018-02-22 04:14:51,442 [salt.loaded.int.module.cmdmod][INFO    ][2104] Executing command ['systemctl', 'is-enabled', 'ondemand.service'] in directory '/root'
2018-02-22 04:14:51,478 [salt.loaded.int.module.cmdmod][INFO    ][2104] Executing command ['systemd-run', '--scope', '/usr/sbin/update-rc.d', '-f', 'ondemand', 'remove'] in directory '/root'
2018-02-22 04:14:51,646 [salt.loaded.int.module.cmdmod][INFO    ][2104] Executing command ['systemctl', 'is-enabled', 'ondemand.service'] in directory '/root'
2018-02-22 04:14:51,674 [salt.loaded.int.module.cmdmod][INFO    ][2104] Executing command 'runlevel' in directory '/root'
2018-02-22 04:14:51,689 [salt.state       ][INFO    ][2104] {'ondemand': True}
2018-02-22 04:14:51,690 [salt.state       ][INFO    ][2104] Completed state [ondemand] at time 04:14:51.690642 duration_in_ms=468.984
2018-02-22 04:14:51,692 [salt.state       ][INFO    ][2104] Running state [cs_CZ.UTF-8] at time 04:14:51.692816
2018-02-22 04:14:51,694 [salt.state       ][INFO    ][2104] Executing state locale.present for cs_CZ.UTF-8
2018-02-22 04:14:51,695 [salt.loaded.int.module.cmdmod][INFO    ][2104] Executing command 'locale -a' in directory '/root'
2018-02-22 04:14:51,714 [salt.loaded.int.module.cmdmod][INFO    ][2104] Executing command ['locale-gen', 'cs_CZ.utf8'] in directory '/root'
2018-02-22 04:14:52,341 [salt.state       ][INFO    ][2104] {'locale': 'cs_CZ.UTF-8'}
2018-02-22 04:14:52,342 [salt.state       ][INFO    ][2104] Completed state [cs_CZ.UTF-8] at time 04:14:52.342857 duration_in_ms=650.041
2018-02-22 04:14:52,343 [salt.state       ][INFO    ][2104] Running state [en_US.UTF-8] at time 04:14:52.343519
2018-02-22 04:14:52,344 [salt.state       ][INFO    ][2104] Executing state locale.present for en_US.UTF-8
2018-02-22 04:14:52,344 [salt.loaded.int.module.cmdmod][INFO    ][2104] Executing command 'locale -a' in directory '/root'
2018-02-22 04:14:52,356 [salt.state       ][INFO    ][2104] Locale en_US.UTF-8 is already present
2018-02-22 04:14:52,357 [salt.state       ][INFO    ][2104] Completed state [en_US.UTF-8] at time 04:14:52.357362 duration_in_ms=13.843
2018-02-22 04:14:52,359 [salt.state       ][INFO    ][2104] Running state [en_US.UTF-8] at time 04:14:52.359395
2018-02-22 04:14:52,359 [salt.state       ][INFO    ][2104] Executing state locale.system for en_US.UTF-8
2018-02-22 04:14:52,361 [salt.loaded.int.module.cmdmod][INFO    ][2104] Executing command 'localectl' in directory '/root'
2018-02-22 04:14:52,419 [salt.state       ][INFO    ][2104] System locale en_US.UTF-8 already set
2018-02-22 04:14:52,420 [salt.state       ][INFO    ][2104] Completed state [en_US.UTF-8] at time 04:14:52.420434 duration_in_ms=61.039
2018-02-22 04:14:52,423 [salt.state       ][INFO    ][2104] Running state [root] at time 04:14:52.423806
2018-02-22 04:14:52,424 [salt.state       ][INFO    ][2104] Executing state user.present for root
2018-02-22 04:14:52,431 [salt.state       ][INFO    ][2104] User root is present and up to date
2018-02-22 04:14:52,431 [salt.state       ][INFO    ][2104] Completed state [root] at time 04:14:52.431765 duration_in_ms=7.958
2018-02-22 04:14:52,433 [salt.state       ][INFO    ][2104] Running state [/root] at time 04:14:52.433777
2018-02-22 04:14:52,434 [salt.state       ][INFO    ][2104] Executing state file.directory for /root
2018-02-22 04:14:52,436 [salt.state       ][INFO    ][2104] Directory /root is in the correct state
2018-02-22 04:14:52,436 [salt.state       ][INFO    ][2104] Completed state [/root] at time 04:14:52.436328 duration_in_ms=2.551
2018-02-22 04:14:52,436 [salt.state       ][INFO    ][2104] Running state [/etc/sudoers.d/90-salt-user-root] at time 04:14:52.436740
2018-02-22 04:14:52,437 [salt.state       ][INFO    ][2104] Executing state file.absent for /etc/sudoers.d/90-salt-user-root
2018-02-22 04:14:52,437 [salt.state       ][INFO    ][2104] File /etc/sudoers.d/90-salt-user-root is not present
2018-02-22 04:14:52,437 [salt.state       ][INFO    ][2104] Completed state [/etc/sudoers.d/90-salt-user-root] at time 04:14:52.437932 duration_in_ms=1.192
2018-02-22 04:14:52,438 [salt.state       ][INFO    ][2104] Running state [ubuntu] at time 04:14:52.438328
2018-02-22 04:14:52,438 [salt.state       ][INFO    ][2104] Executing state user.present for ubuntu
2018-02-22 04:14:52,442 [salt.state       ][INFO    ][2104] {'passwd': 'XXX-REDACTED-XXX'}
2018-02-22 04:14:52,442 [salt.state       ][INFO    ][2104] Completed state [ubuntu] at time 04:14:52.442432 duration_in_ms=4.104
2018-02-22 04:14:52,443 [salt.state       ][INFO    ][2104] Running state [/home/ubuntu] at time 04:14:52.443572
2018-02-22 04:14:52,443 [salt.state       ][INFO    ][2104] Executing state file.directory for /home/ubuntu
2018-02-22 04:14:52,445 [salt.state       ][INFO    ][2104] {'mode': '0700'}
2018-02-22 04:14:52,446 [salt.state       ][INFO    ][2104] Completed state [/home/ubuntu] at time 04:14:52.446002 duration_in_ms=2.429
2018-02-22 04:14:52,446 [salt.state       ][INFO    ][2104] Running state [/etc/sudoers.d/90-salt-user-ubuntu] at time 04:14:52.446895
2018-02-22 04:14:52,448 [salt.state       ][INFO    ][2104] Executing state file.managed for /etc/sudoers.d/90-salt-user-ubuntu
2018-02-22 04:14:52,473 [salt.fileclient  ][INFO    ][2104] Fetching file from saltenv 'base', ** done ** 'linux/files/sudoer'
2018-02-22 04:14:52,480 [salt.loaded.int.module.cmdmod][INFO    ][2104] Executing command '/usr/sbin/visudo -c -f /tmp/tmpm82XLd' in directory '/root'
2018-02-22 04:14:52,504 [salt.state       ][INFO    ][2104] File changed:
New file
2018-02-22 04:14:52,505 [salt.state       ][INFO    ][2104] Completed state [/etc/sudoers.d/90-salt-user-ubuntu] at time 04:14:52.505792 duration_in_ms=58.897
2018-02-22 04:14:52,506 [salt.state       ][INFO    ][2104] Running state [/etc/security/limits.d/90-salt-default.conf] at time 04:14:52.506459
2018-02-22 04:14:52,507 [salt.state       ][INFO    ][2104] Executing state file.managed for /etc/security/limits.d/90-salt-default.conf
2018-02-22 04:14:52,540 [salt.fileclient  ][INFO    ][2104] Fetching file from saltenv 'base', ** done ** 'linux/files/limits.conf'
2018-02-22 04:14:52,637 [salt.state       ][INFO    ][2104] File changed:
New file
2018-02-22 04:14:52,638 [salt.state       ][INFO    ][2104] Completed state [/etc/security/limits.d/90-salt-default.conf] at time 04:14:52.638751 duration_in_ms=132.292
2018-02-22 04:14:52,639 [salt.state       ][INFO    ][2104] Running state [/etc/systemd/system.conf.d/90-salt.conf] at time 04:14:52.639267
2018-02-22 04:14:52,639 [salt.state       ][INFO    ][2104] Executing state file.managed for /etc/systemd/system.conf.d/90-salt.conf
2018-02-22 04:14:52,667 [salt.fileclient  ][INFO    ][2104] Fetching file from saltenv 'base', ** done ** 'linux/files/systemd.conf'
2018-02-22 04:14:52,772 [salt.state       ][INFO    ][2104] File changed:
New file
2018-02-22 04:14:52,773 [salt.state       ][INFO    ][2104] Completed state [/etc/systemd/system.conf.d/90-salt.conf] at time 04:14:52.773661 duration_in_ms=134.394
2018-02-22 04:14:52,775 [salt.state       ][INFO    ][2104] Running state [service.systemctl_reload] at time 04:14:52.775423
2018-02-22 04:14:52,775 [salt.state       ][INFO    ][2104] Executing state module.wait for service.systemctl_reload
2018-02-22 04:14:52,776 [salt.state       ][INFO    ][2104] No changes made for service.systemctl_reload
2018-02-22 04:14:52,776 [salt.state       ][INFO    ][2104] Completed state [service.systemctl_reload] at time 04:14:52.776622 duration_in_ms=1.199
2018-02-22 04:14:52,777 [salt.state       ][INFO    ][2104] Running state [service.systemctl_reload] at time 04:14:52.777338
2018-02-22 04:14:52,777 [salt.state       ][INFO    ][2104] Executing state module.mod_watch for service.systemctl_reload
2018-02-22 04:14:52,778 [salt.loaded.int.module.cmdmod][INFO    ][2104] Executing command ['systemctl', '--system', 'daemon-reload'] in directory '/root'
2018-02-22 04:14:52,869 [salt.state       ][INFO    ][2104] {'ret': True}
2018-02-22 04:14:52,871 [salt.state       ][INFO    ][2104] Completed state [service.systemctl_reload] at time 04:14:52.871384 duration_in_ms=94.046
2018-02-22 04:14:52,872 [salt.state       ][INFO    ][2104] Running state [/etc/hostname] at time 04:14:52.872325
2018-02-22 04:14:52,874 [salt.state       ][INFO    ][2104] Executing state file.managed for /etc/hostname
2018-02-22 04:14:52,904 [salt.fileclient  ][INFO    ][2104] Fetching file from saltenv 'base', ** done ** 'linux/files/hostname'
2018-02-22 04:14:52,912 [salt.state       ][INFO    ][2104] File changed:
--- 
+++ 
@@ -1 +1 @@
-ubuntu
+odl01

2018-02-22 04:14:52,914 [salt.state       ][INFO    ][2104] Completed state [/etc/hostname] at time 04:14:52.913968 duration_in_ms=41.643
2018-02-22 04:14:52,916 [salt.state       ][INFO    ][2104] Running state [hostname odl01] at time 04:14:52.916107
2018-02-22 04:14:52,916 [salt.state       ][INFO    ][2104] Executing state cmd.wait for hostname odl01
2018-02-22 04:14:52,917 [salt.state       ][INFO    ][2104] No changes made for hostname odl01
2018-02-22 04:14:52,917 [salt.state       ][INFO    ][2104] Completed state [hostname odl01] at time 04:14:52.917393 duration_in_ms=1.285
2018-02-22 04:14:52,918 [salt.state       ][INFO    ][2104] Running state [hostname odl01] at time 04:14:52.917780
2018-02-22 04:14:52,919 [salt.state       ][INFO    ][2104] Executing state cmd.mod_watch for hostname odl01
2018-02-22 04:14:52,920 [salt.loaded.int.module.cmdmod][INFO    ][2104] Executing command 'hostname odl01' in directory '/root'
2018-02-22 04:14:52,936 [salt.state       ][INFO    ][2104] {'pid': 4603, 'retcode': 0, 'stderr': '', 'stdout': ''}
2018-02-22 04:14:52,937 [salt.state       ][INFO    ][2104] Completed state [hostname odl01] at time 04:14:52.937891 duration_in_ms=20.111
2018-02-22 04:14:52,940 [salt.state       ][INFO    ][2104] Running state [mdb02] at time 04:14:52.940001
2018-02-22 04:14:52,940 [salt.state       ][INFO    ][2104] Executing state host.present for mdb02
2018-02-22 04:14:52,944 [salt.state       ][INFO    ][2104] {'host': 'mdb02'}
2018-02-22 04:14:52,944 [salt.state       ][INFO    ][2104] Completed state [mdb02] at time 04:14:52.944747 duration_in_ms=4.746
2018-02-22 04:14:52,946 [salt.state       ][INFO    ][2104] Running state [mdb02.mcp-pike-odl-ha.local] at time 04:14:52.946114
2018-02-22 04:14:52,946 [salt.state       ][INFO    ][2104] Executing state host.present for mdb02.mcp-pike-odl-ha.local
2018-02-22 04:14:52,947 [salt.state       ][INFO    ][2104] {'host': 'mdb02.mcp-pike-odl-ha.local'}
2018-02-22 04:14:52,948 [salt.state       ][INFO    ][2104] Completed state [mdb02.mcp-pike-odl-ha.local] at time 04:14:52.948838 duration_in_ms=2.724
2018-02-22 04:14:52,949 [salt.state       ][INFO    ][2104] Running state [mdb03] at time 04:14:52.949436
2018-02-22 04:14:52,949 [salt.state       ][INFO    ][2104] Executing state host.present for mdb03
2018-02-22 04:14:52,951 [salt.state       ][INFO    ][2104] {'host': 'mdb03'}
2018-02-22 04:14:52,952 [salt.state       ][INFO    ][2104] Completed state [mdb03] at time 04:14:52.952053 duration_in_ms=2.617
2018-02-22 04:14:52,953 [salt.state       ][INFO    ][2104] Running state [mdb03.mcp-pike-odl-ha.local] at time 04:14:52.953248
2018-02-22 04:14:52,953 [salt.state       ][INFO    ][2104] Executing state host.present for mdb03.mcp-pike-odl-ha.local
2018-02-22 04:14:52,955 [salt.state       ][INFO    ][2104] {'host': 'mdb03.mcp-pike-odl-ha.local'}
2018-02-22 04:14:52,956 [salt.state       ][INFO    ][2104] Completed state [mdb03.mcp-pike-odl-ha.local] at time 04:14:52.956360 duration_in_ms=3.113
2018-02-22 04:14:52,958 [salt.state       ][INFO    ][2104] Running state [mdb01] at time 04:14:52.958223
2018-02-22 04:14:52,958 [salt.state       ][INFO    ][2104] Executing state host.present for mdb01
2018-02-22 04:14:52,959 [salt.state       ][INFO    ][2104] {'host': 'mdb01'}
2018-02-22 04:14:52,960 [salt.state       ][INFO    ][2104] Completed state [mdb01] at time 04:14:52.960106 duration_in_ms=1.883
2018-02-22 04:14:52,960 [salt.state       ][INFO    ][2104] Running state [mdb01.mcp-pike-odl-ha.local] at time 04:14:52.960542
2018-02-22 04:14:52,961 [salt.state       ][INFO    ][2104] Executing state host.present for mdb01.mcp-pike-odl-ha.local
2018-02-22 04:14:52,962 [salt.state       ][INFO    ][2104] {'host': 'mdb01.mcp-pike-odl-ha.local'}
2018-02-22 04:14:52,963 [salt.state       ][INFO    ][2104] Completed state [mdb01.mcp-pike-odl-ha.local] at time 04:14:52.963048 duration_in_ms=2.505
2018-02-22 04:14:52,963 [salt.state       ][INFO    ][2104] Running state [mdb] at time 04:14:52.963485
2018-02-22 04:14:52,963 [salt.state       ][INFO    ][2104] Executing state host.present for mdb
2018-02-22 04:14:52,965 [salt.state       ][INFO    ][2104] {'host': 'mdb'}
2018-02-22 04:14:52,965 [salt.state       ][INFO    ][2104] Completed state [mdb] at time 04:14:52.965904 duration_in_ms=2.419
2018-02-22 04:14:52,966 [salt.state       ][INFO    ][2104] Running state [mdb.mcp-pike-odl-ha.local] at time 04:14:52.966340
2018-02-22 04:14:52,966 [salt.state       ][INFO    ][2104] Executing state host.present for mdb.mcp-pike-odl-ha.local
2018-02-22 04:14:52,968 [salt.state       ][INFO    ][2104] {'host': 'mdb.mcp-pike-odl-ha.local'}
2018-02-22 04:14:52,968 [salt.state       ][INFO    ][2104] Completed state [mdb.mcp-pike-odl-ha.local] at time 04:14:52.968486 duration_in_ms=2.146
2018-02-22 04:14:52,969 [salt.state       ][INFO    ][2104] Running state [cfg01] at time 04:14:52.969479
2018-02-22 04:14:52,970 [salt.state       ][INFO    ][2104] Executing state host.present for cfg01
2018-02-22 04:14:52,971 [salt.state       ][INFO    ][2104] {'host': 'cfg01'}
2018-02-22 04:14:52,971 [salt.state       ][INFO    ][2104] Completed state [cfg01] at time 04:14:52.971899 duration_in_ms=2.42
2018-02-22 04:14:52,972 [salt.state       ][INFO    ][2104] Running state [cfg01.mcp-pike-odl-ha.local] at time 04:14:52.972326
2018-02-22 04:14:52,973 [salt.state       ][INFO    ][2104] Executing state host.present for cfg01.mcp-pike-odl-ha.local
2018-02-22 04:14:52,974 [salt.state       ][INFO    ][2104] {'host': 'cfg01.mcp-pike-odl-ha.local'}
2018-02-22 04:14:52,974 [salt.state       ][INFO    ][2104] Completed state [cfg01.mcp-pike-odl-ha.local] at time 04:14:52.974801 duration_in_ms=2.475
2018-02-22 04:14:52,975 [salt.state       ][INFO    ][2104] Running state [prx01] at time 04:14:52.975583
2018-02-22 04:14:52,976 [salt.state       ][INFO    ][2104] Executing state host.present for prx01
2018-02-22 04:14:52,977 [salt.state       ][INFO    ][2104] {'host': 'prx01'}
2018-02-22 04:14:52,978 [salt.state       ][INFO    ][2104] Completed state [prx01] at time 04:14:52.978375 duration_in_ms=2.792
2018-02-22 04:14:52,978 [salt.state       ][INFO    ][2104] Running state [prx01.mcp-pike-odl-ha.local] at time 04:14:52.978830
2018-02-22 04:14:52,979 [salt.state       ][INFO    ][2104] Executing state host.present for prx01.mcp-pike-odl-ha.local
2018-02-22 04:14:52,980 [salt.state       ][INFO    ][2104] {'host': 'prx01.mcp-pike-odl-ha.local'}
2018-02-22 04:14:52,981 [salt.state       ][INFO    ][2104] Completed state [prx01.mcp-pike-odl-ha.local] at time 04:14:52.981623 duration_in_ms=2.793
2018-02-22 04:14:52,982 [salt.state       ][INFO    ][2104] Running state [kvm01] at time 04:14:52.982057
2018-02-22 04:14:52,982 [salt.state       ][INFO    ][2104] Executing state host.present for kvm01
2018-02-22 04:14:52,983 [salt.state       ][INFO    ][2104] {'host': 'kvm01'}
2018-02-22 04:14:52,984 [salt.state       ][INFO    ][2104] Completed state [kvm01] at time 04:14:52.984219 duration_in_ms=2.163
2018-02-22 04:14:52,984 [salt.state       ][INFO    ][2104] Running state [kvm01.mcp-pike-odl-ha.local] at time 04:14:52.984946
2018-02-22 04:14:52,985 [salt.state       ][INFO    ][2104] Executing state host.present for kvm01.mcp-pike-odl-ha.local
2018-02-22 04:14:52,986 [salt.state       ][INFO    ][2104] {'host': 'kvm01.mcp-pike-odl-ha.local'}
2018-02-22 04:14:52,987 [salt.state       ][INFO    ][2104] Completed state [kvm01.mcp-pike-odl-ha.local] at time 04:14:52.987111 duration_in_ms=2.165
2018-02-22 04:14:52,987 [salt.state       ][INFO    ][2104] Running state [kvm03] at time 04:14:52.987534
2018-02-22 04:14:52,987 [salt.state       ][INFO    ][2104] Executing state host.present for kvm03
2018-02-22 04:14:52,989 [salt.state       ][INFO    ][2104] {'host': 'kvm03'}
2018-02-22 04:14:52,990 [salt.state       ][INFO    ][2104] Completed state [kvm03] at time 04:14:52.990042 duration_in_ms=2.508
2018-02-22 04:14:52,990 [salt.state       ][INFO    ][2104] Running state [kvm03.mcp-pike-odl-ha.local] at time 04:14:52.990445
2018-02-22 04:14:52,990 [salt.state       ][INFO    ][2104] Executing state host.present for kvm03.mcp-pike-odl-ha.local
2018-02-22 04:14:52,997 [salt.state       ][INFO    ][2104] {'host': 'kvm03.mcp-pike-odl-ha.local'}
2018-02-22 04:14:52,997 [salt.state       ][INFO    ][2104] Completed state [kvm03.mcp-pike-odl-ha.local] at time 04:14:52.997607 duration_in_ms=7.162
2018-02-22 04:14:52,998 [salt.state       ][INFO    ][2104] Running state [kvm02] at time 04:14:52.998032
2018-02-22 04:14:52,998 [salt.state       ][INFO    ][2104] Executing state host.present for kvm02
2018-02-22 04:14:53,000 [salt.state       ][INFO    ][2104] {'host': 'kvm02'}
2018-02-22 04:14:53,000 [salt.state       ][INFO    ][2104] Completed state [kvm02] at time 04:14:53.000849 duration_in_ms=2.816
2018-02-22 04:14:53,001 [salt.state       ][INFO    ][2104] Running state [kvm02.mcp-pike-odl-ha.local] at time 04:14:53.001286
2018-02-22 04:14:53,001 [salt.state       ][INFO    ][2104] Executing state host.present for kvm02.mcp-pike-odl-ha.local
2018-02-22 04:14:53,003 [salt.state       ][INFO    ][2104] {'host': 'kvm02.mcp-pike-odl-ha.local'}
2018-02-22 04:14:53,003 [salt.state       ][INFO    ][2104] Completed state [kvm02.mcp-pike-odl-ha.local] at time 04:14:53.003414 duration_in_ms=2.128
2018-02-22 04:14:53,003 [salt.state       ][INFO    ][2104] Running state [dbs] at time 04:14:53.003843
2018-02-22 04:14:53,004 [salt.state       ][INFO    ][2104] Executing state host.present for dbs
2018-02-22 04:14:53,006 [salt.state       ][INFO    ][2104] {'host': 'dbs'}
2018-02-22 04:14:53,007 [salt.state       ][INFO    ][2104] Completed state [dbs] at time 04:14:53.007060 duration_in_ms=3.217
2018-02-22 04:14:53,008 [salt.state       ][INFO    ][2104] Running state [dbs.mcp-pike-odl-ha.local] at time 04:14:53.007744
2018-02-22 04:14:53,008 [salt.state       ][INFO    ][2104] Executing state host.present for dbs.mcp-pike-odl-ha.local
2018-02-22 04:14:53,009 [salt.state       ][INFO    ][2104] {'host': 'dbs.mcp-pike-odl-ha.local'}
2018-02-22 04:14:53,009 [salt.state       ][INFO    ][2104] Completed state [dbs.mcp-pike-odl-ha.local] at time 04:14:53.009847 duration_in_ms=2.103
2018-02-22 04:14:53,010 [salt.state       ][INFO    ][2104] Running state [prx] at time 04:14:53.010244
2018-02-22 04:14:53,010 [salt.state       ][INFO    ][2104] Executing state host.present for prx
2018-02-22 04:14:53,012 [salt.state       ][INFO    ][2104] {'host': 'prx'}
2018-02-22 04:14:53,012 [salt.state       ][INFO    ][2104] Completed state [prx] at time 04:14:53.012915 duration_in_ms=2.671
2018-02-22 04:14:53,013 [salt.state       ][INFO    ][2104] Running state [prx.mcp-pike-odl-ha.local] at time 04:14:53.013316
2018-02-22 04:14:53,013 [salt.state       ][INFO    ][2104] Executing state host.present for prx.mcp-pike-odl-ha.local
2018-02-22 04:14:53,014 [salt.state       ][INFO    ][2104] {'host': 'prx.mcp-pike-odl-ha.local'}
2018-02-22 04:14:53,015 [salt.state       ][INFO    ][2104] Completed state [prx.mcp-pike-odl-ha.local] at time 04:14:53.015433 duration_in_ms=2.116
2018-02-22 04:14:53,015 [salt.state       ][INFO    ][2104] Running state [prx02] at time 04:14:53.015868
2018-02-22 04:14:53,016 [salt.state       ][INFO    ][2104] Executing state host.present for prx02
2018-02-22 04:14:53,019 [salt.state       ][INFO    ][2104] {'host': 'prx02'}
2018-02-22 04:14:53,019 [salt.state       ][INFO    ][2104] Completed state [prx02] at time 04:14:53.019406 duration_in_ms=3.538
2018-02-22 04:14:53,019 [salt.state       ][INFO    ][2104] Running state [prx02.mcp-pike-odl-ha.local] at time 04:14:53.019830
2018-02-22 04:14:53,020 [salt.state       ][INFO    ][2104] Executing state host.present for prx02.mcp-pike-odl-ha.local
2018-02-22 04:14:53,021 [salt.state       ][INFO    ][2104] {'host': 'prx02.mcp-pike-odl-ha.local'}
2018-02-22 04:14:53,021 [salt.state       ][INFO    ][2104] Completed state [prx02.mcp-pike-odl-ha.local] at time 04:14:53.021720 duration_in_ms=1.891
2018-02-22 04:14:53,022 [salt.state       ][INFO    ][2104] Running state [msg02] at time 04:14:53.022409
2018-02-22 04:14:53,022 [salt.state       ][INFO    ][2104] Executing state host.present for msg02
2018-02-22 04:14:53,024 [salt.state       ][INFO    ][2104] {'host': 'msg02'}
2018-02-22 04:14:53,024 [salt.state       ][INFO    ][2104] Completed state [msg02] at time 04:14:53.024851 duration_in_ms=2.442
2018-02-22 04:14:53,025 [salt.state       ][INFO    ][2104] Running state [msg02.mcp-pike-odl-ha.local] at time 04:14:53.025254
2018-02-22 04:14:53,025 [salt.state       ][INFO    ][2104] Executing state host.present for msg02.mcp-pike-odl-ha.local
2018-02-22 04:14:53,026 [salt.state       ][INFO    ][2104] {'host': 'msg02.mcp-pike-odl-ha.local'}
2018-02-22 04:14:53,027 [salt.state       ][INFO    ][2104] Completed state [msg02.mcp-pike-odl-ha.local] at time 04:14:53.027027 duration_in_ms=1.774
2018-02-22 04:14:53,027 [salt.state       ][INFO    ][2104] Running state [msg03] at time 04:14:53.027427
2018-02-22 04:14:53,027 [salt.state       ][INFO    ][2104] Executing state host.present for msg03
2018-02-22 04:14:53,029 [salt.state       ][INFO    ][2104] {'host': 'msg03'}
2018-02-22 04:14:53,030 [salt.state       ][INFO    ][2104] Completed state [msg03] at time 04:14:53.030058 duration_in_ms=2.63
2018-02-22 04:14:53,031 [salt.state       ][INFO    ][2104] Running state [msg03.mcp-pike-odl-ha.local] at time 04:14:53.031820
2018-02-22 04:14:53,032 [salt.state       ][INFO    ][2104] Executing state host.present for msg03.mcp-pike-odl-ha.local
2018-02-22 04:14:53,033 [salt.state       ][INFO    ][2104] {'host': 'msg03.mcp-pike-odl-ha.local'}
2018-02-22 04:14:53,033 [salt.state       ][INFO    ][2104] Completed state [msg03.mcp-pike-odl-ha.local] at time 04:14:53.033754 duration_in_ms=1.934
2018-02-22 04:14:53,034 [salt.state       ][INFO    ][2104] Running state [msg01] at time 04:14:53.033990
2018-02-22 04:14:53,034 [salt.state       ][INFO    ][2104] Executing state host.present for msg01
2018-02-22 04:14:53,035 [salt.state       ][INFO    ][2104] {'host': 'msg01'}
2018-02-22 04:14:53,035 [salt.state       ][INFO    ][2104] Completed state [msg01] at time 04:14:53.035552 duration_in_ms=1.562
2018-02-22 04:14:53,035 [salt.state       ][INFO    ][2104] Running state [msg01.mcp-pike-odl-ha.local] at time 04:14:53.035781
2018-02-22 04:14:53,036 [salt.state       ][INFO    ][2104] Executing state host.present for msg01.mcp-pike-odl-ha.local
2018-02-22 04:14:53,037 [salt.state       ][INFO    ][2104] {'host': 'msg01.mcp-pike-odl-ha.local'}
2018-02-22 04:14:53,037 [salt.state       ][INFO    ][2104] Completed state [msg01.mcp-pike-odl-ha.local] at time 04:14:53.037418 duration_in_ms=1.637
2018-02-22 04:14:53,037 [salt.state       ][INFO    ][2104] Running state [msg] at time 04:14:53.037639
2018-02-22 04:14:53,037 [salt.state       ][INFO    ][2104] Executing state host.present for msg
2018-02-22 04:14:53,039 [salt.state       ][INFO    ][2104] {'host': 'msg'}
2018-02-22 04:14:53,039 [salt.state       ][INFO    ][2104] Completed state [msg] at time 04:14:53.039786 duration_in_ms=2.146
2018-02-22 04:14:53,040 [salt.state       ][INFO    ][2104] Running state [msg.mcp-pike-odl-ha.local] at time 04:14:53.040008
2018-02-22 04:14:53,040 [salt.state       ][INFO    ][2104] Executing state host.present for msg.mcp-pike-odl-ha.local
2018-02-22 04:14:53,042 [salt.state       ][INFO    ][2104] {'host': 'msg.mcp-pike-odl-ha.local'}
2018-02-22 04:14:53,042 [salt.state       ][INFO    ][2104] Completed state [msg.mcp-pike-odl-ha.local] at time 04:14:53.042460 duration_in_ms=2.452
2018-02-22 04:14:53,042 [salt.state       ][INFO    ][2104] Running state [cfg01] at time 04:14:53.042688
2018-02-22 04:14:53,042 [salt.state       ][INFO    ][2104] Executing state host.present for cfg01
2018-02-22 04:14:53,043 [salt.state       ][INFO    ][2104] Host cfg01 (192.168.10.100) already present
2018-02-22 04:14:53,043 [salt.state       ][INFO    ][2104] Completed state [cfg01] at time 04:14:53.043848 duration_in_ms=1.16
2018-02-22 04:14:53,044 [salt.state       ][INFO    ][2104] Running state [cfg01.mcp-pike-odl-ha.local] at time 04:14:53.044079
2018-02-22 04:14:53,044 [salt.state       ][INFO    ][2104] Executing state host.present for cfg01.mcp-pike-odl-ha.local
2018-02-22 04:14:53,046 [salt.state       ][INFO    ][2104] Host cfg01.mcp-pike-odl-ha.local (192.168.10.100) already present
2018-02-22 04:14:53,046 [salt.state       ][INFO    ][2104] Completed state [cfg01.mcp-pike-odl-ha.local] at time 04:14:53.046228 duration_in_ms=2.149
2018-02-22 04:14:53,046 [salt.state       ][INFO    ][2104] Running state [cmp002] at time 04:14:53.046435
2018-02-22 04:14:53,046 [salt.state       ][INFO    ][2104] Executing state host.present for cmp002
2018-02-22 04:14:53,046 [salt.minion      ][INFO    ][2013] User sudo_ubuntu Executing command saltutil.find_job with jid 20180222041454137622
2018-02-22 04:14:53,047 [salt.state       ][INFO    ][2104] {'host': 'cmp002'}
2018-02-22 04:14:53,047 [salt.state       ][INFO    ][2104] Completed state [cmp002] at time 04:14:53.047810 duration_in_ms=1.376
2018-02-22 04:14:53,048 [salt.state       ][INFO    ][2104] Running state [cmp002.mcp-pike-odl-ha.local] at time 04:14:53.048032
2018-02-22 04:14:53,048 [salt.state       ][INFO    ][2104] Executing state host.present for cmp002.mcp-pike-odl-ha.local
2018-02-22 04:14:53,050 [salt.state       ][INFO    ][2104] {'host': 'cmp002.mcp-pike-odl-ha.local'}
2018-02-22 04:14:53,050 [salt.state       ][INFO    ][2104] Completed state [cmp002.mcp-pike-odl-ha.local] at time 04:14:53.050514 duration_in_ms=2.482
2018-02-22 04:14:53,050 [salt.state       ][INFO    ][2104] Running state [cmp001] at time 04:14:53.050745
2018-02-22 04:14:53,051 [salt.state       ][INFO    ][2104] Executing state host.present for cmp001
2018-02-22 04:14:53,052 [salt.state       ][INFO    ][2104] {'host': 'cmp001'}
2018-02-22 04:14:53,053 [salt.state       ][INFO    ][2104] Completed state [cmp001] at time 04:14:53.052888 duration_in_ms=2.143
2018-02-22 04:14:53,054 [salt.state       ][INFO    ][2104] Running state [cmp001.mcp-pike-odl-ha.local] at time 04:14:53.054480
2018-02-22 04:14:53,054 [salt.state       ][INFO    ][2104] Executing state host.present for cmp001.mcp-pike-odl-ha.local
2018-02-22 04:14:53,055 [salt.state       ][INFO    ][2104] {'host': 'cmp001.mcp-pike-odl-ha.local'}
2018-02-22 04:14:53,055 [salt.state       ][INFO    ][2104] Completed state [cmp001.mcp-pike-odl-ha.local] at time 04:14:53.055906 duration_in_ms=1.427
2018-02-22 04:14:53,056 [salt.state       ][INFO    ][2104] Running state [dbs01] at time 04:14:53.056132
2018-02-22 04:14:53,057 [salt.state       ][INFO    ][2104] Executing state host.present for dbs01
2018-02-22 04:14:53,058 [salt.state       ][INFO    ][2104] {'host': 'dbs01'}
2018-02-22 04:14:53,058 [salt.state       ][INFO    ][2104] Completed state [dbs01] at time 04:14:53.058337 duration_in_ms=2.204
2018-02-22 04:14:53,058 [salt.state       ][INFO    ][2104] Running state [dbs01.mcp-pike-odl-ha.local] at time 04:14:53.058548
2018-02-22 04:14:53,058 [salt.state       ][INFO    ][2104] Executing state host.present for dbs01.mcp-pike-odl-ha.local
2018-02-22 04:14:53,062 [salt.state       ][INFO    ][2104] {'host': 'dbs01.mcp-pike-odl-ha.local'}
2018-02-22 04:14:53,062 [salt.state       ][INFO    ][2104] Completed state [dbs01.mcp-pike-odl-ha.local] at time 04:14:53.062436 duration_in_ms=3.888
2018-02-22 04:14:53,062 [salt.state       ][INFO    ][2104] Running state [dbs02] at time 04:14:53.062678
2018-02-22 04:14:53,062 [salt.state       ][INFO    ][2104] Executing state host.present for dbs02
2018-02-22 04:14:53,064 [salt.state       ][INFO    ][2104] {'host': 'dbs02'}
2018-02-22 04:14:53,064 [salt.state       ][INFO    ][2104] Completed state [dbs02] at time 04:14:53.064723 duration_in_ms=2.045
2018-02-22 04:14:53,066 [salt.state       ][INFO    ][2104] Running state [dbs02.mcp-pike-odl-ha.local] at time 04:14:53.065740
2018-02-22 04:14:53,066 [salt.state       ][INFO    ][2104] Executing state host.present for dbs02.mcp-pike-odl-ha.local
2018-02-22 04:14:53,067 [salt.state       ][INFO    ][2104] {'host': 'dbs02.mcp-pike-odl-ha.local'}
2018-02-22 04:14:53,067 [salt.state       ][INFO    ][2104] Completed state [dbs02.mcp-pike-odl-ha.local] at time 04:14:53.067454 duration_in_ms=1.714
2018-02-22 04:14:53,067 [salt.state       ][INFO    ][2104] Running state [dbs03] at time 04:14:53.067670
2018-02-22 04:14:53,067 [salt.state       ][INFO    ][2104] Executing state host.present for dbs03
2018-02-22 04:14:53,069 [salt.state       ][INFO    ][2104] {'host': 'dbs03'}
2018-02-22 04:14:53,069 [salt.state       ][INFO    ][2104] Completed state [dbs03] at time 04:14:53.069950 duration_in_ms=2.28
2018-02-22 04:14:53,070 [salt.state       ][INFO    ][2104] Running state [dbs03.mcp-pike-odl-ha.local] at time 04:14:53.070193
2018-02-22 04:14:53,070 [salt.state       ][INFO    ][2104] Executing state host.present for dbs03.mcp-pike-odl-ha.local
2018-02-22 04:14:53,071 [salt.state       ][INFO    ][2104] {'host': 'dbs03.mcp-pike-odl-ha.local'}
2018-02-22 04:14:53,072 [salt.state       ][INFO    ][2104] Completed state [dbs03.mcp-pike-odl-ha.local] at time 04:14:53.072434 duration_in_ms=2.241
2018-02-22 04:14:53,074 [salt.state       ][INFO    ][2104] Running state [odl01] at time 04:14:53.074116
2018-02-22 04:14:53,074 [salt.state       ][INFO    ][2104] Executing state host.present for odl01
2018-02-22 04:14:53,075 [salt.state       ][INFO    ][2104] {'host': 'odl01'}
2018-02-22 04:14:53,076 [salt.state       ][INFO    ][2104] Completed state [odl01] at time 04:14:53.076106 duration_in_ms=1.989
2018-02-22 04:14:53,076 [salt.state       ][INFO    ][2104] Running state [odl01.mcp-pike-odl-ha.local] at time 04:14:53.076425
2018-02-22 04:14:53,076 [salt.minion      ][INFO    ][4607] Starting a new job with PID 4607
2018-02-22 04:14:53,076 [salt.state       ][INFO    ][2104] Executing state host.present for odl01.mcp-pike-odl-ha.local
2018-02-22 04:14:53,078 [salt.state       ][INFO    ][2104] {'host': 'odl01.mcp-pike-odl-ha.local'}
2018-02-22 04:14:53,079 [salt.state       ][INFO    ][2104] Completed state [odl01.mcp-pike-odl-ha.local] at time 04:14:53.079194 duration_in_ms=2.77
2018-02-22 04:14:53,079 [salt.state       ][INFO    ][2104] Running state [mas01] at time 04:14:53.079532
2018-02-22 04:14:53,079 [salt.state       ][INFO    ][2104] Executing state host.present for mas01
2018-02-22 04:14:53,082 [salt.state       ][INFO    ][2104] {'host': 'mas01'}
2018-02-22 04:14:53,083 [salt.state       ][INFO    ][2104] Completed state [mas01] at time 04:14:53.083195 duration_in_ms=3.664
2018-02-22 04:14:53,083 [salt.state       ][INFO    ][2104] Running state [mas01.mcp-pike-odl-ha.local] at time 04:14:53.083510
2018-02-22 04:14:53,083 [salt.state       ][INFO    ][2104] Executing state host.present for mas01.mcp-pike-odl-ha.local
2018-02-22 04:14:53,086 [salt.state       ][INFO    ][2104] {'host': 'mas01.mcp-pike-odl-ha.local'}
2018-02-22 04:14:53,086 [salt.state       ][INFO    ][2104] Completed state [mas01.mcp-pike-odl-ha.local] at time 04:14:53.086760 duration_in_ms=3.25
2018-02-22 04:14:53,087 [salt.state       ][INFO    ][2104] Running state [ctl02] at time 04:14:53.087018
2018-02-22 04:14:53,087 [salt.state       ][INFO    ][2104] Executing state host.present for ctl02
2018-02-22 04:14:53,088 [salt.state       ][INFO    ][2104] {'host': 'ctl02'}
2018-02-22 04:14:53,088 [salt.state       ][INFO    ][2104] Completed state [ctl02] at time 04:14:53.088415 duration_in_ms=1.398
2018-02-22 04:14:53,088 [salt.state       ][INFO    ][2104] Running state [ctl02.mcp-pike-odl-ha.local] at time 04:14:53.088634
2018-02-22 04:14:53,088 [salt.state       ][INFO    ][2104] Executing state host.present for ctl02.mcp-pike-odl-ha.local
2018-02-22 04:14:53,090 [salt.state       ][INFO    ][2104] {'host': 'ctl02.mcp-pike-odl-ha.local'}
2018-02-22 04:14:53,090 [salt.state       ][INFO    ][2104] Completed state [ctl02.mcp-pike-odl-ha.local] at time 04:14:53.090573 duration_in_ms=1.939
2018-02-22 04:14:53,090 [salt.state       ][INFO    ][2104] Running state [ctl03] at time 04:14:53.090796
2018-02-22 04:14:53,091 [salt.state       ][INFO    ][2104] Executing state host.present for ctl03
2018-02-22 04:14:53,092 [salt.state       ][INFO    ][2104] {'host': 'ctl03'}
2018-02-22 04:14:53,092 [salt.state       ][INFO    ][2104] Completed state [ctl03] at time 04:14:53.092231 duration_in_ms=1.435
2018-02-22 04:14:53,092 [salt.state       ][INFO    ][2104] Running state [ctl03.mcp-pike-odl-ha.local] at time 04:14:53.092440
2018-02-22 04:14:53,092 [salt.state       ][INFO    ][2104] Executing state host.present for ctl03.mcp-pike-odl-ha.local
2018-02-22 04:14:53,094 [salt.state       ][INFO    ][2104] {'host': 'ctl03.mcp-pike-odl-ha.local'}
2018-02-22 04:14:53,094 [salt.state       ][INFO    ][2104] Completed state [ctl03.mcp-pike-odl-ha.local] at time 04:14:53.094720 duration_in_ms=2.279
2018-02-22 04:14:53,094 [salt.state       ][INFO    ][2104] Running state [ctl01] at time 04:14:53.094935
2018-02-22 04:14:53,095 [salt.state       ][INFO    ][2104] Executing state host.present for ctl01
2018-02-22 04:14:53,096 [salt.minion      ][INFO    ][4607] Returning information for job: 20180222041454137622
2018-02-22 04:14:53,096 [salt.state       ][INFO    ][2104] {'host': 'ctl01'}
2018-02-22 04:14:53,096 [salt.state       ][INFO    ][2104] Completed state [ctl01] at time 04:14:53.096374 duration_in_ms=1.439
2018-02-22 04:14:53,097 [salt.state       ][INFO    ][2104] Running state [ctl01.mcp-pike-odl-ha.local] at time 04:14:53.097156
2018-02-22 04:14:53,097 [salt.state       ][INFO    ][2104] Executing state host.present for ctl01.mcp-pike-odl-ha.local
2018-02-22 04:14:53,098 [salt.state       ][INFO    ][2104] {'host': 'ctl01.mcp-pike-odl-ha.local'}
2018-02-22 04:14:53,098 [salt.state       ][INFO    ][2104] Completed state [ctl01.mcp-pike-odl-ha.local] at time 04:14:53.098938 duration_in_ms=1.782
2018-02-22 04:14:53,099 [salt.state       ][INFO    ][2104] Running state [ctl] at time 04:14:53.099173
2018-02-22 04:14:53,099 [salt.state       ][INFO    ][2104] Executing state host.present for ctl
2018-02-22 04:14:53,103 [salt.state       ][INFO    ][2104] {'host': 'ctl'}
2018-02-22 04:14:53,103 [salt.state       ][INFO    ][2104] Completed state [ctl] at time 04:14:53.103498 duration_in_ms=4.327
2018-02-22 04:14:53,103 [salt.state       ][INFO    ][2104] Running state [ctl.mcp-pike-odl-ha.local] at time 04:14:53.103709
2018-02-22 04:14:53,103 [salt.state       ][INFO    ][2104] Executing state host.present for ctl.mcp-pike-odl-ha.local
2018-02-22 04:14:53,105 [salt.state       ][INFO    ][2104] {'host': 'ctl.mcp-pike-odl-ha.local'}
2018-02-22 04:14:53,105 [salt.state       ][INFO    ][2104] Completed state [ctl.mcp-pike-odl-ha.local] at time 04:14:53.105485 duration_in_ms=1.775
2018-02-22 04:14:53,105 [salt.state       ][INFO    ][2104] Running state [/etc/network/interfaces.d/50-cloud-init.cfg] at time 04:14:53.105701
2018-02-22 04:14:53,105 [salt.state       ][INFO    ][2104] Executing state file.absent for /etc/network/interfaces.d/50-cloud-init.cfg
2018-02-22 04:14:53,106 [salt.state       ][INFO    ][2104] {'removed': '/etc/network/interfaces.d/50-cloud-init.cfg'}
2018-02-22 04:14:53,106 [salt.state       ][INFO    ][2104] Completed state [/etc/network/interfaces.d/50-cloud-init.cfg] at time 04:14:53.106495 duration_in_ms=0.794
2018-02-22 04:14:53,115 [salt.state       ][INFO    ][2104] Running state [ens2] at time 04:14:53.115437
2018-02-22 04:14:53,115 [salt.state       ][INFO    ][2104] Executing state network.managed for ens2
2018-02-22 04:14:53,289 [salt.loaded.int.module.cmdmod][INFO    ][2104] Executing command ['ifdown', 'ens2'] in directory '/root'
2018-02-22 04:14:54,489 [salt.loaded.int.module.cmdmod][INFO    ][2104] Executing command ['ifup', 'ens2'] in directory '/root'
2018-02-22 04:14:55,737 [salt.state       ][INFO    ][2104] {'interface': 'Added network interface.', 'status': 'Interface ens2 restart to validate'}
2018-02-22 04:14:55,738 [salt.state       ][INFO    ][2104] Completed state [ens2] at time 04:14:55.738477 duration_in_ms=2623.04
2018-02-22 04:14:55,738 [salt.state       ][INFO    ][2104] Running state [ens3] at time 04:14:55.738898
2018-02-22 04:14:55,739 [salt.state       ][INFO    ][2104] Executing state network.managed for ens3
2018-02-22 04:14:55,768 [salt.loaded.int.module.cmdmod][INFO    ][2104] Executing command ['ifup', 'ens3'] in directory '/root'
2018-02-22 04:14:56,402 [salt.state       ][INFO    ][2104] {'interface': 'Added network interface.', 'status': 'Interface ens3 is up'}
2018-02-22 04:14:56,403 [salt.state       ][INFO    ][2104] Completed state [ens3] at time 04:14:56.403137 duration_in_ms=664.238
2018-02-22 04:14:56,403 [salt.state       ][INFO    ][2104] Running state [/etc/profile.d/proxy.sh] at time 04:14:56.403467
2018-02-22 04:14:56,403 [salt.state       ][INFO    ][2104] Executing state file.absent for /etc/profile.d/proxy.sh
2018-02-22 04:14:56,404 [salt.state       ][INFO    ][2104] File /etc/profile.d/proxy.sh is not present
2018-02-22 04:14:56,404 [salt.state       ][INFO    ][2104] Completed state [/etc/profile.d/proxy.sh] at time 04:14:56.404761 duration_in_ms=1.296
2018-02-22 04:14:56,405 [salt.state       ][INFO    ][2104] Running state [/etc/apt/apt.conf.d/95proxies] at time 04:14:56.404985
2018-02-22 04:14:56,405 [salt.state       ][INFO    ][2104] Executing state file.absent for /etc/apt/apt.conf.d/95proxies
2018-02-22 04:14:56,405 [salt.state       ][INFO    ][2104] File /etc/apt/apt.conf.d/95proxies is not present
2018-02-22 04:14:56,405 [salt.state       ][INFO    ][2104] Completed state [/etc/apt/apt.conf.d/95proxies] at time 04:14:56.405621 duration_in_ms=0.637
2018-02-22 04:14:56,407 [salt.state       ][INFO    ][2104] Running state [ntp] at time 04:14:56.407033
2018-02-22 04:14:56,407 [salt.state       ][INFO    ][2104] Executing state pkg.installed for ntp
2018-02-22 04:14:56,547 [salt.loaded.int.module.cmdmod][INFO    ][2104] Executing command ['dpkg', '--get-selections', '*'] in directory '/root'
2018-02-22 04:14:56,579 [salt.loaded.int.module.cmdmod][INFO    ][2104] 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-02-22 04:15:00,150 [salt.loaded.int.module.cmdmod][INFO    ][2104] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2018-02-22 04:15:00,212 [salt.state       ][INFO    ][2104] Made the following changes:
'ntp' changed from 'absent' to '1:4.2.8p4+dfsg-3ubuntu5.7'
'libopts25' changed from 'absent' to '1:5.18.7-3'

2018-02-22 04:15:00,232 [salt.state       ][INFO    ][2104] Loading fresh modules for state activity
2018-02-22 04:15:00,261 [salt.state       ][INFO    ][2104] Completed state [ntp] at time 04:15:00.261933 duration_in_ms=3854.898
2018-02-22 04:15:00,266 [salt.state       ][INFO    ][2104] Running state [/etc/ntp.conf] at time 04:15:00.266676
2018-02-22 04:15:00,267 [salt.state       ][INFO    ][2104] Executing state file.managed for /etc/ntp.conf
2018-02-22 04:15:00,303 [salt.fileclient  ][INFO    ][2104] Fetching file from saltenv 'base', ** done ** 'ntp/files/ntp.conf'
2018-02-22 04:15:00,369 [salt.state       ][INFO    ][2104] File changed:
--- 
+++ 
@@ -1,66 +1,24 @@
-# /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
-
-# 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 default noquery nopeer
 restrict 127.0.0.1
 restrict ::1
 
-# Needed for adding pool entries
-restrict source notrap nomodify noquery
-
-# Clients from this (example!) subnet have unlimited access, but only if
-# cryptographically authenticated.
-#restrict 192.168.123.0 mask 255.255.255.0 notrust
+# mode7 is required for collectd monitoring
 
 
-# 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-02-22 04:15:00,369 [salt.state       ][INFO    ][2104] Completed state [/etc/ntp.conf] at time 04:15:00.369808 duration_in_ms=103.131
2018-02-22 04:15:00,761 [salt.state       ][INFO    ][2104] Running state [ntp] at time 04:15:00.761468
2018-02-22 04:15:00,761 [salt.state       ][INFO    ][2104] Executing state service.running for ntp
2018-02-22 04:15:00,764 [salt.loaded.int.module.cmdmod][INFO    ][2104] Executing command ['systemctl', 'status', 'ntp.service', '-n', '0'] in directory '/root'
2018-02-22 04:15:00,780 [salt.loaded.int.module.cmdmod][INFO    ][2104] Executing command ['systemctl', 'is-active', 'ntp.service'] in directory '/root'
2018-02-22 04:15:00,793 [salt.loaded.int.module.cmdmod][INFO    ][2104] Executing command ['systemctl', 'is-enabled', 'ntp.service'] in directory '/root'
2018-02-22 04:15:00,810 [salt.state       ][INFO    ][2104] The service ntp is already running
2018-02-22 04:15:00,810 [salt.state       ][INFO    ][2104] Completed state [ntp] at time 04:15:00.810717 duration_in_ms=49.25
2018-02-22 04:15:00,811 [salt.state       ][INFO    ][2104] Running state [ntp] at time 04:15:00.811022
2018-02-22 04:15:00,811 [salt.state       ][INFO    ][2104] Executing state service.mod_watch for ntp
2018-02-22 04:15:00,812 [salt.loaded.int.module.cmdmod][INFO    ][2104] Executing command ['systemctl', 'is-active', 'ntp.service'] in directory '/root'
2018-02-22 04:15:00,827 [salt.loaded.int.module.cmdmod][INFO    ][2104] Executing command ['systemctl', 'is-enabled', 'ntp.service'] in directory '/root'
2018-02-22 04:15:00,846 [salt.loaded.int.module.cmdmod][INFO    ][2104] Executing command ['systemd-run', '--scope', 'systemctl', 'restart', 'ntp.service'] in directory '/root'
2018-02-22 04:15:00,966 [salt.state       ][INFO    ][2104] {'ntp': True}
2018-02-22 04:15:00,966 [salt.state       ][INFO    ][2104] Completed state [ntp] at time 04:15:00.966781 duration_in_ms=155.758
2018-02-22 04:15:00,977 [salt.minion      ][INFO    ][2104] Returning information for job: 20180222041423961567
2018-02-22 04:15:11,189 [salt.minion      ][INFO    ][2013] User sudo_ubuntu Executing command ssh.set_auth_key with jid 20180222041512280706
2018-02-22 04:15:11,214 [salt.minion      ][INFO    ][5694] Starting a new job with PID 5694
2018-02-22 04:15:11,239 [salt.loader.192.168.11.2.int.module.ssh][WARNING ][5694] Public Key hashing currently defaults to "md5". This will change to "sha256" in the Nitrogen release.
2018-02-22 04:15:11,244 [salt.minion      ][INFO    ][5694] Returning information for job: 20180222041512280706
2018-02-22 04:15:34,325 [salt.minion      ][INFO    ][2013] User sudo_ubuntu Executing command pkg.upgrade with jid 20180222041535415255
2018-02-22 04:15:34,356 [salt.minion      ][INFO    ][5706] Starting a new job with PID 5706
2018-02-22 04:15:34,383 [salt.loader.192.168.11.2.int.module.cmdmod][INFO    ][5706] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2018-02-22 04:15:34,709 [salt.loader.192.168.11.2.int.module.cmdmod][INFO    ][5706] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'upgrade'] in directory '/root'
2018-02-22 04:15:43,833 [salt.loader.192.168.11.2.int.module.cmdmod][INFO    ][5706] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2018-02-22 04:15:43,875 [salt.minion      ][INFO    ][5706] Returning information for job: 20180222041535415255
2018-02-22 04:15:47,783 [salt.minion      ][INFO    ][2013] User sudo_ubuntu Executing command service.mask with jid 20180222041548874559
2018-02-22 04:15:47,808 [salt.minion      ][INFO    ][6613] Starting a new job with PID 6613
2018-02-22 04:15:48,144 [salt.loader.192.168.11.2.int.module.cmdmod][INFO    ][6613] Executing command ['systemctl', 'status', 'opendaylight.service', '-n', '0'] in directory '/root'
2018-02-22 04:15:48,186 [salt.loader.192.168.11.2.int.module.cmdmod][INFO    ][6613] Executing command ['systemd-run', '--scope', 'systemctl', 'mask', 'opendaylight.service'] in directory '/root'
2018-02-22 04:15:48,301 [salt.minion      ][INFO    ][6613] Returning information for job: 20180222041548874559
2018-02-22 04:15:49,043 [salt.minion      ][INFO    ][2013] User sudo_ubuntu Executing command state.sls with jid 20180222041550134482
2018-02-22 04:15:49,065 [salt.minion      ][INFO    ][6638] Starting a new job with PID 6638
2018-02-22 04:15:51,307 [salt.state       ][INFO    ][6638] Loading fresh modules for state activity
2018-02-22 04:15:51,372 [salt.fileclient  ][INFO    ][6638] Fetching file from saltenv 'base', ** done ** 'opendaylight/init.sls'
2018-02-22 04:15:51,416 [salt.fileclient  ][INFO    ][6638] Fetching file from saltenv 'base', ** done ** 'opendaylight/server.sls'
2018-02-22 04:15:51,471 [salt.fileclient  ][INFO    ][6638] Fetching file from saltenv 'base', ** done ** 'opendaylight/map.jinja'
2018-02-22 04:15:51,569 [salt.state       ][INFO    ][6638] Running state [apt-key adv --keyserver keyserver.ubuntu.com --recv 44C05248] at time 04:15:51.569789
2018-02-22 04:15:51,570 [salt.state       ][INFO    ][6638] Executing state cmd.run for apt-key adv --keyserver keyserver.ubuntu.com --recv 44C05248
2018-02-22 04:15:51,571 [salt.loaded.int.module.cmdmod][INFO    ][6638] Executing command 'apt-key adv --keyserver keyserver.ubuntu.com --recv 44C05248' in directory '/root'
2018-02-22 04:15:51,893 [salt.state       ][INFO    ][6638] {'pid': 6645, '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.DFa7VFAAWr/gpg.1.sh --keyserver\nkeyserver.ubuntu.com\n--recv\n44C05248'}
2018-02-22 04:15:51,894 [salt.state       ][INFO    ][6638] Completed state [apt-key adv --keyserver keyserver.ubuntu.com --recv 44C05248] at time 04:15:51.894309 duration_in_ms=324.519
2018-02-22 04:15:51,917 [salt.state       ][INFO    ][6638] Running state [deb http://ppa.launchpad.net/odl-team/nitrogen/ubuntu xenial main] at time 04:15:51.916894
2018-02-22 04:15:51,917 [salt.state       ][INFO    ][6638] Executing state pkgrepo.managed for deb http://ppa.launchpad.net/odl-team/nitrogen/ubuntu xenial main
2018-02-22 04:15:51,991 [salt.loaded.int.module.cmdmod][INFO    ][6638] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2018-02-22 04:15:59,155 [salt.minion      ][INFO    ][2013] User sudo_ubuntu Executing command saltutil.find_job with jid 20180222041600242653
2018-02-22 04:15:59,176 [salt.minion      ][INFO    ][6966] Starting a new job with PID 6966
2018-02-22 04:15:59,195 [salt.minion      ][INFO    ][6966] Returning information for job: 20180222041600242653
2018-02-22 04:16:09,008 [salt.state       ][INFO    ][6638] {'repo': 'deb http://ppa.launchpad.net/odl-team/nitrogen/ubuntu xenial main'}
2018-02-22 04:16:09,009 [salt.state       ][INFO    ][6638] Completed state [deb http://ppa.launchpad.net/odl-team/nitrogen/ubuntu xenial main] at time 04:16:09.009567 duration_in_ms=17092.672
2018-02-22 04:16:09,188 [salt.minion      ][INFO    ][2013] User sudo_ubuntu Executing command saltutil.find_job with jid 20180222041610273686
2018-02-22 04:16:09,210 [salt.minion      ][INFO    ][7127] Starting a new job with PID 7127
2018-02-22 04:16:09,228 [salt.minion      ][INFO    ][7127] Returning information for job: 20180222041610273686
2018-02-22 04:16:09,447 [salt.state       ][INFO    ][6638] Running state [opendaylight] at time 04:16:09.447226
2018-02-22 04:16:09,447 [salt.state       ][INFO    ][6638] Executing state pkg.installed for opendaylight
2018-02-22 04:16:09,448 [salt.loaded.int.module.cmdmod][INFO    ][6638] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2018-02-22 04:16:09,800 [salt.loaded.int.module.cmdmod][INFO    ][6638] Executing command ['apt-cache', '-q', 'policy', 'opendaylight'] in directory '/root'
2018-02-22 04:16:09,904 [salt.loaded.int.module.cmdmod][INFO    ][6638] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2018-02-22 04:16:11,692 [salt.loaded.int.module.cmdmod][INFO    ][6638] Executing command ['dpkg', '--get-selections', '*'] in directory '/root'
2018-02-22 04:16:11,731 [salt.loaded.int.module.cmdmod][INFO    ][6638] 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-02-22 04:16:19,417 [salt.minion      ][INFO    ][2013] User sudo_ubuntu Executing command saltutil.find_job with jid 20180222041620507720
2018-02-22 04:16:19,444 [salt.minion      ][INFO    ][7482] Starting a new job with PID 7482
2018-02-22 04:16:19,462 [salt.minion      ][INFO    ][7482] Returning information for job: 20180222041620507720
2018-02-22 04:16:29,451 [salt.minion      ][INFO    ][2013] User sudo_ubuntu Executing command saltutil.find_job with jid 20180222041630538503
2018-02-22 04:16:29,474 [salt.minion      ][INFO    ][7487] Starting a new job with PID 7487
2018-02-22 04:16:29,493 [salt.minion      ][INFO    ][7487] Returning information for job: 20180222041630538503
2018-02-22 04:16:39,481 [salt.minion      ][INFO    ][2013] User sudo_ubuntu Executing command saltutil.find_job with jid 20180222041640564470
2018-02-22 04:16:39,507 [salt.minion      ][INFO    ][7492] Starting a new job with PID 7492
2018-02-22 04:16:39,524 [salt.minion      ][INFO    ][7492] Returning information for job: 20180222041640564470
2018-02-22 04:16:49,509 [salt.minion      ][INFO    ][2013] User sudo_ubuntu Executing command saltutil.find_job with jid 20180222041650595899
2018-02-22 04:16:49,531 [salt.minion      ][INFO    ][7497] Starting a new job with PID 7497
2018-02-22 04:16:49,548 [salt.minion      ][INFO    ][7497] Returning information for job: 20180222041650595899
2018-02-22 04:16:59,530 [salt.minion      ][INFO    ][2013] User sudo_ubuntu Executing command saltutil.find_job with jid 20180222041700618057
2018-02-22 04:16:59,553 [salt.minion      ][INFO    ][7502] Starting a new job with PID 7502
2018-02-22 04:16:59,573 [salt.minion      ][INFO    ][7502] Returning information for job: 20180222041700618057
2018-02-22 04:17:09,554 [salt.minion      ][INFO    ][2013] User sudo_ubuntu Executing command saltutil.find_job with jid 20180222041710643624
2018-02-22 04:17:09,577 [salt.minion      ][INFO    ][7510] Starting a new job with PID 7510
2018-02-22 04:17:09,597 [salt.minion      ][INFO    ][7510] Returning information for job: 20180222041710643624
2018-02-22 04:17:19,580 [salt.minion      ][INFO    ][2013] User sudo_ubuntu Executing command saltutil.find_job with jid 20180222041720670449
2018-02-22 04:17:19,603 [salt.minion      ][INFO    ][7515] Starting a new job with PID 7515
2018-02-22 04:17:19,622 [salt.minion      ][INFO    ][7515] Returning information for job: 20180222041720670449
2018-02-22 04:17:29,611 [salt.minion      ][INFO    ][2013] User sudo_ubuntu Executing command saltutil.find_job with jid 20180222041730699831
2018-02-22 04:17:29,638 [salt.minion      ][INFO    ][7520] Starting a new job with PID 7520
2018-02-22 04:17:29,668 [salt.minion      ][INFO    ][7520] Returning information for job: 20180222041730699831
2018-02-22 04:17:39,667 [salt.minion      ][INFO    ][2013] User sudo_ubuntu Executing command saltutil.find_job with jid 20180222041740752275
2018-02-22 04:17:39,695 [salt.minion      ][INFO    ][7525] Starting a new job with PID 7525
2018-02-22 04:17:39,712 [salt.minion      ][INFO    ][7525] Returning information for job: 20180222041740752275
2018-02-22 04:17:49,714 [salt.minion      ][INFO    ][2013] User sudo_ubuntu Executing command saltutil.find_job with jid 20180222041750800411
2018-02-22 04:17:49,740 [salt.minion      ][INFO    ][7530] Starting a new job with PID 7530
2018-02-22 04:17:49,759 [salt.minion      ][INFO    ][7530] Returning information for job: 20180222041750800411
2018-02-22 04:17:59,758 [salt.minion      ][INFO    ][2013] User sudo_ubuntu Executing command saltutil.find_job with jid 20180222041800843916
2018-02-22 04:17:59,782 [salt.minion      ][INFO    ][7535] Starting a new job with PID 7535
2018-02-22 04:17:59,799 [salt.minion      ][INFO    ][7535] Returning information for job: 20180222041800843916
2018-02-22 04:18:09,805 [salt.minion      ][INFO    ][2013] User sudo_ubuntu Executing command saltutil.find_job with jid 20180222041810894882
2018-02-22 04:18:09,827 [salt.minion      ][INFO    ][7540] Starting a new job with PID 7540
2018-02-22 04:18:09,847 [salt.minion      ][INFO    ][7540] Returning information for job: 20180222041810894882
2018-02-22 04:18:19,848 [salt.minion      ][INFO    ][2013] User sudo_ubuntu Executing command saltutil.find_job with jid 20180222041820939925
2018-02-22 04:18:19,874 [salt.minion      ][INFO    ][7545] Starting a new job with PID 7545
2018-02-22 04:18:19,894 [salt.minion      ][INFO    ][7545] Returning information for job: 20180222041820939925
2018-02-22 04:18:29,898 [salt.minion      ][INFO    ][2013] User sudo_ubuntu Executing command saltutil.find_job with jid 20180222041830989892
2018-02-22 04:18:29,923 [salt.minion      ][INFO    ][7550] Starting a new job with PID 7550
2018-02-22 04:18:29,941 [salt.minion      ][INFO    ][7550] Returning information for job: 20180222041830989892
2018-02-22 04:18:39,935 [salt.minion      ][INFO    ][2013] User sudo_ubuntu Executing command saltutil.find_job with jid 20180222041841026445
2018-02-22 04:18:39,958 [salt.minion      ][INFO    ][7555] Starting a new job with PID 7555
2018-02-22 04:18:39,978 [salt.minion      ][INFO    ][7555] Returning information for job: 20180222041841026445
2018-02-22 04:18:49,976 [salt.minion      ][INFO    ][2013] User sudo_ubuntu Executing command saltutil.find_job with jid 20180222041851064135
2018-02-22 04:18:49,996 [salt.minion      ][INFO    ][7560] Starting a new job with PID 7560
2018-02-22 04:18:50,016 [salt.minion      ][INFO    ][7560] Returning information for job: 20180222041851064135
2018-02-22 04:19:00,025 [salt.minion      ][INFO    ][2013] User sudo_ubuntu Executing command saltutil.find_job with jid 20180222041901114841
2018-02-22 04:19:00,051 [salt.minion      ][INFO    ][7565] Starting a new job with PID 7565
2018-02-22 04:19:00,069 [salt.minion      ][INFO    ][7565] Returning information for job: 20180222041901114841
2018-02-22 04:19:10,080 [salt.minion      ][INFO    ][2013] User sudo_ubuntu Executing command saltutil.find_job with jid 20180222041911169115
2018-02-22 04:19:10,102 [salt.minion      ][INFO    ][7653] Starting a new job with PID 7653
2018-02-22 04:19:10,120 [salt.minion      ][INFO    ][7653] Returning information for job: 20180222041911169115
2018-02-22 04:19:20,131 [salt.minion      ][INFO    ][2013] User sudo_ubuntu Executing command saltutil.find_job with jid 20180222041921214898
2018-02-22 04:19:20,155 [salt.minion      ][INFO    ][7658] Starting a new job with PID 7658
2018-02-22 04:19:20,173 [salt.minion      ][INFO    ][7658] Returning information for job: 20180222041921214898
2018-02-22 04:19:30,203 [salt.minion      ][INFO    ][2013] User sudo_ubuntu Executing command saltutil.find_job with jid 20180222041931291238
2018-02-22 04:19:30,225 [salt.minion      ][INFO    ][7663] Starting a new job with PID 7663
2018-02-22 04:19:30,245 [salt.minion      ][INFO    ][7663] Returning information for job: 20180222041931291238
2018-02-22 04:19:30,387 [salt.loaded.int.module.cmdmod][ERROR   ][6638] Command '['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'opendaylight']' failed with return code: 100
2018-02-22 04:19:30,388 [salt.loaded.int.module.cmdmod][ERROR   ][6638] stdout: Reading package lists...
Building dependency tree...
Reading state information...
The following additional packages will be installed:
  ca-certificates-java fontconfig-config fonts-dejavu-core java-common
  libavahi-client3 libavahi-common-data libavahi-common3 libcups2
  libfontconfig1 libjpeg-turbo8 libjpeg8 liblcms2-2 libnspr4 libnss3
  libnss3-nssdb libpcsclite1 libxi6 libxrender1 libxtst6
  openjdk-8-jre-headless x11-common
Suggested packages:
  default-jre cups-common liblcms2-utils pcscd libnss-mdns fonts-dejavu-extra
  fonts-ipafont-gothic fonts-ipafont-mincho fonts-wqy-microhei
  fonts-wqy-zenhei fonts-indic
The following NEW packages will be installed:
  ca-certificates-java fontconfig-config fonts-dejavu-core java-common
  libavahi-client3 libavahi-common-data libavahi-common3 libcups2
  libfontconfig1 libjpeg-turbo8 libjpeg8 liblcms2-2 libnspr4 libnss3
  libnss3-nssdb libpcsclite1 libxi6 libxrender1 libxtst6 opendaylight
  openjdk-8-jre-headless x11-common
0 upgraded, 22 newly installed, 0 to remove and 11 not upgraded.
Need to get 328 MB of archives.
After this operation, 494 MB of additional disk space will be used.
Get:1 http://archive.ubuntu.com/ubuntu xenial/main amd64 libjpeg-turbo8 amd64 1.4.2-0ubuntu3 [111 kB]
Get:2 http://archive.ubuntu.com/ubuntu xenial/main amd64 liblcms2-2 amd64 2.6-3ubuntu2 [137 kB]
Get:3 http://ppa.launchpad.net/odl-team/nitrogen/ubuntu xenial/main amd64 opendaylight all 7.1.0-1ppa3 [298 MB]
Get:4 http://archive.ubuntu.com/ubuntu xenial/main amd64 x11-common all 1:7.7+13ubuntu3 [22.4 kB]
Get:5 http://archive.ubuntu.com/ubuntu xenial/main amd64 libxtst6 amd64 2:1.2.2-1 [14.1 kB]
Get:6 http://archive.ubuntu.com/ubuntu xenial/main amd64 java-common all 0.56ubuntu2 [7742 B]
Get:7 http://archive.ubuntu.com/ubuntu xenial/main amd64 libavahi-common-data amd64 0.6.32~rc+dfsg-1ubuntu2 [21.7 kB]
Get:8 http://archive.ubuntu.com/ubuntu xenial/main amd64 libavahi-common3 amd64 0.6.32~rc+dfsg-1ubuntu2 [21.6 kB]
Get:9 http://archive.ubuntu.com/ubuntu xenial/main amd64 libavahi-client3 amd64 0.6.32~rc+dfsg-1ubuntu2 [25.1 kB]
Get:10 http://archive.ubuntu.com/ubuntu xenial-updates/main amd64 libcups2 amd64 2.1.3-4ubuntu0.4 [197 kB]
Get:11 http://archive.ubuntu.com/ubuntu xenial/main amd64 libjpeg8 amd64 8c-2ubuntu8 [2194 B]
Get:12 http://archive.ubuntu.com/ubuntu xenial/main amd64 fonts-dejavu-core all 2.35-1 [1039 kB]
Get:13 http://archive.ubuntu.com/ubuntu xenial-updates/main amd64 fontconfig-config all 2.11.94-0ubuntu1.1 [49.9 kB]
Get:14 http://archive.ubuntu.com/ubuntu xenial-updates/main amd64 libfontconfig1 amd64 2.11.94-0ubuntu1.1 [131 kB]
Get:15 http://archive.ubuntu.com/ubuntu xenial-updates/main amd64 libnspr4 amd64 2:4.13.1-0ubuntu0.16.04.1 [112 kB]
Get:16 http://archive.ubuntu.com/ubuntu xenial-updates/main amd64 libnss3-nssdb all 2:3.28.4-0ubuntu0.16.04.3 [10.6 kB]
Get:17 http://archive.ubuntu.com/ubuntu xenial-updates/main amd64 libnss3 amd64 2:3.28.4-0ubuntu0.16.04.3 [1148 kB]
Get:18 http://archive.ubuntu.com/ubuntu xenial-updates/main amd64 libpcsclite1 amd64 1.8.14-1ubuntu1.16.04.1 [21.4 kB]
Get:19 http://archive.ubuntu.com/ubuntu xenial/main amd64 libxi6 amd64 2:1.7.6-1 [28.6 kB]
Get:20 http://archive.ubuntu.com/ubuntu xenial/main amd64 libxrender1 amd64 1:0.9.9-0ubuntu1 [18.5 kB]
Get:21 http://archive.ubuntu.com/ubuntu xenial-updates/main amd64 openjdk-8-jre-headless amd64 8u151-b12-0ubuntu0.16.04.2 [27.0 MB]
Get:22 http://archive.ubuntu.com/ubuntu xenial-updates/main amd64 ca-certificates-java all 20160321ubuntu1 [12.5 kB]
Err:3 http://ppa.launchpad.net/odl-team/nitrogen/ubuntu xenial/main amd64 opendaylight all 7.1.0-1ppa3
  503  Service Unavailable
Fetched 30.1 MB in 3min 18s (152 kB/s)
2018-02-22 04:19:30,393 [salt.loaded.int.module.cmdmod][ERROR   ][6638] stderr: Running scope as unit run-rfa2f01a5c23245e8b0c56c46ca2ca344.scope.
E: Failed to fetch http://ppa.launchpad.net/odl-team/nitrogen/ubuntu/pool/main/o/opendaylight/opendaylight_7.1.0-1ppa3_all.deb  503  Service Unavailable

E: Unable to fetch some archives, maybe run apt-get update or try with --fix-missing?
2018-02-22 04:19:30,393 [salt.loaded.int.module.cmdmod][ERROR   ][6638] retcode: 100
2018-02-22 04:19:30,395 [salt.loaded.int.module.cmdmod][INFO    ][6638] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2018-02-22 04:19:30,452 [salt.state       ][ERROR   ][6638] Problem encountered installing package(s). Additional info follows:

errors:
    - Running scope as unit run-rfa2f01a5c23245e8b0c56c46ca2ca344.scope.
      E: Failed to fetch http://ppa.launchpad.net/odl-team/nitrogen/ubuntu/pool/main/o/opendaylight/opendaylight_7.1.0-1ppa3_all.deb  503  Service Unavailable
      
      E: Unable to fetch some archives, maybe run apt-get update or try with --fix-missing?
2018-02-22 04:19:30,452 [salt.state       ][INFO    ][6638] Completed state [opendaylight] at time 04:19:30.452455 duration_in_ms=201005.23
2018-02-22 04:19:30,461 [salt.minion      ][INFO    ][6638] Returning information for job: 20180222041550134482
2018-02-22 04:19:41,417 [salt.minion      ][INFO    ][2013] User sudo_ubuntu Executing command service.mask with jid 20180222041942510106
2018-02-22 04:19:41,441 [salt.minion      ][INFO    ][7672] Starting a new job with PID 7672
2018-02-22 04:19:41,783 [salt.loader.192.168.11.2.int.module.cmdmod][INFO    ][7672] Executing command ['systemctl', 'status', 'opendaylight.service', '-n', '0'] in directory '/root'
2018-02-22 04:19:41,829 [salt.loader.192.168.11.2.int.module.cmdmod][INFO    ][7672] Executing command ['systemd-run', '--scope', 'systemctl', 'mask', 'opendaylight.service'] in directory '/root'
2018-02-22 04:19:41,947 [salt.minion      ][INFO    ][7672] Returning information for job: 20180222041942510106
2018-02-22 04:19:42,690 [salt.minion      ][INFO    ][2013] User sudo_ubuntu Executing command state.sls with jid 20180222041943779756
2018-02-22 04:19:42,714 [salt.minion      ][INFO    ][7698] Starting a new job with PID 7698
2018-02-22 04:19:44,964 [salt.state       ][INFO    ][7698] Loading fresh modules for state activity
2018-02-22 04:19:45,324 [salt.state       ][INFO    ][7698] Running state [apt-key adv --keyserver keyserver.ubuntu.com --recv 44C05248] at time 04:19:45.324383
2018-02-22 04:19:45,325 [salt.state       ][INFO    ][7698] Executing state cmd.run for apt-key adv --keyserver keyserver.ubuntu.com --recv 44C05248
2018-02-22 04:19:45,328 [salt.loaded.int.module.cmdmod][INFO    ][7698] Executing command 'apt-key adv --keyserver keyserver.ubuntu.com --recv 44C05248' in directory '/root'
2018-02-22 04:19:45,661 [salt.state       ][INFO    ][7698] {'pid': 7705, 'retcode': 0, 'stderr': 'gpg: requesting key 44C05248 from hkp server keyserver.ubuntu.com\ngpg: key 44C05248: "Launchpad PPA for ODL Team" not changed\ngpg: Total number processed: 1\ngpg:              unchanged: 1', 'stdout': 'Executing: /tmp/tmp.T9FLM3NJix/gpg.1.sh --keyserver\nkeyserver.ubuntu.com\n--recv\n44C05248'}
2018-02-22 04:19:45,662 [salt.state       ][INFO    ][7698] Completed state [apt-key adv --keyserver keyserver.ubuntu.com --recv 44C05248] at time 04:19:45.662537 duration_in_ms=338.156
2018-02-22 04:19:45,684 [salt.state       ][INFO    ][7698] Running state [deb http://ppa.launchpad.net/odl-team/nitrogen/ubuntu xenial main] at time 04:19:45.684149
2018-02-22 04:19:45,684 [salt.state       ][INFO    ][7698] Executing state pkgrepo.managed for deb http://ppa.launchpad.net/odl-team/nitrogen/ubuntu xenial main
2018-02-22 04:19:45,727 [salt.state       ][INFO    ][7698] Package repo 'deb http://ppa.launchpad.net/odl-team/nitrogen/ubuntu xenial main' already configured
2018-02-22 04:19:45,727 [salt.state       ][INFO    ][7698] Completed state [deb http://ppa.launchpad.net/odl-team/nitrogen/ubuntu xenial main] at time 04:19:45.727293 duration_in_ms=43.144
2018-02-22 04:19:46,173 [salt.state       ][INFO    ][7698] Running state [opendaylight] at time 04:19:46.173487
2018-02-22 04:19:46,173 [salt.state       ][INFO    ][7698] Executing state pkg.installed for opendaylight
2018-02-22 04:19:46,174 [salt.loaded.int.module.cmdmod][INFO    ][7698] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2018-02-22 04:19:46,534 [salt.loaded.int.module.cmdmod][INFO    ][7698] Executing command ['apt-cache', '-q', 'policy', 'opendaylight'] in directory '/root'
2018-02-22 04:19:46,636 [salt.loaded.int.module.cmdmod][INFO    ][7698] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2018-02-22 04:19:52,811 [salt.minion      ][INFO    ][2013] User sudo_ubuntu Executing command saltutil.find_job with jid 20180222041953901325
2018-02-22 04:19:52,834 [salt.minion      ][INFO    ][8091] Starting a new job with PID 8091
2018-02-22 04:19:52,854 [salt.minion      ][INFO    ][8091] Returning information for job: 20180222041953901325
2018-02-22 04:20:02,848 [salt.minion      ][INFO    ][2013] User sudo_ubuntu Executing command saltutil.find_job with jid 20180222042003936803
2018-02-22 04:20:02,870 [salt.minion      ][INFO    ][8096] Starting a new job with PID 8096
2018-02-22 04:20:02,889 [salt.minion      ][INFO    ][8096] Returning information for job: 20180222042003936803
2018-02-22 04:20:13,079 [salt.minion      ][INFO    ][2013] User sudo_ubuntu Executing command saltutil.find_job with jid 20180222042014170954
2018-02-22 04:20:13,102 [salt.minion      ][INFO    ][8101] Starting a new job with PID 8101
2018-02-22 04:20:13,121 [salt.minion      ][INFO    ][8101] Returning information for job: 20180222042014170954
2018-02-22 04:20:23,127 [salt.minion      ][INFO    ][2013] User sudo_ubuntu Executing command saltutil.find_job with jid 20180222042024206572
2018-02-22 04:20:23,151 [salt.minion      ][INFO    ][8106] Starting a new job with PID 8106
2018-02-22 04:20:23,169 [salt.minion      ][INFO    ][8106] Returning information for job: 20180222042024206572
2018-02-22 04:20:33,150 [salt.minion      ][INFO    ][2013] User sudo_ubuntu Executing command saltutil.find_job with jid 20180222042034242479
2018-02-22 04:20:33,173 [salt.minion      ][INFO    ][8111] Starting a new job with PID 8111
2018-02-22 04:20:33,189 [salt.minion      ][INFO    ][8111] Returning information for job: 20180222042034242479
2018-02-22 04:20:43,172 [salt.minion      ][INFO    ][2013] User sudo_ubuntu Executing command saltutil.find_job with jid 20180222042044263237
2018-02-22 04:20:43,195 [salt.minion      ][INFO    ][8116] Starting a new job with PID 8116
2018-02-22 04:20:43,213 [salt.minion      ][INFO    ][8116] Returning information for job: 20180222042044263237
2018-02-22 04:20:47,881 [salt.loaded.int.module.cmdmod][INFO    ][7698] Executing command ['dpkg', '--get-selections', '*'] in directory '/root'
2018-02-22 04:20:47,920 [salt.loaded.int.module.cmdmod][INFO    ][7698] 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-02-22 04:20:53,204 [salt.minion      ][INFO    ][2013] User sudo_ubuntu Executing command saltutil.find_job with jid 20180222042054291652
2018-02-22 04:20:53,232 [salt.minion      ][INFO    ][8193] Starting a new job with PID 8193
2018-02-22 04:20:53,250 [salt.minion      ][INFO    ][8193] Returning information for job: 20180222042054291652
2018-02-22 04:21:03,236 [salt.minion      ][INFO    ][2013] User sudo_ubuntu Executing command saltutil.find_job with jid 20180222042104325486
2018-02-22 04:21:03,258 [salt.minion      ][INFO    ][8198] Starting a new job with PID 8198
2018-02-22 04:21:03,275 [salt.minion      ][INFO    ][8198] Returning information for job: 20180222042104325486
2018-02-22 04:21:13,268 [salt.minion      ][INFO    ][2013] User sudo_ubuntu Executing command saltutil.find_job with jid 20180222042114355542
2018-02-22 04:21:13,289 [salt.minion      ][INFO    ][8203] Starting a new job with PID 8203
2018-02-22 04:21:13,307 [salt.minion      ][INFO    ][8203] Returning information for job: 20180222042114355542
2018-02-22 04:21:23,300 [salt.minion      ][INFO    ][2013] User sudo_ubuntu Executing command saltutil.find_job with jid 20180222042124389615
2018-02-22 04:21:23,323 [salt.minion      ][INFO    ][8208] Starting a new job with PID 8208
2018-02-22 04:21:23,341 [salt.minion      ][INFO    ][8208] Returning information for job: 20180222042124389615
2018-02-22 04:21:33,330 [salt.minion      ][INFO    ][2013] User sudo_ubuntu Executing command saltutil.find_job with jid 20180222042134422280
2018-02-22 04:21:33,353 [salt.minion      ][INFO    ][8213] Starting a new job with PID 8213
2018-02-22 04:21:33,371 [salt.minion      ][INFO    ][8213] Returning information for job: 20180222042134422280
2018-02-22 04:21:43,364 [salt.minion      ][INFO    ][2013] User sudo_ubuntu Executing command saltutil.find_job with jid 20180222042144449851
2018-02-22 04:21:43,388 [salt.minion      ][INFO    ][8218] Starting a new job with PID 8218
2018-02-22 04:21:43,406 [salt.minion      ][INFO    ][8218] Returning information for job: 20180222042144449851
2018-02-22 04:21:47,936 [salt.loaded.int.module.cmdmod][ERROR   ][7698] Command '['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'opendaylight']' failed with return code: 100
2018-02-22 04:21:47,938 [salt.loaded.int.module.cmdmod][ERROR   ][7698] stdout: Reading package lists...
Building dependency tree...
Reading state information...
The following additional packages will be installed:
  ca-certificates-java fontconfig-config fonts-dejavu-core java-common
  libavahi-client3 libavahi-common-data libavahi-common3 libcups2
  libfontconfig1 libjpeg-turbo8 libjpeg8 liblcms2-2 libnspr4 libnss3
  libnss3-nssdb libpcsclite1 libxi6 libxrender1 libxtst6
  openjdk-8-jre-headless x11-common
Suggested packages:
  default-jre cups-common liblcms2-utils pcscd libnss-mdns fonts-dejavu-extra
  fonts-ipafont-gothic fonts-ipafont-mincho fonts-wqy-microhei
  fonts-wqy-zenhei fonts-indic
The following NEW packages will be installed:
  ca-certificates-java fontconfig-config fonts-dejavu-core java-common
  libavahi-client3 libavahi-common-data libavahi-common3 libcups2
  libfontconfig1 libjpeg-turbo8 libjpeg8 liblcms2-2 libnspr4 libnss3
  libnss3-nssdb libpcsclite1 libxi6 libxrender1 libxtst6 opendaylight
  openjdk-8-jre-headless x11-common
0 upgraded, 22 newly installed, 0 to remove and 11 not upgraded.
Need to get 298 MB/328 MB of archives.
After this operation, 494 MB of additional disk space will be used.
Err:1 http://ppa.launchpad.net/odl-team/nitrogen/ubuntu xenial/main amd64 opendaylight all 7.1.0-1ppa3
  503  Service Unavailable
2018-02-22 04:21:47,940 [salt.loaded.int.module.cmdmod][ERROR   ][7698] stderr: Running scope as unit run-reaae85263389406982623b48500ffb2d.scope.
E: Failed to fetch http://ppa.launchpad.net/odl-team/nitrogen/ubuntu/pool/main/o/opendaylight/opendaylight_7.1.0-1ppa3_all.deb  503  Service Unavailable

E: Unable to fetch some archives, maybe run apt-get update or try with --fix-missing?
2018-02-22 04:21:47,940 [salt.loaded.int.module.cmdmod][ERROR   ][7698] retcode: 100
2018-02-22 04:21:47,943 [salt.loaded.int.module.cmdmod][INFO    ][7698] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2018-02-22 04:21:47,995 [salt.state       ][ERROR   ][7698] Problem encountered installing package(s). Additional info follows:

errors:
    - Running scope as unit run-reaae85263389406982623b48500ffb2d.scope.
      E: Failed to fetch http://ppa.launchpad.net/odl-team/nitrogen/ubuntu/pool/main/o/opendaylight/opendaylight_7.1.0-1ppa3_all.deb  503  Service Unavailable
      
      E: Unable to fetch some archives, maybe run apt-get update or try with --fix-missing?
2018-02-22 04:21:47,997 [salt.state       ][INFO    ][7698] Completed state [opendaylight] at time 04:21:47.997355 duration_in_ms=121823.868
2018-02-22 04:21:48,004 [salt.minion      ][INFO    ][7698] Returning information for job: 20180222041943779756
2018-02-22 04:21:58,930 [salt.minion      ][INFO    ][2013] User sudo_ubuntu Executing command service.mask with jid 20180222042200024232
2018-02-22 04:21:58,953 [salt.minion      ][INFO    ][8227] Starting a new job with PID 8227
2018-02-22 04:21:59,294 [salt.loader.192.168.11.2.int.module.cmdmod][INFO    ][8227] Executing command ['systemctl', 'status', 'opendaylight.service', '-n', '0'] in directory '/root'
2018-02-22 04:21:59,342 [salt.loader.192.168.11.2.int.module.cmdmod][INFO    ][8227] Executing command ['systemd-run', '--scope', 'systemctl', 'mask', 'opendaylight.service'] in directory '/root'
2018-02-22 04:21:59,450 [salt.minion      ][INFO    ][8227] Returning information for job: 20180222042200024232
2018-02-22 04:22:00,195 [salt.minion      ][INFO    ][2013] User sudo_ubuntu Executing command state.sls with jid 20180222042201287985
2018-02-22 04:22:00,217 [salt.minion      ][INFO    ][8252] Starting a new job with PID 8252
2018-02-22 04:22:02,520 [salt.state       ][INFO    ][8252] Loading fresh modules for state activity
2018-02-22 04:22:02,760 [salt.state       ][INFO    ][8252] Running state [apt-key adv --keyserver keyserver.ubuntu.com --recv 44C05248] at time 04:22:02.760044
2018-02-22 04:22:02,760 [salt.state       ][INFO    ][8252] Executing state cmd.run for apt-key adv --keyserver keyserver.ubuntu.com --recv 44C05248
2018-02-22 04:22:02,761 [salt.loaded.int.module.cmdmod][INFO    ][8252] Executing command 'apt-key adv --keyserver keyserver.ubuntu.com --recv 44C05248' in directory '/root'
2018-02-22 04:22:03,063 [salt.state       ][INFO    ][8252] {'pid': 8259, 'retcode': 0, 'stderr': 'gpg: requesting key 44C05248 from hkp server keyserver.ubuntu.com\ngpg: key 44C05248: "Launchpad PPA for ODL Team" not changed\ngpg: Total number processed: 1\ngpg:              unchanged: 1', 'stdout': 'Executing: /tmp/tmp.IlanedR96O/gpg.1.sh --keyserver\nkeyserver.ubuntu.com\n--recv\n44C05248'}
2018-02-22 04:22:03,064 [salt.state       ][INFO    ][8252] Completed state [apt-key adv --keyserver keyserver.ubuntu.com --recv 44C05248] at time 04:22:03.064212 duration_in_ms=304.168
2018-02-22 04:22:03,086 [salt.state       ][INFO    ][8252] Running state [deb http://ppa.launchpad.net/odl-team/nitrogen/ubuntu xenial main] at time 04:22:03.086683
2018-02-22 04:22:03,087 [salt.state       ][INFO    ][8252] Executing state pkgrepo.managed for deb http://ppa.launchpad.net/odl-team/nitrogen/ubuntu xenial main
2018-02-22 04:22:03,130 [salt.state       ][INFO    ][8252] Package repo 'deb http://ppa.launchpad.net/odl-team/nitrogen/ubuntu xenial main' already configured
2018-02-22 04:22:03,130 [salt.state       ][INFO    ][8252] Completed state [deb http://ppa.launchpad.net/odl-team/nitrogen/ubuntu xenial main] at time 04:22:03.130467 duration_in_ms=43.785
2018-02-22 04:22:03,591 [salt.state       ][INFO    ][8252] Running state [opendaylight] at time 04:22:03.591447
2018-02-22 04:22:03,592 [salt.state       ][INFO    ][8252] Executing state pkg.installed for opendaylight
2018-02-22 04:22:03,592 [salt.loaded.int.module.cmdmod][INFO    ][8252] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2018-02-22 04:22:03,918 [salt.loaded.int.module.cmdmod][INFO    ][8252] Executing command ['apt-cache', '-q', 'policy', 'opendaylight'] in directory '/root'
2018-02-22 04:22:04,020 [salt.loaded.int.module.cmdmod][INFO    ][8252] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2018-02-22 04:22:10,294 [salt.minion      ][INFO    ][2013] User sudo_ubuntu Executing command saltutil.find_job with jid 20180222042211387549
2018-02-22 04:22:10,317 [salt.minion      ][INFO    ][8645] Starting a new job with PID 8645
2018-02-22 04:22:10,337 [salt.minion      ][INFO    ][8645] Returning information for job: 20180222042211387549
2018-02-22 04:22:20,526 [salt.minion      ][INFO    ][2013] User sudo_ubuntu Executing command saltutil.find_job with jid 20180222042221614754
2018-02-22 04:22:20,548 [salt.minion      ][INFO    ][8650] Starting a new job with PID 8650
2018-02-22 04:22:20,568 [salt.minion      ][INFO    ][8650] Returning information for job: 20180222042221614754
2018-02-22 04:22:30,761 [salt.minion      ][INFO    ][2013] User sudo_ubuntu Executing command saltutil.find_job with jid 20180222042231847365
2018-02-22 04:22:30,785 [salt.minion      ][INFO    ][8655] Starting a new job with PID 8655
2018-02-22 04:22:30,803 [salt.minion      ][INFO    ][8655] Returning information for job: 20180222042231847365
2018-02-22 04:22:40,790 [salt.minion      ][INFO    ][2013] User sudo_ubuntu Executing command saltutil.find_job with jid 20180222042241874255
2018-02-22 04:22:40,814 [salt.minion      ][INFO    ][8660] Starting a new job with PID 8660
2018-02-22 04:22:40,832 [salt.minion      ][INFO    ][8660] Returning information for job: 20180222042241874255
2018-02-22 04:22:50,813 [salt.minion      ][INFO    ][2013] User sudo_ubuntu Executing command saltutil.find_job with jid 20180222042251902471
2018-02-22 04:22:50,836 [salt.minion      ][INFO    ][8665] Starting a new job with PID 8665
2018-02-22 04:22:50,856 [salt.minion      ][INFO    ][8665] Returning information for job: 20180222042251902471
2018-02-22 04:23:01,046 [salt.minion      ][INFO    ][2013] User sudo_ubuntu Executing command saltutil.find_job with jid 20180222042302135314
2018-02-22 04:23:01,069 [salt.minion      ][INFO    ][8680] Starting a new job with PID 8680
2018-02-22 04:23:01,087 [salt.minion      ][INFO    ][8680] Returning information for job: 20180222042302135314
2018-02-22 04:23:11,278 [salt.minion      ][INFO    ][2013] User sudo_ubuntu Executing command saltutil.find_job with jid 20180222042312368946
2018-02-22 04:23:11,296 [salt.minion      ][INFO    ][8685] Starting a new job with PID 8685
2018-02-22 04:23:11,316 [salt.minion      ][INFO    ][8685] Returning information for job: 20180222042312368946
2018-02-22 04:23:21,329 [salt.minion      ][INFO    ][2013] User sudo_ubuntu Executing command saltutil.find_job with jid 20180222042322422381
2018-02-22 04:23:21,353 [salt.minion      ][INFO    ][8690] Starting a new job with PID 8690
2018-02-22 04:23:21,371 [salt.minion      ][INFO    ][8690] Returning information for job: 20180222042322422381
2018-02-22 04:23:23,213 [salt.loaded.int.module.cmdmod][INFO    ][8252] Executing command ['dpkg', '--get-selections', '*'] in directory '/root'
2018-02-22 04:23:23,255 [salt.loaded.int.module.cmdmod][INFO    ][8252] 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-02-22 04:23:23,564 [salt.loaded.int.module.cmdmod][ERROR   ][8252] Command '['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'opendaylight']' failed with return code: 100
2018-02-22 04:23:23,566 [salt.loaded.int.module.cmdmod][ERROR   ][8252] stdout: Reading package lists...
Building dependency tree...
Reading state information...
The following additional packages will be installed:
  ca-certificates-java fontconfig-config fonts-dejavu-core java-common
  libavahi-client3 libavahi-common-data libavahi-common3 libcups2
  libfontconfig1 libjpeg-turbo8 libjpeg8 liblcms2-2 libnspr4 libnss3
  libnss3-nssdb libpcsclite1 libxi6 libxrender1 libxtst6
  openjdk-8-jre-headless x11-common
Suggested packages:
  default-jre cups-common liblcms2-utils pcscd libnss-mdns fonts-dejavu-extra
  fonts-ipafont-gothic fonts-ipafont-mincho fonts-wqy-microhei
  fonts-wqy-zenhei fonts-indic
The following NEW packages will be installed:
  ca-certificates-java fontconfig-config fonts-dejavu-core java-common
  libavahi-client3 libavahi-common-data libavahi-common3 libcups2
  libfontconfig1 libjpeg-turbo8 libjpeg8 liblcms2-2 libnspr4 libnss3
  libnss3-nssdb libpcsclite1 libxi6 libxrender1 libxtst6 opendaylight
  openjdk-8-jre-headless x11-common
0 upgraded, 22 newly installed, 0 to remove and 11 not upgraded.
Need to get 298 MB/328 MB of archives.
After this operation, 494 MB of additional disk space will be used.
WARNING: The following packages cannot be authenticated!
  opendaylight
2018-02-22 04:23:23,569 [salt.loaded.int.module.cmdmod][ERROR   ][8252] stderr: Running scope as unit run-rf6695b41097e4793812a1314e56bf4ed.scope.
E: There were unauthenticated packages and -y was used without --allow-unauthenticated
2018-02-22 04:23:23,570 [salt.loaded.int.module.cmdmod][ERROR   ][8252] retcode: 100
2018-02-22 04:23:23,573 [salt.loaded.int.module.cmdmod][INFO    ][8252] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2018-02-22 04:23:23,629 [salt.state       ][ERROR   ][8252] Problem encountered installing package(s). Additional info follows:

errors:
    - Running scope as unit run-rf6695b41097e4793812a1314e56bf4ed.scope.
      E: There were unauthenticated packages and -y was used without --allow-unauthenticated
2018-02-22 04:23:23,630 [salt.state       ][INFO    ][8252] Completed state [opendaylight] at time 04:23:23.630475 duration_in_ms=80039.028
2018-02-22 04:23:23,638 [salt.minion      ][INFO    ][8252] Returning information for job: 20180222042201287985
2018-02-22 04:23:34,527 [salt.minion      ][INFO    ][2013] User sudo_ubuntu Executing command service.mask with jid 20180222042335619477
2018-02-22 04:23:34,551 [salt.minion      ][INFO    ][8729] Starting a new job with PID 8729
2018-02-22 04:23:34,895 [salt.loader.192.168.11.2.int.module.cmdmod][INFO    ][8729] Executing command ['systemctl', 'status', 'opendaylight.service', '-n', '0'] in directory '/root'
2018-02-22 04:23:34,943 [salt.loader.192.168.11.2.int.module.cmdmod][INFO    ][8729] Executing command ['systemd-run', '--scope', 'systemctl', 'mask', 'opendaylight.service'] in directory '/root'
2018-02-22 04:23:35,048 [salt.minion      ][INFO    ][8729] Returning information for job: 20180222042335619477
2018-02-22 04:23:35,803 [salt.minion      ][INFO    ][2013] User sudo_ubuntu Executing command state.sls with jid 20180222042336894765
2018-02-22 04:23:35,830 [salt.minion      ][INFO    ][8754] Starting a new job with PID 8754
2018-02-22 04:23:38,058 [salt.state       ][INFO    ][8754] Loading fresh modules for state activity
2018-02-22 04:23:38,292 [salt.state       ][INFO    ][8754] Running state [apt-key adv --keyserver keyserver.ubuntu.com --recv 44C05248] at time 04:23:38.292897
2018-02-22 04:23:38,293 [salt.state       ][INFO    ][8754] Executing state cmd.run for apt-key adv --keyserver keyserver.ubuntu.com --recv 44C05248
2018-02-22 04:23:38,294 [salt.loaded.int.module.cmdmod][INFO    ][8754] Executing command 'apt-key adv --keyserver keyserver.ubuntu.com --recv 44C05248' in directory '/root'
2018-02-22 04:23:38,625 [salt.state       ][INFO    ][8754] {'pid': 8761, 'retcode': 0, 'stderr': 'gpg: requesting key 44C05248 from hkp server keyserver.ubuntu.com\ngpg: key 44C05248: "Launchpad PPA for ODL Team" not changed\ngpg: Total number processed: 1\ngpg:              unchanged: 1', 'stdout': 'Executing: /tmp/tmp.v1QdWhzr1t/gpg.1.sh --keyserver\nkeyserver.ubuntu.com\n--recv\n44C05248'}
2018-02-22 04:23:38,626 [salt.state       ][INFO    ][8754] Completed state [apt-key adv --keyserver keyserver.ubuntu.com --recv 44C05248] at time 04:23:38.626415 duration_in_ms=333.517
2018-02-22 04:23:38,646 [salt.state       ][INFO    ][8754] Running state [deb http://ppa.launchpad.net/odl-team/nitrogen/ubuntu xenial main] at time 04:23:38.646147
2018-02-22 04:23:38,646 [salt.state       ][INFO    ][8754] Executing state pkgrepo.managed for deb http://ppa.launchpad.net/odl-team/nitrogen/ubuntu xenial main
2018-02-22 04:23:38,690 [salt.state       ][INFO    ][8754] Package repo 'deb http://ppa.launchpad.net/odl-team/nitrogen/ubuntu xenial main' already configured
2018-02-22 04:23:38,690 [salt.state       ][INFO    ][8754] Completed state [deb http://ppa.launchpad.net/odl-team/nitrogen/ubuntu xenial main] at time 04:23:38.690858 duration_in_ms=44.711
2018-02-22 04:23:39,153 [salt.state       ][INFO    ][8754] Running state [opendaylight] at time 04:23:39.153284
2018-02-22 04:23:39,154 [salt.state       ][INFO    ][8754] Executing state pkg.installed for opendaylight
2018-02-22 04:23:39,154 [salt.loaded.int.module.cmdmod][INFO    ][8754] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2018-02-22 04:23:39,510 [salt.loaded.int.module.cmdmod][INFO    ][8754] Executing command ['apt-cache', '-q', 'policy', 'opendaylight'] in directory '/root'
2018-02-22 04:23:39,645 [salt.loaded.int.module.cmdmod][INFO    ][8754] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2018-02-22 04:23:45,909 [salt.minion      ][INFO    ][2013] User sudo_ubuntu Executing command saltutil.find_job with jid 20180222042346999314
2018-02-22 04:23:45,934 [salt.minion      ][INFO    ][9063] Starting a new job with PID 9063
2018-02-22 04:23:45,953 [salt.minion      ][INFO    ][9063] Returning information for job: 20180222042346999314
2018-02-22 04:23:52,326 [salt.loaded.int.module.cmdmod][INFO    ][8754] Executing command ['dpkg', '--get-selections', '*'] in directory '/root'
2018-02-22 04:23:52,365 [salt.loaded.int.module.cmdmod][INFO    ][8754] 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-02-22 04:23:55,935 [salt.minion      ][INFO    ][2013] User sudo_ubuntu Executing command saltutil.find_job with jid 20180222042357021182
2018-02-22 04:23:55,961 [salt.minion      ][INFO    ][9226] Starting a new job with PID 9226
2018-02-22 04:23:55,980 [salt.minion      ][INFO    ][9226] Returning information for job: 20180222042357021182
2018-02-22 04:24:05,962 [salt.minion      ][INFO    ][2013] User sudo_ubuntu Executing command saltutil.find_job with jid 20180222042407055110
2018-02-22 04:24:05,990 [salt.minion      ][INFO    ][9231] Starting a new job with PID 9231
2018-02-22 04:24:06,007 [salt.minion      ][INFO    ][9231] Returning information for job: 20180222042407055110
2018-02-22 04:24:15,995 [salt.minion      ][INFO    ][2013] User sudo_ubuntu Executing command saltutil.find_job with jid 20180222042417086998
2018-02-22 04:24:16,020 [salt.minion      ][INFO    ][9236] Starting a new job with PID 9236
2018-02-22 04:24:16,038 [salt.minion      ][INFO    ][9236] Returning information for job: 20180222042417086998
2018-02-22 04:24:26,021 [salt.minion      ][INFO    ][2013] User sudo_ubuntu Executing command saltutil.find_job with jid 20180222042427111734
2018-02-22 04:24:26,046 [salt.minion      ][INFO    ][9241] Starting a new job with PID 9241
2018-02-22 04:24:26,064 [salt.minion      ][INFO    ][9241] Returning information for job: 20180222042427111734
2018-02-22 04:24:36,063 [salt.minion      ][INFO    ][2013] User sudo_ubuntu Executing command saltutil.find_job with jid 20180222042437142588
2018-02-22 04:24:36,091 [salt.minion      ][INFO    ][9246] Starting a new job with PID 9246
2018-02-22 04:24:36,107 [salt.minion      ][INFO    ][9246] Returning information for job: 20180222042437142588
2018-02-22 04:24:46,101 [salt.minion      ][INFO    ][2013] User sudo_ubuntu Executing command saltutil.find_job with jid 20180222042447189989
2018-02-22 04:24:46,127 [salt.minion      ][INFO    ][9251] Starting a new job with PID 9251
2018-02-22 04:24:46,146 [salt.minion      ][INFO    ][9251] Returning information for job: 20180222042447189989
2018-02-22 04:24:56,192 [salt.minion      ][INFO    ][2013] User sudo_ubuntu Executing command saltutil.find_job with jid 20180222042457285404
2018-02-22 04:24:56,215 [salt.minion      ][INFO    ][9256] Starting a new job with PID 9256
2018-02-22 04:24:56,230 [salt.minion      ][INFO    ][9256] Returning information for job: 20180222042457285404
2018-02-22 04:25:06,425 [salt.minion      ][INFO    ][2013] User sudo_ubuntu Executing command saltutil.find_job with jid 20180222042507512780
2018-02-22 04:25:06,452 [salt.minion      ][INFO    ][9261] Starting a new job with PID 9261
2018-02-22 04:25:06,470 [salt.minion      ][INFO    ][9261] Returning information for job: 20180222042507512780
2018-02-22 04:25:16,469 [salt.minion      ][INFO    ][2013] User sudo_ubuntu Executing command saltutil.find_job with jid 20180222042517561286
2018-02-22 04:25:16,490 [salt.minion      ][INFO    ][9266] Starting a new job with PID 9266
2018-02-22 04:25:16,512 [salt.minion      ][INFO    ][9266] Returning information for job: 20180222042517561286
2018-02-22 04:25:26,498 [salt.minion      ][INFO    ][2013] User sudo_ubuntu Executing command saltutil.find_job with jid 20180222042527589627
2018-02-22 04:25:26,521 [salt.minion      ][INFO    ][9271] Starting a new job with PID 9271
2018-02-22 04:25:26,541 [salt.minion      ][INFO    ][9271] Returning information for job: 20180222042527589627
2018-02-22 04:25:36,534 [salt.minion      ][INFO    ][2013] User sudo_ubuntu Executing command saltutil.find_job with jid 20180222042537621857
2018-02-22 04:25:36,560 [salt.minion      ][INFO    ][9276] Starting a new job with PID 9276
2018-02-22 04:25:36,577 [salt.minion      ][INFO    ][9276] Returning information for job: 20180222042537621857
2018-02-22 04:25:46,572 [salt.minion      ][INFO    ][2013] User sudo_ubuntu Executing command saltutil.find_job with jid 20180222042547662759
2018-02-22 04:25:46,589 [salt.minion      ][INFO    ][9478] Starting a new job with PID 9478
2018-02-22 04:25:46,605 [salt.minion      ][INFO    ][9478] Returning information for job: 20180222042547662759
2018-02-22 04:25:56,604 [salt.minion      ][INFO    ][2013] User sudo_ubuntu Executing command saltutil.find_job with jid 20180222042557697986
2018-02-22 04:25:56,629 [salt.minion      ][INFO    ][9501] Starting a new job with PID 9501
2018-02-22 04:25:56,647 [salt.minion      ][INFO    ][9501] Returning information for job: 20180222042557697986
2018-02-22 04:26:06,646 [salt.minion      ][INFO    ][2013] User sudo_ubuntu Executing command saltutil.find_job with jid 20180222042607737262
2018-02-22 04:26:06,670 [salt.minion      ][INFO    ][9506] Starting a new job with PID 9506
2018-02-22 04:26:06,688 [salt.minion      ][INFO    ][9506] Returning information for job: 20180222042607737262
2018-02-22 04:26:16,686 [salt.minion      ][INFO    ][2013] User sudo_ubuntu Executing command saltutil.find_job with jid 20180222042617776328
2018-02-22 04:26:16,707 [salt.minion      ][INFO    ][11682] Starting a new job with PID 11682
2018-02-22 04:26:16,726 [salt.minion      ][INFO    ][11682] Returning information for job: 20180222042617776328
2018-02-22 04:26:18,371 [salt.loaded.int.module.cmdmod][INFO    ][8754] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2018-02-22 04:26:18,430 [salt.state       ][INFO    ][8754] 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 '8u151-b12-0ubuntu0.16.04.2'
'libxrender1' changed from 'absent' to '1:0.9.9-0ubuntu1'
'libavahi-common3' changed from 'absent' to '0.6.32~rc+dfsg-1ubuntu2'
'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'
'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'
'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 '7.1.0-1ppa3'
'libfontconfig1' changed from 'absent' to '2.11.94-0ubuntu1.1'

2018-02-22 04:26:18,448 [salt.state       ][INFO    ][8754] Loading fresh modules for state activity
2018-02-22 04:26:18,476 [salt.state       ][INFO    ][8754] Completed state [opendaylight] at time 04:26:18.476135 duration_in_ms=159322.852
2018-02-22 04:26:18,735 [salt.state       ][INFO    ][8754] Running state [/opt/opendaylight/etc/jetty.xml] at time 04:26:18.735857
2018-02-22 04:26:18,736 [salt.state       ][INFO    ][8754] Executing state file.managed for /opt/opendaylight/etc/jetty.xml
2018-02-22 04:26:18,804 [salt.fileclient  ][INFO    ][8754] Fetching file from saltenv 'base', ** done ** 'opendaylight/files/jetty.xml'
2018-02-22 04:26:18,864 [salt.state       ][INFO    ][8754] File changed:
--- 
+++ 
@@ -79,7 +79,7 @@
                         </Item>
                     </Array>
                 </Arg>
-                <Set name="host">
+                <Set name="host">192.168.10.111
                     <Property name="jetty.host"/>
                 </Set>
                 <Set name="port">
@@ -110,11 +110,11 @@
                         </Item>
                     </Array>
                 </Arg>
-                <Set name="host">
+                <Set name="host">192.168.10.111
                     <Property name="jetty.host"/>
                 </Set>
                 <Set name="port">
-                    <Property name="jetty.port" default="8080"/>
+                    <Property name="jetty.port" default="8282"/>
                 </Set>
                 <Set name="idleTimeout">
                     <Property name="http.timeout" default="300000"/>

2018-02-22 04:26:18,867 [salt.state       ][INFO    ][8754] Completed state [/opt/opendaylight/etc/jetty.xml] at time 04:26:18.867445 duration_in_ms=131.588
2018-02-22 04:26:18,867 [salt.state       ][INFO    ][8754] Running state [/opt/opendaylight/bin/setenv] at time 04:26:18.867854
2018-02-22 04:26:18,868 [salt.state       ][INFO    ][8754] Executing state file.managed for /opt/opendaylight/bin/setenv
2018-02-22 04:26:18,916 [salt.fileclient  ][INFO    ][8754] Fetching file from saltenv 'base', ** done ** 'opendaylight/files/setenv.shell'
2018-02-22 04:26:18,951 [salt.state       ][INFO    ][8754] 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=4g # Minimum memory for the JVM
+export JAVA_MAX_MEM=4g # 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,4 @@
 # 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-02-22 04:26:18,951 [salt.state       ][INFO    ][8754] Completed state [/opt/opendaylight/bin/setenv] at time 04:26:18.951596 duration_in_ms=83.742
2018-02-22 04:26:18,952 [salt.state       ][INFO    ][8754] Running state [/opt/opendaylight/etc/org.apache.karaf.features.cfg] at time 04:26:18.952192
2018-02-22 04:26:18,952 [salt.state       ][INFO    ][8754] Executing state ini.options_present for /opt/opendaylight/etc/org.apache.karaf.features.cfg
2018-02-22 04:26:18,970 [salt.state       ][INFO    ][8754] {'featuresBoot': {'after': 'standard,wrap,ssh,odl-restconf-all,odl-aaa-authn,odl-dlux-all,odl-mdsal-apidocs,odl-netvirt-openstack', 'before': '\\\n    standard, \\\n    wrap'}}
2018-02-22 04:26:18,971 [salt.state       ][INFO    ][8754] Completed state [/opt/opendaylight/etc/org.apache.karaf.features.cfg] at time 04:26:18.971083 duration_in_ms=18.891
2018-02-22 04:26:18,971 [salt.state       ][INFO    ][8754] Running state [/opt/opendaylight/etc/org.ops4j.pax.web.cfg] at time 04:26:18.971359
2018-02-22 04:26:18,971 [salt.state       ][INFO    ][8754] Executing state ini.options_present for /opt/opendaylight/etc/org.ops4j.pax.web.cfg
2018-02-22 04:26:18,972 [salt.state       ][INFO    ][8754] {'org.ops4j.pax.web.listening.addresses': {'after': '192.168.10.111', 'before': None}}
2018-02-22 04:26:18,972 [salt.state       ][INFO    ][8754] Completed state [/opt/opendaylight/etc/org.ops4j.pax.web.cfg] at time 04:26:18.972313 duration_in_ms=0.954
2018-02-22 04:26:18,972 [salt.state       ][INFO    ][8754] Running state [/opt/opendaylight/etc/custom.properties] at time 04:26:18.972569
2018-02-22 04:26:18,972 [salt.state       ][INFO    ][8754] Executing state ini.options_present for /opt/opendaylight/etc/custom.properties
2018-02-22 04:26:18,995 [salt.state       ][INFO    ][8754] {'ovsdb.l3.fwd.enabled': {'after': 'yes', 'before': None}, 'ovsdb.of.version': {'after': '1.3', 'before': None}}
2018-02-22 04:26:18,995 [salt.state       ][INFO    ][8754] Completed state [/opt/opendaylight/etc/custom.properties] at time 04:26:18.995915 duration_in_ms=23.345
2018-02-22 04:26:18,996 [salt.state       ][INFO    ][8754] Running state [opendaylight] at time 04:26:18.996358
2018-02-22 04:26:18,996 [salt.state       ][INFO    ][8754] Executing state service.running for opendaylight
2018-02-22 04:26:18,999 [salt.loaded.int.module.cmdmod][INFO    ][8754] Executing command ['systemctl', 'status', 'opendaylight.service', '-n', '0'] in directory '/root'
2018-02-22 04:26:19,022 [salt.loaded.int.module.cmdmod][INFO    ][8754] Executing command ['systemctl', 'is-active', 'opendaylight.service'] in directory '/root'
2018-02-22 04:26:19,047 [salt.loaded.int.module.cmdmod][INFO    ][8754] Executing command ['systemctl', 'is-enabled', 'opendaylight.service'] in directory '/root'
2018-02-22 04:26:19,077 [salt.loaded.int.module.cmdmod][INFO    ][8754] Executing command ['systemctl', 'is-enabled', 'opendaylight.service'] in directory '/root'
2018-02-22 04:26:19,103 [salt.loaded.int.module.cmdmod][INFO    ][8754] Executing command ['systemd-run', '--scope', 'systemctl', 'unmask', 'opendaylight.service'] in directory '/root'
2018-02-22 04:26:19,251 [salt.loaded.int.module.cmdmod][INFO    ][8754] Executing command ['systemd-run', '--scope', 'systemctl', 'start', 'opendaylight.service'] in directory '/root'
2018-02-22 04:26:19,343 [salt.loaded.int.module.cmdmod][INFO    ][8754] Executing command ['systemctl', 'is-active', 'opendaylight.service'] in directory '/root'
2018-02-22 04:26:19,362 [salt.loaded.int.module.cmdmod][INFO    ][8754] Executing command ['systemctl', 'is-enabled', 'opendaylight.service'] in directory '/root'
2018-02-22 04:26:19,385 [salt.loaded.int.module.cmdmod][INFO    ][8754] Executing command ['systemctl', 'is-enabled', 'opendaylight.service'] in directory '/root'
2018-02-22 04:26:19,414 [salt.state       ][INFO    ][8754] {'opendaylight': True}
2018-02-22 04:26:19,415 [salt.state       ][INFO    ][8754] Completed state [opendaylight] at time 04:26:19.414928 duration_in_ms=418.568
2018-02-22 04:26:19,418 [salt.minion      ][INFO    ][8754] Returning information for job: 20180222042336894765
2018-02-22 05:13:38,260 [salt.utils.schedule][INFO    ][2013] Running scheduled job: __mine_interval
2018-02-22 05:30:15,069 [salt.minion      ][INFO    ][2013] User sudo_ubuntu Executing command cp.push_dir with jid 20180222053016179299
2018-02-22 05:30:15,106 [salt.minion      ][INFO    ][13499] Starting a new job with PID 13499
