2017-12-01 08:30:59,248 [salt.cli.daemons ][WARNING ][940] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-12-01 08:33:40,006 [salt.state       ][ERROR   ][1111] No contents found in top file
2017-12-01 08:33:46,943 [py.warnings      ][WARNING ][1208] /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-12-01 08:34:09,676 [salt.loaded.int.module.cmdmod][ERROR   ][1208] 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-12-01 08:34:11,355 [salt.loaded.int.module.cmdmod][INFO    ][1679] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2017-12-01 08:34:11,362 [salt.loaded.int.module.cmdmod][INFO    ][1679] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2017-12-01 08:34:11,371 [salt.loaded.int.module.cmdmod][INFO    ][1679] Executing command ['systemd-run', '--scope', 'systemctl', 'restart', 'salt-minion.service'] in directory '/root'
2017-12-01 08:34:11,395 [salt.utils.parsers][WARNING ][940] Minion received a SIGTERM. Exiting.
2017-12-01 08:34:11,633 [salt.cli.daemons ][INFO    ][1735] Setting up the Salt Minion "dbs02.baremetal-mcp-ocata-ovs-dpdk-ha.local"
2017-12-01 08:34:11,900 [salt.minion      ][INFO    ][1735] Creating minion process manager
2017-12-01 08:34:11,901 [salt.cli.daemons ][WARNING ][1735] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-12-01 08:34:11,901 [salt.cli.daemons ][INFO    ][1735] The Salt Minion is starting up
2017-12-01 08:34:11,901 [salt.minion      ][INFO    ][1735] Minion is starting as user 'root'
2017-12-01 08:34:11,901 [salt.utils.event ][INFO    ][1735] Starting pull socket on /var/run/salt/minion/minion_event_83a24dd77d_pull.ipc
2017-12-01 08:34:12,540 [salt.loaded.int.module.cmdmod][INFO    ][1735] Executing command ['date', '+%z'] in directory '/root'
2017-12-01 08:34:12,549 [salt.utils.schedule][INFO    ][1735] Updating job settings for scheduled job: __mine_interval
2017-12-01 08:34:12,551 [salt.minion      ][INFO    ][1735] Added mine.update to scheduler
2017-12-01 08:34:12,643 [salt.minion      ][INFO    ][1735] Minion is ready to receive requests!
2017-12-01 08:34:13,644 [salt.utils.schedule][INFO    ][1735] Running scheduled job: __mine_interval
2017-12-01 08:35:53,178 [salt.minion      ][INFO    ][1735] User sudo_ubuntu Executing command state.apply with jid 20171201083553168395
2017-12-01 08:35:53,202 [salt.minion      ][INFO    ][1873] Starting a new job with PID 1873
2017-12-01 08:35:56,287 [salt.state       ][INFO    ][1873] Loading fresh modules for state activity
2017-12-01 08:35:56,312 [salt.fileclient  ][INFO    ][1873] Fetching file from saltenv 'base', ** done ** 'linux/init.sls'
2017-12-01 08:35:56,468 [salt.fileclient  ][INFO    ][1873] Fetching file from saltenv 'base', ** done ** 'linux/system/init.sls'
2017-12-01 08:35:56,510 [salt.fileclient  ][INFO    ][1873] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-12-01 08:35:56,558 [salt.fileclient  ][INFO    ][1873] Fetching file from saltenv 'base', ** done ** 'linux/system/env.sls'
2017-12-01 08:35:56,572 [salt.fileclient  ][INFO    ][1873] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-12-01 08:35:56,616 [salt.fileclient  ][INFO    ][1873] Fetching file from saltenv 'base', ** done ** 'linux/system/profile.sls'
2017-12-01 08:35:56,633 [salt.fileclient  ][INFO    ][1873] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-12-01 08:35:56,730 [salt.fileclient  ][INFO    ][1873] Fetching file from saltenv 'base', ** done ** 'linux/system/repo.sls'
2017-12-01 08:35:56,778 [salt.fileclient  ][INFO    ][1873] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-12-01 08:35:56,837 [salt.fileclient  ][INFO    ][1873] Fetching file from saltenv 'base', ** done ** 'linux/system/package.sls'
2017-12-01 08:35:56,861 [salt.fileclient  ][INFO    ][1873] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-12-01 08:35:56,920 [salt.fileclient  ][INFO    ][1873] Fetching file from saltenv 'base', ** done ** 'linux/system/timezone.sls'
2017-12-01 08:35:56,959 [salt.fileclient  ][INFO    ][1873] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-12-01 08:35:57,016 [salt.fileclient  ][INFO    ][1873] Fetching file from saltenv 'base', ** done ** 'linux/system/kernel.sls'
2017-12-01 08:35:57,038 [salt.fileclient  ][INFO    ][1873] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-12-01 08:35:57,101 [salt.fileclient  ][INFO    ][1873] Fetching file from saltenv 'base', ** done ** 'linux/system/cpu.sls'
2017-12-01 08:35:57,122 [salt.fileclient  ][INFO    ][1873] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-12-01 08:35:57,169 [salt.fileclient  ][INFO    ][1873] Fetching file from saltenv 'base', ** done ** 'linux/system/sysfs.sls'
2017-12-01 08:35:57,186 [salt.fileclient  ][INFO    ][1873] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-12-01 08:35:57,239 [salt.fileclient  ][INFO    ][1873] Fetching file from saltenv 'base', ** done ** 'linux/system/locale.sls'
2017-12-01 08:35:57,252 [salt.fileclient  ][INFO    ][1873] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-12-01 08:35:57,295 [salt.fileclient  ][INFO    ][1873] Fetching file from saltenv 'base', ** done ** 'linux/system/user.sls'
2017-12-01 08:35:57,320 [salt.fileclient  ][INFO    ][1873] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-12-01 08:35:57,369 [salt.fileclient  ][INFO    ][1873] Fetching file from saltenv 'base', ** done ** 'linux/system/group.sls'
2017-12-01 08:35:57,388 [salt.fileclient  ][INFO    ][1873] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-12-01 08:35:57,428 [salt.fileclient  ][INFO    ][1873] Fetching file from saltenv 'base', ** done ** 'linux/system/limit.sls'
2017-12-01 08:35:57,440 [salt.fileclient  ][INFO    ][1873] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-12-01 08:35:57,482 [salt.fileclient  ][INFO    ][1873] Fetching file from saltenv 'base', ** done ** 'linux/system/service.sls'
2017-12-01 08:35:57,773 [salt.fileclient  ][INFO    ][1873] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-12-01 08:35:57,817 [salt.fileclient  ][INFO    ][1873] Fetching file from saltenv 'base', ** done ** 'linux/system/systemd.sls'
2017-12-01 08:35:57,848 [salt.fileclient  ][INFO    ][1873] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-12-01 08:35:57,915 [salt.fileclient  ][INFO    ][1873] Fetching file from saltenv 'base', ** done ** 'linux/network/init.sls'
2017-12-01 08:35:57,938 [salt.fileclient  ][INFO    ][1873] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-12-01 08:35:58,000 [salt.fileclient  ][INFO    ][1873] Fetching file from saltenv 'base', ** done ** 'linux/network/hostname.sls'
2017-12-01 08:35:58,025 [salt.fileclient  ][INFO    ][1873] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-12-01 08:35:58,087 [salt.fileclient  ][INFO    ][1873] Fetching file from saltenv 'base', ** done ** 'linux/network/host.sls'
2017-12-01 08:35:58,115 [salt.fileclient  ][INFO    ][1873] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-12-01 08:35:58,187 [salt.fileclient  ][INFO    ][1873] Fetching file from saltenv 'base', ** done ** 'linux/network/interface.sls'
2017-12-01 08:35:58,259 [salt.fileclient  ][INFO    ][1873] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-12-01 08:35:58,308 [salt.fileclient  ][INFO    ][1873] Fetching file from saltenv 'base', ** done ** 'linux/network/proxy.sls'
2017-12-01 08:35:58,320 [salt.fileclient  ][INFO    ][1873] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-12-01 08:35:58,363 [salt.fileclient  ][INFO    ][1873] Fetching file from saltenv 'base', ** done ** 'linux/storage/init.sls'
2017-12-01 08:35:58,380 [salt.fileclient  ][INFO    ][1873] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-12-01 08:35:58,425 [salt.fileclient  ][INFO    ][1873] Fetching file from saltenv 'base', ** done ** 'ntp/init.sls'
2017-12-01 08:35:58,436 [salt.fileclient  ][INFO    ][1873] Fetching file from saltenv 'base', ** done ** 'ntp/client.sls'
2017-12-01 08:35:58,459 [salt.fileclient  ][INFO    ][1873] Fetching file from saltenv 'base', ** done ** 'ntp/map.jinja'
2017-12-01 08:35:58,475 [salt.fileclient  ][INFO    ][1873] Fetching file from saltenv 'base', ** done ** 'ntp/server.sls'
2017-12-01 08:35:58,490 [salt.fileclient  ][INFO    ][1873] Fetching file from saltenv 'base', ** done ** 'ntp/map.jinja'
2017-12-01 08:35:58,506 [salt.state       ][INFO    ][1873] Running state [/etc/environment] at time 08:35:58.506324
2017-12-01 08:35:58,507 [salt.state       ][INFO    ][1873] Executing state file.blockreplace for /etc/environment
2017-12-01 08:35:58,515 [salt.state       ][INFO    ][1873] 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-12-01 08:35:58,516 [salt.state       ][INFO    ][1873] Completed state [/etc/environment] at time 08:35:58.515868 duration_in_ms=9.544
2017-12-01 08:35:58,516 [salt.state       ][INFO    ][1873] Running state [/etc/profile.d] at time 08:35:58.516320
2017-12-01 08:35:58,517 [salt.state       ][INFO    ][1873] Executing state file.directory for /etc/profile.d
2017-12-01 08:35:58,518 [salt.state       ][INFO    ][1873] Directory /etc/profile.d is in the correct state
2017-12-01 08:35:58,519 [salt.state       ][INFO    ][1873] Completed state [/etc/profile.d] at time 08:35:58.518551 duration_in_ms=2.23
2017-12-01 08:35:58,787 [salt.state       ][INFO    ][1873] Running state [linux_repo_prereq_pkgs] at time 08:35:58.786466
2017-12-01 08:35:58,787 [salt.state       ][INFO    ][1873] Executing state pkg.installed for linux_repo_prereq_pkgs
2017-12-01 08:35:58,788 [salt.loaded.int.module.cmdmod][INFO    ][1873] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-01 08:35:59,262 [salt.state       ][INFO    ][1873] All specified packages are already installed
2017-12-01 08:35:59,262 [salt.state       ][INFO    ][1873] Completed state [linux_repo_prereq_pkgs] at time 08:35:59.262013 duration_in_ms=475.547
2017-12-01 08:35:59,262 [salt.state       ][INFO    ][1873] Running state [/etc/apt/apt.conf.d/99proxies-salt-mk_openstack] at time 08:35:59.262330
2017-12-01 08:35:59,263 [salt.state       ][INFO    ][1873] Executing state file.absent for /etc/apt/apt.conf.d/99proxies-salt-mk_openstack
2017-12-01 08:35:59,263 [salt.state       ][INFO    ][1873] File /etc/apt/apt.conf.d/99proxies-salt-mk_openstack is not present
2017-12-01 08:35:59,263 [salt.state       ][INFO    ][1873] Completed state [/etc/apt/apt.conf.d/99proxies-salt-mk_openstack] at time 08:35:59.263306 duration_in_ms=0.976
2017-12-01 08:35:59,264 [salt.state       ][INFO    ][1873] Running state [/etc/apt/preferences.d/mk_openstack] at time 08:35:59.263583
2017-12-01 08:35:59,264 [salt.state       ][INFO    ][1873] Executing state file.managed for /etc/apt/preferences.d/mk_openstack
2017-12-01 08:35:59,286 [salt.fileclient  ][INFO    ][1873] Fetching file from saltenv 'base', ** done ** 'linux/files/preferences_repo'
2017-12-01 08:35:59,302 [salt.fileclient  ][INFO    ][1873] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-12-01 08:35:59,335 [salt.state       ][INFO    ][1873] File changed:
New file
2017-12-01 08:35:59,336 [salt.state       ][INFO    ][1873] Completed state [/etc/apt/preferences.d/mk_openstack] at time 08:35:59.335808 duration_in_ms=72.225
2017-12-01 08:35:59,364 [salt.state       ][INFO    ][1873] Running state [deb [arch=amd64] http://apt.mirantis.com/xenial/ nightly ocata] at time 08:35:59.363564
2017-12-01 08:35:59,364 [salt.state       ][INFO    ][1873] Executing state pkgrepo.managed for deb [arch=amd64] http://apt.mirantis.com/xenial/ nightly ocata
2017-12-01 08:35:59,845 [salt.loaded.int.module.cmdmod][INFO    ][1873] Executing command ['apt-key', 'add', '/var/cache/salt/minion/extrn_files/base/apt.mirantis.com/public.gpg'] in directory '/root'
2017-12-01 08:35:59,968 [salt.loaded.int.module.cmdmod][INFO    ][1873] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-12-01 08:36:01,890 [salt.state       ][INFO    ][1873] {'repo': 'deb [arch=amd64] http://apt.mirantis.com/xenial nightly ocata'}
2017-12-01 08:36:01,890 [salt.state       ][INFO    ][1873] Completed state [deb [arch=amd64] http://apt.mirantis.com/xenial/ nightly ocata] at time 08:36:01.890140 duration_in_ms=2526.575
2017-12-01 08:36:01,890 [salt.state       ][INFO    ][1873] Running state [/etc/apt/apt.conf.d/99proxies-salt-mirantis_openstack] at time 08:36:01.890469
2017-12-01 08:36:01,891 [salt.state       ][INFO    ][1873] Executing state file.absent for /etc/apt/apt.conf.d/99proxies-salt-mirantis_openstack
2017-12-01 08:36:01,891 [salt.state       ][INFO    ][1873] File /etc/apt/apt.conf.d/99proxies-salt-mirantis_openstack is not present
2017-12-01 08:36:01,891 [salt.state       ][INFO    ][1873] Completed state [/etc/apt/apt.conf.d/99proxies-salt-mirantis_openstack] at time 08:36:01.891469 duration_in_ms=0.999
2017-12-01 08:36:01,892 [salt.state       ][INFO    ][1873] Running state [/etc/apt/preferences.d/mirantis_openstack] at time 08:36:01.891742
2017-12-01 08:36:01,892 [salt.state       ][INFO    ][1873] Executing state file.managed for /etc/apt/preferences.d/mirantis_openstack
2017-12-01 08:36:01,910 [salt.fileclient  ][INFO    ][1873] Fetching file from saltenv 'base', ** done ** 'linux/files/preferences_repo'
2017-12-01 08:36:01,927 [salt.fileclient  ][INFO    ][1873] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-12-01 08:36:01,960 [salt.state       ][INFO    ][1873] File changed:
New file
2017-12-01 08:36:01,961 [salt.state       ][INFO    ][1873] Completed state [/etc/apt/preferences.d/mirantis_openstack] at time 08:36:01.960530 duration_in_ms=68.788
2017-12-01 08:36:01,961 [salt.state       ][INFO    ][1873] Running state [deb http://mirror.fuel-infra.org/mcp-repos/ocata/xenial ocata main] at time 08:36:01.961289
2017-12-01 08:36:01,962 [salt.state       ][INFO    ][1873] Executing state pkgrepo.managed for deb http://mirror.fuel-infra.org/mcp-repos/ocata/xenial ocata main
2017-12-01 08:36:02,359 [salt.loaded.int.module.cmdmod][INFO    ][1873] 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-12-01 08:36:02,448 [salt.loaded.int.module.cmdmod][INFO    ][1873] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-12-01 08:36:03,227 [salt.minion      ][INFO    ][1735] User sudo_ubuntu Executing command saltutil.find_job with jid 20171201083603217039
2017-12-01 08:36:03,241 [salt.minion      ][INFO    ][2785] Starting a new job with PID 2785
2017-12-01 08:36:03,256 [salt.minion      ][INFO    ][2785] Returning information for job: 20171201083603217039
2017-12-01 08:36:04,418 [salt.state       ][INFO    ][1873] {'repo': 'deb http://mirror.fuel-infra.org/mcp-repos/ocata/xenial ocata main'}
2017-12-01 08:36:04,418 [salt.state       ][INFO    ][1873] Completed state [deb http://mirror.fuel-infra.org/mcp-repos/ocata/xenial ocata main] at time 08:36:04.418010 duration_in_ms=2456.72
2017-12-01 08:36:04,418 [salt.state       ][INFO    ][1873] Running state [/etc/apt/apt.conf.d/99proxies-salt-uca] at time 08:36:04.418351
2017-12-01 08:36:04,419 [salt.state       ][INFO    ][1873] Executing state file.absent for /etc/apt/apt.conf.d/99proxies-salt-uca
2017-12-01 08:36:04,419 [salt.state       ][INFO    ][1873] File /etc/apt/apt.conf.d/99proxies-salt-uca is not present
2017-12-01 08:36:04,419 [salt.state       ][INFO    ][1873] Completed state [/etc/apt/apt.conf.d/99proxies-salt-uca] at time 08:36:04.419344 duration_in_ms=0.992
2017-12-01 08:36:04,420 [salt.state       ][INFO    ][1873] Running state [/etc/apt/preferences.d/uca] at time 08:36:04.419622
2017-12-01 08:36:04,420 [salt.state       ][INFO    ][1873] Executing state file.absent for /etc/apt/preferences.d/uca
2017-12-01 08:36:04,420 [salt.state       ][INFO    ][1873] File /etc/apt/preferences.d/uca is not present
2017-12-01 08:36:04,420 [salt.state       ][INFO    ][1873] Completed state [/etc/apt/preferences.d/uca] at time 08:36:04.420458 duration_in_ms=0.835
2017-12-01 08:36:04,421 [salt.state       ][INFO    ][1873] Running state [deb http://ubuntu-cloud.archive.canonical.com/ubuntu xenial-updates/ocata main] at time 08:36:04.421216
2017-12-01 08:36:04,422 [salt.state       ][INFO    ][1873] Executing state pkgrepo.managed for deb http://ubuntu-cloud.archive.canonical.com/ubuntu xenial-updates/ocata main
2017-12-01 08:36:04,463 [salt.loaded.int.module.cmdmod][INFO    ][1873] Executing command ['apt-key', 'export', 'EC4926EA'] in directory '/root'
2017-12-01 08:36:04,505 [salt.loaded.int.module.cmdmod][INFO    ][1873] Executing command ['apt-key', 'adv', '--keyserver', 'keyserver.ubuntu.com', '--logger-fd', '1', '--recv-keys', 'EC4926EA'] in directory '/root'
2017-12-01 08:36:05,035 [salt.loaded.int.module.cmdmod][INFO    ][1873] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-12-01 08:36:07,648 [salt.state       ][INFO    ][1873] {'repo': 'deb http://ubuntu-cloud.archive.canonical.com/ubuntu xenial-updates/ocata main'}
2017-12-01 08:36:07,649 [salt.state       ][INFO    ][1873] Completed state [deb http://ubuntu-cloud.archive.canonical.com/ubuntu xenial-updates/ocata main] at time 08:36:07.648958 duration_in_ms=3227.741
2017-12-01 08:36:07,649 [salt.state       ][INFO    ][1873] Running state [/etc/apt/apt.conf.d/99proxies-salt-mcp_extra] at time 08:36:07.649324
2017-12-01 08:36:07,650 [salt.state       ][INFO    ][1873] Executing state file.absent for /etc/apt/apt.conf.d/99proxies-salt-mcp_extra
2017-12-01 08:36:07,650 [salt.state       ][INFO    ][1873] File /etc/apt/apt.conf.d/99proxies-salt-mcp_extra is not present
2017-12-01 08:36:07,650 [salt.state       ][INFO    ][1873] Completed state [/etc/apt/apt.conf.d/99proxies-salt-mcp_extra] at time 08:36:07.650294 duration_in_ms=0.969
2017-12-01 08:36:07,651 [salt.state       ][INFO    ][1873] Running state [/etc/apt/preferences.d/mcp_extra] at time 08:36:07.650583
2017-12-01 08:36:07,651 [salt.state       ][INFO    ][1873] Executing state file.managed for /etc/apt/preferences.d/mcp_extra
2017-12-01 08:36:07,668 [salt.fileclient  ][INFO    ][1873] Fetching file from saltenv 'base', ** done ** 'linux/files/preferences_repo'
2017-12-01 08:36:07,687 [salt.fileclient  ][INFO    ][1873] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-12-01 08:36:07,720 [salt.state       ][INFO    ][1873] File changed:
New file
2017-12-01 08:36:07,721 [salt.state       ][INFO    ][1873] Completed state [/etc/apt/preferences.d/mcp_extra] at time 08:36:07.720675 duration_in_ms=70.09
2017-12-01 08:36:07,721 [salt.state       ][INFO    ][1873] Running state [deb [arch=amd64] http://apt.mirantis.com/xenial/ nightly extra] at time 08:36:07.721406
2017-12-01 08:36:07,722 [salt.state       ][INFO    ][1873] Executing state pkgrepo.managed for deb [arch=amd64] http://apt.mirantis.com/xenial/ nightly extra
2017-12-01 08:36:07,811 [salt.loaded.int.module.cmdmod][INFO    ][1873] Executing command ['apt-key', 'add', '/var/cache/salt/minion/extrn_files/base/apt.mirantis.com/public.gpg'] in directory '/root'
2017-12-01 08:36:07,883 [salt.loaded.int.module.cmdmod][INFO    ][1873] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-12-01 08:36:09,671 [salt.state       ][INFO    ][1873] Configured package repo 'deb [arch=amd64] http://apt.mirantis.com/xenial/ nightly extra'
2017-12-01 08:36:09,671 [salt.state       ][INFO    ][1873] Completed state [deb [arch=amd64] http://apt.mirantis.com/xenial/ nightly extra] at time 08:36:09.671127 duration_in_ms=1949.719
2017-12-01 08:36:09,672 [salt.state       ][INFO    ][1873] Running state [linux_extra_packages_purged] at time 08:36:09.671487
2017-12-01 08:36:09,672 [salt.state       ][INFO    ][1873] Executing state pkg.purged for linux_extra_packages_purged
2017-12-01 08:36:09,686 [salt.loaded.int.module.cmdmod][INFO    ][1873] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', 'purge', 'cloud-init', 'unattended-upgrades'] in directory '/root'
2017-12-01 08:36:13,371 [salt.minion      ][INFO    ][1735] User sudo_ubuntu Executing command saltutil.find_job with jid 20171201083613364213
2017-12-01 08:36:13,384 [salt.minion      ][INFO    ][3914] Starting a new job with PID 3914
2017-12-01 08:36:13,396 [salt.minion      ][INFO    ][3914] Returning information for job: 20171201083613364213
2017-12-01 08:36:23,580 [salt.minion      ][INFO    ][1735] User sudo_ubuntu Executing command saltutil.find_job with jid 20171201083623566427
2017-12-01 08:36:23,597 [salt.minion      ][INFO    ][4203] Starting a new job with PID 4203
2017-12-01 08:36:23,831 [salt.minion      ][INFO    ][4203] Returning information for job: 20171201083623566427
2017-12-01 08:36:24,736 [salt.loaded.int.module.cmdmod][INFO    ][1873] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-01 08:36:24,754 [salt.state       ][INFO    ][1873] {'removed': {}, 'installed': {'cloud-init': {'new': '', 'old': '0.7.9-233-ge586fe35-0ubuntu1~16.04.1'}, 'ec2-init': {'new': '', 'old': '1'}, 'unattended-upgrades': {'new': '', 'old': '0.90ubuntu0.8'}}}
2017-12-01 08:36:24,763 [salt.state       ][INFO    ][1873] Loading fresh modules for state activity
2017-12-01 08:36:24,777 [salt.state       ][INFO    ][1873] Completed state [linux_extra_packages_purged] at time 08:36:24.776776 duration_in_ms=15105.289
2017-12-01 08:36:24,782 [salt.state       ][INFO    ][1873] Running state [linux_extra_packages_latest] at time 08:36:24.781597
2017-12-01 08:36:24,782 [salt.state       ][INFO    ][1873] Executing state pkg.latest for linux_extra_packages_latest
2017-12-01 08:36:25,171 [salt.loaded.int.module.cmdmod][INFO    ][1873] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-12-01 08:36:26,813 [salt.loaded.int.module.cmdmod][INFO    ][1873] Executing command ['apt-cache', '-q', 'policy', 'mcelog'] in directory '/root'
2017-12-01 08:36:26,851 [salt.loaded.int.module.cmdmod][INFO    ][1873] 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-12-01 08:36:33,802 [salt.minion      ][INFO    ][1735] User sudo_ubuntu Executing command saltutil.find_job with jid 20171201083633794754
2017-12-01 08:36:33,826 [salt.minion      ][INFO    ][4652] Starting a new job with PID 4652
2017-12-01 08:36:33,874 [salt.minion      ][INFO    ][4652] Returning information for job: 20171201083633794754
2017-12-01 08:36:40,659 [salt.loaded.int.module.cmdmod][INFO    ][1873] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-01 08:36:40,684 [salt.state       ][INFO    ][1873] Made the following changes:
'mcelog' changed from 'absent' to '128+dfsg-1'

2017-12-01 08:36:40,692 [salt.state       ][INFO    ][1873] Loading fresh modules for state activity
2017-12-01 08:36:40,705 [salt.state       ][INFO    ][1873] Completed state [linux_extra_packages_latest] at time 08:36:40.704857 duration_in_ms=15923.26
2017-12-01 08:36:40,861 [salt.state       ][INFO    ][1873] Running state [UTC] at time 08:36:40.861051
2017-12-01 08:36:40,861 [salt.state       ][INFO    ][1873] Executing state timezone.system for UTC
2017-12-01 08:36:40,863 [salt.loaded.int.module.cmdmod][INFO    ][1873] Executing command ['timedatectl'] in directory '/root'
2017-12-01 08:36:41,276 [salt.loaded.int.module.cmdmod][INFO    ][1873] Executing command ['timedatectl'] in directory '/root'
2017-12-01 08:36:41,283 [salt.state       ][INFO    ][1873] Timezone UTC already set, UTC already set to UTC
2017-12-01 08:36:41,283 [salt.state       ][INFO    ][1873] Completed state [UTC] at time 08:36:41.283434 duration_in_ms=422.382
2017-12-01 08:36:41,325 [salt.state       ][INFO    ][1873] Running state [nf_conntrack] at time 08:36:41.324645
2017-12-01 08:36:41,325 [salt.state       ][INFO    ][1873] Executing state kmod.present for nf_conntrack
2017-12-01 08:36:41,325 [salt.loaded.int.module.cmdmod][INFO    ][1873] Executing command 'lsmod' in directory '/root'
2017-12-01 08:36:41,799 [salt.loaded.int.module.cmdmod][INFO    ][1873] Executing command 'lsmod' in directory '/root'
2017-12-01 08:36:41,805 [salt.loaded.int.module.cmdmod][INFO    ][1873] Executing command 'modprobe nf_conntrack' in directory '/root'
2017-12-01 08:36:41,863 [salt.loaded.int.module.cmdmod][INFO    ][1873] Executing command 'lsmod' in directory '/root'
2017-12-01 08:36:41,904 [salt.state       ][INFO    ][1873] {'nf_conntrack': 'loaded'}
2017-12-01 08:36:41,904 [salt.state       ][INFO    ][1873] Completed state [nf_conntrack] at time 08:36:41.904063 duration_in_ms=579.417
2017-12-01 08:36:41,944 [salt.state       ][INFO    ][1873] Running state [kernel.panic] at time 08:36:41.943471
2017-12-01 08:36:41,944 [salt.state       ][INFO    ][1873] Executing state sysctl.present for kernel.panic
2017-12-01 08:36:41,944 [salt.loaded.int.module.cmdmod][INFO    ][1873] Executing command 'sysctl -a' in directory '/root'
2017-12-01 08:36:42,135 [salt.loaded.int.module.cmdmod][INFO    ][1873] Executing command 'sysctl -w kernel.panic="60"' in directory '/root'
2017-12-01 08:36:42,142 [salt.state       ][INFO    ][1873] {'kernel.panic': 60}
2017-12-01 08:36:42,143 [salt.state       ][INFO    ][1873] Completed state [kernel.panic] at time 08:36:42.142685 duration_in_ms=199.213
2017-12-01 08:36:42,143 [salt.state       ][INFO    ][1873] Running state [net.ipv4.tcp_keepalive_probes] at time 08:36:42.143092
2017-12-01 08:36:42,143 [salt.state       ][INFO    ][1873] Executing state sysctl.present for net.ipv4.tcp_keepalive_probes
2017-12-01 08:36:42,144 [salt.loaded.int.module.cmdmod][INFO    ][1873] Executing command 'sysctl -a' in directory '/root'
2017-12-01 08:36:42,286 [salt.loaded.int.module.cmdmod][INFO    ][1873] Executing command 'sysctl -w net.ipv4.tcp_keepalive_probes="8"' in directory '/root'
2017-12-01 08:36:42,294 [salt.state       ][INFO    ][1873] {'net.ipv4.tcp_keepalive_probes': 8}
2017-12-01 08:36:42,294 [salt.state       ][INFO    ][1873] Completed state [net.ipv4.tcp_keepalive_probes] at time 08:36:42.294307 duration_in_ms=151.212
2017-12-01 08:36:42,295 [salt.state       ][INFO    ][1873] Running state [fs.file-max] at time 08:36:42.294730
2017-12-01 08:36:42,295 [salt.state       ][INFO    ][1873] Executing state sysctl.present for fs.file-max
2017-12-01 08:36:42,296 [salt.loaded.int.module.cmdmod][INFO    ][1873] Executing command 'sysctl -a' in directory '/root'
2017-12-01 08:36:42,355 [salt.loaded.int.module.cmdmod][INFO    ][1873] Executing command 'sysctl -w fs.file-max="124165"' in directory '/root'
2017-12-01 08:36:42,361 [salt.state       ][INFO    ][1873] {'fs.file-max': 124165}
2017-12-01 08:36:42,361 [salt.state       ][INFO    ][1873] Completed state [fs.file-max] at time 08:36:42.361398 duration_in_ms=66.667
2017-12-01 08:36:42,362 [salt.state       ][INFO    ][1873] Running state [net.core.somaxconn] at time 08:36:42.361851
2017-12-01 08:36:42,362 [salt.state       ][INFO    ][1873] Executing state sysctl.present for net.core.somaxconn
2017-12-01 08:36:42,363 [salt.loaded.int.module.cmdmod][INFO    ][1873] Executing command 'sysctl -a' in directory '/root'
2017-12-01 08:36:42,402 [salt.loaded.int.module.cmdmod][INFO    ][1873] Executing command 'sysctl -w net.core.somaxconn="4096"' in directory '/root'
2017-12-01 08:36:42,408 [salt.state       ][INFO    ][1873] {'net.core.somaxconn': 4096}
2017-12-01 08:36:42,409 [salt.state       ][INFO    ][1873] Completed state [net.core.somaxconn] at time 08:36:42.408858 duration_in_ms=47.006
2017-12-01 08:36:42,409 [salt.state       ][INFO    ][1873] Running state [net.ipv4.tcp_max_syn_backlog] at time 08:36:42.409254
2017-12-01 08:36:42,410 [salt.state       ][INFO    ][1873] Executing state sysctl.present for net.ipv4.tcp_max_syn_backlog
2017-12-01 08:36:42,410 [salt.loaded.int.module.cmdmod][INFO    ][1873] Executing command 'sysctl -a' in directory '/root'
2017-12-01 08:36:42,498 [salt.loaded.int.module.cmdmod][INFO    ][1873] Executing command 'sysctl -w net.ipv4.tcp_max_syn_backlog="8192"' in directory '/root'
2017-12-01 08:36:42,506 [salt.state       ][INFO    ][1873] {'net.ipv4.tcp_max_syn_backlog': 8192}
2017-12-01 08:36:42,506 [salt.state       ][INFO    ][1873] Completed state [net.ipv4.tcp_max_syn_backlog] at time 08:36:42.506120 duration_in_ms=96.865
2017-12-01 08:36:42,507 [salt.state       ][INFO    ][1873] Running state [net.ipv4.tcp_tw_reuse] at time 08:36:42.506518
2017-12-01 08:36:42,507 [salt.state       ][INFO    ][1873] Executing state sysctl.present for net.ipv4.tcp_tw_reuse
2017-12-01 08:36:42,508 [salt.loaded.int.module.cmdmod][INFO    ][1873] Executing command 'sysctl -a' in directory '/root'
2017-12-01 08:36:42,558 [salt.loaded.int.module.cmdmod][INFO    ][1873] Executing command 'sysctl -w net.ipv4.tcp_tw_reuse="1"' in directory '/root'
2017-12-01 08:36:42,565 [salt.state       ][INFO    ][1873] {'net.ipv4.tcp_tw_reuse': 1}
2017-12-01 08:36:42,565 [salt.state       ][INFO    ][1873] Completed state [net.ipv4.tcp_tw_reuse] at time 08:36:42.565226 duration_in_ms=58.706
2017-12-01 08:36:42,566 [salt.state       ][INFO    ][1873] Running state [net.ipv4.tcp_congestion_control] at time 08:36:42.565669
2017-12-01 08:36:42,566 [salt.state       ][INFO    ][1873] Executing state sysctl.present for net.ipv4.tcp_congestion_control
2017-12-01 08:36:42,567 [salt.loaded.int.module.cmdmod][INFO    ][1873] Executing command 'sysctl -a' in directory '/root'
2017-12-01 08:36:42,618 [salt.loaded.int.module.cmdmod][INFO    ][1873] Executing command 'sysctl -w net.ipv4.tcp_congestion_control="yeah"' in directory '/root'
2017-12-01 08:36:42,730 [salt.state       ][INFO    ][1873] {'net.ipv4.tcp_congestion_control': 'yeah'}
2017-12-01 08:36:42,731 [salt.state       ][INFO    ][1873] Completed state [net.ipv4.tcp_congestion_control] at time 08:36:42.730974 duration_in_ms=165.304
2017-12-01 08:36:42,731 [salt.state       ][INFO    ][1873] Running state [net.ipv4.tcp_retries2] at time 08:36:42.731444
2017-12-01 08:36:42,732 [salt.state       ][INFO    ][1873] Executing state sysctl.present for net.ipv4.tcp_retries2
2017-12-01 08:36:42,733 [salt.loaded.int.module.cmdmod][INFO    ][1873] Executing command 'sysctl -a' in directory '/root'
2017-12-01 08:36:42,746 [salt.loaded.int.module.cmdmod][INFO    ][1873] Executing command 'sysctl -w net.ipv4.tcp_retries2="5"' in directory '/root'
2017-12-01 08:36:42,753 [salt.state       ][INFO    ][1873] {'net.ipv4.tcp_retries2': 5}
2017-12-01 08:36:42,753 [salt.state       ][INFO    ][1873] Completed state [net.ipv4.tcp_retries2] at time 08:36:42.753216 duration_in_ms=21.771
2017-12-01 08:36:42,754 [salt.state       ][INFO    ][1873] Running state [net.core.netdev_max_backlog] at time 08:36:42.753663
2017-12-01 08:36:42,754 [salt.state       ][INFO    ][1873] Executing state sysctl.present for net.core.netdev_max_backlog
2017-12-01 08:36:42,755 [salt.loaded.int.module.cmdmod][INFO    ][1873] Executing command 'sysctl -a' in directory '/root'
2017-12-01 08:36:42,834 [salt.loaded.int.module.cmdmod][INFO    ][1873] Executing command 'sysctl -w net.core.netdev_max_backlog="261144"' in directory '/root'
2017-12-01 08:36:42,840 [salt.state       ][INFO    ][1873] {'net.core.netdev_max_backlog': 261144}
2017-12-01 08:36:42,841 [salt.state       ][INFO    ][1873] Completed state [net.core.netdev_max_backlog] at time 08:36:42.840777 duration_in_ms=87.113
2017-12-01 08:36:42,841 [salt.state       ][INFO    ][1873] Running state [net.ipv4.tcp_slow_start_after_idle] at time 08:36:42.841214
2017-12-01 08:36:42,842 [salt.state       ][INFO    ][1873] Executing state sysctl.present for net.ipv4.tcp_slow_start_after_idle
2017-12-01 08:36:42,842 [salt.loaded.int.module.cmdmod][INFO    ][1873] Executing command 'sysctl -a' in directory '/root'
2017-12-01 08:36:42,894 [salt.loaded.int.module.cmdmod][INFO    ][1873] Executing command 'sysctl -w net.ipv4.tcp_slow_start_after_idle="0"' in directory '/root'
2017-12-01 08:36:42,900 [salt.state       ][INFO    ][1873] {'net.ipv4.tcp_slow_start_after_idle': 0}
2017-12-01 08:36:42,901 [salt.state       ][INFO    ][1873] Completed state [net.ipv4.tcp_slow_start_after_idle] at time 08:36:42.900529 duration_in_ms=59.312
2017-12-01 08:36:42,901 [salt.state       ][INFO    ][1873] Running state [vm.swappiness] at time 08:36:42.900971
2017-12-01 08:36:42,901 [salt.state       ][INFO    ][1873] Executing state sysctl.present for vm.swappiness
2017-12-01 08:36:42,902 [salt.loaded.int.module.cmdmod][INFO    ][1873] Executing command 'sysctl -a' in directory '/root'
2017-12-01 08:36:42,930 [salt.loaded.int.module.cmdmod][INFO    ][1873] Executing command 'sysctl -w vm.swappiness="10"' in directory '/root'
2017-12-01 08:36:42,936 [salt.state       ][INFO    ][1873] {'vm.swappiness': 10}
2017-12-01 08:36:42,936 [salt.state       ][INFO    ][1873] Completed state [vm.swappiness] at time 08:36:42.936268 duration_in_ms=35.296
2017-12-01 08:36:42,937 [salt.state       ][INFO    ][1873] Running state [net.ipv4.tcp_keepalive_intvl] at time 08:36:42.936705
2017-12-01 08:36:42,937 [salt.state       ][INFO    ][1873] Executing state sysctl.present for net.ipv4.tcp_keepalive_intvl
2017-12-01 08:36:42,938 [salt.loaded.int.module.cmdmod][INFO    ][1873] Executing command 'sysctl -a' in directory '/root'
2017-12-01 08:36:42,996 [salt.loaded.int.module.cmdmod][INFO    ][1873] Executing command 'sysctl -w net.ipv4.tcp_keepalive_intvl="3"' in directory '/root'
2017-12-01 08:36:43,002 [salt.state       ][INFO    ][1873] {'net.ipv4.tcp_keepalive_intvl': 3}
2017-12-01 08:36:43,003 [salt.state       ][INFO    ][1873] Completed state [net.ipv4.tcp_keepalive_intvl] at time 08:36:43.002681 duration_in_ms=65.974
2017-12-01 08:36:43,003 [salt.state       ][INFO    ][1873] Running state [net.ipv4.neigh.default.gc_thresh1] at time 08:36:43.003101
2017-12-01 08:36:43,004 [salt.state       ][INFO    ][1873] Executing state sysctl.present for net.ipv4.neigh.default.gc_thresh1
2017-12-01 08:36:43,004 [salt.loaded.int.module.cmdmod][INFO    ][1873] Executing command 'sysctl -a' in directory '/root'
2017-12-01 08:36:43,049 [salt.loaded.int.module.cmdmod][INFO    ][1873] Executing command 'sysctl -w net.ipv4.neigh.default.gc_thresh1="4096"' in directory '/root'
2017-12-01 08:36:43,056 [salt.state       ][INFO    ][1873] {'net.ipv4.neigh.default.gc_thresh1': 4096}
2017-12-01 08:36:43,057 [salt.state       ][INFO    ][1873] Completed state [net.ipv4.neigh.default.gc_thresh1] at time 08:36:43.056882 duration_in_ms=53.779
2017-12-01 08:36:43,057 [salt.state       ][INFO    ][1873] Running state [net.ipv4.neigh.default.gc_thresh2] at time 08:36:43.057307
2017-12-01 08:36:43,058 [salt.state       ][INFO    ][1873] Executing state sysctl.present for net.ipv4.neigh.default.gc_thresh2
2017-12-01 08:36:43,058 [salt.loaded.int.module.cmdmod][INFO    ][1873] Executing command 'sysctl -a' in directory '/root'
2017-12-01 08:36:43,097 [salt.loaded.int.module.cmdmod][INFO    ][1873] Executing command 'sysctl -w net.ipv4.neigh.default.gc_thresh2="8192"' in directory '/root'
2017-12-01 08:36:43,104 [salt.state       ][INFO    ][1873] {'net.ipv4.neigh.default.gc_thresh2': 8192}
2017-12-01 08:36:43,104 [salt.state       ][INFO    ][1873] Completed state [net.ipv4.neigh.default.gc_thresh2] at time 08:36:43.104253 duration_in_ms=46.945
2017-12-01 08:36:43,105 [salt.state       ][INFO    ][1873] Running state [net.ipv4.neigh.default.gc_thresh3] at time 08:36:43.104711
2017-12-01 08:36:43,105 [salt.state       ][INFO    ][1873] Executing state sysctl.present for net.ipv4.neigh.default.gc_thresh3
2017-12-01 08:36:43,106 [salt.loaded.int.module.cmdmod][INFO    ][1873] Executing command 'sysctl -a' in directory '/root'
2017-12-01 08:36:43,118 [salt.loaded.int.module.cmdmod][INFO    ][1873] Executing command 'sysctl -w net.ipv4.neigh.default.gc_thresh3="16384"' in directory '/root'
2017-12-01 08:36:43,124 [salt.state       ][INFO    ][1873] {'net.ipv4.neigh.default.gc_thresh3': 16384}
2017-12-01 08:36:43,124 [salt.state       ][INFO    ][1873] Completed state [net.ipv4.neigh.default.gc_thresh3] at time 08:36:43.124199 duration_in_ms=19.487
2017-12-01 08:36:43,125 [salt.state       ][INFO    ][1873] Running state [net.ipv4.tcp_fin_timeout] at time 08:36:43.124625
2017-12-01 08:36:43,125 [salt.state       ][INFO    ][1873] Executing state sysctl.present for net.ipv4.tcp_fin_timeout
2017-12-01 08:36:43,126 [salt.loaded.int.module.cmdmod][INFO    ][1873] Executing command 'sysctl -a' in directory '/root'
2017-12-01 08:36:43,193 [salt.loaded.int.module.cmdmod][INFO    ][1873] Executing command 'sysctl -w net.ipv4.tcp_fin_timeout="30"' in directory '/root'
2017-12-01 08:36:43,199 [salt.state       ][INFO    ][1873] {'net.ipv4.tcp_fin_timeout': 30}
2017-12-01 08:36:43,200 [salt.state       ][INFO    ][1873] Completed state [net.ipv4.tcp_fin_timeout] at time 08:36:43.199643 duration_in_ms=75.017
2017-12-01 08:36:43,200 [salt.state       ][INFO    ][1873] Running state [net.ipv4.tcp_keepalive_time] at time 08:36:43.200031
2017-12-01 08:36:43,200 [salt.state       ][INFO    ][1873] Executing state sysctl.present for net.ipv4.tcp_keepalive_time
2017-12-01 08:36:43,201 [salt.loaded.int.module.cmdmod][INFO    ][1873] Executing command 'sysctl -a' in directory '/root'
2017-12-01 08:36:43,217 [salt.loaded.int.module.cmdmod][INFO    ][1873] Executing command 'sysctl -w net.ipv4.tcp_keepalive_time="30"' in directory '/root'
2017-12-01 08:36:43,223 [salt.state       ][INFO    ][1873] {'net.ipv4.tcp_keepalive_time': 30}
2017-12-01 08:36:43,223 [salt.state       ][INFO    ][1873] Completed state [net.ipv4.tcp_keepalive_time] at time 08:36:43.223137 duration_in_ms=23.104
2017-12-01 08:36:43,224 [salt.state       ][INFO    ][1873] Running state [net.nf_conntrack_max] at time 08:36:43.223522
2017-12-01 08:36:43,224 [salt.state       ][INFO    ][1873] Executing state sysctl.present for net.nf_conntrack_max
2017-12-01 08:36:43,224 [salt.loaded.int.module.cmdmod][INFO    ][1873] Executing command 'sysctl -a' in directory '/root'
2017-12-01 08:36:43,371 [salt.loaded.int.module.cmdmod][INFO    ][1873] Executing command 'sysctl -w net.nf_conntrack_max="1048576"' in directory '/root'
2017-12-01 08:36:43,379 [salt.state       ][INFO    ][1873] {'net.nf_conntrack_max': 1048576}
2017-12-01 08:36:43,379 [salt.state       ][INFO    ][1873] Completed state [net.nf_conntrack_max] at time 08:36:43.378964 duration_in_ms=155.441
2017-12-01 08:36:43,385 [salt.state       ][INFO    ][1873] Running state [linux_sysfs_package] at time 08:36:43.384937
2017-12-01 08:36:43,385 [salt.state       ][INFO    ][1873] Executing state pkg.installed for linux_sysfs_package
2017-12-01 08:36:43,575 [salt.loaded.int.module.cmdmod][INFO    ][1873] Executing command ['apt-cache', '-q', 'policy', 'sysfsutils'] in directory '/root'
2017-12-01 08:36:43,614 [salt.loaded.int.module.cmdmod][INFO    ][1873] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-12-01 08:36:43,918 [salt.minion      ][INFO    ][1735] User sudo_ubuntu Executing command saltutil.find_job with jid 20171201083643905503
2017-12-01 08:36:43,936 [salt.minion      ][INFO    ][4977] Starting a new job with PID 4977
2017-12-01 08:36:43,946 [salt.minion      ][INFO    ][4977] Returning information for job: 20171201083643905503
2017-12-01 08:36:45,433 [salt.loaded.int.module.cmdmod][INFO    ][1873] 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-12-01 08:36:54,035 [salt.minion      ][INFO    ][1735] User sudo_ubuntu Executing command saltutil.find_job with jid 20171201083654018670
2017-12-01 08:36:54,046 [salt.minion      ][INFO    ][5252] Starting a new job with PID 5252
2017-12-01 08:36:54,058 [salt.minion      ][INFO    ][5252] Returning information for job: 20171201083654018670
2017-12-01 08:37:00,027 [salt.loaded.int.module.cmdmod][INFO    ][1873] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-01 08:37:00,045 [salt.state       ][INFO    ][1873] 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-12-01 08:37:00,053 [salt.state       ][INFO    ][1873] Loading fresh modules for state activity
2017-12-01 08:37:00,065 [salt.state       ][INFO    ][1873] Completed state [linux_sysfs_package] at time 08:37:00.065006 duration_in_ms=16680.068
2017-12-01 08:37:00,067 [salt.state       ][INFO    ][1873] Running state [/etc/sysfs.d] at time 08:37:00.067288
2017-12-01 08:37:00,068 [salt.state       ][INFO    ][1873] Executing state file.directory for /etc/sysfs.d
2017-12-01 08:37:00,070 [salt.state       ][INFO    ][1873] Directory /etc/sysfs.d is in the correct state
2017-12-01 08:37:00,070 [salt.state       ][INFO    ][1873] Completed state [/etc/sysfs.d] at time 08:37:00.069737 duration_in_ms=2.449
2017-12-01 08:37:00,137 [salt.state       ][INFO    ][1873] Running state [ondemand] at time 08:37:00.136731
2017-12-01 08:37:00,137 [salt.state       ][INFO    ][1873] Executing state service.dead for ondemand
2017-12-01 08:37:00,139 [salt.loaded.int.module.cmdmod][INFO    ][1873] Executing command ['systemctl', 'status', 'ondemand.service', '-n', '0'] in directory '/root'
2017-12-01 08:37:00,149 [salt.loaded.int.module.cmdmod][INFO    ][1873] Executing command ['systemctl', 'is-active', 'ondemand.service'] in directory '/root'
2017-12-01 08:37:00,157 [salt.loaded.int.module.cmdmod][INFO    ][1873] Executing command ['systemctl', 'is-enabled', 'ondemand.service'] in directory '/root'
2017-12-01 08:37:00,166 [salt.loaded.int.module.cmdmod][INFO    ][1873] Executing command ['systemd-run', '--scope', 'systemctl', 'stop', 'ondemand.service'] in directory '/root'
2017-12-01 08:37:00,206 [salt.loaded.int.module.cmdmod][INFO    ][1873] Executing command ['systemctl', 'is-active', 'ondemand.service'] in directory '/root'
2017-12-01 08:37:00,214 [salt.loaded.int.module.cmdmod][INFO    ][1873] Executing command ['systemctl', 'is-enabled', 'ondemand.service'] in directory '/root'
2017-12-01 08:37:00,223 [salt.loaded.int.module.cmdmod][INFO    ][1873] Executing command ['systemctl', 'is-enabled', 'ondemand.service'] in directory '/root'
2017-12-01 08:37:00,233 [salt.loaded.int.module.cmdmod][INFO    ][1873] Executing command ['systemd-run', '--scope', '/usr/sbin/update-rc.d', '-f', 'ondemand', 'remove'] in directory '/root'
2017-12-01 08:37:00,298 [salt.loaded.int.module.cmdmod][INFO    ][1873] Executing command ['systemctl', 'is-enabled', 'ondemand.service'] in directory '/root'
2017-12-01 08:37:00,309 [salt.loaded.int.module.cmdmod][INFO    ][1873] Executing command 'runlevel' in directory '/root'
2017-12-01 08:37:00,315 [salt.state       ][INFO    ][1873] {'ondemand': True}
2017-12-01 08:37:00,315 [salt.state       ][INFO    ][1873] Completed state [ondemand] at time 08:37:00.314903 duration_in_ms=178.171
2017-12-01 08:37:00,361 [salt.state       ][INFO    ][1873] Running state [cs_CZ.UTF-8] at time 08:37:00.360960
2017-12-01 08:37:00,361 [salt.state       ][INFO    ][1873] Executing state locale.present for cs_CZ.UTF-8
2017-12-01 08:37:00,362 [salt.loaded.int.module.cmdmod][INFO    ][1873] Executing command 'locale -a' in directory '/root'
2017-12-01 08:37:00,371 [salt.loaded.int.module.cmdmod][INFO    ][1873] Executing command ['locale-gen', 'cs_CZ.UTF-8'] in directory '/root'
2017-12-01 08:37:01,400 [salt.state       ][INFO    ][1873] {'locale': 'cs_CZ.UTF-8'}
2017-12-01 08:37:01,400 [salt.state       ][INFO    ][1873] Completed state [cs_CZ.UTF-8] at time 08:37:01.400383 duration_in_ms=1039.421
2017-12-01 08:37:01,401 [salt.state       ][INFO    ][1873] Running state [en_US.UTF-8] at time 08:37:01.400668
2017-12-01 08:37:01,401 [salt.state       ][INFO    ][1873] Executing state locale.present for en_US.UTF-8
2017-12-01 08:37:01,401 [salt.loaded.int.module.cmdmod][INFO    ][1873] Executing command 'locale -a' in directory '/root'
2017-12-01 08:37:01,407 [salt.state       ][INFO    ][1873] Locale en_US.UTF-8 is already present
2017-12-01 08:37:01,407 [salt.state       ][INFO    ][1873] Completed state [en_US.UTF-8] at time 08:37:01.407169 duration_in_ms=6.501
2017-12-01 08:37:01,408 [salt.state       ][INFO    ][1873] Running state [en_US.UTF-8] at time 08:37:01.408041
2017-12-01 08:37:01,408 [salt.state       ][INFO    ][1873] Executing state locale.system for en_US.UTF-8
2017-12-01 08:37:01,409 [salt.loaded.int.module.cmdmod][INFO    ][1873] Executing command 'localectl' in directory '/root'
2017-12-01 08:37:01,538 [salt.state       ][INFO    ][1873] System locale en_US.UTF-8 already set
2017-12-01 08:37:01,538 [salt.state       ][INFO    ][1873] Completed state [en_US.UTF-8] at time 08:37:01.538289 duration_in_ms=130.246
2017-12-01 08:37:01,547 [salt.state       ][INFO    ][1873] Running state [root] at time 08:37:01.546845
2017-12-01 08:37:01,547 [salt.state       ][INFO    ][1873] Executing state user.present for root
2017-12-01 08:37:01,553 [salt.state       ][INFO    ][1873] {'passwd': 'XXX-REDACTED-XXX', 'lstchg': 17501}
2017-12-01 08:37:01,553 [salt.state       ][INFO    ][1873] Completed state [root] at time 08:37:01.553202 duration_in_ms=6.357
2017-12-01 08:37:01,554 [salt.state       ][INFO    ][1873] Running state [/root] at time 08:37:01.554064
2017-12-01 08:37:01,554 [salt.state       ][INFO    ][1873] Executing state file.directory for /root
2017-12-01 08:37:01,555 [salt.state       ][INFO    ][1873] Directory /root is in the correct state
2017-12-01 08:37:01,555 [salt.state       ][INFO    ][1873] Completed state [/root] at time 08:37:01.555041 duration_in_ms=0.977
2017-12-01 08:37:01,555 [salt.state       ][INFO    ][1873] Running state [/etc/sudoers.d/90-salt-user-root] at time 08:37:01.555245
2017-12-01 08:37:01,555 [salt.state       ][INFO    ][1873] Executing state file.absent for /etc/sudoers.d/90-salt-user-root
2017-12-01 08:37:01,558 [salt.state       ][INFO    ][1873] File /etc/sudoers.d/90-salt-user-root is not present
2017-12-01 08:37:01,558 [salt.state       ][INFO    ][1873] Completed state [/etc/sudoers.d/90-salt-user-root] at time 08:37:01.558145 duration_in_ms=2.9
2017-12-01 08:37:01,558 [salt.state       ][INFO    ][1873] Running state [ubuntu] at time 08:37:01.558364
2017-12-01 08:37:01,559 [salt.state       ][INFO    ][1873] Executing state user.present for ubuntu
2017-12-01 08:37:01,559 [salt.loaded.int.module.cmdmod][INFO    ][1873] Executing command ['useradd', '-s', '/bin/bash', '-m', '-d', '/home/ubuntu', 'ubuntu'] in directory '/root'
2017-12-01 08:37:03,440 [salt.state       ][INFO    ][1873] {'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-12-01 08:37:03,441 [salt.state       ][INFO    ][1873] Completed state [ubuntu] at time 08:37:03.440467 duration_in_ms=1882.101
2017-12-01 08:37:03,442 [salt.state       ][INFO    ][1873] Running state [/home/ubuntu] at time 08:37:03.441740
2017-12-01 08:37:03,442 [salt.state       ][INFO    ][1873] Executing state file.directory for /home/ubuntu
2017-12-01 08:37:03,443 [salt.state       ][INFO    ][1873] {'mode': '0700'}
2017-12-01 08:37:03,444 [salt.state       ][INFO    ][1873] Completed state [/home/ubuntu] at time 08:37:03.443520 duration_in_ms=1.779
2017-12-01 08:37:03,444 [salt.state       ][INFO    ][1873] Running state [/etc/sudoers.d/90-salt-user-ubuntu] at time 08:37:03.444264
2017-12-01 08:37:03,445 [salt.state       ][INFO    ][1873] Executing state file.managed for /etc/sudoers.d/90-salt-user-ubuntu
2017-12-01 08:37:03,466 [salt.fileclient  ][INFO    ][1873] Fetching file from saltenv 'base', ** done ** 'linux/files/sudoer'
2017-12-01 08:37:03,469 [salt.loaded.int.module.cmdmod][INFO    ][1873] Executing command '/usr/sbin/visudo -c -f /tmp/tmpV7Yr7R' in directory '/root'
2017-12-01 08:37:03,568 [salt.state       ][INFO    ][1873] File changed:
New file
2017-12-01 08:37:03,569 [salt.state       ][INFO    ][1873] Completed state [/etc/sudoers.d/90-salt-user-ubuntu] at time 08:37:03.569000 duration_in_ms=124.734
2017-12-01 08:37:03,570 [salt.state       ][INFO    ][1873] Running state [/etc/security/limits.d/90-salt-default.conf] at time 08:37:03.569473
2017-12-01 08:37:03,570 [salt.state       ][INFO    ][1873] Executing state file.managed for /etc/security/limits.d/90-salt-default.conf
2017-12-01 08:37:03,590 [salt.fileclient  ][INFO    ][1873] Fetching file from saltenv 'base', ** done ** 'linux/files/limits.conf'
2017-12-01 08:37:03,610 [salt.fileclient  ][INFO    ][1873] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-12-01 08:37:03,646 [salt.state       ][INFO    ][1873] File changed:
New file
2017-12-01 08:37:03,647 [salt.state       ][INFO    ][1873] Completed state [/etc/security/limits.d/90-salt-default.conf] at time 08:37:03.646531 duration_in_ms=77.058
2017-12-01 08:37:03,647 [salt.state       ][INFO    ][1873] Running state [apt-daily.timer] at time 08:37:03.646854
2017-12-01 08:37:03,647 [salt.state       ][INFO    ][1873] Executing state service.dead for apt-daily.timer
2017-12-01 08:37:03,648 [salt.loaded.int.module.cmdmod][INFO    ][1873] Executing command ['systemctl', 'status', 'apt-daily.timer', '-n', '0'] in directory '/root'
2017-12-01 08:37:03,657 [salt.loaded.int.module.cmdmod][INFO    ][1873] Executing command ['systemctl', 'is-active', 'apt-daily.timer'] in directory '/root'
2017-12-01 08:37:03,663 [salt.loaded.int.module.cmdmod][INFO    ][1873] Executing command ['systemctl', 'is-enabled', 'apt-daily.timer'] in directory '/root'
2017-12-01 08:37:03,671 [salt.state       ][INFO    ][1873] The service apt-daily.timer is already dead
2017-12-01 08:37:03,671 [salt.state       ][INFO    ][1873] Completed state [apt-daily.timer] at time 08:37:03.671380 duration_in_ms=24.525
2017-12-01 08:37:03,672 [salt.state       ][INFO    ][1873] Running state [/etc/systemd/system.conf.d/90-salt.conf] at time 08:37:03.671749
2017-12-01 08:37:03,672 [salt.state       ][INFO    ][1873] Executing state file.managed for /etc/systemd/system.conf.d/90-salt.conf
2017-12-01 08:37:03,690 [salt.fileclient  ][INFO    ][1873] Fetching file from saltenv 'base', ** done ** 'linux/files/systemd.conf'
2017-12-01 08:37:03,709 [salt.fileclient  ][INFO    ][1873] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-12-01 08:37:03,744 [salt.state       ][INFO    ][1873] File changed:
New file
2017-12-01 08:37:03,744 [salt.state       ][INFO    ][1873] Completed state [/etc/systemd/system.conf.d/90-salt.conf] at time 08:37:03.743829 duration_in_ms=72.08
2017-12-01 08:37:03,745 [salt.state       ][INFO    ][1873] Running state [service.systemctl_reload] at time 08:37:03.744964
2017-12-01 08:37:03,745 [salt.state       ][INFO    ][1873] Executing state module.wait for service.systemctl_reload
2017-12-01 08:37:03,746 [salt.state       ][INFO    ][1873] No changes made for service.systemctl_reload
2017-12-01 08:37:03,746 [salt.state       ][INFO    ][1873] Completed state [service.systemctl_reload] at time 08:37:03.745850 duration_in_ms=0.886
2017-12-01 08:37:03,746 [salt.state       ][INFO    ][1873] Running state [service.systemctl_reload] at time 08:37:03.746122
2017-12-01 08:37:03,746 [salt.state       ][INFO    ][1873] Executing state module.mod_watch for service.systemctl_reload
2017-12-01 08:37:03,747 [salt.loaded.int.module.cmdmod][INFO    ][1873] Executing command ['systemctl', '--system', 'daemon-reload'] in directory '/root'
2017-12-01 08:37:03,781 [salt.state       ][INFO    ][1873] {'ret': True}
2017-12-01 08:37:03,781 [salt.state       ][INFO    ][1873] Completed state [service.systemctl_reload] at time 08:37:03.781021 duration_in_ms=34.898
2017-12-01 08:37:03,781 [salt.state       ][INFO    ][1873] Running state [/etc/hostname] at time 08:37:03.781454
2017-12-01 08:37:03,782 [salt.state       ][INFO    ][1873] Executing state file.managed for /etc/hostname
2017-12-01 08:37:03,799 [salt.fileclient  ][INFO    ][1873] Fetching file from saltenv 'base', ** done ** 'linux/files/hostname'
2017-12-01 08:37:03,801 [salt.state       ][INFO    ][1873] File changed:
--- 
+++ 
@@ -1 +1 @@
-ubuntu-1604
+dbs02

2017-12-01 08:37:03,802 [salt.state       ][INFO    ][1873] Completed state [/etc/hostname] at time 08:37:03.801963 duration_in_ms=20.509
2017-12-01 08:37:03,803 [salt.state       ][INFO    ][1873] Running state [hostname dbs02] at time 08:37:03.803456
2017-12-01 08:37:03,804 [salt.state       ][INFO    ][1873] Executing state cmd.wait for hostname dbs02
2017-12-01 08:37:03,804 [salt.state       ][INFO    ][1873] No changes made for hostname dbs02
2017-12-01 08:37:03,804 [salt.state       ][INFO    ][1873] Completed state [hostname dbs02] at time 08:37:03.804349 duration_in_ms=0.893
2017-12-01 08:37:03,805 [salt.state       ][INFO    ][1873] Running state [hostname dbs02] at time 08:37:03.804623
2017-12-01 08:37:03,805 [salt.state       ][INFO    ][1873] Executing state cmd.mod_watch for hostname dbs02
2017-12-01 08:37:03,806 [salt.loaded.int.module.cmdmod][INFO    ][1873] Executing command 'hostname dbs02' in directory '/root'
2017-12-01 08:37:03,813 [salt.state       ][INFO    ][1873] {'pid': 5466, 'retcode': 0, 'stderr': '', 'stdout': ''}
2017-12-01 08:37:03,813 [salt.state       ][INFO    ][1873] Completed state [hostname dbs02] at time 08:37:03.812911 duration_in_ms=8.286
2017-12-01 08:37:03,840 [salt.state       ][INFO    ][1873] Running state [mdb02.baremetal-mcp-ocata-ovs-dpdk-ha.local] at time 08:37:03.840034
2017-12-01 08:37:03,840 [salt.state       ][INFO    ][1873] Executing state host.present for mdb02.baremetal-mcp-ocata-ovs-dpdk-ha.local
2017-12-01 08:37:03,842 [salt.state       ][INFO    ][1873] {'host': 'mdb02.baremetal-mcp-ocata-ovs-dpdk-ha.local'}
2017-12-01 08:37:03,842 [salt.state       ][INFO    ][1873] Completed state [mdb02.baremetal-mcp-ocata-ovs-dpdk-ha.local] at time 08:37:03.841969 duration_in_ms=1.935
2017-12-01 08:37:03,842 [salt.state       ][INFO    ][1873] Running state [mdb02] at time 08:37:03.842259
2017-12-01 08:37:03,843 [salt.state       ][INFO    ][1873] Executing state host.present for mdb02
2017-12-01 08:37:03,874 [salt.state       ][INFO    ][1873] {'host': 'mdb02'}
2017-12-01 08:37:03,874 [salt.state       ][INFO    ][1873] Completed state [mdb02] at time 08:37:03.874232 duration_in_ms=31.973
2017-12-01 08:37:03,875 [salt.state       ][INFO    ][1873] Running state [mdb03.baremetal-mcp-ocata-ovs-dpdk-ha.local] at time 08:37:03.874528
2017-12-01 08:37:03,875 [salt.state       ][INFO    ][1873] Executing state host.present for mdb03.baremetal-mcp-ocata-ovs-dpdk-ha.local
2017-12-01 08:37:03,940 [salt.state       ][INFO    ][1873] {'host': 'mdb03.baremetal-mcp-ocata-ovs-dpdk-ha.local'}
2017-12-01 08:37:03,940 [salt.state       ][INFO    ][1873] Completed state [mdb03.baremetal-mcp-ocata-ovs-dpdk-ha.local] at time 08:37:03.940400 duration_in_ms=65.872
2017-12-01 08:37:03,941 [salt.state       ][INFO    ][1873] Running state [mdb03] at time 08:37:03.940767
2017-12-01 08:37:03,941 [salt.state       ][INFO    ][1873] Executing state host.present for mdb03
2017-12-01 08:37:03,964 [salt.state       ][INFO    ][1873] {'host': 'mdb03'}
2017-12-01 08:37:03,964 [salt.state       ][INFO    ][1873] Completed state [mdb03] at time 08:37:03.964176 duration_in_ms=23.409
2017-12-01 08:37:03,965 [salt.state       ][INFO    ][1873] Running state [mdb01.baremetal-mcp-ocata-ovs-dpdk-ha.local] at time 08:37:03.964500
2017-12-01 08:37:03,965 [salt.state       ][INFO    ][1873] Executing state host.present for mdb01.baremetal-mcp-ocata-ovs-dpdk-ha.local
2017-12-01 08:37:04,060 [salt.state       ][INFO    ][1873] {'host': 'mdb01.baremetal-mcp-ocata-ovs-dpdk-ha.local'}
2017-12-01 08:37:04,060 [salt.state       ][INFO    ][1873] Completed state [mdb01.baremetal-mcp-ocata-ovs-dpdk-ha.local] at time 08:37:04.060326 duration_in_ms=95.826
2017-12-01 08:37:04,061 [salt.state       ][INFO    ][1873] Running state [mdb01] at time 08:37:04.060747
2017-12-01 08:37:04,061 [salt.state       ][INFO    ][1873] Executing state host.present for mdb01
2017-12-01 08:37:04,165 [salt.minion      ][INFO    ][1735] User sudo_ubuntu Executing command saltutil.find_job with jid 20171201083704158619
2017-12-01 08:37:04,183 [salt.minion      ][INFO    ][5470] Starting a new job with PID 5470
2017-12-01 08:37:04,199 [salt.minion      ][INFO    ][5470] Returning information for job: 20171201083704158619
2017-12-01 08:37:04,202 [salt.state       ][INFO    ][1873] {'host': 'mdb01'}
2017-12-01 08:37:04,202 [salt.state       ][INFO    ][1873] Completed state [mdb01] at time 08:37:04.202009 duration_in_ms=141.261
2017-12-01 08:37:04,202 [salt.state       ][INFO    ][1873] Running state [mdb] at time 08:37:04.202383
2017-12-01 08:37:04,203 [salt.state       ][INFO    ][1873] Executing state host.present for mdb
2017-12-01 08:37:04,267 [salt.state       ][INFO    ][1873] {'host': 'mdb'}
2017-12-01 08:37:04,268 [salt.state       ][INFO    ][1873] Completed state [mdb] at time 08:37:04.267842 duration_in_ms=65.458
2017-12-01 08:37:04,268 [salt.state       ][INFO    ][1873] Running state [mdb.baremetal-mcp-ocata-ovs-dpdk-ha.local] at time 08:37:04.268161
2017-12-01 08:37:04,268 [salt.state       ][INFO    ][1873] Executing state host.present for mdb.baremetal-mcp-ocata-ovs-dpdk-ha.local
2017-12-01 08:37:04,285 [salt.state       ][INFO    ][1873] {'host': 'mdb.baremetal-mcp-ocata-ovs-dpdk-ha.local'}
2017-12-01 08:37:04,286 [salt.state       ][INFO    ][1873] Completed state [mdb.baremetal-mcp-ocata-ovs-dpdk-ha.local] at time 08:37:04.285632 duration_in_ms=17.47
2017-12-01 08:37:04,286 [salt.state       ][INFO    ][1873] Running state [cfg01.baremetal-mcp-ocata-ovs-dpdk-ha.local] at time 08:37:04.285934
2017-12-01 08:37:04,286 [salt.state       ][INFO    ][1873] Executing state host.present for cfg01.baremetal-mcp-ocata-ovs-dpdk-ha.local
2017-12-01 08:37:04,369 [salt.state       ][INFO    ][1873] {'host': 'cfg01.baremetal-mcp-ocata-ovs-dpdk-ha.local'}
2017-12-01 08:37:04,370 [salt.state       ][INFO    ][1873] Completed state [cfg01.baremetal-mcp-ocata-ovs-dpdk-ha.local] at time 08:37:04.369890 duration_in_ms=83.955
2017-12-01 08:37:04,370 [salt.state       ][INFO    ][1873] Running state [cfg01] at time 08:37:04.370254
2017-12-01 08:37:04,371 [salt.state       ][INFO    ][1873] Executing state host.present for cfg01
2017-12-01 08:37:04,411 [salt.state       ][INFO    ][1873] {'host': 'cfg01'}
2017-12-01 08:37:04,411 [salt.state       ][INFO    ][1873] Completed state [cfg01] at time 08:37:04.411421 duration_in_ms=41.167
2017-12-01 08:37:04,412 [salt.state       ][INFO    ][1873] Running state [prx01.baremetal-mcp-ocata-ovs-dpdk-ha.local] at time 08:37:04.411748
2017-12-01 08:37:04,412 [salt.state       ][INFO    ][1873] Executing state host.present for prx01.baremetal-mcp-ocata-ovs-dpdk-ha.local
2017-12-01 08:37:04,441 [salt.state       ][INFO    ][1873] {'host': 'prx01.baremetal-mcp-ocata-ovs-dpdk-ha.local'}
2017-12-01 08:37:04,441 [salt.state       ][INFO    ][1873] Completed state [prx01.baremetal-mcp-ocata-ovs-dpdk-ha.local] at time 08:37:04.441454 duration_in_ms=29.705
2017-12-01 08:37:04,442 [salt.state       ][INFO    ][1873] Running state [prx01] at time 08:37:04.441883
2017-12-01 08:37:04,442 [salt.state       ][INFO    ][1873] Executing state host.present for prx01
2017-12-01 08:37:04,495 [salt.state       ][INFO    ][1873] {'host': 'prx01'}
2017-12-01 08:37:04,495 [salt.state       ][INFO    ][1873] Completed state [prx01] at time 08:37:04.495335 duration_in_ms=53.452
2017-12-01 08:37:04,496 [salt.state       ][INFO    ][1873] Running state [kvm01.baremetal-mcp-ocata-ovs-dpdk-ha.local] at time 08:37:04.495718
2017-12-01 08:37:04,496 [salt.state       ][INFO    ][1873] Executing state host.present for kvm01.baremetal-mcp-ocata-ovs-dpdk-ha.local
2017-12-01 08:37:04,555 [salt.state       ][INFO    ][1873] {'host': 'kvm01.baremetal-mcp-ocata-ovs-dpdk-ha.local'}
2017-12-01 08:37:04,556 [salt.state       ][INFO    ][1873] Completed state [kvm01.baremetal-mcp-ocata-ovs-dpdk-ha.local] at time 08:37:04.555712 duration_in_ms=59.994
2017-12-01 08:37:04,556 [salt.state       ][INFO    ][1873] Running state [kvm01] at time 08:37:04.556117
2017-12-01 08:37:04,556 [salt.state       ][INFO    ][1873] Executing state host.present for kvm01
2017-12-01 08:37:04,597 [salt.state       ][INFO    ][1873] {'host': 'kvm01'}
2017-12-01 08:37:04,597 [salt.state       ][INFO    ][1873] Completed state [kvm01] at time 08:37:04.597055 duration_in_ms=40.938
2017-12-01 08:37:04,597 [salt.state       ][INFO    ][1873] Running state [kvm03.baremetal-mcp-ocata-ovs-dpdk-ha.local] at time 08:37:04.597444
2017-12-01 08:37:04,598 [salt.state       ][INFO    ][1873] Executing state host.present for kvm03.baremetal-mcp-ocata-ovs-dpdk-ha.local
2017-12-01 08:37:04,693 [salt.state       ][INFO    ][1873] {'host': 'kvm03.baremetal-mcp-ocata-ovs-dpdk-ha.local'}
2017-12-01 08:37:04,693 [salt.state       ][INFO    ][1873] Completed state [kvm03.baremetal-mcp-ocata-ovs-dpdk-ha.local] at time 08:37:04.693056 duration_in_ms=95.612
2017-12-01 08:37:04,693 [salt.state       ][INFO    ][1873] Running state [kvm03] at time 08:37:04.693435
2017-12-01 08:37:04,694 [salt.state       ][INFO    ][1873] Executing state host.present for kvm03
2017-12-01 08:37:04,699 [salt.state       ][INFO    ][1873] {'host': 'kvm03'}
2017-12-01 08:37:04,699 [salt.state       ][INFO    ][1873] Completed state [kvm03] at time 08:37:04.698954 duration_in_ms=5.518
2017-12-01 08:37:04,699 [salt.state       ][INFO    ][1873] Running state [kvm02.baremetal-mcp-ocata-ovs-dpdk-ha.local] at time 08:37:04.699325
2017-12-01 08:37:04,700 [salt.state       ][INFO    ][1873] Executing state host.present for kvm02.baremetal-mcp-ocata-ovs-dpdk-ha.local
2017-12-01 08:37:04,705 [salt.state       ][INFO    ][1873] {'host': 'kvm02.baremetal-mcp-ocata-ovs-dpdk-ha.local'}
2017-12-01 08:37:04,705 [salt.state       ][INFO    ][1873] Completed state [kvm02.baremetal-mcp-ocata-ovs-dpdk-ha.local] at time 08:37:04.704750 duration_in_ms=5.425
2017-12-01 08:37:04,705 [salt.state       ][INFO    ][1873] Running state [kvm02] at time 08:37:04.705045
2017-12-01 08:37:04,705 [salt.state       ][INFO    ][1873] Executing state host.present for kvm02
2017-12-01 08:37:04,711 [salt.state       ][INFO    ][1873] {'host': 'kvm02'}
2017-12-01 08:37:04,711 [salt.state       ][INFO    ][1873] Completed state [kvm02] at time 08:37:04.710912 duration_in_ms=5.867
2017-12-01 08:37:04,711 [salt.state       ][INFO    ][1873] Running state [dbs.baremetal-mcp-ocata-ovs-dpdk-ha.local] at time 08:37:04.711186
2017-12-01 08:37:04,711 [salt.state       ][INFO    ][1873] Executing state host.present for dbs.baremetal-mcp-ocata-ovs-dpdk-ha.local
2017-12-01 08:37:04,717 [salt.state       ][INFO    ][1873] {'host': 'dbs.baremetal-mcp-ocata-ovs-dpdk-ha.local'}
2017-12-01 08:37:04,717 [salt.state       ][INFO    ][1873] Completed state [dbs.baremetal-mcp-ocata-ovs-dpdk-ha.local] at time 08:37:04.716968 duration_in_ms=5.782
2017-12-01 08:37:04,717 [salt.state       ][INFO    ][1873] Running state [dbs] at time 08:37:04.717272
2017-12-01 08:37:04,718 [salt.state       ][INFO    ][1873] Executing state host.present for dbs
2017-12-01 08:37:04,723 [salt.state       ][INFO    ][1873] {'host': 'dbs'}
2017-12-01 08:37:04,723 [salt.state       ][INFO    ][1873] Completed state [dbs] at time 08:37:04.722947 duration_in_ms=5.674
2017-12-01 08:37:04,723 [salt.state       ][INFO    ][1873] Running state [prx.baremetal-mcp-ocata-ovs-dpdk-ha.local] at time 08:37:04.723231
2017-12-01 08:37:04,724 [salt.state       ][INFO    ][1873] Executing state host.present for prx.baremetal-mcp-ocata-ovs-dpdk-ha.local
2017-12-01 08:37:04,788 [salt.state       ][INFO    ][1873] {'host': 'prx.baremetal-mcp-ocata-ovs-dpdk-ha.local'}
2017-12-01 08:37:04,789 [salt.state       ][INFO    ][1873] Completed state [prx.baremetal-mcp-ocata-ovs-dpdk-ha.local] at time 08:37:04.788683 duration_in_ms=65.452
2017-12-01 08:37:04,789 [salt.state       ][INFO    ][1873] Running state [prx] at time 08:37:04.788959
2017-12-01 08:37:04,789 [salt.state       ][INFO    ][1873] Executing state host.present for prx
2017-12-01 08:37:04,800 [salt.state       ][INFO    ][1873] {'host': 'prx'}
2017-12-01 08:37:04,801 [salt.state       ][INFO    ][1873] Completed state [prx] at time 08:37:04.800464 duration_in_ms=11.505
2017-12-01 08:37:04,801 [salt.state       ][INFO    ][1873] Running state [prx02] at time 08:37:04.800733
2017-12-01 08:37:04,801 [salt.state       ][INFO    ][1873] Executing state host.present for prx02
2017-12-01 08:37:04,806 [salt.state       ][INFO    ][1873] {'host': 'prx02'}
2017-12-01 08:37:04,806 [salt.state       ][INFO    ][1873] Completed state [prx02] at time 08:37:04.806137 duration_in_ms=5.404
2017-12-01 08:37:04,806 [salt.state       ][INFO    ][1873] Running state [prx02.baremetal-mcp-ocata-ovs-dpdk-ha.local] at time 08:37:04.806388
2017-12-01 08:37:04,807 [salt.state       ][INFO    ][1873] Executing state host.present for prx02.baremetal-mcp-ocata-ovs-dpdk-ha.local
2017-12-01 08:37:04,812 [salt.state       ][INFO    ][1873] {'host': 'prx02.baremetal-mcp-ocata-ovs-dpdk-ha.local'}
2017-12-01 08:37:04,812 [salt.state       ][INFO    ][1873] Completed state [prx02.baremetal-mcp-ocata-ovs-dpdk-ha.local] at time 08:37:04.812152 duration_in_ms=5.764
2017-12-01 08:37:04,812 [salt.state       ][INFO    ][1873] Running state [msg02.baremetal-mcp-ocata-ovs-dpdk-ha.local] at time 08:37:04.812393
2017-12-01 08:37:04,813 [salt.state       ][INFO    ][1873] Executing state host.present for msg02.baremetal-mcp-ocata-ovs-dpdk-ha.local
2017-12-01 08:37:04,818 [salt.state       ][INFO    ][1873] {'host': 'msg02.baremetal-mcp-ocata-ovs-dpdk-ha.local'}
2017-12-01 08:37:04,818 [salt.state       ][INFO    ][1873] Completed state [msg02.baremetal-mcp-ocata-ovs-dpdk-ha.local] at time 08:37:04.818158 duration_in_ms=5.765
2017-12-01 08:37:04,818 [salt.state       ][INFO    ][1873] Running state [msg02] at time 08:37:04.818392
2017-12-01 08:37:04,819 [salt.state       ][INFO    ][1873] Executing state host.present for msg02
2017-12-01 08:37:04,824 [salt.state       ][INFO    ][1873] {'host': 'msg02'}
2017-12-01 08:37:04,824 [salt.state       ][INFO    ][1873] Completed state [msg02] at time 08:37:04.824176 duration_in_ms=5.784
2017-12-01 08:37:04,824 [salt.state       ][INFO    ][1873] Running state [msg03.baremetal-mcp-ocata-ovs-dpdk-ha.local] at time 08:37:04.824413
2017-12-01 08:37:04,825 [salt.state       ][INFO    ][1873] Executing state host.present for msg03.baremetal-mcp-ocata-ovs-dpdk-ha.local
2017-12-01 08:37:04,830 [salt.state       ][INFO    ][1873] {'host': 'msg03.baremetal-mcp-ocata-ovs-dpdk-ha.local'}
2017-12-01 08:37:04,830 [salt.state       ][INFO    ][1873] Completed state [msg03.baremetal-mcp-ocata-ovs-dpdk-ha.local] at time 08:37:04.830161 duration_in_ms=5.749
2017-12-01 08:37:04,830 [salt.state       ][INFO    ][1873] Running state [msg03] at time 08:37:04.830396
2017-12-01 08:37:04,831 [salt.state       ][INFO    ][1873] Executing state host.present for msg03
2017-12-01 08:37:04,836 [salt.state       ][INFO    ][1873] {'host': 'msg03'}
2017-12-01 08:37:04,836 [salt.state       ][INFO    ][1873] Completed state [msg03] at time 08:37:04.836166 duration_in_ms=5.771
2017-12-01 08:37:04,836 [salt.state       ][INFO    ][1873] Running state [msg01.baremetal-mcp-ocata-ovs-dpdk-ha.local] at time 08:37:04.836396
2017-12-01 08:37:04,837 [salt.state       ][INFO    ][1873] Executing state host.present for msg01.baremetal-mcp-ocata-ovs-dpdk-ha.local
2017-12-01 08:37:04,842 [salt.state       ][INFO    ][1873] {'host': 'msg01.baremetal-mcp-ocata-ovs-dpdk-ha.local'}
2017-12-01 08:37:04,842 [salt.state       ][INFO    ][1873] Completed state [msg01.baremetal-mcp-ocata-ovs-dpdk-ha.local] at time 08:37:04.842181 duration_in_ms=5.785
2017-12-01 08:37:04,842 [salt.state       ][INFO    ][1873] Running state [msg01] at time 08:37:04.842409
2017-12-01 08:37:04,843 [salt.state       ][INFO    ][1873] Executing state host.present for msg01
2017-12-01 08:37:04,848 [salt.state       ][INFO    ][1873] {'host': 'msg01'}
2017-12-01 08:37:04,848 [salt.state       ][INFO    ][1873] Completed state [msg01] at time 08:37:04.848201 duration_in_ms=5.792
2017-12-01 08:37:04,848 [salt.state       ][INFO    ][1873] Running state [msg] at time 08:37:04.848422
2017-12-01 08:37:04,849 [salt.state       ][INFO    ][1873] Executing state host.present for msg
2017-12-01 08:37:04,854 [salt.state       ][INFO    ][1873] {'host': 'msg'}
2017-12-01 08:37:04,854 [salt.state       ][INFO    ][1873] Completed state [msg] at time 08:37:04.854192 duration_in_ms=5.771
2017-12-01 08:37:04,854 [salt.state       ][INFO    ][1873] Running state [msg.baremetal-mcp-ocata-ovs-dpdk-ha.local] at time 08:37:04.854419
2017-12-01 08:37:04,855 [salt.state       ][INFO    ][1873] Executing state host.present for msg.baremetal-mcp-ocata-ovs-dpdk-ha.local
2017-12-01 08:37:04,860 [salt.state       ][INFO    ][1873] {'host': 'msg.baremetal-mcp-ocata-ovs-dpdk-ha.local'}
2017-12-01 08:37:04,860 [salt.state       ][INFO    ][1873] Completed state [msg.baremetal-mcp-ocata-ovs-dpdk-ha.local] at time 08:37:04.860191 duration_in_ms=5.773
2017-12-01 08:37:04,860 [salt.state       ][INFO    ][1873] Running state [cfg01.baremetal-mcp-ocata-ovs-dpdk-ha.local] at time 08:37:04.860407
2017-12-01 08:37:04,861 [salt.state       ][INFO    ][1873] Executing state host.present for cfg01.baremetal-mcp-ocata-ovs-dpdk-ha.local
2017-12-01 08:37:04,861 [salt.state       ][INFO    ][1873] Host cfg01.baremetal-mcp-ocata-ovs-dpdk-ha.local (10.167.4.100) already present
2017-12-01 08:37:04,861 [salt.state       ][INFO    ][1873] Completed state [cfg01.baremetal-mcp-ocata-ovs-dpdk-ha.local] at time 08:37:04.861195 duration_in_ms=0.788
2017-12-01 08:37:04,861 [salt.state       ][INFO    ][1873] Running state [cfg01] at time 08:37:04.861413
2017-12-01 08:37:04,862 [salt.state       ][INFO    ][1873] Executing state host.present for cfg01
2017-12-01 08:37:04,862 [salt.state       ][INFO    ][1873] Host cfg01 (10.167.4.100) already present
2017-12-01 08:37:04,862 [salt.state       ][INFO    ][1873] Completed state [cfg01] at time 08:37:04.862132 duration_in_ms=0.719
2017-12-01 08:37:04,862 [salt.state       ][INFO    ][1873] Running state [cmp002] at time 08:37:04.862343
2017-12-01 08:37:04,863 [salt.state       ][INFO    ][1873] Executing state host.present for cmp002
2017-12-01 08:37:04,866 [salt.state       ][INFO    ][1873] {'host': 'cmp002'}
2017-12-01 08:37:04,866 [salt.state       ][INFO    ][1873] Completed state [cmp002] at time 08:37:04.866191 duration_in_ms=3.847
2017-12-01 08:37:04,866 [salt.state       ][INFO    ][1873] Running state [cmp002.baremetal-mcp-ocata-ovs-dpdk-ha.local] at time 08:37:04.866409
2017-12-01 08:37:04,867 [salt.state       ][INFO    ][1873] Executing state host.present for cmp002.baremetal-mcp-ocata-ovs-dpdk-ha.local
2017-12-01 08:37:04,872 [salt.state       ][INFO    ][1873] {'host': 'cmp002.baremetal-mcp-ocata-ovs-dpdk-ha.local'}
2017-12-01 08:37:04,872 [salt.state       ][INFO    ][1873] Completed state [cmp002.baremetal-mcp-ocata-ovs-dpdk-ha.local] at time 08:37:04.872198 duration_in_ms=5.789
2017-12-01 08:37:04,872 [salt.state       ][INFO    ][1873] Running state [cmp001.baremetal-mcp-ocata-ovs-dpdk-ha.local] at time 08:37:04.872412
2017-12-01 08:37:04,873 [salt.state       ][INFO    ][1873] Executing state host.present for cmp001.baremetal-mcp-ocata-ovs-dpdk-ha.local
2017-12-01 08:37:04,878 [salt.state       ][INFO    ][1873] {'host': 'cmp001.baremetal-mcp-ocata-ovs-dpdk-ha.local'}
2017-12-01 08:37:04,878 [salt.state       ][INFO    ][1873] Completed state [cmp001.baremetal-mcp-ocata-ovs-dpdk-ha.local] at time 08:37:04.878445 duration_in_ms=6.033
2017-12-01 08:37:04,879 [salt.state       ][INFO    ][1873] Running state [cmp001] at time 08:37:04.878659
2017-12-01 08:37:04,879 [salt.state       ][INFO    ][1873] Executing state host.present for cmp001
2017-12-01 08:37:04,884 [salt.state       ][INFO    ][1873] {'host': 'cmp001'}
2017-12-01 08:37:04,884 [salt.state       ][INFO    ][1873] Completed state [cmp001] at time 08:37:04.884279 duration_in_ms=5.62
2017-12-01 08:37:04,885 [salt.state       ][INFO    ][1873] Running state [dbs01.baremetal-mcp-ocata-ovs-dpdk-ha.local] at time 08:37:04.884491
2017-12-01 08:37:04,885 [salt.state       ][INFO    ][1873] Executing state host.present for dbs01.baremetal-mcp-ocata-ovs-dpdk-ha.local
2017-12-01 08:37:04,890 [salt.state       ][INFO    ][1873] {'host': 'dbs01.baremetal-mcp-ocata-ovs-dpdk-ha.local'}
2017-12-01 08:37:04,890 [salt.state       ][INFO    ][1873] Completed state [dbs01.baremetal-mcp-ocata-ovs-dpdk-ha.local] at time 08:37:04.890295 duration_in_ms=5.804
2017-12-01 08:37:04,891 [salt.state       ][INFO    ][1873] Running state [dbs01] at time 08:37:04.890511
2017-12-01 08:37:04,891 [salt.state       ][INFO    ][1873] Executing state host.present for dbs01
2017-12-01 08:37:05,030 [salt.state       ][INFO    ][1873] {'host': 'dbs01'}
2017-12-01 08:37:05,030 [salt.state       ][INFO    ][1873] Completed state [dbs01] at time 08:37:05.030243 duration_in_ms=139.732
2017-12-01 08:37:05,031 [salt.state       ][INFO    ][1873] Running state [dbs02.baremetal-mcp-ocata-ovs-dpdk-ha.local] at time 08:37:05.030483
2017-12-01 08:37:05,031 [salt.state       ][INFO    ][1873] Executing state host.present for dbs02.baremetal-mcp-ocata-ovs-dpdk-ha.local
2017-12-01 08:37:05,064 [salt.state       ][INFO    ][1873] {'host': 'dbs02.baremetal-mcp-ocata-ovs-dpdk-ha.local'}
2017-12-01 08:37:05,064 [salt.state       ][INFO    ][1873] Completed state [dbs02.baremetal-mcp-ocata-ovs-dpdk-ha.local] at time 08:37:05.064235 duration_in_ms=33.752
2017-12-01 08:37:05,065 [salt.state       ][INFO    ][1873] Running state [dbs02] at time 08:37:05.064491
2017-12-01 08:37:05,065 [salt.state       ][INFO    ][1873] Executing state host.present for dbs02
2017-12-01 08:37:05,070 [salt.state       ][INFO    ][1873] {'host': 'dbs02'}
2017-12-01 08:37:05,070 [salt.state       ][INFO    ][1873] Completed state [dbs02] at time 08:37:05.070093 duration_in_ms=5.602
2017-12-01 08:37:05,070 [salt.state       ][INFO    ][1873] Running state [dbs03.baremetal-mcp-ocata-ovs-dpdk-ha.local] at time 08:37:05.070331
2017-12-01 08:37:05,071 [salt.state       ][INFO    ][1873] Executing state host.present for dbs03.baremetal-mcp-ocata-ovs-dpdk-ha.local
2017-12-01 08:37:05,076 [salt.state       ][INFO    ][1873] {'host': 'dbs03.baremetal-mcp-ocata-ovs-dpdk-ha.local'}
2017-12-01 08:37:05,076 [salt.state       ][INFO    ][1873] Completed state [dbs03.baremetal-mcp-ocata-ovs-dpdk-ha.local] at time 08:37:05.076144 duration_in_ms=5.811
2017-12-01 08:37:05,076 [salt.state       ][INFO    ][1873] Running state [dbs03] at time 08:37:05.076380
2017-12-01 08:37:05,077 [salt.state       ][INFO    ][1873] Executing state host.present for dbs03
2017-12-01 08:37:05,082 [salt.state       ][INFO    ][1873] {'host': 'dbs03'}
2017-12-01 08:37:05,082 [salt.state       ][INFO    ][1873] Completed state [dbs03] at time 08:37:05.082139 duration_in_ms=5.759
2017-12-01 08:37:05,082 [salt.state       ][INFO    ][1873] Running state [mas01.baremetal-mcp-ocata-ovs-dpdk-ha.local] at time 08:37:05.082370
2017-12-01 08:37:05,083 [salt.state       ][INFO    ][1873] Executing state host.present for mas01.baremetal-mcp-ocata-ovs-dpdk-ha.local
2017-12-01 08:37:05,088 [salt.state       ][INFO    ][1873] {'host': 'mas01.baremetal-mcp-ocata-ovs-dpdk-ha.local'}
2017-12-01 08:37:05,088 [salt.state       ][INFO    ][1873] Completed state [mas01.baremetal-mcp-ocata-ovs-dpdk-ha.local] at time 08:37:05.088115 duration_in_ms=5.745
2017-12-01 08:37:05,088 [salt.state       ][INFO    ][1873] Running state [mas01] at time 08:37:05.088343
2017-12-01 08:37:05,089 [salt.state       ][INFO    ][1873] Executing state host.present for mas01
2017-12-01 08:37:05,094 [salt.state       ][INFO    ][1873] {'host': 'mas01'}
2017-12-01 08:37:05,094 [salt.state       ][INFO    ][1873] Completed state [mas01] at time 08:37:05.094119 duration_in_ms=5.776
2017-12-01 08:37:05,094 [salt.state       ][INFO    ][1873] Running state [ctl02.baremetal-mcp-ocata-ovs-dpdk-ha.local] at time 08:37:05.094353
2017-12-01 08:37:05,095 [salt.state       ][INFO    ][1873] Executing state host.present for ctl02.baremetal-mcp-ocata-ovs-dpdk-ha.local
2017-12-01 08:37:05,100 [salt.state       ][INFO    ][1873] {'host': 'ctl02.baremetal-mcp-ocata-ovs-dpdk-ha.local'}
2017-12-01 08:37:05,100 [salt.state       ][INFO    ][1873] Completed state [ctl02.baremetal-mcp-ocata-ovs-dpdk-ha.local] at time 08:37:05.100134 duration_in_ms=5.78
2017-12-01 08:37:05,100 [salt.state       ][INFO    ][1873] Running state [ctl02] at time 08:37:05.100354
2017-12-01 08:37:05,101 [salt.state       ][INFO    ][1873] Executing state host.present for ctl02
2017-12-01 08:37:05,106 [salt.state       ][INFO    ][1873] {'host': 'ctl02'}
2017-12-01 08:37:05,106 [salt.state       ][INFO    ][1873] Completed state [ctl02] at time 08:37:05.106291 duration_in_ms=5.938
2017-12-01 08:37:05,107 [salt.state       ][INFO    ][1873] Running state [ctl03.baremetal-mcp-ocata-ovs-dpdk-ha.local] at time 08:37:05.106531
2017-12-01 08:37:05,107 [salt.state       ][INFO    ][1873] Executing state host.present for ctl03.baremetal-mcp-ocata-ovs-dpdk-ha.local
2017-12-01 08:37:05,112 [salt.state       ][INFO    ][1873] {'host': 'ctl03.baremetal-mcp-ocata-ovs-dpdk-ha.local'}
2017-12-01 08:37:05,112 [salt.state       ][INFO    ][1873] Completed state [ctl03.baremetal-mcp-ocata-ovs-dpdk-ha.local] at time 08:37:05.112137 duration_in_ms=5.607
2017-12-01 08:37:05,112 [salt.state       ][INFO    ][1873] Running state [ctl03] at time 08:37:05.112356
2017-12-01 08:37:05,113 [salt.state       ][INFO    ][1873] Executing state host.present for ctl03
2017-12-01 08:37:05,118 [salt.state       ][INFO    ][1873] {'host': 'ctl03'}
2017-12-01 08:37:05,118 [salt.state       ][INFO    ][1873] Completed state [ctl03] at time 08:37:05.118137 duration_in_ms=5.78
2017-12-01 08:37:05,118 [salt.state       ][INFO    ][1873] Running state [ctl01.baremetal-mcp-ocata-ovs-dpdk-ha.local] at time 08:37:05.118354
2017-12-01 08:37:05,119 [salt.state       ][INFO    ][1873] Executing state host.present for ctl01.baremetal-mcp-ocata-ovs-dpdk-ha.local
2017-12-01 08:37:05,124 [salt.state       ][INFO    ][1873] {'host': 'ctl01.baremetal-mcp-ocata-ovs-dpdk-ha.local'}
2017-12-01 08:37:05,124 [salt.state       ][INFO    ][1873] Completed state [ctl01.baremetal-mcp-ocata-ovs-dpdk-ha.local] at time 08:37:05.124155 duration_in_ms=5.801
2017-12-01 08:37:05,124 [salt.state       ][INFO    ][1873] Running state [ctl01] at time 08:37:05.124370
2017-12-01 08:37:05,125 [salt.state       ][INFO    ][1873] Executing state host.present for ctl01
2017-12-01 08:37:05,130 [salt.state       ][INFO    ][1873] {'host': 'ctl01'}
2017-12-01 08:37:05,130 [salt.state       ][INFO    ][1873] Completed state [ctl01] at time 08:37:05.130154 duration_in_ms=5.784
2017-12-01 08:37:05,130 [salt.state       ][INFO    ][1873] Running state [ctl] at time 08:37:05.130365
2017-12-01 08:37:05,131 [salt.state       ][INFO    ][1873] Executing state host.present for ctl
2017-12-01 08:37:05,136 [salt.state       ][INFO    ][1873] {'host': 'ctl'}
2017-12-01 08:37:05,136 [salt.state       ][INFO    ][1873] Completed state [ctl] at time 08:37:05.136146 duration_in_ms=5.781
2017-12-01 08:37:05,136 [salt.state       ][INFO    ][1873] Running state [ctl.baremetal-mcp-ocata-ovs-dpdk-ha.local] at time 08:37:05.136362
2017-12-01 08:37:05,137 [salt.state       ][INFO    ][1873] Executing state host.present for ctl.baremetal-mcp-ocata-ovs-dpdk-ha.local
2017-12-01 08:37:05,142 [salt.state       ][INFO    ][1873] {'host': 'ctl.baremetal-mcp-ocata-ovs-dpdk-ha.local'}
2017-12-01 08:37:05,143 [salt.state       ][INFO    ][1873] Completed state [ctl.baremetal-mcp-ocata-ovs-dpdk-ha.local] at time 08:37:05.142560 duration_in_ms=6.196
2017-12-01 08:37:05,157 [salt.state       ][INFO    ][1873] Running state [ens2] at time 08:37:05.156980
2017-12-01 08:37:05,157 [salt.state       ][INFO    ][1873] Executing state network.managed for ens2
2017-12-01 08:37:05,701 [salt.state       ][INFO    ][1873] Interface ens2 is up to date.
2017-12-01 08:37:05,701 [salt.state       ][INFO    ][1873] Completed state [ens2] at time 08:37:05.701143 duration_in_ms=544.161
2017-12-01 08:37:05,701 [salt.state       ][INFO    ][1873] Running state [ens3] at time 08:37:05.701414
2017-12-01 08:37:05,702 [salt.state       ][INFO    ][1873] Executing state network.managed for ens3
2017-12-01 08:37:05,717 [salt.loaded.int.module.cmdmod][INFO    ][1873] Executing command ['ifdown', 'ens3'] in directory '/root'
2017-12-01 08:37:06,062 [salt.loaded.int.module.cmdmod][INFO    ][1873] Executing command ['ifup', 'ens3'] in directory '/root'
2017-12-01 08:37:07,117 [salt.state       ][INFO    ][1873] {'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.52\n\n+    netmask 255.255.255.0\n\n \n', 'status': 'Interface ens3 restart to validate'}
2017-12-01 08:37:07,118 [salt.state       ][INFO    ][1873] Completed state [ens3] at time 08:37:07.117695 duration_in_ms=1416.28
2017-12-01 08:37:07,118 [salt.state       ][INFO    ][1873] Running state [/etc/profile.d/proxy.sh] at time 08:37:07.118181
2017-12-01 08:37:07,119 [salt.state       ][INFO    ][1873] Executing state file.absent for /etc/profile.d/proxy.sh
2017-12-01 08:37:07,119 [salt.state       ][INFO    ][1873] File /etc/profile.d/proxy.sh is not present
2017-12-01 08:37:07,120 [salt.state       ][INFO    ][1873] Completed state [/etc/profile.d/proxy.sh] at time 08:37:07.119747 duration_in_ms=1.566
2017-12-01 08:37:07,120 [salt.state       ][INFO    ][1873] Running state [/etc/apt/apt.conf.d/95proxies] at time 08:37:07.120077
2017-12-01 08:37:07,120 [salt.state       ][INFO    ][1873] Executing state file.absent for /etc/apt/apt.conf.d/95proxies
2017-12-01 08:37:07,121 [salt.state       ][INFO    ][1873] File /etc/apt/apt.conf.d/95proxies is not present
2017-12-01 08:37:07,121 [salt.state       ][INFO    ][1873] Completed state [/etc/apt/apt.conf.d/95proxies] at time 08:37:07.121084 duration_in_ms=1.007
2017-12-01 08:37:07,127 [salt.state       ][INFO    ][1873] Running state [ntp] at time 08:37:07.126628
2017-12-01 08:37:07,127 [salt.state       ][INFO    ][1873] Executing state pkg.installed for ntp
2017-12-01 08:37:07,250 [salt.loaded.int.module.cmdmod][INFO    ][1873] 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-12-01 08:37:14,274 [salt.minion      ][INFO    ][1735] User sudo_ubuntu Executing command saltutil.find_job with jid 20171201083714264588
2017-12-01 08:37:14,299 [salt.minion      ][INFO    ][5658] Starting a new job with PID 5658
2017-12-01 08:37:14,378 [salt.minion      ][INFO    ][5658] Returning information for job: 20171201083714264588
2017-12-01 08:37:24,491 [salt.minion      ][INFO    ][1735] User sudo_ubuntu Executing command saltutil.find_job with jid 20171201083724480134
2017-12-01 08:37:24,511 [salt.minion      ][INFO    ][5710] Starting a new job with PID 5710
2017-12-01 08:37:24,562 [salt.minion      ][INFO    ][5710] Returning information for job: 20171201083724480134
2017-12-01 08:37:30,010 [salt.loaded.int.module.cmdmod][INFO    ][1873] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-01 08:37:30,030 [salt.state       ][INFO    ][1873] Made the following changes:
'ntp' changed from 'absent' to '1:4.2.8p4+dfsg-3ubuntu5.7'
'libopts25' changed from 'absent' to '1:5.18.7-3'

2017-12-01 08:37:30,038 [salt.state       ][INFO    ][1873] Loading fresh modules for state activity
2017-12-01 08:37:30,050 [salt.state       ][INFO    ][1873] Completed state [ntp] at time 08:37:30.050100 duration_in_ms=22923.472
2017-12-01 08:37:30,052 [salt.state       ][INFO    ][1873] Running state [/etc/ntp.conf] at time 08:37:30.052172
2017-12-01 08:37:30,053 [salt.state       ][INFO    ][1873] Executing state file.managed for /etc/ntp.conf
2017-12-01 08:37:30,071 [salt.fileclient  ][INFO    ][1873] Fetching file from saltenv 'base', ** done ** 'ntp/files/ntp.conf'
2017-12-01 08:37:30,100 [salt.fileclient  ][INFO    ][1873] Fetching file from saltenv 'base', ** done ** 'ntp/map.jinja'
2017-12-01 08:37:30,109 [salt.state       ][INFO    ][1873] 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-12-01 08:37:30,112 [salt.state       ][INFO    ][1873] Completed state [/etc/ntp.conf] at time 08:37:30.111885 duration_in_ms=59.711
2017-12-01 08:37:30,179 [salt.state       ][INFO    ][1873] Running state [ntp] at time 08:37:30.179055
2017-12-01 08:37:30,179 [salt.state       ][INFO    ][1873] Executing state service.running for ntp
2017-12-01 08:37:30,181 [salt.loaded.int.module.cmdmod][INFO    ][1873] Executing command ['systemctl', 'status', 'ntp.service', '-n', '0'] in directory '/root'
2017-12-01 08:37:30,192 [salt.loaded.int.module.cmdmod][INFO    ][1873] Executing command ['systemctl', 'is-active', 'ntp.service'] in directory '/root'
2017-12-01 08:37:30,203 [salt.loaded.int.module.cmdmod][INFO    ][1873] Executing command ['systemctl', 'is-enabled', 'ntp.service'] in directory '/root'
2017-12-01 08:37:30,215 [salt.state       ][INFO    ][1873] The service ntp is already running
2017-12-01 08:37:30,215 [salt.state       ][INFO    ][1873] Completed state [ntp] at time 08:37:30.214881 duration_in_ms=35.825
2017-12-01 08:37:30,215 [salt.state       ][INFO    ][1873] Running state [ntp] at time 08:37:30.215048
2017-12-01 08:37:30,215 [salt.state       ][INFO    ][1873] Executing state service.mod_watch for ntp
2017-12-01 08:37:30,216 [salt.loaded.int.module.cmdmod][INFO    ][1873] Executing command ['systemctl', 'is-active', 'ntp.service'] in directory '/root'
2017-12-01 08:37:30,226 [salt.loaded.int.module.cmdmod][INFO    ][1873] Executing command ['systemctl', 'is-enabled', 'ntp.service'] in directory '/root'
2017-12-01 08:37:30,239 [salt.loaded.int.module.cmdmod][INFO    ][1873] Executing command ['systemd-run', '--scope', 'systemctl', 'restart', 'ntp.service'] in directory '/root'
2017-12-01 08:37:30,299 [salt.state       ][INFO    ][1873] {'ntp': True}
2017-12-01 08:37:30,299 [salt.state       ][INFO    ][1873] Completed state [ntp] at time 08:37:30.298832 duration_in_ms=83.782
2017-12-01 08:37:30,301 [salt.minion      ][INFO    ][1873] Returning information for job: 20171201083553168395
2017-12-01 08:38:53,459 [salt.minion      ][INFO    ][1735] User sudo_ubuntu Executing command ssh.set_auth_key with jid 20171201083853447277
2017-12-01 08:38:53,477 [salt.minion      ][INFO    ][6109] Starting a new job with PID 6109
2017-12-01 08:38:53,493 [salt.minion      ][INFO    ][6109] Returning information for job: 20171201083853447277
2017-12-01 08:42:54,665 [salt.minion      ][INFO    ][1735] User sudo_ubuntu Executing command test.ping with jid 20171201084254661803
2017-12-01 08:42:54,694 [salt.minion      ][INFO    ][6159] Starting a new job with PID 6159
2017-12-01 08:42:54,719 [salt.minion      ][INFO    ][6159] Returning information for job: 20171201084254661803
2017-12-01 08:44:50,352 [salt.minion      ][INFO    ][1735] User sudo_ubuntu Executing command state.sls with jid 20171201084450348818
2017-12-01 08:44:50,364 [salt.minion      ][INFO    ][6334] Starting a new job with PID 6334
2017-12-01 08:44:51,833 [salt.state       ][INFO    ][6334] Loading fresh modules for state activity
2017-12-01 08:44:51,859 [salt.fileclient  ][INFO    ][6334] Fetching file from saltenv 'base', ** done ** 'keepalived/init.sls'
2017-12-01 08:44:51,879 [salt.fileclient  ][INFO    ][6334] Fetching file from saltenv 'base', ** done ** 'keepalived/cluster.sls'
2017-12-01 08:44:51,904 [salt.fileclient  ][INFO    ][6334] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-12-01 08:44:52,148 [salt.state       ][INFO    ][6334] Running state [lsof] at time 08:44:52.147905
2017-12-01 08:44:52,148 [salt.state       ][INFO    ][6334] Executing state pkg.installed for lsof
2017-12-01 08:44:52,148 [salt.loaded.int.module.cmdmod][INFO    ][6334] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-01 08:44:52,566 [salt.state       ][INFO    ][6334] Package lsof is already installed
2017-12-01 08:44:52,567 [salt.state       ][INFO    ][6334] Completed state [lsof] at time 08:44:52.566610 duration_in_ms=418.705
2017-12-01 08:44:52,567 [salt.state       ][INFO    ][6334] Running state [keepalived] at time 08:44:52.566802
2017-12-01 08:44:52,567 [salt.state       ][INFO    ][6334] Executing state pkg.installed for keepalived
2017-12-01 08:44:52,581 [salt.loaded.int.module.cmdmod][INFO    ][6334] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-12-01 08:44:54,346 [salt.loaded.int.module.cmdmod][INFO    ][6334] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'keepalived'] in directory '/root'
2017-12-01 08:45:00,399 [salt.minion      ][INFO    ][1735] User sudo_ubuntu Executing command saltutil.find_job with jid 20171201084500394770
2017-12-01 08:45:00,414 [salt.minion      ][INFO    ][6816] Starting a new job with PID 6816
2017-12-01 08:45:00,459 [salt.minion      ][INFO    ][6816] Returning information for job: 20171201084500394770
2017-12-01 08:45:04,374 [salt.loaded.int.module.cmdmod][INFO    ][6334] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-01 08:45:04,392 [salt.state       ][INFO    ][6334] Made the following changes:
'libsnmp30' changed from 'absent' to '5.7.3+dfsg-1ubuntu4'
'libsnmp-base' changed from 'absent' to '5.7.3+dfsg-1ubuntu4'
'keepalived' changed from 'absent' to '1:1.2.19-1ubuntu0.2'
'ipvsadm' changed from 'absent' to '1:1.28-3'
'libsensors4' changed from 'absent' to '1:3.4.0-2'

2017-12-01 08:45:04,400 [salt.state       ][INFO    ][6334] Loading fresh modules for state activity
2017-12-01 08:45:04,412 [salt.state       ][INFO    ][6334] Completed state [keepalived] at time 08:45:04.412212 duration_in_ms=11845.41
2017-12-01 08:45:04,414 [salt.state       ][INFO    ][6334] Running state [/etc/keepalived/keepalived.conf] at time 08:45:04.414361
2017-12-01 08:45:04,415 [salt.state       ][INFO    ][6334] Executing state file.managed for /etc/keepalived/keepalived.conf
2017-12-01 08:45:04,440 [salt.fileclient  ][INFO    ][6334] Fetching file from saltenv 'base', ** done ** 'keepalived/files/keepalived.conf'
2017-12-01 08:45:04,474 [salt.fileclient  ][INFO    ][6334] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-12-01 08:45:04,481 [salt.state       ][INFO    ][6334] File changed:
New file
2017-12-01 08:45:04,482 [salt.state       ][INFO    ][6334] Completed state [/etc/keepalived/keepalived.conf] at time 08:45:04.481807 duration_in_ms=67.444
2017-12-01 08:45:04,542 [salt.state       ][INFO    ][6334] Running state [keepalived] at time 08:45:04.541525
2017-12-01 08:45:04,542 [salt.state       ][INFO    ][6334] Executing state service.running for keepalived
2017-12-01 08:45:04,544 [salt.loaded.int.module.cmdmod][INFO    ][6334] Executing command ['systemctl', 'status', 'keepalived.service', '-n', '0'] in directory '/root'
2017-12-01 08:45:04,553 [salt.loaded.int.module.cmdmod][INFO    ][6334] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2017-12-01 08:45:04,560 [salt.loaded.int.module.cmdmod][INFO    ][6334] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-12-01 08:45:04,567 [salt.loaded.int.module.cmdmod][INFO    ][6334] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-12-01 08:45:04,575 [salt.loaded.int.module.cmdmod][INFO    ][6334] Executing command ['systemd-run', '--scope', 'systemctl', 'start', 'keepalived.service'] in directory '/root'
2017-12-01 08:45:04,624 [salt.loaded.int.module.cmdmod][INFO    ][6334] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2017-12-01 08:45:04,632 [salt.loaded.int.module.cmdmod][INFO    ][6334] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-12-01 08:45:04,640 [salt.loaded.int.module.cmdmod][INFO    ][6334] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-12-01 08:45:04,650 [salt.state       ][INFO    ][6334] {'keepalived': True}
2017-12-01 08:45:04,650 [salt.state       ][INFO    ][6334] Completed state [keepalived] at time 08:45:04.650055 duration_in_ms=108.53
2017-12-01 08:45:04,651 [salt.minion      ][INFO    ][6334] Returning information for job: 20171201084450348818
2017-12-01 08:46:53,101 [salt.minion      ][INFO    ][1735] User sudo_ubuntu Executing command pillar.get with jid 20171201084653101822
2017-12-01 08:46:53,122 [salt.minion      ][INFO    ][7064] Starting a new job with PID 7064
2017-12-01 08:46:53,130 [salt.minion      ][INFO    ][7064] Returning information for job: 20171201084653101822
2017-12-01 09:05:43,535 [salt.minion      ][INFO    ][1735] User sudo_ubuntu Executing command state.sls with jid 20171201090543527922
2017-12-01 09:05:43,548 [salt.minion      ][INFO    ][8033] Starting a new job with PID 8033
2017-12-01 09:05:45,994 [salt.state       ][INFO    ][8033] Loading fresh modules for state activity
2017-12-01 09:05:46,020 [salt.fileclient  ][INFO    ][8033] Fetching file from saltenv 'base', ** done ** 'galera/init.sls'
2017-12-01 09:05:46,040 [salt.fileclient  ][INFO    ][8033] Fetching file from saltenv 'base', ** done ** 'galera/ssl.sls'
2017-12-01 09:05:46,063 [salt.fileclient  ][INFO    ][8033] Fetching file from saltenv 'base', ** done ** 'galera/map.jinja'
2017-12-01 09:05:46,091 [salt.fileclient  ][INFO    ][8033] Fetching file from saltenv 'base', ** done ** 'galera/slave.sls'
2017-12-01 09:05:46,117 [salt.fileclient  ][INFO    ][8033] Fetching file from saltenv 'base', ** done ** 'galera/map.jinja'
2017-12-01 09:05:46,134 [py.warnings      ][WARNING ][8033] /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-12-01 09:05:46,135 [salt.loaded.int.module.cmdmod][INFO    ][8033] Executing command 'test -e /var/lib/mysql/.galera_bootstrap; echo $?' in directory '/root'
2017-12-01 09:05:46,187 [salt.fileclient  ][INFO    ][8033] Fetching file from saltenv 'base', ** done ** 'galera/server.sls'
2017-12-01 09:05:46,228 [salt.fileclient  ][INFO    ][8033] Fetching file from saltenv 'base', ** done ** 'mysql/map.jinja'
2017-12-01 09:05:46,543 [salt.state       ][INFO    ][8033] Running state [/etc/mysql/my.cnf] at time 09:05:46.543244
2017-12-01 09:05:46,544 [salt.state       ][INFO    ][8033] Executing state file.managed for /etc/mysql/my.cnf
2017-12-01 09:05:46,563 [salt.fileclient  ][INFO    ][8033] Fetching file from saltenv 'base', ** done ** 'galera/files/my.cnf.pre'
2017-12-01 09:05:46,566 [salt.state       ][INFO    ][8033] File changed:
New file
2017-12-01 09:05:46,566 [salt.state       ][INFO    ][8033] Completed state [/etc/mysql/my.cnf] at time 09:05:46.566139 duration_in_ms=22.895
2017-12-01 09:05:46,567 [salt.state       ][INFO    ][8033] Running state [rsync] at time 09:05:46.566655
2017-12-01 09:05:46,567 [salt.state       ][INFO    ][8033] Executing state pkg.installed for rsync
2017-12-01 09:05:46,567 [salt.loaded.int.module.cmdmod][INFO    ][8033] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-01 09:05:47,028 [salt.loaded.int.module.cmdmod][INFO    ][8033] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-12-01 09:05:48,904 [salt.loaded.int.module.cmdmod][INFO    ][8033] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '--force-yes', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'rsync'] in directory '/root'
2017-12-01 09:05:53,333 [salt.loaded.int.module.cmdmod][INFO    ][8033] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-01 09:05:53,355 [salt.state       ][INFO    ][8033] Made the following changes:
'rsync' changed from 'absent' to '3.1.1-3ubuntu1'

2017-12-01 09:05:53,364 [salt.state       ][INFO    ][8033] Loading fresh modules for state activity
2017-12-01 09:05:53,376 [salt.state       ][INFO    ][8033] Completed state [rsync] at time 09:05:53.375956 duration_in_ms=6809.3
2017-12-01 09:05:53,381 [salt.state       ][INFO    ][8033] Running state [galera-3] at time 09:05:53.381055
2017-12-01 09:05:53,381 [salt.state       ][INFO    ][8033] Executing state pkg.installed for galera-3
2017-12-01 09:05:53,574 [salt.loaded.int.module.cmdmod][INFO    ][8033] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-12-01 09:05:53,630 [salt.minion      ][INFO    ][1735] User sudo_ubuntu Executing command saltutil.find_job with jid 20171201090553620648
2017-12-01 09:05:53,640 [salt.minion      ][INFO    ][8591] Starting a new job with PID 8591
2017-12-01 09:05:53,651 [salt.minion      ][INFO    ][8591] Returning information for job: 20171201090553620648
2017-12-01 09:05:55,435 [salt.loaded.int.module.cmdmod][INFO    ][8033] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '--force-yes', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'galera-3'] in directory '/root'
2017-12-01 09:05:58,512 [salt.loaded.int.module.cmdmod][INFO    ][8033] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-01 09:05:58,531 [salt.state       ][INFO    ][8033] Made the following changes:
'galera' changed from 'absent' to '1'
'percona-xtradb-cluster-galera-25' changed from 'absent' to '1'
'galera3' changed from 'absent' to '1'
'galera-3' changed from 'absent' to '25.3.14-1'
'wsrep' changed from 'absent' to '1'

2017-12-01 09:05:58,539 [salt.state       ][INFO    ][8033] Loading fresh modules for state activity
2017-12-01 09:05:58,551 [salt.state       ][INFO    ][8033] Completed state [galera-3] at time 09:05:58.551061 duration_in_ms=5170.006
2017-12-01 09:05:58,556 [salt.state       ][INFO    ][8033] Running state [python-mysqldb] at time 09:05:58.556273
2017-12-01 09:05:58,557 [salt.state       ][INFO    ][8033] Executing state pkg.installed for python-mysqldb
2017-12-01 09:05:58,749 [salt.loaded.int.module.cmdmod][INFO    ][8033] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-12-01 09:06:00,541 [salt.loaded.int.module.cmdmod][INFO    ][8033] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '--force-yes', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'python-mysqldb'] in directory '/root'
2017-12-01 09:06:03,828 [salt.minion      ][INFO    ][1735] User sudo_ubuntu Executing command saltutil.find_job with jid 20171201090603817902
2017-12-01 09:06:03,840 [salt.minion      ][INFO    ][9402] Starting a new job with PID 9402
2017-12-01 09:06:03,850 [salt.minion      ][INFO    ][9402] Returning information for job: 20171201090603817902
2017-12-01 09:06:07,024 [salt.loaded.int.module.cmdmod][INFO    ][8033] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-01 09:06:07,046 [salt.state       ][INFO    ][8033] Made the following changes:
'python2.7-mysqldb' changed from 'absent' to '1'
'mysql-common' changed from 'absent' to '5.7.20-0ubuntu0.16.04.1'
'mysql-common-5.6' changed from 'absent' to '1'
'libmysqlclient20' changed from 'absent' to '5.7.20-0ubuntu0.16.04.1'
'python-mysqldb' changed from 'absent' to '1.3.7-1build2'

2017-12-01 09:06:07,054 [salt.state       ][INFO    ][8033] Loading fresh modules for state activity
2017-12-01 09:06:07,069 [salt.state       ][INFO    ][8033] Completed state [python-mysqldb] at time 09:06:07.068819 duration_in_ms=8512.545
2017-12-01 09:06:07,074 [salt.state       ][INFO    ][8033] Running state [libmysqlclient-dev] at time 09:06:07.074285
2017-12-01 09:06:07,075 [salt.state       ][INFO    ][8033] Executing state pkg.installed for libmysqlclient-dev
2017-12-01 09:06:07,269 [salt.loaded.int.module.cmdmod][INFO    ][8033] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-12-01 09:06:09,048 [salt.loaded.int.module.cmdmod][INFO    ][8033] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '--force-yes', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'libmysqlclient-dev'] in directory '/root'
2017-12-01 09:06:14,046 [salt.minion      ][INFO    ][1735] User sudo_ubuntu Executing command saltutil.find_job with jid 20171201090614036529
2017-12-01 09:06:14,060 [salt.minion      ][INFO    ][9877] Starting a new job with PID 9877
2017-12-01 09:06:14,139 [salt.minion      ][INFO    ][9877] Returning information for job: 20171201090614036529
2017-12-01 09:06:21,600 [salt.loaded.int.module.cmdmod][INFO    ][8033] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-01 09:06:21,624 [salt.state       ][INFO    ][8033] Made the following changes:
'manpages-dev' changed from 'absent' to '4.04-2'
'libc-dev' changed from 'absent' to '1'
'libz-dev' changed from 'absent' to '1'
'libmysqlclient-dev' changed from 'absent' to '5.7.20-0ubuntu0.16.04.1'
'linux-kernel-headers' changed from 'absent' to '1'
'libc6-dev' changed from 'absent' to '2.23-0ubuntu9'
'manpages' changed from 'absent' to '4.04-2'
'libc-dev-bin' changed from 'absent' to '2.23-0ubuntu9'
'linux-libc-dev' changed from 'absent' to '4.4.0-101.124'
'zlib1g-dev' changed from 'absent' to '1:1.2.8.dfsg-2ubuntu4.1'

2017-12-01 09:06:21,633 [salt.state       ][INFO    ][8033] Loading fresh modules for state activity
2017-12-01 09:06:21,649 [salt.state       ][INFO    ][8033] Completed state [libmysqlclient-dev] at time 09:06:21.649088 duration_in_ms=14574.802
2017-12-01 09:06:21,655 [salt.state       ][INFO    ][8033] Running state [percona-xtrabackup] at time 09:06:21.655440
2017-12-01 09:06:21,656 [salt.state       ][INFO    ][8033] Executing state pkg.installed for percona-xtrabackup
2017-12-01 09:06:21,856 [salt.loaded.int.module.cmdmod][INFO    ][8033] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-12-01 09:06:23,646 [salt.loaded.int.module.cmdmod][INFO    ][8033] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '--force-yes', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'percona-xtrabackup'] in directory '/root'
2017-12-01 09:06:24,096 [salt.minion      ][INFO    ][1735] User sudo_ubuntu Executing command saltutil.find_job with jid 20171201090624087957
2017-12-01 09:06:24,106 [salt.minion      ][INFO    ][10321] Starting a new job with PID 10321
2017-12-01 09:06:24,117 [salt.minion      ][INFO    ][10321] Returning information for job: 20171201090624087957
2017-12-01 09:06:32,635 [salt.loaded.int.module.cmdmod][INFO    ][8033] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-01 09:06:32,656 [salt.state       ][INFO    ][8033] Made the following changes:
'libaio1' changed from 'absent' to '0.3.110-2'
'libev4' changed from 'absent' to '1:4.22-1'
'percona-xtrabackup' changed from 'absent' to '2.3.4-1~u16.04+mcp1'
'libdbi-perl' changed from 'absent' to '1.634-1build1'
'xtrabackup' changed from 'absent' to '1'
'libcurl3' changed from 'absent' to '7.47.0-1ubuntu2.5'
'perl-dbdabi-94' changed from 'absent' to '1'
'libdbd-mysql-perl' changed from 'absent' to '4.033-1ubuntu0.1'

2017-12-01 09:06:32,664 [salt.state       ][INFO    ][8033] Loading fresh modules for state activity
2017-12-01 09:06:32,676 [salt.state       ][INFO    ][8033] Completed state [percona-xtrabackup] at time 09:06:32.675901 duration_in_ms=11020.461
2017-12-01 09:06:32,681 [salt.state       ][INFO    ][8033] Running state [psmisc] at time 09:06:32.681095
2017-12-01 09:06:32,681 [salt.state       ][INFO    ][8033] Executing state pkg.installed for psmisc
2017-12-01 09:06:32,883 [salt.loaded.int.module.cmdmod][INFO    ][8033] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-12-01 09:06:34,289 [salt.minion      ][INFO    ][1735] User sudo_ubuntu Executing command saltutil.find_job with jid 20171201090634281568
2017-12-01 09:06:34,299 [salt.minion      ][INFO    ][10794] Starting a new job with PID 10794
2017-12-01 09:06:34,308 [salt.minion      ][INFO    ][10794] Returning information for job: 20171201090634281568
2017-12-01 09:06:34,528 [salt.loaded.int.module.cmdmod][INFO    ][8033] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '--force-yes', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'psmisc'] in directory '/root'
2017-12-01 09:06:37,091 [salt.loaded.int.module.cmdmod][INFO    ][8033] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-01 09:06:37,113 [salt.state       ][INFO    ][8033] Made the following changes:
'psmisc' changed from 'absent' to '22.21-2.1build1'

2017-12-01 09:06:37,121 [salt.state       ][INFO    ][8033] Loading fresh modules for state activity
2017-12-01 09:06:37,133 [salt.state       ][INFO    ][8033] Completed state [psmisc] at time 09:06:37.133215 duration_in_ms=4452.12
2017-12-01 09:06:37,138 [salt.state       ][INFO    ][8033] Running state [python-pymysql] at time 09:06:37.138257
2017-12-01 09:06:37,138 [salt.state       ][INFO    ][8033] Executing state pkg.installed for python-pymysql
2017-12-01 09:06:37,343 [salt.state       ][INFO    ][8033] Package python-pymysql is already installed
2017-12-01 09:06:37,344 [salt.state       ][INFO    ][8033] Completed state [python-pymysql] at time 09:06:37.343674 duration_in_ms=205.416
2017-12-01 09:06:37,344 [salt.state       ][INFO    ][8033] Running state [socat] at time 09:06:37.344415
2017-12-01 09:06:37,345 [salt.state       ][INFO    ][8033] Executing state pkg.installed for socat
2017-12-01 09:06:37,352 [salt.loaded.int.module.cmdmod][INFO    ][8033] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-12-01 09:06:39,139 [salt.loaded.int.module.cmdmod][INFO    ][8033] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '--force-yes', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'socat'] in directory '/root'
2017-12-01 09:06:41,763 [salt.loaded.int.module.cmdmod][INFO    ][8033] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-01 09:06:41,787 [salt.state       ][INFO    ][8033] Made the following changes:
'socat' changed from 'absent' to '1.7.3.1-1'

2017-12-01 09:06:41,794 [salt.state       ][INFO    ][8033] Loading fresh modules for state activity
2017-12-01 09:06:41,807 [salt.state       ][INFO    ][8033] Completed state [socat] at time 09:06:41.806729 duration_in_ms=4462.313
2017-12-01 09:06:41,812 [salt.state       ][INFO    ][8033] Running state [libdbd-mysql] at time 09:06:41.811892
2017-12-01 09:06:41,812 [salt.state       ][INFO    ][8033] Executing state pkg.installed for libdbd-mysql
2017-12-01 09:06:42,101 [salt.loaded.int.module.cmdmod][INFO    ][8033] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-12-01 09:06:43,964 [salt.loaded.int.module.cmdmod][INFO    ][8033] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '--force-yes', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'libdbd-mysql'] in directory '/root'
2017-12-01 09:06:44,492 [salt.minion      ][INFO    ][1735] User sudo_ubuntu Executing command saltutil.find_job with jid 20171201090644485600
2017-12-01 09:06:44,504 [salt.minion      ][INFO    ][11648] Starting a new job with PID 11648
2017-12-01 09:06:44,514 [salt.minion      ][INFO    ][11648] Returning information for job: 20171201090644485600
2017-12-01 09:06:47,418 [salt.loaded.int.module.cmdmod][INFO    ][8033] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-01 09:06:47,441 [salt.state       ][INFO    ][8033] Made the following changes:
'libdbd-mysql' changed from 'absent' to '0.9.0-3ubuntu2'
'libdbi1' changed from 'absent' to '0.9.0-4'

2017-12-01 09:06:47,448 [salt.state       ][INFO    ][8033] Loading fresh modules for state activity
2017-12-01 09:06:47,469 [salt.state       ][INFO    ][8033] Completed state [libdbd-mysql] at time 09:06:47.468807 duration_in_ms=5656.915
2017-12-01 09:06:47,475 [salt.state       ][INFO    ][8033] Running state [netcat] at time 09:06:47.474500
2017-12-01 09:06:47,475 [salt.state       ][INFO    ][8033] Executing state pkg.installed for netcat
2017-12-01 09:06:47,748 [salt.state       ][INFO    ][8033] Package netcat is already installed
2017-12-01 09:06:47,748 [salt.state       ][INFO    ][8033] Completed state [netcat] at time 09:06:47.748323 duration_in_ms=273.822
2017-12-01 09:06:47,749 [salt.state       ][INFO    ][8033] Running state [mysql-wsrep-5.6] at time 09:06:47.748874
2017-12-01 09:06:47,749 [salt.state       ][INFO    ][8033] Executing state pkg.installed for mysql-wsrep-5.6
2017-12-01 09:06:47,757 [salt.loaded.int.module.cmdmod][INFO    ][8033] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-12-01 09:06:49,569 [salt.loaded.int.module.cmdmod][INFO    ][8033] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '--force-yes', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'mysql-wsrep-5.6'] in directory '/root'
2017-12-01 09:06:54,689 [salt.minion      ][INFO    ][1735] User sudo_ubuntu Executing command saltutil.find_job with jid 20171201090654683323
2017-12-01 09:06:54,700 [salt.minion      ][INFO    ][12090] Starting a new job with PID 12090
2017-12-01 09:06:54,711 [salt.minion      ][INFO    ][12090] Returning information for job: 20171201090654683323
2017-12-01 09:07:04,883 [salt.minion      ][INFO    ][1735] User sudo_ubuntu Executing command saltutil.find_job with jid 20171201090704876671
2017-12-01 09:07:04,897 [salt.minion      ][INFO    ][12108] Starting a new job with PID 12108
2017-12-01 09:07:04,910 [salt.minion      ][INFO    ][12108] Returning information for job: 20171201090704876671
2017-12-01 09:07:15,098 [salt.minion      ][INFO    ][1735] User sudo_ubuntu Executing command saltutil.find_job with jid 20171201090715092797
2017-12-01 09:07:15,111 [salt.minion      ][INFO    ][12242] Starting a new job with PID 12242
2017-12-01 09:07:15,149 [salt.minion      ][INFO    ][12242] Returning information for job: 20171201090715092797
2017-12-01 09:07:25,123 [salt.minion      ][INFO    ][1735] User sudo_ubuntu Executing command saltutil.find_job with jid 20171201090725118964
2017-12-01 09:07:25,137 [salt.minion      ][INFO    ][12445] Starting a new job with PID 12445
2017-12-01 09:07:25,149 [salt.minion      ][INFO    ][12445] Returning information for job: 20171201090725118964
2017-12-01 09:07:35,332 [salt.minion      ][INFO    ][1735] User sudo_ubuntu Executing command saltutil.find_job with jid 20171201090735328011
2017-12-01 09:07:35,347 [salt.minion      ][INFO    ][12518] Starting a new job with PID 12518
2017-12-01 09:07:35,360 [salt.minion      ][INFO    ][12518] Returning information for job: 20171201090735328011
2017-12-01 09:07:41,045 [salt.loaded.int.module.cmdmod][INFO    ][8033] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-01 09:07:41,071 [salt.state       ][INFO    ][8033] Made the following changes:
'mysql-wsrep-common-5.6' changed from 'absent' to '5.6.35-0~u16.04+mcp3'
'libmysqlclient18' changed from 'absent' to '1'
'virtual-mysql-client' changed from 'absent' to '1'
'libencode-locale-perl' changed from 'absent' to '1.05-1'
'libhttp-message-perl' changed from 'absent' to '6.11-1'
'mysql-wsrep-client-5.6' changed from 'absent' to '5.6.35-0~u16.04+mcp3'
'timedate' changed from 'absent' to '1'
'mysql-server-5.6' changed from 'absent' to '1'
'libfcgi-perl' changed from 'absent' to '0.77-1build1'
'libhtml-parser-perl' changed from 'absent' to '3.72-1'
'liburi-perl' changed from 'absent' to '1.71-1'
'mysql-wsrep-server-5.6' changed from 'absent' to '5.6.35-0~u16.04+mcp3'
'libcgi-fast-perl' changed from 'absent' to '1:2.10-1'
'libcgi-pm-perl' changed from 'absent' to '4.26-1'
'liblwp-mediatypes-perl' changed from 'absent' to '6.02-1'
'libhtml-template-perl' changed from 'absent' to '2.95-2'
'virtual-mysql-server' changed from 'absent' to '1'
'mysql-wsrep-libmysqlclient18' changed from 'absent' to '5.6.35-0~u16.04+mcp3'
'libhttp-date-perl' changed from 'absent' to '6.02-1'
'libtimedate-perl' changed from 'absent' to '2.3000-2'
'libterm-readkey-perl' changed from 'absent' to '2.33-1build1'
'libhtml-tagset-perl' changed from 'absent' to '3.20-2'
'libio-html-perl' changed from 'absent' to '1.001-1'
'mysql-wsrep-5.6' changed from 'absent' to '5.6.35-0~u16.04+mcp3'

2017-12-01 09:07:41,079 [salt.state       ][INFO    ][8033] Loading fresh modules for state activity
2017-12-01 09:07:41,097 [salt.state       ][INFO    ][8033] Completed state [mysql-wsrep-5.6] at time 09:07:41.096842 duration_in_ms=53347.967
2017-12-01 09:07:41,100 [salt.state       ][INFO    ][8033] Running state [/var/log/mysql] at time 09:07:41.100357
2017-12-01 09:07:41,101 [salt.state       ][INFO    ][8033] Executing state file.directory for /var/log/mysql
2017-12-01 09:07:41,104 [salt.state       ][INFO    ][8033] {'mode': '0755'}
2017-12-01 09:07:41,104 [salt.state       ][INFO    ][8033] Completed state [/var/log/mysql] at time 09:07:41.104165 duration_in_ms=3.808
2017-12-01 09:07:41,105 [salt.state       ][INFO    ][8033] Running state [/var/run/mysqld] at time 09:07:41.105187
2017-12-01 09:07:41,106 [salt.state       ][INFO    ][8033] Executing state file.directory for /var/run/mysqld
2017-12-01 09:07:41,106 [salt.state       ][INFO    ][8033] Directory /var/run/mysqld is in the correct state
2017-12-01 09:07:41,107 [salt.state       ][INFO    ][8033] Completed state [/var/run/mysqld] at time 09:07:41.106709 duration_in_ms=1.522
2017-12-01 09:07:41,108 [salt.state       ][INFO    ][8033] Running state [/etc/systemd/system/mysql.service.d] at time 09:07:41.107665
2017-12-01 09:07:41,108 [salt.state       ][INFO    ][8033] Executing state file.directory for /etc/systemd/system/mysql.service.d
2017-12-01 09:07:41,109 [salt.state       ][INFO    ][8033] {'/etc/systemd/system/mysql.service.d': 'New Dir'}
2017-12-01 09:07:41,109 [salt.state       ][INFO    ][8033] Completed state [/etc/systemd/system/mysql.service.d] at time 09:07:41.109389 duration_in_ms=1.724
2017-12-01 09:07:41,110 [salt.state       ][INFO    ][8033] Running state [/etc/systemd/system/mysql.service.d/override.conf] at time 09:07:41.110470
2017-12-01 09:07:41,111 [salt.state       ][INFO    ][8033] Executing state file.managed for /etc/systemd/system/mysql.service.d/override.conf
2017-12-01 09:07:41,119 [salt.state       ][INFO    ][8033] File changed:
New file
2017-12-01 09:07:41,120 [salt.state       ][INFO    ][8033] Completed state [/etc/systemd/system/mysql.service.d/override.conf] at time 09:07:41.119983 duration_in_ms=9.511
2017-12-01 09:07:41,121 [salt.state       ][INFO    ][8033] Running state [service.systemctl_reload] at time 09:07:41.121298
2017-12-01 09:07:41,122 [salt.state       ][INFO    ][8033] Executing state module.wait for service.systemctl_reload
2017-12-01 09:07:41,122 [salt.state       ][INFO    ][8033] No changes made for service.systemctl_reload
2017-12-01 09:07:41,123 [salt.state       ][INFO    ][8033] Completed state [service.systemctl_reload] at time 09:07:41.122537 duration_in_ms=1.239
2017-12-01 09:07:41,123 [salt.state       ][INFO    ][8033] Running state [service.systemctl_reload] at time 09:07:41.122995
2017-12-01 09:07:41,123 [salt.state       ][INFO    ][8033] Executing state module.mod_watch for service.systemctl_reload
2017-12-01 09:07:41,204 [salt.loaded.int.module.cmdmod][INFO    ][8033] Executing command ['systemctl', '--system', 'daemon-reload'] in directory '/root'
2017-12-01 09:07:41,247 [salt.state       ][INFO    ][8033] {'ret': True}
2017-12-01 09:07:41,247 [salt.state       ][INFO    ][8033] Completed state [service.systemctl_reload] at time 09:07:41.247028 duration_in_ms=124.032
2017-12-01 09:07:41,248 [salt.state       ][INFO    ][8033] Running state [/etc/mysql/debian.cnf] at time 09:07:41.247702
2017-12-01 09:07:41,248 [salt.state       ][INFO    ][8033] Executing state file.managed for /etc/mysql/debian.cnf
2017-12-01 09:07:41,268 [salt.fileclient  ][INFO    ][8033] Fetching file from saltenv 'base', ** done ** 'galera/files/debian.cnf'
2017-12-01 09:07:41,287 [salt.fileclient  ][INFO    ][8033] Fetching file from saltenv 'base', ** done ** 'galera/map.jinja'
2017-12-01 09:07:41,303 [salt.state       ][INFO    ][8033] File changed:
--- 
+++ 
@@ -1,12 +1,13 @@
-# Automatically generated for Debian scripts. DO NOT TOUCH!
+
 [client]
-host     = localhost
-user     = debian-sys-maint
-password = sabUadYE20sPeSq9
-socket   = /var/run/mysqld/mysqld.sock
+host = localhost
+user = debian-sys-maint
+password = opnfv_secret
+socket = /var/run/mysqld/mysqld.sock
+
 [mysql_upgrade]
-host     = localhost
-user     = debian-sys-maint
-password = sabUadYE20sPeSq9
-socket   = /var/run/mysqld/mysqld.sock
-basedir  = /usr
+host = localhost
+user = debian-sys-maint
+password = opnfv_secret
+socket = /var/run/mysqld/mysqld.sock
+basedir = /usr

2017-12-01 09:07:41,305 [salt.state       ][INFO    ][8033] Completed state [/etc/mysql/debian.cnf] at time 09:07:41.305068 duration_in_ms=57.365
2017-12-01 09:07:41,305 [salt.state       ][INFO    ][8033] Running state [/usr/local/sbin/galera_init.sh] at time 09:07:41.305361
2017-12-01 09:07:41,306 [salt.state       ][INFO    ][8033] Executing state file.managed for /usr/local/sbin/galera_init.sh
2017-12-01 09:07:41,321 [salt.fileclient  ][INFO    ][8033] Fetching file from saltenv 'base', ** done ** 'galera/files/init_bootstrap.sh'
2017-12-01 09:07:41,323 [salt.state       ][INFO    ][8033] File changed:
New file
2017-12-01 09:07:41,324 [salt.state       ][INFO    ][8033] Completed state [/usr/local/sbin/galera_init.sh] at time 09:07:41.323650 duration_in_ms=18.289
2017-12-01 09:07:41,324 [salt.state       ][INFO    ][8033] Running state [/usr/local/sbin/galera_bootstrap.sh] at time 09:07:41.323920
2017-12-01 09:07:41,324 [salt.state       ][INFO    ][8033] Executing state file.managed for /usr/local/sbin/galera_bootstrap.sh
2017-12-01 09:07:41,343 [salt.fileclient  ][INFO    ][8033] Fetching file from saltenv 'base', ** done ** 'galera/files/bootstrap.sh'
2017-12-01 09:07:41,346 [salt.state       ][INFO    ][8033] File changed:
New file
2017-12-01 09:07:41,347 [salt.state       ][INFO    ][8033] Completed state [/usr/local/sbin/galera_bootstrap.sh] at time 09:07:41.346803 duration_in_ms=22.881
2017-12-01 09:07:41,349 [salt.state       ][INFO    ][8033] Running state [/usr/local/sbin/galera_init.sh] at time 09:07:41.348973
2017-12-01 09:07:41,349 [salt.state       ][INFO    ][8033] Executing state cmd.run for /usr/local/sbin/galera_init.sh
2017-12-01 09:07:41,350 [salt.loaded.int.module.cmdmod][INFO    ][8033] Executing command '/usr/local/sbin/galera_init.sh' in directory '/root'
2017-12-01 09:07:44,935 [salt.state       ][INFO    ][8033] {'pid': 12644, 'retcode': 0, 'stderr': '', 'stdout': 'Sucessfully connected to the MySQL service (0 retries).'}
2017-12-01 09:07:44,935 [salt.state       ][INFO    ][8033] Completed state [/usr/local/sbin/galera_init.sh] at time 09:07:44.935144 duration_in_ms=3586.168
2017-12-01 09:07:44,936 [salt.state       ][INFO    ][8033] Running state [mysqladmin password "opnfv_secret"] at time 09:07:44.936244
2017-12-01 09:07:44,937 [salt.state       ][INFO    ][8033] Executing state cmd.run for mysqladmin password "opnfv_secret"
2017-12-01 09:07:44,937 [salt.loaded.int.module.cmdmod][INFO    ][8033] Executing command 'mysqladmin password "opnfv_secret"' in directory '/root'
2017-12-01 09:07:44,955 [salt.state       ][INFO    ][8033] {'pid': 13075, 'retcode': 0, 'stderr': 'Warning: Using a password on the command line interface can be insecure.', 'stdout': ''}
2017-12-01 09:07:44,956 [salt.state       ][INFO    ][8033] Completed state [mysqladmin password "opnfv_secret"] at time 09:07:44.955806 duration_in_ms=19.561
2017-12-01 09:07:44,957 [salt.state       ][INFO    ][8033] Running state [mysql -u root -popnfv_secret -e "GRANT ALL PRIVILEGES ON *.* TO 'debian-sys-maint'@'localhost' IDENTIFIED BY 'opnfv_secret';"] at time 09:07:44.956860
2017-12-01 09:07:44,957 [salt.state       ][INFO    ][8033] Executing state cmd.run for mysql -u root -popnfv_secret -e "GRANT ALL PRIVILEGES ON *.* TO 'debian-sys-maint'@'localhost' IDENTIFIED BY 'opnfv_secret';"
2017-12-01 09:07:44,958 [salt.loaded.int.module.cmdmod][INFO    ][8033] Executing command 'mysql -u root -popnfv_secret -e "GRANT ALL PRIVILEGES ON *.* TO 'debian-sys-maint'@'localhost' IDENTIFIED BY 'opnfv_secret';"' in directory '/root'
2017-12-01 09:07:44,972 [salt.state       ][INFO    ][8033] {'pid': 13077, 'retcode': 0, 'stderr': 'Warning: Using a password on the command line interface can be insecure.', 'stdout': ''}
2017-12-01 09:07:44,972 [salt.state       ][INFO    ][8033] Completed state [mysql -u root -popnfv_secret -e "GRANT ALL PRIVILEGES ON *.* TO 'debian-sys-maint'@'localhost' IDENTIFIED BY 'opnfv_secret';"] at time 09:07:44.972059 duration_in_ms=15.197
2017-12-01 09:07:44,973 [salt.state       ][INFO    ][8033] Running state [mysql] at time 09:07:44.973435
2017-12-01 09:07:44,974 [salt.state       ][INFO    ][8033] Executing state service.dead for mysql
2017-12-01 09:07:44,974 [salt.loaded.int.module.cmdmod][INFO    ][8033] Executing command ['systemctl', 'status', 'mysql.service', '-n', '0'] in directory '/root'
2017-12-01 09:07:44,987 [salt.loaded.int.module.cmdmod][INFO    ][8033] Executing command ['systemctl', 'is-active', 'mysql.service'] in directory '/root'
2017-12-01 09:07:45,001 [salt.loaded.int.module.cmdmod][INFO    ][8033] Executing command ['systemctl', 'is-enabled', 'mysql.service'] in directory '/root'
2017-12-01 09:07:45,016 [salt.loaded.int.module.cmdmod][INFO    ][8033] Executing command ['systemd-run', '--scope', 'systemctl', 'stop', 'mysql.service'] in directory '/root'
2017-12-01 09:07:45,547 [salt.minion      ][INFO    ][1735] User sudo_ubuntu Executing command saltutil.find_job with jid 20171201090745542987
2017-12-01 09:07:45,560 [salt.minion      ][INFO    ][13138] Starting a new job with PID 13138
2017-12-01 09:07:45,570 [salt.minion      ][INFO    ][13138] Returning information for job: 20171201090745542987
2017-12-01 09:07:55,756 [salt.minion      ][INFO    ][1735] User sudo_ubuntu Executing command saltutil.find_job with jid 20171201090755751289
2017-12-01 09:07:55,769 [salt.minion      ][INFO    ][13174] Starting a new job with PID 13174
2017-12-01 09:07:55,779 [salt.minion      ][INFO    ][13174] Returning information for job: 20171201090755751289
2017-12-01 09:08:05,970 [salt.minion      ][INFO    ][1735] User sudo_ubuntu Executing command saltutil.find_job with jid 20171201090805965238
2017-12-01 09:08:05,982 [salt.minion      ][INFO    ][13184] Starting a new job with PID 13184
2017-12-01 09:08:05,993 [salt.minion      ][INFO    ][13184] Returning information for job: 20171201090805965238
2017-12-01 09:08:16,185 [salt.minion      ][INFO    ][1735] User sudo_ubuntu Executing command saltutil.find_job with jid 20171201090816181970
2017-12-01 09:08:16,198 [salt.minion      ][INFO    ][13189] Starting a new job with PID 13189
2017-12-01 09:08:16,208 [salt.minion      ][INFO    ][13189] Returning information for job: 20171201090816181970
2017-12-01 09:08:26,399 [salt.minion      ][INFO    ][1735] User sudo_ubuntu Executing command saltutil.find_job with jid 20171201090826397186
2017-12-01 09:08:26,412 [salt.minion      ][INFO    ][13199] Starting a new job with PID 13199
2017-12-01 09:08:26,423 [salt.minion      ][INFO    ][13199] Returning information for job: 20171201090826397186
2017-12-01 09:08:36,618 [salt.minion      ][INFO    ][1735] User sudo_ubuntu Executing command saltutil.find_job with jid 20171201090836615918
2017-12-01 09:08:36,631 [salt.minion      ][INFO    ][13204] Starting a new job with PID 13204
2017-12-01 09:08:36,648 [salt.minion      ][INFO    ][13204] Returning information for job: 20171201090836615918
2017-12-01 09:08:46,635 [salt.minion      ][INFO    ][1735] User sudo_ubuntu Executing command saltutil.find_job with jid 20171201090846633373
2017-12-01 09:08:46,648 [salt.minion      ][INFO    ][13209] Starting a new job with PID 13209
2017-12-01 09:08:46,659 [salt.minion      ][INFO    ][13209] Returning information for job: 20171201090846633373
2017-12-01 09:08:56,654 [salt.minion      ][INFO    ][1735] User sudo_ubuntu Executing command saltutil.find_job with jid 20171201090856652434
2017-12-01 09:08:56,666 [salt.minion      ][INFO    ][13368] Starting a new job with PID 13368
2017-12-01 09:08:56,676 [salt.minion      ][INFO    ][13368] Returning information for job: 20171201090856652434
2017-12-01 09:09:06,679 [salt.minion      ][INFO    ][1735] User sudo_ubuntu Executing command saltutil.find_job with jid 20171201090906673253
2017-12-01 09:09:06,693 [salt.minion      ][INFO    ][13373] Starting a new job with PID 13373
2017-12-01 09:09:06,717 [salt.minion      ][INFO    ][13373] Returning information for job: 20171201090906673253
2017-12-01 09:09:16,710 [salt.minion      ][INFO    ][1735] User sudo_ubuntu Executing command saltutil.find_job with jid 20171201090916700078
2017-12-01 09:09:16,722 [salt.minion      ][INFO    ][13383] Starting a new job with PID 13383
2017-12-01 09:09:16,733 [salt.minion      ][INFO    ][13383] Returning information for job: 20171201090916700078
2017-12-01 09:09:26,730 [salt.minion      ][INFO    ][1735] User sudo_ubuntu Executing command saltutil.find_job with jid 20171201090926719284
2017-12-01 09:09:26,743 [salt.minion      ][INFO    ][13388] Starting a new job with PID 13388
2017-12-01 09:09:26,754 [salt.minion      ][INFO    ][13388] Returning information for job: 20171201090926719284
2017-12-01 09:09:36,760 [salt.minion      ][INFO    ][1735] User sudo_ubuntu Executing command saltutil.find_job with jid 20171201090936745852
2017-12-01 09:09:36,773 [salt.minion      ][INFO    ][13398] Starting a new job with PID 13398
2017-12-01 09:09:36,784 [salt.minion      ][INFO    ][13398] Returning information for job: 20171201090936745852
2017-12-01 09:09:46,788 [salt.minion      ][INFO    ][1735] User sudo_ubuntu Executing command saltutil.find_job with jid 20171201090946778686
2017-12-01 09:09:46,803 [salt.minion      ][INFO    ][13403] Starting a new job with PID 13403
2017-12-01 09:09:46,814 [salt.minion      ][INFO    ][13403] Returning information for job: 20171201090946778686
2017-12-01 09:09:56,826 [salt.minion      ][INFO    ][1735] User sudo_ubuntu Executing command saltutil.find_job with jid 20171201090956817628
2017-12-01 09:09:56,838 [salt.minion      ][INFO    ][13408] Starting a new job with PID 13408
2017-12-01 09:09:56,849 [salt.minion      ][INFO    ][13408] Returning information for job: 20171201090956817628
2017-12-01 09:10:06,861 [salt.minion      ][INFO    ][1735] User sudo_ubuntu Executing command saltutil.find_job with jid 20171201091006853316
2017-12-01 09:10:06,874 [salt.minion      ][INFO    ][13418] Starting a new job with PID 13418
2017-12-01 09:10:06,884 [salt.minion      ][INFO    ][13418] Returning information for job: 20171201091006853316
2017-12-01 09:10:16,898 [salt.minion      ][INFO    ][1735] User sudo_ubuntu Executing command saltutil.find_job with jid 20171201091016891269
2017-12-01 09:10:16,913 [salt.minion      ][INFO    ][13423] Starting a new job with PID 13423
2017-12-01 09:10:16,923 [salt.minion      ][INFO    ][13423] Returning information for job: 20171201091016891269
2017-12-01 09:10:26,935 [salt.minion      ][INFO    ][1735] User sudo_ubuntu Executing command saltutil.find_job with jid 20171201091026928898
2017-12-01 09:10:26,948 [salt.minion      ][INFO    ][13433] Starting a new job with PID 13433
2017-12-01 09:10:26,959 [salt.minion      ][INFO    ][13433] Returning information for job: 20171201091026928898
2017-12-01 09:10:36,979 [salt.minion      ][INFO    ][1735] User sudo_ubuntu Executing command saltutil.find_job with jid 20171201091036972499
2017-12-01 09:10:36,992 [salt.minion      ][INFO    ][13438] Starting a new job with PID 13438
2017-12-01 09:10:37,003 [salt.minion      ][INFO    ][13438] Returning information for job: 20171201091036972499
2017-12-01 09:10:47,032 [salt.minion      ][INFO    ][1735] User sudo_ubuntu Executing command saltutil.find_job with jid 20171201091047025654
2017-12-01 09:10:47,046 [salt.minion      ][INFO    ][13448] Starting a new job with PID 13448
2017-12-01 09:10:47,057 [salt.minion      ][INFO    ][13448] Returning information for job: 20171201091047025654
2017-12-01 09:10:57,091 [salt.minion      ][INFO    ][1735] User sudo_ubuntu Executing command saltutil.find_job with jid 20171201091057085975
2017-12-01 09:10:57,103 [salt.minion      ][INFO    ][13453] Starting a new job with PID 13453
2017-12-01 09:10:57,114 [salt.minion      ][INFO    ][13453] Returning information for job: 20171201091057085975
2017-12-01 09:11:07,152 [salt.minion      ][INFO    ][1735] User sudo_ubuntu Executing command saltutil.find_job with jid 20171201091107147656
2017-12-01 09:11:07,167 [salt.minion      ][INFO    ][13458] Starting a new job with PID 13458
2017-12-01 09:11:07,180 [salt.minion      ][INFO    ][13458] Returning information for job: 20171201091107147656
2017-12-01 09:11:17,220 [salt.minion      ][INFO    ][1735] User sudo_ubuntu Executing command saltutil.find_job with jid 20171201091117214562
2017-12-01 09:11:17,233 [salt.minion      ][INFO    ][13468] Starting a new job with PID 13468
2017-12-01 09:11:17,244 [salt.minion      ][INFO    ][13468] Returning information for job: 20171201091117214562
2017-12-01 09:11:27,291 [salt.minion      ][INFO    ][1735] User sudo_ubuntu Executing command saltutil.find_job with jid 20171201091127287007
2017-12-01 09:11:27,305 [salt.minion      ][INFO    ][13473] Starting a new job with PID 13473
2017-12-01 09:11:27,316 [salt.minion      ][INFO    ][13473] Returning information for job: 20171201091127287007
2017-12-01 09:11:37,369 [salt.minion      ][INFO    ][1735] User sudo_ubuntu Executing command saltutil.find_job with jid 20171201091137364451
2017-12-01 09:11:37,382 [salt.minion      ][INFO    ][13483] Starting a new job with PID 13483
2017-12-01 09:11:37,393 [salt.minion      ][INFO    ][13483] Returning information for job: 20171201091137364451
2017-12-01 09:11:47,452 [salt.minion      ][INFO    ][1735] User sudo_ubuntu Executing command saltutil.find_job with jid 20171201091147449337
2017-12-01 09:11:47,465 [salt.minion      ][INFO    ][13488] Starting a new job with PID 13488
2017-12-01 09:11:47,475 [salt.minion      ][INFO    ][13488] Returning information for job: 20171201091147449337
2017-12-01 09:11:57,527 [salt.minion      ][INFO    ][1735] User sudo_ubuntu Executing command saltutil.find_job with jid 20171201091157525093
2017-12-01 09:11:57,540 [salt.minion      ][INFO    ][13493] Starting a new job with PID 13493
2017-12-01 09:11:57,551 [salt.minion      ][INFO    ][13493] Returning information for job: 20171201091157525093
2017-12-01 09:12:07,618 [salt.minion      ][INFO    ][1735] User sudo_ubuntu Executing command saltutil.find_job with jid 20171201091207615501
2017-12-01 09:12:07,632 [salt.minion      ][INFO    ][13503] Starting a new job with PID 13503
2017-12-01 09:12:07,643 [salt.minion      ][INFO    ][13503] Returning information for job: 20171201091207615501
2017-12-01 09:12:17,716 [salt.minion      ][INFO    ][1735] User sudo_ubuntu Executing command saltutil.find_job with jid 20171201091217714033
2017-12-01 09:12:17,729 [salt.minion      ][INFO    ][13508] Starting a new job with PID 13508
2017-12-01 09:12:17,740 [salt.minion      ][INFO    ][13508] Returning information for job: 20171201091217714033
2017-12-01 09:12:27,813 [salt.minion      ][INFO    ][1735] User sudo_ubuntu Executing command saltutil.find_job with jid 20171201091227811521
2017-12-01 09:12:27,828 [salt.minion      ][INFO    ][13518] Starting a new job with PID 13518
2017-12-01 09:12:27,839 [salt.minion      ][INFO    ][13518] Returning information for job: 20171201091227811521
2017-12-01 09:12:37,915 [salt.minion      ][INFO    ][1735] User sudo_ubuntu Executing command saltutil.find_job with jid 20171201091237913736
2017-12-01 09:12:37,931 [salt.minion      ][INFO    ][13523] Starting a new job with PID 13523
2017-12-01 09:12:37,940 [salt.minion      ][INFO    ][13523] Returning information for job: 20171201091237913736
2017-12-01 09:12:48,026 [salt.minion      ][INFO    ][1735] User sudo_ubuntu Executing command saltutil.find_job with jid 20171201091248025604
2017-12-01 09:12:48,043 [salt.minion      ][INFO    ][13528] Starting a new job with PID 13528
2017-12-01 09:12:48,052 [salt.minion      ][INFO    ][13528] Returning information for job: 20171201091248025604
2017-12-01 09:12:58,144 [salt.minion      ][INFO    ][1735] User sudo_ubuntu Executing command saltutil.find_job with jid 20171201091258143428
2017-12-01 09:12:58,159 [salt.minion      ][INFO    ][13687] Starting a new job with PID 13687
2017-12-01 09:12:58,168 [salt.minion      ][INFO    ][13687] Returning information for job: 20171201091258143428
2017-12-01 09:13:08,269 [salt.minion      ][INFO    ][1735] User sudo_ubuntu Executing command saltutil.find_job with jid 20171201091308266921
2017-12-01 09:13:08,284 [salt.minion      ][INFO    ][13692] Starting a new job with PID 13692
2017-12-01 09:13:08,294 [salt.minion      ][INFO    ][13692] Returning information for job: 20171201091308266921
2017-12-01 09:13:18,396 [salt.minion      ][INFO    ][1735] User sudo_ubuntu Executing command saltutil.find_job with jid 20171201091318389807
2017-12-01 09:13:18,410 [salt.minion      ][INFO    ][13697] Starting a new job with PID 13697
2017-12-01 09:13:18,420 [salt.minion      ][INFO    ][13697] Returning information for job: 20171201091318389807
2017-12-01 09:13:28,533 [salt.minion      ][INFO    ][1735] User sudo_ubuntu Executing command saltutil.find_job with jid 20171201091328521875
2017-12-01 09:13:28,546 [salt.minion      ][INFO    ][13707] Starting a new job with PID 13707
2017-12-01 09:13:28,556 [salt.minion      ][INFO    ][13707] Returning information for job: 20171201091328521875
2017-12-01 09:13:38,676 [salt.minion      ][INFO    ][1735] User sudo_ubuntu Executing command saltutil.find_job with jid 20171201091338662943
2017-12-01 09:13:38,689 [salt.minion      ][INFO    ][13712] Starting a new job with PID 13712
2017-12-01 09:13:38,699 [salt.minion      ][INFO    ][13712] Returning information for job: 20171201091338662943
2017-12-01 09:13:48,823 [salt.minion      ][INFO    ][1735] User sudo_ubuntu Executing command saltutil.find_job with jid 20171201091348809799
2017-12-01 09:13:48,837 [salt.minion      ][INFO    ][13722] Starting a new job with PID 13722
2017-12-01 09:13:48,848 [salt.minion      ][INFO    ][13722] Returning information for job: 20171201091348809799
2017-12-01 09:13:58,983 [salt.minion      ][INFO    ][1735] User sudo_ubuntu Executing command saltutil.find_job with jid 20171201091358970564
2017-12-01 09:13:58,996 [salt.minion      ][INFO    ][13727] Starting a new job with PID 13727
2017-12-01 09:13:59,008 [salt.minion      ][INFO    ][13727] Returning information for job: 20171201091358970564
2017-12-01 09:14:09,144 [salt.minion      ][INFO    ][1735] User sudo_ubuntu Executing command saltutil.find_job with jid 20171201091409132771
2017-12-01 09:14:09,159 [salt.minion      ][INFO    ][13732] Starting a new job with PID 13732
2017-12-01 09:14:09,171 [salt.minion      ][INFO    ][13732] Returning information for job: 20171201091409132771
2017-12-01 09:14:19,318 [salt.minion      ][INFO    ][1735] User sudo_ubuntu Executing command saltutil.find_job with jid 20171201091419307356
2017-12-01 09:14:19,332 [salt.minion      ][INFO    ][13737] Starting a new job with PID 13737
2017-12-01 09:14:19,343 [salt.minion      ][INFO    ][13737] Returning information for job: 20171201091419307356
2017-12-01 09:14:29,487 [salt.minion      ][INFO    ][1735] User sudo_ubuntu Executing command saltutil.find_job with jid 20171201091429476809
2017-12-01 09:14:29,502 [salt.minion      ][INFO    ][13747] Starting a new job with PID 13747
2017-12-01 09:14:29,514 [salt.minion      ][INFO    ][13747] Returning information for job: 20171201091429476809
2017-12-01 09:14:39,669 [salt.minion      ][INFO    ][1735] User sudo_ubuntu Executing command saltutil.find_job with jid 20171201091439660627
2017-12-01 09:14:39,683 [salt.minion      ][INFO    ][13752] Starting a new job with PID 13752
2017-12-01 09:14:39,695 [salt.minion      ][INFO    ][13752] Returning information for job: 20171201091439660627
2017-12-01 09:14:49,857 [salt.minion      ][INFO    ][1735] User sudo_ubuntu Executing command saltutil.find_job with jid 20171201091449846448
2017-12-01 09:14:49,871 [salt.minion      ][INFO    ][13762] Starting a new job with PID 13762
2017-12-01 09:14:49,882 [salt.minion      ][INFO    ][13762] Returning information for job: 20171201091449846448
2017-12-01 09:15:00,051 [salt.minion      ][INFO    ][1735] User sudo_ubuntu Executing command saltutil.find_job with jid 20171201091500042916
2017-12-01 09:15:00,067 [salt.minion      ][INFO    ][13767] Starting a new job with PID 13767
2017-12-01 09:15:00,078 [salt.minion      ][INFO    ][13767] Returning information for job: 20171201091500042916
2017-12-01 09:15:10,261 [salt.minion      ][INFO    ][1735] User sudo_ubuntu Executing command saltutil.find_job with jid 20171201091510253420
2017-12-01 09:15:10,275 [salt.minion      ][INFO    ][13772] Starting a new job with PID 13772
2017-12-01 09:15:10,286 [salt.minion      ][INFO    ][13772] Returning information for job: 20171201091510253420
2017-12-01 09:15:20,465 [salt.minion      ][INFO    ][1735] User sudo_ubuntu Executing command saltutil.find_job with jid 20171201091520456682
2017-12-01 09:15:20,480 [salt.minion      ][INFO    ][13782] Starting a new job with PID 13782
2017-12-01 09:15:20,529 [salt.minion      ][INFO    ][13782] Returning information for job: 20171201091520456682
2017-12-01 09:15:30,494 [salt.minion      ][INFO    ][1735] User sudo_ubuntu Executing command saltutil.find_job with jid 20171201091530485454
2017-12-01 09:15:30,507 [salt.minion      ][INFO    ][13787] Starting a new job with PID 13787
2017-12-01 09:15:30,519 [salt.minion      ][INFO    ][13787] Returning information for job: 20171201091530485454
2017-12-01 09:15:40,712 [salt.minion      ][INFO    ][1735] User sudo_ubuntu Executing command saltutil.find_job with jid 20171201091540705583
2017-12-01 09:15:40,725 [salt.minion      ][INFO    ][13792] Starting a new job with PID 13792
2017-12-01 09:15:40,737 [salt.minion      ][INFO    ][13792] Returning information for job: 20171201091540705583
2017-12-01 09:15:50,936 [salt.minion      ][INFO    ][1735] User sudo_ubuntu Executing command saltutil.find_job with jid 20171201091550930109
2017-12-01 09:15:50,950 [salt.minion      ][INFO    ][13802] Starting a new job with PID 13802
2017-12-01 09:15:50,961 [salt.minion      ][INFO    ][13802] Returning information for job: 20171201091550930109
2017-12-01 09:16:00,961 [salt.minion      ][INFO    ][1735] User sudo_ubuntu Executing command saltutil.find_job with jid 20171201091600955649
2017-12-01 09:16:00,976 [salt.minion      ][INFO    ][13807] Starting a new job with PID 13807
2017-12-01 09:16:00,988 [salt.minion      ][INFO    ][13807] Returning information for job: 20171201091600955649
2017-12-01 09:16:10,990 [salt.minion      ][INFO    ][1735] User sudo_ubuntu Executing command saltutil.find_job with jid 20171201091610982924
2017-12-01 09:16:11,004 [salt.minion      ][INFO    ][13812] Starting a new job with PID 13812
2017-12-01 09:16:11,016 [salt.minion      ][INFO    ][13812] Returning information for job: 20171201091610982924
2017-12-01 09:16:21,034 [salt.minion      ][INFO    ][1735] User sudo_ubuntu Executing command saltutil.find_job with jid 20171201091621027707
2017-12-01 09:16:21,049 [salt.minion      ][INFO    ][13822] Starting a new job with PID 13822
2017-12-01 09:16:21,062 [salt.minion      ][INFO    ][13822] Returning information for job: 20171201091621027707
2017-12-01 09:16:31,081 [salt.minion      ][INFO    ][1735] User sudo_ubuntu Executing command saltutil.find_job with jid 20171201091631076753
2017-12-01 09:16:31,096 [salt.minion      ][INFO    ][13827] Starting a new job with PID 13827
2017-12-01 09:16:31,107 [salt.minion      ][INFO    ][13827] Returning information for job: 20171201091631076753
2017-12-01 09:16:41,134 [salt.minion      ][INFO    ][1735] User sudo_ubuntu Executing command saltutil.find_job with jid 20171201091641130371
2017-12-01 09:16:41,148 [salt.minion      ][INFO    ][13832] Starting a new job with PID 13832
2017-12-01 09:16:41,159 [salt.minion      ][INFO    ][13832] Returning information for job: 20171201091641130371
2017-12-01 09:16:51,230 [salt.minion      ][INFO    ][1735] User sudo_ubuntu Executing command saltutil.find_job with jid 20171201091651200409
2017-12-01 09:16:51,242 [salt.minion      ][INFO    ][13842] Starting a new job with PID 13842
2017-12-01 09:16:51,253 [salt.minion      ][INFO    ][13842] Returning information for job: 20171201091651200409
2017-12-01 09:17:01,296 [salt.minion      ][INFO    ][1735] User sudo_ubuntu Executing command saltutil.find_job with jid 20171201091701292393
2017-12-01 09:17:01,310 [salt.minion      ][INFO    ][13847] Starting a new job with PID 13847
2017-12-01 09:17:01,322 [salt.minion      ][INFO    ][13847] Returning information for job: 20171201091701292393
2017-12-01 09:17:11,370 [salt.minion      ][INFO    ][1735] User sudo_ubuntu Executing command saltutil.find_job with jid 20171201091711367940
2017-12-01 09:17:11,385 [salt.minion      ][INFO    ][13860] Starting a new job with PID 13860
2017-12-01 09:17:11,396 [salt.minion      ][INFO    ][13860] Returning information for job: 20171201091711367940
2017-12-01 09:17:21,453 [salt.minion      ][INFO    ][1735] User sudo_ubuntu Executing command saltutil.find_job with jid 20171201091721449639
2017-12-01 09:17:21,468 [salt.minion      ][INFO    ][13865] Starting a new job with PID 13865
2017-12-01 09:17:21,480 [salt.minion      ][INFO    ][13865] Returning information for job: 20171201091721449639
2017-12-01 09:17:31,548 [salt.minion      ][INFO    ][1735] User sudo_ubuntu Executing command saltutil.find_job with jid 20171201091731545946
2017-12-01 09:17:31,565 [salt.minion      ][INFO    ][13875] Starting a new job with PID 13875
2017-12-01 09:17:31,576 [salt.minion      ][INFO    ][13875] Returning information for job: 20171201091731545946
2017-12-01 09:17:41,648 [salt.minion      ][INFO    ][1735] User sudo_ubuntu Executing command saltutil.find_job with jid 20171201091741646849
2017-12-01 09:17:41,662 [salt.minion      ][INFO    ][13962] Starting a new job with PID 13962
2017-12-01 09:17:41,673 [salt.minion      ][INFO    ][13962] Returning information for job: 20171201091741646849
2017-12-01 09:17:45,223 [salt.loaded.int.module.cmdmod][INFO    ][8033] Executing command ['systemctl', 'is-active', 'mysql.service'] in directory '/root'
2017-12-01 09:17:45,241 [salt.loaded.int.module.cmdmod][INFO    ][8033] Executing command ['systemctl', 'is-enabled', 'mysql.service'] in directory '/root'
2017-12-01 09:17:45,257 [salt.state       ][INFO    ][8033] {'mysql': False}
2017-12-01 09:17:45,257 [salt.state       ][INFO    ][8033] Completed state [mysql] at time 09:17:45.257238 duration_in_ms=600283.802
2017-12-01 09:17:45,258 [salt.state       ][INFO    ][8033] Running state [/etc/mysql/my.cnf] at time 09:17:45.258245
2017-12-01 09:17:45,259 [salt.state       ][INFO    ][8033] Executing state file.managed for /etc/mysql/my.cnf
2017-12-01 09:17:45,276 [salt.fileclient  ][INFO    ][8033] Fetching file from saltenv 'base', ** done ** 'galera/files/my.cnf'
2017-12-01 09:17:45,304 [salt.fileclient  ][INFO    ][8033] Fetching file from saltenv 'base', ** done ** 'galera/map.jinja'
2017-12-01 09:17:45,320 [salt.state       ][INFO    ][8033] File changed:
--- 
+++ 
@@ -1,36 +1,67 @@
-[client]
-port		= 3306
-socket		= /var/run/mysqld/mysqld.sock
+# All files in this package is subject to the GPL v2 license
+# More information is in the COPYING file in the top directory of this package.
+# Copyright (C) 2011 severalnines.com
+
+[mysql]
+
+
 [mysqld_safe]
-socket		= /var/run/mysqld/mysqld.sock
-nice		= 0
 syslog
+
 [mysqld]
-user		= mysql
-pid-file	= /var/run/mysqld/mysqld.pid
-socket		= /var/run/mysqld/mysqld.sock
-port		= 3306
-basedir		= /usr
-datadir		= /var/lib/mysql
-tmpdir		= /tmp
-lc-messages-dir	= /usr/share/mysql
+datadir=/var/lib/mysql
+bind-address=10.167.4.52
+port=3306
+max_connections=3072
+default-storage-engine=innodb
+binlog_format=ROW
+collation-server=utf8_general_ci
+init-connect='SET NAMES utf8'
+character-set-server=utf8
+default-storage-engine=innodb
+#log_error=/var/log/mysql/error.log
 skip-external-locking
-bind-address		= 127.0.0.1
-key_buffer		= 16M
-max_allowed_packet	= 16M
-thread_stack		= 192K
-thread_cache_size       = 8
-myisam-recover         = BACKUP
-query_cache_limit	= 1M
-query_cache_size        = 16M
-#log_error = /var/log/mysql/error.log
-expire_logs_days	= 10
-max_binlog_size         = 100M
-[mysqldump]
-quick
-quote-names
-max_allowed_packet	= 16M
-[mysql]
-[isamchk]
-key_buffer		= 16M
-!includedir /etc/mysql/conf.d/
+skip-name-resolve
+socket = /var/run/mysqld/mysqld.sock
+
+myisam_sort_buffer_size=64M
+wait_timeout=1800
+open_files_limit=102400
+table_open_cache=10000
+key_buffer_size=64M
+max_allowed_packet=256M
+query_cache_size=0
+query_cache_type=0
+
+innodb_file_format=Barracuda
+innodb_file_per_table=1
+innodb_buffer_pool_size=2048M
+innodb_log_file_size=627M
+innodb_read_io_threads=8
+innodb_write_io_threads=8
+innodb_io_capacity=500
+innodb_flush_log_at_trx_commit=2
+innodb_flush_method=O_DIRECT
+innodb_doublewrite=0
+innodb_autoinc_lock_mode=2
+innodb_locks_unsafe_for_binlog=1
+wsrep_cluster_address="gcomm://10.167.4.51:4567,10.167.4.52:4567,10.167.4.53:4567/?pc.wait_prim=no"
+wsrep_provider=/usr/lib/galera/libgalera_smm.so
+wsrep_cluster_name="openstack"
+
+wsrep_slave_threads=8
+wsrep_sst_method=xtrabackup-v2
+wsrep_sst_auth=root:opnfv_secret
+wsrep_node_address=10.167.4.52
+wsrep_provider_options="gcache.size = 256M"
+wsrep_provider_options="gmcast.listen_addr = tcp://10.167.4.52:4567"
+
+
+
+[xtrabackup]
+parallel=4
+
+[sst]
+streamfmt=xbstream
+transferfmt=socat
+sockopt=,nodelay,sndbuf=1048576,rcvbuf=1048576

2017-12-01 09:17:45,321 [salt.state       ][INFO    ][8033] Completed state [/etc/mysql/my.cnf] at time 09:17:45.320786 duration_in_ms=62.541
2017-12-01 09:17:45,322 [salt.state       ][INFO    ][8033] Running state [/usr/local/sbin/galera_bootstrap.sh] at time 09:17:45.321808
2017-12-01 09:17:45,322 [salt.state       ][INFO    ][8033] Executing state cmd.run for /usr/local/sbin/galera_bootstrap.sh
2017-12-01 09:17:45,322 [salt.loaded.int.module.cmdmod][INFO    ][8033] Executing command '/usr/local/sbin/galera_bootstrap.sh' in directory '/root'
2017-12-01 09:17:51,766 [salt.minion      ][INFO    ][1735] User sudo_ubuntu Executing command saltutil.find_job with jid 20171201091751760397
2017-12-01 09:17:51,783 [salt.minion      ][INFO    ][14698] Starting a new job with PID 14698
2017-12-01 09:17:51,794 [salt.minion      ][INFO    ][14698] Returning information for job: 20171201091751760397
2017-12-01 09:18:01,907 [salt.minion      ][INFO    ][1735] User sudo_ubuntu Executing command saltutil.find_job with jid 20171201091801886680
2017-12-01 09:18:01,922 [salt.minion      ][INFO    ][15120] Starting a new job with PID 15120
2017-12-01 09:18:01,933 [salt.minion      ][INFO    ][15120] Returning information for job: 20171201091801886680
2017-12-01 09:18:12,045 [salt.minion      ][INFO    ][1735] User sudo_ubuntu Executing command saltutil.find_job with jid 20171201091812034660
2017-12-01 09:18:12,059 [salt.minion      ][INFO    ][15145] Starting a new job with PID 15145
2017-12-01 09:18:12,077 [salt.minion      ][INFO    ][15145] Returning information for job: 20171201091812034660
2017-12-01 09:18:22,188 [salt.minion      ][INFO    ][1735] User sudo_ubuntu Executing command saltutil.find_job with jid 20171201091822176123
2017-12-01 09:18:22,203 [salt.minion      ][INFO    ][15271] Starting a new job with PID 15271
2017-12-01 09:18:22,214 [salt.minion      ][INFO    ][15271] Returning information for job: 20171201091822176123
2017-12-01 09:18:24,966 [salt.state       ][INFO    ][8033] {'pid': 13971, 'retcode': 0, 'stderr': "Warning: Using a password on the command line interface can be insecure.\nERROR 2002 (HY000): Can't connect to local MySQL server through socket '/var/run/mysqld/mysqld.sock' (111)\nWarning: Using a password on the command line interface can be insecure.\nERROR 2002 (HY000): Can't connect to local MySQL server through socket '/var/run/mysqld/mysqld.sock' (111)\nWarning: Using a password on the command line interface can be insecure.", 'stdout': 'Sucessfully connected to the MySQL service (2 retries).'}
2017-12-01 09:18:24,966 [salt.state       ][INFO    ][8033] Completed state [/usr/local/sbin/galera_bootstrap.sh] at time 09:18:24.966369 duration_in_ms=39644.559
2017-12-01 09:18:24,967 [salt.state       ][INFO    ][8033] Running state [/var/lib/mysql/.galera_bootstrap] at time 09:18:24.967388
2017-12-01 09:18:24,968 [salt.state       ][INFO    ][8033] Executing state file.touch for /var/lib/mysql/.galera_bootstrap
2017-12-01 09:18:24,968 [salt.state       ][INFO    ][8033] {'new': '/var/lib/mysql/.galera_bootstrap'}
2017-12-01 09:18:24,968 [salt.state       ][INFO    ][8033] Completed state [/var/lib/mysql/.galera_bootstrap] at time 09:18:24.968373 duration_in_ms=0.985
2017-12-01 09:18:25,361 [salt.state       ][INFO    ][8033] Running state [/etc/mysql/my.cnf] at time 09:18:25.360794
2017-12-01 09:18:25,361 [salt.state       ][INFO    ][8033] Executing state file.managed for /etc/mysql/my.cnf
2017-12-01 09:18:25,382 [salt.fileclient  ][INFO    ][8033] Fetching file from saltenv 'base', ** done ** 'galera/files/my.cnf'
2017-12-01 09:18:25,407 [salt.fileclient  ][INFO    ][8033] Fetching file from saltenv 'base', ** done ** 'galera/map.jinja'
2017-12-01 09:18:25,421 [salt.state       ][INFO    ][8033] File /etc/mysql/my.cnf is in the correct state
2017-12-01 09:18:25,421 [salt.state       ][INFO    ][8033] Completed state [/etc/mysql/my.cnf] at time 09:18:25.421257 duration_in_ms=60.463
2017-12-01 09:18:25,423 [salt.state       ][INFO    ][8033] Running state [mysql] at time 09:18:25.422486
2017-12-01 09:18:25,423 [salt.state       ][INFO    ][8033] Executing state service.running for mysql
2017-12-01 09:18:25,423 [salt.loaded.int.module.cmdmod][INFO    ][8033] Executing command ['systemctl', 'is-active', 'mysql.service'] in directory '/root'
2017-12-01 09:18:25,438 [salt.loaded.int.module.cmdmod][INFO    ][8033] Executing command ['systemctl', 'is-enabled', 'mysql.service'] in directory '/root'
2017-12-01 09:18:25,452 [salt.loaded.int.module.cmdmod][INFO    ][8033] Executing command ['systemctl', 'is-enabled', 'mysql.service'] in directory '/root'
2017-12-01 09:18:25,466 [salt.loaded.int.module.cmdmod][INFO    ][8033] Executing command ['systemctl', 'is-enabled', 'mysql.service'] in directory '/root'
2017-12-01 09:18:25,480 [salt.loaded.int.module.cmdmod][INFO    ][8033] Executing command ['systemd-run', '--scope', 'systemctl', 'enable', 'mysql.service'] in directory '/root'
2017-12-01 09:18:25,639 [salt.loaded.int.module.cmdmod][INFO    ][8033] Executing command ['systemctl', 'is-enabled', 'mysql.service'] in directory '/root'
2017-12-01 09:18:25,653 [salt.state       ][INFO    ][8033] {'mysql': True}
2017-12-01 09:18:25,654 [salt.state       ][INFO    ][8033] Completed state [mysql] at time 09:18:25.653669 duration_in_ms=231.182
2017-12-01 09:18:25,654 [salt.state       ][INFO    ][8033] Running state [ceilometer] at time 09:18:25.653896
2017-12-01 09:18:25,654 [salt.state       ][INFO    ][8033] Executing state mysql_database.present for ceilometer
2017-12-01 09:18:25,656 [salt.state       ][INFO    ][8033] Database ceilometer is already present
2017-12-01 09:18:25,657 [salt.state       ][INFO    ][8033] Completed state [ceilometer] at time 09:18:25.656570 duration_in_ms=2.675
2017-12-01 09:18:25,657 [salt.state       ][INFO    ][8033] Running state [ceilometer] at time 09:18:25.656735
2017-12-01 09:18:25,657 [salt.state       ][INFO    ][8033] Executing state mysql_user.present for ceilometer
2017-12-01 09:18:25,659 [salt.state       ][INFO    ][8033] User ceilometer@% is already present with the desired password
2017-12-01 09:18:25,659 [salt.state       ][INFO    ][8033] Completed state [ceilometer] at time 09:18:25.659026 duration_in_ms=2.292
2017-12-01 09:18:25,660 [salt.state       ][INFO    ][8033] Running state [mysql_grants_ceilometer_ceilometer_%] at time 09:18:25.660166
2017-12-01 09:18:25,660 [salt.state       ][INFO    ][8033] Executing state mysql_grants.present for mysql_grants_ceilometer_ceilometer_%
2017-12-01 09:18:25,663 [salt.state       ][INFO    ][8033] Grant all on ceilometer.* to ceilometer@% is already present
2017-12-01 09:18:25,664 [salt.state       ][INFO    ][8033] Completed state [mysql_grants_ceilometer_ceilometer_%] at time 09:18:25.663574 duration_in_ms=3.408
2017-12-01 09:18:25,664 [salt.state       ][INFO    ][8033] Running state [ceilometer] at time 09:18:25.663723
2017-12-01 09:18:25,664 [salt.state       ][INFO    ][8033] Executing state mysql_user.present for ceilometer
2017-12-01 09:18:25,749 [salt.loaded.int.module.mysql][INFO    ][8033] User 'ceilometer'@'10.167.4.52' has been created
2017-12-01 09:18:25,750 [salt.state       ][INFO    ][8033] {'ceilometer': 'Present'}
2017-12-01 09:18:25,750 [salt.state       ][INFO    ][8033] Completed state [ceilometer] at time 09:18:25.749734 duration_in_ms=86.011
2017-12-01 09:18:25,751 [salt.state       ][INFO    ][8033] Running state [mysql_grants_ceilometer_ceilometer_10.167.4.52] at time 09:18:25.750638
2017-12-01 09:18:25,751 [salt.state       ][INFO    ][8033] Executing state mysql_grants.present for mysql_grants_ceilometer_ceilometer_10.167.4.52
2017-12-01 09:18:25,811 [salt.loaded.int.module.mysql][INFO    ][8033] Grant 'all' on 'ceilometer.*' for user 'ceilometer' has been added
2017-12-01 09:18:25,811 [salt.state       ][INFO    ][8033] {'mysql_grants_ceilometer_ceilometer_10.167.4.52': 'Present'}
2017-12-01 09:18:25,811 [salt.state       ][INFO    ][8033] Completed state [mysql_grants_ceilometer_ceilometer_10.167.4.52] at time 09:18:25.811115 duration_in_ms=60.477
2017-12-01 09:18:25,811 [salt.state       ][INFO    ][8033] Running state [aodh] at time 09:18:25.811269
2017-12-01 09:18:25,811 [salt.state       ][INFO    ][8033] Executing state mysql_database.present for aodh
2017-12-01 09:18:25,813 [salt.state       ][INFO    ][8033] Database aodh is already present
2017-12-01 09:18:25,813 [salt.state       ][INFO    ][8033] Completed state [aodh] at time 09:18:25.813332 duration_in_ms=2.062
2017-12-01 09:18:25,814 [salt.state       ][INFO    ][8033] Running state [aodh] at time 09:18:25.813487
2017-12-01 09:18:25,814 [salt.state       ][INFO    ][8033] Executing state mysql_user.present for aodh
2017-12-01 09:18:25,815 [salt.state       ][INFO    ][8033] User aodh@% is already present with the desired password
2017-12-01 09:18:25,816 [salt.state       ][INFO    ][8033] Completed state [aodh] at time 09:18:25.815624 duration_in_ms=2.138
2017-12-01 09:18:25,817 [salt.state       ][INFO    ][8033] Running state [mysql_grants_aodh_aodh_%] at time 09:18:25.816613
2017-12-01 09:18:25,817 [salt.state       ][INFO    ][8033] Executing state mysql_grants.present for mysql_grants_aodh_aodh_%
2017-12-01 09:18:25,820 [salt.state       ][INFO    ][8033] Grant all on aodh.* to aodh@% is already present
2017-12-01 09:18:25,820 [salt.state       ][INFO    ][8033] Completed state [mysql_grants_aodh_aodh_%] at time 09:18:25.819953 duration_in_ms=3.34
2017-12-01 09:18:25,820 [salt.state       ][INFO    ][8033] Running state [aodh] at time 09:18:25.820104
2017-12-01 09:18:25,820 [salt.state       ][INFO    ][8033] Executing state mysql_user.present for aodh
2017-12-01 09:18:25,822 [salt.state       ][INFO    ][8033] User aodh@10.167.4.50 is already present with the desired password
2017-12-01 09:18:25,822 [salt.state       ][INFO    ][8033] Completed state [aodh] at time 09:18:25.822305 duration_in_ms=2.2
2017-12-01 09:18:25,823 [salt.state       ][INFO    ][8033] Running state [mysql_grants_aodh_aodh_10.167.4.50] at time 09:18:25.823178
2017-12-01 09:18:25,823 [salt.state       ][INFO    ][8033] Executing state mysql_grants.present for mysql_grants_aodh_aodh_10.167.4.50
2017-12-01 09:18:25,826 [salt.state       ][INFO    ][8033] Grant all on aodh.* to aodh@10.167.4.50 is already present
2017-12-01 09:18:25,827 [salt.state       ][INFO    ][8033] Completed state [mysql_grants_aodh_aodh_10.167.4.50] at time 09:18:25.826581 duration_in_ms=3.403
2017-12-01 09:18:25,827 [salt.state       ][INFO    ][8033] Running state [nova] at time 09:18:25.826731
2017-12-01 09:18:25,827 [salt.state       ][INFO    ][8033] Executing state mysql_database.present for nova
2017-12-01 09:18:25,828 [salt.state       ][INFO    ][8033] Database nova is already present
2017-12-01 09:18:25,829 [salt.state       ][INFO    ][8033] Completed state [nova] at time 09:18:25.828628 duration_in_ms=1.897
2017-12-01 09:18:25,829 [salt.state       ][INFO    ][8033] Running state [nova] at time 09:18:25.828782
2017-12-01 09:18:25,829 [salt.state       ][INFO    ][8033] Executing state mysql_user.present for nova
2017-12-01 09:18:25,831 [salt.state       ][INFO    ][8033] User nova@% is already present with the desired password
2017-12-01 09:18:25,831 [salt.state       ][INFO    ][8033] Completed state [nova] at time 09:18:25.830993 duration_in_ms=2.211
2017-12-01 09:18:25,832 [salt.state       ][INFO    ][8033] Running state [mysql_grants_nova_nova_%] at time 09:18:25.831951
2017-12-01 09:18:25,832 [salt.state       ][INFO    ][8033] Executing state mysql_grants.present for mysql_grants_nova_nova_%
2017-12-01 09:18:25,835 [salt.state       ][INFO    ][8033] Grant all on nova.* to nova@% is already present
2017-12-01 09:18:25,836 [salt.state       ][INFO    ][8033] Completed state [mysql_grants_nova_nova_%] at time 09:18:25.835582 duration_in_ms=3.631
2017-12-01 09:18:25,836 [salt.state       ][INFO    ][8033] Running state [nova] at time 09:18:25.835728
2017-12-01 09:18:25,836 [salt.state       ][INFO    ][8033] Executing state mysql_user.present for nova
2017-12-01 09:18:25,911 [salt.loaded.int.module.mysql][INFO    ][8033] User 'nova'@'10.167.4.52' has been created
2017-12-01 09:18:25,912 [salt.state       ][INFO    ][8033] {'nova': 'Present'}
2017-12-01 09:18:25,912 [salt.state       ][INFO    ][8033] Completed state [nova] at time 09:18:25.911679 duration_in_ms=75.951
2017-12-01 09:18:25,913 [salt.state       ][INFO    ][8033] Running state [mysql_grants_nova_nova_10.167.4.52] at time 09:18:25.912755
2017-12-01 09:18:25,913 [salt.state       ][INFO    ][8033] Executing state mysql_grants.present for mysql_grants_nova_nova_10.167.4.52
2017-12-01 09:18:25,973 [salt.loaded.int.module.mysql][INFO    ][8033] Grant 'all' on 'nova.*' for user 'nova' has been added
2017-12-01 09:18:25,973 [salt.state       ][INFO    ][8033] {'mysql_grants_nova_nova_10.167.4.52': 'Present'}
2017-12-01 09:18:25,973 [salt.state       ][INFO    ][8033] Completed state [mysql_grants_nova_nova_10.167.4.52] at time 09:18:25.973335 duration_in_ms=60.58
2017-12-01 09:18:25,974 [salt.state       ][INFO    ][8033] Running state [grafana] at time 09:18:25.973652
2017-12-01 09:18:25,974 [salt.state       ][INFO    ][8033] Executing state mysql_database.present for grafana
2017-12-01 09:18:25,976 [salt.state       ][INFO    ][8033] Database grafana is already present
2017-12-01 09:18:25,976 [salt.state       ][INFO    ][8033] Completed state [grafana] at time 09:18:25.976038 duration_in_ms=2.386
2017-12-01 09:18:25,976 [salt.state       ][INFO    ][8033] Running state [grafana] at time 09:18:25.976332
2017-12-01 09:18:25,977 [salt.state       ][INFO    ][8033] Executing state mysql_user.present for grafana
2017-12-01 09:18:25,979 [salt.state       ][INFO    ][8033] User grafana@% is already present with the desired password
2017-12-01 09:18:25,979 [salt.state       ][INFO    ][8033] Completed state [grafana] at time 09:18:25.978944 duration_in_ms=2.612
2017-12-01 09:18:25,980 [salt.state       ][INFO    ][8033] Running state [mysql_grants_grafana_grafana_%] at time 09:18:25.980194
2017-12-01 09:18:25,981 [salt.state       ][INFO    ][8033] Executing state mysql_grants.present for mysql_grants_grafana_grafana_%
2017-12-01 09:18:25,984 [salt.state       ][INFO    ][8033] Grant all on grafana.* to grafana@% is already present
2017-12-01 09:18:25,984 [salt.state       ][INFO    ][8033] Completed state [mysql_grants_grafana_grafana_%] at time 09:18:25.984009 duration_in_ms=3.815
2017-12-01 09:18:25,984 [salt.state       ][INFO    ][8033] Running state [grafana] at time 09:18:25.984289
2017-12-01 09:18:25,985 [salt.state       ][INFO    ][8033] Executing state mysql_user.present for grafana
2017-12-01 09:18:26,055 [salt.loaded.int.module.mysql][INFO    ][8033] User 'grafana'@'10.167.4.52' has been created
2017-12-01 09:18:26,056 [salt.state       ][INFO    ][8033] {'grafana': 'Present'}
2017-12-01 09:18:26,056 [salt.state       ][INFO    ][8033] Completed state [grafana] at time 09:18:26.056059 duration_in_ms=71.77
2017-12-01 09:18:26,057 [salt.state       ][INFO    ][8033] Running state [mysql_grants_grafana_grafana_10.167.4.52] at time 09:18:26.057156
2017-12-01 09:18:26,057 [salt.state       ][INFO    ][8033] Executing state mysql_grants.present for mysql_grants_grafana_grafana_10.167.4.52
2017-12-01 09:18:26,117 [salt.loaded.int.module.mysql][INFO    ][8033] Grant 'all' on 'grafana.*' for user 'grafana' has been added
2017-12-01 09:18:26,117 [salt.state       ][INFO    ][8033] {'mysql_grants_grafana_grafana_10.167.4.52': 'Present'}
2017-12-01 09:18:26,118 [salt.state       ][INFO    ][8033] Completed state [mysql_grants_grafana_grafana_10.167.4.52] at time 09:18:26.117707 duration_in_ms=60.551
2017-12-01 09:18:26,118 [salt.state       ][INFO    ][8033] Running state [designate_pool_manager] at time 09:18:26.118028
2017-12-01 09:18:26,118 [salt.state       ][INFO    ][8033] Executing state mysql_database.present for designate_pool_manager
2017-12-01 09:18:26,120 [salt.state       ][INFO    ][8033] Database designate_pool_manager is already present
2017-12-01 09:18:26,121 [salt.state       ][INFO    ][8033] Completed state [designate_pool_manager] at time 09:18:26.120644 duration_in_ms=2.617
2017-12-01 09:18:26,121 [salt.state       ][INFO    ][8033] Running state [designate] at time 09:18:26.120962
2017-12-01 09:18:26,121 [salt.state       ][INFO    ][8033] Executing state mysql_user.present for designate
2017-12-01 09:18:26,124 [salt.state       ][INFO    ][8033] User designate@% is already present with the desired password
2017-12-01 09:18:26,124 [salt.state       ][INFO    ][8033] Completed state [designate] at time 09:18:26.123943 duration_in_ms=2.98
2017-12-01 09:18:26,125 [salt.state       ][INFO    ][8033] Running state [mysql_grants_designate_designate_pool_manager_%] at time 09:18:26.125225
2017-12-01 09:18:26,126 [salt.state       ][INFO    ][8033] Executing state mysql_grants.present for mysql_grants_designate_designate_pool_manager_%
2017-12-01 09:18:26,129 [salt.state       ][INFO    ][8033] Grant all on designate_pool_manager.* to designate@% is already present
2017-12-01 09:18:26,130 [salt.state       ][INFO    ][8033] Completed state [mysql_grants_designate_designate_pool_manager_%] at time 09:18:26.129681 duration_in_ms=4.457
2017-12-01 09:18:26,130 [salt.state       ][INFO    ][8033] Running state [designate] at time 09:18:26.129991
2017-12-01 09:18:26,130 [salt.state       ][INFO    ][8033] Executing state mysql_user.present for designate
2017-12-01 09:18:26,133 [salt.state       ][INFO    ][8033] User designate@10.167.4.50 is already present with the desired password
2017-12-01 09:18:26,133 [salt.state       ][INFO    ][8033] Completed state [designate] at time 09:18:26.132811 duration_in_ms=2.82
2017-12-01 09:18:26,134 [salt.state       ][INFO    ][8033] Running state [mysql_grants_designate_designate_pool_manager_10.167.4.50] at time 09:18:26.133905
2017-12-01 09:18:26,134 [salt.state       ][INFO    ][8033] Executing state mysql_grants.present for mysql_grants_designate_designate_pool_manager_10.167.4.50
2017-12-01 09:18:26,138 [salt.state       ][INFO    ][8033] Grant all on designate_pool_manager.* to designate@10.167.4.50 is already present
2017-12-01 09:18:26,138 [salt.state       ][INFO    ][8033] Completed state [mysql_grants_designate_designate_pool_manager_10.167.4.50] at time 09:18:26.138233 duration_in_ms=4.328
2017-12-01 09:18:26,139 [salt.state       ][INFO    ][8033] Running state [heat] at time 09:18:26.138541
2017-12-01 09:18:26,139 [salt.state       ][INFO    ][8033] Executing state mysql_database.present for heat
2017-12-01 09:18:26,141 [salt.state       ][INFO    ][8033] Database heat is already present
2017-12-01 09:18:26,141 [salt.state       ][INFO    ][8033] Completed state [heat] at time 09:18:26.141220 duration_in_ms=2.679
2017-12-01 09:18:26,142 [salt.state       ][INFO    ][8033] Running state [heat] at time 09:18:26.141524
2017-12-01 09:18:26,142 [salt.state       ][INFO    ][8033] Executing state mysql_user.present for heat
2017-12-01 09:18:26,144 [salt.state       ][INFO    ][8033] User heat@% is already present with the desired password
2017-12-01 09:18:26,145 [salt.state       ][INFO    ][8033] Completed state [heat] at time 09:18:26.144596 duration_in_ms=3.072
2017-12-01 09:18:26,146 [salt.state       ][INFO    ][8033] Running state [mysql_grants_heat_heat_%] at time 09:18:26.146328
2017-12-01 09:18:26,147 [salt.state       ][INFO    ][8033] Executing state mysql_grants.present for mysql_grants_heat_heat_%
2017-12-01 09:18:26,151 [salt.state       ][INFO    ][8033] Grant all on heat.* to heat@% is already present
2017-12-01 09:18:26,151 [salt.state       ][INFO    ][8033] Completed state [mysql_grants_heat_heat_%] at time 09:18:26.151233 duration_in_ms=4.905
2017-12-01 09:18:26,152 [salt.state       ][INFO    ][8033] Running state [heat] at time 09:18:26.151545
2017-12-01 09:18:26,152 [salt.state       ][INFO    ][8033] Executing state mysql_user.present for heat
2017-12-01 09:18:26,223 [salt.loaded.int.module.mysql][INFO    ][8033] User 'heat'@'10.167.4.52' has been created
2017-12-01 09:18:26,223 [salt.state       ][INFO    ][8033] {'heat': 'Present'}
2017-12-01 09:18:26,224 [salt.state       ][INFO    ][8033] Completed state [heat] at time 09:18:26.223760 duration_in_ms=72.215
2017-12-01 09:18:26,225 [salt.state       ][INFO    ][8033] Running state [mysql_grants_heat_heat_10.167.4.52] at time 09:18:26.224864
2017-12-01 09:18:26,225 [salt.state       ][INFO    ][8033] Executing state mysql_grants.present for mysql_grants_heat_heat_10.167.4.52
2017-12-01 09:18:26,290 [salt.loaded.int.module.mysql][INFO    ][8033] Grant 'all' on 'heat.*' for user 'heat' has been added
2017-12-01 09:18:26,291 [salt.state       ][INFO    ][8033] {'mysql_grants_heat_heat_10.167.4.52': 'Present'}
2017-12-01 09:18:26,291 [salt.state       ][INFO    ][8033] Completed state [mysql_grants_heat_heat_10.167.4.52] at time 09:18:26.290910 duration_in_ms=66.046
2017-12-01 09:18:26,291 [salt.state       ][INFO    ][8033] Running state [nova_api] at time 09:18:26.291198
2017-12-01 09:18:26,291 [salt.state       ][INFO    ][8033] Executing state mysql_database.present for nova_api
2017-12-01 09:18:26,293 [salt.state       ][INFO    ][8033] Database nova_api is already present
2017-12-01 09:18:26,293 [salt.state       ][INFO    ][8033] Completed state [nova_api] at time 09:18:26.293411 duration_in_ms=2.212
2017-12-01 09:18:26,294 [salt.state       ][INFO    ][8033] Running state [nova] at time 09:18:26.293696
2017-12-01 09:18:26,294 [salt.state       ][INFO    ][8033] Executing state mysql_user.present for nova
2017-12-01 09:18:26,296 [salt.state       ][INFO    ][8033] User nova@% is already present with the desired password
2017-12-01 09:18:26,296 [salt.state       ][INFO    ][8033] Completed state [nova] at time 09:18:26.296203 duration_in_ms=2.508
2017-12-01 09:18:26,297 [salt.state       ][INFO    ][8033] Running state [mysql_grants_nova_nova_api_%] at time 09:18:26.297346
2017-12-01 09:18:26,298 [salt.state       ][INFO    ][8033] Executing state mysql_grants.present for mysql_grants_nova_nova_api_%
2017-12-01 09:18:26,301 [salt.state       ][INFO    ][8033] Grant all on nova_api.* to nova@% is already present
2017-12-01 09:18:26,301 [salt.state       ][INFO    ][8033] Completed state [mysql_grants_nova_nova_api_%] at time 09:18:26.301364 duration_in_ms=4.018
2017-12-01 09:18:26,302 [salt.state       ][INFO    ][8033] Running state [nova] at time 09:18:26.301641
2017-12-01 09:18:26,302 [salt.state       ][INFO    ][8033] Executing state mysql_user.present for nova
2017-12-01 09:18:26,304 [salt.state       ][INFO    ][8033] User nova@10.167.4.52 is already present with the desired password
2017-12-01 09:18:26,304 [salt.state       ][INFO    ][8033] Completed state [nova] at time 09:18:26.304124 duration_in_ms=2.482
2017-12-01 09:18:26,305 [salt.state       ][INFO    ][8033] Running state [mysql_grants_nova_nova_api_10.167.4.52] at time 09:18:26.305176
2017-12-01 09:18:26,305 [salt.state       ][INFO    ][8033] Executing state mysql_grants.present for mysql_grants_nova_nova_api_10.167.4.52
2017-12-01 09:18:26,369 [salt.loaded.int.module.mysql][INFO    ][8033] Grant 'all' on 'nova_api.*' for user 'nova' has been added
2017-12-01 09:18:26,369 [salt.state       ][INFO    ][8033] {'mysql_grants_nova_nova_api_10.167.4.52': 'Present'}
2017-12-01 09:18:26,370 [salt.state       ][INFO    ][8033] Completed state [mysql_grants_nova_nova_api_10.167.4.52] at time 09:18:26.369595 duration_in_ms=64.419
2017-12-01 09:18:26,370 [salt.state       ][INFO    ][8033] Running state [keystone] at time 09:18:26.369875
2017-12-01 09:18:26,370 [salt.state       ][INFO    ][8033] Executing state mysql_database.present for keystone
2017-12-01 09:18:26,372 [salt.state       ][INFO    ][8033] Database keystone is already present
2017-12-01 09:18:26,372 [salt.state       ][INFO    ][8033] Completed state [keystone] at time 09:18:26.372075 duration_in_ms=2.201
2017-12-01 09:18:26,372 [salt.state       ][INFO    ][8033] Running state [keystone] at time 09:18:26.372358
2017-12-01 09:18:26,373 [salt.state       ][INFO    ][8033] Executing state mysql_user.present for keystone
2017-12-01 09:18:26,375 [salt.state       ][INFO    ][8033] User keystone@% is already present with the desired password
2017-12-01 09:18:26,375 [salt.state       ][INFO    ][8033] Completed state [keystone] at time 09:18:26.374950 duration_in_ms=2.592
2017-12-01 09:18:26,376 [salt.state       ][INFO    ][8033] Running state [mysql_grants_keystone_keystone_%] at time 09:18:26.376056
2017-12-01 09:18:26,376 [salt.state       ][INFO    ][8033] Executing state mysql_grants.present for mysql_grants_keystone_keystone_%
2017-12-01 09:18:26,379 [salt.state       ][INFO    ][8033] Grant all on keystone.* to keystone@% is already present
2017-12-01 09:18:26,380 [salt.state       ][INFO    ][8033] Completed state [mysql_grants_keystone_keystone_%] at time 09:18:26.379625 duration_in_ms=3.568
2017-12-01 09:18:26,380 [salt.state       ][INFO    ][8033] Running state [keystone] at time 09:18:26.379931
2017-12-01 09:18:26,380 [salt.state       ][INFO    ][8033] Executing state mysql_user.present for keystone
2017-12-01 09:18:26,462 [salt.loaded.int.module.mysql][INFO    ][8033] User 'keystone'@'10.167.4.52' has been created
2017-12-01 09:18:26,463 [salt.state       ][INFO    ][8033] {'keystone': 'Present'}
2017-12-01 09:18:26,463 [salt.state       ][INFO    ][8033] Completed state [keystone] at time 09:18:26.462885 duration_in_ms=82.954
2017-12-01 09:18:26,464 [salt.state       ][INFO    ][8033] Running state [mysql_grants_keystone_keystone_10.167.4.52] at time 09:18:26.463952
2017-12-01 09:18:26,464 [salt.state       ][INFO    ][8033] Executing state mysql_grants.present for mysql_grants_keystone_keystone_10.167.4.52
2017-12-01 09:18:26,499 [salt.loaded.int.module.mysql][INFO    ][8033] Grant 'all' on 'keystone.*' for user 'keystone' has been added
2017-12-01 09:18:26,499 [salt.state       ][INFO    ][8033] {'mysql_grants_keystone_keystone_10.167.4.52': 'Present'}
2017-12-01 09:18:26,499 [salt.state       ][INFO    ][8033] Completed state [mysql_grants_keystone_keystone_10.167.4.52] at time 09:18:26.499181 duration_in_ms=35.228
2017-12-01 09:18:26,500 [salt.state       ][INFO    ][8033] Running state [nova_cell0] at time 09:18:26.499476
2017-12-01 09:18:26,500 [salt.state       ][INFO    ][8033] Executing state mysql_database.present for nova_cell0
2017-12-01 09:18:26,502 [salt.state       ][INFO    ][8033] Database nova_cell0 is already present
2017-12-01 09:18:26,502 [salt.state       ][INFO    ][8033] Completed state [nova_cell0] at time 09:18:26.501791 duration_in_ms=2.315
2017-12-01 09:18:26,502 [salt.state       ][INFO    ][8033] Running state [nova] at time 09:18:26.502079
2017-12-01 09:18:26,502 [salt.state       ][INFO    ][8033] Executing state mysql_user.present for nova
2017-12-01 09:18:26,504 [salt.state       ][INFO    ][8033] User nova@% is already present with the desired password
2017-12-01 09:18:26,505 [salt.state       ][INFO    ][8033] Completed state [nova] at time 09:18:26.504595 duration_in_ms=2.515
2017-12-01 09:18:26,506 [salt.state       ][INFO    ][8033] Running state [mysql_grants_nova_nova_cell0_%] at time 09:18:26.505724
2017-12-01 09:18:26,506 [salt.state       ][INFO    ][8033] Executing state mysql_grants.present for mysql_grants_nova_nova_cell0_%
2017-12-01 09:18:26,509 [salt.state       ][INFO    ][8033] Grant all on nova_cell0.* to nova@% is already present
2017-12-01 09:18:26,510 [salt.state       ][INFO    ][8033] Completed state [mysql_grants_nova_nova_cell0_%] at time 09:18:26.509682 duration_in_ms=3.957
2017-12-01 09:18:26,510 [salt.state       ][INFO    ][8033] Running state [nova] at time 09:18:26.509966
2017-12-01 09:18:26,510 [salt.state       ][INFO    ][8033] Executing state mysql_user.present for nova
2017-12-01 09:18:26,512 [salt.state       ][INFO    ][8033] User nova@10.167.4.52 is already present with the desired password
2017-12-01 09:18:26,513 [salt.state       ][INFO    ][8033] Completed state [nova] at time 09:18:26.512525 duration_in_ms=2.558
2017-12-01 09:18:26,514 [salt.state       ][INFO    ][8033] Running state [mysql_grants_nova_nova_cell0_10.167.4.52] at time 09:18:26.513595
2017-12-01 09:18:26,514 [salt.state       ][INFO    ][8033] Executing state mysql_grants.present for mysql_grants_nova_nova_cell0_10.167.4.52
2017-12-01 09:18:26,541 [salt.loaded.int.module.mysql][INFO    ][8033] Grant 'all' on 'nova_cell0.*' for user 'nova' has been added
2017-12-01 09:18:26,542 [salt.state       ][INFO    ][8033] {'mysql_grants_nova_nova_cell0_10.167.4.52': 'Present'}
2017-12-01 09:18:26,542 [salt.state       ][INFO    ][8033] Completed state [mysql_grants_nova_nova_cell0_10.167.4.52] at time 09:18:26.541916 duration_in_ms=28.32
2017-12-01 09:18:26,542 [salt.state       ][INFO    ][8033] Running state [cinder] at time 09:18:26.542207
2017-12-01 09:18:26,543 [salt.state       ][INFO    ][8033] Executing state mysql_database.present for cinder
2017-12-01 09:18:26,544 [salt.state       ][INFO    ][8033] Database cinder is already present
2017-12-01 09:18:26,544 [salt.state       ][INFO    ][8033] Completed state [cinder] at time 09:18:26.544431 duration_in_ms=2.224
2017-12-01 09:18:26,545 [salt.state       ][INFO    ][8033] Running state [cinder] at time 09:18:26.544729
2017-12-01 09:18:26,545 [salt.state       ][INFO    ][8033] Executing state mysql_user.present for cinder
2017-12-01 09:18:26,547 [salt.state       ][INFO    ][8033] User cinder@% is already present with the desired password
2017-12-01 09:18:26,547 [salt.state       ][INFO    ][8033] Completed state [cinder] at time 09:18:26.547339 duration_in_ms=2.609
2017-12-01 09:18:26,549 [salt.state       ][INFO    ][8033] Running state [mysql_grants_cinder_cinder_%] at time 09:18:26.548585
2017-12-01 09:18:26,549 [salt.state       ][INFO    ][8033] Executing state mysql_grants.present for mysql_grants_cinder_cinder_%
2017-12-01 09:18:26,552 [salt.state       ][INFO    ][8033] Grant all on cinder.* to cinder@% is already present
2017-12-01 09:18:26,552 [salt.state       ][INFO    ][8033] Completed state [mysql_grants_cinder_cinder_%] at time 09:18:26.552273 duration_in_ms=3.688
2017-12-01 09:18:26,553 [salt.state       ][INFO    ][8033] Running state [cinder] at time 09:18:26.552571
2017-12-01 09:18:26,553 [salt.state       ][INFO    ][8033] Executing state mysql_user.present for cinder
2017-12-01 09:18:26,599 [salt.loaded.int.module.mysql][INFO    ][8033] User 'cinder'@'10.167.4.52' has been created
2017-12-01 09:18:26,599 [salt.state       ][INFO    ][8033] {'cinder': 'Present'}
2017-12-01 09:18:26,599 [salt.state       ][INFO    ][8033] Completed state [cinder] at time 09:18:26.599275 duration_in_ms=46.704
2017-12-01 09:18:26,600 [salt.state       ][INFO    ][8033] Running state [mysql_grants_cinder_cinder_10.167.4.52] at time 09:18:26.600293
2017-12-01 09:18:26,601 [salt.state       ][INFO    ][8033] Executing state mysql_grants.present for mysql_grants_cinder_cinder_10.167.4.52
2017-12-01 09:18:26,642 [salt.loaded.int.module.mysql][INFO    ][8033] Grant 'all' on 'cinder.*' for user 'cinder' has been added
2017-12-01 09:18:26,642 [salt.state       ][INFO    ][8033] {'mysql_grants_cinder_cinder_10.167.4.52': 'Present'}
2017-12-01 09:18:26,643 [salt.state       ][INFO    ][8033] Completed state [mysql_grants_cinder_cinder_10.167.4.52] at time 09:18:26.642551 duration_in_ms=42.258
2017-12-01 09:18:26,643 [salt.state       ][INFO    ][8033] Running state [glance] at time 09:18:26.642833
2017-12-01 09:18:26,643 [salt.state       ][INFO    ][8033] Executing state mysql_database.present for glance
2017-12-01 09:18:26,645 [salt.state       ][INFO    ][8033] Database glance is already present
2017-12-01 09:18:26,645 [salt.state       ][INFO    ][8033] Completed state [glance] at time 09:18:26.645351 duration_in_ms=2.518
2017-12-01 09:18:26,646 [salt.state       ][INFO    ][8033] Running state [glance] at time 09:18:26.645631
2017-12-01 09:18:26,646 [salt.state       ][INFO    ][8033] Executing state mysql_user.present for glance
2017-12-01 09:18:26,648 [salt.state       ][INFO    ][8033] User glance@% is already present with the desired password
2017-12-01 09:18:26,648 [salt.state       ][INFO    ][8033] Completed state [glance] at time 09:18:26.648165 duration_in_ms=2.533
2017-12-01 09:18:26,649 [salt.state       ][INFO    ][8033] Running state [mysql_grants_glance_glance_%] at time 09:18:26.649302
2017-12-01 09:18:26,650 [salt.state       ][INFO    ][8033] Executing state mysql_grants.present for mysql_grants_glance_glance_%
2017-12-01 09:18:26,653 [salt.state       ][INFO    ][8033] Grant all on glance.* to glance@% is already present
2017-12-01 09:18:26,653 [salt.state       ][INFO    ][8033] Completed state [mysql_grants_glance_glance_%] at time 09:18:26.652951 duration_in_ms=3.65
2017-12-01 09:18:26,653 [salt.state       ][INFO    ][8033] Running state [glance] at time 09:18:26.653230
2017-12-01 09:18:26,654 [salt.state       ][INFO    ][8033] Executing state mysql_user.present for glance
2017-12-01 09:18:26,695 [salt.loaded.int.module.mysql][INFO    ][8033] User 'glance'@'10.167.4.52' has been created
2017-12-01 09:18:26,695 [salt.state       ][INFO    ][8033] {'glance': 'Present'}
2017-12-01 09:18:26,695 [salt.state       ][INFO    ][8033] Completed state [glance] at time 09:18:26.695126 duration_in_ms=41.896
2017-12-01 09:18:26,696 [salt.state       ][INFO    ][8033] Running state [mysql_grants_glance_glance_10.167.4.52] at time 09:18:26.696140
2017-12-01 09:18:26,696 [salt.state       ][INFO    ][8033] Executing state mysql_grants.present for mysql_grants_glance_glance_10.167.4.52
2017-12-01 09:18:26,744 [salt.loaded.int.module.mysql][INFO    ][8033] Grant 'all' on 'glance.*' for user 'glance' has been added
2017-12-01 09:18:26,745 [salt.state       ][INFO    ][8033] {'mysql_grants_glance_glance_10.167.4.52': 'Present'}
2017-12-01 09:18:26,745 [salt.state       ][INFO    ][8033] Completed state [mysql_grants_glance_glance_10.167.4.52] at time 09:18:26.744983 duration_in_ms=48.842
2017-12-01 09:18:26,745 [salt.state       ][INFO    ][8033] Running state [neutron] at time 09:18:26.745262
2017-12-01 09:18:26,746 [salt.state       ][INFO    ][8033] Executing state mysql_database.present for neutron
2017-12-01 09:18:26,747 [salt.state       ][INFO    ][8033] Database neutron is already present
2017-12-01 09:18:26,748 [salt.state       ][INFO    ][8033] Completed state [neutron] at time 09:18:26.747590 duration_in_ms=2.327
2017-12-01 09:18:26,748 [salt.state       ][INFO    ][8033] Running state [neutron] at time 09:18:26.747877
2017-12-01 09:18:26,748 [salt.state       ][INFO    ][8033] Executing state mysql_user.present for neutron
2017-12-01 09:18:26,750 [salt.state       ][INFO    ][8033] User neutron@% is already present with the desired password
2017-12-01 09:18:26,750 [salt.state       ][INFO    ][8033] Completed state [neutron] at time 09:18:26.750405 duration_in_ms=2.528
2017-12-01 09:18:26,752 [salt.state       ][INFO    ][8033] Running state [mysql_grants_neutron_neutron_%] at time 09:18:26.751520
2017-12-01 09:18:26,752 [salt.state       ][INFO    ][8033] Executing state mysql_grants.present for mysql_grants_neutron_neutron_%
2017-12-01 09:18:26,755 [salt.state       ][INFO    ][8033] Grant all on neutron.* to neutron@% is already present
2017-12-01 09:18:26,755 [salt.state       ][INFO    ][8033] Completed state [mysql_grants_neutron_neutron_%] at time 09:18:26.755203 duration_in_ms=3.683
2017-12-01 09:18:26,756 [salt.state       ][INFO    ][8033] Running state [neutron] at time 09:18:26.755494
2017-12-01 09:18:26,756 [salt.state       ][INFO    ][8033] Executing state mysql_user.present for neutron
2017-12-01 09:18:26,797 [salt.loaded.int.module.mysql][INFO    ][8033] User 'neutron'@'10.167.4.52' has been created
2017-12-01 09:18:26,797 [salt.state       ][INFO    ][8033] {'neutron': 'Present'}
2017-12-01 09:18:26,797 [salt.state       ][INFO    ][8033] Completed state [neutron] at time 09:18:26.797324 duration_in_ms=41.83
2017-12-01 09:18:26,798 [salt.state       ][INFO    ][8033] Running state [mysql_grants_neutron_neutron_10.167.4.52] at time 09:18:26.798364
2017-12-01 09:18:26,799 [salt.state       ][INFO    ][8033] Executing state mysql_grants.present for mysql_grants_neutron_neutron_10.167.4.52
2017-12-01 09:18:26,840 [salt.loaded.int.module.mysql][INFO    ][8033] Grant 'all' on 'neutron.*' for user 'neutron' has been added
2017-12-01 09:18:26,840 [salt.state       ][INFO    ][8033] {'mysql_grants_neutron_neutron_10.167.4.52': 'Present'}
2017-12-01 09:18:26,841 [salt.state       ][INFO    ][8033] Completed state [mysql_grants_neutron_neutron_10.167.4.52] at time 09:18:26.840489 duration_in_ms=42.125
2017-12-01 09:18:26,841 [salt.state       ][INFO    ][8033] Running state [designate] at time 09:18:26.840774
2017-12-01 09:18:26,841 [salt.state       ][INFO    ][8033] Executing state mysql_database.present for designate
2017-12-01 09:18:26,843 [salt.state       ][INFO    ][8033] Database designate is already present
2017-12-01 09:18:26,843 [salt.state       ][INFO    ][8033] Completed state [designate] at time 09:18:26.842966 duration_in_ms=2.192
2017-12-01 09:18:26,843 [salt.state       ][INFO    ][8033] Running state [designate] at time 09:18:26.843236
2017-12-01 09:18:26,844 [salt.state       ][INFO    ][8033] Executing state mysql_user.present for designate
2017-12-01 09:18:26,846 [salt.state       ][INFO    ][8033] User designate@% is already present with the desired password
2017-12-01 09:18:26,846 [salt.state       ][INFO    ][8033] Completed state [designate] at time 09:18:26.845801 duration_in_ms=2.565
2017-12-01 09:18:26,847 [salt.state       ][INFO    ][8033] Running state [mysql_grants_designate_designate_%] at time 09:18:26.846940
2017-12-01 09:18:26,847 [salt.state       ][INFO    ][8033] Executing state mysql_grants.present for mysql_grants_designate_designate_%
2017-12-01 09:18:26,850 [salt.state       ][INFO    ][8033] Grant all on designate.* to designate@% is already present
2017-12-01 09:18:26,851 [salt.state       ][INFO    ][8033] Completed state [mysql_grants_designate_designate_%] at time 09:18:26.850668 duration_in_ms=3.728
2017-12-01 09:18:26,851 [salt.state       ][INFO    ][8033] Running state [designate] at time 09:18:26.850940
2017-12-01 09:18:26,851 [salt.state       ][INFO    ][8033] Executing state mysql_user.present for designate
2017-12-01 09:18:26,853 [salt.state       ][INFO    ][8033] User designate@10.167.4.50 is already present with the desired password
2017-12-01 09:18:26,853 [salt.state       ][INFO    ][8033] Completed state [designate] at time 09:18:26.853361 duration_in_ms=2.42
2017-12-01 09:18:26,854 [salt.state       ][INFO    ][8033] Running state [mysql_grants_designate_designate_10.167.4.50] at time 09:18:26.854370
2017-12-01 09:18:26,855 [salt.state       ][INFO    ][8033] Executing state mysql_grants.present for mysql_grants_designate_designate_10.167.4.50
2017-12-01 09:18:26,858 [salt.state       ][INFO    ][8033] Grant all on designate.* to designate@10.167.4.50 is already present
2017-12-01 09:18:26,858 [salt.state       ][INFO    ][8033] Completed state [mysql_grants_designate_designate_10.167.4.50] at time 09:18:26.857878 duration_in_ms=3.508
2017-12-01 09:18:26,858 [salt.state       ][INFO    ][8033] Running state [haproxy] at time 09:18:26.858152
2017-12-01 09:18:26,858 [salt.state       ][INFO    ][8033] Executing state mysql_user.present for haproxy
2017-12-01 09:18:26,860 [salt.state       ][INFO    ][8033] User haproxy@localhost is already present with passwordless login
2017-12-01 09:18:26,861 [salt.state       ][INFO    ][8033] Completed state [haproxy] at time 09:18:26.860595 duration_in_ms=2.443
2017-12-01 09:18:26,861 [salt.state       ][INFO    ][8033] Running state [haproxy] at time 09:18:26.860881
2017-12-01 09:18:26,861 [salt.state       ][INFO    ][8033] Executing state mysql_user.present for haproxy
2017-12-01 09:18:26,863 [salt.state       ][INFO    ][8033] User haproxy@% is already present with passwordless login
2017-12-01 09:18:26,864 [salt.state       ][INFO    ][8033] Completed state [haproxy] at time 09:18:26.863735 duration_in_ms=2.854
2017-12-01 09:18:26,864 [salt.state       ][INFO    ][8033] Running state [haproxy] at time 09:18:26.864012
2017-12-01 09:18:26,864 [salt.state       ][INFO    ][8033] Executing state mysql_user.present for haproxy
2017-12-01 09:18:26,903 [salt.loaded.int.module.mysql][INFO    ][8033] User 'haproxy'@'10.167.4.52' has been created with passwordless login
2017-12-01 09:18:26,904 [salt.state       ][INFO    ][8033] {'haproxy': 'Present'}
2017-12-01 09:18:26,904 [salt.state       ][INFO    ][8033] Completed state [haproxy] at time 09:18:26.903863 duration_in_ms=39.851
2017-12-01 09:18:26,906 [salt.minion      ][INFO    ][8033] Returning information for job: 20171201090543527922
2017-12-01 09:18:58,563 [salt.minion      ][INFO    ][1735] User sudo_ubuntu Executing command state.sls with jid 20171201091858558916
2017-12-01 09:18:58,593 [salt.minion      ][INFO    ][15341] Starting a new job with PID 15341
2017-12-01 09:18:59,408 [salt.state       ][INFO    ][15341] Loading fresh modules for state activity
2017-12-01 09:18:59,431 [salt.fileclient  ][INFO    ][15341] Fetching file from saltenv 'base', ** done ** 'haproxy/init.sls'
2017-12-01 09:18:59,447 [salt.fileclient  ][INFO    ][15341] Fetching file from saltenv 'base', ** done ** 'haproxy/proxy.sls'
2017-12-01 09:18:59,466 [salt.fileclient  ][INFO    ][15341] Fetching file from saltenv 'base', ** done ** 'haproxy/map.jinja'
2017-12-01 09:18:59,732 [salt.state       ][INFO    ][15341] Running state [haproxy] at time 09:18:59.732192
2017-12-01 09:18:59,732 [salt.state       ][INFO    ][15341] Executing state pkg.installed for haproxy
2017-12-01 09:18:59,733 [salt.loaded.int.module.cmdmod][INFO    ][15341] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-01 09:19:00,238 [salt.loaded.int.module.cmdmod][INFO    ][15341] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-12-01 09:19:02,362 [salt.loaded.int.module.cmdmod][INFO    ][15341] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'haproxy'] in directory '/root'
2017-12-01 09:19:08,653 [salt.minion      ][INFO    ][1735] User sudo_ubuntu Executing command saltutil.find_job with jid 20171201091908644684
2017-12-01 09:19:08,673 [salt.minion      ][INFO    ][15774] Starting a new job with PID 15774
2017-12-01 09:19:08,733 [salt.minion      ][INFO    ][15774] Returning information for job: 20171201091908644684
2017-12-01 09:19:16,005 [salt.loaded.int.module.cmdmod][INFO    ][15341] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-01 09:19:16,057 [salt.state       ][INFO    ][15341] Made the following changes:
'haproxy' changed from 'absent' to '1.6.3-1~u16.04+mcp1'
'liblua5.3-0' changed from 'absent' to '5.3.1-1ubuntu2'

2017-12-01 09:19:16,065 [salt.state       ][INFO    ][15341] Loading fresh modules for state activity
2017-12-01 09:19:16,077 [salt.state       ][INFO    ][15341] Completed state [haproxy] at time 09:19:16.077067 duration_in_ms=16344.876
2017-12-01 09:19:16,079 [salt.state       ][INFO    ][15341] Running state [/etc/default/haproxy] at time 09:19:16.078782
2017-12-01 09:19:16,079 [salt.state       ][INFO    ][15341] Executing state file.managed for /etc/default/haproxy
2017-12-01 09:19:16,101 [salt.fileclient  ][INFO    ][15341] Fetching file from saltenv 'base', ** done ** 'haproxy/files/haproxy.default'
2017-12-01 09:19:16,104 [salt.state       ][INFO    ][15341] File changed:
--- 
+++ 
@@ -1,10 +1,5 @@
-# Defaults file for HAProxy
-#
-# This is sourced by both, the initscript and the systemd unit file, so do not
-# treat it as a shell script fragment.
 
-# Change the config file location if needed
-#CONFIG="/etc/haproxy/haproxy.cfg"
-
-# Add extra flags here, see haproxy(1) for a few options
+# Set ENABLED to 1 if you want the init script to start haproxy.
+ENABLED=1
+# Add extra flags here.
 #EXTRAOPTS="-de -m 16"

2017-12-01 09:19:16,105 [salt.state       ][INFO    ][15341] Completed state [/etc/default/haproxy] at time 09:19:16.105146 duration_in_ms=26.364
2017-12-01 09:19:16,105 [salt.state       ][INFO    ][15341] Running state [/etc/haproxy/haproxy.cfg] at time 09:19:16.105425
2017-12-01 09:19:16,106 [salt.state       ][INFO    ][15341] Executing state file.managed for /etc/haproxy/haproxy.cfg
2017-12-01 09:19:16,122 [salt.fileclient  ][INFO    ][15341] Fetching file from saltenv 'base', ** done ** 'haproxy/files/haproxy.cfg'
2017-12-01 09:19:16,214 [salt.fileclient  ][INFO    ][15341] Fetching file from saltenv 'base', ** done ** 'haproxy/map.jinja'
2017-12-01 09:19:16,222 [salt.state       ][INFO    ][15341] File changed:
--- 
+++ 
@@ -1,35 +1,54 @@
 global
-	log /dev/log	local0
-	log /dev/log	local1 notice
-	chroot /var/lib/haproxy
-	stats socket /run/haproxy/admin.sock mode 660 level admin
-	stats timeout 30s
-	user haproxy
-	group haproxy
-	daemon
-
-	# Default SSL material locations
-	ca-base /etc/ssl/certs
-	crt-base /etc/ssl/private
-
-	# Default ciphers to use on SSL-enabled listening sockets.
-	# For more information, see ciphers(1SSL). This list is from:
-	#  https://hynek.me/articles/hardening-your-web-servers-ssl-ciphers/
-	ssl-default-bind-ciphers ECDH+AESGCM:DH+AESGCM:ECDH+AES256:DH+AES256:ECDH+AES128:DH+AES:ECDH+3DES:DH+3DES:RSA+AESGCM:RSA+AES:RSA+3DES:!aNULL:!MD5:!DSS
-	ssl-default-bind-options no-sslv3
+  log /dev/log  local0
+  log /dev/log  local1 notice
+  chroot /var/lib/haproxy
+  stats  socket /run/haproxy/admin.sock mode 660 level admin
+  stats timeout 30s
+  user  haproxy
+  group haproxy
+  daemon
+  pidfile  /var/run/haproxy.pid
+  spread-checks 4
+  tune.maxrewrite 1024
+  tune.bufsize 32768
+  maxconn  16000
+  # SSL options
+  ca-base /etc/haproxy/ssl
+  crt-base /etc/haproxy/ssl
+  tune.ssl.default-dh-param 2048
+  ssl-default-bind-ciphers ECDHE-ECDSA-CHACHA20-POLY1305:ECDHE-RSA-CHACHA20-POLY1305:ECDHE-ECDSA-AES128-GCM-SHA256:ECDHE-RSA-AES128-GCM-SHA256:ECDHE-ECDSA-AES256-GCM-SHA384:ECDHE-RSA-AES256-GCM-SHA384:DHE-RSA-AES128-GCM-SHA256:DHE-RSA-AES256-GCM-SHA384:ECDHE-ECDSA-AES128-SHA256:ECDHE-RSA-AES128-SHA256:ECDHE-ECDSA-AES128-SHA:ECDHE-RSA-AES256-SHA384:ECDHE-RSA-AES128-SHA:ECDHE-ECDSA-AES256-SHA384:ECDHE-ECDSA-AES256-SHA:ECDHE-RSA-AES256-SHA:DHE-RSA-AES128-SHA256:DHE-RSA-AES128-SHA:DHE-RSA-AES256-SHA256:DHE-RSA-AES256-SHA:ECDHE-ECDSA-DES-CBC3-SHA:ECDHE-RSA-DES-CBC3-SHA:EDH-RSA-DES-CBC3-SHA:AES128-GCM-SHA256:AES256-GCM-SHA384:AES128-SHA256:AES256-SHA256:AES128-SHA:AES256-SHA:DES-CBC3-SHA:!DSS
+  ssl-default-bind-options no-sslv3 no-tls-tickets
+  ssl-default-server-ciphers ECDHE-ECDSA-CHACHA20-POLY1305:ECDHE-RSA-CHACHA20-POLY1305:ECDHE-ECDSA-AES128-GCM-SHA256:ECDHE-RSA-AES128-GCM-SHA256:ECDHE-ECDSA-AES256-GCM-SHA384:ECDHE-RSA-AES256-GCM-SHA384:DHE-RSA-AES128-GCM-SHA256:DHE-RSA-AES256-GCM-SHA384:ECDHE-ECDSA-AES128-SHA256:ECDHE-RSA-AES128-SHA256:ECDHE-ECDSA-AES128-SHA:ECDHE-RSA-AES256-SHA384:ECDHE-RSA-AES128-SHA:ECDHE-ECDSA-AES256-SHA384:ECDHE-ECDSA-AES256-SHA:ECDHE-RSA-AES256-SHA:DHE-RSA-AES128-SHA256:DHE-RSA-AES128-SHA:DHE-RSA-AES256-SHA256:DHE-RSA-AES256-SHA:ECDHE-ECDSA-DES-CBC3-SHA:ECDHE-RSA-DES-CBC3-SHA:EDH-RSA-DES-CBC3-SHA:AES128-GCM-SHA256:AES256-GCM-SHA384:AES128-SHA256:AES256-SHA256:AES128-SHA:AES256-SHA:DES-CBC3-SHA:!DSS
+  ssl-default-server-options no-sslv3 no-tls-tickets
 
 defaults
-	log	global
-	mode	http
-	option	httplog
-	option	dontlognull
-        timeout connect 5000
-        timeout client  50000
-        timeout server  50000
-	errorfile 400 /etc/haproxy/errors/400.http
-	errorfile 403 /etc/haproxy/errors/403.http
-	errorfile 408 /etc/haproxy/errors/408.http
-	errorfile 500 /etc/haproxy/errors/500.http
-	errorfile 502 /etc/haproxy/errors/502.http
-	errorfile 503 /etc/haproxy/errors/503.http
-	errorfile 504 /etc/haproxy/errors/504.http
+  log  global
+  mode http
+
+  maxconn 8000
+  option  redispatch
+  retries  3
+  stats  enable
+
+  timeout http-request 10s
+  timeout queue 10s
+  timeout connect 10s
+  timeout client 10s
+  timeout server 10s
+  timeout check 10s
+
+listen mysql_cluster
+  bind 10.167.4.50:3306 
+  balance first
+  mode tcp
+  option httpchk
+  option tcplog
+  option clitcpka
+  option srvtcpka
+  timeout client  300s
+  timeout server  300s
+  # option conflict's with port check of clustercheck script, if enabled haproxy reports invalid reponse
+  option mysql-check user haproxy
+  server dbs01 10.167.4.51:3306 check inter 20s fastinter 2s downinter 2s rise 3 fall 3
+  server dbs02 10.167.4.52:3306 backup check inter 20s fastinter 2s downinter 2s rise 3 fall 3
+  server dbs03 10.167.4.53:3306 backup check inter 20s fastinter 2s downinter 2s rise 3 fall 3

2017-12-01 09:19:16,228 [salt.state       ][INFO    ][15341] Completed state [/etc/haproxy/haproxy.cfg] at time 09:19:16.227563 duration_in_ms=122.137
2017-12-01 09:19:16,228 [salt.state       ][INFO    ][15341] Running state [/etc/haproxy/ssl] at time 09:19:16.227911
2017-12-01 09:19:16,228 [salt.state       ][INFO    ][15341] Executing state file.directory for /etc/haproxy/ssl
2017-12-01 09:19:16,229 [salt.state       ][INFO    ][15341] {'/etc/haproxy/ssl': 'New Dir'}
2017-12-01 09:19:16,230 [salt.state       ][INFO    ][15341] Completed state [/etc/haproxy/ssl] at time 09:19:16.229478 duration_in_ms=1.567
2017-12-01 09:19:16,230 [salt.state       ][INFO    ][15341] Running state [haproxy_status_packages] at time 09:19:16.230446
2017-12-01 09:19:16,231 [salt.state       ][INFO    ][15341] Executing state pkg.installed for haproxy_status_packages
2017-12-01 09:19:16,399 [salt.state       ][INFO    ][15341] All specified packages are already installed
2017-12-01 09:19:16,399 [salt.state       ][INFO    ][15341] Completed state [haproxy_status_packages] at time 09:19:16.399056 duration_in_ms=168.609
2017-12-01 09:19:16,400 [salt.state       ][INFO    ][15341] Running state [/usr/bin/haproxy-status.sh] at time 09:19:16.399662
2017-12-01 09:19:16,400 [salt.state       ][INFO    ][15341] Executing state file.managed for /usr/bin/haproxy-status.sh
2017-12-01 09:19:16,416 [salt.fileclient  ][INFO    ][15341] Fetching file from saltenv 'base', ** done ** 'haproxy/files/haproxy-status.sh'
2017-12-01 09:19:16,433 [salt.fileclient  ][INFO    ][15341] Fetching file from saltenv 'base', ** done ** 'haproxy/map.jinja'
2017-12-01 09:19:16,437 [salt.state       ][INFO    ][15341] File changed:
New file
2017-12-01 09:19:16,438 [salt.state       ][INFO    ][15341] Completed state [/usr/bin/haproxy-status.sh] at time 09:19:16.437680 duration_in_ms=38.017
2017-12-01 09:19:16,438 [salt.state       ][INFO    ][15341] Running state [net.ipv4.ip_nonlocal_bind] at time 09:19:16.438186
2017-12-01 09:19:16,438 [salt.state       ][INFO    ][15341] Executing state sysctl.present for net.ipv4.ip_nonlocal_bind
2017-12-01 09:19:16,439 [salt.loaded.int.module.cmdmod][INFO    ][15341] Executing command 'sysctl -a' in directory '/root'
2017-12-01 09:19:16,454 [salt.loaded.int.module.cmdmod][INFO    ][15341] Executing command 'sysctl -w net.ipv4.ip_nonlocal_bind="1"' in directory '/root'
2017-12-01 09:19:16,461 [salt.state       ][INFO    ][15341] {'net.ipv4.ip_nonlocal_bind': 1}
2017-12-01 09:19:16,462 [salt.state       ][INFO    ][15341] Completed state [net.ipv4.ip_nonlocal_bind] at time 09:19:16.461713 duration_in_ms=23.525
2017-12-01 09:19:16,463 [salt.state       ][INFO    ][15341] Running state [haproxy] at time 09:19:16.462762
2017-12-01 09:19:16,463 [salt.state       ][INFO    ][15341] Executing state service.running for haproxy
2017-12-01 09:19:16,464 [salt.loaded.int.module.cmdmod][INFO    ][15341] Executing command ['systemctl', 'status', 'haproxy.service', '-n', '0'] in directory '/root'
2017-12-01 09:19:16,473 [salt.loaded.int.module.cmdmod][INFO    ][15341] Executing command ['systemctl', 'is-active', 'haproxy.service'] in directory '/root'
2017-12-01 09:19:16,482 [salt.loaded.int.module.cmdmod][INFO    ][15341] Executing command ['systemctl', 'is-enabled', 'haproxy.service'] in directory '/root'
2017-12-01 09:19:16,491 [salt.state       ][INFO    ][15341] The service haproxy is already running
2017-12-01 09:19:16,491 [salt.state       ][INFO    ][15341] Completed state [haproxy] at time 09:19:16.491155 duration_in_ms=28.392
2017-12-01 09:19:16,491 [salt.state       ][INFO    ][15341] Running state [haproxy] at time 09:19:16.491321
2017-12-01 09:19:16,492 [salt.state       ][INFO    ][15341] Executing state service.mod_watch for haproxy
2017-12-01 09:19:16,492 [salt.loaded.int.module.cmdmod][INFO    ][15341] Executing command ['systemctl', 'is-active', 'haproxy.service'] in directory '/root'
2017-12-01 09:19:16,500 [salt.loaded.int.module.cmdmod][INFO    ][15341] Executing command ['systemctl', 'is-enabled', 'haproxy.service'] in directory '/root'
2017-12-01 09:19:16,509 [salt.loaded.int.module.cmdmod][INFO    ][15341] Executing command ['systemd-run', '--scope', 'systemctl', 'restart', 'haproxy.service'] in directory '/root'
2017-12-01 09:19:16,542 [salt.state       ][INFO    ][15341] {'haproxy': True}
2017-12-01 09:19:16,542 [salt.state       ][INFO    ][15341] Completed state [haproxy] at time 09:19:16.541954 duration_in_ms=50.632
2017-12-01 09:19:16,543 [salt.minion      ][INFO    ][15341] Returning information for job: 20171201091858558916
2017-12-01 09:19:23,551 [salt.minion      ][INFO    ][1735] User sudo_ubuntu Executing command service.status with jid 20171201091923543146
2017-12-01 09:19:23,574 [salt.minion      ][INFO    ][15951] Starting a new job with PID 15951
2017-12-01 09:19:23,679 [salt.loaded.int.module.cmdmod][INFO    ][15951] Executing command ['systemctl', 'status', 'haproxy.service', '-n', '0'] in directory '/root'
2017-12-01 09:19:23,689 [salt.loaded.int.module.cmdmod][INFO    ][15951] Executing command ['systemctl', 'is-active', 'haproxy.service'] in directory '/root'
2017-12-01 09:19:23,698 [salt.minion      ][INFO    ][15951] Returning information for job: 20171201091923543146
2017-12-01 09:19:24,726 [salt.minion      ][INFO    ][1735] User sudo_ubuntu Executing command service.restart with jid 20171201091924719493
2017-12-01 09:19:24,748 [salt.minion      ][INFO    ][15959] Starting a new job with PID 15959
2017-12-01 09:19:24,852 [salt.loaded.int.module.cmdmod][INFO    ][15959] Executing command ['systemctl', 'status', 'rsyslog.service', '-n', '0'] in directory '/root'
2017-12-01 09:19:24,863 [salt.loaded.int.module.cmdmod][INFO    ][15959] Executing command ['systemctl', 'is-enabled', 'rsyslog.service'] in directory '/root'
2017-12-01 09:19:24,879 [salt.loaded.int.module.cmdmod][INFO    ][15959] Executing command ['systemd-run', '--scope', 'systemctl', 'restart', 'rsyslog.service'] in directory '/root'
2017-12-01 09:19:24,913 [salt.minion      ][INFO    ][15959] Returning information for job: 20171201091924719493
2017-12-01 09:34:13,643 [salt.utils.schedule][INFO    ][1735] Running scheduled job: __mine_interval
2017-12-01 10:26:16,557 [salt.minion      ][INFO    ][1735] User sudo_ubuntu Executing command cp.push_dir with jid 20171201102616551012
2017-12-01 10:26:16,584 [salt.minion      ][INFO    ][18991] Starting a new job with PID 18991
