2018-04-10 12:24:56,374 [salt.minion      ][ERROR   ][1299] Error while bringing up minion for multi-master. Is master at 10.20.0.2 responding?
2018-04-10 12:25:46,431 [salt.minion      ][ERROR   ][1299] Error while bringing up minion for multi-master. Is master at 10.20.0.2 responding?
2018-04-10 12:25:58,185 [salt.crypt       ][ERROR   ][1299] 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-04-10 12:27:49,374 [salt.utils.parsers][WARNING ][13133] Minion received a SIGTERM. Exiting.
2018-04-10 12:28:16,178 [salt.loaded.int.states.file][WARNING ][20361] 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-04-10 12:28:30,737 [salt.loaded.int.module.cmdmod][ERROR   ][20361] Command 'while true; do salt-call saltutil.running|grep fun: && continue; salt-call --local service.restart salt-minion; break; done' failed with return code: None
2018-04-10 12:28:33,021 [salt.loaded.int.module.cmdmod][INFO    ][21419] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2018-04-10 12:28:33,035 [salt.loaded.int.module.cmdmod][INFO    ][21419] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2018-04-10 12:28:33,054 [salt.loaded.int.module.cmdmod][INFO    ][21419] Executing command ['systemd-run', '--scope', 'systemctl', 'restart', 'salt-minion.service'] in directory '/root'
2018-04-10 12:28:33,083 [salt.utils.parsers][WARNING ][20039] Minion received a SIGTERM. Exiting.
2018-04-10 12:28:34,113 [salt.cli.daemons ][INFO    ][21476] Setting up the Salt Minion "cfg01.mcp-pike-ovs-ha.local"
2018-04-10 12:28:34,196 [salt.cli.daemons ][INFO    ][21476] Starting up the Salt Minion
2018-04-10 12:28:34,197 [salt.utils.event ][INFO    ][21476] Starting pull socket on /var/run/salt/minion/minion_event_3a8f407f9c_pull.ipc
2018-04-10 12:28:34,726 [salt.minion      ][INFO    ][21476] Creating minion process manager
2018-04-10 12:28:35,820 [salt.loader.10.20.0.2.int.module.cmdmod][INFO    ][21476] Executing command ['date', '+%z'] in directory '/root'
2018-04-10 12:28:35,837 [salt.utils.schedule][INFO    ][21476] Updating job settings for scheduled job: __mine_interval
2018-04-10 12:28:35,847 [salt.minion      ][INFO    ][21476] Added mine.update to scheduler
2018-04-10 12:28:35,860 [salt.minion      ][INFO    ][21476] Minion is starting as user 'root'
2018-04-10 12:28:35,875 [salt.minion      ][INFO    ][21476] Minion is ready to receive requests!
2018-04-10 12:28:36,876 [salt.utils.schedule][INFO    ][21476] Running scheduled job: __mine_interval
2018-04-10 12:28:44,425 [salt.minion      ][INFO    ][21476] User sudo_ubuntu Executing command saltutil.find_job with jid 20180410122844410104
2018-04-10 12:28:44,444 [salt.minion      ][INFO    ][21577] Starting a new job with PID 21577
2018-04-10 12:28:44,468 [salt.minion      ][INFO    ][21577] Returning information for job: 20180410122844410104
2018-04-10 12:29:05,038 [salt.minion      ][INFO    ][21476] User sudo_ubuntu Executing command state.apply with jid 20180410122905021594
2018-04-10 12:29:05,054 [salt.minion      ][INFO    ][21624] Starting a new job with PID 21624
2018-04-10 12:29:06,549 [salt.state       ][INFO    ][21624] Loading fresh modules for state activity
2018-04-10 12:29:06,588 [salt.fileclient  ][INFO    ][21624] Fetching file from saltenv 'base', ** done ** 'linux/init.sls'
2018-04-10 12:29:06,619 [salt.fileclient  ][INFO    ][21624] Fetching file from saltenv 'base', ** done ** 'linux/system/init.sls'
2018-04-10 12:29:06,706 [salt.fileclient  ][INFO    ][21624] Fetching file from saltenv 'base', ** done ** 'linux/system/env.sls'
2018-04-10 12:29:06,775 [salt.fileclient  ][INFO    ][21624] Fetching file from saltenv 'base', ** done ** 'linux/system/profile.sls'
2018-04-10 12:29:06,842 [salt.fileclient  ][INFO    ][21624] Fetching file from saltenv 'base', ** done ** 'linux/system/repo.sls'
2018-04-10 12:29:06,958 [salt.fileclient  ][INFO    ][21624] Fetching file from saltenv 'base', ** done ** 'linux/system/package.sls'
2018-04-10 12:29:07,025 [salt.fileclient  ][INFO    ][21624] Fetching file from saltenv 'base', ** done ** 'linux/system/timezone.sls'
2018-04-10 12:29:07,102 [salt.fileclient  ][INFO    ][21624] Fetching file from saltenv 'base', ** done ** 'linux/system/kernel.sls'
2018-04-10 12:29:07,179 [salt.fileclient  ][INFO    ][21624] Fetching file from saltenv 'base', ** done ** 'linux/system/cpu.sls'
2018-04-10 12:29:07,237 [salt.fileclient  ][INFO    ][21624] Fetching file from saltenv 'base', ** done ** 'linux/system/sysfs.sls'
2018-04-10 12:29:07,301 [salt.fileclient  ][INFO    ][21624] Fetching file from saltenv 'base', ** done ** 'linux/system/locale.sls'
2018-04-10 12:29:07,493 [salt.fileclient  ][INFO    ][21624] Fetching file from saltenv 'base', ** done ** 'linux/system/limit.sls'
2018-04-10 12:29:07,554 [salt.fileclient  ][INFO    ][21624] Fetching file from saltenv 'base', ** done ** 'linux/system/systemd.sls'
2018-04-10 12:29:07,614 [salt.fileclient  ][INFO    ][21624] Fetching file from saltenv 'base', ** done ** 'linux/system/apt.sls'
2018-04-10 12:29:07,679 [salt.fileclient  ][INFO    ][21624] Fetching file from saltenv 'base', ** done ** 'linux/network/init.sls'
2018-04-10 12:29:07,742 [salt.fileclient  ][INFO    ][21624] Fetching file from saltenv 'base', ** done ** 'linux/network/hostname.sls'
2018-04-10 12:29:07,805 [salt.fileclient  ][INFO    ][21624] Fetching file from saltenv 'base', ** done ** 'linux/network/host.sls'
2018-04-10 12:29:07,902 [salt.fileclient  ][INFO    ][21624] Fetching file from saltenv 'base', ** done ** 'linux/network/interface.sls'
2018-04-10 12:29:08,026 [salt.fileclient  ][INFO    ][21624] Fetching file from saltenv 'base', ** done ** 'linux/network/proxy.sls'
2018-04-10 12:29:08,087 [salt.fileclient  ][INFO    ][21624] Fetching file from saltenv 'base', ** done ** 'linux/storage/init.sls'
2018-04-10 12:29:08,146 [salt.state       ][INFO    ][21624] Running state [/etc/environment] at time 12:29:08.146767
2018-04-10 12:29:08,147 [salt.state       ][INFO    ][21624] Executing state file.blockreplace for /etc/environment
2018-04-10 12:29:08,152 [salt.state       ][INFO    ][21624] 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-04-10 12:29:08,152 [salt.state       ][INFO    ][21624] Completed state [/etc/environment] at time 12:29:08.152957 duration_in_ms=6.191
2018-04-10 12:29:08,153 [salt.state       ][INFO    ][21624] Running state [/etc/profile.d] at time 12:29:08.153307
2018-04-10 12:29:08,153 [salt.state       ][INFO    ][21624] Executing state file.directory for /etc/profile.d
2018-04-10 12:29:08,154 [salt.state       ][INFO    ][21624] Directory /etc/profile.d is in the correct state
2018-04-10 12:29:08,154 [salt.state       ][INFO    ][21624] Completed state [/etc/profile.d] at time 12:29:08.154833 duration_in_ms=1.526
2018-04-10 12:29:08,570 [salt.state       ][INFO    ][21624] Running state [/etc/apt/apt.conf.d/99prefer_ipv4-salt] at time 12:29:08.570594
2018-04-10 12:29:08,571 [salt.state       ][INFO    ][21624] Executing state file.managed for /etc/apt/apt.conf.d/99prefer_ipv4-salt
2018-04-10 12:29:08,587 [salt.fileclient  ][INFO    ][21624] Fetching file from saltenv 'base', ** done ** 'linux/files/apt.conf'
2018-04-10 12:29:08,592 [salt.state       ][INFO    ][21624] File changed:
New file
2018-04-10 12:29:08,592 [salt.state       ][INFO    ][21624] Completed state [/etc/apt/apt.conf.d/99prefer_ipv4-salt] at time 12:29:08.592537 duration_in_ms=21.944
2018-04-10 12:29:08,593 [salt.state       ][INFO    ][21624] Running state [linux_repo_prereq_pkgs] at time 12:29:08.593168
2018-04-10 12:29:08,593 [salt.state       ][INFO    ][21624] Executing state pkg.installed for linux_repo_prereq_pkgs
2018-04-10 12:29:08,594 [salt.loaded.int.module.cmdmod][INFO    ][21624] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2018-04-10 12:29:08,875 [salt.state       ][INFO    ][21624] All specified packages are already installed
2018-04-10 12:29:08,876 [salt.state       ][INFO    ][21624] Completed state [linux_repo_prereq_pkgs] at time 12:29:08.876398 duration_in_ms=283.229
2018-04-10 12:29:08,876 [salt.state       ][INFO    ][21624] Running state [/etc/apt/apt.conf.d/99proxies-salt-saltstack] at time 12:29:08.876786
2018-04-10 12:29:08,877 [salt.state       ][INFO    ][21624] Executing state file.absent for /etc/apt/apt.conf.d/99proxies-salt-saltstack
2018-04-10 12:29:08,877 [salt.state       ][INFO    ][21624] File /etc/apt/apt.conf.d/99proxies-salt-saltstack is not present
2018-04-10 12:29:08,877 [salt.state       ][INFO    ][21624] Completed state [/etc/apt/apt.conf.d/99proxies-salt-saltstack] at time 12:29:08.877903 duration_in_ms=1.116
2018-04-10 12:29:08,878 [salt.state       ][INFO    ][21624] Running state [/etc/apt/preferences.d/saltstack] at time 12:29:08.878214
2018-04-10 12:29:08,878 [salt.state       ][INFO    ][21624] Executing state file.absent for /etc/apt/preferences.d/saltstack
2018-04-10 12:29:08,878 [salt.state       ][INFO    ][21624] {'removed': '/etc/apt/preferences.d/saltstack'}
2018-04-10 12:29:08,879 [salt.state       ][INFO    ][21624] Completed state [/etc/apt/preferences.d/saltstack] at time 12:29:08.879185 duration_in_ms=0.971
2018-04-10 12:29:08,892 [salt.state       ][INFO    ][21624] Running state [deb http://repo.saltstack.com/apt/ubuntu/16.04/amd64/2016.11 xenial main] at time 12:29:08.892526
2018-04-10 12:29:08,892 [salt.state       ][INFO    ][21624] Executing state pkgrepo.managed for deb http://repo.saltstack.com/apt/ubuntu/16.04/amd64/2016.11 xenial main
2018-04-10 12:29:09,166 [salt.loaded.int.module.cmdmod][INFO    ][21624] Executing command ['apt-key', 'add', '/var/cache/salt/minion/extrn_files/base/repo.saltstack.com/apt/ubuntu/16.04/amd64/2016.11/SALTSTACK-GPG-KEY.pub'] in directory '/root'
2018-04-10 12:29:09,392 [salt.loaded.int.module.cmdmod][INFO    ][21624] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2018-04-10 12:29:13,216 [salt.state       ][INFO    ][21624] Configured package repo 'deb http://repo.saltstack.com/apt/ubuntu/16.04/amd64/2016.11 xenial main'
2018-04-10 12:29:13,218 [salt.state       ][INFO    ][21624] Completed state [deb http://repo.saltstack.com/apt/ubuntu/16.04/amd64/2016.11 xenial main] at time 12:29:13.217910 duration_in_ms=4325.383
2018-04-10 12:29:13,218 [salt.state       ][INFO    ][21624] Running state [/etc/apt/apt.conf.d/99proxies-salt-uca-staging] at time 12:29:13.218759
2018-04-10 12:29:13,219 [salt.state       ][INFO    ][21624] Executing state file.absent for /etc/apt/apt.conf.d/99proxies-salt-uca-staging
2018-04-10 12:29:13,220 [salt.state       ][INFO    ][21624] File /etc/apt/apt.conf.d/99proxies-salt-uca-staging is not present
2018-04-10 12:29:13,221 [salt.state       ][INFO    ][21624] Completed state [/etc/apt/apt.conf.d/99proxies-salt-uca-staging] at time 12:29:13.221052 duration_in_ms=2.294
2018-04-10 12:29:13,221 [salt.state       ][INFO    ][21624] Running state [/etc/apt/preferences.d/uca-staging] at time 12:29:13.221775
2018-04-10 12:29:13,222 [salt.state       ][INFO    ][21624] Executing state file.absent for /etc/apt/preferences.d/uca-staging
2018-04-10 12:29:13,223 [salt.state       ][INFO    ][21624] File /etc/apt/preferences.d/uca-staging is not present
2018-04-10 12:29:13,223 [salt.state       ][INFO    ][21624] Completed state [/etc/apt/preferences.d/uca-staging] at time 12:29:13.223696 duration_in_ms=1.921
2018-04-10 12:29:13,225 [salt.state       ][INFO    ][21624] Running state [deb http://ppa.launchpad.net/ubuntu-cloud-archive/pike-staging/ubuntu xenial main] at time 12:29:13.225359
2018-04-10 12:29:13,225 [salt.state       ][INFO    ][21624] Executing state pkgrepo.managed for deb http://ppa.launchpad.net/ubuntu-cloud-archive/pike-staging/ubuntu xenial main
2018-04-10 12:29:13,343 [salt.loaded.int.module.cmdmod][INFO    ][21624] Executing command ['apt-key', 'export', '9F68104E'] in directory '/root'
2018-04-10 12:29:13,446 [salt.loaded.int.module.cmdmod][INFO    ][21624] Executing command ['apt-key', 'adv', '--keyserver', 'keyserver.ubuntu.com', '--logger-fd', '1', '--recv-keys', '9F68104E'] in directory '/root'
2018-04-10 12:29:14,177 [salt.loaded.int.module.cmdmod][INFO    ][21624] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2018-04-10 12:29:15,143 [salt.minion      ][INFO    ][21476] User sudo_ubuntu Executing command saltutil.find_job with jid 20180410122915129937
2018-04-10 12:29:15,165 [salt.minion      ][INFO    ][22612] Starting a new job with PID 22612
2018-04-10 12:29:15,188 [salt.minion      ][INFO    ][22612] Returning information for job: 20180410122915129937
2018-04-10 12:29:20,440 [salt.state       ][INFO    ][21624] {'repo': 'deb http://ppa.launchpad.net/ubuntu-cloud-archive/pike-staging/ubuntu xenial main'}
2018-04-10 12:29:20,441 [salt.state       ][INFO    ][21624] Completed state [deb http://ppa.launchpad.net/ubuntu-cloud-archive/pike-staging/ubuntu xenial main] at time 12:29:20.441014 duration_in_ms=7215.654
2018-04-10 12:29:20,442 [salt.state       ][INFO    ][21624] Running state [/etc/apt/apt.conf.d/99proxies-salt-salt] at time 12:29:20.441944
2018-04-10 12:29:20,442 [salt.state       ][INFO    ][21624] Executing state file.absent for /etc/apt/apt.conf.d/99proxies-salt-salt
2018-04-10 12:29:20,443 [salt.state       ][INFO    ][21624] File /etc/apt/apt.conf.d/99proxies-salt-salt is not present
2018-04-10 12:29:20,444 [salt.state       ][INFO    ][21624] Completed state [/etc/apt/apt.conf.d/99proxies-salt-salt] at time 12:29:20.444317 duration_in_ms=2.373
2018-04-10 12:29:20,445 [salt.state       ][INFO    ][21624] Running state [/etc/apt/preferences.d/salt] at time 12:29:20.444979
2018-04-10 12:29:20,445 [salt.state       ][INFO    ][21624] Executing state file.absent for /etc/apt/preferences.d/salt
2018-04-10 12:29:20,446 [salt.state       ][INFO    ][21624] File /etc/apt/preferences.d/salt is not present
2018-04-10 12:29:20,447 [salt.state       ][INFO    ][21624] Completed state [/etc/apt/preferences.d/salt] at time 12:29:20.447008 duration_in_ms=2.029
2018-04-10 12:29:20,447 [salt.state       ][INFO    ][21624] Running state [linux_repo_salt_absent] at time 12:29:20.447683
2018-04-10 12:29:20,448 [salt.state       ][INFO    ][21624] Executing state pkgrepo.absent for linux_repo_salt_absent
2018-04-10 12:29:20,489 [salt.state       ][INFO    ][21624] Package repo linux_repo_salt_absent is absent
2018-04-10 12:29:20,489 [salt.state       ][INFO    ][21624] Completed state [linux_repo_salt_absent] at time 12:29:20.489607 duration_in_ms=41.923
2018-04-10 12:29:20,490 [salt.state       ][INFO    ][21624] Running state [/etc/apt/sources.list.d/salt.list] at time 12:29:20.490175
2018-04-10 12:29:20,490 [salt.state       ][INFO    ][21624] Executing state file.absent for /etc/apt/sources.list.d/salt.list
2018-04-10 12:29:20,491 [salt.state       ][INFO    ][21624] File /etc/apt/sources.list.d/salt.list is not present
2018-04-10 12:29:20,491 [salt.state       ][INFO    ][21624] Completed state [/etc/apt/sources.list.d/salt.list] at time 12:29:20.491839 duration_in_ms=1.663
2018-04-10 12:29:20,492 [salt.state       ][INFO    ][21624] Running state [/etc/apt/apt.conf.d/99proxies-salt-uca] at time 12:29:20.492398
2018-04-10 12:29:20,492 [salt.state       ][INFO    ][21624] Executing state file.absent for /etc/apt/apt.conf.d/99proxies-salt-uca
2018-04-10 12:29:20,493 [salt.state       ][INFO    ][21624] File /etc/apt/apt.conf.d/99proxies-salt-uca is not present
2018-04-10 12:29:20,494 [salt.state       ][INFO    ][21624] Completed state [/etc/apt/apt.conf.d/99proxies-salt-uca] at time 12:29:20.494089 duration_in_ms=1.692
2018-04-10 12:29:20,494 [salt.state       ][INFO    ][21624] Running state [/etc/apt/preferences.d/uca] at time 12:29:20.494638
2018-04-10 12:29:20,495 [salt.state       ][INFO    ][21624] Executing state file.absent for /etc/apt/preferences.d/uca
2018-04-10 12:29:20,495 [salt.state       ][INFO    ][21624] File /etc/apt/preferences.d/uca is not present
2018-04-10 12:29:20,496 [salt.state       ][INFO    ][21624] Completed state [/etc/apt/preferences.d/uca] at time 12:29:20.496235 duration_in_ms=1.597
2018-04-10 12:29:20,497 [salt.state       ][INFO    ][21624] Running state [deb http://ubuntu-cloud.archive.canonical.com/ubuntu xenial-updates/pike main] at time 12:29:20.497566
2018-04-10 12:29:20,498 [salt.state       ][INFO    ][21624] Executing state pkgrepo.managed for deb http://ubuntu-cloud.archive.canonical.com/ubuntu xenial-updates/pike main
2018-04-10 12:29:20,559 [salt.loaded.int.module.cmdmod][INFO    ][21624] Executing command ['apt-key', 'export', 'EC4926EA'] in directory '/root'
2018-04-10 12:29:20,675 [salt.loaded.int.module.cmdmod][INFO    ][21624] Executing command ['apt-key', 'adv', '--keyserver', 'keyserver.ubuntu.com', '--logger-fd', '1', '--recv-keys', 'EC4926EA'] in directory '/root'
2018-04-10 12:29:21,390 [salt.loaded.int.module.cmdmod][INFO    ][21624] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2018-04-10 12:29:25,376 [salt.minion      ][INFO    ][21476] User sudo_ubuntu Executing command saltutil.find_job with jid 20180410122925358798
2018-04-10 12:29:25,396 [salt.minion      ][INFO    ][23329] Starting a new job with PID 23329
2018-04-10 12:29:25,418 [salt.minion      ][INFO    ][23329] Returning information for job: 20180410122925358798
2018-04-10 12:29:26,406 [salt.state       ][INFO    ][21624] {'repo': 'deb http://ubuntu-cloud.archive.canonical.com/ubuntu xenial-updates/pike main'}
2018-04-10 12:29:26,407 [salt.state       ][INFO    ][21624] Completed state [deb http://ubuntu-cloud.archive.canonical.com/ubuntu xenial-updates/pike main] at time 12:29:26.407551 duration_in_ms=5909.985
2018-04-10 12:29:26,408 [salt.state       ][INFO    ][21624] Running state [/etc/apt/apt.conf.d/99proxies-salt-mcp_salt] at time 12:29:26.407978
2018-04-10 12:29:26,408 [salt.state       ][INFO    ][21624] Executing state file.absent for /etc/apt/apt.conf.d/99proxies-salt-mcp_salt
2018-04-10 12:29:26,408 [salt.state       ][INFO    ][21624] File /etc/apt/apt.conf.d/99proxies-salt-mcp_salt is not present
2018-04-10 12:29:26,409 [salt.state       ][INFO    ][21624] Completed state [/etc/apt/apt.conf.d/99proxies-salt-mcp_salt] at time 12:29:26.409242 duration_in_ms=1.263
2018-04-10 12:29:26,409 [salt.state       ][INFO    ][21624] Running state [/etc/apt/preferences.d/mcp_salt] at time 12:29:26.409586
2018-04-10 12:29:26,409 [salt.state       ][INFO    ][21624] Executing state file.managed for /etc/apt/preferences.d/mcp_salt
2018-04-10 12:29:26,443 [salt.fileclient  ][INFO    ][21624] Fetching file from saltenv 'base', ** done ** 'linux/files/preferences_repo'
2018-04-10 12:29:26,505 [salt.state       ][INFO    ][21624] File changed:
New file
2018-04-10 12:29:26,506 [salt.state       ][INFO    ][21624] Completed state [/etc/apt/preferences.d/mcp_salt] at time 12:29:26.506176 duration_in_ms=96.59
2018-04-10 12:29:26,507 [salt.state       ][INFO    ][21624] Running state [deb [arch=amd64] http://apt.mirantis.com/xenial/ nightly salt] at time 12:29:26.507069
2018-04-10 12:29:26,507 [salt.state       ][INFO    ][21624] Executing state pkgrepo.managed for deb [arch=amd64] http://apt.mirantis.com/xenial/ nightly salt
2018-04-10 12:29:26,752 [salt.loaded.int.module.cmdmod][INFO    ][21624] Executing command ['apt-key', 'add', '/var/cache/salt/minion/extrn_files/base/apt.mirantis.com/public.gpg'] in directory '/root'
2018-04-10 12:29:26,992 [salt.loaded.int.module.cmdmod][INFO    ][21624] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2018-04-10 12:29:31,224 [salt.state       ][INFO    ][21624] {'repo': 'deb [arch=amd64] http://apt.mirantis.com/xenial nightly salt'}
2018-04-10 12:29:31,225 [salt.state       ][INFO    ][21624] Completed state [deb [arch=amd64] http://apt.mirantis.com/xenial/ nightly salt] at time 12:29:31.225264 duration_in_ms=4718.194
2018-04-10 12:29:31,232 [salt.state       ][INFO    ][21624] Running state [UTC] at time 12:29:31.232493
2018-04-10 12:29:31,232 [salt.state       ][INFO    ][21624] Executing state timezone.system for UTC
2018-04-10 12:29:31,233 [salt.loaded.int.module.cmdmod][INFO    ][21624] Executing command ['timedatectl'] in directory '/root'
2018-04-10 12:29:31,335 [salt.loaded.int.module.cmdmod][INFO    ][21624] Executing command ['timedatectl'] in directory '/root'
2018-04-10 12:29:31,362 [salt.loaded.int.module.cmdmod][INFO    ][21624] Executing command 'timedatectl set-timezone UTC' in directory '/root'
2018-04-10 12:29:31,390 [salt.state       ][INFO    ][21624] {'timezone': 'UTC'}
2018-04-10 12:29:31,390 [salt.state       ][INFO    ][21624] Completed state [UTC] at time 12:29:31.390489 duration_in_ms=157.996
2018-04-10 12:29:31,392 [salt.state       ][INFO    ][21624] Running state [nf_conntrack] at time 12:29:31.392266
2018-04-10 12:29:31,392 [salt.state       ][INFO    ][21624] Executing state kmod.present for nf_conntrack
2018-04-10 12:29:31,393 [salt.loaded.int.module.cmdmod][INFO    ][21624] Executing command 'lsmod' in directory '/root'
2018-04-10 12:29:31,543 [salt.loaded.int.module.cmdmod][INFO    ][21624] Executing command 'lsmod' in directory '/root'
2018-04-10 12:29:31,564 [salt.loaded.int.module.cmdmod][INFO    ][21624] Executing command 'modprobe nf_conntrack' in directory '/root'
2018-04-10 12:29:31,609 [salt.loaded.int.module.cmdmod][INFO    ][21624] Executing command 'lsmod' in directory '/root'
2018-04-10 12:29:31,647 [salt.state       ][INFO    ][21624] {'nf_conntrack': 'loaded'}
2018-04-10 12:29:31,647 [salt.state       ][INFO    ][21624] Completed state [nf_conntrack] at time 12:29:31.647890 duration_in_ms=255.624
2018-04-10 12:29:31,650 [salt.state       ][INFO    ][21624] Running state [kernel.panic] at time 12:29:31.650700
2018-04-10 12:29:31,651 [salt.state       ][INFO    ][21624] Executing state sysctl.present for kernel.panic
2018-04-10 12:29:31,669 [salt.loaded.int.module.cmdmod][INFO    ][21624] Executing command 'sysctl -a' in directory '/root'
2018-04-10 12:29:31,754 [salt.loaded.int.module.cmdmod][INFO    ][21624] Executing command 'sysctl -w kernel.panic="60"' in directory '/root'
2018-04-10 12:29:31,772 [salt.state       ][INFO    ][21624] {'kernel.panic': 60}
2018-04-10 12:29:31,773 [salt.state       ][INFO    ][21624] Completed state [kernel.panic] at time 12:29:31.773371 duration_in_ms=122.67
2018-04-10 12:29:31,774 [salt.state       ][INFO    ][21624] Running state [net.ipv4.tcp_keepalive_probes] at time 12:29:31.774368
2018-04-10 12:29:31,775 [salt.state       ][INFO    ][21624] Executing state sysctl.present for net.ipv4.tcp_keepalive_probes
2018-04-10 12:29:31,776 [salt.loaded.int.module.cmdmod][INFO    ][21624] Executing command 'sysctl -a' in directory '/root'
2018-04-10 12:29:31,817 [salt.loaded.int.module.cmdmod][INFO    ][21624] Executing command 'sysctl -w net.ipv4.tcp_keepalive_probes="8"' in directory '/root'
2018-04-10 12:29:31,834 [salt.state       ][INFO    ][21624] {'net.ipv4.tcp_keepalive_probes': 8}
2018-04-10 12:29:31,835 [salt.state       ][INFO    ][21624] Completed state [net.ipv4.tcp_keepalive_probes] at time 12:29:31.834966 duration_in_ms=60.598
2018-04-10 12:29:31,835 [salt.state       ][INFO    ][21624] Running state [fs.file-max] at time 12:29:31.835587
2018-04-10 12:29:31,836 [salt.state       ][INFO    ][21624] Executing state sysctl.present for fs.file-max
2018-04-10 12:29:31,837 [salt.loaded.int.module.cmdmod][INFO    ][21624] Executing command 'sysctl -a' in directory '/root'
2018-04-10 12:29:31,880 [salt.loaded.int.module.cmdmod][INFO    ][21624] Executing command 'sysctl -w fs.file-max="124165"' in directory '/root'
2018-04-10 12:29:31,897 [salt.state       ][INFO    ][21624] {'fs.file-max': 124165}
2018-04-10 12:29:31,898 [salt.state       ][INFO    ][21624] Completed state [fs.file-max] at time 12:29:31.898290 duration_in_ms=62.702
2018-04-10 12:29:31,898 [salt.state       ][INFO    ][21624] Running state [net.core.somaxconn] at time 12:29:31.898830
2018-04-10 12:29:31,899 [salt.state       ][INFO    ][21624] Executing state sysctl.present for net.core.somaxconn
2018-04-10 12:29:31,900 [salt.loaded.int.module.cmdmod][INFO    ][21624] Executing command 'sysctl -a' in directory '/root'
2018-04-10 12:29:31,940 [salt.loaded.int.module.cmdmod][INFO    ][21624] Executing command 'sysctl -w net.core.somaxconn="4096"' in directory '/root'
2018-04-10 12:29:31,957 [salt.state       ][INFO    ][21624] {'net.core.somaxconn': 4096}
2018-04-10 12:29:31,958 [salt.state       ][INFO    ][21624] Completed state [net.core.somaxconn] at time 12:29:31.958368 duration_in_ms=59.538
2018-04-10 12:29:31,959 [salt.state       ][INFO    ][21624] Running state [net.ipv4.tcp_max_syn_backlog] at time 12:29:31.958940
2018-04-10 12:29:31,959 [salt.state       ][INFO    ][21624] Executing state sysctl.present for net.ipv4.tcp_max_syn_backlog
2018-04-10 12:29:31,960 [salt.loaded.int.module.cmdmod][INFO    ][21624] Executing command 'sysctl -a' in directory '/root'
2018-04-10 12:29:32,003 [salt.loaded.int.module.cmdmod][INFO    ][21624] Executing command 'sysctl -w net.ipv4.tcp_max_syn_backlog="8192"' in directory '/root'
2018-04-10 12:29:32,018 [salt.state       ][INFO    ][21624] {'net.ipv4.tcp_max_syn_backlog': 8192}
2018-04-10 12:29:32,019 [salt.state       ][INFO    ][21624] Completed state [net.ipv4.tcp_max_syn_backlog] at time 12:29:32.019290 duration_in_ms=60.35
2018-04-10 12:29:32,019 [salt.state       ][INFO    ][21624] Running state [net.ipv4.tcp_tw_reuse] at time 12:29:32.019798
2018-04-10 12:29:32,020 [salt.state       ][INFO    ][21624] Executing state sysctl.present for net.ipv4.tcp_tw_reuse
2018-04-10 12:29:32,021 [salt.loaded.int.module.cmdmod][INFO    ][21624] Executing command 'sysctl -a' in directory '/root'
2018-04-10 12:29:32,060 [salt.loaded.int.module.cmdmod][INFO    ][21624] Executing command 'sysctl -w net.ipv4.tcp_tw_reuse="1"' in directory '/root'
2018-04-10 12:29:32,076 [salt.state       ][INFO    ][21624] {'net.ipv4.tcp_tw_reuse': 1}
2018-04-10 12:29:32,077 [salt.state       ][INFO    ][21624] Completed state [net.ipv4.tcp_tw_reuse] at time 12:29:32.077184 duration_in_ms=57.385
2018-04-10 12:29:32,077 [salt.state       ][INFO    ][21624] Running state [net.ipv4.tcp_congestion_control] at time 12:29:32.077738
2018-04-10 12:29:32,078 [salt.state       ][INFO    ][21624] Executing state sysctl.present for net.ipv4.tcp_congestion_control
2018-04-10 12:29:32,079 [salt.loaded.int.module.cmdmod][INFO    ][21624] Executing command 'sysctl -a' in directory '/root'
2018-04-10 12:29:32,122 [salt.loaded.int.module.cmdmod][INFO    ][21624] Executing command 'sysctl -w net.ipv4.tcp_congestion_control="yeah"' in directory '/root'
2018-04-10 12:29:32,157 [salt.state       ][INFO    ][21624] {'net.ipv4.tcp_congestion_control': 'yeah'}
2018-04-10 12:29:32,157 [salt.state       ][INFO    ][21624] Completed state [net.ipv4.tcp_congestion_control] at time 12:29:32.157631 duration_in_ms=79.893
2018-04-10 12:29:32,158 [salt.state       ][INFO    ][21624] Running state [net.ipv4.tcp_retries2] at time 12:29:32.158195
2018-04-10 12:29:32,158 [salt.state       ][INFO    ][21624] Executing state sysctl.present for net.ipv4.tcp_retries2
2018-04-10 12:29:32,159 [salt.loaded.int.module.cmdmod][INFO    ][21624] Executing command 'sysctl -a' in directory '/root'
2018-04-10 12:29:32,202 [salt.loaded.int.module.cmdmod][INFO    ][21624] Executing command 'sysctl -w net.ipv4.tcp_retries2="5"' in directory '/root'
2018-04-10 12:29:32,224 [salt.state       ][INFO    ][21624] {'net.ipv4.tcp_retries2': 5}
2018-04-10 12:29:32,225 [salt.state       ][INFO    ][21624] Completed state [net.ipv4.tcp_retries2] at time 12:29:32.225501 duration_in_ms=67.306
2018-04-10 12:29:32,226 [salt.state       ][INFO    ][21624] Running state [net.ipv4.tcp_keepalive_intvl] at time 12:29:32.226042
2018-04-10 12:29:32,226 [salt.state       ][INFO    ][21624] Executing state sysctl.present for net.ipv4.tcp_keepalive_intvl
2018-04-10 12:29:32,227 [salt.loaded.int.module.cmdmod][INFO    ][21624] Executing command 'sysctl -a' in directory '/root'
2018-04-10 12:29:32,260 [salt.loaded.int.module.cmdmod][INFO    ][21624] Executing command 'sysctl -w net.ipv4.tcp_keepalive_intvl="3"' in directory '/root'
2018-04-10 12:29:32,277 [salt.state       ][INFO    ][21624] {'net.ipv4.tcp_keepalive_intvl': 3}
2018-04-10 12:29:32,278 [salt.state       ][INFO    ][21624] Completed state [net.ipv4.tcp_keepalive_intvl] at time 12:29:32.278055 duration_in_ms=52.013
2018-04-10 12:29:32,278 [salt.state       ][INFO    ][21624] Running state [net.ipv4.tcp_slow_start_after_idle] at time 12:29:32.278706
2018-04-10 12:29:32,279 [salt.state       ][INFO    ][21624] Executing state sysctl.present for net.ipv4.tcp_slow_start_after_idle
2018-04-10 12:29:32,280 [salt.loaded.int.module.cmdmod][INFO    ][21624] Executing command 'sysctl -a' in directory '/root'
2018-04-10 12:29:32,310 [salt.loaded.int.module.cmdmod][INFO    ][21624] Executing command 'sysctl -w net.ipv4.tcp_slow_start_after_idle="0"' in directory '/root'
2018-04-10 12:29:32,326 [salt.state       ][INFO    ][21624] {'net.ipv4.tcp_slow_start_after_idle': 0}
2018-04-10 12:29:32,326 [salt.state       ][INFO    ][21624] Completed state [net.ipv4.tcp_slow_start_after_idle] at time 12:29:32.326581 duration_in_ms=47.875
2018-04-10 12:29:32,327 [salt.state       ][INFO    ][21624] Running state [vm.swappiness] at time 12:29:32.327120
2018-04-10 12:29:32,327 [salt.state       ][INFO    ][21624] Executing state sysctl.present for vm.swappiness
2018-04-10 12:29:32,328 [salt.loaded.int.module.cmdmod][INFO    ][21624] Executing command 'sysctl -a' in directory '/root'
2018-04-10 12:29:32,363 [salt.loaded.int.module.cmdmod][INFO    ][21624] Executing command 'sysctl -w vm.swappiness="10"' in directory '/root'
2018-04-10 12:29:32,379 [salt.state       ][INFO    ][21624] {'vm.swappiness': 10}
2018-04-10 12:29:32,379 [salt.state       ][INFO    ][21624] Completed state [vm.swappiness] at time 12:29:32.379549 duration_in_ms=52.429
2018-04-10 12:29:32,380 [salt.state       ][INFO    ][21624] Running state [net.core.netdev_max_backlog] at time 12:29:32.380158
2018-04-10 12:29:32,380 [salt.state       ][INFO    ][21624] Executing state sysctl.present for net.core.netdev_max_backlog
2018-04-10 12:29:32,381 [salt.loaded.int.module.cmdmod][INFO    ][21624] Executing command 'sysctl -a' in directory '/root'
2018-04-10 12:29:32,416 [salt.loaded.int.module.cmdmod][INFO    ][21624] Executing command 'sysctl -w net.core.netdev_max_backlog="261144"' in directory '/root'
2018-04-10 12:29:32,431 [salt.state       ][INFO    ][21624] {'net.core.netdev_max_backlog': 261144}
2018-04-10 12:29:32,432 [salt.state       ][INFO    ][21624] Completed state [net.core.netdev_max_backlog] at time 12:29:32.432257 duration_in_ms=52.118
2018-04-10 12:29:32,432 [salt.state       ][INFO    ][21624] Running state [net.ipv4.neigh.default.gc_thresh1] at time 12:29:32.432781
2018-04-10 12:29:32,433 [salt.state       ][INFO    ][21624] Executing state sysctl.present for net.ipv4.neigh.default.gc_thresh1
2018-04-10 12:29:32,434 [salt.loaded.int.module.cmdmod][INFO    ][21624] Executing command 'sysctl -a' in directory '/root'
2018-04-10 12:29:32,466 [salt.loaded.int.module.cmdmod][INFO    ][21624] Executing command 'sysctl -w net.ipv4.neigh.default.gc_thresh1="4096"' in directory '/root'
2018-04-10 12:29:32,481 [salt.state       ][INFO    ][21624] {'net.ipv4.neigh.default.gc_thresh1': 4096}
2018-04-10 12:29:32,481 [salt.state       ][INFO    ][21624] Completed state [net.ipv4.neigh.default.gc_thresh1] at time 12:29:32.481631 duration_in_ms=48.849
2018-04-10 12:29:32,482 [salt.state       ][INFO    ][21624] Running state [net.ipv4.neigh.default.gc_thresh2] at time 12:29:32.482221
2018-04-10 12:29:32,482 [salt.state       ][INFO    ][21624] Executing state sysctl.present for net.ipv4.neigh.default.gc_thresh2
2018-04-10 12:29:32,483 [salt.loaded.int.module.cmdmod][INFO    ][21624] Executing command 'sysctl -a' in directory '/root'
2018-04-10 12:29:32,519 [salt.loaded.int.module.cmdmod][INFO    ][21624] Executing command 'sysctl -w net.ipv4.neigh.default.gc_thresh2="8192"' in directory '/root'
2018-04-10 12:29:32,535 [salt.state       ][INFO    ][21624] {'net.ipv4.neigh.default.gc_thresh2': 8192}
2018-04-10 12:29:32,535 [salt.state       ][INFO    ][21624] Completed state [net.ipv4.neigh.default.gc_thresh2] at time 12:29:32.535459 duration_in_ms=53.239
2018-04-10 12:29:32,535 [salt.state       ][INFO    ][21624] Running state [net.ipv4.neigh.default.gc_thresh3] at time 12:29:32.535766
2018-04-10 12:29:32,536 [salt.state       ][INFO    ][21624] Executing state sysctl.present for net.ipv4.neigh.default.gc_thresh3
2018-04-10 12:29:32,536 [salt.loaded.int.module.cmdmod][INFO    ][21624] Executing command 'sysctl -a' in directory '/root'
2018-04-10 12:29:32,578 [salt.loaded.int.module.cmdmod][INFO    ][21624] Executing command 'sysctl -w net.ipv4.neigh.default.gc_thresh3="16384"' in directory '/root'
2018-04-10 12:29:32,595 [salt.state       ][INFO    ][21624] {'net.ipv4.neigh.default.gc_thresh3': 16384}
2018-04-10 12:29:32,596 [salt.state       ][INFO    ][21624] Completed state [net.ipv4.neigh.default.gc_thresh3] at time 12:29:32.596157 duration_in_ms=60.373
2018-04-10 12:29:32,596 [salt.state       ][INFO    ][21624] Running state [net.ipv4.tcp_fin_timeout] at time 12:29:32.596642
2018-04-10 12:29:32,597 [salt.state       ][INFO    ][21624] Executing state sysctl.present for net.ipv4.tcp_fin_timeout
2018-04-10 12:29:32,598 [salt.loaded.int.module.cmdmod][INFO    ][21624] Executing command 'sysctl -a' in directory '/root'
2018-04-10 12:29:32,636 [salt.loaded.int.module.cmdmod][INFO    ][21624] Executing command 'sysctl -w net.ipv4.tcp_fin_timeout="30"' in directory '/root'
2018-04-10 12:29:32,652 [salt.state       ][INFO    ][21624] {'net.ipv4.tcp_fin_timeout': 30}
2018-04-10 12:29:32,653 [salt.state       ][INFO    ][21624] Completed state [net.ipv4.tcp_fin_timeout] at time 12:29:32.653334 duration_in_ms=56.691
2018-04-10 12:29:32,653 [salt.state       ][INFO    ][21624] Running state [net.ipv4.tcp_keepalive_time] at time 12:29:32.653886
2018-04-10 12:29:32,654 [salt.state       ][INFO    ][21624] Executing state sysctl.present for net.ipv4.tcp_keepalive_time
2018-04-10 12:29:32,655 [salt.loaded.int.module.cmdmod][INFO    ][21624] Executing command 'sysctl -a' in directory '/root'
2018-04-10 12:29:32,687 [salt.loaded.int.module.cmdmod][INFO    ][21624] Executing command 'sysctl -w net.ipv4.tcp_keepalive_time="30"' in directory '/root'
2018-04-10 12:29:32,701 [salt.state       ][INFO    ][21624] {'net.ipv4.tcp_keepalive_time': 30}
2018-04-10 12:29:32,702 [salt.state       ][INFO    ][21624] Completed state [net.ipv4.tcp_keepalive_time] at time 12:29:32.702341 duration_in_ms=48.455
2018-04-10 12:29:32,702 [salt.state       ][INFO    ][21624] Running state [net.nf_conntrack_max] at time 12:29:32.702844
2018-04-10 12:29:32,703 [salt.state       ][INFO    ][21624] Executing state sysctl.present for net.nf_conntrack_max
2018-04-10 12:29:32,704 [salt.loaded.int.module.cmdmod][INFO    ][21624] Executing command 'sysctl -a' in directory '/root'
2018-04-10 12:29:32,736 [salt.loaded.int.module.cmdmod][INFO    ][21624] Executing command 'sysctl -w net.nf_conntrack_max="1048576"' in directory '/root'
2018-04-10 12:29:32,754 [salt.state       ][INFO    ][21624] {'net.nf_conntrack_max': 1048576}
2018-04-10 12:29:32,755 [salt.state       ][INFO    ][21624] Completed state [net.nf_conntrack_max] at time 12:29:32.755039 duration_in_ms=52.193
2018-04-10 12:29:32,755 [salt.state       ][INFO    ][21624] Running state [linux_sysfs_package] at time 12:29:32.755646
2018-04-10 12:29:32,756 [salt.state       ][INFO    ][21624] Executing state pkg.installed for linux_sysfs_package
2018-04-10 12:29:32,784 [salt.loaded.int.module.cmdmod][INFO    ][21624] Executing command ['apt-cache', '-q', 'policy', 'sysfsutils'] in directory '/root'
2018-04-10 12:29:32,871 [salt.loaded.int.module.cmdmod][INFO    ][21624] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2018-04-10 12:29:35,159 [salt.loaded.int.module.cmdmod][INFO    ][21624] Executing command ['dpkg', '--get-selections', '*'] in directory '/root'
2018-04-10 12:29:35,185 [salt.loaded.int.module.cmdmod][INFO    ][21624] 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-04-10 12:29:35,595 [salt.minion      ][INFO    ][21476] User sudo_ubuntu Executing command saltutil.find_job with jid 20180410122935579953
2018-04-10 12:29:35,615 [salt.minion      ][INFO    ][24465] Starting a new job with PID 24465
2018-04-10 12:29:35,639 [salt.minion      ][INFO    ][24465] Returning information for job: 20180410122935579953
2018-04-10 12:29:40,931 [salt.loaded.int.module.cmdmod][INFO    ][21624] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2018-04-10 12:29:40,986 [salt.state       ][INFO    ][21624] 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-04-10 12:29:41,006 [salt.state       ][INFO    ][21624] Loading fresh modules for state activity
2018-04-10 12:29:41,033 [salt.state       ][INFO    ][21624] Completed state [linux_sysfs_package] at time 12:29:41.033798 duration_in_ms=8278.151
2018-04-10 12:29:41,037 [salt.state       ][INFO    ][21624] Running state [/etc/sysfs.d] at time 12:29:41.037730
2018-04-10 12:29:41,038 [salt.state       ][INFO    ][21624] Executing state file.directory for /etc/sysfs.d
2018-04-10 12:29:41,041 [salt.state       ][INFO    ][21624] Directory /etc/sysfs.d is in the correct state
2018-04-10 12:29:41,042 [salt.state       ][INFO    ][21624] Completed state [/etc/sysfs.d] at time 12:29:41.042217 duration_in_ms=4.488
2018-04-10 12:29:41,224 [salt.state       ][INFO    ][21624] Running state [ondemand] at time 12:29:41.224622
2018-04-10 12:29:41,225 [salt.state       ][INFO    ][21624] Executing state service.dead for ondemand
2018-04-10 12:29:41,225 [salt.loaded.int.module.cmdmod][INFO    ][21624] Executing command ['systemctl', 'status', 'ondemand.service', '-n', '0'] in directory '/root'
2018-04-10 12:29:41,241 [salt.loaded.int.module.cmdmod][INFO    ][21624] Executing command ['systemctl', 'is-active', 'ondemand.service'] in directory '/root'
2018-04-10 12:29:41,260 [salt.loaded.int.module.cmdmod][INFO    ][21624] Executing command ['systemctl', 'is-enabled', 'ondemand.service'] in directory '/root'
2018-04-10 12:29:41,278 [salt.loaded.int.module.cmdmod][INFO    ][21624] Executing command ['systemd-run', '--scope', 'systemctl', 'stop', 'ondemand.service'] in directory '/root'
2018-04-10 12:29:41,344 [salt.loaded.int.module.cmdmod][INFO    ][21624] Executing command ['systemctl', 'is-active', 'ondemand.service'] in directory '/root'
2018-04-10 12:29:41,356 [salt.loaded.int.module.cmdmod][INFO    ][21624] Executing command ['systemctl', 'is-enabled', 'ondemand.service'] in directory '/root'
2018-04-10 12:29:41,373 [salt.loaded.int.module.cmdmod][INFO    ][21624] Executing command ['systemctl', 'is-enabled', 'ondemand.service'] in directory '/root'
2018-04-10 12:29:41,390 [salt.loaded.int.module.cmdmod][INFO    ][21624] Executing command ['systemd-run', '--scope', '/usr/sbin/update-rc.d', '-f', 'ondemand', 'remove'] in directory '/root'
2018-04-10 12:29:41,583 [salt.loaded.int.module.cmdmod][INFO    ][21624] Executing command ['systemctl', 'is-enabled', 'ondemand.service'] in directory '/root'
2018-04-10 12:29:41,612 [salt.loaded.int.module.cmdmod][INFO    ][21624] Executing command 'runlevel' in directory '/root'
2018-04-10 12:29:41,629 [salt.state       ][INFO    ][21624] {'ondemand': True}
2018-04-10 12:29:41,629 [salt.state       ][INFO    ][21624] Completed state [ondemand] at time 12:29:41.629686 duration_in_ms=405.064
2018-04-10 12:29:41,640 [salt.state       ][INFO    ][21624] Running state [cs_CZ.UTF-8] at time 12:29:41.640916
2018-04-10 12:29:41,641 [salt.state       ][INFO    ][21624] Executing state locale.present for cs_CZ.UTF-8
2018-04-10 12:29:41,642 [salt.loaded.int.module.cmdmod][INFO    ][21624] Executing command 'locale -a' in directory '/root'
2018-04-10 12:29:41,667 [salt.loaded.int.module.cmdmod][INFO    ][21624] Executing command ['locale-gen', 'cs_CZ.utf8'] in directory '/root'
2018-04-10 12:29:42,393 [salt.state       ][INFO    ][21624] {'locale': 'cs_CZ.UTF-8'}
2018-04-10 12:29:42,394 [salt.state       ][INFO    ][21624] Completed state [cs_CZ.UTF-8] at time 12:29:42.394332 duration_in_ms=753.417
2018-04-10 12:29:42,395 [salt.state       ][INFO    ][21624] Running state [en_US.UTF-8] at time 12:29:42.395426
2018-04-10 12:29:42,396 [salt.state       ][INFO    ][21624] Executing state locale.present for en_US.UTF-8
2018-04-10 12:29:42,399 [salt.loaded.int.module.cmdmod][INFO    ][21624] Executing command 'locale -a' in directory '/root'
2018-04-10 12:29:42,415 [salt.state       ][INFO    ][21624] Locale en_US.UTF-8 is already present
2018-04-10 12:29:42,416 [salt.state       ][INFO    ][21624] Completed state [en_US.UTF-8] at time 12:29:42.416492 duration_in_ms=21.065
2018-04-10 12:29:42,419 [salt.state       ][INFO    ][21624] Running state [en_US.UTF-8] at time 12:29:42.419289
2018-04-10 12:29:42,420 [salt.state       ][INFO    ][21624] Executing state locale.system for en_US.UTF-8
2018-04-10 12:29:42,421 [salt.loaded.int.module.cmdmod][INFO    ][21624] Executing command 'localectl' in directory '/root'
2018-04-10 12:29:42,497 [salt.state       ][INFO    ][21624] System locale en_US.UTF-8 already set
2018-04-10 12:29:42,498 [salt.state       ][INFO    ][21624] Completed state [en_US.UTF-8] at time 12:29:42.498091 duration_in_ms=78.802
2018-04-10 12:29:42,500 [salt.state       ][INFO    ][21624] Running state [root] at time 12:29:42.500014
2018-04-10 12:29:42,500 [salt.state       ][INFO    ][21624] Executing state user.present for root
2018-04-10 12:29:42,506 [salt.state       ][INFO    ][21624] User root is present and up to date
2018-04-10 12:29:42,506 [salt.state       ][INFO    ][21624] Completed state [root] at time 12:29:42.506218 duration_in_ms=6.205
2018-04-10 12:29:42,507 [salt.state       ][INFO    ][21624] Running state [/root] at time 12:29:42.507432
2018-04-10 12:29:42,507 [salt.state       ][INFO    ][21624] Executing state file.directory for /root
2018-04-10 12:29:42,508 [salt.state       ][INFO    ][21624] Directory /root is in the correct state
2018-04-10 12:29:42,508 [salt.state       ][INFO    ][21624] Completed state [/root] at time 12:29:42.508663 duration_in_ms=1.23
2018-04-10 12:29:42,508 [salt.state       ][INFO    ][21624] Running state [/etc/sudoers.d/90-salt-user-root] at time 12:29:42.508904
2018-04-10 12:29:42,509 [salt.state       ][INFO    ][21624] Executing state file.absent for /etc/sudoers.d/90-salt-user-root
2018-04-10 12:29:42,509 [salt.state       ][INFO    ][21624] File /etc/sudoers.d/90-salt-user-root is not present
2018-04-10 12:29:42,509 [salt.state       ][INFO    ][21624] Completed state [/etc/sudoers.d/90-salt-user-root] at time 12:29:42.509709 duration_in_ms=0.805
2018-04-10 12:29:42,509 [salt.state       ][INFO    ][21624] Running state [salt] at time 12:29:42.509945
2018-04-10 12:29:42,510 [salt.state       ][INFO    ][21624] Executing state user.present for salt
2018-04-10 12:29:42,511 [salt.state       ][INFO    ][21624] User salt is present and up to date
2018-04-10 12:29:42,511 [salt.state       ][INFO    ][21624] Completed state [salt] at time 12:29:42.511372 duration_in_ms=1.427
2018-04-10 12:29:42,512 [salt.state       ][INFO    ][21624] Running state [/var/tmp/salt] at time 12:29:42.512296
2018-04-10 12:29:42,512 [salt.state       ][INFO    ][21624] Executing state file.directory for /var/tmp/salt
2018-04-10 12:29:42,513 [salt.state       ][INFO    ][21624] Directory /var/tmp/salt is in the correct state
2018-04-10 12:29:42,513 [salt.state       ][INFO    ][21624] Completed state [/var/tmp/salt] at time 12:29:42.513506 duration_in_ms=1.21
2018-04-10 12:29:42,513 [salt.state       ][INFO    ][21624] Running state [/etc/sudoers.d/90-salt-user-salt] at time 12:29:42.513735
2018-04-10 12:29:42,513 [salt.state       ][INFO    ][21624] Executing state file.absent for /etc/sudoers.d/90-salt-user-salt
2018-04-10 12:29:42,514 [salt.state       ][INFO    ][21624] File /etc/sudoers.d/90-salt-user-salt is not present
2018-04-10 12:29:42,514 [salt.state       ][INFO    ][21624] Completed state [/etc/sudoers.d/90-salt-user-salt] at time 12:29:42.514461 duration_in_ms=0.726
2018-04-10 12:29:42,514 [salt.state       ][INFO    ][21624] Running state [ubuntu] at time 12:29:42.514692
2018-04-10 12:29:42,514 [salt.state       ][INFO    ][21624] Executing state user.present for ubuntu
2018-04-10 12:29:42,515 [salt.state       ][INFO    ][21624] User ubuntu is present and up to date
2018-04-10 12:29:42,516 [salt.state       ][INFO    ][21624] Completed state [ubuntu] at time 12:29:42.516121 duration_in_ms=1.429
2018-04-10 12:29:42,517 [salt.state       ][INFO    ][21624] Running state [/home/ubuntu] at time 12:29:42.517065
2018-04-10 12:29:42,517 [salt.state       ][INFO    ][21624] Executing state file.directory for /home/ubuntu
2018-04-10 12:29:42,518 [salt.state       ][INFO    ][21624] Directory /home/ubuntu is in the correct state
2018-04-10 12:29:42,518 [salt.state       ][INFO    ][21624] Completed state [/home/ubuntu] at time 12:29:42.518249 duration_in_ms=1.184
2018-04-10 12:29:42,519 [salt.state       ][INFO    ][21624] Running state [/etc/sudoers.d/90-salt-user-ubuntu] at time 12:29:42.519017
2018-04-10 12:29:42,519 [salt.state       ][INFO    ][21624] Executing state file.managed for /etc/sudoers.d/90-salt-user-ubuntu
2018-04-10 12:29:42,560 [salt.state       ][INFO    ][21624] File /etc/sudoers.d/90-salt-user-ubuntu is in the correct state
2018-04-10 12:29:42,560 [salt.state       ][INFO    ][21624] Completed state [/etc/sudoers.d/90-salt-user-ubuntu] at time 12:29:42.560551 duration_in_ms=41.534
2018-04-10 12:29:42,560 [salt.state       ][INFO    ][21624] Running state [/etc/security/limits.d/90-salt-default.conf] at time 12:29:42.560806
2018-04-10 12:29:42,561 [salt.state       ][INFO    ][21624] Executing state file.managed for /etc/security/limits.d/90-salt-default.conf
2018-04-10 12:29:42,598 [salt.fileclient  ][INFO    ][21624] Fetching file from saltenv 'base', ** done ** 'linux/files/limits.conf'
2018-04-10 12:29:42,699 [salt.state       ][INFO    ][21624] File changed:
New file
2018-04-10 12:29:42,699 [salt.state       ][INFO    ][21624] Completed state [/etc/security/limits.d/90-salt-default.conf] at time 12:29:42.699617 duration_in_ms=138.811
2018-04-10 12:29:42,699 [salt.state       ][INFO    ][21624] Running state [/etc/systemd/system.conf.d/90-salt.conf] at time 12:29:42.699859
2018-04-10 12:29:42,700 [salt.state       ][INFO    ][21624] Executing state file.managed for /etc/systemd/system.conf.d/90-salt.conf
2018-04-10 12:29:42,735 [salt.fileclient  ][INFO    ][21624] Fetching file from saltenv 'base', ** done ** 'linux/files/systemd.conf'
2018-04-10 12:29:42,815 [salt.state       ][INFO    ][21624] File changed:
New file
2018-04-10 12:29:42,815 [salt.state       ][INFO    ][21624] Completed state [/etc/systemd/system.conf.d/90-salt.conf] at time 12:29:42.815845 duration_in_ms=115.985
2018-04-10 12:29:42,817 [salt.state       ][INFO    ][21624] Running state [service.systemctl_reload] at time 12:29:42.817065
2018-04-10 12:29:42,817 [salt.state       ][INFO    ][21624] Executing state module.wait for service.systemctl_reload
2018-04-10 12:29:42,817 [salt.state       ][INFO    ][21624] No changes made for service.systemctl_reload
2018-04-10 12:29:42,817 [salt.state       ][INFO    ][21624] Completed state [service.systemctl_reload] at time 12:29:42.817750 duration_in_ms=0.685
2018-04-10 12:29:42,817 [salt.state       ][INFO    ][21624] Running state [service.systemctl_reload] at time 12:29:42.817911
2018-04-10 12:29:42,818 [salt.state       ][INFO    ][21624] Executing state module.mod_watch for service.systemctl_reload
2018-04-10 12:29:42,818 [salt.loaded.int.module.cmdmod][INFO    ][21624] Executing command ['systemctl', '--system', 'daemon-reload'] in directory '/root'
2018-04-10 12:29:42,922 [salt.state       ][INFO    ][21624] {'ret': True}
2018-04-10 12:29:42,922 [salt.state       ][INFO    ][21624] Completed state [service.systemctl_reload] at time 12:29:42.922870 duration_in_ms=104.955
2018-04-10 12:29:42,923 [salt.state       ][INFO    ][21624] Running state [/etc/hostname] at time 12:29:42.923560
2018-04-10 12:29:42,924 [salt.state       ][INFO    ][21624] Executing state file.managed for /etc/hostname
2018-04-10 12:29:42,955 [salt.fileclient  ][INFO    ][21624] Fetching file from saltenv 'base', ** done ** 'linux/files/hostname'
2018-04-10 12:29:42,959 [salt.state       ][INFO    ][21624] File /etc/hostname is in the correct state
2018-04-10 12:29:42,959 [salt.state       ][INFO    ][21624] Completed state [/etc/hostname] at time 12:29:42.959806 duration_in_ms=36.246
2018-04-10 12:29:42,963 [salt.state       ][INFO    ][21624] Running state [hostname cfg01] at time 12:29:42.963423
2018-04-10 12:29:42,963 [salt.state       ][INFO    ][21624] Executing state cmd.wait for hostname cfg01
2018-04-10 12:29:42,964 [salt.state       ][INFO    ][21624] No changes made for hostname cfg01
2018-04-10 12:29:42,964 [salt.state       ][INFO    ][21624] Completed state [hostname cfg01] at time 12:29:42.964610 duration_in_ms=1.187
2018-04-10 12:29:42,966 [salt.state       ][INFO    ][21624] Running state [mdb02] at time 12:29:42.965961
2018-04-10 12:29:42,966 [salt.state       ][INFO    ][21624] Executing state host.present for mdb02
2018-04-10 12:29:42,969 [salt.state       ][INFO    ][21624] {'host': 'mdb02'}
2018-04-10 12:29:42,970 [salt.state       ][INFO    ][21624] Completed state [mdb02] at time 12:29:42.970161 duration_in_ms=4.2
2018-04-10 12:29:42,970 [salt.state       ][INFO    ][21624] Running state [mdb02.mcp-pike-ovs-ha.local] at time 12:29:42.970556
2018-04-10 12:29:42,970 [salt.state       ][INFO    ][21624] Executing state host.present for mdb02.mcp-pike-ovs-ha.local
2018-04-10 12:29:42,979 [salt.state       ][INFO    ][21624] {'host': 'mdb02.mcp-pike-ovs-ha.local'}
2018-04-10 12:29:42,979 [salt.state       ][INFO    ][21624] Completed state [mdb02.mcp-pike-ovs-ha.local] at time 12:29:42.979859 duration_in_ms=9.302
2018-04-10 12:29:42,980 [salt.state       ][INFO    ][21624] Running state [mdb03] at time 12:29:42.980239
2018-04-10 12:29:42,980 [salt.state       ][INFO    ][21624] Executing state host.present for mdb03
2018-04-10 12:29:42,985 [salt.state       ][INFO    ][21624] {'host': 'mdb03'}
2018-04-10 12:29:42,985 [salt.state       ][INFO    ][21624] Completed state [mdb03] at time 12:29:42.985803 duration_in_ms=5.563
2018-04-10 12:29:42,986 [salt.state       ][INFO    ][21624] Running state [mdb03.mcp-pike-ovs-ha.local] at time 12:29:42.986167
2018-04-10 12:29:42,986 [salt.state       ][INFO    ][21624] Executing state host.present for mdb03.mcp-pike-ovs-ha.local
2018-04-10 12:29:42,991 [salt.state       ][INFO    ][21624] {'host': 'mdb03.mcp-pike-ovs-ha.local'}
2018-04-10 12:29:42,991 [salt.state       ][INFO    ][21624] Completed state [mdb03.mcp-pike-ovs-ha.local] at time 12:29:42.991910 duration_in_ms=5.743
2018-04-10 12:29:42,992 [salt.state       ][INFO    ][21624] Running state [mdb01] at time 12:29:42.992282
2018-04-10 12:29:42,992 [salt.state       ][INFO    ][21624] Executing state host.present for mdb01
2018-04-10 12:29:42,997 [salt.state       ][INFO    ][21624] {'host': 'mdb01'}
2018-04-10 12:29:42,997 [salt.state       ][INFO    ][21624] Completed state [mdb01] at time 12:29:42.997872 duration_in_ms=5.59
2018-04-10 12:29:42,998 [salt.state       ][INFO    ][21624] Running state [mdb01.mcp-pike-ovs-ha.local] at time 12:29:42.998241
2018-04-10 12:29:42,998 [salt.state       ][INFO    ][21624] Executing state host.present for mdb01.mcp-pike-ovs-ha.local
2018-04-10 12:29:43,003 [salt.state       ][INFO    ][21624] {'host': 'mdb01.mcp-pike-ovs-ha.local'}
2018-04-10 12:29:43,004 [salt.state       ][INFO    ][21624] Completed state [mdb01.mcp-pike-ovs-ha.local] at time 12:29:43.003941 duration_in_ms=5.7
2018-04-10 12:29:43,004 [salt.state       ][INFO    ][21624] Running state [mdb] at time 12:29:43.004314
2018-04-10 12:29:43,004 [salt.state       ][INFO    ][21624] Executing state host.present for mdb
2018-04-10 12:29:43,009 [salt.state       ][INFO    ][21624] {'host': 'mdb'}
2018-04-10 12:29:43,009 [salt.state       ][INFO    ][21624] Completed state [mdb] at time 12:29:43.009930 duration_in_ms=5.616
2018-04-10 12:29:43,010 [salt.state       ][INFO    ][21624] Running state [mdb.mcp-pike-ovs-ha.local] at time 12:29:43.010294
2018-04-10 12:29:43,010 [salt.state       ][INFO    ][21624] Executing state host.present for mdb.mcp-pike-ovs-ha.local
2018-04-10 12:29:43,015 [salt.state       ][INFO    ][21624] {'host': 'mdb.mcp-pike-ovs-ha.local'}
2018-04-10 12:29:43,015 [salt.state       ][INFO    ][21624] Completed state [mdb.mcp-pike-ovs-ha.local] at time 12:29:43.015925 duration_in_ms=5.631
2018-04-10 12:29:43,016 [salt.state       ][INFO    ][21624] Running state [cfg01] at time 12:29:43.016298
2018-04-10 12:29:43,016 [salt.state       ][INFO    ][21624] Executing state host.present for cfg01
2018-04-10 12:29:43,021 [salt.state       ][INFO    ][21624] {'host': 'cfg01'}
2018-04-10 12:29:43,022 [salt.state       ][INFO    ][21624] Completed state [cfg01] at time 12:29:43.021959 duration_in_ms=5.661
2018-04-10 12:29:43,022 [salt.state       ][INFO    ][21624] Running state [cfg01.mcp-pike-ovs-ha.local] at time 12:29:43.022331
2018-04-10 12:29:43,022 [salt.state       ][INFO    ][21624] Executing state host.present for cfg01.mcp-pike-ovs-ha.local
2018-04-10 12:29:43,027 [salt.state       ][INFO    ][21624] {'host': 'cfg01.mcp-pike-ovs-ha.local'}
2018-04-10 12:29:43,028 [salt.state       ][INFO    ][21624] Completed state [cfg01.mcp-pike-ovs-ha.local] at time 12:29:43.028025 duration_in_ms=5.693
2018-04-10 12:29:43,028 [salt.state       ][INFO    ][21624] Running state [prx01] at time 12:29:43.028416
2018-04-10 12:29:43,028 [salt.state       ][INFO    ][21624] Executing state host.present for prx01
2018-04-10 12:29:43,033 [salt.state       ][INFO    ][21624] {'host': 'prx01'}
2018-04-10 12:29:43,034 [salt.state       ][INFO    ][21624] Completed state [prx01] at time 12:29:43.033990 duration_in_ms=5.574
2018-04-10 12:29:43,034 [salt.state       ][INFO    ][21624] Running state [prx01.mcp-pike-ovs-ha.local] at time 12:29:43.034366
2018-04-10 12:29:43,034 [salt.state       ][INFO    ][21624] Executing state host.present for prx01.mcp-pike-ovs-ha.local
2018-04-10 12:29:43,039 [salt.state       ][INFO    ][21624] {'host': 'prx01.mcp-pike-ovs-ha.local'}
2018-04-10 12:29:43,040 [salt.state       ][INFO    ][21624] Completed state [prx01.mcp-pike-ovs-ha.local] at time 12:29:43.040017 duration_in_ms=5.65
2018-04-10 12:29:43,040 [salt.state       ][INFO    ][21624] Running state [kvm01] at time 12:29:43.040404
2018-04-10 12:29:43,040 [salt.state       ][INFO    ][21624] Executing state host.present for kvm01
2018-04-10 12:29:43,045 [salt.state       ][INFO    ][21624] {'host': 'kvm01'}
2018-04-10 12:29:43,045 [salt.state       ][INFO    ][21624] Completed state [kvm01] at time 12:29:43.045933 duration_in_ms=5.528
2018-04-10 12:29:43,046 [salt.state       ][INFO    ][21624] Running state [kvm01.mcp-pike-ovs-ha.local] at time 12:29:43.046322
2018-04-10 12:29:43,046 [salt.state       ][INFO    ][21624] Executing state host.present for kvm01.mcp-pike-ovs-ha.local
2018-04-10 12:29:43,051 [salt.state       ][INFO    ][21624] {'host': 'kvm01.mcp-pike-ovs-ha.local'}
2018-04-10 12:29:43,052 [salt.state       ][INFO    ][21624] Completed state [kvm01.mcp-pike-ovs-ha.local] at time 12:29:43.052101 duration_in_ms=5.779
2018-04-10 12:29:43,052 [salt.state       ][INFO    ][21624] Running state [kvm03] at time 12:29:43.052500
2018-04-10 12:29:43,052 [salt.state       ][INFO    ][21624] Executing state host.present for kvm03
2018-04-10 12:29:43,059 [salt.state       ][INFO    ][21624] {'host': 'kvm03'}
2018-04-10 12:29:43,059 [salt.state       ][INFO    ][21624] Completed state [kvm03] at time 12:29:43.059637 duration_in_ms=7.138
2018-04-10 12:29:43,060 [salt.state       ][INFO    ][21624] Running state [kvm03.mcp-pike-ovs-ha.local] at time 12:29:43.059975
2018-04-10 12:29:43,060 [salt.state       ][INFO    ][21624] Executing state host.present for kvm03.mcp-pike-ovs-ha.local
2018-04-10 12:29:43,081 [salt.state       ][INFO    ][21624] {'host': 'kvm03.mcp-pike-ovs-ha.local'}
2018-04-10 12:29:43,082 [salt.state       ][INFO    ][21624] Completed state [kvm03.mcp-pike-ovs-ha.local] at time 12:29:43.082091 duration_in_ms=22.115
2018-04-10 12:29:43,082 [salt.state       ][INFO    ][21624] Running state [kvm02] at time 12:29:43.082508
2018-04-10 12:29:43,082 [salt.state       ][INFO    ][21624] Executing state host.present for kvm02
2018-04-10 12:29:43,087 [salt.state       ][INFO    ][21624] {'host': 'kvm02'}
2018-04-10 12:29:43,088 [salt.state       ][INFO    ][21624] Completed state [kvm02] at time 12:29:43.088129 duration_in_ms=5.621
2018-04-10 12:29:43,088 [salt.state       ][INFO    ][21624] Running state [kvm02.mcp-pike-ovs-ha.local] at time 12:29:43.088548
2018-04-10 12:29:43,088 [salt.state       ][INFO    ][21624] Executing state host.present for kvm02.mcp-pike-ovs-ha.local
2018-04-10 12:29:43,093 [salt.state       ][INFO    ][21624] {'host': 'kvm02.mcp-pike-ovs-ha.local'}
2018-04-10 12:29:43,094 [salt.state       ][INFO    ][21624] Completed state [kvm02.mcp-pike-ovs-ha.local] at time 12:29:43.094105 duration_in_ms=5.557
2018-04-10 12:29:43,094 [salt.state       ][INFO    ][21624] Running state [dbs] at time 12:29:43.094517
2018-04-10 12:29:43,094 [salt.state       ][INFO    ][21624] Executing state host.present for dbs
2018-04-10 12:29:43,099 [salt.state       ][INFO    ][21624] {'host': 'dbs'}
2018-04-10 12:29:43,100 [salt.state       ][INFO    ][21624] Completed state [dbs] at time 12:29:43.100222 duration_in_ms=5.705
2018-04-10 12:29:43,100 [salt.state       ][INFO    ][21624] Running state [dbs.mcp-pike-ovs-ha.local] at time 12:29:43.100606
2018-04-10 12:29:43,100 [salt.state       ][INFO    ][21624] Executing state host.present for dbs.mcp-pike-ovs-ha.local
2018-04-10 12:29:43,105 [salt.state       ][INFO    ][21624] {'host': 'dbs.mcp-pike-ovs-ha.local'}
2018-04-10 12:29:43,106 [salt.state       ][INFO    ][21624] Completed state [dbs.mcp-pike-ovs-ha.local] at time 12:29:43.106072 duration_in_ms=5.465
2018-04-10 12:29:43,106 [salt.state       ][INFO    ][21624] Running state [prx] at time 12:29:43.106485
2018-04-10 12:29:43,106 [salt.state       ][INFO    ][21624] Executing state host.present for prx
2018-04-10 12:29:43,111 [salt.state       ][INFO    ][21624] {'host': 'prx'}
2018-04-10 12:29:43,112 [salt.state       ][INFO    ][21624] Completed state [prx] at time 12:29:43.112229 duration_in_ms=5.744
2018-04-10 12:29:43,112 [salt.state       ][INFO    ][21624] Running state [prx.mcp-pike-ovs-ha.local] at time 12:29:43.112612
2018-04-10 12:29:43,112 [salt.state       ][INFO    ][21624] Executing state host.present for prx.mcp-pike-ovs-ha.local
2018-04-10 12:29:43,117 [salt.state       ][INFO    ][21624] {'host': 'prx.mcp-pike-ovs-ha.local'}
2018-04-10 12:29:43,118 [salt.state       ][INFO    ][21624] Completed state [prx.mcp-pike-ovs-ha.local] at time 12:29:43.118142 duration_in_ms=5.53
2018-04-10 12:29:43,118 [salt.state       ][INFO    ][21624] Running state [prx02] at time 12:29:43.118554
2018-04-10 12:29:43,118 [salt.state       ][INFO    ][21624] Executing state host.present for prx02
2018-04-10 12:29:43,123 [salt.state       ][INFO    ][21624] {'host': 'prx02'}
2018-04-10 12:29:43,124 [salt.state       ][INFO    ][21624] Completed state [prx02] at time 12:29:43.124259 duration_in_ms=5.705
2018-04-10 12:29:43,124 [salt.state       ][INFO    ][21624] Running state [prx02.mcp-pike-ovs-ha.local] at time 12:29:43.124644
2018-04-10 12:29:43,125 [salt.state       ][INFO    ][21624] Executing state host.present for prx02.mcp-pike-ovs-ha.local
2018-04-10 12:29:43,129 [salt.state       ][INFO    ][21624] {'host': 'prx02.mcp-pike-ovs-ha.local'}
2018-04-10 12:29:43,130 [salt.state       ][INFO    ][21624] Completed state [prx02.mcp-pike-ovs-ha.local] at time 12:29:43.130219 duration_in_ms=5.575
2018-04-10 12:29:43,130 [salt.state       ][INFO    ][21624] Running state [msg02] at time 12:29:43.130602
2018-04-10 12:29:43,130 [salt.state       ][INFO    ][21624] Executing state host.present for msg02
2018-04-10 12:29:43,135 [salt.state       ][INFO    ][21624] {'host': 'msg02'}
2018-04-10 12:29:43,136 [salt.state       ][INFO    ][21624] Completed state [msg02] at time 12:29:43.136226 duration_in_ms=5.624
2018-04-10 12:29:43,136 [salt.state       ][INFO    ][21624] Running state [msg02.mcp-pike-ovs-ha.local] at time 12:29:43.136607
2018-04-10 12:29:43,136 [salt.state       ][INFO    ][21624] Executing state host.present for msg02.mcp-pike-ovs-ha.local
2018-04-10 12:29:43,141 [salt.state       ][INFO    ][21624] {'host': 'msg02.mcp-pike-ovs-ha.local'}
2018-04-10 12:29:43,142 [salt.state       ][INFO    ][21624] Completed state [msg02.mcp-pike-ovs-ha.local] at time 12:29:43.142250 duration_in_ms=5.643
2018-04-10 12:29:43,142 [salt.state       ][INFO    ][21624] Running state [msg03] at time 12:29:43.142646
2018-04-10 12:29:43,143 [salt.state       ][INFO    ][21624] Executing state host.present for msg03
2018-04-10 12:29:43,245 [salt.state       ][INFO    ][21624] {'host': 'msg03'}
2018-04-10 12:29:43,246 [salt.state       ][INFO    ][21624] Completed state [msg03] at time 12:29:43.246020 duration_in_ms=103.373
2018-04-10 12:29:43,246 [salt.state       ][INFO    ][21624] Running state [msg03.mcp-pike-ovs-ha.local] at time 12:29:43.246434
2018-04-10 12:29:43,246 [salt.state       ][INFO    ][21624] Executing state host.present for msg03.mcp-pike-ovs-ha.local
2018-04-10 12:29:43,248 [salt.state       ][INFO    ][21624] {'host': 'msg03.mcp-pike-ovs-ha.local'}
2018-04-10 12:29:43,248 [salt.state       ][INFO    ][21624] Completed state [msg03.mcp-pike-ovs-ha.local] at time 12:29:43.248617 duration_in_ms=2.182
2018-04-10 12:29:43,249 [salt.state       ][INFO    ][21624] Running state [msg01] at time 12:29:43.248959
2018-04-10 12:29:43,249 [salt.state       ][INFO    ][21624] Executing state host.present for msg01
2018-04-10 12:29:43,253 [salt.state       ][INFO    ][21624] {'host': 'msg01'}
2018-04-10 12:29:43,254 [salt.state       ][INFO    ][21624] Completed state [msg01] at time 12:29:43.253944 duration_in_ms=4.985
2018-04-10 12:29:43,254 [salt.state       ][INFO    ][21624] Running state [msg01.mcp-pike-ovs-ha.local] at time 12:29:43.254277
2018-04-10 12:29:43,254 [salt.state       ][INFO    ][21624] Executing state host.present for msg01.mcp-pike-ovs-ha.local
2018-04-10 12:29:43,259 [salt.state       ][INFO    ][21624] {'host': 'msg01.mcp-pike-ovs-ha.local'}
2018-04-10 12:29:43,259 [salt.state       ][INFO    ][21624] Completed state [msg01.mcp-pike-ovs-ha.local] at time 12:29:43.259857 duration_in_ms=5.579
2018-04-10 12:29:43,260 [salt.state       ][INFO    ][21624] Running state [msg] at time 12:29:43.260161
2018-04-10 12:29:43,260 [salt.state       ][INFO    ][21624] Executing state host.present for msg
2018-04-10 12:29:43,265 [salt.state       ][INFO    ][21624] {'host': 'msg'}
2018-04-10 12:29:43,266 [salt.state       ][INFO    ][21624] Completed state [msg] at time 12:29:43.265986 duration_in_ms=5.824
2018-04-10 12:29:43,266 [salt.state       ][INFO    ][21624] Running state [msg.mcp-pike-ovs-ha.local] at time 12:29:43.266402
2018-04-10 12:29:43,266 [salt.state       ][INFO    ][21624] Executing state host.present for msg.mcp-pike-ovs-ha.local
2018-04-10 12:29:43,271 [salt.state       ][INFO    ][21624] {'host': 'msg.mcp-pike-ovs-ha.local'}
2018-04-10 12:29:43,272 [salt.state       ][INFO    ][21624] Completed state [msg.mcp-pike-ovs-ha.local] at time 12:29:43.272011 duration_in_ms=5.609
2018-04-10 12:29:43,272 [salt.state       ][INFO    ][21624] Running state [cfg01] at time 12:29:43.272358
2018-04-10 12:29:43,272 [salt.state       ][INFO    ][21624] Executing state host.present for cfg01
2018-04-10 12:29:43,273 [salt.state       ][INFO    ][21624] Host cfg01 (10.167.4.11) already present
2018-04-10 12:29:43,273 [salt.state       ][INFO    ][21624] Completed state [cfg01] at time 12:29:43.273570 duration_in_ms=1.212
2018-04-10 12:29:43,273 [salt.state       ][INFO    ][21624] Running state [cfg01.mcp-pike-ovs-ha.local] at time 12:29:43.273872
2018-04-10 12:29:43,274 [salt.state       ][INFO    ][21624] Executing state host.present for cfg01.mcp-pike-ovs-ha.local
2018-04-10 12:29:43,274 [salt.state       ][INFO    ][21624] Host cfg01.mcp-pike-ovs-ha.local (10.167.4.11) already present
2018-04-10 12:29:43,275 [salt.state       ][INFO    ][21624] Completed state [cfg01.mcp-pike-ovs-ha.local] at time 12:29:43.275215 duration_in_ms=1.343
2018-04-10 12:29:43,275 [salt.state       ][INFO    ][21624] Running state [cmp002] at time 12:29:43.275534
2018-04-10 12:29:43,275 [salt.state       ][INFO    ][21624] Executing state host.present for cmp002
2018-04-10 12:29:43,277 [salt.state       ][INFO    ][21624] {'host': 'cmp002'}
2018-04-10 12:29:43,277 [salt.state       ][INFO    ][21624] Completed state [cmp002] at time 12:29:43.277857 duration_in_ms=2.322
2018-04-10 12:29:43,278 [salt.state       ][INFO    ][21624] Running state [cmp002.mcp-pike-ovs-ha.local] at time 12:29:43.278280
2018-04-10 12:29:43,278 [salt.state       ][INFO    ][21624] Executing state host.present for cmp002.mcp-pike-ovs-ha.local
2018-04-10 12:29:43,283 [salt.state       ][INFO    ][21624] {'host': 'cmp002.mcp-pike-ovs-ha.local'}
2018-04-10 12:29:43,284 [salt.state       ][INFO    ][21624] Completed state [cmp002.mcp-pike-ovs-ha.local] at time 12:29:43.284046 duration_in_ms=5.765
2018-04-10 12:29:43,284 [salt.state       ][INFO    ][21624] Running state [cmp001] at time 12:29:43.284390
2018-04-10 12:29:43,284 [salt.state       ][INFO    ][21624] Executing state host.present for cmp001
2018-04-10 12:29:43,289 [salt.state       ][INFO    ][21624] {'host': 'cmp001'}
2018-04-10 12:29:43,290 [salt.state       ][INFO    ][21624] Completed state [cmp001] at time 12:29:43.290131 duration_in_ms=5.74
2018-04-10 12:29:43,290 [salt.state       ][INFO    ][21624] Running state [cmp001.mcp-pike-ovs-ha.local] at time 12:29:43.290483
2018-04-10 12:29:43,290 [salt.state       ][INFO    ][21624] Executing state host.present for cmp001.mcp-pike-ovs-ha.local
2018-04-10 12:29:43,295 [salt.state       ][INFO    ][21624] {'host': 'cmp001.mcp-pike-ovs-ha.local'}
2018-04-10 12:29:43,296 [salt.state       ][INFO    ][21624] Completed state [cmp001.mcp-pike-ovs-ha.local] at time 12:29:43.296100 duration_in_ms=5.617
2018-04-10 12:29:43,296 [salt.state       ][INFO    ][21624] Running state [dbs01] at time 12:29:43.296449
2018-04-10 12:29:43,296 [salt.state       ][INFO    ][21624] Executing state host.present for dbs01
2018-04-10 12:29:43,306 [salt.state       ][INFO    ][21624] {'host': 'dbs01'}
2018-04-10 12:29:43,307 [salt.state       ][INFO    ][21624] Completed state [dbs01] at time 12:29:43.306984 duration_in_ms=10.534
2018-04-10 12:29:43,307 [salt.state       ][INFO    ][21624] Running state [dbs01.mcp-pike-ovs-ha.local] at time 12:29:43.307329
2018-04-10 12:29:43,307 [salt.state       ][INFO    ][21624] Executing state host.present for dbs01.mcp-pike-ovs-ha.local
2018-04-10 12:29:43,312 [salt.state       ][INFO    ][21624] {'host': 'dbs01.mcp-pike-ovs-ha.local'}
2018-04-10 12:29:43,312 [salt.state       ][INFO    ][21624] Completed state [dbs01.mcp-pike-ovs-ha.local] at time 12:29:43.312764 duration_in_ms=5.434
2018-04-10 12:29:43,313 [salt.state       ][INFO    ][21624] Running state [dbs02] at time 12:29:43.313076
2018-04-10 12:29:43,313 [salt.state       ][INFO    ][21624] Executing state host.present for dbs02
2018-04-10 12:29:43,318 [salt.state       ][INFO    ][21624] {'host': 'dbs02'}
2018-04-10 12:29:43,318 [salt.state       ][INFO    ][21624] Completed state [dbs02] at time 12:29:43.318759 duration_in_ms=5.683
2018-04-10 12:29:43,319 [salt.state       ][INFO    ][21624] Running state [dbs02.mcp-pike-ovs-ha.local] at time 12:29:43.319074
2018-04-10 12:29:43,319 [salt.state       ][INFO    ][21624] Executing state host.present for dbs02.mcp-pike-ovs-ha.local
2018-04-10 12:29:43,324 [salt.state       ][INFO    ][21624] {'host': 'dbs02.mcp-pike-ovs-ha.local'}
2018-04-10 12:29:43,325 [salt.state       ][INFO    ][21624] Completed state [dbs02.mcp-pike-ovs-ha.local] at time 12:29:43.324927 duration_in_ms=5.853
2018-04-10 12:29:43,325 [salt.state       ][INFO    ][21624] Running state [dbs03] at time 12:29:43.325453
2018-04-10 12:29:43,325 [salt.state       ][INFO    ][21624] Executing state host.present for dbs03
2018-04-10 12:29:43,330 [salt.state       ][INFO    ][21624] {'host': 'dbs03'}
2018-04-10 12:29:43,330 [salt.state       ][INFO    ][21624] Completed state [dbs03] at time 12:29:43.330831 duration_in_ms=5.38
2018-04-10 12:29:43,331 [salt.state       ][INFO    ][21624] Running state [dbs03.mcp-pike-ovs-ha.local] at time 12:29:43.331145
2018-04-10 12:29:43,331 [salt.state       ][INFO    ][21624] Executing state host.present for dbs03.mcp-pike-ovs-ha.local
2018-04-10 12:29:43,333 [salt.state       ][INFO    ][21624] {'host': 'dbs03.mcp-pike-ovs-ha.local'}
2018-04-10 12:29:43,334 [salt.state       ][INFO    ][21624] Completed state [dbs03.mcp-pike-ovs-ha.local] at time 12:29:43.334305 duration_in_ms=3.159
2018-04-10 12:29:43,334 [salt.state       ][INFO    ][21624] Running state [mas01] at time 12:29:43.334622
2018-04-10 12:29:43,334 [salt.state       ][INFO    ][21624] Executing state host.present for mas01
2018-04-10 12:29:43,339 [salt.state       ][INFO    ][21624] {'host': 'mas01'}
2018-04-10 12:29:43,340 [salt.state       ][INFO    ][21624] Completed state [mas01] at time 12:29:43.340252 duration_in_ms=5.63
2018-04-10 12:29:43,340 [salt.state       ][INFO    ][21624] Running state [mas01.mcp-pike-ovs-ha.local] at time 12:29:43.340573
2018-04-10 12:29:43,340 [salt.state       ][INFO    ][21624] Executing state host.present for mas01.mcp-pike-ovs-ha.local
2018-04-10 12:29:43,346 [salt.state       ][INFO    ][21624] {'host': 'mas01.mcp-pike-ovs-ha.local'}
2018-04-10 12:29:43,346 [salt.state       ][INFO    ][21624] Completed state [mas01.mcp-pike-ovs-ha.local] at time 12:29:43.346399 duration_in_ms=5.826
2018-04-10 12:29:43,346 [salt.state       ][INFO    ][21624] Running state [ctl02] at time 12:29:43.346716
2018-04-10 12:29:43,347 [salt.state       ][INFO    ][21624] Executing state host.present for ctl02
2018-04-10 12:29:43,352 [salt.state       ][INFO    ][21624] {'host': 'ctl02'}
2018-04-10 12:29:43,352 [salt.state       ][INFO    ][21624] Completed state [ctl02] at time 12:29:43.352311 duration_in_ms=5.595
2018-04-10 12:29:43,352 [salt.state       ][INFO    ][21624] Running state [ctl02.mcp-pike-ovs-ha.local] at time 12:29:43.352631
2018-04-10 12:29:43,352 [salt.state       ][INFO    ][21624] Executing state host.present for ctl02.mcp-pike-ovs-ha.local
2018-04-10 12:29:43,357 [salt.state       ][INFO    ][21624] {'host': 'ctl02.mcp-pike-ovs-ha.local'}
2018-04-10 12:29:43,358 [salt.state       ][INFO    ][21624] Completed state [ctl02.mcp-pike-ovs-ha.local] at time 12:29:43.358193 duration_in_ms=5.562
2018-04-10 12:29:43,358 [salt.state       ][INFO    ][21624] Running state [ctl03] at time 12:29:43.358516
2018-04-10 12:29:43,358 [salt.state       ][INFO    ][21624] Executing state host.present for ctl03
2018-04-10 12:29:43,364 [salt.state       ][INFO    ][21624] {'host': 'ctl03'}
2018-04-10 12:29:43,364 [salt.state       ][INFO    ][21624] Completed state [ctl03] at time 12:29:43.364325 duration_in_ms=5.805
2018-04-10 12:29:43,364 [salt.state       ][INFO    ][21624] Running state [ctl03.mcp-pike-ovs-ha.local] at time 12:29:43.364753
2018-04-10 12:29:43,365 [salt.state       ][INFO    ][21624] Executing state host.present for ctl03.mcp-pike-ovs-ha.local
2018-04-10 12:29:43,370 [salt.state       ][INFO    ][21624] {'host': 'ctl03.mcp-pike-ovs-ha.local'}
2018-04-10 12:29:43,370 [salt.state       ][INFO    ][21624] Completed state [ctl03.mcp-pike-ovs-ha.local] at time 12:29:43.370311 duration_in_ms=5.557
2018-04-10 12:29:43,370 [salt.state       ][INFO    ][21624] Running state [ctl01] at time 12:29:43.370629
2018-04-10 12:29:43,370 [salt.state       ][INFO    ][21624] Executing state host.present for ctl01
2018-04-10 12:29:43,376 [salt.state       ][INFO    ][21624] {'host': 'ctl01'}
2018-04-10 12:29:43,376 [salt.state       ][INFO    ][21624] Completed state [ctl01] at time 12:29:43.376352 duration_in_ms=5.723
2018-04-10 12:29:43,376 [salt.state       ][INFO    ][21624] Running state [ctl01.mcp-pike-ovs-ha.local] at time 12:29:43.376677
2018-04-10 12:29:43,376 [salt.state       ][INFO    ][21624] Executing state host.present for ctl01.mcp-pike-ovs-ha.local
2018-04-10 12:29:43,382 [salt.state       ][INFO    ][21624] {'host': 'ctl01.mcp-pike-ovs-ha.local'}
2018-04-10 12:29:43,382 [salt.state       ][INFO    ][21624] Completed state [ctl01.mcp-pike-ovs-ha.local] at time 12:29:43.382300 duration_in_ms=5.623
2018-04-10 12:29:43,382 [salt.state       ][INFO    ][21624] Running state [ctl] at time 12:29:43.382616
2018-04-10 12:29:43,382 [salt.state       ][INFO    ][21624] Executing state host.present for ctl
2018-04-10 12:29:43,388 [salt.state       ][INFO    ][21624] {'host': 'ctl'}
2018-04-10 12:29:43,388 [salt.state       ][INFO    ][21624] Completed state [ctl] at time 12:29:43.388366 duration_in_ms=5.749
2018-04-10 12:29:43,388 [salt.state       ][INFO    ][21624] Running state [ctl.mcp-pike-ovs-ha.local] at time 12:29:43.388678
2018-04-10 12:29:43,388 [salt.state       ][INFO    ][21624] Executing state host.present for ctl.mcp-pike-ovs-ha.local
2018-04-10 12:29:43,394 [salt.state       ][INFO    ][21624] {'host': 'ctl.mcp-pike-ovs-ha.local'}
2018-04-10 12:29:43,394 [salt.state       ][INFO    ][21624] Completed state [ctl.mcp-pike-ovs-ha.local] at time 12:29:43.394360 duration_in_ms=5.681
2018-04-10 12:29:43,394 [salt.state       ][INFO    ][21624] Running state [/etc/network/interfaces.d/50-cloud-init.cfg] at time 12:29:43.394671
2018-04-10 12:29:43,394 [salt.state       ][INFO    ][21624] Executing state file.absent for /etc/network/interfaces.d/50-cloud-init.cfg
2018-04-10 12:29:43,395 [salt.state       ][INFO    ][21624] {'removed': '/etc/network/interfaces.d/50-cloud-init.cfg'}
2018-04-10 12:29:43,395 [salt.state       ][INFO    ][21624] Completed state [/etc/network/interfaces.d/50-cloud-init.cfg] at time 12:29:43.395785 duration_in_ms=1.113
2018-04-10 12:29:43,415 [salt.state       ][INFO    ][21624] Running state [ens3] at time 12:29:43.415581
2018-04-10 12:29:43,415 [salt.state       ][INFO    ][21624] Executing state network.managed for ens3
2018-04-10 12:29:43,560 [salt.loaded.int.module.cmdmod][INFO    ][21624] Executing command ['ifdown', 'ens3'] in directory '/root'
2018-04-10 12:29:44,762 [salt.loaded.int.module.cmdmod][INFO    ][21624] Executing command ['ifup', 'ens3'] in directory '/root'
2018-04-10 12:29:45,021 [salt.state       ][INFO    ][21624] {'interface': 'Added network interface.', 'status': 'Interface ens3 restart to validate'}
2018-04-10 12:29:45,022 [salt.state       ][INFO    ][21624] Completed state [ens3] at time 12:29:45.022447 duration_in_ms=1606.865
2018-04-10 12:29:45,023 [salt.state       ][INFO    ][21624] Running state [ens4] at time 12:29:45.023011
2018-04-10 12:29:45,023 [salt.state       ][INFO    ][21624] Executing state network.managed for ens4
2018-04-10 12:29:45,056 [salt.loaded.int.module.cmdmod][INFO    ][21624] Executing command ['ifup', 'ens4'] in directory '/root'
2018-04-10 12:29:45,633 [salt.minion      ][INFO    ][21476] User sudo_ubuntu Executing command saltutil.find_job with jid 20180410122945616160
2018-04-10 12:29:45,651 [salt.minion      ][INFO    ][25198] Starting a new job with PID 25198
2018-04-10 12:29:45,669 [salt.minion      ][INFO    ][25198] Returning information for job: 20180410122945616160
2018-04-10 12:29:45,735 [salt.state       ][INFO    ][21624] {'interface': 'Added network interface.', 'status': 'Interface ens4 is up'}
2018-04-10 12:29:45,736 [salt.state       ][INFO    ][21624] Completed state [ens4] at time 12:29:45.736075 duration_in_ms=713.064
2018-04-10 12:29:45,736 [salt.state       ][INFO    ][21624] Running state [ens5] at time 12:29:45.736315
2018-04-10 12:29:45,736 [salt.state       ][INFO    ][21624] Executing state network.managed for ens5
2018-04-10 12:29:45,760 [salt.loaded.int.module.cmdmod][INFO    ][21624] Executing command ['ifup', 'ens5'] in directory '/root'
2018-04-10 12:29:46,477 [salt.state       ][INFO    ][21624] {'interface': 'Added network interface.', 'status': 'Interface ens5 is up'}
2018-04-10 12:29:46,478 [salt.state       ][INFO    ][21624] Completed state [ens5] at time 12:29:46.478489 duration_in_ms=742.172
2018-04-10 12:29:46,479 [salt.state       ][INFO    ][21624] Running state [/etc/profile.d/proxy.sh] at time 12:29:46.479363
2018-04-10 12:29:46,480 [salt.state       ][INFO    ][21624] Executing state file.absent for /etc/profile.d/proxy.sh
2018-04-10 12:29:46,481 [salt.state       ][INFO    ][21624] File /etc/profile.d/proxy.sh is not present
2018-04-10 12:29:46,482 [salt.state       ][INFO    ][21624] Completed state [/etc/profile.d/proxy.sh] at time 12:29:46.481955 duration_in_ms=2.592
2018-04-10 12:29:46,482 [salt.state       ][INFO    ][21624] Running state [/etc/apt/apt.conf.d/95proxies] at time 12:29:46.482716
2018-04-10 12:29:46,483 [salt.state       ][INFO    ][21624] Executing state file.absent for /etc/apt/apt.conf.d/95proxies
2018-04-10 12:29:46,484 [salt.state       ][INFO    ][21624] File /etc/apt/apt.conf.d/95proxies is not present
2018-04-10 12:29:46,485 [salt.state       ][INFO    ][21624] Completed state [/etc/apt/apt.conf.d/95proxies] at time 12:29:46.484965 duration_in_ms=2.249
2018-04-10 12:29:46,490 [salt.minion      ][INFO    ][21624] Returning information for job: 20180410122905021594
2018-04-10 12:29:48,057 [salt.minion      ][INFO    ][21476] User sudo_ubuntu Executing command saltutil.sync_all with jid 20180410122948046084
2018-04-10 12:29:48,080 [salt.minion      ][INFO    ][25376] Starting a new job with PID 25376
2018-04-10 12:29:49,449 [salt.state       ][INFO    ][25376] Loading fresh modules for state activity
2018-04-10 12:29:49,497 [salt.utils.extmods][INFO    ][25376] Creating module dir '/var/cache/salt/minion/extmods/beacons'
2018-04-10 12:29:49,503 [salt.utils.extmods][INFO    ][25376] Syncing beacons for environment 'base'
2018-04-10 12:29:49,504 [salt.utils.extmods][INFO    ][25376] Loading cache from salt://_beacons, for base)
2018-04-10 12:29:49,504 [salt.fileclient  ][INFO    ][25376] Caching directory '_beacons/' for environment 'base'
2018-04-10 12:29:49,540 [salt.utils.extmods][INFO    ][25376] Syncing modules for environment 'base'
2018-04-10 12:29:49,541 [salt.utils.extmods][INFO    ][25376] Loading cache from salt://_modules, for base)
2018-04-10 12:29:49,541 [salt.fileclient  ][INFO    ][25376] Caching directory '_modules/' for environment 'base'
2018-04-10 12:29:50,344 [salt.fileclient  ][INFO    ][25376] Fetching file from saltenv 'base', ** done ** '_modules/maas.py'
2018-04-10 12:29:50,519 [salt.utils.extmods][INFO    ][25376] Copying '/var/cache/salt/minion/files/base/_modules/__init__.py' to '/var/cache/salt/minion/extmods/modules/__init__.py'
2018-04-10 12:29:50,520 [salt.utils.extmods][INFO    ][25376] Copying '/var/cache/salt/minion/files/base/_modules/architect.py' to '/var/cache/salt/minion/extmods/modules/architect.py'
2018-04-10 12:29:50,520 [salt.utils.extmods][INFO    ][25376] Copying '/var/cache/salt/minion/files/base/_modules/avinetworks.py' to '/var/cache/salt/minion/extmods/modules/avinetworks.py'
2018-04-10 12:29:50,521 [salt.utils.extmods][INFO    ][25376] Copying '/var/cache/salt/minion/files/base/_modules/ceph_ng.py' to '/var/cache/salt/minion/extmods/modules/ceph_ng.py'
2018-04-10 12:29:50,522 [salt.utils.extmods][INFO    ][25376] Copying '/var/cache/salt/minion/files/base/_modules/cinderng.py' to '/var/cache/salt/minion/extmods/modules/cinderng.py'
2018-04-10 12:29:50,522 [salt.utils.extmods][INFO    ][25376] Copying '/var/cache/salt/minion/files/base/_modules/contrail.py' to '/var/cache/salt/minion/extmods/modules/contrail.py'
2018-04-10 12:29:50,523 [salt.utils.extmods][INFO    ][25376] Copying '/var/cache/salt/minion/files/base/_modules/creds.py' to '/var/cache/salt/minion/extmods/modules/creds.py'
2018-04-10 12:29:50,524 [salt.utils.extmods][INFO    ][25376] Copying '/var/cache/salt/minion/files/base/_modules/devops_utils.py' to '/var/cache/salt/minion/extmods/modules/devops_utils.py'
2018-04-10 12:29:50,524 [salt.utils.extmods][INFO    ][25376] Copying '/var/cache/salt/minion/files/base/_modules/dockerng_service.py' to '/var/cache/salt/minion/extmods/modules/dockerng_service.py'
2018-04-10 12:29:50,525 [salt.utils.extmods][INFO    ][25376] Copying '/var/cache/salt/minion/files/base/_modules/encode_json.py' to '/var/cache/salt/minion/extmods/modules/encode_json.py'
2018-04-10 12:29:50,526 [salt.utils.extmods][INFO    ][25376] Copying '/var/cache/salt/minion/files/base/_modules/gerrit.py' to '/var/cache/salt/minion/extmods/modules/gerrit.py'
2018-04-10 12:29:50,526 [salt.utils.extmods][INFO    ][25376] Copying '/var/cache/salt/minion/files/base/_modules/glanceng.py' to '/var/cache/salt/minion/extmods/modules/glanceng.py'
2018-04-10 12:29:50,527 [salt.utils.extmods][INFO    ][25376] Copying '/var/cache/salt/minion/files/base/_modules/heat.py' to '/var/cache/salt/minion/extmods/modules/heat.py'
2018-04-10 12:29:50,527 [salt.utils.extmods][INFO    ][25376] Copying '/var/cache/salt/minion/files/base/_modules/heka_alarming.py' to '/var/cache/salt/minion/extmods/modules/heka_alarming.py'
2018-04-10 12:29:50,528 [salt.utils.extmods][INFO    ][25376] Copying '/var/cache/salt/minion/files/base/_modules/helm.py' to '/var/cache/salt/minion/extmods/modules/helm.py'
2018-04-10 12:29:50,529 [salt.utils.extmods][INFO    ][25376] Copying '/var/cache/salt/minion/files/base/_modules/jenkins_common.py' to '/var/cache/salt/minion/extmods/modules/jenkins_common.py'
2018-04-10 12:29:50,529 [salt.utils.extmods][INFO    ][25376] Copying '/var/cache/salt/minion/files/base/_modules/keystone_policy.py' to '/var/cache/salt/minion/extmods/modules/keystone_policy.py'
2018-04-10 12:29:50,530 [salt.utils.extmods][INFO    ][25376] Copying '/var/cache/salt/minion/files/base/_modules/keystoneng.py' to '/var/cache/salt/minion/extmods/modules/keystoneng.py'
2018-04-10 12:29:50,532 [salt.utils.extmods][INFO    ][25376] Copying '/var/cache/salt/minion/files/base/_modules/linux_hosts.py' to '/var/cache/salt/minion/extmods/modules/linux_hosts.py'
2018-04-10 12:29:50,533 [salt.utils.extmods][INFO    ][25376] Copying '/var/cache/salt/minion/files/base/_modules/linux_netlink.py' to '/var/cache/salt/minion/extmods/modules/linux_netlink.py'
2018-04-10 12:29:50,533 [salt.utils.extmods][INFO    ][25376] Copying '/var/cache/salt/minion/files/base/_modules/maas.py' to '/var/cache/salt/minion/extmods/modules/maas.py'
2018-04-10 12:29:50,534 [salt.utils.extmods][INFO    ][25376] Copying '/var/cache/salt/minion/files/base/_modules/maas_client.py' to '/var/cache/salt/minion/extmods/modules/maas_client.py'
2018-04-10 12:29:50,535 [salt.utils.extmods][INFO    ][25376] Copying '/var/cache/salt/minion/files/base/_modules/maasng.py' to '/var/cache/salt/minion/extmods/modules/maasng.py'
2018-04-10 12:29:50,535 [salt.utils.extmods][INFO    ][25376] Copying '/var/cache/salt/minion/files/base/_modules/modelschema.py' to '/var/cache/salt/minion/extmods/modules/modelschema.py'
2018-04-10 12:29:50,536 [salt.utils.extmods][INFO    ][25376] Copying '/var/cache/salt/minion/files/base/_modules/modelutils.py' to '/var/cache/salt/minion/extmods/modules/modelutils.py'
2018-04-10 12:29:50,536 [salt.utils.extmods][INFO    ][25376] Copying '/var/cache/salt/minion/files/base/_modules/multipart.py' to '/var/cache/salt/minion/extmods/modules/multipart.py'
2018-04-10 12:29:50,537 [salt.utils.extmods][INFO    ][25376] Copying '/var/cache/salt/minion/files/base/_modules/nagios_alarming.py' to '/var/cache/salt/minion/extmods/modules/nagios_alarming.py'
2018-04-10 12:29:50,537 [salt.utils.extmods][INFO    ][25376] Copying '/var/cache/salt/minion/files/base/_modules/neutronng.py' to '/var/cache/salt/minion/extmods/modules/neutronng.py'
2018-04-10 12:29:50,538 [salt.utils.extmods][INFO    ][25376] Copying '/var/cache/salt/minion/files/base/_modules/novang.py' to '/var/cache/salt/minion/extmods/modules/novang.py'
2018-04-10 12:29:50,539 [salt.utils.extmods][INFO    ][25376] Copying '/var/cache/salt/minion/files/base/_modules/reclass.py' to '/var/cache/salt/minion/extmods/modules/reclass.py'
2018-04-10 12:29:50,540 [salt.utils.extmods][INFO    ][25376] Copying '/var/cache/salt/minion/files/base/_modules/rsyslog_util.py' to '/var/cache/salt/minion/extmods/modules/rsyslog_util.py'
2018-04-10 12:29:50,540 [salt.utils.extmods][INFO    ][25376] Copying '/var/cache/salt/minion/files/base/_modules/rundeck.py' to '/var/cache/salt/minion/extmods/modules/rundeck.py'
2018-04-10 12:29:50,541 [salt.utils.extmods][INFO    ][25376] Copying '/var/cache/salt/minion/files/base/_modules/saltkey.py' to '/var/cache/salt/minion/extmods/modules/saltkey.py'
2018-04-10 12:29:50,541 [salt.utils.extmods][INFO    ][25376] Copying '/var/cache/salt/minion/files/base/_modules/saltresource.py' to '/var/cache/salt/minion/extmods/modules/saltresource.py'
2018-04-10 12:29:50,542 [salt.utils.extmods][INFO    ][25376] Copying '/var/cache/salt/minion/files/base/_modules/seedng.py' to '/var/cache/salt/minion/extmods/modules/seedng.py'
2018-04-10 12:29:50,542 [salt.utils.extmods][INFO    ][25376] Copying '/var/cache/salt/minion/files/base/_modules/testing/__init__.py' to '/var/cache/salt/minion/extmods/modules/testing/__init__.py'
2018-04-10 12:29:50,545 [salt.utils.extmods][INFO    ][25376] Copying '/var/cache/salt/minion/files/base/_modules/testing/credentials.py' to '/var/cache/salt/minion/extmods/modules/testing/credentials.py'
2018-04-10 12:29:50,545 [salt.utils.extmods][INFO    ][25376] Copying '/var/cache/salt/minion/files/base/_modules/testing/django.py' to '/var/cache/salt/minion/extmods/modules/testing/django.py'
2018-04-10 12:29:50,546 [salt.utils.extmods][INFO    ][25376] 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-04-10 12:29:50,546 [salt.utils.extmods][INFO    ][25376] Copying '/var/cache/salt/minion/files/base/_modules/utils.py' to '/var/cache/salt/minion/extmods/modules/utils.py'
2018-04-10 12:29:50,546 [salt.utils.extmods][INFO    ][25376] Copying '/var/cache/salt/minion/files/base/_modules/virtng.py' to '/var/cache/salt/minion/extmods/modules/virtng.py'
2018-04-10 12:29:50,563 [salt.utils.extmods][INFO    ][25376] Syncing states for environment 'base'
2018-04-10 12:29:50,563 [salt.utils.extmods][INFO    ][25376] Loading cache from salt://_states, for base)
2018-04-10 12:29:50,563 [salt.fileclient  ][INFO    ][25376] Caching directory '_states/' for environment 'base'
2018-04-10 12:29:50,898 [salt.utils.extmods][INFO    ][25376] Copying '/var/cache/salt/minion/files/base/_states/avinetworks.py' to '/var/cache/salt/minion/extmods/states/avinetworks.py'
2018-04-10 12:29:50,899 [salt.utils.extmods][INFO    ][25376] Copying '/var/cache/salt/minion/files/base/_states/cinderng.py' to '/var/cache/salt/minion/extmods/states/cinderng.py'
2018-04-10 12:29:50,899 [salt.utils.extmods][INFO    ][25376] Copying '/var/cache/salt/minion/files/base/_states/contrail.py' to '/var/cache/salt/minion/extmods/states/contrail.py'
2018-04-10 12:29:50,900 [salt.utils.extmods][INFO    ][25376] Copying '/var/cache/salt/minion/files/base/_states/dockerng_service.py' to '/var/cache/salt/minion/extmods/states/dockerng_service.py'
2018-04-10 12:29:50,901 [salt.utils.extmods][INFO    ][25376] Copying '/var/cache/salt/minion/files/base/_states/gerrit.py' to '/var/cache/salt/minion/extmods/states/gerrit.py'
2018-04-10 12:29:50,901 [salt.utils.extmods][INFO    ][25376] Copying '/var/cache/salt/minion/files/base/_states/glanceng.py' to '/var/cache/salt/minion/extmods/states/glanceng.py'
2018-04-10 12:29:50,902 [salt.utils.extmods][INFO    ][25376] Copying '/var/cache/salt/minion/files/base/_states/grafana3_dashboard.py' to '/var/cache/salt/minion/extmods/states/grafana3_dashboard.py'
2018-04-10 12:29:50,903 [salt.utils.extmods][INFO    ][25376] Copying '/var/cache/salt/minion/files/base/_states/grafana3_datasource.py' to '/var/cache/salt/minion/extmods/states/grafana3_datasource.py'
2018-04-10 12:29:50,903 [salt.utils.extmods][INFO    ][25376] Copying '/var/cache/salt/minion/files/base/_states/heat.py' to '/var/cache/salt/minion/extmods/states/heat.py'
2018-04-10 12:29:50,904 [salt.utils.extmods][INFO    ][25376] Copying '/var/cache/salt/minion/files/base/_states/helm_release.py' to '/var/cache/salt/minion/extmods/states/helm_release.py'
2018-04-10 12:29:50,904 [salt.utils.extmods][INFO    ][25376] Copying '/var/cache/salt/minion/files/base/_states/helm_repos.py' to '/var/cache/salt/minion/extmods/states/helm_repos.py'
2018-04-10 12:29:50,905 [salt.utils.extmods][INFO    ][25376] Copying '/var/cache/salt/minion/files/base/_states/httpng.py' to '/var/cache/salt/minion/extmods/states/httpng.py'
2018-04-10 12:29:50,905 [salt.utils.extmods][INFO    ][25376] Copying '/var/cache/salt/minion/files/base/_states/jenkins_approval.py' to '/var/cache/salt/minion/extmods/states/jenkins_approval.py'
2018-04-10 12:29:50,906 [salt.utils.extmods][INFO    ][25376] Copying '/var/cache/salt/minion/files/base/_states/jenkins_artifactory.py' to '/var/cache/salt/minion/extmods/states/jenkins_artifactory.py'
2018-04-10 12:29:50,906 [salt.utils.extmods][INFO    ][25376] Copying '/var/cache/salt/minion/files/base/_states/jenkins_credential.py' to '/var/cache/salt/minion/extmods/states/jenkins_credential.py'
2018-04-10 12:29:50,907 [salt.utils.extmods][INFO    ][25376] Copying '/var/cache/salt/minion/files/base/_states/jenkins_globalenvprop.py' to '/var/cache/salt/minion/extmods/states/jenkins_globalenvprop.py'
2018-04-10 12:29:50,907 [salt.utils.extmods][INFO    ][25376] Copying '/var/cache/salt/minion/files/base/_states/jenkins_job.py' to '/var/cache/salt/minion/extmods/states/jenkins_job.py'
2018-04-10 12:29:50,908 [salt.utils.extmods][INFO    ][25376] Copying '/var/cache/salt/minion/files/base/_states/jenkins_lib.py' to '/var/cache/salt/minion/extmods/states/jenkins_lib.py'
2018-04-10 12:29:50,908 [salt.utils.extmods][INFO    ][25376] Copying '/var/cache/salt/minion/files/base/_states/jenkins_node.py' to '/var/cache/salt/minion/extmods/states/jenkins_node.py'
2018-04-10 12:29:50,909 [salt.utils.extmods][INFO    ][25376] Copying '/var/cache/salt/minion/files/base/_states/jenkins_plugin.py' to '/var/cache/salt/minion/extmods/states/jenkins_plugin.py'
2018-04-10 12:29:50,909 [salt.utils.extmods][INFO    ][25376] Copying '/var/cache/salt/minion/files/base/_states/jenkins_security.py' to '/var/cache/salt/minion/extmods/states/jenkins_security.py'
2018-04-10 12:29:50,910 [salt.utils.extmods][INFO    ][25376] Copying '/var/cache/salt/minion/files/base/_states/jenkins_slack.py' to '/var/cache/salt/minion/extmods/states/jenkins_slack.py'
2018-04-10 12:29:50,910 [salt.utils.extmods][INFO    ][25376] Copying '/var/cache/salt/minion/files/base/_states/jenkins_smtp.py' to '/var/cache/salt/minion/extmods/states/jenkins_smtp.py'
2018-04-10 12:29:50,911 [salt.utils.extmods][INFO    ][25376] Copying '/var/cache/salt/minion/files/base/_states/jenkins_theme.py' to '/var/cache/salt/minion/extmods/states/jenkins_theme.py'
2018-04-10 12:29:50,911 [salt.utils.extmods][INFO    ][25376] Copying '/var/cache/salt/minion/files/base/_states/jenkins_user.py' to '/var/cache/salt/minion/extmods/states/jenkins_user.py'
2018-04-10 12:29:50,912 [salt.utils.extmods][INFO    ][25376] Copying '/var/cache/salt/minion/files/base/_states/jenkins_view.py' to '/var/cache/salt/minion/extmods/states/jenkins_view.py'
2018-04-10 12:29:50,912 [salt.utils.extmods][INFO    ][25376] Copying '/var/cache/salt/minion/files/base/_states/keystone_policy.py' to '/var/cache/salt/minion/extmods/states/keystone_policy.py'
2018-04-10 12:29:50,913 [salt.utils.extmods][INFO    ][25376] Copying '/var/cache/salt/minion/files/base/_states/keystoneng.py' to '/var/cache/salt/minion/extmods/states/keystoneng.py'
2018-04-10 12:29:50,914 [salt.utils.extmods][INFO    ][25376] Copying '/var/cache/salt/minion/files/base/_states/kibana_object.py' to '/var/cache/salt/minion/extmods/states/kibana_object.py'
2018-04-10 12:29:50,914 [salt.utils.extmods][INFO    ][25376] Copying '/var/cache/salt/minion/files/base/_states/maas_cluster.py' to '/var/cache/salt/minion/extmods/states/maas_cluster.py'
2018-04-10 12:29:50,915 [salt.utils.extmods][INFO    ][25376] Copying '/var/cache/salt/minion/files/base/_states/maasng.py' to '/var/cache/salt/minion/extmods/states/maasng.py'
2018-04-10 12:29:50,915 [salt.utils.extmods][INFO    ][25376] Copying '/var/cache/salt/minion/files/base/_states/neutronng.py' to '/var/cache/salt/minion/extmods/states/neutronng.py'
2018-04-10 12:29:50,916 [salt.utils.extmods][INFO    ][25376] Copying '/var/cache/salt/minion/files/base/_states/novang.py' to '/var/cache/salt/minion/extmods/states/novang.py'
2018-04-10 12:29:50,917 [salt.utils.extmods][INFO    ][25376] Copying '/var/cache/salt/minion/files/base/_states/reclass.py' to '/var/cache/salt/minion/extmods/states/reclass.py'
2018-04-10 12:29:50,917 [salt.utils.extmods][INFO    ][25376] Copying '/var/cache/salt/minion/files/base/_states/rundeck_project.py' to '/var/cache/salt/minion/extmods/states/rundeck_project.py'
2018-04-10 12:29:50,918 [salt.utils.extmods][INFO    ][25376] Copying '/var/cache/salt/minion/files/base/_states/rundeck_scm.py' to '/var/cache/salt/minion/extmods/states/rundeck_scm.py'
2018-04-10 12:29:50,918 [salt.utils.extmods][INFO    ][25376] Copying '/var/cache/salt/minion/files/base/_states/rundeck_secret.py' to '/var/cache/salt/minion/extmods/states/rundeck_secret.py'
2018-04-10 12:29:50,920 [salt.utils.extmods][INFO    ][25376] Creating module dir '/var/cache/salt/minion/extmods/sdb'
2018-04-10 12:29:50,926 [salt.utils.extmods][INFO    ][25376] Syncing sdb for environment 'base'
2018-04-10 12:29:50,926 [salt.utils.extmods][INFO    ][25376] Loading cache from salt://_sdb, for base)
2018-04-10 12:29:50,926 [salt.fileclient  ][INFO    ][25376] Caching directory '_sdb/' for environment 'base'
2018-04-10 12:29:50,969 [salt.utils.extmods][INFO    ][25376] Syncing grains for environment 'base'
2018-04-10 12:29:50,970 [salt.utils.extmods][INFO    ][25376] Loading cache from salt://_grains, for base)
2018-04-10 12:29:50,970 [salt.fileclient  ][INFO    ][25376] Caching directory '_grains/' for environment 'base'
2018-04-10 12:29:51,106 [salt.utils.extmods][INFO    ][25376] Copying '/var/cache/salt/minion/files/base/_grains/ceilometer_policy.py' to '/var/cache/salt/minion/extmods/grains/ceilometer_policy.py'
2018-04-10 12:29:51,108 [salt.utils.extmods][INFO    ][25376] Copying '/var/cache/salt/minion/files/base/_grains/ceph.py' to '/var/cache/salt/minion/extmods/grains/ceph.py'
2018-04-10 12:29:51,108 [salt.utils.extmods][INFO    ][25376] Copying '/var/cache/salt/minion/files/base/_grains/cinder_policy.py' to '/var/cache/salt/minion/extmods/grains/cinder_policy.py'
2018-04-10 12:29:51,109 [salt.utils.extmods][INFO    ][25376] Copying '/var/cache/salt/minion/files/base/_grains/docker_swarm.py' to '/var/cache/salt/minion/extmods/grains/docker_swarm.py'
2018-04-10 12:29:51,110 [salt.utils.extmods][INFO    ][25376] Copying '/var/cache/salt/minion/files/base/_grains/glance_policy.py' to '/var/cache/salt/minion/extmods/grains/glance_policy.py'
2018-04-10 12:29:51,111 [salt.utils.extmods][INFO    ][25376] Copying '/var/cache/salt/minion/files/base/_grains/heat_policy.py' to '/var/cache/salt/minion/extmods/grains/heat_policy.py'
2018-04-10 12:29:51,112 [salt.utils.extmods][INFO    ][25376] Copying '/var/cache/salt/minion/files/base/_grains/jenkins_plugins.py' to '/var/cache/salt/minion/extmods/grains/jenkins_plugins.py'
2018-04-10 12:29:51,113 [salt.utils.extmods][INFO    ][25376] Copying '/var/cache/salt/minion/files/base/_grains/keystone_policy.py' to '/var/cache/salt/minion/extmods/grains/keystone_policy.py'
2018-04-10 12:29:51,114 [salt.utils.extmods][INFO    ][25376] Copying '/var/cache/salt/minion/files/base/_grains/kubernetes.py' to '/var/cache/salt/minion/extmods/grains/kubernetes.py'
2018-04-10 12:29:51,115 [salt.utils.extmods][INFO    ][25376] Copying '/var/cache/salt/minion/files/base/_grains/neutron_policy.py' to '/var/cache/salt/minion/extmods/grains/neutron_policy.py'
2018-04-10 12:29:51,115 [salt.utils.extmods][INFO    ][25376] Copying '/var/cache/salt/minion/files/base/_grains/nova_policy.py' to '/var/cache/salt/minion/extmods/grains/nova_policy.py'
2018-04-10 12:29:51,116 [salt.utils.extmods][INFO    ][25376] Copying '/var/cache/salt/minion/files/base/_grains/ssh_fingerprints.py' to '/var/cache/salt/minion/extmods/grains/ssh_fingerprints.py'
2018-04-10 12:29:51,119 [salt.utils.extmods][INFO    ][25376] Creating module dir '/var/cache/salt/minion/extmods/renderers'
2018-04-10 12:29:51,127 [salt.utils.extmods][INFO    ][25376] Syncing renderers for environment 'base'
2018-04-10 12:29:51,128 [salt.utils.extmods][INFO    ][25376] Loading cache from salt://_renderers, for base)
2018-04-10 12:29:51,129 [salt.fileclient  ][INFO    ][25376] Caching directory '_renderers/' for environment 'base'
2018-04-10 12:29:51,169 [salt.utils.extmods][INFO    ][25376] Creating module dir '/var/cache/salt/minion/extmods/returners'
2018-04-10 12:29:51,177 [salt.utils.extmods][INFO    ][25376] Syncing returners for environment 'base'
2018-04-10 12:29:51,177 [salt.utils.extmods][INFO    ][25376] Loading cache from salt://_returners, for base)
2018-04-10 12:29:51,178 [salt.fileclient  ][INFO    ][25376] Caching directory '_returners/' for environment 'base'
2018-04-10 12:29:51,216 [salt.utils.extmods][INFO    ][25376] Creating module dir '/var/cache/salt/minion/extmods/output'
2018-04-10 12:29:51,221 [salt.utils.extmods][INFO    ][25376] Syncing output for environment 'base'
2018-04-10 12:29:51,221 [salt.utils.extmods][INFO    ][25376] Loading cache from salt://_output, for base)
2018-04-10 12:29:51,222 [salt.fileclient  ][INFO    ][25376] Caching directory '_output/' for environment 'base'
2018-04-10 12:29:51,262 [salt.utils.extmods][INFO    ][25376] Creating module dir '/var/cache/salt/minion/extmods/utils'
2018-04-10 12:29:51,266 [salt.utils.extmods][INFO    ][25376] Syncing utils for environment 'base'
2018-04-10 12:29:51,266 [salt.utils.extmods][INFO    ][25376] Loading cache from salt://_utils, for base)
2018-04-10 12:29:51,267 [salt.fileclient  ][INFO    ][25376] Caching directory '_utils/' for environment 'base'
2018-04-10 12:29:51,296 [salt.utils.extmods][INFO    ][25376] Creating module dir '/var/cache/salt/minion/extmods/log_handlers'
2018-04-10 12:29:51,302 [salt.utils.extmods][INFO    ][25376] Syncing log_handlers for environment 'base'
2018-04-10 12:29:51,302 [salt.utils.extmods][INFO    ][25376] Loading cache from salt://_log_handlers, for base)
2018-04-10 12:29:51,302 [salt.fileclient  ][INFO    ][25376] Caching directory '_log_handlers/' for environment 'base'
2018-04-10 12:29:51,330 [salt.utils.extmods][INFO    ][25376] Creating module dir '/var/cache/salt/minion/extmods/proxy'
2018-04-10 12:29:51,335 [salt.utils.extmods][INFO    ][25376] Syncing proxy for environment 'base'
2018-04-10 12:29:51,335 [salt.utils.extmods][INFO    ][25376] Loading cache from salt://_proxy, for base)
2018-04-10 12:29:51,335 [salt.fileclient  ][INFO    ][25376] Caching directory '_proxy/' for environment 'base'
2018-04-10 12:29:51,372 [salt.utils.extmods][INFO    ][25376] Creating module dir '/var/cache/salt/minion/extmods/engines'
2018-04-10 12:29:51,378 [salt.utils.extmods][INFO    ][25376] Syncing engines for environment 'base'
2018-04-10 12:29:51,378 [salt.utils.extmods][INFO    ][25376] Loading cache from salt://_engines, for base)
2018-04-10 12:29:51,378 [salt.fileclient  ][INFO    ][25376] Caching directory '_engines/' for environment 'base'
2018-04-10 12:29:51,427 [salt.minion      ][INFO    ][25376] Returning information for job: 20180410122948046084
2018-04-10 12:29:53,012 [salt.minion      ][INFO    ][21476] User sudo_ubuntu Executing command state.apply with jid 20180410122952744500
2018-04-10 12:29:53,027 [salt.minion      ][INFO    ][25484] Starting a new job with PID 25484
2018-04-10 12:29:53,488 [salt.state       ][INFO    ][25484] Loading fresh modules for state activity
2018-04-10 12:29:54,680 [salt.loaded.int.module.cmdmod][INFO    ][25484] Executing command 'reclass --version' in directory '/root'
2018-04-10 12:29:54,964 [salt.loaded.int.module.cmdmod][INFO    ][25484] Executing command 'reclass --version' in directory '/root'
2018-04-10 12:29:55,170 [salt.loaded.int.module.cmdmod][INFO    ][25484] Executing command 'salt-minion --version' in directory '/root'
2018-04-10 12:29:55,384 [salt.loaded.int.module.cmdmod][INFO    ][25484] Executing command 'salt --version' in directory '/root'
2018-04-10 12:29:55,608 [salt.loaded.int.module.cmdmod][INFO    ][25484] Executing command 'salt-minion --version' in directory '/root'
2018-04-10 12:29:55,884 [salt.loaded.int.module.cmdmod][INFO    ][25484] Executing command 'salt --version' in directory '/root'
2018-04-10 12:29:56,498 [salt.loaded.int.module.cmdmod][INFO    ][25484] Executing command 'reclass --version' in directory '/root'
2018-04-10 12:29:56,735 [salt.loaded.int.module.cmdmod][INFO    ][25484] Executing command 'reclass --version' in directory '/root'
2018-04-10 12:29:56,949 [salt.loaded.int.module.cmdmod][INFO    ][25484] Executing command 'salt-minion --version' in directory '/root'
2018-04-10 12:29:57,241 [salt.loaded.int.module.cmdmod][INFO    ][25484] Executing command 'salt --version' in directory '/root'
2018-04-10 12:29:57,481 [salt.loaded.int.module.cmdmod][INFO    ][25484] Executing command 'salt-minion --version' in directory '/root'
2018-04-10 12:29:57,771 [salt.loaded.int.module.cmdmod][INFO    ][25484] Executing command 'salt --version' in directory '/root'
2018-04-10 12:29:59,110 [salt.state       ][INFO    ][25484] Running state [salt-master] at time 12:29:59.110159
2018-04-10 12:29:59,110 [salt.state       ][INFO    ][25484] Executing state pkg.installed for salt-master
2018-04-10 12:29:59,111 [salt.loaded.int.module.cmdmod][INFO    ][25484] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2018-04-10 12:29:59,473 [salt.state       ][INFO    ][25484] All specified packages are already installed
2018-04-10 12:29:59,474 [salt.state       ][INFO    ][25484] Completed state [salt-master] at time 12:29:59.474008 duration_in_ms=363.849
2018-04-10 12:29:59,477 [salt.state       ][INFO    ][25484] Running state [/etc/salt/master.d/master.conf] at time 12:29:59.477041
2018-04-10 12:29:59,477 [salt.state       ][INFO    ][25484] Executing state file.managed for /etc/salt/master.d/master.conf
2018-04-10 12:29:59,634 [salt.state       ][INFO    ][25484] File /etc/salt/master.d/master.conf is in the correct state
2018-04-10 12:29:59,634 [salt.state       ][INFO    ][25484] Completed state [/etc/salt/master.d/master.conf] at time 12:29:59.634443 duration_in_ms=157.4
2018-04-10 12:29:59,635 [salt.state       ][INFO    ][25484] Running state [/etc/salt/master.d/_acl.conf] at time 12:29:59.635326
2018-04-10 12:29:59,635 [salt.state       ][INFO    ][25484] Executing state file.managed for /etc/salt/master.d/_acl.conf
2018-04-10 12:29:59,700 [salt.state       ][INFO    ][25484] File /etc/salt/master.d/_acl.conf is in the correct state
2018-04-10 12:29:59,700 [salt.state       ][INFO    ][25484] Completed state [/etc/salt/master.d/_acl.conf] at time 12:29:59.700806 duration_in_ms=65.478
2018-04-10 12:29:59,701 [salt.state       ][INFO    ][25484] Running state [/etc/salt/master.d/_peer.conf] at time 12:29:59.701737
2018-04-10 12:29:59,702 [salt.state       ][INFO    ][25484] Executing state file.managed for /etc/salt/master.d/_peer.conf
2018-04-10 12:29:59,767 [salt.state       ][INFO    ][25484] File /etc/salt/master.d/_peer.conf is in the correct state
2018-04-10 12:29:59,767 [salt.state       ][INFO    ][25484] Completed state [/etc/salt/master.d/_peer.conf] at time 12:29:59.767560 duration_in_ms=65.823
2018-04-10 12:29:59,769 [salt.state       ][INFO    ][25484] Running state [salt-master] at time 12:29:59.769767
2018-04-10 12:29:59,770 [salt.state       ][INFO    ][25484] Executing state service.running for salt-master
2018-04-10 12:29:59,770 [salt.loaded.int.module.cmdmod][INFO    ][25484] Executing command ['systemctl', 'status', 'salt-master.service', '-n', '0'] in directory '/root'
2018-04-10 12:29:59,802 [salt.loaded.int.module.cmdmod][INFO    ][25484] Executing command ['systemctl', 'is-active', 'salt-master.service'] in directory '/root'
2018-04-10 12:29:59,816 [salt.loaded.int.module.cmdmod][INFO    ][25484] Executing command ['systemctl', 'is-enabled', 'salt-master.service'] in directory '/root'
2018-04-10 12:29:59,830 [salt.state       ][INFO    ][25484] The service salt-master is already running
2018-04-10 12:29:59,831 [salt.state       ][INFO    ][25484] Completed state [salt-master] at time 12:29:59.831088 duration_in_ms=61.321
2018-04-10 12:29:59,831 [salt.state       ][INFO    ][25484] Running state [/srv/salt/env] at time 12:29:59.831555
2018-04-10 12:29:59,831 [salt.state       ][INFO    ][25484] Executing state file.directory for /srv/salt/env
2018-04-10 12:29:59,832 [salt.state       ][INFO    ][25484] Directory /srv/salt/env is in the correct state
2018-04-10 12:29:59,833 [salt.state       ][INFO    ][25484] Completed state [/srv/salt/env] at time 12:29:59.833147 duration_in_ms=1.591
2018-04-10 12:29:59,834 [salt.state       ][INFO    ][25484] Running state [root] at time 12:29:59.834475
2018-04-10 12:29:59,834 [salt.state       ][INFO    ][25484] Executing state user.present for root
2018-04-10 12:29:59,835 [salt.state       ][INFO    ][25484] User root is present and up to date
2018-04-10 12:29:59,836 [salt.state       ][INFO    ][25484] Completed state [root] at time 12:29:59.836304 duration_in_ms=1.829
2018-04-10 12:29:59,837 [salt.state       ][INFO    ][25484] Running state [/root] at time 12:29:59.837415
2018-04-10 12:29:59,837 [salt.state       ][INFO    ][25484] Executing state file.directory for /root
2018-04-10 12:29:59,838 [salt.state       ][INFO    ][25484] Directory /root is in the correct state
2018-04-10 12:29:59,838 [salt.state       ][INFO    ][25484] Completed state [/root] at time 12:29:59.838739 duration_in_ms=1.324
2018-04-10 12:29:59,839 [salt.state       ][INFO    ][25484] Running state [/etc/sudoers.d/90-salt-user-root] at time 12:29:59.839095
2018-04-10 12:29:59,839 [salt.state       ][INFO    ][25484] Executing state file.absent for /etc/sudoers.d/90-salt-user-root
2018-04-10 12:29:59,839 [salt.state       ][INFO    ][25484] File /etc/sudoers.d/90-salt-user-root is not present
2018-04-10 12:29:59,840 [salt.state       ][INFO    ][25484] Completed state [/etc/sudoers.d/90-salt-user-root] at time 12:29:59.840307 duration_in_ms=1.211
2018-04-10 12:29:59,840 [salt.state       ][INFO    ][25484] Running state [salt] at time 12:29:59.840663
2018-04-10 12:29:59,841 [salt.state       ][INFO    ][25484] Executing state user.present for salt
2018-04-10 12:29:59,841 [salt.state       ][INFO    ][25484] User salt is present and up to date
2018-04-10 12:29:59,842 [salt.state       ][INFO    ][25484] Completed state [salt] at time 12:29:59.842294 duration_in_ms=1.631
2018-04-10 12:29:59,843 [salt.state       ][INFO    ][25484] Running state [/var/tmp/salt] at time 12:29:59.843177
2018-04-10 12:29:59,843 [salt.state       ][INFO    ][25484] Executing state file.directory for /var/tmp/salt
2018-04-10 12:29:59,844 [salt.state       ][INFO    ][25484] Directory /var/tmp/salt is in the correct state
2018-04-10 12:29:59,844 [salt.state       ][INFO    ][25484] Completed state [/var/tmp/salt] at time 12:29:59.844559 duration_in_ms=1.382
2018-04-10 12:29:59,844 [salt.state       ][INFO    ][25484] Running state [/etc/sudoers.d/90-salt-user-salt] at time 12:29:59.844904
2018-04-10 12:29:59,845 [salt.state       ][INFO    ][25484] Executing state file.absent for /etc/sudoers.d/90-salt-user-salt
2018-04-10 12:29:59,845 [salt.state       ][INFO    ][25484] File /etc/sudoers.d/90-salt-user-salt is not present
2018-04-10 12:29:59,846 [salt.state       ][INFO    ][25484] Completed state [/etc/sudoers.d/90-salt-user-salt] at time 12:29:59.845990 duration_in_ms=1.086
2018-04-10 12:29:59,846 [salt.state       ][INFO    ][25484] Running state [ubuntu] at time 12:29:59.846351
2018-04-10 12:29:59,846 [salt.state       ][INFO    ][25484] Executing state user.present for ubuntu
2018-04-10 12:29:59,847 [salt.state       ][INFO    ][25484] User ubuntu is present and up to date
2018-04-10 12:29:59,847 [salt.state       ][INFO    ][25484] Completed state [ubuntu] at time 12:29:59.847896 duration_in_ms=1.545
2018-04-10 12:29:59,848 [salt.state       ][INFO    ][25484] Running state [/home/ubuntu] at time 12:29:59.848786
2018-04-10 12:29:59,849 [salt.state       ][INFO    ][25484] Executing state file.directory for /home/ubuntu
2018-04-10 12:29:59,849 [salt.state       ][INFO    ][25484] Directory /home/ubuntu is in the correct state
2018-04-10 12:29:59,850 [salt.state       ][INFO    ][25484] Completed state [/home/ubuntu] at time 12:29:59.850159 duration_in_ms=1.373
2018-04-10 12:29:59,850 [salt.state       ][INFO    ][25484] Running state [/etc/sudoers.d/90-salt-user-ubuntu] at time 12:29:59.850950
2018-04-10 12:29:59,851 [salt.state       ][INFO    ][25484] Executing state file.managed for /etc/sudoers.d/90-salt-user-ubuntu
2018-04-10 12:29:59,873 [salt.state       ][INFO    ][25484] File /etc/sudoers.d/90-salt-user-ubuntu is in the correct state
2018-04-10 12:29:59,874 [salt.state       ][INFO    ][25484] Completed state [/etc/sudoers.d/90-salt-user-ubuntu] at time 12:29:59.874209 duration_in_ms=23.259
2018-04-10 12:29:59,874 [salt.state       ][INFO    ][25484] Running state [git-core] at time 12:29:59.874677
2018-04-10 12:29:59,875 [salt.state       ][INFO    ][25484] Executing state pkg.installed for git-core
2018-04-10 12:29:59,880 [salt.state       ][INFO    ][25484] All specified packages are already installed
2018-04-10 12:29:59,881 [salt.state       ][INFO    ][25484] Completed state [git-core] at time 12:29:59.881011 duration_in_ms=6.334
2018-04-10 12:29:59,881 [salt.state       ][INFO    ][25484] Running state [/usr/share/salt-formulas/env/_modules] at time 12:29:59.881439
2018-04-10 12:29:59,881 [salt.state       ][INFO    ][25484] Executing state file.directory for /usr/share/salt-formulas/env/_modules
2018-04-10 12:29:59,882 [salt.state       ][INFO    ][25484] Directory /usr/share/salt-formulas/env/_modules is in the correct state
2018-04-10 12:29:59,882 [salt.state       ][INFO    ][25484] Completed state [/usr/share/salt-formulas/env/_modules] at time 12:29:59.882739 duration_in_ms=1.3
2018-04-10 12:29:59,883 [salt.state       ][INFO    ][25484] Running state [/usr/share/salt-formulas/env/_states] at time 12:29:59.883099
2018-04-10 12:29:59,883 [salt.state       ][INFO    ][25484] Executing state file.directory for /usr/share/salt-formulas/env/_states
2018-04-10 12:29:59,884 [salt.state       ][INFO    ][25484] Directory /usr/share/salt-formulas/env/_states is in the correct state
2018-04-10 12:29:59,884 [salt.state       ][INFO    ][25484] Completed state [/usr/share/salt-formulas/env/_states] at time 12:29:59.884398 duration_in_ms=1.298
2018-04-10 12:29:59,884 [salt.state       ][INFO    ][25484] Running state [/usr/share/salt-formulas/env/_grains] at time 12:29:59.884772
2018-04-10 12:29:59,885 [salt.state       ][INFO    ][25484] Executing state file.directory for /usr/share/salt-formulas/env/_grains
2018-04-10 12:29:59,885 [salt.state       ][INFO    ][25484] Directory /usr/share/salt-formulas/env/_grains is in the correct state
2018-04-10 12:29:59,886 [salt.state       ][INFO    ][25484] Completed state [/usr/share/salt-formulas/env/_grains] at time 12:29:59.886069 duration_in_ms=1.297
2018-04-10 12:29:59,886 [salt.state       ][INFO    ][25484] Running state [/usr/share/salt-formulas/env/_formulas] at time 12:29:59.886436
2018-04-10 12:29:59,886 [salt.state       ][INFO    ][25484] Executing state file.directory for /usr/share/salt-formulas/env/_formulas
2018-04-10 12:29:59,887 [salt.state       ][INFO    ][25484] Directory /usr/share/salt-formulas/env/_formulas is in the correct state
2018-04-10 12:29:59,887 [salt.state       ][INFO    ][25484] Completed state [/usr/share/salt-formulas/env/_formulas] at time 12:29:59.887723 duration_in_ms=1.287
2018-04-10 12:29:59,888 [salt.state       ][INFO    ][25484] Running state [/usr/share/salt-formulas/env/_engines] at time 12:29:59.888074
2018-04-10 12:29:59,888 [salt.state       ][INFO    ][25484] Executing state file.directory for /usr/share/salt-formulas/env/_engines
2018-04-10 12:29:59,889 [salt.state       ][INFO    ][25484] Directory /usr/share/salt-formulas/env/_engines is in the correct state
2018-04-10 12:29:59,889 [salt.state       ][INFO    ][25484] Completed state [/usr/share/salt-formulas/env/_engines] at time 12:29:59.889369 duration_in_ms=1.295
2018-04-10 12:29:59,889 [salt.state       ][INFO    ][25484] Running state [/usr/share/salt-formulas/env/_runners] at time 12:29:59.889722
2018-04-10 12:29:59,890 [salt.state       ][INFO    ][25484] Executing state file.directory for /usr/share/salt-formulas/env/_runners
2018-04-10 12:29:59,890 [salt.state       ][INFO    ][25484] Directory /usr/share/salt-formulas/env/_runners is in the correct state
2018-04-10 12:29:59,891 [salt.state       ][INFO    ][25484] Completed state [/usr/share/salt-formulas/env/_runners] at time 12:29:59.890969 duration_in_ms=1.247
2018-04-10 12:29:59,891 [salt.state       ][INFO    ][25484] Running state [/srv/salt/env/prd] at time 12:29:59.891945
2018-04-10 12:29:59,892 [salt.state       ][INFO    ][25484] Executing state file.symlink for /srv/salt/env/prd
2018-04-10 12:29:59,893 [salt.state       ][INFO    ][25484] Symlink /srv/salt/env/prd is present and owned by root:root
2018-04-10 12:29:59,893 [salt.state       ][INFO    ][25484] Completed state [/srv/salt/env/prd] at time 12:29:59.893823 duration_in_ms=1.878
2018-04-10 12:29:59,894 [salt.state       ][INFO    ][25484] Running state [salt_master_prd_pkg_formulas] at time 12:29:59.894177
2018-04-10 12:29:59,894 [salt.state       ][INFO    ][25484] Executing state pkg.latest for salt_master_prd_pkg_formulas
2018-04-10 12:29:59,903 [salt.loaded.int.module.cmdmod][INFO    ][25484] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-maas'] in directory '/root'
2018-04-10 12:29:59,948 [salt.loaded.int.module.cmdmod][INFO    ][25484] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-grafana'] in directory '/root'
2018-04-10 12:29:59,991 [salt.loaded.int.module.cmdmod][INFO    ][25484] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-xtrabackup'] in directory '/root'
2018-04-10 12:30:00,037 [salt.loaded.int.module.cmdmod][INFO    ][25484] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-docker'] in directory '/root'
2018-04-10 12:30:00,112 [salt.loaded.int.module.cmdmod][INFO    ][25484] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-heat'] in directory '/root'
2018-04-10 12:30:00,192 [salt.loaded.int.module.cmdmod][INFO    ][25484] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-reclass'] in directory '/root'
2018-04-10 12:30:00,258 [salt.loaded.int.module.cmdmod][INFO    ][25484] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-redis'] in directory '/root'
2018-04-10 12:30:00,309 [salt.loaded.int.module.cmdmod][INFO    ][25484] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-nova'] in directory '/root'
2018-04-10 12:30:00,404 [salt.loaded.int.module.cmdmod][INFO    ][25484] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-iptables'] in directory '/root'
2018-04-10 12:30:00,476 [salt.loaded.int.module.cmdmod][INFO    ][25484] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-murano'] in directory '/root'
2018-04-10 12:30:00,533 [salt.loaded.int.module.cmdmod][INFO    ][25484] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-glusterfs'] in directory '/root'
2018-04-10 12:30:00,578 [salt.loaded.int.module.cmdmod][INFO    ][25484] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-backupninja'] in directory '/root'
2018-04-10 12:30:00,619 [salt.loaded.int.module.cmdmod][INFO    ][25484] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-kubernetes'] in directory '/root'
2018-04-10 12:30:00,663 [salt.loaded.int.module.cmdmod][INFO    ][25484] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-linux'] in directory '/root'
2018-04-10 12:30:00,726 [salt.loaded.int.module.cmdmod][INFO    ][25484] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-git'] in directory '/root'
2018-04-10 12:30:00,787 [salt.loaded.int.module.cmdmod][INFO    ][25484] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-apache'] in directory '/root'
2018-04-10 12:30:00,853 [salt.loaded.int.module.cmdmod][INFO    ][25484] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-aptly'] in directory '/root'
2018-04-10 12:30:00,904 [salt.loaded.int.module.cmdmod][INFO    ][25484] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-gerrit'] in directory '/root'
2018-04-10 12:30:00,953 [salt.loaded.int.module.cmdmod][INFO    ][25484] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-sensu'] in directory '/root'
2018-04-10 12:30:01,028 [salt.loaded.int.module.cmdmod][INFO    ][25484] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-glance'] in directory '/root'
2018-04-10 12:30:01,102 [salt.loaded.int.module.cmdmod][INFO    ][25484] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-heka'] in directory '/root'
2018-04-10 12:30:01,186 [salt.loaded.int.module.cmdmod][INFO    ][25484] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-keystone'] in directory '/root'
2018-04-10 12:30:01,260 [salt.loaded.int.module.cmdmod][INFO    ][25484] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-ntp'] in directory '/root'
2018-04-10 12:30:01,326 [salt.loaded.int.module.cmdmod][INFO    ][25484] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-barbican'] in directory '/root'
2018-04-10 12:30:01,389 [salt.loaded.int.module.cmdmod][INFO    ][25484] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-aodh'] in directory '/root'
2018-04-10 12:30:01,478 [salt.loaded.int.module.cmdmod][INFO    ][25484] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-python'] in directory '/root'
2018-04-10 12:30:01,539 [salt.loaded.int.module.cmdmod][INFO    ][25484] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-collectd'] in directory '/root'
2018-04-10 12:30:01,600 [salt.loaded.int.module.cmdmod][INFO    ][25484] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-neutron'] in directory '/root'
2018-04-10 12:30:01,656 [salt.loaded.int.module.cmdmod][INFO    ][25484] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-supervisor'] in directory '/root'
2018-04-10 12:30:01,741 [salt.loaded.int.module.cmdmod][INFO    ][25484] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-ceilometer'] in directory '/root'
2018-04-10 12:30:01,811 [salt.loaded.int.module.cmdmod][INFO    ][25484] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-elasticsearch'] in directory '/root'
2018-04-10 12:30:01,873 [salt.loaded.int.module.cmdmod][INFO    ][25484] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-powerdns'] in directory '/root'
2018-04-10 12:30:01,941 [salt.loaded.int.module.cmdmod][INFO    ][25484] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-cassandra'] in directory '/root'
2018-04-10 12:30:02,018 [salt.loaded.int.module.cmdmod][INFO    ][25484] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-libvirt'] in directory '/root'
2018-04-10 12:30:02,083 [salt.loaded.int.module.cmdmod][INFO    ][25484] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-sahara'] in directory '/root'
2018-04-10 12:30:02,135 [salt.loaded.int.module.cmdmod][INFO    ][25484] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-openssh'] in directory '/root'
2018-04-10 12:30:02,189 [salt.loaded.int.module.cmdmod][INFO    ][25484] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-statsd'] in directory '/root'
2018-04-10 12:30:02,254 [salt.loaded.int.module.cmdmod][INFO    ][25484] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-mongodb'] in directory '/root'
2018-04-10 12:30:02,310 [salt.loaded.int.module.cmdmod][INFO    ][25484] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-kibana'] in directory '/root'
2018-04-10 12:30:02,377 [salt.loaded.int.module.cmdmod][INFO    ][25484] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-sphinx'] in directory '/root'
2018-04-10 12:30:02,453 [salt.loaded.int.module.cmdmod][INFO    ][25484] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-freeipa'] in directory '/root'
2018-04-10 12:30:02,520 [salt.loaded.int.module.cmdmod][INFO    ][25484] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-octavia'] in directory '/root'
2018-04-10 12:30:02,594 [salt.loaded.int.module.cmdmod][INFO    ][25484] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-fluentd'] in directory '/root'
2018-04-10 12:30:02,666 [salt.loaded.int.module.cmdmod][INFO    ][25484] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-aptcacher'] in directory '/root'
2018-04-10 12:30:02,722 [salt.loaded.int.module.cmdmod][INFO    ][25484] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-salt'] in directory '/root'
2018-04-10 12:30:02,768 [salt.loaded.int.module.cmdmod][INFO    ][25484] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-etcd'] in directory '/root'
2018-04-10 12:30:02,810 [salt.loaded.int.module.cmdmod][INFO    ][25484] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-devops-portal'] in directory '/root'
2018-04-10 12:30:02,836 [salt.minion      ][INFO    ][21476] User sudo_ubuntu Executing command saltutil.find_job with jid 20180410123002829867
2018-04-10 12:30:02,867 [salt.minion      ][INFO    ][25746] Starting a new job with PID 25746
2018-04-10 12:30:02,880 [salt.loaded.int.module.cmdmod][INFO    ][25484] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-postgresql'] in directory '/root'
2018-04-10 12:30:02,901 [salt.minion      ][INFO    ][25746] Returning information for job: 20180410123002829867
2018-04-10 12:30:02,923 [salt.loaded.int.module.cmdmod][INFO    ][25484] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-avinetworks'] in directory '/root'
2018-04-10 12:30:02,973 [salt.loaded.int.module.cmdmod][INFO    ][25484] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-rundeck'] in directory '/root'
2018-04-10 12:30:03,016 [salt.loaded.int.module.cmdmod][INFO    ][25484] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-nginx'] in directory '/root'
2018-04-10 12:30:03,089 [salt.loaded.int.module.cmdmod][INFO    ][25484] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-mysql'] in directory '/root'
2018-04-10 12:30:03,154 [salt.loaded.int.module.cmdmod][INFO    ][25484] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-ceph'] in directory '/root'
2018-04-10 12:30:03,212 [salt.loaded.int.module.cmdmod][INFO    ][25484] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-horizon'] in directory '/root'
2018-04-10 12:30:03,259 [salt.loaded.int.module.cmdmod][INFO    ][25484] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-haproxy'] in directory '/root'
2018-04-10 12:30:03,326 [salt.loaded.int.module.cmdmod][INFO    ][25484] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-java'] in directory '/root'
2018-04-10 12:30:03,393 [salt.loaded.int.module.cmdmod][INFO    ][25484] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-billometer'] in directory '/root'
2018-04-10 12:30:03,441 [salt.loaded.int.module.cmdmod][INFO    ][25484] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-telegraf'] in directory '/root'
2018-04-10 12:30:03,484 [salt.loaded.int.module.cmdmod][INFO    ][25484] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-designate'] in directory '/root'
2018-04-10 12:30:03,522 [salt.loaded.int.module.cmdmod][INFO    ][25484] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-keepalived'] in directory '/root'
2018-04-10 12:30:03,596 [salt.loaded.int.module.cmdmod][INFO    ][25484] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-bind'] in directory '/root'
2018-04-10 12:30:03,632 [salt.loaded.int.module.cmdmod][INFO    ][25484] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-ccp'] in directory '/root'
2018-04-10 12:30:03,674 [salt.loaded.int.module.cmdmod][INFO    ][25484] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-tinyproxy'] in directory '/root'
2018-04-10 12:30:03,749 [salt.loaded.int.module.cmdmod][INFO    ][25484] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-rabbitmq'] in directory '/root'
2018-04-10 12:30:03,829 [salt.loaded.int.module.cmdmod][INFO    ][25484] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-openldap'] in directory '/root'
2018-04-10 12:30:03,869 [salt.loaded.int.module.cmdmod][INFO    ][25484] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-influxdb'] in directory '/root'
2018-04-10 12:30:03,939 [salt.loaded.int.module.cmdmod][INFO    ][25484] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-memcached'] in directory '/root'
2018-04-10 12:30:03,978 [salt.loaded.int.module.cmdmod][INFO    ][25484] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-prometheus'] in directory '/root'
2018-04-10 12:30:04,018 [salt.loaded.int.module.cmdmod][INFO    ][25484] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-helm'] in directory '/root'
2018-04-10 12:30:04,088 [salt.loaded.int.module.cmdmod][INFO    ][25484] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-opencontrail'] in directory '/root'
2018-04-10 12:30:04,163 [salt.loaded.int.module.cmdmod][INFO    ][25484] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-jenkins'] in directory '/root'
2018-04-10 12:30:04,224 [salt.loaded.int.module.cmdmod][INFO    ][25484] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-lldp'] in directory '/root'
2018-04-10 12:30:04,296 [salt.loaded.int.module.cmdmod][INFO    ][25484] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-nagios'] in directory '/root'
2018-04-10 12:30:04,346 [salt.loaded.int.module.cmdmod][INFO    ][25484] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-swift'] in directory '/root'
2018-04-10 12:30:04,396 [salt.loaded.int.module.cmdmod][INFO    ][25484] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-zookeeper'] in directory '/root'
2018-04-10 12:30:04,447 [salt.loaded.int.module.cmdmod][INFO    ][25484] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-galera'] in directory '/root'
2018-04-10 12:30:04,518 [salt.loaded.int.module.cmdmod][INFO    ][25484] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-graphite'] in directory '/root'
2018-04-10 12:30:04,572 [salt.loaded.int.module.cmdmod][INFO    ][25484] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-cinder'] in directory '/root'
2018-04-10 12:30:04,623 [salt.loaded.int.module.cmdmod][INFO    ][25484] Executing command ['apt-cache', '-q', 'policy', 'salt-formula-rsyslog'] in directory '/root'
2018-04-10 12:30:04,698 [salt.state       ][INFO    ][25484] All 79 packages are up-to-date.
2018-04-10 12:30:04,699 [salt.state       ][INFO    ][25484] Completed state [salt_master_prd_pkg_formulas] at time 12:30:04.699422 duration_in_ms=4805.244
2018-04-10 12:30:04,700 [salt.state       ][INFO    ][25484] Running state [/srv/salt/reclass] at time 12:30:04.700183
2018-04-10 12:30:04,700 [salt.state       ][INFO    ][25484] Executing state file.directory for /srv/salt/reclass
2018-04-10 12:30:04,702 [salt.state       ][INFO    ][25484] Directory /srv/salt/reclass is in the correct state
2018-04-10 12:30:04,702 [salt.state       ][INFO    ][25484] Completed state [/srv/salt/reclass] at time 12:30:04.702929 duration_in_ms=2.746
2018-04-10 12:30:04,705 [salt.state       ][INFO    ][25484] Running state [/srv/salt/reclass/classes/service] at time 12:30:04.704969
2018-04-10 12:30:04,705 [salt.state       ][INFO    ][25484] Executing state file.directory for /srv/salt/reclass/classes/service
2018-04-10 12:30:04,706 [salt.state       ][INFO    ][25484] Directory /srv/salt/reclass/classes/service is in the correct state
2018-04-10 12:30:04,707 [salt.state       ][INFO    ][25484] Completed state [/srv/salt/reclass/classes/service] at time 12:30:04.707354 duration_in_ms=2.386
2018-04-10 12:30:04,709 [salt.state       ][INFO    ][25484] Running state [/srv/salt/reclass/classes/service/powerdns] at time 12:30:04.709032
2018-04-10 12:30:04,709 [salt.state       ][INFO    ][25484] Executing state file.symlink for /srv/salt/reclass/classes/service/powerdns
2018-04-10 12:30:04,712 [salt.state       ][INFO    ][25484] Symlink /srv/salt/reclass/classes/service/powerdns is present and owned by root:root
2018-04-10 12:30:04,712 [salt.state       ][INFO    ][25484] Completed state [/srv/salt/reclass/classes/service/powerdns] at time 12:30:04.712534 duration_in_ms=3.501
2018-04-10 12:30:04,714 [salt.state       ][INFO    ][25484] Running state [/srv/salt/reclass/classes/service/galera] at time 12:30:04.713959
2018-04-10 12:30:04,714 [salt.state       ][INFO    ][25484] Executing state file.symlink for /srv/salt/reclass/classes/service/galera
2018-04-10 12:30:04,716 [salt.state       ][INFO    ][25484] Symlink /srv/salt/reclass/classes/service/galera is present and owned by root:root
2018-04-10 12:30:04,717 [salt.state       ][INFO    ][25484] Completed state [/srv/salt/reclass/classes/service/galera] at time 12:30:04.717207 duration_in_ms=3.248
2018-04-10 12:30:04,718 [salt.state       ][INFO    ][25484] Running state [/srv/salt/reclass/classes/service/telegraf] at time 12:30:04.718590
2018-04-10 12:30:04,719 [salt.state       ][INFO    ][25484] Executing state file.symlink for /srv/salt/reclass/classes/service/telegraf
2018-04-10 12:30:04,721 [salt.state       ][INFO    ][25484] Symlink /srv/salt/reclass/classes/service/telegraf is present and owned by root:root
2018-04-10 12:30:04,721 [salt.state       ][INFO    ][25484] Completed state [/srv/salt/reclass/classes/service/telegraf] at time 12:30:04.721651 duration_in_ms=3.06
2018-04-10 12:30:04,722 [salt.state       ][INFO    ][25484] Running state [/srv/salt/reclass/classes/service/supervisor] at time 12:30:04.722944
2018-04-10 12:30:04,723 [salt.state       ][INFO    ][25484] Executing state file.symlink for /srv/salt/reclass/classes/service/supervisor
2018-04-10 12:30:04,725 [salt.state       ][INFO    ][25484] Symlink /srv/salt/reclass/classes/service/supervisor is present and owned by root:root
2018-04-10 12:30:04,726 [salt.state       ][INFO    ][25484] Completed state [/srv/salt/reclass/classes/service/supervisor] at time 12:30:04.726051 duration_in_ms=3.107
2018-04-10 12:30:04,727 [salt.state       ][INFO    ][25484] Running state [/srv/salt/reclass/classes/service/sensu] at time 12:30:04.727386
2018-04-10 12:30:04,727 [salt.state       ][INFO    ][25484] Executing state file.symlink for /srv/salt/reclass/classes/service/sensu
2018-04-10 12:30:04,729 [salt.state       ][INFO    ][25484] Symlink /srv/salt/reclass/classes/service/sensu is present and owned by root:root
2018-04-10 12:30:04,730 [salt.state       ][INFO    ][25484] Completed state [/srv/salt/reclass/classes/service/sensu] at time 12:30:04.730312 duration_in_ms=2.925
2018-04-10 12:30:04,731 [salt.state       ][INFO    ][25484] Running state [/srv/salt/reclass/classes/service/aodh] at time 12:30:04.731551
2018-04-10 12:30:04,732 [salt.state       ][INFO    ][25484] Executing state file.symlink for /srv/salt/reclass/classes/service/aodh
2018-04-10 12:30:04,733 [salt.state       ][INFO    ][25484] Symlink /srv/salt/reclass/classes/service/aodh is present and owned by root:root
2018-04-10 12:30:04,734 [salt.state       ][INFO    ][25484] Completed state [/srv/salt/reclass/classes/service/aodh] at time 12:30:04.734441 duration_in_ms=2.89
2018-04-10 12:30:04,735 [salt.state       ][INFO    ][25484] Running state [/srv/salt/reclass/classes/service/tinyproxy] at time 12:30:04.735682
2018-04-10 12:30:04,736 [salt.state       ][INFO    ][25484] Executing state file.symlink for /srv/salt/reclass/classes/service/tinyproxy
2018-04-10 12:30:04,738 [salt.state       ][INFO    ][25484] Symlink /srv/salt/reclass/classes/service/tinyproxy is present and owned by root:root
2018-04-10 12:30:04,738 [salt.state       ][INFO    ][25484] Completed state [/srv/salt/reclass/classes/service/tinyproxy] at time 12:30:04.738593 duration_in_ms=2.911
2018-04-10 12:30:04,739 [salt.state       ][INFO    ][25484] Running state [/srv/salt/reclass/classes/service/kibana] at time 12:30:04.739775
2018-04-10 12:30:04,740 [salt.state       ][INFO    ][25484] Executing state file.symlink for /srv/salt/reclass/classes/service/kibana
2018-04-10 12:30:04,742 [salt.state       ][INFO    ][25484] Symlink /srv/salt/reclass/classes/service/kibana is present and owned by root:root
2018-04-10 12:30:04,742 [salt.state       ][INFO    ][25484] Completed state [/srv/salt/reclass/classes/service/kibana] at time 12:30:04.742553 duration_in_ms=2.778
2018-04-10 12:30:04,743 [salt.state       ][INFO    ][25484] Running state [/srv/salt/reclass/classes/service/nagios] at time 12:30:04.743730
2018-04-10 12:30:04,744 [salt.state       ][INFO    ][25484] Executing state file.symlink for /srv/salt/reclass/classes/service/nagios
2018-04-10 12:30:04,746 [salt.state       ][INFO    ][25484] Symlink /srv/salt/reclass/classes/service/nagios is present and owned by root:root
2018-04-10 12:30:04,746 [salt.state       ][INFO    ][25484] Completed state [/srv/salt/reclass/classes/service/nagios] at time 12:30:04.746506 duration_in_ms=2.776
2018-04-10 12:30:04,747 [salt.state       ][INFO    ][25484] Running state [/srv/salt/reclass/classes/service/ceph] at time 12:30:04.747675
2018-04-10 12:30:04,748 [salt.state       ][INFO    ][25484] Executing state file.symlink for /srv/salt/reclass/classes/service/ceph
2018-04-10 12:30:04,749 [salt.state       ][INFO    ][25484] Symlink /srv/salt/reclass/classes/service/ceph is present and owned by root:root
2018-04-10 12:30:04,750 [salt.state       ][INFO    ][25484] Completed state [/srv/salt/reclass/classes/service/ceph] at time 12:30:04.750384 duration_in_ms=2.709
2018-04-10 12:30:04,751 [salt.state       ][INFO    ][25484] Running state [/srv/salt/reclass/classes/service/apache] at time 12:30:04.751520
2018-04-10 12:30:04,752 [salt.state       ][INFO    ][25484] Executing state file.symlink for /srv/salt/reclass/classes/service/apache
2018-04-10 12:30:04,753 [salt.state       ][INFO    ][25484] Symlink /srv/salt/reclass/classes/service/apache is present and owned by root:root
2018-04-10 12:30:04,754 [salt.state       ][INFO    ][25484] Completed state [/srv/salt/reclass/classes/service/apache] at time 12:30:04.754226 duration_in_ms=2.706
2018-04-10 12:30:04,755 [salt.state       ][INFO    ][25484] Running state [/srv/salt/reclass/classes/service/glusterfs] at time 12:30:04.755370
2018-04-10 12:30:04,755 [salt.state       ][INFO    ][25484] Executing state file.symlink for /srv/salt/reclass/classes/service/glusterfs
2018-04-10 12:30:04,757 [salt.state       ][INFO    ][25484] Symlink /srv/salt/reclass/classes/service/glusterfs is present and owned by root:root
2018-04-10 12:30:04,758 [salt.state       ][INFO    ][25484] Completed state [/srv/salt/reclass/classes/service/glusterfs] at time 12:30:04.758009 duration_in_ms=2.639
2018-04-10 12:30:04,759 [salt.state       ][INFO    ][25484] Running state [/srv/salt/reclass/classes/service/xtrabackup] at time 12:30:04.759103
2018-04-10 12:30:04,759 [salt.state       ][INFO    ][25484] Executing state file.symlink for /srv/salt/reclass/classes/service/xtrabackup
2018-04-10 12:30:04,761 [salt.state       ][INFO    ][25484] Symlink /srv/salt/reclass/classes/service/xtrabackup is present and owned by root:root
2018-04-10 12:30:04,761 [salt.state       ][INFO    ][25484] Completed state [/srv/salt/reclass/classes/service/xtrabackup] at time 12:30:04.761671 duration_in_ms=2.568
2018-04-10 12:30:04,762 [salt.state       ][INFO    ][25484] Running state [/srv/salt/reclass/classes/service/sahara] at time 12:30:04.762761
2018-04-10 12:30:04,763 [salt.state       ][INFO    ][25484] Executing state file.symlink for /srv/salt/reclass/classes/service/sahara
2018-04-10 12:30:04,764 [salt.state       ][INFO    ][25484] Symlink /srv/salt/reclass/classes/service/sahara is present and owned by root:root
2018-04-10 12:30:04,765 [salt.state       ][INFO    ][25484] Completed state [/srv/salt/reclass/classes/service/sahara] at time 12:30:04.765310 duration_in_ms=2.548
2018-04-10 12:30:04,766 [salt.state       ][INFO    ][25484] Running state [/srv/salt/reclass/classes/service/backupninja] at time 12:30:04.766396
2018-04-10 12:30:04,766 [salt.state       ][INFO    ][25484] Executing state file.symlink for /srv/salt/reclass/classes/service/backupninja
2018-04-10 12:30:04,768 [salt.state       ][INFO    ][25484] Symlink /srv/salt/reclass/classes/service/backupninja is present and owned by root:root
2018-04-10 12:30:04,768 [salt.state       ][INFO    ][25484] Completed state [/srv/salt/reclass/classes/service/backupninja] at time 12:30:04.768906 duration_in_ms=2.51
2018-04-10 12:30:04,770 [salt.state       ][INFO    ][25484] Running state [/srv/salt/reclass/classes/service/rsyslog] at time 12:30:04.769969
2018-04-10 12:30:04,770 [salt.state       ][INFO    ][25484] Executing state file.symlink for /srv/salt/reclass/classes/service/rsyslog
2018-04-10 12:30:04,771 [salt.state       ][INFO    ][25484] Symlink /srv/salt/reclass/classes/service/rsyslog is present and owned by root:root
2018-04-10 12:30:04,772 [salt.state       ][INFO    ][25484] Completed state [/srv/salt/reclass/classes/service/rsyslog] at time 12:30:04.772369 duration_in_ms=2.4
2018-04-10 12:30:04,773 [salt.state       ][INFO    ][25484] Running state [/srv/salt/reclass/classes/service/mysql] at time 12:30:04.773451
2018-04-10 12:30:04,773 [salt.state       ][INFO    ][25484] Executing state file.symlink for /srv/salt/reclass/classes/service/mysql
2018-04-10 12:30:04,775 [salt.state       ][INFO    ][25484] Symlink /srv/salt/reclass/classes/service/mysql is present and owned by root:root
2018-04-10 12:30:04,775 [salt.state       ][INFO    ][25484] Completed state [/srv/salt/reclass/classes/service/mysql] at time 12:30:04.775840 duration_in_ms=2.389
2018-04-10 12:30:04,776 [salt.state       ][INFO    ][25484] Running state [/srv/salt/reclass/classes/service/helm] at time 12:30:04.776879
2018-04-10 12:30:04,777 [salt.state       ][INFO    ][25484] Executing state file.symlink for /srv/salt/reclass/classes/service/helm
2018-04-10 12:30:04,778 [salt.state       ][INFO    ][25484] Symlink /srv/salt/reclass/classes/service/helm is present and owned by root:root
2018-04-10 12:30:04,779 [salt.state       ][INFO    ][25484] Completed state [/srv/salt/reclass/classes/service/helm] at time 12:30:04.779312 duration_in_ms=2.433
2018-04-10 12:30:04,780 [salt.state       ][INFO    ][25484] Running state [/srv/salt/reclass/classes/service/freeipa] at time 12:30:04.780327
2018-04-10 12:30:04,780 [salt.state       ][INFO    ][25484] Executing state file.symlink for /srv/salt/reclass/classes/service/freeipa
2018-04-10 12:30:04,782 [salt.state       ][INFO    ][25484] Symlink /srv/salt/reclass/classes/service/freeipa is present and owned by root:root
2018-04-10 12:30:04,782 [salt.state       ][INFO    ][25484] Completed state [/srv/salt/reclass/classes/service/freeipa] at time 12:30:04.782693 duration_in_ms=2.366
2018-04-10 12:30:04,783 [salt.state       ][INFO    ][25484] Running state [/srv/salt/reclass/classes/service/barbican] at time 12:30:04.783698
2018-04-10 12:30:04,784 [salt.state       ][INFO    ][25484] Executing state file.symlink for /srv/salt/reclass/classes/service/barbican
2018-04-10 12:30:04,785 [salt.state       ][INFO    ][25484] Symlink /srv/salt/reclass/classes/service/barbican is present and owned by root:root
2018-04-10 12:30:04,786 [salt.state       ][INFO    ][25484] Completed state [/srv/salt/reclass/classes/service/barbican] at time 12:30:04.786044 duration_in_ms=2.346
2018-04-10 12:30:04,787 [salt.state       ][INFO    ][25484] Running state [/srv/salt/reclass/classes/service/grafana] at time 12:30:04.787051
2018-04-10 12:30:04,787 [salt.state       ][INFO    ][25484] Executing state file.symlink for /srv/salt/reclass/classes/service/grafana
2018-04-10 12:30:04,788 [salt.state       ][INFO    ][25484] Symlink /srv/salt/reclass/classes/service/grafana is present and owned by root:root
2018-04-10 12:30:04,789 [salt.state       ][INFO    ][25484] Completed state [/srv/salt/reclass/classes/service/grafana] at time 12:30:04.789445 duration_in_ms=2.392
2018-04-10 12:30:04,791 [salt.state       ][INFO    ][25484] Running state [/srv/salt/reclass/classes/service/aptly] at time 12:30:04.791143
2018-04-10 12:30:04,791 [salt.state       ][INFO    ][25484] Executing state file.symlink for /srv/salt/reclass/classes/service/aptly
2018-04-10 12:30:04,794 [salt.state       ][INFO    ][25484] Symlink /srv/salt/reclass/classes/service/aptly is present and owned by root:root
2018-04-10 12:30:04,794 [salt.state       ][INFO    ][25484] Completed state [/srv/salt/reclass/classes/service/aptly] at time 12:30:04.794563 duration_in_ms=3.419
2018-04-10 12:30:04,796 [salt.state       ][INFO    ][25484] Running state [/srv/salt/reclass/classes/service/cassandra] at time 12:30:04.796216
2018-04-10 12:30:04,796 [salt.state       ][INFO    ][25484] Executing state file.symlink for /srv/salt/reclass/classes/service/cassandra
2018-04-10 12:30:04,799 [salt.state       ][INFO    ][25484] Symlink /srv/salt/reclass/classes/service/cassandra is present and owned by root:root
2018-04-10 12:30:04,799 [salt.state       ][INFO    ][25484] Completed state [/srv/salt/reclass/classes/service/cassandra] at time 12:30:04.799570 duration_in_ms=3.354
2018-04-10 12:30:04,801 [salt.state       ][INFO    ][25484] Running state [/srv/salt/reclass/classes/service/lldp] at time 12:30:04.801111
2018-04-10 12:30:04,801 [salt.state       ][INFO    ][25484] Executing state file.symlink for /srv/salt/reclass/classes/service/lldp
2018-04-10 12:30:04,803 [salt.state       ][INFO    ][25484] Symlink /srv/salt/reclass/classes/service/lldp is present and owned by root:root
2018-04-10 12:30:04,804 [salt.state       ][INFO    ][25484] Completed state [/srv/salt/reclass/classes/service/lldp] at time 12:30:04.804177 duration_in_ms=3.066
2018-04-10 12:30:04,805 [salt.state       ][INFO    ][25484] Running state [/srv/salt/reclass/classes/service/collectd] at time 12:30:04.805779
2018-04-10 12:30:04,806 [salt.state       ][INFO    ][25484] Executing state file.symlink for /srv/salt/reclass/classes/service/collectd
2018-04-10 12:30:04,808 [salt.state       ][INFO    ][25484] Symlink /srv/salt/reclass/classes/service/collectd is present and owned by root:root
2018-04-10 12:30:04,808 [salt.state       ][INFO    ][25484] Completed state [/srv/salt/reclass/classes/service/collectd] at time 12:30:04.808881 duration_in_ms=3.101
2018-04-10 12:30:04,810 [salt.state       ][INFO    ][25484] Running state [/srv/salt/reclass/classes/service/git] at time 12:30:04.810428
2018-04-10 12:30:04,810 [salt.state       ][INFO    ][25484] Executing state file.symlink for /srv/salt/reclass/classes/service/git
2018-04-10 12:30:04,813 [salt.state       ][INFO    ][25484] Symlink /srv/salt/reclass/classes/service/git is present and owned by root:root
2018-04-10 12:30:04,813 [salt.state       ][INFO    ][25484] Completed state [/srv/salt/reclass/classes/service/git] at time 12:30:04.813381 duration_in_ms=2.953
2018-04-10 12:30:04,814 [salt.state       ][INFO    ][25484] Running state [/srv/salt/reclass/classes/service/java] at time 12:30:04.814790
2018-04-10 12:30:04,815 [salt.state       ][INFO    ][25484] Executing state file.symlink for /srv/salt/reclass/classes/service/java
2018-04-10 12:30:04,817 [salt.state       ][INFO    ][25484] Symlink /srv/salt/reclass/classes/service/java is present and owned by root:root
2018-04-10 12:30:04,817 [salt.state       ][INFO    ][25484] Completed state [/srv/salt/reclass/classes/service/java] at time 12:30:04.817741 duration_in_ms=2.95
2018-04-10 12:30:04,819 [salt.state       ][INFO    ][25484] Running state [/srv/salt/reclass/classes/service/reclass] at time 12:30:04.819186
2018-04-10 12:30:04,819 [salt.state       ][INFO    ][25484] Executing state file.symlink for /srv/salt/reclass/classes/service/reclass
2018-04-10 12:30:04,821 [salt.state       ][INFO    ][25484] Symlink /srv/salt/reclass/classes/service/reclass is present and owned by root:root
2018-04-10 12:30:04,822 [salt.state       ][INFO    ][25484] Completed state [/srv/salt/reclass/classes/service/reclass] at time 12:30:04.822005 duration_in_ms=2.819
2018-04-10 12:30:04,823 [salt.state       ][INFO    ][25484] Running state [/srv/salt/reclass/classes/service/linux] at time 12:30:04.823369
2018-04-10 12:30:04,823 [salt.state       ][INFO    ][25484] Executing state file.symlink for /srv/salt/reclass/classes/service/linux
2018-04-10 12:30:04,826 [salt.state       ][INFO    ][25484] Symlink /srv/salt/reclass/classes/service/linux is present and owned by root:root
2018-04-10 12:30:04,826 [salt.state       ][INFO    ][25484] Completed state [/srv/salt/reclass/classes/service/linux] at time 12:30:04.826290 duration_in_ms=2.921
2018-04-10 12:30:04,827 [salt.state       ][INFO    ][25484] Running state [/srv/salt/reclass/classes/service/glance] at time 12:30:04.827640
2018-04-10 12:30:04,828 [salt.state       ][INFO    ][25484] Executing state file.symlink for /srv/salt/reclass/classes/service/glance
2018-04-10 12:30:04,830 [salt.state       ][INFO    ][25484] Symlink /srv/salt/reclass/classes/service/glance is present and owned by root:root
2018-04-10 12:30:04,830 [salt.state       ][INFO    ][25484] Completed state [/srv/salt/reclass/classes/service/glance] at time 12:30:04.830425 duration_in_ms=2.785
2018-04-10 12:30:04,831 [salt.state       ][INFO    ][25484] Running state [/srv/salt/reclass/classes/service/keepalived] at time 12:30:04.831719
2018-04-10 12:30:04,832 [salt.state       ][INFO    ][25484] Executing state file.symlink for /srv/salt/reclass/classes/service/keepalived
2018-04-10 12:30:04,834 [salt.state       ][INFO    ][25484] Symlink /srv/salt/reclass/classes/service/keepalived is present and owned by root:root
2018-04-10 12:30:04,834 [salt.state       ][INFO    ][25484] Completed state [/srv/salt/reclass/classes/service/keepalived] at time 12:30:04.834437 duration_in_ms=2.718
2018-04-10 12:30:04,835 [salt.state       ][INFO    ][25484] Running state [/srv/salt/reclass/classes/service/nova] at time 12:30:04.835707
2018-04-10 12:30:04,836 [salt.state       ][INFO    ][25484] Executing state file.symlink for /srv/salt/reclass/classes/service/nova
2018-04-10 12:30:04,838 [salt.state       ][INFO    ][25484] Symlink /srv/salt/reclass/classes/service/nova is present and owned by root:root
2018-04-10 12:30:04,838 [salt.state       ][INFO    ][25484] Completed state [/srv/salt/reclass/classes/service/nova] at time 12:30:04.838427 duration_in_ms=2.72
2018-04-10 12:30:04,839 [salt.state       ][INFO    ][25484] Running state [/srv/salt/reclass/classes/service/rundeck] at time 12:30:04.839719
2018-04-10 12:30:04,840 [salt.state       ][INFO    ][25484] Executing state file.symlink for /srv/salt/reclass/classes/service/rundeck
2018-04-10 12:30:04,842 [salt.state       ][INFO    ][25484] Symlink /srv/salt/reclass/classes/service/rundeck is present and owned by root:root
2018-04-10 12:30:04,842 [salt.state       ][INFO    ][25484] Completed state [/srv/salt/reclass/classes/service/rundeck] at time 12:30:04.842446 duration_in_ms=2.728
2018-04-10 12:30:04,843 [salt.state       ][INFO    ][25484] Running state [/srv/salt/reclass/classes/service/murano] at time 12:30:04.843670
2018-04-10 12:30:04,844 [salt.state       ][INFO    ][25484] Executing state file.symlink for /srv/salt/reclass/classes/service/murano
2018-04-10 12:30:04,845 [salt.state       ][INFO    ][25484] Symlink /srv/salt/reclass/classes/service/murano is present and owned by root:root
2018-04-10 12:30:04,846 [salt.state       ][INFO    ][25484] Completed state [/srv/salt/reclass/classes/service/murano] at time 12:30:04.846231 duration_in_ms=2.561
2018-04-10 12:30:04,847 [salt.state       ][INFO    ][25484] Running state [/srv/salt/reclass/classes/service/keystone] at time 12:30:04.847461
2018-04-10 12:30:04,847 [salt.state       ][INFO    ][25484] Executing state file.symlink for /srv/salt/reclass/classes/service/keystone
2018-04-10 12:30:04,849 [salt.state       ][INFO    ][25484] Symlink /srv/salt/reclass/classes/service/keystone is present and owned by root:root
2018-04-10 12:30:04,850 [salt.state       ][INFO    ][25484] Completed state [/srv/salt/reclass/classes/service/keystone] at time 12:30:04.850048 duration_in_ms=2.586
2018-04-10 12:30:04,851 [salt.state       ][INFO    ][25484] Running state [/srv/salt/reclass/classes/service/etcd] at time 12:30:04.851202
2018-04-10 12:30:04,851 [salt.state       ][INFO    ][25484] Executing state file.symlink for /srv/salt/reclass/classes/service/etcd
2018-04-10 12:30:04,853 [salt.state       ][INFO    ][25484] Symlink /srv/salt/reclass/classes/service/etcd is present and owned by root:root
2018-04-10 12:30:04,853 [salt.state       ][INFO    ][25484] Completed state [/srv/salt/reclass/classes/service/etcd] at time 12:30:04.853701 duration_in_ms=2.498
2018-04-10 12:30:04,854 [salt.state       ][INFO    ][25484] Running state [/srv/salt/reclass/classes/service/ntp] at time 12:30:04.854850
2018-04-10 12:30:04,855 [salt.state       ][INFO    ][25484] Executing state file.symlink for /srv/salt/reclass/classes/service/ntp
2018-04-10 12:30:04,857 [salt.state       ][INFO    ][25484] Symlink /srv/salt/reclass/classes/service/ntp is present and owned by root:root
2018-04-10 12:30:04,857 [salt.state       ][INFO    ][25484] Completed state [/srv/salt/reclass/classes/service/ntp] at time 12:30:04.857340 duration_in_ms=2.489
2018-04-10 12:30:04,858 [salt.state       ][INFO    ][25484] Running state [/srv/salt/reclass/classes/service/jenkins] at time 12:30:04.858503
2018-04-10 12:30:04,858 [salt.state       ][INFO    ][25484] Executing state file.symlink for /srv/salt/reclass/classes/service/jenkins
2018-04-10 12:30:04,861 [salt.state       ][INFO    ][25484] Symlink /srv/salt/reclass/classes/service/jenkins is present and owned by root:root
2018-04-10 12:30:04,861 [salt.state       ][INFO    ][25484] Completed state [/srv/salt/reclass/classes/service/jenkins] at time 12:30:04.861441 duration_in_ms=2.938
2018-04-10 12:30:04,862 [salt.state       ][INFO    ][25484] Running state [/srv/salt/reclass/classes/service/memcached] at time 12:30:04.862543
2018-04-10 12:30:04,862 [salt.state       ][INFO    ][25484] Executing state file.symlink for /srv/salt/reclass/classes/service/memcached
2018-04-10 12:30:04,864 [salt.state       ][INFO    ][25484] Symlink /srv/salt/reclass/classes/service/memcached is present and owned by root:root
2018-04-10 12:30:04,864 [salt.state       ][INFO    ][25484] Completed state [/srv/salt/reclass/classes/service/memcached] at time 12:30:04.864876 duration_in_ms=2.332
2018-04-10 12:30:04,866 [salt.state       ][INFO    ][25484] Running state [/srv/salt/reclass/classes/service/neutron] at time 12:30:04.866688
2018-04-10 12:30:04,867 [salt.state       ][INFO    ][25484] Executing state file.symlink for /srv/salt/reclass/classes/service/neutron
2018-04-10 12:30:04,868 [salt.state       ][INFO    ][25484] Symlink /srv/salt/reclass/classes/service/neutron is present and owned by root:root
2018-04-10 12:30:04,869 [salt.state       ][INFO    ][25484] Completed state [/srv/salt/reclass/classes/service/neutron] at time 12:30:04.869064 duration_in_ms=2.375
2018-04-10 12:30:04,870 [salt.state       ][INFO    ][25484] Running state [/srv/salt/reclass/classes/service/designate] at time 12:30:04.870275
2018-04-10 12:30:04,870 [salt.state       ][INFO    ][25484] Executing state file.symlink for /srv/salt/reclass/classes/service/designate
2018-04-10 12:30:04,872 [salt.state       ][INFO    ][25484] Symlink /srv/salt/reclass/classes/service/designate is present and owned by root:root
2018-04-10 12:30:04,872 [salt.state       ][INFO    ][25484] Completed state [/srv/salt/reclass/classes/service/designate] at time 12:30:04.872522 duration_in_ms=2.247
2018-04-10 12:30:04,873 [salt.state       ][INFO    ][25484] Running state [/srv/salt/reclass/classes/service/iptables] at time 12:30:04.873603
2018-04-10 12:30:04,873 [salt.state       ][INFO    ][25484] Executing state file.symlink for /srv/salt/reclass/classes/service/iptables
2018-04-10 12:30:04,875 [salt.state       ][INFO    ][25484] Symlink /srv/salt/reclass/classes/service/iptables is present and owned by root:root
2018-04-10 12:30:04,875 [salt.state       ][INFO    ][25484] Completed state [/srv/salt/reclass/classes/service/iptables] at time 12:30:04.875838 duration_in_ms=2.236
2018-04-10 12:30:04,876 [salt.state       ][INFO    ][25484] Running state [/srv/salt/reclass/classes/service/statsd] at time 12:30:04.876900
2018-04-10 12:30:04,877 [salt.state       ][INFO    ][25484] Executing state file.symlink for /srv/salt/reclass/classes/service/statsd
2018-04-10 12:30:04,878 [salt.state       ][INFO    ][25484] Symlink /srv/salt/reclass/classes/service/statsd is present and owned by root:root
2018-04-10 12:30:04,879 [salt.state       ][INFO    ][25484] Completed state [/srv/salt/reclass/classes/service/statsd] at time 12:30:04.879176 duration_in_ms=2.277
2018-04-10 12:30:04,880 [salt.state       ][INFO    ][25484] Running state [/srv/salt/reclass/classes/service/gerrit] at time 12:30:04.880228
2018-04-10 12:30:04,880 [salt.state       ][INFO    ][25484] Executing state file.symlink for /srv/salt/reclass/classes/service/gerrit
2018-04-10 12:30:04,882 [salt.state       ][INFO    ][25484] Symlink /srv/salt/reclass/classes/service/gerrit is present and owned by root:root
2018-04-10 12:30:04,882 [salt.state       ][INFO    ][25484] Completed state [/srv/salt/reclass/classes/service/gerrit] at time 12:30:04.882381 duration_in_ms=2.152
2018-04-10 12:30:04,883 [salt.state       ][INFO    ][25484] Running state [/srv/salt/reclass/classes/service/zookeeper] at time 12:30:04.883378
2018-04-10 12:30:04,883 [salt.state       ][INFO    ][25484] Executing state file.symlink for /srv/salt/reclass/classes/service/zookeeper
2018-04-10 12:30:04,885 [salt.state       ][INFO    ][25484] Symlink /srv/salt/reclass/classes/service/zookeeper is present and owned by root:root
2018-04-10 12:30:04,885 [salt.state       ][INFO    ][25484] Completed state [/srv/salt/reclass/classes/service/zookeeper] at time 12:30:04.885533 duration_in_ms=2.155
2018-04-10 12:30:04,886 [salt.state       ][INFO    ][25484] Running state [/srv/salt/reclass/classes/service/kubernetes] at time 12:30:04.886531
2018-04-10 12:30:04,886 [salt.state       ][INFO    ][25484] Executing state file.symlink for /srv/salt/reclass/classes/service/kubernetes
2018-04-10 12:30:04,888 [salt.state       ][INFO    ][25484] Symlink /srv/salt/reclass/classes/service/kubernetes is present and owned by root:root
2018-04-10 12:30:04,888 [salt.state       ][INFO    ][25484] Completed state [/srv/salt/reclass/classes/service/kubernetes] at time 12:30:04.888655 duration_in_ms=2.123
2018-04-10 12:30:04,889 [salt.state       ][INFO    ][25484] Running state [/srv/salt/reclass/classes/service/python] at time 12:30:04.889699
2018-04-10 12:30:04,890 [salt.state       ][INFO    ][25484] Executing state file.symlink for /srv/salt/reclass/classes/service/python
2018-04-10 12:30:04,891 [salt.state       ][INFO    ][25484] Symlink /srv/salt/reclass/classes/service/python is present and owned by root:root
2018-04-10 12:30:04,891 [salt.state       ][INFO    ][25484] Completed state [/srv/salt/reclass/classes/service/python] at time 12:30:04.891780 duration_in_ms=2.081
2018-04-10 12:30:04,892 [salt.state       ][INFO    ][25484] Running state [/srv/salt/reclass/classes/service/mongodb] at time 12:30:04.892739
2018-04-10 12:30:04,893 [salt.state       ][INFO    ][25484] Executing state file.symlink for /srv/salt/reclass/classes/service/mongodb
2018-04-10 12:30:04,894 [salt.state       ][INFO    ][25484] Symlink /srv/salt/reclass/classes/service/mongodb is present and owned by root:root
2018-04-10 12:30:04,894 [salt.state       ][INFO    ][25484] Completed state [/srv/salt/reclass/classes/service/mongodb] at time 12:30:04.894824 duration_in_ms=2.086
2018-04-10 12:30:04,895 [salt.state       ][INFO    ][25484] Running state [/srv/salt/reclass/classes/service/maas] at time 12:30:04.895781
2018-04-10 12:30:04,896 [salt.state       ][INFO    ][25484] Executing state file.symlink for /srv/salt/reclass/classes/service/maas
2018-04-10 12:30:04,897 [salt.state       ][INFO    ][25484] Symlink /srv/salt/reclass/classes/service/maas is present and owned by root:root
2018-04-10 12:30:04,897 [salt.state       ][INFO    ][25484] Completed state [/srv/salt/reclass/classes/service/maas] at time 12:30:04.897901 duration_in_ms=2.12
2018-04-10 12:30:04,898 [salt.state       ][INFO    ][25484] Running state [/srv/salt/reclass/classes/service/libvirt] at time 12:30:04.898869
2018-04-10 12:30:04,899 [salt.state       ][INFO    ][25484] Executing state file.symlink for /srv/salt/reclass/classes/service/libvirt
2018-04-10 12:30:04,900 [salt.state       ][INFO    ][25484] Symlink /srv/salt/reclass/classes/service/libvirt is present and owned by root:root
2018-04-10 12:30:04,900 [salt.state       ][INFO    ][25484] Completed state [/srv/salt/reclass/classes/service/libvirt] at time 12:30:04.900898 duration_in_ms=2.029
2018-04-10 12:30:04,901 [salt.state       ][INFO    ][25484] Running state [/srv/salt/reclass/classes/service/heka] at time 12:30:04.901832
2018-04-10 12:30:04,902 [salt.state       ][INFO    ][25484] Executing state file.symlink for /srv/salt/reclass/classes/service/heka
2018-04-10 12:30:04,903 [salt.state       ][INFO    ][25484] Symlink /srv/salt/reclass/classes/service/heka is present and owned by root:root
2018-04-10 12:30:04,903 [salt.state       ][INFO    ][25484] Completed state [/srv/salt/reclass/classes/service/heka] at time 12:30:04.903788 duration_in_ms=1.955
2018-04-10 12:30:04,904 [salt.state       ][INFO    ][25484] Running state [/srv/salt/reclass/classes/service/heat] at time 12:30:04.904697
2018-04-10 12:30:04,904 [salt.state       ][INFO    ][25484] Executing state file.symlink for /srv/salt/reclass/classes/service/heat
2018-04-10 12:30:04,906 [salt.state       ][INFO    ][25484] Symlink /srv/salt/reclass/classes/service/heat is present and owned by root:root
2018-04-10 12:30:04,906 [salt.state       ][INFO    ][25484] Completed state [/srv/salt/reclass/classes/service/heat] at time 12:30:04.906665 duration_in_ms=1.967
2018-04-10 12:30:04,907 [salt.state       ][INFO    ][25484] Running state [/srv/salt/reclass/classes/service/openldap] at time 12:30:04.907575
2018-04-10 12:30:04,907 [salt.state       ][INFO    ][25484] Executing state file.symlink for /srv/salt/reclass/classes/service/openldap
2018-04-10 12:30:04,909 [salt.state       ][INFO    ][25484] Symlink /srv/salt/reclass/classes/service/openldap is present and owned by root:root
2018-04-10 12:30:04,909 [salt.state       ][INFO    ][25484] Completed state [/srv/salt/reclass/classes/service/openldap] at time 12:30:04.909568 duration_in_ms=1.993
2018-04-10 12:30:04,910 [salt.state       ][INFO    ][25484] Running state [/srv/salt/reclass/classes/service/influxdb] at time 12:30:04.910445
2018-04-10 12:30:04,910 [salt.state       ][INFO    ][25484] Executing state file.symlink for /srv/salt/reclass/classes/service/influxdb
2018-04-10 12:30:04,912 [salt.state       ][INFO    ][25484] Symlink /srv/salt/reclass/classes/service/influxdb is present and owned by root:root
2018-04-10 12:30:04,912 [salt.state       ][INFO    ][25484] Completed state [/srv/salt/reclass/classes/service/influxdb] at time 12:30:04.912344 duration_in_ms=1.899
2018-04-10 12:30:04,913 [salt.state       ][INFO    ][25484] Running state [/srv/salt/reclass/classes/service/avinetworks] at time 12:30:04.913270
2018-04-10 12:30:04,913 [salt.state       ][INFO    ][25484] Executing state file.symlink for /srv/salt/reclass/classes/service/avinetworks
2018-04-10 12:30:04,914 [salt.state       ][INFO    ][25484] Symlink /srv/salt/reclass/classes/service/avinetworks is present and owned by root:root
2018-04-10 12:30:04,915 [salt.state       ][INFO    ][25484] Completed state [/srv/salt/reclass/classes/service/avinetworks] at time 12:30:04.915158 duration_in_ms=1.888
2018-04-10 12:30:04,916 [salt.state       ][INFO    ][25484] Running state [/srv/salt/reclass/classes/service/sphinx] at time 12:30:04.916036
2018-04-10 12:30:04,916 [salt.state       ][INFO    ][25484] Executing state file.symlink for /srv/salt/reclass/classes/service/sphinx
2018-04-10 12:30:04,917 [salt.state       ][INFO    ][25484] Symlink /srv/salt/reclass/classes/service/sphinx is present and owned by root:root
2018-04-10 12:30:04,917 [salt.state       ][INFO    ][25484] Completed state [/srv/salt/reclass/classes/service/sphinx] at time 12:30:04.917938 duration_in_ms=1.903
2018-04-10 12:30:04,918 [salt.state       ][INFO    ][25484] Running state [/srv/salt/reclass/classes/service/prometheus] at time 12:30:04.918821
2018-04-10 12:30:04,919 [salt.state       ][INFO    ][25484] Executing state file.symlink for /srv/salt/reclass/classes/service/prometheus
2018-04-10 12:30:04,920 [salt.state       ][INFO    ][25484] Symlink /srv/salt/reclass/classes/service/prometheus is present and owned by root:root
2018-04-10 12:30:04,920 [salt.state       ][INFO    ][25484] Completed state [/srv/salt/reclass/classes/service/prometheus] at time 12:30:04.920635 duration_in_ms=1.814
2018-04-10 12:30:04,921 [salt.state       ][INFO    ][25484] Running state [/srv/salt/reclass/classes/service/swift] at time 12:30:04.921503
2018-04-10 12:30:04,921 [salt.state       ][INFO    ][25484] Executing state file.symlink for /srv/salt/reclass/classes/service/swift
2018-04-10 12:30:04,923 [salt.state       ][INFO    ][25484] Symlink /srv/salt/reclass/classes/service/swift is present and owned by root:root
2018-04-10 12:30:04,923 [salt.state       ][INFO    ][25484] Completed state [/srv/salt/reclass/classes/service/swift] at time 12:30:04.923300 duration_in_ms=1.797
2018-04-10 12:30:04,924 [salt.state       ][INFO    ][25484] Running state [/srv/salt/reclass/classes/service/fluentd] at time 12:30:04.924128
2018-04-10 12:30:04,924 [salt.state       ][INFO    ][25484] Executing state file.symlink for /srv/salt/reclass/classes/service/fluentd
2018-04-10 12:30:04,925 [salt.state       ][INFO    ][25484] Symlink /srv/salt/reclass/classes/service/fluentd is present and owned by root:root
2018-04-10 12:30:04,926 [salt.state       ][INFO    ][25484] Completed state [/srv/salt/reclass/classes/service/fluentd] at time 12:30:04.926029 duration_in_ms=1.9
2018-04-10 12:30:04,926 [salt.state       ][INFO    ][25484] Running state [/srv/salt/reclass/classes/service/billometer] at time 12:30:04.926878
2018-04-10 12:30:04,927 [salt.state       ][INFO    ][25484] Executing state file.symlink for /srv/salt/reclass/classes/service/billometer
2018-04-10 12:30:04,928 [salt.state       ][INFO    ][25484] Symlink /srv/salt/reclass/classes/service/billometer is present and owned by root:root
2018-04-10 12:30:04,928 [salt.state       ][INFO    ][25484] Completed state [/srv/salt/reclass/classes/service/billometer] at time 12:30:04.928664 duration_in_ms=1.786
2018-04-10 12:30:04,929 [salt.state       ][INFO    ][25484] Running state [/srv/salt/reclass/classes/service/haproxy] at time 12:30:04.929558
2018-04-10 12:30:04,929 [salt.state       ][INFO    ][25484] Executing state file.symlink for /srv/salt/reclass/classes/service/haproxy
2018-04-10 12:30:04,931 [salt.state       ][INFO    ][25484] Symlink /srv/salt/reclass/classes/service/haproxy is present and owned by root:root
2018-04-10 12:30:04,931 [salt.state       ][INFO    ][25484] Completed state [/srv/salt/reclass/classes/service/haproxy] at time 12:30:04.931323 duration_in_ms=1.765
2018-04-10 12:30:04,932 [salt.state       ][INFO    ][25484] Running state [/srv/salt/reclass/classes/service/ceilometer] at time 12:30:04.932120
2018-04-10 12:30:04,932 [salt.state       ][INFO    ][25484] Executing state file.symlink for /srv/salt/reclass/classes/service/ceilometer
2018-04-10 12:30:04,933 [salt.state       ][INFO    ][25484] Symlink /srv/salt/reclass/classes/service/ceilometer is present and owned by root:root
2018-04-10 12:30:04,933 [salt.state       ][INFO    ][25484] Completed state [/srv/salt/reclass/classes/service/ceilometer] at time 12:30:04.933863 duration_in_ms=1.743
2018-04-10 12:30:04,934 [salt.state       ][INFO    ][25484] Running state [/srv/salt/reclass/classes/service/aptcacher] at time 12:30:04.934672
2018-04-10 12:30:04,934 [salt.state       ][INFO    ][25484] Executing state file.symlink for /srv/salt/reclass/classes/service/aptcacher
2018-04-10 12:30:04,936 [salt.state       ][INFO    ][25484] Symlink /srv/salt/reclass/classes/service/aptcacher is present and owned by root:root
2018-04-10 12:30:04,936 [salt.state       ][INFO    ][25484] Completed state [/srv/salt/reclass/classes/service/aptcacher] at time 12:30:04.936376 duration_in_ms=1.704
2018-04-10 12:30:04,937 [salt.state       ][INFO    ][25484] Running state [/srv/salt/reclass/classes/service/nginx] at time 12:30:04.937445
2018-04-10 12:30:04,937 [salt.state       ][INFO    ][25484] Executing state file.symlink for /srv/salt/reclass/classes/service/nginx
2018-04-10 12:30:04,939 [salt.state       ][INFO    ][25484] Symlink /srv/salt/reclass/classes/service/nginx is present and owned by root:root
2018-04-10 12:30:04,939 [salt.state       ][INFO    ][25484] Completed state [/srv/salt/reclass/classes/service/nginx] at time 12:30:04.939177 duration_in_ms=1.732
2018-04-10 12:30:04,940 [salt.state       ][INFO    ][25484] Running state [/srv/salt/reclass/classes/service/bind] at time 12:30:04.939995
2018-04-10 12:30:04,940 [salt.state       ][INFO    ][25484] Executing state file.symlink for /srv/salt/reclass/classes/service/bind
2018-04-10 12:30:04,941 [salt.state       ][INFO    ][25484] Symlink /srv/salt/reclass/classes/service/bind is present and owned by root:root
2018-04-10 12:30:04,941 [salt.state       ][INFO    ][25484] Completed state [/srv/salt/reclass/classes/service/bind] at time 12:30:04.941725 duration_in_ms=1.73
2018-04-10 12:30:04,942 [salt.state       ][INFO    ][25484] Running state [/srv/salt/reclass/classes/service/redis] at time 12:30:04.942509
2018-04-10 12:30:04,942 [salt.state       ][INFO    ][25484] Executing state file.symlink for /srv/salt/reclass/classes/service/redis
2018-04-10 12:30:04,943 [salt.state       ][INFO    ][25484] Symlink /srv/salt/reclass/classes/service/redis is present and owned by root:root
2018-04-10 12:30:04,944 [salt.state       ][INFO    ][25484] Completed state [/srv/salt/reclass/classes/service/redis] at time 12:30:04.944149 duration_in_ms=1.64
2018-04-10 12:30:04,944 [salt.state       ][INFO    ][25484] Running state [/srv/salt/reclass/classes/service/opencontrail] at time 12:30:04.944934
2018-04-10 12:30:04,945 [salt.state       ][INFO    ][25484] Executing state file.symlink for /srv/salt/reclass/classes/service/opencontrail
2018-04-10 12:30:04,946 [salt.state       ][INFO    ][25484] Symlink /srv/salt/reclass/classes/service/opencontrail is present and owned by root:root
2018-04-10 12:30:04,946 [salt.state       ][INFO    ][25484] Completed state [/srv/salt/reclass/classes/service/opencontrail] at time 12:30:04.946632 duration_in_ms=1.698
2018-04-10 12:30:04,947 [salt.state       ][INFO    ][25484] Running state [/srv/salt/reclass/classes/service/ccp] at time 12:30:04.947419
2018-04-10 12:30:04,947 [salt.state       ][INFO    ][25484] Executing state file.symlink for /srv/salt/reclass/classes/service/ccp
2018-04-10 12:30:04,948 [salt.state       ][INFO    ][25484] Symlink /srv/salt/reclass/classes/service/ccp is present and owned by root:root
2018-04-10 12:30:04,949 [salt.state       ][INFO    ][25484] Completed state [/srv/salt/reclass/classes/service/ccp] at time 12:30:04.949067 duration_in_ms=1.648
2018-04-10 12:30:04,949 [salt.state       ][INFO    ][25484] Running state [/srv/salt/reclass/classes/service/rabbitmq] at time 12:30:04.949906
2018-04-10 12:30:04,950 [salt.state       ][INFO    ][25484] Executing state file.symlink for /srv/salt/reclass/classes/service/rabbitmq
2018-04-10 12:30:04,951 [salt.state       ][INFO    ][25484] Symlink /srv/salt/reclass/classes/service/rabbitmq is present and owned by root:root
2018-04-10 12:30:04,951 [salt.state       ][INFO    ][25484] Completed state [/srv/salt/reclass/classes/service/rabbitmq] at time 12:30:04.951541 duration_in_ms=1.635
2018-04-10 12:30:04,952 [salt.state       ][INFO    ][25484] Running state [/srv/salt/reclass/classes/service/octavia] at time 12:30:04.952294
2018-04-10 12:30:04,952 [salt.state       ][INFO    ][25484] Executing state file.symlink for /srv/salt/reclass/classes/service/octavia
2018-04-10 12:30:04,953 [salt.state       ][INFO    ][25484] Symlink /srv/salt/reclass/classes/service/octavia is present and owned by root:root
2018-04-10 12:30:04,953 [salt.state       ][INFO    ][25484] Completed state [/srv/salt/reclass/classes/service/octavia] at time 12:30:04.953898 duration_in_ms=1.604
2018-04-10 12:30:04,954 [salt.state       ][INFO    ][25484] Running state [/srv/salt/reclass/classes/service/elasticsearch] at time 12:30:04.954661
2018-04-10 12:30:04,954 [salt.state       ][INFO    ][25484] Executing state file.symlink for /srv/salt/reclass/classes/service/elasticsearch
2018-04-10 12:30:04,956 [salt.state       ][INFO    ][25484] Symlink /srv/salt/reclass/classes/service/elasticsearch is present and owned by root:root
2018-04-10 12:30:04,956 [salt.state       ][INFO    ][25484] Completed state [/srv/salt/reclass/classes/service/elasticsearch] at time 12:30:04.956253 duration_in_ms=1.583
2018-04-10 12:30:04,957 [salt.state       ][INFO    ][25484] Running state [/srv/salt/reclass/classes/service/graphite] at time 12:30:04.957005
2018-04-10 12:30:04,957 [salt.state       ][INFO    ][25484] Executing state file.symlink for /srv/salt/reclass/classes/service/graphite
2018-04-10 12:30:04,958 [salt.state       ][INFO    ][25484] Symlink /srv/salt/reclass/classes/service/graphite is present and owned by root:root
2018-04-10 12:30:04,958 [salt.state       ][INFO    ][25484] Completed state [/srv/salt/reclass/classes/service/graphite] at time 12:30:04.958627 duration_in_ms=1.621
2018-04-10 12:30:04,959 [salt.state       ][INFO    ][25484] Running state [/srv/salt/reclass/classes/service/postgresql] at time 12:30:04.959385
2018-04-10 12:30:04,959 [salt.state       ][INFO    ][25484] Executing state file.symlink for /srv/salt/reclass/classes/service/postgresql
2018-04-10 12:30:04,960 [salt.state       ][INFO    ][25484] Symlink /srv/salt/reclass/classes/service/postgresql is present and owned by root:root
2018-04-10 12:30:04,960 [salt.state       ][INFO    ][25484] Completed state [/srv/salt/reclass/classes/service/postgresql] at time 12:30:04.960942 duration_in_ms=1.557
2018-04-10 12:30:04,961 [salt.state       ][INFO    ][25484] Running state [/srv/salt/reclass/classes/service/horizon] at time 12:30:04.961690
2018-04-10 12:30:04,961 [salt.state       ][INFO    ][25484] Executing state file.symlink for /srv/salt/reclass/classes/service/horizon
2018-04-10 12:30:04,963 [salt.state       ][INFO    ][25484] Symlink /srv/salt/reclass/classes/service/horizon is present and owned by root:root
2018-04-10 12:30:04,963 [salt.state       ][INFO    ][25484] Completed state [/srv/salt/reclass/classes/service/horizon] at time 12:30:04.963232 duration_in_ms=1.542
2018-04-10 12:30:04,963 [salt.state       ][INFO    ][25484] Running state [/srv/salt/reclass/classes/service/openssh] at time 12:30:04.963955
2018-04-10 12:30:04,964 [salt.state       ][INFO    ][25484] Executing state file.symlink for /srv/salt/reclass/classes/service/openssh
2018-04-10 12:30:04,965 [salt.state       ][INFO    ][25484] Symlink /srv/salt/reclass/classes/service/openssh is present and owned by root:root
2018-04-10 12:30:04,965 [salt.state       ][INFO    ][25484] Completed state [/srv/salt/reclass/classes/service/openssh] at time 12:30:04.965539 duration_in_ms=1.584
2018-04-10 12:30:04,966 [salt.state       ][INFO    ][25484] Running state [/srv/salt/reclass/classes/service/cinder] at time 12:30:04.966269
2018-04-10 12:30:04,966 [salt.state       ][INFO    ][25484] Executing state file.symlink for /srv/salt/reclass/classes/service/cinder
2018-04-10 12:30:04,967 [salt.state       ][INFO    ][25484] Symlink /srv/salt/reclass/classes/service/cinder is present and owned by root:root
2018-04-10 12:30:04,967 [salt.state       ][INFO    ][25484] Completed state [/srv/salt/reclass/classes/service/cinder] at time 12:30:04.967787 duration_in_ms=1.518
2018-04-10 12:30:04,968 [salt.state       ][INFO    ][25484] Running state [/srv/salt/reclass/classes/service/docker] at time 12:30:04.968508
2018-04-10 12:30:04,968 [salt.state       ][INFO    ][25484] Executing state file.symlink for /srv/salt/reclass/classes/service/docker
2018-04-10 12:30:04,969 [salt.state       ][INFO    ][25484] Symlink /srv/salt/reclass/classes/service/docker is present and owned by root:root
2018-04-10 12:30:04,970 [salt.state       ][INFO    ][25484] Completed state [/srv/salt/reclass/classes/service/docker] at time 12:30:04.970082 duration_in_ms=1.574
2018-04-10 12:30:04,970 [salt.state       ][INFO    ][25484] Running state [/srv/salt/reclass/classes/service/salt] at time 12:30:04.970789
2018-04-10 12:30:04,971 [salt.state       ][INFO    ][25484] Executing state file.symlink for /srv/salt/reclass/classes/service/salt
2018-04-10 12:30:04,972 [salt.state       ][INFO    ][25484] Symlink /srv/salt/reclass/classes/service/salt is present and owned by root:root
2018-04-10 12:30:04,972 [salt.state       ][INFO    ][25484] Completed state [/srv/salt/reclass/classes/service/salt] at time 12:30:04.972271 duration_in_ms=1.483
2018-04-10 12:30:04,972 [salt.state       ][INFO    ][25484] Running state [/srv/salt/reclass/classes/service/devops_portal] at time 12:30:04.972966
2018-04-10 12:30:04,973 [salt.state       ][INFO    ][25484] Executing state file.symlink for /srv/salt/reclass/classes/service/devops_portal
2018-04-10 12:30:04,974 [salt.state       ][INFO    ][25484] Symlink /srv/salt/reclass/classes/service/devops_portal is present and owned by root:root
2018-04-10 12:30:04,974 [salt.state       ][INFO    ][25484] Completed state [/srv/salt/reclass/classes/service/devops_portal] at time 12:30:04.974517 duration_in_ms=1.551
2018-04-10 12:30:04,974 [salt.state       ][INFO    ][25484] Running state [salt-minion] at time 12:30:04.974704
2018-04-10 12:30:04,974 [salt.state       ][INFO    ][25484] Executing state pkg.installed for salt-minion
2018-04-10 12:30:04,979 [salt.state       ][INFO    ][25484] All specified packages are already installed
2018-04-10 12:30:04,979 [salt.state       ][INFO    ][25484] Completed state [salt-minion] at time 12:30:04.979727 duration_in_ms=5.023
2018-04-10 12:30:04,979 [salt.state       ][INFO    ][25484] Running state [salt_minion_dependency_packages] at time 12:30:04.979906
2018-04-10 12:30:04,980 [salt.state       ][INFO    ][25484] Executing state pkg.installed for salt_minion_dependency_packages
2018-04-10 12:30:04,984 [salt.state       ][INFO    ][25484] All specified packages are already installed
2018-04-10 12:30:04,984 [salt.state       ][INFO    ][25484] Completed state [salt_minion_dependency_packages] at time 12:30:04.984707 duration_in_ms=4.801
2018-04-10 12:30:04,985 [salt.state       ][INFO    ][25484] Running state [/etc/salt/minion.d/minion.conf] at time 12:30:04.985660
2018-04-10 12:30:04,985 [salt.state       ][INFO    ][25484] Executing state file.managed for /etc/salt/minion.d/minion.conf
2018-04-10 12:30:05,135 [salt.state       ][INFO    ][25484] File /etc/salt/minion.d/minion.conf is in the correct state
2018-04-10 12:30:05,135 [salt.state       ][INFO    ][25484] Completed state [/etc/salt/minion.d/minion.conf] at time 12:30:05.135589 duration_in_ms=149.928
2018-04-10 12:30:05,136 [salt.state       ][INFO    ][25484] Running state [/etc/salt/minion.d/_pki.conf] at time 12:30:05.136260
2018-04-10 12:30:05,136 [salt.state       ][INFO    ][25484] Executing state file.managed for /etc/salt/minion.d/_pki.conf
2018-04-10 12:30:05,139 [salt.state       ][INFO    ][25484] File /etc/salt/minion.d/_pki.conf is in the correct state
2018-04-10 12:30:05,139 [salt.state       ][INFO    ][25484] Completed state [/etc/salt/minion.d/_pki.conf] at time 12:30:05.139459 duration_in_ms=3.199
2018-04-10 12:30:05,142 [salt.state       ][INFO    ][25484] Running state [salt-minion] at time 12:30:05.141987
2018-04-10 12:30:05,142 [salt.state       ][INFO    ][25484] Executing state service.running for salt-minion
2018-04-10 12:30:05,142 [salt.loaded.int.module.cmdmod][INFO    ][25484] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2018-04-10 12:30:05,162 [salt.loaded.int.module.cmdmod][INFO    ][25484] Executing command ['systemctl', 'is-active', 'salt-minion.service'] in directory '/root'
2018-04-10 12:30:05,174 [salt.loaded.int.module.cmdmod][INFO    ][25484] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2018-04-10 12:30:05,187 [salt.state       ][INFO    ][25484] The service salt-minion is already running
2018-04-10 12:30:05,187 [salt.state       ][INFO    ][25484] Completed state [salt-minion] at time 12:30:05.187417 duration_in_ms=45.43
2018-04-10 12:30:05,190 [salt.state       ][INFO    ][25484] Running state [/etc/salt/grains.d] at time 12:30:05.190015
2018-04-10 12:30:05,190 [salt.state       ][INFO    ][25484] Executing state file.directory for /etc/salt/grains.d
2018-04-10 12:30:05,190 [salt.state       ][INFO    ][25484] Directory /etc/salt/grains.d is in the correct state
2018-04-10 12:30:05,191 [salt.state       ][INFO    ][25484] Completed state [/etc/salt/grains.d] at time 12:30:05.190974 duration_in_ms=0.959
2018-04-10 12:30:05,191 [salt.state       ][INFO    ][25484] Running state [/etc/salt/grains] at time 12:30:05.191700
2018-04-10 12:30:05,191 [salt.state       ][INFO    ][25484] Executing state file.managed for /etc/salt/grains
2018-04-10 12:30:05,192 [salt.state       ][INFO    ][25484] File /etc/salt/grains exists with proper permissions. No changes made.
2018-04-10 12:30:05,192 [salt.state       ][INFO    ][25484] Completed state [/etc/salt/grains] at time 12:30:05.192383 duration_in_ms=0.682
2018-04-10 12:30:05,192 [salt.state       ][INFO    ][25484] Running state [/etc/salt/grains.d/placeholder] at time 12:30:05.192961
2018-04-10 12:30:05,193 [salt.state       ][INFO    ][25484] Executing state file.managed for /etc/salt/grains.d/placeholder
2018-04-10 12:30:05,193 [salt.state       ][INFO    ][25484] File /etc/salt/grains.d/placeholder exists with proper permissions. No changes made.
2018-04-10 12:30:05,193 [salt.state       ][INFO    ][25484] Completed state [/etc/salt/grains.d/placeholder] at time 12:30:05.193662 duration_in_ms=0.702
2018-04-10 12:30:05,194 [salt.state       ][INFO    ][25484] Running state [/etc/salt/grains.d/sphinx] at time 12:30:05.194247
2018-04-10 12:30:05,194 [salt.state       ][INFO    ][25484] Executing state file.managed for /etc/salt/grains.d/sphinx
2018-04-10 12:30:05,199 [salt.state       ][INFO    ][25484] 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-04-10 12:30:05,199 [salt.state       ][INFO    ][25484] Completed state [/etc/salt/grains.d/sphinx] at time 12:30:05.199533 duration_in_ms=5.286
2018-04-10 12:30:05,200 [salt.state       ][INFO    ][25484] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 12:30:05.200688
2018-04-10 12:30:05,200 [salt.state       ][INFO    ][25484] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2018-04-10 12:30:05,201 [salt.state       ][INFO    ][25484] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2018-04-10 12:30:05,201 [salt.state       ][INFO    ][25484] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 12:30:05.201257 duration_in_ms=0.569
2018-04-10 12:30:05,201 [salt.state       ][INFO    ][25484] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 12:30:05.201399
2018-04-10 12:30:05,201 [salt.state       ][INFO    ][25484] Executing state cmd.mod_watch for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2018-04-10 12:30:05,202 [salt.loaded.int.module.cmdmod][INFO    ][25484] Executing command 'python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"' in directory '/root'
2018-04-10 12:30:05,307 [salt.state       ][INFO    ][25484] {'pid': 25859, 'retcode': 0, 'stderr': '', 'stdout': ''}
2018-04-10 12:30:05,308 [salt.state       ][INFO    ][25484] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 12:30:05.308224 duration_in_ms=106.824
2018-04-10 12:30:05,309 [salt.state       ][INFO    ][25484] Running state [/etc/salt/grains.d/dns_records] at time 12:30:05.309200
2018-04-10 12:30:05,309 [salt.state       ][INFO    ][25484] Executing state file.managed for /etc/salt/grains.d/dns_records
2018-04-10 12:30:05,336 [salt.state       ][INFO    ][25484] File /etc/salt/grains.d/dns_records is in the correct state
2018-04-10 12:30:05,337 [salt.state       ][INFO    ][25484] Completed state [/etc/salt/grains.d/dns_records] at time 12:30:05.337073 duration_in_ms=27.872
2018-04-10 12:30:05,338 [salt.state       ][INFO    ][25484] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 12:30:05.338508
2018-04-10 12:30:05,338 [salt.state       ][INFO    ][25484] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"
2018-04-10 12:30:05,338 [salt.state       ][INFO    ][25484] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"
2018-04-10 12:30:05,339 [salt.state       ][INFO    ][25484] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 12:30:05.339060 duration_in_ms=0.553
2018-04-10 12:30:05,339 [salt.state       ][INFO    ][25484] Running state [/etc/salt/grains.d/salt] at time 12:30:05.339655
2018-04-10 12:30:05,339 [salt.state       ][INFO    ][25484] Executing state file.managed for /etc/salt/grains.d/salt
2018-04-10 12:30:05,353 [salt.state       ][INFO    ][25484] File /etc/salt/grains.d/salt is in the correct state
2018-04-10 12:30:05,353 [salt.state       ][INFO    ][25484] Completed state [/etc/salt/grains.d/salt] at time 12:30:05.353467 duration_in_ms=13.812
2018-04-10 12:30:05,354 [salt.state       ][INFO    ][25484] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 12:30:05.354625
2018-04-10 12:30:05,354 [salt.state       ][INFO    ][25484] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2018-04-10 12:30:05,355 [salt.state       ][INFO    ][25484] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2018-04-10 12:30:05,355 [salt.state       ][INFO    ][25484] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 12:30:05.355170 duration_in_ms=0.545
2018-04-10 12:30:05,357 [salt.state       ][INFO    ][25484] Running state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 12:30:05.357411
2018-04-10 12:30:05,357 [salt.state       ][INFO    ][25484] Executing state cmd.wait for cat /etc/salt/grains.d/* > /etc/salt/grains
2018-04-10 12:30:05,357 [salt.state       ][INFO    ][25484] No changes made for cat /etc/salt/grains.d/* > /etc/salt/grains
2018-04-10 12:30:05,357 [salt.state       ][INFO    ][25484] Completed state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 12:30:05.357963 duration_in_ms=0.552
2018-04-10 12:30:05,358 [salt.state       ][INFO    ][25484] Running state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 12:30:05.358100
2018-04-10 12:30:05,358 [salt.state       ][INFO    ][25484] Executing state cmd.mod_watch for cat /etc/salt/grains.d/* > /etc/salt/grains
2018-04-10 12:30:05,359 [salt.loaded.int.module.cmdmod][INFO    ][25484] Executing command 'cat /etc/salt/grains.d/* > /etc/salt/grains' in directory '/root'
2018-04-10 12:30:05,373 [salt.state       ][INFO    ][25484] {'pid': 25861, 'retcode': 0, 'stderr': '', 'stdout': ''}
2018-04-10 12:30:05,374 [salt.state       ][INFO    ][25484] Completed state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 12:30:05.374310 duration_in_ms=16.209
2018-04-10 12:30:05,375 [salt.state       ][INFO    ][25484] Running state [mine.update] at time 12:30:05.375396
2018-04-10 12:30:05,375 [salt.state       ][INFO    ][25484] Executing state module.wait for mine.update
2018-04-10 12:30:05,375 [salt.state       ][INFO    ][25484] No changes made for mine.update
2018-04-10 12:30:05,376 [salt.state       ][INFO    ][25484] Completed state [mine.update] at time 12:30:05.376001 duration_in_ms=0.605
2018-04-10 12:30:05,376 [salt.state       ][INFO    ][25484] Running state [mine.update] at time 12:30:05.376143
2018-04-10 12:30:05,376 [salt.state       ][INFO    ][25484] Executing state module.mod_watch for mine.update
2018-04-10 12:30:05,907 [salt.state       ][INFO    ][25484] {'ret': True}
2018-04-10 12:30:05,908 [salt.state       ][INFO    ][25484] Completed state [mine.update] at time 12:30:05.908540 duration_in_ms=532.395
2018-04-10 12:30:05,909 [salt.state       ][INFO    ][25484] Running state [/etc/pki/ca/salt_master_ca] at time 12:30:05.909079
2018-04-10 12:30:05,909 [salt.state       ][INFO    ][25484] Executing state file.directory for /etc/pki/ca/salt_master_ca
2018-04-10 12:30:05,910 [salt.state       ][INFO    ][25484] Directory /etc/pki/ca/salt_master_ca is in the correct state
2018-04-10 12:30:05,911 [salt.state       ][INFO    ][25484] Completed state [/etc/pki/ca/salt_master_ca] at time 12:30:05.911111 duration_in_ms=2.033
2018-04-10 12:30:05,911 [salt.state       ][INFO    ][25484] Running state [/etc/pki/ca/salt_master_ca/certs] at time 12:30:05.911496
2018-04-10 12:30:05,911 [salt.state       ][INFO    ][25484] Executing state file.directory for /etc/pki/ca/salt_master_ca/certs
2018-04-10 12:30:05,912 [salt.state       ][INFO    ][25484] Directory /etc/pki/ca/salt_master_ca/certs is in the correct state
2018-04-10 12:30:05,913 [salt.state       ][INFO    ][25484] Completed state [/etc/pki/ca/salt_master_ca/certs] at time 12:30:05.913009 duration_in_ms=1.513
2018-04-10 12:30:05,916 [salt.state       ][INFO    ][25484] Running state [/etc/pki/ca/salt_master_ca/ca.key] at time 12:30:05.916443
2018-04-10 12:30:05,916 [salt.state       ][INFO    ][25484] Executing state x509.private_key_managed for /etc/pki/ca/salt_master_ca/ca.key
2018-04-10 12:30:05,924 [salt.state       ][INFO    ][25484] File /etc/pki/ca/salt_master_ca/ca.key is in the correct state
2018-04-10 12:30:05,924 [salt.state       ][INFO    ][25484] Completed state [/etc/pki/ca/salt_master_ca/ca.key] at time 12:30:05.924395 duration_in_ms=7.953
2018-04-10 12:30:05,925 [salt.state       ][INFO    ][25484] Running state [/etc/pki/ca/salt_master_ca/ca.key] at time 12:30:05.925911
2018-04-10 12:30:05,926 [salt.state       ][INFO    ][25484] Executing state file.managed for /etc/pki/ca/salt_master_ca/ca.key
2018-04-10 12:30:05,927 [salt.state       ][INFO    ][25484] File /etc/pki/ca/salt_master_ca/ca.key exists with proper permissions. No changes made.
2018-04-10 12:30:05,927 [salt.state       ][INFO    ][25484] Completed state [/etc/pki/ca/salt_master_ca/ca.key] at time 12:30:05.927371 duration_in_ms=1.46
2018-04-10 12:30:05,928 [salt.state       ][INFO    ][25484] Running state [/etc/pki/ca/salt_master_ca/ca.crt] at time 12:30:05.928704
2018-04-10 12:30:05,929 [salt.state       ][INFO    ][25484] Executing state x509.certificate_managed for /etc/pki/ca/salt_master_ca/ca.crt
2018-04-10 12:30:05,946 [salt.state       ][INFO    ][25484] File /etc/pki/ca/salt_master_ca/ca.crt is in the correct state
2018-04-10 12:30:05,946 [salt.state       ][INFO    ][25484] Completed state [/etc/pki/ca/salt_master_ca/ca.crt] at time 12:30:05.946624 duration_in_ms=17.92
2018-04-10 12:30:05,948 [salt.state       ][INFO    ][25484] Running state [/etc/pki/ca/salt_master_ca/ca.crt] at time 12:30:05.948604
2018-04-10 12:30:05,949 [salt.state       ][INFO    ][25484] Executing state file.managed for /etc/pki/ca/salt_master_ca/ca.crt
2018-04-10 12:30:05,949 [salt.loaded.int.states.file][WARNING ][25484] 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-04-10 12:30:05,950 [salt.state       ][INFO    ][25484] File /etc/pki/ca/salt_master_ca/ca.crt exists with proper permissions. No changes made.
2018-04-10 12:30:05,950 [salt.state       ][INFO    ][25484] Completed state [/etc/pki/ca/salt_master_ca/ca.crt] at time 12:30:05.950871 duration_in_ms=2.266
2018-04-10 12:30:05,952 [salt.state       ][INFO    ][25484] Running state [mine.send] at time 12:30:05.952378
2018-04-10 12:30:05,952 [salt.state       ][INFO    ][25484] Executing state module.run for mine.send
2018-04-10 12:30:06,457 [salt.state       ][INFO    ][25484] {'ret': True}
2018-04-10 12:30:06,458 [salt.state       ][INFO    ][25484] Completed state [mine.send] at time 12:30:06.458329 duration_in_ms=505.949
2018-04-10 12:30:06,458 [salt.state       ][INFO    ][25484] Running state [ca-certificates] at time 12:30:06.458816
2018-04-10 12:30:06,459 [salt.state       ][INFO    ][25484] Executing state pkg.installed for ca-certificates
2018-04-10 12:30:06,471 [salt.state       ][INFO    ][25484] All specified packages are already installed
2018-04-10 12:30:06,472 [salt.state       ][INFO    ][25484] Completed state [ca-certificates] at time 12:30:06.472045 duration_in_ms=13.229
2018-04-10 12:30:06,474 [salt.state       ][INFO    ][25484] Running state [update-ca-certificates] at time 12:30:06.474121
2018-04-10 12:30:06,474 [salt.state       ][INFO    ][25484] Executing state cmd.wait for update-ca-certificates
2018-04-10 12:30:06,475 [salt.state       ][INFO    ][25484] No changes made for update-ca-certificates
2018-04-10 12:30:06,475 [salt.state       ][INFO    ][25484] Completed state [update-ca-certificates] at time 12:30:06.475418 duration_in_ms=1.297
2018-04-10 12:30:06,475 [salt.state       ][INFO    ][25484] Running state [salt-api] at time 12:30:06.475787
2018-04-10 12:30:06,476 [salt.state       ][INFO    ][25484] Executing state pkg.installed for salt-api
2018-04-10 12:30:06,485 [salt.state       ][INFO    ][25484] All specified packages are already installed
2018-04-10 12:30:06,485 [salt.state       ][INFO    ][25484] Completed state [salt-api] at time 12:30:06.485614 duration_in_ms=9.827
2018-04-10 12:30:06,486 [salt.state       ][INFO    ][25484] Running state [python-cherrypy3] at time 12:30:06.485965
2018-04-10 12:30:06,486 [salt.state       ][INFO    ][25484] Executing state pkg.installed for python-cherrypy3
2018-04-10 12:30:06,495 [salt.state       ][INFO    ][25484] All specified packages are already installed
2018-04-10 12:30:06,495 [salt.state       ][INFO    ][25484] Completed state [python-cherrypy3] at time 12:30:06.495352 duration_in_ms=9.387
2018-04-10 12:30:06,496 [salt.state       ][INFO    ][25484] Running state [/etc/salt/master.d/_api.conf] at time 12:30:06.496923
2018-04-10 12:30:06,497 [salt.state       ][INFO    ][25484] Executing state file.managed for /etc/salt/master.d/_api.conf
2018-04-10 12:30:06,662 [salt.state       ][INFO    ][25484] File /etc/salt/master.d/_api.conf is in the correct state
2018-04-10 12:30:06,663 [salt.state       ][INFO    ][25484] Completed state [/etc/salt/master.d/_api.conf] at time 12:30:06.663065 duration_in_ms=166.142
2018-04-10 12:30:06,664 [salt.state       ][INFO    ][25484] Running state [salt-api] at time 12:30:06.664786
2018-04-10 12:30:06,665 [salt.state       ][INFO    ][25484] Executing state service.running for salt-api
2018-04-10 12:30:06,665 [salt.loaded.int.module.cmdmod][INFO    ][25484] Executing command ['systemctl', 'status', 'salt-api.service', '-n', '0'] in directory '/root'
2018-04-10 12:30:06,684 [salt.loaded.int.module.cmdmod][INFO    ][25484] Executing command ['systemctl', 'is-active', 'salt-api.service'] in directory '/root'
2018-04-10 12:30:06,700 [salt.loaded.int.module.cmdmod][INFO    ][25484] Executing command ['systemctl', 'is-enabled', 'salt-api.service'] in directory '/root'
2018-04-10 12:30:06,715 [salt.state       ][INFO    ][25484] The service salt-api is already running
2018-04-10 12:30:06,715 [salt.state       ][INFO    ][25484] Completed state [salt-api] at time 12:30:06.715820 duration_in_ms=51.032
2018-04-10 12:30:06,722 [salt.minion      ][INFO    ][25484] Returning information for job: 20180410122952744500
2018-04-10 12:32:35,110 [salt.minion      ][INFO    ][21476] User sudo_ubuntu Executing command state.sls with jid 20180410123235099014
2018-04-10 12:32:35,128 [salt.minion      ][INFO    ][26075] Starting a new job with PID 26075
2018-04-10 12:32:36,680 [salt.state       ][INFO    ][26075] Loading fresh modules for state activity
2018-04-10 12:32:36,778 [salt.fileclient  ][INFO    ][26075] Fetching file from saltenv 'base', ** done ** 'ntp/init.sls'
2018-04-10 12:32:36,804 [salt.fileclient  ][INFO    ][26075] Fetching file from saltenv 'base', ** done ** 'ntp/client.sls'
2018-04-10 12:32:36,860 [salt.fileclient  ][INFO    ][26075] Fetching file from saltenv 'base', ** done ** 'ntp/server.sls'
2018-04-10 12:32:37,263 [salt.state       ][INFO    ][26075] Running state [ntp] at time 12:32:37.263469
2018-04-10 12:32:37,263 [salt.state       ][INFO    ][26075] Executing state pkg.installed for ntp
2018-04-10 12:32:37,264 [salt.loaded.int.module.cmdmod][INFO    ][26075] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2018-04-10 12:32:37,699 [salt.loaded.int.module.cmdmod][INFO    ][26075] Executing command ['apt-cache', '-q', 'policy', 'ntp'] in directory '/root'
2018-04-10 12:32:37,774 [salt.loaded.int.module.cmdmod][INFO    ][26075] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2018-04-10 12:32:40,043 [salt.loaded.int.module.cmdmod][INFO    ][26075] Executing command ['dpkg', '--get-selections', '*'] in directory '/root'
2018-04-10 12:32:40,079 [salt.loaded.int.module.cmdmod][INFO    ][26075] 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-04-10 12:32:45,249 [salt.minion      ][INFO    ][21476] User sudo_ubuntu Executing command saltutil.find_job with jid 20180410123245226925
2018-04-10 12:32:45,269 [salt.minion      ][INFO    ][27158] Starting a new job with PID 27158
2018-04-10 12:32:45,293 [salt.minion      ][INFO    ][27158] Returning information for job: 20180410123245226925
2018-04-10 12:32:48,588 [salt.loaded.int.module.cmdmod][INFO    ][26075] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2018-04-10 12:32:48,619 [salt.state       ][INFO    ][26075] 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-04-10 12:32:48,630 [salt.state       ][INFO    ][26075] Loading fresh modules for state activity
2018-04-10 12:32:48,647 [salt.state       ][INFO    ][26075] Completed state [ntp] at time 12:32:48.647816 duration_in_ms=11384.347
2018-04-10 12:32:48,650 [salt.state       ][INFO    ][26075] Running state [/etc/ntp.conf] at time 12:32:48.650167
2018-04-10 12:32:48,650 [salt.state       ][INFO    ][26075] Executing state file.managed for /etc/ntp.conf
2018-04-10 12:32:48,671 [salt.fileclient  ][INFO    ][26075] Fetching file from saltenv 'base', ** done ** 'ntp/files/ntp.conf'
2018-04-10 12:32:48,715 [salt.state       ][INFO    ][26075] File changed:
--- 
+++ 
@@ -1,66 +1,24 @@
-# /etc/ntp.conf, configuration for ntpd; see ntp.conf(5) for help
 
-driftfile /var/lib/ntp/ntp.drift
 
-# Enable this if you want statistics to be logged.
-#statsdir /var/log/ntpstats/
+# ntpd will only synchronize your clock.
 
-statistics loopstats peerstats clockstats
-filegen loopstats file loopstats type day enable
-filegen peerstats file peerstats type day enable
-filegen clockstats file clockstats type day enable
+# For details, see:
+# - the ntp.conf man page
+# - http://support.ntp.org/bin/view/Support/GettingStarted
+# - https://wiki.archlinux.org/index.php/Network_Time_Protocol_daemon
 
-# Specify one or more NTP servers.
+# Associate to cloud NTP pool servers
+server 1.pool.ntp.org iburst
+server 0.pool.ntp.org
 
-# Use servers from the NTP Pool Project. Approved by Ubuntu Technical Board
-# on 2011-02-08 (LP: #104525). See http://www.pool.ntp.org/join.html for
-# more information.
-pool 0.ubuntu.pool.ntp.org iburst
-pool 1.ubuntu.pool.ntp.org iburst
-pool 2.ubuntu.pool.ntp.org iburst
-pool 3.ubuntu.pool.ntp.org iburst
-
-# Use Ubuntu's ntp server as a fallback.
-pool ntp.ubuntu.com
-
-# Access control configuration; see /usr/share/doc/ntp-doc/html/accopt.html for
-# details.  The web page <http://support.ntp.org/bin/view/Support/AccessRestrictions>
-# might also be helpful.
-#
-# Note that "restrict" applies to both servers and clients, so a configuration
-# that might be intended to block requests from certain clients could also end
-# up blocking replies from your own upstream servers.
-
-# By default, exchange time with everybody, but don't allow configuration.
-restrict -4 default kod notrap nomodify nopeer noquery limited
-restrict -6 default kod notrap nomodify nopeer noquery limited
-
-# Local users may interrogate the ntp server more closely.
+# Only allow read-only access from localhost
+restrict default noquery nopeer
 restrict 127.0.0.1
 restrict ::1
 
-# Needed for adding pool entries
-restrict source notrap nomodify noquery
-
-# Clients from this (example!) subnet have unlimited access, but only if
-# cryptographically authenticated.
-#restrict 192.168.123.0 mask 255.255.255.0 notrust
+# mode7 is required for collectd monitoring
 
 
-# If you want to provide time to your local subnet, change the next line.
-# (Again, the address is an example only.)
-#broadcast 192.168.123.255
-
-# If you want to listen to time broadcasts on your local subnet, de-comment the
-# next lines.  Please do this only if you trust everybody on the network!
-#disable auth
-#broadcastclient
-
-#Changes recquired to use pps synchonisation as explained in documentation:
-#http://www.ntp.org/ntpfaq/NTP-s-config-adv.htm#AEN3918
-
-#server 127.127.8.1 mode 135 prefer    # Meinberg GPS167 with PPS
-#fudge 127.127.8.1 time1 0.0042        # relative to PPS for my hardware
-
-#server 127.127.22.1                   # ATOM(PPS)
-#fudge 127.127.22.1 flag3 1            # enable PPS API
+# Location of drift file
+driftfile /var/lib/ntp/ntp.drift
+logfile /var/log/ntp.log

2018-04-10 12:32:48,715 [salt.state       ][INFO    ][26075] Completed state [/etc/ntp.conf] at time 12:32:48.715649 duration_in_ms=65.481
2018-04-10 12:32:48,909 [salt.state       ][INFO    ][26075] Running state [ntp] at time 12:32:48.909918
2018-04-10 12:32:48,910 [salt.state       ][INFO    ][26075] Executing state service.running for ntp
2018-04-10 12:32:48,910 [salt.loaded.int.module.cmdmod][INFO    ][26075] Executing command ['systemctl', 'status', 'ntp.service', '-n', '0'] in directory '/root'
2018-04-10 12:32:48,929 [salt.loaded.int.module.cmdmod][INFO    ][26075] Executing command ['systemctl', 'is-active', 'ntp.service'] in directory '/root'
2018-04-10 12:32:48,942 [salt.loaded.int.module.cmdmod][INFO    ][26075] Executing command ['systemctl', 'is-enabled', 'ntp.service'] in directory '/root'
2018-04-10 12:32:48,955 [salt.state       ][INFO    ][26075] The service ntp is already running
2018-04-10 12:32:48,955 [salt.state       ][INFO    ][26075] Completed state [ntp] at time 12:32:48.955787 duration_in_ms=45.869
2018-04-10 12:32:48,956 [salt.state       ][INFO    ][26075] Running state [ntp] at time 12:32:48.955999
2018-04-10 12:32:48,956 [salt.state       ][INFO    ][26075] Executing state service.mod_watch for ntp
2018-04-10 12:32:48,956 [salt.loaded.int.module.cmdmod][INFO    ][26075] Executing command ['systemctl', 'is-active', 'ntp.service'] in directory '/root'
2018-04-10 12:32:48,969 [salt.loaded.int.module.cmdmod][INFO    ][26075] Executing command ['systemctl', 'is-enabled', 'ntp.service'] in directory '/root'
2018-04-10 12:32:48,988 [salt.loaded.int.module.cmdmod][INFO    ][26075] Executing command ['systemd-run', '--scope', 'systemctl', 'restart', 'ntp.service'] in directory '/root'
2018-04-10 12:32:49,074 [salt.state       ][INFO    ][26075] {'ntp': True}
2018-04-10 12:32:49,075 [salt.state       ][INFO    ][26075] Completed state [ntp] at time 12:32:49.075093 duration_in_ms=119.093
2018-04-10 12:32:49,077 [salt.minion      ][INFO    ][26075] Returning information for job: 20180410123235099014
2018-04-10 13:28:36,876 [salt.utils.schedule][INFO    ][21476] Running scheduled job: __mine_interval
2018-04-10 13:57:34,809 [salt.minion      ][INFO    ][21476] User root Executing command x509.sign_remote_certificate with jid 20180410135734802663
2018-04-10 13:57:34,832 [salt.minion      ][INFO    ][1877] Starting a new job with PID 1877
2018-04-10 13:57:34,881 [salt.minion      ][INFO    ][1877] Returning information for job: 20180410135734802663
2018-04-10 13:57:35,152 [salt.minion      ][INFO    ][21476] User root Executing command x509.sign_remote_certificate with jid 20180410135735142120
2018-04-10 13:57:35,171 [salt.minion      ][INFO    ][1890] Starting a new job with PID 1890
2018-04-10 13:57:35,237 [salt.minion      ][INFO    ][1890] Returning information for job: 20180410135735142120
2018-04-10 13:57:36,455 [salt.minion      ][INFO    ][21476] User root Executing command x509.sign_remote_certificate with jid 20180410135736428728
2018-04-10 13:57:36,475 [salt.minion      ][INFO    ][1899] Starting a new job with PID 1899
2018-04-10 13:57:36,521 [salt.minion      ][INFO    ][1899] Returning information for job: 20180410135736428728
2018-04-10 13:57:36,823 [salt.minion      ][INFO    ][21476] User root Executing command x509.sign_remote_certificate with jid 20180410135736809765
2018-04-10 13:57:36,843 [salt.minion      ][INFO    ][1908] Starting a new job with PID 1908
2018-04-10 13:57:36,899 [salt.minion      ][INFO    ][1908] Returning information for job: 20180410135736809765
2018-04-10 14:28:36,877 [salt.utils.schedule][INFO    ][21476] Running scheduled job: __mine_interval
2018-04-10 15:09:22,901 [salt.minion      ][INFO    ][21476] User sudo_ubuntu Executing command cp.push_dir with jid 20180410150922890305
2018-04-10 15:09:22,922 [salt.minion      ][INFO    ][6471] Starting a new job with PID 6471
