2018-06-13 08:40:23,594 [salt.minion      :878 ][ERROR   ][1957] Error while bringing up minion for multi-master. Is master at 10.20.0.2 responding?
2018-06-13 08:41:13,652 [salt.minion      :878 ][ERROR   ][1957] Error while bringing up minion for multi-master. Is master at 10.20.0.2 responding?
2018-06-13 08:41:36,912 [salt.crypt       :639 ][ERROR   ][1957] 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-06-13 08:42:39,481 [salt.state       :2005][WARNING ][14583] State is set to retry, but a valid dict for retry configuration was not found.  Using retry defaults
2018-06-13 08:43:25,035 [salt.utils.parsers:1050][WARNING ][13776] Minion received a SIGTERM. Exiting.
2018-06-13 08:43:47,783 [salt.state       :2005][WARNING ][21127] State is set to retry, but a valid dict for retry configuration was not found.  Using retry defaults
2018-06-13 08:43:54,098 [salt.utils.decorators:613 ][WARNING ][21127] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2018-06-13 08:43:55,604 [salt.loaded.int.states.file:2144][WARNING ][21127] 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-06-13 08:43:55,606 [salt.utils.decorators:613 ][WARNING ][21127] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2018-06-13 08:44:12,173 [salt.loaded.int.module.cmdmod:394 ][INFO    ][22275] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2018-06-13 08:44:12,204 [salt.loaded.int.module.cmdmod:394 ][INFO    ][22275] Executing command ['systemd-run', '--scope', 'systemctl', 'restart', 'salt-minion.service'] in directory '/root'
2018-06-13 08:44:12,229 [salt.utils.parsers:1050][WARNING ][20804] Minion received a SIGTERM. Exiting.
2018-06-13 08:44:13,218 [salt.cli.daemons :293 ][INFO    ][22345] Setting up the Salt Minion "cfg01.mcp-odl-ha.local"
2018-06-13 08:44:13,358 [salt.cli.daemons :82  ][INFO    ][22345] Starting up the Salt Minion
2018-06-13 08:44:13,359 [salt.utils.event :1017][INFO    ][22345] Starting pull socket on /var/run/salt/minion/minion_event_d96a5db9d6_pull.ipc
2018-06-13 08:44:14,068 [salt.minion      :993 ][INFO    ][22345] Creating minion process manager
2018-06-13 08:44:15,112 [salt.loader.10.20.0.2.int.module.cmdmod:394 ][INFO    ][22345] Executing command ['date', '+%z'] in directory '/root'
2018-06-13 08:44:15,135 [salt.utils.schedule:567 ][INFO    ][22345] Updating job settings for scheduled job: __mine_interval
2018-06-13 08:44:15,141 [salt.minion      :1124][INFO    ][22345] Added mine.update to scheduler
2018-06-13 08:44:15,154 [salt.minion      :1982][INFO    ][22345] Minion is starting as user 'root'
2018-06-13 08:44:15,193 [salt.minion      :2337][INFO    ][22345] Minion is ready to receive requests!
2018-06-13 08:44:23,760 [salt.minion      :1324][INFO    ][22345] User sudo_ubuntu Executing command saltutil.find_job with jid 20180613084423739594
2018-06-13 08:44:23,785 [salt.minion      :1448][INFO    ][22452] Starting a new job with PID 22452
2018-06-13 08:44:23,817 [salt.minion      :1725][INFO    ][22452] Returning information for job: 20180613084423739594
2018-06-13 08:44:44,511 [salt.minion      :1324][INFO    ][22345] User sudo_ubuntu Executing command state.apply with jid 20180613084444492787
2018-06-13 08:44:44,531 [salt.minion      :1448][INFO    ][22470] Starting a new job with PID 22470
2018-06-13 08:44:46,512 [salt.state       :905 ][INFO    ][22470] Loading fresh modules for state activity
2018-06-13 08:44:46,606 [salt.fileclient  :1215][INFO    ][22470] Fetching file from saltenv 'base', ** done ** 'linux/init.sls'
2018-06-13 08:44:46,692 [salt.fileclient  :1215][INFO    ][22470] Fetching file from saltenv 'base', ** done ** 'linux/system/init.sls'
2018-06-13 08:44:46,860 [salt.fileclient  :1215][INFO    ][22470] Fetching file from saltenv 'base', ** done ** 'linux/system/env.sls'
2018-06-13 08:44:46,966 [salt.fileclient  :1215][INFO    ][22470] Fetching file from saltenv 'base', ** done ** 'linux/system/profile.sls'
2018-06-13 08:44:47,063 [salt.fileclient  :1215][INFO    ][22470] Fetching file from saltenv 'base', ** done ** 'linux/system/repo.sls'
2018-06-13 08:44:47,238 [salt.fileclient  :1215][INFO    ][22470] Fetching file from saltenv 'base', ** done ** 'linux/system/package.sls'
2018-06-13 08:44:47,316 [salt.fileclient  :1215][INFO    ][22470] Fetching file from saltenv 'base', ** done ** 'linux/system/timezone.sls'
2018-06-13 08:44:47,380 [salt.fileclient  :1215][INFO    ][22470] Fetching file from saltenv 'base', ** done ** 'linux/system/kernel.sls'
2018-06-13 08:44:47,469 [salt.fileclient  :1215][INFO    ][22470] Fetching file from saltenv 'base', ** done ** 'linux/system/cpu.sls'
2018-06-13 08:44:47,537 [salt.fileclient  :1215][INFO    ][22470] Fetching file from saltenv 'base', ** done ** 'linux/system/sysfs.sls'
2018-06-13 08:44:47,613 [salt.fileclient  :1215][INFO    ][22470] Fetching file from saltenv 'base', ** done ** 'linux/system/locale.sls'
2018-06-13 08:44:47,875 [salt.fileclient  :1215][INFO    ][22470] Fetching file from saltenv 'base', ** done ** 'linux/system/limit.sls'
2018-06-13 08:44:47,941 [salt.fileclient  :1215][INFO    ][22470] Fetching file from saltenv 'base', ** done ** 'linux/system/systemd.sls'
2018-06-13 08:44:48,011 [salt.fileclient  :1215][INFO    ][22470] Fetching file from saltenv 'base', ** done ** 'linux/system/apt.sls'
2018-06-13 08:44:48,080 [salt.fileclient  :1215][INFO    ][22470] Fetching file from saltenv 'base', ** done ** 'linux/system/banner.sls'
2018-06-13 08:44:48,149 [salt.fileclient  :1215][INFO    ][22470] Fetching file from saltenv 'base', ** done ** 'linux/network/init.sls'
2018-06-13 08:44:48,217 [salt.fileclient  :1215][INFO    ][22470] Fetching file from saltenv 'base', ** done ** 'linux/network/hostname.sls'
2018-06-13 08:44:48,287 [salt.fileclient  :1215][INFO    ][22470] Fetching file from saltenv 'base', ** done ** 'linux/network/host.sls'
2018-06-13 08:44:48,421 [salt.fileclient  :1215][INFO    ][22470] Fetching file from saltenv 'base', ** done ** 'linux/network/interface.sls'
2018-06-13 08:44:48,610 [salt.fileclient  :1215][INFO    ][22470] Fetching file from saltenv 'base', ** done ** 'linux/network/proxy.sls'
2018-06-13 08:44:48,687 [salt.fileclient  :1215][INFO    ][22470] Fetching file from saltenv 'base', ** done ** 'linux/storage/init.sls'
2018-06-13 08:44:48,754 [salt.state       :1761][INFO    ][22470] Running state [/etc/environment] at time 08:44:48.754183
2018-06-13 08:44:48,754 [salt.state       :1794][INFO    ][22470] Executing state file.blockreplace for [/etc/environment]
2018-06-13 08:44:48,779 [salt.state       :290 ][INFO    ][22470] 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-06-13 08:44:48,780 [salt.state       :1934][INFO    ][22470] Completed state [/etc/environment] at time 08:44:48.780458 duration_in_ms=26.281
2018-06-13 08:44:48,780 [salt.state       :1761][INFO    ][22470] Running state [/etc/profile.d] at time 08:44:48.780842
2018-06-13 08:44:48,781 [salt.state       :1794][INFO    ][22470] Executing state file.directory for [/etc/profile.d]
2018-06-13 08:44:48,782 [salt.state       :290 ][INFO    ][22470] Directory /etc/profile.d is in the correct state
Directory /etc/profile.d updated
2018-06-13 08:44:48,782 [salt.state       :1934][INFO    ][22470] Completed state [/etc/profile.d] at time 08:44:48.782905 duration_in_ms=2.063
2018-06-13 08:44:49,322 [salt.state       :1761][INFO    ][22470] Running state [/etc/apt/apt.conf.d/99prefer_ipv4-salt] at time 08:44:49.322930
2018-06-13 08:44:49,323 [salt.state       :1794][INFO    ][22470] Executing state file.managed for [/etc/apt/apt.conf.d/99prefer_ipv4-salt]
2018-06-13 08:44:49,351 [salt.fileclient  :1215][INFO    ][22470] Fetching file from saltenv 'base', ** done ** 'linux/files/apt.conf'
2018-06-13 08:44:49,361 [salt.state       :290 ][INFO    ][22470] File changed:
New file
2018-06-13 08:44:49,361 [salt.state       :1934][INFO    ][22470] Completed state [/etc/apt/apt.conf.d/99prefer_ipv4-salt] at time 08:44:49.361614 duration_in_ms=38.684
2018-06-13 08:44:49,362 [salt.state       :1761][INFO    ][22470] Running state [linux_repo_prereq_pkgs] at time 08:44:49.362356
2018-06-13 08:44:49,362 [salt.state       :1794][INFO    ][22470] Executing state pkg.installed for [linux_repo_prereq_pkgs]
2018-06-13 08:44:49,363 [salt.loaded.int.module.cmdmod:394 ][INFO    ][22470] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}', '-W'] in directory '/root'
2018-06-13 08:44:49,747 [salt.state       :290 ][INFO    ][22470] All specified packages are already installed
2018-06-13 08:44:49,766 [salt.state       :1934][INFO    ][22470] Completed state [linux_repo_prereq_pkgs] at time 08:44:49.766266 duration_in_ms=403.907
2018-06-13 08:44:49,766 [salt.state       :1761][INFO    ][22470] Running state [/etc/apt/apt.conf.d/99proxies-salt] at time 08:44:49.766710
2018-06-13 08:44:49,767 [salt.state       :1794][INFO    ][22470] Executing state file.absent for [/etc/apt/apt.conf.d/99proxies-salt]
2018-06-13 08:44:49,767 [salt.state       :290 ][INFO    ][22470] File /etc/apt/apt.conf.d/99proxies-salt is not present
2018-06-13 08:44:49,768 [salt.state       :1934][INFO    ][22470] Completed state [/etc/apt/apt.conf.d/99proxies-salt] at time 08:44:49.768047 duration_in_ms=1.337
2018-06-13 08:44:49,768 [salt.state       :1761][INFO    ][22470] Running state [/etc/apt/apt.conf.d/99proxies-salt-saltstack] at time 08:44:49.768400
2018-06-13 08:44:49,768 [salt.state       :1794][INFO    ][22470] Executing state file.absent for [/etc/apt/apt.conf.d/99proxies-salt-saltstack]
2018-06-13 08:44:49,769 [salt.state       :290 ][INFO    ][22470] File /etc/apt/apt.conf.d/99proxies-salt-saltstack is not present
2018-06-13 08:44:49,769 [salt.state       :1934][INFO    ][22470] Completed state [/etc/apt/apt.conf.d/99proxies-salt-saltstack] at time 08:44:49.769475 duration_in_ms=1.075
2018-06-13 08:44:49,769 [salt.state       :1761][INFO    ][22470] Running state [/etc/apt/preferences.d/saltstack] at time 08:44:49.769823
2018-06-13 08:44:49,770 [salt.state       :1794][INFO    ][22470] Executing state file.absent for [/etc/apt/preferences.d/saltstack]
2018-06-13 08:44:49,770 [salt.state       :290 ][INFO    ][22470] {'removed': '/etc/apt/preferences.d/saltstack'}
2018-06-13 08:44:49,771 [salt.state       :1934][INFO    ][22470] Completed state [/etc/apt/preferences.d/saltstack] at time 08:44:49.770996 duration_in_ms=1.172
2018-06-13 08:44:49,772 [salt.state       :1761][INFO    ][22470] Running state [curl -sL http://repo.saltstack.com/apt/ubuntu/16.04/amd64/2017.7/SALTSTACK-GPG-KEY.pub | apt-key add -] at time 08:44:49.772705
2018-06-13 08:44:49,773 [salt.state       :1794][INFO    ][22470] Executing state cmd.run for [curl -sL http://repo.saltstack.com/apt/ubuntu/16.04/amd64/2017.7/SALTSTACK-GPG-KEY.pub | apt-key add -]
2018-06-13 08:44:49,773 [salt.loaded.int.module.cmdmod:394 ][INFO    ][22470] Executing command 'apt-key finger --with-colons | grep -qF $(curl -sL http://repo.saltstack.com/apt/ubuntu/16.04/amd64/2017.7/SALTSTACK-GPG-KEY.pub | gpg --with-fingerprint --with-colons | grep -E '^fpr')' in directory '/root'
2018-06-13 08:44:49,935 [salt.state       :290 ][INFO    ][22470] unless execution succeeded
2018-06-13 08:44:49,936 [salt.state       :1934][INFO    ][22470] Completed state [curl -sL http://repo.saltstack.com/apt/ubuntu/16.04/amd64/2017.7/SALTSTACK-GPG-KEY.pub | apt-key add -] at time 08:44:49.936375 duration_in_ms=163.668
2018-06-13 08:44:49,950 [salt.state       :1761][INFO    ][22470] Running state [deb http://repo.saltstack.com/apt/ubuntu/16.04/amd64/2017.7 xenial main] at time 08:44:49.950382
2018-06-13 08:44:49,951 [salt.state       :1794][INFO    ][22470] Executing state pkgrepo.managed for [deb http://repo.saltstack.com/apt/ubuntu/16.04/amd64/2017.7 xenial main]
2018-06-13 08:44:50,138 [salt.loaded.int.module.cmdmod:394 ][INFO    ][22470] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2018-06-13 08:44:54,185 [salt.state       :290 ][INFO    ][22470] Configured package repo 'deb http://repo.saltstack.com/apt/ubuntu/16.04/amd64/2017.7 xenial main'
2018-06-13 08:44:54,186 [salt.state       :1934][INFO    ][22470] Completed state [deb http://repo.saltstack.com/apt/ubuntu/16.04/amd64/2017.7 xenial main] at time 08:44:54.186396 duration_in_ms=4236.014
2018-06-13 08:44:54,187 [salt.state       :1761][INFO    ][22470] Running state [/etc/apt/apt.conf.d/99proxies-salt-salt] at time 08:44:54.187234
2018-06-13 08:44:54,188 [salt.state       :1794][INFO    ][22470] Executing state file.absent for [/etc/apt/apt.conf.d/99proxies-salt-salt]
2018-06-13 08:44:54,189 [salt.state       :290 ][INFO    ][22470] File /etc/apt/apt.conf.d/99proxies-salt-salt is not present
2018-06-13 08:44:54,189 [salt.state       :1934][INFO    ][22470] Completed state [/etc/apt/apt.conf.d/99proxies-salt-salt] at time 08:44:54.189708 duration_in_ms=2.473
2018-06-13 08:44:54,190 [salt.state       :1761][INFO    ][22470] Running state [/etc/apt/preferences.d/salt] at time 08:44:54.190345
2018-06-13 08:44:54,190 [salt.state       :1794][INFO    ][22470] Executing state file.absent for [/etc/apt/preferences.d/salt]
2018-06-13 08:44:54,191 [salt.state       :290 ][INFO    ][22470] File /etc/apt/preferences.d/salt is not present
2018-06-13 08:44:54,192 [salt.state       :1934][INFO    ][22470] Completed state [/etc/apt/preferences.d/salt] at time 08:44:54.192183 duration_in_ms=1.838
2018-06-13 08:44:54,192 [salt.state       :1761][INFO    ][22470] Running state [linux_repo_salt_absent] at time 08:44:54.192731
2018-06-13 08:44:54,193 [salt.state       :1794][INFO    ][22470] Executing state pkgrepo.absent for [linux_repo_salt_absent]
2018-06-13 08:44:54,230 [salt.state       :290 ][INFO    ][22470] Package repo linux_repo_salt_absent is absent
2018-06-13 08:44:54,231 [salt.state       :1934][INFO    ][22470] Completed state [linux_repo_salt_absent] at time 08:44:54.231070 duration_in_ms=38.339
2018-06-13 08:44:54,231 [salt.state       :1761][INFO    ][22470] Running state [/etc/apt/sources.list.d/salt.list] at time 08:44:54.231577
2018-06-13 08:44:54,232 [salt.state       :1794][INFO    ][22470] Executing state file.absent for [/etc/apt/sources.list.d/salt.list]
2018-06-13 08:44:54,232 [salt.state       :290 ][INFO    ][22470] File /etc/apt/sources.list.d/salt.list is not present
2018-06-13 08:44:54,233 [salt.state       :1934][INFO    ][22470] Completed state [/etc/apt/sources.list.d/salt.list] at time 08:44:54.233102 duration_in_ms=1.525
2018-06-13 08:44:54,233 [salt.state       :1761][INFO    ][22470] Running state [/etc/apt/apt.conf.d/99proxies-salt-uca] at time 08:44:54.233582
2018-06-13 08:44:54,234 [salt.state       :1794][INFO    ][22470] Executing state file.absent for [/etc/apt/apt.conf.d/99proxies-salt-uca]
2018-06-13 08:44:54,234 [salt.state       :290 ][INFO    ][22470] File /etc/apt/apt.conf.d/99proxies-salt-uca is not present
2018-06-13 08:44:54,235 [salt.state       :1934][INFO    ][22470] Completed state [/etc/apt/apt.conf.d/99proxies-salt-uca] at time 08:44:54.235023 duration_in_ms=1.441
2018-06-13 08:44:54,235 [salt.state       :1761][INFO    ][22470] Running state [/etc/apt/preferences.d/uca] at time 08:44:54.235495
2018-06-13 08:44:54,235 [salt.state       :1794][INFO    ][22470] Executing state file.absent for [/etc/apt/preferences.d/uca]
2018-06-13 08:44:54,236 [salt.state       :290 ][INFO    ][22470] File /etc/apt/preferences.d/uca is not present
2018-06-13 08:44:54,237 [salt.state       :1934][INFO    ][22470] Completed state [/etc/apt/preferences.d/uca] at time 08:44:54.236966 duration_in_ms=1.471
2018-06-13 08:44:54,238 [salt.state       :1761][INFO    ][22470] Running state [deb http://ubuntu-cloud.archive.canonical.com/ubuntu xenial-updates/queens main] at time 08:44:54.238528
2018-06-13 08:44:54,239 [salt.state       :1794][INFO    ][22470] Executing state pkgrepo.managed for [deb http://ubuntu-cloud.archive.canonical.com/ubuntu xenial-updates/queens main]
2018-06-13 08:44:54,296 [salt.loaded.int.module.cmdmod:394 ][INFO    ][22470] Executing command ['apt-key', 'export', 'EC4926EA'] in directory '/root'
2018-06-13 08:44:54,399 [salt.loaded.int.module.cmdmod:394 ][INFO    ][22470] Executing command ['apt-key', 'adv', '--keyserver', 'keyserver.ubuntu.com', '--logger-fd', '1', '--recv-keys', 'EC4926EA'] in directory '/root'
2018-06-13 08:44:54,629 [salt.minion      :1324][INFO    ][22345] User sudo_ubuntu Executing command saltutil.find_job with jid 20180613084454605059
2018-06-13 08:44:54,652 [salt.minion      :1448][INFO    ][23058] Starting a new job with PID 23058
2018-06-13 08:44:54,683 [salt.minion      :1725][INFO    ][23058] Returning information for job: 20180613084454605059
2018-06-13 08:44:55,096 [salt.loaded.int.module.cmdmod:394 ][INFO    ][22470] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2018-06-13 08:45:00,060 [salt.state       :290 ][INFO    ][22470] {'repo': 'deb http://ubuntu-cloud.archive.canonical.com/ubuntu xenial-updates/queens main'}
2018-06-13 08:45:00,071 [salt.state       :1934][INFO    ][22470] Completed state [deb http://ubuntu-cloud.archive.canonical.com/ubuntu xenial-updates/queens main] at time 08:45:00.071893 duration_in_ms=5833.362
2018-06-13 08:45:00,072 [salt.state       :1761][INFO    ][22470] Running state [/etc/apt/apt.conf.d/99proxies-salt-mcp_salt] at time 08:45:00.072703
2018-06-13 08:45:00,073 [salt.state       :1794][INFO    ][22470] Executing state file.absent for [/etc/apt/apt.conf.d/99proxies-salt-mcp_salt]
2018-06-13 08:45:00,074 [salt.state       :290 ][INFO    ][22470] File /etc/apt/apt.conf.d/99proxies-salt-mcp_salt is not present
2018-06-13 08:45:00,075 [salt.state       :1934][INFO    ][22470] Completed state [/etc/apt/apt.conf.d/99proxies-salt-mcp_salt] at time 08:45:00.074955 duration_in_ms=2.252
2018-06-13 08:45:00,075 [salt.state       :1761][INFO    ][22470] Running state [/etc/apt/preferences.d/mcp_salt] at time 08:45:00.075566
2018-06-13 08:45:00,076 [salt.state       :1794][INFO    ][22470] Executing state file.managed for [/etc/apt/preferences.d/mcp_salt]
2018-06-13 08:45:00,124 [salt.fileclient  :1215][INFO    ][22470] Fetching file from saltenv 'base', ** done ** 'linux/files/preferences_repo'
2018-06-13 08:45:00,206 [salt.state       :290 ][INFO    ][22470] File changed:
New file
2018-06-13 08:45:00,207 [salt.state       :1934][INFO    ][22470] Completed state [/etc/apt/preferences.d/mcp_salt] at time 08:45:00.207132 duration_in_ms=131.555
2018-06-13 08:45:00,207 [salt.state       :1761][INFO    ][22470] Running state [curl -sL http://apt.mirantis.com/public.gpg | apt-key add -] at time 08:45:00.207457
2018-06-13 08:45:00,207 [salt.state       :1794][INFO    ][22470] Executing state cmd.run for [curl -sL http://apt.mirantis.com/public.gpg | apt-key add -]
2018-06-13 08:45:00,208 [salt.loaded.int.module.cmdmod:394 ][INFO    ][22470] Executing command 'apt-key finger --with-colons | grep -qF $(curl -sL http://apt.mirantis.com/public.gpg | gpg --with-fingerprint --with-colons | grep -E '^fpr')' in directory '/root'
2018-06-13 08:45:00,427 [salt.state       :290 ][INFO    ][22470] unless execution succeeded
2018-06-13 08:45:00,428 [salt.state       :1934][INFO    ][22470] Completed state [curl -sL http://apt.mirantis.com/public.gpg | apt-key add -] at time 08:45:00.428591 duration_in_ms=221.133
2018-06-13 08:45:00,432 [salt.state       :1761][INFO    ][22470] Running state [deb [arch=amd64] http://apt.mirantis.com/xenial/ nightly salt] at time 08:45:00.432326
2018-06-13 08:45:00,433 [salt.state       :1794][INFO    ][22470] Executing state pkgrepo.managed for [deb [arch=amd64] http://apt.mirantis.com/xenial/ nightly salt]
2018-06-13 08:45:00,519 [salt.loaded.int.module.cmdmod:394 ][INFO    ][22470] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2018-06-13 08:45:04,568 [salt.state       :290 ][INFO    ][22470] {'repo': 'deb [arch=amd64] http://apt.mirantis.com/xenial nightly salt'}
2018-06-13 08:45:04,569 [salt.state       :1934][INFO    ][22470] Completed state [deb [arch=amd64] http://apt.mirantis.com/xenial/ nightly salt] at time 08:45:04.569050 duration_in_ms=4136.724
2018-06-13 08:45:04,569 [salt.state       :1761][INFO    ][22470] Running state [linux_extra_packages_latest] at time 08:45:04.569453
2018-06-13 08:45:04,569 [salt.state       :1794][INFO    ][22470] Executing state pkg.latest for [linux_extra_packages_latest]
2018-06-13 08:45:04,579 [salt.loaded.int.module.cmdmod:394 ][INFO    ][22470] Executing command ['apt-cache', '-q', 'policy', 'python-tornado'] in directory '/root'
2018-06-13 08:45:04,638 [salt.loaded.int.module.cmdmod:394 ][INFO    ][22470] Executing command ['dpkg', '--get-selections', '*'] in directory '/root'
2018-06-13 08:45:04,653 [salt.loaded.int.module.cmdmod:394 ][INFO    ][22470] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'python-tornado'] in directory '/root'
2018-06-13 08:45:04,664 [salt.minion      :1324][INFO    ][22345] User sudo_ubuntu Executing command saltutil.find_job with jid 20180613084504647695
2018-06-13 08:45:04,679 [salt.minion      :1448][INFO    ][24026] Starting a new job with PID 24026
2018-06-13 08:45:04,706 [salt.minion      :1725][INFO    ][24026] Returning information for job: 20180613084504647695
2018-06-13 08:45:10,661 [salt.loaded.int.module.cmdmod:394 ][INFO    ][22470] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}', '-W'] in directory '/root'
2018-06-13 08:45:10,700 [salt.state       :290 ][INFO    ][22470] Made the following changes:
'python-singledispatch' changed from 'absent' to '3.4.0.3-2'
'python-tornado' changed from '4.2.1-2~ds+1' to '4.5.3-1~cloud0'
'python-backports-abc' changed from 'absent' to '0.5-2~cloud0'

2018-06-13 08:45:10,727 [salt.state       :905 ][INFO    ][22470] Loading fresh modules for state activity
2018-06-13 08:45:10,768 [salt.state       :1934][INFO    ][22470] Completed state [linux_extra_packages_latest] at time 08:45:10.768613 duration_in_ms=6199.159
2018-06-13 08:45:10,780 [salt.state       :1761][INFO    ][22470] Running state [UTC] at time 08:45:10.780413
2018-06-13 08:45:10,781 [salt.state       :1794][INFO    ][22470] Executing state timezone.system for [UTC]
2018-06-13 08:45:10,784 [salt.loaded.int.module.cmdmod:394 ][INFO    ][22470] Executing command ['timedatectl'] in directory '/root'
2018-06-13 08:45:10,897 [salt.state       :290 ][INFO    ][22470] Timezone UTC already set, UTC already set to UTC
2018-06-13 08:45:10,899 [salt.state       :1934][INFO    ][22470] Completed state [UTC] at time 08:45:10.898972 duration_in_ms=118.559
2018-06-13 08:45:10,904 [salt.state       :1761][INFO    ][22470] Running state [nf_conntrack] at time 08:45:10.904210
2018-06-13 08:45:10,904 [salt.state       :1794][INFO    ][22470] Executing state kmod.present for [nf_conntrack]
2018-06-13 08:45:10,906 [salt.loaded.int.module.cmdmod:394 ][INFO    ][22470] Executing command 'lsmod' in directory '/root'
2018-06-13 08:45:11,420 [salt.loaded.int.module.cmdmod:394 ][INFO    ][22470] Executing command 'lsmod' in directory '/root'
2018-06-13 08:45:11,442 [salt.loaded.int.module.cmdmod:394 ][INFO    ][22470] Executing command 'modprobe nf_conntrack' in directory '/root'
2018-06-13 08:45:11,478 [salt.loaded.int.module.cmdmod:394 ][INFO    ][22470] Executing command 'lsmod' in directory '/root'
2018-06-13 08:45:11,576 [salt.state       :290 ][INFO    ][22470] {'nf_conntrack': 'loaded'}
2018-06-13 08:45:11,577 [salt.state       :1934][INFO    ][22470] Completed state [nf_conntrack] at time 08:45:11.577104 duration_in_ms=672.893
2018-06-13 08:45:11,585 [salt.state       :1761][INFO    ][22470] Running state [kernel.panic] at time 08:45:11.585332
2018-06-13 08:45:11,585 [salt.state       :1794][INFO    ][22470] Executing state sysctl.present for [kernel.panic]
2018-06-13 08:45:11,587 [salt.loaded.int.module.cmdmod:394 ][INFO    ][22470] Executing command 'sysctl -w kernel.panic="60"' in directory '/root'
2018-06-13 08:45:11,618 [salt.state       :290 ][INFO    ][22470] {'kernel.panic': 60}
2018-06-13 08:45:11,619 [salt.state       :1934][INFO    ][22470] Completed state [kernel.panic] at time 08:45:11.619300 duration_in_ms=33.968
2018-06-13 08:45:11,620 [salt.state       :1761][INFO    ][22470] Running state [net.ipv4.tcp_keepalive_probes] at time 08:45:11.620036
2018-06-13 08:45:11,620 [salt.state       :1794][INFO    ][22470] Executing state sysctl.present for [net.ipv4.tcp_keepalive_probes]
2018-06-13 08:45:11,622 [salt.loaded.int.module.cmdmod:394 ][INFO    ][22470] Executing command 'sysctl -w net.ipv4.tcp_keepalive_probes="8"' in directory '/root'
2018-06-13 08:45:11,635 [salt.state       :290 ][INFO    ][22470] {'net.ipv4.tcp_keepalive_probes': 8}
2018-06-13 08:45:11,637 [salt.state       :1934][INFO    ][22470] Completed state [net.ipv4.tcp_keepalive_probes] at time 08:45:11.636920 duration_in_ms=16.883
2018-06-13 08:45:11,638 [salt.state       :1761][INFO    ][22470] Running state [fs.file-max] at time 08:45:11.638027
2018-06-13 08:45:11,639 [salt.state       :1794][INFO    ][22470] Executing state sysctl.present for [fs.file-max]
2018-06-13 08:45:11,641 [salt.loaded.int.module.cmdmod:394 ][INFO    ][22470] Executing command 'sysctl -w fs.file-max="124165"' in directory '/root'
2018-06-13 08:45:11,655 [salt.state       :290 ][INFO    ][22470] {'fs.file-max': 124165}
2018-06-13 08:45:11,657 [salt.state       :1934][INFO    ][22470] Completed state [fs.file-max] at time 08:45:11.656957 duration_in_ms=18.93
2018-06-13 08:45:11,658 [salt.state       :1761][INFO    ][22470] Running state [net.core.somaxconn] at time 08:45:11.658050
2018-06-13 08:45:11,659 [salt.state       :1794][INFO    ][22470] Executing state sysctl.present for [net.core.somaxconn]
2018-06-13 08:45:11,661 [salt.loaded.int.module.cmdmod:394 ][INFO    ][22470] Executing command 'sysctl -w net.core.somaxconn="4096"' in directory '/root'
2018-06-13 08:45:11,675 [salt.state       :290 ][INFO    ][22470] {'net.core.somaxconn': 4096}
2018-06-13 08:45:11,676 [salt.state       :1934][INFO    ][22470] Completed state [net.core.somaxconn] at time 08:45:11.676253 duration_in_ms=18.203
2018-06-13 08:45:11,677 [salt.state       :1761][INFO    ][22470] Running state [net.ipv4.tcp_max_syn_backlog] at time 08:45:11.677230
2018-06-13 08:45:11,678 [salt.state       :1794][INFO    ][22470] Executing state sysctl.present for [net.ipv4.tcp_max_syn_backlog]
2018-06-13 08:45:11,680 [salt.loaded.int.module.cmdmod:394 ][INFO    ][22470] Executing command 'sysctl -w net.ipv4.tcp_max_syn_backlog="8192"' in directory '/root'
2018-06-13 08:45:11,693 [salt.state       :290 ][INFO    ][22470] {'net.ipv4.tcp_max_syn_backlog': 8192}
2018-06-13 08:45:11,694 [salt.state       :1934][INFO    ][22470] Completed state [net.ipv4.tcp_max_syn_backlog] at time 08:45:11.694311 duration_in_ms=17.081
2018-06-13 08:45:11,695 [salt.state       :1761][INFO    ][22470] Running state [net.ipv4.tcp_tw_reuse] at time 08:45:11.695224
2018-06-13 08:45:11,696 [salt.state       :1794][INFO    ][22470] Executing state sysctl.present for [net.ipv4.tcp_tw_reuse]
2018-06-13 08:45:11,697 [salt.loaded.int.module.cmdmod:394 ][INFO    ][22470] Executing command 'sysctl -w net.ipv4.tcp_tw_reuse="1"' in directory '/root'
2018-06-13 08:45:11,711 [salt.state       :290 ][INFO    ][22470] {'net.ipv4.tcp_tw_reuse': 1}
2018-06-13 08:45:11,712 [salt.state       :1934][INFO    ][22470] Completed state [net.ipv4.tcp_tw_reuse] at time 08:45:11.712139 duration_in_ms=16.916
2018-06-13 08:45:11,713 [salt.state       :1761][INFO    ][22470] Running state [net.ipv4.tcp_congestion_control] at time 08:45:11.713020
2018-06-13 08:45:11,713 [salt.state       :1794][INFO    ][22470] Executing state sysctl.present for [net.ipv4.tcp_congestion_control]
2018-06-13 08:45:11,715 [salt.loaded.int.module.cmdmod:394 ][INFO    ][22470] Executing command 'sysctl -w net.ipv4.tcp_congestion_control="yeah"' in directory '/root'
2018-06-13 08:45:11,755 [salt.state       :290 ][INFO    ][22470] {'net.ipv4.tcp_congestion_control': 'yeah'}
2018-06-13 08:45:11,756 [salt.state       :1934][INFO    ][22470] Completed state [net.ipv4.tcp_congestion_control] at time 08:45:11.756582 duration_in_ms=43.562
2018-06-13 08:45:11,757 [salt.state       :1761][INFO    ][22470] Running state [net.ipv4.tcp_retries2] at time 08:45:11.757434
2018-06-13 08:45:11,758 [salt.state       :1794][INFO    ][22470] Executing state sysctl.present for [net.ipv4.tcp_retries2]
2018-06-13 08:45:11,759 [salt.loaded.int.module.cmdmod:394 ][INFO    ][22470] Executing command 'sysctl -w net.ipv4.tcp_retries2="5"' in directory '/root'
2018-06-13 08:45:11,777 [salt.state       :290 ][INFO    ][22470] {'net.ipv4.tcp_retries2': 5}
2018-06-13 08:45:11,777 [salt.state       :1934][INFO    ][22470] Completed state [net.ipv4.tcp_retries2] at time 08:45:11.777873 duration_in_ms=20.44
2018-06-13 08:45:11,778 [salt.state       :1761][INFO    ][22470] Running state [net.ipv4.tcp_keepalive_intvl] at time 08:45:11.778678
2018-06-13 08:45:11,779 [salt.state       :1794][INFO    ][22470] Executing state sysctl.present for [net.ipv4.tcp_keepalive_intvl]
2018-06-13 08:45:11,780 [salt.loaded.int.module.cmdmod:394 ][INFO    ][22470] Executing command 'sysctl -w net.ipv4.tcp_keepalive_intvl="3"' in directory '/root'
2018-06-13 08:45:11,797 [salt.state       :290 ][INFO    ][22470] {'net.ipv4.tcp_keepalive_intvl': 3}
2018-06-13 08:45:11,797 [salt.state       :1934][INFO    ][22470] Completed state [net.ipv4.tcp_keepalive_intvl] at time 08:45:11.797851 duration_in_ms=19.172
2018-06-13 08:45:11,798 [salt.state       :1761][INFO    ][22470] Running state [net.ipv4.tcp_slow_start_after_idle] at time 08:45:11.798682
2018-06-13 08:45:11,799 [salt.state       :1794][INFO    ][22470] Executing state sysctl.present for [net.ipv4.tcp_slow_start_after_idle]
2018-06-13 08:45:11,801 [salt.loaded.int.module.cmdmod:394 ][INFO    ][22470] Executing command 'sysctl -w net.ipv4.tcp_slow_start_after_idle="0"' in directory '/root'
2018-06-13 08:45:11,818 [salt.state       :290 ][INFO    ][22470] {'net.ipv4.tcp_slow_start_after_idle': 0}
2018-06-13 08:45:11,819 [salt.state       :1934][INFO    ][22470] Completed state [net.ipv4.tcp_slow_start_after_idle] at time 08:45:11.819525 duration_in_ms=20.844
2018-06-13 08:45:11,820 [salt.state       :1761][INFO    ][22470] Running state [vm.swappiness] at time 08:45:11.820486
2018-06-13 08:45:11,821 [salt.state       :1794][INFO    ][22470] Executing state sysctl.present for [vm.swappiness]
2018-06-13 08:45:11,823 [salt.loaded.int.module.cmdmod:394 ][INFO    ][22470] Executing command 'sysctl -w vm.swappiness="10"' in directory '/root'
2018-06-13 08:45:11,840 [salt.state       :290 ][INFO    ][22470] {'vm.swappiness': 10}
2018-06-13 08:45:11,841 [salt.state       :1934][INFO    ][22470] Completed state [vm.swappiness] at time 08:45:11.841341 duration_in_ms=20.854
2018-06-13 08:45:11,842 [salt.state       :1761][INFO    ][22470] Running state [net.core.netdev_max_backlog] at time 08:45:11.842187
2018-06-13 08:45:11,843 [salt.state       :1794][INFO    ][22470] Executing state sysctl.present for [net.core.netdev_max_backlog]
2018-06-13 08:45:11,844 [salt.loaded.int.module.cmdmod:394 ][INFO    ][22470] Executing command 'sysctl -w net.core.netdev_max_backlog="261144"' in directory '/root'
2018-06-13 08:45:11,862 [salt.state       :290 ][INFO    ][22470] {'net.core.netdev_max_backlog': 261144}
2018-06-13 08:45:11,863 [salt.state       :1934][INFO    ][22470] Completed state [net.core.netdev_max_backlog] at time 08:45:11.862967 duration_in_ms=20.78
2018-06-13 08:45:11,863 [salt.state       :1761][INFO    ][22470] Running state [net.ipv4.neigh.default.gc_thresh1] at time 08:45:11.863824
2018-06-13 08:45:11,864 [salt.state       :1794][INFO    ][22470] Executing state sysctl.present for [net.ipv4.neigh.default.gc_thresh1]
2018-06-13 08:45:11,866 [salt.loaded.int.module.cmdmod:394 ][INFO    ][22470] Executing command 'sysctl -w net.ipv4.neigh.default.gc_thresh1="4096"' in directory '/root'
2018-06-13 08:45:11,883 [salt.state       :290 ][INFO    ][22470] {'net.ipv4.neigh.default.gc_thresh1': 4096}
2018-06-13 08:45:11,884 [salt.state       :1934][INFO    ][22470] Completed state [net.ipv4.neigh.default.gc_thresh1] at time 08:45:11.884806 duration_in_ms=20.982
2018-06-13 08:45:11,885 [salt.state       :1761][INFO    ][22470] Running state [net.ipv4.neigh.default.gc_thresh2] at time 08:45:11.885659
2018-06-13 08:45:11,886 [salt.state       :1794][INFO    ][22470] Executing state sysctl.present for [net.ipv4.neigh.default.gc_thresh2]
2018-06-13 08:45:11,888 [salt.loaded.int.module.cmdmod:394 ][INFO    ][22470] Executing command 'sysctl -w net.ipv4.neigh.default.gc_thresh2="8192"' in directory '/root'
2018-06-13 08:45:11,905 [salt.state       :290 ][INFO    ][22470] {'net.ipv4.neigh.default.gc_thresh2': 8192}
2018-06-13 08:45:11,905 [salt.state       :1934][INFO    ][22470] Completed state [net.ipv4.neigh.default.gc_thresh2] at time 08:45:11.905863 duration_in_ms=20.203
2018-06-13 08:45:11,906 [salt.state       :1761][INFO    ][22470] Running state [net.ipv4.neigh.default.gc_thresh3] at time 08:45:11.906684
2018-06-13 08:45:11,907 [salt.state       :1794][INFO    ][22470] Executing state sysctl.present for [net.ipv4.neigh.default.gc_thresh3]
2018-06-13 08:45:11,909 [salt.loaded.int.module.cmdmod:394 ][INFO    ][22470] Executing command 'sysctl -w net.ipv4.neigh.default.gc_thresh3="16384"' in directory '/root'
2018-06-13 08:45:11,926 [salt.state       :290 ][INFO    ][22470] {'net.ipv4.neigh.default.gc_thresh3': 16384}
2018-06-13 08:45:11,926 [salt.state       :1934][INFO    ][22470] Completed state [net.ipv4.neigh.default.gc_thresh3] at time 08:45:11.926857 duration_in_ms=20.174
2018-06-13 08:45:11,927 [salt.state       :1761][INFO    ][22470] Running state [net.ipv4.tcp_fin_timeout] at time 08:45:11.927613
2018-06-13 08:45:11,928 [salt.state       :1794][INFO    ][22470] Executing state sysctl.present for [net.ipv4.tcp_fin_timeout]
2018-06-13 08:45:11,929 [salt.loaded.int.module.cmdmod:394 ][INFO    ][22470] Executing command 'sysctl -w net.ipv4.tcp_fin_timeout="30"' in directory '/root'
2018-06-13 08:45:11,945 [salt.state       :290 ][INFO    ][22470] {'net.ipv4.tcp_fin_timeout': 30}
2018-06-13 08:45:11,946 [salt.state       :1934][INFO    ][22470] Completed state [net.ipv4.tcp_fin_timeout] at time 08:45:11.946236 duration_in_ms=18.622
2018-06-13 08:45:11,947 [salt.state       :1761][INFO    ][22470] Running state [net.ipv4.tcp_keepalive_time] at time 08:45:11.946982
2018-06-13 08:45:11,947 [salt.state       :1794][INFO    ][22470] Executing state sysctl.present for [net.ipv4.tcp_keepalive_time]
2018-06-13 08:45:11,949 [salt.loaded.int.module.cmdmod:394 ][INFO    ][22470] Executing command 'sysctl -w net.ipv4.tcp_keepalive_time="30"' in directory '/root'
2018-06-13 08:45:11,963 [salt.state       :290 ][INFO    ][22470] {'net.ipv4.tcp_keepalive_time': 30}
2018-06-13 08:45:11,964 [salt.state       :1934][INFO    ][22470] Completed state [net.ipv4.tcp_keepalive_time] at time 08:45:11.964684 duration_in_ms=17.703
2018-06-13 08:45:11,965 [salt.state       :1761][INFO    ][22470] Running state [net.nf_conntrack_max] at time 08:45:11.965393
2018-06-13 08:45:11,966 [salt.state       :1794][INFO    ][22470] Executing state sysctl.present for [net.nf_conntrack_max]
2018-06-13 08:45:11,967 [salt.loaded.int.module.cmdmod:394 ][INFO    ][22470] Executing command 'sysctl -w net.nf_conntrack_max="1048576"' in directory '/root'
2018-06-13 08:45:11,981 [salt.state       :290 ][INFO    ][22470] {'net.nf_conntrack_max': 1048576}
2018-06-13 08:45:11,982 [salt.state       :1934][INFO    ][22470] Completed state [net.nf_conntrack_max] at time 08:45:11.982087 duration_in_ms=16.695
2018-06-13 08:45:11,988 [salt.state       :1761][INFO    ][22470] Running state [linux_sysfs_package] at time 08:45:11.988226
2018-06-13 08:45:11,988 [salt.state       :1794][INFO    ][22470] Executing state pkg.installed for [linux_sysfs_package]
2018-06-13 08:45:12,470 [salt.loaded.int.module.cmdmod:394 ][INFO    ][22470] Executing command ['apt-cache', '-q', 'policy', 'sysfsutils'] in directory '/root'
2018-06-13 08:45:12,639 [salt.loaded.int.module.cmdmod:394 ][INFO    ][22470] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2018-06-13 08:45:14,712 [salt.minion      :1324][INFO    ][22345] User sudo_ubuntu Executing command saltutil.find_job with jid 20180613084514690957
2018-06-13 08:45:14,743 [salt.minion      :1448][INFO    ][24660] Starting a new job with PID 24660
2018-06-13 08:45:14,778 [salt.minion      :1725][INFO    ][24660] Returning information for job: 20180613084514690957
2018-06-13 08:45:15,359 [salt.loaded.int.module.cmdmod:394 ][INFO    ][22470] Executing command ['dpkg', '--get-selections', '*'] in directory '/root'
2018-06-13 08:45:15,384 [salt.loaded.int.module.cmdmod:394 ][INFO    ][22470] 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-06-13 08:45:21,118 [salt.loaded.int.module.cmdmod:394 ][INFO    ][22470] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}', '-W'] in directory '/root'
2018-06-13 08:45:21,189 [salt.state       :290 ][INFO    ][22470] 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-06-13 08:45:21,229 [salt.state       :905 ][INFO    ][22470] Loading fresh modules for state activity
2018-06-13 08:45:21,269 [salt.state       :1934][INFO    ][22470] Completed state [linux_sysfs_package] at time 08:45:21.269697 duration_in_ms=9281.469
2018-06-13 08:45:21,277 [salt.state       :1761][INFO    ][22470] Running state [/etc/sysfs.d] at time 08:45:21.277072
2018-06-13 08:45:21,277 [salt.state       :1794][INFO    ][22470] Executing state file.directory for [/etc/sysfs.d]
2018-06-13 08:45:21,282 [salt.state       :290 ][INFO    ][22470] Directory /etc/sysfs.d is in the correct state
Directory /etc/sysfs.d updated
2018-06-13 08:45:21,283 [salt.state       :1934][INFO    ][22470] Completed state [/etc/sysfs.d] at time 08:45:21.283340 duration_in_ms=6.268
2018-06-13 08:45:21,741 [salt.state       :1761][INFO    ][22470] Running state [ondemand] at time 08:45:21.741259
2018-06-13 08:45:21,741 [salt.state       :1794][INFO    ][22470] Executing state service.dead for [ondemand]
2018-06-13 08:45:21,742 [salt.loaded.int.module.cmdmod:394 ][INFO    ][22470] Executing command ['systemctl', 'status', 'ondemand.service', '-n', '0'] in directory '/root'
2018-06-13 08:45:21,763 [salt.loaded.int.module.cmdmod:394 ][INFO    ][22470] Executing command ['systemctl', 'is-active', 'ondemand.service'] in directory '/root'
2018-06-13 08:45:21,782 [salt.loaded.int.module.cmdmod:394 ][INFO    ][22470] Executing command ['systemctl', 'is-enabled', 'ondemand.service'] in directory '/root'
2018-06-13 08:45:21,804 [salt.loaded.int.module.cmdmod:394 ][INFO    ][22470] Executing command ['systemd-run', '--scope', 'systemctl', 'stop', 'ondemand.service'] in directory '/root'
2018-06-13 08:45:21,871 [salt.loaded.int.module.cmdmod:394 ][INFO    ][22470] Executing command ['systemctl', 'is-active', 'ondemand.service'] in directory '/root'
2018-06-13 08:45:21,893 [salt.loaded.int.module.cmdmod:394 ][INFO    ][22470] Executing command ['systemctl', 'is-enabled', 'ondemand.service'] in directory '/root'
2018-06-13 08:45:21,918 [salt.loaded.int.module.cmdmod:394 ][INFO    ][22470] Executing command ['systemctl', 'is-enabled', 'ondemand.service'] in directory '/root'
2018-06-13 08:45:21,944 [salt.loaded.int.module.cmdmod:394 ][INFO    ][22470] Executing command ['systemd-run', '--scope', '/usr/sbin/update-rc.d', '-f', 'ondemand', 'remove'] in directory '/root'
2018-06-13 08:45:22,124 [salt.loaded.int.module.cmdmod:394 ][INFO    ][22470] Executing command ['systemctl', 'is-enabled', 'ondemand.service'] in directory '/root'
2018-06-13 08:45:22,149 [salt.loaded.int.module.cmdmod:394 ][INFO    ][22470] Executing command 'runlevel' in directory '/root'
2018-06-13 08:45:22,163 [salt.state       :290 ][INFO    ][22470] {'ondemand': True}
2018-06-13 08:45:22,164 [salt.state       :1934][INFO    ][22470] Completed state [ondemand] at time 08:45:22.164362 duration_in_ms=423.103
2018-06-13 08:45:22,175 [salt.state       :1761][INFO    ][22470] Running state [cs_CZ.UTF-8] at time 08:45:22.175299
2018-06-13 08:45:22,175 [salt.state       :1794][INFO    ][22470] Executing state locale.present for [cs_CZ.UTF-8]
2018-06-13 08:45:22,176 [salt.loaded.int.module.cmdmod:394 ][INFO    ][22470] Executing command 'locale -a' in directory '/root'
2018-06-13 08:45:22,196 [salt.loaded.int.module.cmdmod:394 ][INFO    ][22470] Executing command ['locale-gen', 'cs_CZ.utf8'] in directory '/root'
2018-06-13 08:45:23,041 [salt.state       :290 ][INFO    ][22470] {'locale': 'cs_CZ.UTF-8'}
2018-06-13 08:45:23,042 [salt.state       :1934][INFO    ][22470] Completed state [cs_CZ.UTF-8] at time 08:45:23.042661 duration_in_ms=867.361
2018-06-13 08:45:23,043 [salt.state       :1761][INFO    ][22470] Running state [en_US.UTF-8] at time 08:45:23.043359
2018-06-13 08:45:23,044 [salt.state       :1794][INFO    ][22470] Executing state locale.present for [en_US.UTF-8]
2018-06-13 08:45:23,045 [salt.loaded.int.module.cmdmod:394 ][INFO    ][22470] Executing command 'locale -a' in directory '/root'
2018-06-13 08:45:23,058 [salt.state       :290 ][INFO    ][22470] Locale en_US.UTF-8 is already present
2018-06-13 08:45:23,059 [salt.state       :1934][INFO    ][22470] Completed state [en_US.UTF-8] at time 08:45:23.059022 duration_in_ms=15.663
2018-06-13 08:45:23,061 [salt.state       :1761][INFO    ][22470] Running state [en_US.UTF-8] at time 08:45:23.061744
2018-06-13 08:45:23,062 [salt.state       :1794][INFO    ][22470] Executing state locale.system for [en_US.UTF-8]
2018-06-13 08:45:23,063 [salt.loaded.int.module.cmdmod:394 ][INFO    ][22470] Executing command 'localectl' in directory '/root'
2018-06-13 08:45:23,137 [salt.state       :290 ][INFO    ][22470] System locale en_US.UTF-8 already set
2018-06-13 08:45:23,138 [salt.state       :1934][INFO    ][22470] Completed state [en_US.UTF-8] at time 08:45:23.138339 duration_in_ms=76.596
2018-06-13 08:45:23,139 [salt.state       :1761][INFO    ][22470] Running state [root] at time 08:45:23.139673
2018-06-13 08:45:23,140 [salt.state       :1794][INFO    ][22470] Executing state group.present for [root]
2018-06-13 08:45:23,140 [salt.state       :290 ][INFO    ][22470] Group root is present and up to date
2018-06-13 08:45:23,141 [salt.state       :1934][INFO    ][22470] Completed state [root] at time 08:45:23.141095 duration_in_ms=1.422
2018-06-13 08:45:23,144 [salt.state       :1761][INFO    ][22470] Running state [root] at time 08:45:23.144181
2018-06-13 08:45:23,144 [salt.state       :1794][INFO    ][22470] Executing state user.present for [root]
2018-06-13 08:45:23,149 [salt.state       :290 ][INFO    ][22470] User root is present and up to date
2018-06-13 08:45:23,149 [salt.state       :1934][INFO    ][22470] Completed state [root] at time 08:45:23.149832 duration_in_ms=5.65
2018-06-13 08:45:23,151 [salt.state       :1761][INFO    ][22470] Running state [/root] at time 08:45:23.151099
2018-06-13 08:45:23,151 [salt.state       :1794][INFO    ][22470] Executing state file.directory for [/root]
2018-06-13 08:45:23,152 [salt.state       :290 ][INFO    ][22470] Directory /root is in the correct state
Directory /root updated
2018-06-13 08:45:23,152 [salt.state       :1934][INFO    ][22470] Completed state [/root] at time 08:45:23.152760 duration_in_ms=1.66
2018-06-13 08:45:23,153 [salt.state       :1761][INFO    ][22470] Running state [/etc/sudoers.d/90-salt-user-root] at time 08:45:23.153051
2018-06-13 08:45:23,153 [salt.state       :1794][INFO    ][22470] Executing state file.absent for [/etc/sudoers.d/90-salt-user-root]
2018-06-13 08:45:23,153 [salt.state       :290 ][INFO    ][22470] File /etc/sudoers.d/90-salt-user-root is not present
2018-06-13 08:45:23,154 [salt.state       :1934][INFO    ][22470] Completed state [/etc/sudoers.d/90-salt-user-root] at time 08:45:23.154003 duration_in_ms=0.952
2018-06-13 08:45:23,154 [salt.state       :1761][INFO    ][22470] Running state [salt] at time 08:45:23.154294
2018-06-13 08:45:23,154 [salt.state       :1794][INFO    ][22470] Executing state group.present for [salt]
2018-06-13 08:45:23,155 [salt.state       :290 ][INFO    ][22470] Group salt is present and up to date
2018-06-13 08:45:23,155 [salt.state       :1934][INFO    ][22470] Completed state [salt] at time 08:45:23.155277 duration_in_ms=0.982
2018-06-13 08:45:23,156 [salt.state       :1761][INFO    ][22470] Running state [salt] at time 08:45:23.156455
2018-06-13 08:45:23,156 [salt.state       :1794][INFO    ][22470] Executing state user.present for [salt]
2018-06-13 08:45:23,158 [salt.state       :290 ][INFO    ][22470] User salt is present and up to date
2018-06-13 08:45:23,158 [salt.state       :1934][INFO    ][22470] Completed state [salt] at time 08:45:23.158382 duration_in_ms=1.927
2018-06-13 08:45:23,159 [salt.state       :1761][INFO    ][22470] Running state [/var/tmp/salt] at time 08:45:23.159602
2018-06-13 08:45:23,159 [salt.state       :1794][INFO    ][22470] Executing state file.directory for [/var/tmp/salt]
2018-06-13 08:45:23,160 [salt.state       :290 ][INFO    ][22470] Directory /var/tmp/salt is in the correct state
Directory /var/tmp/salt updated
2018-06-13 08:45:23,161 [salt.state       :1934][INFO    ][22470] Completed state [/var/tmp/salt] at time 08:45:23.161157 duration_in_ms=1.556
2018-06-13 08:45:23,161 [salt.state       :1761][INFO    ][22470] Running state [/etc/sudoers.d/90-salt-user-salt] at time 08:45:23.161443
2018-06-13 08:45:23,161 [salt.state       :1794][INFO    ][22470] Executing state file.absent for [/etc/sudoers.d/90-salt-user-salt]
2018-06-13 08:45:23,162 [salt.state       :290 ][INFO    ][22470] File /etc/sudoers.d/90-salt-user-salt is not present
2018-06-13 08:45:23,162 [salt.state       :1934][INFO    ][22470] Completed state [/etc/sudoers.d/90-salt-user-salt] at time 08:45:23.162349 duration_in_ms=0.906
2018-06-13 08:45:23,162 [salt.state       :1761][INFO    ][22470] Running state [ubuntu] at time 08:45:23.162649
2018-06-13 08:45:23,162 [salt.state       :1794][INFO    ][22470] Executing state group.present for [ubuntu]
2018-06-13 08:45:23,163 [salt.state       :290 ][INFO    ][22470] Group ubuntu is present and up to date
2018-06-13 08:45:23,163 [salt.state       :1934][INFO    ][22470] Completed state [ubuntu] at time 08:45:23.163612 duration_in_ms=0.962
2018-06-13 08:45:23,164 [salt.state       :1761][INFO    ][22470] Running state [ubuntu] at time 08:45:23.164736
2018-06-13 08:45:23,165 [salt.state       :1794][INFO    ][22470] Executing state user.present for [ubuntu]
2018-06-13 08:45:23,166 [salt.state       :290 ][INFO    ][22470] User ubuntu is present and up to date
2018-06-13 08:45:23,166 [salt.state       :1934][INFO    ][22470] Completed state [ubuntu] at time 08:45:23.166732 duration_in_ms=1.995
2018-06-13 08:45:23,167 [salt.state       :1761][INFO    ][22470] Running state [/home/ubuntu] at time 08:45:23.167910
2018-06-13 08:45:23,168 [salt.state       :1794][INFO    ][22470] Executing state file.directory for [/home/ubuntu]
2018-06-13 08:45:23,169 [salt.state       :290 ][INFO    ][22470] Directory /home/ubuntu is in the correct state
Directory /home/ubuntu updated
2018-06-13 08:45:23,169 [salt.state       :1934][INFO    ][22470] Completed state [/home/ubuntu] at time 08:45:23.169424 duration_in_ms=1.513
2018-06-13 08:45:23,170 [salt.state       :1761][INFO    ][22470] Running state [/etc/sudoers.d/90-salt-user-ubuntu] at time 08:45:23.170417
2018-06-13 08:45:23,170 [salt.state       :1794][INFO    ][22470] Executing state file.managed for [/etc/sudoers.d/90-salt-user-ubuntu]
2018-06-13 08:45:23,219 [salt.state       :290 ][INFO    ][22470] File /etc/sudoers.d/90-salt-user-ubuntu is in the correct state
2018-06-13 08:45:23,219 [salt.state       :1934][INFO    ][22470] Completed state [/etc/sudoers.d/90-salt-user-ubuntu] at time 08:45:23.219647 duration_in_ms=49.229
2018-06-13 08:45:23,219 [salt.state       :1761][INFO    ][22470] Running state [/etc/security/limits.d/90-salt-default.conf] at time 08:45:23.219932
2018-06-13 08:45:23,220 [salt.state       :1794][INFO    ][22470] Executing state file.managed for [/etc/security/limits.d/90-salt-default.conf]
2018-06-13 08:45:23,274 [salt.fileclient  :1215][INFO    ][22470] Fetching file from saltenv 'base', ** done ** 'linux/files/limits.conf'
2018-06-13 08:45:23,386 [salt.state       :290 ][INFO    ][22470] File changed:
New file
2018-06-13 08:45:23,386 [salt.state       :1934][INFO    ][22470] Completed state [/etc/security/limits.d/90-salt-default.conf] at time 08:45:23.386238 duration_in_ms=166.305
2018-06-13 08:45:23,386 [salt.state       :1761][INFO    ][22470] Running state [/etc/systemd/system.conf.d/90-salt.conf] at time 08:45:23.386488
2018-06-13 08:45:23,386 [salt.state       :1794][INFO    ][22470] Executing state file.managed for [/etc/systemd/system.conf.d/90-salt.conf]
2018-06-13 08:45:23,440 [salt.fileclient  :1215][INFO    ][22470] Fetching file from saltenv 'base', ** done ** 'linux/files/systemd.conf'
2018-06-13 08:45:23,527 [salt.state       :290 ][INFO    ][22470] File changed:
New file
2018-06-13 08:45:23,527 [salt.state       :1934][INFO    ][22470] Completed state [/etc/systemd/system.conf.d/90-salt.conf] at time 08:45:23.527405 duration_in_ms=140.917
2018-06-13 08:45:23,528 [salt.state       :1761][INFO    ][22470] Running state [service.systemctl_reload] at time 08:45:23.528890
2018-06-13 08:45:23,529 [salt.state       :1794][INFO    ][22470] Executing state module.wait for [service.systemctl_reload]
2018-06-13 08:45:23,529 [salt.state       :290 ][INFO    ][22470] No changes made for service.systemctl_reload
2018-06-13 08:45:23,529 [salt.state       :1934][INFO    ][22470] Completed state [service.systemctl_reload] at time 08:45:23.529544 duration_in_ms=0.654
2018-06-13 08:45:23,529 [salt.state       :1761][INFO    ][22470] Running state [service.systemctl_reload] at time 08:45:23.529701
2018-06-13 08:45:23,529 [salt.state       :1794][INFO    ][22470] Executing state module.mod_watch for [service.systemctl_reload]
2018-06-13 08:45:23,530 [salt.utils.decorators:613 ][WARNING ][22470] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2018-06-13 08:45:23,530 [salt.loaded.int.module.cmdmod:394 ][INFO    ][22470] Executing command ['systemctl', '--system', 'daemon-reload'] in directory '/root'
2018-06-13 08:45:23,663 [salt.state       :290 ][INFO    ][22470] {'ret': True}
2018-06-13 08:45:23,664 [salt.state       :1934][INFO    ][22470] Completed state [service.systemctl_reload] at time 08:45:23.664312 duration_in_ms=134.608
2018-06-13 08:45:23,665 [salt.state       :1761][INFO    ][22470] Running state [/etc/issue] at time 08:45:23.665014
2018-06-13 08:45:23,665 [salt.state       :1794][INFO    ][22470] Executing state file.managed for [/etc/issue]
2018-06-13 08:45:23,675 [salt.state       :290 ][INFO    ][22470] File changed:
--- 
+++ 
@@ -1,2 +1,9 @@
-Ubuntu 16.04.4 LTS \n \l
-
+=================================== WARNING ====================================
+You have accessed a computer managed by COMPANY_NAME_HERE.
+You are required to have authorisation from COMPANY_NAME_HERE
+before you proceed and you are strictly limited to use set out within that
+authorisation. Unauthorised access to or misuse of this system is prohibited
+and constitutes an offence under the Computer Misuse Act 1990.
+If you disclose any information obtained through this system without authority
+COMPANY_NAME_HERE may take legal action against you.
+================================================================================

2018-06-13 08:45:23,675 [salt.state       :1934][INFO    ][22470] Completed state [/etc/issue] at time 08:45:23.675603 duration_in_ms=10.589
2018-06-13 08:45:23,676 [salt.state       :1761][INFO    ][22470] Running state [/etc/hostname] at time 08:45:23.676079
2018-06-13 08:45:23,676 [salt.state       :1794][INFO    ][22470] Executing state file.managed for [/etc/hostname]
2018-06-13 08:45:23,755 [salt.fileclient  :1215][INFO    ][22470] Fetching file from saltenv 'base', ** done ** 'linux/files/hostname'
2018-06-13 08:45:23,768 [salt.state       :290 ][INFO    ][22470] File /etc/hostname is in the correct state
2018-06-13 08:45:23,768 [salt.state       :1934][INFO    ][22470] Completed state [/etc/hostname] at time 08:45:23.768401 duration_in_ms=92.322
2018-06-13 08:45:23,771 [salt.state       :1761][INFO    ][22470] Running state [hostname cfg01] at time 08:45:23.771416
2018-06-13 08:45:23,771 [salt.state       :1794][INFO    ][22470] Executing state cmd.wait for [hostname cfg01]
2018-06-13 08:45:23,772 [salt.state       :290 ][INFO    ][22470] No changes made for hostname cfg01
2018-06-13 08:45:23,772 [salt.state       :1934][INFO    ][22470] Completed state [hostname cfg01] at time 08:45:23.772710 duration_in_ms=1.294
2018-06-13 08:45:23,779 [salt.state       :1761][INFO    ][22470] Running state [mdb02] at time 08:45:23.779877
2018-06-13 08:45:23,780 [salt.state       :1794][INFO    ][22470] Executing state host.present for [mdb02]
2018-06-13 08:45:23,781 [salt.state       :290 ][INFO    ][22470] {'host': 'mdb02'}
2018-06-13 08:45:23,782 [salt.state       :1934][INFO    ][22470] Completed state [mdb02] at time 08:45:23.782091 duration_in_ms=2.214
2018-06-13 08:45:23,782 [salt.state       :1761][INFO    ][22470] Running state [mdb02.mcp-odl-ha.local] at time 08:45:23.782509
2018-06-13 08:45:23,782 [salt.state       :1794][INFO    ][22470] Executing state host.present for [mdb02.mcp-odl-ha.local]
2018-06-13 08:45:23,788 [salt.state       :290 ][INFO    ][22470] {'host': 'mdb02.mcp-odl-ha.local'}
2018-06-13 08:45:23,788 [salt.state       :1934][INFO    ][22470] Completed state [mdb02.mcp-odl-ha.local] at time 08:45:23.788704 duration_in_ms=6.195
2018-06-13 08:45:23,789 [salt.state       :1761][INFO    ][22470] Running state [mdb03] at time 08:45:23.789125
2018-06-13 08:45:23,789 [salt.state       :1794][INFO    ][22470] Executing state host.present for [mdb03]
2018-06-13 08:45:23,794 [salt.state       :290 ][INFO    ][22470] {'host': 'mdb03'}
2018-06-13 08:45:23,794 [salt.state       :1934][INFO    ][22470] Completed state [mdb03] at time 08:45:23.794888 duration_in_ms=5.762
2018-06-13 08:45:23,795 [salt.state       :1761][INFO    ][22470] Running state [mdb03.mcp-odl-ha.local] at time 08:45:23.795258
2018-06-13 08:45:23,795 [salt.state       :1794][INFO    ][22470] Executing state host.present for [mdb03.mcp-odl-ha.local]
2018-06-13 08:45:23,800 [salt.state       :290 ][INFO    ][22470] {'host': 'mdb03.mcp-odl-ha.local'}
2018-06-13 08:45:23,800 [salt.state       :1934][INFO    ][22470] Completed state [mdb03.mcp-odl-ha.local] at time 08:45:23.800697 duration_in_ms=5.438
2018-06-13 08:45:23,801 [salt.state       :1761][INFO    ][22470] Running state [mdb01] at time 08:45:23.801070
2018-06-13 08:45:23,801 [salt.state       :1794][INFO    ][22470] Executing state host.present for [mdb01]
2018-06-13 08:45:23,806 [salt.state       :290 ][INFO    ][22470] {'host': 'mdb01'}
2018-06-13 08:45:23,807 [salt.state       :1934][INFO    ][22470] Completed state [mdb01] at time 08:45:23.806939 duration_in_ms=5.868
2018-06-13 08:45:23,807 [salt.state       :1761][INFO    ][22470] Running state [mdb01.mcp-odl-ha.local] at time 08:45:23.807330
2018-06-13 08:45:23,807 [salt.state       :1794][INFO    ][22470] Executing state host.present for [mdb01.mcp-odl-ha.local]
2018-06-13 08:45:23,812 [salt.state       :290 ][INFO    ][22470] {'host': 'mdb01.mcp-odl-ha.local'}
2018-06-13 08:45:23,812 [salt.state       :1934][INFO    ][22470] Completed state [mdb01.mcp-odl-ha.local] at time 08:45:23.812838 duration_in_ms=5.507
2018-06-13 08:45:23,813 [salt.state       :1761][INFO    ][22470] Running state [mdb] at time 08:45:23.813209
2018-06-13 08:45:23,813 [salt.state       :1794][INFO    ][22470] Executing state host.present for [mdb]
2018-06-13 08:45:23,818 [salt.state       :290 ][INFO    ][22470] {'host': 'mdb'}
2018-06-13 08:45:23,819 [salt.state       :1934][INFO    ][22470] Completed state [mdb] at time 08:45:23.818959 duration_in_ms=5.75
2018-06-13 08:45:23,819 [salt.state       :1761][INFO    ][22470] Running state [mdb.mcp-odl-ha.local] at time 08:45:23.819347
2018-06-13 08:45:23,819 [salt.state       :1794][INFO    ][22470] Executing state host.present for [mdb.mcp-odl-ha.local]
2018-06-13 08:45:23,824 [salt.state       :290 ][INFO    ][22470] {'host': 'mdb.mcp-odl-ha.local'}
2018-06-13 08:45:23,824 [salt.state       :1934][INFO    ][22470] Completed state [mdb.mcp-odl-ha.local] at time 08:45:23.824841 duration_in_ms=5.494
2018-06-13 08:45:23,825 [salt.state       :1761][INFO    ][22470] Running state [cfg01] at time 08:45:23.825218
2018-06-13 08:45:23,825 [salt.state       :1794][INFO    ][22470] Executing state host.present for [cfg01]
2018-06-13 08:45:23,830 [salt.state       :290 ][INFO    ][22470] {'host': 'cfg01'}
2018-06-13 08:45:23,830 [salt.state       :1934][INFO    ][22470] Completed state [cfg01] at time 08:45:23.830881 duration_in_ms=5.663
2018-06-13 08:45:23,831 [salt.state       :1761][INFO    ][22470] Running state [cfg01.mcp-odl-ha.local] at time 08:45:23.831255
2018-06-13 08:45:23,831 [salt.state       :1794][INFO    ][22470] Executing state host.present for [cfg01.mcp-odl-ha.local]
2018-06-13 08:45:23,836 [salt.state       :290 ][INFO    ][22470] {'host': 'cfg01.mcp-odl-ha.local'}
2018-06-13 08:45:23,836 [salt.state       :1934][INFO    ][22470] Completed state [cfg01.mcp-odl-ha.local] at time 08:45:23.836799 duration_in_ms=5.543
2018-06-13 08:45:23,837 [salt.state       :1761][INFO    ][22470] Running state [prx01] at time 08:45:23.837171
2018-06-13 08:45:23,837 [salt.state       :1794][INFO    ][22470] Executing state host.present for [prx01]
2018-06-13 08:45:23,842 [salt.state       :290 ][INFO    ][22470] {'host': 'prx01'}
2018-06-13 08:45:23,842 [salt.state       :1934][INFO    ][22470] Completed state [prx01] at time 08:45:23.842908 duration_in_ms=5.738
2018-06-13 08:45:23,843 [salt.state       :1761][INFO    ][22470] Running state [prx01.mcp-odl-ha.local] at time 08:45:23.843282
2018-06-13 08:45:23,843 [salt.state       :1794][INFO    ][22470] Executing state host.present for [prx01.mcp-odl-ha.local]
2018-06-13 08:45:23,848 [salt.state       :290 ][INFO    ][22470] {'host': 'prx01.mcp-odl-ha.local'}
2018-06-13 08:45:23,848 [salt.state       :1934][INFO    ][22470] Completed state [prx01.mcp-odl-ha.local] at time 08:45:23.848874 duration_in_ms=5.592
2018-06-13 08:45:23,849 [salt.state       :1761][INFO    ][22470] Running state [kvm01] at time 08:45:23.849249
2018-06-13 08:45:23,849 [salt.state       :1794][INFO    ][22470] Executing state host.present for [kvm01]
2018-06-13 08:45:23,854 [salt.state       :290 ][INFO    ][22470] {'host': 'kvm01'}
2018-06-13 08:45:23,854 [salt.state       :1934][INFO    ][22470] Completed state [kvm01] at time 08:45:23.854926 duration_in_ms=5.676
2018-06-13 08:45:23,855 [salt.state       :1761][INFO    ][22470] Running state [kvm01.mcp-odl-ha.local] at time 08:45:23.855305
2018-06-13 08:45:23,855 [salt.state       :1794][INFO    ][22470] Executing state host.present for [kvm01.mcp-odl-ha.local]
2018-06-13 08:45:23,860 [salt.state       :290 ][INFO    ][22470] {'host': 'kvm01.mcp-odl-ha.local'}
2018-06-13 08:45:23,860 [salt.state       :1934][INFO    ][22470] Completed state [kvm01.mcp-odl-ha.local] at time 08:45:23.860888 duration_in_ms=5.583
2018-06-13 08:45:23,861 [salt.state       :1761][INFO    ][22470] Running state [kvm03] at time 08:45:23.861263
2018-06-13 08:45:23,861 [salt.state       :1794][INFO    ][22470] Executing state host.present for [kvm03]
2018-06-13 08:45:23,866 [salt.state       :290 ][INFO    ][22470] {'host': 'kvm03'}
2018-06-13 08:45:23,867 [salt.state       :1934][INFO    ][22470] Completed state [kvm03] at time 08:45:23.866951 duration_in_ms=5.688
2018-06-13 08:45:23,867 [salt.state       :1761][INFO    ][22470] Running state [kvm03.mcp-odl-ha.local] at time 08:45:23.867331
2018-06-13 08:45:23,867 [salt.state       :1794][INFO    ][22470] Executing state host.present for [kvm03.mcp-odl-ha.local]
2018-06-13 08:45:23,872 [salt.state       :290 ][INFO    ][22470] {'host': 'kvm03.mcp-odl-ha.local'}
2018-06-13 08:45:23,873 [salt.state       :1934][INFO    ][22470] Completed state [kvm03.mcp-odl-ha.local] at time 08:45:23.873018 duration_in_ms=5.687
2018-06-13 08:45:23,873 [salt.state       :1761][INFO    ][22470] Running state [kvm02] at time 08:45:23.873398
2018-06-13 08:45:23,873 [salt.state       :1794][INFO    ][22470] Executing state host.present for [kvm02]
2018-06-13 08:45:23,878 [salt.state       :290 ][INFO    ][22470] {'host': 'kvm02'}
2018-06-13 08:45:23,879 [salt.state       :1934][INFO    ][22470] Completed state [kvm02] at time 08:45:23.878992 duration_in_ms=5.593
2018-06-13 08:45:23,879 [salt.state       :1761][INFO    ][22470] Running state [kvm02.mcp-odl-ha.local] at time 08:45:23.879370
2018-06-13 08:45:23,879 [salt.state       :1794][INFO    ][22470] Executing state host.present for [kvm02.mcp-odl-ha.local]
2018-06-13 08:45:23,884 [salt.state       :290 ][INFO    ][22470] {'host': 'kvm02.mcp-odl-ha.local'}
2018-06-13 08:45:23,884 [salt.state       :1934][INFO    ][22470] Completed state [kvm02.mcp-odl-ha.local] at time 08:45:23.884574 duration_in_ms=5.204
2018-06-13 08:45:23,885 [salt.state       :1761][INFO    ][22470] Running state [dbs] at time 08:45:23.884960
2018-06-13 08:45:23,885 [salt.state       :1794][INFO    ][22470] Executing state host.present for [dbs]
2018-06-13 08:45:23,890 [salt.state       :290 ][INFO    ][22470] {'host': 'dbs'}
2018-06-13 08:45:23,890 [salt.state       :1934][INFO    ][22470] Completed state [dbs] at time 08:45:23.890460 duration_in_ms=5.5
2018-06-13 08:45:23,890 [salt.state       :1761][INFO    ][22470] Running state [dbs.mcp-odl-ha.local] at time 08:45:23.890864
2018-06-13 08:45:23,891 [salt.state       :1794][INFO    ][22470] Executing state host.present for [dbs.mcp-odl-ha.local]
2018-06-13 08:45:23,896 [salt.state       :290 ][INFO    ][22470] {'host': 'dbs.mcp-odl-ha.local'}
2018-06-13 08:45:23,896 [salt.state       :1934][INFO    ][22470] Completed state [dbs.mcp-odl-ha.local] at time 08:45:23.896552 duration_in_ms=5.687
2018-06-13 08:45:23,897 [salt.state       :1761][INFO    ][22470] Running state [prx] at time 08:45:23.896943
2018-06-13 08:45:23,897 [salt.state       :1794][INFO    ][22470] Executing state host.present for [prx]
2018-06-13 08:45:23,902 [salt.state       :290 ][INFO    ][22470] {'host': 'prx'}
2018-06-13 08:45:23,902 [salt.state       :1934][INFO    ][22470] Completed state [prx] at time 08:45:23.902627 duration_in_ms=5.683
2018-06-13 08:45:23,903 [salt.state       :1761][INFO    ][22470] Running state [prx.mcp-odl-ha.local] at time 08:45:23.903015
2018-06-13 08:45:23,903 [salt.state       :1794][INFO    ][22470] Executing state host.present for [prx.mcp-odl-ha.local]
2018-06-13 08:45:23,908 [salt.state       :290 ][INFO    ][22470] {'host': 'prx.mcp-odl-ha.local'}
2018-06-13 08:45:23,908 [salt.state       :1934][INFO    ][22470] Completed state [prx.mcp-odl-ha.local] at time 08:45:23.908581 duration_in_ms=5.566
2018-06-13 08:45:23,909 [salt.state       :1761][INFO    ][22470] Running state [prx02] at time 08:45:23.908968
2018-06-13 08:45:23,909 [salt.state       :1794][INFO    ][22470] Executing state host.present for [prx02]
2018-06-13 08:45:23,914 [salt.state       :290 ][INFO    ][22470] {'host': 'prx02'}
2018-06-13 08:45:23,914 [salt.state       :1934][INFO    ][22470] Completed state [prx02] at time 08:45:23.914630 duration_in_ms=5.663
2018-06-13 08:45:23,915 [salt.state       :1761][INFO    ][22470] Running state [prx02.mcp-odl-ha.local] at time 08:45:23.915012
2018-06-13 08:45:23,915 [salt.state       :1794][INFO    ][22470] Executing state host.present for [prx02.mcp-odl-ha.local]
2018-06-13 08:45:23,920 [salt.state       :290 ][INFO    ][22470] {'host': 'prx02.mcp-odl-ha.local'}
2018-06-13 08:45:23,920 [salt.state       :1934][INFO    ][22470] Completed state [prx02.mcp-odl-ha.local] at time 08:45:23.920648 duration_in_ms=5.636
2018-06-13 08:45:23,921 [salt.state       :1761][INFO    ][22470] Running state [msg02] at time 08:45:23.921031
2018-06-13 08:45:23,921 [salt.state       :1794][INFO    ][22470] Executing state host.present for [msg02]
2018-06-13 08:45:23,926 [salt.state       :290 ][INFO    ][22470] {'host': 'msg02'}
2018-06-13 08:45:23,926 [salt.state       :1934][INFO    ][22470] Completed state [msg02] at time 08:45:23.926598 duration_in_ms=5.566
2018-06-13 08:45:23,927 [salt.state       :1761][INFO    ][22470] Running state [msg02.mcp-odl-ha.local] at time 08:45:23.926983
2018-06-13 08:45:23,927 [salt.state       :1794][INFO    ][22470] Executing state host.present for [msg02.mcp-odl-ha.local]
2018-06-13 08:45:23,932 [salt.state       :290 ][INFO    ][22470] {'host': 'msg02.mcp-odl-ha.local'}
2018-06-13 08:45:23,932 [salt.state       :1934][INFO    ][22470] Completed state [msg02.mcp-odl-ha.local] at time 08:45:23.932599 duration_in_ms=5.616
2018-06-13 08:45:23,933 [salt.state       :1761][INFO    ][22470] Running state [msg03] at time 08:45:23.932985
2018-06-13 08:45:23,933 [salt.state       :1794][INFO    ][22470] Executing state host.present for [msg03]
2018-06-13 08:45:23,938 [salt.state       :290 ][INFO    ][22470] {'host': 'msg03'}
2018-06-13 08:45:23,938 [salt.state       :1934][INFO    ][22470] Completed state [msg03] at time 08:45:23.938719 duration_in_ms=5.734
2018-06-13 08:45:23,939 [salt.state       :1761][INFO    ][22470] Running state [msg03.mcp-odl-ha.local] at time 08:45:23.939105
2018-06-13 08:45:23,939 [salt.state       :1794][INFO    ][22470] Executing state host.present for [msg03.mcp-odl-ha.local]
2018-06-13 08:45:23,944 [salt.state       :290 ][INFO    ][22470] {'host': 'msg03.mcp-odl-ha.local'}
2018-06-13 08:45:23,944 [salt.state       :1934][INFO    ][22470] Completed state [msg03.mcp-odl-ha.local] at time 08:45:23.944750 duration_in_ms=5.645
2018-06-13 08:45:23,945 [salt.state       :1761][INFO    ][22470] Running state [msg01] at time 08:45:23.945157
2018-06-13 08:45:23,945 [salt.state       :1794][INFO    ][22470] Executing state host.present for [msg01]
2018-06-13 08:45:23,950 [salt.state       :290 ][INFO    ][22470] {'host': 'msg01'}
2018-06-13 08:45:23,950 [salt.state       :1934][INFO    ][22470] Completed state [msg01] at time 08:45:23.950744 duration_in_ms=5.587
2018-06-13 08:45:23,951 [salt.state       :1761][INFO    ][22470] Running state [msg01.mcp-odl-ha.local] at time 08:45:23.951149
2018-06-13 08:45:23,951 [salt.state       :1794][INFO    ][22470] Executing state host.present for [msg01.mcp-odl-ha.local]
2018-06-13 08:45:23,956 [salt.state       :290 ][INFO    ][22470] {'host': 'msg01.mcp-odl-ha.local'}
2018-06-13 08:45:23,956 [salt.state       :1934][INFO    ][22470] Completed state [msg01.mcp-odl-ha.local] at time 08:45:23.956714 duration_in_ms=5.565
2018-06-13 08:45:23,957 [salt.state       :1761][INFO    ][22470] Running state [msg] at time 08:45:23.957113
2018-06-13 08:45:23,957 [salt.state       :1794][INFO    ][22470] Executing state host.present for [msg]
2018-06-13 08:45:23,962 [salt.state       :290 ][INFO    ][22470] {'host': 'msg'}
2018-06-13 08:45:23,962 [salt.state       :1934][INFO    ][22470] Completed state [msg] at time 08:45:23.962675 duration_in_ms=5.562
2018-06-13 08:45:23,963 [salt.state       :1761][INFO    ][22470] Running state [msg.mcp-odl-ha.local] at time 08:45:23.963075
2018-06-13 08:45:23,963 [salt.state       :1794][INFO    ][22470] Executing state host.present for [msg.mcp-odl-ha.local]
2018-06-13 08:45:23,968 [salt.state       :290 ][INFO    ][22470] {'host': 'msg.mcp-odl-ha.local'}
2018-06-13 08:45:23,968 [salt.state       :1934][INFO    ][22470] Completed state [msg.mcp-odl-ha.local] at time 08:45:23.968700 duration_in_ms=5.625
2018-06-13 08:45:23,969 [salt.state       :1761][INFO    ][22470] Running state [cfg01] at time 08:45:23.969104
2018-06-13 08:45:23,969 [salt.state       :1794][INFO    ][22470] Executing state host.present for [cfg01]
2018-06-13 08:45:23,970 [salt.state       :290 ][INFO    ][22470] Host cfg01 (10.167.4.11) already present
2018-06-13 08:45:23,970 [salt.state       :1934][INFO    ][22470] Completed state [cfg01] at time 08:45:23.970518 duration_in_ms=1.413
2018-06-13 08:45:23,970 [salt.state       :1761][INFO    ][22470] Running state [cfg01.mcp-odl-ha.local] at time 08:45:23.970915
2018-06-13 08:45:23,971 [salt.state       :1794][INFO    ][22470] Executing state host.present for [cfg01.mcp-odl-ha.local]
2018-06-13 08:45:23,972 [salt.state       :290 ][INFO    ][22470] Host cfg01.mcp-odl-ha.local (10.167.4.11) already present
2018-06-13 08:45:23,972 [salt.state       :1934][INFO    ][22470] Completed state [cfg01.mcp-odl-ha.local] at time 08:45:23.972332 duration_in_ms=1.417
2018-06-13 08:45:23,972 [salt.state       :1761][INFO    ][22470] Running state [cmp002] at time 08:45:23.972753
2018-06-13 08:45:23,973 [salt.state       :1794][INFO    ][22470] Executing state host.present for [cmp002]
2018-06-13 08:45:23,974 [salt.state       :290 ][INFO    ][22470] {'host': 'cmp002'}
2018-06-13 08:45:23,975 [salt.state       :1934][INFO    ][22470] Completed state [cmp002] at time 08:45:23.974938 duration_in_ms=2.185
2018-06-13 08:45:23,975 [salt.state       :1761][INFO    ][22470] Running state [cmp002.mcp-odl-ha.local] at time 08:45:23.975334
2018-06-13 08:45:23,975 [salt.state       :1794][INFO    ][22470] Executing state host.present for [cmp002.mcp-odl-ha.local]
2018-06-13 08:45:23,980 [salt.state       :290 ][INFO    ][22470] {'host': 'cmp002.mcp-odl-ha.local'}
2018-06-13 08:45:23,980 [salt.state       :1934][INFO    ][22470] Completed state [cmp002.mcp-odl-ha.local] at time 08:45:23.980770 duration_in_ms=5.435
2018-06-13 08:45:23,981 [salt.state       :1761][INFO    ][22470] Running state [cmp001] at time 08:45:23.981172
2018-06-13 08:45:23,981 [salt.state       :1794][INFO    ][22470] Executing state host.present for [cmp001]
2018-06-13 08:45:23,986 [salt.state       :290 ][INFO    ][22470] {'host': 'cmp001'}
2018-06-13 08:45:23,986 [salt.state       :1934][INFO    ][22470] Completed state [cmp001] at time 08:45:23.986900 duration_in_ms=5.729
2018-06-13 08:45:23,987 [salt.state       :1761][INFO    ][22470] Running state [cmp001.mcp-odl-ha.local] at time 08:45:23.987306
2018-06-13 08:45:23,987 [salt.state       :1794][INFO    ][22470] Executing state host.present for [cmp001.mcp-odl-ha.local]
2018-06-13 08:45:23,992 [salt.state       :290 ][INFO    ][22470] {'host': 'cmp001.mcp-odl-ha.local'}
2018-06-13 08:45:23,992 [salt.state       :1934][INFO    ][22470] Completed state [cmp001.mcp-odl-ha.local] at time 08:45:23.992844 duration_in_ms=5.538
2018-06-13 08:45:23,993 [salt.state       :1761][INFO    ][22470] Running state [dbs01] at time 08:45:23.993245
2018-06-13 08:45:23,993 [salt.state       :1794][INFO    ][22470] Executing state host.present for [dbs01]
2018-06-13 08:45:23,998 [salt.state       :290 ][INFO    ][22470] {'host': 'dbs01'}
2018-06-13 08:45:23,998 [salt.state       :1934][INFO    ][22470] Completed state [dbs01] at time 08:45:23.998862 duration_in_ms=5.618
2018-06-13 08:45:23,999 [salt.state       :1761][INFO    ][22470] Running state [dbs01.mcp-odl-ha.local] at time 08:45:23.999269
2018-06-13 08:45:23,999 [salt.state       :1794][INFO    ][22470] Executing state host.present for [dbs01.mcp-odl-ha.local]
2018-06-13 08:45:24,004 [salt.state       :290 ][INFO    ][22470] {'host': 'dbs01.mcp-odl-ha.local'}
2018-06-13 08:45:24,004 [salt.state       :1934][INFO    ][22470] Completed state [dbs01.mcp-odl-ha.local] at time 08:45:24.004894 duration_in_ms=5.625
2018-06-13 08:45:24,005 [salt.state       :1761][INFO    ][22470] Running state [dbs02] at time 08:45:24.005294
2018-06-13 08:45:24,005 [salt.state       :1794][INFO    ][22470] Executing state host.present for [dbs02]
2018-06-13 08:45:24,010 [salt.state       :290 ][INFO    ][22470] {'host': 'dbs02'}
2018-06-13 08:45:24,011 [salt.state       :1934][INFO    ][22470] Completed state [dbs02] at time 08:45:24.010956 duration_in_ms=5.663
2018-06-13 08:45:24,011 [salt.state       :1761][INFO    ][22470] Running state [dbs02.mcp-odl-ha.local] at time 08:45:24.011365
2018-06-13 08:45:24,011 [salt.state       :1794][INFO    ][22470] Executing state host.present for [dbs02.mcp-odl-ha.local]
2018-06-13 08:45:24,016 [salt.state       :290 ][INFO    ][22470] {'host': 'dbs02.mcp-odl-ha.local'}
2018-06-13 08:45:24,016 [salt.state       :1934][INFO    ][22470] Completed state [dbs02.mcp-odl-ha.local] at time 08:45:24.016859 duration_in_ms=5.494
2018-06-13 08:45:24,017 [salt.state       :1761][INFO    ][22470] Running state [dbs03] at time 08:45:24.017267
2018-06-13 08:45:24,017 [salt.state       :1794][INFO    ][22470] Executing state host.present for [dbs03]
2018-06-13 08:45:24,022 [salt.state       :290 ][INFO    ][22470] {'host': 'dbs03'}
2018-06-13 08:45:24,023 [salt.state       :1934][INFO    ][22470] Completed state [dbs03] at time 08:45:24.022964 duration_in_ms=5.697
2018-06-13 08:45:24,023 [salt.state       :1761][INFO    ][22470] Running state [dbs03.mcp-odl-ha.local] at time 08:45:24.023368
2018-06-13 08:45:24,023 [salt.state       :1794][INFO    ][22470] Executing state host.present for [dbs03.mcp-odl-ha.local]
2018-06-13 08:45:24,028 [salt.state       :290 ][INFO    ][22470] {'host': 'dbs03.mcp-odl-ha.local'}
2018-06-13 08:45:24,028 [salt.state       :1934][INFO    ][22470] Completed state [dbs03.mcp-odl-ha.local] at time 08:45:24.028881 duration_in_ms=5.513
2018-06-13 08:45:24,029 [salt.state       :1761][INFO    ][22470] Running state [odl01] at time 08:45:24.029280
2018-06-13 08:45:24,029 [salt.state       :1794][INFO    ][22470] Executing state host.present for [odl01]
2018-06-13 08:45:24,034 [salt.state       :290 ][INFO    ][22470] {'host': 'odl01'}
2018-06-13 08:45:24,035 [salt.state       :1934][INFO    ][22470] Completed state [odl01] at time 08:45:24.034992 duration_in_ms=5.711
2018-06-13 08:45:24,035 [salt.state       :1761][INFO    ][22470] Running state [odl01.mcp-odl-ha.local] at time 08:45:24.035398
2018-06-13 08:45:24,035 [salt.state       :1794][INFO    ][22470] Executing state host.present for [odl01.mcp-odl-ha.local]
2018-06-13 08:45:24,040 [salt.state       :290 ][INFO    ][22470] {'host': 'odl01.mcp-odl-ha.local'}
2018-06-13 08:45:24,040 [salt.state       :1934][INFO    ][22470] Completed state [odl01.mcp-odl-ha.local] at time 08:45:24.040916 duration_in_ms=5.517
2018-06-13 08:45:24,041 [salt.state       :1761][INFO    ][22470] Running state [mas01] at time 08:45:24.041322
2018-06-13 08:45:24,041 [salt.state       :1794][INFO    ][22470] Executing state host.present for [mas01]
2018-06-13 08:45:24,046 [salt.state       :290 ][INFO    ][22470] {'host': 'mas01'}
2018-06-13 08:45:24,047 [salt.state       :1934][INFO    ][22470] Completed state [mas01] at time 08:45:24.047056 duration_in_ms=5.735
2018-06-13 08:45:24,047 [salt.state       :1761][INFO    ][22470] Running state [mas01.mcp-odl-ha.local] at time 08:45:24.047464
2018-06-13 08:45:24,047 [salt.state       :1794][INFO    ][22470] Executing state host.present for [mas01.mcp-odl-ha.local]
2018-06-13 08:45:24,052 [salt.state       :290 ][INFO    ][22470] {'host': 'mas01.mcp-odl-ha.local'}
2018-06-13 08:45:24,053 [salt.state       :1934][INFO    ][22470] Completed state [mas01.mcp-odl-ha.local] at time 08:45:24.052938 duration_in_ms=5.474
2018-06-13 08:45:24,053 [salt.state       :1761][INFO    ][22470] Running state [ctl02] at time 08:45:24.053343
2018-06-13 08:45:24,053 [salt.state       :1794][INFO    ][22470] Executing state host.present for [ctl02]
2018-06-13 08:45:24,058 [salt.state       :290 ][INFO    ][22470] {'host': 'ctl02'}
2018-06-13 08:45:24,059 [salt.state       :1934][INFO    ][22470] Completed state [ctl02] at time 08:45:24.059083 duration_in_ms=5.739
2018-06-13 08:45:24,059 [salt.state       :1761][INFO    ][22470] Running state [ctl02.mcp-odl-ha.local] at time 08:45:24.059513
2018-06-13 08:45:24,059 [salt.state       :1794][INFO    ][22470] Executing state host.present for [ctl02.mcp-odl-ha.local]
2018-06-13 08:45:24,064 [salt.state       :290 ][INFO    ][22470] {'host': 'ctl02.mcp-odl-ha.local'}
2018-06-13 08:45:24,065 [salt.state       :1934][INFO    ][22470] Completed state [ctl02.mcp-odl-ha.local] at time 08:45:24.064991 duration_in_ms=5.478
2018-06-13 08:45:24,065 [salt.state       :1761][INFO    ][22470] Running state [ctl03] at time 08:45:24.065397
2018-06-13 08:45:24,065 [salt.state       :1794][INFO    ][22470] Executing state host.present for [ctl03]
2018-06-13 08:45:24,070 [salt.state       :290 ][INFO    ][22470] {'host': 'ctl03'}
2018-06-13 08:45:24,071 [salt.state       :1934][INFO    ][22470] Completed state [ctl03] at time 08:45:24.071075 duration_in_ms=5.677
2018-06-13 08:45:24,071 [salt.state       :1761][INFO    ][22470] Running state [ctl03.mcp-odl-ha.local] at time 08:45:24.071484
2018-06-13 08:45:24,071 [salt.state       :1794][INFO    ][22470] Executing state host.present for [ctl03.mcp-odl-ha.local]
2018-06-13 08:45:24,076 [salt.state       :290 ][INFO    ][22470] {'host': 'ctl03.mcp-odl-ha.local'}
2018-06-13 08:45:24,076 [salt.state       :1934][INFO    ][22470] Completed state [ctl03.mcp-odl-ha.local] at time 08:45:24.076659 duration_in_ms=5.174
2018-06-13 08:45:24,077 [salt.state       :1761][INFO    ][22470] Running state [ctl01] at time 08:45:24.077066
2018-06-13 08:45:24,077 [salt.state       :1794][INFO    ][22470] Executing state host.present for [ctl01]
2018-06-13 08:45:24,082 [salt.state       :290 ][INFO    ][22470] {'host': 'ctl01'}
2018-06-13 08:45:24,082 [salt.state       :1934][INFO    ][22470] Completed state [ctl01] at time 08:45:24.082567 duration_in_ms=5.501
2018-06-13 08:45:24,083 [salt.state       :1761][INFO    ][22470] Running state [ctl01.mcp-odl-ha.local] at time 08:45:24.082989
2018-06-13 08:45:24,083 [salt.state       :1794][INFO    ][22470] Executing state host.present for [ctl01.mcp-odl-ha.local]
2018-06-13 08:45:24,088 [salt.state       :290 ][INFO    ][22470] {'host': 'ctl01.mcp-odl-ha.local'}
2018-06-13 08:45:24,088 [salt.state       :1934][INFO    ][22470] Completed state [ctl01.mcp-odl-ha.local] at time 08:45:24.088601 duration_in_ms=5.613
2018-06-13 08:45:24,089 [salt.state       :1761][INFO    ][22470] Running state [ctl] at time 08:45:24.089011
2018-06-13 08:45:24,089 [salt.state       :1794][INFO    ][22470] Executing state host.present for [ctl]
2018-06-13 08:45:24,094 [salt.state       :290 ][INFO    ][22470] {'host': 'ctl'}
2018-06-13 08:45:24,094 [salt.state       :1934][INFO    ][22470] Completed state [ctl] at time 08:45:24.094645 duration_in_ms=5.633
2018-06-13 08:45:24,095 [salt.state       :1761][INFO    ][22470] Running state [ctl.mcp-odl-ha.local] at time 08:45:24.095065
2018-06-13 08:45:24,095 [salt.state       :1794][INFO    ][22470] Executing state host.present for [ctl.mcp-odl-ha.local]
2018-06-13 08:45:24,100 [salt.state       :290 ][INFO    ][22470] {'host': 'ctl.mcp-odl-ha.local'}
2018-06-13 08:45:24,100 [salt.state       :1934][INFO    ][22470] Completed state [ctl.mcp-odl-ha.local] at time 08:45:24.100673 duration_in_ms=5.608
2018-06-13 08:45:24,101 [salt.state       :1761][INFO    ][22470] Running state [/etc/network/interfaces.d/50-cloud-init.cfg] at time 08:45:24.101019
2018-06-13 08:45:24,101 [salt.state       :1794][INFO    ][22470] Executing state file.absent for [/etc/network/interfaces.d/50-cloud-init.cfg]
2018-06-13 08:45:24,101 [salt.state       :290 ][INFO    ][22470] {'removed': '/etc/network/interfaces.d/50-cloud-init.cfg'}
2018-06-13 08:45:24,102 [salt.state       :1934][INFO    ][22470] Completed state [/etc/network/interfaces.d/50-cloud-init.cfg] at time 08:45:24.102250 duration_in_ms=1.23
2018-06-13 08:45:24,108 [salt.state       :1761][INFO    ][22470] Running state [ens3] at time 08:45:24.108894
2018-06-13 08:45:24,109 [salt.state       :1794][INFO    ][22470] Executing state network.managed for [ens3]
2018-06-13 08:45:24,262 [salt.loaded.int.module.cmdmod:394 ][INFO    ][22470] Executing command ['ifdown', 'ens3'] in directory '/root'
2018-06-13 08:45:24,791 [salt.minion      :1324][INFO    ][22345] User sudo_ubuntu Executing command saltutil.find_job with jid 20180613084524768646
2018-06-13 08:45:24,813 [salt.minion      :1448][INFO    ][25312] Starting a new job with PID 25312
2018-06-13 08:45:24,840 [salt.minion      :1725][INFO    ][25312] Returning information for job: 20180613084524768646
2018-06-13 08:45:25,480 [salt.loaded.int.module.cmdmod:394 ][INFO    ][22470] Executing command ['ifup', 'ens3'] in directory '/root'
2018-06-13 08:45:25,744 [salt.state       :290 ][INFO    ][22470] {'interface': 'Added network interface.', 'status': 'Interface ens3 restart to validate'}
2018-06-13 08:45:25,745 [salt.state       :1934][INFO    ][22470] Completed state [ens3] at time 08:45:25.745387 duration_in_ms=1636.491
2018-06-13 08:45:25,746 [salt.state       :1761][INFO    ][22470] Running state [ens4] at time 08:45:25.746213
2018-06-13 08:45:25,746 [salt.state       :1794][INFO    ][22470] Executing state network.managed for [ens4]
2018-06-13 08:45:25,788 [salt.loaded.int.module.cmdmod:394 ][INFO    ][22470] Executing command ['ifup', 'ens4'] in directory '/root'
2018-06-13 08:45:26,574 [salt.state       :290 ][INFO    ][22470] {'interface': 'Added network interface.', 'status': 'Interface ens4 is up'}
2018-06-13 08:45:26,574 [salt.state       :1934][INFO    ][22470] Completed state [ens4] at time 08:45:26.574736 duration_in_ms=828.524
2018-06-13 08:45:26,574 [salt.state       :1761][INFO    ][22470] Running state [ens5] at time 08:45:26.574960
2018-06-13 08:45:26,575 [salt.state       :1794][INFO    ][22470] Executing state network.managed for [ens5]
2018-06-13 08:45:26,605 [salt.loaded.int.module.cmdmod:394 ][INFO    ][22470] Executing command ['ifup', 'ens5'] in directory '/root'
2018-06-13 08:45:27,174 [salt.state       :290 ][INFO    ][22470] {'interface': 'Added network interface.', 'status': 'Interface ens5 is up'}
2018-06-13 08:45:27,174 [salt.state       :1934][INFO    ][22470] Completed state [ens5] at time 08:45:27.174409 duration_in_ms=599.447
2018-06-13 08:45:27,174 [salt.state       :1761][INFO    ][22470] Running state [/etc/profile.d/proxy.sh] at time 08:45:27.174655
2018-06-13 08:45:27,174 [salt.state       :1794][INFO    ][22470] Executing state file.absent for [/etc/profile.d/proxy.sh]
2018-06-13 08:45:27,175 [salt.state       :290 ][INFO    ][22470] File /etc/profile.d/proxy.sh is not present
2018-06-13 08:45:27,175 [salt.state       :1934][INFO    ][22470] Completed state [/etc/profile.d/proxy.sh] at time 08:45:27.175394 duration_in_ms=0.739
2018-06-13 08:45:27,175 [salt.state       :1761][INFO    ][22470] Running state [/etc/apt/apt.conf.d/95proxies] at time 08:45:27.175579
2018-06-13 08:45:27,175 [salt.state       :1794][INFO    ][22470] Executing state file.absent for [/etc/apt/apt.conf.d/95proxies]
2018-06-13 08:45:27,176 [salt.state       :290 ][INFO    ][22470] File /etc/apt/apt.conf.d/95proxies is not present
2018-06-13 08:45:27,176 [salt.state       :1934][INFO    ][22470] Completed state [/etc/apt/apt.conf.d/95proxies] at time 08:45:27.176133 duration_in_ms=0.555
2018-06-13 08:45:27,180 [salt.minion      :1725][INFO    ][22470] Returning information for job: 20180613084444492787
2018-06-13 08:45:28,898 [salt.minion      :1324][INFO    ][22345] User sudo_ubuntu Executing command saltutil.sync_all with jid 20180613084528879335
2018-06-13 08:45:28,923 [salt.minion      :1448][INFO    ][25717] Starting a new job with PID 25717
2018-06-13 08:45:30,469 [salt.state       :905 ][INFO    ][25717] Loading fresh modules for state activity
2018-06-13 08:45:30,545 [salt.utils.extmods:71  ][INFO    ][25717] Creating module dir '/var/cache/salt/minion/extmods/clouds'
2018-06-13 08:45:30,553 [salt.utils.extmods:82  ][INFO    ][25717] Syncing clouds for environment 'base'
2018-06-13 08:45:30,554 [salt.utils.extmods:86  ][INFO    ][25717] Loading cache from salt://_clouds, for base)
2018-06-13 08:45:30,555 [salt.fileclient  :229 ][INFO    ][25717] Caching directory '_clouds/' for environment 'base'
2018-06-13 08:45:30,646 [salt.utils.extmods:71  ][INFO    ][25717] Creating module dir '/var/cache/salt/minion/extmods/beacons'
2018-06-13 08:45:30,654 [salt.utils.extmods:82  ][INFO    ][25717] Syncing beacons for environment 'base'
2018-06-13 08:45:30,654 [salt.utils.extmods:86  ][INFO    ][25717] Loading cache from salt://_beacons, for base)
2018-06-13 08:45:30,655 [salt.fileclient  :229 ][INFO    ][25717] Caching directory '_beacons/' for environment 'base'
2018-06-13 08:45:30,731 [salt.utils.extmods:82  ][INFO    ][25717] Syncing modules for environment 'base'
2018-06-13 08:45:30,732 [salt.utils.extmods:86  ][INFO    ][25717] Loading cache from salt://_modules, for base)
2018-06-13 08:45:30,732 [salt.fileclient  :229 ][INFO    ][25717] Caching directory '_modules/' for environment 'base'
2018-06-13 08:45:31,327 [salt.fileclient  :1215][INFO    ][25717] Fetching file from saltenv 'base', ** done ** '_modules/maas.py'
2018-06-13 08:45:31,529 [salt.utils.extmods:111 ][INFO    ][25717] Copying '/var/cache/salt/minion/files/base/_modules/__init__.py' to '/var/cache/salt/minion/extmods/modules/__init__.py'
2018-06-13 08:45:31,529 [salt.utils.extmods:111 ][INFO    ][25717] Copying '/var/cache/salt/minion/files/base/_modules/architect.py' to '/var/cache/salt/minion/extmods/modules/architect.py'
2018-06-13 08:45:31,530 [salt.utils.extmods:111 ][INFO    ][25717] Copying '/var/cache/salt/minion/files/base/_modules/avinetworks.py' to '/var/cache/salt/minion/extmods/modules/avinetworks.py'
2018-06-13 08:45:31,531 [salt.utils.extmods:111 ][INFO    ][25717] Copying '/var/cache/salt/minion/files/base/_modules/barbicanv1/__init__.py' to '/var/cache/salt/minion/extmods/modules/barbicanv1/__init__.py'
2018-06-13 08:45:31,531 [salt.utils.extmods:111 ][INFO    ][25717] Copying '/var/cache/salt/minion/files/base/_modules/barbicanv1/acl.py' to '/var/cache/salt/minion/extmods/modules/barbicanv1/acl.py'
2018-06-13 08:45:31,532 [salt.utils.extmods:111 ][INFO    ][25717] Copying '/var/cache/salt/minion/files/base/_modules/barbicanv1/common.py' to '/var/cache/salt/minion/extmods/modules/barbicanv1/common.py'
2018-06-13 08:45:31,533 [salt.utils.extmods:111 ][INFO    ][25717] Copying '/var/cache/salt/minion/files/base/_modules/barbicanv1/secrets.py' to '/var/cache/salt/minion/extmods/modules/barbicanv1/secrets.py'
2018-06-13 08:45:31,533 [salt.utils.extmods:111 ][INFO    ][25717] Copying '/var/cache/salt/minion/files/base/_modules/ceph_ng.py' to '/var/cache/salt/minion/extmods/modules/ceph_ng.py'
2018-06-13 08:45:31,534 [salt.utils.extmods:111 ][INFO    ][25717] Copying '/var/cache/salt/minion/files/base/_modules/cinderng.py' to '/var/cache/salt/minion/extmods/modules/cinderng.py'
2018-06-13 08:45:31,534 [salt.utils.extmods:111 ][INFO    ][25717] Copying '/var/cache/salt/minion/files/base/_modules/contrail.py' to '/var/cache/salt/minion/extmods/modules/contrail.py'
2018-06-13 08:45:31,536 [salt.utils.extmods:111 ][INFO    ][25717] Copying '/var/cache/salt/minion/files/base/_modules/creds.py' to '/var/cache/salt/minion/extmods/modules/creds.py'
2018-06-13 08:45:31,536 [salt.utils.extmods:111 ][INFO    ][25717] Copying '/var/cache/salt/minion/files/base/_modules/devops_utils.py' to '/var/cache/salt/minion/extmods/modules/devops_utils.py'
2018-06-13 08:45:31,537 [salt.utils.extmods:111 ][INFO    ][25717] Copying '/var/cache/salt/minion/files/base/_modules/dockerng_service.py' to '/var/cache/salt/minion/extmods/modules/dockerng_service.py'
2018-06-13 08:45:31,537 [salt.utils.extmods:111 ][INFO    ][25717] Copying '/var/cache/salt/minion/files/base/_modules/encode_json.py' to '/var/cache/salt/minion/extmods/modules/encode_json.py'
2018-06-13 08:45:31,538 [salt.utils.extmods:111 ][INFO    ][25717] Copying '/var/cache/salt/minion/files/base/_modules/gerrit.py' to '/var/cache/salt/minion/extmods/modules/gerrit.py'
2018-06-13 08:45:31,539 [salt.utils.extmods:111 ][INFO    ][25717] Copying '/var/cache/salt/minion/files/base/_modules/glanceng.py' to '/var/cache/salt/minion/extmods/modules/glanceng.py'
2018-06-13 08:45:31,540 [salt.utils.extmods:111 ][INFO    ][25717] Copying '/var/cache/salt/minion/files/base/_modules/glancev2/__init__.py' to '/var/cache/salt/minion/extmods/modules/glancev2/__init__.py'
2018-06-13 08:45:31,540 [salt.utils.extmods:111 ][INFO    ][25717] Copying '/var/cache/salt/minion/files/base/_modules/glancev2/common.py' to '/var/cache/salt/minion/extmods/modules/glancev2/common.py'
2018-06-13 08:45:31,541 [salt.utils.extmods:111 ][INFO    ][25717] Copying '/var/cache/salt/minion/files/base/_modules/glancev2/image.py' to '/var/cache/salt/minion/extmods/modules/glancev2/image.py'
2018-06-13 08:45:31,541 [salt.utils.extmods:111 ][INFO    ][25717] Copying '/var/cache/salt/minion/files/base/_modules/glancev2/task.py' to '/var/cache/salt/minion/extmods/modules/glancev2/task.py'
2018-06-13 08:45:31,542 [salt.utils.extmods:111 ][INFO    ][25717] Copying '/var/cache/salt/minion/files/base/_modules/heat.py' to '/var/cache/salt/minion/extmods/modules/heat.py'
2018-06-13 08:45:31,543 [salt.utils.extmods:111 ][INFO    ][25717] Copying '/var/cache/salt/minion/files/base/_modules/heka_alarming.py' to '/var/cache/salt/minion/extmods/modules/heka_alarming.py'
2018-06-13 08:45:31,543 [salt.utils.extmods:111 ][INFO    ][25717] Copying '/var/cache/salt/minion/files/base/_modules/helm.py' to '/var/cache/salt/minion/extmods/modules/helm.py'
2018-06-13 08:45:31,544 [salt.utils.extmods:111 ][INFO    ][25717] Copying '/var/cache/salt/minion/files/base/_modules/jenkins_common.py' to '/var/cache/salt/minion/extmods/modules/jenkins_common.py'
2018-06-13 08:45:31,545 [salt.utils.extmods:111 ][INFO    ][25717] Copying '/var/cache/salt/minion/files/base/_modules/keystone_policy.py' to '/var/cache/salt/minion/extmods/modules/keystone_policy.py'
2018-06-13 08:45:31,545 [salt.utils.extmods:111 ][INFO    ][25717] Copying '/var/cache/salt/minion/files/base/_modules/keystoneng.py' to '/var/cache/salt/minion/extmods/modules/keystoneng.py'
2018-06-13 08:45:31,546 [salt.utils.extmods:111 ][INFO    ][25717] Copying '/var/cache/salt/minion/files/base/_modules/keystonev3/__init__.py' to '/var/cache/salt/minion/extmods/modules/keystonev3/__init__.py'
2018-06-13 08:45:31,547 [salt.utils.extmods:111 ][INFO    ][25717] Copying '/var/cache/salt/minion/files/base/_modules/keystonev3/common.py' to '/var/cache/salt/minion/extmods/modules/keystonev3/common.py'
2018-06-13 08:45:31,547 [salt.utils.extmods:111 ][INFO    ][25717] Copying '/var/cache/salt/minion/files/base/_modules/keystonev3/endpoints.py' to '/var/cache/salt/minion/extmods/modules/keystonev3/endpoints.py'
2018-06-13 08:45:31,548 [salt.utils.extmods:111 ][INFO    ][25717] Copying '/var/cache/salt/minion/files/base/_modules/keystonev3/projects.py' to '/var/cache/salt/minion/extmods/modules/keystonev3/projects.py'
2018-06-13 08:45:31,548 [salt.utils.extmods:111 ][INFO    ][25717] Copying '/var/cache/salt/minion/files/base/_modules/keystonev3/roles.py' to '/var/cache/salt/minion/extmods/modules/keystonev3/roles.py'
2018-06-13 08:45:31,549 [salt.utils.extmods:111 ][INFO    ][25717] Copying '/var/cache/salt/minion/files/base/_modules/keystonev3/services.py' to '/var/cache/salt/minion/extmods/modules/keystonev3/services.py'
2018-06-13 08:45:31,550 [salt.utils.extmods:111 ][INFO    ][25717] Copying '/var/cache/salt/minion/files/base/_modules/keystonev3/users.py' to '/var/cache/salt/minion/extmods/modules/keystonev3/users.py'
2018-06-13 08:45:31,550 [salt.utils.extmods:111 ][INFO    ][25717] Copying '/var/cache/salt/minion/files/base/_modules/linux_hosts.py' to '/var/cache/salt/minion/extmods/modules/linux_hosts.py'
2018-06-13 08:45:31,551 [salt.utils.extmods:111 ][INFO    ][25717] Copying '/var/cache/salt/minion/files/base/_modules/linux_netlink.py' to '/var/cache/salt/minion/extmods/modules/linux_netlink.py'
2018-06-13 08:45:31,551 [salt.utils.extmods:111 ][INFO    ][25717] Copying '/var/cache/salt/minion/files/base/_modules/maas.py' to '/var/cache/salt/minion/extmods/modules/maas.py'
2018-06-13 08:45:31,552 [salt.utils.extmods:111 ][INFO    ][25717] Copying '/var/cache/salt/minion/files/base/_modules/maas_client.py' to '/var/cache/salt/minion/extmods/modules/maas_client.py'
2018-06-13 08:45:31,553 [salt.utils.extmods:111 ][INFO    ][25717] Copying '/var/cache/salt/minion/files/base/_modules/maasng.py' to '/var/cache/salt/minion/extmods/modules/maasng.py'
2018-06-13 08:45:31,554 [salt.utils.extmods:111 ][INFO    ][25717] Copying '/var/cache/salt/minion/files/base/_modules/modelschema.py' to '/var/cache/salt/minion/extmods/modules/modelschema.py'
2018-06-13 08:45:31,554 [salt.utils.extmods:111 ][INFO    ][25717] Copying '/var/cache/salt/minion/files/base/_modules/modelutils.py' to '/var/cache/salt/minion/extmods/modules/modelutils.py'
2018-06-13 08:45:31,555 [salt.utils.extmods:111 ][INFO    ][25717] Copying '/var/cache/salt/minion/files/base/_modules/multipart.py' to '/var/cache/salt/minion/extmods/modules/multipart.py'
2018-06-13 08:45:31,556 [salt.utils.extmods:111 ][INFO    ][25717] Copying '/var/cache/salt/minion/files/base/_modules/nagios_alarming.py' to '/var/cache/salt/minion/extmods/modules/nagios_alarming.py'
2018-06-13 08:45:31,556 [salt.utils.extmods:111 ][INFO    ][25717] Copying '/var/cache/salt/minion/files/base/_modules/neutronng.py' to '/var/cache/salt/minion/extmods/modules/neutronng.py'
2018-06-13 08:45:31,557 [salt.utils.extmods:111 ][INFO    ][25717] Copying '/var/cache/salt/minion/files/base/_modules/novang.py' to '/var/cache/salt/minion/extmods/modules/novang.py'
2018-06-13 08:45:31,558 [salt.utils.extmods:111 ][INFO    ][25717] Copying '/var/cache/salt/minion/files/base/_modules/reclass.py' to '/var/cache/salt/minion/extmods/modules/reclass.py'
2018-06-13 08:45:31,559 [salt.utils.extmods:111 ][INFO    ][25717] Copying '/var/cache/salt/minion/files/base/_modules/rsyslog_util.py' to '/var/cache/salt/minion/extmods/modules/rsyslog_util.py'
2018-06-13 08:45:31,560 [salt.utils.extmods:111 ][INFO    ][25717] Copying '/var/cache/salt/minion/files/base/_modules/rundeck.py' to '/var/cache/salt/minion/extmods/modules/rundeck.py'
2018-06-13 08:45:31,560 [salt.utils.extmods:111 ][INFO    ][25717] Copying '/var/cache/salt/minion/files/base/_modules/saltkey.py' to '/var/cache/salt/minion/extmods/modules/saltkey.py'
2018-06-13 08:45:31,561 [salt.utils.extmods:111 ][INFO    ][25717] Copying '/var/cache/salt/minion/files/base/_modules/saltresource.py' to '/var/cache/salt/minion/extmods/modules/saltresource.py'
2018-06-13 08:45:31,562 [salt.utils.extmods:111 ][INFO    ][25717] Copying '/var/cache/salt/minion/files/base/_modules/seedng.py' to '/var/cache/salt/minion/extmods/modules/seedng.py'
2018-06-13 08:45:31,562 [salt.utils.extmods:111 ][INFO    ][25717] Copying '/var/cache/salt/minion/files/base/_modules/testing/__init__.py' to '/var/cache/salt/minion/extmods/modules/testing/__init__.py'
2018-06-13 08:45:31,563 [salt.utils.extmods:111 ][INFO    ][25717] Copying '/var/cache/salt/minion/files/base/_modules/testing/credentials.py' to '/var/cache/salt/minion/extmods/modules/testing/credentials.py'
2018-06-13 08:45:31,563 [salt.utils.extmods:111 ][INFO    ][25717] Copying '/var/cache/salt/minion/files/base/_modules/testing/django.py' to '/var/cache/salt/minion/extmods/modules/testing/django.py'
2018-06-13 08:45:31,564 [salt.utils.extmods:111 ][INFO    ][25717] 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-06-13 08:45:31,565 [salt.utils.extmods:111 ][INFO    ][25717] Copying '/var/cache/salt/minion/files/base/_modules/utils.py' to '/var/cache/salt/minion/extmods/modules/utils.py'
2018-06-13 08:45:31,565 [salt.utils.extmods:111 ][INFO    ][25717] Copying '/var/cache/salt/minion/files/base/_modules/virtng.py' to '/var/cache/salt/minion/extmods/modules/virtng.py'
2018-06-13 08:45:31,579 [salt.utils.extmods:82  ][INFO    ][25717] Syncing states for environment 'base'
2018-06-13 08:45:31,579 [salt.utils.extmods:86  ][INFO    ][25717] Loading cache from salt://_states, for base)
2018-06-13 08:45:31,579 [salt.fileclient  :229 ][INFO    ][25717] Caching directory '_states/' for environment 'base'
2018-06-13 08:45:32,003 [salt.utils.extmods:111 ][INFO    ][25717] Copying '/var/cache/salt/minion/files/base/_states/avinetworks.py' to '/var/cache/salt/minion/extmods/states/avinetworks.py'
2018-06-13 08:45:32,004 [salt.utils.extmods:111 ][INFO    ][25717] Copying '/var/cache/salt/minion/files/base/_states/barbicanv1.py' to '/var/cache/salt/minion/extmods/states/barbicanv1.py'
2018-06-13 08:45:32,004 [salt.utils.extmods:111 ][INFO    ][25717] Copying '/var/cache/salt/minion/files/base/_states/cinderng.py' to '/var/cache/salt/minion/extmods/states/cinderng.py'
2018-06-13 08:45:32,005 [salt.utils.extmods:111 ][INFO    ][25717] Copying '/var/cache/salt/minion/files/base/_states/contrail.py' to '/var/cache/salt/minion/extmods/states/contrail.py'
2018-06-13 08:45:32,006 [salt.utils.extmods:111 ][INFO    ][25717] Copying '/var/cache/salt/minion/files/base/_states/debmirror.py' to '/var/cache/salt/minion/extmods/states/debmirror.py'
2018-06-13 08:45:32,007 [salt.utils.extmods:111 ][INFO    ][25717] Copying '/var/cache/salt/minion/files/base/_states/dockerng_service.py' to '/var/cache/salt/minion/extmods/states/dockerng_service.py'
2018-06-13 08:45:32,007 [salt.utils.extmods:111 ][INFO    ][25717] Copying '/var/cache/salt/minion/files/base/_states/gerrit.py' to '/var/cache/salt/minion/extmods/states/gerrit.py'
2018-06-13 08:45:32,008 [salt.utils.extmods:111 ][INFO    ][25717] Copying '/var/cache/salt/minion/files/base/_states/glanceng.py' to '/var/cache/salt/minion/extmods/states/glanceng.py'
2018-06-13 08:45:32,009 [salt.utils.extmods:111 ][INFO    ][25717] Copying '/var/cache/salt/minion/files/base/_states/glancev2.py' to '/var/cache/salt/minion/extmods/states/glancev2.py'
2018-06-13 08:45:32,011 [salt.utils.extmods:111 ][INFO    ][25717] Copying '/var/cache/salt/minion/files/base/_states/grafana3_dashboard.py' to '/var/cache/salt/minion/extmods/states/grafana3_dashboard.py'
2018-06-13 08:45:32,012 [salt.utils.extmods:111 ][INFO    ][25717] Copying '/var/cache/salt/minion/files/base/_states/grafana3_datasource.py' to '/var/cache/salt/minion/extmods/states/grafana3_datasource.py'
2018-06-13 08:45:32,013 [salt.utils.extmods:111 ][INFO    ][25717] Copying '/var/cache/salt/minion/files/base/_states/heat.py' to '/var/cache/salt/minion/extmods/states/heat.py'
2018-06-13 08:45:32,013 [salt.utils.extmods:111 ][INFO    ][25717] Copying '/var/cache/salt/minion/files/base/_states/helm_release.py' to '/var/cache/salt/minion/extmods/states/helm_release.py'
2018-06-13 08:45:32,015 [salt.utils.extmods:111 ][INFO    ][25717] Copying '/var/cache/salt/minion/files/base/_states/helm_repos.py' to '/var/cache/salt/minion/extmods/states/helm_repos.py'
2018-06-13 08:45:32,015 [salt.utils.extmods:111 ][INFO    ][25717] Copying '/var/cache/salt/minion/files/base/_states/httpng.py' to '/var/cache/salt/minion/extmods/states/httpng.py'
2018-06-13 08:45:32,016 [salt.utils.extmods:111 ][INFO    ][25717] Copying '/var/cache/salt/minion/files/base/_states/jenkins_approval.py' to '/var/cache/salt/minion/extmods/states/jenkins_approval.py'
2018-06-13 08:45:32,017 [salt.utils.extmods:111 ][INFO    ][25717] Copying '/var/cache/salt/minion/files/base/_states/jenkins_artifactory.py' to '/var/cache/salt/minion/extmods/states/jenkins_artifactory.py'
2018-06-13 08:45:32,018 [salt.utils.extmods:111 ][INFO    ][25717] Copying '/var/cache/salt/minion/files/base/_states/jenkins_credential.py' to '/var/cache/salt/minion/extmods/states/jenkins_credential.py'
2018-06-13 08:45:32,018 [salt.utils.extmods:111 ][INFO    ][25717] Copying '/var/cache/salt/minion/files/base/_states/jenkins_gerrit.py' to '/var/cache/salt/minion/extmods/states/jenkins_gerrit.py'
2018-06-13 08:45:32,019 [salt.utils.extmods:111 ][INFO    ][25717] Copying '/var/cache/salt/minion/files/base/_states/jenkins_globalenvprop.py' to '/var/cache/salt/minion/extmods/states/jenkins_globalenvprop.py'
2018-06-13 08:45:32,020 [salt.utils.extmods:111 ][INFO    ][25717] Copying '/var/cache/salt/minion/files/base/_states/jenkins_jira.py' to '/var/cache/salt/minion/extmods/states/jenkins_jira.py'
2018-06-13 08:45:32,020 [salt.utils.extmods:111 ][INFO    ][25717] Copying '/var/cache/salt/minion/files/base/_states/jenkins_job.py' to '/var/cache/salt/minion/extmods/states/jenkins_job.py'
2018-06-13 08:45:32,021 [salt.utils.extmods:111 ][INFO    ][25717] Copying '/var/cache/salt/minion/files/base/_states/jenkins_lib.py' to '/var/cache/salt/minion/extmods/states/jenkins_lib.py'
2018-06-13 08:45:32,022 [salt.utils.extmods:111 ][INFO    ][25717] Copying '/var/cache/salt/minion/files/base/_states/jenkins_node.py' to '/var/cache/salt/minion/extmods/states/jenkins_node.py'
2018-06-13 08:45:32,022 [salt.utils.extmods:111 ][INFO    ][25717] Copying '/var/cache/salt/minion/files/base/_states/jenkins_plugin.py' to '/var/cache/salt/minion/extmods/states/jenkins_plugin.py'
2018-06-13 08:45:32,023 [salt.utils.extmods:111 ][INFO    ][25717] Copying '/var/cache/salt/minion/files/base/_states/jenkins_security.py' to '/var/cache/salt/minion/extmods/states/jenkins_security.py'
2018-06-13 08:45:32,024 [salt.utils.extmods:111 ][INFO    ][25717] Copying '/var/cache/salt/minion/files/base/_states/jenkins_slack.py' to '/var/cache/salt/minion/extmods/states/jenkins_slack.py'
2018-06-13 08:45:32,024 [salt.utils.extmods:111 ][INFO    ][25717] Copying '/var/cache/salt/minion/files/base/_states/jenkins_smtp.py' to '/var/cache/salt/minion/extmods/states/jenkins_smtp.py'
2018-06-13 08:45:32,025 [salt.utils.extmods:111 ][INFO    ][25717] Copying '/var/cache/salt/minion/files/base/_states/jenkins_theme.py' to '/var/cache/salt/minion/extmods/states/jenkins_theme.py'
2018-06-13 08:45:32,025 [salt.utils.extmods:111 ][INFO    ][25717] Copying '/var/cache/salt/minion/files/base/_states/jenkins_throttle_category.py' to '/var/cache/salt/minion/extmods/states/jenkins_throttle_category.py'
2018-06-13 08:45:32,026 [salt.utils.extmods:111 ][INFO    ][25717] Copying '/var/cache/salt/minion/files/base/_states/jenkins_user.py' to '/var/cache/salt/minion/extmods/states/jenkins_user.py'
2018-06-13 08:45:32,027 [salt.utils.extmods:111 ][INFO    ][25717] Copying '/var/cache/salt/minion/files/base/_states/jenkins_view.py' to '/var/cache/salt/minion/extmods/states/jenkins_view.py'
2018-06-13 08:45:32,028 [salt.utils.extmods:111 ][INFO    ][25717] Copying '/var/cache/salt/minion/files/base/_states/keystone_policy.py' to '/var/cache/salt/minion/extmods/states/keystone_policy.py'
2018-06-13 08:45:32,028 [salt.utils.extmods:111 ][INFO    ][25717] Copying '/var/cache/salt/minion/files/base/_states/keystoneng.py' to '/var/cache/salt/minion/extmods/states/keystoneng.py'
2018-06-13 08:45:32,029 [salt.utils.extmods:111 ][INFO    ][25717] Copying '/var/cache/salt/minion/files/base/_states/keystonev3.py' to '/var/cache/salt/minion/extmods/states/keystonev3.py'
2018-06-13 08:45:32,030 [salt.utils.extmods:111 ][INFO    ][25717] Copying '/var/cache/salt/minion/files/base/_states/kibana_object.py' to '/var/cache/salt/minion/extmods/states/kibana_object.py'
2018-06-13 08:45:32,030 [salt.utils.extmods:111 ][INFO    ][25717] Copying '/var/cache/salt/minion/files/base/_states/maas_cluster.py' to '/var/cache/salt/minion/extmods/states/maas_cluster.py'
2018-06-13 08:45:32,031 [salt.utils.extmods:111 ][INFO    ][25717] Copying '/var/cache/salt/minion/files/base/_states/maasng.py' to '/var/cache/salt/minion/extmods/states/maasng.py'
2018-06-13 08:45:32,032 [salt.utils.extmods:111 ][INFO    ][25717] Copying '/var/cache/salt/minion/files/base/_states/neutronng.py' to '/var/cache/salt/minion/extmods/states/neutronng.py'
2018-06-13 08:45:32,033 [salt.utils.extmods:111 ][INFO    ][25717] Copying '/var/cache/salt/minion/files/base/_states/novang.py' to '/var/cache/salt/minion/extmods/states/novang.py'
2018-06-13 08:45:32,033 [salt.utils.extmods:111 ][INFO    ][25717] Copying '/var/cache/salt/minion/files/base/_states/reclass.py' to '/var/cache/salt/minion/extmods/states/reclass.py'
2018-06-13 08:45:32,034 [salt.utils.extmods:111 ][INFO    ][25717] Copying '/var/cache/salt/minion/files/base/_states/rundeck_project.py' to '/var/cache/salt/minion/extmods/states/rundeck_project.py'
2018-06-13 08:45:32,034 [salt.utils.extmods:111 ][INFO    ][25717] Copying '/var/cache/salt/minion/files/base/_states/rundeck_scm.py' to '/var/cache/salt/minion/extmods/states/rundeck_scm.py'
2018-06-13 08:45:32,035 [salt.utils.extmods:111 ][INFO    ][25717] Copying '/var/cache/salt/minion/files/base/_states/rundeck_secret.py' to '/var/cache/salt/minion/extmods/states/rundeck_secret.py'
2018-06-13 08:45:32,038 [salt.utils.extmods:71  ][INFO    ][25717] Creating module dir '/var/cache/salt/minion/extmods/sdb'
2018-06-13 08:45:32,046 [salt.utils.extmods:82  ][INFO    ][25717] Syncing sdb for environment 'base'
2018-06-13 08:45:32,046 [salt.utils.extmods:86  ][INFO    ][25717] Loading cache from salt://_sdb, for base)
2018-06-13 08:45:32,047 [salt.fileclient  :229 ][INFO    ][25717] Caching directory '_sdb/' for environment 'base'
2018-06-13 08:45:32,119 [salt.utils.extmods:82  ][INFO    ][25717] Syncing grains for environment 'base'
2018-06-13 08:45:32,120 [salt.utils.extmods:86  ][INFO    ][25717] Loading cache from salt://_grains, for base)
2018-06-13 08:45:32,120 [salt.fileclient  :229 ][INFO    ][25717] Caching directory '_grains/' for environment 'base'
2018-06-13 08:45:32,277 [salt.utils.extmods:111 ][INFO    ][25717] Copying '/var/cache/salt/minion/files/base/_grains/ceilometer_policy.py' to '/var/cache/salt/minion/extmods/grains/ceilometer_policy.py'
2018-06-13 08:45:32,278 [salt.utils.extmods:111 ][INFO    ][25717] Copying '/var/cache/salt/minion/files/base/_grains/ceph.py' to '/var/cache/salt/minion/extmods/grains/ceph.py'
2018-06-13 08:45:32,279 [salt.utils.extmods:111 ][INFO    ][25717] Copying '/var/cache/salt/minion/files/base/_grains/cinder_policy.py' to '/var/cache/salt/minion/extmods/grains/cinder_policy.py'
2018-06-13 08:45:32,280 [salt.utils.extmods:111 ][INFO    ][25717] Copying '/var/cache/salt/minion/files/base/_grains/docker_swarm.py' to '/var/cache/salt/minion/extmods/grains/docker_swarm.py'
2018-06-13 08:45:32,281 [salt.utils.extmods:111 ][INFO    ][25717] Copying '/var/cache/salt/minion/files/base/_grains/glance_policy.py' to '/var/cache/salt/minion/extmods/grains/glance_policy.py'
2018-06-13 08:45:32,282 [salt.utils.extmods:111 ][INFO    ][25717] Copying '/var/cache/salt/minion/files/base/_grains/heat_policy.py' to '/var/cache/salt/minion/extmods/grains/heat_policy.py'
2018-06-13 08:45:32,282 [salt.utils.extmods:111 ][INFO    ][25717] Copying '/var/cache/salt/minion/files/base/_grains/jenkins_plugins.py' to '/var/cache/salt/minion/extmods/grains/jenkins_plugins.py'
2018-06-13 08:45:32,283 [salt.utils.extmods:111 ][INFO    ][25717] Copying '/var/cache/salt/minion/files/base/_grains/keystone_policy.py' to '/var/cache/salt/minion/extmods/grains/keystone_policy.py'
2018-06-13 08:45:32,284 [salt.utils.extmods:111 ][INFO    ][25717] Copying '/var/cache/salt/minion/files/base/_grains/kubernetes.py' to '/var/cache/salt/minion/extmods/grains/kubernetes.py'
2018-06-13 08:45:32,285 [salt.utils.extmods:111 ][INFO    ][25717] Copying '/var/cache/salt/minion/files/base/_grains/neutron_policy.py' to '/var/cache/salt/minion/extmods/grains/neutron_policy.py'
2018-06-13 08:45:32,286 [salt.utils.extmods:111 ][INFO    ][25717] Copying '/var/cache/salt/minion/files/base/_grains/nova_policy.py' to '/var/cache/salt/minion/extmods/grains/nova_policy.py'
2018-06-13 08:45:32,286 [salt.utils.extmods:111 ][INFO    ][25717] Copying '/var/cache/salt/minion/files/base/_grains/ssh_fingerprints.py' to '/var/cache/salt/minion/extmods/grains/ssh_fingerprints.py'
2018-06-13 08:45:32,289 [salt.utils.extmods:71  ][INFO    ][25717] Creating module dir '/var/cache/salt/minion/extmods/renderers'
2018-06-13 08:45:32,295 [salt.utils.extmods:82  ][INFO    ][25717] Syncing renderers for environment 'base'
2018-06-13 08:45:32,295 [salt.utils.extmods:86  ][INFO    ][25717] Loading cache from salt://_renderers, for base)
2018-06-13 08:45:32,296 [salt.fileclient  :229 ][INFO    ][25717] Caching directory '_renderers/' for environment 'base'
2018-06-13 08:45:32,360 [salt.utils.extmods:71  ][INFO    ][25717] Creating module dir '/var/cache/salt/minion/extmods/returners'
2018-06-13 08:45:32,366 [salt.utils.extmods:82  ][INFO    ][25717] Syncing returners for environment 'base'
2018-06-13 08:45:32,367 [salt.utils.extmods:86  ][INFO    ][25717] Loading cache from salt://_returners, for base)
2018-06-13 08:45:32,368 [salt.fileclient  :229 ][INFO    ][25717] Caching directory '_returners/' for environment 'base'
2018-06-13 08:45:32,417 [salt.utils.extmods:71  ][INFO    ][25717] Creating module dir '/var/cache/salt/minion/extmods/output'
2018-06-13 08:45:32,422 [salt.utils.extmods:82  ][INFO    ][25717] Syncing output for environment 'base'
2018-06-13 08:45:32,423 [salt.utils.extmods:86  ][INFO    ][25717] Loading cache from salt://_output, for base)
2018-06-13 08:45:32,423 [salt.fileclient  :229 ][INFO    ][25717] Caching directory '_output/' for environment 'base'
2018-06-13 08:45:32,498 [salt.utils.extmods:71  ][INFO    ][25717] Creating module dir '/var/cache/salt/minion/extmods/utils'
2018-06-13 08:45:32,506 [salt.utils.extmods:82  ][INFO    ][25717] Syncing utils for environment 'base'
2018-06-13 08:45:32,506 [salt.utils.extmods:86  ][INFO    ][25717] Loading cache from salt://_utils, for base)
2018-06-13 08:45:32,507 [salt.fileclient  :229 ][INFO    ][25717] Caching directory '_utils/' for environment 'base'
2018-06-13 08:45:32,565 [salt.utils.extmods:71  ][INFO    ][25717] Creating module dir '/var/cache/salt/minion/extmods/log_handlers'
2018-06-13 08:45:32,575 [salt.utils.extmods:82  ][INFO    ][25717] Syncing log_handlers for environment 'base'
2018-06-13 08:45:32,576 [salt.utils.extmods:86  ][INFO    ][25717] Loading cache from salt://_log_handlers, for base)
2018-06-13 08:45:32,576 [salt.fileclient  :229 ][INFO    ][25717] Caching directory '_log_handlers/' for environment 'base'
2018-06-13 08:45:32,644 [salt.utils.extmods:71  ][INFO    ][25717] Creating module dir '/var/cache/salt/minion/extmods/proxy'
2018-06-13 08:45:32,651 [salt.utils.extmods:82  ][INFO    ][25717] Syncing proxy for environment 'base'
2018-06-13 08:45:32,651 [salt.utils.extmods:86  ][INFO    ][25717] Loading cache from salt://_proxy, for base)
2018-06-13 08:45:32,652 [salt.fileclient  :229 ][INFO    ][25717] Caching directory '_proxy/' for environment 'base'
2018-06-13 08:45:32,700 [salt.utils.extmods:71  ][INFO    ][25717] Creating module dir '/var/cache/salt/minion/extmods/engines'
2018-06-13 08:45:32,707 [salt.utils.extmods:82  ][INFO    ][25717] Syncing engines for environment 'base'
2018-06-13 08:45:32,707 [salt.utils.extmods:86  ][INFO    ][25717] Loading cache from salt://_engines, for base)
2018-06-13 08:45:32,708 [salt.fileclient  :229 ][INFO    ][25717] Caching directory '_engines/' for environment 'base'
2018-06-13 08:45:32,771 [salt.minion      :1725][INFO    ][25717] Returning information for job: 20180613084528879335
2018-06-13 08:45:35,353 [salt.minion      :1324][INFO    ][22345] User sudo_ubuntu Executing command state.apply with jid 20180613084535335475
2018-06-13 08:45:35,373 [salt.minion      :1448][INFO    ][25827] Starting a new job with PID 25827
2018-06-13 08:45:35,939 [salt.state       :905 ][INFO    ][25827] Loading fresh modules for state activity
2018-06-13 08:45:37,109 [salt.loaded.int.module.cmdmod:394 ][INFO    ][25827] Executing command 'reclass --version' in directory '/root'
2018-06-13 08:45:37,423 [salt.loaded.int.module.cmdmod:394 ][INFO    ][25827] Executing command 'reclass --version' in directory '/root'
2018-06-13 08:45:37,774 [salt.loaded.int.module.cmdmod:394 ][INFO    ][25827] Executing command 'salt-minion --version' in directory '/root'
2018-06-13 08:45:38,081 [salt.loaded.int.module.cmdmod:394 ][INFO    ][25827] Executing command 'salt --version' in directory '/root'
2018-06-13 08:45:38,428 [salt.loaded.int.module.cmdmod:394 ][INFO    ][25827] Executing command 'salt-minion --version' in directory '/root'
2018-06-13 08:45:38,732 [salt.loaded.int.module.cmdmod:394 ][INFO    ][25827] Executing command 'salt --version' in directory '/root'
2018-06-13 08:45:39,538 [salt.loaded.int.module.cmdmod:394 ][INFO    ][25827] Executing command 'reclass --version' in directory '/root'
2018-06-13 08:45:39,893 [salt.loaded.int.module.cmdmod:394 ][INFO    ][25827] Executing command 'reclass --version' in directory '/root'
2018-06-13 08:45:40,252 [salt.loaded.int.module.cmdmod:394 ][INFO    ][25827] Executing command 'salt-minion --version' in directory '/root'
2018-06-13 08:45:40,559 [salt.loaded.int.module.cmdmod:394 ][INFO    ][25827] Executing command 'salt --version' in directory '/root'
2018-06-13 08:45:40,873 [salt.loaded.int.module.cmdmod:394 ][INFO    ][25827] Executing command 'salt-minion --version' in directory '/root'
2018-06-13 08:45:41,205 [salt.loaded.int.module.cmdmod:394 ][INFO    ][25827] Executing command 'salt --version' in directory '/root'
2018-06-13 08:45:42,687 [salt.state       :1761][INFO    ][25827] Running state [salt-master] at time 08:45:42.687216
2018-06-13 08:45:42,688 [salt.state       :1794][INFO    ][25827] Executing state pkg.installed for [salt-master]
2018-06-13 08:45:42,688 [salt.loaded.int.module.cmdmod:394 ][INFO    ][25827] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}', '-W'] in directory '/root'
2018-06-13 08:45:43,078 [salt.state       :290 ][INFO    ][25827] All specified packages are already installed
2018-06-13 08:45:43,079 [salt.state       :1934][INFO    ][25827] Completed state [salt-master] at time 08:45:43.079204 duration_in_ms=391.988
2018-06-13 08:45:43,083 [salt.state       :1761][INFO    ][25827] Running state [/etc/salt/master.d/master.conf] at time 08:45:43.083125
2018-06-13 08:45:43,083 [salt.state       :1794][INFO    ][25827] Executing state file.managed for [/etc/salt/master.d/master.conf]
2018-06-13 08:45:43,263 [salt.state       :290 ][INFO    ][25827] File /etc/salt/master.d/master.conf is in the correct state
2018-06-13 08:45:43,263 [salt.state       :1934][INFO    ][25827] Completed state [/etc/salt/master.d/master.conf] at time 08:45:43.263869 duration_in_ms=180.743
2018-06-13 08:45:43,264 [salt.state       :1761][INFO    ][25827] Running state [/etc/salt/master.d/_acl.conf] at time 08:45:43.264885
2018-06-13 08:45:43,265 [salt.state       :1794][INFO    ][25827] Executing state file.managed for [/etc/salt/master.d/_acl.conf]
2018-06-13 08:45:43,332 [salt.state       :290 ][INFO    ][25827] File /etc/salt/master.d/_acl.conf is in the correct state
2018-06-13 08:45:43,332 [salt.state       :1934][INFO    ][25827] Completed state [/etc/salt/master.d/_acl.conf] at time 08:45:43.332713 duration_in_ms=67.828
2018-06-13 08:45:43,333 [salt.state       :1761][INFO    ][25827] Running state [/etc/salt/master.d/_peer.conf] at time 08:45:43.333600
2018-06-13 08:45:43,333 [salt.state       :1794][INFO    ][25827] Executing state file.managed for [/etc/salt/master.d/_peer.conf]
2018-06-13 08:45:43,392 [salt.state       :290 ][INFO    ][25827] File /etc/salt/master.d/_peer.conf is in the correct state
2018-06-13 08:45:43,393 [salt.state       :1934][INFO    ][25827] Completed state [/etc/salt/master.d/_peer.conf] at time 08:45:43.393119 duration_in_ms=59.519
2018-06-13 08:45:43,395 [salt.state       :1761][INFO    ][25827] Running state [salt-master] at time 08:45:43.395478
2018-06-13 08:45:43,395 [salt.state       :1794][INFO    ][25827] Executing state service.running for [salt-master]
2018-06-13 08:45:43,396 [salt.loaded.int.module.cmdmod:394 ][INFO    ][25827] Executing command ['systemctl', 'status', 'salt-master.service', '-n', '0'] in directory '/root'
2018-06-13 08:45:43,427 [salt.loaded.int.module.cmdmod:394 ][INFO    ][25827] Executing command ['systemctl', 'is-active', 'salt-master.service'] in directory '/root'
2018-06-13 08:45:43,438 [salt.loaded.int.module.cmdmod:394 ][INFO    ][25827] Executing command ['systemctl', 'is-enabled', 'salt-master.service'] in directory '/root'
2018-06-13 08:45:43,455 [salt.state       :290 ][INFO    ][25827] The service salt-master is already running
2018-06-13 08:45:43,456 [salt.state       :1934][INFO    ][25827] Completed state [salt-master] at time 08:45:43.456284 duration_in_ms=60.805
2018-06-13 08:45:43,456 [salt.state       :2005][WARNING ][25827] State is set to retry, but a valid dict for retry configuration was not found.  Using retry defaults
2018-06-13 08:45:43,457 [salt.state       :1761][INFO    ][25827] Running state [/srv/salt/env] at time 08:45:43.457078
2018-06-13 08:45:43,457 [salt.state       :1794][INFO    ][25827] Executing state file.directory for [/srv/salt/env]
2018-06-13 08:45:43,459 [salt.state       :290 ][INFO    ][25827] Directory /srv/salt/env is in the correct state
Directory /srv/salt/env updated
2018-06-13 08:45:43,459 [salt.state       :1934][INFO    ][25827] Completed state [/srv/salt/env] at time 08:45:43.459362 duration_in_ms=2.285
2018-06-13 08:45:43,460 [salt.state       :1761][INFO    ][25827] Running state [root] at time 08:45:43.460585
2018-06-13 08:45:43,460 [salt.state       :1794][INFO    ][25827] Executing state group.present for [root]
2018-06-13 08:45:43,461 [salt.state       :290 ][INFO    ][25827] Group root is present and up to date
2018-06-13 08:45:43,461 [salt.state       :1934][INFO    ][25827] Completed state [root] at time 08:45:43.461923 duration_in_ms=1.338
2018-06-13 08:45:43,465 [salt.state       :1761][INFO    ][25827] Running state [root] at time 08:45:43.465391
2018-06-13 08:45:43,465 [salt.state       :1794][INFO    ][25827] Executing state user.present for [root]
2018-06-13 08:45:43,467 [salt.state       :290 ][INFO    ][25827] User root is present and up to date
2018-06-13 08:45:43,467 [salt.state       :1934][INFO    ][25827] Completed state [root] at time 08:45:43.467792 duration_in_ms=2.402
2018-06-13 08:45:43,469 [salt.state       :1761][INFO    ][25827] Running state [/root] at time 08:45:43.469362
2018-06-13 08:45:43,469 [salt.state       :1794][INFO    ][25827] Executing state file.directory for [/root]
2018-06-13 08:45:43,470 [salt.state       :290 ][INFO    ][25827] Directory /root is in the correct state
Directory /root updated
2018-06-13 08:45:43,471 [salt.state       :1934][INFO    ][25827] Completed state [/root] at time 08:45:43.470952 duration_in_ms=1.59
2018-06-13 08:45:43,471 [salt.state       :1761][INFO    ][25827] Running state [/etc/sudoers.d/90-salt-user-root] at time 08:45:43.471288
2018-06-13 08:45:43,471 [salt.state       :1794][INFO    ][25827] Executing state file.absent for [/etc/sudoers.d/90-salt-user-root]
2018-06-13 08:45:43,472 [salt.state       :290 ][INFO    ][25827] File /etc/sudoers.d/90-salt-user-root is not present
2018-06-13 08:45:43,472 [salt.state       :1934][INFO    ][25827] Completed state [/etc/sudoers.d/90-salt-user-root] at time 08:45:43.472382 duration_in_ms=1.093
2018-06-13 08:45:43,472 [salt.state       :1761][INFO    ][25827] Running state [salt] at time 08:45:43.472708
2018-06-13 08:45:43,473 [salt.state       :1794][INFO    ][25827] Executing state group.present for [salt]
2018-06-13 08:45:43,473 [salt.state       :290 ][INFO    ][25827] Group salt is present and up to date
2018-06-13 08:45:43,473 [salt.state       :1934][INFO    ][25827] Completed state [salt] at time 08:45:43.473826 duration_in_ms=1.117
2018-06-13 08:45:43,475 [salt.state       :1761][INFO    ][25827] Running state [salt] at time 08:45:43.475175
2018-06-13 08:45:43,475 [salt.state       :1794][INFO    ][25827] Executing state user.present for [salt]
2018-06-13 08:45:43,477 [salt.state       :290 ][INFO    ][25827] User salt is present and up to date
2018-06-13 08:45:43,477 [salt.state       :1934][INFO    ][25827] Completed state [salt] at time 08:45:43.477284 duration_in_ms=2.109
2018-06-13 08:45:43,478 [salt.state       :1761][INFO    ][25827] Running state [/var/tmp/salt] at time 08:45:43.478734
2018-06-13 08:45:43,479 [salt.state       :1794][INFO    ][25827] Executing state file.directory for [/var/tmp/salt]
2018-06-13 08:45:43,480 [salt.state       :290 ][INFO    ][25827] Directory /var/tmp/salt is in the correct state
Directory /var/tmp/salt updated
2018-06-13 08:45:43,480 [salt.state       :1934][INFO    ][25827] Completed state [/var/tmp/salt] at time 08:45:43.480515 duration_in_ms=1.782
2018-06-13 08:45:43,480 [salt.state       :1761][INFO    ][25827] Running state [/etc/sudoers.d/90-salt-user-salt] at time 08:45:43.480826
2018-06-13 08:45:43,481 [salt.state       :1794][INFO    ][25827] Executing state file.absent for [/etc/sudoers.d/90-salt-user-salt]
2018-06-13 08:45:43,486 [salt.state       :290 ][INFO    ][25827] File /etc/sudoers.d/90-salt-user-salt is not present
2018-06-13 08:45:43,486 [salt.state       :1934][INFO    ][25827] Completed state [/etc/sudoers.d/90-salt-user-salt] at time 08:45:43.486701 duration_in_ms=5.875
2018-06-13 08:45:43,487 [salt.state       :1761][INFO    ][25827] Running state [ubuntu] at time 08:45:43.486989
2018-06-13 08:45:43,487 [salt.state       :1794][INFO    ][25827] Executing state group.present for [ubuntu]
2018-06-13 08:45:43,487 [salt.state       :290 ][INFO    ][25827] Group ubuntu is present and up to date
2018-06-13 08:45:43,488 [salt.state       :1934][INFO    ][25827] Completed state [ubuntu] at time 08:45:43.488124 duration_in_ms=1.134
2018-06-13 08:45:43,489 [salt.state       :1761][INFO    ][25827] Running state [ubuntu] at time 08:45:43.489424
2018-06-13 08:45:43,489 [salt.state       :1794][INFO    ][25827] Executing state user.present for [ubuntu]
2018-06-13 08:45:43,491 [salt.state       :290 ][INFO    ][25827] User ubuntu is present and up to date
2018-06-13 08:45:43,491 [salt.state       :1934][INFO    ][25827] Completed state [ubuntu] at time 08:45:43.491412 duration_in_ms=1.988
2018-06-13 08:45:43,492 [salt.state       :1761][INFO    ][25827] Running state [/home/ubuntu] at time 08:45:43.492805
2018-06-13 08:45:43,493 [salt.state       :1794][INFO    ][25827] Executing state file.directory for [/home/ubuntu]
2018-06-13 08:45:43,494 [salt.state       :290 ][INFO    ][25827] Directory /home/ubuntu is in the correct state
Directory /home/ubuntu updated
2018-06-13 08:45:43,494 [salt.state       :1934][INFO    ][25827] Completed state [/home/ubuntu] at time 08:45:43.494351 duration_in_ms=1.545
2018-06-13 08:45:43,495 [salt.state       :1761][INFO    ][25827] Running state [/etc/sudoers.d/90-salt-user-ubuntu] at time 08:45:43.495518
2018-06-13 08:45:43,495 [salt.state       :1794][INFO    ][25827] Executing state file.managed for [/etc/sudoers.d/90-salt-user-ubuntu]
2018-06-13 08:45:43,526 [salt.state       :290 ][INFO    ][25827] File /etc/sudoers.d/90-salt-user-ubuntu is in the correct state
2018-06-13 08:45:43,526 [salt.state       :1934][INFO    ][25827] Completed state [/etc/sudoers.d/90-salt-user-ubuntu] at time 08:45:43.526537 duration_in_ms=31.018
2018-06-13 08:45:43,526 [salt.state       :1761][INFO    ][25827] Running state [git-core] at time 08:45:43.526856
2018-06-13 08:45:43,527 [salt.state       :1794][INFO    ][25827] Executing state pkg.installed for [git-core]
2018-06-13 08:45:43,536 [salt.state       :290 ][INFO    ][25827] All specified packages are already installed
2018-06-13 08:45:43,537 [salt.state       :1934][INFO    ][25827] Completed state [git-core] at time 08:45:43.537008 duration_in_ms=10.151
2018-06-13 08:45:43,537 [salt.state       :1761][INFO    ][25827] Running state [/usr/share/salt-formulas/env/_modules] at time 08:45:43.537322
2018-06-13 08:45:43,537 [salt.state       :1794][INFO    ][25827] Executing state file.directory for [/usr/share/salt-formulas/env/_modules]
2018-06-13 08:45:43,539 [salt.state       :290 ][INFO    ][25827] Directory /usr/share/salt-formulas/env/_modules is in the correct state
Directory /usr/share/salt-formulas/env/_modules updated
2018-06-13 08:45:43,539 [salt.state       :1934][INFO    ][25827] Completed state [/usr/share/salt-formulas/env/_modules] at time 08:45:43.539822 duration_in_ms=2.501
2018-06-13 08:45:43,540 [salt.state       :1761][INFO    ][25827] Running state [/usr/share/salt-formulas/env/_states] at time 08:45:43.540163
2018-06-13 08:45:43,540 [salt.state       :1794][INFO    ][25827] Executing state file.directory for [/usr/share/salt-formulas/env/_states]
2018-06-13 08:45:43,541 [salt.state       :290 ][INFO    ][25827] Directory /usr/share/salt-formulas/env/_states is in the correct state
Directory /usr/share/salt-formulas/env/_states updated
2018-06-13 08:45:43,541 [salt.state       :1934][INFO    ][25827] Completed state [/usr/share/salt-formulas/env/_states] at time 08:45:43.541482 duration_in_ms=1.318
2018-06-13 08:45:43,541 [salt.state       :1761][INFO    ][25827] Running state [/usr/share/salt-formulas/env/_grains] at time 08:45:43.541769
2018-06-13 08:45:43,542 [salt.state       :1794][INFO    ][25827] Executing state file.directory for [/usr/share/salt-formulas/env/_grains]
2018-06-13 08:45:43,542 [salt.state       :290 ][INFO    ][25827] Directory /usr/share/salt-formulas/env/_grains is in the correct state
Directory /usr/share/salt-formulas/env/_grains updated
2018-06-13 08:45:43,543 [salt.state       :1934][INFO    ][25827] Completed state [/usr/share/salt-formulas/env/_grains] at time 08:45:43.543056 duration_in_ms=1.287
2018-06-13 08:45:43,543 [salt.state       :1761][INFO    ][25827] Running state [/usr/share/salt-formulas/env/_formulas] at time 08:45:43.543371
2018-06-13 08:45:43,543 [salt.state       :1794][INFO    ][25827] Executing state file.directory for [/usr/share/salt-formulas/env/_formulas]
2018-06-13 08:45:43,544 [salt.state       :290 ][INFO    ][25827] Directory /usr/share/salt-formulas/env/_formulas is in the correct state
Directory /usr/share/salt-formulas/env/_formulas updated
2018-06-13 08:45:43,544 [salt.state       :1934][INFO    ][25827] Completed state [/usr/share/salt-formulas/env/_formulas] at time 08:45:43.544698 duration_in_ms=1.326
2018-06-13 08:45:43,545 [salt.state       :1761][INFO    ][25827] Running state [/usr/share/salt-formulas/env/_engines] at time 08:45:43.544987
2018-06-13 08:45:43,545 [salt.state       :1794][INFO    ][25827] Executing state file.directory for [/usr/share/salt-formulas/env/_engines]
2018-06-13 08:45:43,546 [salt.state       :290 ][INFO    ][25827] Directory /usr/share/salt-formulas/env/_engines is in the correct state
Directory /usr/share/salt-formulas/env/_engines updated
2018-06-13 08:45:43,546 [salt.state       :1934][INFO    ][25827] Completed state [/usr/share/salt-formulas/env/_engines] at time 08:45:43.546286 duration_in_ms=1.299
2018-06-13 08:45:43,546 [salt.state       :1761][INFO    ][25827] Running state [/usr/share/salt-formulas/env/_runners] at time 08:45:43.546586
2018-06-13 08:45:43,546 [salt.state       :1794][INFO    ][25827] Executing state file.directory for [/usr/share/salt-formulas/env/_runners]
2018-06-13 08:45:43,547 [salt.state       :290 ][INFO    ][25827] Directory /usr/share/salt-formulas/env/_runners is in the correct state
Directory /usr/share/salt-formulas/env/_runners updated
2018-06-13 08:45:43,547 [salt.state       :1934][INFO    ][25827] Completed state [/usr/share/salt-formulas/env/_runners] at time 08:45:43.547823 duration_in_ms=1.237
2018-06-13 08:45:43,549 [salt.state       :1761][INFO    ][25827] Running state [/srv/salt/env/prd] at time 08:45:43.549494
2018-06-13 08:45:43,549 [salt.state       :1794][INFO    ][25827] Executing state file.symlink for [/srv/salt/env/prd]
2018-06-13 08:45:43,551 [salt.state       :290 ][INFO    ][25827] Symlink /srv/salt/env/prd is present and owned by root:root
2018-06-13 08:45:43,551 [salt.state       :1934][INFO    ][25827] Completed state [/srv/salt/env/prd] at time 08:45:43.551831 duration_in_ms=2.337
2018-06-13 08:45:43,552 [salt.state       :1761][INFO    ][25827] Running state [salt_master_prd_pkg_formulas] at time 08:45:43.552176
2018-06-13 08:45:43,552 [salt.state       :1794][INFO    ][25827] Executing state pkg.latest for [salt_master_prd_pkg_formulas]
2018-06-13 08:45:43,567 [salt.loaded.int.module.cmdmod:394 ][INFO    ][25827] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-maas'] in directory '/root'
2018-06-13 08:45:43,655 [salt.loaded.int.module.cmdmod:394 ][INFO    ][25827] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-grafana'] in directory '/root'
2018-06-13 08:45:43,741 [salt.loaded.int.module.cmdmod:394 ][INFO    ][25827] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-xtrabackup'] in directory '/root'
2018-06-13 08:45:43,801 [salt.loaded.int.module.cmdmod:394 ][INFO    ][25827] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-docker'] in directory '/root'
2018-06-13 08:45:43,843 [salt.loaded.int.module.cmdmod:394 ][INFO    ][25827] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-heat'] in directory '/root'
2018-06-13 08:45:43,883 [salt.loaded.int.module.cmdmod:394 ][INFO    ][25827] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-reclass'] in directory '/root'
2018-06-13 08:45:43,922 [salt.loaded.int.module.cmdmod:394 ][INFO    ][25827] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-memcached'] in directory '/root'
2018-06-13 08:45:43,962 [salt.loaded.int.module.cmdmod:394 ][INFO    ][25827] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-redis'] in directory '/root'
2018-06-13 08:45:44,036 [salt.loaded.int.module.cmdmod:394 ][INFO    ][25827] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-nova'] in directory '/root'
2018-06-13 08:45:44,096 [salt.loaded.int.module.cmdmod:394 ][INFO    ][25827] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-iptables'] in directory '/root'
2018-06-13 08:45:44,136 [salt.loaded.int.module.cmdmod:394 ][INFO    ][25827] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-murano'] in directory '/root'
2018-06-13 08:45:44,177 [salt.loaded.int.module.cmdmod:394 ][INFO    ][25827] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-glusterfs'] in directory '/root'
2018-06-13 08:45:44,217 [salt.loaded.int.module.cmdmod:394 ][INFO    ][25827] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-backupninja'] in directory '/root'
2018-06-13 08:45:44,270 [salt.loaded.int.module.cmdmod:394 ][INFO    ][25827] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-kubernetes'] in directory '/root'
2018-06-13 08:45:44,311 [salt.loaded.int.module.cmdmod:394 ][INFO    ][25827] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-linux'] in directory '/root'
2018-06-13 08:45:44,370 [salt.loaded.int.module.cmdmod:394 ][INFO    ][25827] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-git'] in directory '/root'
2018-06-13 08:45:44,428 [salt.loaded.int.module.cmdmod:394 ][INFO    ][25827] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-apache'] in directory '/root'
2018-06-13 08:45:44,477 [salt.loaded.int.module.cmdmod:394 ][INFO    ][25827] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-aptly'] in directory '/root'
2018-06-13 08:45:44,517 [salt.loaded.int.module.cmdmod:394 ][INFO    ][25827] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-gerrit'] in directory '/root'
2018-06-13 08:45:44,560 [salt.loaded.int.module.cmdmod:394 ][INFO    ][25827] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-sensu'] in directory '/root'
2018-06-13 08:45:44,605 [salt.loaded.int.module.cmdmod:394 ][INFO    ][25827] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-logrotate'] in directory '/root'
2018-06-13 08:45:44,672 [salt.loaded.int.module.cmdmod:394 ][INFO    ][25827] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-glance'] in directory '/root'
2018-06-13 08:45:44,731 [salt.loaded.int.module.cmdmod:394 ][INFO    ][25827] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-heka'] in directory '/root'
2018-06-13 08:45:44,788 [salt.loaded.int.module.cmdmod:394 ][INFO    ][25827] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-keystone'] in directory '/root'
2018-06-13 08:45:44,863 [salt.loaded.int.module.cmdmod:394 ][INFO    ][25827] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-ntp'] in directory '/root'
2018-06-13 08:45:44,941 [salt.loaded.int.module.cmdmod:394 ][INFO    ][25827] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-barbican'] in directory '/root'
2018-06-13 08:45:45,006 [salt.loaded.int.module.cmdmod:394 ][INFO    ][25827] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-aodh'] in directory '/root'
2018-06-13 08:45:45,063 [salt.loaded.int.module.cmdmod:394 ][INFO    ][25827] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-python'] in directory '/root'
2018-06-13 08:45:45,108 [salt.loaded.int.module.cmdmod:394 ][INFO    ][25827] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-collectd'] in directory '/root'
2018-06-13 08:45:45,150 [salt.loaded.int.module.cmdmod:394 ][INFO    ][25827] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-neutron'] in directory '/root'
2018-06-13 08:45:45,191 [salt.loaded.int.module.cmdmod:394 ][INFO    ][25827] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-supervisor'] in directory '/root'
2018-06-13 08:45:45,233 [salt.loaded.int.module.cmdmod:394 ][INFO    ][25827] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-ceilometer'] in directory '/root'
2018-06-13 08:45:45,278 [salt.loaded.int.module.cmdmod:394 ][INFO    ][25827] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-elasticsearch'] in directory '/root'
2018-06-13 08:45:45,322 [salt.loaded.int.module.cmdmod:394 ][INFO    ][25827] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-powerdns'] in directory '/root'
2018-06-13 08:45:45,365 [salt.loaded.int.module.cmdmod:394 ][INFO    ][25827] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-cassandra'] in directory '/root'
2018-06-13 08:45:45,402 [salt.minion      :1324][INFO    ][22345] User sudo_ubuntu Executing command saltutil.find_job with jid 20180613084545390542
2018-06-13 08:45:45,428 [salt.minion      :1448][INFO    ][26048] Starting a new job with PID 26048
2018-06-13 08:45:45,431 [salt.loaded.int.module.cmdmod:394 ][INFO    ][25827] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-libvirt'] in directory '/root'
2018-06-13 08:45:45,452 [salt.minion      :1725][INFO    ][26048] Returning information for job: 20180613084545390542
2018-06-13 08:45:45,476 [salt.loaded.int.module.cmdmod:394 ][INFO    ][25827] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-sahara'] in directory '/root'
2018-06-13 08:45:45,514 [salt.loaded.int.module.cmdmod:394 ][INFO    ][25827] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-openssh'] in directory '/root'
2018-06-13 08:45:45,554 [salt.loaded.int.module.cmdmod:394 ][INFO    ][25827] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-statsd'] in directory '/root'
2018-06-13 08:45:45,594 [salt.loaded.int.module.cmdmod:394 ][INFO    ][25827] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-mongodb'] in directory '/root'
2018-06-13 08:45:45,661 [salt.loaded.int.module.cmdmod:394 ][INFO    ][25827] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-kibana'] in directory '/root'
2018-06-13 08:45:45,723 [salt.loaded.int.module.cmdmod:394 ][INFO    ][25827] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-sphinx'] in directory '/root'
2018-06-13 08:45:45,780 [salt.loaded.int.module.cmdmod:394 ][INFO    ][25827] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-freeipa'] in directory '/root'
2018-06-13 08:45:45,831 [salt.loaded.int.module.cmdmod:394 ][INFO    ][25827] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-octavia'] in directory '/root'
2018-06-13 08:45:45,877 [salt.loaded.int.module.cmdmod:394 ][INFO    ][25827] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-fluentd'] in directory '/root'
2018-06-13 08:45:45,959 [salt.loaded.int.module.cmdmod:394 ][INFO    ][25827] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-aptcacher'] in directory '/root'
2018-06-13 08:45:46,039 [salt.loaded.int.module.cmdmod:394 ][INFO    ][25827] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-salt'] in directory '/root'
2018-06-13 08:45:46,094 [salt.loaded.int.module.cmdmod:394 ][INFO    ][25827] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-etcd'] in directory '/root'
2018-06-13 08:45:46,143 [salt.loaded.int.module.cmdmod:394 ][INFO    ][25827] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-devops-portal'] in directory '/root'
2018-06-13 08:45:46,193 [salt.loaded.int.module.cmdmod:394 ][INFO    ][25827] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-postgresql'] in directory '/root'
2018-06-13 08:45:46,239 [salt.loaded.int.module.cmdmod:394 ][INFO    ][25827] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-avinetworks'] in directory '/root'
2018-06-13 08:45:46,284 [salt.loaded.int.module.cmdmod:394 ][INFO    ][25827] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-rundeck'] in directory '/root'
2018-06-13 08:45:46,328 [salt.loaded.int.module.cmdmod:394 ][INFO    ][25827] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-nginx'] in directory '/root'
2018-06-13 08:45:46,404 [salt.loaded.int.module.cmdmod:394 ][INFO    ][25827] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-mysql'] in directory '/root'
2018-06-13 08:45:46,467 [salt.loaded.int.module.cmdmod:394 ][INFO    ][25827] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-ceph'] in directory '/root'
2018-06-13 08:45:46,528 [salt.loaded.int.module.cmdmod:394 ][INFO    ][25827] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-horizon'] in directory '/root'
2018-06-13 08:45:46,587 [salt.loaded.int.module.cmdmod:394 ][INFO    ][25827] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-haproxy'] in directory '/root'
2018-06-13 08:45:46,642 [salt.loaded.int.module.cmdmod:394 ][INFO    ][25827] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-influxdb'] in directory '/root'
2018-06-13 08:45:46,722 [salt.loaded.int.module.cmdmod:394 ][INFO    ][25827] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-billometer'] in directory '/root'
2018-06-13 08:45:46,790 [salt.loaded.int.module.cmdmod:394 ][INFO    ][25827] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-telegraf'] in directory '/root'
2018-06-13 08:45:46,873 [salt.loaded.int.module.cmdmod:394 ][INFO    ][25827] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-designate'] in directory '/root'
2018-06-13 08:45:46,939 [salt.loaded.int.module.cmdmod:394 ][INFO    ][25827] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-keepalived'] in directory '/root'
2018-06-13 08:45:47,001 [salt.loaded.int.module.cmdmod:394 ][INFO    ][25827] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-bind'] in directory '/root'
2018-06-13 08:45:47,060 [salt.loaded.int.module.cmdmod:394 ][INFO    ][25827] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-ccp'] in directory '/root'
2018-06-13 08:45:47,149 [salt.loaded.int.module.cmdmod:394 ][INFO    ][25827] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-tinyproxy'] in directory '/root'
2018-06-13 08:45:47,233 [salt.loaded.int.module.cmdmod:394 ][INFO    ][25827] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-rabbitmq'] in directory '/root'
2018-06-13 08:45:47,301 [salt.loaded.int.module.cmdmod:394 ][INFO    ][25827] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-openldap'] in directory '/root'
2018-06-13 08:45:47,381 [salt.loaded.int.module.cmdmod:394 ][INFO    ][25827] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-debmirror'] in directory '/root'
2018-06-13 08:45:47,447 [salt.loaded.int.module.cmdmod:394 ][INFO    ][25827] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-java'] in directory '/root'
2018-06-13 08:45:47,507 [salt.loaded.int.module.cmdmod:394 ][INFO    ][25827] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-prometheus'] in directory '/root'
2018-06-13 08:45:47,566 [salt.loaded.int.module.cmdmod:394 ][INFO    ][25827] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-helm'] in directory '/root'
2018-06-13 08:45:47,614 [salt.loaded.int.module.cmdmod:394 ][INFO    ][25827] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-opencontrail'] in directory '/root'
2018-06-13 08:45:47,656 [salt.loaded.int.module.cmdmod:394 ][INFO    ][25827] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-jenkins'] in directory '/root'
2018-06-13 08:45:47,698 [salt.loaded.int.module.cmdmod:394 ][INFO    ][25827] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-lldp'] in directory '/root'
2018-06-13 08:45:47,739 [salt.loaded.int.module.cmdmod:394 ][INFO    ][25827] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-nagios'] in directory '/root'
2018-06-13 08:45:47,780 [salt.loaded.int.module.cmdmod:394 ][INFO    ][25827] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-swift'] in directory '/root'
2018-06-13 08:45:47,820 [salt.loaded.int.module.cmdmod:394 ][INFO    ][25827] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-zookeeper'] in directory '/root'
2018-06-13 08:45:47,861 [salt.loaded.int.module.cmdmod:394 ][INFO    ][25827] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-galera'] in directory '/root'
2018-06-13 08:45:47,904 [salt.loaded.int.module.cmdmod:394 ][INFO    ][25827] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-graphite'] in directory '/root'
2018-06-13 08:45:47,945 [salt.loaded.int.module.cmdmod:394 ][INFO    ][25827] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-cinder'] in directory '/root'
2018-06-13 08:45:47,985 [salt.loaded.int.module.cmdmod:394 ][INFO    ][25827] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-rsyslog'] in directory '/root'
2018-06-13 08:45:48,027 [salt.state       :290 ][INFO    ][25827] All 81 packages are up-to-date.
2018-06-13 08:45:48,028 [salt.state       :1934][INFO    ][25827] Completed state [salt_master_prd_pkg_formulas] at time 08:45:48.027980 duration_in_ms=4475.803
2018-06-13 08:45:48,028 [salt.state       :1761][INFO    ][25827] Running state [/srv/salt/reclass] at time 08:45:48.028391
2018-06-13 08:45:48,028 [salt.state       :1794][INFO    ][25827] Executing state file.directory for [/srv/salt/reclass]
2018-06-13 08:45:48,029 [salt.state       :290 ][INFO    ][25827] Directory /srv/salt/reclass is in the correct state
Directory /srv/salt/reclass updated
2018-06-13 08:45:48,030 [salt.state       :1934][INFO    ][25827] Completed state [/srv/salt/reclass] at time 08:45:48.030002 duration_in_ms=1.611
2018-06-13 08:45:48,031 [salt.state       :1761][INFO    ][25827] Running state [/srv/salt/reclass/classes/service] at time 08:45:48.031615
2018-06-13 08:45:48,031 [salt.state       :1794][INFO    ][25827] Executing state file.directory for [/srv/salt/reclass/classes/service]
2018-06-13 08:45:48,032 [salt.state       :290 ][INFO    ][25827] Directory /srv/salt/reclass/classes/service is in the correct state
Directory /srv/salt/reclass/classes/service updated
2018-06-13 08:45:48,032 [salt.state       :1934][INFO    ][25827] Completed state [/srv/salt/reclass/classes/service] at time 08:45:48.032937 duration_in_ms=1.322
2018-06-13 08:45:48,034 [salt.state       :1761][INFO    ][25827] Running state [/srv/salt/reclass/classes/service/powerdns] at time 08:45:48.034247
2018-06-13 08:45:48,034 [salt.state       :1794][INFO    ][25827] Executing state file.symlink for [/srv/salt/reclass/classes/service/powerdns]
2018-06-13 08:45:48,036 [salt.state       :290 ][INFO    ][25827] Symlink /srv/salt/reclass/classes/service/powerdns is present and owned by root:root
2018-06-13 08:45:48,036 [salt.state       :1934][INFO    ][25827] Completed state [/srv/salt/reclass/classes/service/powerdns] at time 08:45:48.036733 duration_in_ms=2.486
2018-06-13 08:45:48,037 [salt.state       :1761][INFO    ][25827] Running state [/srv/salt/reclass/classes/service/galera] at time 08:45:48.037783
2018-06-13 08:45:48,038 [salt.state       :1794][INFO    ][25827] Executing state file.symlink for [/srv/salt/reclass/classes/service/galera]
2018-06-13 08:45:48,039 [salt.state       :290 ][INFO    ][25827] Symlink /srv/salt/reclass/classes/service/galera is present and owned by root:root
2018-06-13 08:45:48,040 [salt.state       :1934][INFO    ][25827] Completed state [/srv/salt/reclass/classes/service/galera] at time 08:45:48.040040 duration_in_ms=2.257
2018-06-13 08:45:48,041 [salt.state       :1761][INFO    ][25827] Running state [/srv/salt/reclass/classes/service/telegraf] at time 08:45:48.041082
2018-06-13 08:45:48,041 [salt.state       :1794][INFO    ][25827] Executing state file.symlink for [/srv/salt/reclass/classes/service/telegraf]
2018-06-13 08:45:48,043 [salt.state       :290 ][INFO    ][25827] Symlink /srv/salt/reclass/classes/service/telegraf is present and owned by root:root
2018-06-13 08:45:48,043 [salt.state       :1934][INFO    ][25827] Completed state [/srv/salt/reclass/classes/service/telegraf] at time 08:45:48.043314 duration_in_ms=2.231
2018-06-13 08:45:48,044 [salt.state       :1761][INFO    ][25827] Running state [/srv/salt/reclass/classes/service/supervisor] at time 08:45:48.044385
2018-06-13 08:45:48,044 [salt.state       :1794][INFO    ][25827] Executing state file.symlink for [/srv/salt/reclass/classes/service/supervisor]
2018-06-13 08:45:48,046 [salt.state       :290 ][INFO    ][25827] Symlink /srv/salt/reclass/classes/service/supervisor is present and owned by root:root
2018-06-13 08:45:48,046 [salt.state       :1934][INFO    ][25827] Completed state [/srv/salt/reclass/classes/service/supervisor] at time 08:45:48.046625 duration_in_ms=2.24
2018-06-13 08:45:48,047 [salt.state       :1761][INFO    ][25827] Running state [/srv/salt/reclass/classes/service/sensu] at time 08:45:48.047631
2018-06-13 08:45:48,047 [salt.state       :1794][INFO    ][25827] Executing state file.symlink for [/srv/salt/reclass/classes/service/sensu]
2018-06-13 08:45:48,049 [salt.state       :290 ][INFO    ][25827] Symlink /srv/salt/reclass/classes/service/sensu is present and owned by root:root
2018-06-13 08:45:48,049 [salt.state       :1934][INFO    ][25827] Completed state [/srv/salt/reclass/classes/service/sensu] at time 08:45:48.049784 duration_in_ms=2.153
2018-06-13 08:45:48,050 [salt.state       :1761][INFO    ][25827] Running state [/srv/salt/reclass/classes/service/aodh] at time 08:45:48.050787
2018-06-13 08:45:48,051 [salt.state       :1794][INFO    ][25827] Executing state file.symlink for [/srv/salt/reclass/classes/service/aodh]
2018-06-13 08:45:48,052 [salt.state       :290 ][INFO    ][25827] Symlink /srv/salt/reclass/classes/service/aodh is present and owned by root:root
2018-06-13 08:45:48,052 [salt.state       :1934][INFO    ][25827] Completed state [/srv/salt/reclass/classes/service/aodh] at time 08:45:48.052931 duration_in_ms=2.144
2018-06-13 08:45:48,053 [salt.state       :1761][INFO    ][25827] Running state [/srv/salt/reclass/classes/service/mysql] at time 08:45:48.053926
2018-06-13 08:45:48,054 [salt.state       :1794][INFO    ][25827] Executing state file.symlink for [/srv/salt/reclass/classes/service/mysql]
2018-06-13 08:45:48,055 [salt.state       :290 ][INFO    ][25827] Symlink /srv/salt/reclass/classes/service/mysql is present and owned by root:root
2018-06-13 08:45:48,056 [salt.state       :1934][INFO    ][25827] Completed state [/srv/salt/reclass/classes/service/mysql] at time 08:45:48.056042 duration_in_ms=2.116
2018-06-13 08:45:48,057 [salt.state       :1761][INFO    ][25827] Running state [/srv/salt/reclass/classes/service/kibana] at time 08:45:48.056993
2018-06-13 08:45:48,057 [salt.state       :1794][INFO    ][25827] Executing state file.symlink for [/srv/salt/reclass/classes/service/kibana]
2018-06-13 08:45:48,058 [salt.state       :290 ][INFO    ][25827] Symlink /srv/salt/reclass/classes/service/kibana is present and owned by root:root
2018-06-13 08:45:48,059 [salt.state       :1934][INFO    ][25827] Completed state [/srv/salt/reclass/classes/service/kibana] at time 08:45:48.059031 duration_in_ms=2.038
2018-06-13 08:45:48,060 [salt.state       :1761][INFO    ][25827] Running state [/srv/salt/reclass/classes/service/nagios] at time 08:45:48.060046
2018-06-13 08:45:48,060 [salt.state       :1794][INFO    ][25827] Executing state file.symlink for [/srv/salt/reclass/classes/service/nagios]
2018-06-13 08:45:48,061 [salt.state       :290 ][INFO    ][25827] Symlink /srv/salt/reclass/classes/service/nagios is present and owned by root:root
2018-06-13 08:45:48,062 [salt.state       :1934][INFO    ][25827] Completed state [/srv/salt/reclass/classes/service/nagios] at time 08:45:48.062118 duration_in_ms=2.072
2018-06-13 08:45:48,063 [salt.state       :1761][INFO    ][25827] Running state [/srv/salt/reclass/classes/service/ceph] at time 08:45:48.063114
2018-06-13 08:45:48,063 [salt.state       :1794][INFO    ][25827] Executing state file.symlink for [/srv/salt/reclass/classes/service/ceph]
2018-06-13 08:45:48,065 [salt.state       :290 ][INFO    ][25827] Symlink /srv/salt/reclass/classes/service/ceph is present and owned by root:root
2018-06-13 08:45:48,065 [salt.state       :1934][INFO    ][25827] Completed state [/srv/salt/reclass/classes/service/ceph] at time 08:45:48.065268 duration_in_ms=2.153
2018-06-13 08:45:48,066 [salt.state       :1761][INFO    ][25827] Running state [/srv/salt/reclass/classes/service/apache] at time 08:45:48.066229
2018-06-13 08:45:48,066 [salt.state       :1794][INFO    ][25827] Executing state file.symlink for [/srv/salt/reclass/classes/service/apache]
2018-06-13 08:45:48,068 [salt.state       :290 ][INFO    ][25827] Symlink /srv/salt/reclass/classes/service/apache is present and owned by root:root
2018-06-13 08:45:48,068 [salt.state       :1934][INFO    ][25827] Completed state [/srv/salt/reclass/classes/service/apache] at time 08:45:48.068289 duration_in_ms=2.061
2018-06-13 08:45:48,069 [salt.state       :1761][INFO    ][25827] Running state [/srv/salt/reclass/classes/service/glusterfs] at time 08:45:48.069225
2018-06-13 08:45:48,069 [salt.state       :1794][INFO    ][25827] Executing state file.symlink for [/srv/salt/reclass/classes/service/glusterfs]
2018-06-13 08:45:48,071 [salt.state       :290 ][INFO    ][25827] Symlink /srv/salt/reclass/classes/service/glusterfs is present and owned by root:root
2018-06-13 08:45:48,071 [salt.state       :1934][INFO    ][25827] Completed state [/srv/salt/reclass/classes/service/glusterfs] at time 08:45:48.071322 duration_in_ms=2.097
2018-06-13 08:45:48,072 [salt.state       :1761][INFO    ][25827] Running state [/srv/salt/reclass/classes/service/xtrabackup] at time 08:45:48.072306
2018-06-13 08:45:48,072 [salt.state       :1794][INFO    ][25827] Executing state file.symlink for [/srv/salt/reclass/classes/service/xtrabackup]
2018-06-13 08:45:48,074 [salt.state       :290 ][INFO    ][25827] Symlink /srv/salt/reclass/classes/service/xtrabackup is present and owned by root:root
2018-06-13 08:45:48,074 [salt.state       :1934][INFO    ][25827] Completed state [/srv/salt/reclass/classes/service/xtrabackup] at time 08:45:48.074278 duration_in_ms=1.972
2018-06-13 08:45:48,075 [salt.state       :1761][INFO    ][25827] Running state [/srv/salt/reclass/classes/service/sahara] at time 08:45:48.075239
2018-06-13 08:45:48,075 [salt.state       :1794][INFO    ][25827] Executing state file.symlink for [/srv/salt/reclass/classes/service/sahara]
2018-06-13 08:45:48,077 [salt.state       :290 ][INFO    ][25827] Symlink /srv/salt/reclass/classes/service/sahara is present and owned by root:root
2018-06-13 08:45:48,077 [salt.state       :1934][INFO    ][25827] Completed state [/srv/salt/reclass/classes/service/sahara] at time 08:45:48.077244 duration_in_ms=2.005
2018-06-13 08:45:48,078 [salt.state       :1761][INFO    ][25827] Running state [/srv/salt/reclass/classes/service/backupninja] at time 08:45:48.078143
2018-06-13 08:45:48,078 [salt.state       :1794][INFO    ][25827] Executing state file.symlink for [/srv/salt/reclass/classes/service/backupninja]
2018-06-13 08:45:48,079 [salt.state       :290 ][INFO    ][25827] Symlink /srv/salt/reclass/classes/service/backupninja is present and owned by root:root
2018-06-13 08:45:48,080 [salt.state       :1934][INFO    ][25827] Completed state [/srv/salt/reclass/classes/service/backupninja] at time 08:45:48.080115 duration_in_ms=1.971
2018-06-13 08:45:48,081 [salt.state       :1761][INFO    ][25827] Running state [/srv/salt/reclass/classes/service/rsyslog] at time 08:45:48.081045
2018-06-13 08:45:48,081 [salt.state       :1794][INFO    ][25827] Executing state file.symlink for [/srv/salt/reclass/classes/service/rsyslog]
2018-06-13 08:45:48,082 [salt.state       :290 ][INFO    ][25827] Symlink /srv/salt/reclass/classes/service/rsyslog is present and owned by root:root
2018-06-13 08:45:48,083 [salt.state       :1934][INFO    ][25827] Completed state [/srv/salt/reclass/classes/service/rsyslog] at time 08:45:48.082991 duration_in_ms=1.945
2018-06-13 08:45:48,083 [salt.state       :1761][INFO    ][25827] Running state [/srv/salt/reclass/classes/service/tinyproxy] at time 08:45:48.083914
2018-06-13 08:45:48,084 [salt.state       :1794][INFO    ][25827] Executing state file.symlink for [/srv/salt/reclass/classes/service/tinyproxy]
2018-06-13 08:45:48,085 [salt.state       :290 ][INFO    ][25827] Symlink /srv/salt/reclass/classes/service/tinyproxy is present and owned by root:root
2018-06-13 08:45:48,086 [salt.state       :1934][INFO    ][25827] Completed state [/srv/salt/reclass/classes/service/tinyproxy] at time 08:45:48.085987 duration_in_ms=2.073
2018-06-13 08:45:48,086 [salt.state       :1761][INFO    ][25827] Running state [/srv/salt/reclass/classes/service/helm] at time 08:45:48.086855
2018-06-13 08:45:48,087 [salt.state       :1794][INFO    ][25827] Executing state file.symlink for [/srv/salt/reclass/classes/service/helm]
2018-06-13 08:45:48,088 [salt.state       :290 ][INFO    ][25827] Symlink /srv/salt/reclass/classes/service/helm is present and owned by root:root
2018-06-13 08:45:48,088 [salt.state       :1934][INFO    ][25827] Completed state [/srv/salt/reclass/classes/service/helm] at time 08:45:48.088880 duration_in_ms=2.025
2018-06-13 08:45:48,089 [salt.state       :1761][INFO    ][25827] Running state [/srv/salt/reclass/classes/service/freeipa] at time 08:45:48.089764
2018-06-13 08:45:48,090 [salt.state       :1794][INFO    ][25827] Executing state file.symlink for [/srv/salt/reclass/classes/service/freeipa]
2018-06-13 08:45:48,091 [salt.state       :290 ][INFO    ][25827] Symlink /srv/salt/reclass/classes/service/freeipa is present and owned by root:root
2018-06-13 08:45:48,091 [salt.state       :1934][INFO    ][25827] Completed state [/srv/salt/reclass/classes/service/freeipa] at time 08:45:48.091674 duration_in_ms=1.909
2018-06-13 08:45:48,092 [salt.state       :1761][INFO    ][25827] Running state [/srv/salt/reclass/classes/service/barbican] at time 08:45:48.092604
2018-06-13 08:45:48,092 [salt.state       :1794][INFO    ][25827] Executing state file.symlink for [/srv/salt/reclass/classes/service/barbican]
2018-06-13 08:45:48,094 [salt.state       :290 ][INFO    ][25827] Symlink /srv/salt/reclass/classes/service/barbican is present and owned by root:root
2018-06-13 08:45:48,094 [salt.state       :1934][INFO    ][25827] Completed state [/srv/salt/reclass/classes/service/barbican] at time 08:45:48.094574 duration_in_ms=1.97
2018-06-13 08:45:48,095 [salt.state       :1761][INFO    ][25827] Running state [/srv/salt/reclass/classes/service/grafana] at time 08:45:48.095470
2018-06-13 08:45:48,095 [salt.state       :1794][INFO    ][25827] Executing state file.symlink for [/srv/salt/reclass/classes/service/grafana]
2018-06-13 08:45:48,097 [salt.state       :290 ][INFO    ][25827] Symlink /srv/salt/reclass/classes/service/grafana is present and owned by root:root
2018-06-13 08:45:48,097 [salt.state       :1934][INFO    ][25827] Completed state [/srv/salt/reclass/classes/service/grafana] at time 08:45:48.097404 duration_in_ms=1.934
2018-06-13 08:45:48,098 [salt.state       :1761][INFO    ][25827] Running state [/srv/salt/reclass/classes/service/aptly] at time 08:45:48.098239
2018-06-13 08:45:48,098 [salt.state       :1794][INFO    ][25827] Executing state file.symlink for [/srv/salt/reclass/classes/service/aptly]
2018-06-13 08:45:48,099 [salt.state       :290 ][INFO    ][25827] Symlink /srv/salt/reclass/classes/service/aptly is present and owned by root:root
2018-06-13 08:45:48,100 [salt.state       :1934][INFO    ][25827] Completed state [/srv/salt/reclass/classes/service/aptly] at time 08:45:48.100145 duration_in_ms=1.906
2018-06-13 08:45:48,101 [salt.state       :1761][INFO    ][25827] Running state [/srv/salt/reclass/classes/service/cassandra] at time 08:45:48.100997
2018-06-13 08:45:48,101 [salt.state       :1794][INFO    ][25827] Executing state file.symlink for [/srv/salt/reclass/classes/service/cassandra]
2018-06-13 08:45:48,102 [salt.state       :290 ][INFO    ][25827] Symlink /srv/salt/reclass/classes/service/cassandra is present and owned by root:root
2018-06-13 08:45:48,102 [salt.state       :1934][INFO    ][25827] Completed state [/srv/salt/reclass/classes/service/cassandra] at time 08:45:48.102918 duration_in_ms=1.921
2018-06-13 08:45:48,103 [salt.state       :1761][INFO    ][25827] Running state [/srv/salt/reclass/classes/service/lldp] at time 08:45:48.103785
2018-06-13 08:45:48,104 [salt.state       :1794][INFO    ][25827] Executing state file.symlink for [/srv/salt/reclass/classes/service/lldp]
2018-06-13 08:45:48,105 [salt.state       :290 ][INFO    ][25827] Symlink /srv/salt/reclass/classes/service/lldp is present and owned by root:root
2018-06-13 08:45:48,105 [salt.state       :1934][INFO    ][25827] Completed state [/srv/salt/reclass/classes/service/lldp] at time 08:45:48.105737 duration_in_ms=1.952
2018-06-13 08:45:48,106 [salt.state       :1761][INFO    ][25827] Running state [/srv/salt/reclass/classes/service/debmirror] at time 08:45:48.106565
2018-06-13 08:45:48,106 [salt.state       :1794][INFO    ][25827] Executing state file.symlink for [/srv/salt/reclass/classes/service/debmirror]
2018-06-13 08:45:48,108 [salt.state       :290 ][INFO    ][25827] Symlink /srv/salt/reclass/classes/service/debmirror is present and owned by root:root
2018-06-13 08:45:48,108 [salt.state       :1934][INFO    ][25827] Completed state [/srv/salt/reclass/classes/service/debmirror] at time 08:45:48.108389 duration_in_ms=1.824
2018-06-13 08:45:48,109 [salt.state       :1761][INFO    ][25827] Running state [/srv/salt/reclass/classes/service/collectd] at time 08:45:48.109210
2018-06-13 08:45:48,109 [salt.state       :1794][INFO    ][25827] Executing state file.symlink for [/srv/salt/reclass/classes/service/collectd]
2018-06-13 08:45:48,110 [salt.state       :290 ][INFO    ][25827] Symlink /srv/salt/reclass/classes/service/collectd is present and owned by root:root
2018-06-13 08:45:48,111 [salt.state       :1934][INFO    ][25827] Completed state [/srv/salt/reclass/classes/service/collectd] at time 08:45:48.111004 duration_in_ms=1.794
2018-06-13 08:45:48,111 [salt.state       :1761][INFO    ][25827] Running state [/srv/salt/reclass/classes/service/git] at time 08:45:48.111825
2018-06-13 08:45:48,112 [salt.state       :1794][INFO    ][25827] Executing state file.symlink for [/srv/salt/reclass/classes/service/git]
2018-06-13 08:45:48,114 [salt.state       :290 ][INFO    ][25827] Symlink /srv/salt/reclass/classes/service/git is present and owned by root:root
2018-06-13 08:45:48,114 [salt.state       :1934][INFO    ][25827] Completed state [/srv/salt/reclass/classes/service/git] at time 08:45:48.114794 duration_in_ms=2.967
2018-06-13 08:45:48,115 [salt.state       :1761][INFO    ][25827] Running state [/srv/salt/reclass/classes/service/java] at time 08:45:48.115610
2018-06-13 08:45:48,115 [salt.state       :1794][INFO    ][25827] Executing state file.symlink for [/srv/salt/reclass/classes/service/java]
2018-06-13 08:45:48,117 [salt.state       :290 ][INFO    ][25827] Symlink /srv/salt/reclass/classes/service/java is present and owned by root:root
2018-06-13 08:45:48,117 [salt.state       :1934][INFO    ][25827] Completed state [/srv/salt/reclass/classes/service/java] at time 08:45:48.117428 duration_in_ms=1.818
2018-06-13 08:45:48,118 [salt.state       :1761][INFO    ][25827] Running state [/srv/salt/reclass/classes/service/reclass] at time 08:45:48.118219
2018-06-13 08:45:48,118 [salt.state       :1794][INFO    ][25827] Executing state file.symlink for [/srv/salt/reclass/classes/service/reclass]
2018-06-13 08:45:48,119 [salt.state       :290 ][INFO    ][25827] Symlink /srv/salt/reclass/classes/service/reclass is present and owned by root:root
2018-06-13 08:45:48,119 [salt.state       :1934][INFO    ][25827] Completed state [/srv/salt/reclass/classes/service/reclass] at time 08:45:48.119932 duration_in_ms=1.713
2018-06-13 08:45:48,120 [salt.state       :1761][INFO    ][25827] Running state [/srv/salt/reclass/classes/service/linux] at time 08:45:48.120929
2018-06-13 08:45:48,121 [salt.state       :1794][INFO    ][25827] Executing state file.symlink for [/srv/salt/reclass/classes/service/linux]
2018-06-13 08:45:48,122 [salt.state       :290 ][INFO    ][25827] Symlink /srv/salt/reclass/classes/service/linux is present and owned by root:root
2018-06-13 08:45:48,122 [salt.state       :1934][INFO    ][25827] Completed state [/srv/salt/reclass/classes/service/linux] at time 08:45:48.122647 duration_in_ms=1.718
2018-06-13 08:45:48,123 [salt.state       :1761][INFO    ][25827] Running state [/srv/salt/reclass/classes/service/glance] at time 08:45:48.123727
2018-06-13 08:45:48,124 [salt.state       :1794][INFO    ][25827] Executing state file.symlink for [/srv/salt/reclass/classes/service/glance]
2018-06-13 08:45:48,125 [salt.state       :290 ][INFO    ][25827] Symlink /srv/salt/reclass/classes/service/glance is present and owned by root:root
2018-06-13 08:45:48,125 [salt.state       :1934][INFO    ][25827] Completed state [/srv/salt/reclass/classes/service/glance] at time 08:45:48.125504 duration_in_ms=2.046
2018-06-13 08:45:48,126 [salt.state       :1761][INFO    ][25827] Running state [/srv/salt/reclass/classes/service/keepalived] at time 08:45:48.126296
2018-06-13 08:45:48,126 [salt.state       :1794][INFO    ][25827] Executing state file.symlink for [/srv/salt/reclass/classes/service/keepalived]
2018-06-13 08:45:48,127 [salt.state       :290 ][INFO    ][25827] Symlink /srv/salt/reclass/classes/service/keepalived is present and owned by root:root
2018-06-13 08:45:48,128 [salt.state       :1934][INFO    ][25827] Completed state [/srv/salt/reclass/classes/service/keepalived] at time 08:45:48.128042 duration_in_ms=1.746
2018-06-13 08:45:48,128 [salt.state       :1761][INFO    ][25827] Running state [/srv/salt/reclass/classes/service/nova] at time 08:45:48.128824
2018-06-13 08:45:48,129 [salt.state       :1794][INFO    ][25827] Executing state file.symlink for [/srv/salt/reclass/classes/service/nova]
2018-06-13 08:45:48,130 [salt.state       :290 ][INFO    ][25827] Symlink /srv/salt/reclass/classes/service/nova is present and owned by root:root
2018-06-13 08:45:48,130 [salt.state       :1934][INFO    ][25827] Completed state [/srv/salt/reclass/classes/service/nova] at time 08:45:48.130560 duration_in_ms=1.735
2018-06-13 08:45:48,131 [salt.state       :1761][INFO    ][25827] Running state [/srv/salt/reclass/classes/service/rundeck] at time 08:45:48.131358
2018-06-13 08:45:48,131 [salt.state       :1794][INFO    ][25827] Executing state file.symlink for [/srv/salt/reclass/classes/service/rundeck]
2018-06-13 08:45:48,132 [salt.state       :290 ][INFO    ][25827] Symlink /srv/salt/reclass/classes/service/rundeck is present and owned by root:root
2018-06-13 08:45:48,133 [salt.state       :1934][INFO    ][25827] Completed state [/srv/salt/reclass/classes/service/rundeck] at time 08:45:48.133104 duration_in_ms=1.746
2018-06-13 08:45:48,133 [salt.state       :1761][INFO    ][25827] Running state [/srv/salt/reclass/classes/service/murano] at time 08:45:48.133896
2018-06-13 08:45:48,134 [salt.state       :1794][INFO    ][25827] Executing state file.symlink for [/srv/salt/reclass/classes/service/murano]
2018-06-13 08:45:48,135 [salt.state       :290 ][INFO    ][25827] Symlink /srv/salt/reclass/classes/service/murano is present and owned by root:root
2018-06-13 08:45:48,135 [salt.state       :1934][INFO    ][25827] Completed state [/srv/salt/reclass/classes/service/murano] at time 08:45:48.135657 duration_in_ms=1.76
2018-06-13 08:45:48,136 [salt.state       :1761][INFO    ][25827] Running state [/srv/salt/reclass/classes/service/keystone] at time 08:45:48.136487
2018-06-13 08:45:48,136 [salt.state       :1794][INFO    ][25827] Executing state file.symlink for [/srv/salt/reclass/classes/service/keystone]
2018-06-13 08:45:48,138 [salt.state       :290 ][INFO    ][25827] Symlink /srv/salt/reclass/classes/service/keystone is present and owned by root:root
2018-06-13 08:45:48,138 [salt.state       :1934][INFO    ][25827] Completed state [/srv/salt/reclass/classes/service/keystone] at time 08:45:48.138173 duration_in_ms=1.686
2018-06-13 08:45:48,138 [salt.state       :1761][INFO    ][25827] Running state [/srv/salt/reclass/classes/service/etcd] at time 08:45:48.138930
2018-06-13 08:45:48,139 [salt.state       :1794][INFO    ][25827] Executing state file.symlink for [/srv/salt/reclass/classes/service/etcd]
2018-06-13 08:45:48,140 [salt.state       :290 ][INFO    ][25827] Symlink /srv/salt/reclass/classes/service/etcd is present and owned by root:root
2018-06-13 08:45:48,140 [salt.state       :1934][INFO    ][25827] Completed state [/srv/salt/reclass/classes/service/etcd] at time 08:45:48.140671 duration_in_ms=1.741
2018-06-13 08:45:48,141 [salt.state       :1761][INFO    ][25827] Running state [/srv/salt/reclass/classes/service/ntp] at time 08:45:48.141451
2018-06-13 08:45:48,141 [salt.state       :1794][INFO    ][25827] Executing state file.symlink for [/srv/salt/reclass/classes/service/ntp]
2018-06-13 08:45:48,142 [salt.state       :290 ][INFO    ][25827] Symlink /srv/salt/reclass/classes/service/ntp is present and owned by root:root
2018-06-13 08:45:48,143 [salt.state       :1934][INFO    ][25827] Completed state [/srv/salt/reclass/classes/service/ntp] at time 08:45:48.143096 duration_in_ms=1.645
2018-06-13 08:45:48,143 [salt.state       :1761][INFO    ][25827] Running state [/srv/salt/reclass/classes/service/jenkins] at time 08:45:48.143886
2018-06-13 08:45:48,144 [salt.state       :1794][INFO    ][25827] Executing state file.symlink for [/srv/salt/reclass/classes/service/jenkins]
2018-06-13 08:45:48,145 [salt.state       :290 ][INFO    ][25827] Symlink /srv/salt/reclass/classes/service/jenkins is present and owned by root:root
2018-06-13 08:45:48,145 [salt.state       :1934][INFO    ][25827] Completed state [/srv/salt/reclass/classes/service/jenkins] at time 08:45:48.145603 duration_in_ms=1.717
2018-06-13 08:45:48,146 [salt.state       :1761][INFO    ][25827] Running state [/srv/salt/reclass/classes/service/ccp] at time 08:45:48.146357
2018-06-13 08:45:48,146 [salt.state       :1794][INFO    ][25827] Executing state file.symlink for [/srv/salt/reclass/classes/service/ccp]
2018-06-13 08:45:48,147 [salt.state       :290 ][INFO    ][25827] Symlink /srv/salt/reclass/classes/service/ccp is present and owned by root:root
2018-06-13 08:45:48,148 [salt.state       :1934][INFO    ][25827] Completed state [/srv/salt/reclass/classes/service/ccp] at time 08:45:48.147967 duration_in_ms=1.61
2018-06-13 08:45:48,148 [salt.state       :1761][INFO    ][25827] Running state [/srv/salt/reclass/classes/service/memcached] at time 08:45:48.148724
2018-06-13 08:45:48,148 [salt.state       :1794][INFO    ][25827] Executing state file.symlink for [/srv/salt/reclass/classes/service/memcached]
2018-06-13 08:45:48,150 [salt.state       :290 ][INFO    ][25827] Symlink /srv/salt/reclass/classes/service/memcached is present and owned by root:root
2018-06-13 08:45:48,150 [salt.state       :1934][INFO    ][25827] Completed state [/srv/salt/reclass/classes/service/memcached] at time 08:45:48.150328 duration_in_ms=1.604
2018-06-13 08:45:48,151 [salt.state       :1761][INFO    ][25827] Running state [/srv/salt/reclass/classes/service/sphinx] at time 08:45:48.151054
2018-06-13 08:45:48,151 [salt.state       :1794][INFO    ][25827] Executing state file.symlink for [/srv/salt/reclass/classes/service/sphinx]
2018-06-13 08:45:48,152 [salt.state       :290 ][INFO    ][25827] Symlink /srv/salt/reclass/classes/service/sphinx is present and owned by root:root
2018-06-13 08:45:48,152 [salt.state       :1934][INFO    ][25827] Completed state [/srv/salt/reclass/classes/service/sphinx] at time 08:45:48.152721 duration_in_ms=1.667
2018-06-13 08:45:48,153 [salt.state       :1761][INFO    ][25827] Running state [/srv/salt/reclass/classes/service/neutron] at time 08:45:48.153466
2018-06-13 08:45:48,153 [salt.state       :1794][INFO    ][25827] Executing state file.symlink for [/srv/salt/reclass/classes/service/neutron]
2018-06-13 08:45:48,154 [salt.state       :290 ][INFO    ][25827] Symlink /srv/salt/reclass/classes/service/neutron is present and owned by root:root
2018-06-13 08:45:48,155 [salt.state       :1934][INFO    ][25827] Completed state [/srv/salt/reclass/classes/service/neutron] at time 08:45:48.155070 duration_in_ms=1.603
2018-06-13 08:45:48,155 [salt.state       :1761][INFO    ][25827] Running state [/srv/salt/reclass/classes/service/designate] at time 08:45:48.155804
2018-06-13 08:45:48,156 [salt.state       :1794][INFO    ][25827] Executing state file.symlink for [/srv/salt/reclass/classes/service/designate]
2018-06-13 08:45:48,157 [salt.state       :290 ][INFO    ][25827] Symlink /srv/salt/reclass/classes/service/designate is present and owned by root:root
2018-06-13 08:45:48,157 [salt.state       :1934][INFO    ][25827] Completed state [/srv/salt/reclass/classes/service/designate] at time 08:45:48.157399 duration_in_ms=1.595
2018-06-13 08:45:48,158 [salt.state       :1761][INFO    ][25827] Running state [/srv/salt/reclass/classes/service/iptables] at time 08:45:48.158094
2018-06-13 08:45:48,158 [salt.state       :1794][INFO    ][25827] Executing state file.symlink for [/srv/salt/reclass/classes/service/iptables]
2018-06-13 08:45:48,159 [salt.state       :290 ][INFO    ][25827] Symlink /srv/salt/reclass/classes/service/iptables is present and owned by root:root
2018-06-13 08:45:48,159 [salt.state       :1934][INFO    ][25827] Completed state [/srv/salt/reclass/classes/service/iptables] at time 08:45:48.159665 duration_in_ms=1.571
2018-06-13 08:45:48,160 [salt.state       :1761][INFO    ][25827] Running state [/srv/salt/reclass/classes/service/statsd] at time 08:45:48.160433
2018-06-13 08:45:48,160 [salt.state       :1794][INFO    ][25827] Executing state file.symlink for [/srv/salt/reclass/classes/service/statsd]
2018-06-13 08:45:48,161 [salt.state       :290 ][INFO    ][25827] Symlink /srv/salt/reclass/classes/service/statsd is present and owned by root:root
2018-06-13 08:45:48,162 [salt.state       :1934][INFO    ][25827] Completed state [/srv/salt/reclass/classes/service/statsd] at time 08:45:48.162020 duration_in_ms=1.587
2018-06-13 08:45:48,162 [salt.state       :1761][INFO    ][25827] Running state [/srv/salt/reclass/classes/service/gerrit] at time 08:45:48.162740
2018-06-13 08:45:48,162 [salt.state       :1794][INFO    ][25827] Executing state file.symlink for [/srv/salt/reclass/classes/service/gerrit]
2018-06-13 08:45:48,164 [salt.state       :290 ][INFO    ][25827] Symlink /srv/salt/reclass/classes/service/gerrit is present and owned by root:root
2018-06-13 08:45:48,164 [salt.state       :1934][INFO    ][25827] Completed state [/srv/salt/reclass/classes/service/gerrit] at time 08:45:48.164335 duration_in_ms=1.595
2018-06-13 08:45:48,165 [salt.state       :1761][INFO    ][25827] Running state [/srv/salt/reclass/classes/service/zookeeper] at time 08:45:48.165073
2018-06-13 08:45:48,165 [salt.state       :1794][INFO    ][25827] Executing state file.symlink for [/srv/salt/reclass/classes/service/zookeeper]
2018-06-13 08:45:48,166 [salt.state       :290 ][INFO    ][25827] Symlink /srv/salt/reclass/classes/service/zookeeper is present and owned by root:root
2018-06-13 08:45:48,166 [salt.state       :1934][INFO    ][25827] Completed state [/srv/salt/reclass/classes/service/zookeeper] at time 08:45:48.166612 duration_in_ms=1.539
2018-06-13 08:45:48,167 [salt.state       :1761][INFO    ][25827] Running state [/srv/salt/reclass/classes/service/kubernetes] at time 08:45:48.167312
2018-06-13 08:45:48,167 [salt.state       :1794][INFO    ][25827] Executing state file.symlink for [/srv/salt/reclass/classes/service/kubernetes]
2018-06-13 08:45:48,168 [salt.state       :290 ][INFO    ][25827] Symlink /srv/salt/reclass/classes/service/kubernetes is present and owned by root:root
2018-06-13 08:45:48,168 [salt.state       :1934][INFO    ][25827] Completed state [/srv/salt/reclass/classes/service/kubernetes] at time 08:45:48.168852 duration_in_ms=1.54
2018-06-13 08:45:48,169 [salt.state       :1761][INFO    ][25827] Running state [/srv/salt/reclass/classes/service/python] at time 08:45:48.169544
2018-06-13 08:45:48,169 [salt.state       :1794][INFO    ][25827] Executing state file.symlink for [/srv/salt/reclass/classes/service/python]
2018-06-13 08:45:48,170 [salt.state       :290 ][INFO    ][25827] Symlink /srv/salt/reclass/classes/service/python is present and owned by root:root
2018-06-13 08:45:48,171 [salt.state       :1934][INFO    ][25827] Completed state [/srv/salt/reclass/classes/service/python] at time 08:45:48.171102 duration_in_ms=1.558
2018-06-13 08:45:48,171 [salt.state       :1761][INFO    ][25827] Running state [/srv/salt/reclass/classes/service/mongodb] at time 08:45:48.171791
2018-06-13 08:45:48,172 [salt.state       :1794][INFO    ][25827] Executing state file.symlink for [/srv/salt/reclass/classes/service/mongodb]
2018-06-13 08:45:48,173 [salt.state       :290 ][INFO    ][25827] Symlink /srv/salt/reclass/classes/service/mongodb is present and owned by root:root
2018-06-13 08:45:48,173 [salt.state       :1934][INFO    ][25827] Completed state [/srv/salt/reclass/classes/service/mongodb] at time 08:45:48.173664 duration_in_ms=1.872
2018-06-13 08:45:48,174 [salt.state       :1761][INFO    ][25827] Running state [/srv/salt/reclass/classes/service/maas] at time 08:45:48.174358
2018-06-13 08:45:48,174 [salt.state       :1794][INFO    ][25827] Executing state file.symlink for [/srv/salt/reclass/classes/service/maas]
2018-06-13 08:45:48,175 [salt.state       :290 ][INFO    ][25827] Symlink /srv/salt/reclass/classes/service/maas is present and owned by root:root
2018-06-13 08:45:48,175 [salt.state       :1934][INFO    ][25827] Completed state [/srv/salt/reclass/classes/service/maas] at time 08:45:48.175868 duration_in_ms=1.51
2018-06-13 08:45:48,176 [salt.state       :1761][INFO    ][25827] Running state [/srv/salt/reclass/classes/service/libvirt] at time 08:45:48.176621
2018-06-13 08:45:48,176 [salt.state       :1794][INFO    ][25827] Executing state file.symlink for [/srv/salt/reclass/classes/service/libvirt]
2018-06-13 08:45:48,177 [salt.state       :290 ][INFO    ][25827] Symlink /srv/salt/reclass/classes/service/libvirt is present and owned by root:root
2018-06-13 08:45:48,178 [salt.state       :1934][INFO    ][25827] Completed state [/srv/salt/reclass/classes/service/libvirt] at time 08:45:48.178063 duration_in_ms=1.441
2018-06-13 08:45:48,178 [salt.state       :1761][INFO    ][25827] Running state [/srv/salt/reclass/classes/service/heka] at time 08:45:48.178749
2018-06-13 08:45:48,178 [salt.state       :1794][INFO    ][25827] Executing state file.symlink for [/srv/salt/reclass/classes/service/heka]
2018-06-13 08:45:48,180 [salt.state       :290 ][INFO    ][25827] Symlink /srv/salt/reclass/classes/service/heka is present and owned by root:root
2018-06-13 08:45:48,180 [salt.state       :1934][INFO    ][25827] Completed state [/srv/salt/reclass/classes/service/heka] at time 08:45:48.180207 duration_in_ms=1.458
2018-06-13 08:45:48,180 [salt.state       :1761][INFO    ][25827] Running state [/srv/salt/reclass/classes/service/heat] at time 08:45:48.180866
2018-06-13 08:45:48,181 [salt.state       :1794][INFO    ][25827] Executing state file.symlink for [/srv/salt/reclass/classes/service/heat]
2018-06-13 08:45:48,182 [salt.state       :290 ][INFO    ][25827] Symlink /srv/salt/reclass/classes/service/heat is present and owned by root:root
2018-06-13 08:45:48,182 [salt.state       :1934][INFO    ][25827] Completed state [/srv/salt/reclass/classes/service/heat] at time 08:45:48.182319 duration_in_ms=1.454
2018-06-13 08:45:48,183 [salt.state       :1761][INFO    ][25827] Running state [/srv/salt/reclass/classes/service/openldap] at time 08:45:48.182984
2018-06-13 08:45:48,183 [salt.state       :1794][INFO    ][25827] Executing state file.symlink for [/srv/salt/reclass/classes/service/openldap]
2018-06-13 08:45:48,184 [salt.state       :290 ][INFO    ][25827] Symlink /srv/salt/reclass/classes/service/openldap is present and owned by root:root
2018-06-13 08:45:48,184 [salt.state       :1934][INFO    ][25827] Completed state [/srv/salt/reclass/classes/service/openldap] at time 08:45:48.184512 duration_in_ms=1.528
2018-06-13 08:45:48,185 [salt.state       :1761][INFO    ][25827] Running state [/srv/salt/reclass/classes/service/influxdb] at time 08:45:48.185187
2018-06-13 08:45:48,185 [salt.state       :1794][INFO    ][25827] Executing state file.symlink for [/srv/salt/reclass/classes/service/influxdb]
2018-06-13 08:45:48,186 [salt.state       :290 ][INFO    ][25827] Symlink /srv/salt/reclass/classes/service/influxdb is present and owned by root:root
2018-06-13 08:45:48,186 [salt.state       :1934][INFO    ][25827] Completed state [/srv/salt/reclass/classes/service/influxdb] at time 08:45:48.186622 duration_in_ms=1.435
2018-06-13 08:45:48,187 [salt.state       :1761][INFO    ][25827] Running state [/srv/salt/reclass/classes/service/avinetworks] at time 08:45:48.187307
2018-06-13 08:45:48,187 [salt.state       :1794][INFO    ][25827] Executing state file.symlink for [/srv/salt/reclass/classes/service/avinetworks]
2018-06-13 08:45:48,188 [salt.state       :290 ][INFO    ][25827] Symlink /srv/salt/reclass/classes/service/avinetworks is present and owned by root:root
2018-06-13 08:45:48,188 [salt.state       :1934][INFO    ][25827] Completed state [/srv/salt/reclass/classes/service/avinetworks] at time 08:45:48.188758 duration_in_ms=1.45
2018-06-13 08:45:48,189 [salt.state       :1761][INFO    ][25827] Running state [/srv/salt/reclass/classes/service/postgresql] at time 08:45:48.189416
2018-06-13 08:45:48,189 [salt.state       :1794][INFO    ][25827] Executing state file.symlink for [/srv/salt/reclass/classes/service/postgresql]
2018-06-13 08:45:48,190 [salt.state       :290 ][INFO    ][25827] Symlink /srv/salt/reclass/classes/service/postgresql is present and owned by root:root
2018-06-13 08:45:48,190 [salt.state       :1934][INFO    ][25827] Completed state [/srv/salt/reclass/classes/service/postgresql] at time 08:45:48.190836 duration_in_ms=1.42
2018-06-13 08:45:48,191 [salt.state       :1761][INFO    ][25827] Running state [/srv/salt/reclass/classes/service/prometheus] at time 08:45:48.191500
2018-06-13 08:45:48,191 [salt.state       :1794][INFO    ][25827] Executing state file.symlink for [/srv/salt/reclass/classes/service/prometheus]
2018-06-13 08:45:48,192 [salt.state       :290 ][INFO    ][25827] Symlink /srv/salt/reclass/classes/service/prometheus is present and owned by root:root
2018-06-13 08:45:48,192 [salt.state       :1934][INFO    ][25827] Completed state [/srv/salt/reclass/classes/service/prometheus] at time 08:45:48.192956 duration_in_ms=1.456
2018-06-13 08:45:48,193 [salt.state       :1761][INFO    ][25827] Running state [/srv/salt/reclass/classes/service/swift] at time 08:45:48.193607
2018-06-13 08:45:48,193 [salt.state       :1794][INFO    ][25827] Executing state file.symlink for [/srv/salt/reclass/classes/service/swift]
2018-06-13 08:45:48,194 [salt.state       :290 ][INFO    ][25827] Symlink /srv/salt/reclass/classes/service/swift is present and owned by root:root
2018-06-13 08:45:48,195 [salt.state       :1934][INFO    ][25827] Completed state [/srv/salt/reclass/classes/service/swift] at time 08:45:48.195048 duration_in_ms=1.441
2018-06-13 08:45:48,195 [salt.state       :1761][INFO    ][25827] Running state [/srv/salt/reclass/classes/service/fluentd] at time 08:45:48.195732
2018-06-13 08:45:48,195 [salt.state       :1794][INFO    ][25827] Executing state file.symlink for [/srv/salt/reclass/classes/service/fluentd]
2018-06-13 08:45:48,197 [salt.state       :290 ][INFO    ][25827] Symlink /srv/salt/reclass/classes/service/fluentd is present and owned by root:root
2018-06-13 08:45:48,197 [salt.state       :1934][INFO    ][25827] Completed state [/srv/salt/reclass/classes/service/fluentd] at time 08:45:48.197167 duration_in_ms=1.435
2018-06-13 08:45:48,197 [salt.state       :1761][INFO    ][25827] Running state [/srv/salt/reclass/classes/service/billometer] at time 08:45:48.197816
2018-06-13 08:45:48,198 [salt.state       :1794][INFO    ][25827] Executing state file.symlink for [/srv/salt/reclass/classes/service/billometer]
2018-06-13 08:45:48,199 [salt.state       :290 ][INFO    ][25827] Symlink /srv/salt/reclass/classes/service/billometer is present and owned by root:root
2018-06-13 08:45:48,199 [salt.state       :1934][INFO    ][25827] Completed state [/srv/salt/reclass/classes/service/billometer] at time 08:45:48.199236 duration_in_ms=1.419
2018-06-13 08:45:48,199 [salt.state       :1761][INFO    ][25827] Running state [/srv/salt/reclass/classes/service/haproxy] at time 08:45:48.199874
2018-06-13 08:45:48,200 [salt.state       :1794][INFO    ][25827] Executing state file.symlink for [/srv/salt/reclass/classes/service/haproxy]
2018-06-13 08:45:48,201 [salt.state       :290 ][INFO    ][25827] Symlink /srv/salt/reclass/classes/service/haproxy is present and owned by root:root
2018-06-13 08:45:48,201 [salt.state       :1934][INFO    ][25827] Completed state [/srv/salt/reclass/classes/service/haproxy] at time 08:45:48.201314 duration_in_ms=1.44
2018-06-13 08:45:48,201 [salt.state       :1761][INFO    ][25827] Running state [/srv/salt/reclass/classes/service/ceilometer] at time 08:45:48.201946
2018-06-13 08:45:48,202 [salt.state       :1794][INFO    ][25827] Executing state file.symlink for [/srv/salt/reclass/classes/service/ceilometer]
2018-06-13 08:45:48,203 [salt.state       :290 ][INFO    ][25827] Symlink /srv/salt/reclass/classes/service/ceilometer is present and owned by root:root
2018-06-13 08:45:48,203 [salt.state       :1934][INFO    ][25827] Completed state [/srv/salt/reclass/classes/service/ceilometer] at time 08:45:48.203386 duration_in_ms=1.44
2018-06-13 08:45:48,204 [salt.state       :1761][INFO    ][25827] Running state [/srv/salt/reclass/classes/service/aptcacher] at time 08:45:48.204042
2018-06-13 08:45:48,204 [salt.state       :1794][INFO    ][25827] Executing state file.symlink for [/srv/salt/reclass/classes/service/aptcacher]
2018-06-13 08:45:48,205 [salt.state       :290 ][INFO    ][25827] Symlink /srv/salt/reclass/classes/service/aptcacher is present and owned by root:root
2018-06-13 08:45:48,205 [salt.state       :1934][INFO    ][25827] Completed state [/srv/salt/reclass/classes/service/aptcacher] at time 08:45:48.205460 duration_in_ms=1.418
2018-06-13 08:45:48,206 [salt.state       :1761][INFO    ][25827] Running state [/srv/salt/reclass/classes/service/nginx] at time 08:45:48.206091
2018-06-13 08:45:48,206 [salt.state       :1794][INFO    ][25827] Executing state file.symlink for [/srv/salt/reclass/classes/service/nginx]
2018-06-13 08:45:48,207 [salt.state       :290 ][INFO    ][25827] Symlink /srv/salt/reclass/classes/service/nginx is present and owned by root:root
2018-06-13 08:45:48,207 [salt.state       :1934][INFO    ][25827] Completed state [/srv/salt/reclass/classes/service/nginx] at time 08:45:48.207506 duration_in_ms=1.415
2018-06-13 08:45:48,208 [salt.state       :1761][INFO    ][25827] Running state [/srv/salt/reclass/classes/service/bind] at time 08:45:48.208188
2018-06-13 08:45:48,208 [salt.state       :1794][INFO    ][25827] Executing state file.symlink for [/srv/salt/reclass/classes/service/bind]
2018-06-13 08:45:48,209 [salt.state       :290 ][INFO    ][25827] Symlink /srv/salt/reclass/classes/service/bind is present and owned by root:root
2018-06-13 08:45:48,209 [salt.state       :1934][INFO    ][25827] Completed state [/srv/salt/reclass/classes/service/bind] at time 08:45:48.209605 duration_in_ms=1.417
2018-06-13 08:45:48,210 [salt.state       :1761][INFO    ][25827] Running state [/srv/salt/reclass/classes/service/redis] at time 08:45:48.210252
2018-06-13 08:45:48,210 [salt.state       :1794][INFO    ][25827] Executing state file.symlink for [/srv/salt/reclass/classes/service/redis]
2018-06-13 08:45:48,211 [salt.state       :290 ][INFO    ][25827] Symlink /srv/salt/reclass/classes/service/redis is present and owned by root:root
2018-06-13 08:45:48,211 [salt.state       :1934][INFO    ][25827] Completed state [/srv/salt/reclass/classes/service/redis] at time 08:45:48.211673 duration_in_ms=1.42
2018-06-13 08:45:48,212 [salt.state       :1761][INFO    ][25827] Running state [/srv/salt/reclass/classes/service/opencontrail] at time 08:45:48.212340
2018-06-13 08:45:48,212 [salt.state       :1794][INFO    ][25827] Executing state file.symlink for [/srv/salt/reclass/classes/service/opencontrail]
2018-06-13 08:45:48,213 [salt.state       :290 ][INFO    ][25827] Symlink /srv/salt/reclass/classes/service/opencontrail is present and owned by root:root
2018-06-13 08:45:48,213 [salt.state       :1934][INFO    ][25827] Completed state [/srv/salt/reclass/classes/service/opencontrail] at time 08:45:48.213750 duration_in_ms=1.41
2018-06-13 08:45:48,214 [salt.state       :1761][INFO    ][25827] Running state [/srv/salt/reclass/classes/service/logrotate] at time 08:45:48.214404
2018-06-13 08:45:48,214 [salt.state       :1794][INFO    ][25827] Executing state file.symlink for [/srv/salt/reclass/classes/service/logrotate]
2018-06-13 08:45:48,215 [salt.state       :290 ][INFO    ][25827] Symlink /srv/salt/reclass/classes/service/logrotate is present and owned by root:root
2018-06-13 08:45:48,215 [salt.state       :1934][INFO    ][25827] Completed state [/srv/salt/reclass/classes/service/logrotate] at time 08:45:48.215822 duration_in_ms=1.418
2018-06-13 08:45:48,216 [salt.state       :1761][INFO    ][25827] Running state [/srv/salt/reclass/classes/service/rabbitmq] at time 08:45:48.216498
2018-06-13 08:45:48,216 [salt.state       :1794][INFO    ][25827] Executing state file.symlink for [/srv/salt/reclass/classes/service/rabbitmq]
2018-06-13 08:45:48,217 [salt.state       :290 ][INFO    ][25827] Symlink /srv/salt/reclass/classes/service/rabbitmq is present and owned by root:root
2018-06-13 08:45:48,217 [salt.state       :1934][INFO    ][25827] Completed state [/srv/salt/reclass/classes/service/rabbitmq] at time 08:45:48.217908 duration_in_ms=1.411
2018-06-13 08:45:48,218 [salt.state       :1761][INFO    ][25827] Running state [/srv/salt/reclass/classes/service/octavia] at time 08:45:48.218562
2018-06-13 08:45:48,218 [salt.state       :1794][INFO    ][25827] Executing state file.symlink for [/srv/salt/reclass/classes/service/octavia]
2018-06-13 08:45:48,219 [salt.state       :290 ][INFO    ][25827] Symlink /srv/salt/reclass/classes/service/octavia is present and owned by root:root
2018-06-13 08:45:48,220 [salt.state       :1934][INFO    ][25827] Completed state [/srv/salt/reclass/classes/service/octavia] at time 08:45:48.219965 duration_in_ms=1.403
2018-06-13 08:45:48,220 [salt.state       :1761][INFO    ][25827] Running state [/srv/salt/reclass/classes/service/graphite] at time 08:45:48.220674
2018-06-13 08:45:48,220 [salt.state       :1794][INFO    ][25827] Executing state file.symlink for [/srv/salt/reclass/classes/service/graphite]
2018-06-13 08:45:48,221 [salt.state       :290 ][INFO    ][25827] Symlink /srv/salt/reclass/classes/service/graphite is present and owned by root:root
2018-06-13 08:45:48,222 [salt.state       :1934][INFO    ][25827] Completed state [/srv/salt/reclass/classes/service/graphite] at time 08:45:48.222087 duration_in_ms=1.412
2018-06-13 08:45:48,222 [salt.state       :1761][INFO    ][25827] Running state [/srv/salt/reclass/classes/service/elasticsearch] at time 08:45:48.222747
2018-06-13 08:45:48,224 [salt.state       :1794][INFO    ][25827] Executing state file.symlink for [/srv/salt/reclass/classes/service/elasticsearch]
2018-06-13 08:45:48,225 [salt.state       :290 ][INFO    ][25827] Symlink /srv/salt/reclass/classes/service/elasticsearch is present and owned by root:root
2018-06-13 08:45:48,225 [salt.state       :1934][INFO    ][25827] Completed state [/srv/salt/reclass/classes/service/elasticsearch] at time 08:45:48.225462 duration_in_ms=2.715
2018-06-13 08:45:48,226 [salt.state       :1761][INFO    ][25827] Running state [/srv/salt/reclass/classes/service/horizon] at time 08:45:48.226108
2018-06-13 08:45:48,226 [salt.state       :1794][INFO    ][25827] Executing state file.symlink for [/srv/salt/reclass/classes/service/horizon]
2018-06-13 08:45:48,227 [salt.state       :290 ][INFO    ][25827] Symlink /srv/salt/reclass/classes/service/horizon is present and owned by root:root
2018-06-13 08:45:48,227 [salt.state       :1934][INFO    ][25827] Completed state [/srv/salt/reclass/classes/service/horizon] at time 08:45:48.227531 duration_in_ms=1.422
2018-06-13 08:45:48,228 [salt.state       :1761][INFO    ][25827] Running state [/srv/salt/reclass/classes/service/openssh] at time 08:45:48.228217
2018-06-13 08:45:48,228 [salt.state       :1794][INFO    ][25827] Executing state file.symlink for [/srv/salt/reclass/classes/service/openssh]
2018-06-13 08:45:48,229 [salt.state       :290 ][INFO    ][25827] Symlink /srv/salt/reclass/classes/service/openssh is present and owned by root:root
2018-06-13 08:45:48,229 [salt.state       :1934][INFO    ][25827] Completed state [/srv/salt/reclass/classes/service/openssh] at time 08:45:48.229635 duration_in_ms=1.417
2018-06-13 08:45:48,230 [salt.state       :1761][INFO    ][25827] Running state [/srv/salt/reclass/classes/service/cinder] at time 08:45:48.230291
2018-06-13 08:45:48,230 [salt.state       :1794][INFO    ][25827] Executing state file.symlink for [/srv/salt/reclass/classes/service/cinder]
2018-06-13 08:45:48,231 [salt.state       :290 ][INFO    ][25827] Symlink /srv/salt/reclass/classes/service/cinder is present and owned by root:root
2018-06-13 08:45:48,231 [salt.state       :1934][INFO    ][25827] Completed state [/srv/salt/reclass/classes/service/cinder] at time 08:45:48.231700 duration_in_ms=1.409
2018-06-13 08:45:48,232 [salt.state       :1761][INFO    ][25827] Running state [/srv/salt/reclass/classes/service/docker] at time 08:45:48.232436
2018-06-13 08:45:48,232 [salt.state       :1794][INFO    ][25827] Executing state file.symlink for [/srv/salt/reclass/classes/service/docker]
2018-06-13 08:45:48,233 [salt.state       :290 ][INFO    ][25827] Symlink /srv/salt/reclass/classes/service/docker is present and owned by root:root
2018-06-13 08:45:48,233 [salt.state       :1934][INFO    ][25827] Completed state [/srv/salt/reclass/classes/service/docker] at time 08:45:48.233852 duration_in_ms=1.416
2018-06-13 08:45:48,234 [salt.state       :1761][INFO    ][25827] Running state [/srv/salt/reclass/classes/service/salt] at time 08:45:48.234527
2018-06-13 08:45:48,234 [salt.state       :1794][INFO    ][25827] Executing state file.symlink for [/srv/salt/reclass/classes/service/salt]
2018-06-13 08:45:48,235 [salt.state       :290 ][INFO    ][25827] Symlink /srv/salt/reclass/classes/service/salt is present and owned by root:root
2018-06-13 08:45:48,235 [salt.state       :1934][INFO    ][25827] Completed state [/srv/salt/reclass/classes/service/salt] at time 08:45:48.235931 duration_in_ms=1.404
2018-06-13 08:45:48,236 [salt.state       :1761][INFO    ][25827] Running state [/srv/salt/reclass/classes/service/devops_portal] at time 08:45:48.236623
2018-06-13 08:45:48,236 [salt.state       :1794][INFO    ][25827] Executing state file.symlink for [/srv/salt/reclass/classes/service/devops_portal]
2018-06-13 08:45:48,237 [salt.state       :290 ][INFO    ][25827] Symlink /srv/salt/reclass/classes/service/devops_portal is present and owned by root:root
2018-06-13 08:45:48,238 [salt.state       :1934][INFO    ][25827] Completed state [/srv/salt/reclass/classes/service/devops_portal] at time 08:45:48.238017 duration_in_ms=1.395
2018-06-13 08:45:48,238 [salt.state       :1761][INFO    ][25827] Running state [salt-minion] at time 08:45:48.238194
2018-06-13 08:45:48,238 [salt.state       :1794][INFO    ][25827] Executing state pkg.installed for [salt-minion]
2018-06-13 08:45:48,243 [salt.state       :290 ][INFO    ][25827] All specified packages are already installed
2018-06-13 08:45:48,243 [salt.state       :1934][INFO    ][25827] Completed state [salt-minion] at time 08:45:48.243441 duration_in_ms=5.247
2018-06-13 08:45:48,243 [salt.state       :1761][INFO    ][25827] Running state [salt_minion_dependency_packages] at time 08:45:48.243609
2018-06-13 08:45:48,243 [salt.state       :1794][INFO    ][25827] Executing state pkg.installed for [salt_minion_dependency_packages]
2018-06-13 08:45:48,248 [salt.state       :290 ][INFO    ][25827] All specified packages are already installed
2018-06-13 08:45:48,248 [salt.state       :1934][INFO    ][25827] Completed state [salt_minion_dependency_packages] at time 08:45:48.248893 duration_in_ms=5.284
2018-06-13 08:45:48,249 [salt.state       :1761][INFO    ][25827] Running state [/etc/salt/minion.d/minion.conf] at time 08:45:48.249698
2018-06-13 08:45:48,249 [salt.state       :1794][INFO    ][25827] Executing state file.managed for [/etc/salt/minion.d/minion.conf]
2018-06-13 08:45:48,473 [salt.state       :290 ][INFO    ][25827] File /etc/salt/minion.d/minion.conf is in the correct state
2018-06-13 08:45:48,473 [salt.state       :1934][INFO    ][25827] Completed state [/etc/salt/minion.d/minion.conf] at time 08:45:48.473816 duration_in_ms=224.117
2018-06-13 08:45:48,474 [salt.state       :1761][INFO    ][25827] Running state [/etc/salt/minion.d/_pki.conf] at time 08:45:48.474769
2018-06-13 08:45:48,475 [salt.state       :1794][INFO    ][25827] Executing state file.managed for [/etc/salt/minion.d/_pki.conf]
2018-06-13 08:45:48,480 [salt.state       :290 ][INFO    ][25827] File /etc/salt/minion.d/_pki.conf is in the correct state
2018-06-13 08:45:48,480 [salt.state       :1934][INFO    ][25827] Completed state [/etc/salt/minion.d/_pki.conf] at time 08:45:48.480709 duration_in_ms=5.94
2018-06-13 08:45:48,484 [salt.state       :1761][INFO    ][25827] Running state [salt-minion] at time 08:45:48.484189
2018-06-13 08:45:48,484 [salt.state       :1794][INFO    ][25827] Executing state service.running for [salt-minion]
2018-06-13 08:45:48,485 [salt.loaded.int.module.cmdmod:394 ][INFO    ][25827] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2018-06-13 08:45:48,507 [salt.loaded.int.module.cmdmod:394 ][INFO    ][25827] Executing command ['systemctl', 'is-active', 'salt-minion.service'] in directory '/root'
2018-06-13 08:45:48,525 [salt.loaded.int.module.cmdmod:394 ][INFO    ][25827] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2018-06-13 08:45:48,545 [salt.state       :290 ][INFO    ][25827] The service salt-minion is already running
2018-06-13 08:45:48,545 [salt.state       :1934][INFO    ][25827] Completed state [salt-minion] at time 08:45:48.545436 duration_in_ms=61.246
2018-06-13 08:45:48,549 [salt.state       :1761][INFO    ][25827] Running state [/etc/salt/grains.d] at time 08:45:48.549622
2018-06-13 08:45:48,549 [salt.state       :1794][INFO    ][25827] Executing state file.directory for [/etc/salt/grains.d]
2018-06-13 08:45:48,550 [salt.state       :290 ][INFO    ][25827] Directory /etc/salt/grains.d is in the correct state
Directory /etc/salt/grains.d updated
2018-06-13 08:45:48,551 [salt.state       :1934][INFO    ][25827] Completed state [/etc/salt/grains.d] at time 08:45:48.551079 duration_in_ms=1.457
2018-06-13 08:45:48,552 [salt.state       :1761][INFO    ][25827] Running state [/etc/salt/grains] at time 08:45:48.552184
2018-06-13 08:45:48,552 [salt.state       :1794][INFO    ][25827] Executing state file.managed for [/etc/salt/grains]
2018-06-13 08:45:48,553 [salt.state       :290 ][INFO    ][25827] File /etc/salt/grains exists with proper permissions. No changes made.
2018-06-13 08:45:48,553 [salt.state       :1934][INFO    ][25827] Completed state [/etc/salt/grains] at time 08:45:48.553241 duration_in_ms=1.057
2018-06-13 08:45:48,554 [salt.state       :1761][INFO    ][25827] Running state [/etc/salt/grains.d/placeholder] at time 08:45:48.554101
2018-06-13 08:45:48,554 [salt.state       :1794][INFO    ][25827] Executing state file.managed for [/etc/salt/grains.d/placeholder]
2018-06-13 08:45:48,554 [salt.state       :290 ][INFO    ][25827] File /etc/salt/grains.d/placeholder exists with proper permissions. No changes made.
2018-06-13 08:45:48,555 [salt.state       :1934][INFO    ][25827] Completed state [/etc/salt/grains.d/placeholder] at time 08:45:48.555116 duration_in_ms=1.015
2018-06-13 08:45:48,556 [salt.state       :1761][INFO    ][25827] Running state [/etc/salt/grains.d/sphinx] at time 08:45:48.555985
2018-06-13 08:45:48,556 [salt.state       :1794][INFO    ][25827] Executing state file.managed for [/etc/salt/grains.d/sphinx]
2018-06-13 08:45:48,558 [salt.state       :290 ][INFO    ][25827] File changed:
--- 
+++ 
@@ -15,7 +15,9 @@
               name: IP Addresses
               value:
               - 10.20.0.2
+              - 10.167.4.11
               - 127.0.0.1
+              - 192.168.11.2
         system:
           name: System
           param:

2018-06-13 08:45:48,558 [salt.state       :1934][INFO    ][25827] Completed state [/etc/salt/grains.d/sphinx] at time 08:45:48.558641 duration_in_ms=2.656
2018-06-13 08:45:48,560 [salt.state       :1761][INFO    ][25827] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 08:45:48.560274
2018-06-13 08:45:48,560 [salt.state       :1794][INFO    ][25827] Executing state cmd.wait for [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"]
2018-06-13 08:45:48,560 [salt.state       :290 ][INFO    ][25827] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2018-06-13 08:45:48,561 [salt.state       :1934][INFO    ][25827] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 08:45:48.561041 duration_in_ms=0.767
2018-06-13 08:45:48,561 [salt.state       :1761][INFO    ][25827] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 08:45:48.561254
2018-06-13 08:45:48,561 [salt.state       :1794][INFO    ][25827] Executing state cmd.mod_watch for [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"]
2018-06-13 08:45:48,562 [salt.loaded.int.module.cmdmod:394 ][INFO    ][25827] Executing command 'python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"' in directory '/root'
2018-06-13 08:45:48,739 [salt.state       :290 ][INFO    ][25827] {'pid': 26194, 'retcode': 0, 'stderr': '', 'stdout': ''}
2018-06-13 08:45:48,740 [salt.state       :1934][INFO    ][25827] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 08:45:48.740092 duration_in_ms=178.836
2018-06-13 08:45:48,742 [salt.state       :1761][INFO    ][25827] Running state [/etc/salt/grains.d/dns_records] at time 08:45:48.742661
2018-06-13 08:45:48,743 [salt.state       :1794][INFO    ][25827] Executing state file.managed for [/etc/salt/grains.d/dns_records]
2018-06-13 08:45:48,756 [salt.state       :290 ][INFO    ][25827] File /etc/salt/grains.d/dns_records is in the correct state
2018-06-13 08:45:48,756 [salt.state       :1934][INFO    ][25827] Completed state [/etc/salt/grains.d/dns_records] at time 08:45:48.756863 duration_in_ms=14.202
2018-06-13 08:45:48,760 [salt.state       :1761][INFO    ][25827] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 08:45:48.760056
2018-06-13 08:45:48,760 [salt.state       :1794][INFO    ][25827] Executing state cmd.wait for [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"]
2018-06-13 08:45:48,761 [salt.state       :290 ][INFO    ][25827] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"
2018-06-13 08:45:48,761 [salt.state       :1934][INFO    ][25827] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 08:45:48.761414 duration_in_ms=1.358
2018-06-13 08:45:48,763 [salt.state       :1761][INFO    ][25827] Running state [/etc/salt/grains.d/salt] at time 08:45:48.762975
2018-06-13 08:45:48,763 [salt.state       :1794][INFO    ][25827] Executing state file.managed for [/etc/salt/grains.d/salt]
2018-06-13 08:45:48,768 [salt.state       :290 ][INFO    ][25827] File /etc/salt/grains.d/salt is in the correct state
2018-06-13 08:45:48,768 [salt.state       :1934][INFO    ][25827] Completed state [/etc/salt/grains.d/salt] at time 08:45:48.768678 duration_in_ms=5.703
2018-06-13 08:45:48,771 [salt.state       :1761][INFO    ][25827] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 08:45:48.771645
2018-06-13 08:45:48,772 [salt.state       :1794][INFO    ][25827] Executing state cmd.wait for [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"]
2018-06-13 08:45:48,772 [salt.state       :290 ][INFO    ][25827] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2018-06-13 08:45:48,773 [salt.state       :1934][INFO    ][25827] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 08:45:48.773003 duration_in_ms=1.357
2018-06-13 08:45:48,778 [salt.state       :1761][INFO    ][25827] Running state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 08:45:48.778742
2018-06-13 08:45:48,779 [salt.state       :1794][INFO    ][25827] Executing state cmd.wait for [cat /etc/salt/grains.d/* > /etc/salt/grains]
2018-06-13 08:45:48,779 [salt.state       :290 ][INFO    ][25827] No changes made for cat /etc/salt/grains.d/* > /etc/salt/grains
2018-06-13 08:45:48,780 [salt.state       :1934][INFO    ][25827] Completed state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 08:45:48.779995 duration_in_ms=1.252
2018-06-13 08:45:48,780 [salt.state       :1761][INFO    ][25827] Running state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 08:45:48.780366
2018-06-13 08:45:48,780 [salt.state       :1794][INFO    ][25827] Executing state cmd.mod_watch for [cat /etc/salt/grains.d/* > /etc/salt/grains]
2018-06-13 08:45:48,783 [salt.loaded.int.module.cmdmod:394 ][INFO    ][25827] Executing command 'cat /etc/salt/grains.d/* > /etc/salt/grains' in directory '/root'
2018-06-13 08:45:48,802 [salt.state       :290 ][INFO    ][25827] {'pid': 26196, 'retcode': 0, 'stderr': '', 'stdout': ''}
2018-06-13 08:45:48,802 [salt.state       :1934][INFO    ][25827] Completed state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 08:45:48.802855 duration_in_ms=22.489
2018-06-13 08:45:48,805 [salt.state       :1761][INFO    ][25827] Running state [mine.update] at time 08:45:48.805250
2018-06-13 08:45:48,805 [salt.state       :1794][INFO    ][25827] Executing state module.wait for [mine.update]
2018-06-13 08:45:48,806 [salt.state       :290 ][INFO    ][25827] No changes made for mine.update
2018-06-13 08:45:48,806 [salt.state       :1934][INFO    ][25827] Completed state [mine.update] at time 08:45:48.806640 duration_in_ms=1.39
2018-06-13 08:45:48,807 [salt.state       :1761][INFO    ][25827] Running state [mine.update] at time 08:45:48.806967
2018-06-13 08:45:48,807 [salt.state       :1794][INFO    ][25827] Executing state module.mod_watch for [mine.update]
2018-06-13 08:45:48,808 [salt.utils.decorators:613 ][WARNING ][25827] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2018-06-13 08:45:49,351 [salt.state       :290 ][INFO    ][25827] {'ret': True}
2018-06-13 08:45:49,352 [salt.state       :1934][INFO    ][25827] Completed state [mine.update] at time 08:45:49.352663 duration_in_ms=545.693
2018-06-13 08:45:49,354 [salt.state       :1761][INFO    ][25827] Running state [/etc/pki/ca/salt_master_ca] at time 08:45:49.353945
2018-06-13 08:45:49,355 [salt.state       :1794][INFO    ][25827] Executing state file.directory for [/etc/pki/ca/salt_master_ca]
2018-06-13 08:45:49,357 [salt.state       :290 ][INFO    ][25827] Directory /etc/pki/ca/salt_master_ca is in the correct state
Directory /etc/pki/ca/salt_master_ca updated
2018-06-13 08:45:49,357 [salt.state       :1934][INFO    ][25827] Completed state [/etc/pki/ca/salt_master_ca] at time 08:45:49.357639 duration_in_ms=3.692
2018-06-13 08:45:49,358 [salt.state       :1761][INFO    ][25827] Running state [/etc/pki/ca/salt_master_ca/certs] at time 08:45:49.358345
2018-06-13 08:45:49,359 [salt.state       :1794][INFO    ][25827] Executing state file.directory for [/etc/pki/ca/salt_master_ca/certs]
2018-06-13 08:45:49,360 [salt.state       :290 ][INFO    ][25827] Directory /etc/pki/ca/salt_master_ca/certs is in the correct state
Directory /etc/pki/ca/salt_master_ca/certs updated
2018-06-13 08:45:49,361 [salt.state       :1934][INFO    ][25827] Completed state [/etc/pki/ca/salt_master_ca/certs] at time 08:45:49.361147 duration_in_ms=2.78
2018-06-13 08:45:49,366 [salt.state       :1761][INFO    ][25827] Running state [/etc/pki/ca/salt_master_ca/ca.key] at time 08:45:49.366526
2018-06-13 08:45:49,367 [salt.state       :1794][INFO    ][25827] Executing state x509.private_key_managed for [/etc/pki/ca/salt_master_ca/ca.key]
2018-06-13 08:45:49,385 [salt.state       :290 ][INFO    ][25827] File /etc/pki/ca/salt_master_ca/ca.key is in the correct state
2018-06-13 08:45:49,385 [salt.state       :1934][INFO    ][25827] Completed state [/etc/pki/ca/salt_master_ca/ca.key] at time 08:45:49.385661 duration_in_ms=19.134
2018-06-13 08:45:49,388 [salt.state       :1761][INFO    ][25827] Running state [/etc/pki/ca/salt_master_ca/ca.key] at time 08:45:49.388093
2018-06-13 08:45:49,388 [salt.state       :1794][INFO    ][25827] Executing state file.managed for [/etc/pki/ca/salt_master_ca/ca.key]
2018-06-13 08:45:49,390 [salt.state       :290 ][INFO    ][25827] File /etc/pki/ca/salt_master_ca/ca.key exists with proper permissions. No changes made.
2018-06-13 08:45:49,390 [salt.state       :1934][INFO    ][25827] Completed state [/etc/pki/ca/salt_master_ca/ca.key] at time 08:45:49.390852 duration_in_ms=2.758
2018-06-13 08:45:49,392 [salt.state       :1761][INFO    ][25827] Running state [/etc/pki/ca/salt_master_ca/ca.crt] at time 08:45:49.392854
2018-06-13 08:45:49,393 [salt.state       :1794][INFO    ][25827] Executing state x509.certificate_managed for [/etc/pki/ca/salt_master_ca/ca.crt]
2018-06-13 08:45:49,421 [salt.state       :290 ][INFO    ][25827] File /etc/pki/ca/salt_master_ca/ca.crt is in the correct state
2018-06-13 08:45:49,421 [salt.state       :1934][INFO    ][25827] Completed state [/etc/pki/ca/salt_master_ca/ca.crt] at time 08:45:49.421481 duration_in_ms=28.626
2018-06-13 08:45:49,423 [salt.state       :1761][INFO    ][25827] Running state [/etc/pki/ca/salt_master_ca/ca.crt] at time 08:45:49.423621
2018-06-13 08:45:49,424 [salt.state       :1794][INFO    ][25827] Executing state file.managed for [/etc/pki/ca/salt_master_ca/ca.crt]
2018-06-13 08:45:49,425 [salt.loaded.int.states.file:2144][WARNING ][25827] 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-06-13 08:45:49,426 [salt.state       :290 ][INFO    ][25827] File /etc/pki/ca/salt_master_ca/ca.crt exists with proper permissions. No changes made.
2018-06-13 08:45:49,426 [salt.state       :1934][INFO    ][25827] Completed state [/etc/pki/ca/salt_master_ca/ca.crt] at time 08:45:49.426655 duration_in_ms=3.034
2018-06-13 08:45:49,428 [salt.state       :1761][INFO    ][25827] Running state [mine.send] at time 08:45:49.428453
2018-06-13 08:45:49,429 [salt.state       :1794][INFO    ][25827] Executing state module.run for [mine.send]
2018-06-13 08:45:49,429 [salt.utils.decorators:613 ][WARNING ][25827] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2018-06-13 08:45:49,936 [salt.state       :290 ][INFO    ][25827] {'ret': True}
2018-06-13 08:45:49,937 [salt.state       :1934][INFO    ][25827] Completed state [mine.send] at time 08:45:49.937308 duration_in_ms=508.853
2018-06-13 08:45:49,937 [salt.state       :1761][INFO    ][25827] Running state [ca-certificates] at time 08:45:49.937823
2018-06-13 08:45:49,938 [salt.state       :1794][INFO    ][25827] Executing state pkg.installed for [ca-certificates]
2018-06-13 08:45:49,952 [salt.state       :290 ][INFO    ][25827] All specified packages are already installed
2018-06-13 08:45:49,953 [salt.state       :1934][INFO    ][25827] Completed state [ca-certificates] at time 08:45:49.953176 duration_in_ms=15.352
2018-06-13 08:45:49,955 [salt.state       :1761][INFO    ][25827] Running state [update-ca-certificates] at time 08:45:49.955415
2018-06-13 08:45:49,955 [salt.state       :1794][INFO    ][25827] Executing state cmd.wait for [update-ca-certificates]
2018-06-13 08:45:49,956 [salt.state       :290 ][INFO    ][25827] No changes made for update-ca-certificates
2018-06-13 08:45:49,956 [salt.state       :1934][INFO    ][25827] Completed state [update-ca-certificates] at time 08:45:49.956821 duration_in_ms=1.406
2018-06-13 08:45:49,957 [salt.state       :1761][INFO    ][25827] Running state [salt-api] at time 08:45:49.957210
2018-06-13 08:45:49,957 [salt.state       :1794][INFO    ][25827] Executing state pkg.installed for [salt-api]
2018-06-13 08:45:49,967 [salt.state       :290 ][INFO    ][25827] All specified packages are already installed
2018-06-13 08:45:49,968 [salt.state       :1934][INFO    ][25827] Completed state [salt-api] at time 08:45:49.968245 duration_in_ms=11.035
2018-06-13 08:45:49,968 [salt.state       :1761][INFO    ][25827] Running state [python-cherrypy3] at time 08:45:49.968591
2018-06-13 08:45:49,968 [salt.state       :1794][INFO    ][25827] Executing state pkg.installed for [python-cherrypy3]
2018-06-13 08:45:49,978 [salt.state       :290 ][INFO    ][25827] All specified packages are already installed
2018-06-13 08:45:49,979 [salt.state       :1934][INFO    ][25827] Completed state [python-cherrypy3] at time 08:45:49.979017 duration_in_ms=10.426
2018-06-13 08:45:49,980 [salt.state       :1761][INFO    ][25827] Running state [/etc/salt/master.d/_api.conf] at time 08:45:49.980630
2018-06-13 08:45:49,981 [salt.state       :1794][INFO    ][25827] Executing state file.managed for [/etc/salt/master.d/_api.conf]
2018-06-13 08:45:50,165 [salt.state       :290 ][INFO    ][25827] File /etc/salt/master.d/_api.conf is in the correct state
2018-06-13 08:45:50,165 [salt.state       :1934][INFO    ][25827] Completed state [/etc/salt/master.d/_api.conf] at time 08:45:50.165832 duration_in_ms=185.202
2018-06-13 08:45:50,167 [salt.state       :1761][INFO    ][25827] Running state [salt-api] at time 08:45:50.167711
2018-06-13 08:45:50,167 [salt.state       :1794][INFO    ][25827] Executing state service.running for [salt-api]
2018-06-13 08:45:50,168 [salt.loaded.int.module.cmdmod:394 ][INFO    ][25827] Executing command ['systemctl', 'status', 'salt-api.service', '-n', '0'] in directory '/root'
2018-06-13 08:45:50,182 [salt.loaded.int.module.cmdmod:394 ][INFO    ][25827] Executing command ['systemctl', 'is-active', 'salt-api.service'] in directory '/root'
2018-06-13 08:45:50,197 [salt.loaded.int.module.cmdmod:394 ][INFO    ][25827] Executing command ['systemctl', 'is-enabled', 'salt-api.service'] in directory '/root'
2018-06-13 08:45:50,206 [salt.state       :290 ][INFO    ][25827] The service salt-api is already running
2018-06-13 08:45:50,206 [salt.state       :1934][INFO    ][25827] Completed state [salt-api] at time 08:45:50.206425 duration_in_ms=38.714
2018-06-13 08:45:50,212 [salt.minion      :1725][INFO    ][25827] Returning information for job: 20180613084535335475
2018-06-13 08:47:34,809 [salt.minion      :1324][INFO    ][22345] User sudo_ubuntu Executing command state.sls with jid 20180613084734799014
2018-06-13 08:47:34,847 [salt.minion      :1448][INFO    ][26391] Starting a new job with PID 26391
2018-06-13 08:47:37,439 [salt.state       :905 ][INFO    ][26391] Loading fresh modules for state activity
2018-06-13 08:47:37,487 [salt.fileclient  :1215][INFO    ][26391] Fetching file from saltenv 'base', ** done ** 'ntp/init.sls'
2018-06-13 08:47:37,517 [salt.fileclient  :1215][INFO    ][26391] Fetching file from saltenv 'base', ** done ** 'ntp/client.sls'
2018-06-13 08:47:37,576 [salt.fileclient  :1215][INFO    ][26391] Fetching file from saltenv 'base', ** done ** 'ntp/server.sls'
2018-06-13 08:47:38,369 [salt.state       :1761][INFO    ][26391] Running state [ntp] at time 08:47:38.369751
2018-06-13 08:47:38,370 [salt.state       :1794][INFO    ][26391] Executing state pkg.installed for [ntp]
2018-06-13 08:47:38,370 [salt.loaded.int.module.cmdmod:394 ][INFO    ][26391] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}', '-W'] in directory '/root'
2018-06-13 08:47:38,841 [salt.loaded.int.module.cmdmod:394 ][INFO    ][26391] Executing command ['apt-cache', '-q', 'policy', 'ntp'] in directory '/root'
2018-06-13 08:47:38,943 [salt.loaded.int.module.cmdmod:394 ][INFO    ][26391] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2018-06-13 08:47:41,297 [salt.loaded.int.module.cmdmod:394 ][INFO    ][26391] Executing command ['dpkg', '--get-selections', '*'] in directory '/root'
2018-06-13 08:47:41,314 [salt.loaded.int.module.cmdmod:394 ][INFO    ][26391] 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-06-13 08:47:44,892 [salt.minion      :1324][INFO    ][22345] User sudo_ubuntu Executing command saltutil.find_job with jid 20180613084744871953
2018-06-13 08:47:44,917 [salt.minion      :1448][INFO    ][26905] Starting a new job with PID 26905
2018-06-13 08:47:44,954 [salt.minion      :1725][INFO    ][26905] Returning information for job: 20180613084744871953
2018-06-13 08:47:50,289 [salt.loaded.int.module.cmdmod:394 ][INFO    ][26391] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}', '-W'] in directory '/root'
2018-06-13 08:47:50,345 [salt.state       :290 ][INFO    ][26391] Made the following changes:
'ntp' changed from 'absent' to '1:4.2.8p4+dfsg-3ubuntu5.8'
'libopts25' changed from 'absent' to '1:5.18.7-3'

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

2018-06-13 08:47:50,529 [salt.state       :1934][INFO    ][26391] Completed state [/etc/ntp.conf] at time 08:47:50.529018 duration_in_ms=109.119
2018-06-13 08:47:50,845 [salt.state       :1761][INFO    ][26391] Running state [ntp] at time 08:47:50.845309
2018-06-13 08:47:50,845 [salt.state       :1794][INFO    ][26391] Executing state service.running for [ntp]
2018-06-13 08:47:50,846 [salt.loaded.int.module.cmdmod:394 ][INFO    ][26391] Executing command ['systemctl', 'status', 'ntp.service', '-n', '0'] in directory '/root'
2018-06-13 08:47:50,870 [salt.loaded.int.module.cmdmod:394 ][INFO    ][26391] Executing command ['systemctl', 'is-active', 'ntp.service'] in directory '/root'
2018-06-13 08:47:50,891 [salt.loaded.int.module.cmdmod:394 ][INFO    ][26391] Executing command ['systemctl', 'is-enabled', 'ntp.service'] in directory '/root'
2018-06-13 08:47:50,913 [salt.state       :290 ][INFO    ][26391] The service ntp is already running
2018-06-13 08:47:50,913 [salt.state       :1934][INFO    ][26391] Completed state [ntp] at time 08:47:50.913689 duration_in_ms=68.38
2018-06-13 08:47:50,914 [salt.state       :1761][INFO    ][26391] Running state [ntp] at time 08:47:50.914122
2018-06-13 08:47:50,914 [salt.state       :1794][INFO    ][26391] Executing state service.mod_watch for [ntp]
2018-06-13 08:47:50,915 [salt.loaded.int.module.cmdmod:394 ][INFO    ][26391] Executing command ['systemctl', 'is-active', 'ntp.service'] in directory '/root'
2018-06-13 08:47:50,933 [salt.loaded.int.module.cmdmod:394 ][INFO    ][26391] Executing command ['systemd-run', '--scope', 'systemctl', 'restart', 'ntp.service'] in directory '/root'
2018-06-13 08:47:51,029 [salt.state       :290 ][INFO    ][26391] {'ntp': True}
2018-06-13 08:47:51,030 [salt.state       :1934][INFO    ][26391] Completed state [ntp] at time 08:47:51.030637 duration_in_ms=116.515
2018-06-13 08:47:51,035 [salt.minion      :1725][INFO    ][26391] Returning information for job: 20180613084734799014
2018-06-13 09:44:16,196 [salt.utils.schedule:1372][INFO    ][22345] Running scheduled job: __mine_interval
2018-06-13 10:17:31,374 [salt.minion      :1324][INFO    ][22345] User root Executing command x509.sign_remote_certificate with jid 20180613101731357081
2018-06-13 10:17:31,413 [salt.minion      :1448][INFO    ][3107] Starting a new job with PID 3107
2018-06-13 10:17:31,523 [salt.minion      :1725][INFO    ][3107] Returning information for job: 20180613101731357081
2018-06-13 10:17:31,786 [salt.minion      :1324][INFO    ][22345] User root Executing command x509.sign_remote_certificate with jid 20180613101731777808
2018-06-13 10:17:31,802 [salt.minion      :1448][INFO    ][3116] Starting a new job with PID 3116
2018-06-13 10:17:31,859 [salt.minion      :1725][INFO    ][3116] Returning information for job: 20180613101731777808
2018-06-13 10:17:32,084 [salt.minion      :1324][INFO    ][22345] User root Executing command x509.sign_remote_certificate with jid 20180613101732072832
2018-06-13 10:17:32,101 [salt.minion      :1448][INFO    ][3125] Starting a new job with PID 3125
2018-06-13 10:17:32,145 [salt.minion      :1725][INFO    ][3125] Returning information for job: 20180613101732072832
2018-06-13 10:17:32,481 [salt.minion      :1324][INFO    ][22345] User root Executing command x509.sign_remote_certificate with jid 20180613101732442579
2018-06-13 10:17:32,498 [salt.minion      :1448][INFO    ][3134] Starting a new job with PID 3134
2018-06-13 10:17:32,562 [salt.minion      :1725][INFO    ][3134] Returning information for job: 20180613101732442579
2018-06-13 10:44:16,196 [salt.utils.schedule:1372][INFO    ][22345] Running scheduled job: __mine_interval
2018-06-13 11:44:16,196 [salt.utils.schedule:1372][INFO    ][22345] Running scheduled job: __mine_interval
2018-06-13 12:00:36,015 [salt.minion      :1324][INFO    ][22345] User sudo_ubuntu Executing command cp.push_dir with jid 20180613120036002782
2018-06-13 12:00:36,042 [salt.minion      :1448][INFO    ][9400] Starting a new job with PID 9400
