2018-02-15 01:01:03,391 [salt.minion      ][ERROR   ][1340] Error while bringing up minion for multi-master. Is master at 10.20.0.2 responding?
2018-02-15 01:01:53,449 [salt.minion      ][ERROR   ][1340] Error while bringing up minion for multi-master. Is master at 10.20.0.2 responding?
2018-02-15 01:02:03,469 [salt.crypt       ][ERROR   ][1340] The Salt Master has cached the public key for this node, this salt minion will wait for 10 seconds before attempting to re-authenticate
2018-02-15 01:03:54,124 [salt.utils.parsers][WARNING ][12478] Minion received a SIGTERM. Exiting.
2018-02-15 01:04:23,905 [salt.loaded.int.states.file][WARNING ][19655] State for file: /etc/pki/ca/salt_master_ca/ca.crt - Neither 'source' nor 'contents' nor 'contents_pillar' nor 'contents_grains' was defined, yet 'replace' was set to 'True'. As there is no source to replace the file with, 'replace' has been set to 'False' to avoid reading the file unnecessarily.
2018-02-15 01:04:38,311 [salt.loaded.int.module.cmdmod][ERROR   ][19655] 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-15 01:04:41,425 [salt.loaded.int.module.cmdmod][INFO    ][20717] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2018-02-15 01:04:41,462 [salt.loaded.int.module.cmdmod][INFO    ][20717] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2018-02-15 01:04:41,494 [salt.loaded.int.module.cmdmod][INFO    ][20717] Executing command ['systemd-run', '--scope', 'systemctl', 'restart', 'salt-minion.service'] in directory '/root'
2018-02-15 01:04:41,538 [salt.utils.parsers][WARNING ][19328] Minion received a SIGTERM. Exiting.
2018-02-15 01:04:42,608 [salt.cli.daemons ][INFO    ][20772] Setting up the Salt Minion "cfg01.mcp-pike-odl-ha.local"
2018-02-15 01:04:42,718 [salt.cli.daemons ][INFO    ][20772] Starting up the Salt Minion
2018-02-15 01:04:42,719 [salt.utils.event ][INFO    ][20772] Starting pull socket on /var/run/salt/minion/minion_event_e95f2b514c_pull.ipc
2018-02-15 01:04:43,441 [salt.minion      ][INFO    ][20772] Creating minion process manager
2018-02-15 01:04:44,926 [salt.loader.10.20.0.2.int.module.cmdmod][INFO    ][20772] Executing command ['date', '+%z'] in directory '/root'
2018-02-15 01:04:44,960 [salt.utils.schedule][INFO    ][20772] Updating job settings for scheduled job: __mine_interval
2018-02-15 01:04:44,964 [salt.minion      ][INFO    ][20772] Added mine.update to scheduler
2018-02-15 01:04:44,979 [salt.minion      ][INFO    ][20772] Minion is starting as user 'root'
2018-02-15 01:04:45,005 [salt.minion      ][INFO    ][20772] Minion is ready to receive requests!
2018-02-15 01:04:46,009 [salt.utils.schedule][INFO    ][20772] Running scheduled job: __mine_interval
2018-02-15 01:04:52,898 [salt.minion      ][INFO    ][20772] User sudo_ubuntu Executing command saltutil.find_job with jid 20180215010452881021
2018-02-15 01:04:52,925 [salt.minion      ][INFO    ][20874] Starting a new job with PID 20874
2018-02-15 01:04:52,950 [salt.minion      ][INFO    ][20874] Returning information for job: 20180215010452881021
2018-02-15 01:05:13,656 [salt.minion      ][INFO    ][20772] User sudo_ubuntu Executing command state.apply with jid 20180215010513639497
2018-02-15 01:05:13,680 [salt.minion      ][INFO    ][20918] Starting a new job with PID 20918
2018-02-15 01:05:15,479 [salt.state       ][INFO    ][20918] Loading fresh modules for state activity
2018-02-15 01:05:15,551 [salt.fileclient  ][INFO    ][20918] Fetching file from saltenv 'base', ** done ** 'linux/init.sls'
2018-02-15 01:05:15,596 [salt.fileclient  ][INFO    ][20918] Fetching file from saltenv 'base', ** done ** 'linux/system/init.sls'
2018-02-15 01:05:15,721 [salt.fileclient  ][INFO    ][20918] Fetching file from saltenv 'base', ** done ** 'linux/system/env.sls'
2018-02-15 01:05:15,807 [salt.fileclient  ][INFO    ][20918] Fetching file from saltenv 'base', ** done ** 'linux/system/profile.sls'
2018-02-15 01:05:15,879 [salt.fileclient  ][INFO    ][20918] Fetching file from saltenv 'base', ** done ** 'linux/system/repo.sls'
2018-02-15 01:05:16,000 [salt.fileclient  ][INFO    ][20918] Fetching file from saltenv 'base', ** done ** 'linux/system/package.sls'
2018-02-15 01:05:16,070 [salt.fileclient  ][INFO    ][20918] Fetching file from saltenv 'base', ** done ** 'linux/system/timezone.sls'
2018-02-15 01:05:16,132 [salt.fileclient  ][INFO    ][20918] Fetching file from saltenv 'base', ** done ** 'linux/system/kernel.sls'
2018-02-15 01:05:16,215 [salt.fileclient  ][INFO    ][20918] Fetching file from saltenv 'base', ** done ** 'linux/system/cpu.sls'
2018-02-15 01:05:16,303 [salt.fileclient  ][INFO    ][20918] Fetching file from saltenv 'base', ** done ** 'linux/system/sysfs.sls'
2018-02-15 01:05:16,371 [salt.fileclient  ][INFO    ][20918] Fetching file from saltenv 'base', ** done ** 'linux/system/locale.sls'
2018-02-15 01:05:16,572 [salt.fileclient  ][INFO    ][20918] Fetching file from saltenv 'base', ** done ** 'linux/system/limit.sls'
2018-02-15 01:05:16,637 [salt.fileclient  ][INFO    ][20918] Fetching file from saltenv 'base', ** done ** 'linux/system/systemd.sls'
2018-02-15 01:05:16,713 [salt.fileclient  ][INFO    ][20918] Fetching file from saltenv 'base', ** done ** 'linux/system/apt.sls'
2018-02-15 01:05:16,789 [salt.fileclient  ][INFO    ][20918] Fetching file from saltenv 'base', ** done ** 'linux/network/init.sls'
2018-02-15 01:05:16,854 [salt.fileclient  ][INFO    ][20918] Fetching file from saltenv 'base', ** done ** 'linux/network/hostname.sls'
2018-02-15 01:05:16,919 [salt.fileclient  ][INFO    ][20918] Fetching file from saltenv 'base', ** done ** 'linux/network/host.sls'
2018-02-15 01:05:17,022 [salt.fileclient  ][INFO    ][20918] Fetching file from saltenv 'base', ** done ** 'linux/network/interface.sls'
2018-02-15 01:05:17,142 [salt.fileclient  ][INFO    ][20918] Fetching file from saltenv 'base', ** done ** 'linux/network/proxy.sls'
2018-02-15 01:05:17,212 [salt.fileclient  ][INFO    ][20918] Fetching file from saltenv 'base', ** done ** 'linux/storage/init.sls'
2018-02-15 01:05:17,274 [salt.state       ][INFO    ][20918] Running state [/etc/environment] at time 01:05:17.274729
2018-02-15 01:05:17,275 [salt.state       ][INFO    ][20918] Executing state file.blockreplace for /etc/environment
2018-02-15 01:05:17,280 [salt.state       ][INFO    ][20918] 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-15 01:05:17,282 [salt.state       ][INFO    ][20918] Completed state [/etc/environment] at time 01:05:17.282337 duration_in_ms=7.608
2018-02-15 01:05:17,282 [salt.state       ][INFO    ][20918] Running state [/etc/profile.d] at time 01:05:17.282759
2018-02-15 01:05:17,283 [salt.state       ][INFO    ][20918] Executing state file.directory for /etc/profile.d
2018-02-15 01:05:17,284 [salt.state       ][INFO    ][20918] Directory /etc/profile.d is in the correct state
2018-02-15 01:05:17,284 [salt.state       ][INFO    ][20918] Completed state [/etc/profile.d] at time 01:05:17.284764 duration_in_ms=2.006
2018-02-15 01:05:17,852 [salt.state       ][INFO    ][20918] Running state [/etc/apt/apt.conf.d/99compression-workaround-salt] at time 01:05:17.852433
2018-02-15 01:05:17,852 [salt.state       ][INFO    ][20918] Executing state file.managed for /etc/apt/apt.conf.d/99compression-workaround-salt
2018-02-15 01:05:17,876 [salt.fileclient  ][INFO    ][20918] Fetching file from saltenv 'base', ** done ** 'linux/files/apt.conf'
2018-02-15 01:05:17,882 [salt.state       ][INFO    ][20918] File changed:
New file
2018-02-15 01:05:17,882 [salt.state       ][INFO    ][20918] Completed state [/etc/apt/apt.conf.d/99compression-workaround-salt] at time 01:05:17.882741 duration_in_ms=30.308
2018-02-15 01:05:17,883 [salt.state       ][INFO    ][20918] Running state [/etc/apt/apt.conf.d/99prefer_ipv4-salt] at time 01:05:17.883196
2018-02-15 01:05:17,883 [salt.state       ][INFO    ][20918] Executing state file.managed for /etc/apt/apt.conf.d/99prefer_ipv4-salt
2018-02-15 01:05:17,900 [salt.state       ][INFO    ][20918] File changed:
New file
2018-02-15 01:05:17,900 [salt.state       ][INFO    ][20918] Completed state [/etc/apt/apt.conf.d/99prefer_ipv4-salt] at time 01:05:17.900557 duration_in_ms=17.361
2018-02-15 01:05:17,901 [salt.state       ][INFO    ][20918] Running state [linux_repo_prereq_pkgs] at time 01:05:17.901617
2018-02-15 01:05:17,902 [salt.state       ][INFO    ][20918] Executing state pkg.installed for linux_repo_prereq_pkgs
2018-02-15 01:05:17,902 [salt.loaded.int.module.cmdmod][INFO    ][20918] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2018-02-15 01:05:18,227 [salt.state       ][INFO    ][20918] All specified packages are already installed
2018-02-15 01:05:18,228 [salt.state       ][INFO    ][20918] Completed state [linux_repo_prereq_pkgs] at time 01:05:18.228530 duration_in_ms=326.911
2018-02-15 01:05:18,229 [salt.state       ][INFO    ][20918] Running state [/etc/apt/apt.conf.d/99proxies-salt-saltstack] at time 01:05:18.229075
2018-02-15 01:05:18,229 [salt.state       ][INFO    ][20918] Executing state file.absent for /etc/apt/apt.conf.d/99proxies-salt-saltstack
2018-02-15 01:05:18,230 [salt.state       ][INFO    ][20918] File /etc/apt/apt.conf.d/99proxies-salt-saltstack is not present
2018-02-15 01:05:18,230 [salt.state       ][INFO    ][20918] Completed state [/etc/apt/apt.conf.d/99proxies-salt-saltstack] at time 01:05:18.230598 duration_in_ms=1.523
2018-02-15 01:05:18,231 [salt.state       ][INFO    ][20918] Running state [/etc/apt/preferences.d/saltstack] at time 01:05:18.231042
2018-02-15 01:05:18,231 [salt.state       ][INFO    ][20918] Executing state file.absent for /etc/apt/preferences.d/saltstack
2018-02-15 01:05:18,232 [salt.state       ][INFO    ][20918] {'removed': '/etc/apt/preferences.d/saltstack'}
2018-02-15 01:05:18,232 [salt.state       ][INFO    ][20918] Completed state [/etc/apt/preferences.d/saltstack] at time 01:05:18.232384 duration_in_ms=1.341
2018-02-15 01:05:18,243 [salt.state       ][INFO    ][20918] Running state [deb http://repo.saltstack.com/apt/ubuntu/16.04/amd64/2016.11 xenial main] at time 01:05:18.243235
2018-02-15 01:05:18,243 [salt.state       ][INFO    ][20918] Executing state pkgrepo.managed for deb http://repo.saltstack.com/apt/ubuntu/16.04/amd64/2016.11 xenial main
2018-02-15 01:05:18,837 [salt.loaded.int.module.cmdmod][INFO    ][20918] Executing command ['apt-key', 'add', '/var/cache/salt/minion/extrn_files/base/repo.saltstack.com/apt/ubuntu/16.04/amd64/2016.11/SALTSTACK-GPG-KEY.pub'] in directory '/root'
2018-02-15 01:05:19,145 [salt.loaded.int.module.cmdmod][INFO    ][20918] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2018-02-15 01:05:23,191 [salt.state       ][INFO    ][20918] Configured package repo 'deb http://repo.saltstack.com/apt/ubuntu/16.04/amd64/2016.11 xenial main'
2018-02-15 01:05:23,192 [salt.state       ][INFO    ][20918] Completed state [deb http://repo.saltstack.com/apt/ubuntu/16.04/amd64/2016.11 xenial main] at time 01:05:23.192317 duration_in_ms=4949.081
2018-02-15 01:05:23,193 [salt.state       ][INFO    ][20918] Running state [/etc/apt/apt.conf.d/99proxies-salt-salt] at time 01:05:23.193370
2018-02-15 01:05:23,194 [salt.state       ][INFO    ][20918] Executing state file.absent for /etc/apt/apt.conf.d/99proxies-salt-salt
2018-02-15 01:05:23,195 [salt.state       ][INFO    ][20918] File /etc/apt/apt.conf.d/99proxies-salt-salt is not present
2018-02-15 01:05:23,196 [salt.state       ][INFO    ][20918] Completed state [/etc/apt/apt.conf.d/99proxies-salt-salt] at time 01:05:23.196207 duration_in_ms=2.837
2018-02-15 01:05:23,197 [salt.state       ][INFO    ][20918] Running state [/etc/apt/preferences.d/salt] at time 01:05:23.197013
2018-02-15 01:05:23,197 [salt.state       ][INFO    ][20918] Executing state file.absent for /etc/apt/preferences.d/salt
2018-02-15 01:05:23,198 [salt.state       ][INFO    ][20918] File /etc/apt/preferences.d/salt is not present
2018-02-15 01:05:23,199 [salt.state       ][INFO    ][20918] Completed state [/etc/apt/preferences.d/salt] at time 01:05:23.199424 duration_in_ms=2.412
2018-02-15 01:05:23,200 [salt.state       ][INFO    ][20918] Running state [linux_repo_salt_absent] at time 01:05:23.200202
2018-02-15 01:05:23,201 [salt.state       ][INFO    ][20918] Executing state pkgrepo.absent for linux_repo_salt_absent
2018-02-15 01:05:23,236 [salt.state       ][INFO    ][20918] Package repo linux_repo_salt_absent is absent
2018-02-15 01:05:23,236 [salt.state       ][INFO    ][20918] Completed state [linux_repo_salt_absent] at time 01:05:23.236712 duration_in_ms=36.511
2018-02-15 01:05:23,237 [salt.state       ][INFO    ][20918] Running state [/etc/apt/sources.list.d/salt.list] at time 01:05:23.237396
2018-02-15 01:05:23,238 [salt.state       ][INFO    ][20918] Executing state file.absent for /etc/apt/sources.list.d/salt.list
2018-02-15 01:05:23,238 [salt.state       ][INFO    ][20918] File /etc/apt/sources.list.d/salt.list is not present
2018-02-15 01:05:23,239 [salt.state       ][INFO    ][20918] Completed state [/etc/apt/sources.list.d/salt.list] at time 01:05:23.239510 duration_in_ms=2.114
2018-02-15 01:05:23,240 [salt.state       ][INFO    ][20918] Running state [/etc/apt/apt.conf.d/99proxies-salt-uca] at time 01:05:23.240202
2018-02-15 01:05:23,240 [salt.state       ][INFO    ][20918] Executing state file.absent for /etc/apt/apt.conf.d/99proxies-salt-uca
2018-02-15 01:05:23,241 [salt.state       ][INFO    ][20918] File /etc/apt/apt.conf.d/99proxies-salt-uca is not present
2018-02-15 01:05:23,242 [salt.state       ][INFO    ][20918] Completed state [/etc/apt/apt.conf.d/99proxies-salt-uca] at time 01:05:23.242267 duration_in_ms=2.064
2018-02-15 01:05:23,243 [salt.state       ][INFO    ][20918] Running state [/etc/apt/preferences.d/uca] at time 01:05:23.242956
2018-02-15 01:05:23,243 [salt.state       ][INFO    ][20918] Executing state file.absent for /etc/apt/preferences.d/uca
2018-02-15 01:05:23,244 [salt.state       ][INFO    ][20918] File /etc/apt/preferences.d/uca is not present
2018-02-15 01:05:23,245 [salt.state       ][INFO    ][20918] Completed state [/etc/apt/preferences.d/uca] at time 01:05:23.244952 duration_in_ms=1.996
2018-02-15 01:05:23,246 [salt.state       ][INFO    ][20918] Running state [deb http://ubuntu-cloud.archive.canonical.com/ubuntu xenial-updates/pike main] at time 01:05:23.246457
2018-02-15 01:05:23,247 [salt.state       ][INFO    ][20918] Executing state pkgrepo.managed for deb http://ubuntu-cloud.archive.canonical.com/ubuntu xenial-updates/pike main
2018-02-15 01:05:23,358 [salt.loaded.int.module.cmdmod][INFO    ][20918] Executing command ['apt-key', 'export', 'EC4926EA'] in directory '/root'
2018-02-15 01:05:23,498 [salt.loaded.int.module.cmdmod][INFO    ][20918] Executing command ['apt-key', 'adv', '--keyserver', 'keyserver.ubuntu.com', '--logger-fd', '1', '--recv-keys', 'EC4926EA'] in directory '/root'
2018-02-15 01:05:23,762 [salt.minion      ][INFO    ][20772] User sudo_ubuntu Executing command saltutil.find_job with jid 20180215010523745833
2018-02-15 01:05:23,791 [salt.minion      ][INFO    ][21481] Starting a new job with PID 21481
2018-02-15 01:05:23,816 [salt.minion      ][INFO    ][21481] Returning information for job: 20180215010523745833
2018-02-15 01:05:24,332 [salt.loaded.int.module.cmdmod][INFO    ][20918] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2018-02-15 01:05:30,431 [salt.state       ][INFO    ][20918] {'repo': 'deb http://ubuntu-cloud.archive.canonical.com/ubuntu xenial-updates/pike main'}
2018-02-15 01:05:30,432 [salt.state       ][INFO    ][20918] Completed state [deb http://ubuntu-cloud.archive.canonical.com/ubuntu xenial-updates/pike main] at time 01:05:30.432694 duration_in_ms=7186.237
2018-02-15 01:05:30,433 [salt.state       ][INFO    ][20918] Running state [/etc/apt/apt.conf.d/99proxies-salt-mcp_salt] at time 01:05:30.433255
2018-02-15 01:05:30,433 [salt.state       ][INFO    ][20918] Executing state file.absent for /etc/apt/apt.conf.d/99proxies-salt-mcp_salt
2018-02-15 01:05:30,434 [salt.state       ][INFO    ][20918] File /etc/apt/apt.conf.d/99proxies-salt-mcp_salt is not present
2018-02-15 01:05:30,434 [salt.state       ][INFO    ][20918] Completed state [/etc/apt/apt.conf.d/99proxies-salt-mcp_salt] at time 01:05:30.434802 duration_in_ms=1.548
2018-02-15 01:05:30,435 [salt.state       ][INFO    ][20918] Running state [/etc/apt/preferences.d/mcp_salt] at time 01:05:30.435249
2018-02-15 01:05:30,435 [salt.state       ][INFO    ][20918] Executing state file.managed for /etc/apt/preferences.d/mcp_salt
2018-02-15 01:05:30,461 [salt.fileclient  ][INFO    ][20918] Fetching file from saltenv 'base', ** done ** 'linux/files/preferences_repo'
2018-02-15 01:05:30,527 [salt.state       ][INFO    ][20918] File changed:
New file
2018-02-15 01:05:30,528 [salt.state       ][INFO    ][20918] Completed state [/etc/apt/preferences.d/mcp_salt] at time 01:05:30.528022 duration_in_ms=92.773
2018-02-15 01:05:30,529 [salt.state       ][INFO    ][20918] Running state [deb [arch=amd64] http://apt.mirantis.com/xenial/ nightly salt] at time 01:05:30.529029
2018-02-15 01:05:30,529 [salt.state       ][INFO    ][20918] Executing state pkgrepo.managed for deb [arch=amd64] http://apt.mirantis.com/xenial/ nightly salt
2018-02-15 01:05:30,758 [salt.loaded.int.module.cmdmod][INFO    ][20918] Executing command ['apt-key', 'add', '/var/cache/salt/minion/extrn_files/base/apt.mirantis.com/public.gpg'] in directory '/root'
2018-02-15 01:05:31,072 [salt.loaded.int.module.cmdmod][INFO    ][20918] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2018-02-15 01:05:33,796 [salt.minion      ][INFO    ][20772] User sudo_ubuntu Executing command saltutil.find_job with jid 20180215010533778196
2018-02-15 01:05:33,818 [salt.minion      ][INFO    ][22406] Starting a new job with PID 22406
2018-02-15 01:05:33,846 [salt.minion      ][INFO    ][22406] Returning information for job: 20180215010533778196
2018-02-15 01:05:35,672 [salt.state       ][INFO    ][20918] {'repo': 'deb [arch=amd64] http://apt.mirantis.com/xenial nightly salt'}
2018-02-15 01:05:35,672 [salt.state       ][INFO    ][20918] Completed state [deb [arch=amd64] http://apt.mirantis.com/xenial/ nightly salt] at time 01:05:35.672520 duration_in_ms=5143.49
2018-02-15 01:05:35,673 [salt.state       ][INFO    ][20918] Running state [linux_extra_packages_purged] at time 01:05:35.673003
2018-02-15 01:05:35,673 [salt.state       ][INFO    ][20918] Executing state pkg.purged for linux_extra_packages_purged
2018-02-15 01:05:35,719 [salt.loaded.int.module.cmdmod][INFO    ][20918] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', 'purge', 'cloud-init', 'unattended-upgrades'] in directory '/root'
2018-02-15 01:05:43,828 [salt.minion      ][INFO    ][20772] User sudo_ubuntu Executing command saltutil.find_job with jid 20180215010543810521
2018-02-15 01:05:43,855 [salt.minion      ][INFO    ][23079] Starting a new job with PID 23079
2018-02-15 01:05:43,877 [salt.minion      ][INFO    ][23079] Returning information for job: 20180215010543810521
2018-02-15 01:05:43,988 [salt.loaded.int.module.cmdmod][INFO    ][20918] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2018-02-15 01:05:44,055 [salt.state       ][INFO    ][20918] {'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-15 01:05:44,078 [salt.state       ][INFO    ][20918] Loading fresh modules for state activity
2018-02-15 01:05:44,108 [salt.state       ][INFO    ][20918] Completed state [linux_extra_packages_purged] at time 01:05:44.108658 duration_in_ms=8435.654
2018-02-15 01:05:44,117 [salt.state       ][INFO    ][20918] Running state [linux_extra_packages_latest] at time 01:05:44.117840
2018-02-15 01:05:44,118 [salt.state       ][INFO    ][20918] Executing state pkg.latest for linux_extra_packages_latest
2018-02-15 01:05:44,447 [salt.loaded.int.module.cmdmod][INFO    ][20918] Executing command ['apt-cache', '-q', 'policy', 'mcelog'] in directory '/root'
2018-02-15 01:05:44,506 [salt.loaded.int.module.cmdmod][INFO    ][20918] Executing command ['dpkg', '--get-selections', '*'] in directory '/root'
2018-02-15 01:05:44,542 [salt.loaded.int.module.cmdmod][INFO    ][20918] 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-15 01:05:50,239 [salt.loaded.int.module.cmdmod][INFO    ][20918] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2018-02-15 01:05:50,302 [salt.state       ][INFO    ][20918] Made the following changes:
'mcelog' changed from 'absent' to '128+dfsg-1'

2018-02-15 01:05:50,321 [salt.state       ][INFO    ][20918] Loading fresh modules for state activity
2018-02-15 01:05:50,351 [salt.state       ][INFO    ][20918] Completed state [linux_extra_packages_latest] at time 01:05:50.351233 duration_in_ms=6233.391
2018-02-15 01:05:50,357 [salt.state       ][INFO    ][20918] Running state [UTC] at time 01:05:50.357889
2018-02-15 01:05:50,358 [salt.state       ][INFO    ][20918] Executing state timezone.system for UTC
2018-02-15 01:05:50,362 [salt.loaded.int.module.cmdmod][INFO    ][20918] Executing command ['timedatectl'] in directory '/root'
2018-02-15 01:05:50,495 [salt.loaded.int.module.cmdmod][INFO    ][20918] Executing command ['timedatectl'] in directory '/root'
2018-02-15 01:05:50,526 [salt.loaded.int.module.cmdmod][INFO    ][20918] Executing command 'timedatectl set-timezone UTC' in directory '/root'
2018-02-15 01:05:50,559 [salt.state       ][INFO    ][20918] {'timezone': 'UTC'}
2018-02-15 01:05:50,560 [salt.state       ][INFO    ][20918] Completed state [UTC] at time 01:05:50.560008 duration_in_ms=202.119
2018-02-15 01:05:50,564 [salt.state       ][INFO    ][20918] Running state [nf_conntrack] at time 01:05:50.564585
2018-02-15 01:05:50,565 [salt.state       ][INFO    ][20918] Executing state kmod.present for nf_conntrack
2018-02-15 01:05:50,566 [salt.loaded.int.module.cmdmod][INFO    ][20918] Executing command 'lsmod' in directory '/root'
2018-02-15 01:05:50,726 [salt.loaded.int.module.cmdmod][INFO    ][20918] Executing command 'lsmod' in directory '/root'
2018-02-15 01:05:50,760 [salt.loaded.int.module.cmdmod][INFO    ][20918] Executing command 'modprobe nf_conntrack' in directory '/root'
2018-02-15 01:05:50,812 [salt.loaded.int.module.cmdmod][INFO    ][20918] Executing command 'lsmod' in directory '/root'
2018-02-15 01:05:50,863 [salt.state       ][INFO    ][20918] {'nf_conntrack': 'loaded'}
2018-02-15 01:05:50,864 [salt.state       ][INFO    ][20918] Completed state [nf_conntrack] at time 01:05:50.864323 duration_in_ms=299.739
2018-02-15 01:05:50,873 [salt.state       ][INFO    ][20918] Running state [kernel.panic] at time 01:05:50.873017
2018-02-15 01:05:50,873 [salt.state       ][INFO    ][20918] Executing state sysctl.present for kernel.panic
2018-02-15 01:05:50,874 [salt.loaded.int.module.cmdmod][INFO    ][20918] Executing command 'sysctl -a' in directory '/root'
2018-02-15 01:05:50,981 [salt.loaded.int.module.cmdmod][INFO    ][20918] Executing command 'sysctl -w kernel.panic="60"' in directory '/root'
2018-02-15 01:05:51,006 [salt.state       ][INFO    ][20918] {'kernel.panic': 60}
2018-02-15 01:05:51,006 [salt.state       ][INFO    ][20918] Completed state [kernel.panic] at time 01:05:51.006430 duration_in_ms=133.413
2018-02-15 01:05:51,006 [salt.state       ][INFO    ][20918] Running state [net.ipv4.tcp_keepalive_probes] at time 01:05:51.006836
2018-02-15 01:05:51,007 [salt.state       ][INFO    ][20918] Executing state sysctl.present for net.ipv4.tcp_keepalive_probes
2018-02-15 01:05:51,007 [salt.loaded.int.module.cmdmod][INFO    ][20918] Executing command 'sysctl -a' in directory '/root'
2018-02-15 01:05:51,059 [salt.loaded.int.module.cmdmod][INFO    ][20918] Executing command 'sysctl -w net.ipv4.tcp_keepalive_probes="8"' in directory '/root'
2018-02-15 01:05:51,082 [salt.state       ][INFO    ][20918] {'net.ipv4.tcp_keepalive_probes': 8}
2018-02-15 01:05:51,083 [salt.state       ][INFO    ][20918] Completed state [net.ipv4.tcp_keepalive_probes] at time 01:05:51.083004 duration_in_ms=76.168
2018-02-15 01:05:51,083 [salt.state       ][INFO    ][20918] Running state [fs.file-max] at time 01:05:51.083352
2018-02-15 01:05:51,083 [salt.state       ][INFO    ][20918] Executing state sysctl.present for fs.file-max
2018-02-15 01:05:51,084 [salt.loaded.int.module.cmdmod][INFO    ][20918] Executing command 'sysctl -a' in directory '/root'
2018-02-15 01:05:51,164 [salt.loaded.int.module.cmdmod][INFO    ][20918] Executing command 'sysctl -w fs.file-max="124165"' in directory '/root'
2018-02-15 01:05:51,191 [salt.state       ][INFO    ][20918] {'fs.file-max': 124165}
2018-02-15 01:05:51,191 [salt.state       ][INFO    ][20918] Completed state [fs.file-max] at time 01:05:51.191830 duration_in_ms=108.477
2018-02-15 01:05:51,192 [salt.state       ][INFO    ][20918] Running state [net.core.somaxconn] at time 01:05:51.192327
2018-02-15 01:05:51,192 [salt.state       ][INFO    ][20918] Executing state sysctl.present for net.core.somaxconn
2018-02-15 01:05:51,193 [salt.loaded.int.module.cmdmod][INFO    ][20918] Executing command 'sysctl -a' in directory '/root'
2018-02-15 01:05:51,261 [salt.loaded.int.module.cmdmod][INFO    ][20918] Executing command 'sysctl -w net.core.somaxconn="4096"' in directory '/root'
2018-02-15 01:05:51,287 [salt.state       ][INFO    ][20918] {'net.core.somaxconn': 4096}
2018-02-15 01:05:51,288 [salt.state       ][INFO    ][20918] Completed state [net.core.somaxconn] at time 01:05:51.288418 duration_in_ms=96.09
2018-02-15 01:05:51,289 [salt.state       ][INFO    ][20918] Running state [net.ipv4.tcp_max_syn_backlog] at time 01:05:51.289119
2018-02-15 01:05:51,289 [salt.state       ][INFO    ][20918] Executing state sysctl.present for net.ipv4.tcp_max_syn_backlog
2018-02-15 01:05:51,291 [salt.loaded.int.module.cmdmod][INFO    ][20918] Executing command 'sysctl -a' in directory '/root'
2018-02-15 01:05:51,375 [salt.loaded.int.module.cmdmod][INFO    ][20918] Executing command 'sysctl -w net.ipv4.tcp_max_syn_backlog="8192"' in directory '/root'
2018-02-15 01:05:51,400 [salt.state       ][INFO    ][20918] {'net.ipv4.tcp_max_syn_backlog': 8192}
2018-02-15 01:05:51,400 [salt.state       ][INFO    ][20918] Completed state [net.ipv4.tcp_max_syn_backlog] at time 01:05:51.400780 duration_in_ms=111.659
2018-02-15 01:05:51,401 [salt.state       ][INFO    ][20918] Running state [net.ipv4.tcp_tw_reuse] at time 01:05:51.401414
2018-02-15 01:05:51,402 [salt.state       ][INFO    ][20918] Executing state sysctl.present for net.ipv4.tcp_tw_reuse
2018-02-15 01:05:51,403 [salt.loaded.int.module.cmdmod][INFO    ][20918] Executing command 'sysctl -a' in directory '/root'
2018-02-15 01:05:51,501 [salt.loaded.int.module.cmdmod][INFO    ][20918] Executing command 'sysctl -w net.ipv4.tcp_tw_reuse="1"' in directory '/root'
2018-02-15 01:05:51,529 [salt.state       ][INFO    ][20918] {'net.ipv4.tcp_tw_reuse': 1}
2018-02-15 01:05:51,529 [salt.state       ][INFO    ][20918] Completed state [net.ipv4.tcp_tw_reuse] at time 01:05:51.529720 duration_in_ms=128.304
2018-02-15 01:05:51,530 [salt.state       ][INFO    ][20918] Running state [net.ipv4.tcp_congestion_control] at time 01:05:51.530373
2018-02-15 01:05:51,531 [salt.state       ][INFO    ][20918] Executing state sysctl.present for net.ipv4.tcp_congestion_control
2018-02-15 01:05:51,532 [salt.loaded.int.module.cmdmod][INFO    ][20918] Executing command 'sysctl -a' in directory '/root'
2018-02-15 01:05:51,611 [salt.loaded.int.module.cmdmod][INFO    ][20918] Executing command 'sysctl -w net.ipv4.tcp_congestion_control="yeah"' in directory '/root'
2018-02-15 01:05:51,670 [salt.state       ][INFO    ][20918] {'net.ipv4.tcp_congestion_control': 'yeah'}
2018-02-15 01:05:51,671 [salt.state       ][INFO    ][20918] Completed state [net.ipv4.tcp_congestion_control] at time 01:05:51.671209 duration_in_ms=140.835
2018-02-15 01:05:51,671 [salt.state       ][INFO    ][20918] Running state [net.ipv4.tcp_retries2] at time 01:05:51.671882
2018-02-15 01:05:51,672 [salt.state       ][INFO    ][20918] Executing state sysctl.present for net.ipv4.tcp_retries2
2018-02-15 01:05:51,673 [salt.loaded.int.module.cmdmod][INFO    ][20918] Executing command 'sysctl -a' in directory '/root'
2018-02-15 01:05:51,753 [salt.loaded.int.module.cmdmod][INFO    ][20918] Executing command 'sysctl -w net.ipv4.tcp_retries2="5"' in directory '/root'
2018-02-15 01:05:51,780 [salt.state       ][INFO    ][20918] {'net.ipv4.tcp_retries2': 5}
2018-02-15 01:05:51,781 [salt.state       ][INFO    ][20918] Completed state [net.ipv4.tcp_retries2] at time 01:05:51.781235 duration_in_ms=109.353
2018-02-15 01:05:51,781 [salt.state       ][INFO    ][20918] Running state [net.ipv4.tcp_keepalive_intvl] at time 01:05:51.781844
2018-02-15 01:05:51,782 [salt.state       ][INFO    ][20918] Executing state sysctl.present for net.ipv4.tcp_keepalive_intvl
2018-02-15 01:05:51,783 [salt.loaded.int.module.cmdmod][INFO    ][20918] Executing command 'sysctl -a' in directory '/root'
2018-02-15 01:05:51,863 [salt.loaded.int.module.cmdmod][INFO    ][20918] Executing command 'sysctl -w net.ipv4.tcp_keepalive_intvl="3"' in directory '/root'
2018-02-15 01:05:51,890 [salt.state       ][INFO    ][20918] {'net.ipv4.tcp_keepalive_intvl': 3}
2018-02-15 01:05:51,892 [salt.state       ][INFO    ][20918] Completed state [net.ipv4.tcp_keepalive_intvl] at time 01:05:51.892088 duration_in_ms=110.244
2018-02-15 01:05:51,893 [salt.state       ][INFO    ][20918] Running state [net.ipv4.tcp_slow_start_after_idle] at time 01:05:51.893230
2018-02-15 01:05:51,894 [salt.state       ][INFO    ][20918] Executing state sysctl.present for net.ipv4.tcp_slow_start_after_idle
2018-02-15 01:05:51,896 [salt.loaded.int.module.cmdmod][INFO    ][20918] Executing command 'sysctl -a' in directory '/root'
2018-02-15 01:05:51,964 [salt.loaded.int.module.cmdmod][INFO    ][20918] Executing command 'sysctl -w net.ipv4.tcp_slow_start_after_idle="0"' in directory '/root'
2018-02-15 01:05:51,995 [salt.state       ][INFO    ][20918] {'net.ipv4.tcp_slow_start_after_idle': 0}
2018-02-15 01:05:51,997 [salt.state       ][INFO    ][20918] Completed state [net.ipv4.tcp_slow_start_after_idle] at time 01:05:51.997200 duration_in_ms=103.969
2018-02-15 01:05:51,998 [salt.state       ][INFO    ][20918] Running state [vm.swappiness] at time 01:05:51.998470
2018-02-15 01:05:51,999 [salt.state       ][INFO    ][20918] Executing state sysctl.present for vm.swappiness
2018-02-15 01:05:52,001 [salt.loaded.int.module.cmdmod][INFO    ][20918] Executing command 'sysctl -a' in directory '/root'
2018-02-15 01:05:52,072 [salt.loaded.int.module.cmdmod][INFO    ][20918] Executing command 'sysctl -w vm.swappiness="10"' in directory '/root'
2018-02-15 01:05:52,104 [salt.state       ][INFO    ][20918] {'vm.swappiness': 10}
2018-02-15 01:05:52,105 [salt.state       ][INFO    ][20918] Completed state [vm.swappiness] at time 01:05:52.105272 duration_in_ms=106.802
2018-02-15 01:05:52,106 [salt.state       ][INFO    ][20918] Running state [net.core.netdev_max_backlog] at time 01:05:52.106577
2018-02-15 01:05:52,107 [salt.state       ][INFO    ][20918] Executing state sysctl.present for net.core.netdev_max_backlog
2018-02-15 01:05:52,109 [salt.loaded.int.module.cmdmod][INFO    ][20918] Executing command 'sysctl -a' in directory '/root'
2018-02-15 01:05:52,189 [salt.loaded.int.module.cmdmod][INFO    ][20918] Executing command 'sysctl -w net.core.netdev_max_backlog="261144"' in directory '/root'
2018-02-15 01:05:52,217 [salt.state       ][INFO    ][20918] {'net.core.netdev_max_backlog': 261144}
2018-02-15 01:05:52,218 [salt.state       ][INFO    ][20918] Completed state [net.core.netdev_max_backlog] at time 01:05:52.218500 duration_in_ms=111.924
2018-02-15 01:05:52,219 [salt.state       ][INFO    ][20918] Running state [net.ipv4.neigh.default.gc_thresh1] at time 01:05:52.219368
2018-02-15 01:05:52,220 [salt.state       ][INFO    ][20918] Executing state sysctl.present for net.ipv4.neigh.default.gc_thresh1
2018-02-15 01:05:52,221 [salt.loaded.int.module.cmdmod][INFO    ][20918] Executing command 'sysctl -a' in directory '/root'
2018-02-15 01:05:52,306 [salt.loaded.int.module.cmdmod][INFO    ][20918] Executing command 'sysctl -w net.ipv4.neigh.default.gc_thresh1="4096"' in directory '/root'
2018-02-15 01:05:52,334 [salt.state       ][INFO    ][20918] {'net.ipv4.neigh.default.gc_thresh1': 4096}
2018-02-15 01:05:52,335 [salt.state       ][INFO    ][20918] Completed state [net.ipv4.neigh.default.gc_thresh1] at time 01:05:52.335526 duration_in_ms=116.158
2018-02-15 01:05:52,336 [salt.state       ][INFO    ][20918] Running state [net.ipv4.neigh.default.gc_thresh2] at time 01:05:52.336181
2018-02-15 01:05:52,336 [salt.state       ][INFO    ][20918] Executing state sysctl.present for net.ipv4.neigh.default.gc_thresh2
2018-02-15 01:05:52,338 [salt.loaded.int.module.cmdmod][INFO    ][20918] Executing command 'sysctl -a' in directory '/root'
2018-02-15 01:05:52,417 [salt.loaded.int.module.cmdmod][INFO    ][20918] Executing command 'sysctl -w net.ipv4.neigh.default.gc_thresh2="8192"' in directory '/root'
2018-02-15 01:05:52,449 [salt.state       ][INFO    ][20918] {'net.ipv4.neigh.default.gc_thresh2': 8192}
2018-02-15 01:05:52,451 [salt.state       ][INFO    ][20918] Completed state [net.ipv4.neigh.default.gc_thresh2] at time 01:05:52.451109 duration_in_ms=114.927
2018-02-15 01:05:52,452 [salt.state       ][INFO    ][20918] Running state [net.ipv4.neigh.default.gc_thresh3] at time 01:05:52.452208
2018-02-15 01:05:52,453 [salt.state       ][INFO    ][20918] Executing state sysctl.present for net.ipv4.neigh.default.gc_thresh3
2018-02-15 01:05:52,454 [salt.loaded.int.module.cmdmod][INFO    ][20918] Executing command 'sysctl -a' in directory '/root'
2018-02-15 01:05:52,537 [salt.loaded.int.module.cmdmod][INFO    ][20918] Executing command 'sysctl -w net.ipv4.neigh.default.gc_thresh3="16384"' in directory '/root'
2018-02-15 01:05:52,566 [salt.state       ][INFO    ][20918] {'net.ipv4.neigh.default.gc_thresh3': 16384}
2018-02-15 01:05:52,566 [salt.state       ][INFO    ][20918] Completed state [net.ipv4.neigh.default.gc_thresh3] at time 01:05:52.566894 duration_in_ms=114.686
2018-02-15 01:05:52,567 [salt.state       ][INFO    ][20918] Running state [net.ipv4.tcp_fin_timeout] at time 01:05:52.567367
2018-02-15 01:05:52,567 [salt.state       ][INFO    ][20918] Executing state sysctl.present for net.ipv4.tcp_fin_timeout
2018-02-15 01:05:52,568 [salt.loaded.int.module.cmdmod][INFO    ][20918] Executing command 'sysctl -a' in directory '/root'
2018-02-15 01:05:52,649 [salt.loaded.int.module.cmdmod][INFO    ][20918] Executing command 'sysctl -w net.ipv4.tcp_fin_timeout="30"' in directory '/root'
2018-02-15 01:05:52,680 [salt.state       ][INFO    ][20918] {'net.ipv4.tcp_fin_timeout': 30}
2018-02-15 01:05:52,681 [salt.state       ][INFO    ][20918] Completed state [net.ipv4.tcp_fin_timeout] at time 01:05:52.681396 duration_in_ms=114.027
2018-02-15 01:05:52,682 [salt.state       ][INFO    ][20918] Running state [net.ipv4.tcp_keepalive_time] at time 01:05:52.682739
2018-02-15 01:05:52,683 [salt.state       ][INFO    ][20918] Executing state sysctl.present for net.ipv4.tcp_keepalive_time
2018-02-15 01:05:52,686 [salt.loaded.int.module.cmdmod][INFO    ][20918] Executing command 'sysctl -a' in directory '/root'
2018-02-15 01:05:52,768 [salt.loaded.int.module.cmdmod][INFO    ][20918] Executing command 'sysctl -w net.ipv4.tcp_keepalive_time="30"' in directory '/root'
2018-02-15 01:05:52,795 [salt.state       ][INFO    ][20918] {'net.ipv4.tcp_keepalive_time': 30}
2018-02-15 01:05:52,796 [salt.state       ][INFO    ][20918] Completed state [net.ipv4.tcp_keepalive_time] at time 01:05:52.796843 duration_in_ms=114.104
2018-02-15 01:05:52,797 [salt.state       ][INFO    ][20918] Running state [net.nf_conntrack_max] at time 01:05:52.797718
2018-02-15 01:05:52,798 [salt.state       ][INFO    ][20918] Executing state sysctl.present for net.nf_conntrack_max
2018-02-15 01:05:52,799 [salt.loaded.int.module.cmdmod][INFO    ][20918] Executing command 'sysctl -a' in directory '/root'
2018-02-15 01:05:52,865 [salt.loaded.int.module.cmdmod][INFO    ][20918] Executing command 'sysctl -w net.nf_conntrack_max="1048576"' in directory '/root'
2018-02-15 01:05:52,893 [salt.state       ][INFO    ][20918] {'net.nf_conntrack_max': 1048576}
2018-02-15 01:05:52,893 [salt.state       ][INFO    ][20918] Completed state [net.nf_conntrack_max] at time 01:05:52.893856 duration_in_ms=96.137
2018-02-15 01:05:52,904 [salt.state       ][INFO    ][20918] Running state [linux_sysfs_package] at time 01:05:52.904833
2018-02-15 01:05:52,905 [salt.state       ][INFO    ][20918] Executing state pkg.installed for linux_sysfs_package
2018-02-15 01:05:53,259 [salt.loaded.int.module.cmdmod][INFO    ][20918] Executing command ['apt-cache', '-q', 'policy', 'sysfsutils'] in directory '/root'
2018-02-15 01:05:53,361 [salt.loaded.int.module.cmdmod][INFO    ][20918] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2018-02-15 01:05:53,864 [salt.minion      ][INFO    ][20772] User sudo_ubuntu Executing command saltutil.find_job with jid 20180215010553849135
2018-02-15 01:05:53,892 [salt.minion      ][INFO    ][23746] Starting a new job with PID 23746
2018-02-15 01:05:53,913 [salt.minion      ][INFO    ][23746] Returning information for job: 20180215010553849135
2018-02-15 01:05:56,049 [salt.loaded.int.module.cmdmod][INFO    ][20918] Executing command ['dpkg', '--get-selections', '*'] in directory '/root'
2018-02-15 01:05:56,101 [salt.loaded.int.module.cmdmod][INFO    ][20918] 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-15 01:06:02,208 [salt.loaded.int.module.cmdmod][INFO    ][20918] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2018-02-15 01:06:02,264 [salt.state       ][INFO    ][20918] 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-15 01:06:02,281 [salt.state       ][INFO    ][20918] Loading fresh modules for state activity
2018-02-15 01:06:02,307 [salt.state       ][INFO    ][20918] Completed state [linux_sysfs_package] at time 01:06:02.307174 duration_in_ms=9402.339
2018-02-15 01:06:02,311 [salt.state       ][INFO    ][20918] Running state [/etc/sysfs.d] at time 01:06:02.311790
2018-02-15 01:06:02,312 [salt.state       ][INFO    ][20918] Executing state file.directory for /etc/sysfs.d
2018-02-15 01:06:02,317 [salt.state       ][INFO    ][20918] Directory /etc/sysfs.d is in the correct state
2018-02-15 01:06:02,317 [salt.state       ][INFO    ][20918] Completed state [/etc/sysfs.d] at time 01:06:02.317561 duration_in_ms=5.771
2018-02-15 01:06:02,499 [salt.state       ][INFO    ][20918] Running state [ondemand] at time 01:06:02.499368
2018-02-15 01:06:02,499 [salt.state       ][INFO    ][20918] Executing state service.dead for ondemand
2018-02-15 01:06:02,501 [salt.loaded.int.module.cmdmod][INFO    ][20918] Executing command ['systemctl', 'status', 'ondemand.service', '-n', '0'] in directory '/root'
2018-02-15 01:06:02,527 [salt.loaded.int.module.cmdmod][INFO    ][20918] Executing command ['systemctl', 'is-active', 'ondemand.service'] in directory '/root'
2018-02-15 01:06:02,553 [salt.loaded.int.module.cmdmod][INFO    ][20918] Executing command ['systemctl', 'is-enabled', 'ondemand.service'] in directory '/root'
2018-02-15 01:06:02,575 [salt.loaded.int.module.cmdmod][INFO    ][20918] Executing command ['systemd-run', '--scope', 'systemctl', 'stop', 'ondemand.service'] in directory '/root'
2018-02-15 01:06:02,704 [salt.loaded.int.module.cmdmod][INFO    ][20918] Executing command ['systemctl', 'is-active', 'ondemand.service'] in directory '/root'
2018-02-15 01:06:02,728 [salt.loaded.int.module.cmdmod][INFO    ][20918] Executing command ['systemctl', 'is-enabled', 'ondemand.service'] in directory '/root'
2018-02-15 01:06:02,757 [salt.loaded.int.module.cmdmod][INFO    ][20918] Executing command ['systemctl', 'is-enabled', 'ondemand.service'] in directory '/root'
2018-02-15 01:06:02,790 [salt.loaded.int.module.cmdmod][INFO    ][20918] Executing command ['systemd-run', '--scope', '/usr/sbin/update-rc.d', '-f', 'ondemand', 'remove'] in directory '/root'
2018-02-15 01:06:02,994 [salt.loaded.int.module.cmdmod][INFO    ][20918] Executing command ['systemctl', 'is-enabled', 'ondemand.service'] in directory '/root'
2018-02-15 01:06:03,035 [salt.loaded.int.module.cmdmod][INFO    ][20918] Executing command 'runlevel' in directory '/root'
2018-02-15 01:06:03,063 [salt.state       ][INFO    ][20918] {'ondemand': True}
2018-02-15 01:06:03,064 [salt.state       ][INFO    ][20918] Completed state [ondemand] at time 01:06:03.064423 duration_in_ms=565.055
2018-02-15 01:06:03,071 [salt.state       ][INFO    ][20918] Running state [cs_CZ.UTF-8] at time 01:06:03.071699
2018-02-15 01:06:03,072 [salt.state       ][INFO    ][20918] Executing state locale.present for cs_CZ.UTF-8
2018-02-15 01:06:03,073 [salt.loaded.int.module.cmdmod][INFO    ][20918] Executing command 'locale -a' in directory '/root'
2018-02-15 01:06:03,108 [salt.loaded.int.module.cmdmod][INFO    ][20918] Executing command ['locale-gen', 'cs_CZ.utf8'] in directory '/root'
2018-02-15 01:06:03,909 [salt.minion      ][INFO    ][20772] User sudo_ubuntu Executing command saltutil.find_job with jid 20180215010603889684
2018-02-15 01:06:03,939 [salt.minion      ][INFO    ][24532] Starting a new job with PID 24532
2018-02-15 01:06:03,967 [salt.minion      ][INFO    ][24532] Returning information for job: 20180215010603889684
2018-02-15 01:06:04,051 [salt.state       ][INFO    ][20918] {'locale': 'cs_CZ.UTF-8'}
2018-02-15 01:06:04,052 [salt.state       ][INFO    ][20918] Completed state [cs_CZ.UTF-8] at time 01:06:04.052709 duration_in_ms=981.008
2018-02-15 01:06:04,053 [salt.state       ][INFO    ][20918] Running state [en_US.UTF-8] at time 01:06:04.053730
2018-02-15 01:06:04,054 [salt.state       ][INFO    ][20918] Executing state locale.present for en_US.UTF-8
2018-02-15 01:06:04,056 [salt.loaded.int.module.cmdmod][INFO    ][20918] Executing command 'locale -a' in directory '/root'
2018-02-15 01:06:04,087 [salt.state       ][INFO    ][20918] Locale en_US.UTF-8 is already present
2018-02-15 01:06:04,088 [salt.state       ][INFO    ][20918] Completed state [en_US.UTF-8] at time 01:06:04.088470 duration_in_ms=34.74
2018-02-15 01:06:04,091 [salt.state       ][INFO    ][20918] Running state [en_US.UTF-8] at time 01:06:04.091401
2018-02-15 01:06:04,092 [salt.state       ][INFO    ][20918] Executing state locale.system for en_US.UTF-8
2018-02-15 01:06:04,093 [salt.loaded.int.module.cmdmod][INFO    ][20918] Executing command 'localectl' in directory '/root'
2018-02-15 01:06:04,240 [salt.state       ][INFO    ][20918] System locale en_US.UTF-8 already set
2018-02-15 01:06:04,241 [salt.state       ][INFO    ][20918] Completed state [en_US.UTF-8] at time 01:06:04.241332 duration_in_ms=149.931
2018-02-15 01:06:04,246 [salt.state       ][INFO    ][20918] Running state [root] at time 01:06:04.246021
2018-02-15 01:06:04,247 [salt.state       ][INFO    ][20918] Executing state user.present for root
2018-02-15 01:06:04,259 [salt.state       ][INFO    ][20918] User root is present and up to date
2018-02-15 01:06:04,260 [salt.state       ][INFO    ][20918] Completed state [root] at time 01:06:04.260210 duration_in_ms=14.189
2018-02-15 01:06:04,262 [salt.state       ][INFO    ][20918] Running state [/root] at time 01:06:04.262704
2018-02-15 01:06:04,263 [salt.state       ][INFO    ][20918] Executing state file.directory for /root
2018-02-15 01:06:04,265 [salt.state       ][INFO    ][20918] Directory /root is in the correct state
2018-02-15 01:06:04,266 [salt.state       ][INFO    ][20918] Completed state [/root] at time 01:06:04.266447 duration_in_ms=3.743
2018-02-15 01:06:04,267 [salt.state       ][INFO    ][20918] Running state [/etc/sudoers.d/90-salt-user-root] at time 01:06:04.267416
2018-02-15 01:06:04,268 [salt.state       ][INFO    ][20918] Executing state file.absent for /etc/sudoers.d/90-salt-user-root
2018-02-15 01:06:04,269 [salt.state       ][INFO    ][20918] File /etc/sudoers.d/90-salt-user-root is not present
2018-02-15 01:06:04,270 [salt.state       ][INFO    ][20918] Completed state [/etc/sudoers.d/90-salt-user-root] at time 01:06:04.270242 duration_in_ms=2.826
2018-02-15 01:06:04,271 [salt.state       ][INFO    ][20918] Running state [salt] at time 01:06:04.271170
2018-02-15 01:06:04,272 [salt.state       ][INFO    ][20918] Executing state user.present for salt
2018-02-15 01:06:04,274 [salt.state       ][INFO    ][20918] User salt is present and up to date
2018-02-15 01:06:04,275 [salt.state       ][INFO    ][20918] Completed state [salt] at time 01:06:04.275181 duration_in_ms=4.01
2018-02-15 01:06:04,277 [salt.state       ][INFO    ][20918] Running state [/var/tmp/salt] at time 01:06:04.277159
2018-02-15 01:06:04,278 [salt.state       ][INFO    ][20918] Executing state file.directory for /var/tmp/salt
2018-02-15 01:06:04,279 [salt.state       ][INFO    ][20918] Directory /var/tmp/salt is in the correct state
2018-02-15 01:06:04,280 [salt.state       ][INFO    ][20918] Completed state [/var/tmp/salt] at time 01:06:04.280502 duration_in_ms=3.343
2018-02-15 01:06:04,281 [salt.state       ][INFO    ][20918] Running state [/etc/sudoers.d/90-salt-user-salt] at time 01:06:04.281356
2018-02-15 01:06:04,282 [salt.state       ][INFO    ][20918] Executing state file.absent for /etc/sudoers.d/90-salt-user-salt
2018-02-15 01:06:04,283 [salt.state       ][INFO    ][20918] File /etc/sudoers.d/90-salt-user-salt is not present
2018-02-15 01:06:04,284 [salt.state       ][INFO    ][20918] Completed state [/etc/sudoers.d/90-salt-user-salt] at time 01:06:04.283974 duration_in_ms=2.618
2018-02-15 01:06:04,284 [salt.state       ][INFO    ][20918] Running state [ubuntu] at time 01:06:04.284839
2018-02-15 01:06:04,285 [salt.state       ][INFO    ][20918] Executing state user.present for ubuntu
2018-02-15 01:06:04,287 [salt.state       ][INFO    ][20918] User ubuntu is present and up to date
2018-02-15 01:06:04,288 [salt.state       ][INFO    ][20918] Completed state [ubuntu] at time 01:06:04.288678 duration_in_ms=3.84
2018-02-15 01:06:04,290 [salt.state       ][INFO    ][20918] Running state [/home/ubuntu] at time 01:06:04.290560
2018-02-15 01:06:04,291 [salt.state       ][INFO    ][20918] Executing state file.directory for /home/ubuntu
2018-02-15 01:06:04,292 [salt.state       ][INFO    ][20918] Directory /home/ubuntu is in the correct state
2018-02-15 01:06:04,293 [salt.state       ][INFO    ][20918] Completed state [/home/ubuntu] at time 01:06:04.293611 duration_in_ms=3.051
2018-02-15 01:06:04,295 [salt.state       ][INFO    ][20918] Running state [/etc/sudoers.d/90-salt-user-ubuntu] at time 01:06:04.295236
2018-02-15 01:06:04,296 [salt.state       ][INFO    ][20918] Executing state file.managed for /etc/sudoers.d/90-salt-user-ubuntu
2018-02-15 01:06:04,326 [salt.state       ][INFO    ][20918] File /etc/sudoers.d/90-salt-user-ubuntu is in the correct state
2018-02-15 01:06:04,327 [salt.state       ][INFO    ][20918] Completed state [/etc/sudoers.d/90-salt-user-ubuntu] at time 01:06:04.327221 duration_in_ms=31.985
2018-02-15 01:06:04,328 [salt.state       ][INFO    ][20918] Running state [/etc/security/limits.d/90-salt-default.conf] at time 01:06:04.328056
2018-02-15 01:06:04,328 [salt.state       ][INFO    ][20918] Executing state file.managed for /etc/security/limits.d/90-salt-default.conf
2018-02-15 01:06:04,368 [salt.fileclient  ][INFO    ][20918] Fetching file from saltenv 'base', ** done ** 'linux/files/limits.conf'
2018-02-15 01:06:04,456 [salt.state       ][INFO    ][20918] File changed:
New file
2018-02-15 01:06:04,457 [salt.state       ][INFO    ][20918] Completed state [/etc/security/limits.d/90-salt-default.conf] at time 01:06:04.457504 duration_in_ms=129.448
2018-02-15 01:06:04,458 [salt.state       ][INFO    ][20918] Running state [/etc/systemd/system.conf.d/90-salt.conf] at time 01:06:04.458163
2018-02-15 01:06:04,458 [salt.state       ][INFO    ][20918] Executing state file.managed for /etc/systemd/system.conf.d/90-salt.conf
2018-02-15 01:06:04,486 [salt.fileclient  ][INFO    ][20918] Fetching file from saltenv 'base', ** done ** 'linux/files/systemd.conf'
2018-02-15 01:06:04,559 [salt.state       ][INFO    ][20918] File changed:
New file
2018-02-15 01:06:04,559 [salt.state       ][INFO    ][20918] Completed state [/etc/systemd/system.conf.d/90-salt.conf] at time 01:06:04.559717 duration_in_ms=101.554
2018-02-15 01:06:04,561 [salt.state       ][INFO    ][20918] Running state [service.systemctl_reload] at time 01:06:04.561299
2018-02-15 01:06:04,561 [salt.state       ][INFO    ][20918] Executing state module.wait for service.systemctl_reload
2018-02-15 01:06:04,562 [salt.state       ][INFO    ][20918] No changes made for service.systemctl_reload
2018-02-15 01:06:04,562 [salt.state       ][INFO    ][20918] Completed state [service.systemctl_reload] at time 01:06:04.562951 duration_in_ms=1.652
2018-02-15 01:06:04,563 [salt.state       ][INFO    ][20918] Running state [service.systemctl_reload] at time 01:06:04.563454
2018-02-15 01:06:04,563 [salt.state       ][INFO    ][20918] Executing state module.mod_watch for service.systemctl_reload
2018-02-15 01:06:04,564 [salt.loaded.int.module.cmdmod][INFO    ][20918] Executing command ['systemctl', '--system', 'daemon-reload'] in directory '/root'
2018-02-15 01:06:04,704 [salt.state       ][INFO    ][20918] {'ret': True}
2018-02-15 01:06:04,705 [salt.state       ][INFO    ][20918] Completed state [service.systemctl_reload] at time 01:06:04.705454 duration_in_ms=141.999
2018-02-15 01:06:04,706 [salt.state       ][INFO    ][20918] Running state [/etc/hostname] at time 01:06:04.706227
2018-02-15 01:06:04,706 [salt.state       ][INFO    ][20918] Executing state file.managed for /etc/hostname
2018-02-15 01:06:04,756 [salt.fileclient  ][INFO    ][20918] Fetching file from saltenv 'base', ** done ** 'linux/files/hostname'
2018-02-15 01:06:04,761 [salt.state       ][INFO    ][20918] File /etc/hostname is in the correct state
2018-02-15 01:06:04,762 [salt.state       ][INFO    ][20918] Completed state [/etc/hostname] at time 01:06:04.762125 duration_in_ms=55.898
2018-02-15 01:06:04,766 [salt.state       ][INFO    ][20918] Running state [hostname cfg01] at time 01:06:04.766547
2018-02-15 01:06:04,767 [salt.state       ][INFO    ][20918] Executing state cmd.wait for hostname cfg01
2018-02-15 01:06:04,768 [salt.state       ][INFO    ][20918] No changes made for hostname cfg01
2018-02-15 01:06:04,769 [salt.state       ][INFO    ][20918] Completed state [hostname cfg01] at time 01:06:04.769229 duration_in_ms=2.681
2018-02-15 01:06:04,771 [salt.state       ][INFO    ][20918] Running state [mdb02] at time 01:06:04.771211
2018-02-15 01:06:04,772 [salt.state       ][INFO    ][20918] Executing state host.present for mdb02
2018-02-15 01:06:04,775 [salt.state       ][INFO    ][20918] {'host': 'mdb02'}
2018-02-15 01:06:04,776 [salt.state       ][INFO    ][20918] Completed state [mdb02] at time 01:06:04.776717 duration_in_ms=5.506
2018-02-15 01:06:04,777 [salt.state       ][INFO    ][20918] Running state [mdb02.mcp-pike-odl-ha.local] at time 01:06:04.777570
2018-02-15 01:06:04,778 [salt.state       ][INFO    ][20918] Executing state host.present for mdb02.mcp-pike-odl-ha.local
2018-02-15 01:06:04,782 [salt.state       ][INFO    ][20918] {'host': 'mdb02.mcp-pike-odl-ha.local'}
2018-02-15 01:06:04,782 [salt.state       ][INFO    ][20918] Completed state [mdb02.mcp-pike-odl-ha.local] at time 01:06:04.782911 duration_in_ms=5.34
2018-02-15 01:06:04,783 [salt.state       ][INFO    ][20918] Running state [mdb03] at time 01:06:04.783729
2018-02-15 01:06:04,784 [salt.state       ][INFO    ][20918] Executing state host.present for mdb03
2018-02-15 01:06:04,788 [salt.state       ][INFO    ][20918] {'host': 'mdb03'}
2018-02-15 01:06:04,788 [salt.state       ][INFO    ][20918] Completed state [mdb03] at time 01:06:04.788748 duration_in_ms=5.019
2018-02-15 01:06:04,789 [salt.state       ][INFO    ][20918] Running state [mdb03.mcp-pike-odl-ha.local] at time 01:06:04.789578
2018-02-15 01:06:04,790 [salt.state       ][INFO    ][20918] Executing state host.present for mdb03.mcp-pike-odl-ha.local
2018-02-15 01:06:04,794 [salt.state       ][INFO    ][20918] {'host': 'mdb03.mcp-pike-odl-ha.local'}
2018-02-15 01:06:04,794 [salt.state       ][INFO    ][20918] Completed state [mdb03.mcp-pike-odl-ha.local] at time 01:06:04.794830 duration_in_ms=5.252
2018-02-15 01:06:04,795 [salt.state       ][INFO    ][20918] Running state [mdb01] at time 01:06:04.795637
2018-02-15 01:06:04,796 [salt.state       ][INFO    ][20918] Executing state host.present for mdb01
2018-02-15 01:06:04,800 [salt.state       ][INFO    ][20918] {'host': 'mdb01'}
2018-02-15 01:06:04,800 [salt.state       ][INFO    ][20918] Completed state [mdb01] at time 01:06:04.800842 duration_in_ms=5.204
2018-02-15 01:06:04,801 [salt.state       ][INFO    ][20918] Running state [mdb01.mcp-pike-odl-ha.local] at time 01:06:04.801654
2018-02-15 01:06:04,802 [salt.state       ][INFO    ][20918] Executing state host.present for mdb01.mcp-pike-odl-ha.local
2018-02-15 01:06:04,806 [salt.state       ][INFO    ][20918] {'host': 'mdb01.mcp-pike-odl-ha.local'}
2018-02-15 01:06:04,806 [salt.state       ][INFO    ][20918] Completed state [mdb01.mcp-pike-odl-ha.local] at time 01:06:04.806906 duration_in_ms=5.253
2018-02-15 01:06:04,807 [salt.state       ][INFO    ][20918] Running state [mdb] at time 01:06:04.807707
2018-02-15 01:06:04,808 [salt.state       ][INFO    ][20918] Executing state host.present for mdb
2018-02-15 01:06:04,811 [salt.state       ][INFO    ][20918] {'host': 'mdb'}
2018-02-15 01:06:04,812 [salt.state       ][INFO    ][20918] Completed state [mdb] at time 01:06:04.812483 duration_in_ms=4.777
2018-02-15 01:06:04,813 [salt.state       ][INFO    ][20918] Running state [mdb.mcp-pike-odl-ha.local] at time 01:06:04.813304
2018-02-15 01:06:04,814 [salt.state       ][INFO    ][20918] Executing state host.present for mdb.mcp-pike-odl-ha.local
2018-02-15 01:06:04,817 [salt.state       ][INFO    ][20918] {'host': 'mdb.mcp-pike-odl-ha.local'}
2018-02-15 01:06:04,818 [salt.state       ][INFO    ][20918] Completed state [mdb.mcp-pike-odl-ha.local] at time 01:06:04.818573 duration_in_ms=5.27
2018-02-15 01:06:04,819 [salt.state       ][INFO    ][20918] Running state [cfg01] at time 01:06:04.819363
2018-02-15 01:06:04,820 [salt.state       ][INFO    ][20918] Executing state host.present for cfg01
2018-02-15 01:06:04,823 [salt.state       ][INFO    ][20918] {'host': 'cfg01'}
2018-02-15 01:06:04,824 [salt.state       ][INFO    ][20918] Completed state [cfg01] at time 01:06:04.824484 duration_in_ms=5.121
2018-02-15 01:06:04,825 [salt.state       ][INFO    ][20918] Running state [cfg01.mcp-pike-odl-ha.local] at time 01:06:04.825299
2018-02-15 01:06:04,826 [salt.state       ][INFO    ][20918] Executing state host.present for cfg01.mcp-pike-odl-ha.local
2018-02-15 01:06:04,829 [salt.state       ][INFO    ][20918] {'host': 'cfg01.mcp-pike-odl-ha.local'}
2018-02-15 01:06:04,830 [salt.state       ][INFO    ][20918] Completed state [cfg01.mcp-pike-odl-ha.local] at time 01:06:04.830672 duration_in_ms=5.372
2018-02-15 01:06:04,831 [salt.state       ][INFO    ][20918] Running state [prx01] at time 01:06:04.831482
2018-02-15 01:06:04,832 [salt.state       ][INFO    ][20918] Executing state host.present for prx01
2018-02-15 01:06:04,835 [salt.state       ][INFO    ][20918] {'host': 'prx01'}
2018-02-15 01:06:04,836 [salt.state       ][INFO    ][20918] Completed state [prx01] at time 01:06:04.836647 duration_in_ms=5.165
2018-02-15 01:06:04,837 [salt.state       ][INFO    ][20918] Running state [prx01.mcp-pike-odl-ha.local] at time 01:06:04.837477
2018-02-15 01:06:04,838 [salt.state       ][INFO    ][20918] Executing state host.present for prx01.mcp-pike-odl-ha.local
2018-02-15 01:06:04,841 [salt.state       ][INFO    ][20918] {'host': 'prx01.mcp-pike-odl-ha.local'}
2018-02-15 01:06:04,842 [salt.state       ][INFO    ][20918] Completed state [prx01.mcp-pike-odl-ha.local] at time 01:06:04.842673 duration_in_ms=5.196
2018-02-15 01:06:04,843 [salt.state       ][INFO    ][20918] Running state [kvm01] at time 01:06:04.843489
2018-02-15 01:06:04,844 [salt.state       ][INFO    ][20918] Executing state host.present for kvm01
2018-02-15 01:06:04,847 [salt.state       ][INFO    ][20918] {'host': 'kvm01'}
2018-02-15 01:06:04,848 [salt.state       ][INFO    ][20918] Completed state [kvm01] at time 01:06:04.848692 duration_in_ms=5.204
2018-02-15 01:06:04,849 [salt.state       ][INFO    ][20918] Running state [kvm01.mcp-pike-odl-ha.local] at time 01:06:04.849531
2018-02-15 01:06:04,850 [salt.state       ][INFO    ][20918] Executing state host.present for kvm01.mcp-pike-odl-ha.local
2018-02-15 01:06:04,853 [salt.state       ][INFO    ][20918] {'host': 'kvm01.mcp-pike-odl-ha.local'}
2018-02-15 01:06:04,854 [salt.state       ][INFO    ][20918] Completed state [kvm01.mcp-pike-odl-ha.local] at time 01:06:04.854713 duration_in_ms=5.181
2018-02-15 01:06:04,855 [salt.state       ][INFO    ][20918] Running state [kvm03] at time 01:06:04.855543
2018-02-15 01:06:04,856 [salt.state       ][INFO    ][20918] Executing state host.present for kvm03
2018-02-15 01:06:04,860 [salt.state       ][INFO    ][20918] {'host': 'kvm03'}
2018-02-15 01:06:04,861 [salt.state       ][INFO    ][20918] Completed state [kvm03] at time 01:06:04.861468 duration_in_ms=5.924
2018-02-15 01:06:04,862 [salt.state       ][INFO    ][20918] Running state [kvm03.mcp-pike-odl-ha.local] at time 01:06:04.862365
2018-02-15 01:06:04,863 [salt.state       ][INFO    ][20918] Executing state host.present for kvm03.mcp-pike-odl-ha.local
2018-02-15 01:06:04,866 [salt.state       ][INFO    ][20918] {'host': 'kvm03.mcp-pike-odl-ha.local'}
2018-02-15 01:06:04,867 [salt.state       ][INFO    ][20918] Completed state [kvm03.mcp-pike-odl-ha.local] at time 01:06:04.867439 duration_in_ms=5.074
2018-02-15 01:06:04,868 [salt.state       ][INFO    ][20918] Running state [kvm02] at time 01:06:04.868258
2018-02-15 01:06:04,869 [salt.state       ][INFO    ][20918] Executing state host.present for kvm02
2018-02-15 01:06:04,872 [salt.state       ][INFO    ][20918] {'host': 'kvm02'}
2018-02-15 01:06:04,873 [salt.state       ][INFO    ][20918] Completed state [kvm02] at time 01:06:04.873531 duration_in_ms=5.273
2018-02-15 01:06:04,874 [salt.state       ][INFO    ][20918] Running state [kvm02.mcp-pike-odl-ha.local] at time 01:06:04.874408
2018-02-15 01:06:04,875 [salt.state       ][INFO    ][20918] Executing state host.present for kvm02.mcp-pike-odl-ha.local
2018-02-15 01:06:04,878 [salt.state       ][INFO    ][20918] {'host': 'kvm02.mcp-pike-odl-ha.local'}
2018-02-15 01:06:04,879 [salt.state       ][INFO    ][20918] Completed state [kvm02.mcp-pike-odl-ha.local] at time 01:06:04.879539 duration_in_ms=5.131
2018-02-15 01:06:04,880 [salt.state       ][INFO    ][20918] Running state [dbs] at time 01:06:04.880346
2018-02-15 01:06:04,881 [salt.state       ][INFO    ][20918] Executing state host.present for dbs
2018-02-15 01:06:04,884 [salt.state       ][INFO    ][20918] {'host': 'dbs'}
2018-02-15 01:06:04,885 [salt.state       ][INFO    ][20918] Completed state [dbs] at time 01:06:04.885461 duration_in_ms=5.115
2018-02-15 01:06:04,886 [salt.state       ][INFO    ][20918] Running state [dbs.mcp-pike-odl-ha.local] at time 01:06:04.886369
2018-02-15 01:06:04,887 [salt.state       ][INFO    ][20918] Executing state host.present for dbs.mcp-pike-odl-ha.local
2018-02-15 01:06:04,890 [salt.state       ][INFO    ][20918] {'host': 'dbs.mcp-pike-odl-ha.local'}
2018-02-15 01:06:04,891 [salt.state       ][INFO    ][20918] Completed state [dbs.mcp-pike-odl-ha.local] at time 01:06:04.891493 duration_in_ms=5.124
2018-02-15 01:06:04,892 [salt.state       ][INFO    ][20918] Running state [prx] at time 01:06:04.892312
2018-02-15 01:06:04,893 [salt.state       ][INFO    ][20918] Executing state host.present for prx
2018-02-15 01:06:04,896 [salt.state       ][INFO    ][20918] {'host': 'prx'}
2018-02-15 01:06:04,897 [salt.state       ][INFO    ][20918] Completed state [prx] at time 01:06:04.897562 duration_in_ms=5.251
2018-02-15 01:06:04,898 [salt.state       ][INFO    ][20918] Running state [prx.mcp-pike-odl-ha.local] at time 01:06:04.898447
2018-02-15 01:06:04,899 [salt.state       ][INFO    ][20918] Executing state host.present for prx.mcp-pike-odl-ha.local
2018-02-15 01:06:04,902 [salt.state       ][INFO    ][20918] {'host': 'prx.mcp-pike-odl-ha.local'}
2018-02-15 01:06:04,903 [salt.state       ][INFO    ][20918] Completed state [prx.mcp-pike-odl-ha.local] at time 01:06:04.903443 duration_in_ms=4.996
2018-02-15 01:06:04,904 [salt.state       ][INFO    ][20918] Running state [prx02] at time 01:06:04.904272
2018-02-15 01:06:04,905 [salt.state       ][INFO    ][20918] Executing state host.present for prx02
2018-02-15 01:06:04,908 [salt.state       ][INFO    ][20918] {'host': 'prx02'}
2018-02-15 01:06:04,909 [salt.state       ][INFO    ][20918] Completed state [prx02] at time 01:06:04.909610 duration_in_ms=5.337
2018-02-15 01:06:04,910 [salt.state       ][INFO    ][20918] Running state [prx02.mcp-pike-odl-ha.local] at time 01:06:04.910532
2018-02-15 01:06:04,911 [salt.state       ][INFO    ][20918] Executing state host.present for prx02.mcp-pike-odl-ha.local
2018-02-15 01:06:04,914 [salt.state       ][INFO    ][20918] {'host': 'prx02.mcp-pike-odl-ha.local'}
2018-02-15 01:06:04,915 [salt.state       ][INFO    ][20918] Completed state [prx02.mcp-pike-odl-ha.local] at time 01:06:04.915492 duration_in_ms=4.96
2018-02-15 01:06:04,916 [salt.state       ][INFO    ][20918] Running state [msg02] at time 01:06:04.916313
2018-02-15 01:06:04,917 [salt.state       ][INFO    ][20918] Executing state host.present for msg02
2018-02-15 01:06:04,920 [salt.state       ][INFO    ][20918] {'host': 'msg02'}
2018-02-15 01:06:04,921 [salt.state       ][INFO    ][20918] Completed state [msg02] at time 01:06:04.921534 duration_in_ms=5.221
2018-02-15 01:06:04,922 [salt.state       ][INFO    ][20918] Running state [msg02.mcp-pike-odl-ha.local] at time 01:06:04.922409
2018-02-15 01:06:04,923 [salt.state       ][INFO    ][20918] Executing state host.present for msg02.mcp-pike-odl-ha.local
2018-02-15 01:06:04,926 [salt.state       ][INFO    ][20918] {'host': 'msg02.mcp-pike-odl-ha.local'}
2018-02-15 01:06:04,927 [salt.state       ][INFO    ][20918] Completed state [msg02.mcp-pike-odl-ha.local] at time 01:06:04.927585 duration_in_ms=5.176
2018-02-15 01:06:04,928 [salt.state       ][INFO    ][20918] Running state [msg03] at time 01:06:04.928407
2018-02-15 01:06:04,929 [salt.state       ][INFO    ][20918] Executing state host.present for msg03
2018-02-15 01:06:04,932 [salt.state       ][INFO    ][20918] {'host': 'msg03'}
2018-02-15 01:06:04,933 [salt.state       ][INFO    ][20918] Completed state [msg03] at time 01:06:04.933665 duration_in_ms=5.257
2018-02-15 01:06:04,934 [salt.state       ][INFO    ][20918] Running state [msg03.mcp-pike-odl-ha.local] at time 01:06:04.934584
2018-02-15 01:06:04,935 [salt.state       ][INFO    ][20918] Executing state host.present for msg03.mcp-pike-odl-ha.local
2018-02-15 01:06:04,938 [salt.state       ][INFO    ][20918] {'host': 'msg03.mcp-pike-odl-ha.local'}
2018-02-15 01:06:04,939 [salt.state       ][INFO    ][20918] Completed state [msg03.mcp-pike-odl-ha.local] at time 01:06:04.939527 duration_in_ms=4.943
2018-02-15 01:06:04,940 [salt.state       ][INFO    ][20918] Running state [msg01] at time 01:06:04.940332
2018-02-15 01:06:04,941 [salt.state       ][INFO    ][20918] Executing state host.present for msg01
2018-02-15 01:06:04,944 [salt.state       ][INFO    ][20918] {'host': 'msg01'}
2018-02-15 01:06:04,945 [salt.state       ][INFO    ][20918] Completed state [msg01] at time 01:06:04.945681 duration_in_ms=5.349
2018-02-15 01:06:04,946 [salt.state       ][INFO    ][20918] Running state [msg01.mcp-pike-odl-ha.local] at time 01:06:04.946576
2018-02-15 01:06:04,947 [salt.state       ][INFO    ][20918] Executing state host.present for msg01.mcp-pike-odl-ha.local
2018-02-15 01:06:04,950 [salt.state       ][INFO    ][20918] {'host': 'msg01.mcp-pike-odl-ha.local'}
2018-02-15 01:06:04,951 [salt.state       ][INFO    ][20918] Completed state [msg01.mcp-pike-odl-ha.local] at time 01:06:04.951677 duration_in_ms=5.1
2018-02-15 01:06:04,952 [salt.state       ][INFO    ][20918] Running state [msg] at time 01:06:04.952507
2018-02-15 01:06:04,953 [salt.state       ][INFO    ][20918] Executing state host.present for msg
2018-02-15 01:06:04,956 [salt.state       ][INFO    ][20918] {'host': 'msg'}
2018-02-15 01:06:04,957 [salt.state       ][INFO    ][20918] Completed state [msg] at time 01:06:04.957728 duration_in_ms=5.221
2018-02-15 01:06:04,958 [salt.state       ][INFO    ][20918] Running state [msg.mcp-pike-odl-ha.local] at time 01:06:04.958642
2018-02-15 01:06:04,959 [salt.state       ][INFO    ][20918] Executing state host.present for msg.mcp-pike-odl-ha.local
2018-02-15 01:06:04,962 [salt.state       ][INFO    ][20918] {'host': 'msg.mcp-pike-odl-ha.local'}
2018-02-15 01:06:04,963 [salt.state       ][INFO    ][20918] Completed state [msg.mcp-pike-odl-ha.local] at time 01:06:04.963624 duration_in_ms=4.981
2018-02-15 01:06:04,964 [salt.state       ][INFO    ][20918] Running state [cfg01] at time 01:06:04.964448
2018-02-15 01:06:04,965 [salt.state       ][INFO    ][20918] Executing state host.present for cfg01
2018-02-15 01:06:04,966 [salt.state       ][INFO    ][20918] Host cfg01 (10.167.4.100) already present
2018-02-15 01:06:04,967 [salt.state       ][INFO    ][20918] Completed state [cfg01] at time 01:06:04.967167 duration_in_ms=2.718
2018-02-15 01:06:04,968 [salt.state       ][INFO    ][20918] Running state [cfg01.mcp-pike-odl-ha.local] at time 01:06:04.967994
2018-02-15 01:06:04,968 [salt.state       ][INFO    ][20918] Executing state host.present for cfg01.mcp-pike-odl-ha.local
2018-02-15 01:06:04,969 [salt.state       ][INFO    ][20918] Host cfg01.mcp-pike-odl-ha.local (10.167.4.100) already present
2018-02-15 01:06:04,970 [salt.state       ][INFO    ][20918] Completed state [cfg01.mcp-pike-odl-ha.local] at time 01:06:04.970725 duration_in_ms=2.732
2018-02-15 01:06:04,971 [salt.state       ][INFO    ][20918] Running state [cmp002] at time 01:06:04.971558
2018-02-15 01:06:04,972 [salt.state       ][INFO    ][20918] Executing state host.present for cmp002
2018-02-15 01:06:04,974 [salt.state       ][INFO    ][20918] {'host': 'cmp002'}
2018-02-15 01:06:04,975 [salt.state       ][INFO    ][20918] Completed state [cmp002] at time 01:06:04.974964 duration_in_ms=3.406
2018-02-15 01:06:04,975 [salt.state       ][INFO    ][20918] Running state [cmp002.mcp-pike-odl-ha.local] at time 01:06:04.975754
2018-02-15 01:06:04,976 [salt.state       ][INFO    ][20918] Executing state host.present for cmp002.mcp-pike-odl-ha.local
2018-02-15 01:06:04,978 [salt.state       ][INFO    ][20918] {'host': 'cmp002.mcp-pike-odl-ha.local'}
2018-02-15 01:06:04,979 [salt.state       ][INFO    ][20918] Completed state [cmp002.mcp-pike-odl-ha.local] at time 01:06:04.979081 duration_in_ms=3.327
2018-02-15 01:06:04,979 [salt.state       ][INFO    ][20918] Running state [cmp001] at time 01:06:04.979885
2018-02-15 01:06:04,980 [salt.state       ][INFO    ][20918] Executing state host.present for cmp001
2018-02-15 01:06:04,982 [salt.state       ][INFO    ][20918] {'host': 'cmp001'}
2018-02-15 01:06:04,983 [salt.state       ][INFO    ][20918] Completed state [cmp001] at time 01:06:04.983574 duration_in_ms=3.689
2018-02-15 01:06:04,984 [salt.state       ][INFO    ][20918] Running state [cmp001.mcp-pike-odl-ha.local] at time 01:06:04.984324
2018-02-15 01:06:04,985 [salt.state       ][INFO    ][20918] Executing state host.present for cmp001.mcp-pike-odl-ha.local
2018-02-15 01:06:04,988 [salt.state       ][INFO    ][20918] {'host': 'cmp001.mcp-pike-odl-ha.local'}
2018-02-15 01:06:04,989 [salt.state       ][INFO    ][20918] Completed state [cmp001.mcp-pike-odl-ha.local] at time 01:06:04.989309 duration_in_ms=4.985
2018-02-15 01:06:04,990 [salt.state       ][INFO    ][20918] Running state [dbs01] at time 01:06:04.990138
2018-02-15 01:06:04,990 [salt.state       ][INFO    ][20918] Executing state host.present for dbs01
2018-02-15 01:06:04,994 [salt.state       ][INFO    ][20918] {'host': 'dbs01'}
2018-02-15 01:06:04,995 [salt.state       ][INFO    ][20918] Completed state [dbs01] at time 01:06:04.995319 duration_in_ms=5.181
2018-02-15 01:06:04,996 [salt.state       ][INFO    ][20918] Running state [dbs01.mcp-pike-odl-ha.local] at time 01:06:04.996082
2018-02-15 01:06:04,996 [salt.state       ][INFO    ][20918] Executing state host.present for dbs01.mcp-pike-odl-ha.local
2018-02-15 01:06:05,000 [salt.state       ][INFO    ][20918] {'host': 'dbs01.mcp-pike-odl-ha.local'}
2018-02-15 01:06:05,001 [salt.state       ][INFO    ][20918] Completed state [dbs01.mcp-pike-odl-ha.local] at time 01:06:05.001184 duration_in_ms=5.103
2018-02-15 01:06:05,001 [salt.state       ][INFO    ][20918] Running state [dbs02] at time 01:06:05.001905
2018-02-15 01:06:05,002 [salt.state       ][INFO    ][20918] Executing state host.present for dbs02
2018-02-15 01:06:05,006 [salt.state       ][INFO    ][20918] {'host': 'dbs02'}
2018-02-15 01:06:05,007 [salt.state       ][INFO    ][20918] Completed state [dbs02] at time 01:06:05.007276 duration_in_ms=5.371
2018-02-15 01:06:05,008 [salt.state       ][INFO    ][20918] Running state [dbs02.mcp-pike-odl-ha.local] at time 01:06:05.007958
2018-02-15 01:06:05,008 [salt.state       ][INFO    ][20918] Executing state host.present for dbs02.mcp-pike-odl-ha.local
2018-02-15 01:06:05,012 [salt.state       ][INFO    ][20918] {'host': 'dbs02.mcp-pike-odl-ha.local'}
2018-02-15 01:06:05,013 [salt.state       ][INFO    ][20918] Completed state [dbs02.mcp-pike-odl-ha.local] at time 01:06:05.013249 duration_in_ms=5.291
2018-02-15 01:06:05,013 [salt.state       ][INFO    ][20918] Running state [dbs03] at time 01:06:05.013933
2018-02-15 01:06:05,014 [salt.state       ][INFO    ][20918] Executing state host.present for dbs03
2018-02-15 01:06:05,018 [salt.state       ][INFO    ][20918] {'host': 'dbs03'}
2018-02-15 01:06:05,019 [salt.state       ][INFO    ][20918] Completed state [dbs03] at time 01:06:05.019275 duration_in_ms=5.343
2018-02-15 01:06:05,020 [salt.state       ][INFO    ][20918] Running state [dbs03.mcp-pike-odl-ha.local] at time 01:06:05.019963
2018-02-15 01:06:05,020 [salt.state       ][INFO    ][20918] Executing state host.present for dbs03.mcp-pike-odl-ha.local
2018-02-15 01:06:05,024 [salt.state       ][INFO    ][20918] {'host': 'dbs03.mcp-pike-odl-ha.local'}
2018-02-15 01:06:05,025 [salt.state       ][INFO    ][20918] Completed state [dbs03.mcp-pike-odl-ha.local] at time 01:06:05.025442 duration_in_ms=5.479
2018-02-15 01:06:05,026 [salt.state       ][INFO    ][20918] Running state [odl01] at time 01:06:05.026173
2018-02-15 01:06:05,026 [salt.state       ][INFO    ][20918] Executing state host.present for odl01
2018-02-15 01:06:05,034 [salt.state       ][INFO    ][20918] {'host': 'odl01'}
2018-02-15 01:06:05,034 [salt.state       ][INFO    ][20918] Completed state [odl01] at time 01:06:05.034916 duration_in_ms=8.742
2018-02-15 01:06:05,035 [salt.state       ][INFO    ][20918] Running state [odl01.mcp-pike-odl-ha.local] at time 01:06:05.035628
2018-02-15 01:06:05,036 [salt.state       ][INFO    ][20918] Executing state host.present for odl01.mcp-pike-odl-ha.local
2018-02-15 01:06:05,038 [salt.state       ][INFO    ][20918] {'host': 'odl01.mcp-pike-odl-ha.local'}
2018-02-15 01:06:05,038 [salt.state       ][INFO    ][20918] Completed state [odl01.mcp-pike-odl-ha.local] at time 01:06:05.038724 duration_in_ms=3.097
2018-02-15 01:06:05,039 [salt.state       ][INFO    ][20918] Running state [mas01] at time 01:06:05.039402
2018-02-15 01:06:05,040 [salt.state       ][INFO    ][20918] Executing state host.present for mas01
2018-02-15 01:06:05,042 [salt.state       ][INFO    ][20918] {'host': 'mas01'}
2018-02-15 01:06:05,043 [salt.state       ][INFO    ][20918] Completed state [mas01] at time 01:06:05.043307 duration_in_ms=3.905
2018-02-15 01:06:05,044 [salt.state       ][INFO    ][20918] Running state [mas01.mcp-pike-odl-ha.local] at time 01:06:05.044006
2018-02-15 01:06:05,044 [salt.state       ][INFO    ][20918] Executing state host.present for mas01.mcp-pike-odl-ha.local
2018-02-15 01:06:05,049 [salt.state       ][INFO    ][20918] {'host': 'mas01.mcp-pike-odl-ha.local'}
2018-02-15 01:06:05,050 [salt.state       ][INFO    ][20918] Completed state [mas01.mcp-pike-odl-ha.local] at time 01:06:05.050656 duration_in_ms=6.65
2018-02-15 01:06:05,051 [salt.state       ][INFO    ][20918] Running state [ctl02] at time 01:06:05.051346
2018-02-15 01:06:05,052 [salt.state       ][INFO    ][20918] Executing state host.present for ctl02
2018-02-15 01:06:05,055 [salt.state       ][INFO    ][20918] {'host': 'ctl02'}
2018-02-15 01:06:05,056 [salt.state       ][INFO    ][20918] Completed state [ctl02] at time 01:06:05.056461 duration_in_ms=5.115
2018-02-15 01:06:05,057 [salt.state       ][INFO    ][20918] Running state [ctl02.mcp-pike-odl-ha.local] at time 01:06:05.057178
2018-02-15 01:06:05,057 [salt.state       ][INFO    ][20918] Executing state host.present for ctl02.mcp-pike-odl-ha.local
2018-02-15 01:06:05,061 [salt.state       ][INFO    ][20918] {'host': 'ctl02.mcp-pike-odl-ha.local'}
2018-02-15 01:06:05,062 [salt.state       ][INFO    ][20918] Completed state [ctl02.mcp-pike-odl-ha.local] at time 01:06:05.062489 duration_in_ms=5.312
2018-02-15 01:06:05,063 [salt.state       ][INFO    ][20918] Running state [ctl03] at time 01:06:05.063206
2018-02-15 01:06:05,063 [salt.state       ][INFO    ][20918] Executing state host.present for ctl03
2018-02-15 01:06:05,067 [salt.state       ][INFO    ][20918] {'host': 'ctl03'}
2018-02-15 01:06:05,068 [salt.state       ][INFO    ][20918] Completed state [ctl03] at time 01:06:05.068495 duration_in_ms=5.289
2018-02-15 01:06:05,069 [salt.state       ][INFO    ][20918] Running state [ctl03.mcp-pike-odl-ha.local] at time 01:06:05.069212
2018-02-15 01:06:05,069 [salt.state       ][INFO    ][20918] Executing state host.present for ctl03.mcp-pike-odl-ha.local
2018-02-15 01:06:05,073 [salt.state       ][INFO    ][20918] {'host': 'ctl03.mcp-pike-odl-ha.local'}
2018-02-15 01:06:05,074 [salt.state       ][INFO    ][20918] Completed state [ctl03.mcp-pike-odl-ha.local] at time 01:06:05.074576 duration_in_ms=5.364
2018-02-15 01:06:05,075 [salt.state       ][INFO    ][20918] Running state [ctl01] at time 01:06:05.075256
2018-02-15 01:06:05,075 [salt.state       ][INFO    ][20918] Executing state host.present for ctl01
2018-02-15 01:06:05,079 [salt.state       ][INFO    ][20918] {'host': 'ctl01'}
2018-02-15 01:06:05,080 [salt.state       ][INFO    ][20918] Completed state [ctl01] at time 01:06:05.080599 duration_in_ms=5.343
2018-02-15 01:06:05,081 [salt.state       ][INFO    ][20918] Running state [ctl01.mcp-pike-odl-ha.local] at time 01:06:05.081285
2018-02-15 01:06:05,081 [salt.state       ][INFO    ][20918] Executing state host.present for ctl01.mcp-pike-odl-ha.local
2018-02-15 01:06:05,085 [salt.state       ][INFO    ][20918] {'host': 'ctl01.mcp-pike-odl-ha.local'}
2018-02-15 01:06:05,086 [salt.state       ][INFO    ][20918] Completed state [ctl01.mcp-pike-odl-ha.local] at time 01:06:05.086662 duration_in_ms=5.377
2018-02-15 01:06:05,087 [salt.state       ][INFO    ][20918] Running state [ctl] at time 01:06:05.087344
2018-02-15 01:06:05,088 [salt.state       ][INFO    ][20918] Executing state host.present for ctl
2018-02-15 01:06:05,091 [salt.state       ][INFO    ][20918] {'host': 'ctl'}
2018-02-15 01:06:05,092 [salt.state       ][INFO    ][20918] Completed state [ctl] at time 01:06:05.092556 duration_in_ms=5.212
2018-02-15 01:06:05,093 [salt.state       ][INFO    ][20918] Running state [ctl.mcp-pike-odl-ha.local] at time 01:06:05.093246
2018-02-15 01:06:05,093 [salt.state       ][INFO    ][20918] Executing state host.present for ctl.mcp-pike-odl-ha.local
2018-02-15 01:06:05,097 [salt.state       ][INFO    ][20918] {'host': 'ctl.mcp-pike-odl-ha.local'}
2018-02-15 01:06:05,098 [salt.state       ][INFO    ][20918] Completed state [ctl.mcp-pike-odl-ha.local] at time 01:06:05.098603 duration_in_ms=5.357
2018-02-15 01:06:05,099 [salt.state       ][INFO    ][20918] Running state [/etc/network/interfaces.d/50-cloud-init.cfg] at time 01:06:05.099275
2018-02-15 01:06:05,099 [salt.state       ][INFO    ][20918] Executing state file.absent for /etc/network/interfaces.d/50-cloud-init.cfg
2018-02-15 01:06:05,100 [salt.state       ][INFO    ][20918] {'removed': '/etc/network/interfaces.d/50-cloud-init.cfg'}
2018-02-15 01:06:05,101 [salt.state       ][INFO    ][20918] Completed state [/etc/network/interfaces.d/50-cloud-init.cfg] at time 01:06:05.101459 duration_in_ms=2.184
2018-02-15 01:06:05,115 [salt.state       ][INFO    ][20918] Running state [ens3] at time 01:06:05.115019
2018-02-15 01:06:05,115 [salt.state       ][INFO    ][20918] Executing state network.managed for ens3
2018-02-15 01:06:05,289 [salt.loaded.int.module.cmdmod][INFO    ][20918] Executing command ['ifdown', 'ens3'] in directory '/root'
2018-02-15 01:06:06,495 [salt.loaded.int.module.cmdmod][INFO    ][20918] Executing command ['ifup', 'ens3'] in directory '/root'
2018-02-15 01:06:06,844 [salt.state       ][INFO    ][20918] {'interface': 'Added network interface.', 'status': 'Interface ens3 restart to validate'}
2018-02-15 01:06:06,845 [salt.state       ][INFO    ][20918] Completed state [ens3] at time 01:06:06.845387 duration_in_ms=1730.367
2018-02-15 01:06:06,846 [salt.state       ][INFO    ][20918] Running state [ens4] at time 01:06:06.846229
2018-02-15 01:06:06,846 [salt.state       ][INFO    ][20918] Executing state network.managed for ens4
2018-02-15 01:06:06,901 [salt.loaded.int.module.cmdmod][INFO    ][20918] Executing command ['ifup', 'ens4'] in directory '/root'
2018-02-15 01:06:07,791 [salt.state       ][INFO    ][20918] {'interface': 'Added network interface.', 'status': 'Interface ens4 is up'}
2018-02-15 01:06:07,792 [salt.state       ][INFO    ][20918] Completed state [ens4] at time 01:06:07.792284 duration_in_ms=946.054
2018-02-15 01:06:07,793 [salt.state       ][INFO    ][20918] Running state [ens5] at time 01:06:07.793349
2018-02-15 01:06:07,794 [salt.state       ][INFO    ][20918] Executing state network.managed for ens5
2018-02-15 01:06:07,852 [salt.loaded.int.module.cmdmod][INFO    ][20918] Executing command ['ifup', 'ens5'] in directory '/root'
2018-02-15 01:06:08,650 [salt.state       ][INFO    ][20918] {'interface': 'Added network interface.', 'status': 'Interface ens5 is up'}
2018-02-15 01:06:08,651 [salt.state       ][INFO    ][20918] Completed state [ens5] at time 01:06:08.651116 duration_in_ms=857.766
2018-02-15 01:06:08,651 [salt.state       ][INFO    ][20918] Running state [/etc/profile.d/proxy.sh] at time 01:06:08.651607
2018-02-15 01:06:08,652 [salt.state       ][INFO    ][20918] Executing state file.absent for /etc/profile.d/proxy.sh
2018-02-15 01:06:08,652 [salt.state       ][INFO    ][20918] File /etc/profile.d/proxy.sh is not present
2018-02-15 01:06:08,653 [salt.state       ][INFO    ][20918] Completed state [/etc/profile.d/proxy.sh] at time 01:06:08.652976 duration_in_ms=1.369
2018-02-15 01:06:08,653 [salt.state       ][INFO    ][20918] Running state [/etc/apt/apt.conf.d/95proxies] at time 01:06:08.653358
2018-02-15 01:06:08,653 [salt.state       ][INFO    ][20918] Executing state file.absent for /etc/apt/apt.conf.d/95proxies
2018-02-15 01:06:08,654 [salt.state       ][INFO    ][20918] File /etc/apt/apt.conf.d/95proxies is not present
2018-02-15 01:06:08,654 [salt.state       ][INFO    ][20918] Completed state [/etc/apt/apt.conf.d/95proxies] at time 01:06:08.654597 duration_in_ms=1.239
2018-02-15 01:06:08,658 [salt.minion      ][INFO    ][20918] Returning information for job: 20180215010513639497
2018-02-15 01:06:10,377 [salt.minion      ][INFO    ][20772] User sudo_ubuntu Executing command saltutil.sync_all with jid 20180215010610361720
2018-02-15 01:06:10,418 [salt.minion      ][INFO    ][24939] Starting a new job with PID 24939
2018-02-15 01:06:11,944 [salt.state       ][INFO    ][24939] Loading fresh modules for state activity
2018-02-15 01:06:11,974 [salt.utils.extmods][INFO    ][24939] Creating module dir '/var/cache/salt/minion/extmods/beacons'
2018-02-15 01:06:11,978 [salt.utils.extmods][INFO    ][24939] Syncing beacons for environment 'base'
2018-02-15 01:06:11,978 [salt.utils.extmods][INFO    ][24939] Loading cache from salt://_beacons, for base)
2018-02-15 01:06:11,979 [salt.fileclient  ][INFO    ][24939] Caching directory '_beacons/' for environment 'base'
2018-02-15 01:06:12,013 [salt.utils.extmods][INFO    ][24939] Syncing modules for environment 'base'
2018-02-15 01:06:12,014 [salt.utils.extmods][INFO    ][24939] Loading cache from salt://_modules, for base)
2018-02-15 01:06:12,014 [salt.fileclient  ][INFO    ][24939] Caching directory '_modules/' for environment 'base'
2018-02-15 01:06:12,669 [salt.fileclient  ][INFO    ][24939] Fetching file from saltenv 'base', ** done ** '_modules/maas.py'
2018-02-15 01:06:12,822 [salt.utils.extmods][INFO    ][24939] Copying '/var/cache/salt/minion/files/base/_modules/__init__.py' to '/var/cache/salt/minion/extmods/modules/__init__.py'
2018-02-15 01:06:12,822 [salt.utils.extmods][INFO    ][24939] Copying '/var/cache/salt/minion/files/base/_modules/architect.py' to '/var/cache/salt/minion/extmods/modules/architect.py'
2018-02-15 01:06:12,823 [salt.utils.extmods][INFO    ][24939] Copying '/var/cache/salt/minion/files/base/_modules/avinetworks.py' to '/var/cache/salt/minion/extmods/modules/avinetworks.py'
2018-02-15 01:06:12,824 [salt.utils.extmods][INFO    ][24939] Copying '/var/cache/salt/minion/files/base/_modules/ceph_ng.py' to '/var/cache/salt/minion/extmods/modules/ceph_ng.py'
2018-02-15 01:06:12,824 [salt.utils.extmods][INFO    ][24939] Copying '/var/cache/salt/minion/files/base/_modules/cinderng.py' to '/var/cache/salt/minion/extmods/modules/cinderng.py'
2018-02-15 01:06:12,825 [salt.utils.extmods][INFO    ][24939] Copying '/var/cache/salt/minion/files/base/_modules/contrail.py' to '/var/cache/salt/minion/extmods/modules/contrail.py'
2018-02-15 01:06:12,826 [salt.utils.extmods][INFO    ][24939] Copying '/var/cache/salt/minion/files/base/_modules/creds.py' to '/var/cache/salt/minion/extmods/modules/creds.py'
2018-02-15 01:06:12,827 [salt.utils.extmods][INFO    ][24939] Copying '/var/cache/salt/minion/files/base/_modules/devops_utils.py' to '/var/cache/salt/minion/extmods/modules/devops_utils.py'
2018-02-15 01:06:12,827 [salt.utils.extmods][INFO    ][24939] Copying '/var/cache/salt/minion/files/base/_modules/dockerng_service.py' to '/var/cache/salt/minion/extmods/modules/dockerng_service.py'
2018-02-15 01:06:12,828 [salt.utils.extmods][INFO    ][24939] Copying '/var/cache/salt/minion/files/base/_modules/encode_json.py' to '/var/cache/salt/minion/extmods/modules/encode_json.py'
2018-02-15 01:06:12,828 [salt.utils.extmods][INFO    ][24939] Copying '/var/cache/salt/minion/files/base/_modules/gerrit.py' to '/var/cache/salt/minion/extmods/modules/gerrit.py'
2018-02-15 01:06:12,829 [salt.utils.extmods][INFO    ][24939] Copying '/var/cache/salt/minion/files/base/_modules/glanceng.py' to '/var/cache/salt/minion/extmods/modules/glanceng.py'
2018-02-15 01:06:12,830 [salt.utils.extmods][INFO    ][24939] Copying '/var/cache/salt/minion/files/base/_modules/heat.py' to '/var/cache/salt/minion/extmods/modules/heat.py'
2018-02-15 01:06:12,831 [salt.utils.extmods][INFO    ][24939] Copying '/var/cache/salt/minion/files/base/_modules/heka_alarming.py' to '/var/cache/salt/minion/extmods/modules/heka_alarming.py'
2018-02-15 01:06:12,831 [salt.utils.extmods][INFO    ][24939] Copying '/var/cache/salt/minion/files/base/_modules/helm.py' to '/var/cache/salt/minion/extmods/modules/helm.py'
2018-02-15 01:06:12,832 [salt.utils.extmods][INFO    ][24939] Copying '/var/cache/salt/minion/files/base/_modules/jenkins_common.py' to '/var/cache/salt/minion/extmods/modules/jenkins_common.py'
2018-02-15 01:06:12,833 [salt.utils.extmods][INFO    ][24939] Copying '/var/cache/salt/minion/files/base/_modules/keystone_policy.py' to '/var/cache/salt/minion/extmods/modules/keystone_policy.py'
2018-02-15 01:06:12,834 [salt.utils.extmods][INFO    ][24939] Copying '/var/cache/salt/minion/files/base/_modules/keystoneng.py' to '/var/cache/salt/minion/extmods/modules/keystoneng.py'
2018-02-15 01:06:12,835 [salt.utils.extmods][INFO    ][24939] Copying '/var/cache/salt/minion/files/base/_modules/linux_hosts.py' to '/var/cache/salt/minion/extmods/modules/linux_hosts.py'
2018-02-15 01:06:12,835 [salt.utils.extmods][INFO    ][24939] Copying '/var/cache/salt/minion/files/base/_modules/linux_netlink.py' to '/var/cache/salt/minion/extmods/modules/linux_netlink.py'
2018-02-15 01:06:12,835 [salt.utils.extmods][INFO    ][24939] Copying '/var/cache/salt/minion/files/base/_modules/maas.py' to '/var/cache/salt/minion/extmods/modules/maas.py'
2018-02-15 01:06:12,836 [salt.utils.extmods][INFO    ][24939] Copying '/var/cache/salt/minion/files/base/_modules/maas_client.py' to '/var/cache/salt/minion/extmods/modules/maas_client.py'
2018-02-15 01:06:12,836 [salt.utils.extmods][INFO    ][24939] Copying '/var/cache/salt/minion/files/base/_modules/modelschema.py' to '/var/cache/salt/minion/extmods/modules/modelschema.py'
2018-02-15 01:06:12,837 [salt.utils.extmods][INFO    ][24939] Copying '/var/cache/salt/minion/files/base/_modules/modelutils.py' to '/var/cache/salt/minion/extmods/modules/modelutils.py'
2018-02-15 01:06:12,837 [salt.utils.extmods][INFO    ][24939] Copying '/var/cache/salt/minion/files/base/_modules/multipart.py' to '/var/cache/salt/minion/extmods/modules/multipart.py'
2018-02-15 01:06:12,837 [salt.utils.extmods][INFO    ][24939] Copying '/var/cache/salt/minion/files/base/_modules/nagios_alarming.py' to '/var/cache/salt/minion/extmods/modules/nagios_alarming.py'
2018-02-15 01:06:12,838 [salt.utils.extmods][INFO    ][24939] Copying '/var/cache/salt/minion/files/base/_modules/neutronng.py' to '/var/cache/salt/minion/extmods/modules/neutronng.py'
2018-02-15 01:06:12,838 [salt.utils.extmods][INFO    ][24939] Copying '/var/cache/salt/minion/files/base/_modules/novang.py' to '/var/cache/salt/minion/extmods/modules/novang.py'
2018-02-15 01:06:12,839 [salt.utils.extmods][INFO    ][24939] Copying '/var/cache/salt/minion/files/base/_modules/reclass.py' to '/var/cache/salt/minion/extmods/modules/reclass.py'
2018-02-15 01:06:12,840 [salt.utils.extmods][INFO    ][24939] Copying '/var/cache/salt/minion/files/base/_modules/rsyslog_util.py' to '/var/cache/salt/minion/extmods/modules/rsyslog_util.py'
2018-02-15 01:06:12,840 [salt.utils.extmods][INFO    ][24939] Copying '/var/cache/salt/minion/files/base/_modules/rundeck.py' to '/var/cache/salt/minion/extmods/modules/rundeck.py'
2018-02-15 01:06:12,840 [salt.utils.extmods][INFO    ][24939] Copying '/var/cache/salt/minion/files/base/_modules/saltkey.py' to '/var/cache/salt/minion/extmods/modules/saltkey.py'
2018-02-15 01:06:12,841 [salt.utils.extmods][INFO    ][24939] Copying '/var/cache/salt/minion/files/base/_modules/saltresource.py' to '/var/cache/salt/minion/extmods/modules/saltresource.py'
2018-02-15 01:06:12,841 [salt.utils.extmods][INFO    ][24939] Copying '/var/cache/salt/minion/files/base/_modules/seedng.py' to '/var/cache/salt/minion/extmods/modules/seedng.py'
2018-02-15 01:06:12,841 [salt.utils.extmods][INFO    ][24939] Copying '/var/cache/salt/minion/files/base/_modules/testing/__init__.py' to '/var/cache/salt/minion/extmods/modules/testing/__init__.py'
2018-02-15 01:06:12,842 [salt.utils.extmods][INFO    ][24939] Copying '/var/cache/salt/minion/files/base/_modules/testing/credentials.py' to '/var/cache/salt/minion/extmods/modules/testing/credentials.py'
2018-02-15 01:06:12,842 [salt.utils.extmods][INFO    ][24939] Copying '/var/cache/salt/minion/files/base/_modules/testing/django.py' to '/var/cache/salt/minion/extmods/modules/testing/django.py'
2018-02-15 01:06:12,843 [salt.utils.extmods][INFO    ][24939] Copying '/var/cache/salt/minion/files/base/_modules/testing/django_client_proxy.py' to '/var/cache/salt/minion/extmods/modules/testing/django_client_proxy.py'
2018-02-15 01:06:12,843 [salt.utils.extmods][INFO    ][24939] Copying '/var/cache/salt/minion/files/base/_modules/utils.py' to '/var/cache/salt/minion/extmods/modules/utils.py'
2018-02-15 01:06:12,843 [salt.utils.extmods][INFO    ][24939] Copying '/var/cache/salt/minion/files/base/_modules/virtng.py' to '/var/cache/salt/minion/extmods/modules/virtng.py'
2018-02-15 01:06:12,855 [salt.utils.extmods][INFO    ][24939] Syncing states for environment 'base'
2018-02-15 01:06:12,855 [salt.utils.extmods][INFO    ][24939] Loading cache from salt://_states, for base)
2018-02-15 01:06:12,855 [salt.fileclient  ][INFO    ][24939] Caching directory '_states/' for environment 'base'
2018-02-15 01:06:13,136 [salt.utils.extmods][INFO    ][24939] Copying '/var/cache/salt/minion/files/base/_states/avinetworks.py' to '/var/cache/salt/minion/extmods/states/avinetworks.py'
2018-02-15 01:06:13,137 [salt.utils.extmods][INFO    ][24939] Copying '/var/cache/salt/minion/files/base/_states/cinderng.py' to '/var/cache/salt/minion/extmods/states/cinderng.py'
2018-02-15 01:06:13,137 [salt.utils.extmods][INFO    ][24939] Copying '/var/cache/salt/minion/files/base/_states/contrail.py' to '/var/cache/salt/minion/extmods/states/contrail.py'
2018-02-15 01:06:13,137 [salt.utils.extmods][INFO    ][24939] Copying '/var/cache/salt/minion/files/base/_states/dockerng_service.py' to '/var/cache/salt/minion/extmods/states/dockerng_service.py'
2018-02-15 01:06:13,138 [salt.utils.extmods][INFO    ][24939] Copying '/var/cache/salt/minion/files/base/_states/gerrit.py' to '/var/cache/salt/minion/extmods/states/gerrit.py'
2018-02-15 01:06:13,138 [salt.utils.extmods][INFO    ][24939] Copying '/var/cache/salt/minion/files/base/_states/glanceng.py' to '/var/cache/salt/minion/extmods/states/glanceng.py'
2018-02-15 01:06:13,138 [salt.utils.extmods][INFO    ][24939] Copying '/var/cache/salt/minion/files/base/_states/grafana3_dashboard.py' to '/var/cache/salt/minion/extmods/states/grafana3_dashboard.py'
2018-02-15 01:06:13,138 [salt.utils.extmods][INFO    ][24939] Copying '/var/cache/salt/minion/files/base/_states/grafana3_datasource.py' to '/var/cache/salt/minion/extmods/states/grafana3_datasource.py'
2018-02-15 01:06:13,139 [salt.utils.extmods][INFO    ][24939] Copying '/var/cache/salt/minion/files/base/_states/heat.py' to '/var/cache/salt/minion/extmods/states/heat.py'
2018-02-15 01:06:13,139 [salt.utils.extmods][INFO    ][24939] Copying '/var/cache/salt/minion/files/base/_states/helm_release.py' to '/var/cache/salt/minion/extmods/states/helm_release.py'
2018-02-15 01:06:13,139 [salt.utils.extmods][INFO    ][24939] Copying '/var/cache/salt/minion/files/base/_states/helm_repos.py' to '/var/cache/salt/minion/extmods/states/helm_repos.py'
2018-02-15 01:06:13,140 [salt.utils.extmods][INFO    ][24939] Copying '/var/cache/salt/minion/files/base/_states/httpng.py' to '/var/cache/salt/minion/extmods/states/httpng.py'
2018-02-15 01:06:13,140 [salt.utils.extmods][INFO    ][24939] Copying '/var/cache/salt/minion/files/base/_states/jenkins_approval.py' to '/var/cache/salt/minion/extmods/states/jenkins_approval.py'
2018-02-15 01:06:13,140 [salt.utils.extmods][INFO    ][24939] Copying '/var/cache/salt/minion/files/base/_states/jenkins_artifactory.py' to '/var/cache/salt/minion/extmods/states/jenkins_artifactory.py'
2018-02-15 01:06:13,140 [salt.utils.extmods][INFO    ][24939] Copying '/var/cache/salt/minion/files/base/_states/jenkins_credential.py' to '/var/cache/salt/minion/extmods/states/jenkins_credential.py'
2018-02-15 01:06:13,141 [salt.utils.extmods][INFO    ][24939] Copying '/var/cache/salt/minion/files/base/_states/jenkins_globalenvprop.py' to '/var/cache/salt/minion/extmods/states/jenkins_globalenvprop.py'
2018-02-15 01:06:13,141 [salt.utils.extmods][INFO    ][24939] Copying '/var/cache/salt/minion/files/base/_states/jenkins_job.py' to '/var/cache/salt/minion/extmods/states/jenkins_job.py'
2018-02-15 01:06:13,141 [salt.utils.extmods][INFO    ][24939] Copying '/var/cache/salt/minion/files/base/_states/jenkins_lib.py' to '/var/cache/salt/minion/extmods/states/jenkins_lib.py'
2018-02-15 01:06:13,141 [salt.utils.extmods][INFO    ][24939] Copying '/var/cache/salt/minion/files/base/_states/jenkins_node.py' to '/var/cache/salt/minion/extmods/states/jenkins_node.py'
2018-02-15 01:06:13,142 [salt.utils.extmods][INFO    ][24939] Copying '/var/cache/salt/minion/files/base/_states/jenkins_plugin.py' to '/var/cache/salt/minion/extmods/states/jenkins_plugin.py'
2018-02-15 01:06:13,142 [salt.utils.extmods][INFO    ][24939] Copying '/var/cache/salt/minion/files/base/_states/jenkins_security.py' to '/var/cache/salt/minion/extmods/states/jenkins_security.py'
2018-02-15 01:06:13,142 [salt.utils.extmods][INFO    ][24939] Copying '/var/cache/salt/minion/files/base/_states/jenkins_slack.py' to '/var/cache/salt/minion/extmods/states/jenkins_slack.py'
2018-02-15 01:06:13,142 [salt.utils.extmods][INFO    ][24939] Copying '/var/cache/salt/minion/files/base/_states/jenkins_smtp.py' to '/var/cache/salt/minion/extmods/states/jenkins_smtp.py'
2018-02-15 01:06:13,143 [salt.utils.extmods][INFO    ][24939] Copying '/var/cache/salt/minion/files/base/_states/jenkins_theme.py' to '/var/cache/salt/minion/extmods/states/jenkins_theme.py'
2018-02-15 01:06:13,143 [salt.utils.extmods][INFO    ][24939] Copying '/var/cache/salt/minion/files/base/_states/jenkins_user.py' to '/var/cache/salt/minion/extmods/states/jenkins_user.py'
2018-02-15 01:06:13,143 [salt.utils.extmods][INFO    ][24939] Copying '/var/cache/salt/minion/files/base/_states/jenkins_view.py' to '/var/cache/salt/minion/extmods/states/jenkins_view.py'
2018-02-15 01:06:13,143 [salt.utils.extmods][INFO    ][24939] Copying '/var/cache/salt/minion/files/base/_states/keystone_policy.py' to '/var/cache/salt/minion/extmods/states/keystone_policy.py'
2018-02-15 01:06:13,144 [salt.utils.extmods][INFO    ][24939] Copying '/var/cache/salt/minion/files/base/_states/keystoneng.py' to '/var/cache/salt/minion/extmods/states/keystoneng.py'
2018-02-15 01:06:13,144 [salt.utils.extmods][INFO    ][24939] Copying '/var/cache/salt/minion/files/base/_states/kibana_object.py' to '/var/cache/salt/minion/extmods/states/kibana_object.py'
2018-02-15 01:06:13,146 [salt.utils.extmods][INFO    ][24939] Copying '/var/cache/salt/minion/files/base/_states/maas_cluster.py' to '/var/cache/salt/minion/extmods/states/maas_cluster.py'
2018-02-15 01:06:13,146 [salt.utils.extmods][INFO    ][24939] Copying '/var/cache/salt/minion/files/base/_states/neutronng.py' to '/var/cache/salt/minion/extmods/states/neutronng.py'
2018-02-15 01:06:13,146 [salt.utils.extmods][INFO    ][24939] Copying '/var/cache/salt/minion/files/base/_states/novang.py' to '/var/cache/salt/minion/extmods/states/novang.py'
2018-02-15 01:06:13,147 [salt.utils.extmods][INFO    ][24939] Copying '/var/cache/salt/minion/files/base/_states/reclass.py' to '/var/cache/salt/minion/extmods/states/reclass.py'
2018-02-15 01:06:13,147 [salt.utils.extmods][INFO    ][24939] Copying '/var/cache/salt/minion/files/base/_states/rundeck_project.py' to '/var/cache/salt/minion/extmods/states/rundeck_project.py'
2018-02-15 01:06:13,147 [salt.utils.extmods][INFO    ][24939] Copying '/var/cache/salt/minion/files/base/_states/rundeck_scm.py' to '/var/cache/salt/minion/extmods/states/rundeck_scm.py'
2018-02-15 01:06:13,147 [salt.utils.extmods][INFO    ][24939] Copying '/var/cache/salt/minion/files/base/_states/rundeck_secret.py' to '/var/cache/salt/minion/extmods/states/rundeck_secret.py'
2018-02-15 01:06:13,149 [salt.utils.extmods][INFO    ][24939] Creating module dir '/var/cache/salt/minion/extmods/sdb'
2018-02-15 01:06:13,154 [salt.utils.extmods][INFO    ][24939] Syncing sdb for environment 'base'
2018-02-15 01:06:13,154 [salt.utils.extmods][INFO    ][24939] Loading cache from salt://_sdb, for base)
2018-02-15 01:06:13,155 [salt.fileclient  ][INFO    ][24939] Caching directory '_sdb/' for environment 'base'
2018-02-15 01:06:13,186 [salt.utils.extmods][INFO    ][24939] Syncing grains for environment 'base'
2018-02-15 01:06:13,186 [salt.utils.extmods][INFO    ][24939] Loading cache from salt://_grains, for base)
2018-02-15 01:06:13,186 [salt.fileclient  ][INFO    ][24939] Caching directory '_grains/' for environment 'base'
2018-02-15 01:06:13,296 [salt.utils.extmods][INFO    ][24939] Copying '/var/cache/salt/minion/files/base/_grains/ceilometer_policy.py' to '/var/cache/salt/minion/extmods/grains/ceilometer_policy.py'
2018-02-15 01:06:13,297 [salt.utils.extmods][INFO    ][24939] Copying '/var/cache/salt/minion/files/base/_grains/ceph.py' to '/var/cache/salt/minion/extmods/grains/ceph.py'
2018-02-15 01:06:13,297 [salt.utils.extmods][INFO    ][24939] Copying '/var/cache/salt/minion/files/base/_grains/cinder_policy.py' to '/var/cache/salt/minion/extmods/grains/cinder_policy.py'
2018-02-15 01:06:13,298 [salt.utils.extmods][INFO    ][24939] Copying '/var/cache/salt/minion/files/base/_grains/docker_swarm.py' to '/var/cache/salt/minion/extmods/grains/docker_swarm.py'
2018-02-15 01:06:13,299 [salt.utils.extmods][INFO    ][24939] Copying '/var/cache/salt/minion/files/base/_grains/glance_policy.py' to '/var/cache/salt/minion/extmods/grains/glance_policy.py'
2018-02-15 01:06:13,299 [salt.utils.extmods][INFO    ][24939] Copying '/var/cache/salt/minion/files/base/_grains/heat_policy.py' to '/var/cache/salt/minion/extmods/grains/heat_policy.py'
2018-02-15 01:06:13,300 [salt.utils.extmods][INFO    ][24939] Copying '/var/cache/salt/minion/files/base/_grains/jenkins_plugins.py' to '/var/cache/salt/minion/extmods/grains/jenkins_plugins.py'
2018-02-15 01:06:13,300 [salt.utils.extmods][INFO    ][24939] Copying '/var/cache/salt/minion/files/base/_grains/keystone_policy.py' to '/var/cache/salt/minion/extmods/grains/keystone_policy.py'
2018-02-15 01:06:13,301 [salt.utils.extmods][INFO    ][24939] Copying '/var/cache/salt/minion/files/base/_grains/kubernetes.py' to '/var/cache/salt/minion/extmods/grains/kubernetes.py'
2018-02-15 01:06:13,302 [salt.utils.extmods][INFO    ][24939] Copying '/var/cache/salt/minion/files/base/_grains/neutron_policy.py' to '/var/cache/salt/minion/extmods/grains/neutron_policy.py'
2018-02-15 01:06:13,302 [salt.utils.extmods][INFO    ][24939] Copying '/var/cache/salt/minion/files/base/_grains/nova_policy.py' to '/var/cache/salt/minion/extmods/grains/nova_policy.py'
2018-02-15 01:06:13,303 [salt.utils.extmods][INFO    ][24939] Copying '/var/cache/salt/minion/files/base/_grains/ssh_fingerprints.py' to '/var/cache/salt/minion/extmods/grains/ssh_fingerprints.py'
2018-02-15 01:06:13,305 [salt.utils.extmods][INFO    ][24939] Creating module dir '/var/cache/salt/minion/extmods/renderers'
2018-02-15 01:06:13,312 [salt.utils.extmods][INFO    ][24939] Syncing renderers for environment 'base'
2018-02-15 01:06:13,312 [salt.utils.extmods][INFO    ][24939] Loading cache from salt://_renderers, for base)
2018-02-15 01:06:13,313 [salt.fileclient  ][INFO    ][24939] Caching directory '_renderers/' for environment 'base'
2018-02-15 01:06:13,357 [salt.utils.extmods][INFO    ][24939] Creating module dir '/var/cache/salt/minion/extmods/returners'
2018-02-15 01:06:13,365 [salt.utils.extmods][INFO    ][24939] Syncing returners for environment 'base'
2018-02-15 01:06:13,365 [salt.utils.extmods][INFO    ][24939] Loading cache from salt://_returners, for base)
2018-02-15 01:06:13,365 [salt.fileclient  ][INFO    ][24939] Caching directory '_returners/' for environment 'base'
2018-02-15 01:06:13,405 [salt.utils.extmods][INFO    ][24939] Creating module dir '/var/cache/salt/minion/extmods/output'
2018-02-15 01:06:13,414 [salt.utils.extmods][INFO    ][24939] Syncing output for environment 'base'
2018-02-15 01:06:13,415 [salt.utils.extmods][INFO    ][24939] Loading cache from salt://_output, for base)
2018-02-15 01:06:13,416 [salt.fileclient  ][INFO    ][24939] Caching directory '_output/' for environment 'base'
2018-02-15 01:06:13,454 [salt.utils.extmods][INFO    ][24939] Creating module dir '/var/cache/salt/minion/extmods/utils'
2018-02-15 01:06:13,461 [salt.utils.extmods][INFO    ][24939] Syncing utils for environment 'base'
2018-02-15 01:06:13,461 [salt.utils.extmods][INFO    ][24939] Loading cache from salt://_utils, for base)
2018-02-15 01:06:13,462 [salt.fileclient  ][INFO    ][24939] Caching directory '_utils/' for environment 'base'
2018-02-15 01:06:13,499 [salt.utils.extmods][INFO    ][24939] Creating module dir '/var/cache/salt/minion/extmods/log_handlers'
2018-02-15 01:06:13,506 [salt.utils.extmods][INFO    ][24939] Syncing log_handlers for environment 'base'
2018-02-15 01:06:13,507 [salt.utils.extmods][INFO    ][24939] Loading cache from salt://_log_handlers, for base)
2018-02-15 01:06:13,507 [salt.fileclient  ][INFO    ][24939] Caching directory '_log_handlers/' for environment 'base'
2018-02-15 01:06:13,544 [salt.utils.extmods][INFO    ][24939] Creating module dir '/var/cache/salt/minion/extmods/proxy'
2018-02-15 01:06:13,549 [salt.utils.extmods][INFO    ][24939] Syncing proxy for environment 'base'
2018-02-15 01:06:13,549 [salt.utils.extmods][INFO    ][24939] Loading cache from salt://_proxy, for base)
2018-02-15 01:06:13,550 [salt.fileclient  ][INFO    ][24939] Caching directory '_proxy/' for environment 'base'
2018-02-15 01:06:13,582 [salt.utils.extmods][INFO    ][24939] Syncing engines for environment 'base'
2018-02-15 01:06:13,582 [salt.utils.extmods][INFO    ][24939] Loading cache from salt://_engines, for base)
2018-02-15 01:06:13,582 [salt.fileclient  ][INFO    ][24939] Caching directory '_engines/' for environment 'base'
2018-02-15 01:06:13,629 [salt.utils.extmods][INFO    ][24939] Copying '/var/cache/salt/minion/files/base/_engines/architect.py' to '/var/cache/salt/minion/extmods/engines/architect.py'
2018-02-15 01:06:13,630 [salt.utils.extmods][INFO    ][24939] Copying '/var/cache/salt/minion/files/base/_engines/saltgraph.py' to '/var/cache/salt/minion/extmods/engines/saltgraph.py'
2018-02-15 01:06:13,637 [salt.minion      ][INFO    ][24939] Returning information for job: 20180215010610361720
2018-02-15 01:06:15,367 [salt.minion      ][INFO    ][20772] User sudo_ubuntu Executing command state.apply with jid 20180215010614989216
2018-02-15 01:06:15,395 [salt.minion      ][INFO    ][25076] Starting a new job with PID 25076
2018-02-15 01:06:15,861 [salt.state       ][INFO    ][25076] Loading fresh modules for state activity
2018-02-15 01:06:16,775 [salt.loaded.int.module.cmdmod][INFO    ][25076] Executing command 'reclass --version' in directory '/root'
2018-02-15 01:06:16,962 [salt.loaded.int.module.cmdmod][INFO    ][25076] Executing command 'reclass --version' in directory '/root'
2018-02-15 01:06:17,224 [salt.loaded.int.module.cmdmod][INFO    ][25076] Executing command 'salt-minion --version' in directory '/root'
2018-02-15 01:06:17,518 [salt.loaded.int.module.cmdmod][INFO    ][25076] Executing command 'salt --version' in directory '/root'
2018-02-15 01:06:17,796 [salt.loaded.int.module.cmdmod][INFO    ][25076] Executing command 'salt-minion --version' in directory '/root'
2018-02-15 01:06:18,044 [salt.loaded.int.module.cmdmod][INFO    ][25076] Executing command 'salt --version' in directory '/root'
2018-02-15 01:06:18,621 [salt.loaded.int.module.cmdmod][INFO    ][25076] Executing command 'reclass --version' in directory '/root'
2018-02-15 01:06:18,917 [salt.loaded.int.module.cmdmod][INFO    ][25076] Executing command 'reclass --version' in directory '/root'
2018-02-15 01:06:19,207 [salt.loaded.int.module.cmdmod][INFO    ][25076] Executing command 'salt-minion --version' in directory '/root'
2018-02-15 01:06:19,521 [salt.loaded.int.module.cmdmod][INFO    ][25076] Executing command 'salt --version' in directory '/root'
2018-02-15 01:06:19,810 [salt.loaded.int.module.cmdmod][INFO    ][25076] Executing command 'salt-minion --version' in directory '/root'
2018-02-15 01:06:20,116 [salt.loaded.int.module.cmdmod][INFO    ][25076] Executing command 'salt --version' in directory '/root'
2018-02-15 01:06:21,413 [salt.state       ][INFO    ][25076] Running state [salt-master] at time 01:06:21.413867
2018-02-15 01:06:21,414 [salt.state       ][INFO    ][25076] Executing state pkg.installed for salt-master
2018-02-15 01:06:21,415 [salt.loaded.int.module.cmdmod][INFO    ][25076] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2018-02-15 01:06:21,759 [salt.state       ][INFO    ][25076] All specified packages are already installed
2018-02-15 01:06:21,759 [salt.state       ][INFO    ][25076] Completed state [salt-master] at time 01:06:21.759906 duration_in_ms=346.039
2018-02-15 01:06:21,763 [salt.state       ][INFO    ][25076] Running state [/etc/salt/master.d/master.conf] at time 01:06:21.763191
2018-02-15 01:06:21,763 [salt.state       ][INFO    ][25076] Executing state file.managed for /etc/salt/master.d/master.conf
2018-02-15 01:06:21,913 [salt.state       ][INFO    ][25076] File /etc/salt/master.d/master.conf is in the correct state
2018-02-15 01:06:21,913 [salt.state       ][INFO    ][25076] Completed state [/etc/salt/master.d/master.conf] at time 01:06:21.913837 duration_in_ms=150.646
2018-02-15 01:06:21,929 [salt.state       ][INFO    ][25076] Running state [/etc/salt/master.d/_acl.conf] at time 01:06:21.929666
2018-02-15 01:06:21,930 [salt.state       ][INFO    ][25076] Executing state file.managed for /etc/salt/master.d/_acl.conf
2018-02-15 01:06:22,028 [salt.state       ][INFO    ][25076] File /etc/salt/master.d/_acl.conf is in the correct state
2018-02-15 01:06:22,028 [salt.state       ][INFO    ][25076] Completed state [/etc/salt/master.d/_acl.conf] at time 01:06:22.028768 duration_in_ms=99.101
2018-02-15 01:06:22,029 [salt.state       ][INFO    ][25076] Running state [/etc/salt/master.d/_peer.conf] at time 01:06:22.029886
2018-02-15 01:06:22,030 [salt.state       ][INFO    ][25076] Executing state file.managed for /etc/salt/master.d/_peer.conf
2018-02-15 01:06:22,092 [salt.state       ][INFO    ][25076] File /etc/salt/master.d/_peer.conf is in the correct state
2018-02-15 01:06:22,093 [salt.state       ][INFO    ][25076] Completed state [/etc/salt/master.d/_peer.conf] at time 01:06:22.093005 duration_in_ms=63.119
2018-02-15 01:06:22,095 [salt.state       ][INFO    ][25076] Running state [salt-master] at time 01:06:22.095217
2018-02-15 01:06:22,095 [salt.state       ][INFO    ][25076] Executing state service.running for salt-master
2018-02-15 01:06:22,096 [salt.loaded.int.module.cmdmod][INFO    ][25076] Executing command ['systemctl', 'status', 'salt-master.service', '-n', '0'] in directory '/root'
2018-02-15 01:06:22,142 [salt.loaded.int.module.cmdmod][INFO    ][25076] Executing command ['systemctl', 'is-active', 'salt-master.service'] in directory '/root'
2018-02-15 01:06:22,162 [salt.loaded.int.module.cmdmod][INFO    ][25076] Executing command ['systemctl', 'is-enabled', 'salt-master.service'] in directory '/root'
2018-02-15 01:06:22,183 [salt.state       ][INFO    ][25076] The service salt-master is already running
2018-02-15 01:06:22,184 [salt.state       ][INFO    ][25076] Completed state [salt-master] at time 01:06:22.184366 duration_in_ms=89.147
2018-02-15 01:06:22,184 [salt.state       ][INFO    ][25076] Running state [/srv/salt/env] at time 01:06:22.184928
2018-02-15 01:06:22,185 [salt.state       ][INFO    ][25076] Executing state file.directory for /srv/salt/env
2018-02-15 01:06:22,186 [salt.state       ][INFO    ][25076] Directory /srv/salt/env is in the correct state
2018-02-15 01:06:22,186 [salt.state       ][INFO    ][25076] Completed state [/srv/salt/env] at time 01:06:22.186895 duration_in_ms=1.967
2018-02-15 01:06:22,188 [salt.state       ][INFO    ][25076] Running state [root] at time 01:06:22.188482
2018-02-15 01:06:22,188 [salt.state       ][INFO    ][25076] Executing state user.present for root
2018-02-15 01:06:22,190 [salt.state       ][INFO    ][25076] User root is present and up to date
2018-02-15 01:06:22,190 [salt.state       ][INFO    ][25076] Completed state [root] at time 01:06:22.190574 duration_in_ms=2.092
2018-02-15 01:06:22,191 [salt.state       ][INFO    ][25076] Running state [/root] at time 01:06:22.191812
2018-02-15 01:06:22,192 [salt.state       ][INFO    ][25076] Executing state file.directory for /root
2018-02-15 01:06:22,193 [salt.state       ][INFO    ][25076] Directory /root is in the correct state
2018-02-15 01:06:22,193 [salt.state       ][INFO    ][25076] Completed state [/root] at time 01:06:22.193362 duration_in_ms=1.551
2018-02-15 01:06:22,193 [salt.state       ][INFO    ][25076] Running state [/etc/sudoers.d/90-salt-user-root] at time 01:06:22.193781
2018-02-15 01:06:22,194 [salt.state       ][INFO    ][25076] Executing state file.absent for /etc/sudoers.d/90-salt-user-root
2018-02-15 01:06:22,194 [salt.state       ][INFO    ][25076] File /etc/sudoers.d/90-salt-user-root is not present
2018-02-15 01:06:22,195 [salt.state       ][INFO    ][25076] Completed state [/etc/sudoers.d/90-salt-user-root] at time 01:06:22.195067 duration_in_ms=1.285
2018-02-15 01:06:22,195 [salt.state       ][INFO    ][25076] Running state [salt] at time 01:06:22.195480
2018-02-15 01:06:22,195 [salt.state       ][INFO    ][25076] Executing state user.present for salt
2018-02-15 01:06:22,196 [salt.state       ][INFO    ][25076] User salt is present and up to date
2018-02-15 01:06:22,197 [salt.state       ][INFO    ][25076] Completed state [salt] at time 01:06:22.197292 duration_in_ms=1.811
2018-02-15 01:06:22,198 [salt.state       ][INFO    ][25076] Running state [/var/tmp/salt] at time 01:06:22.198251
2018-02-15 01:06:22,198 [salt.state       ][INFO    ][25076] Executing state file.directory for /var/tmp/salt
2018-02-15 01:06:22,199 [salt.state       ][INFO    ][25076] Directory /var/tmp/salt is in the correct state
2018-02-15 01:06:22,199 [salt.state       ][INFO    ][25076] Completed state [/var/tmp/salt] at time 01:06:22.199826 duration_in_ms=1.575
2018-02-15 01:06:22,200 [salt.state       ][INFO    ][25076] Running state [/etc/sudoers.d/90-salt-user-salt] at time 01:06:22.200242
2018-02-15 01:06:22,200 [salt.state       ][INFO    ][25076] Executing state file.absent for /etc/sudoers.d/90-salt-user-salt
2018-02-15 01:06:22,201 [salt.state       ][INFO    ][25076] File /etc/sudoers.d/90-salt-user-salt is not present
2018-02-15 01:06:22,201 [salt.state       ][INFO    ][25076] Completed state [/etc/sudoers.d/90-salt-user-salt] at time 01:06:22.201482 duration_in_ms=1.239
2018-02-15 01:06:22,201 [salt.state       ][INFO    ][25076] Running state [ubuntu] at time 01:06:22.201889
2018-02-15 01:06:22,202 [salt.state       ][INFO    ][25076] Executing state user.present for ubuntu
2018-02-15 01:06:22,203 [salt.state       ][INFO    ][25076] User ubuntu is present and up to date
2018-02-15 01:06:22,203 [salt.state       ][INFO    ][25076] Completed state [ubuntu] at time 01:06:22.203716 duration_in_ms=1.828
2018-02-15 01:06:22,205 [salt.state       ][INFO    ][25076] Running state [/home/ubuntu] at time 01:06:22.205007
2018-02-15 01:06:22,205 [salt.state       ][INFO    ][25076] Executing state file.directory for /home/ubuntu
2018-02-15 01:06:22,206 [salt.state       ][INFO    ][25076] Directory /home/ubuntu is in the correct state
2018-02-15 01:06:22,206 [salt.state       ][INFO    ][25076] Completed state [/home/ubuntu] at time 01:06:22.206604 duration_in_ms=1.597
2018-02-15 01:06:22,207 [salt.state       ][INFO    ][25076] Running state [/etc/sudoers.d/90-salt-user-ubuntu] at time 01:06:22.207442
2018-02-15 01:06:22,207 [salt.state       ][INFO    ][25076] Executing state file.managed for /etc/sudoers.d/90-salt-user-ubuntu
2018-02-15 01:06:22,233 [salt.state       ][INFO    ][25076] File /etc/sudoers.d/90-salt-user-ubuntu is in the correct state
2018-02-15 01:06:22,233 [salt.state       ][INFO    ][25076] Completed state [/etc/sudoers.d/90-salt-user-ubuntu] at time 01:06:22.233620 duration_in_ms=26.177
2018-02-15 01:06:22,234 [salt.state       ][INFO    ][25076] Running state [git-core] at time 01:06:22.234048
2018-02-15 01:06:22,234 [salt.state       ][INFO    ][25076] Executing state pkg.installed for git-core
2018-02-15 01:06:22,239 [salt.state       ][INFO    ][25076] All specified packages are already installed
2018-02-15 01:06:22,240 [salt.state       ][INFO    ][25076] Completed state [git-core] at time 01:06:22.240299 duration_in_ms=6.252
2018-02-15 01:06:22,240 [salt.state       ][INFO    ][25076] Running state [/usr/share/salt-formulas/env/_modules] at time 01:06:22.240708
2018-02-15 01:06:22,241 [salt.state       ][INFO    ][25076] Executing state file.directory for /usr/share/salt-formulas/env/_modules
2018-02-15 01:06:22,241 [salt.state       ][INFO    ][25076] Directory /usr/share/salt-formulas/env/_modules is in the correct state
2018-02-15 01:06:22,242 [salt.state       ][INFO    ][25076] Completed state [/usr/share/salt-formulas/env/_modules] at time 01:06:22.242180 duration_in_ms=1.471
2018-02-15 01:06:22,242 [salt.state       ][INFO    ][25076] Running state [/usr/share/salt-formulas/env/_states] at time 01:06:22.242587
2018-02-15 01:06:22,242 [salt.state       ][INFO    ][25076] Executing state file.directory for /usr/share/salt-formulas/env/_states
2018-02-15 01:06:22,243 [salt.state       ][INFO    ][25076] Directory /usr/share/salt-formulas/env/_states is in the correct state
2018-02-15 01:06:22,244 [salt.state       ][INFO    ][25076] Completed state [/usr/share/salt-formulas/env/_states] at time 01:06:22.243990 duration_in_ms=1.403
2018-02-15 01:06:22,244 [salt.state       ][INFO    ][25076] Running state [/usr/share/salt-formulas/env/_grains] at time 01:06:22.244395
2018-02-15 01:06:22,244 [salt.state       ][INFO    ][25076] Executing state file.directory for /usr/share/salt-formulas/env/_grains
2018-02-15 01:06:22,245 [salt.state       ][INFO    ][25076] Directory /usr/share/salt-formulas/env/_grains is in the correct state
2018-02-15 01:06:22,245 [salt.state       ][INFO    ][25076] Completed state [/usr/share/salt-formulas/env/_grains] at time 01:06:22.245789 duration_in_ms=1.393
2018-02-15 01:06:22,246 [salt.state       ][INFO    ][25076] Running state [/usr/share/salt-formulas/env/_formulas] at time 01:06:22.246215
2018-02-15 01:06:22,246 [salt.state       ][INFO    ][25076] Executing state file.directory for /usr/share/salt-formulas/env/_formulas
2018-02-15 01:06:22,247 [salt.state       ][INFO    ][25076] Directory /usr/share/salt-formulas/env/_formulas is in the correct state
2018-02-15 01:06:22,247 [salt.state       ][INFO    ][25076] Completed state [/usr/share/salt-formulas/env/_formulas] at time 01:06:22.247622 duration_in_ms=1.407
2018-02-15 01:06:22,248 [salt.state       ][INFO    ][25076] Running state [/usr/share/salt-formulas/env/_engines] at time 01:06:22.248015
2018-02-15 01:06:22,248 [salt.state       ][INFO    ][25076] Executing state file.directory for /usr/share/salt-formulas/env/_engines
2018-02-15 01:06:22,249 [salt.state       ][INFO    ][25076] Directory /usr/share/salt-formulas/env/_engines is in the correct state
2018-02-15 01:06:22,249 [salt.state       ][INFO    ][25076] Completed state [/usr/share/salt-formulas/env/_engines] at time 01:06:22.249401 duration_in_ms=1.387
2018-02-15 01:06:22,249 [salt.state       ][INFO    ][25076] Running state [/usr/share/salt-formulas/env/_runners] at time 01:06:22.249785
2018-02-15 01:06:22,250 [salt.state       ][INFO    ][25076] Executing state file.directory for /usr/share/salt-formulas/env/_runners
2018-02-15 01:06:22,250 [salt.state       ][INFO    ][25076] Directory /usr/share/salt-formulas/env/_runners is in the correct state
2018-02-15 01:06:22,251 [salt.state       ][INFO    ][25076] Completed state [/usr/share/salt-formulas/env/_runners] at time 01:06:22.251234 duration_in_ms=1.449
2018-02-15 01:06:22,252 [salt.state       ][INFO    ][25076] Running state [/srv/salt/env/prd] at time 01:06:22.252327
2018-02-15 01:06:22,252 [salt.state       ][INFO    ][25076] Executing state file.symlink for /srv/salt/env/prd
2018-02-15 01:06:22,254 [salt.state       ][INFO    ][25076] Symlink /srv/salt/env/prd is present and owned by root:root
2018-02-15 01:06:22,254 [salt.state       ][INFO    ][25076] Completed state [/srv/salt/env/prd] at time 01:06:22.254464 duration_in_ms=2.137
2018-02-15 01:06:22,254 [salt.state       ][INFO    ][25076] Running state [salt_master_prd_pkg_formulas] at time 01:06:22.254862
2018-02-15 01:06:22,255 [salt.state       ][INFO    ][25076] Executing state pkg.latest for salt_master_prd_pkg_formulas
2018-02-15 01:06:22,264 [salt.loaded.int.module.cmdmod][INFO    ][25076] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-maas'] in directory '/root'
2018-02-15 01:06:22,318 [salt.loaded.int.module.cmdmod][INFO    ][25076] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-grafana'] in directory '/root'
2018-02-15 01:06:22,372 [salt.loaded.int.module.cmdmod][INFO    ][25076] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-xtrabackup'] in directory '/root'
2018-02-15 01:06:22,459 [salt.loaded.int.module.cmdmod][INFO    ][25076] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-docker'] in directory '/root'
2018-02-15 01:06:22,515 [salt.loaded.int.module.cmdmod][INFO    ][25076] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-heat'] in directory '/root'
2018-02-15 01:06:22,572 [salt.loaded.int.module.cmdmod][INFO    ][25076] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-reclass'] in directory '/root'
2018-02-15 01:06:22,626 [salt.loaded.int.module.cmdmod][INFO    ][25076] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-redis'] in directory '/root'
2018-02-15 01:06:22,676 [salt.loaded.int.module.cmdmod][INFO    ][25076] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-nova'] in directory '/root'
2018-02-15 01:06:22,768 [salt.loaded.int.module.cmdmod][INFO    ][25076] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-iptables'] in directory '/root'
2018-02-15 01:06:22,842 [salt.loaded.int.module.cmdmod][INFO    ][25076] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-murano'] in directory '/root'
2018-02-15 01:06:22,906 [salt.loaded.int.module.cmdmod][INFO    ][25076] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-glusterfs'] in directory '/root'
2018-02-15 01:06:22,966 [salt.loaded.int.module.cmdmod][INFO    ][25076] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-backupninja'] in directory '/root'
2018-02-15 01:06:23,060 [salt.loaded.int.module.cmdmod][INFO    ][25076] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-kubernetes'] in directory '/root'
2018-02-15 01:06:23,140 [salt.loaded.int.module.cmdmod][INFO    ][25076] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-linux'] in directory '/root'
2018-02-15 01:06:23,219 [salt.loaded.int.module.cmdmod][INFO    ][25076] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-git'] in directory '/root'
2018-02-15 01:06:23,281 [salt.loaded.int.module.cmdmod][INFO    ][25076] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-apache'] in directory '/root'
2018-02-15 01:06:23,329 [salt.loaded.int.module.cmdmod][INFO    ][25076] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-aptly'] in directory '/root'
2018-02-15 01:06:23,391 [salt.loaded.int.module.cmdmod][INFO    ][25076] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-gerrit'] in directory '/root'
2018-02-15 01:06:23,495 [salt.loaded.int.module.cmdmod][INFO    ][25076] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-sensu'] in directory '/root'
2018-02-15 01:06:23,562 [salt.loaded.int.module.cmdmod][INFO    ][25076] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-aptcacher'] in directory '/root'
2018-02-15 01:06:23,660 [salt.loaded.int.module.cmdmod][INFO    ][25076] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-glance'] in directory '/root'
2018-02-15 01:06:23,760 [salt.loaded.int.module.cmdmod][INFO    ][25076] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-heka'] in directory '/root'
2018-02-15 01:06:23,830 [salt.loaded.int.module.cmdmod][INFO    ][25076] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-keystone'] in directory '/root'
2018-02-15 01:06:23,902 [salt.loaded.int.module.cmdmod][INFO    ][25076] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-ntp'] in directory '/root'
2018-02-15 01:06:23,994 [salt.loaded.int.module.cmdmod][INFO    ][25076] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-barbican'] in directory '/root'
2018-02-15 01:06:24,085 [salt.loaded.int.module.cmdmod][INFO    ][25076] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-aodh'] in directory '/root'
2018-02-15 01:06:24,145 [salt.loaded.int.module.cmdmod][INFO    ][25076] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-python'] in directory '/root'
2018-02-15 01:06:24,197 [salt.loaded.int.module.cmdmod][INFO    ][25076] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-collectd'] in directory '/root'
2018-02-15 01:06:24,250 [salt.loaded.int.module.cmdmod][INFO    ][25076] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-neutron'] in directory '/root'
2018-02-15 01:06:24,300 [salt.loaded.int.module.cmdmod][INFO    ][25076] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-supervisor'] in directory '/root'
2018-02-15 01:06:24,356 [salt.loaded.int.module.cmdmod][INFO    ][25076] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-ceilometer'] in directory '/root'
2018-02-15 01:06:24,412 [salt.loaded.int.module.cmdmod][INFO    ][25076] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-elasticsearch'] in directory '/root'
2018-02-15 01:06:24,461 [salt.loaded.int.module.cmdmod][INFO    ][25076] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-powerdns'] in directory '/root'
2018-02-15 01:06:24,507 [salt.loaded.int.module.cmdmod][INFO    ][25076] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-cassandra'] in directory '/root'
2018-02-15 01:06:24,552 [salt.loaded.int.module.cmdmod][INFO    ][25076] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-libvirt'] in directory '/root'
2018-02-15 01:06:24,595 [salt.loaded.int.module.cmdmod][INFO    ][25076] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-sahara'] in directory '/root'
2018-02-15 01:06:24,640 [salt.loaded.int.module.cmdmod][INFO    ][25076] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-openssh'] in directory '/root'
2018-02-15 01:06:24,683 [salt.loaded.int.module.cmdmod][INFO    ][25076] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-statsd'] in directory '/root'
2018-02-15 01:06:24,728 [salt.loaded.int.module.cmdmod][INFO    ][25076] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-mongodb'] in directory '/root'
2018-02-15 01:06:24,771 [salt.loaded.int.module.cmdmod][INFO    ][25076] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-kibana'] in directory '/root'
2018-02-15 01:06:24,816 [salt.loaded.int.module.cmdmod][INFO    ][25076] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-sphinx'] in directory '/root'
2018-02-15 01:06:24,866 [salt.loaded.int.module.cmdmod][INFO    ][25076] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-freeipa'] in directory '/root'
2018-02-15 01:06:24,919 [salt.loaded.int.module.cmdmod][INFO    ][25076] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-octavia'] in directory '/root'
2018-02-15 01:06:24,966 [salt.loaded.int.module.cmdmod][INFO    ][25076] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-bind'] in directory '/root'
2018-02-15 01:06:25,016 [salt.loaded.int.module.cmdmod][INFO    ][25076] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-salt'] in directory '/root'
2018-02-15 01:06:25,055 [salt.minion      ][INFO    ][20772] User sudo_ubuntu Executing command saltutil.find_job with jid 20180215010625044899
2018-02-15 01:06:25,095 [salt.loaded.int.module.cmdmod][INFO    ][25076] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-etcd'] in directory '/root'
2018-02-15 01:06:25,125 [salt.minion      ][INFO    ][25313] Starting a new job with PID 25313
2018-02-15 01:06:25,143 [salt.minion      ][INFO    ][25313] Returning information for job: 20180215010625044899
2018-02-15 01:06:25,183 [salt.loaded.int.module.cmdmod][INFO    ][25076] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-devops-portal'] in directory '/root'
2018-02-15 01:06:25,238 [salt.loaded.int.module.cmdmod][INFO    ][25076] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-postgresql'] in directory '/root'
2018-02-15 01:06:25,292 [salt.loaded.int.module.cmdmod][INFO    ][25076] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-avinetworks'] in directory '/root'
2018-02-15 01:06:25,356 [salt.loaded.int.module.cmdmod][INFO    ][25076] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-nginx'] in directory '/root'
2018-02-15 01:06:25,403 [salt.loaded.int.module.cmdmod][INFO    ][25076] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-mysql'] in directory '/root'
2018-02-15 01:06:25,458 [salt.loaded.int.module.cmdmod][INFO    ][25076] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-ceph'] in directory '/root'
2018-02-15 01:06:25,502 [salt.loaded.int.module.cmdmod][INFO    ][25076] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-horizon'] in directory '/root'
2018-02-15 01:06:25,547 [salt.loaded.int.module.cmdmod][INFO    ][25076] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-haproxy'] in directory '/root'
2018-02-15 01:06:25,596 [salt.loaded.int.module.cmdmod][INFO    ][25076] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-java'] in directory '/root'
2018-02-15 01:06:25,682 [salt.loaded.int.module.cmdmod][INFO    ][25076] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-billometer'] in directory '/root'
2018-02-15 01:06:25,752 [salt.loaded.int.module.cmdmod][INFO    ][25076] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-telegraf'] in directory '/root'
2018-02-15 01:06:25,848 [salt.loaded.int.module.cmdmod][INFO    ][25076] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-designate'] in directory '/root'
2018-02-15 01:06:25,943 [salt.loaded.int.module.cmdmod][INFO    ][25076] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-keepalived'] in directory '/root'
2018-02-15 01:06:26,031 [salt.loaded.int.module.cmdmod][INFO    ][25076] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-rundeck'] in directory '/root'
2018-02-15 01:06:26,112 [salt.loaded.int.module.cmdmod][INFO    ][25076] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-ccp'] in directory '/root'
2018-02-15 01:06:26,175 [salt.loaded.int.module.cmdmod][INFO    ][25076] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-tinyproxy'] in directory '/root'
2018-02-15 01:06:26,236 [salt.loaded.int.module.cmdmod][INFO    ][25076] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-rabbitmq'] in directory '/root'
2018-02-15 01:06:26,302 [salt.loaded.int.module.cmdmod][INFO    ][25076] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-openldap'] in directory '/root'
2018-02-15 01:06:26,390 [salt.loaded.int.module.cmdmod][INFO    ][25076] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-influxdb'] in directory '/root'
2018-02-15 01:06:26,485 [salt.loaded.int.module.cmdmod][INFO    ][25076] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-memcached'] in directory '/root'
2018-02-15 01:06:26,585 [salt.loaded.int.module.cmdmod][INFO    ][25076] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-prometheus'] in directory '/root'
2018-02-15 01:06:26,662 [salt.loaded.int.module.cmdmod][INFO    ][25076] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-helm'] in directory '/root'
2018-02-15 01:06:26,739 [salt.loaded.int.module.cmdmod][INFO    ][25076] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-opencontrail'] in directory '/root'
2018-02-15 01:06:26,807 [salt.loaded.int.module.cmdmod][INFO    ][25076] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-jenkins'] in directory '/root'
2018-02-15 01:06:26,882 [salt.loaded.int.module.cmdmod][INFO    ][25076] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-lldp'] in directory '/root'
2018-02-15 01:06:26,968 [salt.loaded.int.module.cmdmod][INFO    ][25076] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-nagios'] in directory '/root'
2018-02-15 01:06:27,113 [salt.loaded.int.module.cmdmod][INFO    ][25076] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-swift'] in directory '/root'
2018-02-15 01:06:27,198 [salt.loaded.int.module.cmdmod][INFO    ][25076] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-zookeeper'] in directory '/root'
2018-02-15 01:06:27,287 [salt.loaded.int.module.cmdmod][INFO    ][25076] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-galera'] in directory '/root'
2018-02-15 01:06:27,358 [salt.loaded.int.module.cmdmod][INFO    ][25076] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-graphite'] in directory '/root'
2018-02-15 01:06:27,439 [salt.loaded.int.module.cmdmod][INFO    ][25076] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-cinder'] in directory '/root'
2018-02-15 01:06:27,533 [salt.loaded.int.module.cmdmod][INFO    ][25076] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-rsyslog'] in directory '/root'
2018-02-15 01:06:27,613 [salt.state       ][INFO    ][25076] All 78 packages are up-to-date.
2018-02-15 01:06:27,614 [salt.state       ][INFO    ][25076] Completed state [salt_master_prd_pkg_formulas] at time 01:06:27.614648 duration_in_ms=5359.783
2018-02-15 01:06:27,616 [salt.state       ][INFO    ][25076] Running state [/srv/salt/reclass] at time 01:06:27.615988
2018-02-15 01:06:27,617 [salt.state       ][INFO    ][25076] Executing state file.directory for /srv/salt/reclass
2018-02-15 01:06:27,619 [salt.state       ][INFO    ][25076] Directory /srv/salt/reclass is in the correct state
2018-02-15 01:06:27,620 [salt.state       ][INFO    ][25076] Completed state [/srv/salt/reclass] at time 01:06:27.620722 duration_in_ms=4.735
2018-02-15 01:06:27,623 [salt.state       ][INFO    ][25076] Running state [/srv/salt/reclass/classes/service] at time 01:06:27.623915
2018-02-15 01:06:27,625 [salt.state       ][INFO    ][25076] Executing state file.directory for /srv/salt/reclass/classes/service
2018-02-15 01:06:27,626 [salt.state       ][INFO    ][25076] Directory /srv/salt/reclass/classes/service is in the correct state
2018-02-15 01:06:27,627 [salt.state       ][INFO    ][25076] Completed state [/srv/salt/reclass/classes/service] at time 01:06:27.627874 duration_in_ms=3.959
2018-02-15 01:06:27,630 [salt.state       ][INFO    ][25076] Running state [/srv/salt/reclass/classes/service/powerdns] at time 01:06:27.630555
2018-02-15 01:06:27,631 [salt.state       ][INFO    ][25076] Executing state file.symlink for /srv/salt/reclass/classes/service/powerdns
2018-02-15 01:06:27,635 [salt.state       ][INFO    ][25076] Symlink /srv/salt/reclass/classes/service/powerdns is present and owned by root:root
2018-02-15 01:06:27,636 [salt.state       ][INFO    ][25076] Completed state [/srv/salt/reclass/classes/service/powerdns] at time 01:06:27.636395 duration_in_ms=5.84
2018-02-15 01:06:27,638 [salt.state       ][INFO    ][25076] Running state [/srv/salt/reclass/classes/service/galera] at time 01:06:27.638509
2018-02-15 01:06:27,639 [salt.state       ][INFO    ][25076] Executing state file.symlink for /srv/salt/reclass/classes/service/galera
2018-02-15 01:06:27,643 [salt.state       ][INFO    ][25076] Symlink /srv/salt/reclass/classes/service/galera is present and owned by root:root
2018-02-15 01:06:27,643 [salt.state       ][INFO    ][25076] Completed state [/srv/salt/reclass/classes/service/galera] at time 01:06:27.643869 duration_in_ms=5.36
2018-02-15 01:06:27,645 [salt.state       ][INFO    ][25076] Running state [/srv/salt/reclass/classes/service/telegraf] at time 01:06:27.645804
2018-02-15 01:06:27,646 [salt.state       ][INFO    ][25076] Executing state file.symlink for /srv/salt/reclass/classes/service/telegraf
2018-02-15 01:06:27,650 [salt.state       ][INFO    ][25076] Symlink /srv/salt/reclass/classes/service/telegraf is present and owned by root:root
2018-02-15 01:06:27,651 [salt.state       ][INFO    ][25076] Completed state [/srv/salt/reclass/classes/service/telegraf] at time 01:06:27.650982 duration_in_ms=5.178
2018-02-15 01:06:27,652 [salt.state       ][INFO    ][25076] Running state [/srv/salt/reclass/classes/service/supervisor] at time 01:06:27.652766
2018-02-15 01:06:27,653 [salt.state       ][INFO    ][25076] Executing state file.symlink for /srv/salt/reclass/classes/service/supervisor
2018-02-15 01:06:27,657 [salt.state       ][INFO    ][25076] Symlink /srv/salt/reclass/classes/service/supervisor is present and owned by root:root
2018-02-15 01:06:27,657 [salt.state       ][INFO    ][25076] Completed state [/srv/salt/reclass/classes/service/supervisor] at time 01:06:27.657752 duration_in_ms=4.986
2018-02-15 01:06:27,659 [salt.state       ][INFO    ][25076] Running state [/srv/salt/reclass/classes/service/sensu] at time 01:06:27.659580
2018-02-15 01:06:27,660 [salt.state       ][INFO    ][25076] Executing state file.symlink for /srv/salt/reclass/classes/service/sensu
2018-02-15 01:06:27,663 [salt.state       ][INFO    ][25076] Symlink /srv/salt/reclass/classes/service/sensu is present and owned by root:root
2018-02-15 01:06:27,664 [salt.state       ][INFO    ][25076] Completed state [/srv/salt/reclass/classes/service/sensu] at time 01:06:27.664263 duration_in_ms=4.683
2018-02-15 01:06:27,665 [salt.state       ][INFO    ][25076] Running state [/srv/salt/reclass/classes/service/aodh] at time 01:06:27.665918
2018-02-15 01:06:27,666 [salt.state       ][INFO    ][25076] Executing state file.symlink for /srv/salt/reclass/classes/service/aodh
2018-02-15 01:06:27,669 [salt.state       ][INFO    ][25076] Symlink /srv/salt/reclass/classes/service/aodh is present and owned by root:root
2018-02-15 01:06:27,670 [salt.state       ][INFO    ][25076] Completed state [/srv/salt/reclass/classes/service/aodh] at time 01:06:27.670601 duration_in_ms=4.682
2018-02-15 01:06:27,672 [salt.state       ][INFO    ][25076] Running state [/srv/salt/reclass/classes/service/tinyproxy] at time 01:06:27.672178
2018-02-15 01:06:27,672 [salt.state       ][INFO    ][25076] Executing state file.symlink for /srv/salt/reclass/classes/service/tinyproxy
2018-02-15 01:06:27,675 [salt.state       ][INFO    ][25076] Symlink /srv/salt/reclass/classes/service/tinyproxy is present and owned by root:root
2018-02-15 01:06:27,676 [salt.state       ][INFO    ][25076] Completed state [/srv/salt/reclass/classes/service/tinyproxy] at time 01:06:27.676627 duration_in_ms=4.448
2018-02-15 01:06:27,678 [salt.state       ][INFO    ][25076] Running state [/srv/salt/reclass/classes/service/collectd] at time 01:06:27.678295
2018-02-15 01:06:27,679 [salt.state       ][INFO    ][25076] Executing state file.symlink for /srv/salt/reclass/classes/service/collectd
2018-02-15 01:06:27,682 [salt.state       ][INFO    ][25076] Symlink /srv/salt/reclass/classes/service/collectd is present and owned by root:root
2018-02-15 01:06:27,682 [salt.state       ][INFO    ][25076] Completed state [/srv/salt/reclass/classes/service/collectd] at time 01:06:27.682717 duration_in_ms=4.421
2018-02-15 01:06:27,684 [salt.state       ][INFO    ][25076] Running state [/srv/salt/reclass/classes/service/nagios] at time 01:06:27.684272
2018-02-15 01:06:27,685 [salt.state       ][INFO    ][25076] Executing state file.symlink for /srv/salt/reclass/classes/service/nagios
2018-02-15 01:06:27,687 [salt.state       ][INFO    ][25076] Symlink /srv/salt/reclass/classes/service/nagios is present and owned by root:root
2018-02-15 01:06:27,688 [salt.state       ][INFO    ][25076] Completed state [/srv/salt/reclass/classes/service/nagios] at time 01:06:27.688600 duration_in_ms=4.327
2018-02-15 01:06:27,690 [salt.state       ][INFO    ][25076] Running state [/srv/salt/reclass/classes/service/ceph] at time 01:06:27.690211
2018-02-15 01:06:27,691 [salt.state       ][INFO    ][25076] Executing state file.symlink for /srv/salt/reclass/classes/service/ceph
2018-02-15 01:06:27,693 [salt.state       ][INFO    ][25076] Symlink /srv/salt/reclass/classes/service/ceph is present and owned by root:root
2018-02-15 01:06:27,694 [salt.state       ][INFO    ][25076] Completed state [/srv/salt/reclass/classes/service/ceph] at time 01:06:27.694417 duration_in_ms=4.206
2018-02-15 01:06:27,695 [salt.state       ][INFO    ][25076] Running state [/srv/salt/reclass/classes/service/apache] at time 01:06:27.695902
2018-02-15 01:06:27,696 [salt.state       ][INFO    ][25076] Executing state file.symlink for /srv/salt/reclass/classes/service/apache
2018-02-15 01:06:27,699 [salt.state       ][INFO    ][25076] Symlink /srv/salt/reclass/classes/service/apache is present and owned by root:root
2018-02-15 01:06:27,700 [salt.state       ][INFO    ][25076] Completed state [/srv/salt/reclass/classes/service/apache] at time 01:06:27.700044 duration_in_ms=4.143
2018-02-15 01:06:27,701 [salt.state       ][INFO    ][25076] Running state [/srv/salt/reclass/classes/service/glusterfs] at time 01:06:27.701517
2018-02-15 01:06:27,702 [salt.state       ][INFO    ][25076] Executing state file.symlink for /srv/salt/reclass/classes/service/glusterfs
2018-02-15 01:06:27,704 [salt.state       ][INFO    ][25076] Symlink /srv/salt/reclass/classes/service/glusterfs is present and owned by root:root
2018-02-15 01:06:27,705 [salt.state       ][INFO    ][25076] Completed state [/srv/salt/reclass/classes/service/glusterfs] at time 01:06:27.705464 duration_in_ms=3.947
2018-02-15 01:06:27,706 [salt.state       ][INFO    ][25076] Running state [/srv/salt/reclass/classes/service/xtrabackup] at time 01:06:27.706901
2018-02-15 01:06:27,707 [salt.state       ][INFO    ][25076] Executing state file.symlink for /srv/salt/reclass/classes/service/xtrabackup
2018-02-15 01:06:27,710 [salt.state       ][INFO    ][25076] Symlink /srv/salt/reclass/classes/service/xtrabackup is present and owned by root:root
2018-02-15 01:06:27,710 [salt.state       ][INFO    ][25076] Completed state [/srv/salt/reclass/classes/service/xtrabackup] at time 01:06:27.710844 duration_in_ms=3.943
2018-02-15 01:06:27,712 [salt.state       ][INFO    ][25076] Running state [/srv/salt/reclass/classes/service/sahara] at time 01:06:27.712199
2018-02-15 01:06:27,712 [salt.state       ][INFO    ][25076] Executing state file.symlink for /srv/salt/reclass/classes/service/sahara
2018-02-15 01:06:27,715 [salt.state       ][INFO    ][25076] Symlink /srv/salt/reclass/classes/service/sahara is present and owned by root:root
2018-02-15 01:06:27,716 [salt.state       ][INFO    ][25076] Completed state [/srv/salt/reclass/classes/service/sahara] at time 01:06:27.715966 duration_in_ms=3.766
2018-02-15 01:06:27,717 [salt.state       ][INFO    ][25076] Running state [/srv/salt/reclass/classes/service/backupninja] at time 01:06:27.717322
2018-02-15 01:06:27,718 [salt.state       ][INFO    ][25076] Executing state file.symlink for /srv/salt/reclass/classes/service/backupninja
2018-02-15 01:06:27,720 [salt.state       ][INFO    ][25076] Symlink /srv/salt/reclass/classes/service/backupninja is present and owned by root:root
2018-02-15 01:06:27,721 [salt.state       ][INFO    ][25076] Completed state [/srv/salt/reclass/classes/service/backupninja] at time 01:06:27.721125 duration_in_ms=3.803
2018-02-15 01:06:27,722 [salt.state       ][INFO    ][25076] Running state [/srv/salt/reclass/classes/service/rsyslog] at time 01:06:27.722498
2018-02-15 01:06:27,723 [salt.state       ][INFO    ][25076] Executing state file.symlink for /srv/salt/reclass/classes/service/rsyslog
2018-02-15 01:06:27,725 [salt.state       ][INFO    ][25076] Symlink /srv/salt/reclass/classes/service/rsyslog is present and owned by root:root
2018-02-15 01:06:27,726 [salt.state       ][INFO    ][25076] Completed state [/srv/salt/reclass/classes/service/rsyslog] at time 01:06:27.726104 duration_in_ms=3.606
2018-02-15 01:06:27,727 [salt.state       ][INFO    ][25076] Running state [/srv/salt/reclass/classes/service/mysql] at time 01:06:27.727413
2018-02-15 01:06:27,728 [salt.state       ][INFO    ][25076] Executing state file.symlink for /srv/salt/reclass/classes/service/mysql
2018-02-15 01:06:27,730 [salt.state       ][INFO    ][25076] Symlink /srv/salt/reclass/classes/service/mysql is present and owned by root:root
2018-02-15 01:06:27,731 [salt.state       ][INFO    ][25076] Completed state [/srv/salt/reclass/classes/service/mysql] at time 01:06:27.730992 duration_in_ms=3.579
2018-02-15 01:06:27,732 [salt.state       ][INFO    ][25076] Running state [/srv/salt/reclass/classes/service/helm] at time 01:06:27.732240
2018-02-15 01:06:27,732 [salt.state       ][INFO    ][25076] Executing state file.symlink for /srv/salt/reclass/classes/service/helm
2018-02-15 01:06:27,735 [salt.state       ][INFO    ][25076] Symlink /srv/salt/reclass/classes/service/helm is present and owned by root:root
2018-02-15 01:06:27,735 [salt.state       ][INFO    ][25076] Completed state [/srv/salt/reclass/classes/service/helm] at time 01:06:27.735724 duration_in_ms=3.484
2018-02-15 01:06:27,736 [salt.state       ][INFO    ][25076] Running state [/srv/salt/reclass/classes/service/freeipa] at time 01:06:27.736944
2018-02-15 01:06:27,737 [salt.state       ][INFO    ][25076] Executing state file.symlink for /srv/salt/reclass/classes/service/freeipa
2018-02-15 01:06:27,739 [salt.state       ][INFO    ][25076] Symlink /srv/salt/reclass/classes/service/freeipa is present and owned by root:root
2018-02-15 01:06:27,740 [salt.state       ][INFO    ][25076] Completed state [/srv/salt/reclass/classes/service/freeipa] at time 01:06:27.740372 duration_in_ms=3.428
2018-02-15 01:06:27,741 [salt.state       ][INFO    ][25076] Running state [/srv/salt/reclass/classes/service/barbican] at time 01:06:27.741556
2018-02-15 01:06:27,742 [salt.state       ][INFO    ][25076] Executing state file.symlink for /srv/salt/reclass/classes/service/barbican
2018-02-15 01:06:27,744 [salt.state       ][INFO    ][25076] Symlink /srv/salt/reclass/classes/service/barbican is present and owned by root:root
2018-02-15 01:06:27,744 [salt.state       ][INFO    ][25076] Completed state [/srv/salt/reclass/classes/service/barbican] at time 01:06:27.744900 duration_in_ms=3.344
2018-02-15 01:06:27,746 [salt.state       ][INFO    ][25076] Running state [/srv/salt/reclass/classes/service/grafana] at time 01:06:27.746148
2018-02-15 01:06:27,746 [salt.state       ][INFO    ][25076] Executing state file.symlink for /srv/salt/reclass/classes/service/grafana
2018-02-15 01:06:27,748 [salt.state       ][INFO    ][25076] Symlink /srv/salt/reclass/classes/service/grafana is present and owned by root:root
2018-02-15 01:06:27,749 [salt.state       ][INFO    ][25076] Completed state [/srv/salt/reclass/classes/service/grafana] at time 01:06:27.749412 duration_in_ms=3.264
2018-02-15 01:06:27,750 [salt.state       ][INFO    ][25076] Running state [/srv/salt/reclass/classes/service/aptly] at time 01:06:27.750641
2018-02-15 01:06:27,751 [salt.state       ][INFO    ][25076] Executing state file.symlink for /srv/salt/reclass/classes/service/aptly
2018-02-15 01:06:27,753 [salt.state       ][INFO    ][25076] Symlink /srv/salt/reclass/classes/service/aptly is present and owned by root:root
2018-02-15 01:06:27,753 [salt.state       ][INFO    ][25076] Completed state [/srv/salt/reclass/classes/service/aptly] at time 01:06:27.753776 duration_in_ms=3.135
2018-02-15 01:06:27,754 [salt.state       ][INFO    ][25076] Running state [/srv/salt/reclass/classes/service/cassandra] at time 01:06:27.754937
2018-02-15 01:06:27,755 [salt.state       ][INFO    ][25076] Executing state file.symlink for /srv/salt/reclass/classes/service/cassandra
2018-02-15 01:06:27,757 [salt.state       ][INFO    ][25076] Symlink /srv/salt/reclass/classes/service/cassandra is present and owned by root:root
2018-02-15 01:06:27,758 [salt.state       ][INFO    ][25076] Completed state [/srv/salt/reclass/classes/service/cassandra] at time 01:06:27.758120 duration_in_ms=3.183
2018-02-15 01:06:27,759 [salt.state       ][INFO    ][25076] Running state [/srv/salt/reclass/classes/service/lldp] at time 01:06:27.759272
2018-02-15 01:06:27,759 [salt.state       ][INFO    ][25076] Executing state file.symlink for /srv/salt/reclass/classes/service/lldp
2018-02-15 01:06:27,761 [salt.state       ][INFO    ][25076] Symlink /srv/salt/reclass/classes/service/lldp is present and owned by root:root
2018-02-15 01:06:27,762 [salt.state       ][INFO    ][25076] Completed state [/srv/salt/reclass/classes/service/lldp] at time 01:06:27.762325 duration_in_ms=3.053
2018-02-15 01:06:27,763 [salt.state       ][INFO    ][25076] Running state [/srv/salt/reclass/classes/service/git] at time 01:06:27.763436
2018-02-15 01:06:27,764 [salt.state       ][INFO    ][25076] Executing state file.symlink for /srv/salt/reclass/classes/service/git
2018-02-15 01:06:27,765 [salt.state       ][INFO    ][25076] Symlink /srv/salt/reclass/classes/service/git is present and owned by root:root
2018-02-15 01:06:27,766 [salt.state       ][INFO    ][25076] Completed state [/srv/salt/reclass/classes/service/git] at time 01:06:27.766466 duration_in_ms=3.03
2018-02-15 01:06:27,767 [salt.state       ][INFO    ][25076] Running state [/srv/salt/reclass/classes/service/java] at time 01:06:27.767589
2018-02-15 01:06:27,768 [salt.state       ][INFO    ][25076] Executing state file.symlink for /srv/salt/reclass/classes/service/java
2018-02-15 01:06:27,770 [salt.state       ][INFO    ][25076] Symlink /srv/salt/reclass/classes/service/java is present and owned by root:root
2018-02-15 01:06:27,770 [salt.state       ][INFO    ][25076] Completed state [/srv/salt/reclass/classes/service/java] at time 01:06:27.770662 duration_in_ms=3.073
2018-02-15 01:06:27,771 [salt.state       ][INFO    ][25076] Running state [/srv/salt/reclass/classes/service/reclass] at time 01:06:27.771735
2018-02-15 01:06:27,772 [salt.state       ][INFO    ][25076] Executing state file.symlink for /srv/salt/reclass/classes/service/reclass
2018-02-15 01:06:27,774 [salt.state       ][INFO    ][25076] Symlink /srv/salt/reclass/classes/service/reclass is present and owned by root:root
2018-02-15 01:06:27,774 [salt.state       ][INFO    ][25076] Completed state [/srv/salt/reclass/classes/service/reclass] at time 01:06:27.774664 duration_in_ms=2.929
2018-02-15 01:06:27,775 [salt.state       ][INFO    ][25076] Running state [/srv/salt/reclass/classes/service/linux] at time 01:06:27.775716
2018-02-15 01:06:27,776 [salt.state       ][INFO    ][25076] Executing state file.symlink for /srv/salt/reclass/classes/service/linux
2018-02-15 01:06:27,778 [salt.state       ][INFO    ][25076] Symlink /srv/salt/reclass/classes/service/linux is present and owned by root:root
2018-02-15 01:06:27,778 [salt.state       ][INFO    ][25076] Completed state [/srv/salt/reclass/classes/service/linux] at time 01:06:27.778653 duration_in_ms=2.937
2018-02-15 01:06:27,779 [salt.state       ][INFO    ][25076] Running state [/srv/salt/reclass/classes/service/glance] at time 01:06:27.779717
2018-02-15 01:06:27,780 [salt.state       ][INFO    ][25076] Executing state file.symlink for /srv/salt/reclass/classes/service/glance
2018-02-15 01:06:27,782 [salt.state       ][INFO    ][25076] Symlink /srv/salt/reclass/classes/service/glance is present and owned by root:root
2018-02-15 01:06:27,782 [salt.state       ][INFO    ][25076] Completed state [/srv/salt/reclass/classes/service/glance] at time 01:06:27.782628 duration_in_ms=2.911
2018-02-15 01:06:27,783 [salt.state       ][INFO    ][25076] Running state [/srv/salt/reclass/classes/service/keepalived] at time 01:06:27.783656
2018-02-15 01:06:27,784 [salt.state       ][INFO    ][25076] Executing state file.symlink for /srv/salt/reclass/classes/service/keepalived
2018-02-15 01:06:27,786 [salt.state       ][INFO    ][25076] Symlink /srv/salt/reclass/classes/service/keepalived is present and owned by root:root
2018-02-15 01:06:27,786 [salt.state       ][INFO    ][25076] Completed state [/srv/salt/reclass/classes/service/keepalived] at time 01:06:27.786487 duration_in_ms=2.831
2018-02-15 01:06:27,787 [salt.state       ][INFO    ][25076] Running state [/srv/salt/reclass/classes/service/nova] at time 01:06:27.787505
2018-02-15 01:06:27,788 [salt.state       ][INFO    ][25076] Executing state file.symlink for /srv/salt/reclass/classes/service/nova
2018-02-15 01:06:27,789 [salt.state       ][INFO    ][25076] Symlink /srv/salt/reclass/classes/service/nova is present and owned by root:root
2018-02-15 01:06:27,790 [salt.state       ][INFO    ][25076] Completed state [/srv/salt/reclass/classes/service/nova] at time 01:06:27.790365 duration_in_ms=2.86
2018-02-15 01:06:27,791 [salt.state       ][INFO    ][25076] Running state [/srv/salt/reclass/classes/service/rundeck] at time 01:06:27.791386
2018-02-15 01:06:27,791 [salt.state       ][INFO    ][25076] Executing state file.symlink for /srv/salt/reclass/classes/service/rundeck
2018-02-15 01:06:27,793 [salt.state       ][INFO    ][25076] Symlink /srv/salt/reclass/classes/service/rundeck is present and owned by root:root
2018-02-15 01:06:27,794 [salt.state       ][INFO    ][25076] Completed state [/srv/salt/reclass/classes/service/rundeck] at time 01:06:27.794223 duration_in_ms=2.837
2018-02-15 01:06:27,795 [salt.state       ][INFO    ][25076] Running state [/srv/salt/reclass/classes/service/murano] at time 01:06:27.795245
2018-02-15 01:06:27,795 [salt.state       ][INFO    ][25076] Executing state file.symlink for /srv/salt/reclass/classes/service/murano
2018-02-15 01:06:27,797 [salt.state       ][INFO    ][25076] Symlink /srv/salt/reclass/classes/service/murano is present and owned by root:root
2018-02-15 01:06:27,798 [salt.state       ][INFO    ][25076] Completed state [/srv/salt/reclass/classes/service/murano] at time 01:06:27.798022 duration_in_ms=2.778
2018-02-15 01:06:27,799 [salt.state       ][INFO    ][25076] Running state [/srv/salt/reclass/classes/service/keystone] at time 01:06:27.799072
2018-02-15 01:06:27,799 [salt.state       ][INFO    ][25076] Executing state file.symlink for /srv/salt/reclass/classes/service/keystone
2018-02-15 01:06:27,801 [salt.state       ][INFO    ][25076] Symlink /srv/salt/reclass/classes/service/keystone is present and owned by root:root
2018-02-15 01:06:27,801 [salt.state       ][INFO    ][25076] Completed state [/srv/salt/reclass/classes/service/keystone] at time 01:06:27.801844 duration_in_ms=2.772
2018-02-15 01:06:27,802 [salt.state       ][INFO    ][25076] Running state [/srv/salt/reclass/classes/service/etcd] at time 01:06:27.802820
2018-02-15 01:06:27,803 [salt.state       ][INFO    ][25076] Executing state file.symlink for /srv/salt/reclass/classes/service/etcd
2018-02-15 01:06:27,805 [salt.state       ][INFO    ][25076] Symlink /srv/salt/reclass/classes/service/etcd is present and owned by root:root
2018-02-15 01:06:27,805 [salt.state       ][INFO    ][25076] Completed state [/srv/salt/reclass/classes/service/etcd] at time 01:06:27.805462 duration_in_ms=2.641
2018-02-15 01:06:27,806 [salt.state       ][INFO    ][25076] Running state [/srv/salt/reclass/classes/service/ntp] at time 01:06:27.806465
2018-02-15 01:06:27,806 [salt.state       ][INFO    ][25076] Executing state file.symlink for /srv/salt/reclass/classes/service/ntp
2018-02-15 01:06:27,808 [salt.state       ][INFO    ][25076] Symlink /srv/salt/reclass/classes/service/ntp is present and owned by root:root
2018-02-15 01:06:27,809 [salt.state       ][INFO    ][25076] Completed state [/srv/salt/reclass/classes/service/ntp] at time 01:06:27.809083 duration_in_ms=2.618
2018-02-15 01:06:27,810 [salt.state       ][INFO    ][25076] Running state [/srv/salt/reclass/classes/service/jenkins] at time 01:06:27.810033
2018-02-15 01:06:27,810 [salt.state       ][INFO    ][25076] Executing state file.symlink for /srv/salt/reclass/classes/service/jenkins
2018-02-15 01:06:27,812 [salt.state       ][INFO    ][25076] Symlink /srv/salt/reclass/classes/service/jenkins is present and owned by root:root
2018-02-15 01:06:27,812 [salt.state       ][INFO    ][25076] Completed state [/srv/salt/reclass/classes/service/jenkins] at time 01:06:27.812662 duration_in_ms=2.629
2018-02-15 01:06:27,813 [salt.state       ][INFO    ][25076] Running state [/srv/salt/reclass/classes/service/memcached] at time 01:06:27.813598
2018-02-15 01:06:27,814 [salt.state       ][INFO    ][25076] Executing state file.symlink for /srv/salt/reclass/classes/service/memcached
2018-02-15 01:06:27,815 [salt.state       ][INFO    ][25076] Symlink /srv/salt/reclass/classes/service/memcached is present and owned by root:root
2018-02-15 01:06:27,816 [salt.state       ][INFO    ][25076] Completed state [/srv/salt/reclass/classes/service/memcached] at time 01:06:27.816154 duration_in_ms=2.556
2018-02-15 01:06:27,817 [salt.state       ][INFO    ][25076] Running state [/srv/salt/reclass/classes/service/neutron] at time 01:06:27.817080
2018-02-15 01:06:27,817 [salt.state       ][INFO    ][25076] Executing state file.symlink for /srv/salt/reclass/classes/service/neutron
2018-02-15 01:06:27,820 [salt.state       ][INFO    ][25076] Symlink /srv/salt/reclass/classes/service/neutron is present and owned by root:root
2018-02-15 01:06:27,820 [salt.state       ][INFO    ][25076] Completed state [/srv/salt/reclass/classes/service/neutron] at time 01:06:27.820915 duration_in_ms=3.833
2018-02-15 01:06:27,822 [salt.state       ][INFO    ][25076] Running state [/srv/salt/reclass/classes/service/designate] at time 01:06:27.822641
2018-02-15 01:06:27,823 [salt.state       ][INFO    ][25076] Executing state file.symlink for /srv/salt/reclass/classes/service/designate
2018-02-15 01:06:27,826 [salt.state       ][INFO    ][25076] Symlink /srv/salt/reclass/classes/service/designate is present and owned by root:root
2018-02-15 01:06:27,826 [salt.state       ][INFO    ][25076] Completed state [/srv/salt/reclass/classes/service/designate] at time 01:06:27.826764 duration_in_ms=4.123
2018-02-15 01:06:27,828 [salt.state       ][INFO    ][25076] Running state [/srv/salt/reclass/classes/service/iptables] at time 01:06:27.828429
2018-02-15 01:06:27,828 [salt.state       ][INFO    ][25076] Executing state file.symlink for /srv/salt/reclass/classes/service/iptables
2018-02-15 01:06:27,831 [salt.state       ][INFO    ][25076] Symlink /srv/salt/reclass/classes/service/iptables is present and owned by root:root
2018-02-15 01:06:27,832 [salt.state       ][INFO    ][25076] Completed state [/srv/salt/reclass/classes/service/iptables] at time 01:06:27.832297 duration_in_ms=3.868
2018-02-15 01:06:27,833 [salt.state       ][INFO    ][25076] Running state [/srv/salt/reclass/classes/service/statsd] at time 01:06:27.833817
2018-02-15 01:06:27,834 [salt.state       ][INFO    ][25076] Executing state file.symlink for /srv/salt/reclass/classes/service/statsd
2018-02-15 01:06:27,837 [salt.state       ][INFO    ][25076] Symlink /srv/salt/reclass/classes/service/statsd is present and owned by root:root
2018-02-15 01:06:27,837 [salt.state       ][INFO    ][25076] Completed state [/srv/salt/reclass/classes/service/statsd] at time 01:06:27.837656 duration_in_ms=3.838
2018-02-15 01:06:27,839 [salt.state       ][INFO    ][25076] Running state [/srv/salt/reclass/classes/service/gerrit] at time 01:06:27.839190
2018-02-15 01:06:27,839 [salt.state       ][INFO    ][25076] Executing state file.symlink for /srv/salt/reclass/classes/service/gerrit
2018-02-15 01:06:27,842 [salt.state       ][INFO    ][25076] Symlink /srv/salt/reclass/classes/service/gerrit is present and owned by root:root
2018-02-15 01:06:27,842 [salt.state       ][INFO    ][25076] Completed state [/srv/salt/reclass/classes/service/gerrit] at time 01:06:27.842749 duration_in_ms=3.571
2018-02-15 01:06:27,844 [salt.state       ][INFO    ][25076] Running state [/srv/salt/reclass/classes/service/zookeeper] at time 01:06:27.844155
2018-02-15 01:06:27,844 [salt.state       ][INFO    ][25076] Executing state file.symlink for /srv/salt/reclass/classes/service/zookeeper
2018-02-15 01:06:27,847 [salt.state       ][INFO    ][25076] Symlink /srv/salt/reclass/classes/service/zookeeper is present and owned by root:root
2018-02-15 01:06:27,847 [salt.state       ][INFO    ][25076] Completed state [/srv/salt/reclass/classes/service/zookeeper] at time 01:06:27.847742 duration_in_ms=3.586
2018-02-15 01:06:27,849 [salt.state       ][INFO    ][25076] Running state [/srv/salt/reclass/classes/service/kubernetes] at time 01:06:27.849119
2018-02-15 01:06:27,849 [salt.state       ][INFO    ][25076] Executing state file.symlink for /srv/salt/reclass/classes/service/kubernetes
2018-02-15 01:06:27,852 [salt.state       ][INFO    ][25076] Symlink /srv/salt/reclass/classes/service/kubernetes is present and owned by root:root
2018-02-15 01:06:27,852 [salt.state       ][INFO    ][25076] Completed state [/srv/salt/reclass/classes/service/kubernetes] at time 01:06:27.852508 duration_in_ms=3.389
2018-02-15 01:06:27,853 [salt.state       ][INFO    ][25076] Running state [/srv/salt/reclass/classes/service/python] at time 01:06:27.853843
2018-02-15 01:06:27,854 [salt.state       ][INFO    ][25076] Executing state file.symlink for /srv/salt/reclass/classes/service/python
2018-02-15 01:06:27,857 [salt.state       ][INFO    ][25076] Symlink /srv/salt/reclass/classes/service/python is present and owned by root:root
2018-02-15 01:06:27,857 [salt.state       ][INFO    ][25076] Completed state [/srv/salt/reclass/classes/service/python] at time 01:06:27.857381 duration_in_ms=3.539
2018-02-15 01:06:27,858 [salt.state       ][INFO    ][25076] Running state [/srv/salt/reclass/classes/service/mongodb] at time 01:06:27.858771
2018-02-15 01:06:27,859 [salt.state       ][INFO    ][25076] Executing state file.symlink for /srv/salt/reclass/classes/service/mongodb
2018-02-15 01:06:27,861 [salt.state       ][INFO    ][25076] Symlink /srv/salt/reclass/classes/service/mongodb is present and owned by root:root
2018-02-15 01:06:27,862 [salt.state       ][INFO    ][25076] Completed state [/srv/salt/reclass/classes/service/mongodb] at time 01:06:27.861951 duration_in_ms=3.179
2018-02-15 01:06:27,863 [salt.state       ][INFO    ][25076] Running state [/srv/salt/reclass/classes/service/maas] at time 01:06:27.863341
2018-02-15 01:06:27,863 [salt.state       ][INFO    ][25076] Executing state file.symlink for /srv/salt/reclass/classes/service/maas
2018-02-15 01:06:27,866 [salt.state       ][INFO    ][25076] Symlink /srv/salt/reclass/classes/service/maas is present and owned by root:root
2018-02-15 01:06:27,866 [salt.state       ][INFO    ][25076] Completed state [/srv/salt/reclass/classes/service/maas] at time 01:06:27.866588 duration_in_ms=3.247
2018-02-15 01:06:27,867 [salt.state       ][INFO    ][25076] Running state [/srv/salt/reclass/classes/service/libvirt] at time 01:06:27.867867
2018-02-15 01:06:27,868 [salt.state       ][INFO    ][25076] Executing state file.symlink for /srv/salt/reclass/classes/service/libvirt
2018-02-15 01:06:27,870 [salt.state       ][INFO    ][25076] Symlink /srv/salt/reclass/classes/service/libvirt is present and owned by root:root
2018-02-15 01:06:27,871 [salt.state       ][INFO    ][25076] Completed state [/srv/salt/reclass/classes/service/libvirt] at time 01:06:27.871054 duration_in_ms=3.187
2018-02-15 01:06:27,872 [salt.state       ][INFO    ][25076] Running state [/srv/salt/reclass/classes/service/influxdb] at time 01:06:27.872272
2018-02-15 01:06:27,872 [salt.state       ][INFO    ][25076] Executing state file.symlink for /srv/salt/reclass/classes/service/influxdb
2018-02-15 01:06:27,875 [salt.state       ][INFO    ][25076] Symlink /srv/salt/reclass/classes/service/influxdb is present and owned by root:root
2018-02-15 01:06:27,875 [salt.state       ][INFO    ][25076] Completed state [/srv/salt/reclass/classes/service/influxdb] at time 01:06:27.875345 duration_in_ms=3.073
2018-02-15 01:06:27,876 [salt.state       ][INFO    ][25076] Running state [/srv/salt/reclass/classes/service/heka] at time 01:06:27.876537
2018-02-15 01:06:27,876 [salt.state       ][INFO    ][25076] Executing state file.symlink for /srv/salt/reclass/classes/service/heka
2018-02-15 01:06:27,879 [salt.state       ][INFO    ][25076] Symlink /srv/salt/reclass/classes/service/heka is present and owned by root:root
2018-02-15 01:06:27,879 [salt.state       ][INFO    ][25076] Completed state [/srv/salt/reclass/classes/service/heka] at time 01:06:27.879611 duration_in_ms=3.074
2018-02-15 01:06:27,880 [salt.state       ][INFO    ][25076] Running state [/srv/salt/reclass/classes/service/heat] at time 01:06:27.880749
2018-02-15 01:06:27,881 [salt.state       ][INFO    ][25076] Executing state file.symlink for /srv/salt/reclass/classes/service/heat
2018-02-15 01:06:27,883 [salt.state       ][INFO    ][25076] Symlink /srv/salt/reclass/classes/service/heat is present and owned by root:root
2018-02-15 01:06:27,884 [salt.state       ][INFO    ][25076] Completed state [/srv/salt/reclass/classes/service/heat] at time 01:06:27.884254 duration_in_ms=3.505
2018-02-15 01:06:27,885 [salt.state       ][INFO    ][25076] Running state [/srv/salt/reclass/classes/service/openldap] at time 01:06:27.885404
2018-02-15 01:06:27,885 [salt.state       ][INFO    ][25076] Executing state file.symlink for /srv/salt/reclass/classes/service/openldap
2018-02-15 01:06:27,888 [salt.state       ][INFO    ][25076] Symlink /srv/salt/reclass/classes/service/openldap is present and owned by root:root
2018-02-15 01:06:27,888 [salt.state       ][INFO    ][25076] Completed state [/srv/salt/reclass/classes/service/openldap] at time 01:06:27.888448 duration_in_ms=3.043
2018-02-15 01:06:27,889 [salt.state       ][INFO    ][25076] Running state [/srv/salt/reclass/classes/service/kibana] at time 01:06:27.889563
2018-02-15 01:06:27,889 [salt.state       ][INFO    ][25076] Executing state file.symlink for /srv/salt/reclass/classes/service/kibana
2018-02-15 01:06:27,892 [salt.state       ][INFO    ][25076] Symlink /srv/salt/reclass/classes/service/kibana is present and owned by root:root
2018-02-15 01:06:27,892 [salt.state       ][INFO    ][25076] Completed state [/srv/salt/reclass/classes/service/kibana] at time 01:06:27.892511 duration_in_ms=2.947
2018-02-15 01:06:27,893 [salt.state       ][INFO    ][25076] Running state [/srv/salt/reclass/classes/service/avinetworks] at time 01:06:27.893617
2018-02-15 01:06:27,893 [salt.state       ][INFO    ][25076] Executing state file.symlink for /srv/salt/reclass/classes/service/avinetworks
2018-02-15 01:06:27,896 [salt.state       ][INFO    ][25076] Symlink /srv/salt/reclass/classes/service/avinetworks is present and owned by root:root
2018-02-15 01:06:27,896 [salt.state       ][INFO    ][25076] Completed state [/srv/salt/reclass/classes/service/avinetworks] at time 01:06:27.896532 duration_in_ms=2.915
2018-02-15 01:06:27,897 [salt.state       ][INFO    ][25076] Running state [/srv/salt/reclass/classes/service/sphinx] at time 01:06:27.897638
2018-02-15 01:06:27,898 [salt.state       ][INFO    ][25076] Executing state file.symlink for /srv/salt/reclass/classes/service/sphinx
2018-02-15 01:06:27,900 [salt.state       ][INFO    ][25076] Symlink /srv/salt/reclass/classes/service/sphinx is present and owned by root:root
2018-02-15 01:06:27,900 [salt.state       ][INFO    ][25076] Completed state [/srv/salt/reclass/classes/service/sphinx] at time 01:06:27.900461 duration_in_ms=2.823
2018-02-15 01:06:27,901 [salt.state       ][INFO    ][25076] Running state [/srv/salt/reclass/classes/service/prometheus] at time 01:06:27.901522
2018-02-15 01:06:27,901 [salt.state       ][INFO    ][25076] Executing state file.symlink for /srv/salt/reclass/classes/service/prometheus
2018-02-15 01:06:27,904 [salt.state       ][INFO    ][25076] Symlink /srv/salt/reclass/classes/service/prometheus is present and owned by root:root
2018-02-15 01:06:27,904 [salt.state       ][INFO    ][25076] Completed state [/srv/salt/reclass/classes/service/prometheus] at time 01:06:27.904300 duration_in_ms=2.778
2018-02-15 01:06:27,905 [salt.state       ][INFO    ][25076] Running state [/srv/salt/reclass/classes/service/swift] at time 01:06:27.905352
2018-02-15 01:06:27,905 [salt.state       ][INFO    ][25076] Executing state file.symlink for /srv/salt/reclass/classes/service/swift
2018-02-15 01:06:27,907 [salt.state       ][INFO    ][25076] Symlink /srv/salt/reclass/classes/service/swift is present and owned by root:root
2018-02-15 01:06:27,908 [salt.state       ][INFO    ][25076] Completed state [/srv/salt/reclass/classes/service/swift] at time 01:06:27.908133 duration_in_ms=2.781
2018-02-15 01:06:27,909 [salt.state       ][INFO    ][25076] Running state [/srv/salt/reclass/classes/service/billometer] at time 01:06:27.909160
2018-02-15 01:06:27,909 [salt.state       ][INFO    ][25076] Executing state file.symlink for /srv/salt/reclass/classes/service/billometer
2018-02-15 01:06:27,911 [salt.state       ][INFO    ][25076] Symlink /srv/salt/reclass/classes/service/billometer is present and owned by root:root
2018-02-15 01:06:27,911 [salt.state       ][INFO    ][25076] Completed state [/srv/salt/reclass/classes/service/billometer] at time 01:06:27.911801 duration_in_ms=2.641
2018-02-15 01:06:27,912 [salt.state       ][INFO    ][25076] Running state [/srv/salt/reclass/classes/service/haproxy] at time 01:06:27.912791
2018-02-15 01:06:27,913 [salt.state       ][INFO    ][25076] Executing state file.symlink for /srv/salt/reclass/classes/service/haproxy
2018-02-15 01:06:27,915 [salt.state       ][INFO    ][25076] Symlink /srv/salt/reclass/classes/service/haproxy is present and owned by root:root
2018-02-15 01:06:27,915 [salt.state       ][INFO    ][25076] Completed state [/srv/salt/reclass/classes/service/haproxy] at time 01:06:27.915424 duration_in_ms=2.634
2018-02-15 01:06:27,916 [salt.state       ][INFO    ][25076] Running state [/srv/salt/reclass/classes/service/ceilometer] at time 01:06:27.916421
2018-02-15 01:06:27,916 [salt.state       ][INFO    ][25076] Executing state file.symlink for /srv/salt/reclass/classes/service/ceilometer
2018-02-15 01:06:27,918 [salt.state       ][INFO    ][25076] Symlink /srv/salt/reclass/classes/service/ceilometer is present and owned by root:root
2018-02-15 01:06:27,919 [salt.state       ][INFO    ][25076] Completed state [/srv/salt/reclass/classes/service/ceilometer] at time 01:06:27.919221 duration_in_ms=2.8
2018-02-15 01:06:27,920 [salt.state       ][INFO    ][25076] Running state [/srv/salt/reclass/classes/service/aptcacher] at time 01:06:27.920149
2018-02-15 01:06:27,920 [salt.state       ][INFO    ][25076] Executing state file.symlink for /srv/salt/reclass/classes/service/aptcacher
2018-02-15 01:06:27,922 [salt.state       ][INFO    ][25076] Symlink /srv/salt/reclass/classes/service/aptcacher is present and owned by root:root
2018-02-15 01:06:27,922 [salt.state       ][INFO    ][25076] Completed state [/srv/salt/reclass/classes/service/aptcacher] at time 01:06:27.922712 duration_in_ms=2.563
2018-02-15 01:06:27,923 [salt.state       ][INFO    ][25076] Running state [/srv/salt/reclass/classes/service/nginx] at time 01:06:27.923656
2018-02-15 01:06:27,923 [salt.state       ][INFO    ][25076] Executing state file.symlink for /srv/salt/reclass/classes/service/nginx
2018-02-15 01:06:27,925 [salt.state       ][INFO    ][25076] Symlink /srv/salt/reclass/classes/service/nginx is present and owned by root:root
2018-02-15 01:06:27,926 [salt.state       ][INFO    ][25076] Completed state [/srv/salt/reclass/classes/service/nginx] at time 01:06:27.926297 duration_in_ms=2.641
2018-02-15 01:06:27,927 [salt.state       ][INFO    ][25076] Running state [/srv/salt/reclass/classes/service/bind] at time 01:06:27.927267
2018-02-15 01:06:27,927 [salt.state       ][INFO    ][25076] Executing state file.symlink for /srv/salt/reclass/classes/service/bind
2018-02-15 01:06:27,929 [salt.state       ][INFO    ][25076] Symlink /srv/salt/reclass/classes/service/bind is present and owned by root:root
2018-02-15 01:06:27,929 [salt.state       ][INFO    ][25076] Completed state [/srv/salt/reclass/classes/service/bind] at time 01:06:27.929719 duration_in_ms=2.452
2018-02-15 01:06:27,930 [salt.state       ][INFO    ][25076] Running state [/srv/salt/reclass/classes/service/redis] at time 01:06:27.930645
2018-02-15 01:06:27,930 [salt.state       ][INFO    ][25076] Executing state file.symlink for /srv/salt/reclass/classes/service/redis
2018-02-15 01:06:27,932 [salt.state       ][INFO    ][25076] Symlink /srv/salt/reclass/classes/service/redis is present and owned by root:root
2018-02-15 01:06:27,933 [salt.state       ][INFO    ][25076] Completed state [/srv/salt/reclass/classes/service/redis] at time 01:06:27.933004 duration_in_ms=2.359
2018-02-15 01:06:27,933 [salt.state       ][INFO    ][25076] Running state [/srv/salt/reclass/classes/service/opencontrail] at time 01:06:27.933900
2018-02-15 01:06:27,934 [salt.state       ][INFO    ][25076] Executing state file.symlink for /srv/salt/reclass/classes/service/opencontrail
2018-02-15 01:06:27,936 [salt.state       ][INFO    ][25076] Symlink /srv/salt/reclass/classes/service/opencontrail is present and owned by root:root
2018-02-15 01:06:27,936 [salt.state       ][INFO    ][25076] Completed state [/srv/salt/reclass/classes/service/opencontrail] at time 01:06:27.936334 duration_in_ms=2.434
2018-02-15 01:06:27,937 [salt.state       ][INFO    ][25076] Running state [/srv/salt/reclass/classes/service/ccp] at time 01:06:27.937230
2018-02-15 01:06:27,937 [salt.state       ][INFO    ][25076] Executing state file.symlink for /srv/salt/reclass/classes/service/ccp
2018-02-15 01:06:27,939 [salt.state       ][INFO    ][25076] Symlink /srv/salt/reclass/classes/service/ccp is present and owned by root:root
2018-02-15 01:06:27,939 [salt.state       ][INFO    ][25076] Completed state [/srv/salt/reclass/classes/service/ccp] at time 01:06:27.939626 duration_in_ms=2.396
2018-02-15 01:06:27,940 [salt.state       ][INFO    ][25076] Running state [/srv/salt/reclass/classes/service/rabbitmq] at time 01:06:27.940485
2018-02-15 01:06:27,940 [salt.state       ][INFO    ][25076] Executing state file.symlink for /srv/salt/reclass/classes/service/rabbitmq
2018-02-15 01:06:27,942 [salt.state       ][INFO    ][25076] Symlink /srv/salt/reclass/classes/service/rabbitmq is present and owned by root:root
2018-02-15 01:06:27,942 [salt.state       ][INFO    ][25076] Completed state [/srv/salt/reclass/classes/service/rabbitmq] at time 01:06:27.942802 duration_in_ms=2.316
2018-02-15 01:06:27,943 [salt.state       ][INFO    ][25076] Running state [/srv/salt/reclass/classes/service/octavia] at time 01:06:27.943652
2018-02-15 01:06:27,943 [salt.state       ][INFO    ][25076] Executing state file.symlink for /srv/salt/reclass/classes/service/octavia
2018-02-15 01:06:27,945 [salt.state       ][INFO    ][25076] Symlink /srv/salt/reclass/classes/service/octavia is present and owned by root:root
2018-02-15 01:06:27,945 [salt.state       ][INFO    ][25076] Completed state [/srv/salt/reclass/classes/service/octavia] at time 01:06:27.945889 duration_in_ms=2.237
2018-02-15 01:06:27,946 [salt.state       ][INFO    ][25076] Running state [/srv/salt/reclass/classes/service/elasticsearch] at time 01:06:27.946772
2018-02-15 01:06:27,947 [salt.state       ][INFO    ][25076] Executing state file.symlink for /srv/salt/reclass/classes/service/elasticsearch
2018-02-15 01:06:27,948 [salt.state       ][INFO    ][25076] Symlink /srv/salt/reclass/classes/service/elasticsearch is present and owned by root:root
2018-02-15 01:06:27,949 [salt.state       ][INFO    ][25076] Completed state [/srv/salt/reclass/classes/service/elasticsearch] at time 01:06:27.949017 duration_in_ms=2.245
2018-02-15 01:06:27,949 [salt.state       ][INFO    ][25076] Running state [/srv/salt/reclass/classes/service/graphite] at time 01:06:27.949835
2018-02-15 01:06:27,950 [salt.state       ][INFO    ][25076] Executing state file.symlink for /srv/salt/reclass/classes/service/graphite
2018-02-15 01:06:27,951 [salt.state       ][INFO    ][25076] Symlink /srv/salt/reclass/classes/service/graphite is present and owned by root:root
2018-02-15 01:06:27,952 [salt.state       ][INFO    ][25076] Completed state [/srv/salt/reclass/classes/service/graphite] at time 01:06:27.952073 duration_in_ms=2.238
2018-02-15 01:06:27,952 [salt.state       ][INFO    ][25076] Running state [/srv/salt/reclass/classes/service/postgresql] at time 01:06:27.952906
2018-02-15 01:06:27,953 [salt.state       ][INFO    ][25076] Executing state file.symlink for /srv/salt/reclass/classes/service/postgresql
2018-02-15 01:06:27,954 [salt.state       ][INFO    ][25076] Symlink /srv/salt/reclass/classes/service/postgresql is present and owned by root:root
2018-02-15 01:06:27,955 [salt.state       ][INFO    ][25076] Completed state [/srv/salt/reclass/classes/service/postgresql] at time 01:06:27.955102 duration_in_ms=2.196
2018-02-15 01:06:27,955 [salt.state       ][INFO    ][25076] Running state [/srv/salt/reclass/classes/service/horizon] at time 01:06:27.955939
2018-02-15 01:06:27,956 [salt.state       ][INFO    ][25076] Executing state file.symlink for /srv/salt/reclass/classes/service/horizon
2018-02-15 01:06:27,957 [salt.state       ][INFO    ][25076] Symlink /srv/salt/reclass/classes/service/horizon is present and owned by root:root
2018-02-15 01:06:27,958 [salt.state       ][INFO    ][25076] Completed state [/srv/salt/reclass/classes/service/horizon] at time 01:06:27.958190 duration_in_ms=2.238
2018-02-15 01:06:27,959 [salt.state       ][INFO    ][25076] Running state [/srv/salt/reclass/classes/service/openssh] at time 01:06:27.959011
2018-02-15 01:06:27,959 [salt.state       ][INFO    ][25076] Executing state file.symlink for /srv/salt/reclass/classes/service/openssh
2018-02-15 01:06:27,960 [salt.state       ][INFO    ][25076] Symlink /srv/salt/reclass/classes/service/openssh is present and owned by root:root
2018-02-15 01:06:27,961 [salt.state       ][INFO    ][25076] Completed state [/srv/salt/reclass/classes/service/openssh] at time 01:06:27.961098 duration_in_ms=2.087
2018-02-15 01:06:27,961 [salt.state       ][INFO    ][25076] Running state [/srv/salt/reclass/classes/service/cinder] at time 01:06:27.961892
2018-02-15 01:06:27,962 [salt.state       ][INFO    ][25076] Executing state file.symlink for /srv/salt/reclass/classes/service/cinder
2018-02-15 01:06:27,963 [salt.state       ][INFO    ][25076] Symlink /srv/salt/reclass/classes/service/cinder is present and owned by root:root
2018-02-15 01:06:27,964 [salt.state       ][INFO    ][25076] Completed state [/srv/salt/reclass/classes/service/cinder] at time 01:06:27.964034 duration_in_ms=2.141
2018-02-15 01:06:27,964 [salt.state       ][INFO    ][25076] Running state [/srv/salt/reclass/classes/service/docker] at time 01:06:27.964829
2018-02-15 01:06:27,965 [salt.state       ][INFO    ][25076] Executing state file.symlink for /srv/salt/reclass/classes/service/docker
2018-02-15 01:06:27,966 [salt.state       ][INFO    ][25076] Symlink /srv/salt/reclass/classes/service/docker is present and owned by root:root
2018-02-15 01:06:27,966 [salt.state       ][INFO    ][25076] Completed state [/srv/salt/reclass/classes/service/docker] at time 01:06:27.966947 duration_in_ms=2.118
2018-02-15 01:06:27,967 [salt.state       ][INFO    ][25076] Running state [/srv/salt/reclass/classes/service/salt] at time 01:06:27.967752
2018-02-15 01:06:27,968 [salt.state       ][INFO    ][25076] Executing state file.symlink for /srv/salt/reclass/classes/service/salt
2018-02-15 01:06:27,969 [salt.state       ][INFO    ][25076] Symlink /srv/salt/reclass/classes/service/salt is present and owned by root:root
2018-02-15 01:06:27,969 [salt.state       ][INFO    ][25076] Completed state [/srv/salt/reclass/classes/service/salt] at time 01:06:27.969837 duration_in_ms=2.084
2018-02-15 01:06:27,970 [salt.state       ][INFO    ][25076] Running state [/srv/salt/reclass/classes/service/devops_portal] at time 01:06:27.970661
2018-02-15 01:06:27,970 [salt.state       ][INFO    ][25076] Executing state file.symlink for /srv/salt/reclass/classes/service/devops_portal
2018-02-15 01:06:27,972 [salt.state       ][INFO    ][25076] Symlink /srv/salt/reclass/classes/service/devops_portal is present and owned by root:root
2018-02-15 01:06:27,972 [salt.state       ][INFO    ][25076] Completed state [/srv/salt/reclass/classes/service/devops_portal] at time 01:06:27.972695 duration_in_ms=2.034
2018-02-15 01:06:27,972 [salt.state       ][INFO    ][25076] Running state [salt-minion] at time 01:06:27.972908
2018-02-15 01:06:27,973 [salt.state       ][INFO    ][25076] Executing state pkg.installed for salt-minion
2018-02-15 01:06:27,978 [salt.state       ][INFO    ][25076] All specified packages are already installed
2018-02-15 01:06:27,978 [salt.state       ][INFO    ][25076] Completed state [salt-minion] at time 01:06:27.978950 duration_in_ms=6.042
2018-02-15 01:06:27,979 [salt.state       ][INFO    ][25076] Running state [salt_minion_dependency_packages] at time 01:06:27.979155
2018-02-15 01:06:27,979 [salt.state       ][INFO    ][25076] Executing state pkg.installed for salt_minion_dependency_packages
2018-02-15 01:06:27,984 [salt.state       ][INFO    ][25076] All specified packages are already installed
2018-02-15 01:06:27,984 [salt.state       ][INFO    ][25076] Completed state [salt_minion_dependency_packages] at time 01:06:27.984630 duration_in_ms=5.475
2018-02-15 01:06:27,985 [salt.state       ][INFO    ][25076] Running state [/etc/salt/minion.d/minion.conf] at time 01:06:27.985576
2018-02-15 01:06:27,985 [salt.state       ][INFO    ][25076] Executing state file.managed for /etc/salt/minion.d/minion.conf
2018-02-15 01:06:28,135 [salt.state       ][INFO    ][25076] File /etc/salt/minion.d/minion.conf is in the correct state
2018-02-15 01:06:28,136 [salt.state       ][INFO    ][25076] Completed state [/etc/salt/minion.d/minion.conf] at time 01:06:28.136156 duration_in_ms=150.579
2018-02-15 01:06:28,136 [salt.state       ][INFO    ][25076] Running state [/etc/salt/minion.d/_pki.conf] at time 01:06:28.136896
2018-02-15 01:06:28,137 [salt.state       ][INFO    ][25076] Executing state file.managed for /etc/salt/minion.d/_pki.conf
2018-02-15 01:06:28,149 [salt.state       ][INFO    ][25076] File /etc/salt/minion.d/_pki.conf is in the correct state
2018-02-15 01:06:28,149 [salt.state       ][INFO    ][25076] Completed state [/etc/salt/minion.d/_pki.conf] at time 01:06:28.149670 duration_in_ms=12.774
2018-02-15 01:06:28,152 [salt.state       ][INFO    ][25076] Running state [salt-minion] at time 01:06:28.152320
2018-02-15 01:06:28,152 [salt.state       ][INFO    ][25076] Executing state service.running for salt-minion
2018-02-15 01:06:28,152 [salt.loaded.int.module.cmdmod][INFO    ][25076] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2018-02-15 01:06:28,177 [salt.loaded.int.module.cmdmod][INFO    ][25076] Executing command ['systemctl', 'is-active', 'salt-minion.service'] in directory '/root'
2018-02-15 01:06:28,201 [salt.loaded.int.module.cmdmod][INFO    ][25076] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2018-02-15 01:06:28,222 [salt.state       ][INFO    ][25076] The service salt-minion is already running
2018-02-15 01:06:28,223 [salt.state       ][INFO    ][25076] Completed state [salt-minion] at time 01:06:28.223190 duration_in_ms=70.869
2018-02-15 01:06:28,226 [salt.state       ][INFO    ][25076] Running state [/etc/salt/grains.d] at time 01:06:28.226524
2018-02-15 01:06:28,227 [salt.state       ][INFO    ][25076] Executing state file.directory for /etc/salt/grains.d
2018-02-15 01:06:28,228 [salt.state       ][INFO    ][25076] Directory /etc/salt/grains.d is in the correct state
2018-02-15 01:06:28,228 [salt.state       ][INFO    ][25076] Completed state [/etc/salt/grains.d] at time 01:06:28.228390 duration_in_ms=1.866
2018-02-15 01:06:28,229 [salt.state       ][INFO    ][25076] Running state [/etc/salt/grains] at time 01:06:28.229365
2018-02-15 01:06:28,229 [salt.state       ][INFO    ][25076] Executing state file.managed for /etc/salt/grains
2018-02-15 01:06:28,230 [salt.state       ][INFO    ][25076] File /etc/salt/grains exists with proper permissions. No changes made.
2018-02-15 01:06:28,230 [salt.state       ][INFO    ][25076] Completed state [/etc/salt/grains] at time 01:06:28.230821 duration_in_ms=1.456
2018-02-15 01:06:28,231 [salt.state       ][INFO    ][25076] Running state [/etc/salt/grains.d/placeholder] at time 01:06:28.231635
2018-02-15 01:06:28,232 [salt.state       ][INFO    ][25076] Executing state file.managed for /etc/salt/grains.d/placeholder
2018-02-15 01:06:28,232 [salt.state       ][INFO    ][25076] File /etc/salt/grains.d/placeholder exists with proper permissions. No changes made.
2018-02-15 01:06:28,233 [salt.state       ][INFO    ][25076] Completed state [/etc/salt/grains.d/placeholder] at time 01:06:28.233018 duration_in_ms=1.383
2018-02-15 01:06:28,233 [salt.state       ][INFO    ][25076] Running state [/etc/salt/grains.d/sphinx] at time 01:06:28.233828
2018-02-15 01:06:28,234 [salt.state       ][INFO    ][25076] Executing state file.managed for /etc/salt/grains.d/sphinx
2018-02-15 01:06:28,245 [salt.state       ][INFO    ][25076] File changed:
--- 
+++ 
@@ -15,7 +15,9 @@
               name: IP Addresses
               value:
               - 10.20.0.2
+              - 10.167.4.100
               - 127.0.0.1
+              - 192.168.11.2
         system:
           name: System
           param:

2018-02-15 01:06:28,246 [salt.state       ][INFO    ][25076] Completed state [/etc/salt/grains.d/sphinx] at time 01:06:28.246420 duration_in_ms=12.592
2018-02-15 01:06:28,249 [salt.state       ][INFO    ][25076] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 01:06:28.249142
2018-02-15 01:06:28,249 [salt.state       ][INFO    ][25076] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2018-02-15 01:06:28,250 [salt.state       ][INFO    ][25076] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2018-02-15 01:06:28,250 [salt.state       ][INFO    ][25076] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 01:06:28.250457 duration_in_ms=1.315
2018-02-15 01:06:28,250 [salt.state       ][INFO    ][25076] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 01:06:28.250801
2018-02-15 01:06:28,251 [salt.state       ][INFO    ][25076] Executing state cmd.mod_watch for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2018-02-15 01:06:28,252 [salt.loaded.int.module.cmdmod][INFO    ][25076] Executing command 'python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"' in directory '/root'
2018-02-15 01:06:28,402 [salt.state       ][INFO    ][25076] {'pid': 25419, 'retcode': 0, 'stderr': '', 'stdout': ''}
2018-02-15 01:06:28,403 [salt.state       ][INFO    ][25076] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 01:06:28.403300 duration_in_ms=152.497
2018-02-15 01:06:28,406 [salt.state       ][INFO    ][25076] Running state [/etc/salt/grains.d/dns_records] at time 01:06:28.406030
2018-02-15 01:06:28,406 [salt.state       ][INFO    ][25076] Executing state file.managed for /etc/salt/grains.d/dns_records
2018-02-15 01:06:28,416 [salt.state       ][INFO    ][25076] File /etc/salt/grains.d/dns_records is in the correct state
2018-02-15 01:06:28,416 [salt.state       ][INFO    ][25076] Completed state [/etc/salt/grains.d/dns_records] at time 01:06:28.416516 duration_in_ms=10.487
2018-02-15 01:06:28,419 [salt.state       ][INFO    ][25076] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 01:06:28.419890
2018-02-15 01:06:28,420 [salt.state       ][INFO    ][25076] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"
2018-02-15 01:06:28,421 [salt.state       ][INFO    ][25076] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"
2018-02-15 01:06:28,421 [salt.state       ][INFO    ][25076] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 01:06:28.421612 duration_in_ms=1.722
2018-02-15 01:06:28,423 [salt.state       ][INFO    ][25076] Running state [/etc/salt/grains.d/salt] at time 01:06:28.423292
2018-02-15 01:06:28,423 [salt.state       ][INFO    ][25076] Executing state file.managed for /etc/salt/grains.d/salt
2018-02-15 01:06:28,427 [salt.state       ][INFO    ][25076] File /etc/salt/grains.d/salt is in the correct state
2018-02-15 01:06:28,428 [salt.state       ][INFO    ][25076] Completed state [/etc/salt/grains.d/salt] at time 01:06:28.428263 duration_in_ms=4.971
2018-02-15 01:06:28,431 [salt.state       ][INFO    ][25076] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 01:06:28.431206
2018-02-15 01:06:28,431 [salt.state       ][INFO    ][25076] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2018-02-15 01:06:28,432 [salt.state       ][INFO    ][25076] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2018-02-15 01:06:28,432 [salt.state       ][INFO    ][25076] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 01:06:28.432750 duration_in_ms=1.544
2018-02-15 01:06:28,438 [salt.state       ][INFO    ][25076] Running state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 01:06:28.438340
2018-02-15 01:06:28,438 [salt.state       ][INFO    ][25076] Executing state cmd.wait for cat /etc/salt/grains.d/* > /etc/salt/grains
2018-02-15 01:06:28,439 [salt.state       ][INFO    ][25076] No changes made for cat /etc/salt/grains.d/* > /etc/salt/grains
2018-02-15 01:06:28,439 [salt.state       ][INFO    ][25076] Completed state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 01:06:28.439860 duration_in_ms=1.519
2018-02-15 01:06:28,440 [salt.state       ][INFO    ][25076] Running state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 01:06:28.440305
2018-02-15 01:06:28,440 [salt.state       ][INFO    ][25076] Executing state cmd.mod_watch for cat /etc/salt/grains.d/* > /etc/salt/grains
2018-02-15 01:06:28,443 [salt.loaded.int.module.cmdmod][INFO    ][25076] Executing command 'cat /etc/salt/grains.d/* > /etc/salt/grains' in directory '/root'
2018-02-15 01:06:28,470 [salt.state       ][INFO    ][25076] {'pid': 25421, 'retcode': 0, 'stderr': '', 'stdout': ''}
2018-02-15 01:06:28,471 [salt.state       ][INFO    ][25076] Completed state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 01:06:28.471467 duration_in_ms=31.161
2018-02-15 01:06:28,473 [salt.state       ][INFO    ][25076] Running state [mine.update] at time 01:06:28.473810
2018-02-15 01:06:28,474 [salt.state       ][INFO    ][25076] Executing state module.wait for mine.update
2018-02-15 01:06:28,475 [salt.state       ][INFO    ][25076] No changes made for mine.update
2018-02-15 01:06:28,475 [salt.state       ][INFO    ][25076] Completed state [mine.update] at time 01:06:28.475399 duration_in_ms=1.59
2018-02-15 01:06:28,475 [salt.state       ][INFO    ][25076] Running state [mine.update] at time 01:06:28.475785
2018-02-15 01:06:28,476 [salt.state       ][INFO    ][25076] Executing state module.mod_watch for mine.update
2018-02-15 01:06:29,026 [salt.state       ][INFO    ][25076] {'ret': True}
2018-02-15 01:06:29,027 [salt.state       ][INFO    ][25076] Completed state [mine.update] at time 01:06:29.027453 duration_in_ms=551.667
2018-02-15 01:06:29,028 [salt.state       ][INFO    ][25076] Running state [/etc/pki/ca/salt_master_ca] at time 01:06:29.028123
2018-02-15 01:06:29,028 [salt.state       ][INFO    ][25076] Executing state file.directory for /etc/pki/ca/salt_master_ca
2018-02-15 01:06:29,029 [salt.state       ][INFO    ][25076] Directory /etc/pki/ca/salt_master_ca is in the correct state
2018-02-15 01:06:29,030 [salt.state       ][INFO    ][25076] Completed state [/etc/pki/ca/salt_master_ca] at time 01:06:29.030365 duration_in_ms=2.242
2018-02-15 01:06:29,030 [salt.state       ][INFO    ][25076] Running state [/etc/pki/ca/salt_master_ca/certs] at time 01:06:29.030819
2018-02-15 01:06:29,031 [salt.state       ][INFO    ][25076] Executing state file.directory for /etc/pki/ca/salt_master_ca/certs
2018-02-15 01:06:29,032 [salt.state       ][INFO    ][25076] Directory /etc/pki/ca/salt_master_ca/certs is in the correct state
2018-02-15 01:06:29,032 [salt.state       ][INFO    ][25076] Completed state [/etc/pki/ca/salt_master_ca/certs] at time 01:06:29.032565 duration_in_ms=1.745
2018-02-15 01:06:29,036 [salt.state       ][INFO    ][25076] Running state [/etc/pki/ca/salt_master_ca/ca.key] at time 01:06:29.036041
2018-02-15 01:06:29,036 [salt.state       ][INFO    ][25076] Executing state x509.private_key_managed for /etc/pki/ca/salt_master_ca/ca.key
2018-02-15 01:06:29,044 [salt.state       ][INFO    ][25076] File /etc/pki/ca/salt_master_ca/ca.key is in the correct state
2018-02-15 01:06:29,044 [salt.state       ][INFO    ][25076] Completed state [/etc/pki/ca/salt_master_ca/ca.key] at time 01:06:29.044671 duration_in_ms=8.629
2018-02-15 01:06:29,045 [salt.state       ][INFO    ][25076] Running state [/etc/pki/ca/salt_master_ca/ca.key] at time 01:06:29.045929
2018-02-15 01:06:29,046 [salt.state       ][INFO    ][25076] Executing state file.managed for /etc/pki/ca/salt_master_ca/ca.key
2018-02-15 01:06:29,047 [salt.state       ][INFO    ][25076] File /etc/pki/ca/salt_master_ca/ca.key exists with proper permissions. No changes made.
2018-02-15 01:06:29,047 [salt.state       ][INFO    ][25076] Completed state [/etc/pki/ca/salt_master_ca/ca.key] at time 01:06:29.047699 duration_in_ms=1.771
2018-02-15 01:06:29,048 [salt.state       ][INFO    ][25076] Running state [/etc/pki/ca/salt_master_ca/ca.crt] at time 01:06:29.048731
2018-02-15 01:06:29,049 [salt.state       ][INFO    ][25076] Executing state x509.certificate_managed for /etc/pki/ca/salt_master_ca/ca.crt
2018-02-15 01:06:29,080 [salt.state       ][INFO    ][25076] File /etc/pki/ca/salt_master_ca/ca.crt is in the correct state
2018-02-15 01:06:29,080 [salt.state       ][INFO    ][25076] Completed state [/etc/pki/ca/salt_master_ca/ca.crt] at time 01:06:29.080659 duration_in_ms=31.929
2018-02-15 01:06:29,081 [salt.state       ][INFO    ][25076] Running state [/etc/pki/ca/salt_master_ca/ca.crt] at time 01:06:29.081839
2018-02-15 01:06:29,082 [salt.state       ][INFO    ][25076] Executing state file.managed for /etc/pki/ca/salt_master_ca/ca.crt
2018-02-15 01:06:29,082 [salt.loaded.int.states.file][WARNING ][25076] State for file: /etc/pki/ca/salt_master_ca/ca.crt - Neither 'source' nor 'contents' nor 'contents_pillar' nor 'contents_grains' was defined, yet 'replace' was set to 'True'. As there is no source to replace the file with, 'replace' has been set to 'False' to avoid reading the file unnecessarily.
2018-02-15 01:06:29,083 [salt.state       ][INFO    ][25076] File /etc/pki/ca/salt_master_ca/ca.crt exists with proper permissions. No changes made.
2018-02-15 01:06:29,083 [salt.state       ][INFO    ][25076] Completed state [/etc/pki/ca/salt_master_ca/ca.crt] at time 01:06:29.083816 duration_in_ms=1.977
2018-02-15 01:06:29,084 [salt.state       ][INFO    ][25076] Running state [mine.send] at time 01:06:29.084771
2018-02-15 01:06:29,085 [salt.state       ][INFO    ][25076] Executing state module.run for mine.send
2018-02-15 01:06:29,588 [salt.state       ][INFO    ][25076] {'ret': True}
2018-02-15 01:06:29,589 [salt.state       ][INFO    ][25076] Completed state [mine.send] at time 01:06:29.589661 duration_in_ms=504.888
2018-02-15 01:06:29,590 [salt.state       ][INFO    ][25076] Running state [ca-certificates] at time 01:06:29.590447
2018-02-15 01:06:29,591 [salt.state       ][INFO    ][25076] Executing state pkg.installed for ca-certificates
2018-02-15 01:06:29,604 [salt.state       ][INFO    ][25076] All specified packages are already installed
2018-02-15 01:06:29,605 [salt.state       ][INFO    ][25076] Completed state [ca-certificates] at time 01:06:29.605137 duration_in_ms=14.69
2018-02-15 01:06:29,607 [salt.state       ][INFO    ][25076] Running state [update-ca-certificates] at time 01:06:29.607396
2018-02-15 01:06:29,608 [salt.state       ][INFO    ][25076] Executing state cmd.wait for update-ca-certificates
2018-02-15 01:06:29,608 [salt.state       ][INFO    ][25076] No changes made for update-ca-certificates
2018-02-15 01:06:29,609 [salt.state       ][INFO    ][25076] Completed state [update-ca-certificates] at time 01:06:29.609120 duration_in_ms=1.724
2018-02-15 01:06:29,609 [salt.state       ][INFO    ][25076] Running state [salt-api] at time 01:06:29.609716
2018-02-15 01:06:29,610 [salt.state       ][INFO    ][25076] Executing state pkg.installed for salt-api
2018-02-15 01:06:29,620 [salt.state       ][INFO    ][25076] All specified packages are already installed
2018-02-15 01:06:29,620 [salt.state       ][INFO    ][25076] Completed state [salt-api] at time 01:06:29.620535 duration_in_ms=10.819
2018-02-15 01:06:29,622 [salt.state       ][INFO    ][25076] Running state [/etc/salt/master.d/_api.conf] at time 01:06:29.622312
2018-02-15 01:06:29,622 [salt.state       ][INFO    ][25076] Executing state file.managed for /etc/salt/master.d/_api.conf
2018-02-15 01:06:29,807 [salt.state       ][INFO    ][25076] File /etc/salt/master.d/_api.conf is in the correct state
2018-02-15 01:06:29,808 [salt.state       ][INFO    ][25076] Completed state [/etc/salt/master.d/_api.conf] at time 01:06:29.808081 duration_in_ms=185.77
2018-02-15 01:06:29,810 [salt.state       ][INFO    ][25076] Running state [salt-api] at time 01:06:29.810240
2018-02-15 01:06:29,810 [salt.state       ][INFO    ][25076] Executing state service.running for salt-api
2018-02-15 01:06:29,811 [salt.loaded.int.module.cmdmod][INFO    ][25076] Executing command ['systemctl', 'status', 'salt-api.service', '-n', '0'] in directory '/root'
2018-02-15 01:06:29,839 [salt.loaded.int.module.cmdmod][INFO    ][25076] Executing command ['systemctl', 'is-active', 'salt-api.service'] in directory '/root'
2018-02-15 01:06:29,863 [salt.loaded.int.module.cmdmod][INFO    ][25076] Executing command ['systemctl', 'is-enabled', 'salt-api.service'] in directory '/root'
2018-02-15 01:06:29,886 [salt.state       ][INFO    ][25076] The service salt-api is already running
2018-02-15 01:06:29,887 [salt.state       ][INFO    ][25076] Completed state [salt-api] at time 01:06:29.886952 duration_in_ms=76.71
2018-02-15 01:06:29,901 [salt.minion      ][INFO    ][25076] Returning information for job: 20180215010614989216
2018-02-15 01:09:41,383 [salt.minion      ][INFO    ][20772] User sudo_ubuntu Executing command state.sls with jid 20180215010941377301
2018-02-15 01:09:41,406 [salt.minion      ][INFO    ][25672] Starting a new job with PID 25672
2018-02-15 01:09:43,169 [salt.state       ][INFO    ][25672] Loading fresh modules for state activity
2018-02-15 01:09:43,207 [salt.fileclient  ][INFO    ][25672] Fetching file from saltenv 'base', ** done ** 'ntp/init.sls'
2018-02-15 01:09:43,228 [salt.fileclient  ][INFO    ][25672] Fetching file from saltenv 'base', ** done ** 'ntp/client.sls'
2018-02-15 01:09:43,262 [salt.fileclient  ][INFO    ][25672] Fetching file from saltenv 'base', ** done ** 'ntp/server.sls'
2018-02-15 01:09:43,897 [salt.state       ][INFO    ][25672] Running state [ntp] at time 01:09:43.897233
2018-02-15 01:09:43,897 [salt.state       ][INFO    ][25672] Executing state pkg.installed for ntp
2018-02-15 01:09:43,898 [salt.loaded.int.module.cmdmod][INFO    ][25672] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2018-02-15 01:09:44,392 [salt.loaded.int.module.cmdmod][INFO    ][25672] Executing command ['apt-cache', '-q', 'policy', 'ntp'] in directory '/root'
2018-02-15 01:09:44,489 [salt.loaded.int.module.cmdmod][INFO    ][25672] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2018-02-15 01:09:46,690 [salt.loaded.int.module.cmdmod][INFO    ][25672] Executing command ['dpkg', '--get-selections', '*'] in directory '/root'
2018-02-15 01:09:46,730 [salt.loaded.int.module.cmdmod][INFO    ][25672] 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-15 01:09:51,504 [salt.minion      ][INFO    ][20772] User sudo_ubuntu Executing command saltutil.find_job with jid 20180215010951488005
2018-02-15 01:09:51,534 [salt.minion      ][INFO    ][26667] Starting a new job with PID 26667
2018-02-15 01:09:51,559 [salt.minion      ][INFO    ][26667] Returning information for job: 20180215010951488005
2018-02-15 01:09:55,288 [salt.loaded.int.module.cmdmod][INFO    ][25672] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2018-02-15 01:09:55,328 [salt.state       ][INFO    ][25672] 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-15 01:09:55,345 [salt.state       ][INFO    ][25672] Loading fresh modules for state activity
2018-02-15 01:09:55,367 [salt.state       ][INFO    ][25672] Completed state [ntp] at time 01:09:55.367360 duration_in_ms=11470.127
2018-02-15 01:09:55,370 [salt.state       ][INFO    ][25672] Running state [/etc/ntp.conf] at time 01:09:55.370359
2018-02-15 01:09:55,370 [salt.state       ][INFO    ][25672] Executing state file.managed for /etc/ntp.conf
2018-02-15 01:09:55,401 [salt.fileclient  ][INFO    ][25672] Fetching file from saltenv 'base', ** done ** 'ntp/files/ntp.conf'
2018-02-15 01:09:55,430 [salt.state       ][INFO    ][25672] 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-15 01:09:55,430 [salt.state       ][INFO    ][25672] Completed state [/etc/ntp.conf] at time 01:09:55.430788 duration_in_ms=60.429
2018-02-15 01:09:55,470 [salt.state       ][INFO    ][25672] Running state [ntp] at time 01:09:55.470407
2018-02-15 01:09:55,470 [salt.state       ][INFO    ][25672] Executing state service.running for ntp
2018-02-15 01:09:55,472 [salt.loaded.int.module.cmdmod][INFO    ][25672] Executing command ['systemctl', 'status', 'ntp.service', '-n', '0'] in directory '/root'
2018-02-15 01:09:55,494 [salt.loaded.int.module.cmdmod][INFO    ][25672] Executing command ['systemctl', 'is-active', 'ntp.service'] in directory '/root'
2018-02-15 01:09:55,512 [salt.loaded.int.module.cmdmod][INFO    ][25672] Executing command ['systemctl', 'is-enabled', 'ntp.service'] in directory '/root'
2018-02-15 01:09:55,531 [salt.state       ][INFO    ][25672] The service ntp is already running
2018-02-15 01:09:55,531 [salt.state       ][INFO    ][25672] Completed state [ntp] at time 01:09:55.531792 duration_in_ms=61.385
2018-02-15 01:09:55,532 [salt.state       ][INFO    ][25672] Running state [ntp] at time 01:09:55.532109
2018-02-15 01:09:55,532 [salt.state       ][INFO    ][25672] Executing state service.mod_watch for ntp
2018-02-15 01:09:55,533 [salt.loaded.int.module.cmdmod][INFO    ][25672] Executing command ['systemctl', 'is-active', 'ntp.service'] in directory '/root'
2018-02-15 01:09:55,553 [salt.loaded.int.module.cmdmod][INFO    ][25672] Executing command ['systemctl', 'is-enabled', 'ntp.service'] in directory '/root'
2018-02-15 01:09:55,575 [salt.loaded.int.module.cmdmod][INFO    ][25672] Executing command ['systemd-run', '--scope', 'systemctl', 'restart', 'ntp.service'] in directory '/root'
2018-02-15 01:09:55,679 [salt.state       ][INFO    ][25672] {'ntp': True}
2018-02-15 01:09:55,680 [salt.state       ][INFO    ][25672] Completed state [ntp] at time 01:09:55.680092 duration_in_ms=147.982
2018-02-15 01:09:55,681 [salt.minion      ][INFO    ][25672] Returning information for job: 20180215010941377301
2018-02-15 02:04:46,007 [salt.utils.schedule][INFO    ][20772] Running scheduled job: __mine_interval
2018-02-15 02:18:08,259 [salt.minion      ][INFO    ][20772] User root Executing command x509.sign_remote_certificate with jid 20180215021808249066
2018-02-15 02:18:08,285 [salt.minion      ][INFO    ][32383] Starting a new job with PID 32383
2018-02-15 02:18:08,331 [salt.minion      ][INFO    ][32383] Returning information for job: 20180215021808249066
2018-02-15 02:18:08,635 [salt.minion      ][INFO    ][20772] User root Executing command x509.sign_remote_certificate with jid 20180215021808611481
2018-02-15 02:18:08,667 [salt.minion      ][INFO    ][32392] Starting a new job with PID 32392
2018-02-15 02:18:08,721 [salt.minion      ][INFO    ][32392] Returning information for job: 20180215021808611481
2018-02-15 02:18:09,467 [salt.minion      ][INFO    ][20772] User root Executing command x509.sign_remote_certificate with jid 20180215021809454159
2018-02-15 02:18:09,500 [salt.minion      ][INFO    ][32401] Starting a new job with PID 32401
2018-02-15 02:18:09,546 [salt.minion      ][INFO    ][32401] Returning information for job: 20180215021809454159
2018-02-15 02:18:09,830 [salt.minion      ][INFO    ][20772] User root Executing command x509.sign_remote_certificate with jid 20180215021809816545
2018-02-15 02:18:09,863 [salt.minion      ][INFO    ][32410] Starting a new job with PID 32410
2018-02-15 02:18:09,925 [salt.minion      ][INFO    ][32410] Returning information for job: 20180215021809816545
2018-02-15 03:04:46,007 [salt.utils.schedule][INFO    ][20772] Running scheduled job: __mine_interval
2018-02-15 04:04:46,007 [salt.utils.schedule][INFO    ][20772] Running scheduled job: __mine_interval
2018-02-15 04:19:50,094 [salt.minion      ][INFO    ][20772] User sudo_ubuntu Executing command cp.push_dir with jid 20180215041950083498
2018-02-15 04:19:50,122 [salt.minion      ][INFO    ][7233] Starting a new job with PID 7233
