2018-10-06 14:29:31,561 [salt.loaded.int.module.cmdmod:722 ][ERROR   ][1870] Command 'rabbitmqctl cluster_status' failed with return code: 127
2018-10-06 14:29:31,562 [salt.loaded.int.module.cmdmod:724 ][ERROR   ][1870] stdout: /bin/sh: 1: rabbitmqctl: not found
2018-10-06 14:29:31,563 [salt.loaded.int.module.cmdmod:728 ][ERROR   ][1870] retcode: 127
2018-10-06 14:29:31,589 [salt.loaded.int.module.cmdmod:722 ][ERROR   ][1870] Command 'rabbitmqctl cluster_status' failed with return code: 127
2018-10-06 14:29:31,590 [salt.loaded.int.module.cmdmod:724 ][ERROR   ][1870] stdout: /bin/sh: 1: rabbitmqctl: not found
2018-10-06 14:29:31,590 [salt.loaded.int.module.cmdmod:728 ][ERROR   ][1870] retcode: 127
2018-10-06 14:29:33,228 [salt.loaded.int.module.cmdmod:722 ][ERROR   ][1870] Command 'rabbitmqctl cluster_status' failed with return code: 127
2018-10-06 14:29:33,228 [salt.loaded.int.module.cmdmod:724 ][ERROR   ][1870] stdout: /bin/sh: 1: rabbitmqctl: not found
2018-10-06 14:29:33,229 [salt.loaded.int.module.cmdmod:728 ][ERROR   ][1870] retcode: 127
2018-10-06 14:29:33,256 [salt.loaded.int.module.cmdmod:722 ][ERROR   ][1870] Command 'rabbitmqctl cluster_status' failed with return code: 127
2018-10-06 14:29:33,257 [salt.loaded.int.module.cmdmod:724 ][ERROR   ][1870] stdout: /bin/sh: 1: rabbitmqctl: not found
2018-10-06 14:29:33,257 [salt.loaded.int.module.cmdmod:728 ][ERROR   ][1870] retcode: 127
2018-10-06 14:29:50,174 [salt.utils.decorators:613 ][WARNING ][1870] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2018-10-06 14:29:53,848 [salt.loaded.int.module.cmdmod:395 ][INFO    ][2928] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2018-10-06 14:29:53,876 [salt.loaded.int.module.cmdmod:395 ][INFO    ][2928] Executing command ['systemd-run', '--scope', 'systemctl', 'restart', 'salt-minion.service'] in directory '/root'
2018-10-06 14:29:53,897 [salt.utils.parsers:1051][WARNING ][1539] Minion received a SIGTERM. Exiting.
2018-10-06 14:29:54,805 [salt.cli.daemons :293 ][INFO    ][2981] Setting up the Salt Minion "msg03.mcp-pike-odl-ha.local"
2018-10-06 14:29:54,919 [salt.cli.daemons :82  ][INFO    ][2981] Starting up the Salt Minion
2018-10-06 14:29:54,920 [salt.utils.event :1017][INFO    ][2981] Starting pull socket on /var/run/salt/minion/minion_event_932d37fbb0_pull.ipc
2018-10-06 14:29:55,601 [salt.minion      :976 ][INFO    ][2981] Creating minion process manager
2018-10-06 14:29:56,824 [salt.loader.192.168.11.2.int.module.cmdmod:395 ][INFO    ][2981] Executing command ['date', '+%z'] in directory '/root'
2018-10-06 14:29:56,851 [salt.utils.schedule:568 ][INFO    ][2981] Updating job settings for scheduled job: __mine_interval
2018-10-06 14:29:56,853 [salt.minion      :1107][INFO    ][2981] Added mine.update to scheduler
2018-10-06 14:29:56,859 [salt.minion      :1965][INFO    ][2981] Minion is starting as user 'root'
2018-10-06 14:29:56,877 [salt.minion      :2324][INFO    ][2981] Minion is ready to receive requests!
2018-10-06 14:30:19,925 [salt.minion      :1307][INFO    ][2981] User sudo_ubuntu Executing command state.apply with jid 20181006143019913667
2018-10-06 14:30:19,946 [salt.minion      :1431][INFO    ][3070] Starting a new job with PID 3070
2018-10-06 14:30:25,002 [salt.state       :905 ][INFO    ][3070] Loading fresh modules for state activity
2018-10-06 14:30:25,328 [salt.fileclient  :1215][INFO    ][3070] Fetching file from saltenv 'base', ** done ** 'linux/init.sls'
2018-10-06 14:30:25,375 [salt.fileclient  :1215][INFO    ][3070] Fetching file from saltenv 'base', ** done ** 'linux/system/init.sls'
2018-10-06 14:30:25,812 [salt.fileclient  :1215][INFO    ][3070] Fetching file from saltenv 'base', ** done ** 'linux/system/env.sls'
2018-10-06 14:30:25,960 [salt.fileclient  :1215][INFO    ][3070] Fetching file from saltenv 'base', ** done ** 'linux/system/profile.sls'
2018-10-06 14:30:26,104 [salt.fileclient  :1215][INFO    ][3070] Fetching file from saltenv 'base', ** done ** 'linux/system/shell.sls'
2018-10-06 14:30:26,254 [salt.fileclient  :1215][INFO    ][3070] Fetching file from saltenv 'base', ** done ** 'linux/system/at.sls'
2018-10-06 14:30:26,397 [salt.fileclient  :1215][INFO    ][3070] Fetching file from saltenv 'base', ** done ** 'linux/system/cron.sls'
2018-10-06 14:30:26,542 [salt.fileclient  :1215][INFO    ][3070] Fetching file from saltenv 'base', ** done ** 'linux/system/repo.sls'
2018-10-06 14:30:26,806 [salt.fileclient  :1215][INFO    ][3070] Fetching file from saltenv 'base', ** done ** 'linux/system/package.sls'
2018-10-06 14:30:26,951 [salt.fileclient  :1215][INFO    ][3070] Fetching file from saltenv 'base', ** done ** 'linux/system/timezone.sls'
2018-10-06 14:30:27,076 [salt.fileclient  :1215][INFO    ][3070] Fetching file from saltenv 'base', ** done ** 'linux/system/kernel.sls'
2018-10-06 14:30:27,232 [salt.fileclient  :1215][INFO    ][3070] Fetching file from saltenv 'base', ** done ** 'linux/system/grub.sls'
2018-10-06 14:30:27,266 [salt.fileclient  :1215][INFO    ][3070] Fetching file from saltenv 'base', ** done ** 'linux/system/cpu.sls'
2018-10-06 14:30:27,396 [salt.fileclient  :1215][INFO    ][3070] Fetching file from saltenv 'base', ** done ** 'linux/system/sysfs.sls'
2018-10-06 14:30:27,528 [salt.fileclient  :1215][INFO    ][3070] Fetching file from saltenv 'base', ** done ** 'linux/system/locale.sls'
2018-10-06 14:30:27,652 [salt.fileclient  :1215][INFO    ][3070] Fetching file from saltenv 'base', ** done ** 'linux/system/user.sls'
2018-10-06 14:30:27,827 [salt.fileclient  :1215][INFO    ][3070] Fetching file from saltenv 'base', ** done ** 'linux/system/group.sls'
2018-10-06 14:30:27,975 [salt.fileclient  :1215][INFO    ][3070] Fetching file from saltenv 'base', ** done ** 'linux/system/limit.sls'
2018-10-06 14:30:28,116 [salt.fileclient  :1215][INFO    ][3070] Fetching file from saltenv 'base', ** done ** 'linux/system/systemd.sls'
2018-10-06 14:30:28,251 [salt.fileclient  :1215][INFO    ][3070] Fetching file from saltenv 'base', ** done ** 'linux/system/apt.sls'
2018-10-06 14:30:28,389 [salt.fileclient  :1215][INFO    ][3070] Fetching file from saltenv 'base', ** done ** 'linux/system/banner.sls'
2018-10-06 14:30:28,528 [salt.fileclient  :1215][INFO    ][3070] Fetching file from saltenv 'base', ** done ** 'linux/network/init.sls'
2018-10-06 14:30:28,664 [salt.fileclient  :1215][INFO    ][3070] Fetching file from saltenv 'base', ** done ** 'linux/network/hostname.sls'
2018-10-06 14:30:28,810 [salt.fileclient  :1215][INFO    ][3070] Fetching file from saltenv 'base', ** done ** 'linux/network/host.sls'
2018-10-06 14:30:29,071 [salt.fileclient  :1215][INFO    ][3070] Fetching file from saltenv 'base', ** done ** 'linux/network/interface.sls'
2018-10-06 14:30:29,327 [salt.fileclient  :1215][INFO    ][3070] Fetching file from saltenv 'base', ** done ** 'linux/network/proxy.sls'
2018-10-06 14:30:30,300 [salt.minion      :1307][INFO    ][2981] User sudo_ubuntu Executing command saltutil.find_job with jid 20181006143030285260
2018-10-06 14:30:30,302 [salt.fileclient  :1215][INFO    ][3070] Fetching file from saltenv 'base', ** done ** 'linux/storage/init.sls'
2018-10-06 14:30:30,322 [salt.minion      :1431][INFO    ][3131] Starting a new job with PID 3131
2018-10-06 14:30:30,345 [salt.minion      :1708][INFO    ][3131] Returning information for job: 20181006143030285260
2018-10-06 14:30:30,476 [salt.fileclient  :1215][INFO    ][3070] Fetching file from saltenv 'base', ** done ** 'ntp/init.sls'
2018-10-06 14:30:30,501 [salt.fileclient  :1215][INFO    ][3070] Fetching file from saltenv 'base', ** done ** 'ntp/client.sls'
2018-10-06 14:30:30,548 [salt.fileclient  :1215][INFO    ][3070] Fetching file from saltenv 'base', ** done ** 'ntp/server.sls'
2018-10-06 14:30:30,591 [salt.state       :1770][INFO    ][3070] Running state [/etc/environment] at time 14:30:30.591841
2018-10-06 14:30:30,592 [salt.state       :1803][INFO    ][3070] Executing state file.blockreplace for [/etc/environment]
2018-10-06 14:30:30,601 [salt.state       :290 ][INFO    ][3070] 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-06 14:30:30,601 [salt.state       :1941][INFO    ][3070] Completed state [/etc/environment] at time 14:30:30.601388 duration_in_ms=9.546
2018-10-06 14:30:30,601 [salt.state       :1770][INFO    ][3070] Running state [/etc/profile.d] at time 14:30:30.601662
2018-10-06 14:30:30,601 [salt.state       :1803][INFO    ][3070] Executing state file.directory for [/etc/profile.d]
2018-10-06 14:30:30,604 [salt.state       :290 ][INFO    ][3070] Directory /etc/profile.d is in the correct state
Directory /etc/profile.d updated
2018-10-06 14:30:30,605 [salt.state       :1941][INFO    ][3070] Completed state [/etc/profile.d] at time 14:30:30.605034 duration_in_ms=3.372
2018-10-06 14:30:30,606 [salt.state       :1770][INFO    ][3070] Running state [fake_linux_system_at] at time 14:30:30.606504
2018-10-06 14:30:30,606 [salt.state       :1803][INFO    ][3070] Executing state test.nop for [fake_linux_system_at]
2018-10-06 14:30:30,607 [salt.state       :290 ][INFO    ][3070] Success!
2018-10-06 14:30:30,607 [salt.state       :1941][INFO    ][3070] Completed state [fake_linux_system_at] at time 14:30:30.607263 duration_in_ms=0.759
2018-10-06 14:30:30,607 [salt.state       :1770][INFO    ][3070] Running state [fake_linux_system_cron] at time 14:30:30.607535
2018-10-06 14:30:30,607 [salt.state       :1803][INFO    ][3070] Executing state test.nop for [fake_linux_system_cron]
2018-10-06 14:30:30,608 [salt.state       :290 ][INFO    ][3070] Success!
2018-10-06 14:30:30,608 [salt.state       :1941][INFO    ][3070] Completed state [fake_linux_system_cron] at time 14:30:30.608235 duration_in_ms=0.7
2018-10-06 14:30:31,319 [salt.state       :1770][INFO    ][3070] Running state [/etc/apt/apt.conf.d/99prefer_ipv4-salt] at time 14:30:31.319781
2018-10-06 14:30:31,320 [salt.state       :1803][INFO    ][3070] Executing state file.managed for [/etc/apt/apt.conf.d/99prefer_ipv4-salt]
2018-10-06 14:30:31,349 [salt.fileclient  :1215][INFO    ][3070] Fetching file from saltenv 'base', ** done ** 'linux/files/apt.conf'
2018-10-06 14:30:31,366 [salt.state       :290 ][INFO    ][3070] File changed:
New file
2018-10-06 14:30:31,366 [salt.state       :1941][INFO    ][3070] Completed state [/etc/apt/apt.conf.d/99prefer_ipv4-salt] at time 14:30:31.366530 duration_in_ms=46.75
2018-10-06 14:30:31,367 [salt.state       :1770][INFO    ][3070] Running state [/etc/apt/apt.conf.d/99allow_downgrades-salt] at time 14:30:31.367115
2018-10-06 14:30:31,367 [salt.state       :1803][INFO    ][3070] Executing state file.managed for [/etc/apt/apt.conf.d/99allow_downgrades-salt]
2018-10-06 14:30:31,393 [salt.state       :290 ][INFO    ][3070] File changed:
New file
2018-10-06 14:30:31,394 [salt.state       :1941][INFO    ][3070] Completed state [/etc/apt/apt.conf.d/99allow_downgrades-salt] at time 14:30:31.394004 duration_in_ms=26.889
2018-10-06 14:30:31,396 [salt.state       :1770][INFO    ][3070] Running state [linux_repo_prereq_pkgs] at time 14:30:31.396343
2018-10-06 14:30:31,396 [salt.state       :1803][INFO    ][3070] Executing state pkg.installed for [linux_repo_prereq_pkgs]
2018-10-06 14:30:31,397 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3070] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}', '-W'] in directory '/root'
2018-10-06 14:30:31,896 [salt.state       :290 ][INFO    ][3070] All specified packages are already installed
2018-10-06 14:30:31,896 [salt.state       :1941][INFO    ][3070] Completed state [linux_repo_prereq_pkgs] at time 14:30:31.896619 duration_in_ms=500.275
2018-10-06 14:30:31,896 [salt.state       :1770][INFO    ][3070] Running state [/etc/apt/apt.conf.d/99proxies-salt] at time 14:30:31.896943
2018-10-06 14:30:31,897 [salt.state       :1803][INFO    ][3070] Executing state file.managed for [/etc/apt/apt.conf.d/99proxies-salt]
2018-10-06 14:30:31,920 [salt.fileclient  :1215][INFO    ][3070] Fetching file from saltenv 'base', ** done ** 'linux/files/apt.conf.d_proxies'
2018-10-06 14:30:31,937 [salt.state       :290 ][INFO    ][3070] File changed:
New file
2018-10-06 14:30:31,937 [salt.state       :1941][INFO    ][3070] Completed state [/etc/apt/apt.conf.d/99proxies-salt] at time 14:30:31.937391 duration_in_ms=40.448
2018-10-06 14:30:31,937 [salt.state       :1770][INFO    ][3070] Running state [/etc/apt/apt.conf.d/99proxies-salt-mk_openstack] at time 14:30:31.937659
2018-10-06 14:30:31,937 [salt.state       :1803][INFO    ][3070] Executing state file.absent for [/etc/apt/apt.conf.d/99proxies-salt-mk_openstack]
2018-10-06 14:30:31,938 [salt.state       :290 ][INFO    ][3070] File /etc/apt/apt.conf.d/99proxies-salt-mk_openstack is not present
2018-10-06 14:30:31,938 [salt.state       :1941][INFO    ][3070] Completed state [/etc/apt/apt.conf.d/99proxies-salt-mk_openstack] at time 14:30:31.938505 duration_in_ms=0.846
2018-10-06 14:30:31,939 [salt.state       :1770][INFO    ][3070] Running state [/etc/apt/preferences.d/mk_openstack] at time 14:30:31.939050
2018-10-06 14:30:31,939 [salt.state       :1803][INFO    ][3070] Executing state file.managed for [/etc/apt/preferences.d/mk_openstack]
2018-10-06 14:30:31,959 [salt.fileclient  :1215][INFO    ][3070] Fetching file from saltenv 'base', ** done ** 'linux/files/preferences_repo'
2018-10-06 14:30:32,080 [salt.state       :290 ][INFO    ][3070] File changed:
New file
2018-10-06 14:30:32,080 [salt.state       :1941][INFO    ][3070] Completed state [/etc/apt/preferences.d/mk_openstack] at time 14:30:32.080501 duration_in_ms=141.451
2018-10-06 14:30:32,084 [salt.state       :1770][INFO    ][3070] Running state [deb [arch=amd64] http://apt.mirantis.com/xenial/ nightly pike] at time 14:30:32.084870
2018-10-06 14:30:32,085 [salt.state       :1803][INFO    ][3070] Executing state pkgrepo.managed for [deb [arch=amd64] http://apt.mirantis.com/xenial/ nightly pike]
2018-10-06 14:30:32,513 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3070] Executing command ['apt-key', 'add', '/var/cache/salt/minion/extrn_files/base/apt.mirantis.com/public.gpg'] in directory '/root'
2018-10-06 14:30:32,768 [salt.state       :290 ][INFO    ][3070] {'repo': 'deb [arch=amd64] http://apt.mirantis.com/xenial nightly pike'}
2018-10-06 14:30:32,768 [salt.state       :1941][INFO    ][3070] Completed state [deb [arch=amd64] http://apt.mirantis.com/xenial/ nightly pike] at time 14:30:32.768803 duration_in_ms=683.933
2018-10-06 14:30:32,769 [salt.state       :1770][INFO    ][3070] Running state [/etc/apt/apt.conf.d/99proxies-salt-uca-staging] at time 14:30:32.769210
2018-10-06 14:30:32,769 [salt.state       :1803][INFO    ][3070] Executing state file.absent for [/etc/apt/apt.conf.d/99proxies-salt-uca-staging]
2018-10-06 14:30:32,770 [salt.state       :290 ][INFO    ][3070] File /etc/apt/apt.conf.d/99proxies-salt-uca-staging is not present
2018-10-06 14:30:32,770 [salt.state       :1941][INFO    ][3070] Completed state [/etc/apt/apt.conf.d/99proxies-salt-uca-staging] at time 14:30:32.770384 duration_in_ms=1.174
2018-10-06 14:30:32,770 [salt.state       :1770][INFO    ][3070] Running state [/etc/apt/preferences.d/uca-staging] at time 14:30:32.770664
2018-10-06 14:30:32,770 [salt.state       :1803][INFO    ][3070] Executing state file.absent for [/etc/apt/preferences.d/uca-staging]
2018-10-06 14:30:32,771 [salt.state       :290 ][INFO    ][3070] File /etc/apt/preferences.d/uca-staging is not present
2018-10-06 14:30:32,771 [salt.state       :1941][INFO    ][3070] Completed state [/etc/apt/preferences.d/uca-staging] at time 14:30:32.771466 duration_in_ms=0.803
2018-10-06 14:30:32,777 [salt.state       :1770][INFO    ][3070] Running state [apt-key adv --keyserver keyserver.ubuntu.com --recv 9F68104E] at time 14:30:32.777805
2018-10-06 14:30:32,778 [salt.state       :1803][INFO    ][3070] Executing state cmd.run for [apt-key adv --keyserver keyserver.ubuntu.com --recv 9F68104E]
2018-10-06 14:30:32,779 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3070] Executing command 'test -e /etc/apt/sources.list.d/uca-staging.list' in directory '/root'
2018-10-06 14:30:32,793 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3070] Executing command 'apt-key adv --keyserver keyserver.ubuntu.com --recv 9F68104E' in directory '/root'
2018-10-06 14:30:33,011 [salt.state       :290 ][INFO    ][3070] {'pid': 3284, '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.XNFx0jzb6k/gpg.1.sh --keyserver\nkeyserver.ubuntu.com\n--recv\n9F68104E'}
2018-10-06 14:30:33,012 [salt.state       :1941][INFO    ][3070] Completed state [apt-key adv --keyserver keyserver.ubuntu.com --recv 9F68104E] at time 14:30:33.012416 duration_in_ms=234.61
2018-10-06 14:30:33,016 [salt.state       :1770][INFO    ][3070] Running state [deb http://ppa.launchpad.net/ubuntu-cloud-archive/pike-staging/ubuntu xenial main] at time 14:30:33.016839
2018-10-06 14:30:33,017 [salt.state       :1803][INFO    ][3070] Executing state pkgrepo.managed for [deb http://ppa.launchpad.net/ubuntu-cloud-archive/pike-staging/ubuntu xenial main]
2018-10-06 14:30:33,135 [salt.state       :290 ][INFO    ][3070] {'repo': 'deb http://ppa.launchpad.net/ubuntu-cloud-archive/pike-staging/ubuntu xenial main'}
2018-10-06 14:30:33,136 [salt.state       :1941][INFO    ][3070] Completed state [deb http://ppa.launchpad.net/ubuntu-cloud-archive/pike-staging/ubuntu xenial main] at time 14:30:33.136383 duration_in_ms=119.543
2018-10-06 14:30:33,137 [salt.state       :1770][INFO    ][3070] Running state [/etc/apt/apt.conf.d/99proxies-salt-mirantis_openstack] at time 14:30:33.136983
2018-10-06 14:30:33,137 [salt.state       :1803][INFO    ][3070] Executing state file.absent for [/etc/apt/apt.conf.d/99proxies-salt-mirantis_openstack]
2018-10-06 14:30:33,138 [salt.state       :290 ][INFO    ][3070] File /etc/apt/apt.conf.d/99proxies-salt-mirantis_openstack is not present
2018-10-06 14:30:33,139 [salt.state       :1941][INFO    ][3070] Completed state [/etc/apt/apt.conf.d/99proxies-salt-mirantis_openstack] at time 14:30:33.139081 duration_in_ms=2.098
2018-10-06 14:30:33,139 [salt.state       :1770][INFO    ][3070] Running state [/etc/apt/preferences.d/mirantis_openstack] at time 14:30:33.139612
2018-10-06 14:30:33,140 [salt.state       :1803][INFO    ][3070] Executing state file.managed for [/etc/apt/preferences.d/mirantis_openstack]
2018-10-06 14:30:33,273 [salt.state       :290 ][INFO    ][3070] File changed:
New file
2018-10-06 14:30:33,275 [salt.state       :1941][INFO    ][3070] Completed state [/etc/apt/preferences.d/mirantis_openstack] at time 14:30:33.275034 duration_in_ms=135.421
2018-10-06 14:30:33,277 [salt.state       :1770][INFO    ][3070] Running state [deb http://mirror.fuel-infra.org/mcp-repos/pike/xenial pike main] at time 14:30:33.277680
2018-10-06 14:30:33,278 [salt.state       :1803][INFO    ][3070] Executing state pkgrepo.managed for [deb http://mirror.fuel-infra.org/mcp-repos/pike/xenial pike main]
2018-10-06 14:30:33,695 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3070] 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-06 14:30:33,933 [salt.state       :290 ][INFO    ][3070] {'repo': 'deb http://mirror.fuel-infra.org/mcp-repos/pike/xenial pike main'}
2018-10-06 14:30:33,934 [salt.state       :1941][INFO    ][3070] Completed state [deb http://mirror.fuel-infra.org/mcp-repos/pike/xenial pike main] at time 14:30:33.934357 duration_in_ms=656.676
2018-10-06 14:30:33,935 [salt.state       :1770][INFO    ][3070] Running state [/etc/apt/apt.conf.d/99proxies-salt-uca] at time 14:30:33.935028
2018-10-06 14:30:33,935 [salt.state       :1803][INFO    ][3070] Executing state file.absent for [/etc/apt/apt.conf.d/99proxies-salt-uca]
2018-10-06 14:30:33,936 [salt.state       :290 ][INFO    ][3070] File /etc/apt/apt.conf.d/99proxies-salt-uca is not present
2018-10-06 14:30:33,937 [salt.state       :1941][INFO    ][3070] Completed state [/etc/apt/apt.conf.d/99proxies-salt-uca] at time 14:30:33.936952 duration_in_ms=1.924
2018-10-06 14:30:33,937 [salt.state       :1770][INFO    ][3070] Running state [/etc/apt/preferences.d/uca] at time 14:30:33.937458
2018-10-06 14:30:33,938 [salt.state       :1803][INFO    ][3070] Executing state file.managed for [/etc/apt/preferences.d/uca]
2018-10-06 14:30:34,080 [salt.state       :290 ][INFO    ][3070] File changed:
New file
2018-10-06 14:30:34,081 [salt.state       :1941][INFO    ][3070] Completed state [/etc/apt/preferences.d/uca] at time 14:30:34.081881 duration_in_ms=144.423
2018-10-06 14:30:34,087 [salt.state       :1770][INFO    ][3070] Running state [apt-key adv --keyserver keyserver.ubuntu.com --recv EC4926EA] at time 14:30:34.087712
2018-10-06 14:30:34,088 [salt.state       :1803][INFO    ][3070] Executing state cmd.run for [apt-key adv --keyserver keyserver.ubuntu.com --recv EC4926EA]
2018-10-06 14:30:34,089 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3070] Executing command 'test -e /etc/apt/sources.list.d/uca.list' in directory '/root'
2018-10-06 14:30:34,105 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3070] Executing command 'apt-key adv --keyserver keyserver.ubuntu.com --recv EC4926EA' in directory '/root'
2018-10-06 14:30:34,352 [salt.state       :290 ][INFO    ][3070] {'pid': 3565, '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.2JhUpzsSjo/gpg.1.sh --keyserver\nkeyserver.ubuntu.com\n--recv\nEC4926EA'}
2018-10-06 14:30:34,353 [salt.state       :1941][INFO    ][3070] Completed state [apt-key adv --keyserver keyserver.ubuntu.com --recv EC4926EA] at time 14:30:34.353745 duration_in_ms=266.031
2018-10-06 14:30:34,358 [salt.state       :1770][INFO    ][3070] Running state [deb http://ubuntu-cloud.archive.canonical.com/ubuntu xenial-updates/pike main] at time 14:30:34.358025
2018-10-06 14:30:34,360 [salt.state       :1803][INFO    ][3070] Executing state pkgrepo.managed for [deb http://ubuntu-cloud.archive.canonical.com/ubuntu xenial-updates/pike main]
2018-10-06 14:30:34,597 [salt.state       :290 ][INFO    ][3070] {'repo': 'deb http://ubuntu-cloud.archive.canonical.com/ubuntu xenial-updates/pike main'}
2018-10-06 14:30:34,598 [salt.state       :1941][INFO    ][3070] Completed state [deb http://ubuntu-cloud.archive.canonical.com/ubuntu xenial-updates/pike main] at time 14:30:34.598143 duration_in_ms=240.117
2018-10-06 14:30:34,600 [salt.state       :1770][INFO    ][3070] Running state [pkg.refresh_db] at time 14:30:34.600355
2018-10-06 14:30:34,600 [salt.state       :1803][INFO    ][3070] Executing state module.run for [pkg.refresh_db]
2018-10-06 14:30:34,601 [salt.utils.decorators:613 ][WARNING ][3070] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2018-10-06 14:30:34,602 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3070] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2018-10-06 14:30:39,391 [salt.state       :290 ][INFO    ][3070] {'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-06 14:30:39,392 [salt.state       :1941][INFO    ][3070] Completed state [pkg.refresh_db] at time 14:30:39.392813 duration_in_ms=4792.457
2018-10-06 14:30:39,394 [salt.state       :1770][INFO    ][3070] Running state [UTC] at time 14:30:39.394521
2018-10-06 14:30:39,394 [salt.state       :1803][INFO    ][3070] Executing state timezone.system for [UTC]
2018-10-06 14:30:39,396 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3070] Executing command ['timedatectl'] in directory '/root'
2018-10-06 14:30:39,439 [salt.state       :290 ][INFO    ][3070] Timezone UTC already set, UTC already set to UTC
2018-10-06 14:30:39,439 [salt.state       :1941][INFO    ][3070] Completed state [UTC] at time 14:30:39.439484 duration_in_ms=44.963
2018-10-06 14:30:39,440 [salt.state       :1770][INFO    ][3070] Running state [/etc/default/grub.d] at time 14:30:39.439959
2018-10-06 14:30:39,440 [salt.state       :1803][INFO    ][3070] Executing state file.directory for [/etc/default/grub.d]
2018-10-06 14:30:39,441 [salt.state       :290 ][INFO    ][3070] Directory /etc/default/grub.d is in the correct state
Directory /etc/default/grub.d updated
2018-10-06 14:30:39,441 [salt.state       :1941][INFO    ][3070] Completed state [/etc/default/grub.d] at time 14:30:39.441943 duration_in_ms=1.984
2018-10-06 14:30:39,442 [salt.state       :1770][INFO    ][3070] Running state [update-grub] at time 14:30:39.442213
2018-10-06 14:30:39,442 [salt.state       :1803][INFO    ][3070] Executing state cmd.wait for [update-grub]
2018-10-06 14:30:39,442 [salt.state       :290 ][INFO    ][3070] No changes made for update-grub
2018-10-06 14:30:39,443 [salt.state       :1941][INFO    ][3070] Completed state [update-grub] at time 14:30:39.442992 duration_in_ms=0.78
2018-10-06 14:30:39,444 [salt.state       :1770][INFO    ][3070] Running state [/boot/grub/grub.cfg] at time 14:30:39.444942
2018-10-06 14:30:39,445 [salt.state       :1803][INFO    ][3070] Executing state file.managed for [/boot/grub/grub.cfg]
2018-10-06 14:30:39,652 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3070] Executing command ['git', '--version'] in directory '/root'
2018-10-06 14:30:39,949 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3070] Executing command 'test -f /boot/grub/grub.cfg' in directory '/root'
2018-10-06 14:30:39,964 [salt.loaded.int.states.file:2150][WARNING ][3070] 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-06 14:30:39,965 [salt.state       :290 ][INFO    ][3070] {'mode': '0400'}
2018-10-06 14:30:39,965 [salt.state       :1941][INFO    ][3070] Completed state [/boot/grub/grub.cfg] at time 14:30:39.965643 duration_in_ms=520.701
2018-10-06 14:30:39,966 [salt.state       :1770][INFO    ][3070] Running state [nf_conntrack] at time 14:30:39.966063
2018-10-06 14:30:39,966 [salt.state       :1803][INFO    ][3070] Executing state kmod.present for [nf_conntrack]
2018-10-06 14:30:39,967 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3070] Executing command 'lsmod' in directory '/root'
2018-10-06 14:30:40,366 [salt.minion      :1307][INFO    ][2981] User sudo_ubuntu Executing command saltutil.find_job with jid 20181006143040350092
2018-10-06 14:30:40,385 [salt.minion      :1431][INFO    ][4162] Starting a new job with PID 4162
2018-10-06 14:30:40,408 [salt.minion      :1708][INFO    ][4162] Returning information for job: 20181006143040350092
2018-10-06 14:30:40,434 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3070] Executing command 'lsmod' in directory '/root'
2018-10-06 14:30:40,452 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3070] Executing command 'modprobe nf_conntrack' in directory '/root'
2018-10-06 14:30:40,472 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3070] Executing command 'lsmod' in directory '/root'
2018-10-06 14:30:40,609 [salt.state       :290 ][INFO    ][3070] {'nf_conntrack': 'loaded'}
2018-10-06 14:30:40,609 [salt.state       :1941][INFO    ][3070] Completed state [nf_conntrack] at time 14:30:40.609559 duration_in_ms=643.496
2018-10-06 14:30:40,610 [salt.state       :1770][INFO    ][3070] Running state [kernel.panic] at time 14:30:40.610001
2018-10-06 14:30:40,610 [salt.state       :1803][INFO    ][3070] Executing state sysctl.present for [kernel.panic]
2018-10-06 14:30:40,631 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3070] Executing command 'sysctl -w kernel.panic="60"' in directory '/root'
2018-10-06 14:30:40,649 [salt.state       :290 ][INFO    ][3070] {'kernel.panic': 60}
2018-10-06 14:30:40,649 [salt.state       :1941][INFO    ][3070] Completed state [kernel.panic] at time 14:30:40.649538 duration_in_ms=39.536
2018-10-06 14:30:40,650 [salt.state       :1770][INFO    ][3070] Running state [net.ipv4.tcp_keepalive_probes] at time 14:30:40.649964
2018-10-06 14:30:40,650 [salt.state       :1803][INFO    ][3070] Executing state sysctl.present for [net.ipv4.tcp_keepalive_probes]
2018-10-06 14:30:40,652 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3070] Executing command 'sysctl -w net.ipv4.tcp_keepalive_probes="8"' in directory '/root'
2018-10-06 14:30:40,666 [salt.state       :290 ][INFO    ][3070] {'net.ipv4.tcp_keepalive_probes': 8}
2018-10-06 14:30:40,667 [salt.state       :1941][INFO    ][3070] Completed state [net.ipv4.tcp_keepalive_probes] at time 14:30:40.667376 duration_in_ms=17.412
2018-10-06 14:30:40,667 [salt.state       :1770][INFO    ][3070] Running state [fs.file-max] at time 14:30:40.667831
2018-10-06 14:30:40,668 [salt.state       :1803][INFO    ][3070] Executing state sysctl.present for [fs.file-max]
2018-10-06 14:30:40,669 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3070] Executing command 'sysctl -w fs.file-max="124165"' in directory '/root'
2018-10-06 14:30:40,683 [salt.state       :290 ][INFO    ][3070] {'fs.file-max': 124165}
2018-10-06 14:30:40,684 [salt.state       :1941][INFO    ][3070] Completed state [fs.file-max] at time 14:30:40.684140 duration_in_ms=16.308
2018-10-06 14:30:40,684 [salt.state       :1770][INFO    ][3070] Running state [net.core.somaxconn] at time 14:30:40.684551
2018-10-06 14:30:40,684 [salt.state       :1803][INFO    ][3070] Executing state sysctl.present for [net.core.somaxconn]
2018-10-06 14:30:40,685 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3070] Executing command 'sysctl -w net.core.somaxconn="4096"' in directory '/root'
2018-10-06 14:30:40,700 [salt.state       :290 ][INFO    ][3070] {'net.core.somaxconn': 4096}
2018-10-06 14:30:40,700 [salt.state       :1941][INFO    ][3070] Completed state [net.core.somaxconn] at time 14:30:40.700466 duration_in_ms=15.914
2018-10-06 14:30:40,700 [salt.state       :1770][INFO    ][3070] Running state [net.ipv4.tcp_max_syn_backlog] at time 14:30:40.700885
2018-10-06 14:30:40,701 [salt.state       :1803][INFO    ][3070] Executing state sysctl.present for [net.ipv4.tcp_max_syn_backlog]
2018-10-06 14:30:40,702 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3070] Executing command 'sysctl -w net.ipv4.tcp_max_syn_backlog="8192"' in directory '/root'
2018-10-06 14:30:40,716 [salt.state       :290 ][INFO    ][3070] {'net.ipv4.tcp_max_syn_backlog': 8192}
2018-10-06 14:30:40,716 [salt.state       :1941][INFO    ][3070] Completed state [net.ipv4.tcp_max_syn_backlog] at time 14:30:40.716637 duration_in_ms=15.75
2018-10-06 14:30:40,717 [salt.state       :1770][INFO    ][3070] Running state [net.ipv4.tcp_tw_reuse] at time 14:30:40.717040
2018-10-06 14:30:40,717 [salt.state       :1803][INFO    ][3070] Executing state sysctl.present for [net.ipv4.tcp_tw_reuse]
2018-10-06 14:30:40,719 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3070] Executing command 'sysctl -w net.ipv4.tcp_tw_reuse="1"' in directory '/root'
2018-10-06 14:30:40,734 [salt.state       :290 ][INFO    ][3070] {'net.ipv4.tcp_tw_reuse': 1}
2018-10-06 14:30:40,735 [salt.state       :1941][INFO    ][3070] Completed state [net.ipv4.tcp_tw_reuse] at time 14:30:40.735352 duration_in_ms=18.312
2018-10-06 14:30:40,735 [salt.state       :1770][INFO    ][3070] Running state [net.ipv4.tcp_congestion_control] at time 14:30:40.735835
2018-10-06 14:30:40,736 [salt.state       :1803][INFO    ][3070] Executing state sysctl.present for [net.ipv4.tcp_congestion_control]
2018-10-06 14:30:40,737 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3070] Executing command 'sysctl -w net.ipv4.tcp_congestion_control="yeah"' in directory '/root'
2018-10-06 14:30:40,759 [salt.state       :290 ][INFO    ][3070] {'net.ipv4.tcp_congestion_control': 'yeah'}
2018-10-06 14:30:40,760 [salt.state       :1941][INFO    ][3070] Completed state [net.ipv4.tcp_congestion_control] at time 14:30:40.760401 duration_in_ms=24.566
2018-10-06 14:30:40,760 [salt.state       :1770][INFO    ][3070] Running state [net.ipv4.tcp_retries2] at time 14:30:40.760919
2018-10-06 14:30:40,761 [salt.state       :1803][INFO    ][3070] Executing state sysctl.present for [net.ipv4.tcp_retries2]
2018-10-06 14:30:40,762 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3070] Executing command 'sysctl -w net.ipv4.tcp_retries2="5"' in directory '/root'
2018-10-06 14:30:40,780 [salt.state       :290 ][INFO    ][3070] {'net.ipv4.tcp_retries2': 5}
2018-10-06 14:30:40,780 [salt.state       :1941][INFO    ][3070] Completed state [net.ipv4.tcp_retries2] at time 14:30:40.780852 duration_in_ms=19.933
2018-10-06 14:30:40,781 [salt.state       :1770][INFO    ][3070] Running state [net.core.netdev_max_backlog] at time 14:30:40.781350
2018-10-06 14:30:40,781 [salt.state       :1803][INFO    ][3070] Executing state sysctl.present for [net.core.netdev_max_backlog]
2018-10-06 14:30:40,783 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3070] Executing command 'sysctl -w net.core.netdev_max_backlog="261144"' in directory '/root'
2018-10-06 14:30:40,801 [salt.state       :290 ][INFO    ][3070] {'net.core.netdev_max_backlog': 261144}
2018-10-06 14:30:40,801 [salt.state       :1941][INFO    ][3070] Completed state [net.core.netdev_max_backlog] at time 14:30:40.801598 duration_in_ms=20.247
2018-10-06 14:30:40,802 [salt.state       :1770][INFO    ][3070] Running state [net.ipv4.tcp_slow_start_after_idle] at time 14:30:40.802086
2018-10-06 14:30:40,804 [salt.state       :1803][INFO    ][3070] Executing state sysctl.present for [net.ipv4.tcp_slow_start_after_idle]
2018-10-06 14:30:40,805 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3070] Executing command 'sysctl -w net.ipv4.tcp_slow_start_after_idle="0"' in directory '/root'
2018-10-06 14:30:40,820 [salt.state       :290 ][INFO    ][3070] {'net.ipv4.tcp_slow_start_after_idle': 0}
2018-10-06 14:30:40,820 [salt.state       :1941][INFO    ][3070] Completed state [net.ipv4.tcp_slow_start_after_idle] at time 14:30:40.820541 duration_in_ms=18.455
2018-10-06 14:30:40,820 [salt.state       :1770][INFO    ][3070] Running state [vm.swappiness] at time 14:30:40.820952
2018-10-06 14:30:40,821 [salt.state       :1803][INFO    ][3070] Executing state sysctl.present for [vm.swappiness]
2018-10-06 14:30:40,822 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3070] Executing command 'sysctl -w vm.swappiness="10"' in directory '/root'
2018-10-06 14:30:40,836 [salt.state       :290 ][INFO    ][3070] {'vm.swappiness': 10}
2018-10-06 14:30:40,837 [salt.state       :1941][INFO    ][3070] Completed state [vm.swappiness] at time 14:30:40.837203 duration_in_ms=16.251
2018-10-06 14:30:40,837 [salt.state       :1770][INFO    ][3070] Running state [net.ipv4.tcp_keepalive_intvl] at time 14:30:40.837610
2018-10-06 14:30:40,837 [salt.state       :1803][INFO    ][3070] Executing state sysctl.present for [net.ipv4.tcp_keepalive_intvl]
2018-10-06 14:30:40,839 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3070] Executing command 'sysctl -w net.ipv4.tcp_keepalive_intvl="3"' in directory '/root'
2018-10-06 14:30:40,855 [salt.state       :290 ][INFO    ][3070] {'net.ipv4.tcp_keepalive_intvl': 3}
2018-10-06 14:30:40,856 [salt.state       :1941][INFO    ][3070] Completed state [net.ipv4.tcp_keepalive_intvl] at time 14:30:40.856212 duration_in_ms=18.601
2018-10-06 14:30:40,856 [salt.state       :1770][INFO    ][3070] Running state [net.ipv4.neigh.default.gc_thresh1] at time 14:30:40.856649
2018-10-06 14:30:40,857 [salt.state       :1803][INFO    ][3070] Executing state sysctl.present for [net.ipv4.neigh.default.gc_thresh1]
2018-10-06 14:30:40,858 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3070] Executing command 'sysctl -w net.ipv4.neigh.default.gc_thresh1="4096"' in directory '/root'
2018-10-06 14:30:40,878 [salt.state       :290 ][INFO    ][3070] {'net.ipv4.neigh.default.gc_thresh1': 4096}
2018-10-06 14:30:40,878 [salt.state       :1941][INFO    ][3070] Completed state [net.ipv4.neigh.default.gc_thresh1] at time 14:30:40.878706 duration_in_ms=22.056
2018-10-06 14:30:40,879 [salt.state       :1770][INFO    ][3070] Running state [net.ipv4.neigh.default.gc_thresh2] at time 14:30:40.879191
2018-10-06 14:30:40,879 [salt.state       :1803][INFO    ][3070] Executing state sysctl.present for [net.ipv4.neigh.default.gc_thresh2]
2018-10-06 14:30:40,880 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3070] Executing command 'sysctl -w net.ipv4.neigh.default.gc_thresh2="8192"' in directory '/root'
2018-10-06 14:30:40,897 [salt.state       :290 ][INFO    ][3070] {'net.ipv4.neigh.default.gc_thresh2': 8192}
2018-10-06 14:30:40,898 [salt.state       :1941][INFO    ][3070] Completed state [net.ipv4.neigh.default.gc_thresh2] at time 14:30:40.897889 duration_in_ms=18.698
2018-10-06 14:30:40,899 [salt.state       :1770][INFO    ][3070] Running state [net.ipv4.neigh.default.gc_thresh3] at time 14:30:40.898417
2018-10-06 14:30:40,900 [salt.state       :1803][INFO    ][3070] Executing state sysctl.present for [net.ipv4.neigh.default.gc_thresh3]
2018-10-06 14:30:40,901 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3070] Executing command 'sysctl -w net.ipv4.neigh.default.gc_thresh3="16384"' in directory '/root'
2018-10-06 14:30:40,919 [salt.state       :290 ][INFO    ][3070] {'net.ipv4.neigh.default.gc_thresh3': 16384}
2018-10-06 14:30:40,920 [salt.state       :1941][INFO    ][3070] Completed state [net.ipv4.neigh.default.gc_thresh3] at time 14:30:40.920209 duration_in_ms=21.793
2018-10-06 14:30:40,920 [salt.state       :1770][INFO    ][3070] Running state [net.ipv4.tcp_fin_timeout] at time 14:30:40.920682
2018-10-06 14:30:40,921 [salt.state       :1803][INFO    ][3070] Executing state sysctl.present for [net.ipv4.tcp_fin_timeout]
2018-10-06 14:30:40,922 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3070] Executing command 'sysctl -w net.ipv4.tcp_fin_timeout="30"' in directory '/root'
2018-10-06 14:30:40,942 [salt.state       :290 ][INFO    ][3070] {'net.ipv4.tcp_fin_timeout': 30}
2018-10-06 14:30:40,943 [salt.state       :1941][INFO    ][3070] Completed state [net.ipv4.tcp_fin_timeout] at time 14:30:40.943174 duration_in_ms=22.492
2018-10-06 14:30:40,943 [salt.state       :1770][INFO    ][3070] Running state [net.ipv4.tcp_keepalive_time] at time 14:30:40.943634
2018-10-06 14:30:40,944 [salt.state       :1803][INFO    ][3070] Executing state sysctl.present for [net.ipv4.tcp_keepalive_time]
2018-10-06 14:30:40,945 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3070] Executing command 'sysctl -w net.ipv4.tcp_keepalive_time="30"' in directory '/root'
2018-10-06 14:30:40,964 [salt.state       :290 ][INFO    ][3070] {'net.ipv4.tcp_keepalive_time': 30}
2018-10-06 14:30:40,965 [salt.state       :1941][INFO    ][3070] Completed state [net.ipv4.tcp_keepalive_time] at time 14:30:40.965134 duration_in_ms=21.5
2018-10-06 14:30:40,965 [salt.state       :1770][INFO    ][3070] Running state [net.nf_conntrack_max] at time 14:30:40.965597
2018-10-06 14:30:40,966 [salt.state       :1803][INFO    ][3070] Executing state sysctl.present for [net.nf_conntrack_max]
2018-10-06 14:30:40,967 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3070] Executing command 'sysctl -w net.nf_conntrack_max="1048576"' in directory '/root'
2018-10-06 14:30:40,983 [salt.state       :290 ][INFO    ][3070] {'net.nf_conntrack_max': 1048576}
2018-10-06 14:30:40,984 [salt.state       :1941][INFO    ][3070] Completed state [net.nf_conntrack_max] at time 14:30:40.984356 duration_in_ms=18.759
2018-10-06 14:30:40,984 [salt.state       :1770][INFO    ][3070] Running state [linux_sysfs_package] at time 14:30:40.984774
2018-10-06 14:30:40,985 [salt.state       :1803][INFO    ][3070] Executing state pkg.installed for [linux_sysfs_package]
2018-10-06 14:30:41,013 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3070] Executing command ['apt-cache', '-q', 'policy', 'sysfsutils'] in directory '/root'
2018-10-06 14:30:41,127 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3070] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2018-10-06 14:30:43,235 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3070] Executing command ['dpkg', '--get-selections', '*'] in directory '/root'
2018-10-06 14:30:43,268 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3070] 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-06 14:30:46,725 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3070] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}', '-W'] in directory '/root'
2018-10-06 14:30:46,767 [salt.state       :290 ][INFO    ][3070] 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-06 14:30:46,794 [salt.state       :905 ][INFO    ][3070] Loading fresh modules for state activity
2018-10-06 14:30:46,843 [salt.state       :1941][INFO    ][3070] Completed state [linux_sysfs_package] at time 14:30:46.843883 duration_in_ms=5859.109
2018-10-06 14:30:46,849 [salt.state       :1770][INFO    ][3070] Running state [/etc/sysfs.d] at time 14:30:46.849719
2018-10-06 14:30:46,850 [salt.state       :1803][INFO    ][3070] Executing state file.directory for [/etc/sysfs.d]
2018-10-06 14:30:46,855 [salt.state       :290 ][INFO    ][3070] Directory /etc/sysfs.d is in the correct state
Directory /etc/sysfs.d updated
2018-10-06 14:30:46,855 [salt.state       :1941][INFO    ][3070] Completed state [/etc/sysfs.d] at time 14:30:46.855883 duration_in_ms=6.164
2018-10-06 14:30:47,410 [salt.state       :1770][INFO    ][3070] Running state [ondemand] at time 14:30:47.410833
2018-10-06 14:30:47,411 [salt.state       :1803][INFO    ][3070] Executing state service.dead for [ondemand]
2018-10-06 14:30:47,412 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3070] Executing command ['systemctl', 'status', 'ondemand.service', '-n', '0'] in directory '/root'
2018-10-06 14:30:47,432 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3070] Executing command ['systemctl', 'is-active', 'ondemand.service'] in directory '/root'
2018-10-06 14:30:47,448 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3070] Executing command ['systemctl', 'is-enabled', 'ondemand.service'] in directory '/root'
2018-10-06 14:30:47,467 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3070] Executing command ['systemd-run', '--scope', 'systemctl', 'stop', 'ondemand.service'] in directory '/root'
2018-10-06 14:30:47,534 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3070] Executing command ['systemctl', 'is-active', 'ondemand.service'] in directory '/root'
2018-10-06 14:30:47,553 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3070] Executing command ['systemctl', 'is-enabled', 'ondemand.service'] in directory '/root'
2018-10-06 14:30:47,576 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3070] Executing command ['systemctl', 'is-enabled', 'ondemand.service'] in directory '/root'
2018-10-06 14:30:47,607 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3070] Executing command ['systemd-run', '--scope', '/usr/sbin/update-rc.d', '-f', 'ondemand', 'remove'] in directory '/root'
2018-10-06 14:30:47,778 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3070] Executing command ['systemctl', 'is-enabled', 'ondemand.service'] in directory '/root'
2018-10-06 14:30:47,804 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3070] Executing command 'runlevel' in directory '/root'
2018-10-06 14:30:47,821 [salt.state       :290 ][INFO    ][3070] {'ondemand': True}
2018-10-06 14:30:47,821 [salt.state       :1941][INFO    ][3070] Completed state [ondemand] at time 14:30:47.821898 duration_in_ms=411.066
2018-10-06 14:30:47,823 [salt.state       :1770][INFO    ][3070] Running state [cs_CZ.UTF-8] at time 14:30:47.823780
2018-10-06 14:30:47,824 [salt.state       :1803][INFO    ][3070] Executing state locale.present for [cs_CZ.UTF-8]
2018-10-06 14:30:47,825 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3070] Executing command 'locale -a' in directory '/root'
2018-10-06 14:30:47,847 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3070] Executing command ['locale-gen', 'cs_CZ.utf8'] in directory '/root'
2018-10-06 14:30:48,647 [salt.state       :290 ][INFO    ][3070] {'locale': 'cs_CZ.UTF-8'}
2018-10-06 14:30:48,648 [salt.state       :1941][INFO    ][3070] Completed state [cs_CZ.UTF-8] at time 14:30:48.648179 duration_in_ms=824.399
2018-10-06 14:30:48,648 [salt.state       :1770][INFO    ][3070] Running state [en_US.UTF-8] at time 14:30:48.648885
2018-10-06 14:30:48,649 [salt.state       :1803][INFO    ][3070] Executing state locale.present for [en_US.UTF-8]
2018-10-06 14:30:48,651 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3070] Executing command 'locale -a' in directory '/root'
2018-10-06 14:30:48,669 [salt.state       :290 ][INFO    ][3070] Locale en_US.UTF-8 is already present
2018-10-06 14:30:48,671 [salt.state       :1941][INFO    ][3070] Completed state [en_US.UTF-8] at time 14:30:48.671015 duration_in_ms=22.13
2018-10-06 14:30:48,673 [salt.state       :1770][INFO    ][3070] Running state [en_US.UTF-8] at time 14:30:48.673536
2018-10-06 14:30:48,674 [salt.state       :1803][INFO    ][3070] Executing state locale.system for [en_US.UTF-8]
2018-10-06 14:30:48,676 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3070] Executing command 'localectl' in directory '/root'
2018-10-06 14:30:48,726 [salt.state       :290 ][INFO    ][3070] System locale en_US.UTF-8 already set
2018-10-06 14:30:48,727 [salt.state       :1941][INFO    ][3070] Completed state [en_US.UTF-8] at time 14:30:48.726977 duration_in_ms=53.441
2018-10-06 14:30:48,728 [salt.state       :1770][INFO    ][3070] Running state [root] at time 14:30:48.728442
2018-10-06 14:30:48,728 [salt.state       :1803][INFO    ][3070] Executing state group.present for [root]
2018-10-06 14:30:48,729 [salt.state       :290 ][INFO    ][3070] Group root is present and up to date
2018-10-06 14:30:48,729 [salt.state       :1941][INFO    ][3070] Completed state [root] at time 14:30:48.729565 duration_in_ms=1.123
2018-10-06 14:30:48,733 [salt.state       :1770][INFO    ][3070] Running state [root] at time 14:30:48.733449
2018-10-06 14:30:48,733 [salt.state       :1803][INFO    ][3070] Executing state user.present for [root]
2018-10-06 14:30:48,740 [salt.state       :290 ][INFO    ][3070] User root is present and up to date
2018-10-06 14:30:48,741 [salt.state       :1941][INFO    ][3070] Completed state [root] at time 14:30:48.741146 duration_in_ms=7.696
2018-10-06 14:30:48,742 [salt.state       :1770][INFO    ][3070] Running state [/root] at time 14:30:48.742551
2018-10-06 14:30:48,742 [salt.state       :1803][INFO    ][3070] Executing state file.directory for [/root]
2018-10-06 14:30:48,743 [salt.state       :290 ][INFO    ][3070] Directory /root is in the correct state
Directory /root updated
2018-10-06 14:30:48,744 [salt.state       :1941][INFO    ][3070] Completed state [/root] at time 14:30:48.744076 duration_in_ms=1.525
2018-10-06 14:30:48,744 [salt.state       :1770][INFO    ][3070] Running state [/etc/sudoers.d/90-salt-user-root] at time 14:30:48.744320
2018-10-06 14:30:48,744 [salt.state       :1803][INFO    ][3070] Executing state file.absent for [/etc/sudoers.d/90-salt-user-root]
2018-10-06 14:30:48,744 [salt.state       :290 ][INFO    ][3070] File /etc/sudoers.d/90-salt-user-root is not present
2018-10-06 14:30:48,745 [salt.state       :1941][INFO    ][3070] Completed state [/etc/sudoers.d/90-salt-user-root] at time 14:30:48.745116 duration_in_ms=0.796
2018-10-06 14:30:48,745 [salt.state       :1770][INFO    ][3070] Running state [ubuntu] at time 14:30:48.745358
2018-10-06 14:30:48,745 [salt.state       :1803][INFO    ][3070] Executing state group.present for [ubuntu]
2018-10-06 14:30:48,745 [salt.state       :290 ][INFO    ][3070] Group ubuntu is present and up to date
2018-10-06 14:30:48,746 [salt.state       :1941][INFO    ][3070] Completed state [ubuntu] at time 14:30:48.746154 duration_in_ms=0.796
2018-10-06 14:30:48,748 [salt.state       :1770][INFO    ][3070] Running state [ubuntu] at time 14:30:48.748857
2018-10-06 14:30:48,749 [salt.state       :1803][INFO    ][3070] Executing state user.present for [ubuntu]
2018-10-06 14:30:48,752 [salt.state       :290 ][INFO    ][3070] {'passwd': 'XXX-REDACTED-XXX'}
2018-10-06 14:30:48,752 [salt.state       :1941][INFO    ][3070] Completed state [ubuntu] at time 14:30:48.752950 duration_in_ms=4.093
2018-10-06 14:30:48,754 [salt.state       :1770][INFO    ][3070] Running state [/home/ubuntu] at time 14:30:48.754179
2018-10-06 14:30:48,754 [salt.state       :1803][INFO    ][3070] Executing state file.directory for [/home/ubuntu]
2018-10-06 14:30:48,755 [salt.state       :290 ][INFO    ][3070] {'mode': '0700'}
2018-10-06 14:30:48,755 [salt.state       :1941][INFO    ][3070] Completed state [/home/ubuntu] at time 14:30:48.755852 duration_in_ms=1.674
2018-10-06 14:30:48,756 [salt.state       :1770][INFO    ][3070] Running state [/etc/sudoers.d/90-salt-user-ubuntu] at time 14:30:48.756917
2018-10-06 14:30:48,757 [salt.state       :1803][INFO    ][3070] Executing state file.managed for [/etc/sudoers.d/90-salt-user-ubuntu]
2018-10-06 14:30:48,780 [salt.fileclient  :1215][INFO    ][3070] Fetching file from saltenv 'base', ** done ** 'linux/files/sudoer'
2018-10-06 14:30:48,801 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3070] Executing command '/usr/sbin/visudo -c -f /tmp/__salt.tmp.kvAN1s' in directory '/root'
2018-10-06 14:30:48,830 [salt.state       :290 ][INFO    ][3070] File changed:
New file
2018-10-06 14:30:48,831 [salt.state       :1941][INFO    ][3070] Completed state [/etc/sudoers.d/90-salt-user-ubuntu] at time 14:30:48.831487 duration_in_ms=74.569
2018-10-06 14:30:48,831 [salt.state       :1770][INFO    ][3070] Running state [/etc/security/limits.d/90-salt-default.conf] at time 14:30:48.831893
2018-10-06 14:30:48,832 [salt.state       :1803][INFO    ][3070] Executing state file.managed for [/etc/security/limits.d/90-salt-default.conf]
2018-10-06 14:30:48,859 [salt.fileclient  :1215][INFO    ][3070] Fetching file from saltenv 'base', ** done ** 'linux/files/limits.conf'
2018-10-06 14:30:48,993 [salt.state       :290 ][INFO    ][3070] File changed:
New file
2018-10-06 14:30:48,993 [salt.state       :1941][INFO    ][3070] Completed state [/etc/security/limits.d/90-salt-default.conf] at time 14:30:48.993675 duration_in_ms=161.781
2018-10-06 14:30:48,994 [salt.state       :1770][INFO    ][3070] Running state [/etc/systemd/system.conf.d/90-salt.conf] at time 14:30:48.993960
2018-10-06 14:30:48,994 [salt.state       :1803][INFO    ][3070] Executing state file.managed for [/etc/systemd/system.conf.d/90-salt.conf]
2018-10-06 14:30:49,014 [salt.fileclient  :1215][INFO    ][3070] Fetching file from saltenv 'base', ** done ** 'linux/files/systemd.conf'
2018-10-06 14:30:49,135 [salt.state       :290 ][INFO    ][3070] File changed:
New file
2018-10-06 14:30:49,135 [salt.state       :1941][INFO    ][3070] Completed state [/etc/systemd/system.conf.d/90-salt.conf] at time 14:30:49.135786 duration_in_ms=141.826
2018-10-06 14:30:49,138 [salt.state       :1770][INFO    ][3070] Running state [service.systemctl_reload] at time 14:30:49.138387
2018-10-06 14:30:49,138 [salt.state       :1803][INFO    ][3070] Executing state module.wait for [service.systemctl_reload]
2018-10-06 14:30:49,139 [salt.state       :290 ][INFO    ][3070] No changes made for service.systemctl_reload
2018-10-06 14:30:49,139 [salt.state       :1941][INFO    ][3070] Completed state [service.systemctl_reload] at time 14:30:49.139184 duration_in_ms=0.797
2018-10-06 14:30:49,139 [salt.state       :1770][INFO    ][3070] Running state [service.systemctl_reload] at time 14:30:49.139412
2018-10-06 14:30:49,139 [salt.state       :1803][INFO    ][3070] Executing state module.mod_watch for [service.systemctl_reload]
2018-10-06 14:30:49,140 [salt.utils.decorators:613 ][WARNING ][3070] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2018-10-06 14:30:49,140 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3070] Executing command ['systemctl', '--system', 'daemon-reload'] in directory '/root'
2018-10-06 14:30:49,270 [salt.state       :290 ][INFO    ][3070] {'ret': True}
2018-10-06 14:30:49,271 [salt.state       :1941][INFO    ][3070] Completed state [service.systemctl_reload] at time 14:30:49.271512 duration_in_ms=132.1
2018-10-06 14:30:49,272 [salt.state       :1770][INFO    ][3070] Running state [/etc/issue] at time 14:30:49.272049
2018-10-06 14:30:49,272 [salt.state       :1803][INFO    ][3070] Executing state file.managed for [/etc/issue]
2018-10-06 14:30:49,275 [salt.state       :290 ][INFO    ][3070] 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-06 14:30:49,275 [salt.state       :1941][INFO    ][3070] Completed state [/etc/issue] at time 14:30:49.275885 duration_in_ms=3.836
2018-10-06 14:30:49,276 [salt.state       :1770][INFO    ][3070] Running state [/etc/hostname] at time 14:30:49.276151
2018-10-06 14:30:49,276 [salt.state       :1803][INFO    ][3070] Executing state file.managed for [/etc/hostname]
2018-10-06 14:30:49,298 [salt.fileclient  :1215][INFO    ][3070] Fetching file from saltenv 'base', ** done ** 'linux/files/hostname'
2018-10-06 14:30:49,310 [salt.state       :290 ][INFO    ][3070] File changed:
--- 
+++ 
@@ -1 +1 @@
-ubuntu
+msg03

2018-10-06 14:30:49,310 [salt.state       :1941][INFO    ][3070] Completed state [/etc/hostname] at time 14:30:49.310258 duration_in_ms=34.106
2018-10-06 14:30:49,313 [salt.state       :1770][INFO    ][3070] Running state [hostname msg03] at time 14:30:49.313365
2018-10-06 14:30:49,313 [salt.state       :1803][INFO    ][3070] Executing state cmd.run for [hostname msg03]
2018-10-06 14:30:49,314 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3070] Executing command 'test "$(hostname)" = "msg03"' in directory '/root'
2018-10-06 14:30:49,330 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3070] Executing command 'hostname msg03' in directory '/root'
2018-10-06 14:30:49,346 [salt.state       :290 ][INFO    ][3070] {'pid': 5228, 'retcode': 0, 'stderr': '', 'stdout': ''}
2018-10-06 14:30:49,347 [salt.state       :1941][INFO    ][3070] Completed state [hostname msg03] at time 14:30:49.347515 duration_in_ms=34.15
2018-10-06 14:30:49,349 [salt.state       :1770][INFO    ][3070] Running state [mdb02] at time 14:30:49.349078
2018-10-06 14:30:49,349 [salt.state       :1803][INFO    ][3070] Executing state host.present for [mdb02]
2018-10-06 14:30:49,350 [salt.state       :290 ][INFO    ][3070] {'host': 'mdb02'}
2018-10-06 14:30:49,351 [salt.state       :1941][INFO    ][3070] Completed state [mdb02] at time 14:30:49.351064 duration_in_ms=1.986
2018-10-06 14:30:49,351 [salt.state       :1770][INFO    ][3070] Running state [mdb02.mcp-pike-odl-ha.local] at time 14:30:49.351448
2018-10-06 14:30:49,351 [salt.state       :1803][INFO    ][3070] Executing state host.present for [mdb02.mcp-pike-odl-ha.local]
2018-10-06 14:30:49,352 [salt.state       :290 ][INFO    ][3070] {'host': 'mdb02.mcp-pike-odl-ha.local'}
2018-10-06 14:30:49,353 [salt.state       :1941][INFO    ][3070] Completed state [mdb02.mcp-pike-odl-ha.local] at time 14:30:49.353025 duration_in_ms=1.578
2018-10-06 14:30:49,353 [salt.state       :1770][INFO    ][3070] Running state [mdb03] at time 14:30:49.353385
2018-10-06 14:30:49,353 [salt.state       :1803][INFO    ][3070] Executing state host.present for [mdb03]
2018-10-06 14:30:49,354 [salt.state       :290 ][INFO    ][3070] {'host': 'mdb03'}
2018-10-06 14:30:49,355 [salt.state       :1941][INFO    ][3070] Completed state [mdb03] at time 14:30:49.355155 duration_in_ms=1.771
2018-10-06 14:30:49,355 [salt.state       :1770][INFO    ][3070] Running state [mdb03.mcp-pike-odl-ha.local] at time 14:30:49.355506
2018-10-06 14:30:49,355 [salt.state       :1803][INFO    ][3070] Executing state host.present for [mdb03.mcp-pike-odl-ha.local]
2018-10-06 14:30:49,356 [salt.state       :290 ][INFO    ][3070] {'host': 'mdb03.mcp-pike-odl-ha.local'}
2018-10-06 14:30:49,357 [salt.state       :1941][INFO    ][3070] Completed state [mdb03.mcp-pike-odl-ha.local] at time 14:30:49.357012 duration_in_ms=1.506
2018-10-06 14:30:49,357 [salt.state       :1770][INFO    ][3070] Running state [mdb01] at time 14:30:49.357333
2018-10-06 14:30:49,357 [salt.state       :1803][INFO    ][3070] Executing state host.present for [mdb01]
2018-10-06 14:30:49,359 [salt.state       :290 ][INFO    ][3070] {'host': 'mdb01'}
2018-10-06 14:30:49,359 [salt.state       :1941][INFO    ][3070] Completed state [mdb01] at time 14:30:49.359928 duration_in_ms=2.595
2018-10-06 14:30:49,360 [salt.state       :1770][INFO    ][3070] Running state [mdb01.mcp-pike-odl-ha.local] at time 14:30:49.360259
2018-10-06 14:30:49,360 [salt.state       :1803][INFO    ][3070] Executing state host.present for [mdb01.mcp-pike-odl-ha.local]
2018-10-06 14:30:49,361 [salt.state       :290 ][INFO    ][3070] {'host': 'mdb01.mcp-pike-odl-ha.local'}
2018-10-06 14:30:49,361 [salt.state       :1941][INFO    ][3070] Completed state [mdb01.mcp-pike-odl-ha.local] at time 14:30:49.361677 duration_in_ms=1.418
2018-10-06 14:30:49,362 [salt.state       :1770][INFO    ][3070] Running state [mdb] at time 14:30:49.361991
2018-10-06 14:30:49,362 [salt.state       :1803][INFO    ][3070] Executing state host.present for [mdb]
2018-10-06 14:30:49,363 [salt.state       :290 ][INFO    ][3070] {'host': 'mdb'}
2018-10-06 14:30:49,363 [salt.state       :1941][INFO    ][3070] Completed state [mdb] at time 14:30:49.363448 duration_in_ms=1.457
2018-10-06 14:30:49,363 [salt.state       :1770][INFO    ][3070] Running state [mdb.mcp-pike-odl-ha.local] at time 14:30:49.363771
2018-10-06 14:30:49,364 [salt.state       :1803][INFO    ][3070] Executing state host.present for [mdb.mcp-pike-odl-ha.local]
2018-10-06 14:30:49,366 [salt.state       :290 ][INFO    ][3070] {'host': 'mdb.mcp-pike-odl-ha.local'}
2018-10-06 14:30:49,366 [salt.state       :1941][INFO    ][3070] Completed state [mdb.mcp-pike-odl-ha.local] at time 14:30:49.366732 duration_in_ms=2.96
2018-10-06 14:30:49,367 [salt.state       :1770][INFO    ][3070] Running state [cfg01] at time 14:30:49.367068
2018-10-06 14:30:49,367 [salt.state       :1803][INFO    ][3070] Executing state host.present for [cfg01]
2018-10-06 14:30:49,368 [salt.state       :290 ][INFO    ][3070] {'host': 'cfg01'}
2018-10-06 14:30:49,368 [salt.state       :1941][INFO    ][3070] Completed state [cfg01] at time 14:30:49.368513 duration_in_ms=1.444
2018-10-06 14:30:49,368 [salt.state       :1770][INFO    ][3070] Running state [cfg01.mcp-pike-odl-ha.local] at time 14:30:49.368830
2018-10-06 14:30:49,369 [salt.state       :1803][INFO    ][3070] Executing state host.present for [cfg01.mcp-pike-odl-ha.local]
2018-10-06 14:30:49,370 [salt.state       :290 ][INFO    ][3070] {'host': 'cfg01.mcp-pike-odl-ha.local'}
2018-10-06 14:30:49,370 [salt.state       :1941][INFO    ][3070] Completed state [cfg01.mcp-pike-odl-ha.local] at time 14:30:49.370230 duration_in_ms=1.4
2018-10-06 14:30:49,371 [salt.state       :1770][INFO    ][3070] Running state [prx01] at time 14:30:49.371430
2018-10-06 14:30:49,371 [salt.state       :1803][INFO    ][3070] Executing state host.present for [prx01]
2018-10-06 14:30:49,372 [salt.state       :290 ][INFO    ][3070] {'host': 'prx01'}
2018-10-06 14:30:49,372 [salt.state       :1941][INFO    ][3070] Completed state [prx01] at time 14:30:49.372849 duration_in_ms=1.419
2018-10-06 14:30:49,373 [salt.state       :1770][INFO    ][3070] Running state [prx01.mcp-pike-odl-ha.local] at time 14:30:49.373166
2018-10-06 14:30:49,373 [salt.state       :1803][INFO    ][3070] Executing state host.present for [prx01.mcp-pike-odl-ha.local]
2018-10-06 14:30:49,374 [salt.state       :290 ][INFO    ][3070] {'host': 'prx01.mcp-pike-odl-ha.local'}
2018-10-06 14:30:49,374 [salt.state       :1941][INFO    ][3070] Completed state [prx01.mcp-pike-odl-ha.local] at time 14:30:49.374584 duration_in_ms=1.418
2018-10-06 14:30:49,374 [salt.state       :1770][INFO    ][3070] Running state [kvm01] at time 14:30:49.374901
2018-10-06 14:30:49,375 [salt.state       :1803][INFO    ][3070] Executing state host.present for [kvm01]
2018-10-06 14:30:49,376 [salt.state       :290 ][INFO    ][3070] {'host': 'kvm01'}
2018-10-06 14:30:49,376 [salt.state       :1941][INFO    ][3070] Completed state [kvm01] at time 14:30:49.376347 duration_in_ms=1.445
2018-10-06 14:30:49,376 [salt.state       :1770][INFO    ][3070] Running state [kvm01.mcp-pike-odl-ha.local] at time 14:30:49.376665
2018-10-06 14:30:49,376 [salt.state       :1803][INFO    ][3070] Executing state host.present for [kvm01.mcp-pike-odl-ha.local]
2018-10-06 14:30:49,377 [salt.state       :290 ][INFO    ][3070] {'host': 'kvm01.mcp-pike-odl-ha.local'}
2018-10-06 14:30:49,378 [salt.state       :1941][INFO    ][3070] Completed state [kvm01.mcp-pike-odl-ha.local] at time 14:30:49.378092 duration_in_ms=1.426
2018-10-06 14:30:49,378 [salt.state       :1770][INFO    ][3070] Running state [kvm03] at time 14:30:49.378733
2018-10-06 14:30:49,379 [salt.state       :1803][INFO    ][3070] Executing state host.present for [kvm03]
2018-10-06 14:30:49,380 [salt.state       :290 ][INFO    ][3070] {'host': 'kvm03'}
2018-10-06 14:30:49,380 [salt.state       :1941][INFO    ][3070] Completed state [kvm03] at time 14:30:49.380186 duration_in_ms=1.453
2018-10-06 14:30:49,380 [salt.state       :1770][INFO    ][3070] Running state [kvm03.mcp-pike-odl-ha.local] at time 14:30:49.380506
2018-10-06 14:30:49,380 [salt.state       :1803][INFO    ][3070] Executing state host.present for [kvm03.mcp-pike-odl-ha.local]
2018-10-06 14:30:49,381 [salt.state       :290 ][INFO    ][3070] {'host': 'kvm03.mcp-pike-odl-ha.local'}
2018-10-06 14:30:49,381 [salt.state       :1941][INFO    ][3070] Completed state [kvm03.mcp-pike-odl-ha.local] at time 14:30:49.381940 duration_in_ms=1.434
2018-10-06 14:30:49,382 [salt.state       :1770][INFO    ][3070] Running state [kvm02] at time 14:30:49.382260
2018-10-06 14:30:49,382 [salt.state       :1803][INFO    ][3070] Executing state host.present for [kvm02]
2018-10-06 14:30:49,383 [salt.state       :290 ][INFO    ][3070] {'host': 'kvm02'}
2018-10-06 14:30:49,384 [salt.state       :1941][INFO    ][3070] Completed state [kvm02] at time 14:30:49.384109 duration_in_ms=1.849
2018-10-06 14:30:49,384 [salt.state       :1770][INFO    ][3070] Running state [kvm02.mcp-pike-odl-ha.local] at time 14:30:49.384430
2018-10-06 14:30:49,384 [salt.state       :1803][INFO    ][3070] Executing state host.present for [kvm02.mcp-pike-odl-ha.local]
2018-10-06 14:30:49,385 [salt.state       :290 ][INFO    ][3070] {'host': 'kvm02.mcp-pike-odl-ha.local'}
2018-10-06 14:30:49,385 [salt.state       :1941][INFO    ][3070] Completed state [kvm02.mcp-pike-odl-ha.local] at time 14:30:49.385911 duration_in_ms=1.481
2018-10-06 14:30:49,386 [salt.state       :1770][INFO    ][3070] Running state [dbs] at time 14:30:49.386235
2018-10-06 14:30:49,386 [salt.state       :1803][INFO    ][3070] Executing state host.present for [dbs]
2018-10-06 14:30:49,387 [salt.state       :290 ][INFO    ][3070] {'host': 'dbs'}
2018-10-06 14:30:49,387 [salt.state       :1941][INFO    ][3070] Completed state [dbs] at time 14:30:49.387761 duration_in_ms=1.526
2018-10-06 14:30:49,388 [salt.state       :1770][INFO    ][3070] Running state [dbs.mcp-pike-odl-ha.local] at time 14:30:49.388090
2018-10-06 14:30:49,388 [salt.state       :1803][INFO    ][3070] Executing state host.present for [dbs.mcp-pike-odl-ha.local]
2018-10-06 14:30:49,389 [salt.state       :290 ][INFO    ][3070] {'host': 'dbs.mcp-pike-odl-ha.local'}
2018-10-06 14:30:49,389 [salt.state       :1941][INFO    ][3070] Completed state [dbs.mcp-pike-odl-ha.local] at time 14:30:49.389596 duration_in_ms=1.506
2018-10-06 14:30:49,389 [salt.state       :1770][INFO    ][3070] Running state [prx] at time 14:30:49.389934
2018-10-06 14:30:49,390 [salt.state       :1803][INFO    ][3070] Executing state host.present for [prx]
2018-10-06 14:30:49,391 [salt.state       :290 ][INFO    ][3070] {'host': 'prx'}
2018-10-06 14:30:49,391 [salt.state       :1941][INFO    ][3070] Completed state [prx] at time 14:30:49.391468 duration_in_ms=1.534
2018-10-06 14:30:49,392 [salt.state       :1770][INFO    ][3070] Running state [prx.mcp-pike-odl-ha.local] at time 14:30:49.392089
2018-10-06 14:30:49,392 [salt.state       :1803][INFO    ][3070] Executing state host.present for [prx.mcp-pike-odl-ha.local]
2018-10-06 14:30:49,393 [salt.state       :290 ][INFO    ][3070] {'host': 'prx.mcp-pike-odl-ha.local'}
2018-10-06 14:30:49,393 [salt.state       :1941][INFO    ][3070] Completed state [prx.mcp-pike-odl-ha.local] at time 14:30:49.393595 duration_in_ms=1.506
2018-10-06 14:30:49,393 [salt.state       :1770][INFO    ][3070] Running state [prx02] at time 14:30:49.393929
2018-10-06 14:30:49,394 [salt.state       :1803][INFO    ][3070] Executing state host.present for [prx02]
2018-10-06 14:30:49,396 [salt.state       :290 ][INFO    ][3070] {'host': 'prx02'}
2018-10-06 14:30:49,396 [salt.state       :1941][INFO    ][3070] Completed state [prx02] at time 14:30:49.396457 duration_in_ms=2.528
2018-10-06 14:30:49,396 [salt.state       :1770][INFO    ][3070] Running state [prx02.mcp-pike-odl-ha.local] at time 14:30:49.396789
2018-10-06 14:30:49,397 [salt.state       :1803][INFO    ][3070] Executing state host.present for [prx02.mcp-pike-odl-ha.local]
2018-10-06 14:30:49,398 [salt.state       :290 ][INFO    ][3070] {'host': 'prx02.mcp-pike-odl-ha.local'}
2018-10-06 14:30:49,398 [salt.state       :1941][INFO    ][3070] Completed state [prx02.mcp-pike-odl-ha.local] at time 14:30:49.398289 duration_in_ms=1.5
2018-10-06 14:30:49,398 [salt.state       :1770][INFO    ][3070] Running state [msg02] at time 14:30:49.398634
2018-10-06 14:30:49,398 [salt.state       :1803][INFO    ][3070] Executing state host.present for [msg02]
2018-10-06 14:30:49,399 [salt.state       :290 ][INFO    ][3070] {'host': 'msg02'}
2018-10-06 14:30:49,400 [salt.state       :1941][INFO    ][3070] Completed state [msg02] at time 14:30:49.400141 duration_in_ms=1.507
2018-10-06 14:30:49,400 [salt.state       :1770][INFO    ][3070] Running state [msg02.mcp-pike-odl-ha.local] at time 14:30:49.400471
2018-10-06 14:30:49,400 [salt.state       :1803][INFO    ][3070] Executing state host.present for [msg02.mcp-pike-odl-ha.local]
2018-10-06 14:30:49,401 [salt.state       :290 ][INFO    ][3070] {'host': 'msg02.mcp-pike-odl-ha.local'}
2018-10-06 14:30:49,402 [salt.state       :1941][INFO    ][3070] Completed state [msg02.mcp-pike-odl-ha.local] at time 14:30:49.401968 duration_in_ms=1.497
2018-10-06 14:30:49,402 [salt.state       :1770][INFO    ][3070] Running state [msg03] at time 14:30:49.402313
2018-10-06 14:30:49,402 [salt.state       :1803][INFO    ][3070] Executing state host.present for [msg03]
2018-10-06 14:30:49,403 [salt.state       :290 ][INFO    ][3070] {'host': 'msg03'}
2018-10-06 14:30:49,403 [salt.state       :1941][INFO    ][3070] Completed state [msg03] at time 14:30:49.403857 duration_in_ms=1.544
2018-10-06 14:30:49,404 [salt.state       :1770][INFO    ][3070] Running state [msg03.mcp-pike-odl-ha.local] at time 14:30:49.404198
2018-10-06 14:30:49,404 [salt.state       :1803][INFO    ][3070] Executing state host.present for [msg03.mcp-pike-odl-ha.local]
2018-10-06 14:30:49,405 [salt.state       :290 ][INFO    ][3070] {'host': 'msg03.mcp-pike-odl-ha.local'}
2018-10-06 14:30:49,405 [salt.state       :1941][INFO    ][3070] Completed state [msg03.mcp-pike-odl-ha.local] at time 14:30:49.405731 duration_in_ms=1.533
2018-10-06 14:30:49,406 [salt.state       :1770][INFO    ][3070] Running state [msg01] at time 14:30:49.406068
2018-10-06 14:30:49,406 [salt.state       :1803][INFO    ][3070] Executing state host.present for [msg01]
2018-10-06 14:30:49,407 [salt.state       :290 ][INFO    ][3070] {'host': 'msg01'}
2018-10-06 14:30:49,407 [salt.state       :1941][INFO    ][3070] Completed state [msg01] at time 14:30:49.407935 duration_in_ms=1.867
2018-10-06 14:30:49,408 [salt.state       :1770][INFO    ][3070] Running state [msg01.mcp-pike-odl-ha.local] at time 14:30:49.408279
2018-10-06 14:30:49,408 [salt.state       :1803][INFO    ][3070] Executing state host.present for [msg01.mcp-pike-odl-ha.local]
2018-10-06 14:30:49,409 [salt.state       :290 ][INFO    ][3070] {'host': 'msg01.mcp-pike-odl-ha.local'}
2018-10-06 14:30:49,409 [salt.state       :1941][INFO    ][3070] Completed state [msg01.mcp-pike-odl-ha.local] at time 14:30:49.409826 duration_in_ms=1.547
2018-10-06 14:30:49,410 [salt.state       :1770][INFO    ][3070] Running state [msg] at time 14:30:49.410169
2018-10-06 14:30:49,410 [salt.state       :1803][INFO    ][3070] Executing state host.present for [msg]
2018-10-06 14:30:49,411 [salt.state       :290 ][INFO    ][3070] {'host': 'msg'}
2018-10-06 14:30:49,412 [salt.state       :1941][INFO    ][3070] Completed state [msg] at time 14:30:49.412049 duration_in_ms=1.88
2018-10-06 14:30:49,412 [salt.state       :1770][INFO    ][3070] Running state [msg.mcp-pike-odl-ha.local] at time 14:30:49.412389
2018-10-06 14:30:49,412 [salt.state       :1803][INFO    ][3070] Executing state host.present for [msg.mcp-pike-odl-ha.local]
2018-10-06 14:30:49,413 [salt.state       :290 ][INFO    ][3070] {'host': 'msg.mcp-pike-odl-ha.local'}
2018-10-06 14:30:49,413 [salt.state       :1941][INFO    ][3070] Completed state [msg.mcp-pike-odl-ha.local] at time 14:30:49.413936 duration_in_ms=1.547
2018-10-06 14:30:49,414 [salt.state       :1770][INFO    ][3070] Running state [cfg01] at time 14:30:49.414276
2018-10-06 14:30:49,414 [salt.state       :1803][INFO    ][3070] Executing state host.present for [cfg01]
2018-10-06 14:30:49,415 [salt.state       :290 ][INFO    ][3070] Host cfg01 (192.168.10.11) already present
2018-10-06 14:30:49,415 [salt.state       :1941][INFO    ][3070] Completed state [cfg01] at time 14:30:49.415218 duration_in_ms=0.942
2018-10-06 14:30:49,415 [salt.state       :1770][INFO    ][3070] Running state [cfg01.mcp-pike-odl-ha.local] at time 14:30:49.415573
2018-10-06 14:30:49,415 [salt.state       :1803][INFO    ][3070] Executing state host.present for [cfg01.mcp-pike-odl-ha.local]
2018-10-06 14:30:49,416 [salt.state       :290 ][INFO    ][3070] Host cfg01.mcp-pike-odl-ha.local (192.168.10.11) already present
2018-10-06 14:30:49,416 [salt.state       :1941][INFO    ][3070] Completed state [cfg01.mcp-pike-odl-ha.local] at time 14:30:49.416481 duration_in_ms=0.908
2018-10-06 14:30:49,416 [salt.state       :1770][INFO    ][3070] Running state [cmp002] at time 14:30:49.416813
2018-10-06 14:30:49,417 [salt.state       :1803][INFO    ][3070] Executing state host.present for [cmp002]
2018-10-06 14:30:49,420 [salt.state       :290 ][INFO    ][3070] {'host': 'cmp002'}
2018-10-06 14:30:49,421 [salt.state       :1941][INFO    ][3070] Completed state [cmp002] at time 14:30:49.421146 duration_in_ms=4.333
2018-10-06 14:30:49,421 [salt.state       :1770][INFO    ][3070] Running state [cmp002.mcp-pike-odl-ha.local] at time 14:30:49.421506
2018-10-06 14:30:49,421 [salt.state       :1803][INFO    ][3070] Executing state host.present for [cmp002.mcp-pike-odl-ha.local]
2018-10-06 14:30:49,422 [salt.state       :290 ][INFO    ][3070] {'host': 'cmp002.mcp-pike-odl-ha.local'}
2018-10-06 14:30:49,423 [salt.state       :1941][INFO    ][3070] Completed state [cmp002.mcp-pike-odl-ha.local] at time 14:30:49.423142 duration_in_ms=1.635
2018-10-06 14:30:49,423 [salt.state       :1770][INFO    ][3070] Running state [cmp001] at time 14:30:49.423520
2018-10-06 14:30:49,423 [salt.state       :1803][INFO    ][3070] Executing state host.present for [cmp001]
2018-10-06 14:30:49,424 [salt.state       :290 ][INFO    ][3070] {'host': 'cmp001'}
2018-10-06 14:30:49,425 [salt.state       :1941][INFO    ][3070] Completed state [cmp001] at time 14:30:49.425116 duration_in_ms=1.596
2018-10-06 14:30:49,425 [salt.state       :1770][INFO    ][3070] Running state [cmp001.mcp-pike-odl-ha.local] at time 14:30:49.425470
2018-10-06 14:30:49,425 [salt.state       :1803][INFO    ][3070] Executing state host.present for [cmp001.mcp-pike-odl-ha.local]
2018-10-06 14:30:49,426 [salt.state       :290 ][INFO    ][3070] {'host': 'cmp001.mcp-pike-odl-ha.local'}
2018-10-06 14:30:49,427 [salt.state       :1941][INFO    ][3070] Completed state [cmp001.mcp-pike-odl-ha.local] at time 14:30:49.427076 duration_in_ms=1.605
2018-10-06 14:30:49,427 [salt.state       :1770][INFO    ][3070] Running state [dbs01] at time 14:30:49.427457
2018-10-06 14:30:49,427 [salt.state       :1803][INFO    ][3070] Executing state host.present for [dbs01]
2018-10-06 14:30:49,428 [salt.state       :290 ][INFO    ][3070] {'host': 'dbs01'}
2018-10-06 14:30:49,429 [salt.state       :1941][INFO    ][3070] Completed state [dbs01] at time 14:30:49.429061 duration_in_ms=1.604
2018-10-06 14:30:49,429 [salt.state       :1770][INFO    ][3070] Running state [dbs01.mcp-pike-odl-ha.local] at time 14:30:49.429412
2018-10-06 14:30:49,429 [salt.state       :1803][INFO    ][3070] Executing state host.present for [dbs01.mcp-pike-odl-ha.local]
2018-10-06 14:30:49,431 [salt.state       :290 ][INFO    ][3070] {'host': 'dbs01.mcp-pike-odl-ha.local'}
2018-10-06 14:30:49,431 [salt.state       :1941][INFO    ][3070] Completed state [dbs01.mcp-pike-odl-ha.local] at time 14:30:49.431348 duration_in_ms=1.936
2018-10-06 14:30:49,431 [salt.state       :1770][INFO    ][3070] Running state [dbs02] at time 14:30:49.431732
2018-10-06 14:30:49,432 [salt.state       :1803][INFO    ][3070] Executing state host.present for [dbs02]
2018-10-06 14:30:49,433 [salt.state       :290 ][INFO    ][3070] {'host': 'dbs02'}
2018-10-06 14:30:49,433 [salt.state       :1941][INFO    ][3070] Completed state [dbs02] at time 14:30:49.433335 duration_in_ms=1.603
2018-10-06 14:30:49,433 [salt.state       :1770][INFO    ][3070] Running state [dbs02.mcp-pike-odl-ha.local] at time 14:30:49.433688
2018-10-06 14:30:49,433 [salt.state       :1803][INFO    ][3070] Executing state host.present for [dbs02.mcp-pike-odl-ha.local]
2018-10-06 14:30:49,435 [salt.state       :290 ][INFO    ][3070] {'host': 'dbs02.mcp-pike-odl-ha.local'}
2018-10-06 14:30:49,435 [salt.state       :1941][INFO    ][3070] Completed state [dbs02.mcp-pike-odl-ha.local] at time 14:30:49.435641 duration_in_ms=1.953
2018-10-06 14:30:49,436 [salt.state       :1770][INFO    ][3070] Running state [dbs03] at time 14:30:49.436011
2018-10-06 14:30:49,436 [salt.state       :1803][INFO    ][3070] Executing state host.present for [dbs03]
2018-10-06 14:30:49,437 [salt.state       :290 ][INFO    ][3070] {'host': 'dbs03'}
2018-10-06 14:30:49,437 [salt.state       :1941][INFO    ][3070] Completed state [dbs03] at time 14:30:49.437635 duration_in_ms=1.624
2018-10-06 14:30:49,438 [salt.state       :1770][INFO    ][3070] Running state [dbs03.mcp-pike-odl-ha.local] at time 14:30:49.437989
2018-10-06 14:30:49,438 [salt.state       :1803][INFO    ][3070] Executing state host.present for [dbs03.mcp-pike-odl-ha.local]
2018-10-06 14:30:49,439 [salt.state       :290 ][INFO    ][3070] {'host': 'dbs03.mcp-pike-odl-ha.local'}
2018-10-06 14:30:49,440 [salt.state       :1941][INFO    ][3070] Completed state [dbs03.mcp-pike-odl-ha.local] at time 14:30:49.440112 duration_in_ms=2.122
2018-10-06 14:30:49,440 [salt.state       :1770][INFO    ][3070] Running state [odl01] at time 14:30:49.440477
2018-10-06 14:30:49,440 [salt.state       :1803][INFO    ][3070] Executing state host.present for [odl01]
2018-10-06 14:30:49,441 [salt.state       :290 ][INFO    ][3070] {'host': 'odl01'}
2018-10-06 14:30:49,442 [salt.state       :1941][INFO    ][3070] Completed state [odl01] at time 14:30:49.442112 duration_in_ms=1.635
2018-10-06 14:30:49,443 [salt.state       :1770][INFO    ][3070] Running state [odl01.mcp-pike-odl-ha.local] at time 14:30:49.443071
2018-10-06 14:30:49,443 [salt.state       :1803][INFO    ][3070] Executing state host.present for [odl01.mcp-pike-odl-ha.local]
2018-10-06 14:30:49,444 [salt.state       :290 ][INFO    ][3070] {'host': 'odl01.mcp-pike-odl-ha.local'}
2018-10-06 14:30:49,444 [salt.state       :1941][INFO    ][3070] Completed state [odl01.mcp-pike-odl-ha.local] at time 14:30:49.444725 duration_in_ms=1.655
2018-10-06 14:30:49,445 [salt.state       :1770][INFO    ][3070] Running state [mas01] at time 14:30:49.445084
2018-10-06 14:30:49,445 [salt.state       :1803][INFO    ][3070] Executing state host.present for [mas01]
2018-10-06 14:30:49,446 [salt.state       :290 ][INFO    ][3070] {'host': 'mas01'}
2018-10-06 14:30:49,446 [salt.state       :1941][INFO    ][3070] Completed state [mas01] at time 14:30:49.446725 duration_in_ms=1.641
2018-10-06 14:30:49,447 [salt.state       :1770][INFO    ][3070] Running state [mas01.mcp-pike-odl-ha.local] at time 14:30:49.447080
2018-10-06 14:30:49,447 [salt.state       :1803][INFO    ][3070] Executing state host.present for [mas01.mcp-pike-odl-ha.local]
2018-10-06 14:30:49,448 [salt.state       :290 ][INFO    ][3070] {'host': 'mas01.mcp-pike-odl-ha.local'}
2018-10-06 14:30:49,448 [salt.state       :1941][INFO    ][3070] Completed state [mas01.mcp-pike-odl-ha.local] at time 14:30:49.448756 duration_in_ms=1.675
2018-10-06 14:30:49,449 [salt.state       :1770][INFO    ][3070] Running state [ctl02] at time 14:30:49.449111
2018-10-06 14:30:49,449 [salt.state       :1803][INFO    ][3070] Executing state host.present for [ctl02]
2018-10-06 14:30:49,450 [salt.state       :290 ][INFO    ][3070] {'host': 'ctl02'}
2018-10-06 14:30:49,450 [salt.state       :1941][INFO    ][3070] Completed state [ctl02] at time 14:30:49.450765 duration_in_ms=1.654
2018-10-06 14:30:49,451 [salt.state       :1770][INFO    ][3070] Running state [ctl02.mcp-pike-odl-ha.local] at time 14:30:49.451121
2018-10-06 14:30:49,451 [salt.state       :1803][INFO    ][3070] Executing state host.present for [ctl02.mcp-pike-odl-ha.local]
2018-10-06 14:30:49,452 [salt.state       :290 ][INFO    ][3070] {'host': 'ctl02.mcp-pike-odl-ha.local'}
2018-10-06 14:30:49,452 [salt.state       :1941][INFO    ][3070] Completed state [ctl02.mcp-pike-odl-ha.local] at time 14:30:49.452822 duration_in_ms=1.701
2018-10-06 14:30:49,453 [salt.state       :1770][INFO    ][3070] Running state [ctl03] at time 14:30:49.453185
2018-10-06 14:30:49,453 [salt.state       :1803][INFO    ][3070] Executing state host.present for [ctl03]
2018-10-06 14:30:49,454 [salt.state       :290 ][INFO    ][3070] {'host': 'ctl03'}
2018-10-06 14:30:49,454 [salt.state       :1941][INFO    ][3070] Completed state [ctl03] at time 14:30:49.454872 duration_in_ms=1.687
2018-10-06 14:30:49,455 [salt.state       :1770][INFO    ][3070] Running state [ctl03.mcp-pike-odl-ha.local] at time 14:30:49.455230
2018-10-06 14:30:49,455 [salt.state       :1803][INFO    ][3070] Executing state host.present for [ctl03.mcp-pike-odl-ha.local]
2018-10-06 14:30:49,456 [salt.state       :290 ][INFO    ][3070] {'host': 'ctl03.mcp-pike-odl-ha.local'}
2018-10-06 14:30:49,457 [salt.state       :1941][INFO    ][3070] Completed state [ctl03.mcp-pike-odl-ha.local] at time 14:30:49.457069 duration_in_ms=1.839
2018-10-06 14:30:49,457 [salt.state       :1770][INFO    ][3070] Running state [ctl01] at time 14:30:49.457430
2018-10-06 14:30:49,457 [salt.state       :1803][INFO    ][3070] Executing state host.present for [ctl01]
2018-10-06 14:30:49,458 [salt.state       :290 ][INFO    ][3070] {'host': 'ctl01'}
2018-10-06 14:30:49,459 [salt.state       :1941][INFO    ][3070] Completed state [ctl01] at time 14:30:49.459120 duration_in_ms=1.69
2018-10-06 14:30:49,459 [salt.state       :1770][INFO    ][3070] Running state [ctl01.mcp-pike-odl-ha.local] at time 14:30:49.459505
2018-10-06 14:30:49,459 [salt.state       :1803][INFO    ][3070] Executing state host.present for [ctl01.mcp-pike-odl-ha.local]
2018-10-06 14:30:49,461 [salt.state       :290 ][INFO    ][3070] {'host': 'ctl01.mcp-pike-odl-ha.local'}
2018-10-06 14:30:49,461 [salt.state       :1941][INFO    ][3070] Completed state [ctl01.mcp-pike-odl-ha.local] at time 14:30:49.461193 duration_in_ms=1.688
2018-10-06 14:30:49,461 [salt.state       :1770][INFO    ][3070] Running state [ctl] at time 14:30:49.461556
2018-10-06 14:30:49,461 [salt.state       :1803][INFO    ][3070] Executing state host.present for [ctl]
2018-10-06 14:30:49,463 [salt.state       :290 ][INFO    ][3070] {'host': 'ctl'}
2018-10-06 14:30:49,463 [salt.state       :1941][INFO    ][3070] Completed state [ctl] at time 14:30:49.463241 duration_in_ms=1.685
2018-10-06 14:30:49,463 [salt.state       :1770][INFO    ][3070] Running state [ctl.mcp-pike-odl-ha.local] at time 14:30:49.463625
2018-10-06 14:30:49,463 [salt.state       :1803][INFO    ][3070] Executing state host.present for [ctl.mcp-pike-odl-ha.local]
2018-10-06 14:30:49,465 [salt.state       :290 ][INFO    ][3070] {'host': 'ctl.mcp-pike-odl-ha.local'}
2018-10-06 14:30:49,465 [salt.state       :1941][INFO    ][3070] Completed state [ctl.mcp-pike-odl-ha.local] at time 14:30:49.465328 duration_in_ms=1.702
2018-10-06 14:30:49,465 [salt.state       :1770][INFO    ][3070] Running state [/etc/network/interfaces.d/50-cloud-init.cfg] at time 14:30:49.465584
2018-10-06 14:30:49,465 [salt.state       :1803][INFO    ][3070] Executing state file.absent for [/etc/network/interfaces.d/50-cloud-init.cfg]
2018-10-06 14:30:49,466 [salt.state       :290 ][INFO    ][3070] {'removed': '/etc/network/interfaces.d/50-cloud-init.cfg'}
2018-10-06 14:30:49,466 [salt.state       :1941][INFO    ][3070] Completed state [/etc/network/interfaces.d/50-cloud-init.cfg] at time 14:30:49.466820 duration_in_ms=1.237
2018-10-06 14:30:49,467 [salt.state       :1770][INFO    ][3070] Running state [ens2] at time 14:30:49.467734
2018-10-06 14:30:49,468 [salt.state       :1803][INFO    ][3070] Executing state network.managed for [ens2]
2018-10-06 14:30:49,617 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3070] Executing command ['ifdown', 'ens2'] in directory '/root'
2018-10-06 14:30:50,484 [salt.minion      :1307][INFO    ][2981] User sudo_ubuntu Executing command saltutil.find_job with jid 20181006143050471790
2018-10-06 14:30:50,502 [salt.minion      :1431][INFO    ][5250] Starting a new job with PID 5250
2018-10-06 14:30:50,523 [salt.minion      :1708][INFO    ][5250] Returning information for job: 20181006143050471790
2018-10-06 14:30:50,788 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3070] Executing command ['ifup', 'ens2'] in directory '/root'
2018-10-06 14:30:52,077 [salt.state       :290 ][INFO    ][3070] {'interface': 'Added network interface.', 'status': 'Interface ens2 restart to validate'}
2018-10-06 14:30:52,078 [salt.state       :1941][INFO    ][3070] Completed state [ens2] at time 14:30:52.078752 duration_in_ms=2611.018
2018-10-06 14:30:52,079 [salt.state       :1770][INFO    ][3070] Running state [ens3] at time 14:30:52.079465
2018-10-06 14:30:52,080 [salt.state       :1803][INFO    ][3070] Executing state network.managed for [ens3]
2018-10-06 14:30:52,115 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3070] Executing command ['ifup', 'ens3'] in directory '/root'
2018-10-06 14:30:52,812 [salt.state       :290 ][INFO    ][3070] {'interface': 'Added network interface.', 'status': 'Interface ens3 is up'}
2018-10-06 14:30:52,812 [salt.state       :1941][INFO    ][3070] Completed state [ens3] at time 14:30:52.812460 duration_in_ms=732.994
2018-10-06 14:30:52,812 [salt.state       :1770][INFO    ][3070] Running state [/etc/profile.d/proxy.sh] at time 14:30:52.812835
2018-10-06 14:30:52,813 [salt.state       :1803][INFO    ][3070] Executing state file.absent for [/etc/profile.d/proxy.sh]
2018-10-06 14:30:52,813 [salt.state       :290 ][INFO    ][3070] File /etc/profile.d/proxy.sh is not present
2018-10-06 14:30:52,813 [salt.state       :1941][INFO    ][3070] Completed state [/etc/profile.d/proxy.sh] at time 14:30:52.813873 duration_in_ms=1.038
2018-10-06 14:30:52,814 [salt.state       :1770][INFO    ][3070] Running state [/etc/apt/apt.conf.d/95proxies] at time 14:30:52.814125
2018-10-06 14:30:52,814 [salt.state       :1803][INFO    ][3070] Executing state file.absent for [/etc/apt/apt.conf.d/95proxies]
2018-10-06 14:30:52,815 [salt.state       :290 ][INFO    ][3070] File /etc/apt/apt.conf.d/95proxies is not present
2018-10-06 14:30:52,815 [salt.state       :1941][INFO    ][3070] Completed state [/etc/apt/apt.conf.d/95proxies] at time 14:30:52.815234 duration_in_ms=1.109
2018-10-06 14:30:52,816 [salt.state       :1770][INFO    ][3070] Running state [ntp] at time 14:30:52.816701
2018-10-06 14:30:52,816 [salt.state       :1803][INFO    ][3070] Executing state pkg.installed for [ntp]
2018-10-06 14:30:53,075 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3070] Executing command ['dpkg', '--get-selections', '*'] in directory '/root'
2018-10-06 14:30:53,106 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3070] 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-06 14:30:57,030 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3070] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}', '-W'] in directory '/root'
2018-10-06 14:30:57,077 [salt.state       :290 ][INFO    ][3070] 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-06 14:30:57,102 [salt.state       :905 ][INFO    ][3070] Loading fresh modules for state activity
2018-10-06 14:30:57,152 [salt.state       :1941][INFO    ][3070] Completed state [ntp] at time 14:30:57.152068 duration_in_ms=4335.366
2018-10-06 14:30:57,158 [salt.state       :1770][INFO    ][3070] Running state [/etc/ntp.conf] at time 14:30:57.158133
2018-10-06 14:30:57,158 [salt.state       :1803][INFO    ][3070] Executing state file.managed for [/etc/ntp.conf]
2018-10-06 14:30:57,187 [salt.fileclient  :1215][INFO    ][3070] Fetching file from saltenv 'base', ** done ** 'ntp/files/ntp.conf'
2018-10-06 14:30:57,269 [salt.state       :290 ][INFO    ][3070] 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-06 14:30:57,270 [salt.state       :1941][INFO    ][3070] Completed state [/etc/ntp.conf] at time 14:30:57.269978 duration_in_ms=111.845
2018-10-06 14:30:57,840 [salt.state       :1770][INFO    ][3070] Running state [ntp] at time 14:30:57.840829
2018-10-06 14:30:57,841 [salt.state       :1803][INFO    ][3070] Executing state service.running for [ntp]
2018-10-06 14:30:57,843 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3070] Executing command ['systemctl', 'status', 'ntp.service', '-n', '0'] in directory '/root'
2018-10-06 14:30:57,862 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3070] Executing command ['systemctl', 'is-active', 'ntp.service'] in directory '/root'
2018-10-06 14:30:57,878 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3070] Executing command ['systemctl', 'is-enabled', 'ntp.service'] in directory '/root'
2018-10-06 14:30:57,897 [salt.state       :290 ][INFO    ][3070] The service ntp is already running
2018-10-06 14:30:57,898 [salt.state       :1941][INFO    ][3070] Completed state [ntp] at time 14:30:57.898674 duration_in_ms=57.845
2018-10-06 14:30:57,899 [salt.state       :1770][INFO    ][3070] Running state [ntp] at time 14:30:57.899212
2018-10-06 14:30:57,899 [salt.state       :1803][INFO    ][3070] Executing state service.mod_watch for [ntp]
2018-10-06 14:30:57,900 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3070] Executing command ['systemctl', 'is-active', 'ntp.service'] in directory '/root'
2018-10-06 14:30:57,918 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3070] Executing command ['systemd-run', '--scope', 'systemctl', 'restart', 'ntp.service'] in directory '/root'
2018-10-06 14:30:57,998 [salt.state       :290 ][INFO    ][3070] {'ntp': True}
2018-10-06 14:30:57,999 [salt.state       :1941][INFO    ][3070] Completed state [ntp] at time 14:30:57.999266 duration_in_ms=100.053
2018-10-06 14:30:58,005 [salt.minion      :1708][INFO    ][3070] Returning information for job: 20181006143019913667
2018-10-06 14:31:17,226 [salt.minion      :1307][INFO    ][2981] User sudo_ubuntu Executing command state.apply with jid 20181006143117212897
2018-10-06 14:31:17,252 [salt.minion      :1431][INFO    ][6452] Starting a new job with PID 6452
2018-10-06 14:31:21,880 [salt.state       :905 ][INFO    ][6452] Loading fresh modules for state activity
2018-10-06 14:31:26,273 [salt.state       :1770][INFO    ][6452] Running state [/etc/environment] at time 14:31:26.273480
2018-10-06 14:31:26,274 [salt.state       :1803][INFO    ][6452] Executing state file.blockreplace for [/etc/environment]
2018-10-06 14:31:26,280 [salt.state       :290 ][INFO    ][6452] No changes needed to be made
2018-10-06 14:31:26,281 [salt.state       :1941][INFO    ][6452] Completed state [/etc/environment] at time 14:31:26.281408 duration_in_ms=7.929
2018-10-06 14:31:26,281 [salt.state       :1770][INFO    ][6452] Running state [/etc/profile.d] at time 14:31:26.281904
2018-10-06 14:31:26,282 [salt.state       :1803][INFO    ][6452] Executing state file.directory for [/etc/profile.d]
2018-10-06 14:31:26,284 [salt.state       :290 ][INFO    ][6452] Directory /etc/profile.d is in the correct state
Directory /etc/profile.d updated
2018-10-06 14:31:26,285 [salt.state       :1941][INFO    ][6452] Completed state [/etc/profile.d] at time 14:31:26.285319 duration_in_ms=3.415
2018-10-06 14:31:26,286 [salt.state       :1770][INFO    ][6452] Running state [fake_linux_system_at] at time 14:31:26.286253
2018-10-06 14:31:26,286 [salt.state       :1803][INFO    ][6452] Executing state test.nop for [fake_linux_system_at]
2018-10-06 14:31:26,287 [salt.state       :290 ][INFO    ][6452] Success!
2018-10-06 14:31:26,287 [salt.state       :1941][INFO    ][6452] Completed state [fake_linux_system_at] at time 14:31:26.287666 duration_in_ms=1.413
2018-10-06 14:31:26,288 [salt.state       :1770][INFO    ][6452] Running state [fake_linux_system_cron] at time 14:31:26.288123
2018-10-06 14:31:26,288 [salt.state       :1803][INFO    ][6452] Executing state test.nop for [fake_linux_system_cron]
2018-10-06 14:31:26,289 [salt.state       :290 ][INFO    ][6452] Success!
2018-10-06 14:31:26,289 [salt.state       :1941][INFO    ][6452] Completed state [fake_linux_system_cron] at time 14:31:26.289473 duration_in_ms=1.35
2018-10-06 14:31:27,017 [salt.state       :1770][INFO    ][6452] Running state [/etc/apt/apt.conf.d/99prefer_ipv4-salt] at time 14:31:27.017843
2018-10-06 14:31:27,018 [salt.state       :1803][INFO    ][6452] Executing state file.managed for [/etc/apt/apt.conf.d/99prefer_ipv4-salt]
2018-10-06 14:31:27,055 [salt.state       :290 ][INFO    ][6452] File /etc/apt/apt.conf.d/99prefer_ipv4-salt is in the correct state
2018-10-06 14:31:27,056 [salt.state       :1941][INFO    ][6452] Completed state [/etc/apt/apt.conf.d/99prefer_ipv4-salt] at time 14:31:27.056642 duration_in_ms=38.798
2018-10-06 14:31:27,057 [salt.state       :1770][INFO    ][6452] Running state [/etc/apt/apt.conf.d/99allow_downgrades-salt] at time 14:31:27.057168
2018-10-06 14:31:27,057 [salt.state       :1803][INFO    ][6452] Executing state file.managed for [/etc/apt/apt.conf.d/99allow_downgrades-salt]
2018-10-06 14:31:27,085 [salt.state       :290 ][INFO    ][6452] File /etc/apt/apt.conf.d/99allow_downgrades-salt is in the correct state
2018-10-06 14:31:27,086 [salt.state       :1941][INFO    ][6452] Completed state [/etc/apt/apt.conf.d/99allow_downgrades-salt] at time 14:31:27.086099 duration_in_ms=28.93
2018-10-06 14:31:27,088 [salt.state       :1770][INFO    ][6452] Running state [linux_repo_prereq_pkgs] at time 14:31:27.088149
2018-10-06 14:31:27,088 [salt.state       :1803][INFO    ][6452] Executing state pkg.installed for [linux_repo_prereq_pkgs]
2018-10-06 14:31:27,089 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6452] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}', '-W'] in directory '/root'
2018-10-06 14:31:27,279 [salt.minion      :1307][INFO    ][2981] User sudo_ubuntu Executing command saltutil.find_job with jid 20181006143127262975
2018-10-06 14:31:27,300 [salt.minion      :1431][INFO    ][6539] Starting a new job with PID 6539
2018-10-06 14:31:27,320 [salt.minion      :1708][INFO    ][6539] Returning information for job: 20181006143127262975
2018-10-06 14:31:27,583 [salt.state       :290 ][INFO    ][6452] All specified packages are already installed
2018-10-06 14:31:27,584 [salt.state       :1941][INFO    ][6452] Completed state [linux_repo_prereq_pkgs] at time 14:31:27.584235 duration_in_ms=496.086
2018-10-06 14:31:27,584 [salt.state       :1770][INFO    ][6452] Running state [/etc/apt/apt.conf.d/99proxies-salt] at time 14:31:27.584917
2018-10-06 14:31:27,585 [salt.state       :1803][INFO    ][6452] Executing state file.managed for [/etc/apt/apt.conf.d/99proxies-salt]
2018-10-06 14:31:27,617 [salt.state       :290 ][INFO    ][6452] File /etc/apt/apt.conf.d/99proxies-salt is in the correct state
2018-10-06 14:31:27,617 [salt.state       :1941][INFO    ][6452] Completed state [/etc/apt/apt.conf.d/99proxies-salt] at time 14:31:27.617719 duration_in_ms=32.801
2018-10-06 14:31:27,618 [salt.state       :1770][INFO    ][6452] Running state [/etc/apt/apt.conf.d/99proxies-salt-mk_openstack] at time 14:31:27.618003
2018-10-06 14:31:27,618 [salt.state       :1803][INFO    ][6452] Executing state file.absent for [/etc/apt/apt.conf.d/99proxies-salt-mk_openstack]
2018-10-06 14:31:27,618 [salt.state       :290 ][INFO    ][6452] File /etc/apt/apt.conf.d/99proxies-salt-mk_openstack is not present
2018-10-06 14:31:27,618 [salt.state       :1941][INFO    ][6452] Completed state [/etc/apt/apt.conf.d/99proxies-salt-mk_openstack] at time 14:31:27.618908 duration_in_ms=0.905
2018-10-06 14:31:27,619 [salt.state       :1770][INFO    ][6452] Running state [/etc/apt/preferences.d/mk_openstack] at time 14:31:27.619161
2018-10-06 14:31:27,619 [salt.state       :1803][INFO    ][6452] Executing state file.managed for [/etc/apt/preferences.d/mk_openstack]
2018-10-06 14:31:27,755 [salt.state       :290 ][INFO    ][6452] File /etc/apt/preferences.d/mk_openstack is in the correct state
2018-10-06 14:31:27,755 [salt.state       :1941][INFO    ][6452] Completed state [/etc/apt/preferences.d/mk_openstack] at time 14:31:27.755895 duration_in_ms=136.734
2018-10-06 14:31:27,760 [salt.state       :1770][INFO    ][6452] Running state [deb [arch=amd64] http://apt.mirantis.com/xenial/ nightly pike] at time 14:31:27.760376
2018-10-06 14:31:27,760 [salt.state       :1803][INFO    ][6452] Executing state pkgrepo.managed for [deb [arch=amd64] http://apt.mirantis.com/xenial/ nightly pike]
2018-10-06 14:31:27,807 [salt.state       :290 ][INFO    ][6452] Package repo 'deb [arch=amd64] http://apt.mirantis.com/xenial/ nightly pike' already configured
2018-10-06 14:31:27,808 [salt.state       :1941][INFO    ][6452] Completed state [deb [arch=amd64] http://apt.mirantis.com/xenial/ nightly pike] at time 14:31:27.808205 duration_in_ms=47.828
2018-10-06 14:31:27,808 [salt.state       :1770][INFO    ][6452] Running state [/etc/apt/apt.conf.d/99proxies-salt-uca-staging] at time 14:31:27.808490
2018-10-06 14:31:27,808 [salt.state       :1803][INFO    ][6452] Executing state file.absent for [/etc/apt/apt.conf.d/99proxies-salt-uca-staging]
2018-10-06 14:31:27,809 [salt.state       :290 ][INFO    ][6452] File /etc/apt/apt.conf.d/99proxies-salt-uca-staging is not present
2018-10-06 14:31:27,809 [salt.state       :1941][INFO    ][6452] Completed state [/etc/apt/apt.conf.d/99proxies-salt-uca-staging] at time 14:31:27.809347 duration_in_ms=0.857
2018-10-06 14:31:27,809 [salt.state       :1770][INFO    ][6452] Running state [/etc/apt/preferences.d/uca-staging] at time 14:31:27.809588
2018-10-06 14:31:27,809 [salt.state       :1803][INFO    ][6452] Executing state file.absent for [/etc/apt/preferences.d/uca-staging]
2018-10-06 14:31:27,810 [salt.state       :290 ][INFO    ][6452] File /etc/apt/preferences.d/uca-staging is not present
2018-10-06 14:31:27,810 [salt.state       :1941][INFO    ][6452] Completed state [/etc/apt/preferences.d/uca-staging] at time 14:31:27.810351 duration_in_ms=0.763
2018-10-06 14:31:27,816 [salt.state       :1770][INFO    ][6452] Running state [apt-key adv --keyserver keyserver.ubuntu.com --recv 9F68104E] at time 14:31:27.816013
2018-10-06 14:31:27,816 [salt.state       :1803][INFO    ][6452] Executing state cmd.run for [apt-key adv --keyserver keyserver.ubuntu.com --recv 9F68104E]
2018-10-06 14:31:27,817 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6452] Executing command 'test -e /etc/apt/sources.list.d/uca-staging.list' in directory '/root'
2018-10-06 14:31:27,834 [salt.state       :290 ][INFO    ][6452] unless execution succeeded
2018-10-06 14:31:27,835 [salt.state       :1941][INFO    ][6452] Completed state [apt-key adv --keyserver keyserver.ubuntu.com --recv 9F68104E] at time 14:31:27.835172 duration_in_ms=19.16
2018-10-06 14:31:27,839 [salt.state       :1770][INFO    ][6452] Running state [deb http://ppa.launchpad.net/ubuntu-cloud-archive/pike-staging/ubuntu xenial main] at time 14:31:27.839214
2018-10-06 14:31:27,839 [salt.state       :1803][INFO    ][6452] Executing state pkgrepo.managed for [deb http://ppa.launchpad.net/ubuntu-cloud-archive/pike-staging/ubuntu xenial main]
2018-10-06 14:31:27,881 [salt.state       :290 ][INFO    ][6452] Package repo 'deb http://ppa.launchpad.net/ubuntu-cloud-archive/pike-staging/ubuntu xenial main' already configured
2018-10-06 14:31:27,882 [salt.state       :1941][INFO    ][6452] Completed state [deb http://ppa.launchpad.net/ubuntu-cloud-archive/pike-staging/ubuntu xenial main] at time 14:31:27.881951 duration_in_ms=42.737
2018-10-06 14:31:27,882 [salt.state       :1770][INFO    ][6452] Running state [/etc/apt/apt.conf.d/99proxies-salt-mirantis_openstack] at time 14:31:27.882257
2018-10-06 14:31:27,882 [salt.state       :1803][INFO    ][6452] Executing state file.absent for [/etc/apt/apt.conf.d/99proxies-salt-mirantis_openstack]
2018-10-06 14:31:27,883 [salt.state       :290 ][INFO    ][6452] File /etc/apt/apt.conf.d/99proxies-salt-mirantis_openstack is not present
2018-10-06 14:31:27,883 [salt.state       :1941][INFO    ][6452] Completed state [/etc/apt/apt.conf.d/99proxies-salt-mirantis_openstack] at time 14:31:27.883227 duration_in_ms=0.97
2018-10-06 14:31:27,884 [salt.state       :1770][INFO    ][6452] Running state [/etc/apt/preferences.d/mirantis_openstack] at time 14:31:27.883489
2018-10-06 14:31:27,884 [salt.state       :1803][INFO    ][6452] Executing state file.managed for [/etc/apt/preferences.d/mirantis_openstack]
2018-10-06 14:31:28,019 [salt.state       :290 ][INFO    ][6452] File /etc/apt/preferences.d/mirantis_openstack is in the correct state
2018-10-06 14:31:28,019 [salt.state       :1941][INFO    ][6452] Completed state [/etc/apt/preferences.d/mirantis_openstack] at time 14:31:28.019784 duration_in_ms=136.294
2018-10-06 14:31:28,022 [salt.state       :1770][INFO    ][6452] Running state [deb http://mirror.fuel-infra.org/mcp-repos/pike/xenial pike main] at time 14:31:28.022187
2018-10-06 14:31:28,022 [salt.state       :1803][INFO    ][6452] Executing state pkgrepo.managed for [deb http://mirror.fuel-infra.org/mcp-repos/pike/xenial pike main]
2018-10-06 14:31:29,024 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6452] 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-06 14:31:29,250 [salt.state       :290 ][INFO    ][6452] Configured package repo 'deb http://mirror.fuel-infra.org/mcp-repos/pike/xenial pike main'
2018-10-06 14:31:29,250 [salt.state       :1941][INFO    ][6452] Completed state [deb http://mirror.fuel-infra.org/mcp-repos/pike/xenial pike main] at time 14:31:29.250850 duration_in_ms=1228.662
2018-10-06 14:31:29,251 [salt.state       :1770][INFO    ][6452] Running state [/etc/apt/apt.conf.d/99proxies-salt-uca] at time 14:31:29.251286
2018-10-06 14:31:29,252 [salt.state       :1803][INFO    ][6452] Executing state file.absent for [/etc/apt/apt.conf.d/99proxies-salt-uca]
2018-10-06 14:31:29,252 [salt.state       :290 ][INFO    ][6452] File /etc/apt/apt.conf.d/99proxies-salt-uca is not present
2018-10-06 14:31:29,253 [salt.state       :1941][INFO    ][6452] Completed state [/etc/apt/apt.conf.d/99proxies-salt-uca] at time 14:31:29.253132 duration_in_ms=1.846
2018-10-06 14:31:29,253 [salt.state       :1770][INFO    ][6452] Running state [/etc/apt/preferences.d/uca] at time 14:31:29.253389
2018-10-06 14:31:29,253 [salt.state       :1803][INFO    ][6452] Executing state file.managed for [/etc/apt/preferences.d/uca]
2018-10-06 14:31:29,405 [salt.state       :290 ][INFO    ][6452] File /etc/apt/preferences.d/uca is in the correct state
2018-10-06 14:31:29,406 [salt.state       :1941][INFO    ][6452] Completed state [/etc/apt/preferences.d/uca] at time 14:31:29.406166 duration_in_ms=152.776
2018-10-06 14:31:29,411 [salt.state       :1770][INFO    ][6452] Running state [apt-key adv --keyserver keyserver.ubuntu.com --recv EC4926EA] at time 14:31:29.411221
2018-10-06 14:31:29,411 [salt.state       :1803][INFO    ][6452] Executing state cmd.run for [apt-key adv --keyserver keyserver.ubuntu.com --recv EC4926EA]
2018-10-06 14:31:29,412 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6452] Executing command 'test -e /etc/apt/sources.list.d/uca.list' in directory '/root'
2018-10-06 14:31:29,427 [salt.state       :290 ][INFO    ][6452] unless execution succeeded
2018-10-06 14:31:29,428 [salt.state       :1941][INFO    ][6452] Completed state [apt-key adv --keyserver keyserver.ubuntu.com --recv EC4926EA] at time 14:31:29.428244 duration_in_ms=17.023
2018-10-06 14:31:29,432 [salt.state       :1770][INFO    ][6452] Running state [deb http://ubuntu-cloud.archive.canonical.com/ubuntu xenial-updates/pike main] at time 14:31:29.431507
2018-10-06 14:31:29,432 [salt.state       :1803][INFO    ][6452] Executing state pkgrepo.managed for [deb http://ubuntu-cloud.archive.canonical.com/ubuntu xenial-updates/pike main]
2018-10-06 14:31:29,540 [salt.state       :290 ][INFO    ][6452] Package repo 'deb http://ubuntu-cloud.archive.canonical.com/ubuntu xenial-updates/pike main' already configured
2018-10-06 14:31:29,540 [salt.state       :1941][INFO    ][6452] Completed state [deb http://ubuntu-cloud.archive.canonical.com/ubuntu xenial-updates/pike main] at time 14:31:29.540716 duration_in_ms=109.208
2018-10-06 14:31:29,541 [salt.state       :1770][INFO    ][6452] Running state [pkg.refresh_db] at time 14:31:29.541791
2018-10-06 14:31:29,542 [salt.state       :1803][INFO    ][6452] Executing state module.run for [pkg.refresh_db]
2018-10-06 14:31:29,542 [salt.utils.decorators:613 ][WARNING ][6452] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2018-10-06 14:31:29,543 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6452] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2018-10-06 14:31:33,655 [salt.state       :290 ][INFO    ][6452] {'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-06 14:31:33,656 [salt.state       :1941][INFO    ][6452] Completed state [pkg.refresh_db] at time 14:31:33.656457 duration_in_ms=4114.666
2018-10-06 14:31:33,657 [salt.state       :1770][INFO    ][6452] Running state [UTC] at time 14:31:33.657655
2018-10-06 14:31:33,658 [salt.state       :1803][INFO    ][6452] Executing state timezone.system for [UTC]
2018-10-06 14:31:33,659 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6452] Executing command ['timedatectl'] in directory '/root'
2018-10-06 14:31:33,690 [salt.state       :290 ][INFO    ][6452] Timezone UTC already set, UTC already set to UTC
2018-10-06 14:31:33,692 [salt.state       :1941][INFO    ][6452] Completed state [UTC] at time 14:31:33.691461 duration_in_ms=33.806
2018-10-06 14:31:33,692 [salt.state       :1770][INFO    ][6452] Running state [/etc/default/grub.d] at time 14:31:33.692576
2018-10-06 14:31:33,693 [salt.state       :1803][INFO    ][6452] Executing state file.directory for [/etc/default/grub.d]
2018-10-06 14:31:33,694 [salt.state       :290 ][INFO    ][6452] Directory /etc/default/grub.d is in the correct state
Directory /etc/default/grub.d updated
2018-10-06 14:31:33,695 [salt.state       :1941][INFO    ][6452] Completed state [/etc/default/grub.d] at time 14:31:33.695003 duration_in_ms=2.433
2018-10-06 14:31:33,695 [salt.state       :1770][INFO    ][6452] Running state [update-grub] at time 14:31:33.695372
2018-10-06 14:31:33,695 [salt.state       :1803][INFO    ][6452] Executing state cmd.wait for [update-grub]
2018-10-06 14:31:33,696 [salt.state       :290 ][INFO    ][6452] No changes made for update-grub
2018-10-06 14:31:33,696 [salt.state       :1941][INFO    ][6452] Completed state [update-grub] at time 14:31:33.696384 duration_in_ms=1.012
2018-10-06 14:31:33,699 [salt.state       :1770][INFO    ][6452] Running state [/boot/grub/grub.cfg] at time 14:31:33.699054
2018-10-06 14:31:33,700 [salt.state       :1803][INFO    ][6452] Executing state file.managed for [/boot/grub/grub.cfg]
2018-10-06 14:31:33,810 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6452] Executing command ['git', '--version'] in directory '/root'
2018-10-06 14:31:34,002 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6452] Executing command 'test -f /boot/grub/grub.cfg' in directory '/root'
2018-10-06 14:31:34,018 [salt.loaded.int.states.file:2150][WARNING ][6452] 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-06 14:31:34,019 [salt.state       :290 ][INFO    ][6452] File /boot/grub/grub.cfg exists with proper permissions. No changes made.
2018-10-06 14:31:34,020 [salt.state       :1941][INFO    ][6452] Completed state [/boot/grub/grub.cfg] at time 14:31:34.019965 duration_in_ms=320.91
2018-10-06 14:31:34,020 [salt.state       :1770][INFO    ][6452] Running state [nf_conntrack] at time 14:31:34.020404
2018-10-06 14:31:34,020 [salt.state       :1803][INFO    ][6452] Executing state kmod.present for [nf_conntrack]
2018-10-06 14:31:34,021 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6452] Executing command 'lsmod' in directory '/root'
2018-10-06 14:31:34,037 [salt.state       :290 ][INFO    ][6452] Kernel module nf_conntrack is already present
2018-10-06 14:31:34,038 [salt.state       :1941][INFO    ][6452] Completed state [nf_conntrack] at time 14:31:34.038204 duration_in_ms=17.8
2018-10-06 14:31:34,038 [salt.state       :1770][INFO    ][6452] Running state [kernel.panic] at time 14:31:34.038593
2018-10-06 14:31:34,038 [salt.state       :1803][INFO    ][6452] Executing state sysctl.present for [kernel.panic]
2018-10-06 14:31:34,055 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6452] Executing command 'sysctl -n kernel.panic' in directory '/root'
2018-10-06 14:31:34,077 [salt.state       :290 ][INFO    ][6452] Sysctl value kernel.panic = 60 is already set
2018-10-06 14:31:34,077 [salt.state       :1941][INFO    ][6452] Completed state [kernel.panic] at time 14:31:34.077536 duration_in_ms=38.943
2018-10-06 14:31:34,078 [salt.state       :1770][INFO    ][6452] Running state [net.ipv4.tcp_keepalive_probes] at time 14:31:34.077958
2018-10-06 14:31:34,078 [salt.state       :1803][INFO    ][6452] Executing state sysctl.present for [net.ipv4.tcp_keepalive_probes]
2018-10-06 14:31:34,079 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6452] Executing command 'sysctl -n net.ipv4.tcp_keepalive_probes' in directory '/root'
2018-10-06 14:31:34,095 [salt.state       :290 ][INFO    ][6452] Sysctl value net.ipv4.tcp_keepalive_probes = 8 is already set
2018-10-06 14:31:34,095 [salt.state       :1941][INFO    ][6452] Completed state [net.ipv4.tcp_keepalive_probes] at time 14:31:34.095698 duration_in_ms=17.74
2018-10-06 14:31:34,096 [salt.state       :1770][INFO    ][6452] Running state [fs.file-max] at time 14:31:34.096112
2018-10-06 14:31:34,096 [salt.state       :1803][INFO    ][6452] Executing state sysctl.present for [fs.file-max]
2018-10-06 14:31:34,097 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6452] Executing command 'sysctl -n fs.file-max' in directory '/root'
2018-10-06 14:31:34,112 [salt.state       :290 ][INFO    ][6452] Sysctl value fs.file-max = 124165 is already set
2018-10-06 14:31:34,112 [salt.state       :1941][INFO    ][6452] Completed state [fs.file-max] at time 14:31:34.112654 duration_in_ms=16.541
2018-10-06 14:31:34,113 [salt.state       :1770][INFO    ][6452] Running state [net.core.somaxconn] at time 14:31:34.113074
2018-10-06 14:31:34,113 [salt.state       :1803][INFO    ][6452] Executing state sysctl.present for [net.core.somaxconn]
2018-10-06 14:31:34,114 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6452] Executing command 'sysctl -n net.core.somaxconn' in directory '/root'
2018-10-06 14:31:34,129 [salt.state       :290 ][INFO    ][6452] Sysctl value net.core.somaxconn = 4096 is already set
2018-10-06 14:31:34,130 [salt.state       :1941][INFO    ][6452] Completed state [net.core.somaxconn] at time 14:31:34.130365 duration_in_ms=17.291
2018-10-06 14:31:34,130 [salt.state       :1770][INFO    ][6452] Running state [net.ipv4.tcp_max_syn_backlog] at time 14:31:34.130784
2018-10-06 14:31:34,131 [salt.state       :1803][INFO    ][6452] Executing state sysctl.present for [net.ipv4.tcp_max_syn_backlog]
2018-10-06 14:31:34,133 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6452] Executing command 'sysctl -n net.ipv4.tcp_max_syn_backlog' in directory '/root'
2018-10-06 14:31:34,148 [salt.state       :290 ][INFO    ][6452] Sysctl value net.ipv4.tcp_max_syn_backlog = 8192 is already set
2018-10-06 14:31:34,149 [salt.state       :1941][INFO    ][6452] Completed state [net.ipv4.tcp_max_syn_backlog] at time 14:31:34.149110 duration_in_ms=18.325
2018-10-06 14:31:34,149 [salt.state       :1770][INFO    ][6452] Running state [net.ipv4.tcp_tw_reuse] at time 14:31:34.149750
2018-10-06 14:31:34,150 [salt.state       :1803][INFO    ][6452] Executing state sysctl.present for [net.ipv4.tcp_tw_reuse]
2018-10-06 14:31:34,151 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6452] Executing command 'sysctl -n net.ipv4.tcp_tw_reuse' in directory '/root'
2018-10-06 14:31:34,168 [salt.state       :290 ][INFO    ][6452] Sysctl value net.ipv4.tcp_tw_reuse = 1 is already set
2018-10-06 14:31:34,168 [salt.state       :1941][INFO    ][6452] Completed state [net.ipv4.tcp_tw_reuse] at time 14:31:34.168605 duration_in_ms=18.855
2018-10-06 14:31:34,169 [salt.state       :1770][INFO    ][6452] Running state [net.ipv4.tcp_congestion_control] at time 14:31:34.169258
2018-10-06 14:31:34,169 [salt.state       :1803][INFO    ][6452] Executing state sysctl.present for [net.ipv4.tcp_congestion_control]
2018-10-06 14:31:34,171 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6452] Executing command 'sysctl -n net.ipv4.tcp_congestion_control' in directory '/root'
2018-10-06 14:31:34,186 [salt.state       :290 ][INFO    ][6452] Sysctl value net.ipv4.tcp_congestion_control = yeah is already set
2018-10-06 14:31:34,186 [salt.state       :1941][INFO    ][6452] Completed state [net.ipv4.tcp_congestion_control] at time 14:31:34.186793 duration_in_ms=17.535
2018-10-06 14:31:34,187 [salt.state       :1770][INFO    ][6452] Running state [net.ipv4.tcp_retries2] at time 14:31:34.187377
2018-10-06 14:31:34,188 [salt.state       :1803][INFO    ][6452] Executing state sysctl.present for [net.ipv4.tcp_retries2]
2018-10-06 14:31:34,189 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6452] Executing command 'sysctl -n net.ipv4.tcp_retries2' in directory '/root'
2018-10-06 14:31:34,205 [salt.state       :290 ][INFO    ][6452] Sysctl value net.ipv4.tcp_retries2 = 5 is already set
2018-10-06 14:31:34,206 [salt.state       :1941][INFO    ][6452] Completed state [net.ipv4.tcp_retries2] at time 14:31:34.205921 duration_in_ms=18.544
2018-10-06 14:31:34,206 [salt.state       :1770][INFO    ][6452] Running state [net.core.netdev_max_backlog] at time 14:31:34.206668
2018-10-06 14:31:34,207 [salt.state       :1803][INFO    ][6452] Executing state sysctl.present for [net.core.netdev_max_backlog]
2018-10-06 14:31:34,209 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6452] Executing command 'sysctl -n net.core.netdev_max_backlog' in directory '/root'
2018-10-06 14:31:34,226 [salt.state       :290 ][INFO    ][6452] Sysctl value net.core.netdev_max_backlog = 261144 is already set
2018-10-06 14:31:34,228 [salt.state       :1941][INFO    ][6452] Completed state [net.core.netdev_max_backlog] at time 14:31:34.227502 duration_in_ms=20.832
2018-10-06 14:31:34,228 [salt.state       :1770][INFO    ][6452] Running state [net.ipv4.tcp_slow_start_after_idle] at time 14:31:34.228713
2018-10-06 14:31:34,229 [salt.state       :1803][INFO    ][6452] Executing state sysctl.present for [net.ipv4.tcp_slow_start_after_idle]
2018-10-06 14:31:34,231 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6452] Executing command 'sysctl -n net.ipv4.tcp_slow_start_after_idle' in directory '/root'
2018-10-06 14:31:34,246 [salt.state       :290 ][INFO    ][6452] Sysctl value net.ipv4.tcp_slow_start_after_idle = 0 is already set
2018-10-06 14:31:34,247 [salt.state       :1941][INFO    ][6452] Completed state [net.ipv4.tcp_slow_start_after_idle] at time 14:31:34.247150 duration_in_ms=18.437
2018-10-06 14:31:34,248 [salt.state       :1770][INFO    ][6452] Running state [vm.swappiness] at time 14:31:34.248324
2018-10-06 14:31:34,248 [salt.state       :1803][INFO    ][6452] Executing state sysctl.present for [vm.swappiness]
2018-10-06 14:31:34,250 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6452] Executing command 'sysctl -n vm.swappiness' in directory '/root'
2018-10-06 14:31:34,265 [salt.state       :290 ][INFO    ][6452] Sysctl value vm.swappiness = 10 is already set
2018-10-06 14:31:34,266 [salt.state       :1941][INFO    ][6452] Completed state [vm.swappiness] at time 14:31:34.266113 duration_in_ms=17.788
2018-10-06 14:31:34,266 [salt.state       :1770][INFO    ][6452] Running state [net.ipv4.tcp_keepalive_intvl] at time 14:31:34.266887
2018-10-06 14:31:34,267 [salt.state       :1803][INFO    ][6452] Executing state sysctl.present for [net.ipv4.tcp_keepalive_intvl]
2018-10-06 14:31:34,269 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6452] Executing command 'sysctl -n net.ipv4.tcp_keepalive_intvl' in directory '/root'
2018-10-06 14:31:34,286 [salt.state       :290 ][INFO    ][6452] Sysctl value net.ipv4.tcp_keepalive_intvl = 3 is already set
2018-10-06 14:31:34,287 [salt.state       :1941][INFO    ][6452] Completed state [net.ipv4.tcp_keepalive_intvl] at time 14:31:34.287882 duration_in_ms=20.996
2018-10-06 14:31:34,288 [salt.state       :1770][INFO    ][6452] Running state [net.ipv4.neigh.default.gc_thresh1] at time 14:31:34.288551
2018-10-06 14:31:34,289 [salt.state       :1803][INFO    ][6452] Executing state sysctl.present for [net.ipv4.neigh.default.gc_thresh1]
2018-10-06 14:31:34,291 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6452] Executing command 'sysctl -n net.ipv4.neigh.default.gc_thresh1' in directory '/root'
2018-10-06 14:31:34,307 [salt.state       :290 ][INFO    ][6452] Sysctl value net.ipv4.neigh.default.gc_thresh1 = 4096 is already set
2018-10-06 14:31:34,308 [salt.state       :1941][INFO    ][6452] Completed state [net.ipv4.neigh.default.gc_thresh1] at time 14:31:34.308368 duration_in_ms=19.818
2018-10-06 14:31:34,308 [salt.state       :1770][INFO    ][6452] Running state [net.ipv4.neigh.default.gc_thresh2] at time 14:31:34.308914
2018-10-06 14:31:34,309 [salt.state       :1803][INFO    ][6452] Executing state sysctl.present for [net.ipv4.neigh.default.gc_thresh2]
2018-10-06 14:31:34,310 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6452] Executing command 'sysctl -n net.ipv4.neigh.default.gc_thresh2' in directory '/root'
2018-10-06 14:31:34,326 [salt.state       :290 ][INFO    ][6452] Sysctl value net.ipv4.neigh.default.gc_thresh2 = 8192 is already set
2018-10-06 14:31:34,326 [salt.state       :1941][INFO    ][6452] Completed state [net.ipv4.neigh.default.gc_thresh2] at time 14:31:34.326536 duration_in_ms=17.622
2018-10-06 14:31:34,327 [salt.state       :1770][INFO    ][6452] Running state [net.ipv4.neigh.default.gc_thresh3] at time 14:31:34.326964
2018-10-06 14:31:34,327 [salt.state       :1803][INFO    ][6452] Executing state sysctl.present for [net.ipv4.neigh.default.gc_thresh3]
2018-10-06 14:31:34,329 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6452] Executing command 'sysctl -n net.ipv4.neigh.default.gc_thresh3' in directory '/root'
2018-10-06 14:31:34,345 [salt.state       :290 ][INFO    ][6452] Sysctl value net.ipv4.neigh.default.gc_thresh3 = 16384 is already set
2018-10-06 14:31:34,346 [salt.state       :1941][INFO    ][6452] Completed state [net.ipv4.neigh.default.gc_thresh3] at time 14:31:34.346445 duration_in_ms=19.48
2018-10-06 14:31:34,347 [salt.state       :1770][INFO    ][6452] Running state [net.ipv4.tcp_fin_timeout] at time 14:31:34.347136
2018-10-06 14:31:34,349 [salt.state       :1803][INFO    ][6452] Executing state sysctl.present for [net.ipv4.tcp_fin_timeout]
2018-10-06 14:31:34,350 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6452] Executing command 'sysctl -n net.ipv4.tcp_fin_timeout' in directory '/root'
2018-10-06 14:31:34,366 [salt.state       :290 ][INFO    ][6452] Sysctl value net.ipv4.tcp_fin_timeout = 30 is already set
2018-10-06 14:31:34,367 [salt.state       :1941][INFO    ][6452] Completed state [net.ipv4.tcp_fin_timeout] at time 14:31:34.367133 duration_in_ms=19.997
2018-10-06 14:31:34,368 [salt.state       :1770][INFO    ][6452] Running state [net.ipv4.tcp_keepalive_time] at time 14:31:34.368539
2018-10-06 14:31:34,369 [salt.state       :1803][INFO    ][6452] Executing state sysctl.present for [net.ipv4.tcp_keepalive_time]
2018-10-06 14:31:34,370 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6452] Executing command 'sysctl -n net.ipv4.tcp_keepalive_time' in directory '/root'
2018-10-06 14:31:34,385 [salt.state       :290 ][INFO    ][6452] Sysctl value net.ipv4.tcp_keepalive_time = 30 is already set
2018-10-06 14:31:34,386 [salt.state       :1941][INFO    ][6452] Completed state [net.ipv4.tcp_keepalive_time] at time 14:31:34.386487 duration_in_ms=17.948
2018-10-06 14:31:34,386 [salt.state       :1770][INFO    ][6452] Running state [net.nf_conntrack_max] at time 14:31:34.386893
2018-10-06 14:31:34,387 [salt.state       :1803][INFO    ][6452] Executing state sysctl.present for [net.nf_conntrack_max]
2018-10-06 14:31:34,389 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6452] Executing command 'sysctl -n net.nf_conntrack_max' in directory '/root'
2018-10-06 14:31:34,405 [salt.state       :290 ][INFO    ][6452] Sysctl value net.nf_conntrack_max = 1048576 is already set
2018-10-06 14:31:34,405 [salt.state       :1941][INFO    ][6452] Completed state [net.nf_conntrack_max] at time 14:31:34.405740 duration_in_ms=18.847
2018-10-06 14:31:34,406 [salt.state       :1770][INFO    ][6452] Running state [linux_sysfs_package] at time 14:31:34.406420
2018-10-06 14:31:34,407 [salt.state       :1803][INFO    ][6452] Executing state pkg.installed for [linux_sysfs_package]
2018-10-06 14:31:34,417 [salt.state       :290 ][INFO    ][6452] All specified packages are already installed
2018-10-06 14:31:34,418 [salt.state       :1941][INFO    ][6452] Completed state [linux_sysfs_package] at time 14:31:34.418036 duration_in_ms=11.616
2018-10-06 14:31:34,420 [salt.state       :1770][INFO    ][6452] Running state [/etc/sysfs.d] at time 14:31:34.420123
2018-10-06 14:31:34,420 [salt.state       :1803][INFO    ][6452] Executing state file.directory for [/etc/sysfs.d]
2018-10-06 14:31:34,421 [salt.state       :290 ][INFO    ][6452] Directory /etc/sysfs.d is in the correct state
Directory /etc/sysfs.d updated
2018-10-06 14:31:34,421 [salt.state       :1941][INFO    ][6452] Completed state [/etc/sysfs.d] at time 14:31:34.421378 duration_in_ms=1.255
2018-10-06 14:31:34,421 [salt.state       :1770][INFO    ][6452] Running state [ondemand] at time 14:31:34.421636
2018-10-06 14:31:34,421 [salt.state       :1803][INFO    ][6452] Executing state service.dead for [ondemand]
2018-10-06 14:31:34,422 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6452] Executing command ['systemctl', 'status', 'ondemand.service', '-n', '0'] in directory '/root'
2018-10-06 14:31:34,442 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6452] Executing command ['systemctl', 'is-active', 'ondemand.service'] in directory '/root'
2018-10-06 14:31:34,464 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6452] Executing command ['systemctl', 'is-enabled', 'ondemand.service'] in directory '/root'
2018-10-06 14:31:34,492 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6452] Executing command 'runlevel' in directory '/root'
2018-10-06 14:31:34,510 [salt.state       :290 ][INFO    ][6452] The service ondemand is already dead
2018-10-06 14:31:34,511 [salt.state       :1941][INFO    ][6452] Completed state [ondemand] at time 14:31:34.511331 duration_in_ms=89.695
2018-10-06 14:31:34,512 [salt.state       :1770][INFO    ][6452] Running state [cs_CZ.UTF-8] at time 14:31:34.512115
2018-10-06 14:31:34,512 [salt.state       :1803][INFO    ][6452] Executing state locale.present for [cs_CZ.UTF-8]
2018-10-06 14:31:34,513 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6452] Executing command 'locale -a' in directory '/root'
2018-10-06 14:31:34,529 [salt.state       :290 ][INFO    ][6452] Locale cs_CZ.UTF-8 is already present
2018-10-06 14:31:34,530 [salt.state       :1941][INFO    ][6452] Completed state [cs_CZ.UTF-8] at time 14:31:34.530552 duration_in_ms=18.436
2018-10-06 14:31:34,531 [salt.state       :1770][INFO    ][6452] Running state [en_US.UTF-8] at time 14:31:34.530970
2018-10-06 14:31:34,531 [salt.state       :1803][INFO    ][6452] Executing state locale.present for [en_US.UTF-8]
2018-10-06 14:31:34,532 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6452] Executing command 'locale -a' in directory '/root'
2018-10-06 14:31:34,547 [salt.state       :290 ][INFO    ][6452] Locale en_US.UTF-8 is already present
2018-10-06 14:31:34,548 [salt.state       :1941][INFO    ][6452] Completed state [en_US.UTF-8] at time 14:31:34.548434 duration_in_ms=17.464
2018-10-06 14:31:34,551 [salt.state       :1770][INFO    ][6452] Running state [en_US.UTF-8] at time 14:31:34.551287
2018-10-06 14:31:34,552 [salt.state       :1803][INFO    ][6452] Executing state locale.system for [en_US.UTF-8]
2018-10-06 14:31:34,553 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6452] Executing command 'localectl' in directory '/root'
2018-10-06 14:31:34,585 [salt.state       :290 ][INFO    ][6452] System locale en_US.UTF-8 already set
2018-10-06 14:31:34,586 [salt.state       :1941][INFO    ][6452] Completed state [en_US.UTF-8] at time 14:31:34.586051 duration_in_ms=34.763
2018-10-06 14:31:34,586 [salt.state       :1770][INFO    ][6452] Running state [root] at time 14:31:34.586543
2018-10-06 14:31:34,586 [salt.state       :1803][INFO    ][6452] Executing state group.present for [root]
2018-10-06 14:31:34,588 [salt.state       :290 ][INFO    ][6452] Group root is present and up to date
2018-10-06 14:31:34,589 [salt.state       :1941][INFO    ][6452] Completed state [root] at time 14:31:34.589042 duration_in_ms=2.499
2018-10-06 14:31:34,591 [salt.state       :1770][INFO    ][6452] Running state [root] at time 14:31:34.590978
2018-10-06 14:31:34,591 [salt.state       :1803][INFO    ][6452] Executing state user.present for [root]
2018-10-06 14:31:34,593 [salt.state       :290 ][INFO    ][6452] User root is present and up to date
2018-10-06 14:31:34,593 [salt.state       :1941][INFO    ][6452] Completed state [root] at time 14:31:34.593250 duration_in_ms=2.272
2018-10-06 14:31:34,594 [salt.state       :1770][INFO    ][6452] Running state [/root] at time 14:31:34.594712
2018-10-06 14:31:34,595 [salt.state       :1803][INFO    ][6452] Executing state file.directory for [/root]
2018-10-06 14:31:34,596 [salt.state       :290 ][INFO    ][6452] Directory /root is in the correct state
Directory /root updated
2018-10-06 14:31:34,596 [salt.state       :1941][INFO    ][6452] Completed state [/root] at time 14:31:34.596340 duration_in_ms=1.628
2018-10-06 14:31:34,596 [salt.state       :1770][INFO    ][6452] Running state [/etc/sudoers.d/90-salt-user-root] at time 14:31:34.596614
2018-10-06 14:31:34,596 [salt.state       :1803][INFO    ][6452] Executing state file.absent for [/etc/sudoers.d/90-salt-user-root]
2018-10-06 14:31:34,597 [salt.state       :290 ][INFO    ][6452] File /etc/sudoers.d/90-salt-user-root is not present
2018-10-06 14:31:34,597 [salt.state       :1941][INFO    ][6452] Completed state [/etc/sudoers.d/90-salt-user-root] at time 14:31:34.597529 duration_in_ms=0.915
2018-10-06 14:31:34,597 [salt.state       :1770][INFO    ][6452] Running state [ubuntu] at time 14:31:34.597804
2018-10-06 14:31:34,598 [salt.state       :1803][INFO    ][6452] Executing state group.present for [ubuntu]
2018-10-06 14:31:34,598 [salt.state       :290 ][INFO    ][6452] Group ubuntu is present and up to date
2018-10-06 14:31:34,598 [salt.state       :1941][INFO    ][6452] Completed state [ubuntu] at time 14:31:34.598716 duration_in_ms=0.912
2018-10-06 14:31:34,600 [salt.state       :1770][INFO    ][6452] Running state [ubuntu] at time 14:31:34.600520
2018-10-06 14:31:34,600 [salt.state       :1803][INFO    ][6452] Executing state user.present for [ubuntu]
2018-10-06 14:31:34,601 [salt.state       :290 ][INFO    ][6452] User ubuntu is present and up to date
2018-10-06 14:31:34,602 [salt.state       :1941][INFO    ][6452] Completed state [ubuntu] at time 14:31:34.602125 duration_in_ms=1.605
2018-10-06 14:31:34,603 [salt.state       :1770][INFO    ][6452] Running state [/home/ubuntu] at time 14:31:34.603369
2018-10-06 14:31:34,603 [salt.state       :1803][INFO    ][6452] Executing state file.directory for [/home/ubuntu]
2018-10-06 14:31:34,604 [salt.state       :290 ][INFO    ][6452] Directory /home/ubuntu is in the correct state
Directory /home/ubuntu updated
2018-10-06 14:31:34,604 [salt.state       :1941][INFO    ][6452] Completed state [/home/ubuntu] at time 14:31:34.604696 duration_in_ms=1.327
2018-10-06 14:31:34,605 [salt.state       :1770][INFO    ][6452] Running state [/etc/sudoers.d/90-salt-user-ubuntu] at time 14:31:34.605767
2018-10-06 14:31:34,606 [salt.state       :1803][INFO    ][6452] Executing state file.managed for [/etc/sudoers.d/90-salt-user-ubuntu]
2018-10-06 14:31:34,633 [salt.state       :290 ][INFO    ][6452] File /etc/sudoers.d/90-salt-user-ubuntu is in the correct state
2018-10-06 14:31:34,633 [salt.state       :1941][INFO    ][6452] Completed state [/etc/sudoers.d/90-salt-user-ubuntu] at time 14:31:34.633479 duration_in_ms=27.712
2018-10-06 14:31:34,633 [salt.state       :1770][INFO    ][6452] Running state [/etc/security/limits.d/90-salt-default.conf] at time 14:31:34.633767
2018-10-06 14:31:34,634 [salt.state       :1803][INFO    ][6452] Executing state file.managed for [/etc/security/limits.d/90-salt-default.conf]
2018-10-06 14:31:34,764 [salt.state       :290 ][INFO    ][6452] File /etc/security/limits.d/90-salt-default.conf is in the correct state
2018-10-06 14:31:34,764 [salt.state       :1941][INFO    ][6452] Completed state [/etc/security/limits.d/90-salt-default.conf] at time 14:31:34.764289 duration_in_ms=130.522
2018-10-06 14:31:34,764 [salt.state       :1770][INFO    ][6452] Running state [/etc/systemd/system.conf.d/90-salt.conf] at time 14:31:34.764541
2018-10-06 14:31:34,764 [salt.state       :1803][INFO    ][6452] Executing state file.managed for [/etc/systemd/system.conf.d/90-salt.conf]
2018-10-06 14:31:34,887 [salt.state       :290 ][INFO    ][6452] File /etc/systemd/system.conf.d/90-salt.conf is in the correct state
2018-10-06 14:31:34,887 [salt.state       :1941][INFO    ][6452] Completed state [/etc/systemd/system.conf.d/90-salt.conf] at time 14:31:34.887379 duration_in_ms=122.838
2018-10-06 14:31:34,889 [salt.state       :1770][INFO    ][6452] Running state [service.systemctl_reload] at time 14:31:34.889026
2018-10-06 14:31:34,889 [salt.state       :1803][INFO    ][6452] Executing state module.wait for [service.systemctl_reload]
2018-10-06 14:31:34,889 [salt.state       :290 ][INFO    ][6452] No changes made for service.systemctl_reload
2018-10-06 14:31:34,889 [salt.state       :1941][INFO    ][6452] Completed state [service.systemctl_reload] at time 14:31:34.889817 duration_in_ms=0.791
2018-10-06 14:31:34,890 [salt.state       :1770][INFO    ][6452] Running state [/etc/issue] at time 14:31:34.890061
2018-10-06 14:31:34,890 [salt.state       :1803][INFO    ][6452] Executing state file.managed for [/etc/issue]
2018-10-06 14:31:34,892 [salt.state       :290 ][INFO    ][6452] File /etc/issue is in the correct state
2018-10-06 14:31:34,892 [salt.state       :1941][INFO    ][6452] Completed state [/etc/issue] at time 14:31:34.892869 duration_in_ms=2.808
2018-10-06 14:31:34,893 [salt.state       :1770][INFO    ][6452] Running state [/etc/hostname] at time 14:31:34.893194
2018-10-06 14:31:34,893 [salt.state       :1803][INFO    ][6452] Executing state file.managed for [/etc/hostname]
2018-10-06 14:31:34,917 [salt.state       :290 ][INFO    ][6452] File /etc/hostname is in the correct state
2018-10-06 14:31:34,917 [salt.state       :1941][INFO    ][6452] Completed state [/etc/hostname] at time 14:31:34.917693 duration_in_ms=24.499
2018-10-06 14:31:34,918 [salt.state       :1770][INFO    ][6452] Running state [hostname msg03] at time 14:31:34.918855
2018-10-06 14:31:34,919 [salt.state       :1803][INFO    ][6452] Executing state cmd.run for [hostname msg03]
2018-10-06 14:31:34,919 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6452] Executing command 'test "$(hostname)" = "msg03"' in directory '/root'
2018-10-06 14:31:34,940 [salt.state       :290 ][INFO    ][6452] unless execution succeeded
2018-10-06 14:31:34,940 [salt.state       :1941][INFO    ][6452] Completed state [hostname msg03] at time 14:31:34.940777 duration_in_ms=21.922
2018-10-06 14:31:34,941 [salt.state       :1770][INFO    ][6452] Running state [mdb02] at time 14:31:34.941410
2018-10-06 14:31:34,941 [salt.state       :1803][INFO    ][6452] Executing state host.present for [mdb02]
2018-10-06 14:31:34,942 [salt.state       :290 ][INFO    ][6452] Host mdb02 (192.168.10.33) already present
2018-10-06 14:31:34,943 [salt.state       :1941][INFO    ][6452] Completed state [mdb02] at time 14:31:34.943012 duration_in_ms=1.602
2018-10-06 14:31:34,943 [salt.state       :1770][INFO    ][6452] Running state [mdb02.mcp-pike-odl-ha.local] at time 14:31:34.943337
2018-10-06 14:31:34,943 [salt.state       :1803][INFO    ][6452] Executing state host.present for [mdb02.mcp-pike-odl-ha.local]
2018-10-06 14:31:34,944 [salt.state       :290 ][INFO    ][6452] Host mdb02.mcp-pike-odl-ha.local (192.168.10.33) already present
2018-10-06 14:31:34,944 [salt.state       :1941][INFO    ][6452] Completed state [mdb02.mcp-pike-odl-ha.local] at time 14:31:34.944437 duration_in_ms=1.1
2018-10-06 14:31:34,944 [salt.state       :1770][INFO    ][6452] Running state [mdb03] at time 14:31:34.944767
2018-10-06 14:31:34,945 [salt.state       :1803][INFO    ][6452] Executing state host.present for [mdb03]
2018-10-06 14:31:34,945 [salt.state       :290 ][INFO    ][6452] Host mdb03 (192.168.10.34) already present
2018-10-06 14:31:34,945 [salt.state       :1941][INFO    ][6452] Completed state [mdb03] at time 14:31:34.945786 duration_in_ms=1.019
2018-10-06 14:31:34,946 [salt.state       :1770][INFO    ][6452] Running state [mdb03.mcp-pike-odl-ha.local] at time 14:31:34.946100
2018-10-06 14:31:34,946 [salt.state       :1803][INFO    ][6452] Executing state host.present for [mdb03.mcp-pike-odl-ha.local]
2018-10-06 14:31:34,946 [salt.state       :290 ][INFO    ][6452] Host mdb03.mcp-pike-odl-ha.local (192.168.10.34) already present
2018-10-06 14:31:34,947 [salt.state       :1941][INFO    ][6452] Completed state [mdb03.mcp-pike-odl-ha.local] at time 14:31:34.947067 duration_in_ms=0.966
2018-10-06 14:31:34,947 [salt.state       :1770][INFO    ][6452] Running state [mdb01] at time 14:31:34.947385
2018-10-06 14:31:34,948 [salt.state       :1803][INFO    ][6452] Executing state host.present for [mdb01]
2018-10-06 14:31:34,948 [salt.state       :290 ][INFO    ][6452] Host mdb01 (192.168.10.32) already present
2018-10-06 14:31:34,948 [salt.state       :1941][INFO    ][6452] Completed state [mdb01] at time 14:31:34.948763 duration_in_ms=1.378
2018-10-06 14:31:34,949 [salt.state       :1770][INFO    ][6452] Running state [mdb01.mcp-pike-odl-ha.local] at time 14:31:34.949079
2018-10-06 14:31:34,949 [salt.state       :1803][INFO    ][6452] Executing state host.present for [mdb01.mcp-pike-odl-ha.local]
2018-10-06 14:31:34,949 [salt.state       :290 ][INFO    ][6452] Host mdb01.mcp-pike-odl-ha.local (192.168.10.32) already present
2018-10-06 14:31:34,950 [salt.state       :1941][INFO    ][6452] Completed state [mdb01.mcp-pike-odl-ha.local] at time 14:31:34.950042 duration_in_ms=0.963
2018-10-06 14:31:34,950 [salt.state       :1770][INFO    ][6452] Running state [mdb] at time 14:31:34.950357
2018-10-06 14:31:34,950 [salt.state       :1803][INFO    ][6452] Executing state host.present for [mdb]
2018-10-06 14:31:34,951 [salt.state       :290 ][INFO    ][6452] Host mdb (192.168.10.31) already present
2018-10-06 14:31:34,951 [salt.state       :1941][INFO    ][6452] Completed state [mdb] at time 14:31:34.951335 duration_in_ms=0.978
2018-10-06 14:31:34,951 [salt.state       :1770][INFO    ][6452] Running state [mdb.mcp-pike-odl-ha.local] at time 14:31:34.951680
2018-10-06 14:31:34,951 [salt.state       :1803][INFO    ][6452] Executing state host.present for [mdb.mcp-pike-odl-ha.local]
2018-10-06 14:31:34,952 [salt.state       :290 ][INFO    ][6452] Host mdb.mcp-pike-odl-ha.local (192.168.10.31) already present
2018-10-06 14:31:34,952 [salt.state       :1941][INFO    ][6452] Completed state [mdb.mcp-pike-odl-ha.local] at time 14:31:34.952690 duration_in_ms=1.011
2018-10-06 14:31:34,953 [salt.state       :1770][INFO    ][6452] Running state [cfg01] at time 14:31:34.953004
2018-10-06 14:31:34,953 [salt.state       :1803][INFO    ][6452] Executing state host.present for [cfg01]
2018-10-06 14:31:34,953 [salt.state       :290 ][INFO    ][6452] Host cfg01 (192.168.10.11) already present
2018-10-06 14:31:34,953 [salt.state       :1941][INFO    ][6452] Completed state [cfg01] at time 14:31:34.953951 duration_in_ms=0.947
2018-10-06 14:31:34,954 [salt.state       :1770][INFO    ][6452] Running state [cfg01.mcp-pike-odl-ha.local] at time 14:31:34.954254
2018-10-06 14:31:34,954 [salt.state       :1803][INFO    ][6452] Executing state host.present for [cfg01.mcp-pike-odl-ha.local]
2018-10-06 14:31:34,956 [salt.state       :290 ][INFO    ][6452] Host cfg01.mcp-pike-odl-ha.local (192.168.10.11) already present
2018-10-06 14:31:34,956 [salt.state       :1941][INFO    ][6452] Completed state [cfg01.mcp-pike-odl-ha.local] at time 14:31:34.956497 duration_in_ms=2.243
2018-10-06 14:31:34,956 [salt.state       :1770][INFO    ][6452] Running state [prx01] at time 14:31:34.956824
2018-10-06 14:31:34,957 [salt.state       :1803][INFO    ][6452] Executing state host.present for [prx01]
2018-10-06 14:31:34,957 [salt.state       :290 ][INFO    ][6452] Host prx01 (192.168.10.14) already present
2018-10-06 14:31:34,957 [salt.state       :1941][INFO    ][6452] Completed state [prx01] at time 14:31:34.957790 duration_in_ms=0.966
2018-10-06 14:31:34,958 [salt.state       :1770][INFO    ][6452] Running state [prx01.mcp-pike-odl-ha.local] at time 14:31:34.958108
2018-10-06 14:31:34,958 [salt.state       :1803][INFO    ][6452] Executing state host.present for [prx01.mcp-pike-odl-ha.local]
2018-10-06 14:31:34,958 [salt.state       :290 ][INFO    ][6452] Host prx01.mcp-pike-odl-ha.local (192.168.10.14) already present
2018-10-06 14:31:34,959 [salt.state       :1941][INFO    ][6452] Completed state [prx01.mcp-pike-odl-ha.local] at time 14:31:34.959048 duration_in_ms=0.94
2018-10-06 14:31:34,959 [salt.state       :1770][INFO    ][6452] Running state [kvm01] at time 14:31:34.959365
2018-10-06 14:31:34,960 [salt.state       :1803][INFO    ][6452] Executing state host.present for [kvm01]
2018-10-06 14:31:34,960 [salt.state       :290 ][INFO    ][6452] Host kvm01 (192.168.10.20) already present
2018-10-06 14:31:34,960 [salt.state       :1941][INFO    ][6452] Completed state [kvm01] at time 14:31:34.960699 duration_in_ms=1.334
2018-10-06 14:31:34,961 [salt.state       :1770][INFO    ][6452] Running state [kvm01.mcp-pike-odl-ha.local] at time 14:31:34.961016
2018-10-06 14:31:34,961 [salt.state       :1803][INFO    ][6452] Executing state host.present for [kvm01.mcp-pike-odl-ha.local]
2018-10-06 14:31:34,961 [salt.state       :290 ][INFO    ][6452] Host kvm01.mcp-pike-odl-ha.local (192.168.10.20) already present
2018-10-06 14:31:34,962 [salt.state       :1941][INFO    ][6452] Completed state [kvm01.mcp-pike-odl-ha.local] at time 14:31:34.961961 duration_in_ms=0.945
2018-10-06 14:31:34,962 [salt.state       :1770][INFO    ][6452] Running state [kvm03] at time 14:31:34.962278
2018-10-06 14:31:34,962 [salt.state       :1803][INFO    ][6452] Executing state host.present for [kvm03]
2018-10-06 14:31:34,963 [salt.state       :290 ][INFO    ][6452] Host kvm03 (192.168.10.22) already present
2018-10-06 14:31:34,963 [salt.state       :1941][INFO    ][6452] Completed state [kvm03] at time 14:31:34.963203 duration_in_ms=0.925
2018-10-06 14:31:34,963 [salt.state       :1770][INFO    ][6452] Running state [kvm03.mcp-pike-odl-ha.local] at time 14:31:34.963548
2018-10-06 14:31:34,963 [salt.state       :1803][INFO    ][6452] Executing state host.present for [kvm03.mcp-pike-odl-ha.local]
2018-10-06 14:31:34,964 [salt.state       :290 ][INFO    ][6452] Host kvm03.mcp-pike-odl-ha.local (192.168.10.22) already present
2018-10-06 14:31:34,964 [salt.state       :1941][INFO    ][6452] Completed state [kvm03.mcp-pike-odl-ha.local] at time 14:31:34.964474 duration_in_ms=0.926
2018-10-06 14:31:34,964 [salt.state       :1770][INFO    ][6452] Running state [kvm02] at time 14:31:34.964793
2018-10-06 14:31:34,965 [salt.state       :1803][INFO    ][6452] Executing state host.present for [kvm02]
2018-10-06 14:31:34,965 [salt.state       :290 ][INFO    ][6452] Host kvm02 (192.168.10.21) already present
2018-10-06 14:31:34,965 [salt.state       :1941][INFO    ][6452] Completed state [kvm02] at time 14:31:34.965719 duration_in_ms=0.926
2018-10-06 14:31:34,966 [salt.state       :1770][INFO    ][6452] Running state [kvm02.mcp-pike-odl-ha.local] at time 14:31:34.966028
2018-10-06 14:31:34,966 [salt.state       :1803][INFO    ][6452] Executing state host.present for [kvm02.mcp-pike-odl-ha.local]
2018-10-06 14:31:34,966 [salt.state       :290 ][INFO    ][6452] Host kvm02.mcp-pike-odl-ha.local (192.168.10.21) already present
2018-10-06 14:31:34,966 [salt.state       :1941][INFO    ][6452] Completed state [kvm02.mcp-pike-odl-ha.local] at time 14:31:34.966948 duration_in_ms=0.92
2018-10-06 14:31:34,967 [salt.state       :1770][INFO    ][6452] Running state [dbs] at time 14:31:34.967265
2018-10-06 14:31:34,968 [salt.state       :1803][INFO    ][6452] Executing state host.present for [dbs]
2018-10-06 14:31:34,968 [salt.state       :290 ][INFO    ][6452] Host dbs (192.168.10.23) already present
2018-10-06 14:31:34,968 [salt.state       :1941][INFO    ][6452] Completed state [dbs] at time 14:31:34.968835 duration_in_ms=1.57
2018-10-06 14:31:34,969 [salt.state       :1770][INFO    ][6452] Running state [dbs.mcp-pike-odl-ha.local] at time 14:31:34.969150
2018-10-06 14:31:34,969 [salt.state       :1803][INFO    ][6452] Executing state host.present for [dbs.mcp-pike-odl-ha.local]
2018-10-06 14:31:34,969 [salt.state       :290 ][INFO    ][6452] Host dbs.mcp-pike-odl-ha.local (192.168.10.23) already present
2018-10-06 14:31:34,970 [salt.state       :1941][INFO    ][6452] Completed state [dbs.mcp-pike-odl-ha.local] at time 14:31:34.970075 duration_in_ms=0.925
2018-10-06 14:31:34,970 [salt.state       :1770][INFO    ][6452] Running state [prx] at time 14:31:34.970406
2018-10-06 14:31:34,970 [salt.state       :1803][INFO    ][6452] Executing state host.present for [prx]
2018-10-06 14:31:34,971 [salt.state       :290 ][INFO    ][6452] Host prx (192.168.10.13) already present
2018-10-06 14:31:34,971 [salt.state       :1941][INFO    ][6452] Completed state [prx] at time 14:31:34.971335 duration_in_ms=0.929
2018-10-06 14:31:34,972 [salt.state       :1770][INFO    ][6452] Running state [prx.mcp-pike-odl-ha.local] at time 14:31:34.972036
2018-10-06 14:31:34,972 [salt.state       :1803][INFO    ][6452] Executing state host.present for [prx.mcp-pike-odl-ha.local]
2018-10-06 14:31:34,972 [salt.state       :290 ][INFO    ][6452] Host prx.mcp-pike-odl-ha.local (192.168.10.13) already present
2018-10-06 14:31:34,973 [salt.state       :1941][INFO    ][6452] Completed state [prx.mcp-pike-odl-ha.local] at time 14:31:34.972979 duration_in_ms=0.942
2018-10-06 14:31:34,973 [salt.state       :1770][INFO    ][6452] Running state [prx02] at time 14:31:34.973312
2018-10-06 14:31:34,973 [salt.state       :1803][INFO    ][6452] Executing state host.present for [prx02]
2018-10-06 14:31:34,974 [salt.state       :290 ][INFO    ][6452] Host prx02 (192.168.10.15) already present
2018-10-06 14:31:34,974 [salt.state       :1941][INFO    ][6452] Completed state [prx02] at time 14:31:34.974242 duration_in_ms=0.93
2018-10-06 14:31:34,974 [salt.state       :1770][INFO    ][6452] Running state [prx02.mcp-pike-odl-ha.local] at time 14:31:34.974560
2018-10-06 14:31:34,974 [salt.state       :1803][INFO    ][6452] Executing state host.present for [prx02.mcp-pike-odl-ha.local]
2018-10-06 14:31:34,975 [salt.state       :290 ][INFO    ][6452] Host prx02.mcp-pike-odl-ha.local (192.168.10.15) already present
2018-10-06 14:31:34,975 [salt.state       :1941][INFO    ][6452] Completed state [prx02.mcp-pike-odl-ha.local] at time 14:31:34.975514 duration_in_ms=0.952
2018-10-06 14:31:34,976 [salt.state       :1770][INFO    ][6452] Running state [msg02] at time 14:31:34.976168
2018-10-06 14:31:34,976 [salt.state       :1803][INFO    ][6452] Executing state host.present for [msg02]
2018-10-06 14:31:34,976 [salt.state       :290 ][INFO    ][6452] Host msg02 (192.168.10.29) already present
2018-10-06 14:31:34,977 [salt.state       :1941][INFO    ][6452] Completed state [msg02] at time 14:31:34.977096 duration_in_ms=0.928
2018-10-06 14:31:34,977 [salt.state       :1770][INFO    ][6452] Running state [msg02.mcp-pike-odl-ha.local] at time 14:31:34.977423
2018-10-06 14:31:34,977 [salt.state       :1803][INFO    ][6452] Executing state host.present for [msg02.mcp-pike-odl-ha.local]
2018-10-06 14:31:34,978 [salt.state       :290 ][INFO    ][6452] Host msg02.mcp-pike-odl-ha.local (192.168.10.29) already present
2018-10-06 14:31:34,978 [salt.state       :1941][INFO    ][6452] Completed state [msg02.mcp-pike-odl-ha.local] at time 14:31:34.978349 duration_in_ms=0.926
2018-10-06 14:31:34,978 [salt.state       :1770][INFO    ][6452] Running state [msg03] at time 14:31:34.978674
2018-10-06 14:31:34,978 [salt.state       :1803][INFO    ][6452] Executing state host.present for [msg03]
2018-10-06 14:31:34,979 [salt.state       :290 ][INFO    ][6452] Host msg03 (192.168.10.30) already present
2018-10-06 14:31:34,979 [salt.state       :1941][INFO    ][6452] Completed state [msg03] at time 14:31:34.979657 duration_in_ms=0.983
2018-10-06 14:31:34,980 [salt.state       :1770][INFO    ][6452] Running state [msg03.mcp-pike-odl-ha.local] at time 14:31:34.979978
2018-10-06 14:31:34,980 [salt.state       :1803][INFO    ][6452] Executing state host.present for [msg03.mcp-pike-odl-ha.local]
2018-10-06 14:31:34,980 [salt.state       :290 ][INFO    ][6452] Host msg03.mcp-pike-odl-ha.local (192.168.10.30) already present
2018-10-06 14:31:34,980 [salt.state       :1941][INFO    ][6452] Completed state [msg03.mcp-pike-odl-ha.local] at time 14:31:34.980912 duration_in_ms=0.934
2018-10-06 14:31:34,982 [salt.state       :1770][INFO    ][6452] Running state [file.replace] at time 14:31:34.982712
2018-10-06 14:31:34,983 [salt.state       :1803][INFO    ][6452] Executing state module.run for [file.replace]
2018-10-06 14:31:34,989 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6452] Executing command 'grep -q "msg03 msg03.mcp-pike-odl-ha.local" /etc/hosts' in directory '/root'
2018-10-06 14:31:35,005 [salt.utils.decorators:613 ][WARNING ][6452] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2018-10-06 14:31:35,010 [salt.state       :290 ][INFO    ][6452] {'ret': '--- \n+++ \n@@ -19,7 +19,7 @@\n 192.168.10.13\t\tprx prx.mcp-pike-odl-ha.local\n 192.168.10.15\t\tprx02 prx02.mcp-pike-odl-ha.local\n 192.168.10.29\t\tmsg02 msg02.mcp-pike-odl-ha.local\n-192.168.10.30\t\tmsg03 msg03.mcp-pike-odl-ha.local\n+192.168.10.30\t\tmsg03.mcp-pike-odl-ha.local msg03\n 192.168.10.28\t\tmsg01 msg01.mcp-pike-odl-ha.local\n 192.168.10.27\t\tmsg msg.mcp-pike-odl-ha.local\n 192.168.10.53\t\tcmp002 cmp002.mcp-pike-odl-ha.local\n'}
2018-10-06 14:31:35,011 [salt.state       :1941][INFO    ][6452] Completed state [file.replace] at time 14:31:35.011031 duration_in_ms=28.319
2018-10-06 14:31:35,011 [salt.state       :1770][INFO    ][6452] Running state [msg01] at time 14:31:35.011666
2018-10-06 14:31:35,011 [salt.state       :1803][INFO    ][6452] Executing state host.present for [msg01]
2018-10-06 14:31:35,012 [salt.state       :290 ][INFO    ][6452] Host msg01 (192.168.10.28) already present
2018-10-06 14:31:35,012 [salt.state       :1941][INFO    ][6452] Completed state [msg01] at time 14:31:35.012862 duration_in_ms=1.196
2018-10-06 14:31:35,013 [salt.state       :1770][INFO    ][6452] Running state [msg01.mcp-pike-odl-ha.local] at time 14:31:35.013213
2018-10-06 14:31:35,013 [salt.state       :1803][INFO    ][6452] Executing state host.present for [msg01.mcp-pike-odl-ha.local]
2018-10-06 14:31:35,014 [salt.state       :290 ][INFO    ][6452] Host msg01.mcp-pike-odl-ha.local (192.168.10.28) already present
2018-10-06 14:31:35,014 [salt.state       :1941][INFO    ][6452] Completed state [msg01.mcp-pike-odl-ha.local] at time 14:31:35.014184 duration_in_ms=0.971
2018-10-06 14:31:35,014 [salt.state       :1770][INFO    ][6452] Running state [msg] at time 14:31:35.014522
2018-10-06 14:31:35,014 [salt.state       :1803][INFO    ][6452] Executing state host.present for [msg]
2018-10-06 14:31:35,015 [salt.state       :290 ][INFO    ][6452] Host msg (192.168.10.27) already present
2018-10-06 14:31:35,015 [salt.state       :1941][INFO    ][6452] Completed state [msg] at time 14:31:35.015515 duration_in_ms=0.993
2018-10-06 14:31:35,015 [salt.state       :1770][INFO    ][6452] Running state [msg.mcp-pike-odl-ha.local] at time 14:31:35.015853
2018-10-06 14:31:35,016 [salt.state       :1803][INFO    ][6452] Executing state host.present for [msg.mcp-pike-odl-ha.local]
2018-10-06 14:31:35,016 [salt.state       :290 ][INFO    ][6452] Host msg.mcp-pike-odl-ha.local (192.168.10.27) already present
2018-10-06 14:31:35,016 [salt.state       :1941][INFO    ][6452] Completed state [msg.mcp-pike-odl-ha.local] at time 14:31:35.016810 duration_in_ms=0.957
2018-10-06 14:31:35,017 [salt.state       :1770][INFO    ][6452] Running state [cfg01] at time 14:31:35.017144
2018-10-06 14:31:35,017 [salt.state       :1803][INFO    ][6452] Executing state host.present for [cfg01]
2018-10-06 14:31:35,017 [salt.state       :290 ][INFO    ][6452] Host cfg01 (192.168.10.11) already present
2018-10-06 14:31:35,018 [salt.state       :1941][INFO    ][6452] Completed state [cfg01] at time 14:31:35.018106 duration_in_ms=0.961
2018-10-06 14:31:35,018 [salt.state       :1770][INFO    ][6452] Running state [cfg01.mcp-pike-odl-ha.local] at time 14:31:35.018441
2018-10-06 14:31:35,018 [salt.state       :1803][INFO    ][6452] Executing state host.present for [cfg01.mcp-pike-odl-ha.local]
2018-10-06 14:31:35,019 [salt.state       :290 ][INFO    ][6452] Host cfg01.mcp-pike-odl-ha.local (192.168.10.11) already present
2018-10-06 14:31:35,019 [salt.state       :1941][INFO    ][6452] Completed state [cfg01.mcp-pike-odl-ha.local] at time 14:31:35.019385 duration_in_ms=0.944
2018-10-06 14:31:35,019 [salt.state       :1770][INFO    ][6452] Running state [cmp002] at time 14:31:35.019775
2018-10-06 14:31:35,020 [salt.state       :1803][INFO    ][6452] Executing state host.present for [cmp002]
2018-10-06 14:31:35,020 [salt.state       :290 ][INFO    ][6452] Host cmp002 (192.168.10.53) already present
2018-10-06 14:31:35,020 [salt.state       :1941][INFO    ][6452] Completed state [cmp002] at time 14:31:35.020751 duration_in_ms=0.976
2018-10-06 14:31:35,021 [salt.state       :1770][INFO    ][6452] Running state [cmp002.mcp-pike-odl-ha.local] at time 14:31:35.021090
2018-10-06 14:31:35,021 [salt.state       :1803][INFO    ][6452] Executing state host.present for [cmp002.mcp-pike-odl-ha.local]
2018-10-06 14:31:35,021 [salt.state       :290 ][INFO    ][6452] Host cmp002.mcp-pike-odl-ha.local (192.168.10.53) already present
2018-10-06 14:31:35,022 [salt.state       :1941][INFO    ][6452] Completed state [cmp002.mcp-pike-odl-ha.local] at time 14:31:35.022040 duration_in_ms=0.95
2018-10-06 14:31:35,022 [salt.state       :1770][INFO    ][6452] Running state [cmp001] at time 14:31:35.022378
2018-10-06 14:31:35,022 [salt.state       :1803][INFO    ][6452] Executing state host.present for [cmp001]
2018-10-06 14:31:35,023 [salt.state       :290 ][INFO    ][6452] Host cmp001 (192.168.10.52) already present
2018-10-06 14:31:35,023 [salt.state       :1941][INFO    ][6452] Completed state [cmp001] at time 14:31:35.023324 duration_in_ms=0.946
2018-10-06 14:31:35,024 [salt.state       :1770][INFO    ][6452] Running state [cmp001.mcp-pike-odl-ha.local] at time 14:31:35.024044
2018-10-06 14:31:35,024 [salt.state       :1803][INFO    ][6452] Executing state host.present for [cmp001.mcp-pike-odl-ha.local]
2018-10-06 14:31:35,024 [salt.state       :290 ][INFO    ][6452] Host cmp001.mcp-pike-odl-ha.local (192.168.10.52) already present
2018-10-06 14:31:35,025 [salt.state       :1941][INFO    ][6452] Completed state [cmp001.mcp-pike-odl-ha.local] at time 14:31:35.024997 duration_in_ms=0.953
2018-10-06 14:31:35,025 [salt.state       :1770][INFO    ][6452] Running state [dbs01] at time 14:31:35.025334
2018-10-06 14:31:35,025 [salt.state       :1803][INFO    ][6452] Executing state host.present for [dbs01]
2018-10-06 14:31:35,026 [salt.state       :290 ][INFO    ][6452] Host dbs01 (192.168.10.24) already present
2018-10-06 14:31:35,026 [salt.state       :1941][INFO    ][6452] Completed state [dbs01] at time 14:31:35.026296 duration_in_ms=0.962
2018-10-06 14:31:35,026 [salt.state       :1770][INFO    ][6452] Running state [dbs01.mcp-pike-odl-ha.local] at time 14:31:35.026638
2018-10-06 14:31:35,026 [salt.state       :1803][INFO    ][6452] Executing state host.present for [dbs01.mcp-pike-odl-ha.local]
2018-10-06 14:31:35,027 [salt.state       :290 ][INFO    ][6452] Host dbs01.mcp-pike-odl-ha.local (192.168.10.24) already present
2018-10-06 14:31:35,027 [salt.state       :1941][INFO    ][6452] Completed state [dbs01.mcp-pike-odl-ha.local] at time 14:31:35.027655 duration_in_ms=1.017
2018-10-06 14:31:35,028 [salt.state       :1770][INFO    ][6452] Running state [dbs02] at time 14:31:35.028000
2018-10-06 14:31:35,028 [salt.state       :1803][INFO    ][6452] Executing state host.present for [dbs02]
2018-10-06 14:31:35,028 [salt.state       :290 ][INFO    ][6452] Host dbs02 (192.168.10.25) already present
2018-10-06 14:31:35,029 [salt.state       :1941][INFO    ][6452] Completed state [dbs02] at time 14:31:35.028956 duration_in_ms=0.956
2018-10-06 14:31:35,029 [salt.state       :1770][INFO    ][6452] Running state [dbs02.mcp-pike-odl-ha.local] at time 14:31:35.029295
2018-10-06 14:31:35,029 [salt.state       :1803][INFO    ][6452] Executing state host.present for [dbs02.mcp-pike-odl-ha.local]
2018-10-06 14:31:35,030 [salt.state       :290 ][INFO    ][6452] Host dbs02.mcp-pike-odl-ha.local (192.168.10.25) already present
2018-10-06 14:31:35,030 [salt.state       :1941][INFO    ][6452] Completed state [dbs02.mcp-pike-odl-ha.local] at time 14:31:35.030253 duration_in_ms=0.958
2018-10-06 14:31:35,030 [salt.state       :1770][INFO    ][6452] Running state [dbs03] at time 14:31:35.030598
2018-10-06 14:31:35,030 [salt.state       :1803][INFO    ][6452] Executing state host.present for [dbs03]
2018-10-06 14:31:35,031 [salt.state       :290 ][INFO    ][6452] Host dbs03 (192.168.10.26) already present
2018-10-06 14:31:35,031 [salt.state       :1941][INFO    ][6452] Completed state [dbs03] at time 14:31:35.031615 duration_in_ms=1.016
2018-10-06 14:31:35,032 [salt.state       :1770][INFO    ][6452] Running state [dbs03.mcp-pike-odl-ha.local] at time 14:31:35.031969
2018-10-06 14:31:35,032 [salt.state       :1803][INFO    ][6452] Executing state host.present for [dbs03.mcp-pike-odl-ha.local]
2018-10-06 14:31:35,032 [salt.state       :290 ][INFO    ][6452] Host dbs03.mcp-pike-odl-ha.local (192.168.10.26) already present
2018-10-06 14:31:35,032 [salt.state       :1941][INFO    ][6452] Completed state [dbs03.mcp-pike-odl-ha.local] at time 14:31:35.032944 duration_in_ms=0.974
2018-10-06 14:31:35,033 [salt.state       :1770][INFO    ][6452] Running state [odl01] at time 14:31:35.033286
2018-10-06 14:31:35,033 [salt.state       :1803][INFO    ][6452] Executing state host.present for [odl01]
2018-10-06 14:31:35,034 [salt.state       :290 ][INFO    ][6452] Host odl01 (192.168.10.39) already present
2018-10-06 14:31:35,034 [salt.state       :1941][INFO    ][6452] Completed state [odl01] at time 14:31:35.034427 duration_in_ms=1.141
2018-10-06 14:31:35,034 [salt.state       :1770][INFO    ][6452] Running state [odl01.mcp-pike-odl-ha.local] at time 14:31:35.034770
2018-10-06 14:31:35,035 [salt.state       :1803][INFO    ][6452] Executing state host.present for [odl01.mcp-pike-odl-ha.local]
2018-10-06 14:31:35,035 [salt.state       :290 ][INFO    ][6452] Host odl01.mcp-pike-odl-ha.local (192.168.10.39) already present
2018-10-06 14:31:35,035 [salt.state       :1941][INFO    ][6452] Completed state [odl01.mcp-pike-odl-ha.local] at time 14:31:35.035742 duration_in_ms=0.972
2018-10-06 14:31:35,036 [salt.state       :1770][INFO    ][6452] Running state [mas01] at time 14:31:35.036092
2018-10-06 14:31:35,036 [salt.state       :1803][INFO    ][6452] Executing state host.present for [mas01]
2018-10-06 14:31:35,036 [salt.state       :290 ][INFO    ][6452] Host mas01 (192.168.10.12) already present
2018-10-06 14:31:35,037 [salt.state       :1941][INFO    ][6452] Completed state [mas01] at time 14:31:35.037019 duration_in_ms=0.927
2018-10-06 14:31:35,037 [salt.state       :1770][INFO    ][6452] Running state [mas01.mcp-pike-odl-ha.local] at time 14:31:35.037362
2018-10-06 14:31:35,037 [salt.state       :1803][INFO    ][6452] Executing state host.present for [mas01.mcp-pike-odl-ha.local]
2018-10-06 14:31:35,038 [salt.state       :290 ][INFO    ][6452] Host mas01.mcp-pike-odl-ha.local (192.168.10.12) already present
2018-10-06 14:31:35,038 [salt.state       :1941][INFO    ][6452] Completed state [mas01.mcp-pike-odl-ha.local] at time 14:31:35.038288 duration_in_ms=0.926
2018-10-06 14:31:35,038 [salt.state       :1770][INFO    ][6452] Running state [ctl02] at time 14:31:35.038630
2018-10-06 14:31:35,038 [salt.state       :1803][INFO    ][6452] Executing state host.present for [ctl02]
2018-10-06 14:31:35,039 [salt.state       :290 ][INFO    ][6452] Host ctl02 (192.168.10.37) already present
2018-10-06 14:31:35,039 [salt.state       :1941][INFO    ][6452] Completed state [ctl02] at time 14:31:35.039593 duration_in_ms=0.964
2018-10-06 14:31:35,039 [salt.state       :1770][INFO    ][6452] Running state [ctl02.mcp-pike-odl-ha.local] at time 14:31:35.039938
2018-10-06 14:31:35,040 [salt.state       :1803][INFO    ][6452] Executing state host.present for [ctl02.mcp-pike-odl-ha.local]
2018-10-06 14:31:35,040 [salt.state       :290 ][INFO    ][6452] Host ctl02.mcp-pike-odl-ha.local (192.168.10.37) already present
2018-10-06 14:31:35,040 [salt.state       :1941][INFO    ][6452] Completed state [ctl02.mcp-pike-odl-ha.local] at time 14:31:35.040874 duration_in_ms=0.936
2018-10-06 14:31:35,041 [salt.state       :1770][INFO    ][6452] Running state [ctl03] at time 14:31:35.041225
2018-10-06 14:31:35,041 [salt.state       :1803][INFO    ][6452] Executing state host.present for [ctl03]
2018-10-06 14:31:35,042 [salt.state       :290 ][INFO    ][6452] Host ctl03 (192.168.10.38) already present
2018-10-06 14:31:35,042 [salt.state       :1941][INFO    ][6452] Completed state [ctl03] at time 14:31:35.042166 duration_in_ms=0.941
2018-10-06 14:31:35,042 [salt.state       :1770][INFO    ][6452] Running state [ctl03.mcp-pike-odl-ha.local] at time 14:31:35.042513
2018-10-06 14:31:35,042 [salt.state       :1803][INFO    ][6452] Executing state host.present for [ctl03.mcp-pike-odl-ha.local]
2018-10-06 14:31:35,043 [salt.state       :290 ][INFO    ][6452] Host ctl03.mcp-pike-odl-ha.local (192.168.10.38) already present
2018-10-06 14:31:35,043 [salt.state       :1941][INFO    ][6452] Completed state [ctl03.mcp-pike-odl-ha.local] at time 14:31:35.043478 duration_in_ms=0.965
2018-10-06 14:31:35,043 [salt.state       :1770][INFO    ][6452] Running state [ctl01] at time 14:31:35.043860
2018-10-06 14:31:35,044 [salt.state       :1803][INFO    ][6452] Executing state host.present for [ctl01]
2018-10-06 14:31:35,044 [salt.state       :290 ][INFO    ][6452] Host ctl01 (192.168.10.36) already present
2018-10-06 14:31:35,044 [salt.state       :1941][INFO    ][6452] Completed state [ctl01] at time 14:31:35.044790 duration_in_ms=0.93
2018-10-06 14:31:35,045 [salt.state       :1770][INFO    ][6452] Running state [ctl01.mcp-pike-odl-ha.local] at time 14:31:35.045142
2018-10-06 14:31:35,045 [salt.state       :1803][INFO    ][6452] Executing state host.present for [ctl01.mcp-pike-odl-ha.local]
2018-10-06 14:31:35,045 [salt.state       :290 ][INFO    ][6452] Host ctl01.mcp-pike-odl-ha.local (192.168.10.36) already present
2018-10-06 14:31:35,046 [salt.state       :1941][INFO    ][6452] Completed state [ctl01.mcp-pike-odl-ha.local] at time 14:31:35.046066 duration_in_ms=0.924
2018-10-06 14:31:35,046 [salt.state       :1770][INFO    ][6452] Running state [ctl] at time 14:31:35.046418
2018-10-06 14:31:35,046 [salt.state       :1803][INFO    ][6452] Executing state host.present for [ctl]
2018-10-06 14:31:35,047 [salt.state       :290 ][INFO    ][6452] Host ctl (192.168.10.35) already present
2018-10-06 14:31:35,047 [salt.state       :1941][INFO    ][6452] Completed state [ctl] at time 14:31:35.047350 duration_in_ms=0.932
2018-10-06 14:31:35,048 [salt.state       :1770][INFO    ][6452] Running state [ctl.mcp-pike-odl-ha.local] at time 14:31:35.048068
2018-10-06 14:31:35,048 [salt.state       :1803][INFO    ][6452] Executing state host.present for [ctl.mcp-pike-odl-ha.local]
2018-10-06 14:31:35,048 [salt.state       :290 ][INFO    ][6452] Host ctl.mcp-pike-odl-ha.local (192.168.10.35) already present
2018-10-06 14:31:35,049 [salt.state       :1941][INFO    ][6452] Completed state [ctl.mcp-pike-odl-ha.local] at time 14:31:35.049010 duration_in_ms=0.942
2018-10-06 14:31:35,049 [salt.state       :1770][INFO    ][6452] Running state [/etc/network/interfaces.d/50-cloud-init.cfg] at time 14:31:35.049246
2018-10-06 14:31:35,049 [salt.state       :1803][INFO    ][6452] Executing state file.absent for [/etc/network/interfaces.d/50-cloud-init.cfg]
2018-10-06 14:31:35,049 [salt.state       :290 ][INFO    ][6452] File /etc/network/interfaces.d/50-cloud-init.cfg is not present
2018-10-06 14:31:35,050 [salt.state       :1941][INFO    ][6452] Completed state [/etc/network/interfaces.d/50-cloud-init.cfg] at time 14:31:35.050012 duration_in_ms=0.767
2018-10-06 14:31:35,050 [salt.state       :1770][INFO    ][6452] Running state [ens2] at time 14:31:35.050268
2018-10-06 14:31:35,050 [salt.state       :1803][INFO    ][6452] Executing state network.managed for [ens2]
2018-10-06 14:31:35,197 [salt.state       :290 ][INFO    ][6452] Interface ens2 is up to date.
2018-10-06 14:31:35,198 [salt.state       :1941][INFO    ][6452] Completed state [ens2] at time 14:31:35.197990 duration_in_ms=147.722
2018-10-06 14:31:35,198 [salt.state       :1770][INFO    ][6452] Running state [ens3] at time 14:31:35.198420
2018-10-06 14:31:35,198 [salt.state       :1803][INFO    ][6452] Executing state network.managed for [ens3]
2018-10-06 14:31:35,227 [salt.state       :290 ][INFO    ][6452] Interface ens3 is up to date.
2018-10-06 14:31:35,228 [salt.state       :1941][INFO    ][6452] Completed state [ens3] at time 14:31:35.228505 duration_in_ms=30.084
2018-10-06 14:31:35,228 [salt.state       :1770][INFO    ][6452] Running state [/etc/profile.d/proxy.sh] at time 14:31:35.228942
2018-10-06 14:31:35,229 [salt.state       :1803][INFO    ][6452] Executing state file.absent for [/etc/profile.d/proxy.sh]
2018-10-06 14:31:35,229 [salt.state       :290 ][INFO    ][6452] File /etc/profile.d/proxy.sh is not present
2018-10-06 14:31:35,230 [salt.state       :1941][INFO    ][6452] Completed state [/etc/profile.d/proxy.sh] at time 14:31:35.230172 duration_in_ms=1.231
2018-10-06 14:31:35,230 [salt.state       :1770][INFO    ][6452] Running state [/etc/apt/apt.conf.d/95proxies] at time 14:31:35.230427
2018-10-06 14:31:35,230 [salt.state       :1803][INFO    ][6452] Executing state file.absent for [/etc/apt/apt.conf.d/95proxies]
2018-10-06 14:31:35,231 [salt.state       :290 ][INFO    ][6452] File /etc/apt/apt.conf.d/95proxies is not present
2018-10-06 14:31:35,231 [salt.state       :1941][INFO    ][6452] Completed state [/etc/apt/apt.conf.d/95proxies] at time 14:31:35.231205 duration_in_ms=0.779
2018-10-06 14:31:35,231 [salt.state       :1770][INFO    ][6452] Running state [ntp] at time 14:31:35.231490
2018-10-06 14:31:35,231 [salt.state       :1803][INFO    ][6452] Executing state pkg.installed for [ntp]
2018-10-06 14:31:35,244 [salt.state       :290 ][INFO    ][6452] All specified packages are already installed
2018-10-06 14:31:35,244 [salt.state       :1941][INFO    ][6452] Completed state [ntp] at time 14:31:35.244343 duration_in_ms=12.853
2018-10-06 14:31:35,246 [salt.state       :1770][INFO    ][6452] Running state [/etc/ntp.conf] at time 14:31:35.246504
2018-10-06 14:31:35,246 [salt.state       :1803][INFO    ][6452] Executing state file.managed for [/etc/ntp.conf]
2018-10-06 14:31:35,332 [salt.state       :290 ][INFO    ][6452] File /etc/ntp.conf is in the correct state
2018-10-06 14:31:35,333 [salt.state       :1941][INFO    ][6452] Completed state [/etc/ntp.conf] at time 14:31:35.333023 duration_in_ms=86.519
2018-10-06 14:31:35,334 [salt.state       :1770][INFO    ][6452] Running state [ntp] at time 14:31:35.334334
2018-10-06 14:31:35,334 [salt.state       :1803][INFO    ][6452] Executing state service.running for [ntp]
2018-10-06 14:31:35,335 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6452] Executing command ['systemctl', 'status', 'ntp.service', '-n', '0'] in directory '/root'
2018-10-06 14:31:35,355 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6452] Executing command ['systemctl', 'is-active', 'ntp.service'] in directory '/root'
2018-10-06 14:31:35,372 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6452] Executing command ['systemctl', 'is-enabled', 'ntp.service'] in directory '/root'
2018-10-06 14:31:35,393 [salt.state       :290 ][INFO    ][6452] The service ntp is already running
2018-10-06 14:31:35,394 [salt.state       :1941][INFO    ][6452] Completed state [ntp] at time 14:31:35.394002 duration_in_ms=59.668
2018-10-06 14:31:35,403 [salt.minion      :1708][INFO    ][6452] Returning information for job: 20181006143117212897
2018-10-06 14:31:36,216 [salt.minion      :1307][INFO    ][2981] User sudo_ubuntu Executing command ssh.set_auth_key with jid 20181006143136195303
2018-10-06 14:31:36,236 [salt.minion      :1431][INFO    ][7183] Starting a new job with PID 7183
2018-10-06 14:31:36,258 [salt.minion      :1708][INFO    ][7183] Returning information for job: 20181006143136195303
2018-10-06 14:32:12,710 [salt.minion      :1307][INFO    ][2981] User sudo_ubuntu Executing command pkg.upgrade with jid 20181006143212696430
2018-10-06 14:32:12,731 [salt.minion      :1431][INFO    ][7207] Starting a new job with PID 7207
2018-10-06 14:32:12,756 [salt.loader.192.168.11.2.int.module.cmdmod:395 ][INFO    ][7207] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}', '-W'] in directory '/root'
2018-10-06 14:32:13,177 [salt.loader.192.168.11.2.int.module.cmdmod:395 ][INFO    ][7207] 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-06 14:32:20,265 [salt.loader.192.168.11.2.int.module.cmdmod:395 ][INFO    ][7207] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}', '-W'] in directory '/root'
2018-10-06 14:32:20,303 [salt.minion      :1708][INFO    ][7207] Returning information for job: 20181006143212696430
2018-10-06 14:41:28,391 [salt.minion      :1307][INFO    ][2981] User sudo_ubuntu Executing command test.ping with jid 20181006144128381518
2018-10-06 14:41:28,423 [salt.minion      :1431][INFO    ][8150] Starting a new job with PID 8150
2018-10-06 14:41:28,449 [salt.minion      :1708][INFO    ][8150] Returning information for job: 20181006144128381518
2018-10-06 14:42:11,230 [salt.minion      :1307][INFO    ][2981] User sudo_ubuntu Executing command state.sls with jid 20181006144211210936
2018-10-06 14:42:11,248 [salt.minion      :1431][INFO    ][8156] Starting a new job with PID 8156
2018-10-06 14:42:11,872 [salt.state       :905 ][INFO    ][8156] Loading fresh modules for state activity
2018-10-06 14:42:11,938 [salt.fileclient  :1215][INFO    ][8156] Fetching file from saltenv 'base', ** done ** 'keepalived/init.sls'
2018-10-06 14:42:11,979 [salt.fileclient  :1215][INFO    ][8156] Fetching file from saltenv 'base', ** done ** 'keepalived/cluster.sls'
2018-10-06 14:42:12,743 [salt.state       :1770][INFO    ][8156] Running state [keepalived] at time 14:42:12.743844
2018-10-06 14:42:12,744 [salt.state       :1803][INFO    ][8156] Executing state pkg.installed for [keepalived]
2018-10-06 14:42:12,746 [salt.loaded.int.module.cmdmod:395 ][INFO    ][8156] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}', '-W'] in directory '/root'
2018-10-06 14:42:13,166 [salt.loaded.int.module.cmdmod:395 ][INFO    ][8156] Executing command ['apt-cache', '-q', 'policy', 'keepalived'] in directory '/root'
2018-10-06 14:42:13,271 [salt.loaded.int.module.cmdmod:395 ][INFO    ][8156] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2018-10-06 14:42:15,580 [salt.loaded.int.module.cmdmod:395 ][INFO    ][8156] Executing command ['dpkg', '--get-selections', '*'] in directory '/root'
2018-10-06 14:42:15,617 [salt.loaded.int.module.cmdmod:395 ][INFO    ][8156] 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-06 14:42:19,992 [salt.loaded.int.module.cmdmod:395 ][INFO    ][8156] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}', '-W'] in directory '/root'
2018-10-06 14:42:20,033 [salt.state       :290 ][INFO    ][8156] 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-06 14:42:20,055 [salt.state       :905 ][INFO    ][8156] Loading fresh modules for state activity
2018-10-06 14:42:20,099 [salt.state       :1941][INFO    ][8156] Completed state [keepalived] at time 14:42:20.099889 duration_in_ms=7356.046
2018-10-06 14:42:20,106 [salt.state       :1770][INFO    ][8156] Running state [lsof] at time 14:42:20.106337
2018-10-06 14:42:20,106 [salt.state       :1803][INFO    ][8156] Executing state pkg.installed for [lsof]
2018-10-06 14:42:20,833 [salt.state       :290 ][INFO    ][8156] All specified packages are already installed
2018-10-06 14:42:20,834 [salt.state       :1941][INFO    ][8156] Completed state [lsof] at time 14:42:20.834220 duration_in_ms=727.881
2018-10-06 14:42:20,838 [salt.state       :1770][INFO    ][8156] Running state [/etc/keepalived/keepalived.conf] at time 14:42:20.838044
2018-10-06 14:42:20,838 [salt.state       :1803][INFO    ][8156] Executing state file.managed for [/etc/keepalived/keepalived.conf]
2018-10-06 14:42:20,880 [salt.fileclient  :1215][INFO    ][8156] Fetching file from saltenv 'base', ** done ** 'keepalived/files/keepalived.conf'
2018-10-06 14:42:20,942 [salt.state       :290 ][INFO    ][8156] File changed:
New file
2018-10-06 14:42:20,943 [salt.state       :1941][INFO    ][8156] Completed state [/etc/keepalived/keepalived.conf] at time 14:42:20.943482 duration_in_ms=105.438
2018-10-06 14:42:20,944 [salt.state       :1770][INFO    ][8156] Running state [keepalived] at time 14:42:20.944697
2018-10-06 14:42:20,945 [salt.state       :1803][INFO    ][8156] Executing state service.running for [keepalived]
2018-10-06 14:42:20,946 [salt.loaded.int.module.cmdmod:395 ][INFO    ][8156] Executing command ['systemctl', 'status', 'keepalived.service', '-n', '0'] in directory '/root'
2018-10-06 14:42:20,963 [salt.loaded.int.module.cmdmod:395 ][INFO    ][8156] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2018-10-06 14:42:20,983 [salt.loaded.int.module.cmdmod:395 ][INFO    ][8156] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2018-10-06 14:42:21,012 [salt.loaded.int.module.cmdmod:395 ][INFO    ][8156] Executing command ['systemd-run', '--scope', 'systemctl', 'start', 'keepalived.service'] in directory '/root'
2018-10-06 14:42:21,083 [salt.loaded.int.module.cmdmod:395 ][INFO    ][8156] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2018-10-06 14:42:21,102 [salt.loaded.int.module.cmdmod:395 ][INFO    ][8156] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2018-10-06 14:42:21,122 [salt.loaded.int.module.cmdmod:395 ][INFO    ][8156] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2018-10-06 14:42:21,140 [salt.state       :290 ][INFO    ][8156] {'keepalived': True}
2018-10-06 14:42:21,140 [salt.state       :1941][INFO    ][8156] Completed state [keepalived] at time 14:42:21.140458 duration_in_ms=195.76
2018-10-06 14:42:21,142 [salt.minion      :1708][INFO    ][8156] Returning information for job: 20181006144211210936
2018-10-06 14:44:35,792 [salt.minion      :1307][INFO    ][2981] User sudo_ubuntu Executing command pillar.get with jid 20181006144435781965
2018-10-06 14:44:35,818 [salt.minion      :1431][INFO    ][9612] Starting a new job with PID 9612
2018-10-06 14:44:35,826 [salt.minion      :1708][INFO    ][9612] Returning information for job: 20181006144435781965
2018-10-06 14:47:14,301 [salt.minion      :1307][INFO    ][2981] User sudo_ubuntu Executing command state.sls with jid 20181006144714287427
2018-10-06 14:47:14,324 [salt.minion      :1431][INFO    ][9617] Starting a new job with PID 9617
2018-10-06 14:47:18,028 [salt.state       :905 ][INFO    ][9617] Loading fresh modules for state activity
2018-10-06 14:47:18,089 [salt.fileclient  :1215][INFO    ][9617] Fetching file from saltenv 'base', ** done ** 'rabbitmq/init.sls'
2018-10-06 14:47:18,137 [salt.fileclient  :1215][INFO    ][9617] Fetching file from saltenv 'base', ** done ** 'rabbitmq/server/init.sls'
2018-10-06 14:47:18,168 [salt.fileclient  :1215][INFO    ][9617] Fetching file from saltenv 'base', ** done ** 'rabbitmq/server/service.sls'
2018-10-06 14:47:18,232 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9617] Executing command 'cat /var/lib/rabbitmq/.erlang.cookie' in directory '/root'
2018-10-06 14:47:18,251 [salt.loaded.int.module.cmdmod:722 ][ERROR   ][9617] Command 'cat /var/lib/rabbitmq/.erlang.cookie' failed with return code: 1
2018-10-06 14:47:18,251 [salt.loaded.int.module.cmdmod:724 ][ERROR   ][9617] stdout: cat: /var/lib/rabbitmq/.erlang.cookie: No such file or directory
2018-10-06 14:47:18,251 [salt.loaded.int.module.cmdmod:728 ][ERROR   ][9617] retcode: 1
2018-10-06 14:47:18,294 [salt.fileclient  :1215][INFO    ][9617] Fetching file from saltenv 'base', ** done ** 'rabbitmq/server/ssl.sls'
2018-10-06 14:47:18,367 [salt.fileclient  :1215][INFO    ][9617] Fetching file from saltenv 'base', ** done ** 'rabbitmq/server/plugin.sls'
2018-10-06 14:47:18,451 [salt.fileclient  :1215][INFO    ][9617] Fetching file from saltenv 'base', ** done ** 'rabbitmq/server/vhost.sls'
2018-10-06 14:47:18,548 [salt.fileclient  :1215][INFO    ][9617] Fetching file from saltenv 'base', ** done ** 'rabbitmq/server/user.sls'
2018-10-06 14:47:18,616 [salt.fileclient  :1215][INFO    ][9617] Fetching file from saltenv 'base', ** done ** 'rabbitmq/cluster.sls'
2018-10-06 14:47:19,403 [salt.state       :1770][INFO    ][9617] Running state [rabbitmq-server] at time 14:47:19.403333
2018-10-06 14:47:19,404 [salt.state       :1803][INFO    ][9617] Executing state pkg.installed for [rabbitmq-server]
2018-10-06 14:47:19,404 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9617] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}', '-W'] in directory '/root'
2018-10-06 14:47:19,830 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9617] Executing command ['apt-cache', '-q', 'policy', 'rabbitmq-server'] in directory '/root'
2018-10-06 14:47:19,954 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9617] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2018-10-06 14:47:22,311 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9617] Executing command ['dpkg', '--get-selections', '*'] in directory '/root'
2018-10-06 14:47:22,342 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9617] 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-06 14:47:24,399 [salt.minion      :1307][INFO    ][2981] User sudo_ubuntu Executing command saltutil.find_job with jid 20181006144724379967
2018-10-06 14:47:24,414 [salt.minion      :1431][INFO    ][10112] Starting a new job with PID 10112
2018-10-06 14:47:24,433 [salt.minion      :1708][INFO    ][10112] Returning information for job: 20181006144724379967
2018-10-06 14:47:34,628 [salt.minion      :1307][INFO    ][2981] User sudo_ubuntu Executing command saltutil.find_job with jid 20181006144734607877
2018-10-06 14:47:34,644 [salt.minion      :1431][INFO    ][10981] Starting a new job with PID 10981
2018-10-06 14:47:34,662 [salt.minion      :1708][INFO    ][10981] Returning information for job: 20181006144734607877
2018-10-06 14:47:44,662 [salt.minion      :1307][INFO    ][2981] User sudo_ubuntu Executing command saltutil.find_job with jid 20181006144744648911
2018-10-06 14:47:44,681 [salt.minion      :1431][INFO    ][10986] Starting a new job with PID 10986
2018-10-06 14:47:44,698 [salt.minion      :1708][INFO    ][10986] Returning information for job: 20181006144744648911
2018-10-06 14:47:54,860 [salt.minion      :1307][INFO    ][2981] User sudo_ubuntu Executing command saltutil.find_job with jid 20181006144754840747
2018-10-06 14:47:54,876 [salt.minion      :1431][INFO    ][10991] Starting a new job with PID 10991
2018-10-06 14:47:54,893 [salt.minion      :1708][INFO    ][10991] Returning information for job: 20181006144754840747
2018-10-06 14:48:05,087 [salt.minion      :1307][INFO    ][2981] User sudo_ubuntu Executing command saltutil.find_job with jid 20181006144805070736
2018-10-06 14:48:05,107 [salt.minion      :1431][INFO    ][10996] Starting a new job with PID 10996
2018-10-06 14:48:05,127 [salt.minion      :1708][INFO    ][10996] Returning information for job: 20181006144805070736
2018-10-06 14:48:07,752 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9617] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}', '-W'] in directory '/root'
2018-10-06 14:48:07,799 [salt.state       :290 ][INFO    ][9617] 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-06 14:48:07,833 [salt.state       :905 ][INFO    ][9617] Loading fresh modules for state activity
2018-10-06 14:48:07,874 [salt.state       :1941][INFO    ][9617] Completed state [rabbitmq-server] at time 14:48:07.874087 duration_in_ms=48470.755
2018-10-06 14:48:07,879 [salt.state       :1770][INFO    ][9617] Running state [/etc/rabbitmq/rabbitmq.config] at time 14:48:07.879227
2018-10-06 14:48:07,879 [salt.state       :1803][INFO    ][9617] Executing state file.managed for [/etc/rabbitmq/rabbitmq.config]
2018-10-06 14:48:07,915 [salt.fileclient  :1215][INFO    ][9617] Fetching file from saltenv 'base', ** done ** 'rabbitmq/files/rabbitmq.config'
2018-10-06 14:48:07,986 [salt.state       :290 ][INFO    ][9617] File changed:
New file
2018-10-06 14:48:07,986 [salt.state       :1941][INFO    ][9617] Completed state [/etc/rabbitmq/rabbitmq.config] at time 14:48:07.986215 duration_in_ms=106.996
2018-10-06 14:48:07,986 [salt.state       :1770][INFO    ][9617] Running state [/etc/default/rabbitmq-server] at time 14:48:07.986615
2018-10-06 14:48:07,986 [salt.state       :1803][INFO    ][9617] Executing state file.managed for [/etc/default/rabbitmq-server]
2018-10-06 14:48:08,008 [salt.fileclient  :1215][INFO    ][9617] Fetching file from saltenv 'base', ** done ** 'rabbitmq/files/default'
2018-10-06 14:48:08,048 [salt.state       :290 ][INFO    ][9617] 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-06 14:48:08,049 [salt.state       :1941][INFO    ][9617] Completed state [/etc/default/rabbitmq-server] at time 14:48:08.049055 duration_in_ms=62.44
2018-10-06 14:48:08,049 [salt.state       :1770][INFO    ][9617] Running state [/etc/systemd/system/rabbitmq-server.service.d/limits.conf] at time 14:48:08.049504
2018-10-06 14:48:08,049 [salt.state       :1803][INFO    ][9617] Executing state file.managed for [/etc/systemd/system/rabbitmq-server.service.d/limits.conf]
2018-10-06 14:48:08,072 [salt.fileclient  :1215][INFO    ][9617] Fetching file from saltenv 'base', ** done ** 'rabbitmq/files/limits.conf'
2018-10-06 14:48:08,111 [salt.state       :290 ][INFO    ][9617] File changed:
New file
2018-10-06 14:48:08,111 [salt.state       :1941][INFO    ][9617] Completed state [/etc/systemd/system/rabbitmq-server.service.d/limits.conf] at time 14:48:08.111330 duration_in_ms=61.826
2018-10-06 14:48:08,112 [salt.state       :1770][INFO    ][9617] Running state [sleep 30] at time 14:48:08.112731
2018-10-06 14:48:08,113 [salt.state       :1803][INFO    ][9617] Executing state cmd.run for [sleep 30]
2018-10-06 14:48:08,113 [py.warnings      :2526][WARNING ][9617] /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-06 14:48:08,116 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9617] Executing command 'sleep 30' as user 'root' in directory '/root'
2018-10-06 14:48:15,311 [salt.minion      :1307][INFO    ][2981] User sudo_ubuntu Executing command saltutil.find_job with jid 20181006144815296858
2018-10-06 14:48:15,336 [salt.minion      :1431][INFO    ][11178] Starting a new job with PID 11178
2018-10-06 14:48:15,356 [salt.minion      :1708][INFO    ][11178] Returning information for job: 20181006144815296858
2018-10-06 14:48:25,377 [salt.minion      :1307][INFO    ][2981] User sudo_ubuntu Executing command saltutil.find_job with jid 20181006144825356313
2018-10-06 14:48:25,399 [salt.minion      :1431][INFO    ][11183] Starting a new job with PID 11183
2018-10-06 14:48:25,419 [salt.minion      :1708][INFO    ][11183] Returning information for job: 20181006144825356313
2018-10-06 14:48:35,400 [salt.minion      :1307][INFO    ][2981] User sudo_ubuntu Executing command saltutil.find_job with jid 20181006144835383491
2018-10-06 14:48:35,421 [salt.minion      :1431][INFO    ][11188] Starting a new job with PID 11188
2018-10-06 14:48:35,440 [salt.minion      :1708][INFO    ][11188] Returning information for job: 20181006144835383491
2018-10-06 14:48:38,219 [salt.state       :290 ][INFO    ][9617] {'pid': 11138, 'retcode': 0, 'stderr': '', 'stdout': ''}
2018-10-06 14:48:38,221 [salt.state       :1941][INFO    ][9617] Completed state [sleep 30] at time 14:48:38.221030 duration_in_ms=30108.297
2018-10-06 14:48:38,224 [salt.state       :1770][INFO    ][9617] Running state [service rabbitmq-server stop] at time 14:48:38.224188
2018-10-06 14:48:38,225 [salt.state       :1803][INFO    ][9617] Executing state cmd.run for [service rabbitmq-server stop]
2018-10-06 14:48:38,227 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9617] Executing command 'service rabbitmq-server stop' in directory '/root'
2018-10-06 14:48:38,570 [salt.state       :290 ][INFO    ][9617] {'pid': 11191, 'retcode': 0, 'stderr': '', 'stdout': ''}
2018-10-06 14:48:38,572 [salt.state       :1941][INFO    ][9617] Completed state [service rabbitmq-server stop] at time 14:48:38.571903 duration_in_ms=347.715
2018-10-06 14:48:38,572 [salt.state       :1770][INFO    ][9617] Running state [/var/lib/rabbitmq] at time 14:48:38.572623
2018-10-06 14:48:38,573 [salt.state       :1803][INFO    ][9617] Executing state file.directory for [/var/lib/rabbitmq]
2018-10-06 14:48:38,574 [salt.state       :290 ][INFO    ][9617] Directory /var/lib/rabbitmq is in the correct state
Directory /var/lib/rabbitmq updated
2018-10-06 14:48:38,575 [salt.state       :1941][INFO    ][9617] Completed state [/var/lib/rabbitmq] at time 14:48:38.575186 duration_in_ms=2.564
2018-10-06 14:48:38,576 [salt.state       :1770][INFO    ][9617] Running state [/var/lib/rabbitmq/.erlang.cookie] at time 14:48:38.576754
2018-10-06 14:48:38,577 [salt.state       :1803][INFO    ][9617] Executing state file.managed for [/var/lib/rabbitmq/.erlang.cookie]
2018-10-06 14:48:38,580 [salt.state       :290 ][INFO    ][9617] File changed:
--- 
+++ 
@@ -1 +1 @@
-DGSCNQFOUVRWMDWBHIHV+opnfv_secret

2018-10-06 14:48:38,581 [salt.state       :1941][INFO    ][9617] Completed state [/var/lib/rabbitmq/.erlang.cookie] at time 14:48:38.581042 duration_in_ms=4.288
2018-10-06 14:48:38,582 [salt.state       :1770][INFO    ][9617] Running state [sleep 30] at time 14:48:38.582436
2018-10-06 14:48:38,582 [salt.state       :1803][INFO    ][9617] Executing state cmd.run for [sleep 30]
2018-10-06 14:48:38,583 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9617] Executing command 'sleep 30' as user 'root' in directory '/root'
2018-10-06 14:48:45,629 [salt.minion      :1307][INFO    ][2981] User sudo_ubuntu Executing command saltutil.find_job with jid 20181006144845611421
2018-10-06 14:48:45,653 [salt.minion      :1431][INFO    ][11275] Starting a new job with PID 11275
2018-10-06 14:48:45,676 [salt.minion      :1708][INFO    ][11275] Returning information for job: 20181006144845611421
2018-10-06 14:48:55,672 [salt.minion      :1307][INFO    ][2981] User sudo_ubuntu Executing command saltutil.find_job with jid 20181006144855649391
2018-10-06 14:48:55,697 [salt.minion      :1431][INFO    ][11280] Starting a new job with PID 11280
2018-10-06 14:48:55,717 [salt.minion      :1708][INFO    ][11280] Returning information for job: 20181006144855649391
2018-10-06 14:49:05,722 [salt.minion      :1307][INFO    ][2981] User sudo_ubuntu Executing command saltutil.find_job with jid 20181006144905702860
2018-10-06 14:49:05,747 [salt.minion      :1431][INFO    ][11285] Starting a new job with PID 11285
2018-10-06 14:49:05,767 [salt.minion      :1708][INFO    ][11285] Returning information for job: 20181006144905702860
2018-10-06 14:49:08,682 [salt.state       :290 ][INFO    ][9617] {'pid': 11250, 'retcode': 0, 'stderr': '', 'stdout': ''}
2018-10-06 14:49:08,683 [salt.state       :1941][INFO    ][9617] Completed state [sleep 30] at time 14:49:08.683450 duration_in_ms=30101.013
2018-10-06 14:49:09,200 [salt.state       :1770][INFO    ][9617] Running state [rabbitmq-server] at time 14:49:09.200603
2018-10-06 14:49:09,201 [salt.state       :1803][INFO    ][9617] Executing state service.running for [rabbitmq-server]
2018-10-06 14:49:09,201 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9617] Executing command ['systemctl', 'status', 'rabbitmq-server.service', '-n', '0'] in directory '/root'
2018-10-06 14:49:09,225 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9617] Executing command ['systemctl', 'is-active', 'rabbitmq-server.service'] in directory '/root'
2018-10-06 14:49:09,241 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9617] Executing command ['systemctl', 'is-enabled', 'rabbitmq-server.service'] in directory '/root'
2018-10-06 14:49:09,266 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9617] Executing command ['systemd-run', '--scope', 'systemctl', 'start', 'rabbitmq-server.service'] in directory '/root'
2018-10-06 14:49:12,443 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9617] Executing command ['systemctl', 'is-active', 'rabbitmq-server.service'] in directory '/root'
2018-10-06 14:49:12,462 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9617] Executing command ['systemctl', 'is-enabled', 'rabbitmq-server.service'] in directory '/root'
2018-10-06 14:49:12,483 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9617] Executing command ['systemctl', 'is-enabled', 'rabbitmq-server.service'] in directory '/root'
2018-10-06 14:49:12,509 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9617] Executing command ['systemd-run', '--scope', 'systemctl', 'enable', 'rabbitmq-server.service'] in directory '/root'
2018-10-06 14:49:13,011 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9617] Executing command ['systemctl', 'is-enabled', 'rabbitmq-server.service'] in directory '/root'
2018-10-06 14:49:13,030 [salt.state       :290 ][INFO    ][9617] {'rabbitmq-server': True}
2018-10-06 14:49:13,031 [salt.state       :1941][INFO    ][9617] Completed state [rabbitmq-server] at time 14:49:13.031156 duration_in_ms=3830.552
2018-10-06 14:49:13,035 [salt.state       :1770][INFO    ][9617] Running state [amqp_client] at time 14:49:13.035199
2018-10-06 14:49:13,035 [salt.state       :1803][INFO    ][9617] Executing state rabbitmq_plugin.enabled for [amqp_client]
2018-10-06 14:49:13,036 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9617] Executing command ['/usr/sbin/rabbitmq-plugins', 'list', '-m', '-e'] as user 'root' in directory '/root'
2018-10-06 14:49:14,160 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9617] Executing command ['/usr/sbin/rabbitmq-plugins', 'enable', 'amqp_client'] as user 'root' in directory '/root'
2018-10-06 14:49:15,512 [salt.state       :290 ][INFO    ][9617] {'new': 'amqp_client', 'old': ''}
2018-10-06 14:49:15,513 [salt.state       :1941][INFO    ][9617] Completed state [amqp_client] at time 14:49:15.513166 duration_in_ms=2477.965
2018-10-06 14:49:15,514 [salt.state       :1770][INFO    ][9617] Running state [rabbitmq_management] at time 14:49:15.514483
2018-10-06 14:49:15,515 [salt.state       :1803][INFO    ][9617] Executing state rabbitmq_plugin.enabled for [rabbitmq_management]
2018-10-06 14:49:15,516 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9617] Executing command ['/usr/sbin/rabbitmq-plugins', 'list', '-m', '-e'] as user 'root' in directory '/root'
2018-10-06 14:49:15,753 [salt.minion      :1307][INFO    ][2981] User sudo_ubuntu Executing command saltutil.find_job with jid 20181006144915738384
2018-10-06 14:49:15,772 [salt.minion      :1431][INFO    ][12302] Starting a new job with PID 12302
2018-10-06 14:49:15,798 [salt.minion      :1708][INFO    ][12302] Returning information for job: 20181006144915738384
2018-10-06 14:49:16,676 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9617] Executing command ['/usr/sbin/rabbitmq-plugins', 'enable', 'rabbitmq_management'] as user 'root' in directory '/root'
2018-10-06 14:49:18,699 [salt.state       :290 ][INFO    ][9617] {'new': 'rabbitmq_management', 'old': ''}
2018-10-06 14:49:18,700 [salt.state       :1941][INFO    ][9617] Completed state [rabbitmq_management] at time 14:49:18.700266 duration_in_ms=3185.782
2018-10-06 14:49:18,703 [salt.state       :1770][INFO    ][9617] Running state [/openstack] at time 14:49:18.703760
2018-10-06 14:49:18,704 [salt.state       :1803][INFO    ][9617] Executing state rabbitmq_vhost.present for [/openstack]
2018-10-06 14:49:18,705 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9617] Executing command ['/usr/sbin/rabbitmqctl', 'list_vhosts', '-q'] as user 'root' in directory '/root'
2018-10-06 14:49:19,884 [salt.state       :290 ][INFO    ][9617] Virtual Host '/openstack' already exists.
2018-10-06 14:49:19,885 [salt.state       :1941][INFO    ][9617] Completed state [/openstack] at time 14:49:19.885066 duration_in_ms=1181.306
2018-10-06 14:49:19,889 [salt.state       :1770][INFO    ][9617] Running state [openstack] at time 14:49:19.888991
2018-10-06 14:49:19,890 [salt.state       :1803][INFO    ][9617] Executing state rabbitmq_user.present for [openstack]
2018-10-06 14:49:19,890 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9617] Executing command ['/usr/sbin/rabbitmqctl', 'list_users', '-q'] as user 'root' in directory '/root'
2018-10-06 14:49:21,076 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9617] Executing command ['/usr/sbin/rabbitmqctl', 'status'] as user 'root' in directory '/root'
2018-10-06 14:49:24,634 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9617] Executing command ['/usr/sbin/rabbitmqctl', 'list_user_permissions', 'openstack', '-q'] as user 'root' in directory '/root'
2018-10-06 14:49:25,787 [salt.minion      :1307][INFO    ][2981] User sudo_ubuntu Executing command saltutil.find_job with jid 20181006144925766869
2018-10-06 14:49:25,804 [salt.minion      :1431][INFO    ][14031] Starting a new job with PID 14031
2018-10-06 14:49:25,825 [salt.minion      :1708][INFO    ][14031] Returning information for job: 20181006144925766869
2018-10-06 14:49:25,849 [salt.state       :290 ][INFO    ][9617] Made the following changes:
'password' changed from 'absent' to 'Set password.'

2018-10-06 14:49:25,850 [salt.state       :1941][INFO    ][9617] Completed state [openstack] at time 14:49:25.850208 duration_in_ms=5961.216
2018-10-06 14:49:25,853 [salt.state       :1770][INFO    ][9617] Running state [Ceilometer] at time 14:49:25.853843
2018-10-06 14:49:25,854 [salt.state       :1803][INFO    ][9617] Executing state rabbitmq_policy.present for [Ceilometer]
2018-10-06 14:49:25,855 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9617] Executing command ['/usr/sbin/rabbitmqctl', 'list_policies', '-q', '-p', '/openstack'] as user 'root' in directory '/root'
2018-10-06 14:49:27,001 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9617] 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-06 14:49:28,206 [salt.state       :290 ][INFO    ][9617] {'new': ['Definition'], 'old': {'apply_to': 'all', 'priority': '10', 'definition': '{"ha-mode":"all","message-ttl":10800000}', 'pattern': '^metering.sample$'}}
2018-10-06 14:49:28,207 [salt.state       :1941][INFO    ][9617] Completed state [Ceilometer] at time 14:49:28.207371 duration_in_ms=2353.527
2018-10-06 14:49:28,208 [salt.state       :1770][INFO    ][9617] Running state [HA] at time 14:49:28.208579
2018-10-06 14:49:28,209 [salt.state       :1803][INFO    ][9617] Executing state rabbitmq_policy.present for [HA]
2018-10-06 14:49:28,210 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9617] Executing command ['/usr/sbin/rabbitmqctl', 'list_policies', '-q', '-p', '/openstack'] as user 'root' in directory '/root'
2018-10-06 14:49:29,376 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9617] 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-06 14:49:30,539 [salt.state       :290 ][INFO    ][9617] {'new': ['Pattern', 'Definition'], 'old': {'apply_to': 'all', 'priority': '0', 'definition': '{"ha-mode":"all","message-ttl":120000}', 'pattern': '^(?!amq\\\\.).*'}}
2018-10-06 14:49:30,540 [salt.state       :1941][INFO    ][9617] Completed state [HA] at time 14:49:30.539932 duration_in_ms=2331.352
2018-10-06 14:49:30,540 [salt.state       :1770][INFO    ][9617] Running state [guest] at time 14:49:30.540379
2018-10-06 14:49:30,540 [salt.state       :1803][INFO    ][9617] Executing state rabbitmq_user.present for [guest]
2018-10-06 14:49:30,542 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9617] Executing command ['/usr/sbin/rabbitmqctl', 'list_users', '-q'] as user 'root' in directory '/root'
2018-10-06 14:49:31,675 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9617] Executing command ['/usr/sbin/rabbitmqctl', 'status'] as user 'root' in directory '/root'
2018-10-06 14:49:35,301 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9617] Executing command ['/usr/sbin/rabbitmqctl', 'list_user_permissions', 'guest', '-q'] as user 'root' in directory '/root'
2018-10-06 14:49:35,812 [salt.minion      :1307][INFO    ][2981] User sudo_ubuntu Executing command saltutil.find_job with jid 20181006144935801581
2018-10-06 14:49:35,829 [salt.minion      :1431][INFO    ][16210] Starting a new job with PID 16210
2018-10-06 14:49:35,850 [salt.minion      :1708][INFO    ][16210] Returning information for job: 20181006144935801581
2018-10-06 14:49:36,490 [salt.state       :290 ][INFO    ][9617] Made the following changes:
'password' changed from 'absent' to 'Set password.'

2018-10-06 14:49:36,491 [salt.state       :1941][INFO    ][9617] Completed state [guest] at time 14:49:36.491288 duration_in_ms=5950.907
2018-10-06 14:49:36,494 [salt.state       :1770][INFO    ][9617] Running state [HA] at time 14:49:36.493065
2018-10-06 14:49:36,494 [salt.state       :1803][INFO    ][9617] Executing state rabbitmq_policy.present for [HA]
2018-10-06 14:49:36,495 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9617] Executing command ['/usr/sbin/rabbitmqctl', 'list_policies', '-q', '-p', '/'] as user 'root' in directory '/root'
2018-10-06 14:49:37,675 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9617] Executing command ['/usr/sbin/rabbitmqctl', 'set_policy', '-p', '/', 'HA', '^(?!amq\\.).*', '{"ha-mode": "all", "message-ttl": 120000}'] as user 'root' in directory '/root'
2018-10-06 14:49:38,823 [salt.state       :290 ][INFO    ][9617] {'new': ['Pattern', 'Definition'], 'old': {'apply_to': 'all', 'priority': '0', 'definition': '{"ha-mode":"all","message-ttl":120000}', 'pattern': '^(?!amq\\\\.).*'}}
2018-10-06 14:49:38,823 [salt.state       :1941][INFO    ][9617] Completed state [HA] at time 14:49:38.823818 duration_in_ms=2330.753
2018-10-06 14:49:38,824 [salt.state       :1770][INFO    ][9617] Running state [admin] at time 14:49:38.824905
2018-10-06 14:49:38,826 [salt.state       :1803][INFO    ][9617] Executing state rabbitmq_user.present for [admin]
2018-10-06 14:49:38,827 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9617] Executing command ['/usr/sbin/rabbitmqctl', 'list_users', '-q'] as user 'root' in directory '/root'
2018-10-06 14:49:40,005 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9617] Executing command ['/usr/sbin/rabbitmqctl', 'status'] as user 'root' in directory '/root'
2018-10-06 14:49:43,520 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9617] Executing command ['/usr/sbin/rabbitmqctl', 'list_users', '-q'] as user 'root' in directory '/root'
2018-10-06 14:49:44,694 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9617] Executing command ['/usr/sbin/rabbitmqctl', 'list_user_permissions', 'admin', '-q'] as user 'root' in directory '/root'
2018-10-06 14:49:45,852 [salt.minion      :1307][INFO    ][2981] User sudo_ubuntu Executing command saltutil.find_job with jid 20181006144945835749
2018-10-06 14:49:45,868 [salt.minion      :1431][INFO    ][18218] Starting a new job with PID 18218
2018-10-06 14:49:45,891 [salt.minion      :1708][INFO    ][18218] Returning information for job: 20181006144945835749
2018-10-06 14:49:45,903 [salt.state       :290 ][INFO    ][9617] Made the following changes:
'password' changed from 'absent' to 'Set password.'

2018-10-06 14:49:45,904 [salt.state       :1941][INFO    ][9617] Completed state [admin] at time 14:49:45.904694 duration_in_ms=7079.788
2018-10-06 14:49:45,910 [salt.state       :1770][INFO    ][9617] Running state [rabbit@master] at time 14:49:45.910760
2018-10-06 14:49:45,911 [salt.state       :1803][INFO    ][9617] Executing state rabbitmq_cluster.join for [rabbit@master]
2018-10-06 14:49:45,912 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9617] Executing command ['/usr/sbin/rabbitmqctl', 'cluster_status'] as user 'root' in directory '/root'
2018-10-06 14:49:47,171 [salt.state       :290 ][INFO    ][9617] Already in cluster
2018-10-06 14:49:47,171 [salt.state       :1941][INFO    ][9617] Completed state [rabbit@master] at time 14:49:47.171871 duration_in_ms=1261.111
2018-10-06 14:49:47,175 [salt.minion      :1708][INFO    ][9617] Returning information for job: 20181006144714287427
2018-10-06 14:49:47,993 [salt.minion      :1307][INFO    ][2981] User sudo_ubuntu Executing command cmd.run with jid 20181006144947982320
2018-10-06 14:49:48,017 [salt.minion      :1431][INFO    ][18471] Starting a new job with PID 18471
2018-10-06 14:49:48,029 [salt.loader.192.168.11.2.int.module.cmdmod:395 ][INFO    ][18471] Executing command 'rabbitmqctl cluster_status' in directory '/root'
2018-10-06 14:49:49,207 [salt.minion      :1708][INFO    ][18471] Returning information for job: 20181006144947982320
2018-10-06 14:56:26,089 [salt.minion      :1307][INFO    ][2981] User sudo_ubuntu Executing command state.sls with jid 20181006145626080306
2018-10-06 14:56:26,109 [salt.minion      :1431][INFO    ][18756] Starting a new job with PID 18756
2018-10-06 14:56:27,459 [salt.state       :905 ][INFO    ][18756] Loading fresh modules for state activity
2018-10-06 14:56:27,518 [salt.fileclient  :1215][INFO    ][18756] Fetching file from saltenv 'base', ** done ** 'haproxy/init.sls'
2018-10-06 14:56:27,547 [salt.fileclient  :1215][INFO    ][18756] Fetching file from saltenv 'base', ** done ** 'haproxy/proxy.sls'
2018-10-06 14:56:28,330 [salt.state       :1770][INFO    ][18756] Running state [haproxy] at time 14:56:28.329930
2018-10-06 14:56:28,330 [salt.state       :1803][INFO    ][18756] Executing state pkg.installed for [haproxy]
2018-10-06 14:56:28,331 [salt.loaded.int.module.cmdmod:395 ][INFO    ][18756] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}', '-W'] in directory '/root'
2018-10-06 14:56:28,774 [salt.loaded.int.module.cmdmod:395 ][INFO    ][18756] Executing command ['apt-cache', '-q', 'policy', 'haproxy'] in directory '/root'
2018-10-06 14:56:28,889 [salt.loaded.int.module.cmdmod:395 ][INFO    ][18756] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2018-10-06 14:56:31,120 [salt.loaded.int.module.cmdmod:395 ][INFO    ][18756] Executing command ['dpkg', '--get-selections', '*'] in directory '/root'
2018-10-06 14:56:31,148 [salt.loaded.int.module.cmdmod:395 ][INFO    ][18756] 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-06 14:56:34,939 [salt.loaded.int.module.cmdmod:395 ][INFO    ][18756] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}', '-W'] in directory '/root'
2018-10-06 14:56:34,989 [salt.state       :290 ][INFO    ][18756] 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-06 14:56:35,016 [salt.state       :905 ][INFO    ][18756] Loading fresh modules for state activity
2018-10-06 14:56:35,062 [salt.state       :1941][INFO    ][18756] Completed state [haproxy] at time 14:56:35.062020 duration_in_ms=6732.091
2018-10-06 14:56:35,068 [salt.state       :1770][INFO    ][18756] Running state [/etc/default/haproxy] at time 14:56:35.068178
2018-10-06 14:56:35,068 [salt.state       :1803][INFO    ][18756] Executing state file.managed for [/etc/default/haproxy]
2018-10-06 14:56:35,100 [salt.fileclient  :1215][INFO    ][18756] Fetching file from saltenv 'base', ** done ** 'haproxy/files/haproxy.default'
2018-10-06 14:56:35,104 [salt.state       :290 ][INFO    ][18756] 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-06 14:56:35,107 [salt.state       :1941][INFO    ][18756] Completed state [/etc/default/haproxy] at time 14:56:35.107798 duration_in_ms=39.619
2018-10-06 14:56:35,108 [salt.state       :1770][INFO    ][18756] Running state [/etc/haproxy/haproxy.cfg] at time 14:56:35.108364
2018-10-06 14:56:35,108 [salt.state       :1803][INFO    ][18756] Executing state file.managed for [/etc/haproxy/haproxy.cfg]
2018-10-06 14:56:35,130 [salt.fileclient  :1215][INFO    ][18756] Fetching file from saltenv 'base', ** done ** 'haproxy/files/haproxy.cfg'
2018-10-06 14:56:35,335 [salt.state       :290 ][INFO    ][18756] 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-06 14:56:35,336 [salt.state       :1941][INFO    ][18756] Completed state [/etc/haproxy/haproxy.cfg] at time 14:56:35.336261 duration_in_ms=227.896
2018-10-06 14:56:35,336 [salt.state       :1770][INFO    ][18756] Running state [/etc/haproxy/ssl] at time 14:56:35.336750
2018-10-06 14:56:35,337 [salt.state       :1803][INFO    ][18756] Executing state file.directory for [/etc/haproxy/ssl]
2018-10-06 14:56:35,339 [salt.state       :290 ][INFO    ][18756] {'/etc/haproxy/ssl': 'New Dir'}
2018-10-06 14:56:35,339 [salt.state       :1941][INFO    ][18756] Completed state [/etc/haproxy/ssl] at time 14:56:35.339469 duration_in_ms=2.719
2018-10-06 14:56:35,339 [salt.state       :1770][INFO    ][18756] Running state [/etc/haproxy/errors/429.http11] at time 14:56:35.339811
2018-10-06 14:56:35,340 [salt.state       :1803][INFO    ][18756] Executing state file.managed for [/etc/haproxy/errors/429.http11]
2018-10-06 14:56:35,358 [salt.fileclient  :1215][INFO    ][18756] Fetching file from saltenv 'base', ** done ** 'haproxy/files/errors/429.http11'
2018-10-06 14:56:35,368 [salt.state       :290 ][INFO    ][18756] File changed:
New file
2018-10-06 14:56:35,369 [salt.state       :1941][INFO    ][18756] Completed state [/etc/haproxy/errors/429.http11] at time 14:56:35.369006 duration_in_ms=29.195
2018-10-06 14:56:35,370 [salt.state       :1770][INFO    ][18756] Running state [haproxy_status_packages] at time 14:56:35.370740
2018-10-06 14:56:35,371 [salt.state       :1803][INFO    ][18756] Executing state pkg.installed for [haproxy_status_packages]
2018-10-06 14:56:36,114 [salt.state       :290 ][INFO    ][18756] All specified packages are already installed
2018-10-06 14:56:36,114 [salt.state       :1941][INFO    ][18756] Completed state [haproxy_status_packages] at time 14:56:36.114900 duration_in_ms=744.159
2018-10-06 14:56:36,115 [salt.state       :1770][INFO    ][18756] Running state [/usr/bin/haproxy-status.sh] at time 14:56:36.115754
2018-10-06 14:56:36,116 [salt.state       :1803][INFO    ][18756] Executing state file.managed for [/usr/bin/haproxy-status.sh]
2018-10-06 14:56:36,120 [salt.minion      :1307][INFO    ][2981] User sudo_ubuntu Executing command saltutil.find_job with jid 20181006145636104837
2018-10-06 14:56:36,139 [salt.fileclient  :1215][INFO    ][18756] Fetching file from saltenv 'base', ** done ** 'haproxy/files/haproxy-status.sh'
2018-10-06 14:56:36,139 [salt.minion      :1431][INFO    ][19686] Starting a new job with PID 19686
2018-10-06 14:56:36,160 [salt.minion      :1708][INFO    ][19686] Returning information for job: 20181006145636104837
2018-10-06 14:56:36,221 [salt.state       :290 ][INFO    ][18756] File changed:
New file
2018-10-06 14:56:36,221 [salt.state       :1941][INFO    ][18756] Completed state [/usr/bin/haproxy-status.sh] at time 14:56:36.221338 duration_in_ms=105.583
2018-10-06 14:56:36,221 [salt.state       :1770][INFO    ][18756] Running state [net.ipv4.ip_nonlocal_bind] at time 14:56:36.221958
2018-10-06 14:56:36,222 [salt.state       :1803][INFO    ][18756] Executing state sysctl.present for [net.ipv4.ip_nonlocal_bind]
2018-10-06 14:56:36,223 [salt.loaded.int.module.cmdmod:395 ][INFO    ][18756] Executing command 'sysctl -w net.ipv4.ip_nonlocal_bind="1"' in directory '/root'
2018-10-06 14:56:36,237 [salt.state       :290 ][INFO    ][18756] {'net.ipv4.ip_nonlocal_bind': 1}
2018-10-06 14:56:36,237 [salt.state       :1941][INFO    ][18756] Completed state [net.ipv4.ip_nonlocal_bind] at time 14:56:36.237903 duration_in_ms=15.945
2018-10-06 14:56:36,240 [salt.state       :1770][INFO    ][18756] Running state [haproxy] at time 14:56:36.240518
2018-10-06 14:56:36,240 [salt.state       :1803][INFO    ][18756] Executing state service.running for [haproxy]
2018-10-06 14:56:36,242 [salt.loaded.int.module.cmdmod:395 ][INFO    ][18756] Executing command ['systemctl', 'status', 'haproxy.service', '-n', '0'] in directory '/root'
2018-10-06 14:56:36,261 [salt.loaded.int.module.cmdmod:395 ][INFO    ][18756] Executing command ['systemctl', 'is-active', 'haproxy.service'] in directory '/root'
2018-10-06 14:56:36,280 [salt.loaded.int.module.cmdmod:395 ][INFO    ][18756] Executing command ['systemctl', 'is-enabled', 'haproxy.service'] in directory '/root'
2018-10-06 14:56:36,300 [salt.state       :290 ][INFO    ][18756] The service haproxy is already running
2018-10-06 14:56:36,301 [salt.state       :1941][INFO    ][18756] Completed state [haproxy] at time 14:56:36.301080 duration_in_ms=60.561
2018-10-06 14:56:36,301 [salt.state       :1770][INFO    ][18756] Running state [haproxy] at time 14:56:36.301452
2018-10-06 14:56:36,303 [salt.state       :1803][INFO    ][18756] Executing state service.mod_watch for [haproxy]
2018-10-06 14:56:36,304 [salt.loaded.int.module.cmdmod:395 ][INFO    ][18756] Executing command ['systemctl', 'is-active', 'haproxy.service'] in directory '/root'
2018-10-06 14:56:36,322 [salt.loaded.int.module.cmdmod:395 ][INFO    ][18756] Executing command ['systemd-run', '--scope', 'systemctl', 'restart', 'haproxy.service'] in directory '/root'
2018-10-06 14:56:36,392 [salt.state       :290 ][INFO    ][18756] {'haproxy': True}
2018-10-06 14:56:36,393 [salt.state       :1941][INFO    ][18756] Completed state [haproxy] at time 14:56:36.393043 duration_in_ms=91.59
2018-10-06 14:56:36,397 [salt.minion      :1708][INFO    ][18756] Returning information for job: 20181006145626080306
2018-10-06 14:56:42,532 [salt.minion      :1307][INFO    ][2981] User sudo_ubuntu Executing command service.status with jid 20181006145642522472
2018-10-06 14:56:42,552 [salt.minion      :1431][INFO    ][19740] Starting a new job with PID 19740
2018-10-06 14:56:43,045 [salt.loader.192.168.11.2.int.module.cmdmod:395 ][INFO    ][19740] Executing command ['systemctl', 'status', 'haproxy.service', '-n', '0'] in directory '/root'
2018-10-06 14:56:43,064 [salt.loader.192.168.11.2.int.module.cmdmod:395 ][INFO    ][19740] Executing command ['systemctl', 'is-active', 'haproxy.service'] in directory '/root'
2018-10-06 14:56:43,083 [salt.minion      :1708][INFO    ][19740] Returning information for job: 20181006145642522472
2018-10-06 14:56:44,242 [salt.minion      :1307][INFO    ][2981] User sudo_ubuntu Executing command service.restart with jid 20181006145644229764
2018-10-06 14:56:44,263 [salt.minion      :1431][INFO    ][19748] Starting a new job with PID 19748
2018-10-06 14:56:44,768 [salt.loader.192.168.11.2.int.module.cmdmod:395 ][INFO    ][19748] Executing command ['systemctl', 'status', 'rsyslog.service', '-n', '0'] in directory '/root'
2018-10-06 14:56:44,803 [salt.loader.192.168.11.2.int.module.cmdmod:395 ][INFO    ][19748] Executing command ['systemd-run', '--scope', 'systemctl', 'restart', 'rsyslog.service'] in directory '/root'
2018-10-06 14:56:44,837 [salt.minion      :1708][INFO    ][19748] Returning information for job: 20181006145644229764
2018-10-06 15:29:57,883 [salt.utils.schedule:1375][INFO    ][2981] Running scheduled job: __mine_interval
2018-10-06 15:32:01,661 [salt.minion      :1307][INFO    ][2981] User sudo_ubuntu Executing command cp.push_dir with jid 20181006153201649240
2018-10-06 15:32:01,690 [salt.minion      :1431][INFO    ][20328] Starting a new job with PID 20328
