2018-10-14 05:34:47,498 [salt.loaded.int.module.cmdmod:722 ][ERROR   ][1781] Command 'rabbitmqctl cluster_status' failed with return code: 127
2018-10-14 05:34:47,499 [salt.loaded.int.module.cmdmod:724 ][ERROR   ][1781] stdout: /bin/sh: 1: rabbitmqctl: not found
2018-10-14 05:34:47,499 [salt.loaded.int.module.cmdmod:728 ][ERROR   ][1781] retcode: 127
2018-10-14 05:34:47,525 [salt.loaded.int.module.cmdmod:722 ][ERROR   ][1781] Command 'rabbitmqctl cluster_status' failed with return code: 127
2018-10-14 05:34:47,527 [salt.loaded.int.module.cmdmod:724 ][ERROR   ][1781] stdout: /bin/sh: 1: rabbitmqctl: not found
2018-10-14 05:34:47,527 [salt.loaded.int.module.cmdmod:728 ][ERROR   ][1781] retcode: 127
2018-10-14 05:34:49,205 [salt.loaded.int.module.cmdmod:722 ][ERROR   ][1781] Command 'rabbitmqctl cluster_status' failed with return code: 127
2018-10-14 05:34:49,206 [salt.loaded.int.module.cmdmod:724 ][ERROR   ][1781] stdout: /bin/sh: 1: rabbitmqctl: not found
2018-10-14 05:34:49,206 [salt.loaded.int.module.cmdmod:728 ][ERROR   ][1781] retcode: 127
2018-10-14 05:34:49,231 [salt.loaded.int.module.cmdmod:722 ][ERROR   ][1781] Command 'rabbitmqctl cluster_status' failed with return code: 127
2018-10-14 05:34:49,231 [salt.loaded.int.module.cmdmod:724 ][ERROR   ][1781] stdout: /bin/sh: 1: rabbitmqctl: not found
2018-10-14 05:34:49,232 [salt.loaded.int.module.cmdmod:728 ][ERROR   ][1781] retcode: 127
2018-10-14 05:35:06,493 [salt.utils.decorators:613 ][WARNING ][1781] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2018-10-14 05:35:10,332 [salt.loaded.int.module.cmdmod:395 ][INFO    ][2846] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2018-10-14 05:35:10,363 [salt.loaded.int.module.cmdmod:395 ][INFO    ][2846] Executing command ['systemd-run', '--scope', 'systemctl', 'restart', 'salt-minion.service'] in directory '/root'
2018-10-14 05:35:10,384 [salt.utils.parsers:1051][WARNING ][1450] Minion received a SIGTERM. Exiting.
2018-10-14 05:35:11,292 [salt.cli.daemons :293 ][INFO    ][2899] Setting up the Salt Minion "msg03.mcp-pike-odl-ha.local"
2018-10-14 05:35:11,412 [salt.cli.daemons :82  ][INFO    ][2899] Starting up the Salt Minion
2018-10-14 05:35:11,413 [salt.utils.event :1017][INFO    ][2899] Starting pull socket on /var/run/salt/minion/minion_event_932d37fbb0_pull.ipc
2018-10-14 05:35:12,127 [salt.minion      :976 ][INFO    ][2899] Creating minion process manager
2018-10-14 05:35:13,431 [salt.loader.192.168.11.2.int.module.cmdmod:395 ][INFO    ][2899] Executing command ['date', '+%z'] in directory '/root'
2018-10-14 05:35:13,455 [salt.utils.schedule:568 ][INFO    ][2899] Updating job settings for scheduled job: __mine_interval
2018-10-14 05:35:13,457 [salt.minion      :1107][INFO    ][2899] Added mine.update to scheduler
2018-10-14 05:35:13,462 [salt.minion      :1965][INFO    ][2899] Minion is starting as user 'root'
2018-10-14 05:35:13,490 [salt.minion      :2324][INFO    ][2899] Minion is ready to receive requests!
2018-10-14 05:35:36,862 [salt.minion      :1307][INFO    ][2899] User sudo_ubuntu Executing command state.apply with jid 20181014053536849187
2018-10-14 05:35:36,881 [salt.minion      :1431][INFO    ][2988] Starting a new job with PID 2988
2018-10-14 05:35:42,599 [salt.state       :905 ][INFO    ][2988] Loading fresh modules for state activity
2018-10-14 05:35:43,239 [salt.fileclient  :1215][INFO    ][2988] Fetching file from saltenv 'base', ** done ** 'linux/init.sls'
2018-10-14 05:35:43,288 [salt.fileclient  :1215][INFO    ][2988] Fetching file from saltenv 'base', ** done ** 'linux/system/init.sls'
2018-10-14 05:35:43,478 [salt.fileclient  :1215][INFO    ][2988] Fetching file from saltenv 'base', ** done ** 'linux/system/env.sls'
2018-10-14 05:35:43,643 [salt.fileclient  :1215][INFO    ][2988] Fetching file from saltenv 'base', ** done ** 'linux/system/profile.sls'
2018-10-14 05:35:43,798 [salt.fileclient  :1215][INFO    ][2988] Fetching file from saltenv 'base', ** done ** 'linux/system/shell.sls'
2018-10-14 05:35:43,969 [salt.fileclient  :1215][INFO    ][2988] Fetching file from saltenv 'base', ** done ** 'linux/system/at.sls'
2018-10-14 05:35:44,113 [salt.fileclient  :1215][INFO    ][2988] Fetching file from saltenv 'base', ** done ** 'linux/system/cron.sls'
2018-10-14 05:35:44,261 [salt.fileclient  :1215][INFO    ][2988] Fetching file from saltenv 'base', ** done ** 'linux/system/repo.sls'
2018-10-14 05:35:44,544 [salt.fileclient  :1215][INFO    ][2988] Fetching file from saltenv 'base', ** done ** 'linux/system/package.sls'
2018-10-14 05:35:44,698 [salt.fileclient  :1215][INFO    ][2988] Fetching file from saltenv 'base', ** done ** 'linux/system/timezone.sls'
2018-10-14 05:35:44,828 [salt.fileclient  :1215][INFO    ][2988] Fetching file from saltenv 'base', ** done ** 'linux/system/kernel.sls'
2018-10-14 05:35:45,977 [salt.fileclient  :1215][INFO    ][2988] Fetching file from saltenv 'base', ** done ** 'linux/system/grub.sls'
2018-10-14 05:35:46,017 [salt.fileclient  :1215][INFO    ][2988] Fetching file from saltenv 'base', ** done ** 'linux/system/cpu.sls'
2018-10-14 05:35:46,155 [salt.fileclient  :1215][INFO    ][2988] Fetching file from saltenv 'base', ** done ** 'linux/system/sysfs.sls'
2018-10-14 05:35:46,297 [salt.fileclient  :1215][INFO    ][2988] Fetching file from saltenv 'base', ** done ** 'linux/system/locale.sls'
2018-10-14 05:35:46,438 [salt.fileclient  :1215][INFO    ][2988] Fetching file from saltenv 'base', ** done ** 'linux/system/user.sls'
2018-10-14 05:35:46,620 [salt.fileclient  :1215][INFO    ][2988] Fetching file from saltenv 'base', ** done ** 'linux/system/group.sls'
2018-10-14 05:35:46,765 [salt.fileclient  :1215][INFO    ][2988] Fetching file from saltenv 'base', ** done ** 'linux/system/limit.sls'
2018-10-14 05:35:46,908 [salt.fileclient  :1215][INFO    ][2988] Fetching file from saltenv 'base', ** done ** 'linux/system/systemd.sls'
2018-10-14 05:35:46,974 [salt.minion      :1307][INFO    ][2899] User sudo_ubuntu Executing command saltutil.find_job with jid 20181014053546955544
2018-10-14 05:35:47,011 [salt.minion      :1431][INFO    ][3033] Starting a new job with PID 3033
2018-10-14 05:35:47,033 [salt.minion      :1708][INFO    ][3033] Returning information for job: 20181014053546955544
2018-10-14 05:35:47,096 [salt.fileclient  :1215][INFO    ][2988] Fetching file from saltenv 'base', ** done ** 'linux/system/apt.sls'
2018-10-14 05:35:47,240 [salt.fileclient  :1215][INFO    ][2988] Fetching file from saltenv 'base', ** done ** 'linux/system/banner.sls'
2018-10-14 05:35:47,381 [salt.fileclient  :1215][INFO    ][2988] Fetching file from saltenv 'base', ** done ** 'linux/network/init.sls'
2018-10-14 05:35:47,517 [salt.fileclient  :1215][INFO    ][2988] Fetching file from saltenv 'base', ** done ** 'linux/network/hostname.sls'
2018-10-14 05:35:47,701 [salt.fileclient  :1215][INFO    ][2988] Fetching file from saltenv 'base', ** done ** 'linux/network/host.sls'
2018-10-14 05:35:47,908 [salt.fileclient  :1215][INFO    ][2988] Fetching file from saltenv 'base', ** done ** 'linux/network/interface.sls'
2018-10-14 05:35:48,172 [salt.fileclient  :1215][INFO    ][2988] Fetching file from saltenv 'base', ** done ** 'linux/network/proxy.sls'
2018-10-14 05:35:48,312 [salt.fileclient  :1215][INFO    ][2988] Fetching file from saltenv 'base', ** done ** 'linux/storage/init.sls'
2018-10-14 05:35:49,595 [salt.fileclient  :1215][INFO    ][2988] Fetching file from saltenv 'base', ** done ** 'ntp/init.sls'
2018-10-14 05:35:49,625 [salt.fileclient  :1215][INFO    ][2988] Fetching file from saltenv 'base', ** done ** 'ntp/client.sls'
2018-10-14 05:35:49,685 [salt.fileclient  :1215][INFO    ][2988] Fetching file from saltenv 'base', ** done ** 'ntp/server.sls'
2018-10-14 05:35:49,744 [salt.state       :1770][INFO    ][2988] Running state [/etc/environment] at time 05:35:49.744789
2018-10-14 05:35:49,745 [salt.state       :1803][INFO    ][2988] Executing state file.blockreplace for [/etc/environment]
2018-10-14 05:35:49,755 [salt.state       :290 ][INFO    ][2988] 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-14 05:35:49,755 [salt.state       :1941][INFO    ][2988] Completed state [/etc/environment] at time 05:35:49.755921 duration_in_ms=11.133
2018-10-14 05:35:49,756 [salt.state       :1770][INFO    ][2988] Running state [/etc/profile.d] at time 05:35:49.756220
2018-10-14 05:35:49,756 [salt.state       :1803][INFO    ][2988] Executing state file.directory for [/etc/profile.d]
2018-10-14 05:35:49,758 [salt.state       :290 ][INFO    ][2988] Directory /etc/profile.d is in the correct state
Directory /etc/profile.d updated
2018-10-14 05:35:49,758 [salt.state       :1941][INFO    ][2988] Completed state [/etc/profile.d] at time 05:35:49.758769 duration_in_ms=2.549
2018-10-14 05:35:49,759 [salt.state       :1770][INFO    ][2988] Running state [fake_linux_system_at] at time 05:35:49.759925
2018-10-14 05:35:49,760 [salt.state       :1803][INFO    ][2988] Executing state test.nop for [fake_linux_system_at]
2018-10-14 05:35:49,760 [salt.state       :290 ][INFO    ][2988] Success!
2018-10-14 05:35:49,760 [salt.state       :1941][INFO    ][2988] Completed state [fake_linux_system_at] at time 05:35:49.760638 duration_in_ms=0.713
2018-10-14 05:35:49,762 [salt.state       :1770][INFO    ][2988] Running state [fake_linux_system_cron] at time 05:35:49.762068
2018-10-14 05:35:49,762 [salt.state       :1803][INFO    ][2988] Executing state test.nop for [fake_linux_system_cron]
2018-10-14 05:35:49,762 [salt.state       :290 ][INFO    ][2988] Success!
2018-10-14 05:35:49,762 [salt.state       :1941][INFO    ][2988] Completed state [fake_linux_system_cron] at time 05:35:49.762741 duration_in_ms=0.673
2018-10-14 05:35:50,526 [salt.state       :1770][INFO    ][2988] Running state [/etc/apt/apt.conf.d/99prefer_ipv4-salt] at time 05:35:50.526206
2018-10-14 05:35:50,526 [salt.state       :1803][INFO    ][2988] Executing state file.managed for [/etc/apt/apt.conf.d/99prefer_ipv4-salt]
2018-10-14 05:35:50,561 [salt.fileclient  :1215][INFO    ][2988] Fetching file from saltenv 'base', ** done ** 'linux/files/apt.conf'
2018-10-14 05:35:50,643 [salt.state       :290 ][INFO    ][2988] File changed:
New file
2018-10-14 05:35:50,643 [salt.state       :1941][INFO    ][2988] Completed state [/etc/apt/apt.conf.d/99prefer_ipv4-salt] at time 05:35:50.643682 duration_in_ms=117.476
2018-10-14 05:35:50,644 [salt.state       :1770][INFO    ][2988] Running state [/etc/apt/apt.conf.d/99allow_downgrades-salt] at time 05:35:50.643963
2018-10-14 05:35:50,644 [salt.state       :1803][INFO    ][2988] Executing state file.managed for [/etc/apt/apt.conf.d/99allow_downgrades-salt]
2018-10-14 05:35:50,678 [salt.state       :290 ][INFO    ][2988] File changed:
New file
2018-10-14 05:35:50,679 [salt.state       :1941][INFO    ][2988] Completed state [/etc/apt/apt.conf.d/99allow_downgrades-salt] at time 05:35:50.679150 duration_in_ms=35.187
2018-10-14 05:35:50,680 [salt.state       :1770][INFO    ][2988] Running state [linux_repo_prereq_pkgs] at time 05:35:50.680568
2018-10-14 05:35:50,680 [salt.state       :1803][INFO    ][2988] Executing state pkg.installed for [linux_repo_prereq_pkgs]
2018-10-14 05:35:50,681 [salt.loaded.int.module.cmdmod:395 ][INFO    ][2988] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}', '-W'] in directory '/root'
2018-10-14 05:35:51,201 [salt.state       :290 ][INFO    ][2988] All specified packages are already installed
2018-10-14 05:35:51,202 [salt.state       :1941][INFO    ][2988] Completed state [linux_repo_prereq_pkgs] at time 05:35:51.202073 duration_in_ms=521.504
2018-10-14 05:35:51,202 [salt.state       :1770][INFO    ][2988] Running state [/etc/apt/apt.conf.d/99proxies-salt] at time 05:35:51.202481
2018-10-14 05:35:51,202 [salt.state       :1803][INFO    ][2988] Executing state file.managed for [/etc/apt/apt.conf.d/99proxies-salt]
2018-10-14 05:35:51,234 [salt.fileclient  :1215][INFO    ][2988] Fetching file from saltenv 'base', ** done ** 'linux/files/apt.conf.d_proxies'
2018-10-14 05:35:51,253 [salt.state       :290 ][INFO    ][2988] File changed:
New file
2018-10-14 05:35:51,253 [salt.state       :1941][INFO    ][2988] Completed state [/etc/apt/apt.conf.d/99proxies-salt] at time 05:35:51.253509 duration_in_ms=51.027
2018-10-14 05:35:51,253 [salt.state       :1770][INFO    ][2988] Running state [/etc/apt/apt.conf.d/99proxies-salt-mk_openstack] at time 05:35:51.253805
2018-10-14 05:35:51,254 [salt.state       :1803][INFO    ][2988] Executing state file.absent for [/etc/apt/apt.conf.d/99proxies-salt-mk_openstack]
2018-10-14 05:35:51,254 [salt.state       :290 ][INFO    ][2988] File /etc/apt/apt.conf.d/99proxies-salt-mk_openstack is not present
2018-10-14 05:35:51,254 [salt.state       :1941][INFO    ][2988] Completed state [/etc/apt/apt.conf.d/99proxies-salt-mk_openstack] at time 05:35:51.254718 duration_in_ms=0.913
2018-10-14 05:35:51,255 [salt.state       :1770][INFO    ][2988] Running state [/etc/apt/preferences.d/mk_openstack] at time 05:35:51.255208
2018-10-14 05:35:51,255 [salt.state       :1803][INFO    ][2988] Executing state file.managed for [/etc/apt/preferences.d/mk_openstack]
2018-10-14 05:35:51,287 [salt.fileclient  :1215][INFO    ][2988] Fetching file from saltenv 'base', ** done ** 'linux/files/preferences_repo'
2018-10-14 05:35:51,417 [salt.state       :290 ][INFO    ][2988] File changed:
New file
2018-10-14 05:35:51,418 [salt.state       :1941][INFO    ][2988] Completed state [/etc/apt/preferences.d/mk_openstack] at time 05:35:51.418524 duration_in_ms=163.315
2018-10-14 05:35:51,423 [salt.state       :1770][INFO    ][2988] Running state [deb [arch=amd64] http://apt.mirantis.com/xenial/ nightly pike] at time 05:35:51.423322
2018-10-14 05:35:51,423 [salt.state       :1803][INFO    ][2988] Executing state pkgrepo.managed for [deb [arch=amd64] http://apt.mirantis.com/xenial/ nightly pike]
2018-10-14 05:35:51,793 [salt.loaded.int.module.cmdmod:395 ][INFO    ][2988] Executing command ['apt-key', 'add', '/var/cache/salt/minion/extrn_files/base/apt.mirantis.com/public.gpg'] in directory '/root'
2018-10-14 05:35:52,037 [salt.state       :290 ][INFO    ][2988] {'repo': 'deb [arch=amd64] http://apt.mirantis.com/xenial nightly pike'}
2018-10-14 05:35:52,037 [salt.state       :1941][INFO    ][2988] Completed state [deb [arch=amd64] http://apt.mirantis.com/xenial/ nightly pike] at time 05:35:52.037793 duration_in_ms=614.47
2018-10-14 05:35:52,038 [salt.state       :1770][INFO    ][2988] Running state [/etc/apt/apt.conf.d/99proxies-salt-uca-staging] at time 05:35:52.038212
2018-10-14 05:35:52,038 [salt.state       :1803][INFO    ][2988] Executing state file.absent for [/etc/apt/apt.conf.d/99proxies-salt-uca-staging]
2018-10-14 05:35:52,039 [salt.state       :290 ][INFO    ][2988] File /etc/apt/apt.conf.d/99proxies-salt-uca-staging is not present
2018-10-14 05:35:52,039 [salt.state       :1941][INFO    ][2988] Completed state [/etc/apt/apt.conf.d/99proxies-salt-uca-staging] at time 05:35:52.039410 duration_in_ms=1.198
2018-10-14 05:35:52,039 [salt.state       :1770][INFO    ][2988] Running state [/etc/apt/preferences.d/uca-staging] at time 05:35:52.039677
2018-10-14 05:35:52,039 [salt.state       :1803][INFO    ][2988] Executing state file.absent for [/etc/apt/preferences.d/uca-staging]
2018-10-14 05:35:52,040 [salt.state       :290 ][INFO    ][2988] File /etc/apt/preferences.d/uca-staging is not present
2018-10-14 05:35:52,040 [salt.state       :1941][INFO    ][2988] Completed state [/etc/apt/preferences.d/uca-staging] at time 05:35:52.040461 duration_in_ms=0.784
2018-10-14 05:35:52,048 [salt.state       :1770][INFO    ][2988] Running state [apt-key adv --keyserver keyserver.ubuntu.com --recv 9F68104E] at time 05:35:52.048093
2018-10-14 05:35:52,048 [salt.state       :1803][INFO    ][2988] Executing state cmd.run for [apt-key adv --keyserver keyserver.ubuntu.com --recv 9F68104E]
2018-10-14 05:35:52,049 [salt.loaded.int.module.cmdmod:395 ][INFO    ][2988] Executing command 'test -e /etc/apt/sources.list.d/uca-staging.list' in directory '/root'
2018-10-14 05:35:52,066 [salt.loaded.int.module.cmdmod:395 ][INFO    ][2988] Executing command 'apt-key adv --keyserver keyserver.ubuntu.com --recv 9F68104E' in directory '/root'
2018-10-14 05:35:52,303 [salt.state       :290 ][INFO    ][2988] {'pid': 3204, '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.cKcHViCFnE/gpg.1.sh --keyserver\nkeyserver.ubuntu.com\n--recv\n9F68104E'}
2018-10-14 05:35:52,304 [salt.state       :1941][INFO    ][2988] Completed state [apt-key adv --keyserver keyserver.ubuntu.com --recv 9F68104E] at time 05:35:52.304333 duration_in_ms=256.239
2018-10-14 05:35:52,309 [salt.state       :1770][INFO    ][2988] Running state [deb http://ppa.launchpad.net/ubuntu-cloud-archive/pike-staging/ubuntu xenial main] at time 05:35:52.309210
2018-10-14 05:35:52,309 [salt.state       :1803][INFO    ][2988] Executing state pkgrepo.managed for [deb http://ppa.launchpad.net/ubuntu-cloud-archive/pike-staging/ubuntu xenial main]
2018-10-14 05:35:52,441 [salt.state       :290 ][INFO    ][2988] {'repo': 'deb http://ppa.launchpad.net/ubuntu-cloud-archive/pike-staging/ubuntu xenial main'}
2018-10-14 05:35:52,442 [salt.state       :1941][INFO    ][2988] Completed state [deb http://ppa.launchpad.net/ubuntu-cloud-archive/pike-staging/ubuntu xenial main] at time 05:35:52.441981 duration_in_ms=132.769
2018-10-14 05:35:52,442 [salt.state       :1770][INFO    ][2988] Running state [/etc/apt/apt.conf.d/99proxies-salt-mirantis_openstack] at time 05:35:52.442346
2018-10-14 05:35:52,442 [salt.state       :1803][INFO    ][2988] Executing state file.absent for [/etc/apt/apt.conf.d/99proxies-salt-mirantis_openstack]
2018-10-14 05:35:52,443 [salt.state       :290 ][INFO    ][2988] File /etc/apt/apt.conf.d/99proxies-salt-mirantis_openstack is not present
2018-10-14 05:35:52,443 [salt.state       :1941][INFO    ][2988] Completed state [/etc/apt/apt.conf.d/99proxies-salt-mirantis_openstack] at time 05:35:52.443361 duration_in_ms=1.015
2018-10-14 05:35:52,443 [salt.state       :1770][INFO    ][2988] Running state [/etc/apt/preferences.d/mirantis_openstack] at time 05:35:52.443611
2018-10-14 05:35:52,443 [salt.state       :1803][INFO    ][2988] Executing state file.managed for [/etc/apt/preferences.d/mirantis_openstack]
2018-10-14 05:35:52,590 [salt.state       :290 ][INFO    ][2988] File changed:
New file
2018-10-14 05:35:52,591 [salt.state       :1941][INFO    ][2988] Completed state [/etc/apt/preferences.d/mirantis_openstack] at time 05:35:52.590981 duration_in_ms=147.37
2018-10-14 05:35:52,594 [salt.state       :1770][INFO    ][2988] Running state [deb http://mirror.fuel-infra.org/mcp-repos/pike/xenial pike main] at time 05:35:52.594099
2018-10-14 05:35:52,594 [salt.state       :1803][INFO    ][2988] Executing state pkgrepo.managed for [deb http://mirror.fuel-infra.org/mcp-repos/pike/xenial pike main]
2018-10-14 05:35:52,766 [salt.loaded.int.module.cmdmod:395 ][INFO    ][2988] 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-14 05:35:52,994 [salt.state       :290 ][INFO    ][2988] {'repo': 'deb http://mirror.fuel-infra.org/mcp-repos/pike/xenial pike main'}
2018-10-14 05:35:52,994 [salt.state       :1941][INFO    ][2988] Completed state [deb http://mirror.fuel-infra.org/mcp-repos/pike/xenial pike main] at time 05:35:52.994750 duration_in_ms=400.651
2018-10-14 05:35:52,995 [salt.state       :1770][INFO    ][2988] Running state [/etc/apt/apt.conf.d/99proxies-salt-uca] at time 05:35:52.995142
2018-10-14 05:35:52,995 [salt.state       :1803][INFO    ][2988] Executing state file.absent for [/etc/apt/apt.conf.d/99proxies-salt-uca]
2018-10-14 05:35:52,996 [salt.state       :290 ][INFO    ][2988] File /etc/apt/apt.conf.d/99proxies-salt-uca is not present
2018-10-14 05:35:52,996 [salt.state       :1941][INFO    ][2988] Completed state [/etc/apt/apt.conf.d/99proxies-salt-uca] at time 05:35:52.996296 duration_in_ms=1.154
2018-10-14 05:35:52,996 [salt.state       :1770][INFO    ][2988] Running state [/etc/apt/preferences.d/uca] at time 05:35:52.996551
2018-10-14 05:35:52,996 [salt.state       :1803][INFO    ][2988] Executing state file.managed for [/etc/apt/preferences.d/uca]
2018-10-14 05:35:53,139 [salt.state       :290 ][INFO    ][2988] File changed:
New file
2018-10-14 05:35:53,140 [salt.state       :1941][INFO    ][2988] Completed state [/etc/apt/preferences.d/uca] at time 05:35:53.140238 duration_in_ms=143.686
2018-10-14 05:35:53,145 [salt.state       :1770][INFO    ][2988] Running state [apt-key adv --keyserver keyserver.ubuntu.com --recv EC4926EA] at time 05:35:53.145061
2018-10-14 05:35:53,145 [salt.state       :1803][INFO    ][2988] Executing state cmd.run for [apt-key adv --keyserver keyserver.ubuntu.com --recv EC4926EA]
2018-10-14 05:35:53,146 [salt.loaded.int.module.cmdmod:395 ][INFO    ][2988] Executing command 'test -e /etc/apt/sources.list.d/uca.list' in directory '/root'
2018-10-14 05:35:53,161 [salt.loaded.int.module.cmdmod:395 ][INFO    ][2988] Executing command 'apt-key adv --keyserver keyserver.ubuntu.com --recv EC4926EA' in directory '/root'
2018-10-14 05:35:53,388 [salt.state       :290 ][INFO    ][2988] {'pid': 3485, '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.eeJGNaizzt/gpg.1.sh --keyserver\nkeyserver.ubuntu.com\n--recv\nEC4926EA'}
2018-10-14 05:35:53,389 [salt.state       :1941][INFO    ][2988] Completed state [apt-key adv --keyserver keyserver.ubuntu.com --recv EC4926EA] at time 05:35:53.388637 duration_in_ms=243.575
2018-10-14 05:35:53,392 [salt.state       :1770][INFO    ][2988] Running state [deb http://ubuntu-cloud.archive.canonical.com/ubuntu xenial-updates/pike main] at time 05:35:53.392399
2018-10-14 05:35:53,393 [salt.state       :1803][INFO    ][2988] Executing state pkgrepo.managed for [deb http://ubuntu-cloud.archive.canonical.com/ubuntu xenial-updates/pike main]
2018-10-14 05:35:53,609 [salt.state       :290 ][INFO    ][2988] {'repo': 'deb http://ubuntu-cloud.archive.canonical.com/ubuntu xenial-updates/pike main'}
2018-10-14 05:35:53,610 [salt.state       :1941][INFO    ][2988] Completed state [deb http://ubuntu-cloud.archive.canonical.com/ubuntu xenial-updates/pike main] at time 05:35:53.610284 duration_in_ms=217.884
2018-10-14 05:35:53,611 [salt.state       :1770][INFO    ][2988] Running state [pkg.refresh_db] at time 05:35:53.611404
2018-10-14 05:35:53,611 [salt.state       :1803][INFO    ][2988] Executing state module.run for [pkg.refresh_db]
2018-10-14 05:35:53,612 [salt.utils.decorators:613 ][WARNING ][2988] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2018-10-14 05:35:53,612 [salt.loaded.int.module.cmdmod:395 ][INFO    ][2988] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2018-10-14 05:35:57,146 [salt.minion      :1307][INFO    ][2899] User sudo_ubuntu Executing command saltutil.find_job with jid 20181014053557133997
2018-10-14 05:35:57,161 [salt.minion      :1431][INFO    ][4061] Starting a new job with PID 4061
2018-10-14 05:35:57,182 [salt.minion      :1708][INFO    ][4061] Returning information for job: 20181014053557133997
2018-10-14 05:35:58,348 [salt.state       :290 ][INFO    ][2988] {'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-14 05:35:58,349 [salt.state       :1941][INFO    ][2988] Completed state [pkg.refresh_db] at time 05:35:58.349353 duration_in_ms=4737.949
2018-10-14 05:35:58,350 [salt.state       :1770][INFO    ][2988] Running state [UTC] at time 05:35:58.350928
2018-10-14 05:35:58,351 [salt.state       :1803][INFO    ][2988] Executing state timezone.system for [UTC]
2018-10-14 05:35:58,352 [salt.loaded.int.module.cmdmod:395 ][INFO    ][2988] Executing command ['timedatectl'] in directory '/root'
2018-10-14 05:35:58,395 [salt.state       :290 ][INFO    ][2988] Timezone UTC already set, UTC already set to UTC
2018-10-14 05:35:58,396 [salt.state       :1941][INFO    ][2988] Completed state [UTC] at time 05:35:58.396180 duration_in_ms=45.251
2018-10-14 05:35:58,397 [salt.state       :1770][INFO    ][2988] Running state [/etc/default/grub.d] at time 05:35:58.397030
2018-10-14 05:35:58,397 [salt.state       :1803][INFO    ][2988] Executing state file.directory for [/etc/default/grub.d]
2018-10-14 05:35:58,399 [salt.state       :290 ][INFO    ][2988] Directory /etc/default/grub.d is in the correct state
Directory /etc/default/grub.d updated
2018-10-14 05:35:58,399 [salt.state       :1941][INFO    ][2988] Completed state [/etc/default/grub.d] at time 05:35:58.399301 duration_in_ms=2.271
2018-10-14 05:35:58,399 [salt.state       :1770][INFO    ][2988] Running state [update-grub] at time 05:35:58.399595
2018-10-14 05:35:58,399 [salt.state       :1803][INFO    ][2988] Executing state cmd.wait for [update-grub]
2018-10-14 05:35:58,400 [salt.state       :290 ][INFO    ][2988] No changes made for update-grub
2018-10-14 05:35:58,400 [salt.state       :1941][INFO    ][2988] Completed state [update-grub] at time 05:35:58.400455 duration_in_ms=0.859
2018-10-14 05:35:58,404 [salt.state       :1770][INFO    ][2988] Running state [/boot/grub/grub.cfg] at time 05:35:58.404095
2018-10-14 05:35:58,404 [salt.state       :1803][INFO    ][2988] Executing state file.managed for [/boot/grub/grub.cfg]
2018-10-14 05:35:58,613 [salt.loaded.int.module.cmdmod:395 ][INFO    ][2988] Executing command ['git', '--version'] in directory '/root'
2018-10-14 05:35:58,923 [salt.loaded.int.module.cmdmod:395 ][INFO    ][2988] Executing command 'test -f /boot/grub/grub.cfg' in directory '/root'
2018-10-14 05:35:58,938 [salt.loaded.int.states.file:2150][WARNING ][2988] 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-14 05:35:58,939 [salt.state       :290 ][INFO    ][2988] {'mode': '0400'}
2018-10-14 05:35:58,939 [salt.state       :1941][INFO    ][2988] Completed state [/boot/grub/grub.cfg] at time 05:35:58.939844 duration_in_ms=535.748
2018-10-14 05:35:58,940 [salt.state       :1770][INFO    ][2988] Running state [nf_conntrack] at time 05:35:58.940275
2018-10-14 05:35:58,941 [salt.state       :1803][INFO    ][2988] Executing state kmod.present for [nf_conntrack]
2018-10-14 05:35:58,942 [salt.loaded.int.module.cmdmod:395 ][INFO    ][2988] Executing command 'lsmod' in directory '/root'
2018-10-14 05:35:59,351 [salt.loaded.int.module.cmdmod:395 ][INFO    ][2988] Executing command 'lsmod' in directory '/root'
2018-10-14 05:35:59,367 [salt.loaded.int.module.cmdmod:395 ][INFO    ][2988] Executing command 'modprobe nf_conntrack' in directory '/root'
2018-10-14 05:35:59,386 [salt.loaded.int.module.cmdmod:395 ][INFO    ][2988] Executing command 'lsmod' in directory '/root'
2018-10-14 05:35:59,496 [salt.state       :290 ][INFO    ][2988] {'nf_conntrack': 'loaded'}
2018-10-14 05:35:59,497 [salt.state       :1941][INFO    ][2988] Completed state [nf_conntrack] at time 05:35:59.497316 duration_in_ms=557.04
2018-10-14 05:35:59,497 [salt.state       :1770][INFO    ][2988] Running state [kernel.panic] at time 05:35:59.497729
2018-10-14 05:35:59,498 [salt.state       :1803][INFO    ][2988] Executing state sysctl.present for [kernel.panic]
2018-10-14 05:35:59,512 [salt.loaded.int.module.cmdmod:395 ][INFO    ][2988] Executing command 'sysctl -w kernel.panic="60"' in directory '/root'
2018-10-14 05:35:59,526 [salt.state       :290 ][INFO    ][2988] {'kernel.panic': 60}
2018-10-14 05:35:59,527 [salt.state       :1941][INFO    ][2988] Completed state [kernel.panic] at time 05:35:59.527108 duration_in_ms=29.379
2018-10-14 05:35:59,527 [salt.state       :1770][INFO    ][2988] Running state [net.ipv4.tcp_keepalive_probes] at time 05:35:59.527526
2018-10-14 05:35:59,527 [salt.state       :1803][INFO    ][2988] Executing state sysctl.present for [net.ipv4.tcp_keepalive_probes]
2018-10-14 05:35:59,529 [salt.loaded.int.module.cmdmod:395 ][INFO    ][2988] Executing command 'sysctl -w net.ipv4.tcp_keepalive_probes="8"' in directory '/root'
2018-10-14 05:35:59,541 [salt.state       :290 ][INFO    ][2988] {'net.ipv4.tcp_keepalive_probes': 8}
2018-10-14 05:35:59,542 [salt.state       :1941][INFO    ][2988] Completed state [net.ipv4.tcp_keepalive_probes] at time 05:35:59.542191 duration_in_ms=14.665
2018-10-14 05:35:59,542 [salt.state       :1770][INFO    ][2988] Running state [fs.file-max] at time 05:35:59.542601
2018-10-14 05:35:59,542 [salt.state       :1803][INFO    ][2988] Executing state sysctl.present for [fs.file-max]
2018-10-14 05:35:59,543 [salt.loaded.int.module.cmdmod:395 ][INFO    ][2988] Executing command 'sysctl -w fs.file-max="124165"' in directory '/root'
2018-10-14 05:35:59,557 [salt.state       :290 ][INFO    ][2988] {'fs.file-max': 124165}
2018-10-14 05:35:59,557 [salt.state       :1941][INFO    ][2988] Completed state [fs.file-max] at time 05:35:59.557660 duration_in_ms=15.058
2018-10-14 05:35:59,558 [salt.state       :1770][INFO    ][2988] Running state [net.core.somaxconn] at time 05:35:59.558069
2018-10-14 05:35:59,558 [salt.state       :1803][INFO    ][2988] Executing state sysctl.present for [net.core.somaxconn]
2018-10-14 05:35:59,559 [salt.loaded.int.module.cmdmod:395 ][INFO    ][2988] Executing command 'sysctl -w net.core.somaxconn="4096"' in directory '/root'
2018-10-14 05:35:59,571 [salt.state       :290 ][INFO    ][2988] {'net.core.somaxconn': 4096}
2018-10-14 05:35:59,571 [salt.state       :1941][INFO    ][2988] Completed state [net.core.somaxconn] at time 05:35:59.571658 duration_in_ms=13.589
2018-10-14 05:35:59,572 [salt.state       :1770][INFO    ][2988] Running state [net.ipv4.tcp_max_syn_backlog] at time 05:35:59.572073
2018-10-14 05:35:59,572 [salt.state       :1803][INFO    ][2988] Executing state sysctl.present for [net.ipv4.tcp_max_syn_backlog]
2018-10-14 05:35:59,573 [salt.loaded.int.module.cmdmod:395 ][INFO    ][2988] Executing command 'sysctl -w net.ipv4.tcp_max_syn_backlog="8192"' in directory '/root'
2018-10-14 05:35:59,586 [salt.state       :290 ][INFO    ][2988] {'net.ipv4.tcp_max_syn_backlog': 8192}
2018-10-14 05:35:59,586 [salt.state       :1941][INFO    ][2988] Completed state [net.ipv4.tcp_max_syn_backlog] at time 05:35:59.586371 duration_in_ms=14.297
2018-10-14 05:35:59,586 [salt.state       :1770][INFO    ][2988] Running state [net.ipv4.tcp_tw_reuse] at time 05:35:59.586775
2018-10-14 05:35:59,587 [salt.state       :1803][INFO    ][2988] Executing state sysctl.present for [net.ipv4.tcp_tw_reuse]
2018-10-14 05:35:59,588 [salt.loaded.int.module.cmdmod:395 ][INFO    ][2988] Executing command 'sysctl -w net.ipv4.tcp_tw_reuse="1"' in directory '/root'
2018-10-14 05:35:59,601 [salt.state       :290 ][INFO    ][2988] {'net.ipv4.tcp_tw_reuse': 1}
2018-10-14 05:35:59,602 [salt.state       :1941][INFO    ][2988] Completed state [net.ipv4.tcp_tw_reuse] at time 05:35:59.602236 duration_in_ms=15.461
2018-10-14 05:35:59,602 [salt.state       :1770][INFO    ][2988] Running state [net.ipv4.tcp_congestion_control] at time 05:35:59.602649
2018-10-14 05:35:59,603 [salt.state       :1803][INFO    ][2988] Executing state sysctl.present for [net.ipv4.tcp_congestion_control]
2018-10-14 05:35:59,604 [salt.loaded.int.module.cmdmod:395 ][INFO    ][2988] Executing command 'sysctl -w net.ipv4.tcp_congestion_control="yeah"' in directory '/root'
2018-10-14 05:35:59,621 [salt.state       :290 ][INFO    ][2988] {'net.ipv4.tcp_congestion_control': 'yeah'}
2018-10-14 05:35:59,622 [salt.state       :1941][INFO    ][2988] Completed state [net.ipv4.tcp_congestion_control] at time 05:35:59.622339 duration_in_ms=19.69
2018-10-14 05:35:59,622 [salt.state       :1770][INFO    ][2988] Running state [net.ipv4.tcp_retries2] at time 05:35:59.622751
2018-10-14 05:35:59,623 [salt.state       :1803][INFO    ][2988] Executing state sysctl.present for [net.ipv4.tcp_retries2]
2018-10-14 05:35:59,624 [salt.loaded.int.module.cmdmod:395 ][INFO    ][2988] Executing command 'sysctl -w net.ipv4.tcp_retries2="5"' in directory '/root'
2018-10-14 05:35:59,637 [salt.state       :290 ][INFO    ][2988] {'net.ipv4.tcp_retries2': 5}
2018-10-14 05:35:59,637 [salt.state       :1941][INFO    ][2988] Completed state [net.ipv4.tcp_retries2] at time 05:35:59.637711 duration_in_ms=14.96
2018-10-14 05:35:59,638 [salt.state       :1770][INFO    ][2988] Running state [net.core.netdev_max_backlog] at time 05:35:59.638119
2018-10-14 05:35:59,638 [salt.state       :1803][INFO    ][2988] Executing state sysctl.present for [net.core.netdev_max_backlog]
2018-10-14 05:35:59,639 [salt.loaded.int.module.cmdmod:395 ][INFO    ][2988] Executing command 'sysctl -w net.core.netdev_max_backlog="261144"' in directory '/root'
2018-10-14 05:35:59,652 [salt.state       :290 ][INFO    ][2988] {'net.core.netdev_max_backlog': 261144}
2018-10-14 05:35:59,653 [salt.state       :1941][INFO    ][2988] Completed state [net.core.netdev_max_backlog] at time 05:35:59.653202 duration_in_ms=15.083
2018-10-14 05:35:59,653 [salt.state       :1770][INFO    ][2988] Running state [net.ipv4.tcp_slow_start_after_idle] at time 05:35:59.653609
2018-10-14 05:35:59,653 [salt.state       :1803][INFO    ][2988] Executing state sysctl.present for [net.ipv4.tcp_slow_start_after_idle]
2018-10-14 05:35:59,654 [salt.loaded.int.module.cmdmod:395 ][INFO    ][2988] Executing command 'sysctl -w net.ipv4.tcp_slow_start_after_idle="0"' in directory '/root'
2018-10-14 05:35:59,667 [salt.state       :290 ][INFO    ][2988] {'net.ipv4.tcp_slow_start_after_idle': 0}
2018-10-14 05:35:59,667 [salt.state       :1941][INFO    ][2988] Completed state [net.ipv4.tcp_slow_start_after_idle] at time 05:35:59.667846 duration_in_ms=14.237
2018-10-14 05:35:59,668 [salt.state       :1770][INFO    ][2988] Running state [vm.swappiness] at time 05:35:59.668257
2018-10-14 05:35:59,669 [salt.state       :1803][INFO    ][2988] Executing state sysctl.present for [vm.swappiness]
2018-10-14 05:35:59,670 [salt.loaded.int.module.cmdmod:395 ][INFO    ][2988] Executing command 'sysctl -w vm.swappiness="10"' in directory '/root'
2018-10-14 05:35:59,682 [salt.state       :290 ][INFO    ][2988] {'vm.swappiness': 10}
2018-10-14 05:35:59,682 [salt.state       :1941][INFO    ][2988] Completed state [vm.swappiness] at time 05:35:59.682827 duration_in_ms=14.569
2018-10-14 05:35:59,683 [salt.state       :1770][INFO    ][2988] Running state [net.ipv4.tcp_keepalive_intvl] at time 05:35:59.683237
2018-10-14 05:35:59,683 [salt.state       :1803][INFO    ][2988] Executing state sysctl.present for [net.ipv4.tcp_keepalive_intvl]
2018-10-14 05:35:59,685 [salt.loaded.int.module.cmdmod:395 ][INFO    ][2988] Executing command 'sysctl -w net.ipv4.tcp_keepalive_intvl="3"' in directory '/root'
2018-10-14 05:35:59,698 [salt.state       :290 ][INFO    ][2988] {'net.ipv4.tcp_keepalive_intvl': 3}
2018-10-14 05:35:59,698 [salt.state       :1941][INFO    ][2988] Completed state [net.ipv4.tcp_keepalive_intvl] at time 05:35:59.698433 duration_in_ms=15.196
2018-10-14 05:35:59,698 [salt.state       :1770][INFO    ][2988] Running state [net.ipv4.neigh.default.gc_thresh1] at time 05:35:59.698828
2018-10-14 05:35:59,699 [salt.state       :1803][INFO    ][2988] Executing state sysctl.present for [net.ipv4.neigh.default.gc_thresh1]
2018-10-14 05:35:59,700 [salt.loaded.int.module.cmdmod:395 ][INFO    ][2988] Executing command 'sysctl -w net.ipv4.neigh.default.gc_thresh1="4096"' in directory '/root'
2018-10-14 05:35:59,715 [salt.state       :290 ][INFO    ][2988] {'net.ipv4.neigh.default.gc_thresh1': 4096}
2018-10-14 05:35:59,715 [salt.state       :1941][INFO    ][2988] Completed state [net.ipv4.neigh.default.gc_thresh1] at time 05:35:59.715680 duration_in_ms=16.852
2018-10-14 05:35:59,716 [salt.state       :1770][INFO    ][2988] Running state [net.ipv4.neigh.default.gc_thresh2] at time 05:35:59.716328
2018-10-14 05:35:59,717 [salt.state       :1803][INFO    ][2988] Executing state sysctl.present for [net.ipv4.neigh.default.gc_thresh2]
2018-10-14 05:35:59,718 [salt.loaded.int.module.cmdmod:395 ][INFO    ][2988] Executing command 'sysctl -w net.ipv4.neigh.default.gc_thresh2="8192"' in directory '/root'
2018-10-14 05:35:59,732 [salt.state       :290 ][INFO    ][2988] {'net.ipv4.neigh.default.gc_thresh2': 8192}
2018-10-14 05:35:59,733 [salt.state       :1941][INFO    ][2988] Completed state [net.ipv4.neigh.default.gc_thresh2] at time 05:35:59.733011 duration_in_ms=16.683
2018-10-14 05:35:59,733 [salt.state       :1770][INFO    ][2988] Running state [net.ipv4.neigh.default.gc_thresh3] at time 05:35:59.733440
2018-10-14 05:35:59,733 [salt.state       :1803][INFO    ][2988] Executing state sysctl.present for [net.ipv4.neigh.default.gc_thresh3]
2018-10-14 05:35:59,734 [salt.loaded.int.module.cmdmod:395 ][INFO    ][2988] Executing command 'sysctl -w net.ipv4.neigh.default.gc_thresh3="16384"' in directory '/root'
2018-10-14 05:35:59,747 [salt.state       :290 ][INFO    ][2988] {'net.ipv4.neigh.default.gc_thresh3': 16384}
2018-10-14 05:35:59,748 [salt.state       :1941][INFO    ][2988] Completed state [net.ipv4.neigh.default.gc_thresh3] at time 05:35:59.748008 duration_in_ms=14.568
2018-10-14 05:35:59,748 [salt.state       :1770][INFO    ][2988] Running state [net.ipv4.tcp_fin_timeout] at time 05:35:59.748428
2018-10-14 05:35:59,749 [salt.state       :1803][INFO    ][2988] Executing state sysctl.present for [net.ipv4.tcp_fin_timeout]
2018-10-14 05:35:59,750 [salt.loaded.int.module.cmdmod:395 ][INFO    ][2988] Executing command 'sysctl -w net.ipv4.tcp_fin_timeout="30"' in directory '/root'
2018-10-14 05:35:59,762 [salt.state       :290 ][INFO    ][2988] {'net.ipv4.tcp_fin_timeout': 30}
2018-10-14 05:35:59,763 [salt.state       :1941][INFO    ][2988] Completed state [net.ipv4.tcp_fin_timeout] at time 05:35:59.763311 duration_in_ms=14.883
2018-10-14 05:35:59,763 [salt.state       :1770][INFO    ][2988] Running state [net.ipv4.tcp_keepalive_time] at time 05:35:59.763731
2018-10-14 05:35:59,764 [salt.state       :1803][INFO    ][2988] Executing state sysctl.present for [net.ipv4.tcp_keepalive_time]
2018-10-14 05:35:59,765 [salt.loaded.int.module.cmdmod:395 ][INFO    ][2988] Executing command 'sysctl -w net.ipv4.tcp_keepalive_time="30"' in directory '/root'
2018-10-14 05:35:59,778 [salt.state       :290 ][INFO    ][2988] {'net.ipv4.tcp_keepalive_time': 30}
2018-10-14 05:35:59,778 [salt.state       :1941][INFO    ][2988] Completed state [net.ipv4.tcp_keepalive_time] at time 05:35:59.778891 duration_in_ms=15.16
2018-10-14 05:35:59,779 [salt.state       :1770][INFO    ][2988] Running state [net.nf_conntrack_max] at time 05:35:59.779311
2018-10-14 05:35:59,779 [salt.state       :1803][INFO    ][2988] Executing state sysctl.present for [net.nf_conntrack_max]
2018-10-14 05:35:59,781 [salt.loaded.int.module.cmdmod:395 ][INFO    ][2988] Executing command 'sysctl -w net.nf_conntrack_max="1048576"' in directory '/root'
2018-10-14 05:35:59,795 [salt.state       :290 ][INFO    ][2988] {'net.nf_conntrack_max': 1048576}
2018-10-14 05:35:59,795 [salt.state       :1941][INFO    ][2988] Completed state [net.nf_conntrack_max] at time 05:35:59.795400 duration_in_ms=16.089
2018-10-14 05:35:59,795 [salt.state       :1770][INFO    ][2988] Running state [linux_sysfs_package] at time 05:35:59.795833
2018-10-14 05:35:59,796 [salt.state       :1803][INFO    ][2988] Executing state pkg.installed for [linux_sysfs_package]
2018-10-14 05:35:59,822 [salt.loaded.int.module.cmdmod:395 ][INFO    ][2988] Executing command ['apt-cache', '-q', 'policy', 'sysfsutils'] in directory '/root'
2018-10-14 05:35:59,916 [salt.loaded.int.module.cmdmod:395 ][INFO    ][2988] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2018-10-14 05:36:02,067 [salt.loaded.int.module.cmdmod:395 ][INFO    ][2988] Executing command ['dpkg', '--get-selections', '*'] in directory '/root'
2018-10-14 05:36:02,098 [salt.loaded.int.module.cmdmod:395 ][INFO    ][2988] 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-14 05:36:05,339 [salt.loaded.int.module.cmdmod:395 ][INFO    ][2988] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}', '-W'] in directory '/root'
2018-10-14 05:36:05,383 [salt.state       :290 ][INFO    ][2988] 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-14 05:36:05,416 [salt.state       :905 ][INFO    ][2988] Loading fresh modules for state activity
2018-10-14 05:36:05,462 [salt.state       :1941][INFO    ][2988] Completed state [linux_sysfs_package] at time 05:36:05.462456 duration_in_ms=5666.622
2018-10-14 05:36:05,468 [salt.state       :1770][INFO    ][2988] Running state [/etc/sysfs.d] at time 05:36:05.468155
2018-10-14 05:36:05,469 [salt.state       :1803][INFO    ][2988] Executing state file.directory for [/etc/sysfs.d]
2018-10-14 05:36:05,474 [salt.state       :290 ][INFO    ][2988] Directory /etc/sysfs.d is in the correct state
Directory /etc/sysfs.d updated
2018-10-14 05:36:05,474 [salt.state       :1941][INFO    ][2988] Completed state [/etc/sysfs.d] at time 05:36:05.474250 duration_in_ms=6.095
2018-10-14 05:36:06,090 [salt.state       :1770][INFO    ][2988] Running state [ondemand] at time 05:36:06.090588
2018-10-14 05:36:06,091 [salt.state       :1803][INFO    ][2988] Executing state service.dead for [ondemand]
2018-10-14 05:36:06,091 [salt.loaded.int.module.cmdmod:395 ][INFO    ][2988] Executing command ['systemctl', 'status', 'ondemand.service', '-n', '0'] in directory '/root'
2018-10-14 05:36:06,112 [salt.loaded.int.module.cmdmod:395 ][INFO    ][2988] Executing command ['systemctl', 'is-active', 'ondemand.service'] in directory '/root'
2018-10-14 05:36:06,130 [salt.loaded.int.module.cmdmod:395 ][INFO    ][2988] Executing command ['systemctl', 'is-enabled', 'ondemand.service'] in directory '/root'
2018-10-14 05:36:06,149 [salt.loaded.int.module.cmdmod:395 ][INFO    ][2988] Executing command ['systemd-run', '--scope', 'systemctl', 'stop', 'ondemand.service'] in directory '/root'
2018-10-14 05:36:06,213 [salt.loaded.int.module.cmdmod:395 ][INFO    ][2988] Executing command ['systemctl', 'is-active', 'ondemand.service'] in directory '/root'
2018-10-14 05:36:06,230 [salt.loaded.int.module.cmdmod:395 ][INFO    ][2988] Executing command ['systemctl', 'is-enabled', 'ondemand.service'] in directory '/root'
2018-10-14 05:36:06,248 [salt.loaded.int.module.cmdmod:395 ][INFO    ][2988] Executing command ['systemctl', 'is-enabled', 'ondemand.service'] in directory '/root'
2018-10-14 05:36:06,272 [salt.loaded.int.module.cmdmod:395 ][INFO    ][2988] Executing command ['systemd-run', '--scope', '/usr/sbin/update-rc.d', '-f', 'ondemand', 'remove'] in directory '/root'
2018-10-14 05:36:06,423 [salt.loaded.int.module.cmdmod:395 ][INFO    ][2988] Executing command ['systemctl', 'is-enabled', 'ondemand.service'] in directory '/root'
2018-10-14 05:36:06,448 [salt.loaded.int.module.cmdmod:395 ][INFO    ][2988] Executing command 'runlevel' in directory '/root'
2018-10-14 05:36:06,462 [salt.state       :290 ][INFO    ][2988] {'ondemand': True}
2018-10-14 05:36:06,463 [salt.state       :1941][INFO    ][2988] Completed state [ondemand] at time 05:36:06.463335 duration_in_ms=372.747
2018-10-14 05:36:06,465 [salt.state       :1770][INFO    ][2988] Running state [cs_CZ.UTF-8] at time 05:36:06.464976
2018-10-14 05:36:06,465 [salt.state       :1803][INFO    ][2988] Executing state locale.present for [cs_CZ.UTF-8]
2018-10-14 05:36:06,466 [salt.loaded.int.module.cmdmod:395 ][INFO    ][2988] Executing command 'locale -a' in directory '/root'
2018-10-14 05:36:06,486 [salt.loaded.int.module.cmdmod:395 ][INFO    ][2988] Executing command ['locale-gen', 'cs_CZ.utf8'] in directory '/root'
2018-10-14 05:36:07,246 [salt.state       :290 ][INFO    ][2988] {'locale': 'cs_CZ.UTF-8'}
2018-10-14 05:36:07,246 [salt.state       :1941][INFO    ][2988] Completed state [cs_CZ.UTF-8] at time 05:36:07.246475 duration_in_ms=781.499
2018-10-14 05:36:07,247 [salt.state       :1770][INFO    ][2988] Running state [en_US.UTF-8] at time 05:36:07.247161
2018-10-14 05:36:07,247 [salt.state       :1803][INFO    ][2988] Executing state locale.present for [en_US.UTF-8]
2018-10-14 05:36:07,249 [salt.loaded.int.module.cmdmod:395 ][INFO    ][2988] Executing command 'locale -a' in directory '/root'
2018-10-14 05:36:07,264 [salt.state       :290 ][INFO    ][2988] Locale en_US.UTF-8 is already present
2018-10-14 05:36:07,265 [salt.state       :1941][INFO    ][2988] Completed state [en_US.UTF-8] at time 05:36:07.265307 duration_in_ms=18.146
2018-10-14 05:36:07,268 [salt.state       :1770][INFO    ][2988] Running state [en_US.UTF-8] at time 05:36:07.268031
2018-10-14 05:36:07,269 [salt.state       :1803][INFO    ][2988] Executing state locale.system for [en_US.UTF-8]
2018-10-14 05:36:07,270 [salt.loaded.int.module.cmdmod:395 ][INFO    ][2988] Executing command 'localectl' in directory '/root'
2018-10-14 05:36:07,313 [salt.state       :290 ][INFO    ][2988] System locale en_US.UTF-8 already set
2018-10-14 05:36:07,314 [salt.state       :1941][INFO    ][2988] Completed state [en_US.UTF-8] at time 05:36:07.314302 duration_in_ms=46.27
2018-10-14 05:36:07,316 [salt.state       :1770][INFO    ][2988] Running state [root] at time 05:36:07.316117
2018-10-14 05:36:07,317 [salt.state       :1803][INFO    ][2988] Executing state group.present for [root]
2018-10-14 05:36:07,318 [salt.state       :290 ][INFO    ][2988] Group root is present and up to date
2018-10-14 05:36:07,318 [salt.state       :1941][INFO    ][2988] Completed state [root] at time 05:36:07.318387 duration_in_ms=2.27
2018-10-14 05:36:07,321 [salt.state       :1770][INFO    ][2988] Running state [root] at time 05:36:07.320998
2018-10-14 05:36:07,321 [salt.state       :1803][INFO    ][2988] Executing state user.present for [root]
2018-10-14 05:36:07,325 [salt.state       :290 ][INFO    ][2988] User root is present and up to date
2018-10-14 05:36:07,326 [salt.state       :1941][INFO    ][2988] Completed state [root] at time 05:36:07.326107 duration_in_ms=5.109
2018-10-14 05:36:07,327 [salt.state       :1770][INFO    ][2988] Running state [/root] at time 05:36:07.327356
2018-10-14 05:36:07,327 [salt.state       :1803][INFO    ][2988] Executing state file.directory for [/root]
2018-10-14 05:36:07,329 [salt.state       :290 ][INFO    ][2988] Directory /root is in the correct state
Directory /root updated
2018-10-14 05:36:07,329 [salt.state       :1941][INFO    ][2988] Completed state [/root] at time 05:36:07.329614 duration_in_ms=2.258
2018-10-14 05:36:07,329 [salt.state       :1770][INFO    ][2988] Running state [/etc/sudoers.d/90-salt-user-root] at time 05:36:07.329858
2018-10-14 05:36:07,330 [salt.state       :1803][INFO    ][2988] Executing state file.absent for [/etc/sudoers.d/90-salt-user-root]
2018-10-14 05:36:07,330 [salt.state       :290 ][INFO    ][2988] File /etc/sudoers.d/90-salt-user-root is not present
2018-10-14 05:36:07,330 [salt.state       :1941][INFO    ][2988] Completed state [/etc/sudoers.d/90-salt-user-root] at time 05:36:07.330641 duration_in_ms=0.783
2018-10-14 05:36:07,330 [salt.state       :1770][INFO    ][2988] Running state [ubuntu] at time 05:36:07.330870
2018-10-14 05:36:07,331 [salt.state       :1803][INFO    ][2988] Executing state group.present for [ubuntu]
2018-10-14 05:36:07,331 [salt.state       :290 ][INFO    ][2988] Group ubuntu is present and up to date
2018-10-14 05:36:07,331 [salt.state       :1941][INFO    ][2988] Completed state [ubuntu] at time 05:36:07.331652 duration_in_ms=0.781
2018-10-14 05:36:07,332 [salt.state       :1770][INFO    ][2988] Running state [ubuntu] at time 05:36:07.332672
2018-10-14 05:36:07,332 [salt.state       :1803][INFO    ][2988] Executing state user.present for [ubuntu]
2018-10-14 05:36:07,336 [salt.state       :290 ][INFO    ][2988] {'passwd': 'XXX-REDACTED-XXX'}
2018-10-14 05:36:07,336 [salt.state       :1941][INFO    ][2988] Completed state [ubuntu] at time 05:36:07.336847 duration_in_ms=4.175
2018-10-14 05:36:07,338 [salt.state       :1770][INFO    ][2988] Running state [/home/ubuntu] at time 05:36:07.338072
2018-10-14 05:36:07,338 [salt.state       :1803][INFO    ][2988] Executing state file.directory for [/home/ubuntu]
2018-10-14 05:36:07,339 [salt.state       :290 ][INFO    ][2988] {'mode': '0700'}
2018-10-14 05:36:07,339 [salt.state       :1941][INFO    ][2988] Completed state [/home/ubuntu] at time 05:36:07.339892 duration_in_ms=1.821
2018-10-14 05:36:07,341 [salt.state       :1770][INFO    ][2988] Running state [/etc/sudoers.d/90-salt-user-ubuntu] at time 05:36:07.341302
2018-10-14 05:36:07,341 [salt.state       :1803][INFO    ][2988] Executing state file.managed for [/etc/sudoers.d/90-salt-user-ubuntu]
2018-10-14 05:36:07,363 [salt.fileclient  :1215][INFO    ][2988] Fetching file from saltenv 'base', ** done ** 'linux/files/sudoer'
2018-10-14 05:36:07,378 [salt.loaded.int.module.cmdmod:395 ][INFO    ][2988] Executing command '/usr/sbin/visudo -c -f /tmp/__salt.tmp.hK_LOy' in directory '/root'
2018-10-14 05:36:07,403 [salt.state       :290 ][INFO    ][2988] File changed:
New file
2018-10-14 05:36:07,403 [salt.state       :1941][INFO    ][2988] Completed state [/etc/sudoers.d/90-salt-user-ubuntu] at time 05:36:07.403735 duration_in_ms=62.432
2018-10-14 05:36:07,404 [salt.state       :1770][INFO    ][2988] Running state [/etc/security/limits.d/90-salt-default.conf] at time 05:36:07.404146
2018-10-14 05:36:07,405 [salt.state       :1803][INFO    ][2988] Executing state file.managed for [/etc/security/limits.d/90-salt-default.conf]
2018-10-14 05:36:07,429 [salt.fileclient  :1215][INFO    ][2988] Fetching file from saltenv 'base', ** done ** 'linux/files/limits.conf'
2018-10-14 05:36:07,563 [salt.state       :290 ][INFO    ][2988] File changed:
New file
2018-10-14 05:36:07,563 [salt.state       :1941][INFO    ][2988] Completed state [/etc/security/limits.d/90-salt-default.conf] at time 05:36:07.563807 duration_in_ms=159.661
2018-10-14 05:36:07,564 [salt.state       :1770][INFO    ][2988] Running state [/etc/systemd/system.conf.d/90-salt.conf] at time 05:36:07.564083
2018-10-14 05:36:07,564 [salt.state       :1803][INFO    ][2988] Executing state file.managed for [/etc/systemd/system.conf.d/90-salt.conf]
2018-10-14 05:36:07,590 [salt.fileclient  :1215][INFO    ][2988] Fetching file from saltenv 'base', ** done ** 'linux/files/systemd.conf'
2018-10-14 05:36:07,711 [salt.state       :290 ][INFO    ][2988] File changed:
New file
2018-10-14 05:36:07,712 [salt.state       :1941][INFO    ][2988] Completed state [/etc/systemd/system.conf.d/90-salt.conf] at time 05:36:07.712252 duration_in_ms=148.169
2018-10-14 05:36:07,716 [salt.state       :1770][INFO    ][2988] Running state [service.systemctl_reload] at time 05:36:07.716029
2018-10-14 05:36:07,716 [salt.state       :1803][INFO    ][2988] Executing state module.wait for [service.systemctl_reload]
2018-10-14 05:36:07,716 [salt.state       :290 ][INFO    ][2988] No changes made for service.systemctl_reload
2018-10-14 05:36:07,717 [salt.state       :1941][INFO    ][2988] Completed state [service.systemctl_reload] at time 05:36:07.717153 duration_in_ms=1.124
2018-10-14 05:36:07,717 [salt.state       :1770][INFO    ][2988] Running state [service.systemctl_reload] at time 05:36:07.717362
2018-10-14 05:36:07,717 [salt.state       :1803][INFO    ][2988] Executing state module.mod_watch for [service.systemctl_reload]
2018-10-14 05:36:07,717 [salt.utils.decorators:613 ][WARNING ][2988] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2018-10-14 05:36:07,718 [salt.loaded.int.module.cmdmod:395 ][INFO    ][2988] Executing command ['systemctl', '--system', 'daemon-reload'] in directory '/root'
2018-10-14 05:36:07,839 [salt.state       :290 ][INFO    ][2988] {'ret': True}
2018-10-14 05:36:07,840 [salt.state       :1941][INFO    ][2988] Completed state [service.systemctl_reload] at time 05:36:07.840172 duration_in_ms=122.808
2018-10-14 05:36:07,841 [salt.state       :1770][INFO    ][2988] Running state [/etc/issue] at time 05:36:07.841048
2018-10-14 05:36:07,841 [salt.state       :1803][INFO    ][2988] Executing state file.managed for [/etc/issue]
2018-10-14 05:36:07,845 [salt.state       :290 ][INFO    ][2988] 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-14 05:36:07,846 [salt.state       :1941][INFO    ][2988] Completed state [/etc/issue] at time 05:36:07.846100 duration_in_ms=5.052
2018-10-14 05:36:07,846 [salt.state       :1770][INFO    ][2988] Running state [/etc/hostname] at time 05:36:07.846375
2018-10-14 05:36:07,846 [salt.state       :1803][INFO    ][2988] Executing state file.managed for [/etc/hostname]
2018-10-14 05:36:08,214 [salt.minion      :1307][INFO    ][2899] User sudo_ubuntu Executing command saltutil.find_job with jid 20181014053608201286
2018-10-14 05:36:08,220 [salt.fileclient  :1215][INFO    ][2988] Fetching file from saltenv 'base', ** done ** 'linux/files/hostname'
2018-10-14 05:36:08,231 [salt.minion      :1431][INFO    ][5153] Starting a new job with PID 5153
2018-10-14 05:36:08,235 [salt.state       :290 ][INFO    ][2988] File changed:
--- 
+++ 
@@ -1 +1 @@
-ubuntu
+msg03

2018-10-14 05:36:08,237 [salt.state       :1941][INFO    ][2988] Completed state [/etc/hostname] at time 05:36:08.237140 duration_in_ms=390.765
2018-10-14 05:36:08,240 [salt.state       :1770][INFO    ][2988] Running state [hostname msg03] at time 05:36:08.240027
2018-10-14 05:36:08,241 [salt.state       :1803][INFO    ][2988] Executing state cmd.run for [hostname msg03]
2018-10-14 05:36:08,242 [salt.loaded.int.module.cmdmod:395 ][INFO    ][2988] Executing command 'test "$(hostname)" = "msg03"' in directory '/root'
2018-10-14 05:36:08,251 [salt.minion      :1708][INFO    ][5153] Returning information for job: 20181014053608201286
2018-10-14 05:36:08,260 [salt.loaded.int.module.cmdmod:395 ][INFO    ][2988] Executing command 'hostname msg03' in directory '/root'
2018-10-14 05:36:08,282 [salt.state       :290 ][INFO    ][2988] {'pid': 5160, 'retcode': 0, 'stderr': '', 'stdout': ''}
2018-10-14 05:36:08,283 [salt.state       :1941][INFO    ][2988] Completed state [hostname msg03] at time 05:36:08.283505 duration_in_ms=43.476
2018-10-14 05:36:08,286 [salt.state       :1770][INFO    ][2988] Running state [mdb02] at time 05:36:08.286399
2018-10-14 05:36:08,287 [salt.state       :1803][INFO    ][2988] Executing state host.present for [mdb02]
2018-10-14 05:36:08,291 [salt.state       :290 ][INFO    ][2988] {'host': 'mdb02'}
2018-10-14 05:36:08,291 [salt.state       :1941][INFO    ][2988] Completed state [mdb02] at time 05:36:08.291634 duration_in_ms=5.236
2018-10-14 05:36:08,292 [salt.state       :1770][INFO    ][2988] Running state [mdb02.mcp-pike-odl-ha.local] at time 05:36:08.292447
2018-10-14 05:36:08,293 [salt.state       :1803][INFO    ][2988] Executing state host.present for [mdb02.mcp-pike-odl-ha.local]
2018-10-14 05:36:08,294 [salt.state       :290 ][INFO    ][2988] {'host': 'mdb02.mcp-pike-odl-ha.local'}
2018-10-14 05:36:08,295 [salt.state       :1941][INFO    ][2988] Completed state [mdb02.mcp-pike-odl-ha.local] at time 05:36:08.295321 duration_in_ms=2.873
2018-10-14 05:36:08,296 [salt.state       :1770][INFO    ][2988] Running state [mdb03] at time 05:36:08.296082
2018-10-14 05:36:08,297 [salt.state       :1803][INFO    ][2988] Executing state host.present for [mdb03]
2018-10-14 05:36:08,298 [salt.state       :290 ][INFO    ][2988] {'host': 'mdb03'}
2018-10-14 05:36:08,298 [salt.state       :1941][INFO    ][2988] Completed state [mdb03] at time 05:36:08.298526 duration_in_ms=2.444
2018-10-14 05:36:08,298 [salt.state       :1770][INFO    ][2988] Running state [mdb03.mcp-pike-odl-ha.local] at time 05:36:08.298857
2018-10-14 05:36:08,299 [salt.state       :1803][INFO    ][2988] Executing state host.present for [mdb03.mcp-pike-odl-ha.local]
2018-10-14 05:36:08,301 [salt.state       :290 ][INFO    ][2988] {'host': 'mdb03.mcp-pike-odl-ha.local'}
2018-10-14 05:36:08,302 [salt.state       :1941][INFO    ][2988] Completed state [mdb03.mcp-pike-odl-ha.local] at time 05:36:08.302140 duration_in_ms=3.283
2018-10-14 05:36:08,302 [salt.state       :1770][INFO    ][2988] Running state [mdb01] at time 05:36:08.302495
2018-10-14 05:36:08,302 [salt.state       :1803][INFO    ][2988] Executing state host.present for [mdb01]
2018-10-14 05:36:08,303 [salt.state       :290 ][INFO    ][2988] {'host': 'mdb01'}
2018-10-14 05:36:08,303 [salt.state       :1941][INFO    ][2988] Completed state [mdb01] at time 05:36:08.303922 duration_in_ms=1.427
2018-10-14 05:36:08,304 [salt.state       :1770][INFO    ][2988] Running state [mdb01.mcp-pike-odl-ha.local] at time 05:36:08.304241
2018-10-14 05:36:08,305 [salt.state       :1803][INFO    ][2988] Executing state host.present for [mdb01.mcp-pike-odl-ha.local]
2018-10-14 05:36:08,306 [salt.state       :290 ][INFO    ][2988] {'host': 'mdb01.mcp-pike-odl-ha.local'}
2018-10-14 05:36:08,306 [salt.state       :1941][INFO    ][2988] Completed state [mdb01.mcp-pike-odl-ha.local] at time 05:36:08.306633 duration_in_ms=2.392
2018-10-14 05:36:08,307 [salt.state       :1770][INFO    ][2988] Running state [mdb] at time 05:36:08.306980
2018-10-14 05:36:08,307 [salt.state       :1803][INFO    ][2988] Executing state host.present for [mdb]
2018-10-14 05:36:08,308 [salt.state       :290 ][INFO    ][2988] {'host': 'mdb'}
2018-10-14 05:36:08,309 [salt.state       :1941][INFO    ][2988] Completed state [mdb] at time 05:36:08.309184 duration_in_ms=2.203
2018-10-14 05:36:08,309 [salt.state       :1770][INFO    ][2988] Running state [mdb.mcp-pike-odl-ha.local] at time 05:36:08.309576
2018-10-14 05:36:08,309 [salt.state       :1803][INFO    ][2988] Executing state host.present for [mdb.mcp-pike-odl-ha.local]
2018-10-14 05:36:08,318 [salt.state       :290 ][INFO    ][2988] {'host': 'mdb.mcp-pike-odl-ha.local'}
2018-10-14 05:36:08,318 [salt.state       :1941][INFO    ][2988] Completed state [mdb.mcp-pike-odl-ha.local] at time 05:36:08.318872 duration_in_ms=9.297
2018-10-14 05:36:08,319 [salt.state       :1770][INFO    ][2988] Running state [cfg01] at time 05:36:08.319281
2018-10-14 05:36:08,319 [salt.state       :1803][INFO    ][2988] Executing state host.present for [cfg01]
2018-10-14 05:36:08,320 [salt.state       :290 ][INFO    ][2988] {'host': 'cfg01'}
2018-10-14 05:36:08,320 [salt.state       :1941][INFO    ][2988] Completed state [cfg01] at time 05:36:08.320778 duration_in_ms=1.496
2018-10-14 05:36:08,321 [salt.state       :1770][INFO    ][2988] Running state [cfg01.mcp-pike-odl-ha.local] at time 05:36:08.321153
2018-10-14 05:36:08,321 [salt.state       :1803][INFO    ][2988] Executing state host.present for [cfg01.mcp-pike-odl-ha.local]
2018-10-14 05:36:08,322 [salt.state       :290 ][INFO    ][2988] {'host': 'cfg01.mcp-pike-odl-ha.local'}
2018-10-14 05:36:08,322 [salt.state       :1941][INFO    ][2988] Completed state [cfg01.mcp-pike-odl-ha.local] at time 05:36:08.322581 duration_in_ms=1.428
2018-10-14 05:36:08,322 [salt.state       :1770][INFO    ][2988] Running state [prx01] at time 05:36:08.322923
2018-10-14 05:36:08,323 [salt.state       :1803][INFO    ][2988] Executing state host.present for [prx01]
2018-10-14 05:36:08,324 [salt.state       :290 ][INFO    ][2988] {'host': 'prx01'}
2018-10-14 05:36:08,325 [salt.state       :1941][INFO    ][2988] Completed state [prx01] at time 05:36:08.325483 duration_in_ms=2.56
2018-10-14 05:36:08,325 [salt.state       :1770][INFO    ][2988] Running state [prx01.mcp-pike-odl-ha.local] at time 05:36:08.325830
2018-10-14 05:36:08,326 [salt.state       :1803][INFO    ][2988] Executing state host.present for [prx01.mcp-pike-odl-ha.local]
2018-10-14 05:36:08,327 [salt.state       :290 ][INFO    ][2988] {'host': 'prx01.mcp-pike-odl-ha.local'}
2018-10-14 05:36:08,327 [salt.state       :1941][INFO    ][2988] Completed state [prx01.mcp-pike-odl-ha.local] at time 05:36:08.327302 duration_in_ms=1.471
2018-10-14 05:36:08,327 [salt.state       :1770][INFO    ][2988] Running state [kvm01] at time 05:36:08.327622
2018-10-14 05:36:08,327 [salt.state       :1803][INFO    ][2988] Executing state host.present for [kvm01]
2018-10-14 05:36:08,328 [salt.state       :290 ][INFO    ][2988] {'host': 'kvm01'}
2018-10-14 05:36:08,329 [salt.state       :1941][INFO    ][2988] Completed state [kvm01] at time 05:36:08.329109 duration_in_ms=1.487
2018-10-14 05:36:08,329 [salt.state       :1770][INFO    ][2988] Running state [kvm01.mcp-pike-odl-ha.local] at time 05:36:08.329430
2018-10-14 05:36:08,329 [salt.state       :1803][INFO    ][2988] Executing state host.present for [kvm01.mcp-pike-odl-ha.local]
2018-10-14 05:36:08,330 [salt.state       :290 ][INFO    ][2988] {'host': 'kvm01.mcp-pike-odl-ha.local'}
2018-10-14 05:36:08,330 [salt.state       :1941][INFO    ][2988] Completed state [kvm01.mcp-pike-odl-ha.local] at time 05:36:08.330874 duration_in_ms=1.444
2018-10-14 05:36:08,331 [salt.state       :1770][INFO    ][2988] Running state [kvm03] at time 05:36:08.331197
2018-10-14 05:36:08,331 [salt.state       :1803][INFO    ][2988] Executing state host.present for [kvm03]
2018-10-14 05:36:08,332 [salt.state       :290 ][INFO    ][2988] {'host': 'kvm03'}
2018-10-14 05:36:08,332 [salt.state       :1941][INFO    ][2988] Completed state [kvm03] at time 05:36:08.332647 duration_in_ms=1.45
2018-10-14 05:36:08,333 [salt.state       :1770][INFO    ][2988] Running state [kvm03.mcp-pike-odl-ha.local] at time 05:36:08.333010
2018-10-14 05:36:08,333 [salt.state       :1803][INFO    ][2988] Executing state host.present for [kvm03.mcp-pike-odl-ha.local]
2018-10-14 05:36:08,334 [salt.state       :290 ][INFO    ][2988] {'host': 'kvm03.mcp-pike-odl-ha.local'}
2018-10-14 05:36:08,334 [salt.state       :1941][INFO    ][2988] Completed state [kvm03.mcp-pike-odl-ha.local] at time 05:36:08.334478 duration_in_ms=1.468
2018-10-14 05:36:08,334 [salt.state       :1770][INFO    ][2988] Running state [kvm02] at time 05:36:08.334809
2018-10-14 05:36:08,335 [salt.state       :1803][INFO    ][2988] Executing state host.present for [kvm02]
2018-10-14 05:36:08,336 [salt.state       :290 ][INFO    ][2988] {'host': 'kvm02'}
2018-10-14 05:36:08,336 [salt.state       :1941][INFO    ][2988] Completed state [kvm02] at time 05:36:08.336281 duration_in_ms=1.472
2018-10-14 05:36:08,337 [salt.state       :1770][INFO    ][2988] Running state [kvm02.mcp-pike-odl-ha.local] at time 05:36:08.337211
2018-10-14 05:36:08,337 [salt.state       :1803][INFO    ][2988] Executing state host.present for [kvm02.mcp-pike-odl-ha.local]
2018-10-14 05:36:08,338 [salt.state       :290 ][INFO    ][2988] {'host': 'kvm02.mcp-pike-odl-ha.local'}
2018-10-14 05:36:08,338 [salt.state       :1941][INFO    ][2988] Completed state [kvm02.mcp-pike-odl-ha.local] at time 05:36:08.338686 duration_in_ms=1.474
2018-10-14 05:36:08,339 [salt.state       :1770][INFO    ][2988] Running state [dbs] at time 05:36:08.339025
2018-10-14 05:36:08,339 [salt.state       :1803][INFO    ][2988] Executing state host.present for [dbs]
2018-10-14 05:36:08,340 [salt.state       :290 ][INFO    ][2988] {'host': 'dbs'}
2018-10-14 05:36:08,340 [salt.state       :1941][INFO    ][2988] Completed state [dbs] at time 05:36:08.340806 duration_in_ms=1.782
2018-10-14 05:36:08,341 [salt.state       :1770][INFO    ][2988] Running state [dbs.mcp-pike-odl-ha.local] at time 05:36:08.341173
2018-10-14 05:36:08,341 [salt.state       :1803][INFO    ][2988] Executing state host.present for [dbs.mcp-pike-odl-ha.local]
2018-10-14 05:36:08,342 [salt.state       :290 ][INFO    ][2988] {'host': 'dbs.mcp-pike-odl-ha.local'}
2018-10-14 05:36:08,342 [salt.state       :1941][INFO    ][2988] Completed state [dbs.mcp-pike-odl-ha.local] at time 05:36:08.342665 duration_in_ms=1.492
2018-10-14 05:36:08,343 [salt.state       :1770][INFO    ][2988] Running state [prx] at time 05:36:08.343025
2018-10-14 05:36:08,343 [salt.state       :1803][INFO    ][2988] Executing state host.present for [prx]
2018-10-14 05:36:08,344 [salt.state       :290 ][INFO    ][2988] {'host': 'prx'}
2018-10-14 05:36:08,344 [salt.state       :1941][INFO    ][2988] Completed state [prx] at time 05:36:08.344855 duration_in_ms=1.83
2018-10-14 05:36:08,345 [salt.state       :1770][INFO    ][2988] Running state [prx.mcp-pike-odl-ha.local] at time 05:36:08.345190
2018-10-14 05:36:08,345 [salt.state       :1803][INFO    ][2988] Executing state host.present for [prx.mcp-pike-odl-ha.local]
2018-10-14 05:36:08,346 [salt.state       :290 ][INFO    ][2988] {'host': 'prx.mcp-pike-odl-ha.local'}
2018-10-14 05:36:08,346 [salt.state       :1941][INFO    ][2988] Completed state [prx.mcp-pike-odl-ha.local] at time 05:36:08.346693 duration_in_ms=1.503
2018-10-14 05:36:08,347 [salt.state       :1770][INFO    ][2988] Running state [prx02] at time 05:36:08.347038
2018-10-14 05:36:08,347 [salt.state       :1803][INFO    ][2988] Executing state host.present for [prx02]
2018-10-14 05:36:08,348 [salt.state       :290 ][INFO    ][2988] {'host': 'prx02'}
2018-10-14 05:36:08,349 [salt.state       :1941][INFO    ][2988] Completed state [prx02] at time 05:36:08.349027 duration_in_ms=1.988
2018-10-14 05:36:08,349 [salt.state       :1770][INFO    ][2988] Running state [prx02.mcp-pike-odl-ha.local] at time 05:36:08.349363
2018-10-14 05:36:08,349 [salt.state       :1803][INFO    ][2988] Executing state host.present for [prx02.mcp-pike-odl-ha.local]
2018-10-14 05:36:08,350 [salt.state       :290 ][INFO    ][2988] {'host': 'prx02.mcp-pike-odl-ha.local'}
2018-10-14 05:36:08,350 [salt.state       :1941][INFO    ][2988] Completed state [prx02.mcp-pike-odl-ha.local] at time 05:36:08.350878 duration_in_ms=1.515
2018-10-14 05:36:08,351 [salt.state       :1770][INFO    ][2988] Running state [msg02] at time 05:36:08.351227
2018-10-14 05:36:08,351 [salt.state       :1803][INFO    ][2988] Executing state host.present for [msg02]
2018-10-14 05:36:08,352 [salt.state       :290 ][INFO    ][2988] {'host': 'msg02'}
2018-10-14 05:36:08,352 [salt.state       :1941][INFO    ][2988] Completed state [msg02] at time 05:36:08.352761 duration_in_ms=1.534
2018-10-14 05:36:08,353 [salt.state       :1770][INFO    ][2988] Running state [msg02.mcp-pike-odl-ha.local] at time 05:36:08.353129
2018-10-14 05:36:08,353 [salt.state       :1803][INFO    ][2988] Executing state host.present for [msg02.mcp-pike-odl-ha.local]
2018-10-14 05:36:08,354 [salt.state       :290 ][INFO    ][2988] {'host': 'msg02.mcp-pike-odl-ha.local'}
2018-10-14 05:36:08,354 [salt.state       :1941][INFO    ][2988] Completed state [msg02.mcp-pike-odl-ha.local] at time 05:36:08.354646 duration_in_ms=1.517
2018-10-14 05:36:08,355 [salt.state       :1770][INFO    ][2988] Running state [msg03] at time 05:36:08.355002
2018-10-14 05:36:08,355 [salt.state       :1803][INFO    ][2988] Executing state host.present for [msg03]
2018-10-14 05:36:08,356 [salt.state       :290 ][INFO    ][2988] {'host': 'msg03'}
2018-10-14 05:36:08,356 [salt.state       :1941][INFO    ][2988] Completed state [msg03] at time 05:36:08.356859 duration_in_ms=1.857
2018-10-14 05:36:08,357 [salt.state       :1770][INFO    ][2988] Running state [msg03.mcp-pike-odl-ha.local] at time 05:36:08.357196
2018-10-14 05:36:08,357 [salt.state       :1803][INFO    ][2988] Executing state host.present for [msg03.mcp-pike-odl-ha.local]
2018-10-14 05:36:08,358 [salt.state       :290 ][INFO    ][2988] {'host': 'msg03.mcp-pike-odl-ha.local'}
2018-10-14 05:36:08,358 [salt.state       :1941][INFO    ][2988] Completed state [msg03.mcp-pike-odl-ha.local] at time 05:36:08.358730 duration_in_ms=1.534
2018-10-14 05:36:08,359 [salt.state       :1770][INFO    ][2988] Running state [msg01] at time 05:36:08.359082
2018-10-14 05:36:08,359 [salt.state       :1803][INFO    ][2988] Executing state host.present for [msg01]
2018-10-14 05:36:08,360 [salt.state       :290 ][INFO    ][2988] {'host': 'msg01'}
2018-10-14 05:36:08,360 [salt.state       :1941][INFO    ][2988] Completed state [msg01] at time 05:36:08.360656 duration_in_ms=1.574
2018-10-14 05:36:08,361 [salt.state       :1770][INFO    ][2988] Running state [msg01.mcp-pike-odl-ha.local] at time 05:36:08.361025
2018-10-14 05:36:08,361 [salt.state       :1803][INFO    ][2988] Executing state host.present for [msg01.mcp-pike-odl-ha.local]
2018-10-14 05:36:08,362 [salt.state       :290 ][INFO    ][2988] {'host': 'msg01.mcp-pike-odl-ha.local'}
2018-10-14 05:36:08,362 [salt.state       :1941][INFO    ][2988] Completed state [msg01.mcp-pike-odl-ha.local] at time 05:36:08.362573 duration_in_ms=1.548
2018-10-14 05:36:08,362 [salt.state       :1770][INFO    ][2988] Running state [msg] at time 05:36:08.362929
2018-10-14 05:36:08,363 [salt.state       :1803][INFO    ][2988] Executing state host.present for [msg]
2018-10-14 05:36:08,364 [salt.state       :290 ][INFO    ][2988] {'host': 'msg'}
2018-10-14 05:36:08,364 [salt.state       :1941][INFO    ][2988] Completed state [msg] at time 05:36:08.364503 duration_in_ms=1.574
2018-10-14 05:36:08,364 [salt.state       :1770][INFO    ][2988] Running state [msg.mcp-pike-odl-ha.local] at time 05:36:08.364868
2018-10-14 05:36:08,365 [salt.state       :1803][INFO    ][2988] Executing state host.present for [msg.mcp-pike-odl-ha.local]
2018-10-14 05:36:08,366 [salt.state       :290 ][INFO    ][2988] {'host': 'msg.mcp-pike-odl-ha.local'}
2018-10-14 05:36:08,366 [salt.state       :1941][INFO    ][2988] Completed state [msg.mcp-pike-odl-ha.local] at time 05:36:08.366436 duration_in_ms=1.568
2018-10-14 05:36:08,366 [salt.state       :1770][INFO    ][2988] Running state [cfg01] at time 05:36:08.366794
2018-10-14 05:36:08,367 [salt.state       :1803][INFO    ][2988] Executing state host.present for [cfg01]
2018-10-14 05:36:08,367 [salt.state       :290 ][INFO    ][2988] Host cfg01 (192.168.10.11) already present
2018-10-14 05:36:08,367 [salt.state       :1941][INFO    ][2988] Completed state [cfg01] at time 05:36:08.367723 duration_in_ms=0.929
2018-10-14 05:36:08,368 [salt.state       :1770][INFO    ][2988] Running state [cfg01.mcp-pike-odl-ha.local] at time 05:36:08.368057
2018-10-14 05:36:08,368 [salt.state       :1803][INFO    ][2988] Executing state host.present for [cfg01.mcp-pike-odl-ha.local]
2018-10-14 05:36:08,368 [salt.state       :290 ][INFO    ][2988] Host cfg01.mcp-pike-odl-ha.local (192.168.10.11) already present
2018-10-14 05:36:08,369 [salt.state       :1941][INFO    ][2988] Completed state [cfg01.mcp-pike-odl-ha.local] at time 05:36:08.369012 duration_in_ms=0.956
2018-10-14 05:36:08,369 [salt.state       :1770][INFO    ][2988] Running state [cmp002] at time 05:36:08.369347
2018-10-14 05:36:08,369 [salt.state       :1803][INFO    ][2988] Executing state host.present for [cmp002]
2018-10-14 05:36:08,370 [salt.state       :290 ][INFO    ][2988] {'host': 'cmp002'}
2018-10-14 05:36:08,371 [salt.state       :1941][INFO    ][2988] Completed state [cmp002] at time 05:36:08.371043 duration_in_ms=1.695
2018-10-14 05:36:08,371 [salt.state       :1770][INFO    ][2988] Running state [cmp002.mcp-pike-odl-ha.local] at time 05:36:08.371407
2018-10-14 05:36:08,371 [salt.state       :1803][INFO    ][2988] Executing state host.present for [cmp002.mcp-pike-odl-ha.local]
2018-10-14 05:36:08,372 [salt.state       :290 ][INFO    ][2988] {'host': 'cmp002.mcp-pike-odl-ha.local'}
2018-10-14 05:36:08,373 [salt.state       :1941][INFO    ][2988] Completed state [cmp002.mcp-pike-odl-ha.local] at time 05:36:08.373058 duration_in_ms=1.651
2018-10-14 05:36:08,373 [salt.state       :1770][INFO    ][2988] Running state [cmp001] at time 05:36:08.373407
2018-10-14 05:36:08,373 [salt.state       :1803][INFO    ][2988] Executing state host.present for [cmp001]
2018-10-14 05:36:08,374 [salt.state       :290 ][INFO    ][2988] {'host': 'cmp001'}
2018-10-14 05:36:08,375 [salt.state       :1941][INFO    ][2988] Completed state [cmp001] at time 05:36:08.374983 duration_in_ms=1.577
2018-10-14 05:36:08,375 [salt.state       :1770][INFO    ][2988] Running state [cmp001.mcp-pike-odl-ha.local] at time 05:36:08.375345
2018-10-14 05:36:08,375 [salt.state       :1803][INFO    ][2988] Executing state host.present for [cmp001.mcp-pike-odl-ha.local]
2018-10-14 05:36:08,377 [salt.state       :290 ][INFO    ][2988] {'host': 'cmp001.mcp-pike-odl-ha.local'}
2018-10-14 05:36:08,377 [salt.state       :1941][INFO    ][2988] Completed state [cmp001.mcp-pike-odl-ha.local] at time 05:36:08.377273 duration_in_ms=1.928
2018-10-14 05:36:08,377 [salt.state       :1770][INFO    ][2988] Running state [dbs01] at time 05:36:08.377641
2018-10-14 05:36:08,377 [salt.state       :1803][INFO    ][2988] Executing state host.present for [dbs01]
2018-10-14 05:36:08,379 [salt.state       :290 ][INFO    ][2988] {'host': 'dbs01'}
2018-10-14 05:36:08,379 [salt.state       :1941][INFO    ][2988] Completed state [dbs01] at time 05:36:08.379233 duration_in_ms=1.592
2018-10-14 05:36:08,379 [salt.state       :1770][INFO    ][2988] Running state [dbs01.mcp-pike-odl-ha.local] at time 05:36:08.379600
2018-10-14 05:36:08,379 [salt.state       :1803][INFO    ][2988] Executing state host.present for [dbs01.mcp-pike-odl-ha.local]
2018-10-14 05:36:08,381 [salt.state       :290 ][INFO    ][2988] {'host': 'dbs01.mcp-pike-odl-ha.local'}
2018-10-14 05:36:08,381 [salt.state       :1941][INFO    ][2988] Completed state [dbs01.mcp-pike-odl-ha.local] at time 05:36:08.381235 duration_in_ms=1.635
2018-10-14 05:36:08,381 [salt.state       :1770][INFO    ][2988] Running state [dbs02] at time 05:36:08.381599
2018-10-14 05:36:08,381 [salt.state       :1803][INFO    ][2988] Executing state host.present for [dbs02]
2018-10-14 05:36:08,383 [salt.state       :290 ][INFO    ][2988] {'host': 'dbs02'}
2018-10-14 05:36:08,383 [salt.state       :1941][INFO    ][2988] Completed state [dbs02] at time 05:36:08.383221 duration_in_ms=1.622
2018-10-14 05:36:08,383 [salt.state       :1770][INFO    ][2988] Running state [dbs02.mcp-pike-odl-ha.local] at time 05:36:08.383580
2018-10-14 05:36:08,383 [salt.state       :1803][INFO    ][2988] Executing state host.present for [dbs02.mcp-pike-odl-ha.local]
2018-10-14 05:36:08,385 [salt.state       :290 ][INFO    ][2988] {'host': 'dbs02.mcp-pike-odl-ha.local'}
2018-10-14 05:36:08,386 [salt.state       :1941][INFO    ][2988] Completed state [dbs02.mcp-pike-odl-ha.local] at time 05:36:08.386107 duration_in_ms=2.527
2018-10-14 05:36:08,386 [salt.state       :1770][INFO    ][2988] Running state [dbs03] at time 05:36:08.386475
2018-10-14 05:36:08,386 [salt.state       :1803][INFO    ][2988] Executing state host.present for [dbs03]
2018-10-14 05:36:08,387 [salt.state       :290 ][INFO    ][2988] {'host': 'dbs03'}
2018-10-14 05:36:08,388 [salt.state       :1941][INFO    ][2988] Completed state [dbs03] at time 05:36:08.388110 duration_in_ms=1.635
2018-10-14 05:36:08,388 [salt.state       :1770][INFO    ][2988] Running state [dbs03.mcp-pike-odl-ha.local] at time 05:36:08.388769
2018-10-14 05:36:08,389 [salt.state       :1803][INFO    ][2988] Executing state host.present for [dbs03.mcp-pike-odl-ha.local]
2018-10-14 05:36:08,390 [salt.state       :290 ][INFO    ][2988] {'host': 'dbs03.mcp-pike-odl-ha.local'}
2018-10-14 05:36:08,390 [salt.state       :1941][INFO    ][2988] Completed state [dbs03.mcp-pike-odl-ha.local] at time 05:36:08.390568 duration_in_ms=1.799
2018-10-14 05:36:08,390 [salt.state       :1770][INFO    ][2988] Running state [odl01] at time 05:36:08.390938
2018-10-14 05:36:08,391 [salt.state       :1803][INFO    ][2988] Executing state host.present for [odl01]
2018-10-14 05:36:08,392 [salt.state       :290 ][INFO    ][2988] {'host': 'odl01'}
2018-10-14 05:36:08,392 [salt.state       :1941][INFO    ][2988] Completed state [odl01] at time 05:36:08.392586 duration_in_ms=1.648
2018-10-14 05:36:08,393 [salt.state       :1770][INFO    ][2988] Running state [odl01.mcp-pike-odl-ha.local] at time 05:36:08.392965
2018-10-14 05:36:08,393 [salt.state       :1803][INFO    ][2988] Executing state host.present for [odl01.mcp-pike-odl-ha.local]
2018-10-14 05:36:08,394 [salt.state       :290 ][INFO    ][2988] {'host': 'odl01.mcp-pike-odl-ha.local'}
2018-10-14 05:36:08,394 [salt.state       :1941][INFO    ][2988] Completed state [odl01.mcp-pike-odl-ha.local] at time 05:36:08.394607 duration_in_ms=1.642
2018-10-14 05:36:08,395 [salt.state       :1770][INFO    ][2988] Running state [mas01] at time 05:36:08.394978
2018-10-14 05:36:08,395 [salt.state       :1803][INFO    ][2988] Executing state host.present for [mas01]
2018-10-14 05:36:08,397 [salt.state       :290 ][INFO    ][2988] {'host': 'mas01'}
2018-10-14 05:36:08,397 [salt.state       :1941][INFO    ][2988] Completed state [mas01] at time 05:36:08.397247 duration_in_ms=2.269
2018-10-14 05:36:08,397 [salt.state       :1770][INFO    ][2988] Running state [mas01.mcp-pike-odl-ha.local] at time 05:36:08.397605
2018-10-14 05:36:08,397 [salt.state       :1803][INFO    ][2988] Executing state host.present for [mas01.mcp-pike-odl-ha.local]
2018-10-14 05:36:08,399 [salt.state       :290 ][INFO    ][2988] {'host': 'mas01.mcp-pike-odl-ha.local'}
2018-10-14 05:36:08,399 [salt.state       :1941][INFO    ][2988] Completed state [mas01.mcp-pike-odl-ha.local] at time 05:36:08.399270 duration_in_ms=1.665
2018-10-14 05:36:08,399 [salt.state       :1770][INFO    ][2988] Running state [ctl02] at time 05:36:08.399643
2018-10-14 05:36:08,399 [salt.state       :1803][INFO    ][2988] Executing state host.present for [ctl02]
2018-10-14 05:36:08,401 [salt.state       :290 ][INFO    ][2988] {'host': 'ctl02'}
2018-10-14 05:36:08,401 [salt.state       :1941][INFO    ][2988] Completed state [ctl02] at time 05:36:08.401649 duration_in_ms=2.006
2018-10-14 05:36:08,402 [salt.state       :1770][INFO    ][2988] Running state [ctl02.mcp-pike-odl-ha.local] at time 05:36:08.402023
2018-10-14 05:36:08,402 [salt.state       :1803][INFO    ][2988] Executing state host.present for [ctl02.mcp-pike-odl-ha.local]
2018-10-14 05:36:08,403 [salt.state       :290 ][INFO    ][2988] {'host': 'ctl02.mcp-pike-odl-ha.local'}
2018-10-14 05:36:08,403 [salt.state       :1941][INFO    ][2988] Completed state [ctl02.mcp-pike-odl-ha.local] at time 05:36:08.403693 duration_in_ms=1.67
2018-10-14 05:36:08,404 [salt.state       :1770][INFO    ][2988] Running state [ctl03] at time 05:36:08.404067
2018-10-14 05:36:08,404 [salt.state       :1803][INFO    ][2988] Executing state host.present for [ctl03]
2018-10-14 05:36:08,405 [salt.state       :290 ][INFO    ][2988] {'host': 'ctl03'}
2018-10-14 05:36:08,406 [salt.state       :1941][INFO    ][2988] Completed state [ctl03] at time 05:36:08.406076 duration_in_ms=2.009
2018-10-14 05:36:08,406 [salt.state       :1770][INFO    ][2988] Running state [ctl03.mcp-pike-odl-ha.local] at time 05:36:08.406453
2018-10-14 05:36:08,406 [salt.state       :1803][INFO    ][2988] Executing state host.present for [ctl03.mcp-pike-odl-ha.local]
2018-10-14 05:36:08,408 [salt.state       :290 ][INFO    ][2988] {'host': 'ctl03.mcp-pike-odl-ha.local'}
2018-10-14 05:36:08,409 [salt.state       :1941][INFO    ][2988] Completed state [ctl03.mcp-pike-odl-ha.local] at time 05:36:08.408262 duration_in_ms=1.809
2018-10-14 05:36:08,409 [salt.state       :1770][INFO    ][2988] Running state [ctl01] at time 05:36:08.409527
2018-10-14 05:36:08,409 [salt.state       :1803][INFO    ][2988] Executing state host.present for [ctl01]
2018-10-14 05:36:08,411 [salt.state       :290 ][INFO    ][2988] {'host': 'ctl01'}
2018-10-14 05:36:08,411 [salt.state       :1941][INFO    ][2988] Completed state [ctl01] at time 05:36:08.411218 duration_in_ms=1.691
2018-10-14 05:36:08,411 [salt.state       :1770][INFO    ][2988] Running state [ctl01.mcp-pike-odl-ha.local] at time 05:36:08.411593
2018-10-14 05:36:08,411 [salt.state       :1803][INFO    ][2988] Executing state host.present for [ctl01.mcp-pike-odl-ha.local]
2018-10-14 05:36:08,413 [salt.state       :290 ][INFO    ][2988] {'host': 'ctl01.mcp-pike-odl-ha.local'}
2018-10-14 05:36:08,413 [salt.state       :1941][INFO    ][2988] Completed state [ctl01.mcp-pike-odl-ha.local] at time 05:36:08.413323 duration_in_ms=1.73
2018-10-14 05:36:08,413 [salt.state       :1770][INFO    ][2988] Running state [ctl] at time 05:36:08.413699
2018-10-14 05:36:08,413 [salt.state       :1803][INFO    ][2988] Executing state host.present for [ctl]
2018-10-14 05:36:08,415 [salt.state       :290 ][INFO    ][2988] {'host': 'ctl'}
2018-10-14 05:36:08,415 [salt.state       :1941][INFO    ][2988] Completed state [ctl] at time 05:36:08.415398 duration_in_ms=1.699
2018-10-14 05:36:08,415 [salt.state       :1770][INFO    ][2988] Running state [ctl.mcp-pike-odl-ha.local] at time 05:36:08.415774
2018-10-14 05:36:08,416 [salt.state       :1803][INFO    ][2988] Executing state host.present for [ctl.mcp-pike-odl-ha.local]
2018-10-14 05:36:08,417 [salt.state       :290 ][INFO    ][2988] {'host': 'ctl.mcp-pike-odl-ha.local'}
2018-10-14 05:36:08,417 [salt.state       :1941][INFO    ][2988] Completed state [ctl.mcp-pike-odl-ha.local] at time 05:36:08.417530 duration_in_ms=1.755
2018-10-14 05:36:08,417 [salt.state       :1770][INFO    ][2988] Running state [/etc/network/interfaces.d/50-cloud-init.cfg] at time 05:36:08.417799
2018-10-14 05:36:08,418 [salt.state       :1803][INFO    ][2988] Executing state file.absent for [/etc/network/interfaces.d/50-cloud-init.cfg]
2018-10-14 05:36:08,418 [salt.state       :290 ][INFO    ][2988] {'removed': '/etc/network/interfaces.d/50-cloud-init.cfg'}
2018-10-14 05:36:08,418 [salt.state       :1941][INFO    ][2988] Completed state [/etc/network/interfaces.d/50-cloud-init.cfg] at time 05:36:08.418815 duration_in_ms=1.016
2018-10-14 05:36:08,419 [salt.state       :1770][INFO    ][2988] Running state [ens2] at time 05:36:08.419600
2018-10-14 05:36:08,419 [salt.state       :1803][INFO    ][2988] Executing state network.managed for [ens2]
2018-10-14 05:36:08,581 [salt.loaded.int.module.cmdmod:395 ][INFO    ][2988] Executing command ['ifdown', 'ens2'] in directory '/root'
2018-10-14 05:36:09,774 [salt.loaded.int.module.cmdmod:395 ][INFO    ][2988] Executing command ['ifup', 'ens2'] in directory '/root'
2018-10-14 05:36:11,141 [salt.state       :290 ][INFO    ][2988] {'interface': 'Added network interface.', 'status': 'Interface ens2 restart to validate'}
2018-10-14 05:36:11,142 [salt.state       :1941][INFO    ][2988] Completed state [ens2] at time 05:36:11.142125 duration_in_ms=2722.524
2018-10-14 05:36:11,142 [salt.state       :1770][INFO    ][2988] Running state [ens3] at time 05:36:11.142595
2018-10-14 05:36:11,142 [salt.state       :1803][INFO    ][2988] Executing state network.managed for [ens3]
2018-10-14 05:36:11,176 [salt.loaded.int.module.cmdmod:395 ][INFO    ][2988] Executing command ['ifup', 'ens3'] in directory '/root'
2018-10-14 05:36:11,897 [salt.state       :290 ][INFO    ][2988] {'interface': 'Added network interface.', 'status': 'Interface ens3 is up'}
2018-10-14 05:36:11,898 [salt.state       :1941][INFO    ][2988] Completed state [ens3] at time 05:36:11.898475 duration_in_ms=755.878
2018-10-14 05:36:11,899 [salt.state       :1770][INFO    ][2988] Running state [/etc/profile.d/proxy.sh] at time 05:36:11.899080
2018-10-14 05:36:11,899 [salt.state       :1803][INFO    ][2988] Executing state file.absent for [/etc/profile.d/proxy.sh]
2018-10-14 05:36:11,900 [salt.state       :290 ][INFO    ][2988] File /etc/profile.d/proxy.sh is not present
2018-10-14 05:36:11,901 [salt.state       :1941][INFO    ][2988] Completed state [/etc/profile.d/proxy.sh] at time 05:36:11.901178 duration_in_ms=2.098
2018-10-14 05:36:11,901 [salt.state       :1770][INFO    ][2988] Running state [/etc/apt/apt.conf.d/95proxies] at time 05:36:11.901666
2018-10-14 05:36:11,902 [salt.state       :1803][INFO    ][2988] Executing state file.absent for [/etc/apt/apt.conf.d/95proxies]
2018-10-14 05:36:11,902 [salt.state       :290 ][INFO    ][2988] File /etc/apt/apt.conf.d/95proxies is not present
2018-10-14 05:36:11,903 [salt.state       :1941][INFO    ][2988] Completed state [/etc/apt/apt.conf.d/95proxies] at time 05:36:11.903154 duration_in_ms=1.489
2018-10-14 05:36:11,904 [salt.state       :1770][INFO    ][2988] Running state [ntp] at time 05:36:11.904800
2018-10-14 05:36:11,905 [salt.state       :1803][INFO    ][2988] Executing state pkg.installed for [ntp]
2018-10-14 05:36:12,164 [salt.loaded.int.module.cmdmod:395 ][INFO    ][2988] Executing command ['dpkg', '--get-selections', '*'] in directory '/root'
2018-10-14 05:36:12,191 [salt.loaded.int.module.cmdmod:395 ][INFO    ][2988] 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-14 05:36:15,989 [salt.loaded.int.module.cmdmod:395 ][INFO    ][2988] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}', '-W'] in directory '/root'
2018-10-14 05:36:16,035 [salt.state       :290 ][INFO    ][2988] 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-14 05:36:16,061 [salt.state       :905 ][INFO    ][2988] Loading fresh modules for state activity
2018-10-14 05:36:16,109 [salt.state       :1941][INFO    ][2988] Completed state [ntp] at time 05:36:16.109341 duration_in_ms=4204.54
2018-10-14 05:36:16,115 [salt.state       :1770][INFO    ][2988] Running state [/etc/ntp.conf] at time 05:36:16.115741
2018-10-14 05:36:16,116 [salt.state       :1803][INFO    ][2988] Executing state file.managed for [/etc/ntp.conf]
2018-10-14 05:36:16,162 [salt.fileclient  :1215][INFO    ][2988] Fetching file from saltenv 'base', ** done ** 'ntp/files/ntp.conf'
2018-10-14 05:36:16,250 [salt.state       :290 ][INFO    ][2988] 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-14 05:36:16,251 [salt.state       :1941][INFO    ][2988] Completed state [/etc/ntp.conf] at time 05:36:16.251104 duration_in_ms=135.362
2018-10-14 05:36:16,921 [salt.state       :1770][INFO    ][2988] Running state [ntp] at time 05:36:16.921358
2018-10-14 05:36:16,921 [salt.state       :1803][INFO    ][2988] Executing state service.running for [ntp]
2018-10-14 05:36:16,922 [salt.loaded.int.module.cmdmod:395 ][INFO    ][2988] Executing command ['systemctl', 'status', 'ntp.service', '-n', '0'] in directory '/root'
2018-10-14 05:36:16,941 [salt.loaded.int.module.cmdmod:395 ][INFO    ][2988] Executing command ['systemctl', 'is-active', 'ntp.service'] in directory '/root'
2018-10-14 05:36:16,959 [salt.loaded.int.module.cmdmod:395 ][INFO    ][2988] Executing command ['systemctl', 'is-enabled', 'ntp.service'] in directory '/root'
2018-10-14 05:36:16,979 [salt.state       :290 ][INFO    ][2988] The service ntp is already running
2018-10-14 05:36:16,980 [salt.state       :1941][INFO    ][2988] Completed state [ntp] at time 05:36:16.980072 duration_in_ms=58.714
2018-10-14 05:36:16,981 [salt.state       :1770][INFO    ][2988] Running state [ntp] at time 05:36:16.981044
2018-10-14 05:36:16,981 [salt.state       :1803][INFO    ][2988] Executing state service.mod_watch for [ntp]
2018-10-14 05:36:16,982 [salt.loaded.int.module.cmdmod:395 ][INFO    ][2988] Executing command ['systemctl', 'is-active', 'ntp.service'] in directory '/root'
2018-10-14 05:36:17,000 [salt.loaded.int.module.cmdmod:395 ][INFO    ][2988] Executing command ['systemd-run', '--scope', 'systemctl', 'restart', 'ntp.service'] in directory '/root'
2018-10-14 05:36:17,090 [salt.state       :290 ][INFO    ][2988] {'ntp': True}
2018-10-14 05:36:17,090 [salt.state       :1941][INFO    ][2988] Completed state [ntp] at time 05:36:17.090846 duration_in_ms=109.802
2018-10-14 05:36:17,098 [salt.minion      :1708][INFO    ][2988] Returning information for job: 20181014053536849187
2018-10-14 05:36:34,523 [salt.minion      :1307][INFO    ][2899] User sudo_ubuntu Executing command state.apply with jid 20181014053634511899
2018-10-14 05:36:34,548 [salt.minion      :1431][INFO    ][6395] Starting a new job with PID 6395
2018-10-14 05:36:39,296 [salt.state       :905 ][INFO    ][6395] Loading fresh modules for state activity
2018-10-14 05:36:44,218 [salt.state       :1770][INFO    ][6395] Running state [/etc/environment] at time 05:36:44.218750
2018-10-14 05:36:44,219 [salt.state       :1803][INFO    ][6395] Executing state file.blockreplace for [/etc/environment]
2018-10-14 05:36:44,227 [salt.state       :290 ][INFO    ][6395] No changes needed to be made
2018-10-14 05:36:44,228 [salt.state       :1941][INFO    ][6395] Completed state [/etc/environment] at time 05:36:44.228516 duration_in_ms=9.766
2018-10-14 05:36:44,229 [salt.state       :1770][INFO    ][6395] Running state [/etc/profile.d] at time 05:36:44.229039
2018-10-14 05:36:44,229 [salt.state       :1803][INFO    ][6395] Executing state file.directory for [/etc/profile.d]
2018-10-14 05:36:44,231 [salt.state       :290 ][INFO    ][6395] Directory /etc/profile.d is in the correct state
Directory /etc/profile.d updated
2018-10-14 05:36:44,232 [salt.state       :1941][INFO    ][6395] Completed state [/etc/profile.d] at time 05:36:44.232063 duration_in_ms=3.023
2018-10-14 05:36:44,233 [salt.state       :1770][INFO    ][6395] Running state [fake_linux_system_at] at time 05:36:44.233089
2018-10-14 05:36:44,233 [salt.state       :1803][INFO    ][6395] Executing state test.nop for [fake_linux_system_at]
2018-10-14 05:36:44,234 [salt.state       :290 ][INFO    ][6395] Success!
2018-10-14 05:36:44,234 [salt.state       :1941][INFO    ][6395] Completed state [fake_linux_system_at] at time 05:36:44.234478 duration_in_ms=1.389
2018-10-14 05:36:44,234 [salt.state       :1770][INFO    ][6395] Running state [fake_linux_system_cron] at time 05:36:44.234942
2018-10-14 05:36:44,235 [salt.state       :1803][INFO    ][6395] Executing state test.nop for [fake_linux_system_cron]
2018-10-14 05:36:44,235 [salt.state       :290 ][INFO    ][6395] Success!
2018-10-14 05:36:44,236 [salt.state       :1941][INFO    ][6395] Completed state [fake_linux_system_cron] at time 05:36:44.236256 duration_in_ms=1.314
2018-10-14 05:36:44,584 [salt.minion      :1307][INFO    ][2899] User sudo_ubuntu Executing command saltutil.find_job with jid 20181014053644577210
2018-10-14 05:36:44,613 [salt.minion      :1431][INFO    ][6474] Starting a new job with PID 6474
2018-10-14 05:36:44,633 [salt.minion      :1708][INFO    ][6474] Returning information for job: 20181014053644577210
2018-10-14 05:36:45,021 [salt.state       :1770][INFO    ][6395] Running state [/etc/apt/apt.conf.d/99prefer_ipv4-salt] at time 05:36:45.021158
2018-10-14 05:36:45,021 [salt.state       :1803][INFO    ][6395] Executing state file.managed for [/etc/apt/apt.conf.d/99prefer_ipv4-salt]
2018-10-14 05:36:45,061 [salt.state       :290 ][INFO    ][6395] File /etc/apt/apt.conf.d/99prefer_ipv4-salt is in the correct state
2018-10-14 05:36:45,062 [salt.state       :1941][INFO    ][6395] Completed state [/etc/apt/apt.conf.d/99prefer_ipv4-salt] at time 05:36:45.061933 duration_in_ms=40.776
2018-10-14 05:36:45,062 [salt.state       :1770][INFO    ][6395] Running state [/etc/apt/apt.conf.d/99allow_downgrades-salt] at time 05:36:45.062223
2018-10-14 05:36:45,062 [salt.state       :1803][INFO    ][6395] Executing state file.managed for [/etc/apt/apt.conf.d/99allow_downgrades-salt]
2018-10-14 05:36:45,088 [salt.state       :290 ][INFO    ][6395] File /etc/apt/apt.conf.d/99allow_downgrades-salt is in the correct state
2018-10-14 05:36:45,089 [salt.state       :1941][INFO    ][6395] Completed state [/etc/apt/apt.conf.d/99allow_downgrades-salt] at time 05:36:45.089716 duration_in_ms=27.492
2018-10-14 05:36:45,091 [salt.state       :1770][INFO    ][6395] Running state [linux_repo_prereq_pkgs] at time 05:36:45.091383
2018-10-14 05:36:45,091 [salt.state       :1803][INFO    ][6395] Executing state pkg.installed for [linux_repo_prereq_pkgs]
2018-10-14 05:36:45,092 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6395] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}', '-W'] in directory '/root'
2018-10-14 05:36:45,563 [salt.state       :290 ][INFO    ][6395] All specified packages are already installed
2018-10-14 05:36:45,563 [salt.state       :1941][INFO    ][6395] Completed state [linux_repo_prereq_pkgs] at time 05:36:45.563785 duration_in_ms=472.401
2018-10-14 05:36:45,564 [salt.state       :1770][INFO    ][6395] Running state [/etc/apt/apt.conf.d/99proxies-salt] at time 05:36:45.564164
2018-10-14 05:36:45,564 [salt.state       :1803][INFO    ][6395] Executing state file.managed for [/etc/apt/apt.conf.d/99proxies-salt]
2018-10-14 05:36:45,594 [salt.state       :290 ][INFO    ][6395] File /etc/apt/apt.conf.d/99proxies-salt is in the correct state
2018-10-14 05:36:45,594 [salt.state       :1941][INFO    ][6395] Completed state [/etc/apt/apt.conf.d/99proxies-salt] at time 05:36:45.594273 duration_in_ms=30.107
2018-10-14 05:36:45,594 [salt.state       :1770][INFO    ][6395] Running state [/etc/apt/apt.conf.d/99proxies-salt-mk_openstack] at time 05:36:45.594549
2018-10-14 05:36:45,594 [salt.state       :1803][INFO    ][6395] Executing state file.absent for [/etc/apt/apt.conf.d/99proxies-salt-mk_openstack]
2018-10-14 05:36:45,595 [salt.state       :290 ][INFO    ][6395] File /etc/apt/apt.conf.d/99proxies-salt-mk_openstack is not present
2018-10-14 05:36:45,595 [salt.state       :1941][INFO    ][6395] Completed state [/etc/apt/apt.conf.d/99proxies-salt-mk_openstack] at time 05:36:45.595879 duration_in_ms=1.33
2018-10-14 05:36:45,596 [salt.state       :1770][INFO    ][6395] Running state [/etc/apt/preferences.d/mk_openstack] at time 05:36:45.596342
2018-10-14 05:36:45,596 [salt.state       :1803][INFO    ][6395] Executing state file.managed for [/etc/apt/preferences.d/mk_openstack]
2018-10-14 05:36:45,736 [salt.state       :290 ][INFO    ][6395] File /etc/apt/preferences.d/mk_openstack is in the correct state
2018-10-14 05:36:45,737 [salt.state       :1941][INFO    ][6395] Completed state [/etc/apt/preferences.d/mk_openstack] at time 05:36:45.737466 duration_in_ms=141.124
2018-10-14 05:36:45,741 [salt.state       :1770][INFO    ][6395] Running state [deb [arch=amd64] http://apt.mirantis.com/xenial/ nightly pike] at time 05:36:45.741781
2018-10-14 05:36:45,742 [salt.state       :1803][INFO    ][6395] Executing state pkgrepo.managed for [deb [arch=amd64] http://apt.mirantis.com/xenial/ nightly pike]
2018-10-14 05:36:45,797 [salt.state       :290 ][INFO    ][6395] Package repo 'deb [arch=amd64] http://apt.mirantis.com/xenial/ nightly pike' already configured
2018-10-14 05:36:45,797 [salt.state       :1941][INFO    ][6395] Completed state [deb [arch=amd64] http://apt.mirantis.com/xenial/ nightly pike] at time 05:36:45.797941 duration_in_ms=56.159
2018-10-14 05:36:45,798 [salt.state       :1770][INFO    ][6395] Running state [/etc/apt/apt.conf.d/99proxies-salt-uca-staging] at time 05:36:45.798428
2018-10-14 05:36:45,798 [salt.state       :1803][INFO    ][6395] Executing state file.absent for [/etc/apt/apt.conf.d/99proxies-salt-uca-staging]
2018-10-14 05:36:45,799 [salt.state       :290 ][INFO    ][6395] File /etc/apt/apt.conf.d/99proxies-salt-uca-staging is not present
2018-10-14 05:36:45,799 [salt.state       :1941][INFO    ][6395] Completed state [/etc/apt/apt.conf.d/99proxies-salt-uca-staging] at time 05:36:45.799888 duration_in_ms=1.46
2018-10-14 05:36:45,800 [salt.state       :1770][INFO    ][6395] Running state [/etc/apt/preferences.d/uca-staging] at time 05:36:45.800348
2018-10-14 05:36:45,800 [salt.state       :1803][INFO    ][6395] Executing state file.absent for [/etc/apt/preferences.d/uca-staging]
2018-10-14 05:36:45,801 [salt.state       :290 ][INFO    ][6395] File /etc/apt/preferences.d/uca-staging is not present
2018-10-14 05:36:45,801 [salt.state       :1941][INFO    ][6395] Completed state [/etc/apt/preferences.d/uca-staging] at time 05:36:45.801795 duration_in_ms=1.446
2018-10-14 05:36:45,808 [salt.state       :1770][INFO    ][6395] Running state [apt-key adv --keyserver keyserver.ubuntu.com --recv 9F68104E] at time 05:36:45.808295
2018-10-14 05:36:45,808 [salt.state       :1803][INFO    ][6395] Executing state cmd.run for [apt-key adv --keyserver keyserver.ubuntu.com --recv 9F68104E]
2018-10-14 05:36:45,810 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6395] Executing command 'test -e /etc/apt/sources.list.d/uca-staging.list' in directory '/root'
2018-10-14 05:36:45,826 [salt.state       :290 ][INFO    ][6395] unless execution succeeded
2018-10-14 05:36:45,827 [salt.state       :1941][INFO    ][6395] Completed state [apt-key adv --keyserver keyserver.ubuntu.com --recv 9F68104E] at time 05:36:45.827529 duration_in_ms=19.234
2018-10-14 05:36:45,832 [salt.state       :1770][INFO    ][6395] Running state [deb http://ppa.launchpad.net/ubuntu-cloud-archive/pike-staging/ubuntu xenial main] at time 05:36:45.832394
2018-10-14 05:36:45,833 [salt.state       :1803][INFO    ][6395] Executing state pkgrepo.managed for [deb http://ppa.launchpad.net/ubuntu-cloud-archive/pike-staging/ubuntu xenial main]
2018-10-14 05:36:45,884 [salt.state       :290 ][INFO    ][6395] Package repo 'deb http://ppa.launchpad.net/ubuntu-cloud-archive/pike-staging/ubuntu xenial main' already configured
2018-10-14 05:36:45,885 [salt.state       :1941][INFO    ][6395] Completed state [deb http://ppa.launchpad.net/ubuntu-cloud-archive/pike-staging/ubuntu xenial main] at time 05:36:45.885789 duration_in_ms=53.395
2018-10-14 05:36:45,886 [salt.state       :1770][INFO    ][6395] Running state [/etc/apt/apt.conf.d/99proxies-salt-mirantis_openstack] at time 05:36:45.886339
2018-10-14 05:36:45,886 [salt.state       :1803][INFO    ][6395] Executing state file.absent for [/etc/apt/apt.conf.d/99proxies-salt-mirantis_openstack]
2018-10-14 05:36:45,887 [salt.state       :290 ][INFO    ][6395] File /etc/apt/apt.conf.d/99proxies-salt-mirantis_openstack is not present
2018-10-14 05:36:45,888 [salt.state       :1941][INFO    ][6395] Completed state [/etc/apt/apt.conf.d/99proxies-salt-mirantis_openstack] at time 05:36:45.887969 duration_in_ms=1.629
2018-10-14 05:36:45,888 [salt.state       :1770][INFO    ][6395] Running state [/etc/apt/preferences.d/mirantis_openstack] at time 05:36:45.888444
2018-10-14 05:36:45,888 [salt.state       :1803][INFO    ][6395] Executing state file.managed for [/etc/apt/preferences.d/mirantis_openstack]
2018-10-14 05:36:46,039 [salt.state       :290 ][INFO    ][6395] File /etc/apt/preferences.d/mirantis_openstack is in the correct state
2018-10-14 05:36:46,040 [salt.state       :1941][INFO    ][6395] Completed state [/etc/apt/preferences.d/mirantis_openstack] at time 05:36:46.039963 duration_in_ms=151.518
2018-10-14 05:36:46,042 [salt.state       :1770][INFO    ][6395] Running state [deb http://mirror.fuel-infra.org/mcp-repos/pike/xenial pike main] at time 05:36:46.042609
2018-10-14 05:36:46,043 [salt.state       :1803][INFO    ][6395] Executing state pkgrepo.managed for [deb http://mirror.fuel-infra.org/mcp-repos/pike/xenial pike main]
2018-10-14 05:36:46,482 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6395] 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-14 05:36:46,708 [salt.state       :290 ][INFO    ][6395] Configured package repo 'deb http://mirror.fuel-infra.org/mcp-repos/pike/xenial pike main'
2018-10-14 05:36:46,710 [salt.state       :1941][INFO    ][6395] Completed state [deb http://mirror.fuel-infra.org/mcp-repos/pike/xenial pike main] at time 05:36:46.709999 duration_in_ms=667.39
2018-10-14 05:36:46,710 [salt.state       :1770][INFO    ][6395] Running state [/etc/apt/apt.conf.d/99proxies-salt-uca] at time 05:36:46.710635
2018-10-14 05:36:46,711 [salt.state       :1803][INFO    ][6395] Executing state file.absent for [/etc/apt/apt.conf.d/99proxies-salt-uca]
2018-10-14 05:36:46,712 [salt.state       :290 ][INFO    ][6395] File /etc/apt/apt.conf.d/99proxies-salt-uca is not present
2018-10-14 05:36:46,712 [salt.state       :1941][INFO    ][6395] Completed state [/etc/apt/apt.conf.d/99proxies-salt-uca] at time 05:36:46.712458 duration_in_ms=1.823
2018-10-14 05:36:46,713 [salt.state       :1770][INFO    ][6395] Running state [/etc/apt/preferences.d/uca] at time 05:36:46.712955
2018-10-14 05:36:46,713 [salt.state       :1803][INFO    ][6395] Executing state file.managed for [/etc/apt/preferences.d/uca]
2018-10-14 05:36:46,905 [salt.state       :290 ][INFO    ][6395] File /etc/apt/preferences.d/uca is in the correct state
2018-10-14 05:36:46,905 [salt.state       :1941][INFO    ][6395] Completed state [/etc/apt/preferences.d/uca] at time 05:36:46.905708 duration_in_ms=192.753
2018-10-14 05:36:46,910 [salt.state       :1770][INFO    ][6395] Running state [apt-key adv --keyserver keyserver.ubuntu.com --recv EC4926EA] at time 05:36:46.910429
2018-10-14 05:36:46,910 [salt.state       :1803][INFO    ][6395] Executing state cmd.run for [apt-key adv --keyserver keyserver.ubuntu.com --recv EC4926EA]
2018-10-14 05:36:46,911 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6395] Executing command 'test -e /etc/apt/sources.list.d/uca.list' in directory '/root'
2018-10-14 05:36:46,928 [salt.state       :290 ][INFO    ][6395] unless execution succeeded
2018-10-14 05:36:46,929 [salt.state       :1941][INFO    ][6395] Completed state [apt-key adv --keyserver keyserver.ubuntu.com --recv EC4926EA] at time 05:36:46.928943 duration_in_ms=18.514
2018-10-14 05:36:46,932 [salt.state       :1770][INFO    ][6395] Running state [deb http://ubuntu-cloud.archive.canonical.com/ubuntu xenial-updates/pike main] at time 05:36:46.932790
2018-10-14 05:36:46,934 [salt.state       :1803][INFO    ][6395] Executing state pkgrepo.managed for [deb http://ubuntu-cloud.archive.canonical.com/ubuntu xenial-updates/pike main]
2018-10-14 05:36:46,987 [salt.state       :290 ][INFO    ][6395] Package repo 'deb http://ubuntu-cloud.archive.canonical.com/ubuntu xenial-updates/pike main' already configured
2018-10-14 05:36:46,987 [salt.state       :1941][INFO    ][6395] Completed state [deb http://ubuntu-cloud.archive.canonical.com/ubuntu xenial-updates/pike main] at time 05:36:46.987397 duration_in_ms=54.607
2018-10-14 05:36:46,988 [salt.state       :1770][INFO    ][6395] Running state [pkg.refresh_db] at time 05:36:46.988718
2018-10-14 05:36:46,989 [salt.state       :1803][INFO    ][6395] Executing state module.run for [pkg.refresh_db]
2018-10-14 05:36:46,989 [salt.utils.decorators:613 ][WARNING ][6395] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2018-10-14 05:36:46,990 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6395] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2018-10-14 05:36:51,211 [salt.state       :290 ][INFO    ][6395] {'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-14 05:36:51,212 [salt.state       :1941][INFO    ][6395] Completed state [pkg.refresh_db] at time 05:36:51.212139 duration_in_ms=4223.42
2018-10-14 05:36:51,214 [salt.state       :1770][INFO    ][6395] Running state [UTC] at time 05:36:51.214403
2018-10-14 05:36:51,214 [salt.state       :1803][INFO    ][6395] Executing state timezone.system for [UTC]
2018-10-14 05:36:51,216 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6395] Executing command ['timedatectl'] in directory '/root'
2018-10-14 05:36:51,250 [salt.state       :290 ][INFO    ][6395] Timezone UTC already set, UTC already set to UTC
2018-10-14 05:36:51,250 [salt.state       :1941][INFO    ][6395] Completed state [UTC] at time 05:36:51.250454 duration_in_ms=36.051
2018-10-14 05:36:51,250 [salt.state       :1770][INFO    ][6395] Running state [/etc/default/grub.d] at time 05:36:51.250919
2018-10-14 05:36:51,251 [salt.state       :1803][INFO    ][6395] Executing state file.directory for [/etc/default/grub.d]
2018-10-14 05:36:51,252 [salt.state       :290 ][INFO    ][6395] Directory /etc/default/grub.d is in the correct state
Directory /etc/default/grub.d updated
2018-10-14 05:36:51,253 [salt.state       :1941][INFO    ][6395] Completed state [/etc/default/grub.d] at time 05:36:51.253582 duration_in_ms=2.663
2018-10-14 05:36:51,253 [salt.state       :1770][INFO    ][6395] Running state [update-grub] at time 05:36:51.253847
2018-10-14 05:36:51,254 [salt.state       :1803][INFO    ][6395] Executing state cmd.wait for [update-grub]
2018-10-14 05:36:51,254 [salt.state       :290 ][INFO    ][6395] No changes made for update-grub
2018-10-14 05:36:51,254 [salt.state       :1941][INFO    ][6395] Completed state [update-grub] at time 05:36:51.254619 duration_in_ms=0.773
2018-10-14 05:36:51,256 [salt.state       :1770][INFO    ][6395] Running state [/boot/grub/grub.cfg] at time 05:36:51.256641
2018-10-14 05:36:51,257 [salt.state       :1803][INFO    ][6395] Executing state file.managed for [/boot/grub/grub.cfg]
2018-10-14 05:36:51,370 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6395] Executing command ['git', '--version'] in directory '/root'
2018-10-14 05:36:51,563 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6395] Executing command 'test -f /boot/grub/grub.cfg' in directory '/root'
2018-10-14 05:36:51,580 [salt.loaded.int.states.file:2150][WARNING ][6395] 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-14 05:36:51,581 [salt.state       :290 ][INFO    ][6395] File /boot/grub/grub.cfg exists with proper permissions. No changes made.
2018-10-14 05:36:51,582 [salt.state       :1941][INFO    ][6395] Completed state [/boot/grub/grub.cfg] at time 05:36:51.582198 duration_in_ms=325.556
2018-10-14 05:36:51,582 [salt.state       :1770][INFO    ][6395] Running state [nf_conntrack] at time 05:36:51.582650
2018-10-14 05:36:51,583 [salt.state       :1803][INFO    ][6395] Executing state kmod.present for [nf_conntrack]
2018-10-14 05:36:51,583 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6395] Executing command 'lsmod' in directory '/root'
2018-10-14 05:36:51,607 [salt.state       :290 ][INFO    ][6395] Kernel module nf_conntrack is already present
2018-10-14 05:36:51,608 [salt.state       :1941][INFO    ][6395] Completed state [nf_conntrack] at time 05:36:51.608016 duration_in_ms=25.366
2018-10-14 05:36:51,608 [salt.state       :1770][INFO    ][6395] Running state [kernel.panic] at time 05:36:51.608423
2018-10-14 05:36:51,608 [salt.state       :1803][INFO    ][6395] Executing state sysctl.present for [kernel.panic]
2018-10-14 05:36:51,626 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6395] Executing command 'sysctl -n kernel.panic' in directory '/root'
2018-10-14 05:36:51,640 [salt.state       :290 ][INFO    ][6395] Sysctl value kernel.panic = 60 is already set
2018-10-14 05:36:51,641 [salt.state       :1941][INFO    ][6395] Completed state [kernel.panic] at time 05:36:51.640729 duration_in_ms=32.306
2018-10-14 05:36:51,641 [salt.state       :1770][INFO    ][6395] Running state [net.ipv4.tcp_keepalive_probes] at time 05:36:51.641853
2018-10-14 05:36:51,642 [salt.state       :1803][INFO    ][6395] Executing state sysctl.present for [net.ipv4.tcp_keepalive_probes]
2018-10-14 05:36:51,643 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6395] Executing command 'sysctl -n net.ipv4.tcp_keepalive_probes' in directory '/root'
2018-10-14 05:36:51,658 [salt.state       :290 ][INFO    ][6395] Sysctl value net.ipv4.tcp_keepalive_probes = 8 is already set
2018-10-14 05:36:51,659 [salt.state       :1941][INFO    ][6395] Completed state [net.ipv4.tcp_keepalive_probes] at time 05:36:51.659294 duration_in_ms=17.442
2018-10-14 05:36:51,659 [salt.state       :1770][INFO    ][6395] Running state [fs.file-max] at time 05:36:51.659893
2018-10-14 05:36:51,660 [salt.state       :1803][INFO    ][6395] Executing state sysctl.present for [fs.file-max]
2018-10-14 05:36:51,661 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6395] Executing command 'sysctl -n fs.file-max' in directory '/root'
2018-10-14 05:36:51,679 [salt.state       :290 ][INFO    ][6395] Sysctl value fs.file-max = 124165 is already set
2018-10-14 05:36:51,680 [salt.state       :1941][INFO    ][6395] Completed state [fs.file-max] at time 05:36:51.680275 duration_in_ms=20.381
2018-10-14 05:36:51,681 [salt.state       :1770][INFO    ][6395] Running state [net.core.somaxconn] at time 05:36:51.681213
2018-10-14 05:36:51,681 [salt.state       :1803][INFO    ][6395] Executing state sysctl.present for [net.core.somaxconn]
2018-10-14 05:36:51,683 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6395] Executing command 'sysctl -n net.core.somaxconn' in directory '/root'
2018-10-14 05:36:51,698 [salt.state       :290 ][INFO    ][6395] Sysctl value net.core.somaxconn = 4096 is already set
2018-10-14 05:36:51,699 [salt.state       :1941][INFO    ][6395] Completed state [net.core.somaxconn] at time 05:36:51.699278 duration_in_ms=18.064
2018-10-14 05:36:51,699 [salt.state       :1770][INFO    ][6395] Running state [net.ipv4.tcp_max_syn_backlog] at time 05:36:51.699708
2018-10-14 05:36:51,700 [salt.state       :1803][INFO    ][6395] Executing state sysctl.present for [net.ipv4.tcp_max_syn_backlog]
2018-10-14 05:36:51,701 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6395] Executing command 'sysctl -n net.ipv4.tcp_max_syn_backlog' in directory '/root'
2018-10-14 05:36:51,715 [salt.state       :290 ][INFO    ][6395] Sysctl value net.ipv4.tcp_max_syn_backlog = 8192 is already set
2018-10-14 05:36:51,716 [salt.state       :1941][INFO    ][6395] Completed state [net.ipv4.tcp_max_syn_backlog] at time 05:36:51.716489 duration_in_ms=16.78
2018-10-14 05:36:51,717 [salt.state       :1770][INFO    ][6395] Running state [net.ipv4.tcp_tw_reuse] at time 05:36:51.717460
2018-10-14 05:36:51,718 [salt.state       :1803][INFO    ][6395] Executing state sysctl.present for [net.ipv4.tcp_tw_reuse]
2018-10-14 05:36:51,719 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6395] Executing command 'sysctl -n net.ipv4.tcp_tw_reuse' in directory '/root'
2018-10-14 05:36:51,735 [salt.state       :290 ][INFO    ][6395] Sysctl value net.ipv4.tcp_tw_reuse = 1 is already set
2018-10-14 05:36:51,735 [salt.state       :1941][INFO    ][6395] Completed state [net.ipv4.tcp_tw_reuse] at time 05:36:51.735581 duration_in_ms=18.122
2018-10-14 05:36:51,736 [salt.state       :1770][INFO    ][6395] Running state [net.ipv4.tcp_congestion_control] at time 05:36:51.736010
2018-10-14 05:36:51,736 [salt.state       :1803][INFO    ][6395] Executing state sysctl.present for [net.ipv4.tcp_congestion_control]
2018-10-14 05:36:51,737 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6395] Executing command 'sysctl -n net.ipv4.tcp_congestion_control' in directory '/root'
2018-10-14 05:36:51,753 [salt.state       :290 ][INFO    ][6395] Sysctl value net.ipv4.tcp_congestion_control = yeah is already set
2018-10-14 05:36:51,754 [salt.state       :1941][INFO    ][6395] Completed state [net.ipv4.tcp_congestion_control] at time 05:36:51.754522 duration_in_ms=18.51
2018-10-14 05:36:51,755 [salt.state       :1770][INFO    ][6395] Running state [net.ipv4.tcp_retries2] at time 05:36:51.755310
2018-10-14 05:36:51,756 [salt.state       :1803][INFO    ][6395] Executing state sysctl.present for [net.ipv4.tcp_retries2]
2018-10-14 05:36:51,757 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6395] Executing command 'sysctl -n net.ipv4.tcp_retries2' in directory '/root'
2018-10-14 05:36:51,773 [salt.state       :290 ][INFO    ][6395] Sysctl value net.ipv4.tcp_retries2 = 5 is already set
2018-10-14 05:36:51,774 [salt.state       :1941][INFO    ][6395] Completed state [net.ipv4.tcp_retries2] at time 05:36:51.774601 duration_in_ms=19.29
2018-10-14 05:36:51,775 [salt.state       :1770][INFO    ][6395] Running state [net.core.netdev_max_backlog] at time 05:36:51.775341
2018-10-14 05:36:51,776 [salt.state       :1803][INFO    ][6395] Executing state sysctl.present for [net.core.netdev_max_backlog]
2018-10-14 05:36:51,777 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6395] Executing command 'sysctl -n net.core.netdev_max_backlog' in directory '/root'
2018-10-14 05:36:51,791 [salt.state       :290 ][INFO    ][6395] Sysctl value net.core.netdev_max_backlog = 261144 is already set
2018-10-14 05:36:51,791 [salt.state       :1941][INFO    ][6395] Completed state [net.core.netdev_max_backlog] at time 05:36:51.791662 duration_in_ms=16.321
2018-10-14 05:36:51,792 [salt.state       :1770][INFO    ][6395] Running state [net.ipv4.tcp_slow_start_after_idle] at time 05:36:51.792394
2018-10-14 05:36:51,793 [salt.state       :1803][INFO    ][6395] Executing state sysctl.present for [net.ipv4.tcp_slow_start_after_idle]
2018-10-14 05:36:51,794 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6395] Executing command 'sysctl -n net.ipv4.tcp_slow_start_after_idle' in directory '/root'
2018-10-14 05:36:51,808 [salt.state       :290 ][INFO    ][6395] Sysctl value net.ipv4.tcp_slow_start_after_idle = 0 is already set
2018-10-14 05:36:51,809 [salt.state       :1941][INFO    ][6395] Completed state [net.ipv4.tcp_slow_start_after_idle] at time 05:36:51.808784 duration_in_ms=16.389
2018-10-14 05:36:51,810 [salt.state       :1770][INFO    ][6395] Running state [vm.swappiness] at time 05:36:51.809943
2018-10-14 05:36:51,810 [salt.state       :1803][INFO    ][6395] Executing state sysctl.present for [vm.swappiness]
2018-10-14 05:36:51,811 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6395] Executing command 'sysctl -n vm.swappiness' in directory '/root'
2018-10-14 05:36:51,829 [salt.state       :290 ][INFO    ][6395] Sysctl value vm.swappiness = 10 is already set
2018-10-14 05:36:51,830 [salt.state       :1941][INFO    ][6395] Completed state [vm.swappiness] at time 05:36:51.830065 duration_in_ms=20.121
2018-10-14 05:36:51,831 [salt.state       :1770][INFO    ][6395] Running state [net.ipv4.tcp_keepalive_intvl] at time 05:36:51.830987
2018-10-14 05:36:51,831 [salt.state       :1803][INFO    ][6395] Executing state sysctl.present for [net.ipv4.tcp_keepalive_intvl]
2018-10-14 05:36:51,833 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6395] Executing command 'sysctl -n net.ipv4.tcp_keepalive_intvl' in directory '/root'
2018-10-14 05:36:51,854 [salt.state       :290 ][INFO    ][6395] Sysctl value net.ipv4.tcp_keepalive_intvl = 3 is already set
2018-10-14 05:36:51,855 [salt.state       :1941][INFO    ][6395] Completed state [net.ipv4.tcp_keepalive_intvl] at time 05:36:51.854943 duration_in_ms=23.956
2018-10-14 05:36:51,855 [salt.state       :1770][INFO    ][6395] Running state [net.ipv4.neigh.default.gc_thresh1] at time 05:36:51.855524
2018-10-14 05:36:51,856 [salt.state       :1803][INFO    ][6395] Executing state sysctl.present for [net.ipv4.neigh.default.gc_thresh1]
2018-10-14 05:36:51,857 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6395] Executing command 'sysctl -n net.ipv4.neigh.default.gc_thresh1' in directory '/root'
2018-10-14 05:36:51,873 [salt.state       :290 ][INFO    ][6395] Sysctl value net.ipv4.neigh.default.gc_thresh1 = 4096 is already set
2018-10-14 05:36:51,874 [salt.state       :1941][INFO    ][6395] Completed state [net.ipv4.neigh.default.gc_thresh1] at time 05:36:51.873951 duration_in_ms=18.426
2018-10-14 05:36:51,874 [salt.state       :1770][INFO    ][6395] Running state [net.ipv4.neigh.default.gc_thresh2] at time 05:36:51.874569
2018-10-14 05:36:51,875 [salt.state       :1803][INFO    ][6395] Executing state sysctl.present for [net.ipv4.neigh.default.gc_thresh2]
2018-10-14 05:36:51,876 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6395] Executing command 'sysctl -n net.ipv4.neigh.default.gc_thresh2' in directory '/root'
2018-10-14 05:36:51,895 [salt.state       :290 ][INFO    ][6395] Sysctl value net.ipv4.neigh.default.gc_thresh2 = 8192 is already set
2018-10-14 05:36:51,895 [salt.state       :1941][INFO    ][6395] Completed state [net.ipv4.neigh.default.gc_thresh2] at time 05:36:51.895695 duration_in_ms=21.126
2018-10-14 05:36:51,896 [salt.state       :1770][INFO    ][6395] Running state [net.ipv4.neigh.default.gc_thresh3] at time 05:36:51.896133
2018-10-14 05:36:51,896 [salt.state       :1803][INFO    ][6395] Executing state sysctl.present for [net.ipv4.neigh.default.gc_thresh3]
2018-10-14 05:36:51,898 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6395] Executing command 'sysctl -n net.ipv4.neigh.default.gc_thresh3' in directory '/root'
2018-10-14 05:36:51,915 [salt.state       :290 ][INFO    ][6395] Sysctl value net.ipv4.neigh.default.gc_thresh3 = 16384 is already set
2018-10-14 05:36:51,916 [salt.state       :1941][INFO    ][6395] Completed state [net.ipv4.neigh.default.gc_thresh3] at time 05:36:51.916172 duration_in_ms=20.039
2018-10-14 05:36:51,916 [salt.state       :1770][INFO    ][6395] Running state [net.ipv4.tcp_fin_timeout] at time 05:36:51.916593
2018-10-14 05:36:51,917 [salt.state       :1803][INFO    ][6395] Executing state sysctl.present for [net.ipv4.tcp_fin_timeout]
2018-10-14 05:36:51,919 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6395] Executing command 'sysctl -n net.ipv4.tcp_fin_timeout' in directory '/root'
2018-10-14 05:36:51,933 [salt.state       :290 ][INFO    ][6395] Sysctl value net.ipv4.tcp_fin_timeout = 30 is already set
2018-10-14 05:36:51,934 [salt.state       :1941][INFO    ][6395] Completed state [net.ipv4.tcp_fin_timeout] at time 05:36:51.934459 duration_in_ms=17.865
2018-10-14 05:36:51,935 [salt.state       :1770][INFO    ][6395] Running state [net.ipv4.tcp_keepalive_time] at time 05:36:51.935124
2018-10-14 05:36:51,935 [salt.state       :1803][INFO    ][6395] Executing state sysctl.present for [net.ipv4.tcp_keepalive_time]
2018-10-14 05:36:51,937 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6395] Executing command 'sysctl -n net.ipv4.tcp_keepalive_time' in directory '/root'
2018-10-14 05:36:51,952 [salt.state       :290 ][INFO    ][6395] Sysctl value net.ipv4.tcp_keepalive_time = 30 is already set
2018-10-14 05:36:51,952 [salt.state       :1941][INFO    ][6395] Completed state [net.ipv4.tcp_keepalive_time] at time 05:36:51.952516 duration_in_ms=17.393
2018-10-14 05:36:51,953 [salt.state       :1770][INFO    ][6395] Running state [net.nf_conntrack_max] at time 05:36:51.953562
2018-10-14 05:36:51,954 [salt.state       :1803][INFO    ][6395] Executing state sysctl.present for [net.nf_conntrack_max]
2018-10-14 05:36:51,955 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6395] Executing command 'sysctl -n net.nf_conntrack_max' in directory '/root'
2018-10-14 05:36:51,972 [salt.state       :290 ][INFO    ][6395] Sysctl value net.nf_conntrack_max = 1048576 is already set
2018-10-14 05:36:51,973 [salt.state       :1941][INFO    ][6395] Completed state [net.nf_conntrack_max] at time 05:36:51.973498 duration_in_ms=19.936
2018-10-14 05:36:51,974 [salt.state       :1770][INFO    ][6395] Running state [linux_sysfs_package] at time 05:36:51.973998
2018-10-14 05:36:51,974 [salt.state       :1803][INFO    ][6395] Executing state pkg.installed for [linux_sysfs_package]
2018-10-14 05:36:51,989 [salt.state       :290 ][INFO    ][6395] All specified packages are already installed
2018-10-14 05:36:51,989 [salt.state       :1941][INFO    ][6395] Completed state [linux_sysfs_package] at time 05:36:51.989776 duration_in_ms=15.778
2018-10-14 05:36:51,991 [salt.state       :1770][INFO    ][6395] Running state [/etc/sysfs.d] at time 05:36:51.991748
2018-10-14 05:36:51,992 [salt.state       :1803][INFO    ][6395] Executing state file.directory for [/etc/sysfs.d]
2018-10-14 05:36:51,993 [salt.state       :290 ][INFO    ][6395] Directory /etc/sysfs.d is in the correct state
Directory /etc/sysfs.d updated
2018-10-14 05:36:51,993 [salt.state       :1941][INFO    ][6395] Completed state [/etc/sysfs.d] at time 05:36:51.993326 duration_in_ms=1.578
2018-10-14 05:36:51,993 [salt.state       :1770][INFO    ][6395] Running state [ondemand] at time 05:36:51.993575
2018-10-14 05:36:51,993 [salt.state       :1803][INFO    ][6395] Executing state service.dead for [ondemand]
2018-10-14 05:36:51,994 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6395] Executing command ['systemctl', 'status', 'ondemand.service', '-n', '0'] in directory '/root'
2018-10-14 05:36:52,014 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6395] Executing command ['systemctl', 'is-active', 'ondemand.service'] in directory '/root'
2018-10-14 05:36:52,029 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6395] Executing command ['systemctl', 'is-enabled', 'ondemand.service'] in directory '/root'
2018-10-14 05:36:52,059 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6395] Executing command 'runlevel' in directory '/root'
2018-10-14 05:36:52,075 [salt.state       :290 ][INFO    ][6395] The service ondemand is already dead
2018-10-14 05:36:52,075 [salt.state       :1941][INFO    ][6395] Completed state [ondemand] at time 05:36:52.075814 duration_in_ms=82.239
2018-10-14 05:36:52,076 [salt.state       :1770][INFO    ][6395] Running state [cs_CZ.UTF-8] at time 05:36:52.076277
2018-10-14 05:36:52,076 [salt.state       :1803][INFO    ][6395] Executing state locale.present for [cs_CZ.UTF-8]
2018-10-14 05:36:52,077 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6395] Executing command 'locale -a' in directory '/root'
2018-10-14 05:36:52,094 [salt.state       :290 ][INFO    ][6395] Locale cs_CZ.UTF-8 is already present
2018-10-14 05:36:52,094 [salt.state       :1941][INFO    ][6395] Completed state [cs_CZ.UTF-8] at time 05:36:52.094839 duration_in_ms=18.562
2018-10-14 05:36:52,095 [salt.state       :1770][INFO    ][6395] Running state [en_US.UTF-8] at time 05:36:52.095274
2018-10-14 05:36:52,095 [salt.state       :1803][INFO    ][6395] Executing state locale.present for [en_US.UTF-8]
2018-10-14 05:36:52,096 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6395] Executing command 'locale -a' in directory '/root'
2018-10-14 05:36:52,109 [salt.state       :290 ][INFO    ][6395] Locale en_US.UTF-8 is already present
2018-10-14 05:36:52,110 [salt.state       :1941][INFO    ][6395] Completed state [en_US.UTF-8] at time 05:36:52.110546 duration_in_ms=15.271
2018-10-14 05:36:52,113 [salt.state       :1770][INFO    ][6395] Running state [en_US.UTF-8] at time 05:36:52.113939
2018-10-14 05:36:52,114 [salt.state       :1803][INFO    ][6395] Executing state locale.system for [en_US.UTF-8]
2018-10-14 05:36:52,115 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6395] Executing command 'localectl' in directory '/root'
2018-10-14 05:36:52,147 [salt.state       :290 ][INFO    ][6395] System locale en_US.UTF-8 already set
2018-10-14 05:36:52,148 [salt.state       :1941][INFO    ][6395] Completed state [en_US.UTF-8] at time 05:36:52.147954 duration_in_ms=34.014
2018-10-14 05:36:52,148 [salt.state       :1770][INFO    ][6395] Running state [root] at time 05:36:52.148798
2018-10-14 05:36:52,149 [salt.state       :1803][INFO    ][6395] Executing state group.present for [root]
2018-10-14 05:36:52,150 [salt.state       :290 ][INFO    ][6395] Group root is present and up to date
2018-10-14 05:36:52,150 [salt.state       :1941][INFO    ][6395] Completed state [root] at time 05:36:52.150837 duration_in_ms=2.039
2018-10-14 05:36:52,153 [salt.state       :1770][INFO    ][6395] Running state [root] at time 05:36:52.153824
2018-10-14 05:36:52,154 [salt.state       :1803][INFO    ][6395] Executing state user.present for [root]
2018-10-14 05:36:52,156 [salt.state       :290 ][INFO    ][6395] User root is present and up to date
2018-10-14 05:36:52,156 [salt.state       :1941][INFO    ][6395] Completed state [root] at time 05:36:52.156443 duration_in_ms=2.619
2018-10-14 05:36:52,158 [salt.state       :1770][INFO    ][6395] Running state [/root] at time 05:36:52.157958
2018-10-14 05:36:52,158 [salt.state       :1803][INFO    ][6395] Executing state file.directory for [/root]
2018-10-14 05:36:52,159 [salt.state       :290 ][INFO    ][6395] Directory /root is in the correct state
Directory /root updated
2018-10-14 05:36:52,160 [salt.state       :1941][INFO    ][6395] Completed state [/root] at time 05:36:52.160226 duration_in_ms=2.268
2018-10-14 05:36:52,160 [salt.state       :1770][INFO    ][6395] Running state [/etc/sudoers.d/90-salt-user-root] at time 05:36:52.160696
2018-10-14 05:36:52,161 [salt.state       :1803][INFO    ][6395] Executing state file.absent for [/etc/sudoers.d/90-salt-user-root]
2018-10-14 05:36:52,162 [salt.state       :290 ][INFO    ][6395] File /etc/sudoers.d/90-salt-user-root is not present
2018-10-14 05:36:52,162 [salt.state       :1941][INFO    ][6395] Completed state [/etc/sudoers.d/90-salt-user-root] at time 05:36:52.162561 duration_in_ms=1.865
2018-10-14 05:36:52,163 [salt.state       :1770][INFO    ][6395] Running state [ubuntu] at time 05:36:52.163016
2018-10-14 05:36:52,163 [salt.state       :1803][INFO    ][6395] Executing state group.present for [ubuntu]
2018-10-14 05:36:52,164 [salt.state       :290 ][INFO    ][6395] Group ubuntu is present and up to date
2018-10-14 05:36:52,164 [salt.state       :1941][INFO    ][6395] Completed state [ubuntu] at time 05:36:52.164441 duration_in_ms=1.425
2018-10-14 05:36:52,166 [salt.state       :1770][INFO    ][6395] Running state [ubuntu] at time 05:36:52.166055
2018-10-14 05:36:52,166 [salt.state       :1803][INFO    ][6395] Executing state user.present for [ubuntu]
2018-10-14 05:36:52,167 [salt.state       :290 ][INFO    ][6395] User ubuntu is present and up to date
2018-10-14 05:36:52,168 [salt.state       :1941][INFO    ][6395] Completed state [ubuntu] at time 05:36:52.168326 duration_in_ms=2.271
2018-10-14 05:36:52,170 [salt.state       :1770][INFO    ][6395] Running state [/home/ubuntu] at time 05:36:52.170164
2018-10-14 05:36:52,170 [salt.state       :1803][INFO    ][6395] Executing state file.directory for [/home/ubuntu]
2018-10-14 05:36:52,171 [salt.state       :290 ][INFO    ][6395] Directory /home/ubuntu is in the correct state
Directory /home/ubuntu updated
2018-10-14 05:36:52,172 [salt.state       :1941][INFO    ][6395] Completed state [/home/ubuntu] at time 05:36:52.172294 duration_in_ms=2.13
2018-10-14 05:36:52,173 [salt.state       :1770][INFO    ][6395] Running state [/etc/sudoers.d/90-salt-user-ubuntu] at time 05:36:52.173615
2018-10-14 05:36:52,174 [salt.state       :1803][INFO    ][6395] Executing state file.managed for [/etc/sudoers.d/90-salt-user-ubuntu]
2018-10-14 05:36:52,203 [salt.state       :290 ][INFO    ][6395] File /etc/sudoers.d/90-salt-user-ubuntu is in the correct state
2018-10-14 05:36:52,203 [salt.state       :1941][INFO    ][6395] Completed state [/etc/sudoers.d/90-salt-user-ubuntu] at time 05:36:52.203664 duration_in_ms=30.049
2018-10-14 05:36:52,204 [salt.state       :1770][INFO    ][6395] Running state [/etc/security/limits.d/90-salt-default.conf] at time 05:36:52.204161
2018-10-14 05:36:52,204 [salt.state       :1803][INFO    ][6395] Executing state file.managed for [/etc/security/limits.d/90-salt-default.conf]
2018-10-14 05:36:52,339 [salt.state       :290 ][INFO    ][6395] File /etc/security/limits.d/90-salt-default.conf is in the correct state
2018-10-14 05:36:52,339 [salt.state       :1941][INFO    ][6395] Completed state [/etc/security/limits.d/90-salt-default.conf] at time 05:36:52.339610 duration_in_ms=135.448
2018-10-14 05:36:52,340 [salt.state       :1770][INFO    ][6395] Running state [/etc/systemd/system.conf.d/90-salt.conf] at time 05:36:52.340138
2018-10-14 05:36:52,340 [salt.state       :1803][INFO    ][6395] Executing state file.managed for [/etc/systemd/system.conf.d/90-salt.conf]
2018-10-14 05:36:52,470 [salt.state       :290 ][INFO    ][6395] File /etc/systemd/system.conf.d/90-salt.conf is in the correct state
2018-10-14 05:36:52,471 [salt.state       :1941][INFO    ][6395] Completed state [/etc/systemd/system.conf.d/90-salt.conf] at time 05:36:52.471329 duration_in_ms=131.191
2018-10-14 05:36:52,472 [salt.state       :1770][INFO    ][6395] Running state [service.systemctl_reload] at time 05:36:52.472805
2018-10-14 05:36:52,473 [salt.state       :1803][INFO    ][6395] Executing state module.wait for [service.systemctl_reload]
2018-10-14 05:36:52,473 [salt.state       :290 ][INFO    ][6395] No changes made for service.systemctl_reload
2018-10-14 05:36:52,474 [salt.state       :1941][INFO    ][6395] Completed state [service.systemctl_reload] at time 05:36:52.474292 duration_in_ms=1.487
2018-10-14 05:36:52,474 [salt.state       :1770][INFO    ][6395] Running state [/etc/issue] at time 05:36:52.474792
2018-10-14 05:36:52,475 [salt.state       :1803][INFO    ][6395] Executing state file.managed for [/etc/issue]
2018-10-14 05:36:52,477 [salt.state       :290 ][INFO    ][6395] File /etc/issue is in the correct state
2018-10-14 05:36:52,477 [salt.state       :1941][INFO    ][6395] Completed state [/etc/issue] at time 05:36:52.477760 duration_in_ms=2.968
2018-10-14 05:36:52,478 [salt.state       :1770][INFO    ][6395] Running state [/etc/hostname] at time 05:36:52.478256
2018-10-14 05:36:52,478 [salt.state       :1803][INFO    ][6395] Executing state file.managed for [/etc/hostname]
2018-10-14 05:36:52,504 [salt.state       :290 ][INFO    ][6395] File /etc/hostname is in the correct state
2018-10-14 05:36:52,505 [salt.state       :1941][INFO    ][6395] Completed state [/etc/hostname] at time 05:36:52.505323 duration_in_ms=27.067
2018-10-14 05:36:52,506 [salt.state       :1770][INFO    ][6395] Running state [hostname msg03] at time 05:36:52.506623
2018-10-14 05:36:52,507 [salt.state       :1803][INFO    ][6395] Executing state cmd.run for [hostname msg03]
2018-10-14 05:36:52,508 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6395] Executing command 'test "$(hostname)" = "msg03"' in directory '/root'
2018-10-14 05:36:52,523 [salt.state       :290 ][INFO    ][6395] unless execution succeeded
2018-10-14 05:36:52,524 [salt.state       :1941][INFO    ][6395] Completed state [hostname msg03] at time 05:36:52.524344 duration_in_ms=17.721
2018-10-14 05:36:52,525 [salt.state       :1770][INFO    ][6395] Running state [mdb02] at time 05:36:52.525242
2018-10-14 05:36:52,525 [salt.state       :1803][INFO    ][6395] Executing state host.present for [mdb02]
2018-10-14 05:36:52,527 [salt.state       :290 ][INFO    ][6395] Host mdb02 (192.168.10.33) already present
2018-10-14 05:36:52,527 [salt.state       :1941][INFO    ][6395] Completed state [mdb02] at time 05:36:52.527459 duration_in_ms=2.217
2018-10-14 05:36:52,528 [salt.state       :1770][INFO    ][6395] Running state [mdb02.mcp-pike-odl-ha.local] at time 05:36:52.528003
2018-10-14 05:36:52,528 [salt.state       :1803][INFO    ][6395] Executing state host.present for [mdb02.mcp-pike-odl-ha.local]
2018-10-14 05:36:52,529 [salt.state       :290 ][INFO    ][6395] Host mdb02.mcp-pike-odl-ha.local (192.168.10.33) already present
2018-10-14 05:36:52,529 [salt.state       :1941][INFO    ][6395] Completed state [mdb02.mcp-pike-odl-ha.local] at time 05:36:52.529709 duration_in_ms=1.706
2018-10-14 05:36:52,530 [salt.state       :1770][INFO    ][6395] Running state [mdb03] at time 05:36:52.530248
2018-10-14 05:36:52,530 [salt.state       :1803][INFO    ][6395] Executing state host.present for [mdb03]
2018-10-14 05:36:52,531 [salt.state       :290 ][INFO    ][6395] Host mdb03 (192.168.10.34) already present
2018-10-14 05:36:52,531 [salt.state       :1941][INFO    ][6395] Completed state [mdb03] at time 05:36:52.531877 duration_in_ms=1.629
2018-10-14 05:36:52,532 [salt.state       :1770][INFO    ][6395] Running state [mdb03.mcp-pike-odl-ha.local] at time 05:36:52.532408
2018-10-14 05:36:52,532 [salt.state       :1803][INFO    ][6395] Executing state host.present for [mdb03.mcp-pike-odl-ha.local]
2018-10-14 05:36:52,533 [salt.state       :290 ][INFO    ][6395] Host mdb03.mcp-pike-odl-ha.local (192.168.10.34) already present
2018-10-14 05:36:52,534 [salt.state       :1941][INFO    ][6395] Completed state [mdb03.mcp-pike-odl-ha.local] at time 05:36:52.534066 duration_in_ms=1.658
2018-10-14 05:36:52,534 [salt.state       :1770][INFO    ][6395] Running state [mdb01] at time 05:36:52.534599
2018-10-14 05:36:52,535 [salt.state       :1803][INFO    ][6395] Executing state host.present for [mdb01]
2018-10-14 05:36:52,535 [salt.state       :290 ][INFO    ][6395] Host mdb01 (192.168.10.32) already present
2018-10-14 05:36:52,536 [salt.state       :1941][INFO    ][6395] Completed state [mdb01] at time 05:36:52.536227 duration_in_ms=1.628
2018-10-14 05:36:52,537 [salt.state       :1770][INFO    ][6395] Running state [mdb01.mcp-pike-odl-ha.local] at time 05:36:52.536762
2018-10-14 05:36:52,537 [salt.state       :1803][INFO    ][6395] Executing state host.present for [mdb01.mcp-pike-odl-ha.local]
2018-10-14 05:36:52,538 [salt.state       :290 ][INFO    ][6395] Host mdb01.mcp-pike-odl-ha.local (192.168.10.32) already present
2018-10-14 05:36:52,538 [salt.state       :1941][INFO    ][6395] Completed state [mdb01.mcp-pike-odl-ha.local] at time 05:36:52.538740 duration_in_ms=1.979
2018-10-14 05:36:52,539 [salt.state       :1770][INFO    ][6395] Running state [mdb] at time 05:36:52.539270
2018-10-14 05:36:52,539 [salt.state       :1803][INFO    ][6395] Executing state host.present for [mdb]
2018-10-14 05:36:52,540 [salt.state       :290 ][INFO    ][6395] Host mdb (192.168.10.31) already present
2018-10-14 05:36:52,541 [salt.state       :1941][INFO    ][6395] Completed state [mdb] at time 05:36:52.541530 duration_in_ms=2.26
2018-10-14 05:36:52,542 [salt.state       :1770][INFO    ][6395] Running state [mdb.mcp-pike-odl-ha.local] at time 05:36:52.541956
2018-10-14 05:36:52,542 [salt.state       :1803][INFO    ][6395] Executing state host.present for [mdb.mcp-pike-odl-ha.local]
2018-10-14 05:36:52,542 [salt.state       :290 ][INFO    ][6395] Host mdb.mcp-pike-odl-ha.local (192.168.10.31) already present
2018-10-14 05:36:52,543 [salt.state       :1941][INFO    ][6395] Completed state [mdb.mcp-pike-odl-ha.local] at time 05:36:52.543171 duration_in_ms=1.215
2018-10-14 05:36:52,543 [salt.state       :1770][INFO    ][6395] Running state [cfg01] at time 05:36:52.543490
2018-10-14 05:36:52,543 [salt.state       :1803][INFO    ][6395] Executing state host.present for [cfg01]
2018-10-14 05:36:52,547 [salt.state       :290 ][INFO    ][6395] Host cfg01 (192.168.10.11) already present
2018-10-14 05:36:52,547 [salt.state       :1941][INFO    ][6395] Completed state [cfg01] at time 05:36:52.547735 duration_in_ms=4.244
2018-10-14 05:36:52,548 [salt.state       :1770][INFO    ][6395] Running state [cfg01.mcp-pike-odl-ha.local] at time 05:36:52.548069
2018-10-14 05:36:52,548 [salt.state       :1803][INFO    ][6395] Executing state host.present for [cfg01.mcp-pike-odl-ha.local]
2018-10-14 05:36:52,549 [salt.state       :290 ][INFO    ][6395] Host cfg01.mcp-pike-odl-ha.local (192.168.10.11) already present
2018-10-14 05:36:52,549 [salt.state       :1941][INFO    ][6395] Completed state [cfg01.mcp-pike-odl-ha.local] at time 05:36:52.549547 duration_in_ms=1.478
2018-10-14 05:36:52,549 [salt.state       :1770][INFO    ][6395] Running state [prx01] at time 05:36:52.549866
2018-10-14 05:36:52,550 [salt.state       :1803][INFO    ][6395] Executing state host.present for [prx01]
2018-10-14 05:36:52,550 [salt.state       :290 ][INFO    ][6395] Host prx01 (192.168.10.14) already present
2018-10-14 05:36:52,550 [salt.state       :1941][INFO    ][6395] Completed state [prx01] at time 05:36:52.550845 duration_in_ms=0.979
2018-10-14 05:36:52,551 [salt.state       :1770][INFO    ][6395] Running state [prx01.mcp-pike-odl-ha.local] at time 05:36:52.551170
2018-10-14 05:36:52,551 [salt.state       :1803][INFO    ][6395] Executing state host.present for [prx01.mcp-pike-odl-ha.local]
2018-10-14 05:36:52,551 [salt.state       :290 ][INFO    ][6395] Host prx01.mcp-pike-odl-ha.local (192.168.10.14) already present
2018-10-14 05:36:52,552 [salt.state       :1941][INFO    ][6395] Completed state [prx01.mcp-pike-odl-ha.local] at time 05:36:52.552119 duration_in_ms=0.949
2018-10-14 05:36:52,552 [salt.state       :1770][INFO    ][6395] Running state [kvm01] at time 05:36:52.552434
2018-10-14 05:36:52,552 [salt.state       :1803][INFO    ][6395] Executing state host.present for [kvm01]
2018-10-14 05:36:52,553 [salt.state       :290 ][INFO    ][6395] Host kvm01 (192.168.10.20) already present
2018-10-14 05:36:52,553 [salt.state       :1941][INFO    ][6395] Completed state [kvm01] at time 05:36:52.553781 duration_in_ms=1.347
2018-10-14 05:36:52,554 [salt.state       :1770][INFO    ][6395] Running state [kvm01.mcp-pike-odl-ha.local] at time 05:36:52.554095
2018-10-14 05:36:52,554 [salt.state       :1803][INFO    ][6395] Executing state host.present for [kvm01.mcp-pike-odl-ha.local]
2018-10-14 05:36:52,554 [salt.state       :290 ][INFO    ][6395] Host kvm01.mcp-pike-odl-ha.local (192.168.10.20) already present
2018-10-14 05:36:52,555 [salt.state       :1941][INFO    ][6395] Completed state [kvm01.mcp-pike-odl-ha.local] at time 05:36:52.555039 duration_in_ms=0.944
2018-10-14 05:36:52,555 [salt.state       :1770][INFO    ][6395] Running state [kvm03] at time 05:36:52.555353
2018-10-14 05:36:52,555 [salt.state       :1803][INFO    ][6395] Executing state host.present for [kvm03]
2018-10-14 05:36:52,556 [salt.state       :290 ][INFO    ][6395] Host kvm03 (192.168.10.22) already present
2018-10-14 05:36:52,556 [salt.state       :1941][INFO    ][6395] Completed state [kvm03] at time 05:36:52.556290 duration_in_ms=0.938
2018-10-14 05:36:52,556 [salt.state       :1770][INFO    ][6395] Running state [kvm03.mcp-pike-odl-ha.local] at time 05:36:52.556603
2018-10-14 05:36:52,556 [salt.state       :1803][INFO    ][6395] Executing state host.present for [kvm03.mcp-pike-odl-ha.local]
2018-10-14 05:36:52,557 [salt.state       :290 ][INFO    ][6395] Host kvm03.mcp-pike-odl-ha.local (192.168.10.22) already present
2018-10-14 05:36:52,557 [salt.state       :1941][INFO    ][6395] Completed state [kvm03.mcp-pike-odl-ha.local] at time 05:36:52.557574 duration_in_ms=0.97
2018-10-14 05:36:52,557 [salt.state       :1770][INFO    ][6395] Running state [kvm02] at time 05:36:52.557891
2018-10-14 05:36:52,558 [salt.state       :1803][INFO    ][6395] Executing state host.present for [kvm02]
2018-10-14 05:36:52,558 [salt.state       :290 ][INFO    ][6395] Host kvm02 (192.168.10.21) already present
2018-10-14 05:36:52,558 [salt.state       :1941][INFO    ][6395] Completed state [kvm02] at time 05:36:52.558823 duration_in_ms=0.933
2018-10-14 05:36:52,559 [salt.state       :1770][INFO    ][6395] Running state [kvm02.mcp-pike-odl-ha.local] at time 05:36:52.559137
2018-10-14 05:36:52,559 [salt.state       :1803][INFO    ][6395] Executing state host.present for [kvm02.mcp-pike-odl-ha.local]
2018-10-14 05:36:52,559 [salt.state       :290 ][INFO    ][6395] Host kvm02.mcp-pike-odl-ha.local (192.168.10.21) already present
2018-10-14 05:36:52,560 [salt.state       :1941][INFO    ][6395] Completed state [kvm02.mcp-pike-odl-ha.local] at time 05:36:52.560072 duration_in_ms=0.933
2018-10-14 05:36:52,560 [salt.state       :1770][INFO    ][6395] Running state [dbs] at time 05:36:52.560395
2018-10-14 05:36:52,560 [salt.state       :1803][INFO    ][6395] Executing state host.present for [dbs]
2018-10-14 05:36:52,561 [salt.state       :290 ][INFO    ][6395] Host dbs (192.168.10.23) already present
2018-10-14 05:36:52,561 [salt.state       :1941][INFO    ][6395] Completed state [dbs] at time 05:36:52.561743 duration_in_ms=1.348
2018-10-14 05:36:52,562 [salt.state       :1770][INFO    ][6395] Running state [dbs.mcp-pike-odl-ha.local] at time 05:36:52.562060
2018-10-14 05:36:52,562 [salt.state       :1803][INFO    ][6395] Executing state host.present for [dbs.mcp-pike-odl-ha.local]
2018-10-14 05:36:52,562 [salt.state       :290 ][INFO    ][6395] Host dbs.mcp-pike-odl-ha.local (192.168.10.23) already present
2018-10-14 05:36:52,563 [salt.state       :1941][INFO    ][6395] Completed state [dbs.mcp-pike-odl-ha.local] at time 05:36:52.562990 duration_in_ms=0.93
2018-10-14 05:36:52,563 [salt.state       :1770][INFO    ][6395] Running state [prx] at time 05:36:52.563323
2018-10-14 05:36:52,563 [salt.state       :1803][INFO    ][6395] Executing state host.present for [prx]
2018-10-14 05:36:52,564 [salt.state       :290 ][INFO    ][6395] Host prx (192.168.10.13) already present
2018-10-14 05:36:52,564 [salt.state       :1941][INFO    ][6395] Completed state [prx] at time 05:36:52.564271 duration_in_ms=0.948
2018-10-14 05:36:52,564 [salt.state       :1770][INFO    ][6395] Running state [prx.mcp-pike-odl-ha.local] at time 05:36:52.564592
2018-10-14 05:36:52,564 [salt.state       :1803][INFO    ][6395] Executing state host.present for [prx.mcp-pike-odl-ha.local]
2018-10-14 05:36:52,565 [salt.state       :290 ][INFO    ][6395] Host prx.mcp-pike-odl-ha.local (192.168.10.13) already present
2018-10-14 05:36:52,565 [salt.state       :1941][INFO    ][6395] Completed state [prx.mcp-pike-odl-ha.local] at time 05:36:52.565582 duration_in_ms=0.99
2018-10-14 05:36:52,565 [salt.state       :1770][INFO    ][6395] Running state [prx02] at time 05:36:52.565909
2018-10-14 05:36:52,566 [salt.state       :1803][INFO    ][6395] Executing state host.present for [prx02]
2018-10-14 05:36:52,566 [salt.state       :290 ][INFO    ][6395] Host prx02 (192.168.10.15) already present
2018-10-14 05:36:52,566 [salt.state       :1941][INFO    ][6395] Completed state [prx02] at time 05:36:52.566847 duration_in_ms=0.938
2018-10-14 05:36:52,567 [salt.state       :1770][INFO    ][6395] Running state [prx02.mcp-pike-odl-ha.local] at time 05:36:52.567172
2018-10-14 05:36:52,567 [salt.state       :1803][INFO    ][6395] Executing state host.present for [prx02.mcp-pike-odl-ha.local]
2018-10-14 05:36:52,567 [salt.state       :290 ][INFO    ][6395] Host prx02.mcp-pike-odl-ha.local (192.168.10.15) already present
2018-10-14 05:36:52,568 [salt.state       :1941][INFO    ][6395] Completed state [prx02.mcp-pike-odl-ha.local] at time 05:36:52.568117 duration_in_ms=0.945
2018-10-14 05:36:52,568 [salt.state       :1770][INFO    ][6395] Running state [msg02] at time 05:36:52.568447
2018-10-14 05:36:52,568 [salt.state       :1803][INFO    ][6395] Executing state host.present for [msg02]
2018-10-14 05:36:52,569 [salt.state       :290 ][INFO    ][6395] Host msg02 (192.168.10.29) already present
2018-10-14 05:36:52,569 [salt.state       :1941][INFO    ][6395] Completed state [msg02] at time 05:36:52.569437 duration_in_ms=0.989
2018-10-14 05:36:52,569 [salt.state       :1770][INFO    ][6395] Running state [msg02.mcp-pike-odl-ha.local] at time 05:36:52.569760
2018-10-14 05:36:52,570 [salt.state       :1803][INFO    ][6395] Executing state host.present for [msg02.mcp-pike-odl-ha.local]
2018-10-14 05:36:52,570 [salt.state       :290 ][INFO    ][6395] Host msg02.mcp-pike-odl-ha.local (192.168.10.29) already present
2018-10-14 05:36:52,570 [salt.state       :1941][INFO    ][6395] Completed state [msg02.mcp-pike-odl-ha.local] at time 05:36:52.570722 duration_in_ms=0.962
2018-10-14 05:36:52,571 [salt.state       :1770][INFO    ][6395] Running state [msg03] at time 05:36:52.571047
2018-10-14 05:36:52,571 [salt.state       :1803][INFO    ][6395] Executing state host.present for [msg03]
2018-10-14 05:36:52,571 [salt.state       :290 ][INFO    ][6395] Host msg03 (192.168.10.30) already present
2018-10-14 05:36:52,572 [salt.state       :1941][INFO    ][6395] Completed state [msg03] at time 05:36:52.571990 duration_in_ms=0.943
2018-10-14 05:36:52,572 [salt.state       :1770][INFO    ][6395] Running state [msg03.mcp-pike-odl-ha.local] at time 05:36:52.572320
2018-10-14 05:36:52,572 [salt.state       :1803][INFO    ][6395] Executing state host.present for [msg03.mcp-pike-odl-ha.local]
2018-10-14 05:36:52,573 [salt.state       :290 ][INFO    ][6395] Host msg03.mcp-pike-odl-ha.local (192.168.10.30) already present
2018-10-14 05:36:52,573 [salt.state       :1941][INFO    ][6395] Completed state [msg03.mcp-pike-odl-ha.local] at time 05:36:52.573658 duration_in_ms=1.338
2018-10-14 05:36:52,575 [salt.state       :1770][INFO    ][6395] Running state [file.replace] at time 05:36:52.575414
2018-10-14 05:36:52,575 [salt.state       :1803][INFO    ][6395] Executing state module.run for [file.replace]
2018-10-14 05:36:52,582 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6395] Executing command 'grep -q "msg03 msg03.mcp-pike-odl-ha.local" /etc/hosts' in directory '/root'
2018-10-14 05:36:52,603 [salt.utils.decorators:613 ][WARNING ][6395] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2018-10-14 05:36:52,608 [salt.state       :290 ][INFO    ][6395] {'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-14 05:36:52,608 [salt.state       :1941][INFO    ][6395] Completed state [file.replace] at time 05:36:52.608389 duration_in_ms=32.975
2018-10-14 05:36:52,609 [salt.state       :1770][INFO    ][6395] Running state [msg01] at time 05:36:52.609027
2018-10-14 05:36:52,609 [salt.state       :1803][INFO    ][6395] Executing state host.present for [msg01]
2018-10-14 05:36:52,610 [salt.state       :290 ][INFO    ][6395] Host msg01 (192.168.10.28) already present
2018-10-14 05:36:52,610 [salt.state       :1941][INFO    ][6395] Completed state [msg01] at time 05:36:52.610235 duration_in_ms=1.208
2018-10-14 05:36:52,610 [salt.state       :1770][INFO    ][6395] Running state [msg01.mcp-pike-odl-ha.local] at time 05:36:52.610592
2018-10-14 05:36:52,610 [salt.state       :1803][INFO    ][6395] Executing state host.present for [msg01.mcp-pike-odl-ha.local]
2018-10-14 05:36:52,611 [salt.state       :290 ][INFO    ][6395] Host msg01.mcp-pike-odl-ha.local (192.168.10.28) already present
2018-10-14 05:36:52,611 [salt.state       :1941][INFO    ][6395] Completed state [msg01.mcp-pike-odl-ha.local] at time 05:36:52.611581 duration_in_ms=0.989
2018-10-14 05:36:52,611 [salt.state       :1770][INFO    ][6395] Running state [msg] at time 05:36:52.611928
2018-10-14 05:36:52,612 [salt.state       :1803][INFO    ][6395] Executing state host.present for [msg]
2018-10-14 05:36:52,612 [salt.state       :290 ][INFO    ][6395] Host msg (192.168.10.27) already present
2018-10-14 05:36:52,612 [salt.state       :1941][INFO    ][6395] Completed state [msg] at time 05:36:52.612940 duration_in_ms=1.012
2018-10-14 05:36:52,613 [salt.state       :1770][INFO    ][6395] Running state [msg.mcp-pike-odl-ha.local] at time 05:36:52.613280
2018-10-14 05:36:52,613 [salt.state       :1803][INFO    ][6395] Executing state host.present for [msg.mcp-pike-odl-ha.local]
2018-10-14 05:36:52,614 [salt.state       :290 ][INFO    ][6395] Host msg.mcp-pike-odl-ha.local (192.168.10.27) already present
2018-10-14 05:36:52,614 [salt.state       :1941][INFO    ][6395] Completed state [msg.mcp-pike-odl-ha.local] at time 05:36:52.614245 duration_in_ms=0.965
2018-10-14 05:36:52,614 [salt.state       :1770][INFO    ][6395] Running state [cfg01] at time 05:36:52.614586
2018-10-14 05:36:52,614 [salt.state       :1803][INFO    ][6395] Executing state host.present for [cfg01]
2018-10-14 05:36:52,615 [salt.state       :290 ][INFO    ][6395] Host cfg01 (192.168.10.11) already present
2018-10-14 05:36:52,615 [salt.state       :1941][INFO    ][6395] Completed state [cfg01] at time 05:36:52.615563 duration_in_ms=0.977
2018-10-14 05:36:52,615 [salt.state       :1770][INFO    ][6395] Running state [cfg01.mcp-pike-odl-ha.local] at time 05:36:52.615897
2018-10-14 05:36:52,616 [salt.state       :1803][INFO    ][6395] Executing state host.present for [cfg01.mcp-pike-odl-ha.local]
2018-10-14 05:36:52,616 [salt.state       :290 ][INFO    ][6395] Host cfg01.mcp-pike-odl-ha.local (192.168.10.11) already present
2018-10-14 05:36:52,616 [salt.state       :1941][INFO    ][6395] Completed state [cfg01.mcp-pike-odl-ha.local] at time 05:36:52.616910 duration_in_ms=1.013
2018-10-14 05:36:52,617 [salt.state       :1770][INFO    ][6395] Running state [cmp002] at time 05:36:52.617258
2018-10-14 05:36:52,617 [salt.state       :1803][INFO    ][6395] Executing state host.present for [cmp002]
2018-10-14 05:36:52,618 [salt.state       :290 ][INFO    ][6395] Host cmp002 (192.168.10.53) already present
2018-10-14 05:36:52,618 [salt.state       :1941][INFO    ][6395] Completed state [cmp002] at time 05:36:52.618228 duration_in_ms=0.971
2018-10-14 05:36:52,618 [salt.state       :1770][INFO    ][6395] Running state [cmp002.mcp-pike-odl-ha.local] at time 05:36:52.618584
2018-10-14 05:36:52,618 [salt.state       :1803][INFO    ][6395] Executing state host.present for [cmp002.mcp-pike-odl-ha.local]
2018-10-14 05:36:52,619 [salt.state       :290 ][INFO    ][6395] Host cmp002.mcp-pike-odl-ha.local (192.168.10.53) already present
2018-10-14 05:36:52,619 [salt.state       :1941][INFO    ][6395] Completed state [cmp002.mcp-pike-odl-ha.local] at time 05:36:52.619549 duration_in_ms=0.966
2018-10-14 05:36:52,619 [salt.state       :1770][INFO    ][6395] Running state [cmp001] at time 05:36:52.619885
2018-10-14 05:36:52,620 [salt.state       :1803][INFO    ][6395] Executing state host.present for [cmp001]
2018-10-14 05:36:52,620 [salt.state       :290 ][INFO    ][6395] Host cmp001 (192.168.10.52) already present
2018-10-14 05:36:52,621 [salt.state       :1941][INFO    ][6395] Completed state [cmp001] at time 05:36:52.621243 duration_in_ms=1.358
2018-10-14 05:36:52,621 [salt.state       :1770][INFO    ][6395] Running state [cmp001.mcp-pike-odl-ha.local] at time 05:36:52.621585
2018-10-14 05:36:52,621 [salt.state       :1803][INFO    ][6395] Executing state host.present for [cmp001.mcp-pike-odl-ha.local]
2018-10-14 05:36:52,622 [salt.state       :290 ][INFO    ][6395] Host cmp001.mcp-pike-odl-ha.local (192.168.10.52) already present
2018-10-14 05:36:52,622 [salt.state       :1941][INFO    ][6395] Completed state [cmp001.mcp-pike-odl-ha.local] at time 05:36:52.622546 duration_in_ms=0.961
2018-10-14 05:36:52,622 [salt.state       :1770][INFO    ][6395] Running state [dbs01] at time 05:36:52.622892
2018-10-14 05:36:52,623 [salt.state       :1803][INFO    ][6395] Executing state host.present for [dbs01]
2018-10-14 05:36:52,623 [salt.state       :290 ][INFO    ][6395] Host dbs01 (192.168.10.24) already present
2018-10-14 05:36:52,623 [salt.state       :1941][INFO    ][6395] Completed state [dbs01] at time 05:36:52.623859 duration_in_ms=0.967
2018-10-14 05:36:52,624 [salt.state       :1770][INFO    ][6395] Running state [dbs01.mcp-pike-odl-ha.local] at time 05:36:52.624198
2018-10-14 05:36:52,624 [salt.state       :1803][INFO    ][6395] Executing state host.present for [dbs01.mcp-pike-odl-ha.local]
2018-10-14 05:36:52,625 [salt.state       :290 ][INFO    ][6395] Host dbs01.mcp-pike-odl-ha.local (192.168.10.24) already present
2018-10-14 05:36:52,625 [salt.state       :1941][INFO    ][6395] Completed state [dbs01.mcp-pike-odl-ha.local] at time 05:36:52.625223 duration_in_ms=1.025
2018-10-14 05:36:52,625 [salt.state       :1770][INFO    ][6395] Running state [dbs02] at time 05:36:52.625571
2018-10-14 05:36:52,625 [salt.state       :1803][INFO    ][6395] Executing state host.present for [dbs02]
2018-10-14 05:36:52,626 [salt.state       :290 ][INFO    ][6395] Host dbs02 (192.168.10.25) already present
2018-10-14 05:36:52,626 [salt.state       :1941][INFO    ][6395] Completed state [dbs02] at time 05:36:52.626532 duration_in_ms=0.961
2018-10-14 05:36:52,626 [salt.state       :1770][INFO    ][6395] Running state [dbs02.mcp-pike-odl-ha.local] at time 05:36:52.626881
2018-10-14 05:36:52,627 [salt.state       :1803][INFO    ][6395] Executing state host.present for [dbs02.mcp-pike-odl-ha.local]
2018-10-14 05:36:52,627 [salt.state       :290 ][INFO    ][6395] Host dbs02.mcp-pike-odl-ha.local (192.168.10.25) already present
2018-10-14 05:36:52,627 [salt.state       :1941][INFO    ][6395] Completed state [dbs02.mcp-pike-odl-ha.local] at time 05:36:52.627838 duration_in_ms=0.957
2018-10-14 05:36:52,628 [salt.state       :1770][INFO    ][6395] Running state [dbs03] at time 05:36:52.628179
2018-10-14 05:36:52,628 [salt.state       :1803][INFO    ][6395] Executing state host.present for [dbs03]
2018-10-14 05:36:52,629 [salt.state       :290 ][INFO    ][6395] Host dbs03 (192.168.10.26) already present
2018-10-14 05:36:52,629 [salt.state       :1941][INFO    ][6395] Completed state [dbs03] at time 05:36:52.629470 duration_in_ms=1.292
2018-10-14 05:36:52,629 [salt.state       :1770][INFO    ][6395] Running state [dbs03.mcp-pike-odl-ha.local] at time 05:36:52.629814
2018-10-14 05:36:52,630 [salt.state       :1803][INFO    ][6395] Executing state host.present for [dbs03.mcp-pike-odl-ha.local]
2018-10-14 05:36:52,630 [salt.state       :290 ][INFO    ][6395] Host dbs03.mcp-pike-odl-ha.local (192.168.10.26) already present
2018-10-14 05:36:52,631 [salt.state       :1941][INFO    ][6395] Completed state [dbs03.mcp-pike-odl-ha.local] at time 05:36:52.630974 duration_in_ms=1.16
2018-10-14 05:36:52,631 [salt.state       :1770][INFO    ][6395] Running state [odl01] at time 05:36:52.631322
2018-10-14 05:36:52,631 [salt.state       :1803][INFO    ][6395] Executing state host.present for [odl01]
2018-10-14 05:36:52,632 [salt.state       :290 ][INFO    ][6395] Host odl01 (192.168.10.39) already present
2018-10-14 05:36:52,632 [salt.state       :1941][INFO    ][6395] Completed state [odl01] at time 05:36:52.632272 duration_in_ms=0.949
2018-10-14 05:36:52,632 [salt.state       :1770][INFO    ][6395] Running state [odl01.mcp-pike-odl-ha.local] at time 05:36:52.632618
2018-10-14 05:36:52,633 [salt.state       :1803][INFO    ][6395] Executing state host.present for [odl01.mcp-pike-odl-ha.local]
2018-10-14 05:36:52,633 [salt.state       :290 ][INFO    ][6395] Host odl01.mcp-pike-odl-ha.local (192.168.10.39) already present
2018-10-14 05:36:52,634 [salt.state       :1941][INFO    ][6395] Completed state [odl01.mcp-pike-odl-ha.local] at time 05:36:52.633961 duration_in_ms=1.343
2018-10-14 05:36:52,634 [salt.state       :1770][INFO    ][6395] Running state [mas01] at time 05:36:52.634307
2018-10-14 05:36:52,634 [salt.state       :1803][INFO    ][6395] Executing state host.present for [mas01]
2018-10-14 05:36:52,635 [salt.state       :290 ][INFO    ][6395] Host mas01 (192.168.10.12) already present
2018-10-14 05:36:52,635 [salt.state       :1941][INFO    ][6395] Completed state [mas01] at time 05:36:52.635258 duration_in_ms=0.951
2018-10-14 05:36:52,635 [salt.state       :1770][INFO    ][6395] Running state [mas01.mcp-pike-odl-ha.local] at time 05:36:52.635654
2018-10-14 05:36:52,635 [salt.state       :1803][INFO    ][6395] Executing state host.present for [mas01.mcp-pike-odl-ha.local]
2018-10-14 05:36:52,636 [salt.state       :290 ][INFO    ][6395] Host mas01.mcp-pike-odl-ha.local (192.168.10.12) already present
2018-10-14 05:36:52,636 [salt.state       :1941][INFO    ][6395] Completed state [mas01.mcp-pike-odl-ha.local] at time 05:36:52.636603 duration_in_ms=0.949
2018-10-14 05:36:52,637 [salt.state       :1770][INFO    ][6395] Running state [ctl02] at time 05:36:52.636995
2018-10-14 05:36:52,637 [salt.state       :1803][INFO    ][6395] Executing state host.present for [ctl02]
2018-10-14 05:36:52,637 [salt.state       :290 ][INFO    ][6395] Host ctl02 (192.168.10.37) already present
2018-10-14 05:36:52,638 [salt.state       :1941][INFO    ][6395] Completed state [ctl02] at time 05:36:52.637958 duration_in_ms=0.963
2018-10-14 05:36:52,638 [salt.state       :1770][INFO    ][6395] Running state [ctl02.mcp-pike-odl-ha.local] at time 05:36:52.638306
2018-10-14 05:36:52,638 [salt.state       :1803][INFO    ][6395] Executing state host.present for [ctl02.mcp-pike-odl-ha.local]
2018-10-14 05:36:52,639 [salt.state       :290 ][INFO    ][6395] Host ctl02.mcp-pike-odl-ha.local (192.168.10.37) already present
2018-10-14 05:36:52,639 [salt.state       :1941][INFO    ][6395] Completed state [ctl02.mcp-pike-odl-ha.local] at time 05:36:52.639250 duration_in_ms=0.944
2018-10-14 05:36:52,639 [salt.state       :1770][INFO    ][6395] Running state [ctl03] at time 05:36:52.639597
2018-10-14 05:36:52,639 [salt.state       :1803][INFO    ][6395] Executing state host.present for [ctl03]
2018-10-14 05:36:52,640 [salt.state       :290 ][INFO    ][6395] Host ctl03 (192.168.10.38) already present
2018-10-14 05:36:52,640 [salt.state       :1941][INFO    ][6395] Completed state [ctl03] at time 05:36:52.640551 duration_in_ms=0.954
2018-10-14 05:36:52,640 [salt.state       :1770][INFO    ][6395] Running state [ctl03.mcp-pike-odl-ha.local] at time 05:36:52.640945
2018-10-14 05:36:52,641 [salt.state       :1803][INFO    ][6395] Executing state host.present for [ctl03.mcp-pike-odl-ha.local]
2018-10-14 05:36:52,641 [salt.state       :290 ][INFO    ][6395] Host ctl03.mcp-pike-odl-ha.local (192.168.10.38) already present
2018-10-14 05:36:52,641 [salt.state       :1941][INFO    ][6395] Completed state [ctl03.mcp-pike-odl-ha.local] at time 05:36:52.641904 duration_in_ms=0.96
2018-10-14 05:36:52,642 [salt.state       :1770][INFO    ][6395] Running state [ctl01] at time 05:36:52.642255
2018-10-14 05:36:52,642 [salt.state       :1803][INFO    ][6395] Executing state host.present for [ctl01]
2018-10-14 05:36:52,643 [salt.state       :290 ][INFO    ][6395] Host ctl01 (192.168.10.36) already present
2018-10-14 05:36:52,643 [salt.state       :1941][INFO    ][6395] Completed state [ctl01] at time 05:36:52.643219 duration_in_ms=0.964
2018-10-14 05:36:52,643 [salt.state       :1770][INFO    ][6395] Running state [ctl01.mcp-pike-odl-ha.local] at time 05:36:52.643574
2018-10-14 05:36:52,643 [salt.state       :1803][INFO    ][6395] Executing state host.present for [ctl01.mcp-pike-odl-ha.local]
2018-10-14 05:36:52,644 [salt.state       :290 ][INFO    ][6395] Host ctl01.mcp-pike-odl-ha.local (192.168.10.36) already present
2018-10-14 05:36:52,644 [salt.state       :1941][INFO    ][6395] Completed state [ctl01.mcp-pike-odl-ha.local] at time 05:36:52.644516 duration_in_ms=0.942
2018-10-14 05:36:52,645 [salt.state       :1770][INFO    ][6395] Running state [ctl] at time 05:36:52.645259
2018-10-14 05:36:52,645 [salt.state       :1803][INFO    ][6395] Executing state host.present for [ctl]
2018-10-14 05:36:52,646 [salt.state       :290 ][INFO    ][6395] Host ctl (192.168.10.35) already present
2018-10-14 05:36:52,646 [salt.state       :1941][INFO    ][6395] Completed state [ctl] at time 05:36:52.646219 duration_in_ms=0.96
2018-10-14 05:36:52,646 [salt.state       :1770][INFO    ][6395] Running state [ctl.mcp-pike-odl-ha.local] at time 05:36:52.646572
2018-10-14 05:36:52,646 [salt.state       :1803][INFO    ][6395] Executing state host.present for [ctl.mcp-pike-odl-ha.local]
2018-10-14 05:36:52,647 [salt.state       :290 ][INFO    ][6395] Host ctl.mcp-pike-odl-ha.local (192.168.10.35) already present
2018-10-14 05:36:52,647 [salt.state       :1941][INFO    ][6395] Completed state [ctl.mcp-pike-odl-ha.local] at time 05:36:52.647520 duration_in_ms=0.948
2018-10-14 05:36:52,647 [salt.state       :1770][INFO    ][6395] Running state [/etc/network/interfaces.d/50-cloud-init.cfg] at time 05:36:52.647759
2018-10-14 05:36:52,648 [salt.state       :1803][INFO    ][6395] Executing state file.absent for [/etc/network/interfaces.d/50-cloud-init.cfg]
2018-10-14 05:36:52,648 [salt.state       :290 ][INFO    ][6395] File /etc/network/interfaces.d/50-cloud-init.cfg is not present
2018-10-14 05:36:52,648 [salt.state       :1941][INFO    ][6395] Completed state [/etc/network/interfaces.d/50-cloud-init.cfg] at time 05:36:52.648545 duration_in_ms=0.786
2018-10-14 05:36:52,648 [salt.state       :1770][INFO    ][6395] Running state [ens2] at time 05:36:52.648810
2018-10-14 05:36:52,649 [salt.state       :1803][INFO    ][6395] Executing state network.managed for [ens2]
2018-10-14 05:36:52,795 [salt.state       :290 ][INFO    ][6395] Interface ens2 is up to date.
2018-10-14 05:36:52,796 [salt.state       :1941][INFO    ][6395] Completed state [ens2] at time 05:36:52.796204 duration_in_ms=147.394
2018-10-14 05:36:52,796 [salt.state       :1770][INFO    ][6395] Running state [ens3] at time 05:36:52.796648
2018-10-14 05:36:52,797 [salt.state       :1803][INFO    ][6395] Executing state network.managed for [ens3]
2018-10-14 05:36:52,833 [salt.state       :290 ][INFO    ][6395] Interface ens3 is up to date.
2018-10-14 05:36:52,834 [salt.state       :1941][INFO    ][6395] Completed state [ens3] at time 05:36:52.834718 duration_in_ms=38.07
2018-10-14 05:36:52,835 [salt.state       :1770][INFO    ][6395] Running state [/etc/profile.d/proxy.sh] at time 05:36:52.835215
2018-10-14 05:36:52,835 [salt.state       :1803][INFO    ][6395] Executing state file.absent for [/etc/profile.d/proxy.sh]
2018-10-14 05:36:52,836 [salt.state       :290 ][INFO    ][6395] File /etc/profile.d/proxy.sh is not present
2018-10-14 05:36:52,836 [salt.state       :1941][INFO    ][6395] Completed state [/etc/profile.d/proxy.sh] at time 05:36:52.836583 duration_in_ms=1.368
2018-10-14 05:36:52,837 [salt.state       :1770][INFO    ][6395] Running state [/etc/apt/apt.conf.d/95proxies] at time 05:36:52.837529
2018-10-14 05:36:52,837 [salt.state       :1803][INFO    ][6395] Executing state file.absent for [/etc/apt/apt.conf.d/95proxies]
2018-10-14 05:36:52,838 [salt.state       :290 ][INFO    ][6395] File /etc/apt/apt.conf.d/95proxies is not present
2018-10-14 05:36:52,838 [salt.state       :1941][INFO    ][6395] Completed state [/etc/apt/apt.conf.d/95proxies] at time 05:36:52.838324 duration_in_ms=0.796
2018-10-14 05:36:52,838 [salt.state       :1770][INFO    ][6395] Running state [ntp] at time 05:36:52.838590
2018-10-14 05:36:52,838 [salt.state       :1803][INFO    ][6395] Executing state pkg.installed for [ntp]
2018-10-14 05:36:52,849 [salt.state       :290 ][INFO    ][6395] All specified packages are already installed
2018-10-14 05:36:52,849 [salt.state       :1941][INFO    ][6395] Completed state [ntp] at time 05:36:52.849486 duration_in_ms=10.896
2018-10-14 05:36:52,851 [salt.state       :1770][INFO    ][6395] Running state [/etc/ntp.conf] at time 05:36:52.851419
2018-10-14 05:36:52,851 [salt.state       :1803][INFO    ][6395] Executing state file.managed for [/etc/ntp.conf]
2018-10-14 05:36:52,937 [salt.state       :290 ][INFO    ][6395] File /etc/ntp.conf is in the correct state
2018-10-14 05:36:52,937 [salt.state       :1941][INFO    ][6395] Completed state [/etc/ntp.conf] at time 05:36:52.937714 duration_in_ms=86.295
2018-10-14 05:36:52,939 [salt.state       :1770][INFO    ][6395] Running state [ntp] at time 05:36:52.939012
2018-10-14 05:36:52,939 [salt.state       :1803][INFO    ][6395] Executing state service.running for [ntp]
2018-10-14 05:36:52,940 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6395] Executing command ['systemctl', 'status', 'ntp.service', '-n', '0'] in directory '/root'
2018-10-14 05:36:52,963 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6395] Executing command ['systemctl', 'is-active', 'ntp.service'] in directory '/root'
2018-10-14 05:36:52,986 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6395] Executing command ['systemctl', 'is-enabled', 'ntp.service'] in directory '/root'
2018-10-14 05:36:53,006 [salt.state       :290 ][INFO    ][6395] The service ntp is already running
2018-10-14 05:36:53,007 [salt.state       :1941][INFO    ][6395] Completed state [ntp] at time 05:36:53.007167 duration_in_ms=68.154
2018-10-14 05:36:53,013 [salt.minion      :1708][INFO    ][6395] Returning information for job: 20181014053634511899
2018-10-14 05:36:53,862 [salt.minion      :1307][INFO    ][2899] User sudo_ubuntu Executing command ssh.set_auth_key with jid 20181014053653854207
2018-10-14 05:36:53,884 [salt.minion      :1431][INFO    ][7127] Starting a new job with PID 7127
2018-10-14 05:36:53,907 [salt.minion      :1708][INFO    ][7127] Returning information for job: 20181014053653854207
2018-10-14 05:37:30,281 [salt.minion      :1307][INFO    ][2899] User sudo_ubuntu Executing command pkg.upgrade with jid 20181014053730274390
2018-10-14 05:37:30,305 [salt.minion      :1431][INFO    ][7150] Starting a new job with PID 7150
2018-10-14 05:37:30,335 [salt.loader.192.168.11.2.int.module.cmdmod:395 ][INFO    ][7150] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}', '-W'] in directory '/root'
2018-10-14 05:37:30,782 [salt.loader.192.168.11.2.int.module.cmdmod:395 ][INFO    ][7150] 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-14 05:37:37,704 [salt.loader.192.168.11.2.int.module.cmdmod:395 ][INFO    ][7150] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}', '-W'] in directory '/root'
2018-10-14 05:37:37,751 [salt.minion      :1708][INFO    ][7150] Returning information for job: 20181014053730274390
2018-10-14 05:45:28,618 [salt.minion      :1307][INFO    ][2899] User sudo_ubuntu Executing command test.ping with jid 20181014054528610612
2018-10-14 05:45:28,644 [salt.minion      :1431][INFO    ][8095] Starting a new job with PID 8095
2018-10-14 05:45:28,669 [salt.minion      :1708][INFO    ][8095] Returning information for job: 20181014054528610612
2018-10-14 05:46:34,014 [salt.minion      :1307][INFO    ][2899] User sudo_ubuntu Executing command state.sls with jid 20181014054633998527
2018-10-14 05:46:34,037 [salt.minion      :1431][INFO    ][8100] Starting a new job with PID 8100
2018-10-14 05:46:37,060 [salt.state       :905 ][INFO    ][8100] Loading fresh modules for state activity
2018-10-14 05:46:37,117 [salt.fileclient  :1215][INFO    ][8100] Fetching file from saltenv 'base', ** done ** 'keepalived/init.sls'
2018-10-14 05:46:37,149 [salt.fileclient  :1215][INFO    ][8100] Fetching file from saltenv 'base', ** done ** 'keepalived/cluster.sls'
2018-10-14 05:46:37,961 [salt.state       :1770][INFO    ][8100] Running state [keepalived] at time 05:46:37.961168
2018-10-14 05:46:37,962 [salt.state       :1803][INFO    ][8100] Executing state pkg.installed for [keepalived]
2018-10-14 05:46:37,963 [salt.loaded.int.module.cmdmod:395 ][INFO    ][8100] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}', '-W'] in directory '/root'
2018-10-14 05:46:38,428 [salt.loaded.int.module.cmdmod:395 ][INFO    ][8100] Executing command ['apt-cache', '-q', 'policy', 'keepalived'] in directory '/root'
2018-10-14 05:46:38,545 [salt.loaded.int.module.cmdmod:395 ][INFO    ][8100] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2018-10-14 05:46:40,866 [salt.loaded.int.module.cmdmod:395 ][INFO    ][8100] Executing command ['dpkg', '--get-selections', '*'] in directory '/root'
2018-10-14 05:46:40,895 [salt.loaded.int.module.cmdmod:395 ][INFO    ][8100] 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-14 05:46:44,134 [salt.minion      :1307][INFO    ][2899] User sudo_ubuntu Executing command saltutil.find_job with jid 20181014054644119629
2018-10-14 05:46:44,151 [salt.minion      :1431][INFO    ][9423] Starting a new job with PID 9423
2018-10-14 05:46:44,170 [salt.minion      :1708][INFO    ][9423] Returning information for job: 20181014054644119629
2018-10-14 05:46:45,276 [salt.loaded.int.module.cmdmod:395 ][INFO    ][8100] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}', '-W'] in directory '/root'
2018-10-14 05:46:45,321 [salt.state       :290 ][INFO    ][8100] 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-14 05:46:45,343 [salt.state       :905 ][INFO    ][8100] Loading fresh modules for state activity
2018-10-14 05:46:45,384 [salt.state       :1941][INFO    ][8100] Completed state [keepalived] at time 05:46:45.384692 duration_in_ms=7423.525
2018-10-14 05:46:45,390 [salt.state       :1770][INFO    ][8100] Running state [lsof] at time 05:46:45.390823
2018-10-14 05:46:45,391 [salt.state       :1803][INFO    ][8100] Executing state pkg.installed for [lsof]
2018-10-14 05:46:46,131 [salt.state       :290 ][INFO    ][8100] All specified packages are already installed
2018-10-14 05:46:46,132 [salt.state       :1941][INFO    ][8100] Completed state [lsof] at time 05:46:46.132281 duration_in_ms=741.457
2018-10-14 05:46:46,135 [salt.state       :1770][INFO    ][8100] Running state [/etc/keepalived/keepalived.conf] at time 05:46:46.135593
2018-10-14 05:46:46,135 [salt.state       :1803][INFO    ][8100] Executing state file.managed for [/etc/keepalived/keepalived.conf]
2018-10-14 05:46:46,173 [salt.fileclient  :1215][INFO    ][8100] Fetching file from saltenv 'base', ** done ** 'keepalived/files/keepalived.conf'
2018-10-14 05:46:46,232 [salt.state       :290 ][INFO    ][8100] File changed:
New file
2018-10-14 05:46:46,232 [salt.state       :1941][INFO    ][8100] Completed state [/etc/keepalived/keepalived.conf] at time 05:46:46.232225 duration_in_ms=96.632
2018-10-14 05:46:46,233 [salt.state       :1770][INFO    ][8100] Running state [keepalived] at time 05:46:46.233307
2018-10-14 05:46:46,233 [salt.state       :1803][INFO    ][8100] Executing state service.running for [keepalived]
2018-10-14 05:46:46,234 [salt.loaded.int.module.cmdmod:395 ][INFO    ][8100] Executing command ['systemctl', 'status', 'keepalived.service', '-n', '0'] in directory '/root'
2018-10-14 05:46:46,261 [salt.loaded.int.module.cmdmod:395 ][INFO    ][8100] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2018-10-14 05:46:46,279 [salt.loaded.int.module.cmdmod:395 ][INFO    ][8100] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2018-10-14 05:46:46,296 [salt.loaded.int.module.cmdmod:395 ][INFO    ][8100] Executing command ['systemd-run', '--scope', 'systemctl', 'start', 'keepalived.service'] in directory '/root'
2018-10-14 05:46:46,367 [salt.loaded.int.module.cmdmod:395 ][INFO    ][8100] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2018-10-14 05:46:46,386 [salt.loaded.int.module.cmdmod:395 ][INFO    ][8100] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2018-10-14 05:46:46,402 [salt.loaded.int.module.cmdmod:395 ][INFO    ][8100] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2018-10-14 05:46:46,421 [salt.state       :290 ][INFO    ][8100] {'keepalived': True}
2018-10-14 05:46:46,422 [salt.state       :1941][INFO    ][8100] Completed state [keepalived] at time 05:46:46.422317 duration_in_ms=189.009
2018-10-14 05:46:46,424 [salt.minion      :1708][INFO    ][8100] Returning information for job: 20181014054633998527
2018-10-14 05:48:36,112 [salt.minion      :1307][INFO    ][2899] User sudo_ubuntu Executing command pillar.get with jid 20181014054836100882
2018-10-14 05:48:36,144 [salt.minion      :1431][INFO    ][9543] Starting a new job with PID 9543
2018-10-14 05:48:36,152 [salt.minion      :1708][INFO    ][9543] Returning information for job: 20181014054836100882
2018-10-14 05:51:44,837 [salt.minion      :1307][INFO    ][2899] User sudo_ubuntu Executing command state.sls with jid 20181014055144825452
2018-10-14 05:51:44,861 [salt.minion      :1431][INFO    ][9575] Starting a new job with PID 9575
2018-10-14 05:51:48,546 [salt.state       :905 ][INFO    ][9575] Loading fresh modules for state activity
2018-10-14 05:51:48,622 [salt.fileclient  :1215][INFO    ][9575] Fetching file from saltenv 'base', ** done ** 'rabbitmq/init.sls'
2018-10-14 05:51:48,667 [salt.fileclient  :1215][INFO    ][9575] Fetching file from saltenv 'base', ** done ** 'rabbitmq/server/init.sls'
2018-10-14 05:51:48,695 [salt.fileclient  :1215][INFO    ][9575] Fetching file from saltenv 'base', ** done ** 'rabbitmq/server/service.sls'
2018-10-14 05:51:48,755 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9575] Executing command 'cat /var/lib/rabbitmq/.erlang.cookie' in directory '/root'
2018-10-14 05:51:48,773 [salt.loaded.int.module.cmdmod:722 ][ERROR   ][9575] Command 'cat /var/lib/rabbitmq/.erlang.cookie' failed with return code: 1
2018-10-14 05:51:48,774 [salt.loaded.int.module.cmdmod:724 ][ERROR   ][9575] stdout: cat: /var/lib/rabbitmq/.erlang.cookie: No such file or directory
2018-10-14 05:51:48,774 [salt.loaded.int.module.cmdmod:728 ][ERROR   ][9575] retcode: 1
2018-10-14 05:51:48,821 [salt.fileclient  :1215][INFO    ][9575] Fetching file from saltenv 'base', ** done ** 'rabbitmq/server/ssl.sls'
2018-10-14 05:51:48,913 [salt.fileclient  :1215][INFO    ][9575] Fetching file from saltenv 'base', ** done ** 'rabbitmq/server/plugin.sls'
2018-10-14 05:51:48,976 [salt.fileclient  :1215][INFO    ][9575] Fetching file from saltenv 'base', ** done ** 'rabbitmq/server/vhost.sls'
2018-10-14 05:51:49,058 [salt.fileclient  :1215][INFO    ][9575] Fetching file from saltenv 'base', ** done ** 'rabbitmq/server/user.sls'
2018-10-14 05:51:49,121 [salt.fileclient  :1215][INFO    ][9575] Fetching file from saltenv 'base', ** done ** 'rabbitmq/cluster.sls'
2018-10-14 05:51:49,958 [salt.state       :1770][INFO    ][9575] Running state [rabbitmq-server] at time 05:51:49.958867
2018-10-14 05:51:49,959 [salt.state       :1803][INFO    ][9575] Executing state pkg.installed for [rabbitmq-server]
2018-10-14 05:51:49,961 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9575] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}', '-W'] in directory '/root'
2018-10-14 05:51:50,377 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9575] Executing command ['apt-cache', '-q', 'policy', 'rabbitmq-server'] in directory '/root'
2018-10-14 05:51:50,494 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9575] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2018-10-14 05:51:52,845 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9575] Executing command ['dpkg', '--get-selections', '*'] in directory '/root'
2018-10-14 05:51:52,875 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9575] 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-14 05:51:54,866 [salt.minion      :1307][INFO    ][2899] User sudo_ubuntu Executing command saltutil.find_job with jid 20181014055154848485
2018-10-14 05:51:54,878 [salt.minion      :1431][INFO    ][10072] Starting a new job with PID 10072
2018-10-14 05:51:54,896 [salt.minion      :1708][INFO    ][10072] Returning information for job: 20181014055154848485
2018-10-14 05:52:05,094 [salt.minion      :1307][INFO    ][2899] User sudo_ubuntu Executing command saltutil.find_job with jid 20181014055205079500
2018-10-14 05:52:05,110 [salt.minion      :1431][INFO    ][10947] Starting a new job with PID 10947
2018-10-14 05:52:05,135 [salt.minion      :1708][INFO    ][10947] Returning information for job: 20181014055205079500
2018-10-14 05:52:15,322 [salt.minion      :1307][INFO    ][2899] User sudo_ubuntu Executing command saltutil.find_job with jid 20181014055215303124
2018-10-14 05:52:15,338 [salt.minion      :1431][INFO    ][10952] Starting a new job with PID 10952
2018-10-14 05:52:15,360 [salt.minion      :1708][INFO    ][10952] Returning information for job: 20181014055215303124
2018-10-14 05:52:25,397 [salt.minion      :1307][INFO    ][2899] User sudo_ubuntu Executing command saltutil.find_job with jid 20181014055225383385
2018-10-14 05:52:25,414 [salt.minion      :1431][INFO    ][10957] Starting a new job with PID 10957
2018-10-14 05:52:25,436 [salt.minion      :1708][INFO    ][10957] Returning information for job: 20181014055225383385
2018-10-14 05:52:35,427 [salt.minion      :1307][INFO    ][2899] User sudo_ubuntu Executing command saltutil.find_job with jid 20181014055235408448
2018-10-14 05:52:35,440 [salt.minion      :1431][INFO    ][10962] Starting a new job with PID 10962
2018-10-14 05:52:35,458 [salt.minion      :1708][INFO    ][10962] Returning information for job: 20181014055235408448
2018-10-14 05:52:39,483 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9575] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}', '-W'] in directory '/root'
2018-10-14 05:52:39,535 [salt.state       :290 ][INFO    ][9575] 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-14 05:52:39,559 [salt.state       :905 ][INFO    ][9575] Loading fresh modules for state activity
2018-10-14 05:52:39,601 [salt.state       :1941][INFO    ][9575] Completed state [rabbitmq-server] at time 05:52:39.601493 duration_in_ms=49642.627
2018-10-14 05:52:39,606 [salt.state       :1770][INFO    ][9575] Running state [/etc/rabbitmq/rabbitmq.config] at time 05:52:39.606850
2018-10-14 05:52:39,607 [salt.state       :1803][INFO    ][9575] Executing state file.managed for [/etc/rabbitmq/rabbitmq.config]
2018-10-14 05:52:39,669 [salt.fileclient  :1215][INFO    ][9575] Fetching file from saltenv 'base', ** done ** 'rabbitmq/files/rabbitmq.config'
2018-10-14 05:52:39,748 [salt.state       :290 ][INFO    ][9575] File changed:
New file
2018-10-14 05:52:39,748 [salt.state       :1941][INFO    ][9575] Completed state [/etc/rabbitmq/rabbitmq.config] at time 05:52:39.748936 duration_in_ms=142.085
2018-10-14 05:52:39,749 [salt.state       :1770][INFO    ][9575] Running state [/etc/default/rabbitmq-server] at time 05:52:39.749373
2018-10-14 05:52:39,749 [salt.state       :1803][INFO    ][9575] Executing state file.managed for [/etc/default/rabbitmq-server]
2018-10-14 05:52:39,780 [salt.fileclient  :1215][INFO    ][9575] Fetching file from saltenv 'base', ** done ** 'rabbitmq/files/default'
2018-10-14 05:52:39,827 [salt.state       :290 ][INFO    ][9575] 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-14 05:52:39,827 [salt.state       :1941][INFO    ][9575] Completed state [/etc/default/rabbitmq-server] at time 05:52:39.827651 duration_in_ms=78.278
2018-10-14 05:52:39,828 [salt.state       :1770][INFO    ][9575] Running state [/etc/systemd/system/rabbitmq-server.service.d/limits.conf] at time 05:52:39.828093
2018-10-14 05:52:39,828 [salt.state       :1803][INFO    ][9575] Executing state file.managed for [/etc/systemd/system/rabbitmq-server.service.d/limits.conf]
2018-10-14 05:52:39,854 [salt.fileclient  :1215][INFO    ][9575] Fetching file from saltenv 'base', ** done ** 'rabbitmq/files/limits.conf'
2018-10-14 05:52:39,896 [salt.state       :290 ][INFO    ][9575] File changed:
New file
2018-10-14 05:52:39,896 [salt.state       :1941][INFO    ][9575] Completed state [/etc/systemd/system/rabbitmq-server.service.d/limits.conf] at time 05:52:39.896835 duration_in_ms=68.723
2018-10-14 05:52:39,898 [salt.state       :1770][INFO    ][9575] Running state [sleep 30] at time 05:52:39.898221
2018-10-14 05:52:39,898 [salt.state       :1803][INFO    ][9575] Executing state cmd.run for [sleep 30]
2018-10-14 05:52:39,899 [py.warnings      :2526][WARNING ][9575] /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-14 05:52:39,902 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9575] Executing command 'sleep 30' as user 'root' in directory '/root'
2018-10-14 05:52:45,650 [salt.minion      :1307][INFO    ][2899] User sudo_ubuntu Executing command saltutil.find_job with jid 20181014055245633360
2018-10-14 05:52:45,673 [salt.minion      :1431][INFO    ][11134] Starting a new job with PID 11134
2018-10-14 05:52:45,694 [salt.minion      :1708][INFO    ][11134] Returning information for job: 20181014055245633360
2018-10-14 05:52:55,882 [salt.minion      :1307][INFO    ][2899] User sudo_ubuntu Executing command saltutil.find_job with jid 20181014055255865124
2018-10-14 05:52:55,900 [salt.minion      :1431][INFO    ][11139] Starting a new job with PID 11139
2018-10-14 05:52:55,920 [salt.minion      :1708][INFO    ][11139] Returning information for job: 20181014055255865124
2018-10-14 05:53:05,910 [salt.minion      :1307][INFO    ][2899] User sudo_ubuntu Executing command saltutil.find_job with jid 20181014055305891007
2018-10-14 05:53:05,930 [salt.minion      :1431][INFO    ][11144] Starting a new job with PID 11144
2018-10-14 05:53:05,950 [salt.minion      :1708][INFO    ][11144] Returning information for job: 20181014055305891007
2018-10-14 05:53:10,005 [salt.state       :290 ][INFO    ][9575] {'pid': 11104, 'retcode': 0, 'stderr': '', 'stdout': ''}
2018-10-14 05:53:10,007 [salt.state       :1941][INFO    ][9575] Completed state [sleep 30] at time 05:53:10.007573 duration_in_ms=30109.35
2018-10-14 05:53:10,010 [salt.state       :1770][INFO    ][9575] Running state [service rabbitmq-server stop] at time 05:53:10.010785
2018-10-14 05:53:10,012 [salt.state       :1803][INFO    ][9575] Executing state cmd.run for [service rabbitmq-server stop]
2018-10-14 05:53:10,014 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9575] Executing command 'service rabbitmq-server stop' in directory '/root'
2018-10-14 05:53:10,347 [salt.state       :290 ][INFO    ][9575] {'pid': 11147, 'retcode': 0, 'stderr': '', 'stdout': ''}
2018-10-14 05:53:10,349 [salt.state       :1941][INFO    ][9575] Completed state [service rabbitmq-server stop] at time 05:53:10.349272 duration_in_ms=338.487
2018-10-14 05:53:10,350 [salt.state       :1770][INFO    ][9575] Running state [/var/lib/rabbitmq] at time 05:53:10.350513
2018-10-14 05:53:10,351 [salt.state       :1803][INFO    ][9575] Executing state file.directory for [/var/lib/rabbitmq]
2018-10-14 05:53:10,354 [salt.state       :290 ][INFO    ][9575] Directory /var/lib/rabbitmq is in the correct state
Directory /var/lib/rabbitmq updated
2018-10-14 05:53:10,354 [salt.state       :1941][INFO    ][9575] Completed state [/var/lib/rabbitmq] at time 05:53:10.354423 duration_in_ms=3.91
2018-10-14 05:53:10,355 [salt.state       :1770][INFO    ][9575] Running state [/var/lib/rabbitmq/.erlang.cookie] at time 05:53:10.355808
2018-10-14 05:53:10,356 [salt.state       :1803][INFO    ][9575] Executing state file.managed for [/var/lib/rabbitmq/.erlang.cookie]
2018-10-14 05:53:10,359 [salt.state       :290 ][INFO    ][9575] File changed:
--- 
+++ 
@@ -1 +1 @@
-NOOMLNOGRPADUMPMAFYX+opnfv_secret

2018-10-14 05:53:10,360 [salt.state       :1941][INFO    ][9575] Completed state [/var/lib/rabbitmq/.erlang.cookie] at time 05:53:10.360201 duration_in_ms=4.393
2018-10-14 05:53:10,360 [salt.state       :1770][INFO    ][9575] Running state [sleep 30] at time 05:53:10.360617
2018-10-14 05:53:10,360 [salt.state       :1803][INFO    ][9575] Executing state cmd.run for [sleep 30]
2018-10-14 05:53:10,361 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9575] Executing command 'sleep 30' as user 'root' in directory '/root'
2018-10-14 05:53:16,143 [salt.minion      :1307][INFO    ][2899] User sudo_ubuntu Executing command saltutil.find_job with jid 20181014055316123988
2018-10-14 05:53:16,166 [salt.minion      :1431][INFO    ][11235] Starting a new job with PID 11235
2018-10-14 05:53:16,187 [salt.minion      :1708][INFO    ][11235] Returning information for job: 20181014055316123988
2018-10-14 05:53:26,168 [salt.minion      :1307][INFO    ][2899] User sudo_ubuntu Executing command saltutil.find_job with jid 20181014055326154651
2018-10-14 05:53:26,192 [salt.minion      :1431][INFO    ][11250] Starting a new job with PID 11250
2018-10-14 05:53:26,210 [salt.minion      :1708][INFO    ][11250] Returning information for job: 20181014055326154651
2018-10-14 05:53:36,195 [salt.minion      :1307][INFO    ][2899] User sudo_ubuntu Executing command saltutil.find_job with jid 20181014055336178232
2018-10-14 05:53:36,216 [salt.minion      :1431][INFO    ][11255] Starting a new job with PID 11255
2018-10-14 05:53:36,238 [salt.minion      :1708][INFO    ][11255] Returning information for job: 20181014055336178232
2018-10-14 05:53:40,443 [salt.state       :290 ][INFO    ][9575] {'pid': 11209, 'retcode': 0, 'stderr': '', 'stdout': ''}
2018-10-14 05:53:40,445 [salt.state       :1941][INFO    ][9575] Completed state [sleep 30] at time 05:53:40.445033 duration_in_ms=30084.414
2018-10-14 05:53:40,988 [salt.state       :1770][INFO    ][9575] Running state [rabbitmq-server] at time 05:53:40.987991
2018-10-14 05:53:40,988 [salt.state       :1803][INFO    ][9575] Executing state service.running for [rabbitmq-server]
2018-10-14 05:53:40,989 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9575] Executing command ['systemctl', 'status', 'rabbitmq-server.service', '-n', '0'] in directory '/root'
2018-10-14 05:53:41,013 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9575] Executing command ['systemctl', 'is-active', 'rabbitmq-server.service'] in directory '/root'
2018-10-14 05:53:41,031 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9575] Executing command ['systemctl', 'is-enabled', 'rabbitmq-server.service'] in directory '/root'
2018-10-14 05:53:41,065 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9575] Executing command ['systemd-run', '--scope', 'systemctl', 'start', 'rabbitmq-server.service'] in directory '/root'
2018-10-14 05:53:44,294 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9575] Executing command ['systemctl', 'is-active', 'rabbitmq-server.service'] in directory '/root'
2018-10-14 05:53:44,312 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9575] Executing command ['systemctl', 'is-enabled', 'rabbitmq-server.service'] in directory '/root'
2018-10-14 05:53:44,332 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9575] Executing command ['systemctl', 'is-enabled', 'rabbitmq-server.service'] in directory '/root'
2018-10-14 05:53:44,357 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9575] Executing command ['systemd-run', '--scope', 'systemctl', 'enable', 'rabbitmq-server.service'] in directory '/root'
2018-10-14 05:53:44,814 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9575] Executing command ['systemctl', 'is-enabled', 'rabbitmq-server.service'] in directory '/root'
2018-10-14 05:53:44,832 [salt.state       :290 ][INFO    ][9575] {'rabbitmq-server': True}
2018-10-14 05:53:44,833 [salt.state       :1941][INFO    ][9575] Completed state [rabbitmq-server] at time 05:53:44.833294 duration_in_ms=3845.304
2018-10-14 05:53:44,837 [salt.state       :1770][INFO    ][9575] Running state [amqp_client] at time 05:53:44.837574
2018-10-14 05:53:44,838 [salt.state       :1803][INFO    ][9575] Executing state rabbitmq_plugin.enabled for [amqp_client]
2018-10-14 05:53:44,839 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9575] Executing command ['/usr/sbin/rabbitmq-plugins', 'list', '-m', '-e'] as user 'root' in directory '/root'
2018-10-14 05:53:45,997 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9575] Executing command ['/usr/sbin/rabbitmq-plugins', 'enable', 'amqp_client'] as user 'root' in directory '/root'
2018-10-14 05:53:46,223 [salt.minion      :1307][INFO    ][2899] User sudo_ubuntu Executing command saltutil.find_job with jid 20181014055346205939
2018-10-14 05:53:46,238 [salt.minion      :1431][INFO    ][12047] Starting a new job with PID 12047
2018-10-14 05:53:46,258 [salt.minion      :1708][INFO    ][12047] Returning information for job: 20181014055346205939
2018-10-14 05:53:47,271 [salt.state       :290 ][INFO    ][9575] {'new': 'amqp_client', 'old': ''}
2018-10-14 05:53:47,272 [salt.state       :1941][INFO    ][9575] Completed state [amqp_client] at time 05:53:47.272893 duration_in_ms=2435.319
2018-10-14 05:53:47,274 [salt.state       :1770][INFO    ][9575] Running state [rabbitmq_management] at time 05:53:47.274425
2018-10-14 05:53:47,275 [salt.state       :1803][INFO    ][9575] Executing state rabbitmq_plugin.enabled for [rabbitmq_management]
2018-10-14 05:53:47,277 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9575] Executing command ['/usr/sbin/rabbitmq-plugins', 'list', '-m', '-e'] as user 'root' in directory '/root'
2018-10-14 05:53:48,339 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9575] Executing command ['/usr/sbin/rabbitmq-plugins', 'enable', 'rabbitmq_management'] as user 'root' in directory '/root'
2018-10-14 05:53:50,316 [salt.state       :290 ][INFO    ][9575] {'new': 'rabbitmq_management', 'old': ''}
2018-10-14 05:53:50,316 [salt.state       :1941][INFO    ][9575] Completed state [rabbitmq_management] at time 05:53:50.316676 duration_in_ms=3042.251
2018-10-14 05:53:50,319 [salt.state       :1770][INFO    ][9575] Running state [/openstack] at time 05:53:50.319347
2018-10-14 05:53:50,319 [salt.state       :1803][INFO    ][9575] Executing state rabbitmq_vhost.present for [/openstack]
2018-10-14 05:53:50,320 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9575] Executing command ['/usr/sbin/rabbitmqctl', 'list_vhosts', '-q'] as user 'root' in directory '/root'
2018-10-14 05:53:51,495 [salt.state       :290 ][INFO    ][9575] Virtual Host '/openstack' already exists.
2018-10-14 05:53:51,496 [salt.state       :1941][INFO    ][9575] Completed state [/openstack] at time 05:53:51.496777 duration_in_ms=1177.428
2018-10-14 05:53:51,502 [salt.state       :1770][INFO    ][9575] Running state [openstack] at time 05:53:51.502252
2018-10-14 05:53:51,502 [salt.state       :1803][INFO    ][9575] Executing state rabbitmq_user.present for [openstack]
2018-10-14 05:53:51,503 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9575] Executing command ['/usr/sbin/rabbitmqctl', 'list_users', '-q'] as user 'root' in directory '/root'
2018-10-14 05:53:52,681 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9575] Executing command ['/usr/sbin/rabbitmqctl', 'status'] as user 'root' in directory '/root'
2018-10-14 05:53:56,247 [salt.minion      :1307][INFO    ][2899] User sudo_ubuntu Executing command saltutil.find_job with jid 20181014055356230406
2018-10-14 05:53:56,265 [salt.minion      :1431][INFO    ][13759] Starting a new job with PID 13759
2018-10-14 05:53:56,285 [salt.minion      :1708][INFO    ][13759] Returning information for job: 20181014055356230406
2018-10-14 05:53:56,286 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9575] Executing command ['/usr/sbin/rabbitmqctl', 'list_user_permissions', 'openstack', '-q'] as user 'root' in directory '/root'
2018-10-14 05:53:57,507 [salt.state       :290 ][INFO    ][9575] Made the following changes:
'password' changed from 'absent' to 'Set password.'

2018-10-14 05:53:57,508 [salt.state       :1941][INFO    ][9575] Completed state [openstack] at time 05:53:57.508161 duration_in_ms=6005.907
2018-10-14 05:53:57,512 [salt.state       :1770][INFO    ][9575] Running state [Ceilometer] at time 05:53:57.511768
2018-10-14 05:53:57,513 [salt.state       :1803][INFO    ][9575] Executing state rabbitmq_policy.present for [Ceilometer]
2018-10-14 05:53:57,513 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9575] Executing command ['/usr/sbin/rabbitmqctl', 'list_policies', '-q', '-p', '/openstack'] as user 'root' in directory '/root'
2018-10-14 05:53:58,704 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9575] 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-14 05:53:59,864 [salt.state       :290 ][INFO    ][9575] {'new': ['Definition'], 'old': {'apply_to': 'all', 'priority': '10', 'definition': '{"ha-mode":"all","message-ttl":10800000}', 'pattern': '^metering.sample$'}}
2018-10-14 05:53:59,865 [salt.state       :1941][INFO    ][9575] Completed state [Ceilometer] at time 05:53:59.865246 duration_in_ms=2353.476
2018-10-14 05:53:59,867 [salt.state       :1770][INFO    ][9575] Running state [HA] at time 05:53:59.867170
2018-10-14 05:53:59,868 [salt.state       :1803][INFO    ][9575] Executing state rabbitmq_policy.present for [HA]
2018-10-14 05:53:59,872 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9575] Executing command ['/usr/sbin/rabbitmqctl', 'list_policies', '-q', '-p', '/openstack'] as user 'root' in directory '/root'
2018-10-14 05:54:01,042 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9575] 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-14 05:54:02,196 [salt.state       :290 ][INFO    ][9575] {'new': ['Pattern', 'Definition'], 'old': {'apply_to': 'all', 'priority': '0', 'definition': '{"ha-mode":"all","message-ttl":120000}', 'pattern': '^(?!amq\\\\.).*'}}
2018-10-14 05:54:02,197 [salt.state       :1941][INFO    ][9575] Completed state [HA] at time 05:54:02.197061 duration_in_ms=2329.891
2018-10-14 05:54:02,197 [salt.state       :1770][INFO    ][9575] Running state [guest] at time 05:54:02.197512
2018-10-14 05:54:02,197 [salt.state       :1803][INFO    ][9575] Executing state rabbitmq_user.present for [guest]
2018-10-14 05:54:02,198 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9575] Executing command ['/usr/sbin/rabbitmqctl', 'list_users', '-q'] as user 'root' in directory '/root'
2018-10-14 05:54:03,374 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9575] Executing command ['/usr/sbin/rabbitmqctl', 'status'] as user 'root' in directory '/root'
2018-10-14 05:54:06,281 [salt.minion      :1307][INFO    ][2899] User sudo_ubuntu Executing command saltutil.find_job with jid 20181014055406264961
2018-10-14 05:54:06,302 [salt.minion      :1431][INFO    ][15922] Starting a new job with PID 15922
2018-10-14 05:54:06,320 [salt.minion      :1708][INFO    ][15922] Returning information for job: 20181014055406264961
2018-10-14 05:54:06,961 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9575] Executing command ['/usr/sbin/rabbitmqctl', 'list_user_permissions', 'guest', '-q'] as user 'root' in directory '/root'
2018-10-14 05:54:08,115 [salt.state       :290 ][INFO    ][9575] Made the following changes:
'password' changed from 'absent' to 'Set password.'

2018-10-14 05:54:08,117 [salt.state       :1941][INFO    ][9575] Completed state [guest] at time 05:54:08.117153 duration_in_ms=5919.639
2018-10-14 05:54:08,118 [salt.state       :1770][INFO    ][9575] Running state [HA] at time 05:54:08.118654
2018-10-14 05:54:08,119 [salt.state       :1803][INFO    ][9575] Executing state rabbitmq_policy.present for [HA]
2018-10-14 05:54:08,124 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9575] Executing command ['/usr/sbin/rabbitmqctl', 'list_policies', '-q', '-p', '/'] as user 'root' in directory '/root'
2018-10-14 05:54:09,310 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9575] Executing command ['/usr/sbin/rabbitmqctl', 'set_policy', '-p', '/', 'HA', '^(?!amq\\.).*', '{"ha-mode": "all", "message-ttl": 120000}'] as user 'root' in directory '/root'
2018-10-14 05:54:10,476 [salt.state       :290 ][INFO    ][9575] {'new': ['Pattern', 'Definition'], 'old': {'apply_to': 'all', 'priority': '0', 'definition': '{"ha-mode":"all","message-ttl":120000}', 'pattern': '^(?!amq\\\\.).*'}}
2018-10-14 05:54:10,477 [salt.state       :1941][INFO    ][9575] Completed state [HA] at time 05:54:10.477672 duration_in_ms=2359.016
2018-10-14 05:54:10,479 [salt.state       :1770][INFO    ][9575] Running state [admin] at time 05:54:10.479468
2018-10-14 05:54:10,480 [salt.state       :1803][INFO    ][9575] Executing state rabbitmq_user.present for [admin]
2018-10-14 05:54:10,484 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9575] Executing command ['/usr/sbin/rabbitmqctl', 'list_users', '-q'] as user 'root' in directory '/root'
2018-10-14 05:54:11,654 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9575] Executing command ['/usr/sbin/rabbitmqctl', 'status'] as user 'root' in directory '/root'
2018-10-14 05:54:15,253 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9575] Executing command ['/usr/sbin/rabbitmqctl', 'list_users', '-q'] as user 'root' in directory '/root'
2018-10-14 05:54:16,382 [salt.minion      :1307][INFO    ][2899] User sudo_ubuntu Executing command saltutil.find_job with jid 20181014055416360990
2018-10-14 05:54:16,395 [salt.minion      :1431][INFO    ][17905] Starting a new job with PID 17905
2018-10-14 05:54:16,417 [salt.minion      :1708][INFO    ][17905] Returning information for job: 20181014055416360990
2018-10-14 05:54:16,431 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9575] Executing command ['/usr/sbin/rabbitmqctl', 'list_user_permissions', 'admin', '-q'] as user 'root' in directory '/root'
2018-10-14 05:54:17,617 [salt.state       :290 ][INFO    ][9575] Made the following changes:
'password' changed from 'absent' to 'Set password.'

2018-10-14 05:54:17,618 [salt.state       :1941][INFO    ][9575] Completed state [admin] at time 05:54:17.617987 duration_in_ms=7138.518
2018-10-14 05:54:17,622 [salt.state       :1770][INFO    ][9575] Running state [rabbit@master] at time 05:54:17.622859
2018-10-14 05:54:17,623 [salt.state       :1803][INFO    ][9575] Executing state rabbitmq_cluster.join for [rabbit@master]
2018-10-14 05:54:17,624 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9575] Executing command ['/usr/sbin/rabbitmqctl', 'cluster_status'] as user 'root' in directory '/root'
2018-10-14 05:54:18,996 [salt.state       :290 ][INFO    ][9575] Already in cluster
2018-10-14 05:54:18,997 [salt.state       :1941][INFO    ][9575] Completed state [rabbit@master] at time 05:54:18.997159 duration_in_ms=1374.3
2018-10-14 05:54:19,000 [salt.minion      :1708][INFO    ][9575] Returning information for job: 20181014055144825452
2018-10-14 05:54:19,832 [salt.minion      :1307][INFO    ][2899] User sudo_ubuntu Executing command cmd.run with jid 20181014055419818247
2018-10-14 05:54:19,853 [salt.minion      :1431][INFO    ][18404] Starting a new job with PID 18404
2018-10-14 05:54:19,862 [salt.loader.192.168.11.2.int.module.cmdmod:395 ][INFO    ][18404] Executing command 'rabbitmqctl cluster_status' in directory '/root'
2018-10-14 05:54:21,088 [salt.minion      :1708][INFO    ][18404] Returning information for job: 20181014055419818247
2018-10-14 06:00:57,654 [salt.minion      :1307][INFO    ][2899] User sudo_ubuntu Executing command state.sls with jid 20181014060057642636
2018-10-14 06:00:57,677 [salt.minion      :1431][INFO    ][18689] Starting a new job with PID 18689
2018-10-14 06:00:58,943 [salt.state       :905 ][INFO    ][18689] Loading fresh modules for state activity
2018-10-14 06:00:58,996 [salt.fileclient  :1215][INFO    ][18689] Fetching file from saltenv 'base', ** done ** 'haproxy/init.sls'
2018-10-14 06:00:59,035 [salt.fileclient  :1215][INFO    ][18689] Fetching file from saltenv 'base', ** done ** 'haproxy/proxy.sls'
2018-10-14 06:00:59,842 [salt.state       :1770][INFO    ][18689] Running state [haproxy] at time 06:00:59.842063
2018-10-14 06:00:59,842 [salt.state       :1803][INFO    ][18689] Executing state pkg.installed for [haproxy]
2018-10-14 06:00:59,843 [salt.loaded.int.module.cmdmod:395 ][INFO    ][18689] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}', '-W'] in directory '/root'
2018-10-14 06:01:00,280 [salt.loaded.int.module.cmdmod:395 ][INFO    ][18689] Executing command ['apt-cache', '-q', 'policy', 'haproxy'] in directory '/root'
2018-10-14 06:01:00,386 [salt.loaded.int.module.cmdmod:395 ][INFO    ][18689] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2018-10-14 06:01:02,742 [salt.loaded.int.module.cmdmod:395 ][INFO    ][18689] Executing command ['dpkg', '--get-selections', '*'] in directory '/root'
2018-10-14 06:01:02,771 [salt.loaded.int.module.cmdmod:395 ][INFO    ][18689] 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-14 06:01:07,152 [salt.loaded.int.module.cmdmod:395 ][INFO    ][18689] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}', '-W'] in directory '/root'
2018-10-14 06:01:07,192 [salt.state       :290 ][INFO    ][18689] 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-14 06:01:07,216 [salt.state       :905 ][INFO    ][18689] Loading fresh modules for state activity
2018-10-14 06:01:07,257 [salt.state       :1941][INFO    ][18689] Completed state [haproxy] at time 06:01:07.257771 duration_in_ms=7415.709
2018-10-14 06:01:07,262 [salt.state       :1770][INFO    ][18689] Running state [/etc/default/haproxy] at time 06:01:07.262714
2018-10-14 06:01:07,263 [salt.state       :1803][INFO    ][18689] Executing state file.managed for [/etc/default/haproxy]
2018-10-14 06:01:07,302 [salt.fileclient  :1215][INFO    ][18689] Fetching file from saltenv 'base', ** done ** 'haproxy/files/haproxy.default'
2018-10-14 06:01:07,306 [salt.state       :290 ][INFO    ][18689] 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-14 06:01:07,309 [salt.state       :1941][INFO    ][18689] Completed state [/etc/default/haproxy] at time 06:01:07.309576 duration_in_ms=46.861
2018-10-14 06:01:07,310 [salt.state       :1770][INFO    ][18689] Running state [/etc/haproxy/haproxy.cfg] at time 06:01:07.310185
2018-10-14 06:01:07,310 [salt.state       :1803][INFO    ][18689] Executing state file.managed for [/etc/haproxy/haproxy.cfg]
2018-10-14 06:01:07,343 [salt.fileclient  :1215][INFO    ][18689] Fetching file from saltenv 'base', ** done ** 'haproxy/files/haproxy.cfg'
2018-10-14 06:01:07,542 [salt.state       :290 ][INFO    ][18689] 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-14 06:01:07,545 [salt.state       :1941][INFO    ][18689] Completed state [/etc/haproxy/haproxy.cfg] at time 06:01:07.545162 duration_in_ms=234.977
2018-10-14 06:01:07,545 [salt.state       :1770][INFO    ][18689] Running state [/etc/haproxy/ssl] at time 06:01:07.545558
2018-10-14 06:01:07,545 [salt.state       :1803][INFO    ][18689] Executing state file.directory for [/etc/haproxy/ssl]
2018-10-14 06:01:07,547 [salt.state       :290 ][INFO    ][18689] {'/etc/haproxy/ssl': 'New Dir'}
2018-10-14 06:01:07,547 [salt.state       :1941][INFO    ][18689] Completed state [/etc/haproxy/ssl] at time 06:01:07.547810 duration_in_ms=2.252
2018-10-14 06:01:07,548 [salt.state       :1770][INFO    ][18689] Running state [/etc/haproxy/errors/429.http11] at time 06:01:07.548142
2018-10-14 06:01:07,549 [salt.state       :1803][INFO    ][18689] Executing state file.managed for [/etc/haproxy/errors/429.http11]
2018-10-14 06:01:07,569 [salt.fileclient  :1215][INFO    ][18689] Fetching file from saltenv 'base', ** done ** 'haproxy/files/errors/429.http11'
2018-10-14 06:01:07,577 [salt.state       :290 ][INFO    ][18689] File changed:
New file
2018-10-14 06:01:07,577 [salt.state       :1941][INFO    ][18689] Completed state [/etc/haproxy/errors/429.http11] at time 06:01:07.577698 duration_in_ms=29.554
2018-10-14 06:01:07,578 [salt.state       :1770][INFO    ][18689] Running state [haproxy_status_packages] at time 06:01:07.578722
2018-10-14 06:01:07,579 [salt.state       :1803][INFO    ][18689] Executing state pkg.installed for [haproxy_status_packages]
2018-10-14 06:01:07,885 [salt.minion      :1307][INFO    ][2899] User sudo_ubuntu Executing command saltutil.find_job with jid 20181014060107772959
2018-10-14 06:01:07,899 [salt.minion      :1431][INFO    ][19633] Starting a new job with PID 19633
2018-10-14 06:01:07,917 [salt.minion      :1708][INFO    ][19633] Returning information for job: 20181014060107772959
2018-10-14 06:01:08,382 [salt.state       :290 ][INFO    ][18689] All specified packages are already installed
2018-10-14 06:01:08,383 [salt.state       :1941][INFO    ][18689] Completed state [haproxy_status_packages] at time 06:01:08.382989 duration_in_ms=804.266
2018-10-14 06:01:08,383 [salt.state       :1770][INFO    ][18689] Running state [/usr/bin/haproxy-status.sh] at time 06:01:08.383881
2018-10-14 06:01:08,384 [salt.state       :1803][INFO    ][18689] Executing state file.managed for [/usr/bin/haproxy-status.sh]
2018-10-14 06:01:08,410 [salt.fileclient  :1215][INFO    ][18689] Fetching file from saltenv 'base', ** done ** 'haproxy/files/haproxy-status.sh'
2018-10-14 06:01:08,441 [salt.state       :290 ][INFO    ][18689] File changed:
New file
2018-10-14 06:01:08,442 [salt.state       :1941][INFO    ][18689] Completed state [/usr/bin/haproxy-status.sh] at time 06:01:08.442193 duration_in_ms=58.311
2018-10-14 06:01:08,442 [salt.state       :1770][INFO    ][18689] Running state [net.ipv4.ip_nonlocal_bind] at time 06:01:08.442908
2018-10-14 06:01:08,443 [salt.state       :1803][INFO    ][18689] Executing state sysctl.present for [net.ipv4.ip_nonlocal_bind]
2018-10-14 06:01:08,444 [salt.loaded.int.module.cmdmod:395 ][INFO    ][18689] Executing command 'sysctl -w net.ipv4.ip_nonlocal_bind="1"' in directory '/root'
2018-10-14 06:01:08,466 [salt.state       :290 ][INFO    ][18689] {'net.ipv4.ip_nonlocal_bind': 1}
2018-10-14 06:01:08,467 [salt.state       :1941][INFO    ][18689] Completed state [net.ipv4.ip_nonlocal_bind] at time 06:01:08.467343 duration_in_ms=24.433
2018-10-14 06:01:08,469 [salt.state       :1770][INFO    ][18689] Running state [haproxy] at time 06:01:08.469744
2018-10-14 06:01:08,470 [salt.state       :1803][INFO    ][18689] Executing state service.running for [haproxy]
2018-10-14 06:01:08,471 [salt.loaded.int.module.cmdmod:395 ][INFO    ][18689] Executing command ['systemctl', 'status', 'haproxy.service', '-n', '0'] in directory '/root'
2018-10-14 06:01:08,493 [salt.loaded.int.module.cmdmod:395 ][INFO    ][18689] Executing command ['systemctl', 'is-active', 'haproxy.service'] in directory '/root'
2018-10-14 06:01:08,511 [salt.loaded.int.module.cmdmod:395 ][INFO    ][18689] Executing command ['systemctl', 'is-enabled', 'haproxy.service'] in directory '/root'
2018-10-14 06:01:08,533 [salt.state       :290 ][INFO    ][18689] The service haproxy is already running
2018-10-14 06:01:08,533 [salt.state       :1941][INFO    ][18689] Completed state [haproxy] at time 06:01:08.533656 duration_in_ms=63.911
2018-10-14 06:01:08,534 [salt.state       :1770][INFO    ][18689] Running state [haproxy] at time 06:01:08.534012
2018-10-14 06:01:08,534 [salt.state       :1803][INFO    ][18689] Executing state service.mod_watch for [haproxy]
2018-10-14 06:01:08,535 [salt.loaded.int.module.cmdmod:395 ][INFO    ][18689] Executing command ['systemctl', 'is-active', 'haproxy.service'] in directory '/root'
2018-10-14 06:01:08,552 [salt.loaded.int.module.cmdmod:395 ][INFO    ][18689] Executing command ['systemd-run', '--scope', 'systemctl', 'restart', 'haproxy.service'] in directory '/root'
2018-10-14 06:01:08,620 [salt.state       :290 ][INFO    ][18689] {'haproxy': True}
2018-10-14 06:01:08,620 [salt.state       :1941][INFO    ][18689] Completed state [haproxy] at time 06:01:08.620805 duration_in_ms=86.792
2018-10-14 06:01:08,623 [salt.minion      :1708][INFO    ][18689] Returning information for job: 20181014060057642636
2018-10-14 06:01:13,025 [salt.minion      :1307][INFO    ][2899] User sudo_ubuntu Executing command service.status with jid 20181014060113013197
2018-10-14 06:01:13,048 [salt.minion      :1431][INFO    ][19692] Starting a new job with PID 19692
2018-10-14 06:01:13,590 [salt.loader.192.168.11.2.int.module.cmdmod:395 ][INFO    ][19692] Executing command ['systemctl', 'status', 'haproxy.service', '-n', '0'] in directory '/root'
2018-10-14 06:01:13,613 [salt.loader.192.168.11.2.int.module.cmdmod:395 ][INFO    ][19692] Executing command ['systemctl', 'is-active', 'haproxy.service'] in directory '/root'
2018-10-14 06:01:13,629 [salt.minion      :1708][INFO    ][19692] Returning information for job: 20181014060113013197
2018-10-14 06:01:14,726 [salt.minion      :1307][INFO    ][2899] User sudo_ubuntu Executing command service.restart with jid 20181014060114714982
2018-10-14 06:01:14,749 [salt.minion      :1431][INFO    ][19704] Starting a new job with PID 19704
2018-10-14 06:01:15,302 [salt.loader.192.168.11.2.int.module.cmdmod:395 ][INFO    ][19704] Executing command ['systemctl', 'status', 'rsyslog.service', '-n', '0'] in directory '/root'
2018-10-14 06:01:15,341 [salt.loader.192.168.11.2.int.module.cmdmod:395 ][INFO    ][19704] Executing command ['systemd-run', '--scope', 'systemctl', 'restart', 'rsyslog.service'] in directory '/root'
2018-10-14 06:01:15,375 [salt.minion      :1708][INFO    ][19704] Returning information for job: 20181014060114714982
2018-10-14 06:33:51,608 [salt.minion      :1307][INFO    ][2899] User sudo_ubuntu Executing command cp.push_dir with jid 20181014063351595032
2018-10-14 06:33:51,632 [salt.minion      :1431][INFO    ][20335] Starting a new job with PID 20335
