2018-10-14 05:34:47,755 [salt.loaded.int.module.cmdmod:722 ][ERROR   ][1883] Command 'rabbitmqctl cluster_status' failed with return code: 127
2018-10-14 05:34:47,757 [salt.loaded.int.module.cmdmod:724 ][ERROR   ][1883] stdout: /bin/sh: 1: rabbitmqctl: not found
2018-10-14 05:34:47,757 [salt.loaded.int.module.cmdmod:728 ][ERROR   ][1883] retcode: 127
2018-10-14 05:34:47,781 [salt.loaded.int.module.cmdmod:722 ][ERROR   ][1883] Command 'rabbitmqctl cluster_status' failed with return code: 127
2018-10-14 05:34:47,781 [salt.loaded.int.module.cmdmod:724 ][ERROR   ][1883] stdout: /bin/sh: 1: rabbitmqctl: not found
2018-10-14 05:34:47,781 [salt.loaded.int.module.cmdmod:728 ][ERROR   ][1883] retcode: 127
2018-10-14 05:34:49,278 [salt.loaded.int.module.cmdmod:722 ][ERROR   ][1883] Command 'rabbitmqctl cluster_status' failed with return code: 127
2018-10-14 05:34:49,279 [salt.loaded.int.module.cmdmod:724 ][ERROR   ][1883] stdout: /bin/sh: 1: rabbitmqctl: not found
2018-10-14 05:34:49,279 [salt.loaded.int.module.cmdmod:728 ][ERROR   ][1883] retcode: 127
2018-10-14 05:34:49,302 [salt.loaded.int.module.cmdmod:722 ][ERROR   ][1883] Command 'rabbitmqctl cluster_status' failed with return code: 127
2018-10-14 05:34:49,303 [salt.loaded.int.module.cmdmod:724 ][ERROR   ][1883] stdout: /bin/sh: 1: rabbitmqctl: not found
2018-10-14 05:34:49,303 [salt.loaded.int.module.cmdmod:728 ][ERROR   ][1883] retcode: 127
2018-10-14 05:35:05,627 [salt.utils.decorators:613 ][WARNING ][1883] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2018-10-14 05:35:09,032 [salt.loaded.int.module.cmdmod:395 ][INFO    ][2953] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2018-10-14 05:35:09,057 [salt.loaded.int.module.cmdmod:395 ][INFO    ][2953] Executing command ['systemd-run', '--scope', 'systemctl', 'restart', 'salt-minion.service'] in directory '/root'
2018-10-14 05:35:09,074 [salt.utils.parsers:1051][WARNING ][1546] Minion received a SIGTERM. Exiting.
2018-10-14 05:35:09,923 [salt.cli.daemons :293 ][INFO    ][3008] Setting up the Salt Minion "msg02.mcp-pike-odl-ha.local"
2018-10-14 05:35:10,032 [salt.cli.daemons :82  ][INFO    ][3008] Starting up the Salt Minion
2018-10-14 05:35:10,033 [salt.utils.event :1017][INFO    ][3008] Starting pull socket on /var/run/salt/minion/minion_event_dda4868e5c_pull.ipc
2018-10-14 05:35:10,680 [salt.minion      :976 ][INFO    ][3008] Creating minion process manager
2018-10-14 05:35:11,898 [salt.loader.192.168.11.2.int.module.cmdmod:395 ][INFO    ][3008] Executing command ['date', '+%z'] in directory '/root'
2018-10-14 05:35:11,916 [salt.utils.schedule:568 ][INFO    ][3008] Updating job settings for scheduled job: __mine_interval
2018-10-14 05:35:11,918 [salt.minion      :1107][INFO    ][3008] Added mine.update to scheduler
2018-10-14 05:35:11,923 [salt.minion      :1965][INFO    ][3008] Minion is starting as user 'root'
2018-10-14 05:35:11,943 [salt.minion      :2324][INFO    ][3008] Minion is ready to receive requests!
2018-10-14 05:35:36,862 [salt.minion      :1307][INFO    ][3008] User sudo_ubuntu Executing command state.apply with jid 20181014053536849187
2018-10-14 05:35:36,878 [salt.minion      :1431][INFO    ][3096] Starting a new job with PID 3096
2018-10-14 05:35:42,504 [salt.state       :905 ][INFO    ][3096] Loading fresh modules for state activity
2018-10-14 05:35:43,008 [salt.fileclient  :1215][INFO    ][3096] Fetching file from saltenv 'base', ** done ** 'linux/init.sls'
2018-10-14 05:35:43,150 [salt.fileclient  :1215][INFO    ][3096] Fetching file from saltenv 'base', ** done ** 'linux/system/init.sls'
2018-10-14 05:35:43,312 [salt.fileclient  :1215][INFO    ][3096] Fetching file from saltenv 'base', ** done ** 'linux/system/env.sls'
2018-10-14 05:35:43,446 [salt.fileclient  :1215][INFO    ][3096] Fetching file from saltenv 'base', ** done ** 'linux/system/profile.sls'
2018-10-14 05:35:43,575 [salt.fileclient  :1215][INFO    ][3096] Fetching file from saltenv 'base', ** done ** 'linux/system/shell.sls'
2018-10-14 05:35:43,724 [salt.fileclient  :1215][INFO    ][3096] Fetching file from saltenv 'base', ** done ** 'linux/system/at.sls'
2018-10-14 05:35:43,863 [salt.fileclient  :1215][INFO    ][3096] Fetching file from saltenv 'base', ** done ** 'linux/system/cron.sls'
2018-10-14 05:35:43,991 [salt.fileclient  :1215][INFO    ][3096] Fetching file from saltenv 'base', ** done ** 'linux/system/repo.sls'
2018-10-14 05:35:44,238 [salt.fileclient  :1215][INFO    ][3096] Fetching file from saltenv 'base', ** done ** 'linux/system/package.sls'
2018-10-14 05:35:44,385 [salt.fileclient  :1215][INFO    ][3096] Fetching file from saltenv 'base', ** done ** 'linux/system/timezone.sls'
2018-10-14 05:35:44,520 [salt.fileclient  :1215][INFO    ][3096] Fetching file from saltenv 'base', ** done ** 'linux/system/kernel.sls'
2018-10-14 05:35:44,688 [salt.fileclient  :1215][INFO    ][3096] Fetching file from saltenv 'base', ** done ** 'linux/system/grub.sls'
2018-10-14 05:35:44,721 [salt.fileclient  :1215][INFO    ][3096] Fetching file from saltenv 'base', ** done ** 'linux/system/cpu.sls'
2018-10-14 05:35:44,854 [salt.fileclient  :1215][INFO    ][3096] Fetching file from saltenv 'base', ** done ** 'linux/system/sysfs.sls'
2018-10-14 05:35:44,986 [salt.fileclient  :1215][INFO    ][3096] Fetching file from saltenv 'base', ** done ** 'linux/system/locale.sls'
2018-10-14 05:35:45,973 [salt.fileclient  :1215][INFO    ][3096] Fetching file from saltenv 'base', ** done ** 'linux/system/user.sls'
2018-10-14 05:35:46,132 [salt.fileclient  :1215][INFO    ][3096] Fetching file from saltenv 'base', ** done ** 'linux/system/group.sls'
2018-10-14 05:35:46,271 [salt.fileclient  :1215][INFO    ][3096] Fetching file from saltenv 'base', ** done ** 'linux/system/limit.sls'
2018-10-14 05:35:46,386 [salt.fileclient  :1215][INFO    ][3096] Fetching file from saltenv 'base', ** done ** 'linux/system/systemd.sls'
2018-10-14 05:35:46,671 [salt.fileclient  :1215][INFO    ][3096] Fetching file from saltenv 'base', ** done ** 'linux/system/apt.sls'
2018-10-14 05:35:46,813 [salt.fileclient  :1215][INFO    ][3096] Fetching file from saltenv 'base', ** done ** 'linux/system/banner.sls'
2018-10-14 05:35:46,948 [salt.fileclient  :1215][INFO    ][3096] Fetching file from saltenv 'base', ** done ** 'linux/network/init.sls'
2018-10-14 05:35:46,972 [salt.minion      :1307][INFO    ][3008] User sudo_ubuntu Executing command saltutil.find_job with jid 20181014053546955544
2018-10-14 05:35:46,994 [salt.minion      :1431][INFO    ][3147] Starting a new job with PID 3147
2018-10-14 05:35:47,023 [salt.minion      :1708][INFO    ][3147] Returning information for job: 20181014053546955544
2018-10-14 05:35:47,087 [salt.fileclient  :1215][INFO    ][3096] Fetching file from saltenv 'base', ** done ** 'linux/network/hostname.sls'
2018-10-14 05:35:47,250 [salt.fileclient  :1215][INFO    ][3096] Fetching file from saltenv 'base', ** done ** 'linux/network/host.sls'
2018-10-14 05:35:47,438 [salt.fileclient  :1215][INFO    ][3096] Fetching file from saltenv 'base', ** done ** 'linux/network/interface.sls'
2018-10-14 05:35:48,623 [salt.fileclient  :1215][INFO    ][3096] Fetching file from saltenv 'base', ** done ** 'linux/network/proxy.sls'
2018-10-14 05:35:48,762 [salt.fileclient  :1215][INFO    ][3096] Fetching file from saltenv 'base', ** done ** 'linux/storage/init.sls'
2018-10-14 05:35:48,904 [salt.fileclient  :1215][INFO    ][3096] Fetching file from saltenv 'base', ** done ** 'ntp/init.sls'
2018-10-14 05:35:48,932 [salt.fileclient  :1215][INFO    ][3096] Fetching file from saltenv 'base', ** done ** 'ntp/client.sls'
2018-10-14 05:35:49,583 [salt.fileclient  :1215][INFO    ][3096] Fetching file from saltenv 'base', ** done ** 'ntp/server.sls'
2018-10-14 05:35:49,631 [salt.state       :1770][INFO    ][3096] Running state [/etc/environment] at time 05:35:49.631899
2018-10-14 05:35:49,632 [salt.state       :1803][INFO    ][3096] Executing state file.blockreplace for [/etc/environment]
2018-10-14 05:35:49,640 [salt.state       :290 ][INFO    ][3096] 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,640 [salt.state       :1941][INFO    ][3096] Completed state [/etc/environment] at time 05:35:49.640426 duration_in_ms=8.527
2018-10-14 05:35:49,640 [salt.state       :1770][INFO    ][3096] Running state [/etc/profile.d] at time 05:35:49.640674
2018-10-14 05:35:49,640 [salt.state       :1803][INFO    ][3096] Executing state file.directory for [/etc/profile.d]
2018-10-14 05:35:49,643 [salt.state       :290 ][INFO    ][3096] Directory /etc/profile.d is in the correct state
Directory /etc/profile.d updated
2018-10-14 05:35:49,643 [salt.state       :1941][INFO    ][3096] Completed state [/etc/profile.d] at time 05:35:49.643274 duration_in_ms=2.601
2018-10-14 05:35:49,644 [salt.state       :1770][INFO    ][3096] Running state [fake_linux_system_at] at time 05:35:49.644287
2018-10-14 05:35:49,644 [salt.state       :1803][INFO    ][3096] Executing state test.nop for [fake_linux_system_at]
2018-10-14 05:35:49,644 [salt.state       :290 ][INFO    ][3096] Success!
2018-10-14 05:35:49,644 [salt.state       :1941][INFO    ][3096] Completed state [fake_linux_system_at] at time 05:35:49.644944 duration_in_ms=0.657
2018-10-14 05:35:49,645 [salt.state       :1770][INFO    ][3096] Running state [fake_linux_system_cron] at time 05:35:49.645152
2018-10-14 05:35:49,645 [salt.state       :1803][INFO    ][3096] Executing state test.nop for [fake_linux_system_cron]
2018-10-14 05:35:49,645 [salt.state       :290 ][INFO    ][3096] Success!
2018-10-14 05:35:49,645 [salt.state       :1941][INFO    ][3096] Completed state [fake_linux_system_cron] at time 05:35:49.645823 duration_in_ms=0.671
2018-10-14 05:35:50,271 [salt.state       :1770][INFO    ][3096] Running state [/etc/apt/apt.conf.d/99prefer_ipv4-salt] at time 05:35:50.271633
2018-10-14 05:35:50,272 [salt.state       :1803][INFO    ][3096] Executing state file.managed for [/etc/apt/apt.conf.d/99prefer_ipv4-salt]
2018-10-14 05:35:50,300 [salt.fileclient  :1215][INFO    ][3096] Fetching file from saltenv 'base', ** done ** 'linux/files/apt.conf'
2018-10-14 05:35:50,363 [salt.state       :290 ][INFO    ][3096] File changed:
New file
2018-10-14 05:35:50,363 [salt.state       :1941][INFO    ][3096] Completed state [/etc/apt/apt.conf.d/99prefer_ipv4-salt] at time 05:35:50.363601 duration_in_ms=91.968
2018-10-14 05:35:50,363 [salt.state       :1770][INFO    ][3096] Running state [/etc/apt/apt.conf.d/99allow_downgrades-salt] at time 05:35:50.363841
2018-10-14 05:35:50,364 [salt.state       :1803][INFO    ][3096] Executing state file.managed for [/etc/apt/apt.conf.d/99allow_downgrades-salt]
2018-10-14 05:35:50,389 [salt.state       :290 ][INFO    ][3096] File changed:
New file
2018-10-14 05:35:50,389 [salt.state       :1941][INFO    ][3096] Completed state [/etc/apt/apt.conf.d/99allow_downgrades-salt] at time 05:35:50.389711 duration_in_ms=25.87
2018-10-14 05:35:50,391 [salt.state       :1770][INFO    ][3096] Running state [linux_repo_prereq_pkgs] at time 05:35:50.391103
2018-10-14 05:35:50,391 [salt.state       :1803][INFO    ][3096] Executing state pkg.installed for [linux_repo_prereq_pkgs]
2018-10-14 05:35:50,391 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3096] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}', '-W'] in directory '/root'
2018-10-14 05:35:50,765 [salt.state       :290 ][INFO    ][3096] All specified packages are already installed
2018-10-14 05:35:50,766 [salt.state       :1941][INFO    ][3096] Completed state [linux_repo_prereq_pkgs] at time 05:35:50.766530 duration_in_ms=375.426
2018-10-14 05:35:50,766 [salt.state       :1770][INFO    ][3096] Running state [/etc/apt/apt.conf.d/99proxies-salt] at time 05:35:50.766922
2018-10-14 05:35:50,767 [salt.state       :1803][INFO    ][3096] Executing state file.managed for [/etc/apt/apt.conf.d/99proxies-salt]
2018-10-14 05:35:50,788 [salt.fileclient  :1215][INFO    ][3096] Fetching file from saltenv 'base', ** done ** 'linux/files/apt.conf.d_proxies'
2018-10-14 05:35:50,808 [salt.state       :290 ][INFO    ][3096] File changed:
New file
2018-10-14 05:35:50,808 [salt.state       :1941][INFO    ][3096] Completed state [/etc/apt/apt.conf.d/99proxies-salt] at time 05:35:50.808283 duration_in_ms=41.361
2018-10-14 05:35:50,808 [salt.state       :1770][INFO    ][3096] Running state [/etc/apt/apt.conf.d/99proxies-salt-mk_openstack] at time 05:35:50.808566
2018-10-14 05:35:50,808 [salt.state       :1803][INFO    ][3096] Executing state file.absent for [/etc/apt/apt.conf.d/99proxies-salt-mk_openstack]
2018-10-14 05:35:50,809 [salt.state       :290 ][INFO    ][3096] File /etc/apt/apt.conf.d/99proxies-salt-mk_openstack is not present
2018-10-14 05:35:50,809 [salt.state       :1941][INFO    ][3096] Completed state [/etc/apt/apt.conf.d/99proxies-salt-mk_openstack] at time 05:35:50.809401 duration_in_ms=0.835
2018-10-14 05:35:50,810 [salt.state       :1770][INFO    ][3096] Running state [/etc/apt/preferences.d/mk_openstack] at time 05:35:50.810403
2018-10-14 05:35:50,810 [salt.state       :1803][INFO    ][3096] Executing state file.managed for [/etc/apt/preferences.d/mk_openstack]
2018-10-14 05:35:50,839 [salt.fileclient  :1215][INFO    ][3096] Fetching file from saltenv 'base', ** done ** 'linux/files/preferences_repo'
2018-10-14 05:35:51,248 [salt.state       :290 ][INFO    ][3096] File changed:
New file
2018-10-14 05:35:51,248 [salt.state       :1941][INFO    ][3096] Completed state [/etc/apt/preferences.d/mk_openstack] at time 05:35:51.248846 duration_in_ms=438.443
2018-10-14 05:35:51,253 [salt.state       :1770][INFO    ][3096] Running state [deb [arch=amd64] http://apt.mirantis.com/xenial/ nightly pike] at time 05:35:51.253415
2018-10-14 05:35:51,253 [salt.state       :1803][INFO    ][3096] Executing state pkgrepo.managed for [deb [arch=amd64] http://apt.mirantis.com/xenial/ nightly pike]
2018-10-14 05:35:51,652 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3096] 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:51,892 [salt.state       :290 ][INFO    ][3096] {'repo': 'deb [arch=amd64] http://apt.mirantis.com/xenial nightly pike'}
2018-10-14 05:35:51,893 [salt.state       :1941][INFO    ][3096] Completed state [deb [arch=amd64] http://apt.mirantis.com/xenial/ nightly pike] at time 05:35:51.893047 duration_in_ms=639.631
2018-10-14 05:35:51,893 [salt.state       :1770][INFO    ][3096] Running state [/etc/apt/apt.conf.d/99proxies-salt-uca-staging] at time 05:35:51.893394
2018-10-14 05:35:51,893 [salt.state       :1803][INFO    ][3096] Executing state file.absent for [/etc/apt/apt.conf.d/99proxies-salt-uca-staging]
2018-10-14 05:35:51,894 [salt.state       :290 ][INFO    ][3096] File /etc/apt/apt.conf.d/99proxies-salt-uca-staging is not present
2018-10-14 05:35:51,894 [salt.state       :1941][INFO    ][3096] Completed state [/etc/apt/apt.conf.d/99proxies-salt-uca-staging] at time 05:35:51.894461 duration_in_ms=1.067
2018-10-14 05:35:51,894 [salt.state       :1770][INFO    ][3096] Running state [/etc/apt/preferences.d/uca-staging] at time 05:35:51.894676
2018-10-14 05:35:51,894 [salt.state       :1803][INFO    ][3096] Executing state file.absent for [/etc/apt/preferences.d/uca-staging]
2018-10-14 05:35:51,895 [salt.state       :290 ][INFO    ][3096] File /etc/apt/preferences.d/uca-staging is not present
2018-10-14 05:35:51,895 [salt.state       :1941][INFO    ][3096] Completed state [/etc/apt/preferences.d/uca-staging] at time 05:35:51.895405 duration_in_ms=0.73
2018-10-14 05:35:51,900 [salt.state       :1770][INFO    ][3096] Running state [apt-key adv --keyserver keyserver.ubuntu.com --recv 9F68104E] at time 05:35:51.900560
2018-10-14 05:35:51,900 [salt.state       :1803][INFO    ][3096] Executing state cmd.run for [apt-key adv --keyserver keyserver.ubuntu.com --recv 9F68104E]
2018-10-14 05:35:51,901 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3096] Executing command 'test -e /etc/apt/sources.list.d/uca-staging.list' in directory '/root'
2018-10-14 05:35:51,913 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3096] Executing command 'apt-key adv --keyserver keyserver.ubuntu.com --recv 9F68104E' in directory '/root'
2018-10-14 05:35:52,140 [salt.state       :290 ][INFO    ][3096] {'pid': 3312, '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.ejNuFMyUKu/gpg.1.sh --keyserver\nkeyserver.ubuntu.com\n--recv\n9F68104E'}
2018-10-14 05:35:52,140 [salt.state       :1941][INFO    ][3096] Completed state [apt-key adv --keyserver keyserver.ubuntu.com --recv 9F68104E] at time 05:35:52.140658 duration_in_ms=240.098
2018-10-14 05:35:52,143 [salt.state       :1770][INFO    ][3096] Running state [deb http://ppa.launchpad.net/ubuntu-cloud-archive/pike-staging/ubuntu xenial main] at time 05:35:52.143728
2018-10-14 05:35:52,144 [salt.state       :1803][INFO    ][3096] Executing state pkgrepo.managed for [deb http://ppa.launchpad.net/ubuntu-cloud-archive/pike-staging/ubuntu xenial main]
2018-10-14 05:35:52,246 [salt.state       :290 ][INFO    ][3096] {'repo': 'deb http://ppa.launchpad.net/ubuntu-cloud-archive/pike-staging/ubuntu xenial main'}
2018-10-14 05:35:52,246 [salt.state       :1941][INFO    ][3096] Completed state [deb http://ppa.launchpad.net/ubuntu-cloud-archive/pike-staging/ubuntu xenial main] at time 05:35:52.246484 duration_in_ms=102.756
2018-10-14 05:35:52,246 [salt.state       :1770][INFO    ][3096] Running state [/etc/apt/apt.conf.d/99proxies-salt-mirantis_openstack] at time 05:35:52.246726
2018-10-14 05:35:52,246 [salt.state       :1803][INFO    ][3096] Executing state file.absent for [/etc/apt/apt.conf.d/99proxies-salt-mirantis_openstack]
2018-10-14 05:35:52,247 [salt.state       :290 ][INFO    ][3096] File /etc/apt/apt.conf.d/99proxies-salt-mirantis_openstack is not present
2018-10-14 05:35:52,247 [salt.state       :1941][INFO    ][3096] Completed state [/etc/apt/apt.conf.d/99proxies-salt-mirantis_openstack] at time 05:35:52.247583 duration_in_ms=0.857
2018-10-14 05:35:52,247 [salt.state       :1770][INFO    ][3096] Running state [/etc/apt/preferences.d/mirantis_openstack] at time 05:35:52.247797
2018-10-14 05:35:52,248 [salt.state       :1803][INFO    ][3096] Executing state file.managed for [/etc/apt/preferences.d/mirantis_openstack]
2018-10-14 05:35:52,371 [salt.state       :290 ][INFO    ][3096] File changed:
New file
2018-10-14 05:35:52,371 [salt.state       :1941][INFO    ][3096] Completed state [/etc/apt/preferences.d/mirantis_openstack] at time 05:35:52.371886 duration_in_ms=124.089
2018-10-14 05:35:52,373 [salt.state       :1770][INFO    ][3096] Running state [deb http://mirror.fuel-infra.org/mcp-repos/pike/xenial pike main] at time 05:35:52.373872
2018-10-14 05:35:52,374 [salt.state       :1803][INFO    ][3096] Executing state pkgrepo.managed for [deb http://mirror.fuel-infra.org/mcp-repos/pike/xenial pike main]
2018-10-14 05:35:52,526 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3096] 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,741 [salt.state       :290 ][INFO    ][3096] {'repo': 'deb http://mirror.fuel-infra.org/mcp-repos/pike/xenial pike main'}
2018-10-14 05:35:52,742 [salt.state       :1941][INFO    ][3096] Completed state [deb http://mirror.fuel-infra.org/mcp-repos/pike/xenial pike main] at time 05:35:52.742437 duration_in_ms=368.563
2018-10-14 05:35:52,742 [salt.state       :1770][INFO    ][3096] Running state [/etc/apt/apt.conf.d/99proxies-salt-uca] at time 05:35:52.742864
2018-10-14 05:35:52,743 [salt.state       :1803][INFO    ][3096] Executing state file.absent for [/etc/apt/apt.conf.d/99proxies-salt-uca]
2018-10-14 05:35:52,743 [salt.state       :290 ][INFO    ][3096] File /etc/apt/apt.conf.d/99proxies-salt-uca is not present
2018-10-14 05:35:52,744 [salt.state       :1941][INFO    ][3096] Completed state [/etc/apt/apt.conf.d/99proxies-salt-uca] at time 05:35:52.744040 duration_in_ms=1.176
2018-10-14 05:35:52,744 [salt.state       :1770][INFO    ][3096] Running state [/etc/apt/preferences.d/uca] at time 05:35:52.744280
2018-10-14 05:35:52,744 [salt.state       :1803][INFO    ][3096] Executing state file.managed for [/etc/apt/preferences.d/uca]
2018-10-14 05:35:52,883 [salt.state       :290 ][INFO    ][3096] File changed:
New file
2018-10-14 05:35:52,883 [salt.state       :1941][INFO    ][3096] Completed state [/etc/apt/preferences.d/uca] at time 05:35:52.883395 duration_in_ms=139.115
2018-10-14 05:35:52,888 [salt.state       :1770][INFO    ][3096] Running state [apt-key adv --keyserver keyserver.ubuntu.com --recv EC4926EA] at time 05:35:52.888093
2018-10-14 05:35:52,888 [salt.state       :1803][INFO    ][3096] Executing state cmd.run for [apt-key adv --keyserver keyserver.ubuntu.com --recv EC4926EA]
2018-10-14 05:35:52,889 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3096] Executing command 'test -e /etc/apt/sources.list.d/uca.list' in directory '/root'
2018-10-14 05:35:52,904 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3096] Executing command 'apt-key adv --keyserver keyserver.ubuntu.com --recv EC4926EA' in directory '/root'
2018-10-14 05:35:53,130 [salt.state       :290 ][INFO    ][3096] {'pid': 3593, '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.EUcjGIYVwb/gpg.1.sh --keyserver\nkeyserver.ubuntu.com\n--recv\nEC4926EA'}
2018-10-14 05:35:53,130 [salt.state       :1941][INFO    ][3096] Completed state [apt-key adv --keyserver keyserver.ubuntu.com --recv EC4926EA] at time 05:35:53.130672 duration_in_ms=242.578
2018-10-14 05:35:53,134 [salt.state       :1770][INFO    ][3096] Running state [deb http://ubuntu-cloud.archive.canonical.com/ubuntu xenial-updates/pike main] at time 05:35:53.134676
2018-10-14 05:35:53,135 [salt.state       :1803][INFO    ][3096] Executing state pkgrepo.managed for [deb http://ubuntu-cloud.archive.canonical.com/ubuntu xenial-updates/pike main]
2018-10-14 05:35:53,328 [salt.state       :290 ][INFO    ][3096] {'repo': 'deb http://ubuntu-cloud.archive.canonical.com/ubuntu xenial-updates/pike main'}
2018-10-14 05:35:53,329 [salt.state       :1941][INFO    ][3096] Completed state [deb http://ubuntu-cloud.archive.canonical.com/ubuntu xenial-updates/pike main] at time 05:35:53.329276 duration_in_ms=194.598
2018-10-14 05:35:53,330 [salt.state       :1770][INFO    ][3096] Running state [pkg.refresh_db] at time 05:35:53.330609
2018-10-14 05:35:53,330 [salt.state       :1803][INFO    ][3096] Executing state module.run for [pkg.refresh_db]
2018-10-14 05:35:53,331 [salt.utils.decorators:613 ][WARNING ][3096] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2018-10-14 05:35:53,331 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3096] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2018-10-14 05:35:57,145 [salt.minion      :1307][INFO    ][3008] User sudo_ubuntu Executing command saltutil.find_job with jid 20181014053557133997
2018-10-14 05:35:57,168 [salt.minion      :1431][INFO    ][4169] Starting a new job with PID 4169
2018-10-14 05:35:57,191 [salt.minion      :1708][INFO    ][4169] Returning information for job: 20181014053557133997
2018-10-14 05:35:57,686 [salt.state       :290 ][INFO    ][3096] {'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:57,688 [salt.state       :1941][INFO    ][3096] Completed state [pkg.refresh_db] at time 05:35:57.688100 duration_in_ms=4357.489
2018-10-14 05:35:57,690 [salt.state       :1770][INFO    ][3096] Running state [UTC] at time 05:35:57.690085
2018-10-14 05:35:57,690 [salt.state       :1803][INFO    ][3096] Executing state timezone.system for [UTC]
2018-10-14 05:35:57,691 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3096] Executing command ['timedatectl'] in directory '/root'
2018-10-14 05:35:57,731 [salt.state       :290 ][INFO    ][3096] Timezone UTC already set, UTC already set to UTC
2018-10-14 05:35:57,731 [salt.state       :1941][INFO    ][3096] Completed state [UTC] at time 05:35:57.731503 duration_in_ms=41.418
2018-10-14 05:35:57,731 [salt.state       :1770][INFO    ][3096] Running state [/etc/default/grub.d] at time 05:35:57.731897
2018-10-14 05:35:57,732 [salt.state       :1803][INFO    ][3096] Executing state file.directory for [/etc/default/grub.d]
2018-10-14 05:35:57,733 [salt.state       :290 ][INFO    ][3096] Directory /etc/default/grub.d is in the correct state
Directory /etc/default/grub.d updated
2018-10-14 05:35:57,734 [salt.state       :1941][INFO    ][3096] Completed state [/etc/default/grub.d] at time 05:35:57.734427 duration_in_ms=2.53
2018-10-14 05:35:57,734 [salt.state       :1770][INFO    ][3096] Running state [update-grub] at time 05:35:57.734676
2018-10-14 05:35:57,734 [salt.state       :1803][INFO    ][3096] Executing state cmd.wait for [update-grub]
2018-10-14 05:35:57,735 [salt.state       :290 ][INFO    ][3096] No changes made for update-grub
2018-10-14 05:35:57,735 [salt.state       :1941][INFO    ][3096] Completed state [update-grub] at time 05:35:57.735372 duration_in_ms=0.696
2018-10-14 05:35:57,736 [salt.state       :1770][INFO    ][3096] Running state [/boot/grub/grub.cfg] at time 05:35:57.736877
2018-10-14 05:35:57,737 [salt.state       :1803][INFO    ][3096] Executing state file.managed for [/boot/grub/grub.cfg]
2018-10-14 05:35:57,927 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3096] Executing command ['git', '--version'] in directory '/root'
2018-10-14 05:35:58,224 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3096] Executing command 'test -f /boot/grub/grub.cfg' in directory '/root'
2018-10-14 05:35:58,236 [salt.loaded.int.states.file:2150][WARNING ][3096] 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,238 [salt.state       :290 ][INFO    ][3096] {'mode': '0400'}
2018-10-14 05:35:58,238 [salt.state       :1941][INFO    ][3096] Completed state [/boot/grub/grub.cfg] at time 05:35:58.238474 duration_in_ms=501.595
2018-10-14 05:35:58,238 [salt.state       :1770][INFO    ][3096] Running state [nf_conntrack] at time 05:35:58.238844
2018-10-14 05:35:58,239 [salt.state       :1803][INFO    ][3096] Executing state kmod.present for [nf_conntrack]
2018-10-14 05:35:58,239 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3096] Executing command 'lsmod' in directory '/root'
2018-10-14 05:35:58,662 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3096] Executing command 'lsmod' in directory '/root'
2018-10-14 05:35:58,677 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3096] Executing command 'modprobe nf_conntrack' in directory '/root'
2018-10-14 05:35:58,695 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3096] Executing command 'lsmod' in directory '/root'
2018-10-14 05:35:58,795 [salt.state       :290 ][INFO    ][3096] {'nf_conntrack': 'loaded'}
2018-10-14 05:35:58,796 [salt.state       :1941][INFO    ][3096] Completed state [nf_conntrack] at time 05:35:58.796116 duration_in_ms=557.272
2018-10-14 05:35:58,796 [salt.state       :1770][INFO    ][3096] Running state [kernel.panic] at time 05:35:58.796459
2018-10-14 05:35:58,796 [salt.state       :1803][INFO    ][3096] Executing state sysctl.present for [kernel.panic]
2018-10-14 05:35:58,811 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3096] Executing command 'sysctl -w kernel.panic="60"' in directory '/root'
2018-10-14 05:35:58,824 [salt.state       :290 ][INFO    ][3096] {'kernel.panic': 60}
2018-10-14 05:35:58,824 [salt.state       :1941][INFO    ][3096] Completed state [kernel.panic] at time 05:35:58.824805 duration_in_ms=28.346
2018-10-14 05:35:58,825 [salt.state       :1770][INFO    ][3096] Running state [net.ipv4.tcp_keepalive_probes] at time 05:35:58.825136
2018-10-14 05:35:58,825 [salt.state       :1803][INFO    ][3096] Executing state sysctl.present for [net.ipv4.tcp_keepalive_probes]
2018-10-14 05:35:58,826 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3096] Executing command 'sysctl -w net.ipv4.tcp_keepalive_probes="8"' in directory '/root'
2018-10-14 05:35:58,840 [salt.state       :290 ][INFO    ][3096] {'net.ipv4.tcp_keepalive_probes': 8}
2018-10-14 05:35:58,841 [salt.state       :1941][INFO    ][3096] Completed state [net.ipv4.tcp_keepalive_probes] at time 05:35:58.841191 duration_in_ms=16.055
2018-10-14 05:35:58,842 [salt.state       :1770][INFO    ][3096] Running state [fs.file-max] at time 05:35:58.842396
2018-10-14 05:35:58,842 [salt.state       :1803][INFO    ][3096] Executing state sysctl.present for [fs.file-max]
2018-10-14 05:35:58,844 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3096] Executing command 'sysctl -w fs.file-max="124165"' in directory '/root'
2018-10-14 05:35:58,859 [salt.state       :290 ][INFO    ][3096] {'fs.file-max': 124165}
2018-10-14 05:35:58,860 [salt.state       :1941][INFO    ][3096] Completed state [fs.file-max] at time 05:35:58.859898 duration_in_ms=17.501
2018-10-14 05:35:58,860 [salt.state       :1770][INFO    ][3096] Running state [net.core.somaxconn] at time 05:35:58.860626
2018-10-14 05:35:58,861 [salt.state       :1803][INFO    ][3096] Executing state sysctl.present for [net.core.somaxconn]
2018-10-14 05:35:58,862 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3096] Executing command 'sysctl -w net.core.somaxconn="4096"' in directory '/root'
2018-10-14 05:35:58,879 [salt.state       :290 ][INFO    ][3096] {'net.core.somaxconn': 4096}
2018-10-14 05:35:58,879 [salt.state       :1941][INFO    ][3096] Completed state [net.core.somaxconn] at time 05:35:58.879391 duration_in_ms=18.767
2018-10-14 05:35:58,879 [salt.state       :1770][INFO    ][3096] Running state [net.ipv4.tcp_max_syn_backlog] at time 05:35:58.879740
2018-10-14 05:35:58,880 [salt.state       :1803][INFO    ][3096] Executing state sysctl.present for [net.ipv4.tcp_max_syn_backlog]
2018-10-14 05:35:58,880 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3096] Executing command 'sysctl -w net.ipv4.tcp_max_syn_backlog="8192"' in directory '/root'
2018-10-14 05:35:58,892 [salt.state       :290 ][INFO    ][3096] {'net.ipv4.tcp_max_syn_backlog': 8192}
2018-10-14 05:35:58,892 [salt.state       :1941][INFO    ][3096] Completed state [net.ipv4.tcp_max_syn_backlog] at time 05:35:58.892518 duration_in_ms=12.778
2018-10-14 05:35:58,892 [salt.state       :1770][INFO    ][3096] Running state [net.ipv4.tcp_tw_reuse] at time 05:35:58.892872
2018-10-14 05:35:58,893 [salt.state       :1803][INFO    ][3096] Executing state sysctl.present for [net.ipv4.tcp_tw_reuse]
2018-10-14 05:35:58,894 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3096] Executing command 'sysctl -w net.ipv4.tcp_tw_reuse="1"' in directory '/root'
2018-10-14 05:35:58,910 [salt.state       :290 ][INFO    ][3096] {'net.ipv4.tcp_tw_reuse': 1}
2018-10-14 05:35:58,910 [salt.state       :1941][INFO    ][3096] Completed state [net.ipv4.tcp_tw_reuse] at time 05:35:58.910602 duration_in_ms=17.729
2018-10-14 05:35:58,911 [salt.state       :1770][INFO    ][3096] Running state [net.ipv4.tcp_congestion_control] at time 05:35:58.911160
2018-10-14 05:35:58,911 [salt.state       :1803][INFO    ][3096] Executing state sysctl.present for [net.ipv4.tcp_congestion_control]
2018-10-14 05:35:58,912 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3096] Executing command 'sysctl -w net.ipv4.tcp_congestion_control="yeah"' in directory '/root'
2018-10-14 05:35:58,933 [salt.state       :290 ][INFO    ][3096] {'net.ipv4.tcp_congestion_control': 'yeah'}
2018-10-14 05:35:58,933 [salt.state       :1941][INFO    ][3096] Completed state [net.ipv4.tcp_congestion_control] at time 05:35:58.933516 duration_in_ms=22.356
2018-10-14 05:35:58,933 [salt.state       :1770][INFO    ][3096] Running state [net.ipv4.tcp_retries2] at time 05:35:58.933896
2018-10-14 05:35:58,934 [salt.state       :1803][INFO    ][3096] Executing state sysctl.present for [net.ipv4.tcp_retries2]
2018-10-14 05:35:58,935 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3096] Executing command 'sysctl -w net.ipv4.tcp_retries2="5"' in directory '/root'
2018-10-14 05:35:58,949 [salt.state       :290 ][INFO    ][3096] {'net.ipv4.tcp_retries2': 5}
2018-10-14 05:35:58,949 [salt.state       :1941][INFO    ][3096] Completed state [net.ipv4.tcp_retries2] at time 05:35:58.949718 duration_in_ms=15.822
2018-10-14 05:35:58,950 [salt.state       :1770][INFO    ][3096] Running state [net.core.netdev_max_backlog] at time 05:35:58.950088
2018-10-14 05:35:58,950 [salt.state       :1803][INFO    ][3096] Executing state sysctl.present for [net.core.netdev_max_backlog]
2018-10-14 05:35:58,951 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3096] Executing command 'sysctl -w net.core.netdev_max_backlog="261144"' in directory '/root'
2018-10-14 05:35:58,962 [salt.state       :290 ][INFO    ][3096] {'net.core.netdev_max_backlog': 261144}
2018-10-14 05:35:58,963 [salt.state       :1941][INFO    ][3096] Completed state [net.core.netdev_max_backlog] at time 05:35:58.963243 duration_in_ms=13.154
2018-10-14 05:35:58,963 [salt.state       :1770][INFO    ][3096] Running state [net.ipv4.tcp_slow_start_after_idle] at time 05:35:58.963605
2018-10-14 05:35:58,963 [salt.state       :1803][INFO    ][3096] Executing state sysctl.present for [net.ipv4.tcp_slow_start_after_idle]
2018-10-14 05:35:58,964 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3096] Executing command 'sysctl -w net.ipv4.tcp_slow_start_after_idle="0"' in directory '/root'
2018-10-14 05:35:58,976 [salt.state       :290 ][INFO    ][3096] {'net.ipv4.tcp_slow_start_after_idle': 0}
2018-10-14 05:35:58,976 [salt.state       :1941][INFO    ][3096] Completed state [net.ipv4.tcp_slow_start_after_idle] at time 05:35:58.976641 duration_in_ms=13.035
2018-10-14 05:35:58,977 [salt.state       :1770][INFO    ][3096] Running state [vm.swappiness] at time 05:35:58.976995
2018-10-14 05:35:58,977 [salt.state       :1803][INFO    ][3096] Executing state sysctl.present for [vm.swappiness]
2018-10-14 05:35:58,978 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3096] Executing command 'sysctl -w vm.swappiness="10"' in directory '/root'
2018-10-14 05:35:58,991 [salt.state       :290 ][INFO    ][3096] {'vm.swappiness': 10}
2018-10-14 05:35:58,991 [salt.state       :1941][INFO    ][3096] Completed state [vm.swappiness] at time 05:35:58.991643 duration_in_ms=14.647
2018-10-14 05:35:58,992 [salt.state       :1770][INFO    ][3096] Running state [net.ipv4.tcp_keepalive_intvl] at time 05:35:58.992072
2018-10-14 05:35:58,992 [salt.state       :1803][INFO    ][3096] Executing state sysctl.present for [net.ipv4.tcp_keepalive_intvl]
2018-10-14 05:35:58,994 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3096] Executing command 'sysctl -w net.ipv4.tcp_keepalive_intvl="3"' in directory '/root'
2018-10-14 05:35:59,011 [salt.state       :290 ][INFO    ][3096] {'net.ipv4.tcp_keepalive_intvl': 3}
2018-10-14 05:35:59,011 [salt.state       :1941][INFO    ][3096] Completed state [net.ipv4.tcp_keepalive_intvl] at time 05:35:59.011579 duration_in_ms=19.507
2018-10-14 05:35:59,012 [salt.state       :1770][INFO    ][3096] Running state [net.ipv4.neigh.default.gc_thresh1] at time 05:35:59.011993
2018-10-14 05:35:59,012 [salt.state       :1803][INFO    ][3096] Executing state sysctl.present for [net.ipv4.neigh.default.gc_thresh1]
2018-10-14 05:35:59,015 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3096] Executing command 'sysctl -w net.ipv4.neigh.default.gc_thresh1="4096"' in directory '/root'
2018-10-14 05:35:59,028 [salt.state       :290 ][INFO    ][3096] {'net.ipv4.neigh.default.gc_thresh1': 4096}
2018-10-14 05:35:59,028 [salt.state       :1941][INFO    ][3096] Completed state [net.ipv4.neigh.default.gc_thresh1] at time 05:35:59.028689 duration_in_ms=16.694
2018-10-14 05:35:59,029 [salt.state       :1770][INFO    ][3096] Running state [net.ipv4.neigh.default.gc_thresh2] at time 05:35:59.029261
2018-10-14 05:35:59,030 [salt.state       :1803][INFO    ][3096] Executing state sysctl.present for [net.ipv4.neigh.default.gc_thresh2]
2018-10-14 05:35:59,031 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3096] Executing command 'sysctl -w net.ipv4.neigh.default.gc_thresh2="8192"' in directory '/root'
2018-10-14 05:35:59,047 [salt.state       :290 ][INFO    ][3096] {'net.ipv4.neigh.default.gc_thresh2': 8192}
2018-10-14 05:35:59,048 [salt.state       :1941][INFO    ][3096] Completed state [net.ipv4.neigh.default.gc_thresh2] at time 05:35:59.047978 duration_in_ms=18.718
2018-10-14 05:35:59,048 [salt.state       :1770][INFO    ][3096] Running state [net.ipv4.neigh.default.gc_thresh3] at time 05:35:59.048448
2018-10-14 05:35:59,048 [salt.state       :1803][INFO    ][3096] Executing state sysctl.present for [net.ipv4.neigh.default.gc_thresh3]
2018-10-14 05:35:59,050 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3096] Executing command 'sysctl -w net.ipv4.neigh.default.gc_thresh3="16384"' in directory '/root'
2018-10-14 05:35:59,066 [salt.state       :290 ][INFO    ][3096] {'net.ipv4.neigh.default.gc_thresh3': 16384}
2018-10-14 05:35:59,066 [salt.state       :1941][INFO    ][3096] Completed state [net.ipv4.neigh.default.gc_thresh3] at time 05:35:59.066674 duration_in_ms=18.225
2018-10-14 05:35:59,067 [salt.state       :1770][INFO    ][3096] Running state [net.ipv4.tcp_fin_timeout] at time 05:35:59.067248
2018-10-14 05:35:59,067 [salt.state       :1803][INFO    ][3096] Executing state sysctl.present for [net.ipv4.tcp_fin_timeout]
2018-10-14 05:35:59,069 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3096] Executing command 'sysctl -w net.ipv4.tcp_fin_timeout="30"' in directory '/root'
2018-10-14 05:35:59,083 [salt.state       :290 ][INFO    ][3096] {'net.ipv4.tcp_fin_timeout': 30}
2018-10-14 05:35:59,084 [salt.state       :1941][INFO    ][3096] Completed state [net.ipv4.tcp_fin_timeout] at time 05:35:59.084336 duration_in_ms=17.087
2018-10-14 05:35:59,085 [salt.state       :1770][INFO    ][3096] Running state [net.ipv4.tcp_keepalive_time] at time 05:35:59.084999
2018-10-14 05:35:59,085 [salt.state       :1803][INFO    ][3096] Executing state sysctl.present for [net.ipv4.tcp_keepalive_time]
2018-10-14 05:35:59,087 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3096] Executing command 'sysctl -w net.ipv4.tcp_keepalive_time="30"' in directory '/root'
2018-10-14 05:35:59,103 [salt.state       :290 ][INFO    ][3096] {'net.ipv4.tcp_keepalive_time': 30}
2018-10-14 05:35:59,104 [salt.state       :1941][INFO    ][3096] Completed state [net.ipv4.tcp_keepalive_time] at time 05:35:59.104069 duration_in_ms=19.07
2018-10-14 05:35:59,104 [salt.state       :1770][INFO    ][3096] Running state [net.nf_conntrack_max] at time 05:35:59.104714
2018-10-14 05:35:59,105 [salt.state       :1803][INFO    ][3096] Executing state sysctl.present for [net.nf_conntrack_max]
2018-10-14 05:35:59,106 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3096] Executing command 'sysctl -w net.nf_conntrack_max="1048576"' in directory '/root'
2018-10-14 05:35:59,122 [salt.state       :290 ][INFO    ][3096] {'net.nf_conntrack_max': 1048576}
2018-10-14 05:35:59,123 [salt.state       :1941][INFO    ][3096] Completed state [net.nf_conntrack_max] at time 05:35:59.123202 duration_in_ms=18.488
2018-10-14 05:35:59,123 [salt.state       :1770][INFO    ][3096] Running state [linux_sysfs_package] at time 05:35:59.123613
2018-10-14 05:35:59,123 [salt.state       :1803][INFO    ][3096] Executing state pkg.installed for [linux_sysfs_package]
2018-10-14 05:35:59,145 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3096] Executing command ['apt-cache', '-q', 'policy', 'sysfsutils'] in directory '/root'
2018-10-14 05:35:59,232 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3096] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2018-10-14 05:36:01,134 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3096] Executing command ['dpkg', '--get-selections', '*'] in directory '/root'
2018-10-14 05:36:01,160 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3096] 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:04,267 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3096] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}', '-W'] in directory '/root'
2018-10-14 05:36:04,303 [salt.state       :290 ][INFO    ][3096] 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:04,328 [salt.state       :905 ][INFO    ][3096] Loading fresh modules for state activity
2018-10-14 05:36:04,365 [salt.state       :1941][INFO    ][3096] Completed state [linux_sysfs_package] at time 05:36:04.365079 duration_in_ms=5241.466
2018-10-14 05:36:04,370 [salt.state       :1770][INFO    ][3096] Running state [/etc/sysfs.d] at time 05:36:04.370048
2018-10-14 05:36:04,370 [salt.state       :1803][INFO    ][3096] Executing state file.directory for [/etc/sysfs.d]
2018-10-14 05:36:04,374 [salt.state       :290 ][INFO    ][3096] Directory /etc/sysfs.d is in the correct state
Directory /etc/sysfs.d updated
2018-10-14 05:36:04,374 [salt.state       :1941][INFO    ][3096] Completed state [/etc/sysfs.d] at time 05:36:04.374645 duration_in_ms=4.597
2018-10-14 05:36:04,939 [salt.state       :1770][INFO    ][3096] Running state [ondemand] at time 05:36:04.939311
2018-10-14 05:36:04,939 [salt.state       :1803][INFO    ][3096] Executing state service.dead for [ondemand]
2018-10-14 05:36:04,940 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3096] Executing command ['systemctl', 'status', 'ondemand.service', '-n', '0'] in directory '/root'
2018-10-14 05:36:04,964 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3096] Executing command ['systemctl', 'is-active', 'ondemand.service'] in directory '/root'
2018-10-14 05:36:04,979 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3096] Executing command ['systemctl', 'is-enabled', 'ondemand.service'] in directory '/root'
2018-10-14 05:36:04,996 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3096] Executing command ['systemd-run', '--scope', 'systemctl', 'stop', 'ondemand.service'] in directory '/root'
2018-10-14 05:36:05,062 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3096] Executing command ['systemctl', 'is-active', 'ondemand.service'] in directory '/root'
2018-10-14 05:36:05,080 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3096] Executing command ['systemctl', 'is-enabled', 'ondemand.service'] in directory '/root'
2018-10-14 05:36:05,103 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3096] Executing command ['systemctl', 'is-enabled', 'ondemand.service'] in directory '/root'
2018-10-14 05:36:05,134 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3096] Executing command ['systemd-run', '--scope', '/usr/sbin/update-rc.d', '-f', 'ondemand', 'remove'] in directory '/root'
2018-10-14 05:36:05,295 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3096] Executing command ['systemctl', 'is-enabled', 'ondemand.service'] in directory '/root'
2018-10-14 05:36:05,322 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3096] Executing command 'runlevel' in directory '/root'
2018-10-14 05:36:05,337 [salt.state       :290 ][INFO    ][3096] {'ondemand': True}
2018-10-14 05:36:05,338 [salt.state       :1941][INFO    ][3096] Completed state [ondemand] at time 05:36:05.337967 duration_in_ms=398.655
2018-10-14 05:36:05,339 [salt.state       :1770][INFO    ][3096] Running state [cs_CZ.UTF-8] at time 05:36:05.339378
2018-10-14 05:36:05,339 [salt.state       :1803][INFO    ][3096] Executing state locale.present for [cs_CZ.UTF-8]
2018-10-14 05:36:05,340 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3096] Executing command 'locale -a' in directory '/root'
2018-10-14 05:36:05,361 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3096] Executing command ['locale-gen', 'cs_CZ.utf8'] in directory '/root'
2018-10-14 05:36:06,039 [salt.state       :290 ][INFO    ][3096] {'locale': 'cs_CZ.UTF-8'}
2018-10-14 05:36:06,039 [salt.state       :1941][INFO    ][3096] Completed state [cs_CZ.UTF-8] at time 05:36:06.039605 duration_in_ms=700.227
2018-10-14 05:36:06,040 [salt.state       :1770][INFO    ][3096] Running state [en_US.UTF-8] at time 05:36:06.039992
2018-10-14 05:36:06,040 [salt.state       :1803][INFO    ][3096] Executing state locale.present for [en_US.UTF-8]
2018-10-14 05:36:06,041 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3096] Executing command 'locale -a' in directory '/root'
2018-10-14 05:36:06,055 [salt.state       :290 ][INFO    ][3096] Locale en_US.UTF-8 is already present
2018-10-14 05:36:06,055 [salt.state       :1941][INFO    ][3096] Completed state [en_US.UTF-8] at time 05:36:06.055859 duration_in_ms=15.867
2018-10-14 05:36:06,058 [salt.state       :1770][INFO    ][3096] Running state [en_US.UTF-8] at time 05:36:06.058125
2018-10-14 05:36:06,058 [salt.state       :1803][INFO    ][3096] Executing state locale.system for [en_US.UTF-8]
2018-10-14 05:36:06,059 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3096] Executing command 'localectl' in directory '/root'
2018-10-14 05:36:06,099 [salt.state       :290 ][INFO    ][3096] System locale en_US.UTF-8 already set
2018-10-14 05:36:06,100 [salt.state       :1941][INFO    ][3096] Completed state [en_US.UTF-8] at time 05:36:06.100519 duration_in_ms=42.393
2018-10-14 05:36:06,102 [salt.state       :1770][INFO    ][3096] Running state [root] at time 05:36:06.102791
2018-10-14 05:36:06,103 [salt.state       :1803][INFO    ][3096] Executing state group.present for [root]
2018-10-14 05:36:06,104 [salt.state       :290 ][INFO    ][3096] Group root is present and up to date
2018-10-14 05:36:06,104 [salt.state       :1941][INFO    ][3096] Completed state [root] at time 05:36:06.104402 duration_in_ms=1.611
2018-10-14 05:36:06,106 [salt.state       :1770][INFO    ][3096] Running state [root] at time 05:36:06.106478
2018-10-14 05:36:06,106 [salt.state       :1803][INFO    ][3096] Executing state user.present for [root]
2018-10-14 05:36:06,111 [salt.state       :290 ][INFO    ][3096] User root is present and up to date
2018-10-14 05:36:06,112 [salt.state       :1941][INFO    ][3096] Completed state [root] at time 05:36:06.112128 duration_in_ms=5.65
2018-10-14 05:36:06,114 [salt.state       :1770][INFO    ][3096] Running state [/root] at time 05:36:06.114247
2018-10-14 05:36:06,114 [salt.state       :1803][INFO    ][3096] Executing state file.directory for [/root]
2018-10-14 05:36:06,115 [salt.state       :290 ][INFO    ][3096] Directory /root is in the correct state
Directory /root updated
2018-10-14 05:36:06,116 [salt.state       :1941][INFO    ][3096] Completed state [/root] at time 05:36:06.116216 duration_in_ms=1.968
2018-10-14 05:36:06,116 [salt.state       :1770][INFO    ][3096] Running state [/etc/sudoers.d/90-salt-user-root] at time 05:36:06.116620
2018-10-14 05:36:06,117 [salt.state       :1803][INFO    ][3096] Executing state file.absent for [/etc/sudoers.d/90-salt-user-root]
2018-10-14 05:36:06,117 [salt.state       :290 ][INFO    ][3096] File /etc/sudoers.d/90-salt-user-root is not present
2018-10-14 05:36:06,118 [salt.state       :1941][INFO    ][3096] Completed state [/etc/sudoers.d/90-salt-user-root] at time 05:36:06.118201 duration_in_ms=1.581
2018-10-14 05:36:06,118 [salt.state       :1770][INFO    ][3096] Running state [ubuntu] at time 05:36:06.118612
2018-10-14 05:36:06,119 [salt.state       :1803][INFO    ][3096] Executing state group.present for [ubuntu]
2018-10-14 05:36:06,119 [salt.state       :290 ][INFO    ][3096] Group ubuntu is present and up to date
2018-10-14 05:36:06,119 [salt.state       :1941][INFO    ][3096] Completed state [ubuntu] at time 05:36:06.119961 duration_in_ms=1.349
2018-10-14 05:36:06,121 [salt.state       :1770][INFO    ][3096] Running state [ubuntu] at time 05:36:06.121035
2018-10-14 05:36:06,121 [salt.state       :1803][INFO    ][3096] Executing state user.present for [ubuntu]
2018-10-14 05:36:06,124 [salt.state       :290 ][INFO    ][3096] {'passwd': 'XXX-REDACTED-XXX'}
2018-10-14 05:36:06,125 [salt.state       :1941][INFO    ][3096] Completed state [ubuntu] at time 05:36:06.125456 duration_in_ms=4.42
2018-10-14 05:36:06,127 [salt.state       :1770][INFO    ][3096] Running state [/home/ubuntu] at time 05:36:06.126989
2018-10-14 05:36:06,127 [salt.state       :1803][INFO    ][3096] Executing state file.directory for [/home/ubuntu]
2018-10-14 05:36:06,128 [salt.state       :290 ][INFO    ][3096] {'mode': '0700'}
2018-10-14 05:36:06,128 [salt.state       :1941][INFO    ][3096] Completed state [/home/ubuntu] at time 05:36:06.128905 duration_in_ms=1.916
2018-10-14 05:36:06,130 [salt.state       :1770][INFO    ][3096] Running state [/etc/sudoers.d/90-salt-user-ubuntu] at time 05:36:06.130366
2018-10-14 05:36:06,130 [salt.state       :1803][INFO    ][3096] Executing state file.managed for [/etc/sudoers.d/90-salt-user-ubuntu]
2018-10-14 05:36:06,155 [salt.fileclient  :1215][INFO    ][3096] Fetching file from saltenv 'base', ** done ** 'linux/files/sudoer'
2018-10-14 05:36:06,166 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3096] Executing command '/usr/sbin/visudo -c -f /tmp/__salt.tmp.UgLBe6' in directory '/root'
2018-10-14 05:36:06,190 [salt.state       :290 ][INFO    ][3096] File changed:
New file
2018-10-14 05:36:06,191 [salt.state       :1941][INFO    ][3096] Completed state [/etc/sudoers.d/90-salt-user-ubuntu] at time 05:36:06.191760 duration_in_ms=61.392
2018-10-14 05:36:06,192 [salt.state       :1770][INFO    ][3096] Running state [/etc/security/limits.d/90-salt-default.conf] at time 05:36:06.192471
2018-10-14 05:36:06,193 [salt.state       :1803][INFO    ][3096] Executing state file.managed for [/etc/security/limits.d/90-salt-default.conf]
2018-10-14 05:36:06,217 [salt.fileclient  :1215][INFO    ][3096] Fetching file from saltenv 'base', ** done ** 'linux/files/limits.conf'
2018-10-14 05:36:06,335 [salt.state       :290 ][INFO    ][3096] File changed:
New file
2018-10-14 05:36:06,336 [salt.state       :1941][INFO    ][3096] Completed state [/etc/security/limits.d/90-salt-default.conf] at time 05:36:06.336274 duration_in_ms=143.803
2018-10-14 05:36:06,336 [salt.state       :1770][INFO    ][3096] Running state [/etc/systemd/system.conf.d/90-salt.conf] at time 05:36:06.336726
2018-10-14 05:36:06,337 [salt.state       :1803][INFO    ][3096] Executing state file.managed for [/etc/systemd/system.conf.d/90-salt.conf]
2018-10-14 05:36:06,357 [salt.fileclient  :1215][INFO    ][3096] Fetching file from saltenv 'base', ** done ** 'linux/files/systemd.conf'
2018-10-14 05:36:06,464 [salt.state       :290 ][INFO    ][3096] File changed:
New file
2018-10-14 05:36:06,465 [salt.state       :1941][INFO    ][3096] Completed state [/etc/systemd/system.conf.d/90-salt.conf] at time 05:36:06.464976 duration_in_ms=128.249
2018-10-14 05:36:06,467 [salt.state       :1770][INFO    ][3096] Running state [service.systemctl_reload] at time 05:36:06.467490
2018-10-14 05:36:06,467 [salt.state       :1803][INFO    ][3096] Executing state module.wait for [service.systemctl_reload]
2018-10-14 05:36:06,468 [salt.state       :290 ][INFO    ][3096] No changes made for service.systemctl_reload
2018-10-14 05:36:06,468 [salt.state       :1941][INFO    ][3096] Completed state [service.systemctl_reload] at time 05:36:06.468797 duration_in_ms=1.307
2018-10-14 05:36:06,469 [salt.state       :1770][INFO    ][3096] Running state [service.systemctl_reload] at time 05:36:06.469184
2018-10-14 05:36:06,469 [salt.state       :1803][INFO    ][3096] Executing state module.mod_watch for [service.systemctl_reload]
2018-10-14 05:36:06,470 [salt.utils.decorators:613 ][WARNING ][3096] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2018-10-14 05:36:06,470 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3096] Executing command ['systemctl', '--system', 'daemon-reload'] in directory '/root'
2018-10-14 05:36:06,591 [salt.state       :290 ][INFO    ][3096] {'ret': True}
2018-10-14 05:36:06,593 [salt.state       :1941][INFO    ][3096] Completed state [service.systemctl_reload] at time 05:36:06.592940 duration_in_ms=123.756
2018-10-14 05:36:06,594 [salt.state       :1770][INFO    ][3096] Running state [/etc/issue] at time 05:36:06.594552
2018-10-14 05:36:06,595 [salt.state       :1803][INFO    ][3096] Executing state file.managed for [/etc/issue]
2018-10-14 05:36:06,597 [salt.state       :290 ][INFO    ][3096] 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:06,600 [salt.state       :1941][INFO    ][3096] Completed state [/etc/issue] at time 05:36:06.600228 duration_in_ms=5.676
2018-10-14 05:36:06,600 [salt.state       :1770][INFO    ][3096] Running state [/etc/hostname] at time 05:36:06.600627
2018-10-14 05:36:06,601 [salt.state       :1803][INFO    ][3096] Executing state file.managed for [/etc/hostname]
2018-10-14 05:36:06,625 [salt.fileclient  :1215][INFO    ][3096] Fetching file from saltenv 'base', ** done ** 'linux/files/hostname'
2018-10-14 05:36:06,636 [salt.state       :290 ][INFO    ][3096] File changed:
--- 
+++ 
@@ -1 +1 @@
-ubuntu
+msg02

2018-10-14 05:36:06,638 [salt.state       :1941][INFO    ][3096] Completed state [/etc/hostname] at time 05:36:06.638361 duration_in_ms=37.733
2018-10-14 05:36:06,640 [salt.state       :1770][INFO    ][3096] Running state [hostname msg02] at time 05:36:06.640755
2018-10-14 05:36:06,642 [salt.state       :1803][INFO    ][3096] Executing state cmd.run for [hostname msg02]
2018-10-14 05:36:06,643 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3096] Executing command 'test "$(hostname)" = "msg02"' in directory '/root'
2018-10-14 05:36:06,659 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3096] Executing command 'hostname msg02' in directory '/root'
2018-10-14 05:36:06,673 [salt.state       :290 ][INFO    ][3096] {'pid': 5271, 'retcode': 0, 'stderr': '', 'stdout': ''}
2018-10-14 05:36:06,674 [salt.state       :1941][INFO    ][3096] Completed state [hostname msg02] at time 05:36:06.674046 duration_in_ms=33.291
2018-10-14 05:36:06,675 [salt.state       :1770][INFO    ][3096] Running state [mdb02] at time 05:36:06.675673
2018-10-14 05:36:06,676 [salt.state       :1803][INFO    ][3096] Executing state host.present for [mdb02]
2018-10-14 05:36:06,679 [salt.state       :290 ][INFO    ][3096] {'host': 'mdb02'}
2018-10-14 05:36:06,679 [salt.state       :1941][INFO    ][3096] Completed state [mdb02] at time 05:36:06.679427 duration_in_ms=3.754
2018-10-14 05:36:06,680 [salt.state       :1770][INFO    ][3096] Running state [mdb02.mcp-pike-odl-ha.local] at time 05:36:06.679954
2018-10-14 05:36:06,680 [salt.state       :1803][INFO    ][3096] Executing state host.present for [mdb02.mcp-pike-odl-ha.local]
2018-10-14 05:36:06,681 [salt.state       :290 ][INFO    ][3096] {'host': 'mdb02.mcp-pike-odl-ha.local'}
2018-10-14 05:36:06,681 [salt.state       :1941][INFO    ][3096] Completed state [mdb02.mcp-pike-odl-ha.local] at time 05:36:06.681853 duration_in_ms=1.899
2018-10-14 05:36:06,682 [salt.state       :1770][INFO    ][3096] Running state [mdb03] at time 05:36:06.682364
2018-10-14 05:36:06,682 [salt.state       :1803][INFO    ][3096] Executing state host.present for [mdb03]
2018-10-14 05:36:06,683 [salt.state       :290 ][INFO    ][3096] {'host': 'mdb03'}
2018-10-14 05:36:06,684 [salt.state       :1941][INFO    ][3096] Completed state [mdb03] at time 05:36:06.684265 duration_in_ms=1.902
2018-10-14 05:36:06,684 [salt.state       :1770][INFO    ][3096] Running state [mdb03.mcp-pike-odl-ha.local] at time 05:36:06.684757
2018-10-14 05:36:06,685 [salt.state       :1803][INFO    ][3096] Executing state host.present for [mdb03.mcp-pike-odl-ha.local]
2018-10-14 05:36:06,686 [salt.state       :290 ][INFO    ][3096] {'host': 'mdb03.mcp-pike-odl-ha.local'}
2018-10-14 05:36:06,686 [salt.state       :1941][INFO    ][3096] Completed state [mdb03.mcp-pike-odl-ha.local] at time 05:36:06.686630 duration_in_ms=1.873
2018-10-14 05:36:06,687 [salt.state       :1770][INFO    ][3096] Running state [mdb01] at time 05:36:06.687173
2018-10-14 05:36:06,687 [salt.state       :1803][INFO    ][3096] Executing state host.present for [mdb01]
2018-10-14 05:36:06,689 [salt.state       :290 ][INFO    ][3096] {'host': 'mdb01'}
2018-10-14 05:36:06,690 [salt.state       :1941][INFO    ][3096] Completed state [mdb01] at time 05:36:06.690290 duration_in_ms=3.117
2018-10-14 05:36:06,690 [salt.state       :1770][INFO    ][3096] Running state [mdb01.mcp-pike-odl-ha.local] at time 05:36:06.690815
2018-10-14 05:36:06,691 [salt.state       :1803][INFO    ][3096] Executing state host.present for [mdb01.mcp-pike-odl-ha.local]
2018-10-14 05:36:06,692 [salt.state       :290 ][INFO    ][3096] {'host': 'mdb01.mcp-pike-odl-ha.local'}
2018-10-14 05:36:06,692 [salt.state       :1941][INFO    ][3096] Completed state [mdb01.mcp-pike-odl-ha.local] at time 05:36:06.692789 duration_in_ms=1.974
2018-10-14 05:36:06,693 [salt.state       :1770][INFO    ][3096] Running state [mdb] at time 05:36:06.693268
2018-10-14 05:36:06,693 [salt.state       :1803][INFO    ][3096] Executing state host.present for [mdb]
2018-10-14 05:36:06,694 [salt.state       :290 ][INFO    ][3096] {'host': 'mdb'}
2018-10-14 05:36:06,695 [salt.state       :1941][INFO    ][3096] Completed state [mdb] at time 05:36:06.695105 duration_in_ms=1.837
2018-10-14 05:36:06,695 [salt.state       :1770][INFO    ][3096] Running state [mdb.mcp-pike-odl-ha.local] at time 05:36:06.695596
2018-10-14 05:36:06,696 [salt.state       :1803][INFO    ][3096] Executing state host.present for [mdb.mcp-pike-odl-ha.local]
2018-10-14 05:36:06,700 [salt.state       :290 ][INFO    ][3096] {'host': 'mdb.mcp-pike-odl-ha.local'}
2018-10-14 05:36:06,700 [salt.state       :1941][INFO    ][3096] Completed state [mdb.mcp-pike-odl-ha.local] at time 05:36:06.700685 duration_in_ms=5.089
2018-10-14 05:36:06,701 [salt.state       :1770][INFO    ][3096] Running state [cfg01] at time 05:36:06.701531
2018-10-14 05:36:06,701 [salt.state       :1803][INFO    ][3096] Executing state host.present for [cfg01]
2018-10-14 05:36:06,703 [salt.state       :290 ][INFO    ][3096] {'host': 'cfg01'}
2018-10-14 05:36:06,703 [salt.state       :1941][INFO    ][3096] Completed state [cfg01] at time 05:36:06.703435 duration_in_ms=1.904
2018-10-14 05:36:06,703 [salt.state       :1770][INFO    ][3096] Running state [cfg01.mcp-pike-odl-ha.local] at time 05:36:06.703897
2018-10-14 05:36:06,704 [salt.state       :1803][INFO    ][3096] Executing state host.present for [cfg01.mcp-pike-odl-ha.local]
2018-10-14 05:36:06,705 [salt.state       :290 ][INFO    ][3096] {'host': 'cfg01.mcp-pike-odl-ha.local'}
2018-10-14 05:36:06,706 [salt.state       :1941][INFO    ][3096] Completed state [cfg01.mcp-pike-odl-ha.local] at time 05:36:06.706329 duration_in_ms=2.433
2018-10-14 05:36:06,706 [salt.state       :1770][INFO    ][3096] Running state [prx01] at time 05:36:06.706798
2018-10-14 05:36:06,707 [salt.state       :1803][INFO    ][3096] Executing state host.present for [prx01]
2018-10-14 05:36:06,708 [salt.state       :290 ][INFO    ][3096] {'host': 'prx01'}
2018-10-14 05:36:06,708 [salt.state       :1941][INFO    ][3096] Completed state [prx01] at time 05:36:06.708637 duration_in_ms=1.839
2018-10-14 05:36:06,709 [salt.state       :1770][INFO    ][3096] Running state [prx01.mcp-pike-odl-ha.local] at time 05:36:06.709159
2018-10-14 05:36:06,709 [salt.state       :1803][INFO    ][3096] Executing state host.present for [prx01.mcp-pike-odl-ha.local]
2018-10-14 05:36:06,710 [salt.state       :290 ][INFO    ][3096] {'host': 'prx01.mcp-pike-odl-ha.local'}
2018-10-14 05:36:06,711 [salt.state       :1941][INFO    ][3096] Completed state [prx01.mcp-pike-odl-ha.local] at time 05:36:06.711052 duration_in_ms=1.892
2018-10-14 05:36:06,711 [salt.state       :1770][INFO    ][3096] Running state [kvm01] at time 05:36:06.711549
2018-10-14 05:36:06,711 [salt.state       :1803][INFO    ][3096] Executing state host.present for [kvm01]
2018-10-14 05:36:06,713 [salt.state       :290 ][INFO    ][3096] {'host': 'kvm01'}
2018-10-14 05:36:06,714 [salt.state       :1941][INFO    ][3096] Completed state [kvm01] at time 05:36:06.713957 duration_in_ms=2.408
2018-10-14 05:36:06,714 [salt.state       :1770][INFO    ][3096] Running state [kvm01.mcp-pike-odl-ha.local] at time 05:36:06.714439
2018-10-14 05:36:06,714 [salt.state       :1803][INFO    ][3096] Executing state host.present for [kvm01.mcp-pike-odl-ha.local]
2018-10-14 05:36:06,715 [salt.state       :290 ][INFO    ][3096] {'host': 'kvm01.mcp-pike-odl-ha.local'}
2018-10-14 05:36:06,716 [salt.state       :1941][INFO    ][3096] Completed state [kvm01.mcp-pike-odl-ha.local] at time 05:36:06.716334 duration_in_ms=1.895
2018-10-14 05:36:06,716 [salt.state       :1770][INFO    ][3096] Running state [kvm03] at time 05:36:06.716811
2018-10-14 05:36:06,718 [salt.state       :1803][INFO    ][3096] Executing state host.present for [kvm03]
2018-10-14 05:36:06,719 [salt.state       :290 ][INFO    ][3096] {'host': 'kvm03'}
2018-10-14 05:36:06,719 [salt.state       :1941][INFO    ][3096] Completed state [kvm03] at time 05:36:06.719540 duration_in_ms=2.73
2018-10-14 05:36:06,720 [salt.state       :1770][INFO    ][3096] Running state [kvm03.mcp-pike-odl-ha.local] at time 05:36:06.720017
2018-10-14 05:36:06,720 [salt.state       :1803][INFO    ][3096] Executing state host.present for [kvm03.mcp-pike-odl-ha.local]
2018-10-14 05:36:06,722 [salt.state       :290 ][INFO    ][3096] {'host': 'kvm03.mcp-pike-odl-ha.local'}
2018-10-14 05:36:06,722 [salt.state       :1941][INFO    ][3096] Completed state [kvm03.mcp-pike-odl-ha.local] at time 05:36:06.722502 duration_in_ms=2.485
2018-10-14 05:36:06,723 [salt.state       :1770][INFO    ][3096] Running state [kvm02] at time 05:36:06.723010
2018-10-14 05:36:06,723 [salt.state       :1803][INFO    ][3096] Executing state host.present for [kvm02]
2018-10-14 05:36:06,724 [salt.state       :290 ][INFO    ][3096] {'host': 'kvm02'}
2018-10-14 05:36:06,724 [salt.state       :1941][INFO    ][3096] Completed state [kvm02] at time 05:36:06.724888 duration_in_ms=1.878
2018-10-14 05:36:06,726 [salt.state       :1770][INFO    ][3096] Running state [kvm02.mcp-pike-odl-ha.local] at time 05:36:06.726816
2018-10-14 05:36:06,727 [salt.state       :1803][INFO    ][3096] Executing state host.present for [kvm02.mcp-pike-odl-ha.local]
2018-10-14 05:36:06,728 [salt.state       :290 ][INFO    ][3096] {'host': 'kvm02.mcp-pike-odl-ha.local'}
2018-10-14 05:36:06,728 [salt.state       :1941][INFO    ][3096] Completed state [kvm02.mcp-pike-odl-ha.local] at time 05:36:06.728665 duration_in_ms=1.848
2018-10-14 05:36:06,729 [salt.state       :1770][INFO    ][3096] Running state [dbs] at time 05:36:06.729753
2018-10-14 05:36:06,730 [salt.state       :1803][INFO    ][3096] Executing state host.present for [dbs]
2018-10-14 05:36:06,731 [salt.state       :290 ][INFO    ][3096] {'host': 'dbs'}
2018-10-14 05:36:06,731 [salt.state       :1941][INFO    ][3096] Completed state [dbs] at time 05:36:06.731689 duration_in_ms=1.936
2018-10-14 05:36:06,732 [salt.state       :1770][INFO    ][3096] Running state [dbs.mcp-pike-odl-ha.local] at time 05:36:06.732179
2018-10-14 05:36:06,732 [salt.state       :1803][INFO    ][3096] Executing state host.present for [dbs.mcp-pike-odl-ha.local]
2018-10-14 05:36:06,733 [salt.state       :290 ][INFO    ][3096] {'host': 'dbs.mcp-pike-odl-ha.local'}
2018-10-14 05:36:06,734 [salt.state       :1941][INFO    ][3096] Completed state [dbs.mcp-pike-odl-ha.local] at time 05:36:06.734146 duration_in_ms=1.967
2018-10-14 05:36:06,734 [salt.state       :1770][INFO    ][3096] Running state [prx] at time 05:36:06.734641
2018-10-14 05:36:06,735 [salt.state       :1803][INFO    ][3096] Executing state host.present for [prx]
2018-10-14 05:36:06,736 [salt.state       :290 ][INFO    ][3096] {'host': 'prx'}
2018-10-14 05:36:06,736 [salt.state       :1941][INFO    ][3096] Completed state [prx] at time 05:36:06.736642 duration_in_ms=2.002
2018-10-14 05:36:06,738 [salt.state       :1770][INFO    ][3096] Running state [prx.mcp-pike-odl-ha.local] at time 05:36:06.738278
2018-10-14 05:36:06,738 [salt.state       :1803][INFO    ][3096] Executing state host.present for [prx.mcp-pike-odl-ha.local]
2018-10-14 05:36:06,739 [salt.state       :290 ][INFO    ][3096] {'host': 'prx.mcp-pike-odl-ha.local'}
2018-10-14 05:36:06,740 [salt.state       :1941][INFO    ][3096] Completed state [prx.mcp-pike-odl-ha.local] at time 05:36:06.740269 duration_in_ms=1.99
2018-10-14 05:36:06,740 [salt.state       :1770][INFO    ][3096] Running state [prx02] at time 05:36:06.740775
2018-10-14 05:36:06,741 [salt.state       :1803][INFO    ][3096] Executing state host.present for [prx02]
2018-10-14 05:36:06,742 [salt.state       :290 ][INFO    ][3096] {'host': 'prx02'}
2018-10-14 05:36:06,742 [salt.state       :1941][INFO    ][3096] Completed state [prx02] at time 05:36:06.742880 duration_in_ms=2.105
2018-10-14 05:36:06,743 [salt.state       :1770][INFO    ][3096] Running state [prx02.mcp-pike-odl-ha.local] at time 05:36:06.743430
2018-10-14 05:36:06,743 [salt.state       :1803][INFO    ][3096] Executing state host.present for [prx02.mcp-pike-odl-ha.local]
2018-10-14 05:36:06,745 [salt.state       :290 ][INFO    ][3096] {'host': 'prx02.mcp-pike-odl-ha.local'}
2018-10-14 05:36:06,746 [salt.state       :1941][INFO    ][3096] Completed state [prx02.mcp-pike-odl-ha.local] at time 05:36:06.745988 duration_in_ms=2.558
2018-10-14 05:36:06,746 [salt.state       :1770][INFO    ][3096] Running state [msg02] at time 05:36:06.746506
2018-10-14 05:36:06,746 [salt.state       :1803][INFO    ][3096] Executing state host.present for [msg02]
2018-10-14 05:36:06,748 [salt.state       :290 ][INFO    ][3096] {'host': 'msg02'}
2018-10-14 05:36:06,748 [salt.state       :1941][INFO    ][3096] Completed state [msg02] at time 05:36:06.748537 duration_in_ms=2.031
2018-10-14 05:36:06,750 [salt.state       :1770][INFO    ][3096] Running state [msg02.mcp-pike-odl-ha.local] at time 05:36:06.749369
2018-10-14 05:36:06,750 [salt.state       :1803][INFO    ][3096] Executing state host.present for [msg02.mcp-pike-odl-ha.local]
2018-10-14 05:36:06,752 [salt.state       :290 ][INFO    ][3096] {'host': 'msg02.mcp-pike-odl-ha.local'}
2018-10-14 05:36:06,752 [salt.state       :1941][INFO    ][3096] Completed state [msg02.mcp-pike-odl-ha.local] at time 05:36:06.752352 duration_in_ms=3.247
2018-10-14 05:36:06,752 [salt.state       :1770][INFO    ][3096] Running state [msg03] at time 05:36:06.752691
2018-10-14 05:36:06,752 [salt.state       :1803][INFO    ][3096] Executing state host.present for [msg03]
2018-10-14 05:36:06,754 [salt.state       :290 ][INFO    ][3096] {'host': 'msg03'}
2018-10-14 05:36:06,754 [salt.state       :1941][INFO    ][3096] Completed state [msg03] at time 05:36:06.754176 duration_in_ms=1.485
2018-10-14 05:36:06,754 [salt.state       :1770][INFO    ][3096] Running state [msg03.mcp-pike-odl-ha.local] at time 05:36:06.754516
2018-10-14 05:36:06,754 [salt.state       :1803][INFO    ][3096] Executing state host.present for [msg03.mcp-pike-odl-ha.local]
2018-10-14 05:36:06,755 [salt.state       :290 ][INFO    ][3096] {'host': 'msg03.mcp-pike-odl-ha.local'}
2018-10-14 05:36:06,755 [salt.state       :1941][INFO    ][3096] Completed state [msg03.mcp-pike-odl-ha.local] at time 05:36:06.755904 duration_in_ms=1.388
2018-10-14 05:36:06,756 [salt.state       :1770][INFO    ][3096] Running state [msg01] at time 05:36:06.756223
2018-10-14 05:36:06,756 [salt.state       :1803][INFO    ][3096] Executing state host.present for [msg01]
2018-10-14 05:36:06,757 [salt.state       :290 ][INFO    ][3096] {'host': 'msg01'}
2018-10-14 05:36:06,757 [salt.state       :1941][INFO    ][3096] Completed state [msg01] at time 05:36:06.757613 duration_in_ms=1.389
2018-10-14 05:36:06,757 [salt.state       :1770][INFO    ][3096] Running state [msg01.mcp-pike-odl-ha.local] at time 05:36:06.757943
2018-10-14 05:36:06,758 [salt.state       :1803][INFO    ][3096] Executing state host.present for [msg01.mcp-pike-odl-ha.local]
2018-10-14 05:36:06,759 [salt.state       :290 ][INFO    ][3096] {'host': 'msg01.mcp-pike-odl-ha.local'}
2018-10-14 05:36:06,759 [salt.state       :1941][INFO    ][3096] Completed state [msg01.mcp-pike-odl-ha.local] at time 05:36:06.759393 duration_in_ms=1.449
2018-10-14 05:36:06,759 [salt.state       :1770][INFO    ][3096] Running state [msg] at time 05:36:06.759716
2018-10-14 05:36:06,759 [salt.state       :1803][INFO    ][3096] Executing state host.present for [msg]
2018-10-14 05:36:06,760 [salt.state       :290 ][INFO    ][3096] {'host': 'msg'}
2018-10-14 05:36:06,762 [salt.state       :1941][INFO    ][3096] Completed state [msg] at time 05:36:06.762226 duration_in_ms=2.51
2018-10-14 05:36:06,762 [salt.state       :1770][INFO    ][3096] Running state [msg.mcp-pike-odl-ha.local] at time 05:36:06.762584
2018-10-14 05:36:06,762 [salt.state       :1803][INFO    ][3096] Executing state host.present for [msg.mcp-pike-odl-ha.local]
2018-10-14 05:36:06,763 [salt.state       :290 ][INFO    ][3096] {'host': 'msg.mcp-pike-odl-ha.local'}
2018-10-14 05:36:06,764 [salt.state       :1941][INFO    ][3096] Completed state [msg.mcp-pike-odl-ha.local] at time 05:36:06.764079 duration_in_ms=1.495
2018-10-14 05:36:06,764 [salt.state       :1770][INFO    ][3096] Running state [cfg01] at time 05:36:06.764428
2018-10-14 05:36:06,764 [salt.state       :1803][INFO    ][3096] Executing state host.present for [cfg01]
2018-10-14 05:36:06,765 [salt.state       :290 ][INFO    ][3096] Host cfg01 (192.168.10.11) already present
2018-10-14 05:36:06,765 [salt.state       :1941][INFO    ][3096] Completed state [cfg01] at time 05:36:06.765546 duration_in_ms=1.118
2018-10-14 05:36:06,765 [salt.state       :1770][INFO    ][3096] Running state [cfg01.mcp-pike-odl-ha.local] at time 05:36:06.765899
2018-10-14 05:36:06,766 [salt.state       :1803][INFO    ][3096] Executing state host.present for [cfg01.mcp-pike-odl-ha.local]
2018-10-14 05:36:06,766 [salt.state       :290 ][INFO    ][3096] Host cfg01.mcp-pike-odl-ha.local (192.168.10.11) already present
2018-10-14 05:36:06,766 [salt.state       :1941][INFO    ][3096] Completed state [cfg01.mcp-pike-odl-ha.local] at time 05:36:06.766742 duration_in_ms=0.843
2018-10-14 05:36:06,767 [salt.state       :1770][INFO    ][3096] Running state [cmp002] at time 05:36:06.767040
2018-10-14 05:36:06,767 [salt.state       :1803][INFO    ][3096] Executing state host.present for [cmp002]
2018-10-14 05:36:06,768 [salt.state       :290 ][INFO    ][3096] {'host': 'cmp002'}
2018-10-14 05:36:06,768 [salt.state       :1941][INFO    ][3096] Completed state [cmp002] at time 05:36:06.768517 duration_in_ms=1.493
2018-10-14 05:36:06,768 [salt.state       :1770][INFO    ][3096] Running state [cmp002.mcp-pike-odl-ha.local] at time 05:36:06.768848
2018-10-14 05:36:06,769 [salt.state       :1803][INFO    ][3096] Executing state host.present for [cmp002.mcp-pike-odl-ha.local]
2018-10-14 05:36:06,770 [salt.state       :290 ][INFO    ][3096] {'host': 'cmp002.mcp-pike-odl-ha.local'}
2018-10-14 05:36:06,770 [salt.state       :1941][INFO    ][3096] Completed state [cmp002.mcp-pike-odl-ha.local] at time 05:36:06.770911 duration_in_ms=2.063
2018-10-14 05:36:06,771 [salt.state       :1770][INFO    ][3096] Running state [cmp001] at time 05:36:06.771281
2018-10-14 05:36:06,771 [salt.state       :1803][INFO    ][3096] Executing state host.present for [cmp001]
2018-10-14 05:36:06,772 [salt.state       :290 ][INFO    ][3096] {'host': 'cmp001'}
2018-10-14 05:36:06,772 [salt.state       :1941][INFO    ][3096] Completed state [cmp001] at time 05:36:06.772686 duration_in_ms=1.405
2018-10-14 05:36:06,773 [salt.state       :1770][INFO    ][3096] Running state [cmp001.mcp-pike-odl-ha.local] at time 05:36:06.773000
2018-10-14 05:36:06,774 [salt.state       :1803][INFO    ][3096] Executing state host.present for [cmp001.mcp-pike-odl-ha.local]
2018-10-14 05:36:06,775 [salt.state       :290 ][INFO    ][3096] {'host': 'cmp001.mcp-pike-odl-ha.local'}
2018-10-14 05:36:06,775 [salt.state       :1941][INFO    ][3096] Completed state [cmp001.mcp-pike-odl-ha.local] at time 05:36:06.775302 duration_in_ms=2.301
2018-10-14 05:36:06,775 [salt.state       :1770][INFO    ][3096] Running state [dbs01] at time 05:36:06.775620
2018-10-14 05:36:06,775 [salt.state       :1803][INFO    ][3096] Executing state host.present for [dbs01]
2018-10-14 05:36:06,776 [salt.state       :290 ][INFO    ][3096] {'host': 'dbs01'}
2018-10-14 05:36:06,777 [salt.state       :1941][INFO    ][3096] Completed state [dbs01] at time 05:36:06.777002 duration_in_ms=1.382
2018-10-14 05:36:06,777 [salt.state       :1770][INFO    ][3096] Running state [dbs01.mcp-pike-odl-ha.local] at time 05:36:06.777639
2018-10-14 05:36:06,777 [salt.state       :1803][INFO    ][3096] Executing state host.present for [dbs01.mcp-pike-odl-ha.local]
2018-10-14 05:36:06,778 [salt.state       :290 ][INFO    ][3096] {'host': 'dbs01.mcp-pike-odl-ha.local'}
2018-10-14 05:36:06,779 [salt.state       :1941][INFO    ][3096] Completed state [dbs01.mcp-pike-odl-ha.local] at time 05:36:06.779155 duration_in_ms=1.516
2018-10-14 05:36:06,779 [salt.state       :1770][INFO    ][3096] Running state [dbs02] at time 05:36:06.779464
2018-10-14 05:36:06,779 [salt.state       :1803][INFO    ][3096] Executing state host.present for [dbs02]
2018-10-14 05:36:06,780 [salt.state       :290 ][INFO    ][3096] {'host': 'dbs02'}
2018-10-14 05:36:06,780 [salt.state       :1941][INFO    ][3096] Completed state [dbs02] at time 05:36:06.780825 duration_in_ms=1.36
2018-10-14 05:36:06,781 [salt.state       :1770][INFO    ][3096] Running state [dbs02.mcp-pike-odl-ha.local] at time 05:36:06.781175
2018-10-14 05:36:06,781 [salt.state       :1803][INFO    ][3096] Executing state host.present for [dbs02.mcp-pike-odl-ha.local]
2018-10-14 05:36:06,782 [salt.state       :290 ][INFO    ][3096] {'host': 'dbs02.mcp-pike-odl-ha.local'}
2018-10-14 05:36:06,782 [salt.state       :1941][INFO    ][3096] Completed state [dbs02.mcp-pike-odl-ha.local] at time 05:36:06.782673 duration_in_ms=1.498
2018-10-14 05:36:06,783 [salt.state       :1770][INFO    ][3096] Running state [dbs03] at time 05:36:06.782996
2018-10-14 05:36:06,783 [salt.state       :1803][INFO    ][3096] Executing state host.present for [dbs03]
2018-10-14 05:36:06,784 [salt.state       :290 ][INFO    ][3096] {'host': 'dbs03'}
2018-10-14 05:36:06,784 [salt.state       :1941][INFO    ][3096] Completed state [dbs03] at time 05:36:06.784428 duration_in_ms=1.433
2018-10-14 05:36:06,784 [salt.state       :1770][INFO    ][3096] Running state [dbs03.mcp-pike-odl-ha.local] at time 05:36:06.784740
2018-10-14 05:36:06,784 [salt.state       :1803][INFO    ][3096] Executing state host.present for [dbs03.mcp-pike-odl-ha.local]
2018-10-14 05:36:06,787 [salt.state       :290 ][INFO    ][3096] {'host': 'dbs03.mcp-pike-odl-ha.local'}
2018-10-14 05:36:06,787 [salt.state       :1941][INFO    ][3096] Completed state [dbs03.mcp-pike-odl-ha.local] at time 05:36:06.787483 duration_in_ms=2.743
2018-10-14 05:36:06,787 [salt.state       :1770][INFO    ][3096] Running state [odl01] at time 05:36:06.787803
2018-10-14 05:36:06,788 [salt.state       :1803][INFO    ][3096] Executing state host.present for [odl01]
2018-10-14 05:36:06,789 [salt.state       :290 ][INFO    ][3096] {'host': 'odl01'}
2018-10-14 05:36:06,789 [salt.state       :1941][INFO    ][3096] Completed state [odl01] at time 05:36:06.789265 duration_in_ms=1.462
2018-10-14 05:36:06,789 [salt.state       :1770][INFO    ][3096] Running state [odl01.mcp-pike-odl-ha.local] at time 05:36:06.789605
2018-10-14 05:36:06,789 [salt.state       :1803][INFO    ][3096] Executing state host.present for [odl01.mcp-pike-odl-ha.local]
2018-10-14 05:36:06,790 [salt.state       :290 ][INFO    ][3096] {'host': 'odl01.mcp-pike-odl-ha.local'}
2018-10-14 05:36:06,791 [salt.state       :1941][INFO    ][3096] Completed state [odl01.mcp-pike-odl-ha.local] at time 05:36:06.791107 duration_in_ms=1.502
2018-10-14 05:36:06,791 [salt.state       :1770][INFO    ][3096] Running state [mas01] at time 05:36:06.791423
2018-10-14 05:36:06,791 [salt.state       :1803][INFO    ][3096] Executing state host.present for [mas01]
2018-10-14 05:36:06,792 [salt.state       :290 ][INFO    ][3096] {'host': 'mas01'}
2018-10-14 05:36:06,792 [salt.state       :1941][INFO    ][3096] Completed state [mas01] at time 05:36:06.792819 duration_in_ms=1.396
2018-10-14 05:36:06,793 [salt.state       :1770][INFO    ][3096] Running state [mas01.mcp-pike-odl-ha.local] at time 05:36:06.793775
2018-10-14 05:36:06,794 [salt.state       :1803][INFO    ][3096] Executing state host.present for [mas01.mcp-pike-odl-ha.local]
2018-10-14 05:36:06,795 [salt.state       :290 ][INFO    ][3096] {'host': 'mas01.mcp-pike-odl-ha.local'}
2018-10-14 05:36:06,795 [salt.state       :1941][INFO    ][3096] Completed state [mas01.mcp-pike-odl-ha.local] at time 05:36:06.795293 duration_in_ms=1.518
2018-10-14 05:36:06,795 [salt.state       :1770][INFO    ][3096] Running state [ctl02] at time 05:36:06.795607
2018-10-14 05:36:06,795 [salt.state       :1803][INFO    ][3096] Executing state host.present for [ctl02]
2018-10-14 05:36:06,796 [salt.state       :290 ][INFO    ][3096] {'host': 'ctl02'}
2018-10-14 05:36:06,797 [salt.state       :1941][INFO    ][3096] Completed state [ctl02] at time 05:36:06.797061 duration_in_ms=1.454
2018-10-14 05:36:06,798 [salt.state       :1770][INFO    ][3096] Running state [ctl02.mcp-pike-odl-ha.local] at time 05:36:06.798227
2018-10-14 05:36:06,798 [salt.state       :1803][INFO    ][3096] Executing state host.present for [ctl02.mcp-pike-odl-ha.local]
2018-10-14 05:36:06,799 [salt.state       :290 ][INFO    ][3096] {'host': 'ctl02.mcp-pike-odl-ha.local'}
2018-10-14 05:36:06,799 [salt.state       :1941][INFO    ][3096] Completed state [ctl02.mcp-pike-odl-ha.local] at time 05:36:06.799781 duration_in_ms=1.554
2018-10-14 05:36:06,800 [salt.state       :1770][INFO    ][3096] Running state [ctl03] at time 05:36:06.800109
2018-10-14 05:36:06,800 [salt.state       :1803][INFO    ][3096] Executing state host.present for [ctl03]
2018-10-14 05:36:06,801 [salt.state       :290 ][INFO    ][3096] {'host': 'ctl03'}
2018-10-14 05:36:06,801 [salt.state       :1941][INFO    ][3096] Completed state [ctl03] at time 05:36:06.801605 duration_in_ms=1.496
2018-10-14 05:36:06,801 [salt.state       :1770][INFO    ][3096] Running state [ctl03.mcp-pike-odl-ha.local] at time 05:36:06.801919
2018-10-14 05:36:06,802 [salt.state       :1803][INFO    ][3096] Executing state host.present for [ctl03.mcp-pike-odl-ha.local]
2018-10-14 05:36:06,803 [salt.state       :290 ][INFO    ][3096] {'host': 'ctl03.mcp-pike-odl-ha.local'}
2018-10-14 05:36:06,803 [salt.state       :1941][INFO    ][3096] Completed state [ctl03.mcp-pike-odl-ha.local] at time 05:36:06.803551 duration_in_ms=1.632
2018-10-14 05:36:06,803 [salt.state       :1770][INFO    ][3096] Running state [ctl01] at time 05:36:06.803884
2018-10-14 05:36:06,804 [salt.state       :1803][INFO    ][3096] Executing state host.present for [ctl01]
2018-10-14 05:36:06,805 [salt.state       :290 ][INFO    ][3096] {'host': 'ctl01'}
2018-10-14 05:36:06,805 [salt.state       :1941][INFO    ][3096] Completed state [ctl01] at time 05:36:06.805656 duration_in_ms=1.772
2018-10-14 05:36:06,806 [salt.state       :1770][INFO    ][3096] Running state [ctl01.mcp-pike-odl-ha.local] at time 05:36:06.806000
2018-10-14 05:36:06,806 [salt.state       :1803][INFO    ][3096] Executing state host.present for [ctl01.mcp-pike-odl-ha.local]
2018-10-14 05:36:06,807 [salt.state       :290 ][INFO    ][3096] {'host': 'ctl01.mcp-pike-odl-ha.local'}
2018-10-14 05:36:06,807 [salt.state       :1941][INFO    ][3096] Completed state [ctl01.mcp-pike-odl-ha.local] at time 05:36:06.807532 duration_in_ms=1.532
2018-10-14 05:36:06,807 [salt.state       :1770][INFO    ][3096] Running state [ctl] at time 05:36:06.807851
2018-10-14 05:36:06,808 [salt.state       :1803][INFO    ][3096] Executing state host.present for [ctl]
2018-10-14 05:36:06,809 [salt.state       :290 ][INFO    ][3096] {'host': 'ctl'}
2018-10-14 05:36:06,809 [salt.state       :1941][INFO    ][3096] Completed state [ctl] at time 05:36:06.809863 duration_in_ms=2.011
2018-10-14 05:36:06,810 [salt.state       :1770][INFO    ][3096] Running state [ctl.mcp-pike-odl-ha.local] at time 05:36:06.810197
2018-10-14 05:36:06,810 [salt.state       :1803][INFO    ][3096] Executing state host.present for [ctl.mcp-pike-odl-ha.local]
2018-10-14 05:36:06,811 [salt.state       :290 ][INFO    ][3096] {'host': 'ctl.mcp-pike-odl-ha.local'}
2018-10-14 05:36:06,811 [salt.state       :1941][INFO    ][3096] Completed state [ctl.mcp-pike-odl-ha.local] at time 05:36:06.811698 duration_in_ms=1.501
2018-10-14 05:36:06,811 [salt.state       :1770][INFO    ][3096] Running state [/etc/network/interfaces.d/50-cloud-init.cfg] at time 05:36:06.811918
2018-10-14 05:36:06,812 [salt.state       :1803][INFO    ][3096] Executing state file.absent for [/etc/network/interfaces.d/50-cloud-init.cfg]
2018-10-14 05:36:06,812 [salt.state       :290 ][INFO    ][3096] {'removed': '/etc/network/interfaces.d/50-cloud-init.cfg'}
2018-10-14 05:36:06,812 [salt.state       :1941][INFO    ][3096] Completed state [/etc/network/interfaces.d/50-cloud-init.cfg] at time 05:36:06.812641 duration_in_ms=0.723
2018-10-14 05:36:06,813 [salt.state       :1770][INFO    ][3096] Running state [ens2] at time 05:36:06.813861
2018-10-14 05:36:06,814 [salt.state       :1803][INFO    ][3096] Executing state network.managed for [ens2]
2018-10-14 05:36:06,959 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3096] Executing command ['ifdown', 'ens2'] in directory '/root'
2018-10-14 05:36:08,126 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3096] Executing command ['ifup', 'ens2'] in directory '/root'
2018-10-14 05:36:09,380 [salt.state       :290 ][INFO    ][3096] {'interface': 'Added network interface.', 'status': 'Interface ens2 restart to validate'}
2018-10-14 05:36:09,380 [salt.state       :1941][INFO    ][3096] Completed state [ens2] at time 05:36:09.380817 duration_in_ms=2566.956
2018-10-14 05:36:09,381 [salt.state       :1770][INFO    ][3096] Running state [ens3] at time 05:36:09.381573
2018-10-14 05:36:09,381 [salt.state       :1803][INFO    ][3096] Executing state network.managed for [ens3]
2018-10-14 05:36:09,409 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3096] Executing command ['ifup', 'ens3'] in directory '/root'
2018-10-14 05:36:09,895 [salt.minion      :1307][INFO    ][3008] User sudo_ubuntu Executing command saltutil.find_job with jid 20181014053608201286
2018-10-14 05:36:09,906 [salt.minion      :1431][INFO    ][5536] Starting a new job with PID 5536
2018-10-14 05:36:09,923 [salt.minion      :1708][INFO    ][5536] Returning information for job: 20181014053608201286
2018-10-14 05:36:10,068 [salt.state       :290 ][INFO    ][3096] {'interface': 'Added network interface.', 'status': 'Interface ens3 is up'}
2018-10-14 05:36:10,068 [salt.state       :1941][INFO    ][3096] Completed state [ens3] at time 05:36:10.068510 duration_in_ms=686.937
2018-10-14 05:36:10,068 [salt.state       :1770][INFO    ][3096] Running state [/etc/profile.d/proxy.sh] at time 05:36:10.068817
2018-10-14 05:36:10,069 [salt.state       :1803][INFO    ][3096] Executing state file.absent for [/etc/profile.d/proxy.sh]
2018-10-14 05:36:10,070 [salt.state       :290 ][INFO    ][3096] File /etc/profile.d/proxy.sh is not present
2018-10-14 05:36:10,070 [salt.state       :1941][INFO    ][3096] Completed state [/etc/profile.d/proxy.sh] at time 05:36:10.070367 duration_in_ms=1.55
2018-10-14 05:36:10,070 [salt.state       :1770][INFO    ][3096] Running state [/etc/apt/apt.conf.d/95proxies] at time 05:36:10.070576
2018-10-14 05:36:10,070 [salt.state       :1803][INFO    ][3096] Executing state file.absent for [/etc/apt/apt.conf.d/95proxies]
2018-10-14 05:36:10,071 [salt.state       :290 ][INFO    ][3096] File /etc/apt/apt.conf.d/95proxies is not present
2018-10-14 05:36:10,071 [salt.state       :1941][INFO    ][3096] Completed state [/etc/apt/apt.conf.d/95proxies] at time 05:36:10.071233 duration_in_ms=0.658
2018-10-14 05:36:10,072 [salt.state       :1770][INFO    ][3096] Running state [ntp] at time 05:36:10.072379
2018-10-14 05:36:10,072 [salt.state       :1803][INFO    ][3096] Executing state pkg.installed for [ntp]
2018-10-14 05:36:10,295 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3096] Executing command ['dpkg', '--get-selections', '*'] in directory '/root'
2018-10-14 05:36:10,318 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3096] 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:13,646 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3096] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}', '-W'] in directory '/root'
2018-10-14 05:36:13,690 [salt.state       :290 ][INFO    ][3096] 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:13,709 [salt.state       :905 ][INFO    ][3096] Loading fresh modules for state activity
2018-10-14 05:36:13,743 [salt.state       :1941][INFO    ][3096] Completed state [ntp] at time 05:36:13.743153 duration_in_ms=3670.774
2018-10-14 05:36:13,748 [salt.state       :1770][INFO    ][3096] Running state [/etc/ntp.conf] at time 05:36:13.748551
2018-10-14 05:36:13,748 [salt.state       :1803][INFO    ][3096] Executing state file.managed for [/etc/ntp.conf]
2018-10-14 05:36:13,772 [salt.fileclient  :1215][INFO    ][3096] Fetching file from saltenv 'base', ** done ** 'ntp/files/ntp.conf'
2018-10-14 05:36:13,847 [salt.state       :290 ][INFO    ][3096] 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:13,847 [salt.state       :1941][INFO    ][3096] Completed state [/etc/ntp.conf] at time 05:36:13.847424 duration_in_ms=98.873
2018-10-14 05:36:14,366 [salt.state       :1770][INFO    ][3096] Running state [ntp] at time 05:36:14.366624
2018-10-14 05:36:14,367 [salt.state       :1803][INFO    ][3096] Executing state service.running for [ntp]
2018-10-14 05:36:14,367 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3096] Executing command ['systemctl', 'status', 'ntp.service', '-n', '0'] in directory '/root'
2018-10-14 05:36:14,387 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3096] Executing command ['systemctl', 'is-active', 'ntp.service'] in directory '/root'
2018-10-14 05:36:14,401 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3096] Executing command ['systemctl', 'is-enabled', 'ntp.service'] in directory '/root'
2018-10-14 05:36:14,425 [salt.state       :290 ][INFO    ][3096] The service ntp is already running
2018-10-14 05:36:14,426 [salt.state       :1941][INFO    ][3096] Completed state [ntp] at time 05:36:14.425929 duration_in_ms=59.304
2018-10-14 05:36:14,426 [salt.state       :1770][INFO    ][3096] Running state [ntp] at time 05:36:14.426624
2018-10-14 05:36:14,427 [salt.state       :1803][INFO    ][3096] Executing state service.mod_watch for [ntp]
2018-10-14 05:36:14,429 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3096] Executing command ['systemctl', 'is-active', 'ntp.service'] in directory '/root'
2018-10-14 05:36:14,447 [salt.loaded.int.module.cmdmod:395 ][INFO    ][3096] Executing command ['systemd-run', '--scope', 'systemctl', 'restart', 'ntp.service'] in directory '/root'
2018-10-14 05:36:14,534 [salt.state       :290 ][INFO    ][3096] {'ntp': True}
2018-10-14 05:36:14,535 [salt.state       :1941][INFO    ][3096] Completed state [ntp] at time 05:36:14.535199 duration_in_ms=108.576
2018-10-14 05:36:14,542 [salt.minion      :1708][INFO    ][3096] Returning information for job: 20181014053536849187
2018-10-14 05:36:34,524 [salt.minion      :1307][INFO    ][3008] User sudo_ubuntu Executing command state.apply with jid 20181014053634511899
2018-10-14 05:36:34,543 [salt.minion      :1431][INFO    ][6525] Starting a new job with PID 6525
2018-10-14 05:36:39,607 [salt.state       :905 ][INFO    ][6525] Loading fresh modules for state activity
2018-10-14 05:36:43,280 [salt.state       :1770][INFO    ][6525] Running state [/etc/environment] at time 05:36:43.279988
2018-10-14 05:36:43,280 [salt.state       :1803][INFO    ][6525] Executing state file.blockreplace for [/etc/environment]
2018-10-14 05:36:43,288 [salt.state       :290 ][INFO    ][6525] No changes needed to be made
2018-10-14 05:36:43,288 [salt.state       :1941][INFO    ][6525] Completed state [/etc/environment] at time 05:36:43.288461 duration_in_ms=8.474
2018-10-14 05:36:43,288 [salt.state       :1770][INFO    ][6525] Running state [/etc/profile.d] at time 05:36:43.288729
2018-10-14 05:36:43,288 [salt.state       :1803][INFO    ][6525] Executing state file.directory for [/etc/profile.d]
2018-10-14 05:36:43,291 [salt.state       :290 ][INFO    ][6525] Directory /etc/profile.d is in the correct state
Directory /etc/profile.d updated
2018-10-14 05:36:43,291 [salt.state       :1941][INFO    ][6525] Completed state [/etc/profile.d] at time 05:36:43.291392 duration_in_ms=2.662
2018-10-14 05:36:43,292 [salt.state       :1770][INFO    ][6525] Running state [fake_linux_system_at] at time 05:36:43.292059
2018-10-14 05:36:43,292 [salt.state       :1803][INFO    ][6525] Executing state test.nop for [fake_linux_system_at]
2018-10-14 05:36:43,292 [salt.state       :290 ][INFO    ][6525] Success!
2018-10-14 05:36:43,292 [salt.state       :1941][INFO    ][6525] Completed state [fake_linux_system_at] at time 05:36:43.292707 duration_in_ms=0.649
2018-10-14 05:36:43,292 [salt.state       :1770][INFO    ][6525] Running state [fake_linux_system_cron] at time 05:36:43.292926
2018-10-14 05:36:43,293 [salt.state       :1803][INFO    ][6525] Executing state test.nop for [fake_linux_system_cron]
2018-10-14 05:36:43,293 [salt.state       :290 ][INFO    ][6525] Success!
2018-10-14 05:36:43,293 [salt.state       :1941][INFO    ][6525] Completed state [fake_linux_system_cron] at time 05:36:43.293570 duration_in_ms=0.643
2018-10-14 05:36:43,994 [salt.state       :1770][INFO    ][6525] Running state [/etc/apt/apt.conf.d/99prefer_ipv4-salt] at time 05:36:43.994172
2018-10-14 05:36:43,994 [salt.state       :1803][INFO    ][6525] Executing state file.managed for [/etc/apt/apt.conf.d/99prefer_ipv4-salt]
2018-10-14 05:36:44,033 [salt.state       :290 ][INFO    ][6525] File /etc/apt/apt.conf.d/99prefer_ipv4-salt is in the correct state
2018-10-14 05:36:44,034 [salt.state       :1941][INFO    ][6525] Completed state [/etc/apt/apt.conf.d/99prefer_ipv4-salt] at time 05:36:44.034166 duration_in_ms=39.995
2018-10-14 05:36:44,034 [salt.state       :1770][INFO    ][6525] Running state [/etc/apt/apt.conf.d/99allow_downgrades-salt] at time 05:36:44.034442
2018-10-14 05:36:44,034 [salt.state       :1803][INFO    ][6525] Executing state file.managed for [/etc/apt/apt.conf.d/99allow_downgrades-salt]
2018-10-14 05:36:44,060 [salt.state       :290 ][INFO    ][6525] File /etc/apt/apt.conf.d/99allow_downgrades-salt is in the correct state
2018-10-14 05:36:44,061 [salt.state       :1941][INFO    ][6525] Completed state [/etc/apt/apt.conf.d/99allow_downgrades-salt] at time 05:36:44.061548 duration_in_ms=27.105
2018-10-14 05:36:44,063 [salt.state       :1770][INFO    ][6525] Running state [linux_repo_prereq_pkgs] at time 05:36:44.063189
2018-10-14 05:36:44,063 [salt.state       :1803][INFO    ][6525] Executing state pkg.installed for [linux_repo_prereq_pkgs]
2018-10-14 05:36:44,064 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6525] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}', '-W'] in directory '/root'
2018-10-14 05:36:44,466 [salt.state       :290 ][INFO    ][6525] All specified packages are already installed
2018-10-14 05:36:44,466 [salt.state       :1941][INFO    ][6525] Completed state [linux_repo_prereq_pkgs] at time 05:36:44.466815 duration_in_ms=403.626
2018-10-14 05:36:44,467 [salt.state       :1770][INFO    ][6525] Running state [/etc/apt/apt.conf.d/99proxies-salt] at time 05:36:44.467220
2018-10-14 05:36:44,467 [salt.state       :1803][INFO    ][6525] Executing state file.managed for [/etc/apt/apt.conf.d/99proxies-salt]
2018-10-14 05:36:44,498 [salt.state       :290 ][INFO    ][6525] File /etc/apt/apt.conf.d/99proxies-salt is in the correct state
2018-10-14 05:36:44,499 [salt.state       :1941][INFO    ][6525] Completed state [/etc/apt/apt.conf.d/99proxies-salt] at time 05:36:44.499084 duration_in_ms=31.864
2018-10-14 05:36:44,499 [salt.state       :1770][INFO    ][6525] Running state [/etc/apt/apt.conf.d/99proxies-salt-mk_openstack] at time 05:36:44.499341
2018-10-14 05:36:44,499 [salt.state       :1803][INFO    ][6525] Executing state file.absent for [/etc/apt/apt.conf.d/99proxies-salt-mk_openstack]
2018-10-14 05:36:44,499 [salt.state       :290 ][INFO    ][6525] File /etc/apt/apt.conf.d/99proxies-salt-mk_openstack is not present
2018-10-14 05:36:44,500 [salt.state       :1941][INFO    ][6525] Completed state [/etc/apt/apt.conf.d/99proxies-salt-mk_openstack] at time 05:36:44.500157 duration_in_ms=0.829
2018-10-14 05:36:44,500 [salt.state       :1770][INFO    ][6525] Running state [/etc/apt/preferences.d/mk_openstack] at time 05:36:44.500415
2018-10-14 05:36:44,500 [salt.state       :1803][INFO    ][6525] Executing state file.managed for [/etc/apt/preferences.d/mk_openstack]
2018-10-14 05:36:44,587 [salt.minion      :1307][INFO    ][3008] User sudo_ubuntu Executing command saltutil.find_job with jid 20181014053644577210
2018-10-14 05:36:44,611 [salt.minion      :1431][INFO    ][6618] Starting a new job with PID 6618
2018-10-14 05:36:44,630 [salt.minion      :1708][INFO    ][6618] Returning information for job: 20181014053644577210
2018-10-14 05:36:44,643 [salt.state       :290 ][INFO    ][6525] File /etc/apt/preferences.d/mk_openstack is in the correct state
2018-10-14 05:36:44,643 [salt.state       :1941][INFO    ][6525] Completed state [/etc/apt/preferences.d/mk_openstack] at time 05:36:44.643449 duration_in_ms=143.034
2018-10-14 05:36:44,647 [salt.state       :1770][INFO    ][6525] Running state [deb [arch=amd64] http://apt.mirantis.com/xenial/ nightly pike] at time 05:36:44.647486
2018-10-14 05:36:44,647 [salt.state       :1803][INFO    ][6525] Executing state pkgrepo.managed for [deb [arch=amd64] http://apt.mirantis.com/xenial/ nightly pike]
2018-10-14 05:36:44,698 [salt.state       :290 ][INFO    ][6525] Package repo 'deb [arch=amd64] http://apt.mirantis.com/xenial/ nightly pike' already configured
2018-10-14 05:36:44,698 [salt.state       :1941][INFO    ][6525] Completed state [deb [arch=amd64] http://apt.mirantis.com/xenial/ nightly pike] at time 05:36:44.698664 duration_in_ms=51.177
2018-10-14 05:36:44,698 [salt.state       :1770][INFO    ][6525] Running state [/etc/apt/apt.conf.d/99proxies-salt-uca-staging] at time 05:36:44.698922
2018-10-14 05:36:44,699 [salt.state       :1803][INFO    ][6525] Executing state file.absent for [/etc/apt/apt.conf.d/99proxies-salt-uca-staging]
2018-10-14 05:36:44,699 [salt.state       :290 ][INFO    ][6525] File /etc/apt/apt.conf.d/99proxies-salt-uca-staging is not present
2018-10-14 05:36:44,699 [salt.state       :1941][INFO    ][6525] Completed state [/etc/apt/apt.conf.d/99proxies-salt-uca-staging] at time 05:36:44.699740 duration_in_ms=0.817
2018-10-14 05:36:44,700 [salt.state       :1770][INFO    ][6525] Running state [/etc/apt/preferences.d/uca-staging] at time 05:36:44.699963
2018-10-14 05:36:44,700 [salt.state       :1803][INFO    ][6525] Executing state file.absent for [/etc/apt/preferences.d/uca-staging]
2018-10-14 05:36:44,700 [salt.state       :290 ][INFO    ][6525] File /etc/apt/preferences.d/uca-staging is not present
2018-10-14 05:36:44,700 [salt.state       :1941][INFO    ][6525] Completed state [/etc/apt/preferences.d/uca-staging] at time 05:36:44.700653 duration_in_ms=0.691
2018-10-14 05:36:44,706 [salt.state       :1770][INFO    ][6525] Running state [apt-key adv --keyserver keyserver.ubuntu.com --recv 9F68104E] at time 05:36:44.705985
2018-10-14 05:36:44,706 [salt.state       :1803][INFO    ][6525] Executing state cmd.run for [apt-key adv --keyserver keyserver.ubuntu.com --recv 9F68104E]
2018-10-14 05:36:44,706 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6525] Executing command 'test -e /etc/apt/sources.list.d/uca-staging.list' in directory '/root'
2018-10-14 05:36:44,719 [salt.state       :290 ][INFO    ][6525] unless execution succeeded
2018-10-14 05:36:44,720 [salt.state       :1941][INFO    ][6525] Completed state [apt-key adv --keyserver keyserver.ubuntu.com --recv 9F68104E] at time 05:36:44.720154 duration_in_ms=14.169
2018-10-14 05:36:44,723 [salt.state       :1770][INFO    ][6525] Running state [deb http://ppa.launchpad.net/ubuntu-cloud-archive/pike-staging/ubuntu xenial main] at time 05:36:44.723011
2018-10-14 05:36:44,723 [salt.state       :1803][INFO    ][6525] Executing state pkgrepo.managed for [deb http://ppa.launchpad.net/ubuntu-cloud-archive/pike-staging/ubuntu xenial main]
2018-10-14 05:36:44,769 [salt.state       :290 ][INFO    ][6525] Package repo 'deb http://ppa.launchpad.net/ubuntu-cloud-archive/pike-staging/ubuntu xenial main' already configured
2018-10-14 05:36:44,770 [salt.state       :1941][INFO    ][6525] Completed state [deb http://ppa.launchpad.net/ubuntu-cloud-archive/pike-staging/ubuntu xenial main] at time 05:36:44.770051 duration_in_ms=47.039
2018-10-14 05:36:44,770 [salt.state       :1770][INFO    ][6525] Running state [/etc/apt/apt.conf.d/99proxies-salt-mirantis_openstack] at time 05:36:44.770348
2018-10-14 05:36:44,770 [salt.state       :1803][INFO    ][6525] Executing state file.absent for [/etc/apt/apt.conf.d/99proxies-salt-mirantis_openstack]
2018-10-14 05:36:44,771 [salt.state       :290 ][INFO    ][6525] File /etc/apt/apt.conf.d/99proxies-salt-mirantis_openstack is not present
2018-10-14 05:36:44,771 [salt.state       :1941][INFO    ][6525] Completed state [/etc/apt/apt.conf.d/99proxies-salt-mirantis_openstack] at time 05:36:44.771245 duration_in_ms=0.898
2018-10-14 05:36:44,771 [salt.state       :1770][INFO    ][6525] Running state [/etc/apt/preferences.d/mirantis_openstack] at time 05:36:44.771450
2018-10-14 05:36:44,771 [salt.state       :1803][INFO    ][6525] Executing state file.managed for [/etc/apt/preferences.d/mirantis_openstack]
2018-10-14 05:36:44,910 [salt.state       :290 ][INFO    ][6525] File /etc/apt/preferences.d/mirantis_openstack is in the correct state
2018-10-14 05:36:44,911 [salt.state       :1941][INFO    ][6525] Completed state [/etc/apt/preferences.d/mirantis_openstack] at time 05:36:44.911196 duration_in_ms=139.745
2018-10-14 05:36:44,913 [salt.state       :1770][INFO    ][6525] Running state [deb http://mirror.fuel-infra.org/mcp-repos/pike/xenial pike main] at time 05:36:44.913739
2018-10-14 05:36:44,914 [salt.state       :1803][INFO    ][6525] Executing state pkgrepo.managed for [deb http://mirror.fuel-infra.org/mcp-repos/pike/xenial pike main]
2018-10-14 05:36:45,081 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6525] 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:45,311 [salt.state       :290 ][INFO    ][6525] Configured package repo 'deb http://mirror.fuel-infra.org/mcp-repos/pike/xenial pike main'
2018-10-14 05:36:45,312 [salt.state       :1941][INFO    ][6525] Completed state [deb http://mirror.fuel-infra.org/mcp-repos/pike/xenial pike main] at time 05:36:45.312072 duration_in_ms=398.333
2018-10-14 05:36:45,312 [salt.state       :1770][INFO    ][6525] Running state [/etc/apt/apt.conf.d/99proxies-salt-uca] at time 05:36:45.312485
2018-10-14 05:36:45,312 [salt.state       :1803][INFO    ][6525] Executing state file.absent for [/etc/apt/apt.conf.d/99proxies-salt-uca]
2018-10-14 05:36:45,314 [salt.state       :290 ][INFO    ][6525] File /etc/apt/apt.conf.d/99proxies-salt-uca is not present
2018-10-14 05:36:45,314 [salt.state       :1941][INFO    ][6525] Completed state [/etc/apt/apt.conf.d/99proxies-salt-uca] at time 05:36:45.314742 duration_in_ms=2.257
2018-10-14 05:36:45,315 [salt.state       :1770][INFO    ][6525] Running state [/etc/apt/preferences.d/uca] at time 05:36:45.315001
2018-10-14 05:36:45,315 [salt.state       :1803][INFO    ][6525] Executing state file.managed for [/etc/apt/preferences.d/uca]
2018-10-14 05:36:45,527 [salt.state       :290 ][INFO    ][6525] File /etc/apt/preferences.d/uca is in the correct state
2018-10-14 05:36:45,527 [salt.state       :1941][INFO    ][6525] Completed state [/etc/apt/preferences.d/uca] at time 05:36:45.527298 duration_in_ms=212.295
2018-10-14 05:36:45,532 [salt.state       :1770][INFO    ][6525] Running state [apt-key adv --keyserver keyserver.ubuntu.com --recv EC4926EA] at time 05:36:45.532442
2018-10-14 05:36:45,532 [salt.state       :1803][INFO    ][6525] Executing state cmd.run for [apt-key adv --keyserver keyserver.ubuntu.com --recv EC4926EA]
2018-10-14 05:36:45,533 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6525] Executing command 'test -e /etc/apt/sources.list.d/uca.list' in directory '/root'
2018-10-14 05:36:45,547 [salt.state       :290 ][INFO    ][6525] unless execution succeeded
2018-10-14 05:36:45,547 [salt.state       :1941][INFO    ][6525] Completed state [apt-key adv --keyserver keyserver.ubuntu.com --recv EC4926EA] at time 05:36:45.547699 duration_in_ms=15.257
2018-10-14 05:36:45,550 [salt.state       :1770][INFO    ][6525] Running state [deb http://ubuntu-cloud.archive.canonical.com/ubuntu xenial-updates/pike main] at time 05:36:45.550286
2018-10-14 05:36:45,550 [salt.state       :1803][INFO    ][6525] Executing state pkgrepo.managed for [deb http://ubuntu-cloud.archive.canonical.com/ubuntu xenial-updates/pike main]
2018-10-14 05:36:45,595 [salt.state       :290 ][INFO    ][6525] Package repo 'deb http://ubuntu-cloud.archive.canonical.com/ubuntu xenial-updates/pike main' already configured
2018-10-14 05:36:45,596 [salt.state       :1941][INFO    ][6525] Completed state [deb http://ubuntu-cloud.archive.canonical.com/ubuntu xenial-updates/pike main] at time 05:36:45.596211 duration_in_ms=45.925
2018-10-14 05:36:45,597 [salt.state       :1770][INFO    ][6525] Running state [pkg.refresh_db] at time 05:36:45.597746
2018-10-14 05:36:45,598 [salt.state       :1803][INFO    ][6525] Executing state module.run for [pkg.refresh_db]
2018-10-14 05:36:45,598 [salt.utils.decorators:613 ][WARNING ][6525] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2018-10-14 05:36:45,598 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6525] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2018-10-14 05:36:49,278 [salt.state       :290 ][INFO    ][6525] {'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:49,281 [salt.state       :1941][INFO    ][6525] Completed state [pkg.refresh_db] at time 05:36:49.280977 duration_in_ms=3683.231
2018-10-14 05:36:49,282 [salt.state       :1770][INFO    ][6525] Running state [UTC] at time 05:36:49.282645
2018-10-14 05:36:49,283 [salt.state       :1803][INFO    ][6525] Executing state timezone.system for [UTC]
2018-10-14 05:36:49,284 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6525] Executing command ['timedatectl'] in directory '/root'
2018-10-14 05:36:49,316 [salt.state       :290 ][INFO    ][6525] Timezone UTC already set, UTC already set to UTC
2018-10-14 05:36:49,317 [salt.state       :1941][INFO    ][6525] Completed state [UTC] at time 05:36:49.317121 duration_in_ms=34.474
2018-10-14 05:36:49,318 [salt.state       :1770][INFO    ][6525] Running state [/etc/default/grub.d] at time 05:36:49.318047
2018-10-14 05:36:49,318 [salt.state       :1803][INFO    ][6525] Executing state file.directory for [/etc/default/grub.d]
2018-10-14 05:36:49,320 [salt.state       :290 ][INFO    ][6525] Directory /etc/default/grub.d is in the correct state
Directory /etc/default/grub.d updated
2018-10-14 05:36:49,320 [salt.state       :1941][INFO    ][6525] Completed state [/etc/default/grub.d] at time 05:36:49.320694 duration_in_ms=2.646
2018-10-14 05:36:49,321 [salt.state       :1770][INFO    ][6525] Running state [update-grub] at time 05:36:49.321225
2018-10-14 05:36:49,322 [salt.state       :1803][INFO    ][6525] Executing state cmd.wait for [update-grub]
2018-10-14 05:36:49,322 [salt.state       :290 ][INFO    ][6525] No changes made for update-grub
2018-10-14 05:36:49,323 [salt.state       :1941][INFO    ][6525] Completed state [update-grub] at time 05:36:49.323086 duration_in_ms=1.862
2018-10-14 05:36:49,324 [salt.state       :1770][INFO    ][6525] Running state [/boot/grub/grub.cfg] at time 05:36:49.324869
2018-10-14 05:36:49,325 [salt.state       :1803][INFO    ][6525] Executing state file.managed for [/boot/grub/grub.cfg]
2018-10-14 05:36:49,421 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6525] Executing command ['git', '--version'] in directory '/root'
2018-10-14 05:36:49,579 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6525] Executing command 'test -f /boot/grub/grub.cfg' in directory '/root'
2018-10-14 05:36:49,594 [salt.loaded.int.states.file:2150][WARNING ][6525] 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:49,595 [salt.state       :290 ][INFO    ][6525] File /boot/grub/grub.cfg exists with proper permissions. No changes made.
2018-10-14 05:36:49,596 [salt.state       :1941][INFO    ][6525] Completed state [/boot/grub/grub.cfg] at time 05:36:49.596369 duration_in_ms=271.498
2018-10-14 05:36:49,598 [salt.state       :1770][INFO    ][6525] Running state [nf_conntrack] at time 05:36:49.598667
2018-10-14 05:36:49,599 [salt.state       :1803][INFO    ][6525] Executing state kmod.present for [nf_conntrack]
2018-10-14 05:36:49,600 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6525] Executing command 'lsmod' in directory '/root'
2018-10-14 05:36:49,615 [salt.state       :290 ][INFO    ][6525] Kernel module nf_conntrack is already present
2018-10-14 05:36:49,615 [salt.state       :1941][INFO    ][6525] Completed state [nf_conntrack] at time 05:36:49.615744 duration_in_ms=17.077
2018-10-14 05:36:49,616 [salt.state       :1770][INFO    ][6525] Running state [kernel.panic] at time 05:36:49.616435
2018-10-14 05:36:49,617 [salt.state       :1803][INFO    ][6525] Executing state sysctl.present for [kernel.panic]
2018-10-14 05:36:49,629 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6525] Executing command 'sysctl -n kernel.panic' in directory '/root'
2018-10-14 05:36:49,648 [salt.state       :290 ][INFO    ][6525] Sysctl value kernel.panic = 60 is already set
2018-10-14 05:36:49,649 [salt.state       :1941][INFO    ][6525] Completed state [kernel.panic] at time 05:36:49.649623 duration_in_ms=33.188
2018-10-14 05:36:49,650 [salt.state       :1770][INFO    ][6525] Running state [net.ipv4.tcp_keepalive_probes] at time 05:36:49.650195
2018-10-14 05:36:49,651 [salt.state       :1803][INFO    ][6525] Executing state sysctl.present for [net.ipv4.tcp_keepalive_probes]
2018-10-14 05:36:49,652 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6525] Executing command 'sysctl -n net.ipv4.tcp_keepalive_probes' in directory '/root'
2018-10-14 05:36:49,666 [salt.state       :290 ][INFO    ][6525] Sysctl value net.ipv4.tcp_keepalive_probes = 8 is already set
2018-10-14 05:36:49,667 [salt.state       :1941][INFO    ][6525] Completed state [net.ipv4.tcp_keepalive_probes] at time 05:36:49.667534 duration_in_ms=17.338
2018-10-14 05:36:49,668 [salt.state       :1770][INFO    ][6525] Running state [fs.file-max] at time 05:36:49.668566
2018-10-14 05:36:49,669 [salt.state       :1803][INFO    ][6525] Executing state sysctl.present for [fs.file-max]
2018-10-14 05:36:49,671 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6525] Executing command 'sysctl -n fs.file-max' in directory '/root'
2018-10-14 05:36:49,686 [salt.state       :290 ][INFO    ][6525] Sysctl value fs.file-max = 124165 is already set
2018-10-14 05:36:49,686 [salt.state       :1941][INFO    ][6525] Completed state [fs.file-max] at time 05:36:49.686655 duration_in_ms=18.09
2018-10-14 05:36:49,687 [salt.state       :1770][INFO    ][6525] Running state [net.core.somaxconn] at time 05:36:49.687274
2018-10-14 05:36:49,687 [salt.state       :1803][INFO    ][6525] Executing state sysctl.present for [net.core.somaxconn]
2018-10-14 05:36:49,688 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6525] Executing command 'sysctl -n net.core.somaxconn' in directory '/root'
2018-10-14 05:36:49,702 [salt.state       :290 ][INFO    ][6525] Sysctl value net.core.somaxconn = 4096 is already set
2018-10-14 05:36:49,703 [salt.state       :1941][INFO    ][6525] Completed state [net.core.somaxconn] at time 05:36:49.703387 duration_in_ms=16.112
2018-10-14 05:36:49,704 [salt.state       :1770][INFO    ][6525] Running state [net.ipv4.tcp_max_syn_backlog] at time 05:36:49.704363
2018-10-14 05:36:49,705 [salt.state       :1803][INFO    ][6525] Executing state sysctl.present for [net.ipv4.tcp_max_syn_backlog]
2018-10-14 05:36:49,706 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6525] Executing command 'sysctl -n net.ipv4.tcp_max_syn_backlog' in directory '/root'
2018-10-14 05:36:49,721 [salt.state       :290 ][INFO    ][6525] Sysctl value net.ipv4.tcp_max_syn_backlog = 8192 is already set
2018-10-14 05:36:49,722 [salt.state       :1941][INFO    ][6525] Completed state [net.ipv4.tcp_max_syn_backlog] at time 05:36:49.722756 duration_in_ms=18.394
2018-10-14 05:36:49,723 [salt.state       :1770][INFO    ][6525] Running state [net.ipv4.tcp_tw_reuse] at time 05:36:49.723380
2018-10-14 05:36:49,724 [salt.state       :1803][INFO    ][6525] Executing state sysctl.present for [net.ipv4.tcp_tw_reuse]
2018-10-14 05:36:49,726 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6525] Executing command 'sysctl -n net.ipv4.tcp_tw_reuse' in directory '/root'
2018-10-14 05:36:49,744 [salt.state       :290 ][INFO    ][6525] Sysctl value net.ipv4.tcp_tw_reuse = 1 is already set
2018-10-14 05:36:49,745 [salt.state       :1941][INFO    ][6525] Completed state [net.ipv4.tcp_tw_reuse] at time 05:36:49.745176 duration_in_ms=21.797
2018-10-14 05:36:49,746 [salt.state       :1770][INFO    ][6525] Running state [net.ipv4.tcp_congestion_control] at time 05:36:49.746223
2018-10-14 05:36:49,746 [salt.state       :1803][INFO    ][6525] Executing state sysctl.present for [net.ipv4.tcp_congestion_control]
2018-10-14 05:36:49,748 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6525] Executing command 'sysctl -n net.ipv4.tcp_congestion_control' in directory '/root'
2018-10-14 05:36:49,760 [salt.state       :290 ][INFO    ][6525] Sysctl value net.ipv4.tcp_congestion_control = yeah is already set
2018-10-14 05:36:49,761 [salt.state       :1941][INFO    ][6525] Completed state [net.ipv4.tcp_congestion_control] at time 05:36:49.761038 duration_in_ms=14.816
2018-10-14 05:36:49,762 [salt.state       :1770][INFO    ][6525] Running state [net.ipv4.tcp_retries2] at time 05:36:49.762119
2018-10-14 05:36:49,762 [salt.state       :1803][INFO    ][6525] Executing state sysctl.present for [net.ipv4.tcp_retries2]
2018-10-14 05:36:49,764 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6525] Executing command 'sysctl -n net.ipv4.tcp_retries2' in directory '/root'
2018-10-14 05:36:49,775 [salt.state       :290 ][INFO    ][6525] Sysctl value net.ipv4.tcp_retries2 = 5 is already set
2018-10-14 05:36:49,775 [salt.state       :1941][INFO    ][6525] Completed state [net.ipv4.tcp_retries2] at time 05:36:49.775554 duration_in_ms=13.435
2018-10-14 05:36:49,776 [salt.state       :1770][INFO    ][6525] Running state [net.core.netdev_max_backlog] at time 05:36:49.776076
2018-10-14 05:36:49,776 [salt.state       :1803][INFO    ][6525] Executing state sysctl.present for [net.core.netdev_max_backlog]
2018-10-14 05:36:49,778 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6525] Executing command 'sysctl -n net.core.netdev_max_backlog' in directory '/root'
2018-10-14 05:36:49,793 [salt.state       :290 ][INFO    ][6525] Sysctl value net.core.netdev_max_backlog = 261144 is already set
2018-10-14 05:36:49,794 [salt.state       :1941][INFO    ][6525] Completed state [net.core.netdev_max_backlog] at time 05:36:49.794367 duration_in_ms=18.291
2018-10-14 05:36:49,795 [salt.state       :1770][INFO    ][6525] Running state [net.ipv4.tcp_slow_start_after_idle] at time 05:36:49.795098
2018-10-14 05:36:49,795 [salt.state       :1803][INFO    ][6525] Executing state sysctl.present for [net.ipv4.tcp_slow_start_after_idle]
2018-10-14 05:36:49,797 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6525] Executing command 'sysctl -n net.ipv4.tcp_slow_start_after_idle' in directory '/root'
2018-10-14 05:36:49,815 [salt.state       :290 ][INFO    ][6525] Sysctl value net.ipv4.tcp_slow_start_after_idle = 0 is already set
2018-10-14 05:36:49,815 [salt.state       :1941][INFO    ][6525] Completed state [net.ipv4.tcp_slow_start_after_idle] at time 05:36:49.815643 duration_in_ms=20.531
2018-10-14 05:36:49,816 [salt.state       :1770][INFO    ][6525] Running state [vm.swappiness] at time 05:36:49.816374
2018-10-14 05:36:49,816 [salt.state       :1803][INFO    ][6525] Executing state sysctl.present for [vm.swappiness]
2018-10-14 05:36:49,818 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6525] Executing command 'sysctl -n vm.swappiness' in directory '/root'
2018-10-14 05:36:49,828 [salt.state       :290 ][INFO    ][6525] Sysctl value vm.swappiness = 10 is already set
2018-10-14 05:36:49,828 [salt.state       :1941][INFO    ][6525] Completed state [vm.swappiness] at time 05:36:49.828767 duration_in_ms=12.393
2018-10-14 05:36:49,830 [salt.state       :1770][INFO    ][6525] Running state [net.ipv4.tcp_keepalive_intvl] at time 05:36:49.830375
2018-10-14 05:36:49,830 [salt.state       :1803][INFO    ][6525] Executing state sysctl.present for [net.ipv4.tcp_keepalive_intvl]
2018-10-14 05:36:49,831 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6525] Executing command 'sysctl -n net.ipv4.tcp_keepalive_intvl' in directory '/root'
2018-10-14 05:36:49,846 [salt.state       :290 ][INFO    ][6525] Sysctl value net.ipv4.tcp_keepalive_intvl = 3 is already set
2018-10-14 05:36:49,847 [salt.state       :1941][INFO    ][6525] Completed state [net.ipv4.tcp_keepalive_intvl] at time 05:36:49.846916 duration_in_ms=16.541
2018-10-14 05:36:49,847 [salt.state       :1770][INFO    ][6525] Running state [net.ipv4.neigh.default.gc_thresh1] at time 05:36:49.847683
2018-10-14 05:36:49,848 [salt.state       :1803][INFO    ][6525] Executing state sysctl.present for [net.ipv4.neigh.default.gc_thresh1]
2018-10-14 05:36:49,850 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6525] Executing command 'sysctl -n net.ipv4.neigh.default.gc_thresh1' in directory '/root'
2018-10-14 05:36:49,859 [salt.state       :290 ][INFO    ][6525] Sysctl value net.ipv4.neigh.default.gc_thresh1 = 4096 is already set
2018-10-14 05:36:49,860 [salt.state       :1941][INFO    ][6525] Completed state [net.ipv4.neigh.default.gc_thresh1] at time 05:36:49.860416 duration_in_ms=12.733
2018-10-14 05:36:49,860 [salt.state       :1770][INFO    ][6525] Running state [net.ipv4.neigh.default.gc_thresh2] at time 05:36:49.860932
2018-10-14 05:36:49,861 [salt.state       :1803][INFO    ][6525] Executing state sysctl.present for [net.ipv4.neigh.default.gc_thresh2]
2018-10-14 05:36:49,863 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6525] Executing command 'sysctl -n net.ipv4.neigh.default.gc_thresh2' in directory '/root'
2018-10-14 05:36:49,876 [salt.state       :290 ][INFO    ][6525] Sysctl value net.ipv4.neigh.default.gc_thresh2 = 8192 is already set
2018-10-14 05:36:49,877 [salt.state       :1941][INFO    ][6525] Completed state [net.ipv4.neigh.default.gc_thresh2] at time 05:36:49.877116 duration_in_ms=16.184
2018-10-14 05:36:49,878 [salt.state       :1770][INFO    ][6525] Running state [net.ipv4.neigh.default.gc_thresh3] at time 05:36:49.878239
2018-10-14 05:36:49,879 [salt.state       :1803][INFO    ][6525] Executing state sysctl.present for [net.ipv4.neigh.default.gc_thresh3]
2018-10-14 05:36:49,880 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6525] Executing command 'sysctl -n net.ipv4.neigh.default.gc_thresh3' in directory '/root'
2018-10-14 05:36:49,896 [salt.state       :290 ][INFO    ][6525] Sysctl value net.ipv4.neigh.default.gc_thresh3 = 16384 is already set
2018-10-14 05:36:49,898 [salt.state       :1941][INFO    ][6525] Completed state [net.ipv4.neigh.default.gc_thresh3] at time 05:36:49.898123 duration_in_ms=19.884
2018-10-14 05:36:49,898 [salt.state       :1770][INFO    ][6525] Running state [net.ipv4.tcp_fin_timeout] at time 05:36:49.898520
2018-10-14 05:36:49,898 [salt.state       :1803][INFO    ][6525] Executing state sysctl.present for [net.ipv4.tcp_fin_timeout]
2018-10-14 05:36:49,899 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6525] Executing command 'sysctl -n net.ipv4.tcp_fin_timeout' in directory '/root'
2018-10-14 05:36:49,909 [salt.state       :290 ][INFO    ][6525] Sysctl value net.ipv4.tcp_fin_timeout = 30 is already set
2018-10-14 05:36:49,909 [salt.state       :1941][INFO    ][6525] Completed state [net.ipv4.tcp_fin_timeout] at time 05:36:49.909718 duration_in_ms=11.199
2018-10-14 05:36:49,910 [salt.state       :1770][INFO    ][6525] Running state [net.ipv4.tcp_keepalive_time] at time 05:36:49.910081
2018-10-14 05:36:49,910 [salt.state       :1803][INFO    ][6525] Executing state sysctl.present for [net.ipv4.tcp_keepalive_time]
2018-10-14 05:36:49,911 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6525] Executing command 'sysctl -n net.ipv4.tcp_keepalive_time' in directory '/root'
2018-10-14 05:36:49,920 [salt.state       :290 ][INFO    ][6525] Sysctl value net.ipv4.tcp_keepalive_time = 30 is already set
2018-10-14 05:36:49,921 [salt.state       :1941][INFO    ][6525] Completed state [net.ipv4.tcp_keepalive_time] at time 05:36:49.921061 duration_in_ms=10.98
2018-10-14 05:36:49,921 [salt.state       :1770][INFO    ][6525] Running state [net.nf_conntrack_max] at time 05:36:49.921775
2018-10-14 05:36:49,922 [salt.state       :1803][INFO    ][6525] Executing state sysctl.present for [net.nf_conntrack_max]
2018-10-14 05:36:49,922 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6525] Executing command 'sysctl -n net.nf_conntrack_max' in directory '/root'
2018-10-14 05:36:49,932 [salt.state       :290 ][INFO    ][6525] Sysctl value net.nf_conntrack_max = 1048576 is already set
2018-10-14 05:36:49,933 [salt.state       :1941][INFO    ][6525] Completed state [net.nf_conntrack_max] at time 05:36:49.933095 duration_in_ms=11.32
2018-10-14 05:36:49,934 [salt.state       :1770][INFO    ][6525] Running state [linux_sysfs_package] at time 05:36:49.934058
2018-10-14 05:36:49,934 [salt.state       :1803][INFO    ][6525] Executing state pkg.installed for [linux_sysfs_package]
2018-10-14 05:36:49,943 [salt.state       :290 ][INFO    ][6525] All specified packages are already installed
2018-10-14 05:36:49,943 [salt.state       :1941][INFO    ][6525] Completed state [linux_sysfs_package] at time 05:36:49.943460 duration_in_ms=9.401
2018-10-14 05:36:49,945 [salt.state       :1770][INFO    ][6525] Running state [/etc/sysfs.d] at time 05:36:49.945103
2018-10-14 05:36:49,946 [salt.state       :1803][INFO    ][6525] Executing state file.directory for [/etc/sysfs.d]
2018-10-14 05:36:49,947 [salt.state       :290 ][INFO    ][6525] Directory /etc/sysfs.d is in the correct state
Directory /etc/sysfs.d updated
2018-10-14 05:36:49,947 [salt.state       :1941][INFO    ][6525] Completed state [/etc/sysfs.d] at time 05:36:49.947542 duration_in_ms=2.439
2018-10-14 05:36:49,947 [salt.state       :1770][INFO    ][6525] Running state [ondemand] at time 05:36:49.947753
2018-10-14 05:36:49,947 [salt.state       :1803][INFO    ][6525] Executing state service.dead for [ondemand]
2018-10-14 05:36:49,948 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6525] Executing command ['systemctl', 'status', 'ondemand.service', '-n', '0'] in directory '/root'
2018-10-14 05:36:49,966 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6525] Executing command ['systemctl', 'is-active', 'ondemand.service'] in directory '/root'
2018-10-14 05:36:49,987 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6525] Executing command ['systemctl', 'is-enabled', 'ondemand.service'] in directory '/root'
2018-10-14 05:36:50,011 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6525] Executing command 'runlevel' in directory '/root'
2018-10-14 05:36:50,023 [salt.state       :290 ][INFO    ][6525] The service ondemand is already dead
2018-10-14 05:36:50,024 [salt.state       :1941][INFO    ][6525] Completed state [ondemand] at time 05:36:50.024073 duration_in_ms=76.32
2018-10-14 05:36:50,024 [salt.state       :1770][INFO    ][6525] Running state [cs_CZ.UTF-8] at time 05:36:50.024414
2018-10-14 05:36:50,024 [salt.state       :1803][INFO    ][6525] Executing state locale.present for [cs_CZ.UTF-8]
2018-10-14 05:36:50,025 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6525] Executing command 'locale -a' in directory '/root'
2018-10-14 05:36:50,039 [salt.state       :290 ][INFO    ][6525] Locale cs_CZ.UTF-8 is already present
2018-10-14 05:36:50,039 [salt.state       :1941][INFO    ][6525] Completed state [cs_CZ.UTF-8] at time 05:36:50.039898 duration_in_ms=15.483
2018-10-14 05:36:50,040 [salt.state       :1770][INFO    ][6525] Running state [en_US.UTF-8] at time 05:36:50.040233
2018-10-14 05:36:50,040 [salt.state       :1803][INFO    ][6525] Executing state locale.present for [en_US.UTF-8]
2018-10-14 05:36:50,041 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6525] Executing command 'locale -a' in directory '/root'
2018-10-14 05:36:50,055 [salt.state       :290 ][INFO    ][6525] Locale en_US.UTF-8 is already present
2018-10-14 05:36:50,055 [salt.state       :1941][INFO    ][6525] Completed state [en_US.UTF-8] at time 05:36:50.055784 duration_in_ms=15.551
2018-10-14 05:36:50,058 [salt.state       :1770][INFO    ][6525] Running state [en_US.UTF-8] at time 05:36:50.058838
2018-10-14 05:36:50,059 [salt.state       :1803][INFO    ][6525] Executing state locale.system for [en_US.UTF-8]
2018-10-14 05:36:50,059 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6525] Executing command 'localectl' in directory '/root'
2018-10-14 05:36:50,088 [salt.state       :290 ][INFO    ][6525] System locale en_US.UTF-8 already set
2018-10-14 05:36:50,090 [salt.state       :1941][INFO    ][6525] Completed state [en_US.UTF-8] at time 05:36:50.090600 duration_in_ms=31.762
2018-10-14 05:36:50,091 [salt.state       :1770][INFO    ][6525] Running state [root] at time 05:36:50.091166
2018-10-14 05:36:50,091 [salt.state       :1803][INFO    ][6525] Executing state group.present for [root]
2018-10-14 05:36:50,092 [salt.state       :290 ][INFO    ][6525] Group root is present and up to date
2018-10-14 05:36:50,092 [salt.state       :1941][INFO    ][6525] Completed state [root] at time 05:36:50.092559 duration_in_ms=1.393
2018-10-14 05:36:50,094 [salt.state       :1770][INFO    ][6525] Running state [root] at time 05:36:50.094841
2018-10-14 05:36:50,095 [salt.state       :1803][INFO    ][6525] Executing state user.present for [root]
2018-10-14 05:36:50,096 [salt.state       :290 ][INFO    ][6525] User root is present and up to date
2018-10-14 05:36:50,097 [salt.state       :1941][INFO    ][6525] Completed state [root] at time 05:36:50.097227 duration_in_ms=2.387
2018-10-14 05:36:50,098 [salt.state       :1770][INFO    ][6525] Running state [/root] at time 05:36:50.098882
2018-10-14 05:36:50,099 [salt.state       :1803][INFO    ][6525] Executing state file.directory for [/root]
2018-10-14 05:36:50,100 [salt.state       :290 ][INFO    ][6525] Directory /root is in the correct state
Directory /root updated
2018-10-14 05:36:50,100 [salt.state       :1941][INFO    ][6525] Completed state [/root] at time 05:36:50.100569 duration_in_ms=1.687
2018-10-14 05:36:50,100 [salt.state       :1770][INFO    ][6525] Running state [/etc/sudoers.d/90-salt-user-root] at time 05:36:50.100870
2018-10-14 05:36:50,101 [salt.state       :1803][INFO    ][6525] Executing state file.absent for [/etc/sudoers.d/90-salt-user-root]
2018-10-14 05:36:50,102 [salt.state       :290 ][INFO    ][6525] File /etc/sudoers.d/90-salt-user-root is not present
2018-10-14 05:36:50,102 [salt.state       :1941][INFO    ][6525] Completed state [/etc/sudoers.d/90-salt-user-root] at time 05:36:50.102592 duration_in_ms=1.722
2018-10-14 05:36:50,102 [salt.state       :1770][INFO    ][6525] Running state [ubuntu] at time 05:36:50.102777
2018-10-14 05:36:50,102 [salt.state       :1803][INFO    ][6525] Executing state group.present for [ubuntu]
2018-10-14 05:36:50,103 [salt.state       :290 ][INFO    ][6525] Group ubuntu is present and up to date
2018-10-14 05:36:50,103 [salt.state       :1941][INFO    ][6525] Completed state [ubuntu] at time 05:36:50.103507 duration_in_ms=0.729
2018-10-14 05:36:50,104 [salt.state       :1770][INFO    ][6525] Running state [ubuntu] at time 05:36:50.104313
2018-10-14 05:36:50,104 [salt.state       :1803][INFO    ][6525] Executing state user.present for [ubuntu]
2018-10-14 05:36:50,105 [salt.state       :290 ][INFO    ][6525] User ubuntu is present and up to date
2018-10-14 05:36:50,105 [salt.state       :1941][INFO    ][6525] Completed state [ubuntu] at time 05:36:50.105637 duration_in_ms=1.324
2018-10-14 05:36:50,106 [salt.state       :1770][INFO    ][6525] Running state [/home/ubuntu] at time 05:36:50.106631
2018-10-14 05:36:50,106 [salt.state       :1803][INFO    ][6525] Executing state file.directory for [/home/ubuntu]
2018-10-14 05:36:50,107 [salt.state       :290 ][INFO    ][6525] Directory /home/ubuntu is in the correct state
Directory /home/ubuntu updated
2018-10-14 05:36:50,107 [salt.state       :1941][INFO    ][6525] Completed state [/home/ubuntu] at time 05:36:50.107774 duration_in_ms=1.143
2018-10-14 05:36:50,108 [salt.state       :1770][INFO    ][6525] Running state [/etc/sudoers.d/90-salt-user-ubuntu] at time 05:36:50.108625
2018-10-14 05:36:50,108 [salt.state       :1803][INFO    ][6525] Executing state file.managed for [/etc/sudoers.d/90-salt-user-ubuntu]
2018-10-14 05:36:50,134 [salt.state       :290 ][INFO    ][6525] File /etc/sudoers.d/90-salt-user-ubuntu is in the correct state
2018-10-14 05:36:50,134 [salt.state       :1941][INFO    ][6525] Completed state [/etc/sudoers.d/90-salt-user-ubuntu] at time 05:36:50.134872 duration_in_ms=26.246
2018-10-14 05:36:50,135 [salt.state       :1770][INFO    ][6525] Running state [/etc/security/limits.d/90-salt-default.conf] at time 05:36:50.135107
2018-10-14 05:36:50,135 [salt.state       :1803][INFO    ][6525] Executing state file.managed for [/etc/security/limits.d/90-salt-default.conf]
2018-10-14 05:36:50,252 [salt.state       :290 ][INFO    ][6525] File /etc/security/limits.d/90-salt-default.conf is in the correct state
2018-10-14 05:36:50,253 [salt.state       :1941][INFO    ][6525] Completed state [/etc/security/limits.d/90-salt-default.conf] at time 05:36:50.253030 duration_in_ms=117.923
2018-10-14 05:36:50,253 [salt.state       :1770][INFO    ][6525] Running state [/etc/systemd/system.conf.d/90-salt.conf] at time 05:36:50.253224
2018-10-14 05:36:50,253 [salt.state       :1803][INFO    ][6525] Executing state file.managed for [/etc/systemd/system.conf.d/90-salt.conf]
2018-10-14 05:36:50,362 [salt.state       :290 ][INFO    ][6525] File /etc/systemd/system.conf.d/90-salt.conf is in the correct state
2018-10-14 05:36:50,362 [salt.state       :1941][INFO    ][6525] Completed state [/etc/systemd/system.conf.d/90-salt.conf] at time 05:36:50.362239 duration_in_ms=109.014
2018-10-14 05:36:50,363 [salt.state       :1770][INFO    ][6525] Running state [service.systemctl_reload] at time 05:36:50.363109
2018-10-14 05:36:50,363 [salt.state       :1803][INFO    ][6525] Executing state module.wait for [service.systemctl_reload]
2018-10-14 05:36:50,363 [salt.state       :290 ][INFO    ][6525] No changes made for service.systemctl_reload
2018-10-14 05:36:50,363 [salt.state       :1941][INFO    ][6525] Completed state [service.systemctl_reload] at time 05:36:50.363694 duration_in_ms=0.585
2018-10-14 05:36:50,363 [salt.state       :1770][INFO    ][6525] Running state [/etc/issue] at time 05:36:50.363883
2018-10-14 05:36:50,364 [salt.state       :1803][INFO    ][6525] Executing state file.managed for [/etc/issue]
2018-10-14 05:36:50,365 [salt.state       :290 ][INFO    ][6525] File /etc/issue is in the correct state
2018-10-14 05:36:50,365 [salt.state       :1941][INFO    ][6525] Completed state [/etc/issue] at time 05:36:50.365766 duration_in_ms=1.883
2018-10-14 05:36:50,366 [salt.state       :1770][INFO    ][6525] Running state [/etc/hostname] at time 05:36:50.365980
2018-10-14 05:36:50,366 [salt.state       :1803][INFO    ][6525] Executing state file.managed for [/etc/hostname]
2018-10-14 05:36:50,392 [salt.state       :290 ][INFO    ][6525] File /etc/hostname is in the correct state
2018-10-14 05:36:50,392 [salt.state       :1941][INFO    ][6525] Completed state [/etc/hostname] at time 05:36:50.392595 duration_in_ms=26.615
2018-10-14 05:36:50,393 [salt.state       :1770][INFO    ][6525] Running state [hostname msg02] at time 05:36:50.393719
2018-10-14 05:36:50,394 [salt.state       :1803][INFO    ][6525] Executing state cmd.run for [hostname msg02]
2018-10-14 05:36:50,394 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6525] Executing command 'test "$(hostname)" = "msg02"' in directory '/root'
2018-10-14 05:36:50,410 [salt.state       :290 ][INFO    ][6525] unless execution succeeded
2018-10-14 05:36:50,411 [salt.state       :1941][INFO    ][6525] Completed state [hostname msg02] at time 05:36:50.411371 duration_in_ms=17.652
2018-10-14 05:36:50,412 [salt.state       :1770][INFO    ][6525] Running state [mdb02] at time 05:36:50.411999
2018-10-14 05:36:50,412 [salt.state       :1803][INFO    ][6525] Executing state host.present for [mdb02]
2018-10-14 05:36:50,414 [salt.state       :290 ][INFO    ][6525] Host mdb02 (192.168.10.33) already present
2018-10-14 05:36:50,414 [salt.state       :1941][INFO    ][6525] Completed state [mdb02] at time 05:36:50.414460 duration_in_ms=2.461
2018-10-14 05:36:50,414 [salt.state       :1770][INFO    ][6525] Running state [mdb02.mcp-pike-odl-ha.local] at time 05:36:50.414758
2018-10-14 05:36:50,415 [salt.state       :1803][INFO    ][6525] Executing state host.present for [mdb02.mcp-pike-odl-ha.local]
2018-10-14 05:36:50,415 [salt.state       :290 ][INFO    ][6525] Host mdb02.mcp-pike-odl-ha.local (192.168.10.33) already present
2018-10-14 05:36:50,415 [salt.state       :1941][INFO    ][6525] Completed state [mdb02.mcp-pike-odl-ha.local] at time 05:36:50.415787 duration_in_ms=1.03
2018-10-14 05:36:50,416 [salt.state       :1770][INFO    ][6525] Running state [mdb03] at time 05:36:50.416100
2018-10-14 05:36:50,416 [salt.state       :1803][INFO    ][6525] Executing state host.present for [mdb03]
2018-10-14 05:36:50,416 [salt.state       :290 ][INFO    ][6525] Host mdb03 (192.168.10.34) already present
2018-10-14 05:36:50,417 [salt.state       :1941][INFO    ][6525] Completed state [mdb03] at time 05:36:50.417044 duration_in_ms=0.944
2018-10-14 05:36:50,417 [salt.state       :1770][INFO    ][6525] Running state [mdb03.mcp-pike-odl-ha.local] at time 05:36:50.417696
2018-10-14 05:36:50,417 [salt.state       :1803][INFO    ][6525] Executing state host.present for [mdb03.mcp-pike-odl-ha.local]
2018-10-14 05:36:50,418 [salt.state       :290 ][INFO    ][6525] Host mdb03.mcp-pike-odl-ha.local (192.168.10.34) already present
2018-10-14 05:36:50,418 [salt.state       :1941][INFO    ][6525] Completed state [mdb03.mcp-pike-odl-ha.local] at time 05:36:50.418630 duration_in_ms=0.934
2018-10-14 05:36:50,418 [salt.state       :1770][INFO    ][6525] Running state [mdb01] at time 05:36:50.418918
2018-10-14 05:36:50,419 [salt.state       :1803][INFO    ][6525] Executing state host.present for [mdb01]
2018-10-14 05:36:50,419 [salt.state       :290 ][INFO    ][6525] Host mdb01 (192.168.10.32) already present
2018-10-14 05:36:50,419 [salt.state       :1941][INFO    ][6525] Completed state [mdb01] at time 05:36:50.419914 duration_in_ms=0.995
2018-10-14 05:36:50,420 [salt.state       :1770][INFO    ][6525] Running state [mdb01.mcp-pike-odl-ha.local] at time 05:36:50.420209
2018-10-14 05:36:50,420 [salt.state       :1803][INFO    ][6525] Executing state host.present for [mdb01.mcp-pike-odl-ha.local]
2018-10-14 05:36:50,420 [salt.state       :290 ][INFO    ][6525] Host mdb01.mcp-pike-odl-ha.local (192.168.10.32) already present
2018-10-14 05:36:50,421 [salt.state       :1941][INFO    ][6525] Completed state [mdb01.mcp-pike-odl-ha.local] at time 05:36:50.421082 duration_in_ms=0.874
2018-10-14 05:36:50,421 [salt.state       :1770][INFO    ][6525] Running state [mdb] at time 05:36:50.421412
2018-10-14 05:36:50,421 [salt.state       :1803][INFO    ][6525] Executing state host.present for [mdb]
2018-10-14 05:36:50,422 [salt.state       :290 ][INFO    ][6525] Host mdb (192.168.10.31) already present
2018-10-14 05:36:50,422 [salt.state       :1941][INFO    ][6525] Completed state [mdb] at time 05:36:50.422325 duration_in_ms=0.913
2018-10-14 05:36:50,422 [salt.state       :1770][INFO    ][6525] Running state [mdb.mcp-pike-odl-ha.local] at time 05:36:50.422633
2018-10-14 05:36:50,422 [salt.state       :1803][INFO    ][6525] Executing state host.present for [mdb.mcp-pike-odl-ha.local]
2018-10-14 05:36:50,423 [salt.state       :290 ][INFO    ][6525] Host mdb.mcp-pike-odl-ha.local (192.168.10.31) already present
2018-10-14 05:36:50,423 [salt.state       :1941][INFO    ][6525] Completed state [mdb.mcp-pike-odl-ha.local] at time 05:36:50.423641 duration_in_ms=1.008
2018-10-14 05:36:50,423 [salt.state       :1770][INFO    ][6525] Running state [cfg01] at time 05:36:50.423897
2018-10-14 05:36:50,424 [salt.state       :1803][INFO    ][6525] Executing state host.present for [cfg01]
2018-10-14 05:36:50,426 [salt.state       :290 ][INFO    ][6525] Host cfg01 (192.168.10.11) already present
2018-10-14 05:36:50,426 [salt.state       :1941][INFO    ][6525] Completed state [cfg01] at time 05:36:50.426834 duration_in_ms=2.937
2018-10-14 05:36:50,427 [salt.state       :1770][INFO    ][6525] Running state [cfg01.mcp-pike-odl-ha.local] at time 05:36:50.427196
2018-10-14 05:36:50,427 [salt.state       :1803][INFO    ][6525] Executing state host.present for [cfg01.mcp-pike-odl-ha.local]
2018-10-14 05:36:50,427 [salt.state       :290 ][INFO    ][6525] Host cfg01.mcp-pike-odl-ha.local (192.168.10.11) already present
2018-10-14 05:36:50,428 [salt.state       :1941][INFO    ][6525] Completed state [cfg01.mcp-pike-odl-ha.local] at time 05:36:50.428087 duration_in_ms=0.891
2018-10-14 05:36:50,428 [salt.state       :1770][INFO    ][6525] Running state [prx01] at time 05:36:50.428343
2018-10-14 05:36:50,428 [salt.state       :1803][INFO    ][6525] Executing state host.present for [prx01]
2018-10-14 05:36:50,428 [salt.state       :290 ][INFO    ][6525] Host prx01 (192.168.10.14) already present
2018-10-14 05:36:50,429 [salt.state       :1941][INFO    ][6525] Completed state [prx01] at time 05:36:50.429131 duration_in_ms=0.788
2018-10-14 05:36:50,430 [salt.state       :1770][INFO    ][6525] Running state [prx01.mcp-pike-odl-ha.local] at time 05:36:50.429999
2018-10-14 05:36:50,430 [salt.state       :1803][INFO    ][6525] Executing state host.present for [prx01.mcp-pike-odl-ha.local]
2018-10-14 05:36:50,430 [salt.state       :290 ][INFO    ][6525] Host prx01.mcp-pike-odl-ha.local (192.168.10.14) already present
2018-10-14 05:36:50,430 [salt.state       :1941][INFO    ][6525] Completed state [prx01.mcp-pike-odl-ha.local] at time 05:36:50.430813 duration_in_ms=0.814
2018-10-14 05:36:50,431 [salt.state       :1770][INFO    ][6525] Running state [kvm01] at time 05:36:50.431112
2018-10-14 05:36:50,431 [salt.state       :1803][INFO    ][6525] Executing state host.present for [kvm01]
2018-10-14 05:36:50,431 [salt.state       :290 ][INFO    ][6525] Host kvm01 (192.168.10.20) already present
2018-10-14 05:36:50,431 [salt.state       :1941][INFO    ][6525] Completed state [kvm01] at time 05:36:50.431906 duration_in_ms=0.794
2018-10-14 05:36:50,432 [salt.state       :1770][INFO    ][6525] Running state [kvm01.mcp-pike-odl-ha.local] at time 05:36:50.432164
2018-10-14 05:36:50,432 [salt.state       :1803][INFO    ][6525] Executing state host.present for [kvm01.mcp-pike-odl-ha.local]
2018-10-14 05:36:50,432 [salt.state       :290 ][INFO    ][6525] Host kvm01.mcp-pike-odl-ha.local (192.168.10.20) already present
2018-10-14 05:36:50,432 [salt.state       :1941][INFO    ][6525] Completed state [kvm01.mcp-pike-odl-ha.local] at time 05:36:50.432958 duration_in_ms=0.794
2018-10-14 05:36:50,433 [salt.state       :1770][INFO    ][6525] Running state [kvm03] at time 05:36:50.433230
2018-10-14 05:36:50,433 [salt.state       :1803][INFO    ][6525] Executing state host.present for [kvm03]
2018-10-14 05:36:50,434 [salt.state       :290 ][INFO    ][6525] Host kvm03 (192.168.10.22) already present
2018-10-14 05:36:50,434 [salt.state       :1941][INFO    ][6525] Completed state [kvm03] at time 05:36:50.434404 duration_in_ms=1.174
2018-10-14 05:36:50,434 [salt.state       :1770][INFO    ][6525] Running state [kvm03.mcp-pike-odl-ha.local] at time 05:36:50.434657
2018-10-14 05:36:50,434 [salt.state       :1803][INFO    ][6525] Executing state host.present for [kvm03.mcp-pike-odl-ha.local]
2018-10-14 05:36:50,435 [salt.state       :290 ][INFO    ][6525] Host kvm03.mcp-pike-odl-ha.local (192.168.10.22) already present
2018-10-14 05:36:50,435 [salt.state       :1941][INFO    ][6525] Completed state [kvm03.mcp-pike-odl-ha.local] at time 05:36:50.435483 duration_in_ms=0.826
2018-10-14 05:36:50,435 [salt.state       :1770][INFO    ][6525] Running state [kvm02] at time 05:36:50.435742
2018-10-14 05:36:50,435 [salt.state       :1803][INFO    ][6525] Executing state host.present for [kvm02]
2018-10-14 05:36:50,436 [salt.state       :290 ][INFO    ][6525] Host kvm02 (192.168.10.21) already present
2018-10-14 05:36:50,436 [salt.state       :1941][INFO    ][6525] Completed state [kvm02] at time 05:36:50.436508 duration_in_ms=0.767
2018-10-14 05:36:50,436 [salt.state       :1770][INFO    ][6525] Running state [kvm02.mcp-pike-odl-ha.local] at time 05:36:50.436767
2018-10-14 05:36:50,436 [salt.state       :1803][INFO    ][6525] Executing state host.present for [kvm02.mcp-pike-odl-ha.local]
2018-10-14 05:36:50,437 [salt.state       :290 ][INFO    ][6525] Host kvm02.mcp-pike-odl-ha.local (192.168.10.21) already present
2018-10-14 05:36:50,437 [salt.state       :1941][INFO    ][6525] Completed state [kvm02.mcp-pike-odl-ha.local] at time 05:36:50.437888 duration_in_ms=1.122
2018-10-14 05:36:50,438 [salt.state       :1770][INFO    ][6525] Running state [dbs] at time 05:36:50.438145
2018-10-14 05:36:50,438 [salt.state       :1803][INFO    ][6525] Executing state host.present for [dbs]
2018-10-14 05:36:50,438 [salt.state       :290 ][INFO    ][6525] Host dbs (192.168.10.23) already present
2018-10-14 05:36:50,438 [salt.state       :1941][INFO    ][6525] Completed state [dbs] at time 05:36:50.438909 duration_in_ms=0.763
2018-10-14 05:36:50,439 [salt.state       :1770][INFO    ][6525] Running state [dbs.mcp-pike-odl-ha.local] at time 05:36:50.439208
2018-10-14 05:36:50,439 [salt.state       :1803][INFO    ][6525] Executing state host.present for [dbs.mcp-pike-odl-ha.local]
2018-10-14 05:36:50,439 [salt.state       :290 ][INFO    ][6525] Host dbs.mcp-pike-odl-ha.local (192.168.10.23) already present
2018-10-14 05:36:50,440 [salt.state       :1941][INFO    ][6525] Completed state [dbs.mcp-pike-odl-ha.local] at time 05:36:50.439984 duration_in_ms=0.776
2018-10-14 05:36:50,440 [salt.state       :1770][INFO    ][6525] Running state [prx] at time 05:36:50.440251
2018-10-14 05:36:50,440 [salt.state       :1803][INFO    ][6525] Executing state host.present for [prx]
2018-10-14 05:36:50,440 [salt.state       :290 ][INFO    ][6525] Host prx (192.168.10.13) already present
2018-10-14 05:36:50,441 [salt.state       :1941][INFO    ][6525] Completed state [prx] at time 05:36:50.441016 duration_in_ms=0.765
2018-10-14 05:36:50,441 [salt.state       :1770][INFO    ][6525] Running state [prx.mcp-pike-odl-ha.local] at time 05:36:50.441868
2018-10-14 05:36:50,442 [salt.state       :1803][INFO    ][6525] Executing state host.present for [prx.mcp-pike-odl-ha.local]
2018-10-14 05:36:50,442 [salt.state       :290 ][INFO    ][6525] Host prx.mcp-pike-odl-ha.local (192.168.10.13) already present
2018-10-14 05:36:50,442 [salt.state       :1941][INFO    ][6525] Completed state [prx.mcp-pike-odl-ha.local] at time 05:36:50.442678 duration_in_ms=0.81
2018-10-14 05:36:50,442 [salt.state       :1770][INFO    ][6525] Running state [prx02] at time 05:36:50.442948
2018-10-14 05:36:50,443 [salt.state       :1803][INFO    ][6525] Executing state host.present for [prx02]
2018-10-14 05:36:50,443 [salt.state       :290 ][INFO    ][6525] Host prx02 (192.168.10.15) already present
2018-10-14 05:36:50,443 [salt.state       :1941][INFO    ][6525] Completed state [prx02] at time 05:36:50.443786 duration_in_ms=0.838
2018-10-14 05:36:50,444 [salt.state       :1770][INFO    ][6525] Running state [prx02.mcp-pike-odl-ha.local] at time 05:36:50.444059
2018-10-14 05:36:50,444 [salt.state       :1803][INFO    ][6525] Executing state host.present for [prx02.mcp-pike-odl-ha.local]
2018-10-14 05:36:50,444 [salt.state       :290 ][INFO    ][6525] Host prx02.mcp-pike-odl-ha.local (192.168.10.15) already present
2018-10-14 05:36:50,444 [salt.state       :1941][INFO    ][6525] Completed state [prx02.mcp-pike-odl-ha.local] at time 05:36:50.444821 duration_in_ms=0.763
2018-10-14 05:36:50,445 [salt.state       :1770][INFO    ][6525] Running state [msg02] at time 05:36:50.445084
2018-10-14 05:36:50,445 [salt.state       :1803][INFO    ][6525] Executing state host.present for [msg02]
2018-10-14 05:36:50,446 [salt.state       :290 ][INFO    ][6525] Host msg02 (192.168.10.29) already present
2018-10-14 05:36:50,446 [salt.state       :1941][INFO    ][6525] Completed state [msg02] at time 05:36:50.446208 duration_in_ms=1.123
2018-10-14 05:36:50,446 [salt.state       :1770][INFO    ][6525] Running state [msg02.mcp-pike-odl-ha.local] at time 05:36:50.446469
2018-10-14 05:36:50,446 [salt.state       :1803][INFO    ][6525] Executing state host.present for [msg02.mcp-pike-odl-ha.local]
2018-10-14 05:36:50,447 [salt.state       :290 ][INFO    ][6525] Host msg02.mcp-pike-odl-ha.local (192.168.10.29) already present
2018-10-14 05:36:50,447 [salt.state       :1941][INFO    ][6525] Completed state [msg02.mcp-pike-odl-ha.local] at time 05:36:50.447283 duration_in_ms=0.813
2018-10-14 05:36:50,448 [salt.state       :1770][INFO    ][6525] Running state [file.replace] at time 05:36:50.448792
2018-10-14 05:36:50,449 [salt.state       :1803][INFO    ][6525] Executing state module.run for [file.replace]
2018-10-14 05:36:50,454 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6525] Executing command 'grep -q "msg02 msg02.mcp-pike-odl-ha.local" /etc/hosts' in directory '/root'
2018-10-14 05:36:50,468 [salt.utils.decorators:613 ][WARNING ][6525] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2018-10-14 05:36:50,473 [salt.state       :290 ][INFO    ][6525] {'ret': '--- \n+++ \n@@ -18,7 +18,7 @@\n 192.168.10.23\t\tdbs dbs.mcp-pike-odl-ha.local\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.29\t\tmsg02.mcp-pike-odl-ha.local msg02\n 192.168.10.30\t\tmsg03 msg03.mcp-pike-odl-ha.local\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'}
2018-10-14 05:36:50,473 [salt.state       :1941][INFO    ][6525] Completed state [file.replace] at time 05:36:50.473207 duration_in_ms=24.415
2018-10-14 05:36:50,473 [salt.state       :1770][INFO    ][6525] Running state [msg03] at time 05:36:50.473691
2018-10-14 05:36:50,473 [salt.state       :1803][INFO    ][6525] Executing state host.present for [msg03]
2018-10-14 05:36:50,474 [salt.state       :290 ][INFO    ][6525] Host msg03 (192.168.10.30) already present
2018-10-14 05:36:50,474 [salt.state       :1941][INFO    ][6525] Completed state [msg03] at time 05:36:50.474664 duration_in_ms=0.974
2018-10-14 05:36:50,474 [salt.state       :1770][INFO    ][6525] Running state [msg03.mcp-pike-odl-ha.local] at time 05:36:50.474959
2018-10-14 05:36:50,475 [salt.state       :1803][INFO    ][6525] Executing state host.present for [msg03.mcp-pike-odl-ha.local]
2018-10-14 05:36:50,475 [salt.state       :290 ][INFO    ][6525] Host msg03.mcp-pike-odl-ha.local (192.168.10.30) already present
2018-10-14 05:36:50,475 [salt.state       :1941][INFO    ][6525] Completed state [msg03.mcp-pike-odl-ha.local] at time 05:36:50.475820 duration_in_ms=0.862
2018-10-14 05:36:50,476 [salt.state       :1770][INFO    ][6525] Running state [msg01] at time 05:36:50.476100
2018-10-14 05:36:50,476 [salt.state       :1803][INFO    ][6525] Executing state host.present for [msg01]
2018-10-14 05:36:50,476 [salt.state       :290 ][INFO    ][6525] Host msg01 (192.168.10.28) already present
2018-10-14 05:36:50,476 [salt.state       :1941][INFO    ][6525] Completed state [msg01] at time 05:36:50.476876 duration_in_ms=0.776
2018-10-14 05:36:50,477 [salt.state       :1770][INFO    ][6525] Running state [msg01.mcp-pike-odl-ha.local] at time 05:36:50.477143
2018-10-14 05:36:50,477 [salt.state       :1803][INFO    ][6525] Executing state host.present for [msg01.mcp-pike-odl-ha.local]
2018-10-14 05:36:50,478 [salt.state       :290 ][INFO    ][6525] Host msg01.mcp-pike-odl-ha.local (192.168.10.28) already present
2018-10-14 05:36:50,478 [salt.state       :1941][INFO    ][6525] Completed state [msg01.mcp-pike-odl-ha.local] at time 05:36:50.478284 duration_in_ms=1.142
2018-10-14 05:36:50,478 [salt.state       :1770][INFO    ][6525] Running state [msg] at time 05:36:50.478557
2018-10-14 05:36:50,478 [salt.state       :1803][INFO    ][6525] Executing state host.present for [msg]
2018-10-14 05:36:50,479 [salt.state       :290 ][INFO    ][6525] Host msg (192.168.10.27) already present
2018-10-14 05:36:50,479 [salt.state       :1941][INFO    ][6525] Completed state [msg] at time 05:36:50.479413 duration_in_ms=0.855
2018-10-14 05:36:50,479 [salt.state       :1770][INFO    ][6525] Running state [msg.mcp-pike-odl-ha.local] at time 05:36:50.479680
2018-10-14 05:36:50,479 [salt.state       :1803][INFO    ][6525] Executing state host.present for [msg.mcp-pike-odl-ha.local]
2018-10-14 05:36:50,480 [salt.state       :290 ][INFO    ][6525] Host msg.mcp-pike-odl-ha.local (192.168.10.27) already present
2018-10-14 05:36:50,480 [salt.state       :1941][INFO    ][6525] Completed state [msg.mcp-pike-odl-ha.local] at time 05:36:50.480453 duration_in_ms=0.772
2018-10-14 05:36:50,480 [salt.state       :1770][INFO    ][6525] Running state [cfg01] at time 05:36:50.480722
2018-10-14 05:36:50,480 [salt.state       :1803][INFO    ][6525] Executing state host.present for [cfg01]
2018-10-14 05:36:50,481 [salt.state       :290 ][INFO    ][6525] Host cfg01 (192.168.10.11) already present
2018-10-14 05:36:50,481 [salt.state       :1941][INFO    ][6525] Completed state [cfg01] at time 05:36:50.481509 duration_in_ms=0.787
2018-10-14 05:36:50,481 [salt.state       :1770][INFO    ][6525] Running state [cfg01.mcp-pike-odl-ha.local] at time 05:36:50.481778
2018-10-14 05:36:50,481 [salt.state       :1803][INFO    ][6525] Executing state host.present for [cfg01.mcp-pike-odl-ha.local]
2018-10-14 05:36:50,482 [salt.state       :290 ][INFO    ][6525] Host cfg01.mcp-pike-odl-ha.local (192.168.10.11) already present
2018-10-14 05:36:50,482 [salt.state       :1941][INFO    ][6525] Completed state [cfg01.mcp-pike-odl-ha.local] at time 05:36:50.482550 duration_in_ms=0.772
2018-10-14 05:36:50,482 [salt.state       :1770][INFO    ][6525] Running state [cmp002] at time 05:36:50.482819
2018-10-14 05:36:50,483 [salt.state       :1803][INFO    ][6525] Executing state host.present for [cmp002]
2018-10-14 05:36:50,483 [salt.state       :290 ][INFO    ][6525] Host cmp002 (192.168.10.53) already present
2018-10-14 05:36:50,483 [salt.state       :1941][INFO    ][6525] Completed state [cmp002] at time 05:36:50.483671 duration_in_ms=0.852
2018-10-14 05:36:50,483 [salt.state       :1770][INFO    ][6525] Running state [cmp002.mcp-pike-odl-ha.local] at time 05:36:50.483942
2018-10-14 05:36:50,484 [salt.state       :1803][INFO    ][6525] Executing state host.present for [cmp002.mcp-pike-odl-ha.local]
2018-10-14 05:36:50,484 [salt.state       :290 ][INFO    ][6525] Host cmp002.mcp-pike-odl-ha.local (192.168.10.53) already present
2018-10-14 05:36:50,484 [salt.state       :1941][INFO    ][6525] Completed state [cmp002.mcp-pike-odl-ha.local] at time 05:36:50.484720 duration_in_ms=0.778
2018-10-14 05:36:50,485 [salt.state       :1770][INFO    ][6525] Running state [cmp001] at time 05:36:50.484993
2018-10-14 05:36:50,485 [salt.state       :1803][INFO    ][6525] Executing state host.present for [cmp001]
2018-10-14 05:36:50,486 [salt.state       :290 ][INFO    ][6525] Host cmp001 (192.168.10.52) already present
2018-10-14 05:36:50,486 [salt.state       :1941][INFO    ][6525] Completed state [cmp001] at time 05:36:50.486432 duration_in_ms=1.438
2018-10-14 05:36:50,486 [salt.state       :1770][INFO    ][6525] Running state [cmp001.mcp-pike-odl-ha.local] at time 05:36:50.486704
2018-10-14 05:36:50,486 [salt.state       :1803][INFO    ][6525] Executing state host.present for [cmp001.mcp-pike-odl-ha.local]
2018-10-14 05:36:50,487 [salt.state       :290 ][INFO    ][6525] Host cmp001.mcp-pike-odl-ha.local (192.168.10.52) already present
2018-10-14 05:36:50,487 [salt.state       :1941][INFO    ][6525] Completed state [cmp001.mcp-pike-odl-ha.local] at time 05:36:50.487539 duration_in_ms=0.834
2018-10-14 05:36:50,487 [salt.state       :1770][INFO    ][6525] Running state [dbs01] at time 05:36:50.487839
2018-10-14 05:36:50,488 [salt.state       :1803][INFO    ][6525] Executing state host.present for [dbs01]
2018-10-14 05:36:50,488 [salt.state       :290 ][INFO    ][6525] Host dbs01 (192.168.10.24) already present
2018-10-14 05:36:50,488 [salt.state       :1941][INFO    ][6525] Completed state [dbs01] at time 05:36:50.488645 duration_in_ms=0.806
2018-10-14 05:36:50,488 [salt.state       :1770][INFO    ][6525] Running state [dbs01.mcp-pike-odl-ha.local] at time 05:36:50.488924
2018-10-14 05:36:50,489 [salt.state       :1803][INFO    ][6525] Executing state host.present for [dbs01.mcp-pike-odl-ha.local]
2018-10-14 05:36:50,490 [salt.state       :290 ][INFO    ][6525] Host dbs01.mcp-pike-odl-ha.local (192.168.10.24) already present
2018-10-14 05:36:50,490 [salt.state       :1941][INFO    ][6525] Completed state [dbs01.mcp-pike-odl-ha.local] at time 05:36:50.490182 duration_in_ms=1.258
2018-10-14 05:36:50,490 [salt.state       :1770][INFO    ][6525] Running state [dbs02] at time 05:36:50.490504
2018-10-14 05:36:50,490 [salt.state       :1803][INFO    ][6525] Executing state host.present for [dbs02]
2018-10-14 05:36:50,491 [salt.state       :290 ][INFO    ][6525] Host dbs02 (192.168.10.25) already present
2018-10-14 05:36:50,491 [salt.state       :1941][INFO    ][6525] Completed state [dbs02] at time 05:36:50.491388 duration_in_ms=0.883
2018-10-14 05:36:50,491 [salt.state       :1770][INFO    ][6525] Running state [dbs02.mcp-pike-odl-ha.local] at time 05:36:50.491721
2018-10-14 05:36:50,491 [salt.state       :1803][INFO    ][6525] Executing state host.present for [dbs02.mcp-pike-odl-ha.local]
2018-10-14 05:36:50,492 [salt.state       :290 ][INFO    ][6525] Host dbs02.mcp-pike-odl-ha.local (192.168.10.25) already present
2018-10-14 05:36:50,492 [salt.state       :1941][INFO    ][6525] Completed state [dbs02.mcp-pike-odl-ha.local] at time 05:36:50.492546 duration_in_ms=0.825
2018-10-14 05:36:50,492 [salt.state       :1770][INFO    ][6525] Running state [dbs03] at time 05:36:50.492839
2018-10-14 05:36:50,493 [salt.state       :1803][INFO    ][6525] Executing state host.present for [dbs03]
2018-10-14 05:36:50,493 [salt.state       :290 ][INFO    ][6525] Host dbs03 (192.168.10.26) already present
2018-10-14 05:36:50,493 [salt.state       :1941][INFO    ][6525] Completed state [dbs03] at time 05:36:50.493665 duration_in_ms=0.826
2018-10-14 05:36:50,494 [salt.state       :1770][INFO    ][6525] Running state [dbs03.mcp-pike-odl-ha.local] at time 05:36:50.493968
2018-10-14 05:36:50,494 [salt.state       :1803][INFO    ][6525] Executing state host.present for [dbs03.mcp-pike-odl-ha.local]
2018-10-14 05:36:50,494 [salt.state       :290 ][INFO    ][6525] Host dbs03.mcp-pike-odl-ha.local (192.168.10.26) already present
2018-10-14 05:36:50,494 [salt.state       :1941][INFO    ][6525] Completed state [dbs03.mcp-pike-odl-ha.local] at time 05:36:50.494927 duration_in_ms=0.959
2018-10-14 05:36:50,495 [salt.state       :1770][INFO    ][6525] Running state [odl01] at time 05:36:50.495260
2018-10-14 05:36:50,495 [salt.state       :1803][INFO    ][6525] Executing state host.present for [odl01]
2018-10-14 05:36:50,495 [salt.state       :290 ][INFO    ][6525] Host odl01 (192.168.10.39) already present
2018-10-14 05:36:50,496 [salt.state       :1941][INFO    ][6525] Completed state [odl01] at time 05:36:50.496044 duration_in_ms=0.784
2018-10-14 05:36:50,496 [salt.state       :1770][INFO    ][6525] Running state [odl01.mcp-pike-odl-ha.local] at time 05:36:50.496321
2018-10-14 05:36:50,496 [salt.state       :1803][INFO    ][6525] Executing state host.present for [odl01.mcp-pike-odl-ha.local]
2018-10-14 05:36:50,496 [salt.state       :290 ][INFO    ][6525] Host odl01.mcp-pike-odl-ha.local (192.168.10.39) already present
2018-10-14 05:36:50,497 [salt.state       :1941][INFO    ][6525] Completed state [odl01.mcp-pike-odl-ha.local] at time 05:36:50.497119 duration_in_ms=0.797
2018-10-14 05:36:50,497 [salt.state       :1770][INFO    ][6525] Running state [mas01] at time 05:36:50.497766
2018-10-14 05:36:50,498 [salt.state       :1803][INFO    ][6525] Executing state host.present for [mas01]
2018-10-14 05:36:50,498 [salt.state       :290 ][INFO    ][6525] Host mas01 (192.168.10.12) already present
2018-10-14 05:36:50,498 [salt.state       :1941][INFO    ][6525] Completed state [mas01] at time 05:36:50.498565 duration_in_ms=0.798
2018-10-14 05:36:50,498 [salt.state       :1770][INFO    ][6525] Running state [mas01.mcp-pike-odl-ha.local] at time 05:36:50.498864
2018-10-14 05:36:50,499 [salt.state       :1803][INFO    ][6525] Executing state host.present for [mas01.mcp-pike-odl-ha.local]
2018-10-14 05:36:50,499 [salt.state       :290 ][INFO    ][6525] Host mas01.mcp-pike-odl-ha.local (192.168.10.12) already present
2018-10-14 05:36:50,499 [salt.state       :1941][INFO    ][6525] Completed state [mas01.mcp-pike-odl-ha.local] at time 05:36:50.499688 duration_in_ms=0.823
2018-10-14 05:36:50,500 [salt.state       :1770][INFO    ][6525] Running state [ctl02] at time 05:36:50.499969
2018-10-14 05:36:50,500 [salt.state       :1803][INFO    ][6525] Executing state host.present for [ctl02]
2018-10-14 05:36:50,500 [salt.state       :290 ][INFO    ][6525] Host ctl02 (192.168.10.37) already present
2018-10-14 05:36:50,500 [salt.state       :1941][INFO    ][6525] Completed state [ctl02] at time 05:36:50.500766 duration_in_ms=0.797
2018-10-14 05:36:50,501 [salt.state       :1770][INFO    ][6525] Running state [ctl02.mcp-pike-odl-ha.local] at time 05:36:50.501045
2018-10-14 05:36:50,501 [salt.state       :1803][INFO    ][6525] Executing state host.present for [ctl02.mcp-pike-odl-ha.local]
2018-10-14 05:36:50,501 [salt.state       :290 ][INFO    ][6525] Host ctl02.mcp-pike-odl-ha.local (192.168.10.37) already present
2018-10-14 05:36:50,501 [salt.state       :1941][INFO    ][6525] Completed state [ctl02.mcp-pike-odl-ha.local] at time 05:36:50.501820 duration_in_ms=0.775
2018-10-14 05:36:50,502 [salt.state       :1770][INFO    ][6525] Running state [ctl03] at time 05:36:50.502101
2018-10-14 05:36:50,502 [salt.state       :1803][INFO    ][6525] Executing state host.present for [ctl03]
2018-10-14 05:36:50,502 [salt.state       :290 ][INFO    ][6525] Host ctl03 (192.168.10.38) already present
2018-10-14 05:36:50,502 [salt.state       :1941][INFO    ][6525] Completed state [ctl03] at time 05:36:50.502869 duration_in_ms=0.768
2018-10-14 05:36:50,503 [salt.state       :1770][INFO    ][6525] Running state [ctl03.mcp-pike-odl-ha.local] at time 05:36:50.503192
2018-10-14 05:36:50,503 [salt.state       :1803][INFO    ][6525] Executing state host.present for [ctl03.mcp-pike-odl-ha.local]
2018-10-14 05:36:50,503 [salt.state       :290 ][INFO    ][6525] Host ctl03.mcp-pike-odl-ha.local (192.168.10.38) already present
2018-10-14 05:36:50,504 [salt.state       :1941][INFO    ][6525] Completed state [ctl03.mcp-pike-odl-ha.local] at time 05:36:50.503988 duration_in_ms=0.796
2018-10-14 05:36:50,504 [salt.state       :1770][INFO    ][6525] Running state [ctl01] at time 05:36:50.504276
2018-10-14 05:36:50,504 [salt.state       :1803][INFO    ][6525] Executing state host.present for [ctl01]
2018-10-14 05:36:50,504 [salt.state       :290 ][INFO    ][6525] Host ctl01 (192.168.10.36) already present
2018-10-14 05:36:50,505 [salt.state       :1941][INFO    ][6525] Completed state [ctl01] at time 05:36:50.505070 duration_in_ms=0.794
2018-10-14 05:36:50,505 [salt.state       :1770][INFO    ][6525] Running state [ctl01.mcp-pike-odl-ha.local] at time 05:36:50.505363
2018-10-14 05:36:50,505 [salt.state       :1803][INFO    ][6525] Executing state host.present for [ctl01.mcp-pike-odl-ha.local]
2018-10-14 05:36:50,505 [salt.state       :290 ][INFO    ][6525] Host ctl01.mcp-pike-odl-ha.local (192.168.10.36) already present
2018-10-14 05:36:50,506 [salt.state       :1941][INFO    ][6525] Completed state [ctl01.mcp-pike-odl-ha.local] at time 05:36:50.506123 duration_in_ms=0.761
2018-10-14 05:36:50,506 [salt.state       :1770][INFO    ][6525] Running state [ctl] at time 05:36:50.506406
2018-10-14 05:36:50,506 [salt.state       :1803][INFO    ][6525] Executing state host.present for [ctl]
2018-10-14 05:36:50,507 [salt.state       :290 ][INFO    ][6525] Host ctl (192.168.10.35) already present
2018-10-14 05:36:50,507 [salt.state       :1941][INFO    ][6525] Completed state [ctl] at time 05:36:50.507200 duration_in_ms=0.794
2018-10-14 05:36:50,507 [salt.state       :1770][INFO    ][6525] Running state [ctl.mcp-pike-odl-ha.local] at time 05:36:50.507501
2018-10-14 05:36:50,507 [salt.state       :1803][INFO    ][6525] Executing state host.present for [ctl.mcp-pike-odl-ha.local]
2018-10-14 05:36:50,508 [salt.state       :290 ][INFO    ][6525] Host ctl.mcp-pike-odl-ha.local (192.168.10.35) already present
2018-10-14 05:36:50,508 [salt.state       :1941][INFO    ][6525] Completed state [ctl.mcp-pike-odl-ha.local] at time 05:36:50.508263 duration_in_ms=0.762
2018-10-14 05:36:50,508 [salt.state       :1770][INFO    ][6525] Running state [/etc/network/interfaces.d/50-cloud-init.cfg] at time 05:36:50.508458
2018-10-14 05:36:50,508 [salt.state       :1803][INFO    ][6525] Executing state file.absent for [/etc/network/interfaces.d/50-cloud-init.cfg]
2018-10-14 05:36:50,508 [salt.state       :290 ][INFO    ][6525] File /etc/network/interfaces.d/50-cloud-init.cfg is not present
2018-10-14 05:36:50,509 [salt.state       :1941][INFO    ][6525] Completed state [/etc/network/interfaces.d/50-cloud-init.cfg] at time 05:36:50.509702 duration_in_ms=1.244
2018-10-14 05:36:50,509 [salt.state       :1770][INFO    ][6525] Running state [ens2] at time 05:36:50.509927
2018-10-14 05:36:50,510 [salt.state       :1803][INFO    ][6525] Executing state network.managed for [ens2]
2018-10-14 05:36:50,639 [salt.state       :290 ][INFO    ][6525] Interface ens2 is up to date.
2018-10-14 05:36:50,640 [salt.state       :1941][INFO    ][6525] Completed state [ens2] at time 05:36:50.640401 duration_in_ms=130.472
2018-10-14 05:36:50,641 [salt.state       :1770][INFO    ][6525] Running state [ens3] at time 05:36:50.640962
2018-10-14 05:36:50,642 [salt.state       :1803][INFO    ][6525] Executing state network.managed for [ens3]
2018-10-14 05:36:50,668 [salt.state       :290 ][INFO    ][6525] Interface ens3 is up to date.
2018-10-14 05:36:50,669 [salt.state       :1941][INFO    ][6525] Completed state [ens3] at time 05:36:50.669091 duration_in_ms=28.129
2018-10-14 05:36:50,670 [salt.state       :1770][INFO    ][6525] Running state [/etc/profile.d/proxy.sh] at time 05:36:50.670107
2018-10-14 05:36:50,670 [salt.state       :1803][INFO    ][6525] Executing state file.absent for [/etc/profile.d/proxy.sh]
2018-10-14 05:36:50,670 [salt.state       :290 ][INFO    ][6525] File /etc/profile.d/proxy.sh is not present
2018-10-14 05:36:50,671 [salt.state       :1941][INFO    ][6525] Completed state [/etc/profile.d/proxy.sh] at time 05:36:50.671130 duration_in_ms=1.022
2018-10-14 05:36:50,671 [salt.state       :1770][INFO    ][6525] Running state [/etc/apt/apt.conf.d/95proxies] at time 05:36:50.671359
2018-10-14 05:36:50,671 [salt.state       :1803][INFO    ][6525] Executing state file.absent for [/etc/apt/apt.conf.d/95proxies]
2018-10-14 05:36:50,671 [salt.state       :290 ][INFO    ][6525] File /etc/apt/apt.conf.d/95proxies is not present
2018-10-14 05:36:50,672 [salt.state       :1941][INFO    ][6525] Completed state [/etc/apt/apt.conf.d/95proxies] at time 05:36:50.672037 duration_in_ms=0.679
2018-10-14 05:36:50,672 [salt.state       :1770][INFO    ][6525] Running state [ntp] at time 05:36:50.672257
2018-10-14 05:36:50,672 [salt.state       :1803][INFO    ][6525] Executing state pkg.installed for [ntp]
2018-10-14 05:36:50,681 [salt.state       :290 ][INFO    ][6525] All specified packages are already installed
2018-10-14 05:36:50,681 [salt.state       :1941][INFO    ][6525] Completed state [ntp] at time 05:36:50.681929 duration_in_ms=9.672
2018-10-14 05:36:50,683 [salt.state       :1770][INFO    ][6525] Running state [/etc/ntp.conf] at time 05:36:50.683670
2018-10-14 05:36:50,683 [salt.state       :1803][INFO    ][6525] Executing state file.managed for [/etc/ntp.conf]
2018-10-14 05:36:50,762 [salt.state       :290 ][INFO    ][6525] File /etc/ntp.conf is in the correct state
2018-10-14 05:36:50,762 [salt.state       :1941][INFO    ][6525] Completed state [/etc/ntp.conf] at time 05:36:50.762570 duration_in_ms=78.9
2018-10-14 05:36:50,763 [salt.state       :1770][INFO    ][6525] Running state [ntp] at time 05:36:50.763869
2018-10-14 05:36:50,764 [salt.state       :1803][INFO    ][6525] Executing state service.running for [ntp]
2018-10-14 05:36:50,764 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6525] Executing command ['systemctl', 'status', 'ntp.service', '-n', '0'] in directory '/root'
2018-10-14 05:36:50,783 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6525] Executing command ['systemctl', 'is-active', 'ntp.service'] in directory '/root'
2018-10-14 05:36:50,798 [salt.loaded.int.module.cmdmod:395 ][INFO    ][6525] Executing command ['systemctl', 'is-enabled', 'ntp.service'] in directory '/root'
2018-10-14 05:36:50,815 [salt.state       :290 ][INFO    ][6525] The service ntp is already running
2018-10-14 05:36:50,815 [salt.state       :1941][INFO    ][6525] Completed state [ntp] at time 05:36:50.815510 duration_in_ms=51.64
2018-10-14 05:36:50,821 [salt.minion      :1708][INFO    ][6525] Returning information for job: 20181014053634511899
2018-10-14 05:36:53,867 [salt.minion      :1307][INFO    ][3008] User sudo_ubuntu Executing command ssh.set_auth_key with jid 20181014053653854207
2018-10-14 05:36:53,890 [salt.minion      :1431][INFO    ][7257] Starting a new job with PID 7257
2018-10-14 05:36:53,911 [salt.minion      :1708][INFO    ][7257] Returning information for job: 20181014053653854207
2018-10-14 05:37:30,286 [salt.minion      :1307][INFO    ][3008] User sudo_ubuntu Executing command pkg.upgrade with jid 20181014053730274390
2018-10-14 05:37:30,310 [salt.minion      :1431][INFO    ][7281] Starting a new job with PID 7281
2018-10-14 05:37:30,332 [salt.loader.192.168.11.2.int.module.cmdmod:395 ][INFO    ][7281] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}', '-W'] in directory '/root'
2018-10-14 05:37:30,660 [salt.loader.192.168.11.2.int.module.cmdmod:395 ][INFO    ][7281] 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:36,829 [salt.loader.192.168.11.2.int.module.cmdmod:395 ][INFO    ][7281] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}', '-W'] in directory '/root'
2018-10-14 05:37:36,864 [salt.minion      :1708][INFO    ][7281] Returning information for job: 20181014053730274390
2018-10-14 05:45:28,620 [salt.minion      :1307][INFO    ][3008] User sudo_ubuntu Executing command test.ping with jid 20181014054528610612
2018-10-14 05:45:28,637 [salt.minion      :1431][INFO    ][8228] Starting a new job with PID 8228
2018-10-14 05:45:28,665 [salt.minion      :1708][INFO    ][8228] Returning information for job: 20181014054528610612
2018-10-14 05:45:28,812 [salt.minion      :1307][INFO    ][3008] User sudo_ubuntu Executing command state.sls with jid 20181014054528801858
2018-10-14 05:45:28,828 [salt.minion      :1431][INFO    ][8233] Starting a new job with PID 8233
2018-10-14 05:45:31,889 [salt.state       :905 ][INFO    ][8233] Loading fresh modules for state activity
2018-10-14 05:45:31,952 [salt.fileclient  :1215][INFO    ][8233] Fetching file from saltenv 'base', ** done ** 'keepalived/init.sls'
2018-10-14 05:45:31,992 [salt.fileclient  :1215][INFO    ][8233] Fetching file from saltenv 'base', ** done ** 'keepalived/cluster.sls'
2018-10-14 05:45:32,649 [salt.state       :1770][INFO    ][8233] Running state [keepalived] at time 05:45:32.649583
2018-10-14 05:45:32,650 [salt.state       :1803][INFO    ][8233] Executing state pkg.installed for [keepalived]
2018-10-14 05:45:32,651 [salt.loaded.int.module.cmdmod:395 ][INFO    ][8233] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}', '-W'] in directory '/root'
2018-10-14 05:45:33,011 [salt.loaded.int.module.cmdmod:395 ][INFO    ][8233] Executing command ['apt-cache', '-q', 'policy', 'keepalived'] in directory '/root'
2018-10-14 05:45:33,105 [salt.loaded.int.module.cmdmod:395 ][INFO    ][8233] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2018-10-14 05:45:35,075 [salt.loaded.int.module.cmdmod:395 ][INFO    ][8233] Executing command ['dpkg', '--get-selections', '*'] in directory '/root'
2018-10-14 05:45:35,101 [salt.loaded.int.module.cmdmod:395 ][INFO    ][8233] 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:45:38,837 [salt.minion      :1307][INFO    ][3008] User sudo_ubuntu Executing command saltutil.find_job with jid 20181014054538829649
2018-10-14 05:45:38,849 [salt.minion      :1431][INFO    ][9584] Starting a new job with PID 9584
2018-10-14 05:45:38,864 [salt.minion      :1708][INFO    ][9584] Returning information for job: 20181014054538829649
2018-10-14 05:45:39,035 [salt.loaded.int.module.cmdmod:395 ][INFO    ][8233] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}', '-W'] in directory '/root'
2018-10-14 05:45:39,069 [salt.state       :290 ][INFO    ][8233] 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:45:39,090 [salt.state       :905 ][INFO    ][8233] Loading fresh modules for state activity
2018-10-14 05:45:39,131 [salt.state       :1941][INFO    ][8233] Completed state [keepalived] at time 05:45:39.131436 duration_in_ms=6481.853
2018-10-14 05:45:39,137 [salt.state       :1770][INFO    ][8233] Running state [lsof] at time 05:45:39.137578
2018-10-14 05:45:39,137 [salt.state       :1803][INFO    ][8233] Executing state pkg.installed for [lsof]
2018-10-14 05:45:39,750 [salt.state       :290 ][INFO    ][8233] All specified packages are already installed
2018-10-14 05:45:39,751 [salt.state       :1941][INFO    ][8233] Completed state [lsof] at time 05:45:39.751005 duration_in_ms=613.426
2018-10-14 05:45:39,753 [salt.state       :1770][INFO    ][8233] Running state [/etc/keepalived/keepalived.conf] at time 05:45:39.753497
2018-10-14 05:45:39,753 [salt.state       :1803][INFO    ][8233] Executing state file.managed for [/etc/keepalived/keepalived.conf]
2018-10-14 05:45:39,784 [salt.fileclient  :1215][INFO    ][8233] Fetching file from saltenv 'base', ** done ** 'keepalived/files/keepalived.conf'
2018-10-14 05:45:39,837 [salt.state       :290 ][INFO    ][8233] File changed:
New file
2018-10-14 05:45:39,838 [salt.state       :1941][INFO    ][8233] Completed state [/etc/keepalived/keepalived.conf] at time 05:45:39.838103 duration_in_ms=84.604
2018-10-14 05:45:39,839 [salt.state       :1770][INFO    ][8233] Running state [keepalived] at time 05:45:39.839551
2018-10-14 05:45:39,839 [salt.state       :1803][INFO    ][8233] Executing state service.running for [keepalived]
2018-10-14 05:45:39,840 [salt.loaded.int.module.cmdmod:395 ][INFO    ][8233] Executing command ['systemctl', 'status', 'keepalived.service', '-n', '0'] in directory '/root'
2018-10-14 05:45:39,857 [salt.loaded.int.module.cmdmod:395 ][INFO    ][8233] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2018-10-14 05:45:39,873 [salt.loaded.int.module.cmdmod:395 ][INFO    ][8233] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2018-10-14 05:45:39,893 [salt.loaded.int.module.cmdmod:395 ][INFO    ][8233] Executing command ['systemd-run', '--scope', 'systemctl', 'start', 'keepalived.service'] in directory '/root'
2018-10-14 05:45:39,952 [salt.loaded.int.module.cmdmod:395 ][INFO    ][8233] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2018-10-14 05:45:39,967 [salt.loaded.int.module.cmdmod:395 ][INFO    ][8233] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2018-10-14 05:45:39,981 [salt.loaded.int.module.cmdmod:395 ][INFO    ][8233] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2018-10-14 05:45:39,996 [salt.state       :290 ][INFO    ][8233] {'keepalived': True}
2018-10-14 05:45:39,996 [salt.state       :1941][INFO    ][8233] Completed state [keepalived] at time 05:45:39.996881 duration_in_ms=157.329
2018-10-14 05:45:39,999 [salt.minion      :1708][INFO    ][8233] Returning information for job: 20181014054528801858
2018-10-14 05:48:36,115 [salt.minion      :1307][INFO    ][3008] User sudo_ubuntu Executing command pillar.get with jid 20181014054836100882
2018-10-14 05:48:36,141 [salt.minion      :1431][INFO    ][9680] Starting a new job with PID 9680
2018-10-14 05:48:36,147 [salt.minion      :1708][INFO    ][9680] Returning information for job: 20181014054836100882
2018-10-14 05:51:44,837 [salt.minion      :1307][INFO    ][3008] User sudo_ubuntu Executing command state.sls with jid 20181014055144825452
2018-10-14 05:51:44,863 [salt.minion      :1431][INFO    ][9714] Starting a new job with PID 9714
2018-10-14 05:51:47,956 [salt.state       :905 ][INFO    ][9714] Loading fresh modules for state activity
2018-10-14 05:51:48,042 [salt.fileclient  :1215][INFO    ][9714] Fetching file from saltenv 'base', ** done ** 'rabbitmq/init.sls'
2018-10-14 05:51:48,099 [salt.fileclient  :1215][INFO    ][9714] Fetching file from saltenv 'base', ** done ** 'rabbitmq/server/init.sls'
2018-10-14 05:51:48,131 [salt.fileclient  :1215][INFO    ][9714] Fetching file from saltenv 'base', ** done ** 'rabbitmq/server/service.sls'
2018-10-14 05:51:48,185 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9714] Executing command 'cat /var/lib/rabbitmq/.erlang.cookie' in directory '/root'
2018-10-14 05:51:48,206 [salt.loaded.int.module.cmdmod:722 ][ERROR   ][9714] Command 'cat /var/lib/rabbitmq/.erlang.cookie' failed with return code: 1
2018-10-14 05:51:48,206 [salt.loaded.int.module.cmdmod:724 ][ERROR   ][9714] stdout: cat: /var/lib/rabbitmq/.erlang.cookie: No such file or directory
2018-10-14 05:51:48,206 [salt.loaded.int.module.cmdmod:728 ][ERROR   ][9714] retcode: 1
2018-10-14 05:51:48,242 [salt.fileclient  :1215][INFO    ][9714] Fetching file from saltenv 'base', ** done ** 'rabbitmq/server/ssl.sls'
2018-10-14 05:51:48,302 [salt.fileclient  :1215][INFO    ][9714] Fetching file from saltenv 'base', ** done ** 'rabbitmq/server/plugin.sls'
2018-10-14 05:51:48,354 [salt.fileclient  :1215][INFO    ][9714] Fetching file from saltenv 'base', ** done ** 'rabbitmq/server/vhost.sls'
2018-10-14 05:51:48,448 [salt.fileclient  :1215][INFO    ][9714] Fetching file from saltenv 'base', ** done ** 'rabbitmq/server/user.sls'
2018-10-14 05:51:48,505 [salt.fileclient  :1215][INFO    ][9714] Fetching file from saltenv 'base', ** done ** 'rabbitmq/cluster.sls'
2018-10-14 05:51:49,194 [salt.state       :1770][INFO    ][9714] Running state [rabbitmq-server] at time 05:51:49.194165
2018-10-14 05:51:49,194 [salt.state       :1803][INFO    ][9714] Executing state pkg.installed for [rabbitmq-server]
2018-10-14 05:51:49,195 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9714] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}', '-W'] in directory '/root'
2018-10-14 05:51:49,530 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9714] Executing command ['apt-cache', '-q', 'policy', 'rabbitmq-server'] in directory '/root'
2018-10-14 05:51:49,643 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9714] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2018-10-14 05:51:51,727 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9714] Executing command ['dpkg', '--get-selections', '*'] in directory '/root'
2018-10-14 05:51:51,755 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9714] 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,867 [salt.minion      :1307][INFO    ][3008] User sudo_ubuntu Executing command saltutil.find_job with jid 20181014055154848485
2018-10-14 05:51:54,885 [salt.minion      :1431][INFO    ][10318] Starting a new job with PID 10318
2018-10-14 05:51:54,904 [salt.minion      :1708][INFO    ][10318] Returning information for job: 20181014055154848485
2018-10-14 05:52:05,095 [salt.minion      :1307][INFO    ][3008] User sudo_ubuntu Executing command saltutil.find_job with jid 20181014055205079500
2018-10-14 05:52:05,108 [salt.minion      :1431][INFO    ][11087] Starting a new job with PID 11087
2018-10-14 05:52:05,127 [salt.minion      :1708][INFO    ][11087] Returning information for job: 20181014055205079500
2018-10-14 05:52:15,323 [salt.minion      :1307][INFO    ][3008] User sudo_ubuntu Executing command saltutil.find_job with jid 20181014055215303124
2018-10-14 05:52:15,334 [salt.minion      :1431][INFO    ][11092] Starting a new job with PID 11092
2018-10-14 05:52:15,348 [salt.minion      :1708][INFO    ][11092] Returning information for job: 20181014055215303124
2018-10-14 05:52:25,397 [salt.minion      :1307][INFO    ][3008] User sudo_ubuntu Executing command saltutil.find_job with jid 20181014055225383385
2018-10-14 05:52:25,411 [salt.minion      :1431][INFO    ][11097] Starting a new job with PID 11097
2018-10-14 05:52:25,426 [salt.minion      :1708][INFO    ][11097] Returning information for job: 20181014055225383385
2018-10-14 05:52:34,641 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9714] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}', '-W'] in directory '/root'
2018-10-14 05:52:34,682 [salt.state       :290 ][INFO    ][9714] 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:34,701 [salt.state       :905 ][INFO    ][9714] Loading fresh modules for state activity
2018-10-14 05:52:34,736 [salt.state       :1941][INFO    ][9714] Completed state [rabbitmq-server] at time 05:52:34.736892 duration_in_ms=45542.728
2018-10-14 05:52:34,741 [salt.state       :1770][INFO    ][9714] Running state [/etc/rabbitmq/rabbitmq.config] at time 05:52:34.741505
2018-10-14 05:52:34,741 [salt.state       :1803][INFO    ][9714] Executing state file.managed for [/etc/rabbitmq/rabbitmq.config]
2018-10-14 05:52:34,796 [salt.fileclient  :1215][INFO    ][9714] Fetching file from saltenv 'base', ** done ** 'rabbitmq/files/rabbitmq.config'
2018-10-14 05:52:34,864 [salt.state       :290 ][INFO    ][9714] File changed:
New file
2018-10-14 05:52:34,864 [salt.state       :1941][INFO    ][9714] Completed state [/etc/rabbitmq/rabbitmq.config] at time 05:52:34.864769 duration_in_ms=123.264
2018-10-14 05:52:34,865 [salt.state       :1770][INFO    ][9714] Running state [/etc/default/rabbitmq-server] at time 05:52:34.865133
2018-10-14 05:52:34,865 [salt.state       :1803][INFO    ][9714] Executing state file.managed for [/etc/default/rabbitmq-server]
2018-10-14 05:52:34,911 [salt.fileclient  :1215][INFO    ][9714] Fetching file from saltenv 'base', ** done ** 'rabbitmq/files/default'
2018-10-14 05:52:34,952 [salt.state       :290 ][INFO    ][9714] 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:34,952 [salt.state       :1941][INFO    ][9714] Completed state [/etc/default/rabbitmq-server] at time 05:52:34.952383 duration_in_ms=87.249
2018-10-14 05:52:34,952 [salt.state       :1770][INFO    ][9714] Running state [/etc/systemd/system/rabbitmq-server.service.d/limits.conf] at time 05:52:34.952752
2018-10-14 05:52:34,952 [salt.state       :1803][INFO    ][9714] Executing state file.managed for [/etc/systemd/system/rabbitmq-server.service.d/limits.conf]
2018-10-14 05:52:34,988 [salt.fileclient  :1215][INFO    ][9714] Fetching file from saltenv 'base', ** done ** 'rabbitmq/files/limits.conf'
2018-10-14 05:52:35,032 [salt.state       :290 ][INFO    ][9714] File changed:
New file
2018-10-14 05:52:35,032 [salt.state       :1941][INFO    ][9714] Completed state [/etc/systemd/system/rabbitmq-server.service.d/limits.conf] at time 05:52:35.032680 duration_in_ms=79.927
2018-10-14 05:52:35,035 [salt.state       :1770][INFO    ][9714] Running state [sleep 30] at time 05:52:35.035050
2018-10-14 05:52:35,035 [salt.state       :1803][INFO    ][9714] Executing state cmd.run for [sleep 30]
2018-10-14 05:52:35,035 [py.warnings      :2526][WARNING ][9714] /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:35,038 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9714] Executing command 'sleep 30' as user 'root' in directory '/root'
2018-10-14 05:52:35,426 [salt.minion      :1307][INFO    ][3008] User sudo_ubuntu Executing command saltutil.find_job with jid 20181014055235408448
2018-10-14 05:52:35,446 [salt.minion      :1431][INFO    ][11272] Starting a new job with PID 11272
2018-10-14 05:52:35,464 [salt.minion      :1708][INFO    ][11272] Returning information for job: 20181014055235408448
2018-10-14 05:52:45,652 [salt.minion      :1307][INFO    ][3008] User sudo_ubuntu Executing command saltutil.find_job with jid 20181014055245633360
2018-10-14 05:52:45,672 [salt.minion      :1431][INFO    ][11277] Starting a new job with PID 11277
2018-10-14 05:52:45,690 [salt.minion      :1708][INFO    ][11277] Returning information for job: 20181014055245633360
2018-10-14 05:52:55,884 [salt.minion      :1307][INFO    ][3008] User sudo_ubuntu Executing command saltutil.find_job with jid 20181014055255865124
2018-10-14 05:52:55,906 [salt.minion      :1431][INFO    ][11282] Starting a new job with PID 11282
2018-10-14 05:52:55,924 [salt.minion      :1708][INFO    ][11282] Returning information for job: 20181014055255865124
2018-10-14 05:53:05,137 [salt.state       :290 ][INFO    ][9714] {'pid': 11245, 'retcode': 0, 'stderr': '', 'stdout': ''}
2018-10-14 05:53:05,138 [salt.state       :1941][INFO    ][9714] Completed state [sleep 30] at time 05:53:05.138509 duration_in_ms=30103.458
2018-10-14 05:53:05,140 [salt.state       :1770][INFO    ][9714] Running state [service rabbitmq-server stop] at time 05:53:05.140764
2018-10-14 05:53:05,142 [salt.state       :1803][INFO    ][9714] Executing state cmd.run for [service rabbitmq-server stop]
2018-10-14 05:53:05,142 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9714] Executing command 'service rabbitmq-server stop' in directory '/root'
2018-10-14 05:53:05,460 [salt.state       :290 ][INFO    ][9714] {'pid': 11285, 'retcode': 0, 'stderr': '', 'stdout': ''}
2018-10-14 05:53:05,461 [salt.state       :1941][INFO    ][9714] Completed state [service rabbitmq-server stop] at time 05:53:05.461312 duration_in_ms=320.548
2018-10-14 05:53:05,462 [salt.state       :1770][INFO    ][9714] Running state [/var/lib/rabbitmq] at time 05:53:05.462173
2018-10-14 05:53:05,462 [salt.state       :1803][INFO    ][9714] Executing state file.directory for [/var/lib/rabbitmq]
2018-10-14 05:53:05,464 [salt.state       :290 ][INFO    ][9714] Directory /var/lib/rabbitmq is in the correct state
Directory /var/lib/rabbitmq updated
2018-10-14 05:53:05,465 [salt.state       :1941][INFO    ][9714] Completed state [/var/lib/rabbitmq] at time 05:53:05.465288 duration_in_ms=3.114
2018-10-14 05:53:05,466 [salt.state       :1770][INFO    ][9714] Running state [/var/lib/rabbitmq/.erlang.cookie] at time 05:53:05.466930
2018-10-14 05:53:05,467 [salt.state       :1803][INFO    ][9714] Executing state file.managed for [/var/lib/rabbitmq/.erlang.cookie]
2018-10-14 05:53:05,469 [salt.state       :290 ][INFO    ][9714] File changed:
--- 
+++ 
@@ -1 +1 @@
-HLZAJYIRVAHHVYZAQOHM+opnfv_secret

2018-10-14 05:53:05,470 [salt.state       :1941][INFO    ][9714] Completed state [/var/lib/rabbitmq/.erlang.cookie] at time 05:53:05.470755 duration_in_ms=3.826
2018-10-14 05:53:05,471 [salt.state       :1770][INFO    ][9714] Running state [sleep 30] at time 05:53:05.471181
2018-10-14 05:53:05,471 [salt.state       :1803][INFO    ][9714] Executing state cmd.run for [sleep 30]
2018-10-14 05:53:05,472 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9714] Executing command 'sleep 30' as user 'root' in directory '/root'
2018-10-14 05:53:05,909 [salt.minion      :1307][INFO    ][3008] User sudo_ubuntu Executing command saltutil.find_job with jid 20181014055305891007
2018-10-14 05:53:05,927 [salt.minion      :1431][INFO    ][11368] Starting a new job with PID 11368
2018-10-14 05:53:05,944 [salt.minion      :1708][INFO    ][11368] Returning information for job: 20181014055305891007
2018-10-14 05:53:16,142 [salt.minion      :1307][INFO    ][3008] User sudo_ubuntu Executing command saltutil.find_job with jid 20181014055316123988
2018-10-14 05:53:16,164 [salt.minion      :1431][INFO    ][11373] Starting a new job with PID 11373
2018-10-14 05:53:16,182 [salt.minion      :1708][INFO    ][11373] Returning information for job: 20181014055316123988
2018-10-14 05:53:26,168 [salt.minion      :1307][INFO    ][3008] User sudo_ubuntu Executing command saltutil.find_job with jid 20181014055326154651
2018-10-14 05:53:26,192 [salt.minion      :1431][INFO    ][11388] Starting a new job with PID 11388
2018-10-14 05:53:26,212 [salt.minion      :1708][INFO    ][11388] Returning information for job: 20181014055326154651
2018-10-14 05:53:35,555 [salt.state       :290 ][INFO    ][9714] {'pid': 11344, 'retcode': 0, 'stderr': '', 'stdout': ''}
2018-10-14 05:53:35,556 [salt.state       :1941][INFO    ][9714] Completed state [sleep 30] at time 05:53:35.556652 duration_in_ms=30085.468
2018-10-14 05:53:35,994 [salt.state       :1770][INFO    ][9714] Running state [rabbitmq-server] at time 05:53:35.994813
2018-10-14 05:53:35,995 [salt.state       :1803][INFO    ][9714] Executing state service.running for [rabbitmq-server]
2018-10-14 05:53:35,995 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9714] Executing command ['systemctl', 'status', 'rabbitmq-server.service', '-n', '0'] in directory '/root'
2018-10-14 05:53:36,012 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9714] Executing command ['systemctl', 'is-active', 'rabbitmq-server.service'] in directory '/root'
2018-10-14 05:53:36,031 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9714] Executing command ['systemctl', 'is-enabled', 'rabbitmq-server.service'] in directory '/root'
2018-10-14 05:53:36,055 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9714] Executing command ['systemd-run', '--scope', 'systemctl', 'start', 'rabbitmq-server.service'] in directory '/root'
2018-10-14 05:53:36,194 [salt.minion      :1307][INFO    ][3008] User sudo_ubuntu Executing command saltutil.find_job with jid 20181014055336178232
2018-10-14 05:53:36,207 [salt.minion      :1431][INFO    ][11528] Starting a new job with PID 11528
2018-10-14 05:53:36,225 [salt.minion      :1708][INFO    ][11528] Returning information for job: 20181014055336178232
2018-10-14 05:53:38,710 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9714] Executing command ['systemctl', 'is-active', 'rabbitmq-server.service'] in directory '/root'
2018-10-14 05:53:38,730 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9714] Executing command ['systemctl', 'is-enabled', 'rabbitmq-server.service'] in directory '/root'
2018-10-14 05:53:38,750 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9714] Executing command ['systemctl', 'is-enabled', 'rabbitmq-server.service'] in directory '/root'
2018-10-14 05:53:38,778 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9714] Executing command ['systemd-run', '--scope', 'systemctl', 'enable', 'rabbitmq-server.service'] in directory '/root'
2018-10-14 05:53:39,178 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9714] Executing command ['systemctl', 'is-enabled', 'rabbitmq-server.service'] in directory '/root'
2018-10-14 05:53:39,193 [salt.state       :290 ][INFO    ][9714] {'rabbitmq-server': True}
2018-10-14 05:53:39,193 [salt.state       :1941][INFO    ][9714] Completed state [rabbitmq-server] at time 05:53:39.193698 duration_in_ms=3198.885
2018-10-14 05:53:39,196 [salt.state       :1770][INFO    ][9714] Running state [amqp_client] at time 05:53:39.196103
2018-10-14 05:53:39,196 [salt.state       :1803][INFO    ][9714] Executing state rabbitmq_plugin.enabled for [amqp_client]
2018-10-14 05:53:39,197 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9714] Executing command ['/usr/sbin/rabbitmq-plugins', 'list', '-m', '-e'] as user 'root' in directory '/root'
2018-10-14 05:53:40,228 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9714] Executing command ['/usr/sbin/rabbitmq-plugins', 'enable', 'amqp_client'] as user 'root' in directory '/root'
2018-10-14 05:53:41,333 [salt.state       :290 ][INFO    ][9714] {'new': 'amqp_client', 'old': ''}
2018-10-14 05:53:41,334 [salt.state       :1941][INFO    ][9714] Completed state [amqp_client] at time 05:53:41.333968 duration_in_ms=2137.864
2018-10-14 05:53:41,334 [salt.state       :1770][INFO    ][9714] Running state [rabbitmq_management] at time 05:53:41.334737
2018-10-14 05:53:41,335 [salt.state       :1803][INFO    ][9714] Executing state rabbitmq_plugin.enabled for [rabbitmq_management]
2018-10-14 05:53:41,335 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9714] Executing command ['/usr/sbin/rabbitmq-plugins', 'list', '-m', '-e'] as user 'root' in directory '/root'
2018-10-14 05:53:42,331 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9714] Executing command ['/usr/sbin/rabbitmq-plugins', 'enable', 'rabbitmq_management'] as user 'root' in directory '/root'
2018-10-14 05:53:44,074 [salt.state       :290 ][INFO    ][9714] {'new': 'rabbitmq_management', 'old': ''}
2018-10-14 05:53:44,075 [salt.state       :1941][INFO    ][9714] Completed state [rabbitmq_management] at time 05:53:44.074951 duration_in_ms=2740.214
2018-10-14 05:53:44,078 [salt.state       :1770][INFO    ][9714] Running state [/openstack] at time 05:53:44.078731
2018-10-14 05:53:44,079 [salt.state       :1803][INFO    ][9714] Executing state rabbitmq_vhost.present for [/openstack]
2018-10-14 05:53:44,080 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9714] Executing command ['/usr/sbin/rabbitmqctl', 'list_vhosts', '-q'] as user 'root' in directory '/root'
2018-10-14 05:53:45,085 [salt.state       :290 ][INFO    ][9714] Virtual Host '/openstack' already exists.
2018-10-14 05:53:45,086 [salt.state       :1941][INFO    ][9714] Completed state [/openstack] at time 05:53:45.085989 duration_in_ms=1007.257
2018-10-14 05:53:45,091 [salt.state       :1770][INFO    ][9714] Running state [openstack] at time 05:53:45.091673
2018-10-14 05:53:45,092 [salt.state       :1803][INFO    ][9714] Executing state rabbitmq_user.present for [openstack]
2018-10-14 05:53:45,093 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9714] Executing command ['/usr/sbin/rabbitmqctl', 'list_users', '-q'] as user 'root' in directory '/root'
2018-10-14 05:53:46,079 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9714] Executing command ['/usr/sbin/rabbitmqctl', 'status'] as user 'root' in directory '/root'
2018-10-14 05:53:46,223 [salt.minion      :1307][INFO    ][3008] User sudo_ubuntu Executing command saltutil.find_job with jid 20181014055346205939
2018-10-14 05:53:46,238 [salt.minion      :1431][INFO    ][13255] Starting a new job with PID 13255
2018-10-14 05:53:46,258 [salt.minion      :1708][INFO    ][13255] Returning information for job: 20181014055346205939
2018-10-14 05:53:49,146 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9714] Executing command ['/usr/sbin/rabbitmqctl', 'list_user_permissions', 'openstack', '-q'] as user 'root' in directory '/root'
2018-10-14 05:53:50,156 [salt.state       :290 ][INFO    ][9714] Made the following changes:
'password' changed from 'absent' to 'Set password.'

2018-10-14 05:53:50,157 [salt.state       :1941][INFO    ][9714] Completed state [openstack] at time 05:53:50.156867 duration_in_ms=5065.192
2018-10-14 05:53:50,160 [salt.state       :1770][INFO    ][9714] Running state [Ceilometer] at time 05:53:50.160301
2018-10-14 05:53:50,160 [salt.state       :1803][INFO    ][9714] Executing state rabbitmq_policy.present for [Ceilometer]
2018-10-14 05:53:50,161 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9714] Executing command ['/usr/sbin/rabbitmqctl', 'list_policies', '-q', '-p', '/openstack'] as user 'root' in directory '/root'
2018-10-14 05:53:51,250 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9714] 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:52,291 [salt.state       :290 ][INFO    ][9714] {'new': ['Definition'], 'old': {'apply_to': 'all', 'priority': '10', 'definition': '{"ha-mode":"all","message-ttl":10800000}', 'pattern': '^metering.sample$'}}
2018-10-14 05:53:52,291 [salt.state       :1941][INFO    ][9714] Completed state [Ceilometer] at time 05:53:52.291758 duration_in_ms=2131.456
2018-10-14 05:53:52,292 [salt.state       :1770][INFO    ][9714] Running state [HA] at time 05:53:52.292656
2018-10-14 05:53:52,293 [salt.state       :1803][INFO    ][9714] Executing state rabbitmq_policy.present for [HA]
2018-10-14 05:53:52,294 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9714] Executing command ['/usr/sbin/rabbitmqctl', 'list_policies', '-q', '-p', '/openstack'] as user 'root' in directory '/root'
2018-10-14 05:53:53,282 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9714] 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:53:54,323 [salt.state       :290 ][INFO    ][9714] {'new': ['Pattern', 'Definition'], 'old': {'apply_to': 'all', 'priority': '0', 'definition': '{"ha-mode":"all","message-ttl":120000}', 'pattern': '^(?!amq\\\\.).*'}}
2018-10-14 05:53:54,323 [salt.state       :1941][INFO    ][9714] Completed state [HA] at time 05:53:54.323875 duration_in_ms=2031.219
2018-10-14 05:53:54,324 [salt.state       :1770][INFO    ][9714] Running state [guest] at time 05:53:54.324242
2018-10-14 05:53:54,324 [salt.state       :1803][INFO    ][9714] Executing state rabbitmq_user.present for [guest]
2018-10-14 05:53:54,325 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9714] Executing command ['/usr/sbin/rabbitmqctl', 'list_users', '-q'] as user 'root' in directory '/root'
2018-10-14 05:53:55,342 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9714] Executing command ['/usr/sbin/rabbitmqctl', 'status'] as user 'root' in directory '/root'
2018-10-14 05:53:56,248 [salt.minion      :1307][INFO    ][3008] User sudo_ubuntu Executing command saltutil.find_job with jid 20181014055356230406
2018-10-14 05:53:56,260 [salt.minion      :1431][INFO    ][15613] Starting a new job with PID 15613
2018-10-14 05:53:56,276 [salt.minion      :1708][INFO    ][15613] Returning information for job: 20181014055356230406
2018-10-14 05:53:58,499 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9714] Executing command ['/usr/sbin/rabbitmqctl', 'list_user_permissions', 'guest', '-q'] as user 'root' in directory '/root'
2018-10-14 05:53:59,533 [salt.state       :290 ][INFO    ][9714] Made the following changes:
'password' changed from 'absent' to 'Set password.'

2018-10-14 05:53:59,534 [salt.state       :1941][INFO    ][9714] Completed state [guest] at time 05:53:59.534183 duration_in_ms=5209.94
2018-10-14 05:53:59,534 [salt.state       :1770][INFO    ][9714] Running state [HA] at time 05:53:59.534934
2018-10-14 05:53:59,535 [salt.state       :1803][INFO    ][9714] Executing state rabbitmq_policy.present for [HA]
2018-10-14 05:53:59,536 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9714] Executing command ['/usr/sbin/rabbitmqctl', 'list_policies', '-q', '-p', '/'] as user 'root' in directory '/root'
2018-10-14 05:54:00,539 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9714] 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:01,585 [salt.state       :290 ][INFO    ][9714] {'new': ['Pattern', 'Definition'], 'old': {'apply_to': 'all', 'priority': '0', 'definition': '{"ha-mode":"all","message-ttl":120000}', 'pattern': '^(?!amq\\\\.).*'}}
2018-10-14 05:54:01,586 [salt.state       :1941][INFO    ][9714] Completed state [HA] at time 05:54:01.585948 duration_in_ms=2051.012
2018-10-14 05:54:01,586 [salt.state       :1770][INFO    ][9714] Running state [admin] at time 05:54:01.586721
2018-10-14 05:54:01,587 [salt.state       :1803][INFO    ][9714] Executing state rabbitmq_user.present for [admin]
2018-10-14 05:54:01,588 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9714] Executing command ['/usr/sbin/rabbitmqctl', 'list_users', '-q'] as user 'root' in directory '/root'
2018-10-14 05:54:02,643 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9714] Executing command ['/usr/sbin/rabbitmqctl', 'status'] as user 'root' in directory '/root'
2018-10-14 05:54:05,686 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9714] Executing command ['/usr/sbin/rabbitmqctl', 'list_users', '-q'] as user 'root' in directory '/root'
2018-10-14 05:54:06,282 [salt.minion      :1307][INFO    ][3008] User sudo_ubuntu Executing command saltutil.find_job with jid 20181014055406264961
2018-10-14 05:54:06,295 [salt.minion      :1431][INFO    ][18024] Starting a new job with PID 18024
2018-10-14 05:54:06,316 [salt.minion      :1708][INFO    ][18024] Returning information for job: 20181014055406264961
2018-10-14 05:54:06,683 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9714] Executing command ['/usr/sbin/rabbitmqctl', 'list_user_permissions', 'admin', '-q'] as user 'root' in directory '/root'
2018-10-14 05:54:07,666 [salt.state       :290 ][INFO    ][9714] Made the following changes:
'password' changed from 'absent' to 'Set password.'

2018-10-14 05:54:07,667 [salt.state       :1941][INFO    ][9714] Completed state [admin] at time 05:54:07.667078 duration_in_ms=6080.357
2018-10-14 05:54:07,671 [salt.state       :1770][INFO    ][9714] Running state [rabbit@master] at time 05:54:07.670994
2018-10-14 05:54:07,671 [salt.state       :1803][INFO    ][9714] Executing state rabbitmq_cluster.join for [rabbit@master]
2018-10-14 05:54:07,672 [salt.loaded.int.module.cmdmod:395 ][INFO    ][9714] Executing command ['/usr/sbin/rabbitmqctl', 'cluster_status'] as user 'root' in directory '/root'
2018-10-14 05:54:08,776 [salt.state       :290 ][INFO    ][9714] Already in cluster
2018-10-14 05:54:08,777 [salt.state       :1941][INFO    ][9714] Completed state [rabbit@master] at time 05:54:08.777075 duration_in_ms=1106.08
2018-10-14 05:54:08,781 [salt.minion      :1708][INFO    ][9714] Returning information for job: 20181014055144825452
2018-10-14 05:54:19,831 [salt.minion      :1307][INFO    ][3008] User sudo_ubuntu Executing command cmd.run with jid 20181014055419818247
2018-10-14 05:54:19,848 [salt.minion      :1431][INFO    ][18568] Starting a new job with PID 18568
2018-10-14 05:54:19,857 [salt.loader.192.168.11.2.int.module.cmdmod:395 ][INFO    ][18568] Executing command 'rabbitmqctl cluster_status' in directory '/root'
2018-10-14 05:54:20,856 [salt.minion      :1708][INFO    ][18568] Returning information for job: 20181014055419818247
2018-10-14 06:00:57,654 [salt.minion      :1307][INFO    ][3008] User sudo_ubuntu Executing command state.sls with jid 20181014060057642636
2018-10-14 06:00:57,674 [salt.minion      :1431][INFO    ][18851] Starting a new job with PID 18851
2018-10-14 06:00:59,171 [salt.state       :905 ][INFO    ][18851] Loading fresh modules for state activity
2018-10-14 06:00:59,667 [salt.fileclient  :1215][INFO    ][18851] Fetching file from saltenv 'base', ** done ** 'haproxy/init.sls'
2018-10-14 06:00:59,700 [salt.fileclient  :1215][INFO    ][18851] Fetching file from saltenv 'base', ** done ** 'haproxy/proxy.sls'
2018-10-14 06:01:00,404 [salt.state       :1770][INFO    ][18851] Running state [haproxy] at time 06:01:00.404083
2018-10-14 06:01:00,404 [salt.state       :1803][INFO    ][18851] Executing state pkg.installed for [haproxy]
2018-10-14 06:01:00,405 [salt.loaded.int.module.cmdmod:395 ][INFO    ][18851] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}', '-W'] in directory '/root'
2018-10-14 06:01:00,819 [salt.loaded.int.module.cmdmod:395 ][INFO    ][18851] Executing command ['apt-cache', '-q', 'policy', 'haproxy'] in directory '/root'
2018-10-14 06:01:00,920 [salt.loaded.int.module.cmdmod:395 ][INFO    ][18851] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2018-10-14 06:01:03,011 [salt.loaded.int.module.cmdmod:395 ][INFO    ][18851] Executing command ['dpkg', '--get-selections', '*'] in directory '/root'
2018-10-14 06:01:03,039 [salt.loaded.int.module.cmdmod:395 ][INFO    ][18851] 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,301 [salt.loaded.int.module.cmdmod:395 ][INFO    ][18851] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}', '-W'] in directory '/root'
2018-10-14 06:01:07,343 [salt.state       :290 ][INFO    ][18851] 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,366 [salt.state       :905 ][INFO    ][18851] Loading fresh modules for state activity
2018-10-14 06:01:07,407 [salt.state       :1941][INFO    ][18851] Completed state [haproxy] at time 06:01:07.407497 duration_in_ms=7003.413
2018-10-14 06:01:07,412 [salt.state       :1770][INFO    ][18851] Running state [/etc/default/haproxy] at time 06:01:07.412698
2018-10-14 06:01:07,413 [salt.state       :1803][INFO    ][18851] Executing state file.managed for [/etc/default/haproxy]
2018-10-14 06:01:07,444 [salt.fileclient  :1215][INFO    ][18851] Fetching file from saltenv 'base', ** done ** 'haproxy/files/haproxy.default'
2018-10-14 06:01:07,448 [salt.state       :290 ][INFO    ][18851] 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,448 [salt.state       :1941][INFO    ][18851] Completed state [/etc/default/haproxy] at time 06:01:07.448715 duration_in_ms=36.017
2018-10-14 06:01:07,449 [salt.state       :1770][INFO    ][18851] Running state [/etc/haproxy/haproxy.cfg] at time 06:01:07.449363
2018-10-14 06:01:07,449 [salt.state       :1803][INFO    ][18851] Executing state file.managed for [/etc/haproxy/haproxy.cfg]
2018-10-14 06:01:07,471 [salt.fileclient  :1215][INFO    ][18851] Fetching file from saltenv 'base', ** done ** 'haproxy/files/haproxy.cfg'
2018-10-14 06:01:07,660 [salt.state       :290 ][INFO    ][18851] 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,660 [salt.state       :1941][INFO    ][18851] Completed state [/etc/haproxy/haproxy.cfg] at time 06:01:07.660386 duration_in_ms=211.022
2018-10-14 06:01:07,660 [salt.state       :1770][INFO    ][18851] Running state [/etc/haproxy/ssl] at time 06:01:07.660726
2018-10-14 06:01:07,660 [salt.state       :1803][INFO    ][18851] Executing state file.directory for [/etc/haproxy/ssl]
2018-10-14 06:01:07,663 [salt.state       :290 ][INFO    ][18851] {'/etc/haproxy/ssl': 'New Dir'}
2018-10-14 06:01:07,663 [salt.state       :1941][INFO    ][18851] Completed state [/etc/haproxy/ssl] at time 06:01:07.663383 duration_in_ms=2.657
2018-10-14 06:01:07,663 [salt.state       :1770][INFO    ][18851] Running state [/etc/haproxy/errors/429.http11] at time 06:01:07.663681
2018-10-14 06:01:07,663 [salt.state       :1803][INFO    ][18851] Executing state file.managed for [/etc/haproxy/errors/429.http11]
2018-10-14 06:01:07,687 [salt.fileclient  :1215][INFO    ][18851] Fetching file from saltenv 'base', ** done ** 'haproxy/files/errors/429.http11'
2018-10-14 06:01:07,696 [salt.state       :290 ][INFO    ][18851] File changed:
New file
2018-10-14 06:01:07,696 [salt.state       :1941][INFO    ][18851] Completed state [/etc/haproxy/errors/429.http11] at time 06:01:07.696566 duration_in_ms=32.884
2018-10-14 06:01:07,698 [salt.state       :1770][INFO    ][18851] Running state [haproxy_status_packages] at time 06:01:07.698183
2018-10-14 06:01:07,698 [salt.state       :1803][INFO    ][18851] Executing state pkg.installed for [haproxy_status_packages]
2018-10-14 06:01:07,983 [salt.minion      :1307][INFO    ][3008] User sudo_ubuntu Executing command saltutil.find_job with jid 20181014060107772959
2018-10-14 06:01:07,996 [salt.minion      :1431][INFO    ][19788] Starting a new job with PID 19788
2018-10-14 06:01:08,014 [salt.minion      :1708][INFO    ][19788] Returning information for job: 20181014060107772959
2018-10-14 06:01:08,394 [salt.state       :290 ][INFO    ][18851] All specified packages are already installed
2018-10-14 06:01:08,394 [salt.state       :1941][INFO    ][18851] Completed state [haproxy_status_packages] at time 06:01:08.394876 duration_in_ms=696.693
2018-10-14 06:01:08,395 [salt.state       :1770][INFO    ][18851] Running state [/usr/bin/haproxy-status.sh] at time 06:01:08.395701
2018-10-14 06:01:08,396 [salt.state       :1803][INFO    ][18851] Executing state file.managed for [/usr/bin/haproxy-status.sh]
2018-10-14 06:01:08,422 [salt.fileclient  :1215][INFO    ][18851] Fetching file from saltenv 'base', ** done ** 'haproxy/files/haproxy-status.sh'
2018-10-14 06:01:08,451 [salt.state       :290 ][INFO    ][18851] File changed:
New file
2018-10-14 06:01:08,452 [salt.state       :1941][INFO    ][18851] Completed state [/usr/bin/haproxy-status.sh] at time 06:01:08.452144 duration_in_ms=56.443
2018-10-14 06:01:08,452 [salt.state       :1770][INFO    ][18851] Running state [net.ipv4.ip_nonlocal_bind] at time 06:01:08.452754
2018-10-14 06:01:08,453 [salt.state       :1803][INFO    ][18851] Executing state sysctl.present for [net.ipv4.ip_nonlocal_bind]
2018-10-14 06:01:08,454 [salt.loaded.int.module.cmdmod:395 ][INFO    ][18851] Executing command 'sysctl -w net.ipv4.ip_nonlocal_bind="1"' in directory '/root'
2018-10-14 06:01:08,469 [salt.state       :290 ][INFO    ][18851] {'net.ipv4.ip_nonlocal_bind': 1}
2018-10-14 06:01:08,469 [salt.state       :1941][INFO    ][18851] Completed state [net.ipv4.ip_nonlocal_bind] at time 06:01:08.469806 duration_in_ms=17.051
2018-10-14 06:01:08,471 [salt.state       :1770][INFO    ][18851] Running state [haproxy] at time 06:01:08.471766
2018-10-14 06:01:08,472 [salt.state       :1803][INFO    ][18851] Executing state service.running for [haproxy]
2018-10-14 06:01:08,472 [salt.loaded.int.module.cmdmod:395 ][INFO    ][18851] Executing command ['systemctl', 'status', 'haproxy.service', '-n', '0'] in directory '/root'
2018-10-14 06:01:08,490 [salt.loaded.int.module.cmdmod:395 ][INFO    ][18851] Executing command ['systemctl', 'is-active', 'haproxy.service'] in directory '/root'
2018-10-14 06:01:08,507 [salt.loaded.int.module.cmdmod:395 ][INFO    ][18851] Executing command ['systemctl', 'is-enabled', 'haproxy.service'] in directory '/root'
2018-10-14 06:01:08,523 [salt.state       :290 ][INFO    ][18851] The service haproxy is already running
2018-10-14 06:01:08,524 [salt.state       :1941][INFO    ][18851] Completed state [haproxy] at time 06:01:08.524124 duration_in_ms=52.357
2018-10-14 06:01:08,524 [salt.state       :1770][INFO    ][18851] Running state [haproxy] at time 06:01:08.524480
2018-10-14 06:01:08,524 [salt.state       :1803][INFO    ][18851] Executing state service.mod_watch for [haproxy]
2018-10-14 06:01:08,527 [salt.loaded.int.module.cmdmod:395 ][INFO    ][18851] Executing command ['systemctl', 'is-active', 'haproxy.service'] in directory '/root'
2018-10-14 06:01:08,546 [salt.loaded.int.module.cmdmod:395 ][INFO    ][18851] Executing command ['systemd-run', '--scope', 'systemctl', 'restart', 'haproxy.service'] in directory '/root'
2018-10-14 06:01:08,612 [salt.state       :290 ][INFO    ][18851] {'haproxy': True}
2018-10-14 06:01:08,613 [salt.state       :1941][INFO    ][18851] Completed state [haproxy] at time 06:01:08.613097 duration_in_ms=88.616
2018-10-14 06:01:08,615 [salt.minion      :1708][INFO    ][18851] Returning information for job: 20181014060057642636
2018-10-14 06:01:13,025 [salt.minion      :1307][INFO    ][3008] User sudo_ubuntu Executing command service.status with jid 20181014060113013197
2018-10-14 06:01:13,051 [salt.minion      :1431][INFO    ][19850] Starting a new job with PID 19850
2018-10-14 06:01:13,511 [salt.loader.192.168.11.2.int.module.cmdmod:395 ][INFO    ][19850] Executing command ['systemctl', 'status', 'haproxy.service', '-n', '0'] in directory '/root'
2018-10-14 06:01:13,531 [salt.loader.192.168.11.2.int.module.cmdmod:395 ][INFO    ][19850] Executing command ['systemctl', 'is-active', 'haproxy.service'] in directory '/root'
2018-10-14 06:01:13,549 [salt.minion      :1708][INFO    ][19850] Returning information for job: 20181014060113013197
2018-10-14 06:01:14,727 [salt.minion      :1307][INFO    ][3008] User sudo_ubuntu Executing command service.restart with jid 20181014060114714982
2018-10-14 06:01:14,747 [salt.minion      :1431][INFO    ][19860] Starting a new job with PID 19860
2018-10-14 06:01:15,199 [salt.loader.192.168.11.2.int.module.cmdmod:395 ][INFO    ][19860] Executing command ['systemctl', 'status', 'rsyslog.service', '-n', '0'] in directory '/root'
2018-10-14 06:01:15,231 [salt.loader.192.168.11.2.int.module.cmdmod:395 ][INFO    ][19860] Executing command ['systemd-run', '--scope', 'systemctl', 'restart', 'rsyslog.service'] in directory '/root'
2018-10-14 06:01:15,261 [salt.minion      :1708][INFO    ][19860] Returning information for job: 20181014060114714982
2018-10-14 06:33:51,607 [salt.minion      :1307][INFO    ][3008] User sudo_ubuntu Executing command cp.push_dir with jid 20181014063351595032
2018-10-14 06:33:51,634 [salt.minion      :1431][INFO    ][20490] Starting a new job with PID 20490
