2018-10-15 01:07:39,647 [salt.loaded.int.module.cmdmod:722 ][ERROR   ][1818] Command 'rabbitmqctl cluster_status' failed with return code: 127
2018-10-15 01:07:39,649 [salt.loaded.int.module.cmdmod:724 ][ERROR   ][1818] stdout: /bin/sh: 1: rabbitmqctl: not found
2018-10-15 01:07:39,649 [salt.loaded.int.module.cmdmod:728 ][ERROR   ][1818] retcode: 127
2018-10-15 01:07:39,683 [salt.loaded.int.module.cmdmod:722 ][ERROR   ][1818] Command 'rabbitmqctl cluster_status' failed with return code: 127
2018-10-15 01:07:39,684 [salt.loaded.int.module.cmdmod:724 ][ERROR   ][1818] stdout: /bin/sh: 1: rabbitmqctl: not found
2018-10-15 01:07:39,684 [salt.loaded.int.module.cmdmod:728 ][ERROR   ][1818] retcode: 127
2018-10-15 01:07:41,261 [salt.loaded.int.module.cmdmod:722 ][ERROR   ][1818] Command 'rabbitmqctl cluster_status' failed with return code: 127
2018-10-15 01:07:41,262 [salt.loaded.int.module.cmdmod:724 ][ERROR   ][1818] stdout: /bin/sh: 1: rabbitmqctl: not found
2018-10-15 01:07:41,262 [salt.loaded.int.module.cmdmod:728 ][ERROR   ][1818] retcode: 127
2018-10-15 01:07:41,289 [salt.loaded.int.module.cmdmod:722 ][ERROR   ][1818] Command 'rabbitmqctl cluster_status' failed with return code: 127
2018-10-15 01:07:41,290 [salt.loaded.int.module.cmdmod:724 ][ERROR   ][1818] stdout: /bin/sh: 1: rabbitmqctl: not found
2018-10-15 01:07:41,290 [salt.loaded.int.module.cmdmod:728 ][ERROR   ][1818] retcode: 127
2018-10-15 01:08:04,160 [salt.utils.decorators:613 ][WARNING ][1818] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2018-10-15 01:08:07,918 [salt.loaded.int.module.cmdmod:395 ][INFO    ][2885] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2018-10-15 01:08:07,952 [salt.loaded.int.module.cmdmod:395 ][INFO    ][2885] Executing command ['systemd-run', '--scope', 'systemctl', 'restart', 'salt-minion.service'] in directory '/root'
2018-10-15 01:08:07,975 [salt.utils.parsers:1051][WARNING ][1492] Minion received a SIGTERM. Exiting.
2018-10-15 01:08:08,868 [salt.cli.daemons :293 ][INFO    ][2938] Setting up the Salt Minion "msg02.mcp-pike-ovs-ha.local"
2018-10-15 01:08:08,972 [salt.cli.daemons :82  ][INFO    ][2938] Starting up the Salt Minion
2018-10-15 01:08:08,973 [salt.utils.event :1017][INFO    ][2938] Starting pull socket on /var/run/salt/minion/minion_event_25da2ef0ea_pull.ipc
2018-10-15 01:08:09,698 [salt.minion      :976 ][INFO    ][2938] Creating minion process manager
2018-10-15 01:08:11,021 [salt.loader.192.168.11.2.int.module.cmdmod:395 ][INFO    ][2938] Executing command ['date', '+%z'] in directory '/root'
2018-10-15 01:08:11,056 [salt.utils.schedule:568 ][INFO    ][2938] Updating job settings for scheduled job: __mine_interval
2018-10-15 01:08:11,058 [salt.minion      :1107][INFO    ][2938] Added mine.update to scheduler
2018-10-15 01:08:11,069 [salt.minion      :1965][INFO    ][2938] Minion is starting as user 'root'
2018-10-15 01:08:11,089 [salt.minion      :2324][INFO    ][2938] Minion is ready to receive requests!
2018-10-15 01:08:41,691 [salt.minion      :1307][INFO    ][2938] User sudo_ubuntu Executing command state.apply with jid 20181015010841679611
2018-10-15 01:08:41,708 [salt.minion      :1431][INFO    ][3026] Starting a new job with PID 3026
2018-10-15 01:08:46,191 [salt.state       :905 ][INFO    ][3026] Loading fresh modules for state activity
2018-10-15 01:08:46,771 [salt.fileclient  :1215][INFO    ][3026] Fetching file from saltenv 'base', ** done ** 'linux/init.sls'
2018-10-15 01:08:46,818 [salt.fileclient  :1215][INFO    ][3026] Fetching file from saltenv 'base', ** done ** 'linux/system/init.sls'
2018-10-15 01:08:46,978 [salt.fileclient  :1215][INFO    ][3026] Fetching file from saltenv 'base', ** done ** 'linux/system/env.sls'
2018-10-15 01:08:47,096 [salt.fileclient  :1215][INFO    ][3026] Fetching file from saltenv 'base', ** done ** 'linux/system/profile.sls'
2018-10-15 01:08:47,211 [salt.fileclient  :1215][INFO    ][3026] Fetching file from saltenv 'base', ** done ** 'linux/system/shell.sls'
2018-10-15 01:08:47,347 [salt.fileclient  :1215][INFO    ][3026] Fetching file from saltenv 'base', ** done ** 'linux/system/at.sls'
2018-10-15 01:08:47,466 [salt.fileclient  :1215][INFO    ][3026] Fetching file from saltenv 'base', ** done ** 'linux/system/cron.sls'
2018-10-15 01:08:47,593 [salt.fileclient  :1215][INFO    ][3026] Fetching file from saltenv 'base', ** done ** 'linux/system/repo.sls'
2018-10-15 01:08:47,832 [salt.fileclient  :1215][INFO    ][3026] Fetching file from saltenv 'base', ** done ** 'linux/system/package.sls'
2018-10-15 01:08:47,978 [salt.fileclient  :1215][INFO    ][3026] Fetching file from saltenv 'base', ** done ** 'linux/system/timezone.sls'
2018-10-15 01:08:48,107 [salt.fileclient  :1215][INFO    ][3026] Fetching file from saltenv 'base', ** done ** 'linux/system/kernel.sls'
2018-10-15 01:08:48,264 [salt.fileclient  :1215][INFO    ][3026] Fetching file from saltenv 'base', ** done ** 'linux/system/grub.sls'
2018-10-15 01:08:48,306 [salt.fileclient  :1215][INFO    ][3026] Fetching file from saltenv 'base', ** done ** 'linux/system/cpu.sls'
2018-10-15 01:08:48,427 [salt.fileclient  :1215][INFO    ][3026] Fetching file from saltenv 'base', ** done ** 'linux/system/sysfs.sls'
2018-10-15 01:08:48,554 [salt.fileclient  :1215][INFO    ][3026] Fetching file from saltenv 'base', ** done ** 'linux/system/locale.sls'
2018-10-15 01:08:48,690 [salt.fileclient  :1215][INFO    ][3026] Fetching file from saltenv 'base', ** done ** 'linux/system/user.sls'
2018-10-15 01:08:48,843 [salt.fileclient  :1215][INFO    ][3026] Fetching file from saltenv 'base', ** done ** 'linux/system/group.sls'
2018-10-15 01:08:48,971 [salt.fileclient  :1215][INFO    ][3026] Fetching file from saltenv 'base', ** done ** 'linux/system/limit.sls'
2018-10-15 01:08:49,094 [salt.fileclient  :1215][INFO    ][3026] Fetching file from saltenv 'base', ** done ** 'linux/system/systemd.sls'
2018-10-15 01:08:49,214 [salt.fileclient  :1215][INFO    ][3026] Fetching file from saltenv 'base', ** done ** 'linux/system/apt.sls'
2018-10-15 01:08:49,335 [salt.fileclient  :1215][INFO    ][3026] Fetching file from saltenv 'base', ** done ** 'linux/system/banner.sls'
2018-10-15 01:08:49,453 [salt.fileclient  :1215][INFO    ][3026] Fetching file from saltenv 'base', ** done ** 'linux/network/init.sls'
2018-10-15 01:08:49,576 [salt.fileclient  :1215][INFO    ][3026] Fetching file from saltenv 'base', ** done ** 'linux/network/hostname.sls'
2018-10-15 01:08:49,722 [salt.fileclient  :1215][INFO    ][3026] Fetching file from saltenv 'base', ** done ** 'linux/network/host.sls'
2018-10-15 01:08:49,887 [salt.fileclient  :1215][INFO    ][3026] Fetching file from saltenv 'base', ** done ** 'linux/network/interface.sls'
2018-10-15 01:08:50,094 [salt.fileclient  :1215][INFO    ][3026] Fetching file from saltenv 'base', ** done ** 'linux/network/proxy.sls'
2018-10-15 01:08:50,221 [salt.fileclient  :1215][INFO    ][3026] Fetching file from saltenv 'base', ** done ** 'linux/storage/init.sls'
2018-10-15 01:08:50,367 [salt.fileclient  :1215][INFO    ][3026] Fetching file from saltenv 'base', ** done ** 'ntp/init.sls'
2018-10-15 01:08:50,394 [salt.fileclient  :1215][INFO    ][3026] Fetching file from saltenv 'base', ** done ** 'ntp/client.sls'
2018-10-15 01:08:50,443 [salt.fileclient  :1215][INFO    ][3026] Fetching file from saltenv 'base', ** done ** 'ntp/server.sls'
2018-10-15 01:08:50,486 [salt.state       :1770][INFO    ][3026] Running state [/etc/environment] at time 01:08:50.486144
2018-10-15 01:08:50,486 [salt.state       :1803][INFO    ][3026] Executing state file.blockreplace for [/etc/environment]
2018-10-15 01:08:50,493 [salt.state       :290 ][INFO    ][3026] 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-10-15 01:08:50,494 [salt.state       :1941][INFO    ][3026] Completed state [/etc/environment] at time 01:08:50.494376 duration_in_ms=8.232
2018-10-15 01:08:50,494 [salt.state       :1770][INFO    ][3026] Running state [/etc/profile.d] at time 01:08:50.494758
2018-10-15 01:08:50,495 [salt.state       :1803][INFO    ][3026] Executing state file.directory for [/etc/profile.d]
2018-10-15 01:08:50,496 [salt.state       :290 ][INFO    ][3026] Directory /etc/profile.d is in the correct state
Directory /etc/profile.d updated
2018-10-15 01:08:50,497 [salt.state       :1941][INFO    ][3026] Completed state [/etc/profile.d] at time 01:08:50.497374 duration_in_ms=2.616
2018-10-15 01:08:50,498 [salt.state       :1770][INFO    ][3026] Running state [fake_linux_system_at] at time 01:08:50.498370
2018-10-15 01:08:50,498 [salt.state       :1803][INFO    ][3026] Executing state test.nop for [fake_linux_system_at]
2018-10-15 01:08:50,499 [salt.state       :290 ][INFO    ][3026] Success!
2018-10-15 01:08:50,499 [salt.state       :1941][INFO    ][3026] Completed state [fake_linux_system_at] at time 01:08:50.499523 duration_in_ms=1.153
2018-10-15 01:08:50,499 [salt.state       :1770][INFO    ][3026] Running state [fake_linux_system_cron] at time 01:08:50.499894
2018-10-15 01:08:50,500 [salt.state       :1803][INFO    ][3026] Executing state test.nop for [fake_linux_system_cron]
2018-10-15 01:08:50,501 [salt.state       :290 ][INFO    ][3026] Success!
2018-10-15 01:08:50,501 [salt.state       :1941][INFO    ][3026] Completed state [fake_linux_system_cron] at time 01:08:50.501401 duration_in_ms=1.508
2018-10-15 01:08:51,105 [salt.state       :1770][INFO    ][3026] Running state [/etc/apt/apt.conf.d/99prefer_ipv4-salt] at time 01:08:51.104721
2018-10-15 01:08:51,105 [salt.state       :1803][INFO    ][3026] Executing state file.managed for [/etc/apt/apt.conf.d/99prefer_ipv4-salt]
2018-10-15 01:08:51,133 [salt.fileclient  :1215][INFO    ][3026] Fetching file from saltenv 'base', ** done ** 'linux/files/apt.conf'
2018-10-15 01:08:51,148 [salt.state       :290 ][INFO    ][3026] File changed:
New file
2018-10-15 01:08:51,148 [salt.state       :1941][INFO    ][3026] Completed state [/etc/apt/apt.conf.d/99prefer_ipv4-salt] at time 01:08:51.148612 duration_in_ms=43.891
2018-10-15 01:08:51,149 [salt.state       :1770][INFO    ][3026] Running state [/etc/apt/apt.conf.d/99allow_downgrades-salt] at time 01:08:51.149009
2018-10-15 01:08:51,149 [salt.state       :1803][INFO    ][3026] Executing state file.managed for [/etc/apt/apt.conf.d/99allow_downgrades-salt]
2018-10-15 01:08:51,206 [salt.state       :290 ][INFO    ][3026] File changed:
New file
2018-10-15 01:08:51,207 [salt.state       :1941][INFO    ][3026] Completed state [/etc/apt/apt.conf.d/99allow_downgrades-salt] at time 01:08:51.206978 duration_in_ms=57.969
2018-10-15 01:08:51,208 [salt.state       :1770][INFO    ][3026] Running state [linux_repo_prereq_pkgs] at time 01:08:51.208277
2018-10-15 01:08:51,209 [salt.state       :1803][INFO    ][3026] Executing state pkg.installed for [linux_repo_prereq_pkgs]
2018-10-15 01:08:51,209 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3026] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}', '-W'] in directory '/root'
2018-10-15 01:08:51,515 [salt.state       :290 ][INFO    ][3026] All specified packages are already installed
2018-10-15 01:08:51,515 [salt.state       :1941][INFO    ][3026] Completed state [linux_repo_prereq_pkgs] at time 01:08:51.515870 duration_in_ms=307.592
2018-10-15 01:08:51,516 [salt.state       :1770][INFO    ][3026] Running state [/etc/apt/apt.conf.d/99proxies-salt] at time 01:08:51.516385
2018-10-15 01:08:51,516 [salt.state       :1803][INFO    ][3026] Executing state file.managed for [/etc/apt/apt.conf.d/99proxies-salt]
2018-10-15 01:08:51,540 [salt.fileclient  :1215][INFO    ][3026] Fetching file from saltenv 'base', ** done ** 'linux/files/apt.conf.d_proxies'
2018-10-15 01:08:51,557 [salt.state       :290 ][INFO    ][3026] File changed:
New file
2018-10-15 01:08:51,558 [salt.state       :1941][INFO    ][3026] Completed state [/etc/apt/apt.conf.d/99proxies-salt] at time 01:08:51.558395 duration_in_ms=42.01
2018-10-15 01:08:51,558 [salt.state       :1770][INFO    ][3026] Running state [/etc/apt/apt.conf.d/99proxies-salt-mk_openstack] at time 01:08:51.558790
2018-10-15 01:08:51,559 [salt.state       :1803][INFO    ][3026] Executing state file.absent for [/etc/apt/apt.conf.d/99proxies-salt-mk_openstack]
2018-10-15 01:08:51,560 [salt.state       :290 ][INFO    ][3026] File /etc/apt/apt.conf.d/99proxies-salt-mk_openstack is not present
2018-10-15 01:08:51,561 [salt.state       :1941][INFO    ][3026] Completed state [/etc/apt/apt.conf.d/99proxies-salt-mk_openstack] at time 01:08:51.561013 duration_in_ms=2.223
2018-10-15 01:08:51,561 [salt.state       :1770][INFO    ][3026] Running state [/etc/apt/preferences.d/mk_openstack] at time 01:08:51.561393
2018-10-15 01:08:51,561 [salt.state       :1803][INFO    ][3026] Executing state file.managed for [/etc/apt/preferences.d/mk_openstack]
2018-10-15 01:08:51,579 [salt.fileclient  :1215][INFO    ][3026] Fetching file from saltenv 'base', ** done ** 'linux/files/preferences_repo'
2018-10-15 01:08:51,682 [salt.state       :290 ][INFO    ][3026] File changed:
New file
2018-10-15 01:08:51,684 [salt.state       :1941][INFO    ][3026] Completed state [/etc/apt/preferences.d/mk_openstack] at time 01:08:51.684119 duration_in_ms=122.726
2018-10-15 01:08:51,695 [salt.state       :1770][INFO    ][3026] Running state [deb [arch=amd64] http://apt.mirantis.com/xenial/ nightly pike] at time 01:08:51.695782
2018-10-15 01:08:51,696 [salt.state       :1803][INFO    ][3026] Executing state pkgrepo.managed for [deb [arch=amd64] http://apt.mirantis.com/xenial/ nightly pike]
2018-10-15 01:08:51,806 [salt.minion      :1307][INFO    ][2938] User sudo_ubuntu Executing command saltutil.find_job with jid 20181015010851789230
2018-10-15 01:08:51,827 [salt.minion      :1431][INFO    ][3110] Starting a new job with PID 3110
2018-10-15 01:08:51,851 [salt.minion      :1708][INFO    ][3110] Returning information for job: 20181015010851789230
2018-10-15 01:08:52,188 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3026] Executing command ['apt-key', 'add', '/var/cache/salt/minion/extrn_files/base/apt.mirantis.com/public.gpg'] in directory '/root'
2018-10-15 01:08:52,560 [salt.state       :290 ][INFO    ][3026] {'repo': 'deb [arch=amd64] http://apt.mirantis.com/xenial nightly pike'}
2018-10-15 01:08:52,561 [salt.state       :1941][INFO    ][3026] Completed state [deb [arch=amd64] http://apt.mirantis.com/xenial/ nightly pike] at time 01:08:52.560906 duration_in_ms=865.124
2018-10-15 01:08:52,561 [salt.state       :1770][INFO    ][3026] Running state [/etc/apt/apt.conf.d/99proxies-salt-uca-staging] at time 01:08:52.561265
2018-10-15 01:08:52,561 [salt.state       :1803][INFO    ][3026] Executing state file.absent for [/etc/apt/apt.conf.d/99proxies-salt-uca-staging]
2018-10-15 01:08:52,562 [salt.state       :290 ][INFO    ][3026] File /etc/apt/apt.conf.d/99proxies-salt-uca-staging is not present
2018-10-15 01:08:52,562 [salt.state       :1941][INFO    ][3026] Completed state [/etc/apt/apt.conf.d/99proxies-salt-uca-staging] at time 01:08:52.562211 duration_in_ms=0.946
2018-10-15 01:08:52,562 [salt.state       :1770][INFO    ][3026] Running state [/etc/apt/preferences.d/uca-staging] at time 01:08:52.562426
2018-10-15 01:08:52,562 [salt.state       :1803][INFO    ][3026] Executing state file.absent for [/etc/apt/preferences.d/uca-staging]
2018-10-15 01:08:52,562 [salt.state       :290 ][INFO    ][3026] File /etc/apt/preferences.d/uca-staging is not present
2018-10-15 01:08:52,563 [salt.state       :1941][INFO    ][3026] Completed state [/etc/apt/preferences.d/uca-staging] at time 01:08:52.563045 duration_in_ms=0.62
2018-10-15 01:08:52,569 [salt.state       :1770][INFO    ][3026] Running state [apt-key adv --keyserver keyserver.ubuntu.com --recv 9F68104E] at time 01:08:52.569711
2018-10-15 01:08:52,569 [salt.state       :1803][INFO    ][3026] Executing state cmd.run for [apt-key adv --keyserver keyserver.ubuntu.com --recv 9F68104E]
2018-10-15 01:08:52,570 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3026] Executing command 'test -e /etc/apt/sources.list.d/uca-staging.list' in directory '/root'
2018-10-15 01:08:52,590 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3026] Executing command 'apt-key adv --keyserver keyserver.ubuntu.com --recv 9F68104E' in directory '/root'
2018-10-15 01:08:52,914 [salt.state       :290 ][INFO    ][3026] {'pid': 3242, 'retcode': 0, 'stderr': 'gpg: requesting key 9F68104E from hkp server keyserver.ubuntu.com\ngpg: key 9F68104E: public key "Launchpad PPA for Ubuntu Cloud Archive Team" imported\ngpg: Total number processed: 1\ngpg:               imported: 1  (RSA: 1)', 'stdout': 'Executing: /tmp/tmp.1VbgOSb9xx/gpg.1.sh --keyserver\nkeyserver.ubuntu.com\n--recv\n9F68104E'}
2018-10-15 01:08:52,914 [salt.state       :1941][INFO    ][3026] Completed state [apt-key adv --keyserver keyserver.ubuntu.com --recv 9F68104E] at time 01:08:52.914650 duration_in_ms=344.939
2018-10-15 01:08:52,918 [salt.state       :1770][INFO    ][3026] Running state [deb http://ppa.launchpad.net/ubuntu-cloud-archive/pike-staging/ubuntu xenial main] at time 01:08:52.918564
2018-10-15 01:08:52,919 [salt.state       :1803][INFO    ][3026] Executing state pkgrepo.managed for [deb http://ppa.launchpad.net/ubuntu-cloud-archive/pike-staging/ubuntu xenial main]
2018-10-15 01:08:53,033 [salt.state       :290 ][INFO    ][3026] {'repo': 'deb http://ppa.launchpad.net/ubuntu-cloud-archive/pike-staging/ubuntu xenial main'}
2018-10-15 01:08:53,033 [salt.state       :1941][INFO    ][3026] Completed state [deb http://ppa.launchpad.net/ubuntu-cloud-archive/pike-staging/ubuntu xenial main] at time 01:08:53.033737 duration_in_ms=115.173
2018-10-15 01:08:53,033 [salt.state       :1770][INFO    ][3026] Running state [/etc/apt/apt.conf.d/99proxies-salt-mirantis_openstack] at time 01:08:53.033953
2018-10-15 01:08:53,034 [salt.state       :1803][INFO    ][3026] Executing state file.absent for [/etc/apt/apt.conf.d/99proxies-salt-mirantis_openstack]
2018-10-15 01:08:53,034 [salt.state       :290 ][INFO    ][3026] File /etc/apt/apt.conf.d/99proxies-salt-mirantis_openstack is not present
2018-10-15 01:08:53,034 [salt.state       :1941][INFO    ][3026] Completed state [/etc/apt/apt.conf.d/99proxies-salt-mirantis_openstack] at time 01:08:53.034676 duration_in_ms=0.724
2018-10-15 01:08:53,034 [salt.state       :1770][INFO    ][3026] Running state [/etc/apt/preferences.d/mirantis_openstack] at time 01:08:53.034883
2018-10-15 01:08:53,035 [salt.state       :1803][INFO    ][3026] Executing state file.managed for [/etc/apt/preferences.d/mirantis_openstack]
2018-10-15 01:08:53,164 [salt.state       :290 ][INFO    ][3026] File changed:
New file
2018-10-15 01:08:53,164 [salt.state       :1941][INFO    ][3026] Completed state [/etc/apt/preferences.d/mirantis_openstack] at time 01:08:53.164405 duration_in_ms=129.522
2018-10-15 01:08:53,166 [salt.state       :1770][INFO    ][3026] Running state [deb http://mirror.fuel-infra.org/mcp-repos/pike/xenial pike main] at time 01:08:53.166117
2018-10-15 01:08:53,166 [salt.state       :1803][INFO    ][3026] Executing state pkgrepo.managed for [deb http://mirror.fuel-infra.org/mcp-repos/pike/xenial pike main]
2018-10-15 01:08:53,314 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3026] Executing command ['apt-key', 'add', '/var/cache/salt/minion/extrn_files/base/mirror.fuel-infra.org/mcp-repos/pike/xenial/archive-mcppike.key'] in directory '/root'
2018-10-15 01:08:53,659 [salt.state       :290 ][INFO    ][3026] {'repo': 'deb http://mirror.fuel-infra.org/mcp-repos/pike/xenial pike main'}
2018-10-15 01:08:53,659 [salt.state       :1941][INFO    ][3026] Completed state [deb http://mirror.fuel-infra.org/mcp-repos/pike/xenial pike main] at time 01:08:53.659612 duration_in_ms=493.494
2018-10-15 01:08:53,659 [salt.state       :1770][INFO    ][3026] Running state [/etc/apt/apt.conf.d/99proxies-salt-uca] at time 01:08:53.659939
2018-10-15 01:08:53,660 [salt.state       :1803][INFO    ][3026] Executing state file.absent for [/etc/apt/apt.conf.d/99proxies-salt-uca]
2018-10-15 01:08:53,660 [salt.state       :290 ][INFO    ][3026] File /etc/apt/apt.conf.d/99proxies-salt-uca is not present
2018-10-15 01:08:53,660 [salt.state       :1941][INFO    ][3026] Completed state [/etc/apt/apt.conf.d/99proxies-salt-uca] at time 01:08:53.660883 duration_in_ms=0.944
2018-10-15 01:08:53,661 [salt.state       :1770][INFO    ][3026] Running state [/etc/apt/preferences.d/uca] at time 01:08:53.661086
2018-10-15 01:08:53,661 [salt.state       :1803][INFO    ][3026] Executing state file.managed for [/etc/apt/preferences.d/uca]
2018-10-15 01:08:53,800 [salt.state       :290 ][INFO    ][3026] File changed:
New file
2018-10-15 01:08:53,800 [salt.state       :1941][INFO    ][3026] Completed state [/etc/apt/preferences.d/uca] at time 01:08:53.800759 duration_in_ms=139.673
2018-10-15 01:08:53,804 [salt.state       :1770][INFO    ][3026] Running state [apt-key adv --keyserver keyserver.ubuntu.com --recv EC4926EA] at time 01:08:53.804187
2018-10-15 01:08:53,804 [salt.state       :1803][INFO    ][3026] Executing state cmd.run for [apt-key adv --keyserver keyserver.ubuntu.com --recv EC4926EA]
2018-10-15 01:08:53,805 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3026] Executing command 'test -e /etc/apt/sources.list.d/uca.list' in directory '/root'
2018-10-15 01:08:53,823 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3026] Executing command 'apt-key adv --keyserver keyserver.ubuntu.com --recv EC4926EA' in directory '/root'
2018-10-15 01:08:54,139 [salt.state       :290 ][INFO    ][3026] {'pid': 3523, 'retcode': 0, 'stderr': 'gpg: requesting key EC4926EA from hkp server keyserver.ubuntu.com\ngpg: key EC4926EA: public key "Canonical Cloud Archive Signing Key <ftpmaster@canonical.com>" imported\ngpg: Total number processed: 1\ngpg:               imported: 1  (RSA: 1)', 'stdout': 'Executing: /tmp/tmp.tLatmPcadb/gpg.1.sh --keyserver\nkeyserver.ubuntu.com\n--recv\nEC4926EA'}
2018-10-15 01:08:54,141 [salt.state       :1941][INFO    ][3026] Completed state [apt-key adv --keyserver keyserver.ubuntu.com --recv EC4926EA] at time 01:08:54.140131 duration_in_ms=335.942
2018-10-15 01:08:54,144 [salt.state       :1770][INFO    ][3026] Running state [deb http://ubuntu-cloud.archive.canonical.com/ubuntu xenial-updates/pike main] at time 01:08:54.144682
2018-10-15 01:08:54,145 [salt.state       :1803][INFO    ][3026] Executing state pkgrepo.managed for [deb http://ubuntu-cloud.archive.canonical.com/ubuntu xenial-updates/pike main]
2018-10-15 01:08:54,332 [salt.state       :290 ][INFO    ][3026] {'repo': 'deb http://ubuntu-cloud.archive.canonical.com/ubuntu xenial-updates/pike main'}
2018-10-15 01:08:54,333 [salt.state       :1941][INFO    ][3026] Completed state [deb http://ubuntu-cloud.archive.canonical.com/ubuntu xenial-updates/pike main] at time 01:08:54.333171 duration_in_ms=188.489
2018-10-15 01:08:54,334 [salt.state       :1770][INFO    ][3026] Running state [pkg.refresh_db] at time 01:08:54.334289
2018-10-15 01:08:54,334 [salt.state       :1803][INFO    ][3026] Executing state module.run for [pkg.refresh_db]
2018-10-15 01:08:54,334 [salt.utils.decorators:613 ][WARNING ][3026] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2018-10-15 01:08:54,335 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3026] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2018-10-15 01:08:58,816 [salt.state       :290 ][INFO    ][3026] {'ret': {'http://apt.mirantis.com/xenial nightly InRelease': True, 'http://security.ubuntu.com/ubuntu xenial-security InRelease': None, 'http://ppa.launchpad.net/ubuntu-cloud-archive/pike-staging/ubuntu xenial InRelease': True, 'http://ubuntu-cloud.archive.canonical.com/ubuntu xenial-updates/pike Release': True, 'http://mirror.fuel-infra.org/mcp-repos/pike/xenial pike/main amd64 Packages': True, 'http://archive.ubuntu.com/ubuntu xenial-backports InRelease': None, 'http://archive.ubuntu.com/ubuntu xenial-updates InRelease': None, 'http://ubuntu-cloud.archive.canonical.com/ubuntu xenial-updates/pike InRelease': False, 'http://ppa.launchpad.net/ubuntu-cloud-archive/pike-staging/ubuntu xenial/main Translation-en': True, 'http://ubuntu-cloud.archive.canonical.com/ubuntu xenial-updates/pike/main amd64 Packages': True, 'http://repo.saltstack.com/apt/ubuntu/16.04/amd64/2017.7 xenial InRelease': None, 'http://ubuntu-cloud.archive.canonical.com/ubuntu xenial-updates/pike Release.gpg': True, 'http://archive.ubuntu.com/ubuntu xenial InRelease': None, 'http://apt.mirantis.com/xenial nightly/pike amd64 Packages': True, 'http://ppa.launchpad.net/ubuntu-cloud-archive/pike-staging/ubuntu xenial/main amd64 Packages': True, 'http://mirror.fuel-infra.org/mcp-repos/pike/xenial pike InRelease': True}}
2018-10-15 01:08:58,817 [salt.state       :1941][INFO    ][3026] Completed state [pkg.refresh_db] at time 01:08:58.817626 duration_in_ms=4483.337
2018-10-15 01:08:58,848 [salt.state       :1770][INFO    ][3026] Running state [UTC] at time 01:08:58.848302
2018-10-15 01:08:58,849 [salt.state       :1803][INFO    ][3026] Executing state timezone.system for [UTC]
2018-10-15 01:08:58,852 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3026] Executing command ['timedatectl'] in directory '/root'
2018-10-15 01:08:58,942 [salt.state       :290 ][INFO    ][3026] Timezone UTC already set, UTC already set to UTC
2018-10-15 01:08:58,943 [salt.state       :1941][INFO    ][3026] Completed state [UTC] at time 01:08:58.943727 duration_in_ms=95.426
2018-10-15 01:08:58,944 [salt.state       :1770][INFO    ][3026] Running state [/etc/default/grub.d] at time 01:08:58.944423
2018-10-15 01:08:58,945 [salt.state       :1803][INFO    ][3026] Executing state file.directory for [/etc/default/grub.d]
2018-10-15 01:08:58,948 [salt.state       :290 ][INFO    ][3026] Directory /etc/default/grub.d is in the correct state
Directory /etc/default/grub.d updated
2018-10-15 01:08:58,948 [salt.state       :1941][INFO    ][3026] Completed state [/etc/default/grub.d] at time 01:08:58.948865 duration_in_ms=4.443
2018-10-15 01:08:58,949 [salt.state       :1770][INFO    ][3026] Running state [update-grub] at time 01:08:58.949125
2018-10-15 01:08:58,949 [salt.state       :1803][INFO    ][3026] Executing state cmd.wait for [update-grub]
2018-10-15 01:08:58,949 [salt.state       :290 ][INFO    ][3026] No changes made for update-grub
2018-10-15 01:08:58,949 [salt.state       :1941][INFO    ][3026] Completed state [update-grub] at time 01:08:58.949735 duration_in_ms=0.611
2018-10-15 01:08:58,952 [salt.state       :1770][INFO    ][3026] Running state [/boot/grub/grub.cfg] at time 01:08:58.952810
2018-10-15 01:08:58,953 [salt.state       :1803][INFO    ][3026] Executing state file.managed for [/boot/grub/grub.cfg]
2018-10-15 01:08:59,366 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3026] Executing command ['git', '--version'] in directory '/root'
2018-10-15 01:09:00,559 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3026] Executing command 'test -f /boot/grub/grub.cfg' in directory '/root'
2018-10-15 01:09:00,579 [salt.loaded.int.states.file:2150][WARNING ][3026] State for file: /boot/grub/grub.cfg - 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-10-15 01:09:00,581 [salt.state       :290 ][INFO    ][3026] {'mode': '0400'}
2018-10-15 01:09:00,581 [salt.state       :1941][INFO    ][3026] Completed state [/boot/grub/grub.cfg] at time 01:09:00.581788 duration_in_ms=1628.978
2018-10-15 01:09:00,582 [salt.state       :1770][INFO    ][3026] Running state [nf_conntrack] at time 01:09:00.582619
2018-10-15 01:09:00,583 [salt.state       :1803][INFO    ][3026] Executing state kmod.present for [nf_conntrack]
2018-10-15 01:09:00,584 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3026] Executing command 'lsmod' in directory '/root'
2018-10-15 01:09:01,569 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3026] Executing command 'lsmod' in directory '/root'
2018-10-15 01:09:01,592 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3026] Executing command 'modprobe nf_conntrack' in directory '/root'
2018-10-15 01:09:01,689 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3026] Executing command 'lsmod' in directory '/root'
2018-10-15 01:09:01,811 [salt.state       :290 ][INFO    ][3026] {'nf_conntrack': 'loaded'}
2018-10-15 01:09:01,811 [salt.state       :1941][INFO    ][3026] Completed state [nf_conntrack] at time 01:09:01.811579 duration_in_ms=1228.96
2018-10-15 01:09:01,812 [salt.state       :1770][INFO    ][3026] Running state [kernel.panic] at time 01:09:01.812010
2018-10-15 01:09:01,812 [salt.state       :1803][INFO    ][3026] Executing state sysctl.present for [kernel.panic]
2018-10-15 01:09:01,834 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3026] Executing command 'sysctl -w kernel.panic="60"' in directory '/root'
2018-10-15 01:09:01,864 [salt.state       :290 ][INFO    ][3026] {'kernel.panic': 60}
2018-10-15 01:09:01,865 [salt.state       :1941][INFO    ][3026] Completed state [kernel.panic] at time 01:09:01.865465 duration_in_ms=53.454
2018-10-15 01:09:01,866 [salt.state       :1770][INFO    ][3026] Running state [net.ipv4.tcp_keepalive_probes] at time 01:09:01.866157
2018-10-15 01:09:01,868 [salt.state       :1803][INFO    ][3026] Executing state sysctl.present for [net.ipv4.tcp_keepalive_probes]
2018-10-15 01:09:01,870 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3026] Executing command 'sysctl -w net.ipv4.tcp_keepalive_probes="8"' in directory '/root'
2018-10-15 01:09:01,895 [salt.state       :290 ][INFO    ][3026] {'net.ipv4.tcp_keepalive_probes': 8}
2018-10-15 01:09:01,895 [salt.state       :1941][INFO    ][3026] Completed state [net.ipv4.tcp_keepalive_probes] at time 01:09:01.895797 duration_in_ms=29.64
2018-10-15 01:09:01,896 [salt.state       :1770][INFO    ][3026] Running state [fs.file-max] at time 01:09:01.896395
2018-10-15 01:09:01,896 [salt.state       :1803][INFO    ][3026] Executing state sysctl.present for [fs.file-max]
2018-10-15 01:09:01,898 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3026] Executing command 'sysctl -w fs.file-max="124165"' in directory '/root'
2018-10-15 01:09:01,924 [salt.state       :290 ][INFO    ][3026] {'fs.file-max': 124165}
2018-10-15 01:09:01,924 [salt.state       :1941][INFO    ][3026] Completed state [fs.file-max] at time 01:09:01.924668 duration_in_ms=28.271
2018-10-15 01:09:01,925 [salt.state       :1770][INFO    ][3026] Running state [net.core.somaxconn] at time 01:09:01.925360
2018-10-15 01:09:01,926 [salt.state       :1803][INFO    ][3026] Executing state sysctl.present for [net.core.somaxconn]
2018-10-15 01:09:01,927 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3026] Executing command 'sysctl -w net.core.somaxconn="4096"' in directory '/root'
2018-10-15 01:09:01,950 [salt.state       :290 ][INFO    ][3026] {'net.core.somaxconn': 4096}
2018-10-15 01:09:01,950 [salt.state       :1941][INFO    ][3026] Completed state [net.core.somaxconn] at time 01:09:01.950582 duration_in_ms=25.222
2018-10-15 01:09:01,952 [salt.state       :1770][INFO    ][3026] Running state [net.ipv4.tcp_max_syn_backlog] at time 01:09:01.951461
2018-10-15 01:09:01,953 [salt.state       :1803][INFO    ][3026] Executing state sysctl.present for [net.ipv4.tcp_max_syn_backlog]
2018-10-15 01:09:01,954 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3026] Executing command 'sysctl -w net.ipv4.tcp_max_syn_backlog="8192"' in directory '/root'
2018-10-15 01:09:01,977 [salt.state       :290 ][INFO    ][3026] {'net.ipv4.tcp_max_syn_backlog': 8192}
2018-10-15 01:09:01,978 [salt.state       :1941][INFO    ][3026] Completed state [net.ipv4.tcp_max_syn_backlog] at time 01:09:01.978416 duration_in_ms=26.954
2018-10-15 01:09:01,981 [salt.state       :1770][INFO    ][3026] Running state [net.ipv4.tcp_tw_reuse] at time 01:09:01.980973
2018-10-15 01:09:01,982 [salt.state       :1803][INFO    ][3026] Executing state sysctl.present for [net.ipv4.tcp_tw_reuse]
2018-10-15 01:09:01,983 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3026] Executing command 'sysctl -w net.ipv4.tcp_tw_reuse="1"' in directory '/root'
2018-10-15 01:09:02,004 [salt.state       :290 ][INFO    ][3026] {'net.ipv4.tcp_tw_reuse': 1}
2018-10-15 01:09:02,005 [salt.state       :1941][INFO    ][3026] Completed state [net.ipv4.tcp_tw_reuse] at time 01:09:02.005039 duration_in_ms=24.065
2018-10-15 01:09:02,006 [salt.state       :1770][INFO    ][3026] Running state [net.ipv4.tcp_congestion_control] at time 01:09:02.005741
2018-10-15 01:09:02,006 [salt.state       :1803][INFO    ][3026] Executing state sysctl.present for [net.ipv4.tcp_congestion_control]
2018-10-15 01:09:02,008 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3026] Executing command 'sysctl -w net.ipv4.tcp_congestion_control="yeah"' in directory '/root'
2018-10-15 01:09:02,008 [salt.minion      :1307][INFO    ][2938] User sudo_ubuntu Executing command saltutil.find_job with jid 20181015010901995411
2018-10-15 01:09:02,033 [salt.minion      :1431][INFO    ][4136] Starting a new job with PID 4136
2018-10-15 01:09:02,037 [salt.state       :290 ][INFO    ][3026] {'net.ipv4.tcp_congestion_control': 'yeah'}
2018-10-15 01:09:02,038 [salt.state       :1941][INFO    ][3026] Completed state [net.ipv4.tcp_congestion_control] at time 01:09:02.038096 duration_in_ms=32.355
2018-10-15 01:09:02,038 [salt.state       :1770][INFO    ][3026] Running state [net.ipv4.tcp_retries2] at time 01:09:02.038423
2018-10-15 01:09:02,038 [salt.state       :1803][INFO    ][3026] Executing state sysctl.present for [net.ipv4.tcp_retries2]
2018-10-15 01:09:02,039 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3026] Executing command 'sysctl -w net.ipv4.tcp_retries2="5"' in directory '/root'
2018-10-15 01:09:02,054 [salt.minion      :1708][INFO    ][4136] Returning information for job: 20181015010901995411
2018-10-15 01:09:02,055 [salt.state       :290 ][INFO    ][3026] {'net.ipv4.tcp_retries2': 5}
2018-10-15 01:09:02,056 [salt.state       :1941][INFO    ][3026] Completed state [net.ipv4.tcp_retries2] at time 01:09:02.056215 duration_in_ms=17.792
2018-10-15 01:09:02,056 [salt.state       :1770][INFO    ][3026] Running state [net.core.netdev_max_backlog] at time 01:09:02.056810
2018-10-15 01:09:02,057 [salt.state       :1803][INFO    ][3026] Executing state sysctl.present for [net.core.netdev_max_backlog]
2018-10-15 01:09:02,058 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3026] Executing command 'sysctl -w net.core.netdev_max_backlog="261144"' in directory '/root'
2018-10-15 01:09:02,080 [salt.state       :290 ][INFO    ][3026] {'net.core.netdev_max_backlog': 261144}
2018-10-15 01:09:02,081 [salt.state       :1941][INFO    ][3026] Completed state [net.core.netdev_max_backlog] at time 01:09:02.081227 duration_in_ms=24.416
2018-10-15 01:09:02,081 [salt.state       :1770][INFO    ][3026] Running state [net.ipv4.tcp_slow_start_after_idle] at time 01:09:02.081729
2018-10-15 01:09:02,082 [salt.state       :1803][INFO    ][3026] Executing state sysctl.present for [net.ipv4.tcp_slow_start_after_idle]
2018-10-15 01:09:02,084 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3026] Executing command 'sysctl -w net.ipv4.tcp_slow_start_after_idle="0"' in directory '/root'
2018-10-15 01:09:02,105 [salt.state       :290 ][INFO    ][3026] {'net.ipv4.tcp_slow_start_after_idle': 0}
2018-10-15 01:09:02,107 [salt.state       :1941][INFO    ][3026] Completed state [net.ipv4.tcp_slow_start_after_idle] at time 01:09:02.106909 duration_in_ms=25.179
2018-10-15 01:09:02,108 [salt.state       :1770][INFO    ][3026] Running state [vm.swappiness] at time 01:09:02.108141
2018-10-15 01:09:02,109 [salt.state       :1803][INFO    ][3026] Executing state sysctl.present for [vm.swappiness]
2018-10-15 01:09:02,110 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3026] Executing command 'sysctl -w vm.swappiness="10"' in directory '/root'
2018-10-15 01:09:02,135 [salt.state       :290 ][INFO    ][3026] {'vm.swappiness': 10}
2018-10-15 01:09:02,136 [salt.state       :1941][INFO    ][3026] Completed state [vm.swappiness] at time 01:09:02.136009 duration_in_ms=27.866
2018-10-15 01:09:02,136 [salt.state       :1770][INFO    ][3026] Running state [net.ipv4.tcp_keepalive_intvl] at time 01:09:02.136515
2018-10-15 01:09:02,137 [salt.state       :1803][INFO    ][3026] Executing state sysctl.present for [net.ipv4.tcp_keepalive_intvl]
2018-10-15 01:09:02,139 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3026] Executing command 'sysctl -w net.ipv4.tcp_keepalive_intvl="3"' in directory '/root'
2018-10-15 01:09:02,162 [salt.state       :290 ][INFO    ][3026] {'net.ipv4.tcp_keepalive_intvl': 3}
2018-10-15 01:09:02,164 [salt.state       :1941][INFO    ][3026] Completed state [net.ipv4.tcp_keepalive_intvl] at time 01:09:02.164007 duration_in_ms=27.492
2018-10-15 01:09:02,164 [salt.state       :1770][INFO    ][3026] Running state [net.ipv4.neigh.default.gc_thresh1] at time 01:09:02.164483
2018-10-15 01:09:02,164 [salt.state       :1803][INFO    ][3026] Executing state sysctl.present for [net.ipv4.neigh.default.gc_thresh1]
2018-10-15 01:09:02,166 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3026] Executing command 'sysctl -w net.ipv4.neigh.default.gc_thresh1="4096"' in directory '/root'
2018-10-15 01:09:02,187 [salt.state       :290 ][INFO    ][3026] {'net.ipv4.neigh.default.gc_thresh1': 4096}
2018-10-15 01:09:02,188 [salt.state       :1941][INFO    ][3026] Completed state [net.ipv4.neigh.default.gc_thresh1] at time 01:09:02.188611 duration_in_ms=24.128
2018-10-15 01:09:02,189 [salt.state       :1770][INFO    ][3026] Running state [net.ipv4.neigh.default.gc_thresh2] at time 01:09:02.189289
2018-10-15 01:09:02,189 [salt.state       :1803][INFO    ][3026] Executing state sysctl.present for [net.ipv4.neigh.default.gc_thresh2]
2018-10-15 01:09:02,192 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3026] Executing command 'sysctl -w net.ipv4.neigh.default.gc_thresh2="8192"' in directory '/root'
2018-10-15 01:09:02,213 [salt.state       :290 ][INFO    ][3026] {'net.ipv4.neigh.default.gc_thresh2': 8192}
2018-10-15 01:09:02,214 [salt.state       :1941][INFO    ][3026] Completed state [net.ipv4.neigh.default.gc_thresh2] at time 01:09:02.214325 duration_in_ms=25.036
2018-10-15 01:09:02,215 [salt.state       :1770][INFO    ][3026] Running state [net.ipv4.neigh.default.gc_thresh3] at time 01:09:02.214974
2018-10-15 01:09:02,216 [salt.state       :1803][INFO    ][3026] Executing state sysctl.present for [net.ipv4.neigh.default.gc_thresh3]
2018-10-15 01:09:02,218 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3026] Executing command 'sysctl -w net.ipv4.neigh.default.gc_thresh3="16384"' in directory '/root'
2018-10-15 01:09:02,240 [salt.state       :290 ][INFO    ][3026] {'net.ipv4.neigh.default.gc_thresh3': 16384}
2018-10-15 01:09:02,241 [salt.state       :1941][INFO    ][3026] Completed state [net.ipv4.neigh.default.gc_thresh3] at time 01:09:02.240880 duration_in_ms=25.906
2018-10-15 01:09:02,241 [salt.state       :1770][INFO    ][3026] Running state [net.ipv4.tcp_fin_timeout] at time 01:09:02.241942
2018-10-15 01:09:02,242 [salt.state       :1803][INFO    ][3026] Executing state sysctl.present for [net.ipv4.tcp_fin_timeout]
2018-10-15 01:09:02,244 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3026] Executing command 'sysctl -w net.ipv4.tcp_fin_timeout="30"' in directory '/root'
2018-10-15 01:09:02,263 [salt.state       :290 ][INFO    ][3026] {'net.ipv4.tcp_fin_timeout': 30}
2018-10-15 01:09:02,264 [salt.state       :1941][INFO    ][3026] Completed state [net.ipv4.tcp_fin_timeout] at time 01:09:02.264401 duration_in_ms=22.459
2018-10-15 01:09:02,265 [salt.state       :1770][INFO    ][3026] Running state [net.ipv4.tcp_keepalive_time] at time 01:09:02.265042
2018-10-15 01:09:02,265 [salt.state       :1803][INFO    ][3026] Executing state sysctl.present for [net.ipv4.tcp_keepalive_time]
2018-10-15 01:09:02,268 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3026] Executing command 'sysctl -w net.ipv4.tcp_keepalive_time="30"' in directory '/root'
2018-10-15 01:09:02,285 [salt.state       :290 ][INFO    ][3026] {'net.ipv4.tcp_keepalive_time': 30}
2018-10-15 01:09:02,286 [salt.state       :1941][INFO    ][3026] Completed state [net.ipv4.tcp_keepalive_time] at time 01:09:02.286431 duration_in_ms=21.39
2018-10-15 01:09:02,287 [salt.state       :1770][INFO    ][3026] Running state [net.nf_conntrack_max] at time 01:09:02.287138
2018-10-15 01:09:02,287 [salt.state       :1803][INFO    ][3026] Executing state sysctl.present for [net.nf_conntrack_max]
2018-10-15 01:09:02,289 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3026] Executing command 'sysctl -w net.nf_conntrack_max="1048576"' in directory '/root'
2018-10-15 01:09:02,308 [salt.state       :290 ][INFO    ][3026] {'net.nf_conntrack_max': 1048576}
2018-10-15 01:09:02,309 [salt.state       :1941][INFO    ][3026] Completed state [net.nf_conntrack_max] at time 01:09:02.309173 duration_in_ms=22.035
2018-10-15 01:09:02,310 [salt.state       :1770][INFO    ][3026] Running state [linux_sysfs_package] at time 01:09:02.310081
2018-10-15 01:09:02,310 [salt.state       :1803][INFO    ][3026] Executing state pkg.installed for [linux_sysfs_package]
2018-10-15 01:09:02,340 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3026] Executing command ['apt-cache', '-q', 'policy', 'sysfsutils'] in directory '/root'
2018-10-15 01:09:02,435 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3026] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2018-10-15 01:09:04,678 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3026] Executing command ['dpkg', '--get-selections', '*'] in directory '/root'
2018-10-15 01:09:04,706 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3026] 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-10-15 01:09:09,093 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3026] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}', '-W'] in directory '/root'
2018-10-15 01:09:09,137 [salt.state       :290 ][INFO    ][3026] 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-10-15 01:09:09,165 [salt.state       :905 ][INFO    ][3026] Loading fresh modules for state activity
2018-10-15 01:09:09,206 [salt.state       :1941][INFO    ][3026] Completed state [linux_sysfs_package] at time 01:09:09.206525 duration_in_ms=6896.444
2018-10-15 01:09:09,212 [salt.state       :1770][INFO    ][3026] Running state [/etc/sysfs.d] at time 01:09:09.212304
2018-10-15 01:09:09,212 [salt.state       :1803][INFO    ][3026] Executing state file.directory for [/etc/sysfs.d]
2018-10-15 01:09:09,217 [salt.state       :290 ][INFO    ][3026] Directory /etc/sysfs.d is in the correct state
Directory /etc/sysfs.d updated
2018-10-15 01:09:09,218 [salt.state       :1941][INFO    ][3026] Completed state [/etc/sysfs.d] at time 01:09:09.218070 duration_in_ms=5.766
2018-10-15 01:09:09,818 [salt.state       :1770][INFO    ][3026] Running state [ondemand] at time 01:09:09.818697
2018-10-15 01:09:09,819 [salt.state       :1803][INFO    ][3026] Executing state service.dead for [ondemand]
2018-10-15 01:09:09,820 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3026] Executing command ['systemctl', 'status', 'ondemand.service', '-n', '0'] in directory '/root'
2018-10-15 01:09:09,852 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3026] Executing command ['systemctl', 'is-active', 'ondemand.service'] in directory '/root'
2018-10-15 01:09:09,870 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3026] Executing command ['systemctl', 'is-enabled', 'ondemand.service'] in directory '/root'
2018-10-15 01:09:09,890 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3026] Executing command ['systemd-run', '--scope', 'systemctl', 'stop', 'ondemand.service'] in directory '/root'
2018-10-15 01:09:09,965 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3026] Executing command ['systemctl', 'is-active', 'ondemand.service'] in directory '/root'
2018-10-15 01:09:09,990 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3026] Executing command ['systemctl', 'is-enabled', 'ondemand.service'] in directory '/root'
2018-10-15 01:09:10,017 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3026] Executing command ['systemctl', 'is-enabled', 'ondemand.service'] in directory '/root'
2018-10-15 01:09:10,046 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3026] Executing command ['systemd-run', '--scope', '/usr/sbin/update-rc.d', '-f', 'ondemand', 'remove'] in directory '/root'
2018-10-15 01:09:10,214 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3026] Executing command ['systemctl', 'is-enabled', 'ondemand.service'] in directory '/root'
2018-10-15 01:09:10,242 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3026] Executing command 'runlevel' in directory '/root'
2018-10-15 01:09:10,263 [salt.state       :290 ][INFO    ][3026] {'ondemand': True}
2018-10-15 01:09:10,264 [salt.state       :1941][INFO    ][3026] Completed state [ondemand] at time 01:09:10.264158 duration_in_ms=445.462
2018-10-15 01:09:10,266 [salt.state       :1770][INFO    ][3026] Running state [cs_CZ.UTF-8] at time 01:09:10.266117
2018-10-15 01:09:10,266 [salt.state       :1803][INFO    ][3026] Executing state locale.present for [cs_CZ.UTF-8]
2018-10-15 01:09:10,267 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3026] Executing command 'locale -a' in directory '/root'
2018-10-15 01:09:10,294 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3026] Executing command ['locale-gen', 'cs_CZ.utf8'] in directory '/root'
2018-10-15 01:09:11,105 [salt.state       :290 ][INFO    ][3026] {'locale': 'cs_CZ.UTF-8'}
2018-10-15 01:09:11,106 [salt.state       :1941][INFO    ][3026] Completed state [cs_CZ.UTF-8] at time 01:09:11.106019 duration_in_ms=839.902
2018-10-15 01:09:11,106 [salt.state       :1770][INFO    ][3026] Running state [en_US.UTF-8] at time 01:09:11.106589
2018-10-15 01:09:11,107 [salt.state       :1803][INFO    ][3026] Executing state locale.present for [en_US.UTF-8]
2018-10-15 01:09:11,108 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3026] Executing command 'locale -a' in directory '/root'
2018-10-15 01:09:11,128 [salt.state       :290 ][INFO    ][3026] Locale en_US.UTF-8 is already present
2018-10-15 01:09:11,128 [salt.state       :1941][INFO    ][3026] Completed state [en_US.UTF-8] at time 01:09:11.128545 duration_in_ms=21.942
2018-10-15 01:09:11,131 [salt.state       :1770][INFO    ][3026] Running state [en_US.UTF-8] at time 01:09:11.131915
2018-10-15 01:09:11,132 [salt.state       :1803][INFO    ][3026] Executing state locale.system for [en_US.UTF-8]
2018-10-15 01:09:11,133 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3026] Executing command 'localectl' in directory '/root'
2018-10-15 01:09:11,173 [salt.state       :290 ][INFO    ][3026] System locale en_US.UTF-8 already set
2018-10-15 01:09:11,174 [salt.state       :1941][INFO    ][3026] Completed state [en_US.UTF-8] at time 01:09:11.174199 duration_in_ms=42.284
2018-10-15 01:09:11,175 [salt.state       :1770][INFO    ][3026] Running state [root] at time 01:09:11.175629
2018-10-15 01:09:11,175 [salt.state       :1803][INFO    ][3026] Executing state group.present for [root]
2018-10-15 01:09:11,176 [salt.state       :290 ][INFO    ][3026] Group root is present and up to date
2018-10-15 01:09:11,176 [salt.state       :1941][INFO    ][3026] Completed state [root] at time 01:09:11.176575 duration_in_ms=0.947
2018-10-15 01:09:11,178 [salt.state       :1770][INFO    ][3026] Running state [root] at time 01:09:11.178307
2018-10-15 01:09:11,178 [salt.state       :1803][INFO    ][3026] Executing state user.present for [root]
2018-10-15 01:09:11,183 [salt.state       :290 ][INFO    ][3026] User root is present and up to date
2018-10-15 01:09:11,184 [salt.state       :1941][INFO    ][3026] Completed state [root] at time 01:09:11.184500 duration_in_ms=6.193
2018-10-15 01:09:11,185 [salt.state       :1770][INFO    ][3026] Running state [/root] at time 01:09:11.185546
2018-10-15 01:09:11,185 [salt.state       :1803][INFO    ][3026] Executing state file.directory for [/root]
2018-10-15 01:09:11,186 [salt.state       :290 ][INFO    ][3026] Directory /root is in the correct state
Directory /root updated
2018-10-15 01:09:11,186 [salt.state       :1941][INFO    ][3026] Completed state [/root] at time 01:09:11.186782 duration_in_ms=1.236
2018-10-15 01:09:11,187 [salt.state       :1770][INFO    ][3026] Running state [/etc/sudoers.d/90-salt-user-root] at time 01:09:11.187002
2018-10-15 01:09:11,187 [salt.state       :1803][INFO    ][3026] Executing state file.absent for [/etc/sudoers.d/90-salt-user-root]
2018-10-15 01:09:11,187 [salt.state       :290 ][INFO    ][3026] File /etc/sudoers.d/90-salt-user-root is not present
2018-10-15 01:09:11,188 [salt.state       :1941][INFO    ][3026] Completed state [/etc/sudoers.d/90-salt-user-root] at time 01:09:11.187982 duration_in_ms=0.979
2018-10-15 01:09:11,188 [salt.state       :1770][INFO    ][3026] Running state [ubuntu] at time 01:09:11.188167
2018-10-15 01:09:11,189 [salt.state       :1803][INFO    ][3026] Executing state group.present for [ubuntu]
2018-10-15 01:09:11,189 [salt.state       :290 ][INFO    ][3026] Group ubuntu is present and up to date
2018-10-15 01:09:11,189 [salt.state       :1941][INFO    ][3026] Completed state [ubuntu] at time 01:09:11.189478 duration_in_ms=1.311
2018-10-15 01:09:11,190 [salt.state       :1770][INFO    ][3026] Running state [ubuntu] at time 01:09:11.190278
2018-10-15 01:09:11,190 [salt.state       :1803][INFO    ][3026] Executing state user.present for [ubuntu]
2018-10-15 01:09:11,193 [salt.state       :290 ][INFO    ][3026] {'passwd': 'XXX-REDACTED-XXX'}
2018-10-15 01:09:11,194 [salt.state       :1941][INFO    ][3026] Completed state [ubuntu] at time 01:09:11.193969 duration_in_ms=3.691
2018-10-15 01:09:11,195 [salt.state       :1770][INFO    ][3026] Running state [/home/ubuntu] at time 01:09:11.194968
2018-10-15 01:09:11,195 [salt.state       :1803][INFO    ][3026] Executing state file.directory for [/home/ubuntu]
2018-10-15 01:09:11,197 [salt.state       :290 ][INFO    ][3026] {'mode': '0700'}
2018-10-15 01:09:11,197 [salt.state       :1941][INFO    ][3026] Completed state [/home/ubuntu] at time 01:09:11.197252 duration_in_ms=2.284
2018-10-15 01:09:11,198 [salt.state       :1770][INFO    ][3026] Running state [/etc/sudoers.d/90-salt-user-ubuntu] at time 01:09:11.198096
2018-10-15 01:09:11,198 [salt.state       :1803][INFO    ][3026] Executing state file.managed for [/etc/sudoers.d/90-salt-user-ubuntu]
2018-10-15 01:09:11,221 [salt.fileclient  :1215][INFO    ][3026] Fetching file from saltenv 'base', ** done ** 'linux/files/sudoer'
2018-10-15 01:09:11,234 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3026] Executing command '/usr/sbin/visudo -c -f /tmp/__salt.tmp.Yia5_0' in directory '/root'
2018-10-15 01:09:11,262 [salt.state       :290 ][INFO    ][3026] File changed:
New file
2018-10-15 01:09:11,264 [salt.state       :1941][INFO    ][3026] Completed state [/etc/sudoers.d/90-salt-user-ubuntu] at time 01:09:11.262862 duration_in_ms=64.766
2018-10-15 01:09:11,264 [salt.state       :1770][INFO    ][3026] Running state [/etc/security/limits.d/90-salt-default.conf] at time 01:09:11.264701
2018-10-15 01:09:11,265 [salt.state       :1803][INFO    ][3026] Executing state file.managed for [/etc/security/limits.d/90-salt-default.conf]
2018-10-15 01:09:11,290 [salt.fileclient  :1215][INFO    ][3026] Fetching file from saltenv 'base', ** done ** 'linux/files/limits.conf'
2018-10-15 01:09:11,410 [salt.state       :290 ][INFO    ][3026] File changed:
New file
2018-10-15 01:09:11,412 [salt.state       :1941][INFO    ][3026] Completed state [/etc/security/limits.d/90-salt-default.conf] at time 01:09:11.412131 duration_in_ms=147.43
2018-10-15 01:09:11,412 [salt.state       :1770][INFO    ][3026] Running state [/etc/systemd/system.conf.d/90-salt.conf] at time 01:09:11.412433
2018-10-15 01:09:11,412 [salt.state       :1803][INFO    ][3026] Executing state file.managed for [/etc/systemd/system.conf.d/90-salt.conf]
2018-10-15 01:09:11,744 [salt.fileclient  :1215][INFO    ][3026] Fetching file from saltenv 'base', ** done ** 'linux/files/systemd.conf'
2018-10-15 01:09:11,870 [salt.state       :290 ][INFO    ][3026] File changed:
New file
2018-10-15 01:09:11,871 [salt.state       :1941][INFO    ][3026] Completed state [/etc/systemd/system.conf.d/90-salt.conf] at time 01:09:11.870972 duration_in_ms=458.538
2018-10-15 01:09:11,873 [salt.state       :1770][INFO    ][3026] Running state [service.systemctl_reload] at time 01:09:11.873538
2018-10-15 01:09:11,873 [salt.state       :1803][INFO    ][3026] Executing state module.wait for [service.systemctl_reload]
2018-10-15 01:09:11,874 [salt.state       :290 ][INFO    ][3026] No changes made for service.systemctl_reload
2018-10-15 01:09:11,874 [salt.state       :1941][INFO    ][3026] Completed state [service.systemctl_reload] at time 01:09:11.874165 duration_in_ms=0.627
2018-10-15 01:09:11,874 [salt.state       :1770][INFO    ][3026] Running state [service.systemctl_reload] at time 01:09:11.874326
2018-10-15 01:09:11,874 [salt.state       :1803][INFO    ][3026] Executing state module.mod_watch for [service.systemctl_reload]
2018-10-15 01:09:11,874 [salt.utils.decorators:613 ][WARNING ][3026] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2018-10-15 01:09:11,875 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3026] Executing command ['systemctl', '--system', 'daemon-reload'] in directory '/root'
2018-10-15 01:09:12,010 [salt.state       :290 ][INFO    ][3026] {'ret': True}
2018-10-15 01:09:12,012 [salt.state       :1941][INFO    ][3026] Completed state [service.systemctl_reload] at time 01:09:12.012596 duration_in_ms=138.268
2018-10-15 01:09:12,013 [salt.state       :1770][INFO    ][3026] Running state [/etc/issue] at time 01:09:12.013091
2018-10-15 01:09:12,013 [salt.state       :1803][INFO    ][3026] Executing state file.managed for [/etc/issue]
2018-10-15 01:09:12,016 [salt.state       :290 ][INFO    ][3026] File changed:
--- 
+++ 
@@ -1,2 +1,9 @@
-Ubuntu 16.04.5 LTS \n \l
-
+=================================== WARNING ====================================
+You have accessed a computer managed by COMPANY_NAME_HERE.
+You are required to have authorisation from COMPANY_NAME_HERE
+before you proceed and you are strictly limited to use set out within that
+authorisation. Unauthorised access to or misuse of this system is prohibited
+and constitutes an offence under the Computer Misuse Act 1990.
+If you disclose any information obtained through this system without authority
+COMPANY_NAME_HERE may take legal action against you.
+================================================================================

2018-10-15 01:09:12,016 [salt.state       :1941][INFO    ][3026] Completed state [/etc/issue] at time 01:09:12.016730 duration_in_ms=3.638
2018-10-15 01:09:12,016 [salt.state       :1770][INFO    ][3026] Running state [/etc/hostname] at time 01:09:12.016943
2018-10-15 01:09:12,017 [salt.state       :1803][INFO    ][3026] Executing state file.managed for [/etc/hostname]
2018-10-15 01:09:12,036 [salt.fileclient  :1215][INFO    ][3026] Fetching file from saltenv 'base', ** done ** 'linux/files/hostname'
2018-10-15 01:09:12,050 [salt.state       :290 ][INFO    ][3026] File changed:
--- 
+++ 
@@ -1 +1 @@
-ubuntu
+msg02

2018-10-15 01:09:12,051 [salt.state       :1941][INFO    ][3026] Completed state [/etc/hostname] at time 01:09:12.051047 duration_in_ms=34.104
2018-10-15 01:09:12,053 [salt.state       :1770][INFO    ][3026] Running state [hostname msg02] at time 01:09:12.053438
2018-10-15 01:09:12,053 [salt.state       :1803][INFO    ][3026] Executing state cmd.run for [hostname msg02]
2018-10-15 01:09:12,054 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3026] Executing command 'test "$(hostname)" = "msg02"' in directory '/root'
2018-10-15 01:09:12,072 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3026] Executing command 'hostname msg02' in directory '/root'
2018-10-15 01:09:12,093 [salt.state       :290 ][INFO    ][3026] {'pid': 5198, 'retcode': 0, 'stderr': '', 'stdout': ''}
2018-10-15 01:09:12,094 [salt.state       :1941][INFO    ][3026] Completed state [hostname msg02] at time 01:09:12.094622 duration_in_ms=41.183
2018-10-15 01:09:12,097 [salt.state       :1770][INFO    ][3026] Running state [mdb02] at time 01:09:12.097308
2018-10-15 01:09:12,097 [salt.state       :1803][INFO    ][3026] Executing state host.present for [mdb02]
2018-10-15 01:09:12,100 [salt.state       :290 ][INFO    ][3026] {'host': 'mdb02'}
2018-10-15 01:09:12,100 [salt.state       :1941][INFO    ][3026] Completed state [mdb02] at time 01:09:12.100287 duration_in_ms=2.98
2018-10-15 01:09:12,100 [salt.state       :1770][INFO    ][3026] Running state [mdb02.mcp-pike-ovs-ha.local] at time 01:09:12.100694
2018-10-15 01:09:12,101 [salt.state       :1803][INFO    ][3026] Executing state host.present for [mdb02.mcp-pike-ovs-ha.local]
2018-10-15 01:09:12,102 [salt.state       :290 ][INFO    ][3026] {'host': 'mdb02.mcp-pike-ovs-ha.local'}
2018-10-15 01:09:12,103 [salt.state       :1941][INFO    ][3026] Completed state [mdb02.mcp-pike-ovs-ha.local] at time 01:09:12.102982 duration_in_ms=2.288
2018-10-15 01:09:12,103 [salt.state       :1770][INFO    ][3026] Running state [mdb03] at time 01:09:12.103395
2018-10-15 01:09:12,103 [salt.state       :1803][INFO    ][3026] Executing state host.present for [mdb03]
2018-10-15 01:09:12,104 [salt.state       :290 ][INFO    ][3026] {'host': 'mdb03'}
2018-10-15 01:09:12,105 [salt.state       :1941][INFO    ][3026] Completed state [mdb03] at time 01:09:12.105083 duration_in_ms=1.688
2018-10-15 01:09:12,105 [salt.state       :1770][INFO    ][3026] Running state [mdb03.mcp-pike-ovs-ha.local] at time 01:09:12.105468
2018-10-15 01:09:12,105 [salt.state       :1803][INFO    ][3026] Executing state host.present for [mdb03.mcp-pike-ovs-ha.local]
2018-10-15 01:09:12,106 [salt.state       :290 ][INFO    ][3026] {'host': 'mdb03.mcp-pike-ovs-ha.local'}
2018-10-15 01:09:12,107 [salt.state       :1941][INFO    ][3026] Completed state [mdb03.mcp-pike-ovs-ha.local] at time 01:09:12.107129 duration_in_ms=1.661
2018-10-15 01:09:12,107 [salt.state       :1770][INFO    ][3026] Running state [mdb01] at time 01:09:12.107532
2018-10-15 01:09:12,107 [salt.state       :1803][INFO    ][3026] Executing state host.present for [mdb01]
2018-10-15 01:09:12,109 [salt.state       :290 ][INFO    ][3026] {'host': 'mdb01'}
2018-10-15 01:09:12,109 [salt.state       :1941][INFO    ][3026] Completed state [mdb01] at time 01:09:12.109272 duration_in_ms=1.739
2018-10-15 01:09:12,110 [salt.state       :1770][INFO    ][3026] Running state [mdb01.mcp-pike-ovs-ha.local] at time 01:09:12.109976
2018-10-15 01:09:12,110 [salt.state       :1803][INFO    ][3026] Executing state host.present for [mdb01.mcp-pike-ovs-ha.local]
2018-10-15 01:09:12,112 [salt.state       :290 ][INFO    ][3026] {'host': 'mdb01.mcp-pike-ovs-ha.local'}
2018-10-15 01:09:12,112 [salt.state       :1941][INFO    ][3026] Completed state [mdb01.mcp-pike-ovs-ha.local] at time 01:09:12.112186 duration_in_ms=2.21
2018-10-15 01:09:12,112 [salt.state       :1770][INFO    ][3026] Running state [mdb] at time 01:09:12.112474
2018-10-15 01:09:12,112 [salt.state       :1803][INFO    ][3026] Executing state host.present for [mdb]
2018-10-15 01:09:12,113 [salt.state       :290 ][INFO    ][3026] {'host': 'mdb'}
2018-10-15 01:09:12,113 [salt.state       :1941][INFO    ][3026] Completed state [mdb] at time 01:09:12.113614 duration_in_ms=1.139
2018-10-15 01:09:12,114 [salt.state       :1770][INFO    ][3026] Running state [mdb.mcp-pike-ovs-ha.local] at time 01:09:12.114183
2018-10-15 01:09:12,114 [salt.state       :1803][INFO    ][3026] Executing state host.present for [mdb.mcp-pike-ovs-ha.local]
2018-10-15 01:09:12,120 [salt.state       :290 ][INFO    ][3026] {'host': 'mdb.mcp-pike-ovs-ha.local'}
2018-10-15 01:09:12,120 [salt.state       :1941][INFO    ][3026] Completed state [mdb.mcp-pike-ovs-ha.local] at time 01:09:12.120623 duration_in_ms=6.44
2018-10-15 01:09:12,121 [salt.state       :1770][INFO    ][3026] Running state [cfg01] at time 01:09:12.121024
2018-10-15 01:09:12,121 [salt.state       :1803][INFO    ][3026] Executing state host.present for [cfg01]
2018-10-15 01:09:12,122 [salt.state       :290 ][INFO    ][3026] {'host': 'cfg01'}
2018-10-15 01:09:12,123 [salt.state       :1941][INFO    ][3026] Completed state [cfg01] at time 01:09:12.122920 duration_in_ms=1.896
2018-10-15 01:09:12,123 [salt.state       :1770][INFO    ][3026] Running state [cfg01.mcp-pike-ovs-ha.local] at time 01:09:12.123863
2018-10-15 01:09:12,124 [salt.state       :1803][INFO    ][3026] Executing state host.present for [cfg01.mcp-pike-ovs-ha.local]
2018-10-15 01:09:12,125 [salt.state       :290 ][INFO    ][3026] {'host': 'cfg01.mcp-pike-ovs-ha.local'}
2018-10-15 01:09:12,125 [salt.state       :1941][INFO    ][3026] Completed state [cfg01.mcp-pike-ovs-ha.local] at time 01:09:12.125773 duration_in_ms=1.91
2018-10-15 01:09:12,126 [salt.state       :1770][INFO    ][3026] Running state [prx01] at time 01:09:12.126137
2018-10-15 01:09:12,126 [salt.state       :1803][INFO    ][3026] Executing state host.present for [prx01]
2018-10-15 01:09:12,128 [salt.state       :290 ][INFO    ][3026] {'host': 'prx01'}
2018-10-15 01:09:12,128 [salt.state       :1941][INFO    ][3026] Completed state [prx01] at time 01:09:12.128716 duration_in_ms=2.579
2018-10-15 01:09:12,129 [salt.state       :1770][INFO    ][3026] Running state [prx01.mcp-pike-ovs-ha.local] at time 01:09:12.129068
2018-10-15 01:09:12,129 [salt.state       :1803][INFO    ][3026] Executing state host.present for [prx01.mcp-pike-ovs-ha.local]
2018-10-15 01:09:12,130 [salt.state       :290 ][INFO    ][3026] {'host': 'prx01.mcp-pike-ovs-ha.local'}
2018-10-15 01:09:12,130 [salt.state       :1941][INFO    ][3026] Completed state [prx01.mcp-pike-ovs-ha.local] at time 01:09:12.130632 duration_in_ms=1.564
2018-10-15 01:09:12,131 [salt.state       :1770][INFO    ][3026] Running state [kvm01] at time 01:09:12.131908
2018-10-15 01:09:12,132 [salt.state       :1803][INFO    ][3026] Executing state host.present for [kvm01]
2018-10-15 01:09:12,132 [salt.state       :290 ][INFO    ][3026] {'host': 'kvm01'}
2018-10-15 01:09:12,133 [salt.state       :1941][INFO    ][3026] Completed state [kvm01] at time 01:09:12.133124 duration_in_ms=1.216
2018-10-15 01:09:12,133 [salt.state       :1770][INFO    ][3026] Running state [kvm01.mcp-pike-ovs-ha.local] at time 01:09:12.133381
2018-10-15 01:09:12,133 [salt.state       :1803][INFO    ][3026] Executing state host.present for [kvm01.mcp-pike-ovs-ha.local]
2018-10-15 01:09:12,134 [salt.state       :290 ][INFO    ][3026] {'host': 'kvm01.mcp-pike-ovs-ha.local'}
2018-10-15 01:09:12,134 [salt.state       :1941][INFO    ][3026] Completed state [kvm01.mcp-pike-ovs-ha.local] at time 01:09:12.134533 duration_in_ms=1.152
2018-10-15 01:09:12,135 [salt.state       :1770][INFO    ][3026] Running state [kvm03] at time 01:09:12.134803
2018-10-15 01:09:12,135 [salt.state       :1803][INFO    ][3026] Executing state host.present for [kvm03]
2018-10-15 01:09:12,136 [salt.state       :290 ][INFO    ][3026] {'host': 'kvm03'}
2018-10-15 01:09:12,136 [salt.state       :1941][INFO    ][3026] Completed state [kvm03] at time 01:09:12.136931 duration_in_ms=2.128
2018-10-15 01:09:12,137 [salt.state       :1770][INFO    ][3026] Running state [kvm03.mcp-pike-ovs-ha.local] at time 01:09:12.137229
2018-10-15 01:09:12,137 [salt.state       :1803][INFO    ][3026] Executing state host.present for [kvm03.mcp-pike-ovs-ha.local]
2018-10-15 01:09:12,138 [salt.state       :290 ][INFO    ][3026] {'host': 'kvm03.mcp-pike-ovs-ha.local'}
2018-10-15 01:09:12,138 [salt.state       :1941][INFO    ][3026] Completed state [kvm03.mcp-pike-ovs-ha.local] at time 01:09:12.138399 duration_in_ms=1.17
2018-10-15 01:09:12,138 [salt.state       :1770][INFO    ][3026] Running state [kvm02] at time 01:09:12.138677
2018-10-15 01:09:12,138 [salt.state       :1803][INFO    ][3026] Executing state host.present for [kvm02]
2018-10-15 01:09:12,140 [salt.state       :290 ][INFO    ][3026] {'host': 'kvm02'}
2018-10-15 01:09:12,140 [salt.state       :1941][INFO    ][3026] Completed state [kvm02] at time 01:09:12.140606 duration_in_ms=1.93
2018-10-15 01:09:12,140 [salt.state       :1770][INFO    ][3026] Running state [kvm02.mcp-pike-ovs-ha.local] at time 01:09:12.140892
2018-10-15 01:09:12,141 [salt.state       :1803][INFO    ][3026] Executing state host.present for [kvm02.mcp-pike-ovs-ha.local]
2018-10-15 01:09:12,141 [salt.state       :290 ][INFO    ][3026] {'host': 'kvm02.mcp-pike-ovs-ha.local'}
2018-10-15 01:09:12,142 [salt.state       :1941][INFO    ][3026] Completed state [kvm02.mcp-pike-ovs-ha.local] at time 01:09:12.142046 duration_in_ms=1.155
2018-10-15 01:09:12,142 [salt.state       :1770][INFO    ][3026] Running state [dbs] at time 01:09:12.142635
2018-10-15 01:09:12,142 [salt.state       :1803][INFO    ][3026] Executing state host.present for [dbs]
2018-10-15 01:09:12,144 [salt.state       :290 ][INFO    ][3026] {'host': 'dbs'}
2018-10-15 01:09:12,144 [salt.state       :1941][INFO    ][3026] Completed state [dbs] at time 01:09:12.144794 duration_in_ms=2.16
2018-10-15 01:09:12,145 [salt.state       :1770][INFO    ][3026] Running state [dbs.mcp-pike-ovs-ha.local] at time 01:09:12.145060
2018-10-15 01:09:12,145 [salt.state       :1803][INFO    ][3026] Executing state host.present for [dbs.mcp-pike-ovs-ha.local]
2018-10-15 01:09:12,146 [salt.state       :290 ][INFO    ][3026] {'host': 'dbs.mcp-pike-ovs-ha.local'}
2018-10-15 01:09:12,146 [salt.state       :1941][INFO    ][3026] Completed state [dbs.mcp-pike-ovs-ha.local] at time 01:09:12.146908 duration_in_ms=1.848
2018-10-15 01:09:12,147 [salt.state       :1770][INFO    ][3026] Running state [prx] at time 01:09:12.147246
2018-10-15 01:09:12,147 [salt.state       :1803][INFO    ][3026] Executing state host.present for [prx]
2018-10-15 01:09:12,149 [salt.state       :290 ][INFO    ][3026] {'host': 'prx'}
2018-10-15 01:09:12,149 [salt.state       :1941][INFO    ][3026] Completed state [prx] at time 01:09:12.149183 duration_in_ms=1.937
2018-10-15 01:09:12,149 [salt.state       :1770][INFO    ][3026] Running state [prx.mcp-pike-ovs-ha.local] at time 01:09:12.149468
2018-10-15 01:09:12,149 [salt.state       :1803][INFO    ][3026] Executing state host.present for [prx.mcp-pike-ovs-ha.local]
2018-10-15 01:09:12,150 [salt.state       :290 ][INFO    ][3026] {'host': 'prx.mcp-pike-ovs-ha.local'}
2018-10-15 01:09:12,150 [salt.state       :1941][INFO    ][3026] Completed state [prx.mcp-pike-ovs-ha.local] at time 01:09:12.150642 duration_in_ms=1.175
2018-10-15 01:09:12,150 [salt.state       :1770][INFO    ][3026] Running state [prx02] at time 01:09:12.150910
2018-10-15 01:09:12,151 [salt.state       :1803][INFO    ][3026] Executing state host.present for [prx02]
2018-10-15 01:09:12,152 [salt.state       :290 ][INFO    ][3026] {'host': 'prx02'}
2018-10-15 01:09:12,152 [salt.state       :1941][INFO    ][3026] Completed state [prx02] at time 01:09:12.152556 duration_in_ms=1.645
2018-10-15 01:09:12,152 [salt.state       :1770][INFO    ][3026] Running state [prx02.mcp-pike-ovs-ha.local] at time 01:09:12.152840
2018-10-15 01:09:12,153 [salt.state       :1803][INFO    ][3026] Executing state host.present for [prx02.mcp-pike-ovs-ha.local]
2018-10-15 01:09:12,154 [salt.state       :290 ][INFO    ][3026] {'host': 'prx02.mcp-pike-ovs-ha.local'}
2018-10-15 01:09:12,154 [salt.state       :1941][INFO    ][3026] Completed state [prx02.mcp-pike-ovs-ha.local] at time 01:09:12.154370 duration_in_ms=1.53
2018-10-15 01:09:12,155 [salt.state       :1770][INFO    ][3026] Running state [msg02] at time 01:09:12.154985
2018-10-15 01:09:12,155 [salt.state       :1803][INFO    ][3026] Executing state host.present for [msg02]
2018-10-15 01:09:12,156 [salt.state       :290 ][INFO    ][3026] {'host': 'msg02'}
2018-10-15 01:09:12,156 [salt.state       :1941][INFO    ][3026] Completed state [msg02] at time 01:09:12.156529 duration_in_ms=1.544
2018-10-15 01:09:12,156 [salt.state       :1770][INFO    ][3026] Running state [msg02.mcp-pike-ovs-ha.local] at time 01:09:12.156804
2018-10-15 01:09:12,157 [salt.state       :1803][INFO    ][3026] Executing state host.present for [msg02.mcp-pike-ovs-ha.local]
2018-10-15 01:09:12,158 [salt.state       :290 ][INFO    ][3026] {'host': 'msg02.mcp-pike-ovs-ha.local'}
2018-10-15 01:09:12,158 [salt.state       :1941][INFO    ][3026] Completed state [msg02.mcp-pike-ovs-ha.local] at time 01:09:12.158333 duration_in_ms=1.529
2018-10-15 01:09:12,158 [salt.state       :1770][INFO    ][3026] Running state [msg03] at time 01:09:12.158630
2018-10-15 01:09:12,158 [salt.state       :1803][INFO    ][3026] Executing state host.present for [msg03]
2018-10-15 01:09:12,159 [salt.state       :290 ][INFO    ][3026] {'host': 'msg03'}
2018-10-15 01:09:12,159 [salt.state       :1941][INFO    ][3026] Completed state [msg03] at time 01:09:12.159865 duration_in_ms=1.234
2018-10-15 01:09:12,160 [salt.state       :1770][INFO    ][3026] Running state [msg03.mcp-pike-ovs-ha.local] at time 01:09:12.160498
2018-10-15 01:09:12,160 [salt.state       :1803][INFO    ][3026] Executing state host.present for [msg03.mcp-pike-ovs-ha.local]
2018-10-15 01:09:12,161 [salt.state       :290 ][INFO    ][3026] {'host': 'msg03.mcp-pike-ovs-ha.local'}
2018-10-15 01:09:12,162 [salt.state       :1941][INFO    ][3026] Completed state [msg03.mcp-pike-ovs-ha.local] at time 01:09:12.162120 duration_in_ms=1.621
2018-10-15 01:09:12,162 [salt.state       :1770][INFO    ][3026] Running state [msg01] at time 01:09:12.162400
2018-10-15 01:09:12,162 [salt.state       :1803][INFO    ][3026] Executing state host.present for [msg01]
2018-10-15 01:09:12,163 [salt.state       :290 ][INFO    ][3026] {'host': 'msg01'}
2018-10-15 01:09:12,163 [salt.state       :1941][INFO    ][3026] Completed state [msg01] at time 01:09:12.163954 duration_in_ms=1.554
2018-10-15 01:09:12,164 [salt.state       :1770][INFO    ][3026] Running state [msg01.mcp-pike-ovs-ha.local] at time 01:09:12.164274
2018-10-15 01:09:12,164 [salt.state       :1803][INFO    ][3026] Executing state host.present for [msg01.mcp-pike-ovs-ha.local]
2018-10-15 01:09:12,165 [salt.state       :290 ][INFO    ][3026] {'host': 'msg01.mcp-pike-ovs-ha.local'}
2018-10-15 01:09:12,165 [salt.state       :1941][INFO    ][3026] Completed state [msg01.mcp-pike-ovs-ha.local] at time 01:09:12.165506 duration_in_ms=1.233
2018-10-15 01:09:12,165 [salt.state       :1770][INFO    ][3026] Running state [msg] at time 01:09:12.165787
2018-10-15 01:09:12,165 [salt.state       :1803][INFO    ][3026] Executing state host.present for [msg]
2018-10-15 01:09:12,166 [salt.state       :290 ][INFO    ][3026] {'host': 'msg'}
2018-10-15 01:09:12,167 [salt.state       :1941][INFO    ][3026] Completed state [msg] at time 01:09:12.167028 duration_in_ms=1.24
2018-10-15 01:09:12,167 [salt.state       :1770][INFO    ][3026] Running state [msg.mcp-pike-ovs-ha.local] at time 01:09:12.167303
2018-10-15 01:09:12,167 [salt.state       :1803][INFO    ][3026] Executing state host.present for [msg.mcp-pike-ovs-ha.local]
2018-10-15 01:09:12,168 [salt.state       :290 ][INFO    ][3026] {'host': 'msg.mcp-pike-ovs-ha.local'}
2018-10-15 01:09:12,168 [salt.state       :1941][INFO    ][3026] Completed state [msg.mcp-pike-ovs-ha.local] at time 01:09:12.168901 duration_in_ms=1.598
2018-10-15 01:09:12,169 [salt.state       :1770][INFO    ][3026] Running state [cfg01] at time 01:09:12.169213
2018-10-15 01:09:12,169 [salt.state       :1803][INFO    ][3026] Executing state host.present for [cfg01]
2018-10-15 01:09:12,169 [salt.state       :290 ][INFO    ][3026] Host cfg01 (192.168.10.11) already present
2018-10-15 01:09:12,169 [salt.state       :1941][INFO    ][3026] Completed state [cfg01] at time 01:09:12.169957 duration_in_ms=0.744
2018-10-15 01:09:12,170 [salt.state       :1770][INFO    ][3026] Running state [cfg01.mcp-pike-ovs-ha.local] at time 01:09:12.170222
2018-10-15 01:09:12,170 [salt.state       :1803][INFO    ][3026] Executing state host.present for [cfg01.mcp-pike-ovs-ha.local]
2018-10-15 01:09:12,171 [salt.state       :290 ][INFO    ][3026] Host cfg01.mcp-pike-ovs-ha.local (192.168.10.11) already present
2018-10-15 01:09:12,171 [salt.state       :1941][INFO    ][3026] Completed state [cfg01.mcp-pike-ovs-ha.local] at time 01:09:12.171690 duration_in_ms=1.467
2018-10-15 01:09:12,171 [salt.state       :1770][INFO    ][3026] Running state [cmp002] at time 01:09:12.171956
2018-10-15 01:09:12,172 [salt.state       :1803][INFO    ][3026] Executing state host.present for [cmp002]
2018-10-15 01:09:12,173 [salt.state       :290 ][INFO    ][3026] {'host': 'cmp002'}
2018-10-15 01:09:12,173 [salt.state       :1941][INFO    ][3026] Completed state [cmp002] at time 01:09:12.173312 duration_in_ms=1.356
2018-10-15 01:09:12,173 [salt.state       :1770][INFO    ][3026] Running state [cmp002.mcp-pike-ovs-ha.local] at time 01:09:12.173593
2018-10-15 01:09:12,174 [salt.state       :1803][INFO    ][3026] Executing state host.present for [cmp002.mcp-pike-ovs-ha.local]
2018-10-15 01:09:12,175 [salt.state       :290 ][INFO    ][3026] {'host': 'cmp002.mcp-pike-ovs-ha.local'}
2018-10-15 01:09:12,175 [salt.state       :1941][INFO    ][3026] Completed state [cmp002.mcp-pike-ovs-ha.local] at time 01:09:12.175215 duration_in_ms=1.622
2018-10-15 01:09:12,175 [salt.state       :1770][INFO    ][3026] Running state [cmp001] at time 01:09:12.175515
2018-10-15 01:09:12,175 [salt.state       :1803][INFO    ][3026] Executing state host.present for [cmp001]
2018-10-15 01:09:12,176 [salt.state       :290 ][INFO    ][3026] {'host': 'cmp001'}
2018-10-15 01:09:12,176 [salt.state       :1941][INFO    ][3026] Completed state [cmp001] at time 01:09:12.176825 duration_in_ms=1.311
2018-10-15 01:09:12,177 [salt.state       :1770][INFO    ][3026] Running state [cmp001.mcp-pike-ovs-ha.local] at time 01:09:12.177105
2018-10-15 01:09:12,177 [salt.state       :1803][INFO    ][3026] Executing state host.present for [cmp001.mcp-pike-ovs-ha.local]
2018-10-15 01:09:12,178 [salt.state       :290 ][INFO    ][3026] {'host': 'cmp001.mcp-pike-ovs-ha.local'}
2018-10-15 01:09:12,178 [salt.state       :1941][INFO    ][3026] Completed state [cmp001.mcp-pike-ovs-ha.local] at time 01:09:12.178668 duration_in_ms=1.563
2018-10-15 01:09:12,179 [salt.state       :1770][INFO    ][3026] Running state [dbs01] at time 01:09:12.179588
2018-10-15 01:09:12,179 [salt.state       :1803][INFO    ][3026] Executing state host.present for [dbs01]
2018-10-15 01:09:12,180 [salt.state       :290 ][INFO    ][3026] {'host': 'dbs01'}
2018-10-15 01:09:12,180 [salt.state       :1941][INFO    ][3026] Completed state [dbs01] at time 01:09:12.180927 duration_in_ms=1.338
2018-10-15 01:09:12,181 [salt.state       :1770][INFO    ][3026] Running state [dbs01.mcp-pike-ovs-ha.local] at time 01:09:12.181211
2018-10-15 01:09:12,181 [salt.state       :1803][INFO    ][3026] Executing state host.present for [dbs01.mcp-pike-ovs-ha.local]
2018-10-15 01:09:12,182 [salt.state       :290 ][INFO    ][3026] {'host': 'dbs01.mcp-pike-ovs-ha.local'}
2018-10-15 01:09:12,182 [salt.state       :1941][INFO    ][3026] Completed state [dbs01.mcp-pike-ovs-ha.local] at time 01:09:12.182794 duration_in_ms=1.583
2018-10-15 01:09:12,183 [salt.state       :1770][INFO    ][3026] Running state [dbs02] at time 01:09:12.183468
2018-10-15 01:09:12,183 [salt.state       :1803][INFO    ][3026] Executing state host.present for [dbs02]
2018-10-15 01:09:12,184 [salt.state       :290 ][INFO    ][3026] {'host': 'dbs02'}
2018-10-15 01:09:12,185 [salt.state       :1941][INFO    ][3026] Completed state [dbs02] at time 01:09:12.185144 duration_in_ms=1.675
2018-10-15 01:09:12,185 [salt.state       :1770][INFO    ][3026] Running state [dbs02.mcp-pike-ovs-ha.local] at time 01:09:12.185456
2018-10-15 01:09:12,185 [salt.state       :1803][INFO    ][3026] Executing state host.present for [dbs02.mcp-pike-ovs-ha.local]
2018-10-15 01:09:12,186 [salt.state       :290 ][INFO    ][3026] {'host': 'dbs02.mcp-pike-ovs-ha.local'}
2018-10-15 01:09:12,187 [salt.state       :1941][INFO    ][3026] Completed state [dbs02.mcp-pike-ovs-ha.local] at time 01:09:12.187065 duration_in_ms=1.609
2018-10-15 01:09:12,187 [salt.state       :1770][INFO    ][3026] Running state [dbs03] at time 01:09:12.187717
2018-10-15 01:09:12,187 [salt.state       :1803][INFO    ][3026] Executing state host.present for [dbs03]
2018-10-15 01:09:12,188 [salt.state       :290 ][INFO    ][3026] {'host': 'dbs03'}
2018-10-15 01:09:12,189 [salt.state       :1941][INFO    ][3026] Completed state [dbs03] at time 01:09:12.189056 duration_in_ms=1.339
2018-10-15 01:09:12,189 [salt.state       :1770][INFO    ][3026] Running state [dbs03.mcp-pike-ovs-ha.local] at time 01:09:12.189345
2018-10-15 01:09:12,189 [salt.state       :1803][INFO    ][3026] Executing state host.present for [dbs03.mcp-pike-ovs-ha.local]
2018-10-15 01:09:12,191 [salt.state       :290 ][INFO    ][3026] {'host': 'dbs03.mcp-pike-ovs-ha.local'}
2018-10-15 01:09:12,191 [salt.state       :1941][INFO    ][3026] Completed state [dbs03.mcp-pike-ovs-ha.local] at time 01:09:12.191641 duration_in_ms=2.295
2018-10-15 01:09:12,192 [salt.state       :1770][INFO    ][3026] Running state [mas01] at time 01:09:12.191991
2018-10-15 01:09:12,192 [salt.state       :1803][INFO    ][3026] Executing state host.present for [mas01]
2018-10-15 01:09:12,193 [salt.state       :290 ][INFO    ][3026] {'host': 'mas01'}
2018-10-15 01:09:12,194 [salt.state       :1941][INFO    ][3026] Completed state [mas01] at time 01:09:12.194002 duration_in_ms=2.01
2018-10-15 01:09:12,194 [salt.state       :1770][INFO    ][3026] Running state [mas01.mcp-pike-ovs-ha.local] at time 01:09:12.194317
2018-10-15 01:09:12,194 [salt.state       :1803][INFO    ][3026] Executing state host.present for [mas01.mcp-pike-ovs-ha.local]
2018-10-15 01:09:12,196 [salt.state       :290 ][INFO    ][3026] {'host': 'mas01.mcp-pike-ovs-ha.local'}
2018-10-15 01:09:12,196 [salt.state       :1941][INFO    ][3026] Completed state [mas01.mcp-pike-ovs-ha.local] at time 01:09:12.196691 duration_in_ms=2.374
2018-10-15 01:09:12,197 [salt.state       :1770][INFO    ][3026] Running state [ctl02] at time 01:09:12.197047
2018-10-15 01:09:12,197 [salt.state       :1803][INFO    ][3026] Executing state host.present for [ctl02]
2018-10-15 01:09:12,198 [salt.state       :290 ][INFO    ][3026] {'host': 'ctl02'}
2018-10-15 01:09:12,198 [salt.state       :1941][INFO    ][3026] Completed state [ctl02] at time 01:09:12.198354 duration_in_ms=1.307
2018-10-15 01:09:12,198 [salt.state       :1770][INFO    ][3026] Running state [ctl02.mcp-pike-ovs-ha.local] at time 01:09:12.198640
2018-10-15 01:09:12,198 [salt.state       :1803][INFO    ][3026] Executing state host.present for [ctl02.mcp-pike-ovs-ha.local]
2018-10-15 01:09:12,199 [salt.state       :290 ][INFO    ][3026] {'host': 'ctl02.mcp-pike-ovs-ha.local'}
2018-10-15 01:09:12,200 [salt.state       :1941][INFO    ][3026] Completed state [ctl02.mcp-pike-ovs-ha.local] at time 01:09:12.200333 duration_in_ms=1.694
2018-10-15 01:09:12,200 [salt.state       :1770][INFO    ][3026] Running state [ctl03] at time 01:09:12.200683
2018-10-15 01:09:12,200 [salt.state       :1803][INFO    ][3026] Executing state host.present for [ctl03]
2018-10-15 01:09:12,201 [salt.state       :290 ][INFO    ][3026] {'host': 'ctl03'}
2018-10-15 01:09:12,202 [salt.state       :1941][INFO    ][3026] Completed state [ctl03] at time 01:09:12.201992 duration_in_ms=1.309
2018-10-15 01:09:12,202 [salt.state       :1770][INFO    ][3026] Running state [ctl03.mcp-pike-ovs-ha.local] at time 01:09:12.202281
2018-10-15 01:09:12,202 [salt.state       :1803][INFO    ][3026] Executing state host.present for [ctl03.mcp-pike-ovs-ha.local]
2018-10-15 01:09:12,203 [salt.state       :290 ][INFO    ][3026] {'host': 'ctl03.mcp-pike-ovs-ha.local'}
2018-10-15 01:09:12,203 [salt.state       :1941][INFO    ][3026] Completed state [ctl03.mcp-pike-ovs-ha.local] at time 01:09:12.203942 duration_in_ms=1.66
2018-10-15 01:09:12,204 [salt.state       :1770][INFO    ][3026] Running state [ctl01] at time 01:09:12.204292
2018-10-15 01:09:12,204 [salt.state       :1803][INFO    ][3026] Executing state host.present for [ctl01]
2018-10-15 01:09:12,205 [salt.state       :290 ][INFO    ][3026] {'host': 'ctl01'}
2018-10-15 01:09:12,206 [salt.state       :1941][INFO    ][3026] Completed state [ctl01] at time 01:09:12.205987 duration_in_ms=1.695
2018-10-15 01:09:12,206 [salt.state       :1770][INFO    ][3026] Running state [ctl01.mcp-pike-ovs-ha.local] at time 01:09:12.206270
2018-10-15 01:09:12,206 [salt.state       :1803][INFO    ][3026] Executing state host.present for [ctl01.mcp-pike-ovs-ha.local]
2018-10-15 01:09:12,208 [salt.state       :290 ][INFO    ][3026] {'host': 'ctl01.mcp-pike-ovs-ha.local'}
2018-10-15 01:09:12,208 [salt.state       :1941][INFO    ][3026] Completed state [ctl01.mcp-pike-ovs-ha.local] at time 01:09:12.208419 duration_in_ms=2.149
2018-10-15 01:09:12,208 [salt.state       :1770][INFO    ][3026] Running state [ctl] at time 01:09:12.208725
2018-10-15 01:09:12,208 [salt.state       :1803][INFO    ][3026] Executing state host.present for [ctl]
2018-10-15 01:09:12,210 [salt.state       :290 ][INFO    ][3026] {'host': 'ctl'}
2018-10-15 01:09:12,210 [salt.state       :1941][INFO    ][3026] Completed state [ctl] at time 01:09:12.210404 duration_in_ms=1.68
2018-10-15 01:09:12,210 [salt.state       :1770][INFO    ][3026] Running state [ctl.mcp-pike-ovs-ha.local] at time 01:09:12.210701
2018-10-15 01:09:12,210 [salt.state       :1803][INFO    ][3026] Executing state host.present for [ctl.mcp-pike-ovs-ha.local]
2018-10-15 01:09:12,211 [salt.state       :290 ][INFO    ][3026] {'host': 'ctl.mcp-pike-ovs-ha.local'}
2018-10-15 01:09:12,212 [salt.state       :1941][INFO    ][3026] Completed state [ctl.mcp-pike-ovs-ha.local] at time 01:09:12.212086 duration_in_ms=1.384
2018-10-15 01:09:12,212 [salt.state       :1770][INFO    ][3026] Running state [/etc/network/interfaces.d/50-cloud-init.cfg] at time 01:09:12.212311
2018-10-15 01:09:12,212 [salt.state       :1803][INFO    ][3026] Executing state file.absent for [/etc/network/interfaces.d/50-cloud-init.cfg]
2018-10-15 01:09:12,212 [salt.state       :290 ][INFO    ][3026] {'removed': '/etc/network/interfaces.d/50-cloud-init.cfg'}
2018-10-15 01:09:12,213 [salt.state       :1941][INFO    ][3026] Completed state [/etc/network/interfaces.d/50-cloud-init.cfg] at time 01:09:12.213014 duration_in_ms=0.703
2018-10-15 01:09:12,213 [salt.state       :1770][INFO    ][3026] Running state [ens2] at time 01:09:12.213618
2018-10-15 01:09:12,214 [salt.state       :1803][INFO    ][3026] Executing state network.managed for [ens2]
2018-10-15 01:09:12,219 [salt.minion      :1307][INFO    ][2938] User sudo_ubuntu Executing command saltutil.find_job with jid 20181015010912206926
2018-10-15 01:09:12,244 [salt.minion      :1431][INFO    ][5202] Starting a new job with PID 5202
2018-10-15 01:09:12,266 [salt.minion      :1708][INFO    ][5202] Returning information for job: 20181015010912206926
2018-10-15 01:09:12,383 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3026] Executing command ['ifdown', 'ens2'] in directory '/root'
2018-10-15 01:09:13,624 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3026] Executing command ['ifup', 'ens2'] in directory '/root'
2018-10-15 01:09:14,931 [salt.state       :290 ][INFO    ][3026] {'interface': 'Added network interface.', 'status': 'Interface ens2 restart to validate'}
2018-10-15 01:09:14,933 [salt.state       :1941][INFO    ][3026] Completed state [ens2] at time 01:09:14.933120 duration_in_ms=2719.502
2018-10-15 01:09:14,933 [salt.state       :1770][INFO    ][3026] Running state [ens3] at time 01:09:14.933647
2018-10-15 01:09:14,934 [salt.state       :1803][INFO    ][3026] Executing state network.managed for [ens3]
2018-10-15 01:09:14,978 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3026] Executing command ['ifup', 'ens3'] in directory '/root'
2018-10-15 01:09:15,800 [salt.state       :290 ][INFO    ][3026] {'interface': 'Added network interface.', 'status': 'Interface ens3 is up'}
2018-10-15 01:09:15,801 [salt.state       :1941][INFO    ][3026] Completed state [ens3] at time 01:09:15.800944 duration_in_ms=867.296
2018-10-15 01:09:15,801 [salt.state       :1770][INFO    ][3026] Running state [/etc/profile.d/proxy.sh] at time 01:09:15.801253
2018-10-15 01:09:15,801 [salt.state       :1803][INFO    ][3026] Executing state file.absent for [/etc/profile.d/proxy.sh]
2018-10-15 01:09:15,801 [salt.state       :290 ][INFO    ][3026] File /etc/profile.d/proxy.sh is not present
2018-10-15 01:09:15,802 [salt.state       :1941][INFO    ][3026] Completed state [/etc/profile.d/proxy.sh] at time 01:09:15.802128 duration_in_ms=0.874
2018-10-15 01:09:15,802 [salt.state       :1770][INFO    ][3026] Running state [/etc/apt/apt.conf.d/95proxies] at time 01:09:15.802333
2018-10-15 01:09:15,802 [salt.state       :1803][INFO    ][3026] Executing state file.absent for [/etc/apt/apt.conf.d/95proxies]
2018-10-15 01:09:15,803 [salt.state       :290 ][INFO    ][3026] File /etc/apt/apt.conf.d/95proxies is not present
2018-10-15 01:09:15,803 [salt.state       :1941][INFO    ][3026] Completed state [/etc/apt/apt.conf.d/95proxies] at time 01:09:15.803564 duration_in_ms=1.231
2018-10-15 01:09:15,804 [salt.state       :1770][INFO    ][3026] Running state [ntp] at time 01:09:15.804842
2018-10-15 01:09:15,805 [salt.state       :1803][INFO    ][3026] Executing state pkg.installed for [ntp]
2018-10-15 01:09:16,060 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3026] Executing command ['dpkg', '--get-selections', '*'] in directory '/root'
2018-10-15 01:09:16,089 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3026] 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-10-15 01:09:19,907 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3026] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}', '-W'] in directory '/root'
2018-10-15 01:09:19,951 [salt.state       :290 ][INFO    ][3026] Made the following changes:
'ntp' changed from 'absent' to '1:4.2.8p4+dfsg-3ubuntu5.9'
'libopts25' changed from 'absent' to '1:5.18.7-3'

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

2018-10-15 01:09:20,130 [salt.state       :1941][INFO    ][3026] Completed state [/etc/ntp.conf] at time 01:09:20.130472 duration_in_ms=107.819
2018-10-15 01:09:20,723 [salt.state       :1770][INFO    ][3026] Running state [ntp] at time 01:09:20.723508
2018-10-15 01:09:20,723 [salt.state       :1803][INFO    ][3026] Executing state service.running for [ntp]
2018-10-15 01:09:20,724 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3026] Executing command ['systemctl', 'status', 'ntp.service', '-n', '0'] in directory '/root'
2018-10-15 01:09:20,739 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3026] Executing command ['systemctl', 'is-active', 'ntp.service'] in directory '/root'
2018-10-15 01:09:20,759 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3026] Executing command ['systemctl', 'is-enabled', 'ntp.service'] in directory '/root'
2018-10-15 01:09:20,788 [salt.state       :290 ][INFO    ][3026] The service ntp is already running
2018-10-15 01:09:20,789 [salt.state       :1941][INFO    ][3026] Completed state [ntp] at time 01:09:20.789358 duration_in_ms=65.85
2018-10-15 01:09:20,790 [salt.state       :1770][INFO    ][3026] Running state [ntp] at time 01:09:20.789923
2018-10-15 01:09:20,790 [salt.state       :1803][INFO    ][3026] Executing state service.mod_watch for [ntp]
2018-10-15 01:09:20,793 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3026] Executing command ['systemctl', 'is-active', 'ntp.service'] in directory '/root'
2018-10-15 01:09:20,816 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3026] Executing command ['systemd-run', '--scope', 'systemctl', 'restart', 'ntp.service'] in directory '/root'
2018-10-15 01:09:20,919 [salt.state       :290 ][INFO    ][3026] {'ntp': True}
2018-10-15 01:09:20,919 [salt.state       :1941][INFO    ][3026] Completed state [ntp] at time 01:09:20.919748 duration_in_ms=129.825
2018-10-15 01:09:20,926 [salt.minion      :1708][INFO    ][3026] Returning information for job: 20181015010841679611
2018-10-15 01:10:03,491 [salt.minion      :1307][INFO    ][2938] User sudo_ubuntu Executing command state.apply with jid 20181015011003477680
2018-10-15 01:10:03,516 [salt.minion      :1431][INFO    ][6449] Starting a new job with PID 6449
2018-10-15 01:10:08,258 [salt.state       :905 ][INFO    ][6449] Loading fresh modules for state activity
2018-10-15 01:10:12,017 [salt.state       :1770][INFO    ][6449] Running state [/etc/environment] at time 01:10:12.017201
2018-10-15 01:10:12,017 [salt.state       :1803][INFO    ][6449] Executing state file.blockreplace for [/etc/environment]
2018-10-15 01:10:12,024 [salt.state       :290 ][INFO    ][6449] No changes needed to be made
2018-10-15 01:10:12,025 [salt.state       :1941][INFO    ][6449] Completed state [/etc/environment] at time 01:10:12.025013 duration_in_ms=7.812
2018-10-15 01:10:12,025 [salt.state       :1770][INFO    ][6449] Running state [/etc/profile.d] at time 01:10:12.025213
2018-10-15 01:10:12,025 [salt.state       :1803][INFO    ][6449] Executing state file.directory for [/etc/profile.d]
2018-10-15 01:10:12,027 [salt.state       :290 ][INFO    ][6449] Directory /etc/profile.d is in the correct state
Directory /etc/profile.d updated
2018-10-15 01:10:12,028 [salt.state       :1941][INFO    ][6449] Completed state [/etc/profile.d] at time 01:10:12.028139 duration_in_ms=2.926
2018-10-15 01:10:12,029 [salt.state       :1770][INFO    ][6449] Running state [fake_linux_system_at] at time 01:10:12.029080
2018-10-15 01:10:12,029 [salt.state       :1803][INFO    ][6449] Executing state test.nop for [fake_linux_system_at]
2018-10-15 01:10:12,029 [salt.state       :290 ][INFO    ][6449] Success!
2018-10-15 01:10:12,030 [salt.state       :1941][INFO    ][6449] Completed state [fake_linux_system_at] at time 01:10:12.030033 duration_in_ms=0.952
2018-10-15 01:10:12,030 [salt.state       :1770][INFO    ][6449] Running state [fake_linux_system_cron] at time 01:10:12.030233
2018-10-15 01:10:12,030 [salt.state       :1803][INFO    ][6449] Executing state test.nop for [fake_linux_system_cron]
2018-10-15 01:10:12,030 [salt.state       :290 ][INFO    ][6449] Success!
2018-10-15 01:10:12,031 [salt.state       :1941][INFO    ][6449] Completed state [fake_linux_system_cron] at time 01:10:12.031150 duration_in_ms=0.917
2018-10-15 01:10:12,752 [salt.state       :1770][INFO    ][6449] Running state [/etc/apt/apt.conf.d/99prefer_ipv4-salt] at time 01:10:12.752790
2018-10-15 01:10:12,753 [salt.state       :1803][INFO    ][6449] Executing state file.managed for [/etc/apt/apt.conf.d/99prefer_ipv4-salt]
2018-10-15 01:10:12,791 [salt.state       :290 ][INFO    ][6449] File /etc/apt/apt.conf.d/99prefer_ipv4-salt is in the correct state
2018-10-15 01:10:12,792 [salt.state       :1941][INFO    ][6449] Completed state [/etc/apt/apt.conf.d/99prefer_ipv4-salt] at time 01:10:12.791976 duration_in_ms=39.186
2018-10-15 01:10:12,792 [salt.state       :1770][INFO    ][6449] Running state [/etc/apt/apt.conf.d/99allow_downgrades-salt] at time 01:10:12.792774
2018-10-15 01:10:12,793 [salt.state       :1803][INFO    ][6449] Executing state file.managed for [/etc/apt/apt.conf.d/99allow_downgrades-salt]
2018-10-15 01:10:12,823 [salt.state       :290 ][INFO    ][6449] File /etc/apt/apt.conf.d/99allow_downgrades-salt is in the correct state
2018-10-15 01:10:12,823 [salt.state       :1941][INFO    ][6449] Completed state [/etc/apt/apt.conf.d/99allow_downgrades-salt] at time 01:10:12.823651 duration_in_ms=30.877
2018-10-15 01:10:12,825 [salt.state       :1770][INFO    ][6449] Running state [linux_repo_prereq_pkgs] at time 01:10:12.825290
2018-10-15 01:10:12,825 [salt.state       :1803][INFO    ][6449] Executing state pkg.installed for [linux_repo_prereq_pkgs]
2018-10-15 01:10:12,826 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6449] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}', '-W'] in directory '/root'
2018-10-15 01:10:13,216 [salt.state       :290 ][INFO    ][6449] All specified packages are already installed
2018-10-15 01:10:13,216 [salt.state       :1941][INFO    ][6449] Completed state [linux_repo_prereq_pkgs] at time 01:10:13.216763 duration_in_ms=391.473
2018-10-15 01:10:13,217 [salt.state       :1770][INFO    ][6449] Running state [/etc/apt/apt.conf.d/99proxies-salt] at time 01:10:13.217077
2018-10-15 01:10:13,217 [salt.state       :1803][INFO    ][6449] Executing state file.managed for [/etc/apt/apt.conf.d/99proxies-salt]
2018-10-15 01:10:13,250 [salt.state       :290 ][INFO    ][6449] File /etc/apt/apt.conf.d/99proxies-salt is in the correct state
2018-10-15 01:10:13,250 [salt.state       :1941][INFO    ][6449] Completed state [/etc/apt/apt.conf.d/99proxies-salt] at time 01:10:13.250801 duration_in_ms=33.724
2018-10-15 01:10:13,251 [salt.state       :1770][INFO    ][6449] Running state [/etc/apt/apt.conf.d/99proxies-salt-mk_openstack] at time 01:10:13.251051
2018-10-15 01:10:13,251 [salt.state       :1803][INFO    ][6449] Executing state file.absent for [/etc/apt/apt.conf.d/99proxies-salt-mk_openstack]
2018-10-15 01:10:13,251 [salt.state       :290 ][INFO    ][6449] File /etc/apt/apt.conf.d/99proxies-salt-mk_openstack is not present
2018-10-15 01:10:13,252 [salt.state       :1941][INFO    ][6449] Completed state [/etc/apt/apt.conf.d/99proxies-salt-mk_openstack] at time 01:10:13.252114 duration_in_ms=1.063
2018-10-15 01:10:13,252 [salt.state       :1770][INFO    ][6449] Running state [/etc/apt/preferences.d/mk_openstack] at time 01:10:13.252343
2018-10-15 01:10:13,252 [salt.state       :1803][INFO    ][6449] Executing state file.managed for [/etc/apt/preferences.d/mk_openstack]
2018-10-15 01:10:13,380 [salt.state       :290 ][INFO    ][6449] File /etc/apt/preferences.d/mk_openstack is in the correct state
2018-10-15 01:10:13,380 [salt.state       :1941][INFO    ][6449] Completed state [/etc/apt/preferences.d/mk_openstack] at time 01:10:13.380923 duration_in_ms=128.579
2018-10-15 01:10:13,385 [salt.state       :1770][INFO    ][6449] Running state [deb [arch=amd64] http://apt.mirantis.com/xenial/ nightly pike] at time 01:10:13.385741
2018-10-15 01:10:13,386 [salt.state       :1803][INFO    ][6449] Executing state pkgrepo.managed for [deb [arch=amd64] http://apt.mirantis.com/xenial/ nightly pike]
2018-10-15 01:10:13,441 [salt.state       :290 ][INFO    ][6449] Package repo 'deb [arch=amd64] http://apt.mirantis.com/xenial/ nightly pike' already configured
2018-10-15 01:10:13,442 [salt.state       :1941][INFO    ][6449] Completed state [deb [arch=amd64] http://apt.mirantis.com/xenial/ nightly pike] at time 01:10:13.442808 duration_in_ms=57.067
2018-10-15 01:10:13,443 [salt.state       :1770][INFO    ][6449] Running state [/etc/apt/apt.conf.d/99proxies-salt-uca-staging] at time 01:10:13.443062
2018-10-15 01:10:13,443 [salt.state       :1803][INFO    ][6449] Executing state file.absent for [/etc/apt/apt.conf.d/99proxies-salt-uca-staging]
2018-10-15 01:10:13,443 [salt.state       :290 ][INFO    ][6449] File /etc/apt/apt.conf.d/99proxies-salt-uca-staging is not present
2018-10-15 01:10:13,444 [salt.state       :1941][INFO    ][6449] Completed state [/etc/apt/apt.conf.d/99proxies-salt-uca-staging] at time 01:10:13.444075 duration_in_ms=1.013
2018-10-15 01:10:13,444 [salt.state       :1770][INFO    ][6449] Running state [/etc/apt/preferences.d/uca-staging] at time 01:10:13.444296
2018-10-15 01:10:13,444 [salt.state       :1803][INFO    ][6449] Executing state file.absent for [/etc/apt/preferences.d/uca-staging]
2018-10-15 01:10:13,444 [salt.state       :290 ][INFO    ][6449] File /etc/apt/preferences.d/uca-staging is not present
2018-10-15 01:10:13,445 [salt.state       :1941][INFO    ][6449] Completed state [/etc/apt/preferences.d/uca-staging] at time 01:10:13.444981 duration_in_ms=0.685
2018-10-15 01:10:13,450 [salt.state       :1770][INFO    ][6449] Running state [apt-key adv --keyserver keyserver.ubuntu.com --recv 9F68104E] at time 01:10:13.450141
2018-10-15 01:10:13,450 [salt.state       :1803][INFO    ][6449] Executing state cmd.run for [apt-key adv --keyserver keyserver.ubuntu.com --recv 9F68104E]
2018-10-15 01:10:13,451 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6449] Executing command 'test -e /etc/apt/sources.list.d/uca-staging.list' in directory '/root'
2018-10-15 01:10:13,468 [salt.state       :290 ][INFO    ][6449] unless execution succeeded
2018-10-15 01:10:13,468 [salt.state       :1941][INFO    ][6449] Completed state [apt-key adv --keyserver keyserver.ubuntu.com --recv 9F68104E] at time 01:10:13.468885 duration_in_ms=18.744
2018-10-15 01:10:13,472 [salt.state       :1770][INFO    ][6449] Running state [deb http://ppa.launchpad.net/ubuntu-cloud-archive/pike-staging/ubuntu xenial main] at time 01:10:13.472173
2018-10-15 01:10:13,472 [salt.state       :1803][INFO    ][6449] Executing state pkgrepo.managed for [deb http://ppa.launchpad.net/ubuntu-cloud-archive/pike-staging/ubuntu xenial main]
2018-10-15 01:10:13,527 [salt.state       :290 ][INFO    ][6449] Package repo 'deb http://ppa.launchpad.net/ubuntu-cloud-archive/pike-staging/ubuntu xenial main' already configured
2018-10-15 01:10:13,527 [salt.state       :1941][INFO    ][6449] Completed state [deb http://ppa.launchpad.net/ubuntu-cloud-archive/pike-staging/ubuntu xenial main] at time 01:10:13.527439 duration_in_ms=55.266
2018-10-15 01:10:13,527 [salt.state       :1770][INFO    ][6449] Running state [/etc/apt/apt.conf.d/99proxies-salt-mirantis_openstack] at time 01:10:13.527691
2018-10-15 01:10:13,528 [salt.state       :1803][INFO    ][6449] Executing state file.absent for [/etc/apt/apt.conf.d/99proxies-salt-mirantis_openstack]
2018-10-15 01:10:13,529 [salt.state       :290 ][INFO    ][6449] File /etc/apt/apt.conf.d/99proxies-salt-mirantis_openstack is not present
2018-10-15 01:10:13,529 [salt.state       :1941][INFO    ][6449] Completed state [/etc/apt/apt.conf.d/99proxies-salt-mirantis_openstack] at time 01:10:13.529390 duration_in_ms=1.698
2018-10-15 01:10:13,529 [salt.state       :1770][INFO    ][6449] Running state [/etc/apt/preferences.d/mirantis_openstack] at time 01:10:13.529888
2018-10-15 01:10:13,531 [salt.state       :1803][INFO    ][6449] Executing state file.managed for [/etc/apt/preferences.d/mirantis_openstack]
2018-10-15 01:10:13,596 [salt.minion      :1307][INFO    ][2938] User sudo_ubuntu Executing command saltutil.find_job with jid 20181015011013583590
2018-10-15 01:10:13,617 [salt.minion      :1431][INFO    ][6536] Starting a new job with PID 6536
2018-10-15 01:10:13,639 [salt.minion      :1708][INFO    ][6536] Returning information for job: 20181015011013583590
2018-10-15 01:10:13,703 [salt.state       :290 ][INFO    ][6449] File /etc/apt/preferences.d/mirantis_openstack is in the correct state
2018-10-15 01:10:13,704 [salt.state       :1941][INFO    ][6449] Completed state [/etc/apt/preferences.d/mirantis_openstack] at time 01:10:13.704409 duration_in_ms=174.521
2018-10-15 01:10:13,706 [salt.state       :1770][INFO    ][6449] Running state [deb http://mirror.fuel-infra.org/mcp-repos/pike/xenial pike main] at time 01:10:13.706666
2018-10-15 01:10:13,706 [salt.state       :1803][INFO    ][6449] Executing state pkgrepo.managed for [deb http://mirror.fuel-infra.org/mcp-repos/pike/xenial pike main]
2018-10-15 01:10:13,879 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6449] Executing command ['apt-key', 'add', '/var/cache/salt/minion/extrn_files/base/mirror.fuel-infra.org/mcp-repos/pike/xenial/archive-mcppike.key'] in directory '/root'
2018-10-15 01:10:14,140 [salt.state       :290 ][INFO    ][6449] Configured package repo 'deb http://mirror.fuel-infra.org/mcp-repos/pike/xenial pike main'
2018-10-15 01:10:14,141 [salt.state       :1941][INFO    ][6449] Completed state [deb http://mirror.fuel-infra.org/mcp-repos/pike/xenial pike main] at time 01:10:14.141143 duration_in_ms=434.477
2018-10-15 01:10:14,141 [salt.state       :1770][INFO    ][6449] Running state [/etc/apt/apt.conf.d/99proxies-salt-uca] at time 01:10:14.141478
2018-10-15 01:10:14,141 [salt.state       :1803][INFO    ][6449] Executing state file.absent for [/etc/apt/apt.conf.d/99proxies-salt-uca]
2018-10-15 01:10:14,142 [salt.state       :290 ][INFO    ][6449] File /etc/apt/apt.conf.d/99proxies-salt-uca is not present
2018-10-15 01:10:14,142 [salt.state       :1941][INFO    ][6449] Completed state [/etc/apt/apt.conf.d/99proxies-salt-uca] at time 01:10:14.142684 duration_in_ms=1.205
2018-10-15 01:10:14,142 [salt.state       :1770][INFO    ][6449] Running state [/etc/apt/preferences.d/uca] at time 01:10:14.142918
2018-10-15 01:10:14,143 [salt.state       :1803][INFO    ][6449] Executing state file.managed for [/etc/apt/preferences.d/uca]
2018-10-15 01:10:14,357 [salt.state       :290 ][INFO    ][6449] File /etc/apt/preferences.d/uca is in the correct state
2018-10-15 01:10:14,358 [salt.state       :1941][INFO    ][6449] Completed state [/etc/apt/preferences.d/uca] at time 01:10:14.358069 duration_in_ms=215.151
2018-10-15 01:10:14,362 [salt.state       :1770][INFO    ][6449] Running state [apt-key adv --keyserver keyserver.ubuntu.com --recv EC4926EA] at time 01:10:14.362748
2018-10-15 01:10:14,362 [salt.state       :1803][INFO    ][6449] Executing state cmd.run for [apt-key adv --keyserver keyserver.ubuntu.com --recv EC4926EA]
2018-10-15 01:10:14,363 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6449] Executing command 'test -e /etc/apt/sources.list.d/uca.list' in directory '/root'
2018-10-15 01:10:14,384 [salt.state       :290 ][INFO    ][6449] unless execution succeeded
2018-10-15 01:10:14,385 [salt.state       :1941][INFO    ][6449] Completed state [apt-key adv --keyserver keyserver.ubuntu.com --recv EC4926EA] at time 01:10:14.385507 duration_in_ms=22.759
2018-10-15 01:10:14,391 [salt.state       :1770][INFO    ][6449] Running state [deb http://ubuntu-cloud.archive.canonical.com/ubuntu xenial-updates/pike main] at time 01:10:14.391871
2018-10-15 01:10:14,393 [salt.state       :1803][INFO    ][6449] Executing state pkgrepo.managed for [deb http://ubuntu-cloud.archive.canonical.com/ubuntu xenial-updates/pike main]
2018-10-15 01:10:14,449 [salt.state       :290 ][INFO    ][6449] Package repo 'deb http://ubuntu-cloud.archive.canonical.com/ubuntu xenial-updates/pike main' already configured
2018-10-15 01:10:14,450 [salt.state       :1941][INFO    ][6449] Completed state [deb http://ubuntu-cloud.archive.canonical.com/ubuntu xenial-updates/pike main] at time 01:10:14.450828 duration_in_ms=58.958
2018-10-15 01:10:14,451 [salt.state       :1770][INFO    ][6449] Running state [pkg.refresh_db] at time 01:10:14.451781
2018-10-15 01:10:14,452 [salt.state       :1803][INFO    ][6449] Executing state module.run for [pkg.refresh_db]
2018-10-15 01:10:14,452 [salt.utils.decorators:613 ][WARNING ][6449] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2018-10-15 01:10:14,452 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6449] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2018-10-15 01:10:18,699 [salt.state       :290 ][INFO    ][6449] {'ret': {'http://apt.mirantis.com/xenial nightly InRelease': None, 'http://security.ubuntu.com/ubuntu xenial-security InRelease': None, 'http://ppa.launchpad.net/ubuntu-cloud-archive/pike-staging/ubuntu xenial InRelease': None, 'http://ubuntu-cloud.archive.canonical.com/ubuntu xenial-updates/pike Release': None, 'http://archive.ubuntu.com/ubuntu xenial-backports InRelease': None, 'http://archive.ubuntu.com/ubuntu xenial-updates InRelease': None, 'http://ubuntu-cloud.archive.canonical.com/ubuntu xenial-updates/pike InRelease': False, 'http://repo.saltstack.com/apt/ubuntu/16.04/amd64/2017.7 xenial InRelease': None, 'http://archive.ubuntu.com/ubuntu xenial InRelease': None, 'http://mirror.fuel-infra.org/mcp-repos/pike/xenial pike InRelease': None}}
2018-10-15 01:10:18,699 [salt.state       :1941][INFO    ][6449] Completed state [pkg.refresh_db] at time 01:10:18.699651 duration_in_ms=4247.869
2018-10-15 01:10:18,701 [salt.state       :1770][INFO    ][6449] Running state [UTC] at time 01:10:18.701046
2018-10-15 01:10:18,701 [salt.state       :1803][INFO    ][6449] Executing state timezone.system for [UTC]
2018-10-15 01:10:18,703 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6449] Executing command ['timedatectl'] in directory '/root'
2018-10-15 01:10:18,737 [salt.state       :290 ][INFO    ][6449] Timezone UTC already set, UTC already set to UTC
2018-10-15 01:10:18,738 [salt.state       :1941][INFO    ][6449] Completed state [UTC] at time 01:10:18.738475 duration_in_ms=37.427
2018-10-15 01:10:18,739 [salt.state       :1770][INFO    ][6449] Running state [/etc/default/grub.d] at time 01:10:18.739128
2018-10-15 01:10:18,739 [salt.state       :1803][INFO    ][6449] Executing state file.directory for [/etc/default/grub.d]
2018-10-15 01:10:18,741 [salt.state       :290 ][INFO    ][6449] Directory /etc/default/grub.d is in the correct state
Directory /etc/default/grub.d updated
2018-10-15 01:10:18,742 [salt.state       :1941][INFO    ][6449] Completed state [/etc/default/grub.d] at time 01:10:18.742598 duration_in_ms=3.468
2018-10-15 01:10:18,743 [salt.state       :1770][INFO    ][6449] Running state [update-grub] at time 01:10:18.743096
2018-10-15 01:10:18,743 [salt.state       :1803][INFO    ][6449] Executing state cmd.wait for [update-grub]
2018-10-15 01:10:18,744 [salt.state       :290 ][INFO    ][6449] No changes made for update-grub
2018-10-15 01:10:18,744 [salt.state       :1941][INFO    ][6449] Completed state [update-grub] at time 01:10:18.744751 duration_in_ms=1.655
2018-10-15 01:10:18,748 [salt.state       :1770][INFO    ][6449] Running state [/boot/grub/grub.cfg] at time 01:10:18.747699
2018-10-15 01:10:18,748 [salt.state       :1803][INFO    ][6449] Executing state file.managed for [/boot/grub/grub.cfg]
2018-10-15 01:10:18,846 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6449] Executing command ['git', '--version'] in directory '/root'
2018-10-15 01:10:19,022 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6449] Executing command 'test -f /boot/grub/grub.cfg' in directory '/root'
2018-10-15 01:10:19,037 [salt.loaded.int.states.file:2150][WARNING ][6449] State for file: /boot/grub/grub.cfg - 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-10-15 01:10:19,038 [salt.state       :290 ][INFO    ][6449] File /boot/grub/grub.cfg exists with proper permissions. No changes made.
2018-10-15 01:10:19,039 [salt.state       :1941][INFO    ][6449] Completed state [/boot/grub/grub.cfg] at time 01:10:19.039191 duration_in_ms=291.491
2018-10-15 01:10:19,039 [salt.state       :1770][INFO    ][6449] Running state [nf_conntrack] at time 01:10:19.039738
2018-10-15 01:10:19,040 [salt.state       :1803][INFO    ][6449] Executing state kmod.present for [nf_conntrack]
2018-10-15 01:10:19,041 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6449] Executing command 'lsmod' in directory '/root'
2018-10-15 01:10:19,058 [salt.state       :290 ][INFO    ][6449] Kernel module nf_conntrack is already present
2018-10-15 01:10:19,058 [salt.state       :1941][INFO    ][6449] Completed state [nf_conntrack] at time 01:10:19.058785 duration_in_ms=19.047
2018-10-15 01:10:19,059 [salt.state       :1770][INFO    ][6449] Running state [kernel.panic] at time 01:10:19.059285
2018-10-15 01:10:19,059 [salt.state       :1803][INFO    ][6449] Executing state sysctl.present for [kernel.panic]
2018-10-15 01:10:19,075 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6449] Executing command 'sysctl -n kernel.panic' in directory '/root'
2018-10-15 01:10:19,091 [salt.state       :290 ][INFO    ][6449] Sysctl value kernel.panic = 60 is already set
2018-10-15 01:10:19,092 [salt.state       :1941][INFO    ][6449] Completed state [kernel.panic] at time 01:10:19.092181 duration_in_ms=32.896
2018-10-15 01:10:19,092 [salt.state       :1770][INFO    ][6449] Running state [net.ipv4.tcp_keepalive_probes] at time 01:10:19.092754
2018-10-15 01:10:19,093 [salt.state       :1803][INFO    ][6449] Executing state sysctl.present for [net.ipv4.tcp_keepalive_probes]
2018-10-15 01:10:19,095 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6449] Executing command 'sysctl -n net.ipv4.tcp_keepalive_probes' in directory '/root'
2018-10-15 01:10:19,110 [salt.state       :290 ][INFO    ][6449] Sysctl value net.ipv4.tcp_keepalive_probes = 8 is already set
2018-10-15 01:10:19,110 [salt.state       :1941][INFO    ][6449] Completed state [net.ipv4.tcp_keepalive_probes] at time 01:10:19.110656 duration_in_ms=17.901
2018-10-15 01:10:19,111 [salt.state       :1770][INFO    ][6449] Running state [fs.file-max] at time 01:10:19.111186
2018-10-15 01:10:19,111 [salt.state       :1803][INFO    ][6449] Executing state sysctl.present for [fs.file-max]
2018-10-15 01:10:19,112 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6449] Executing command 'sysctl -n fs.file-max' in directory '/root'
2018-10-15 01:10:19,128 [salt.state       :290 ][INFO    ][6449] Sysctl value fs.file-max = 124165 is already set
2018-10-15 01:10:19,129 [salt.state       :1941][INFO    ][6449] Completed state [fs.file-max] at time 01:10:19.129348 duration_in_ms=18.162
2018-10-15 01:10:19,129 [salt.state       :1770][INFO    ][6449] Running state [net.core.somaxconn] at time 01:10:19.129689
2018-10-15 01:10:19,130 [salt.state       :1803][INFO    ][6449] Executing state sysctl.present for [net.core.somaxconn]
2018-10-15 01:10:19,131 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6449] Executing command 'sysctl -n net.core.somaxconn' in directory '/root'
2018-10-15 01:10:19,147 [salt.state       :290 ][INFO    ][6449] Sysctl value net.core.somaxconn = 4096 is already set
2018-10-15 01:10:19,147 [salt.state       :1941][INFO    ][6449] Completed state [net.core.somaxconn] at time 01:10:19.147664 duration_in_ms=17.976
2018-10-15 01:10:19,148 [salt.state       :1770][INFO    ][6449] Running state [net.ipv4.tcp_max_syn_backlog] at time 01:10:19.148006
2018-10-15 01:10:19,148 [salt.state       :1803][INFO    ][6449] Executing state sysctl.present for [net.ipv4.tcp_max_syn_backlog]
2018-10-15 01:10:19,149 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6449] Executing command 'sysctl -n net.ipv4.tcp_max_syn_backlog' in directory '/root'
2018-10-15 01:10:19,164 [salt.state       :290 ][INFO    ][6449] Sysctl value net.ipv4.tcp_max_syn_backlog = 8192 is already set
2018-10-15 01:10:19,165 [salt.state       :1941][INFO    ][6449] Completed state [net.ipv4.tcp_max_syn_backlog] at time 01:10:19.165240 duration_in_ms=17.233
2018-10-15 01:10:19,165 [salt.state       :1770][INFO    ][6449] Running state [net.ipv4.tcp_tw_reuse] at time 01:10:19.165743
2018-10-15 01:10:19,167 [salt.state       :1803][INFO    ][6449] Executing state sysctl.present for [net.ipv4.tcp_tw_reuse]
2018-10-15 01:10:19,168 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6449] Executing command 'sysctl -n net.ipv4.tcp_tw_reuse' in directory '/root'
2018-10-15 01:10:19,184 [salt.state       :290 ][INFO    ][6449] Sysctl value net.ipv4.tcp_tw_reuse = 1 is already set
2018-10-15 01:10:19,185 [salt.state       :1941][INFO    ][6449] Completed state [net.ipv4.tcp_tw_reuse] at time 01:10:19.185247 duration_in_ms=19.504
2018-10-15 01:10:19,185 [salt.state       :1770][INFO    ][6449] Running state [net.ipv4.tcp_congestion_control] at time 01:10:19.185760
2018-10-15 01:10:19,186 [salt.state       :1803][INFO    ][6449] Executing state sysctl.present for [net.ipv4.tcp_congestion_control]
2018-10-15 01:10:19,187 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6449] Executing command 'sysctl -n net.ipv4.tcp_congestion_control' in directory '/root'
2018-10-15 01:10:19,202 [salt.state       :290 ][INFO    ][6449] Sysctl value net.ipv4.tcp_congestion_control = yeah is already set
2018-10-15 01:10:19,203 [salt.state       :1941][INFO    ][6449] Completed state [net.ipv4.tcp_congestion_control] at time 01:10:19.203333 duration_in_ms=17.572
2018-10-15 01:10:19,203 [salt.state       :1770][INFO    ][6449] Running state [net.ipv4.tcp_retries2] at time 01:10:19.203868
2018-10-15 01:10:19,204 [salt.state       :1803][INFO    ][6449] Executing state sysctl.present for [net.ipv4.tcp_retries2]
2018-10-15 01:10:19,205 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6449] Executing command 'sysctl -n net.ipv4.tcp_retries2' in directory '/root'
2018-10-15 01:10:19,222 [salt.state       :290 ][INFO    ][6449] Sysctl value net.ipv4.tcp_retries2 = 5 is already set
2018-10-15 01:10:19,223 [salt.state       :1941][INFO    ][6449] Completed state [net.ipv4.tcp_retries2] at time 01:10:19.223377 duration_in_ms=19.509
2018-10-15 01:10:19,223 [salt.state       :1770][INFO    ][6449] Running state [net.core.netdev_max_backlog] at time 01:10:19.223911
2018-10-15 01:10:19,224 [salt.state       :1803][INFO    ][6449] Executing state sysctl.present for [net.core.netdev_max_backlog]
2018-10-15 01:10:19,225 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6449] Executing command 'sysctl -n net.core.netdev_max_backlog' in directory '/root'
2018-10-15 01:10:19,243 [salt.state       :290 ][INFO    ][6449] Sysctl value net.core.netdev_max_backlog = 261144 is already set
2018-10-15 01:10:19,243 [salt.state       :1941][INFO    ][6449] Completed state [net.core.netdev_max_backlog] at time 01:10:19.243566 duration_in_ms=19.655
2018-10-15 01:10:19,244 [salt.state       :1770][INFO    ][6449] Running state [net.ipv4.tcp_slow_start_after_idle] at time 01:10:19.244116
2018-10-15 01:10:19,244 [salt.state       :1803][INFO    ][6449] Executing state sysctl.present for [net.ipv4.tcp_slow_start_after_idle]
2018-10-15 01:10:19,245 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6449] Executing command 'sysctl -n net.ipv4.tcp_slow_start_after_idle' in directory '/root'
2018-10-15 01:10:19,261 [salt.state       :290 ][INFO    ][6449] Sysctl value net.ipv4.tcp_slow_start_after_idle = 0 is already set
2018-10-15 01:10:19,262 [salt.state       :1941][INFO    ][6449] Completed state [net.ipv4.tcp_slow_start_after_idle] at time 01:10:19.262845 duration_in_ms=18.728
2018-10-15 01:10:19,263 [salt.state       :1770][INFO    ][6449] Running state [vm.swappiness] at time 01:10:19.263382
2018-10-15 01:10:19,263 [salt.state       :1803][INFO    ][6449] Executing state sysctl.present for [vm.swappiness]
2018-10-15 01:10:19,265 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6449] Executing command 'sysctl -n vm.swappiness' in directory '/root'
2018-10-15 01:10:19,281 [salt.state       :290 ][INFO    ][6449] Sysctl value vm.swappiness = 10 is already set
2018-10-15 01:10:19,281 [salt.state       :1941][INFO    ][6449] Completed state [vm.swappiness] at time 01:10:19.281808 duration_in_ms=18.425
2018-10-15 01:10:19,282 [salt.state       :1770][INFO    ][6449] Running state [net.ipv4.tcp_keepalive_intvl] at time 01:10:19.282360
2018-10-15 01:10:19,282 [salt.state       :1803][INFO    ][6449] Executing state sysctl.present for [net.ipv4.tcp_keepalive_intvl]
2018-10-15 01:10:19,283 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6449] Executing command 'sysctl -n net.ipv4.tcp_keepalive_intvl' in directory '/root'
2018-10-15 01:10:19,299 [salt.state       :290 ][INFO    ][6449] Sysctl value net.ipv4.tcp_keepalive_intvl = 3 is already set
2018-10-15 01:10:19,300 [salt.state       :1941][INFO    ][6449] Completed state [net.ipv4.tcp_keepalive_intvl] at time 01:10:19.300082 duration_in_ms=17.721
2018-10-15 01:10:19,300 [salt.state       :1770][INFO    ][6449] Running state [net.ipv4.neigh.default.gc_thresh1] at time 01:10:19.300636
2018-10-15 01:10:19,301 [salt.state       :1803][INFO    ][6449] Executing state sysctl.present for [net.ipv4.neigh.default.gc_thresh1]
2018-10-15 01:10:19,302 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6449] Executing command 'sysctl -n net.ipv4.neigh.default.gc_thresh1' in directory '/root'
2018-10-15 01:10:19,319 [salt.state       :290 ][INFO    ][6449] Sysctl value net.ipv4.neigh.default.gc_thresh1 = 4096 is already set
2018-10-15 01:10:19,319 [salt.state       :1941][INFO    ][6449] Completed state [net.ipv4.neigh.default.gc_thresh1] at time 01:10:19.319799 duration_in_ms=19.161
2018-10-15 01:10:19,320 [salt.state       :1770][INFO    ][6449] Running state [net.ipv4.neigh.default.gc_thresh2] at time 01:10:19.320788
2018-10-15 01:10:19,321 [salt.state       :1803][INFO    ][6449] Executing state sysctl.present for [net.ipv4.neigh.default.gc_thresh2]
2018-10-15 01:10:19,323 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6449] Executing command 'sysctl -n net.ipv4.neigh.default.gc_thresh2' in directory '/root'
2018-10-15 01:10:19,339 [salt.state       :290 ][INFO    ][6449] Sysctl value net.ipv4.neigh.default.gc_thresh2 = 8192 is already set
2018-10-15 01:10:19,339 [salt.state       :1941][INFO    ][6449] Completed state [net.ipv4.neigh.default.gc_thresh2] at time 01:10:19.339677 duration_in_ms=18.888
2018-10-15 01:10:19,340 [salt.state       :1770][INFO    ][6449] Running state [net.ipv4.neigh.default.gc_thresh3] at time 01:10:19.340196
2018-10-15 01:10:19,340 [salt.state       :1803][INFO    ][6449] Executing state sysctl.present for [net.ipv4.neigh.default.gc_thresh3]
2018-10-15 01:10:19,342 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6449] Executing command 'sysctl -n net.ipv4.neigh.default.gc_thresh3' in directory '/root'
2018-10-15 01:10:19,361 [salt.state       :290 ][INFO    ][6449] Sysctl value net.ipv4.neigh.default.gc_thresh3 = 16384 is already set
2018-10-15 01:10:19,362 [salt.state       :1941][INFO    ][6449] Completed state [net.ipv4.neigh.default.gc_thresh3] at time 01:10:19.361680 duration_in_ms=21.483
2018-10-15 01:10:19,362 [salt.state       :1770][INFO    ][6449] Running state [net.ipv4.tcp_fin_timeout] at time 01:10:19.362844
2018-10-15 01:10:19,363 [salt.state       :1803][INFO    ][6449] Executing state sysctl.present for [net.ipv4.tcp_fin_timeout]
2018-10-15 01:10:19,365 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6449] Executing command 'sysctl -n net.ipv4.tcp_fin_timeout' in directory '/root'
2018-10-15 01:10:19,381 [salt.state       :290 ][INFO    ][6449] Sysctl value net.ipv4.tcp_fin_timeout = 30 is already set
2018-10-15 01:10:19,382 [salt.state       :1941][INFO    ][6449] Completed state [net.ipv4.tcp_fin_timeout] at time 01:10:19.381982 duration_in_ms=19.139
2018-10-15 01:10:19,382 [salt.state       :1770][INFO    ][6449] Running state [net.ipv4.tcp_keepalive_time] at time 01:10:19.382374
2018-10-15 01:10:19,382 [salt.state       :1803][INFO    ][6449] Executing state sysctl.present for [net.ipv4.tcp_keepalive_time]
2018-10-15 01:10:19,383 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6449] Executing command 'sysctl -n net.ipv4.tcp_keepalive_time' in directory '/root'
2018-10-15 01:10:19,400 [salt.state       :290 ][INFO    ][6449] Sysctl value net.ipv4.tcp_keepalive_time = 30 is already set
2018-10-15 01:10:19,401 [salt.state       :1941][INFO    ][6449] Completed state [net.ipv4.tcp_keepalive_time] at time 01:10:19.401049 duration_in_ms=18.673
2018-10-15 01:10:19,402 [salt.state       :1770][INFO    ][6449] Running state [net.nf_conntrack_max] at time 01:10:19.401899
2018-10-15 01:10:19,402 [salt.state       :1803][INFO    ][6449] Executing state sysctl.present for [net.nf_conntrack_max]
2018-10-15 01:10:19,405 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6449] Executing command 'sysctl -n net.nf_conntrack_max' in directory '/root'
2018-10-15 01:10:19,421 [salt.state       :290 ][INFO    ][6449] Sysctl value net.nf_conntrack_max = 1048576 is already set
2018-10-15 01:10:19,422 [salt.state       :1941][INFO    ][6449] Completed state [net.nf_conntrack_max] at time 01:10:19.422236 duration_in_ms=20.336
2018-10-15 01:10:19,422 [salt.state       :1770][INFO    ][6449] Running state [linux_sysfs_package] at time 01:10:19.422889
2018-10-15 01:10:19,423 [salt.state       :1803][INFO    ][6449] Executing state pkg.installed for [linux_sysfs_package]
2018-10-15 01:10:19,440 [salt.state       :290 ][INFO    ][6449] All specified packages are already installed
2018-10-15 01:10:19,441 [salt.state       :1941][INFO    ][6449] Completed state [linux_sysfs_package] at time 01:10:19.441093 duration_in_ms=18.205
2018-10-15 01:10:19,442 [salt.state       :1770][INFO    ][6449] Running state [/etc/sysfs.d] at time 01:10:19.442756
2018-10-15 01:10:19,443 [salt.state       :1803][INFO    ][6449] Executing state file.directory for [/etc/sysfs.d]
2018-10-15 01:10:19,443 [salt.state       :290 ][INFO    ][6449] Directory /etc/sysfs.d is in the correct state
Directory /etc/sysfs.d updated
2018-10-15 01:10:19,443 [salt.state       :1941][INFO    ][6449] Completed state [/etc/sysfs.d] at time 01:10:19.443763 duration_in_ms=1.007
2018-10-15 01:10:19,443 [salt.state       :1770][INFO    ][6449] Running state [ondemand] at time 01:10:19.443960
2018-10-15 01:10:19,444 [salt.state       :1803][INFO    ][6449] Executing state service.dead for [ondemand]
2018-10-15 01:10:19,444 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6449] Executing command ['systemctl', 'status', 'ondemand.service', '-n', '0'] in directory '/root'
2018-10-15 01:10:19,465 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6449] Executing command ['systemctl', 'is-active', 'ondemand.service'] in directory '/root'
2018-10-15 01:10:19,481 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6449] Executing command ['systemctl', 'is-enabled', 'ondemand.service'] in directory '/root'
2018-10-15 01:10:19,503 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6449] Executing command 'runlevel' in directory '/root'
2018-10-15 01:10:19,517 [salt.state       :290 ][INFO    ][6449] The service ondemand is already dead
2018-10-15 01:10:19,517 [salt.state       :1941][INFO    ][6449] Completed state [ondemand] at time 01:10:19.517500 duration_in_ms=73.539
2018-10-15 01:10:19,517 [salt.state       :1770][INFO    ][6449] Running state [cs_CZ.UTF-8] at time 01:10:19.517879
2018-10-15 01:10:19,518 [salt.state       :1803][INFO    ][6449] Executing state locale.present for [cs_CZ.UTF-8]
2018-10-15 01:10:19,519 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6449] Executing command 'locale -a' in directory '/root'
2018-10-15 01:10:19,530 [salt.state       :290 ][INFO    ][6449] Locale cs_CZ.UTF-8 is already present
2018-10-15 01:10:19,531 [salt.state       :1941][INFO    ][6449] Completed state [cs_CZ.UTF-8] at time 01:10:19.531072 duration_in_ms=13.193
2018-10-15 01:10:19,531 [salt.state       :1770][INFO    ][6449] Running state [en_US.UTF-8] at time 01:10:19.531414
2018-10-15 01:10:19,531 [salt.state       :1803][INFO    ][6449] Executing state locale.present for [en_US.UTF-8]
2018-10-15 01:10:19,533 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6449] Executing command 'locale -a' in directory '/root'
2018-10-15 01:10:19,543 [salt.state       :290 ][INFO    ][6449] Locale en_US.UTF-8 is already present
2018-10-15 01:10:19,543 [salt.state       :1941][INFO    ][6449] Completed state [en_US.UTF-8] at time 01:10:19.543791 duration_in_ms=12.377
2018-10-15 01:10:19,545 [salt.state       :1770][INFO    ][6449] Running state [en_US.UTF-8] at time 01:10:19.545609
2018-10-15 01:10:19,545 [salt.state       :1803][INFO    ][6449] Executing state locale.system for [en_US.UTF-8]
2018-10-15 01:10:19,546 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6449] Executing command 'localectl' in directory '/root'
2018-10-15 01:10:19,576 [salt.state       :290 ][INFO    ][6449] System locale en_US.UTF-8 already set
2018-10-15 01:10:19,577 [salt.state       :1941][INFO    ][6449] Completed state [en_US.UTF-8] at time 01:10:19.577292 duration_in_ms=31.681
2018-10-15 01:10:19,577 [salt.state       :1770][INFO    ][6449] Running state [root] at time 01:10:19.577674
2018-10-15 01:10:19,577 [salt.state       :1803][INFO    ][6449] Executing state group.present for [root]
2018-10-15 01:10:19,578 [salt.state       :290 ][INFO    ][6449] Group root is present and up to date
2018-10-15 01:10:19,578 [salt.state       :1941][INFO    ][6449] Completed state [root] at time 01:10:19.578689 duration_in_ms=1.015
2018-10-15 01:10:19,581 [salt.state       :1770][INFO    ][6449] Running state [root] at time 01:10:19.581186
2018-10-15 01:10:19,581 [salt.state       :1803][INFO    ][6449] Executing state user.present for [root]
2018-10-15 01:10:19,583 [salt.state       :290 ][INFO    ][6449] User root is present and up to date
2018-10-15 01:10:19,583 [salt.state       :1941][INFO    ][6449] Completed state [root] at time 01:10:19.583515 duration_in_ms=2.329
2018-10-15 01:10:19,584 [salt.state       :1770][INFO    ][6449] Running state [/root] at time 01:10:19.584630
2018-10-15 01:10:19,584 [salt.state       :1803][INFO    ][6449] Executing state file.directory for [/root]
2018-10-15 01:10:19,585 [salt.state       :290 ][INFO    ][6449] Directory /root is in the correct state
Directory /root updated
2018-10-15 01:10:19,585 [salt.state       :1941][INFO    ][6449] Completed state [/root] at time 01:10:19.585824 duration_in_ms=1.193
2018-10-15 01:10:19,586 [salt.state       :1770][INFO    ][6449] Running state [/etc/sudoers.d/90-salt-user-root] at time 01:10:19.586031
2018-10-15 01:10:19,586 [salt.state       :1803][INFO    ][6449] Executing state file.absent for [/etc/sudoers.d/90-salt-user-root]
2018-10-15 01:10:19,586 [salt.state       :290 ][INFO    ][6449] File /etc/sudoers.d/90-salt-user-root is not present
2018-10-15 01:10:19,586 [salt.state       :1941][INFO    ][6449] Completed state [/etc/sudoers.d/90-salt-user-root] at time 01:10:19.586668 duration_in_ms=0.637
2018-10-15 01:10:19,586 [salt.state       :1770][INFO    ][6449] Running state [ubuntu] at time 01:10:19.586865
2018-10-15 01:10:19,587 [salt.state       :1803][INFO    ][6449] Executing state group.present for [ubuntu]
2018-10-15 01:10:19,587 [salt.state       :290 ][INFO    ][6449] Group ubuntu is present and up to date
2018-10-15 01:10:19,587 [salt.state       :1941][INFO    ][6449] Completed state [ubuntu] at time 01:10:19.587510 duration_in_ms=0.645
2018-10-15 01:10:19,589 [salt.state       :1770][INFO    ][6449] Running state [ubuntu] at time 01:10:19.589617
2018-10-15 01:10:19,589 [salt.state       :1803][INFO    ][6449] Executing state user.present for [ubuntu]
2018-10-15 01:10:19,590 [salt.state       :290 ][INFO    ][6449] User ubuntu is present and up to date
2018-10-15 01:10:19,591 [salt.state       :1941][INFO    ][6449] Completed state [ubuntu] at time 01:10:19.590974 duration_in_ms=1.358
2018-10-15 01:10:19,592 [salt.state       :1770][INFO    ][6449] Running state [/home/ubuntu] at time 01:10:19.591970
2018-10-15 01:10:19,592 [salt.state       :1803][INFO    ][6449] Executing state file.directory for [/home/ubuntu]
2018-10-15 01:10:19,592 [salt.state       :290 ][INFO    ][6449] Directory /home/ubuntu is in the correct state
Directory /home/ubuntu updated
2018-10-15 01:10:19,593 [salt.state       :1941][INFO    ][6449] Completed state [/home/ubuntu] at time 01:10:19.593126 duration_in_ms=1.156
2018-10-15 01:10:19,594 [salt.state       :1770][INFO    ][6449] Running state [/etc/sudoers.d/90-salt-user-ubuntu] at time 01:10:19.594365
2018-10-15 01:10:19,594 [salt.state       :1803][INFO    ][6449] Executing state file.managed for [/etc/sudoers.d/90-salt-user-ubuntu]
2018-10-15 01:10:19,623 [salt.state       :290 ][INFO    ][6449] File /etc/sudoers.d/90-salt-user-ubuntu is in the correct state
2018-10-15 01:10:19,623 [salt.state       :1941][INFO    ][6449] Completed state [/etc/sudoers.d/90-salt-user-ubuntu] at time 01:10:19.623616 duration_in_ms=29.251
2018-10-15 01:10:19,623 [salt.state       :1770][INFO    ][6449] Running state [/etc/security/limits.d/90-salt-default.conf] at time 01:10:19.623845
2018-10-15 01:10:19,624 [salt.state       :1803][INFO    ][6449] Executing state file.managed for [/etc/security/limits.d/90-salt-default.conf]
2018-10-15 01:10:19,747 [salt.state       :290 ][INFO    ][6449] File /etc/security/limits.d/90-salt-default.conf is in the correct state
2018-10-15 01:10:19,747 [salt.state       :1941][INFO    ][6449] Completed state [/etc/security/limits.d/90-salt-default.conf] at time 01:10:19.747339 duration_in_ms=123.493
2018-10-15 01:10:19,747 [salt.state       :1770][INFO    ][6449] Running state [/etc/systemd/system.conf.d/90-salt.conf] at time 01:10:19.747579
2018-10-15 01:10:19,747 [salt.state       :1803][INFO    ][6449] Executing state file.managed for [/etc/systemd/system.conf.d/90-salt.conf]
2018-10-15 01:10:19,877 [salt.state       :290 ][INFO    ][6449] File /etc/systemd/system.conf.d/90-salt.conf is in the correct state
2018-10-15 01:10:19,878 [salt.state       :1941][INFO    ][6449] Completed state [/etc/systemd/system.conf.d/90-salt.conf] at time 01:10:19.878215 duration_in_ms=130.635
2018-10-15 01:10:19,879 [salt.state       :1770][INFO    ][6449] Running state [service.systemctl_reload] at time 01:10:19.879292
2018-10-15 01:10:19,879 [salt.state       :1803][INFO    ][6449] Executing state module.wait for [service.systemctl_reload]
2018-10-15 01:10:19,879 [salt.state       :290 ][INFO    ][6449] No changes made for service.systemctl_reload
2018-10-15 01:10:19,879 [salt.state       :1941][INFO    ][6449] Completed state [service.systemctl_reload] at time 01:10:19.879960 duration_in_ms=0.668
2018-10-15 01:10:19,880 [salt.state       :1770][INFO    ][6449] Running state [/etc/issue] at time 01:10:19.880162
2018-10-15 01:10:19,880 [salt.state       :1803][INFO    ][6449] Executing state file.managed for [/etc/issue]
2018-10-15 01:10:19,882 [salt.state       :290 ][INFO    ][6449] File /etc/issue is in the correct state
2018-10-15 01:10:19,883 [salt.state       :1941][INFO    ][6449] Completed state [/etc/issue] at time 01:10:19.883145 duration_in_ms=2.983
2018-10-15 01:10:19,883 [salt.state       :1770][INFO    ][6449] Running state [/etc/hostname] at time 01:10:19.883353
2018-10-15 01:10:19,883 [salt.state       :1803][INFO    ][6449] Executing state file.managed for [/etc/hostname]
2018-10-15 01:10:19,906 [salt.state       :290 ][INFO    ][6449] File /etc/hostname is in the correct state
2018-10-15 01:10:19,906 [salt.state       :1941][INFO    ][6449] Completed state [/etc/hostname] at time 01:10:19.906916 duration_in_ms=23.564
2018-10-15 01:10:19,907 [salt.state       :1770][INFO    ][6449] Running state [hostname msg02] at time 01:10:19.907895
2018-10-15 01:10:19,908 [salt.state       :1803][INFO    ][6449] Executing state cmd.run for [hostname msg02]
2018-10-15 01:10:19,908 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6449] Executing command 'test "$(hostname)" = "msg02"' in directory '/root'
2018-10-15 01:10:19,923 [salt.state       :290 ][INFO    ][6449] unless execution succeeded
2018-10-15 01:10:19,923 [salt.state       :1941][INFO    ][6449] Completed state [hostname msg02] at time 01:10:19.923644 duration_in_ms=15.748
2018-10-15 01:10:19,924 [salt.state       :1770][INFO    ][6449] Running state [mdb02] at time 01:10:19.924833
2018-10-15 01:10:19,925 [salt.state       :1803][INFO    ][6449] Executing state host.present for [mdb02]
2018-10-15 01:10:19,926 [salt.state       :290 ][INFO    ][6449] Host mdb02 (192.168.10.33) already present
2018-10-15 01:10:19,926 [salt.state       :1941][INFO    ][6449] Completed state [mdb02] at time 01:10:19.926581 duration_in_ms=1.747
2018-10-15 01:10:19,926 [salt.state       :1770][INFO    ][6449] Running state [mdb02.mcp-pike-ovs-ha.local] at time 01:10:19.926853
2018-10-15 01:10:19,927 [salt.state       :1803][INFO    ][6449] Executing state host.present for [mdb02.mcp-pike-ovs-ha.local]
2018-10-15 01:10:19,927 [salt.state       :290 ][INFO    ][6449] Host mdb02.mcp-pike-ovs-ha.local (192.168.10.33) already present
2018-10-15 01:10:19,927 [salt.state       :1941][INFO    ][6449] Completed state [mdb02.mcp-pike-ovs-ha.local] at time 01:10:19.927725 duration_in_ms=0.872
2018-10-15 01:10:19,928 [salt.state       :1770][INFO    ][6449] Running state [mdb03] at time 01:10:19.927996
2018-10-15 01:10:19,928 [salt.state       :1803][INFO    ][6449] Executing state host.present for [mdb03]
2018-10-15 01:10:19,928 [salt.state       :290 ][INFO    ][6449] Host mdb03 (192.168.10.34) already present
2018-10-15 01:10:19,929 [salt.state       :1941][INFO    ][6449] Completed state [mdb03] at time 01:10:19.929018 duration_in_ms=1.023
2018-10-15 01:10:19,929 [salt.state       :1770][INFO    ][6449] Running state [mdb03.mcp-pike-ovs-ha.local] at time 01:10:19.929335
2018-10-15 01:10:19,929 [salt.state       :1803][INFO    ][6449] Executing state host.present for [mdb03.mcp-pike-ovs-ha.local]
2018-10-15 01:10:19,930 [salt.state       :290 ][INFO    ][6449] Host mdb03.mcp-pike-ovs-ha.local (192.168.10.34) already present
2018-10-15 01:10:19,930 [salt.state       :1941][INFO    ][6449] Completed state [mdb03.mcp-pike-ovs-ha.local] at time 01:10:19.930694 duration_in_ms=1.359
2018-10-15 01:10:19,931 [salt.state       :1770][INFO    ][6449] Running state [mdb01] at time 01:10:19.931019
2018-10-15 01:10:19,931 [salt.state       :1803][INFO    ][6449] Executing state host.present for [mdb01]
2018-10-15 01:10:19,932 [salt.state       :290 ][INFO    ][6449] Host mdb01 (192.168.10.32) already present
2018-10-15 01:10:19,932 [salt.state       :1941][INFO    ][6449] Completed state [mdb01] at time 01:10:19.932619 duration_in_ms=1.6
2018-10-15 01:10:19,933 [salt.state       :1770][INFO    ][6449] Running state [mdb01.mcp-pike-ovs-ha.local] at time 01:10:19.932951
2018-10-15 01:10:19,933 [salt.state       :1803][INFO    ][6449] Executing state host.present for [mdb01.mcp-pike-ovs-ha.local]
2018-10-15 01:10:19,934 [salt.state       :290 ][INFO    ][6449] Host mdb01.mcp-pike-ovs-ha.local (192.168.10.32) already present
2018-10-15 01:10:19,934 [salt.state       :1941][INFO    ][6449] Completed state [mdb01.mcp-pike-ovs-ha.local] at time 01:10:19.934453 duration_in_ms=1.504
2018-10-15 01:10:19,934 [salt.state       :1770][INFO    ][6449] Running state [mdb] at time 01:10:19.934730
2018-10-15 01:10:19,934 [salt.state       :1803][INFO    ][6449] Executing state host.present for [mdb]
2018-10-15 01:10:19,935 [salt.state       :290 ][INFO    ][6449] Host mdb (192.168.10.31) already present
2018-10-15 01:10:19,935 [salt.state       :1941][INFO    ][6449] Completed state [mdb] at time 01:10:19.935511 duration_in_ms=0.782
2018-10-15 01:10:19,935 [salt.state       :1770][INFO    ][6449] Running state [mdb.mcp-pike-ovs-ha.local] at time 01:10:19.935763
2018-10-15 01:10:19,936 [salt.state       :1803][INFO    ][6449] Executing state host.present for [mdb.mcp-pike-ovs-ha.local]
2018-10-15 01:10:19,937 [salt.state       :290 ][INFO    ][6449] Host mdb.mcp-pike-ovs-ha.local (192.168.10.31) already present
2018-10-15 01:10:19,937 [salt.state       :1941][INFO    ][6449] Completed state [mdb.mcp-pike-ovs-ha.local] at time 01:10:19.937222 duration_in_ms=1.458
2018-10-15 01:10:19,937 [salt.state       :1770][INFO    ][6449] Running state [cfg01] at time 01:10:19.937474
2018-10-15 01:10:19,937 [salt.state       :1803][INFO    ][6449] Executing state host.present for [cfg01]
2018-10-15 01:10:19,939 [salt.state       :290 ][INFO    ][6449] Host cfg01 (192.168.10.11) already present
2018-10-15 01:10:19,940 [salt.state       :1941][INFO    ][6449] Completed state [cfg01] at time 01:10:19.940153 duration_in_ms=2.679
2018-10-15 01:10:19,940 [salt.state       :1770][INFO    ][6449] Running state [cfg01.mcp-pike-ovs-ha.local] at time 01:10:19.940792
2018-10-15 01:10:19,941 [salt.state       :1803][INFO    ][6449] Executing state host.present for [cfg01.mcp-pike-ovs-ha.local]
2018-10-15 01:10:19,941 [salt.state       :290 ][INFO    ][6449] Host cfg01.mcp-pike-ovs-ha.local (192.168.10.11) already present
2018-10-15 01:10:19,942 [salt.state       :1941][INFO    ][6449] Completed state [cfg01.mcp-pike-ovs-ha.local] at time 01:10:19.942310 duration_in_ms=1.518
2018-10-15 01:10:19,942 [salt.state       :1770][INFO    ][6449] Running state [prx01] at time 01:10:19.942600
2018-10-15 01:10:19,942 [salt.state       :1803][INFO    ][6449] Executing state host.present for [prx01]
2018-10-15 01:10:19,943 [salt.state       :290 ][INFO    ][6449] Host prx01 (192.168.10.14) already present
2018-10-15 01:10:19,943 [salt.state       :1941][INFO    ][6449] Completed state [prx01] at time 01:10:19.943356 duration_in_ms=0.756
2018-10-15 01:10:19,943 [salt.state       :1770][INFO    ][6449] Running state [prx01.mcp-pike-ovs-ha.local] at time 01:10:19.943609
2018-10-15 01:10:19,943 [salt.state       :1803][INFO    ][6449] Executing state host.present for [prx01.mcp-pike-ovs-ha.local]
2018-10-15 01:10:19,945 [salt.state       :290 ][INFO    ][6449] Host prx01.mcp-pike-ovs-ha.local (192.168.10.14) already present
2018-10-15 01:10:19,945 [salt.state       :1941][INFO    ][6449] Completed state [prx01.mcp-pike-ovs-ha.local] at time 01:10:19.945336 duration_in_ms=1.726
2018-10-15 01:10:19,945 [salt.state       :1770][INFO    ][6449] Running state [kvm01] at time 01:10:19.945587
2018-10-15 01:10:19,945 [salt.state       :1803][INFO    ][6449] Executing state host.present for [kvm01]
2018-10-15 01:10:19,946 [salt.state       :290 ][INFO    ][6449] Host kvm01 (192.168.10.20) already present
2018-10-15 01:10:19,946 [salt.state       :1941][INFO    ][6449] Completed state [kvm01] at time 01:10:19.946369 duration_in_ms=0.781
2018-10-15 01:10:19,946 [salt.state       :1770][INFO    ][6449] Running state [kvm01.mcp-pike-ovs-ha.local] at time 01:10:19.946623
2018-10-15 01:10:19,946 [salt.state       :1803][INFO    ][6449] Executing state host.present for [kvm01.mcp-pike-ovs-ha.local]
2018-10-15 01:10:19,947 [salt.state       :290 ][INFO    ][6449] Host kvm01.mcp-pike-ovs-ha.local (192.168.10.20) already present
2018-10-15 01:10:19,947 [salt.state       :1941][INFO    ][6449] Completed state [kvm01.mcp-pike-ovs-ha.local] at time 01:10:19.947415 duration_in_ms=0.792
2018-10-15 01:10:19,947 [salt.state       :1770][INFO    ][6449] Running state [kvm03] at time 01:10:19.947673
2018-10-15 01:10:19,947 [salt.state       :1803][INFO    ][6449] Executing state host.present for [kvm03]
2018-10-15 01:10:19,948 [salt.state       :290 ][INFO    ][6449] Host kvm03 (192.168.10.22) already present
2018-10-15 01:10:19,948 [salt.state       :1941][INFO    ][6449] Completed state [kvm03] at time 01:10:19.948531 duration_in_ms=0.858
2018-10-15 01:10:19,948 [salt.state       :1770][INFO    ][6449] Running state [kvm03.mcp-pike-ovs-ha.local] at time 01:10:19.948815
2018-10-15 01:10:19,949 [salt.state       :1803][INFO    ][6449] Executing state host.present for [kvm03.mcp-pike-ovs-ha.local]
2018-10-15 01:10:19,949 [salt.state       :290 ][INFO    ][6449] Host kvm03.mcp-pike-ovs-ha.local (192.168.10.22) already present
2018-10-15 01:10:19,949 [salt.state       :1941][INFO    ][6449] Completed state [kvm03.mcp-pike-ovs-ha.local] at time 01:10:19.949586 duration_in_ms=0.771
2018-10-15 01:10:19,949 [salt.state       :1770][INFO    ][6449] Running state [kvm02] at time 01:10:19.949852
2018-10-15 01:10:19,950 [salt.state       :1803][INFO    ][6449] Executing state host.present for [kvm02]
2018-10-15 01:10:19,950 [salt.state       :290 ][INFO    ][6449] Host kvm02 (192.168.10.21) already present
2018-10-15 01:10:19,951 [salt.state       :1941][INFO    ][6449] Completed state [kvm02] at time 01:10:19.951007 duration_in_ms=1.155
2018-10-15 01:10:19,951 [salt.state       :1770][INFO    ][6449] Running state [kvm02.mcp-pike-ovs-ha.local] at time 01:10:19.951266
2018-10-15 01:10:19,951 [salt.state       :1803][INFO    ][6449] Executing state host.present for [kvm02.mcp-pike-ovs-ha.local]
2018-10-15 01:10:19,952 [salt.state       :290 ][INFO    ][6449] Host kvm02.mcp-pike-ovs-ha.local (192.168.10.21) already present
2018-10-15 01:10:19,953 [salt.state       :1941][INFO    ][6449] Completed state [kvm02.mcp-pike-ovs-ha.local] at time 01:10:19.953228 duration_in_ms=1.962
2018-10-15 01:10:19,953 [salt.state       :1770][INFO    ][6449] Running state [dbs] at time 01:10:19.953516
2018-10-15 01:10:19,953 [salt.state       :1803][INFO    ][6449] Executing state host.present for [dbs]
2018-10-15 01:10:19,954 [salt.state       :290 ][INFO    ][6449] Host dbs (192.168.10.23) already present
2018-10-15 01:10:19,954 [salt.state       :1941][INFO    ][6449] Completed state [dbs] at time 01:10:19.954687 duration_in_ms=1.172
2018-10-15 01:10:19,954 [salt.state       :1770][INFO    ][6449] Running state [dbs.mcp-pike-ovs-ha.local] at time 01:10:19.954949
2018-10-15 01:10:19,955 [salt.state       :1803][INFO    ][6449] Executing state host.present for [dbs.mcp-pike-ovs-ha.local]
2018-10-15 01:10:19,955 [salt.state       :290 ][INFO    ][6449] Host dbs.mcp-pike-ovs-ha.local (192.168.10.23) already present
2018-10-15 01:10:19,955 [salt.state       :1941][INFO    ][6449] Completed state [dbs.mcp-pike-ovs-ha.local] at time 01:10:19.955725 duration_in_ms=0.776
2018-10-15 01:10:19,956 [salt.state       :1770][INFO    ][6449] Running state [prx] at time 01:10:19.956349
2018-10-15 01:10:19,956 [salt.state       :1803][INFO    ][6449] Executing state host.present for [prx]
2018-10-15 01:10:19,957 [salt.state       :290 ][INFO    ][6449] Host prx (192.168.10.13) already present
2018-10-15 01:10:19,957 [salt.state       :1941][INFO    ][6449] Completed state [prx] at time 01:10:19.957174 duration_in_ms=0.825
2018-10-15 01:10:19,957 [salt.state       :1770][INFO    ][6449] Running state [prx.mcp-pike-ovs-ha.local] at time 01:10:19.957438
2018-10-15 01:10:19,957 [salt.state       :1803][INFO    ][6449] Executing state host.present for [prx.mcp-pike-ovs-ha.local]
2018-10-15 01:10:19,958 [salt.state       :290 ][INFO    ][6449] Host prx.mcp-pike-ovs-ha.local (192.168.10.13) already present
2018-10-15 01:10:19,958 [salt.state       :1941][INFO    ][6449] Completed state [prx.mcp-pike-ovs-ha.local] at time 01:10:19.958230 duration_in_ms=0.793
2018-10-15 01:10:19,958 [salt.state       :1770][INFO    ][6449] Running state [prx02] at time 01:10:19.958502
2018-10-15 01:10:19,958 [salt.state       :1803][INFO    ][6449] Executing state host.present for [prx02]
2018-10-15 01:10:19,959 [salt.state       :290 ][INFO    ][6449] Host prx02 (192.168.10.15) already present
2018-10-15 01:10:19,959 [salt.state       :1941][INFO    ][6449] Completed state [prx02] at time 01:10:19.959276 duration_in_ms=0.774
2018-10-15 01:10:19,959 [salt.state       :1770][INFO    ][6449] Running state [prx02.mcp-pike-ovs-ha.local] at time 01:10:19.959533
2018-10-15 01:10:19,959 [salt.state       :1803][INFO    ][6449] Executing state host.present for [prx02.mcp-pike-ovs-ha.local]
2018-10-15 01:10:19,960 [salt.state       :290 ][INFO    ][6449] Host prx02.mcp-pike-ovs-ha.local (192.168.10.15) already present
2018-10-15 01:10:19,960 [salt.state       :1941][INFO    ][6449] Completed state [prx02.mcp-pike-ovs-ha.local] at time 01:10:19.960335 duration_in_ms=0.802
2018-10-15 01:10:19,960 [salt.state       :1770][INFO    ][6449] Running state [msg02] at time 01:10:19.960594
2018-10-15 01:10:19,960 [salt.state       :1803][INFO    ][6449] Executing state host.present for [msg02]
2018-10-15 01:10:19,961 [salt.state       :290 ][INFO    ][6449] Host msg02 (192.168.10.29) already present
2018-10-15 01:10:19,961 [salt.state       :1941][INFO    ][6449] Completed state [msg02] at time 01:10:19.961696 duration_in_ms=1.101
2018-10-15 01:10:19,962 [salt.state       :1770][INFO    ][6449] Running state [msg02.mcp-pike-ovs-ha.local] at time 01:10:19.962263
2018-10-15 01:10:19,962 [salt.state       :1803][INFO    ][6449] Executing state host.present for [msg02.mcp-pike-ovs-ha.local]
2018-10-15 01:10:19,962 [salt.state       :290 ][INFO    ][6449] Host msg02.mcp-pike-ovs-ha.local (192.168.10.29) already present
2018-10-15 01:10:19,963 [salt.state       :1941][INFO    ][6449] Completed state [msg02.mcp-pike-ovs-ha.local] at time 01:10:19.963061 duration_in_ms=0.798
2018-10-15 01:10:19,965 [salt.state       :1770][INFO    ][6449] Running state [file.replace] at time 01:10:19.965443
2018-10-15 01:10:19,965 [salt.state       :1803][INFO    ][6449] Executing state module.run for [file.replace]
2018-10-15 01:10:19,970 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6449] Executing command 'grep -q "msg02 msg02.mcp-pike-ovs-ha.local" /etc/hosts' in directory '/root'
2018-10-15 01:10:19,997 [salt.utils.decorators:613 ][WARNING ][6449] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2018-10-15 01:10:20,007 [salt.state       :290 ][INFO    ][6449] {'ret': '--- \n+++ \n@@ -18,7 +18,7 @@\n 192.168.10.23\t\tdbs dbs.mcp-pike-ovs-ha.local\n 192.168.10.13\t\tprx prx.mcp-pike-ovs-ha.local\n 192.168.10.15\t\tprx02 prx02.mcp-pike-ovs-ha.local\n-192.168.10.29\t\tmsg02 msg02.mcp-pike-ovs-ha.local\n+192.168.10.29\t\tmsg02.mcp-pike-ovs-ha.local msg02\n 192.168.10.30\t\tmsg03 msg03.mcp-pike-ovs-ha.local\n 192.168.10.28\t\tmsg01 msg01.mcp-pike-ovs-ha.local\n 192.168.10.27\t\tmsg msg.mcp-pike-ovs-ha.local\n'}
2018-10-15 01:10:20,007 [salt.state       :1941][INFO    ][6449] Completed state [file.replace] at time 01:10:20.007661 duration_in_ms=42.217
2018-10-15 01:10:20,008 [salt.state       :1770][INFO    ][6449] Running state [msg03] at time 01:10:20.008808
2018-10-15 01:10:20,009 [salt.state       :1803][INFO    ][6449] Executing state host.present for [msg03]
2018-10-15 01:10:20,010 [salt.state       :290 ][INFO    ][6449] Host msg03 (192.168.10.30) already present
2018-10-15 01:10:20,010 [salt.state       :1941][INFO    ][6449] Completed state [msg03] at time 01:10:20.010959 duration_in_ms=2.153
2018-10-15 01:10:20,011 [salt.state       :1770][INFO    ][6449] Running state [msg03.mcp-pike-ovs-ha.local] at time 01:10:20.011244
2018-10-15 01:10:20,011 [salt.state       :1803][INFO    ][6449] Executing state host.present for [msg03.mcp-pike-ovs-ha.local]
2018-10-15 01:10:20,011 [salt.state       :290 ][INFO    ][6449] Host msg03.mcp-pike-ovs-ha.local (192.168.10.30) already present
2018-10-15 01:10:20,012 [salt.state       :1941][INFO    ][6449] Completed state [msg03.mcp-pike-ovs-ha.local] at time 01:10:20.012064 duration_in_ms=0.82
2018-10-15 01:10:20,012 [salt.state       :1770][INFO    ][6449] Running state [msg01] at time 01:10:20.012385
2018-10-15 01:10:20,012 [salt.state       :1803][INFO    ][6449] Executing state host.present for [msg01]
2018-10-15 01:10:20,013 [salt.state       :290 ][INFO    ][6449] Host msg01 (192.168.10.28) already present
2018-10-15 01:10:20,013 [salt.state       :1941][INFO    ][6449] Completed state [msg01] at time 01:10:20.013174 duration_in_ms=0.789
2018-10-15 01:10:20,013 [salt.state       :1770][INFO    ][6449] Running state [msg01.mcp-pike-ovs-ha.local] at time 01:10:20.013763
2018-10-15 01:10:20,014 [salt.state       :1803][INFO    ][6449] Executing state host.present for [msg01.mcp-pike-ovs-ha.local]
2018-10-15 01:10:20,015 [salt.state       :290 ][INFO    ][6449] Host msg01.mcp-pike-ovs-ha.local (192.168.10.28) already present
2018-10-15 01:10:20,015 [salt.state       :1941][INFO    ][6449] Completed state [msg01.mcp-pike-ovs-ha.local] at time 01:10:20.015193 duration_in_ms=1.431
2018-10-15 01:10:20,015 [salt.state       :1770][INFO    ][6449] Running state [msg] at time 01:10:20.015476
2018-10-15 01:10:20,015 [salt.state       :1803][INFO    ][6449] Executing state host.present for [msg]
2018-10-15 01:10:20,017 [salt.state       :290 ][INFO    ][6449] Host msg (192.168.10.27) already present
2018-10-15 01:10:20,017 [salt.state       :1941][INFO    ][6449] Completed state [msg] at time 01:10:20.017204 duration_in_ms=1.728
2018-10-15 01:10:20,017 [salt.state       :1770][INFO    ][6449] Running state [msg.mcp-pike-ovs-ha.local] at time 01:10:20.017479
2018-10-15 01:10:20,017 [salt.state       :1803][INFO    ][6449] Executing state host.present for [msg.mcp-pike-ovs-ha.local]
2018-10-15 01:10:20,018 [salt.state       :290 ][INFO    ][6449] Host msg.mcp-pike-ovs-ha.local (192.168.10.27) already present
2018-10-15 01:10:20,018 [salt.state       :1941][INFO    ][6449] Completed state [msg.mcp-pike-ovs-ha.local] at time 01:10:20.018622 duration_in_ms=1.143
2018-10-15 01:10:20,018 [salt.state       :1770][INFO    ][6449] Running state [cfg01] at time 01:10:20.018903
2018-10-15 01:10:20,019 [salt.state       :1803][INFO    ][6449] Executing state host.present for [cfg01]
2018-10-15 01:10:20,019 [salt.state       :290 ][INFO    ][6449] Host cfg01 (192.168.10.11) already present
2018-10-15 01:10:20,019 [salt.state       :1941][INFO    ][6449] Completed state [cfg01] at time 01:10:20.019724 duration_in_ms=0.821
2018-10-15 01:10:20,020 [salt.state       :1770][INFO    ][6449] Running state [cfg01.mcp-pike-ovs-ha.local] at time 01:10:20.019998
2018-10-15 01:10:20,020 [salt.state       :1803][INFO    ][6449] Executing state host.present for [cfg01.mcp-pike-ovs-ha.local]
2018-10-15 01:10:20,020 [salt.state       :290 ][INFO    ][6449] Host cfg01.mcp-pike-ovs-ha.local (192.168.10.11) already present
2018-10-15 01:10:20,020 [salt.state       :1941][INFO    ][6449] Completed state [cfg01.mcp-pike-ovs-ha.local] at time 01:10:20.020874 duration_in_ms=0.875
2018-10-15 01:10:20,021 [salt.state       :1770][INFO    ][6449] Running state [cmp002] at time 01:10:20.021163
2018-10-15 01:10:20,021 [salt.state       :1803][INFO    ][6449] Executing state host.present for [cmp002]
2018-10-15 01:10:20,022 [salt.state       :290 ][INFO    ][6449] Host cmp002 (192.168.10.53) already present
2018-10-15 01:10:20,022 [salt.state       :1941][INFO    ][6449] Completed state [cmp002] at time 01:10:20.022319 duration_in_ms=1.156
2018-10-15 01:10:20,022 [salt.state       :1770][INFO    ][6449] Running state [cmp002.mcp-pike-ovs-ha.local] at time 01:10:20.022609
2018-10-15 01:10:20,022 [salt.state       :1803][INFO    ][6449] Executing state host.present for [cmp002.mcp-pike-ovs-ha.local]
2018-10-15 01:10:20,023 [salt.state       :290 ][INFO    ][6449] Host cmp002.mcp-pike-ovs-ha.local (192.168.10.53) already present
2018-10-15 01:10:20,023 [salt.state       :1941][INFO    ][6449] Completed state [cmp002.mcp-pike-ovs-ha.local] at time 01:10:20.023714 duration_in_ms=1.105
2018-10-15 01:10:20,024 [salt.state       :1770][INFO    ][6449] Running state [cmp001] at time 01:10:20.024024
2018-10-15 01:10:20,024 [salt.state       :1803][INFO    ][6449] Executing state host.present for [cmp001]
2018-10-15 01:10:20,025 [salt.state       :290 ][INFO    ][6449] Host cmp001 (192.168.10.52) already present
2018-10-15 01:10:20,025 [salt.state       :1941][INFO    ][6449] Completed state [cmp001] at time 01:10:20.025593 duration_in_ms=1.569
2018-10-15 01:10:20,025 [salt.state       :1770][INFO    ][6449] Running state [cmp001.mcp-pike-ovs-ha.local] at time 01:10:20.025877
2018-10-15 01:10:20,026 [salt.state       :1803][INFO    ][6449] Executing state host.present for [cmp001.mcp-pike-ovs-ha.local]
2018-10-15 01:10:20,027 [salt.state       :290 ][INFO    ][6449] Host cmp001.mcp-pike-ovs-ha.local (192.168.10.52) already present
2018-10-15 01:10:20,027 [salt.state       :1941][INFO    ][6449] Completed state [cmp001.mcp-pike-ovs-ha.local] at time 01:10:20.027565 duration_in_ms=1.688
2018-10-15 01:10:20,027 [salt.state       :1770][INFO    ][6449] Running state [dbs01] at time 01:10:20.027895
2018-10-15 01:10:20,028 [salt.state       :1803][INFO    ][6449] Executing state host.present for [dbs01]
2018-10-15 01:10:20,028 [salt.state       :290 ][INFO    ][6449] Host dbs01 (192.168.10.24) already present
2018-10-15 01:10:20,029 [salt.state       :1941][INFO    ][6449] Completed state [dbs01] at time 01:10:20.029100 duration_in_ms=1.205
2018-10-15 01:10:20,029 [salt.state       :1770][INFO    ][6449] Running state [dbs01.mcp-pike-ovs-ha.local] at time 01:10:20.029380
2018-10-15 01:10:20,029 [salt.state       :1803][INFO    ][6449] Executing state host.present for [dbs01.mcp-pike-ovs-ha.local]
2018-10-15 01:10:20,030 [salt.state       :290 ][INFO    ][6449] Host dbs01.mcp-pike-ovs-ha.local (192.168.10.24) already present
2018-10-15 01:10:20,030 [salt.state       :1941][INFO    ][6449] Completed state [dbs01.mcp-pike-ovs-ha.local] at time 01:10:20.030780 duration_in_ms=1.4
2018-10-15 01:10:20,031 [salt.state       :1770][INFO    ][6449] Running state [dbs02] at time 01:10:20.031054
2018-10-15 01:10:20,031 [salt.state       :1803][INFO    ][6449] Executing state host.present for [dbs02]
2018-10-15 01:10:20,031 [salt.state       :290 ][INFO    ][6449] Host dbs02 (192.168.10.25) already present
2018-10-15 01:10:20,032 [salt.state       :1941][INFO    ][6449] Completed state [dbs02] at time 01:10:20.031849 duration_in_ms=0.795
2018-10-15 01:10:20,032 [salt.state       :1770][INFO    ][6449] Running state [dbs02.mcp-pike-ovs-ha.local] at time 01:10:20.032523
2018-10-15 01:10:20,032 [salt.state       :1803][INFO    ][6449] Executing state host.present for [dbs02.mcp-pike-ovs-ha.local]
2018-10-15 01:10:20,033 [salt.state       :290 ][INFO    ][6449] Host dbs02.mcp-pike-ovs-ha.local (192.168.10.25) already present
2018-10-15 01:10:20,033 [salt.state       :1941][INFO    ][6449] Completed state [dbs02.mcp-pike-ovs-ha.local] at time 01:10:20.033303 duration_in_ms=0.781
2018-10-15 01:10:20,033 [salt.state       :1770][INFO    ][6449] Running state [dbs03] at time 01:10:20.033578
2018-10-15 01:10:20,033 [salt.state       :1803][INFO    ][6449] Executing state host.present for [dbs03]
2018-10-15 01:10:20,034 [salt.state       :290 ][INFO    ][6449] Host dbs03 (192.168.10.26) already present
2018-10-15 01:10:20,035 [salt.state       :1941][INFO    ][6449] Completed state [dbs03] at time 01:10:20.035009 duration_in_ms=1.431
2018-10-15 01:10:20,035 [salt.state       :1770][INFO    ][6449] Running state [dbs03.mcp-pike-ovs-ha.local] at time 01:10:20.035285
2018-10-15 01:10:20,035 [salt.state       :1803][INFO    ][6449] Executing state host.present for [dbs03.mcp-pike-ovs-ha.local]
2018-10-15 01:10:20,036 [salt.state       :290 ][INFO    ][6449] Host dbs03.mcp-pike-ovs-ha.local (192.168.10.26) already present
2018-10-15 01:10:20,036 [salt.state       :1941][INFO    ][6449] Completed state [dbs03.mcp-pike-ovs-ha.local] at time 01:10:20.036941 duration_in_ms=1.657
2018-10-15 01:10:20,037 [salt.state       :1770][INFO    ][6449] Running state [mas01] at time 01:10:20.037246
2018-10-15 01:10:20,037 [salt.state       :1803][INFO    ][6449] Executing state host.present for [mas01]
2018-10-15 01:10:20,038 [salt.state       :290 ][INFO    ][6449] Host mas01 (192.168.10.12) already present
2018-10-15 01:10:20,038 [salt.state       :1941][INFO    ][6449] Completed state [mas01] at time 01:10:20.038214 duration_in_ms=0.968
2018-10-15 01:10:20,038 [salt.state       :1770][INFO    ][6449] Running state [mas01.mcp-pike-ovs-ha.local] at time 01:10:20.038493
2018-10-15 01:10:20,038 [salt.state       :1803][INFO    ][6449] Executing state host.present for [mas01.mcp-pike-ovs-ha.local]
2018-10-15 01:10:20,039 [salt.state       :290 ][INFO    ][6449] Host mas01.mcp-pike-ovs-ha.local (192.168.10.12) already present
2018-10-15 01:10:20,039 [salt.state       :1941][INFO    ][6449] Completed state [mas01.mcp-pike-ovs-ha.local] at time 01:10:20.039259 duration_in_ms=0.767
2018-10-15 01:10:20,039 [salt.state       :1770][INFO    ][6449] Running state [ctl02] at time 01:10:20.039534
2018-10-15 01:10:20,039 [salt.state       :1803][INFO    ][6449] Executing state host.present for [ctl02]
2018-10-15 01:10:20,040 [salt.state       :290 ][INFO    ][6449] Host ctl02 (192.168.10.37) already present
2018-10-15 01:10:20,041 [salt.state       :1941][INFO    ][6449] Completed state [ctl02] at time 01:10:20.040980 duration_in_ms=1.445
2018-10-15 01:10:20,041 [salt.state       :1770][INFO    ][6449] Running state [ctl02.mcp-pike-ovs-ha.local] at time 01:10:20.041256
2018-10-15 01:10:20,041 [salt.state       :1803][INFO    ][6449] Executing state host.present for [ctl02.mcp-pike-ovs-ha.local]
2018-10-15 01:10:20,041 [salt.state       :290 ][INFO    ][6449] Host ctl02.mcp-pike-ovs-ha.local (192.168.10.37) already present
2018-10-15 01:10:20,042 [salt.state       :1941][INFO    ][6449] Completed state [ctl02.mcp-pike-ovs-ha.local] at time 01:10:20.042015 duration_in_ms=0.758
2018-10-15 01:10:20,042 [salt.state       :1770][INFO    ][6449] Running state [ctl03] at time 01:10:20.042292
2018-10-15 01:10:20,042 [salt.state       :1803][INFO    ][6449] Executing state host.present for [ctl03]
2018-10-15 01:10:20,043 [salt.state       :290 ][INFO    ][6449] Host ctl03 (192.168.10.38) already present
2018-10-15 01:10:20,043 [salt.state       :1941][INFO    ][6449] Completed state [ctl03] at time 01:10:20.043394 duration_in_ms=1.102
2018-10-15 01:10:20,043 [salt.state       :1770][INFO    ][6449] Running state [ctl03.mcp-pike-ovs-ha.local] at time 01:10:20.043680
2018-10-15 01:10:20,044 [salt.state       :1803][INFO    ][6449] Executing state host.present for [ctl03.mcp-pike-ovs-ha.local]
2018-10-15 01:10:20,044 [salt.state       :290 ][INFO    ][6449] Host ctl03.mcp-pike-ovs-ha.local (192.168.10.38) already present
2018-10-15 01:10:20,044 [salt.state       :1941][INFO    ][6449] Completed state [ctl03.mcp-pike-ovs-ha.local] at time 01:10:20.044831 duration_in_ms=1.151
2018-10-15 01:10:20,045 [salt.state       :1770][INFO    ][6449] Running state [ctl01] at time 01:10:20.045109
2018-10-15 01:10:20,045 [salt.state       :1803][INFO    ][6449] Executing state host.present for [ctl01]
2018-10-15 01:10:20,045 [salt.state       :290 ][INFO    ][6449] Host ctl01 (192.168.10.36) already present
2018-10-15 01:10:20,045 [salt.state       :1941][INFO    ][6449] Completed state [ctl01] at time 01:10:20.045866 duration_in_ms=0.756
2018-10-15 01:10:20,046 [salt.state       :1770][INFO    ][6449] Running state [ctl01.mcp-pike-ovs-ha.local] at time 01:10:20.046503
2018-10-15 01:10:20,046 [salt.state       :1803][INFO    ][6449] Executing state host.present for [ctl01.mcp-pike-ovs-ha.local]
2018-10-15 01:10:20,047 [salt.state       :290 ][INFO    ][6449] Host ctl01.mcp-pike-ovs-ha.local (192.168.10.36) already present
2018-10-15 01:10:20,047 [salt.state       :1941][INFO    ][6449] Completed state [ctl01.mcp-pike-ovs-ha.local] at time 01:10:20.047274 duration_in_ms=0.771
2018-10-15 01:10:20,047 [salt.state       :1770][INFO    ][6449] Running state [ctl] at time 01:10:20.047553
2018-10-15 01:10:20,047 [salt.state       :1803][INFO    ][6449] Executing state host.present for [ctl]
2018-10-15 01:10:20,049 [salt.state       :290 ][INFO    ][6449] Host ctl (192.168.10.35) already present
2018-10-15 01:10:20,049 [salt.state       :1941][INFO    ][6449] Completed state [ctl] at time 01:10:20.049276 duration_in_ms=1.722
2018-10-15 01:10:20,049 [salt.state       :1770][INFO    ][6449] Running state [ctl.mcp-pike-ovs-ha.local] at time 01:10:20.049577
2018-10-15 01:10:20,049 [salt.state       :1803][INFO    ][6449] Executing state host.present for [ctl.mcp-pike-ovs-ha.local]
2018-10-15 01:10:20,050 [salt.state       :290 ][INFO    ][6449] Host ctl.mcp-pike-ovs-ha.local (192.168.10.35) already present
2018-10-15 01:10:20,050 [salt.state       :1941][INFO    ][6449] Completed state [ctl.mcp-pike-ovs-ha.local] at time 01:10:20.050376 duration_in_ms=0.798
2018-10-15 01:10:20,050 [salt.state       :1770][INFO    ][6449] Running state [/etc/network/interfaces.d/50-cloud-init.cfg] at time 01:10:20.050569
2018-10-15 01:10:20,050 [salt.state       :1803][INFO    ][6449] Executing state file.absent for [/etc/network/interfaces.d/50-cloud-init.cfg]
2018-10-15 01:10:20,051 [salt.state       :290 ][INFO    ][6449] File /etc/network/interfaces.d/50-cloud-init.cfg is not present
2018-10-15 01:10:20,051 [salt.state       :1941][INFO    ][6449] Completed state [/etc/network/interfaces.d/50-cloud-init.cfg] at time 01:10:20.051501 duration_in_ms=0.933
2018-10-15 01:10:20,051 [salt.state       :1770][INFO    ][6449] Running state [ens2] at time 01:10:20.051723
2018-10-15 01:10:20,052 [salt.state       :1803][INFO    ][6449] Executing state network.managed for [ens2]
2018-10-15 01:10:20,181 [salt.state       :290 ][INFO    ][6449] Interface ens2 is up to date.
2018-10-15 01:10:20,182 [salt.state       :1941][INFO    ][6449] Completed state [ens2] at time 01:10:20.182170 duration_in_ms=130.446
2018-10-15 01:10:20,183 [salt.state       :1770][INFO    ][6449] Running state [ens3] at time 01:10:20.183284
2018-10-15 01:10:20,184 [salt.state       :1803][INFO    ][6449] Executing state network.managed for [ens3]
2018-10-15 01:10:20,220 [salt.state       :290 ][INFO    ][6449] Interface ens3 is up to date.
2018-10-15 01:10:20,221 [salt.state       :1941][INFO    ][6449] Completed state [ens3] at time 01:10:20.221577 duration_in_ms=38.293
2018-10-15 01:10:20,222 [salt.state       :1770][INFO    ][6449] Running state [/etc/profile.d/proxy.sh] at time 01:10:20.222477
2018-10-15 01:10:20,223 [salt.state       :1803][INFO    ][6449] Executing state file.absent for [/etc/profile.d/proxy.sh]
2018-10-15 01:10:20,224 [salt.state       :290 ][INFO    ][6449] File /etc/profile.d/proxy.sh is not present
2018-10-15 01:10:20,224 [salt.state       :1941][INFO    ][6449] Completed state [/etc/profile.d/proxy.sh] at time 01:10:20.224855 duration_in_ms=2.379
2018-10-15 01:10:20,225 [salt.state       :1770][INFO    ][6449] Running state [/etc/apt/apt.conf.d/95proxies] at time 01:10:20.225271
2018-10-15 01:10:20,225 [salt.state       :1803][INFO    ][6449] Executing state file.absent for [/etc/apt/apt.conf.d/95proxies]
2018-10-15 01:10:20,226 [salt.state       :290 ][INFO    ][6449] File /etc/apt/apt.conf.d/95proxies is not present
2018-10-15 01:10:20,226 [salt.state       :1941][INFO    ][6449] Completed state [/etc/apt/apt.conf.d/95proxies] at time 01:10:20.226923 duration_in_ms=1.653
2018-10-15 01:10:20,227 [salt.state       :1770][INFO    ][6449] Running state [ntp] at time 01:10:20.227184
2018-10-15 01:10:20,227 [salt.state       :1803][INFO    ][6449] Executing state pkg.installed for [ntp]
2018-10-15 01:10:20,239 [salt.state       :290 ][INFO    ][6449] All specified packages are already installed
2018-10-15 01:10:20,239 [salt.state       :1941][INFO    ][6449] Completed state [ntp] at time 01:10:20.239649 duration_in_ms=12.465
2018-10-15 01:10:20,242 [salt.state       :1770][INFO    ][6449] Running state [/etc/ntp.conf] at time 01:10:20.242112
2018-10-15 01:10:20,242 [salt.state       :1803][INFO    ][6449] Executing state file.managed for [/etc/ntp.conf]
2018-10-15 01:10:20,326 [salt.state       :290 ][INFO    ][6449] File /etc/ntp.conf is in the correct state
2018-10-15 01:10:20,326 [salt.state       :1941][INFO    ][6449] Completed state [/etc/ntp.conf] at time 01:10:20.326904 duration_in_ms=84.791
2018-10-15 01:10:20,328 [salt.state       :1770][INFO    ][6449] Running state [ntp] at time 01:10:20.327985
2018-10-15 01:10:20,328 [salt.state       :1803][INFO    ][6449] Executing state service.running for [ntp]
2018-10-15 01:10:20,328 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6449] Executing command ['systemctl', 'status', 'ntp.service', '-n', '0'] in directory '/root'
2018-10-15 01:10:20,357 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6449] Executing command ['systemctl', 'is-active', 'ntp.service'] in directory '/root'
2018-10-15 01:10:20,382 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6449] Executing command ['systemctl', 'is-enabled', 'ntp.service'] in directory '/root'
2018-10-15 01:10:20,411 [salt.state       :290 ][INFO    ][6449] The service ntp is already running
2018-10-15 01:10:20,412 [salt.state       :1941][INFO    ][6449] Completed state [ntp] at time 01:10:20.412655 duration_in_ms=84.67
2018-10-15 01:10:20,421 [salt.minion      :1708][INFO    ][6449] Returning information for job: 20181015011003477680
2018-10-15 01:10:42,898 [salt.minion      :1307][INFO    ][2938] User sudo_ubuntu Executing command ssh.set_auth_key with jid 20181015011042883720
2018-10-15 01:10:42,917 [salt.minion      :1431][INFO    ][7170] Starting a new job with PID 7170
2018-10-15 01:10:42,941 [salt.minion      :1708][INFO    ][7170] Returning information for job: 20181015011042883720
2018-10-15 01:11:22,159 [salt.minion      :1307][INFO    ][2938] User sudo_ubuntu Executing command pkg.upgrade with jid 20181015011122147064
2018-10-15 01:11:22,188 [salt.minion      :1431][INFO    ][7194] Starting a new job with PID 7194
2018-10-15 01:11:22,218 [salt.loader.192.168.11.2.int.module.cmdmod:395 ][INFO    ][7194] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}', '-W'] in directory '/root'
2018-10-15 01:11:22,597 [salt.loader.192.168.11.2.int.module.cmdmod:395 ][INFO    ][7194] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'upgrade'] in directory '/root'
2018-10-15 01:11:32,249 [salt.minion      :1307][INFO    ][2938] User sudo_ubuntu Executing command saltutil.find_job with jid 20181015011132234231
2018-10-15 01:11:32,266 [salt.minion      :1431][INFO    ][7962] Starting a new job with PID 7962
2018-10-15 01:11:32,286 [salt.minion      :1708][INFO    ][7962] Returning information for job: 20181015011132234231
2018-10-15 01:11:34,386 [salt.loader.192.168.11.2.int.module.cmdmod:395 ][INFO    ][7194] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}', '-W'] in directory '/root'
2018-10-15 01:11:34,433 [salt.minion      :1708][INFO    ][7194] Returning information for job: 20181015011122147064
2018-10-15 01:11:44,583 [salt.minion      :1307][INFO    ][2938] User sudo_ubuntu Executing command test.ping with jid 20181015011144569623
2018-10-15 01:11:44,617 [salt.minion      :1431][INFO    ][8032] Starting a new job with PID 8032
2018-10-15 01:11:44,648 [salt.minion      :1708][INFO    ][8032] Returning information for job: 20181015011144569623
2018-10-15 01:12:23,466 [salt.minion      :1307][INFO    ][2938] User sudo_ubuntu Executing command state.sls with jid 20181015011223452274
2018-10-15 01:12:23,491 [salt.minion      :1431][INFO    ][8037] Starting a new job with PID 8037
2018-10-15 01:12:24,126 [salt.state       :905 ][INFO    ][8037] Loading fresh modules for state activity
2018-10-15 01:12:24,189 [salt.fileclient  :1215][INFO    ][8037] Fetching file from saltenv 'base', ** done ** 'keepalived/init.sls'
2018-10-15 01:12:24,230 [salt.fileclient  :1215][INFO    ][8037] Fetching file from saltenv 'base', ** done ** 'keepalived/cluster.sls'
2018-10-15 01:12:24,878 [salt.state       :1770][INFO    ][8037] Running state [keepalived] at time 01:12:24.878146
2018-10-15 01:12:24,878 [salt.state       :1803][INFO    ][8037] Executing state pkg.installed for [keepalived]
2018-10-15 01:12:24,879 [salt.loaded.int.module.cmdmod:395 ][INFO    ][8037] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}', '-W'] in directory '/root'
2018-10-15 01:12:25,225 [salt.loaded.int.module.cmdmod:395 ][INFO    ][8037] Executing command ['apt-cache', '-q', 'policy', 'keepalived'] in directory '/root'
2018-10-15 01:12:25,320 [salt.loaded.int.module.cmdmod:395 ][INFO    ][8037] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2018-10-15 01:12:27,474 [salt.loaded.int.module.cmdmod:395 ][INFO    ][8037] Executing command ['dpkg', '--get-selections', '*'] in directory '/root'
2018-10-15 01:12:27,505 [salt.loaded.int.module.cmdmod:395 ][INFO    ][8037] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'keepalived'] in directory '/root'
2018-10-15 01:12:31,778 [salt.loaded.int.module.cmdmod:395 ][INFO    ][8037] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}', '-W'] in directory '/root'
2018-10-15 01:12:31,827 [salt.state       :290 ][INFO    ][8037] Made the following changes:
'libsnmp30' changed from 'absent' to '5.7.3+dfsg-1ubuntu4.1'
'libsensors4' changed from 'absent' to '1:3.4.0-2'
'libsnmp-base' changed from 'absent' to '5.7.3+dfsg-1ubuntu4.1'
'keepalived' changed from 'absent' to '1:1.2.24-1ubuntu0.16.04.1'
'ipvsadm' changed from 'absent' to '1:1.28-3'
'libnl-route-3-200' changed from 'absent' to '3.2.27-1ubuntu0.16.04.1'

2018-10-15 01:12:31,846 [salt.state       :905 ][INFO    ][8037] Loading fresh modules for state activity
2018-10-15 01:12:31,882 [salt.state       :1941][INFO    ][8037] Completed state [keepalived] at time 01:12:31.882456 duration_in_ms=7004.311
2018-10-15 01:12:31,887 [salt.state       :1770][INFO    ][8037] Running state [lsof] at time 01:12:31.887793
2018-10-15 01:12:31,888 [salt.state       :1803][INFO    ][8037] Executing state pkg.installed for [lsof]
2018-10-15 01:12:32,538 [salt.state       :290 ][INFO    ][8037] All specified packages are already installed
2018-10-15 01:12:32,538 [salt.state       :1941][INFO    ][8037] Completed state [lsof] at time 01:12:32.538352 duration_in_ms=650.558
2018-10-15 01:12:32,541 [salt.state       :1770][INFO    ][8037] Running state [/etc/keepalived/keepalived.conf] at time 01:12:32.541641
2018-10-15 01:12:32,541 [salt.state       :1803][INFO    ][8037] Executing state file.managed for [/etc/keepalived/keepalived.conf]
2018-10-15 01:12:32,581 [salt.fileclient  :1215][INFO    ][8037] Fetching file from saltenv 'base', ** done ** 'keepalived/files/keepalived.conf'
2018-10-15 01:12:32,637 [salt.state       :290 ][INFO    ][8037] File changed:
New file
2018-10-15 01:12:32,638 [salt.state       :1941][INFO    ][8037] Completed state [/etc/keepalived/keepalived.conf] at time 01:12:32.638088 duration_in_ms=96.447
2018-10-15 01:12:32,638 [salt.state       :1770][INFO    ][8037] Running state [keepalived] at time 01:12:32.638805
2018-10-15 01:12:32,639 [salt.state       :1803][INFO    ][8037] Executing state service.running for [keepalived]
2018-10-15 01:12:32,639 [salt.loaded.int.module.cmdmod:395 ][INFO    ][8037] Executing command ['systemctl', 'status', 'keepalived.service', '-n', '0'] in directory '/root'
2018-10-15 01:12:32,665 [salt.loaded.int.module.cmdmod:395 ][INFO    ][8037] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2018-10-15 01:12:32,689 [salt.loaded.int.module.cmdmod:395 ][INFO    ][8037] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2018-10-15 01:12:32,714 [salt.loaded.int.module.cmdmod:395 ][INFO    ][8037] Executing command ['systemd-run', '--scope', 'systemctl', 'start', 'keepalived.service'] in directory '/root'
2018-10-15 01:12:32,784 [salt.loaded.int.module.cmdmod:395 ][INFO    ][8037] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2018-10-15 01:12:32,804 [salt.loaded.int.module.cmdmod:395 ][INFO    ][8037] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2018-10-15 01:12:32,824 [salt.loaded.int.module.cmdmod:395 ][INFO    ][8037] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2018-10-15 01:12:32,843 [salt.state       :290 ][INFO    ][8037] {'keepalived': True}
2018-10-15 01:12:32,843 [salt.state       :1941][INFO    ][8037] Completed state [keepalived] at time 01:12:32.843646 duration_in_ms=204.84
2018-10-15 01:12:32,846 [salt.minion      :1708][INFO    ][8037] Returning information for job: 20181015011223452274
2018-10-15 01:15:15,211 [salt.minion      :1307][INFO    ][2938] User sudo_ubuntu Executing command pillar.get with jid 20181015011515199745
2018-10-15 01:15:15,238 [salt.minion      :1431][INFO    ][9580] Starting a new job with PID 9580
2018-10-15 01:15:15,247 [salt.minion      :1708][INFO    ][9580] Returning information for job: 20181015011515199745
2018-10-15 01:18:32,858 [salt.minion      :1307][INFO    ][2938] User sudo_ubuntu Executing command state.sls with jid 20181015011832846879
2018-10-15 01:18:32,880 [salt.minion      :1431][INFO    ][9604] Starting a new job with PID 9604
2018-10-15 01:18:35,795 [salt.state       :905 ][INFO    ][9604] Loading fresh modules for state activity
2018-10-15 01:18:35,872 [salt.fileclient  :1215][INFO    ][9604] Fetching file from saltenv 'base', ** done ** 'rabbitmq/init.sls'
2018-10-15 01:18:35,936 [salt.fileclient  :1215][INFO    ][9604] Fetching file from saltenv 'base', ** done ** 'rabbitmq/server/init.sls'
2018-10-15 01:18:35,981 [salt.fileclient  :1215][INFO    ][9604] Fetching file from saltenv 'base', ** done ** 'rabbitmq/server/service.sls'
2018-10-15 01:18:36,037 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9604] Executing command 'cat /var/lib/rabbitmq/.erlang.cookie' in directory '/root'
2018-10-15 01:18:36,057 [salt.loaded.int.module.cmdmod:722 ][ERROR   ][9604] Command 'cat /var/lib/rabbitmq/.erlang.cookie' failed with return code: 1
2018-10-15 01:18:36,058 [salt.loaded.int.module.cmdmod:724 ][ERROR   ][9604] stdout: cat: /var/lib/rabbitmq/.erlang.cookie: No such file or directory
2018-10-15 01:18:36,058 [salt.loaded.int.module.cmdmod:728 ][ERROR   ][9604] retcode: 1
2018-10-15 01:18:36,111 [salt.fileclient  :1215][INFO    ][9604] Fetching file from saltenv 'base', ** done ** 'rabbitmq/server/ssl.sls'
2018-10-15 01:18:36,183 [salt.fileclient  :1215][INFO    ][9604] Fetching file from saltenv 'base', ** done ** 'rabbitmq/server/plugin.sls'
2018-10-15 01:18:36,269 [salt.fileclient  :1215][INFO    ][9604] Fetching file from saltenv 'base', ** done ** 'rabbitmq/server/vhost.sls'
2018-10-15 01:18:36,345 [salt.fileclient  :1215][INFO    ][9604] Fetching file from saltenv 'base', ** done ** 'rabbitmq/server/user.sls'
2018-10-15 01:18:36,401 [salt.fileclient  :1215][INFO    ][9604] Fetching file from saltenv 'base', ** done ** 'rabbitmq/cluster.sls'
2018-10-15 01:18:37,087 [salt.state       :1770][INFO    ][9604] Running state [rabbitmq-server] at time 01:18:37.087672
2018-10-15 01:18:37,088 [salt.state       :1803][INFO    ][9604] Executing state pkg.installed for [rabbitmq-server]
2018-10-15 01:18:37,089 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9604] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}', '-W'] in directory '/root'
2018-10-15 01:18:37,428 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9604] Executing command ['apt-cache', '-q', 'policy', 'rabbitmq-server'] in directory '/root'
2018-10-15 01:18:37,560 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9604] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2018-10-15 01:18:39,780 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9604] Executing command ['dpkg', '--get-selections', '*'] in directory '/root'
2018-10-15 01:18:39,814 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9604] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'rabbitmq-server'] in directory '/root'
2018-10-15 01:18:42,989 [salt.minion      :1307][INFO    ][2938] User sudo_ubuntu Executing command saltutil.find_job with jid 20181015011842970371
2018-10-15 01:18:43,009 [salt.minion      :1431][INFO    ][10183] Starting a new job with PID 10183
2018-10-15 01:18:43,028 [salt.minion      :1708][INFO    ][10183] Returning information for job: 20181015011842970371
2018-10-15 01:18:53,212 [salt.minion      :1307][INFO    ][2938] User sudo_ubuntu Executing command saltutil.find_job with jid 20181015011853195212
2018-10-15 01:18:53,225 [salt.minion      :1431][INFO    ][10977] Starting a new job with PID 10977
2018-10-15 01:18:53,246 [salt.minion      :1708][INFO    ][10977] Returning information for job: 20181015011853195212
2018-10-15 01:19:03,247 [salt.minion      :1307][INFO    ][2938] User sudo_ubuntu Executing command saltutil.find_job with jid 20181015011903232889
2018-10-15 01:19:03,261 [salt.minion      :1431][INFO    ][10982] Starting a new job with PID 10982
2018-10-15 01:19:03,287 [salt.minion      :1708][INFO    ][10982] Returning information for job: 20181015011903232889
2018-10-15 01:19:13,392 [salt.minion      :1307][INFO    ][2938] User sudo_ubuntu Executing command saltutil.find_job with jid 20181015011913376842
2018-10-15 01:19:13,409 [salt.minion      :1431][INFO    ][10987] Starting a new job with PID 10987
2018-10-15 01:19:13,423 [salt.minion      :1708][INFO    ][10987] Returning information for job: 20181015011913376842
2018-10-15 01:19:23,425 [salt.minion      :1307][INFO    ][2938] User sudo_ubuntu Executing command saltutil.find_job with jid 20181015011923406361
2018-10-15 01:19:23,444 [salt.minion      :1431][INFO    ][10992] Starting a new job with PID 10992
2018-10-15 01:19:23,463 [salt.minion      :1708][INFO    ][10992] Returning information for job: 20181015011923406361
2018-10-15 01:19:25,236 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9604] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}', '-W'] in directory '/root'
2018-10-15 01:19:25,289 [salt.state       :290 ][INFO    ][9604] Made the following changes:
'libltdl7' changed from 'absent' to '2.4.6-0.1'
'erlang-runtime-tools' changed from 'absent' to '1:20.2.2+dfsg-1.1~u16.04+mcp1'
'erlang-eunit' changed from 'absent' to '1:20.2.2+dfsg-1.1~u16.04+mcp1'
'erlang-asn1' changed from 'absent' to '1:20.2.2+dfsg-1.1~u16.04+mcp1'
'erlang-inets' changed from 'absent' to '1:20.2.2+dfsg-1.1~u16.04+mcp1'
'erlang-snmp' changed from 'absent' to '1:20.2.2+dfsg-1.1~u16.04+mcp1'
'erlang-odbc' changed from 'absent' to '1:20.2.2+dfsg-1.1~u16.04+mcp1'
'erlang-diameter' changed from 'absent' to '1:20.2.2+dfsg-1.1~u16.04+mcp1'
'erlang-parsetools' changed from 'absent' to '1:20.2.2+dfsg-1.1~u16.04+mcp1'
'erlang-public-key' changed from 'absent' to '1:20.2.2+dfsg-1.1~u16.04+mcp1'
'socat' changed from 'absent' to '1.7.3.1-1'
'erlang-abi-17.0' changed from 'absent' to '1'
'erlang-corba' changed from 'absent' to '1:20.2.2+dfsg-1.1~u16.04+mcp1'
'erlang-xmerl' changed from 'absent' to '1:20.2.2+dfsg-1.1~u16.04+mcp1'
'erlang-ic' changed from 'absent' to '1:20.2.2+dfsg-1.1~u16.04+mcp1'
'erlang-os-mon' changed from 'absent' to '1:20.2.2+dfsg-1.1~u16.04+mcp1'
'libodbc1' changed from 'absent' to '2.3.1-4.1'
'erlang-eldap' changed from 'absent' to '1:20.2.2+dfsg-1.1~u16.04+mcp1'
'erlang-syntax-tools' changed from 'absent' to '1:20.2.2+dfsg-1.1~u16.04+mcp1'
'erlang-edoc' changed from 'absent' to '1:20.2.2+dfsg-1.1~u16.04+mcp1'
'erlang-ssl' changed from 'absent' to '1:20.2.2+dfsg-1.1~u16.04+mcp1'
'erlang-tools' changed from 'absent' to '1:20.2.2+dfsg-1.1~u16.04+mcp1'
'erlang-mnesia' changed from 'absent' to '1:20.2.2+dfsg-1.1~u16.04+mcp1'
'erlang-ssh' changed from 'absent' to '1:20.2.2+dfsg-1.1~u16.04+mcp1'
'libsctp1' changed from 'absent' to '1.0.16+dfsg-3'
'rabbitmq-server' changed from 'absent' to '3.6.15-3~u16.04+mcp1'
'erlang-base-hipe' changed from 'absent' to '1:20.2.2+dfsg-1.1~u16.04+mcp1'
'erlang-crypto' changed from 'absent' to '1:20.2.2+dfsg-1.1~u16.04+mcp1'
'erlang-erl-docgen' changed from 'absent' to '1:20.2.2+dfsg-1.1~u16.04+mcp1'
'erlang-abi-15.b' changed from 'absent' to '1'
'erlang-nox' changed from 'absent' to '1:20.2.2+dfsg-1.1~u16.04+mcp1'

2018-10-15 01:19:25,307 [salt.state       :905 ][INFO    ][9604] Loading fresh modules for state activity
2018-10-15 01:19:25,344 [salt.state       :1941][INFO    ][9604] Completed state [rabbitmq-server] at time 01:19:25.344676 duration_in_ms=48257.003
2018-10-15 01:19:25,349 [salt.state       :1770][INFO    ][9604] Running state [/etc/rabbitmq/rabbitmq.config] at time 01:19:25.349355
2018-10-15 01:19:25,349 [salt.state       :1803][INFO    ][9604] Executing state file.managed for [/etc/rabbitmq/rabbitmq.config]
2018-10-15 01:19:25,381 [salt.fileclient  :1215][INFO    ][9604] Fetching file from saltenv 'base', ** done ** 'rabbitmq/files/rabbitmq.config'
2018-10-15 01:19:25,447 [salt.state       :290 ][INFO    ][9604] File changed:
New file
2018-10-15 01:19:25,447 [salt.state       :1941][INFO    ][9604] Completed state [/etc/rabbitmq/rabbitmq.config] at time 01:19:25.447409 duration_in_ms=98.053
2018-10-15 01:19:25,447 [salt.state       :1770][INFO    ][9604] Running state [/etc/default/rabbitmq-server] at time 01:19:25.447757
2018-10-15 01:19:25,447 [salt.state       :1803][INFO    ][9604] Executing state file.managed for [/etc/default/rabbitmq-server]
2018-10-15 01:19:25,471 [salt.fileclient  :1215][INFO    ][9604] Fetching file from saltenv 'base', ** done ** 'rabbitmq/files/default'
2018-10-15 01:19:25,511 [salt.state       :290 ][INFO    ][9604] File changed:
--- 
+++ 
@@ -1,3 +1,6 @@
+
+# Managed by Salt
+
 # This file is sourced by /etc/init.d/rabbitmq-server. Its primary
 # reason for existing is to allow adjustment of system limits for the
 # rabbitmq-server process.
@@ -6,12 +9,5 @@
 # to handle many simultaneous connections. Refer to the system
 # documentation for ulimit (in man bash) for more information.
 #
-#ulimit -n 1024
-# Default value is 1024, but it's absolutely unreasonable default in a
-# modern world, as rabbitmq consumes file descriptors for everything:
-# for client connections, for per-queue files, etc. Its documentation
-# recommends to allow for at least 65536 open file descriptors in
-# production. Values were chosen in
-# https://bugs.launchpad.net/fuel/+bug/1279594
-ulimit -H -n 105472 || true
-ulimit -S -n 102400 || true
+
+ulimit -n 8192
2018-10-15 01:19:25,511 [salt.state       :1941][INFO    ][9604] Completed state [/etc/default/rabbitmq-server] at time 01:19:25.511842 duration_in_ms=64.085
2018-10-15 01:19:25,512 [salt.state       :1770][INFO    ][9604] Running state [/etc/systemd/system/rabbitmq-server.service.d/limits.conf] at time 01:19:25.512229
2018-10-15 01:19:25,520 [salt.state       :1803][INFO    ][9604] Executing state file.managed for [/etc/systemd/system/rabbitmq-server.service.d/limits.conf]
2018-10-15 01:19:25,550 [salt.fileclient  :1215][INFO    ][9604] Fetching file from saltenv 'base', ** done ** 'rabbitmq/files/limits.conf'
2018-10-15 01:19:25,595 [salt.state       :290 ][INFO    ][9604] File changed:
New file
2018-10-15 01:19:25,596 [salt.state       :1941][INFO    ][9604] Completed state [/etc/systemd/system/rabbitmq-server.service.d/limits.conf] at time 01:19:25.596016 duration_in_ms=83.787
2018-10-15 01:19:25,597 [salt.state       :1770][INFO    ][9604] Running state [sleep 30] at time 01:19:25.597217
2018-10-15 01:19:25,597 [salt.state       :1803][INFO    ][9604] Executing state cmd.run for [sleep 30]
2018-10-15 01:19:25,597 [py.warnings      :2526][WARNING ][9604] /usr/lib/python2.7/dist-packages/salt/states/cmd.py:824: DeprecationWarning: The legacy user/group arguments are deprecated. Replace them with runas. These arguments will be removed in Salt Oxygen.

2018-10-15 01:19:25,600 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9604] Executing command 'sleep 30' as user 'root' in directory '/root'
2018-10-15 01:19:33,626 [salt.minion      :1307][INFO    ][2938] User sudo_ubuntu Executing command saltutil.find_job with jid 20181015011933610250
2018-10-15 01:19:33,653 [salt.minion      :1431][INFO    ][11162] Starting a new job with PID 11162
2018-10-15 01:19:33,669 [salt.minion      :1708][INFO    ][11162] Returning information for job: 20181015011933610250
2018-10-15 01:19:43,650 [salt.minion      :1307][INFO    ][2938] User sudo_ubuntu Executing command saltutil.find_job with jid 20181015011943633358
2018-10-15 01:19:43,670 [salt.minion      :1431][INFO    ][11167] Starting a new job with PID 11167
2018-10-15 01:19:43,691 [salt.minion      :1708][INFO    ][11167] Returning information for job: 20181015011943633358
2018-10-15 01:19:53,678 [salt.minion      :1307][INFO    ][2938] User sudo_ubuntu Executing command saltutil.find_job with jid 20181015011953657557
2018-10-15 01:19:53,698 [salt.minion      :1431][INFO    ][11172] Starting a new job with PID 11172
2018-10-15 01:19:53,718 [salt.minion      :1708][INFO    ][11172] Returning information for job: 20181015011953657557
2018-10-15 01:19:55,690 [salt.state       :290 ][INFO    ][9604] {'pid': 11136, 'retcode': 0, 'stderr': '', 'stdout': ''}
2018-10-15 01:19:55,691 [salt.state       :1941][INFO    ][9604] Completed state [sleep 30] at time 01:19:55.691416 duration_in_ms=30094.198
2018-10-15 01:19:55,693 [salt.state       :1770][INFO    ][9604] Running state [service rabbitmq-server stop] at time 01:19:55.693755
2018-10-15 01:19:55,694 [salt.state       :1803][INFO    ][9604] Executing state cmd.run for [service rabbitmq-server stop]
2018-10-15 01:19:55,697 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9604] Executing command 'service rabbitmq-server stop' in directory '/root'
2018-10-15 01:19:56,047 [salt.state       :290 ][INFO    ][9604] {'pid': 11175, 'retcode': 0, 'stderr': '', 'stdout': ''}
2018-10-15 01:19:56,048 [salt.state       :1941][INFO    ][9604] Completed state [service rabbitmq-server stop] at time 01:19:56.048044 duration_in_ms=354.289
2018-10-15 01:19:56,048 [salt.state       :1770][INFO    ][9604] Running state [/var/lib/rabbitmq] at time 01:19:56.048742
2018-10-15 01:19:56,049 [salt.state       :1803][INFO    ][9604] Executing state file.directory for [/var/lib/rabbitmq]
2018-10-15 01:19:56,050 [salt.state       :290 ][INFO    ][9604] Directory /var/lib/rabbitmq is in the correct state
Directory /var/lib/rabbitmq updated
2018-10-15 01:19:56,051 [salt.state       :1941][INFO    ][9604] Completed state [/var/lib/rabbitmq] at time 01:19:56.050988 duration_in_ms=2.246
2018-10-15 01:19:56,053 [salt.state       :1770][INFO    ][9604] Running state [/var/lib/rabbitmq/.erlang.cookie] at time 01:19:56.053406
2018-10-15 01:19:56,053 [salt.state       :1803][INFO    ][9604] Executing state file.managed for [/var/lib/rabbitmq/.erlang.cookie]
2018-10-15 01:19:56,057 [salt.state       :290 ][INFO    ][9604] File changed:
--- 
+++ 
@@ -1 +1 @@
-HQBMNIYFNNGTSOJJWFIV+opnfv_secret

2018-10-15 01:19:56,057 [salt.state       :1941][INFO    ][9604] Completed state [/var/lib/rabbitmq/.erlang.cookie] at time 01:19:56.057942 duration_in_ms=4.537
2018-10-15 01:19:56,058 [salt.state       :1770][INFO    ][9604] Running state [sleep 30] at time 01:19:56.058376
2018-10-15 01:19:56,058 [salt.state       :1803][INFO    ][9604] Executing state cmd.run for [sleep 30]
2018-10-15 01:19:56,059 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9604] Executing command 'sleep 30' as user 'root' in directory '/root'
2018-10-15 01:20:03,905 [salt.minion      :1307][INFO    ][2938] User sudo_ubuntu Executing command saltutil.find_job with jid 20181015012003885746
2018-10-15 01:20:03,928 [salt.minion      :1431][INFO    ][11260] Starting a new job with PID 11260
2018-10-15 01:20:03,950 [salt.minion      :1708][INFO    ][11260] Returning information for job: 20181015012003885746
2018-10-15 01:20:14,121 [salt.minion      :1307][INFO    ][2938] User sudo_ubuntu Executing command saltutil.find_job with jid 20181015012014106877
2018-10-15 01:20:14,141 [salt.minion      :1431][INFO    ][11265] Starting a new job with PID 11265
2018-10-15 01:20:14,160 [salt.minion      :1708][INFO    ][11265] Returning information for job: 20181015012014106877
2018-10-15 01:20:24,352 [salt.minion      :1307][INFO    ][2938] User sudo_ubuntu Executing command saltutil.find_job with jid 20181015012024337035
2018-10-15 01:20:24,374 [salt.minion      :1431][INFO    ][11270] Starting a new job with PID 11270
2018-10-15 01:20:24,391 [salt.minion      :1708][INFO    ][11270] Returning information for job: 20181015012024337035
2018-10-15 01:20:26,153 [salt.state       :290 ][INFO    ][9604] {'pid': 11235, 'retcode': 0, 'stderr': '', 'stdout': ''}
2018-10-15 01:20:26,156 [salt.state       :1941][INFO    ][9604] Completed state [sleep 30] at time 01:20:26.156001 duration_in_ms=30097.623
2018-10-15 01:20:26,634 [salt.state       :1770][INFO    ][9604] Running state [rabbitmq-server] at time 01:20:26.634315
2018-10-15 01:20:26,635 [salt.state       :1803][INFO    ][9604] Executing state service.running for [rabbitmq-server]
2018-10-15 01:20:26,636 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9604] Executing command ['systemctl', 'status', 'rabbitmq-server.service', '-n', '0'] in directory '/root'
2018-10-15 01:20:26,665 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9604] Executing command ['systemctl', 'is-active', 'rabbitmq-server.service'] in directory '/root'
2018-10-15 01:20:26,690 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9604] Executing command ['systemctl', 'is-enabled', 'rabbitmq-server.service'] in directory '/root'
2018-10-15 01:20:26,729 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9604] Executing command ['systemd-run', '--scope', 'systemctl', 'start', 'rabbitmq-server.service'] in directory '/root'
2018-10-15 01:20:29,889 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9604] Executing command ['systemctl', 'is-active', 'rabbitmq-server.service'] in directory '/root'
2018-10-15 01:20:29,909 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9604] Executing command ['systemctl', 'is-enabled', 'rabbitmq-server.service'] in directory '/root'
2018-10-15 01:20:29,931 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9604] Executing command ['systemctl', 'is-enabled', 'rabbitmq-server.service'] in directory '/root'
2018-10-15 01:20:29,953 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9604] Executing command ['systemd-run', '--scope', 'systemctl', 'enable', 'rabbitmq-server.service'] in directory '/root'
2018-10-15 01:20:30,395 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9604] Executing command ['systemctl', 'is-enabled', 'rabbitmq-server.service'] in directory '/root'
2018-10-15 01:20:30,417 [salt.state       :290 ][INFO    ][9604] {'rabbitmq-server': True}
2018-10-15 01:20:30,417 [salt.state       :1941][INFO    ][9604] Completed state [rabbitmq-server] at time 01:20:30.417367 duration_in_ms=3783.053
2018-10-15 01:20:30,422 [salt.state       :1770][INFO    ][9604] Running state [amqp_client] at time 01:20:30.421934
2018-10-15 01:20:30,422 [salt.state       :1803][INFO    ][9604] Executing state rabbitmq_plugin.enabled for [amqp_client]
2018-10-15 01:20:30,423 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9604] Executing command ['/usr/sbin/rabbitmq-plugins', 'list', '-m', '-e'] as user 'root' in directory '/root'
2018-10-15 01:20:31,458 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9604] Executing command ['/usr/sbin/rabbitmq-plugins', 'enable', 'amqp_client'] as user 'root' in directory '/root'
2018-10-15 01:20:32,706 [salt.state       :290 ][INFO    ][9604] {'new': 'amqp_client', 'old': ''}
2018-10-15 01:20:32,707 [salt.state       :1941][INFO    ][9604] Completed state [amqp_client] at time 01:20:32.707543 duration_in_ms=2285.607
2018-10-15 01:20:32,709 [salt.state       :1770][INFO    ][9604] Running state [rabbitmq_management] at time 01:20:32.709658
2018-10-15 01:20:32,710 [salt.state       :1803][INFO    ][9604] Executing state rabbitmq_plugin.enabled for [rabbitmq_management]
2018-10-15 01:20:32,711 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9604] Executing command ['/usr/sbin/rabbitmq-plugins', 'list', '-m', '-e'] as user 'root' in directory '/root'
2018-10-15 01:20:33,816 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9604] Executing command ['/usr/sbin/rabbitmq-plugins', 'enable', 'rabbitmq_management'] as user 'root' in directory '/root'
2018-10-15 01:20:34,380 [salt.minion      :1307][INFO    ][2938] User sudo_ubuntu Executing command saltutil.find_job with jid 20181015012034364151
2018-10-15 01:20:34,396 [salt.minion      :1431][INFO    ][12515] Starting a new job with PID 12515
2018-10-15 01:20:34,413 [salt.minion      :1708][INFO    ][12515] Returning information for job: 20181015012034364151
2018-10-15 01:20:35,704 [salt.state       :290 ][INFO    ][9604] {'new': 'rabbitmq_management', 'old': ''}
2018-10-15 01:20:35,705 [salt.state       :1941][INFO    ][9604] Completed state [rabbitmq_management] at time 01:20:35.704963 duration_in_ms=2995.305
2018-10-15 01:20:35,708 [salt.state       :1770][INFO    ][9604] Running state [/openstack] at time 01:20:35.708783
2018-10-15 01:20:35,709 [salt.state       :1803][INFO    ][9604] Executing state rabbitmq_vhost.present for [/openstack]
2018-10-15 01:20:35,710 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9604] Executing command ['/usr/sbin/rabbitmqctl', 'list_vhosts', '-q'] as user 'root' in directory '/root'
2018-10-15 01:20:36,780 [salt.state       :290 ][INFO    ][9604] Virtual Host '/openstack' already exists.
2018-10-15 01:20:36,780 [salt.state       :1941][INFO    ][9604] Completed state [/openstack] at time 01:20:36.780739 duration_in_ms=1071.955
2018-10-15 01:20:36,784 [salt.state       :1770][INFO    ][9604] Running state [openstack] at time 01:20:36.784823
2018-10-15 01:20:36,785 [salt.state       :1803][INFO    ][9604] Executing state rabbitmq_user.present for [openstack]
2018-10-15 01:20:36,785 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9604] Executing command ['/usr/sbin/rabbitmqctl', 'list_users', '-q'] as user 'root' in directory '/root'
2018-10-15 01:20:37,885 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9604] Executing command ['/usr/sbin/rabbitmqctl', 'status'] as user 'root' in directory '/root'
2018-10-15 01:20:41,298 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9604] Executing command ['/usr/sbin/rabbitmqctl', 'list_user_permissions', 'openstack', '-q'] as user 'root' in directory '/root'
2018-10-15 01:20:42,395 [salt.state       :290 ][INFO    ][9604] Made the following changes:
'password' changed from 'absent' to 'Set password.'

2018-10-15 01:20:42,396 [salt.state       :1941][INFO    ][9604] Completed state [openstack] at time 01:20:42.395891 duration_in_ms=5611.066
2018-10-15 01:20:42,399 [salt.state       :1770][INFO    ][9604] Running state [Ceilometer] at time 01:20:42.399088
2018-10-15 01:20:42,400 [salt.state       :1803][INFO    ][9604] Executing state rabbitmq_policy.present for [Ceilometer]
2018-10-15 01:20:42,401 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9604] Executing command ['/usr/sbin/rabbitmqctl', 'list_policies', '-q', '-p', '/openstack'] as user 'root' in directory '/root'
2018-10-15 01:20:43,466 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9604] Executing command ['/usr/sbin/rabbitmqctl', 'set_policy', '-p', '/openstack', '--priority', 10, 'Ceilometer', '^metering.sample$', '{"ha-mode": "all", "message-ttl": 10800000}'] as user 'root' in directory '/root'
2018-10-15 01:20:44,403 [salt.minion      :1307][INFO    ][2938] User sudo_ubuntu Executing command saltutil.find_job with jid 20181015012044390132
2018-10-15 01:20:44,418 [salt.minion      :1431][INFO    ][14521] Starting a new job with PID 14521
2018-10-15 01:20:44,438 [salt.minion      :1708][INFO    ][14521] Returning information for job: 20181015012044390132
2018-10-15 01:20:44,645 [salt.state       :290 ][INFO    ][9604] {'new': ['Definition'], 'old': {'apply_to': 'all', 'priority': '10', 'definition': '{"ha-mode":"all","message-ttl":10800000}', 'pattern': '^metering.sample$'}}
2018-10-15 01:20:44,646 [salt.state       :1941][INFO    ][9604] Completed state [Ceilometer] at time 01:20:44.646062 duration_in_ms=2246.973
2018-10-15 01:20:44,647 [salt.state       :1770][INFO    ][9604] Running state [HA] at time 01:20:44.647199
2018-10-15 01:20:44,648 [salt.state       :1803][INFO    ][9604] Executing state rabbitmq_policy.present for [HA]
2018-10-15 01:20:44,649 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9604] Executing command ['/usr/sbin/rabbitmqctl', 'list_policies', '-q', '-p', '/openstack'] as user 'root' in directory '/root'
2018-10-15 01:20:45,760 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9604] Executing command ['/usr/sbin/rabbitmqctl', 'set_policy', '-p', '/openstack', 'HA', '^(?!amq\\.).*', '{"ha-mode": "all", "message-ttl": 120000}'] as user 'root' in directory '/root'
2018-10-15 01:20:46,870 [salt.state       :290 ][INFO    ][9604] {'new': ['Pattern', 'Definition'], 'old': {'apply_to': 'all', 'priority': '0', 'definition': '{"ha-mode":"all","message-ttl":120000}', 'pattern': '^(?!amq\\\\.).*'}}
2018-10-15 01:20:46,871 [salt.state       :1941][INFO    ][9604] Completed state [HA] at time 01:20:46.871514 duration_in_ms=2224.313
2018-10-15 01:20:46,872 [salt.state       :1770][INFO    ][9604] Running state [guest] at time 01:20:46.872083
2018-10-15 01:20:46,872 [salt.state       :1803][INFO    ][9604] Executing state rabbitmq_user.present for [guest]
2018-10-15 01:20:46,874 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9604] Executing command ['/usr/sbin/rabbitmqctl', 'list_users', '-q'] as user 'root' in directory '/root'
2018-10-15 01:20:47,967 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9604] Executing command ['/usr/sbin/rabbitmqctl', 'status'] as user 'root' in directory '/root'
2018-10-15 01:20:51,367 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9604] Executing command ['/usr/sbin/rabbitmqctl', 'list_user_permissions', 'guest', '-q'] as user 'root' in directory '/root'
2018-10-15 01:20:52,465 [salt.state       :290 ][INFO    ][9604] Made the following changes:
'password' changed from 'absent' to 'Set password.'

2018-10-15 01:20:52,466 [salt.state       :1941][INFO    ][9604] Completed state [guest] at time 01:20:52.466157 duration_in_ms=5594.073
2018-10-15 01:20:52,467 [salt.state       :1770][INFO    ][9604] Running state [HA] at time 01:20:52.467185
2018-10-15 01:20:52,467 [salt.state       :1803][INFO    ][9604] Executing state rabbitmq_policy.present for [HA]
2018-10-15 01:20:52,469 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9604] Executing command ['/usr/sbin/rabbitmqctl', 'list_policies', '-q', '-p', '/'] as user 'root' in directory '/root'
2018-10-15 01:20:53,572 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9604] Executing command ['/usr/sbin/rabbitmqctl', 'set_policy', '-p', '/', 'HA', '^(?!amq\\.).*', '{"ha-mode": "all", "message-ttl": 120000}'] as user 'root' in directory '/root'
2018-10-15 01:20:54,641 [salt.minion      :1307][INFO    ][2938] User sudo_ubuntu Executing command saltutil.find_job with jid 20181015012054619293
2018-10-15 01:20:54,656 [salt.minion      :1431][INFO    ][16727] Starting a new job with PID 16727
2018-10-15 01:20:54,672 [salt.minion      :1708][INFO    ][16727] Returning information for job: 20181015012054619293
2018-10-15 01:20:54,696 [salt.state       :290 ][INFO    ][9604] {'new': ['Pattern', 'Definition'], 'old': {'apply_to': 'all', 'priority': '0', 'definition': '{"ha-mode":"all","message-ttl":120000}', 'pattern': '^(?!amq\\\\.).*'}}
2018-10-15 01:20:54,697 [salt.state       :1941][INFO    ][9604] Completed state [HA] at time 01:20:54.697526 duration_in_ms=2230.34
2018-10-15 01:20:54,698 [salt.state       :1770][INFO    ][9604] Running state [admin] at time 01:20:54.698578
2018-10-15 01:20:54,699 [salt.state       :1803][INFO    ][9604] Executing state rabbitmq_user.present for [admin]
2018-10-15 01:20:54,700 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9604] Executing command ['/usr/sbin/rabbitmqctl', 'list_users', '-q'] as user 'root' in directory '/root'
2018-10-15 01:20:55,809 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9604] Executing command ['/usr/sbin/rabbitmqctl', 'status'] as user 'root' in directory '/root'
2018-10-15 01:20:59,145 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9604] Executing command ['/usr/sbin/rabbitmqctl', 'list_users', '-q'] as user 'root' in directory '/root'
2018-10-15 01:21:00,250 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9604] Executing command ['/usr/sbin/rabbitmqctl', 'list_user_permissions', 'admin', '-q'] as user 'root' in directory '/root'
2018-10-15 01:21:01,381 [salt.state       :290 ][INFO    ][9604] Made the following changes:
'password' changed from 'absent' to 'Set password.'

2018-10-15 01:21:01,382 [salt.state       :1941][INFO    ][9604] Completed state [admin] at time 01:21:01.382203 duration_in_ms=6683.624
2018-10-15 01:21:01,385 [salt.state       :1770][INFO    ][9604] Running state [rabbit@master] at time 01:21:01.385167
2018-10-15 01:21:01,385 [salt.state       :1803][INFO    ][9604] Executing state rabbitmq_cluster.join for [rabbit@master]
2018-10-15 01:21:01,386 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9604] Executing command ['/usr/sbin/rabbitmqctl', 'cluster_status'] as user 'root' in directory '/root'
2018-10-15 01:21:02,582 [salt.state       :290 ][INFO    ][9604] Already in cluster
2018-10-15 01:21:02,584 [salt.state       :1941][INFO    ][9604] Completed state [rabbit@master] at time 01:21:02.583670 duration_in_ms=1198.502
2018-10-15 01:21:02,587 [salt.minion      :1708][INFO    ][9604] Returning information for job: 20181015011832846879
2018-10-15 01:21:25,822 [salt.minion      :1307][INFO    ][2938] User sudo_ubuntu Executing command cmd.run with jid 20181015012125809482
2018-10-15 01:21:25,845 [salt.minion      :1431][INFO    ][18456] Starting a new job with PID 18456
2018-10-15 01:21:25,855 [salt.loader.192.168.11.2.int.module.cmdmod:395 ][INFO    ][18456] Executing command 'rabbitmqctl cluster_status' in directory '/root'
2018-10-15 01:21:26,914 [salt.minion      :1708][INFO    ][18456] Returning information for job: 20181015012125809482
2018-10-15 01:28:57,580 [salt.minion      :1307][INFO    ][2938] User sudo_ubuntu Executing command state.sls with jid 20181015012857570734
2018-10-15 01:28:57,607 [salt.minion      :1431][INFO    ][18779] Starting a new job with PID 18779
2018-10-15 01:28:59,181 [salt.state       :905 ][INFO    ][18779] Loading fresh modules for state activity
2018-10-15 01:28:59,239 [salt.fileclient  :1215][INFO    ][18779] Fetching file from saltenv 'base', ** done ** 'haproxy/init.sls'
2018-10-15 01:28:59,274 [salt.fileclient  :1215][INFO    ][18779] Fetching file from saltenv 'base', ** done ** 'haproxy/proxy.sls'
2018-10-15 01:29:00,030 [salt.state       :1770][INFO    ][18779] Running state [haproxy] at time 01:29:00.030583
2018-10-15 01:29:00,031 [salt.state       :1803][INFO    ][18779] Executing state pkg.installed for [haproxy]
2018-10-15 01:29:00,032 [salt.loaded.int.module.cmdmod:395 ][INFO    ][18779] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}', '-W'] in directory '/root'
2018-10-15 01:29:00,434 [salt.loaded.int.module.cmdmod:395 ][INFO    ][18779] Executing command ['apt-cache', '-q', 'policy', 'haproxy'] in directory '/root'
2018-10-15 01:29:00,543 [salt.loaded.int.module.cmdmod:395 ][INFO    ][18779] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2018-10-15 01:29:02,965 [salt.loaded.int.module.cmdmod:395 ][INFO    ][18779] Executing command ['dpkg', '--get-selections', '*'] in directory '/root'
2018-10-15 01:29:02,992 [salt.loaded.int.module.cmdmod:395 ][INFO    ][18779] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'haproxy'] in directory '/root'
2018-10-15 01:29:07,432 [salt.loaded.int.module.cmdmod:395 ][INFO    ][18779] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}', '-W'] in directory '/root'
2018-10-15 01:29:07,473 [salt.state       :290 ][INFO    ][18779] Made the following changes:
'haproxy' changed from 'absent' to '1.6.3-1ubuntu0.1'
'liblua5.3-0' changed from 'absent' to '5.3.1-1ubuntu2'

2018-10-15 01:29:07,496 [salt.state       :905 ][INFO    ][18779] Loading fresh modules for state activity
2018-10-15 01:29:07,536 [salt.state       :1941][INFO    ][18779] Completed state [haproxy] at time 01:29:07.536574 duration_in_ms=7505.992
2018-10-15 01:29:07,543 [salt.state       :1770][INFO    ][18779] Running state [/etc/default/haproxy] at time 01:29:07.543876
2018-10-15 01:29:07,544 [salt.state       :1803][INFO    ][18779] Executing state file.managed for [/etc/default/haproxy]
2018-10-15 01:29:07,579 [salt.fileclient  :1215][INFO    ][18779] Fetching file from saltenv 'base', ** done ** 'haproxy/files/haproxy.default'
2018-10-15 01:29:07,582 [salt.state       :290 ][INFO    ][18779] File changed:
--- 
+++ 
@@ -1,10 +1,5 @@
-# Defaults file for HAProxy
-#
-# This is sourced by both, the initscript and the systemd unit file, so do not
-# treat it as a shell script fragment.
 
-# Change the config file location if needed
-#CONFIG="/etc/haproxy/haproxy.cfg"
-
-# Add extra flags here, see haproxy(1) for a few options
+# Set ENABLED to 1 if you want the init script to start haproxy.
+ENABLED=1
+# Add extra flags here.
 #EXTRAOPTS="-de -m 16"

2018-10-15 01:29:07,583 [salt.state       :1941][INFO    ][18779] Completed state [/etc/default/haproxy] at time 01:29:07.583165 duration_in_ms=39.288
2018-10-15 01:29:07,583 [salt.state       :1770][INFO    ][18779] Running state [/etc/haproxy/haproxy.cfg] at time 01:29:07.583480
2018-10-15 01:29:07,584 [salt.state       :1803][INFO    ][18779] Executing state file.managed for [/etc/haproxy/haproxy.cfg]
2018-10-15 01:29:07,607 [salt.fileclient  :1215][INFO    ][18779] Fetching file from saltenv 'base', ** done ** 'haproxy/files/haproxy.cfg'
2018-10-15 01:29:07,810 [salt.state       :290 ][INFO    ][18779] File changed:
--- 
+++ 
@@ -1,35 +1,49 @@
 global
-	log /dev/log	local0
-	log /dev/log	local1 notice
-	chroot /var/lib/haproxy
-	stats socket /run/haproxy/admin.sock mode 660 level admin
-	stats timeout 30s
-	user haproxy
-	group haproxy
-	daemon
-
-	# Default SSL material locations
-	ca-base /etc/ssl/certs
-	crt-base /etc/ssl/private
-
-	# Default ciphers to use on SSL-enabled listening sockets.
-	# For more information, see ciphers(1SSL). This list is from:
-	#  https://hynek.me/articles/hardening-your-web-servers-ssl-ciphers/
-	ssl-default-bind-ciphers ECDH+AESGCM:DH+AESGCM:ECDH+AES256:DH+AES256:ECDH+AES128:DH+AES:ECDH+3DES:DH+3DES:RSA+AESGCM:RSA+AES:RSA+3DES:!aNULL:!MD5:!DSS
-	ssl-default-bind-options no-sslv3
+  log /dev/log  local0
+  log /dev/log  local1 notice
+  chroot /var/lib/haproxy
+  stats  socket /run/haproxy/admin.sock mode 660 level admin
+  stats timeout 30s
+  user  haproxy
+  group haproxy
+  daemon
+  pidfile  /var/run/haproxy.pid
+  spread-checks 4
+  tune.maxrewrite 1024
+  tune.bufsize 32768
+  maxconn  16000
+  # SSL options
+  ca-base /etc/haproxy/ssl
+  crt-base /etc/haproxy/ssl
+  tune.ssl.default-dh-param 2048
+  ssl-default-bind-ciphers ECDHE-ECDSA-CHACHA20-POLY1305:ECDHE-RSA-CHACHA20-POLY1305:ECDHE-ECDSA-AES128-GCM-SHA256:ECDHE-RSA-AES128-GCM-SHA256:ECDHE-ECDSA-AES256-GCM-SHA384:ECDHE-RSA-AES256-GCM-SHA384:DHE-RSA-AES128-GCM-SHA256:DHE-RSA-AES256-GCM-SHA384:ECDHE-ECDSA-AES128-SHA256:ECDHE-RSA-AES128-SHA256:ECDHE-ECDSA-AES128-SHA:ECDHE-RSA-AES256-SHA384:ECDHE-RSA-AES128-SHA:ECDHE-ECDSA-AES256-SHA384:ECDHE-ECDSA-AES256-SHA:ECDHE-RSA-AES256-SHA:DHE-RSA-AES128-SHA256:DHE-RSA-AES128-SHA:DHE-RSA-AES256-SHA256:DHE-RSA-AES256-SHA:ECDHE-ECDSA-DES-CBC3-SHA:ECDHE-RSA-DES-CBC3-SHA:EDH-RSA-DES-CBC3-SHA:AES128-GCM-SHA256:AES256-GCM-SHA384:AES128-SHA256:AES256-SHA256:AES128-SHA:AES256-SHA:DES-CBC3-SHA:!DSS
+  ssl-default-bind-options no-sslv3 no-tls-tickets
+  ssl-default-server-ciphers ECDHE-ECDSA-CHACHA20-POLY1305:ECDHE-RSA-CHACHA20-POLY1305:ECDHE-ECDSA-AES128-GCM-SHA256:ECDHE-RSA-AES128-GCM-SHA256:ECDHE-ECDSA-AES256-GCM-SHA384:ECDHE-RSA-AES256-GCM-SHA384:DHE-RSA-AES128-GCM-SHA256:DHE-RSA-AES256-GCM-SHA384:ECDHE-ECDSA-AES128-SHA256:ECDHE-RSA-AES128-SHA256:ECDHE-ECDSA-AES128-SHA:ECDHE-RSA-AES256-SHA384:ECDHE-RSA-AES128-SHA:ECDHE-ECDSA-AES256-SHA384:ECDHE-ECDSA-AES256-SHA:ECDHE-RSA-AES256-SHA:DHE-RSA-AES128-SHA256:DHE-RSA-AES128-SHA:DHE-RSA-AES256-SHA256:DHE-RSA-AES256-SHA:ECDHE-ECDSA-DES-CBC3-SHA:ECDHE-RSA-DES-CBC3-SHA:EDH-RSA-DES-CBC3-SHA:AES128-GCM-SHA256:AES256-GCM-SHA384:AES128-SHA256:AES256-SHA256:AES128-SHA:AES256-SHA:DES-CBC3-SHA:!DSS
+  ssl-default-server-options no-sslv3 no-tls-tickets
 
 defaults
-	log	global
-	mode	http
-	option	httplog
-	option	dontlognull
-        timeout connect 5000
-        timeout client  50000
-        timeout server  50000
-	errorfile 400 /etc/haproxy/errors/400.http
-	errorfile 403 /etc/haproxy/errors/403.http
-	errorfile 408 /etc/haproxy/errors/408.http
-	errorfile 500 /etc/haproxy/errors/500.http
-	errorfile 502 /etc/haproxy/errors/502.http
-	errorfile 503 /etc/haproxy/errors/503.http
-	errorfile 504 /etc/haproxy/errors/504.http
+  log  global
+  mode http
+
+  maxconn 8000
+  option  redispatch
+  retries  3
+  stats  enable
+
+  timeout http-request 10s
+  timeout queue 1m
+  timeout connect 10s
+  timeout client 1m
+  timeout server 1m
+  timeout check 10s
+
+listen rabbitmq_cluster
+  bind 192.168.10.27:5672 
+  balance roundrobin
+  mode tcp
+  option tcpka
+  timeout client 300s
+  timeout server 300s
+  server msg01 192.168.10.28:5672 check inter 5000 rise 2 fall 3
+  server msg02 192.168.10.29:5672 backup check inter 5000 rise 2 fall 3
+  server msg03 192.168.10.30:5672 backup check inter 5000 rise 2 fall 3

2018-10-15 01:29:07,816 [salt.state       :1941][INFO    ][18779] Completed state [/etc/haproxy/haproxy.cfg] at time 01:29:07.816419 duration_in_ms=232.939
2018-10-15 01:29:07,816 [salt.state       :1770][INFO    ][18779] Running state [/etc/haproxy/ssl] at time 01:29:07.816766
2018-10-15 01:29:07,817 [salt.state       :1803][INFO    ][18779] Executing state file.directory for [/etc/haproxy/ssl]
2018-10-15 01:29:07,820 [salt.state       :290 ][INFO    ][18779] {'/etc/haproxy/ssl': 'New Dir'}
2018-10-15 01:29:07,820 [salt.state       :1941][INFO    ][18779] Completed state [/etc/haproxy/ssl] at time 01:29:07.820488 duration_in_ms=3.722
2018-10-15 01:29:07,820 [salt.state       :1770][INFO    ][18779] Running state [/etc/haproxy/errors/429.http11] at time 01:29:07.820771
2018-10-15 01:29:07,821 [salt.state       :1803][INFO    ][18779] Executing state file.managed for [/etc/haproxy/errors/429.http11]
2018-10-15 01:29:07,840 [salt.fileclient  :1215][INFO    ][18779] Fetching file from saltenv 'base', ** done ** 'haproxy/files/errors/429.http11'
2018-10-15 01:29:07,850 [salt.state       :290 ][INFO    ][18779] File changed:
New file
2018-10-15 01:29:07,850 [salt.state       :1941][INFO    ][18779] Completed state [/etc/haproxy/errors/429.http11] at time 01:29:07.850244 duration_in_ms=29.473
2018-10-15 01:29:07,851 [salt.state       :1770][INFO    ][18779] Running state [haproxy_status_packages] at time 01:29:07.851452
2018-10-15 01:29:07,851 [salt.state       :1803][INFO    ][18779] Executing state pkg.installed for [haproxy_status_packages]
2018-10-15 01:29:08,199 [salt.minion      :1307][INFO    ][2938] User sudo_ubuntu Executing command saltutil.find_job with jid 20181015012907674518
2018-10-15 01:29:08,216 [salt.minion      :1431][INFO    ][19722] Starting a new job with PID 19722
2018-10-15 01:29:08,239 [salt.minion      :1708][INFO    ][19722] Returning information for job: 20181015012907674518
2018-10-15 01:29:08,686 [salt.state       :290 ][INFO    ][18779] All specified packages are already installed
2018-10-15 01:29:08,687 [salt.state       :1941][INFO    ][18779] Completed state [haproxy_status_packages] at time 01:29:08.687456 duration_in_ms=836.004
2018-10-15 01:29:08,688 [salt.state       :1770][INFO    ][18779] Running state [/usr/bin/haproxy-status.sh] at time 01:29:08.688226
2018-10-15 01:29:08,688 [salt.state       :1803][INFO    ][18779] Executing state file.managed for [/usr/bin/haproxy-status.sh]
2018-10-15 01:29:08,706 [salt.fileclient  :1215][INFO    ][18779] Fetching file from saltenv 'base', ** done ** 'haproxy/files/haproxy-status.sh'
2018-10-15 01:29:08,735 [salt.state       :290 ][INFO    ][18779] File changed:
New file
2018-10-15 01:29:08,735 [salt.state       :1941][INFO    ][18779] Completed state [/usr/bin/haproxy-status.sh] at time 01:29:08.735801 duration_in_ms=47.576
2018-10-15 01:29:08,736 [salt.state       :1770][INFO    ][18779] Running state [net.ipv4.ip_nonlocal_bind] at time 01:29:08.736361
2018-10-15 01:29:08,736 [salt.state       :1803][INFO    ][18779] Executing state sysctl.present for [net.ipv4.ip_nonlocal_bind]
2018-10-15 01:29:08,738 [salt.loaded.int.module.cmdmod:395 ][INFO    ][18779] Executing command 'sysctl -w net.ipv4.ip_nonlocal_bind="1"' in directory '/root'
2018-10-15 01:29:08,757 [salt.state       :290 ][INFO    ][18779] {'net.ipv4.ip_nonlocal_bind': 1}
2018-10-15 01:29:08,758 [salt.state       :1941][INFO    ][18779] Completed state [net.ipv4.ip_nonlocal_bind] at time 01:29:08.758357 duration_in_ms=21.996
2018-10-15 01:29:08,760 [salt.state       :1770][INFO    ][18779] Running state [haproxy] at time 01:29:08.760766
2018-10-15 01:29:08,761 [salt.state       :1803][INFO    ][18779] Executing state service.running for [haproxy]
2018-10-15 01:29:08,761 [salt.loaded.int.module.cmdmod:395 ][INFO    ][18779] Executing command ['systemctl', 'status', 'haproxy.service', '-n', '0'] in directory '/root'
2018-10-15 01:29:08,782 [salt.loaded.int.module.cmdmod:395 ][INFO    ][18779] Executing command ['systemctl', 'is-active', 'haproxy.service'] in directory '/root'
2018-10-15 01:29:08,797 [salt.loaded.int.module.cmdmod:395 ][INFO    ][18779] Executing command ['systemctl', 'is-enabled', 'haproxy.service'] in directory '/root'
2018-10-15 01:29:08,814 [salt.state       :290 ][INFO    ][18779] The service haproxy is already running
2018-10-15 01:29:08,814 [salt.state       :1941][INFO    ][18779] Completed state [haproxy] at time 01:29:08.814379 duration_in_ms=53.612
2018-10-15 01:29:08,814 [salt.state       :1770][INFO    ][18779] Running state [haproxy] at time 01:29:08.814661
2018-10-15 01:29:08,815 [salt.state       :1803][INFO    ][18779] Executing state service.mod_watch for [haproxy]
2018-10-15 01:29:08,815 [salt.loaded.int.module.cmdmod:395 ][INFO    ][18779] Executing command ['systemctl', 'is-active', 'haproxy.service'] in directory '/root'
2018-10-15 01:29:08,832 [salt.loaded.int.module.cmdmod:395 ][INFO    ][18779] Executing command ['systemd-run', '--scope', 'systemctl', 'restart', 'haproxy.service'] in directory '/root'
2018-10-15 01:29:08,896 [salt.state       :290 ][INFO    ][18779] {'haproxy': True}
2018-10-15 01:29:08,897 [salt.state       :1941][INFO    ][18779] Completed state [haproxy] at time 01:29:08.897400 duration_in_ms=82.738
2018-10-15 01:29:08,900 [salt.minion      :1708][INFO    ][18779] Returning information for job: 20181015012857570734
2018-10-15 01:29:15,191 [salt.minion      :1307][INFO    ][2938] User sudo_ubuntu Executing command service.status with jid 20181015012915180260
2018-10-15 01:29:15,223 [salt.minion      :1431][INFO    ][19788] Starting a new job with PID 19788
2018-10-15 01:29:15,715 [salt.loader.192.168.11.2.int.module.cmdmod:395 ][INFO    ][19788] Executing command ['systemctl', 'status', 'haproxy.service', '-n', '0'] in directory '/root'
2018-10-15 01:29:15,735 [salt.loader.192.168.11.2.int.module.cmdmod:395 ][INFO    ][19788] Executing command ['systemctl', 'is-active', 'haproxy.service'] in directory '/root'
2018-10-15 01:29:15,754 [salt.minion      :1708][INFO    ][19788] Returning information for job: 20181015012915180260
2018-10-15 01:29:17,087 [salt.minion      :1307][INFO    ][2938] User sudo_ubuntu Executing command service.restart with jid 20181015012917072506
2018-10-15 01:29:17,111 [salt.minion      :1431][INFO    ][19798] Starting a new job with PID 19798
2018-10-15 01:29:17,582 [salt.loader.192.168.11.2.int.module.cmdmod:395 ][INFO    ][19798] Executing command ['systemctl', 'status', 'rsyslog.service', '-n', '0'] in directory '/root'
2018-10-15 01:29:17,631 [salt.loader.192.168.11.2.int.module.cmdmod:395 ][INFO    ][19798] Executing command ['systemd-run', '--scope', 'systemctl', 'restart', 'rsyslog.service'] in directory '/root'
2018-10-15 01:29:17,674 [salt.minion      :1708][INFO    ][19798] Returning information for job: 20181015012917072506
2018-10-15 02:08:12,094 [salt.utils.schedule:1375][INFO    ][2938] Running scheduled job: __mine_interval
2018-10-15 02:10:17,036 [salt.minion      :1307][INFO    ][2938] User sudo_ubuntu Executing command cp.push_dir with jid 20181015021017024785
2018-10-15 02:10:17,066 [salt.minion      :1431][INFO    ][20440] Starting a new job with PID 20440
