2018-01-14 00:27:21,046 [py.warnings      ][WARNING ][1828] /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.

2018-01-14 00:27:54,404 [salt.loaded.int.module.cmdmod][ERROR   ][1828] Command 'while true; do salt-call saltutil.running|grep fun: && continue; salt-call --local service.restart salt-minion; break; done' failed with return code: None
2018-01-14 00:27:57,134 [salt.loaded.int.module.cmdmod][INFO    ][2395] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2018-01-14 00:27:57,155 [salt.loaded.int.module.cmdmod][INFO    ][2395] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2018-01-14 00:27:57,177 [salt.loaded.int.module.cmdmod][INFO    ][2395] Executing command ['systemd-run', '--scope', 'systemctl', 'restart', 'salt-minion.service'] in directory '/root'
2018-01-14 00:27:57,194 [salt.utils.parsers][WARNING ][1540] Minion received a SIGTERM. Exiting.
2018-01-14 00:27:58,163 [salt.cli.daemons ][INFO    ][2477] Setting up the Salt Minion "dbs02.baremetal-mcp-pike-ovs-ha.local"
2018-01-14 00:27:58,258 [salt.cli.daemons ][INFO    ][2477] Starting up the Salt Minion
2018-01-14 00:27:58,259 [salt.utils.event ][INFO    ][2477] Starting pull socket on /var/run/salt/minion/minion_event_08b7a86c1e_pull.ipc
2018-01-14 00:27:58,778 [salt.minion      ][INFO    ][2477] Creating minion process manager
2018-01-14 00:27:59,747 [salt.loader.192.168.11.2.int.module.cmdmod][INFO    ][2477] Executing command ['date', '+%z'] in directory '/root'
2018-01-14 00:27:59,765 [salt.utils.schedule][INFO    ][2477] Updating job settings for scheduled job: __mine_interval
2018-01-14 00:27:59,770 [salt.minion      ][INFO    ][2477] Added mine.update to scheduler
2018-01-14 00:27:59,783 [salt.minion      ][INFO    ][2477] Minion is starting as user 'root'
2018-01-14 00:27:59,799 [salt.minion      ][INFO    ][2477] Minion is ready to receive requests!
2018-01-14 00:28:00,800 [salt.utils.schedule][INFO    ][2477] Running scheduled job: __mine_interval
2018-01-14 00:28:06,733 [salt.minion      ][INFO    ][2477] User sudo_ubuntu Executing command service.force_reload with jid 20180114002805759503
2018-01-14 00:28:06,757 [salt.minion      ][INFO    ][2574] Starting a new job with PID 2574
2018-01-14 00:28:07,133 [salt.loader.192.168.11.2.int.module.cmdmod][INFO    ][2574] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2018-01-14 00:28:07,163 [salt.loader.192.168.11.2.int.module.cmdmod][INFO    ][2574] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2018-01-14 00:28:07,209 [salt.loader.192.168.11.2.int.module.cmdmod][INFO    ][2574] Executing command ['systemd-run', '--scope', 'systemctl', 'force-reload', 'salt-minion.service'] in directory '/root'
2018-01-14 00:28:07,241 [salt.utils.parsers][WARNING ][2477] Minion received a SIGTERM. Exiting.
2018-01-14 00:28:07,242 [salt.cli.daemons ][INFO    ][2477] Shutting down the Salt Minion
2018-01-14 00:28:07,591 [salt.cli.daemons ][INFO    ][2613] Setting up the Salt Minion "dbs02.baremetal-mcp-pike-ovs-ha.local"
2018-01-14 00:28:07,674 [salt.cli.daemons ][INFO    ][2613] Starting up the Salt Minion
2018-01-14 00:28:07,675 [salt.utils.event ][INFO    ][2613] Starting pull socket on /var/run/salt/minion/minion_event_08b7a86c1e_pull.ipc
2018-01-14 00:28:08,029 [salt.minion      ][INFO    ][2613] Creating minion process manager
2018-01-14 00:28:09,243 [salt.loader.192.168.11.2.int.module.cmdmod][INFO    ][2613] Executing command ['date', '+%z'] in directory '/root'
2018-01-14 00:28:09,270 [salt.utils.schedule][INFO    ][2613] Updating job settings for scheduled job: __mine_interval
2018-01-14 00:28:09,279 [salt.minion      ][INFO    ][2613] Added mine.update to scheduler
2018-01-14 00:28:09,292 [salt.minion      ][INFO    ][2613] Minion is starting as user 'root'
2018-01-14 00:28:09,307 [salt.minion      ][INFO    ][2613] Minion is ready to receive requests!
2018-01-14 00:28:10,309 [salt.utils.schedule][INFO    ][2613] Running scheduled job: __mine_interval
2018-01-14 00:28:16,855 [salt.minion      ][INFO    ][2613] User sudo_ubuntu Executing command saltutil.find_job with jid 20180114002815881458
2018-01-14 00:28:16,890 [salt.minion      ][INFO    ][2711] Starting a new job with PID 2711
2018-01-14 00:28:16,915 [salt.minion      ][INFO    ][2711] Returning information for job: 20180114002815881458
2018-01-14 00:28:28,477 [salt.minion      ][INFO    ][2613] User sudo_ubuntu Executing command state.apply with jid 20180114002827503901
2018-01-14 00:28:28,501 [salt.minion      ][INFO    ][2716] Starting a new job with PID 2716
2018-01-14 00:28:31,649 [salt.state       ][INFO    ][2716] Loading fresh modules for state activity
2018-01-14 00:28:31,858 [salt.fileclient  ][INFO    ][2716] Fetching file from saltenv 'base', ** done ** 'linux/init.sls'
2018-01-14 00:28:31,908 [salt.fileclient  ][INFO    ][2716] Fetching file from saltenv 'base', ** done ** 'linux/system/init.sls'
2018-01-14 00:28:32,044 [salt.fileclient  ][INFO    ][2716] Fetching file from saltenv 'base', ** done ** 'linux/system/env.sls'
2018-01-14 00:28:32,114 [salt.fileclient  ][INFO    ][2716] Fetching file from saltenv 'base', ** done ** 'linux/system/profile.sls'
2018-01-14 00:28:32,173 [salt.fileclient  ][INFO    ][2716] Fetching file from saltenv 'base', ** done ** 'linux/system/repo.sls'
2018-01-14 00:28:32,306 [salt.fileclient  ][INFO    ][2716] Fetching file from saltenv 'base', ** done ** 'linux/system/package.sls'
2018-01-14 00:28:32,372 [salt.fileclient  ][INFO    ][2716] Fetching file from saltenv 'base', ** done ** 'linux/system/timezone.sls'
2018-01-14 00:28:32,429 [salt.fileclient  ][INFO    ][2716] Fetching file from saltenv 'base', ** done ** 'linux/system/kernel.sls'
2018-01-14 00:28:32,509 [salt.fileclient  ][INFO    ][2716] Fetching file from saltenv 'base', ** done ** 'linux/system/cpu.sls'
2018-01-14 00:28:32,574 [salt.fileclient  ][INFO    ][2716] Fetching file from saltenv 'base', ** done ** 'linux/system/sysfs.sls'
2018-01-14 00:28:32,639 [salt.fileclient  ][INFO    ][2716] Fetching file from saltenv 'base', ** done ** 'linux/system/locale.sls'
2018-01-14 00:28:32,700 [salt.fileclient  ][INFO    ][2716] Fetching file from saltenv 'base', ** done ** 'linux/system/user.sls'
2018-01-14 00:28:32,782 [salt.fileclient  ][INFO    ][2716] Fetching file from saltenv 'base', ** done ** 'linux/system/group.sls'
2018-01-14 00:28:32,877 [salt.fileclient  ][INFO    ][2716] Fetching file from saltenv 'base', ** done ** 'linux/system/limit.sls'
2018-01-14 00:28:32,945 [salt.fileclient  ][INFO    ][2716] Fetching file from saltenv 'base', ** done ** 'linux/system/systemd.sls'
2018-01-14 00:28:33,007 [salt.fileclient  ][INFO    ][2716] Fetching file from saltenv 'base', ** done ** 'linux/system/apt.sls'
2018-01-14 00:28:33,081 [salt.fileclient  ][INFO    ][2716] Fetching file from saltenv 'base', ** done ** 'linux/network/init.sls'
2018-01-14 00:28:33,148 [salt.fileclient  ][INFO    ][2716] Fetching file from saltenv 'base', ** done ** 'linux/network/hostname.sls'
2018-01-14 00:28:33,209 [salt.fileclient  ][INFO    ][2716] Fetching file from saltenv 'base', ** done ** 'linux/network/host.sls'
2018-01-14 00:28:33,317 [salt.fileclient  ][INFO    ][2716] Fetching file from saltenv 'base', ** done ** 'linux/network/interface.sls'
2018-01-14 00:28:33,433 [salt.fileclient  ][INFO    ][2716] Fetching file from saltenv 'base', ** done ** 'linux/network/proxy.sls'
2018-01-14 00:28:33,504 [salt.fileclient  ][INFO    ][2716] Fetching file from saltenv 'base', ** done ** 'linux/storage/init.sls'
2018-01-14 00:28:33,577 [salt.fileclient  ][INFO    ][2716] Fetching file from saltenv 'base', ** done ** 'ntp/init.sls'
2018-01-14 00:28:33,597 [salt.fileclient  ][INFO    ][2716] Fetching file from saltenv 'base', ** done ** 'ntp/client.sls'
2018-01-14 00:28:33,632 [salt.fileclient  ][INFO    ][2716] Fetching file from saltenv 'base', ** done ** 'ntp/server.sls'
2018-01-14 00:28:33,665 [salt.state       ][INFO    ][2716] Running state [/etc/environment] at time 00:28:33.665691
2018-01-14 00:28:33,666 [salt.state       ][INFO    ][2716] Executing state file.blockreplace for /etc/environment
2018-01-14 00:28:33,672 [salt.state       ][INFO    ][2716] File changed:
--- 
+++ 
@@ -1 +1,4 @@
 PATH="/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/games:/usr/local/games"
+# SALT MANAGED VARIABLES - DO NOT EDIT - START
+# +# SALT MANAGED VARIABLES - END

2018-01-14 00:28:33,673 [salt.state       ][INFO    ][2716] Completed state [/etc/environment] at time 00:28:33.673385 duration_in_ms=7.695
2018-01-14 00:28:33,673 [salt.state       ][INFO    ][2716] Running state [/etc/profile.d] at time 00:28:33.673786
2018-01-14 00:28:33,674 [salt.state       ][INFO    ][2716] Executing state file.directory for /etc/profile.d
2018-01-14 00:28:33,686 [salt.state       ][INFO    ][2716] Directory /etc/profile.d is in the correct state
2018-01-14 00:28:33,686 [salt.state       ][INFO    ][2716] Completed state [/etc/profile.d] at time 00:28:33.686347 duration_in_ms=12.56
2018-01-14 00:28:34,116 [salt.state       ][INFO    ][2716] Running state [/etc/apt/apt.conf.d/99compression-workaround-salt] at time 00:28:34.116742
2018-01-14 00:28:34,117 [salt.state       ][INFO    ][2716] Executing state file.managed for /etc/apt/apt.conf.d/99compression-workaround-salt
2018-01-14 00:28:34,154 [salt.fileclient  ][INFO    ][2716] Fetching file from saltenv 'base', ** done ** 'linux/files/apt.conf'
2018-01-14 00:28:34,160 [salt.state       ][INFO    ][2716] File changed:
New file
2018-01-14 00:28:34,160 [salt.state       ][INFO    ][2716] Completed state [/etc/apt/apt.conf.d/99compression-workaround-salt] at time 00:28:34.160878 duration_in_ms=44.137
2018-01-14 00:28:34,161 [salt.state       ][INFO    ][2716] Running state [/etc/apt/apt.conf.d/99prefer_ipv4-salt] at time 00:28:34.161268
2018-01-14 00:28:34,161 [salt.state       ][INFO    ][2716] Executing state file.managed for /etc/apt/apt.conf.d/99prefer_ipv4-salt
2018-01-14 00:28:34,189 [salt.state       ][INFO    ][2716] File changed:
New file
2018-01-14 00:28:34,190 [salt.state       ][INFO    ][2716] Completed state [/etc/apt/apt.conf.d/99prefer_ipv4-salt] at time 00:28:34.190513 duration_in_ms=29.244
2018-01-14 00:28:34,191 [salt.state       ][INFO    ][2716] Running state [linux_repo_prereq_pkgs] at time 00:28:34.191544
2018-01-14 00:28:34,191 [salt.state       ][INFO    ][2716] Executing state pkg.installed for linux_repo_prereq_pkgs
2018-01-14 00:28:34,192 [salt.loaded.int.module.cmdmod][INFO    ][2716] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2018-01-14 00:28:34,558 [salt.state       ][INFO    ][2716] All specified packages are already installed
2018-01-14 00:28:34,559 [salt.state       ][INFO    ][2716] Completed state [linux_repo_prereq_pkgs] at time 00:28:34.559386 duration_in_ms=367.841
2018-01-14 00:28:34,559 [salt.state       ][INFO    ][2716] Running state [/etc/apt/apt.conf.d/99proxies-salt-mk_openstack] at time 00:28:34.559928
2018-01-14 00:28:34,560 [salt.state       ][INFO    ][2716] Executing state file.absent for /etc/apt/apt.conf.d/99proxies-salt-mk_openstack
2018-01-14 00:28:34,561 [salt.state       ][INFO    ][2716] File /etc/apt/apt.conf.d/99proxies-salt-mk_openstack is not present
2018-01-14 00:28:34,561 [salt.state       ][INFO    ][2716] Completed state [/etc/apt/apt.conf.d/99proxies-salt-mk_openstack] at time 00:28:34.561399 duration_in_ms=1.471
2018-01-14 00:28:34,561 [salt.state       ][INFO    ][2716] Running state [/etc/apt/preferences.d/mk_openstack] at time 00:28:34.561797
2018-01-14 00:28:34,562 [salt.state       ][INFO    ][2716] Executing state file.managed for /etc/apt/preferences.d/mk_openstack
2018-01-14 00:28:34,583 [salt.fileclient  ][INFO    ][2716] Fetching file from saltenv 'base', ** done ** 'linux/files/preferences_repo'
2018-01-14 00:28:34,637 [salt.state       ][INFO    ][2716] File changed:
New file
2018-01-14 00:28:34,637 [salt.state       ][INFO    ][2716] Completed state [/etc/apt/preferences.d/mk_openstack] at time 00:28:34.637854 duration_in_ms=76.056
2018-01-14 00:28:34,696 [salt.state       ][INFO    ][2716] Running state [deb [arch=amd64] http://apt.mirantis.com/xenial/ nightly pike] at time 00:28:34.696596
2018-01-14 00:28:34,697 [salt.state       ][INFO    ][2716] Executing state pkgrepo.managed for deb [arch=amd64] http://apt.mirantis.com/xenial/ nightly pike
2018-01-14 00:28:34,932 [salt.loaded.int.module.cmdmod][INFO    ][2716] Executing command ['apt-key', 'add', '/var/cache/salt/minion/extrn_files/base/apt.mirantis.com/public.gpg'] in directory '/root'
2018-01-14 00:28:35,360 [salt.loaded.int.module.cmdmod][INFO    ][2716] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2018-01-14 00:28:38,571 [salt.minion      ][INFO    ][2613] User sudo_ubuntu Executing command saltutil.find_job with jid 20180114002837596955
2018-01-14 00:28:38,598 [salt.minion      ][INFO    ][3205] Starting a new job with PID 3205
2018-01-14 00:28:38,627 [salt.minion      ][INFO    ][3205] Returning information for job: 20180114002837596955
2018-01-14 00:28:39,040 [salt.state       ][INFO    ][2716] {'repo': 'deb [arch=amd64] http://apt.mirantis.com/xenial nightly pike'}
2018-01-14 00:28:39,040 [salt.state       ][INFO    ][2716] Completed state [deb [arch=amd64] http://apt.mirantis.com/xenial/ nightly pike] at time 00:28:39.040788 duration_in_ms=4344.192
2018-01-14 00:28:39,041 [salt.state       ][INFO    ][2716] Running state [/etc/apt/apt.conf.d/99proxies-salt-mirantis_openstack] at time 00:28:39.041232
2018-01-14 00:28:39,041 [salt.state       ][INFO    ][2716] Executing state file.absent for /etc/apt/apt.conf.d/99proxies-salt-mirantis_openstack
2018-01-14 00:28:39,042 [salt.state       ][INFO    ][2716] File /etc/apt/apt.conf.d/99proxies-salt-mirantis_openstack is not present
2018-01-14 00:28:39,042 [salt.state       ][INFO    ][2716] Completed state [/etc/apt/apt.conf.d/99proxies-salt-mirantis_openstack] at time 00:28:39.042549 duration_in_ms=1.318
2018-01-14 00:28:39,042 [salt.state       ][INFO    ][2716] Running state [/etc/apt/preferences.d/mirantis_openstack] at time 00:28:39.042919
2018-01-14 00:28:39,043 [salt.state       ][INFO    ][2716] Executing state file.managed for /etc/apt/preferences.d/mirantis_openstack
2018-01-14 00:28:39,113 [salt.state       ][INFO    ][2716] File changed:
New file
2018-01-14 00:28:39,113 [salt.state       ][INFO    ][2716] Completed state [/etc/apt/preferences.d/mirantis_openstack] at time 00:28:39.113537 duration_in_ms=70.618
2018-01-14 00:28:39,114 [salt.state       ][INFO    ][2716] Running state [deb http://mirror.fuel-infra.org/mcp-repos/pike/xenial pike main] at time 00:28:39.114505
2018-01-14 00:28:39,114 [salt.state       ][INFO    ][2716] Executing state pkgrepo.managed for deb http://mirror.fuel-infra.org/mcp-repos/pike/xenial pike main
2018-01-14 00:28:39,158 [salt.loaded.int.module.cmdmod][INFO    ][2716] Executing command ['apt-key', 'add', '/var/cache/salt/minion/extrn_files/base/mirror.fuel-infra.org/mcp-repos/pike/xenial/archive-mcppike.key'] in directory '/root'
2018-01-14 00:28:39,317 [salt.loaded.int.module.cmdmod][INFO    ][2716] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2018-01-14 00:28:43,446 [salt.state       ][INFO    ][2716] {'repo': 'deb http://mirror.fuel-infra.org/mcp-repos/pike/xenial pike main'}
2018-01-14 00:28:43,446 [salt.state       ][INFO    ][2716] Completed state [deb http://mirror.fuel-infra.org/mcp-repos/pike/xenial pike main] at time 00:28:43.446821 duration_in_ms=4332.316
2018-01-14 00:28:43,447 [salt.state       ][INFO    ][2716] Running state [/etc/apt/apt.conf.d/99proxies-salt-uca] at time 00:28:43.447282
2018-01-14 00:28:43,447 [salt.state       ][INFO    ][2716] Executing state file.absent for /etc/apt/apt.conf.d/99proxies-salt-uca
2018-01-14 00:28:43,448 [salt.state       ][INFO    ][2716] File /etc/apt/apt.conf.d/99proxies-salt-uca is not present
2018-01-14 00:28:43,448 [salt.state       ][INFO    ][2716] Completed state [/etc/apt/apt.conf.d/99proxies-salt-uca] at time 00:28:43.448580 duration_in_ms=1.298
2018-01-14 00:28:43,448 [salt.state       ][INFO    ][2716] Running state [/etc/apt/preferences.d/uca] at time 00:28:43.448931
2018-01-14 00:28:43,449 [salt.state       ][INFO    ][2716] Executing state file.absent for /etc/apt/preferences.d/uca
2018-01-14 00:28:43,449 [salt.state       ][INFO    ][2716] File /etc/apt/preferences.d/uca is not present
2018-01-14 00:28:43,450 [salt.state       ][INFO    ][2716] Completed state [/etc/apt/preferences.d/uca] at time 00:28:43.450002 duration_in_ms=1.071
2018-01-14 00:28:43,450 [salt.state       ][INFO    ][2716] Running state [deb http://ubuntu-cloud.archive.canonical.com/ubuntu xenial-updates/pike main] at time 00:28:43.450945
2018-01-14 00:28:43,451 [salt.state       ][INFO    ][2716] Executing state pkgrepo.managed for deb http://ubuntu-cloud.archive.canonical.com/ubuntu xenial-updates/pike main
2018-01-14 00:28:43,539 [salt.loaded.int.module.cmdmod][INFO    ][2716] Executing command ['apt-key', 'export', 'EC4926EA'] in directory '/root'
2018-01-14 00:28:43,650 [salt.loaded.int.module.cmdmod][INFO    ][2716] Executing command ['apt-key', 'adv', '--keyserver-options', 'http-proxy=http://192.168.11.3:8000', '--keyserver', 'keyserver.ubuntu.com', '--logger-fd', '1', '--recv-keys', 'EC4926EA'] in directory '/root'
2018-01-14 00:28:43,984 [salt.loaded.int.module.cmdmod][INFO    ][2716] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2018-01-14 00:28:48,226 [salt.state       ][INFO    ][2716] {'repo': 'deb http://ubuntu-cloud.archive.canonical.com/ubuntu xenial-updates/pike main'}
2018-01-14 00:28:48,298 [salt.state       ][INFO    ][2716] Completed state [deb http://ubuntu-cloud.archive.canonical.com/ubuntu xenial-updates/pike main] at time 00:28:48.298557 duration_in_ms=4847.61
2018-01-14 00:28:48,299 [salt.state       ][INFO    ][2716] Running state [linux_extra_packages_purged] at time 00:28:48.299494
2018-01-14 00:28:48,300 [salt.state       ][INFO    ][2716] Executing state pkg.purged for linux_extra_packages_purged
2018-01-14 00:28:48,325 [salt.loaded.int.module.cmdmod][INFO    ][2716] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', 'purge', 'cloud-init', 'unattended-upgrades'] in directory '/root'
2018-01-14 00:28:48,626 [salt.minion      ][INFO    ][2613] User sudo_ubuntu Executing command saltutil.find_job with jid 20180114002847656130
2018-01-14 00:28:48,643 [salt.minion      ][INFO    ][4274] Starting a new job with PID 4274
2018-01-14 00:28:48,669 [salt.minion      ][INFO    ][4274] Returning information for job: 20180114002847656130
2018-01-14 00:28:58,729 [salt.minion      ][INFO    ][2613] User sudo_ubuntu Executing command saltutil.find_job with jid 20180114002857757486
2018-01-14 00:28:58,751 [salt.minion      ][INFO    ][4939] Starting a new job with PID 4939
2018-01-14 00:28:58,781 [salt.minion      ][INFO    ][4939] Returning information for job: 20180114002857757486
2018-01-14 00:28:59,739 [salt.loaded.int.module.cmdmod][INFO    ][2716] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2018-01-14 00:28:59,791 [salt.state       ][INFO    ][2716] {'removed': {}, 'installed': {'cloud-init': {'new': '', 'old': '17.1-46-g7acc9e68-0ubuntu1~16.04.1'}, 'ec2-init': {'new': '', 'old': '1'}, 'unattended-upgrades': {'new': '', 'old': '0.90ubuntu0.9'}}}
2018-01-14 00:28:59,827 [salt.state       ][INFO    ][2716] Loading fresh modules for state activity
2018-01-14 00:28:59,864 [salt.state       ][INFO    ][2716] Completed state [linux_extra_packages_purged] at time 00:28:59.864740 duration_in_ms=11565.245
2018-01-14 00:28:59,878 [salt.state       ][INFO    ][2716] Running state [linux_extra_packages_latest] at time 00:28:59.877980
2018-01-14 00:28:59,878 [salt.state       ][INFO    ][2716] Executing state pkg.latest for linux_extra_packages_latest
2018-01-14 00:29:00,231 [salt.loaded.int.module.cmdmod][INFO    ][2716] Executing command ['apt-cache', '-q', 'policy', 'mcelog'] in directory '/root'
2018-01-14 00:29:00,302 [salt.loaded.int.module.cmdmod][INFO    ][2716] Executing command ['dpkg', '--get-selections', '*'] in directory '/root'
2018-01-14 00:29:00,330 [salt.loaded.int.module.cmdmod][INFO    ][2716] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'mcelog'] in directory '/root'
2018-01-14 00:29:08,850 [salt.loaded.int.module.cmdmod][INFO    ][2716] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2018-01-14 00:29:08,884 [salt.state       ][INFO    ][2716] Made the following changes:
'mcelog' changed from 'absent' to '128+dfsg-1'

2018-01-14 00:29:08,899 [salt.state       ][INFO    ][2716] Loading fresh modules for state activity
2018-01-14 00:29:08,920 [salt.state       ][INFO    ][2716] Completed state [linux_extra_packages_latest] at time 00:29:08.920159 duration_in_ms=9042.178
2018-01-14 00:29:08,941 [salt.state       ][INFO    ][2716] Running state [UTC] at time 00:29:08.941194
2018-01-14 00:29:08,942 [salt.state       ][INFO    ][2716] Executing state timezone.system for UTC
2018-01-14 00:29:08,945 [salt.loaded.int.module.cmdmod][INFO    ][2716] Executing command ['timedatectl'] in directory '/root'
2018-01-14 00:29:09,132 [salt.loaded.int.module.cmdmod][INFO    ][2716] Executing command ['timedatectl'] in directory '/root'
2018-01-14 00:29:09,151 [salt.loaded.int.module.cmdmod][INFO    ][2716] Executing command 'timedatectl set-timezone UTC' in directory '/root'
2018-01-14 00:29:09,265 [salt.state       ][INFO    ][2716] {'timezone': 'UTC'}
2018-01-14 00:29:09,266 [salt.state       ][INFO    ][2716] Completed state [UTC] at time 00:29:09.266432 duration_in_ms=325.238
2018-01-14 00:29:09,358 [salt.minion      ][INFO    ][2613] User sudo_ubuntu Executing command saltutil.find_job with jid 20180114002907958464
2018-01-14 00:29:09,372 [salt.minion      ][INFO    ][5538] Starting a new job with PID 5538
2018-01-14 00:29:09,376 [salt.state       ][INFO    ][2716] Running state [nf_conntrack] at time 00:29:09.376636
2018-01-14 00:29:09,377 [salt.state       ][INFO    ][2716] Executing state kmod.present for nf_conntrack
2018-01-14 00:29:09,378 [salt.loaded.int.module.cmdmod][INFO    ][2716] Executing command 'lsmod' in directory '/root'
2018-01-14 00:29:09,396 [salt.minion      ][INFO    ][5538] Returning information for job: 20180114002907958464
2018-01-14 00:29:11,290 [salt.loaded.int.module.cmdmod][INFO    ][2716] Executing command 'lsmod' in directory '/root'
2018-01-14 00:29:11,321 [salt.loaded.int.module.cmdmod][INFO    ][2716] Executing command 'modprobe nf_conntrack' in directory '/root'
2018-01-14 00:29:11,414 [salt.loaded.int.module.cmdmod][INFO    ][2716] Executing command 'lsmod' in directory '/root'
2018-01-14 00:29:11,548 [salt.state       ][INFO    ][2716] {'nf_conntrack': 'loaded'}
2018-01-14 00:29:11,549 [salt.state       ][INFO    ][2716] Completed state [nf_conntrack] at time 00:29:11.549041 duration_in_ms=2172.404
2018-01-14 00:29:11,619 [salt.state       ][INFO    ][2716] Running state [kernel.panic] at time 00:29:11.619336
2018-01-14 00:29:11,620 [salt.state       ][INFO    ][2716] Executing state sysctl.present for kernel.panic
2018-01-14 00:29:11,621 [salt.loaded.int.module.cmdmod][INFO    ][2716] Executing command 'sysctl -a' in directory '/root'
2018-01-14 00:29:12,000 [salt.loaded.int.module.cmdmod][INFO    ][2716] Executing command 'sysctl -w kernel.panic="60"' in directory '/root'
2018-01-14 00:29:12,019 [salt.state       ][INFO    ][2716] {'kernel.panic': 60}
2018-01-14 00:29:12,020 [salt.state       ][INFO    ][2716] Completed state [kernel.panic] at time 00:29:12.020403 duration_in_ms=401.066
2018-01-14 00:29:12,021 [salt.state       ][INFO    ][2716] Running state [net.ipv4.tcp_keepalive_probes] at time 00:29:12.021010
2018-01-14 00:29:12,021 [salt.state       ][INFO    ][2716] Executing state sysctl.present for net.ipv4.tcp_keepalive_probes
2018-01-14 00:29:12,022 [salt.loaded.int.module.cmdmod][INFO    ][2716] Executing command 'sysctl -a' in directory '/root'
2018-01-14 00:29:12,109 [salt.loaded.int.module.cmdmod][INFO    ][2716] Executing command 'sysctl -w net.ipv4.tcp_keepalive_probes="8"' in directory '/root'
2018-01-14 00:29:12,131 [salt.state       ][INFO    ][2716] {'net.ipv4.tcp_keepalive_probes': 8}
2018-01-14 00:29:12,132 [salt.state       ][INFO    ][2716] Completed state [net.ipv4.tcp_keepalive_probes] at time 00:29:12.131923 duration_in_ms=110.911
2018-01-14 00:29:12,132 [salt.state       ][INFO    ][2716] Running state [fs.file-max] at time 00:29:12.132873
2018-01-14 00:29:12,133 [salt.state       ][INFO    ][2716] Executing state sysctl.present for fs.file-max
2018-01-14 00:29:12,135 [salt.loaded.int.module.cmdmod][INFO    ][2716] Executing command 'sysctl -a' in directory '/root'
2018-01-14 00:29:12,183 [salt.loaded.int.module.cmdmod][INFO    ][2716] Executing command 'sysctl -w fs.file-max="124165"' in directory '/root'
2018-01-14 00:29:12,200 [salt.state       ][INFO    ][2716] {'fs.file-max': 124165}
2018-01-14 00:29:12,200 [salt.state       ][INFO    ][2716] Completed state [fs.file-max] at time 00:29:12.200816 duration_in_ms=67.943
2018-01-14 00:29:12,201 [salt.state       ][INFO    ][2716] Running state [net.core.somaxconn] at time 00:29:12.201599
2018-01-14 00:29:12,202 [salt.state       ][INFO    ][2716] Executing state sysctl.present for net.core.somaxconn
2018-01-14 00:29:12,203 [salt.loaded.int.module.cmdmod][INFO    ][2716] Executing command 'sysctl -a' in directory '/root'
2018-01-14 00:29:12,246 [salt.loaded.int.module.cmdmod][INFO    ][2716] Executing command 'sysctl -w net.core.somaxconn="4096"' in directory '/root'
2018-01-14 00:29:12,268 [salt.state       ][INFO    ][2716] {'net.core.somaxconn': 4096}
2018-01-14 00:29:12,269 [salt.state       ][INFO    ][2716] Completed state [net.core.somaxconn] at time 00:29:12.268931 duration_in_ms=67.332
2018-01-14 00:29:12,269 [salt.state       ][INFO    ][2716] Running state [net.ipv4.tcp_max_syn_backlog] at time 00:29:12.269548
2018-01-14 00:29:12,270 [salt.state       ][INFO    ][2716] Executing state sysctl.present for net.ipv4.tcp_max_syn_backlog
2018-01-14 00:29:12,271 [salt.loaded.int.module.cmdmod][INFO    ][2716] Executing command 'sysctl -a' in directory '/root'
2018-01-14 00:29:12,298 [salt.loaded.int.module.cmdmod][INFO    ][2716] Executing command 'sysctl -w net.ipv4.tcp_max_syn_backlog="8192"' in directory '/root'
2018-01-14 00:29:12,318 [salt.state       ][INFO    ][2716] {'net.ipv4.tcp_max_syn_backlog': 8192}
2018-01-14 00:29:12,318 [salt.state       ][INFO    ][2716] Completed state [net.ipv4.tcp_max_syn_backlog] at time 00:29:12.318879 duration_in_ms=49.331
2018-01-14 00:29:12,319 [salt.state       ][INFO    ][2716] Running state [net.ipv4.tcp_tw_reuse] at time 00:29:12.319445
2018-01-14 00:29:12,319 [salt.state       ][INFO    ][2716] Executing state sysctl.present for net.ipv4.tcp_tw_reuse
2018-01-14 00:29:12,320 [salt.loaded.int.module.cmdmod][INFO    ][2716] Executing command 'sysctl -a' in directory '/root'
2018-01-14 00:29:12,379 [salt.loaded.int.module.cmdmod][INFO    ][2716] Executing command 'sysctl -w net.ipv4.tcp_tw_reuse="1"' in directory '/root'
2018-01-14 00:29:12,400 [salt.state       ][INFO    ][2716] {'net.ipv4.tcp_tw_reuse': 1}
2018-01-14 00:29:12,401 [salt.state       ][INFO    ][2716] Completed state [net.ipv4.tcp_tw_reuse] at time 00:29:12.401110 duration_in_ms=81.665
2018-01-14 00:29:12,401 [salt.state       ][INFO    ][2716] Running state [net.ipv4.tcp_congestion_control] at time 00:29:12.401844
2018-01-14 00:29:12,402 [salt.state       ][INFO    ][2716] Executing state sysctl.present for net.ipv4.tcp_congestion_control
2018-01-14 00:29:12,403 [salt.loaded.int.module.cmdmod][INFO    ][2716] Executing command 'sysctl -a' in directory '/root'
2018-01-14 00:29:12,448 [salt.loaded.int.module.cmdmod][INFO    ][2716] Executing command 'sysctl -w net.ipv4.tcp_congestion_control="yeah"' in directory '/root'
2018-01-14 00:29:12,558 [salt.state       ][INFO    ][2716] {'net.ipv4.tcp_congestion_control': 'yeah'}
2018-01-14 00:29:12,559 [salt.state       ][INFO    ][2716] Completed state [net.ipv4.tcp_congestion_control] at time 00:29:12.559345 duration_in_ms=157.5
2018-01-14 00:29:12,560 [salt.state       ][INFO    ][2716] Running state [net.ipv4.tcp_retries2] at time 00:29:12.560433
2018-01-14 00:29:12,561 [salt.state       ][INFO    ][2716] Executing state sysctl.present for net.ipv4.tcp_retries2
2018-01-14 00:29:12,563 [salt.loaded.int.module.cmdmod][INFO    ][2716] Executing command 'sysctl -a' in directory '/root'
2018-01-14 00:29:12,609 [salt.loaded.int.module.cmdmod][INFO    ][2716] Executing command 'sysctl -w net.ipv4.tcp_retries2="5"' in directory '/root'
2018-01-14 00:29:12,626 [salt.state       ][INFO    ][2716] {'net.ipv4.tcp_retries2': 5}
2018-01-14 00:29:12,627 [salt.state       ][INFO    ][2716] Completed state [net.ipv4.tcp_retries2] at time 00:29:12.627406 duration_in_ms=66.973
2018-01-14 00:29:12,628 [salt.state       ][INFO    ][2716] Running state [net.core.netdev_max_backlog] at time 00:29:12.627970
2018-01-14 00:29:12,628 [salt.state       ][INFO    ][2716] Executing state sysctl.present for net.core.netdev_max_backlog
2018-01-14 00:29:12,629 [salt.loaded.int.module.cmdmod][INFO    ][2716] Executing command 'sysctl -a' in directory '/root'
2018-01-14 00:29:12,738 [salt.loaded.int.module.cmdmod][INFO    ][2716] Executing command 'sysctl -w net.core.netdev_max_backlog="261144"' in directory '/root'
2018-01-14 00:29:12,762 [salt.state       ][INFO    ][2716] {'net.core.netdev_max_backlog': 261144}
2018-01-14 00:29:12,763 [salt.state       ][INFO    ][2716] Completed state [net.core.netdev_max_backlog] at time 00:29:12.762920 duration_in_ms=134.948
2018-01-14 00:29:12,763 [salt.state       ][INFO    ][2716] Running state [net.ipv4.tcp_slow_start_after_idle] at time 00:29:12.763698
2018-01-14 00:29:12,764 [salt.state       ][INFO    ][2716] Executing state sysctl.present for net.ipv4.tcp_slow_start_after_idle
2018-01-14 00:29:12,765 [salt.loaded.int.module.cmdmod][INFO    ][2716] Executing command 'sysctl -a' in directory '/root'
2018-01-14 00:29:12,910 [salt.loaded.int.module.cmdmod][INFO    ][2716] Executing command 'sysctl -w net.ipv4.tcp_slow_start_after_idle="0"' in directory '/root'
2018-01-14 00:29:12,936 [salt.state       ][INFO    ][2716] {'net.ipv4.tcp_slow_start_after_idle': 0}
2018-01-14 00:29:12,936 [salt.state       ][INFO    ][2716] Completed state [net.ipv4.tcp_slow_start_after_idle] at time 00:29:12.936813 duration_in_ms=173.114
2018-01-14 00:29:12,937 [salt.state       ][INFO    ][2716] Running state [vm.swappiness] at time 00:29:12.937691
2018-01-14 00:29:12,938 [salt.state       ][INFO    ][2716] Executing state sysctl.present for vm.swappiness
2018-01-14 00:29:12,940 [salt.loaded.int.module.cmdmod][INFO    ][2716] Executing command 'sysctl -a' in directory '/root'
2018-01-14 00:29:12,990 [salt.loaded.int.module.cmdmod][INFO    ][2716] Executing command 'sysctl -w vm.swappiness="10"' in directory '/root'
2018-01-14 00:29:13,012 [salt.state       ][INFO    ][2716] {'vm.swappiness': 10}
2018-01-14 00:29:13,013 [salt.state       ][INFO    ][2716] Completed state [vm.swappiness] at time 00:29:13.013313 duration_in_ms=75.622
2018-01-14 00:29:13,014 [salt.state       ][INFO    ][2716] Running state [net.ipv4.tcp_keepalive_intvl] at time 00:29:13.014094
2018-01-14 00:29:13,014 [salt.state       ][INFO    ][2716] Executing state sysctl.present for net.ipv4.tcp_keepalive_intvl
2018-01-14 00:29:13,016 [salt.loaded.int.module.cmdmod][INFO    ][2716] Executing command 'sysctl -a' in directory '/root'
2018-01-14 00:29:13,091 [salt.loaded.int.module.cmdmod][INFO    ][2716] Executing command 'sysctl -w net.ipv4.tcp_keepalive_intvl="3"' in directory '/root'
2018-01-14 00:29:13,115 [salt.state       ][INFO    ][2716] {'net.ipv4.tcp_keepalive_intvl': 3}
2018-01-14 00:29:13,116 [salt.state       ][INFO    ][2716] Completed state [net.ipv4.tcp_keepalive_intvl] at time 00:29:13.116147 duration_in_ms=102.052
2018-01-14 00:29:13,116 [salt.state       ][INFO    ][2716] Running state [net.ipv4.neigh.default.gc_thresh1] at time 00:29:13.116877
2018-01-14 00:29:13,117 [salt.state       ][INFO    ][2716] Executing state sysctl.present for net.ipv4.neigh.default.gc_thresh1
2018-01-14 00:29:13,118 [salt.loaded.int.module.cmdmod][INFO    ][2716] Executing command 'sysctl -a' in directory '/root'
2018-01-14 00:29:13,170 [salt.loaded.int.module.cmdmod][INFO    ][2716] Executing command 'sysctl -w net.ipv4.neigh.default.gc_thresh1="4096"' in directory '/root'
2018-01-14 00:29:13,189 [salt.state       ][INFO    ][2716] {'net.ipv4.neigh.default.gc_thresh1': 4096}
2018-01-14 00:29:13,190 [salt.state       ][INFO    ][2716] Completed state [net.ipv4.neigh.default.gc_thresh1] at time 00:29:13.190115 duration_in_ms=73.238
2018-01-14 00:29:13,190 [salt.state       ][INFO    ][2716] Running state [net.ipv4.neigh.default.gc_thresh2] at time 00:29:13.190807
2018-01-14 00:29:13,191 [salt.state       ][INFO    ][2716] Executing state sysctl.present for net.ipv4.neigh.default.gc_thresh2
2018-01-14 00:29:13,192 [salt.loaded.int.module.cmdmod][INFO    ][2716] Executing command 'sysctl -a' in directory '/root'
2018-01-14 00:29:13,236 [salt.loaded.int.module.cmdmod][INFO    ][2716] Executing command 'sysctl -w net.ipv4.neigh.default.gc_thresh2="8192"' in directory '/root'
2018-01-14 00:29:13,251 [salt.state       ][INFO    ][2716] {'net.ipv4.neigh.default.gc_thresh2': 8192}
2018-01-14 00:29:13,252 [salt.state       ][INFO    ][2716] Completed state [net.ipv4.neigh.default.gc_thresh2] at time 00:29:13.251909 duration_in_ms=61.102
2018-01-14 00:29:13,252 [salt.state       ][INFO    ][2716] Running state [net.ipv4.neigh.default.gc_thresh3] at time 00:29:13.252446
2018-01-14 00:29:13,252 [salt.state       ][INFO    ][2716] Executing state sysctl.present for net.ipv4.neigh.default.gc_thresh3
2018-01-14 00:29:13,253 [salt.loaded.int.module.cmdmod][INFO    ][2716] Executing command 'sysctl -a' in directory '/root'
2018-01-14 00:29:13,308 [salt.loaded.int.module.cmdmod][INFO    ][2716] Executing command 'sysctl -w net.ipv4.neigh.default.gc_thresh3="16384"' in directory '/root'
2018-01-14 00:29:13,328 [salt.state       ][INFO    ][2716] {'net.ipv4.neigh.default.gc_thresh3': 16384}
2018-01-14 00:29:13,329 [salt.state       ][INFO    ][2716] Completed state [net.ipv4.neigh.default.gc_thresh3] at time 00:29:13.328959 duration_in_ms=76.513
2018-01-14 00:29:13,329 [salt.state       ][INFO    ][2716] Running state [net.ipv4.tcp_fin_timeout] at time 00:29:13.329386
2018-01-14 00:29:13,329 [salt.state       ][INFO    ][2716] Executing state sysctl.present for net.ipv4.tcp_fin_timeout
2018-01-14 00:29:13,330 [salt.loaded.int.module.cmdmod][INFO    ][2716] Executing command 'sysctl -a' in directory '/root'
2018-01-14 00:29:13,371 [salt.loaded.int.module.cmdmod][INFO    ][2716] Executing command 'sysctl -w net.ipv4.tcp_fin_timeout="30"' in directory '/root'
2018-01-14 00:29:13,386 [salt.state       ][INFO    ][2716] {'net.ipv4.tcp_fin_timeout': 30}
2018-01-14 00:29:13,387 [salt.state       ][INFO    ][2716] Completed state [net.ipv4.tcp_fin_timeout] at time 00:29:13.387150 duration_in_ms=57.763
2018-01-14 00:29:13,387 [salt.state       ][INFO    ][2716] Running state [net.ipv4.tcp_keepalive_time] at time 00:29:13.387533
2018-01-14 00:29:13,387 [salt.state       ][INFO    ][2716] Executing state sysctl.present for net.ipv4.tcp_keepalive_time
2018-01-14 00:29:13,388 [salt.loaded.int.module.cmdmod][INFO    ][2716] Executing command 'sysctl -a' in directory '/root'
2018-01-14 00:29:13,415 [salt.loaded.int.module.cmdmod][INFO    ][2716] Executing command 'sysctl -w net.ipv4.tcp_keepalive_time="30"' in directory '/root'
2018-01-14 00:29:13,425 [salt.state       ][INFO    ][2716] {'net.ipv4.tcp_keepalive_time': 30}
2018-01-14 00:29:13,426 [salt.state       ][INFO    ][2716] Completed state [net.ipv4.tcp_keepalive_time] at time 00:29:13.426182 duration_in_ms=38.648
2018-01-14 00:29:13,426 [salt.state       ][INFO    ][2716] Running state [net.nf_conntrack_max] at time 00:29:13.426592
2018-01-14 00:29:13,426 [salt.state       ][INFO    ][2716] Executing state sysctl.present for net.nf_conntrack_max
2018-01-14 00:29:13,427 [salt.loaded.int.module.cmdmod][INFO    ][2716] Executing command 'sysctl -a' in directory '/root'
2018-01-14 00:29:13,452 [salt.loaded.int.module.cmdmod][INFO    ][2716] Executing command 'sysctl -w net.nf_conntrack_max="1048576"' in directory '/root'
2018-01-14 00:29:13,464 [salt.state       ][INFO    ][2716] {'net.nf_conntrack_max': 1048576}
2018-01-14 00:29:13,464 [salt.state       ][INFO    ][2716] Completed state [net.nf_conntrack_max] at time 00:29:13.464763 duration_in_ms=38.171
2018-01-14 00:29:13,471 [salt.state       ][INFO    ][2716] Running state [linux_sysfs_package] at time 00:29:13.471506
2018-01-14 00:29:13,471 [salt.state       ][INFO    ][2716] Executing state pkg.installed for linux_sysfs_package
2018-01-14 00:29:13,785 [salt.loaded.int.module.cmdmod][INFO    ][2716] Executing command ['apt-cache', '-q', 'policy', 'sysfsutils'] in directory '/root'
2018-01-14 00:29:13,869 [salt.loaded.int.module.cmdmod][INFO    ][2716] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2018-01-14 00:29:16,155 [salt.loaded.int.module.cmdmod][INFO    ][2716] Executing command ['dpkg', '--get-selections', '*'] in directory '/root'
2018-01-14 00:29:16,174 [salt.loaded.int.module.cmdmod][INFO    ][2716] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'sysfsutils'] in directory '/root'
2018-01-14 00:29:19,148 [salt.minion      ][INFO    ][2613] User sudo_ubuntu Executing command saltutil.find_job with jid 20180114002918176806
2018-01-14 00:29:19,178 [salt.minion      ][INFO    ][6063] Starting a new job with PID 6063
2018-01-14 00:29:19,206 [salt.minion      ][INFO    ][6063] Returning information for job: 20180114002918176806
2018-01-14 00:29:26,346 [salt.loaded.int.module.cmdmod][INFO    ][2716] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2018-01-14 00:29:26,386 [salt.state       ][INFO    ][2716] Made the following changes:
'libsysfs2' changed from 'absent' to '2.1.0+repack-4'
'sysfsutils' changed from 'absent' to '2.1.0+repack-4'

2018-01-14 00:29:26,404 [salt.state       ][INFO    ][2716] Loading fresh modules for state activity
2018-01-14 00:29:26,428 [salt.state       ][INFO    ][2716] Completed state [linux_sysfs_package] at time 00:29:26.428822 duration_in_ms=12957.315
2018-01-14 00:29:26,432 [salt.state       ][INFO    ][2716] Running state [/etc/sysfs.d] at time 00:29:26.432729
2018-01-14 00:29:26,433 [salt.state       ][INFO    ][2716] Executing state file.directory for /etc/sysfs.d
2018-01-14 00:29:26,439 [salt.state       ][INFO    ][2716] Directory /etc/sysfs.d is in the correct state
2018-01-14 00:29:26,439 [salt.state       ][INFO    ][2716] Completed state [/etc/sysfs.d] at time 00:29:26.439492 duration_in_ms=6.763
2018-01-14 00:29:26,682 [salt.state       ][INFO    ][2716] Running state [ondemand] at time 00:29:26.682712
2018-01-14 00:29:26,683 [salt.state       ][INFO    ][2716] Executing state service.dead for ondemand
2018-01-14 00:29:26,684 [salt.loaded.int.module.cmdmod][INFO    ][2716] Executing command ['systemctl', 'status', 'ondemand.service', '-n', '0'] in directory '/root'
2018-01-14 00:29:26,701 [salt.loaded.int.module.cmdmod][INFO    ][2716] Executing command ['systemctl', 'is-active', 'ondemand.service'] in directory '/root'
2018-01-14 00:29:26,715 [salt.loaded.int.module.cmdmod][INFO    ][2716] Executing command ['systemctl', 'is-enabled', 'ondemand.service'] in directory '/root'
2018-01-14 00:29:26,732 [salt.loaded.int.module.cmdmod][INFO    ][2716] Executing command ['systemd-run', '--scope', 'systemctl', 'stop', 'ondemand.service'] in directory '/root'
2018-01-14 00:29:26,778 [salt.loaded.int.module.cmdmod][INFO    ][2716] Executing command ['systemctl', 'is-active', 'ondemand.service'] in directory '/root'
2018-01-14 00:29:26,793 [salt.loaded.int.module.cmdmod][INFO    ][2716] Executing command ['systemctl', 'is-enabled', 'ondemand.service'] in directory '/root'
2018-01-14 00:29:26,808 [salt.loaded.int.module.cmdmod][INFO    ][2716] Executing command ['systemctl', 'is-enabled', 'ondemand.service'] in directory '/root'
2018-01-14 00:29:26,826 [salt.loaded.int.module.cmdmod][INFO    ][2716] Executing command ['systemd-run', '--scope', '/usr/sbin/update-rc.d', '-f', 'ondemand', 'remove'] in directory '/root'
2018-01-14 00:29:27,051 [salt.loaded.int.module.cmdmod][INFO    ][2716] Executing command ['systemctl', 'is-enabled', 'ondemand.service'] in directory '/root'
2018-01-14 00:29:27,080 [salt.loaded.int.module.cmdmod][INFO    ][2716] Executing command 'runlevel' in directory '/root'
2018-01-14 00:29:27,097 [salt.state       ][INFO    ][2716] {'ondemand': True}
2018-01-14 00:29:27,097 [salt.state       ][INFO    ][2716] Completed state [ondemand] at time 00:29:27.097855 duration_in_ms=415.143
2018-01-14 00:29:27,365 [salt.state       ][INFO    ][2716] Running state [cs_CZ.UTF-8] at time 00:29:27.365499
2018-01-14 00:29:27,366 [salt.state       ][INFO    ][2716] Executing state locale.present for cs_CZ.UTF-8
2018-01-14 00:29:27,367 [salt.loaded.int.module.cmdmod][INFO    ][2716] Executing command 'locale -a' in directory '/root'
2018-01-14 00:29:27,399 [salt.loaded.int.module.cmdmod][INFO    ][2716] Executing command ['locale-gen', 'cs_CZ.utf8'] in directory '/root'
2018-01-14 00:29:28,297 [salt.state       ][INFO    ][2716] {'locale': 'cs_CZ.UTF-8'}
2018-01-14 00:29:28,298 [salt.state       ][INFO    ][2716] Completed state [cs_CZ.UTF-8] at time 00:29:28.298682 duration_in_ms=933.181
2018-01-14 00:29:28,299 [salt.state       ][INFO    ][2716] Running state [en_US.UTF-8] at time 00:29:28.299813
2018-01-14 00:29:28,300 [salt.state       ][INFO    ][2716] Executing state locale.present for en_US.UTF-8
2018-01-14 00:29:28,302 [salt.loaded.int.module.cmdmod][INFO    ][2716] Executing command 'locale -a' in directory '/root'
2018-01-14 00:29:28,325 [salt.state       ][INFO    ][2716] Locale en_US.UTF-8 is already present
2018-01-14 00:29:28,326 [salt.state       ][INFO    ][2716] Completed state [en_US.UTF-8] at time 00:29:28.325949 duration_in_ms=26.136
2018-01-14 00:29:28,329 [salt.state       ][INFO    ][2716] Running state [en_US.UTF-8] at time 00:29:28.329061
2018-01-14 00:29:28,329 [salt.state       ][INFO    ][2716] Executing state locale.system for en_US.UTF-8
2018-01-14 00:29:28,331 [salt.loaded.int.module.cmdmod][INFO    ][2716] Executing command 'localectl' in directory '/root'
2018-01-14 00:29:28,830 [salt.state       ][INFO    ][2716] System locale en_US.UTF-8 already set
2018-01-14 00:29:28,830 [salt.state       ][INFO    ][2716] Completed state [en_US.UTF-8] at time 00:29:28.830827 duration_in_ms=501.765
2018-01-14 00:29:28,838 [salt.state       ][INFO    ][2716] Running state [root] at time 00:29:28.838430
2018-01-14 00:29:28,838 [salt.state       ][INFO    ][2716] Executing state user.present for root
2018-01-14 00:29:28,845 [salt.state       ][INFO    ][2716] User root is present and up to date
2018-01-14 00:29:28,845 [salt.state       ][INFO    ][2716] Completed state [root] at time 00:29:28.845645 duration_in_ms=7.216
2018-01-14 00:29:28,847 [salt.state       ][INFO    ][2716] Running state [/root] at time 00:29:28.847011
2018-01-14 00:29:28,847 [salt.state       ][INFO    ][2716] Executing state file.directory for /root
2018-01-14 00:29:28,848 [salt.state       ][INFO    ][2716] Directory /root is in the correct state
2018-01-14 00:29:28,848 [salt.state       ][INFO    ][2716] Completed state [/root] at time 00:29:28.848308 duration_in_ms=1.297
2018-01-14 00:29:28,848 [salt.state       ][INFO    ][2716] Running state [/etc/sudoers.d/90-salt-user-root] at time 00:29:28.848545
2018-01-14 00:29:28,848 [salt.state       ][INFO    ][2716] Executing state file.absent for /etc/sudoers.d/90-salt-user-root
2018-01-14 00:29:28,849 [salt.state       ][INFO    ][2716] File /etc/sudoers.d/90-salt-user-root is not present
2018-01-14 00:29:28,849 [salt.state       ][INFO    ][2716] Completed state [/etc/sudoers.d/90-salt-user-root] at time 00:29:28.849288 duration_in_ms=0.743
2018-01-14 00:29:28,849 [salt.state       ][INFO    ][2716] Running state [ubuntu] at time 00:29:28.849520
2018-01-14 00:29:28,849 [salt.state       ][INFO    ][2716] Executing state user.present for ubuntu
2018-01-14 00:29:28,852 [salt.state       ][INFO    ][2716] {'passwd': 'XXX-REDACTED-XXX'}
2018-01-14 00:29:28,853 [salt.state       ][INFO    ][2716] Completed state [ubuntu] at time 00:29:28.853171 duration_in_ms=3.651
2018-01-14 00:29:28,854 [salt.state       ][INFO    ][2716] Running state [/home/ubuntu] at time 00:29:28.854089
2018-01-14 00:29:28,854 [salt.state       ][INFO    ][2716] Executing state file.directory for /home/ubuntu
2018-01-14 00:29:28,855 [salt.state       ][INFO    ][2716] {'mode': '0700'}
2018-01-14 00:29:28,855 [salt.state       ][INFO    ][2716] Completed state [/home/ubuntu] at time 00:29:28.855511 duration_in_ms=1.422
2018-01-14 00:29:28,856 [salt.state       ][INFO    ][2716] Running state [/etc/sudoers.d/90-salt-user-ubuntu] at time 00:29:28.856208
2018-01-14 00:29:28,856 [salt.state       ][INFO    ][2716] Executing state file.managed for /etc/sudoers.d/90-salt-user-ubuntu
2018-01-14 00:29:28,880 [salt.fileclient  ][INFO    ][2716] Fetching file from saltenv 'base', ** done ** 'linux/files/sudoer'
2018-01-14 00:29:28,885 [salt.loaded.int.module.cmdmod][INFO    ][2716] Executing command '/usr/sbin/visudo -c -f /tmp/tmpgex5nL' in directory '/root'
2018-01-14 00:29:29,032 [salt.state       ][INFO    ][2716] File changed:
New file
2018-01-14 00:29:29,033 [salt.state       ][INFO    ][2716] Completed state [/etc/sudoers.d/90-salt-user-ubuntu] at time 00:29:29.033260 duration_in_ms=177.051
2018-01-14 00:29:29,033 [salt.state       ][INFO    ][2716] Running state [/etc/security/limits.d/90-salt-default.conf] at time 00:29:29.033780
2018-01-14 00:29:29,034 [salt.state       ][INFO    ][2716] Executing state file.managed for /etc/security/limits.d/90-salt-default.conf
2018-01-14 00:29:29,065 [salt.fileclient  ][INFO    ][2716] Fetching file from saltenv 'base', ** done ** 'linux/files/limits.conf'
2018-01-14 00:29:29,139 [salt.state       ][INFO    ][2716] File changed:
New file
2018-01-14 00:29:29,139 [salt.state       ][INFO    ][2716] Completed state [/etc/security/limits.d/90-salt-default.conf] at time 00:29:29.139652 duration_in_ms=105.871
2018-01-14 00:29:29,140 [salt.state       ][INFO    ][2716] Running state [/etc/systemd/system.conf.d/90-salt.conf] at time 00:29:29.140022
2018-01-14 00:29:29,140 [salt.state       ][INFO    ][2716] Executing state file.managed for /etc/systemd/system.conf.d/90-salt.conf
2018-01-14 00:29:29,162 [salt.fileclient  ][INFO    ][2716] Fetching file from saltenv 'base', ** done ** 'linux/files/systemd.conf'
2018-01-14 00:29:29,196 [salt.minion      ][INFO    ][2613] User sudo_ubuntu Executing command saltutil.find_job with jid 20180114002928227660
2018-01-14 00:29:29,215 [salt.state       ][INFO    ][2716] File changed:
New file
2018-01-14 00:29:29,216 [salt.state       ][INFO    ][2716] Completed state [/etc/systemd/system.conf.d/90-salt.conf] at time 00:29:29.216102 duration_in_ms=76.079
2018-01-14 00:29:29,214 [salt.minion      ][INFO    ][6545] Starting a new job with PID 6545
2018-01-14 00:29:29,217 [salt.state       ][INFO    ][2716] Running state [service.systemctl_reload] at time 00:29:29.217396
2018-01-14 00:29:29,217 [salt.state       ][INFO    ][2716] Executing state module.wait for service.systemctl_reload
2018-01-14 00:29:29,217 [salt.state       ][INFO    ][2716] No changes made for service.systemctl_reload
2018-01-14 00:29:29,218 [salt.state       ][INFO    ][2716] Completed state [service.systemctl_reload] at time 00:29:29.217992 duration_in_ms=0.595
2018-01-14 00:29:29,218 [salt.state       ][INFO    ][2716] Running state [service.systemctl_reload] at time 00:29:29.218143
2018-01-14 00:29:29,218 [salt.state       ][INFO    ][2716] Executing state module.mod_watch for service.systemctl_reload
2018-01-14 00:29:29,218 [salt.loaded.int.module.cmdmod][INFO    ][2716] Executing command ['systemctl', '--system', 'daemon-reload'] in directory '/root'
2018-01-14 00:29:29,242 [salt.minion      ][INFO    ][6545] Returning information for job: 20180114002928227660
2018-01-14 00:29:29,344 [salt.state       ][INFO    ][2716] {'ret': True}
2018-01-14 00:29:29,345 [salt.state       ][INFO    ][2716] Completed state [service.systemctl_reload] at time 00:29:29.344922 duration_in_ms=126.778
2018-01-14 00:29:29,345 [salt.state       ][INFO    ][2716] Running state [/etc/hostname] at time 00:29:29.345583
2018-01-14 00:29:29,346 [salt.state       ][INFO    ][2716] Executing state file.managed for /etc/hostname
2018-01-14 00:29:29,367 [salt.fileclient  ][INFO    ][2716] Fetching file from saltenv 'base', ** done ** 'linux/files/hostname'
2018-01-14 00:29:29,372 [salt.state       ][INFO    ][2716] File changed:
--- 
+++ 
@@ -1 +1 @@
-ubuntu
+dbs02

2018-01-14 00:29:29,372 [salt.state       ][INFO    ][2716] Completed state [/etc/hostname] at time 00:29:29.372418 duration_in_ms=26.834
2018-01-14 00:29:29,375 [salt.state       ][INFO    ][2716] Running state [hostname dbs02] at time 00:29:29.375499
2018-01-14 00:29:29,375 [salt.state       ][INFO    ][2716] Executing state cmd.wait for hostname dbs02
2018-01-14 00:29:29,376 [salt.state       ][INFO    ][2716] No changes made for hostname dbs02
2018-01-14 00:29:29,376 [salt.state       ][INFO    ][2716] Completed state [hostname dbs02] at time 00:29:29.376561 duration_in_ms=1.062
2018-01-14 00:29:29,376 [salt.state       ][INFO    ][2716] Running state [hostname dbs02] at time 00:29:29.376856
2018-01-14 00:29:29,377 [salt.state       ][INFO    ][2716] Executing state cmd.mod_watch for hostname dbs02
2018-01-14 00:29:29,378 [salt.loaded.int.module.cmdmod][INFO    ][2716] Executing command 'hostname dbs02' in directory '/root'
2018-01-14 00:29:29,392 [salt.state       ][INFO    ][2716] {'pid': 6562, 'retcode': 0, 'stderr': '', 'stdout': ''}
2018-01-14 00:29:29,393 [salt.state       ][INFO    ][2716] Completed state [hostname dbs02] at time 00:29:29.393197 duration_in_ms=16.341
2018-01-14 00:29:29,409 [salt.state       ][INFO    ][2716] Running state [mdb02] at time 00:29:29.409305
2018-01-14 00:29:29,409 [salt.state       ][INFO    ][2716] Executing state host.present for mdb02
2018-01-14 00:29:29,412 [salt.state       ][INFO    ][2716] {'host': 'mdb02'}
2018-01-14 00:29:29,412 [salt.state       ][INFO    ][2716] Completed state [mdb02] at time 00:29:29.412551 duration_in_ms=3.245
2018-01-14 00:29:29,412 [salt.state       ][INFO    ][2716] Running state [mdb02.baremetal-mcp-pike-ovs-ha.local] at time 00:29:29.412880
2018-01-14 00:29:29,413 [salt.state       ][INFO    ][2716] Executing state host.present for mdb02.baremetal-mcp-pike-ovs-ha.local
2018-01-14 00:29:29,418 [salt.state       ][INFO    ][2716] {'host': 'mdb02.baremetal-mcp-pike-ovs-ha.local'}
2018-01-14 00:29:29,418 [salt.state       ][INFO    ][2716] Completed state [mdb02.baremetal-mcp-pike-ovs-ha.local] at time 00:29:29.418608 duration_in_ms=5.728
2018-01-14 00:29:29,418 [salt.state       ][INFO    ][2716] Running state [mdb03] at time 00:29:29.418935
2018-01-14 00:29:29,419 [salt.state       ][INFO    ][2716] Executing state host.present for mdb03
2018-01-14 00:29:29,422 [salt.state       ][INFO    ][2716] {'host': 'mdb03'}
2018-01-14 00:29:29,422 [salt.state       ][INFO    ][2716] Completed state [mdb03] at time 00:29:29.422632 duration_in_ms=3.697
2018-01-14 00:29:29,422 [salt.state       ][INFO    ][2716] Running state [mdb03.baremetal-mcp-pike-ovs-ha.local] at time 00:29:29.422938
2018-01-14 00:29:29,423 [salt.state       ][INFO    ][2716] Executing state host.present for mdb03.baremetal-mcp-pike-ovs-ha.local
2018-01-14 00:29:29,428 [salt.state       ][INFO    ][2716] {'host': 'mdb03.baremetal-mcp-pike-ovs-ha.local'}
2018-01-14 00:29:29,428 [salt.state       ][INFO    ][2716] Completed state [mdb03.baremetal-mcp-pike-ovs-ha.local] at time 00:29:29.428630 duration_in_ms=5.692
2018-01-14 00:29:29,428 [salt.state       ][INFO    ][2716] Running state [mdb01] at time 00:29:29.428946
2018-01-14 00:29:29,429 [salt.state       ][INFO    ][2716] Executing state host.present for mdb01
2018-01-14 00:29:29,434 [salt.state       ][INFO    ][2716] {'host': 'mdb01'}
2018-01-14 00:29:29,434 [salt.state       ][INFO    ][2716] Completed state [mdb01] at time 00:29:29.434619 duration_in_ms=5.673
2018-01-14 00:29:29,434 [salt.state       ][INFO    ][2716] Running state [mdb01.baremetal-mcp-pike-ovs-ha.local] at time 00:29:29.434918
2018-01-14 00:29:29,435 [salt.state       ][INFO    ][2716] Executing state host.present for mdb01.baremetal-mcp-pike-ovs-ha.local
2018-01-14 00:29:29,440 [salt.state       ][INFO    ][2716] {'host': 'mdb01.baremetal-mcp-pike-ovs-ha.local'}
2018-01-14 00:29:29,440 [salt.state       ][INFO    ][2716] Completed state [mdb01.baremetal-mcp-pike-ovs-ha.local] at time 00:29:29.440638 duration_in_ms=5.72
2018-01-14 00:29:29,440 [salt.state       ][INFO    ][2716] Running state [mdb] at time 00:29:29.440946
2018-01-14 00:29:29,441 [salt.state       ][INFO    ][2716] Executing state host.present for mdb
2018-01-14 00:29:29,446 [salt.state       ][INFO    ][2716] {'host': 'mdb'}
2018-01-14 00:29:29,446 [salt.state       ][INFO    ][2716] Completed state [mdb] at time 00:29:29.446654 duration_in_ms=5.708
2018-01-14 00:29:29,447 [salt.state       ][INFO    ][2716] Running state [mdb.baremetal-mcp-pike-ovs-ha.local] at time 00:29:29.446955
2018-01-14 00:29:29,447 [salt.state       ][INFO    ][2716] Executing state host.present for mdb.baremetal-mcp-pike-ovs-ha.local
2018-01-14 00:29:29,452 [salt.state       ][INFO    ][2716] {'host': 'mdb.baremetal-mcp-pike-ovs-ha.local'}
2018-01-14 00:29:29,452 [salt.state       ][INFO    ][2716] Completed state [mdb.baremetal-mcp-pike-ovs-ha.local] at time 00:29:29.452706 duration_in_ms=5.75
2018-01-14 00:29:29,453 [salt.state       ][INFO    ][2716] Running state [cfg01] at time 00:29:29.453024
2018-01-14 00:29:29,453 [salt.state       ][INFO    ][2716] Executing state host.present for cfg01
2018-01-14 00:29:29,458 [salt.state       ][INFO    ][2716] {'host': 'cfg01'}
2018-01-14 00:29:29,458 [salt.state       ][INFO    ][2716] Completed state [cfg01] at time 00:29:29.458753 duration_in_ms=5.729
2018-01-14 00:29:29,459 [salt.state       ][INFO    ][2716] Running state [cfg01.baremetal-mcp-pike-ovs-ha.local] at time 00:29:29.459071
2018-01-14 00:29:29,459 [salt.state       ][INFO    ][2716] Executing state host.present for cfg01.baremetal-mcp-pike-ovs-ha.local
2018-01-14 00:29:29,464 [salt.state       ][INFO    ][2716] {'host': 'cfg01.baremetal-mcp-pike-ovs-ha.local'}
2018-01-14 00:29:29,464 [salt.state       ][INFO    ][2716] Completed state [cfg01.baremetal-mcp-pike-ovs-ha.local] at time 00:29:29.464824 duration_in_ms=5.752
2018-01-14 00:29:29,465 [salt.state       ][INFO    ][2716] Running state [prx01] at time 00:29:29.465127
2018-01-14 00:29:29,465 [salt.state       ][INFO    ][2716] Executing state host.present for prx01
2018-01-14 00:29:29,470 [salt.state       ][INFO    ][2716] {'host': 'prx01'}
2018-01-14 00:29:29,470 [salt.state       ][INFO    ][2716] Completed state [prx01] at time 00:29:29.470734 duration_in_ms=5.607
2018-01-14 00:29:29,471 [salt.state       ][INFO    ][2716] Running state [prx01.baremetal-mcp-pike-ovs-ha.local] at time 00:29:29.471041
2018-01-14 00:29:29,471 [salt.state       ][INFO    ][2716] Executing state host.present for prx01.baremetal-mcp-pike-ovs-ha.local
2018-01-14 00:29:29,476 [salt.state       ][INFO    ][2716] {'host': 'prx01.baremetal-mcp-pike-ovs-ha.local'}
2018-01-14 00:29:29,476 [salt.state       ][INFO    ][2716] Completed state [prx01.baremetal-mcp-pike-ovs-ha.local] at time 00:29:29.476755 duration_in_ms=5.715
2018-01-14 00:29:29,477 [salt.state       ][INFO    ][2716] Running state [kvm01] at time 00:29:29.477064
2018-01-14 00:29:29,477 [salt.state       ][INFO    ][2716] Executing state host.present for kvm01
2018-01-14 00:29:29,488 [salt.state       ][INFO    ][2716] {'host': 'kvm01'}
2018-01-14 00:29:29,488 [salt.state       ][INFO    ][2716] Completed state [kvm01] at time 00:29:29.488791 duration_in_ms=11.727
2018-01-14 00:29:29,489 [salt.state       ][INFO    ][2716] Running state [kvm01.baremetal-mcp-pike-ovs-ha.local] at time 00:29:29.489104
2018-01-14 00:29:29,489 [salt.state       ][INFO    ][2716] Executing state host.present for kvm01.baremetal-mcp-pike-ovs-ha.local
2018-01-14 00:29:29,494 [salt.state       ][INFO    ][2716] {'host': 'kvm01.baremetal-mcp-pike-ovs-ha.local'}
2018-01-14 00:29:29,494 [salt.state       ][INFO    ][2716] Completed state [kvm01.baremetal-mcp-pike-ovs-ha.local] at time 00:29:29.494881 duration_in_ms=5.778
2018-01-14 00:29:29,495 [salt.state       ][INFO    ][2716] Running state [kvm03] at time 00:29:29.495196
2018-01-14 00:29:29,495 [salt.state       ][INFO    ][2716] Executing state host.present for kvm03
2018-01-14 00:29:29,500 [salt.state       ][INFO    ][2716] {'host': 'kvm03'}
2018-01-14 00:29:29,500 [salt.state       ][INFO    ][2716] Completed state [kvm03] at time 00:29:29.500907 duration_in_ms=5.711
2018-01-14 00:29:29,501 [salt.state       ][INFO    ][2716] Running state [kvm03.baremetal-mcp-pike-ovs-ha.local] at time 00:29:29.501210
2018-01-14 00:29:29,501 [salt.state       ][INFO    ][2716] Executing state host.present for kvm03.baremetal-mcp-pike-ovs-ha.local
2018-01-14 00:29:29,506 [salt.state       ][INFO    ][2716] {'host': 'kvm03.baremetal-mcp-pike-ovs-ha.local'}
2018-01-14 00:29:29,506 [salt.state       ][INFO    ][2716] Completed state [kvm03.baremetal-mcp-pike-ovs-ha.local] at time 00:29:29.506781 duration_in_ms=5.571
2018-01-14 00:29:29,507 [salt.state       ][INFO    ][2716] Running state [kvm02] at time 00:29:29.507107
2018-01-14 00:29:29,507 [salt.state       ][INFO    ][2716] Executing state host.present for kvm02
2018-01-14 00:29:29,620 [salt.state       ][INFO    ][2716] {'host': 'kvm02'}
2018-01-14 00:29:29,621 [salt.state       ][INFO    ][2716] Completed state [kvm02] at time 00:29:29.621053 duration_in_ms=113.945
2018-01-14 00:29:29,621 [salt.state       ][INFO    ][2716] Running state [kvm02.baremetal-mcp-pike-ovs-ha.local] at time 00:29:29.621486
2018-01-14 00:29:29,621 [salt.state       ][INFO    ][2716] Executing state host.present for kvm02.baremetal-mcp-pike-ovs-ha.local
2018-01-14 00:29:29,758 [salt.state       ][INFO    ][2716] {'host': 'kvm02.baremetal-mcp-pike-ovs-ha.local'}
2018-01-14 00:29:29,758 [salt.state       ][INFO    ][2716] Completed state [kvm02.baremetal-mcp-pike-ovs-ha.local] at time 00:29:29.758888 duration_in_ms=137.401
2018-01-14 00:29:29,759 [salt.state       ][INFO    ][2716] Running state [dbs] at time 00:29:29.759370
2018-01-14 00:29:29,759 [salt.state       ][INFO    ][2716] Executing state host.present for dbs
2018-01-14 00:29:29,826 [salt.state       ][INFO    ][2716] {'host': 'dbs'}
2018-01-14 00:29:29,826 [salt.state       ][INFO    ][2716] Completed state [dbs] at time 00:29:29.826610 duration_in_ms=67.238
2018-01-14 00:29:29,827 [salt.state       ][INFO    ][2716] Running state [dbs.baremetal-mcp-pike-ovs-ha.local] at time 00:29:29.827270
2018-01-14 00:29:29,827 [salt.state       ][INFO    ][2716] Executing state host.present for dbs.baremetal-mcp-pike-ovs-ha.local
2018-01-14 00:29:29,831 [salt.state       ][INFO    ][2716] {'host': 'dbs.baremetal-mcp-pike-ovs-ha.local'}
2018-01-14 00:29:29,832 [salt.state       ][INFO    ][2716] Completed state [dbs.baremetal-mcp-pike-ovs-ha.local] at time 00:29:29.832292 duration_in_ms=5.022
2018-01-14 00:29:29,832 [salt.state       ][INFO    ][2716] Running state [prx] at time 00:29:29.832902
2018-01-14 00:29:29,833 [salt.state       ][INFO    ][2716] Executing state host.present for prx
2018-01-14 00:29:29,837 [salt.state       ][INFO    ][2716] {'host': 'prx'}
2018-01-14 00:29:29,838 [salt.state       ][INFO    ][2716] Completed state [prx] at time 00:29:29.838147 duration_in_ms=5.246
2018-01-14 00:29:29,838 [salt.state       ][INFO    ][2716] Running state [prx.baremetal-mcp-pike-ovs-ha.local] at time 00:29:29.838575
2018-01-14 00:29:29,838 [salt.state       ][INFO    ][2716] Executing state host.present for prx.baremetal-mcp-pike-ovs-ha.local
2018-01-14 00:29:29,843 [salt.state       ][INFO    ][2716] {'host': 'prx.baremetal-mcp-pike-ovs-ha.local'}
2018-01-14 00:29:29,844 [salt.state       ][INFO    ][2716] Completed state [prx.baremetal-mcp-pike-ovs-ha.local] at time 00:29:29.844103 duration_in_ms=5.529
2018-01-14 00:29:29,844 [salt.state       ][INFO    ][2716] Running state [prx02] at time 00:29:29.844479
2018-01-14 00:29:29,844 [salt.state       ][INFO    ][2716] Executing state host.present for prx02
2018-01-14 00:29:29,849 [salt.state       ][INFO    ][2716] {'host': 'prx02'}
2018-01-14 00:29:29,850 [salt.state       ][INFO    ][2716] Completed state [prx02] at time 00:29:29.850096 duration_in_ms=5.617
2018-01-14 00:29:29,850 [salt.state       ][INFO    ][2716] Running state [prx02.baremetal-mcp-pike-ovs-ha.local] at time 00:29:29.850498
2018-01-14 00:29:29,850 [salt.state       ][INFO    ][2716] Executing state host.present for prx02.baremetal-mcp-pike-ovs-ha.local
2018-01-14 00:29:29,855 [salt.state       ][INFO    ][2716] {'host': 'prx02.baremetal-mcp-pike-ovs-ha.local'}
2018-01-14 00:29:29,856 [salt.state       ][INFO    ][2716] Completed state [prx02.baremetal-mcp-pike-ovs-ha.local] at time 00:29:29.856150 duration_in_ms=5.652
2018-01-14 00:29:29,856 [salt.state       ][INFO    ][2716] Running state [msg02] at time 00:29:29.856556
2018-01-14 00:29:29,856 [salt.state       ][INFO    ][2716] Executing state host.present for msg02
2018-01-14 00:29:29,861 [salt.state       ][INFO    ][2716] {'host': 'msg02'}
2018-01-14 00:29:29,862 [salt.state       ][INFO    ][2716] Completed state [msg02] at time 00:29:29.862127 duration_in_ms=5.572
2018-01-14 00:29:29,862 [salt.state       ][INFO    ][2716] Running state [msg02.baremetal-mcp-pike-ovs-ha.local] at time 00:29:29.862533
2018-01-14 00:29:29,862 [salt.state       ][INFO    ][2716] Executing state host.present for msg02.baremetal-mcp-pike-ovs-ha.local
2018-01-14 00:29:29,867 [salt.state       ][INFO    ][2716] {'host': 'msg02.baremetal-mcp-pike-ovs-ha.local'}
2018-01-14 00:29:29,868 [salt.state       ][INFO    ][2716] Completed state [msg02.baremetal-mcp-pike-ovs-ha.local] at time 00:29:29.868100 duration_in_ms=5.567
2018-01-14 00:29:29,868 [salt.state       ][INFO    ][2716] Running state [msg03] at time 00:29:29.868478
2018-01-14 00:29:29,868 [salt.state       ][INFO    ][2716] Executing state host.present for msg03
2018-01-14 00:29:29,873 [salt.state       ][INFO    ][2716] {'host': 'msg03'}
2018-01-14 00:29:29,874 [salt.state       ][INFO    ][2716] Completed state [msg03] at time 00:29:29.874139 duration_in_ms=5.66
2018-01-14 00:29:29,874 [salt.state       ][INFO    ][2716] Running state [msg03.baremetal-mcp-pike-ovs-ha.local] at time 00:29:29.874550
2018-01-14 00:29:29,874 [salt.state       ][INFO    ][2716] Executing state host.present for msg03.baremetal-mcp-pike-ovs-ha.local
2018-01-14 00:29:29,988 [salt.state       ][INFO    ][2716] {'host': 'msg03.baremetal-mcp-pike-ovs-ha.local'}
2018-01-14 00:29:29,988 [salt.state       ][INFO    ][2716] Completed state [msg03.baremetal-mcp-pike-ovs-ha.local] at time 00:29:29.988516 duration_in_ms=113.965
2018-01-14 00:29:29,989 [salt.state       ][INFO    ][2716] Running state [msg01] at time 00:29:29.989025
2018-01-14 00:29:29,989 [salt.state       ][INFO    ][2716] Executing state host.present for msg01
2018-01-14 00:29:29,993 [salt.state       ][INFO    ][2716] {'host': 'msg01'}
2018-01-14 00:29:29,994 [salt.state       ][INFO    ][2716] Completed state [msg01] at time 00:29:29.994128 duration_in_ms=5.101
2018-01-14 00:29:29,994 [salt.state       ][INFO    ][2716] Running state [msg01.baremetal-mcp-pike-ovs-ha.local] at time 00:29:29.994656
2018-01-14 00:29:29,995 [salt.state       ][INFO    ][2716] Executing state host.present for msg01.baremetal-mcp-pike-ovs-ha.local
2018-01-14 00:29:29,999 [salt.state       ][INFO    ][2716] {'host': 'msg01.baremetal-mcp-pike-ovs-ha.local'}
2018-01-14 00:29:30,000 [salt.state       ][INFO    ][2716] Completed state [msg01.baremetal-mcp-pike-ovs-ha.local] at time 00:29:30.000094 duration_in_ms=5.438
2018-01-14 00:29:30,000 [salt.state       ][INFO    ][2716] Running state [msg] at time 00:29:30.000599
2018-01-14 00:29:30,001 [salt.state       ][INFO    ][2716] Executing state host.present for msg
2018-01-14 00:29:30,005 [salt.state       ][INFO    ][2716] {'host': 'msg'}
2018-01-14 00:29:30,006 [salt.state       ][INFO    ][2716] Completed state [msg] at time 00:29:30.006090 duration_in_ms=5.491
2018-01-14 00:29:30,006 [salt.state       ][INFO    ][2716] Running state [msg.baremetal-mcp-pike-ovs-ha.local] at time 00:29:30.006582
2018-01-14 00:29:30,007 [salt.state       ][INFO    ][2716] Executing state host.present for msg.baremetal-mcp-pike-ovs-ha.local
2018-01-14 00:29:30,011 [salt.state       ][INFO    ][2716] {'host': 'msg.baremetal-mcp-pike-ovs-ha.local'}
2018-01-14 00:29:30,012 [salt.state       ][INFO    ][2716] Completed state [msg.baremetal-mcp-pike-ovs-ha.local] at time 00:29:30.012106 duration_in_ms=5.524
2018-01-14 00:29:30,012 [salt.state       ][INFO    ][2716] Running state [cfg01] at time 00:29:30.012573
2018-01-14 00:29:30,013 [salt.state       ][INFO    ][2716] Executing state host.present for cfg01
2018-01-14 00:29:30,013 [salt.state       ][INFO    ][2716] Host cfg01 (10.167.4.100) already present
2018-01-14 00:29:30,014 [salt.state       ][INFO    ][2716] Completed state [cfg01] at time 00:29:30.014243 duration_in_ms=1.669
2018-01-14 00:29:30,014 [salt.state       ][INFO    ][2716] Running state [cfg01.baremetal-mcp-pike-ovs-ha.local] at time 00:29:30.014730
2018-01-14 00:29:30,015 [salt.state       ][INFO    ][2716] Executing state host.present for cfg01.baremetal-mcp-pike-ovs-ha.local
2018-01-14 00:29:30,015 [salt.state       ][INFO    ][2716] Host cfg01.baremetal-mcp-pike-ovs-ha.local (10.167.4.100) already present
2018-01-14 00:29:30,016 [salt.state       ][INFO    ][2716] Completed state [cfg01.baremetal-mcp-pike-ovs-ha.local] at time 00:29:30.016300 duration_in_ms=1.571
2018-01-14 00:29:30,016 [salt.state       ][INFO    ][2716] Running state [cmp002] at time 00:29:30.016724
2018-01-14 00:29:30,017 [salt.state       ][INFO    ][2716] Executing state host.present for cmp002
2018-01-14 00:29:30,019 [salt.state       ][INFO    ][2716] {'host': 'cmp002'}
2018-01-14 00:29:30,019 [salt.state       ][INFO    ][2716] Completed state [cmp002] at time 00:29:30.019324 duration_in_ms=2.599
2018-01-14 00:29:30,019 [salt.state       ][INFO    ][2716] Running state [cmp002.baremetal-mcp-pike-ovs-ha.local] at time 00:29:30.019755
2018-01-14 00:29:30,020 [salt.state       ][INFO    ][2716] Executing state host.present for cmp002.baremetal-mcp-pike-ovs-ha.local
2018-01-14 00:29:30,023 [salt.state       ][INFO    ][2716] {'host': 'cmp002.baremetal-mcp-pike-ovs-ha.local'}
2018-01-14 00:29:30,024 [salt.state       ][INFO    ][2716] Completed state [cmp002.baremetal-mcp-pike-ovs-ha.local] at time 00:29:30.024125 duration_in_ms=4.369
2018-01-14 00:29:30,024 [salt.state       ][INFO    ][2716] Running state [cmp001] at time 00:29:30.024580
2018-01-14 00:29:30,025 [salt.state       ][INFO    ][2716] Executing state host.present for cmp001
2018-01-14 00:29:30,027 [salt.state       ][INFO    ][2716] {'host': 'cmp001'}
2018-01-14 00:29:30,028 [salt.state       ][INFO    ][2716] Completed state [cmp001] at time 00:29:30.028134 duration_in_ms=3.554
2018-01-14 00:29:30,028 [salt.state       ][INFO    ][2716] Running state [cmp001.baremetal-mcp-pike-ovs-ha.local] at time 00:29:30.028557
2018-01-14 00:29:30,028 [salt.state       ][INFO    ][2716] Executing state host.present for cmp001.baremetal-mcp-pike-ovs-ha.local
2018-01-14 00:29:30,033 [salt.state       ][INFO    ][2716] {'host': 'cmp001.baremetal-mcp-pike-ovs-ha.local'}
2018-01-14 00:29:30,034 [salt.state       ][INFO    ][2716] Completed state [cmp001.baremetal-mcp-pike-ovs-ha.local] at time 00:29:30.034198 duration_in_ms=5.641
2018-01-14 00:29:30,034 [salt.state       ][INFO    ][2716] Running state [dbs01] at time 00:29:30.034685
2018-01-14 00:29:30,035 [salt.state       ][INFO    ][2716] Executing state host.present for dbs01
2018-01-14 00:29:30,039 [salt.state       ][INFO    ][2716] {'host': 'dbs01'}
2018-01-14 00:29:30,040 [salt.state       ][INFO    ][2716] Completed state [dbs01] at time 00:29:30.040102 duration_in_ms=5.416
2018-01-14 00:29:30,040 [salt.state       ][INFO    ][2716] Running state [dbs01.baremetal-mcp-pike-ovs-ha.local] at time 00:29:30.040493
2018-01-14 00:29:30,040 [salt.state       ][INFO    ][2716] Executing state host.present for dbs01.baremetal-mcp-pike-ovs-ha.local
2018-01-14 00:29:30,045 [salt.state       ][INFO    ][2716] {'host': 'dbs01.baremetal-mcp-pike-ovs-ha.local'}
2018-01-14 00:29:30,046 [salt.state       ][INFO    ][2716] Completed state [dbs01.baremetal-mcp-pike-ovs-ha.local] at time 00:29:30.046113 duration_in_ms=5.62
2018-01-14 00:29:30,046 [salt.state       ][INFO    ][2716] Running state [dbs02] at time 00:29:30.046540
2018-01-14 00:29:30,046 [salt.state       ][INFO    ][2716] Executing state host.present for dbs02
2018-01-14 00:29:30,051 [salt.state       ][INFO    ][2716] {'host': 'dbs02'}
2018-01-14 00:29:30,052 [salt.state       ][INFO    ][2716] Completed state [dbs02] at time 00:29:30.052201 duration_in_ms=5.661
2018-01-14 00:29:30,052 [salt.state       ][INFO    ][2716] Running state [dbs02.baremetal-mcp-pike-ovs-ha.local] at time 00:29:30.052588
2018-01-14 00:29:30,052 [salt.state       ][INFO    ][2716] Executing state host.present for dbs02.baremetal-mcp-pike-ovs-ha.local
2018-01-14 00:29:30,057 [salt.state       ][INFO    ][2716] {'host': 'dbs02.baremetal-mcp-pike-ovs-ha.local'}
2018-01-14 00:29:30,058 [salt.state       ][INFO    ][2716] Completed state [dbs02.baremetal-mcp-pike-ovs-ha.local] at time 00:29:30.058157 duration_in_ms=5.568
2018-01-14 00:29:30,058 [salt.state       ][INFO    ][2716] Running state [dbs03] at time 00:29:30.058568
2018-01-14 00:29:30,058 [salt.state       ][INFO    ][2716] Executing state host.present for dbs03
2018-01-14 00:29:30,063 [salt.state       ][INFO    ][2716] {'host': 'dbs03'}
2018-01-14 00:29:30,064 [salt.state       ][INFO    ][2716] Completed state [dbs03] at time 00:29:30.064070 duration_in_ms=5.502
2018-01-14 00:29:30,064 [salt.state       ][INFO    ][2716] Running state [dbs03.baremetal-mcp-pike-ovs-ha.local] at time 00:29:30.064435
2018-01-14 00:29:30,064 [salt.state       ][INFO    ][2716] Executing state host.present for dbs03.baremetal-mcp-pike-ovs-ha.local
2018-01-14 00:29:30,088 [salt.state       ][INFO    ][2716] {'host': 'dbs03.baremetal-mcp-pike-ovs-ha.local'}
2018-01-14 00:29:30,088 [salt.state       ][INFO    ][2716] Completed state [dbs03.baremetal-mcp-pike-ovs-ha.local] at time 00:29:30.088596 duration_in_ms=24.16
2018-01-14 00:29:30,089 [salt.state       ][INFO    ][2716] Running state [mas01] at time 00:29:30.088997
2018-01-14 00:29:30,089 [salt.state       ][INFO    ][2716] Executing state host.present for mas01
2018-01-14 00:29:30,093 [salt.state       ][INFO    ][2716] {'host': 'mas01'}
2018-01-14 00:29:30,094 [salt.state       ][INFO    ][2716] Completed state [mas01] at time 00:29:30.094204 duration_in_ms=5.207
2018-01-14 00:29:30,094 [salt.state       ][INFO    ][2716] Running state [mas01.baremetal-mcp-pike-ovs-ha.local] at time 00:29:30.094605
2018-01-14 00:29:30,094 [salt.state       ][INFO    ][2716] Executing state host.present for mas01.baremetal-mcp-pike-ovs-ha.local
2018-01-14 00:29:30,099 [salt.state       ][INFO    ][2716] {'host': 'mas01.baremetal-mcp-pike-ovs-ha.local'}
2018-01-14 00:29:30,100 [salt.state       ][INFO    ][2716] Completed state [mas01.baremetal-mcp-pike-ovs-ha.local] at time 00:29:30.100024 duration_in_ms=5.418
2018-01-14 00:29:30,100 [salt.state       ][INFO    ][2716] Running state [ctl02] at time 00:29:30.100378
2018-01-14 00:29:30,100 [salt.state       ][INFO    ][2716] Executing state host.present for ctl02
2018-01-14 00:29:30,105 [salt.state       ][INFO    ][2716] {'host': 'ctl02'}
2018-01-14 00:29:30,106 [salt.state       ][INFO    ][2716] Completed state [ctl02] at time 00:29:30.106050 duration_in_ms=5.672
2018-01-14 00:29:30,106 [salt.state       ][INFO    ][2716] Running state [ctl02.baremetal-mcp-pike-ovs-ha.local] at time 00:29:30.106441
2018-01-14 00:29:30,106 [salt.state       ][INFO    ][2716] Executing state host.present for ctl02.baremetal-mcp-pike-ovs-ha.local
2018-01-14 00:29:30,111 [salt.state       ][INFO    ][2716] {'host': 'ctl02.baremetal-mcp-pike-ovs-ha.local'}
2018-01-14 00:29:30,112 [salt.state       ][INFO    ][2716] Completed state [ctl02.baremetal-mcp-pike-ovs-ha.local] at time 00:29:30.112121 duration_in_ms=5.679
2018-01-14 00:29:30,112 [salt.state       ][INFO    ][2716] Running state [ctl03] at time 00:29:30.112470
2018-01-14 00:29:30,112 [salt.state       ][INFO    ][2716] Executing state host.present for ctl03
2018-01-14 00:29:30,117 [salt.state       ][INFO    ][2716] {'host': 'ctl03'}
2018-01-14 00:29:30,118 [salt.state       ][INFO    ][2716] Completed state [ctl03] at time 00:29:30.118146 duration_in_ms=5.676
2018-01-14 00:29:30,118 [salt.state       ][INFO    ][2716] Running state [ctl03.baremetal-mcp-pike-ovs-ha.local] at time 00:29:30.118524
2018-01-14 00:29:30,118 [salt.state       ][INFO    ][2716] Executing state host.present for ctl03.baremetal-mcp-pike-ovs-ha.local
2018-01-14 00:29:30,123 [salt.state       ][INFO    ][2716] {'host': 'ctl03.baremetal-mcp-pike-ovs-ha.local'}
2018-01-14 00:29:30,124 [salt.state       ][INFO    ][2716] Completed state [ctl03.baremetal-mcp-pike-ovs-ha.local] at time 00:29:30.124037 duration_in_ms=5.513
2018-01-14 00:29:30,124 [salt.state       ][INFO    ][2716] Running state [ctl01] at time 00:29:30.124376
2018-01-14 00:29:30,124 [salt.state       ][INFO    ][2716] Executing state host.present for ctl01
2018-01-14 00:29:30,129 [salt.state       ][INFO    ][2716] {'host': 'ctl01'}
2018-01-14 00:29:30,130 [salt.state       ][INFO    ][2716] Completed state [ctl01] at time 00:29:30.130137 duration_in_ms=5.761
2018-01-14 00:29:30,130 [salt.state       ][INFO    ][2716] Running state [ctl01.baremetal-mcp-pike-ovs-ha.local] at time 00:29:30.130512
2018-01-14 00:29:30,130 [salt.state       ][INFO    ][2716] Executing state host.present for ctl01.baremetal-mcp-pike-ovs-ha.local
2018-01-14 00:29:30,135 [salt.state       ][INFO    ][2716] {'host': 'ctl01.baremetal-mcp-pike-ovs-ha.local'}
2018-01-14 00:29:30,136 [salt.state       ][INFO    ][2716] Completed state [ctl01.baremetal-mcp-pike-ovs-ha.local] at time 00:29:30.136042 duration_in_ms=5.529
2018-01-14 00:29:30,136 [salt.state       ][INFO    ][2716] Running state [ctl] at time 00:29:30.136387
2018-01-14 00:29:30,136 [salt.state       ][INFO    ][2716] Executing state host.present for ctl
2018-01-14 00:29:30,143 [salt.state       ][INFO    ][2716] {'host': 'ctl'}
2018-01-14 00:29:30,143 [salt.state       ][INFO    ][2716] Completed state [ctl] at time 00:29:30.143843 duration_in_ms=7.456
2018-01-14 00:29:30,144 [salt.state       ][INFO    ][2716] Running state [ctl.baremetal-mcp-pike-ovs-ha.local] at time 00:29:30.144199
2018-01-14 00:29:30,144 [salt.state       ][INFO    ][2716] Executing state host.present for ctl.baremetal-mcp-pike-ovs-ha.local
2018-01-14 00:29:30,149 [salt.state       ][INFO    ][2716] {'host': 'ctl.baremetal-mcp-pike-ovs-ha.local'}
2018-01-14 00:29:30,149 [salt.state       ][INFO    ][2716] Completed state [ctl.baremetal-mcp-pike-ovs-ha.local] at time 00:29:30.149791 duration_in_ms=5.592
2018-01-14 00:29:30,152 [salt.state       ][INFO    ][2716] Running state [ens2] at time 00:29:30.152495
2018-01-14 00:29:30,152 [salt.state       ][INFO    ][2716] Executing state network.managed for ens2
2018-01-14 00:29:30,831 [salt.state       ][INFO    ][2716] Interface ens2 is up to date.
2018-01-14 00:29:30,831 [salt.state       ][INFO    ][2716] Completed state [ens2] at time 00:29:30.831405 duration_in_ms=678.91
2018-01-14 00:29:30,831 [salt.state       ][INFO    ][2716] Running state [ens3] at time 00:29:30.831808
2018-01-14 00:29:30,832 [salt.state       ][INFO    ][2716] Executing state network.managed for ens3
2018-01-14 00:29:30,856 [salt.loaded.int.module.cmdmod][INFO    ][2716] Executing command ['ifup', 'ens3'] in directory '/root'
2018-01-14 00:29:31,457 [salt.state       ][INFO    ][2716] {'interface': 'Added network interface.', 'status': 'Interface ens3 is up'}
2018-01-14 00:29:31,458 [salt.state       ][INFO    ][2716] Completed state [ens3] at time 00:29:31.458092 duration_in_ms=626.284
2018-01-14 00:29:31,458 [salt.state       ][INFO    ][2716] Running state [/etc/profile.d/proxy.sh] at time 00:29:31.458486
2018-01-14 00:29:31,458 [salt.state       ][INFO    ][2716] Executing state file.absent for /etc/profile.d/proxy.sh
2018-01-14 00:29:31,459 [salt.state       ][INFO    ][2716] File /etc/profile.d/proxy.sh is not present
2018-01-14 00:29:31,459 [salt.state       ][INFO    ][2716] Completed state [/etc/profile.d/proxy.sh] at time 00:29:31.459691 duration_in_ms=1.204
2018-01-14 00:29:31,460 [salt.state       ][INFO    ][2716] Running state [/etc/apt/apt.conf.d/95proxies] at time 00:29:31.459986
2018-01-14 00:29:31,460 [salt.state       ][INFO    ][2716] Executing state file.absent for /etc/apt/apt.conf.d/95proxies
2018-01-14 00:29:31,460 [salt.state       ][INFO    ][2716] File /etc/apt/apt.conf.d/95proxies is not present
2018-01-14 00:29:31,460 [salt.state       ][INFO    ][2716] Completed state [/etc/apt/apt.conf.d/95proxies] at time 00:29:31.460882 duration_in_ms=0.896
2018-01-14 00:29:31,462 [salt.state       ][INFO    ][2716] Running state [ntp] at time 00:29:31.462524
2018-01-14 00:29:31,462 [salt.state       ][INFO    ][2716] Executing state pkg.installed for ntp
2018-01-14 00:29:31,644 [salt.loaded.int.module.cmdmod][INFO    ][2716] Executing command ['dpkg', '--get-selections', '*'] in directory '/root'
2018-01-14 00:29:31,664 [salt.loaded.int.module.cmdmod][INFO    ][2716] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'ntp'] in directory '/root'
2018-01-14 00:29:39,356 [salt.minion      ][INFO    ][2613] User sudo_ubuntu Executing command saltutil.find_job with jid 20180114002938387232
2018-01-14 00:29:39,376 [salt.minion      ][INFO    ][7520] Starting a new job with PID 7520
2018-01-14 00:29:39,404 [salt.minion      ][INFO    ][7520] Returning information for job: 20180114002938387232
2018-01-14 00:29:39,931 [salt.loaded.int.module.cmdmod][INFO    ][2716] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2018-01-14 00:29:39,983 [salt.state       ][INFO    ][2716] Made the following changes:
'ntp' changed from 'absent' to '1:4.2.8p4+dfsg-3ubuntu5.7'
'libopts25' changed from 'absent' to '1:5.18.7-3'

2018-01-14 00:29:40,003 [salt.state       ][INFO    ][2716] Loading fresh modules for state activity
2018-01-14 00:29:40,031 [salt.state       ][INFO    ][2716] Completed state [ntp] at time 00:29:40.031046 duration_in_ms=8568.521
2018-01-14 00:29:40,036 [salt.state       ][INFO    ][2716] Running state [/etc/ntp.conf] at time 00:29:40.036876
2018-01-14 00:29:40,037 [salt.state       ][INFO    ][2716] Executing state file.managed for /etc/ntp.conf
2018-01-14 00:29:40,073 [salt.fileclient  ][INFO    ][2716] Fetching file from saltenv 'base', ** done ** 'ntp/files/ntp.conf'
2018-01-14 00:29:40,105 [salt.state       ][INFO    ][2716] File changed:
--- 
+++ 
@@ -1,66 +1,24 @@
-# /etc/ntp.conf, configuration for ntpd; see ntp.conf(5) for help
 
-driftfile /var/lib/ntp/ntp.drift
 
-# Enable this if you want statistics to be logged.
-#statsdir /var/log/ntpstats/
+# ntpd will only synchronize your clock.
 
-statistics loopstats peerstats clockstats
-filegen loopstats file loopstats type day enable
-filegen peerstats file peerstats type day enable
-filegen clockstats file clockstats type day enable
+# For details, see:
+# - the ntp.conf man page
+# - http://support.ntp.org/bin/view/Support/GettingStarted
+# - https://wiki.archlinux.org/index.php/Network_Time_Protocol_daemon
 
-# Specify one or more NTP servers.
+# Associate to cloud NTP pool servers
+server 1.pool.ntp.org iburst
+server 0.pool.ntp.org
 
-# Use servers from the NTP Pool Project. Approved by Ubuntu Technical Board
-# on 2011-02-08 (LP: #104525). See http://www.pool.ntp.org/join.html for
-# more information.
-pool 0.ubuntu.pool.ntp.org iburst
-pool 1.ubuntu.pool.ntp.org iburst
-pool 2.ubuntu.pool.ntp.org iburst
-pool 3.ubuntu.pool.ntp.org iburst
-
-# Use Ubuntu's ntp server as a fallback.
-pool ntp.ubuntu.com
-
-# Access control configuration; see /usr/share/doc/ntp-doc/html/accopt.html for
-# details.  The web page <http://support.ntp.org/bin/view/Support/AccessRestrictions>
-# might also be helpful.
-#
-# Note that "restrict" applies to both servers and clients, so a configuration
-# that might be intended to block requests from certain clients could also end
-# up blocking replies from your own upstream servers.
-
-# By default, exchange time with everybody, but don't allow configuration.
-restrict -4 default kod notrap nomodify nopeer noquery limited
-restrict -6 default kod notrap nomodify nopeer noquery limited
-
-# Local users may interrogate the ntp server more closely.
+# Only allow read-only access from localhost
+restrict default noquery nopeer
 restrict 127.0.0.1
 restrict ::1
 
-# Needed for adding pool entries
-restrict source notrap nomodify noquery
-
-# Clients from this (example!) subnet have unlimited access, but only if
-# cryptographically authenticated.
-#restrict 192.168.123.0 mask 255.255.255.0 notrust
+# mode7 is required for collectd monitoring
 
 
-# If you want to provide time to your local subnet, change the next line.
-# (Again, the address is an example only.)
-#broadcast 192.168.123.255
-
-# If you want to listen to time broadcasts on your local subnet, de-comment the
-# next lines.  Please do this only if you trust everybody on the network!
-#disable auth
-#broadcastclient
-
-#Changes recquired to use pps synchonisation as explained in documentation:
-#http://www.ntp.org/ntpfaq/NTP-s-config-adv.htm#AEN3918
-
-#server 127.127.8.1 mode 135 prefer    # Meinberg GPS167 with PPS
-#fudge 127.127.8.1 time1 0.0042        # relative to PPS for my hardware
-
-#server 127.127.22.1                   # ATOM(PPS)
-#fudge 127.127.22.1 flag3 1            # enable PPS API
+# Location of drift file
+driftfile /var/lib/ntp/ntp.drift
+logfile /var/log/ntp.log
2018-01-14 00:29:40,114 [salt.state       ][INFO    ][2716] Completed state [/etc/ntp.conf] at time 00:29:40.114315 duration_in_ms=77.438
2018-01-14 00:29:40,345 [salt.state       ][INFO    ][2716] Running state [ntp] at time 00:29:40.345374
2018-01-14 00:29:40,346 [salt.state       ][INFO    ][2716] Executing state service.running for ntp
2018-01-14 00:29:40,346 [salt.loaded.int.module.cmdmod][INFO    ][2716] Executing command ['systemctl', 'status', 'ntp.service', '-n', '0'] in directory '/root'
2018-01-14 00:29:40,364 [salt.loaded.int.module.cmdmod][INFO    ][2716] Executing command ['systemctl', 'is-active', 'ntp.service'] in directory '/root'
2018-01-14 00:29:40,375 [salt.loaded.int.module.cmdmod][INFO    ][2716] Executing command ['systemctl', 'is-enabled', 'ntp.service'] in directory '/root'
2018-01-14 00:29:40,393 [salt.state       ][INFO    ][2716] The service ntp is already running
2018-01-14 00:29:40,393 [salt.state       ][INFO    ][2716] Completed state [ntp] at time 00:29:40.393582 duration_in_ms=48.206
2018-01-14 00:29:40,394 [salt.state       ][INFO    ][2716] Running state [ntp] at time 00:29:40.394022
2018-01-14 00:29:40,394 [salt.state       ][INFO    ][2716] Executing state service.mod_watch for ntp
2018-01-14 00:29:40,395 [salt.loaded.int.module.cmdmod][INFO    ][2716] Executing command ['systemctl', 'is-active', 'ntp.service'] in directory '/root'
2018-01-14 00:29:40,406 [salt.loaded.int.module.cmdmod][INFO    ][2716] Executing command ['systemctl', 'is-enabled', 'ntp.service'] in directory '/root'
2018-01-14 00:29:40,425 [salt.loaded.int.module.cmdmod][INFO    ][2716] Executing command ['systemd-run', '--scope', 'systemctl', 'restart', 'ntp.service'] in directory '/root'
2018-01-14 00:29:40,484 [salt.state       ][INFO    ][2716] {'ntp': True}
2018-01-14 00:29:40,485 [salt.state       ][INFO    ][2716] Completed state [ntp] at time 00:29:40.485287 duration_in_ms=91.265
2018-01-14 00:29:40,489 [salt.minion      ][INFO    ][2716] Returning information for job: 20180114002827503901
2018-01-14 00:29:57,995 [salt.minion      ][INFO    ][2613] User sudo_ubuntu Executing command ssh.set_auth_key with jid 20180114002957026572
2018-01-14 00:29:58,017 [salt.minion      ][INFO    ][7640] Starting a new job with PID 7640
2018-01-14 00:29:58,039 [salt.loader.192.168.11.2.int.module.ssh][WARNING ][7640] Public Key hashing currently defaults to "md5". This will change to "sha256" in the Nitrogen release.
2018-01-14 00:29:58,043 [salt.minion      ][INFO    ][7640] Returning information for job: 20180114002957026572
2018-01-14 00:30:23,768 [salt.minion      ][INFO    ][2613] User sudo_ubuntu Executing command pkg.upgrade with jid 20180114003022807020
2018-01-14 00:30:23,791 [salt.minion      ][INFO    ][7653] Starting a new job with PID 7653
2018-01-14 00:30:23,832 [salt.loader.192.168.11.2.int.module.cmdmod][INFO    ][7653] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2018-01-14 00:30:24,211 [salt.loader.192.168.11.2.int.module.cmdmod][INFO    ][7653] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'upgrade'] in directory '/root'
2018-01-14 00:30:33,869 [salt.minion      ][INFO    ][2613] User sudo_ubuntu Executing command saltutil.find_job with jid 20180114003032899913
2018-01-14 00:30:33,891 [salt.minion      ][INFO    ][7737] Starting a new job with PID 7737
2018-01-14 00:30:33,926 [salt.minion      ][INFO    ][7737] Returning information for job: 20180114003032899913
2018-01-14 00:30:44,093 [salt.minion      ][INFO    ][2613] User sudo_ubuntu Executing command saltutil.find_job with jid 20180114003043126720
2018-01-14 00:30:44,116 [salt.minion      ][INFO    ][7819] Starting a new job with PID 7819
2018-01-14 00:30:44,142 [salt.minion      ][INFO    ][7819] Returning information for job: 20180114003043126720
2018-01-14 00:30:54,143 [salt.minion      ][INFO    ][2613] User sudo_ubuntu Executing command saltutil.find_job with jid 20180114003053174771
2018-01-14 00:30:54,170 [salt.minion      ][INFO    ][8302] Starting a new job with PID 8302
2018-01-14 00:30:54,197 [salt.minion      ][INFO    ][8302] Returning information for job: 20180114003053174771
2018-01-14 00:31:04,320 [salt.minion      ][INFO    ][2613] User sudo_ubuntu Executing command saltutil.find_job with jid 20180114003103352941
2018-01-14 00:31:04,348 [salt.minion      ][INFO    ][8441] Starting a new job with PID 8441
2018-01-14 00:31:04,373 [salt.minion      ][INFO    ][8441] Returning information for job: 20180114003103352941
2018-01-14 00:31:05,030 [salt.loader.192.168.11.2.int.module.cmdmod][INFO    ][7653] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2018-01-14 00:31:05,059 [salt.minion      ][INFO    ][7653] Returning information for job: 20180114003022807020
2018-01-14 00:31:30,007 [salt.minion      ][INFO    ][2613] User sudo_ubuntu Executing command test.ping with jid 20180114003129045511
2018-01-14 00:31:30,037 [salt.minion      ][INFO    ][8464] Starting a new job with PID 8464
2018-01-14 00:31:30,117 [salt.minion      ][INFO    ][8464] Returning information for job: 20180114003129045511
2018-01-14 00:34:18,167 [salt.minion      ][INFO    ][2613] User sudo_ubuntu Executing command state.sls with jid 20180114003417211031
2018-01-14 00:34:18,189 [salt.minion      ][INFO    ][8568] Starting a new job with PID 8568
2018-01-14 00:34:19,814 [salt.state       ][INFO    ][8568] Loading fresh modules for state activity
2018-01-14 00:34:19,879 [salt.fileclient  ][INFO    ][8568] Fetching file from saltenv 'base', ** done ** 'keepalived/init.sls'
2018-01-14 00:34:19,911 [salt.fileclient  ][INFO    ][8568] Fetching file from saltenv 'base', ** done ** 'keepalived/cluster.sls'
2018-01-14 00:34:20,460 [salt.state       ][INFO    ][8568] Running state [keepalived] at time 00:34:20.460317
2018-01-14 00:34:20,460 [salt.state       ][INFO    ][8568] Executing state pkg.installed for keepalived
2018-01-14 00:34:20,461 [salt.loaded.int.module.cmdmod][INFO    ][8568] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2018-01-14 00:34:20,816 [salt.loaded.int.module.cmdmod][INFO    ][8568] Executing command ['apt-cache', '-q', 'policy', 'keepalived'] in directory '/root'
2018-01-14 00:34:20,943 [salt.loaded.int.module.cmdmod][INFO    ][8568] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2018-01-14 00:34:23,194 [salt.loaded.int.module.cmdmod][INFO    ][8568] Executing command ['dpkg', '--get-selections', '*'] in directory '/root'
2018-01-14 00:34:23,249 [salt.loaded.int.module.cmdmod][INFO    ][8568] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'keepalived'] in directory '/root'
2018-01-14 00:34:28,218 [salt.minion      ][INFO    ][2613] User sudo_ubuntu Executing command saltutil.find_job with jid 20180114003427261074
2018-01-14 00:34:28,242 [salt.minion      ][INFO    ][9604] Starting a new job with PID 9604
2018-01-14 00:34:28,274 [salt.minion      ][INFO    ][9604] Returning information for job: 20180114003427261074
2018-01-14 00:34:31,195 [salt.loaded.int.module.cmdmod][INFO    ][8568] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2018-01-14 00:34:31,257 [salt.state       ][INFO    ][8568] 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'

2018-01-14 00:34:31,290 [salt.state       ][INFO    ][8568] Loading fresh modules for state activity
2018-01-14 00:34:31,331 [salt.state       ][INFO    ][8568] Completed state [keepalived] at time 00:34:31.331273 duration_in_ms=10870.954
2018-01-14 00:34:31,345 [salt.state       ][INFO    ][8568] Running state [lsof] at time 00:34:31.344928
2018-01-14 00:34:31,345 [salt.state       ][INFO    ][8568] Executing state pkg.installed for lsof
2018-01-14 00:34:31,742 [salt.state       ][INFO    ][8568] All specified packages are already installed
2018-01-14 00:34:31,742 [salt.state       ][INFO    ][8568] Completed state [lsof] at time 00:34:31.742703 duration_in_ms=397.775
2018-01-14 00:34:31,744 [salt.state       ][INFO    ][8568] Running state [/etc/keepalived/keepalived.conf] at time 00:34:31.744846
2018-01-14 00:34:31,745 [salt.state       ][INFO    ][8568] Executing state file.managed for /etc/keepalived/keepalived.conf
2018-01-14 00:34:31,789 [salt.fileclient  ][INFO    ][8568] Fetching file from saltenv 'base', ** done ** 'keepalived/files/keepalived.conf'
2018-01-14 00:34:31,838 [salt.state       ][INFO    ][8568] File changed:
New file
2018-01-14 00:34:31,838 [salt.state       ][INFO    ][8568] Completed state [/etc/keepalived/keepalived.conf] at time 00:34:31.838252 duration_in_ms=93.406
2018-01-14 00:34:31,839 [salt.state       ][INFO    ][8568] Running state [keepalived] at time 00:34:31.839181
2018-01-14 00:34:31,839 [salt.state       ][INFO    ][8568] Executing state service.running for keepalived
2018-01-14 00:34:31,840 [salt.loaded.int.module.cmdmod][INFO    ][8568] Executing command ['systemctl', 'status', 'keepalived.service', '-n', '0'] in directory '/root'
2018-01-14 00:34:31,868 [salt.loaded.int.module.cmdmod][INFO    ][8568] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2018-01-14 00:34:31,892 [salt.loaded.int.module.cmdmod][INFO    ][8568] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2018-01-14 00:34:31,914 [salt.loaded.int.module.cmdmod][INFO    ][8568] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2018-01-14 00:34:31,935 [salt.loaded.int.module.cmdmod][INFO    ][8568] Executing command ['systemd-run', '--scope', 'systemctl', 'start', 'keepalived.service'] in directory '/root'
2018-01-14 00:34:32,022 [salt.loaded.int.module.cmdmod][INFO    ][8568] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2018-01-14 00:34:32,048 [salt.loaded.int.module.cmdmod][INFO    ][8568] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2018-01-14 00:34:32,063 [salt.loaded.int.module.cmdmod][INFO    ][8568] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2018-01-14 00:34:32,084 [salt.state       ][INFO    ][8568] {'keepalived': True}
2018-01-14 00:34:32,084 [salt.state       ][INFO    ][8568] Completed state [keepalived] at time 00:34:32.084796 duration_in_ms=245.615
2018-01-14 00:34:32,087 [salt.minion      ][INFO    ][8568] Returning information for job: 20180114003417211031
2018-01-14 00:35:29,665 [salt.minion      ][INFO    ][2613] User sudo_ubuntu Executing command pillar.get with jid 20180114003528711886
2018-01-14 00:35:29,696 [salt.minion      ][INFO    ][9882] Starting a new job with PID 9882
2018-01-14 00:35:29,707 [salt.minion      ][INFO    ][9882] Returning information for job: 20180114003528711886
2018-01-14 01:00:31,705 [salt.minion      ][INFO    ][2613] User sudo_ubuntu Executing command state.sls with jid 20180114010030816122
2018-01-14 01:00:31,726 [salt.minion      ][INFO    ][9975] Starting a new job with PID 9975
2018-01-14 01:00:33,203 [salt.state       ][INFO    ][9975] Loading fresh modules for state activity
2018-01-14 01:00:33,267 [salt.fileclient  ][INFO    ][9975] Fetching file from saltenv 'base', ** done ** 'galera/init.sls'
2018-01-14 01:00:33,303 [salt.fileclient  ][INFO    ][9975] Fetching file from saltenv 'base', ** done ** 'galera/ssl.sls'
2018-01-14 01:00:33,377 [salt.fileclient  ][INFO    ][9975] Fetching file from saltenv 'base', ** done ** 'galera/slave.sls'
2018-01-14 01:00:33,432 [py.warnings      ][WARNING ][9975] /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.

2018-01-14 01:00:33,434 [salt.loaded.int.module.cmdmod][INFO    ][9975] Executing command 'test -e /var/lib/mysql/.galera_bootstrap; echo $?' in directory '/root'
2018-01-14 01:00:33,500 [salt.fileclient  ][INFO    ][9975] Fetching file from saltenv 'base', ** done ** 'galera/server.sls'
2018-01-14 01:00:34,039 [salt.state       ][INFO    ][9975] Running state [/etc/mysql/my.cnf] at time 01:00:34.039845
2018-01-14 01:00:34,040 [salt.state       ][INFO    ][9975] Executing state file.managed for /etc/mysql/my.cnf
2018-01-14 01:00:34,062 [salt.fileclient  ][INFO    ][9975] Fetching file from saltenv 'base', ** done ** 'galera/files/my.cnf.pre'
2018-01-14 01:00:34,066 [salt.state       ][INFO    ][9975] File changed:
New file
2018-01-14 01:00:34,066 [salt.state       ][INFO    ][9975] Completed state [/etc/mysql/my.cnf] at time 01:00:34.066869 duration_in_ms=27.024
2018-01-14 01:00:34,067 [salt.state       ][INFO    ][9975] Running state [mysql-wsrep-5.6] at time 01:00:34.067515
2018-01-14 01:00:34,067 [salt.state       ][INFO    ][9975] Executing state pkg.installed for mysql-wsrep-5.6
2018-01-14 01:00:34,068 [salt.loaded.int.module.cmdmod][INFO    ][9975] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2018-01-14 01:00:34,377 [salt.loaded.int.module.cmdmod][INFO    ][9975] Executing command ['apt-cache', '-q', 'policy', 'mysql-wsrep-5.6'] in directory '/root'
2018-01-14 01:00:34,444 [salt.loaded.int.module.cmdmod][INFO    ][9975] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2018-01-14 01:00:36,690 [salt.loaded.int.module.cmdmod][INFO    ][9975] Executing command ['dpkg', '--get-selections', '*'] in directory '/root'
2018-01-14 01:00:36,733 [salt.loaded.int.module.cmdmod][INFO    ][9975] 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'
2018-01-14 01:00:41,799 [salt.minion      ][INFO    ][2613] User sudo_ubuntu Executing command saltutil.find_job with jid 20180114010040910991
2018-01-14 01:00:41,820 [salt.minion      ][INFO    ][10758] Starting a new job with PID 10758
2018-01-14 01:00:41,844 [salt.minion      ][INFO    ][10758] Returning information for job: 20180114010040910991
2018-01-14 01:00:52,022 [salt.minion      ][INFO    ][2613] User sudo_ubuntu Executing command saltutil.find_job with jid 20180114010051132802
2018-01-14 01:00:52,045 [salt.minion      ][INFO    ][11125] Starting a new job with PID 11125
2018-01-14 01:00:52,068 [salt.minion      ][INFO    ][11125] Returning information for job: 20180114010051132802
2018-01-14 01:01:02,250 [salt.minion      ][INFO    ][2613] User sudo_ubuntu Executing command saltutil.find_job with jid 20180114010101356159
2018-01-14 01:01:02,272 [salt.minion      ][INFO    ][11458] Starting a new job with PID 11458
2018-01-14 01:01:02,300 [salt.minion      ][INFO    ][11458] Returning information for job: 20180114010101356159
2018-01-14 01:01:11,183 [salt.loaded.int.module.cmdmod][INFO    ][9975] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2018-01-14 01:01:11,251 [salt.state       ][INFO    ][9975] Made the following changes:
'libmysqlclient18' changed from 'absent' to '1'
'virtual-mysql-client' changed from 'absent' to '1'
'libencode-locale-perl' changed from 'absent' to '1.05-1'
'timedate' changed from 'absent' to '1'
'mysql-server-5.6' changed from 'absent' to '1'
'libdbi-perl' changed from 'absent' to '1.634-1build1'
'mysql-common' changed from 'absent' to '5.7.20-0ubuntu0.16.04.1'
'mysql-wsrep-server-5.6' changed from 'absent' to '5.6.35-0.1~u16.04+mcp2'
'socat' changed from 'absent' to '1.7.3.1-1'
'libcgi-pm-perl' changed from 'absent' to '4.26-1'
'libio-html-perl' changed from 'absent' to '1.001-1'
'mysql-wsrep-libmysqlclient18' changed from 'absent' to '5.6.35-0.1~u16.04+mcp2'
'libtimedate-perl' changed from 'absent' to '2.3000-2'
'libterm-readkey-perl' changed from 'absent' to '2.33-1build1'
'liburi-perl' changed from 'absent' to '1.71-1'
'mysql-wsrep-common-5.6' changed from 'absent' to '5.6.35-0.1~u16.04+mcp2'
'libhtml-parser-perl' changed from 'absent' to '3.72-1'
'libaio1' changed from 'absent' to '0.3.110-2'
'mysql-common-5.6' changed from 'absent' to '1'
'libhttp-message-perl' changed from 'absent' to '6.11-1'
'mysql-wsrep-client-5.6' changed from 'absent' to '5.6.35-0.1~u16.04+mcp2'
'libmysqlclient20' changed from 'absent' to '5.7.20-0ubuntu0.16.04.1'
'libfcgi-perl' changed from 'absent' to '0.77-1build1'
'libcgi-fast-perl' changed from 'absent' to '1:2.10-1'
'perl-dbdabi-94' changed from 'absent' to '1'
'libdbd-mysql-perl' changed from 'absent' to '4.033-1ubuntu0.1'
'liblwp-mediatypes-perl' changed from 'absent' to '6.02-1'
'virtual-mysql-server' changed from 'absent' to '1'
'libhtml-template-perl' changed from 'absent' to '2.95-2'
'libhttp-date-perl' changed from 'absent' to '6.02-1'
'libhtml-tagset-perl' changed from 'absent' to '3.20-2'
'mysql-wsrep-5.6' changed from 'absent' to '5.6.35-0.1~u16.04+mcp2'

2018-01-14 01:01:11,292 [salt.state       ][INFO    ][9975] Loading fresh modules for state activity
2018-01-14 01:01:11,331 [salt.state       ][INFO    ][9975] Completed state [mysql-wsrep-5.6] at time 01:01:11.331809 duration_in_ms=37264.293
2018-01-14 01:01:11,341 [salt.state       ][INFO    ][9975] Running state [galera-3] at time 01:01:11.341912
2018-01-14 01:01:11,342 [salt.state       ][INFO    ][9975] Executing state pkg.installed for galera-3
2018-01-14 01:01:11,798 [salt.loaded.int.module.cmdmod][INFO    ][9975] Executing command ['apt-cache', '-q', 'policy', 'galera-3'] in directory '/root'
2018-01-14 01:01:11,890 [salt.loaded.int.module.cmdmod][INFO    ][9975] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2018-01-14 01:01:12,464 [salt.minion      ][INFO    ][2613] User sudo_ubuntu Executing command saltutil.find_job with jid 20180114010111578693
2018-01-14 01:01:12,488 [salt.minion      ][INFO    ][11817] Starting a new job with PID 11817
2018-01-14 01:01:12,515 [salt.minion      ][INFO    ][11817] Returning information for job: 20180114010111578693
2018-01-14 01:01:13,904 [salt.loaded.int.module.cmdmod][INFO    ][9975] Executing command ['dpkg', '--get-selections', '*'] in directory '/root'
2018-01-14 01:01:13,945 [salt.loaded.int.module.cmdmod][INFO    ][9975] 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'
2018-01-14 01:01:16,589 [salt.loaded.int.module.cmdmod][INFO    ][9975] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2018-01-14 01:01:16,662 [salt.state       ][INFO    ][9975] 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'

2018-01-14 01:01:16,686 [salt.state       ][INFO    ][9975] Loading fresh modules for state activity
2018-01-14 01:01:16,724 [salt.state       ][INFO    ][9975] Completed state [galera-3] at time 01:01:16.724166 duration_in_ms=5382.254
2018-01-14 01:01:16,733 [salt.state       ][INFO    ][9975] Running state [rsync] at time 01:01:16.733022
2018-01-14 01:01:16,733 [salt.state       ][INFO    ][9975] Executing state pkg.installed for rsync
2018-01-14 01:01:17,088 [salt.state       ][INFO    ][9975] All specified packages are already installed
2018-01-14 01:01:17,089 [salt.state       ][INFO    ][9975] Completed state [rsync] at time 01:01:17.089204 duration_in_ms=356.181
2018-01-14 01:01:17,089 [salt.state       ][INFO    ][9975] Running state [python-mysqldb] at time 01:01:17.089870
2018-01-14 01:01:17,090 [salt.state       ][INFO    ][9975] Executing state pkg.installed for python-mysqldb
2018-01-14 01:01:17,103 [salt.loaded.int.module.cmdmod][INFO    ][9975] Executing command ['apt-cache', '-q', 'policy', 'python-mysqldb'] in directory '/root'
2018-01-14 01:01:17,188 [salt.loaded.int.module.cmdmod][INFO    ][9975] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2018-01-14 01:01:19,247 [salt.loaded.int.module.cmdmod][INFO    ][9975] Executing command ['dpkg', '--get-selections', '*'] in directory '/root'
2018-01-14 01:01:19,289 [salt.loaded.int.module.cmdmod][INFO    ][9975] 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'
2018-01-14 01:01:21,723 [salt.loaded.int.module.cmdmod][INFO    ][9975] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2018-01-14 01:01:21,793 [salt.state       ][INFO    ][9975] Made the following changes:
'python2.7-mysqldb' changed from 'absent' to '1'
'python-mysqldb' changed from 'absent' to '1.3.7-1build2'

2018-01-14 01:01:21,819 [salt.state       ][INFO    ][9975] Loading fresh modules for state activity
2018-01-14 01:01:21,858 [salt.state       ][INFO    ][9975] Completed state [python-mysqldb] at time 01:01:21.858535 duration_in_ms=4768.664
2018-01-14 01:01:21,867 [salt.state       ][INFO    ][9975] Running state [libmysqlclient-dev] at time 01:01:21.867840
2018-01-14 01:01:21,868 [salt.state       ][INFO    ][9975] Executing state pkg.installed for libmysqlclient-dev
2018-01-14 01:01:22,229 [salt.loaded.int.module.cmdmod][INFO    ][9975] Executing command ['apt-cache', '-q', 'policy', 'libmysqlclient-dev'] in directory '/root'
2018-01-14 01:01:22,319 [salt.loaded.int.module.cmdmod][INFO    ][9975] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2018-01-14 01:01:22,523 [salt.minion      ][INFO    ][2613] User sudo_ubuntu Executing command saltutil.find_job with jid 20180114010121637009
2018-01-14 01:01:22,545 [salt.minion      ][INFO    ][12686] Starting a new job with PID 12686
2018-01-14 01:01:22,572 [salt.minion      ][INFO    ][12686] Returning information for job: 20180114010121637009
2018-01-14 01:01:24,491 [salt.loaded.int.module.cmdmod][INFO    ][9975] Executing command ['dpkg', '--get-selections', '*'] in directory '/root'
2018-01-14 01:01:24,535 [salt.loaded.int.module.cmdmod][INFO    ][9975] 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'
2018-01-14 01:01:32,568 [salt.minion      ][INFO    ][2613] User sudo_ubuntu Executing command saltutil.find_job with jid 20180114010131681451
2018-01-14 01:01:32,588 [salt.minion      ][INFO    ][15840] Starting a new job with PID 15840
2018-01-14 01:01:32,617 [salt.minion      ][INFO    ][15840] Returning information for job: 20180114010131681451
2018-01-14 01:01:35,312 [salt.loaded.int.module.cmdmod][INFO    ][9975] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2018-01-14 01:01:35,366 [salt.state       ][INFO    ][9975] 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'
'libc-dev-bin' changed from 'absent' to '2.23-0ubuntu9'
'linux-libc-dev' changed from 'absent' to '4.4.0-109.132'
'zlib1g-dev' changed from 'absent' to '1:1.2.8.dfsg-2ubuntu4.1'

2018-01-14 01:01:35,393 [salt.state       ][INFO    ][9975] Loading fresh modules for state activity
2018-01-14 01:01:35,426 [salt.state       ][INFO    ][9975] Completed state [libmysqlclient-dev] at time 01:01:35.426470 duration_in_ms=13558.629
2018-01-14 01:01:35,435 [salt.state       ][INFO    ][9975] Running state [psmisc] at time 01:01:35.435746
2018-01-14 01:01:35,436 [salt.state       ][INFO    ][9975] Executing state pkg.installed for psmisc
2018-01-14 01:01:35,835 [salt.state       ][INFO    ][9975] All specified packages are already installed
2018-01-14 01:01:35,836 [salt.state       ][INFO    ][9975] Completed state [psmisc] at time 01:01:35.836030 duration_in_ms=400.284
2018-01-14 01:01:35,836 [salt.state       ][INFO    ][9975] Running state [netcat] at time 01:01:35.836907
2018-01-14 01:01:35,837 [salt.state       ][INFO    ][9975] Executing state pkg.installed for netcat
2018-01-14 01:01:35,841 [salt.state       ][INFO    ][9975] All specified packages are already installed
2018-01-14 01:01:35,841 [salt.state       ][INFO    ][9975] Completed state [netcat] at time 01:01:35.841934 duration_in_ms=5.027
2018-01-14 01:01:35,842 [salt.state       ][INFO    ][9975] Running state [percona-xtrabackup] at time 01:01:35.842565
2018-01-14 01:01:35,842 [salt.state       ][INFO    ][9975] Executing state pkg.installed for percona-xtrabackup
2018-01-14 01:01:35,855 [salt.loaded.int.module.cmdmod][INFO    ][9975] Executing command ['apt-cache', '-q', 'policy', 'percona-xtrabackup'] in directory '/root'
2018-01-14 01:01:35,942 [salt.loaded.int.module.cmdmod][INFO    ][9975] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2018-01-14 01:01:37,874 [salt.loaded.int.module.cmdmod][INFO    ][9975] Executing command ['dpkg', '--get-selections', '*'] in directory '/root'
2018-01-14 01:01:37,897 [salt.loaded.int.module.cmdmod][INFO    ][9975] 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'
2018-01-14 01:01:42,522 [salt.loaded.int.module.cmdmod][INFO    ][9975] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2018-01-14 01:01:42,590 [salt.state       ][INFO    ][9975] Made the following changes:
'libev4' changed from 'absent' to '1:4.22-1'
'xtrabackup' changed from 'absent' to '1'
'libcurl3' changed from 'absent' to '7.47.0-1ubuntu2.5'
'percona-xtrabackup' changed from 'absent' to '2.3.7-0ubuntu0.16.04.2'

2018-01-14 01:01:42,617 [salt.state       ][INFO    ][9975] Loading fresh modules for state activity
2018-01-14 01:01:42,652 [salt.state       ][INFO    ][9975] Completed state [percona-xtrabackup] at time 01:01:42.652012 duration_in_ms=6809.445
2018-01-14 01:01:42,661 [salt.state       ][INFO    ][9975] Running state [socat] at time 01:01:42.661476
2018-01-14 01:01:42,662 [salt.state       ][INFO    ][9975] Executing state pkg.installed for socat
2018-01-14 01:01:43,009 [salt.state       ][INFO    ][9975] All specified packages are already installed
2018-01-14 01:01:43,010 [salt.state       ][INFO    ][9975] Completed state [socat] at time 01:01:43.010403 duration_in_ms=348.926
2018-01-14 01:01:43,011 [salt.state       ][INFO    ][9975] Running state [libdbd-mysql] at time 01:01:43.011296
2018-01-14 01:01:43,011 [salt.state       ][INFO    ][9975] Executing state pkg.installed for libdbd-mysql
2018-01-14 01:01:43,027 [salt.loaded.int.module.cmdmod][INFO    ][9975] Executing command ['apt-cache', '-q', 'policy', 'libdbd-mysql'] in directory '/root'
2018-01-14 01:01:43,100 [salt.loaded.int.module.cmdmod][INFO    ][9975] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2018-01-14 01:01:43,337 [salt.minion      ][INFO    ][2613] User sudo_ubuntu Executing command saltutil.find_job with jid 20180114010141912544
2018-01-14 01:01:43,354 [salt.minion      ][INFO    ][17149] Starting a new job with PID 17149
2018-01-14 01:01:43,378 [salt.minion      ][INFO    ][17149] Returning information for job: 20180114010141912544
2018-01-14 01:01:45,136 [salt.loaded.int.module.cmdmod][INFO    ][9975] Executing command ['dpkg', '--get-selections', '*'] in directory '/root'
2018-01-14 01:01:45,177 [salt.loaded.int.module.cmdmod][INFO    ][9975] 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'
2018-01-14 01:01:48,134 [salt.loaded.int.module.cmdmod][INFO    ][9975] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2018-01-14 01:01:48,192 [salt.state       ][INFO    ][9975] Made the following changes:
'libdbd-mysql' changed from 'absent' to '0.9.0-3ubuntu2'
'libdbi1' changed from 'absent' to '0.9.0-4'

2018-01-14 01:01:48,217 [salt.state       ][INFO    ][9975] Loading fresh modules for state activity
2018-01-14 01:01:48,248 [salt.state       ][INFO    ][9975] Completed state [libdbd-mysql] at time 01:01:48.248737 duration_in_ms=5237.44
2018-01-14 01:01:48,257 [salt.state       ][INFO    ][9975] Running state [python-pymysql] at time 01:01:48.257700
2018-01-14 01:01:48,258 [salt.state       ][INFO    ][9975] Executing state pkg.installed for python-pymysql
2018-01-14 01:01:48,601 [salt.state       ][INFO    ][9975] All specified packages are already installed
2018-01-14 01:01:48,602 [salt.state       ][INFO    ][9975] Completed state [python-pymysql] at time 01:01:48.602574 duration_in_ms=344.874
2018-01-14 01:01:48,604 [salt.state       ][INFO    ][9975] Running state [/var/log/mysql] at time 01:01:48.604714
2018-01-14 01:01:48,605 [salt.state       ][INFO    ][9975] Executing state file.directory for /var/log/mysql
2018-01-14 01:01:48,606 [salt.state       ][INFO    ][9975] {'mode': '0755'}
2018-01-14 01:01:48,606 [salt.state       ][INFO    ][9975] Completed state [/var/log/mysql] at time 01:01:48.606469 duration_in_ms=1.755
2018-01-14 01:01:48,607 [salt.state       ][INFO    ][9975] Running state [/var/run/mysqld] at time 01:01:48.607175
2018-01-14 01:01:48,607 [salt.state       ][INFO    ][9975] Executing state file.directory for /var/run/mysqld
2018-01-14 01:01:48,608 [salt.state       ][INFO    ][9975] Directory /var/run/mysqld is in the correct state
2018-01-14 01:01:48,608 [salt.state       ][INFO    ][9975] Completed state [/var/run/mysqld] at time 01:01:48.608767 duration_in_ms=1.592
2018-01-14 01:01:48,609 [salt.state       ][INFO    ][9975] Running state [/etc/systemd/system/mysql.service.d] at time 01:01:48.609472
2018-01-14 01:01:48,609 [salt.state       ][INFO    ][9975] Executing state file.directory for /etc/systemd/system/mysql.service.d
2018-01-14 01:01:48,611 [salt.state       ][INFO    ][9975] {'/etc/systemd/system/mysql.service.d': 'New Dir'}
2018-01-14 01:01:48,611 [salt.state       ][INFO    ][9975] Completed state [/etc/systemd/system/mysql.service.d] at time 01:01:48.611349 duration_in_ms=1.876
2018-01-14 01:01:48,714 [salt.state       ][INFO    ][9975] Running state [/etc/systemd/system/mysql.service.d/override.conf] at time 01:01:48.714581
2018-01-14 01:01:48,715 [salt.state       ][INFO    ][9975] Executing state file.managed for /etc/systemd/system/mysql.service.d/override.conf
2018-01-14 01:01:48,722 [salt.state       ][INFO    ][9975] File changed:
New file
2018-01-14 01:01:48,722 [salt.state       ][INFO    ][9975] Completed state [/etc/systemd/system/mysql.service.d/override.conf] at time 01:01:48.722843 duration_in_ms=8.262
2018-01-14 01:01:48,724 [salt.state       ][INFO    ][9975] Running state [service.systemctl_reload] at time 01:01:48.724142
2018-01-14 01:01:48,724 [salt.state       ][INFO    ][9975] Executing state module.wait for service.systemctl_reload
2018-01-14 01:01:48,724 [salt.state       ][INFO    ][9975] No changes made for service.systemctl_reload
2018-01-14 01:01:48,725 [salt.state       ][INFO    ][9975] Completed state [service.systemctl_reload] at time 01:01:48.725249 duration_in_ms=1.107
2018-01-14 01:01:48,725 [salt.state       ][INFO    ][9975] Running state [service.systemctl_reload] at time 01:01:48.725609
2018-01-14 01:01:48,725 [salt.state       ][INFO    ][9975] Executing state module.mod_watch for service.systemctl_reload
2018-01-14 01:01:48,726 [salt.loaded.int.module.cmdmod][INFO    ][9975] Executing command ['systemctl', '--system', 'daemon-reload'] in directory '/root'
2018-01-14 01:01:48,872 [salt.state       ][INFO    ][9975] {'ret': True}
2018-01-14 01:01:48,874 [salt.state       ][INFO    ][9975] Completed state [service.systemctl_reload] at time 01:01:48.874105 duration_in_ms=148.495
2018-01-14 01:01:48,876 [salt.state       ][INFO    ][9975] Running state [/etc/mysql/debian.cnf] at time 01:01:48.876725
2018-01-14 01:01:48,877 [salt.state       ][INFO    ][9975] Executing state file.managed for /etc/mysql/debian.cnf
2018-01-14 01:01:48,909 [salt.fileclient  ][INFO    ][9975] Fetching file from saltenv 'base', ** done ** 'galera/files/debian.cnf'
2018-01-14 01:01:48,969 [salt.state       ][INFO    ][9975] File changed:
--- 
+++ 
@@ -1,12 +1,13 @@
-# Automatically generated for Debian scripts. DO NOT TOUCH!
+
 [client]
-host     = localhost
-user     = debian-sys-maint
-password = cMet7CxjU7o8PkIM
-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 = cMet7CxjU7o8PkIM
-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

2018-01-14 01:01:48,971 [salt.state       ][INFO    ][9975] Completed state [/etc/mysql/debian.cnf] at time 01:01:48.971059 duration_in_ms=94.333
2018-01-14 01:01:48,971 [salt.state       ][INFO    ][9975] Running state [/usr/local/sbin/galera_init.sh] at time 01:01:48.971698
2018-01-14 01:01:48,972 [salt.state       ][INFO    ][9975] Executing state file.managed for /usr/local/sbin/galera_init.sh
2018-01-14 01:01:49,000 [salt.fileclient  ][INFO    ][9975] Fetching file from saltenv 'base', ** done ** 'galera/files/init_bootstrap.sh'
2018-01-14 01:01:49,006 [salt.state       ][INFO    ][9975] File changed:
New file
2018-01-14 01:01:49,006 [salt.state       ][INFO    ][9975] Completed state [/usr/local/sbin/galera_init.sh] at time 01:01:49.006822 duration_in_ms=35.124
2018-01-14 01:01:49,007 [salt.state       ][INFO    ][9975] Running state [/usr/local/sbin/galera_bootstrap.sh] at time 01:01:49.007232
2018-01-14 01:01:49,007 [salt.state       ][INFO    ][9975] Executing state file.managed for /usr/local/sbin/galera_bootstrap.sh
2018-01-14 01:01:49,042 [salt.fileclient  ][INFO    ][9975] Fetching file from saltenv 'base', ** done ** 'galera/files/bootstrap.sh'
2018-01-14 01:01:49,048 [salt.state       ][INFO    ][9975] File changed:
New file
2018-01-14 01:01:49,048 [salt.state       ][INFO    ][9975] Completed state [/usr/local/sbin/galera_bootstrap.sh] at time 01:01:49.048332 duration_in_ms=41.099
2018-01-14 01:01:49,053 [salt.state       ][INFO    ][9975] Running state [/usr/local/sbin/galera_init.sh] at time 01:01:49.053291
2018-01-14 01:01:49,053 [salt.state       ][INFO    ][9975] Executing state cmd.run for /usr/local/sbin/galera_init.sh
2018-01-14 01:01:49,054 [salt.loaded.int.module.cmdmod][INFO    ][9975] Executing command '/usr/local/sbin/galera_init.sh' in directory '/root'
2018-01-14 01:01:52,899 [salt.minion      ][INFO    ][2613] User sudo_ubuntu Executing command saltutil.find_job with jid 20180114010152013705
2018-01-14 01:01:52,923 [salt.minion      ][INFO    ][18069] Starting a new job with PID 18069
2018-01-14 01:01:52,951 [salt.minion      ][INFO    ][18069] Returning information for job: 20180114010152013705
2018-01-14 01:01:53,307 [salt.state       ][INFO    ][9975] {'pid': 17612, 'retcode': 0, 'stderr': '', 'stdout': 'Sucessfully connected to the MySQL service (0 retries).'}
2018-01-14 01:01:53,308 [salt.state       ][INFO    ][9975] Completed state [/usr/local/sbin/galera_init.sh] at time 01:01:53.307974 duration_in_ms=4254.682
2018-01-14 01:01:53,311 [salt.state       ][INFO    ][9975] Running state [mysqladmin password "opnfv_secret"] at time 01:01:53.311674
2018-01-14 01:01:53,312 [salt.state       ][INFO    ][9975] Executing state cmd.run for mysqladmin password "opnfv_secret"
2018-01-14 01:01:53,314 [salt.loaded.int.module.cmdmod][INFO    ][9975] Executing command 'mysqladmin password "opnfv_secret"' in directory '/root'
2018-01-14 01:01:53,346 [salt.state       ][INFO    ][9975] {'pid': 18076, 'retcode': 0, 'stderr': 'Warning: Using a password on the command line interface can be insecure.', 'stdout': ''}
2018-01-14 01:01:53,347 [salt.state       ][INFO    ][9975] Completed state [mysqladmin password "opnfv_secret"] at time 01:01:53.347049 duration_in_ms=35.375
2018-01-14 01:01:53,350 [salt.state       ][INFO    ][9975] Running state [mysql -u root -popnfv_secret -e "GRANT ALL PRIVILEGES ON *.* TO 'debian-sys-maint'@'localhost' IDENTIFIED BY 'opnfv_secret';"] at time 01:01:53.350114
2018-01-14 01:01:53,350 [salt.state       ][INFO    ][9975] Executing state cmd.run for mysql -u root -popnfv_secret -e "GRANT ALL PRIVILEGES ON *.* TO 'debian-sys-maint'@'localhost' IDENTIFIED BY 'opnfv_secret';"
2018-01-14 01:01:53,352 [salt.loaded.int.module.cmdmod][INFO    ][9975] Executing command 'mysql -u root -popnfv_secret -e "GRANT ALL PRIVILEGES ON *.* TO 'debian-sys-maint'@'localhost' IDENTIFIED BY 'opnfv_secret';"' in directory '/root'
2018-01-14 01:01:53,380 [salt.state       ][INFO    ][9975] {'pid': 18078, 'retcode': 0, 'stderr': 'Warning: Using a password on the command line interface can be insecure.', 'stdout': ''}
2018-01-14 01:01:53,381 [salt.state       ][INFO    ][9975] Completed state [mysql -u root -popnfv_secret -e "GRANT ALL PRIVILEGES ON *.* TO 'debian-sys-maint'@'localhost' IDENTIFIED BY 'opnfv_secret';"] at time 01:01:53.381523 duration_in_ms=31.409
2018-01-14 01:01:53,386 [salt.state       ][INFO    ][9975] Running state [mysql] at time 01:01:53.386306
2018-01-14 01:01:53,386 [salt.state       ][INFO    ][9975] Executing state service.dead for mysql
2018-01-14 01:01:53,388 [salt.loaded.int.module.cmdmod][INFO    ][9975] Executing command ['systemctl', 'status', 'mysql.service', '-n', '0'] in directory '/root'
2018-01-14 01:01:53,416 [salt.loaded.int.module.cmdmod][INFO    ][9975] Executing command ['systemctl', 'is-active', 'mysql.service'] in directory '/root'
2018-01-14 01:01:53,438 [salt.loaded.int.module.cmdmod][INFO    ][9975] Executing command ['systemctl', 'is-enabled', 'mysql.service'] in directory '/root'
2018-01-14 01:01:53,467 [salt.loaded.int.module.cmdmod][INFO    ][9975] Executing command ['systemd-run', '--scope', 'systemctl', 'stop', 'mysql.service'] in directory '/root'
2018-01-14 01:02:02,922 [salt.minion      ][INFO    ][2613] User sudo_ubuntu Executing command saltutil.find_job with jid 20180114010202034319
2018-01-14 01:02:02,945 [salt.minion      ][INFO    ][18177] Starting a new job with PID 18177
2018-01-14 01:02:02,973 [salt.minion      ][INFO    ][18177] Returning information for job: 20180114010202034319
2018-01-14 01:02:12,939 [salt.minion      ][INFO    ][2613] User sudo_ubuntu Executing command saltutil.find_job with jid 20180114010212053170
2018-01-14 01:02:12,963 [salt.minion      ][INFO    ][18182] Starting a new job with PID 18182
2018-01-14 01:02:12,991 [salt.minion      ][INFO    ][18182] Returning information for job: 20180114010212053170
2018-01-14 01:02:22,965 [salt.minion      ][INFO    ][2613] User sudo_ubuntu Executing command saltutil.find_job with jid 20180114010222080791
2018-01-14 01:02:22,991 [salt.minion      ][INFO    ][18187] Starting a new job with PID 18187
2018-01-14 01:02:23,019 [salt.minion      ][INFO    ][18187] Returning information for job: 20180114010222080791
2018-01-14 01:02:32,991 [salt.minion      ][INFO    ][2613] User sudo_ubuntu Executing command saltutil.find_job with jid 20180114010232106627
2018-01-14 01:02:33,013 [salt.minion      ][INFO    ][18192] Starting a new job with PID 18192
2018-01-14 01:02:33,039 [salt.minion      ][INFO    ][18192] Returning information for job: 20180114010232106627
2018-01-14 01:02:43,018 [salt.minion      ][INFO    ][2613] User sudo_ubuntu Executing command saltutil.find_job with jid 20180114010242133718
2018-01-14 01:02:43,039 [salt.minion      ][INFO    ][18197] Starting a new job with PID 18197
2018-01-14 01:02:43,069 [salt.minion      ][INFO    ][18197] Returning information for job: 20180114010242133718
2018-01-14 01:02:53,047 [salt.minion      ][INFO    ][2613] User sudo_ubuntu Executing command saltutil.find_job with jid 20180114010252163397
2018-01-14 01:02:53,069 [salt.minion      ][INFO    ][18202] Starting a new job with PID 18202
2018-01-14 01:02:53,097 [salt.minion      ][INFO    ][18202] Returning information for job: 20180114010252163397
2018-01-14 01:03:03,080 [salt.minion      ][INFO    ][2613] User sudo_ubuntu Executing command saltutil.find_job with jid 20180114010302197473
2018-01-14 01:03:03,101 [salt.minion      ][INFO    ][18207] Starting a new job with PID 18207
2018-01-14 01:03:03,128 [salt.minion      ][INFO    ][18207] Returning information for job: 20180114010302197473
2018-01-14 01:03:13,119 [salt.minion      ][INFO    ][2613] User sudo_ubuntu Executing command saltutil.find_job with jid 20180114010312234021
2018-01-14 01:03:13,141 [salt.minion      ][INFO    ][18222] Starting a new job with PID 18222
2018-01-14 01:03:13,170 [salt.minion      ][INFO    ][18222] Returning information for job: 20180114010312234021
2018-01-14 01:03:23,189 [salt.minion      ][INFO    ][2613] User sudo_ubuntu Executing command saltutil.find_job with jid 20180114010322305925
2018-01-14 01:03:23,211 [salt.minion      ][INFO    ][18227] Starting a new job with PID 18227
2018-01-14 01:03:23,240 [salt.minion      ][INFO    ][18227] Returning information for job: 20180114010322305925
2018-01-14 01:03:33,236 [salt.minion      ][INFO    ][2613] User sudo_ubuntu Executing command saltutil.find_job with jid 20180114010332352221
2018-01-14 01:03:33,259 [salt.minion      ][INFO    ][18232] Starting a new job with PID 18232
2018-01-14 01:03:33,287 [salt.minion      ][INFO    ][18232] Returning information for job: 20180114010332352221
2018-01-14 01:03:43,279 [salt.minion      ][INFO    ][2613] User sudo_ubuntu Executing command saltutil.find_job with jid 20180114010342398151
2018-01-14 01:03:43,302 [salt.minion      ][INFO    ][18237] Starting a new job with PID 18237
2018-01-14 01:03:43,355 [salt.minion      ][INFO    ][18237] Returning information for job: 20180114010342398151
2018-01-14 01:03:53,349 [salt.minion      ][INFO    ][2613] User sudo_ubuntu Executing command saltutil.find_job with jid 20180114010352466947
2018-01-14 01:03:53,372 [salt.minion      ][INFO    ][18242] Starting a new job with PID 18242
2018-01-14 01:03:53,400 [salt.minion      ][INFO    ][18242] Returning information for job: 20180114010352466947
2018-01-14 01:04:03,396 [salt.minion      ][INFO    ][2613] User sudo_ubuntu Executing command saltutil.find_job with jid 20180114010402516727
2018-01-14 01:04:03,422 [salt.minion      ][INFO    ][18247] Starting a new job with PID 18247
2018-01-14 01:04:03,453 [salt.minion      ][INFO    ][18247] Returning information for job: 20180114010402516727
2018-01-14 01:04:13,450 [salt.minion      ][INFO    ][2613] User sudo_ubuntu Executing command saltutil.find_job with jid 20180114010412570429
2018-01-14 01:04:13,472 [salt.minion      ][INFO    ][18252] Starting a new job with PID 18252
2018-01-14 01:04:13,505 [salt.minion      ][INFO    ][18252] Returning information for job: 20180114010412570429
2018-01-14 01:04:23,505 [salt.minion      ][INFO    ][2613] User sudo_ubuntu Executing command saltutil.find_job with jid 20180114010422626298
2018-01-14 01:04:23,526 [salt.minion      ][INFO    ][18257] Starting a new job with PID 18257
2018-01-14 01:04:23,554 [salt.minion      ][INFO    ][18257] Returning information for job: 20180114010422626298
2018-01-14 01:04:33,561 [salt.minion      ][INFO    ][2613] User sudo_ubuntu Executing command saltutil.find_job with jid 20180114010432682319
2018-01-14 01:04:33,585 [salt.minion      ][INFO    ][18262] Starting a new job with PID 18262
2018-01-14 01:04:33,611 [salt.minion      ][INFO    ][18262] Returning information for job: 20180114010432682319
2018-01-14 01:04:43,625 [salt.minion      ][INFO    ][2613] User sudo_ubuntu Executing command saltutil.find_job with jid 20180114010442745942
2018-01-14 01:04:43,649 [salt.minion      ][INFO    ][18267] Starting a new job with PID 18267
2018-01-14 01:04:43,679 [salt.minion      ][INFO    ][18267] Returning information for job: 20180114010442745942
2018-01-14 01:04:53,702 [salt.minion      ][INFO    ][2613] User sudo_ubuntu Executing command saltutil.find_job with jid 20180114010452822754
2018-01-14 01:04:53,726 [salt.minion      ][INFO    ][18272] Starting a new job with PID 18272
2018-01-14 01:04:53,752 [salt.minion      ][INFO    ][18272] Returning information for job: 20180114010452822754
2018-01-14 01:05:03,774 [salt.minion      ][INFO    ][2613] User sudo_ubuntu Executing command saltutil.find_job with jid 20180114010502895604
2018-01-14 01:05:03,795 [salt.minion      ][INFO    ][18277] Starting a new job with PID 18277
2018-01-14 01:05:03,822 [salt.minion      ][INFO    ][18277] Returning information for job: 20180114010502895604
2018-01-14 01:05:13,848 [salt.minion      ][INFO    ][2613] User sudo_ubuntu Executing command saltutil.find_job with jid 20180114010512971166
2018-01-14 01:05:13,869 [salt.minion      ][INFO    ][18282] Starting a new job with PID 18282
2018-01-14 01:05:13,899 [salt.minion      ][INFO    ][18282] Returning information for job: 20180114010512971166
2018-01-14 01:05:23,932 [salt.minion      ][INFO    ][2613] User sudo_ubuntu Executing command saltutil.find_job with jid 20180114010523055033
2018-01-14 01:05:23,955 [salt.minion      ][INFO    ][18287] Starting a new job with PID 18287
2018-01-14 01:05:23,984 [salt.minion      ][INFO    ][18287] Returning information for job: 20180114010523055033
2018-01-14 01:05:34,018 [salt.minion      ][INFO    ][2613] User sudo_ubuntu Executing command saltutil.find_job with jid 20180114010533140185
2018-01-14 01:05:34,042 [salt.minion      ][INFO    ][18292] Starting a new job with PID 18292
2018-01-14 01:05:34,070 [salt.minion      ][INFO    ][18292] Returning information for job: 20180114010533140185
2018-01-14 01:05:44,105 [salt.minion      ][INFO    ][2613] User sudo_ubuntu Executing command saltutil.find_job with jid 20180114010543229359
2018-01-14 01:05:44,129 [salt.minion      ][INFO    ][18297] Starting a new job with PID 18297
2018-01-14 01:05:44,157 [salt.minion      ][INFO    ][18297] Returning information for job: 20180114010543229359
2018-01-14 01:05:54,199 [salt.minion      ][INFO    ][2613] User sudo_ubuntu Executing command saltutil.find_job with jid 20180114010553322109
2018-01-14 01:05:54,221 [salt.minion      ][INFO    ][18302] Starting a new job with PID 18302
2018-01-14 01:05:54,251 [salt.minion      ][INFO    ][18302] Returning information for job: 20180114010553322109
2018-01-14 01:06:04,294 [salt.minion      ][INFO    ][2613] User sudo_ubuntu Executing command saltutil.find_job with jid 20180114010603418587
2018-01-14 01:06:04,318 [salt.minion      ][INFO    ][18307] Starting a new job with PID 18307
2018-01-14 01:06:04,347 [salt.minion      ][INFO    ][18307] Returning information for job: 20180114010603418587
2018-01-14 01:06:14,393 [salt.minion      ][INFO    ][2613] User sudo_ubuntu Executing command saltutil.find_job with jid 20180114010613518014
2018-01-14 01:06:14,418 [salt.minion      ][INFO    ][18312] Starting a new job with PID 18312
2018-01-14 01:06:14,447 [salt.minion      ][INFO    ][18312] Returning information for job: 20180114010613518014
2018-01-14 01:06:24,496 [salt.minion      ][INFO    ][2613] User sudo_ubuntu Executing command saltutil.find_job with jid 20180114010623622504
2018-01-14 01:06:24,521 [salt.minion      ][INFO    ][18317] Starting a new job with PID 18317
2018-01-14 01:06:24,553 [salt.minion      ][INFO    ][18317] Returning information for job: 20180114010623622504
2018-01-14 01:06:34,607 [salt.minion      ][INFO    ][2613] User sudo_ubuntu Executing command saltutil.find_job with jid 20180114010633732595
2018-01-14 01:06:34,630 [salt.minion      ][INFO    ][18322] Starting a new job with PID 18322
2018-01-14 01:06:34,658 [salt.minion      ][INFO    ][18322] Returning information for job: 20180114010633732595
2018-01-14 01:06:44,722 [salt.minion      ][INFO    ][2613] User sudo_ubuntu Executing command saltutil.find_job with jid 20180114010643848881
2018-01-14 01:06:44,744 [salt.minion      ][INFO    ][18327] Starting a new job with PID 18327
2018-01-14 01:06:44,772 [salt.minion      ][INFO    ][18327] Returning information for job: 20180114010643848881
2018-01-14 01:06:54,845 [salt.minion      ][INFO    ][2613] User sudo_ubuntu Executing command saltutil.find_job with jid 20180114010653971898
2018-01-14 01:06:54,870 [salt.minion      ][INFO    ][18332] Starting a new job with PID 18332
2018-01-14 01:06:54,899 [salt.minion      ][INFO    ][18332] Returning information for job: 20180114010653971898
2018-01-14 01:07:04,967 [salt.minion      ][INFO    ][2613] User sudo_ubuntu Executing command saltutil.find_job with jid 20180114010704094705
2018-01-14 01:07:04,989 [salt.minion      ][INFO    ][18337] Starting a new job with PID 18337
2018-01-14 01:07:05,017 [salt.minion      ][INFO    ][18337] Returning information for job: 20180114010704094705
2018-01-14 01:07:15,096 [salt.minion      ][INFO    ][2613] User sudo_ubuntu Executing command saltutil.find_job with jid 20180114010714224085
2018-01-14 01:07:15,119 [salt.minion      ][INFO    ][18352] Starting a new job with PID 18352
2018-01-14 01:07:15,147 [salt.minion      ][INFO    ][18352] Returning information for job: 20180114010714224085
2018-01-14 01:07:25,225 [salt.minion      ][INFO    ][2613] User sudo_ubuntu Executing command saltutil.find_job with jid 20180114010724354094
2018-01-14 01:07:25,248 [salt.minion      ][INFO    ][18357] Starting a new job with PID 18357
2018-01-14 01:07:25,275 [salt.minion      ][INFO    ][18357] Returning information for job: 20180114010724354094
2018-01-14 01:07:35,364 [salt.minion      ][INFO    ][2613] User sudo_ubuntu Executing command saltutil.find_job with jid 20180114010734493178
2018-01-14 01:07:35,386 [salt.minion      ][INFO    ][18362] Starting a new job with PID 18362
2018-01-14 01:07:35,412 [salt.minion      ][INFO    ][18362] Returning information for job: 20180114010734493178
2018-01-14 01:07:45,509 [salt.minion      ][INFO    ][2613] User sudo_ubuntu Executing command saltutil.find_job with jid 20180114010744638211
2018-01-14 01:07:45,531 [salt.minion      ][INFO    ][18367] Starting a new job with PID 18367
2018-01-14 01:07:45,558 [salt.minion      ][INFO    ][18367] Returning information for job: 20180114010744638211
2018-01-14 01:07:55,661 [salt.minion      ][INFO    ][2613] User sudo_ubuntu Executing command saltutil.find_job with jid 20180114010754790534
2018-01-14 01:07:55,683 [salt.minion      ][INFO    ][18372] Starting a new job with PID 18372
2018-01-14 01:07:55,712 [salt.minion      ][INFO    ][18372] Returning information for job: 20180114010754790534
2018-01-14 01:08:05,827 [salt.minion      ][INFO    ][2613] User sudo_ubuntu Executing command saltutil.find_job with jid 20180114010804956815
2018-01-14 01:08:05,849 [salt.minion      ][INFO    ][18377] Starting a new job with PID 18377
2018-01-14 01:08:05,878 [salt.minion      ][INFO    ][18377] Returning information for job: 20180114010804956815
2018-01-14 01:08:15,985 [salt.minion      ][INFO    ][2613] User sudo_ubuntu Executing command saltutil.find_job with jid 20180114010815115499
2018-01-14 01:08:16,008 [salt.minion      ][INFO    ][18382] Starting a new job with PID 18382
2018-01-14 01:08:16,035 [salt.minion      ][INFO    ][18382] Returning information for job: 20180114010815115499
2018-01-14 01:08:26,164 [salt.minion      ][INFO    ][2613] User sudo_ubuntu Executing command saltutil.find_job with jid 20180114010825294785
2018-01-14 01:08:26,186 [salt.minion      ][INFO    ][18387] Starting a new job with PID 18387
2018-01-14 01:08:26,216 [salt.minion      ][INFO    ][18387] Returning information for job: 20180114010825294785
2018-01-14 01:08:36,335 [salt.minion      ][INFO    ][2613] User sudo_ubuntu Executing command saltutil.find_job with jid 20180114010835466712
2018-01-14 01:08:36,357 [salt.minion      ][INFO    ][18392] Starting a new job with PID 18392
2018-01-14 01:08:36,389 [salt.minion      ][INFO    ][18392] Returning information for job: 20180114010835466712
2018-01-14 01:08:46,513 [salt.minion      ][INFO    ][2613] User sudo_ubuntu Executing command saltutil.find_job with jid 20180114010845644036
2018-01-14 01:08:46,536 [salt.minion      ][INFO    ][18397] Starting a new job with PID 18397
2018-01-14 01:08:46,564 [salt.minion      ][INFO    ][18397] Returning information for job: 20180114010845644036
2018-01-14 01:08:56,701 [salt.minion      ][INFO    ][2613] User sudo_ubuntu Executing command saltutil.find_job with jid 20180114010855833850
2018-01-14 01:08:56,724 [salt.minion      ][INFO    ][18402] Starting a new job with PID 18402
2018-01-14 01:08:56,755 [salt.minion      ][INFO    ][18402] Returning information for job: 20180114010855833850
2018-01-14 01:09:06,900 [salt.minion      ][INFO    ][2613] User sudo_ubuntu Executing command saltutil.find_job with jid 20180114010906023788
2018-01-14 01:09:06,923 [salt.minion      ][INFO    ][18407] Starting a new job with PID 18407
2018-01-14 01:09:06,954 [salt.minion      ][INFO    ][18407] Returning information for job: 20180114010906023788
2018-01-14 01:09:17,092 [salt.minion      ][INFO    ][2613] User sudo_ubuntu Executing command saltutil.find_job with jid 20180114010916227023
2018-01-14 01:09:17,115 [salt.minion      ][INFO    ][18412] Starting a new job with PID 18412
2018-01-14 01:09:17,146 [salt.minion      ][INFO    ][18412] Returning information for job: 20180114010916227023
2018-01-14 01:09:27,296 [salt.minion      ][INFO    ][2613] User sudo_ubuntu Executing command saltutil.find_job with jid 20180114010926430258
2018-01-14 01:09:27,319 [salt.minion      ][INFO    ][18417] Starting a new job with PID 18417
2018-01-14 01:09:27,350 [salt.minion      ][INFO    ][18417] Returning information for job: 20180114010926430258
2018-01-14 01:09:37,507 [salt.minion      ][INFO    ][2613] User sudo_ubuntu Executing command saltutil.find_job with jid 20180114010936641171
2018-01-14 01:09:37,530 [salt.minion      ][INFO    ][18422] Starting a new job with PID 18422
2018-01-14 01:09:37,558 [salt.minion      ][INFO    ][18422] Returning information for job: 20180114010936641171
2018-01-14 01:09:47,725 [salt.minion      ][INFO    ][2613] User sudo_ubuntu Executing command saltutil.find_job with jid 20180114010946859249
2018-01-14 01:09:47,749 [salt.minion      ][INFO    ][18427] Starting a new job with PID 18427
2018-01-14 01:09:47,776 [salt.minion      ][INFO    ][18427] Returning information for job: 20180114010946859249
2018-01-14 01:09:57,955 [salt.minion      ][INFO    ][2613] User sudo_ubuntu Executing command saltutil.find_job with jid 20180114010957088478
2018-01-14 01:09:57,978 [salt.minion      ][INFO    ][18432] Starting a new job with PID 18432
2018-01-14 01:09:58,005 [salt.minion      ][INFO    ][18432] Returning information for job: 20180114010957088478
2018-01-14 01:10:07,977 [salt.minion      ][INFO    ][2613] User sudo_ubuntu Executing command saltutil.find_job with jid 20180114011007111945
2018-01-14 01:10:08,000 [salt.minion      ][INFO    ][18437] Starting a new job with PID 18437
2018-01-14 01:10:08,028 [salt.minion      ][INFO    ][18437] Returning information for job: 20180114011007111945
2018-01-14 01:10:18,005 [salt.minion      ][INFO    ][2613] User sudo_ubuntu Executing command saltutil.find_job with jid 20180114011017140864
2018-01-14 01:10:18,028 [salt.minion      ][INFO    ][18442] Starting a new job with PID 18442
2018-01-14 01:10:18,056 [salt.minion      ][INFO    ][18442] Returning information for job: 20180114011017140864
2018-01-14 01:10:28,031 [salt.minion      ][INFO    ][2613] User sudo_ubuntu Executing command saltutil.find_job with jid 20180114011027167976
2018-01-14 01:10:28,054 [salt.minion      ][INFO    ][18447] Starting a new job with PID 18447
2018-01-14 01:10:28,083 [salt.minion      ][INFO    ][18447] Returning information for job: 20180114011027167976
2018-01-14 01:10:38,064 [salt.minion      ][INFO    ][2613] User sudo_ubuntu Executing command saltutil.find_job with jid 20180114011037201541
2018-01-14 01:10:38,087 [salt.minion      ][INFO    ][18452] Starting a new job with PID 18452
2018-01-14 01:10:38,115 [salt.minion      ][INFO    ][18452] Returning information for job: 20180114011037201541
2018-01-14 01:10:48,111 [salt.minion      ][INFO    ][2613] User sudo_ubuntu Executing command saltutil.find_job with jid 20180114011047248493
2018-01-14 01:10:48,133 [salt.minion      ][INFO    ][18457] Starting a new job with PID 18457
2018-01-14 01:10:48,161 [salt.minion      ][INFO    ][18457] Returning information for job: 20180114011047248493
2018-01-14 01:10:58,169 [salt.minion      ][INFO    ][2613] User sudo_ubuntu Executing command saltutil.find_job with jid 20180114011057307049
2018-01-14 01:10:58,190 [salt.minion      ][INFO    ][18462] Starting a new job with PID 18462
2018-01-14 01:10:58,218 [salt.minion      ][INFO    ][18462] Returning information for job: 20180114011057307049
2018-01-14 01:11:08,230 [salt.minion      ][INFO    ][2613] User sudo_ubuntu Executing command saltutil.find_job with jid 20180114011107368362
2018-01-14 01:11:08,253 [salt.minion      ][INFO    ][18467] Starting a new job with PID 18467
2018-01-14 01:11:08,282 [salt.minion      ][INFO    ][18467] Returning information for job: 20180114011107368362
2018-01-14 01:11:18,299 [salt.minion      ][INFO    ][2613] User sudo_ubuntu Executing command saltutil.find_job with jid 20180114011117438245
2018-01-14 01:11:18,322 [salt.minion      ][INFO    ][18472] Starting a new job with PID 18472
2018-01-14 01:11:18,352 [salt.minion      ][INFO    ][18472] Returning information for job: 20180114011117438245
2018-01-14 01:11:28,375 [salt.minion      ][INFO    ][2613] User sudo_ubuntu Executing command saltutil.find_job with jid 20180114011127514826
2018-01-14 01:11:28,400 [salt.minion      ][INFO    ][18477] Starting a new job with PID 18477
2018-01-14 01:11:28,430 [salt.minion      ][INFO    ][18477] Returning information for job: 20180114011127514826
2018-01-14 01:11:38,465 [salt.minion      ][INFO    ][2613] User sudo_ubuntu Executing command saltutil.find_job with jid 20180114011137604787
2018-01-14 01:11:38,487 [salt.minion      ][INFO    ][18492] Starting a new job with PID 18492
2018-01-14 01:11:38,515 [salt.minion      ][INFO    ][18492] Returning information for job: 20180114011137604787
2018-01-14 01:11:48,564 [salt.minion      ][INFO    ][2613] User sudo_ubuntu Executing command saltutil.find_job with jid 20180114011147702551
2018-01-14 01:11:48,586 [salt.minion      ][INFO    ][18497] Starting a new job with PID 18497
2018-01-14 01:11:48,614 [salt.minion      ][INFO    ][18497] Returning information for job: 20180114011147702551
2018-01-14 01:11:53,658 [salt.loaded.int.module.cmdmod][INFO    ][9975] Executing command ['systemctl', 'is-active', 'mysql.service'] in directory '/root'
2018-01-14 01:11:53,683 [salt.loaded.int.module.cmdmod][INFO    ][9975] Executing command ['systemctl', 'is-enabled', 'mysql.service'] in directory '/root'
2018-01-14 01:11:53,717 [salt.state       ][INFO    ][9975] {'mysql': False}
2018-01-14 01:11:53,718 [salt.state       ][INFO    ][9975] Completed state [mysql] at time 01:11:53.718589 duration_in_ms=600332.283
2018-01-14 01:11:53,722 [salt.state       ][INFO    ][9975] Running state [/etc/mysql/my.cnf] at time 01:11:53.722186
2018-01-14 01:11:53,722 [salt.state       ][INFO    ][9975] Executing state file.managed for /etc/mysql/my.cnf
2018-01-14 01:11:53,763 [salt.fileclient  ][INFO    ][9975] Fetching file from saltenv 'base', ** done ** 'galera/files/my.cnf'
2018-01-14 01:11:53,835 [salt.state       ][INFO    ][9975] 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

2018-01-14 01:11:53,836 [salt.state       ][INFO    ][9975] Completed state [/etc/mysql/my.cnf] at time 01:11:53.835998 duration_in_ms=113.811
2018-01-14 01:11:53,837 [salt.state       ][INFO    ][9975] Running state [/usr/local/sbin/galera_bootstrap.sh] at time 01:11:53.837620
2018-01-14 01:11:53,837 [salt.state       ][INFO    ][9975] Executing state cmd.run for /usr/local/sbin/galera_bootstrap.sh
2018-01-14 01:11:53,838 [salt.loaded.int.module.cmdmod][INFO    ][9975] Executing command '/usr/local/sbin/galera_bootstrap.sh' in directory '/root'
2018-01-14 01:11:58,669 [salt.minion      ][INFO    ][2613] User sudo_ubuntu Executing command saltutil.find_job with jid 20180114011157809723
2018-01-14 01:11:58,696 [salt.minion      ][INFO    ][19264] Starting a new job with PID 19264
2018-01-14 01:11:58,727 [salt.minion      ][INFO    ][19264] Returning information for job: 20180114011157809723
2018-01-14 01:12:08,787 [salt.minion      ][INFO    ][2613] User sudo_ubuntu Executing command saltutil.find_job with jid 20180114011207927046
2018-01-14 01:12:08,810 [salt.minion      ][INFO    ][19613] Starting a new job with PID 19613
2018-01-14 01:12:08,838 [salt.minion      ][INFO    ][19613] Returning information for job: 20180114011207927046
2018-01-14 01:12:18,914 [salt.minion      ][INFO    ][2613] User sudo_ubuntu Executing command saltutil.find_job with jid 20180114011218051547
2018-01-14 01:12:18,937 [salt.minion      ][INFO    ][19638] Starting a new job with PID 19638
2018-01-14 01:12:18,970 [salt.minion      ][INFO    ][19638] Returning information for job: 20180114011218051547
2018-01-14 01:12:29,048 [salt.minion      ][INFO    ][2613] User sudo_ubuntu Executing command saltutil.find_job with jid 20180114011228188476
2018-01-14 01:12:29,072 [salt.minion      ][INFO    ][19724] Starting a new job with PID 19724
2018-01-14 01:12:29,104 [salt.minion      ][INFO    ][19724] Returning information for job: 20180114011228188476
2018-01-14 01:12:29,549 [salt.state       ][INFO    ][9975] {'pid': 18521, '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.", 'stdout': 'Sucessfully connected to the MySQL service (1 retries).'}
2018-01-14 01:12:29,550 [salt.state       ][INFO    ][9975] Completed state [/usr/local/sbin/galera_bootstrap.sh] at time 01:12:29.549984 duration_in_ms=35712.362
2018-01-14 01:12:29,553 [salt.state       ][INFO    ][9975] Running state [/var/lib/mysql/.galera_bootstrap] at time 01:12:29.553506
2018-01-14 01:12:29,554 [salt.state       ][INFO    ][9975] Executing state file.touch for /var/lib/mysql/.galera_bootstrap
2018-01-14 01:12:29,555 [salt.state       ][INFO    ][9975] {'new': '/var/lib/mysql/.galera_bootstrap'}
2018-01-14 01:12:29,556 [salt.state       ][INFO    ][9975] Completed state [/var/lib/mysql/.galera_bootstrap] at time 01:12:29.556080 duration_in_ms=2.574
2018-01-14 01:12:30,303 [salt.loaded.int.module.cmdmod][INFO    ][9975] Executing command ['git', '--version'] in directory '/root'
2018-01-14 01:12:30,745 [salt.state       ][INFO    ][9975] Running state [/etc/mysql/my.cnf] at time 01:12:30.745823
2018-01-14 01:12:30,746 [salt.state       ][INFO    ][9975] Executing state file.managed for /etc/mysql/my.cnf
2018-01-14 01:12:30,841 [salt.state       ][INFO    ][9975] File /etc/mysql/my.cnf is in the correct state
2018-01-14 01:12:30,841 [salt.state       ][INFO    ][9975] Completed state [/etc/mysql/my.cnf] at time 01:12:30.841641 duration_in_ms=95.819
2018-01-14 01:12:30,844 [salt.state       ][INFO    ][9975] Running state [mysql] at time 01:12:30.844046
2018-01-14 01:12:30,844 [salt.state       ][INFO    ][9975] Executing state service.running for mysql
2018-01-14 01:12:30,845 [salt.loaded.int.module.cmdmod][INFO    ][9975] Executing command ['systemctl', 'is-active', 'mysql.service'] in directory '/root'
2018-01-14 01:12:30,873 [salt.loaded.int.module.cmdmod][INFO    ][9975] Executing command ['systemctl', 'is-enabled', 'mysql.service'] in directory '/root'
2018-01-14 01:12:30,902 [salt.loaded.int.module.cmdmod][INFO    ][9975] Executing command ['systemctl', 'is-enabled', 'mysql.service'] in directory '/root'
2018-01-14 01:12:30,940 [salt.loaded.int.module.cmdmod][INFO    ][9975] Executing command ['systemctl', 'is-enabled', 'mysql.service'] in directory '/root'
2018-01-14 01:12:30,977 [salt.loaded.int.module.cmdmod][INFO    ][9975] Executing command ['systemd-run', '--scope', 'systemctl', 'enable', 'mysql.service'] in directory '/root'
2018-01-14 01:12:31,528 [salt.loaded.int.module.cmdmod][INFO    ][9975] Executing command ['systemctl', 'is-enabled', 'mysql.service'] in directory '/root'
2018-01-14 01:12:31,557 [salt.state       ][INFO    ][9975] {'mysql': True}
2018-01-14 01:12:31,559 [salt.state       ][INFO    ][9975] Completed state [mysql] at time 01:12:31.559029 duration_in_ms=714.982
2018-01-14 01:12:31,560 [salt.state       ][INFO    ][9975] Running state [ceilometer] at time 01:12:31.559977
2018-01-14 01:12:31,560 [salt.state       ][INFO    ][9975] Executing state mysql_database.present for ceilometer
2018-01-14 01:12:31,574 [salt.state       ][INFO    ][9975] Database ceilometer is already present
2018-01-14 01:12:31,575 [salt.state       ][INFO    ][9975] Completed state [ceilometer] at time 01:12:31.575275 duration_in_ms=15.298
2018-01-14 01:12:31,575 [salt.state       ][INFO    ][9975] Running state [ceilometer] at time 01:12:31.575765
2018-01-14 01:12:31,576 [salt.state       ][INFO    ][9975] Executing state mysql_user.present for ceilometer
2018-01-14 01:12:31,583 [salt.state       ][INFO    ][9975] User ceilometer@% is already present with the desired password
2018-01-14 01:12:31,584 [salt.state       ][INFO    ][9975] Completed state [ceilometer] at time 01:12:31.584163 duration_in_ms=8.398
2018-01-14 01:12:31,588 [salt.state       ][INFO    ][9975] Running state [mysql_grants_ceilometer_ceilometer_%] at time 01:12:31.588018
2018-01-14 01:12:31,588 [salt.state       ][INFO    ][9975] Executing state mysql_grants.present for mysql_grants_ceilometer_ceilometer_%
2018-01-14 01:12:31,599 [salt.state       ][INFO    ][9975] Grant all on ceilometer.* to ceilometer@% is already present
2018-01-14 01:12:31,599 [salt.state       ][INFO    ][9975] Completed state [mysql_grants_ceilometer_ceilometer_%] at time 01:12:31.599605 duration_in_ms=11.587
2018-01-14 01:12:31,600 [salt.state       ][INFO    ][9975] Running state [ceilometer] at time 01:12:31.600024
2018-01-14 01:12:31,600 [salt.state       ][INFO    ][9975] Executing state mysql_user.present for ceilometer
2018-01-14 01:12:31,646 [salt.loaded.int.module.mysql][INFO    ][9975] User 'ceilometer'@'10.167.4.52' has been created
2018-01-14 01:12:31,647 [salt.state       ][INFO    ][9975] {'ceilometer': 'Present'}
2018-01-14 01:12:31,647 [salt.state       ][INFO    ][9975] Completed state [ceilometer] at time 01:12:31.647665 duration_in_ms=47.641
2018-01-14 01:12:31,650 [salt.state       ][INFO    ][9975] Running state [mysql_grants_ceilometer_ceilometer_10.167.4.52] at time 01:12:31.650296
2018-01-14 01:12:31,650 [salt.state       ][INFO    ][9975] Executing state mysql_grants.present for mysql_grants_ceilometer_ceilometer_10.167.4.52
2018-01-14 01:12:31,690 [salt.loaded.int.module.mysql][INFO    ][9975] Grant 'all' on 'ceilometer.*' for user 'ceilometer' has been added
2018-01-14 01:12:31,691 [salt.state       ][INFO    ][9975] {'mysql_grants_ceilometer_ceilometer_10.167.4.52': 'Present'}
2018-01-14 01:12:31,691 [salt.state       ][INFO    ][9975] Completed state [mysql_grants_ceilometer_ceilometer_10.167.4.52] at time 01:12:31.691807 duration_in_ms=41.511
2018-01-14 01:12:31,692 [salt.state       ][INFO    ][9975] Running state [aodh] at time 01:12:31.692279
2018-01-14 01:12:31,692 [salt.state       ][INFO    ][9975] Executing state mysql_database.present for aodh
2018-01-14 01:12:31,698 [salt.state       ][INFO    ][9975] Database aodh is already present
2018-01-14 01:12:31,698 [salt.state       ][INFO    ][9975] Completed state [aodh] at time 01:12:31.698455 duration_in_ms=6.176
2018-01-14 01:12:31,698 [salt.state       ][INFO    ][9975] Running state [aodh] at time 01:12:31.698889
2018-01-14 01:12:31,699 [salt.state       ][INFO    ][9975] Executing state mysql_user.present for aodh
2018-01-14 01:12:31,705 [salt.state       ][INFO    ][9975] User aodh@% is already present with the desired password
2018-01-14 01:12:31,706 [salt.state       ][INFO    ][9975] Completed state [aodh] at time 01:12:31.706027 duration_in_ms=7.138
2018-01-14 01:12:31,708 [salt.state       ][INFO    ][9975] Running state [mysql_grants_aodh_aodh_%] at time 01:12:31.708642
2018-01-14 01:12:31,709 [salt.state       ][INFO    ][9975] Executing state mysql_grants.present for mysql_grants_aodh_aodh_%
2018-01-14 01:12:31,718 [salt.state       ][INFO    ][9975] Grant all on aodh.* to aodh@% is already present
2018-01-14 01:12:31,719 [salt.state       ][INFO    ][9975] Completed state [mysql_grants_aodh_aodh_%] at time 01:12:31.719126 duration_in_ms=10.484
2018-01-14 01:12:31,719 [salt.state       ][INFO    ][9975] Running state [aodh] at time 01:12:31.719525
2018-01-14 01:12:31,719 [salt.state       ][INFO    ][9975] Executing state mysql_user.present for aodh
2018-01-14 01:12:31,726 [salt.state       ][INFO    ][9975] User aodh@10.167.4.50 is already present with the desired password
2018-01-14 01:12:31,726 [salt.state       ][INFO    ][9975] Completed state [aodh] at time 01:12:31.726418 duration_in_ms=6.892
2018-01-14 01:12:31,728 [salt.state       ][INFO    ][9975] Running state [mysql_grants_aodh_aodh_10.167.4.50] at time 01:12:31.728802
2018-01-14 01:12:31,729 [salt.state       ][INFO    ][9975] Executing state mysql_grants.present for mysql_grants_aodh_aodh_10.167.4.50
2018-01-14 01:12:31,738 [salt.state       ][INFO    ][9975] Grant all on aodh.* to aodh@10.167.4.50 is already present
2018-01-14 01:12:31,739 [salt.state       ][INFO    ][9975] Completed state [mysql_grants_aodh_aodh_10.167.4.50] at time 01:12:31.739116 duration_in_ms=10.314
2018-01-14 01:12:31,739 [salt.state       ][INFO    ][9975] Running state [nova] at time 01:12:31.739514
2018-01-14 01:12:31,739 [salt.state       ][INFO    ][9975] Executing state mysql_database.present for nova
2018-01-14 01:12:31,744 [salt.state       ][INFO    ][9975] Database nova is already present
2018-01-14 01:12:31,745 [salt.state       ][INFO    ][9975] Completed state [nova] at time 01:12:31.745037 duration_in_ms=5.522
2018-01-14 01:12:31,745 [salt.state       ][INFO    ][9975] Running state [nova] at time 01:12:31.745431
2018-01-14 01:12:31,745 [salt.state       ][INFO    ][9975] Executing state mysql_user.present for nova
2018-01-14 01:12:31,751 [salt.state       ][INFO    ][9975] User nova@% is already present with the desired password
2018-01-14 01:12:31,752 [salt.state       ][INFO    ][9975] Completed state [nova] at time 01:12:31.752040 duration_in_ms=6.61
2018-01-14 01:12:31,754 [salt.state       ][INFO    ][9975] Running state [mysql_grants_nova_nova_%] at time 01:12:31.754307
2018-01-14 01:12:31,754 [salt.state       ][INFO    ][9975] Executing state mysql_grants.present for mysql_grants_nova_nova_%
2018-01-14 01:12:31,764 [salt.state       ][INFO    ][9975] Grant all on nova.* to nova@% is already present
2018-01-14 01:12:31,764 [salt.state       ][INFO    ][9975] Completed state [mysql_grants_nova_nova_%] at time 01:12:31.764914 duration_in_ms=10.607
2018-01-14 01:12:31,765 [salt.state       ][INFO    ][9975] Running state [nova] at time 01:12:31.765274
2018-01-14 01:12:31,765 [salt.state       ][INFO    ][9975] Executing state mysql_user.present for nova
2018-01-14 01:12:31,808 [salt.loaded.int.module.mysql][INFO    ][9975] User 'nova'@'10.167.4.52' has been created
2018-01-14 01:12:31,809 [salt.state       ][INFO    ][9975] {'nova': 'Present'}
2018-01-14 01:12:31,809 [salt.state       ][INFO    ][9975] Completed state [nova] at time 01:12:31.809560 duration_in_ms=44.285
2018-01-14 01:12:31,812 [salt.state       ][INFO    ][9975] Running state [mysql_grants_nova_nova_10.167.4.52] at time 01:12:31.812316
2018-01-14 01:12:31,812 [salt.state       ][INFO    ][9975] Executing state mysql_grants.present for mysql_grants_nova_nova_10.167.4.52
2018-01-14 01:12:31,852 [salt.loaded.int.module.mysql][INFO    ][9975] Grant 'all' on 'nova.*' for user 'nova' has been added
2018-01-14 01:12:31,853 [salt.state       ][INFO    ][9975] {'mysql_grants_nova_nova_10.167.4.52': 'Present'}
2018-01-14 01:12:31,853 [salt.state       ][INFO    ][9975] Completed state [mysql_grants_nova_nova_10.167.4.52] at time 01:12:31.853678 duration_in_ms=41.362
2018-01-14 01:12:31,854 [salt.state       ][INFO    ][9975] Running state [grafana] at time 01:12:31.854099
2018-01-14 01:12:31,854 [salt.state       ][INFO    ][9975] Executing state mysql_database.present for grafana
2018-01-14 01:12:31,859 [salt.state       ][INFO    ][9975] Database grafana is already present
2018-01-14 01:12:31,860 [salt.state       ][INFO    ][9975] Completed state [grafana] at time 01:12:31.860058 duration_in_ms=5.958
2018-01-14 01:12:31,860 [salt.state       ][INFO    ][9975] Running state [grafana] at time 01:12:31.860479
2018-01-14 01:12:31,860 [salt.state       ][INFO    ][9975] Executing state mysql_user.present for grafana
2018-01-14 01:12:31,867 [salt.state       ][INFO    ][9975] User grafana@% is already present with the desired password
2018-01-14 01:12:31,867 [salt.state       ][INFO    ][9975] Completed state [grafana] at time 01:12:31.867483 duration_in_ms=7.005
2018-01-14 01:12:31,870 [salt.state       ][INFO    ][9975] Running state [mysql_grants_grafana_grafana_%] at time 01:12:31.870072
2018-01-14 01:12:31,870 [salt.state       ][INFO    ][9975] Executing state mysql_grants.present for mysql_grants_grafana_grafana_%
2018-01-14 01:12:31,879 [salt.state       ][INFO    ][9975] Grant all on grafana.* to grafana@% is already present
2018-01-14 01:12:31,880 [salt.state       ][INFO    ][9975] Completed state [mysql_grants_grafana_grafana_%] at time 01:12:31.880084 duration_in_ms=10.011
2018-01-14 01:12:31,880 [salt.state       ][INFO    ][9975] Running state [grafana] at time 01:12:31.880475
2018-01-14 01:12:31,880 [salt.state       ][INFO    ][9975] Executing state mysql_user.present for grafana
2018-01-14 01:12:31,928 [salt.loaded.int.module.mysql][INFO    ][9975] User 'grafana'@'10.167.4.52' has been created
2018-01-14 01:12:31,929 [salt.state       ][INFO    ][9975] {'grafana': 'Present'}
2018-01-14 01:12:31,929 [salt.state       ][INFO    ][9975] Completed state [grafana] at time 01:12:31.929392 duration_in_ms=48.917
2018-01-14 01:12:31,931 [salt.state       ][INFO    ][9975] Running state [mysql_grants_grafana_grafana_10.167.4.52] at time 01:12:31.931855
2018-01-14 01:12:31,932 [salt.state       ][INFO    ][9975] Executing state mysql_grants.present for mysql_grants_grafana_grafana_10.167.4.52
2018-01-14 01:12:31,965 [salt.loaded.int.module.mysql][INFO    ][9975] Grant 'all' on 'grafana.*' for user 'grafana' has been added
2018-01-14 01:12:31,965 [salt.state       ][INFO    ][9975] {'mysql_grants_grafana_grafana_10.167.4.52': 'Present'}
2018-01-14 01:12:31,966 [salt.state       ][INFO    ][9975] Completed state [mysql_grants_grafana_grafana_10.167.4.52] at time 01:12:31.966197 duration_in_ms=34.342
2018-01-14 01:12:31,966 [salt.state       ][INFO    ][9975] Running state [designate_pool_manager] at time 01:12:31.966640
2018-01-14 01:12:31,967 [salt.state       ][INFO    ][9975] Executing state mysql_database.present for designate_pool_manager
2018-01-14 01:12:31,971 [salt.state       ][INFO    ][9975] Database designate_pool_manager is already present
2018-01-14 01:12:31,972 [salt.state       ][INFO    ][9975] Completed state [designate_pool_manager] at time 01:12:31.972005 duration_in_ms=5.364
2018-01-14 01:12:31,972 [salt.state       ][INFO    ][9975] Running state [designate] at time 01:12:31.972406
2018-01-14 01:12:31,972 [salt.state       ][INFO    ][9975] Executing state mysql_user.present for designate
2018-01-14 01:12:31,978 [salt.state       ][INFO    ][9975] User designate@% is already present with the desired password
2018-01-14 01:12:31,979 [salt.state       ][INFO    ][9975] Completed state [designate] at time 01:12:31.979202 duration_in_ms=6.797
2018-01-14 01:12:31,981 [salt.state       ][INFO    ][9975] Running state [mysql_grants_designate_designate_pool_manager_%] at time 01:12:31.981763
2018-01-14 01:12:31,982 [salt.state       ][INFO    ][9975] Executing state mysql_grants.present for mysql_grants_designate_designate_pool_manager_%
2018-01-14 01:12:31,991 [salt.state       ][INFO    ][9975] Grant all on designate_pool_manager.* to designate@% is already present
2018-01-14 01:12:31,991 [salt.state       ][INFO    ][9975] Completed state [mysql_grants_designate_designate_pool_manager_%] at time 01:12:31.991776 duration_in_ms=10.014
2018-01-14 01:12:31,992 [salt.state       ][INFO    ][9975] Running state [designate] at time 01:12:31.992145
2018-01-14 01:12:31,992 [salt.state       ][INFO    ][9975] Executing state mysql_user.present for designate
2018-01-14 01:12:31,998 [salt.state       ][INFO    ][9975] User designate@10.167.4.50 is already present with the desired password
2018-01-14 01:12:31,998 [salt.state       ][INFO    ][9975] Completed state [designate] at time 01:12:31.998558 duration_in_ms=6.413
2018-01-14 01:12:32,000 [salt.state       ][INFO    ][9975] Running state [mysql_grants_designate_designate_pool_manager_10.167.4.50] at time 01:12:32.000814
2018-01-14 01:12:32,001 [salt.state       ][INFO    ][9975] Executing state mysql_grants.present for mysql_grants_designate_designate_pool_manager_10.167.4.50
2018-01-14 01:12:32,010 [salt.state       ][INFO    ][9975] Grant all on designate_pool_manager.* to designate@10.167.4.50 is already present
2018-01-14 01:12:32,010 [salt.state       ][INFO    ][9975] Completed state [mysql_grants_designate_designate_pool_manager_10.167.4.50] at time 01:12:32.010893 duration_in_ms=10.079
2018-01-14 01:12:32,011 [salt.state       ][INFO    ][9975] Running state [heat] at time 01:12:32.011270
2018-01-14 01:12:32,011 [salt.state       ][INFO    ][9975] Executing state mysql_database.present for heat
2018-01-14 01:12:32,016 [salt.state       ][INFO    ][9975] Database heat is already present
2018-01-14 01:12:32,016 [salt.state       ][INFO    ][9975] Completed state [heat] at time 01:12:32.016564 duration_in_ms=5.294
2018-01-14 01:12:32,016 [salt.state       ][INFO    ][9975] Running state [heat] at time 01:12:32.016936
2018-01-14 01:12:32,017 [salt.state       ][INFO    ][9975] Executing state mysql_user.present for heat
2018-01-14 01:12:32,022 [salt.state       ][INFO    ][9975] User heat@% is already present with the desired password
2018-01-14 01:12:32,023 [salt.state       ][INFO    ][9975] Completed state [heat] at time 01:12:32.023229 duration_in_ms=6.293
2018-01-14 01:12:32,025 [salt.state       ][INFO    ][9975] Running state [mysql_grants_heat_heat_%] at time 01:12:32.025477
2018-01-14 01:12:32,025 [salt.state       ][INFO    ][9975] Executing state mysql_grants.present for mysql_grants_heat_heat_%
2018-01-14 01:12:32,034 [salt.state       ][INFO    ][9975] Grant all on heat.* to heat@% is already present
2018-01-14 01:12:32,034 [salt.state       ][INFO    ][9975] Completed state [mysql_grants_heat_heat_%] at time 01:12:32.034698 duration_in_ms=9.221
2018-01-14 01:12:32,035 [salt.state       ][INFO    ][9975] Running state [heat] at time 01:12:32.035045
2018-01-14 01:12:32,035 [salt.state       ][INFO    ][9975] Executing state mysql_user.present for heat
2018-01-14 01:12:32,108 [salt.loaded.int.module.mysql][INFO    ][9975] User 'heat'@'10.167.4.52' has been created
2018-01-14 01:12:32,109 [salt.state       ][INFO    ][9975] {'heat': 'Present'}
2018-01-14 01:12:32,109 [salt.state       ][INFO    ][9975] Completed state [heat] at time 01:12:32.109411 duration_in_ms=74.366
2018-01-14 01:12:32,112 [salt.state       ][INFO    ][9975] Running state [mysql_grants_heat_heat_10.167.4.52] at time 01:12:32.111967
2018-01-14 01:12:32,112 [salt.state       ][INFO    ][9975] Executing state mysql_grants.present for mysql_grants_heat_heat_10.167.4.52
2018-01-14 01:12:32,151 [salt.loaded.int.module.mysql][INFO    ][9975] Grant 'all' on 'heat.*' for user 'heat' has been added
2018-01-14 01:12:32,151 [salt.state       ][INFO    ][9975] {'mysql_grants_heat_heat_10.167.4.52': 'Present'}
2018-01-14 01:12:32,152 [salt.state       ][INFO    ][9975] Completed state [mysql_grants_heat_heat_10.167.4.52] at time 01:12:32.152011 duration_in_ms=40.045
2018-01-14 01:12:32,152 [salt.state       ][INFO    ][9975] Running state [nova_api] at time 01:12:32.152432
2018-01-14 01:12:32,152 [salt.state       ][INFO    ][9975] Executing state mysql_database.present for nova_api
2018-01-14 01:12:32,157 [salt.state       ][INFO    ][9975] Database nova_api is already present
2018-01-14 01:12:32,157 [salt.state       ][INFO    ][9975] Completed state [nova_api] at time 01:12:32.157776 duration_in_ms=5.344
2018-01-14 01:12:32,158 [salt.state       ][INFO    ][9975] Running state [nova] at time 01:12:32.158182
2018-01-14 01:12:32,158 [salt.state       ][INFO    ][9975] Executing state mysql_user.present for nova
2018-01-14 01:12:32,164 [salt.state       ][INFO    ][9975] User nova@% is already present with the desired password
2018-01-14 01:12:32,164 [salt.state       ][INFO    ][9975] Completed state [nova] at time 01:12:32.164451 duration_in_ms=6.268
2018-01-14 01:12:32,166 [salt.state       ][INFO    ][9975] Running state [mysql_grants_nova_nova_api_%] at time 01:12:32.166889
2018-01-14 01:12:32,167 [salt.state       ][INFO    ][9975] Executing state mysql_grants.present for mysql_grants_nova_nova_api_%
2018-01-14 01:12:32,176 [salt.state       ][INFO    ][9975] Grant all on nova_api.* to nova@% is already present
2018-01-14 01:12:32,176 [salt.state       ][INFO    ][9975] Completed state [mysql_grants_nova_nova_api_%] at time 01:12:32.176699 duration_in_ms=9.811
2018-01-14 01:12:32,177 [salt.state       ][INFO    ][9975] Running state [nova] at time 01:12:32.177070
2018-01-14 01:12:32,177 [salt.state       ][INFO    ][9975] Executing state mysql_user.present for nova
2018-01-14 01:12:32,183 [salt.state       ][INFO    ][9975] User nova@10.167.4.52 is already present with the desired password
2018-01-14 01:12:32,183 [salt.state       ][INFO    ][9975] Completed state [nova] at time 01:12:32.183291 duration_in_ms=6.221
2018-01-14 01:12:32,185 [salt.state       ][INFO    ][9975] Running state [mysql_grants_nova_nova_api_10.167.4.52] at time 01:12:32.185360
2018-01-14 01:12:32,185 [salt.state       ][INFO    ][9975] Executing state mysql_grants.present for mysql_grants_nova_nova_api_10.167.4.52
2018-01-14 01:12:32,223 [salt.loaded.int.module.mysql][INFO    ][9975] Grant 'all' on 'nova_api.*' for user 'nova' has been added
2018-01-14 01:12:32,223 [salt.state       ][INFO    ][9975] {'mysql_grants_nova_nova_api_10.167.4.52': 'Present'}
2018-01-14 01:12:32,224 [salt.state       ][INFO    ][9975] Completed state [mysql_grants_nova_nova_api_10.167.4.52] at time 01:12:32.224231 duration_in_ms=38.871
2018-01-14 01:12:32,224 [salt.state       ][INFO    ][9975] Running state [keystone] at time 01:12:32.224653
2018-01-14 01:12:32,225 [salt.state       ][INFO    ][9975] Executing state mysql_database.present for keystone
2018-01-14 01:12:32,229 [salt.state       ][INFO    ][9975] Database keystone is already present
2018-01-14 01:12:32,230 [salt.state       ][INFO    ][9975] Completed state [keystone] at time 01:12:32.230116 duration_in_ms=5.463
2018-01-14 01:12:32,230 [salt.state       ][INFO    ][9975] Running state [keystone] at time 01:12:32.230559
2018-01-14 01:12:32,230 [salt.state       ][INFO    ][9975] Executing state mysql_user.present for keystone
2018-01-14 01:12:32,236 [salt.state       ][INFO    ][9975] User keystone@% is already present with the desired password
2018-01-14 01:12:32,237 [salt.state       ][INFO    ][9975] Completed state [keystone] at time 01:12:32.237269 duration_in_ms=6.71
2018-01-14 01:12:32,240 [salt.state       ][INFO    ][9975] Running state [mysql_grants_keystone_keystone_%] at time 01:12:32.240535
2018-01-14 01:12:32,241 [salt.state       ][INFO    ][9975] Executing state mysql_grants.present for mysql_grants_keystone_keystone_%
2018-01-14 01:12:32,250 [salt.state       ][INFO    ][9975] Grant all on keystone.* to keystone@% is already present
2018-01-14 01:12:32,250 [salt.state       ][INFO    ][9975] Completed state [mysql_grants_keystone_keystone_%] at time 01:12:32.250550 duration_in_ms=10.015
2018-01-14 01:12:32,250 [salt.state       ][INFO    ][9975] Running state [keystone] at time 01:12:32.250925
2018-01-14 01:12:32,251 [salt.state       ][INFO    ][9975] Executing state mysql_user.present for keystone
2018-01-14 01:12:32,294 [salt.loaded.int.module.mysql][INFO    ][9975] User 'keystone'@'10.167.4.52' has been created
2018-01-14 01:12:32,295 [salt.state       ][INFO    ][9975] {'keystone': 'Present'}
2018-01-14 01:12:32,295 [salt.state       ][INFO    ][9975] Completed state [keystone] at time 01:12:32.295366 duration_in_ms=44.44
2018-01-14 01:12:32,297 [salt.state       ][INFO    ][9975] Running state [mysql_grants_keystone_keystone_10.167.4.52] at time 01:12:32.297625
2018-01-14 01:12:32,298 [salt.state       ][INFO    ][9975] Executing state mysql_grants.present for mysql_grants_keystone_keystone_10.167.4.52
2018-01-14 01:12:32,337 [salt.loaded.int.module.mysql][INFO    ][9975] Grant 'all' on 'keystone.*' for user 'keystone' has been added
2018-01-14 01:12:32,338 [salt.state       ][INFO    ][9975] {'mysql_grants_keystone_keystone_10.167.4.52': 'Present'}
2018-01-14 01:12:32,338 [salt.state       ][INFO    ][9975] Completed state [mysql_grants_keystone_keystone_10.167.4.52] at time 01:12:32.338292 duration_in_ms=40.666
2018-01-14 01:12:32,338 [salt.state       ][INFO    ][9975] Running state [nova_cell0] at time 01:12:32.338709
2018-01-14 01:12:32,339 [salt.state       ][INFO    ][9975] Executing state mysql_database.present for nova_cell0
2018-01-14 01:12:32,343 [salt.state       ][INFO    ][9975] Database nova_cell0 is already present
2018-01-14 01:12:32,344 [salt.state       ][INFO    ][9975] Completed state [nova_cell0] at time 01:12:32.344264 duration_in_ms=5.554
2018-01-14 01:12:32,344 [salt.state       ][INFO    ][9975] Running state [nova] at time 01:12:32.344655
2018-01-14 01:12:32,345 [salt.state       ][INFO    ][9975] Executing state mysql_user.present for nova
2018-01-14 01:12:32,351 [salt.state       ][INFO    ][9975] User nova@% is already present with the desired password
2018-01-14 01:12:32,351 [salt.state       ][INFO    ][9975] Completed state [nova] at time 01:12:32.351296 duration_in_ms=6.64
2018-01-14 01:12:32,353 [salt.state       ][INFO    ][9975] Running state [mysql_grants_nova_nova_cell0_%] at time 01:12:32.353643
2018-01-14 01:12:32,354 [salt.state       ][INFO    ][9975] Executing state mysql_grants.present for mysql_grants_nova_nova_cell0_%
2018-01-14 01:12:32,363 [salt.state       ][INFO    ][9975] Grant all on nova_cell0.* to nova@% is already present
2018-01-14 01:12:32,363 [salt.state       ][INFO    ][9975] Completed state [mysql_grants_nova_nova_cell0_%] at time 01:12:32.363692 duration_in_ms=10.05
2018-01-14 01:12:32,364 [salt.state       ][INFO    ][9975] Running state [nova] at time 01:12:32.364058
2018-01-14 01:12:32,364 [salt.state       ][INFO    ][9975] Executing state mysql_user.present for nova
2018-01-14 01:12:32,370 [salt.state       ][INFO    ][9975] User nova@10.167.4.52 is already present with the desired password
2018-01-14 01:12:32,370 [salt.state       ][INFO    ][9975] Completed state [nova] at time 01:12:32.370656 duration_in_ms=6.598
2018-01-14 01:12:32,372 [salt.state       ][INFO    ][9975] Running state [mysql_grants_nova_nova_cell0_10.167.4.52] at time 01:12:32.372760
2018-01-14 01:12:32,373 [salt.state       ][INFO    ][9975] Executing state mysql_grants.present for mysql_grants_nova_nova_cell0_10.167.4.52
2018-01-14 01:12:32,416 [salt.loaded.int.module.mysql][INFO    ][9975] Grant 'all' on 'nova_cell0.*' for user 'nova' has been added
2018-01-14 01:12:32,417 [salt.state       ][INFO    ][9975] {'mysql_grants_nova_nova_cell0_10.167.4.52': 'Present'}
2018-01-14 01:12:32,417 [salt.state       ][INFO    ][9975] Completed state [mysql_grants_nova_nova_cell0_10.167.4.52] at time 01:12:32.417378 duration_in_ms=44.618
2018-01-14 01:12:32,417 [salt.state       ][INFO    ][9975] Running state [cinder] at time 01:12:32.417839
2018-01-14 01:12:32,418 [salt.state       ][INFO    ][9975] Executing state mysql_database.present for cinder
2018-01-14 01:12:32,423 [salt.state       ][INFO    ][9975] Database cinder is already present
2018-01-14 01:12:32,423 [salt.state       ][INFO    ][9975] Completed state [cinder] at time 01:12:32.423874 duration_in_ms=6.035
2018-01-14 01:12:32,424 [salt.state       ][INFO    ][9975] Running state [cinder] at time 01:12:32.424326
2018-01-14 01:12:32,424 [salt.state       ][INFO    ][9975] Executing state mysql_user.present for cinder
2018-01-14 01:12:32,430 [salt.state       ][INFO    ][9975] User cinder@% is already present with the desired password
2018-01-14 01:12:32,431 [salt.state       ][INFO    ][9975] Completed state [cinder] at time 01:12:32.431272 duration_in_ms=6.945
2018-01-14 01:12:32,433 [salt.state       ][INFO    ][9975] Running state [mysql_grants_cinder_cinder_%] at time 01:12:32.433825
2018-01-14 01:12:32,434 [salt.state       ][INFO    ][9975] Executing state mysql_grants.present for mysql_grants_cinder_cinder_%
2018-01-14 01:12:32,443 [salt.state       ][INFO    ][9975] Grant all on cinder.* to cinder@% is already present
2018-01-14 01:12:32,444 [salt.state       ][INFO    ][9975] Completed state [mysql_grants_cinder_cinder_%] at time 01:12:32.444098 duration_in_ms=10.273
2018-01-14 01:12:32,444 [salt.state       ][INFO    ][9975] Running state [cinder] at time 01:12:32.444500
2018-01-14 01:12:32,444 [salt.state       ][INFO    ][9975] Executing state mysql_user.present for cinder
2018-01-14 01:12:32,486 [salt.loaded.int.module.mysql][INFO    ][9975] User 'cinder'@'10.167.4.52' has been created
2018-01-14 01:12:32,487 [salt.state       ][INFO    ][9975] {'cinder': 'Present'}
2018-01-14 01:12:32,487 [salt.state       ][INFO    ][9975] Completed state [cinder] at time 01:12:32.487814 duration_in_ms=43.314
2018-01-14 01:12:32,490 [salt.state       ][INFO    ][9975] Running state [mysql_grants_cinder_cinder_10.167.4.52] at time 01:12:32.490385
2018-01-14 01:12:32,490 [salt.state       ][INFO    ][9975] Executing state mysql_grants.present for mysql_grants_cinder_cinder_10.167.4.52
2018-01-14 01:12:32,523 [salt.loaded.int.module.mysql][INFO    ][9975] Grant 'all' on 'cinder.*' for user 'cinder' has been added
2018-01-14 01:12:32,524 [salt.state       ][INFO    ][9975] {'mysql_grants_cinder_cinder_10.167.4.52': 'Present'}
2018-01-14 01:12:32,524 [salt.state       ][INFO    ][9975] Completed state [mysql_grants_cinder_cinder_10.167.4.52] at time 01:12:32.524463 duration_in_ms=34.078
2018-01-14 01:12:32,524 [salt.state       ][INFO    ][9975] Running state [glance] at time 01:12:32.524856
2018-01-14 01:12:32,525 [salt.state       ][INFO    ][9975] Executing state mysql_database.present for glance
2018-01-14 01:12:32,530 [salt.state       ][INFO    ][9975] Database glance is already present
2018-01-14 01:12:32,530 [salt.state       ][INFO    ][9975] Completed state [glance] at time 01:12:32.530615 duration_in_ms=5.758
2018-01-14 01:12:32,531 [salt.state       ][INFO    ][9975] Running state [glance] at time 01:12:32.531002
2018-01-14 01:12:32,531 [salt.state       ][INFO    ][9975] Executing state mysql_user.present for glance
2018-01-14 01:12:32,537 [salt.state       ][INFO    ][9975] User glance@% is already present with the desired password
2018-01-14 01:12:32,537 [salt.state       ][INFO    ][9975] Completed state [glance] at time 01:12:32.537649 duration_in_ms=6.646
2018-01-14 01:12:32,540 [salt.state       ][INFO    ][9975] Running state [mysql_grants_glance_glance_%] at time 01:12:32.540117
2018-01-14 01:12:32,540 [salt.state       ][INFO    ][9975] Executing state mysql_grants.present for mysql_grants_glance_glance_%
2018-01-14 01:12:32,549 [salt.state       ][INFO    ][9975] Grant all on glance.* to glance@% is already present
2018-01-14 01:12:32,550 [salt.state       ][INFO    ][9975] Completed state [mysql_grants_glance_glance_%] at time 01:12:32.550109 duration_in_ms=9.992
2018-01-14 01:12:32,550 [salt.state       ][INFO    ][9975] Running state [glance] at time 01:12:32.550518
2018-01-14 01:12:32,550 [salt.state       ][INFO    ][9975] Executing state mysql_user.present for glance
2018-01-14 01:12:32,588 [salt.loaded.int.module.mysql][INFO    ][9975] User 'glance'@'10.167.4.52' has been created
2018-01-14 01:12:32,589 [salt.state       ][INFO    ][9975] {'glance': 'Present'}
2018-01-14 01:12:32,589 [salt.state       ][INFO    ][9975] Completed state [glance] at time 01:12:32.589726 duration_in_ms=39.207
2018-01-14 01:12:32,592 [salt.state       ][INFO    ][9975] Running state [mysql_grants_glance_glance_10.167.4.52] at time 01:12:32.592294
2018-01-14 01:12:32,592 [salt.state       ][INFO    ][9975] Executing state mysql_grants.present for mysql_grants_glance_glance_10.167.4.52
2018-01-14 01:12:32,632 [salt.loaded.int.module.mysql][INFO    ][9975] Grant 'all' on 'glance.*' for user 'glance' has been added
2018-01-14 01:12:32,633 [salt.state       ][INFO    ][9975] {'mysql_grants_glance_glance_10.167.4.52': 'Present'}
2018-01-14 01:12:32,633 [salt.state       ][INFO    ][9975] Completed state [mysql_grants_glance_glance_10.167.4.52] at time 01:12:32.633786 duration_in_ms=41.492
2018-01-14 01:12:32,634 [salt.state       ][INFO    ][9975] Running state [neutron] at time 01:12:32.634223
2018-01-14 01:12:32,634 [salt.state       ][INFO    ][9975] Executing state mysql_database.present for neutron
2018-01-14 01:12:32,639 [salt.state       ][INFO    ][9975] Database neutron is already present
2018-01-14 01:12:32,640 [salt.state       ][INFO    ][9975] Completed state [neutron] at time 01:12:32.640140 duration_in_ms=5.917
2018-01-14 01:12:32,640 [salt.state       ][INFO    ][9975] Running state [neutron] at time 01:12:32.640549
2018-01-14 01:12:32,640 [salt.state       ][INFO    ][9975] Executing state mysql_user.present for neutron
2018-01-14 01:12:32,647 [salt.state       ][INFO    ][9975] User neutron@% is already present with the desired password
2018-01-14 01:12:32,647 [salt.state       ][INFO    ][9975] Completed state [neutron] at time 01:12:32.647596 duration_in_ms=7.047
2018-01-14 01:12:32,650 [salt.state       ][INFO    ][9975] Running state [mysql_grants_neutron_neutron_%] at time 01:12:32.650208
2018-01-14 01:12:32,650 [salt.state       ][INFO    ][9975] Executing state mysql_grants.present for mysql_grants_neutron_neutron_%
2018-01-14 01:12:32,660 [salt.state       ][INFO    ][9975] Grant all on neutron.* to neutron@% is already present
2018-01-14 01:12:32,660 [salt.state       ][INFO    ][9975] Completed state [mysql_grants_neutron_neutron_%] at time 01:12:32.660821 duration_in_ms=10.613
2018-01-14 01:12:32,661 [salt.state       ][INFO    ][9975] Running state [neutron] at time 01:12:32.661212
2018-01-14 01:12:32,661 [salt.state       ][INFO    ][9975] Executing state mysql_user.present for neutron
2018-01-14 01:12:32,709 [salt.loaded.int.module.mysql][INFO    ][9975] User 'neutron'@'10.167.4.52' has been created
2018-01-14 01:12:32,709 [salt.state       ][INFO    ][9975] {'neutron': 'Present'}
2018-01-14 01:12:32,710 [salt.state       ][INFO    ][9975] Completed state [neutron] at time 01:12:32.710282 duration_in_ms=49.069
2018-01-14 01:12:32,712 [salt.state       ][INFO    ][9975] Running state [mysql_grants_neutron_neutron_10.167.4.52] at time 01:12:32.712804
2018-01-14 01:12:32,713 [salt.state       ][INFO    ][9975] Executing state mysql_grants.present for mysql_grants_neutron_neutron_10.167.4.52
2018-01-14 01:12:32,752 [salt.loaded.int.module.mysql][INFO    ][9975] Grant 'all' on 'neutron.*' for user 'neutron' has been added
2018-01-14 01:12:32,752 [salt.state       ][INFO    ][9975] {'mysql_grants_neutron_neutron_10.167.4.52': 'Present'}
2018-01-14 01:12:32,753 [salt.state       ][INFO    ][9975] Completed state [mysql_grants_neutron_neutron_10.167.4.52] at time 01:12:32.753269 duration_in_ms=40.465
2018-01-14 01:12:32,753 [salt.state       ][INFO    ][9975] Running state [designate] at time 01:12:32.753721
2018-01-14 01:12:32,754 [salt.state       ][INFO    ][9975] Executing state mysql_database.present for designate
2018-01-14 01:12:32,759 [salt.state       ][INFO    ][9975] Database designate is already present
2018-01-14 01:12:32,759 [salt.state       ][INFO    ][9975] Completed state [designate] at time 01:12:32.759588 duration_in_ms=5.867
2018-01-14 01:12:32,760 [salt.state       ][INFO    ][9975] Running state [designate] at time 01:12:32.759994
2018-01-14 01:12:32,760 [salt.state       ][INFO    ][9975] Executing state mysql_user.present for designate
2018-01-14 01:12:32,766 [salt.state       ][INFO    ][9975] User designate@% is already present with the desired password
2018-01-14 01:12:32,767 [salt.state       ][INFO    ][9975] Completed state [designate] at time 01:12:32.766990 duration_in_ms=6.995
2018-01-14 01:12:32,769 [salt.state       ][INFO    ][9975] Running state [mysql_grants_designate_designate_%] at time 01:12:32.769584
2018-01-14 01:12:32,770 [salt.state       ][INFO    ][9975] Executing state mysql_grants.present for mysql_grants_designate_designate_%
2018-01-14 01:12:32,779 [salt.state       ][INFO    ][9975] Grant all on designate.* to designate@% is already present
2018-01-14 01:12:32,780 [salt.state       ][INFO    ][9975] Completed state [mysql_grants_designate_designate_%] at time 01:12:32.780216 duration_in_ms=10.632
2018-01-14 01:12:32,780 [salt.state       ][INFO    ][9975] Running state [designate] at time 01:12:32.780631
2018-01-14 01:12:32,781 [salt.state       ][INFO    ][9975] Executing state mysql_user.present for designate
2018-01-14 01:12:32,787 [salt.state       ][INFO    ][9975] User designate@10.167.4.50 is already present with the desired password
2018-01-14 01:12:32,787 [salt.state       ][INFO    ][9975] Completed state [designate] at time 01:12:32.787453 duration_in_ms=6.822
2018-01-14 01:12:32,789 [salt.state       ][INFO    ][9975] Running state [mysql_grants_designate_designate_10.167.4.50] at time 01:12:32.789809
2018-01-14 01:12:32,790 [salt.state       ][INFO    ][9975] Executing state mysql_grants.present for mysql_grants_designate_designate_10.167.4.50
2018-01-14 01:12:32,799 [salt.state       ][INFO    ][9975] Grant all on designate.* to designate@10.167.4.50 is already present
2018-01-14 01:12:32,800 [salt.state       ][INFO    ][9975] Completed state [mysql_grants_designate_designate_10.167.4.50] at time 01:12:32.800171 duration_in_ms=10.361
2018-01-14 01:12:32,800 [salt.state       ][INFO    ][9975] Running state [haproxy] at time 01:12:32.800576
2018-01-14 01:12:32,800 [salt.state       ][INFO    ][9975] Executing state mysql_user.present for haproxy
2018-01-14 01:12:32,807 [salt.state       ][INFO    ][9975] User haproxy@localhost is already present with passwordless login
2018-01-14 01:12:32,807 [salt.state       ][INFO    ][9975] Completed state [haproxy] at time 01:12:32.807492 duration_in_ms=6.916
2018-01-14 01:12:32,807 [salt.state       ][INFO    ][9975] Running state [haproxy] at time 01:12:32.807900
2018-01-14 01:12:32,808 [salt.state       ][INFO    ][9975] Executing state mysql_user.present for haproxy
2018-01-14 01:12:32,814 [salt.state       ][INFO    ][9975] User haproxy@% is already present with passwordless login
2018-01-14 01:12:32,814 [salt.state       ][INFO    ][9975] Completed state [haproxy] at time 01:12:32.814661 duration_in_ms=6.76
2018-01-14 01:12:32,815 [salt.state       ][INFO    ][9975] Running state [haproxy] at time 01:12:32.815077
2018-01-14 01:12:32,815 [salt.state       ][INFO    ][9975] Executing state mysql_user.present for haproxy
2018-01-14 01:12:32,859 [salt.loaded.int.module.mysql][INFO    ][9975] User 'haproxy'@'10.167.4.52' has been created with passwordless login
2018-01-14 01:12:32,859 [salt.state       ][INFO    ][9975] {'haproxy': 'Present'}
2018-01-14 01:12:32,859 [salt.state       ][INFO    ][9975] Completed state [haproxy] at time 01:12:32.859880 duration_in_ms=44.803
2018-01-14 01:12:32,866 [salt.minion      ][INFO    ][9975] Returning information for job: 20180114010030816122
2018-01-14 01:13:04,439 [salt.minion      ][INFO    ][2613] User sudo_ubuntu Executing command state.sls with jid 20180114011303587043
2018-01-14 01:13:04,465 [salt.minion      ][INFO    ][19843] Starting a new job with PID 19843
2018-01-14 01:13:05,459 [salt.state       ][INFO    ][19843] Loading fresh modules for state activity
2018-01-14 01:13:05,740 [salt.fileclient  ][INFO    ][19843] Fetching file from saltenv 'base', ** done ** 'haproxy/init.sls'
2018-01-14 01:13:05,781 [salt.fileclient  ][INFO    ][19843] Fetching file from saltenv 'base', ** done ** 'haproxy/proxy.sls'
2018-01-14 01:13:06,275 [salt.state       ][INFO    ][19843] Running state [haproxy] at time 01:13:06.275632
2018-01-14 01:13:06,276 [salt.state       ][INFO    ][19843] Executing state pkg.installed for haproxy
2018-01-14 01:13:06,277 [salt.loaded.int.module.cmdmod][INFO    ][19843] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2018-01-14 01:13:06,612 [salt.loaded.int.module.cmdmod][INFO    ][19843] Executing command ['apt-cache', '-q', 'policy', 'haproxy'] in directory '/root'
2018-01-14 01:13:06,678 [salt.loaded.int.module.cmdmod][INFO    ][19843] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2018-01-14 01:13:08,443 [salt.loaded.int.module.cmdmod][INFO    ][19843] Executing command ['dpkg', '--get-selections', '*'] in directory '/root'
2018-01-14 01:13:08,482 [salt.loaded.int.module.cmdmod][INFO    ][19843] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'haproxy'] in directory '/root'
2018-01-14 01:13:14,544 [salt.minion      ][INFO    ][2613] User sudo_ubuntu Executing command saltutil.find_job with jid 20180114011313686539
2018-01-14 01:13:14,562 [salt.minion      ][INFO    ][20551] Starting a new job with PID 20551
2018-01-14 01:13:14,585 [salt.minion      ][INFO    ][20551] Returning information for job: 20180114011313686539
2018-01-14 01:13:16,448 [salt.loaded.int.module.cmdmod][INFO    ][19843] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2018-01-14 01:13:16,494 [salt.state       ][INFO    ][19843] Made the following changes:
'haproxy' changed from 'absent' to '1.6.3-1ubuntu0.1'
'liblua5.3-0' changed from 'absent' to '5.3.1-1ubuntu2'

2018-01-14 01:13:16,524 [salt.state       ][INFO    ][19843] Loading fresh modules for state activity
2018-01-14 01:13:16,563 [salt.state       ][INFO    ][19843] Completed state [haproxy] at time 01:13:16.563200 duration_in_ms=10287.565
2018-01-14 01:13:16,570 [salt.state       ][INFO    ][19843] Running state [/etc/default/haproxy] at time 01:13:16.570275
2018-01-14 01:13:16,570 [salt.state       ][INFO    ][19843] Executing state file.managed for /etc/default/haproxy
2018-01-14 01:13:16,611 [salt.fileclient  ][INFO    ][19843] Fetching file from saltenv 'base', ** done ** 'haproxy/files/haproxy.default'
2018-01-14 01:13:16,616 [salt.state       ][INFO    ][19843] File changed:
--- 
+++ 
@@ -1,10 +1,5 @@
-# Defaults file for HAProxy
-#
-# This is sourced by both, the initscript and the systemd unit file, so do not
-# treat it as a shell script fragment.
 
-# Change the config file location if needed
-#CONFIG="/etc/haproxy/haproxy.cfg"
-
-# Add extra flags here, see haproxy(1) for a few options
+# Set ENABLED to 1 if you want the init script to start haproxy.
+ENABLED=1
+# Add extra flags here.
 #EXTRAOPTS="-de -m 16"

2018-01-14 01:13:16,616 [salt.state       ][INFO    ][19843] Completed state [/etc/default/haproxy] at time 01:13:16.616484 duration_in_ms=46.21
2018-01-14 01:13:16,617 [salt.state       ][INFO    ][19843] Running state [/etc/haproxy/haproxy.cfg] at time 01:13:16.616997
2018-01-14 01:13:16,617 [salt.state       ][INFO    ][19843] Executing state file.managed for /etc/haproxy/haproxy.cfg
2018-01-14 01:13:16,640 [salt.fileclient  ][INFO    ][19843] Fetching file from saltenv 'base', ** done ** 'haproxy/files/haproxy.cfg'
2018-01-14 01:13:16,790 [salt.state       ][INFO    ][19843] 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

2018-01-14 01:13:16,790 [salt.state       ][INFO    ][19843] Completed state [/etc/haproxy/haproxy.cfg] at time 01:13:16.790404 duration_in_ms=173.407
2018-01-14 01:13:16,790 [salt.state       ][INFO    ][19843] Running state [/etc/haproxy/ssl] at time 01:13:16.790665
2018-01-14 01:13:16,790 [salt.state       ][INFO    ][19843] Executing state file.directory for /etc/haproxy/ssl
2018-01-14 01:13:16,792 [salt.state       ][INFO    ][19843] {'/etc/haproxy/ssl': 'New Dir'}
2018-01-14 01:13:16,792 [salt.state       ][INFO    ][19843] Completed state [/etc/haproxy/ssl] at time 01:13:16.792177 duration_in_ms=1.512
2018-01-14 01:13:16,792 [salt.state       ][INFO    ][19843] Running state [haproxy_status_packages] at time 01:13:16.792858
2018-01-14 01:13:16,793 [salt.state       ][INFO    ][19843] Executing state pkg.installed for haproxy_status_packages
2018-01-14 01:13:17,137 [salt.state       ][INFO    ][19843] All specified packages are already installed
2018-01-14 01:13:17,137 [salt.state       ][INFO    ][19843] Completed state [haproxy_status_packages] at time 01:13:17.137564 duration_in_ms=344.705
2018-01-14 01:13:17,138 [salt.state       ][INFO    ][19843] Running state [/usr/bin/haproxy-status.sh] at time 01:13:17.138077
2018-01-14 01:13:17,138 [salt.state       ][INFO    ][19843] Executing state file.managed for /usr/bin/haproxy-status.sh
2018-01-14 01:13:17,160 [salt.fileclient  ][INFO    ][19843] Fetching file from saltenv 'base', ** done ** 'haproxy/files/haproxy-status.sh'
2018-01-14 01:13:17,180 [salt.state       ][INFO    ][19843] File changed:
New file
2018-01-14 01:13:17,181 [salt.state       ][INFO    ][19843] Completed state [/usr/bin/haproxy-status.sh] at time 01:13:17.181074 duration_in_ms=42.997
2018-01-14 01:13:17,181 [salt.state       ][INFO    ][19843] Running state [net.ipv4.ip_nonlocal_bind] at time 01:13:17.181524
2018-01-14 01:13:17,181 [salt.state       ][INFO    ][19843] Executing state sysctl.present for net.ipv4.ip_nonlocal_bind
2018-01-14 01:13:17,182 [salt.loaded.int.module.cmdmod][INFO    ][19843] Executing command 'sysctl -a' in directory '/root'
2018-01-14 01:13:17,229 [salt.loaded.int.module.cmdmod][INFO    ][19843] Executing command 'sysctl -w net.ipv4.ip_nonlocal_bind="1"' in directory '/root'
2018-01-14 01:13:17,244 [salt.state       ][INFO    ][19843] {'net.ipv4.ip_nonlocal_bind': 1}
2018-01-14 01:13:17,244 [salt.state       ][INFO    ][19843] Completed state [net.ipv4.ip_nonlocal_bind] at time 01:13:17.244804 duration_in_ms=63.279
2018-01-14 01:13:17,246 [salt.state       ][INFO    ][19843] Running state [haproxy] at time 01:13:17.246241
2018-01-14 01:13:17,246 [salt.state       ][INFO    ][19843] Executing state service.running for haproxy
2018-01-14 01:13:17,247 [salt.loaded.int.module.cmdmod][INFO    ][19843] Executing command ['systemctl', 'status', 'haproxy.service', '-n', '0'] in directory '/root'
2018-01-14 01:13:17,266 [salt.loaded.int.module.cmdmod][INFO    ][19843] Executing command ['systemctl', 'is-active', 'haproxy.service'] in directory '/root'
2018-01-14 01:13:17,280 [salt.loaded.int.module.cmdmod][INFO    ][19843] Executing command ['systemctl', 'is-enabled', 'haproxy.service'] in directory '/root'
2018-01-14 01:13:17,297 [salt.state       ][INFO    ][19843] The service haproxy is already running
2018-01-14 01:13:17,298 [salt.state       ][INFO    ][19843] Completed state [haproxy] at time 01:13:17.298301 duration_in_ms=52.059
2018-01-14 01:13:17,298 [salt.state       ][INFO    ][19843] Running state [haproxy] at time 01:13:17.298697
2018-01-14 01:13:17,299 [salt.state       ][INFO    ][19843] Executing state service.mod_watch for haproxy
2018-01-14 01:13:17,300 [salt.loaded.int.module.cmdmod][INFO    ][19843] Executing command ['systemctl', 'is-active', 'haproxy.service'] in directory '/root'
2018-01-14 01:13:17,325 [salt.loaded.int.module.cmdmod][INFO    ][19843] Executing command ['systemctl', 'is-enabled', 'haproxy.service'] in directory '/root'
2018-01-14 01:13:17,339 [salt.loaded.int.module.cmdmod][INFO    ][19843] Executing command ['systemd-run', '--scope', 'systemctl', 'restart', 'haproxy.service'] in directory '/root'
2018-01-14 01:13:17,396 [salt.state       ][INFO    ][19843] {'haproxy': True}
2018-01-14 01:13:17,396 [salt.state       ][INFO    ][19843] Completed state [haproxy] at time 01:13:17.396710 duration_in_ms=98.013
2018-01-14 01:13:17,398 [salt.minion      ][INFO    ][19843] Returning information for job: 20180114011303587043
2018-01-14 01:13:22,956 [salt.minion      ][INFO    ][2613] User sudo_ubuntu Executing command service.status with jid 20180114011322100271
2018-01-14 01:13:22,984 [salt.minion      ][INFO    ][20748] Starting a new job with PID 20748
2018-01-14 01:13:23,382 [salt.loader.192.168.11.2.int.module.cmdmod][INFO    ][20748] Executing command ['systemctl', 'status', 'haproxy.service', '-n', '0'] in directory '/root'
2018-01-14 01:13:23,403 [salt.loader.192.168.11.2.int.module.cmdmod][INFO    ][20748] Executing command ['systemctl', 'is-active', 'haproxy.service'] in directory '/root'
2018-01-14 01:13:23,427 [salt.minion      ][INFO    ][20748] Returning information for job: 20180114011322100271
2018-01-14 01:13:24,647 [salt.minion      ][INFO    ][2613] User sudo_ubuntu Executing command service.restart with jid 20180114011323791169
2018-01-14 01:13:24,672 [salt.minion      ][INFO    ][20757] Starting a new job with PID 20757
2018-01-14 01:13:25,075 [salt.loader.192.168.11.2.int.module.cmdmod][INFO    ][20757] Executing command ['systemctl', 'status', 'rsyslog.service', '-n', '0'] in directory '/root'
2018-01-14 01:13:25,088 [salt.loader.192.168.11.2.int.module.cmdmod][INFO    ][20757] Executing command ['systemctl', 'is-enabled', 'rsyslog.service'] in directory '/root'
2018-01-14 01:13:25,113 [salt.loader.192.168.11.2.int.module.cmdmod][INFO    ][20757] Executing command ['systemd-run', '--scope', 'systemctl', 'restart', 'rsyslog.service'] in directory '/root'
2018-01-14 01:13:25,149 [salt.minion      ][INFO    ][20757] Returning information for job: 20180114011323791169
2018-01-14 01:28:10,309 [salt.utils.schedule][INFO    ][2613] Running scheduled job: __mine_interval
2018-01-14 02:08:20,262 [salt.minion      ][INFO    ][2613] User sudo_ubuntu Executing command cp.push_dir with jid 20180114020819544179
2018-01-14 02:08:20,297 [salt.minion      ][INFO    ][20944] Starting a new job with PID 20944
