2018-01-31 15:39:23,177 [salt.loaded.int.module.cmdmod][ERROR   ][1447] Command 'rabbitmqctl cluster_status' failed with return code: 127
2018-01-31 15:39:23,179 [salt.loaded.int.module.cmdmod][ERROR   ][1447] output: /bin/sh: 1: rabbitmqctl: not found
2018-01-31 15:39:23,205 [salt.loaded.int.module.cmdmod][ERROR   ][1447] Command 'rabbitmqctl cluster_status' failed with return code: 127
2018-01-31 15:39:23,207 [salt.loaded.int.module.cmdmod][ERROR   ][1447] output: /bin/sh: 1: rabbitmqctl: not found
2018-01-31 15:39:24,699 [salt.loaded.int.module.cmdmod][ERROR   ][1447] Command 'rabbitmqctl cluster_status' failed with return code: 127
2018-01-31 15:39:24,700 [salt.loaded.int.module.cmdmod][ERROR   ][1447] output: /bin/sh: 1: rabbitmqctl: not found
2018-01-31 15:39:24,723 [salt.loaded.int.module.cmdmod][ERROR   ][1447] Command 'rabbitmqctl cluster_status' failed with return code: 127
2018-01-31 15:39:24,724 [salt.loaded.int.module.cmdmod][ERROR   ][1447] output: /bin/sh: 1: rabbitmqctl: not found
2018-01-31 15:39:37,675 [salt.loaded.int.module.cmdmod][ERROR   ][1447] 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-01-31 15:39:40,396 [salt.loaded.int.module.cmdmod][INFO    ][1968] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2018-01-31 15:39:40,416 [salt.loaded.int.module.cmdmod][INFO    ][1968] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2018-01-31 15:39:40,456 [salt.loaded.int.module.cmdmod][INFO    ][1968] Executing command ['systemd-run', '--scope', 'systemctl', 'restart', 'salt-minion.service'] in directory '/root'
2018-01-31 15:39:40,503 [salt.utils.parsers][WARNING ][1215] Minion received a SIGTERM. Exiting.
2018-01-31 15:39:41,400 [salt.cli.daemons ][INFO    ][2017] Setting up the Salt Minion "msg01.baremetal-mcp-pike-odl-ha.local"
2018-01-31 15:39:41,515 [salt.cli.daemons ][INFO    ][2017] Starting up the Salt Minion
2018-01-31 15:39:41,516 [salt.utils.event ][INFO    ][2017] Starting pull socket on /var/run/salt/minion/minion_event_d600b40566_pull.ipc
2018-01-31 15:39:42,048 [salt.minion      ][INFO    ][2017] Creating minion process manager
2018-01-31 15:39:43,256 [salt.loader.192.168.11.2.int.module.cmdmod][INFO    ][2017] Executing command ['date', '+%z'] in directory '/root'
2018-01-31 15:39:43,277 [salt.utils.schedule][INFO    ][2017] Updating job settings for scheduled job: __mine_interval
2018-01-31 15:39:43,280 [salt.minion      ][INFO    ][2017] Added mine.update to scheduler
2018-01-31 15:39:43,286 [salt.minion      ][INFO    ][2017] Minion is starting as user 'root'
2018-01-31 15:39:43,301 [salt.minion      ][INFO    ][2017] Minion is ready to receive requests!
2018-01-31 15:39:44,303 [salt.utils.schedule][INFO    ][2017] Running scheduled job: __mine_interval
2018-01-31 15:39:47,412 [salt.minion      ][INFO    ][2017] User sudo_ubuntu Executing command state.apply with jid 20180131153948814523
2018-01-31 15:39:47,437 [salt.minion      ][INFO    ][2108] Starting a new job with PID 2108
2018-01-31 15:39:51,220 [salt.state       ][INFO    ][2108] Loading fresh modules for state activity
2018-01-31 15:39:52,089 [salt.fileclient  ][INFO    ][2108] Fetching file from saltenv 'base', ** done ** 'linux/init.sls'
2018-01-31 15:39:52,127 [salt.fileclient  ][INFO    ][2108] Fetching file from saltenv 'base', ** done ** 'linux/system/init.sls'
2018-01-31 15:39:52,275 [salt.fileclient  ][INFO    ][2108] Fetching file from saltenv 'base', ** done ** 'linux/system/env.sls'
2018-01-31 15:39:52,396 [salt.fileclient  ][INFO    ][2108] Fetching file from saltenv 'base', ** done ** 'linux/system/profile.sls'
2018-01-31 15:39:52,507 [salt.fileclient  ][INFO    ][2108] Fetching file from saltenv 'base', ** done ** 'linux/system/repo.sls'
2018-01-31 15:39:52,740 [salt.fileclient  ][INFO    ][2108] Fetching file from saltenv 'base', ** done ** 'linux/system/package.sls'
2018-01-31 15:39:52,874 [salt.fileclient  ][INFO    ][2108] Fetching file from saltenv 'base', ** done ** 'linux/system/timezone.sls'
2018-01-31 15:39:52,986 [salt.fileclient  ][INFO    ][2108] Fetching file from saltenv 'base', ** done ** 'linux/system/kernel.sls'
2018-01-31 15:39:53,137 [salt.fileclient  ][INFO    ][2108] Fetching file from saltenv 'base', ** done ** 'linux/system/cpu.sls'
2018-01-31 15:39:53,248 [salt.fileclient  ][INFO    ][2108] Fetching file from saltenv 'base', ** done ** 'linux/system/sysfs.sls'
2018-01-31 15:39:54,091 [salt.fileclient  ][INFO    ][2108] Fetching file from saltenv 'base', ** done ** 'linux/system/locale.sls'
2018-01-31 15:39:54,209 [salt.fileclient  ][INFO    ][2108] Fetching file from saltenv 'base', ** done ** 'linux/system/user.sls'
2018-01-31 15:39:54,339 [salt.fileclient  ][INFO    ][2108] Fetching file from saltenv 'base', ** done ** 'linux/system/group.sls'
2018-01-31 15:39:54,447 [salt.fileclient  ][INFO    ][2108] Fetching file from saltenv 'base', ** done ** 'linux/system/limit.sls'
2018-01-31 15:39:54,542 [salt.fileclient  ][INFO    ][2108] Fetching file from saltenv 'base', ** done ** 'linux/system/systemd.sls'
2018-01-31 15:39:54,653 [salt.fileclient  ][INFO    ][2108] Fetching file from saltenv 'base', ** done ** 'linux/system/apt.sls'
2018-01-31 15:39:54,785 [salt.fileclient  ][INFO    ][2108] Fetching file from saltenv 'base', ** done ** 'linux/network/init.sls'
2018-01-31 15:39:54,897 [salt.fileclient  ][INFO    ][2108] Fetching file from saltenv 'base', ** done ** 'linux/network/hostname.sls'
2018-01-31 15:39:55,005 [salt.fileclient  ][INFO    ][2108] Fetching file from saltenv 'base', ** done ** 'linux/network/host.sls'
2018-01-31 15:39:55,196 [salt.fileclient  ][INFO    ][2108] Fetching file from saltenv 'base', ** done ** 'linux/network/interface.sls'
2018-01-31 15:39:56,381 [salt.fileclient  ][INFO    ][2108] Fetching file from saltenv 'base', ** done ** 'linux/network/proxy.sls'
2018-01-31 15:39:56,498 [salt.fileclient  ][INFO    ][2108] Fetching file from saltenv 'base', ** done ** 'linux/storage/init.sls'
2018-01-31 15:39:56,901 [salt.fileclient  ][INFO    ][2108] Fetching file from saltenv 'base', ** done ** 'ntp/init.sls'
2018-01-31 15:39:56,931 [salt.fileclient  ][INFO    ][2108] Fetching file from saltenv 'base', ** done ** 'ntp/client.sls'
2018-01-31 15:39:56,985 [salt.fileclient  ][INFO    ][2108] Fetching file from saltenv 'base', ** done ** 'ntp/server.sls'
2018-01-31 15:39:57,028 [salt.state       ][INFO    ][2108] Running state [/etc/environment] at time 15:39:57.028918
2018-01-31 15:39:57,029 [salt.state       ][INFO    ][2108] Executing state file.blockreplace for /etc/environment
2018-01-31 15:39:57,038 [salt.state       ][INFO    ][2108] 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-01-31 15:39:57,040 [salt.state       ][INFO    ][2108] Completed state [/etc/environment] at time 15:39:57.040315 duration_in_ms=11.398
2018-01-31 15:39:57,040 [salt.state       ][INFO    ][2108] Running state [/etc/profile.d] at time 15:39:57.040839
2018-01-31 15:39:57,041 [salt.state       ][INFO    ][2108] Executing state file.directory for /etc/profile.d
2018-01-31 15:39:57,043 [salt.state       ][INFO    ][2108] Directory /etc/profile.d is in the correct state
2018-01-31 15:39:57,044 [salt.state       ][INFO    ][2108] Completed state [/etc/profile.d] at time 15:39:57.044178 duration_in_ms=3.339
2018-01-31 15:39:57,449 [salt.minion      ][INFO    ][2017] User sudo_ubuntu Executing command saltutil.find_job with jid 20180131153958849406
2018-01-31 15:39:57,466 [salt.minion      ][INFO    ][2162] Starting a new job with PID 2162
2018-01-31 15:39:57,488 [salt.minion      ][INFO    ][2162] Returning information for job: 20180131153958849406
2018-01-31 15:39:57,638 [salt.state       ][INFO    ][2108] Running state [/etc/apt/apt.conf.d/99compression-workaround-salt] at time 15:39:57.638674
2018-01-31 15:39:57,639 [salt.state       ][INFO    ][2108] Executing state file.managed for /etc/apt/apt.conf.d/99compression-workaround-salt
2018-01-31 15:39:57,672 [salt.fileclient  ][INFO    ][2108] Fetching file from saltenv 'base', ** done ** 'linux/files/apt.conf'
2018-01-31 15:39:57,683 [salt.state       ][INFO    ][2108] File changed:
New file
2018-01-31 15:39:57,684 [salt.state       ][INFO    ][2108] Completed state [/etc/apt/apt.conf.d/99compression-workaround-salt] at time 15:39:57.684441 duration_in_ms=45.767
2018-01-31 15:39:57,685 [salt.state       ][INFO    ][2108] Running state [/etc/apt/apt.conf.d/99prefer_ipv4-salt] at time 15:39:57.684973
2018-01-31 15:39:57,685 [salt.state       ][INFO    ][2108] Executing state file.managed for /etc/apt/apt.conf.d/99prefer_ipv4-salt
2018-01-31 15:39:57,705 [salt.state       ][INFO    ][2108] File changed:
New file
2018-01-31 15:39:57,706 [salt.state       ][INFO    ][2108] Completed state [/etc/apt/apt.conf.d/99prefer_ipv4-salt] at time 15:39:57.705982 duration_in_ms=21.009
2018-01-31 15:39:57,707 [salt.state       ][INFO    ][2108] Running state [linux_repo_prereq_pkgs] at time 15:39:57.707729
2018-01-31 15:39:57,708 [salt.state       ][INFO    ][2108] Executing state pkg.installed for linux_repo_prereq_pkgs
2018-01-31 15:39:57,709 [salt.loaded.int.module.cmdmod][INFO    ][2108] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2018-01-31 15:39:58,082 [salt.state       ][INFO    ][2108] All specified packages are already installed
2018-01-31 15:39:58,082 [salt.state       ][INFO    ][2108] Completed state [linux_repo_prereq_pkgs] at time 15:39:58.082765 duration_in_ms=375.035
2018-01-31 15:39:58,083 [salt.state       ][INFO    ][2108] Running state [/etc/apt/apt.conf.d/99proxies-salt-mk_openstack] at time 15:39:58.083434
2018-01-31 15:39:58,084 [salt.state       ][INFO    ][2108] Executing state file.absent for /etc/apt/apt.conf.d/99proxies-salt-mk_openstack
2018-01-31 15:39:58,084 [salt.state       ][INFO    ][2108] File /etc/apt/apt.conf.d/99proxies-salt-mk_openstack is not present
2018-01-31 15:39:58,085 [salt.state       ][INFO    ][2108] Completed state [/etc/apt/apt.conf.d/99proxies-salt-mk_openstack] at time 15:39:58.085183 duration_in_ms=1.749
2018-01-31 15:39:58,085 [salt.state       ][INFO    ][2108] Running state [/etc/apt/preferences.d/mk_openstack] at time 15:39:58.085651
2018-01-31 15:39:58,086 [salt.state       ][INFO    ][2108] Executing state file.managed for /etc/apt/preferences.d/mk_openstack
2018-01-31 15:39:58,105 [salt.fileclient  ][INFO    ][2108] Fetching file from saltenv 'base', ** done ** 'linux/files/preferences_repo'
2018-01-31 15:39:58,202 [salt.state       ][INFO    ][2108] File changed:
New file
2018-01-31 15:39:58,202 [salt.state       ][INFO    ][2108] Completed state [/etc/apt/preferences.d/mk_openstack] at time 15:39:58.202791 duration_in_ms=117.14
2018-01-31 15:39:58,204 [salt.state       ][INFO    ][2108] Running state [curl -s http://apt.mirantis.com/public.gpg | apt-key add -] at time 15:39:58.204721
2018-01-31 15:39:58,205 [salt.state       ][INFO    ][2108] Executing state cmd.run for curl -s http://apt.mirantis.com/public.gpg | apt-key add -
2018-01-31 15:39:58,206 [salt.loaded.int.module.cmdmod][INFO    ][2108] Executing command 'curl -s http://apt.mirantis.com/public.gpg | apt-key add -' in directory '/root'
2018-01-31 15:39:58,398 [salt.state       ][INFO    ][2108] {'pid': 2173, 'retcode': 0, 'stderr': '', 'stdout': 'OK'}
2018-01-31 15:39:58,399 [salt.state       ][INFO    ][2108] Completed state [curl -s http://apt.mirantis.com/public.gpg | apt-key add -] at time 15:39:58.399184 duration_in_ms=194.462
2018-01-31 15:39:58,404 [salt.state       ][INFO    ][2108] Running state [deb [arch=amd64] http://apt.mirantis.com/xenial/ stable pike] at time 15:39:58.404594
2018-01-31 15:39:58,405 [salt.state       ][INFO    ][2108] Executing state pkgrepo.managed for deb [arch=amd64] http://apt.mirantis.com/xenial/ stable pike
2018-01-31 15:39:58,504 [salt.loaded.int.module.cmdmod][INFO    ][2108] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2018-01-31 15:40:02,113 [salt.state       ][INFO    ][2108] {'repo': 'deb [arch=amd64] http://apt.mirantis.com/xenial stable pike'}
2018-01-31 15:40:02,114 [salt.state       ][INFO    ][2108] Completed state [deb [arch=amd64] http://apt.mirantis.com/xenial/ stable pike] at time 15:40:02.114860 duration_in_ms=3710.266
2018-01-31 15:40:02,115 [salt.state       ][INFO    ][2108] Running state [/etc/apt/apt.conf.d/99proxies-salt-mirantis_openstack] at time 15:40:02.115506
2018-01-31 15:40:02,116 [salt.state       ][INFO    ][2108] Executing state file.absent for /etc/apt/apt.conf.d/99proxies-salt-mirantis_openstack
2018-01-31 15:40:02,116 [salt.state       ][INFO    ][2108] File /etc/apt/apt.conf.d/99proxies-salt-mirantis_openstack is not present
2018-01-31 15:40:02,117 [salt.state       ][INFO    ][2108] Completed state [/etc/apt/apt.conf.d/99proxies-salt-mirantis_openstack] at time 15:40:02.117261 duration_in_ms=1.755
2018-01-31 15:40:02,117 [salt.state       ][INFO    ][2108] Running state [/etc/apt/preferences.d/mirantis_openstack] at time 15:40:02.117727
2018-01-31 15:40:02,119 [salt.state       ][INFO    ][2108] Executing state file.managed for /etc/apt/preferences.d/mirantis_openstack
2018-01-31 15:40:02,225 [salt.state       ][INFO    ][2108] File changed:
New file
2018-01-31 15:40:02,226 [salt.state       ][INFO    ][2108] Completed state [/etc/apt/preferences.d/mirantis_openstack] at time 15:40:02.226849 duration_in_ms=109.121
2018-01-31 15:40:02,227 [salt.state       ][INFO    ][2108] Running state [curl -s http://mirror.fuel-infra.org/mcp-repos/pike/xenial/archive-mcppike.key | apt-key add -] at time 15:40:02.227371
2018-01-31 15:40:02,227 [salt.state       ][INFO    ][2108] Executing state cmd.run for curl -s http://mirror.fuel-infra.org/mcp-repos/pike/xenial/archive-mcppike.key | apt-key add -
2018-01-31 15:40:02,228 [salt.loaded.int.module.cmdmod][INFO    ][2108] Executing command 'curl -s http://mirror.fuel-infra.org/mcp-repos/pike/xenial/archive-mcppike.key | apt-key add -' in directory '/root'
2018-01-31 15:40:02,410 [salt.state       ][INFO    ][2108] {'pid': 2600, 'retcode': 0, 'stderr': '', 'stdout': 'OK'}
2018-01-31 15:40:02,411 [salt.state       ][INFO    ][2108] Completed state [curl -s http://mirror.fuel-infra.org/mcp-repos/pike/xenial/archive-mcppike.key | apt-key add -] at time 15:40:02.411394 duration_in_ms=184.022
2018-01-31 15:40:02,413 [salt.state       ][INFO    ][2108] Running state [deb http://mirror.fuel-infra.org/mcp-repos/pike/xenial pike main] at time 15:40:02.413334
2018-01-31 15:40:02,413 [salt.state       ][INFO    ][2108] Executing state pkgrepo.managed for deb http://mirror.fuel-infra.org/mcp-repos/pike/xenial pike main
2018-01-31 15:40:02,635 [salt.loaded.int.module.cmdmod][INFO    ][2108] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2018-01-31 15:40:06,686 [salt.state       ][INFO    ][2108] {'repo': 'deb http://mirror.fuel-infra.org/mcp-repos/pike/xenial pike main'}
2018-01-31 15:40:06,686 [salt.state       ][INFO    ][2108] Completed state [deb http://mirror.fuel-infra.org/mcp-repos/pike/xenial pike main] at time 15:40:06.686867 duration_in_ms=4273.533
2018-01-31 15:40:06,687 [salt.state       ][INFO    ][2108] Running state [/etc/apt/apt.conf.d/99proxies-salt-uca] at time 15:40:06.687488
2018-01-31 15:40:06,688 [salt.state       ][INFO    ][2108] Executing state file.absent for /etc/apt/apt.conf.d/99proxies-salt-uca
2018-01-31 15:40:06,688 [salt.state       ][INFO    ][2108] File /etc/apt/apt.conf.d/99proxies-salt-uca is not present
2018-01-31 15:40:06,689 [salt.state       ][INFO    ][2108] Completed state [/etc/apt/apt.conf.d/99proxies-salt-uca] at time 15:40:06.689271 duration_in_ms=1.782
2018-01-31 15:40:06,689 [salt.state       ][INFO    ][2108] Running state [/etc/apt/preferences.d/uca] at time 15:40:06.689749
2018-01-31 15:40:06,691 [salt.state       ][INFO    ][2108] Executing state file.absent for /etc/apt/preferences.d/uca
2018-01-31 15:40:06,691 [salt.state       ][INFO    ][2108] File /etc/apt/preferences.d/uca is not present
2018-01-31 15:40:06,692 [salt.state       ][INFO    ][2108] Completed state [/etc/apt/preferences.d/uca] at time 15:40:06.692258 duration_in_ms=2.508
2018-01-31 15:40:06,692 [salt.state       ][INFO    ][2108] Running state [apt-key adv --keyserver keyserver.ubuntu.com --recv EC4926EA] at time 15:40:06.692729
2018-01-31 15:40:06,693 [salt.state       ][INFO    ][2108] Executing state cmd.run for apt-key adv --keyserver keyserver.ubuntu.com --recv EC4926EA
2018-01-31 15:40:06,694 [salt.loaded.int.module.cmdmod][INFO    ][2108] Executing command 'apt-key adv --keyserver keyserver.ubuntu.com --recv EC4926EA' in directory '/root'
2018-01-31 15:40:06,961 [salt.state       ][INFO    ][2108] {'pid': 3077, '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.PiCaQyD5Uu/gpg.1.sh --keyserver\nkeyserver.ubuntu.com\n--recv\nEC4926EA'}
2018-01-31 15:40:06,962 [salt.state       ][INFO    ][2108] Completed state [apt-key adv --keyserver keyserver.ubuntu.com --recv EC4926EA] at time 15:40:06.962723 duration_in_ms=269.993
2018-01-31 15:40:06,964 [salt.state       ][INFO    ][2108] Running state [deb http://ubuntu-cloud.archive.canonical.com/ubuntu xenial-updates/pike main] at time 15:40:06.964672
2018-01-31 15:40:06,965 [salt.state       ][INFO    ][2108] Executing state pkgrepo.managed for deb http://ubuntu-cloud.archive.canonical.com/ubuntu xenial-updates/pike main
2018-01-31 15:40:07,059 [salt.loaded.int.module.cmdmod][INFO    ][2108] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2018-01-31 15:40:07,523 [salt.minion      ][INFO    ][2017] User sudo_ubuntu Executing command saltutil.find_job with jid 20180131154008925570
2018-01-31 15:40:07,551 [salt.minion      ][INFO    ][3414] Starting a new job with PID 3414
2018-01-31 15:40:07,571 [salt.minion      ][INFO    ][3414] Returning information for job: 20180131154008925570
2018-01-31 15:40:11,571 [salt.state       ][INFO    ][2108] {'repo': 'deb http://ubuntu-cloud.archive.canonical.com/ubuntu xenial-updates/pike main'}
2018-01-31 15:40:11,572 [salt.state       ][INFO    ][2108] Completed state [deb http://ubuntu-cloud.archive.canonical.com/ubuntu xenial-updates/pike main] at time 15:40:11.572722 duration_in_ms=4608.049
2018-01-31 15:40:11,573 [salt.state       ][INFO    ][2108] Running state [linux_extra_packages_purged] at time 15:40:11.573362
2018-01-31 15:40:11,573 [salt.state       ][INFO    ][2108] Executing state pkg.purged for linux_extra_packages_purged
2018-01-31 15:40:11,610 [salt.loaded.int.module.cmdmod][INFO    ][2108] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', 'purge', 'cloud-init', 'unattended-upgrades'] in directory '/root'
2018-01-31 15:40:16,178 [salt.loaded.int.module.cmdmod][INFO    ][2108] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2018-01-31 15:40:16,220 [salt.state       ][INFO    ][2108] {'removed': {}, 'installed': {'cloud-init': {'new': '', 'old': '17.1-46-g7acc9e68-0ubuntu1~16.04.1'}, 'ec2-init': {'new': '', 'old': '1'}, 'unattended-upgrades': {'new': '', 'old': '0.90ubuntu0.9'}}}
2018-01-31 15:40:16,243 [salt.state       ][INFO    ][2108] Loading fresh modules for state activity
2018-01-31 15:40:16,275 [salt.state       ][INFO    ][2108] Completed state [linux_extra_packages_purged] at time 15:40:16.275509 duration_in_ms=4702.147
2018-01-31 15:40:16,287 [salt.state       ][INFO    ][2108] Running state [linux_extra_packages_latest] at time 15:40:16.287630
2018-01-31 15:40:16,288 [salt.state       ][INFO    ][2108] Executing state pkg.latest for linux_extra_packages_latest
2018-01-31 15:40:16,718 [salt.loaded.int.module.cmdmod][INFO    ][2108] Executing command ['apt-cache', '-q', 'policy', 'mcelog'] in directory '/root'
2018-01-31 15:40:16,784 [salt.loaded.int.module.cmdmod][INFO    ][2108] Executing command ['dpkg', '--get-selections', '*'] in directory '/root'
2018-01-31 15:40:16,812 [salt.loaded.int.module.cmdmod][INFO    ][2108] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'mcelog'] in directory '/root'
2018-01-31 15:40:17,644 [salt.minion      ][INFO    ][2017] User sudo_ubuntu Executing command saltutil.find_job with jid 20180131154019043457
2018-01-31 15:40:17,665 [salt.minion      ][INFO    ][4335] Starting a new job with PID 4335
2018-01-31 15:40:17,686 [salt.minion      ][INFO    ][4335] Returning information for job: 20180131154019043457
2018-01-31 15:40:19,816 [salt.loaded.int.module.cmdmod][INFO    ][2108] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2018-01-31 15:40:19,859 [salt.state       ][INFO    ][2108] Made the following changes:
'mcelog' changed from 'absent' to '128+dfsg-1'

2018-01-31 15:40:19,879 [salt.state       ][INFO    ][2108] Loading fresh modules for state activity
2018-01-31 15:40:19,913 [salt.state       ][INFO    ][2108] Completed state [linux_extra_packages_latest] at time 15:40:19.912934 duration_in_ms=3625.303
2018-01-31 15:40:19,917 [salt.state       ][INFO    ][2108] Running state [UTC] at time 15:40:19.917785
2018-01-31 15:40:19,918 [salt.state       ][INFO    ][2108] Executing state timezone.system for UTC
2018-01-31 15:40:19,921 [salt.loaded.int.module.cmdmod][INFO    ][2108] Executing command ['timedatectl'] in directory '/root'
2018-01-31 15:40:20,004 [salt.loaded.int.module.cmdmod][INFO    ][2108] Executing command ['timedatectl'] in directory '/root'
2018-01-31 15:40:20,024 [salt.loaded.int.module.cmdmod][INFO    ][2108] Executing command 'timedatectl set-timezone UTC' in directory '/root'
2018-01-31 15:40:20,049 [salt.state       ][INFO    ][2108] {'timezone': 'UTC'}
2018-01-31 15:40:20,050 [salt.state       ][INFO    ][2108] Completed state [UTC] at time 15:40:20.050674 duration_in_ms=132.888
2018-01-31 15:40:20,054 [salt.state       ][INFO    ][2108] Running state [nf_conntrack] at time 15:40:20.053952
2018-01-31 15:40:20,054 [salt.state       ][INFO    ][2108] Executing state kmod.present for nf_conntrack
2018-01-31 15:40:20,055 [salt.loaded.int.module.cmdmod][INFO    ][2108] Executing command 'lsmod' in directory '/root'
2018-01-31 15:40:20,149 [salt.loaded.int.module.cmdmod][INFO    ][2108] Executing command 'lsmod' in directory '/root'
2018-01-31 15:40:20,170 [salt.loaded.int.module.cmdmod][INFO    ][2108] Executing command 'modprobe nf_conntrack' in directory '/root'
2018-01-31 15:40:20,193 [salt.loaded.int.module.cmdmod][INFO    ][2108] Executing command 'lsmod' in directory '/root'
2018-01-31 15:40:20,242 [salt.state       ][INFO    ][2108] {'nf_conntrack': 'loaded'}
2018-01-31 15:40:20,243 [salt.state       ][INFO    ][2108] Completed state [nf_conntrack] at time 15:40:20.243816 duration_in_ms=189.863
2018-01-31 15:40:20,247 [salt.state       ][INFO    ][2108] Running state [kernel.panic] at time 15:40:20.247300
2018-01-31 15:40:20,247 [salt.state       ][INFO    ][2108] Executing state sysctl.present for kernel.panic
2018-01-31 15:40:20,248 [salt.loaded.int.module.cmdmod][INFO    ][2108] Executing command 'sysctl -a' in directory '/root'
2018-01-31 15:40:20,324 [salt.loaded.int.module.cmdmod][INFO    ][2108] Executing command 'sysctl -w kernel.panic="60"' in directory '/root'
2018-01-31 15:40:20,340 [salt.state       ][INFO    ][2108] {'kernel.panic': 60}
2018-01-31 15:40:20,340 [salt.state       ][INFO    ][2108] Completed state [kernel.panic] at time 15:40:20.340617 duration_in_ms=93.316
2018-01-31 15:40:20,341 [salt.state       ][INFO    ][2108] Running state [net.ipv4.tcp_keepalive_probes] at time 15:40:20.341084
2018-01-31 15:40:20,341 [salt.state       ][INFO    ][2108] Executing state sysctl.present for net.ipv4.tcp_keepalive_probes
2018-01-31 15:40:20,342 [salt.loaded.int.module.cmdmod][INFO    ][2108] Executing command 'sysctl -a' in directory '/root'
2018-01-31 15:40:20,376 [salt.loaded.int.module.cmdmod][INFO    ][2108] Executing command 'sysctl -w net.ipv4.tcp_keepalive_probes="8"' in directory '/root'
2018-01-31 15:40:20,391 [salt.state       ][INFO    ][2108] {'net.ipv4.tcp_keepalive_probes': 8}
2018-01-31 15:40:20,391 [salt.state       ][INFO    ][2108] Completed state [net.ipv4.tcp_keepalive_probes] at time 15:40:20.391534 duration_in_ms=50.449
2018-01-31 15:40:20,392 [salt.state       ][INFO    ][2108] Running state [fs.file-max] at time 15:40:20.391975
2018-01-31 15:40:20,392 [salt.state       ][INFO    ][2108] Executing state sysctl.present for fs.file-max
2018-01-31 15:40:20,393 [salt.loaded.int.module.cmdmod][INFO    ][2108] Executing command 'sysctl -a' in directory '/root'
2018-01-31 15:40:20,428 [salt.loaded.int.module.cmdmod][INFO    ][2108] Executing command 'sysctl -w fs.file-max="124165"' in directory '/root'
2018-01-31 15:40:20,445 [salt.state       ][INFO    ][2108] {'fs.file-max': 124165}
2018-01-31 15:40:20,445 [salt.state       ][INFO    ][2108] Completed state [fs.file-max] at time 15:40:20.445863 duration_in_ms=53.887
2018-01-31 15:40:20,446 [salt.state       ][INFO    ][2108] Running state [net.core.somaxconn] at time 15:40:20.446567
2018-01-31 15:40:20,446 [salt.state       ][INFO    ][2108] Executing state sysctl.present for net.core.somaxconn
2018-01-31 15:40:20,447 [salt.loaded.int.module.cmdmod][INFO    ][2108] Executing command 'sysctl -a' in directory '/root'
2018-01-31 15:40:20,482 [salt.loaded.int.module.cmdmod][INFO    ][2108] Executing command 'sysctl -w net.core.somaxconn="4096"' in directory '/root'
2018-01-31 15:40:20,497 [salt.state       ][INFO    ][2108] {'net.core.somaxconn': 4096}
2018-01-31 15:40:20,498 [salt.state       ][INFO    ][2108] Completed state [net.core.somaxconn] at time 15:40:20.498884 duration_in_ms=52.316
2018-01-31 15:40:20,499 [salt.state       ][INFO    ][2108] Running state [net.ipv4.tcp_max_syn_backlog] at time 15:40:20.499320
2018-01-31 15:40:20,499 [salt.state       ][INFO    ][2108] Executing state sysctl.present for net.ipv4.tcp_max_syn_backlog
2018-01-31 15:40:20,500 [salt.loaded.int.module.cmdmod][INFO    ][2108] Executing command 'sysctl -a' in directory '/root'
2018-01-31 15:40:20,536 [salt.loaded.int.module.cmdmod][INFO    ][2108] Executing command 'sysctl -w net.ipv4.tcp_max_syn_backlog="8192"' in directory '/root'
2018-01-31 15:40:20,554 [salt.state       ][INFO    ][2108] {'net.ipv4.tcp_max_syn_backlog': 8192}
2018-01-31 15:40:20,555 [salt.state       ][INFO    ][2108] Completed state [net.ipv4.tcp_max_syn_backlog] at time 15:40:20.555240 duration_in_ms=55.919
2018-01-31 15:40:20,555 [salt.state       ][INFO    ][2108] Running state [net.ipv4.tcp_tw_reuse] at time 15:40:20.555644
2018-01-31 15:40:20,556 [salt.state       ][INFO    ][2108] Executing state sysctl.present for net.ipv4.tcp_tw_reuse
2018-01-31 15:40:20,556 [salt.loaded.int.module.cmdmod][INFO    ][2108] Executing command 'sysctl -a' in directory '/root'
2018-01-31 15:40:20,593 [salt.loaded.int.module.cmdmod][INFO    ][2108] Executing command 'sysctl -w net.ipv4.tcp_tw_reuse="1"' in directory '/root'
2018-01-31 15:40:20,609 [salt.state       ][INFO    ][2108] {'net.ipv4.tcp_tw_reuse': 1}
2018-01-31 15:40:20,609 [salt.state       ][INFO    ][2108] Completed state [net.ipv4.tcp_tw_reuse] at time 15:40:20.609617 duration_in_ms=53.972
2018-01-31 15:40:20,610 [salt.state       ][INFO    ][2108] Running state [net.ipv4.tcp_congestion_control] at time 15:40:20.610888
2018-01-31 15:40:20,611 [salt.state       ][INFO    ][2108] Executing state sysctl.present for net.ipv4.tcp_congestion_control
2018-01-31 15:40:20,612 [salt.loaded.int.module.cmdmod][INFO    ][2108] Executing command 'sysctl -a' in directory '/root'
2018-01-31 15:40:20,647 [salt.loaded.int.module.cmdmod][INFO    ][2108] Executing command 'sysctl -w net.ipv4.tcp_congestion_control="yeah"' in directory '/root'
2018-01-31 15:40:20,667 [salt.state       ][INFO    ][2108] {'net.ipv4.tcp_congestion_control': 'yeah'}
2018-01-31 15:40:20,668 [salt.state       ][INFO    ][2108] Completed state [net.ipv4.tcp_congestion_control] at time 15:40:20.668281 duration_in_ms=57.392
2018-01-31 15:40:20,668 [salt.state       ][INFO    ][2108] Running state [net.ipv4.tcp_retries2] at time 15:40:20.668929
2018-01-31 15:40:20,669 [salt.state       ][INFO    ][2108] Executing state sysctl.present for net.ipv4.tcp_retries2
2018-01-31 15:40:20,671 [salt.loaded.int.module.cmdmod][INFO    ][2108] Executing command 'sysctl -a' in directory '/root'
2018-01-31 15:40:20,704 [salt.loaded.int.module.cmdmod][INFO    ][2108] Executing command 'sysctl -w net.ipv4.tcp_retries2="5"' in directory '/root'
2018-01-31 15:40:20,723 [salt.state       ][INFO    ][2108] {'net.ipv4.tcp_retries2': 5}
2018-01-31 15:40:20,724 [salt.state       ][INFO    ][2108] Completed state [net.ipv4.tcp_retries2] at time 15:40:20.723951 duration_in_ms=55.021
2018-01-31 15:40:20,724 [salt.state       ][INFO    ][2108] Running state [net.core.netdev_max_backlog] at time 15:40:20.724433
2018-01-31 15:40:20,724 [salt.state       ][INFO    ][2108] Executing state sysctl.present for net.core.netdev_max_backlog
2018-01-31 15:40:20,725 [salt.loaded.int.module.cmdmod][INFO    ][2108] Executing command 'sysctl -a' in directory '/root'
2018-01-31 15:40:20,761 [salt.loaded.int.module.cmdmod][INFO    ][2108] Executing command 'sysctl -w net.core.netdev_max_backlog="261144"' in directory '/root'
2018-01-31 15:40:20,778 [salt.state       ][INFO    ][2108] {'net.core.netdev_max_backlog': 261144}
2018-01-31 15:40:20,779 [salt.state       ][INFO    ][2108] Completed state [net.core.netdev_max_backlog] at time 15:40:20.779360 duration_in_ms=54.926
2018-01-31 15:40:20,779 [salt.state       ][INFO    ][2108] Running state [net.ipv4.tcp_slow_start_after_idle] at time 15:40:20.779803
2018-01-31 15:40:20,780 [salt.state       ][INFO    ][2108] Executing state sysctl.present for net.ipv4.tcp_slow_start_after_idle
2018-01-31 15:40:20,781 [salt.loaded.int.module.cmdmod][INFO    ][2108] Executing command 'sysctl -a' in directory '/root'
2018-01-31 15:40:20,817 [salt.loaded.int.module.cmdmod][INFO    ][2108] Executing command 'sysctl -w net.ipv4.tcp_slow_start_after_idle="0"' in directory '/root'
2018-01-31 15:40:20,834 [salt.state       ][INFO    ][2108] {'net.ipv4.tcp_slow_start_after_idle': 0}
2018-01-31 15:40:20,835 [salt.state       ][INFO    ][2108] Completed state [net.ipv4.tcp_slow_start_after_idle] at time 15:40:20.835609 duration_in_ms=55.805
2018-01-31 15:40:20,836 [salt.state       ][INFO    ][2108] Running state [vm.swappiness] at time 15:40:20.836337
2018-01-31 15:40:20,837 [salt.state       ][INFO    ][2108] Executing state sysctl.present for vm.swappiness
2018-01-31 15:40:20,839 [salt.loaded.int.module.cmdmod][INFO    ][2108] Executing command 'sysctl -a' in directory '/root'
2018-01-31 15:40:20,877 [salt.loaded.int.module.cmdmod][INFO    ][2108] Executing command 'sysctl -w vm.swappiness="10"' in directory '/root'
2018-01-31 15:40:20,894 [salt.state       ][INFO    ][2108] {'vm.swappiness': 10}
2018-01-31 15:40:20,895 [salt.state       ][INFO    ][2108] Completed state [vm.swappiness] at time 15:40:20.895846 duration_in_ms=59.508
2018-01-31 15:40:20,896 [salt.state       ][INFO    ][2108] Running state [net.ipv4.tcp_keepalive_intvl] at time 15:40:20.896556
2018-01-31 15:40:20,897 [salt.state       ][INFO    ][2108] Executing state sysctl.present for net.ipv4.tcp_keepalive_intvl
2018-01-31 15:40:20,899 [salt.loaded.int.module.cmdmod][INFO    ][2108] Executing command 'sysctl -a' in directory '/root'
2018-01-31 15:40:20,937 [salt.loaded.int.module.cmdmod][INFO    ][2108] Executing command 'sysctl -w net.ipv4.tcp_keepalive_intvl="3"' in directory '/root'
2018-01-31 15:40:20,954 [salt.state       ][INFO    ][2108] {'net.ipv4.tcp_keepalive_intvl': 3}
2018-01-31 15:40:20,955 [salt.state       ][INFO    ][2108] Completed state [net.ipv4.tcp_keepalive_intvl] at time 15:40:20.955272 duration_in_ms=58.715
2018-01-31 15:40:20,956 [salt.state       ][INFO    ][2108] Running state [net.ipv4.neigh.default.gc_thresh1] at time 15:40:20.956014
2018-01-31 15:40:20,956 [salt.state       ][INFO    ][2108] Executing state sysctl.present for net.ipv4.neigh.default.gc_thresh1
2018-01-31 15:40:20,957 [salt.loaded.int.module.cmdmod][INFO    ][2108] Executing command 'sysctl -a' in directory '/root'
2018-01-31 15:40:20,998 [salt.loaded.int.module.cmdmod][INFO    ][2108] Executing command 'sysctl -w net.ipv4.neigh.default.gc_thresh1="4096"' in directory '/root'
2018-01-31 15:40:21,014 [salt.state       ][INFO    ][2108] {'net.ipv4.neigh.default.gc_thresh1': 4096}
2018-01-31 15:40:21,015 [salt.state       ][INFO    ][2108] Completed state [net.ipv4.neigh.default.gc_thresh1] at time 15:40:21.015650 duration_in_ms=59.635
2018-01-31 15:40:21,016 [salt.state       ][INFO    ][2108] Running state [net.ipv4.neigh.default.gc_thresh2] at time 15:40:21.016346
2018-01-31 15:40:21,017 [salt.state       ][INFO    ][2108] Executing state sysctl.present for net.ipv4.neigh.default.gc_thresh2
2018-01-31 15:40:21,018 [salt.loaded.int.module.cmdmod][INFO    ][2108] Executing command 'sysctl -a' in directory '/root'
2018-01-31 15:40:21,054 [salt.loaded.int.module.cmdmod][INFO    ][2108] Executing command 'sysctl -w net.ipv4.neigh.default.gc_thresh2="8192"' in directory '/root'
2018-01-31 15:40:21,070 [salt.state       ][INFO    ][2108] {'net.ipv4.neigh.default.gc_thresh2': 8192}
2018-01-31 15:40:21,071 [salt.state       ][INFO    ][2108] Completed state [net.ipv4.neigh.default.gc_thresh2] at time 15:40:21.071593 duration_in_ms=55.246
2018-01-31 15:40:21,072 [salt.state       ][INFO    ][2108] Running state [net.ipv4.neigh.default.gc_thresh3] at time 15:40:21.072295
2018-01-31 15:40:21,072 [salt.state       ][INFO    ][2108] Executing state sysctl.present for net.ipv4.neigh.default.gc_thresh3
2018-01-31 15:40:21,074 [salt.loaded.int.module.cmdmod][INFO    ][2108] Executing command 'sysctl -a' in directory '/root'
2018-01-31 15:40:21,115 [salt.loaded.int.module.cmdmod][INFO    ][2108] Executing command 'sysctl -w net.ipv4.neigh.default.gc_thresh3="16384"' in directory '/root'
2018-01-31 15:40:21,132 [salt.state       ][INFO    ][2108] {'net.ipv4.neigh.default.gc_thresh3': 16384}
2018-01-31 15:40:21,133 [salt.state       ][INFO    ][2108] Completed state [net.ipv4.neigh.default.gc_thresh3] at time 15:40:21.133328 duration_in_ms=61.032
2018-01-31 15:40:21,134 [salt.state       ][INFO    ][2108] Running state [net.ipv4.tcp_fin_timeout] at time 15:40:21.134054
2018-01-31 15:40:21,134 [salt.state       ][INFO    ][2108] Executing state sysctl.present for net.ipv4.tcp_fin_timeout
2018-01-31 15:40:21,135 [salt.loaded.int.module.cmdmod][INFO    ][2108] Executing command 'sysctl -a' in directory '/root'
2018-01-31 15:40:21,174 [salt.loaded.int.module.cmdmod][INFO    ][2108] Executing command 'sysctl -w net.ipv4.tcp_fin_timeout="30"' in directory '/root'
2018-01-31 15:40:21,189 [salt.state       ][INFO    ][2108] {'net.ipv4.tcp_fin_timeout': 30}
2018-01-31 15:40:21,191 [salt.state       ][INFO    ][2108] Completed state [net.ipv4.tcp_fin_timeout] at time 15:40:21.191072 duration_in_ms=57.018
2018-01-31 15:40:21,191 [salt.state       ][INFO    ][2108] Running state [net.ipv4.tcp_keepalive_time] at time 15:40:21.191733
2018-01-31 15:40:21,192 [salt.state       ][INFO    ][2108] Executing state sysctl.present for net.ipv4.tcp_keepalive_time
2018-01-31 15:40:21,193 [salt.loaded.int.module.cmdmod][INFO    ][2108] Executing command 'sysctl -a' in directory '/root'
2018-01-31 15:40:21,226 [salt.loaded.int.module.cmdmod][INFO    ][2108] Executing command 'sysctl -w net.ipv4.tcp_keepalive_time="30"' in directory '/root'
2018-01-31 15:40:21,241 [salt.state       ][INFO    ][2108] {'net.ipv4.tcp_keepalive_time': 30}
2018-01-31 15:40:21,243 [salt.state       ][INFO    ][2108] Completed state [net.ipv4.tcp_keepalive_time] at time 15:40:21.243007 duration_in_ms=51.273
2018-01-31 15:40:21,243 [salt.state       ][INFO    ][2108] Running state [net.nf_conntrack_max] at time 15:40:21.243658
2018-01-31 15:40:21,244 [salt.state       ][INFO    ][2108] Executing state sysctl.present for net.nf_conntrack_max
2018-01-31 15:40:21,245 [salt.loaded.int.module.cmdmod][INFO    ][2108] Executing command 'sysctl -a' in directory '/root'
2018-01-31 15:40:21,278 [salt.loaded.int.module.cmdmod][INFO    ][2108] Executing command 'sysctl -w net.nf_conntrack_max="1048576"' in directory '/root'
2018-01-31 15:40:21,293 [salt.state       ][INFO    ][2108] {'net.nf_conntrack_max': 1048576}
2018-01-31 15:40:21,294 [salt.state       ][INFO    ][2108] Completed state [net.nf_conntrack_max] at time 15:40:21.294672 duration_in_ms=51.014
2018-01-31 15:40:21,307 [salt.state       ][INFO    ][2108] Running state [linux_sysfs_package] at time 15:40:21.307225
2018-01-31 15:40:21,307 [salt.state       ][INFO    ][2108] Executing state pkg.installed for linux_sysfs_package
2018-01-31 15:40:21,723 [salt.loaded.int.module.cmdmod][INFO    ][2108] Executing command ['apt-cache', '-q', 'policy', 'sysfsutils'] in directory '/root'
2018-01-31 15:40:21,780 [salt.loaded.int.module.cmdmod][INFO    ][2108] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2018-01-31 15:40:23,704 [salt.loaded.int.module.cmdmod][INFO    ][2108] Executing command ['dpkg', '--get-selections', '*'] in directory '/root'
2018-01-31 15:40:23,733 [salt.loaded.int.module.cmdmod][INFO    ][2108] 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-01-31 15:40:26,917 [salt.loaded.int.module.cmdmod][INFO    ][2108] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2018-01-31 15:40:26,967 [salt.state       ][INFO    ][2108] 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-01-31 15:40:26,987 [salt.state       ][INFO    ][2108] Loading fresh modules for state activity
2018-01-31 15:40:27,020 [salt.state       ][INFO    ][2108] Completed state [linux_sysfs_package] at time 15:40:27.020623 duration_in_ms=5713.398
2018-01-31 15:40:27,025 [salt.state       ][INFO    ][2108] Running state [/etc/sysfs.d] at time 15:40:27.025345
2018-01-31 15:40:27,025 [salt.state       ][INFO    ][2108] Executing state file.directory for /etc/sysfs.d
2018-01-31 15:40:27,029 [salt.state       ][INFO    ][2108] Directory /etc/sysfs.d is in the correct state
2018-01-31 15:40:27,029 [salt.state       ][INFO    ][2108] Completed state [/etc/sysfs.d] at time 15:40:27.029345 duration_in_ms=4.001
2018-01-31 15:40:27,081 [salt.state       ][INFO    ][2108] Running state [ondemand] at time 15:40:27.081613
2018-01-31 15:40:27,081 [salt.state       ][INFO    ][2108] Executing state service.dead for ondemand
2018-01-31 15:40:27,084 [salt.loaded.int.module.cmdmod][INFO    ][2108] Executing command ['systemctl', 'status', 'ondemand.service', '-n', '0'] in directory '/root'
2018-01-31 15:40:27,105 [salt.loaded.int.module.cmdmod][INFO    ][2108] Executing command ['systemctl', 'is-active', 'ondemand.service'] in directory '/root'
2018-01-31 15:40:27,129 [salt.loaded.int.module.cmdmod][INFO    ][2108] Executing command ['systemctl', 'is-enabled', 'ondemand.service'] in directory '/root'
2018-01-31 15:40:27,154 [salt.loaded.int.module.cmdmod][INFO    ][2108] Executing command ['systemd-run', '--scope', 'systemctl', 'stop', 'ondemand.service'] in directory '/root'
2018-01-31 15:40:27,232 [salt.loaded.int.module.cmdmod][INFO    ][2108] Executing command ['systemctl', 'is-active', 'ondemand.service'] in directory '/root'
2018-01-31 15:40:27,253 [salt.loaded.int.module.cmdmod][INFO    ][2108] Executing command ['systemctl', 'is-enabled', 'ondemand.service'] in directory '/root'
2018-01-31 15:40:27,279 [salt.loaded.int.module.cmdmod][INFO    ][2108] Executing command ['systemctl', 'is-enabled', 'ondemand.service'] in directory '/root'
2018-01-31 15:40:27,312 [salt.loaded.int.module.cmdmod][INFO    ][2108] Executing command ['systemd-run', '--scope', '/usr/sbin/update-rc.d', '-f', 'ondemand', 'remove'] in directory '/root'
2018-01-31 15:40:27,487 [salt.loaded.int.module.cmdmod][INFO    ][2108] Executing command ['systemctl', 'is-enabled', 'ondemand.service'] in directory '/root'
2018-01-31 15:40:27,517 [salt.loaded.int.module.cmdmod][INFO    ][2108] Executing command 'runlevel' in directory '/root'
2018-01-31 15:40:27,536 [salt.state       ][INFO    ][2108] {'ondemand': True}
2018-01-31 15:40:27,537 [salt.state       ][INFO    ][2108] Completed state [ondemand] at time 15:40:27.537238 duration_in_ms=455.625
2018-01-31 15:40:27,541 [salt.state       ][INFO    ][2108] Running state [cs_CZ.UTF-8] at time 15:40:27.541426
2018-01-31 15:40:27,541 [salt.state       ][INFO    ][2108] Executing state locale.present for cs_CZ.UTF-8
2018-01-31 15:40:27,542 [salt.loaded.int.module.cmdmod][INFO    ][2108] Executing command 'locale -a' in directory '/root'
2018-01-31 15:40:27,565 [salt.loaded.int.module.cmdmod][INFO    ][2108] Executing command ['locale-gen', 'cs_CZ.utf8'] in directory '/root'
2018-01-31 15:40:27,746 [salt.minion      ][INFO    ][2017] User sudo_ubuntu Executing command saltutil.find_job with jid 20180131154029143786
2018-01-31 15:40:27,765 [salt.minion      ][INFO    ][5680] Starting a new job with PID 5680
2018-01-31 15:40:27,785 [salt.minion      ][INFO    ][5680] Returning information for job: 20180131154029143786
2018-01-31 15:40:28,420 [salt.state       ][INFO    ][2108] {'locale': 'cs_CZ.UTF-8'}
2018-01-31 15:40:28,421 [salt.state       ][INFO    ][2108] Completed state [cs_CZ.UTF-8] at time 15:40:28.421420 duration_in_ms=879.993
2018-01-31 15:40:28,421 [salt.state       ][INFO    ][2108] Running state [en_US.UTF-8] at time 15:40:28.421908
2018-01-31 15:40:28,422 [salt.state       ][INFO    ][2108] Executing state locale.present for en_US.UTF-8
2018-01-31 15:40:28,423 [salt.loaded.int.module.cmdmod][INFO    ][2108] Executing command 'locale -a' in directory '/root'
2018-01-31 15:40:28,437 [salt.state       ][INFO    ][2108] Locale en_US.UTF-8 is already present
2018-01-31 15:40:28,437 [salt.state       ][INFO    ][2108] Completed state [en_US.UTF-8] at time 15:40:28.437857 duration_in_ms=15.949
2018-01-31 15:40:28,440 [salt.state       ][INFO    ][2108] Running state [en_US.UTF-8] at time 15:40:28.440186
2018-01-31 15:40:28,440 [salt.state       ][INFO    ][2108] Executing state locale.system for en_US.UTF-8
2018-01-31 15:40:28,441 [salt.loaded.int.module.cmdmod][INFO    ][2108] Executing command 'localectl' in directory '/root'
2018-01-31 15:40:28,490 [salt.state       ][INFO    ][2108] System locale en_US.UTF-8 already set
2018-01-31 15:40:28,491 [salt.state       ][INFO    ][2108] Completed state [en_US.UTF-8] at time 15:40:28.491190 duration_in_ms=51.002
2018-01-31 15:40:28,494 [salt.state       ][INFO    ][2108] Running state [root] at time 15:40:28.494897
2018-01-31 15:40:28,495 [salt.state       ][INFO    ][2108] Executing state user.present for root
2018-01-31 15:40:28,501 [salt.state       ][INFO    ][2108] User root is present and up to date
2018-01-31 15:40:28,502 [salt.state       ][INFO    ][2108] Completed state [root] at time 15:40:28.502313 duration_in_ms=7.416
2018-01-31 15:40:28,503 [salt.state       ][INFO    ][2108] Running state [/root] at time 15:40:28.503829
2018-01-31 15:40:28,504 [salt.state       ][INFO    ][2108] Executing state file.directory for /root
2018-01-31 15:40:28,504 [salt.state       ][INFO    ][2108] Directory /root is in the correct state
2018-01-31 15:40:28,505 [salt.state       ][INFO    ][2108] Completed state [/root] at time 15:40:28.505136 duration_in_ms=1.307
2018-01-31 15:40:28,505 [salt.state       ][INFO    ][2108] Running state [/etc/sudoers.d/90-salt-user-root] at time 15:40:28.505372
2018-01-31 15:40:28,505 [salt.state       ][INFO    ][2108] Executing state file.absent for /etc/sudoers.d/90-salt-user-root
2018-01-31 15:40:28,505 [salt.state       ][INFO    ][2108] File /etc/sudoers.d/90-salt-user-root is not present
2018-01-31 15:40:28,506 [salt.state       ][INFO    ][2108] Completed state [/etc/sudoers.d/90-salt-user-root] at time 15:40:28.506688 duration_in_ms=1.316
2018-01-31 15:40:28,506 [salt.state       ][INFO    ][2108] Running state [ubuntu] at time 15:40:28.506937
2018-01-31 15:40:28,507 [salt.state       ][INFO    ][2108] Executing state user.present for ubuntu
2018-01-31 15:40:28,510 [salt.state       ][INFO    ][2108] {'passwd': 'XXX-REDACTED-XXX'}
2018-01-31 15:40:28,510 [salt.state       ][INFO    ][2108] Completed state [ubuntu] at time 15:40:28.510569 duration_in_ms=3.631
2018-01-31 15:40:28,511 [salt.state       ][INFO    ][2108] Running state [/home/ubuntu] at time 15:40:28.511663
2018-01-31 15:40:28,511 [salt.state       ][INFO    ][2108] Executing state file.directory for /home/ubuntu
2018-01-31 15:40:28,512 [salt.state       ][INFO    ][2108] {'mode': '0700'}
2018-01-31 15:40:28,513 [salt.state       ][INFO    ][2108] Completed state [/home/ubuntu] at time 15:40:28.513099 duration_in_ms=1.436
2018-01-31 15:40:28,514 [salt.state       ][INFO    ][2108] Running state [/etc/sudoers.d/90-salt-user-ubuntu] at time 15:40:28.514003
2018-01-31 15:40:28,514 [salt.state       ][INFO    ][2108] Executing state file.managed for /etc/sudoers.d/90-salt-user-ubuntu
2018-01-31 15:40:28,534 [salt.fileclient  ][INFO    ][2108] Fetching file from saltenv 'base', ** done ** 'linux/files/sudoer'
2018-01-31 15:40:28,539 [salt.loaded.int.module.cmdmod][INFO    ][2108] Executing command '/usr/sbin/visudo -c -f /tmp/tmpfnXgCq' in directory '/root'
2018-01-31 15:40:28,564 [salt.state       ][INFO    ][2108] File changed:
New file
2018-01-31 15:40:28,564 [salt.state       ][INFO    ][2108] Completed state [/etc/sudoers.d/90-salt-user-ubuntu] at time 15:40:28.564884 duration_in_ms=50.88
2018-01-31 15:40:28,565 [salt.state       ][INFO    ][2108] Running state [/etc/security/limits.d/90-salt-default.conf] at time 15:40:28.565303
2018-01-31 15:40:28,565 [salt.state       ][INFO    ][2108] Executing state file.managed for /etc/security/limits.d/90-salt-default.conf
2018-01-31 15:40:28,587 [salt.fileclient  ][INFO    ][2108] Fetching file from saltenv 'base', ** done ** 'linux/files/limits.conf'
2018-01-31 15:40:28,679 [salt.state       ][INFO    ][2108] File changed:
New file
2018-01-31 15:40:28,679 [salt.state       ][INFO    ][2108] Completed state [/etc/security/limits.d/90-salt-default.conf] at time 15:40:28.679364 duration_in_ms=114.06
2018-01-31 15:40:28,679 [salt.state       ][INFO    ][2108] Running state [/etc/systemd/system.conf.d/90-salt.conf] at time 15:40:28.679649
2018-01-31 15:40:28,679 [salt.state       ][INFO    ][2108] Executing state file.managed for /etc/systemd/system.conf.d/90-salt.conf
2018-01-31 15:40:28,698 [salt.fileclient  ][INFO    ][2108] Fetching file from saltenv 'base', ** done ** 'linux/files/systemd.conf'
2018-01-31 15:40:28,783 [salt.state       ][INFO    ][2108] File changed:
New file
2018-01-31 15:40:28,784 [salt.state       ][INFO    ][2108] Completed state [/etc/systemd/system.conf.d/90-salt.conf] at time 15:40:28.783969 duration_in_ms=104.319
2018-01-31 15:40:28,785 [salt.state       ][INFO    ][2108] Running state [service.systemctl_reload] at time 15:40:28.785809
2018-01-31 15:40:28,786 [salt.state       ][INFO    ][2108] Executing state module.wait for service.systemctl_reload
2018-01-31 15:40:28,786 [salt.state       ][INFO    ][2108] No changes made for service.systemctl_reload
2018-01-31 15:40:28,787 [salt.state       ][INFO    ][2108] Completed state [service.systemctl_reload] at time 15:40:28.787116 duration_in_ms=1.308
2018-01-31 15:40:28,787 [salt.state       ][INFO    ][2108] Running state [service.systemctl_reload] at time 15:40:28.787317
2018-01-31 15:40:28,787 [salt.state       ][INFO    ][2108] Executing state module.mod_watch for service.systemctl_reload
2018-01-31 15:40:28,788 [salt.loaded.int.module.cmdmod][INFO    ][2108] Executing command ['systemctl', '--system', 'daemon-reload'] in directory '/root'
2018-01-31 15:40:28,868 [salt.state       ][INFO    ][2108] {'ret': True}
2018-01-31 15:40:28,869 [salt.state       ][INFO    ][2108] Completed state [service.systemctl_reload] at time 15:40:28.869085 duration_in_ms=81.768
2018-01-31 15:40:28,869 [salt.state       ][INFO    ][2108] Running state [/etc/hostname] at time 15:40:28.869663
2018-01-31 15:40:28,870 [salt.state       ][INFO    ][2108] Executing state file.managed for /etc/hostname
2018-01-31 15:40:28,892 [salt.fileclient  ][INFO    ][2108] Fetching file from saltenv 'base', ** done ** 'linux/files/hostname'
2018-01-31 15:40:28,897 [salt.state       ][INFO    ][2108] File changed:
--- 
+++ 
@@ -1 +1 @@
-ubuntu
+msg01

2018-01-31 15:40:28,897 [salt.state       ][INFO    ][2108] Completed state [/etc/hostname] at time 15:40:28.897821 duration_in_ms=28.157
2018-01-31 15:40:28,900 [salt.state       ][INFO    ][2108] Running state [hostname msg01] at time 15:40:28.900139
2018-01-31 15:40:28,900 [salt.state       ][INFO    ][2108] Executing state cmd.wait for hostname msg01
2018-01-31 15:40:28,900 [salt.state       ][INFO    ][2108] No changes made for hostname msg01
2018-01-31 15:40:28,900 [salt.state       ][INFO    ][2108] Completed state [hostname msg01] at time 15:40:28.900946 duration_in_ms=0.807
2018-01-31 15:40:28,901 [salt.state       ][INFO    ][2108] Running state [hostname msg01] at time 15:40:28.901151
2018-01-31 15:40:28,901 [salt.state       ][INFO    ][2108] Executing state cmd.mod_watch for hostname msg01
2018-01-31 15:40:28,902 [salt.loaded.int.module.cmdmod][INFO    ][2108] Executing command 'hostname msg01' in directory '/root'
2018-01-31 15:40:28,920 [salt.state       ][INFO    ][2108] {'pid': 5707, 'retcode': 0, 'stderr': '', 'stdout': ''}
2018-01-31 15:40:28,921 [salt.state       ][INFO    ][2108] Completed state [hostname msg01] at time 15:40:28.921398 duration_in_ms=20.247
2018-01-31 15:40:28,923 [salt.state       ][INFO    ][2108] Running state [mdb02] at time 15:40:28.923294
2018-01-31 15:40:28,923 [salt.state       ][INFO    ][2108] Executing state host.present for mdb02
2018-01-31 15:40:28,927 [salt.state       ][INFO    ][2108] {'host': 'mdb02'}
2018-01-31 15:40:28,927 [salt.state       ][INFO    ][2108] Completed state [mdb02] at time 15:40:28.927499 duration_in_ms=4.206
2018-01-31 15:40:28,927 [salt.state       ][INFO    ][2108] Running state [mdb02.baremetal-mcp-pike-odl-ha.local] at time 15:40:28.927752
2018-01-31 15:40:28,927 [salt.state       ][INFO    ][2108] Executing state host.present for mdb02.baremetal-mcp-pike-odl-ha.local
2018-01-31 15:40:28,928 [salt.state       ][INFO    ][2108] {'host': 'mdb02.baremetal-mcp-pike-odl-ha.local'}
2018-01-31 15:40:28,929 [salt.state       ][INFO    ][2108] Completed state [mdb02.baremetal-mcp-pike-odl-ha.local] at time 15:40:28.929068 duration_in_ms=1.316
2018-01-31 15:40:28,929 [salt.state       ][INFO    ][2108] Running state [mdb03] at time 15:40:28.929308
2018-01-31 15:40:28,929 [salt.state       ][INFO    ][2108] Executing state host.present for mdb03
2018-01-31 15:40:28,931 [salt.state       ][INFO    ][2108] {'host': 'mdb03'}
2018-01-31 15:40:28,931 [salt.state       ][INFO    ][2108] Completed state [mdb03] at time 15:40:28.931397 duration_in_ms=2.089
2018-01-31 15:40:28,931 [salt.state       ][INFO    ][2108] Running state [mdb03.baremetal-mcp-pike-odl-ha.local] at time 15:40:28.931633
2018-01-31 15:40:28,931 [salt.state       ][INFO    ][2108] Executing state host.present for mdb03.baremetal-mcp-pike-odl-ha.local
2018-01-31 15:40:28,932 [salt.state       ][INFO    ][2108] {'host': 'mdb03.baremetal-mcp-pike-odl-ha.local'}
2018-01-31 15:40:28,932 [salt.state       ][INFO    ][2108] Completed state [mdb03.baremetal-mcp-pike-odl-ha.local] at time 15:40:28.932935 duration_in_ms=1.303
2018-01-31 15:40:28,933 [salt.state       ][INFO    ][2108] Running state [mdb01] at time 15:40:28.933171
2018-01-31 15:40:28,933 [salt.state       ][INFO    ][2108] Executing state host.present for mdb01
2018-01-31 15:40:28,934 [salt.state       ][INFO    ][2108] {'host': 'mdb01'}
2018-01-31 15:40:28,934 [salt.state       ][INFO    ][2108] Completed state [mdb01] at time 15:40:28.934737 duration_in_ms=1.566
2018-01-31 15:40:28,935 [salt.state       ][INFO    ][2108] Running state [mdb01.baremetal-mcp-pike-odl-ha.local] at time 15:40:28.934973
2018-01-31 15:40:28,935 [salt.state       ][INFO    ][2108] Executing state host.present for mdb01.baremetal-mcp-pike-odl-ha.local
2018-01-31 15:40:28,936 [salt.state       ][INFO    ][2108] {'host': 'mdb01.baremetal-mcp-pike-odl-ha.local'}
2018-01-31 15:40:28,936 [salt.state       ][INFO    ][2108] Completed state [mdb01.baremetal-mcp-pike-odl-ha.local] at time 15:40:28.936266 duration_in_ms=1.293
2018-01-31 15:40:28,936 [salt.state       ][INFO    ][2108] Running state [mdb] at time 15:40:28.936507
2018-01-31 15:40:28,936 [salt.state       ][INFO    ][2108] Executing state host.present for mdb
2018-01-31 15:40:28,937 [salt.state       ][INFO    ][2108] {'host': 'mdb'}
2018-01-31 15:40:28,937 [salt.state       ][INFO    ][2108] Completed state [mdb] at time 15:40:28.937827 duration_in_ms=1.319
2018-01-31 15:40:28,939 [salt.state       ][INFO    ][2108] Running state [mdb.baremetal-mcp-pike-odl-ha.local] at time 15:40:28.939177
2018-01-31 15:40:28,939 [salt.state       ][INFO    ][2108] Executing state host.present for mdb.baremetal-mcp-pike-odl-ha.local
2018-01-31 15:40:28,940 [salt.state       ][INFO    ][2108] {'host': 'mdb.baremetal-mcp-pike-odl-ha.local'}
2018-01-31 15:40:28,940 [salt.state       ][INFO    ][2108] Completed state [mdb.baremetal-mcp-pike-odl-ha.local] at time 15:40:28.940473 duration_in_ms=1.295
2018-01-31 15:40:28,940 [salt.state       ][INFO    ][2108] Running state [cfg01] at time 15:40:28.940740
2018-01-31 15:40:28,940 [salt.state       ][INFO    ][2108] Executing state host.present for cfg01
2018-01-31 15:40:28,941 [salt.state       ][INFO    ][2108] {'host': 'cfg01'}
2018-01-31 15:40:28,942 [salt.state       ][INFO    ][2108] Completed state [cfg01] at time 15:40:28.942634 duration_in_ms=1.894
2018-01-31 15:40:28,942 [salt.state       ][INFO    ][2108] Running state [cfg01.baremetal-mcp-pike-odl-ha.local] at time 15:40:28.942872
2018-01-31 15:40:28,943 [salt.state       ][INFO    ][2108] Executing state host.present for cfg01.baremetal-mcp-pike-odl-ha.local
2018-01-31 15:40:28,944 [salt.state       ][INFO    ][2108] {'host': 'cfg01.baremetal-mcp-pike-odl-ha.local'}
2018-01-31 15:40:28,944 [salt.state       ][INFO    ][2108] Completed state [cfg01.baremetal-mcp-pike-odl-ha.local] at time 15:40:28.944199 duration_in_ms=1.327
2018-01-31 15:40:28,944 [salt.state       ][INFO    ][2108] Running state [prx01] at time 15:40:28.944439
2018-01-31 15:40:28,944 [salt.state       ][INFO    ][2108] Executing state host.present for prx01
2018-01-31 15:40:28,945 [salt.state       ][INFO    ][2108] {'host': 'prx01'}
2018-01-31 15:40:28,945 [salt.state       ][INFO    ][2108] Completed state [prx01] at time 15:40:28.945777 duration_in_ms=1.338
2018-01-31 15:40:28,946 [salt.state       ][INFO    ][2108] Running state [prx01.baremetal-mcp-pike-odl-ha.local] at time 15:40:28.946030
2018-01-31 15:40:28,946 [salt.state       ][INFO    ][2108] Executing state host.present for prx01.baremetal-mcp-pike-odl-ha.local
2018-01-31 15:40:28,947 [salt.state       ][INFO    ][2108] {'host': 'prx01.baremetal-mcp-pike-odl-ha.local'}
2018-01-31 15:40:28,947 [salt.state       ][INFO    ][2108] Completed state [prx01.baremetal-mcp-pike-odl-ha.local] at time 15:40:28.947340 duration_in_ms=1.31
2018-01-31 15:40:28,947 [salt.state       ][INFO    ][2108] Running state [kvm01] at time 15:40:28.947582
2018-01-31 15:40:28,947 [salt.state       ][INFO    ][2108] Executing state host.present for kvm01
2018-01-31 15:40:28,948 [salt.state       ][INFO    ][2108] {'host': 'kvm01'}
2018-01-31 15:40:28,948 [salt.state       ][INFO    ][2108] Completed state [kvm01] at time 15:40:28.948927 duration_in_ms=1.345
2018-01-31 15:40:28,949 [salt.state       ][INFO    ][2108] Running state [kvm01.baremetal-mcp-pike-odl-ha.local] at time 15:40:28.949168
2018-01-31 15:40:28,949 [salt.state       ][INFO    ][2108] Executing state host.present for kvm01.baremetal-mcp-pike-odl-ha.local
2018-01-31 15:40:28,951 [salt.state       ][INFO    ][2108] {'host': 'kvm01.baremetal-mcp-pike-odl-ha.local'}
2018-01-31 15:40:28,951 [salt.state       ][INFO    ][2108] Completed state [kvm01.baremetal-mcp-pike-odl-ha.local] at time 15:40:28.951380 duration_in_ms=2.212
2018-01-31 15:40:28,951 [salt.state       ][INFO    ][2108] Running state [kvm03] at time 15:40:28.951621
2018-01-31 15:40:28,951 [salt.state       ][INFO    ][2108] Executing state host.present for kvm03
2018-01-31 15:40:28,953 [salt.state       ][INFO    ][2108] {'host': 'kvm03'}
2018-01-31 15:40:28,953 [salt.state       ][INFO    ][2108] Completed state [kvm03] at time 15:40:28.953470 duration_in_ms=1.849
2018-01-31 15:40:28,953 [salt.state       ][INFO    ][2108] Running state [kvm03.baremetal-mcp-pike-odl-ha.local] at time 15:40:28.953713
2018-01-31 15:40:28,953 [salt.state       ][INFO    ][2108] Executing state host.present for kvm03.baremetal-mcp-pike-odl-ha.local
2018-01-31 15:40:28,955 [salt.state       ][INFO    ][2108] {'host': 'kvm03.baremetal-mcp-pike-odl-ha.local'}
2018-01-31 15:40:28,955 [salt.state       ][INFO    ][2108] Completed state [kvm03.baremetal-mcp-pike-odl-ha.local] at time 15:40:28.955362 duration_in_ms=1.649
2018-01-31 15:40:28,955 [salt.state       ][INFO    ][2108] Running state [kvm02] at time 15:40:28.955600
2018-01-31 15:40:28,955 [salt.state       ][INFO    ][2108] Executing state host.present for kvm02
2018-01-31 15:40:28,956 [salt.state       ][INFO    ][2108] {'host': 'kvm02'}
2018-01-31 15:40:28,957 [salt.state       ][INFO    ][2108] Completed state [kvm02] at time 15:40:28.956958 duration_in_ms=1.357
2018-01-31 15:40:28,957 [salt.state       ][INFO    ][2108] Running state [kvm02.baremetal-mcp-pike-odl-ha.local] at time 15:40:28.957187
2018-01-31 15:40:28,957 [salt.state       ][INFO    ][2108] Executing state host.present for kvm02.baremetal-mcp-pike-odl-ha.local
2018-01-31 15:40:28,958 [salt.state       ][INFO    ][2108] {'host': 'kvm02.baremetal-mcp-pike-odl-ha.local'}
2018-01-31 15:40:28,958 [salt.state       ][INFO    ][2108] Completed state [kvm02.baremetal-mcp-pike-odl-ha.local] at time 15:40:28.958540 duration_in_ms=1.353
2018-01-31 15:40:28,958 [salt.state       ][INFO    ][2108] Running state [dbs] at time 15:40:28.958785
2018-01-31 15:40:28,959 [salt.state       ][INFO    ][2108] Executing state host.present for dbs
2018-01-31 15:40:28,959 [salt.state       ][INFO    ][2108] {'host': 'dbs'}
2018-01-31 15:40:28,960 [salt.state       ][INFO    ][2108] Completed state [dbs] at time 15:40:28.960124 duration_in_ms=1.339
2018-01-31 15:40:28,960 [salt.state       ][INFO    ][2108] Running state [dbs.baremetal-mcp-pike-odl-ha.local] at time 15:40:28.960356
2018-01-31 15:40:28,960 [salt.state       ][INFO    ][2108] Executing state host.present for dbs.baremetal-mcp-pike-odl-ha.local
2018-01-31 15:40:28,961 [salt.state       ][INFO    ][2108] {'host': 'dbs.baremetal-mcp-pike-odl-ha.local'}
2018-01-31 15:40:28,961 [salt.state       ][INFO    ][2108] Completed state [dbs.baremetal-mcp-pike-odl-ha.local] at time 15:40:28.961752 duration_in_ms=1.396
2018-01-31 15:40:28,962 [salt.state       ][INFO    ][2108] Running state [prx] at time 15:40:28.962804
2018-01-31 15:40:28,963 [salt.state       ][INFO    ][2108] Executing state host.present for prx
2018-01-31 15:40:28,963 [salt.state       ][INFO    ][2108] {'host': 'prx'}
2018-01-31 15:40:28,964 [salt.state       ][INFO    ][2108] Completed state [prx] at time 15:40:28.964163 duration_in_ms=1.359
2018-01-31 15:40:28,964 [salt.state       ][INFO    ][2108] Running state [prx.baremetal-mcp-pike-odl-ha.local] at time 15:40:28.964396
2018-01-31 15:40:28,964 [salt.state       ][INFO    ][2108] Executing state host.present for prx.baremetal-mcp-pike-odl-ha.local
2018-01-31 15:40:28,965 [salt.state       ][INFO    ][2108] {'host': 'prx.baremetal-mcp-pike-odl-ha.local'}
2018-01-31 15:40:28,965 [salt.state       ][INFO    ][2108] Completed state [prx.baremetal-mcp-pike-odl-ha.local] at time 15:40:28.965787 duration_in_ms=1.391
2018-01-31 15:40:28,966 [salt.state       ][INFO    ][2108] Running state [prx02] at time 15:40:28.966576
2018-01-31 15:40:28,966 [salt.state       ][INFO    ][2108] Executing state host.present for prx02
2018-01-31 15:40:28,967 [salt.state       ][INFO    ][2108] {'host': 'prx02'}
2018-01-31 15:40:28,968 [salt.state       ][INFO    ][2108] Completed state [prx02] at time 15:40:28.967957 duration_in_ms=1.381
2018-01-31 15:40:28,968 [salt.state       ][INFO    ][2108] Running state [prx02.baremetal-mcp-pike-odl-ha.local] at time 15:40:28.968188
2018-01-31 15:40:28,968 [salt.state       ][INFO    ][2108] Executing state host.present for prx02.baremetal-mcp-pike-odl-ha.local
2018-01-31 15:40:28,969 [salt.state       ][INFO    ][2108] {'host': 'prx02.baremetal-mcp-pike-odl-ha.local'}
2018-01-31 15:40:28,969 [salt.state       ][INFO    ][2108] Completed state [prx02.baremetal-mcp-pike-odl-ha.local] at time 15:40:28.969610 duration_in_ms=1.422
2018-01-31 15:40:28,969 [salt.state       ][INFO    ][2108] Running state [msg02] at time 15:40:28.969847
2018-01-31 15:40:28,970 [salt.state       ][INFO    ][2108] Executing state host.present for msg02
2018-01-31 15:40:28,971 [salt.state       ][INFO    ][2108] {'host': 'msg02'}
2018-01-31 15:40:28,971 [salt.state       ][INFO    ][2108] Completed state [msg02] at time 15:40:28.971280 duration_in_ms=1.433
2018-01-31 15:40:28,971 [salt.state       ][INFO    ][2108] Running state [msg02.baremetal-mcp-pike-odl-ha.local] at time 15:40:28.971516
2018-01-31 15:40:28,971 [salt.state       ][INFO    ][2108] Executing state host.present for msg02.baremetal-mcp-pike-odl-ha.local
2018-01-31 15:40:28,972 [salt.state       ][INFO    ][2108] {'host': 'msg02.baremetal-mcp-pike-odl-ha.local'}
2018-01-31 15:40:28,973 [salt.state       ][INFO    ][2108] Completed state [msg02.baremetal-mcp-pike-odl-ha.local] at time 15:40:28.972993 duration_in_ms=1.477
2018-01-31 15:40:28,973 [salt.state       ][INFO    ][2108] Running state [msg03] at time 15:40:28.973232
2018-01-31 15:40:28,973 [salt.state       ][INFO    ][2108] Executing state host.present for msg03
2018-01-31 15:40:28,975 [salt.state       ][INFO    ][2108] {'host': 'msg03'}
2018-01-31 15:40:28,975 [salt.state       ][INFO    ][2108] Completed state [msg03] at time 15:40:28.975778 duration_in_ms=2.546
2018-01-31 15:40:28,976 [salt.state       ][INFO    ][2108] Running state [msg03.baremetal-mcp-pike-odl-ha.local] at time 15:40:28.976030
2018-01-31 15:40:28,976 [salt.state       ][INFO    ][2108] Executing state host.present for msg03.baremetal-mcp-pike-odl-ha.local
2018-01-31 15:40:28,977 [salt.state       ][INFO    ][2108] {'host': 'msg03.baremetal-mcp-pike-odl-ha.local'}
2018-01-31 15:40:28,977 [salt.state       ][INFO    ][2108] Completed state [msg03.baremetal-mcp-pike-odl-ha.local] at time 15:40:28.977632 duration_in_ms=1.602
2018-01-31 15:40:28,977 [salt.state       ][INFO    ][2108] Running state [msg01] at time 15:40:28.977874
2018-01-31 15:40:28,978 [salt.state       ][INFO    ][2108] Executing state host.present for msg01
2018-01-31 15:40:28,979 [salt.state       ][INFO    ][2108] {'host': 'msg01'}
2018-01-31 15:40:28,979 [salt.state       ][INFO    ][2108] Completed state [msg01] at time 15:40:28.979843 duration_in_ms=1.969
2018-01-31 15:40:28,980 [salt.state       ][INFO    ][2108] Running state [msg01.baremetal-mcp-pike-odl-ha.local] at time 15:40:28.980078
2018-01-31 15:40:28,980 [salt.state       ][INFO    ][2108] Executing state host.present for msg01.baremetal-mcp-pike-odl-ha.local
2018-01-31 15:40:28,981 [salt.state       ][INFO    ][2108] {'host': 'msg01.baremetal-mcp-pike-odl-ha.local'}
2018-01-31 15:40:28,981 [salt.state       ][INFO    ][2108] Completed state [msg01.baremetal-mcp-pike-odl-ha.local] at time 15:40:28.981541 duration_in_ms=1.463
2018-01-31 15:40:28,981 [salt.state       ][INFO    ][2108] Running state [msg] at time 15:40:28.981783
2018-01-31 15:40:28,982 [salt.state       ][INFO    ][2108] Executing state host.present for msg
2018-01-31 15:40:28,983 [salt.state       ][INFO    ][2108] {'host': 'msg'}
2018-01-31 15:40:28,983 [salt.state       ][INFO    ][2108] Completed state [msg] at time 15:40:28.983211 duration_in_ms=1.427
2018-01-31 15:40:28,983 [salt.state       ][INFO    ][2108] Running state [msg.baremetal-mcp-pike-odl-ha.local] at time 15:40:28.983441
2018-01-31 15:40:28,983 [salt.state       ][INFO    ][2108] Executing state host.present for msg.baremetal-mcp-pike-odl-ha.local
2018-01-31 15:40:28,984 [salt.state       ][INFO    ][2108] {'host': 'msg.baremetal-mcp-pike-odl-ha.local'}
2018-01-31 15:40:28,984 [salt.state       ][INFO    ][2108] Completed state [msg.baremetal-mcp-pike-odl-ha.local] at time 15:40:28.984951 duration_in_ms=1.51
2018-01-31 15:40:28,985 [salt.state       ][INFO    ][2108] Running state [cfg01] at time 15:40:28.985189
2018-01-31 15:40:28,985 [salt.state       ][INFO    ][2108] Executing state host.present for cfg01
2018-01-31 15:40:28,985 [salt.state       ][INFO    ][2108] Host cfg01 (192.168.10.100) already present
2018-01-31 15:40:28,988 [salt.state       ][INFO    ][2108] Completed state [cfg01] at time 15:40:28.987955 duration_in_ms=2.767
2018-01-31 15:40:28,988 [salt.state       ][INFO    ][2108] Running state [cfg01.baremetal-mcp-pike-odl-ha.local] at time 15:40:28.988192
2018-01-31 15:40:28,988 [salt.state       ][INFO    ][2108] Executing state host.present for cfg01.baremetal-mcp-pike-odl-ha.local
2018-01-31 15:40:28,988 [salt.state       ][INFO    ][2108] Host cfg01.baremetal-mcp-pike-odl-ha.local (192.168.10.100) already present
2018-01-31 15:40:28,989 [salt.state       ][INFO    ][2108] Completed state [cfg01.baremetal-mcp-pike-odl-ha.local] at time 15:40:28.989072 duration_in_ms=0.88
2018-01-31 15:40:28,989 [salt.state       ][INFO    ][2108] Running state [cmp002] at time 15:40:28.989306
2018-01-31 15:40:28,989 [salt.state       ][INFO    ][2108] Executing state host.present for cmp002
2018-01-31 15:40:28,991 [salt.state       ][INFO    ][2108] {'host': 'cmp002'}
2018-01-31 15:40:28,991 [salt.state       ][INFO    ][2108] Completed state [cmp002] at time 15:40:28.991321 duration_in_ms=2.015
2018-01-31 15:40:28,991 [salt.state       ][INFO    ][2108] Running state [cmp002.baremetal-mcp-pike-odl-ha.local] at time 15:40:28.991556
2018-01-31 15:40:28,991 [salt.state       ][INFO    ][2108] Executing state host.present for cmp002.baremetal-mcp-pike-odl-ha.local
2018-01-31 15:40:28,992 [salt.state       ][INFO    ][2108] {'host': 'cmp002.baremetal-mcp-pike-odl-ha.local'}
2018-01-31 15:40:28,993 [salt.state       ][INFO    ][2108] Completed state [cmp002.baremetal-mcp-pike-odl-ha.local] at time 15:40:28.993068 duration_in_ms=1.512
2018-01-31 15:40:28,993 [salt.state       ][INFO    ][2108] Running state [cmp001] at time 15:40:28.993307
2018-01-31 15:40:28,993 [salt.state       ][INFO    ][2108] Executing state host.present for cmp001
2018-01-31 15:40:28,994 [salt.state       ][INFO    ][2108] {'host': 'cmp001'}
2018-01-31 15:40:28,995 [salt.state       ][INFO    ][2108] Completed state [cmp001] at time 15:40:28.995060 duration_in_ms=1.753
2018-01-31 15:40:28,995 [salt.state       ][INFO    ][2108] Running state [cmp001.baremetal-mcp-pike-odl-ha.local] at time 15:40:28.995303
2018-01-31 15:40:28,995 [salt.state       ][INFO    ][2108] Executing state host.present for cmp001.baremetal-mcp-pike-odl-ha.local
2018-01-31 15:40:28,996 [salt.state       ][INFO    ][2108] {'host': 'cmp001.baremetal-mcp-pike-odl-ha.local'}
2018-01-31 15:40:28,996 [salt.state       ][INFO    ][2108] Completed state [cmp001.baremetal-mcp-pike-odl-ha.local] at time 15:40:28.996807 duration_in_ms=1.504
2018-01-31 15:40:28,997 [salt.state       ][INFO    ][2108] Running state [dbs01] at time 15:40:28.997043
2018-01-31 15:40:28,997 [salt.state       ][INFO    ][2108] Executing state host.present for dbs01
2018-01-31 15:40:28,999 [salt.state       ][INFO    ][2108] {'host': 'dbs01'}
2018-01-31 15:40:28,999 [salt.state       ][INFO    ][2108] Completed state [dbs01] at time 15:40:28.999517 duration_in_ms=2.473
2018-01-31 15:40:28,999 [salt.state       ][INFO    ][2108] Running state [dbs01.baremetal-mcp-pike-odl-ha.local] at time 15:40:28.999770
2018-01-31 15:40:29,000 [salt.state       ][INFO    ][2108] Executing state host.present for dbs01.baremetal-mcp-pike-odl-ha.local
2018-01-31 15:40:29,001 [salt.state       ][INFO    ][2108] {'host': 'dbs01.baremetal-mcp-pike-odl-ha.local'}
2018-01-31 15:40:29,001 [salt.state       ][INFO    ][2108] Completed state [dbs01.baremetal-mcp-pike-odl-ha.local] at time 15:40:29.001296 duration_in_ms=1.524
2018-01-31 15:40:29,001 [salt.state       ][INFO    ][2108] Running state [dbs02] at time 15:40:29.001543
2018-01-31 15:40:29,001 [salt.state       ][INFO    ][2108] Executing state host.present for dbs02
2018-01-31 15:40:29,002 [salt.state       ][INFO    ][2108] {'host': 'dbs02'}
2018-01-31 15:40:29,003 [salt.state       ][INFO    ][2108] Completed state [dbs02] at time 15:40:29.003047 duration_in_ms=1.504
2018-01-31 15:40:29,003 [salt.state       ][INFO    ][2108] Running state [dbs02.baremetal-mcp-pike-odl-ha.local] at time 15:40:29.003280
2018-01-31 15:40:29,003 [salt.state       ][INFO    ][2108] Executing state host.present for dbs02.baremetal-mcp-pike-odl-ha.local
2018-01-31 15:40:29,004 [salt.state       ][INFO    ][2108] {'host': 'dbs02.baremetal-mcp-pike-odl-ha.local'}
2018-01-31 15:40:29,004 [salt.state       ][INFO    ][2108] Completed state [dbs02.baremetal-mcp-pike-odl-ha.local] at time 15:40:29.004806 duration_in_ms=1.526
2018-01-31 15:40:29,005 [salt.state       ][INFO    ][2108] Running state [dbs03] at time 15:40:29.005040
2018-01-31 15:40:29,005 [salt.state       ][INFO    ][2108] Executing state host.present for dbs03
2018-01-31 15:40:29,006 [salt.state       ][INFO    ][2108] {'host': 'dbs03'}
2018-01-31 15:40:29,006 [salt.state       ][INFO    ][2108] Completed state [dbs03] at time 15:40:29.006844 duration_in_ms=1.804
2018-01-31 15:40:29,007 [salt.state       ][INFO    ][2108] Running state [dbs03.baremetal-mcp-pike-odl-ha.local] at time 15:40:29.007075
2018-01-31 15:40:29,007 [salt.state       ][INFO    ][2108] Executing state host.present for dbs03.baremetal-mcp-pike-odl-ha.local
2018-01-31 15:40:29,008 [salt.state       ][INFO    ][2108] {'host': 'dbs03.baremetal-mcp-pike-odl-ha.local'}
2018-01-31 15:40:29,008 [salt.state       ][INFO    ][2108] Completed state [dbs03.baremetal-mcp-pike-odl-ha.local] at time 15:40:29.008608 duration_in_ms=1.533
2018-01-31 15:40:29,008 [salt.state       ][INFO    ][2108] Running state [odl01] at time 15:40:29.008855
2018-01-31 15:40:29,009 [salt.state       ][INFO    ][2108] Executing state host.present for odl01
2018-01-31 15:40:29,011 [salt.state       ][INFO    ][2108] {'host': 'odl01'}
2018-01-31 15:40:29,011 [salt.state       ][INFO    ][2108] Completed state [odl01] at time 15:40:29.011216 duration_in_ms=2.361
2018-01-31 15:40:29,011 [salt.state       ][INFO    ][2108] Running state [odl01.baremetal-mcp-pike-odl-ha.local] at time 15:40:29.011449
2018-01-31 15:40:29,011 [salt.state       ][INFO    ][2108] Executing state host.present for odl01.baremetal-mcp-pike-odl-ha.local
2018-01-31 15:40:29,012 [salt.state       ][INFO    ][2108] {'host': 'odl01.baremetal-mcp-pike-odl-ha.local'}
2018-01-31 15:40:29,013 [salt.state       ][INFO    ][2108] Completed state [odl01.baremetal-mcp-pike-odl-ha.local] at time 15:40:29.013015 duration_in_ms=1.565
2018-01-31 15:40:29,013 [salt.state       ][INFO    ][2108] Running state [mas01] at time 15:40:29.013252
2018-01-31 15:40:29,013 [salt.state       ][INFO    ][2108] Executing state host.present for mas01
2018-01-31 15:40:29,015 [salt.state       ][INFO    ][2108] {'host': 'mas01'}
2018-01-31 15:40:29,015 [salt.state       ][INFO    ][2108] Completed state [mas01] at time 15:40:29.015249 duration_in_ms=1.997
2018-01-31 15:40:29,015 [salt.state       ][INFO    ][2108] Running state [mas01.baremetal-mcp-pike-odl-ha.local] at time 15:40:29.015501
2018-01-31 15:40:29,015 [salt.state       ][INFO    ][2108] Executing state host.present for mas01.baremetal-mcp-pike-odl-ha.local
2018-01-31 15:40:29,016 [salt.state       ][INFO    ][2108] {'host': 'mas01.baremetal-mcp-pike-odl-ha.local'}
2018-01-31 15:40:29,017 [salt.state       ][INFO    ][2108] Completed state [mas01.baremetal-mcp-pike-odl-ha.local] at time 15:40:29.017084 duration_in_ms=1.583
2018-01-31 15:40:29,017 [salt.state       ][INFO    ][2108] Running state [ctl02] at time 15:40:29.017326
2018-01-31 15:40:29,017 [salt.state       ][INFO    ][2108] Executing state host.present for ctl02
2018-01-31 15:40:29,018 [salt.state       ][INFO    ][2108] {'host': 'ctl02'}
2018-01-31 15:40:29,018 [salt.state       ][INFO    ][2108] Completed state [ctl02] at time 15:40:29.018899 duration_in_ms=1.573
2018-01-31 15:40:29,019 [salt.state       ][INFO    ][2108] Running state [ctl02.baremetal-mcp-pike-odl-ha.local] at time 15:40:29.019130
2018-01-31 15:40:29,019 [salt.state       ][INFO    ][2108] Executing state host.present for ctl02.baremetal-mcp-pike-odl-ha.local
2018-01-31 15:40:29,020 [salt.state       ][INFO    ][2108] {'host': 'ctl02.baremetal-mcp-pike-odl-ha.local'}
2018-01-31 15:40:29,020 [salt.state       ][INFO    ][2108] Completed state [ctl02.baremetal-mcp-pike-odl-ha.local] at time 15:40:29.020700 duration_in_ms=1.569
2018-01-31 15:40:29,020 [salt.state       ][INFO    ][2108] Running state [ctl03] at time 15:40:29.020942
2018-01-31 15:40:29,021 [salt.state       ][INFO    ][2108] Executing state host.present for ctl03
2018-01-31 15:40:29,022 [salt.state       ][INFO    ][2108] {'host': 'ctl03'}
2018-01-31 15:40:29,022 [salt.state       ][INFO    ][2108] Completed state [ctl03] at time 15:40:29.022807 duration_in_ms=1.866
2018-01-31 15:40:29,023 [salt.state       ][INFO    ][2108] Running state [ctl03.baremetal-mcp-pike-odl-ha.local] at time 15:40:29.023041
2018-01-31 15:40:29,023 [salt.state       ][INFO    ][2108] Executing state host.present for ctl03.baremetal-mcp-pike-odl-ha.local
2018-01-31 15:40:29,024 [salt.state       ][INFO    ][2108] {'host': 'ctl03.baremetal-mcp-pike-odl-ha.local'}
2018-01-31 15:40:29,024 [salt.state       ][INFO    ][2108] Completed state [ctl03.baremetal-mcp-pike-odl-ha.local] at time 15:40:29.024633 duration_in_ms=1.592
2018-01-31 15:40:29,024 [salt.state       ][INFO    ][2108] Running state [ctl01] at time 15:40:29.024871
2018-01-31 15:40:29,025 [salt.state       ][INFO    ][2108] Executing state host.present for ctl01
2018-01-31 15:40:29,026 [salt.state       ][INFO    ][2108] {'host': 'ctl01'}
2018-01-31 15:40:29,026 [salt.state       ][INFO    ][2108] Completed state [ctl01] at time 15:40:29.026442 duration_in_ms=1.571
2018-01-31 15:40:29,026 [salt.state       ][INFO    ][2108] Running state [ctl01.baremetal-mcp-pike-odl-ha.local] at time 15:40:29.026676
2018-01-31 15:40:29,026 [salt.state       ][INFO    ][2108] Executing state host.present for ctl01.baremetal-mcp-pike-odl-ha.local
2018-01-31 15:40:29,028 [salt.state       ][INFO    ][2108] {'host': 'ctl01.baremetal-mcp-pike-odl-ha.local'}
2018-01-31 15:40:29,028 [salt.state       ][INFO    ][2108] Completed state [ctl01.baremetal-mcp-pike-odl-ha.local] at time 15:40:29.028399 duration_in_ms=1.723
2018-01-31 15:40:29,028 [salt.state       ][INFO    ][2108] Running state [ctl] at time 15:40:29.028661
2018-01-31 15:40:29,028 [salt.state       ][INFO    ][2108] Executing state host.present for ctl
2018-01-31 15:40:29,030 [salt.state       ][INFO    ][2108] {'host': 'ctl'}
2018-01-31 15:40:29,030 [salt.state       ][INFO    ][2108] Completed state [ctl] at time 15:40:29.030269 duration_in_ms=1.608
2018-01-31 15:40:29,030 [salt.state       ][INFO    ][2108] Running state [ctl.baremetal-mcp-pike-odl-ha.local] at time 15:40:29.030507
2018-01-31 15:40:29,030 [salt.state       ][INFO    ][2108] Executing state host.present for ctl.baremetal-mcp-pike-odl-ha.local
2018-01-31 15:40:29,032 [salt.state       ][INFO    ][2108] {'host': 'ctl.baremetal-mcp-pike-odl-ha.local'}
2018-01-31 15:40:29,032 [salt.state       ][INFO    ][2108] Completed state [ctl.baremetal-mcp-pike-odl-ha.local] at time 15:40:29.032383 duration_in_ms=1.876
2018-01-31 15:40:29,032 [salt.state       ][INFO    ][2108] Running state [/etc/network/interfaces.d/50-cloud-init.cfg] at time 15:40:29.032643
2018-01-31 15:40:29,032 [salt.state       ][INFO    ][2108] Executing state file.absent for /etc/network/interfaces.d/50-cloud-init.cfg
2018-01-31 15:40:29,033 [salt.state       ][INFO    ][2108] {'removed': '/etc/network/interfaces.d/50-cloud-init.cfg'}
2018-01-31 15:40:29,033 [salt.state       ][INFO    ][2108] Completed state [/etc/network/interfaces.d/50-cloud-init.cfg] at time 15:40:29.033500 duration_in_ms=0.857
2018-01-31 15:40:29,041 [salt.state       ][INFO    ][2108] Running state [ens2] at time 15:40:29.041443
2018-01-31 15:40:29,041 [salt.state       ][INFO    ][2108] Executing state network.managed for ens2
2018-01-31 15:40:29,205 [salt.loaded.int.module.cmdmod][INFO    ][2108] Executing command ['ifdown', 'ens2'] in directory '/root'
2018-01-31 15:40:30,365 [salt.loaded.int.module.cmdmod][INFO    ][2108] Executing command ['ifup', 'ens2'] in directory '/root'
2018-01-31 15:40:31,615 [salt.state       ][INFO    ][2108] {'interface': 'Added network interface.', 'status': 'Interface ens2 restart to validate'}
2018-01-31 15:40:31,616 [salt.state       ][INFO    ][2108] Completed state [ens2] at time 15:40:31.616684 duration_in_ms=2575.24
2018-01-31 15:40:31,617 [salt.state       ][INFO    ][2108] Running state [ens3] at time 15:40:31.617401
2018-01-31 15:40:31,618 [salt.state       ][INFO    ][2108] Executing state network.managed for ens3
2018-01-31 15:40:31,647 [salt.loaded.int.module.cmdmod][INFO    ][2108] Executing command ['ifup', 'ens3'] in directory '/root'
2018-01-31 15:40:32,445 [salt.state       ][INFO    ][2108] {'interface': 'Added network interface.', 'status': 'Interface ens3 is up'}
2018-01-31 15:40:32,446 [salt.state       ][INFO    ][2108] Completed state [ens3] at time 15:40:32.445948 duration_in_ms=828.547
2018-01-31 15:40:32,447 [salt.state       ][INFO    ][2108] Running state [/etc/profile.d/proxy.sh] at time 15:40:32.447108
2018-01-31 15:40:32,447 [salt.state       ][INFO    ][2108] Executing state file.absent for /etc/profile.d/proxy.sh
2018-01-31 15:40:32,448 [salt.state       ][INFO    ][2108] File /etc/profile.d/proxy.sh is not present
2018-01-31 15:40:32,448 [salt.state       ][INFO    ][2108] Completed state [/etc/profile.d/proxy.sh] at time 15:40:32.448845 duration_in_ms=1.737
2018-01-31 15:40:32,449 [salt.state       ][INFO    ][2108] Running state [/etc/apt/apt.conf.d/95proxies] at time 15:40:32.449323
2018-01-31 15:40:32,449 [salt.state       ][INFO    ][2108] Executing state file.absent for /etc/apt/apt.conf.d/95proxies
2018-01-31 15:40:32,450 [salt.state       ][INFO    ][2108] File /etc/apt/apt.conf.d/95proxies is not present
2018-01-31 15:40:32,450 [salt.state       ][INFO    ][2108] Completed state [/etc/apt/apt.conf.d/95proxies] at time 15:40:32.450746 duration_in_ms=1.423
2018-01-31 15:40:32,463 [salt.state       ][INFO    ][2108] Running state [ntp] at time 15:40:32.463408
2018-01-31 15:40:32,463 [salt.state       ][INFO    ][2108] Executing state pkg.installed for ntp
2018-01-31 15:40:32,848 [salt.loaded.int.module.cmdmod][INFO    ][2108] Executing command ['dpkg', '--get-selections', '*'] in directory '/root'
2018-01-31 15:40:32,873 [salt.loaded.int.module.cmdmod][INFO    ][2108] 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-01-31 15:40:36,144 [salt.loaded.int.module.cmdmod][INFO    ][2108] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2018-01-31 15:40:36,188 [salt.state       ][INFO    ][2108] Made the following changes:
'ntp' changed from 'absent' to '1:4.2.8p4+dfsg-3ubuntu5.7'
'libopts25' changed from 'absent' to '1:5.18.7-3'

2018-01-31 15:40:36,208 [salt.state       ][INFO    ][2108] Loading fresh modules for state activity
2018-01-31 15:40:36,241 [salt.state       ][INFO    ][2108] Completed state [ntp] at time 15:40:36.241069 duration_in_ms=3777.66
2018-01-31 15:40:36,245 [salt.state       ][INFO    ][2108] Running state [/etc/ntp.conf] at time 15:40:36.245416
2018-01-31 15:40:36,245 [salt.state       ][INFO    ][2108] Executing state file.managed for /etc/ntp.conf
2018-01-31 15:40:36,283 [salt.fileclient  ][INFO    ][2108] Fetching file from saltenv 'base', ** done ** 'ntp/files/ntp.conf'
2018-01-31 15:40:36,336 [salt.state       ][INFO    ][2108] File changed:
--- 
+++ 
@@ -1,66 +1,24 @@
-# /etc/ntp.conf, configuration for ntpd; see ntp.conf(5) for help
 
-driftfile /var/lib/ntp/ntp.drift
 
-# Enable this if you want statistics to be logged.
-#statsdir /var/log/ntpstats/
+# ntpd will only synchronize your clock.
 
-statistics loopstats peerstats clockstats
-filegen loopstats file loopstats type day enable
-filegen peerstats file peerstats type day enable
-filegen clockstats file clockstats type day enable
+# For details, see:
+# - the ntp.conf man page
+# - http://support.ntp.org/bin/view/Support/GettingStarted
+# - https://wiki.archlinux.org/index.php/Network_Time_Protocol_daemon
 
-# Specify one or more NTP servers.
+# Associate to cloud NTP pool servers
+server 1.pool.ntp.org iburst
+server 0.pool.ntp.org
 
-# Use servers from the NTP Pool Project. Approved by Ubuntu Technical Board
-# on 2011-02-08 (LP: #104525). See http://www.pool.ntp.org/join.html for
-# more information.
-pool 0.ubuntu.pool.ntp.org iburst
-pool 1.ubuntu.pool.ntp.org iburst
-pool 2.ubuntu.pool.ntp.org iburst
-pool 3.ubuntu.pool.ntp.org iburst
-
-# Use Ubuntu's ntp server as a fallback.
-pool ntp.ubuntu.com
-
-# Access control configuration; see /usr/share/doc/ntp-doc/html/accopt.html for
-# details.  The web page <http://support.ntp.org/bin/view/Support/AccessRestrictions>
-# might also be helpful.
-#
-# Note that "restrict" applies to both servers and clients, so a configuration
-# that might be intended to block requests from certain clients could also end
-# up blocking replies from your own upstream servers.
-
-# By default, exchange time with everybody, but don't allow configuration.
-restrict -4 default kod notrap nomodify nopeer noquery limited
-restrict -6 default kod notrap nomodify nopeer noquery limited
-
-# Local users may interrogate the ntp server more closely.
+# Only allow read-only access from localhost
+restrict default noquery nopeer
 restrict 127.0.0.1
 restrict ::1
 
-# Needed for adding pool entries
-restrict source notrap nomodify noquery
-
-# Clients from this (example!) subnet have unlimited access, but only if
-# cryptographically authenticated.
-#restrict 192.168.123.0 mask 255.255.255.0 notrust
+# mode7 is required for collectd monitoring
 
 
-# If you want to provide time to your local subnet, change the next line.
-# (Again, the address is an example only.)
-#broadcast 192.168.123.255
-
-# If you want to listen to time broadcasts on your local subnet, de-comment the
-# next lines.  Please do this only if you trust everybody on the network!
-#disable auth
-#broadcastclient
-
-#Changes recquired to use pps synchonisation as explained in documentation:
-#http://www.ntp.org/ntpfaq/NTP-s-config-adv.htm#AEN3918
-
-#server 127.127.8.1 mode 135 prefer    # Meinberg GPS167 with PPS
-#fudge 127.127.8.1 time1 0.0042        # relative to PPS for my hardware
-
-#server 127.127.22.1                   # ATOM(PPS)
-#fudge 127.127.22.1 flag3 1            # enable PPS API
+# Location of drift file
+driftfile /var/lib/ntp/ntp.drift
+logfile /var/log/ntp.log
2018-01-31 15:40:36,336 [salt.state       ][INFO    ][2108] Completed state [/etc/ntp.conf] at time 15:40:36.336673 duration_in_ms=91.256
2018-01-31 15:40:36,390 [salt.state       ][INFO    ][2108] Running state [ntp] at time 15:40:36.390732
2018-01-31 15:40:36,391 [salt.state       ][INFO    ][2108] Executing state service.running for ntp
2018-01-31 15:40:36,393 [salt.loaded.int.module.cmdmod][INFO    ][2108] Executing command ['systemctl', 'status', 'ntp.service', '-n', '0'] in directory '/root'
2018-01-31 15:40:36,413 [salt.loaded.int.module.cmdmod][INFO    ][2108] Executing command ['systemctl', 'is-active', 'ntp.service'] in directory '/root'
2018-01-31 15:40:36,436 [salt.loaded.int.module.cmdmod][INFO    ][2108] Executing command ['systemctl', 'is-enabled', 'ntp.service'] in directory '/root'
2018-01-31 15:40:36,458 [salt.state       ][INFO    ][2108] The service ntp is already running
2018-01-31 15:40:36,459 [salt.state       ][INFO    ][2108] Completed state [ntp] at time 15:40:36.459379 duration_in_ms=68.646
2018-01-31 15:40:36,460 [salt.state       ][INFO    ][2108] Running state [ntp] at time 15:40:36.460103
2018-01-31 15:40:36,460 [salt.state       ][INFO    ][2108] Executing state service.mod_watch for ntp
2018-01-31 15:40:36,462 [salt.loaded.int.module.cmdmod][INFO    ][2108] Executing command ['systemctl', 'is-active', 'ntp.service'] in directory '/root'
2018-01-31 15:40:36,481 [salt.loaded.int.module.cmdmod][INFO    ][2108] Executing command ['systemctl', 'is-enabled', 'ntp.service'] in directory '/root'
2018-01-31 15:40:36,504 [salt.loaded.int.module.cmdmod][INFO    ][2108] Executing command ['systemd-run', '--scope', 'systemctl', 'restart', 'ntp.service'] in directory '/root'
2018-01-31 15:40:36,620 [salt.state       ][INFO    ][2108] {'ntp': True}
2018-01-31 15:40:36,621 [salt.state       ][INFO    ][2108] Completed state [ntp] at time 15:40:36.621725 duration_in_ms=161.622
2018-01-31 15:40:36,628 [salt.minion      ][INFO    ][2108] Returning information for job: 20180131153948814523
2018-01-31 15:40:58,875 [salt.minion      ][INFO    ][2017] User sudo_ubuntu Executing command state.apply with jid 20180131154100272253
2018-01-31 15:40:58,904 [salt.minion      ][INFO    ][6798] Starting a new job with PID 6798
2018-01-31 15:41:02,360 [salt.state       ][INFO    ][6798] Loading fresh modules for state activity
2018-01-31 15:41:05,982 [salt.state       ][INFO    ][6798] Running state [/etc/environment] at time 15:41:05.982832
2018-01-31 15:41:05,983 [salt.state       ][INFO    ][6798] Executing state file.blockreplace for /etc/environment
2018-01-31 15:41:05,991 [salt.state       ][INFO    ][6798] 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-01-31 15:41:05,993 [salt.state       ][INFO    ][6798] Completed state [/etc/environment] at time 15:41:05.993083 duration_in_ms=10.251
2018-01-31 15:41:05,993 [salt.state       ][INFO    ][6798] Running state [/etc/profile.d] at time 15:41:05.993463
2018-01-31 15:41:05,993 [salt.state       ][INFO    ][6798] Executing state file.directory for /etc/profile.d
2018-01-31 15:41:05,995 [salt.state       ][INFO    ][6798] Directory /etc/profile.d is in the correct state
2018-01-31 15:41:05,995 [salt.state       ][INFO    ][6798] Completed state [/etc/profile.d] at time 15:41:05.995682 duration_in_ms=2.219
2018-01-31 15:41:06,551 [salt.state       ][INFO    ][6798] Running state [/etc/apt/apt.conf.d/99compression-workaround-salt] at time 15:41:06.551116
2018-01-31 15:41:06,551 [salt.state       ][INFO    ][6798] Executing state file.managed for /etc/apt/apt.conf.d/99compression-workaround-salt
2018-01-31 15:41:06,589 [salt.state       ][INFO    ][6798] File /etc/apt/apt.conf.d/99compression-workaround-salt is in the correct state
2018-01-31 15:41:06,590 [salt.state       ][INFO    ][6798] Completed state [/etc/apt/apt.conf.d/99compression-workaround-salt] at time 15:41:06.590326 duration_in_ms=39.21
2018-01-31 15:41:06,590 [salt.state       ][INFO    ][6798] Running state [/etc/apt/apt.conf.d/99prefer_ipv4-salt] at time 15:41:06.590621
2018-01-31 15:41:06,590 [salt.state       ][INFO    ][6798] Executing state file.managed for /etc/apt/apt.conf.d/99prefer_ipv4-salt
2018-01-31 15:41:06,612 [salt.state       ][INFO    ][6798] File /etc/apt/apt.conf.d/99prefer_ipv4-salt is in the correct state
2018-01-31 15:41:06,612 [salt.state       ][INFO    ][6798] Completed state [/etc/apt/apt.conf.d/99prefer_ipv4-salt] at time 15:41:06.612720 duration_in_ms=22.098
2018-01-31 15:41:06,614 [salt.state       ][INFO    ][6798] Running state [linux_repo_prereq_pkgs] at time 15:41:06.614048
2018-01-31 15:41:06,614 [salt.state       ][INFO    ][6798] Executing state pkg.installed for linux_repo_prereq_pkgs
2018-01-31 15:41:06,614 [salt.loaded.int.module.cmdmod][INFO    ][6798] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2018-01-31 15:41:07,105 [salt.state       ][INFO    ][6798] All specified packages are already installed
2018-01-31 15:41:07,105 [salt.state       ][INFO    ][6798] Completed state [linux_repo_prereq_pkgs] at time 15:41:07.105544 duration_in_ms=491.495
2018-01-31 15:41:07,105 [salt.state       ][INFO    ][6798] Running state [/etc/apt/apt.conf.d/99proxies-salt-mk_openstack] at time 15:41:07.105859
2018-01-31 15:41:07,106 [salt.state       ][INFO    ][6798] Executing state file.absent for /etc/apt/apt.conf.d/99proxies-salt-mk_openstack
2018-01-31 15:41:07,107 [salt.state       ][INFO    ][6798] File /etc/apt/apt.conf.d/99proxies-salt-mk_openstack is not present
2018-01-31 15:41:07,107 [salt.state       ][INFO    ][6798] Completed state [/etc/apt/apt.conf.d/99proxies-salt-mk_openstack] at time 15:41:07.107351 duration_in_ms=1.493
2018-01-31 15:41:07,107 [salt.state       ][INFO    ][6798] Running state [/etc/apt/preferences.d/mk_openstack] at time 15:41:07.107575
2018-01-31 15:41:07,107 [salt.state       ][INFO    ][6798] Executing state file.managed for /etc/apt/preferences.d/mk_openstack
2018-01-31 15:41:07,217 [salt.state       ][INFO    ][6798] File /etc/apt/preferences.d/mk_openstack is in the correct state
2018-01-31 15:41:07,217 [salt.state       ][INFO    ][6798] Completed state [/etc/apt/preferences.d/mk_openstack] at time 15:41:07.217397 duration_in_ms=109.822
2018-01-31 15:41:07,219 [salt.state       ][INFO    ][6798] Running state [curl -s http://apt.mirantis.com/public.gpg | apt-key add -] at time 15:41:07.219587
2018-01-31 15:41:07,219 [salt.state       ][INFO    ][6798] Executing state cmd.run for curl -s http://apt.mirantis.com/public.gpg | apt-key add -
2018-01-31 15:41:07,220 [salt.loaded.int.module.cmdmod][INFO    ][6798] Executing command 'curl -s http://apt.mirantis.com/public.gpg | apt-key add -' in directory '/root'
2018-01-31 15:41:07,376 [salt.state       ][INFO    ][6798] {'pid': 6858, 'retcode': 0, 'stderr': '', 'stdout': 'OK'}
2018-01-31 15:41:07,377 [salt.state       ][INFO    ][6798] Completed state [curl -s http://apt.mirantis.com/public.gpg | apt-key add -] at time 15:41:07.377168 duration_in_ms=157.58
2018-01-31 15:41:07,383 [salt.state       ][INFO    ][6798] Running state [deb [arch=amd64] http://apt.mirantis.com/xenial/ stable pike] at time 15:41:07.383063
2018-01-31 15:41:07,383 [salt.state       ][INFO    ][6798] Executing state pkgrepo.managed for deb [arch=amd64] http://apt.mirantis.com/xenial/ stable pike
2018-01-31 15:41:07,446 [salt.state       ][INFO    ][6798] Package repo 'deb [arch=amd64] http://apt.mirantis.com/xenial/ stable pike' already configured
2018-01-31 15:41:07,446 [salt.state       ][INFO    ][6798] Completed state [deb [arch=amd64] http://apt.mirantis.com/xenial/ stable pike] at time 15:41:07.446924 duration_in_ms=63.864
2018-01-31 15:41:07,447 [salt.state       ][INFO    ][6798] Running state [/etc/apt/apt.conf.d/99proxies-salt-mirantis_openstack] at time 15:41:07.447196
2018-01-31 15:41:07,447 [salt.state       ][INFO    ][6798] Executing state file.absent for /etc/apt/apt.conf.d/99proxies-salt-mirantis_openstack
2018-01-31 15:41:07,447 [salt.state       ][INFO    ][6798] File /etc/apt/apt.conf.d/99proxies-salt-mirantis_openstack is not present
2018-01-31 15:41:07,448 [salt.state       ][INFO    ][6798] Completed state [/etc/apt/apt.conf.d/99proxies-salt-mirantis_openstack] at time 15:41:07.448070 duration_in_ms=0.874
2018-01-31 15:41:07,448 [salt.state       ][INFO    ][6798] Running state [/etc/apt/preferences.d/mirantis_openstack] at time 15:41:07.448307
2018-01-31 15:41:07,448 [salt.state       ][INFO    ][6798] Executing state file.managed for /etc/apt/preferences.d/mirantis_openstack
2018-01-31 15:41:07,565 [salt.state       ][INFO    ][6798] File /etc/apt/preferences.d/mirantis_openstack is in the correct state
2018-01-31 15:41:07,565 [salt.state       ][INFO    ][6798] Completed state [/etc/apt/preferences.d/mirantis_openstack] at time 15:41:07.565688 duration_in_ms=117.38
2018-01-31 15:41:07,566 [salt.state       ][INFO    ][6798] Running state [curl -s http://mirror.fuel-infra.org/mcp-repos/pike/xenial/archive-mcppike.key | apt-key add -] at time 15:41:07.565971
2018-01-31 15:41:07,567 [salt.state       ][INFO    ][6798] Executing state cmd.run for curl -s http://mirror.fuel-infra.org/mcp-repos/pike/xenial/archive-mcppike.key | apt-key add -
2018-01-31 15:41:07,567 [salt.loaded.int.module.cmdmod][INFO    ][6798] Executing command 'curl -s http://mirror.fuel-infra.org/mcp-repos/pike/xenial/archive-mcppike.key | apt-key add -' in directory '/root'
2018-01-31 15:41:07,737 [salt.state       ][INFO    ][6798] {'pid': 6973, 'retcode': 0, 'stderr': '', 'stdout': 'OK'}
2018-01-31 15:41:07,737 [salt.state       ][INFO    ][6798] Completed state [curl -s http://mirror.fuel-infra.org/mcp-repos/pike/xenial/archive-mcppike.key | apt-key add -] at time 15:41:07.737695 duration_in_ms=171.723
2018-01-31 15:41:07,740 [salt.state       ][INFO    ][6798] Running state [deb http://mirror.fuel-infra.org/mcp-repos/pike/xenial pike main] at time 15:41:07.740225
2018-01-31 15:41:07,740 [salt.state       ][INFO    ][6798] Executing state pkgrepo.managed for deb http://mirror.fuel-infra.org/mcp-repos/pike/xenial pike main
2018-01-31 15:41:07,840 [salt.loaded.int.module.cmdmod][INFO    ][6798] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2018-01-31 15:41:08,990 [salt.minion      ][INFO    ][2017] User sudo_ubuntu Executing command saltutil.find_job with jid 20180131154110381153
2018-01-31 15:41:09,017 [salt.minion      ][INFO    ][7464] Starting a new job with PID 7464
2018-01-31 15:41:09,043 [salt.minion      ][INFO    ][7464] Returning information for job: 20180131154110381153
2018-01-31 15:41:11,592 [salt.state       ][INFO    ][6798] Configured package repo 'deb http://mirror.fuel-infra.org/mcp-repos/pike/xenial pike main'
2018-01-31 15:41:11,593 [salt.state       ][INFO    ][6798] Completed state [deb http://mirror.fuel-infra.org/mcp-repos/pike/xenial pike main] at time 15:41:11.593103 duration_in_ms=3852.878
2018-01-31 15:41:11,593 [salt.state       ][INFO    ][6798] Running state [/etc/apt/apt.conf.d/99proxies-salt-uca] at time 15:41:11.593716
2018-01-31 15:41:11,594 [salt.state       ][INFO    ][6798] Executing state file.absent for /etc/apt/apt.conf.d/99proxies-salt-uca
2018-01-31 15:41:11,595 [salt.state       ][INFO    ][6798] File /etc/apt/apt.conf.d/99proxies-salt-uca is not present
2018-01-31 15:41:11,595 [salt.state       ][INFO    ][6798] Completed state [/etc/apt/apt.conf.d/99proxies-salt-uca] at time 15:41:11.595431 duration_in_ms=1.715
2018-01-31 15:41:11,595 [salt.state       ][INFO    ][6798] Running state [/etc/apt/preferences.d/uca] at time 15:41:11.595902
2018-01-31 15:41:11,596 [salt.state       ][INFO    ][6798] Executing state file.absent for /etc/apt/preferences.d/uca
2018-01-31 15:41:11,596 [salt.state       ][INFO    ][6798] File /etc/apt/preferences.d/uca is not present
2018-01-31 15:41:11,597 [salt.state       ][INFO    ][6798] Completed state [/etc/apt/preferences.d/uca] at time 15:41:11.597314 duration_in_ms=1.412
2018-01-31 15:41:11,597 [salt.state       ][INFO    ][6798] Running state [apt-key adv --keyserver keyserver.ubuntu.com --recv EC4926EA] at time 15:41:11.597767
2018-01-31 15:41:11,598 [salt.state       ][INFO    ][6798] Executing state cmd.run for apt-key adv --keyserver keyserver.ubuntu.com --recv EC4926EA
2018-01-31 15:41:11,599 [salt.loaded.int.module.cmdmod][INFO    ][6798] Executing command 'apt-key adv --keyserver keyserver.ubuntu.com --recv EC4926EA' in directory '/root'
2018-01-31 15:41:11,793 [salt.state       ][INFO    ][6798] {'pid': 7473, '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.XcbryBnTEO/gpg.1.sh --keyserver\nkeyserver.ubuntu.com\n--recv\nEC4926EA'}
2018-01-31 15:41:11,796 [salt.state       ][INFO    ][6798] Completed state [apt-key adv --keyserver keyserver.ubuntu.com --recv EC4926EA] at time 15:41:11.795933 duration_in_ms=198.165
2018-01-31 15:41:11,797 [salt.state       ][INFO    ][6798] Running state [deb http://ubuntu-cloud.archive.canonical.com/ubuntu xenial-updates/pike main] at time 15:41:11.797770
2018-01-31 15:41:11,798 [salt.state       ][INFO    ][6798] Executing state pkgrepo.managed for deb http://ubuntu-cloud.archive.canonical.com/ubuntu xenial-updates/pike main
2018-01-31 15:41:11,900 [salt.loaded.int.module.cmdmod][INFO    ][6798] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2018-01-31 15:41:14,694 [salt.state       ][INFO    ][6798] Configured package repo 'deb http://ubuntu-cloud.archive.canonical.com/ubuntu xenial-updates/pike main'
2018-01-31 15:41:14,695 [salt.state       ][INFO    ][6798] Completed state [deb http://ubuntu-cloud.archive.canonical.com/ubuntu xenial-updates/pike main] at time 15:41:14.695719 duration_in_ms=2897.948
2018-01-31 15:41:14,696 [salt.state       ][INFO    ][6798] Running state [linux_extra_packages_purged] at time 15:41:14.696339
2018-01-31 15:41:14,696 [salt.state       ][INFO    ][6798] Executing state pkg.purged for linux_extra_packages_purged
2018-01-31 15:41:14,710 [salt.state       ][INFO    ][6798] All specified packages are already absent
2018-01-31 15:41:14,711 [salt.state       ][INFO    ][6798] Completed state [linux_extra_packages_purged] at time 15:41:14.711415 duration_in_ms=15.076
2018-01-31 15:41:14,711 [salt.state       ][INFO    ][6798] Running state [linux_extra_packages_latest] at time 15:41:14.711899
2018-01-31 15:41:14,712 [salt.state       ][INFO    ][6798] Executing state pkg.latest for linux_extra_packages_latest
2018-01-31 15:41:14,724 [salt.loaded.int.module.cmdmod][INFO    ][6798] Executing command ['apt-cache', '-q', 'policy', 'mcelog'] in directory '/root'
2018-01-31 15:41:14,777 [salt.state       ][INFO    ][6798] Package mcelog is already up-to-date
2018-01-31 15:41:14,779 [salt.state       ][INFO    ][6798] Completed state [linux_extra_packages_latest] at time 15:41:14.778986 duration_in_ms=67.086
2018-01-31 15:41:14,780 [salt.state       ][INFO    ][6798] Running state [UTC] at time 15:41:14.780259
2018-01-31 15:41:14,780 [salt.state       ][INFO    ][6798] Executing state timezone.system for UTC
2018-01-31 15:41:14,781 [salt.loaded.int.module.cmdmod][INFO    ][6798] Executing command ['timedatectl'] in directory '/root'
2018-01-31 15:41:14,827 [salt.loaded.int.module.cmdmod][INFO    ][6798] Executing command ['timedatectl'] in directory '/root'
2018-01-31 15:41:14,845 [salt.state       ][INFO    ][6798] Timezone UTC already set, UTC already set to UTC
2018-01-31 15:41:14,845 [salt.state       ][INFO    ][6798] Completed state [UTC] at time 15:41:14.845817 duration_in_ms=65.557
2018-01-31 15:41:14,847 [salt.state       ][INFO    ][6798] Running state [nf_conntrack] at time 15:41:14.847160
2018-01-31 15:41:14,847 [salt.state       ][INFO    ][6798] Executing state kmod.present for nf_conntrack
2018-01-31 15:41:14,848 [salt.loaded.int.module.cmdmod][INFO    ][6798] Executing command 'lsmod' in directory '/root'
2018-01-31 15:41:14,867 [salt.state       ][INFO    ][6798] Kernel module nf_conntrack is already present
2018-01-31 15:41:14,868 [salt.state       ][INFO    ][6798] Completed state [nf_conntrack] at time 15:41:14.868044 duration_in_ms=20.883
2018-01-31 15:41:14,869 [salt.state       ][INFO    ][6798] Running state [kernel.panic] at time 15:41:14.869065
2018-01-31 15:41:14,869 [salt.state       ][INFO    ][6798] Executing state sysctl.present for kernel.panic
2018-01-31 15:41:14,888 [salt.loaded.int.module.cmdmod][INFO    ][6798] Executing command 'sysctl -a' in directory '/root'
2018-01-31 15:41:14,928 [salt.state       ][INFO    ][6798] Sysctl value kernel.panic = 60 is already set
2018-01-31 15:41:14,929 [salt.state       ][INFO    ][6798] Completed state [kernel.panic] at time 15:41:14.929643 duration_in_ms=60.578
2018-01-31 15:41:14,930 [salt.state       ][INFO    ][6798] Running state [net.ipv4.tcp_keepalive_probes] at time 15:41:14.930750
2018-01-31 15:41:14,931 [salt.state       ][INFO    ][6798] Executing state sysctl.present for net.ipv4.tcp_keepalive_probes
2018-01-31 15:41:14,933 [salt.loaded.int.module.cmdmod][INFO    ][6798] Executing command 'sysctl -a' in directory '/root'
2018-01-31 15:41:14,967 [salt.state       ][INFO    ][6798] Sysctl value net.ipv4.tcp_keepalive_probes = 8 is already set
2018-01-31 15:41:14,968 [salt.state       ][INFO    ][6798] Completed state [net.ipv4.tcp_keepalive_probes] at time 15:41:14.968835 duration_in_ms=38.085
2018-01-31 15:41:14,969 [salt.state       ][INFO    ][6798] Running state [fs.file-max] at time 15:41:14.969761
2018-01-31 15:41:14,971 [salt.state       ][INFO    ][6798] Executing state sysctl.present for fs.file-max
2018-01-31 15:41:14,971 [salt.loaded.int.module.cmdmod][INFO    ][6798] Executing command 'sysctl -a' in directory '/root'
2018-01-31 15:41:15,007 [salt.state       ][INFO    ][6798] Sysctl value fs.file-max = 124165 is already set
2018-01-31 15:41:15,008 [salt.state       ][INFO    ][6798] Completed state [fs.file-max] at time 15:41:15.007915 duration_in_ms=38.154
2018-01-31 15:41:15,008 [salt.state       ][INFO    ][6798] Running state [net.core.somaxconn] at time 15:41:15.008547
2018-01-31 15:41:15,009 [salt.state       ][INFO    ][6798] Executing state sysctl.present for net.core.somaxconn
2018-01-31 15:41:15,010 [salt.loaded.int.module.cmdmod][INFO    ][6798] Executing command 'sysctl -a' in directory '/root'
2018-01-31 15:41:15,042 [salt.state       ][INFO    ][6798] Sysctl value net.core.somaxconn = 4096 is already set
2018-01-31 15:41:15,043 [salt.state       ][INFO    ][6798] Completed state [net.core.somaxconn] at time 15:41:15.043645 duration_in_ms=35.098
2018-01-31 15:41:15,044 [salt.state       ][INFO    ][6798] Running state [net.ipv4.tcp_max_syn_backlog] at time 15:41:15.044357
2018-01-31 15:41:15,045 [salt.state       ][INFO    ][6798] Executing state sysctl.present for net.ipv4.tcp_max_syn_backlog
2018-01-31 15:41:15,046 [salt.loaded.int.module.cmdmod][INFO    ][6798] Executing command 'sysctl -a' in directory '/root'
2018-01-31 15:41:15,082 [salt.state       ][INFO    ][6798] Sysctl value net.ipv4.tcp_max_syn_backlog = 8192 is already set
2018-01-31 15:41:15,083 [salt.state       ][INFO    ][6798] Completed state [net.ipv4.tcp_max_syn_backlog] at time 15:41:15.083603 duration_in_ms=39.246
2018-01-31 15:41:15,084 [salt.state       ][INFO    ][6798] Running state [net.ipv4.tcp_tw_reuse] at time 15:41:15.084360
2018-01-31 15:41:15,085 [salt.state       ][INFO    ][6798] Executing state sysctl.present for net.ipv4.tcp_tw_reuse
2018-01-31 15:41:15,086 [salt.loaded.int.module.cmdmod][INFO    ][6798] Executing command 'sysctl -a' in directory '/root'
2018-01-31 15:41:15,123 [salt.state       ][INFO    ][6798] Sysctl value net.ipv4.tcp_tw_reuse = 1 is already set
2018-01-31 15:41:15,124 [salt.state       ][INFO    ][6798] Completed state [net.ipv4.tcp_tw_reuse] at time 15:41:15.124055 duration_in_ms=39.694
2018-01-31 15:41:15,125 [salt.state       ][INFO    ][6798] Running state [net.ipv4.tcp_congestion_control] at time 15:41:15.124938
2018-01-31 15:41:15,125 [salt.state       ][INFO    ][6798] Executing state sysctl.present for net.ipv4.tcp_congestion_control
2018-01-31 15:41:15,127 [salt.loaded.int.module.cmdmod][INFO    ][6798] Executing command 'sysctl -a' in directory '/root'
2018-01-31 15:41:15,165 [salt.state       ][INFO    ][6798] Sysctl value net.ipv4.tcp_congestion_control = yeah is already set
2018-01-31 15:41:15,166 [salt.state       ][INFO    ][6798] Completed state [net.ipv4.tcp_congestion_control] at time 15:41:15.166350 duration_in_ms=41.412
2018-01-31 15:41:15,166 [salt.state       ][INFO    ][6798] Running state [net.ipv4.tcp_retries2] at time 15:41:15.166871
2018-01-31 15:41:15,167 [salt.state       ][INFO    ][6798] Executing state sysctl.present for net.ipv4.tcp_retries2
2018-01-31 15:41:15,168 [salt.loaded.int.module.cmdmod][INFO    ][6798] Executing command 'sysctl -a' in directory '/root'
2018-01-31 15:41:15,200 [salt.state       ][INFO    ][6798] Sysctl value net.ipv4.tcp_retries2 = 5 is already set
2018-01-31 15:41:15,201 [salt.state       ][INFO    ][6798] Completed state [net.ipv4.tcp_retries2] at time 15:41:15.201052 duration_in_ms=34.18
2018-01-31 15:41:15,201 [salt.state       ][INFO    ][6798] Running state [net.core.netdev_max_backlog] at time 15:41:15.201550
2018-01-31 15:41:15,201 [salt.state       ][INFO    ][6798] Executing state sysctl.present for net.core.netdev_max_backlog
2018-01-31 15:41:15,203 [salt.loaded.int.module.cmdmod][INFO    ][6798] Executing command 'sysctl -a' in directory '/root'
2018-01-31 15:41:15,237 [salt.state       ][INFO    ][6798] Sysctl value net.core.netdev_max_backlog = 261144 is already set
2018-01-31 15:41:15,238 [salt.state       ][INFO    ][6798] Completed state [net.core.netdev_max_backlog] at time 15:41:15.238334 duration_in_ms=36.784
2018-01-31 15:41:15,239 [salt.state       ][INFO    ][6798] Running state [net.ipv4.tcp_slow_start_after_idle] at time 15:41:15.238972
2018-01-31 15:41:15,239 [salt.state       ][INFO    ][6798] Executing state sysctl.present for net.ipv4.tcp_slow_start_after_idle
2018-01-31 15:41:15,240 [salt.loaded.int.module.cmdmod][INFO    ][6798] Executing command 'sysctl -a' in directory '/root'
2018-01-31 15:41:15,276 [salt.state       ][INFO    ][6798] Sysctl value net.ipv4.tcp_slow_start_after_idle = 0 is already set
2018-01-31 15:41:15,277 [salt.state       ][INFO    ][6798] Completed state [net.ipv4.tcp_slow_start_after_idle] at time 15:41:15.277233 duration_in_ms=38.261
2018-01-31 15:41:15,277 [salt.state       ][INFO    ][6798] Running state [vm.swappiness] at time 15:41:15.277874
2018-01-31 15:41:15,278 [salt.state       ][INFO    ][6798] Executing state sysctl.present for vm.swappiness
2018-01-31 15:41:15,279 [salt.loaded.int.module.cmdmod][INFO    ][6798] Executing command 'sysctl -a' in directory '/root'
2018-01-31 15:41:15,313 [salt.state       ][INFO    ][6798] Sysctl value vm.swappiness = 10 is already set
2018-01-31 15:41:15,314 [salt.state       ][INFO    ][6798] Completed state [vm.swappiness] at time 15:41:15.314593 duration_in_ms=36.719
2018-01-31 15:41:15,315 [salt.state       ][INFO    ][6798] Running state [net.ipv4.tcp_keepalive_intvl] at time 15:41:15.315221
2018-01-31 15:41:15,315 [salt.state       ][INFO    ][6798] Executing state sysctl.present for net.ipv4.tcp_keepalive_intvl
2018-01-31 15:41:15,316 [salt.loaded.int.module.cmdmod][INFO    ][6798] Executing command 'sysctl -a' in directory '/root'
2018-01-31 15:41:15,355 [salt.state       ][INFO    ][6798] Sysctl value net.ipv4.tcp_keepalive_intvl = 3 is already set
2018-01-31 15:41:15,356 [salt.state       ][INFO    ][6798] Completed state [net.ipv4.tcp_keepalive_intvl] at time 15:41:15.355932 duration_in_ms=40.711
2018-01-31 15:41:15,356 [salt.state       ][INFO    ][6798] Running state [net.ipv4.neigh.default.gc_thresh1] at time 15:41:15.356592
2018-01-31 15:41:15,357 [salt.state       ][INFO    ][6798] Executing state sysctl.present for net.ipv4.neigh.default.gc_thresh1
2018-01-31 15:41:15,358 [salt.loaded.int.module.cmdmod][INFO    ][6798] Executing command 'sysctl -a' in directory '/root'
2018-01-31 15:41:15,393 [salt.state       ][INFO    ][6798] Sysctl value net.ipv4.neigh.default.gc_thresh1 = 4096 is already set
2018-01-31 15:41:15,394 [salt.state       ][INFO    ][6798] Completed state [net.ipv4.neigh.default.gc_thresh1] at time 15:41:15.394481 duration_in_ms=37.92
2018-01-31 15:41:15,395 [salt.state       ][INFO    ][6798] Running state [net.ipv4.neigh.default.gc_thresh2] at time 15:41:15.395384
2018-01-31 15:41:15,396 [salt.state       ][INFO    ][6798] Executing state sysctl.present for net.ipv4.neigh.default.gc_thresh2
2018-01-31 15:41:15,397 [salt.loaded.int.module.cmdmod][INFO    ][6798] Executing command 'sysctl -a' in directory '/root'
2018-01-31 15:41:15,437 [salt.state       ][INFO    ][6798] Sysctl value net.ipv4.neigh.default.gc_thresh2 = 8192 is already set
2018-01-31 15:41:15,439 [salt.state       ][INFO    ][6798] Completed state [net.ipv4.neigh.default.gc_thresh2] at time 15:41:15.439129 duration_in_ms=43.744
2018-01-31 15:41:15,439 [salt.state       ][INFO    ][6798] Running state [net.ipv4.neigh.default.gc_thresh3] at time 15:41:15.439762
2018-01-31 15:41:15,440 [salt.state       ][INFO    ][6798] Executing state sysctl.present for net.ipv4.neigh.default.gc_thresh3
2018-01-31 15:41:15,441 [salt.loaded.int.module.cmdmod][INFO    ][6798] Executing command 'sysctl -a' in directory '/root'
2018-01-31 15:41:15,479 [salt.state       ][INFO    ][6798] Sysctl value net.ipv4.neigh.default.gc_thresh3 = 16384 is already set
2018-01-31 15:41:15,480 [salt.state       ][INFO    ][6798] Completed state [net.ipv4.neigh.default.gc_thresh3] at time 15:41:15.479948 duration_in_ms=40.186
2018-01-31 15:41:15,480 [salt.state       ][INFO    ][6798] Running state [net.ipv4.tcp_fin_timeout] at time 15:41:15.480630
2018-01-31 15:41:15,481 [salt.state       ][INFO    ][6798] Executing state sysctl.present for net.ipv4.tcp_fin_timeout
2018-01-31 15:41:15,482 [salt.loaded.int.module.cmdmod][INFO    ][6798] Executing command 'sysctl -a' in directory '/root'
2018-01-31 15:41:15,515 [salt.state       ][INFO    ][6798] Sysctl value net.ipv4.tcp_fin_timeout = 30 is already set
2018-01-31 15:41:15,515 [salt.state       ][INFO    ][6798] Completed state [net.ipv4.tcp_fin_timeout] at time 15:41:15.515895 duration_in_ms=35.264
2018-01-31 15:41:15,516 [salt.state       ][INFO    ][6798] Running state [net.ipv4.tcp_keepalive_time] at time 15:41:15.516508
2018-01-31 15:41:15,517 [salt.state       ][INFO    ][6798] Executing state sysctl.present for net.ipv4.tcp_keepalive_time
2018-01-31 15:41:15,518 [salt.loaded.int.module.cmdmod][INFO    ][6798] Executing command 'sysctl -a' in directory '/root'
2018-01-31 15:41:15,551 [salt.state       ][INFO    ][6798] Sysctl value net.ipv4.tcp_keepalive_time = 30 is already set
2018-01-31 15:41:15,552 [salt.state       ][INFO    ][6798] Completed state [net.ipv4.tcp_keepalive_time] at time 15:41:15.552072 duration_in_ms=35.562
2018-01-31 15:41:15,552 [salt.state       ][INFO    ][6798] Running state [net.nf_conntrack_max] at time 15:41:15.552712
2018-01-31 15:41:15,553 [salt.state       ][INFO    ][6798] Executing state sysctl.present for net.nf_conntrack_max
2018-01-31 15:41:15,554 [salt.loaded.int.module.cmdmod][INFO    ][6798] Executing command 'sysctl -a' in directory '/root'
2018-01-31 15:41:15,592 [salt.state       ][INFO    ][6798] Sysctl value net.nf_conntrack_max = 1048576 is already set
2018-01-31 15:41:15,593 [salt.state       ][INFO    ][6798] Completed state [net.nf_conntrack_max] at time 15:41:15.593351 duration_in_ms=40.638
2018-01-31 15:41:15,595 [salt.state       ][INFO    ][6798] Running state [linux_sysfs_package] at time 15:41:15.594957
2018-01-31 15:41:15,595 [salt.state       ][INFO    ][6798] Executing state pkg.installed for linux_sysfs_package
2018-01-31 15:41:15,606 [salt.state       ][INFO    ][6798] All specified packages are already installed
2018-01-31 15:41:15,607 [salt.state       ][INFO    ][6798] Completed state [linux_sysfs_package] at time 15:41:15.607128 duration_in_ms=12.17
2018-01-31 15:41:15,608 [salt.state       ][INFO    ][6798] Running state [/etc/sysfs.d] at time 15:41:15.608947
2018-01-31 15:41:15,609 [salt.state       ][INFO    ][6798] Executing state file.directory for /etc/sysfs.d
2018-01-31 15:41:15,610 [salt.state       ][INFO    ][6798] Directory /etc/sysfs.d is in the correct state
2018-01-31 15:41:15,610 [salt.state       ][INFO    ][6798] Completed state [/etc/sysfs.d] at time 15:41:15.610748 duration_in_ms=1.801
2018-01-31 15:41:15,611 [salt.state       ][INFO    ][6798] Running state [ondemand] at time 15:41:15.611756
2018-01-31 15:41:15,612 [salt.state       ][INFO    ][6798] Executing state service.dead for ondemand
2018-01-31 15:41:15,613 [salt.loaded.int.module.cmdmod][INFO    ][6798] Executing command ['systemctl', 'status', 'ondemand.service', '-n', '0'] in directory '/root'
2018-01-31 15:41:15,635 [salt.loaded.int.module.cmdmod][INFO    ][6798] Executing command ['systemctl', 'is-active', 'ondemand.service'] in directory '/root'
2018-01-31 15:41:15,655 [salt.loaded.int.module.cmdmod][INFO    ][6798] Executing command ['systemctl', 'is-enabled', 'ondemand.service'] in directory '/root'
2018-01-31 15:41:15,685 [salt.loaded.int.module.cmdmod][INFO    ][6798] Executing command 'runlevel' in directory '/root'
2018-01-31 15:41:15,701 [salt.state       ][INFO    ][6798] The service ondemand is already dead
2018-01-31 15:41:15,701 [salt.state       ][INFO    ][6798] Completed state [ondemand] at time 15:41:15.701680 duration_in_ms=89.923
2018-01-31 15:41:15,704 [salt.state       ][INFO    ][6798] Running state [cs_CZ.UTF-8] at time 15:41:15.704269
2018-01-31 15:41:15,704 [salt.state       ][INFO    ][6798] Executing state locale.present for cs_CZ.UTF-8
2018-01-31 15:41:15,706 [salt.loaded.int.module.cmdmod][INFO    ][6798] Executing command 'locale -a' in directory '/root'
2018-01-31 15:41:15,723 [salt.state       ][INFO    ][6798] Locale cs_CZ.UTF-8 is already present
2018-01-31 15:41:15,724 [salt.state       ][INFO    ][6798] Completed state [cs_CZ.UTF-8] at time 15:41:15.724025 duration_in_ms=19.756
2018-01-31 15:41:15,724 [salt.state       ][INFO    ][6798] Running state [en_US.UTF-8] at time 15:41:15.724703
2018-01-31 15:41:15,725 [salt.state       ][INFO    ][6798] Executing state locale.present for en_US.UTF-8
2018-01-31 15:41:15,727 [salt.loaded.int.module.cmdmod][INFO    ][6798] Executing command 'locale -a' in directory '/root'
2018-01-31 15:41:15,743 [salt.state       ][INFO    ][6798] Locale en_US.UTF-8 is already present
2018-01-31 15:41:15,744 [salt.state       ][INFO    ][6798] Completed state [en_US.UTF-8] at time 15:41:15.743906 duration_in_ms=19.202
2018-01-31 15:41:15,747 [salt.state       ][INFO    ][6798] Running state [en_US.UTF-8] at time 15:41:15.747085
2018-01-31 15:41:15,747 [salt.state       ][INFO    ][6798] Executing state locale.system for en_US.UTF-8
2018-01-31 15:41:15,748 [salt.loaded.int.module.cmdmod][INFO    ][6798] Executing command 'localectl' in directory '/root'
2018-01-31 15:41:15,799 [salt.state       ][INFO    ][6798] System locale en_US.UTF-8 already set
2018-01-31 15:41:15,799 [salt.state       ][INFO    ][6798] Completed state [en_US.UTF-8] at time 15:41:15.799859 duration_in_ms=52.775
2018-01-31 15:41:15,802 [salt.state       ][INFO    ][6798] Running state [root] at time 15:41:15.802523
2018-01-31 15:41:15,802 [salt.state       ][INFO    ][6798] Executing state user.present for root
2018-01-31 15:41:15,804 [salt.state       ][INFO    ][6798] User root is present and up to date
2018-01-31 15:41:15,804 [salt.state       ][INFO    ][6798] Completed state [root] at time 15:41:15.804863 duration_in_ms=2.34
2018-01-31 15:41:15,806 [salt.state       ][INFO    ][6798] Running state [/root] at time 15:41:15.806559
2018-01-31 15:41:15,806 [salt.state       ][INFO    ][6798] Executing state file.directory for /root
2018-01-31 15:41:15,807 [salt.state       ][INFO    ][6798] Directory /root is in the correct state
2018-01-31 15:41:15,808 [salt.state       ][INFO    ][6798] Completed state [/root] at time 15:41:15.808080 duration_in_ms=1.521
2018-01-31 15:41:15,808 [salt.state       ][INFO    ][6798] Running state [/etc/sudoers.d/90-salt-user-root] at time 15:41:15.808397
2018-01-31 15:41:15,808 [salt.state       ][INFO    ][6798] Executing state file.absent for /etc/sudoers.d/90-salt-user-root
2018-01-31 15:41:15,809 [salt.state       ][INFO    ][6798] File /etc/sudoers.d/90-salt-user-root is not present
2018-01-31 15:41:15,809 [salt.state       ][INFO    ][6798] Completed state [/etc/sudoers.d/90-salt-user-root] at time 15:41:15.809425 duration_in_ms=1.028
2018-01-31 15:41:15,809 [salt.state       ][INFO    ][6798] Running state [ubuntu] at time 15:41:15.809748
2018-01-31 15:41:15,810 [salt.state       ][INFO    ][6798] Executing state user.present for ubuntu
2018-01-31 15:41:15,811 [salt.state       ][INFO    ][6798] User ubuntu is present and up to date
2018-01-31 15:41:15,812 [salt.state       ][INFO    ][6798] Completed state [ubuntu] at time 15:41:15.812196 duration_in_ms=2.448
2018-01-31 15:41:15,813 [salt.state       ][INFO    ][6798] Running state [/home/ubuntu] at time 15:41:15.813328
2018-01-31 15:41:15,813 [salt.state       ][INFO    ][6798] Executing state file.directory for /home/ubuntu
2018-01-31 15:41:15,814 [salt.state       ][INFO    ][6798] Directory /home/ubuntu is in the correct state
2018-01-31 15:41:15,814 [salt.state       ][INFO    ][6798] Completed state [/home/ubuntu] at time 15:41:15.814940 duration_in_ms=1.612
2018-01-31 15:41:15,815 [salt.state       ][INFO    ][6798] Running state [/etc/sudoers.d/90-salt-user-ubuntu] at time 15:41:15.815896
2018-01-31 15:41:15,816 [salt.state       ][INFO    ][6798] Executing state file.managed for /etc/sudoers.d/90-salt-user-ubuntu
2018-01-31 15:41:15,844 [salt.state       ][INFO    ][6798] File /etc/sudoers.d/90-salt-user-ubuntu is in the correct state
2018-01-31 15:41:15,844 [salt.state       ][INFO    ][6798] Completed state [/etc/sudoers.d/90-salt-user-ubuntu] at time 15:41:15.844620 duration_in_ms=28.723
2018-01-31 15:41:15,844 [salt.state       ][INFO    ][6798] Running state [/etc/security/limits.d/90-salt-default.conf] at time 15:41:15.844907
2018-01-31 15:41:15,845 [salt.state       ][INFO    ][6798] Executing state file.managed for /etc/security/limits.d/90-salt-default.conf
2018-01-31 15:41:15,957 [salt.state       ][INFO    ][6798] File /etc/security/limits.d/90-salt-default.conf is in the correct state
2018-01-31 15:41:15,957 [salt.state       ][INFO    ][6798] Completed state [/etc/security/limits.d/90-salt-default.conf] at time 15:41:15.957568 duration_in_ms=112.661
2018-01-31 15:41:15,957 [salt.state       ][INFO    ][6798] Running state [/etc/systemd/system.conf.d/90-salt.conf] at time 15:41:15.957878
2018-01-31 15:41:15,958 [salt.state       ][INFO    ][6798] Executing state file.managed for /etc/systemd/system.conf.d/90-salt.conf
2018-01-31 15:41:16,074 [salt.state       ][INFO    ][6798] File /etc/systemd/system.conf.d/90-salt.conf is in the correct state
2018-01-31 15:41:16,075 [salt.state       ][INFO    ][6798] Completed state [/etc/systemd/system.conf.d/90-salt.conf] at time 15:41:16.075147 duration_in_ms=117.269
2018-01-31 15:41:16,076 [salt.state       ][INFO    ][6798] Running state [service.systemctl_reload] at time 15:41:16.076722
2018-01-31 15:41:16,077 [salt.state       ][INFO    ][6798] Executing state module.wait for service.systemctl_reload
2018-01-31 15:41:16,077 [salt.state       ][INFO    ][6798] No changes made for service.systemctl_reload
2018-01-31 15:41:16,077 [salt.state       ][INFO    ][6798] Completed state [service.systemctl_reload] at time 15:41:16.077583 duration_in_ms=0.862
2018-01-31 15:41:16,077 [salt.state       ][INFO    ][6798] Running state [/etc/hostname] at time 15:41:16.077863
2018-01-31 15:41:16,078 [salt.state       ][INFO    ][6798] Executing state file.managed for /etc/hostname
2018-01-31 15:41:16,099 [salt.state       ][INFO    ][6798] File /etc/hostname is in the correct state
2018-01-31 15:41:16,099 [salt.state       ][INFO    ][6798] Completed state [/etc/hostname] at time 15:41:16.099572 duration_in_ms=21.709
2018-01-31 15:41:16,100 [salt.state       ][INFO    ][6798] Running state [hostname msg01] at time 15:41:16.100658
2018-01-31 15:41:16,100 [salt.state       ][INFO    ][6798] Executing state cmd.wait for hostname msg01
2018-01-31 15:41:16,101 [salt.state       ][INFO    ][6798] No changes made for hostname msg01
2018-01-31 15:41:16,101 [salt.state       ][INFO    ][6798] Completed state [hostname msg01] at time 15:41:16.101561 duration_in_ms=0.903
2018-01-31 15:41:16,103 [salt.state       ][INFO    ][6798] Running state [mdb02] at time 15:41:16.103035
2018-01-31 15:41:16,103 [salt.state       ][INFO    ][6798] Executing state host.present for mdb02
2018-01-31 15:41:16,103 [salt.state       ][INFO    ][6798] Host mdb02 (192.168.10.77) already present
2018-01-31 15:41:16,104 [salt.state       ][INFO    ][6798] Completed state [mdb02] at time 15:41:16.104156 duration_in_ms=1.121
2018-01-31 15:41:16,104 [salt.state       ][INFO    ][6798] Running state [mdb02.baremetal-mcp-pike-odl-ha.local] at time 15:41:16.104436
2018-01-31 15:41:16,104 [salt.state       ][INFO    ][6798] Executing state host.present for mdb02.baremetal-mcp-pike-odl-ha.local
2018-01-31 15:41:16,105 [salt.state       ][INFO    ][6798] Host mdb02.baremetal-mcp-pike-odl-ha.local (192.168.10.77) already present
2018-01-31 15:41:16,105 [salt.state       ][INFO    ][6798] Completed state [mdb02.baremetal-mcp-pike-odl-ha.local] at time 15:41:16.105496 duration_in_ms=1.059
2018-01-31 15:41:16,105 [salt.state       ][INFO    ][6798] Running state [mdb03] at time 15:41:16.105780
2018-01-31 15:41:16,106 [salt.state       ][INFO    ][6798] Executing state host.present for mdb03
2018-01-31 15:41:16,106 [salt.state       ][INFO    ][6798] Host mdb03 (192.168.10.78) already present
2018-01-31 15:41:16,106 [salt.state       ][INFO    ][6798] Completed state [mdb03] at time 15:41:16.106823 duration_in_ms=1.043
2018-01-31 15:41:16,107 [salt.state       ][INFO    ][6798] Running state [mdb03.baremetal-mcp-pike-odl-ha.local] at time 15:41:16.107104
2018-01-31 15:41:16,107 [salt.state       ][INFO    ][6798] Executing state host.present for mdb03.baremetal-mcp-pike-odl-ha.local
2018-01-31 15:41:16,107 [salt.state       ][INFO    ][6798] Host mdb03.baremetal-mcp-pike-odl-ha.local (192.168.10.78) already present
2018-01-31 15:41:16,108 [salt.state       ][INFO    ][6798] Completed state [mdb03.baremetal-mcp-pike-odl-ha.local] at time 15:41:16.108127 duration_in_ms=1.023
2018-01-31 15:41:16,108 [salt.state       ][INFO    ][6798] Running state [mdb01] at time 15:41:16.108404
2018-01-31 15:41:16,108 [salt.state       ][INFO    ][6798] Executing state host.present for mdb01
2018-01-31 15:41:16,109 [salt.state       ][INFO    ][6798] Host mdb01 (192.168.10.76) already present
2018-01-31 15:41:16,109 [salt.state       ][INFO    ][6798] Completed state [mdb01] at time 15:41:16.109437 duration_in_ms=1.033
2018-01-31 15:41:16,109 [salt.state       ][INFO    ][6798] Running state [mdb01.baremetal-mcp-pike-odl-ha.local] at time 15:41:16.109717
2018-01-31 15:41:16,110 [salt.state       ][INFO    ][6798] Executing state host.present for mdb01.baremetal-mcp-pike-odl-ha.local
2018-01-31 15:41:16,111 [salt.state       ][INFO    ][6798] Host mdb01.baremetal-mcp-pike-odl-ha.local (192.168.10.76) already present
2018-01-31 15:41:16,111 [salt.state       ][INFO    ][6798] Completed state [mdb01.baremetal-mcp-pike-odl-ha.local] at time 15:41:16.111373 duration_in_ms=1.657
2018-01-31 15:41:16,111 [salt.state       ][INFO    ][6798] Running state [mdb] at time 15:41:16.111659
2018-01-31 15:41:16,111 [salt.state       ][INFO    ][6798] Executing state host.present for mdb
2018-01-31 15:41:16,112 [salt.state       ][INFO    ][6798] Host mdb (192.168.10.75) already present
2018-01-31 15:41:16,112 [salt.state       ][INFO    ][6798] Completed state [mdb] at time 15:41:16.112686 duration_in_ms=1.028
2018-01-31 15:41:16,113 [salt.state       ][INFO    ][6798] Running state [mdb.baremetal-mcp-pike-odl-ha.local] at time 15:41:16.112966
2018-01-31 15:41:16,113 [salt.state       ][INFO    ][6798] Executing state host.present for mdb.baremetal-mcp-pike-odl-ha.local
2018-01-31 15:41:16,113 [salt.state       ][INFO    ][6798] Host mdb.baremetal-mcp-pike-odl-ha.local (192.168.10.75) already present
2018-01-31 15:41:16,114 [salt.state       ][INFO    ][6798] Completed state [mdb.baremetal-mcp-pike-odl-ha.local] at time 15:41:16.113981 duration_in_ms=1.015
2018-01-31 15:41:16,114 [salt.state       ][INFO    ][6798] Running state [cfg01] at time 15:41:16.114268
2018-01-31 15:41:16,114 [salt.state       ][INFO    ][6798] Executing state host.present for cfg01
2018-01-31 15:41:16,115 [salt.state       ][INFO    ][6798] Host cfg01 (192.168.10.100) already present
2018-01-31 15:41:16,115 [salt.state       ][INFO    ][6798] Completed state [cfg01] at time 15:41:16.115278 duration_in_ms=1.01
2018-01-31 15:41:16,115 [salt.state       ][INFO    ][6798] Running state [cfg01.baremetal-mcp-pike-odl-ha.local] at time 15:41:16.115551
2018-01-31 15:41:16,115 [salt.state       ][INFO    ][6798] Executing state host.present for cfg01.baremetal-mcp-pike-odl-ha.local
2018-01-31 15:41:16,116 [salt.state       ][INFO    ][6798] Host cfg01.baremetal-mcp-pike-odl-ha.local (192.168.10.100) already present
2018-01-31 15:41:16,116 [salt.state       ][INFO    ][6798] Completed state [cfg01.baremetal-mcp-pike-odl-ha.local] at time 15:41:16.116591 duration_in_ms=1.04
2018-01-31 15:41:16,116 [salt.state       ][INFO    ][6798] Running state [prx01] at time 15:41:16.116870
2018-01-31 15:41:16,117 [salt.state       ][INFO    ][6798] Executing state host.present for prx01
2018-01-31 15:41:16,117 [salt.state       ][INFO    ][6798] Host prx01 (192.168.10.104) already present
2018-01-31 15:41:16,117 [salt.state       ][INFO    ][6798] Completed state [prx01] at time 15:41:16.117874 duration_in_ms=1.004
2018-01-31 15:41:16,118 [salt.state       ][INFO    ][6798] Running state [prx01.baremetal-mcp-pike-odl-ha.local] at time 15:41:16.118486
2018-01-31 15:41:16,118 [salt.state       ][INFO    ][6798] Executing state host.present for prx01.baremetal-mcp-pike-odl-ha.local
2018-01-31 15:41:16,119 [salt.state       ][INFO    ][6798] Host prx01.baremetal-mcp-pike-odl-ha.local (192.168.10.104) already present
2018-01-31 15:41:16,119 [salt.state       ][INFO    ][6798] Completed state [prx01.baremetal-mcp-pike-odl-ha.local] at time 15:41:16.119501 duration_in_ms=1.015
2018-01-31 15:41:16,119 [salt.state       ][INFO    ][6798] Running state [kvm01] at time 15:41:16.119775
2018-01-31 15:41:16,120 [salt.state       ][INFO    ][6798] Executing state host.present for kvm01
2018-01-31 15:41:16,120 [salt.state       ][INFO    ][6798] Host kvm01 (192.168.10.141) already present
2018-01-31 15:41:16,120 [salt.state       ][INFO    ][6798] Completed state [kvm01] at time 15:41:16.120804 duration_in_ms=1.028
2018-01-31 15:41:16,121 [salt.state       ][INFO    ][6798] Running state [kvm01.baremetal-mcp-pike-odl-ha.local] at time 15:41:16.121076
2018-01-31 15:41:16,121 [salt.state       ][INFO    ][6798] Executing state host.present for kvm01.baremetal-mcp-pike-odl-ha.local
2018-01-31 15:41:16,121 [salt.state       ][INFO    ][6798] Host kvm01.baremetal-mcp-pike-odl-ha.local (192.168.10.141) already present
2018-01-31 15:41:16,122 [salt.state       ][INFO    ][6798] Completed state [kvm01.baremetal-mcp-pike-odl-ha.local] at time 15:41:16.122698 duration_in_ms=1.622
2018-01-31 15:41:16,123 [salt.state       ][INFO    ][6798] Running state [kvm03] at time 15:41:16.122989
2018-01-31 15:41:16,123 [salt.state       ][INFO    ][6798] Executing state host.present for kvm03
2018-01-31 15:41:16,123 [salt.state       ][INFO    ][6798] Host kvm03 (192.168.10.143) already present
2018-01-31 15:41:16,124 [salt.state       ][INFO    ][6798] Completed state [kvm03] at time 15:41:16.124010 duration_in_ms=1.021
2018-01-31 15:41:16,124 [salt.state       ][INFO    ][6798] Running state [kvm03.baremetal-mcp-pike-odl-ha.local] at time 15:41:16.124286
2018-01-31 15:41:16,124 [salt.state       ][INFO    ][6798] Executing state host.present for kvm03.baremetal-mcp-pike-odl-ha.local
2018-01-31 15:41:16,125 [salt.state       ][INFO    ][6798] Host kvm03.baremetal-mcp-pike-odl-ha.local (192.168.10.143) already present
2018-01-31 15:41:16,125 [salt.state       ][INFO    ][6798] Completed state [kvm03.baremetal-mcp-pike-odl-ha.local] at time 15:41:16.125326 duration_in_ms=1.04
2018-01-31 15:41:16,125 [salt.state       ][INFO    ][6798] Running state [kvm02] at time 15:41:16.125603
2018-01-31 15:41:16,125 [salt.state       ][INFO    ][6798] Executing state host.present for kvm02
2018-01-31 15:41:16,126 [salt.state       ][INFO    ][6798] Host kvm02 (192.168.10.142) already present
2018-01-31 15:41:16,126 [salt.state       ][INFO    ][6798] Completed state [kvm02] at time 15:41:16.126618 duration_in_ms=1.015
2018-01-31 15:41:16,126 [salt.state       ][INFO    ][6798] Running state [kvm02.baremetal-mcp-pike-odl-ha.local] at time 15:41:16.126889
2018-01-31 15:41:16,127 [salt.state       ][INFO    ][6798] Executing state host.present for kvm02.baremetal-mcp-pike-odl-ha.local
2018-01-31 15:41:16,127 [salt.state       ][INFO    ][6798] Host kvm02.baremetal-mcp-pike-odl-ha.local (192.168.10.142) already present
2018-01-31 15:41:16,127 [salt.state       ][INFO    ][6798] Completed state [kvm02.baremetal-mcp-pike-odl-ha.local] at time 15:41:16.127906 duration_in_ms=1.017
2018-01-31 15:41:16,128 [salt.state       ][INFO    ][6798] Running state [dbs] at time 15:41:16.128186
2018-01-31 15:41:16,128 [salt.state       ][INFO    ][6798] Executing state host.present for dbs
2018-01-31 15:41:16,129 [salt.state       ][INFO    ][6798] Host dbs (192.168.10.50) already present
2018-01-31 15:41:16,129 [salt.state       ][INFO    ][6798] Completed state [dbs] at time 15:41:16.129537 duration_in_ms=1.351
2018-01-31 15:41:16,129 [salt.state       ][INFO    ][6798] Running state [dbs.baremetal-mcp-pike-odl-ha.local] at time 15:41:16.129818
2018-01-31 15:41:16,130 [salt.state       ][INFO    ][6798] Executing state host.present for dbs.baremetal-mcp-pike-odl-ha.local
2018-01-31 15:41:16,130 [salt.state       ][INFO    ][6798] Host dbs.baremetal-mcp-pike-odl-ha.local (192.168.10.50) already present
2018-01-31 15:41:16,130 [salt.state       ][INFO    ][6798] Completed state [dbs.baremetal-mcp-pike-odl-ha.local] at time 15:41:16.130849 duration_in_ms=1.032
2018-01-31 15:41:16,131 [salt.state       ][INFO    ][6798] Running state [prx] at time 15:41:16.131129
2018-01-31 15:41:16,131 [salt.state       ][INFO    ][6798] Executing state host.present for prx
2018-01-31 15:41:16,131 [salt.state       ][INFO    ][6798] Host prx (192.168.10.103) already present
2018-01-31 15:41:16,132 [salt.state       ][INFO    ][6798] Completed state [prx] at time 15:41:16.132158 duration_in_ms=1.029
2018-01-31 15:41:16,132 [salt.state       ][INFO    ][6798] Running state [prx.baremetal-mcp-pike-odl-ha.local] at time 15:41:16.132435
2018-01-31 15:41:16,132 [salt.state       ][INFO    ][6798] Executing state host.present for prx.baremetal-mcp-pike-odl-ha.local
2018-01-31 15:41:16,133 [salt.state       ][INFO    ][6798] Host prx.baremetal-mcp-pike-odl-ha.local (192.168.10.103) already present
2018-01-31 15:41:16,133 [salt.state       ][INFO    ][6798] Completed state [prx.baremetal-mcp-pike-odl-ha.local] at time 15:41:16.133475 duration_in_ms=1.04
2018-01-31 15:41:16,133 [salt.state       ][INFO    ][6798] Running state [prx02] at time 15:41:16.133750
2018-01-31 15:41:16,134 [salt.state       ][INFO    ][6798] Executing state host.present for prx02
2018-01-31 15:41:16,135 [salt.state       ][INFO    ][6798] Host prx02 (192.168.10.105) already present
2018-01-31 15:41:16,135 [salt.state       ][INFO    ][6798] Completed state [prx02] at time 15:41:16.135933 duration_in_ms=2.182
2018-01-31 15:41:16,136 [salt.state       ][INFO    ][6798] Running state [prx02.baremetal-mcp-pike-odl-ha.local] at time 15:41:16.136209
2018-01-31 15:41:16,136 [salt.state       ][INFO    ][6798] Executing state host.present for prx02.baremetal-mcp-pike-odl-ha.local
2018-01-31 15:41:16,137 [salt.state       ][INFO    ][6798] Host prx02.baremetal-mcp-pike-odl-ha.local (192.168.10.105) already present
2018-01-31 15:41:16,137 [salt.state       ][INFO    ][6798] Completed state [prx02.baremetal-mcp-pike-odl-ha.local] at time 15:41:16.137244 duration_in_ms=1.035
2018-01-31 15:41:16,137 [salt.state       ][INFO    ][6798] Running state [msg02] at time 15:41:16.137527
2018-01-31 15:41:16,137 [salt.state       ][INFO    ][6798] Executing state host.present for msg02
2018-01-31 15:41:16,138 [salt.state       ][INFO    ][6798] Host msg02 (192.168.10.42) already present
2018-01-31 15:41:16,138 [salt.state       ][INFO    ][6798] Completed state [msg02] at time 15:41:16.138545 duration_in_ms=1.018
2018-01-31 15:41:16,138 [salt.state       ][INFO    ][6798] Running state [msg02.baremetal-mcp-pike-odl-ha.local] at time 15:41:16.138818
2018-01-31 15:41:16,139 [salt.state       ][INFO    ][6798] Executing state host.present for msg02.baremetal-mcp-pike-odl-ha.local
2018-01-31 15:41:16,139 [salt.state       ][INFO    ][6798] Host msg02.baremetal-mcp-pike-odl-ha.local (192.168.10.42) already present
2018-01-31 15:41:16,139 [salt.state       ][INFO    ][6798] Completed state [msg02.baremetal-mcp-pike-odl-ha.local] at time 15:41:16.139826 duration_in_ms=1.009
2018-01-31 15:41:16,140 [salt.state       ][INFO    ][6798] Running state [msg03] at time 15:41:16.140110
2018-01-31 15:41:16,140 [salt.state       ][INFO    ][6798] Executing state host.present for msg03
2018-01-31 15:41:16,140 [salt.state       ][INFO    ][6798] Host msg03 (192.168.10.43) already present
2018-01-31 15:41:16,141 [salt.state       ][INFO    ][6798] Completed state [msg03] at time 15:41:16.141140 duration_in_ms=1.029
2018-01-31 15:41:16,141 [salt.state       ][INFO    ][6798] Running state [msg03.baremetal-mcp-pike-odl-ha.local] at time 15:41:16.141410
2018-01-31 15:41:16,141 [salt.state       ][INFO    ][6798] Executing state host.present for msg03.baremetal-mcp-pike-odl-ha.local
2018-01-31 15:41:16,142 [salt.state       ][INFO    ][6798] Host msg03.baremetal-mcp-pike-odl-ha.local (192.168.10.43) already present
2018-01-31 15:41:16,142 [salt.state       ][INFO    ][6798] Completed state [msg03.baremetal-mcp-pike-odl-ha.local] at time 15:41:16.142763 duration_in_ms=1.353
2018-01-31 15:41:16,143 [salt.state       ][INFO    ][6798] Running state [msg01] at time 15:41:16.143042
2018-01-31 15:41:16,143 [salt.state       ][INFO    ][6798] Executing state host.present for msg01
2018-01-31 15:41:16,143 [salt.state       ][INFO    ][6798] Host msg01 (192.168.10.41) already present
2018-01-31 15:41:16,144 [salt.state       ][INFO    ][6798] Completed state [msg01] at time 15:41:16.144053 duration_in_ms=1.011
2018-01-31 15:41:16,144 [salt.state       ][INFO    ][6798] Running state [msg01.baremetal-mcp-pike-odl-ha.local] at time 15:41:16.144332
2018-01-31 15:41:16,144 [salt.state       ][INFO    ][6798] Executing state host.present for msg01.baremetal-mcp-pike-odl-ha.local
2018-01-31 15:41:16,145 [salt.state       ][INFO    ][6798] Host msg01.baremetal-mcp-pike-odl-ha.local (192.168.10.41) already present
2018-01-31 15:41:16,145 [salt.state       ][INFO    ][6798] Completed state [msg01.baremetal-mcp-pike-odl-ha.local] at time 15:41:16.145368 duration_in_ms=1.036
2018-01-31 15:41:16,147 [salt.state       ][INFO    ][6798] Running state [file.replace] at time 15:41:16.147273
2018-01-31 15:41:16,147 [salt.state       ][INFO    ][6798] Executing state module.run for file.replace
2018-01-31 15:41:16,365 [salt.loaded.int.module.cmdmod][INFO    ][6798] Executing command ['git', '--version'] in directory '/root'
2018-01-31 15:41:16,541 [salt.loaded.int.module.cmdmod][INFO    ][6798] Executing command 'grep -q "msg01 msg01.baremetal-mcp-pike-odl-ha.local" /etc/hosts' in directory '/root'
2018-01-31 15:41:16,623 [salt.state       ][INFO    ][6798] {'ret': '--- \n+++ \n@@ -20,7 +20,7 @@\n 192.168.10.105\t\tprx02 prx02.baremetal-mcp-pike-odl-ha.local\n 192.168.10.42\t\tmsg02 msg02.baremetal-mcp-pike-odl-ha.local\n 192.168.10.43\t\tmsg03 msg03.baremetal-mcp-pike-odl-ha.local\n-192.168.10.41\t\tmsg01 msg01.baremetal-mcp-pike-odl-ha.local\n+192.168.10.41\t\tmsg01.baremetal-mcp-pike-odl-ha.local msg01\n 192.168.10.40\t\tmsg msg.baremetal-mcp-pike-odl-ha.local\n 192.168.10.102\t\tcmp002 cmp002.baremetal-mcp-pike-odl-ha.local\n 192.168.10.101\t\tcmp001 cmp001.baremetal-mcp-pike-odl-ha.local\n'}
2018-01-31 15:41:16,623 [salt.state       ][INFO    ][6798] Completed state [file.replace] at time 15:41:16.623789 duration_in_ms=476.515
2018-01-31 15:41:16,624 [salt.state       ][INFO    ][6798] Running state [msg] at time 15:41:16.624134
2018-01-31 15:41:16,624 [salt.state       ][INFO    ][6798] Executing state host.present for msg
2018-01-31 15:41:16,625 [salt.state       ][INFO    ][6798] Host msg (192.168.10.40) already present
2018-01-31 15:41:16,625 [salt.state       ][INFO    ][6798] Completed state [msg] at time 15:41:16.625407 duration_in_ms=1.273
2018-01-31 15:41:16,625 [salt.state       ][INFO    ][6798] Running state [msg.baremetal-mcp-pike-odl-ha.local] at time 15:41:16.625748
2018-01-31 15:41:16,627 [salt.state       ][INFO    ][6798] Executing state host.present for msg.baremetal-mcp-pike-odl-ha.local
2018-01-31 15:41:16,627 [salt.state       ][INFO    ][6798] Host msg.baremetal-mcp-pike-odl-ha.local (192.168.10.40) already present
2018-01-31 15:41:16,628 [salt.state       ][INFO    ][6798] Completed state [msg.baremetal-mcp-pike-odl-ha.local] at time 15:41:16.627957 duration_in_ms=2.209
2018-01-31 15:41:16,628 [salt.state       ][INFO    ][6798] Running state [cfg01] at time 15:41:16.628258
2018-01-31 15:41:16,628 [salt.state       ][INFO    ][6798] Executing state host.present for cfg01
2018-01-31 15:41:16,629 [salt.state       ][INFO    ][6798] Host cfg01 (192.168.10.100) already present
2018-01-31 15:41:16,629 [salt.state       ][INFO    ][6798] Completed state [cfg01] at time 15:41:16.629309 duration_in_ms=1.051
2018-01-31 15:41:16,629 [salt.state       ][INFO    ][6798] Running state [cfg01.baremetal-mcp-pike-odl-ha.local] at time 15:41:16.629585
2018-01-31 15:41:16,629 [salt.state       ][INFO    ][6798] Executing state host.present for cfg01.baremetal-mcp-pike-odl-ha.local
2018-01-31 15:41:16,630 [salt.state       ][INFO    ][6798] Host cfg01.baremetal-mcp-pike-odl-ha.local (192.168.10.100) already present
2018-01-31 15:41:16,630 [salt.state       ][INFO    ][6798] Completed state [cfg01.baremetal-mcp-pike-odl-ha.local] at time 15:41:16.630623 duration_in_ms=1.038
2018-01-31 15:41:16,630 [salt.state       ][INFO    ][6798] Running state [cmp002] at time 15:41:16.630909
2018-01-31 15:41:16,631 [salt.state       ][INFO    ][6798] Executing state host.present for cmp002
2018-01-31 15:41:16,631 [salt.state       ][INFO    ][6798] Host cmp002 (192.168.10.102) already present
2018-01-31 15:41:16,631 [salt.state       ][INFO    ][6798] Completed state [cmp002] at time 15:41:16.631934 duration_in_ms=1.025
2018-01-31 15:41:16,632 [salt.state       ][INFO    ][6798] Running state [cmp002.baremetal-mcp-pike-odl-ha.local] at time 15:41:16.632215
2018-01-31 15:41:16,632 [salt.state       ][INFO    ][6798] Executing state host.present for cmp002.baremetal-mcp-pike-odl-ha.local
2018-01-31 15:41:16,633 [salt.state       ][INFO    ][6798] Host cmp002.baremetal-mcp-pike-odl-ha.local (192.168.10.102) already present
2018-01-31 15:41:16,633 [salt.state       ][INFO    ][6798] Completed state [cmp002.baremetal-mcp-pike-odl-ha.local] at time 15:41:16.633242 duration_in_ms=1.027
2018-01-31 15:41:16,633 [salt.state       ][INFO    ][6798] Running state [cmp001] at time 15:41:16.633521
2018-01-31 15:41:16,633 [salt.state       ][INFO    ][6798] Executing state host.present for cmp001
2018-01-31 15:41:16,634 [salt.state       ][INFO    ][6798] Host cmp001 (192.168.10.101) already present
2018-01-31 15:41:16,634 [salt.state       ][INFO    ][6798] Completed state [cmp001] at time 15:41:16.634542 duration_in_ms=1.021
2018-01-31 15:41:16,634 [salt.state       ][INFO    ][6798] Running state [cmp001.baremetal-mcp-pike-odl-ha.local] at time 15:41:16.634815
2018-01-31 15:41:16,635 [salt.state       ][INFO    ][6798] Executing state host.present for cmp001.baremetal-mcp-pike-odl-ha.local
2018-01-31 15:41:16,635 [salt.state       ][INFO    ][6798] Host cmp001.baremetal-mcp-pike-odl-ha.local (192.168.10.101) already present
2018-01-31 15:41:16,636 [salt.state       ][INFO    ][6798] Completed state [cmp001.baremetal-mcp-pike-odl-ha.local] at time 15:41:16.636124 duration_in_ms=1.308
2018-01-31 15:41:16,636 [salt.state       ][INFO    ][6798] Running state [dbs01] at time 15:41:16.636403
2018-01-31 15:41:16,636 [salt.state       ][INFO    ][6798] Executing state host.present for dbs01
2018-01-31 15:41:16,637 [salt.state       ][INFO    ][6798] Host dbs01 (192.168.10.51) already present
2018-01-31 15:41:16,637 [salt.state       ][INFO    ][6798] Completed state [dbs01] at time 15:41:16.637432 duration_in_ms=1.029
2018-01-31 15:41:16,637 [salt.state       ][INFO    ][6798] Running state [dbs01.baremetal-mcp-pike-odl-ha.local] at time 15:41:16.637708
2018-01-31 15:41:16,637 [salt.state       ][INFO    ][6798] Executing state host.present for dbs01.baremetal-mcp-pike-odl-ha.local
2018-01-31 15:41:16,639 [salt.state       ][INFO    ][6798] Host dbs01.baremetal-mcp-pike-odl-ha.local (192.168.10.51) already present
2018-01-31 15:41:16,639 [salt.state       ][INFO    ][6798] Completed state [dbs01.baremetal-mcp-pike-odl-ha.local] at time 15:41:16.639291 duration_in_ms=1.583
2018-01-31 15:41:16,639 [salt.state       ][INFO    ][6798] Running state [dbs02] at time 15:41:16.639568
2018-01-31 15:41:16,639 [salt.state       ][INFO    ][6798] Executing state host.present for dbs02
2018-01-31 15:41:16,640 [salt.state       ][INFO    ][6798] Host dbs02 (192.168.10.52) already present
2018-01-31 15:41:16,640 [salt.state       ][INFO    ][6798] Completed state [dbs02] at time 15:41:16.640595 duration_in_ms=1.027
2018-01-31 15:41:16,640 [salt.state       ][INFO    ][6798] Running state [dbs02.baremetal-mcp-pike-odl-ha.local] at time 15:41:16.640869
2018-01-31 15:41:16,641 [salt.state       ][INFO    ][6798] Executing state host.present for dbs02.baremetal-mcp-pike-odl-ha.local
2018-01-31 15:41:16,641 [salt.state       ][INFO    ][6798] Host dbs02.baremetal-mcp-pike-odl-ha.local (192.168.10.52) already present
2018-01-31 15:41:16,642 [salt.state       ][INFO    ][6798] Completed state [dbs02.baremetal-mcp-pike-odl-ha.local] at time 15:41:16.641976 duration_in_ms=1.106
2018-01-31 15:41:16,642 [salt.state       ][INFO    ][6798] Running state [dbs03] at time 15:41:16.642292
2018-01-31 15:41:16,642 [salt.state       ][INFO    ][6798] Executing state host.present for dbs03
2018-01-31 15:41:16,643 [salt.state       ][INFO    ][6798] Host dbs03 (192.168.10.53) already present
2018-01-31 15:41:16,643 [salt.state       ][INFO    ][6798] Completed state [dbs03] at time 15:41:16.643301 duration_in_ms=1.009
2018-01-31 15:41:16,643 [salt.state       ][INFO    ][6798] Running state [dbs03.baremetal-mcp-pike-odl-ha.local] at time 15:41:16.643575
2018-01-31 15:41:16,643 [salt.state       ][INFO    ][6798] Executing state host.present for dbs03.baremetal-mcp-pike-odl-ha.local
2018-01-31 15:41:16,644 [salt.state       ][INFO    ][6798] Host dbs03.baremetal-mcp-pike-odl-ha.local (192.168.10.53) already present
2018-01-31 15:41:16,644 [salt.state       ][INFO    ][6798] Completed state [dbs03.baremetal-mcp-pike-odl-ha.local] at time 15:41:16.644606 duration_in_ms=1.031
2018-01-31 15:41:16,644 [salt.state       ][INFO    ][6798] Running state [odl01] at time 15:41:16.644884
2018-01-31 15:41:16,645 [salt.state       ][INFO    ][6798] Executing state host.present for odl01
2018-01-31 15:41:16,645 [salt.state       ][INFO    ][6798] Host odl01 (192.168.10.111) already present
2018-01-31 15:41:16,645 [salt.state       ][INFO    ][6798] Completed state [odl01] at time 15:41:16.645889 duration_in_ms=1.005
2018-01-31 15:41:16,646 [salt.state       ][INFO    ][6798] Running state [odl01.baremetal-mcp-pike-odl-ha.local] at time 15:41:16.646172
2018-01-31 15:41:16,646 [salt.state       ][INFO    ][6798] Executing state host.present for odl01.baremetal-mcp-pike-odl-ha.local
2018-01-31 15:41:16,646 [salt.state       ][INFO    ][6798] Host odl01.baremetal-mcp-pike-odl-ha.local (192.168.10.111) already present
2018-01-31 15:41:16,647 [salt.state       ][INFO    ][6798] Completed state [odl01.baremetal-mcp-pike-odl-ha.local] at time 15:41:16.647182 duration_in_ms=1.01
2018-01-31 15:41:16,647 [salt.state       ][INFO    ][6798] Running state [mas01] at time 15:41:16.647455
2018-01-31 15:41:16,647 [salt.state       ][INFO    ][6798] Executing state host.present for mas01
2018-01-31 15:41:16,648 [salt.state       ][INFO    ][6798] Host mas01 (192.168.10.3) already present
2018-01-31 15:41:16,648 [salt.state       ][INFO    ][6798] Completed state [mas01] at time 15:41:16.648456 duration_in_ms=1.001
2018-01-31 15:41:16,648 [salt.state       ][INFO    ][6798] Running state [mas01.baremetal-mcp-pike-odl-ha.local] at time 15:41:16.648748
2018-01-31 15:41:16,649 [salt.state       ][INFO    ][6798] Executing state host.present for mas01.baremetal-mcp-pike-odl-ha.local
2018-01-31 15:41:16,649 [salt.state       ][INFO    ][6798] Host mas01.baremetal-mcp-pike-odl-ha.local (192.168.10.3) already present
2018-01-31 15:41:16,649 [salt.state       ][INFO    ][6798] Completed state [mas01.baremetal-mcp-pike-odl-ha.local] at time 15:41:16.649755 duration_in_ms=1.007
2018-01-31 15:41:16,650 [salt.state       ][INFO    ][6798] Running state [ctl02] at time 15:41:16.650619
2018-01-31 15:41:16,650 [salt.state       ][INFO    ][6798] Executing state host.present for ctl02
2018-01-31 15:41:16,651 [salt.state       ][INFO    ][6798] Host ctl02 (192.168.10.12) already present
2018-01-31 15:41:16,651 [salt.state       ][INFO    ][6798] Completed state [ctl02] at time 15:41:16.651627 duration_in_ms=1.008
2018-01-31 15:41:16,651 [salt.state       ][INFO    ][6798] Running state [ctl02.baremetal-mcp-pike-odl-ha.local] at time 15:41:16.651900
2018-01-31 15:41:16,652 [salt.state       ][INFO    ][6798] Executing state host.present for ctl02.baremetal-mcp-pike-odl-ha.local
2018-01-31 15:41:16,652 [salt.state       ][INFO    ][6798] Host ctl02.baremetal-mcp-pike-odl-ha.local (192.168.10.12) already present
2018-01-31 15:41:16,653 [salt.state       ][INFO    ][6798] Completed state [ctl02.baremetal-mcp-pike-odl-ha.local] at time 15:41:16.653081 duration_in_ms=1.181
2018-01-31 15:41:16,653 [salt.state       ][INFO    ][6798] Running state [ctl03] at time 15:41:16.653359
2018-01-31 15:41:16,653 [salt.state       ][INFO    ][6798] Executing state host.present for ctl03
2018-01-31 15:41:16,654 [salt.state       ][INFO    ][6798] Host ctl03 (192.168.10.13) already present
2018-01-31 15:41:16,654 [salt.state       ][INFO    ][6798] Completed state [ctl03] at time 15:41:16.654385 duration_in_ms=1.026
2018-01-31 15:41:16,654 [salt.state       ][INFO    ][6798] Running state [ctl03.baremetal-mcp-pike-odl-ha.local] at time 15:41:16.654663
2018-01-31 15:41:16,654 [salt.state       ][INFO    ][6798] Executing state host.present for ctl03.baremetal-mcp-pike-odl-ha.local
2018-01-31 15:41:16,655 [salt.state       ][INFO    ][6798] Host ctl03.baremetal-mcp-pike-odl-ha.local (192.168.10.13) already present
2018-01-31 15:41:16,655 [salt.state       ][INFO    ][6798] Completed state [ctl03.baremetal-mcp-pike-odl-ha.local] at time 15:41:16.655670 duration_in_ms=1.007
2018-01-31 15:41:16,655 [salt.state       ][INFO    ][6798] Running state [ctl01] at time 15:41:16.655951
2018-01-31 15:41:16,656 [salt.state       ][INFO    ][6798] Executing state host.present for ctl01
2018-01-31 15:41:16,656 [salt.state       ][INFO    ][6798] Host ctl01 (192.168.10.11) already present
2018-01-31 15:41:16,657 [salt.state       ][INFO    ][6798] Completed state [ctl01] at time 15:41:16.656971 duration_in_ms=1.02
2018-01-31 15:41:16,657 [salt.state       ][INFO    ][6798] Running state [ctl01.baremetal-mcp-pike-odl-ha.local] at time 15:41:16.657244
2018-01-31 15:41:16,657 [salt.state       ][INFO    ][6798] Executing state host.present for ctl01.baremetal-mcp-pike-odl-ha.local
2018-01-31 15:41:16,658 [salt.state       ][INFO    ][6798] Host ctl01.baremetal-mcp-pike-odl-ha.local (192.168.10.11) already present
2018-01-31 15:41:16,658 [salt.state       ][INFO    ][6798] Completed state [ctl01.baremetal-mcp-pike-odl-ha.local] at time 15:41:16.658265 duration_in_ms=1.021
2018-01-31 15:41:16,658 [salt.state       ][INFO    ][6798] Running state [ctl] at time 15:41:16.658541
2018-01-31 15:41:16,658 [salt.state       ][INFO    ][6798] Executing state host.present for ctl
2018-01-31 15:41:16,659 [salt.state       ][INFO    ][6798] Host ctl (192.168.10.10) already present
2018-01-31 15:41:16,659 [salt.state       ][INFO    ][6798] Completed state [ctl] at time 15:41:16.659534 duration_in_ms=0.993
2018-01-31 15:41:16,659 [salt.state       ][INFO    ][6798] Running state [ctl.baremetal-mcp-pike-odl-ha.local] at time 15:41:16.659807
2018-01-31 15:41:16,660 [salt.state       ][INFO    ][6798] Executing state host.present for ctl.baremetal-mcp-pike-odl-ha.local
2018-01-31 15:41:16,660 [salt.state       ][INFO    ][6798] Host ctl.baremetal-mcp-pike-odl-ha.local (192.168.10.10) already present
2018-01-31 15:41:16,660 [salt.state       ][INFO    ][6798] Completed state [ctl.baremetal-mcp-pike-odl-ha.local] at time 15:41:16.660832 duration_in_ms=1.025
2018-01-31 15:41:16,661 [salt.state       ][INFO    ][6798] Running state [/etc/network/interfaces.d/50-cloud-init.cfg] at time 15:41:16.661108
2018-01-31 15:41:16,661 [salt.state       ][INFO    ][6798] Executing state file.absent for /etc/network/interfaces.d/50-cloud-init.cfg
2018-01-31 15:41:16,661 [salt.state       ][INFO    ][6798] File /etc/network/interfaces.d/50-cloud-init.cfg is not present
2018-01-31 15:41:16,662 [salt.state       ][INFO    ][6798] Completed state [/etc/network/interfaces.d/50-cloud-init.cfg] at time 15:41:16.661978 duration_in_ms=0.87
2018-01-31 15:41:16,663 [salt.state       ][INFO    ][6798] Running state [ens2] at time 15:41:16.663113
2018-01-31 15:41:16,663 [salt.state       ][INFO    ][6798] Executing state network.managed for ens2
2018-01-31 15:41:17,561 [salt.state       ][INFO    ][6798] Interface ens2 is up to date.
2018-01-31 15:41:17,561 [salt.state       ][INFO    ][6798] Completed state [ens2] at time 15:41:17.561888 duration_in_ms=898.774
2018-01-31 15:41:17,562 [salt.state       ][INFO    ][6798] Running state [ens3] at time 15:41:17.562354
2018-01-31 15:41:17,562 [salt.state       ][INFO    ][6798] Executing state network.managed for ens3
2018-01-31 15:41:18,285 [salt.state       ][INFO    ][6798] Interface ens3 is up to date.
2018-01-31 15:41:18,286 [salt.state       ][INFO    ][6798] Completed state [ens3] at time 15:41:18.286356 duration_in_ms=724.001
2018-01-31 15:41:18,286 [salt.state       ][INFO    ][6798] Running state [/etc/profile.d/proxy.sh] at time 15:41:18.286797
2018-01-31 15:41:18,287 [salt.state       ][INFO    ][6798] Executing state file.absent for /etc/profile.d/proxy.sh
2018-01-31 15:41:18,287 [salt.state       ][INFO    ][6798] File /etc/profile.d/proxy.sh is not present
2018-01-31 15:41:18,287 [salt.state       ][INFO    ][6798] Completed state [/etc/profile.d/proxy.sh] at time 15:41:18.287931 duration_in_ms=1.134
2018-01-31 15:41:18,288 [salt.state       ][INFO    ][6798] Running state [/etc/apt/apt.conf.d/95proxies] at time 15:41:18.288213
2018-01-31 15:41:18,288 [salt.state       ][INFO    ][6798] Executing state file.absent for /etc/apt/apt.conf.d/95proxies
2018-01-31 15:41:18,288 [salt.state       ][INFO    ][6798] File /etc/apt/apt.conf.d/95proxies is not present
2018-01-31 15:41:18,289 [salt.state       ][INFO    ][6798] Completed state [/etc/apt/apt.conf.d/95proxies] at time 15:41:18.289043 duration_in_ms=0.831
2018-01-31 15:41:18,289 [salt.state       ][INFO    ][6798] Running state [ntp] at time 15:41:18.289323
2018-01-31 15:41:18,289 [salt.state       ][INFO    ][6798] Executing state pkg.installed for ntp
2018-01-31 15:41:18,299 [salt.state       ][INFO    ][6798] All specified packages are already installed
2018-01-31 15:41:18,299 [salt.state       ][INFO    ][6798] Completed state [ntp] at time 15:41:18.299398 duration_in_ms=10.075
2018-01-31 15:41:18,301 [salt.state       ][INFO    ][6798] Running state [/etc/ntp.conf] at time 15:41:18.300991
2018-01-31 15:41:18,301 [salt.state       ][INFO    ][6798] Executing state file.managed for /etc/ntp.conf
2018-01-31 15:41:18,372 [salt.state       ][INFO    ][6798] File /etc/ntp.conf is in the correct state
2018-01-31 15:41:18,372 [salt.state       ][INFO    ][6798] Completed state [/etc/ntp.conf] at time 15:41:18.372805 duration_in_ms=71.814
2018-01-31 15:41:18,374 [salt.state       ][INFO    ][6798] Running state [ntp] at time 15:41:18.374070
2018-01-31 15:41:18,374 [salt.state       ][INFO    ][6798] Executing state service.running for ntp
2018-01-31 15:41:18,375 [salt.loaded.int.module.cmdmod][INFO    ][6798] Executing command ['systemctl', 'status', 'ntp.service', '-n', '0'] in directory '/root'
2018-01-31 15:41:18,400 [salt.loaded.int.module.cmdmod][INFO    ][6798] Executing command ['systemctl', 'is-active', 'ntp.service'] in directory '/root'
2018-01-31 15:41:18,421 [salt.loaded.int.module.cmdmod][INFO    ][6798] Executing command ['systemctl', 'is-enabled', 'ntp.service'] in directory '/root'
2018-01-31 15:41:18,445 [salt.state       ][INFO    ][6798] The service ntp is already running
2018-01-31 15:41:18,446 [salt.state       ][INFO    ][6798] Completed state [ntp] at time 15:41:18.446470 duration_in_ms=72.399
2018-01-31 15:41:18,451 [salt.minion      ][INFO    ][6798] Returning information for job: 20180131154100272253
2018-01-31 15:41:37,808 [salt.minion      ][INFO    ][2017] User sudo_ubuntu Executing command ssh.set_auth_key with jid 20180131154139208473
2018-01-31 15:41:37,834 [salt.minion      ][INFO    ][8157] Starting a new job with PID 8157
2018-01-31 15:41:37,845 [salt.loader.192.168.11.2.int.module.ssh][WARNING ][8157] Public Key hashing currently defaults to "md5". This will change to "sha256" in the Nitrogen release.
2018-01-31 15:41:37,847 [salt.minion      ][INFO    ][8157] Returning information for job: 20180131154139208473
2018-01-31 15:42:01,199 [salt.minion      ][INFO    ][2017] User sudo_ubuntu Executing command pkg.upgrade with jid 20180131154202597998
2018-01-31 15:42:01,231 [salt.minion      ][INFO    ][8169] Starting a new job with PID 8169
2018-01-31 15:42:01,259 [salt.loader.192.168.11.2.int.module.cmdmod][INFO    ][8169] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2018-01-31 15:42:01,623 [salt.loader.192.168.11.2.int.module.cmdmod][INFO    ][8169] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'upgrade'] in directory '/root'
2018-01-31 15:42:11,264 [salt.minion      ][INFO    ][2017] User sudo_ubuntu Executing command saltutil.find_job with jid 20180131154212664272
2018-01-31 15:42:11,282 [salt.minion      ][INFO    ][8939] Starting a new job with PID 8939
2018-01-31 15:42:11,300 [salt.minion      ][INFO    ][8939] Returning information for job: 20180131154212664272
2018-01-31 15:42:13,047 [salt.loader.192.168.11.2.int.module.cmdmod][INFO    ][8169] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2018-01-31 15:42:13,089 [salt.minion      ][INFO    ][8169] Returning information for job: 20180131154202597998
2018-01-31 15:48:44,837 [salt.minion      ][INFO    ][2017] User sudo_ubuntu Executing command test.ping with jid 20180131154846240543
2018-01-31 15:48:44,867 [salt.minion      ][INFO    ][9092] Starting a new job with PID 9092
2018-01-31 15:48:44,931 [salt.minion      ][INFO    ][9092] Returning information for job: 20180131154846240543
2018-01-31 15:49:40,239 [salt.minion      ][INFO    ][2017] User sudo_ubuntu Executing command state.sls with jid 20180131154941643043
2018-01-31 15:49:40,267 [salt.minion      ][INFO    ][9097] Starting a new job with PID 9097
2018-01-31 15:49:42,618 [salt.state       ][INFO    ][9097] Loading fresh modules for state activity
2018-01-31 15:49:42,678 [salt.fileclient  ][INFO    ][9097] Fetching file from saltenv 'base', ** done ** 'keepalived/init.sls'
2018-01-31 15:49:42,713 [salt.fileclient  ][INFO    ][9097] Fetching file from saltenv 'base', ** done ** 'keepalived/cluster.sls'
2018-01-31 15:49:43,319 [salt.state       ][INFO    ][9097] Running state [keepalived] at time 15:49:43.319172
2018-01-31 15:49:43,320 [salt.state       ][INFO    ][9097] Executing state pkg.installed for keepalived
2018-01-31 15:49:43,320 [salt.loaded.int.module.cmdmod][INFO    ][9097] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2018-01-31 15:49:43,684 [salt.loaded.int.module.cmdmod][INFO    ][9097] Executing command ['apt-cache', '-q', 'policy', 'keepalived'] in directory '/root'
2018-01-31 15:49:43,776 [salt.loaded.int.module.cmdmod][INFO    ][9097] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2018-01-31 15:49:45,688 [salt.loaded.int.module.cmdmod][INFO    ][9097] Executing command ['dpkg', '--get-selections', '*'] in directory '/root'
2018-01-31 15:49:45,720 [salt.loaded.int.module.cmdmod][INFO    ][9097] 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-01-31 15:49:49,647 [salt.loaded.int.module.cmdmod][INFO    ][9097] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2018-01-31 15:49:49,696 [salt.state       ][INFO    ][9097] Made the following changes:
'libsnmp30' changed from 'absent' to '5.7.3+dfsg-1ubuntu4'
'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'
'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-01-31 15:49:49,717 [salt.state       ][INFO    ][9097] Loading fresh modules for state activity
2018-01-31 15:49:49,753 [salt.state       ][INFO    ][9097] Completed state [keepalived] at time 15:49:49.753039 duration_in_ms=6433.867
2018-01-31 15:49:49,763 [salt.state       ][INFO    ][9097] Running state [lsof] at time 15:49:49.763352
2018-01-31 15:49:49,763 [salt.state       ][INFO    ][9097] Executing state pkg.installed for lsof
2018-01-31 15:49:50,154 [salt.state       ][INFO    ][9097] All specified packages are already installed
2018-01-31 15:49:50,154 [salt.state       ][INFO    ][9097] Completed state [lsof] at time 15:49:50.154859 duration_in_ms=391.506
2018-01-31 15:49:50,157 [salt.state       ][INFO    ][9097] Running state [/etc/keepalived/keepalived.conf] at time 15:49:50.157381
2018-01-31 15:49:50,157 [salt.state       ][INFO    ][9097] Executing state file.managed for /etc/keepalived/keepalived.conf
2018-01-31 15:49:50,208 [salt.fileclient  ][INFO    ][9097] Fetching file from saltenv 'base', ** done ** 'keepalived/files/keepalived.conf'
2018-01-31 15:49:50,270 [salt.state       ][INFO    ][9097] File changed:
New file
2018-01-31 15:49:50,270 [salt.state       ][INFO    ][9097] Completed state [/etc/keepalived/keepalived.conf] at time 15:49:50.270924 duration_in_ms=113.541
2018-01-31 15:49:50,271 [salt.state       ][INFO    ][9097] Running state [keepalived] at time 15:49:50.271946
2018-01-31 15:49:50,272 [salt.state       ][INFO    ][9097] Executing state service.running for keepalived
2018-01-31 15:49:50,273 [salt.loaded.int.module.cmdmod][INFO    ][9097] Executing command ['systemctl', 'status', 'keepalived.service', '-n', '0'] in directory '/root'
2018-01-31 15:49:50,291 [salt.loaded.int.module.cmdmod][INFO    ][9097] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2018-01-31 15:49:50,316 [salt.loaded.int.module.cmdmod][INFO    ][9097] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2018-01-31 15:49:50,335 [salt.minion      ][INFO    ][2017] User sudo_ubuntu Executing command saltutil.find_job with jid 20180131154951698083
2018-01-31 15:49:50,336 [salt.loaded.int.module.cmdmod][INFO    ][9097] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2018-01-31 15:49:50,355 [salt.minion      ][INFO    ][10359] Starting a new job with PID 10359
2018-01-31 15:49:50,363 [salt.loaded.int.module.cmdmod][INFO    ][9097] Executing command ['systemd-run', '--scope', 'systemctl', 'start', 'keepalived.service'] in directory '/root'
2018-01-31 15:49:50,373 [salt.minion      ][INFO    ][10359] Returning information for job: 20180131154951698083
2018-01-31 15:49:50,440 [salt.loaded.int.module.cmdmod][INFO    ][9097] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2018-01-31 15:49:50,461 [salt.loaded.int.module.cmdmod][INFO    ][9097] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2018-01-31 15:49:50,481 [salt.loaded.int.module.cmdmod][INFO    ][9097] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2018-01-31 15:49:50,499 [salt.state       ][INFO    ][9097] {'keepalived': True}
2018-01-31 15:49:50,500 [salt.state       ][INFO    ][9097] Completed state [keepalived] at time 15:49:50.500796 duration_in_ms=228.849
2018-01-31 15:49:50,503 [salt.minion      ][INFO    ][9097] Returning information for job: 20180131154941643043
2018-01-31 15:51:40,995 [salt.minion      ][INFO    ][2017] User sudo_ubuntu Executing command pillar.get with jid 20180131155142396019
2018-01-31 15:51:41,027 [salt.minion      ][INFO    ][10382] Starting a new job with PID 10382
2018-01-31 15:51:41,036 [salt.minion      ][INFO    ][10382] Returning information for job: 20180131155142396019
2018-01-31 15:51:41,799 [salt.minion      ][INFO    ][2017] User sudo_ubuntu Executing command state.sls with jid 20180131155143200331
2018-01-31 15:51:41,822 [salt.minion      ][INFO    ][10387] Starting a new job with PID 10387
2018-01-31 15:51:44,205 [salt.state       ][INFO    ][10387] Loading fresh modules for state activity
2018-01-31 15:51:44,260 [salt.fileclient  ][INFO    ][10387] Fetching file from saltenv 'base', ** done ** 'rabbitmq/init.sls'
2018-01-31 15:51:44,303 [salt.fileclient  ][INFO    ][10387] Fetching file from saltenv 'base', ** done ** 'rabbitmq/server/init.sls'
2018-01-31 15:51:44,336 [salt.fileclient  ][INFO    ][10387] Fetching file from saltenv 'base', ** done ** 'rabbitmq/server/service.sls'
2018-01-31 15:51:44,394 [salt.loaded.int.module.cmdmod][INFO    ][10387] Executing command 'cat /var/lib/rabbitmq/.erlang.cookie' in directory '/root'
2018-01-31 15:51:44,414 [salt.loaded.int.module.cmdmod][ERROR   ][10387] Command 'cat /var/lib/rabbitmq/.erlang.cookie' failed with return code: 1
2018-01-31 15:51:44,415 [salt.loaded.int.module.cmdmod][ERROR   ][10387] output: cat: /var/lib/rabbitmq/.erlang.cookie: No such file or directory
2018-01-31 15:51:44,464 [salt.fileclient  ][INFO    ][10387] Fetching file from saltenv 'base', ** done ** 'rabbitmq/server/ssl.sls'
2018-01-31 15:51:44,552 [salt.fileclient  ][INFO    ][10387] Fetching file from saltenv 'base', ** done ** 'rabbitmq/server/plugin.sls'
2018-01-31 15:51:44,622 [salt.fileclient  ][INFO    ][10387] Fetching file from saltenv 'base', ** done ** 'rabbitmq/server/vhost.sls'
2018-01-31 15:51:44,717 [salt.fileclient  ][INFO    ][10387] Fetching file from saltenv 'base', ** done ** 'rabbitmq/server/user.sls'
2018-01-31 15:51:44,785 [salt.fileclient  ][INFO    ][10387] Fetching file from saltenv 'base', ** done ** 'rabbitmq/cluster.sls'
2018-01-31 15:51:45,366 [salt.state       ][INFO    ][10387] Running state [rabbitmq-server] at time 15:51:45.366120
2018-01-31 15:51:45,366 [salt.state       ][INFO    ][10387] Executing state pkg.installed for rabbitmq-server
2018-01-31 15:51:45,367 [salt.loaded.int.module.cmdmod][INFO    ][10387] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2018-01-31 15:51:45,756 [salt.loaded.int.module.cmdmod][INFO    ][10387] Executing command ['apt-cache', '-q', 'policy', 'rabbitmq-server'] in directory '/root'
2018-01-31 15:51:45,867 [salt.loaded.int.module.cmdmod][INFO    ][10387] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2018-01-31 15:51:47,826 [salt.loaded.int.module.cmdmod][INFO    ][10387] Executing command ['dpkg', '--get-selections', '*'] in directory '/root'
2018-01-31 15:51:47,863 [salt.loaded.int.module.cmdmod][INFO    ][10387] 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-01-31 15:51:51,924 [salt.minion      ][INFO    ][2017] User sudo_ubuntu Executing command saltutil.find_job with jid 20180131155153318921
2018-01-31 15:51:51,952 [salt.minion      ][INFO    ][10800] Starting a new job with PID 10800
2018-01-31 15:51:51,970 [salt.minion      ][INFO    ][10800] Returning information for job: 20180131155153318921
2018-01-31 15:52:01,952 [salt.minion      ][INFO    ][2017] User sudo_ubuntu Executing command saltutil.find_job with jid 20180131155203352364
2018-01-31 15:52:01,976 [salt.minion      ][INFO    ][11568] Starting a new job with PID 11568
2018-01-31 15:52:01,995 [salt.minion      ][INFO    ][11568] Returning information for job: 20180131155203352364
2018-01-31 15:52:06,230 [salt.loaded.int.module.cmdmod][INFO    ][10387] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2018-01-31 15:52:06,281 [salt.state       ][INFO    ][10387] Made the following changes:
'libltdl7' changed from 'absent' to '2.4.6-0.1'
'erlang-asn1' changed from 'absent' to '1:18.3.4+dfsg-1.1~u16.04+mcp1'
'erlang-inets' changed from 'absent' to '1:18.3.4+dfsg-1.1~u16.04+mcp1'
'erlang-snmp' changed from 'absent' to '1:18.3.4+dfsg-1.1~u16.04+mcp1'
'erlang-percept' changed from 'absent' to '1:18.3.4+dfsg-1.1~u16.04+mcp1'
'erlang-abi-17.0' changed from 'absent' to '1'
'erlang-ic' changed from 'absent' to '1:18.3.4+dfsg-1.1~u16.04+mcp1'
'erlang-os-mon' changed from 'absent' to '1:18.3.4+dfsg-1.1~u16.04+mcp1'
'libodbc1' changed from 'absent' to '2.3.1-4.1'
'erlang-syntax-tools' changed from 'absent' to '1:18.3.4+dfsg-1.1~u16.04+mcp1'
'erlang-sd-notify' changed from 'absent' to '1.0-1.1~u16.04+mcp1'
'erlang-ssl' changed from 'absent' to '1:18.3.4+dfsg-1.1~u16.04+mcp1'
'erlang-ssh' changed from 'absent' to '1:18.3.4+dfsg-1.1~u16.04+mcp1'
'libsctp1' changed from 'absent' to '1.0.16+dfsg-3'
'erlang-runtime-tools' changed from 'absent' to '1:18.3.4+dfsg-1.1~u16.04+mcp1'
'erlang-eunit' changed from 'absent' to '1:18.3.4+dfsg-1.1~u16.04+mcp1'
'erlang-tools' changed from 'absent' to '1:18.3.4+dfsg-1.1~u16.04+mcp1'
'erlang-odbc' changed from 'absent' to '1:18.3.4+dfsg-1.1~u16.04+mcp1'
'erlang-parsetools' changed from 'absent' to '1:18.3.4+dfsg-1.1~u16.04+mcp1'
'erlang-public-key' changed from 'absent' to '1:18.3.4+dfsg-1.1~u16.04+mcp1'
'erlang-diameter' changed from 'absent' to '1:18.3.4+dfsg-1.1~u16.04+mcp1'
'erlang-corba' changed from 'absent' to '1:18.3.4+dfsg-1.1~u16.04+mcp1'
'erlang-xmerl' changed from 'absent' to '1:18.3.4+dfsg-1.1~u16.04+mcp1'
'erlang-nox' changed from 'absent' to '1:18.3.4+dfsg-1.1~u16.04+mcp1'
'rabbitmq-server' changed from 'absent' to '3.6.11-1~u16.04+mcp1'
'erlang-eldap' changed from 'absent' to '1:18.3.4+dfsg-1.1~u16.04+mcp1'
'erlang-edoc' changed from 'absent' to '1:18.3.4+dfsg-1.1~u16.04+mcp1'
'erlang-mnesia' changed from 'absent' to '1:18.3.4+dfsg-1.1~u16.04+mcp1'
'erlang-webtool' changed from 'absent' to '1:18.3.4+dfsg-1.1~u16.04+mcp1'
'erlang-crypto' changed from 'absent' to '1:18.3.4+dfsg-1.1~u16.04+mcp1'
'erlang-erl-docgen' changed from 'absent' to '1:18.3.4+dfsg-1.1~u16.04+mcp1'
'erlang-abi-15.b' changed from 'absent' to '1'
'erlang-base' changed from 'absent' to '1:18.3.4+dfsg-1.1~u16.04+mcp1'

2018-01-31 15:52:06,306 [salt.state       ][INFO    ][10387] Loading fresh modules for state activity
2018-01-31 15:52:06,337 [salt.state       ][INFO    ][10387] Completed state [rabbitmq-server] at time 15:52:06.337348 duration_in_ms=20971.229
2018-01-31 15:52:06,341 [salt.state       ][INFO    ][10387] Running state [/etc/rabbitmq/rabbitmq.config] at time 15:52:06.341317
2018-01-31 15:52:06,341 [salt.state       ][INFO    ][10387] Executing state file.managed for /etc/rabbitmq/rabbitmq.config
2018-01-31 15:52:06,391 [salt.fileclient  ][INFO    ][10387] Fetching file from saltenv 'base', ** done ** 'rabbitmq/files/rabbitmq.config'
2018-01-31 15:52:06,466 [salt.state       ][INFO    ][10387] File changed:
New file
2018-01-31 15:52:06,467 [salt.state       ][INFO    ][10387] Completed state [/etc/rabbitmq/rabbitmq.config] at time 15:52:06.467069 duration_in_ms=125.751
2018-01-31 15:52:06,467 [salt.state       ][INFO    ][10387] Running state [/etc/default/rabbitmq-server] at time 15:52:06.467478
2018-01-31 15:52:06,467 [salt.state       ][INFO    ][10387] Executing state file.managed for /etc/default/rabbitmq-server
2018-01-31 15:52:06,504 [salt.fileclient  ][INFO    ][10387] Fetching file from saltenv 'base', ** done ** 'rabbitmq/files/default'
2018-01-31 15:52:06,550 [salt.state       ][INFO    ][10387] 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,13 +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 -H -n 105472 || true
+
+ulimit -n 8192
2018-01-31 15:52:06,550 [salt.state       ][INFO    ][10387] Completed state [/etc/default/rabbitmq-server] at time 15:52:06.550630 duration_in_ms=83.151
2018-01-31 15:52:06,551 [salt.state       ][INFO    ][10387] Running state [/etc/systemd/system/rabbitmq-server.service.d/limits.conf] at time 15:52:06.551041
2018-01-31 15:52:06,551 [salt.state       ][INFO    ][10387] Executing state file.managed for /etc/systemd/system/rabbitmq-server.service.d/limits.conf
2018-01-31 15:52:06,587 [salt.fileclient  ][INFO    ][10387] Fetching file from saltenv 'base', ** done ** 'rabbitmq/files/limits.conf'
2018-01-31 15:52:06,634 [salt.state       ][INFO    ][10387] File changed:
New file
2018-01-31 15:52:06,635 [salt.state       ][INFO    ][10387] Completed state [/etc/systemd/system/rabbitmq-server.service.d/limits.conf] at time 15:52:06.634986 duration_in_ms=83.944
2018-01-31 15:52:06,636 [salt.state       ][INFO    ][10387] Running state [sleep 30] at time 15:52:06.636231
2018-01-31 15:52:06,636 [salt.state       ][INFO    ][10387] Executing state cmd.run for sleep 30
2018-01-31 15:52:06,637 [py.warnings      ][WARNING ][10387] /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-01-31 15:52:06,639 [salt.loaded.int.module.cmdmod][INFO    ][10387] Executing command 'sleep 30' as user 'root' in directory '/root'
2018-01-31 15:52:11,976 [salt.minion      ][INFO    ][2017] User sudo_ubuntu Executing command saltutil.find_job with jid 20180131155213376637
2018-01-31 15:52:12,002 [salt.minion      ][INFO    ][11823] Starting a new job with PID 11823
2018-01-31 15:52:12,021 [salt.minion      ][INFO    ][11823] Returning information for job: 20180131155213376637
2018-01-31 15:52:22,008 [salt.minion      ][INFO    ][2017] User sudo_ubuntu Executing command saltutil.find_job with jid 20180131155223406102
2018-01-31 15:52:22,034 [salt.minion      ][INFO    ][11858] Starting a new job with PID 11858
2018-01-31 15:52:22,054 [salt.minion      ][INFO    ][11858] Returning information for job: 20180131155223406102
2018-01-31 15:52:32,047 [salt.minion      ][INFO    ][2017] User sudo_ubuntu Executing command saltutil.find_job with jid 20180131155233447665
2018-01-31 15:52:32,069 [salt.minion      ][INFO    ][11893] Starting a new job with PID 11893
2018-01-31 15:52:32,087 [salt.minion      ][INFO    ][11893] Returning information for job: 20180131155233447665
2018-01-31 15:52:36,772 [salt.state       ][INFO    ][10387] {'pid': 11797, 'retcode': 0, 'stderr': '', 'stdout': ''}
2018-01-31 15:52:36,773 [salt.state       ][INFO    ][10387] Completed state [sleep 30] at time 15:52:36.773581 duration_in_ms=30137.344
2018-01-31 15:52:36,776 [salt.state       ][INFO    ][10387] Running state [service rabbitmq-server stop] at time 15:52:36.775946
2018-01-31 15:52:36,776 [salt.state       ][INFO    ][10387] Executing state cmd.run for service rabbitmq-server stop
2018-01-31 15:52:36,778 [salt.loaded.int.module.cmdmod][INFO    ][10387] Executing command 'service rabbitmq-server stop' in directory '/root'
2018-01-31 15:52:38,277 [salt.state       ][INFO    ][10387] {'pid': 11912, 'retcode': 0, 'stderr': "Warning: rabbitmq-server.service changed on disk. Run 'systemctl daemon-reload' to reload units.", 'stdout': ''}
2018-01-31 15:52:38,277 [salt.state       ][INFO    ][10387] Completed state [service rabbitmq-server stop] at time 15:52:38.277603 duration_in_ms=1501.657
2018-01-31 15:52:38,278 [salt.state       ][INFO    ][10387] Running state [/var/lib/rabbitmq] at time 15:52:38.278401
2018-01-31 15:52:38,278 [salt.state       ][INFO    ][10387] Executing state file.directory for /var/lib/rabbitmq
2018-01-31 15:52:38,279 [salt.state       ][INFO    ][10387] Directory /var/lib/rabbitmq is in the correct state
2018-01-31 15:52:38,280 [salt.state       ][INFO    ][10387] Completed state [/var/lib/rabbitmq] at time 15:52:38.279965 duration_in_ms=1.564
2018-01-31 15:52:38,281 [salt.state       ][INFO    ][10387] Running state [/var/lib/rabbitmq/.erlang.cookie] at time 15:52:38.281329
2018-01-31 15:52:38,281 [salt.state       ][INFO    ][10387] Executing state file.managed for /var/lib/rabbitmq/.erlang.cookie
2018-01-31 15:52:38,285 [salt.state       ][INFO    ][10387] File changed:
--- 
+++ 
@@ -1 +1 @@
-FOWWAGDFHFFJEFELUZUA+opnfv_secret

2018-01-31 15:52:38,285 [salt.state       ][INFO    ][10387] Completed state [/var/lib/rabbitmq/.erlang.cookie] at time 15:52:38.285322 duration_in_ms=3.992
2018-01-31 15:52:38,285 [salt.state       ][INFO    ][10387] Running state [sleep 30] at time 15:52:38.285867
2018-01-31 15:52:38,286 [salt.state       ][INFO    ][10387] Executing state cmd.run for sleep 30
2018-01-31 15:52:38,287 [salt.loaded.int.module.cmdmod][INFO    ][10387] Executing command 'sleep 30' as user 'root' in directory '/root'
2018-01-31 15:52:42,086 [salt.minion      ][INFO    ][2017] User sudo_ubuntu Executing command saltutil.find_job with jid 20180131155243482034
2018-01-31 15:52:42,112 [salt.minion      ][INFO    ][12100] Starting a new job with PID 12100
2018-01-31 15:52:42,129 [salt.minion      ][INFO    ][12100] Returning information for job: 20180131155243482034
2018-01-31 15:52:52,138 [salt.minion      ][INFO    ][2017] User sudo_ubuntu Executing command saltutil.find_job with jid 20180131155253531051
2018-01-31 15:52:52,165 [salt.minion      ][INFO    ][12105] Starting a new job with PID 12105
2018-01-31 15:52:52,184 [salt.minion      ][INFO    ][12105] Returning information for job: 20180131155253531051
2018-01-31 15:53:02,226 [salt.minion      ][INFO    ][2017] User sudo_ubuntu Executing command saltutil.find_job with jid 20180131155303626504
2018-01-31 15:53:02,251 [salt.minion      ][INFO    ][12110] Starting a new job with PID 12110
2018-01-31 15:53:02,272 [salt.minion      ][INFO    ][12110] Returning information for job: 20180131155303626504
2018-01-31 15:53:08,401 [salt.state       ][INFO    ][10387] {'pid': 12090, 'retcode': 0, 'stderr': '', 'stdout': ''}
2018-01-31 15:53:08,402 [salt.state       ][INFO    ][10387] Completed state [sleep 30] at time 15:53:08.402667 duration_in_ms=30116.798
2018-01-31 15:53:08,448 [salt.state       ][INFO    ][10387] Running state [rabbitmq-server] at time 15:53:08.448512
2018-01-31 15:53:08,448 [salt.state       ][INFO    ][10387] Executing state service.running for rabbitmq-server
2018-01-31 15:53:08,449 [salt.loaded.int.module.cmdmod][INFO    ][10387] Executing command ['systemctl', 'status', 'rabbitmq-server.service', '-n', '0'] in directory '/root'
2018-01-31 15:53:08,481 [salt.loaded.int.module.cmdmod][INFO    ][10387] Executing command ['systemctl', '--system', 'daemon-reload'] in directory '/root'
2018-01-31 15:53:08,564 [salt.loaded.int.module.cmdmod][INFO    ][10387] Executing command ['systemctl', 'status', 'rabbitmq-server.service', '-n', '0'] in directory '/root'
2018-01-31 15:53:08,589 [salt.loaded.int.module.cmdmod][INFO    ][10387] Executing command ['systemctl', 'is-active', 'rabbitmq-server.service'] in directory '/root'
2018-01-31 15:53:08,612 [salt.loaded.int.module.cmdmod][INFO    ][10387] Executing command ['systemctl', 'is-enabled', 'rabbitmq-server.service'] in directory '/root'
2018-01-31 15:53:08,635 [salt.loaded.int.module.cmdmod][INFO    ][10387] Executing command ['systemctl', 'is-enabled', 'rabbitmq-server.service'] in directory '/root'
2018-01-31 15:53:08,659 [salt.loaded.int.module.cmdmod][INFO    ][10387] Executing command ['systemd-run', '--scope', 'systemctl', 'start', 'rabbitmq-server.service'] in directory '/root'
2018-01-31 15:53:11,355 [salt.loaded.int.module.cmdmod][INFO    ][10387] Executing command ['systemctl', 'is-active', 'rabbitmq-server.service'] in directory '/root'
2018-01-31 15:53:11,376 [salt.loaded.int.module.cmdmod][INFO    ][10387] Executing command ['systemctl', 'is-enabled', 'rabbitmq-server.service'] in directory '/root'
2018-01-31 15:53:11,396 [salt.loaded.int.module.cmdmod][INFO    ][10387] Executing command ['systemctl', 'is-enabled', 'rabbitmq-server.service'] in directory '/root'
2018-01-31 15:53:11,416 [salt.state       ][INFO    ][10387] {'rabbitmq-server': True}
2018-01-31 15:53:11,417 [salt.state       ][INFO    ][10387] Completed state [rabbitmq-server] at time 15:53:11.416958 duration_in_ms=2968.445
2018-01-31 15:53:11,419 [salt.state       ][INFO    ][10387] Running state [amqp_client] at time 15:53:11.419898
2018-01-31 15:53:11,420 [salt.state       ][INFO    ][10387] Executing state rabbitmq_plugin.enabled for amqp_client
2018-01-31 15:53:11,423 [salt.loaded.int.module.cmdmod][INFO    ][10387] Executing command ['/usr/sbin/rabbitmq-plugins', 'list', '-m', '-e'] as user 'root' in directory '/root'
2018-01-31 15:53:12,260 [salt.minion      ][INFO    ][2017] User sudo_ubuntu Executing command saltutil.find_job with jid 20180131155313659341
2018-01-31 15:53:12,282 [salt.minion      ][INFO    ][12520] Starting a new job with PID 12520
2018-01-31 15:53:12,299 [salt.minion      ][INFO    ][12520] Returning information for job: 20180131155313659341
2018-01-31 15:53:12,672 [salt.loaded.int.module.cmdmod][INFO    ][10387] Executing command ['/usr/sbin/rabbitmq-plugins', 'enable', 'amqp_client'] as user 'root' in directory '/root'
2018-01-31 15:53:14,122 [salt.state       ][INFO    ][10387] {'new': 'amqp_client', 'old': ''}
2018-01-31 15:53:14,122 [salt.state       ][INFO    ][10387] Completed state [amqp_client] at time 15:53:14.122867 duration_in_ms=2702.966
2018-01-31 15:53:14,123 [salt.state       ][INFO    ][10387] Running state [rabbitmq_management] at time 15:53:14.123732
2018-01-31 15:53:14,124 [salt.state       ][INFO    ][10387] Executing state rabbitmq_plugin.enabled for rabbitmq_management
2018-01-31 15:53:14,126 [salt.loaded.int.module.cmdmod][INFO    ][10387] Executing command ['/usr/sbin/rabbitmq-plugins', 'list', '-m', '-e'] as user 'root' in directory '/root'
2018-01-31 15:53:15,233 [salt.loaded.int.module.cmdmod][INFO    ][10387] Executing command ['/usr/sbin/rabbitmq-plugins', 'enable', 'rabbitmq_management'] as user 'root' in directory '/root'
2018-01-31 15:53:17,362 [salt.state       ][INFO    ][10387] {'new': 'rabbitmq_management', 'old': ''}
2018-01-31 15:53:17,363 [salt.state       ][INFO    ][10387] Completed state [rabbitmq_management] at time 15:53:17.363736 duration_in_ms=3240.003
2018-01-31 15:53:17,367 [salt.state       ][INFO    ][10387] Running state [/openstack] at time 15:53:17.367524
2018-01-31 15:53:17,368 [salt.state       ][INFO    ][10387] Executing state rabbitmq_vhost.present for /openstack
2018-01-31 15:53:17,369 [salt.loaded.int.module.cmdmod][INFO    ][10387] Executing command 'rabbitmqctl list_vhosts -q' as user 'root' in directory '/root'
2018-01-31 15:53:19,223 [salt.loaded.int.module.cmdmod][INFO    ][10387] Executing command ['rabbitmqctl', 'add_vhost', '/openstack'] as user 'root' in directory '/root'
2018-01-31 15:53:21,055 [salt.state       ][INFO    ][10387] {'new': '/openstack', 'old': ''}
2018-01-31 15:53:21,056 [salt.state       ][INFO    ][10387] Completed state [/openstack] at time 15:53:21.056445 duration_in_ms=3688.92
2018-01-31 15:53:21,060 [salt.state       ][INFO    ][10387] Running state [openstack] at time 15:53:21.060246
2018-01-31 15:53:21,060 [salt.state       ][INFO    ][10387] Executing state rabbitmq_user.present for openstack
2018-01-31 15:53:21,061 [salt.loaded.int.module.cmdmod][INFO    ][10387] Executing command ['rabbitmqctl', 'list_users'] as user 'root' in directory '/root'
2018-01-31 15:53:22,298 [salt.minion      ][INFO    ][2017] User sudo_ubuntu Executing command saltutil.find_job with jid 20180131155323695536
2018-01-31 15:53:22,321 [salt.minion      ][INFO    ][13547] Starting a new job with PID 13547
2018-01-31 15:53:22,338 [salt.minion      ][INFO    ][13547] Returning information for job: 20180131155323695536
2018-01-31 15:53:24,683 [salt.loaded.int.module.cmdmod][INFO    ][10387] Executing command ['rabbitmqctl', 'list_user_permissions', 'openstack'] as user 'root' in directory '/root'
2018-01-31 15:53:26,480 [salt.loaded.int.module.cmdmod][INFO    ][10387] Executing command ['rabbitmqctl', 'set_permissions', '-p', '/openstack', 'openstack', '.*', '.*', '.*'] as user 'root' in directory '/root'
2018-01-31 15:53:28,285 [salt.state       ][INFO    ][10387] Made the following changes:
'perms' changed from 'absent' to '{'/openstack': ['.*', '.*', '.*']}'
'user' changed from 'absent' to 'openstack'

2018-01-31 15:53:28,285 [salt.state       ][INFO    ][10387] Completed state [openstack] at time 15:53:28.285650 duration_in_ms=7225.404
2018-01-31 15:53:28,288 [salt.state       ][INFO    ][10387] Running state [Ceilometer] at time 15:53:28.288276
2018-01-31 15:53:28,288 [salt.state       ][INFO    ][10387] Executing state rabbitmq_policy.present for Ceilometer
2018-01-31 15:53:28,289 [salt.loaded.int.module.cmdmod][INFO    ][10387] Executing command ['rabbitmqctl', 'list_policies', '-p', '/openstack'] as user 'root' in directory '/root'
2018-01-31 15:53:30,117 [salt.loaded.int.module.cmdmod][INFO    ][10387] 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-01-31 15:53:31,980 [salt.state       ][INFO    ][10387] {'new': 'Ceilometer', 'old': {}}
2018-01-31 15:53:31,981 [salt.state       ][INFO    ][10387] Completed state [Ceilometer] at time 15:53:31.980973 duration_in_ms=3692.697
2018-01-31 15:53:31,981 [salt.state       ][INFO    ][10387] Running state [HA] at time 15:53:31.981760
2018-01-31 15:53:31,982 [salt.state       ][INFO    ][10387] Executing state rabbitmq_policy.present for HA
2018-01-31 15:53:31,984 [salt.loaded.int.module.cmdmod][INFO    ][10387] Executing command ['rabbitmqctl', 'list_policies', '-p', '/openstack'] as user 'root' in directory '/root'
2018-01-31 15:53:32,351 [salt.minion      ][INFO    ][2017] User sudo_ubuntu Executing command saltutil.find_job with jid 20180131155333743379
2018-01-31 15:53:32,374 [salt.minion      ][INFO    ][14626] Starting a new job with PID 14626
2018-01-31 15:53:32,391 [salt.minion      ][INFO    ][14626] Returning information for job: 20180131155333743379
2018-01-31 15:53:33,838 [salt.loaded.int.module.cmdmod][INFO    ][10387] Executing command ['rabbitmqctl', 'set_policy', '-p', '/openstack', 'HA', '^(?!amq\\.).*', '{"ha-mode": "all", "message-ttl": 120000}'] as user 'root' in directory '/root'
2018-01-31 15:53:35,677 [salt.state       ][INFO    ][10387] {'new': 'HA', 'old': {}}
2018-01-31 15:53:35,678 [salt.state       ][INFO    ][10387] Completed state [HA] at time 15:53:35.678429 duration_in_ms=3696.668
2018-01-31 15:53:35,678 [salt.state       ][INFO    ][10387] Running state [guest] at time 15:53:35.678900
2018-01-31 15:53:35,679 [salt.state       ][INFO    ][10387] Executing state rabbitmq_user.present for guest
2018-01-31 15:53:35,680 [salt.loaded.int.module.cmdmod][INFO    ][10387] Executing command ['rabbitmqctl', 'list_users'] as user 'root' in directory '/root'
2018-01-31 15:53:37,562 [salt.loaded.int.module.cmdmod][INFO    ][10387] Executing command ['rabbitmqctl', 'status'] as user 'root' in directory '/root'
2018-01-31 15:53:42,383 [salt.minion      ][INFO    ][2017] User sudo_ubuntu Executing command saltutil.find_job with jid 20180131155343776344
2018-01-31 15:53:42,405 [salt.minion      ][INFO    ][15570] Starting a new job with PID 15570
2018-01-31 15:53:42,423 [salt.minion      ][INFO    ][15570] Returning information for job: 20180131155343776344
2018-01-31 15:53:43,112 [salt.loaded.int.module.cmdmod][INFO    ][10387] Executing command ['rabbitmqctl', 'list_user_permissions', 'guest'] as user 'root' in directory '/root'
2018-01-31 15:53:44,992 [salt.state       ][INFO    ][10387] Made the following changes:
'password' changed from 'absent' to 'Set password.'

2018-01-31 15:53:44,993 [salt.state       ][INFO    ][10387] Completed state [guest] at time 15:53:44.993431 duration_in_ms=9314.53
2018-01-31 15:53:44,996 [salt.state       ][INFO    ][10387] Running state [HA] at time 15:53:44.996808
2018-01-31 15:53:44,997 [salt.state       ][INFO    ][10387] Executing state rabbitmq_policy.present for HA
2018-01-31 15:53:44,999 [salt.loaded.int.module.cmdmod][INFO    ][10387] Executing command ['rabbitmqctl', 'list_policies', '-p', '/'] as user 'root' in directory '/root'
2018-01-31 15:53:46,801 [salt.loaded.int.module.cmdmod][INFO    ][10387] Executing command ['rabbitmqctl', 'set_policy', '-p', '/', 'HA', '^(?!amq\\.).*', '{"ha-mode": "all", "message-ttl": 120000}'] as user 'root' in directory '/root'
2018-01-31 15:53:48,644 [salt.state       ][INFO    ][10387] {'new': 'HA', 'old': {}}
2018-01-31 15:53:48,645 [salt.state       ][INFO    ][10387] Completed state [HA] at time 15:53:48.644964 duration_in_ms=3648.156
2018-01-31 15:53:48,645 [salt.state       ][INFO    ][10387] Running state [admin] at time 15:53:48.645668
2018-01-31 15:53:48,646 [salt.state       ][INFO    ][10387] Executing state rabbitmq_user.present for admin
2018-01-31 15:53:48,647 [salt.loaded.int.module.cmdmod][INFO    ][10387] Executing command ['rabbitmqctl', 'list_users'] as user 'root' in directory '/root'
2018-01-31 15:53:52,336 [salt.loaded.int.module.cmdmod][INFO    ][10387] Executing command ['rabbitmqctl', 'list_users'] as user 'root' in directory '/root'
2018-01-31 15:53:52,420 [salt.minion      ][INFO    ][2017] User sudo_ubuntu Executing command saltutil.find_job with jid 20180131155353822402
2018-01-31 15:53:52,439 [salt.minion      ][INFO    ][16517] Starting a new job with PID 16517
2018-01-31 15:53:52,461 [salt.minion      ][INFO    ][16517] Returning information for job: 20180131155353822402
2018-01-31 15:53:54,145 [salt.loaded.int.module.cmdmod][INFO    ][10387] Executing command ['rabbitmqctl', 'set_user_tags', 'admin', 'administrator'] as user 'root' in directory '/root'
2018-01-31 15:53:55,957 [salt.loaded.int.module.cmdmod][INFO    ][10387] Executing command ['rabbitmqctl', 'list_user_permissions', 'admin'] as user 'root' in directory '/root'
2018-01-31 15:53:57,751 [salt.loaded.int.module.cmdmod][INFO    ][10387] Executing command ['rabbitmqctl', 'set_permissions', '-p', '/openstack', 'admin', '.*', '.*', '.*'] as user 'root' in directory '/root'
2018-01-31 15:53:59,623 [salt.loaded.int.module.cmdmod][INFO    ][10387] Executing command ['rabbitmqctl', 'set_permissions', '-p', '/', 'admin', '.*', '.*', '.*'] as user 'root' in directory '/root'
2018-01-31 15:54:01,451 [salt.state       ][INFO    ][10387] Made the following changes:
'perms' changed from 'absent' to '{'/openstack': ['.*', '.*', '.*'], '/': ['.*', '.*', '.*']}'
'user' changed from 'absent' to 'admin'
'tags' changed from '['']' to '['administrator']'

2018-01-31 15:54:01,452 [salt.state       ][INFO    ][10387] Completed state [admin] at time 15:54:01.452025 duration_in_ms=12806.355
2018-01-31 15:54:01,452 [salt.state       ][INFO    ][10387] Running state [rabbitmqctl set_cluster_name openstack && echo "openstack" > /var/lib/rabbitmq/.cluster_name
] at time 15:54:01.452766
2018-01-31 15:54:01,453 [salt.state       ][INFO    ][10387] Executing state cmd.run for rabbitmqctl set_cluster_name openstack && echo "openstack" > /var/lib/rabbitmq/.cluster_name

2018-01-31 15:54:01,455 [salt.loaded.int.module.cmdmod][INFO    ][10387] Executing command 'rabbitmqctl set_cluster_name openstack && echo "openstack" > /var/lib/rabbitmq/.cluster_name
' in directory '/root'
2018-01-31 15:54:02,459 [salt.minion      ][INFO    ][2017] User sudo_ubuntu Executing command saltutil.find_job with jid 20180131155403860554
2018-01-31 15:54:02,480 [salt.minion      ][INFO    ][17544] Starting a new job with PID 17544
2018-01-31 15:54:02,496 [salt.minion      ][INFO    ][17544] Returning information for job: 20180131155403860554
2018-01-31 15:54:03,201 [salt.state       ][INFO    ][10387] {'pid': 17413, 'retcode': 0, 'stderr': '', 'stdout': 'Setting cluster name to openstack'}
2018-01-31 15:54:03,202 [salt.state       ][INFO    ][10387] Completed state [rabbitmqctl set_cluster_name openstack && echo "openstack" > /var/lib/rabbitmq/.cluster_name
] at time 15:54:03.202127 duration_in_ms=1749.361
2018-01-31 15:54:03,204 [salt.minion      ][INFO    ][10387] Returning information for job: 20180131155143200331
2018-01-31 15:54:04,040 [salt.minion      ][INFO    ][2017] User sudo_ubuntu Executing command state.sls with jid 20180131155405442391
2018-01-31 15:54:04,062 [salt.minion      ][INFO    ][17593] Starting a new job with PID 17593
2018-01-31 15:54:06,666 [salt.state       ][INFO    ][17593] Loading fresh modules for state activity
2018-01-31 15:54:06,811 [salt.loaded.int.module.cmdmod][INFO    ][17593] Executing command 'cat /var/lib/rabbitmq/.erlang.cookie' in directory '/root'
2018-01-31 15:54:08,623 [salt.state       ][INFO    ][17593] Running state [rabbitmq-server] at time 15:54:08.623720
2018-01-31 15:54:08,624 [salt.state       ][INFO    ][17593] Executing state pkg.installed for rabbitmq-server
2018-01-31 15:54:08,625 [salt.loaded.int.module.cmdmod][INFO    ][17593] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2018-01-31 15:54:08,976 [salt.state       ][INFO    ][17593] All specified packages are already installed
2018-01-31 15:54:08,977 [salt.state       ][INFO    ][17593] Completed state [rabbitmq-server] at time 15:54:08.977073 duration_in_ms=353.353
2018-01-31 15:54:08,981 [salt.state       ][INFO    ][17593] Running state [/etc/rabbitmq/rabbitmq.config] at time 15:54:08.981059
2018-01-31 15:54:08,981 [salt.state       ][INFO    ][17593] Executing state file.managed for /etc/rabbitmq/rabbitmq.config
2018-01-31 15:54:09,078 [salt.state       ][INFO    ][17593] File /etc/rabbitmq/rabbitmq.config is in the correct state
2018-01-31 15:54:09,079 [salt.state       ][INFO    ][17593] Completed state [/etc/rabbitmq/rabbitmq.config] at time 15:54:09.079249 duration_in_ms=98.19
2018-01-31 15:54:09,079 [salt.state       ][INFO    ][17593] Running state [/etc/default/rabbitmq-server] at time 15:54:09.079881
2018-01-31 15:54:09,080 [salt.state       ][INFO    ][17593] Executing state file.managed for /etc/default/rabbitmq-server
2018-01-31 15:54:09,133 [salt.state       ][INFO    ][17593] File /etc/default/rabbitmq-server is in the correct state
2018-01-31 15:54:09,134 [salt.state       ][INFO    ][17593] Completed state [/etc/default/rabbitmq-server] at time 15:54:09.134320 duration_in_ms=54.439
2018-01-31 15:54:09,134 [salt.state       ][INFO    ][17593] Running state [/etc/systemd/system/rabbitmq-server.service.d/limits.conf] at time 15:54:09.134915
2018-01-31 15:54:09,135 [salt.state       ][INFO    ][17593] Executing state file.managed for /etc/systemd/system/rabbitmq-server.service.d/limits.conf
2018-01-31 15:54:09,234 [salt.state       ][INFO    ][17593] File /etc/systemd/system/rabbitmq-server.service.d/limits.conf is in the correct state
2018-01-31 15:54:09,235 [salt.state       ][INFO    ][17593] Completed state [/etc/systemd/system/rabbitmq-server.service.d/limits.conf] at time 15:54:09.235327 duration_in_ms=100.412
2018-01-31 15:54:09,236 [salt.state       ][INFO    ][17593] Running state [rabbitmq-server] at time 15:54:09.236873
2018-01-31 15:54:09,237 [salt.state       ][INFO    ][17593] Executing state service.running for rabbitmq-server
2018-01-31 15:54:09,238 [salt.loaded.int.module.cmdmod][INFO    ][17593] Executing command ['systemctl', 'status', 'rabbitmq-server.service', '-n', '0'] in directory '/root'
2018-01-31 15:54:09,280 [salt.loaded.int.module.cmdmod][INFO    ][17593] Executing command ['systemctl', 'is-active', 'rabbitmq-server.service'] in directory '/root'
2018-01-31 15:54:09,304 [salt.loaded.int.module.cmdmod][INFO    ][17593] Executing command ['systemctl', 'is-enabled', 'rabbitmq-server.service'] in directory '/root'
2018-01-31 15:54:09,327 [salt.state       ][INFO    ][17593] The service rabbitmq-server is already running
2018-01-31 15:54:09,328 [salt.state       ][INFO    ][17593] Completed state [rabbitmq-server] at time 15:54:09.328239 duration_in_ms=91.365
2018-01-31 15:54:09,331 [salt.state       ][INFO    ][17593] Running state [amqp_client] at time 15:54:09.331482
2018-01-31 15:54:09,331 [salt.state       ][INFO    ][17593] Executing state rabbitmq_plugin.enabled for amqp_client
2018-01-31 15:54:09,332 [salt.loaded.int.module.cmdmod][INFO    ][17593] Executing command ['/usr/sbin/rabbitmq-plugins', 'list', '-m', '-e'] as user 'root' in directory '/root'
2018-01-31 15:54:10,568 [salt.state       ][INFO    ][17593] Plugin 'amqp_client' is already enabled.
2018-01-31 15:54:10,569 [salt.state       ][INFO    ][17593] Completed state [amqp_client] at time 15:54:10.569424 duration_in_ms=1237.941
2018-01-31 15:54:10,570 [salt.state       ][INFO    ][17593] Running state [rabbitmq_management] at time 15:54:10.570812
2018-01-31 15:54:10,571 [salt.state       ][INFO    ][17593] Executing state rabbitmq_plugin.enabled for rabbitmq_management
2018-01-31 15:54:10,572 [salt.loaded.int.module.cmdmod][INFO    ][17593] Executing command ['/usr/sbin/rabbitmq-plugins', 'list', '-m', '-e'] as user 'root' in directory '/root'
2018-01-31 15:54:11,783 [salt.state       ][INFO    ][17593] Plugin 'rabbitmq_management' is already enabled.
2018-01-31 15:54:11,784 [salt.state       ][INFO    ][17593] Completed state [rabbitmq_management] at time 15:54:11.784093 duration_in_ms=1213.28
2018-01-31 15:54:11,787 [salt.state       ][INFO    ][17593] Running state [/openstack] at time 15:54:11.787571
2018-01-31 15:54:11,788 [salt.state       ][INFO    ][17593] Executing state rabbitmq_vhost.present for /openstack
2018-01-31 15:54:11,789 [salt.loaded.int.module.cmdmod][INFO    ][17593] Executing command 'rabbitmqctl list_vhosts -q' as user 'root' in directory '/root'
2018-01-31 15:54:13,624 [salt.state       ][INFO    ][17593] Virtual Host '/openstack' already exists.
2018-01-31 15:54:13,624 [salt.state       ][INFO    ][17593] Completed state [/openstack] at time 15:54:13.624485 duration_in_ms=1836.914
2018-01-31 15:54:13,628 [salt.state       ][INFO    ][17593] Running state [openstack] at time 15:54:13.627972
2018-01-31 15:54:13,628 [salt.state       ][INFO    ][17593] Executing state rabbitmq_user.present for openstack
2018-01-31 15:54:13,629 [salt.loaded.int.module.cmdmod][INFO    ][17593] Executing command ['rabbitmqctl', 'list_users'] as user 'root' in directory '/root'
2018-01-31 15:54:14,139 [salt.minion      ][INFO    ][2017] User sudo_ubuntu Executing command saltutil.find_job with jid 20180131155415541002
2018-01-31 15:54:14,162 [salt.minion      ][INFO    ][18297] Starting a new job with PID 18297
2018-01-31 15:54:14,179 [salt.minion      ][INFO    ][18297] Returning information for job: 20180131155415541002
2018-01-31 15:54:15,485 [salt.loaded.int.module.cmdmod][INFO    ][17593] Executing command ['rabbitmqctl', 'status'] as user 'root' in directory '/root'
2018-01-31 15:54:20,992 [salt.loaded.int.module.cmdmod][INFO    ][17593] Executing command ['rabbitmqctl', 'list_user_permissions', 'openstack'] as user 'root' in directory '/root'
2018-01-31 15:54:22,904 [salt.state       ][INFO    ][17593] Made the following changes:
'password' changed from 'absent' to 'Set password.'

2018-01-31 15:54:22,904 [salt.state       ][INFO    ][17593] Completed state [openstack] at time 15:54:22.904662 duration_in_ms=9276.69
2018-01-31 15:54:22,907 [salt.state       ][INFO    ][17593] Running state [Ceilometer] at time 15:54:22.907414
2018-01-31 15:54:22,907 [salt.state       ][INFO    ][17593] Executing state rabbitmq_policy.present for Ceilometer
2018-01-31 15:54:22,908 [salt.loaded.int.module.cmdmod][INFO    ][17593] Executing command ['rabbitmqctl', 'list_policies', '-p', '/openstack'] as user 'root' in directory '/root'
2018-01-31 15:54:24,374 [salt.minion      ][INFO    ][2017] User sudo_ubuntu Executing command saltutil.find_job with jid 20180131155425773032
2018-01-31 15:54:24,395 [salt.minion      ][INFO    ][19243] Starting a new job with PID 19243
2018-01-31 15:54:24,414 [salt.minion      ][INFO    ][19243] Returning information for job: 20180131155425773032
2018-01-31 15:54:24,784 [salt.loaded.int.module.cmdmod][INFO    ][17593] 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-01-31 15:54:26,652 [salt.state       ][INFO    ][17593] {'new': ['Definition'], 'old': {'apply_to': 'all', 'priority': '10', 'definition': '{"ha-mode":"all","message-ttl":10800000}', 'pattern': '^metering.sample$'}}
2018-01-31 15:54:26,653 [salt.state       ][INFO    ][17593] Completed state [Ceilometer] at time 15:54:26.653461 duration_in_ms=3746.046
2018-01-31 15:54:26,654 [salt.state       ][INFO    ][17593] Running state [HA] at time 15:54:26.654832
2018-01-31 15:54:26,655 [salt.state       ][INFO    ][17593] Executing state rabbitmq_policy.present for HA
2018-01-31 15:54:26,656 [salt.loaded.int.module.cmdmod][INFO    ][17593] Executing command ['rabbitmqctl', 'list_policies', '-p', '/openstack'] as user 'root' in directory '/root'
2018-01-31 15:54:28,471 [salt.loaded.int.module.cmdmod][INFO    ][17593] Executing command ['rabbitmqctl', 'set_policy', '-p', '/openstack', 'HA', '^(?!amq\\.).*', '{"ha-mode": "all", "message-ttl": 120000}'] as user 'root' in directory '/root'
2018-01-31 15:54:30,316 [salt.state       ][INFO    ][17593] {'new': ['Pattern', 'Definition'], 'old': {'apply_to': 'all', 'priority': '0', 'definition': '{"ha-mode":"all","message-ttl":120000}', 'pattern': '^(?!amq\\\\.).*'}}
2018-01-31 15:54:30,317 [salt.state       ][INFO    ][17593] Completed state [HA] at time 15:54:30.317257 duration_in_ms=3662.432
2018-01-31 15:54:30,318 [salt.state       ][INFO    ][17593] Running state [guest] at time 15:54:30.318958
2018-01-31 15:54:30,319 [salt.state       ][INFO    ][17593] Executing state rabbitmq_user.present for guest
2018-01-31 15:54:30,321 [salt.loaded.int.module.cmdmod][INFO    ][17593] Executing command ['rabbitmqctl', 'list_users'] as user 'root' in directory '/root'
2018-01-31 15:54:32,193 [salt.loaded.int.module.cmdmod][INFO    ][17593] Executing command ['rabbitmqctl', 'status'] as user 'root' in directory '/root'
2018-01-31 15:54:34,394 [salt.minion      ][INFO    ][2017] User sudo_ubuntu Executing command saltutil.find_job with jid 20180131155435793306
2018-01-31 15:54:34,411 [salt.minion      ][INFO    ][20323] Starting a new job with PID 20323
2018-01-31 15:54:34,427 [salt.minion      ][INFO    ][20323] Returning information for job: 20180131155435793306
2018-01-31 15:54:37,743 [salt.loaded.int.module.cmdmod][INFO    ][17593] Executing command ['rabbitmqctl', 'list_user_permissions', 'guest'] as user 'root' in directory '/root'
2018-01-31 15:54:39,660 [salt.state       ][INFO    ][17593] Made the following changes:
'password' changed from 'absent' to 'Set password.'

2018-01-31 15:54:39,661 [salt.state       ][INFO    ][17593] Completed state [guest] at time 15:54:39.661390 duration_in_ms=9342.431
2018-01-31 15:54:39,662 [salt.state       ][INFO    ][17593] Running state [HA] at time 15:54:39.662146
2018-01-31 15:54:39,662 [salt.state       ][INFO    ][17593] Executing state rabbitmq_policy.present for HA
2018-01-31 15:54:39,663 [salt.loaded.int.module.cmdmod][INFO    ][17593] Executing command ['rabbitmqctl', 'list_policies', '-p', '/'] as user 'root' in directory '/root'
2018-01-31 15:54:41,536 [salt.loaded.int.module.cmdmod][INFO    ][17593] Executing command ['rabbitmqctl', 'set_policy', '-p', '/', 'HA', '^(?!amq\\.).*', '{"ha-mode": "all", "message-ttl": 120000}'] as user 'root' in directory '/root'
2018-01-31 15:54:43,417 [salt.state       ][INFO    ][17593] {'new': ['Pattern', 'Definition'], 'old': {'apply_to': 'all', 'priority': '0', 'definition': '{"ha-mode":"all","message-ttl":120000}', 'pattern': '^(?!amq\\\\.).*'}}
2018-01-31 15:54:43,418 [salt.state       ][INFO    ][17593] Completed state [HA] at time 15:54:43.418557 duration_in_ms=3756.41
2018-01-31 15:54:43,419 [salt.state       ][INFO    ][17593] Running state [admin] at time 15:54:43.419284
2018-01-31 15:54:43,419 [salt.state       ][INFO    ][17593] Executing state rabbitmq_user.present for admin
2018-01-31 15:54:43,420 [salt.loaded.int.module.cmdmod][INFO    ][17593] Executing command ['rabbitmqctl', 'list_users'] as user 'root' in directory '/root'
2018-01-31 15:54:44,617 [salt.minion      ][INFO    ][2017] User sudo_ubuntu Executing command saltutil.find_job with jid 20180131155446018297
2018-01-31 15:54:44,640 [salt.minion      ][INFO    ][21267] Starting a new job with PID 21267
2018-01-31 15:54:44,657 [salt.minion      ][INFO    ][21267] Returning information for job: 20180131155446018297
2018-01-31 15:54:45,255 [salt.loaded.int.module.cmdmod][INFO    ][17593] Executing command ['rabbitmqctl', 'status'] as user 'root' in directory '/root'
2018-01-31 15:54:50,908 [salt.loaded.int.module.cmdmod][INFO    ][17593] Executing command ['rabbitmqctl', 'list_users'] as user 'root' in directory '/root'
2018-01-31 15:54:52,766 [salt.loaded.int.module.cmdmod][INFO    ][17593] Executing command ['rabbitmqctl', 'list_user_permissions', 'admin'] as user 'root' in directory '/root'
2018-01-31 15:54:54,585 [salt.state       ][INFO    ][17593] Made the following changes:
'password' changed from 'absent' to 'Set password.'

2018-01-31 15:54:54,587 [salt.state       ][INFO    ][17593] Completed state [admin] at time 15:54:54.585700 duration_in_ms=11166.415
2018-01-31 15:54:54,590 [salt.state       ][INFO    ][17593] Running state [rabbitmqctl set_cluster_name openstack && echo "openstack" > /var/lib/rabbitmq/.cluster_name
] at time 15:54:54.590101
2018-01-31 15:54:54,590 [salt.state       ][INFO    ][17593] Executing state cmd.run for rabbitmqctl set_cluster_name openstack && echo "openstack" > /var/lib/rabbitmq/.cluster_name

2018-01-31 15:54:54,591 [salt.state       ][INFO    ][17593] /var/lib/rabbitmq/.cluster_name exists
2018-01-31 15:54:54,591 [salt.state       ][INFO    ][17593] Completed state [rabbitmqctl set_cluster_name openstack && echo "openstack" > /var/lib/rabbitmq/.cluster_name
] at time 15:54:54.591266 duration_in_ms=1.165
2018-01-31 15:54:54,593 [salt.minion      ][INFO    ][17593] Returning information for job: 20180131155405442391
2018-01-31 15:56:30,080 [salt.minion      ][INFO    ][2017] User sudo_ubuntu Executing command cmd.run with jid 20180131155631482573
2018-01-31 15:56:30,105 [salt.minion      ][INFO    ][22518] Starting a new job with PID 22518
2018-01-31 15:56:30,116 [salt.loader.192.168.11.2.int.module.cmdmod][INFO    ][22518] Executing command 'rabbitmqctl cluster_status' in directory '/root'
2018-01-31 15:56:31,998 [salt.minion      ][INFO    ][22518] Returning information for job: 20180131155631482573
2018-01-31 16:20:40,351 [salt.minion      ][INFO    ][2017] User sudo_ubuntu Executing command state.sls with jid 20180131162041764785
2018-01-31 16:20:40,378 [salt.minion      ][INFO    ][27678] Starting a new job with PID 27678
2018-01-31 16:20:41,751 [salt.state       ][INFO    ][27678] Loading fresh modules for state activity
2018-01-31 16:20:41,806 [salt.fileclient  ][INFO    ][27678] Fetching file from saltenv 'base', ** done ** 'haproxy/init.sls'
2018-01-31 16:20:41,830 [salt.fileclient  ][INFO    ][27678] Fetching file from saltenv 'base', ** done ** 'haproxy/proxy.sls'
2018-01-31 16:20:42,968 [salt.state       ][INFO    ][27678] Running state [haproxy] at time 16:20:42.968741
2018-01-31 16:20:42,969 [salt.state       ][INFO    ][27678] Executing state pkg.installed for haproxy
2018-01-31 16:20:42,969 [salt.loaded.int.module.cmdmod][INFO    ][27678] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2018-01-31 16:20:43,377 [salt.loaded.int.module.cmdmod][INFO    ][27678] Executing command ['apt-cache', '-q', 'policy', 'haproxy'] in directory '/root'
2018-01-31 16:20:43,453 [salt.loaded.int.module.cmdmod][INFO    ][27678] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2018-01-31 16:20:47,690 [salt.loaded.int.module.cmdmod][INFO    ][27678] Executing command ['dpkg', '--get-selections', '*'] in directory '/root'
2018-01-31 16:20:47,729 [salt.loaded.int.module.cmdmod][INFO    ][27678] 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-01-31 16:20:50,477 [salt.minion      ][INFO    ][2017] User sudo_ubuntu Executing command saltutil.find_job with jid 20180131162051881932
2018-01-31 16:20:50,497 [salt.minion      ][INFO    ][28497] Starting a new job with PID 28497
2018-01-31 16:20:50,517 [salt.minion      ][INFO    ][28497] Returning information for job: 20180131162051881932
2018-01-31 16:20:50,835 [salt.loaded.int.module.cmdmod][INFO    ][27678] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2018-01-31 16:20:50,881 [salt.state       ][INFO    ][27678] 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-01-31 16:20:50,903 [salt.state       ][INFO    ][27678] Loading fresh modules for state activity
2018-01-31 16:20:50,940 [salt.state       ][INFO    ][27678] Completed state [haproxy] at time 16:20:50.940360 duration_in_ms=7971.619
2018-01-31 16:20:50,944 [salt.state       ][INFO    ][27678] Running state [/etc/default/haproxy] at time 16:20:50.944312
2018-01-31 16:20:50,944 [salt.state       ][INFO    ][27678] Executing state file.managed for /etc/default/haproxy
2018-01-31 16:20:50,983 [salt.fileclient  ][INFO    ][27678] Fetching file from saltenv 'base', ** done ** 'haproxy/files/haproxy.default'
2018-01-31 16:20:50,987 [salt.state       ][INFO    ][27678] 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-01-31 16:20:50,989 [salt.state       ][INFO    ][27678] Completed state [/etc/default/haproxy] at time 16:20:50.989119 duration_in_ms=44.806
2018-01-31 16:20:50,989 [salt.state       ][INFO    ][27678] Running state [/etc/haproxy/haproxy.cfg] at time 16:20:50.989723
2018-01-31 16:20:50,990 [salt.state       ][INFO    ][27678] Executing state file.managed for /etc/haproxy/haproxy.cfg
2018-01-31 16:20:51,013 [salt.fileclient  ][INFO    ][27678] Fetching file from saltenv 'base', ** done ** 'haproxy/files/haproxy.cfg'
2018-01-31 16:20:51,220 [salt.state       ][INFO    ][27678] 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.40:5672 
+  balance roundrobin
+  mode tcp
+  option tcpka
+  timeout client 300s
+  timeout server 300s
+  server msg01 192.168.10.41:5672 check inter 5000 rise 2 fall 3
+  server msg02 192.168.10.42:5672 backup check inter 5000 rise 2 fall 3
+  server msg03 192.168.10.43:5672 backup check inter 5000 rise 2 fall 3

2018-01-31 16:20:51,220 [salt.state       ][INFO    ][27678] Completed state [/etc/haproxy/haproxy.cfg] at time 16:20:51.220326 duration_in_ms=230.603
2018-01-31 16:20:51,220 [salt.state       ][INFO    ][27678] Running state [/etc/haproxy/ssl] at time 16:20:51.220740
2018-01-31 16:20:51,221 [salt.state       ][INFO    ][27678] Executing state file.directory for /etc/haproxy/ssl
2018-01-31 16:20:51,223 [salt.state       ][INFO    ][27678] {'/etc/haproxy/ssl': 'New Dir'}
2018-01-31 16:20:51,223 [salt.state       ][INFO    ][27678] Completed state [/etc/haproxy/ssl] at time 16:20:51.223672 duration_in_ms=2.932
2018-01-31 16:20:51,224 [salt.state       ][INFO    ][27678] Running state [haproxy_status_packages] at time 16:20:51.224450
2018-01-31 16:20:51,224 [salt.state       ][INFO    ][27678] Executing state pkg.installed for haproxy_status_packages
2018-01-31 16:20:51,634 [salt.loaded.int.module.cmdmod][INFO    ][27678] Executing command ['dpkg', '--get-selections', '*'] in directory '/root'
2018-01-31 16:20:51,667 [salt.loaded.int.module.cmdmod][INFO    ][27678] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'socat'] in directory '/root'
2018-01-31 16:20:53,679 [salt.loaded.int.module.cmdmod][INFO    ][27678] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2018-01-31 16:20:53,726 [salt.state       ][INFO    ][27678] Made the following changes:
'socat' changed from 'absent' to '1.7.3.1-1'

2018-01-31 16:20:53,745 [salt.state       ][INFO    ][27678] Loading fresh modules for state activity
2018-01-31 16:20:53,783 [salt.state       ][INFO    ][27678] Completed state [haproxy_status_packages] at time 16:20:53.783372 duration_in_ms=2558.922
2018-01-31 16:20:53,786 [salt.state       ][INFO    ][27678] Running state [/usr/bin/haproxy-status.sh] at time 16:20:53.786500
2018-01-31 16:20:53,786 [salt.state       ][INFO    ][27678] Executing state file.managed for /usr/bin/haproxy-status.sh
2018-01-31 16:20:53,811 [salt.fileclient  ][INFO    ][27678] Fetching file from saltenv 'base', ** done ** 'haproxy/files/haproxy-status.sh'
2018-01-31 16:20:53,837 [salt.state       ][INFO    ][27678] File changed:
New file
2018-01-31 16:20:53,837 [salt.state       ][INFO    ][27678] Completed state [/usr/bin/haproxy-status.sh] at time 16:20:53.837743 duration_in_ms=51.243
2018-01-31 16:20:53,840 [salt.state       ][INFO    ][27678] Running state [net.ipv4.ip_nonlocal_bind] at time 16:20:53.840810
2018-01-31 16:20:53,841 [salt.state       ][INFO    ][27678] Executing state sysctl.present for net.ipv4.ip_nonlocal_bind
2018-01-31 16:20:53,844 [salt.loaded.int.module.cmdmod][INFO    ][27678] Executing command 'sysctl -a' in directory '/root'
2018-01-31 16:20:53,889 [salt.loaded.int.module.cmdmod][INFO    ][27678] Executing command 'sysctl -w net.ipv4.ip_nonlocal_bind="1"' in directory '/root'
2018-01-31 16:20:53,913 [salt.state       ][INFO    ][27678] {'net.ipv4.ip_nonlocal_bind': 1}
2018-01-31 16:20:53,914 [salt.state       ][INFO    ][27678] Completed state [net.ipv4.ip_nonlocal_bind] at time 16:20:53.914428 duration_in_ms=73.617
2018-01-31 16:20:53,963 [salt.state       ][INFO    ][27678] Running state [haproxy] at time 16:20:53.963643
2018-01-31 16:20:53,964 [salt.state       ][INFO    ][27678] Executing state service.running for haproxy
2018-01-31 16:20:53,965 [salt.loaded.int.module.cmdmod][INFO    ][27678] Executing command ['systemctl', 'status', 'haproxy.service', '-n', '0'] in directory '/root'
2018-01-31 16:20:53,990 [salt.loaded.int.module.cmdmod][INFO    ][27678] Executing command ['systemctl', 'is-active', 'haproxy.service'] in directory '/root'
2018-01-31 16:20:54,015 [salt.loaded.int.module.cmdmod][INFO    ][27678] Executing command ['systemctl', 'is-enabled', 'haproxy.service'] in directory '/root'
2018-01-31 16:20:54,036 [salt.state       ][INFO    ][27678] The service haproxy is already running
2018-01-31 16:20:54,037 [salt.state       ][INFO    ][27678] Completed state [haproxy] at time 16:20:54.036909 duration_in_ms=73.266
2018-01-31 16:20:54,037 [salt.state       ][INFO    ][27678] Running state [haproxy] at time 16:20:54.037284
2018-01-31 16:20:54,037 [salt.state       ][INFO    ][27678] Executing state service.mod_watch for haproxy
2018-01-31 16:20:54,038 [salt.loaded.int.module.cmdmod][INFO    ][27678] Executing command ['systemctl', 'is-active', 'haproxy.service'] in directory '/root'
2018-01-31 16:20:54,057 [salt.loaded.int.module.cmdmod][INFO    ][27678] Executing command ['systemctl', 'is-enabled', 'haproxy.service'] in directory '/root'
2018-01-31 16:20:54,077 [salt.loaded.int.module.cmdmod][INFO    ][27678] Executing command ['systemd-run', '--scope', 'systemctl', 'restart', 'haproxy.service'] in directory '/root'
2018-01-31 16:20:54,129 [salt.state       ][INFO    ][27678] {'haproxy': True}
2018-01-31 16:20:54,130 [salt.state       ][INFO    ][27678] Completed state [haproxy] at time 16:20:54.130801 duration_in_ms=93.516
2018-01-31 16:20:54,132 [salt.minion      ][INFO    ][27678] Returning information for job: 20180131162041764785
2018-01-31 16:20:54,858 [salt.minion      ][INFO    ][2017] User sudo_ubuntu Executing command service.status with jid 20180131162056270500
2018-01-31 16:20:54,880 [salt.minion      ][INFO    ][28841] Starting a new job with PID 28841
2018-01-31 16:20:54,934 [salt.loader.192.168.11.2.int.module.cmdmod][INFO    ][28841] Executing command ['systemctl', 'status', 'haproxy.service', '-n', '0'] in directory '/root'
2018-01-31 16:20:54,955 [salt.loader.192.168.11.2.int.module.cmdmod][INFO    ][28841] Executing command ['systemctl', 'is-active', 'haproxy.service'] in directory '/root'
2018-01-31 16:20:54,975 [salt.minion      ][INFO    ][28841] Returning information for job: 20180131162056270500
2018-01-31 16:20:56,410 [salt.minion      ][INFO    ][2017] User sudo_ubuntu Executing command service.restart with jid 20180131162057821891
2018-01-31 16:20:56,431 [salt.minion      ][INFO    ][28856] Starting a new job with PID 28856
2018-01-31 16:20:56,481 [salt.loader.192.168.11.2.int.module.cmdmod][INFO    ][28856] Executing command ['systemctl', 'status', 'rsyslog.service', '-n', '0'] in directory '/root'
2018-01-31 16:20:56,500 [salt.loader.192.168.11.2.int.module.cmdmod][INFO    ][28856] Executing command ['systemctl', 'is-enabled', 'rsyslog.service'] in directory '/root'
2018-01-31 16:20:56,531 [salt.loader.192.168.11.2.int.module.cmdmod][INFO    ][28856] Executing command ['systemd-run', '--scope', 'systemctl', 'restart', 'rsyslog.service'] in directory '/root'
2018-01-31 16:20:56,575 [salt.minion      ][INFO    ][28856] Returning information for job: 20180131162057821891
2018-01-31 16:39:44,302 [salt.utils.schedule][INFO    ][2017] Running scheduled job: __mine_interval
2018-01-31 16:50:21,712 [salt.minion      ][INFO    ][2017] User sudo_ubuntu Executing command cp.push_dir with jid 20180131165023132088
2018-01-31 16:50:21,746 [salt.minion      ][INFO    ][2524] Starting a new job with PID 2524
