2017-09-14 21:04:40,449 [salt.cli.daemons ][WARNING ][867] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-09-14 21:16:29,512 [salt.state       ][ERROR   ][1233] No contents found in top file
2017-09-14 21:16:39,585 [py.warnings      ][WARNING ][1330] /usr/lib/python2.7/dist-packages/salt/utils/templates.py:73: DeprecationWarning: Starting in 2015.5, cmd.run uses python_shell=False by default, which doesn't support shellisms (pipes, env variables, etc). cmd.run is currently aliased to cmd.shell to prevent breakage. Please switch to cmd.shell or set python_shell=True to avoid breakage in the future, when this aliasing is removed.

2017-09-14 21:16:47,796 [salt.loaded.int.module.cmdmod][ERROR   ][1330] 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
2017-09-14 21:16:49,532 [salt.loaded.int.module.cmdmod][INFO    ][1447] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2017-09-14 21:16:49,541 [salt.loaded.int.module.cmdmod][INFO    ][1447] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2017-09-14 21:16:49,553 [salt.loaded.int.module.cmdmod][INFO    ][1447] Executing command ['systemd-run', '--scope', 'systemctl', 'restart', 'salt-minion.service'] in directory '/root'
2017-09-14 21:16:49,614 [salt.utils.parsers][WARNING ][867] Minion received a SIGTERM. Exiting.
2017-09-14 21:16:49,876 [salt.cli.daemons ][INFO    ][1503] Setting up the Salt Minion "odl01.baremetal-mcp-ocata-odl-ha.local"
2017-09-14 21:16:50,165 [salt.minion      ][INFO    ][1503] Creating minion process manager
2017-09-14 21:16:50,165 [salt.cli.daemons ][WARNING ][1503] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-09-14 21:16:50,166 [salt.cli.daemons ][INFO    ][1503] The Salt Minion is starting up
2017-09-14 21:16:50,166 [salt.minion      ][INFO    ][1503] Minion is starting as user 'root'
2017-09-14 21:16:50,166 [salt.utils.event ][INFO    ][1503] Starting pull socket on /var/run/salt/minion/minion_event_c4ab45d64e_pull.ipc
2017-09-14 21:16:50,660 [salt.loaded.int.module.cmdmod][INFO    ][1503] Executing command ['date', '+%z'] in directory '/root'
2017-09-14 21:16:50,671 [salt.utils.schedule][INFO    ][1503] Updating job settings for scheduled job: __mine_interval
2017-09-14 21:16:50,673 [salt.minion      ][INFO    ][1503] Added mine.update to scheduler
2017-09-14 21:16:50,703 [salt.minion      ][INFO    ][1503] Minion is ready to receive requests!
2017-09-14 21:16:51,704 [salt.utils.schedule][INFO    ][1503] Running scheduled job: __mine_interval
2017-09-14 21:16:53,571 [salt.minion      ][INFO    ][1503] User sudo_ubuntu Executing command state.apply with jid 20170914211653558483
2017-09-14 21:16:53,600 [salt.minion      ][INFO    ][1594] Starting a new job with PID 1594
2017-09-14 21:16:56,688 [salt.state       ][INFO    ][1594] Loading fresh modules for state activity
2017-09-14 21:16:57,107 [salt.fileclient  ][INFO    ][1594] Fetching file from saltenv 'base', ** done ** 'linux/init.sls'
2017-09-14 21:16:57,130 [salt.fileclient  ][INFO    ][1594] Fetching file from saltenv 'base', ** done ** 'linux/system/init.sls'
2017-09-14 21:16:57,156 [salt.fileclient  ][INFO    ][1594] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-09-14 21:16:57,352 [salt.fileclient  ][INFO    ][1594] Fetching file from saltenv 'base', ** done ** 'linux/system/env.sls'
2017-09-14 21:16:57,372 [salt.fileclient  ][INFO    ][1594] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-09-14 21:16:57,432 [salt.fileclient  ][INFO    ][1594] Fetching file from saltenv 'base', ** done ** 'linux/system/profile.sls'
2017-09-14 21:16:57,458 [salt.fileclient  ][INFO    ][1594] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-09-14 21:16:57,500 [salt.fileclient  ][INFO    ][1594] Fetching file from saltenv 'base', ** done ** 'linux/system/repo.sls'
2017-09-14 21:16:57,553 [salt.fileclient  ][INFO    ][1594] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-09-14 21:16:57,659 [salt.fileclient  ][INFO    ][1594] Fetching file from saltenv 'base', ** done ** 'linux/system/package.sls'
2017-09-14 21:16:57,686 [salt.fileclient  ][INFO    ][1594] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-09-14 21:16:57,727 [salt.fileclient  ][INFO    ][1594] Fetching file from saltenv 'base', ** done ** 'linux/system/timezone.sls'
2017-09-14 21:16:57,753 [salt.fileclient  ][INFO    ][1594] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-09-14 21:16:57,801 [salt.fileclient  ][INFO    ][1594] Fetching file from saltenv 'base', ** done ** 'linux/system/kernel.sls'
2017-09-14 21:16:57,852 [salt.fileclient  ][INFO    ][1594] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-09-14 21:16:57,909 [salt.fileclient  ][INFO    ][1594] Fetching file from saltenv 'base', ** done ** 'linux/system/cpu.sls'
2017-09-14 21:16:57,946 [salt.fileclient  ][INFO    ][1594] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-09-14 21:16:58,007 [salt.fileclient  ][INFO    ][1594] Fetching file from saltenv 'base', ** done ** 'linux/system/sysfs.sls'
2017-09-14 21:16:58,043 [salt.fileclient  ][INFO    ][1594] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-09-14 21:16:58,086 [salt.fileclient  ][INFO    ][1594] Fetching file from saltenv 'base', ** done ** 'linux/system/locale.sls'
2017-09-14 21:16:58,122 [salt.fileclient  ][INFO    ][1594] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-09-14 21:16:58,169 [salt.fileclient  ][INFO    ][1594] Fetching file from saltenv 'base', ** done ** 'linux/system/user.sls'
2017-09-14 21:16:58,210 [salt.fileclient  ][INFO    ][1594] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-09-14 21:16:58,257 [salt.fileclient  ][INFO    ][1594] Fetching file from saltenv 'base', ** done ** 'linux/system/group.sls'
2017-09-14 21:16:58,289 [salt.fileclient  ][INFO    ][1594] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-09-14 21:16:58,546 [salt.fileclient  ][INFO    ][1594] Fetching file from saltenv 'base', ** done ** 'linux/system/limit.sls'
2017-09-14 21:16:58,566 [salt.fileclient  ][INFO    ][1594] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-09-14 21:16:58,606 [salt.fileclient  ][INFO    ][1594] Fetching file from saltenv 'base', ** done ** 'linux/system/systemd.sls'
2017-09-14 21:16:58,629 [salt.fileclient  ][INFO    ][1594] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-09-14 21:16:58,685 [salt.fileclient  ][INFO    ][1594] Fetching file from saltenv 'base', ** done ** 'linux/network/init.sls'
2017-09-14 21:16:58,711 [salt.fileclient  ][INFO    ][1594] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-09-14 21:16:58,750 [salt.fileclient  ][INFO    ][1594] Fetching file from saltenv 'base', ** done ** 'linux/network/hostname.sls'
2017-09-14 21:16:58,771 [salt.fileclient  ][INFO    ][1594] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-09-14 21:16:58,812 [salt.fileclient  ][INFO    ][1594] Fetching file from saltenv 'base', ** done ** 'linux/network/host.sls'
2017-09-14 21:16:58,843 [salt.fileclient  ][INFO    ][1594] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-09-14 21:16:58,911 [salt.fileclient  ][INFO    ][1594] Fetching file from saltenv 'base', ** done ** 'linux/network/interface.sls'
2017-09-14 21:16:58,968 [salt.fileclient  ][INFO    ][1594] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-09-14 21:16:59,015 [salt.fileclient  ][INFO    ][1594] Fetching file from saltenv 'base', ** done ** 'linux/network/proxy.sls'
2017-09-14 21:16:59,040 [salt.fileclient  ][INFO    ][1594] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-09-14 21:16:59,087 [salt.fileclient  ][INFO    ][1594] Fetching file from saltenv 'base', ** done ** 'linux/storage/init.sls'
2017-09-14 21:16:59,116 [salt.fileclient  ][INFO    ][1594] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-09-14 21:16:59,171 [salt.fileclient  ][INFO    ][1594] Fetching file from saltenv 'base', ** done ** 'ntp/init.sls'
2017-09-14 21:16:59,184 [salt.fileclient  ][INFO    ][1594] Fetching file from saltenv 'base', ** done ** 'ntp/client.sls'
2017-09-14 21:16:59,200 [salt.fileclient  ][INFO    ][1594] Fetching file from saltenv 'base', ** done ** 'ntp/map.jinja'
2017-09-14 21:16:59,220 [salt.fileclient  ][INFO    ][1594] Fetching file from saltenv 'base', ** done ** 'ntp/server.sls'
2017-09-14 21:16:59,241 [salt.fileclient  ][INFO    ][1594] Fetching file from saltenv 'base', ** done ** 'ntp/map.jinja'
2017-09-14 21:16:59,253 [salt.state       ][INFO    ][1594] Running state [/etc/environment] at time 21:16:59.253336
2017-09-14 21:16:59,254 [salt.state       ][INFO    ][1594] Executing state file.blockreplace for /etc/environment
2017-09-14 21:16:59,258 [salt.state       ][INFO    ][1594] 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

2017-09-14 21:16:59,259 [salt.state       ][INFO    ][1594] Completed state [/etc/environment] at time 21:16:59.259012 duration_in_ms=5.676
2017-09-14 21:16:59,259 [salt.state       ][INFO    ][1594] Running state [/etc/profile.d] at time 21:16:59.259277
2017-09-14 21:16:59,260 [salt.state       ][INFO    ][1594] Executing state file.directory for /etc/profile.d
2017-09-14 21:16:59,260 [salt.state       ][INFO    ][1594] Directory /etc/profile.d is in the correct state
2017-09-14 21:16:59,261 [salt.state       ][INFO    ][1594] Completed state [/etc/profile.d] at time 21:16:59.260566 duration_in_ms=1.289
2017-09-14 21:16:59,484 [salt.state       ][INFO    ][1594] Running state [linux_repo_prereq_pkgs] at time 21:16:59.484284
2017-09-14 21:16:59,485 [salt.state       ][INFO    ][1594] Executing state pkg.installed for linux_repo_prereq_pkgs
2017-09-14 21:16:59,485 [salt.loaded.int.module.cmdmod][INFO    ][1594] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-14 21:16:59,566 [salt.state       ][INFO    ][1594] All specified packages are already installed
2017-09-14 21:16:59,566 [salt.state       ][INFO    ][1594] Completed state [linux_repo_prereq_pkgs] at time 21:16:59.566314 duration_in_ms=82.029
2017-09-14 21:16:59,567 [salt.state       ][INFO    ][1594] Running state [/etc/apt/apt.conf.d/99proxies-salt-mirantis_openstack_holdback] at time 21:16:59.566779
2017-09-14 21:16:59,567 [salt.state       ][INFO    ][1594] Executing state file.absent for /etc/apt/apt.conf.d/99proxies-salt-mirantis_openstack_holdback
2017-09-14 21:16:59,568 [salt.state       ][INFO    ][1594] File /etc/apt/apt.conf.d/99proxies-salt-mirantis_openstack_holdback is not present
2017-09-14 21:16:59,568 [salt.state       ][INFO    ][1594] Completed state [/etc/apt/apt.conf.d/99proxies-salt-mirantis_openstack_holdback] at time 21:16:59.568098 duration_in_ms=1.319
2017-09-14 21:16:59,569 [salt.state       ][INFO    ][1594] Running state [/etc/apt/preferences.d/mirantis_openstack_holdback] at time 21:16:59.568479
2017-09-14 21:16:59,569 [salt.state       ][INFO    ][1594] Executing state file.managed for /etc/apt/preferences.d/mirantis_openstack_holdback
2017-09-14 21:16:59,763 [salt.fileclient  ][INFO    ][1594] Fetching file from saltenv 'base', ** done ** 'linux/files/preferences_repo'
2017-09-14 21:16:59,783 [salt.fileclient  ][INFO    ][1594] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-09-14 21:16:59,848 [salt.state       ][INFO    ][1594] File changed:
New file
2017-09-14 21:16:59,849 [salt.state       ][INFO    ][1594] Completed state [/etc/apt/preferences.d/mirantis_openstack_holdback] at time 21:16:59.848597 duration_in_ms=280.119
2017-09-14 21:16:59,900 [salt.state       ][INFO    ][1594] Running state [deb http://mirror.fuel-infra.org/mcp-repos/ocata/xenial ocata-holdback main] at time 21:16:59.900256
2017-09-14 21:16:59,901 [salt.state       ][INFO    ][1594] Executing state pkgrepo.managed for deb http://mirror.fuel-infra.org/mcp-repos/ocata/xenial ocata-holdback main
2017-09-14 21:17:00,183 [salt.loaded.int.module.cmdmod][INFO    ][1594] Executing command ['apt-key', 'add', '/var/cache/salt/minion/extrn_files/base/mirror.fuel-infra.org/mcp-repos/ocata/xenial/archive-mcpocata.key'] in directory '/root'
2017-09-14 21:17:00,643 [salt.loaded.int.module.cmdmod][INFO    ][1594] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-09-14 21:17:03,598 [salt.minion      ][INFO    ][1503] User sudo_ubuntu Executing command saltutil.find_job with jid 20170914211703584348
2017-09-14 21:17:03,609 [salt.minion      ][INFO    ][2110] Starting a new job with PID 2110
2017-09-14 21:17:03,622 [salt.minion      ][INFO    ][2110] Returning information for job: 20170914211703584348
2017-09-14 21:17:13,740 [salt.minion      ][INFO    ][1503] User sudo_ubuntu Executing command saltutil.find_job with jid 20170914211713727729
2017-09-14 21:17:13,754 [salt.minion      ][INFO    ][2115] Starting a new job with PID 2115
2017-09-14 21:17:13,777 [salt.minion      ][INFO    ][2115] Returning information for job: 20170914211713727729
2017-09-14 21:17:23,843 [salt.minion      ][INFO    ][1503] User sudo_ubuntu Executing command saltutil.find_job with jid 20170914211723833553
2017-09-14 21:17:23,862 [salt.minion      ][INFO    ][2120] Starting a new job with PID 2120
2017-09-14 21:17:23,873 [salt.minion      ][INFO    ][2120] Returning information for job: 20170914211723833553
2017-09-14 21:17:33,341 [salt.state       ][INFO    ][1594] {'repo': 'deb http://mirror.fuel-infra.org/mcp-repos/ocata/xenial ocata-holdback main'}
2017-09-14 21:17:33,341 [salt.state       ][INFO    ][1594] Completed state [deb http://mirror.fuel-infra.org/mcp-repos/ocata/xenial ocata-holdback main] at time 21:17:33.341413 duration_in_ms=33441.156
2017-09-14 21:17:33,342 [salt.state       ][INFO    ][1594] Running state [/etc/apt/apt.conf.d/99proxies-salt-uca] at time 21:17:33.341740
2017-09-14 21:17:33,342 [salt.state       ][INFO    ][1594] Executing state file.absent for /etc/apt/apt.conf.d/99proxies-salt-uca
2017-09-14 21:17:33,342 [salt.state       ][INFO    ][1594] File /etc/apt/apt.conf.d/99proxies-salt-uca is not present
2017-09-14 21:17:33,343 [salt.state       ][INFO    ][1594] Completed state [/etc/apt/apt.conf.d/99proxies-salt-uca] at time 21:17:33.342717 duration_in_ms=0.976
2017-09-14 21:17:33,343 [salt.state       ][INFO    ][1594] Running state [/etc/apt/preferences.d/uca] at time 21:17:33.342995
2017-09-14 21:17:33,343 [salt.state       ][INFO    ][1594] Executing state file.absent for /etc/apt/preferences.d/uca
2017-09-14 21:17:33,344 [salt.state       ][INFO    ][1594] File /etc/apt/preferences.d/uca is not present
2017-09-14 21:17:33,344 [salt.state       ][INFO    ][1594] Completed state [/etc/apt/preferences.d/uca] at time 21:17:33.343790 duration_in_ms=0.796
2017-09-14 21:17:33,345 [salt.state       ][INFO    ][1594] Running state [deb http://ubuntu-cloud.archive.canonical.com/ubuntu xenial-updates/ocata main] at time 21:17:33.344565
2017-09-14 21:17:33,345 [salt.state       ][INFO    ][1594] Executing state pkgrepo.managed for deb http://ubuntu-cloud.archive.canonical.com/ubuntu xenial-updates/ocata main
2017-09-14 21:17:33,388 [salt.loaded.int.module.cmdmod][INFO    ][1594] Executing command ['apt-key', 'export', 'EC4926EA'] in directory '/root'
2017-09-14 21:17:33,428 [salt.loaded.int.module.cmdmod][INFO    ][1594] Executing command ['apt-key', 'adv', '--keyserver', 'keyserver.ubuntu.com', '--logger-fd', '1', '--recv-keys', 'EC4926EA'] in directory '/root'
2017-09-14 21:17:34,059 [salt.minion      ][INFO    ][1503] User sudo_ubuntu Executing command saltutil.find_job with jid 20170914211734045156
2017-09-14 21:17:34,077 [salt.minion      ][INFO    ][2231] Starting a new job with PID 2231
2017-09-14 21:17:34,094 [salt.minion      ][INFO    ][2231] Returning information for job: 20170914211734045156
2017-09-14 21:17:34,390 [salt.loaded.int.module.cmdmod][INFO    ][1594] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-09-14 21:17:37,764 [salt.state       ][INFO    ][1594] {'repo': 'deb http://ubuntu-cloud.archive.canonical.com/ubuntu xenial-updates/ocata main'}
2017-09-14 21:17:37,765 [salt.state       ][INFO    ][1594] Completed state [deb http://ubuntu-cloud.archive.canonical.com/ubuntu xenial-updates/ocata main] at time 21:17:37.764508 duration_in_ms=4419.942
2017-09-14 21:17:37,765 [salt.state       ][INFO    ][1594] Running state [/etc/apt/apt.conf.d/99proxies-salt-mirantis_openstack_updates] at time 21:17:37.764847
2017-09-14 21:17:37,765 [salt.state       ][INFO    ][1594] Executing state file.absent for /etc/apt/apt.conf.d/99proxies-salt-mirantis_openstack_updates
2017-09-14 21:17:37,766 [salt.state       ][INFO    ][1594] File /etc/apt/apt.conf.d/99proxies-salt-mirantis_openstack_updates is not present
2017-09-14 21:17:37,766 [salt.state       ][INFO    ][1594] Completed state [/etc/apt/apt.conf.d/99proxies-salt-mirantis_openstack_updates] at time 21:17:37.765901 duration_in_ms=1.054
2017-09-14 21:17:37,766 [salt.state       ][INFO    ][1594] Running state [/etc/apt/preferences.d/mirantis_openstack_updates] at time 21:17:37.766212
2017-09-14 21:17:37,767 [salt.state       ][INFO    ][1594] Executing state file.managed for /etc/apt/preferences.d/mirantis_openstack_updates
2017-09-14 21:17:37,779 [salt.fileclient  ][INFO    ][1594] Fetching file from saltenv 'base', ** done ** 'linux/files/preferences_repo'
2017-09-14 21:17:37,791 [salt.fileclient  ][INFO    ][1594] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-09-14 21:17:37,821 [salt.state       ][INFO    ][1594] File changed:
New file
2017-09-14 21:17:37,821 [salt.state       ][INFO    ][1594] Completed state [/etc/apt/preferences.d/mirantis_openstack_updates] at time 21:17:37.821038 duration_in_ms=54.826
2017-09-14 21:17:37,822 [salt.state       ][INFO    ][1594] Running state [deb http://mirror.fuel-infra.org/mcp-repos/ocata/xenial ocata-updates main] at time 21:17:37.821851
2017-09-14 21:17:37,822 [salt.state       ][INFO    ][1594] Executing state pkgrepo.managed for deb http://mirror.fuel-infra.org/mcp-repos/ocata/xenial ocata-updates main
2017-09-14 21:17:37,869 [salt.loaded.int.module.cmdmod][INFO    ][1594] Executing command ['apt-key', 'add', '/var/cache/salt/minion/extrn_files/base/mirror.fuel-infra.org/mcp-repos/ocata/xenial/archive-mcpocata.key'] in directory '/root'
2017-09-14 21:17:37,946 [salt.loaded.int.module.cmdmod][INFO    ][1594] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-09-14 21:17:39,744 [salt.state       ][INFO    ][1594] {'repo': 'deb http://mirror.fuel-infra.org/mcp-repos/ocata/xenial ocata-updates main'}
2017-09-14 21:17:39,744 [salt.state       ][INFO    ][1594] Completed state [deb http://mirror.fuel-infra.org/mcp-repos/ocata/xenial ocata-updates main] at time 21:17:39.744426 duration_in_ms=1922.575
2017-09-14 21:17:39,745 [salt.state       ][INFO    ][1594] Running state [/etc/apt/apt.conf.d/99proxies-salt-mirantis_openstack_security] at time 21:17:39.744754
2017-09-14 21:17:39,745 [salt.state       ][INFO    ][1594] Executing state file.absent for /etc/apt/apt.conf.d/99proxies-salt-mirantis_openstack_security
2017-09-14 21:17:39,746 [salt.state       ][INFO    ][1594] File /etc/apt/apt.conf.d/99proxies-salt-mirantis_openstack_security is not present
2017-09-14 21:17:39,746 [salt.state       ][INFO    ][1594] Completed state [/etc/apt/apt.conf.d/99proxies-salt-mirantis_openstack_security] at time 21:17:39.745765 duration_in_ms=1.01
2017-09-14 21:17:39,746 [salt.state       ][INFO    ][1594] Running state [/etc/apt/preferences.d/mirantis_openstack_security] at time 21:17:39.746030
2017-09-14 21:17:39,746 [salt.state       ][INFO    ][1594] Executing state file.managed for /etc/apt/preferences.d/mirantis_openstack_security
2017-09-14 21:17:39,762 [salt.fileclient  ][INFO    ][1594] Fetching file from saltenv 'base', ** done ** 'linux/files/preferences_repo'
2017-09-14 21:17:39,779 [salt.fileclient  ][INFO    ][1594] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-09-14 21:17:39,808 [salt.state       ][INFO    ][1594] File changed:
New file
2017-09-14 21:17:39,808 [salt.state       ][INFO    ][1594] Completed state [/etc/apt/preferences.d/mirantis_openstack_security] at time 21:17:39.807906 duration_in_ms=61.876
2017-09-14 21:17:39,809 [salt.state       ][INFO    ][1594] Running state [deb http://mirror.fuel-infra.org/mcp-repos/ocata/xenial ocata-security main] at time 21:17:39.808651
2017-09-14 21:17:39,809 [salt.state       ][INFO    ][1594] Executing state pkgrepo.managed for deb http://mirror.fuel-infra.org/mcp-repos/ocata/xenial ocata-security main
2017-09-14 21:17:39,904 [salt.loaded.int.module.cmdmod][INFO    ][1594] Executing command ['apt-key', 'add', '/var/cache/salt/minion/extrn_files/base/mirror.fuel-infra.org/mcp-repos/ocata/xenial/archive-mcpocata.key'] in directory '/root'
2017-09-14 21:17:39,975 [salt.loaded.int.module.cmdmod][INFO    ][1594] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-09-14 21:17:42,990 [salt.state       ][INFO    ][1594] {'repo': 'deb http://mirror.fuel-infra.org/mcp-repos/ocata/xenial ocata-security main'}
2017-09-14 21:17:42,991 [salt.state       ][INFO    ][1594] Completed state [deb http://mirror.fuel-infra.org/mcp-repos/ocata/xenial ocata-security main] at time 21:17:42.990959 duration_in_ms=3182.307
2017-09-14 21:17:42,991 [salt.state       ][INFO    ][1594] Running state [/etc/apt/apt.conf.d/99proxies-salt-mk_openstack] at time 21:17:42.991392
2017-09-14 21:17:42,992 [salt.state       ][INFO    ][1594] Executing state file.absent for /etc/apt/apt.conf.d/99proxies-salt-mk_openstack
2017-09-14 21:17:42,992 [salt.state       ][INFO    ][1594] File /etc/apt/apt.conf.d/99proxies-salt-mk_openstack is not present
2017-09-14 21:17:42,993 [salt.state       ][INFO    ][1594] Completed state [/etc/apt/apt.conf.d/99proxies-salt-mk_openstack] at time 21:17:42.992828 duration_in_ms=1.436
2017-09-14 21:17:42,993 [salt.state       ][INFO    ][1594] Running state [/etc/apt/preferences.d/mk_openstack] at time 21:17:42.993214
2017-09-14 21:17:42,994 [salt.state       ][INFO    ][1594] Executing state file.managed for /etc/apt/preferences.d/mk_openstack
2017-09-14 21:17:43,010 [salt.fileclient  ][INFO    ][1594] Fetching file from saltenv 'base', ** done ** 'linux/files/preferences_repo'
2017-09-14 21:17:43,032 [salt.fileclient  ][INFO    ][1594] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-09-14 21:17:43,080 [salt.state       ][INFO    ][1594] File changed:
New file
2017-09-14 21:17:43,080 [salt.state       ][INFO    ][1594] Completed state [/etc/apt/preferences.d/mk_openstack] at time 21:17:43.080029 duration_in_ms=86.814
2017-09-14 21:17:43,081 [salt.state       ][INFO    ][1594] Running state [deb [arch=amd64] http://apt-mk.mirantis.com/xenial/ nightly ocata] at time 21:17:43.080794
2017-09-14 21:17:43,081 [salt.state       ][INFO    ][1594] Executing state pkgrepo.managed for deb [arch=amd64] http://apt-mk.mirantis.com/xenial/ nightly ocata
2017-09-14 21:17:43,496 [salt.loaded.int.module.cmdmod][INFO    ][1594] Executing command ['apt-key', 'add', '/var/cache/salt/minion/extrn_files/base/apt-mk.mirantis.com/public.gpg'] in directory '/root'
2017-09-14 21:17:43,580 [salt.loaded.int.module.cmdmod][INFO    ][1594] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-09-14 21:17:44,135 [salt.minion      ][INFO    ][1503] User sudo_ubuntu Executing command saltutil.find_job with jid 20170914211744121728
2017-09-14 21:17:44,152 [salt.minion      ][INFO    ][4258] Starting a new job with PID 4258
2017-09-14 21:17:44,168 [salt.minion      ][INFO    ][4258] Returning information for job: 20170914211744121728
2017-09-14 21:17:45,743 [salt.state       ][INFO    ][1594] {'repo': 'deb [arch=amd64] http://apt-mk.mirantis.com/xenial nightly ocata'}
2017-09-14 21:17:45,743 [salt.state       ][INFO    ][1594] Completed state [deb [arch=amd64] http://apt-mk.mirantis.com/xenial/ nightly ocata] at time 21:17:45.743038 duration_in_ms=2662.244
2017-09-14 21:17:45,743 [salt.state       ][INFO    ][1594] Running state [/etc/apt/apt.conf.d/99proxies-salt-mcp_extra] at time 21:17:45.743345
2017-09-14 21:17:45,744 [salt.state       ][INFO    ][1594] Executing state file.absent for /etc/apt/apt.conf.d/99proxies-salt-mcp_extra
2017-09-14 21:17:45,744 [salt.state       ][INFO    ][1594] File /etc/apt/apt.conf.d/99proxies-salt-mcp_extra is not present
2017-09-14 21:17:45,744 [salt.state       ][INFO    ][1594] Completed state [/etc/apt/apt.conf.d/99proxies-salt-mcp_extra] at time 21:17:45.744252 duration_in_ms=0.907
2017-09-14 21:17:45,745 [salt.state       ][INFO    ][1594] Running state [/etc/apt/preferences.d/mcp_extra] at time 21:17:45.744529
2017-09-14 21:17:45,745 [salt.state       ][INFO    ][1594] Executing state file.managed for /etc/apt/preferences.d/mcp_extra
2017-09-14 21:17:45,771 [salt.fileclient  ][INFO    ][1594] Fetching file from saltenv 'base', ** done ** 'linux/files/preferences_repo'
2017-09-14 21:17:45,790 [salt.fileclient  ][INFO    ][1594] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-09-14 21:17:45,822 [salt.state       ][INFO    ][1594] File changed:
New file
2017-09-14 21:17:45,822 [salt.state       ][INFO    ][1594] Completed state [/etc/apt/preferences.d/mcp_extra] at time 21:17:45.822362 duration_in_ms=77.832
2017-09-14 21:17:45,823 [salt.state       ][INFO    ][1594] Running state [deb [arch=amd64] http://apt-mk.mirantis.com/xenial/ nightly extra] at time 21:17:45.823245
2017-09-14 21:17:45,824 [salt.state       ][INFO    ][1594] Executing state pkgrepo.managed for deb [arch=amd64] http://apt-mk.mirantis.com/xenial/ nightly extra
2017-09-14 21:17:45,875 [salt.loaded.int.module.cmdmod][INFO    ][1594] Executing command ['apt-key', 'add', '/var/cache/salt/minion/extrn_files/base/apt-mk.mirantis.com/public.gpg'] in directory '/root'
2017-09-14 21:17:45,952 [salt.loaded.int.module.cmdmod][INFO    ][1594] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-09-14 21:17:48,369 [salt.state       ][INFO    ][1594] Configured package repo 'deb [arch=amd64] http://apt-mk.mirantis.com/xenial/ nightly extra'
2017-09-14 21:17:48,370 [salt.state       ][INFO    ][1594] Completed state [deb [arch=amd64] http://apt-mk.mirantis.com/xenial/ nightly extra] at time 21:17:48.369846 duration_in_ms=2546.6
2017-09-14 21:17:48,370 [salt.state       ][INFO    ][1594] Running state [/etc/apt/apt.conf.d/99proxies-salt-mirantis_openstack] at time 21:17:48.370191
2017-09-14 21:17:48,371 [salt.state       ][INFO    ][1594] Executing state file.absent for /etc/apt/apt.conf.d/99proxies-salt-mirantis_openstack
2017-09-14 21:17:48,371 [salt.state       ][INFO    ][1594] File /etc/apt/apt.conf.d/99proxies-salt-mirantis_openstack is not present
2017-09-14 21:17:48,371 [salt.state       ][INFO    ][1594] Completed state [/etc/apt/apt.conf.d/99proxies-salt-mirantis_openstack] at time 21:17:48.371202 duration_in_ms=1.012
2017-09-14 21:17:48,371 [salt.state       ][INFO    ][1594] Running state [/etc/apt/preferences.d/mirantis_openstack] at time 21:17:48.371473
2017-09-14 21:17:48,372 [salt.state       ][INFO    ][1594] Executing state file.managed for /etc/apt/preferences.d/mirantis_openstack
2017-09-14 21:17:48,385 [salt.fileclient  ][INFO    ][1594] Fetching file from saltenv 'base', ** done ** 'linux/files/preferences_repo'
2017-09-14 21:17:48,398 [salt.fileclient  ][INFO    ][1594] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-09-14 21:17:48,430 [salt.state       ][INFO    ][1594] File changed:
New file
2017-09-14 21:17:48,431 [salt.state       ][INFO    ][1594] Completed state [/etc/apt/preferences.d/mirantis_openstack] at time 21:17:48.430611 duration_in_ms=59.137
2017-09-14 21:17:48,431 [salt.state       ][INFO    ][1594] Running state [deb http://mirror.fuel-infra.org/mcp-repos/ocata/xenial ocata main] at time 21:17:48.431458
2017-09-14 21:17:48,432 [salt.state       ][INFO    ][1594] Executing state pkgrepo.managed for deb http://mirror.fuel-infra.org/mcp-repos/ocata/xenial ocata main
2017-09-14 21:17:48,482 [salt.loaded.int.module.cmdmod][INFO    ][1594] Executing command ['apt-key', 'add', '/var/cache/salt/minion/extrn_files/base/mirror.fuel-infra.org/mcp-repos/ocata/xenial/archive-mcpocata.key'] in directory '/root'
2017-09-14 21:17:48,564 [salt.loaded.int.module.cmdmod][INFO    ][1594] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-09-14 21:17:51,522 [salt.state       ][INFO    ][1594] {'repo': 'deb http://mirror.fuel-infra.org/mcp-repos/ocata/xenial ocata main'}
2017-09-14 21:17:51,522 [salt.state       ][INFO    ][1594] Completed state [deb http://mirror.fuel-infra.org/mcp-repos/ocata/xenial ocata main] at time 21:17:51.522256 duration_in_ms=3090.798
2017-09-14 21:17:51,523 [salt.state       ][INFO    ][1594] Running state [/etc/apt/apt.conf.d/99proxies-salt-mirantis_openstack_hotfix] at time 21:17:51.522616
2017-09-14 21:17:51,523 [salt.state       ][INFO    ][1594] Executing state file.absent for /etc/apt/apt.conf.d/99proxies-salt-mirantis_openstack_hotfix
2017-09-14 21:17:51,523 [salt.state       ][INFO    ][1594] File /etc/apt/apt.conf.d/99proxies-salt-mirantis_openstack_hotfix is not present
2017-09-14 21:17:51,524 [salt.state       ][INFO    ][1594] Completed state [/etc/apt/apt.conf.d/99proxies-salt-mirantis_openstack_hotfix] at time 21:17:51.523568 duration_in_ms=0.951
2017-09-14 21:17:51,524 [salt.state       ][INFO    ][1594] Running state [/etc/apt/preferences.d/mirantis_openstack_hotfix] at time 21:17:51.523835
2017-09-14 21:17:51,524 [salt.state       ][INFO    ][1594] Executing state file.managed for /etc/apt/preferences.d/mirantis_openstack_hotfix
2017-09-14 21:17:51,537 [salt.fileclient  ][INFO    ][1594] Fetching file from saltenv 'base', ** done ** 'linux/files/preferences_repo'
2017-09-14 21:17:51,558 [salt.fileclient  ][INFO    ][1594] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-09-14 21:17:51,588 [salt.state       ][INFO    ][1594] File changed:
New file
2017-09-14 21:17:51,589 [salt.state       ][INFO    ][1594] Completed state [/etc/apt/preferences.d/mirantis_openstack_hotfix] at time 21:17:51.588762 duration_in_ms=64.927
2017-09-14 21:17:51,590 [salt.state       ][INFO    ][1594] Running state [deb http://mirror.fuel-infra.org/mcp-repos/ocata/xenial ocata-hotfix main] at time 21:17:51.589545
2017-09-14 21:17:51,590 [salt.state       ][INFO    ][1594] Executing state pkgrepo.managed for deb http://mirror.fuel-infra.org/mcp-repos/ocata/xenial ocata-hotfix main
2017-09-14 21:17:51,691 [salt.loaded.int.module.cmdmod][INFO    ][1594] Executing command ['apt-key', 'add', '/var/cache/salt/minion/extrn_files/base/mirror.fuel-infra.org/mcp-repos/ocata/xenial/archive-mcpocata.key'] in directory '/root'
2017-09-14 21:17:51,764 [salt.loaded.int.module.cmdmod][INFO    ][1594] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-09-14 21:17:53,808 [salt.state       ][INFO    ][1594] {'repo': 'deb http://mirror.fuel-infra.org/mcp-repos/ocata/xenial ocata-hotfix main'}
2017-09-14 21:17:53,808 [salt.state       ][INFO    ][1594] Completed state [deb http://mirror.fuel-infra.org/mcp-repos/ocata/xenial ocata-hotfix main] at time 21:17:53.808428 duration_in_ms=2218.882
2017-09-14 21:17:53,809 [salt.state       ][INFO    ][1594] Running state [/etc/apt/apt.conf.d/99proxies-salt-salt] at time 21:17:53.808769
2017-09-14 21:17:53,809 [salt.state       ][INFO    ][1594] Executing state file.absent for /etc/apt/apt.conf.d/99proxies-salt-salt
2017-09-14 21:17:53,810 [salt.state       ][INFO    ][1594] File /etc/apt/apt.conf.d/99proxies-salt-salt is not present
2017-09-14 21:17:53,810 [salt.state       ][INFO    ][1594] Completed state [/etc/apt/apt.conf.d/99proxies-salt-salt] at time 21:17:53.809758 duration_in_ms=0.989
2017-09-14 21:17:53,810 [salt.state       ][INFO    ][1594] Running state [/etc/apt/preferences.d/salt] at time 21:17:53.810032
2017-09-14 21:17:53,810 [salt.state       ][INFO    ][1594] Executing state file.absent for /etc/apt/preferences.d/salt
2017-09-14 21:17:53,811 [salt.state       ][INFO    ][1594] File /etc/apt/preferences.d/salt is not present
2017-09-14 21:17:53,811 [salt.state       ][INFO    ][1594] Completed state [/etc/apt/preferences.d/salt] at time 21:17:53.810926 duration_in_ms=0.894
2017-09-14 21:17:53,812 [salt.state       ][INFO    ][1594] Running state [deb http://repo.saltstack.com/apt/ubuntu/16.04/amd64/2016.3 xenial main] at time 21:17:53.811678
2017-09-14 21:17:53,812 [salt.state       ][INFO    ][1594] Executing state pkgrepo.managed for deb http://repo.saltstack.com/apt/ubuntu/16.04/amd64/2016.3 xenial main
2017-09-14 21:17:54,002 [salt.loaded.int.module.cmdmod][INFO    ][1594] Executing command ['apt-key', 'add', '/var/cache/salt/minion/extrn_files/base/repo.saltstack.com/apt/ubuntu/16.04/amd64/2016.3/SALTSTACK-GPG-KEY.pub'] in directory '/root'
2017-09-14 21:17:54,083 [salt.loaded.int.module.cmdmod][INFO    ][1594] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-09-14 21:17:54,343 [salt.minion      ][INFO    ][1503] User sudo_ubuntu Executing command saltutil.find_job with jid 20170914211754329882
2017-09-14 21:17:54,368 [salt.minion      ][INFO    ][6271] Starting a new job with PID 6271
2017-09-14 21:17:54,383 [salt.minion      ][INFO    ][6271] Returning information for job: 20170914211754329882
2017-09-14 21:17:56,477 [salt.state       ][INFO    ][1594] Configured package repo 'deb http://repo.saltstack.com/apt/ubuntu/16.04/amd64/2016.3 xenial main'
2017-09-14 21:17:56,477 [salt.state       ][INFO    ][1594] Completed state [deb http://repo.saltstack.com/apt/ubuntu/16.04/amd64/2016.3 xenial main] at time 21:17:56.476946 duration_in_ms=2665.267
2017-09-14 21:17:56,477 [salt.state       ][INFO    ][1594] Running state [linux_extra_packages_purged] at time 21:17:56.477295
2017-09-14 21:17:56,478 [salt.state       ][INFO    ][1594] Executing state pkg.purged for linux_extra_packages_purged
2017-09-14 21:17:56,490 [salt.loaded.int.module.cmdmod][INFO    ][1594] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', 'purge', 'cloud-init'] in directory '/root'
2017-09-14 21:18:04,468 [salt.minion      ][INFO    ][1503] User sudo_ubuntu Executing command saltutil.find_job with jid 20170914211804456571
2017-09-14 21:18:04,489 [salt.minion      ][INFO    ][6764] Starting a new job with PID 6764
2017-09-14 21:18:04,502 [salt.minion      ][INFO    ][6764] Returning information for job: 20170914211804456571
2017-09-14 21:18:14,498 [salt.minion      ][INFO    ][1503] User sudo_ubuntu Executing command saltutil.find_job with jid 20170914211814484821
2017-09-14 21:18:14,625 [salt.minion      ][INFO    ][6777] Starting a new job with PID 6777
2017-09-14 21:18:14,637 [salt.minion      ][INFO    ][6777] Returning information for job: 20170914211814484821
2017-09-14 21:18:20,503 [salt.loaded.int.module.cmdmod][INFO    ][1594] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-14 21:18:20,520 [salt.state       ][INFO    ][1594] {'removed': {}, 'installed': {'cloud-init': {'new': '', 'old': '0.7.9-153-g16a7302f-0ubuntu1~16.04.2'}, 'ec2-init': {'new': '', 'old': '1'}}}
2017-09-14 21:18:20,568 [salt.state       ][INFO    ][1594] Loading fresh modules for state activity
2017-09-14 21:18:20,581 [salt.state       ][INFO    ][1594] Completed state [linux_extra_packages_purged] at time 21:18:20.580542 duration_in_ms=24103.245
2017-09-14 21:18:20,586 [salt.state       ][INFO    ][1594] Running state [linux_extra_packages_latest] at time 21:18:20.585777
2017-09-14 21:18:20,586 [salt.state       ][INFO    ][1594] Executing state pkg.latest for linux_extra_packages_latest
2017-09-14 21:18:20,802 [salt.loaded.int.module.cmdmod][INFO    ][1594] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-09-14 21:18:23,243 [salt.loaded.int.module.cmdmod][INFO    ][1594] Executing command ['apt-cache', '-q', 'policy', 'mcelog'] in directory '/root'
2017-09-14 21:18:23,385 [salt.loaded.int.module.cmdmod][INFO    ][1594] Executing command ['apt-cache', '-q', 'policy', 'python-msgpack'] in directory '/root'
2017-09-14 21:18:23,433 [salt.loaded.int.module.cmdmod][INFO    ][1594] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'mcelog'] in directory '/root'
2017-09-14 21:18:24,578 [salt.minion      ][INFO    ][1503] User sudo_ubuntu Executing command saltutil.find_job with jid 20170914211824565262
2017-09-14 21:18:24,593 [salt.minion      ][INFO    ][7463] Starting a new job with PID 7463
2017-09-14 21:18:24,608 [salt.minion      ][INFO    ][7463] Returning information for job: 20170914211824565262
2017-09-14 21:18:34,630 [salt.minion      ][INFO    ][1503] User sudo_ubuntu Executing command saltutil.find_job with jid 20170914211834615975
2017-09-14 21:18:34,652 [salt.minion      ][INFO    ][7582] Starting a new job with PID 7582
2017-09-14 21:18:34,664 [salt.minion      ][INFO    ][7582] Returning information for job: 20170914211834615975
2017-09-14 21:18:35,207 [salt.loaded.int.module.cmdmod][INFO    ][1594] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-14 21:18:35,225 [salt.state       ][INFO    ][1594] Made the following changes:
'mcelog' changed from 'absent' to '128+dfsg-1'

2017-09-14 21:18:35,233 [salt.state       ][INFO    ][1594] Loading fresh modules for state activity
2017-09-14 21:18:35,245 [salt.state       ][INFO    ][1594] Completed state [linux_extra_packages_latest] at time 21:18:35.244605 duration_in_ms=14658.827
2017-09-14 21:18:35,318 [salt.state       ][INFO    ][1594] Running state [UTC] at time 21:18:35.318051
2017-09-14 21:18:35,318 [salt.state       ][INFO    ][1594] Executing state timezone.system for UTC
2017-09-14 21:18:35,320 [salt.loaded.int.module.cmdmod][INFO    ][1594] Executing command ['timedatectl'] in directory '/root'
2017-09-14 21:18:35,437 [salt.loaded.int.module.cmdmod][INFO    ][1594] Executing command ['timedatectl'] in directory '/root'
2017-09-14 21:18:35,446 [salt.state       ][INFO    ][1594] Timezone UTC already set, UTC already set to UTC
2017-09-14 21:18:35,446 [salt.state       ][INFO    ][1594] Completed state [UTC] at time 21:18:35.446264 duration_in_ms=128.213
2017-09-14 21:18:35,486 [salt.state       ][INFO    ][1594] Running state [nf_conntrack] at time 21:18:35.485899
2017-09-14 21:18:35,486 [salt.state       ][INFO    ][1594] Executing state kmod.present for nf_conntrack
2017-09-14 21:18:35,487 [salt.loaded.int.module.cmdmod][INFO    ][1594] Executing command 'lsmod' in directory '/root'
2017-09-14 21:18:36,523 [salt.loaded.int.module.cmdmod][INFO    ][1594] Executing command 'lsmod' in directory '/root'
2017-09-14 21:18:36,532 [salt.loaded.int.module.cmdmod][INFO    ][1594] Executing command 'modprobe nf_conntrack' in directory '/root'
2017-09-14 21:18:36,609 [salt.loaded.int.module.cmdmod][INFO    ][1594] Executing command 'lsmod' in directory '/root'
2017-09-14 21:18:36,651 [salt.state       ][INFO    ][1594] {'nf_conntrack': 'loaded'}
2017-09-14 21:18:36,651 [salt.state       ][INFO    ][1594] Completed state [nf_conntrack] at time 21:18:36.651113 duration_in_ms=1165.213
2017-09-14 21:18:36,738 [salt.state       ][INFO    ][1594] Running state [net.ipv4.tcp_keepalive_probes] at time 21:18:36.737449
2017-09-14 21:18:36,738 [salt.state       ][INFO    ][1594] Executing state sysctl.present for net.ipv4.tcp_keepalive_probes
2017-09-14 21:18:36,738 [salt.loaded.int.module.cmdmod][INFO    ][1594] Executing command 'sysctl -a' in directory '/root'
2017-09-14 21:18:36,936 [salt.loaded.int.module.cmdmod][INFO    ][1594] Executing command 'sysctl -w net.ipv4.tcp_keepalive_probes="8"' in directory '/root'
2017-09-14 21:18:36,944 [salt.state       ][INFO    ][1594] {'net.ipv4.tcp_keepalive_probes': 8}
2017-09-14 21:18:36,944 [salt.state       ][INFO    ][1594] Completed state [net.ipv4.tcp_keepalive_probes] at time 21:18:36.944445 duration_in_ms=206.997
2017-09-14 21:18:36,945 [salt.state       ][INFO    ][1594] Running state [fs.file-max] at time 21:18:36.944824
2017-09-14 21:18:36,945 [salt.state       ][INFO    ][1594] Executing state sysctl.present for fs.file-max
2017-09-14 21:18:36,946 [salt.loaded.int.module.cmdmod][INFO    ][1594] Executing command 'sysctl -a' in directory '/root'
2017-09-14 21:18:36,987 [salt.loaded.int.module.cmdmod][INFO    ][1594] Executing command 'sysctl -w fs.file-max="124165"' in directory '/root'
2017-09-14 21:18:36,995 [salt.state       ][INFO    ][1594] {'fs.file-max': 124165}
2017-09-14 21:18:36,996 [salt.state       ][INFO    ][1594] Completed state [fs.file-max] at time 21:18:36.995699 duration_in_ms=50.874
2017-09-14 21:18:36,996 [salt.state       ][INFO    ][1594] Running state [net.core.somaxconn] at time 21:18:36.996058
2017-09-14 21:18:36,996 [salt.state       ][INFO    ][1594] Executing state sysctl.present for net.core.somaxconn
2017-09-14 21:18:36,997 [salt.loaded.int.module.cmdmod][INFO    ][1594] Executing command 'sysctl -a' in directory '/root'
2017-09-14 21:18:37,047 [salt.loaded.int.module.cmdmod][INFO    ][1594] Executing command 'sysctl -w net.core.somaxconn="4096"' in directory '/root'
2017-09-14 21:18:37,055 [salt.state       ][INFO    ][1594] {'net.core.somaxconn': 4096}
2017-09-14 21:18:37,055 [salt.state       ][INFO    ][1594] Completed state [net.core.somaxconn] at time 21:18:37.055455 duration_in_ms=59.396
2017-09-14 21:18:37,056 [salt.state       ][INFO    ][1594] Running state [net.ipv4.tcp_max_syn_backlog] at time 21:18:37.055811
2017-09-14 21:18:37,056 [salt.state       ][INFO    ][1594] Executing state sysctl.present for net.ipv4.tcp_max_syn_backlog
2017-09-14 21:18:37,057 [salt.loaded.int.module.cmdmod][INFO    ][1594] Executing command 'sysctl -a' in directory '/root'
2017-09-14 21:18:37,155 [salt.loaded.int.module.cmdmod][INFO    ][1594] Executing command 'sysctl -w net.ipv4.tcp_max_syn_backlog="8192"' in directory '/root'
2017-09-14 21:18:37,163 [salt.state       ][INFO    ][1594] {'net.ipv4.tcp_max_syn_backlog': 8192}
2017-09-14 21:18:37,164 [salt.state       ][INFO    ][1594] Completed state [net.ipv4.tcp_max_syn_backlog] at time 21:18:37.163485 duration_in_ms=107.672
2017-09-14 21:18:37,164 [salt.state       ][INFO    ][1594] Running state [net.ipv4.tcp_tw_reuse] at time 21:18:37.163863
2017-09-14 21:18:37,164 [salt.state       ][INFO    ][1594] Executing state sysctl.present for net.ipv4.tcp_tw_reuse
2017-09-14 21:18:37,165 [salt.loaded.int.module.cmdmod][INFO    ][1594] Executing command 'sysctl -a' in directory '/root'
2017-09-14 21:18:37,179 [salt.loaded.int.module.cmdmod][INFO    ][1594] Executing command 'sysctl -w net.ipv4.tcp_tw_reuse="1"' in directory '/root'
2017-09-14 21:18:37,188 [salt.state       ][INFO    ][1594] {'net.ipv4.tcp_tw_reuse': 1}
2017-09-14 21:18:37,189 [salt.state       ][INFO    ][1594] Completed state [net.ipv4.tcp_tw_reuse] at time 21:18:37.188592 duration_in_ms=24.729
2017-09-14 21:18:37,189 [salt.state       ][INFO    ][1594] Running state [net.ipv4.tcp_congestion_control] at time 21:18:37.188925
2017-09-14 21:18:37,189 [salt.state       ][INFO    ][1594] Executing state sysctl.present for net.ipv4.tcp_congestion_control
2017-09-14 21:18:37,190 [salt.loaded.int.module.cmdmod][INFO    ][1594] Executing command 'sysctl -a' in directory '/root'
2017-09-14 21:18:37,203 [salt.loaded.int.module.cmdmod][INFO    ][1594] Executing command 'sysctl -w net.ipv4.tcp_congestion_control="yeah"' in directory '/root'
2017-09-14 21:18:37,308 [salt.state       ][INFO    ][1594] {'net.ipv4.tcp_congestion_control': 'yeah'}
2017-09-14 21:18:37,308 [salt.state       ][INFO    ][1594] Completed state [net.ipv4.tcp_congestion_control] at time 21:18:37.308396 duration_in_ms=119.471
2017-09-14 21:18:37,309 [salt.state       ][INFO    ][1594] Running state [net.nf_conntrack_max] at time 21:18:37.308758
2017-09-14 21:18:37,309 [salt.state       ][INFO    ][1594] Executing state sysctl.present for net.nf_conntrack_max
2017-09-14 21:18:37,310 [salt.loaded.int.module.cmdmod][INFO    ][1594] Executing command 'sysctl -a' in directory '/root'
2017-09-14 21:18:37,327 [salt.loaded.int.module.cmdmod][INFO    ][1594] Executing command 'sysctl -w net.nf_conntrack_max="1048576"' in directory '/root'
2017-09-14 21:18:37,338 [salt.state       ][INFO    ][1594] {'net.nf_conntrack_max': 1048576}
2017-09-14 21:18:37,338 [salt.state       ][INFO    ][1594] Completed state [net.nf_conntrack_max] at time 21:18:37.338366 duration_in_ms=29.607
2017-09-14 21:18:37,339 [salt.state       ][INFO    ][1594] Running state [net.ipv4.tcp_retries2] at time 21:18:37.338738
2017-09-14 21:18:37,339 [salt.state       ][INFO    ][1594] Executing state sysctl.present for net.ipv4.tcp_retries2
2017-09-14 21:18:37,340 [salt.loaded.int.module.cmdmod][INFO    ][1594] Executing command 'sysctl -a' in directory '/root'
2017-09-14 21:18:37,453 [salt.loaded.int.module.cmdmod][INFO    ][1594] Executing command 'sysctl -w net.ipv4.tcp_retries2="5"' in directory '/root'
2017-09-14 21:18:37,463 [salt.state       ][INFO    ][1594] {'net.ipv4.tcp_retries2': 5}
2017-09-14 21:18:37,463 [salt.state       ][INFO    ][1594] Completed state [net.ipv4.tcp_retries2] at time 21:18:37.463388 duration_in_ms=124.649
2017-09-14 21:18:37,464 [salt.state       ][INFO    ][1594] Running state [net.core.netdev_max_backlog] at time 21:18:37.463778
2017-09-14 21:18:37,464 [salt.state       ][INFO    ][1594] Executing state sysctl.present for net.core.netdev_max_backlog
2017-09-14 21:18:37,465 [salt.loaded.int.module.cmdmod][INFO    ][1594] Executing command 'sysctl -a' in directory '/root'
2017-09-14 21:18:37,496 [salt.loaded.int.module.cmdmod][INFO    ][1594] Executing command 'sysctl -w net.core.netdev_max_backlog="261144"' in directory '/root'
2017-09-14 21:18:37,505 [salt.state       ][INFO    ][1594] {'net.core.netdev_max_backlog': 261144}
2017-09-14 21:18:37,506 [salt.state       ][INFO    ][1594] Completed state [net.core.netdev_max_backlog] at time 21:18:37.505449 duration_in_ms=41.67
2017-09-14 21:18:37,506 [salt.state       ][INFO    ][1594] Running state [net.ipv4.tcp_slow_start_after_idle] at time 21:18:37.505886
2017-09-14 21:18:37,506 [salt.state       ][INFO    ][1594] Executing state sysctl.present for net.ipv4.tcp_slow_start_after_idle
2017-09-14 21:18:37,507 [salt.loaded.int.module.cmdmod][INFO    ][1594] Executing command 'sysctl -a' in directory '/root'
2017-09-14 21:18:37,567 [salt.loaded.int.module.cmdmod][INFO    ][1594] Executing command 'sysctl -w net.ipv4.tcp_slow_start_after_idle="0"' in directory '/root'
2017-09-14 21:18:37,576 [salt.state       ][INFO    ][1594] {'net.ipv4.tcp_slow_start_after_idle': 0}
2017-09-14 21:18:37,576 [salt.state       ][INFO    ][1594] Completed state [net.ipv4.tcp_slow_start_after_idle] at time 21:18:37.576212 duration_in_ms=70.325
2017-09-14 21:18:37,577 [salt.state       ][INFO    ][1594] Running state [vm.swappiness] at time 21:18:37.576605
2017-09-14 21:18:37,577 [salt.state       ][INFO    ][1594] Executing state sysctl.present for vm.swappiness
2017-09-14 21:18:37,578 [salt.loaded.int.module.cmdmod][INFO    ][1594] Executing command 'sysctl -a' in directory '/root'
2017-09-14 21:18:37,711 [salt.loaded.int.module.cmdmod][INFO    ][1594] Executing command 'sysctl -w vm.swappiness="10"' in directory '/root'
2017-09-14 21:18:37,721 [salt.state       ][INFO    ][1594] {'vm.swappiness': 10}
2017-09-14 21:18:37,722 [salt.state       ][INFO    ][1594] Completed state [vm.swappiness] at time 21:18:37.721656 duration_in_ms=145.05
2017-09-14 21:18:37,722 [salt.state       ][INFO    ][1594] Running state [net.ipv4.tcp_keepalive_intvl] at time 21:18:37.722045
2017-09-14 21:18:37,722 [salt.state       ][INFO    ][1594] Executing state sysctl.present for net.ipv4.tcp_keepalive_intvl
2017-09-14 21:18:37,723 [salt.loaded.int.module.cmdmod][INFO    ][1594] Executing command 'sysctl -a' in directory '/root'
2017-09-14 21:18:37,738 [salt.loaded.int.module.cmdmod][INFO    ][1594] Executing command 'sysctl -w net.ipv4.tcp_keepalive_intvl="3"' in directory '/root'
2017-09-14 21:18:37,745 [salt.state       ][INFO    ][1594] {'net.ipv4.tcp_keepalive_intvl': 3}
2017-09-14 21:18:37,746 [salt.state       ][INFO    ][1594] Completed state [net.ipv4.tcp_keepalive_intvl] at time 21:18:37.745950 duration_in_ms=23.904
2017-09-14 21:18:37,746 [salt.state       ][INFO    ][1594] Running state [net.ipv4.neigh.default.gc_thresh1] at time 21:18:37.746302
2017-09-14 21:18:37,747 [salt.state       ][INFO    ][1594] Executing state sysctl.present for net.ipv4.neigh.default.gc_thresh1
2017-09-14 21:18:37,747 [salt.loaded.int.module.cmdmod][INFO    ][1594] Executing command 'sysctl -a' in directory '/root'
2017-09-14 21:18:37,831 [salt.loaded.int.module.cmdmod][INFO    ][1594] Executing command 'sysctl -w net.ipv4.neigh.default.gc_thresh1="4096"' in directory '/root'
2017-09-14 21:18:37,838 [salt.state       ][INFO    ][1594] {'net.ipv4.neigh.default.gc_thresh1': 4096}
2017-09-14 21:18:37,838 [salt.state       ][INFO    ][1594] Completed state [net.ipv4.neigh.default.gc_thresh1] at time 21:18:37.838299 duration_in_ms=91.996
2017-09-14 21:18:37,839 [salt.state       ][INFO    ][1594] Running state [net.ipv4.neigh.default.gc_thresh2] at time 21:18:37.838676
2017-09-14 21:18:37,839 [salt.state       ][INFO    ][1594] Executing state sysctl.present for net.ipv4.neigh.default.gc_thresh2
2017-09-14 21:18:37,840 [salt.loaded.int.module.cmdmod][INFO    ][1594] Executing command 'sysctl -a' in directory '/root'
2017-09-14 21:18:37,945 [salt.loaded.int.module.cmdmod][INFO    ][1594] Executing command 'sysctl -w net.ipv4.neigh.default.gc_thresh2="8192"' in directory '/root'
2017-09-14 21:18:37,954 [salt.state       ][INFO    ][1594] {'net.ipv4.neigh.default.gc_thresh2': 8192}
2017-09-14 21:18:37,954 [salt.state       ][INFO    ][1594] Completed state [net.ipv4.neigh.default.gc_thresh2] at time 21:18:37.954127 duration_in_ms=115.449
2017-09-14 21:18:37,955 [salt.state       ][INFO    ][1594] Running state [net.ipv4.neigh.default.gc_thresh3] at time 21:18:37.954516
2017-09-14 21:18:37,955 [salt.state       ][INFO    ][1594] Executing state sysctl.present for net.ipv4.neigh.default.gc_thresh3
2017-09-14 21:18:37,955 [salt.loaded.int.module.cmdmod][INFO    ][1594] Executing command 'sysctl -a' in directory '/root'
2017-09-14 21:18:38,046 [salt.loaded.int.module.cmdmod][INFO    ][1594] Executing command 'sysctl -w net.ipv4.neigh.default.gc_thresh3="16384"' in directory '/root'
2017-09-14 21:18:38,055 [salt.state       ][INFO    ][1594] {'net.ipv4.neigh.default.gc_thresh3': 16384}
2017-09-14 21:18:38,056 [salt.state       ][INFO    ][1594] Completed state [net.ipv4.neigh.default.gc_thresh3] at time 21:18:38.055797 duration_in_ms=101.279
2017-09-14 21:18:38,056 [salt.state       ][INFO    ][1594] Running state [net.ipv4.tcp_fin_timeout] at time 21:18:38.056176
2017-09-14 21:18:38,057 [salt.state       ][INFO    ][1594] Executing state sysctl.present for net.ipv4.tcp_fin_timeout
2017-09-14 21:18:38,057 [salt.loaded.int.module.cmdmod][INFO    ][1594] Executing command 'sysctl -a' in directory '/root'
2017-09-14 21:18:38,118 [salt.loaded.int.module.cmdmod][INFO    ][1594] Executing command 'sysctl -w net.ipv4.tcp_fin_timeout="30"' in directory '/root'
2017-09-14 21:18:38,127 [salt.state       ][INFO    ][1594] {'net.ipv4.tcp_fin_timeout': 30}
2017-09-14 21:18:38,128 [salt.state       ][INFO    ][1594] Completed state [net.ipv4.tcp_fin_timeout] at time 21:18:38.128048 duration_in_ms=71.871
2017-09-14 21:18:38,128 [salt.state       ][INFO    ][1594] Running state [net.ipv4.tcp_keepalive_time] at time 21:18:38.128414
2017-09-14 21:18:38,129 [salt.state       ][INFO    ][1594] Executing state sysctl.present for net.ipv4.tcp_keepalive_time
2017-09-14 21:18:38,129 [salt.loaded.int.module.cmdmod][INFO    ][1594] Executing command 'sysctl -a' in directory '/root'
2017-09-14 21:18:38,232 [salt.loaded.int.module.cmdmod][INFO    ][1594] Executing command 'sysctl -w net.ipv4.tcp_keepalive_time="30"' in directory '/root'
2017-09-14 21:18:38,242 [salt.state       ][INFO    ][1594] {'net.ipv4.tcp_keepalive_time': 30}
2017-09-14 21:18:38,242 [salt.state       ][INFO    ][1594] Completed state [net.ipv4.tcp_keepalive_time] at time 21:18:38.242174 duration_in_ms=113.76
2017-09-14 21:18:38,243 [salt.state       ][INFO    ][1594] Running state [kernel.panic] at time 21:18:38.242583
2017-09-14 21:18:38,243 [salt.state       ][INFO    ][1594] Executing state sysctl.present for kernel.panic
2017-09-14 21:18:38,244 [salt.loaded.int.module.cmdmod][INFO    ][1594] Executing command 'sysctl -a' in directory '/root'
2017-09-14 21:18:38,257 [salt.loaded.int.module.cmdmod][INFO    ][1594] Executing command 'sysctl -w kernel.panic="60"' in directory '/root'
2017-09-14 21:18:38,265 [salt.state       ][INFO    ][1594] {'kernel.panic': 60}
2017-09-14 21:18:38,266 [salt.state       ][INFO    ][1594] Completed state [kernel.panic] at time 21:18:38.266002 duration_in_ms=23.417
2017-09-14 21:18:38,271 [salt.state       ][INFO    ][1594] Running state [linux_sysfs_package] at time 21:18:38.271142
2017-09-14 21:18:38,271 [salt.state       ][INFO    ][1594] Executing state pkg.installed for linux_sysfs_package
2017-09-14 21:18:38,448 [salt.loaded.int.module.cmdmod][INFO    ][1594] Executing command ['apt-cache', '-q', 'policy', 'sysfsutils'] in directory '/root'
2017-09-14 21:18:38,494 [salt.loaded.int.module.cmdmod][INFO    ][1594] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-09-14 21:18:43,571 [salt.loaded.int.module.cmdmod][INFO    ][1594] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'sysfsutils'] in directory '/root'
2017-09-14 21:18:44,700 [salt.minion      ][INFO    ][1503] User sudo_ubuntu Executing command saltutil.find_job with jid 20170914211844690934
2017-09-14 21:18:44,716 [salt.minion      ][INFO    ][8221] Starting a new job with PID 8221
2017-09-14 21:18:44,732 [salt.minion      ][INFO    ][8221] Returning information for job: 20170914211844690934
2017-09-14 21:18:54,875 [salt.minion      ][INFO    ][1503] User sudo_ubuntu Executing command saltutil.find_job with jid 20170914211854860258
2017-09-14 21:18:54,893 [salt.minion      ][INFO    ][8274] Starting a new job with PID 8274
2017-09-14 21:18:54,910 [salt.minion      ][INFO    ][8274] Returning information for job: 20170914211854860258
2017-09-14 21:19:04,907 [salt.minion      ][INFO    ][1503] User sudo_ubuntu Executing command saltutil.find_job with jid 20170914211904892035
2017-09-14 21:19:04,937 [salt.minion      ][INFO    ][8362] Starting a new job with PID 8362
2017-09-14 21:19:06,887 [salt.minion      ][INFO    ][8362] Returning information for job: 20170914211904892035
2017-09-14 21:19:14,992 [salt.minion      ][INFO    ][1503] User sudo_ubuntu Executing command saltutil.find_job with jid 20170914211914978046
2017-09-14 21:19:15,507 [salt.minion      ][INFO    ][8375] Starting a new job with PID 8375
2017-09-14 21:19:15,516 [salt.minion      ][INFO    ][8375] Returning information for job: 20170914211914978046
2017-09-14 21:19:23,735 [salt.loaded.int.module.cmdmod][INFO    ][1594] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-14 21:19:23,755 [salt.state       ][INFO    ][1594] Made the following changes:
'libsysfs2' changed from 'absent' to '2.1.0+repack-4'
'sysfsutils' changed from 'absent' to '2.1.0+repack-4'

2017-09-14 21:19:23,763 [salt.state       ][INFO    ][1594] Loading fresh modules for state activity
2017-09-14 21:19:23,779 [salt.state       ][INFO    ][1594] Completed state [linux_sysfs_package] at time 21:19:23.778716 duration_in_ms=45507.573
2017-09-14 21:19:23,781 [salt.state       ][INFO    ][1594] Running state [/etc/sysfs.d] at time 21:19:23.781148
2017-09-14 21:19:23,782 [salt.state       ][INFO    ][1594] Executing state file.directory for /etc/sysfs.d
2017-09-14 21:19:23,783 [salt.state       ][INFO    ][1594] Directory /etc/sysfs.d is in the correct state
2017-09-14 21:19:23,784 [salt.state       ][INFO    ][1594] Completed state [/etc/sysfs.d] at time 21:19:23.783621 duration_in_ms=2.473
2017-09-14 21:19:24,007 [salt.state       ][INFO    ][1594] Running state [ondemand] at time 21:19:24.007415
2017-09-14 21:19:24,008 [salt.state       ][INFO    ][1594] Executing state service.dead for ondemand
2017-09-14 21:19:24,009 [salt.loaded.int.module.cmdmod][INFO    ][1594] Executing command ['systemctl', 'status', 'ondemand.service', '-n', '0'] in directory '/root'
2017-09-14 21:19:24,018 [salt.loaded.int.module.cmdmod][INFO    ][1594] Executing command ['systemctl', 'is-active', 'ondemand.service'] in directory '/root'
2017-09-14 21:19:24,026 [salt.loaded.int.module.cmdmod][INFO    ][1594] Executing command ['systemctl', 'is-enabled', 'ondemand.service'] in directory '/root'
2017-09-14 21:19:24,036 [salt.loaded.int.module.cmdmod][INFO    ][1594] Executing command ['systemd-run', '--scope', 'systemctl', 'stop', 'ondemand.service'] in directory '/root'
2017-09-14 21:19:24,076 [salt.loaded.int.module.cmdmod][INFO    ][1594] Executing command ['systemctl', 'is-active', 'ondemand.service'] in directory '/root'
2017-09-14 21:19:24,084 [salt.loaded.int.module.cmdmod][INFO    ][1594] Executing command ['systemctl', 'is-enabled', 'ondemand.service'] in directory '/root'
2017-09-14 21:19:24,094 [salt.loaded.int.module.cmdmod][INFO    ][1594] Executing command ['systemctl', 'is-enabled', 'ondemand.service'] in directory '/root'
2017-09-14 21:19:24,105 [salt.loaded.int.module.cmdmod][INFO    ][1594] Executing command ['systemd-run', '--scope', '/usr/sbin/update-rc.d', '-f', 'ondemand', 'remove'] in directory '/root'
2017-09-14 21:19:24,190 [salt.loaded.int.module.cmdmod][INFO    ][1594] Executing command ['systemctl', 'is-enabled', 'ondemand.service'] in directory '/root'
2017-09-14 21:19:24,201 [salt.loaded.int.module.cmdmod][INFO    ][1594] Executing command 'runlevel' in directory '/root'
2017-09-14 21:19:24,209 [salt.state       ][INFO    ][1594] {'ondemand': True}
2017-09-14 21:19:24,210 [salt.state       ][INFO    ][1594] Completed state [ondemand] at time 21:19:24.209761 duration_in_ms=202.346
2017-09-14 21:19:24,342 [salt.state       ][INFO    ][1594] Running state [cs_CZ.UTF-8] at time 21:19:24.341526
2017-09-14 21:19:24,342 [salt.state       ][INFO    ][1594] Executing state locale.present for cs_CZ.UTF-8
2017-09-14 21:19:24,343 [salt.loaded.int.module.cmdmod][INFO    ][1594] Executing command 'locale -a' in directory '/root'
2017-09-14 21:19:24,354 [salt.loaded.int.module.cmdmod][INFO    ][1594] Executing command ['locale-gen', 'cs_CZ.UTF-8'] in directory '/root'
2017-09-14 21:19:25,158 [salt.state       ][INFO    ][1594] {'locale': 'cs_CZ.UTF-8'}
2017-09-14 21:19:25,159 [salt.state       ][INFO    ][1594] Completed state [cs_CZ.UTF-8] at time 21:19:25.158791 duration_in_ms=817.265
2017-09-14 21:19:25,159 [salt.state       ][INFO    ][1594] Running state [en_US.UTF-8] at time 21:19:25.159239
2017-09-14 21:19:25,160 [salt.state       ][INFO    ][1594] Executing state locale.present for en_US.UTF-8
2017-09-14 21:19:25,160 [salt.loaded.int.module.cmdmod][INFO    ][1594] Executing command 'locale -a' in directory '/root'
2017-09-14 21:19:25,170 [salt.state       ][INFO    ][1594] Locale en_US.UTF-8 is already present
2017-09-14 21:19:25,171 [salt.state       ][INFO    ][1594] Completed state [en_US.UTF-8] at time 21:19:25.170844 duration_in_ms=11.605
2017-09-14 21:19:25,172 [salt.state       ][INFO    ][1594] Running state [en_US.UTF-8] at time 21:19:25.171916
2017-09-14 21:19:25,172 [salt.state       ][INFO    ][1594] Executing state locale.system for en_US.UTF-8
2017-09-14 21:19:25,173 [salt.loaded.int.module.cmdmod][INFO    ][1594] Executing command 'localectl' in directory '/root'
2017-09-14 21:19:25,211 [salt.minion      ][INFO    ][1503] User sudo_ubuntu Executing command saltutil.find_job with jid 20170914211925197331
2017-09-14 21:19:25,225 [salt.minion      ][INFO    ][8486] Starting a new job with PID 8486
2017-09-14 21:19:25,237 [salt.minion      ][INFO    ][8486] Returning information for job: 20170914211925197331
2017-09-14 21:19:25,443 [salt.state       ][INFO    ][1594] System locale en_US.UTF-8 already set
2017-09-14 21:19:25,444 [salt.state       ][INFO    ][1594] Completed state [en_US.UTF-8] at time 21:19:25.443509 duration_in_ms=271.593
2017-09-14 21:19:25,455 [salt.state       ][INFO    ][1594] Running state [root] at time 21:19:25.454811
2017-09-14 21:19:25,455 [salt.state       ][INFO    ][1594] Executing state user.present for root
2017-09-14 21:19:25,460 [salt.state       ][INFO    ][1594] {'passwd': 'XXX-REDACTED-XXX', 'lstchg': 17423}
2017-09-14 21:19:25,460 [salt.state       ][INFO    ][1594] Completed state [root] at time 21:19:25.459744 duration_in_ms=4.933
2017-09-14 21:19:25,461 [salt.state       ][INFO    ][1594] Running state [/root] at time 21:19:25.460701
2017-09-14 21:19:25,461 [salt.state       ][INFO    ][1594] Executing state file.directory for /root
2017-09-14 21:19:25,462 [salt.state       ][INFO    ][1594] Directory /root is in the correct state
2017-09-14 21:19:25,462 [salt.state       ][INFO    ][1594] Completed state [/root] at time 21:19:25.461792 duration_in_ms=1.09
2017-09-14 21:19:25,462 [salt.state       ][INFO    ][1594] Running state [/etc/sudoers.d/90-salt-user-root] at time 21:19:25.462067
2017-09-14 21:19:25,462 [salt.state       ][INFO    ][1594] Executing state file.absent for /etc/sudoers.d/90-salt-user-root
2017-09-14 21:19:25,467 [salt.state       ][INFO    ][1594] File /etc/sudoers.d/90-salt-user-root is not present
2017-09-14 21:19:25,467 [salt.state       ][INFO    ][1594] Completed state [/etc/sudoers.d/90-salt-user-root] at time 21:19:25.466801 duration_in_ms=4.733
2017-09-14 21:19:25,467 [salt.state       ][INFO    ][1594] Running state [ubuntu] at time 21:19:25.467096
2017-09-14 21:19:25,467 [salt.state       ][INFO    ][1594] Executing state user.present for ubuntu
2017-09-14 21:19:25,468 [salt.loaded.int.module.cmdmod][INFO    ][1594] Executing command ['useradd', '-s', '/bin/bash', '-m', '-d', '/home/ubuntu', 'ubuntu'] in directory '/root'
2017-09-14 21:19:26,447 [salt.state       ][INFO    ][1594] {'shell': '/bin/bash', 'workphone': '', 'uid': 1000, 'passwd': 'x', 'roomnumber': '', 'groups': ['ubuntu'], 'home': '/home/ubuntu', 'password': 'XXX-REDACTED-XXX', 'name': 'ubuntu', 'gid': 1000, 'fullname': '', 'homephone': ''}
2017-09-14 21:19:26,447 [salt.state       ][INFO    ][1594] Completed state [ubuntu] at time 21:19:26.446754 duration_in_ms=979.657
2017-09-14 21:19:26,448 [salt.state       ][INFO    ][1594] Running state [/home/ubuntu] at time 21:19:26.447673
2017-09-14 21:19:26,448 [salt.state       ][INFO    ][1594] Executing state file.directory for /home/ubuntu
2017-09-14 21:19:26,449 [salt.state       ][INFO    ][1594] {'mode': '0700'}
2017-09-14 21:19:26,449 [salt.state       ][INFO    ][1594] Completed state [/home/ubuntu] at time 21:19:26.448680 duration_in_ms=1.006
2017-09-14 21:19:26,449 [salt.state       ][INFO    ][1594] Running state [/etc/sudoers.d/90-salt-user-ubuntu] at time 21:19:26.449242
2017-09-14 21:19:26,449 [salt.state       ][INFO    ][1594] Executing state file.managed for /etc/sudoers.d/90-salt-user-ubuntu
2017-09-14 21:19:26,474 [salt.fileclient  ][INFO    ][1594] Fetching file from saltenv 'base', ** done ** 'linux/files/sudoer'
2017-09-14 21:19:26,477 [salt.loaded.int.module.cmdmod][INFO    ][1594] Executing command '/usr/sbin/visudo -c -f /tmp/tmpMSf7In' in directory '/root'
2017-09-14 21:19:26,626 [salt.state       ][INFO    ][1594] File changed:
New file
2017-09-14 21:19:26,626 [salt.state       ][INFO    ][1594] Completed state [/etc/sudoers.d/90-salt-user-ubuntu] at time 21:19:26.625961 duration_in_ms=176.719
2017-09-14 21:19:26,626 [salt.state       ][INFO    ][1594] Running state [/etc/security/limits.d/90-salt-default.conf] at time 21:19:26.626156
2017-09-14 21:19:26,626 [salt.state       ][INFO    ][1594] Executing state file.managed for /etc/security/limits.d/90-salt-default.conf
2017-09-14 21:19:26,648 [salt.fileclient  ][INFO    ][1594] Fetching file from saltenv 'base', ** done ** 'linux/files/limits.conf'
2017-09-14 21:19:26,665 [salt.fileclient  ][INFO    ][1594] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-09-14 21:19:26,696 [salt.state       ][INFO    ][1594] File changed:
New file
2017-09-14 21:19:26,697 [salt.state       ][INFO    ][1594] Completed state [/etc/security/limits.d/90-salt-default.conf] at time 21:19:26.696577 duration_in_ms=70.421
2017-09-14 21:19:26,697 [salt.state       ][INFO    ][1594] Running state [/etc/systemd/system.conf.d/90-salt.conf] at time 21:19:26.696726
2017-09-14 21:19:26,697 [salt.state       ][INFO    ][1594] Executing state file.managed for /etc/systemd/system.conf.d/90-salt.conf
2017-09-14 21:19:26,712 [salt.fileclient  ][INFO    ][1594] Fetching file from saltenv 'base', ** done ** 'linux/files/systemd.conf'
2017-09-14 21:19:26,758 [salt.fileclient  ][INFO    ][1594] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-09-14 21:19:26,786 [salt.state       ][INFO    ][1594] File changed:
New file
2017-09-14 21:19:26,786 [salt.state       ][INFO    ][1594] Completed state [/etc/systemd/system.conf.d/90-salt.conf] at time 21:19:26.786429 duration_in_ms=89.702
2017-09-14 21:19:26,787 [salt.state       ][INFO    ][1594] Running state [service.systemctl_reload] at time 21:19:26.787373
2017-09-14 21:19:26,788 [salt.state       ][INFO    ][1594] Executing state module.wait for service.systemctl_reload
2017-09-14 21:19:26,788 [salt.state       ][INFO    ][1594] No changes made for service.systemctl_reload
2017-09-14 21:19:26,788 [salt.state       ][INFO    ][1594] Completed state [service.systemctl_reload] at time 21:19:26.787801 duration_in_ms=0.427
2017-09-14 21:19:26,788 [salt.state       ][INFO    ][1594] Running state [service.systemctl_reload] at time 21:19:26.787919
2017-09-14 21:19:26,788 [salt.state       ][INFO    ][1594] Executing state module.mod_watch for service.systemctl_reload
2017-09-14 21:19:26,788 [salt.loaded.int.module.cmdmod][INFO    ][1594] Executing command ['systemctl', '--system', 'daemon-reload'] in directory '/root'
2017-09-14 21:19:26,821 [salt.state       ][INFO    ][1594] {'ret': True}
2017-09-14 21:19:26,821 [salt.state       ][INFO    ][1594] Completed state [service.systemctl_reload] at time 21:19:26.821263 duration_in_ms=33.343
2017-09-14 21:19:26,822 [salt.state       ][INFO    ][1594] Running state [/etc/hostname] at time 21:19:26.821482
2017-09-14 21:19:26,822 [salt.state       ][INFO    ][1594] Executing state file.managed for /etc/hostname
2017-09-14 21:19:26,839 [salt.fileclient  ][INFO    ][1594] Fetching file from saltenv 'base', ** done ** 'linux/files/hostname'
2017-09-14 21:19:26,841 [salt.state       ][INFO    ][1594] File changed:
--- 
+++ 
@@ -1 +1 @@
-ubuntu-1604
+odl01

2017-09-14 21:19:26,841 [salt.state       ][INFO    ][1594] Completed state [/etc/hostname] at time 21:19:26.841058 duration_in_ms=19.575
2017-09-14 21:19:26,842 [salt.state       ][INFO    ][1594] Running state [hostname odl01] at time 21:19:26.842322
2017-09-14 21:19:26,843 [salt.state       ][INFO    ][1594] Executing state cmd.wait for hostname odl01
2017-09-14 21:19:26,843 [salt.state       ][INFO    ][1594] No changes made for hostname odl01
2017-09-14 21:19:26,843 [salt.state       ][INFO    ][1594] Completed state [hostname odl01] at time 21:19:26.842819 duration_in_ms=0.497
2017-09-14 21:19:26,843 [salt.state       ][INFO    ][1594] Running state [hostname odl01] at time 21:19:26.842929
2017-09-14 21:19:26,843 [salt.state       ][INFO    ][1594] Executing state cmd.mod_watch for hostname odl01
2017-09-14 21:19:26,844 [salt.loaded.int.module.cmdmod][INFO    ][1594] Executing command 'hostname odl01' in directory '/root'
2017-09-14 21:19:26,850 [salt.state       ][INFO    ][1594] {'pid': 8513, 'retcode': 0, 'stderr': '', 'stdout': ''}
2017-09-14 21:19:26,850 [salt.state       ][INFO    ][1594] Completed state [hostname odl01] at time 21:19:26.850043 duration_in_ms=7.112
2017-09-14 21:19:26,904 [salt.state       ][INFO    ][1594] Running state [mdb02.baremetal-mcp-ocata-odl-ha.local] at time 21:19:26.904409
2017-09-14 21:19:26,905 [salt.state       ][INFO    ][1594] Executing state host.present for mdb02.baremetal-mcp-ocata-odl-ha.local
2017-09-14 21:19:26,906 [salt.state       ][INFO    ][1594] {'host': 'mdb02.baremetal-mcp-ocata-odl-ha.local'}
2017-09-14 21:19:26,906 [salt.state       ][INFO    ][1594] Completed state [mdb02.baremetal-mcp-ocata-odl-ha.local] at time 21:19:26.906071 duration_in_ms=1.663
2017-09-14 21:19:26,906 [salt.state       ][INFO    ][1594] Running state [mdb02] at time 21:19:26.906231
2017-09-14 21:19:26,906 [salt.state       ][INFO    ][1594] Executing state host.present for mdb02
2017-09-14 21:19:26,964 [salt.state       ][INFO    ][1594] {'host': 'mdb02'}
2017-09-14 21:19:26,965 [salt.state       ][INFO    ][1594] Completed state [mdb02] at time 21:19:26.964640 duration_in_ms=58.409
2017-09-14 21:19:26,965 [salt.state       ][INFO    ][1594] Running state [mdb03.baremetal-mcp-ocata-odl-ha.local] at time 21:19:26.964827
2017-09-14 21:19:26,965 [salt.state       ][INFO    ][1594] Executing state host.present for mdb03.baremetal-mcp-ocata-odl-ha.local
2017-09-14 21:19:26,970 [salt.state       ][INFO    ][1594] {'host': 'mdb03.baremetal-mcp-ocata-odl-ha.local'}
2017-09-14 21:19:26,970 [salt.state       ][INFO    ][1594] Completed state [mdb03.baremetal-mcp-ocata-odl-ha.local] at time 21:19:26.970370 duration_in_ms=5.543
2017-09-14 21:19:26,971 [salt.state       ][INFO    ][1594] Running state [mdb03] at time 21:19:26.970540
2017-09-14 21:19:26,971 [salt.state       ][INFO    ][1594] Executing state host.present for mdb03
2017-09-14 21:19:26,976 [salt.state       ][INFO    ][1594] {'host': 'mdb03'}
2017-09-14 21:19:26,977 [salt.state       ][INFO    ][1594] Completed state [mdb03] at time 21:19:26.976511 duration_in_ms=5.97
2017-09-14 21:19:26,977 [salt.state       ][INFO    ][1594] Running state [mdb01.baremetal-mcp-ocata-odl-ha.local] at time 21:19:26.976689
2017-09-14 21:19:26,977 [salt.state       ][INFO    ][1594] Executing state host.present for mdb01.baremetal-mcp-ocata-odl-ha.local
2017-09-14 21:19:26,982 [salt.state       ][INFO    ][1594] {'host': 'mdb01.baremetal-mcp-ocata-odl-ha.local'}
2017-09-14 21:19:26,983 [salt.state       ][INFO    ][1594] Completed state [mdb01.baremetal-mcp-ocata-odl-ha.local] at time 21:19:26.982489 duration_in_ms=5.8
2017-09-14 21:19:26,983 [salt.state       ][INFO    ][1594] Running state [mdb01] at time 21:19:26.982664
2017-09-14 21:19:26,983 [salt.state       ][INFO    ][1594] Executing state host.present for mdb01
2017-09-14 21:19:26,988 [salt.state       ][INFO    ][1594] {'host': 'mdb01'}
2017-09-14 21:19:26,988 [salt.state       ][INFO    ][1594] Completed state [mdb01] at time 21:19:26.988468 duration_in_ms=5.804
2017-09-14 21:19:26,989 [salt.state       ][INFO    ][1594] Running state [mdb] at time 21:19:26.988638
2017-09-14 21:19:26,989 [salt.state       ][INFO    ][1594] Executing state host.present for mdb
2017-09-14 21:19:26,994 [salt.state       ][INFO    ][1594] {'host': 'mdb'}
2017-09-14 21:19:26,994 [salt.state       ][INFO    ][1594] Completed state [mdb] at time 21:19:26.994413 duration_in_ms=5.775
2017-09-14 21:19:26,995 [salt.state       ][INFO    ][1594] Running state [mdb.baremetal-mcp-ocata-odl-ha.local] at time 21:19:26.994586
2017-09-14 21:19:26,995 [salt.state       ][INFO    ][1594] Executing state host.present for mdb.baremetal-mcp-ocata-odl-ha.local
2017-09-14 21:19:27,000 [salt.state       ][INFO    ][1594] {'host': 'mdb.baremetal-mcp-ocata-odl-ha.local'}
2017-09-14 21:19:27,000 [salt.state       ][INFO    ][1594] Completed state [mdb.baremetal-mcp-ocata-odl-ha.local] at time 21:19:27.000440 duration_in_ms=5.853
2017-09-14 21:19:27,001 [salt.state       ][INFO    ][1594] Running state [cfg01.baremetal-mcp-ocata-odl-ha.local] at time 21:19:27.000609
2017-09-14 21:19:27,001 [salt.state       ][INFO    ][1594] Executing state host.present for cfg01.baremetal-mcp-ocata-odl-ha.local
2017-09-14 21:19:27,007 [salt.state       ][INFO    ][1594] {'host': 'cfg01.baremetal-mcp-ocata-odl-ha.local'}
2017-09-14 21:19:27,007 [salt.state       ][INFO    ][1594] Completed state [cfg01.baremetal-mcp-ocata-odl-ha.local] at time 21:19:27.006717 duration_in_ms=6.108
2017-09-14 21:19:27,007 [salt.state       ][INFO    ][1594] Running state [cfg01] at time 21:19:27.006902
2017-09-14 21:19:27,007 [salt.state       ][INFO    ][1594] Executing state host.present for cfg01
2017-09-14 21:19:27,012 [salt.state       ][INFO    ][1594] {'host': 'cfg01'}
2017-09-14 21:19:27,012 [salt.state       ][INFO    ][1594] Completed state [cfg01] at time 21:19:27.012430 duration_in_ms=5.529
2017-09-14 21:19:27,013 [salt.state       ][INFO    ][1594] Running state [prx01] at time 21:19:27.012578
2017-09-14 21:19:27,013 [salt.state       ][INFO    ][1594] Executing state host.present for prx01
2017-09-14 21:19:27,027 [salt.state       ][INFO    ][1594] {'host': 'prx01'}
2017-09-14 21:19:27,028 [salt.state       ][INFO    ][1594] Completed state [prx01] at time 21:19:27.027510 duration_in_ms=14.932
2017-09-14 21:19:27,028 [salt.state       ][INFO    ][1594] Running state [prx01.baremetal-mcp-ocata-odl-ha.local] at time 21:19:27.027654
2017-09-14 21:19:27,028 [salt.state       ][INFO    ][1594] Executing state host.present for prx01.baremetal-mcp-ocata-odl-ha.local
2017-09-14 21:19:27,033 [salt.state       ][INFO    ][1594] {'host': 'prx01.baremetal-mcp-ocata-odl-ha.local'}
2017-09-14 21:19:27,033 [salt.state       ][INFO    ][1594] Completed state [prx01.baremetal-mcp-ocata-odl-ha.local] at time 21:19:27.033225 duration_in_ms=5.57
2017-09-14 21:19:27,033 [salt.state       ][INFO    ][1594] Running state [kvm01.baremetal-mcp-ocata-odl-ha.local] at time 21:19:27.033371
2017-09-14 21:19:27,034 [salt.state       ][INFO    ][1594] Executing state host.present for kvm01.baremetal-mcp-ocata-odl-ha.local
2017-09-14 21:19:27,039 [salt.state       ][INFO    ][1594] {'host': 'kvm01.baremetal-mcp-ocata-odl-ha.local'}
2017-09-14 21:19:27,039 [salt.state       ][INFO    ][1594] Completed state [kvm01.baremetal-mcp-ocata-odl-ha.local] at time 21:19:27.039228 duration_in_ms=5.856
2017-09-14 21:19:27,039 [salt.state       ][INFO    ][1594] Running state [kvm01] at time 21:19:27.039383
2017-09-14 21:19:27,040 [salt.state       ][INFO    ][1594] Executing state host.present for kvm01
2017-09-14 21:19:27,045 [salt.state       ][INFO    ][1594] {'host': 'kvm01'}
2017-09-14 21:19:27,045 [salt.state       ][INFO    ][1594] Completed state [kvm01] at time 21:19:27.045206 duration_in_ms=5.824
2017-09-14 21:19:27,045 [salt.state       ][INFO    ][1594] Running state [kvm03.baremetal-mcp-ocata-odl-ha.local] at time 21:19:27.045354
2017-09-14 21:19:27,046 [salt.state       ][INFO    ][1594] Executing state host.present for kvm03.baremetal-mcp-ocata-odl-ha.local
2017-09-14 21:19:27,051 [salt.state       ][INFO    ][1594] {'host': 'kvm03.baremetal-mcp-ocata-odl-ha.local'}
2017-09-14 21:19:27,051 [salt.state       ][INFO    ][1594] Completed state [kvm03.baremetal-mcp-ocata-odl-ha.local] at time 21:19:27.051458 duration_in_ms=6.103
2017-09-14 21:19:27,052 [salt.state       ][INFO    ][1594] Running state [kvm03] at time 21:19:27.051615
2017-09-14 21:19:27,052 [salt.state       ][INFO    ][1594] Executing state host.present for kvm03
2017-09-14 21:19:27,057 [salt.state       ][INFO    ][1594] {'host': 'kvm03'}
2017-09-14 21:19:27,057 [salt.state       ][INFO    ][1594] Completed state [kvm03] at time 21:19:27.057298 duration_in_ms=5.684
2017-09-14 21:19:27,057 [salt.state       ][INFO    ][1594] Running state [kvm02.baremetal-mcp-ocata-odl-ha.local] at time 21:19:27.057446
2017-09-14 21:19:27,058 [salt.state       ][INFO    ][1594] Executing state host.present for kvm02.baremetal-mcp-ocata-odl-ha.local
2017-09-14 21:19:27,063 [salt.state       ][INFO    ][1594] {'host': 'kvm02.baremetal-mcp-ocata-odl-ha.local'}
2017-09-14 21:19:27,063 [salt.state       ][INFO    ][1594] Completed state [kvm02.baremetal-mcp-ocata-odl-ha.local] at time 21:19:27.063377 duration_in_ms=5.93
2017-09-14 21:19:27,064 [salt.state       ][INFO    ][1594] Running state [kvm02] at time 21:19:27.063526
2017-09-14 21:19:27,064 [salt.state       ][INFO    ][1594] Executing state host.present for kvm02
2017-09-14 21:19:27,153 [salt.state       ][INFO    ][1594] {'host': 'kvm02'}
2017-09-14 21:19:27,153 [salt.state       ][INFO    ][1594] Completed state [kvm02] at time 21:19:27.153199 duration_in_ms=89.672
2017-09-14 21:19:27,153 [salt.state       ][INFO    ][1594] Running state [dbs] at time 21:19:27.153410
2017-09-14 21:19:27,154 [salt.state       ][INFO    ][1594] Executing state host.present for dbs
2017-09-14 21:19:27,159 [salt.state       ][INFO    ][1594] {'host': 'dbs'}
2017-09-14 21:19:27,159 [salt.state       ][INFO    ][1594] Completed state [dbs] at time 21:19:27.159111 duration_in_ms=5.701
2017-09-14 21:19:27,159 [salt.state       ][INFO    ][1594] Running state [dbs.baremetal-mcp-ocata-odl-ha.local] at time 21:19:27.159283
2017-09-14 21:19:27,159 [salt.state       ][INFO    ][1594] Executing state host.present for dbs.baremetal-mcp-ocata-odl-ha.local
2017-09-14 21:19:27,165 [salt.state       ][INFO    ][1594] {'host': 'dbs.baremetal-mcp-ocata-odl-ha.local'}
2017-09-14 21:19:27,165 [salt.state       ][INFO    ][1594] Completed state [dbs.baremetal-mcp-ocata-odl-ha.local] at time 21:19:27.165091 duration_in_ms=5.809
2017-09-14 21:19:27,165 [salt.state       ][INFO    ][1594] Running state [prx.baremetal-mcp-ocata-odl-ha.local] at time 21:19:27.165318
2017-09-14 21:19:27,165 [salt.state       ][INFO    ][1594] Executing state host.present for prx.baremetal-mcp-ocata-odl-ha.local
2017-09-14 21:19:27,171 [salt.state       ][INFO    ][1594] {'host': 'prx.baremetal-mcp-ocata-odl-ha.local'}
2017-09-14 21:19:27,171 [salt.state       ][INFO    ][1594] Completed state [prx.baremetal-mcp-ocata-odl-ha.local] at time 21:19:27.171110 duration_in_ms=5.791
2017-09-14 21:19:27,171 [salt.state       ][INFO    ][1594] Running state [prx] at time 21:19:27.171268
2017-09-14 21:19:27,171 [salt.state       ][INFO    ][1594] Executing state host.present for prx
2017-09-14 21:19:27,177 [salt.state       ][INFO    ][1594] {'host': 'prx'}
2017-09-14 21:19:27,177 [salt.state       ][INFO    ][1594] Completed state [prx] at time 21:19:27.177206 duration_in_ms=5.938
2017-09-14 21:19:27,177 [salt.state       ][INFO    ][1594] Running state [prx02] at time 21:19:27.177377
2017-09-14 21:19:27,178 [salt.state       ][INFO    ][1594] Executing state host.present for prx02
2017-09-14 21:19:27,183 [salt.state       ][INFO    ][1594] {'host': 'prx02'}
2017-09-14 21:19:27,183 [salt.state       ][INFO    ][1594] Completed state [prx02] at time 21:19:27.183405 duration_in_ms=6.027
2017-09-14 21:19:27,184 [salt.state       ][INFO    ][1594] Running state [prx02.baremetal-mcp-ocata-odl-ha.local] at time 21:19:27.183564
2017-09-14 21:19:27,184 [salt.state       ][INFO    ][1594] Executing state host.present for prx02.baremetal-mcp-ocata-odl-ha.local
2017-09-14 21:19:27,189 [salt.state       ][INFO    ][1594] {'host': 'prx02.baremetal-mcp-ocata-odl-ha.local'}
2017-09-14 21:19:27,189 [salt.state       ][INFO    ][1594] Completed state [prx02.baremetal-mcp-ocata-odl-ha.local] at time 21:19:27.189238 duration_in_ms=5.673
2017-09-14 21:19:27,189 [salt.state       ][INFO    ][1594] Running state [msg02.baremetal-mcp-ocata-odl-ha.local] at time 21:19:27.189406
2017-09-14 21:19:27,190 [salt.state       ][INFO    ][1594] Executing state host.present for msg02.baremetal-mcp-ocata-odl-ha.local
2017-09-14 21:19:27,195 [salt.state       ][INFO    ][1594] {'host': 'msg02.baremetal-mcp-ocata-odl-ha.local'}
2017-09-14 21:19:27,195 [salt.state       ][INFO    ][1594] Completed state [msg02.baremetal-mcp-ocata-odl-ha.local] at time 21:19:27.195163 duration_in_ms=5.757
2017-09-14 21:19:27,195 [salt.state       ][INFO    ][1594] Running state [msg02] at time 21:19:27.195325
2017-09-14 21:19:27,195 [salt.state       ][INFO    ][1594] Executing state host.present for msg02
2017-09-14 21:19:27,201 [salt.state       ][INFO    ][1594] {'host': 'msg02'}
2017-09-14 21:19:27,201 [salt.state       ][INFO    ][1594] Completed state [msg02] at time 21:19:27.201339 duration_in_ms=6.015
2017-09-14 21:19:27,202 [salt.state       ][INFO    ][1594] Running state [msg03.baremetal-mcp-ocata-odl-ha.local] at time 21:19:27.201507
2017-09-14 21:19:27,202 [salt.state       ][INFO    ][1594] Executing state host.present for msg03.baremetal-mcp-ocata-odl-ha.local
2017-09-14 21:19:27,210 [salt.state       ][INFO    ][1594] {'host': 'msg03.baremetal-mcp-ocata-odl-ha.local'}
2017-09-14 21:19:27,210 [salt.state       ][INFO    ][1594] Completed state [msg03.baremetal-mcp-ocata-odl-ha.local] at time 21:19:27.210439 duration_in_ms=8.932
2017-09-14 21:19:27,211 [salt.state       ][INFO    ][1594] Running state [msg03] at time 21:19:27.210623
2017-09-14 21:19:27,211 [salt.state       ][INFO    ][1594] Executing state host.present for msg03
2017-09-14 21:19:27,216 [salt.state       ][INFO    ][1594] {'host': 'msg03'}
2017-09-14 21:19:27,216 [salt.state       ][INFO    ][1594] Completed state [msg03] at time 21:19:27.216350 duration_in_ms=5.728
2017-09-14 21:19:27,217 [salt.state       ][INFO    ][1594] Running state [msg01.baremetal-mcp-ocata-odl-ha.local] at time 21:19:27.216528
2017-09-14 21:19:27,217 [salt.state       ][INFO    ][1594] Executing state host.present for msg01.baremetal-mcp-ocata-odl-ha.local
2017-09-14 21:19:27,222 [salt.state       ][INFO    ][1594] {'host': 'msg01.baremetal-mcp-ocata-odl-ha.local'}
2017-09-14 21:19:27,222 [salt.state       ][INFO    ][1594] Completed state [msg01.baremetal-mcp-ocata-odl-ha.local] at time 21:19:27.222331 duration_in_ms=5.803
2017-09-14 21:19:27,223 [salt.state       ][INFO    ][1594] Running state [msg01] at time 21:19:27.222543
2017-09-14 21:19:27,223 [salt.state       ][INFO    ][1594] Executing state host.present for msg01
2017-09-14 21:19:27,228 [salt.state       ][INFO    ][1594] {'host': 'msg01'}
2017-09-14 21:19:27,228 [salt.state       ][INFO    ][1594] Completed state [msg01] at time 21:19:27.228133 duration_in_ms=5.59
2017-09-14 21:19:27,228 [salt.state       ][INFO    ][1594] Running state [msg] at time 21:19:27.228315
2017-09-14 21:19:27,228 [salt.state       ][INFO    ][1594] Executing state host.present for msg
2017-09-14 21:19:27,486 [salt.state       ][INFO    ][1594] {'host': 'msg'}
2017-09-14 21:19:27,486 [salt.state       ][INFO    ][1594] Completed state [msg] at time 21:19:27.485896 duration_in_ms=257.58
2017-09-14 21:19:27,486 [salt.state       ][INFO    ][1594] Running state [msg.baremetal-mcp-ocata-odl-ha.local] at time 21:19:27.486090
2017-09-14 21:19:27,486 [salt.state       ][INFO    ][1594] Executing state host.present for msg.baremetal-mcp-ocata-odl-ha.local
2017-09-14 21:19:27,491 [salt.state       ][INFO    ][1594] {'host': 'msg.baremetal-mcp-ocata-odl-ha.local'}
2017-09-14 21:19:27,492 [salt.state       ][INFO    ][1594] Completed state [msg.baremetal-mcp-ocata-odl-ha.local] at time 21:19:27.491584 duration_in_ms=5.495
2017-09-14 21:19:27,492 [salt.state       ][INFO    ][1594] Running state [cfg01.baremetal-mcp-ocata-odl-ha.local] at time 21:19:27.491753
2017-09-14 21:19:27,492 [salt.state       ][INFO    ][1594] Executing state host.present for cfg01.baremetal-mcp-ocata-odl-ha.local
2017-09-14 21:19:27,492 [salt.state       ][INFO    ][1594] Host cfg01.baremetal-mcp-ocata-odl-ha.local (10.167.4.100) already present
2017-09-14 21:19:27,492 [salt.state       ][INFO    ][1594] Completed state [cfg01.baremetal-mcp-ocata-odl-ha.local] at time 21:19:27.492312 duration_in_ms=0.558
2017-09-14 21:19:27,492 [salt.state       ][INFO    ][1594] Running state [cfg01] at time 21:19:27.492461
2017-09-14 21:19:27,493 [salt.state       ][INFO    ][1594] Executing state host.present for cfg01
2017-09-14 21:19:27,493 [salt.state       ][INFO    ][1594] Host cfg01 (10.167.4.100) already present
2017-09-14 21:19:27,493 [salt.state       ][INFO    ][1594] Completed state [cfg01] at time 21:19:27.493007 duration_in_ms=0.546
2017-09-14 21:19:27,493 [salt.state       ][INFO    ][1594] Running state [cmp002] at time 21:19:27.493192
2017-09-14 21:19:27,493 [salt.state       ][INFO    ][1594] Executing state host.present for cmp002
2017-09-14 21:19:27,497 [salt.state       ][INFO    ][1594] {'host': 'cmp002'}
2017-09-14 21:19:27,498 [salt.state       ][INFO    ][1594] Completed state [cmp002] at time 21:19:27.497585 duration_in_ms=4.393
2017-09-14 21:19:27,498 [salt.state       ][INFO    ][1594] Running state [cmp002.baremetal-mcp-ocata-odl-ha.local] at time 21:19:27.497733
2017-09-14 21:19:27,498 [salt.state       ][INFO    ][1594] Executing state host.present for cmp002.baremetal-mcp-ocata-odl-ha.local
2017-09-14 21:19:27,504 [salt.state       ][INFO    ][1594] {'host': 'cmp002.baremetal-mcp-ocata-odl-ha.local'}
2017-09-14 21:19:27,504 [salt.state       ][INFO    ][1594] Completed state [cmp002.baremetal-mcp-ocata-odl-ha.local] at time 21:19:27.503794 duration_in_ms=6.06
2017-09-14 21:19:27,504 [salt.state       ][INFO    ][1594] Running state [cmp001] at time 21:19:27.503942
2017-09-14 21:19:27,504 [salt.state       ][INFO    ][1594] Executing state host.present for cmp001
2017-09-14 21:19:27,509 [salt.state       ][INFO    ][1594] {'host': 'cmp001'}
2017-09-14 21:19:27,510 [salt.state       ][INFO    ][1594] Completed state [cmp001] at time 21:19:27.509610 duration_in_ms=5.668
2017-09-14 21:19:27,510 [salt.state       ][INFO    ][1594] Running state [cmp001.baremetal-mcp-ocata-odl-ha.local] at time 21:19:27.509758
2017-09-14 21:19:27,510 [salt.state       ][INFO    ][1594] Executing state host.present for cmp001.baremetal-mcp-ocata-odl-ha.local
2017-09-14 21:19:27,515 [salt.state       ][INFO    ][1594] {'host': 'cmp001.baremetal-mcp-ocata-odl-ha.local'}
2017-09-14 21:19:27,516 [salt.state       ][INFO    ][1594] Completed state [cmp001.baremetal-mcp-ocata-odl-ha.local] at time 21:19:27.515615 duration_in_ms=5.857
2017-09-14 21:19:27,516 [salt.state       ][INFO    ][1594] Running state [dbs01.baremetal-mcp-ocata-odl-ha.local] at time 21:19:27.515765
2017-09-14 21:19:27,516 [salt.state       ][INFO    ][1594] Executing state host.present for dbs01.baremetal-mcp-ocata-odl-ha.local
2017-09-14 21:19:27,522 [salt.state       ][INFO    ][1594] {'host': 'dbs01.baremetal-mcp-ocata-odl-ha.local'}
2017-09-14 21:19:27,522 [salt.state       ][INFO    ][1594] Completed state [dbs01.baremetal-mcp-ocata-odl-ha.local] at time 21:19:27.521674 duration_in_ms=5.909
2017-09-14 21:19:27,522 [salt.state       ][INFO    ][1594] Running state [dbs01] at time 21:19:27.521825
2017-09-14 21:19:27,522 [salt.state       ][INFO    ][1594] Executing state host.present for dbs01
2017-09-14 21:19:27,528 [salt.state       ][INFO    ][1594] {'host': 'dbs01'}
2017-09-14 21:19:27,528 [salt.state       ][INFO    ][1594] Completed state [dbs01] at time 21:19:27.527878 duration_in_ms=6.054
2017-09-14 21:19:27,528 [salt.state       ][INFO    ][1594] Running state [dbs02.baremetal-mcp-ocata-odl-ha.local] at time 21:19:27.528032
2017-09-14 21:19:27,528 [salt.state       ][INFO    ][1594] Executing state host.present for dbs02.baremetal-mcp-ocata-odl-ha.local
2017-09-14 21:19:27,534 [salt.state       ][INFO    ][1594] {'host': 'dbs02.baremetal-mcp-ocata-odl-ha.local'}
2017-09-14 21:19:27,534 [salt.state       ][INFO    ][1594] Completed state [dbs02.baremetal-mcp-ocata-odl-ha.local] at time 21:19:27.533854 duration_in_ms=5.822
2017-09-14 21:19:27,534 [salt.state       ][INFO    ][1594] Running state [dbs02] at time 21:19:27.534002
2017-09-14 21:19:27,534 [salt.state       ][INFO    ][1594] Executing state host.present for dbs02
2017-09-14 21:19:27,540 [salt.state       ][INFO    ][1594] {'host': 'dbs02'}
2017-09-14 21:19:27,540 [salt.state       ][INFO    ][1594] Completed state [dbs02] at time 21:19:27.539877 duration_in_ms=5.874
2017-09-14 21:19:27,540 [salt.state       ][INFO    ][1594] Running state [dbs03.baremetal-mcp-ocata-odl-ha.local] at time 21:19:27.540025
2017-09-14 21:19:27,540 [salt.state       ][INFO    ][1594] Executing state host.present for dbs03.baremetal-mcp-ocata-odl-ha.local
2017-09-14 21:19:27,546 [salt.state       ][INFO    ][1594] {'host': 'dbs03.baremetal-mcp-ocata-odl-ha.local'}
2017-09-14 21:19:27,546 [salt.state       ][INFO    ][1594] Completed state [dbs03.baremetal-mcp-ocata-odl-ha.local] at time 21:19:27.545805 duration_in_ms=5.78
2017-09-14 21:19:27,546 [salt.state       ][INFO    ][1594] Running state [dbs03] at time 21:19:27.545956
2017-09-14 21:19:27,546 [salt.state       ][INFO    ][1594] Executing state host.present for dbs03
2017-09-14 21:19:27,552 [salt.state       ][INFO    ][1594] {'host': 'dbs03'}
2017-09-14 21:19:27,552 [salt.state       ][INFO    ][1594] Completed state [dbs03] at time 21:19:27.551702 duration_in_ms=5.746
2017-09-14 21:19:27,552 [salt.state       ][INFO    ][1594] Running state [odl01.baremetal-mcp-ocata-odl-ha.local] at time 21:19:27.551871
2017-09-14 21:19:27,552 [salt.state       ][INFO    ][1594] Executing state host.present for odl01.baremetal-mcp-ocata-odl-ha.local
2017-09-14 21:19:27,561 [salt.state       ][INFO    ][1594] {'host': 'odl01.baremetal-mcp-ocata-odl-ha.local'}
2017-09-14 21:19:27,561 [salt.state       ][INFO    ][1594] Completed state [odl01.baremetal-mcp-ocata-odl-ha.local] at time 21:19:27.560778 duration_in_ms=8.908
2017-09-14 21:19:27,561 [salt.state       ][INFO    ][1594] Running state [odl01] at time 21:19:27.560928
2017-09-14 21:19:27,561 [salt.state       ][INFO    ][1594] Executing state host.present for odl01
2017-09-14 21:19:27,566 [salt.state       ][INFO    ][1594] {'host': 'odl01'}
2017-09-14 21:19:27,567 [salt.state       ][INFO    ][1594] Completed state [odl01] at time 21:19:27.566511 duration_in_ms=5.583
2017-09-14 21:19:27,567 [salt.state       ][INFO    ][1594] Running state [mas01.baremetal-mcp-ocata-odl-ha.local] at time 21:19:27.566663
2017-09-14 21:19:27,567 [salt.state       ][INFO    ][1594] Executing state host.present for mas01.baremetal-mcp-ocata-odl-ha.local
2017-09-14 21:19:27,573 [salt.state       ][INFO    ][1594] {'host': 'mas01.baremetal-mcp-ocata-odl-ha.local'}
2017-09-14 21:19:27,573 [salt.state       ][INFO    ][1594] Completed state [mas01.baremetal-mcp-ocata-odl-ha.local] at time 21:19:27.572670 duration_in_ms=6.007
2017-09-14 21:19:27,573 [salt.state       ][INFO    ][1594] Running state [mas01] at time 21:19:27.572819
2017-09-14 21:19:27,573 [salt.state       ][INFO    ][1594] Executing state host.present for mas01
2017-09-14 21:19:27,578 [salt.state       ][INFO    ][1594] {'host': 'mas01'}
2017-09-14 21:19:27,579 [salt.state       ][INFO    ][1594] Completed state [mas01] at time 21:19:27.578510 duration_in_ms=5.69
2017-09-14 21:19:27,579 [salt.state       ][INFO    ][1594] Running state [ctl02.baremetal-mcp-ocata-odl-ha.local] at time 21:19:27.578664
2017-09-14 21:19:27,579 [salt.state       ][INFO    ][1594] Executing state host.present for ctl02.baremetal-mcp-ocata-odl-ha.local
2017-09-14 21:19:27,585 [salt.state       ][INFO    ][1594] {'host': 'ctl02.baremetal-mcp-ocata-odl-ha.local'}
2017-09-14 21:19:27,585 [salt.state       ][INFO    ][1594] Completed state [ctl02.baremetal-mcp-ocata-odl-ha.local] at time 21:19:27.584707 duration_in_ms=6.044
2017-09-14 21:19:27,585 [salt.state       ][INFO    ][1594] Running state [ctl02] at time 21:19:27.584860
2017-09-14 21:19:27,585 [salt.state       ][INFO    ][1594] Executing state host.present for ctl02
2017-09-14 21:19:27,842 [salt.state       ][INFO    ][1594] {'host': 'ctl02'}
2017-09-14 21:19:27,842 [salt.state       ][INFO    ][1594] Completed state [ctl02] at time 21:19:27.842258 duration_in_ms=257.398
2017-09-14 21:19:27,842 [salt.state       ][INFO    ][1594] Running state [ctl03.baremetal-mcp-ocata-odl-ha.local] at time 21:19:27.842452
2017-09-14 21:19:27,843 [salt.state       ][INFO    ][1594] Executing state host.present for ctl03.baremetal-mcp-ocata-odl-ha.local
2017-09-14 21:19:27,848 [salt.state       ][INFO    ][1594] {'host': 'ctl03.baremetal-mcp-ocata-odl-ha.local'}
2017-09-14 21:19:27,848 [salt.state       ][INFO    ][1594] Completed state [ctl03.baremetal-mcp-ocata-odl-ha.local] at time 21:19:27.847967 duration_in_ms=5.525
2017-09-14 21:19:27,848 [salt.state       ][INFO    ][1594] Running state [ctl03] at time 21:19:27.848113
2017-09-14 21:19:27,848 [salt.state       ][INFO    ][1594] Executing state host.present for ctl03
2017-09-14 21:19:27,854 [salt.state       ][INFO    ][1594] {'host': 'ctl03'}
2017-09-14 21:19:27,854 [salt.state       ][INFO    ][1594] Completed state [ctl03] at time 21:19:27.853962 duration_in_ms=5.849
2017-09-14 21:19:27,854 [salt.state       ][INFO    ][1594] Running state [ctl01.baremetal-mcp-ocata-odl-ha.local] at time 21:19:27.854106
2017-09-14 21:19:27,854 [salt.state       ][INFO    ][1594] Executing state host.present for ctl01.baremetal-mcp-ocata-odl-ha.local
2017-09-14 21:19:27,860 [salt.state       ][INFO    ][1594] {'host': 'ctl01.baremetal-mcp-ocata-odl-ha.local'}
2017-09-14 21:19:27,860 [salt.state       ][INFO    ][1594] Completed state [ctl01.baremetal-mcp-ocata-odl-ha.local] at time 21:19:27.859975 duration_in_ms=5.869
2017-09-14 21:19:27,860 [salt.state       ][INFO    ][1594] Running state [ctl01] at time 21:19:27.860119
2017-09-14 21:19:27,860 [salt.state       ][INFO    ][1594] Executing state host.present for ctl01
2017-09-14 21:19:27,866 [salt.state       ][INFO    ][1594] {'host': 'ctl01'}
2017-09-14 21:19:27,866 [salt.state       ][INFO    ][1594] Completed state [ctl01] at time 21:19:27.865989 duration_in_ms=5.869
2017-09-14 21:19:27,866 [salt.state       ][INFO    ][1594] Running state [ctl] at time 21:19:27.866131
2017-09-14 21:19:27,866 [salt.state       ][INFO    ][1594] Executing state host.present for ctl
2017-09-14 21:19:27,872 [salt.state       ][INFO    ][1594] {'host': 'ctl'}
2017-09-14 21:19:27,872 [salt.state       ][INFO    ][1594] Completed state [ctl] at time 21:19:27.871990 duration_in_ms=5.859
2017-09-14 21:19:27,872 [salt.state       ][INFO    ][1594] Running state [ctl.baremetal-mcp-ocata-odl-ha.local] at time 21:19:27.872130
2017-09-14 21:19:27,872 [salt.state       ][INFO    ][1594] Executing state host.present for ctl.baremetal-mcp-ocata-odl-ha.local
2017-09-14 21:19:27,878 [salt.state       ][INFO    ][1594] {'host': 'ctl.baremetal-mcp-ocata-odl-ha.local'}
2017-09-14 21:19:27,878 [salt.state       ][INFO    ][1594] Completed state [ctl.baremetal-mcp-ocata-odl-ha.local] at time 21:19:27.878005 duration_in_ms=5.874
2017-09-14 21:19:27,880 [salt.state       ][INFO    ][1594] Running state [ens3] at time 21:19:27.880313
2017-09-14 21:19:27,880 [salt.state       ][INFO    ][1594] Executing state network.managed for ens3
2017-09-14 21:19:27,954 [salt.loaded.int.module.cmdmod][INFO    ][1594] Executing command ['ifdown', 'ens3'] in directory '/root'
2017-09-14 21:19:28,338 [salt.loaded.int.module.cmdmod][INFO    ][1594] Executing command ['ifup', 'ens3'] in directory '/root'
2017-09-14 21:19:28,631 [salt.state       ][INFO    ][1594] {'interface': u'--- \n+++ \n@@ -1,3 +1,5 @@\n auto ens3\n\n-iface ens3 inet dhcp\n\n+iface ens3 inet static\n\n+    address 10.167.4.111\n\n+    netmask 255.255.255.0\n\n \n', 'status': 'Interface ens3 restart to validate'}
2017-09-14 21:19:28,631 [salt.state       ][INFO    ][1594] Completed state [ens3] at time 21:19:28.631360 duration_in_ms=751.046
2017-09-14 21:19:28,632 [salt.state       ][INFO    ][1594] Running state [/etc/profile.d/proxy.sh] at time 21:19:28.631637
2017-09-14 21:19:28,632 [salt.state       ][INFO    ][1594] Executing state file.absent for /etc/profile.d/proxy.sh
2017-09-14 21:19:28,632 [salt.state       ][INFO    ][1594] File /etc/profile.d/proxy.sh is not present
2017-09-14 21:19:28,632 [salt.state       ][INFO    ][1594] Completed state [/etc/profile.d/proxy.sh] at time 21:19:28.632429 duration_in_ms=0.792
2017-09-14 21:19:28,633 [salt.state       ][INFO    ][1594] Running state [/etc/apt/apt.conf.d/95proxies] at time 21:19:28.632623
2017-09-14 21:19:28,633 [salt.state       ][INFO    ][1594] Executing state file.absent for /etc/apt/apt.conf.d/95proxies
2017-09-14 21:19:28,633 [salt.state       ][INFO    ][1594] File /etc/apt/apt.conf.d/95proxies is not present
2017-09-14 21:19:28,633 [salt.state       ][INFO    ][1594] Completed state [/etc/apt/apt.conf.d/95proxies] at time 21:19:28.633213 duration_in_ms=0.59
2017-09-14 21:19:28,639 [salt.state       ][INFO    ][1594] Running state [ntp] at time 21:19:28.638568
2017-09-14 21:19:28,639 [salt.state       ][INFO    ][1594] Executing state pkg.installed for ntp
2017-09-14 21:19:28,820 [salt.loaded.int.module.cmdmod][INFO    ][1594] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'ntp'] in directory '/root'
2017-09-14 21:19:35,237 [salt.minion      ][INFO    ][1503] User sudo_ubuntu Executing command saltutil.find_job with jid 20170914211935223036
2017-09-14 21:19:35,257 [salt.minion      ][INFO    ][8611] Starting a new job with PID 8611
2017-09-14 21:19:35,269 [salt.minion      ][INFO    ][8611] Returning information for job: 20170914211935223036
2017-09-14 21:19:45,303 [salt.minion      ][INFO    ][1503] User sudo_ubuntu Executing command saltutil.find_job with jid 20170914211945290325
2017-09-14 21:19:45,318 [salt.minion      ][INFO    ][8661] Starting a new job with PID 8661
2017-09-14 21:19:45,332 [salt.minion      ][INFO    ][8661] Returning information for job: 20170914211945290325
2017-09-14 21:19:54,919 [salt.loaded.int.module.cmdmod][INFO    ][1594] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-14 21:19:54,938 [salt.state       ][INFO    ][1594] Made the following changes:
'ntp' changed from 'absent' to '1:4.2.8p4+dfsg-3ubuntu5.6'
'libopts25' changed from 'absent' to '1:5.18.7-3'

2017-09-14 21:19:54,946 [salt.state       ][INFO    ][1594] Loading fresh modules for state activity
2017-09-14 21:19:54,958 [salt.state       ][INFO    ][1594] Completed state [ntp] at time 21:19:54.958204 duration_in_ms=26319.635
2017-09-14 21:19:54,961 [salt.state       ][INFO    ][1594] Running state [/etc/ntp.conf] at time 21:19:54.960656
2017-09-14 21:19:54,961 [salt.state       ][INFO    ][1594] Executing state file.managed for /etc/ntp.conf
2017-09-14 21:19:54,987 [salt.fileclient  ][INFO    ][1594] Fetching file from saltenv 'base', ** done ** 'ntp/files/ntp.conf'
2017-09-14 21:19:55,010 [salt.fileclient  ][INFO    ][1594] Fetching file from saltenv 'base', ** done ** 'ntp/map.jinja'
2017-09-14 21:19:55,020 [salt.state       ][INFO    ][1594] 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
2017-09-14 21:19:55,022 [salt.state       ][INFO    ][1594] Completed state [/etc/ntp.conf] at time 21:19:55.021560 duration_in_ms=60.904
2017-09-14 21:19:55,082 [salt.state       ][INFO    ][1594] Running state [ntp] at time 21:19:55.081610
2017-09-14 21:19:55,082 [salt.state       ][INFO    ][1594] Executing state service.running for ntp
2017-09-14 21:19:55,083 [salt.loaded.int.module.cmdmod][INFO    ][1594] Executing command ['systemctl', 'status', 'ntp.service', '-n', '0'] in directory '/root'
2017-09-14 21:19:55,093 [salt.loaded.int.module.cmdmod][INFO    ][1594] Executing command ['systemctl', 'is-active', 'ntp.service'] in directory '/root'
2017-09-14 21:19:55,102 [salt.loaded.int.module.cmdmod][INFO    ][1594] Executing command ['systemctl', 'is-enabled', 'ntp.service'] in directory '/root'
2017-09-14 21:19:55,112 [salt.state       ][INFO    ][1594] The service ntp is already running
2017-09-14 21:19:55,113 [salt.state       ][INFO    ][1594] Completed state [ntp] at time 21:19:55.112556 duration_in_ms=30.945
2017-09-14 21:19:55,113 [salt.state       ][INFO    ][1594] Running state [ntp] at time 21:19:55.112854
2017-09-14 21:19:55,113 [salt.state       ][INFO    ][1594] Executing state service.mod_watch for ntp
2017-09-14 21:19:55,114 [salt.loaded.int.module.cmdmod][INFO    ][1594] Executing command ['systemctl', 'is-active', 'ntp.service'] in directory '/root'
2017-09-14 21:19:55,122 [salt.loaded.int.module.cmdmod][INFO    ][1594] Executing command ['systemctl', 'is-enabled', 'ntp.service'] in directory '/root'
2017-09-14 21:19:55,132 [salt.loaded.int.module.cmdmod][INFO    ][1594] Executing command ['systemd-run', '--scope', 'systemctl', 'restart', 'ntp.service'] in directory '/root'
2017-09-14 21:19:55,176 [salt.state       ][INFO    ][1594] {'ntp': True}
2017-09-14 21:19:55,176 [salt.state       ][INFO    ][1594] Completed state [ntp] at time 21:19:55.176029 duration_in_ms=63.174
2017-09-14 21:19:55,179 [salt.minion      ][INFO    ][1594] Returning information for job: 20170914211653558483
2017-09-14 21:20:36,933 [salt.minion      ][INFO    ][1503] User sudo_ubuntu Executing command state.apply with jid 20170914212036914919
2017-09-14 21:20:36,964 [salt.minion      ][INFO    ][8884] Starting a new job with PID 8884
2017-09-14 21:20:40,516 [salt.state       ][INFO    ][8884] Loading fresh modules for state activity
2017-09-14 21:20:41,167 [salt.fileclient  ][INFO    ][8884] Fetching file from saltenv 'base', ** done ** 'linux/init.sls'
2017-09-14 21:20:41,354 [salt.fileclient  ][INFO    ][8884] Fetching file from saltenv 'base', ** done ** 'linux/system/init.sls'
2017-09-14 21:20:41,394 [salt.fileclient  ][INFO    ][8884] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-09-14 21:20:41,438 [salt.fileclient  ][INFO    ][8884] Fetching file from saltenv 'base', ** done ** 'linux/system/env.sls'
2017-09-14 21:20:41,459 [salt.fileclient  ][INFO    ][8884] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-09-14 21:20:41,499 [salt.fileclient  ][INFO    ][8884] Fetching file from saltenv 'base', ** done ** 'linux/system/profile.sls'
2017-09-14 21:20:41,520 [salt.fileclient  ][INFO    ][8884] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-09-14 21:20:41,566 [salt.fileclient  ][INFO    ][8884] Fetching file from saltenv 'base', ** done ** 'linux/system/repo.sls'
2017-09-14 21:20:41,626 [salt.fileclient  ][INFO    ][8884] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-09-14 21:20:41,693 [salt.fileclient  ][INFO    ][8884] Fetching file from saltenv 'base', ** done ** 'linux/system/package.sls'
2017-09-14 21:20:41,715 [salt.fileclient  ][INFO    ][8884] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-09-14 21:20:41,752 [salt.fileclient  ][INFO    ][8884] Fetching file from saltenv 'base', ** done ** 'linux/system/timezone.sls'
2017-09-14 21:20:41,767 [salt.fileclient  ][INFO    ][8884] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-09-14 21:20:41,807 [salt.fileclient  ][INFO    ][8884] Fetching file from saltenv 'base', ** done ** 'linux/system/kernel.sls'
2017-09-14 21:20:41,826 [salt.fileclient  ][INFO    ][8884] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-09-14 21:20:41,877 [salt.fileclient  ][INFO    ][8884] Fetching file from saltenv 'base', ** done ** 'linux/system/cpu.sls'
2017-09-14 21:20:41,900 [salt.fileclient  ][INFO    ][8884] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-09-14 21:20:42,055 [salt.fileclient  ][INFO    ][8884] Fetching file from saltenv 'base', ** done ** 'linux/system/sysfs.sls'
2017-09-14 21:20:42,078 [salt.fileclient  ][INFO    ][8884] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-09-14 21:20:42,140 [salt.fileclient  ][INFO    ][8884] Fetching file from saltenv 'base', ** done ** 'linux/system/locale.sls'
2017-09-14 21:20:42,182 [salt.fileclient  ][INFO    ][8884] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-09-14 21:20:42,223 [salt.fileclient  ][INFO    ][8884] Fetching file from saltenv 'base', ** done ** 'linux/system/user.sls'
2017-09-14 21:20:42,256 [salt.fileclient  ][INFO    ][8884] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-09-14 21:20:42,300 [salt.fileclient  ][INFO    ][8884] Fetching file from saltenv 'base', ** done ** 'linux/system/group.sls'
2017-09-14 21:20:42,337 [salt.fileclient  ][INFO    ][8884] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-09-14 21:20:42,376 [salt.fileclient  ][INFO    ][8884] Fetching file from saltenv 'base', ** done ** 'linux/system/limit.sls'
2017-09-14 21:20:42,395 [salt.fileclient  ][INFO    ][8884] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-09-14 21:20:42,437 [salt.fileclient  ][INFO    ][8884] Fetching file from saltenv 'base', ** done ** 'linux/system/systemd.sls'
2017-09-14 21:20:42,475 [salt.fileclient  ][INFO    ][8884] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-09-14 21:20:42,520 [salt.fileclient  ][INFO    ][8884] Fetching file from saltenv 'base', ** done ** 'linux/network/init.sls'
2017-09-14 21:20:42,535 [salt.fileclient  ][INFO    ][8884] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-09-14 21:20:42,573 [salt.fileclient  ][INFO    ][8884] Fetching file from saltenv 'base', ** done ** 'linux/network/hostname.sls'
2017-09-14 21:20:42,586 [salt.fileclient  ][INFO    ][8884] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-09-14 21:20:42,631 [salt.fileclient  ][INFO    ][8884] Fetching file from saltenv 'base', ** done ** 'linux/network/host.sls'
2017-09-14 21:20:42,662 [salt.fileclient  ][INFO    ][8884] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-09-14 21:20:42,737 [salt.fileclient  ][INFO    ][8884] Fetching file from saltenv 'base', ** done ** 'linux/network/interface.sls'
2017-09-14 21:20:42,794 [salt.fileclient  ][INFO    ][8884] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-09-14 21:20:42,835 [salt.fileclient  ][INFO    ][8884] Fetching file from saltenv 'base', ** done ** 'linux/network/proxy.sls'
2017-09-14 21:20:42,848 [salt.fileclient  ][INFO    ][8884] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-09-14 21:20:42,901 [salt.fileclient  ][INFO    ][8884] Fetching file from saltenv 'base', ** done ** 'linux/storage/init.sls'
2017-09-14 21:20:42,924 [salt.fileclient  ][INFO    ][8884] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-09-14 21:20:42,976 [salt.fileclient  ][INFO    ][8884] Fetching file from saltenv 'base', ** done ** 'ntp/init.sls'
2017-09-14 21:20:42,989 [salt.fileclient  ][INFO    ][8884] Fetching file from saltenv 'base', ** done ** 'ntp/client.sls'
2017-09-14 21:20:43,017 [salt.fileclient  ][INFO    ][8884] Fetching file from saltenv 'base', ** done ** 'ntp/map.jinja'
2017-09-14 21:20:43,038 [salt.fileclient  ][INFO    ][8884] Fetching file from saltenv 'base', ** done ** 'ntp/server.sls'
2017-09-14 21:20:43,059 [salt.fileclient  ][INFO    ][8884] Fetching file from saltenv 'base', ** done ** 'ntp/map.jinja'
2017-09-14 21:20:43,073 [salt.state       ][INFO    ][8884] Running state [/etc/environment] at time 21:20:43.073409
2017-09-14 21:20:43,074 [salt.state       ][INFO    ][8884] Executing state file.blockreplace for /etc/environment
2017-09-14 21:20:43,079 [salt.state       ][INFO    ][8884] 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

2017-09-14 21:20:43,080 [salt.state       ][INFO    ][8884] Completed state [/etc/environment] at time 21:20:43.079860 duration_in_ms=6.451
2017-09-14 21:20:43,080 [salt.state       ][INFO    ][8884] Running state [/etc/profile.d] at time 21:20:43.080162
2017-09-14 21:20:43,080 [salt.state       ][INFO    ][8884] Executing state file.directory for /etc/profile.d
2017-09-14 21:20:43,081 [salt.state       ][INFO    ][8884] Directory /etc/profile.d is in the correct state
2017-09-14 21:20:43,081 [salt.state       ][INFO    ][8884] Completed state [/etc/profile.d] at time 21:20:43.081471 duration_in_ms=1.309
2017-09-14 21:20:43,366 [salt.state       ][INFO    ][8884] Running state [linux_repo_prereq_pkgs] at time 21:20:43.366061
2017-09-14 21:20:43,367 [salt.state       ][INFO    ][8884] Executing state pkg.installed for linux_repo_prereq_pkgs
2017-09-14 21:20:43,367 [salt.loaded.int.module.cmdmod][INFO    ][8884] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-14 21:20:43,813 [salt.state       ][INFO    ][8884] All specified packages are already installed
2017-09-14 21:20:43,813 [salt.state       ][INFO    ][8884] Completed state [linux_repo_prereq_pkgs] at time 21:20:43.812977 duration_in_ms=446.915
2017-09-14 21:20:43,813 [salt.state       ][INFO    ][8884] Running state [/etc/apt/apt.conf.d/99proxies-salt-mirantis_openstack_holdback] at time 21:20:43.813303
2017-09-14 21:20:43,814 [salt.state       ][INFO    ][8884] Executing state file.absent for /etc/apt/apt.conf.d/99proxies-salt-mirantis_openstack_holdback
2017-09-14 21:20:43,814 [salt.state       ][INFO    ][8884] File /etc/apt/apt.conf.d/99proxies-salt-mirantis_openstack_holdback is not present
2017-09-14 21:20:43,814 [salt.state       ][INFO    ][8884] Completed state [/etc/apt/apt.conf.d/99proxies-salt-mirantis_openstack_holdback] at time 21:20:43.814246 duration_in_ms=0.943
2017-09-14 21:20:43,815 [salt.state       ][INFO    ][8884] Running state [/etc/apt/preferences.d/mirantis_openstack_holdback] at time 21:20:43.814530
2017-09-14 21:20:43,815 [salt.state       ][INFO    ][8884] Executing state file.managed for /etc/apt/preferences.d/mirantis_openstack_holdback
2017-09-14 21:20:43,837 [salt.fileclient  ][INFO    ][8884] Fetching file from saltenv 'base', ** done ** 'linux/files/preferences_repo'
2017-09-14 21:20:43,854 [salt.fileclient  ][INFO    ][8884] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-09-14 21:20:43,885 [salt.state       ][INFO    ][8884] File /etc/apt/preferences.d/mirantis_openstack_holdback is in the correct state
2017-09-14 21:20:43,886 [salt.state       ][INFO    ][8884] Completed state [/etc/apt/preferences.d/mirantis_openstack_holdback] at time 21:20:43.885510 duration_in_ms=70.979
2017-09-14 21:20:43,888 [salt.state       ][INFO    ][8884] Running state [deb http://mirror.fuel-infra.org/mcp-repos/ocata/xenial ocata-holdback main] at time 21:20:43.887544
2017-09-14 21:20:43,888 [salt.state       ][INFO    ][8884] Executing state pkgrepo.managed for deb http://mirror.fuel-infra.org/mcp-repos/ocata/xenial ocata-holdback main
2017-09-14 21:20:43,999 [salt.loaded.int.module.cmdmod][INFO    ][8884] Executing command ['apt-key', 'add', '/var/cache/salt/minion/extrn_files/base/mirror.fuel-infra.org/mcp-repos/ocata/xenial/archive-mcpocata.key'] in directory '/root'
2017-09-14 21:20:44,077 [salt.loaded.int.module.cmdmod][INFO    ][8884] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-09-14 21:20:46,539 [salt.state       ][INFO    ][8884] Configured package repo 'deb http://mirror.fuel-infra.org/mcp-repos/ocata/xenial ocata-holdback main'
2017-09-14 21:20:46,540 [salt.state       ][INFO    ][8884] Completed state [deb http://mirror.fuel-infra.org/mcp-repos/ocata/xenial ocata-holdback main] at time 21:20:46.539609 duration_in_ms=2652.064
2017-09-14 21:20:46,540 [salt.state       ][INFO    ][8884] Running state [/etc/apt/apt.conf.d/99proxies-salt-uca] at time 21:20:46.539943
2017-09-14 21:20:46,540 [salt.state       ][INFO    ][8884] Executing state file.absent for /etc/apt/apt.conf.d/99proxies-salt-uca
2017-09-14 21:20:46,541 [salt.state       ][INFO    ][8884] File /etc/apt/apt.conf.d/99proxies-salt-uca is not present
2017-09-14 21:20:46,541 [salt.state       ][INFO    ][8884] Completed state [/etc/apt/apt.conf.d/99proxies-salt-uca] at time 21:20:46.540904 duration_in_ms=0.96
2017-09-14 21:20:46,541 [salt.state       ][INFO    ][8884] Running state [/etc/apt/preferences.d/uca] at time 21:20:46.541183
2017-09-14 21:20:46,541 [salt.state       ][INFO    ][8884] Executing state file.absent for /etc/apt/preferences.d/uca
2017-09-14 21:20:46,542 [salt.state       ][INFO    ][8884] File /etc/apt/preferences.d/uca is not present
2017-09-14 21:20:46,542 [salt.state       ][INFO    ][8884] Completed state [/etc/apt/preferences.d/uca] at time 21:20:46.541996 duration_in_ms=0.813
2017-09-14 21:20:46,543 [salt.state       ][INFO    ][8884] Running state [deb http://ubuntu-cloud.archive.canonical.com/ubuntu xenial-updates/ocata main] at time 21:20:46.542851
2017-09-14 21:20:46,543 [salt.state       ][INFO    ][8884] Executing state pkgrepo.managed for deb http://ubuntu-cloud.archive.canonical.com/ubuntu xenial-updates/ocata main
2017-09-14 21:20:46,599 [salt.loaded.int.module.cmdmod][INFO    ][8884] Executing command ['apt-key', 'export', 'EC4926EA'] in directory '/root'
2017-09-14 21:20:46,643 [salt.loaded.int.module.cmdmod][INFO    ][8884] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-09-14 21:20:47,021 [salt.minion      ][INFO    ][1503] User sudo_ubuntu Executing command saltutil.find_job with jid 20170914212047003969
2017-09-14 21:20:47,109 [salt.minion      ][INFO    ][9717] Starting a new job with PID 9717
2017-09-14 21:20:47,119 [salt.minion      ][INFO    ][9717] Returning information for job: 20170914212047003969
2017-09-14 21:20:50,114 [salt.state       ][INFO    ][8884] Configured package repo 'deb http://ubuntu-cloud.archive.canonical.com/ubuntu xenial-updates/ocata main'
2017-09-14 21:20:50,115 [salt.state       ][INFO    ][8884] Completed state [deb http://ubuntu-cloud.archive.canonical.com/ubuntu xenial-updates/ocata main] at time 21:20:50.114936 duration_in_ms=3572.085
2017-09-14 21:20:50,115 [salt.state       ][INFO    ][8884] Running state [/etc/apt/apt.conf.d/99proxies-salt-mirantis_openstack_updates] at time 21:20:50.115270
2017-09-14 21:20:50,116 [salt.state       ][INFO    ][8884] Executing state file.absent for /etc/apt/apt.conf.d/99proxies-salt-mirantis_openstack_updates
2017-09-14 21:20:50,116 [salt.state       ][INFO    ][8884] File /etc/apt/apt.conf.d/99proxies-salt-mirantis_openstack_updates is not present
2017-09-14 21:20:50,116 [salt.state       ][INFO    ][8884] Completed state [/etc/apt/apt.conf.d/99proxies-salt-mirantis_openstack_updates] at time 21:20:50.116226 duration_in_ms=0.956
2017-09-14 21:20:50,117 [salt.state       ][INFO    ][8884] Running state [/etc/apt/preferences.d/mirantis_openstack_updates] at time 21:20:50.116498
2017-09-14 21:20:50,117 [salt.state       ][INFO    ][8884] Executing state file.managed for /etc/apt/preferences.d/mirantis_openstack_updates
2017-09-14 21:20:50,135 [salt.fileclient  ][INFO    ][8884] Fetching file from saltenv 'base', ** done ** 'linux/files/preferences_repo'
2017-09-14 21:20:50,150 [salt.fileclient  ][INFO    ][8884] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-09-14 21:20:50,181 [salt.state       ][INFO    ][8884] File /etc/apt/preferences.d/mirantis_openstack_updates is in the correct state
2017-09-14 21:20:50,182 [salt.state       ][INFO    ][8884] Completed state [/etc/apt/preferences.d/mirantis_openstack_updates] at time 21:20:50.181658 duration_in_ms=65.16
2017-09-14 21:20:50,182 [salt.state       ][INFO    ][8884] Running state [deb http://mirror.fuel-infra.org/mcp-repos/ocata/xenial ocata-updates main] at time 21:20:50.182463
2017-09-14 21:20:50,183 [salt.state       ][INFO    ][8884] Executing state pkgrepo.managed for deb http://mirror.fuel-infra.org/mcp-repos/ocata/xenial ocata-updates main
2017-09-14 21:20:50,246 [salt.loaded.int.module.cmdmod][INFO    ][8884] Executing command ['apt-key', 'add', '/var/cache/salt/minion/extrn_files/base/mirror.fuel-infra.org/mcp-repos/ocata/xenial/archive-mcpocata.key'] in directory '/root'
2017-09-14 21:20:50,320 [salt.loaded.int.module.cmdmod][INFO    ][8884] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-09-14 21:20:52,936 [salt.state       ][INFO    ][8884] Configured package repo 'deb http://mirror.fuel-infra.org/mcp-repos/ocata/xenial ocata-updates main'
2017-09-14 21:20:52,937 [salt.state       ][INFO    ][8884] Completed state [deb http://mirror.fuel-infra.org/mcp-repos/ocata/xenial ocata-updates main] at time 21:20:52.936816 duration_in_ms=2754.353
2017-09-14 21:20:52,937 [salt.state       ][INFO    ][8884] Running state [/etc/apt/apt.conf.d/99proxies-salt-mirantis_openstack_security] at time 21:20:52.937159
2017-09-14 21:20:52,937 [salt.state       ][INFO    ][8884] Executing state file.absent for /etc/apt/apt.conf.d/99proxies-salt-mirantis_openstack_security
2017-09-14 21:20:52,938 [salt.state       ][INFO    ][8884] File /etc/apt/apt.conf.d/99proxies-salt-mirantis_openstack_security is not present
2017-09-14 21:20:52,938 [salt.state       ][INFO    ][8884] Completed state [/etc/apt/apt.conf.d/99proxies-salt-mirantis_openstack_security] at time 21:20:52.938100 duration_in_ms=0.941
2017-09-14 21:20:52,938 [salt.state       ][INFO    ][8884] Running state [/etc/apt/preferences.d/mirantis_openstack_security] at time 21:20:52.938367
2017-09-14 21:20:52,939 [salt.state       ][INFO    ][8884] Executing state file.managed for /etc/apt/preferences.d/mirantis_openstack_security
2017-09-14 21:20:52,955 [salt.fileclient  ][INFO    ][8884] Fetching file from saltenv 'base', ** done ** 'linux/files/preferences_repo'
2017-09-14 21:20:52,976 [salt.fileclient  ][INFO    ][8884] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-09-14 21:20:53,018 [salt.state       ][INFO    ][8884] File /etc/apt/preferences.d/mirantis_openstack_security is in the correct state
2017-09-14 21:20:53,018 [salt.state       ][INFO    ][8884] Completed state [/etc/apt/preferences.d/mirantis_openstack_security] at time 21:20:53.018356 duration_in_ms=79.988
2017-09-14 21:20:53,019 [salt.state       ][INFO    ][8884] Running state [deb http://mirror.fuel-infra.org/mcp-repos/ocata/xenial ocata-security main] at time 21:20:53.019153
2017-09-14 21:20:53,019 [salt.state       ][INFO    ][8884] Executing state pkgrepo.managed for deb http://mirror.fuel-infra.org/mcp-repos/ocata/xenial ocata-security main
2017-09-14 21:20:53,076 [salt.loaded.int.module.cmdmod][INFO    ][8884] Executing command ['apt-key', 'add', '/var/cache/salt/minion/extrn_files/base/mirror.fuel-infra.org/mcp-repos/ocata/xenial/archive-mcpocata.key'] in directory '/root'
2017-09-14 21:20:53,162 [salt.loaded.int.module.cmdmod][INFO    ][8884] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-09-14 21:20:55,117 [salt.state       ][INFO    ][8884] Configured package repo 'deb http://mirror.fuel-infra.org/mcp-repos/ocata/xenial ocata-security main'
2017-09-14 21:20:55,118 [salt.state       ][INFO    ][8884] Completed state [deb http://mirror.fuel-infra.org/mcp-repos/ocata/xenial ocata-security main] at time 21:20:55.117697 duration_in_ms=2098.543
2017-09-14 21:20:55,118 [salt.state       ][INFO    ][8884] Running state [/etc/apt/apt.conf.d/99proxies-salt-mk_openstack] at time 21:20:55.118139
2017-09-14 21:20:55,119 [salt.state       ][INFO    ][8884] Executing state file.absent for /etc/apt/apt.conf.d/99proxies-salt-mk_openstack
2017-09-14 21:20:55,119 [salt.state       ][INFO    ][8884] File /etc/apt/apt.conf.d/99proxies-salt-mk_openstack is not present
2017-09-14 21:20:55,119 [salt.state       ][INFO    ][8884] Completed state [/etc/apt/apt.conf.d/99proxies-salt-mk_openstack] at time 21:20:55.119198 duration_in_ms=1.059
2017-09-14 21:20:55,120 [salt.state       ][INFO    ][8884] Running state [/etc/apt/preferences.d/mk_openstack] at time 21:20:55.119493
2017-09-14 21:20:55,120 [salt.state       ][INFO    ][8884] Executing state file.managed for /etc/apt/preferences.d/mk_openstack
2017-09-14 21:20:55,138 [salt.fileclient  ][INFO    ][8884] Fetching file from saltenv 'base', ** done ** 'linux/files/preferences_repo'
2017-09-14 21:20:55,159 [salt.fileclient  ][INFO    ][8884] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-09-14 21:20:55,190 [salt.state       ][INFO    ][8884] File /etc/apt/preferences.d/mk_openstack is in the correct state
2017-09-14 21:20:55,191 [salt.state       ][INFO    ][8884] Completed state [/etc/apt/preferences.d/mk_openstack] at time 21:20:55.190520 duration_in_ms=71.026
2017-09-14 21:20:55,191 [salt.state       ][INFO    ][8884] Running state [deb [arch=amd64] http://apt-mk.mirantis.com/xenial/ nightly ocata] at time 21:20:55.191366
2017-09-14 21:20:55,192 [salt.state       ][INFO    ][8884] Executing state pkgrepo.managed for deb [arch=amd64] http://apt-mk.mirantis.com/xenial/ nightly ocata
2017-09-14 21:20:55,615 [salt.loaded.int.module.cmdmod][INFO    ][8884] Executing command ['apt-key', 'add', '/var/cache/salt/minion/extrn_files/base/apt-mk.mirantis.com/public.gpg'] in directory '/root'
2017-09-14 21:20:55,702 [salt.loaded.int.module.cmdmod][INFO    ][8884] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-09-14 21:20:57,088 [salt.minion      ][INFO    ][1503] User sudo_ubuntu Executing command saltutil.find_job with jid 20170914212057069317
2017-09-14 21:20:57,110 [salt.minion      ][INFO    ][12089] Starting a new job with PID 12089
2017-09-14 21:20:57,120 [salt.minion      ][INFO    ][12089] Returning information for job: 20170914212057069317
2017-09-14 21:20:58,098 [salt.state       ][INFO    ][8884] Configured package repo 'deb [arch=amd64] http://apt-mk.mirantis.com/xenial/ nightly ocata'
2017-09-14 21:20:58,098 [salt.state       ][INFO    ][8884] Completed state [deb [arch=amd64] http://apt-mk.mirantis.com/xenial/ nightly ocata] at time 21:20:58.098443 duration_in_ms=2907.076
2017-09-14 21:20:58,099 [salt.state       ][INFO    ][8884] Running state [/etc/apt/apt.conf.d/99proxies-salt-mcp_extra] at time 21:20:58.098816
2017-09-14 21:20:58,099 [salt.state       ][INFO    ][8884] Executing state file.absent for /etc/apt/apt.conf.d/99proxies-salt-mcp_extra
2017-09-14 21:20:58,100 [salt.state       ][INFO    ][8884] File /etc/apt/apt.conf.d/99proxies-salt-mcp_extra is not present
2017-09-14 21:20:58,100 [salt.state       ][INFO    ][8884] Completed state [/etc/apt/apt.conf.d/99proxies-salt-mcp_extra] at time 21:20:58.099891 duration_in_ms=1.074
2017-09-14 21:20:58,100 [salt.state       ][INFO    ][8884] Running state [/etc/apt/preferences.d/mcp_extra] at time 21:20:58.100306
2017-09-14 21:20:58,101 [salt.state       ][INFO    ][8884] Executing state file.managed for /etc/apt/preferences.d/mcp_extra
2017-09-14 21:20:58,121 [salt.fileclient  ][INFO    ][8884] Fetching file from saltenv 'base', ** done ** 'linux/files/preferences_repo'
2017-09-14 21:20:58,138 [salt.fileclient  ][INFO    ][8884] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-09-14 21:20:58,169 [salt.state       ][INFO    ][8884] File /etc/apt/preferences.d/mcp_extra is in the correct state
2017-09-14 21:20:58,170 [salt.state       ][INFO    ][8884] Completed state [/etc/apt/preferences.d/mcp_extra] at time 21:20:58.169681 duration_in_ms=69.375
2017-09-14 21:20:58,171 [salt.state       ][INFO    ][8884] Running state [deb [arch=amd64] http://apt-mk.mirantis.com/xenial/ nightly extra] at time 21:20:58.170534
2017-09-14 21:20:58,171 [salt.state       ][INFO    ][8884] Executing state pkgrepo.managed for deb [arch=amd64] http://apt-mk.mirantis.com/xenial/ nightly extra
2017-09-14 21:20:58,227 [salt.loaded.int.module.cmdmod][INFO    ][8884] Executing command ['apt-key', 'add', '/var/cache/salt/minion/extrn_files/base/apt-mk.mirantis.com/public.gpg'] in directory '/root'
2017-09-14 21:20:58,303 [salt.loaded.int.module.cmdmod][INFO    ][8884] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-09-14 21:21:01,003 [salt.state       ][INFO    ][8884] Configured package repo 'deb [arch=amd64] http://apt-mk.mirantis.com/xenial/ nightly extra'
2017-09-14 21:21:01,004 [salt.state       ][INFO    ][8884] Completed state [deb [arch=amd64] http://apt-mk.mirantis.com/xenial/ nightly extra] at time 21:21:01.003500 duration_in_ms=2832.964
2017-09-14 21:21:01,004 [salt.state       ][INFO    ][8884] Running state [/etc/apt/apt.conf.d/99proxies-salt-mirantis_openstack] at time 21:21:01.003709
2017-09-14 21:21:01,004 [salt.state       ][INFO    ][8884] Executing state file.absent for /etc/apt/apt.conf.d/99proxies-salt-mirantis_openstack
2017-09-14 21:21:01,004 [salt.state       ][INFO    ][8884] File /etc/apt/apt.conf.d/99proxies-salt-mirantis_openstack is not present
2017-09-14 21:21:01,004 [salt.state       ][INFO    ][8884] Completed state [/etc/apt/apt.conf.d/99proxies-salt-mirantis_openstack] at time 21:21:01.004337 duration_in_ms=0.628
2017-09-14 21:21:01,005 [salt.state       ][INFO    ][8884] Running state [/etc/apt/preferences.d/mirantis_openstack] at time 21:21:01.004483
2017-09-14 21:21:01,005 [salt.state       ][INFO    ][8884] Executing state file.managed for /etc/apt/preferences.d/mirantis_openstack
2017-09-14 21:21:01,021 [salt.fileclient  ][INFO    ][8884] Fetching file from saltenv 'base', ** done ** 'linux/files/preferences_repo'
2017-09-14 21:21:01,039 [salt.fileclient  ][INFO    ][8884] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-09-14 21:21:01,068 [salt.state       ][INFO    ][8884] File /etc/apt/preferences.d/mirantis_openstack is in the correct state
2017-09-14 21:21:01,068 [salt.state       ][INFO    ][8884] Completed state [/etc/apt/preferences.d/mirantis_openstack] at time 21:21:01.068064 duration_in_ms=63.581
2017-09-14 21:21:01,069 [salt.state       ][INFO    ][8884] Running state [deb http://mirror.fuel-infra.org/mcp-repos/ocata/xenial ocata main] at time 21:21:01.068736
2017-09-14 21:21:01,069 [salt.state       ][INFO    ][8884] Executing state pkgrepo.managed for deb http://mirror.fuel-infra.org/mcp-repos/ocata/xenial ocata main
2017-09-14 21:21:01,189 [salt.loaded.int.module.cmdmod][INFO    ][8884] Executing command ['apt-key', 'add', '/var/cache/salt/minion/extrn_files/base/mirror.fuel-infra.org/mcp-repos/ocata/xenial/archive-mcpocata.key'] in directory '/root'
2017-09-14 21:21:01,265 [salt.loaded.int.module.cmdmod][INFO    ][8884] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-09-14 21:21:03,309 [salt.state       ][INFO    ][8884] Configured package repo 'deb http://mirror.fuel-infra.org/mcp-repos/ocata/xenial ocata main'
2017-09-14 21:21:03,309 [salt.state       ][INFO    ][8884] Completed state [deb http://mirror.fuel-infra.org/mcp-repos/ocata/xenial ocata main] at time 21:21:03.309316 duration_in_ms=2240.58
2017-09-14 21:21:03,310 [salt.state       ][INFO    ][8884] Running state [/etc/apt/apt.conf.d/99proxies-salt-mirantis_openstack_hotfix] at time 21:21:03.309655
2017-09-14 21:21:03,310 [salt.state       ][INFO    ][8884] Executing state file.absent for /etc/apt/apt.conf.d/99proxies-salt-mirantis_openstack_hotfix
2017-09-14 21:21:03,310 [salt.state       ][INFO    ][8884] File /etc/apt/apt.conf.d/99proxies-salt-mirantis_openstack_hotfix is not present
2017-09-14 21:21:03,311 [salt.state       ][INFO    ][8884] Completed state [/etc/apt/apt.conf.d/99proxies-salt-mirantis_openstack_hotfix] at time 21:21:03.310696 duration_in_ms=1.041
2017-09-14 21:21:03,311 [salt.state       ][INFO    ][8884] Running state [/etc/apt/preferences.d/mirantis_openstack_hotfix] at time 21:21:03.310971
2017-09-14 21:21:03,311 [salt.state       ][INFO    ][8884] Executing state file.managed for /etc/apt/preferences.d/mirantis_openstack_hotfix
2017-09-14 21:21:03,329 [salt.fileclient  ][INFO    ][8884] Fetching file from saltenv 'base', ** done ** 'linux/files/preferences_repo'
2017-09-14 21:21:03,347 [salt.fileclient  ][INFO    ][8884] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-09-14 21:21:03,398 [salt.state       ][INFO    ][8884] File /etc/apt/preferences.d/mirantis_openstack_hotfix is in the correct state
2017-09-14 21:21:03,398 [salt.state       ][INFO    ][8884] Completed state [/etc/apt/preferences.d/mirantis_openstack_hotfix] at time 21:21:03.398182 duration_in_ms=87.211
2017-09-14 21:21:03,399 [salt.state       ][INFO    ][8884] Running state [deb http://mirror.fuel-infra.org/mcp-repos/ocata/xenial ocata-hotfix main] at time 21:21:03.398992
2017-09-14 21:21:03,399 [salt.state       ][INFO    ][8884] Executing state pkgrepo.managed for deb http://mirror.fuel-infra.org/mcp-repos/ocata/xenial ocata-hotfix main
2017-09-14 21:21:03,458 [salt.loaded.int.module.cmdmod][INFO    ][8884] Executing command ['apt-key', 'add', '/var/cache/salt/minion/extrn_files/base/mirror.fuel-infra.org/mcp-repos/ocata/xenial/archive-mcpocata.key'] in directory '/root'
2017-09-14 21:21:03,532 [salt.loaded.int.module.cmdmod][INFO    ][8884] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-09-14 21:21:05,623 [salt.state       ][INFO    ][8884] Configured package repo 'deb http://mirror.fuel-infra.org/mcp-repos/ocata/xenial ocata-hotfix main'
2017-09-14 21:21:05,624 [salt.state       ][INFO    ][8884] Completed state [deb http://mirror.fuel-infra.org/mcp-repos/ocata/xenial ocata-hotfix main] at time 21:21:05.623506 duration_in_ms=2224.514
2017-09-14 21:21:05,624 [salt.state       ][INFO    ][8884] Running state [/etc/apt/apt.conf.d/99proxies-salt-salt] at time 21:21:05.623871
2017-09-14 21:21:05,624 [salt.state       ][INFO    ][8884] Executing state file.absent for /etc/apt/apt.conf.d/99proxies-salt-salt
2017-09-14 21:21:05,625 [salt.state       ][INFO    ][8884] File /etc/apt/apt.conf.d/99proxies-salt-salt is not present
2017-09-14 21:21:05,625 [salt.state       ][INFO    ][8884] Completed state [/etc/apt/apt.conf.d/99proxies-salt-salt] at time 21:21:05.624844 duration_in_ms=0.972
2017-09-14 21:21:05,625 [salt.state       ][INFO    ][8884] Running state [/etc/apt/preferences.d/salt] at time 21:21:05.625132
2017-09-14 21:21:05,625 [salt.state       ][INFO    ][8884] Executing state file.absent for /etc/apt/preferences.d/salt
2017-09-14 21:21:05,626 [salt.state       ][INFO    ][8884] File /etc/apt/preferences.d/salt is not present
2017-09-14 21:21:05,626 [salt.state       ][INFO    ][8884] Completed state [/etc/apt/preferences.d/salt] at time 21:21:05.625983 duration_in_ms=0.851
2017-09-14 21:21:05,627 [salt.state       ][INFO    ][8884] Running state [deb http://repo.saltstack.com/apt/ubuntu/16.04/amd64/2016.3 xenial main] at time 21:21:05.626838
2017-09-14 21:21:05,627 [salt.state       ][INFO    ][8884] Executing state pkgrepo.managed for deb http://repo.saltstack.com/apt/ubuntu/16.04/amd64/2016.3 xenial main
2017-09-14 21:21:05,831 [salt.loaded.int.module.cmdmod][INFO    ][8884] Executing command ['apt-key', 'add', '/var/cache/salt/minion/extrn_files/base/repo.saltstack.com/apt/ubuntu/16.04/amd64/2016.3/SALTSTACK-GPG-KEY.pub'] in directory '/root'
2017-09-14 21:21:05,917 [salt.loaded.int.module.cmdmod][INFO    ][8884] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-09-14 21:21:07,200 [salt.minion      ][INFO    ][1503] User sudo_ubuntu Executing command saltutil.find_job with jid 20170914212107176763
2017-09-14 21:21:07,225 [salt.minion      ][INFO    ][14661] Starting a new job with PID 14661
2017-09-14 21:21:07,239 [salt.minion      ][INFO    ][14661] Returning information for job: 20170914212107176763
2017-09-14 21:21:08,218 [salt.state       ][INFO    ][8884] Configured package repo 'deb http://repo.saltstack.com/apt/ubuntu/16.04/amd64/2016.3 xenial main'
2017-09-14 21:21:08,218 [salt.state       ][INFO    ][8884] Completed state [deb http://repo.saltstack.com/apt/ubuntu/16.04/amd64/2016.3 xenial main] at time 21:21:08.218198 duration_in_ms=2591.359
2017-09-14 21:21:08,219 [salt.state       ][INFO    ][8884] Running state [linux_extra_packages_purged] at time 21:21:08.218639
2017-09-14 21:21:08,219 [salt.state       ][INFO    ][8884] Executing state pkg.purged for linux_extra_packages_purged
2017-09-14 21:21:08,225 [salt.state       ][INFO    ][8884] All specified packages are already absent
2017-09-14 21:21:08,226 [salt.state       ][INFO    ][8884] Completed state [linux_extra_packages_purged] at time 21:21:08.225570 duration_in_ms=6.931
2017-09-14 21:21:08,226 [salt.state       ][INFO    ][8884] Running state [linux_extra_packages_latest] at time 21:21:08.225861
2017-09-14 21:21:08,226 [salt.state       ][INFO    ][8884] Executing state pkg.latest for linux_extra_packages_latest
2017-09-14 21:21:08,229 [salt.loaded.int.module.cmdmod][INFO    ][8884] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-09-14 21:21:10,917 [salt.loaded.int.module.cmdmod][INFO    ][8884] Executing command ['apt-cache', '-q', 'policy', 'mcelog'] in directory '/root'
2017-09-14 21:21:10,961 [salt.loaded.int.module.cmdmod][INFO    ][8884] Executing command ['apt-cache', '-q', 'policy', 'python-msgpack'] in directory '/root'
2017-09-14 21:21:11,001 [salt.state       ][INFO    ][8884] All packages are up-to-date (mcelog, python-msgpack).
2017-09-14 21:21:11,002 [salt.state       ][INFO    ][8884] Completed state [linux_extra_packages_latest] at time 21:21:11.001574 duration_in_ms=2775.712
2017-09-14 21:21:11,002 [salt.state       ][INFO    ][8884] Running state [UTC] at time 21:21:11.002322
2017-09-14 21:21:11,003 [salt.state       ][INFO    ][8884] Executing state timezone.system for UTC
2017-09-14 21:21:11,003 [salt.loaded.int.module.cmdmod][INFO    ][8884] Executing command ['timedatectl'] in directory '/root'
2017-09-14 21:21:11,042 [salt.loaded.int.module.cmdmod][INFO    ][8884] Executing command ['timedatectl'] in directory '/root'
2017-09-14 21:21:11,050 [salt.state       ][INFO    ][8884] Timezone UTC already set, UTC already set to UTC
2017-09-14 21:21:11,050 [salt.state       ][INFO    ][8884] Completed state [UTC] at time 21:21:11.049914 duration_in_ms=47.592
2017-09-14 21:21:11,051 [salt.state       ][INFO    ][8884] Running state [nf_conntrack] at time 21:21:11.050583
2017-09-14 21:21:11,051 [salt.state       ][INFO    ][8884] Executing state kmod.present for nf_conntrack
2017-09-14 21:21:11,051 [salt.loaded.int.module.cmdmod][INFO    ][8884] Executing command 'lsmod' in directory '/root'
2017-09-14 21:21:11,058 [salt.state       ][INFO    ][8884] Kernel module nf_conntrack is already present
2017-09-14 21:21:11,058 [salt.state       ][INFO    ][8884] Completed state [nf_conntrack] at time 21:21:11.058198 duration_in_ms=7.615
2017-09-14 21:21:11,059 [salt.state       ][INFO    ][8884] Running state [net.ipv4.tcp_keepalive_probes] at time 21:21:11.058863
2017-09-14 21:21:11,059 [salt.state       ][INFO    ][8884] Executing state sysctl.present for net.ipv4.tcp_keepalive_probes
2017-09-14 21:21:11,066 [salt.loaded.int.module.cmdmod][INFO    ][8884] Executing command 'sysctl -a' in directory '/root'
2017-09-14 21:21:11,079 [salt.state       ][INFO    ][8884] Sysctl value net.ipv4.tcp_keepalive_probes = 8 is already set
2017-09-14 21:21:11,079 [salt.state       ][INFO    ][8884] Completed state [net.ipv4.tcp_keepalive_probes] at time 21:21:11.079427 duration_in_ms=20.564
2017-09-14 21:21:11,080 [salt.state       ][INFO    ][8884] Running state [fs.file-max] at time 21:21:11.079755
2017-09-14 21:21:11,080 [salt.state       ][INFO    ][8884] Executing state sysctl.present for fs.file-max
2017-09-14 21:21:11,081 [salt.loaded.int.module.cmdmod][INFO    ][8884] Executing command 'sysctl -a' in directory '/root'
2017-09-14 21:21:11,094 [salt.state       ][INFO    ][8884] Sysctl value fs.file-max = 124165 is already set
2017-09-14 21:21:11,095 [salt.state       ][INFO    ][8884] Completed state [fs.file-max] at time 21:21:11.094726 duration_in_ms=14.969
2017-09-14 21:21:11,095 [salt.state       ][INFO    ][8884] Running state [net.core.somaxconn] at time 21:21:11.095098
2017-09-14 21:21:11,095 [salt.state       ][INFO    ][8884] Executing state sysctl.present for net.core.somaxconn
2017-09-14 21:21:11,096 [salt.loaded.int.module.cmdmod][INFO    ][8884] Executing command 'sysctl -a' in directory '/root'
2017-09-14 21:21:11,111 [salt.state       ][INFO    ][8884] Sysctl value net.core.somaxconn = 4096 is already set
2017-09-14 21:21:11,111 [salt.state       ][INFO    ][8884] Completed state [net.core.somaxconn] at time 21:21:11.111203 duration_in_ms=16.103
2017-09-14 21:21:11,112 [salt.state       ][INFO    ][8884] Running state [net.ipv4.tcp_max_syn_backlog] at time 21:21:11.111593
2017-09-14 21:21:11,112 [salt.state       ][INFO    ][8884] Executing state sysctl.present for net.ipv4.tcp_max_syn_backlog
2017-09-14 21:21:11,112 [salt.loaded.int.module.cmdmod][INFO    ][8884] Executing command 'sysctl -a' in directory '/root'
2017-09-14 21:21:11,127 [salt.state       ][INFO    ][8884] Sysctl value net.ipv4.tcp_max_syn_backlog = 8192 is already set
2017-09-14 21:21:11,127 [salt.state       ][INFO    ][8884] Completed state [net.ipv4.tcp_max_syn_backlog] at time 21:21:11.126951 duration_in_ms=15.358
2017-09-14 21:21:11,127 [salt.state       ][INFO    ][8884] Running state [net.ipv4.tcp_tw_reuse] at time 21:21:11.127287
2017-09-14 21:21:11,128 [salt.state       ][INFO    ][8884] Executing state sysctl.present for net.ipv4.tcp_tw_reuse
2017-09-14 21:21:11,128 [salt.loaded.int.module.cmdmod][INFO    ][8884] Executing command 'sysctl -a' in directory '/root'
2017-09-14 21:21:11,144 [salt.state       ][INFO    ][8884] Sysctl value net.ipv4.tcp_tw_reuse = 1 is already set
2017-09-14 21:21:11,144 [salt.state       ][INFO    ][8884] Completed state [net.ipv4.tcp_tw_reuse] at time 21:21:11.144013 duration_in_ms=16.725
2017-09-14 21:21:11,144 [salt.state       ][INFO    ][8884] Running state [net.ipv4.tcp_congestion_control] at time 21:21:11.144347
2017-09-14 21:21:11,145 [salt.state       ][INFO    ][8884] Executing state sysctl.present for net.ipv4.tcp_congestion_control
2017-09-14 21:21:11,145 [salt.loaded.int.module.cmdmod][INFO    ][8884] Executing command 'sysctl -a' in directory '/root'
2017-09-14 21:21:11,164 [salt.state       ][INFO    ][8884] Sysctl value net.ipv4.tcp_congestion_control = yeah is already set
2017-09-14 21:21:11,164 [salt.state       ][INFO    ][8884] Completed state [net.ipv4.tcp_congestion_control] at time 21:21:11.164312 duration_in_ms=19.965
2017-09-14 21:21:11,165 [salt.state       ][INFO    ][8884] Running state [net.nf_conntrack_max] at time 21:21:11.164817
2017-09-14 21:21:11,165 [salt.state       ][INFO    ][8884] Executing state sysctl.present for net.nf_conntrack_max
2017-09-14 21:21:11,166 [salt.loaded.int.module.cmdmod][INFO    ][8884] Executing command 'sysctl -a' in directory '/root'
2017-09-14 21:21:11,184 [salt.state       ][INFO    ][8884] Sysctl value net.nf_conntrack_max = 1048576 is already set
2017-09-14 21:21:11,184 [salt.state       ][INFO    ][8884] Completed state [net.nf_conntrack_max] at time 21:21:11.184276 duration_in_ms=19.459
2017-09-14 21:21:11,185 [salt.state       ][INFO    ][8884] Running state [net.ipv4.tcp_retries2] at time 21:21:11.184620
2017-09-14 21:21:11,185 [salt.state       ][INFO    ][8884] Executing state sysctl.present for net.ipv4.tcp_retries2
2017-09-14 21:21:11,186 [salt.loaded.int.module.cmdmod][INFO    ][8884] Executing command 'sysctl -a' in directory '/root'
2017-09-14 21:21:11,203 [salt.state       ][INFO    ][8884] Sysctl value net.ipv4.tcp_retries2 = 5 is already set
2017-09-14 21:21:11,204 [salt.state       ][INFO    ][8884] Completed state [net.ipv4.tcp_retries2] at time 21:21:11.203824 duration_in_ms=19.202
2017-09-14 21:21:11,204 [salt.state       ][INFO    ][8884] Running state [net.core.netdev_max_backlog] at time 21:21:11.204157
2017-09-14 21:21:11,204 [salt.state       ][INFO    ][8884] Executing state sysctl.present for net.core.netdev_max_backlog
2017-09-14 21:21:11,205 [salt.loaded.int.module.cmdmod][INFO    ][8884] Executing command 'sysctl -a' in directory '/root'
2017-09-14 21:21:11,224 [salt.state       ][INFO    ][8884] Sysctl value net.core.netdev_max_backlog = 261144 is already set
2017-09-14 21:21:11,224 [salt.state       ][INFO    ][8884] Completed state [net.core.netdev_max_backlog] at time 21:21:11.224359 duration_in_ms=20.202
2017-09-14 21:21:11,225 [salt.state       ][INFO    ][8884] Running state [net.ipv4.tcp_slow_start_after_idle] at time 21:21:11.224716
2017-09-14 21:21:11,225 [salt.state       ][INFO    ][8884] Executing state sysctl.present for net.ipv4.tcp_slow_start_after_idle
2017-09-14 21:21:11,226 [salt.loaded.int.module.cmdmod][INFO    ][8884] Executing command 'sysctl -a' in directory '/root'
2017-09-14 21:21:11,242 [salt.state       ][INFO    ][8884] Sysctl value net.ipv4.tcp_slow_start_after_idle = 0 is already set
2017-09-14 21:21:11,242 [salt.state       ][INFO    ][8884] Completed state [net.ipv4.tcp_slow_start_after_idle] at time 21:21:11.242426 duration_in_ms=17.71
2017-09-14 21:21:11,243 [salt.state       ][INFO    ][8884] Running state [vm.swappiness] at time 21:21:11.242785
2017-09-14 21:21:11,243 [salt.state       ][INFO    ][8884] Executing state sysctl.present for vm.swappiness
2017-09-14 21:21:11,244 [salt.loaded.int.module.cmdmod][INFO    ][8884] Executing command 'sysctl -a' in directory '/root'
2017-09-14 21:21:11,261 [salt.state       ][INFO    ][8884] Sysctl value vm.swappiness = 10 is already set
2017-09-14 21:21:11,262 [salt.state       ][INFO    ][8884] Completed state [vm.swappiness] at time 21:21:11.261891 duration_in_ms=19.106
2017-09-14 21:21:11,262 [salt.state       ][INFO    ][8884] Running state [net.ipv4.tcp_keepalive_intvl] at time 21:21:11.262225
2017-09-14 21:21:11,263 [salt.state       ][INFO    ][8884] Executing state sysctl.present for net.ipv4.tcp_keepalive_intvl
2017-09-14 21:21:11,263 [salt.loaded.int.module.cmdmod][INFO    ][8884] Executing command 'sysctl -a' in directory '/root'
2017-09-14 21:21:11,281 [salt.state       ][INFO    ][8884] Sysctl value net.ipv4.tcp_keepalive_intvl = 3 is already set
2017-09-14 21:21:11,282 [salt.state       ][INFO    ][8884] Completed state [net.ipv4.tcp_keepalive_intvl] at time 21:21:11.281461 duration_in_ms=19.236
2017-09-14 21:21:11,282 [salt.state       ][INFO    ][8884] Running state [net.ipv4.neigh.default.gc_thresh1] at time 21:21:11.281801
2017-09-14 21:21:11,282 [salt.state       ][INFO    ][8884] Executing state sysctl.present for net.ipv4.neigh.default.gc_thresh1
2017-09-14 21:21:11,283 [salt.loaded.int.module.cmdmod][INFO    ][8884] Executing command 'sysctl -a' in directory '/root'
2017-09-14 21:21:11,297 [salt.state       ][INFO    ][8884] Sysctl value net.ipv4.neigh.default.gc_thresh1 = 4096 is already set
2017-09-14 21:21:11,297 [salt.state       ][INFO    ][8884] Completed state [net.ipv4.neigh.default.gc_thresh1] at time 21:21:11.297229 duration_in_ms=15.426
2017-09-14 21:21:11,298 [salt.state       ][INFO    ][8884] Running state [net.ipv4.neigh.default.gc_thresh2] at time 21:21:11.297674
2017-09-14 21:21:11,298 [salt.state       ][INFO    ][8884] Executing state sysctl.present for net.ipv4.neigh.default.gc_thresh2
2017-09-14 21:21:11,299 [salt.loaded.int.module.cmdmod][INFO    ][8884] Executing command 'sysctl -a' in directory '/root'
2017-09-14 21:21:11,318 [salt.state       ][INFO    ][8884] Sysctl value net.ipv4.neigh.default.gc_thresh2 = 8192 is already set
2017-09-14 21:21:11,319 [salt.state       ][INFO    ][8884] Completed state [net.ipv4.neigh.default.gc_thresh2] at time 21:21:11.318885 duration_in_ms=21.21
2017-09-14 21:21:11,319 [salt.state       ][INFO    ][8884] Running state [net.ipv4.neigh.default.gc_thresh3] at time 21:21:11.319397
2017-09-14 21:21:11,320 [salt.state       ][INFO    ][8884] Executing state sysctl.present for net.ipv4.neigh.default.gc_thresh3
2017-09-14 21:21:11,321 [salt.loaded.int.module.cmdmod][INFO    ][8884] Executing command 'sysctl -a' in directory '/root'
2017-09-14 21:21:11,335 [salt.state       ][INFO    ][8884] Sysctl value net.ipv4.neigh.default.gc_thresh3 = 16384 is already set
2017-09-14 21:21:11,336 [salt.state       ][INFO    ][8884] Completed state [net.ipv4.neigh.default.gc_thresh3] at time 21:21:11.336072 duration_in_ms=16.675
2017-09-14 21:21:11,337 [salt.state       ][INFO    ][8884] Running state [net.ipv4.tcp_fin_timeout] at time 21:21:11.336566
2017-09-14 21:21:11,337 [salt.state       ][INFO    ][8884] Executing state sysctl.present for net.ipv4.tcp_fin_timeout
2017-09-14 21:21:11,338 [salt.loaded.int.module.cmdmod][INFO    ][8884] Executing command 'sysctl -a' in directory '/root'
2017-09-14 21:21:11,354 [salt.state       ][INFO    ][8884] Sysctl value net.ipv4.tcp_fin_timeout = 30 is already set
2017-09-14 21:21:11,355 [salt.state       ][INFO    ][8884] Completed state [net.ipv4.tcp_fin_timeout] at time 21:21:11.354550 duration_in_ms=17.983
2017-09-14 21:21:11,355 [salt.state       ][INFO    ][8884] Running state [net.ipv4.tcp_keepalive_time] at time 21:21:11.355041
2017-09-14 21:21:11,356 [salt.state       ][INFO    ][8884] Executing state sysctl.present for net.ipv4.tcp_keepalive_time
2017-09-14 21:21:11,356 [salt.loaded.int.module.cmdmod][INFO    ][8884] Executing command 'sysctl -a' in directory '/root'
2017-09-14 21:21:11,371 [salt.state       ][INFO    ][8884] Sysctl value net.ipv4.tcp_keepalive_time = 30 is already set
2017-09-14 21:21:11,371 [salt.state       ][INFO    ][8884] Completed state [net.ipv4.tcp_keepalive_time] at time 21:21:11.371315 duration_in_ms=16.274
2017-09-14 21:21:11,372 [salt.state       ][INFO    ][8884] Running state [kernel.panic] at time 21:21:11.371647
2017-09-14 21:21:11,372 [salt.state       ][INFO    ][8884] Executing state sysctl.present for kernel.panic
2017-09-14 21:21:11,373 [salt.loaded.int.module.cmdmod][INFO    ][8884] Executing command 'sysctl -a' in directory '/root'
2017-09-14 21:21:11,388 [salt.state       ][INFO    ][8884] Sysctl value kernel.panic = 60 is already set
2017-09-14 21:21:11,389 [salt.state       ][INFO    ][8884] Completed state [kernel.panic] at time 21:21:11.388466 duration_in_ms=16.817
2017-09-14 21:21:11,389 [salt.state       ][INFO    ][8884] Running state [linux_sysfs_package] at time 21:21:11.388798
2017-09-14 21:21:11,389 [salt.state       ][INFO    ][8884] Executing state pkg.installed for linux_sysfs_package
2017-09-14 21:21:11,392 [salt.state       ][INFO    ][8884] All specified packages are already installed
2017-09-14 21:21:11,393 [salt.state       ][INFO    ][8884] Completed state [linux_sysfs_package] at time 21:21:11.392685 duration_in_ms=3.885
2017-09-14 21:21:11,394 [salt.state       ][INFO    ][8884] Running state [/etc/sysfs.d] at time 21:21:11.393685
2017-09-14 21:21:11,394 [salt.state       ][INFO    ][8884] Executing state file.directory for /etc/sysfs.d
2017-09-14 21:21:11,395 [salt.state       ][INFO    ][8884] Directory /etc/sysfs.d is in the correct state
2017-09-14 21:21:11,395 [salt.state       ][INFO    ][8884] Completed state [/etc/sysfs.d] at time 21:21:11.394826 duration_in_ms=1.141
2017-09-14 21:21:11,395 [salt.state       ][INFO    ][8884] Running state [ondemand] at time 21:21:11.395429
2017-09-14 21:21:11,396 [salt.state       ][INFO    ][8884] Executing state service.dead for ondemand
2017-09-14 21:21:11,396 [salt.loaded.int.module.cmdmod][INFO    ][8884] Executing command ['systemctl', 'status', 'ondemand.service', '-n', '0'] in directory '/root'
2017-09-14 21:21:11,406 [salt.loaded.int.module.cmdmod][INFO    ][8884] Executing command ['systemctl', 'is-active', 'ondemand.service'] in directory '/root'
2017-09-14 21:21:11,414 [salt.loaded.int.module.cmdmod][INFO    ][8884] Executing command ['systemctl', 'is-enabled', 'ondemand.service'] in directory '/root'
2017-09-14 21:21:11,425 [salt.loaded.int.module.cmdmod][INFO    ][8884] Executing command 'runlevel' in directory '/root'
2017-09-14 21:21:11,434 [salt.state       ][INFO    ][8884] The service ondemand is already dead
2017-09-14 21:21:11,434 [salt.state       ][INFO    ][8884] Completed state [ondemand] at time 21:21:11.434047 duration_in_ms=38.617
2017-09-14 21:21:11,435 [salt.state       ][INFO    ][8884] Running state [cs_CZ.UTF-8] at time 21:21:11.434717
2017-09-14 21:21:11,435 [salt.state       ][INFO    ][8884] Executing state locale.present for cs_CZ.UTF-8
2017-09-14 21:21:11,436 [salt.loaded.int.module.cmdmod][INFO    ][8884] Executing command 'locale -a' in directory '/root'
2017-09-14 21:21:11,442 [salt.state       ][INFO    ][8884] Locale cs_CZ.UTF-8 is already present
2017-09-14 21:21:11,443 [salt.state       ][INFO    ][8884] Completed state [cs_CZ.UTF-8] at time 21:21:11.442924 duration_in_ms=8.206
2017-09-14 21:21:11,443 [salt.state       ][INFO    ][8884] Running state [en_US.UTF-8] at time 21:21:11.443281
2017-09-14 21:21:11,444 [salt.state       ][INFO    ][8884] Executing state locale.present for en_US.UTF-8
2017-09-14 21:21:11,444 [salt.loaded.int.module.cmdmod][INFO    ][8884] Executing command 'locale -a' in directory '/root'
2017-09-14 21:21:11,450 [salt.state       ][INFO    ][8884] Locale en_US.UTF-8 is already present
2017-09-14 21:21:11,450 [salt.state       ][INFO    ][8884] Completed state [en_US.UTF-8] at time 21:21:11.450338 duration_in_ms=7.057
2017-09-14 21:21:11,451 [salt.state       ][INFO    ][8884] Running state [en_US.UTF-8] at time 21:21:11.451437
2017-09-14 21:21:11,452 [salt.state       ][INFO    ][8884] Executing state locale.system for en_US.UTF-8
2017-09-14 21:21:11,452 [salt.loaded.int.module.cmdmod][INFO    ][8884] Executing command 'localectl' in directory '/root'
2017-09-14 21:21:11,491 [salt.state       ][INFO    ][8884] System locale en_US.UTF-8 already set
2017-09-14 21:21:11,491 [salt.state       ][INFO    ][8884] Completed state [en_US.UTF-8] at time 21:21:11.491256 duration_in_ms=39.819
2017-09-14 21:21:11,493 [salt.state       ][INFO    ][8884] Running state [root] at time 21:21:11.492738
2017-09-14 21:21:11,493 [salt.state       ][INFO    ][8884] Executing state user.present for root
2017-09-14 21:21:11,495 [salt.state       ][INFO    ][8884] User root is present and up to date
2017-09-14 21:21:11,495 [salt.state       ][INFO    ][8884] Completed state [root] at time 21:21:11.494945 duration_in_ms=2.208
2017-09-14 21:21:11,496 [salt.state       ][INFO    ][8884] Running state [/root] at time 21:21:11.496417
2017-09-14 21:21:11,497 [salt.state       ][INFO    ][8884] Executing state file.directory for /root
2017-09-14 21:21:11,498 [salt.state       ][INFO    ][8884] Directory /root is in the correct state
2017-09-14 21:21:11,498 [salt.state       ][INFO    ][8884] Completed state [/root] at time 21:21:11.498011 duration_in_ms=1.593
2017-09-14 21:21:11,498 [salt.state       ][INFO    ][8884] Running state [/etc/sudoers.d/90-salt-user-root] at time 21:21:11.498395
2017-09-14 21:21:11,499 [salt.state       ][INFO    ][8884] Executing state file.absent for /etc/sudoers.d/90-salt-user-root
2017-09-14 21:21:11,499 [salt.state       ][INFO    ][8884] File /etc/sudoers.d/90-salt-user-root is not present
2017-09-14 21:21:11,500 [salt.state       ][INFO    ][8884] Completed state [/etc/sudoers.d/90-salt-user-root] at time 21:21:11.499630 duration_in_ms=1.235
2017-09-14 21:21:11,500 [salt.state       ][INFO    ][8884] Running state [ubuntu] at time 21:21:11.500035
2017-09-14 21:21:11,500 [salt.state       ][INFO    ][8884] Executing state user.present for ubuntu
2017-09-14 21:21:11,502 [salt.state       ][INFO    ][8884] User ubuntu is present and up to date
2017-09-14 21:21:11,502 [salt.state       ][INFO    ][8884] Completed state [ubuntu] at time 21:21:11.501938 duration_in_ms=1.902
2017-09-14 21:21:11,503 [salt.state       ][INFO    ][8884] Running state [/home/ubuntu] at time 21:21:11.503312
2017-09-14 21:21:11,504 [salt.state       ][INFO    ][8884] Executing state file.directory for /home/ubuntu
2017-09-14 21:21:11,505 [salt.state       ][INFO    ][8884] Directory /home/ubuntu is in the correct state
2017-09-14 21:21:11,505 [salt.state       ][INFO    ][8884] Completed state [/home/ubuntu] at time 21:21:11.504883 duration_in_ms=1.571
2017-09-14 21:21:11,506 [salt.state       ][INFO    ][8884] Running state [/etc/sudoers.d/90-salt-user-ubuntu] at time 21:21:11.506037
2017-09-14 21:21:11,506 [salt.state       ][INFO    ][8884] Executing state file.managed for /etc/sudoers.d/90-salt-user-ubuntu
2017-09-14 21:21:11,523 [salt.fileclient  ][INFO    ][8884] Fetching file from saltenv 'base', ** done ** 'linux/files/sudoer'
2017-09-14 21:21:11,551 [salt.state       ][INFO    ][8884] File /etc/sudoers.d/90-salt-user-ubuntu is in the correct state
2017-09-14 21:21:11,551 [salt.state       ][INFO    ][8884] Completed state [/etc/sudoers.d/90-salt-user-ubuntu] at time 21:21:11.551425 duration_in_ms=45.387
2017-09-14 21:21:11,552 [salt.state       ][INFO    ][8884] Running state [/etc/security/limits.d/90-salt-default.conf] at time 21:21:11.551661
2017-09-14 21:21:11,552 [salt.state       ][INFO    ][8884] Executing state file.managed for /etc/security/limits.d/90-salt-default.conf
2017-09-14 21:21:11,567 [salt.fileclient  ][INFO    ][8884] Fetching file from saltenv 'base', ** done ** 'linux/files/limits.conf'
2017-09-14 21:21:11,586 [salt.fileclient  ][INFO    ][8884] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-09-14 21:21:11,617 [salt.state       ][INFO    ][8884] File /etc/security/limits.d/90-salt-default.conf is in the correct state
2017-09-14 21:21:11,618 [salt.state       ][INFO    ][8884] Completed state [/etc/security/limits.d/90-salt-default.conf] at time 21:21:11.617486 duration_in_ms=65.824
2017-09-14 21:21:11,618 [salt.state       ][INFO    ][8884] Running state [/etc/systemd/system.conf.d/90-salt.conf] at time 21:21:11.617770
2017-09-14 21:21:11,618 [salt.state       ][INFO    ][8884] Executing state file.managed for /etc/systemd/system.conf.d/90-salt.conf
2017-09-14 21:21:11,635 [salt.fileclient  ][INFO    ][8884] Fetching file from saltenv 'base', ** done ** 'linux/files/systemd.conf'
2017-09-14 21:21:11,652 [salt.fileclient  ][INFO    ][8884] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-09-14 21:21:11,685 [salt.state       ][INFO    ][8884] File /etc/systemd/system.conf.d/90-salt.conf is in the correct state
2017-09-14 21:21:11,686 [salt.state       ][INFO    ][8884] Completed state [/etc/systemd/system.conf.d/90-salt.conf] at time 21:21:11.685579 duration_in_ms=67.808
2017-09-14 21:21:11,687 [salt.state       ][INFO    ][8884] Running state [service.systemctl_reload] at time 21:21:11.686583
2017-09-14 21:21:11,687 [salt.state       ][INFO    ][8884] Executing state module.wait for service.systemctl_reload
2017-09-14 21:21:11,687 [salt.state       ][INFO    ][8884] No changes made for service.systemctl_reload
2017-09-14 21:21:11,687 [salt.state       ][INFO    ][8884] Completed state [service.systemctl_reload] at time 21:21:11.687164 duration_in_ms=0.581
2017-09-14 21:21:11,687 [salt.state       ][INFO    ][8884] Running state [/etc/hostname] at time 21:21:11.687345
2017-09-14 21:21:11,688 [salt.state       ][INFO    ][8884] Executing state file.managed for /etc/hostname
2017-09-14 21:21:11,705 [salt.fileclient  ][INFO    ][8884] Fetching file from saltenv 'base', ** done ** 'linux/files/hostname'
2017-09-14 21:21:11,706 [salt.state       ][INFO    ][8884] File /etc/hostname is in the correct state
2017-09-14 21:21:11,707 [salt.state       ][INFO    ][8884] Completed state [/etc/hostname] at time 21:21:11.706574 duration_in_ms=19.229
2017-09-14 21:21:11,708 [salt.state       ][INFO    ][8884] Running state [hostname odl01] at time 21:21:11.707778
2017-09-14 21:21:11,708 [salt.state       ][INFO    ][8884] Executing state cmd.wait for hostname odl01
2017-09-14 21:21:11,708 [salt.state       ][INFO    ][8884] No changes made for hostname odl01
2017-09-14 21:21:11,708 [salt.state       ][INFO    ][8884] Completed state [hostname odl01] at time 21:21:11.708385 duration_in_ms=0.607
2017-09-14 21:21:11,709 [salt.state       ][INFO    ][8884] Running state [mdb02.baremetal-mcp-ocata-odl-ha.local] at time 21:21:11.708755
2017-09-14 21:21:11,709 [salt.state       ][INFO    ][8884] Executing state host.present for mdb02.baremetal-mcp-ocata-odl-ha.local
2017-09-14 21:21:11,709 [salt.state       ][INFO    ][8884] Host mdb02.baremetal-mcp-ocata-odl-ha.local (10.167.4.77) already present
2017-09-14 21:21:11,710 [salt.state       ][INFO    ][8884] Completed state [mdb02.baremetal-mcp-ocata-odl-ha.local] at time 21:21:11.709483 duration_in_ms=0.728
2017-09-14 21:21:11,710 [salt.state       ][INFO    ][8884] Running state [mdb02] at time 21:21:11.709669
2017-09-14 21:21:11,710 [salt.state       ][INFO    ][8884] Executing state host.present for mdb02
2017-09-14 21:21:11,710 [salt.state       ][INFO    ][8884] Host mdb02 (10.167.4.77) already present
2017-09-14 21:21:11,710 [salt.state       ][INFO    ][8884] Completed state [mdb02] at time 21:21:11.710335 duration_in_ms=0.666
2017-09-14 21:21:11,711 [salt.state       ][INFO    ][8884] Running state [mdb03.baremetal-mcp-ocata-odl-ha.local] at time 21:21:11.710538
2017-09-14 21:21:11,711 [salt.state       ][INFO    ][8884] Executing state host.present for mdb03.baremetal-mcp-ocata-odl-ha.local
2017-09-14 21:21:11,711 [salt.state       ][INFO    ][8884] Host mdb03.baremetal-mcp-ocata-odl-ha.local (10.167.4.78) already present
2017-09-14 21:21:11,711 [salt.state       ][INFO    ][8884] Completed state [mdb03.baremetal-mcp-ocata-odl-ha.local] at time 21:21:11.711202 duration_in_ms=0.664
2017-09-14 21:21:11,711 [salt.state       ][INFO    ][8884] Running state [mdb03] at time 21:21:11.711382
2017-09-14 21:21:11,712 [salt.state       ][INFO    ][8884] Executing state host.present for mdb03
2017-09-14 21:21:11,712 [salt.state       ][INFO    ][8884] Host mdb03 (10.167.4.78) already present
2017-09-14 21:21:11,712 [salt.state       ][INFO    ][8884] Completed state [mdb03] at time 21:21:11.712042 duration_in_ms=0.659
2017-09-14 21:21:11,712 [salt.state       ][INFO    ][8884] Running state [mdb01.baremetal-mcp-ocata-odl-ha.local] at time 21:21:11.712226
2017-09-14 21:21:11,712 [salt.state       ][INFO    ][8884] Executing state host.present for mdb01.baremetal-mcp-ocata-odl-ha.local
2017-09-14 21:21:11,713 [salt.state       ][INFO    ][8884] Host mdb01.baremetal-mcp-ocata-odl-ha.local (10.167.4.76) already present
2017-09-14 21:21:11,713 [salt.state       ][INFO    ][8884] Completed state [mdb01.baremetal-mcp-ocata-odl-ha.local] at time 21:21:11.712890 duration_in_ms=0.664
2017-09-14 21:21:11,713 [salt.state       ][INFO    ][8884] Running state [mdb01] at time 21:21:11.713080
2017-09-14 21:21:11,713 [salt.state       ][INFO    ][8884] Executing state host.present for mdb01
2017-09-14 21:21:11,714 [salt.state       ][INFO    ][8884] Host mdb01 (10.167.4.76) already present
2017-09-14 21:21:11,714 [salt.state       ][INFO    ][8884] Completed state [mdb01] at time 21:21:11.713743 duration_in_ms=0.663
2017-09-14 21:21:11,714 [salt.state       ][INFO    ][8884] Running state [mdb] at time 21:21:11.713925
2017-09-14 21:21:11,714 [salt.state       ][INFO    ][8884] Executing state host.present for mdb
2017-09-14 21:21:11,714 [salt.state       ][INFO    ][8884] Host mdb (10.167.4.75) already present
2017-09-14 21:21:11,715 [salt.state       ][INFO    ][8884] Completed state [mdb] at time 21:21:11.714625 duration_in_ms=0.7
2017-09-14 21:21:11,715 [salt.state       ][INFO    ][8884] Running state [mdb.baremetal-mcp-ocata-odl-ha.local] at time 21:21:11.714823
2017-09-14 21:21:11,715 [salt.state       ][INFO    ][8884] Executing state host.present for mdb.baremetal-mcp-ocata-odl-ha.local
2017-09-14 21:21:11,715 [salt.state       ][INFO    ][8884] Host mdb.baremetal-mcp-ocata-odl-ha.local (10.167.4.75) already present
2017-09-14 21:21:11,716 [salt.state       ][INFO    ][8884] Completed state [mdb.baremetal-mcp-ocata-odl-ha.local] at time 21:21:11.715497 duration_in_ms=0.674
2017-09-14 21:21:11,716 [salt.state       ][INFO    ][8884] Running state [cfg01.baremetal-mcp-ocata-odl-ha.local] at time 21:21:11.715684
2017-09-14 21:21:11,716 [salt.state       ][INFO    ][8884] Executing state host.present for cfg01.baremetal-mcp-ocata-odl-ha.local
2017-09-14 21:21:11,716 [salt.state       ][INFO    ][8884] Host cfg01.baremetal-mcp-ocata-odl-ha.local (10.167.4.100) already present
2017-09-14 21:21:11,716 [salt.state       ][INFO    ][8884] Completed state [cfg01.baremetal-mcp-ocata-odl-ha.local] at time 21:21:11.716346 duration_in_ms=0.662
2017-09-14 21:21:11,717 [salt.state       ][INFO    ][8884] Running state [cfg01] at time 21:21:11.716529
2017-09-14 21:21:11,717 [salt.state       ][INFO    ][8884] Executing state host.present for cfg01
2017-09-14 21:21:11,717 [salt.state       ][INFO    ][8884] Host cfg01 (10.167.4.100) already present
2017-09-14 21:21:11,717 [salt.state       ][INFO    ][8884] Completed state [cfg01] at time 21:21:11.717200 duration_in_ms=0.67
2017-09-14 21:21:11,717 [salt.state       ][INFO    ][8884] Running state [prx01] at time 21:21:11.717382
2017-09-14 21:21:11,718 [salt.state       ][INFO    ][8884] Executing state host.present for prx01
2017-09-14 21:21:11,718 [salt.state       ][INFO    ][8884] Host prx01 (10.167.4.81) already present
2017-09-14 21:21:11,718 [salt.state       ][INFO    ][8884] Completed state [prx01] at time 21:21:11.718041 duration_in_ms=0.658
2017-09-14 21:21:11,718 [salt.state       ][INFO    ][8884] Running state [prx01.baremetal-mcp-ocata-odl-ha.local] at time 21:21:11.718222
2017-09-14 21:21:11,718 [salt.state       ][INFO    ][8884] Executing state host.present for prx01.baremetal-mcp-ocata-odl-ha.local
2017-09-14 21:21:11,719 [salt.state       ][INFO    ][8884] Host prx01.baremetal-mcp-ocata-odl-ha.local (10.167.4.81) already present
2017-09-14 21:21:11,719 [salt.state       ][INFO    ][8884] Completed state [prx01.baremetal-mcp-ocata-odl-ha.local] at time 21:21:11.718897 duration_in_ms=0.675
2017-09-14 21:21:11,719 [salt.state       ][INFO    ][8884] Running state [kvm01.baremetal-mcp-ocata-odl-ha.local] at time 21:21:11.719081
2017-09-14 21:21:11,719 [salt.state       ][INFO    ][8884] Executing state host.present for kvm01.baremetal-mcp-ocata-odl-ha.local
2017-09-14 21:21:11,720 [salt.state       ][INFO    ][8884] Host kvm01.baremetal-mcp-ocata-odl-ha.local (10.167.4.141) already present
2017-09-14 21:21:11,720 [salt.state       ][INFO    ][8884] Completed state [kvm01.baremetal-mcp-ocata-odl-ha.local] at time 21:21:11.719744 duration_in_ms=0.663
2017-09-14 21:21:11,720 [salt.state       ][INFO    ][8884] Running state [kvm01] at time 21:21:11.719928
2017-09-14 21:21:11,720 [salt.state       ][INFO    ][8884] Executing state host.present for kvm01
2017-09-14 21:21:11,720 [salt.state       ][INFO    ][8884] Host kvm01 (10.167.4.141) already present
2017-09-14 21:21:11,721 [salt.state       ][INFO    ][8884] Completed state [kvm01] at time 21:21:11.720591 duration_in_ms=0.663
2017-09-14 21:21:11,721 [salt.state       ][INFO    ][8884] Running state [kvm03.baremetal-mcp-ocata-odl-ha.local] at time 21:21:11.720774
2017-09-14 21:21:11,721 [salt.state       ][INFO    ][8884] Executing state host.present for kvm03.baremetal-mcp-ocata-odl-ha.local
2017-09-14 21:21:11,721 [salt.state       ][INFO    ][8884] Host kvm03.baremetal-mcp-ocata-odl-ha.local (10.167.4.143) already present
2017-09-14 21:21:11,721 [salt.state       ][INFO    ][8884] Completed state [kvm03.baremetal-mcp-ocata-odl-ha.local] at time 21:21:11.721445 duration_in_ms=0.671
2017-09-14 21:21:11,722 [salt.state       ][INFO    ][8884] Running state [kvm03] at time 21:21:11.721635
2017-09-14 21:21:11,722 [salt.state       ][INFO    ][8884] Executing state host.present for kvm03
2017-09-14 21:21:11,722 [salt.state       ][INFO    ][8884] Host kvm03 (10.167.4.143) already present
2017-09-14 21:21:11,722 [salt.state       ][INFO    ][8884] Completed state [kvm03] at time 21:21:11.722303 duration_in_ms=0.667
2017-09-14 21:21:11,723 [salt.state       ][INFO    ][8884] Running state [kvm02.baremetal-mcp-ocata-odl-ha.local] at time 21:21:11.722500
2017-09-14 21:21:11,723 [salt.state       ][INFO    ][8884] Executing state host.present for kvm02.baremetal-mcp-ocata-odl-ha.local
2017-09-14 21:21:11,723 [salt.state       ][INFO    ][8884] Host kvm02.baremetal-mcp-ocata-odl-ha.local (10.167.4.142) already present
2017-09-14 21:21:11,723 [salt.state       ][INFO    ][8884] Completed state [kvm02.baremetal-mcp-ocata-odl-ha.local] at time 21:21:11.723159 duration_in_ms=0.659
2017-09-14 21:21:11,723 [salt.state       ][INFO    ][8884] Running state [kvm02] at time 21:21:11.723345
2017-09-14 21:21:11,724 [salt.state       ][INFO    ][8884] Executing state host.present for kvm02
2017-09-14 21:21:11,724 [salt.state       ][INFO    ][8884] Host kvm02 (10.167.4.142) already present
2017-09-14 21:21:11,724 [salt.state       ][INFO    ][8884] Completed state [kvm02] at time 21:21:11.724000 duration_in_ms=0.655
2017-09-14 21:21:11,724 [salt.state       ][INFO    ][8884] Running state [dbs] at time 21:21:11.724184
2017-09-14 21:21:11,724 [salt.state       ][INFO    ][8884] Executing state host.present for dbs
2017-09-14 21:21:11,725 [salt.state       ][INFO    ][8884] Host dbs (10.167.4.50) already present
2017-09-14 21:21:11,725 [salt.state       ][INFO    ][8884] Completed state [dbs] at time 21:21:11.725123 duration_in_ms=0.939
2017-09-14 21:21:11,725 [salt.state       ][INFO    ][8884] Running state [dbs.baremetal-mcp-ocata-odl-ha.local] at time 21:21:11.725309
2017-09-14 21:21:11,725 [salt.state       ][INFO    ][8884] Executing state host.present for dbs.baremetal-mcp-ocata-odl-ha.local
2017-09-14 21:21:11,726 [salt.state       ][INFO    ][8884] Host dbs.baremetal-mcp-ocata-odl-ha.local (10.167.4.50) already present
2017-09-14 21:21:11,726 [salt.state       ][INFO    ][8884] Completed state [dbs.baremetal-mcp-ocata-odl-ha.local] at time 21:21:11.725977 duration_in_ms=0.667
2017-09-14 21:21:11,726 [salt.state       ][INFO    ][8884] Running state [prx.baremetal-mcp-ocata-odl-ha.local] at time 21:21:11.726162
2017-09-14 21:21:11,726 [salt.state       ][INFO    ][8884] Executing state host.present for prx.baremetal-mcp-ocata-odl-ha.local
2017-09-14 21:21:11,727 [salt.state       ][INFO    ][8884] Host prx.baremetal-mcp-ocata-odl-ha.local (10.167.4.80) already present
2017-09-14 21:21:11,727 [salt.state       ][INFO    ][8884] Completed state [prx.baremetal-mcp-ocata-odl-ha.local] at time 21:21:11.726843 duration_in_ms=0.68
2017-09-14 21:21:11,727 [salt.state       ][INFO    ][8884] Running state [prx] at time 21:21:11.727029
2017-09-14 21:21:11,727 [salt.state       ][INFO    ][8884] Executing state host.present for prx
2017-09-14 21:21:11,728 [salt.state       ][INFO    ][8884] Host prx (10.167.4.80) already present
2017-09-14 21:21:11,728 [salt.state       ][INFO    ][8884] Completed state [prx] at time 21:21:11.727688 duration_in_ms=0.659
2017-09-14 21:21:11,728 [salt.state       ][INFO    ][8884] Running state [prx02] at time 21:21:11.727870
2017-09-14 21:21:11,728 [salt.state       ][INFO    ][8884] Executing state host.present for prx02
2017-09-14 21:21:11,728 [salt.state       ][INFO    ][8884] Host prx02 (10.167.4.82) already present
2017-09-14 21:21:11,729 [salt.state       ][INFO    ][8884] Completed state [prx02] at time 21:21:11.728524 duration_in_ms=0.653
2017-09-14 21:21:11,729 [salt.state       ][INFO    ][8884] Running state [prx02.baremetal-mcp-ocata-odl-ha.local] at time 21:21:11.728705
2017-09-14 21:21:11,729 [salt.state       ][INFO    ][8884] Executing state host.present for prx02.baremetal-mcp-ocata-odl-ha.local
2017-09-14 21:21:11,729 [salt.state       ][INFO    ][8884] Host prx02.baremetal-mcp-ocata-odl-ha.local (10.167.4.82) already present
2017-09-14 21:21:11,729 [salt.state       ][INFO    ][8884] Completed state [prx02.baremetal-mcp-ocata-odl-ha.local] at time 21:21:11.729380 duration_in_ms=0.675
2017-09-14 21:21:11,730 [salt.state       ][INFO    ][8884] Running state [msg02.baremetal-mcp-ocata-odl-ha.local] at time 21:21:11.729568
2017-09-14 21:21:11,730 [salt.state       ][INFO    ][8884] Executing state host.present for msg02.baremetal-mcp-ocata-odl-ha.local
2017-09-14 21:21:11,730 [salt.state       ][INFO    ][8884] Host msg02.baremetal-mcp-ocata-odl-ha.local (10.167.4.42) already present
2017-09-14 21:21:11,730 [salt.state       ][INFO    ][8884] Completed state [msg02.baremetal-mcp-ocata-odl-ha.local] at time 21:21:11.730225 duration_in_ms=0.657
2017-09-14 21:21:11,730 [salt.state       ][INFO    ][8884] Running state [msg02] at time 21:21:11.730407
2017-09-14 21:21:11,731 [salt.state       ][INFO    ][8884] Executing state host.present for msg02
2017-09-14 21:21:11,731 [salt.state       ][INFO    ][8884] Host msg02 (10.167.4.42) already present
2017-09-14 21:21:11,731 [salt.state       ][INFO    ][8884] Completed state [msg02] at time 21:21:11.731079 duration_in_ms=0.671
2017-09-14 21:21:11,731 [salt.state       ][INFO    ][8884] Running state [msg03.baremetal-mcp-ocata-odl-ha.local] at time 21:21:11.731259
2017-09-14 21:21:11,731 [salt.state       ][INFO    ][8884] Executing state host.present for msg03.baremetal-mcp-ocata-odl-ha.local
2017-09-14 21:21:11,732 [salt.state       ][INFO    ][8884] Host msg03.baremetal-mcp-ocata-odl-ha.local (10.167.4.43) already present
2017-09-14 21:21:11,732 [salt.state       ][INFO    ][8884] Completed state [msg03.baremetal-mcp-ocata-odl-ha.local] at time 21:21:11.731921 duration_in_ms=0.662
2017-09-14 21:21:11,732 [salt.state       ][INFO    ][8884] Running state [msg03] at time 21:21:11.732106
2017-09-14 21:21:11,732 [salt.state       ][INFO    ][8884] Executing state host.present for msg03
2017-09-14 21:21:11,733 [salt.state       ][INFO    ][8884] Host msg03 (10.167.4.43) already present
2017-09-14 21:21:11,733 [salt.state       ][INFO    ][8884] Completed state [msg03] at time 21:21:11.732771 duration_in_ms=0.664
2017-09-14 21:21:11,733 [salt.state       ][INFO    ][8884] Running state [msg01.baremetal-mcp-ocata-odl-ha.local] at time 21:21:11.732970
2017-09-14 21:21:11,733 [salt.state       ][INFO    ][8884] Executing state host.present for msg01.baremetal-mcp-ocata-odl-ha.local
2017-09-14 21:21:11,733 [salt.state       ][INFO    ][8884] Host msg01.baremetal-mcp-ocata-odl-ha.local (10.167.4.41) already present
2017-09-14 21:21:11,734 [salt.state       ][INFO    ][8884] Completed state [msg01.baremetal-mcp-ocata-odl-ha.local] at time 21:21:11.733635 duration_in_ms=0.664
2017-09-14 21:21:11,734 [salt.state       ][INFO    ][8884] Running state [msg01] at time 21:21:11.733818
2017-09-14 21:21:11,734 [salt.state       ][INFO    ][8884] Executing state host.present for msg01
2017-09-14 21:21:11,734 [salt.state       ][INFO    ][8884] Host msg01 (10.167.4.41) already present
2017-09-14 21:21:11,735 [salt.state       ][INFO    ][8884] Completed state [msg01] at time 21:21:11.734489 duration_in_ms=0.672
2017-09-14 21:21:11,735 [salt.state       ][INFO    ][8884] Running state [msg] at time 21:21:11.734674
2017-09-14 21:21:11,735 [salt.state       ][INFO    ][8884] Executing state host.present for msg
2017-09-14 21:21:11,735 [salt.state       ][INFO    ][8884] Host msg (10.167.4.40) already present
2017-09-14 21:21:11,735 [salt.state       ][INFO    ][8884] Completed state [msg] at time 21:21:11.735332 duration_in_ms=0.658
2017-09-14 21:21:11,736 [salt.state       ][INFO    ][8884] Running state [msg.baremetal-mcp-ocata-odl-ha.local] at time 21:21:11.735516
2017-09-14 21:21:11,736 [salt.state       ][INFO    ][8884] Executing state host.present for msg.baremetal-mcp-ocata-odl-ha.local
2017-09-14 21:21:11,736 [salt.state       ][INFO    ][8884] Host msg.baremetal-mcp-ocata-odl-ha.local (10.167.4.40) already present
2017-09-14 21:21:11,736 [salt.state       ][INFO    ][8884] Completed state [msg.baremetal-mcp-ocata-odl-ha.local] at time 21:21:11.736183 duration_in_ms=0.667
2017-09-14 21:21:11,736 [salt.state       ][INFO    ][8884] Running state [cfg01.baremetal-mcp-ocata-odl-ha.local] at time 21:21:11.736367
2017-09-14 21:21:11,737 [salt.state       ][INFO    ][8884] Executing state host.present for cfg01.baremetal-mcp-ocata-odl-ha.local
2017-09-14 21:21:11,737 [salt.state       ][INFO    ][8884] Host cfg01.baremetal-mcp-ocata-odl-ha.local (10.167.4.100) already present
2017-09-14 21:21:11,737 [salt.state       ][INFO    ][8884] Completed state [cfg01.baremetal-mcp-ocata-odl-ha.local] at time 21:21:11.737043 duration_in_ms=0.676
2017-09-14 21:21:11,737 [salt.state       ][INFO    ][8884] Running state [cfg01] at time 21:21:11.737227
2017-09-14 21:21:11,737 [salt.state       ][INFO    ][8884] Executing state host.present for cfg01
2017-09-14 21:21:11,738 [salt.state       ][INFO    ][8884] Host cfg01 (10.167.4.100) already present
2017-09-14 21:21:11,738 [salt.state       ][INFO    ][8884] Completed state [cfg01] at time 21:21:11.737943 duration_in_ms=0.716
2017-09-14 21:21:11,738 [salt.state       ][INFO    ][8884] Running state [cmp002] at time 21:21:11.738127
2017-09-14 21:21:11,738 [salt.state       ][INFO    ][8884] Executing state host.present for cmp002
2017-09-14 21:21:11,739 [salt.state       ][INFO    ][8884] Host cmp002 (10.167.4.102) already present
2017-09-14 21:21:11,739 [salt.state       ][INFO    ][8884] Completed state [cmp002] at time 21:21:11.738814 duration_in_ms=0.687
2017-09-14 21:21:11,739 [salt.state       ][INFO    ][8884] Running state [cmp002.baremetal-mcp-ocata-odl-ha.local] at time 21:21:11.738995
2017-09-14 21:21:11,739 [salt.state       ][INFO    ][8884] Executing state host.present for cmp002.baremetal-mcp-ocata-odl-ha.local
2017-09-14 21:21:11,740 [salt.state       ][INFO    ][8884] Host cmp002.baremetal-mcp-ocata-odl-ha.local (10.167.4.102) already present
2017-09-14 21:21:11,740 [salt.state       ][INFO    ][8884] Completed state [cmp002.baremetal-mcp-ocata-odl-ha.local] at time 21:21:11.739656 duration_in_ms=0.66
2017-09-14 21:21:11,740 [salt.state       ][INFO    ][8884] Running state [cmp001] at time 21:21:11.739838
2017-09-14 21:21:11,740 [salt.state       ][INFO    ][8884] Executing state host.present for cmp001
2017-09-14 21:21:11,740 [salt.state       ][INFO    ][8884] Host cmp001 (10.167.4.101) already present
2017-09-14 21:21:11,741 [salt.state       ][INFO    ][8884] Completed state [cmp001] at time 21:21:11.740495 duration_in_ms=0.657
2017-09-14 21:21:11,741 [salt.state       ][INFO    ][8884] Running state [cmp001.baremetal-mcp-ocata-odl-ha.local] at time 21:21:11.740678
2017-09-14 21:21:11,741 [salt.state       ][INFO    ][8884] Executing state host.present for cmp001.baremetal-mcp-ocata-odl-ha.local
2017-09-14 21:21:11,741 [salt.state       ][INFO    ][8884] Host cmp001.baremetal-mcp-ocata-odl-ha.local (10.167.4.101) already present
2017-09-14 21:21:11,741 [salt.state       ][INFO    ][8884] Completed state [cmp001.baremetal-mcp-ocata-odl-ha.local] at time 21:21:11.741347 duration_in_ms=0.668
2017-09-14 21:21:11,742 [salt.state       ][INFO    ][8884] Running state [dbs01.baremetal-mcp-ocata-odl-ha.local] at time 21:21:11.741528
2017-09-14 21:21:11,742 [salt.state       ][INFO    ][8884] Executing state host.present for dbs01.baremetal-mcp-ocata-odl-ha.local
2017-09-14 21:21:11,742 [salt.state       ][INFO    ][8884] Host dbs01.baremetal-mcp-ocata-odl-ha.local (10.167.4.51) already present
2017-09-14 21:21:11,742 [salt.state       ][INFO    ][8884] Completed state [dbs01.baremetal-mcp-ocata-odl-ha.local] at time 21:21:11.742185 duration_in_ms=0.656
2017-09-14 21:21:11,742 [salt.state       ][INFO    ][8884] Running state [dbs01] at time 21:21:11.742367
2017-09-14 21:21:11,743 [salt.state       ][INFO    ][8884] Executing state host.present for dbs01
2017-09-14 21:21:11,743 [salt.state       ][INFO    ][8884] Host dbs01 (10.167.4.51) already present
2017-09-14 21:21:11,743 [salt.state       ][INFO    ][8884] Completed state [dbs01] at time 21:21:11.743033 duration_in_ms=0.667
2017-09-14 21:21:11,743 [salt.state       ][INFO    ][8884] Running state [dbs02.baremetal-mcp-ocata-odl-ha.local] at time 21:21:11.743216
2017-09-14 21:21:11,743 [salt.state       ][INFO    ][8884] Executing state host.present for dbs02.baremetal-mcp-ocata-odl-ha.local
2017-09-14 21:21:11,744 [salt.state       ][INFO    ][8884] Host dbs02.baremetal-mcp-ocata-odl-ha.local (10.167.4.52) already present
2017-09-14 21:21:11,744 [salt.state       ][INFO    ][8884] Completed state [dbs02.baremetal-mcp-ocata-odl-ha.local] at time 21:21:11.744030 duration_in_ms=0.814
2017-09-14 21:21:11,744 [salt.state       ][INFO    ][8884] Running state [dbs02] at time 21:21:11.744215
2017-09-14 21:21:11,744 [salt.state       ][INFO    ][8884] Executing state host.present for dbs02
2017-09-14 21:21:11,745 [salt.state       ][INFO    ][8884] Host dbs02 (10.167.4.52) already present
2017-09-14 21:21:11,745 [salt.state       ][INFO    ][8884] Completed state [dbs02] at time 21:21:11.744873 duration_in_ms=0.658
2017-09-14 21:21:11,745 [salt.state       ][INFO    ][8884] Running state [dbs03.baremetal-mcp-ocata-odl-ha.local] at time 21:21:11.745062
2017-09-14 21:21:11,745 [salt.state       ][INFO    ][8884] Executing state host.present for dbs03.baremetal-mcp-ocata-odl-ha.local
2017-09-14 21:21:11,746 [salt.state       ][INFO    ][8884] Host dbs03.baremetal-mcp-ocata-odl-ha.local (10.167.4.53) already present
2017-09-14 21:21:11,746 [salt.state       ][INFO    ][8884] Completed state [dbs03.baremetal-mcp-ocata-odl-ha.local] at time 21:21:11.745721 duration_in_ms=0.659
2017-09-14 21:21:11,746 [salt.state       ][INFO    ][8884] Running state [dbs03] at time 21:21:11.745905
2017-09-14 21:21:11,746 [salt.state       ][INFO    ][8884] Executing state host.present for dbs03
2017-09-14 21:21:11,746 [salt.state       ][INFO    ][8884] Host dbs03 (10.167.4.53) already present
2017-09-14 21:21:11,747 [salt.state       ][INFO    ][8884] Completed state [dbs03] at time 21:21:11.746599 duration_in_ms=0.695
2017-09-14 21:21:11,747 [salt.state       ][INFO    ][8884] Running state [odl01.baremetal-mcp-ocata-odl-ha.local] at time 21:21:11.746782
2017-09-14 21:21:11,747 [salt.state       ][INFO    ][8884] Executing state host.present for odl01.baremetal-mcp-ocata-odl-ha.local
2017-09-14 21:21:11,747 [salt.state       ][INFO    ][8884] Host odl01.baremetal-mcp-ocata-odl-ha.local (10.167.4.111) already present
2017-09-14 21:21:11,747 [salt.state       ][INFO    ][8884] Completed state [odl01.baremetal-mcp-ocata-odl-ha.local] at time 21:21:11.747441 duration_in_ms=0.658
2017-09-14 21:21:11,748 [salt.state       ][INFO    ][8884] Running state [odl01] at time 21:21:11.747624
2017-09-14 21:21:11,748 [salt.state       ][INFO    ][8884] Executing state host.present for odl01
2017-09-14 21:21:11,748 [salt.state       ][INFO    ][8884] Host odl01 (10.167.4.111) already present
2017-09-14 21:21:11,748 [salt.state       ][INFO    ][8884] Completed state [odl01] at time 21:21:11.748279 duration_in_ms=0.654
2017-09-14 21:21:11,749 [salt.state       ][INFO    ][8884] Running state [file.replace] at time 21:21:11.749035
2017-09-14 21:21:11,749 [salt.state       ][INFO    ][8884] Executing state module.run for file.replace
2017-09-14 21:21:12,415 [salt.loaded.int.module.cmdmod][INFO    ][8884] Executing command 'grep -q "odl01 odl01.baremetal-mcp-ocata-odl-ha.local" /etc/hosts' in directory '/root'
2017-09-14 21:21:12,421 [salt.state       ][INFO    ][8884] onlyif execution failed
2017-09-14 21:21:12,422 [salt.state       ][INFO    ][8884] Completed state [file.replace] at time 21:21:12.421464 duration_in_ms=672.428
2017-09-14 21:21:12,422 [salt.state       ][INFO    ][8884] Running state [mas01.baremetal-mcp-ocata-odl-ha.local] at time 21:21:12.421733
2017-09-14 21:21:12,422 [salt.state       ][INFO    ][8884] Executing state host.present for mas01.baremetal-mcp-ocata-odl-ha.local
2017-09-14 21:21:12,422 [salt.state       ][INFO    ][8884] Host mas01.baremetal-mcp-ocata-odl-ha.local (10.167.4.3) already present
2017-09-14 21:21:12,423 [salt.state       ][INFO    ][8884] Completed state [mas01.baremetal-mcp-ocata-odl-ha.local] at time 21:21:12.422632 duration_in_ms=0.899
2017-09-14 21:21:12,423 [salt.state       ][INFO    ][8884] Running state [mas01] at time 21:21:12.422827
2017-09-14 21:21:12,423 [salt.state       ][INFO    ][8884] Executing state host.present for mas01
2017-09-14 21:21:12,423 [salt.state       ][INFO    ][8884] Host mas01 (10.167.4.3) already present
2017-09-14 21:21:12,424 [salt.state       ][INFO    ][8884] Completed state [mas01] at time 21:21:12.423513 duration_in_ms=0.685
2017-09-14 21:21:12,424 [salt.state       ][INFO    ][8884] Running state [ctl02.baremetal-mcp-ocata-odl-ha.local] at time 21:21:12.423704
2017-09-14 21:21:12,424 [salt.state       ][INFO    ][8884] Executing state host.present for ctl02.baremetal-mcp-ocata-odl-ha.local
2017-09-14 21:21:12,424 [salt.state       ][INFO    ][8884] Host ctl02.baremetal-mcp-ocata-odl-ha.local (10.167.4.12) already present
2017-09-14 21:21:12,424 [salt.state       ][INFO    ][8884] Completed state [ctl02.baremetal-mcp-ocata-odl-ha.local] at time 21:21:12.424375 duration_in_ms=0.67
2017-09-14 21:21:12,425 [salt.state       ][INFO    ][8884] Running state [ctl02] at time 21:21:12.424557
2017-09-14 21:21:12,425 [salt.state       ][INFO    ][8884] Executing state host.present for ctl02
2017-09-14 21:21:12,425 [salt.state       ][INFO    ][8884] Host ctl02 (10.167.4.12) already present
2017-09-14 21:21:12,425 [salt.state       ][INFO    ][8884] Completed state [ctl02] at time 21:21:12.425231 duration_in_ms=0.673
2017-09-14 21:21:12,425 [salt.state       ][INFO    ][8884] Running state [ctl03.baremetal-mcp-ocata-odl-ha.local] at time 21:21:12.425413
2017-09-14 21:21:12,426 [salt.state       ][INFO    ][8884] Executing state host.present for ctl03.baremetal-mcp-ocata-odl-ha.local
2017-09-14 21:21:12,426 [salt.state       ][INFO    ][8884] Host ctl03.baremetal-mcp-ocata-odl-ha.local (10.167.4.13) already present
2017-09-14 21:21:12,426 [salt.state       ][INFO    ][8884] Completed state [ctl03.baremetal-mcp-ocata-odl-ha.local] at time 21:21:12.426080 duration_in_ms=0.668
2017-09-14 21:21:12,426 [salt.state       ][INFO    ][8884] Running state [ctl03] at time 21:21:12.426263
2017-09-14 21:21:12,426 [salt.state       ][INFO    ][8884] Executing state host.present for ctl03
2017-09-14 21:21:12,427 [salt.state       ][INFO    ][8884] Host ctl03 (10.167.4.13) already present
2017-09-14 21:21:12,427 [salt.state       ][INFO    ][8884] Completed state [ctl03] at time 21:21:12.426945 duration_in_ms=0.682
2017-09-14 21:21:12,427 [salt.state       ][INFO    ][8884] Running state [ctl01.baremetal-mcp-ocata-odl-ha.local] at time 21:21:12.427127
2017-09-14 21:21:12,427 [salt.state       ][INFO    ][8884] Executing state host.present for ctl01.baremetal-mcp-ocata-odl-ha.local
2017-09-14 21:21:12,428 [salt.state       ][INFO    ][8884] Host ctl01.baremetal-mcp-ocata-odl-ha.local (10.167.4.11) already present
2017-09-14 21:21:12,428 [salt.state       ][INFO    ][8884] Completed state [ctl01.baremetal-mcp-ocata-odl-ha.local] at time 21:21:12.427789 duration_in_ms=0.662
2017-09-14 21:21:12,428 [salt.state       ][INFO    ][8884] Running state [ctl01] at time 21:21:12.427973
2017-09-14 21:21:12,428 [salt.state       ][INFO    ][8884] Executing state host.present for ctl01
2017-09-14 21:21:12,428 [salt.state       ][INFO    ][8884] Host ctl01 (10.167.4.11) already present
2017-09-14 21:21:12,429 [salt.state       ][INFO    ][8884] Completed state [ctl01] at time 21:21:12.428637 duration_in_ms=0.664
2017-09-14 21:21:12,429 [salt.state       ][INFO    ][8884] Running state [ctl] at time 21:21:12.428820
2017-09-14 21:21:12,429 [salt.state       ][INFO    ][8884] Executing state host.present for ctl
2017-09-14 21:21:12,429 [salt.state       ][INFO    ][8884] Host ctl (10.167.4.10) already present
2017-09-14 21:21:12,430 [salt.state       ][INFO    ][8884] Completed state [ctl] at time 21:21:12.429492 duration_in_ms=0.672
2017-09-14 21:21:12,430 [salt.state       ][INFO    ][8884] Running state [ctl.baremetal-mcp-ocata-odl-ha.local] at time 21:21:12.429683
2017-09-14 21:21:12,430 [salt.state       ][INFO    ][8884] Executing state host.present for ctl.baremetal-mcp-ocata-odl-ha.local
2017-09-14 21:21:12,430 [salt.state       ][INFO    ][8884] Host ctl.baremetal-mcp-ocata-odl-ha.local (10.167.4.10) already present
2017-09-14 21:21:12,430 [salt.state       ][INFO    ][8884] Completed state [ctl.baremetal-mcp-ocata-odl-ha.local] at time 21:21:12.430346 duration_in_ms=0.662
2017-09-14 21:21:12,431 [salt.state       ][INFO    ][8884] Running state [ens3] at time 21:21:12.430549
2017-09-14 21:21:12,431 [salt.state       ][INFO    ][8884] Executing state network.managed for ens3
2017-09-14 21:21:12,723 [salt.state       ][INFO    ][8884] Interface ens3 is up to date.
2017-09-14 21:21:12,723 [salt.state       ][INFO    ][8884] Completed state [ens3] at time 21:21:12.723168 duration_in_ms=292.618
2017-09-14 21:21:12,723 [salt.state       ][INFO    ][8884] Running state [/etc/profile.d/proxy.sh] at time 21:21:12.723462
2017-09-14 21:21:12,724 [salt.state       ][INFO    ][8884] Executing state file.absent for /etc/profile.d/proxy.sh
2017-09-14 21:21:12,724 [salt.state       ][INFO    ][8884] File /etc/profile.d/proxy.sh is not present
2017-09-14 21:21:12,724 [salt.state       ][INFO    ][8884] Completed state [/etc/profile.d/proxy.sh] at time 21:21:12.724354 duration_in_ms=0.893
2017-09-14 21:21:12,725 [salt.state       ][INFO    ][8884] Running state [/etc/apt/apt.conf.d/95proxies] at time 21:21:12.724603
2017-09-14 21:21:12,725 [salt.state       ][INFO    ][8884] Executing state file.absent for /etc/apt/apt.conf.d/95proxies
2017-09-14 21:21:12,725 [salt.state       ][INFO    ][8884] File /etc/apt/apt.conf.d/95proxies is not present
2017-09-14 21:21:12,725 [salt.state       ][INFO    ][8884] Completed state [/etc/apt/apt.conf.d/95proxies] at time 21:21:12.725393 duration_in_ms=0.789
2017-09-14 21:21:12,726 [salt.state       ][INFO    ][8884] Running state [ntp] at time 21:21:12.725643
2017-09-14 21:21:12,726 [salt.state       ][INFO    ][8884] Executing state pkg.installed for ntp
2017-09-14 21:21:12,729 [salt.state       ][INFO    ][8884] Package ntp is already installed
2017-09-14 21:21:12,730 [salt.state       ][INFO    ][8884] Completed state [ntp] at time 21:21:12.729561 duration_in_ms=3.916
2017-09-14 21:21:12,731 [salt.state       ][INFO    ][8884] Running state [/etc/ntp.conf] at time 21:21:12.730530
2017-09-14 21:21:12,731 [salt.state       ][INFO    ][8884] Executing state file.managed for /etc/ntp.conf
2017-09-14 21:21:12,752 [salt.fileclient  ][INFO    ][8884] Fetching file from saltenv 'base', ** done ** 'ntp/files/ntp.conf'
2017-09-14 21:21:12,779 [salt.fileclient  ][INFO    ][8884] Fetching file from saltenv 'base', ** done ** 'ntp/map.jinja'
2017-09-14 21:21:12,785 [salt.state       ][INFO    ][8884] File /etc/ntp.conf is in the correct state
2017-09-14 21:21:12,786 [salt.state       ][INFO    ][8884] Completed state [/etc/ntp.conf] at time 21:21:12.785675 duration_in_ms=55.144
2017-09-14 21:21:12,787 [salt.state       ][INFO    ][8884] Running state [ntp] at time 21:21:12.786620
2017-09-14 21:21:12,787 [salt.state       ][INFO    ][8884] Executing state service.running for ntp
2017-09-14 21:21:12,787 [salt.loaded.int.module.cmdmod][INFO    ][8884] Executing command ['systemctl', 'status', 'ntp.service', '-n', '0'] in directory '/root'
2017-09-14 21:21:12,799 [salt.loaded.int.module.cmdmod][INFO    ][8884] Executing command ['systemctl', 'is-active', 'ntp.service'] in directory '/root'
2017-09-14 21:21:12,809 [salt.loaded.int.module.cmdmod][INFO    ][8884] Executing command ['systemctl', 'is-enabled', 'ntp.service'] in directory '/root'
2017-09-14 21:21:12,821 [salt.state       ][INFO    ][8884] The service ntp is already running
2017-09-14 21:21:12,821 [salt.state       ][INFO    ][8884] Completed state [ntp] at time 21:21:12.821152 duration_in_ms=34.53
2017-09-14 21:21:12,825 [salt.minion      ][INFO    ][8884] Returning information for job: 20170914212036914919
2017-09-14 21:22:49,121 [salt.minion      ][INFO    ][1503] User sudo_ubuntu Executing command ssh.set_auth_key with jid 20170914212249106239
2017-09-14 21:22:49,160 [salt.minion      ][INFO    ][15343] Starting a new job with PID 15343
2017-09-14 21:22:49,207 [salt.minion      ][INFO    ][15343] Returning information for job: 20170914212249106239
2017-09-14 21:22:50,551 [salt.minion      ][INFO    ][1503] User sudo_ubuntu Executing command state.sls with jid 20170914212250538882
2017-09-14 21:22:50,565 [salt.minion      ][INFO    ][15348] Starting a new job with PID 15348
2017-09-14 21:22:52,028 [salt.state       ][INFO    ][15348] Loading fresh modules for state activity
2017-09-14 21:22:52,053 [salt.fileclient  ][INFO    ][15348] Fetching file from saltenv 'base', ** done ** 'opendaylight/init.sls'
2017-09-14 21:22:52,070 [salt.fileclient  ][INFO    ][15348] Fetching file from saltenv 'base', ** done ** 'opendaylight/server.sls'
2017-09-14 21:22:52,088 [salt.fileclient  ][INFO    ][15348] Fetching file from saltenv 'base', ** done ** 'opendaylight/map.jinja'
2017-09-14 21:22:52,113 [salt.state       ][INFO    ][15348] Running state [opendaylight_repo] at time 21:22:52.112838
2017-09-14 21:22:52,113 [salt.state       ][INFO    ][15348] Executing state pkgrepo.managed for opendaylight_repo
2017-09-14 21:22:52,180 [salt.loaded.int.module.cmdmod][INFO    ][15348] Executing command ['apt-add-repository', '-y', 'ppa:odl-team/carbon'] in directory '/root'
2017-09-14 21:22:54,340 [salt.loaded.int.module.cmdmod][INFO    ][15348] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-09-14 21:22:56,698 [salt.state       ][INFO    ][15348] {'repo': 'ppa:odl-team/carbon'}
2017-09-14 21:22:56,698 [salt.state       ][INFO    ][15348] Completed state [opendaylight_repo] at time 21:22:56.698292 duration_in_ms=4585.453
2017-09-14 21:22:56,897 [salt.state       ][INFO    ][15348] Running state [opendaylight] at time 21:22:56.896718
2017-09-14 21:22:56,897 [salt.state       ][INFO    ][15348] Executing state pkg.installed for opendaylight
2017-09-14 21:22:56,898 [salt.loaded.int.module.cmdmod][INFO    ][15348] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-14 21:22:57,356 [salt.loaded.int.module.cmdmod][INFO    ][15348] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-09-14 21:22:59,790 [salt.loaded.int.module.cmdmod][INFO    ][15348] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'opendaylight'] in directory '/root'
2017-09-14 21:23:00,645 [salt.minion      ][INFO    ][1503] User sudo_ubuntu Executing command saltutil.find_job with jid 20170914212300628441
2017-09-14 21:23:00,658 [salt.minion      ][INFO    ][16594] Starting a new job with PID 16594
2017-09-14 21:23:00,702 [salt.minion      ][INFO    ][16594] Returning information for job: 20170914212300628441
2017-09-14 21:23:10,866 [salt.minion      ][INFO    ][1503] User sudo_ubuntu Executing command saltutil.find_job with jid 20170914212310851693
2017-09-14 21:23:10,876 [salt.minion      ][INFO    ][16599] Starting a new job with PID 16599
2017-09-14 21:23:10,917 [salt.minion      ][INFO    ][16599] Returning information for job: 20170914212310851693
2017-09-14 21:23:21,079 [salt.minion      ][INFO    ][1503] User sudo_ubuntu Executing command saltutil.find_job with jid 20170914212321064632
2017-09-14 21:23:21,090 [salt.minion      ][INFO    ][16609] Starting a new job with PID 16609
2017-09-14 21:23:21,131 [salt.minion      ][INFO    ][16609] Returning information for job: 20170914212321064632
2017-09-14 21:23:31,293 [salt.minion      ][INFO    ][1503] User sudo_ubuntu Executing command saltutil.find_job with jid 20170914212331279935
2017-09-14 21:23:31,303 [salt.minion      ][INFO    ][16614] Starting a new job with PID 16614
2017-09-14 21:23:31,343 [salt.minion      ][INFO    ][16614] Returning information for job: 20170914212331279935
2017-09-14 21:23:41,505 [salt.minion      ][INFO    ][1503] User sudo_ubuntu Executing command saltutil.find_job with jid 20170914212341491706
2017-09-14 21:23:41,516 [salt.minion      ][INFO    ][16620] Starting a new job with PID 16620
2017-09-14 21:23:41,558 [salt.minion      ][INFO    ][16620] Returning information for job: 20170914212341491706
2017-09-14 21:23:51,728 [salt.minion      ][INFO    ][1503] User sudo_ubuntu Executing command saltutil.find_job with jid 20170914212351711480
2017-09-14 21:23:51,783 [salt.minion      ][INFO    ][16630] Starting a new job with PID 16630
2017-09-14 21:23:51,791 [salt.minion      ][INFO    ][16630] Returning information for job: 20170914212351711480
2017-09-14 21:24:01,751 [salt.minion      ][INFO    ][1503] User sudo_ubuntu Executing command saltutil.find_job with jid 20170914212401735043
2017-09-14 21:24:01,804 [salt.minion      ][INFO    ][16635] Starting a new job with PID 16635
2017-09-14 21:24:01,812 [salt.minion      ][INFO    ][16635] Returning information for job: 20170914212401735043
2017-09-14 21:24:11,813 [salt.minion      ][INFO    ][1503] User sudo_ubuntu Executing command saltutil.find_job with jid 20170914212411798264
2017-09-14 21:24:11,825 [salt.minion      ][INFO    ][16645] Starting a new job with PID 16645
2017-09-14 21:24:11,834 [salt.minion      ][INFO    ][16645] Returning information for job: 20170914212411798264
2017-09-14 21:24:22,005 [salt.minion      ][INFO    ][1503] User sudo_ubuntu Executing command saltutil.find_job with jid 20170914212421990467
2017-09-14 21:24:22,018 [salt.minion      ][INFO    ][16650] Starting a new job with PID 16650
2017-09-14 21:24:22,027 [salt.minion      ][INFO    ][16650] Returning information for job: 20170914212421990467
2017-09-14 21:24:32,201 [salt.minion      ][INFO    ][1503] User sudo_ubuntu Executing command saltutil.find_job with jid 20170914212432186259
2017-09-14 21:24:32,214 [salt.minion      ][INFO    ][16807] Starting a new job with PID 16807
2017-09-14 21:24:32,223 [salt.minion      ][INFO    ][16807] Returning information for job: 20170914212432186259
2017-09-14 21:24:42,400 [salt.minion      ][INFO    ][1503] User sudo_ubuntu Executing command saltutil.find_job with jid 20170914212442385768
2017-09-14 21:24:42,413 [salt.minion      ][INFO    ][16812] Starting a new job with PID 16812
2017-09-14 21:24:42,422 [salt.minion      ][INFO    ][16812] Returning information for job: 20170914212442385768
2017-09-14 21:24:52,599 [salt.minion      ][INFO    ][1503] User sudo_ubuntu Executing command saltutil.find_job with jid 20170914212452582833
2017-09-14 21:24:52,610 [salt.minion      ][INFO    ][16817] Starting a new job with PID 16817
2017-09-14 21:24:52,618 [salt.minion      ][INFO    ][16817] Returning information for job: 20170914212452582833
2017-09-14 21:25:02,798 [salt.minion      ][INFO    ][1503] User sudo_ubuntu Executing command saltutil.find_job with jid 20170914212502780570
2017-09-14 21:25:02,813 [salt.minion      ][INFO    ][16822] Starting a new job with PID 16822
2017-09-14 21:25:02,822 [salt.minion      ][INFO    ][16822] Returning information for job: 20170914212502780570
2017-09-14 21:25:13,005 [salt.minion      ][INFO    ][1503] User sudo_ubuntu Executing command saltutil.find_job with jid 20170914212512987287
2017-09-14 21:25:13,016 [salt.minion      ][INFO    ][16832] Starting a new job with PID 16832
2017-09-14 21:25:13,025 [salt.minion      ][INFO    ][16832] Returning information for job: 20170914212512987287
2017-09-14 21:25:23,209 [salt.minion      ][INFO    ][1503] User sudo_ubuntu Executing command saltutil.find_job with jid 20170914212523190888
2017-09-14 21:25:23,222 [salt.minion      ][INFO    ][16837] Starting a new job with PID 16837
2017-09-14 21:25:23,230 [salt.minion      ][INFO    ][16837] Returning information for job: 20170914212523190888
2017-09-14 21:25:33,417 [salt.minion      ][INFO    ][1503] User sudo_ubuntu Executing command saltutil.find_job with jid 20170914212533399279
2017-09-14 21:25:33,428 [salt.minion      ][INFO    ][16842] Starting a new job with PID 16842
2017-09-14 21:25:33,437 [salt.minion      ][INFO    ][16842] Returning information for job: 20170914212533399279
2017-09-14 21:25:43,622 [salt.minion      ][INFO    ][1503] User sudo_ubuntu Executing command saltutil.find_job with jid 20170914212543604945
2017-09-14 21:25:43,636 [salt.minion      ][INFO    ][16852] Starting a new job with PID 16852
2017-09-14 21:25:43,646 [salt.minion      ][INFO    ][16852] Returning information for job: 20170914212543604945
2017-09-14 21:25:53,833 [salt.minion      ][INFO    ][1503] User sudo_ubuntu Executing command saltutil.find_job with jid 20170914212553815997
2017-09-14 21:25:53,845 [salt.minion      ][INFO    ][16857] Starting a new job with PID 16857
2017-09-14 21:25:53,853 [salt.minion      ][INFO    ][16857] Returning information for job: 20170914212553815997
2017-09-14 21:26:04,044 [salt.minion      ][INFO    ][1503] User sudo_ubuntu Executing command saltutil.find_job with jid 20170914212604027205
2017-09-14 21:26:04,057 [salt.minion      ][INFO    ][16867] Starting a new job with PID 16867
2017-09-14 21:26:04,065 [salt.minion      ][INFO    ][16867] Returning information for job: 20170914212604027205
2017-09-14 21:26:14,260 [salt.minion      ][INFO    ][1503] User sudo_ubuntu Executing command saltutil.find_job with jid 20170914212614244105
2017-09-14 21:26:14,272 [salt.minion      ][INFO    ][16872] Starting a new job with PID 16872
2017-09-14 21:26:14,281 [salt.minion      ][INFO    ][16872] Returning information for job: 20170914212614244105
2017-09-14 21:26:24,478 [salt.minion      ][INFO    ][1503] User sudo_ubuntu Executing command saltutil.find_job with jid 20170914212624463436
2017-09-14 21:26:24,489 [salt.minion      ][INFO    ][16882] Starting a new job with PID 16882
2017-09-14 21:26:24,497 [salt.minion      ][INFO    ][16882] Returning information for job: 20170914212624463436
2017-09-14 21:26:34,695 [salt.minion      ][INFO    ][1503] User sudo_ubuntu Executing command saltutil.find_job with jid 20170914212634679975
2017-09-14 21:26:34,707 [salt.minion      ][INFO    ][16887] Starting a new job with PID 16887
2017-09-14 21:26:34,715 [salt.minion      ][INFO    ][16887] Returning information for job: 20170914212634679975
2017-09-14 21:26:44,918 [salt.minion      ][INFO    ][1503] User sudo_ubuntu Executing command saltutil.find_job with jid 20170914212644902392
2017-09-14 21:26:44,932 [salt.minion      ][INFO    ][16897] Starting a new job with PID 16897
2017-09-14 21:26:44,942 [salt.minion      ][INFO    ][16897] Returning information for job: 20170914212644902392
2017-09-14 21:26:54,946 [salt.minion      ][INFO    ][1503] User sudo_ubuntu Executing command saltutil.find_job with jid 20170914212654921918
2017-09-14 21:26:54,957 [salt.minion      ][INFO    ][16902] Starting a new job with PID 16902
2017-09-14 21:26:54,966 [salt.minion      ][INFO    ][16902] Returning information for job: 20170914212654921918
2017-09-14 21:27:04,968 [salt.minion      ][INFO    ][1503] User sudo_ubuntu Executing command saltutil.find_job with jid 20170914212704952112
2017-09-14 21:27:04,982 [salt.minion      ][INFO    ][17048] Starting a new job with PID 17048
2017-09-14 21:27:04,992 [salt.minion      ][INFO    ][17048] Returning information for job: 20170914212704952112
2017-09-14 21:27:15,019 [salt.minion      ][INFO    ][1503] User sudo_ubuntu Executing command saltutil.find_job with jid 20170914212714983735
2017-09-14 21:27:15,029 [salt.minion      ][INFO    ][17132] Starting a new job with PID 17132
2017-09-14 21:27:15,038 [salt.minion      ][INFO    ][17132] Returning information for job: 20170914212714983735
2017-09-14 21:27:25,050 [salt.minion      ][INFO    ][1503] User sudo_ubuntu Executing command saltutil.find_job with jid 20170914212725034382
2017-09-14 21:27:25,064 [salt.minion      ][INFO    ][17137] Starting a new job with PID 17137
2017-09-14 21:27:25,072 [salt.minion      ][INFO    ][17137] Returning information for job: 20170914212725034382
2017-09-14 21:27:35,082 [salt.minion      ][INFO    ][1503] User sudo_ubuntu Executing command saltutil.find_job with jid 20170914212735067161
2017-09-14 21:27:35,094 [salt.minion      ][INFO    ][17142] Starting a new job with PID 17142
2017-09-14 21:27:35,103 [salt.minion      ][INFO    ][17142] Returning information for job: 20170914212735067161
2017-09-14 21:27:45,117 [salt.minion      ][INFO    ][1503] User sudo_ubuntu Executing command saltutil.find_job with jid 20170914212745102146
2017-09-14 21:27:45,131 [salt.minion      ][INFO    ][17152] Starting a new job with PID 17152
2017-09-14 21:27:45,177 [salt.minion      ][INFO    ][17152] Returning information for job: 20170914212745102146
2017-09-14 21:27:55,205 [salt.minion      ][INFO    ][1503] User sudo_ubuntu Executing command saltutil.find_job with jid 20170914212755190519
2017-09-14 21:27:55,219 [salt.minion      ][INFO    ][18135] Starting a new job with PID 18135
2017-09-14 21:27:55,243 [salt.minion      ][INFO    ][18135] Returning information for job: 20170914212755190519
2017-09-14 21:28:05,269 [salt.minion      ][INFO    ][1503] User sudo_ubuntu Executing command saltutil.find_job with jid 20170914212805254754
2017-09-14 21:28:05,283 [salt.minion      ][INFO    ][19175] Starting a new job with PID 19175
2017-09-14 21:28:05,327 [salt.minion      ][INFO    ][19175] Returning information for job: 20170914212805254754
2017-09-14 21:28:07,279 [salt.loaded.int.module.cmdmod][INFO    ][15348] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-14 21:28:07,305 [salt.state       ][INFO    ][15348] Made the following changes:
'java-common' changed from 'absent' to '0.56ubuntu2'
'libxtst6' changed from 'absent' to '2:1.2.2-1'
'liblcms2-2' changed from 'absent' to '2.6-3ubuntu2'
'openjdk-8-jre-headless' changed from 'absent' to '8u131-b11-2ubuntu1.16.04.3'
'libxrender1' changed from 'absent' to '1:0.9.9-0ubuntu1'
'libavahi-common3' changed from 'absent' to '0.6.32~rc+dfsg-1ubuntu2'
'libnspr4' changed from 'absent' to '2:4.13.1-0ubuntu0.16.04.1'
'libfontconfig' changed from 'absent' to '1'
'fonts-dejavu-core' changed from 'absent' to '2.35-1'
'libnss3-nssdb' changed from 'absent' to '2:3.28.4-0ubuntu0.16.04.2'
'java8-runtime-headless' changed from 'absent' to '1'
'libcups2' changed from 'absent' to '2.1.3-4ubuntu0.3'
'libjpeg-turbo8' changed from 'absent' to '1.4.2-0ubuntu3'
'libavahi-client3' changed from 'absent' to '0.6.32~rc+dfsg-1ubuntu2'
'libnss3' changed from 'absent' to '2:3.28.4-0ubuntu0.16.04.2'
'libpcsclite1' changed from 'absent' to '1.8.14-1ubuntu1.16.04.1'
'java7-runtime-headless' changed from 'absent' to '1'
'ca-certificates-java' changed from 'absent' to '20160321'
'java2-runtime-headless' changed from 'absent' to '1'
'fontconfig-config' changed from 'absent' to '2.11.94-0ubuntu1.1'
'libavahi-common-data' changed from 'absent' to '0.6.32~rc+dfsg-1ubuntu2'
'libxi6' changed from 'absent' to '2:1.7.6-1'
'java5-runtime-headless' changed from 'absent' to '1'
'java6-runtime-headless' changed from 'absent' to '1'
'x11-common' changed from 'absent' to '1:7.7+13ubuntu3'
'libjpeg8' changed from 'absent' to '8c-2ubuntu8'
'opendaylight' changed from 'absent' to '6.1.0-1'
'libfontconfig1' changed from 'absent' to '2.11.94-0ubuntu1.1'

2017-09-14 21:28:07,315 [salt.state       ][INFO    ][15348] Loading fresh modules for state activity
2017-09-14 21:28:07,328 [salt.state       ][INFO    ][15348] Completed state [opendaylight] at time 21:28:07.327986 duration_in_ms=310431.267
2017-09-14 21:28:07,393 [salt.state       ][INFO    ][15348] Running state [/opt/opendaylight/etc/jetty.xml] at time 21:28:07.393267
2017-09-14 21:28:07,394 [salt.state       ][INFO    ][15348] Executing state file.managed for /opt/opendaylight/etc/jetty.xml
2017-09-14 21:28:07,420 [salt.fileclient  ][INFO    ][15348] Fetching file from saltenv 'base', ** done ** 'opendaylight/files/jetty.xml'
2017-09-14 21:28:07,446 [salt.fileclient  ][INFO    ][15348] Fetching file from saltenv 'base', ** done ** 'opendaylight/map.jinja'
2017-09-14 21:28:07,456 [salt.state       ][INFO    ][15348] File changed:
--- 
+++ 
@@ -33,7 +33,7 @@
     <Call name="addConnector">
         <Arg>
             <New class="org.eclipse.jetty.server.nio.SelectChannelConnector">
-                <Set name="host">
+                <Set name="host">10.167.4.111
                     <Property name="jetty.host" />
                 </Set>
                 <Set name="port">
@@ -51,11 +51,11 @@
     <Call name="addConnector">
       <Arg>
         <New class="org.eclipse.jetty.server.nio.SelectChannelConnector">
-          <Set name="host">
+          <Set name="host">10.167.4.111
             <Property name="jetty.host" />
           </Set>
           <Set name="port">
-            <Property name="jetty.port" default="8080" />
+            <Property name="jetty.port" default="8282" />
           </Set>
           <Set name="maxIdleTime">300000</Set>
           <Set name="Acceptors">2</Set>

2017-09-14 21:28:07,458 [salt.state       ][INFO    ][15348] Completed state [/opt/opendaylight/etc/jetty.xml] at time 21:28:07.457677 duration_in_ms=64.41
2017-09-14 21:28:07,458 [salt.state       ][INFO    ][15348] Running state [/opt/opendaylight/bin/setenv] at time 21:28:07.458030
2017-09-14 21:28:07,458 [salt.state       ][INFO    ][15348] Executing state file.managed for /opt/opendaylight/bin/setenv
2017-09-14 21:28:07,477 [salt.fileclient  ][INFO    ][15348] Fetching file from saltenv 'base', ** done ** 'opendaylight/files/setenv.shell'
2017-09-14 21:28:07,495 [salt.fileclient  ][INFO    ][15348] Fetching file from saltenv 'base', ** done ** 'opendaylight/map.jinja'
2017-09-14 21:28:07,509 [salt.state       ][INFO    ][15348] File changed:
--- 
+++ 
@@ -1,46 +1,9 @@
-#!/bin/sh
-#
-#    Licensed to the Apache Software Foundation (ASF) under one or more
-#    contributor license agreements.  See the NOTICE file distributed with
-#    this work for additional information regarding copyright ownership.
-#    The ASF licenses this file to You under the Apache License, Version 2.0
-#    (the "License"); you may not use this file except in compliance with
-#    the License.  You may obtain a copy of the License at
-#
-#       http://www.apache.org/licenses/LICENSE-2.0
-#
-#    Unless required by applicable law or agreed to in writing, software
-#    distributed under the License is distributed on an "AS IS" BASIS,
-#    WITHOUT WARRANTIES OR CONDITIONS OF ANY KIND, either express or implied.
-#    See the License for the specific language governing permissions and
-#    limitations under the License.
-#
-
-#
-# handle specific scripts; the SCRIPT_NAME is exactly the name of the Karaf
-# script: client, instance, shell, start, status, stop, karaf
-#
-# if [ "$KARAF_SCRIPT" == "SCRIPT_NAME" ]; then
-#   Actions go here...
-# fi
-
-#
-# general settings which should be applied for all scripts go here; please keep
-# in mind that it is possible that scripts might be executed more than once, e.g.
-# in example of the start script where the start script is executed first and the
-# karaf script afterwards.
-#
-
-#
-# The following section shows the possible configuration options for the default
-# karaf scripts
-#
 # export JAVA_HOME # Location of Java installation
-# export JAVA_MIN_MEM # Minimum memory for the JVM
-# export JAVA_MAX_MEM # Maximum memory for the JVM
+export JAVA_MIN_MEM=4g # Minimum memory for the JVM
+export JAVA_MAX_MEM=4g # Maximum memory for the JVM
 # export JAVA_PERM_MEM # Minimum perm memory for the JVM
-# export JAVA_MAX_PERM_MEM # Maximum perm memory for the JVM
-# export EXTRA_JAVA_OPTS # Additional JVM options
+export JAVA_MAX_PERM_MEM=512m # Maximum perm memory for the JVM
+export EXTRA_JAVA_OPTS='-Djava.net.preferIPv4Stack=true -XX:+UseG1GC' # Additional JVM options
 # export KARAF_HOME # Karaf home folder
 # export KARAF_DATA # Karaf data folder
 # export KARAF_BASE # Karaf base folder
@@ -48,9 +11,4 @@
 # export KARAF_OPTS # Additional available Karaf options
 # export KARAF_DEBUG # Enable debug mode
 # export KARAF_REDIRECT # Enable/set the std/err redirection when using bin/start
-if [ "x$JAVA_MAX_PERM_MEM" = "x" ]; then
-    export JAVA_MAX_PERM_MEM="512m"
-fi
-if [ "x$JAVA_MAX_MEM" = "x" ]; then
-    export JAVA_MAX_MEM="2048m"
-fi
+

2017-09-14 21:28:07,509 [salt.state       ][INFO    ][15348] Completed state [/opt/opendaylight/bin/setenv] at time 21:28:07.508823 duration_in_ms=50.792
2017-09-14 21:28:07,510 [salt.state       ][INFO    ][15348] Running state [/opt/opendaylight/etc/org.apache.karaf.features.cfg] at time 21:28:07.509984
2017-09-14 21:28:07,510 [salt.state       ][INFO    ][15348] Executing state ini.options_present for /opt/opendaylight/etc/org.apache.karaf.features.cfg
2017-09-14 21:28:07,521 [salt.state       ][INFO    ][15348] {'featuresBoot': {'after': 'config,standard,region,package,kar,ssh,management,odl-restconf-all,odl-aaa-authn,odl-dlux-all,odl-netvirt-openstack', 'before': 'config,standard,region,package,kar,ssh,management'}}
2017-09-14 21:28:07,521 [salt.state       ][INFO    ][15348] Completed state [/opt/opendaylight/etc/org.apache.karaf.features.cfg] at time 21:28:07.521127 duration_in_ms=11.143
2017-09-14 21:28:07,522 [salt.state       ][INFO    ][15348] Running state [/opt/opendaylight/etc/custom.properties] at time 21:28:07.521659
2017-09-14 21:28:07,522 [salt.state       ][INFO    ][15348] Executing state ini.options_present for /opt/opendaylight/etc/custom.properties
2017-09-14 21:28:07,544 [salt.state       ][INFO    ][15348] {'ovsdb.l3.fwd.enabled': {'after': 'yes', 'before': None}, 'ovsdb.of.version': {'after': 1.3, 'before': None}}
2017-09-14 21:28:07,544 [salt.state       ][INFO    ][15348] Completed state [/opt/opendaylight/etc/custom.properties] at time 21:28:07.544221 duration_in_ms=22.562
2017-09-14 21:28:07,545 [salt.state       ][INFO    ][15348] Running state [opendaylight] at time 21:28:07.544615
2017-09-14 21:28:07,545 [salt.state       ][INFO    ][15348] Executing state service.running for opendaylight
2017-09-14 21:28:07,546 [salt.loaded.int.module.cmdmod][INFO    ][15348] Executing command ['systemctl', 'status', 'opendaylight.service', '-n', '0'] in directory '/root'
2017-09-14 21:28:07,556 [salt.loaded.int.module.cmdmod][INFO    ][15348] Executing command ['systemctl', 'is-active', 'opendaylight.service'] in directory '/root'
2017-09-14 21:28:07,566 [salt.loaded.int.module.cmdmod][INFO    ][15348] Executing command ['systemctl', 'is-enabled', 'opendaylight.service'] in directory '/root'
2017-09-14 21:28:07,575 [salt.state       ][INFO    ][15348] The service opendaylight is already running
2017-09-14 21:28:07,575 [salt.state       ][INFO    ][15348] Completed state [opendaylight] at time 21:28:07.575025 duration_in_ms=30.408
2017-09-14 21:28:07,575 [salt.state       ][INFO    ][15348] Running state [opendaylight] at time 21:28:07.575356
2017-09-14 21:28:07,576 [salt.state       ][INFO    ][15348] Executing state service.mod_watch for opendaylight
2017-09-14 21:28:07,576 [salt.loaded.int.module.cmdmod][INFO    ][15348] Executing command ['systemctl', 'is-active', 'opendaylight.service'] in directory '/root'
2017-09-14 21:28:07,585 [salt.loaded.int.module.cmdmod][INFO    ][15348] Executing command ['systemctl', 'is-enabled', 'opendaylight.service'] in directory '/root'
2017-09-14 21:28:07,595 [salt.loaded.int.module.cmdmod][INFO    ][15348] Executing command ['systemd-run', '--scope', 'systemctl', 'restart', 'opendaylight.service'] in directory '/root'
2017-09-14 21:28:08,408 [salt.state       ][INFO    ][15348] {'opendaylight': True}
2017-09-14 21:28:08,409 [salt.state       ][INFO    ][15348] Completed state [opendaylight] at time 21:28:08.408774 duration_in_ms=833.416
2017-09-14 21:28:08,410 [salt.minion      ][INFO    ][15348] Returning information for job: 20170914212250538882
2017-09-14 22:16:51,704 [salt.utils.schedule][INFO    ][1503] Running scheduled job: __mine_interval
2017-09-14 22:40:49,125 [salt.minion      ][INFO    ][1503] User sudo_ubuntu Executing command cp.push_dir with jid 20170914224049113087
2017-09-14 22:40:49,328 [salt.minion      ][INFO    ][23741] Starting a new job with PID 23741
