2018-04-17 21:44:56,645 [salt.loaded.int.module.cmdmod][ERROR   ][1490] Command 'rabbitmqctl cluster_status' failed with return code: 127
2018-04-17 21:44:56,646 [salt.loaded.int.module.cmdmod][ERROR   ][1490] output: /bin/sh: 1: rabbitmqctl: not found
2018-04-17 21:44:56,665 [salt.loaded.int.module.cmdmod][ERROR   ][1490] Command 'rabbitmqctl cluster_status' failed with return code: 127
2018-04-17 21:44:56,665 [salt.loaded.int.module.cmdmod][ERROR   ][1490] output: /bin/sh: 1: rabbitmqctl: not found
2018-04-17 21:44:57,844 [salt.loaded.int.module.cmdmod][ERROR   ][1490] Command 'rabbitmqctl cluster_status' failed with return code: 127
2018-04-17 21:44:57,845 [salt.loaded.int.module.cmdmod][ERROR   ][1490] output: /bin/sh: 1: rabbitmqctl: not found
2018-04-17 21:44:57,862 [salt.loaded.int.module.cmdmod][ERROR   ][1490] Command 'rabbitmqctl cluster_status' failed with return code: 127
2018-04-17 21:44:57,862 [salt.loaded.int.module.cmdmod][ERROR   ][1490] output: /bin/sh: 1: rabbitmqctl: not found
2018-04-17 21:45:37,723 [salt.loaded.int.module.cmdmod][ERROR   ][1490] Command 'while true; do salt-call saltutil.running|grep fun: && continue; salt-call --local service.restart salt-minion; break; done' failed with return code: None
2018-04-17 21:45:39,860 [salt.loaded.int.module.cmdmod][INFO    ][2027] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2018-04-17 21:45:39,873 [salt.loaded.int.module.cmdmod][INFO    ][2027] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2018-04-17 21:45:39,901 [salt.loaded.int.module.cmdmod][INFO    ][2027] Executing command ['systemd-run', '--scope', 'systemctl', 'restart', 'salt-minion.service'] in directory '/root'
2018-04-17 21:45:39,937 [salt.utils.parsers][WARNING ][1303] Minion received a SIGTERM. Exiting.
2018-04-17 21:45:40,303 [salt.cli.daemons ][INFO    ][2074] Setting up the Salt Minion "msg01.mcp-pike-ovs-ha.local"
2018-04-17 21:45:40,380 [salt.cli.daemons ][INFO    ][2074] Starting up the Salt Minion
2018-04-17 21:45:40,380 [salt.utils.event ][INFO    ][2074] Starting pull socket on /var/run/salt/minion/minion_event_91d01dc5a8_pull.ipc
2018-04-17 21:45:40,752 [salt.minion      ][INFO    ][2074] Creating minion process manager
2018-04-17 21:45:41,725 [salt.loader.192.168.11.2.int.module.cmdmod][INFO    ][2074] Executing command ['date', '+%z'] in directory '/root'
2018-04-17 21:45:41,750 [salt.utils.schedule][INFO    ][2074] Updating job settings for scheduled job: __mine_interval
2018-04-17 21:45:41,751 [salt.minion      ][INFO    ][2074] Added mine.update to scheduler
2018-04-17 21:45:41,765 [salt.minion      ][INFO    ][2074] Minion is starting as user 'root'
2018-04-17 21:45:41,779 [salt.minion      ][INFO    ][2074] Minion is ready to receive requests!
2018-04-17 21:45:42,781 [salt.utils.schedule][INFO    ][2074] Running scheduled job: __mine_interval
2018-04-17 21:47:11,417 [salt.minion      ][INFO    ][2074] User sudo_ubuntu Executing command state.apply with jid 20180417214711407955
2018-04-17 21:47:11,441 [salt.minion      ][INFO    ][2165] Starting a new job with PID 2165
2018-04-17 21:47:14,361 [salt.state       ][INFO    ][2165] Loading fresh modules for state activity
2018-04-17 21:47:14,624 [salt.fileclient  ][INFO    ][2165] Fetching file from saltenv 'base', ** done ** 'linux/init.sls'
2018-04-17 21:47:14,664 [salt.fileclient  ][INFO    ][2165] Fetching file from saltenv 'base', ** done ** 'linux/system/init.sls'
2018-04-17 21:47:14,806 [salt.fileclient  ][INFO    ][2165] Fetching file from saltenv 'base', ** done ** 'linux/system/env.sls'
2018-04-17 21:47:14,896 [salt.fileclient  ][INFO    ][2165] Fetching file from saltenv 'base', ** done ** 'linux/system/profile.sls'
2018-04-17 21:47:14,966 [salt.fileclient  ][INFO    ][2165] Fetching file from saltenv 'base', ** done ** 'linux/system/repo.sls'
2018-04-17 21:47:15,106 [salt.fileclient  ][INFO    ][2165] Fetching file from saltenv 'base', ** done ** 'linux/system/package.sls'
2018-04-17 21:47:15,411 [salt.fileclient  ][INFO    ][2165] Fetching file from saltenv 'base', ** done ** 'linux/system/timezone.sls'
2018-04-17 21:47:15,536 [salt.fileclient  ][INFO    ][2165] Fetching file from saltenv 'base', ** done ** 'linux/system/kernel.sls'
2018-04-17 21:47:15,670 [salt.fileclient  ][INFO    ][2165] Fetching file from saltenv 'base', ** done ** 'linux/system/cpu.sls'
2018-04-17 21:47:15,742 [salt.fileclient  ][INFO    ][2165] Fetching file from saltenv 'base', ** done ** 'linux/system/sysfs.sls'
2018-04-17 21:47:15,809 [salt.fileclient  ][INFO    ][2165] Fetching file from saltenv 'base', ** done ** 'linux/system/locale.sls'
2018-04-17 21:47:15,882 [salt.fileclient  ][INFO    ][2165] Fetching file from saltenv 'base', ** done ** 'linux/system/user.sls'
2018-04-17 21:47:16,030 [salt.fileclient  ][INFO    ][2165] Fetching file from saltenv 'base', ** done ** 'linux/system/group.sls'
2018-04-17 21:47:16,120 [salt.fileclient  ][INFO    ][2165] Fetching file from saltenv 'base', ** done ** 'linux/system/limit.sls'
2018-04-17 21:47:16,186 [salt.fileclient  ][INFO    ][2165] Fetching file from saltenv 'base', ** done ** 'linux/system/systemd.sls'
2018-04-17 21:47:16,254 [salt.fileclient  ][INFO    ][2165] Fetching file from saltenv 'base', ** done ** 'linux/system/apt.sls'
2018-04-17 21:47:17,041 [salt.fileclient  ][INFO    ][2165] Fetching file from saltenv 'base', ** done ** 'linux/network/init.sls'
2018-04-17 21:47:17,161 [salt.fileclient  ][INFO    ][2165] Fetching file from saltenv 'base', ** done ** 'linux/network/hostname.sls'
2018-04-17 21:47:17,229 [salt.fileclient  ][INFO    ][2165] Fetching file from saltenv 'base', ** done ** 'linux/network/host.sls'
2018-04-17 21:47:17,339 [salt.fileclient  ][INFO    ][2165] Fetching file from saltenv 'base', ** done ** 'linux/network/interface.sls'
2018-04-17 21:47:17,469 [salt.fileclient  ][INFO    ][2165] Fetching file from saltenv 'base', ** done ** 'linux/network/proxy.sls'
2018-04-17 21:47:17,564 [salt.fileclient  ][INFO    ][2165] Fetching file from saltenv 'base', ** done ** 'linux/storage/init.sls'
2018-04-17 21:47:17,643 [salt.fileclient  ][INFO    ][2165] Fetching file from saltenv 'base', ** done ** 'ntp/init.sls'
2018-04-17 21:47:17,660 [salt.fileclient  ][INFO    ][2165] Fetching file from saltenv 'base', ** done ** 'ntp/client.sls'
2018-04-17 21:47:17,692 [salt.fileclient  ][INFO    ][2165] Fetching file from saltenv 'base', ** done ** 'ntp/server.sls'
2018-04-17 21:47:17,749 [salt.state       ][INFO    ][2165] Running state [/etc/environment] at time 21:47:17.749072
2018-04-17 21:47:17,749 [salt.state       ][INFO    ][2165] Executing state file.blockreplace for /etc/environment
2018-04-17 21:47:17,758 [salt.state       ][INFO    ][2165] File changed:
--- 
+++ 
@@ -1 +1,4 @@
 PATH="/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/games:/usr/local/games"
+# SALT MANAGED VARIABLES - DO NOT EDIT - START
+# +# SALT MANAGED VARIABLES - END

2018-04-17 21:47:17,759 [salt.state       ][INFO    ][2165] Completed state [/etc/environment] at time 21:47:17.759600 duration_in_ms=10.529
2018-04-17 21:47:17,760 [salt.state       ][INFO    ][2165] Running state [/etc/profile.d] at time 21:47:17.760022
2018-04-17 21:47:17,760 [salt.state       ][INFO    ][2165] Executing state file.directory for /etc/profile.d
2018-04-17 21:47:17,769 [salt.state       ][INFO    ][2165] Directory /etc/profile.d is in the correct state
2018-04-17 21:47:17,770 [salt.state       ][INFO    ][2165] Completed state [/etc/profile.d] at time 21:47:17.770350 duration_in_ms=10.327
2018-04-17 21:47:18,205 [salt.state       ][INFO    ][2165] Running state [/etc/apt/apt.conf.d/99prefer_ipv4-salt] at time 21:47:18.205857
2018-04-17 21:47:18,206 [salt.state       ][INFO    ][2165] Executing state file.managed for /etc/apt/apt.conf.d/99prefer_ipv4-salt
2018-04-17 21:47:18,550 [salt.fileclient  ][INFO    ][2165] Fetching file from saltenv 'base', ** done ** 'linux/files/apt.conf'
2018-04-17 21:47:18,561 [salt.state       ][INFO    ][2165] File changed:
New file
2018-04-17 21:47:18,562 [salt.state       ][INFO    ][2165] Completed state [/etc/apt/apt.conf.d/99prefer_ipv4-salt] at time 21:47:18.561943 duration_in_ms=356.086
2018-04-17 21:47:18,563 [salt.state       ][INFO    ][2165] Running state [linux_repo_prereq_pkgs] at time 21:47:18.563090
2018-04-17 21:47:18,563 [salt.state       ][INFO    ][2165] Executing state pkg.installed for linux_repo_prereq_pkgs
2018-04-17 21:47:18,564 [salt.loaded.int.module.cmdmod][INFO    ][2165] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2018-04-17 21:47:18,867 [salt.state       ][INFO    ][2165] All specified packages are already installed
2018-04-17 21:47:18,868 [salt.state       ][INFO    ][2165] Completed state [linux_repo_prereq_pkgs] at time 21:47:18.868385 duration_in_ms=305.296
2018-04-17 21:47:18,868 [salt.state       ][INFO    ][2165] Running state [/etc/apt/apt.conf.d/99proxies-salt-mk_openstack] at time 21:47:18.868912
2018-04-17 21:47:18,869 [salt.state       ][INFO    ][2165] Executing state file.absent for /etc/apt/apt.conf.d/99proxies-salt-mk_openstack
2018-04-17 21:47:18,870 [salt.state       ][INFO    ][2165] File /etc/apt/apt.conf.d/99proxies-salt-mk_openstack is not present
2018-04-17 21:47:18,870 [salt.state       ][INFO    ][2165] Completed state [/etc/apt/apt.conf.d/99proxies-salt-mk_openstack] at time 21:47:18.870365 duration_in_ms=1.453
2018-04-17 21:47:18,870 [salt.state       ][INFO    ][2165] Running state [/etc/apt/preferences.d/mk_openstack] at time 21:47:18.870749
2018-04-17 21:47:18,871 [salt.state       ][INFO    ][2165] Executing state file.managed for /etc/apt/preferences.d/mk_openstack
2018-04-17 21:47:18,892 [salt.fileclient  ][INFO    ][2165] Fetching file from saltenv 'base', ** done ** 'linux/files/preferences_repo'
2018-04-17 21:47:18,950 [salt.state       ][INFO    ][2165] File changed:
New file
2018-04-17 21:47:18,950 [salt.state       ][INFO    ][2165] Completed state [/etc/apt/preferences.d/mk_openstack] at time 21:47:18.950782 duration_in_ms=80.032
2018-04-17 21:47:18,952 [salt.state       ][INFO    ][2165] Running state [curl -s http://apt.mirantis.com/public.gpg | apt-key add -] at time 21:47:18.952355
2018-04-17 21:47:18,952 [salt.state       ][INFO    ][2165] Executing state cmd.run for curl -s http://apt.mirantis.com/public.gpg | apt-key add -
2018-04-17 21:47:18,953 [salt.loaded.int.module.cmdmod][INFO    ][2165] Executing command 'curl -s http://apt.mirantis.com/public.gpg | apt-key add -' in directory '/root'
2018-04-17 21:47:19,127 [salt.state       ][INFO    ][2165] {'pid': 2225, 'retcode': 0, 'stderr': '', 'stdout': 'OK'}
2018-04-17 21:47:19,128 [salt.state       ][INFO    ][2165] Completed state [curl -s http://apt.mirantis.com/public.gpg | apt-key add -] at time 21:47:19.127975 duration_in_ms=175.619
2018-04-17 21:47:19,138 [salt.state       ][INFO    ][2165] Running state [deb [arch=amd64] http://apt.mirantis.com/xenial/ nightly pike] at time 21:47:19.138381
2018-04-17 21:47:19,138 [salt.state       ][INFO    ][2165] Executing state pkgrepo.managed for deb [arch=amd64] http://apt.mirantis.com/xenial/ nightly pike
2018-04-17 21:47:19,211 [salt.loaded.int.module.cmdmod][INFO    ][2165] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2018-04-17 21:47:21,501 [salt.minion      ][INFO    ][2074] User sudo_ubuntu Executing command saltutil.find_job with jid 20180417214721484173
2018-04-17 21:47:21,519 [salt.minion      ][INFO    ][2651] Starting a new job with PID 2651
2018-04-17 21:47:21,545 [salt.minion      ][INFO    ][2651] Returning information for job: 20180417214721484173
2018-04-17 21:47:22,229 [salt.state       ][INFO    ][2165] {'repo': 'deb [arch=amd64] http://apt.mirantis.com/xenial nightly pike'}
2018-04-17 21:47:22,230 [salt.state       ][INFO    ][2165] Completed state [deb [arch=amd64] http://apt.mirantis.com/xenial/ nightly pike] at time 21:47:22.230305 duration_in_ms=3091.924
2018-04-17 21:47:22,230 [salt.state       ][INFO    ][2165] Running state [/etc/apt/apt.conf.d/99proxies-salt-uca-staging] at time 21:47:22.230804
2018-04-17 21:47:22,231 [salt.state       ][INFO    ][2165] Executing state file.absent for /etc/apt/apt.conf.d/99proxies-salt-uca-staging
2018-04-17 21:47:22,231 [salt.state       ][INFO    ][2165] File /etc/apt/apt.conf.d/99proxies-salt-uca-staging is not present
2018-04-17 21:47:22,232 [salt.state       ][INFO    ][2165] Completed state [/etc/apt/apt.conf.d/99proxies-salt-uca-staging] at time 21:47:22.232162 duration_in_ms=1.358
2018-04-17 21:47:22,232 [salt.state       ][INFO    ][2165] Running state [/etc/apt/preferences.d/uca-staging] at time 21:47:22.232560
2018-04-17 21:47:22,232 [salt.state       ][INFO    ][2165] Executing state file.absent for /etc/apt/preferences.d/uca-staging
2018-04-17 21:47:22,233 [salt.state       ][INFO    ][2165] File /etc/apt/preferences.d/uca-staging is not present
2018-04-17 21:47:22,233 [salt.state       ][INFO    ][2165] Completed state [/etc/apt/preferences.d/uca-staging] at time 21:47:22.233637 duration_in_ms=1.078
2018-04-17 21:47:22,234 [salt.state       ][INFO    ][2165] Running state [apt-key adv --keyserver keyserver.ubuntu.com --recv 9F68104E] at time 21:47:22.233993
2018-04-17 21:47:22,234 [salt.state       ][INFO    ][2165] Executing state cmd.run for apt-key adv --keyserver keyserver.ubuntu.com --recv 9F68104E
2018-04-17 21:47:22,235 [salt.loaded.int.module.cmdmod][INFO    ][2165] Executing command 'apt-key adv --keyserver keyserver.ubuntu.com --recv 9F68104E' in directory '/root'
2018-04-17 21:47:22,760 [salt.state       ][INFO    ][2165] {'pid': 2655, '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.UnQJu0AN9Y/gpg.1.sh --keyserver\nkeyserver.ubuntu.com\n--recv\n9F68104E'}
2018-04-17 21:47:22,760 [salt.state       ][INFO    ][2165] Completed state [apt-key adv --keyserver keyserver.ubuntu.com --recv 9F68104E] at time 21:47:22.760922 duration_in_ms=526.929
2018-04-17 21:47:22,762 [salt.state       ][INFO    ][2165] Running state [deb http://ppa.launchpad.net/ubuntu-cloud-archive/pike-staging/ubuntu xenial main] at time 21:47:22.762231
2018-04-17 21:47:22,762 [salt.state       ][INFO    ][2165] Executing state pkgrepo.managed for deb http://ppa.launchpad.net/ubuntu-cloud-archive/pike-staging/ubuntu xenial main
2018-04-17 21:47:22,804 [salt.loaded.int.module.cmdmod][INFO    ][2165] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2018-04-17 21:47:26,691 [salt.state       ][INFO    ][2165] {'repo': 'deb http://ppa.launchpad.net/ubuntu-cloud-archive/pike-staging/ubuntu xenial main'}
2018-04-17 21:47:26,692 [salt.state       ][INFO    ][2165] Completed state [deb http://ppa.launchpad.net/ubuntu-cloud-archive/pike-staging/ubuntu xenial main] at time 21:47:26.692324 duration_in_ms=3930.092
2018-04-17 21:47:26,692 [salt.state       ][INFO    ][2165] Running state [/etc/apt/apt.conf.d/99proxies-salt-mirantis_openstack] at time 21:47:26.692787
2018-04-17 21:47:26,693 [salt.state       ][INFO    ][2165] Executing state file.absent for /etc/apt/apt.conf.d/99proxies-salt-mirantis_openstack
2018-04-17 21:47:26,693 [salt.state       ][INFO    ][2165] File /etc/apt/apt.conf.d/99proxies-salt-mirantis_openstack is not present
2018-04-17 21:47:26,694 [salt.state       ][INFO    ][2165] Completed state [/etc/apt/apt.conf.d/99proxies-salt-mirantis_openstack] at time 21:47:26.694055 duration_in_ms=1.268
2018-04-17 21:47:26,694 [salt.state       ][INFO    ][2165] Running state [/etc/apt/preferences.d/mirantis_openstack] at time 21:47:26.694423
2018-04-17 21:47:26,694 [salt.state       ][INFO    ][2165] Executing state file.managed for /etc/apt/preferences.d/mirantis_openstack
2018-04-17 21:47:26,752 [salt.state       ][INFO    ][2165] File changed:
New file
2018-04-17 21:47:26,752 [salt.state       ][INFO    ][2165] Completed state [/etc/apt/preferences.d/mirantis_openstack] at time 21:47:26.752577 duration_in_ms=58.153
2018-04-17 21:47:26,752 [salt.state       ][INFO    ][2165] Running state [curl -s http://mirror.fuel-infra.org/mcp-repos/pike/xenial/archive-mcppike.key | apt-key add -] at time 21:47:26.752947
2018-04-17 21:47:26,753 [salt.state       ][INFO    ][2165] Executing state cmd.run for curl -s http://mirror.fuel-infra.org/mcp-repos/pike/xenial/archive-mcppike.key | apt-key add -
2018-04-17 21:47:26,754 [salt.loaded.int.module.cmdmod][INFO    ][2165] Executing command 'curl -s http://mirror.fuel-infra.org/mcp-repos/pike/xenial/archive-mcppike.key | apt-key add -' in directory '/root'
2018-04-17 21:47:28,805 [salt.state       ][INFO    ][2165] {'pid': 3136, 'retcode': 0, 'stderr': '', 'stdout': 'OK'}
2018-04-17 21:47:28,806 [salt.state       ][INFO    ][2165] Completed state [curl -s http://mirror.fuel-infra.org/mcp-repos/pike/xenial/archive-mcppike.key | apt-key add -] at time 21:47:28.806837 duration_in_ms=2053.888
2018-04-17 21:47:28,809 [salt.state       ][INFO    ][2165] Running state [deb http://mirror.fuel-infra.org/mcp-repos/pike/xenial pike main] at time 21:47:28.809308
2018-04-17 21:47:28,810 [salt.state       ][INFO    ][2165] Executing state pkgrepo.managed for deb http://mirror.fuel-infra.org/mcp-repos/pike/xenial pike main
2018-04-17 21:47:28,875 [salt.loaded.int.module.cmdmod][INFO    ][2165] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2018-04-17 21:47:31,557 [salt.minion      ][INFO    ][2074] User sudo_ubuntu Executing command saltutil.find_job with jid 20180417214731529080
2018-04-17 21:47:31,578 [salt.minion      ][INFO    ][3663] Starting a new job with PID 3663
2018-04-17 21:47:31,603 [salt.minion      ][INFO    ][3663] Returning information for job: 20180417214731529080
2018-04-17 21:47:32,572 [salt.state       ][INFO    ][2165] {'repo': 'deb http://mirror.fuel-infra.org/mcp-repos/pike/xenial pike main'}
2018-04-17 21:47:32,572 [salt.state       ][INFO    ][2165] Completed state [deb http://mirror.fuel-infra.org/mcp-repos/pike/xenial pike main] at time 21:47:32.572503 duration_in_ms=3763.195
2018-04-17 21:47:32,572 [salt.state       ][INFO    ][2165] Running state [/etc/apt/apt.conf.d/99proxies-salt-uca] at time 21:47:32.572799
2018-04-17 21:47:32,573 [salt.state       ][INFO    ][2165] Executing state file.absent for /etc/apt/apt.conf.d/99proxies-salt-uca
2018-04-17 21:47:32,573 [salt.state       ][INFO    ][2165] File /etc/apt/apt.conf.d/99proxies-salt-uca is not present
2018-04-17 21:47:32,573 [salt.state       ][INFO    ][2165] Completed state [/etc/apt/apt.conf.d/99proxies-salt-uca] at time 21:47:32.573587 duration_in_ms=0.788
2018-04-17 21:47:32,573 [salt.state       ][INFO    ][2165] Running state [/etc/apt/preferences.d/uca] at time 21:47:32.573763
2018-04-17 21:47:32,573 [salt.state       ][INFO    ][2165] Executing state file.absent for /etc/apt/preferences.d/uca
2018-04-17 21:47:32,574 [salt.state       ][INFO    ][2165] File /etc/apt/preferences.d/uca is not present
2018-04-17 21:47:32,574 [salt.state       ][INFO    ][2165] Completed state [/etc/apt/preferences.d/uca] at time 21:47:32.574270 duration_in_ms=0.507
2018-04-17 21:47:32,574 [salt.state       ][INFO    ][2165] Running state [apt-key adv --keyserver keyserver.ubuntu.com --recv EC4926EA] at time 21:47:32.574431
2018-04-17 21:47:32,574 [salt.state       ][INFO    ][2165] Executing state cmd.run for apt-key adv --keyserver keyserver.ubuntu.com --recv EC4926EA
2018-04-17 21:47:32,575 [salt.loaded.int.module.cmdmod][INFO    ][2165] Executing command 'apt-key adv --keyserver keyserver.ubuntu.com --recv EC4926EA' in directory '/root'
2018-04-17 21:47:32,935 [salt.state       ][INFO    ][2165] {'pid': 3668, '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.oG7FPbbA52/gpg.1.sh --keyserver\nkeyserver.ubuntu.com\n--recv\nEC4926EA'}
2018-04-17 21:47:32,936 [salt.state       ][INFO    ][2165] Completed state [apt-key adv --keyserver keyserver.ubuntu.com --recv EC4926EA] at time 21:47:32.936730 duration_in_ms=362.298
2018-04-17 21:47:32,939 [salt.state       ][INFO    ][2165] Running state [deb http://ubuntu-cloud.archive.canonical.com/ubuntu xenial-updates/pike main] at time 21:47:32.938941
2018-04-17 21:47:32,939 [salt.state       ][INFO    ][2165] Executing state pkgrepo.managed for deb http://ubuntu-cloud.archive.canonical.com/ubuntu xenial-updates/pike main
2018-04-17 21:47:33,009 [salt.loaded.int.module.cmdmod][INFO    ][2165] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2018-04-17 21:47:37,125 [salt.state       ][INFO    ][2165] {'repo': 'deb http://ubuntu-cloud.archive.canonical.com/ubuntu xenial-updates/pike main'}
2018-04-17 21:47:37,125 [salt.state       ][INFO    ][2165] Completed state [deb http://ubuntu-cloud.archive.canonical.com/ubuntu xenial-updates/pike main] at time 21:47:37.125726 duration_in_ms=4186.786
2018-04-17 21:47:37,237 [salt.state       ][INFO    ][2165] Running state [UTC] at time 21:47:37.237679
2018-04-17 21:47:37,238 [salt.state       ][INFO    ][2165] Executing state timezone.system for UTC
2018-04-17 21:47:37,238 [salt.loaded.int.module.cmdmod][INFO    ][2165] Executing command ['timedatectl'] in directory '/root'
2018-04-17 21:47:37,658 [salt.loaded.int.module.cmdmod][INFO    ][2165] Executing command ['timedatectl'] in directory '/root'
2018-04-17 21:47:37,681 [salt.loaded.int.module.cmdmod][INFO    ][2165] Executing command 'timedatectl set-timezone UTC' in directory '/root'
2018-04-17 21:47:37,836 [salt.state       ][INFO    ][2165] {'timezone': 'UTC'}
2018-04-17 21:47:37,837 [salt.state       ][INFO    ][2165] Completed state [UTC] at time 21:47:37.837398 duration_in_ms=599.718
2018-04-17 21:47:37,935 [salt.state       ][INFO    ][2165] Running state [nf_conntrack] at time 21:47:37.935197
2018-04-17 21:47:37,935 [salt.state       ][INFO    ][2165] Executing state kmod.present for nf_conntrack
2018-04-17 21:47:37,937 [salt.loaded.int.module.cmdmod][INFO    ][2165] Executing command 'lsmod' in directory '/root'
2018-04-17 21:47:38,728 [salt.loaded.int.module.cmdmod][INFO    ][2165] Executing command 'lsmod' in directory '/root'
2018-04-17 21:47:38,753 [salt.loaded.int.module.cmdmod][INFO    ][2165] Executing command 'modprobe nf_conntrack' in directory '/root'
2018-04-17 21:47:38,947 [salt.loaded.int.module.cmdmod][INFO    ][2165] Executing command 'lsmod' in directory '/root'
2018-04-17 21:47:38,974 [salt.state       ][INFO    ][2165] {'nf_conntrack': 'loaded'}
2018-04-17 21:47:38,975 [salt.state       ][INFO    ][2165] Completed state [nf_conntrack] at time 21:47:38.975053 duration_in_ms=1039.857
2018-04-17 21:47:39,034 [salt.state       ][INFO    ][2165] Running state [kernel.panic] at time 21:47:39.034715
2018-04-17 21:47:39,035 [salt.state       ][INFO    ][2165] Executing state sysctl.present for kernel.panic
2018-04-17 21:47:39,054 [salt.loaded.int.module.cmdmod][INFO    ][2165] Executing command 'sysctl -a' in directory '/root'
2018-04-17 21:47:39,291 [salt.loaded.int.module.cmdmod][INFO    ][2165] Executing command 'sysctl -w kernel.panic="60"' in directory '/root'
2018-04-17 21:47:39,315 [salt.state       ][INFO    ][2165] {'kernel.panic': 60}
2018-04-17 21:47:39,316 [salt.state       ][INFO    ][2165] Completed state [kernel.panic] at time 21:47:39.316181 duration_in_ms=281.466
2018-04-17 21:47:39,316 [salt.state       ][INFO    ][2165] Running state [net.ipv4.tcp_keepalive_probes] at time 21:47:39.316685
2018-04-17 21:47:39,317 [salt.state       ][INFO    ][2165] Executing state sysctl.present for net.ipv4.tcp_keepalive_probes
2018-04-17 21:47:39,317 [salt.loaded.int.module.cmdmod][INFO    ][2165] Executing command 'sysctl -a' in directory '/root'
2018-04-17 21:47:39,365 [salt.loaded.int.module.cmdmod][INFO    ][2165] Executing command 'sysctl -w net.ipv4.tcp_keepalive_probes="8"' in directory '/root'
2018-04-17 21:47:39,379 [salt.state       ][INFO    ][2165] {'net.ipv4.tcp_keepalive_probes': 8}
2018-04-17 21:47:39,379 [salt.state       ][INFO    ][2165] Completed state [net.ipv4.tcp_keepalive_probes] at time 21:47:39.379731 duration_in_ms=63.045
2018-04-17 21:47:39,380 [salt.state       ][INFO    ][2165] Running state [fs.file-max] at time 21:47:39.380090
2018-04-17 21:47:39,380 [salt.state       ][INFO    ][2165] Executing state sysctl.present for fs.file-max
2018-04-17 21:47:39,381 [salt.loaded.int.module.cmdmod][INFO    ][2165] Executing command 'sysctl -a' in directory '/root'
2018-04-17 21:47:39,447 [salt.loaded.int.module.cmdmod][INFO    ][2165] Executing command 'sysctl -w fs.file-max="124165"' in directory '/root'
2018-04-17 21:47:39,461 [salt.state       ][INFO    ][2165] {'fs.file-max': 124165}
2018-04-17 21:47:39,461 [salt.state       ][INFO    ][2165] Completed state [fs.file-max] at time 21:47:39.461729 duration_in_ms=81.638
2018-04-17 21:47:39,462 [salt.state       ][INFO    ][2165] Running state [net.core.somaxconn] at time 21:47:39.462122
2018-04-17 21:47:39,462 [salt.state       ][INFO    ][2165] Executing state sysctl.present for net.core.somaxconn
2018-04-17 21:47:39,463 [salt.loaded.int.module.cmdmod][INFO    ][2165] Executing command 'sysctl -a' in directory '/root'
2018-04-17 21:47:39,581 [salt.loaded.int.module.cmdmod][INFO    ][2165] Executing command 'sysctl -w net.core.somaxconn="4096"' in directory '/root'
2018-04-17 21:47:39,596 [salt.state       ][INFO    ][2165] {'net.core.somaxconn': 4096}
2018-04-17 21:47:39,597 [salt.state       ][INFO    ][2165] Completed state [net.core.somaxconn] at time 21:47:39.597123 duration_in_ms=135.0
2018-04-17 21:47:39,597 [salt.state       ][INFO    ][2165] Running state [net.ipv4.tcp_max_syn_backlog] at time 21:47:39.597778
2018-04-17 21:47:39,598 [salt.state       ][INFO    ][2165] Executing state sysctl.present for net.ipv4.tcp_max_syn_backlog
2018-04-17 21:47:39,599 [salt.loaded.int.module.cmdmod][INFO    ][2165] Executing command 'sysctl -a' in directory '/root'
2018-04-17 21:47:39,701 [salt.loaded.int.module.cmdmod][INFO    ][2165] Executing command 'sysctl -w net.ipv4.tcp_max_syn_backlog="8192"' in directory '/root'
2018-04-17 21:47:39,724 [salt.state       ][INFO    ][2165] {'net.ipv4.tcp_max_syn_backlog': 8192}
2018-04-17 21:47:39,724 [salt.state       ][INFO    ][2165] Completed state [net.ipv4.tcp_max_syn_backlog] at time 21:47:39.724877 duration_in_ms=127.098
2018-04-17 21:47:39,725 [salt.state       ][INFO    ][2165] Running state [net.ipv4.tcp_tw_reuse] at time 21:47:39.725324
2018-04-17 21:47:39,725 [salt.state       ][INFO    ][2165] Executing state sysctl.present for net.ipv4.tcp_tw_reuse
2018-04-17 21:47:39,726 [salt.loaded.int.module.cmdmod][INFO    ][2165] Executing command 'sysctl -a' in directory '/root'
2018-04-17 21:47:39,764 [salt.loaded.int.module.cmdmod][INFO    ][2165] Executing command 'sysctl -w net.ipv4.tcp_tw_reuse="1"' in directory '/root'
2018-04-17 21:47:39,778 [salt.state       ][INFO    ][2165] {'net.ipv4.tcp_tw_reuse': 1}
2018-04-17 21:47:39,778 [salt.state       ][INFO    ][2165] Completed state [net.ipv4.tcp_tw_reuse] at time 21:47:39.778445 duration_in_ms=53.12
2018-04-17 21:47:39,778 [salt.state       ][INFO    ][2165] Running state [net.ipv4.tcp_congestion_control] at time 21:47:39.778936
2018-04-17 21:47:39,779 [salt.state       ][INFO    ][2165] Executing state sysctl.present for net.ipv4.tcp_congestion_control
2018-04-17 21:47:39,780 [salt.loaded.int.module.cmdmod][INFO    ][2165] Executing command 'sysctl -a' in directory '/root'
2018-04-17 21:47:39,959 [salt.loaded.int.module.cmdmod][INFO    ][2165] Executing command 'sysctl -w net.ipv4.tcp_congestion_control="yeah"' in directory '/root'
2018-04-17 21:47:40,252 [salt.state       ][INFO    ][2165] {'net.ipv4.tcp_congestion_control': 'yeah'}
2018-04-17 21:47:40,253 [salt.state       ][INFO    ][2165] Completed state [net.ipv4.tcp_congestion_control] at time 21:47:40.252966 duration_in_ms=474.028
2018-04-17 21:47:40,254 [salt.state       ][INFO    ][2165] Running state [net.ipv4.tcp_retries2] at time 21:47:40.254073
2018-04-17 21:47:40,254 [salt.state       ][INFO    ][2165] Executing state sysctl.present for net.ipv4.tcp_retries2
2018-04-17 21:47:40,256 [salt.loaded.int.module.cmdmod][INFO    ][2165] Executing command 'sysctl -a' in directory '/root'
2018-04-17 21:47:40,310 [salt.loaded.int.module.cmdmod][INFO    ][2165] Executing command 'sysctl -w net.ipv4.tcp_retries2="5"' in directory '/root'
2018-04-17 21:47:40,336 [salt.state       ][INFO    ][2165] {'net.ipv4.tcp_retries2': 5}
2018-04-17 21:47:40,336 [salt.state       ][INFO    ][2165] Completed state [net.ipv4.tcp_retries2] at time 21:47:40.336712 duration_in_ms=82.639
2018-04-17 21:47:40,337 [salt.state       ][INFO    ][2165] Running state [net.core.netdev_max_backlog] at time 21:47:40.337536
2018-04-17 21:47:40,338 [salt.state       ][INFO    ][2165] Executing state sysctl.present for net.core.netdev_max_backlog
2018-04-17 21:47:40,339 [salt.loaded.int.module.cmdmod][INFO    ][2165] Executing command 'sysctl -a' in directory '/root'
2018-04-17 21:47:40,390 [salt.loaded.int.module.cmdmod][INFO    ][2165] Executing command 'sysctl -w net.core.netdev_max_backlog="261144"' in directory '/root'
2018-04-17 21:47:40,411 [salt.state       ][INFO    ][2165] {'net.core.netdev_max_backlog': 261144}
2018-04-17 21:47:40,411 [salt.state       ][INFO    ][2165] Completed state [net.core.netdev_max_backlog] at time 21:47:40.411785 duration_in_ms=74.248
2018-04-17 21:47:40,412 [salt.state       ][INFO    ][2165] Running state [net.ipv4.tcp_slow_start_after_idle] at time 21:47:40.412418
2018-04-17 21:47:40,412 [salt.state       ][INFO    ][2165] Executing state sysctl.present for net.ipv4.tcp_slow_start_after_idle
2018-04-17 21:47:40,414 [salt.loaded.int.module.cmdmod][INFO    ][2165] Executing command 'sysctl -a' in directory '/root'
2018-04-17 21:47:40,492 [salt.loaded.int.module.cmdmod][INFO    ][2165] Executing command 'sysctl -w net.ipv4.tcp_slow_start_after_idle="0"' in directory '/root'
2018-04-17 21:47:40,516 [salt.state       ][INFO    ][2165] {'net.ipv4.tcp_slow_start_after_idle': 0}
2018-04-17 21:47:40,517 [salt.state       ][INFO    ][2165] Completed state [net.ipv4.tcp_slow_start_after_idle] at time 21:47:40.517589 duration_in_ms=105.168
2018-04-17 21:47:40,518 [salt.state       ][INFO    ][2165] Running state [vm.swappiness] at time 21:47:40.518388
2018-04-17 21:47:40,519 [salt.state       ][INFO    ][2165] Executing state sysctl.present for vm.swappiness
2018-04-17 21:47:40,520 [salt.loaded.int.module.cmdmod][INFO    ][2165] Executing command 'sysctl -a' in directory '/root'
2018-04-17 21:47:40,613 [salt.loaded.int.module.cmdmod][INFO    ][2165] Executing command 'sysctl -w vm.swappiness="10"' in directory '/root'
2018-04-17 21:47:40,639 [salt.state       ][INFO    ][2165] {'vm.swappiness': 10}
2018-04-17 21:47:40,639 [salt.state       ][INFO    ][2165] Completed state [vm.swappiness] at time 21:47:40.639805 duration_in_ms=121.417
2018-04-17 21:47:40,640 [salt.state       ][INFO    ][2165] Running state [net.ipv4.tcp_keepalive_intvl] at time 21:47:40.640751
2018-04-17 21:47:40,641 [salt.state       ][INFO    ][2165] Executing state sysctl.present for net.ipv4.tcp_keepalive_intvl
2018-04-17 21:47:40,642 [salt.loaded.int.module.cmdmod][INFO    ][2165] Executing command 'sysctl -a' in directory '/root'
2018-04-17 21:47:40,715 [salt.loaded.int.module.cmdmod][INFO    ][2165] Executing command 'sysctl -w net.ipv4.tcp_keepalive_intvl="3"' in directory '/root'
2018-04-17 21:47:40,734 [salt.state       ][INFO    ][2165] {'net.ipv4.tcp_keepalive_intvl': 3}
2018-04-17 21:47:40,734 [salt.state       ][INFO    ][2165] Completed state [net.ipv4.tcp_keepalive_intvl] at time 21:47:40.734663 duration_in_ms=93.911
2018-04-17 21:47:40,735 [salt.state       ][INFO    ][2165] Running state [net.ipv4.neigh.default.gc_thresh1] at time 21:47:40.735518
2018-04-17 21:47:40,736 [salt.state       ][INFO    ][2165] Executing state sysctl.present for net.ipv4.neigh.default.gc_thresh1
2018-04-17 21:47:40,737 [salt.loaded.int.module.cmdmod][INFO    ][2165] Executing command 'sysctl -a' in directory '/root'
2018-04-17 21:47:40,829 [salt.loaded.int.module.cmdmod][INFO    ][2165] Executing command 'sysctl -w net.ipv4.neigh.default.gc_thresh1="4096"' in directory '/root'
2018-04-17 21:47:40,855 [salt.state       ][INFO    ][2165] {'net.ipv4.neigh.default.gc_thresh1': 4096}
2018-04-17 21:47:40,856 [salt.state       ][INFO    ][2165] Completed state [net.ipv4.neigh.default.gc_thresh1] at time 21:47:40.856642 duration_in_ms=121.124
2018-04-17 21:47:40,857 [salt.state       ][INFO    ][2165] Running state [net.ipv4.neigh.default.gc_thresh2] at time 21:47:40.857836
2018-04-17 21:47:40,858 [salt.state       ][INFO    ][2165] Executing state sysctl.present for net.ipv4.neigh.default.gc_thresh2
2018-04-17 21:47:40,860 [salt.loaded.int.module.cmdmod][INFO    ][2165] Executing command 'sysctl -a' in directory '/root'
2018-04-17 21:47:41,057 [salt.loaded.int.module.cmdmod][INFO    ][2165] Executing command 'sysctl -w net.ipv4.neigh.default.gc_thresh2="8192"' in directory '/root'
2018-04-17 21:47:41,082 [salt.state       ][INFO    ][2165] {'net.ipv4.neigh.default.gc_thresh2': 8192}
2018-04-17 21:47:41,084 [salt.state       ][INFO    ][2165] Completed state [net.ipv4.neigh.default.gc_thresh2] at time 21:47:41.084159 duration_in_ms=226.323
2018-04-17 21:47:41,085 [salt.state       ][INFO    ][2165] Running state [net.ipv4.neigh.default.gc_thresh3] at time 21:47:41.085443
2018-04-17 21:47:41,086 [salt.state       ][INFO    ][2165] Executing state sysctl.present for net.ipv4.neigh.default.gc_thresh3
2018-04-17 21:47:41,088 [salt.loaded.int.module.cmdmod][INFO    ][2165] Executing command 'sysctl -a' in directory '/root'
2018-04-17 21:47:41,140 [salt.loaded.int.module.cmdmod][INFO    ][2165] Executing command 'sysctl -w net.ipv4.neigh.default.gc_thresh3="16384"' in directory '/root'
2018-04-17 21:47:41,158 [salt.state       ][INFO    ][2165] {'net.ipv4.neigh.default.gc_thresh3': 16384}
2018-04-17 21:47:41,159 [salt.state       ][INFO    ][2165] Completed state [net.ipv4.neigh.default.gc_thresh3] at time 21:47:41.159693 duration_in_ms=74.25
2018-04-17 21:47:41,160 [salt.state       ][INFO    ][2165] Running state [net.ipv4.tcp_fin_timeout] at time 21:47:41.160702
2018-04-17 21:47:41,161 [salt.state       ][INFO    ][2165] Executing state sysctl.present for net.ipv4.tcp_fin_timeout
2018-04-17 21:47:41,163 [salt.loaded.int.module.cmdmod][INFO    ][2165] Executing command 'sysctl -a' in directory '/root'
2018-04-17 21:47:41,219 [salt.loaded.int.module.cmdmod][INFO    ][2165] Executing command 'sysctl -w net.ipv4.tcp_fin_timeout="30"' in directory '/root'
2018-04-17 21:47:41,237 [salt.state       ][INFO    ][2165] {'net.ipv4.tcp_fin_timeout': 30}
2018-04-17 21:47:41,238 [salt.state       ][INFO    ][2165] Completed state [net.ipv4.tcp_fin_timeout] at time 21:47:41.237923 duration_in_ms=77.222
2018-04-17 21:47:41,238 [salt.state       ][INFO    ][2165] Running state [net.ipv4.tcp_keepalive_time] at time 21:47:41.238623
2018-04-17 21:47:41,239 [salt.state       ][INFO    ][2165] Executing state sysctl.present for net.ipv4.tcp_keepalive_time
2018-04-17 21:47:41,240 [salt.loaded.int.module.cmdmod][INFO    ][2165] Executing command 'sysctl -a' in directory '/root'
2018-04-17 21:47:41,434 [salt.loaded.int.module.cmdmod][INFO    ][2165] Executing command 'sysctl -w net.ipv4.tcp_keepalive_time="30"' in directory '/root'
2018-04-17 21:47:41,461 [salt.state       ][INFO    ][2165] {'net.ipv4.tcp_keepalive_time': 30}
2018-04-17 21:47:41,462 [salt.state       ][INFO    ][2165] Completed state [net.ipv4.tcp_keepalive_time] at time 21:47:41.462609 duration_in_ms=223.985
2018-04-17 21:47:41,463 [salt.state       ][INFO    ][2165] Running state [net.nf_conntrack_max] at time 21:47:41.463797
2018-04-17 21:47:41,464 [salt.state       ][INFO    ][2165] Executing state sysctl.present for net.nf_conntrack_max
2018-04-17 21:47:41,466 [salt.loaded.int.module.cmdmod][INFO    ][2165] Executing command 'sysctl -a' in directory '/root'
2018-04-17 21:47:41,602 [salt.loaded.int.module.cmdmod][INFO    ][2165] Executing command 'sysctl -w net.nf_conntrack_max="1048576"' in directory '/root'
2018-04-17 21:47:41,624 [salt.state       ][INFO    ][2165] {'net.nf_conntrack_max': 1048576}
2018-04-17 21:47:41,625 [salt.state       ][INFO    ][2165] Completed state [net.nf_conntrack_max] at time 21:47:41.625519 duration_in_ms=161.721
2018-04-17 21:47:41,626 [salt.state       ][INFO    ][2165] Running state [linux_sysfs_package] at time 21:47:41.626376
2018-04-17 21:47:41,627 [salt.state       ][INFO    ][2165] Executing state pkg.installed for linux_sysfs_package
2018-04-17 21:47:41,648 [salt.loaded.int.module.cmdmod][INFO    ][2165] Executing command ['apt-cache', '-q', 'policy', 'sysfsutils'] in directory '/root'
2018-04-17 21:47:41,716 [salt.loaded.int.module.cmdmod][INFO    ][2165] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2018-04-17 21:47:41,755 [salt.minion      ][INFO    ][2074] User sudo_ubuntu Executing command saltutil.find_job with jid 20180417214741736558
2018-04-17 21:47:41,769 [salt.minion      ][INFO    ][4314] Starting a new job with PID 4314
2018-04-17 21:47:41,783 [salt.minion      ][INFO    ][4314] Returning information for job: 20180417214741736558
2018-04-17 21:47:43,268 [salt.loaded.int.module.cmdmod][INFO    ][2165] Executing command ['dpkg', '--get-selections', '*'] in directory '/root'
2018-04-17 21:47:43,298 [salt.loaded.int.module.cmdmod][INFO    ][2165] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'sysfsutils'] in directory '/root'
2018-04-17 21:47:51,827 [salt.minion      ][INFO    ][2074] User sudo_ubuntu Executing command saltutil.find_job with jid 20180417214751812707
2018-04-17 21:47:51,853 [salt.minion      ][INFO    ][5010] Starting a new job with PID 5010
2018-04-17 21:47:51,878 [salt.minion      ][INFO    ][5010] Returning information for job: 20180417214751812707
2018-04-17 21:47:55,874 [salt.loaded.int.module.cmdmod][INFO    ][2165] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2018-04-17 21:47:55,915 [salt.state       ][INFO    ][2165] Made the following changes:
'libsysfs2' changed from 'absent' to '2.1.0+repack-4'
'sysfsutils' changed from 'absent' to '2.1.0+repack-4'

2018-04-17 21:47:55,938 [salt.state       ][INFO    ][2165] Loading fresh modules for state activity
2018-04-17 21:47:55,966 [salt.state       ][INFO    ][2165] Completed state [linux_sysfs_package] at time 21:47:55.966235 duration_in_ms=14339.857
2018-04-17 21:47:55,972 [salt.state       ][INFO    ][2165] Running state [/etc/sysfs.d] at time 21:47:55.972431
2018-04-17 21:47:55,972 [salt.state       ][INFO    ][2165] Executing state file.directory for /etc/sysfs.d
2018-04-17 21:47:55,978 [salt.state       ][INFO    ][2165] Directory /etc/sysfs.d is in the correct state
2018-04-17 21:47:55,978 [salt.state       ][INFO    ][2165] Completed state [/etc/sysfs.d] at time 21:47:55.978561 duration_in_ms=6.13
2018-04-17 21:47:56,026 [salt.state       ][INFO    ][2165] Running state [ondemand] at time 21:47:56.026891
2018-04-17 21:47:56,027 [salt.state       ][INFO    ][2165] Executing state service.dead for ondemand
2018-04-17 21:47:56,029 [salt.loaded.int.module.cmdmod][INFO    ][2165] Executing command ['systemctl', 'status', 'ondemand.service', '-n', '0'] in directory '/root'
2018-04-17 21:47:56,053 [salt.loaded.int.module.cmdmod][INFO    ][2165] Executing command ['systemctl', 'is-active', 'ondemand.service'] in directory '/root'
2018-04-17 21:47:56,067 [salt.loaded.int.module.cmdmod][INFO    ][2165] Executing command ['systemctl', 'is-enabled', 'ondemand.service'] in directory '/root'
2018-04-17 21:47:56,083 [salt.loaded.int.module.cmdmod][INFO    ][2165] Executing command ['systemd-run', '--scope', 'systemctl', 'stop', 'ondemand.service'] in directory '/root'
2018-04-17 21:47:56,161 [salt.loaded.int.module.cmdmod][INFO    ][2165] Executing command ['systemctl', 'is-active', 'ondemand.service'] in directory '/root'
2018-04-17 21:47:56,176 [salt.loaded.int.module.cmdmod][INFO    ][2165] Executing command ['systemctl', 'is-enabled', 'ondemand.service'] in directory '/root'
2018-04-17 21:47:56,194 [salt.loaded.int.module.cmdmod][INFO    ][2165] Executing command ['systemctl', 'is-enabled', 'ondemand.service'] in directory '/root'
2018-04-17 21:47:56,215 [salt.loaded.int.module.cmdmod][INFO    ][2165] Executing command ['systemd-run', '--scope', '/usr/sbin/update-rc.d', '-f', 'ondemand', 'remove'] in directory '/root'
2018-04-17 21:47:56,575 [salt.loaded.int.module.cmdmod][INFO    ][2165] Executing command ['systemctl', 'is-enabled', 'ondemand.service'] in directory '/root'
2018-04-17 21:47:56,606 [salt.loaded.int.module.cmdmod][INFO    ][2165] Executing command 'runlevel' in directory '/root'
2018-04-17 21:47:56,623 [salt.state       ][INFO    ][2165] {'ondemand': True}
2018-04-17 21:47:56,624 [salt.state       ][INFO    ][2165] Completed state [ondemand] at time 21:47:56.624731 duration_in_ms=597.838
2018-04-17 21:47:56,697 [salt.state       ][INFO    ][2165] Running state [cs_CZ.UTF-8] at time 21:47:56.697874
2018-04-17 21:47:56,699 [salt.state       ][INFO    ][2165] Executing state locale.present for cs_CZ.UTF-8
2018-04-17 21:47:56,700 [salt.loaded.int.module.cmdmod][INFO    ][2165] Executing command 'locale -a' in directory '/root'
2018-04-17 21:47:56,741 [salt.loaded.int.module.cmdmod][INFO    ][2165] Executing command ['locale-gen', 'cs_CZ.utf8'] in directory '/root'
2018-04-17 21:47:57,702 [salt.state       ][INFO    ][2165] {'locale': 'cs_CZ.UTF-8'}
2018-04-17 21:47:57,703 [salt.state       ][INFO    ][2165] Completed state [cs_CZ.UTF-8] at time 21:47:57.703265 duration_in_ms=1005.392
2018-04-17 21:47:57,703 [salt.state       ][INFO    ][2165] Running state [en_US.UTF-8] at time 21:47:57.703798
2018-04-17 21:47:57,704 [salt.state       ][INFO    ][2165] Executing state locale.present for en_US.UTF-8
2018-04-17 21:47:57,705 [salt.loaded.int.module.cmdmod][INFO    ][2165] Executing command 'locale -a' in directory '/root'
2018-04-17 21:47:57,723 [salt.state       ][INFO    ][2165] Locale en_US.UTF-8 is already present
2018-04-17 21:47:57,724 [salt.state       ][INFO    ][2165] Completed state [en_US.UTF-8] at time 21:47:57.724363 duration_in_ms=20.565
2018-04-17 21:47:57,725 [salt.state       ][INFO    ][2165] Running state [en_US.UTF-8] at time 21:47:57.725915
2018-04-17 21:47:57,726 [salt.state       ][INFO    ][2165] Executing state locale.system for en_US.UTF-8
2018-04-17 21:47:57,727 [salt.loaded.int.module.cmdmod][INFO    ][2165] Executing command 'localectl' in directory '/root'
2018-04-17 21:47:58,145 [salt.state       ][INFO    ][2165] System locale en_US.UTF-8 already set
2018-04-17 21:47:58,146 [salt.state       ][INFO    ][2165] Completed state [en_US.UTF-8] at time 21:47:58.146320 duration_in_ms=420.402
2018-04-17 21:47:58,276 [salt.state       ][INFO    ][2165] Running state [root] at time 21:47:58.276859
2018-04-17 21:47:58,278 [salt.state       ][INFO    ][2165] Executing state user.present for root
2018-04-17 21:47:58,285 [salt.state       ][INFO    ][2165] User root is present and up to date
2018-04-17 21:47:58,286 [salt.state       ][INFO    ][2165] Completed state [root] at time 21:47:58.286053 duration_in_ms=9.194
2018-04-17 21:47:58,289 [salt.state       ][INFO    ][2165] Running state [/root] at time 21:47:58.289100
2018-04-17 21:47:58,290 [salt.state       ][INFO    ][2165] Executing state file.directory for /root
2018-04-17 21:47:58,292 [salt.state       ][INFO    ][2165] Directory /root is in the correct state
2018-04-17 21:47:58,292 [salt.state       ][INFO    ][2165] Completed state [/root] at time 21:47:58.292879 duration_in_ms=3.78
2018-04-17 21:47:58,293 [salt.state       ][INFO    ][2165] Running state [/etc/sudoers.d/90-salt-user-root] at time 21:47:58.293835
2018-04-17 21:47:58,294 [salt.state       ][INFO    ][2165] Executing state file.absent for /etc/sudoers.d/90-salt-user-root
2018-04-17 21:47:58,295 [salt.state       ][INFO    ][2165] File /etc/sudoers.d/90-salt-user-root is not present
2018-04-17 21:47:58,296 [salt.state       ][INFO    ][2165] Completed state [/etc/sudoers.d/90-salt-user-root] at time 21:47:58.296633 duration_in_ms=2.798
2018-04-17 21:47:58,297 [salt.state       ][INFO    ][2165] Running state [ubuntu] at time 21:47:58.297543
2018-04-17 21:47:58,298 [salt.state       ][INFO    ][2165] Executing state user.present for ubuntu
2018-04-17 21:47:58,304 [salt.state       ][INFO    ][2165] {'passwd': 'XXX-REDACTED-XXX'}
2018-04-17 21:47:58,305 [salt.state       ][INFO    ][2165] Completed state [ubuntu] at time 21:47:58.305428 duration_in_ms=7.884
2018-04-17 21:47:58,307 [salt.state       ][INFO    ][2165] Running state [/home/ubuntu] at time 21:47:58.307491
2018-04-17 21:47:58,308 [salt.state       ][INFO    ][2165] Executing state file.directory for /home/ubuntu
2018-04-17 21:47:58,310 [salt.state       ][INFO    ][2165] {'mode': '0700'}
2018-04-17 21:47:58,311 [salt.state       ][INFO    ][2165] Completed state [/home/ubuntu] at time 21:47:58.311327 duration_in_ms=3.837
2018-04-17 21:47:58,313 [salt.state       ][INFO    ][2165] Running state [/etc/sudoers.d/90-salt-user-ubuntu] at time 21:47:58.313018
2018-04-17 21:47:58,313 [salt.state       ][INFO    ][2165] Executing state file.managed for /etc/sudoers.d/90-salt-user-ubuntu
2018-04-17 21:47:58,344 [salt.fileclient  ][INFO    ][2165] Fetching file from saltenv 'base', ** done ** 'linux/files/sudoer'
2018-04-17 21:47:58,352 [salt.loaded.int.module.cmdmod][INFO    ][2165] Executing command '/usr/sbin/visudo -c -f /tmp/tmpRhOIKW' in directory '/root'
2018-04-17 21:47:58,474 [salt.state       ][INFO    ][2165] File changed:
New file
2018-04-17 21:47:58,475 [salt.state       ][INFO    ][2165] Completed state [/etc/sudoers.d/90-salt-user-ubuntu] at time 21:47:58.475669 duration_in_ms=162.651
2018-04-17 21:47:58,476 [salt.state       ][INFO    ][2165] Running state [/etc/security/limits.d/90-salt-default.conf] at time 21:47:58.476829
2018-04-17 21:47:58,478 [salt.state       ][INFO    ][2165] Executing state file.managed for /etc/security/limits.d/90-salt-default.conf
2018-04-17 21:47:58,541 [salt.fileclient  ][INFO    ][2165] Fetching file from saltenv 'base', ** done ** 'linux/files/limits.conf'
2018-04-17 21:47:58,645 [salt.state       ][INFO    ][2165] File changed:
New file
2018-04-17 21:47:58,647 [salt.state       ][INFO    ][2165] Completed state [/etc/security/limits.d/90-salt-default.conf] at time 21:47:58.646958 duration_in_ms=170.129
2018-04-17 21:47:58,647 [salt.state       ][INFO    ][2165] Running state [/etc/systemd/system.conf.d/90-salt.conf] at time 21:47:58.647594
2018-04-17 21:47:58,648 [salt.state       ][INFO    ][2165] Executing state file.managed for /etc/systemd/system.conf.d/90-salt.conf
2018-04-17 21:47:58,672 [salt.fileclient  ][INFO    ][2165] Fetching file from saltenv 'base', ** done ** 'linux/files/systemd.conf'
2018-04-17 21:47:58,743 [salt.state       ][INFO    ][2165] File changed:
New file
2018-04-17 21:47:58,744 [salt.state       ][INFO    ][2165] Completed state [/etc/systemd/system.conf.d/90-salt.conf] at time 21:47:58.744193 duration_in_ms=96.599
2018-04-17 21:47:58,746 [salt.state       ][INFO    ][2165] Running state [service.systemctl_reload] at time 21:47:58.746146
2018-04-17 21:47:58,746 [salt.state       ][INFO    ][2165] Executing state module.wait for service.systemctl_reload
2018-04-17 21:47:58,747 [salt.state       ][INFO    ][2165] No changes made for service.systemctl_reload
2018-04-17 21:47:58,747 [salt.state       ][INFO    ][2165] Completed state [service.systemctl_reload] at time 21:47:58.747702 duration_in_ms=1.556
2018-04-17 21:47:58,748 [salt.state       ][INFO    ][2165] Running state [service.systemctl_reload] at time 21:47:58.748147
2018-04-17 21:47:58,748 [salt.state       ][INFO    ][2165] Executing state module.mod_watch for service.systemctl_reload
2018-04-17 21:47:58,749 [salt.loaded.int.module.cmdmod][INFO    ][2165] Executing command ['systemctl', '--system', 'daemon-reload'] in directory '/root'
2018-04-17 21:47:58,850 [salt.state       ][INFO    ][2165] {'ret': True}
2018-04-17 21:47:58,851 [salt.state       ][INFO    ][2165] Completed state [service.systemctl_reload] at time 21:47:58.851393 duration_in_ms=103.245
2018-04-17 21:47:58,852 [salt.state       ][INFO    ][2165] Running state [/etc/hostname] at time 21:47:58.852068
2018-04-17 21:47:58,852 [salt.state       ][INFO    ][2165] Executing state file.managed for /etc/hostname
2018-04-17 21:47:58,875 [salt.fileclient  ][INFO    ][2165] Fetching file from saltenv 'base', ** done ** 'linux/files/hostname'
2018-04-17 21:47:58,879 [salt.state       ][INFO    ][2165] File changed:
--- 
+++ 
@@ -1 +1 @@
-ubuntu
+msg01

2018-04-17 21:47:58,881 [salt.state       ][INFO    ][2165] Completed state [/etc/hostname] at time 21:47:58.880820 duration_in_ms=28.751
2018-04-17 21:47:58,884 [salt.state       ][INFO    ][2165] Running state [hostname msg01] at time 21:47:58.884713
2018-04-17 21:47:58,885 [salt.state       ][INFO    ][2165] Executing state cmd.wait for hostname msg01
2018-04-17 21:47:58,885 [salt.state       ][INFO    ][2165] No changes made for hostname msg01
2018-04-17 21:47:58,886 [salt.state       ][INFO    ][2165] Completed state [hostname msg01] at time 21:47:58.886071 duration_in_ms=1.358
2018-04-17 21:47:58,886 [salt.state       ][INFO    ][2165] Running state [hostname msg01] at time 21:47:58.886407
2018-04-17 21:47:58,886 [salt.state       ][INFO    ][2165] Executing state cmd.mod_watch for hostname msg01
2018-04-17 21:47:58,888 [salt.loaded.int.module.cmdmod][INFO    ][2165] Executing command 'hostname msg01' in directory '/root'
2018-04-17 21:47:58,907 [salt.state       ][INFO    ][2165] {'pid': 5258, 'retcode': 0, 'stderr': '', 'stdout': ''}
2018-04-17 21:47:58,908 [salt.state       ][INFO    ][2165] Completed state [hostname msg01] at time 21:47:58.908015 duration_in_ms=21.607
2018-04-17 21:47:58,940 [salt.state       ][INFO    ][2165] Running state [mdb02] at time 21:47:58.939980
2018-04-17 21:47:58,940 [salt.state       ][INFO    ][2165] Executing state host.present for mdb02
2018-04-17 21:47:58,946 [salt.state       ][INFO    ][2165] {'host': 'mdb02'}
2018-04-17 21:47:58,946 [salt.state       ][INFO    ][2165] Completed state [mdb02] at time 21:47:58.946426 duration_in_ms=6.447
2018-04-17 21:47:58,946 [salt.state       ][INFO    ][2165] Running state [mdb02.mcp-pike-ovs-ha.local] at time 21:47:58.946924
2018-04-17 21:47:58,947 [salt.state       ][INFO    ][2165] Executing state host.present for mdb02.mcp-pike-ovs-ha.local
2018-04-17 21:47:59,073 [salt.state       ][INFO    ][2165] {'host': 'mdb02.mcp-pike-ovs-ha.local'}
2018-04-17 21:47:59,073 [salt.state       ][INFO    ][2165] Completed state [mdb02.mcp-pike-ovs-ha.local] at time 21:47:59.073462 duration_in_ms=126.539
2018-04-17 21:47:59,073 [salt.state       ][INFO    ][2165] Running state [mdb03] at time 21:47:59.073726
2018-04-17 21:47:59,073 [salt.state       ][INFO    ][2165] Executing state host.present for mdb03
2018-04-17 21:47:59,169 [salt.state       ][INFO    ][2165] {'host': 'mdb03'}
2018-04-17 21:47:59,169 [salt.state       ][INFO    ][2165] Completed state [mdb03] at time 21:47:59.169504 duration_in_ms=95.777
2018-04-17 21:47:59,170 [salt.state       ][INFO    ][2165] Running state [mdb03.mcp-pike-ovs-ha.local] at time 21:47:59.169942
2018-04-17 21:47:59,170 [salt.state       ][INFO    ][2165] Executing state host.present for mdb03.mcp-pike-ovs-ha.local
2018-04-17 21:47:59,174 [salt.state       ][INFO    ][2165] {'host': 'mdb03.mcp-pike-ovs-ha.local'}
2018-04-17 21:47:59,175 [salt.state       ][INFO    ][2165] Completed state [mdb03.mcp-pike-ovs-ha.local] at time 21:47:59.174971 duration_in_ms=5.029
2018-04-17 21:47:59,175 [salt.state       ][INFO    ][2165] Running state [mdb01] at time 21:47:59.175364
2018-04-17 21:47:59,175 [salt.state       ][INFO    ][2165] Executing state host.present for mdb01
2018-04-17 21:47:59,180 [salt.state       ][INFO    ][2165] {'host': 'mdb01'}
2018-04-17 21:47:59,180 [salt.state       ][INFO    ][2165] Completed state [mdb01] at time 21:47:59.180776 duration_in_ms=5.412
2018-04-17 21:47:59,181 [salt.state       ][INFO    ][2165] Running state [mdb01.mcp-pike-ovs-ha.local] at time 21:47:59.181013
2018-04-17 21:47:59,181 [salt.state       ][INFO    ][2165] Executing state host.present for mdb01.mcp-pike-ovs-ha.local
2018-04-17 21:47:59,186 [salt.state       ][INFO    ][2165] {'host': 'mdb01.mcp-pike-ovs-ha.local'}
2018-04-17 21:47:59,186 [salt.state       ][INFO    ][2165] Completed state [mdb01.mcp-pike-ovs-ha.local] at time 21:47:59.186902 duration_in_ms=5.889
2018-04-17 21:47:59,187 [salt.state       ][INFO    ][2165] Running state [mdb] at time 21:47:59.187181
2018-04-17 21:47:59,187 [salt.state       ][INFO    ][2165] Executing state host.present for mdb
2018-04-17 21:47:59,192 [salt.state       ][INFO    ][2165] {'host': 'mdb'}
2018-04-17 21:47:59,192 [salt.state       ][INFO    ][2165] Completed state [mdb] at time 21:47:59.192774 duration_in_ms=5.593
2018-04-17 21:47:59,193 [salt.state       ][INFO    ][2165] Running state [mdb.mcp-pike-ovs-ha.local] at time 21:47:59.193016
2018-04-17 21:47:59,193 [salt.state       ][INFO    ][2165] Executing state host.present for mdb.mcp-pike-ovs-ha.local
2018-04-17 21:47:59,198 [salt.state       ][INFO    ][2165] {'host': 'mdb.mcp-pike-ovs-ha.local'}
2018-04-17 21:47:59,198 [salt.state       ][INFO    ][2165] Completed state [mdb.mcp-pike-ovs-ha.local] at time 21:47:59.198839 duration_in_ms=5.823
2018-04-17 21:47:59,199 [salt.state       ][INFO    ][2165] Running state [cfg01] at time 21:47:59.199072
2018-04-17 21:47:59,199 [salt.state       ][INFO    ][2165] Executing state host.present for cfg01
2018-04-17 21:47:59,216 [salt.state       ][INFO    ][2165] {'host': 'cfg01'}
2018-04-17 21:47:59,216 [salt.state       ][INFO    ][2165] Completed state [cfg01] at time 21:47:59.216295 duration_in_ms=17.223
2018-04-17 21:47:59,216 [salt.state       ][INFO    ][2165] Running state [cfg01.mcp-pike-ovs-ha.local] at time 21:47:59.216569
2018-04-17 21:47:59,216 [salt.state       ][INFO    ][2165] Executing state host.present for cfg01.mcp-pike-ovs-ha.local
2018-04-17 21:47:59,220 [salt.state       ][INFO    ][2165] {'host': 'cfg01.mcp-pike-ovs-ha.local'}
2018-04-17 21:47:59,220 [salt.state       ][INFO    ][2165] Completed state [cfg01.mcp-pike-ovs-ha.local] at time 21:47:59.220951 duration_in_ms=4.382
2018-04-17 21:47:59,221 [salt.state       ][INFO    ][2165] Running state [prx01] at time 21:47:59.221165
2018-04-17 21:47:59,221 [salt.state       ][INFO    ][2165] Executing state host.present for prx01
2018-04-17 21:47:59,226 [salt.state       ][INFO    ][2165] {'host': 'prx01'}
2018-04-17 21:47:59,227 [salt.state       ][INFO    ][2165] Completed state [prx01] at time 21:47:59.226976 duration_in_ms=5.81
2018-04-17 21:47:59,227 [salt.state       ][INFO    ][2165] Running state [prx01.mcp-pike-ovs-ha.local] at time 21:47:59.227180
2018-04-17 21:47:59,227 [salt.state       ][INFO    ][2165] Executing state host.present for prx01.mcp-pike-ovs-ha.local
2018-04-17 21:47:59,232 [salt.state       ][INFO    ][2165] {'host': 'prx01.mcp-pike-ovs-ha.local'}
2018-04-17 21:47:59,233 [salt.state       ][INFO    ][2165] Completed state [prx01.mcp-pike-ovs-ha.local] at time 21:47:59.232974 duration_in_ms=5.793
2018-04-17 21:47:59,233 [salt.state       ][INFO    ][2165] Running state [kvm01] at time 21:47:59.233200
2018-04-17 21:47:59,233 [salt.state       ][INFO    ][2165] Executing state host.present for kvm01
2018-04-17 21:47:59,238 [salt.state       ][INFO    ][2165] {'host': 'kvm01'}
2018-04-17 21:47:59,239 [salt.state       ][INFO    ][2165] Completed state [kvm01] at time 21:47:59.238976 duration_in_ms=5.776
2018-04-17 21:47:59,239 [salt.state       ][INFO    ][2165] Running state [kvm01.mcp-pike-ovs-ha.local] at time 21:47:59.239182
2018-04-17 21:47:59,239 [salt.state       ][INFO    ][2165] Executing state host.present for kvm01.mcp-pike-ovs-ha.local
2018-04-17 21:47:59,244 [salt.state       ][INFO    ][2165] {'host': 'kvm01.mcp-pike-ovs-ha.local'}
2018-04-17 21:47:59,245 [salt.state       ][INFO    ][2165] Completed state [kvm01.mcp-pike-ovs-ha.local] at time 21:47:59.244978 duration_in_ms=5.795
2018-04-17 21:47:59,245 [salt.state       ][INFO    ][2165] Running state [kvm03] at time 21:47:59.245182
2018-04-17 21:47:59,245 [salt.state       ][INFO    ][2165] Executing state host.present for kvm03
2018-04-17 21:47:59,365 [salt.state       ][INFO    ][2165] {'host': 'kvm03'}
2018-04-17 21:47:59,365 [salt.state       ][INFO    ][2165] Completed state [kvm03] at time 21:47:59.365473 duration_in_ms=120.29
2018-04-17 21:47:59,365 [salt.state       ][INFO    ][2165] Running state [kvm03.mcp-pike-ovs-ha.local] at time 21:47:59.365805
2018-04-17 21:47:59,366 [salt.state       ][INFO    ][2165] Executing state host.present for kvm03.mcp-pike-ovs-ha.local
2018-04-17 21:47:59,370 [salt.state       ][INFO    ][2165] {'host': 'kvm03.mcp-pike-ovs-ha.local'}
2018-04-17 21:47:59,370 [salt.state       ][INFO    ][2165] Completed state [kvm03.mcp-pike-ovs-ha.local] at time 21:47:59.370839 duration_in_ms=5.034
2018-04-17 21:47:59,371 [salt.state       ][INFO    ][2165] Running state [kvm02] at time 21:47:59.371115
2018-04-17 21:47:59,371 [salt.state       ][INFO    ][2165] Executing state host.present for kvm02
2018-04-17 21:47:59,376 [salt.state       ][INFO    ][2165] {'host': 'kvm02'}
2018-04-17 21:47:59,376 [salt.state       ][INFO    ][2165] Completed state [kvm02] at time 21:47:59.376810 duration_in_ms=5.695
2018-04-17 21:47:59,377 [salt.state       ][INFO    ][2165] Running state [kvm02.mcp-pike-ovs-ha.local] at time 21:47:59.377070
2018-04-17 21:47:59,377 [salt.state       ][INFO    ][2165] Executing state host.present for kvm02.mcp-pike-ovs-ha.local
2018-04-17 21:47:59,382 [salt.state       ][INFO    ][2165] {'host': 'kvm02.mcp-pike-ovs-ha.local'}
2018-04-17 21:47:59,382 [salt.state       ][INFO    ][2165] Completed state [kvm02.mcp-pike-ovs-ha.local] at time 21:47:59.382849 duration_in_ms=5.779
2018-04-17 21:47:59,383 [salt.state       ][INFO    ][2165] Running state [dbs] at time 21:47:59.383113
2018-04-17 21:47:59,383 [salt.state       ][INFO    ][2165] Executing state host.present for dbs
2018-04-17 21:47:59,388 [salt.state       ][INFO    ][2165] {'host': 'dbs'}
2018-04-17 21:47:59,388 [salt.state       ][INFO    ][2165] Completed state [dbs] at time 21:47:59.388780 duration_in_ms=5.667
2018-04-17 21:47:59,389 [salt.state       ][INFO    ][2165] Running state [dbs.mcp-pike-ovs-ha.local] at time 21:47:59.389033
2018-04-17 21:47:59,389 [salt.state       ][INFO    ][2165] Executing state host.present for dbs.mcp-pike-ovs-ha.local
2018-04-17 21:47:59,394 [salt.state       ][INFO    ][2165] {'host': 'dbs.mcp-pike-ovs-ha.local'}
2018-04-17 21:47:59,394 [salt.state       ][INFO    ][2165] Completed state [dbs.mcp-pike-ovs-ha.local] at time 21:47:59.394878 duration_in_ms=5.845
2018-04-17 21:47:59,395 [salt.state       ][INFO    ][2165] Running state [prx] at time 21:47:59.395139
2018-04-17 21:47:59,395 [salt.state       ][INFO    ][2165] Executing state host.present for prx
2018-04-17 21:47:59,400 [salt.state       ][INFO    ][2165] {'host': 'prx'}
2018-04-17 21:47:59,400 [salt.state       ][INFO    ][2165] Completed state [prx] at time 21:47:59.400883 duration_in_ms=5.744
2018-04-17 21:47:59,401 [salt.state       ][INFO    ][2165] Running state [prx.mcp-pike-ovs-ha.local] at time 21:47:59.401138
2018-04-17 21:47:59,401 [salt.state       ][INFO    ][2165] Executing state host.present for prx.mcp-pike-ovs-ha.local
2018-04-17 21:47:59,406 [salt.state       ][INFO    ][2165] {'host': 'prx.mcp-pike-ovs-ha.local'}
2018-04-17 21:47:59,406 [salt.state       ][INFO    ][2165] Completed state [prx.mcp-pike-ovs-ha.local] at time 21:47:59.406899 duration_in_ms=5.761
2018-04-17 21:47:59,407 [salt.state       ][INFO    ][2165] Running state [prx02] at time 21:47:59.407147
2018-04-17 21:47:59,407 [salt.state       ][INFO    ][2165] Executing state host.present for prx02
2018-04-17 21:47:59,412 [salt.state       ][INFO    ][2165] {'host': 'prx02'}
2018-04-17 21:47:59,412 [salt.state       ][INFO    ][2165] Completed state [prx02] at time 21:47:59.412895 duration_in_ms=5.748
2018-04-17 21:47:59,413 [salt.state       ][INFO    ][2165] Running state [prx02.mcp-pike-ovs-ha.local] at time 21:47:59.413146
2018-04-17 21:47:59,413 [salt.state       ][INFO    ][2165] Executing state host.present for prx02.mcp-pike-ovs-ha.local
2018-04-17 21:47:59,418 [salt.state       ][INFO    ][2165] {'host': 'prx02.mcp-pike-ovs-ha.local'}
2018-04-17 21:47:59,418 [salt.state       ][INFO    ][2165] Completed state [prx02.mcp-pike-ovs-ha.local] at time 21:47:59.418924 duration_in_ms=5.778
2018-04-17 21:47:59,419 [salt.state       ][INFO    ][2165] Running state [msg02] at time 21:47:59.419160
2018-04-17 21:47:59,419 [salt.state       ][INFO    ][2165] Executing state host.present for msg02
2018-04-17 21:47:59,443 [salt.state       ][INFO    ][2165] {'host': 'msg02'}
2018-04-17 21:47:59,444 [salt.state       ][INFO    ][2165] Completed state [msg02] at time 21:47:59.444155 duration_in_ms=24.994
2018-04-17 21:47:59,444 [salt.state       ][INFO    ][2165] Running state [msg02.mcp-pike-ovs-ha.local] at time 21:47:59.444446
2018-04-17 21:47:59,444 [salt.state       ][INFO    ][2165] Executing state host.present for msg02.mcp-pike-ovs-ha.local
2018-04-17 21:47:59,546 [salt.state       ][INFO    ][2165] {'host': 'msg02.mcp-pike-ovs-ha.local'}
2018-04-17 21:47:59,546 [salt.state       ][INFO    ][2165] Completed state [msg02.mcp-pike-ovs-ha.local] at time 21:47:59.546460 duration_in_ms=102.013
2018-04-17 21:47:59,546 [salt.state       ][INFO    ][2165] Running state [msg03] at time 21:47:59.546761
2018-04-17 21:47:59,547 [salt.state       ][INFO    ][2165] Executing state host.present for msg03
2018-04-17 21:47:59,552 [salt.state       ][INFO    ][2165] {'host': 'msg03'}
2018-04-17 21:47:59,552 [salt.state       ][INFO    ][2165] Completed state [msg03] at time 21:47:59.552805 duration_in_ms=6.043
2018-04-17 21:47:59,553 [salt.state       ][INFO    ][2165] Running state [msg03.mcp-pike-ovs-ha.local] at time 21:47:59.553394
2018-04-17 21:47:59,553 [salt.state       ][INFO    ][2165] Executing state host.present for msg03.mcp-pike-ovs-ha.local
2018-04-17 21:47:59,558 [salt.state       ][INFO    ][2165] {'host': 'msg03.mcp-pike-ovs-ha.local'}
2018-04-17 21:47:59,558 [salt.state       ][INFO    ][2165] Completed state [msg03.mcp-pike-ovs-ha.local] at time 21:47:59.558439 duration_in_ms=5.045
2018-04-17 21:47:59,559 [salt.state       ][INFO    ][2165] Running state [msg01] at time 21:47:59.558958
2018-04-17 21:47:59,559 [salt.state       ][INFO    ][2165] Executing state host.present for msg01
2018-04-17 21:47:59,564 [salt.state       ][INFO    ][2165] {'host': 'msg01'}
2018-04-17 21:47:59,564 [salt.state       ][INFO    ][2165] Completed state [msg01] at time 21:47:59.564456 duration_in_ms=5.497
2018-04-17 21:47:59,565 [salt.state       ][INFO    ][2165] Running state [msg01.mcp-pike-ovs-ha.local] at time 21:47:59.565059
2018-04-17 21:47:59,565 [salt.state       ][INFO    ][2165] Executing state host.present for msg01.mcp-pike-ovs-ha.local
2018-04-17 21:47:59,569 [salt.state       ][INFO    ][2165] {'host': 'msg01.mcp-pike-ovs-ha.local'}
2018-04-17 21:47:59,570 [salt.state       ][INFO    ][2165] Completed state [msg01.mcp-pike-ovs-ha.local] at time 21:47:59.570370 duration_in_ms=5.311
2018-04-17 21:47:59,570 [salt.state       ][INFO    ][2165] Running state [msg] at time 21:47:59.570878
2018-04-17 21:47:59,571 [salt.state       ][INFO    ][2165] Executing state host.present for msg
2018-04-17 21:47:59,576 [salt.state       ][INFO    ][2165] {'host': 'msg'}
2018-04-17 21:47:59,576 [salt.state       ][INFO    ][2165] Completed state [msg] at time 21:47:59.576449 duration_in_ms=5.571
2018-04-17 21:47:59,577 [salt.state       ][INFO    ][2165] Running state [msg.mcp-pike-ovs-ha.local] at time 21:47:59.576946
2018-04-17 21:47:59,577 [salt.state       ][INFO    ][2165] Executing state host.present for msg.mcp-pike-ovs-ha.local
2018-04-17 21:47:59,582 [salt.state       ][INFO    ][2165] {'host': 'msg.mcp-pike-ovs-ha.local'}
2018-04-17 21:47:59,582 [salt.state       ][INFO    ][2165] Completed state [msg.mcp-pike-ovs-ha.local] at time 21:47:59.582371 duration_in_ms=5.425
2018-04-17 21:47:59,582 [salt.state       ][INFO    ][2165] Running state [cfg01] at time 21:47:59.582849
2018-04-17 21:47:59,583 [salt.state       ][INFO    ][2165] Executing state host.present for cfg01
2018-04-17 21:47:59,584 [salt.state       ][INFO    ][2165] Host cfg01 (10.167.4.11) already present
2018-04-17 21:47:59,584 [salt.state       ][INFO    ][2165] Completed state [cfg01] at time 21:47:59.584547 duration_in_ms=1.698
2018-04-17 21:47:59,585 [salt.state       ][INFO    ][2165] Running state [cfg01.mcp-pike-ovs-ha.local] at time 21:47:59.585022
2018-04-17 21:47:59,585 [salt.state       ][INFO    ][2165] Executing state host.present for cfg01.mcp-pike-ovs-ha.local
2018-04-17 21:47:59,586 [salt.state       ][INFO    ][2165] Host cfg01.mcp-pike-ovs-ha.local (10.167.4.11) already present
2018-04-17 21:47:59,586 [salt.state       ][INFO    ][2165] Completed state [cfg01.mcp-pike-ovs-ha.local] at time 21:47:59.586708 duration_in_ms=1.686
2018-04-17 21:47:59,587 [salt.state       ][INFO    ][2165] Running state [cmp002] at time 21:47:59.587149
2018-04-17 21:47:59,587 [salt.state       ][INFO    ][2165] Executing state host.present for cmp002
2018-04-17 21:47:59,589 [salt.state       ][INFO    ][2165] {'host': 'cmp002'}
2018-04-17 21:47:59,589 [salt.state       ][INFO    ][2165] Completed state [cmp002] at time 21:47:59.589893 duration_in_ms=2.744
2018-04-17 21:47:59,590 [salt.state       ][INFO    ][2165] Running state [cmp002.mcp-pike-ovs-ha.local] at time 21:47:59.590328
2018-04-17 21:47:59,590 [salt.state       ][INFO    ][2165] Executing state host.present for cmp002.mcp-pike-ovs-ha.local
2018-04-17 21:47:59,593 [salt.state       ][INFO    ][2165] {'host': 'cmp002.mcp-pike-ovs-ha.local'}
2018-04-17 21:47:59,594 [salt.state       ][INFO    ][2165] Completed state [cmp002.mcp-pike-ovs-ha.local] at time 21:47:59.594314 duration_in_ms=3.986
2018-04-17 21:47:59,594 [salt.state       ][INFO    ][2165] Running state [cmp001] at time 21:47:59.594752
2018-04-17 21:47:59,595 [salt.state       ][INFO    ][2165] Executing state host.present for cmp001
2018-04-17 21:47:59,599 [salt.state       ][INFO    ][2165] {'host': 'cmp001'}
2018-04-17 21:47:59,600 [salt.state       ][INFO    ][2165] Completed state [cmp001] at time 21:47:59.600379 duration_in_ms=5.627
2018-04-17 21:47:59,600 [salt.state       ][INFO    ][2165] Running state [cmp001.mcp-pike-ovs-ha.local] at time 21:47:59.600818
2018-04-17 21:47:59,601 [salt.state       ][INFO    ][2165] Executing state host.present for cmp001.mcp-pike-ovs-ha.local
2018-04-17 21:47:59,606 [salt.state       ][INFO    ][2165] {'host': 'cmp001.mcp-pike-ovs-ha.local'}
2018-04-17 21:47:59,606 [salt.state       ][INFO    ][2165] Completed state [cmp001.mcp-pike-ovs-ha.local] at time 21:47:59.606326 duration_in_ms=5.508
2018-04-17 21:47:59,606 [salt.state       ][INFO    ][2165] Running state [dbs01] at time 21:47:59.606737
2018-04-17 21:47:59,607 [salt.state       ][INFO    ][2165] Executing state host.present for dbs01
2018-04-17 21:47:59,611 [salt.state       ][INFO    ][2165] {'host': 'dbs01'}
2018-04-17 21:47:59,612 [salt.state       ][INFO    ][2165] Completed state [dbs01] at time 21:47:59.612287 duration_in_ms=5.55
2018-04-17 21:47:59,612 [salt.state       ][INFO    ][2165] Running state [dbs01.mcp-pike-ovs-ha.local] at time 21:47:59.612736
2018-04-17 21:47:59,613 [salt.state       ][INFO    ][2165] Executing state host.present for dbs01.mcp-pike-ovs-ha.local
2018-04-17 21:47:59,618 [salt.state       ][INFO    ][2165] {'host': 'dbs01.mcp-pike-ovs-ha.local'}
2018-04-17 21:47:59,618 [salt.state       ][INFO    ][2165] Completed state [dbs01.mcp-pike-ovs-ha.local] at time 21:47:59.618370 duration_in_ms=5.634
2018-04-17 21:47:59,618 [salt.state       ][INFO    ][2165] Running state [dbs02] at time 21:47:59.618790
2018-04-17 21:47:59,619 [salt.state       ][INFO    ][2165] Executing state host.present for dbs02
2018-04-17 21:47:59,623 [salt.state       ][INFO    ][2165] {'host': 'dbs02'}
2018-04-17 21:47:59,624 [salt.state       ][INFO    ][2165] Completed state [dbs02] at time 21:47:59.624288 duration_in_ms=5.498
2018-04-17 21:47:59,624 [salt.state       ][INFO    ][2165] Running state [dbs02.mcp-pike-ovs-ha.local] at time 21:47:59.624719
2018-04-17 21:47:59,625 [salt.state       ][INFO    ][2165] Executing state host.present for dbs02.mcp-pike-ovs-ha.local
2018-04-17 21:47:59,630 [salt.state       ][INFO    ][2165] {'host': 'dbs02.mcp-pike-ovs-ha.local'}
2018-04-17 21:47:59,630 [salt.state       ][INFO    ][2165] Completed state [dbs02.mcp-pike-ovs-ha.local] at time 21:47:59.630327 duration_in_ms=5.608
2018-04-17 21:47:59,630 [salt.state       ][INFO    ][2165] Running state [dbs03] at time 21:47:59.630721
2018-04-17 21:47:59,631 [salt.state       ][INFO    ][2165] Executing state host.present for dbs03
2018-04-17 21:47:59,659 [salt.state       ][INFO    ][2165] {'host': 'dbs03'}
2018-04-17 21:47:59,659 [salt.state       ][INFO    ][2165] Completed state [dbs03] at time 21:47:59.659591 duration_in_ms=28.869
2018-04-17 21:47:59,660 [salt.state       ][INFO    ][2165] Running state [dbs03.mcp-pike-ovs-ha.local] at time 21:47:59.660037
2018-04-17 21:47:59,660 [salt.state       ][INFO    ][2165] Executing state host.present for dbs03.mcp-pike-ovs-ha.local
2018-04-17 21:47:59,664 [salt.state       ][INFO    ][2165] {'host': 'dbs03.mcp-pike-ovs-ha.local'}
2018-04-17 21:47:59,665 [salt.state       ][INFO    ][2165] Completed state [dbs03.mcp-pike-ovs-ha.local] at time 21:47:59.664931 duration_in_ms=4.894
2018-04-17 21:47:59,665 [salt.state       ][INFO    ][2165] Running state [mas01] at time 21:47:59.665313
2018-04-17 21:47:59,665 [salt.state       ][INFO    ][2165] Executing state host.present for mas01
2018-04-17 21:47:59,670 [salt.state       ][INFO    ][2165] {'host': 'mas01'}
2018-04-17 21:47:59,671 [salt.state       ][INFO    ][2165] Completed state [mas01] at time 21:47:59.670962 duration_in_ms=5.648
2018-04-17 21:47:59,671 [salt.state       ][INFO    ][2165] Running state [mas01.mcp-pike-ovs-ha.local] at time 21:47:59.671356
2018-04-17 21:47:59,671 [salt.state       ][INFO    ][2165] Executing state host.present for mas01.mcp-pike-ovs-ha.local
2018-04-17 21:47:59,676 [salt.state       ][INFO    ][2165] {'host': 'mas01.mcp-pike-ovs-ha.local'}
2018-04-17 21:47:59,676 [salt.state       ][INFO    ][2165] Completed state [mas01.mcp-pike-ovs-ha.local] at time 21:47:59.676901 duration_in_ms=5.545
2018-04-17 21:47:59,677 [salt.state       ][INFO    ][2165] Running state [ctl02] at time 21:47:59.677276
2018-04-17 21:47:59,677 [salt.state       ][INFO    ][2165] Executing state host.present for ctl02
2018-04-17 21:47:59,682 [salt.state       ][INFO    ][2165] {'host': 'ctl02'}
2018-04-17 21:47:59,683 [salt.state       ][INFO    ][2165] Completed state [ctl02] at time 21:47:59.682931 duration_in_ms=5.656
2018-04-17 21:47:59,683 [salt.state       ][INFO    ][2165] Running state [ctl02.mcp-pike-ovs-ha.local] at time 21:47:59.683298
2018-04-17 21:47:59,683 [salt.state       ][INFO    ][2165] Executing state host.present for ctl02.mcp-pike-ovs-ha.local
2018-04-17 21:47:59,688 [salt.state       ][INFO    ][2165] {'host': 'ctl02.mcp-pike-ovs-ha.local'}
2018-04-17 21:47:59,688 [salt.state       ][INFO    ][2165] Completed state [ctl02.mcp-pike-ovs-ha.local] at time 21:47:59.688903 duration_in_ms=5.605
2018-04-17 21:47:59,689 [salt.state       ][INFO    ][2165] Running state [ctl03] at time 21:47:59.689250
2018-04-17 21:47:59,689 [salt.state       ][INFO    ][2165] Executing state host.present for ctl03
2018-04-17 21:47:59,694 [salt.state       ][INFO    ][2165] {'host': 'ctl03'}
2018-04-17 21:47:59,694 [salt.state       ][INFO    ][2165] Completed state [ctl03] at time 21:47:59.694903 duration_in_ms=5.653
2018-04-17 21:47:59,695 [salt.state       ][INFO    ][2165] Running state [ctl03.mcp-pike-ovs-ha.local] at time 21:47:59.695247
2018-04-17 21:47:59,695 [salt.state       ][INFO    ][2165] Executing state host.present for ctl03.mcp-pike-ovs-ha.local
2018-04-17 21:47:59,700 [salt.state       ][INFO    ][2165] {'host': 'ctl03.mcp-pike-ovs-ha.local'}
2018-04-17 21:47:59,700 [salt.state       ][INFO    ][2165] Completed state [ctl03.mcp-pike-ovs-ha.local] at time 21:47:59.700855 duration_in_ms=5.608
2018-04-17 21:47:59,701 [salt.state       ][INFO    ][2165] Running state [ctl01] at time 21:47:59.701179
2018-04-17 21:47:59,701 [salt.state       ][INFO    ][2165] Executing state host.present for ctl01
2018-04-17 21:47:59,706 [salt.state       ][INFO    ][2165] {'host': 'ctl01'}
2018-04-17 21:47:59,706 [salt.state       ][INFO    ][2165] Completed state [ctl01] at time 21:47:59.706871 duration_in_ms=5.692
2018-04-17 21:47:59,707 [salt.state       ][INFO    ][2165] Running state [ctl01.mcp-pike-ovs-ha.local] at time 21:47:59.707199
2018-04-17 21:47:59,707 [salt.state       ][INFO    ][2165] Executing state host.present for ctl01.mcp-pike-ovs-ha.local
2018-04-17 21:47:59,712 [salt.state       ][INFO    ][2165] {'host': 'ctl01.mcp-pike-ovs-ha.local'}
2018-04-17 21:47:59,712 [salt.state       ][INFO    ][2165] Completed state [ctl01.mcp-pike-ovs-ha.local] at time 21:47:59.712852 duration_in_ms=5.653
2018-04-17 21:47:59,713 [salt.state       ][INFO    ][2165] Running state [ctl] at time 21:47:59.713161
2018-04-17 21:47:59,713 [salt.state       ][INFO    ][2165] Executing state host.present for ctl
2018-04-17 21:47:59,718 [salt.state       ][INFO    ][2165] {'host': 'ctl'}
2018-04-17 21:47:59,718 [salt.state       ][INFO    ][2165] Completed state [ctl] at time 21:47:59.718919 duration_in_ms=5.759
2018-04-17 21:47:59,719 [salt.state       ][INFO    ][2165] Running state [ctl.mcp-pike-ovs-ha.local] at time 21:47:59.719228
2018-04-17 21:47:59,719 [salt.state       ][INFO    ][2165] Executing state host.present for ctl.mcp-pike-ovs-ha.local
2018-04-17 21:47:59,724 [salt.state       ][INFO    ][2165] {'host': 'ctl.mcp-pike-ovs-ha.local'}
2018-04-17 21:47:59,724 [salt.state       ][INFO    ][2165] Completed state [ctl.mcp-pike-ovs-ha.local] at time 21:47:59.724860 duration_in_ms=5.631
2018-04-17 21:47:59,725 [salt.state       ][INFO    ][2165] Running state [/etc/network/interfaces.d/50-cloud-init.cfg] at time 21:47:59.725180
2018-04-17 21:47:59,725 [salt.state       ][INFO    ][2165] Executing state file.absent for /etc/network/interfaces.d/50-cloud-init.cfg
2018-04-17 21:47:59,726 [salt.state       ][INFO    ][2165] {'removed': '/etc/network/interfaces.d/50-cloud-init.cfg'}
2018-04-17 21:47:59,726 [salt.state       ][INFO    ][2165] Completed state [/etc/network/interfaces.d/50-cloud-init.cfg] at time 21:47:59.726256 duration_in_ms=1.076
2018-04-17 21:47:59,738 [salt.state       ][INFO    ][2165] Running state [ens2] at time 21:47:59.738685
2018-04-17 21:47:59,739 [salt.state       ][INFO    ][2165] Executing state network.managed for ens2
2018-04-17 21:48:00,040 [salt.loaded.int.module.cmdmod][INFO    ][2165] Executing command ['ifdown', 'ens2'] in directory '/root'
2018-04-17 21:48:01,412 [salt.loaded.int.module.cmdmod][INFO    ][2165] Executing command ['ifup', 'ens2'] in directory '/root'
2018-04-17 21:48:01,930 [salt.state       ][INFO    ][2165] {'interface': 'Added network interface.', 'status': 'Interface ens2 restart to validate'}
2018-04-17 21:48:01,931 [salt.state       ][INFO    ][2165] Completed state [ens2] at time 21:48:01.931197 duration_in_ms=2192.511
2018-04-17 21:48:01,932 [salt.state       ][INFO    ][2165] Running state [ens3] at time 21:48:01.932637
2018-04-17 21:48:01,933 [salt.state       ][INFO    ][2165] Executing state network.managed for ens3
2018-04-17 21:48:01,975 [salt.loaded.int.module.cmdmod][INFO    ][2165] Executing command ['ifup', 'ens3'] in directory '/root'
2018-04-17 21:48:02,018 [salt.minion      ][INFO    ][2074] User sudo_ubuntu Executing command saltutil.find_job with jid 20180417214802003498
2018-04-17 21:48:02,035 [salt.minion      ][INFO    ][5446] Starting a new job with PID 5446
2018-04-17 21:48:02,059 [salt.minion      ][INFO    ][5446] Returning information for job: 20180417214802003498
2018-04-17 21:48:02,600 [salt.state       ][INFO    ][2165] {'interface': 'Added network interface.', 'status': 'Interface ens3 is up'}
2018-04-17 21:48:02,601 [salt.state       ][INFO    ][2165] Completed state [ens3] at time 21:48:02.601075 duration_in_ms=668.439
2018-04-17 21:48:02,601 [salt.state       ][INFO    ][2165] Running state [/etc/profile.d/proxy.sh] at time 21:48:02.601551
2018-04-17 21:48:02,602 [salt.state       ][INFO    ][2165] Executing state file.absent for /etc/profile.d/proxy.sh
2018-04-17 21:48:02,602 [salt.state       ][INFO    ][2165] File /etc/profile.d/proxy.sh is not present
2018-04-17 21:48:02,602 [salt.state       ][INFO    ][2165] Completed state [/etc/profile.d/proxy.sh] at time 21:48:02.602918 duration_in_ms=1.367
2018-04-17 21:48:02,603 [salt.state       ][INFO    ][2165] Running state [/etc/apt/apt.conf.d/95proxies] at time 21:48:02.603304
2018-04-17 21:48:02,603 [salt.state       ][INFO    ][2165] Executing state file.absent for /etc/apt/apt.conf.d/95proxies
2018-04-17 21:48:02,604 [salt.state       ][INFO    ][2165] File /etc/apt/apt.conf.d/95proxies is not present
2018-04-17 21:48:02,604 [salt.state       ][INFO    ][2165] Completed state [/etc/apt/apt.conf.d/95proxies] at time 21:48:02.604441 duration_in_ms=1.137
2018-04-17 21:48:02,610 [salt.state       ][INFO    ][2165] Running state [ntp] at time 21:48:02.610534
2018-04-17 21:48:02,610 [salt.state       ][INFO    ][2165] Executing state pkg.installed for ntp
2018-04-17 21:48:02,883 [salt.loaded.int.module.cmdmod][INFO    ][2165] Executing command ['dpkg', '--get-selections', '*'] in directory '/root'
2018-04-17 21:48:02,911 [salt.loaded.int.module.cmdmod][INFO    ][2165] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'ntp'] in directory '/root'
2018-04-17 21:48:12,371 [salt.minion      ][INFO    ][2074] User sudo_ubuntu Executing command saltutil.find_job with jid 20180417214812355018
2018-04-17 21:48:12,387 [salt.minion      ][INFO    ][6291] Starting a new job with PID 6291
2018-04-17 21:48:12,402 [salt.minion      ][INFO    ][6291] Returning information for job: 20180417214812355018
2018-04-17 21:48:13,037 [salt.loaded.int.module.cmdmod][INFO    ][2165] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2018-04-17 21:48:13,077 [salt.state       ][INFO    ][2165] Made the following changes:
'ntp' changed from 'absent' to '1:4.2.8p4+dfsg-3ubuntu5.8'
'libopts25' changed from 'absent' to '1:5.18.7-3'

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

2018-04-17 21:48:13,195 [salt.state       ][INFO    ][2165] Completed state [/etc/ntp.conf] at time 21:48:13.195431 duration_in_ms=81.339
2018-04-17 21:48:13,313 [salt.state       ][INFO    ][2165] Running state [ntp] at time 21:48:13.313587
2018-04-17 21:48:13,313 [salt.state       ][INFO    ][2165] Executing state service.running for ntp
2018-04-17 21:48:13,315 [salt.loaded.int.module.cmdmod][INFO    ][2165] Executing command ['systemctl', 'status', 'ntp.service', '-n', '0'] in directory '/root'
2018-04-17 21:48:13,330 [salt.loaded.int.module.cmdmod][INFO    ][2165] Executing command ['systemctl', 'is-active', 'ntp.service'] in directory '/root'
2018-04-17 21:48:13,343 [salt.loaded.int.module.cmdmod][INFO    ][2165] Executing command ['systemctl', 'is-enabled', 'ntp.service'] in directory '/root'
2018-04-17 21:48:13,359 [salt.state       ][INFO    ][2165] The service ntp is already running
2018-04-17 21:48:13,360 [salt.state       ][INFO    ][2165] Completed state [ntp] at time 21:48:13.360111 duration_in_ms=46.523
2018-04-17 21:48:13,360 [salt.state       ][INFO    ][2165] Running state [ntp] at time 21:48:13.360484
2018-04-17 21:48:13,361 [salt.state       ][INFO    ][2165] Executing state service.mod_watch for ntp
2018-04-17 21:48:13,361 [salt.loaded.int.module.cmdmod][INFO    ][2165] Executing command ['systemctl', 'is-active', 'ntp.service'] in directory '/root'
2018-04-17 21:48:13,374 [salt.loaded.int.module.cmdmod][INFO    ][2165] Executing command ['systemctl', 'is-enabled', 'ntp.service'] in directory '/root'
2018-04-17 21:48:13,395 [salt.loaded.int.module.cmdmod][INFO    ][2165] Executing command ['systemd-run', '--scope', 'systemctl', 'restart', 'ntp.service'] in directory '/root'
2018-04-17 21:48:13,521 [salt.state       ][INFO    ][2165] {'ntp': True}
2018-04-17 21:48:13,522 [salt.state       ][INFO    ][2165] Completed state [ntp] at time 21:48:13.522541 duration_in_ms=162.055
2018-04-17 21:48:13,528 [salt.minion      ][INFO    ][2165] Returning information for job: 20180417214711407955
2018-04-17 21:48:19,425 [salt.minion      ][INFO    ][2074] User sudo_ubuntu Executing command ssh.set_auth_key with jid 20180417214819413655
2018-04-17 21:48:19,448 [salt.minion      ][INFO    ][6390] Starting a new job with PID 6390
2018-04-17 21:48:19,466 [salt.loader.192.168.11.2.int.module.ssh][WARNING ][6390] Public Key hashing currently defaults to "md5". This will change to "sha256" in the Nitrogen release.
2018-04-17 21:48:19,469 [salt.minion      ][INFO    ][6390] Returning information for job: 20180417214819413655
2018-04-17 21:48:45,547 [salt.minion      ][INFO    ][2074] User sudo_ubuntu Executing command pkg.upgrade with jid 20180417214845532730
2018-04-17 21:48:45,571 [salt.minion      ][INFO    ][6399] Starting a new job with PID 6399
2018-04-17 21:48:45,623 [salt.loader.192.168.11.2.int.module.cmdmod][INFO    ][6399] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2018-04-17 21:48:45,976 [salt.loader.192.168.11.2.int.module.cmdmod][INFO    ][6399] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'upgrade'] in directory '/root'
2018-04-17 21:48:55,650 [salt.minion      ][INFO    ][2074] User sudo_ubuntu Executing command saltutil.find_job with jid 20180417214855629349
2018-04-17 21:48:55,672 [salt.minion      ][INFO    ][6450] Starting a new job with PID 6450
2018-04-17 21:48:55,698 [salt.minion      ][INFO    ][6450] Returning information for job: 20180417214855629349
2018-04-17 21:49:05,817 [salt.minion      ][INFO    ][2074] User sudo_ubuntu Executing command saltutil.find_job with jid 20180417214905801458
2018-04-17 21:49:05,842 [salt.minion      ][INFO    ][6470] Starting a new job with PID 6470
2018-04-17 21:49:05,962 [salt.minion      ][INFO    ][6470] Returning information for job: 20180417214905801458
2018-04-17 21:49:15,922 [salt.minion      ][INFO    ][2074] User sudo_ubuntu Executing command saltutil.find_job with jid 20180417214915906614
2018-04-17 21:49:15,949 [salt.minion      ][INFO    ][6484] Starting a new job with PID 6484
2018-04-17 21:49:15,976 [salt.minion      ][INFO    ][6484] Returning information for job: 20180417214915906614
2018-04-17 21:49:26,115 [salt.minion      ][INFO    ][2074] User sudo_ubuntu Executing command saltutil.find_job with jid 20180417214926097707
2018-04-17 21:49:26,141 [salt.minion      ][INFO    ][6803] Starting a new job with PID 6803
2018-04-17 21:49:26,167 [salt.minion      ][INFO    ][6803] Returning information for job: 20180417214926097707
2018-04-17 21:49:36,195 [salt.minion      ][INFO    ][2074] User sudo_ubuntu Executing command saltutil.find_job with jid 20180417214936182710
2018-04-17 21:49:36,225 [salt.minion      ][INFO    ][6808] Starting a new job with PID 6808
2018-04-17 21:49:36,250 [salt.minion      ][INFO    ][6808] Returning information for job: 20180417214936182710
2018-04-17 21:49:46,254 [salt.minion      ][INFO    ][2074] User sudo_ubuntu Executing command saltutil.find_job with jid 20180417214946241328
2018-04-17 21:49:46,276 [salt.minion      ][INFO    ][6813] Starting a new job with PID 6813
2018-04-17 21:49:46,301 [salt.minion      ][INFO    ][6813] Returning information for job: 20180417214946241328
2018-04-17 21:49:56,299 [salt.minion      ][INFO    ][2074] User sudo_ubuntu Executing command saltutil.find_job with jid 20180417214956285403
2018-04-17 21:49:56,328 [salt.minion      ][INFO    ][6818] Starting a new job with PID 6818
2018-04-17 21:49:56,355 [salt.minion      ][INFO    ][6818] Returning information for job: 20180417214956285403
2018-04-17 21:50:06,496 [salt.minion      ][INFO    ][2074] User sudo_ubuntu Executing command saltutil.find_job with jid 20180417215006479698
2018-04-17 21:50:06,520 [salt.minion      ][INFO    ][6849] Starting a new job with PID 6849
2018-04-17 21:50:06,578 [salt.minion      ][INFO    ][6849] Returning information for job: 20180417215006479698
2018-04-17 21:50:16,526 [salt.minion      ][INFO    ][2074] User sudo_ubuntu Executing command saltutil.find_job with jid 20180417215016509069
2018-04-17 21:50:16,552 [salt.minion      ][INFO    ][7098] Starting a new job with PID 7098
2018-04-17 21:50:16,578 [salt.minion      ][INFO    ][7098] Returning information for job: 20180417215016509069
2018-04-17 21:50:26,641 [salt.minion      ][INFO    ][2074] User sudo_ubuntu Executing command saltutil.find_job with jid 20180417215026622695
2018-04-17 21:50:26,667 [salt.minion      ][INFO    ][7720] Starting a new job with PID 7720
2018-04-17 21:50:26,693 [salt.minion      ][INFO    ][7720] Returning information for job: 20180417215026622695
2018-04-17 21:50:36,798 [salt.minion      ][INFO    ][2074] User sudo_ubuntu Executing command saltutil.find_job with jid 20180417215036781236
2018-04-17 21:50:36,823 [salt.minion      ][INFO    ][7992] Starting a new job with PID 7992
2018-04-17 21:50:36,852 [salt.minion      ][INFO    ][7992] Returning information for job: 20180417215036781236
2018-04-17 21:50:46,989 [salt.minion      ][INFO    ][2074] User sudo_ubuntu Executing command saltutil.find_job with jid 20180417215046969590
2018-04-17 21:50:47,020 [salt.minion      ][INFO    ][8018] Starting a new job with PID 8018
2018-04-17 21:50:47,046 [salt.minion      ][INFO    ][8018] Returning information for job: 20180417215046969590
2018-04-17 21:50:57,054 [salt.minion      ][INFO    ][2074] User sudo_ubuntu Executing command saltutil.find_job with jid 20180417215057035642
2018-04-17 21:50:57,084 [salt.minion      ][INFO    ][8041] Starting a new job with PID 8041
2018-04-17 21:50:57,111 [salt.minion      ][INFO    ][8041] Returning information for job: 20180417215057035642
2018-04-17 21:51:07,178 [salt.minion      ][INFO    ][2074] User sudo_ubuntu Executing command saltutil.find_job with jid 20180417215107157452
2018-04-17 21:51:07,205 [salt.minion      ][INFO    ][8059] Starting a new job with PID 8059
2018-04-17 21:51:07,358 [salt.minion      ][INFO    ][8059] Returning information for job: 20180417215107157452
2018-04-17 21:51:17,271 [salt.minion      ][INFO    ][2074] User sudo_ubuntu Executing command saltutil.find_job with jid 20180417215117249270
2018-04-17 21:51:19,562 [salt.minion      ][INFO    ][8088] Starting a new job with PID 8088
2018-04-17 21:51:19,589 [salt.minion      ][INFO    ][8088] Returning information for job: 20180417215117249270
2018-04-17 21:51:27,450 [salt.minion      ][INFO    ][2074] User sudo_ubuntu Executing command saltutil.find_job with jid 20180417215127428568
2018-04-17 21:51:27,481 [salt.minion      ][INFO    ][8115] Starting a new job with PID 8115
2018-04-17 21:51:27,507 [salt.minion      ][INFO    ][8115] Returning information for job: 20180417215127428568
2018-04-17 21:51:37,571 [salt.minion      ][INFO    ][2074] User sudo_ubuntu Executing command saltutil.find_job with jid 20180417215137549026
2018-04-17 21:51:37,597 [salt.minion      ][INFO    ][8134] Starting a new job with PID 8134
2018-04-17 21:51:37,852 [salt.minion      ][INFO    ][8134] Returning information for job: 20180417215137549026
2018-04-17 21:51:47,612 [salt.minion      ][INFO    ][2074] User sudo_ubuntu Executing command saltutil.find_job with jid 20180417215147591496
2018-04-17 21:51:47,635 [salt.minion      ][INFO    ][8169] Starting a new job with PID 8169
2018-04-17 21:51:47,956 [salt.minion      ][INFO    ][8169] Returning information for job: 20180417215147591496
2018-04-17 21:51:57,799 [salt.minion      ][INFO    ][2074] User sudo_ubuntu Executing command saltutil.find_job with jid 20180417215157770550
2018-04-17 21:51:57,828 [salt.minion      ][INFO    ][8279] Starting a new job with PID 8279
2018-04-17 21:51:57,854 [salt.minion      ][INFO    ][8279] Returning information for job: 20180417215157770550
2018-04-17 21:52:07,897 [salt.minion      ][INFO    ][2074] User sudo_ubuntu Executing command saltutil.find_job with jid 20180417215207877652
2018-04-17 21:52:07,926 [salt.minion      ][INFO    ][8318] Starting a new job with PID 8318
2018-04-17 21:52:07,960 [salt.minion      ][INFO    ][8318] Returning information for job: 20180417215207877652
2018-04-17 21:52:17,927 [salt.minion      ][INFO    ][2074] User sudo_ubuntu Executing command saltutil.find_job with jid 20180417215217909445
2018-04-17 21:52:17,950 [salt.minion      ][INFO    ][8537] Starting a new job with PID 8537
2018-04-17 21:52:17,976 [salt.minion      ][INFO    ][8537] Returning information for job: 20180417215217909445
2018-04-17 21:52:27,966 [salt.minion      ][INFO    ][2074] User sudo_ubuntu Executing command saltutil.find_job with jid 20180417215227947276
2018-04-17 21:52:28,268 [salt.minion      ][INFO    ][8802] Starting a new job with PID 8802
2018-04-17 21:52:28,701 [salt.minion      ][INFO    ][8802] Returning information for job: 20180417215227947276
2018-04-17 21:52:34,659 [salt.loader.192.168.11.2.int.module.cmdmod][INFO    ][6399] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2018-04-17 21:52:34,715 [salt.minion      ][INFO    ][6399] Returning information for job: 20180417214845532730
2018-04-17 21:52:42,410 [salt.minion      ][INFO    ][2074] User sudo_ubuntu Executing command test.ping with jid 20180417215242391914
2018-04-17 21:52:42,439 [salt.minion      ][INFO    ][8921] Starting a new job with PID 8921
2018-04-17 21:52:42,523 [salt.minion      ][INFO    ][8921] Returning information for job: 20180417215242391914
2018-04-17 21:56:15,131 [salt.minion      ][INFO    ][2074] User sudo_ubuntu Executing command state.sls with jid 20180417215615118265
2018-04-17 21:56:15,153 [salt.minion      ][INFO    ][8936] Starting a new job with PID 8936
2018-04-17 21:56:16,811 [salt.state       ][INFO    ][8936] Loading fresh modules for state activity
2018-04-17 21:56:16,885 [salt.fileclient  ][INFO    ][8936] Fetching file from saltenv 'base', ** done ** 'keepalived/init.sls'
2018-04-17 21:56:16,917 [salt.fileclient  ][INFO    ][8936] Fetching file from saltenv 'base', ** done ** 'keepalived/cluster.sls'
2018-04-17 21:56:17,477 [salt.state       ][INFO    ][8936] Running state [keepalived] at time 21:56:17.477788
2018-04-17 21:56:17,478 [salt.state       ][INFO    ][8936] Executing state pkg.installed for keepalived
2018-04-17 21:56:17,478 [salt.loaded.int.module.cmdmod][INFO    ][8936] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2018-04-17 21:56:17,789 [salt.loaded.int.module.cmdmod][INFO    ][8936] Executing command ['apt-cache', '-q', 'policy', 'keepalived'] in directory '/root'
2018-04-17 21:56:17,882 [salt.loaded.int.module.cmdmod][INFO    ][8936] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2018-04-17 21:56:20,195 [salt.loaded.int.module.cmdmod][INFO    ][8936] Executing command ['dpkg', '--get-selections', '*'] in directory '/root'
2018-04-17 21:56:20,231 [salt.loaded.int.module.cmdmod][INFO    ][8936] 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-04-17 21:56:25,180 [salt.minion      ][INFO    ][2074] User sudo_ubuntu Executing command saltutil.find_job with jid 20180417215625164878
2018-04-17 21:56:25,200 [salt.minion      ][INFO    ][9926] Starting a new job with PID 9926
2018-04-17 21:56:25,232 [salt.minion      ][INFO    ][9926] Returning information for job: 20180417215625164878
2018-04-17 21:56:29,837 [salt.loaded.int.module.cmdmod][INFO    ][8936] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2018-04-17 21:56:29,873 [salt.state       ][INFO    ][8936] Made the following changes:
'libsnmp30' changed from 'absent' to '5.7.3+dfsg-1ubuntu4.1'
'libnl-3-200' changed from 'absent' to '3.2.27-1ubuntu0.16.04.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.19-1ubuntu0.2'
'ipvsadm' changed from 'absent' to '1:1.28-3'
'libnl-genl-3-200' changed from 'absent' to '3.2.27-1ubuntu0.16.04.1'

2018-04-17 21:56:29,888 [salt.state       ][INFO    ][8936] Loading fresh modules for state activity
2018-04-17 21:56:29,909 [salt.state       ][INFO    ][8936] Completed state [keepalived] at time 21:56:29.909001 duration_in_ms=12431.212
2018-04-17 21:56:29,923 [salt.state       ][INFO    ][8936] Running state [lsof] at time 21:56:29.923252
2018-04-17 21:56:29,924 [salt.state       ][INFO    ][8936] Executing state pkg.installed for lsof
2018-04-17 21:56:30,315 [salt.state       ][INFO    ][8936] All specified packages are already installed
2018-04-17 21:56:30,315 [salt.state       ][INFO    ][8936] Completed state [lsof] at time 21:56:30.315908 duration_in_ms=392.657
2018-04-17 21:56:30,318 [salt.state       ][INFO    ][8936] Running state [/etc/keepalived/keepalived.conf] at time 21:56:30.318564
2018-04-17 21:56:30,318 [salt.state       ][INFO    ][8936] Executing state file.managed for /etc/keepalived/keepalived.conf
2018-04-17 21:56:30,368 [salt.fileclient  ][INFO    ][8936] Fetching file from saltenv 'base', ** done ** 'keepalived/files/keepalived.conf'
2018-04-17 21:56:30,404 [salt.state       ][INFO    ][8936] File changed:
New file
2018-04-17 21:56:30,404 [salt.state       ][INFO    ][8936] Completed state [/etc/keepalived/keepalived.conf] at time 21:56:30.404866 duration_in_ms=86.302
2018-04-17 21:56:30,405 [salt.state       ][INFO    ][8936] Running state [keepalived] at time 21:56:30.405554
2018-04-17 21:56:30,405 [salt.state       ][INFO    ][8936] Executing state service.running for keepalived
2018-04-17 21:56:30,406 [salt.loaded.int.module.cmdmod][INFO    ][8936] Executing command ['systemctl', 'status', 'keepalived.service', '-n', '0'] in directory '/root'
2018-04-17 21:56:30,430 [salt.loaded.int.module.cmdmod][INFO    ][8936] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2018-04-17 21:56:30,451 [salt.loaded.int.module.cmdmod][INFO    ][8936] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2018-04-17 21:56:30,474 [salt.loaded.int.module.cmdmod][INFO    ][8936] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2018-04-17 21:56:30,497 [salt.loaded.int.module.cmdmod][INFO    ][8936] Executing command ['systemd-run', '--scope', 'systemctl', 'start', 'keepalived.service'] in directory '/root'
2018-04-17 21:56:30,590 [salt.loaded.int.module.cmdmod][INFO    ][8936] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2018-04-17 21:56:30,622 [salt.loaded.int.module.cmdmod][INFO    ][8936] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2018-04-17 21:56:30,649 [salt.loaded.int.module.cmdmod][INFO    ][8936] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2018-04-17 21:56:30,676 [salt.state       ][INFO    ][8936] {'keepalived': True}
2018-04-17 21:56:30,676 [salt.state       ][INFO    ][8936] Completed state [keepalived] at time 21:56:30.676728 duration_in_ms=271.173
2018-04-17 21:56:30,679 [salt.minion      ][INFO    ][8936] Returning information for job: 20180417215615118265
2018-04-17 21:57:16,039 [salt.minion      ][INFO    ][2074] User sudo_ubuntu Executing command pillar.get with jid 20180417215716027073
2018-04-17 21:57:16,073 [salt.minion      ][INFO    ][10296] Starting a new job with PID 10296
2018-04-17 21:57:16,084 [salt.minion      ][INFO    ][10296] Returning information for job: 20180417215716027073
2018-04-17 21:57:16,786 [salt.minion      ][INFO    ][2074] User sudo_ubuntu Executing command state.sls with jid 20180417215716768942
2018-04-17 21:57:16,808 [salt.minion      ][INFO    ][10301] Starting a new job with PID 10301
2018-04-17 21:57:18,434 [salt.state       ][INFO    ][10301] Loading fresh modules for state activity
2018-04-17 21:57:18,495 [salt.fileclient  ][INFO    ][10301] Fetching file from saltenv 'base', ** done ** 'rabbitmq/init.sls'
2018-04-17 21:57:18,537 [salt.fileclient  ][INFO    ][10301] Fetching file from saltenv 'base', ** done ** 'rabbitmq/server/init.sls'
2018-04-17 21:57:18,564 [salt.fileclient  ][INFO    ][10301] Fetching file from saltenv 'base', ** done ** 'rabbitmq/server/service.sls'
2018-04-17 21:57:18,619 [salt.loaded.int.module.cmdmod][INFO    ][10301] Executing command 'cat /var/lib/rabbitmq/.erlang.cookie' in directory '/root'
2018-04-17 21:57:18,642 [salt.loaded.int.module.cmdmod][ERROR   ][10301] Command 'cat /var/lib/rabbitmq/.erlang.cookie' failed with return code: 1
2018-04-17 21:57:18,643 [salt.loaded.int.module.cmdmod][ERROR   ][10301] output: cat: /var/lib/rabbitmq/.erlang.cookie: No such file or directory
2018-04-17 21:57:18,696 [salt.fileclient  ][INFO    ][10301] Fetching file from saltenv 'base', ** done ** 'rabbitmq/server/ssl.sls'
2018-04-17 21:57:18,762 [salt.fileclient  ][INFO    ][10301] Fetching file from saltenv 'base', ** done ** 'rabbitmq/server/plugin.sls'
2018-04-17 21:57:18,820 [salt.fileclient  ][INFO    ][10301] Fetching file from saltenv 'base', ** done ** 'rabbitmq/server/vhost.sls'
2018-04-17 21:57:18,890 [salt.fileclient  ][INFO    ][10301] Fetching file from saltenv 'base', ** done ** 'rabbitmq/server/user.sls'
2018-04-17 21:57:18,952 [salt.fileclient  ][INFO    ][10301] Fetching file from saltenv 'base', ** done ** 'rabbitmq/cluster.sls'
2018-04-17 21:57:19,451 [salt.state       ][INFO    ][10301] Running state [rabbitmq-server] at time 21:57:19.451036
2018-04-17 21:57:19,451 [salt.state       ][INFO    ][10301] Executing state pkg.installed for rabbitmq-server
2018-04-17 21:57:19,452 [salt.loaded.int.module.cmdmod][INFO    ][10301] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2018-04-17 21:57:19,843 [salt.loaded.int.module.cmdmod][INFO    ][10301] Executing command ['apt-cache', '-q', 'policy', 'rabbitmq-server'] in directory '/root'
2018-04-17 21:57:19,970 [salt.loaded.int.module.cmdmod][INFO    ][10301] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2018-04-17 21:57:22,234 [salt.loaded.int.module.cmdmod][INFO    ][10301] Executing command ['dpkg', '--get-selections', '*'] in directory '/root'
2018-04-17 21:57:22,277 [salt.loaded.int.module.cmdmod][INFO    ][10301] 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-04-17 21:57:26,878 [salt.minion      ][INFO    ][2074] User sudo_ubuntu Executing command saltutil.find_job with jid 20180417215726862148
2018-04-17 21:57:26,901 [salt.minion      ][INFO    ][10759] Starting a new job with PID 10759
2018-04-17 21:57:26,930 [salt.minion      ][INFO    ][10759] Returning information for job: 20180417215726862148
2018-04-17 21:57:37,103 [salt.minion      ][INFO    ][2074] User sudo_ubuntu Executing command saltutil.find_job with jid 20180417215737086943
2018-04-17 21:57:37,125 [salt.minion      ][INFO    ][10764] Starting a new job with PID 10764
2018-04-17 21:57:37,155 [salt.minion      ][INFO    ][10764] Returning information for job: 20180417215737086943
2018-04-17 21:57:47,325 [salt.minion      ][INFO    ][2074] User sudo_ubuntu Executing command saltutil.find_job with jid 20180417215747309137
2018-04-17 21:57:47,350 [salt.minion      ][INFO    ][10913] Starting a new job with PID 10913
2018-04-17 21:57:47,383 [salt.minion      ][INFO    ][10913] Returning information for job: 20180417215747309137
2018-04-17 21:57:57,554 [salt.minion      ][INFO    ][2074] User sudo_ubuntu Executing command saltutil.find_job with jid 20180417215757538004
2018-04-17 21:57:57,578 [salt.minion      ][INFO    ][11435] Starting a new job with PID 11435
2018-04-17 21:57:57,606 [salt.minion      ][INFO    ][11435] Returning information for job: 20180417215757538004
2018-04-17 21:58:07,774 [salt.minion      ][INFO    ][2074] User sudo_ubuntu Executing command saltutil.find_job with jid 20180417215807759226
2018-04-17 21:58:07,783 [salt.minion      ][INFO    ][11639] Starting a new job with PID 11639
2018-04-17 21:58:07,795 [salt.minion      ][INFO    ][11639] Returning information for job: 20180417215807759226
2018-04-17 21:58:17,960 [salt.minion      ][INFO    ][2074] User sudo_ubuntu Executing command saltutil.find_job with jid 20180417215817944598
2018-04-17 21:58:17,971 [salt.minion      ][INFO    ][11644] Starting a new job with PID 11644
2018-04-17 21:58:17,988 [salt.minion      ][INFO    ][11644] Returning information for job: 20180417215817944598
2018-04-17 21:58:28,163 [salt.minion      ][INFO    ][2074] User sudo_ubuntu Executing command saltutil.find_job with jid 20180417215828146483
2018-04-17 21:58:28,174 [salt.minion      ][INFO    ][11649] Starting a new job with PID 11649
2018-04-17 21:58:28,187 [salt.minion      ][INFO    ][11649] Returning information for job: 20180417215828146483
2018-04-17 21:58:31,749 [salt.loaded.int.module.cmdmod][INFO    ][10301] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2018-04-17 21:58:31,799 [salt.state       ][INFO    ][10301] 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-2~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-04-17 21:58:31,813 [salt.state       ][INFO    ][10301] Loading fresh modules for state activity
2018-04-17 21:58:31,832 [salt.state       ][INFO    ][10301] Completed state [rabbitmq-server] at time 21:58:31.832114 duration_in_ms=72381.078
2018-04-17 21:58:31,834 [salt.state       ][INFO    ][10301] Running state [/etc/rabbitmq/rabbitmq.config] at time 21:58:31.834951
2018-04-17 21:58:31,835 [salt.state       ][INFO    ][10301] Executing state file.managed for /etc/rabbitmq/rabbitmq.config
2018-04-17 21:58:31,861 [salt.fileclient  ][INFO    ][10301] Fetching file from saltenv 'base', ** done ** 'rabbitmq/files/rabbitmq.config'
2018-04-17 21:58:31,925 [salt.state       ][INFO    ][10301] File changed:
New file
2018-04-17 21:58:31,926 [salt.state       ][INFO    ][10301] Completed state [/etc/rabbitmq/rabbitmq.config] at time 21:58:31.926633 duration_in_ms=91.68
2018-04-17 21:58:31,927 [salt.state       ][INFO    ][10301] Running state [/etc/default/rabbitmq-server] at time 21:58:31.927634
2018-04-17 21:58:31,928 [salt.state       ][INFO    ][10301] Executing state file.managed for /etc/default/rabbitmq-server
2018-04-17 21:58:31,952 [salt.fileclient  ][INFO    ][10301] Fetching file from saltenv 'base', ** done ** 'rabbitmq/files/default'
2018-04-17 21:58:31,997 [salt.state       ][INFO    ][10301] 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-04-17 21:58:32,005 [salt.state       ][INFO    ][10301] Completed state [/etc/default/rabbitmq-server] at time 21:58:32.005635 duration_in_ms=78.0
2018-04-17 21:58:32,006 [salt.state       ][INFO    ][10301] Running state [/etc/systemd/system/rabbitmq-server.service.d/limits.conf] at time 21:58:32.006385
2018-04-17 21:58:32,006 [salt.state       ][INFO    ][10301] Executing state file.managed for /etc/systemd/system/rabbitmq-server.service.d/limits.conf
2018-04-17 21:58:32,032 [salt.fileclient  ][INFO    ][10301] Fetching file from saltenv 'base', ** done ** 'rabbitmq/files/limits.conf'
2018-04-17 21:58:32,077 [salt.state       ][INFO    ][10301] File changed:
New file
2018-04-17 21:58:32,078 [salt.state       ][INFO    ][10301] Completed state [/etc/systemd/system/rabbitmq-server.service.d/limits.conf] at time 21:58:32.077935 duration_in_ms=71.55
2018-04-17 21:58:32,079 [salt.state       ][INFO    ][10301] Running state [sleep 30] at time 21:58:32.079799
2018-04-17 21:58:32,080 [salt.state       ][INFO    ][10301] Executing state cmd.run for sleep 30
2018-04-17 21:58:32,081 [py.warnings      ][WARNING ][10301] /usr/lib/python2.7/dist-packages/salt/states/cmd.py:815: DeprecationWarning: The legacy user/group arguments are deprecated. Replace them with runas. These arguments will be removed in Salt Oxygen.

2018-04-17 21:58:32,084 [salt.loaded.int.module.cmdmod][INFO    ][10301] Executing command 'sleep 30' as user 'root' in directory '/root'
2018-04-17 21:58:38,188 [salt.minion      ][INFO    ][2074] User sudo_ubuntu Executing command saltutil.find_job with jid 20180417215838173091
2018-04-17 21:58:38,210 [salt.minion      ][INFO    ][11783] Starting a new job with PID 11783
2018-04-17 21:58:38,239 [salt.minion      ][INFO    ][11783] Returning information for job: 20180417215838173091
2018-04-17 21:58:48,214 [salt.minion      ][INFO    ][2074] User sudo_ubuntu Executing command saltutil.find_job with jid 20180417215848197131
2018-04-17 21:58:48,236 [salt.minion      ][INFO    ][11791] Starting a new job with PID 11791
2018-04-17 21:58:48,266 [salt.minion      ][INFO    ][11791] Returning information for job: 20180417215848197131
2018-04-17 21:58:58,441 [salt.minion      ][INFO    ][2074] User sudo_ubuntu Executing command saltutil.find_job with jid 20180417215858424726
2018-04-17 21:58:58,464 [salt.minion      ][INFO    ][11796] Starting a new job with PID 11796
2018-04-17 21:58:58,492 [salt.minion      ][INFO    ][11796] Returning information for job: 20180417215858424726
2018-04-17 21:59:02,226 [salt.state       ][INFO    ][10301] {'pid': 11768, 'retcode': 0, 'stderr': '', 'stdout': ''}
2018-04-17 21:59:02,228 [salt.state       ][INFO    ][10301] Completed state [sleep 30] at time 21:59:02.227960 duration_in_ms=30148.159
2018-04-17 21:59:02,230 [salt.state       ][INFO    ][10301] Running state [service rabbitmq-server stop] at time 21:59:02.230393
2018-04-17 21:59:02,231 [salt.state       ][INFO    ][10301] Executing state cmd.run for service rabbitmq-server stop
2018-04-17 21:59:02,232 [salt.loaded.int.module.cmdmod][INFO    ][10301] Executing command 'service rabbitmq-server stop' in directory '/root'
2018-04-17 21:59:02,598 [salt.state       ][INFO    ][10301] {'pid': 11799, 'retcode': 0, 'stderr': '', 'stdout': ''}
2018-04-17 21:59:02,599 [salt.state       ][INFO    ][10301] Completed state [service rabbitmq-server stop] at time 21:59:02.599183 duration_in_ms=368.789
2018-04-17 21:59:02,600 [salt.state       ][INFO    ][10301] Running state [/var/lib/rabbitmq] at time 21:59:02.600072
2018-04-17 21:59:02,600 [salt.state       ][INFO    ][10301] Executing state file.directory for /var/lib/rabbitmq
2018-04-17 21:59:02,602 [salt.state       ][INFO    ][10301] Directory /var/lib/rabbitmq is in the correct state
2018-04-17 21:59:02,603 [salt.state       ][INFO    ][10301] Completed state [/var/lib/rabbitmq] at time 21:59:02.603174 duration_in_ms=3.102
2018-04-17 21:59:02,605 [salt.state       ][INFO    ][10301] Running state [/var/lib/rabbitmq/.erlang.cookie] at time 21:59:02.605291
2018-04-17 21:59:02,605 [salt.state       ][INFO    ][10301] Executing state file.managed for /var/lib/rabbitmq/.erlang.cookie
2018-04-17 21:59:02,616 [salt.state       ][INFO    ][10301] File changed:
--- 
+++ 
@@ -1 +1 @@
-GNWHMJMAZQKOZHKMTRZF+opnfv_secret

2018-04-17 21:59:02,616 [salt.state       ][INFO    ][10301] Completed state [/var/lib/rabbitmq/.erlang.cookie] at time 21:59:02.616615 duration_in_ms=11.324
2018-04-17 21:59:02,617 [salt.state       ][INFO    ][10301] Running state [sleep 30] at time 21:59:02.617278
2018-04-17 21:59:02,617 [salt.state       ][INFO    ][10301] Executing state cmd.run for sleep 30
2018-04-17 21:59:02,618 [salt.loaded.int.module.cmdmod][INFO    ][10301] Executing command 'sleep 30' as user 'root' in directory '/root'
2018-04-17 21:59:08,485 [salt.minion      ][INFO    ][2074] User sudo_ubuntu Executing command saltutil.find_job with jid 20180417215908466165
2018-04-17 21:59:08,508 [salt.minion      ][INFO    ][11856] Starting a new job with PID 11856
2018-04-17 21:59:08,537 [salt.minion      ][INFO    ][11856] Returning information for job: 20180417215908466165
2018-04-17 21:59:18,522 [salt.minion      ][INFO    ][2074] User sudo_ubuntu Executing command saltutil.find_job with jid 20180417215918505333
2018-04-17 21:59:18,544 [salt.minion      ][INFO    ][11861] Starting a new job with PID 11861
2018-04-17 21:59:18,571 [salt.minion      ][INFO    ][11861] Returning information for job: 20180417215918505333
2018-04-17 21:59:28,542 [salt.minion      ][INFO    ][2074] User sudo_ubuntu Executing command saltutil.find_job with jid 20180417215928525678
2018-04-17 21:59:28,565 [salt.minion      ][INFO    ][11866] Starting a new job with PID 11866
2018-04-17 21:59:28,593 [salt.minion      ][INFO    ][11866] Returning information for job: 20180417215928525678
2018-04-17 21:59:32,755 [salt.state       ][INFO    ][10301] {'pid': 11846, 'retcode': 0, 'stderr': '', 'stdout': ''}
2018-04-17 21:59:32,756 [salt.state       ][INFO    ][10301] Completed state [sleep 30] at time 21:59:32.756784 duration_in_ms=30139.505
2018-04-17 21:59:32,845 [salt.state       ][INFO    ][10301] Running state [rabbitmq-server] at time 21:59:32.845133
2018-04-17 21:59:32,845 [salt.state       ][INFO    ][10301] Executing state service.running for rabbitmq-server
2018-04-17 21:59:32,846 [salt.loaded.int.module.cmdmod][INFO    ][10301] Executing command ['systemctl', 'status', 'rabbitmq-server.service', '-n', '0'] in directory '/root'
2018-04-17 21:59:32,881 [salt.loaded.int.module.cmdmod][INFO    ][10301] Executing command ['systemctl', 'is-active', 'rabbitmq-server.service'] in directory '/root'
2018-04-17 21:59:32,910 [salt.loaded.int.module.cmdmod][INFO    ][10301] Executing command ['systemctl', 'is-enabled', 'rabbitmq-server.service'] in directory '/root'
2018-04-17 21:59:32,947 [salt.loaded.int.module.cmdmod][INFO    ][10301] Executing command ['systemctl', 'is-enabled', 'rabbitmq-server.service'] in directory '/root'
2018-04-17 21:59:32,978 [salt.loaded.int.module.cmdmod][INFO    ][10301] Executing command ['systemd-run', '--scope', 'systemctl', 'start', 'rabbitmq-server.service'] in directory '/root'
2018-04-17 21:59:36,616 [salt.loaded.int.module.cmdmod][INFO    ][10301] Executing command ['systemctl', 'is-active', 'rabbitmq-server.service'] in directory '/root'
2018-04-17 21:59:36,645 [salt.loaded.int.module.cmdmod][INFO    ][10301] Executing command ['systemctl', 'is-enabled', 'rabbitmq-server.service'] in directory '/root'
2018-04-17 21:59:36,679 [salt.loaded.int.module.cmdmod][INFO    ][10301] Executing command ['systemctl', 'is-enabled', 'rabbitmq-server.service'] in directory '/root'
2018-04-17 21:59:36,714 [salt.loaded.int.module.cmdmod][INFO    ][10301] Executing command ['systemctl', 'is-enabled', 'rabbitmq-server.service'] in directory '/root'
2018-04-17 21:59:36,746 [salt.loaded.int.module.cmdmod][INFO    ][10301] Executing command ['systemd-run', '--scope', 'systemctl', 'enable', 'rabbitmq-server.service'] in directory '/root'
2018-04-17 21:59:37,278 [salt.loaded.int.module.cmdmod][INFO    ][10301] Executing command ['systemctl', 'is-enabled', 'rabbitmq-server.service'] in directory '/root'
2018-04-17 21:59:37,307 [salt.state       ][INFO    ][10301] {'rabbitmq-server': True}
2018-04-17 21:59:37,308 [salt.state       ][INFO    ][10301] Completed state [rabbitmq-server] at time 21:59:37.308133 duration_in_ms=4463.0
2018-04-17 21:59:37,316 [salt.state       ][INFO    ][10301] Running state [amqp_client] at time 21:59:37.316570
2018-04-17 21:59:37,317 [salt.state       ][INFO    ][10301] Executing state rabbitmq_plugin.enabled for amqp_client
2018-04-17 21:59:37,322 [salt.loaded.int.module.cmdmod][INFO    ][10301] Executing command ['/usr/sbin/rabbitmq-plugins', 'list', '-m', '-e'] as user 'root' in directory '/root'
2018-04-17 21:59:38,567 [salt.loaded.int.module.cmdmod][INFO    ][10301] Executing command ['/usr/sbin/rabbitmq-plugins', 'enable', 'amqp_client'] as user 'root' in directory '/root'
2018-04-17 21:59:38,574 [salt.minion      ][INFO    ][2074] User sudo_ubuntu Executing command saltutil.find_job with jid 20180417215938557205
2018-04-17 21:59:38,597 [salt.minion      ][INFO    ][12408] Starting a new job with PID 12408
2018-04-17 21:59:38,625 [salt.minion      ][INFO    ][12408] Returning information for job: 20180417215938557205
2018-04-17 21:59:39,978 [salt.state       ][INFO    ][10301] {'new': 'amqp_client', 'old': ''}
2018-04-17 21:59:39,979 [salt.state       ][INFO    ][10301] Completed state [amqp_client] at time 21:59:39.979489 duration_in_ms=2662.918
2018-04-17 21:59:39,980 [salt.state       ][INFO    ][10301] Running state [rabbitmq_management] at time 21:59:39.980570
2018-04-17 21:59:39,981 [salt.state       ][INFO    ][10301] Executing state rabbitmq_plugin.enabled for rabbitmq_management
2018-04-17 21:59:39,982 [salt.loaded.int.module.cmdmod][INFO    ][10301] Executing command ['/usr/sbin/rabbitmq-plugins', 'list', '-m', '-e'] as user 'root' in directory '/root'
2018-04-17 21:59:41,140 [salt.loaded.int.module.cmdmod][INFO    ][10301] Executing command ['/usr/sbin/rabbitmq-plugins', 'enable', 'rabbitmq_management'] as user 'root' in directory '/root'
2018-04-17 21:59:43,180 [salt.state       ][INFO    ][10301] {'new': 'rabbitmq_management', 'old': ''}
2018-04-17 21:59:43,181 [salt.state       ][INFO    ][10301] Completed state [rabbitmq_management] at time 21:59:43.181679 duration_in_ms=3201.107
2018-04-17 21:59:43,187 [salt.state       ][INFO    ][10301] Running state [/openstack] at time 21:59:43.187643
2018-04-17 21:59:43,188 [salt.state       ][INFO    ][10301] Executing state rabbitmq_vhost.present for /openstack
2018-04-17 21:59:43,189 [salt.loaded.int.module.cmdmod][INFO    ][10301] Executing command 'rabbitmqctl list_vhosts -q' as user 'root' in directory '/root'
2018-04-17 21:59:44,425 [salt.loaded.int.module.cmdmod][INFO    ][10301] Executing command ['rabbitmqctl', 'add_vhost', '/openstack'] as user 'root' in directory '/root'
2018-04-17 21:59:45,980 [salt.state       ][INFO    ][10301] {'new': '/openstack', 'old': ''}
2018-04-17 21:59:45,981 [salt.state       ][INFO    ][10301] Completed state [/openstack] at time 21:59:45.981214 duration_in_ms=2793.57
2018-04-17 21:59:45,993 [salt.state       ][INFO    ][10301] Running state [openstack] at time 21:59:45.993761
2018-04-17 21:59:45,994 [salt.state       ][INFO    ][10301] Executing state rabbitmq_user.present for openstack
2018-04-17 21:59:45,995 [salt.loaded.int.module.cmdmod][INFO    ][10301] Executing command ['rabbitmqctl', 'list_users'] as user 'root' in directory '/root'
2018-04-17 21:59:48,509 [salt.loaded.int.module.cmdmod][INFO    ][10301] Executing command ['rabbitmqctl', 'list_user_permissions', 'openstack'] as user 'root' in directory '/root'
2018-04-17 21:59:48,610 [salt.minion      ][INFO    ][2074] User sudo_ubuntu Executing command saltutil.find_job with jid 20180417215948593146
2018-04-17 21:59:48,630 [salt.minion      ][INFO    ][13861] Starting a new job with PID 13861
2018-04-17 21:59:48,657 [salt.minion      ][INFO    ][13861] Returning information for job: 20180417215948593146
2018-04-17 21:59:49,776 [salt.loaded.int.module.cmdmod][INFO    ][10301] Executing command ['rabbitmqctl', 'set_permissions', '-p', '/openstack', 'openstack', '.*', '.*', '.*'] as user 'root' in directory '/root'
2018-04-17 21:59:51,082 [salt.state       ][INFO    ][10301] Made the following changes:
'perms' changed from 'absent' to '{'/openstack': ['.*', '.*', '.*']}'
'user' changed from 'absent' to 'openstack'

2018-04-17 21:59:51,085 [salt.state       ][INFO    ][10301] Completed state [openstack] at time 21:59:51.085422 duration_in_ms=5091.66
2018-04-17 21:59:51,096 [salt.state       ][INFO    ][10301] Running state [Ceilometer] at time 21:59:51.096608
2018-04-17 21:59:51,097 [salt.state       ][INFO    ][10301] Executing state rabbitmq_policy.present for Ceilometer
2018-04-17 21:59:51,098 [salt.loaded.int.module.cmdmod][INFO    ][10301] Executing command ['rabbitmqctl', 'list_policies', '-p', '/openstack'] as user 'root' in directory '/root'
2018-04-17 21:59:52,417 [salt.loaded.int.module.cmdmod][INFO    ][10301] Executing command ['rabbitmqctl', 'set_policy', '-p', '/openstack', '--priority', 10, 'Ceilometer', '^metering.sample$', '{"ha-mode": "all", "message-ttl": 10800000}'] as user 'root' in directory '/root'
2018-04-17 21:59:53,716 [salt.state       ][INFO    ][10301] {'new': 'Ceilometer', 'old': {}}
2018-04-17 21:59:53,717 [salt.state       ][INFO    ][10301] Completed state [Ceilometer] at time 21:59:53.717110 duration_in_ms=2620.5
2018-04-17 21:59:53,718 [salt.state       ][INFO    ][10301] Running state [HA] at time 21:59:53.718504
2018-04-17 21:59:53,719 [salt.state       ][INFO    ][10301] Executing state rabbitmq_policy.present for HA
2018-04-17 21:59:53,720 [salt.loaded.int.module.cmdmod][INFO    ][10301] Executing command ['rabbitmqctl', 'list_policies', '-p', '/openstack'] as user 'root' in directory '/root'
2018-04-17 21:59:55,024 [salt.loaded.int.module.cmdmod][INFO    ][10301] Executing command ['rabbitmqctl', 'set_policy', '-p', '/openstack', 'HA', '^(?!amq\\.).*', '{"ha-mode": "all", "message-ttl": 120000}'] as user 'root' in directory '/root'
2018-04-17 21:59:56,352 [salt.state       ][INFO    ][10301] {'new': 'HA', 'old': {}}
2018-04-17 21:59:56,354 [salt.state       ][INFO    ][10301] Completed state [HA] at time 21:59:56.354024 duration_in_ms=2635.519
2018-04-17 21:59:56,356 [salt.state       ][INFO    ][10301] Running state [guest] at time 21:59:56.356833
2018-04-17 21:59:56,357 [salt.state       ][INFO    ][10301] Executing state rabbitmq_user.present for guest
2018-04-17 21:59:56,359 [salt.loaded.int.module.cmdmod][INFO    ][10301] Executing command ['rabbitmqctl', 'list_users'] as user 'root' in directory '/root'
2018-04-17 21:59:57,630 [salt.loaded.int.module.cmdmod][INFO    ][10301] Executing command ['rabbitmqctl', 'status'] as user 'root' in directory '/root'
2018-04-17 21:59:58,648 [salt.minion      ][INFO    ][2074] User sudo_ubuntu Executing command saltutil.find_job with jid 20180417215958628630
2018-04-17 21:59:58,670 [salt.minion      ][INFO    ][15568] Starting a new job with PID 15568
2018-04-17 21:59:58,689 [salt.minion      ][INFO    ][15568] Returning information for job: 20180417215958628630
2018-04-17 22:00:01,681 [salt.loaded.int.module.cmdmod][INFO    ][10301] Executing command ['rabbitmqctl', 'list_user_permissions', 'guest'] as user 'root' in directory '/root'
2018-04-17 22:00:02,949 [salt.state       ][INFO    ][10301] Made the following changes:
'password' changed from 'absent' to 'Set password.'

2018-04-17 22:00:02,950 [salt.state       ][INFO    ][10301] Completed state [guest] at time 22:00:02.950632 duration_in_ms=6593.798
2018-04-17 22:00:02,951 [salt.state       ][INFO    ][10301] Running state [HA] at time 22:00:02.951878
2018-04-17 22:00:02,952 [salt.state       ][INFO    ][10301] Executing state rabbitmq_policy.present for HA
2018-04-17 22:00:02,954 [salt.loaded.int.module.cmdmod][INFO    ][10301] Executing command ['rabbitmqctl', 'list_policies', '-p', '/'] as user 'root' in directory '/root'
2018-04-17 22:00:04,158 [salt.loaded.int.module.cmdmod][INFO    ][10301] Executing command ['rabbitmqctl', 'set_policy', '-p', '/', 'HA', '^(?!amq\\.).*', '{"ha-mode": "all", "message-ttl": 120000}'] as user 'root' in directory '/root'
2018-04-17 22:00:05,490 [salt.state       ][INFO    ][10301] {'new': 'HA', 'old': {}}
2018-04-17 22:00:05,491 [salt.state       ][INFO    ][10301] Completed state [HA] at time 22:00:05.491438 duration_in_ms=2539.559
2018-04-17 22:00:05,493 [salt.state       ][INFO    ][10301] Running state [admin] at time 22:00:05.493169
2018-04-17 22:00:05,494 [salt.state       ][INFO    ][10301] Executing state rabbitmq_user.present for admin
2018-04-17 22:00:05,496 [salt.loaded.int.module.cmdmod][INFO    ][10301] Executing command ['rabbitmqctl', 'list_users'] as user 'root' in directory '/root'
2018-04-17 22:00:08,131 [salt.loaded.int.module.cmdmod][INFO    ][10301] Executing command ['rabbitmqctl', 'list_users'] as user 'root' in directory '/root'
2018-04-17 22:00:08,672 [salt.minion      ][INFO    ][2074] User sudo_ubuntu Executing command saltutil.find_job with jid 20180417220008656521
2018-04-17 22:00:08,696 [salt.minion      ][INFO    ][17241] Starting a new job with PID 17241
2018-04-17 22:00:08,724 [salt.minion      ][INFO    ][17241] Returning information for job: 20180417220008656521
2018-04-17 22:00:09,417 [salt.loaded.int.module.cmdmod][INFO    ][10301] Executing command ['rabbitmqctl', 'set_user_tags', 'admin', 'administrator'] as user 'root' in directory '/root'
2018-04-17 22:00:10,730 [salt.loaded.int.module.cmdmod][INFO    ][10301] Executing command ['rabbitmqctl', 'list_user_permissions', 'admin'] as user 'root' in directory '/root'
2018-04-17 22:00:12,066 [salt.loaded.int.module.cmdmod][INFO    ][10301] Executing command ['rabbitmqctl', 'set_permissions', '-p', '/openstack', 'admin', '.*', '.*', '.*'] as user 'root' in directory '/root'
2018-04-17 22:00:13,420 [salt.loaded.int.module.cmdmod][INFO    ][10301] Executing command ['rabbitmqctl', 'set_permissions', '-p', '/', 'admin', '.*', '.*', '.*'] as user 'root' in directory '/root'
2018-04-17 22:00:14,748 [salt.state       ][INFO    ][10301] Made the following changes:
'perms' changed from 'absent' to '{'/openstack': ['.*', '.*', '.*'], '/': ['.*', '.*', '.*']}'
'user' changed from 'absent' to 'admin'
'tags' changed from '['']' to '['administrator']'

2018-04-17 22:00:14,749 [salt.state       ][INFO    ][10301] Completed state [admin] at time 22:00:14.749006 duration_in_ms=9255.836
2018-04-17 22:00:14,751 [salt.state       ][INFO    ][10301] Running state [rabbitmqctl set_cluster_name openstack && echo "openstack" > /var/lib/rabbitmq/.cluster_name
] at time 22:00:14.751115
2018-04-17 22:00:14,751 [salt.state       ][INFO    ][10301] Executing state cmd.run for rabbitmqctl set_cluster_name openstack && echo "openstack" > /var/lib/rabbitmq/.cluster_name

2018-04-17 22:00:14,753 [salt.loaded.int.module.cmdmod][INFO    ][10301] Executing command 'rabbitmqctl set_cluster_name openstack && echo "openstack" > /var/lib/rabbitmq/.cluster_name
' in directory '/root'
2018-04-17 22:00:15,893 [salt.state       ][INFO    ][10301] {'pid': 18162, 'retcode': 0, 'stderr': '', 'stdout': 'Setting cluster name to openstack'}
2018-04-17 22:00:15,897 [salt.state       ][INFO    ][10301] Completed state [rabbitmqctl set_cluster_name openstack && echo "openstack" > /var/lib/rabbitmq/.cluster_name
] at time 22:00:15.896337 duration_in_ms=1145.221
2018-04-17 22:00:15,903 [salt.minion      ][INFO    ][10301] Returning information for job: 20180417215716768942
2018-04-17 22:00:16,543 [salt.minion      ][INFO    ][2074] User sudo_ubuntu Executing command state.sls with jid 20180417220016533153
2018-04-17 22:00:16,565 [salt.minion      ][INFO    ][18365] Starting a new job with PID 18365
2018-04-17 22:00:19,048 [salt.state       ][INFO    ][18365] Loading fresh modules for state activity
2018-04-17 22:00:19,196 [salt.loaded.int.module.cmdmod][INFO    ][18365] Executing command 'cat /var/lib/rabbitmq/.erlang.cookie' in directory '/root'
2018-04-17 22:00:20,019 [salt.state       ][INFO    ][18365] Running state [rabbitmq-server] at time 22:00:20.019406
2018-04-17 22:00:20,019 [salt.state       ][INFO    ][18365] Executing state pkg.installed for rabbitmq-server
2018-04-17 22:00:20,020 [salt.loaded.int.module.cmdmod][INFO    ][18365] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2018-04-17 22:00:20,439 [salt.state       ][INFO    ][18365] All specified packages are already installed
2018-04-17 22:00:20,440 [salt.state       ][INFO    ][18365] Completed state [rabbitmq-server] at time 22:00:20.440343 duration_in_ms=420.938
2018-04-17 22:00:20,443 [salt.state       ][INFO    ][18365] Running state [/etc/rabbitmq/rabbitmq.config] at time 22:00:20.443831
2018-04-17 22:00:20,444 [salt.state       ][INFO    ][18365] Executing state file.managed for /etc/rabbitmq/rabbitmq.config
2018-04-17 22:00:20,509 [salt.state       ][INFO    ][18365] File /etc/rabbitmq/rabbitmq.config is in the correct state
2018-04-17 22:00:20,509 [salt.state       ][INFO    ][18365] Completed state [/etc/rabbitmq/rabbitmq.config] at time 22:00:20.509250 duration_in_ms=65.419
2018-04-17 22:00:20,509 [salt.state       ][INFO    ][18365] Running state [/etc/default/rabbitmq-server] at time 22:00:20.509510
2018-04-17 22:00:20,509 [salt.state       ][INFO    ][18365] Executing state file.managed for /etc/default/rabbitmq-server
2018-04-17 22:00:20,545 [salt.state       ][INFO    ][18365] File /etc/default/rabbitmq-server is in the correct state
2018-04-17 22:00:20,545 [salt.state       ][INFO    ][18365] Completed state [/etc/default/rabbitmq-server] at time 22:00:20.545294 duration_in_ms=35.783
2018-04-17 22:00:20,545 [salt.state       ][INFO    ][18365] Running state [/etc/systemd/system/rabbitmq-server.service.d/limits.conf] at time 22:00:20.545548
2018-04-17 22:00:20,545 [salt.state       ][INFO    ][18365] Executing state file.managed for /etc/systemd/system/rabbitmq-server.service.d/limits.conf
2018-04-17 22:00:20,581 [salt.state       ][INFO    ][18365] File /etc/systemd/system/rabbitmq-server.service.d/limits.conf is in the correct state
2018-04-17 22:00:20,581 [salt.state       ][INFO    ][18365] Completed state [/etc/systemd/system/rabbitmq-server.service.d/limits.conf] at time 22:00:20.581791 duration_in_ms=36.243
2018-04-17 22:00:20,582 [salt.state       ][INFO    ][18365] Running state [rabbitmq-server] at time 22:00:20.582606
2018-04-17 22:00:20,582 [salt.state       ][INFO    ][18365] Executing state service.running for rabbitmq-server
2018-04-17 22:00:20,583 [salt.loaded.int.module.cmdmod][INFO    ][18365] Executing command ['systemctl', 'status', 'rabbitmq-server.service', '-n', '0'] in directory '/root'
2018-04-17 22:00:20,631 [salt.loaded.int.module.cmdmod][INFO    ][18365] Executing command ['systemctl', 'is-active', 'rabbitmq-server.service'] in directory '/root'
2018-04-17 22:00:20,656 [salt.loaded.int.module.cmdmod][INFO    ][18365] Executing command ['systemctl', 'is-enabled', 'rabbitmq-server.service'] in directory '/root'
2018-04-17 22:00:20,682 [salt.state       ][INFO    ][18365] The service rabbitmq-server is already running
2018-04-17 22:00:20,683 [salt.state       ][INFO    ][18365] Completed state [rabbitmq-server] at time 22:00:20.683370 duration_in_ms=100.762
2018-04-17 22:00:20,688 [salt.state       ][INFO    ][18365] Running state [amqp_client] at time 22:00:20.688782
2018-04-17 22:00:20,689 [salt.state       ][INFO    ][18365] Executing state rabbitmq_plugin.enabled for amqp_client
2018-04-17 22:00:20,691 [salt.loaded.int.module.cmdmod][INFO    ][18365] Executing command ['/usr/sbin/rabbitmq-plugins', 'list', '-m', '-e'] as user 'root' in directory '/root'
2018-04-17 22:00:21,974 [salt.state       ][INFO    ][18365] Plugin 'amqp_client' is already enabled.
2018-04-17 22:00:21,976 [salt.state       ][INFO    ][18365] Completed state [amqp_client] at time 22:00:21.975968 duration_in_ms=1287.185
2018-04-17 22:00:21,977 [salt.state       ][INFO    ][18365] Running state [rabbitmq_management] at time 22:00:21.977881
2018-04-17 22:00:21,979 [salt.state       ][INFO    ][18365] Executing state rabbitmq_plugin.enabled for rabbitmq_management
2018-04-17 22:00:21,981 [salt.loaded.int.module.cmdmod][INFO    ][18365] Executing command ['/usr/sbin/rabbitmq-plugins', 'list', '-m', '-e'] as user 'root' in directory '/root'
2018-04-17 22:00:22,976 [salt.state       ][INFO    ][18365] Plugin 'rabbitmq_management' is already enabled.
2018-04-17 22:00:22,977 [salt.state       ][INFO    ][18365] Completed state [rabbitmq_management] at time 22:00:22.976997 duration_in_ms=999.116
2018-04-17 22:00:22,978 [salt.state       ][INFO    ][18365] Running state [/openstack] at time 22:00:22.978813
2018-04-17 22:00:22,979 [salt.state       ][INFO    ][18365] Executing state rabbitmq_vhost.present for /openstack
2018-04-17 22:00:22,979 [salt.loaded.int.module.cmdmod][INFO    ][18365] Executing command 'rabbitmqctl list_vhosts -q' as user 'root' in directory '/root'
2018-04-17 22:00:24,279 [salt.state       ][INFO    ][18365] Virtual Host '/openstack' already exists.
2018-04-17 22:00:24,281 [salt.state       ][INFO    ][18365] Completed state [/openstack] at time 22:00:24.281171 duration_in_ms=1302.356
2018-04-17 22:00:24,288 [salt.state       ][INFO    ][18365] Running state [openstack] at time 22:00:24.288417
2018-04-17 22:00:24,289 [salt.state       ][INFO    ][18365] Executing state rabbitmq_user.present for openstack
2018-04-17 22:00:24,290 [salt.loaded.int.module.cmdmod][INFO    ][18365] Executing command ['rabbitmqctl', 'list_users'] as user 'root' in directory '/root'
2018-04-17 22:00:25,545 [salt.loaded.int.module.cmdmod][INFO    ][18365] Executing command ['rabbitmqctl', 'status'] as user 'root' in directory '/root'
2018-04-17 22:00:26,640 [salt.minion      ][INFO    ][2074] User sudo_ubuntu Executing command saltutil.find_job with jid 20180417220026624614
2018-04-17 22:00:26,665 [salt.minion      ][INFO    ][19411] Starting a new job with PID 19411
2018-04-17 22:00:26,694 [salt.minion      ][INFO    ][19411] Returning information for job: 20180417220026624614
2018-04-17 22:00:29,516 [salt.loaded.int.module.cmdmod][INFO    ][18365] Executing command ['rabbitmqctl', 'list_user_permissions', 'openstack'] as user 'root' in directory '/root'
2018-04-17 22:00:30,838 [salt.state       ][INFO    ][18365] Made the following changes:
'password' changed from 'absent' to 'Set password.'

2018-04-17 22:00:30,839 [salt.state       ][INFO    ][18365] Completed state [openstack] at time 22:00:30.839466 duration_in_ms=6551.048
2018-04-17 22:00:30,844 [salt.state       ][INFO    ][18365] Running state [Ceilometer] at time 22:00:30.844166
2018-04-17 22:00:30,844 [salt.state       ][INFO    ][18365] Executing state rabbitmq_policy.present for Ceilometer
2018-04-17 22:00:30,846 [salt.loaded.int.module.cmdmod][INFO    ][18365] Executing command ['rabbitmqctl', 'list_policies', '-p', '/openstack'] as user 'root' in directory '/root'
2018-04-17 22:00:32,128 [salt.loaded.int.module.cmdmod][INFO    ][18365] Executing command ['rabbitmqctl', 'set_policy', '-p', '/openstack', '--priority', 10, 'Ceilometer', '^metering.sample$', '{"ha-mode": "all", "message-ttl": 10800000}'] as user 'root' in directory '/root'
2018-04-17 22:00:33,504 [salt.state       ][INFO    ][18365] {'new': ['Definition'], 'old': {'apply_to': 'all', 'priority': '10', 'definition': '{"ha-mode":"all","message-ttl":10800000}', 'pattern': '^metering.sample$'}}
2018-04-17 22:00:33,506 [salt.state       ][INFO    ][18365] Completed state [Ceilometer] at time 22:00:33.506495 duration_in_ms=2662.328
2018-04-17 22:00:33,508 [salt.state       ][INFO    ][18365] Running state [HA] at time 22:00:33.508244
2018-04-17 22:00:33,509 [salt.state       ][INFO    ][18365] Executing state rabbitmq_policy.present for HA
2018-04-17 22:00:33,512 [salt.loaded.int.module.cmdmod][INFO    ][18365] Executing command ['rabbitmqctl', 'list_policies', '-p', '/openstack'] as user 'root' in directory '/root'
2018-04-17 22:00:34,752 [salt.loaded.int.module.cmdmod][INFO    ][18365] Executing command ['rabbitmqctl', 'set_policy', '-p', '/openstack', 'HA', '^(?!amq\\.).*', '{"ha-mode": "all", "message-ttl": 120000}'] as user 'root' in directory '/root'
2018-04-17 22:00:36,064 [salt.state       ][INFO    ][18365] {'new': ['Pattern', 'Definition'], 'old': {'apply_to': 'all', 'priority': '0', 'definition': '{"ha-mode":"all","message-ttl":120000}', 'pattern': '^(?!amq\\\\.).*'}}
2018-04-17 22:00:36,065 [salt.state       ][INFO    ][18365] Completed state [HA] at time 22:00:36.065717 duration_in_ms=2557.478
2018-04-17 22:00:36,066 [salt.state       ][INFO    ][18365] Running state [guest] at time 22:00:36.066904
2018-04-17 22:00:36,067 [salt.state       ][INFO    ][18365] Executing state rabbitmq_user.present for guest
2018-04-17 22:00:36,070 [salt.loaded.int.module.cmdmod][INFO    ][18365] Executing command ['rabbitmqctl', 'list_users'] as user 'root' in directory '/root'
2018-04-17 22:00:36,669 [salt.minion      ][INFO    ][2074] User sudo_ubuntu Executing command saltutil.find_job with jid 20180417220036652416
2018-04-17 22:00:36,692 [salt.minion      ][INFO    ][21101] Starting a new job with PID 21101
2018-04-17 22:00:36,717 [salt.minion      ][INFO    ][21101] Returning information for job: 20180417220036652416
2018-04-17 22:00:37,423 [salt.loaded.int.module.cmdmod][INFO    ][18365] Executing command ['rabbitmqctl', 'status'] as user 'root' in directory '/root'
2018-04-17 22:00:41,248 [salt.loaded.int.module.cmdmod][INFO    ][18365] Executing command ['rabbitmqctl', 'list_user_permissions', 'guest'] as user 'root' in directory '/root'
2018-04-17 22:00:42,565 [salt.state       ][INFO    ][18365] Made the following changes:
'password' changed from 'absent' to 'Set password.'

2018-04-17 22:00:42,566 [salt.state       ][INFO    ][18365] Completed state [guest] at time 22:00:42.566575 duration_in_ms=6499.671
2018-04-17 22:00:42,567 [salt.state       ][INFO    ][18365] Running state [HA] at time 22:00:42.567511
2018-04-17 22:00:42,568 [salt.state       ][INFO    ][18365] Executing state rabbitmq_policy.present for HA
2018-04-17 22:00:42,569 [salt.loaded.int.module.cmdmod][INFO    ][18365] Executing command ['rabbitmqctl', 'list_policies', '-p', '/'] as user 'root' in directory '/root'
2018-04-17 22:00:43,895 [salt.loaded.int.module.cmdmod][INFO    ][18365] Executing command ['rabbitmqctl', 'set_policy', '-p', '/', 'HA', '^(?!amq\\.).*', '{"ha-mode": "all", "message-ttl": 120000}'] as user 'root' in directory '/root'
2018-04-17 22:00:45,170 [salt.state       ][INFO    ][18365] {'new': ['Pattern', 'Definition'], 'old': {'apply_to': 'all', 'priority': '0', 'definition': '{"ha-mode":"all","message-ttl":120000}', 'pattern': '^(?!amq\\\\.).*'}}
2018-04-17 22:00:45,171 [salt.state       ][INFO    ][18365] Completed state [HA] at time 22:00:45.171270 duration_in_ms=2603.756
2018-04-17 22:00:45,172 [salt.state       ][INFO    ][18365] Running state [admin] at time 22:00:45.172851
2018-04-17 22:00:45,173 [salt.state       ][INFO    ][18365] Executing state rabbitmq_user.present for admin
2018-04-17 22:00:45,176 [salt.loaded.int.module.cmdmod][INFO    ][18365] Executing command ['rabbitmqctl', 'list_users'] as user 'root' in directory '/root'
2018-04-17 22:00:46,483 [salt.loaded.int.module.cmdmod][INFO    ][18365] Executing command ['rabbitmqctl', 'status'] as user 'root' in directory '/root'
2018-04-17 22:00:46,896 [salt.minion      ][INFO    ][2074] User sudo_ubuntu Executing command saltutil.find_job with jid 20180417220046880739
2018-04-17 22:00:46,916 [salt.minion      ][INFO    ][22806] Starting a new job with PID 22806
2018-04-17 22:00:46,943 [salt.minion      ][INFO    ][22806] Returning information for job: 20180417220046880739
2018-04-17 22:00:50,318 [salt.loaded.int.module.cmdmod][INFO    ][18365] Executing command ['rabbitmqctl', 'list_users'] as user 'root' in directory '/root'
2018-04-17 22:00:51,594 [salt.loaded.int.module.cmdmod][INFO    ][18365] Executing command ['rabbitmqctl', 'list_user_permissions', 'admin'] as user 'root' in directory '/root'
2018-04-17 22:00:52,824 [salt.state       ][INFO    ][18365] Made the following changes:
'password' changed from 'absent' to 'Set password.'

2018-04-17 22:00:52,825 [salt.state       ][INFO    ][18365] Completed state [admin] at time 22:00:52.825200 duration_in_ms=7652.347
2018-04-17 22:00:52,830 [salt.state       ][INFO    ][18365] Running state [rabbitmqctl set_cluster_name openstack && echo "openstack" > /var/lib/rabbitmq/.cluster_name
] at time 22:00:52.830891
2018-04-17 22:00:52,831 [salt.state       ][INFO    ][18365] Executing state cmd.run for rabbitmqctl set_cluster_name openstack && echo "openstack" > /var/lib/rabbitmq/.cluster_name

2018-04-17 22:00:52,832 [salt.state       ][INFO    ][18365] /var/lib/rabbitmq/.cluster_name exists
2018-04-17 22:00:52,833 [salt.state       ][INFO    ][18365] Completed state [rabbitmqctl set_cluster_name openstack && echo "openstack" > /var/lib/rabbitmq/.cluster_name
] at time 22:00:52.833169 duration_in_ms=2.279
2018-04-17 22:00:52,836 [salt.minion      ][INFO    ][18365] Returning information for job: 20180417220016533153
2018-04-17 22:03:00,869 [salt.minion      ][INFO    ][2074] User sudo_ubuntu Executing command cmd.run with jid 20180417220300859254
2018-04-17 22:03:00,892 [salt.minion      ][INFO    ][23744] Starting a new job with PID 23744
2018-04-17 22:03:00,903 [salt.loader.192.168.11.2.int.module.cmdmod][INFO    ][23744] Executing command 'rabbitmqctl cluster_status' in directory '/root'
2018-04-17 22:03:02,134 [salt.minion      ][INFO    ][23744] Returning information for job: 20180417220300859254
2018-04-17 22:09:16,443 [salt.minion      ][INFO    ][2074] User sudo_ubuntu Executing command state.sls with jid 20180417220916430930
2018-04-17 22:09:16,474 [salt.minion      ][INFO    ][24038] Starting a new job with PID 24038
2018-04-17 22:09:17,164 [salt.state       ][INFO    ][24038] Loading fresh modules for state activity
2018-04-17 22:09:17,217 [salt.fileclient  ][INFO    ][24038] Fetching file from saltenv 'base', ** done ** 'haproxy/init.sls'
2018-04-17 22:09:17,246 [salt.fileclient  ][INFO    ][24038] Fetching file from saltenv 'base', ** done ** 'haproxy/proxy.sls'
2018-04-17 22:09:18,180 [salt.state       ][INFO    ][24038] Running state [haproxy] at time 22:09:18.180783
2018-04-17 22:09:18,181 [salt.state       ][INFO    ][24038] Executing state pkg.installed for haproxy
2018-04-17 22:09:18,182 [salt.loaded.int.module.cmdmod][INFO    ][24038] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2018-04-17 22:09:18,595 [salt.loaded.int.module.cmdmod][INFO    ][24038] Executing command ['apt-cache', '-q', 'policy', 'haproxy'] in directory '/root'
2018-04-17 22:09:18,707 [salt.loaded.int.module.cmdmod][INFO    ][24038] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2018-04-17 22:09:20,369 [salt.loaded.int.module.cmdmod][INFO    ][24038] Executing command ['dpkg', '--get-selections', '*'] in directory '/root'
2018-04-17 22:09:20,414 [salt.loaded.int.module.cmdmod][INFO    ][24038] 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-04-17 22:09:26,536 [salt.minion      ][INFO    ][2074] User sudo_ubuntu Executing command saltutil.find_job with jid 20180417220926526489
2018-04-17 22:09:26,567 [salt.minion      ][INFO    ][24737] Starting a new job with PID 24737
2018-04-17 22:09:26,604 [salt.minion      ][INFO    ][24737] Returning information for job: 20180417220926526489
2018-04-17 22:09:29,170 [salt.loaded.int.module.cmdmod][INFO    ][24038] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2018-04-17 22:09:29,207 [salt.state       ][INFO    ][24038] 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-04-17 22:09:29,219 [salt.state       ][INFO    ][24038] Loading fresh modules for state activity
2018-04-17 22:09:29,236 [salt.state       ][INFO    ][24038] Completed state [haproxy] at time 22:09:29.236930 duration_in_ms=11056.148
2018-04-17 22:09:29,239 [salt.state       ][INFO    ][24038] Running state [/etc/default/haproxy] at time 22:09:29.239458
2018-04-17 22:09:29,239 [salt.state       ][INFO    ][24038] Executing state file.managed for /etc/default/haproxy
2018-04-17 22:09:29,282 [salt.fileclient  ][INFO    ][24038] Fetching file from saltenv 'base', ** done ** 'haproxy/files/haproxy.default'
2018-04-17 22:09:29,289 [salt.state       ][INFO    ][24038] 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-04-17 22:09:29,292 [salt.state       ][INFO    ][24038] Completed state [/etc/default/haproxy] at time 22:09:29.292525 duration_in_ms=53.067
2018-04-17 22:09:29,292 [salt.state       ][INFO    ][24038] Running state [/etc/haproxy/haproxy.cfg] at time 22:09:29.292846
2018-04-17 22:09:29,293 [salt.state       ][INFO    ][24038] Executing state file.managed for /etc/haproxy/haproxy.cfg
2018-04-17 22:09:29,315 [salt.fileclient  ][INFO    ][24038] Fetching file from saltenv 'base', ** done ** 'haproxy/files/haproxy.cfg'
2018-04-17 22:09:29,444 [salt.state       ][INFO    ][24038] 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 10.167.4.27:5672 
+  balance roundrobin
+  mode tcp
+  option tcpka
+  timeout client 300s
+  timeout server 300s
+  server msg01 10.167.4.28:5672 check inter 5000 rise 2 fall 3
+  server msg02 10.167.4.29:5672 backup check inter 5000 rise 2 fall 3
+  server msg03 10.167.4.30:5672 backup check inter 5000 rise 2 fall 3

2018-04-17 22:09:29,444 [salt.state       ][INFO    ][24038] Completed state [/etc/haproxy/haproxy.cfg] at time 22:09:29.444848 duration_in_ms=152.002
2018-04-17 22:09:29,445 [salt.state       ][INFO    ][24038] Running state [/etc/haproxy/ssl] at time 22:09:29.445089
2018-04-17 22:09:29,445 [salt.state       ][INFO    ][24038] Executing state file.directory for /etc/haproxy/ssl
2018-04-17 22:09:29,446 [salt.state       ][INFO    ][24038] {'/etc/haproxy/ssl': 'New Dir'}
2018-04-17 22:09:29,446 [salt.state       ][INFO    ][24038] Completed state [/etc/haproxy/ssl] at time 22:09:29.446365 duration_in_ms=1.277
2018-04-17 22:09:29,446 [salt.state       ][INFO    ][24038] Running state [/etc/haproxy/errors/429.http11] at time 22:09:29.446630
2018-04-17 22:09:29,446 [salt.state       ][INFO    ][24038] Executing state file.managed for /etc/haproxy/errors/429.http11
2018-04-17 22:09:29,464 [salt.fileclient  ][INFO    ][24038] Fetching file from saltenv 'base', ** done ** 'haproxy/files/errors/429.http11'
2018-04-17 22:09:29,469 [salt.state       ][INFO    ][24038] File changed:
New file
2018-04-17 22:09:29,469 [salt.state       ][INFO    ][24038] Completed state [/etc/haproxy/errors/429.http11] at time 22:09:29.469552 duration_in_ms=22.922
2018-04-17 22:09:29,470 [salt.state       ][INFO    ][24038] Running state [haproxy_status_packages] at time 22:09:29.470476
2018-04-17 22:09:29,470 [salt.state       ][INFO    ][24038] Executing state pkg.installed for haproxy_status_packages
2018-04-17 22:09:29,739 [salt.state       ][INFO    ][24038] All specified packages are already installed
2018-04-17 22:09:29,739 [salt.state       ][INFO    ][24038] Completed state [haproxy_status_packages] at time 22:09:29.739847 duration_in_ms=269.37
2018-04-17 22:09:29,740 [salt.state       ][INFO    ][24038] Running state [/usr/bin/haproxy-status.sh] at time 22:09:29.740514
2018-04-17 22:09:29,740 [salt.state       ][INFO    ][24038] Executing state file.managed for /usr/bin/haproxy-status.sh
2018-04-17 22:09:29,758 [salt.fileclient  ][INFO    ][24038] Fetching file from saltenv 'base', ** done ** 'haproxy/files/haproxy-status.sh'
2018-04-17 22:09:29,778 [salt.state       ][INFO    ][24038] File changed:
New file
2018-04-17 22:09:29,778 [salt.state       ][INFO    ][24038] Completed state [/usr/bin/haproxy-status.sh] at time 22:09:29.778673 duration_in_ms=38.159
2018-04-17 22:09:29,779 [salt.state       ][INFO    ][24038] Running state [net.ipv4.ip_nonlocal_bind] at time 22:09:29.779228
2018-04-17 22:09:29,779 [salt.state       ][INFO    ][24038] Executing state sysctl.present for net.ipv4.ip_nonlocal_bind
2018-04-17 22:09:29,780 [salt.loaded.int.module.cmdmod][INFO    ][24038] Executing command 'sysctl -a' in directory '/root'
2018-04-17 22:09:29,803 [salt.loaded.int.module.cmdmod][INFO    ][24038] Executing command 'sysctl -w net.ipv4.ip_nonlocal_bind="1"' in directory '/root'
2018-04-17 22:09:29,814 [salt.state       ][INFO    ][24038] {'net.ipv4.ip_nonlocal_bind': 1}
2018-04-17 22:09:29,815 [salt.state       ][INFO    ][24038] Completed state [net.ipv4.ip_nonlocal_bind] at time 22:09:29.815161 duration_in_ms=35.933
2018-04-17 22:09:29,816 [salt.state       ][INFO    ][24038] Running state [haproxy] at time 22:09:29.816448
2018-04-17 22:09:29,816 [salt.state       ][INFO    ][24038] Executing state service.running for haproxy
2018-04-17 22:09:29,817 [salt.loaded.int.module.cmdmod][INFO    ][24038] Executing command ['systemctl', 'status', 'haproxy.service', '-n', '0'] in directory '/root'
2018-04-17 22:09:29,829 [salt.loaded.int.module.cmdmod][INFO    ][24038] Executing command ['systemctl', 'is-active', 'haproxy.service'] in directory '/root'
2018-04-17 22:09:29,840 [salt.loaded.int.module.cmdmod][INFO    ][24038] Executing command ['systemctl', 'is-enabled', 'haproxy.service'] in directory '/root'
2018-04-17 22:09:29,851 [salt.state       ][INFO    ][24038] The service haproxy is already running
2018-04-17 22:09:29,852 [salt.state       ][INFO    ][24038] Completed state [haproxy] at time 22:09:29.852568 duration_in_ms=36.119
2018-04-17 22:09:29,853 [salt.state       ][INFO    ][24038] Running state [haproxy] at time 22:09:29.853075
2018-04-17 22:09:29,853 [salt.state       ][INFO    ][24038] Executing state service.mod_watch for haproxy
2018-04-17 22:09:29,854 [salt.loaded.int.module.cmdmod][INFO    ][24038] Executing command ['systemctl', 'is-active', 'haproxy.service'] in directory '/root'
2018-04-17 22:09:29,866 [salt.loaded.int.module.cmdmod][INFO    ][24038] Executing command ['systemctl', 'is-enabled', 'haproxy.service'] in directory '/root'
2018-04-17 22:09:29,878 [salt.loaded.int.module.cmdmod][INFO    ][24038] Executing command ['systemd-run', '--scope', 'systemctl', 'restart', 'haproxy.service'] in directory '/root'
2018-04-17 22:09:29,940 [salt.state       ][INFO    ][24038] {'haproxy': True}
2018-04-17 22:09:29,941 [salt.state       ][INFO    ][24038] Completed state [haproxy] at time 22:09:29.941162 duration_in_ms=88.087
2018-04-17 22:09:29,942 [salt.minion      ][INFO    ][24038] Returning information for job: 20180417220916430930
2018-04-17 22:09:34,182 [salt.minion      ][INFO    ][2074] User sudo_ubuntu Executing command service.status with jid 20180417220934171882
2018-04-17 22:09:34,204 [salt.minion      ][INFO    ][24965] Starting a new job with PID 24965
2018-04-17 22:09:34,282 [salt.loader.192.168.11.2.int.module.cmdmod][INFO    ][24965] Executing command ['systemctl', 'status', 'haproxy.service', '-n', '0'] in directory '/root'
2018-04-17 22:09:34,304 [salt.loader.192.168.11.2.int.module.cmdmod][INFO    ][24965] Executing command ['systemctl', 'is-active', 'haproxy.service'] in directory '/root'
2018-04-17 22:09:34,321 [salt.minion      ][INFO    ][24965] Returning information for job: 20180417220934171882
2018-04-17 22:09:35,452 [salt.minion      ][INFO    ][2074] User sudo_ubuntu Executing command service.restart with jid 20180417220935442229
2018-04-17 22:09:35,478 [salt.minion      ][INFO    ][24972] Starting a new job with PID 24972
2018-04-17 22:09:35,559 [salt.loader.192.168.11.2.int.module.cmdmod][INFO    ][24972] Executing command ['systemctl', 'status', 'rsyslog.service', '-n', '0'] in directory '/root'
2018-04-17 22:09:35,584 [salt.loader.192.168.11.2.int.module.cmdmod][INFO    ][24972] Executing command ['systemctl', 'is-enabled', 'rsyslog.service'] in directory '/root'
2018-04-17 22:09:35,623 [salt.loader.192.168.11.2.int.module.cmdmod][INFO    ][24972] Executing command ['systemd-run', '--scope', 'systemctl', 'restart', 'rsyslog.service'] in directory '/root'
2018-04-17 22:09:35,681 [salt.minion      ][INFO    ][24972] Returning information for job: 20180417220935442229
2018-04-17 22:45:42,782 [salt.utils.schedule][INFO    ][2074] Running scheduled job: __mine_interval
2018-04-17 23:04:58,571 [salt.minion      ][INFO    ][2074] User sudo_ubuntu Executing command cp.push_dir with jid 20180417230458560852
2018-04-17 23:04:58,594 [salt.minion      ][INFO    ][25788] Starting a new job with PID 25788
