2018-04-20 18:59:20,946 [salt.loaded.int.module.cmdmod][ERROR   ][1454] Command 'rabbitmqctl cluster_status' failed with return code: 127
2018-04-20 18:59:20,946 [salt.loaded.int.module.cmdmod][ERROR   ][1454] output: /bin/sh: 1: rabbitmqctl: not found
2018-04-20 18:59:20,972 [salt.loaded.int.module.cmdmod][ERROR   ][1454] Command 'rabbitmqctl cluster_status' failed with return code: 127
2018-04-20 18:59:20,973 [salt.loaded.int.module.cmdmod][ERROR   ][1454] output: /bin/sh: 1: rabbitmqctl: not found
2018-04-20 18:59:22,495 [salt.loaded.int.module.cmdmod][ERROR   ][1454] Command 'rabbitmqctl cluster_status' failed with return code: 127
2018-04-20 18:59:22,496 [salt.loaded.int.module.cmdmod][ERROR   ][1454] output: /bin/sh: 1: rabbitmqctl: not found
2018-04-20 18:59:22,525 [salt.loaded.int.module.cmdmod][ERROR   ][1454] Command 'rabbitmqctl cluster_status' failed with return code: 127
2018-04-20 18:59:22,526 [salt.loaded.int.module.cmdmod][ERROR   ][1454] output: /bin/sh: 1: rabbitmqctl: not found
2018-04-20 18:59:36,304 [salt.loaded.int.module.cmdmod][ERROR   ][1454] 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-20 18:59:39,282 [salt.loaded.int.module.cmdmod][INFO    ][1976] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2018-04-20 18:59:39,300 [salt.loaded.int.module.cmdmod][INFO    ][1976] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2018-04-20 18:59:39,329 [salt.loaded.int.module.cmdmod][INFO    ][1976] Executing command ['systemd-run', '--scope', 'systemctl', 'restart', 'salt-minion.service'] in directory '/root'
2018-04-20 18:59:39,373 [salt.utils.parsers][WARNING ][1230] Minion received a SIGTERM. Exiting.
2018-04-20 18:59:39,801 [salt.cli.daemons ][INFO    ][2025] Setting up the Salt Minion "msg01.mcp-pike-odl-ha.local"
2018-04-20 18:59:39,916 [salt.cli.daemons ][INFO    ][2025] Starting up the Salt Minion
2018-04-20 18:59:39,917 [salt.utils.event ][INFO    ][2025] Starting pull socket on /var/run/salt/minion/minion_event_80d0aa2101_pull.ipc
2018-04-20 18:59:40,438 [salt.minion      ][INFO    ][2025] Creating minion process manager
2018-04-20 18:59:41,479 [salt.loader.192.168.11.2.int.module.cmdmod][INFO    ][2025] Executing command ['date', '+%z'] in directory '/root'
2018-04-20 18:59:41,505 [salt.utils.schedule][INFO    ][2025] Updating job settings for scheduled job: __mine_interval
2018-04-20 18:59:41,507 [salt.minion      ][INFO    ][2025] Added mine.update to scheduler
2018-04-20 18:59:41,513 [salt.minion      ][INFO    ][2025] Minion is starting as user 'root'
2018-04-20 18:59:41,533 [salt.minion      ][INFO    ][2025] Minion is ready to receive requests!
2018-04-20 18:59:42,534 [salt.utils.schedule][INFO    ][2025] Running scheduled job: __mine_interval
2018-04-20 19:00:05,409 [salt.minion      ][INFO    ][2025] User sudo_ubuntu Executing command state.apply with jid 20180420190005395557
2018-04-20 19:00:05,423 [salt.minion      ][INFO    ][2116] Starting a new job with PID 2116
2018-04-20 19:00:09,064 [salt.state       ][INFO    ][2116] Loading fresh modules for state activity
2018-04-20 19:00:09,939 [salt.fileclient  ][INFO    ][2116] Fetching file from saltenv 'base', ** done ** 'linux/init.sls'
2018-04-20 19:00:09,990 [salt.fileclient  ][INFO    ][2116] Fetching file from saltenv 'base', ** done ** 'linux/system/init.sls'
2018-04-20 19:00:10,129 [salt.fileclient  ][INFO    ][2116] Fetching file from saltenv 'base', ** done ** 'linux/system/env.sls'
2018-04-20 19:00:10,243 [salt.fileclient  ][INFO    ][2116] Fetching file from saltenv 'base', ** done ** 'linux/system/profile.sls'
2018-04-20 19:00:10,354 [salt.fileclient  ][INFO    ][2116] Fetching file from saltenv 'base', ** done ** 'linux/system/repo.sls'
2018-04-20 19:00:10,579 [salt.fileclient  ][INFO    ][2116] Fetching file from saltenv 'base', ** done ** 'linux/system/package.sls'
2018-04-20 19:00:10,700 [salt.fileclient  ][INFO    ][2116] Fetching file from saltenv 'base', ** done ** 'linux/system/timezone.sls'
2018-04-20 19:00:10,810 [salt.fileclient  ][INFO    ][2116] Fetching file from saltenv 'base', ** done ** 'linux/system/kernel.sls'
2018-04-20 19:00:10,960 [salt.fileclient  ][INFO    ][2116] Fetching file from saltenv 'base', ** done ** 'linux/system/cpu.sls'
2018-04-20 19:00:11,073 [salt.fileclient  ][INFO    ][2116] Fetching file from saltenv 'base', ** done ** 'linux/system/sysfs.sls'
2018-04-20 19:00:11,182 [salt.fileclient  ][INFO    ][2116] Fetching file from saltenv 'base', ** done ** 'linux/system/locale.sls'
2018-04-20 19:00:11,294 [salt.fileclient  ][INFO    ][2116] Fetching file from saltenv 'base', ** done ** 'linux/system/user.sls'
2018-04-20 19:00:11,429 [salt.fileclient  ][INFO    ][2116] Fetching file from saltenv 'base', ** done ** 'linux/system/group.sls'
2018-04-20 19:00:11,541 [salt.fileclient  ][INFO    ][2116] Fetching file from saltenv 'base', ** done ** 'linux/system/limit.sls'
2018-04-20 19:00:11,649 [salt.fileclient  ][INFO    ][2116] Fetching file from saltenv 'base', ** done ** 'linux/system/systemd.sls'
2018-04-20 19:00:11,752 [salt.fileclient  ][INFO    ][2116] Fetching file from saltenv 'base', ** done ** 'linux/system/apt.sls'
2018-04-20 19:00:11,864 [salt.fileclient  ][INFO    ][2116] Fetching file from saltenv 'base', ** done ** 'linux/network/init.sls'
2018-04-20 19:00:11,965 [salt.fileclient  ][INFO    ][2116] Fetching file from saltenv 'base', ** done ** 'linux/network/hostname.sls'
2018-04-20 19:00:12,068 [salt.fileclient  ][INFO    ][2116] Fetching file from saltenv 'base', ** done ** 'linux/network/host.sls'
2018-04-20 19:00:12,241 [salt.fileclient  ][INFO    ][2116] Fetching file from saltenv 'base', ** done ** 'linux/network/interface.sls'
2018-04-20 19:00:12,457 [salt.fileclient  ][INFO    ][2116] Fetching file from saltenv 'base', ** done ** 'linux/network/proxy.sls'
2018-04-20 19:00:12,572 [salt.fileclient  ][INFO    ][2116] Fetching file from saltenv 'base', ** done ** 'linux/storage/init.sls'
2018-04-20 19:00:12,693 [salt.fileclient  ][INFO    ][2116] Fetching file from saltenv 'base', ** done ** 'ntp/init.sls'
2018-04-20 19:00:12,715 [salt.fileclient  ][INFO    ][2116] Fetching file from saltenv 'base', ** done ** 'ntp/client.sls'
2018-04-20 19:00:12,764 [salt.fileclient  ][INFO    ][2116] Fetching file from saltenv 'base', ** done ** 'ntp/server.sls'
2018-04-20 19:00:12,818 [salt.state       ][INFO    ][2116] Running state [/etc/environment] at time 19:00:12.818145
2018-04-20 19:00:12,818 [salt.state       ][INFO    ][2116] Executing state file.blockreplace for /etc/environment
2018-04-20 19:00:12,829 [salt.state       ][INFO    ][2116] 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-20 19:00:12,830 [salt.state       ][INFO    ][2116] Completed state [/etc/environment] at time 19:00:12.830869 duration_in_ms=12.725
2018-04-20 19:00:12,831 [salt.state       ][INFO    ][2116] Running state [/etc/profile.d] at time 19:00:12.831355
2018-04-20 19:00:12,831 [salt.state       ][INFO    ][2116] Executing state file.directory for /etc/profile.d
2018-04-20 19:00:12,833 [salt.state       ][INFO    ][2116] Directory /etc/profile.d is in the correct state
2018-04-20 19:00:12,834 [salt.state       ][INFO    ][2116] Completed state [/etc/profile.d] at time 19:00:12.834261 duration_in_ms=2.906
2018-04-20 19:00:13,420 [salt.state       ][INFO    ][2116] Running state [/etc/apt/apt.conf.d/99prefer_ipv4-salt] at time 19:00:13.420063
2018-04-20 19:00:13,420 [salt.state       ][INFO    ][2116] Executing state file.managed for /etc/apt/apt.conf.d/99prefer_ipv4-salt
2018-04-20 19:00:13,449 [salt.fileclient  ][INFO    ][2116] Fetching file from saltenv 'base', ** done ** 'linux/files/apt.conf'
2018-04-20 19:00:13,458 [salt.state       ][INFO    ][2116] File changed:
New file
2018-04-20 19:00:13,458 [salt.state       ][INFO    ][2116] Completed state [/etc/apt/apt.conf.d/99prefer_ipv4-salt] at time 19:00:13.458674 duration_in_ms=38.612
2018-04-20 19:00:13,459 [salt.state       ][INFO    ][2116] Running state [linux_repo_prereq_pkgs] at time 19:00:13.459558
2018-04-20 19:00:13,459 [salt.state       ][INFO    ][2116] Executing state pkg.installed for linux_repo_prereq_pkgs
2018-04-20 19:00:13,460 [salt.loaded.int.module.cmdmod][INFO    ][2116] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2018-04-20 19:00:13,825 [salt.state       ][INFO    ][2116] All specified packages are already installed
2018-04-20 19:00:13,826 [salt.state       ][INFO    ][2116] Completed state [linux_repo_prereq_pkgs] at time 19:00:13.826096 duration_in_ms=366.538
2018-04-20 19:00:13,826 [salt.state       ][INFO    ][2116] Running state [/etc/apt/apt.conf.d/99proxies-salt-mk_openstack] at time 19:00:13.826521
2018-04-20 19:00:13,826 [salt.state       ][INFO    ][2116] Executing state file.absent for /etc/apt/apt.conf.d/99proxies-salt-mk_openstack
2018-04-20 19:00:13,827 [salt.state       ][INFO    ][2116] File /etc/apt/apt.conf.d/99proxies-salt-mk_openstack is not present
2018-04-20 19:00:13,827 [salt.state       ][INFO    ][2116] Completed state [/etc/apt/apt.conf.d/99proxies-salt-mk_openstack] at time 19:00:13.827615 duration_in_ms=1.094
2018-04-20 19:00:13,828 [salt.state       ][INFO    ][2116] Running state [/etc/apt/preferences.d/mk_openstack] at time 19:00:13.828418
2018-04-20 19:00:13,828 [salt.state       ][INFO    ][2116] Executing state file.managed for /etc/apt/preferences.d/mk_openstack
2018-04-20 19:00:13,847 [salt.fileclient  ][INFO    ][2116] Fetching file from saltenv 'base', ** done ** 'linux/files/preferences_repo'
2018-04-20 19:00:13,936 [salt.state       ][INFO    ][2116] File changed:
New file
2018-04-20 19:00:13,937 [salt.state       ][INFO    ][2116] Completed state [/etc/apt/preferences.d/mk_openstack] at time 19:00:13.937032 duration_in_ms=108.613
2018-04-20 19:00:13,938 [salt.state       ][INFO    ][2116] Running state [curl -s http://apt.mirantis.com/public.gpg | apt-key add -] at time 19:00:13.938816
2018-04-20 19:00:13,939 [salt.state       ][INFO    ][2116] Executing state cmd.run for curl -s http://apt.mirantis.com/public.gpg | apt-key add -
2018-04-20 19:00:13,939 [salt.loaded.int.module.cmdmod][INFO    ][2116] Executing command 'curl -s http://apt.mirantis.com/public.gpg | apt-key add -' in directory '/root'
2018-04-20 19:00:14,395 [salt.state       ][INFO    ][2116] {'pid': 2176, 'retcode': 0, 'stderr': '', 'stdout': 'OK'}
2018-04-20 19:00:14,395 [salt.state       ][INFO    ][2116] Completed state [curl -s http://apt.mirantis.com/public.gpg | apt-key add -] at time 19:00:14.395456 duration_in_ms=456.639
2018-04-20 19:00:14,401 [salt.state       ][INFO    ][2116] Running state [deb [arch=amd64] http://apt.mirantis.com/xenial/ nightly pike] at time 19:00:14.401447
2018-04-20 19:00:14,401 [salt.state       ][INFO    ][2116] Executing state pkgrepo.managed for deb [arch=amd64] http://apt.mirantis.com/xenial/ nightly pike
2018-04-20 19:00:14,483 [salt.loaded.int.module.cmdmod][INFO    ][2116] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2018-04-20 19:00:15,514 [salt.minion      ][INFO    ][2025] User sudo_ubuntu Executing command saltutil.find_job with jid 20180420190015501364
2018-04-20 19:00:15,530 [salt.minion      ][INFO    ][2597] Starting a new job with PID 2597
2018-04-20 19:00:15,550 [salt.minion      ][INFO    ][2597] Returning information for job: 20180420190015501364
2018-04-20 19:00:18,217 [salt.state       ][INFO    ][2116] {'repo': 'deb [arch=amd64] http://apt.mirantis.com/xenial nightly pike'}
2018-04-20 19:00:18,218 [salt.state       ][INFO    ][2116] Completed state [deb [arch=amd64] http://apt.mirantis.com/xenial/ nightly pike] at time 19:00:18.218150 duration_in_ms=3816.702
2018-04-20 19:00:18,218 [salt.state       ][INFO    ][2116] Running state [/etc/apt/apt.conf.d/99proxies-salt-uca-staging] at time 19:00:18.218803
2018-04-20 19:00:18,219 [salt.state       ][INFO    ][2116] Executing state file.absent for /etc/apt/apt.conf.d/99proxies-salt-uca-staging
2018-04-20 19:00:18,220 [salt.state       ][INFO    ][2116] File /etc/apt/apt.conf.d/99proxies-salt-uca-staging is not present
2018-04-20 19:00:18,220 [salt.state       ][INFO    ][2116] Completed state [/etc/apt/apt.conf.d/99proxies-salt-uca-staging] at time 19:00:18.220601 duration_in_ms=1.798
2018-04-20 19:00:18,221 [salt.state       ][INFO    ][2116] Running state [/etc/apt/preferences.d/uca-staging] at time 19:00:18.221088
2018-04-20 19:00:18,221 [salt.state       ][INFO    ][2116] Executing state file.absent for /etc/apt/preferences.d/uca-staging
2018-04-20 19:00:18,222 [salt.state       ][INFO    ][2116] File /etc/apt/preferences.d/uca-staging is not present
2018-04-20 19:00:18,222 [salt.state       ][INFO    ][2116] Completed state [/etc/apt/preferences.d/uca-staging] at time 19:00:18.222559 duration_in_ms=1.471
2018-04-20 19:00:18,223 [salt.state       ][INFO    ][2116] Running state [apt-key adv --keyserver keyserver.ubuntu.com --recv 9F68104E] at time 19:00:18.223031
2018-04-20 19:00:18,223 [salt.state       ][INFO    ][2116] Executing state cmd.run for apt-key adv --keyserver keyserver.ubuntu.com --recv 9F68104E
2018-04-20 19:00:18,224 [salt.loaded.int.module.cmdmod][INFO    ][2116] Executing command 'apt-key adv --keyserver keyserver.ubuntu.com --recv 9F68104E' in directory '/root'
2018-04-20 19:00:18,427 [salt.state       ][INFO    ][2116] {'pid': 2606, '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.odGiOWIRbv/gpg.1.sh --keyserver\nkeyserver.ubuntu.com\n--recv\n9F68104E'}
2018-04-20 19:00:18,428 [salt.state       ][INFO    ][2116] Completed state [apt-key adv --keyserver keyserver.ubuntu.com --recv 9F68104E] at time 19:00:18.428615 duration_in_ms=205.584
2018-04-20 19:00:18,430 [salt.state       ][INFO    ][2116] Running state [deb http://ppa.launchpad.net/ubuntu-cloud-archive/pike-staging/ubuntu xenial main] at time 19:00:18.430558
2018-04-20 19:00:18,431 [salt.state       ][INFO    ][2116] Executing state pkgrepo.managed for deb http://ppa.launchpad.net/ubuntu-cloud-archive/pike-staging/ubuntu xenial main
2018-04-20 19:00:18,495 [salt.loaded.int.module.cmdmod][INFO    ][2116] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2018-04-20 19:00:22,501 [salt.state       ][INFO    ][2116] {'repo': 'deb http://ppa.launchpad.net/ubuntu-cloud-archive/pike-staging/ubuntu xenial main'}
2018-04-20 19:00:22,502 [salt.state       ][INFO    ][2116] Completed state [deb http://ppa.launchpad.net/ubuntu-cloud-archive/pike-staging/ubuntu xenial main] at time 19:00:22.502396 duration_in_ms=4071.837
2018-04-20 19:00:22,503 [salt.state       ][INFO    ][2116] Running state [/etc/apt/apt.conf.d/99proxies-salt-mirantis_openstack] at time 19:00:22.503003
2018-04-20 19:00:22,503 [salt.state       ][INFO    ][2116] Executing state file.absent for /etc/apt/apt.conf.d/99proxies-salt-mirantis_openstack
2018-04-20 19:00:22,504 [salt.state       ][INFO    ][2116] File /etc/apt/apt.conf.d/99proxies-salt-mirantis_openstack is not present
2018-04-20 19:00:22,504 [salt.state       ][INFO    ][2116] Completed state [/etc/apt/apt.conf.d/99proxies-salt-mirantis_openstack] at time 19:00:22.504685 duration_in_ms=1.682
2018-04-20 19:00:22,505 [salt.state       ][INFO    ][2116] Running state [/etc/apt/preferences.d/mirantis_openstack] at time 19:00:22.505173
2018-04-20 19:00:22,505 [salt.state       ][INFO    ][2116] Executing state file.managed for /etc/apt/preferences.d/mirantis_openstack
2018-04-20 19:00:22,618 [salt.state       ][INFO    ][2116] File changed:
New file
2018-04-20 19:00:22,619 [salt.state       ][INFO    ][2116] Completed state [/etc/apt/preferences.d/mirantis_openstack] at time 19:00:22.619840 duration_in_ms=114.666
2018-04-20 19:00:22,620 [salt.state       ][INFO    ][2116] Running state [curl -s http://mirror.fuel-infra.org/mcp-repos/pike/xenial/archive-mcppike.key | apt-key add -] at time 19:00:22.620356
2018-04-20 19:00:22,620 [salt.state       ][INFO    ][2116] Executing state cmd.run for curl -s http://mirror.fuel-infra.org/mcp-repos/pike/xenial/archive-mcppike.key | apt-key add -
2018-04-20 19:00:22,621 [salt.loaded.int.module.cmdmod][INFO    ][2116] Executing command 'curl -s http://mirror.fuel-infra.org/mcp-repos/pike/xenial/archive-mcppike.key | apt-key add -' in directory '/root'
2018-04-20 19:00:22,789 [salt.state       ][INFO    ][2116] {'pid': 3086, 'retcode': 0, 'stderr': '', 'stdout': 'OK'}
2018-04-20 19:00:22,790 [salt.state       ][INFO    ][2116] Completed state [curl -s http://mirror.fuel-infra.org/mcp-repos/pike/xenial/archive-mcppike.key | apt-key add -] at time 19:00:22.790691 duration_in_ms=170.335
2018-04-20 19:00:22,792 [salt.state       ][INFO    ][2116] Running state [deb http://mirror.fuel-infra.org/mcp-repos/pike/xenial pike main] at time 19:00:22.792639
2018-04-20 19:00:22,793 [salt.state       ][INFO    ][2116] Executing state pkgrepo.managed for deb http://mirror.fuel-infra.org/mcp-repos/pike/xenial pike main
2018-04-20 19:00:22,865 [salt.loaded.int.module.cmdmod][INFO    ][2116] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2018-04-20 19:00:25,585 [salt.minion      ][INFO    ][2025] User sudo_ubuntu Executing command saltutil.find_job with jid 20180420190025570601
2018-04-20 19:00:25,602 [salt.minion      ][INFO    ][3612] Starting a new job with PID 3612
2018-04-20 19:00:25,622 [salt.minion      ][INFO    ][3612] Returning information for job: 20180420190025570601
2018-04-20 19:00:27,380 [salt.state       ][INFO    ][2116] {'repo': 'deb http://mirror.fuel-infra.org/mcp-repos/pike/xenial pike main'}
2018-04-20 19:00:27,380 [salt.state       ][INFO    ][2116] Completed state [deb http://mirror.fuel-infra.org/mcp-repos/pike/xenial pike main] at time 19:00:27.380872 duration_in_ms=4588.232
2018-04-20 19:00:27,381 [salt.state       ][INFO    ][2116] Running state [/etc/apt/apt.conf.d/99proxies-salt-uca] at time 19:00:27.381280
2018-04-20 19:00:27,381 [salt.state       ][INFO    ][2116] Executing state file.absent for /etc/apt/apt.conf.d/99proxies-salt-uca
2018-04-20 19:00:27,382 [salt.state       ][INFO    ][2116] File /etc/apt/apt.conf.d/99proxies-salt-uca is not present
2018-04-20 19:00:27,382 [salt.state       ][INFO    ][2116] Completed state [/etc/apt/apt.conf.d/99proxies-salt-uca] at time 19:00:27.382454 duration_in_ms=1.174
2018-04-20 19:00:27,382 [salt.state       ][INFO    ][2116] Running state [/etc/apt/preferences.d/uca] at time 19:00:27.382703
2018-04-20 19:00:27,382 [salt.state       ][INFO    ][2116] Executing state file.absent for /etc/apt/preferences.d/uca
2018-04-20 19:00:27,383 [salt.state       ][INFO    ][2116] File /etc/apt/preferences.d/uca is not present
2018-04-20 19:00:27,384 [salt.state       ][INFO    ][2116] Completed state [/etc/apt/preferences.d/uca] at time 19:00:27.383990 duration_in_ms=1.287
2018-04-20 19:00:27,384 [salt.state       ][INFO    ][2116] Running state [apt-key adv --keyserver keyserver.ubuntu.com --recv EC4926EA] at time 19:00:27.384227
2018-04-20 19:00:27,384 [salt.state       ][INFO    ][2116] Executing state cmd.run for apt-key adv --keyserver keyserver.ubuntu.com --recv EC4926EA
2018-04-20 19:00:27,385 [salt.loaded.int.module.cmdmod][INFO    ][2116] Executing command 'apt-key adv --keyserver keyserver.ubuntu.com --recv EC4926EA' in directory '/root'
2018-04-20 19:00:27,602 [salt.state       ][INFO    ][2116] {'pid': 3620, '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.C22j3Ae0Zs/gpg.1.sh --keyserver\nkeyserver.ubuntu.com\n--recv\nEC4926EA'}
2018-04-20 19:00:27,604 [salt.state       ][INFO    ][2116] Completed state [apt-key adv --keyserver keyserver.ubuntu.com --recv EC4926EA] at time 19:00:27.604261 duration_in_ms=220.033
2018-04-20 19:00:27,606 [salt.state       ][INFO    ][2116] Running state [deb http://ubuntu-cloud.archive.canonical.com/ubuntu xenial-updates/pike main] at time 19:00:27.606003
2018-04-20 19:00:27,606 [salt.state       ][INFO    ][2116] Executing state pkgrepo.managed for deb http://ubuntu-cloud.archive.canonical.com/ubuntu xenial-updates/pike main
2018-04-20 19:00:27,681 [salt.loaded.int.module.cmdmod][INFO    ][2116] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2018-04-20 19:00:31,885 [salt.state       ][INFO    ][2116] {'repo': 'deb http://ubuntu-cloud.archive.canonical.com/ubuntu xenial-updates/pike main'}
2018-04-20 19:00:31,886 [salt.state       ][INFO    ][2116] Completed state [deb http://ubuntu-cloud.archive.canonical.com/ubuntu xenial-updates/pike main] at time 19:00:31.886118 duration_in_ms=4280.114
2018-04-20 19:00:31,888 [salt.state       ][INFO    ][2116] Running state [UTC] at time 19:00:31.888500
2018-04-20 19:00:31,888 [salt.state       ][INFO    ][2116] Executing state timezone.system for UTC
2018-04-20 19:00:31,889 [salt.loaded.int.module.cmdmod][INFO    ][2116] Executing command ['timedatectl'] in directory '/root'
2018-04-20 19:00:31,947 [salt.loaded.int.module.cmdmod][INFO    ][2116] Executing command ['timedatectl'] in directory '/root'
2018-04-20 19:00:31,964 [salt.loaded.int.module.cmdmod][INFO    ][2116] Executing command 'timedatectl set-timezone UTC' in directory '/root'
2018-04-20 19:00:31,982 [salt.state       ][INFO    ][2116] {'timezone': 'UTC'}
2018-04-20 19:00:31,984 [salt.state       ][INFO    ][2116] Completed state [UTC] at time 19:00:31.984215 duration_in_ms=95.714
2018-04-20 19:00:31,986 [salt.state       ][INFO    ][2116] Running state [nf_conntrack] at time 19:00:31.986408
2018-04-20 19:00:31,987 [salt.state       ][INFO    ][2116] Executing state kmod.present for nf_conntrack
2018-04-20 19:00:31,988 [salt.loaded.int.module.cmdmod][INFO    ][2116] Executing command 'lsmod' in directory '/root'
2018-04-20 19:00:32,081 [salt.loaded.int.module.cmdmod][INFO    ][2116] Executing command 'lsmod' in directory '/root'
2018-04-20 19:00:32,098 [salt.loaded.int.module.cmdmod][INFO    ][2116] Executing command 'modprobe nf_conntrack' in directory '/root'
2018-04-20 19:00:32,119 [salt.loaded.int.module.cmdmod][INFO    ][2116] Executing command 'lsmod' in directory '/root'
2018-04-20 19:00:32,158 [salt.state       ][INFO    ][2116] {'nf_conntrack': 'loaded'}
2018-04-20 19:00:32,160 [salt.state       ][INFO    ][2116] Completed state [nf_conntrack] at time 19:00:32.159044 duration_in_ms=172.635
2018-04-20 19:00:32,161 [salt.state       ][INFO    ][2116] Running state [kernel.panic] at time 19:00:32.161531
2018-04-20 19:00:32,161 [salt.state       ][INFO    ][2116] Executing state sysctl.present for kernel.panic
2018-04-20 19:00:32,177 [salt.loaded.int.module.cmdmod][INFO    ][2116] Executing command 'sysctl -a' in directory '/root'
2018-04-20 19:00:32,235 [salt.loaded.int.module.cmdmod][INFO    ][2116] Executing command 'sysctl -w kernel.panic="60"' in directory '/root'
2018-04-20 19:00:32,250 [salt.state       ][INFO    ][2116] {'kernel.panic': 60}
2018-04-20 19:00:32,251 [salt.state       ][INFO    ][2116] Completed state [kernel.panic] at time 19:00:32.251007 duration_in_ms=89.475
2018-04-20 19:00:32,251 [salt.state       ][INFO    ][2116] Running state [net.ipv4.tcp_keepalive_probes] at time 19:00:32.251746
2018-04-20 19:00:32,252 [salt.state       ][INFO    ][2116] Executing state sysctl.present for net.ipv4.tcp_keepalive_probes
2018-04-20 19:00:32,253 [salt.loaded.int.module.cmdmod][INFO    ][2116] Executing command 'sysctl -a' in directory '/root'
2018-04-20 19:00:32,289 [salt.loaded.int.module.cmdmod][INFO    ][2116] Executing command 'sysctl -w net.ipv4.tcp_keepalive_probes="8"' in directory '/root'
2018-04-20 19:00:32,304 [salt.state       ][INFO    ][2116] {'net.ipv4.tcp_keepalive_probes': 8}
2018-04-20 19:00:32,305 [salt.state       ][INFO    ][2116] Completed state [net.ipv4.tcp_keepalive_probes] at time 19:00:32.305219 duration_in_ms=53.473
2018-04-20 19:00:32,305 [salt.state       ][INFO    ][2116] Running state [fs.file-max] at time 19:00:32.305649
2018-04-20 19:00:32,306 [salt.state       ][INFO    ][2116] Executing state sysctl.present for fs.file-max
2018-04-20 19:00:32,306 [salt.loaded.int.module.cmdmod][INFO    ][2116] Executing command 'sysctl -a' in directory '/root'
2018-04-20 19:00:32,342 [salt.loaded.int.module.cmdmod][INFO    ][2116] Executing command 'sysctl -w fs.file-max="124165"' in directory '/root'
2018-04-20 19:00:32,355 [salt.state       ][INFO    ][2116] {'fs.file-max': 124165}
2018-04-20 19:00:32,356 [salt.state       ][INFO    ][2116] Completed state [fs.file-max] at time 19:00:32.356042 duration_in_ms=50.393
2018-04-20 19:00:32,356 [salt.state       ][INFO    ][2116] Running state [net.core.somaxconn] at time 19:00:32.356467
2018-04-20 19:00:32,356 [salt.state       ][INFO    ][2116] Executing state sysctl.present for net.core.somaxconn
2018-04-20 19:00:32,357 [salt.loaded.int.module.cmdmod][INFO    ][2116] Executing command 'sysctl -a' in directory '/root'
2018-04-20 19:00:32,390 [salt.loaded.int.module.cmdmod][INFO    ][2116] Executing command 'sysctl -w net.core.somaxconn="4096"' in directory '/root'
2018-04-20 19:00:32,405 [salt.state       ][INFO    ][2116] {'net.core.somaxconn': 4096}
2018-04-20 19:00:32,406 [salt.state       ][INFO    ][2116] Completed state [net.core.somaxconn] at time 19:00:32.406349 duration_in_ms=49.881
2018-04-20 19:00:32,406 [salt.state       ][INFO    ][2116] Running state [net.ipv4.tcp_max_syn_backlog] at time 19:00:32.406805
2018-04-20 19:00:32,407 [salt.state       ][INFO    ][2116] Executing state sysctl.present for net.ipv4.tcp_max_syn_backlog
2018-04-20 19:00:32,408 [salt.loaded.int.module.cmdmod][INFO    ][2116] Executing command 'sysctl -a' in directory '/root'
2018-04-20 19:00:32,444 [salt.loaded.int.module.cmdmod][INFO    ][2116] Executing command 'sysctl -w net.ipv4.tcp_max_syn_backlog="8192"' in directory '/root'
2018-04-20 19:00:32,458 [salt.state       ][INFO    ][2116] {'net.ipv4.tcp_max_syn_backlog': 8192}
2018-04-20 19:00:32,460 [salt.state       ][INFO    ][2116] Completed state [net.ipv4.tcp_max_syn_backlog] at time 19:00:32.459973 duration_in_ms=53.167
2018-04-20 19:00:32,460 [salt.state       ][INFO    ][2116] Running state [net.ipv4.tcp_tw_reuse] at time 19:00:32.460395
2018-04-20 19:00:32,460 [salt.state       ][INFO    ][2116] Executing state sysctl.present for net.ipv4.tcp_tw_reuse
2018-04-20 19:00:32,461 [salt.loaded.int.module.cmdmod][INFO    ][2116] Executing command 'sysctl -a' in directory '/root'
2018-04-20 19:00:32,493 [salt.loaded.int.module.cmdmod][INFO    ][2116] Executing command 'sysctl -w net.ipv4.tcp_tw_reuse="1"' in directory '/root'
2018-04-20 19:00:32,508 [salt.state       ][INFO    ][2116] {'net.ipv4.tcp_tw_reuse': 1}
2018-04-20 19:00:32,509 [salt.state       ][INFO    ][2116] Completed state [net.ipv4.tcp_tw_reuse] at time 19:00:32.509546 duration_in_ms=49.151
2018-04-20 19:00:32,510 [salt.state       ][INFO    ][2116] Running state [net.ipv4.tcp_congestion_control] at time 19:00:32.510205
2018-04-20 19:00:32,510 [salt.state       ][INFO    ][2116] Executing state sysctl.present for net.ipv4.tcp_congestion_control
2018-04-20 19:00:32,511 [salt.loaded.int.module.cmdmod][INFO    ][2116] Executing command 'sysctl -a' in directory '/root'
2018-04-20 19:00:32,543 [salt.loaded.int.module.cmdmod][INFO    ][2116] Executing command 'sysctl -w net.ipv4.tcp_congestion_control="yeah"' in directory '/root'
2018-04-20 19:00:32,561 [salt.state       ][INFO    ][2116] {'net.ipv4.tcp_congestion_control': 'yeah'}
2018-04-20 19:00:32,562 [salt.state       ][INFO    ][2116] Completed state [net.ipv4.tcp_congestion_control] at time 19:00:32.562325 duration_in_ms=52.119
2018-04-20 19:00:32,562 [salt.state       ][INFO    ][2116] Running state [net.ipv4.tcp_retries2] at time 19:00:32.562831
2018-04-20 19:00:32,563 [salt.state       ][INFO    ][2116] Executing state sysctl.present for net.ipv4.tcp_retries2
2018-04-20 19:00:32,564 [salt.loaded.int.module.cmdmod][INFO    ][2116] Executing command 'sysctl -a' in directory '/root'
2018-04-20 19:00:32,598 [salt.loaded.int.module.cmdmod][INFO    ][2116] Executing command 'sysctl -w net.ipv4.tcp_retries2="5"' in directory '/root'
2018-04-20 19:00:32,610 [salt.state       ][INFO    ][2116] {'net.ipv4.tcp_retries2': 5}
2018-04-20 19:00:32,611 [salt.state       ][INFO    ][2116] Completed state [net.ipv4.tcp_retries2] at time 19:00:32.611664 duration_in_ms=48.832
2018-04-20 19:00:32,612 [salt.state       ][INFO    ][2116] Running state [net.core.netdev_max_backlog] at time 19:00:32.612074
2018-04-20 19:00:32,612 [salt.state       ][INFO    ][2116] Executing state sysctl.present for net.core.netdev_max_backlog
2018-04-20 19:00:32,613 [salt.loaded.int.module.cmdmod][INFO    ][2116] Executing command 'sysctl -a' in directory '/root'
2018-04-20 19:00:32,645 [salt.loaded.int.module.cmdmod][INFO    ][2116] Executing command 'sysctl -w net.core.netdev_max_backlog="261144"' in directory '/root'
2018-04-20 19:00:32,658 [salt.state       ][INFO    ][2116] {'net.core.netdev_max_backlog': 261144}
2018-04-20 19:00:32,658 [salt.state       ][INFO    ][2116] Completed state [net.core.netdev_max_backlog] at time 19:00:32.658446 duration_in_ms=46.371
2018-04-20 19:00:32,658 [salt.state       ][INFO    ][2116] Running state [net.ipv4.tcp_slow_start_after_idle] at time 19:00:32.658930
2018-04-20 19:00:32,659 [salt.state       ][INFO    ][2116] Executing state sysctl.present for net.ipv4.tcp_slow_start_after_idle
2018-04-20 19:00:32,660 [salt.loaded.int.module.cmdmod][INFO    ][2116] Executing command 'sysctl -a' in directory '/root'
2018-04-20 19:00:32,694 [salt.loaded.int.module.cmdmod][INFO    ][2116] Executing command 'sysctl -w net.ipv4.tcp_slow_start_after_idle="0"' in directory '/root'
2018-04-20 19:00:32,710 [salt.state       ][INFO    ][2116] {'net.ipv4.tcp_slow_start_after_idle': 0}
2018-04-20 19:00:32,710 [salt.state       ][INFO    ][2116] Completed state [net.ipv4.tcp_slow_start_after_idle] at time 19:00:32.710666 duration_in_ms=51.735
2018-04-20 19:00:32,712 [salt.state       ][INFO    ][2116] Running state [vm.swappiness] at time 19:00:32.712847
2018-04-20 19:00:32,713 [salt.state       ][INFO    ][2116] Executing state sysctl.present for vm.swappiness
2018-04-20 19:00:32,714 [salt.loaded.int.module.cmdmod][INFO    ][2116] Executing command 'sysctl -a' in directory '/root'
2018-04-20 19:00:32,750 [salt.loaded.int.module.cmdmod][INFO    ][2116] Executing command 'sysctl -w vm.swappiness="10"' in directory '/root'
2018-04-20 19:00:32,766 [salt.state       ][INFO    ][2116] {'vm.swappiness': 10}
2018-04-20 19:00:32,768 [salt.state       ][INFO    ][2116] Completed state [vm.swappiness] at time 19:00:32.767949 duration_in_ms=55.101
2018-04-20 19:00:32,768 [salt.state       ][INFO    ][2116] Running state [net.ipv4.tcp_keepalive_intvl] at time 19:00:32.768496
2018-04-20 19:00:32,768 [salt.state       ][INFO    ][2116] Executing state sysctl.present for net.ipv4.tcp_keepalive_intvl
2018-04-20 19:00:32,769 [salt.loaded.int.module.cmdmod][INFO    ][2116] Executing command 'sysctl -a' in directory '/root'
2018-04-20 19:00:32,804 [salt.loaded.int.module.cmdmod][INFO    ][2116] Executing command 'sysctl -w net.ipv4.tcp_keepalive_intvl="3"' in directory '/root'
2018-04-20 19:00:32,820 [salt.state       ][INFO    ][2116] {'net.ipv4.tcp_keepalive_intvl': 3}
2018-04-20 19:00:32,821 [salt.state       ][INFO    ][2116] Completed state [net.ipv4.tcp_keepalive_intvl] at time 19:00:32.820977 duration_in_ms=52.48
2018-04-20 19:00:32,821 [salt.state       ][INFO    ][2116] Running state [net.ipv4.neigh.default.gc_thresh1] at time 19:00:32.821513
2018-04-20 19:00:32,821 [salt.state       ][INFO    ][2116] Executing state sysctl.present for net.ipv4.neigh.default.gc_thresh1
2018-04-20 19:00:32,822 [salt.loaded.int.module.cmdmod][INFO    ][2116] Executing command 'sysctl -a' in directory '/root'
2018-04-20 19:00:32,857 [salt.loaded.int.module.cmdmod][INFO    ][2116] Executing command 'sysctl -w net.ipv4.neigh.default.gc_thresh1="4096"' in directory '/root'
2018-04-20 19:00:32,873 [salt.state       ][INFO    ][2116] {'net.ipv4.neigh.default.gc_thresh1': 4096}
2018-04-20 19:00:32,874 [salt.state       ][INFO    ][2116] Completed state [net.ipv4.neigh.default.gc_thresh1] at time 19:00:32.873991 duration_in_ms=52.477
2018-04-20 19:00:32,874 [salt.state       ][INFO    ][2116] Running state [net.ipv4.neigh.default.gc_thresh2] at time 19:00:32.874514
2018-04-20 19:00:32,874 [salt.state       ][INFO    ][2116] Executing state sysctl.present for net.ipv4.neigh.default.gc_thresh2
2018-04-20 19:00:32,876 [salt.loaded.int.module.cmdmod][INFO    ][2116] Executing command 'sysctl -a' in directory '/root'
2018-04-20 19:00:32,908 [salt.loaded.int.module.cmdmod][INFO    ][2116] Executing command 'sysctl -w net.ipv4.neigh.default.gc_thresh2="8192"' in directory '/root'
2018-04-20 19:00:32,922 [salt.state       ][INFO    ][2116] {'net.ipv4.neigh.default.gc_thresh2': 8192}
2018-04-20 19:00:32,923 [salt.state       ][INFO    ][2116] Completed state [net.ipv4.neigh.default.gc_thresh2] at time 19:00:32.923512 duration_in_ms=48.998
2018-04-20 19:00:32,924 [salt.state       ][INFO    ][2116] Running state [net.ipv4.neigh.default.gc_thresh3] at time 19:00:32.924008
2018-04-20 19:00:32,924 [salt.state       ][INFO    ][2116] Executing state sysctl.present for net.ipv4.neigh.default.gc_thresh3
2018-04-20 19:00:32,925 [salt.loaded.int.module.cmdmod][INFO    ][2116] Executing command 'sysctl -a' in directory '/root'
2018-04-20 19:00:32,959 [salt.loaded.int.module.cmdmod][INFO    ][2116] Executing command 'sysctl -w net.ipv4.neigh.default.gc_thresh3="16384"' in directory '/root'
2018-04-20 19:00:32,977 [salt.state       ][INFO    ][2116] {'net.ipv4.neigh.default.gc_thresh3': 16384}
2018-04-20 19:00:32,977 [salt.state       ][INFO    ][2116] Completed state [net.ipv4.neigh.default.gc_thresh3] at time 19:00:32.977476 duration_in_ms=53.467
2018-04-20 19:00:32,977 [salt.state       ][INFO    ][2116] Running state [net.ipv4.tcp_fin_timeout] at time 19:00:32.977938
2018-04-20 19:00:32,978 [salt.state       ][INFO    ][2116] Executing state sysctl.present for net.ipv4.tcp_fin_timeout
2018-04-20 19:00:32,979 [salt.loaded.int.module.cmdmod][INFO    ][2116] Executing command 'sysctl -a' in directory '/root'
2018-04-20 19:00:33,014 [salt.loaded.int.module.cmdmod][INFO    ][2116] Executing command 'sysctl -w net.ipv4.tcp_fin_timeout="30"' in directory '/root'
2018-04-20 19:00:33,030 [salt.state       ][INFO    ][2116] {'net.ipv4.tcp_fin_timeout': 30}
2018-04-20 19:00:33,031 [salt.state       ][INFO    ][2116] Completed state [net.ipv4.tcp_fin_timeout] at time 19:00:33.030978 duration_in_ms=53.039
2018-04-20 19:00:33,031 [salt.state       ][INFO    ][2116] Running state [net.ipv4.tcp_keepalive_time] at time 19:00:33.031794
2018-04-20 19:00:33,032 [salt.state       ][INFO    ][2116] Executing state sysctl.present for net.ipv4.tcp_keepalive_time
2018-04-20 19:00:33,033 [salt.loaded.int.module.cmdmod][INFO    ][2116] Executing command 'sysctl -a' in directory '/root'
2018-04-20 19:00:33,068 [salt.loaded.int.module.cmdmod][INFO    ][2116] Executing command 'sysctl -w net.ipv4.tcp_keepalive_time="30"' in directory '/root'
2018-04-20 19:00:33,084 [salt.state       ][INFO    ][2116] {'net.ipv4.tcp_keepalive_time': 30}
2018-04-20 19:00:33,084 [salt.state       ][INFO    ][2116] Completed state [net.ipv4.tcp_keepalive_time] at time 19:00:33.084535 duration_in_ms=52.74
2018-04-20 19:00:33,085 [salt.state       ][INFO    ][2116] Running state [net.nf_conntrack_max] at time 19:00:33.085010
2018-04-20 19:00:33,085 [salt.state       ][INFO    ][2116] Executing state sysctl.present for net.nf_conntrack_max
2018-04-20 19:00:33,086 [salt.loaded.int.module.cmdmod][INFO    ][2116] Executing command 'sysctl -a' in directory '/root'
2018-04-20 19:00:33,122 [salt.loaded.int.module.cmdmod][INFO    ][2116] Executing command 'sysctl -w net.nf_conntrack_max="1048576"' in directory '/root'
2018-04-20 19:00:33,136 [salt.state       ][INFO    ][2116] {'net.nf_conntrack_max': 1048576}
2018-04-20 19:00:33,137 [salt.state       ][INFO    ][2116] Completed state [net.nf_conntrack_max] at time 19:00:33.136996 duration_in_ms=51.986
2018-04-20 19:00:33,137 [salt.state       ][INFO    ][2116] Running state [linux_sysfs_package] at time 19:00:33.137481
2018-04-20 19:00:33,137 [salt.state       ][INFO    ][2116] Executing state pkg.installed for linux_sysfs_package
2018-04-20 19:00:33,161 [salt.loaded.int.module.cmdmod][INFO    ][2116] Executing command ['apt-cache', '-q', 'policy', 'sysfsutils'] in directory '/root'
2018-04-20 19:00:33,221 [salt.loaded.int.module.cmdmod][INFO    ][2116] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2018-04-20 19:00:35,312 [salt.loaded.int.module.cmdmod][INFO    ][2116] Executing command ['dpkg', '--get-selections', '*'] in directory '/root'
2018-04-20 19:00:35,337 [salt.loaded.int.module.cmdmod][INFO    ][2116] 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-20 19:00:35,717 [salt.minion      ][INFO    ][2025] User sudo_ubuntu Executing command saltutil.find_job with jid 20180420190035707774
2018-04-20 19:00:35,738 [salt.minion      ][INFO    ][4682] Starting a new job with PID 4682
2018-04-20 19:00:35,758 [salt.minion      ][INFO    ][4682] Returning information for job: 20180420190035707774
2018-04-20 19:00:38,648 [salt.loaded.int.module.cmdmod][INFO    ][2116] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2018-04-20 19:00:38,696 [salt.state       ][INFO    ][2116] 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-20 19:00:38,725 [salt.state       ][INFO    ][2116] Loading fresh modules for state activity
2018-04-20 19:00:38,757 [salt.state       ][INFO    ][2116] Completed state [linux_sysfs_package] at time 19:00:38.757210 duration_in_ms=5619.729
2018-04-20 19:00:38,762 [salt.state       ][INFO    ][2116] Running state [/etc/sysfs.d] at time 19:00:38.762022
2018-04-20 19:00:38,762 [salt.state       ][INFO    ][2116] Executing state file.directory for /etc/sysfs.d
2018-04-20 19:00:38,765 [salt.state       ][INFO    ][2116] Directory /etc/sysfs.d is in the correct state
2018-04-20 19:00:38,765 [salt.state       ][INFO    ][2116] Completed state [/etc/sysfs.d] at time 19:00:38.765879 duration_in_ms=3.857
2018-04-20 19:00:39,122 [salt.state       ][INFO    ][2116] Running state [ondemand] at time 19:00:39.122840
2018-04-20 19:00:39,123 [salt.state       ][INFO    ][2116] Executing state service.dead for ondemand
2018-04-20 19:00:39,124 [salt.loaded.int.module.cmdmod][INFO    ][2116] Executing command ['systemctl', 'status', 'ondemand.service', '-n', '0'] in directory '/root'
2018-04-20 19:00:39,142 [salt.loaded.int.module.cmdmod][INFO    ][2116] Executing command ['systemctl', 'is-active', 'ondemand.service'] in directory '/root'
2018-04-20 19:00:39,160 [salt.loaded.int.module.cmdmod][INFO    ][2116] Executing command ['systemctl', 'is-enabled', 'ondemand.service'] in directory '/root'
2018-04-20 19:00:39,180 [salt.loaded.int.module.cmdmod][INFO    ][2116] Executing command ['systemd-run', '--scope', 'systemctl', 'stop', 'ondemand.service'] in directory '/root'
2018-04-20 19:00:39,259 [salt.loaded.int.module.cmdmod][INFO    ][2116] Executing command ['systemctl', 'is-active', 'ondemand.service'] in directory '/root'
2018-04-20 19:00:39,276 [salt.loaded.int.module.cmdmod][INFO    ][2116] Executing command ['systemctl', 'is-enabled', 'ondemand.service'] in directory '/root'
2018-04-20 19:00:39,296 [salt.loaded.int.module.cmdmod][INFO    ][2116] Executing command ['systemctl', 'is-enabled', 'ondemand.service'] in directory '/root'
2018-04-20 19:00:39,318 [salt.loaded.int.module.cmdmod][INFO    ][2116] Executing command ['systemd-run', '--scope', '/usr/sbin/update-rc.d', '-f', 'ondemand', 'remove'] in directory '/root'
2018-04-20 19:00:39,478 [salt.loaded.int.module.cmdmod][INFO    ][2116] Executing command ['systemctl', 'is-enabled', 'ondemand.service'] in directory '/root'
2018-04-20 19:00:39,504 [salt.loaded.int.module.cmdmod][INFO    ][2116] Executing command 'runlevel' in directory '/root'
2018-04-20 19:00:39,520 [salt.state       ][INFO    ][2116] {'ondemand': True}
2018-04-20 19:00:39,520 [salt.state       ][INFO    ][2116] Completed state [ondemand] at time 19:00:39.520513 duration_in_ms=397.673
2018-04-20 19:00:39,522 [salt.state       ][INFO    ][2116] Running state [cs_CZ.UTF-8] at time 19:00:39.522118
2018-04-20 19:00:39,522 [salt.state       ][INFO    ][2116] Executing state locale.present for cs_CZ.UTF-8
2018-04-20 19:00:39,523 [salt.loaded.int.module.cmdmod][INFO    ][2116] Executing command 'locale -a' in directory '/root'
2018-04-20 19:00:39,543 [salt.loaded.int.module.cmdmod][INFO    ][2116] Executing command ['locale-gen', 'cs_CZ.utf8'] in directory '/root'
2018-04-20 19:00:40,476 [salt.state       ][INFO    ][2116] {'locale': 'cs_CZ.UTF-8'}
2018-04-20 19:00:40,476 [salt.state       ][INFO    ][2116] Completed state [cs_CZ.UTF-8] at time 19:00:40.476777 duration_in_ms=954.658
2018-04-20 19:00:40,477 [salt.state       ][INFO    ][2116] Running state [en_US.UTF-8] at time 19:00:40.477194
2018-04-20 19:00:40,477 [salt.state       ][INFO    ][2116] Executing state locale.present for en_US.UTF-8
2018-04-20 19:00:40,478 [salt.loaded.int.module.cmdmod][INFO    ][2116] Executing command 'locale -a' in directory '/root'
2018-04-20 19:00:40,491 [salt.state       ][INFO    ][2116] Locale en_US.UTF-8 is already present
2018-04-20 19:00:40,492 [salt.state       ][INFO    ][2116] Completed state [en_US.UTF-8] at time 19:00:40.492168 duration_in_ms=14.974
2018-04-20 19:00:40,494 [salt.state       ][INFO    ][2116] Running state [en_US.UTF-8] at time 19:00:40.494175
2018-04-20 19:00:40,494 [salt.state       ][INFO    ][2116] Executing state locale.system for en_US.UTF-8
2018-04-20 19:00:40,495 [salt.loaded.int.module.cmdmod][INFO    ][2116] Executing command 'localectl' in directory '/root'
2018-04-20 19:00:40,543 [salt.state       ][INFO    ][2116] System locale en_US.UTF-8 already set
2018-04-20 19:00:40,543 [salt.state       ][INFO    ][2116] Completed state [en_US.UTF-8] at time 19:00:40.543497 duration_in_ms=49.322
2018-04-20 19:00:40,545 [salt.state       ][INFO    ][2116] Running state [root] at time 19:00:40.545040
2018-04-20 19:00:40,545 [salt.state       ][INFO    ][2116] Executing state group.present for root
2018-04-20 19:00:40,546 [salt.state       ][INFO    ][2116] Group root is present and up to date
2018-04-20 19:00:40,546 [salt.state       ][INFO    ][2116] Completed state [root] at time 19:00:40.546215 duration_in_ms=1.175
2018-04-20 19:00:40,550 [salt.state       ][INFO    ][2116] Running state [root] at time 19:00:40.550256
2018-04-20 19:00:40,550 [salt.state       ][INFO    ][2116] Executing state user.present for root
2018-04-20 19:00:40,555 [salt.state       ][INFO    ][2116] User root is present and up to date
2018-04-20 19:00:40,555 [salt.state       ][INFO    ][2116] Completed state [root] at time 19:00:40.555313 duration_in_ms=5.057
2018-04-20 19:00:40,556 [salt.state       ][INFO    ][2116] Running state [/root] at time 19:00:40.556656
2018-04-20 19:00:40,556 [salt.state       ][INFO    ][2116] Executing state file.directory for /root
2018-04-20 19:00:40,557 [salt.state       ][INFO    ][2116] Directory /root is in the correct state
2018-04-20 19:00:40,557 [salt.state       ][INFO    ][2116] Completed state [/root] at time 19:00:40.557946 duration_in_ms=1.29
2018-04-20 19:00:40,558 [salt.state       ][INFO    ][2116] Running state [/etc/sudoers.d/90-salt-user-root] at time 19:00:40.558177
2018-04-20 19:00:40,558 [salt.state       ][INFO    ][2116] Executing state file.absent for /etc/sudoers.d/90-salt-user-root
2018-04-20 19:00:40,558 [salt.state       ][INFO    ][2116] File /etc/sudoers.d/90-salt-user-root is not present
2018-04-20 19:00:40,559 [salt.state       ][INFO    ][2116] Completed state [/etc/sudoers.d/90-salt-user-root] at time 19:00:40.559713 duration_in_ms=1.537
2018-04-20 19:00:40,559 [salt.state       ][INFO    ][2116] Running state [ubuntu] at time 19:00:40.559946
2018-04-20 19:00:40,560 [salt.state       ][INFO    ][2116] Executing state group.present for ubuntu
2018-04-20 19:00:40,560 [salt.state       ][INFO    ][2116] Group ubuntu is present and up to date
2018-04-20 19:00:40,560 [salt.state       ][INFO    ][2116] Completed state [ubuntu] at time 19:00:40.560670 duration_in_ms=0.725
2018-04-20 19:00:40,561 [salt.state       ][INFO    ][2116] Running state [ubuntu] at time 19:00:40.561645
2018-04-20 19:00:40,561 [salt.state       ][INFO    ][2116] Executing state user.present for ubuntu
2018-04-20 19:00:40,565 [salt.state       ][INFO    ][2116] {'passwd': 'XXX-REDACTED-XXX'}
2018-04-20 19:00:40,565 [salt.state       ][INFO    ][2116] Completed state [ubuntu] at time 19:00:40.565646 duration_in_ms=4.001
2018-04-20 19:00:40,567 [salt.state       ][INFO    ][2116] Running state [/home/ubuntu] at time 19:00:40.566818
2018-04-20 19:00:40,567 [salt.state       ][INFO    ][2116] Executing state file.directory for /home/ubuntu
2018-04-20 19:00:40,568 [salt.state       ][INFO    ][2116] {'mode': '0700'}
2018-04-20 19:00:40,568 [salt.state       ][INFO    ][2116] Completed state [/home/ubuntu] at time 19:00:40.568515 duration_in_ms=1.697
2018-04-20 19:00:40,569 [salt.state       ][INFO    ][2116] Running state [/etc/sudoers.d/90-salt-user-ubuntu] at time 19:00:40.569473
2018-04-20 19:00:40,569 [salt.state       ][INFO    ][2116] Executing state file.managed for /etc/sudoers.d/90-salt-user-ubuntu
2018-04-20 19:00:40,892 [salt.fileclient  ][INFO    ][2116] Fetching file from saltenv 'base', ** done ** 'linux/files/sudoer'
2018-04-20 19:00:40,898 [salt.loaded.int.module.cmdmod][INFO    ][2116] Executing command '/usr/sbin/visudo -c -f /tmp/tmpx9D6NI' in directory '/root'
2018-04-20 19:00:40,921 [salt.state       ][INFO    ][2116] File changed:
New file
2018-04-20 19:00:40,922 [salt.state       ][INFO    ][2116] Completed state [/etc/sudoers.d/90-salt-user-ubuntu] at time 19:00:40.922343 duration_in_ms=352.869
2018-04-20 19:00:40,922 [salt.state       ][INFO    ][2116] Running state [/etc/security/limits.d/90-salt-default.conf] at time 19:00:40.922712
2018-04-20 19:00:40,923 [salt.state       ][INFO    ][2116] Executing state file.managed for /etc/security/limits.d/90-salt-default.conf
2018-04-20 19:00:40,949 [salt.fileclient  ][INFO    ][2116] Fetching file from saltenv 'base', ** done ** 'linux/files/limits.conf'
2018-04-20 19:00:41,044 [salt.state       ][INFO    ][2116] File changed:
New file
2018-04-20 19:00:41,044 [salt.state       ][INFO    ][2116] Completed state [/etc/security/limits.d/90-salt-default.conf] at time 19:00:41.044873 duration_in_ms=122.161
2018-04-20 19:00:41,045 [salt.state       ][INFO    ][2116] Running state [/etc/systemd/system.conf.d/90-salt.conf] at time 19:00:41.045134
2018-04-20 19:00:41,045 [salt.state       ][INFO    ][2116] Executing state file.managed for /etc/systemd/system.conf.d/90-salt.conf
2018-04-20 19:00:41,065 [salt.fileclient  ][INFO    ][2116] Fetching file from saltenv 'base', ** done ** 'linux/files/systemd.conf'
2018-04-20 19:00:41,154 [salt.state       ][INFO    ][2116] File changed:
New file
2018-04-20 19:00:41,155 [salt.state       ][INFO    ][2116] Completed state [/etc/systemd/system.conf.d/90-salt.conf] at time 19:00:41.155166 duration_in_ms=110.032
2018-04-20 19:00:41,157 [salt.state       ][INFO    ][2116] Running state [service.systemctl_reload] at time 19:00:41.157059
2018-04-20 19:00:41,157 [salt.state       ][INFO    ][2116] Executing state module.wait for service.systemctl_reload
2018-04-20 19:00:41,157 [salt.state       ][INFO    ][2116] No changes made for service.systemctl_reload
2018-04-20 19:00:41,157 [salt.state       ][INFO    ][2116] Completed state [service.systemctl_reload] at time 19:00:41.157782 duration_in_ms=0.723
2018-04-20 19:00:41,158 [salt.state       ][INFO    ][2116] Running state [service.systemctl_reload] at time 19:00:41.157980
2018-04-20 19:00:41,158 [salt.state       ][INFO    ][2116] Executing state module.mod_watch for service.systemctl_reload
2018-04-20 19:00:41,158 [salt.loaded.int.module.cmdmod][INFO    ][2116] Executing command ['systemctl', '--system', 'daemon-reload'] in directory '/root'
2018-04-20 19:00:41,253 [salt.state       ][INFO    ][2116] {'ret': True}
2018-04-20 19:00:41,254 [salt.state       ][INFO    ][2116] Completed state [service.systemctl_reload] at time 19:00:41.254189 duration_in_ms=96.209
2018-04-20 19:00:41,254 [salt.state       ][INFO    ][2116] Running state [/etc/hostname] at time 19:00:41.254675
2018-04-20 19:00:41,257 [salt.state       ][INFO    ][2116] Executing state file.managed for /etc/hostname
2018-04-20 19:00:41,284 [salt.fileclient  ][INFO    ][2116] Fetching file from saltenv 'base', ** done ** 'linux/files/hostname'
2018-04-20 19:00:41,289 [salt.state       ][INFO    ][2116] File changed:
--- 
+++ 
@@ -1 +1 @@
-ubuntu
+msg01

2018-04-20 19:00:41,290 [salt.state       ][INFO    ][2116] Completed state [/etc/hostname] at time 19:00:41.290117 duration_in_ms=35.442
2018-04-20 19:00:41,293 [salt.state       ][INFO    ][2116] Running state [hostname msg01] at time 19:00:41.293853
2018-04-20 19:00:41,294 [salt.state       ][INFO    ][2116] Executing state cmd.wait for hostname msg01
2018-04-20 19:00:41,294 [salt.state       ][INFO    ][2116] No changes made for hostname msg01
2018-04-20 19:00:41,294 [salt.state       ][INFO    ][2116] Completed state [hostname msg01] at time 19:00:41.294599 duration_in_ms=0.746
2018-04-20 19:00:41,294 [salt.state       ][INFO    ][2116] Running state [hostname msg01] at time 19:00:41.294797
2018-04-20 19:00:41,295 [salt.state       ][INFO    ][2116] Executing state cmd.mod_watch for hostname msg01
2018-04-20 19:00:41,295 [salt.loaded.int.module.cmdmod][INFO    ][2116] Executing command 'hostname msg01' in directory '/root'
2018-04-20 19:00:41,309 [salt.state       ][INFO    ][2116] {'pid': 5200, 'retcode': 0, 'stderr': '', 'stdout': ''}
2018-04-20 19:00:41,310 [salt.state       ][INFO    ][2116] Completed state [hostname msg01] at time 19:00:41.310335 duration_in_ms=15.537
2018-04-20 19:00:41,312 [salt.state       ][INFO    ][2116] Running state [mdb02] at time 19:00:41.312080
2018-04-20 19:00:41,312 [salt.state       ][INFO    ][2116] Executing state host.present for mdb02
2018-04-20 19:00:41,313 [salt.state       ][INFO    ][2116] {'host': 'mdb02'}
2018-04-20 19:00:41,314 [salt.state       ][INFO    ][2116] Completed state [mdb02] at time 19:00:41.313972 duration_in_ms=1.892
2018-04-20 19:00:41,314 [salt.state       ][INFO    ][2116] Running state [mdb02.mcp-pike-odl-ha.local] at time 19:00:41.314533
2018-04-20 19:00:41,314 [salt.state       ][INFO    ][2116] Executing state host.present for mdb02.mcp-pike-odl-ha.local
2018-04-20 19:00:41,316 [salt.state       ][INFO    ][2116] {'host': 'mdb02.mcp-pike-odl-ha.local'}
2018-04-20 19:00:41,316 [salt.state       ][INFO    ][2116] Completed state [mdb02.mcp-pike-odl-ha.local] at time 19:00:41.316459 duration_in_ms=1.927
2018-04-20 19:00:41,316 [salt.state       ][INFO    ][2116] Running state [mdb03] at time 19:00:41.316699
2018-04-20 19:00:41,316 [salt.state       ][INFO    ][2116] Executing state host.present for mdb03
2018-04-20 19:00:41,317 [salt.state       ][INFO    ][2116] {'host': 'mdb03'}
2018-04-20 19:00:41,318 [salt.state       ][INFO    ][2116] Completed state [mdb03] at time 19:00:41.317994 duration_in_ms=1.295
2018-04-20 19:00:41,318 [salt.state       ][INFO    ][2116] Running state [mdb03.mcp-pike-odl-ha.local] at time 19:00:41.318223
2018-04-20 19:00:41,318 [salt.state       ][INFO    ][2116] Executing state host.present for mdb03.mcp-pike-odl-ha.local
2018-04-20 19:00:41,319 [salt.state       ][INFO    ][2116] {'host': 'mdb03.mcp-pike-odl-ha.local'}
2018-04-20 19:00:41,319 [salt.state       ][INFO    ][2116] Completed state [mdb03.mcp-pike-odl-ha.local] at time 19:00:41.319529 duration_in_ms=1.306
2018-04-20 19:00:41,319 [salt.state       ][INFO    ][2116] Running state [mdb01] at time 19:00:41.319762
2018-04-20 19:00:41,319 [salt.state       ][INFO    ][2116] Executing state host.present for mdb01
2018-04-20 19:00:41,320 [salt.state       ][INFO    ][2116] {'host': 'mdb01'}
2018-04-20 19:00:41,321 [salt.state       ][INFO    ][2116] Completed state [mdb01] at time 19:00:41.321061 duration_in_ms=1.299
2018-04-20 19:00:41,321 [salt.state       ][INFO    ][2116] Running state [mdb01.mcp-pike-odl-ha.local] at time 19:00:41.321302
2018-04-20 19:00:41,321 [salt.state       ][INFO    ][2116] Executing state host.present for mdb01.mcp-pike-odl-ha.local
2018-04-20 19:00:41,322 [salt.state       ][INFO    ][2116] {'host': 'mdb01.mcp-pike-odl-ha.local'}
2018-04-20 19:00:41,322 [salt.state       ][INFO    ][2116] Completed state [mdb01.mcp-pike-odl-ha.local] at time 19:00:41.322623 duration_in_ms=1.321
2018-04-20 19:00:41,322 [salt.state       ][INFO    ][2116] Running state [mdb] at time 19:00:41.322875
2018-04-20 19:00:41,323 [salt.state       ][INFO    ][2116] Executing state host.present for mdb
2018-04-20 19:00:41,324 [salt.state       ][INFO    ][2116] {'host': 'mdb'}
2018-04-20 19:00:41,324 [salt.state       ][INFO    ][2116] Completed state [mdb] at time 19:00:41.324191 duration_in_ms=1.316
2018-04-20 19:00:41,324 [salt.state       ][INFO    ][2116] Running state [mdb.mcp-pike-odl-ha.local] at time 19:00:41.324425
2018-04-20 19:00:41,324 [salt.state       ][INFO    ][2116] Executing state host.present for mdb.mcp-pike-odl-ha.local
2018-04-20 19:00:41,325 [salt.state       ][INFO    ][2116] {'host': 'mdb.mcp-pike-odl-ha.local'}
2018-04-20 19:00:41,326 [salt.state       ][INFO    ][2116] Completed state [mdb.mcp-pike-odl-ha.local] at time 19:00:41.326250 duration_in_ms=1.824
2018-04-20 19:00:41,326 [salt.state       ][INFO    ][2116] Running state [cfg01] at time 19:00:41.326605
2018-04-20 19:00:41,328 [salt.state       ][INFO    ][2116] Executing state host.present for cfg01
2018-04-20 19:00:41,329 [salt.state       ][INFO    ][2116] {'host': 'cfg01'}
2018-04-20 19:00:41,329 [salt.state       ][INFO    ][2116] Completed state [cfg01] at time 19:00:41.329554 duration_in_ms=2.949
2018-04-20 19:00:41,329 [salt.state       ][INFO    ][2116] Running state [cfg01.mcp-pike-odl-ha.local] at time 19:00:41.329928
2018-04-20 19:00:41,330 [salt.state       ][INFO    ][2116] Executing state host.present for cfg01.mcp-pike-odl-ha.local
2018-04-20 19:00:41,331 [salt.state       ][INFO    ][2116] {'host': 'cfg01.mcp-pike-odl-ha.local'}
2018-04-20 19:00:41,331 [salt.state       ][INFO    ][2116] Completed state [cfg01.mcp-pike-odl-ha.local] at time 19:00:41.331770 duration_in_ms=1.842
2018-04-20 19:00:41,332 [salt.state       ][INFO    ][2116] Running state [prx01] at time 19:00:41.332097
2018-04-20 19:00:41,332 [salt.state       ][INFO    ][2116] Executing state host.present for prx01
2018-04-20 19:00:41,333 [salt.state       ][INFO    ][2116] {'host': 'prx01'}
2018-04-20 19:00:41,333 [salt.state       ][INFO    ][2116] Completed state [prx01] at time 19:00:41.333942 duration_in_ms=1.844
2018-04-20 19:00:41,334 [salt.state       ][INFO    ][2116] Running state [prx01.mcp-pike-odl-ha.local] at time 19:00:41.334269
2018-04-20 19:00:41,334 [salt.state       ][INFO    ][2116] Executing state host.present for prx01.mcp-pike-odl-ha.local
2018-04-20 19:00:41,335 [salt.state       ][INFO    ][2116] {'host': 'prx01.mcp-pike-odl-ha.local'}
2018-04-20 19:00:41,335 [salt.state       ][INFO    ][2116] Completed state [prx01.mcp-pike-odl-ha.local] at time 19:00:41.335857 duration_in_ms=1.588
2018-04-20 19:00:41,336 [salt.state       ][INFO    ][2116] Running state [kvm01] at time 19:00:41.336091
2018-04-20 19:00:41,336 [salt.state       ][INFO    ][2116] Executing state host.present for kvm01
2018-04-20 19:00:41,337 [salt.state       ][INFO    ][2116] {'host': 'kvm01'}
2018-04-20 19:00:41,337 [salt.state       ][INFO    ][2116] Completed state [kvm01] at time 19:00:41.337448 duration_in_ms=1.357
2018-04-20 19:00:41,337 [salt.state       ][INFO    ][2116] Running state [kvm01.mcp-pike-odl-ha.local] at time 19:00:41.337708
2018-04-20 19:00:41,337 [salt.state       ][INFO    ][2116] Executing state host.present for kvm01.mcp-pike-odl-ha.local
2018-04-20 19:00:41,339 [salt.state       ][INFO    ][2116] {'host': 'kvm01.mcp-pike-odl-ha.local'}
2018-04-20 19:00:41,339 [salt.state       ][INFO    ][2116] Completed state [kvm01.mcp-pike-odl-ha.local] at time 19:00:41.339905 duration_in_ms=2.197
2018-04-20 19:00:41,340 [salt.state       ][INFO    ][2116] Running state [kvm03] at time 19:00:41.340138
2018-04-20 19:00:41,340 [salt.state       ][INFO    ][2116] Executing state host.present for kvm03
2018-04-20 19:00:41,341 [salt.state       ][INFO    ][2116] {'host': 'kvm03'}
2018-04-20 19:00:41,341 [salt.state       ][INFO    ][2116] Completed state [kvm03] at time 19:00:41.341495 duration_in_ms=1.357
2018-04-20 19:00:41,341 [salt.state       ][INFO    ][2116] Running state [kvm03.mcp-pike-odl-ha.local] at time 19:00:41.341762
2018-04-20 19:00:41,341 [salt.state       ][INFO    ][2116] Executing state host.present for kvm03.mcp-pike-odl-ha.local
2018-04-20 19:00:41,343 [salt.state       ][INFO    ][2116] {'host': 'kvm03.mcp-pike-odl-ha.local'}
2018-04-20 19:00:41,343 [salt.state       ][INFO    ][2116] Completed state [kvm03.mcp-pike-odl-ha.local] at time 19:00:41.343661 duration_in_ms=1.899
2018-04-20 19:00:41,343 [salt.state       ][INFO    ][2116] Running state [kvm02] at time 19:00:41.343901
2018-04-20 19:00:41,344 [salt.state       ][INFO    ][2116] Executing state host.present for kvm02
2018-04-20 19:00:41,345 [salt.state       ][INFO    ][2116] {'host': 'kvm02'}
2018-04-20 19:00:41,345 [salt.state       ][INFO    ][2116] Completed state [kvm02] at time 19:00:41.345243 duration_in_ms=1.342
2018-04-20 19:00:41,345 [salt.state       ][INFO    ][2116] Running state [kvm02.mcp-pike-odl-ha.local] at time 19:00:41.345470
2018-04-20 19:00:41,345 [salt.state       ][INFO    ][2116] Executing state host.present for kvm02.mcp-pike-odl-ha.local
2018-04-20 19:00:41,346 [salt.state       ][INFO    ][2116] {'host': 'kvm02.mcp-pike-odl-ha.local'}
2018-04-20 19:00:41,346 [salt.state       ][INFO    ][2116] Completed state [kvm02.mcp-pike-odl-ha.local] at time 19:00:41.346845 duration_in_ms=1.375
2018-04-20 19:00:41,347 [salt.state       ][INFO    ][2116] Running state [dbs] at time 19:00:41.347074
2018-04-20 19:00:41,347 [salt.state       ][INFO    ][2116] Executing state host.present for dbs
2018-04-20 19:00:41,348 [salt.state       ][INFO    ][2116] {'host': 'dbs'}
2018-04-20 19:00:41,348 [salt.state       ][INFO    ][2116] Completed state [dbs] at time 19:00:41.348412 duration_in_ms=1.338
2018-04-20 19:00:41,348 [salt.state       ][INFO    ][2116] Running state [dbs.mcp-pike-odl-ha.local] at time 19:00:41.348643
2018-04-20 19:00:41,348 [salt.state       ][INFO    ][2116] Executing state host.present for dbs.mcp-pike-odl-ha.local
2018-04-20 19:00:41,349 [salt.state       ][INFO    ][2116] {'host': 'dbs.mcp-pike-odl-ha.local'}
2018-04-20 19:00:41,350 [salt.state       ][INFO    ][2116] Completed state [dbs.mcp-pike-odl-ha.local] at time 19:00:41.350022 duration_in_ms=1.379
2018-04-20 19:00:41,350 [salt.state       ][INFO    ][2116] Running state [prx] at time 19:00:41.350256
2018-04-20 19:00:41,350 [salt.state       ][INFO    ][2116] Executing state host.present for prx
2018-04-20 19:00:41,352 [salt.state       ][INFO    ][2116] {'host': 'prx'}
2018-04-20 19:00:41,352 [salt.state       ][INFO    ][2116] Completed state [prx] at time 19:00:41.352504 duration_in_ms=2.247
2018-04-20 19:00:41,352 [salt.state       ][INFO    ][2116] Running state [prx.mcp-pike-odl-ha.local] at time 19:00:41.352732
2018-04-20 19:00:41,352 [salt.state       ][INFO    ][2116] Executing state host.present for prx.mcp-pike-odl-ha.local
2018-04-20 19:00:41,353 [salt.state       ][INFO    ][2116] {'host': 'prx.mcp-pike-odl-ha.local'}
2018-04-20 19:00:41,354 [salt.state       ][INFO    ][2116] Completed state [prx.mcp-pike-odl-ha.local] at time 19:00:41.354128 duration_in_ms=1.397
2018-04-20 19:00:41,354 [salt.state       ][INFO    ][2116] Running state [prx02] at time 19:00:41.354362
2018-04-20 19:00:41,354 [salt.state       ][INFO    ][2116] Executing state host.present for prx02
2018-04-20 19:00:41,355 [salt.state       ][INFO    ][2116] {'host': 'prx02'}
2018-04-20 19:00:41,356 [salt.state       ][INFO    ][2116] Completed state [prx02] at time 19:00:41.356030 duration_in_ms=1.668
2018-04-20 19:00:41,356 [salt.state       ][INFO    ][2116] Running state [prx02.mcp-pike-odl-ha.local] at time 19:00:41.356274
2018-04-20 19:00:41,356 [salt.state       ][INFO    ][2116] Executing state host.present for prx02.mcp-pike-odl-ha.local
2018-04-20 19:00:41,357 [salt.state       ][INFO    ][2116] {'host': 'prx02.mcp-pike-odl-ha.local'}
2018-04-20 19:00:41,357 [salt.state       ][INFO    ][2116] Completed state [prx02.mcp-pike-odl-ha.local] at time 19:00:41.357669 duration_in_ms=1.395
2018-04-20 19:00:41,357 [salt.state       ][INFO    ][2116] Running state [msg02] at time 19:00:41.357920
2018-04-20 19:00:41,358 [salt.state       ][INFO    ][2116] Executing state host.present for msg02
2018-04-20 19:00:41,359 [salt.state       ][INFO    ][2116] {'host': 'msg02'}
2018-04-20 19:00:41,359 [salt.state       ][INFO    ][2116] Completed state [msg02] at time 19:00:41.359317 duration_in_ms=1.397
2018-04-20 19:00:41,359 [salt.state       ][INFO    ][2116] Running state [msg02.mcp-pike-odl-ha.local] at time 19:00:41.359548
2018-04-20 19:00:41,359 [salt.state       ][INFO    ][2116] Executing state host.present for msg02.mcp-pike-odl-ha.local
2018-04-20 19:00:41,360 [salt.state       ][INFO    ][2116] {'host': 'msg02.mcp-pike-odl-ha.local'}
2018-04-20 19:00:41,360 [salt.state       ][INFO    ][2116] Completed state [msg02.mcp-pike-odl-ha.local] at time 19:00:41.360940 duration_in_ms=1.392
2018-04-20 19:00:41,361 [salt.state       ][INFO    ][2116] Running state [msg03] at time 19:00:41.361171
2018-04-20 19:00:41,361 [salt.state       ][INFO    ][2116] Executing state host.present for msg03
2018-04-20 19:00:41,362 [salt.state       ][INFO    ][2116] {'host': 'msg03'}
2018-04-20 19:00:41,362 [salt.state       ][INFO    ][2116] Completed state [msg03] at time 19:00:41.362663 duration_in_ms=1.492
2018-04-20 19:00:41,363 [salt.state       ][INFO    ][2116] Running state [msg03.mcp-pike-odl-ha.local] at time 19:00:41.363777
2018-04-20 19:00:41,364 [salt.state       ][INFO    ][2116] Executing state host.present for msg03.mcp-pike-odl-ha.local
2018-04-20 19:00:41,365 [salt.state       ][INFO    ][2116] {'host': 'msg03.mcp-pike-odl-ha.local'}
2018-04-20 19:00:41,365 [salt.state       ][INFO    ][2116] Completed state [msg03.mcp-pike-odl-ha.local] at time 19:00:41.365271 duration_in_ms=1.494
2018-04-20 19:00:41,365 [salt.state       ][INFO    ][2116] Running state [msg01] at time 19:00:41.365528
2018-04-20 19:00:41,365 [salt.state       ][INFO    ][2116] Executing state host.present for msg01
2018-04-20 19:00:41,367 [salt.state       ][INFO    ][2116] {'host': 'msg01'}
2018-04-20 19:00:41,367 [salt.state       ][INFO    ][2116] Completed state [msg01] at time 19:00:41.367686 duration_in_ms=2.158
2018-04-20 19:00:41,367 [salt.state       ][INFO    ][2116] Running state [msg01.mcp-pike-odl-ha.local] at time 19:00:41.367924
2018-04-20 19:00:41,368 [salt.state       ][INFO    ][2116] Executing state host.present for msg01.mcp-pike-odl-ha.local
2018-04-20 19:00:41,369 [salt.state       ][INFO    ][2116] {'host': 'msg01.mcp-pike-odl-ha.local'}
2018-04-20 19:00:41,369 [salt.state       ][INFO    ][2116] Completed state [msg01.mcp-pike-odl-ha.local] at time 19:00:41.369365 duration_in_ms=1.44
2018-04-20 19:00:41,369 [salt.state       ][INFO    ][2116] Running state [msg] at time 19:00:41.369632
2018-04-20 19:00:41,369 [salt.state       ][INFO    ][2116] Executing state host.present for msg
2018-04-20 19:00:41,371 [salt.state       ][INFO    ][2116] {'host': 'msg'}
2018-04-20 19:00:41,371 [salt.state       ][INFO    ][2116] Completed state [msg] at time 19:00:41.371421 duration_in_ms=1.789
2018-04-20 19:00:41,371 [salt.state       ][INFO    ][2116] Running state [msg.mcp-pike-odl-ha.local] at time 19:00:41.371649
2018-04-20 19:00:41,371 [salt.state       ][INFO    ][2116] Executing state host.present for msg.mcp-pike-odl-ha.local
2018-04-20 19:00:41,372 [salt.state       ][INFO    ][2116] {'host': 'msg.mcp-pike-odl-ha.local'}
2018-04-20 19:00:41,373 [salt.state       ][INFO    ][2116] Completed state [msg.mcp-pike-odl-ha.local] at time 19:00:41.373102 duration_in_ms=1.453
2018-04-20 19:00:41,373 [salt.state       ][INFO    ][2116] Running state [cfg01] at time 19:00:41.373340
2018-04-20 19:00:41,373 [salt.state       ][INFO    ][2116] Executing state host.present for cfg01
2018-04-20 19:00:41,374 [salt.state       ][INFO    ][2116] Host cfg01 (192.168.10.11) already present
2018-04-20 19:00:41,374 [salt.state       ][INFO    ][2116] Completed state [cfg01] at time 19:00:41.374249 duration_in_ms=0.909
2018-04-20 19:00:41,374 [salt.state       ][INFO    ][2116] Running state [cfg01.mcp-pike-odl-ha.local] at time 19:00:41.374475
2018-04-20 19:00:41,374 [salt.state       ][INFO    ][2116] Executing state host.present for cfg01.mcp-pike-odl-ha.local
2018-04-20 19:00:41,376 [salt.state       ][INFO    ][2116] Host cfg01.mcp-pike-odl-ha.local (192.168.10.11) already present
2018-04-20 19:00:41,376 [salt.state       ][INFO    ][2116] Completed state [cfg01.mcp-pike-odl-ha.local] at time 19:00:41.376715 duration_in_ms=2.24
2018-04-20 19:00:41,376 [salt.state       ][INFO    ][2116] Running state [cmp002] at time 19:00:41.376948
2018-04-20 19:00:41,377 [salt.state       ][INFO    ][2116] Executing state host.present for cmp002
2018-04-20 19:00:41,378 [salt.state       ][INFO    ][2116] {'host': 'cmp002'}
2018-04-20 19:00:41,378 [salt.state       ][INFO    ][2116] Completed state [cmp002] at time 19:00:41.378414 duration_in_ms=1.466
2018-04-20 19:00:41,378 [salt.state       ][INFO    ][2116] Running state [cmp002.mcp-pike-odl-ha.local] at time 19:00:41.378652
2018-04-20 19:00:41,379 [salt.state       ][INFO    ][2116] Executing state host.present for cmp002.mcp-pike-odl-ha.local
2018-04-20 19:00:41,380 [salt.state       ][INFO    ][2116] {'host': 'cmp002.mcp-pike-odl-ha.local'}
2018-04-20 19:00:41,380 [salt.state       ][INFO    ][2116] Completed state [cmp002.mcp-pike-odl-ha.local] at time 19:00:41.380407 duration_in_ms=1.755
2018-04-20 19:00:41,380 [salt.state       ][INFO    ][2116] Running state [cmp001] at time 19:00:41.380639
2018-04-20 19:00:41,380 [salt.state       ][INFO    ][2116] Executing state host.present for cmp001
2018-04-20 19:00:41,381 [salt.state       ][INFO    ][2116] {'host': 'cmp001'}
2018-04-20 19:00:41,382 [salt.state       ][INFO    ][2116] Completed state [cmp001] at time 19:00:41.382147 duration_in_ms=1.508
2018-04-20 19:00:41,382 [salt.state       ][INFO    ][2116] Running state [cmp001.mcp-pike-odl-ha.local] at time 19:00:41.382379
2018-04-20 19:00:41,382 [salt.state       ][INFO    ][2116] Executing state host.present for cmp001.mcp-pike-odl-ha.local
2018-04-20 19:00:41,383 [salt.state       ][INFO    ][2116] {'host': 'cmp001.mcp-pike-odl-ha.local'}
2018-04-20 19:00:41,383 [salt.state       ][INFO    ][2116] Completed state [cmp001.mcp-pike-odl-ha.local] at time 19:00:41.383896 duration_in_ms=1.517
2018-04-20 19:00:41,384 [salt.state       ][INFO    ][2116] Running state [dbs01] at time 19:00:41.384127
2018-04-20 19:00:41,384 [salt.state       ][INFO    ][2116] Executing state host.present for dbs01
2018-04-20 19:00:41,385 [salt.state       ][INFO    ][2116] {'host': 'dbs01'}
2018-04-20 19:00:41,385 [salt.state       ][INFO    ][2116] Completed state [dbs01] at time 19:00:41.385824 duration_in_ms=1.697
2018-04-20 19:00:41,386 [salt.state       ][INFO    ][2116] Running state [dbs01.mcp-pike-odl-ha.local] at time 19:00:41.386064
2018-04-20 19:00:41,386 [salt.state       ][INFO    ][2116] Executing state host.present for dbs01.mcp-pike-odl-ha.local
2018-04-20 19:00:41,388 [salt.state       ][INFO    ][2116] {'host': 'dbs01.mcp-pike-odl-ha.local'}
2018-04-20 19:00:41,388 [salt.state       ][INFO    ][2116] Completed state [dbs01.mcp-pike-odl-ha.local] at time 19:00:41.388575 duration_in_ms=2.511
2018-04-20 19:00:41,388 [salt.state       ][INFO    ][2116] Running state [dbs02] at time 19:00:41.388824
2018-04-20 19:00:41,389 [salt.state       ][INFO    ][2116] Executing state host.present for dbs02
2018-04-20 19:00:41,390 [salt.state       ][INFO    ][2116] {'host': 'dbs02'}
2018-04-20 19:00:41,390 [salt.state       ][INFO    ][2116] Completed state [dbs02] at time 19:00:41.390501 duration_in_ms=1.676
2018-04-20 19:00:41,390 [salt.state       ][INFO    ][2116] Running state [dbs02.mcp-pike-odl-ha.local] at time 19:00:41.390743
2018-04-20 19:00:41,391 [salt.state       ][INFO    ][2116] Executing state host.present for dbs02.mcp-pike-odl-ha.local
2018-04-20 19:00:41,392 [salt.state       ][INFO    ][2116] {'host': 'dbs02.mcp-pike-odl-ha.local'}
2018-04-20 19:00:41,392 [salt.state       ][INFO    ][2116] Completed state [dbs02.mcp-pike-odl-ha.local] at time 19:00:41.392923 duration_in_ms=2.18
2018-04-20 19:00:41,393 [salt.state       ][INFO    ][2116] Running state [dbs03] at time 19:00:41.393163
2018-04-20 19:00:41,393 [salt.state       ][INFO    ][2116] Executing state host.present for dbs03
2018-04-20 19:00:41,394 [salt.state       ][INFO    ][2116] {'host': 'dbs03'}
2018-04-20 19:00:41,394 [salt.state       ][INFO    ][2116] Completed state [dbs03] at time 19:00:41.394750 duration_in_ms=1.587
2018-04-20 19:00:41,395 [salt.state       ][INFO    ][2116] Running state [dbs03.mcp-pike-odl-ha.local] at time 19:00:41.395010
2018-04-20 19:00:41,395 [salt.state       ][INFO    ][2116] Executing state host.present for dbs03.mcp-pike-odl-ha.local
2018-04-20 19:00:41,396 [salt.state       ][INFO    ][2116] {'host': 'dbs03.mcp-pike-odl-ha.local'}
2018-04-20 19:00:41,396 [salt.state       ][INFO    ][2116] Completed state [dbs03.mcp-pike-odl-ha.local] at time 19:00:41.396576 duration_in_ms=1.566
2018-04-20 19:00:41,396 [salt.state       ][INFO    ][2116] Running state [odl01] at time 19:00:41.396808
2018-04-20 19:00:41,397 [salt.state       ][INFO    ][2116] Executing state host.present for odl01
2018-04-20 19:00:41,398 [salt.state       ][INFO    ][2116] {'host': 'odl01'}
2018-04-20 19:00:41,398 [salt.state       ][INFO    ][2116] Completed state [odl01] at time 19:00:41.398398 duration_in_ms=1.59
2018-04-20 19:00:41,398 [salt.state       ][INFO    ][2116] Running state [odl01.mcp-pike-odl-ha.local] at time 19:00:41.398670
2018-04-20 19:00:41,400 [salt.state       ][INFO    ][2116] Executing state host.present for odl01.mcp-pike-odl-ha.local
2018-04-20 19:00:41,401 [salt.state       ][INFO    ][2116] {'host': 'odl01.mcp-pike-odl-ha.local'}
2018-04-20 19:00:41,401 [salt.state       ][INFO    ][2116] Completed state [odl01.mcp-pike-odl-ha.local] at time 19:00:41.401664 duration_in_ms=2.995
2018-04-20 19:00:41,401 [salt.state       ][INFO    ][2116] Running state [mas01] at time 19:00:41.401928
2018-04-20 19:00:41,402 [salt.state       ][INFO    ][2116] Executing state host.present for mas01
2018-04-20 19:00:41,403 [salt.state       ][INFO    ][2116] {'host': 'mas01'}
2018-04-20 19:00:41,404 [salt.state       ][INFO    ][2116] Completed state [mas01] at time 19:00:41.403980 duration_in_ms=2.052
2018-04-20 19:00:41,404 [salt.state       ][INFO    ][2116] Running state [mas01.mcp-pike-odl-ha.local] at time 19:00:41.404230
2018-04-20 19:00:41,404 [salt.state       ][INFO    ][2116] Executing state host.present for mas01.mcp-pike-odl-ha.local
2018-04-20 19:00:41,405 [salt.state       ][INFO    ][2116] {'host': 'mas01.mcp-pike-odl-ha.local'}
2018-04-20 19:00:41,405 [salt.state       ][INFO    ][2116] Completed state [mas01.mcp-pike-odl-ha.local] at time 19:00:41.405862 duration_in_ms=1.632
2018-04-20 19:00:41,406 [salt.state       ][INFO    ][2116] Running state [ctl02] at time 19:00:41.406106
2018-04-20 19:00:41,406 [salt.state       ][INFO    ][2116] Executing state host.present for ctl02
2018-04-20 19:00:41,407 [salt.state       ][INFO    ][2116] {'host': 'ctl02'}
2018-04-20 19:00:41,407 [salt.state       ][INFO    ][2116] Completed state [ctl02] at time 19:00:41.407756 duration_in_ms=1.65
2018-04-20 19:00:41,408 [salt.state       ][INFO    ][2116] Running state [ctl02.mcp-pike-odl-ha.local] at time 19:00:41.407987
2018-04-20 19:00:41,408 [salt.state       ][INFO    ][2116] Executing state host.present for ctl02.mcp-pike-odl-ha.local
2018-04-20 19:00:41,409 [salt.state       ][INFO    ][2116] {'host': 'ctl02.mcp-pike-odl-ha.local'}
2018-04-20 19:00:41,409 [salt.state       ][INFO    ][2116] Completed state [ctl02.mcp-pike-odl-ha.local] at time 19:00:41.409618 duration_in_ms=1.631
2018-04-20 19:00:41,409 [salt.state       ][INFO    ][2116] Running state [ctl03] at time 19:00:41.409909
2018-04-20 19:00:41,410 [salt.state       ][INFO    ][2116] Executing state host.present for ctl03
2018-04-20 19:00:41,411 [salt.state       ][INFO    ][2116] {'host': 'ctl03'}
2018-04-20 19:00:41,412 [salt.state       ][INFO    ][2116] Completed state [ctl03] at time 19:00:41.412139 duration_in_ms=2.23
2018-04-20 19:00:41,412 [salt.state       ][INFO    ][2116] Running state [ctl03.mcp-pike-odl-ha.local] at time 19:00:41.412373
2018-04-20 19:00:41,412 [salt.state       ][INFO    ][2116] Executing state host.present for ctl03.mcp-pike-odl-ha.local
2018-04-20 19:00:41,413 [salt.state       ][INFO    ][2116] {'host': 'ctl03.mcp-pike-odl-ha.local'}
2018-04-20 19:00:41,414 [salt.state       ][INFO    ][2116] Completed state [ctl03.mcp-pike-odl-ha.local] at time 19:00:41.414050 duration_in_ms=1.677
2018-04-20 19:00:41,414 [salt.state       ][INFO    ][2116] Running state [ctl01] at time 19:00:41.414284
2018-04-20 19:00:41,414 [salt.state       ][INFO    ][2116] Executing state host.present for ctl01
2018-04-20 19:00:41,416 [salt.state       ][INFO    ][2116] {'host': 'ctl01'}
2018-04-20 19:00:41,416 [salt.state       ][INFO    ][2116] Completed state [ctl01] at time 19:00:41.416208 duration_in_ms=1.923
2018-04-20 19:00:41,416 [salt.state       ][INFO    ][2116] Running state [ctl01.mcp-pike-odl-ha.local] at time 19:00:41.416467
2018-04-20 19:00:41,416 [salt.state       ][INFO    ][2116] Executing state host.present for ctl01.mcp-pike-odl-ha.local
2018-04-20 19:00:41,417 [salt.state       ][INFO    ][2116] {'host': 'ctl01.mcp-pike-odl-ha.local'}
2018-04-20 19:00:41,418 [salt.state       ][INFO    ][2116] Completed state [ctl01.mcp-pike-odl-ha.local] at time 19:00:41.418143 duration_in_ms=1.676
2018-04-20 19:00:41,418 [salt.state       ][INFO    ][2116] Running state [ctl] at time 19:00:41.418377
2018-04-20 19:00:41,418 [salt.state       ][INFO    ][2116] Executing state host.present for ctl
2018-04-20 19:00:41,422 [salt.state       ][INFO    ][2116] {'host': 'ctl'}
2018-04-20 19:00:41,423 [salt.state       ][INFO    ][2116] Completed state [ctl] at time 19:00:41.423088 duration_in_ms=4.711
2018-04-20 19:00:41,423 [salt.state       ][INFO    ][2116] Running state [ctl.mcp-pike-odl-ha.local] at time 19:00:41.423331
2018-04-20 19:00:41,423 [salt.state       ][INFO    ][2116] Executing state host.present for ctl.mcp-pike-odl-ha.local
2018-04-20 19:00:41,424 [salt.state       ][INFO    ][2116] {'host': 'ctl.mcp-pike-odl-ha.local'}
2018-04-20 19:00:41,425 [salt.state       ][INFO    ][2116] Completed state [ctl.mcp-pike-odl-ha.local] at time 19:00:41.424967 duration_in_ms=1.636
2018-04-20 19:00:41,425 [salt.state       ][INFO    ][2116] Running state [/etc/network/interfaces.d/50-cloud-init.cfg] at time 19:00:41.425229
2018-04-20 19:00:41,425 [salt.state       ][INFO    ][2116] Executing state file.absent for /etc/network/interfaces.d/50-cloud-init.cfg
2018-04-20 19:00:41,425 [salt.state       ][INFO    ][2116] {'removed': '/etc/network/interfaces.d/50-cloud-init.cfg'}
2018-04-20 19:00:41,426 [salt.state       ][INFO    ][2116] Completed state [/etc/network/interfaces.d/50-cloud-init.cfg] at time 19:00:41.426103 duration_in_ms=0.874
2018-04-20 19:00:41,427 [salt.state       ][INFO    ][2116] Running state [ens2] at time 19:00:41.427959
2018-04-20 19:00:41,428 [salt.state       ][INFO    ][2116] Executing state network.managed for ens2
2018-04-20 19:00:41,576 [salt.loaded.int.module.cmdmod][INFO    ][2116] Executing command ['ifdown', 'ens2'] in directory '/root'
2018-04-20 19:00:42,728 [salt.loaded.int.module.cmdmod][INFO    ][2116] Executing command ['ifup', 'ens2'] in directory '/root'
2018-04-20 19:00:43,964 [salt.state       ][INFO    ][2116] {'interface': 'Added network interface.', 'status': 'Interface ens2 restart to validate'}
2018-04-20 19:00:43,964 [salt.state       ][INFO    ][2116] Completed state [ens2] at time 19:00:43.964813 duration_in_ms=2536.853
2018-04-20 19:00:43,965 [salt.state       ][INFO    ][2116] Running state [ens3] at time 19:00:43.965475
2018-04-20 19:00:43,966 [salt.state       ][INFO    ][2116] Executing state network.managed for ens3
2018-04-20 19:00:43,994 [salt.loaded.int.module.cmdmod][INFO    ][2116] Executing command ['ifup', 'ens3'] in directory '/root'
2018-04-20 19:00:44,694 [salt.state       ][INFO    ][2116] {'interface': 'Added network interface.', 'status': 'Interface ens3 is up'}
2018-04-20 19:00:44,695 [salt.state       ][INFO    ][2116] Completed state [ens3] at time 19:00:44.695346 duration_in_ms=729.87
2018-04-20 19:00:44,695 [salt.state       ][INFO    ][2116] Running state [/etc/profile.d/proxy.sh] at time 19:00:44.695706
2018-04-20 19:00:44,696 [salt.state       ][INFO    ][2116] Executing state file.absent for /etc/profile.d/proxy.sh
2018-04-20 19:00:44,696 [salt.state       ][INFO    ][2116] File /etc/profile.d/proxy.sh is not present
2018-04-20 19:00:44,696 [salt.state       ][INFO    ][2116] Completed state [/etc/profile.d/proxy.sh] at time 19:00:44.696754 duration_in_ms=1.048
2018-04-20 19:00:44,697 [salt.state       ][INFO    ][2116] Running state [/etc/apt/apt.conf.d/95proxies] at time 19:00:44.696990
2018-04-20 19:00:44,697 [salt.state       ][INFO    ][2116] Executing state file.absent for /etc/apt/apt.conf.d/95proxies
2018-04-20 19:00:44,697 [salt.state       ][INFO    ][2116] File /etc/apt/apt.conf.d/95proxies is not present
2018-04-20 19:00:44,697 [salt.state       ][INFO    ][2116] Completed state [/etc/apt/apt.conf.d/95proxies] at time 19:00:44.697763 duration_in_ms=0.774
2018-04-20 19:00:44,700 [salt.state       ][INFO    ][2116] Running state [ntp] at time 19:00:44.700074
2018-04-20 19:00:44,700 [salt.state       ][INFO    ][2116] Executing state pkg.installed for ntp
2018-04-20 19:00:44,822 [salt.loaded.int.module.cmdmod][INFO    ][2116] Executing command ['dpkg', '--get-selections', '*'] in directory '/root'
2018-04-20 19:00:44,852 [salt.loaded.int.module.cmdmod][INFO    ][2116] 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-20 19:00:45,854 [salt.minion      ][INFO    ][2025] User sudo_ubuntu Executing command saltutil.find_job with jid 20180420190045843345
2018-04-20 19:00:45,868 [salt.minion      ][INFO    ][5533] Starting a new job with PID 5533
2018-04-20 19:00:45,887 [salt.minion      ][INFO    ][5533] Returning information for job: 20180420190045843345
2018-04-20 19:00:48,488 [salt.loaded.int.module.cmdmod][INFO    ][2116] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2018-04-20 19:00:48,528 [salt.state       ][INFO    ][2116] 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-20 19:00:48,548 [salt.state       ][INFO    ][2116] Loading fresh modules for state activity
2018-04-20 19:00:48,580 [salt.state       ][INFO    ][2116] Completed state [ntp] at time 19:00:48.580211 duration_in_ms=3880.136
2018-04-20 19:00:48,584 [salt.state       ][INFO    ][2116] Running state [/etc/ntp.conf] at time 19:00:48.584529
2018-04-20 19:00:48,584 [salt.state       ][INFO    ][2116] Executing state file.managed for /etc/ntp.conf
2018-04-20 19:00:48,618 [salt.fileclient  ][INFO    ][2116] Fetching file from saltenv 'base', ** done ** 'ntp/files/ntp.conf'
2018-04-20 19:00:48,763 [salt.state       ][INFO    ][2116] File changed:
--- 
+++ 
@@ -1,66 +1,26 @@
-# /etc/ntp.conf, configuration for ntpd; see ntp.conf(5) for help
 
-driftfile /var/lib/ntp/ntp.drift
 
-# Enable this if you want statistics to be logged.
-#statsdir /var/log/ntpstats/
+# ntpd will only synchronize your clock.
 
-statistics loopstats peerstats clockstats
-filegen loopstats file loopstats type day enable
-filegen peerstats file peerstats type day enable
-filegen clockstats file clockstats type day enable
+# For details, see:
+# - the ntp.conf man page
+# - http://support.ntp.org/bin/view/Support/GettingStarted
+# - https://wiki.archlinux.org/index.php/Network_Time_Protocol_daemon
 
-# Specify one or more NTP servers.
+# Associate to cloud NTP pool servers
+server 1.pool.ntp.org iburst
+server 0.pool.ntp.org
 
-# Use servers from the NTP Pool Project. Approved by Ubuntu Technical Board
-# on 2011-02-08 (LP: #104525). See http://www.pool.ntp.org/join.html for
-# more information.
-pool 0.ubuntu.pool.ntp.org iburst
-pool 1.ubuntu.pool.ntp.org iburst
-pool 2.ubuntu.pool.ntp.org iburst
-pool 3.ubuntu.pool.ntp.org iburst
+# Exchange time with everybody, but don't allow configuration.
+restrict -4 default kod notrap nomodify nopeer noquery
+restrict -6 default kod notrap nomodify nopeer noquery
 
-# Use Ubuntu's ntp server as a fallback.
-pool ntp.ubuntu.com
-
-# Access control configuration; see /usr/share/doc/ntp-doc/html/accopt.html for
-# details.  The web page <http://support.ntp.org/bin/view/Support/AccessRestrictions>
-# might also be helpful.
-#
-# Note that "restrict" applies to both servers and clients, so a configuration
-# that might be intended to block requests from certain clients could also end
-# up blocking replies from your own upstream servers.
-
-# By default, exchange time with everybody, but don't allow configuration.
-restrict -4 default kod notrap nomodify nopeer noquery limited
-restrict -6 default kod notrap nomodify nopeer noquery limited
-
-# Local users may interrogate the ntp server more closely.
+# Only allow read-only access from localhost
 restrict 127.0.0.1
 restrict ::1
 
-# Needed for adding pool entries
-restrict source notrap nomodify noquery
+# mode7 is required for collectd monitoring
 
-# Clients from this (example!) subnet have unlimited access, but only if
-# cryptographically authenticated.
-#restrict 192.168.123.0 mask 255.255.255.0 notrust
-
-
-# If you want to provide time to your local subnet, change the next line.
-# (Again, the address is an example only.)
-#broadcast 192.168.123.255
-
-# If you want to listen to time broadcasts on your local subnet, de-comment the
-# next lines.  Please do this only if you trust everybody on the network!
-#disable auth
-#broadcastclient
-
-#Changes recquired to use pps synchonisation as explained in documentation:
-#http://www.ntp.org/ntpfaq/NTP-s-config-adv.htm#AEN3918
-
-#server 127.127.8.1 mode 135 prefer    # Meinberg GPS167 with PPS
-#fudge 127.127.8.1 time1 0.0042        # relative to PPS for my hardware
-
-#server 127.127.22.1                   # ATOM(PPS)
-#fudge 127.127.22.1 flag3 1            # enable PPS API
+# Location of drift file
+driftfile /var/lib/ntp/ntp.drift
+logfile /var/log/ntp.log

2018-04-20 19:00:48,764 [salt.state       ][INFO    ][2116] Completed state [/etc/ntp.conf] at time 19:00:48.764179 duration_in_ms=179.649
2018-04-20 19:00:49,102 [salt.state       ][INFO    ][2116] Running state [ntp] at time 19:00:49.102678
2018-04-20 19:00:49,103 [salt.state       ][INFO    ][2116] Executing state service.running for ntp
2018-04-20 19:00:49,105 [salt.loaded.int.module.cmdmod][INFO    ][2116] Executing command ['systemctl', 'status', 'ntp.service', '-n', '0'] in directory '/root'
2018-04-20 19:00:49,123 [salt.loaded.int.module.cmdmod][INFO    ][2116] Executing command ['systemctl', 'is-active', 'ntp.service'] in directory '/root'
2018-04-20 19:00:49,141 [salt.loaded.int.module.cmdmod][INFO    ][2116] Executing command ['systemctl', 'is-enabled', 'ntp.service'] in directory '/root'
2018-04-20 19:00:49,161 [salt.state       ][INFO    ][2116] The service ntp is already running
2018-04-20 19:00:49,161 [salt.state       ][INFO    ][2116] Completed state [ntp] at time 19:00:49.161425 duration_in_ms=58.747
2018-04-20 19:00:49,161 [salt.state       ][INFO    ][2116] Running state [ntp] at time 19:00:49.161754
2018-04-20 19:00:49,162 [salt.state       ][INFO    ][2116] Executing state service.mod_watch for ntp
2018-04-20 19:00:49,163 [salt.loaded.int.module.cmdmod][INFO    ][2116] Executing command ['systemctl', 'is-active', 'ntp.service'] in directory '/root'
2018-04-20 19:00:49,181 [salt.loaded.int.module.cmdmod][INFO    ][2116] Executing command ['systemctl', 'is-enabled', 'ntp.service'] in directory '/root'
2018-04-20 19:00:49,200 [salt.loaded.int.module.cmdmod][INFO    ][2116] Executing command ['systemd-run', '--scope', 'systemctl', 'restart', 'ntp.service'] in directory '/root'
2018-04-20 19:00:49,289 [salt.state       ][INFO    ][2116] {'ntp': True}
2018-04-20 19:00:49,289 [salt.state       ][INFO    ][2116] Completed state [ntp] at time 19:00:49.289908 duration_in_ms=128.154
2018-04-20 19:00:49,296 [salt.minion      ][INFO    ][2116] Returning information for job: 20180420190005395557
2018-04-20 19:01:16,788 [salt.minion      ][INFO    ][2025] User sudo_ubuntu Executing command state.apply with jid 20180420190116777793
2018-04-20 19:01:16,809 [salt.minion      ][INFO    ][6323] Starting a new job with PID 6323
2018-04-20 19:01:20,260 [salt.state       ][INFO    ][6323] Loading fresh modules for state activity
2018-04-20 19:01:23,336 [salt.state       ][INFO    ][6323] Running state [/etc/environment] at time 19:01:23.336393
2018-04-20 19:01:23,336 [salt.state       ][INFO    ][6323] Executing state file.blockreplace for /etc/environment
2018-04-20 19:01:23,345 [salt.state       ][INFO    ][6323] File changed:
--- 
+++ 
@@ -1,3 +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-20 19:01:23,345 [salt.state       ][INFO    ][6323] Completed state [/etc/environment] at time 19:01:23.345237 duration_in_ms=8.845
2018-04-20 19:01:23,345 [salt.state       ][INFO    ][6323] Running state [/etc/profile.d] at time 19:01:23.345481
2018-04-20 19:01:23,345 [salt.state       ][INFO    ][6323] Executing state file.directory for /etc/profile.d
2018-04-20 19:01:23,347 [salt.state       ][INFO    ][6323] Directory /etc/profile.d is in the correct state
2018-04-20 19:01:23,347 [salt.state       ][INFO    ][6323] Completed state [/etc/profile.d] at time 19:01:23.347295 duration_in_ms=1.814
2018-04-20 19:01:23,873 [salt.state       ][INFO    ][6323] Running state [/etc/apt/apt.conf.d/99prefer_ipv4-salt] at time 19:01:23.873655
2018-04-20 19:01:23,874 [salt.state       ][INFO    ][6323] Executing state file.managed for /etc/apt/apt.conf.d/99prefer_ipv4-salt
2018-04-20 19:01:23,904 [salt.state       ][INFO    ][6323] File /etc/apt/apt.conf.d/99prefer_ipv4-salt is in the correct state
2018-04-20 19:01:23,904 [salt.state       ][INFO    ][6323] Completed state [/etc/apt/apt.conf.d/99prefer_ipv4-salt] at time 19:01:23.904772 duration_in_ms=31.118
2018-04-20 19:01:23,905 [salt.state       ][INFO    ][6323] Running state [linux_repo_prereq_pkgs] at time 19:01:23.905666
2018-04-20 19:01:23,905 [salt.state       ][INFO    ][6323] Executing state pkg.installed for linux_repo_prereq_pkgs
2018-04-20 19:01:23,906 [salt.loaded.int.module.cmdmod][INFO    ][6323] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2018-04-20 19:01:24,262 [salt.state       ][INFO    ][6323] All specified packages are already installed
2018-04-20 19:01:24,263 [salt.state       ][INFO    ][6323] Completed state [linux_repo_prereq_pkgs] at time 19:01:24.263116 duration_in_ms=357.449
2018-04-20 19:01:24,263 [salt.state       ][INFO    ][6323] Running state [/etc/apt/apt.conf.d/99proxies-salt-mk_openstack] at time 19:01:24.263516
2018-04-20 19:01:24,263 [salt.state       ][INFO    ][6323] Executing state file.absent for /etc/apt/apt.conf.d/99proxies-salt-mk_openstack
2018-04-20 19:01:24,264 [salt.state       ][INFO    ][6323] File /etc/apt/apt.conf.d/99proxies-salt-mk_openstack is not present
2018-04-20 19:01:24,264 [salt.state       ][INFO    ][6323] Completed state [/etc/apt/apt.conf.d/99proxies-salt-mk_openstack] at time 19:01:24.264587 duration_in_ms=1.07
2018-04-20 19:01:24,264 [salt.state       ][INFO    ][6323] Running state [/etc/apt/preferences.d/mk_openstack] at time 19:01:24.264835
2018-04-20 19:01:24,265 [salt.state       ][INFO    ][6323] Executing state file.managed for /etc/apt/preferences.d/mk_openstack
2018-04-20 19:01:24,372 [salt.state       ][INFO    ][6323] File /etc/apt/preferences.d/mk_openstack is in the correct state
2018-04-20 19:01:24,372 [salt.state       ][INFO    ][6323] Completed state [/etc/apt/preferences.d/mk_openstack] at time 19:01:24.372903 duration_in_ms=108.068
2018-04-20 19:01:24,374 [salt.state       ][INFO    ][6323] Running state [curl -s http://apt.mirantis.com/public.gpg | apt-key add -] at time 19:01:24.374591
2018-04-20 19:01:24,374 [salt.state       ][INFO    ][6323] Executing state cmd.run for curl -s http://apt.mirantis.com/public.gpg | apt-key add -
2018-04-20 19:01:24,375 [salt.loaded.int.module.cmdmod][INFO    ][6323] Executing command 'curl -s http://apt.mirantis.com/public.gpg | apt-key add -' in directory '/root'
2018-04-20 19:01:24,553 [salt.state       ][INFO    ][6323] {'pid': 6383, 'retcode': 0, 'stderr': '', 'stdout': 'OK'}
2018-04-20 19:01:24,554 [salt.state       ][INFO    ][6323] Completed state [curl -s http://apt.mirantis.com/public.gpg | apt-key add -] at time 19:01:24.554277 duration_in_ms=179.685
2018-04-20 19:01:24,560 [salt.state       ][INFO    ][6323] Running state [deb [arch=amd64] http://apt.mirantis.com/xenial/ nightly pike] at time 19:01:24.559973
2018-04-20 19:01:24,560 [salt.state       ][INFO    ][6323] Executing state pkgrepo.managed for deb [arch=amd64] http://apt.mirantis.com/xenial/ nightly pike
2018-04-20 19:01:24,661 [salt.state       ][INFO    ][6323] Package repo 'deb [arch=amd64] http://apt.mirantis.com/xenial/ nightly pike' already configured
2018-04-20 19:01:24,662 [salt.state       ][INFO    ][6323] Completed state [deb [arch=amd64] http://apt.mirantis.com/xenial/ nightly pike] at time 19:01:24.662266 duration_in_ms=102.292
2018-04-20 19:01:24,662 [salt.state       ][INFO    ][6323] Running state [/etc/apt/apt.conf.d/99proxies-salt-uca-staging] at time 19:01:24.662533
2018-04-20 19:01:24,662 [salt.state       ][INFO    ][6323] Executing state file.absent for /etc/apt/apt.conf.d/99proxies-salt-uca-staging
2018-04-20 19:01:24,663 [salt.state       ][INFO    ][6323] File /etc/apt/apt.conf.d/99proxies-salt-uca-staging is not present
2018-04-20 19:01:24,663 [salt.state       ][INFO    ][6323] Completed state [/etc/apt/apt.conf.d/99proxies-salt-uca-staging] at time 19:01:24.663351 duration_in_ms=0.819
2018-04-20 19:01:24,663 [salt.state       ][INFO    ][6323] Running state [/etc/apt/preferences.d/uca-staging] at time 19:01:24.663581
2018-04-20 19:01:24,663 [salt.state       ][INFO    ][6323] Executing state file.absent for /etc/apt/preferences.d/uca-staging
2018-04-20 19:01:24,664 [salt.state       ][INFO    ][6323] File /etc/apt/preferences.d/uca-staging is not present
2018-04-20 19:01:24,664 [salt.state       ][INFO    ][6323] Completed state [/etc/apt/preferences.d/uca-staging] at time 19:01:24.664280 duration_in_ms=0.699
2018-04-20 19:01:24,664 [salt.state       ][INFO    ][6323] Running state [apt-key adv --keyserver keyserver.ubuntu.com --recv 9F68104E] at time 19:01:24.664501
2018-04-20 19:01:24,664 [salt.state       ][INFO    ][6323] Executing state cmd.run for apt-key adv --keyserver keyserver.ubuntu.com --recv 9F68104E
2018-04-20 19:01:24,665 [salt.loaded.int.module.cmdmod][INFO    ][6323] Executing command 'apt-key adv --keyserver keyserver.ubuntu.com --recv 9F68104E' in directory '/root'
2018-04-20 19:01:24,866 [salt.state       ][INFO    ][6323] {'pid': 6500, 'retcode': 0, 'stderr': 'gpg: requesting key 9F68104E from hkp server keyserver.ubuntu.com\ngpg: key 9F68104E: "Launchpad PPA for Ubuntu Cloud Archive Team" not changed\ngpg: Total number processed: 1\ngpg:              unchanged: 1', 'stdout': 'Executing: /tmp/tmp.wJ44s61B2k/gpg.1.sh --keyserver\nkeyserver.ubuntu.com\n--recv\n9F68104E'}
2018-04-20 19:01:24,867 [salt.state       ][INFO    ][6323] Completed state [apt-key adv --keyserver keyserver.ubuntu.com --recv 9F68104E] at time 19:01:24.867300 duration_in_ms=202.798
2018-04-20 19:01:24,869 [salt.state       ][INFO    ][6323] Running state [deb http://ppa.launchpad.net/ubuntu-cloud-archive/pike-staging/ubuntu xenial main] at time 19:01:24.869065
2018-04-20 19:01:24,869 [salt.state       ][INFO    ][6323] Executing state pkgrepo.managed for deb http://ppa.launchpad.net/ubuntu-cloud-archive/pike-staging/ubuntu xenial main
2018-04-20 19:01:24,914 [salt.state       ][INFO    ][6323] Package repo 'deb http://ppa.launchpad.net/ubuntu-cloud-archive/pike-staging/ubuntu xenial main' already configured
2018-04-20 19:01:24,914 [salt.state       ][INFO    ][6323] Completed state [deb http://ppa.launchpad.net/ubuntu-cloud-archive/pike-staging/ubuntu xenial main] at time 19:01:24.914446 duration_in_ms=45.381
2018-04-20 19:01:24,914 [salt.state       ][INFO    ][6323] Running state [/etc/apt/apt.conf.d/99proxies-salt-mirantis_openstack] at time 19:01:24.914729
2018-04-20 19:01:24,915 [salt.state       ][INFO    ][6323] Executing state file.absent for /etc/apt/apt.conf.d/99proxies-salt-mirantis_openstack
2018-04-20 19:01:24,915 [salt.state       ][INFO    ][6323] File /etc/apt/apt.conf.d/99proxies-salt-mirantis_openstack is not present
2018-04-20 19:01:24,915 [salt.state       ][INFO    ][6323] Completed state [/etc/apt/apt.conf.d/99proxies-salt-mirantis_openstack] at time 19:01:24.915644 duration_in_ms=0.915
2018-04-20 19:01:24,915 [salt.state       ][INFO    ][6323] Running state [/etc/apt/preferences.d/mirantis_openstack] at time 19:01:24.915877
2018-04-20 19:01:24,916 [salt.state       ][INFO    ][6323] Executing state file.managed for /etc/apt/preferences.d/mirantis_openstack
2018-04-20 19:01:25,031 [salt.state       ][INFO    ][6323] File /etc/apt/preferences.d/mirantis_openstack is in the correct state
2018-04-20 19:01:25,031 [salt.state       ][INFO    ][6323] Completed state [/etc/apt/preferences.d/mirantis_openstack] at time 19:01:25.031888 duration_in_ms=116.011
2018-04-20 19:01:25,032 [salt.state       ][INFO    ][6323] Running state [curl -s http://mirror.fuel-infra.org/mcp-repos/pike/xenial/archive-mcppike.key | apt-key add -] at time 19:01:25.032136
2018-04-20 19:01:25,032 [salt.state       ][INFO    ][6323] Executing state cmd.run for curl -s http://mirror.fuel-infra.org/mcp-repos/pike/xenial/archive-mcppike.key | apt-key add -
2018-04-20 19:01:25,033 [salt.loaded.int.module.cmdmod][INFO    ][6323] Executing command 'curl -s http://mirror.fuel-infra.org/mcp-repos/pike/xenial/archive-mcppike.key | apt-key add -' in directory '/root'
2018-04-20 19:01:25,197 [salt.state       ][INFO    ][6323] {'pid': 6618, 'retcode': 0, 'stderr': '', 'stdout': 'OK'}
2018-04-20 19:01:25,199 [salt.state       ][INFO    ][6323] Completed state [curl -s http://mirror.fuel-infra.org/mcp-repos/pike/xenial/archive-mcppike.key | apt-key add -] at time 19:01:25.199303 duration_in_ms=167.166
2018-04-20 19:01:25,202 [salt.state       ][INFO    ][6323] Running state [deb http://mirror.fuel-infra.org/mcp-repos/pike/xenial pike main] at time 19:01:25.202162
2018-04-20 19:01:25,202 [salt.state       ][INFO    ][6323] Executing state pkgrepo.managed for deb http://mirror.fuel-infra.org/mcp-repos/pike/xenial pike main
2018-04-20 19:01:25,295 [salt.loaded.int.module.cmdmod][INFO    ][6323] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2018-04-20 19:01:26,893 [salt.minion      ][INFO    ][2025] User sudo_ubuntu Executing command saltutil.find_job with jid 20180420190126879757
2018-04-20 19:01:26,912 [salt.minion      ][INFO    ][7157] Starting a new job with PID 7157
2018-04-20 19:01:26,931 [salt.minion      ][INFO    ][7157] Returning information for job: 20180420190126879757
2018-04-20 19:01:29,521 [salt.state       ][INFO    ][6323] Configured package repo 'deb http://mirror.fuel-infra.org/mcp-repos/pike/xenial pike main'
2018-04-20 19:01:29,522 [salt.state       ][INFO    ][6323] Completed state [deb http://mirror.fuel-infra.org/mcp-repos/pike/xenial pike main] at time 19:01:29.521926 duration_in_ms=4319.765
2018-04-20 19:01:29,522 [salt.state       ][INFO    ][6323] Running state [/etc/apt/apt.conf.d/99proxies-salt-uca] at time 19:01:29.522548
2018-04-20 19:01:29,523 [salt.state       ][INFO    ][6323] Executing state file.absent for /etc/apt/apt.conf.d/99proxies-salt-uca
2018-04-20 19:01:29,523 [salt.state       ][INFO    ][6323] File /etc/apt/apt.conf.d/99proxies-salt-uca is not present
2018-04-20 19:01:29,524 [salt.state       ][INFO    ][6323] Completed state [/etc/apt/apt.conf.d/99proxies-salt-uca] at time 19:01:29.524313 duration_in_ms=1.765
2018-04-20 19:01:29,524 [salt.state       ][INFO    ][6323] Running state [/etc/apt/preferences.d/uca] at time 19:01:29.524789
2018-04-20 19:01:29,525 [salt.state       ][INFO    ][6323] Executing state file.absent for /etc/apt/preferences.d/uca
2018-04-20 19:01:29,525 [salt.state       ][INFO    ][6323] File /etc/apt/preferences.d/uca is not present
2018-04-20 19:01:29,526 [salt.state       ][INFO    ][6323] Completed state [/etc/apt/preferences.d/uca] at time 19:01:29.526240 duration_in_ms=1.451
2018-04-20 19:01:29,526 [salt.state       ][INFO    ][6323] Running state [apt-key adv --keyserver keyserver.ubuntu.com --recv EC4926EA] at time 19:01:29.526706
2018-04-20 19:01:29,527 [salt.state       ][INFO    ][6323] Executing state cmd.run for apt-key adv --keyserver keyserver.ubuntu.com --recv EC4926EA
2018-04-20 19:01:29,528 [salt.loaded.int.module.cmdmod][INFO    ][6323] Executing command 'apt-key adv --keyserver keyserver.ubuntu.com --recv EC4926EA' in directory '/root'
2018-04-20 19:01:29,717 [salt.state       ][INFO    ][6323] {'pid': 7166, 'retcode': 0, 'stderr': 'gpg: requesting key EC4926EA from hkp server keyserver.ubuntu.com\ngpg: key EC4926EA: "Canonical Cloud Archive Signing Key <ftpmaster@canonical.com>" not changed\ngpg: Total number processed: 1\ngpg:              unchanged: 1', 'stdout': 'Executing: /tmp/tmp.mh0e0wpYoj/gpg.1.sh --keyserver\nkeyserver.ubuntu.com\n--recv\nEC4926EA'}
2018-04-20 19:01:29,718 [salt.state       ][INFO    ][6323] Completed state [apt-key adv --keyserver keyserver.ubuntu.com --recv EC4926EA] at time 19:01:29.718253 duration_in_ms=191.546
2018-04-20 19:01:29,720 [salt.state       ][INFO    ][6323] Running state [deb http://ubuntu-cloud.archive.canonical.com/ubuntu xenial-updates/pike main] at time 19:01:29.720214
2018-04-20 19:01:29,720 [salt.state       ][INFO    ][6323] Executing state pkgrepo.managed for deb http://ubuntu-cloud.archive.canonical.com/ubuntu xenial-updates/pike main
2018-04-20 19:01:29,763 [salt.state       ][INFO    ][6323] Package repo 'deb http://ubuntu-cloud.archive.canonical.com/ubuntu xenial-updates/pike main' already configured
2018-04-20 19:01:29,763 [salt.state       ][INFO    ][6323] Completed state [deb http://ubuntu-cloud.archive.canonical.com/ubuntu xenial-updates/pike main] at time 19:01:29.763904 duration_in_ms=43.689
2018-04-20 19:01:29,765 [salt.state       ][INFO    ][6323] Running state [UTC] at time 19:01:29.765019
2018-04-20 19:01:29,765 [salt.state       ][INFO    ][6323] Executing state timezone.system for UTC
2018-04-20 19:01:29,766 [salt.loaded.int.module.cmdmod][INFO    ][6323] Executing command ['timedatectl'] in directory '/root'
2018-04-20 19:01:29,822 [salt.loaded.int.module.cmdmod][INFO    ][6323] Executing command ['timedatectl'] in directory '/root'
2018-04-20 19:01:29,839 [salt.state       ][INFO    ][6323] Timezone UTC already set, UTC already set to UTC
2018-04-20 19:01:29,839 [salt.state       ][INFO    ][6323] Completed state [UTC] at time 19:01:29.839800 duration_in_ms=74.78
2018-04-20 19:01:29,841 [salt.state       ][INFO    ][6323] Running state [nf_conntrack] at time 19:01:29.841098
2018-04-20 19:01:29,841 [salt.state       ][INFO    ][6323] Executing state kmod.present for nf_conntrack
2018-04-20 19:01:29,842 [salt.loaded.int.module.cmdmod][INFO    ][6323] Executing command 'lsmod' in directory '/root'
2018-04-20 19:01:29,858 [salt.state       ][INFO    ][6323] Kernel module nf_conntrack is already present
2018-04-20 19:01:29,858 [salt.state       ][INFO    ][6323] Completed state [nf_conntrack] at time 19:01:29.858717 duration_in_ms=17.619
2018-04-20 19:01:29,859 [salt.state       ][INFO    ][6323] Running state [kernel.panic] at time 19:01:29.859913
2018-04-20 19:01:29,860 [salt.state       ][INFO    ][6323] Executing state sysctl.present for kernel.panic
2018-04-20 19:01:29,874 [salt.loaded.int.module.cmdmod][INFO    ][6323] Executing command 'sysctl -a' in directory '/root'
2018-04-20 19:01:29,908 [salt.state       ][INFO    ][6323] Sysctl value kernel.panic = 60 is already set
2018-04-20 19:01:29,908 [salt.state       ][INFO    ][6323] Completed state [kernel.panic] at time 19:01:29.908574 duration_in_ms=48.662
2018-04-20 19:01:29,909 [salt.state       ][INFO    ][6323] Running state [net.ipv4.tcp_keepalive_probes] at time 19:01:29.909014
2018-04-20 19:01:29,909 [salt.state       ][INFO    ][6323] Executing state sysctl.present for net.ipv4.tcp_keepalive_probes
2018-04-20 19:01:29,910 [salt.loaded.int.module.cmdmod][INFO    ][6323] Executing command 'sysctl -a' in directory '/root'
2018-04-20 19:01:29,945 [salt.state       ][INFO    ][6323] Sysctl value net.ipv4.tcp_keepalive_probes = 8 is already set
2018-04-20 19:01:29,945 [salt.state       ][INFO    ][6323] Completed state [net.ipv4.tcp_keepalive_probes] at time 19:01:29.945597 duration_in_ms=36.583
2018-04-20 19:01:29,946 [salt.state       ][INFO    ][6323] Running state [fs.file-max] at time 19:01:29.946879
2018-04-20 19:01:29,947 [salt.state       ][INFO    ][6323] Executing state sysctl.present for fs.file-max
2018-04-20 19:01:29,948 [salt.loaded.int.module.cmdmod][INFO    ][6323] Executing command 'sysctl -a' in directory '/root'
2018-04-20 19:01:29,983 [salt.state       ][INFO    ][6323] Sysctl value fs.file-max = 124165 is already set
2018-04-20 19:01:29,983 [salt.state       ][INFO    ][6323] Completed state [fs.file-max] at time 19:01:29.983715 duration_in_ms=36.836
2018-04-20 19:01:29,984 [salt.state       ][INFO    ][6323] Running state [net.core.somaxconn] at time 19:01:29.984259
2018-04-20 19:01:29,984 [salt.state       ][INFO    ][6323] Executing state sysctl.present for net.core.somaxconn
2018-04-20 19:01:29,985 [salt.loaded.int.module.cmdmod][INFO    ][6323] Executing command 'sysctl -a' in directory '/root'
2018-04-20 19:01:30,019 [salt.state       ][INFO    ][6323] Sysctl value net.core.somaxconn = 4096 is already set
2018-04-20 19:01:30,019 [salt.state       ][INFO    ][6323] Completed state [net.core.somaxconn] at time 19:01:30.019757 duration_in_ms=35.497
2018-04-20 19:01:30,020 [salt.state       ][INFO    ][6323] Running state [net.ipv4.tcp_max_syn_backlog] at time 19:01:30.020308
2018-04-20 19:01:30,020 [salt.state       ][INFO    ][6323] Executing state sysctl.present for net.ipv4.tcp_max_syn_backlog
2018-04-20 19:01:30,021 [salt.loaded.int.module.cmdmod][INFO    ][6323] Executing command 'sysctl -a' in directory '/root'
2018-04-20 19:01:30,057 [salt.state       ][INFO    ][6323] Sysctl value net.ipv4.tcp_max_syn_backlog = 8192 is already set
2018-04-20 19:01:30,058 [salt.state       ][INFO    ][6323] Completed state [net.ipv4.tcp_max_syn_backlog] at time 19:01:30.058759 duration_in_ms=38.45
2018-04-20 19:01:30,059 [salt.state       ][INFO    ][6323] Running state [net.ipv4.tcp_tw_reuse] at time 19:01:30.059236
2018-04-20 19:01:30,059 [salt.state       ][INFO    ][6323] Executing state sysctl.present for net.ipv4.tcp_tw_reuse
2018-04-20 19:01:30,060 [salt.loaded.int.module.cmdmod][INFO    ][6323] Executing command 'sysctl -a' in directory '/root'
2018-04-20 19:01:30,100 [salt.state       ][INFO    ][6323] Sysctl value net.ipv4.tcp_tw_reuse = 1 is already set
2018-04-20 19:01:30,100 [salt.state       ][INFO    ][6323] Completed state [net.ipv4.tcp_tw_reuse] at time 19:01:30.100883 duration_in_ms=41.647
2018-04-20 19:01:30,101 [salt.state       ][INFO    ][6323] Running state [net.ipv4.tcp_congestion_control] at time 19:01:30.101420
2018-04-20 19:01:30,101 [salt.state       ][INFO    ][6323] Executing state sysctl.present for net.ipv4.tcp_congestion_control
2018-04-20 19:01:30,103 [salt.loaded.int.module.cmdmod][INFO    ][6323] Executing command 'sysctl -a' in directory '/root'
2018-04-20 19:01:30,144 [salt.state       ][INFO    ][6323] Sysctl value net.ipv4.tcp_congestion_control = yeah is already set
2018-04-20 19:01:30,145 [salt.state       ][INFO    ][6323] Completed state [net.ipv4.tcp_congestion_control] at time 19:01:30.144998 duration_in_ms=43.578
2018-04-20 19:01:30,145 [salt.state       ][INFO    ][6323] Running state [net.ipv4.tcp_retries2] at time 19:01:30.145511
2018-04-20 19:01:30,145 [salt.state       ][INFO    ][6323] Executing state sysctl.present for net.ipv4.tcp_retries2
2018-04-20 19:01:30,146 [salt.loaded.int.module.cmdmod][INFO    ][6323] Executing command 'sysctl -a' in directory '/root'
2018-04-20 19:01:30,180 [salt.state       ][INFO    ][6323] Sysctl value net.ipv4.tcp_retries2 = 5 is already set
2018-04-20 19:01:30,181 [salt.state       ][INFO    ][6323] Completed state [net.ipv4.tcp_retries2] at time 19:01:30.181328 duration_in_ms=35.816
2018-04-20 19:01:30,181 [salt.state       ][INFO    ][6323] Running state [net.core.netdev_max_backlog] at time 19:01:30.181797
2018-04-20 19:01:30,183 [salt.state       ][INFO    ][6323] Executing state sysctl.present for net.core.netdev_max_backlog
2018-04-20 19:01:30,183 [salt.loaded.int.module.cmdmod][INFO    ][6323] Executing command 'sysctl -a' in directory '/root'
2018-04-20 19:01:30,220 [salt.state       ][INFO    ][6323] Sysctl value net.core.netdev_max_backlog = 261144 is already set
2018-04-20 19:01:30,220 [salt.state       ][INFO    ][6323] Completed state [net.core.netdev_max_backlog] at time 19:01:30.220689 duration_in_ms=38.892
2018-04-20 19:01:30,221 [salt.state       ][INFO    ][6323] Running state [net.ipv4.tcp_slow_start_after_idle] at time 19:01:30.221191
2018-04-20 19:01:30,221 [salt.state       ][INFO    ][6323] Executing state sysctl.present for net.ipv4.tcp_slow_start_after_idle
2018-04-20 19:01:30,222 [salt.loaded.int.module.cmdmod][INFO    ][6323] Executing command 'sysctl -a' in directory '/root'
2018-04-20 19:01:30,256 [salt.state       ][INFO    ][6323] Sysctl value net.ipv4.tcp_slow_start_after_idle = 0 is already set
2018-04-20 19:01:30,256 [salt.state       ][INFO    ][6323] Completed state [net.ipv4.tcp_slow_start_after_idle] at time 19:01:30.256634 duration_in_ms=35.443
2018-04-20 19:01:30,257 [salt.state       ][INFO    ][6323] Running state [vm.swappiness] at time 19:01:30.257094
2018-04-20 19:01:30,257 [salt.state       ][INFO    ][6323] Executing state sysctl.present for vm.swappiness
2018-04-20 19:01:30,258 [salt.loaded.int.module.cmdmod][INFO    ][6323] Executing command 'sysctl -a' in directory '/root'
2018-04-20 19:01:30,290 [salt.state       ][INFO    ][6323] Sysctl value vm.swappiness = 10 is already set
2018-04-20 19:01:30,291 [salt.state       ][INFO    ][6323] Completed state [vm.swappiness] at time 19:01:30.291156 duration_in_ms=34.062
2018-04-20 19:01:30,291 [salt.state       ][INFO    ][6323] Running state [net.ipv4.tcp_keepalive_intvl] at time 19:01:30.291601
2018-04-20 19:01:30,292 [salt.state       ][INFO    ][6323] Executing state sysctl.present for net.ipv4.tcp_keepalive_intvl
2018-04-20 19:01:30,292 [salt.loaded.int.module.cmdmod][INFO    ][6323] Executing command 'sysctl -a' in directory '/root'
2018-04-20 19:01:30,327 [salt.state       ][INFO    ][6323] Sysctl value net.ipv4.tcp_keepalive_intvl = 3 is already set
2018-04-20 19:01:30,328 [salt.state       ][INFO    ][6323] Completed state [net.ipv4.tcp_keepalive_intvl] at time 19:01:30.328209 duration_in_ms=36.607
2018-04-20 19:01:30,328 [salt.state       ][INFO    ][6323] Running state [net.ipv4.neigh.default.gc_thresh1] at time 19:01:30.328714
2018-04-20 19:01:30,329 [salt.state       ][INFO    ][6323] Executing state sysctl.present for net.ipv4.neigh.default.gc_thresh1
2018-04-20 19:01:30,329 [salt.loaded.int.module.cmdmod][INFO    ][6323] Executing command 'sysctl -a' in directory '/root'
2018-04-20 19:01:30,360 [salt.state       ][INFO    ][6323] Sysctl value net.ipv4.neigh.default.gc_thresh1 = 4096 is already set
2018-04-20 19:01:30,361 [salt.state       ][INFO    ][6323] Completed state [net.ipv4.neigh.default.gc_thresh1] at time 19:01:30.360979 duration_in_ms=32.264
2018-04-20 19:01:30,361 [salt.state       ][INFO    ][6323] Running state [net.ipv4.neigh.default.gc_thresh2] at time 19:01:30.361488
2018-04-20 19:01:30,361 [salt.state       ][INFO    ][6323] Executing state sysctl.present for net.ipv4.neigh.default.gc_thresh2
2018-04-20 19:01:30,362 [salt.loaded.int.module.cmdmod][INFO    ][6323] Executing command 'sysctl -a' in directory '/root'
2018-04-20 19:01:30,400 [salt.state       ][INFO    ][6323] Sysctl value net.ipv4.neigh.default.gc_thresh2 = 8192 is already set
2018-04-20 19:01:30,400 [salt.state       ][INFO    ][6323] Completed state [net.ipv4.neigh.default.gc_thresh2] at time 19:01:30.400501 duration_in_ms=39.012
2018-04-20 19:01:30,400 [salt.state       ][INFO    ][6323] Running state [net.ipv4.neigh.default.gc_thresh3] at time 19:01:30.400946
2018-04-20 19:01:30,401 [salt.state       ][INFO    ][6323] Executing state sysctl.present for net.ipv4.neigh.default.gc_thresh3
2018-04-20 19:01:30,402 [salt.loaded.int.module.cmdmod][INFO    ][6323] Executing command 'sysctl -a' in directory '/root'
2018-04-20 19:01:30,435 [salt.state       ][INFO    ][6323] Sysctl value net.ipv4.neigh.default.gc_thresh3 = 16384 is already set
2018-04-20 19:01:30,435 [salt.state       ][INFO    ][6323] Completed state [net.ipv4.neigh.default.gc_thresh3] at time 19:01:30.435385 duration_in_ms=34.438
2018-04-20 19:01:30,435 [salt.state       ][INFO    ][6323] Running state [net.ipv4.tcp_fin_timeout] at time 19:01:30.435888
2018-04-20 19:01:30,436 [salt.state       ][INFO    ][6323] Executing state sysctl.present for net.ipv4.tcp_fin_timeout
2018-04-20 19:01:30,437 [salt.loaded.int.module.cmdmod][INFO    ][6323] Executing command 'sysctl -a' in directory '/root'
2018-04-20 19:01:30,469 [salt.state       ][INFO    ][6323] Sysctl value net.ipv4.tcp_fin_timeout = 30 is already set
2018-04-20 19:01:30,469 [salt.state       ][INFO    ][6323] Completed state [net.ipv4.tcp_fin_timeout] at time 19:01:30.469532 duration_in_ms=33.643
2018-04-20 19:01:30,470 [salt.state       ][INFO    ][6323] Running state [net.ipv4.tcp_keepalive_time] at time 19:01:30.470359
2018-04-20 19:01:30,470 [salt.state       ][INFO    ][6323] Executing state sysctl.present for net.ipv4.tcp_keepalive_time
2018-04-20 19:01:30,471 [salt.loaded.int.module.cmdmod][INFO    ][6323] Executing command 'sysctl -a' in directory '/root'
2018-04-20 19:01:30,508 [salt.state       ][INFO    ][6323] Sysctl value net.ipv4.tcp_keepalive_time = 30 is already set
2018-04-20 19:01:30,508 [salt.state       ][INFO    ][6323] Completed state [net.ipv4.tcp_keepalive_time] at time 19:01:30.508802 duration_in_ms=38.442
2018-04-20 19:01:30,509 [salt.state       ][INFO    ][6323] Running state [net.nf_conntrack_max] at time 19:01:30.509293
2018-04-20 19:01:30,509 [salt.state       ][INFO    ][6323] Executing state sysctl.present for net.nf_conntrack_max
2018-04-20 19:01:30,510 [salt.loaded.int.module.cmdmod][INFO    ][6323] Executing command 'sysctl -a' in directory '/root'
2018-04-20 19:01:30,542 [salt.state       ][INFO    ][6323] Sysctl value net.nf_conntrack_max = 1048576 is already set
2018-04-20 19:01:30,543 [salt.state       ][INFO    ][6323] Completed state [net.nf_conntrack_max] at time 19:01:30.543101 duration_in_ms=33.807
2018-04-20 19:01:30,543 [salt.state       ][INFO    ][6323] Running state [linux_sysfs_package] at time 19:01:30.543622
2018-04-20 19:01:30,544 [salt.state       ][INFO    ][6323] Executing state pkg.installed for linux_sysfs_package
2018-04-20 19:01:30,553 [salt.state       ][INFO    ][6323] All specified packages are already installed
2018-04-20 19:01:30,553 [salt.state       ][INFO    ][6323] Completed state [linux_sysfs_package] at time 19:01:30.553548 duration_in_ms=9.926
2018-04-20 19:01:30,555 [salt.state       ][INFO    ][6323] Running state [/etc/sysfs.d] at time 19:01:30.555688
2018-04-20 19:01:30,555 [salt.state       ][INFO    ][6323] Executing state file.directory for /etc/sysfs.d
2018-04-20 19:01:30,556 [salt.state       ][INFO    ][6323] Directory /etc/sysfs.d is in the correct state
2018-04-20 19:01:30,557 [salt.state       ][INFO    ][6323] Completed state [/etc/sysfs.d] at time 19:01:30.556976 duration_in_ms=1.288
2018-04-20 19:01:30,558 [salt.state       ][INFO    ][6323] Running state [ondemand] at time 19:01:30.557885
2018-04-20 19:01:30,558 [salt.state       ][INFO    ][6323] Executing state service.dead for ondemand
2018-04-20 19:01:30,559 [salt.loaded.int.module.cmdmod][INFO    ][6323] Executing command ['systemctl', 'status', 'ondemand.service', '-n', '0'] in directory '/root'
2018-04-20 19:01:30,577 [salt.loaded.int.module.cmdmod][INFO    ][6323] Executing command ['systemctl', 'is-active', 'ondemand.service'] in directory '/root'
2018-04-20 19:01:30,592 [salt.loaded.int.module.cmdmod][INFO    ][6323] Executing command ['systemctl', 'is-enabled', 'ondemand.service'] in directory '/root'
2018-04-20 19:01:30,615 [salt.loaded.int.module.cmdmod][INFO    ][6323] Executing command 'runlevel' in directory '/root'
2018-04-20 19:01:30,630 [salt.state       ][INFO    ][6323] The service ondemand is already dead
2018-04-20 19:01:30,631 [salt.state       ][INFO    ][6323] Completed state [ondemand] at time 19:01:30.630929 duration_in_ms=73.044
2018-04-20 19:01:30,632 [salt.state       ][INFO    ][6323] Running state [cs_CZ.UTF-8] at time 19:01:30.632086
2018-04-20 19:01:30,632 [salt.state       ][INFO    ][6323] Executing state locale.present for cs_CZ.UTF-8
2018-04-20 19:01:30,633 [salt.loaded.int.module.cmdmod][INFO    ][6323] Executing command 'locale -a' in directory '/root'
2018-04-20 19:01:30,647 [salt.state       ][INFO    ][6323] Locale cs_CZ.UTF-8 is already present
2018-04-20 19:01:30,648 [salt.state       ][INFO    ][6323] Completed state [cs_CZ.UTF-8] at time 19:01:30.647992 duration_in_ms=15.905
2018-04-20 19:01:30,648 [salt.state       ][INFO    ][6323] Running state [en_US.UTF-8] at time 19:01:30.648482
2018-04-20 19:01:30,648 [salt.state       ][INFO    ][6323] Executing state locale.present for en_US.UTF-8
2018-04-20 19:01:30,649 [salt.loaded.int.module.cmdmod][INFO    ][6323] Executing command 'locale -a' in directory '/root'
2018-04-20 19:01:30,663 [salt.state       ][INFO    ][6323] Locale en_US.UTF-8 is already present
2018-04-20 19:01:30,663 [salt.state       ][INFO    ][6323] Completed state [en_US.UTF-8] at time 19:01:30.663676 duration_in_ms=15.194
2018-04-20 19:01:30,666 [salt.state       ][INFO    ][6323] Running state [en_US.UTF-8] at time 19:01:30.666875
2018-04-20 19:01:30,667 [salt.state       ][INFO    ][6323] Executing state locale.system for en_US.UTF-8
2018-04-20 19:01:30,668 [salt.loaded.int.module.cmdmod][INFO    ][6323] Executing command 'localectl' in directory '/root'
2018-04-20 19:01:30,722 [salt.state       ][INFO    ][6323] System locale en_US.UTF-8 already set
2018-04-20 19:01:30,723 [salt.state       ][INFO    ][6323] Completed state [en_US.UTF-8] at time 19:01:30.723319 duration_in_ms=56.443
2018-04-20 19:01:30,724 [salt.state       ][INFO    ][6323] Running state [root] at time 19:01:30.724599
2018-04-20 19:01:30,724 [salt.state       ][INFO    ][6323] Executing state group.present for root
2018-04-20 19:01:30,725 [salt.state       ][INFO    ][6323] Group root is present and up to date
2018-04-20 19:01:30,725 [salt.state       ][INFO    ][6323] Completed state [root] at time 19:01:30.725892 duration_in_ms=1.293
2018-04-20 19:01:30,728 [salt.state       ][INFO    ][6323] Running state [root] at time 19:01:30.728876
2018-04-20 19:01:30,729 [salt.state       ][INFO    ][6323] Executing state user.present for root
2018-04-20 19:01:30,731 [salt.state       ][INFO    ][6323] User root is present and up to date
2018-04-20 19:01:30,731 [salt.state       ][INFO    ][6323] Completed state [root] at time 19:01:30.731403 duration_in_ms=2.527
2018-04-20 19:01:30,732 [salt.state       ][INFO    ][6323] Running state [/root] at time 19:01:30.732583
2018-04-20 19:01:30,732 [salt.state       ][INFO    ][6323] Executing state file.directory for /root
2018-04-20 19:01:30,733 [salt.state       ][INFO    ][6323] Directory /root is in the correct state
2018-04-20 19:01:30,734 [salt.state       ][INFO    ][6323] Completed state [/root] at time 19:01:30.734010 duration_in_ms=1.427
2018-04-20 19:01:30,734 [salt.state       ][INFO    ][6323] Running state [/etc/sudoers.d/90-salt-user-root] at time 19:01:30.734279
2018-04-20 19:01:30,734 [salt.state       ][INFO    ][6323] Executing state file.absent for /etc/sudoers.d/90-salt-user-root
2018-04-20 19:01:30,734 [salt.state       ][INFO    ][6323] File /etc/sudoers.d/90-salt-user-root is not present
2018-04-20 19:01:30,735 [salt.state       ][INFO    ][6323] Completed state [/etc/sudoers.d/90-salt-user-root] at time 19:01:30.735136 duration_in_ms=0.857
2018-04-20 19:01:30,735 [salt.state       ][INFO    ][6323] Running state [ubuntu] at time 19:01:30.735401
2018-04-20 19:01:30,735 [salt.state       ][INFO    ][6323] Executing state group.present for ubuntu
2018-04-20 19:01:30,736 [salt.state       ][INFO    ][6323] Group ubuntu is present and up to date
2018-04-20 19:01:30,736 [salt.state       ][INFO    ][6323] Completed state [ubuntu] at time 19:01:30.736235 duration_in_ms=0.835
2018-04-20 19:01:30,737 [salt.state       ][INFO    ][6323] Running state [ubuntu] at time 19:01:30.737213
2018-04-20 19:01:30,737 [salt.state       ][INFO    ][6323] Executing state user.present for ubuntu
2018-04-20 19:01:30,738 [salt.state       ][INFO    ][6323] User ubuntu is present and up to date
2018-04-20 19:01:30,739 [salt.state       ][INFO    ][6323] Completed state [ubuntu] at time 19:01:30.739128 duration_in_ms=1.915
2018-04-20 19:01:30,740 [salt.state       ][INFO    ][6323] Running state [/home/ubuntu] at time 19:01:30.740323
2018-04-20 19:01:30,740 [salt.state       ][INFO    ][6323] Executing state file.directory for /home/ubuntu
2018-04-20 19:01:30,741 [salt.state       ][INFO    ][6323] Directory /home/ubuntu is in the correct state
2018-04-20 19:01:30,741 [salt.state       ][INFO    ][6323] Completed state [/home/ubuntu] at time 19:01:30.741577 duration_in_ms=1.254
2018-04-20 19:01:30,743 [salt.state       ][INFO    ][6323] Running state [/etc/sudoers.d/90-salt-user-ubuntu] at time 19:01:30.743801
2018-04-20 19:01:30,744 [salt.state       ][INFO    ][6323] Executing state file.managed for /etc/sudoers.d/90-salt-user-ubuntu
2018-04-20 19:01:30,770 [salt.state       ][INFO    ][6323] File /etc/sudoers.d/90-salt-user-ubuntu is in the correct state
2018-04-20 19:01:30,770 [salt.state       ][INFO    ][6323] Completed state [/etc/sudoers.d/90-salt-user-ubuntu] at time 19:01:30.770544 duration_in_ms=26.743
2018-04-20 19:01:30,770 [salt.state       ][INFO    ][6323] Running state [/etc/security/limits.d/90-salt-default.conf] at time 19:01:30.770907
2018-04-20 19:01:30,771 [salt.state       ][INFO    ][6323] Executing state file.managed for /etc/security/limits.d/90-salt-default.conf
2018-04-20 19:01:30,877 [salt.state       ][INFO    ][6323] File /etc/security/limits.d/90-salt-default.conf is in the correct state
2018-04-20 19:01:30,877 [salt.state       ][INFO    ][6323] Completed state [/etc/security/limits.d/90-salt-default.conf] at time 19:01:30.877668 duration_in_ms=106.761
2018-04-20 19:01:30,878 [salt.state       ][INFO    ][6323] Running state [/etc/systemd/system.conf.d/90-salt.conf] at time 19:01:30.878348
2018-04-20 19:01:30,878 [salt.state       ][INFO    ][6323] Executing state file.managed for /etc/systemd/system.conf.d/90-salt.conf
2018-04-20 19:01:30,977 [salt.state       ][INFO    ][6323] File /etc/systemd/system.conf.d/90-salt.conf is in the correct state
2018-04-20 19:01:30,978 [salt.state       ][INFO    ][6323] Completed state [/etc/systemd/system.conf.d/90-salt.conf] at time 19:01:30.978154 duration_in_ms=99.805
2018-04-20 19:01:30,980 [salt.state       ][INFO    ][6323] Running state [service.systemctl_reload] at time 19:01:30.980355
2018-04-20 19:01:30,980 [salt.state       ][INFO    ][6323] Executing state module.wait for service.systemctl_reload
2018-04-20 19:01:30,981 [salt.state       ][INFO    ][6323] No changes made for service.systemctl_reload
2018-04-20 19:01:30,981 [salt.state       ][INFO    ][6323] Completed state [service.systemctl_reload] at time 19:01:30.981212 duration_in_ms=0.857
2018-04-20 19:01:30,981 [salt.state       ][INFO    ][6323] Running state [/etc/hostname] at time 19:01:30.981493
2018-04-20 19:01:30,981 [salt.state       ][INFO    ][6323] Executing state file.managed for /etc/hostname
2018-04-20 19:01:30,996 [salt.state       ][INFO    ][6323] File /etc/hostname is in the correct state
2018-04-20 19:01:30,996 [salt.state       ][INFO    ][6323] Completed state [/etc/hostname] at time 19:01:30.996642 duration_in_ms=15.149
2018-04-20 19:01:30,997 [salt.state       ][INFO    ][6323] Running state [hostname msg01] at time 19:01:30.997744
2018-04-20 19:01:30,998 [salt.state       ][INFO    ][6323] Executing state cmd.wait for hostname msg01
2018-04-20 19:01:30,998 [salt.state       ][INFO    ][6323] No changes made for hostname msg01
2018-04-20 19:01:30,998 [salt.state       ][INFO    ][6323] Completed state [hostname msg01] at time 19:01:30.998619 duration_in_ms=0.875
2018-04-20 19:01:30,999 [salt.state       ][INFO    ][6323] Running state [mdb02] at time 19:01:30.999219
2018-04-20 19:01:30,999 [salt.state       ][INFO    ][6323] Executing state host.present for mdb02
2018-04-20 19:01:31,000 [salt.state       ][INFO    ][6323] Host mdb02 (192.168.10.33) already present
2018-04-20 19:01:31,000 [salt.state       ][INFO    ][6323] Completed state [mdb02] at time 19:01:31.000273 duration_in_ms=1.054
2018-04-20 19:01:31,000 [salt.state       ][INFO    ][6323] Running state [mdb02.mcp-pike-odl-ha.local] at time 19:01:31.000571
2018-04-20 19:01:31,000 [salt.state       ][INFO    ][6323] Executing state host.present for mdb02.mcp-pike-odl-ha.local
2018-04-20 19:01:31,001 [salt.state       ][INFO    ][6323] Host mdb02.mcp-pike-odl-ha.local (192.168.10.33) already present
2018-04-20 19:01:31,001 [salt.state       ][INFO    ][6323] Completed state [mdb02.mcp-pike-odl-ha.local] at time 19:01:31.001579 duration_in_ms=1.008
2018-04-20 19:01:31,002 [salt.state       ][INFO    ][6323] Running state [mdb03] at time 19:01:31.002700
2018-04-20 19:01:31,002 [salt.state       ][INFO    ][6323] Executing state host.present for mdb03
2018-04-20 19:01:31,003 [salt.state       ][INFO    ][6323] Host mdb03 (192.168.10.34) already present
2018-04-20 19:01:31,003 [salt.state       ][INFO    ][6323] Completed state [mdb03] at time 19:01:31.003669 duration_in_ms=0.969
2018-04-20 19:01:31,003 [salt.state       ][INFO    ][6323] Running state [mdb03.mcp-pike-odl-ha.local] at time 19:01:31.003958
2018-04-20 19:01:31,004 [salt.state       ][INFO    ][6323] Executing state host.present for mdb03.mcp-pike-odl-ha.local
2018-04-20 19:01:31,004 [salt.state       ][INFO    ][6323] Host mdb03.mcp-pike-odl-ha.local (192.168.10.34) already present
2018-04-20 19:01:31,004 [salt.state       ][INFO    ][6323] Completed state [mdb03.mcp-pike-odl-ha.local] at time 19:01:31.004956 duration_in_ms=0.997
2018-04-20 19:01:31,005 [salt.state       ][INFO    ][6323] Running state [mdb01] at time 19:01:31.005220
2018-04-20 19:01:31,005 [salt.state       ][INFO    ][6323] Executing state host.present for mdb01
2018-04-20 19:01:31,006 [salt.state       ][INFO    ][6323] Host mdb01 (192.168.10.32) already present
2018-04-20 19:01:31,006 [salt.state       ][INFO    ][6323] Completed state [mdb01] at time 19:01:31.006796 duration_in_ms=1.574
2018-04-20 19:01:31,007 [salt.state       ][INFO    ][6323] Running state [mdb01.mcp-pike-odl-ha.local] at time 19:01:31.007099
2018-04-20 19:01:31,007 [salt.state       ][INFO    ][6323] Executing state host.present for mdb01.mcp-pike-odl-ha.local
2018-04-20 19:01:31,007 [salt.state       ][INFO    ][6323] Host mdb01.mcp-pike-odl-ha.local (192.168.10.32) already present
2018-04-20 19:01:31,008 [salt.state       ][INFO    ][6323] Completed state [mdb01.mcp-pike-odl-ha.local] at time 19:01:31.008111 duration_in_ms=1.012
2018-04-20 19:01:31,008 [salt.state       ][INFO    ][6323] Running state [mdb] at time 19:01:31.008383
2018-04-20 19:01:31,008 [salt.state       ][INFO    ][6323] Executing state host.present for mdb
2018-04-20 19:01:31,009 [salt.state       ][INFO    ][6323] Host mdb (192.168.10.31) already present
2018-04-20 19:01:31,009 [salt.state       ][INFO    ][6323] Completed state [mdb] at time 19:01:31.009385 duration_in_ms=0.972
2018-04-20 19:01:31,009 [salt.state       ][INFO    ][6323] Running state [mdb.mcp-pike-odl-ha.local] at time 19:01:31.009654
2018-04-20 19:01:31,010 [salt.state       ][INFO    ][6323] Executing state host.present for mdb.mcp-pike-odl-ha.local
2018-04-20 19:01:31,010 [salt.state       ][INFO    ][6323] Host mdb.mcp-pike-odl-ha.local (192.168.10.31) already present
2018-04-20 19:01:31,011 [salt.state       ][INFO    ][6323] Completed state [mdb.mcp-pike-odl-ha.local] at time 19:01:31.010965 duration_in_ms=1.311
2018-04-20 19:01:31,011 [salt.state       ][INFO    ][6323] Running state [cfg01] at time 19:01:31.011241
2018-04-20 19:01:31,011 [salt.state       ][INFO    ][6323] Executing state host.present for cfg01
2018-04-20 19:01:31,012 [salt.state       ][INFO    ][6323] Host cfg01 (192.168.10.11) already present
2018-04-20 19:01:31,012 [salt.state       ][INFO    ][6323] Completed state [cfg01] at time 19:01:31.012230 duration_in_ms=0.99
2018-04-20 19:01:31,012 [salt.state       ][INFO    ][6323] Running state [cfg01.mcp-pike-odl-ha.local] at time 19:01:31.012499
2018-04-20 19:01:31,012 [salt.state       ][INFO    ][6323] Executing state host.present for cfg01.mcp-pike-odl-ha.local
2018-04-20 19:01:31,013 [salt.state       ][INFO    ][6323] Host cfg01.mcp-pike-odl-ha.local (192.168.10.11) already present
2018-04-20 19:01:31,013 [salt.state       ][INFO    ][6323] Completed state [cfg01.mcp-pike-odl-ha.local] at time 19:01:31.013491 duration_in_ms=0.992
2018-04-20 19:01:31,013 [salt.state       ][INFO    ][6323] Running state [prx01] at time 19:01:31.013783
2018-04-20 19:01:31,014 [salt.state       ][INFO    ][6323] Executing state host.present for prx01
2018-04-20 19:01:31,014 [salt.state       ][INFO    ][6323] Host prx01 (192.168.10.14) already present
2018-04-20 19:01:31,014 [salt.state       ][INFO    ][6323] Completed state [prx01] at time 19:01:31.014784 duration_in_ms=1.001
2018-04-20 19:01:31,015 [salt.state       ][INFO    ][6323] Running state [prx01.mcp-pike-odl-ha.local] at time 19:01:31.015054
2018-04-20 19:01:31,015 [salt.state       ][INFO    ][6323] Executing state host.present for prx01.mcp-pike-odl-ha.local
2018-04-20 19:01:31,015 [salt.state       ][INFO    ][6323] Host prx01.mcp-pike-odl-ha.local (192.168.10.14) already present
2018-04-20 19:01:31,016 [salt.state       ][INFO    ][6323] Completed state [prx01.mcp-pike-odl-ha.local] at time 19:01:31.016046 duration_in_ms=0.992
2018-04-20 19:01:31,016 [salt.state       ][INFO    ][6323] Running state [kvm01] at time 19:01:31.016313
2018-04-20 19:01:31,016 [salt.state       ][INFO    ][6323] Executing state host.present for kvm01
2018-04-20 19:01:31,017 [salt.state       ][INFO    ][6323] Host kvm01 (192.168.10.20) already present
2018-04-20 19:01:31,017 [salt.state       ][INFO    ][6323] Completed state [kvm01] at time 19:01:31.017296 duration_in_ms=0.983
2018-04-20 19:01:31,017 [salt.state       ][INFO    ][6323] Running state [kvm01.mcp-pike-odl-ha.local] at time 19:01:31.017565
2018-04-20 19:01:31,018 [salt.state       ][INFO    ][6323] Executing state host.present for kvm01.mcp-pike-odl-ha.local
2018-04-20 19:01:31,018 [salt.state       ][INFO    ][6323] Host kvm01.mcp-pike-odl-ha.local (192.168.10.20) already present
2018-04-20 19:01:31,019 [salt.state       ][INFO    ][6323] Completed state [kvm01.mcp-pike-odl-ha.local] at time 19:01:31.019183 duration_in_ms=1.618
2018-04-20 19:01:31,019 [salt.state       ][INFO    ][6323] Running state [kvm03] at time 19:01:31.019454
2018-04-20 19:01:31,019 [salt.state       ][INFO    ][6323] Executing state host.present for kvm03
2018-04-20 19:01:31,020 [salt.state       ][INFO    ][6323] Host kvm03 (192.168.10.22) already present
2018-04-20 19:01:31,020 [salt.state       ][INFO    ][6323] Completed state [kvm03] at time 19:01:31.020471 duration_in_ms=1.017
2018-04-20 19:01:31,020 [salt.state       ][INFO    ][6323] Running state [kvm03.mcp-pike-odl-ha.local] at time 19:01:31.020742
2018-04-20 19:01:31,021 [salt.state       ][INFO    ][6323] Executing state host.present for kvm03.mcp-pike-odl-ha.local
2018-04-20 19:01:31,021 [salt.state       ][INFO    ][6323] Host kvm03.mcp-pike-odl-ha.local (192.168.10.22) already present
2018-04-20 19:01:31,022 [salt.state       ][INFO    ][6323] Completed state [kvm03.mcp-pike-odl-ha.local] at time 19:01:31.022492 duration_in_ms=1.75
2018-04-20 19:01:31,022 [salt.state       ][INFO    ][6323] Running state [kvm02] at time 19:01:31.022766
2018-04-20 19:01:31,023 [salt.state       ][INFO    ][6323] Executing state host.present for kvm02
2018-04-20 19:01:31,023 [salt.state       ][INFO    ][6323] Host kvm02 (192.168.10.21) already present
2018-04-20 19:01:31,023 [salt.state       ][INFO    ][6323] Completed state [kvm02] at time 19:01:31.023763 duration_in_ms=0.997
2018-04-20 19:01:31,024 [salt.state       ][INFO    ][6323] Running state [kvm02.mcp-pike-odl-ha.local] at time 19:01:31.024037
2018-04-20 19:01:31,024 [salt.state       ][INFO    ][6323] Executing state host.present for kvm02.mcp-pike-odl-ha.local
2018-04-20 19:01:31,024 [salt.state       ][INFO    ][6323] Host kvm02.mcp-pike-odl-ha.local (192.168.10.21) already present
2018-04-20 19:01:31,025 [salt.state       ][INFO    ][6323] Completed state [kvm02.mcp-pike-odl-ha.local] at time 19:01:31.025106 duration_in_ms=1.069
2018-04-20 19:01:31,025 [salt.state       ][INFO    ][6323] Running state [dbs] at time 19:01:31.025380
2018-04-20 19:01:31,025 [salt.state       ][INFO    ][6323] Executing state host.present for dbs
2018-04-20 19:01:31,026 [salt.state       ][INFO    ][6323] Host dbs (192.168.10.23) already present
2018-04-20 19:01:31,026 [salt.state       ][INFO    ][6323] Completed state [dbs] at time 19:01:31.026658 duration_in_ms=1.278
2018-04-20 19:01:31,026 [salt.state       ][INFO    ][6323] Running state [dbs.mcp-pike-odl-ha.local] at time 19:01:31.026956
2018-04-20 19:01:31,027 [salt.state       ][INFO    ][6323] Executing state host.present for dbs.mcp-pike-odl-ha.local
2018-04-20 19:01:31,027 [salt.state       ][INFO    ][6323] Host dbs.mcp-pike-odl-ha.local (192.168.10.23) already present
2018-04-20 19:01:31,027 [salt.state       ][INFO    ][6323] Completed state [dbs.mcp-pike-odl-ha.local] at time 19:01:31.027939 duration_in_ms=0.984
2018-04-20 19:01:31,028 [salt.state       ][INFO    ][6323] Running state [prx] at time 19:01:31.028210
2018-04-20 19:01:31,028 [salt.state       ][INFO    ][6323] Executing state host.present for prx
2018-04-20 19:01:31,029 [salt.state       ][INFO    ][6323] Host prx (192.168.10.13) already present
2018-04-20 19:01:31,029 [salt.state       ][INFO    ][6323] Completed state [prx] at time 19:01:31.029197 duration_in_ms=0.987
2018-04-20 19:01:31,029 [salt.state       ][INFO    ][6323] Running state [prx.mcp-pike-odl-ha.local] at time 19:01:31.029460
2018-04-20 19:01:31,029 [salt.state       ][INFO    ][6323] Executing state host.present for prx.mcp-pike-odl-ha.local
2018-04-20 19:01:31,030 [salt.state       ][INFO    ][6323] Host prx.mcp-pike-odl-ha.local (192.168.10.13) already present
2018-04-20 19:01:31,031 [salt.state       ][INFO    ][6323] Completed state [prx.mcp-pike-odl-ha.local] at time 19:01:31.031037 duration_in_ms=1.577
2018-04-20 19:01:31,031 [salt.state       ][INFO    ][6323] Running state [prx02] at time 19:01:31.031304
2018-04-20 19:01:31,031 [salt.state       ][INFO    ][6323] Executing state host.present for prx02
2018-04-20 19:01:31,032 [salt.state       ][INFO    ][6323] Host prx02 (192.168.10.15) already present
2018-04-20 19:01:31,032 [salt.state       ][INFO    ][6323] Completed state [prx02] at time 19:01:31.032285 duration_in_ms=0.981
2018-04-20 19:01:31,032 [salt.state       ][INFO    ][6323] Running state [prx02.mcp-pike-odl-ha.local] at time 19:01:31.032558
2018-04-20 19:01:31,032 [salt.state       ][INFO    ][6323] Executing state host.present for prx02.mcp-pike-odl-ha.local
2018-04-20 19:01:31,033 [salt.state       ][INFO    ][6323] Host prx02.mcp-pike-odl-ha.local (192.168.10.15) already present
2018-04-20 19:01:31,033 [salt.state       ][INFO    ][6323] Completed state [prx02.mcp-pike-odl-ha.local] at time 19:01:31.033564 duration_in_ms=1.006
2018-04-20 19:01:31,033 [salt.state       ][INFO    ][6323] Running state [msg02] at time 19:01:31.033861
2018-04-20 19:01:31,034 [salt.state       ][INFO    ][6323] Executing state host.present for msg02
2018-04-20 19:01:31,034 [salt.state       ][INFO    ][6323] Host msg02 (192.168.10.29) already present
2018-04-20 19:01:31,034 [salt.state       ][INFO    ][6323] Completed state [msg02] at time 19:01:31.034844 duration_in_ms=0.983
2018-04-20 19:01:31,035 [salt.state       ][INFO    ][6323] Running state [msg02.mcp-pike-odl-ha.local] at time 19:01:31.035111
2018-04-20 19:01:31,035 [salt.state       ][INFO    ][6323] Executing state host.present for msg02.mcp-pike-odl-ha.local
2018-04-20 19:01:31,035 [salt.state       ][INFO    ][6323] Host msg02.mcp-pike-odl-ha.local (192.168.10.29) already present
2018-04-20 19:01:31,036 [salt.state       ][INFO    ][6323] Completed state [msg02.mcp-pike-odl-ha.local] at time 19:01:31.036093 duration_in_ms=0.982
2018-04-20 19:01:31,036 [salt.state       ][INFO    ][6323] Running state [msg03] at time 19:01:31.036363
2018-04-20 19:01:31,036 [salt.state       ][INFO    ][6323] Executing state host.present for msg03
2018-04-20 19:01:31,037 [salt.state       ][INFO    ][6323] Host msg03 (192.168.10.30) already present
2018-04-20 19:01:31,037 [salt.state       ][INFO    ][6323] Completed state [msg03] at time 19:01:31.037343 duration_in_ms=0.98
2018-04-20 19:01:31,037 [salt.state       ][INFO    ][6323] Running state [msg03.mcp-pike-odl-ha.local] at time 19:01:31.037618
2018-04-20 19:01:31,038 [salt.state       ][INFO    ][6323] Executing state host.present for msg03.mcp-pike-odl-ha.local
2018-04-20 19:01:31,038 [salt.state       ][INFO    ][6323] Host msg03.mcp-pike-odl-ha.local (192.168.10.30) already present
2018-04-20 19:01:31,038 [salt.state       ][INFO    ][6323] Completed state [msg03.mcp-pike-odl-ha.local] at time 19:01:31.038921 duration_in_ms=1.303
2018-04-20 19:01:31,039 [salt.state       ][INFO    ][6323] Running state [msg01] at time 19:01:31.039189
2018-04-20 19:01:31,039 [salt.state       ][INFO    ][6323] Executing state host.present for msg01
2018-04-20 19:01:31,039 [salt.state       ][INFO    ][6323] Host msg01 (192.168.10.28) already present
2018-04-20 19:01:31,040 [salt.state       ][INFO    ][6323] Completed state [msg01] at time 19:01:31.040168 duration_in_ms=0.98
2018-04-20 19:01:31,040 [salt.state       ][INFO    ][6323] Running state [msg01.mcp-pike-odl-ha.local] at time 19:01:31.040435
2018-04-20 19:01:31,040 [salt.state       ][INFO    ][6323] Executing state host.present for msg01.mcp-pike-odl-ha.local
2018-04-20 19:01:31,041 [salt.state       ][INFO    ][6323] Host msg01.mcp-pike-odl-ha.local (192.168.10.28) already present
2018-04-20 19:01:31,041 [salt.state       ][INFO    ][6323] Completed state [msg01.mcp-pike-odl-ha.local] at time 19:01:31.041415 duration_in_ms=0.981
2018-04-20 19:01:31,043 [salt.state       ][INFO    ][6323] Running state [file.replace] at time 19:01:31.042967
2018-04-20 19:01:31,043 [salt.state       ][INFO    ][6323] Executing state module.run for file.replace
2018-04-20 19:01:31,280 [salt.loaded.int.module.cmdmod][INFO    ][6323] Executing command ['git', '--version'] in directory '/root'
2018-04-20 19:01:31,429 [salt.loaded.int.module.cmdmod][INFO    ][6323] Executing command 'grep -q "msg01 msg01.mcp-pike-odl-ha.local" /etc/hosts' in directory '/root'
2018-04-20 19:01:31,449 [salt.state       ][INFO    ][6323] {'ret': '--- \n+++ \n@@ -20,7 +20,7 @@\n 192.168.10.15\t\tprx02 prx02.mcp-pike-odl-ha.local\n 192.168.10.29\t\tmsg02 msg02.mcp-pike-odl-ha.local\n 192.168.10.30\t\tmsg03 msg03.mcp-pike-odl-ha.local\n-192.168.10.28\t\tmsg01 msg01.mcp-pike-odl-ha.local\n+192.168.10.28\t\tmsg01.mcp-pike-odl-ha.local msg01\n 192.168.10.27\t\tmsg msg.mcp-pike-odl-ha.local\n 192.168.10.53\t\tcmp002 cmp002.mcp-pike-odl-ha.local\n 192.168.10.52\t\tcmp001 cmp001.mcp-pike-odl-ha.local\n'}
2018-04-20 19:01:31,451 [salt.state       ][INFO    ][6323] Completed state [file.replace] at time 19:01:31.451066 duration_in_ms=408.098
2018-04-20 19:01:31,451 [salt.state       ][INFO    ][6323] Running state [msg] at time 19:01:31.451647
2018-04-20 19:01:31,452 [salt.state       ][INFO    ][6323] Executing state host.present for msg
2018-04-20 19:01:31,453 [salt.state       ][INFO    ][6323] Host msg (192.168.10.27) already present
2018-04-20 19:01:31,453 [salt.state       ][INFO    ][6323] Completed state [msg] at time 19:01:31.453238 duration_in_ms=1.591
2018-04-20 19:01:31,453 [salt.state       ][INFO    ][6323] Running state [msg.mcp-pike-odl-ha.local] at time 19:01:31.453582
2018-04-20 19:01:31,453 [salt.state       ][INFO    ][6323] Executing state host.present for msg.mcp-pike-odl-ha.local
2018-04-20 19:01:31,454 [salt.state       ][INFO    ][6323] Host msg.mcp-pike-odl-ha.local (192.168.10.27) already present
2018-04-20 19:01:31,454 [salt.state       ][INFO    ][6323] Completed state [msg.mcp-pike-odl-ha.local] at time 19:01:31.454801 duration_in_ms=1.219
2018-04-20 19:01:31,455 [salt.state       ][INFO    ][6323] Running state [cfg01] at time 19:01:31.455130
2018-04-20 19:01:31,455 [salt.state       ][INFO    ][6323] Executing state host.present for cfg01
2018-04-20 19:01:31,456 [salt.state       ][INFO    ][6323] Host cfg01 (192.168.10.11) already present
2018-04-20 19:01:31,456 [salt.state       ][INFO    ][6323] Completed state [cfg01] at time 19:01:31.456282 duration_in_ms=1.152
2018-04-20 19:01:31,456 [salt.state       ][INFO    ][6323] Running state [cfg01.mcp-pike-odl-ha.local] at time 19:01:31.456616
2018-04-20 19:01:31,456 [salt.state       ][INFO    ][6323] Executing state host.present for cfg01.mcp-pike-odl-ha.local
2018-04-20 19:01:31,457 [salt.state       ][INFO    ][6323] Host cfg01.mcp-pike-odl-ha.local (192.168.10.11) already present
2018-04-20 19:01:31,457 [salt.state       ][INFO    ][6323] Completed state [cfg01.mcp-pike-odl-ha.local] at time 19:01:31.457725 duration_in_ms=1.108
2018-04-20 19:01:31,458 [salt.state       ][INFO    ][6323] Running state [cmp002] at time 19:01:31.458091
2018-04-20 19:01:31,458 [salt.state       ][INFO    ][6323] Executing state host.present for cmp002
2018-04-20 19:01:31,459 [salt.state       ][INFO    ][6323] Host cmp002 (192.168.10.53) already present
2018-04-20 19:01:31,459 [salt.state       ][INFO    ][6323] Completed state [cmp002] at time 19:01:31.459205 duration_in_ms=1.114
2018-04-20 19:01:31,459 [salt.state       ][INFO    ][6323] Running state [cmp002.mcp-pike-odl-ha.local] at time 19:01:31.459568
2018-04-20 19:01:31,459 [salt.state       ][INFO    ][6323] Executing state host.present for cmp002.mcp-pike-odl-ha.local
2018-04-20 19:01:31,460 [salt.state       ][INFO    ][6323] Host cmp002.mcp-pike-odl-ha.local (192.168.10.53) already present
2018-04-20 19:01:31,460 [salt.state       ][INFO    ][6323] Completed state [cmp002.mcp-pike-odl-ha.local] at time 19:01:31.460682 duration_in_ms=1.114
2018-04-20 19:01:31,461 [salt.state       ][INFO    ][6323] Running state [cmp001] at time 19:01:31.460990
2018-04-20 19:01:31,461 [salt.state       ][INFO    ][6323] Executing state host.present for cmp001
2018-04-20 19:01:31,462 [salt.state       ][INFO    ][6323] Host cmp001 (192.168.10.52) already present
2018-04-20 19:01:31,462 [salt.state       ][INFO    ][6323] Completed state [cmp001] at time 19:01:31.462700 duration_in_ms=1.71
2018-04-20 19:01:31,463 [salt.state       ][INFO    ][6323] Running state [cmp001.mcp-pike-odl-ha.local] at time 19:01:31.462983
2018-04-20 19:01:31,463 [salt.state       ][INFO    ][6323] Executing state host.present for cmp001.mcp-pike-odl-ha.local
2018-04-20 19:01:31,463 [salt.state       ][INFO    ][6323] Host cmp001.mcp-pike-odl-ha.local (192.168.10.52) already present
2018-04-20 19:01:31,464 [salt.state       ][INFO    ][6323] Completed state [cmp001.mcp-pike-odl-ha.local] at time 19:01:31.463989 duration_in_ms=1.006
2018-04-20 19:01:31,464 [salt.state       ][INFO    ][6323] Running state [dbs01] at time 19:01:31.464267
2018-04-20 19:01:31,464 [salt.state       ][INFO    ][6323] Executing state host.present for dbs01
2018-04-20 19:01:31,465 [salt.state       ][INFO    ][6323] Host dbs01 (192.168.10.24) already present
2018-04-20 19:01:31,465 [salt.state       ][INFO    ][6323] Completed state [dbs01] at time 19:01:31.465271 duration_in_ms=1.004
2018-04-20 19:01:31,465 [salt.state       ][INFO    ][6323] Running state [dbs01.mcp-pike-odl-ha.local] at time 19:01:31.465538
2018-04-20 19:01:31,466 [salt.state       ][INFO    ][6323] Executing state host.present for dbs01.mcp-pike-odl-ha.local
2018-04-20 19:01:31,466 [salt.state       ][INFO    ][6323] Host dbs01.mcp-pike-odl-ha.local (192.168.10.24) already present
2018-04-20 19:01:31,467 [salt.state       ][INFO    ][6323] Completed state [dbs01.mcp-pike-odl-ha.local] at time 19:01:31.467151 duration_in_ms=1.583
2018-04-20 19:01:31,467 [salt.state       ][INFO    ][6323] Running state [dbs02] at time 19:01:31.467428
2018-04-20 19:01:31,467 [salt.state       ][INFO    ][6323] Executing state host.present for dbs02
2018-04-20 19:01:31,468 [salt.state       ][INFO    ][6323] Host dbs02 (192.168.10.25) already present
2018-04-20 19:01:31,468 [salt.state       ][INFO    ][6323] Completed state [dbs02] at time 19:01:31.468450 duration_in_ms=1.022
2018-04-20 19:01:31,468 [salt.state       ][INFO    ][6323] Running state [dbs02.mcp-pike-odl-ha.local] at time 19:01:31.468745
2018-04-20 19:01:31,469 [salt.state       ][INFO    ][6323] Executing state host.present for dbs02.mcp-pike-odl-ha.local
2018-04-20 19:01:31,469 [salt.state       ][INFO    ][6323] Host dbs02.mcp-pike-odl-ha.local (192.168.10.25) already present
2018-04-20 19:01:31,469 [salt.state       ][INFO    ][6323] Completed state [dbs02.mcp-pike-odl-ha.local] at time 19:01:31.469766 duration_in_ms=1.021
2018-04-20 19:01:31,470 [salt.state       ][INFO    ][6323] Running state [dbs03] at time 19:01:31.470354
2018-04-20 19:01:31,470 [salt.state       ][INFO    ][6323] Executing state host.present for dbs03
2018-04-20 19:01:31,471 [salt.state       ][INFO    ][6323] Host dbs03 (192.168.10.26) already present
2018-04-20 19:01:31,471 [salt.state       ][INFO    ][6323] Completed state [dbs03] at time 19:01:31.471384 duration_in_ms=1.03
2018-04-20 19:01:31,471 [salt.state       ][INFO    ][6323] Running state [dbs03.mcp-pike-odl-ha.local] at time 19:01:31.471667
2018-04-20 19:01:31,471 [salt.state       ][INFO    ][6323] Executing state host.present for dbs03.mcp-pike-odl-ha.local
2018-04-20 19:01:31,472 [salt.state       ][INFO    ][6323] Host dbs03.mcp-pike-odl-ha.local (192.168.10.26) already present
2018-04-20 19:01:31,472 [salt.state       ][INFO    ][6323] Completed state [dbs03.mcp-pike-odl-ha.local] at time 19:01:31.472810 duration_in_ms=1.143
2018-04-20 19:01:31,473 [salt.state       ][INFO    ][6323] Running state [odl01] at time 19:01:31.473081
2018-04-20 19:01:31,473 [salt.state       ][INFO    ][6323] Executing state host.present for odl01
2018-04-20 19:01:31,474 [salt.state       ][INFO    ][6323] Host odl01 (192.168.10.39) already present
2018-04-20 19:01:31,474 [salt.state       ][INFO    ][6323] Completed state [odl01] at time 19:01:31.474696 duration_in_ms=1.615
2018-04-20 19:01:31,475 [salt.state       ][INFO    ][6323] Running state [odl01.mcp-pike-odl-ha.local] at time 19:01:31.474966
2018-04-20 19:01:31,475 [salt.state       ][INFO    ][6323] Executing state host.present for odl01.mcp-pike-odl-ha.local
2018-04-20 19:01:31,475 [salt.state       ][INFO    ][6323] Host odl01.mcp-pike-odl-ha.local (192.168.10.39) already present
2018-04-20 19:01:31,476 [salt.state       ][INFO    ][6323] Completed state [odl01.mcp-pike-odl-ha.local] at time 19:01:31.475960 duration_in_ms=0.994
2018-04-20 19:01:31,476 [salt.state       ][INFO    ][6323] Running state [mas01] at time 19:01:31.476237
2018-04-20 19:01:31,476 [salt.state       ][INFO    ][6323] Executing state host.present for mas01
2018-04-20 19:01:31,477 [salt.state       ][INFO    ][6323] Host mas01 (192.168.10.12) already present
2018-04-20 19:01:31,477 [salt.state       ][INFO    ][6323] Completed state [mas01] at time 19:01:31.477229 duration_in_ms=0.992
2018-04-20 19:01:31,477 [salt.state       ][INFO    ][6323] Running state [mas01.mcp-pike-odl-ha.local] at time 19:01:31.477502
2018-04-20 19:01:31,477 [salt.state       ][INFO    ][6323] Executing state host.present for mas01.mcp-pike-odl-ha.local
2018-04-20 19:01:31,478 [salt.state       ][INFO    ][6323] Host mas01.mcp-pike-odl-ha.local (192.168.10.12) already present
2018-04-20 19:01:31,479 [salt.state       ][INFO    ][6323] Completed state [mas01.mcp-pike-odl-ha.local] at time 19:01:31.479093 duration_in_ms=1.591
2018-04-20 19:01:31,479 [salt.state       ][INFO    ][6323] Running state [ctl02] at time 19:01:31.479373
2018-04-20 19:01:31,479 [salt.state       ][INFO    ][6323] Executing state host.present for ctl02
2018-04-20 19:01:31,480 [salt.state       ][INFO    ][6323] Host ctl02 (192.168.10.37) already present
2018-04-20 19:01:31,480 [salt.state       ][INFO    ][6323] Completed state [ctl02] at time 19:01:31.480375 duration_in_ms=1.002
2018-04-20 19:01:31,480 [salt.state       ][INFO    ][6323] Running state [ctl02.mcp-pike-odl-ha.local] at time 19:01:31.480643
2018-04-20 19:01:31,480 [salt.state       ][INFO    ][6323] Executing state host.present for ctl02.mcp-pike-odl-ha.local
2018-04-20 19:01:31,481 [salt.state       ][INFO    ][6323] Host ctl02.mcp-pike-odl-ha.local (192.168.10.37) already present
2018-04-20 19:01:31,481 [salt.state       ][INFO    ][6323] Completed state [ctl02.mcp-pike-odl-ha.local] at time 19:01:31.481626 duration_in_ms=0.983
2018-04-20 19:01:31,482 [salt.state       ][INFO    ][6323] Running state [ctl03] at time 19:01:31.482508
2018-04-20 19:01:31,482 [salt.state       ][INFO    ][6323] Executing state host.present for ctl03
2018-04-20 19:01:31,483 [salt.state       ][INFO    ][6323] Host ctl03 (192.168.10.38) already present
2018-04-20 19:01:31,483 [salt.state       ][INFO    ][6323] Completed state [ctl03] at time 19:01:31.483489 duration_in_ms=0.981
2018-04-20 19:01:31,483 [salt.state       ][INFO    ][6323] Running state [ctl03.mcp-pike-odl-ha.local] at time 19:01:31.483753
2018-04-20 19:01:31,484 [salt.state       ][INFO    ][6323] Executing state host.present for ctl03.mcp-pike-odl-ha.local
2018-04-20 19:01:31,484 [salt.state       ][INFO    ][6323] Host ctl03.mcp-pike-odl-ha.local (192.168.10.38) already present
2018-04-20 19:01:31,484 [salt.state       ][INFO    ][6323] Completed state [ctl03.mcp-pike-odl-ha.local] at time 19:01:31.484746 duration_in_ms=0.993
2018-04-20 19:01:31,485 [salt.state       ][INFO    ][6323] Running state [ctl01] at time 19:01:31.485016
2018-04-20 19:01:31,485 [salt.state       ][INFO    ][6323] Executing state host.present for ctl01
2018-04-20 19:01:31,486 [salt.state       ][INFO    ][6323] Host ctl01 (192.168.10.36) already present
2018-04-20 19:01:31,486 [salt.state       ][INFO    ][6323] Completed state [ctl01] at time 19:01:31.486615 duration_in_ms=1.599
2018-04-20 19:01:31,486 [salt.state       ][INFO    ][6323] Running state [ctl01.mcp-pike-odl-ha.local] at time 19:01:31.486888
2018-04-20 19:01:31,487 [salt.state       ][INFO    ][6323] Executing state host.present for ctl01.mcp-pike-odl-ha.local
2018-04-20 19:01:31,487 [salt.state       ][INFO    ][6323] Host ctl01.mcp-pike-odl-ha.local (192.168.10.36) already present
2018-04-20 19:01:31,487 [salt.state       ][INFO    ][6323] Completed state [ctl01.mcp-pike-odl-ha.local] at time 19:01:31.487885 duration_in_ms=0.996
2018-04-20 19:01:31,488 [salt.state       ][INFO    ][6323] Running state [ctl] at time 19:01:31.488154
2018-04-20 19:01:31,488 [salt.state       ][INFO    ][6323] Executing state host.present for ctl
2018-04-20 19:01:31,488 [salt.state       ][INFO    ][6323] Host ctl (192.168.10.35) already present
2018-04-20 19:01:31,489 [salt.state       ][INFO    ][6323] Completed state [ctl] at time 19:01:31.489141 duration_in_ms=0.987
2018-04-20 19:01:31,489 [salt.state       ][INFO    ][6323] Running state [ctl.mcp-pike-odl-ha.local] at time 19:01:31.489413
2018-04-20 19:01:31,489 [salt.state       ][INFO    ][6323] Executing state host.present for ctl.mcp-pike-odl-ha.local
2018-04-20 19:01:31,490 [salt.state       ][INFO    ][6323] Host ctl.mcp-pike-odl-ha.local (192.168.10.35) already present
2018-04-20 19:01:31,491 [salt.state       ][INFO    ][6323] Completed state [ctl.mcp-pike-odl-ha.local] at time 19:01:31.491004 duration_in_ms=1.591
2018-04-20 19:01:31,491 [salt.state       ][INFO    ][6323] Running state [/etc/network/interfaces.d/50-cloud-init.cfg] at time 19:01:31.491287
2018-04-20 19:01:31,491 [salt.state       ][INFO    ][6323] Executing state file.absent for /etc/network/interfaces.d/50-cloud-init.cfg
2018-04-20 19:01:31,491 [salt.state       ][INFO    ][6323] File /etc/network/interfaces.d/50-cloud-init.cfg is not present
2018-04-20 19:01:31,492 [salt.state       ][INFO    ][6323] Completed state [/etc/network/interfaces.d/50-cloud-init.cfg] at time 19:01:31.492139 duration_in_ms=0.852
2018-04-20 19:01:31,492 [salt.state       ][INFO    ][6323] Running state [ens2] at time 19:01:31.492412
2018-04-20 19:01:31,492 [salt.state       ][INFO    ][6323] Executing state network.managed for ens2
2018-04-20 19:01:32,288 [salt.state       ][INFO    ][6323] Interface ens2 is up to date.
2018-04-20 19:01:32,288 [salt.state       ][INFO    ][6323] Completed state [ens2] at time 19:01:32.288660 duration_in_ms=796.248
2018-04-20 19:01:32,289 [salt.state       ][INFO    ][6323] Running state [ens3] at time 19:01:32.289076
2018-04-20 19:01:32,289 [salt.state       ][INFO    ][6323] Executing state network.managed for ens3
2018-04-20 19:01:32,959 [salt.state       ][INFO    ][6323] Interface ens3 is up to date.
2018-04-20 19:01:32,959 [salt.state       ][INFO    ][6323] Completed state [ens3] at time 19:01:32.959593 duration_in_ms=670.52
2018-04-20 19:01:32,960 [salt.state       ][INFO    ][6323] Running state [/etc/profile.d/proxy.sh] at time 19:01:32.959990
2018-04-20 19:01:32,960 [salt.state       ][INFO    ][6323] Executing state file.absent for /etc/profile.d/proxy.sh
2018-04-20 19:01:32,960 [salt.state       ][INFO    ][6323] File /etc/profile.d/proxy.sh is not present
2018-04-20 19:01:32,961 [salt.state       ][INFO    ][6323] Completed state [/etc/profile.d/proxy.sh] at time 19:01:32.961122 duration_in_ms=1.132
2018-04-20 19:01:32,961 [salt.state       ][INFO    ][6323] Running state [/etc/apt/apt.conf.d/95proxies] at time 19:01:32.961397
2018-04-20 19:01:32,961 [salt.state       ][INFO    ][6323] Executing state file.absent for /etc/apt/apt.conf.d/95proxies
2018-04-20 19:01:32,963 [salt.state       ][INFO    ][6323] File /etc/apt/apt.conf.d/95proxies is not present
2018-04-20 19:01:32,963 [salt.state       ][INFO    ][6323] Completed state [/etc/apt/apt.conf.d/95proxies] at time 19:01:32.963304 duration_in_ms=1.907
2018-04-20 19:01:32,963 [salt.state       ][INFO    ][6323] Running state [ntp] at time 19:01:32.963614
2018-04-20 19:01:32,963 [salt.state       ][INFO    ][6323] Executing state pkg.installed for ntp
2018-04-20 19:01:32,971 [salt.state       ][INFO    ][6323] All specified packages are already installed
2018-04-20 19:01:32,972 [salt.state       ][INFO    ][6323] Completed state [ntp] at time 19:01:32.972168 duration_in_ms=8.554
2018-04-20 19:01:32,974 [salt.state       ][INFO    ][6323] Running state [/etc/ntp.conf] at time 19:01:32.974794
2018-04-20 19:01:32,975 [salt.state       ][INFO    ][6323] Executing state file.managed for /etc/ntp.conf
2018-04-20 19:01:33,087 [salt.state       ][INFO    ][6323] File /etc/ntp.conf is in the correct state
2018-04-20 19:01:33,088 [salt.state       ][INFO    ][6323] Completed state [/etc/ntp.conf] at time 19:01:33.088085 duration_in_ms=113.29
2018-04-20 19:01:33,089 [salt.state       ][INFO    ][6323] Running state [ntp] at time 19:01:33.089362
2018-04-20 19:01:33,089 [salt.state       ][INFO    ][6323] Executing state service.running for ntp
2018-04-20 19:01:33,090 [salt.loaded.int.module.cmdmod][INFO    ][6323] Executing command ['systemctl', 'status', 'ntp.service', '-n', '0'] in directory '/root'
2018-04-20 19:01:33,112 [salt.loaded.int.module.cmdmod][INFO    ][6323] Executing command ['systemctl', 'is-active', 'ntp.service'] in directory '/root'
2018-04-20 19:01:33,133 [salt.loaded.int.module.cmdmod][INFO    ][6323] Executing command ['systemctl', 'is-enabled', 'ntp.service'] in directory '/root'
2018-04-20 19:01:33,155 [salt.state       ][INFO    ][6323] The service ntp is already running
2018-04-20 19:01:33,156 [salt.state       ][INFO    ][6323] Completed state [ntp] at time 19:01:33.155983 duration_in_ms=66.62
2018-04-20 19:01:33,162 [salt.minion      ][INFO    ][6323] Returning information for job: 20180420190116777793
2018-04-20 19:01:53,916 [salt.minion      ][INFO    ][2025] User sudo_ubuntu Executing command ssh.set_auth_key with jid 20180420190153905535
2018-04-20 19:01:53,943 [salt.minion      ][INFO    ][7470] Starting a new job with PID 7470
2018-04-20 19:01:53,956 [salt.loader.192.168.11.2.int.module.ssh][WARNING ][7470] Public Key hashing currently defaults to "md5". This will change to "sha256" in the Nitrogen release.
2018-04-20 19:01:53,959 [salt.minion      ][INFO    ][7470] Returning information for job: 20180420190153905535
2018-04-20 19:02:20,513 [salt.minion      ][INFO    ][2025] User sudo_ubuntu Executing command pkg.upgrade with jid 20180420190220501807
2018-04-20 19:02:20,533 [salt.minion      ][INFO    ][7482] Starting a new job with PID 7482
2018-04-20 19:02:20,559 [salt.loader.192.168.11.2.int.module.cmdmod][INFO    ][7482] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2018-04-20 19:02:20,971 [salt.loader.192.168.11.2.int.module.cmdmod][INFO    ][7482] 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-20 19:02:30,569 [salt.minion      ][INFO    ][2025] User sudo_ubuntu Executing command saltutil.find_job with jid 20180420190230556640
2018-04-20 19:02:30,584 [salt.minion      ][INFO    ][8547] Starting a new job with PID 8547
2018-04-20 19:02:30,603 [salt.minion      ][INFO    ][8547] Returning information for job: 20180420190230556640
2018-04-20 19:02:33,374 [salt.loader.192.168.11.2.int.module.cmdmod][INFO    ][7482] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2018-04-20 19:02:33,417 [salt.minion      ][INFO    ][7482] Returning information for job: 20180420190220501807
2018-04-20 19:07:39,021 [salt.minion      ][INFO    ][2025] User sudo_ubuntu Executing command test.ping with jid 20180420190739013414
2018-04-20 19:07:39,039 [salt.minion      ][INFO    ][8738] Starting a new job with PID 8738
2018-04-20 19:07:39,137 [salt.minion      ][INFO    ][8738] Returning information for job: 20180420190739013414
2018-04-20 19:09:39,688 [salt.minion      ][INFO    ][2025] User sudo_ubuntu Executing command state.sls with jid 20180420190939678613
2018-04-20 19:09:39,706 [salt.minion      ][INFO    ][8753] Starting a new job with PID 8753
2018-04-20 19:09:40,213 [salt.state       ][INFO    ][8753] Loading fresh modules for state activity
2018-04-20 19:09:40,275 [salt.fileclient  ][INFO    ][8753] Fetching file from saltenv 'base', ** done ** 'keepalived/init.sls'
2018-04-20 19:09:40,314 [salt.fileclient  ][INFO    ][8753] Fetching file from saltenv 'base', ** done ** 'keepalived/cluster.sls'
2018-04-20 19:09:40,920 [salt.state       ][INFO    ][8753] Running state [keepalived] at time 19:09:40.920422
2018-04-20 19:09:40,920 [salt.state       ][INFO    ][8753] Executing state pkg.installed for keepalived
2018-04-20 19:09:40,921 [salt.loaded.int.module.cmdmod][INFO    ][8753] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2018-04-20 19:09:41,301 [salt.loaded.int.module.cmdmod][INFO    ][8753] Executing command ['apt-cache', '-q', 'policy', 'keepalived'] in directory '/root'
2018-04-20 19:09:41,391 [salt.loaded.int.module.cmdmod][INFO    ][8753] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2018-04-20 19:09:43,482 [salt.loaded.int.module.cmdmod][INFO    ][8753] Executing command ['dpkg', '--get-selections', '*'] in directory '/root'
2018-04-20 19:09:43,517 [salt.loaded.int.module.cmdmod][INFO    ][8753] 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-20 19:09:47,609 [salt.loaded.int.module.cmdmod][INFO    ][8753] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2018-04-20 19:09:47,660 [salt.state       ][INFO    ][8753] 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-20 19:09:47,682 [salt.state       ][INFO    ][8753] Loading fresh modules for state activity
2018-04-20 19:09:47,715 [salt.state       ][INFO    ][8753] Completed state [keepalived] at time 19:09:47.715749 duration_in_ms=6795.328
2018-04-20 19:09:47,720 [salt.state       ][INFO    ][8753] Running state [lsof] at time 19:09:47.720784
2018-04-20 19:09:47,721 [salt.state       ][INFO    ][8753] Executing state pkg.installed for lsof
2018-04-20 19:09:48,151 [salt.state       ][INFO    ][8753] All specified packages are already installed
2018-04-20 19:09:48,151 [salt.state       ][INFO    ][8753] Completed state [lsof] at time 19:09:48.151910 duration_in_ms=431.125
2018-04-20 19:09:48,154 [salt.state       ][INFO    ][8753] Running state [/etc/keepalived/keepalived.conf] at time 19:09:48.154447
2018-04-20 19:09:48,154 [salt.state       ][INFO    ][8753] Executing state file.managed for /etc/keepalived/keepalived.conf
2018-04-20 19:09:48,195 [salt.fileclient  ][INFO    ][8753] Fetching file from saltenv 'base', ** done ** 'keepalived/files/keepalived.conf'
2018-04-20 19:09:48,254 [salt.state       ][INFO    ][8753] File changed:
New file
2018-04-20 19:09:48,254 [salt.state       ][INFO    ][8753] Completed state [/etc/keepalived/keepalived.conf] at time 19:09:48.254478 duration_in_ms=100.031
2018-04-20 19:09:48,255 [salt.state       ][INFO    ][8753] Running state [keepalived] at time 19:09:48.255518
2018-04-20 19:09:48,255 [salt.state       ][INFO    ][8753] Executing state service.running for keepalived
2018-04-20 19:09:48,256 [salt.loaded.int.module.cmdmod][INFO    ][8753] Executing command ['systemctl', 'status', 'keepalived.service', '-n', '0'] in directory '/root'
2018-04-20 19:09:48,277 [salt.loaded.int.module.cmdmod][INFO    ][8753] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2018-04-20 19:09:48,297 [salt.loaded.int.module.cmdmod][INFO    ][8753] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2018-04-20 19:09:48,318 [salt.loaded.int.module.cmdmod][INFO    ][8753] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2018-04-20 19:09:48,342 [salt.loaded.int.module.cmdmod][INFO    ][8753] Executing command ['systemd-run', '--scope', 'systemctl', 'start', 'keepalived.service'] in directory '/root'
2018-04-20 19:09:48,419 [salt.loaded.int.module.cmdmod][INFO    ][8753] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2018-04-20 19:09:48,437 [salt.loaded.int.module.cmdmod][INFO    ][8753] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2018-04-20 19:09:48,454 [salt.loaded.int.module.cmdmod][INFO    ][8753] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2018-04-20 19:09:48,474 [salt.state       ][INFO    ][8753] {'keepalived': True}
2018-04-20 19:09:48,477 [salt.state       ][INFO    ][8753] Completed state [keepalived] at time 19:09:48.476297 duration_in_ms=220.776
2018-04-20 19:09:48,478 [salt.minion      ][INFO    ][8753] Returning information for job: 20180420190939678613
2018-04-20 19:10:19,910 [salt.minion      ][INFO    ][2025] User sudo_ubuntu Executing command pillar.get with jid 20180420191019898278
2018-04-20 19:10:19,939 [salt.minion      ][INFO    ][10117] Starting a new job with PID 10117
2018-04-20 19:10:19,948 [salt.minion      ][INFO    ][10117] Returning information for job: 20180420191019898278
2018-04-20 19:10:20,703 [salt.minion      ][INFO    ][2025] User sudo_ubuntu Executing command state.sls with jid 20180420191020693696
2018-04-20 19:10:20,723 [salt.minion      ][INFO    ][10122] Starting a new job with PID 10122
2018-04-20 19:10:23,121 [salt.state       ][INFO    ][10122] Loading fresh modules for state activity
2018-04-20 19:10:23,186 [salt.fileclient  ][INFO    ][10122] Fetching file from saltenv 'base', ** done ** 'rabbitmq/init.sls'
2018-04-20 19:10:23,233 [salt.fileclient  ][INFO    ][10122] Fetching file from saltenv 'base', ** done ** 'rabbitmq/server/init.sls'
2018-04-20 19:10:23,263 [salt.fileclient  ][INFO    ][10122] Fetching file from saltenv 'base', ** done ** 'rabbitmq/server/service.sls'
2018-04-20 19:10:23,321 [salt.loaded.int.module.cmdmod][INFO    ][10122] Executing command 'cat /var/lib/rabbitmq/.erlang.cookie' in directory '/root'
2018-04-20 19:10:23,334 [salt.loaded.int.module.cmdmod][ERROR   ][10122] Command 'cat /var/lib/rabbitmq/.erlang.cookie' failed with return code: 1
2018-04-20 19:10:23,335 [salt.loaded.int.module.cmdmod][ERROR   ][10122] output: cat: /var/lib/rabbitmq/.erlang.cookie: No such file or directory
2018-04-20 19:10:23,381 [salt.fileclient  ][INFO    ][10122] Fetching file from saltenv 'base', ** done ** 'rabbitmq/server/ssl.sls'
2018-04-20 19:10:23,458 [salt.fileclient  ][INFO    ][10122] Fetching file from saltenv 'base', ** done ** 'rabbitmq/server/plugin.sls'
2018-04-20 19:10:23,532 [salt.fileclient  ][INFO    ][10122] Fetching file from saltenv 'base', ** done ** 'rabbitmq/server/vhost.sls'
2018-04-20 19:10:23,636 [salt.fileclient  ][INFO    ][10122] Fetching file from saltenv 'base', ** done ** 'rabbitmq/server/user.sls'
2018-04-20 19:10:23,705 [salt.fileclient  ][INFO    ][10122] Fetching file from saltenv 'base', ** done ** 'rabbitmq/cluster.sls'
2018-04-20 19:10:24,310 [salt.state       ][INFO    ][10122] Running state [rabbitmq-server] at time 19:10:24.309944
2018-04-20 19:10:24,310 [salt.state       ][INFO    ][10122] Executing state pkg.installed for rabbitmq-server
2018-04-20 19:10:24,311 [salt.loaded.int.module.cmdmod][INFO    ][10122] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2018-04-20 19:10:24,691 [salt.loaded.int.module.cmdmod][INFO    ][10122] Executing command ['apt-cache', '-q', 'policy', 'rabbitmq-server'] in directory '/root'
2018-04-20 19:10:24,789 [salt.loaded.int.module.cmdmod][INFO    ][10122] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2018-04-20 19:10:26,938 [salt.loaded.int.module.cmdmod][INFO    ][10122] Executing command ['dpkg', '--get-selections', '*'] in directory '/root'
2018-04-20 19:10:26,970 [salt.loaded.int.module.cmdmod][INFO    ][10122] 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-20 19:10:30,811 [salt.minion      ][INFO    ][2025] User sudo_ubuntu Executing command saltutil.find_job with jid 20180420191030791899
2018-04-20 19:10:30,830 [salt.minion      ][INFO    ][10582] Starting a new job with PID 10582
2018-04-20 19:10:30,851 [salt.minion      ][INFO    ][10582] Returning information for job: 20180420191030791899
2018-04-20 19:10:41,030 [salt.minion      ][INFO    ][2025] User sudo_ubuntu Executing command saltutil.find_job with jid 20180420191041019109
2018-04-20 19:10:41,044 [salt.minion      ][INFO    ][11447] Starting a new job with PID 11447
2018-04-20 19:10:41,061 [salt.minion      ][INFO    ][11447] Returning information for job: 20180420191041019109
2018-04-20 19:10:51,239 [salt.minion      ][INFO    ][2025] User sudo_ubuntu Executing command saltutil.find_job with jid 20180420191051221931
2018-04-20 19:10:51,252 [salt.minion      ][INFO    ][11452] Starting a new job with PID 11452
2018-04-20 19:10:51,267 [salt.minion      ][INFO    ][11452] Returning information for job: 20180420191051221931
2018-04-20 19:11:01,451 [salt.minion      ][INFO    ][2025] User sudo_ubuntu Executing command saltutil.find_job with jid 20180420191101439520
2018-04-20 19:11:01,467 [salt.minion      ][INFO    ][11457] Starting a new job with PID 11457
2018-04-20 19:11:01,481 [salt.minion      ][INFO    ][11457] Returning information for job: 20180420191101439520
2018-04-20 19:11:11,670 [salt.minion      ][INFO    ][2025] User sudo_ubuntu Executing command saltutil.find_job with jid 20180420191111657824
2018-04-20 19:11:11,688 [salt.minion      ][INFO    ][11462] Starting a new job with PID 11462
2018-04-20 19:11:11,707 [salt.minion      ][INFO    ][11462] Returning information for job: 20180420191111657824
2018-04-20 19:11:15,695 [salt.loaded.int.module.cmdmod][INFO    ][10122] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2018-04-20 19:11:15,748 [salt.state       ][INFO    ][10122] 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-20 19:11:15,776 [salt.state       ][INFO    ][10122] Loading fresh modules for state activity
2018-04-20 19:11:15,808 [salt.state       ][INFO    ][10122] Completed state [rabbitmq-server] at time 19:11:15.808117 duration_in_ms=51498.173
2018-04-20 19:11:15,812 [salt.state       ][INFO    ][10122] Running state [/etc/rabbitmq/rabbitmq.config] at time 19:11:15.812912
2018-04-20 19:11:15,813 [salt.state       ][INFO    ][10122] Executing state file.managed for /etc/rabbitmq/rabbitmq.config
2018-04-20 19:11:15,863 [salt.fileclient  ][INFO    ][10122] Fetching file from saltenv 'base', ** done ** 'rabbitmq/files/rabbitmq.config'
2018-04-20 19:11:15,940 [salt.state       ][INFO    ][10122] File changed:
New file
2018-04-20 19:11:15,941 [salt.state       ][INFO    ][10122] Completed state [/etc/rabbitmq/rabbitmq.config] at time 19:11:15.941028 duration_in_ms=128.116
2018-04-20 19:11:15,941 [salt.state       ][INFO    ][10122] Running state [/etc/default/rabbitmq-server] at time 19:11:15.941678
2018-04-20 19:11:15,942 [salt.state       ][INFO    ][10122] Executing state file.managed for /etc/default/rabbitmq-server
2018-04-20 19:11:15,982 [salt.fileclient  ][INFO    ][10122] Fetching file from saltenv 'base', ** done ** 'rabbitmq/files/default'
2018-04-20 19:11:16,031 [salt.state       ][INFO    ][10122] 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-20 19:11:16,035 [salt.state       ][INFO    ][10122] Completed state [/etc/default/rabbitmq-server] at time 19:11:16.035448 duration_in_ms=93.771
2018-04-20 19:11:16,036 [salt.state       ][INFO    ][10122] Running state [/etc/systemd/system/rabbitmq-server.service.d/limits.conf] at time 19:11:16.036047
2018-04-20 19:11:16,036 [salt.state       ][INFO    ][10122] Executing state file.managed for /etc/systemd/system/rabbitmq-server.service.d/limits.conf
2018-04-20 19:11:16,071 [salt.fileclient  ][INFO    ][10122] Fetching file from saltenv 'base', ** done ** 'rabbitmq/files/limits.conf'
2018-04-20 19:11:16,113 [salt.state       ][INFO    ][10122] File changed:
New file
2018-04-20 19:11:16,113 [salt.state       ][INFO    ][10122] Completed state [/etc/systemd/system/rabbitmq-server.service.d/limits.conf] at time 19:11:16.113740 duration_in_ms=77.693
2018-04-20 19:11:16,115 [salt.state       ][INFO    ][10122] Running state [sleep 30] at time 19:11:16.115620
2018-04-20 19:11:16,116 [salt.state       ][INFO    ][10122] Executing state cmd.run for sleep 30
2018-04-20 19:11:16,116 [py.warnings      ][WARNING ][10122] /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-20 19:11:16,119 [salt.loaded.int.module.cmdmod][INFO    ][10122] Executing command 'sleep 30' as user 'root' in directory '/root'
2018-04-20 19:11:21,902 [salt.minion      ][INFO    ][2025] User sudo_ubuntu Executing command saltutil.find_job with jid 20180420191121883098
2018-04-20 19:11:21,918 [salt.minion      ][INFO    ][11598] Starting a new job with PID 11598
2018-04-20 19:11:21,939 [salt.minion      ][INFO    ][11598] Returning information for job: 20180420191121883098
2018-04-20 19:11:31,928 [salt.minion      ][INFO    ][2025] User sudo_ubuntu Executing command saltutil.find_job with jid 20180420191131912143
2018-04-20 19:11:31,953 [salt.minion      ][INFO    ][11603] Starting a new job with PID 11603
2018-04-20 19:11:31,973 [salt.minion      ][INFO    ][11603] Returning information for job: 20180420191131912143
2018-04-20 19:11:42,025 [salt.minion      ][INFO    ][2025] User sudo_ubuntu Executing command saltutil.find_job with jid 20180420191142002961
2018-04-20 19:11:42,042 [salt.minion      ][INFO    ][11608] Starting a new job with PID 11608
2018-04-20 19:11:42,062 [salt.minion      ][INFO    ][11608] Returning information for job: 20180420191142002961
2018-04-20 19:11:46,238 [salt.state       ][INFO    ][10122] {'pid': 11586, 'retcode': 0, 'stderr': '', 'stdout': ''}
2018-04-20 19:11:46,240 [salt.state       ][INFO    ][10122] Completed state [sleep 30] at time 19:11:46.240745 duration_in_ms=30125.122
2018-04-20 19:11:46,244 [salt.state       ][INFO    ][10122] Running state [service rabbitmq-server stop] at time 19:11:46.244144
2018-04-20 19:11:46,245 [salt.state       ][INFO    ][10122] Executing state cmd.run for service rabbitmq-server stop
2018-04-20 19:11:46,248 [salt.loaded.int.module.cmdmod][INFO    ][10122] Executing command 'service rabbitmq-server stop' in directory '/root'
2018-04-20 19:11:46,527 [salt.state       ][INFO    ][10122] {'pid': 11611, 'retcode': 0, 'stderr': '', 'stdout': ''}
2018-04-20 19:11:46,528 [salt.state       ][INFO    ][10122] Completed state [service rabbitmq-server stop] at time 19:11:46.528673 duration_in_ms=284.53
2018-04-20 19:11:46,529 [salt.state       ][INFO    ][10122] Running state [/var/lib/rabbitmq] at time 19:11:46.529475
2018-04-20 19:11:46,530 [salt.state       ][INFO    ][10122] Executing state file.directory for /var/lib/rabbitmq
2018-04-20 19:11:46,531 [salt.state       ][INFO    ][10122] Directory /var/lib/rabbitmq is in the correct state
2018-04-20 19:11:46,532 [salt.state       ][INFO    ][10122] Completed state [/var/lib/rabbitmq] at time 19:11:46.532276 duration_in_ms=2.801
2018-04-20 19:11:46,534 [salt.state       ][INFO    ][10122] Running state [/var/lib/rabbitmq/.erlang.cookie] at time 19:11:46.534019
2018-04-20 19:11:46,534 [salt.state       ][INFO    ][10122] Executing state file.managed for /var/lib/rabbitmq/.erlang.cookie
2018-04-20 19:11:46,537 [salt.state       ][INFO    ][10122] File changed:
--- 
+++ 
@@ -1 +1 @@
-RGDSEPOAYLFZQRXWXXBI+opnfv_secret

2018-04-20 19:11:46,539 [salt.state       ][INFO    ][10122] Completed state [/var/lib/rabbitmq/.erlang.cookie] at time 19:11:46.538992 duration_in_ms=4.973
2018-04-20 19:11:46,540 [salt.state       ][INFO    ][10122] Running state [sleep 30] at time 19:11:46.539980
2018-04-20 19:11:46,540 [salt.state       ][INFO    ][10122] Executing state cmd.run for sleep 30
2018-04-20 19:11:46,541 [salt.loaded.int.module.cmdmod][INFO    ][10122] Executing command 'sleep 30' as user 'root' in directory '/root'
2018-04-20 19:11:52,256 [salt.minion      ][INFO    ][2025] User sudo_ubuntu Executing command saltutil.find_job with jid 20180420191152236712
2018-04-20 19:11:52,275 [salt.minion      ][INFO    ][11666] Starting a new job with PID 11666
2018-04-20 19:11:52,296 [salt.minion      ][INFO    ][11666] Returning information for job: 20180420191152236712
2018-04-20 19:12:02,496 [salt.minion      ][INFO    ][2025] User sudo_ubuntu Executing command saltutil.find_job with jid 20180420191202474017
2018-04-20 19:12:02,513 [salt.minion      ][INFO    ][11671] Starting a new job with PID 11671
2018-04-20 19:12:02,533 [salt.minion      ][INFO    ][11671] Returning information for job: 20180420191202474017
2018-04-20 19:12:12,730 [salt.minion      ][INFO    ][2025] User sudo_ubuntu Executing command saltutil.find_job with jid 20180420191212707911
2018-04-20 19:12:12,753 [salt.minion      ][INFO    ][11676] Starting a new job with PID 11676
2018-04-20 19:12:12,773 [salt.minion      ][INFO    ][11676] Returning information for job: 20180420191212707911
2018-04-20 19:12:16,653 [salt.state       ][INFO    ][10122] {'pid': 11656, 'retcode': 0, 'stderr': '', 'stdout': ''}
2018-04-20 19:12:16,655 [salt.state       ][INFO    ][10122] Completed state [sleep 30] at time 19:12:16.654908 duration_in_ms=30114.926
2018-04-20 19:12:16,991 [salt.state       ][INFO    ][10122] Running state [rabbitmq-server] at time 19:12:16.991782
2018-04-20 19:12:16,992 [salt.state       ][INFO    ][10122] Executing state service.running for rabbitmq-server
2018-04-20 19:12:16,993 [salt.loaded.int.module.cmdmod][INFO    ][10122] Executing command ['systemctl', 'status', 'rabbitmq-server.service', '-n', '0'] in directory '/root'
2018-04-20 19:12:17,019 [salt.loaded.int.module.cmdmod][INFO    ][10122] Executing command ['systemctl', 'is-active', 'rabbitmq-server.service'] in directory '/root'
2018-04-20 19:12:17,038 [salt.loaded.int.module.cmdmod][INFO    ][10122] Executing command ['systemctl', 'is-enabled', 'rabbitmq-server.service'] in directory '/root'
2018-04-20 19:12:17,062 [salt.loaded.int.module.cmdmod][INFO    ][10122] Executing command ['systemctl', 'is-enabled', 'rabbitmq-server.service'] in directory '/root'
2018-04-20 19:12:17,082 [salt.loaded.int.module.cmdmod][INFO    ][10122] Executing command ['systemd-run', '--scope', 'systemctl', 'start', 'rabbitmq-server.service'] in directory '/root'
2018-04-20 19:12:19,935 [salt.loaded.int.module.cmdmod][INFO    ][10122] Executing command ['systemctl', 'is-active', 'rabbitmq-server.service'] in directory '/root'
2018-04-20 19:12:19,953 [salt.loaded.int.module.cmdmod][INFO    ][10122] Executing command ['systemctl', 'is-enabled', 'rabbitmq-server.service'] in directory '/root'
2018-04-20 19:12:19,974 [salt.loaded.int.module.cmdmod][INFO    ][10122] Executing command ['systemctl', 'is-enabled', 'rabbitmq-server.service'] in directory '/root'
2018-04-20 19:12:19,996 [salt.loaded.int.module.cmdmod][INFO    ][10122] Executing command ['systemctl', 'is-enabled', 'rabbitmq-server.service'] in directory '/root'
2018-04-20 19:12:20,020 [salt.loaded.int.module.cmdmod][INFO    ][10122] Executing command ['systemd-run', '--scope', 'systemctl', 'enable', 'rabbitmq-server.service'] in directory '/root'
2018-04-20 19:12:20,359 [salt.loaded.int.module.cmdmod][INFO    ][10122] Executing command ['systemctl', 'is-enabled', 'rabbitmq-server.service'] in directory '/root'
2018-04-20 19:12:20,378 [salt.state       ][INFO    ][10122] {'rabbitmq-server': True}
2018-04-20 19:12:20,378 [salt.state       ][INFO    ][10122] Completed state [rabbitmq-server] at time 19:12:20.378893 duration_in_ms=3387.111
2018-04-20 19:12:20,381 [salt.state       ][INFO    ][10122] Running state [amqp_client] at time 19:12:20.381836
2018-04-20 19:12:20,382 [salt.state       ][INFO    ][10122] Executing state rabbitmq_plugin.enabled for amqp_client
2018-04-20 19:12:20,385 [salt.loaded.int.module.cmdmod][INFO    ][10122] Executing command ['/usr/sbin/rabbitmq-plugins', 'list', '-m', '-e'] as user 'root' in directory '/root'
2018-04-20 19:12:21,551 [salt.loaded.int.module.cmdmod][INFO    ][10122] Executing command ['/usr/sbin/rabbitmq-plugins', 'enable', 'amqp_client'] as user 'root' in directory '/root'
2018-04-20 19:12:22,766 [salt.minion      ][INFO    ][2025] User sudo_ubuntu Executing command saltutil.find_job with jid 20180420191222747154
2018-04-20 19:12:22,780 [salt.minion      ][INFO    ][12411] Starting a new job with PID 12411
2018-04-20 19:12:22,811 [salt.minion      ][INFO    ][12411] Returning information for job: 20180420191222747154
2018-04-20 19:12:22,855 [salt.state       ][INFO    ][10122] {'new': 'amqp_client', 'old': ''}
2018-04-20 19:12:22,855 [salt.state       ][INFO    ][10122] Completed state [amqp_client] at time 19:12:22.855777 duration_in_ms=2473.941
2018-04-20 19:12:22,857 [salt.state       ][INFO    ][10122] Running state [rabbitmq_management] at time 19:12:22.857296
2018-04-20 19:12:22,857 [salt.state       ][INFO    ][10122] Executing state rabbitmq_plugin.enabled for rabbitmq_management
2018-04-20 19:12:22,859 [salt.loaded.int.module.cmdmod][INFO    ][10122] Executing command ['/usr/sbin/rabbitmq-plugins', 'list', '-m', '-e'] as user 'root' in directory '/root'
2018-04-20 19:12:24,033 [salt.loaded.int.module.cmdmod][INFO    ][10122] Executing command ['/usr/sbin/rabbitmq-plugins', 'enable', 'rabbitmq_management'] as user 'root' in directory '/root'
2018-04-20 19:12:25,965 [salt.state       ][INFO    ][10122] {'new': 'rabbitmq_management', 'old': ''}
2018-04-20 19:12:25,966 [salt.state       ][INFO    ][10122] Completed state [rabbitmq_management] at time 19:12:25.966338 duration_in_ms=3109.041
2018-04-20 19:12:25,970 [salt.state       ][INFO    ][10122] Running state [/openstack] at time 19:12:25.970439
2018-04-20 19:12:25,970 [salt.state       ][INFO    ][10122] Executing state rabbitmq_vhost.present for /openstack
2018-04-20 19:12:25,971 [salt.loaded.int.module.cmdmod][INFO    ][10122] Executing command 'rabbitmqctl list_vhosts -q' as user 'root' in directory '/root'
2018-04-20 19:12:27,087 [salt.loaded.int.module.cmdmod][INFO    ][10122] Executing command ['rabbitmqctl', 'add_vhost', '/openstack'] as user 'root' in directory '/root'
2018-04-20 19:12:28,205 [salt.state       ][INFO    ][10122] {'new': '/openstack', 'old': ''}
2018-04-20 19:12:28,206 [salt.state       ][INFO    ][10122] Completed state [/openstack] at time 19:12:28.206416 duration_in_ms=2235.976
2018-04-20 19:12:28,209 [salt.state       ][INFO    ][10122] Running state [openstack] at time 19:12:28.209809
2018-04-20 19:12:28,210 [salt.state       ][INFO    ][10122] Executing state rabbitmq_user.present for openstack
2018-04-20 19:12:28,210 [salt.loaded.int.module.cmdmod][INFO    ][10122] Executing command ['rabbitmqctl', 'list_users'] as user 'root' in directory '/root'
2018-04-20 19:12:30,418 [salt.loaded.int.module.cmdmod][INFO    ][10122] Executing command ['rabbitmqctl', 'list_user_permissions', 'openstack'] as user 'root' in directory '/root'
2018-04-20 19:12:31,522 [salt.loaded.int.module.cmdmod][INFO    ][10122] Executing command ['rabbitmqctl', 'set_permissions', '-p', '/openstack', 'openstack', '.*', '.*', '.*'] as user 'root' in directory '/root'
2018-04-20 19:12:32,681 [salt.state       ][INFO    ][10122] Made the following changes:
'perms' changed from 'absent' to '{'/openstack': ['.*', '.*', '.*']}'
'user' changed from 'absent' to 'openstack'

2018-04-20 19:12:32,681 [salt.state       ][INFO    ][10122] Completed state [openstack] at time 19:12:32.681807 duration_in_ms=4471.997
2018-04-20 19:12:32,685 [salt.state       ][INFO    ][10122] Running state [Ceilometer] at time 19:12:32.685621
2018-04-20 19:12:32,686 [salt.state       ][INFO    ][10122] Executing state rabbitmq_policy.present for Ceilometer
2018-04-20 19:12:32,687 [salt.loaded.int.module.cmdmod][INFO    ][10122] Executing command ['rabbitmqctl', 'list_policies', '-p', '/openstack'] as user 'root' in directory '/root'
2018-04-20 19:12:32,800 [salt.minion      ][INFO    ][2025] User sudo_ubuntu Executing command saltutil.find_job with jid 20180420191232785333
2018-04-20 19:12:32,816 [salt.minion      ][INFO    ][14115] Starting a new job with PID 14115
2018-04-20 19:12:32,836 [salt.minion      ][INFO    ][14115] Returning information for job: 20180420191232785333
2018-04-20 19:12:33,794 [salt.loaded.int.module.cmdmod][INFO    ][10122] 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-20 19:12:34,924 [salt.state       ][INFO    ][10122] {'new': 'Ceilometer', 'old': {}}
2018-04-20 19:12:34,925 [salt.state       ][INFO    ][10122] Completed state [Ceilometer] at time 19:12:34.925169 duration_in_ms=2239.547
2018-04-20 19:12:34,926 [salt.state       ][INFO    ][10122] Running state [HA] at time 19:12:34.926699
2018-04-20 19:12:34,927 [salt.state       ][INFO    ][10122] Executing state rabbitmq_policy.present for HA
2018-04-20 19:12:34,930 [salt.loaded.int.module.cmdmod][INFO    ][10122] Executing command ['rabbitmqctl', 'list_policies', '-p', '/openstack'] as user 'root' in directory '/root'
2018-04-20 19:12:36,059 [salt.loaded.int.module.cmdmod][INFO    ][10122] Executing command ['rabbitmqctl', 'set_policy', '-p', '/openstack', 'HA', '^(?!amq\\.).*', '{"ha-mode": "all", "message-ttl": 120000}'] as user 'root' in directory '/root'
2018-04-20 19:12:37,205 [salt.state       ][INFO    ][10122] {'new': 'HA', 'old': {}}
2018-04-20 19:12:37,205 [salt.state       ][INFO    ][10122] Completed state [HA] at time 19:12:37.205786 duration_in_ms=2279.086
2018-04-20 19:12:37,206 [salt.state       ][INFO    ][10122] Running state [guest] at time 19:12:37.206496
2018-04-20 19:12:37,207 [salt.state       ][INFO    ][10122] Executing state rabbitmq_user.present for guest
2018-04-20 19:12:37,208 [salt.loaded.int.module.cmdmod][INFO    ][10122] Executing command ['rabbitmqctl', 'list_users'] as user 'root' in directory '/root'
2018-04-20 19:12:38,298 [salt.loaded.int.module.cmdmod][INFO    ][10122] Executing command ['rabbitmqctl', 'status'] as user 'root' in directory '/root'
2018-04-20 19:12:41,706 [salt.loaded.int.module.cmdmod][INFO    ][10122] Executing command ['rabbitmqctl', 'list_user_permissions', 'guest'] as user 'root' in directory '/root'
2018-04-20 19:12:42,831 [salt.minion      ][INFO    ][2025] User sudo_ubuntu Executing command saltutil.find_job with jid 20180420191242815282
2018-04-20 19:12:42,851 [salt.minion      ][INFO    ][16015] Starting a new job with PID 16015
2018-04-20 19:12:42,870 [salt.state       ][INFO    ][10122] Made the following changes:
'password' changed from 'absent' to 'Set password.'

2018-04-20 19:12:42,873 [salt.state       ][INFO    ][10122] Completed state [guest] at time 19:12:42.873434 duration_in_ms=5666.938
2018-04-20 19:12:42,874 [salt.state       ][INFO    ][10122] Running state [HA] at time 19:12:42.874488
2018-04-20 19:12:42,875 [salt.state       ][INFO    ][10122] Executing state rabbitmq_policy.present for HA
2018-04-20 19:12:42,876 [salt.loaded.int.module.cmdmod][INFO    ][10122] Executing command ['rabbitmqctl', 'list_policies', '-p', '/'] as user 'root' in directory '/root'
2018-04-20 19:12:42,877 [salt.minion      ][INFO    ][16015] Returning information for job: 20180420191242815282
2018-04-20 19:12:43,959 [salt.loaded.int.module.cmdmod][INFO    ][10122] Executing command ['rabbitmqctl', 'set_policy', '-p', '/', 'HA', '^(?!amq\\.).*', '{"ha-mode": "all", "message-ttl": 120000}'] as user 'root' in directory '/root'
2018-04-20 19:12:45,059 [salt.state       ][INFO    ][10122] {'new': 'HA', 'old': {}}
2018-04-20 19:12:45,061 [salt.state       ][INFO    ][10122] Completed state [HA] at time 19:12:45.061637 duration_in_ms=2187.148
2018-04-20 19:12:45,062 [salt.state       ][INFO    ][10122] Running state [admin] at time 19:12:45.062791
2018-04-20 19:12:45,063 [salt.state       ][INFO    ][10122] Executing state rabbitmq_user.present for admin
2018-04-20 19:12:45,065 [salt.loaded.int.module.cmdmod][INFO    ][10122] Executing command ['rabbitmqctl', 'list_users'] as user 'root' in directory '/root'
2018-04-20 19:12:47,271 [salt.loaded.int.module.cmdmod][INFO    ][10122] Executing command ['rabbitmqctl', 'list_users'] as user 'root' in directory '/root'
2018-04-20 19:12:48,368 [salt.loaded.int.module.cmdmod][INFO    ][10122] Executing command ['rabbitmqctl', 'set_user_tags', 'admin', 'administrator'] as user 'root' in directory '/root'
2018-04-20 19:12:49,466 [salt.loaded.int.module.cmdmod][INFO    ][10122] Executing command ['rabbitmqctl', 'list_user_permissions', 'admin'] as user 'root' in directory '/root'
2018-04-20 19:12:50,580 [salt.loaded.int.module.cmdmod][INFO    ][10122] Executing command ['rabbitmqctl', 'set_permissions', '-p', '/openstack', 'admin', '.*', '.*', '.*'] as user 'root' in directory '/root'
2018-04-20 19:12:51,673 [salt.loaded.int.module.cmdmod][INFO    ][10122] Executing command ['rabbitmqctl', 'set_permissions', '-p', '/', 'admin', '.*', '.*', '.*'] as user 'root' in directory '/root'
2018-04-20 19:12:52,739 [salt.state       ][INFO    ][10122] Made the following changes:
'perms' changed from 'absent' to '{'/openstack': ['.*', '.*', '.*'], '/': ['.*', '.*', '.*']}'
'user' changed from 'absent' to 'admin'
'tags' changed from '['']' to '['administrator']'

2018-04-20 19:12:52,739 [salt.state       ][INFO    ][10122] Completed state [admin] at time 19:12:52.739563 duration_in_ms=7676.771
2018-04-20 19:12:52,740 [salt.state       ][INFO    ][10122] Running state [rabbitmqctl set_cluster_name openstack && echo "openstack" > /var/lib/rabbitmq/.cluster_name
] at time 19:12:52.740737
2018-04-20 19:12:52,741 [salt.state       ][INFO    ][10122] Executing state cmd.run for rabbitmqctl set_cluster_name openstack && echo "openstack" > /var/lib/rabbitmq/.cluster_name

2018-04-20 19:12:52,742 [salt.loaded.int.module.cmdmod][INFO    ][10122] Executing command 'rabbitmqctl set_cluster_name openstack && echo "openstack" > /var/lib/rabbitmq/.cluster_name
' in directory '/root'
2018-04-20 19:12:52,878 [salt.minion      ][INFO    ][2025] User sudo_ubuntu Executing command saltutil.find_job with jid 20180420191252855618
2018-04-20 19:12:52,893 [salt.minion      ][INFO    ][18074] Starting a new job with PID 18074
2018-04-20 19:12:52,911 [salt.minion      ][INFO    ][18074] Returning information for job: 20180420191252855618
2018-04-20 19:12:53,734 [salt.state       ][INFO    ][10122] {'pid': 17949, 'retcode': 0, 'stderr': '', 'stdout': 'Setting cluster name to openstack'}
2018-04-20 19:12:53,735 [salt.state       ][INFO    ][10122] Completed state [rabbitmqctl set_cluster_name openstack && echo "openstack" > /var/lib/rabbitmq/.cluster_name
] at time 19:12:53.735430 duration_in_ms=994.692
2018-04-20 19:12:53,739 [salt.minion      ][INFO    ][10122] Returning information for job: 20180420191020693696
2018-04-20 19:12:54,510 [salt.minion      ][INFO    ][2025] User sudo_ubuntu Executing command state.sls with jid 20180420191254495975
2018-04-20 19:12:54,523 [salt.minion      ][INFO    ][18153] Starting a new job with PID 18153
2018-04-20 19:12:57,007 [salt.state       ][INFO    ][18153] Loading fresh modules for state activity
2018-04-20 19:12:57,188 [salt.loaded.int.module.cmdmod][INFO    ][18153] Executing command 'cat /var/lib/rabbitmq/.erlang.cookie' in directory '/root'
2018-04-20 19:12:58,089 [salt.state       ][INFO    ][18153] Running state [rabbitmq-server] at time 19:12:58.089617
2018-04-20 19:12:58,090 [salt.state       ][INFO    ][18153] Executing state pkg.installed for rabbitmq-server
2018-04-20 19:12:58,091 [salt.loaded.int.module.cmdmod][INFO    ][18153] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2018-04-20 19:12:58,457 [salt.state       ][INFO    ][18153] All specified packages are already installed
2018-04-20 19:12:58,458 [salt.state       ][INFO    ][18153] Completed state [rabbitmq-server] at time 19:12:58.458846 duration_in_ms=369.228
2018-04-20 19:12:58,463 [salt.state       ][INFO    ][18153] Running state [/etc/rabbitmq/rabbitmq.config] at time 19:12:58.463550
2018-04-20 19:12:58,464 [salt.state       ][INFO    ][18153] Executing state file.managed for /etc/rabbitmq/rabbitmq.config
2018-04-20 19:12:58,559 [salt.state       ][INFO    ][18153] File /etc/rabbitmq/rabbitmq.config is in the correct state
2018-04-20 19:12:58,559 [salt.state       ][INFO    ][18153] Completed state [/etc/rabbitmq/rabbitmq.config] at time 19:12:58.559719 duration_in_ms=96.169
2018-04-20 19:12:58,560 [salt.state       ][INFO    ][18153] Running state [/etc/default/rabbitmq-server] at time 19:12:58.560323
2018-04-20 19:12:58,560 [salt.state       ][INFO    ][18153] Executing state file.managed for /etc/default/rabbitmq-server
2018-04-20 19:12:58,619 [salt.state       ][INFO    ][18153] File /etc/default/rabbitmq-server is in the correct state
2018-04-20 19:12:58,619 [salt.state       ][INFO    ][18153] Completed state [/etc/default/rabbitmq-server] at time 19:12:58.619722 duration_in_ms=59.399
2018-04-20 19:12:58,620 [salt.state       ][INFO    ][18153] Running state [/etc/systemd/system/rabbitmq-server.service.d/limits.conf] at time 19:12:58.620084
2018-04-20 19:12:58,620 [salt.state       ][INFO    ][18153] Executing state file.managed for /etc/systemd/system/rabbitmq-server.service.d/limits.conf
2018-04-20 19:12:58,678 [salt.state       ][INFO    ][18153] File /etc/systemd/system/rabbitmq-server.service.d/limits.conf is in the correct state
2018-04-20 19:12:58,678 [salt.state       ][INFO    ][18153] Completed state [/etc/systemd/system/rabbitmq-server.service.d/limits.conf] at time 19:12:58.678663 duration_in_ms=58.579
2018-04-20 19:12:58,679 [salt.state       ][INFO    ][18153] Running state [rabbitmq-server] at time 19:12:58.679813
2018-04-20 19:12:58,680 [salt.state       ][INFO    ][18153] Executing state service.running for rabbitmq-server
2018-04-20 19:12:58,680 [salt.loaded.int.module.cmdmod][INFO    ][18153] Executing command ['systemctl', 'status', 'rabbitmq-server.service', '-n', '0'] in directory '/root'
2018-04-20 19:12:58,719 [salt.loaded.int.module.cmdmod][INFO    ][18153] Executing command ['systemctl', 'is-active', 'rabbitmq-server.service'] in directory '/root'
2018-04-20 19:12:58,737 [salt.loaded.int.module.cmdmod][INFO    ][18153] Executing command ['systemctl', 'is-enabled', 'rabbitmq-server.service'] in directory '/root'
2018-04-20 19:12:58,757 [salt.state       ][INFO    ][18153] The service rabbitmq-server is already running
2018-04-20 19:12:58,758 [salt.state       ][INFO    ][18153] Completed state [rabbitmq-server] at time 19:12:58.758032 duration_in_ms=78.218
2018-04-20 19:12:58,762 [salt.state       ][INFO    ][18153] Running state [amqp_client] at time 19:12:58.762301
2018-04-20 19:12:58,762 [salt.state       ][INFO    ][18153] Executing state rabbitmq_plugin.enabled for amqp_client
2018-04-20 19:12:58,764 [salt.loaded.int.module.cmdmod][INFO    ][18153] Executing command ['/usr/sbin/rabbitmq-plugins', 'list', '-m', '-e'] as user 'root' in directory '/root'
2018-04-20 19:12:59,859 [salt.state       ][INFO    ][18153] Plugin 'amqp_client' is already enabled.
2018-04-20 19:12:59,860 [salt.state       ][INFO    ][18153] Completed state [amqp_client] at time 19:12:59.860337 duration_in_ms=1098.035
2018-04-20 19:12:59,861 [salt.state       ][INFO    ][18153] Running state [rabbitmq_management] at time 19:12:59.861480
2018-04-20 19:12:59,862 [salt.state       ][INFO    ][18153] Executing state rabbitmq_plugin.enabled for rabbitmq_management
2018-04-20 19:12:59,863 [salt.loaded.int.module.cmdmod][INFO    ][18153] Executing command ['/usr/sbin/rabbitmq-plugins', 'list', '-m', '-e'] as user 'root' in directory '/root'
2018-04-20 19:13:01,016 [salt.state       ][INFO    ][18153] Plugin 'rabbitmq_management' is already enabled.
2018-04-20 19:13:01,018 [salt.state       ][INFO    ][18153] Completed state [rabbitmq_management] at time 19:13:01.018007 duration_in_ms=1156.526
2018-04-20 19:13:01,022 [salt.state       ][INFO    ][18153] Running state [/openstack] at time 19:13:01.022456
2018-04-20 19:13:01,023 [salt.state       ][INFO    ][18153] Executing state rabbitmq_vhost.present for /openstack
2018-04-20 19:13:01,024 [salt.loaded.int.module.cmdmod][INFO    ][18153] Executing command 'rabbitmqctl list_vhosts -q' as user 'root' in directory '/root'
2018-04-20 19:13:02,069 [salt.state       ][INFO    ][18153] Virtual Host '/openstack' already exists.
2018-04-20 19:13:02,070 [salt.state       ][INFO    ][18153] Completed state [/openstack] at time 19:13:02.070037 duration_in_ms=1047.579
2018-04-20 19:13:02,073 [salt.state       ][INFO    ][18153] Running state [openstack] at time 19:13:02.073391
2018-04-20 19:13:02,073 [salt.state       ][INFO    ][18153] Executing state rabbitmq_user.present for openstack
2018-04-20 19:13:02,074 [salt.loaded.int.module.cmdmod][INFO    ][18153] Executing command ['rabbitmqctl', 'list_users'] as user 'root' in directory '/root'
2018-04-20 19:13:03,173 [salt.loaded.int.module.cmdmod][INFO    ][18153] Executing command ['rabbitmqctl', 'status'] as user 'root' in directory '/root'
2018-04-20 19:13:04,610 [salt.minion      ][INFO    ][2025] User sudo_ubuntu Executing command saltutil.find_job with jid 20180420191304592566
2018-04-20 19:13:04,626 [salt.minion      ][INFO    ][19365] Starting a new job with PID 19365
2018-04-20 19:13:04,644 [salt.minion      ][INFO    ][19365] Returning information for job: 20180420191304592566
2018-04-20 19:13:06,491 [salt.loaded.int.module.cmdmod][INFO    ][18153] Executing command ['rabbitmqctl', 'list_user_permissions', 'openstack'] as user 'root' in directory '/root'
2018-04-20 19:13:07,628 [salt.state       ][INFO    ][18153] Made the following changes:
'password' changed from 'absent' to 'Set password.'

2018-04-20 19:13:07,629 [salt.state       ][INFO    ][18153] Completed state [openstack] at time 19:13:07.629780 duration_in_ms=5556.389
2018-04-20 19:13:07,633 [salt.state       ][INFO    ][18153] Running state [Ceilometer] at time 19:13:07.633789
2018-04-20 19:13:07,634 [salt.state       ][INFO    ][18153] Executing state rabbitmq_policy.present for Ceilometer
2018-04-20 19:13:07,635 [salt.loaded.int.module.cmdmod][INFO    ][18153] Executing command ['rabbitmqctl', 'list_policies', '-p', '/openstack'] as user 'root' in directory '/root'
2018-04-20 19:13:08,761 [salt.loaded.int.module.cmdmod][INFO    ][18153] 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-20 19:13:09,904 [salt.state       ][INFO    ][18153] {'new': ['Definition'], 'old': {'apply_to': 'all', 'priority': '10', 'definition': '{"ha-mode":"all","message-ttl":10800000}', 'pattern': '^metering.sample$'}}
2018-04-20 19:13:09,905 [salt.state       ][INFO    ][18153] Completed state [Ceilometer] at time 19:13:09.905485 duration_in_ms=2271.695
2018-04-20 19:13:09,906 [salt.state       ][INFO    ][18153] Running state [HA] at time 19:13:09.906477
2018-04-20 19:13:09,906 [salt.state       ][INFO    ][18153] Executing state rabbitmq_policy.present for HA
2018-04-20 19:13:09,908 [salt.loaded.int.module.cmdmod][INFO    ][18153] Executing command ['rabbitmqctl', 'list_policies', '-p', '/openstack'] as user 'root' in directory '/root'
2018-04-20 19:13:11,019 [salt.loaded.int.module.cmdmod][INFO    ][18153] Executing command ['rabbitmqctl', 'set_policy', '-p', '/openstack', 'HA', '^(?!amq\\.).*', '{"ha-mode": "all", "message-ttl": 120000}'] as user 'root' in directory '/root'
2018-04-20 19:13:12,098 [salt.state       ][INFO    ][18153] {'new': ['Pattern', 'Definition'], 'old': {'apply_to': 'all', 'priority': '0', 'definition': '{"ha-mode":"all","message-ttl":120000}', 'pattern': '^(?!amq\\\\.).*'}}
2018-04-20 19:13:12,098 [salt.state       ][INFO    ][18153] Completed state [HA] at time 19:13:12.098736 duration_in_ms=2192.258
2018-04-20 19:13:12,099 [salt.state       ][INFO    ][18153] Running state [guest] at time 19:13:12.099302
2018-04-20 19:13:12,099 [salt.state       ][INFO    ][18153] Executing state rabbitmq_user.present for guest
2018-04-20 19:13:12,100 [salt.loaded.int.module.cmdmod][INFO    ][18153] Executing command ['rabbitmqctl', 'list_users'] as user 'root' in directory '/root'
2018-04-20 19:13:13,200 [salt.loaded.int.module.cmdmod][INFO    ][18153] Executing command ['rabbitmqctl', 'status'] as user 'root' in directory '/root'
2018-04-20 19:13:14,834 [salt.minion      ][INFO    ][2025] User sudo_ubuntu Executing command saltutil.find_job with jid 20180420191314819814
2018-04-20 19:13:14,850 [salt.minion      ][INFO    ][21302] Starting a new job with PID 21302
2018-04-20 19:13:14,871 [salt.minion      ][INFO    ][21302] Returning information for job: 20180420191314819814
2018-04-20 19:13:16,576 [salt.loaded.int.module.cmdmod][INFO    ][18153] Executing command ['rabbitmqctl', 'list_user_permissions', 'guest'] as user 'root' in directory '/root'
2018-04-20 19:13:17,720 [salt.state       ][INFO    ][18153] Made the following changes:
'password' changed from 'absent' to 'Set password.'

2018-04-20 19:13:17,721 [salt.state       ][INFO    ][18153] Completed state [guest] at time 19:13:17.721368 duration_in_ms=5622.065
2018-04-20 19:13:17,722 [salt.state       ][INFO    ][18153] Running state [HA] at time 19:13:17.722182
2018-04-20 19:13:17,722 [salt.state       ][INFO    ][18153] Executing state rabbitmq_policy.present for HA
2018-04-20 19:13:17,723 [salt.loaded.int.module.cmdmod][INFO    ][18153] Executing command ['rabbitmqctl', 'list_policies', '-p', '/'] as user 'root' in directory '/root'
2018-04-20 19:13:18,796 [salt.loaded.int.module.cmdmod][INFO    ][18153] Executing command ['rabbitmqctl', 'set_policy', '-p', '/', 'HA', '^(?!amq\\.).*', '{"ha-mode": "all", "message-ttl": 120000}'] as user 'root' in directory '/root'
2018-04-20 19:13:19,882 [salt.state       ][INFO    ][18153] {'new': ['Pattern', 'Definition'], 'old': {'apply_to': 'all', 'priority': '0', 'definition': '{"ha-mode":"all","message-ttl":120000}', 'pattern': '^(?!amq\\\\.).*'}}
2018-04-20 19:13:19,886 [salt.state       ][INFO    ][18153] Completed state [HA] at time 19:13:19.885321 duration_in_ms=2163.139
2018-04-20 19:13:19,887 [salt.state       ][INFO    ][18153] Running state [admin] at time 19:13:19.887753
2018-04-20 19:13:19,888 [salt.state       ][INFO    ][18153] Executing state rabbitmq_user.present for admin
2018-04-20 19:13:19,889 [salt.loaded.int.module.cmdmod][INFO    ][18153] Executing command ['rabbitmqctl', 'list_users'] as user 'root' in directory '/root'
2018-04-20 19:13:21,037 [salt.loaded.int.module.cmdmod][INFO    ][18153] Executing command ['rabbitmqctl', 'status'] as user 'root' in directory '/root'
2018-04-20 19:13:24,358 [salt.loaded.int.module.cmdmod][INFO    ][18153] Executing command ['rabbitmqctl', 'list_users'] as user 'root' in directory '/root'
2018-04-20 19:13:25,066 [salt.minion      ][INFO    ][2025] User sudo_ubuntu Executing command saltutil.find_job with jid 20180420191325041006
2018-04-20 19:13:25,082 [salt.minion      ][INFO    ][23213] Starting a new job with PID 23213
2018-04-20 19:13:25,102 [salt.minion      ][INFO    ][23213] Returning information for job: 20180420191325041006
2018-04-20 19:13:25,481 [salt.loaded.int.module.cmdmod][INFO    ][18153] Executing command ['rabbitmqctl', 'list_user_permissions', 'admin'] as user 'root' in directory '/root'
2018-04-20 19:13:26,582 [salt.state       ][INFO    ][18153] Made the following changes:
'password' changed from 'absent' to 'Set password.'

2018-04-20 19:13:26,585 [salt.state       ][INFO    ][18153] Completed state [admin] at time 19:13:26.583841 duration_in_ms=6696.088
2018-04-20 19:13:26,589 [salt.state       ][INFO    ][18153] Running state [rabbitmqctl set_cluster_name openstack && echo "openstack" > /var/lib/rabbitmq/.cluster_name
] at time 19:13:26.589437
2018-04-20 19:13:26,589 [salt.state       ][INFO    ][18153] Executing state cmd.run for rabbitmqctl set_cluster_name openstack && echo "openstack" > /var/lib/rabbitmq/.cluster_name

2018-04-20 19:13:26,590 [salt.state       ][INFO    ][18153] /var/lib/rabbitmq/.cluster_name exists
2018-04-20 19:13:26,590 [salt.state       ][INFO    ][18153] Completed state [rabbitmqctl set_cluster_name openstack && echo "openstack" > /var/lib/rabbitmq/.cluster_name
] at time 19:13:26.590897 duration_in_ms=1.461
2018-04-20 19:13:26,593 [salt.minion      ][INFO    ][18153] Returning information for job: 20180420191254495975
2018-04-20 19:15:23,413 [salt.minion      ][INFO    ][2025] User sudo_ubuntu Executing command cmd.run with jid 20180420191523399480
2018-04-20 19:15:23,432 [salt.minion      ][INFO    ][23511] Starting a new job with PID 23511
2018-04-20 19:15:23,441 [salt.loader.192.168.11.2.int.module.cmdmod][INFO    ][23511] Executing command 'rabbitmqctl cluster_status' in directory '/root'
2018-04-20 19:15:24,512 [salt.minion      ][INFO    ][23511] Returning information for job: 20180420191523399480
2018-04-20 19:19:42,119 [salt.minion      ][INFO    ][2025] User sudo_ubuntu Executing command state.sls with jid 20180420191942108575
2018-04-20 19:19:42,140 [salt.minion      ][INFO    ][23775] Starting a new job with PID 23775
2018-04-20 19:19:43,369 [salt.state       ][INFO    ][23775] Loading fresh modules for state activity
2018-04-20 19:19:43,418 [salt.fileclient  ][INFO    ][23775] Fetching file from saltenv 'base', ** done ** 'haproxy/init.sls'
2018-04-20 19:19:43,444 [salt.fileclient  ][INFO    ][23775] Fetching file from saltenv 'base', ** done ** 'haproxy/proxy.sls'
2018-04-20 19:19:44,057 [salt.state       ][INFO    ][23775] Running state [haproxy] at time 19:19:44.057177
2018-04-20 19:19:44,058 [salt.state       ][INFO    ][23775] Executing state pkg.installed for haproxy
2018-04-20 19:19:44,058 [salt.loaded.int.module.cmdmod][INFO    ][23775] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2018-04-20 19:19:44,472 [salt.loaded.int.module.cmdmod][INFO    ][23775] Executing command ['apt-cache', '-q', 'policy', 'haproxy'] in directory '/root'
2018-04-20 19:19:44,558 [salt.loaded.int.module.cmdmod][INFO    ][23775] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2018-04-20 19:19:46,626 [salt.loaded.int.module.cmdmod][INFO    ][23775] Executing command ['dpkg', '--get-selections', '*'] in directory '/root'
2018-04-20 19:19:46,653 [salt.loaded.int.module.cmdmod][INFO    ][23775] 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-20 19:19:49,939 [salt.loaded.int.module.cmdmod][INFO    ][23775] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2018-04-20 19:19:49,982 [salt.state       ][INFO    ][23775] 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-20 19:19:50,007 [salt.state       ][INFO    ][23775] Loading fresh modules for state activity
2018-04-20 19:19:50,043 [salt.state       ][INFO    ][23775] Completed state [haproxy] at time 19:19:50.043006 duration_in_ms=5985.829
2018-04-20 19:19:50,047 [salt.state       ][INFO    ][23775] Running state [/etc/default/haproxy] at time 19:19:50.047422
2018-04-20 19:19:50,047 [salt.state       ][INFO    ][23775] Executing state file.managed for /etc/default/haproxy
2018-04-20 19:19:50,081 [salt.fileclient  ][INFO    ][23775] Fetching file from saltenv 'base', ** done ** 'haproxy/files/haproxy.default'
2018-04-20 19:19:50,085 [salt.state       ][INFO    ][23775] 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-20 19:19:50,089 [salt.state       ][INFO    ][23775] Completed state [/etc/default/haproxy] at time 19:19:50.089402 duration_in_ms=41.98
2018-04-20 19:19:50,090 [salt.state       ][INFO    ][23775] Running state [/etc/haproxy/haproxy.cfg] at time 19:19:50.089985
2018-04-20 19:19:50,090 [salt.state       ][INFO    ][23775] Executing state file.managed for /etc/haproxy/haproxy.cfg
2018-04-20 19:19:50,113 [salt.fileclient  ][INFO    ][23775] Fetching file from saltenv 'base', ** done ** 'haproxy/files/haproxy.cfg'
2018-04-20 19:19:50,301 [salt.state       ][INFO    ][23775] File changed:
--- 
+++ 
@@ -1,35 +1,49 @@
 global
-	log /dev/log	local0
-	log /dev/log	local1 notice
-	chroot /var/lib/haproxy
-	stats socket /run/haproxy/admin.sock mode 660 level admin
-	stats timeout 30s
-	user haproxy
-	group haproxy
-	daemon
-
-	# Default SSL material locations
-	ca-base /etc/ssl/certs
-	crt-base /etc/ssl/private
-
-	# Default ciphers to use on SSL-enabled listening sockets.
-	# For more information, see ciphers(1SSL). This list is from:
-	#  https://hynek.me/articles/hardening-your-web-servers-ssl-ciphers/
-	ssl-default-bind-ciphers ECDH+AESGCM:DH+AESGCM:ECDH+AES256:DH+AES256:ECDH+AES128:DH+AES:ECDH+3DES:DH+3DES:RSA+AESGCM:RSA+AES:RSA+3DES:!aNULL:!MD5:!DSS
-	ssl-default-bind-options no-sslv3
+  log /dev/log  local0
+  log /dev/log  local1 notice
+  chroot /var/lib/haproxy
+  stats  socket /run/haproxy/admin.sock mode 660 level admin
+  stats timeout 30s
+  user  haproxy
+  group haproxy
+  daemon
+  pidfile  /var/run/haproxy.pid
+  spread-checks 4
+  tune.maxrewrite 1024
+  tune.bufsize 32768
+  maxconn  16000
+  # SSL options
+  ca-base /etc/haproxy/ssl
+  crt-base /etc/haproxy/ssl
+  tune.ssl.default-dh-param 2048
+  ssl-default-bind-ciphers ECDHE-ECDSA-CHACHA20-POLY1305:ECDHE-RSA-CHACHA20-POLY1305:ECDHE-ECDSA-AES128-GCM-SHA256:ECDHE-RSA-AES128-GCM-SHA256:ECDHE-ECDSA-AES256-GCM-SHA384:ECDHE-RSA-AES256-GCM-SHA384:DHE-RSA-AES128-GCM-SHA256:DHE-RSA-AES256-GCM-SHA384:ECDHE-ECDSA-AES128-SHA256:ECDHE-RSA-AES128-SHA256:ECDHE-ECDSA-AES128-SHA:ECDHE-RSA-AES256-SHA384:ECDHE-RSA-AES128-SHA:ECDHE-ECDSA-AES256-SHA384:ECDHE-ECDSA-AES256-SHA:ECDHE-RSA-AES256-SHA:DHE-RSA-AES128-SHA256:DHE-RSA-AES128-SHA:DHE-RSA-AES256-SHA256:DHE-RSA-AES256-SHA:ECDHE-ECDSA-DES-CBC3-SHA:ECDHE-RSA-DES-CBC3-SHA:EDH-RSA-DES-CBC3-SHA:AES128-GCM-SHA256:AES256-GCM-SHA384:AES128-SHA256:AES256-SHA256:AES128-SHA:AES256-SHA:DES-CBC3-SHA:!DSS
+  ssl-default-bind-options no-sslv3 no-tls-tickets
+  ssl-default-server-ciphers ECDHE-ECDSA-CHACHA20-POLY1305:ECDHE-RSA-CHACHA20-POLY1305:ECDHE-ECDSA-AES128-GCM-SHA256:ECDHE-RSA-AES128-GCM-SHA256:ECDHE-ECDSA-AES256-GCM-SHA384:ECDHE-RSA-AES256-GCM-SHA384:DHE-RSA-AES128-GCM-SHA256:DHE-RSA-AES256-GCM-SHA384:ECDHE-ECDSA-AES128-SHA256:ECDHE-RSA-AES128-SHA256:ECDHE-ECDSA-AES128-SHA:ECDHE-RSA-AES256-SHA384:ECDHE-RSA-AES128-SHA:ECDHE-ECDSA-AES256-SHA384:ECDHE-ECDSA-AES256-SHA:ECDHE-RSA-AES256-SHA:DHE-RSA-AES128-SHA256:DHE-RSA-AES128-SHA:DHE-RSA-AES256-SHA256:DHE-RSA-AES256-SHA:ECDHE-ECDSA-DES-CBC3-SHA:ECDHE-RSA-DES-CBC3-SHA:EDH-RSA-DES-CBC3-SHA:AES128-GCM-SHA256:AES256-GCM-SHA384:AES128-SHA256:AES256-SHA256:AES128-SHA:AES256-SHA:DES-CBC3-SHA:!DSS
+  ssl-default-server-options no-sslv3 no-tls-tickets
 
 defaults
-	log	global
-	mode	http
-	option	httplog
-	option	dontlognull
-        timeout connect 5000
-        timeout client  50000
-        timeout server  50000
-	errorfile 400 /etc/haproxy/errors/400.http
-	errorfile 403 /etc/haproxy/errors/403.http
-	errorfile 408 /etc/haproxy/errors/408.http
-	errorfile 500 /etc/haproxy/errors/500.http
-	errorfile 502 /etc/haproxy/errors/502.http
-	errorfile 503 /etc/haproxy/errors/503.http
-	errorfile 504 /etc/haproxy/errors/504.http
+  log  global
+  mode http
+
+  maxconn 8000
+  option  redispatch
+  retries  3
+  stats  enable
+
+  timeout http-request 10s
+  timeout queue 1m
+  timeout connect 10s
+  timeout client 1m
+  timeout server 1m
+  timeout check 10s
+
+listen rabbitmq_cluster
+  bind 192.168.10.27:5672 
+  balance roundrobin
+  mode tcp
+  option tcpka
+  timeout client 300s
+  timeout server 300s
+  server msg01 192.168.10.28:5672 check inter 5000 rise 2 fall 3
+  server msg02 192.168.10.29:5672 backup check inter 5000 rise 2 fall 3
+  server msg03 192.168.10.30:5672 backup check inter 5000 rise 2 fall 3

2018-04-20 19:19:50,303 [salt.state       ][INFO    ][23775] Completed state [/etc/haproxy/haproxy.cfg] at time 19:19:50.302969 duration_in_ms=212.984
2018-04-20 19:19:50,303 [salt.state       ][INFO    ][23775] Running state [/etc/haproxy/ssl] at time 19:19:50.303340
2018-04-20 19:19:50,303 [salt.state       ][INFO    ][23775] Executing state file.directory for /etc/haproxy/ssl
2018-04-20 19:19:50,305 [salt.state       ][INFO    ][23775] {'/etc/haproxy/ssl': 'New Dir'}
2018-04-20 19:19:50,305 [salt.state       ][INFO    ][23775] Completed state [/etc/haproxy/ssl] at time 19:19:50.305651 duration_in_ms=2.311
2018-04-20 19:19:50,306 [salt.state       ][INFO    ][23775] Running state [/etc/haproxy/errors/429.http11] at time 19:19:50.306267
2018-04-20 19:19:50,306 [salt.state       ][INFO    ][23775] Executing state file.managed for /etc/haproxy/errors/429.http11
2018-04-20 19:19:50,333 [salt.fileclient  ][INFO    ][23775] Fetching file from saltenv 'base', ** done ** 'haproxy/files/errors/429.http11'
2018-04-20 19:19:50,335 [salt.state       ][INFO    ][23775] File changed:
New file
2018-04-20 19:19:50,336 [salt.state       ][INFO    ][23775] Completed state [/etc/haproxy/errors/429.http11] at time 19:19:50.336290 duration_in_ms=30.023
2018-04-20 19:19:50,337 [salt.state       ][INFO    ][23775] Running state [haproxy_status_packages] at time 19:19:50.337207
2018-04-20 19:19:50,337 [salt.state       ][INFO    ][23775] Executing state pkg.installed for haproxy_status_packages
2018-04-20 19:19:50,731 [salt.state       ][INFO    ][23775] All specified packages are already installed
2018-04-20 19:19:50,731 [salt.state       ][INFO    ][23775] Completed state [haproxy_status_packages] at time 19:19:50.731541 duration_in_ms=394.333
2018-04-20 19:19:50,732 [salt.state       ][INFO    ][23775] Running state [/usr/bin/haproxy-status.sh] at time 19:19:50.732911
2018-04-20 19:19:50,733 [salt.state       ][INFO    ][23775] Executing state file.managed for /usr/bin/haproxy-status.sh
2018-04-20 19:19:50,754 [salt.fileclient  ][INFO    ][23775] Fetching file from saltenv 'base', ** done ** 'haproxy/files/haproxy-status.sh'
2018-04-20 19:19:50,786 [salt.state       ][INFO    ][23775] File changed:
New file
2018-04-20 19:19:50,786 [salt.state       ][INFO    ][23775] Completed state [/usr/bin/haproxy-status.sh] at time 19:19:50.786461 duration_in_ms=53.55
2018-04-20 19:19:50,787 [salt.state       ][INFO    ][23775] Running state [net.ipv4.ip_nonlocal_bind] at time 19:19:50.787141
2018-04-20 19:19:50,787 [salt.state       ][INFO    ][23775] Executing state sysctl.present for net.ipv4.ip_nonlocal_bind
2018-04-20 19:19:50,788 [salt.loaded.int.module.cmdmod][INFO    ][23775] Executing command 'sysctl -a' in directory '/root'
2018-04-20 19:19:50,824 [salt.loaded.int.module.cmdmod][INFO    ][23775] Executing command 'sysctl -w net.ipv4.ip_nonlocal_bind="1"' in directory '/root'
2018-04-20 19:19:50,840 [salt.state       ][INFO    ][23775] {'net.ipv4.ip_nonlocal_bind': 1}
2018-04-20 19:19:50,840 [salt.state       ][INFO    ][23775] Completed state [net.ipv4.ip_nonlocal_bind] at time 19:19:50.840892 duration_in_ms=53.75
2018-04-20 19:19:50,843 [salt.state       ][INFO    ][23775] Running state [haproxy] at time 19:19:50.842979
2018-04-20 19:19:50,843 [salt.state       ][INFO    ][23775] Executing state service.running for haproxy
2018-04-20 19:19:50,844 [salt.loaded.int.module.cmdmod][INFO    ][23775] Executing command ['systemctl', 'status', 'haproxy.service', '-n', '0'] in directory '/root'
2018-04-20 19:19:50,863 [salt.loaded.int.module.cmdmod][INFO    ][23775] Executing command ['systemctl', 'is-active', 'haproxy.service'] in directory '/root'
2018-04-20 19:19:50,881 [salt.loaded.int.module.cmdmod][INFO    ][23775] Executing command ['systemctl', 'is-enabled', 'haproxy.service'] in directory '/root'
2018-04-20 19:19:50,898 [salt.state       ][INFO    ][23775] The service haproxy is already running
2018-04-20 19:19:50,898 [salt.state       ][INFO    ][23775] Completed state [haproxy] at time 19:19:50.898584 duration_in_ms=55.604
2018-04-20 19:19:50,899 [salt.state       ][INFO    ][23775] Running state [haproxy] at time 19:19:50.898974
2018-04-20 19:19:50,899 [salt.state       ][INFO    ][23775] Executing state service.mod_watch for haproxy
2018-04-20 19:19:50,900 [salt.loaded.int.module.cmdmod][INFO    ][23775] Executing command ['systemctl', 'is-active', 'haproxy.service'] in directory '/root'
2018-04-20 19:19:50,921 [salt.loaded.int.module.cmdmod][INFO    ][23775] Executing command ['systemctl', 'is-enabled', 'haproxy.service'] in directory '/root'
2018-04-20 19:19:50,943 [salt.loaded.int.module.cmdmod][INFO    ][23775] Executing command ['systemd-run', '--scope', 'systemctl', 'restart', 'haproxy.service'] in directory '/root'
2018-04-20 19:19:51,029 [salt.state       ][INFO    ][23775] {'haproxy': True}
2018-04-20 19:19:51,030 [salt.state       ][INFO    ][23775] Completed state [haproxy] at time 19:19:51.030606 duration_in_ms=131.632
2018-04-20 19:19:51,033 [salt.minion      ][INFO    ][23775] Returning information for job: 20180420191942108575
2018-04-20 19:19:55,183 [salt.minion      ][INFO    ][2025] User sudo_ubuntu Executing command service.status with jid 20180420191955163294
2018-04-20 19:19:55,199 [salt.minion      ][INFO    ][24700] Starting a new job with PID 24700
2018-04-20 19:19:55,666 [salt.loader.192.168.11.2.int.module.cmdmod][INFO    ][24700] Executing command ['systemctl', 'status', 'haproxy.service', '-n', '0'] in directory '/root'
2018-04-20 19:19:55,686 [salt.loader.192.168.11.2.int.module.cmdmod][INFO    ][24700] Executing command ['systemctl', 'is-active', 'haproxy.service'] in directory '/root'
2018-04-20 19:19:55,705 [salt.minion      ][INFO    ][24700] Returning information for job: 20180420191955163294
2018-04-20 19:19:56,739 [salt.minion      ][INFO    ][2025] User sudo_ubuntu Executing command service.restart with jid 20180420191956721582
2018-04-20 19:19:56,757 [salt.minion      ][INFO    ][24709] Starting a new job with PID 24709
2018-04-20 19:19:57,225 [salt.loader.192.168.11.2.int.module.cmdmod][INFO    ][24709] Executing command ['systemctl', 'status', 'rsyslog.service', '-n', '0'] in directory '/root'
2018-04-20 19:19:57,246 [salt.loader.192.168.11.2.int.module.cmdmod][INFO    ][24709] Executing command ['systemctl', 'is-enabled', 'rsyslog.service'] in directory '/root'
2018-04-20 19:19:57,278 [salt.loader.192.168.11.2.int.module.cmdmod][INFO    ][24709] Executing command ['systemd-run', '--scope', 'systemctl', 'restart', 'rsyslog.service'] in directory '/root'
2018-04-20 19:19:57,329 [salt.minion      ][INFO    ][24709] Returning information for job: 20180420191956721582
2018-04-20 19:49:52,982 [salt.minion      ][INFO    ][2025] User sudo_ubuntu Executing command cp.push_dir with jid 20180420194952960591
2018-04-20 19:49:53,008 [salt.minion      ][INFO    ][25162] Starting a new job with PID 25162
