2018-01-31 20:41:51,619 [salt.loaded.int.module.cmdmod][ERROR   ][1454] Command 'while true; do salt-call saltutil.running|grep fun: && continue; salt-call --local service.restart salt-minion; break; done' failed with return code: None
2018-01-31 20:42:43,840 [salt.loaded.int.module.cmdmod][INFO    ][7940] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2018-01-31 20:42:43,858 [salt.loaded.int.module.cmdmod][INFO    ][7940] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2018-01-31 20:42:43,886 [salt.loaded.int.module.cmdmod][INFO    ][7940] Executing command ['systemd-run', '--scope', 'systemctl', 'restart', 'salt-minion.service'] in directory '/root'
2018-01-31 20:42:43,935 [salt.utils.parsers][WARNING ][1218] Minion received a SIGTERM. Exiting.
2018-01-31 20:42:44,331 [salt.cli.daemons ][INFO    ][7988] Setting up the Salt Minion "dbs01.baremetal-mcp-pike-ovs-dpdk-ha.local"
2018-01-31 20:42:44,437 [salt.cli.daemons ][INFO    ][7988] Starting up the Salt Minion
2018-01-31 20:42:44,439 [salt.utils.event ][INFO    ][7988] Starting pull socket on /var/run/salt/minion/minion_event_e58f66c3de_pull.ipc
2018-01-31 20:42:45,034 [salt.minion      ][INFO    ][7988] Creating minion process manager
2018-01-31 20:42:46,254 [salt.loader.192.168.11.2.int.module.cmdmod][INFO    ][7988] Executing command ['date', '+%z'] in directory '/root'
2018-01-31 20:42:46,283 [salt.utils.schedule][INFO    ][7988] Updating job settings for scheduled job: __mine_interval
2018-01-31 20:42:46,284 [salt.minion      ][INFO    ][7988] Added mine.update to scheduler
2018-01-31 20:42:46,290 [salt.minion      ][INFO    ][7988] Minion is starting as user 'root'
2018-01-31 20:42:46,309 [salt.minion      ][INFO    ][7988] Minion is ready to receive requests!
2018-01-31 20:42:47,311 [salt.utils.schedule][INFO    ][7988] Running scheduled job: __mine_interval
2018-01-31 20:42:51,295 [salt.minion      ][INFO    ][7988] User sudo_ubuntu Executing command ssh.set_auth_key with jid 20180131204251891577
2018-01-31 20:42:51,323 [salt.minion      ][INFO    ][8079] Starting a new job with PID 8079
2018-01-31 20:42:51,334 [salt.loader.192.168.11.2.int.module.ssh][WARNING ][8079] Public Key hashing currently defaults to "md5". This will change to "sha256" in the Nitrogen release.
2018-01-31 20:42:51,337 [salt.minion      ][INFO    ][8079] Returning information for job: 20180131204251891577
2018-01-31 20:43:14,824 [salt.minion      ][INFO    ][7988] User sudo_ubuntu Executing command pkg.upgrade with jid 20180131204315424754
2018-01-31 20:43:14,844 [salt.minion      ][INFO    ][8091] Starting a new job with PID 8091
2018-01-31 20:43:14,871 [salt.loader.192.168.11.2.int.module.cmdmod][INFO    ][8091] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2018-01-31 20:43:15,252 [salt.loader.192.168.11.2.int.module.cmdmod][INFO    ][8091] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'upgrade'] in directory '/root'
2018-01-31 20:43:22,629 [salt.loader.192.168.11.2.int.module.cmdmod][INFO    ][8091] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2018-01-31 20:43:22,665 [salt.minion      ][INFO    ][8091] Returning information for job: 20180131204315424754
2018-01-31 20:46:30,445 [salt.minion      ][INFO    ][7988] User sudo_ubuntu Executing command test.ping with jid 20180131204631047668
2018-01-31 20:46:30,469 [salt.minion      ][INFO    ][8925] Starting a new job with PID 8925
2018-01-31 20:46:30,538 [salt.minion      ][INFO    ][8925] Returning information for job: 20180131204631047668
2018-01-31 20:48:21,294 [salt.minion      ][INFO    ][7988] User sudo_ubuntu Executing command state.sls with jid 20180131204821895590
2018-01-31 20:48:21,321 [salt.minion      ][INFO    ][8930] Starting a new job with PID 8930
2018-01-31 20:48:23,763 [salt.state       ][INFO    ][8930] Loading fresh modules for state activity
2018-01-31 20:48:23,827 [salt.fileclient  ][INFO    ][8930] Fetching file from saltenv 'base', ** done ** 'keepalived/init.sls'
2018-01-31 20:48:23,870 [salt.fileclient  ][INFO    ][8930] Fetching file from saltenv 'base', ** done ** 'keepalived/cluster.sls'
2018-01-31 20:48:24,449 [salt.state       ][INFO    ][8930] Running state [keepalived] at time 20:48:24.449061
2018-01-31 20:48:24,449 [salt.state       ][INFO    ][8930] Executing state pkg.installed for keepalived
2018-01-31 20:48:24,450 [salt.loaded.int.module.cmdmod][INFO    ][8930] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2018-01-31 20:48:24,866 [salt.loaded.int.module.cmdmod][INFO    ][8930] Executing command ['apt-cache', '-q', 'policy', 'keepalived'] in directory '/root'
2018-01-31 20:48:24,967 [salt.loaded.int.module.cmdmod][INFO    ][8930] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2018-01-31 20:48:26,952 [salt.loaded.int.module.cmdmod][INFO    ][8930] Executing command ['dpkg', '--get-selections', '*'] in directory '/root'
2018-01-31 20:48:26,987 [salt.loaded.int.module.cmdmod][INFO    ][8930] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'keepalived'] in directory '/root'
2018-01-31 20:48:30,962 [salt.loaded.int.module.cmdmod][INFO    ][8930] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2018-01-31 20:48:31,016 [salt.state       ][INFO    ][8930] Made the following changes:
'libsnmp30' changed from 'absent' to '5.7.3+dfsg-1ubuntu4'
'libnl-3-200' changed from 'absent' to '3.2.27-1ubuntu0.16.04.1'
'libsensors4' changed from 'absent' to '1:3.4.0-2'
'libsnmp-base' changed from 'absent' to '5.7.3+dfsg-1ubuntu4'
'keepalived' changed from 'absent' to '1:1.2.19-1ubuntu0.2'
'ipvsadm' changed from 'absent' to '1:1.28-3'
'libnl-genl-3-200' changed from 'absent' to '3.2.27-1ubuntu0.16.04.1'

2018-01-31 20:48:31,039 [salt.state       ][INFO    ][8930] Loading fresh modules for state activity
2018-01-31 20:48:31,070 [salt.state       ][INFO    ][8930] Completed state [keepalived] at time 20:48:31.070153 duration_in_ms=6621.093
2018-01-31 20:48:31,080 [salt.state       ][INFO    ][8930] Running state [lsof] at time 20:48:31.080402
2018-01-31 20:48:31,080 [salt.state       ][INFO    ][8930] Executing state pkg.installed for lsof
2018-01-31 20:48:31,530 [salt.state       ][INFO    ][8930] All specified packages are already installed
2018-01-31 20:48:31,531 [salt.state       ][INFO    ][8930] Completed state [lsof] at time 20:48:31.531431 duration_in_ms=451.028
2018-01-31 20:48:31,534 [salt.state       ][INFO    ][8930] Running state [/etc/keepalived/keepalived.conf] at time 20:48:31.534104
2018-01-31 20:48:31,534 [salt.state       ][INFO    ][8930] Executing state file.managed for /etc/keepalived/keepalived.conf
2018-01-31 20:48:31,580 [salt.fileclient  ][INFO    ][8930] Fetching file from saltenv 'base', ** done ** 'keepalived/files/keepalived.conf'
2018-01-31 20:48:31,637 [salt.state       ][INFO    ][8930] File changed:
New file
2018-01-31 20:48:31,637 [salt.state       ][INFO    ][8930] Completed state [/etc/keepalived/keepalived.conf] at time 20:48:31.637911 duration_in_ms=103.807
2018-01-31 20:48:31,638 [salt.state       ][INFO    ][8930] Running state [keepalived] at time 20:48:31.638947
2018-01-31 20:48:31,639 [salt.state       ][INFO    ][8930] Executing state service.running for keepalived
2018-01-31 20:48:31,640 [salt.loaded.int.module.cmdmod][INFO    ][8930] Executing command ['systemctl', 'status', 'keepalived.service', '-n', '0'] in directory '/root'
2018-01-31 20:48:31,666 [salt.loaded.int.module.cmdmod][INFO    ][8930] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2018-01-31 20:48:31,686 [salt.minion      ][INFO    ][7988] User sudo_ubuntu Executing command saltutil.find_job with jid 20180131204831954034
2018-01-31 20:48:31,687 [salt.loaded.int.module.cmdmod][INFO    ][8930] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2018-01-31 20:48:31,707 [salt.minion      ][INFO    ][10182] Starting a new job with PID 10182
2018-01-31 20:48:31,710 [salt.loaded.int.module.cmdmod][INFO    ][8930] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2018-01-31 20:48:31,723 [salt.minion      ][INFO    ][10182] Returning information for job: 20180131204831954034
2018-01-31 20:48:31,738 [salt.loaded.int.module.cmdmod][INFO    ][8930] Executing command ['systemd-run', '--scope', 'systemctl', 'start', 'keepalived.service'] in directory '/root'
2018-01-31 20:48:31,823 [salt.loaded.int.module.cmdmod][INFO    ][8930] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2018-01-31 20:48:31,846 [salt.loaded.int.module.cmdmod][INFO    ][8930] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2018-01-31 20:48:31,864 [salt.loaded.int.module.cmdmod][INFO    ][8930] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2018-01-31 20:48:31,889 [salt.state       ][INFO    ][8930] {'keepalived': True}
2018-01-31 20:48:31,889 [salt.state       ][INFO    ][8930] Completed state [keepalived] at time 20:48:31.889806 duration_in_ms=250.858
2018-01-31 20:48:31,891 [salt.minion      ][INFO    ][8930] Returning information for job: 20180131204821895590
2018-01-31 20:49:10,069 [salt.minion      ][INFO    ][7988] User sudo_ubuntu Executing command pillar.get with jid 20180131204910674504
2018-01-31 20:49:10,094 [salt.minion      ][INFO    ][10206] Starting a new job with PID 10206
2018-01-31 20:49:10,102 [salt.minion      ][INFO    ][10206] Returning information for job: 20180131204910674504
2018-01-31 20:55:40,251 [salt.minion      ][INFO    ][7988] User sudo_ubuntu Executing command state.sls with jid 20180131205540855952
2018-01-31 20:55:40,275 [salt.minion      ][INFO    ][10215] Starting a new job with PID 10215
2018-01-31 20:55:42,669 [salt.state       ][INFO    ][10215] Loading fresh modules for state activity
2018-01-31 20:55:42,730 [salt.fileclient  ][INFO    ][10215] Fetching file from saltenv 'base', ** done ** 'galera/init.sls'
2018-01-31 20:55:42,769 [salt.fileclient  ][INFO    ][10215] Fetching file from saltenv 'base', ** done ** 'galera/master.sls'
2018-01-31 20:55:42,844 [py.warnings      ][WARNING ][10215] /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-31 20:55:42,846 [salt.loaded.int.module.cmdmod][INFO    ][10215] Executing command 'test -e /var/lib/mysql/.galera_bootstrap; echo $?' in directory '/root'
2018-01-31 20:55:42,940 [salt.fileclient  ][INFO    ][10215] Fetching file from saltenv 'base', ** done ** 'galera/server.sls'
2018-01-31 20:55:43,723 [salt.state       ][INFO    ][10215] Running state [/etc/mysql/my.cnf] at time 20:55:43.723474
2018-01-31 20:55:43,724 [salt.state       ][INFO    ][10215] Executing state file.managed for /etc/mysql/my.cnf
2018-01-31 20:55:43,767 [salt.fileclient  ][INFO    ][10215] Fetching file from saltenv 'base', ** done ** 'galera/files/my.cnf.pre'
2018-01-31 20:55:43,775 [salt.state       ][INFO    ][10215] File changed:
New file
2018-01-31 20:55:43,775 [salt.state       ][INFO    ][10215] Completed state [/etc/mysql/my.cnf] at time 20:55:43.775755 duration_in_ms=52.282
2018-01-31 20:55:43,776 [salt.state       ][INFO    ][10215] Running state [mysql-wsrep-5.6] at time 20:55:43.776710
2018-01-31 20:55:43,777 [salt.state       ][INFO    ][10215] Executing state pkg.installed for mysql-wsrep-5.6
2018-01-31 20:55:43,777 [salt.loaded.int.module.cmdmod][INFO    ][10215] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2018-01-31 20:55:44,148 [salt.loaded.int.module.cmdmod][INFO    ][10215] Executing command ['apt-cache', '-q', 'policy', 'mysql-wsrep-5.6'] in directory '/root'
2018-01-31 20:55:44,237 [salt.loaded.int.module.cmdmod][INFO    ][10215] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2018-01-31 20:55:46,244 [salt.loaded.int.module.cmdmod][INFO    ][10215] Executing command ['dpkg', '--get-selections', '*'] in directory '/root'
2018-01-31 20:55:46,278 [salt.loaded.int.module.cmdmod][INFO    ][10215] 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-31 20:55:50,355 [salt.minion      ][INFO    ][7988] User sudo_ubuntu Executing command saltutil.find_job with jid 20180131205550955933
2018-01-31 20:55:50,373 [salt.minion      ][INFO    ][11164] Starting a new job with PID 11164
2018-01-31 20:55:50,390 [salt.minion      ][INFO    ][11164] Returning information for job: 20180131205550955933
2018-01-31 20:56:00,578 [salt.minion      ][INFO    ][7988] User sudo_ubuntu Executing command saltutil.find_job with jid 20180131205601177549
2018-01-31 20:56:00,605 [salt.minion      ][INFO    ][11669] Starting a new job with PID 11669
2018-01-31 20:56:00,622 [salt.minion      ][INFO    ][11669] Returning information for job: 20180131205601177549
2018-01-31 20:56:05,486 [salt.loaded.int.module.cmdmod][INFO    ][10215] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2018-01-31 20:56:05,539 [salt.state       ][INFO    ][10215] 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.21-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.21-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-31 20:56:05,562 [salt.state       ][INFO    ][10215] Loading fresh modules for state activity
2018-01-31 20:56:05,594 [salt.state       ][INFO    ][10215] Completed state [mysql-wsrep-5.6] at time 20:56:05.594603 duration_in_ms=21817.892
2018-01-31 20:56:05,605 [salt.state       ][INFO    ][10215] Running state [galera-3] at time 20:56:05.605878
2018-01-31 20:56:05,606 [salt.state       ][INFO    ][10215] Executing state pkg.installed for galera-3
2018-01-31 20:56:06,035 [salt.loaded.int.module.cmdmod][INFO    ][10215] Executing command ['apt-cache', '-q', 'policy', 'galera-3'] in directory '/root'
2018-01-31 20:56:06,095 [salt.loaded.int.module.cmdmod][INFO    ][10215] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2018-01-31 20:56:08,054 [salt.loaded.int.module.cmdmod][INFO    ][10215] Executing command ['dpkg', '--get-selections', '*'] in directory '/root'
2018-01-31 20:56:08,090 [salt.loaded.int.module.cmdmod][INFO    ][10215] 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-31 20:56:10,115 [salt.loaded.int.module.cmdmod][INFO    ][10215] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2018-01-31 20:56:10,173 [salt.state       ][INFO    ][10215] 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-31 20:56:10,192 [salt.state       ][INFO    ][10215] Loading fresh modules for state activity
2018-01-31 20:56:10,223 [salt.state       ][INFO    ][10215] Completed state [galera-3] at time 20:56:10.223284 duration_in_ms=4617.405
2018-01-31 20:56:10,233 [salt.state       ][INFO    ][10215] Running state [rsync] at time 20:56:10.233859
2018-01-31 20:56:10,234 [salt.state       ][INFO    ][10215] Executing state pkg.installed for rsync
2018-01-31 20:56:10,658 [salt.state       ][INFO    ][10215] All specified packages are already installed
2018-01-31 20:56:10,659 [salt.state       ][INFO    ][10215] Completed state [rsync] at time 20:56:10.658967 duration_in_ms=425.107
2018-01-31 20:56:10,659 [salt.state       ][INFO    ][10215] Running state [python-mysqldb] at time 20:56:10.659863
2018-01-31 20:56:10,660 [salt.state       ][INFO    ][10215] Executing state pkg.installed for python-mysqldb
2018-01-31 20:56:10,679 [salt.loaded.int.module.cmdmod][INFO    ][10215] Executing command ['apt-cache', '-q', 'policy', 'python-mysqldb'] in directory '/root'
2018-01-31 20:56:10,751 [salt.loaded.int.module.cmdmod][INFO    ][10215] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2018-01-31 20:56:10,861 [salt.minion      ][INFO    ][7988] User sudo_ubuntu Executing command saltutil.find_job with jid 20180131205611202182
2018-01-31 20:56:10,879 [salt.minion      ][INFO    ][12324] Starting a new job with PID 12324
2018-01-31 20:56:10,896 [salt.minion      ][INFO    ][12324] Returning information for job: 20180131205611202182
2018-01-31 20:56:12,721 [salt.loaded.int.module.cmdmod][INFO    ][10215] Executing command ['dpkg', '--get-selections', '*'] in directory '/root'
2018-01-31 20:56:12,758 [salt.loaded.int.module.cmdmod][INFO    ][10215] 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-31 20:56:14,673 [salt.loaded.int.module.cmdmod][INFO    ][10215] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2018-01-31 20:56:14,717 [salt.state       ][INFO    ][10215] Made the following changes:
'python2.7-mysqldb' changed from 'absent' to '1'
'python-mysqldb' changed from 'absent' to '1.3.7-1build2'

2018-01-31 20:56:14,736 [salt.state       ][INFO    ][10215] Loading fresh modules for state activity
2018-01-31 20:56:14,771 [salt.state       ][INFO    ][10215] Completed state [python-mysqldb] at time 20:56:14.771466 duration_in_ms=4111.599
2018-01-31 20:56:14,787 [salt.state       ][INFO    ][10215] Running state [psmisc] at time 20:56:14.787149
2018-01-31 20:56:14,787 [salt.state       ][INFO    ][10215] Executing state pkg.installed for psmisc
2018-01-31 20:56:15,219 [salt.state       ][INFO    ][10215] All specified packages are already installed
2018-01-31 20:56:15,220 [salt.state       ][INFO    ][10215] Completed state [psmisc] at time 20:56:15.219988 duration_in_ms=432.838
2018-01-31 20:56:15,221 [salt.state       ][INFO    ][10215] Running state [netcat] at time 20:56:15.221129
2018-01-31 20:56:15,221 [salt.state       ][INFO    ][10215] Executing state pkg.installed for netcat
2018-01-31 20:56:15,229 [salt.state       ][INFO    ][10215] All specified packages are already installed
2018-01-31 20:56:15,229 [salt.state       ][INFO    ][10215] Completed state [netcat] at time 20:56:15.229414 duration_in_ms=8.285
2018-01-31 20:56:15,230 [salt.state       ][INFO    ][10215] Running state [percona-xtrabackup] at time 20:56:15.230300
2018-01-31 20:56:15,230 [salt.state       ][INFO    ][10215] Executing state pkg.installed for percona-xtrabackup
2018-01-31 20:56:15,250 [salt.loaded.int.module.cmdmod][INFO    ][10215] Executing command ['apt-cache', '-q', 'policy', 'percona-xtrabackup'] in directory '/root'
2018-01-31 20:56:15,311 [salt.loaded.int.module.cmdmod][INFO    ][10215] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2018-01-31 20:56:17,320 [salt.loaded.int.module.cmdmod][INFO    ][10215] Executing command ['dpkg', '--get-selections', '*'] in directory '/root'
2018-01-31 20:56:17,360 [salt.loaded.int.module.cmdmod][INFO    ][10215] 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-31 20:56:20,108 [salt.loaded.int.module.cmdmod][INFO    ][10215] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2018-01-31 20:56:20,164 [salt.state       ][INFO    ][10215] 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-31 20:56:20,184 [salt.state       ][INFO    ][10215] Loading fresh modules for state activity
2018-01-31 20:56:20,216 [salt.state       ][INFO    ][10215] Completed state [percona-xtrabackup] at time 20:56:20.216881 duration_in_ms=4986.581
2018-01-31 20:56:20,227 [salt.state       ][INFO    ][10215] Running state [socat] at time 20:56:20.227299
2018-01-31 20:56:20,227 [salt.state       ][INFO    ][10215] Executing state pkg.installed for socat
2018-01-31 20:56:20,641 [salt.state       ][INFO    ][10215] All specified packages are already installed
2018-01-31 20:56:20,642 [salt.state       ][INFO    ][10215] Completed state [socat] at time 20:56:20.642458 duration_in_ms=415.158
2018-01-31 20:56:20,643 [salt.state       ][INFO    ][10215] Running state [libdbd-mysql] at time 20:56:20.643654
2018-01-31 20:56:20,644 [salt.state       ][INFO    ][10215] Executing state pkg.installed for libdbd-mysql
2018-01-31 20:56:20,664 [salt.loaded.int.module.cmdmod][INFO    ][10215] Executing command ['apt-cache', '-q', 'policy', 'libdbd-mysql'] in directory '/root'
2018-01-31 20:56:20,728 [salt.loaded.int.module.cmdmod][INFO    ][10215] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2018-01-31 20:56:20,870 [salt.minion      ][INFO    ][7988] User sudo_ubuntu Executing command saltutil.find_job with jid 20180131205621264560
2018-01-31 20:56:20,889 [salt.minion      ][INFO    ][13324] Starting a new job with PID 13324
2018-01-31 20:56:20,905 [salt.minion      ][INFO    ][13324] Returning information for job: 20180131205621264560
2018-01-31 20:56:23,147 [salt.loaded.int.module.cmdmod][INFO    ][10215] Executing command ['dpkg', '--get-selections', '*'] in directory '/root'
2018-01-31 20:56:23,185 [salt.loaded.int.module.cmdmod][INFO    ][10215] 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-31 20:56:25,135 [salt.loaded.int.module.cmdmod][INFO    ][10215] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2018-01-31 20:56:25,189 [salt.state       ][INFO    ][10215] 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-31 20:56:25,209 [salt.state       ][INFO    ][10215] Loading fresh modules for state activity
2018-01-31 20:56:25,335 [salt.state       ][INFO    ][10215] Completed state [libdbd-mysql] at time 20:56:25.335010 duration_in_ms=4691.355
2018-01-31 20:56:25,347 [salt.state       ][INFO    ][10215] Running state [python-pymysql] at time 20:56:25.347647
2018-01-31 20:56:25,348 [salt.state       ][INFO    ][10215] Executing state pkg.installed for python-pymysql
2018-01-31 20:56:25,770 [salt.state       ][INFO    ][10215] All specified packages are already installed
2018-01-31 20:56:25,770 [salt.state       ][INFO    ][10215] Completed state [python-pymysql] at time 20:56:25.770413 duration_in_ms=422.765
2018-01-31 20:56:25,773 [salt.state       ][INFO    ][10215] Running state [/var/log/mysql] at time 20:56:25.773317
2018-01-31 20:56:25,773 [salt.state       ][INFO    ][10215] Executing state file.directory for /var/log/mysql
2018-01-31 20:56:25,774 [salt.state       ][INFO    ][10215] {'mode': '0755'}
2018-01-31 20:56:25,774 [salt.state       ][INFO    ][10215] Completed state [/var/log/mysql] at time 20:56:25.774805 duration_in_ms=1.488
2018-01-31 20:56:25,775 [salt.state       ][INFO    ][10215] Running state [/etc/mysql] at time 20:56:25.775586
2018-01-31 20:56:25,776 [salt.state       ][INFO    ][10215] Executing state file.directory for /etc/mysql
2018-01-31 20:56:25,776 [salt.state       ][INFO    ][10215] Directory /etc/mysql is in the correct state
2018-01-31 20:56:25,776 [salt.state       ][INFO    ][10215] Completed state [/etc/mysql] at time 20:56:25.776901 duration_in_ms=1.314
2018-01-31 20:56:25,777 [salt.state       ][INFO    ][10215] Running state [/var/run/mysqld] at time 20:56:25.777693
2018-01-31 20:56:25,777 [salt.state       ][INFO    ][10215] Executing state file.directory for /var/run/mysqld
2018-01-31 20:56:25,778 [salt.state       ][INFO    ][10215] Directory /var/run/mysqld is in the correct state
2018-01-31 20:56:25,779 [salt.state       ][INFO    ][10215] Completed state [/var/run/mysqld] at time 20:56:25.779091 duration_in_ms=1.397
2018-01-31 20:56:25,779 [salt.state       ][INFO    ][10215] Running state [/etc/systemd/system/mysql.service.d] at time 20:56:25.779902
2018-01-31 20:56:25,780 [salt.state       ][INFO    ][10215] Executing state file.directory for /etc/systemd/system/mysql.service.d
2018-01-31 20:56:25,781 [salt.state       ][INFO    ][10215] {'/etc/systemd/system/mysql.service.d': 'New Dir'}
2018-01-31 20:56:25,781 [salt.state       ][INFO    ][10215] Completed state [/etc/systemd/system/mysql.service.d] at time 20:56:25.781551 duration_in_ms=1.649
2018-01-31 20:56:25,783 [salt.state       ][INFO    ][10215] Running state [/etc/systemd/system/mysql.service.d/override.conf] at time 20:56:25.783173
2018-01-31 20:56:25,783 [salt.state       ][INFO    ][10215] Executing state file.managed for /etc/systemd/system/mysql.service.d/override.conf
2018-01-31 20:56:25,785 [salt.state       ][INFO    ][10215] File changed:
New file
2018-01-31 20:56:25,785 [salt.state       ][INFO    ][10215] Completed state [/etc/systemd/system/mysql.service.d/override.conf] at time 20:56:25.785609 duration_in_ms=2.436
2018-01-31 20:56:25,787 [salt.state       ][INFO    ][10215] Running state [service.systemctl_reload] at time 20:56:25.787042
2018-01-31 20:56:25,787 [salt.state       ][INFO    ][10215] Executing state module.wait for service.systemctl_reload
2018-01-31 20:56:25,787 [salt.state       ][INFO    ][10215] No changes made for service.systemctl_reload
2018-01-31 20:56:25,787 [salt.state       ][INFO    ][10215] Completed state [service.systemctl_reload] at time 20:56:25.787738 duration_in_ms=0.695
2018-01-31 20:56:25,787 [salt.state       ][INFO    ][10215] Running state [service.systemctl_reload] at time 20:56:25.787951
2018-01-31 20:56:25,788 [salt.state       ][INFO    ][10215] Executing state module.mod_watch for service.systemctl_reload
2018-01-31 20:56:25,788 [salt.loaded.int.module.cmdmod][INFO    ][10215] Executing command ['systemctl', '--system', 'daemon-reload'] in directory '/root'
2018-01-31 20:56:25,876 [salt.state       ][INFO    ][10215] {'ret': True}
2018-01-31 20:56:25,877 [salt.state       ][INFO    ][10215] Completed state [service.systemctl_reload] at time 20:56:25.877255 duration_in_ms=89.303
2018-01-31 20:56:25,878 [salt.state       ][INFO    ][10215] Running state [/etc/mysql/debian.cnf] at time 20:56:25.878740
2018-01-31 20:56:25,879 [salt.state       ][INFO    ][10215] Executing state file.managed for /etc/mysql/debian.cnf
2018-01-31 20:56:25,923 [salt.fileclient  ][INFO    ][10215] Fetching file from saltenv 'base', ** done ** 'galera/files/debian.cnf'
2018-01-31 20:56:26,000 [salt.state       ][INFO    ][10215] File changed:
--- 
+++ 
@@ -1,12 +1,13 @@
-# Automatically generated for Debian scripts. DO NOT TOUCH!
+
 [client]
-host     = localhost
-user     = debian-sys-maint
-password = uZ58ZSqVz96FpeRx
-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 = uZ58ZSqVz96FpeRx
-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-31 20:56:26,000 [salt.state       ][INFO    ][10215] Completed state [/etc/mysql/debian.cnf] at time 20:56:26.000470 duration_in_ms=121.73
2018-01-31 20:56:26,000 [salt.state       ][INFO    ][10215] Running state [/usr/local/sbin/galera_init.sh] at time 20:56:26.000712
2018-01-31 20:56:26,000 [salt.state       ][INFO    ][10215] Executing state file.managed for /usr/local/sbin/galera_init.sh
2018-01-31 20:56:26,030 [salt.fileclient  ][INFO    ][10215] Fetching file from saltenv 'base', ** done ** 'galera/files/init_bootstrap.sh'
2018-01-31 20:56:26,035 [salt.state       ][INFO    ][10215] File changed:
New file
2018-01-31 20:56:26,036 [salt.state       ][INFO    ][10215] Completed state [/usr/local/sbin/galera_init.sh] at time 20:56:26.036586 duration_in_ms=35.874
2018-01-31 20:56:26,036 [salt.state       ][INFO    ][10215] Running state [/usr/local/sbin/galera_bootstrap.sh] at time 20:56:26.036936
2018-01-31 20:56:26,037 [salt.state       ][INFO    ][10215] Executing state file.managed for /usr/local/sbin/galera_bootstrap.sh
2018-01-31 20:56:26,069 [salt.fileclient  ][INFO    ][10215] Fetching file from saltenv 'base', ** done ** 'galera/files/bootstrap.sh'
2018-01-31 20:56:26,073 [salt.state       ][INFO    ][10215] File changed:
New file
2018-01-31 20:56:26,073 [salt.state       ][INFO    ][10215] Completed state [/usr/local/sbin/galera_bootstrap.sh] at time 20:56:26.073523 duration_in_ms=36.587
2018-01-31 20:56:26,076 [salt.state       ][INFO    ][10215] Running state [/usr/local/sbin/galera_init.sh] at time 20:56:26.076801
2018-01-31 20:56:26,077 [salt.state       ][INFO    ][10215] Executing state cmd.run for /usr/local/sbin/galera_init.sh
2018-01-31 20:56:26,077 [salt.loaded.int.module.cmdmod][INFO    ][10215] Executing command '/usr/local/sbin/galera_init.sh' in directory '/root'
2018-01-31 20:56:29,927 [salt.state       ][INFO    ][10215] {'pid': 13779, 'retcode': 0, 'stderr': '', 'stdout': 'Sucessfully connected to the MySQL service (0 retries).'}
2018-01-31 20:56:29,928 [salt.state       ][INFO    ][10215] Completed state [/usr/local/sbin/galera_init.sh] at time 20:56:29.928584 duration_in_ms=3851.782
2018-01-31 20:56:29,932 [salt.state       ][INFO    ][10215] Running state [mysqladmin password "opnfv_secret"] at time 20:56:29.932252
2018-01-31 20:56:29,933 [salt.state       ][INFO    ][10215] Executing state cmd.run for mysqladmin password "opnfv_secret"
2018-01-31 20:56:29,934 [salt.loaded.int.module.cmdmod][INFO    ][10215] Executing command 'mysqladmin password "opnfv_secret"' in directory '/root'
2018-01-31 20:56:29,963 [salt.state       ][INFO    ][10215] {'pid': 14223, 'retcode': 0, 'stderr': 'Warning: Using a password on the command line interface can be insecure.', 'stdout': ''}
2018-01-31 20:56:29,964 [salt.state       ][INFO    ][10215] Completed state [mysqladmin password "opnfv_secret"] at time 20:56:29.964521 duration_in_ms=32.269
2018-01-31 20:56:29,966 [salt.state       ][INFO    ][10215] Running state [mysql -u root -popnfv_secret -e "GRANT ALL PRIVILEGES ON *.* TO 'debian-sys-maint'@'localhost' IDENTIFIED BY 'opnfv_secret';"] at time 20:56:29.966721
2018-01-31 20:56:29,967 [salt.state       ][INFO    ][10215] 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-31 20:56:29,968 [salt.loaded.int.module.cmdmod][INFO    ][10215] 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-31 20:56:29,990 [salt.state       ][INFO    ][10215] {'pid': 14225, 'retcode': 0, 'stderr': 'Warning: Using a password on the command line interface can be insecure.', 'stdout': ''}
2018-01-31 20:56:29,991 [salt.state       ][INFO    ][10215] Completed state [mysql -u root -popnfv_secret -e "GRANT ALL PRIVILEGES ON *.* TO 'debian-sys-maint'@'localhost' IDENTIFIED BY 'opnfv_secret';"] at time 20:56:29.991173 duration_in_ms=24.452
2018-01-31 20:56:29,995 [salt.state       ][INFO    ][10215] Running state [mysql] at time 20:56:29.995046
2018-01-31 20:56:29,995 [salt.state       ][INFO    ][10215] Executing state service.dead for mysql
2018-01-31 20:56:29,996 [salt.loaded.int.module.cmdmod][INFO    ][10215] Executing command ['systemctl', 'status', 'mysql.service', '-n', '0'] in directory '/root'
2018-01-31 20:56:30,018 [salt.loaded.int.module.cmdmod][INFO    ][10215] Executing command ['systemctl', 'is-active', 'mysql.service'] in directory '/root'
2018-01-31 20:56:30,038 [salt.loaded.int.module.cmdmod][INFO    ][10215] Executing command ['systemctl', 'is-enabled', 'mysql.service'] in directory '/root'
2018-01-31 20:56:30,064 [salt.loaded.int.module.cmdmod][INFO    ][10215] Executing command ['systemd-run', '--scope', 'systemctl', 'stop', 'mysql.service'] in directory '/root'
2018-01-31 20:56:30,893 [salt.minion      ][INFO    ][7988] User sudo_ubuntu Executing command saltutil.find_job with jid 20180131205631491801
2018-01-31 20:56:30,921 [salt.minion      ][INFO    ][14286] Starting a new job with PID 14286
2018-01-31 20:56:30,937 [salt.minion      ][INFO    ][14286] Returning information for job: 20180131205631491801
2018-01-31 20:56:40,931 [salt.minion      ][INFO    ][7988] User sudo_ubuntu Executing command saltutil.find_job with jid 20180131205641530283
2018-01-31 20:56:40,960 [salt.minion      ][INFO    ][14323] Starting a new job with PID 14323
2018-01-31 20:56:40,979 [salt.minion      ][INFO    ][14323] Returning information for job: 20180131205641530283
2018-01-31 20:56:50,966 [salt.minion      ][INFO    ][7988] User sudo_ubuntu Executing command saltutil.find_job with jid 20180131205651565707
2018-01-31 20:56:50,992 [salt.minion      ][INFO    ][14328] Starting a new job with PID 14328
2018-01-31 20:56:51,011 [salt.minion      ][INFO    ][14328] Returning information for job: 20180131205651565707
2018-01-31 20:57:00,997 [salt.minion      ][INFO    ][7988] User sudo_ubuntu Executing command saltutil.find_job with jid 20180131205701597965
2018-01-31 20:57:01,021 [salt.minion      ][INFO    ][14333] Starting a new job with PID 14333
2018-01-31 20:57:01,040 [salt.minion      ][INFO    ][14333] Returning information for job: 20180131205701597965
2018-01-31 20:57:11,026 [salt.minion      ][INFO    ][7988] User sudo_ubuntu Executing command saltutil.find_job with jid 20180131205711629649
2018-01-31 20:57:11,056 [salt.minion      ][INFO    ][14338] Starting a new job with PID 14338
2018-01-31 20:57:11,073 [salt.minion      ][INFO    ][14338] Returning information for job: 20180131205711629649
2018-01-31 20:57:21,066 [salt.minion      ][INFO    ][7988] User sudo_ubuntu Executing command saltutil.find_job with jid 20180131205721669869
2018-01-31 20:57:21,096 [salt.minion      ][INFO    ][14343] Starting a new job with PID 14343
2018-01-31 20:57:21,117 [salt.minion      ][INFO    ][14343] Returning information for job: 20180131205721669869
2018-01-31 20:57:31,112 [salt.minion      ][INFO    ][7988] User sudo_ubuntu Executing command saltutil.find_job with jid 20180131205731714692
2018-01-31 20:57:31,138 [salt.minion      ][INFO    ][14348] Starting a new job with PID 14348
2018-01-31 20:57:31,158 [salt.minion      ][INFO    ][14348] Returning information for job: 20180131205731714692
2018-01-31 20:57:41,154 [salt.minion      ][INFO    ][7988] User sudo_ubuntu Executing command saltutil.find_job with jid 20180131205741756413
2018-01-31 20:57:41,181 [salt.minion      ][INFO    ][14353] Starting a new job with PID 14353
2018-01-31 20:57:41,197 [salt.minion      ][INFO    ][14353] Returning information for job: 20180131205741756413
2018-01-31 20:57:51,205 [salt.minion      ][INFO    ][7988] User sudo_ubuntu Executing command saltutil.find_job with jid 20180131205751805942
2018-01-31 20:57:51,235 [salt.minion      ][INFO    ][14358] Starting a new job with PID 14358
2018-01-31 20:57:51,251 [salt.minion      ][INFO    ][14358] Returning information for job: 20180131205751805942
2018-01-31 20:58:01,254 [salt.minion      ][INFO    ][7988] User sudo_ubuntu Executing command saltutil.find_job with jid 20180131205801852538
2018-01-31 20:58:01,280 [salt.minion      ][INFO    ][14363] Starting a new job with PID 14363
2018-01-31 20:58:01,296 [salt.minion      ][INFO    ][14363] Returning information for job: 20180131205801852538
2018-01-31 20:58:11,307 [salt.minion      ][INFO    ][7988] User sudo_ubuntu Executing command saltutil.find_job with jid 20180131205811903698
2018-01-31 20:58:11,334 [salt.minion      ][INFO    ][14368] Starting a new job with PID 14368
2018-01-31 20:58:11,351 [salt.minion      ][INFO    ][14368] Returning information for job: 20180131205811903698
2018-01-31 20:58:21,351 [salt.minion      ][INFO    ][7988] User sudo_ubuntu Executing command saltutil.find_job with jid 20180131205821952224
2018-01-31 20:58:21,380 [salt.minion      ][INFO    ][14373] Starting a new job with PID 14373
2018-01-31 20:58:21,397 [salt.minion      ][INFO    ][14373] Returning information for job: 20180131205821952224
2018-01-31 20:58:31,398 [salt.minion      ][INFO    ][7988] User sudo_ubuntu Executing command saltutil.find_job with jid 20180131205831996763
2018-01-31 20:58:31,425 [salt.minion      ][INFO    ][14378] Starting a new job with PID 14378
2018-01-31 20:58:31,441 [salt.minion      ][INFO    ][14378] Returning information for job: 20180131205831996763
2018-01-31 20:58:41,441 [salt.minion      ][INFO    ][7988] User sudo_ubuntu Executing command saltutil.find_job with jid 20180131205842043892
2018-01-31 20:58:41,466 [salt.minion      ][INFO    ][14383] Starting a new job with PID 14383
2018-01-31 20:58:41,484 [salt.minion      ][INFO    ][14383] Returning information for job: 20180131205842043892
2018-01-31 20:58:51,500 [salt.minion      ][INFO    ][7988] User sudo_ubuntu Executing command saltutil.find_job with jid 20180131205852103182
2018-01-31 20:58:51,526 [salt.minion      ][INFO    ][14388] Starting a new job with PID 14388
2018-01-31 20:58:51,547 [salt.minion      ][INFO    ][14388] Returning information for job: 20180131205852103182
2018-01-31 20:59:01,566 [salt.minion      ][INFO    ][7988] User sudo_ubuntu Executing command saltutil.find_job with jid 20180131205902163794
2018-01-31 20:59:01,592 [salt.minion      ][INFO    ][14393] Starting a new job with PID 14393
2018-01-31 20:59:01,608 [salt.minion      ][INFO    ][14393] Returning information for job: 20180131205902163794
2018-01-31 20:59:11,624 [salt.minion      ][INFO    ][7988] User sudo_ubuntu Executing command saltutil.find_job with jid 20180131205912228117
2018-01-31 20:59:11,650 [salt.minion      ][INFO    ][14398] Starting a new job with PID 14398
2018-01-31 20:59:11,671 [salt.minion      ][INFO    ][14398] Returning information for job: 20180131205912228117
2018-01-31 20:59:21,688 [salt.minion      ][INFO    ][7988] User sudo_ubuntu Executing command saltutil.find_job with jid 20180131205922290979
2018-01-31 20:59:21,717 [salt.minion      ][INFO    ][14403] Starting a new job with PID 14403
2018-01-31 20:59:21,733 [salt.minion      ][INFO    ][14403] Returning information for job: 20180131205922290979
2018-01-31 20:59:31,769 [salt.minion      ][INFO    ][7988] User sudo_ubuntu Executing command saltutil.find_job with jid 20180131205932371344
2018-01-31 20:59:31,795 [salt.minion      ][INFO    ][14408] Starting a new job with PID 14408
2018-01-31 20:59:31,810 [salt.minion      ][INFO    ][14408] Returning information for job: 20180131205932371344
2018-01-31 20:59:41,844 [salt.minion      ][INFO    ][7988] User sudo_ubuntu Executing command saltutil.find_job with jid 20180131205942445844
2018-01-31 20:59:41,874 [salt.minion      ][INFO    ][14413] Starting a new job with PID 14413
2018-01-31 20:59:41,895 [salt.minion      ][INFO    ][14413] Returning information for job: 20180131205942445844
2018-01-31 20:59:51,937 [salt.minion      ][INFO    ][7988] User sudo_ubuntu Executing command saltutil.find_job with jid 20180131205952532241
2018-01-31 20:59:51,964 [salt.minion      ][INFO    ][14418] Starting a new job with PID 14418
2018-01-31 20:59:51,982 [salt.minion      ][INFO    ][14418] Returning information for job: 20180131205952532241
2018-01-31 21:00:02,036 [salt.minion      ][INFO    ][7988] User sudo_ubuntu Executing command saltutil.find_job with jid 20180131210002635950
2018-01-31 21:00:02,060 [salt.minion      ][INFO    ][14423] Starting a new job with PID 14423
2018-01-31 21:00:02,077 [salt.minion      ][INFO    ][14423] Returning information for job: 20180131210002635950
2018-01-31 21:00:12,124 [salt.minion      ][INFO    ][7988] User sudo_ubuntu Executing command saltutil.find_job with jid 20180131210012723873
2018-01-31 21:00:12,151 [salt.minion      ][INFO    ][14428] Starting a new job with PID 14428
2018-01-31 21:00:12,168 [salt.minion      ][INFO    ][14428] Returning information for job: 20180131210012723873
2018-01-31 21:00:22,222 [salt.minion      ][INFO    ][7988] User sudo_ubuntu Executing command saltutil.find_job with jid 20180131210022820819
2018-01-31 21:00:22,251 [salt.minion      ][INFO    ][14433] Starting a new job with PID 14433
2018-01-31 21:00:22,270 [salt.minion      ][INFO    ][14433] Returning information for job: 20180131210022820819
2018-01-31 21:00:32,321 [salt.minion      ][INFO    ][7988] User sudo_ubuntu Executing command saltutil.find_job with jid 20180131210032922343
2018-01-31 21:00:32,348 [salt.minion      ][INFO    ][14438] Starting a new job with PID 14438
2018-01-31 21:00:32,365 [salt.minion      ][INFO    ][14438] Returning information for job: 20180131210032922343
2018-01-31 21:00:42,434 [salt.minion      ][INFO    ][7988] User sudo_ubuntu Executing command saltutil.find_job with jid 20180131210043031627
2018-01-31 21:00:42,460 [salt.minion      ][INFO    ][14443] Starting a new job with PID 14443
2018-01-31 21:00:42,478 [salt.minion      ][INFO    ][14443] Returning information for job: 20180131210043031627
2018-01-31 21:00:52,540 [salt.minion      ][INFO    ][7988] User sudo_ubuntu Executing command saltutil.find_job with jid 20180131210053143292
2018-01-31 21:00:52,566 [salt.minion      ][INFO    ][14448] Starting a new job with PID 14448
2018-01-31 21:00:52,584 [salt.minion      ][INFO    ][14448] Returning information for job: 20180131210053143292
2018-01-31 21:01:02,639 [salt.minion      ][INFO    ][7988] User sudo_ubuntu Executing command saltutil.find_job with jid 20180131210103241461
2018-01-31 21:01:02,667 [salt.minion      ][INFO    ][14453] Starting a new job with PID 14453
2018-01-31 21:01:02,686 [salt.minion      ][INFO    ][14453] Returning information for job: 20180131210103241461
2018-01-31 21:01:12,762 [salt.minion      ][INFO    ][7988] User sudo_ubuntu Executing command saltutil.find_job with jid 20180131210113367159
2018-01-31 21:01:12,789 [salt.minion      ][INFO    ][14458] Starting a new job with PID 14458
2018-01-31 21:01:12,805 [salt.minion      ][INFO    ][14458] Returning information for job: 20180131210113367159
2018-01-31 21:01:22,891 [salt.minion      ][INFO    ][7988] User sudo_ubuntu Executing command saltutil.find_job with jid 20180131210123491355
2018-01-31 21:01:22,915 [salt.minion      ][INFO    ][14463] Starting a new job with PID 14463
2018-01-31 21:01:22,936 [salt.minion      ][INFO    ][14463] Returning information for job: 20180131210123491355
2018-01-31 21:01:33,025 [salt.minion      ][INFO    ][7988] User sudo_ubuntu Executing command saltutil.find_job with jid 20180131210133621807
2018-01-31 21:01:33,053 [salt.minion      ][INFO    ][14468] Starting a new job with PID 14468
2018-01-31 21:01:33,070 [salt.minion      ][INFO    ][14468] Returning information for job: 20180131210133621807
2018-01-31 21:01:43,168 [salt.minion      ][INFO    ][7988] User sudo_ubuntu Executing command saltutil.find_job with jid 20180131210143765534
2018-01-31 21:01:43,194 [salt.minion      ][INFO    ][14473] Starting a new job with PID 14473
2018-01-31 21:01:43,212 [salt.minion      ][INFO    ][14473] Returning information for job: 20180131210143765534
2018-01-31 21:01:53,306 [salt.minion      ][INFO    ][7988] User sudo_ubuntu Executing command saltutil.find_job with jid 20180131210153908754
2018-01-31 21:01:53,333 [salt.minion      ][INFO    ][14478] Starting a new job with PID 14478
2018-01-31 21:01:53,351 [salt.minion      ][INFO    ][14478] Returning information for job: 20180131210153908754
2018-01-31 21:02:03,451 [salt.minion      ][INFO    ][7988] User sudo_ubuntu Executing command saltutil.find_job with jid 20180131210204054376
2018-01-31 21:02:03,478 [salt.minion      ][INFO    ][14483] Starting a new job with PID 14483
2018-01-31 21:02:03,497 [salt.minion      ][INFO    ][14483] Returning information for job: 20180131210204054376
2018-01-31 21:02:13,617 [salt.minion      ][INFO    ][7988] User sudo_ubuntu Executing command saltutil.find_job with jid 20180131210214220106
2018-01-31 21:02:13,644 [salt.minion      ][INFO    ][14488] Starting a new job with PID 14488
2018-01-31 21:02:13,663 [salt.minion      ][INFO    ][14488] Returning information for job: 20180131210214220106
2018-01-31 21:02:23,775 [salt.minion      ][INFO    ][7988] User sudo_ubuntu Executing command saltutil.find_job with jid 20180131210224376828
2018-01-31 21:02:23,803 [salt.minion      ][INFO    ][14493] Starting a new job with PID 14493
2018-01-31 21:02:23,820 [salt.minion      ][INFO    ][14493] Returning information for job: 20180131210224376828
2018-01-31 21:02:33,951 [salt.minion      ][INFO    ][7988] User sudo_ubuntu Executing command saltutil.find_job with jid 20180131210234542577
2018-01-31 21:02:33,979 [salt.minion      ][INFO    ][14498] Starting a new job with PID 14498
2018-01-31 21:02:33,996 [salt.minion      ][INFO    ][14498] Returning information for job: 20180131210234542577
2018-01-31 21:02:44,105 [salt.minion      ][INFO    ][7988] User sudo_ubuntu Executing command saltutil.find_job with jid 20180131210244708471
2018-01-31 21:02:44,132 [salt.minion      ][INFO    ][14503] Starting a new job with PID 14503
2018-01-31 21:02:44,149 [salt.minion      ][INFO    ][14503] Returning information for job: 20180131210244708471
2018-01-31 21:02:54,281 [salt.minion      ][INFO    ][7988] User sudo_ubuntu Executing command saltutil.find_job with jid 20180131210254885206
2018-01-31 21:02:54,310 [salt.minion      ][INFO    ][14508] Starting a new job with PID 14508
2018-01-31 21:02:54,332 [salt.minion      ][INFO    ][14508] Returning information for job: 20180131210254885206
2018-01-31 21:03:04,470 [salt.minion      ][INFO    ][7988] User sudo_ubuntu Executing command saltutil.find_job with jid 20180131210305069790
2018-01-31 21:03:04,497 [salt.minion      ][INFO    ][14513] Starting a new job with PID 14513
2018-01-31 21:03:04,514 [salt.minion      ][INFO    ][14513] Returning information for job: 20180131210305069790
2018-01-31 21:03:14,666 [salt.minion      ][INFO    ][7988] User sudo_ubuntu Executing command saltutil.find_job with jid 20180131210315264817
2018-01-31 21:03:14,694 [salt.minion      ][INFO    ][14518] Starting a new job with PID 14518
2018-01-31 21:03:14,711 [salt.minion      ][INFO    ][14518] Returning information for job: 20180131210315264817
2018-01-31 21:03:24,867 [salt.minion      ][INFO    ][7988] User sudo_ubuntu Executing command saltutil.find_job with jid 20180131210325467179
2018-01-31 21:03:24,894 [salt.minion      ][INFO    ][14523] Starting a new job with PID 14523
2018-01-31 21:03:24,911 [salt.minion      ][INFO    ][14523] Returning information for job: 20180131210325467179
2018-01-31 21:03:35,069 [salt.minion      ][INFO    ][7988] User sudo_ubuntu Executing command saltutil.find_job with jid 20180131210335669550
2018-01-31 21:03:35,093 [salt.minion      ][INFO    ][14528] Starting a new job with PID 14528
2018-01-31 21:03:35,111 [salt.minion      ][INFO    ][14528] Returning information for job: 20180131210335669550
2018-01-31 21:03:45,277 [salt.minion      ][INFO    ][7988] User sudo_ubuntu Executing command saltutil.find_job with jid 20180131210345881004
2018-01-31 21:03:45,305 [salt.minion      ][INFO    ][14533] Starting a new job with PID 14533
2018-01-31 21:03:45,322 [salt.minion      ][INFO    ][14533] Returning information for job: 20180131210345881004
2018-01-31 21:03:55,504 [salt.minion      ][INFO    ][7988] User sudo_ubuntu Executing command saltutil.find_job with jid 20180131210356107627
2018-01-31 21:03:55,529 [salt.minion      ][INFO    ][14538] Starting a new job with PID 14538
2018-01-31 21:03:55,547 [salt.minion      ][INFO    ][14538] Returning information for job: 20180131210356107627
2018-01-31 21:04:05,739 [salt.minion      ][INFO    ][7988] User sudo_ubuntu Executing command saltutil.find_job with jid 20180131210406339149
2018-01-31 21:04:05,766 [salt.minion      ][INFO    ][14543] Starting a new job with PID 14543
2018-01-31 21:04:05,784 [salt.minion      ][INFO    ][14543] Returning information for job: 20180131210406339149
2018-01-31 21:04:15,976 [salt.minion      ][INFO    ][7988] User sudo_ubuntu Executing command saltutil.find_job with jid 20180131210416576566
2018-01-31 21:04:16,005 [salt.minion      ][INFO    ][14548] Starting a new job with PID 14548
2018-01-31 21:04:16,021 [salt.minion      ][INFO    ][14548] Returning information for job: 20180131210416576566
2018-01-31 21:04:25,997 [salt.minion      ][INFO    ][7988] User sudo_ubuntu Executing command saltutil.find_job with jid 20180131210426602642
2018-01-31 21:04:26,025 [salt.minion      ][INFO    ][14553] Starting a new job with PID 14553
2018-01-31 21:04:26,045 [salt.minion      ][INFO    ][14553] Returning information for job: 20180131210426602642
2018-01-31 21:04:36,043 [salt.minion      ][INFO    ][7988] User sudo_ubuntu Executing command saltutil.find_job with jid 20180131210436643125
2018-01-31 21:04:36,069 [salt.minion      ][INFO    ][14558] Starting a new job with PID 14558
2018-01-31 21:04:36,090 [salt.minion      ][INFO    ][14558] Returning information for job: 20180131210436643125
2018-01-31 21:04:46,085 [salt.minion      ][INFO    ][7988] User sudo_ubuntu Executing command saltutil.find_job with jid 20180131210446690734
2018-01-31 21:04:46,116 [salt.minion      ][INFO    ][14563] Starting a new job with PID 14563
2018-01-31 21:04:46,136 [salt.minion      ][INFO    ][14563] Returning information for job: 20180131210446690734
2018-01-31 21:04:56,146 [salt.minion      ][INFO    ][7988] User sudo_ubuntu Executing command saltutil.find_job with jid 20180131210456746959
2018-01-31 21:04:56,173 [salt.minion      ][INFO    ][14568] Starting a new job with PID 14568
2018-01-31 21:04:56,193 [salt.minion      ][INFO    ][14568] Returning information for job: 20180131210456746959
2018-01-31 21:05:06,194 [salt.minion      ][INFO    ][7988] User sudo_ubuntu Executing command saltutil.find_job with jid 20180131210506798050
2018-01-31 21:05:06,225 [salt.minion      ][INFO    ][14573] Starting a new job with PID 14573
2018-01-31 21:05:06,241 [salt.minion      ][INFO    ][14573] Returning information for job: 20180131210506798050
2018-01-31 21:05:16,262 [salt.minion      ][INFO    ][7988] User sudo_ubuntu Executing command saltutil.find_job with jid 20180131210516865361
2018-01-31 21:05:16,287 [salt.minion      ][INFO    ][14578] Starting a new job with PID 14578
2018-01-31 21:05:16,307 [salt.minion      ][INFO    ][14578] Returning information for job: 20180131210516865361
2018-01-31 21:05:26,341 [salt.minion      ][INFO    ][7988] User sudo_ubuntu Executing command saltutil.find_job with jid 20180131210526942542
2018-01-31 21:05:26,370 [salt.minion      ][INFO    ][14583] Starting a new job with PID 14583
2018-01-31 21:05:26,388 [salt.minion      ][INFO    ][14583] Returning information for job: 20180131210526942542
2018-01-31 21:05:36,411 [salt.minion      ][INFO    ][7988] User sudo_ubuntu Executing command saltutil.find_job with jid 20180131210537016398
2018-01-31 21:05:36,439 [salt.minion      ][INFO    ][14588] Starting a new job with PID 14588
2018-01-31 21:05:36,455 [salt.minion      ][INFO    ][14588] Returning information for job: 20180131210537016398
2018-01-31 21:05:46,504 [salt.minion      ][INFO    ][7988] User sudo_ubuntu Executing command saltutil.find_job with jid 20180131210547107337
2018-01-31 21:05:46,530 [salt.minion      ][INFO    ][14593] Starting a new job with PID 14593
2018-01-31 21:05:46,548 [salt.minion      ][INFO    ][14593] Returning information for job: 20180131210547107337
2018-01-31 21:05:56,599 [salt.minion      ][INFO    ][7988] User sudo_ubuntu Executing command saltutil.find_job with jid 20180131210557206855
2018-01-31 21:05:56,624 [salt.minion      ][INFO    ][14598] Starting a new job with PID 14598
2018-01-31 21:05:56,641 [salt.minion      ][INFO    ][14598] Returning information for job: 20180131210557206855
2018-01-31 21:06:06,690 [salt.minion      ][INFO    ][7988] User sudo_ubuntu Executing command saltutil.find_job with jid 20180131210607294617
2018-01-31 21:06:06,716 [salt.minion      ][INFO    ][14603] Starting a new job with PID 14603
2018-01-31 21:06:06,733 [salt.minion      ][INFO    ][14603] Returning information for job: 20180131210607294617
2018-01-31 21:06:16,803 [salt.minion      ][INFO    ][7988] User sudo_ubuntu Executing command saltutil.find_job with jid 20180131210617401993
2018-01-31 21:06:16,829 [salt.minion      ][INFO    ][14608] Starting a new job with PID 14608
2018-01-31 21:06:16,847 [salt.minion      ][INFO    ][14608] Returning information for job: 20180131210617401993
2018-01-31 21:06:26,923 [salt.minion      ][INFO    ][7988] User sudo_ubuntu Executing command saltutil.find_job with jid 20180131210627528950
2018-01-31 21:06:26,949 [salt.minion      ][INFO    ][14613] Starting a new job with PID 14613
2018-01-31 21:06:26,971 [salt.minion      ][INFO    ][14613] Returning information for job: 20180131210627528950
2018-01-31 21:06:30,175 [salt.loaded.int.module.cmdmod][INFO    ][10215] Executing command ['systemctl', 'is-active', 'mysql.service'] in directory '/root'
2018-01-31 21:06:30,206 [salt.loaded.int.module.cmdmod][INFO    ][10215] Executing command ['systemctl', 'is-enabled', 'mysql.service'] in directory '/root'
2018-01-31 21:06:30,239 [salt.state       ][INFO    ][10215] {'mysql': False}
2018-01-31 21:06:30,240 [salt.state       ][INFO    ][10215] Completed state [mysql] at time 21:06:30.240196 duration_in_ms=600245.15
2018-01-31 21:06:30,242 [salt.state       ][INFO    ][10215] Running state [/etc/mysql/my.cnf] at time 21:06:30.242150
2018-01-31 21:06:30,242 [salt.state       ][INFO    ][10215] Executing state file.managed for /etc/mysql/my.cnf
2018-01-31 21:06:30,299 [salt.fileclient  ][INFO    ][10215] Fetching file from saltenv 'base', ** done ** 'galera/files/my.cnf.init'
2018-01-31 21:06:30,375 [salt.state       ][INFO    ][10215] File changed:
--- 
+++ 
@@ -1,36 +1,61 @@
-[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
 [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=192.168.10.51
+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
 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
+
+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://"
+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=192.168.10.51
+wsrep_provider_options="gcache.size = 256M"
+wsrep_provider_options="gmcast.listen_addr = tcp://192.168.10.51:4567"
+
+
+
+[xtrabackup]
+parallel=4
+
+[sst]
+streamfmt=xbstream
+transferfmt=socat
+sockopt=,nodelay,sndbuf=1048576,rcvbuf=1048576

2018-01-31 21:06:30,375 [salt.state       ][INFO    ][10215] Completed state [/etc/mysql/my.cnf] at time 21:06:30.375384 duration_in_ms=133.234
2018-01-31 21:06:30,377 [salt.state       ][INFO    ][10215] Running state [/usr/local/sbin/galera_bootstrap.sh] at time 21:06:30.377501
2018-01-31 21:06:30,377 [salt.state       ][INFO    ][10215] Executing state cmd.run for /usr/local/sbin/galera_bootstrap.sh
2018-01-31 21:06:30,378 [salt.loaded.int.module.cmdmod][INFO    ][10215] Executing command '/usr/local/sbin/galera_bootstrap.sh' in directory '/root'
2018-01-31 21:06:36,587 [salt.state       ][INFO    ][10215] {'pid': 14623, 'retcode': 0, 'stderr': 'Warning: Using a password on the command line interface can be insecure.', 'stdout': 'Sucessfully connected to the MySQL service (0 retries).'}
2018-01-31 21:06:36,588 [salt.state       ][INFO    ][10215] Completed state [/usr/local/sbin/galera_bootstrap.sh] at time 21:06:36.588254 duration_in_ms=6210.752
2018-01-31 21:06:36,590 [salt.state       ][INFO    ][10215] Running state [/var/lib/mysql/.galera_bootstrap] at time 21:06:36.590890
2018-01-31 21:06:36,591 [salt.state       ][INFO    ][10215] Executing state file.touch for /var/lib/mysql/.galera_bootstrap
2018-01-31 21:06:36,592 [salt.state       ][INFO    ][10215] {'new': '/var/lib/mysql/.galera_bootstrap'}
2018-01-31 21:06:36,592 [salt.state       ][INFO    ][10215] Completed state [/var/lib/mysql/.galera_bootstrap] at time 21:06:36.592818 duration_in_ms=1.927
2018-01-31 21:06:36,799 [salt.loaded.int.module.cmdmod][INFO    ][10215] Executing command ['git', '--version'] in directory '/root'
2018-01-31 21:06:36,982 [salt.state       ][INFO    ][10215] Running state [/etc/mysql/my.cnf] at time 21:06:36.982270
2018-01-31 21:06:36,982 [salt.state       ][INFO    ][10215] Executing state file.managed for /etc/mysql/my.cnf
2018-01-31 21:06:37,034 [salt.fileclient  ][INFO    ][10215] Fetching file from saltenv 'base', ** done ** 'galera/files/my.cnf'
2018-01-31 21:06:37,051 [salt.minion      ][INFO    ][7988] User sudo_ubuntu Executing command saltutil.find_job with jid 20180131210637653487
2018-01-31 21:06:37,077 [salt.minion      ][INFO    ][15407] Starting a new job with PID 15407
2018-01-31 21:06:37,093 [salt.minion      ][INFO    ][15407] Returning information for job: 20180131210637653487
2018-01-31 21:06:37,115 [salt.state       ][INFO    ][10215] File changed:
--- 
+++ 
@@ -1,8 +1,13 @@
 # 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]
 syslog
+
 [mysqld]
 datadir=/var/lib/mysql
 bind-address=192.168.10.51
@@ -14,8 +19,10 @@
 init-connect='SET NAMES utf8'
 character-set-server=utf8
 default-storage-engine=innodb
+#log_error=/var/log/mysql/error.log
 skip-external-locking
 skip-name-resolve
+socket = /var/run/mysqld/mysqld.sock
 
 myisam_sort_buffer_size=64M
 wait_timeout=1800
@@ -38,8 +45,7 @@
 innodb_doublewrite=0
 innodb_autoinc_lock_mode=2
 innodb_locks_unsafe_for_binlog=1
-
-wsrep_cluster_address="gcomm://"
+wsrep_cluster_address="gcomm://192.168.10.51:4567,192.168.10.52:4567,192.168.10.53:4567/?pc.wait_prim=no"
 wsrep_provider=/usr/lib/galera/libgalera_smm.so
 wsrep_cluster_name="openstack"
 

2018-01-31 21:06:37,115 [salt.state       ][INFO    ][10215] Completed state [/etc/mysql/my.cnf] at time 21:06:37.115375 duration_in_ms=133.105
2018-01-31 21:06:37,117 [salt.state       ][INFO    ][10215] Running state [mysql] at time 21:06:37.117741
2018-01-31 21:06:37,118 [salt.state       ][INFO    ][10215] Executing state service.running for mysql
2018-01-31 21:06:37,118 [salt.loaded.int.module.cmdmod][INFO    ][10215] Executing command ['systemctl', 'is-active', 'mysql.service'] in directory '/root'
2018-01-31 21:06:37,143 [salt.loaded.int.module.cmdmod][INFO    ][10215] Executing command ['systemctl', 'is-enabled', 'mysql.service'] in directory '/root'
2018-01-31 21:06:37,173 [salt.loaded.int.module.cmdmod][INFO    ][10215] Executing command ['systemctl', 'is-enabled', 'mysql.service'] in directory '/root'
2018-01-31 21:06:37,203 [salt.loaded.int.module.cmdmod][INFO    ][10215] Executing command ['systemctl', 'is-enabled', 'mysql.service'] in directory '/root'
2018-01-31 21:06:37,237 [salt.loaded.int.module.cmdmod][INFO    ][10215] Executing command ['systemd-run', '--scope', 'systemctl', 'enable', 'mysql.service'] in directory '/root'
2018-01-31 21:06:37,584 [salt.loaded.int.module.cmdmod][INFO    ][10215] Executing command ['systemctl', 'is-enabled', 'mysql.service'] in directory '/root'
2018-01-31 21:06:37,615 [salt.state       ][INFO    ][10215] {'mysql': True}
2018-01-31 21:06:37,616 [salt.state       ][INFO    ][10215] Completed state [mysql] at time 21:06:37.616467 duration_in_ms=498.725
2018-01-31 21:06:37,617 [salt.state       ][INFO    ][10215] Running state [ceilometer] at time 21:06:37.616987
2018-01-31 21:06:37,617 [salt.state       ][INFO    ][10215] Executing state mysql_database.present for ceilometer
2018-01-31 21:06:37,626 [salt.loaded.int.module.mysql][INFO    ][10215] DB 'ceilometer' created
2018-01-31 21:06:37,626 [salt.state       ][INFO    ][10215] {'ceilometer': 'Present'}
2018-01-31 21:06:37,626 [salt.state       ][INFO    ][10215] Completed state [ceilometer] at time 21:06:37.626696 duration_in_ms=9.709
2018-01-31 21:06:37,627 [salt.state       ][INFO    ][10215] Running state [ceilometer] at time 21:06:37.627250
2018-01-31 21:06:37,627 [salt.state       ][INFO    ][10215] Executing state mysql_user.present for ceilometer
2018-01-31 21:06:37,650 [salt.loaded.int.module.mysql][INFO    ][10215] User 'ceilometer'@'%' has been created
2018-01-31 21:06:37,650 [salt.state       ][INFO    ][10215] {'ceilometer': 'Present'}
2018-01-31 21:06:37,651 [salt.state       ][INFO    ][10215] Completed state [ceilometer] at time 21:06:37.651472 duration_in_ms=24.222
2018-01-31 21:06:37,655 [salt.state       ][INFO    ][10215] Running state [mysql_grants_ceilometer_ceilometer_%] at time 21:06:37.655009
2018-01-31 21:06:37,655 [salt.state       ][INFO    ][10215] Executing state mysql_grants.present for mysql_grants_ceilometer_ceilometer_%
2018-01-31 21:06:37,673 [salt.loaded.int.module.mysql][INFO    ][10215] Grant 'all' on 'ceilometer.*' for user 'ceilometer' has been added
2018-01-31 21:06:37,673 [salt.state       ][INFO    ][10215] {'mysql_grants_ceilometer_ceilometer_%': 'Present'}
2018-01-31 21:06:37,674 [salt.state       ][INFO    ][10215] Completed state [mysql_grants_ceilometer_ceilometer_%] at time 21:06:37.674006 duration_in_ms=18.997
2018-01-31 21:06:37,674 [salt.state       ][INFO    ][10215] Running state [ceilometer] at time 21:06:37.674519
2018-01-31 21:06:37,675 [salt.state       ][INFO    ][10215] Executing state mysql_user.present for ceilometer
2018-01-31 21:06:37,694 [salt.loaded.int.module.mysql][INFO    ][10215] User 'ceilometer'@'192.168.10.51' has been created
2018-01-31 21:06:37,695 [salt.state       ][INFO    ][10215] {'ceilometer': 'Present'}
2018-01-31 21:06:37,695 [salt.state       ][INFO    ][10215] Completed state [ceilometer] at time 21:06:37.695781 duration_in_ms=21.261
2018-01-31 21:06:37,698 [salt.state       ][INFO    ][10215] Running state [mysql_grants_ceilometer_ceilometer_192.168.10.51] at time 21:06:37.697974
2018-01-31 21:06:37,698 [salt.state       ][INFO    ][10215] Executing state mysql_grants.present for mysql_grants_ceilometer_ceilometer_192.168.10.51
2018-01-31 21:06:37,715 [salt.loaded.int.module.mysql][INFO    ][10215] Grant 'all' on 'ceilometer.*' for user 'ceilometer' has been added
2018-01-31 21:06:37,716 [salt.state       ][INFO    ][10215] {'mysql_grants_ceilometer_ceilometer_192.168.10.51': 'Present'}
2018-01-31 21:06:37,717 [salt.state       ][INFO    ][10215] Completed state [mysql_grants_ceilometer_ceilometer_192.168.10.51] at time 21:06:37.717085 duration_in_ms=19.111
2018-01-31 21:06:37,717 [salt.state       ][INFO    ][10215] Running state [aodh] at time 21:06:37.717659
2018-01-31 21:06:37,718 [salt.state       ][INFO    ][10215] Executing state mysql_database.present for aodh
2018-01-31 21:06:37,724 [salt.loaded.int.module.mysql][INFO    ][10215] DB 'aodh' created
2018-01-31 21:06:37,724 [salt.state       ][INFO    ][10215] {'aodh': 'Present'}
2018-01-31 21:06:37,725 [salt.state       ][INFO    ][10215] Completed state [aodh] at time 21:06:37.725466 duration_in_ms=7.807
2018-01-31 21:06:37,726 [salt.state       ][INFO    ][10215] Running state [aodh] at time 21:06:37.726028
2018-01-31 21:06:37,726 [salt.state       ][INFO    ][10215] Executing state mysql_user.present for aodh
2018-01-31 21:06:37,747 [salt.loaded.int.module.mysql][INFO    ][10215] User 'aodh'@'%' has been created
2018-01-31 21:06:37,748 [salt.state       ][INFO    ][10215] {'aodh': 'Present'}
2018-01-31 21:06:37,749 [salt.state       ][INFO    ][10215] Completed state [aodh] at time 21:06:37.749664 duration_in_ms=23.633
2018-01-31 21:06:37,753 [salt.state       ][INFO    ][10215] Running state [mysql_grants_aodh_aodh_%] at time 21:06:37.753753
2018-01-31 21:06:37,754 [salt.state       ][INFO    ][10215] Executing state mysql_grants.present for mysql_grants_aodh_aodh_%
2018-01-31 21:06:37,770 [salt.loaded.int.module.mysql][INFO    ][10215] Grant 'all' on 'aodh.*' for user 'aodh' has been added
2018-01-31 21:06:37,770 [salt.state       ][INFO    ][10215] {'mysql_grants_aodh_aodh_%': 'Present'}
2018-01-31 21:06:37,771 [salt.state       ][INFO    ][10215] Completed state [mysql_grants_aodh_aodh_%] at time 21:06:37.771194 duration_in_ms=17.442
2018-01-31 21:06:37,771 [salt.state       ][INFO    ][10215] Running state [aodh] at time 21:06:37.771689
2018-01-31 21:06:37,772 [salt.state       ][INFO    ][10215] Executing state mysql_user.present for aodh
2018-01-31 21:06:37,790 [salt.loaded.int.module.mysql][INFO    ][10215] User 'aodh'@'192.168.10.50' has been created
2018-01-31 21:06:37,791 [salt.state       ][INFO    ][10215] {'aodh': 'Present'}
2018-01-31 21:06:37,792 [salt.state       ][INFO    ][10215] Completed state [aodh] at time 21:06:37.791975 duration_in_ms=20.286
2018-01-31 21:06:37,794 [salt.state       ][INFO    ][10215] Running state [mysql_grants_aodh_aodh_192.168.10.50] at time 21:06:37.794188
2018-01-31 21:06:37,794 [salt.state       ][INFO    ][10215] Executing state mysql_grants.present for mysql_grants_aodh_aodh_192.168.10.50
2018-01-31 21:06:37,811 [salt.loaded.int.module.mysql][INFO    ][10215] Grant 'all' on 'aodh.*' for user 'aodh' has been added
2018-01-31 21:06:37,811 [salt.state       ][INFO    ][10215] {'mysql_grants_aodh_aodh_192.168.10.50': 'Present'}
2018-01-31 21:06:37,812 [salt.state       ][INFO    ][10215] Completed state [mysql_grants_aodh_aodh_192.168.10.50] at time 21:06:37.812295 duration_in_ms=18.108
2018-01-31 21:06:37,812 [salt.state       ][INFO    ][10215] Running state [nova] at time 21:06:37.812869
2018-01-31 21:06:37,813 [salt.state       ][INFO    ][10215] Executing state mysql_database.present for nova
2018-01-31 21:06:37,818 [salt.loaded.int.module.mysql][INFO    ][10215] DB 'nova' created
2018-01-31 21:06:37,819 [salt.state       ][INFO    ][10215] {'nova': 'Present'}
2018-01-31 21:06:37,820 [salt.state       ][INFO    ][10215] Completed state [nova] at time 21:06:37.820357 duration_in_ms=7.487
2018-01-31 21:06:37,820 [salt.state       ][INFO    ][10215] Running state [nova] at time 21:06:37.820865
2018-01-31 21:06:37,821 [salt.state       ][INFO    ][10215] Executing state mysql_user.present for nova
2018-01-31 21:06:37,837 [salt.loaded.int.module.mysql][INFO    ][10215] User 'nova'@'%' has been created
2018-01-31 21:06:37,838 [salt.state       ][INFO    ][10215] {'nova': 'Present'}
2018-01-31 21:06:37,838 [salt.state       ][INFO    ][10215] Completed state [nova] at time 21:06:37.838878 duration_in_ms=18.013
2018-01-31 21:06:37,841 [salt.state       ][INFO    ][10215] Running state [mysql_grants_nova_nova_%] at time 21:06:37.841409
2018-01-31 21:06:37,842 [salt.state       ][INFO    ][10215] Executing state mysql_grants.present for mysql_grants_nova_nova_%
2018-01-31 21:06:37,857 [salt.loaded.int.module.mysql][INFO    ][10215] Grant 'all' on 'nova.*' for user 'nova' has been added
2018-01-31 21:06:37,858 [salt.state       ][INFO    ][10215] {'mysql_grants_nova_nova_%': 'Present'}
2018-01-31 21:06:37,858 [salt.state       ][INFO    ][10215] Completed state [mysql_grants_nova_nova_%] at time 21:06:37.858866 duration_in_ms=17.457
2018-01-31 21:06:37,859 [salt.state       ][INFO    ][10215] Running state [nova] at time 21:06:37.859443
2018-01-31 21:06:37,860 [salt.state       ][INFO    ][10215] Executing state mysql_user.present for nova
2018-01-31 21:06:37,877 [salt.loaded.int.module.mysql][INFO    ][10215] User 'nova'@'192.168.10.51' has been created
2018-01-31 21:06:37,878 [salt.state       ][INFO    ][10215] {'nova': 'Present'}
2018-01-31 21:06:37,878 [salt.state       ][INFO    ][10215] Completed state [nova] at time 21:06:37.878608 duration_in_ms=19.165
2018-01-31 21:06:37,881 [salt.state       ][INFO    ][10215] Running state [mysql_grants_nova_nova_192.168.10.51] at time 21:06:37.881264
2018-01-31 21:06:37,881 [salt.state       ][INFO    ][10215] Executing state mysql_grants.present for mysql_grants_nova_nova_192.168.10.51
2018-01-31 21:06:37,897 [salt.loaded.int.module.mysql][INFO    ][10215] Grant 'all' on 'nova.*' for user 'nova' has been added
2018-01-31 21:06:37,897 [salt.state       ][INFO    ][10215] {'mysql_grants_nova_nova_192.168.10.51': 'Present'}
2018-01-31 21:06:37,898 [salt.state       ][INFO    ][10215] Completed state [mysql_grants_nova_nova_192.168.10.51] at time 21:06:37.898235 duration_in_ms=16.972
2018-01-31 21:06:37,898 [salt.state       ][INFO    ][10215] Running state [grafana] at time 21:06:37.898764
2018-01-31 21:06:37,899 [salt.state       ][INFO    ][10215] Executing state mysql_database.present for grafana
2018-01-31 21:06:37,904 [salt.loaded.int.module.mysql][INFO    ][10215] DB 'grafana' created
2018-01-31 21:06:37,905 [salt.state       ][INFO    ][10215] {'grafana': 'Present'}
2018-01-31 21:06:37,906 [salt.state       ][INFO    ][10215] Completed state [grafana] at time 21:06:37.905951 duration_in_ms=7.187
2018-01-31 21:06:37,906 [salt.state       ][INFO    ][10215] Running state [grafana] at time 21:06:37.906510
2018-01-31 21:06:37,907 [salt.state       ][INFO    ][10215] Executing state mysql_user.present for grafana
2018-01-31 21:06:37,925 [salt.loaded.int.module.mysql][INFO    ][10215] User 'grafana'@'%' has been created
2018-01-31 21:06:37,925 [salt.state       ][INFO    ][10215] {'grafana': 'Present'}
2018-01-31 21:06:37,926 [salt.state       ][INFO    ][10215] Completed state [grafana] at time 21:06:37.926371 duration_in_ms=19.86
2018-01-31 21:06:37,929 [salt.state       ][INFO    ][10215] Running state [mysql_grants_grafana_grafana_%] at time 21:06:37.928991
2018-01-31 21:06:37,929 [salt.state       ][INFO    ][10215] Executing state mysql_grants.present for mysql_grants_grafana_grafana_%
2018-01-31 21:06:37,945 [salt.loaded.int.module.mysql][INFO    ][10215] Grant 'all' on 'grafana.*' for user 'grafana' has been added
2018-01-31 21:06:37,946 [salt.state       ][INFO    ][10215] {'mysql_grants_grafana_grafana_%': 'Present'}
2018-01-31 21:06:37,946 [salt.state       ][INFO    ][10215] Completed state [mysql_grants_grafana_grafana_%] at time 21:06:37.946715 duration_in_ms=17.725
2018-01-31 21:06:37,947 [salt.state       ][INFO    ][10215] Running state [grafana] at time 21:06:37.947238
2018-01-31 21:06:37,947 [salt.state       ][INFO    ][10215] Executing state mysql_user.present for grafana
2018-01-31 21:06:37,965 [salt.loaded.int.module.mysql][INFO    ][10215] User 'grafana'@'192.168.10.51' has been created
2018-01-31 21:06:37,966 [salt.state       ][INFO    ][10215] {'grafana': 'Present'}
2018-01-31 21:06:37,966 [salt.state       ][INFO    ][10215] Completed state [grafana] at time 21:06:37.966912 duration_in_ms=19.674
2018-01-31 21:06:37,969 [salt.state       ][INFO    ][10215] Running state [mysql_grants_grafana_grafana_192.168.10.51] at time 21:06:37.969548
2018-01-31 21:06:37,970 [salt.state       ][INFO    ][10215] Executing state mysql_grants.present for mysql_grants_grafana_grafana_192.168.10.51
2018-01-31 21:06:37,985 [salt.loaded.int.module.mysql][INFO    ][10215] Grant 'all' on 'grafana.*' for user 'grafana' has been added
2018-01-31 21:06:37,986 [salt.state       ][INFO    ][10215] {'mysql_grants_grafana_grafana_192.168.10.51': 'Present'}
2018-01-31 21:06:37,987 [salt.state       ][INFO    ][10215] Completed state [mysql_grants_grafana_grafana_192.168.10.51] at time 21:06:37.986955 duration_in_ms=17.407
2018-01-31 21:06:37,987 [salt.state       ][INFO    ][10215] Running state [designate_pool_manager] at time 21:06:37.987477
2018-01-31 21:06:37,988 [salt.state       ][INFO    ][10215] Executing state mysql_database.present for designate_pool_manager
2018-01-31 21:06:37,994 [salt.loaded.int.module.mysql][INFO    ][10215] DB 'designate_pool_manager' created
2018-01-31 21:06:37,995 [salt.state       ][INFO    ][10215] {'designate_pool_manager': 'Present'}
2018-01-31 21:06:37,995 [salt.state       ][INFO    ][10215] Completed state [designate_pool_manager] at time 21:06:37.995693 duration_in_ms=8.216
2018-01-31 21:06:37,996 [salt.state       ][INFO    ][10215] Running state [designate] at time 21:06:37.996264
2018-01-31 21:06:37,996 [salt.state       ][INFO    ][10215] Executing state mysql_user.present for designate
2018-01-31 21:06:38,014 [salt.loaded.int.module.mysql][INFO    ][10215] User 'designate'@'%' has been created
2018-01-31 21:06:38,014 [salt.state       ][INFO    ][10215] {'designate': 'Present'}
2018-01-31 21:06:38,015 [salt.state       ][INFO    ][10215] Completed state [designate] at time 21:06:38.015199 duration_in_ms=18.935
2018-01-31 21:06:38,018 [salt.state       ][INFO    ][10215] Running state [mysql_grants_designate_designate_pool_manager_%] at time 21:06:38.017984
2018-01-31 21:06:38,018 [salt.state       ][INFO    ][10215] Executing state mysql_grants.present for mysql_grants_designate_designate_pool_manager_%
2018-01-31 21:06:38,033 [salt.loaded.int.module.mysql][INFO    ][10215] Grant 'all' on 'designate_pool_manager.*' for user 'designate' has been added
2018-01-31 21:06:38,033 [salt.state       ][INFO    ][10215] {'mysql_grants_designate_designate_pool_manager_%': 'Present'}
2018-01-31 21:06:38,034 [salt.state       ][INFO    ][10215] Completed state [mysql_grants_designate_designate_pool_manager_%] at time 21:06:38.034109 duration_in_ms=16.125
2018-01-31 21:06:38,034 [salt.state       ][INFO    ][10215] Running state [designate] at time 21:06:38.034646
2018-01-31 21:06:38,035 [salt.state       ][INFO    ][10215] Executing state mysql_user.present for designate
2018-01-31 21:06:38,057 [salt.loaded.int.module.mysql][INFO    ][10215] User 'designate'@'192.168.10.50' has been created
2018-01-31 21:06:38,058 [salt.state       ][INFO    ][10215] {'designate': 'Present'}
2018-01-31 21:06:38,059 [salt.state       ][INFO    ][10215] Completed state [designate] at time 21:06:38.059336 duration_in_ms=24.689
2018-01-31 21:06:38,062 [salt.state       ][INFO    ][10215] Running state [mysql_grants_designate_designate_pool_manager_192.168.10.50] at time 21:06:38.062439
2018-01-31 21:06:38,062 [salt.state       ][INFO    ][10215] Executing state mysql_grants.present for mysql_grants_designate_designate_pool_manager_192.168.10.50
2018-01-31 21:06:38,081 [salt.loaded.int.module.mysql][INFO    ][10215] Grant 'all' on 'designate_pool_manager.*' for user 'designate' has been added
2018-01-31 21:06:38,082 [salt.state       ][INFO    ][10215] {'mysql_grants_designate_designate_pool_manager_192.168.10.50': 'Present'}
2018-01-31 21:06:38,082 [salt.state       ][INFO    ][10215] Completed state [mysql_grants_designate_designate_pool_manager_192.168.10.50] at time 21:06:38.082455 duration_in_ms=20.015
2018-01-31 21:06:38,082 [salt.state       ][INFO    ][10215] Running state [heat] at time 21:06:38.082937
2018-01-31 21:06:38,083 [salt.state       ][INFO    ][10215] Executing state mysql_database.present for heat
2018-01-31 21:06:38,089 [salt.loaded.int.module.mysql][INFO    ][10215] DB 'heat' created
2018-01-31 21:06:38,090 [salt.state       ][INFO    ][10215] {'heat': 'Present'}
2018-01-31 21:06:38,090 [salt.state       ][INFO    ][10215] Completed state [heat] at time 21:06:38.090893 duration_in_ms=7.956
2018-01-31 21:06:38,091 [salt.state       ][INFO    ][10215] Running state [heat] at time 21:06:38.091406
2018-01-31 21:06:38,091 [salt.state       ][INFO    ][10215] Executing state mysql_user.present for heat
2018-01-31 21:06:38,110 [salt.loaded.int.module.mysql][INFO    ][10215] User 'heat'@'%' has been created
2018-01-31 21:06:38,111 [salt.state       ][INFO    ][10215] {'heat': 'Present'}
2018-01-31 21:06:38,111 [salt.state       ][INFO    ][10215] Completed state [heat] at time 21:06:38.111680 duration_in_ms=20.273
2018-01-31 21:06:38,114 [salt.state       ][INFO    ][10215] Running state [mysql_grants_heat_heat_%] at time 21:06:38.114363
2018-01-31 21:06:38,114 [salt.state       ][INFO    ][10215] Executing state mysql_grants.present for mysql_grants_heat_heat_%
2018-01-31 21:06:38,129 [salt.loaded.int.module.mysql][INFO    ][10215] Grant 'all' on 'heat.*' for user 'heat' has been added
2018-01-31 21:06:38,130 [salt.state       ][INFO    ][10215] {'mysql_grants_heat_heat_%': 'Present'}
2018-01-31 21:06:38,130 [salt.state       ][INFO    ][10215] Completed state [mysql_grants_heat_heat_%] at time 21:06:38.130752 duration_in_ms=16.389
2018-01-31 21:06:38,131 [salt.state       ][INFO    ][10215] Running state [heat] at time 21:06:38.131243
2018-01-31 21:06:38,131 [salt.state       ][INFO    ][10215] Executing state mysql_user.present for heat
2018-01-31 21:06:38,149 [salt.loaded.int.module.mysql][INFO    ][10215] User 'heat'@'192.168.10.51' has been created
2018-01-31 21:06:38,150 [salt.state       ][INFO    ][10215] {'heat': 'Present'}
2018-01-31 21:06:38,151 [salt.state       ][INFO    ][10215] Completed state [heat] at time 21:06:38.150976 duration_in_ms=19.733
2018-01-31 21:06:38,153 [salt.state       ][INFO    ][10215] Running state [mysql_grants_heat_heat_192.168.10.51] at time 21:06:38.153098
2018-01-31 21:06:38,153 [salt.state       ][INFO    ][10215] Executing state mysql_grants.present for mysql_grants_heat_heat_192.168.10.51
2018-01-31 21:06:38,168 [salt.loaded.int.module.mysql][INFO    ][10215] Grant 'all' on 'heat.*' for user 'heat' has been added
2018-01-31 21:06:38,169 [salt.state       ][INFO    ][10215] {'mysql_grants_heat_heat_192.168.10.51': 'Present'}
2018-01-31 21:06:38,169 [salt.state       ][INFO    ][10215] Completed state [mysql_grants_heat_heat_192.168.10.51] at time 21:06:38.169866 duration_in_ms=16.768
2018-01-31 21:06:38,170 [salt.state       ][INFO    ][10215] Running state [nova_api] at time 21:06:38.170477
2018-01-31 21:06:38,171 [salt.state       ][INFO    ][10215] Executing state mysql_database.present for nova_api
2018-01-31 21:06:38,176 [salt.loaded.int.module.mysql][INFO    ][10215] DB 'nova_api' created
2018-01-31 21:06:38,177 [salt.state       ][INFO    ][10215] {'nova_api': 'Present'}
2018-01-31 21:06:38,178 [salt.state       ][INFO    ][10215] Completed state [nova_api] at time 21:06:38.178022 duration_in_ms=7.545
2018-01-31 21:06:38,178 [salt.state       ][INFO    ][10215] Running state [nova] at time 21:06:38.178626
2018-01-31 21:06:38,179 [salt.state       ][INFO    ][10215] Executing state mysql_user.present for nova
2018-01-31 21:06:38,183 [salt.state       ][INFO    ][10215] User nova@% is already present with the desired password
2018-01-31 21:06:38,184 [salt.state       ][INFO    ][10215] Completed state [nova] at time 21:06:38.184159 duration_in_ms=5.533
2018-01-31 21:06:38,186 [salt.state       ][INFO    ][10215] Running state [mysql_grants_nova_nova_api_%] at time 21:06:38.186184
2018-01-31 21:06:38,186 [salt.state       ][INFO    ][10215] Executing state mysql_grants.present for mysql_grants_nova_nova_api_%
2018-01-31 21:06:38,202 [salt.loaded.int.module.mysql][INFO    ][10215] Grant 'all' on 'nova_api.*' for user 'nova' has been added
2018-01-31 21:06:38,202 [salt.state       ][INFO    ][10215] {'mysql_grants_nova_nova_api_%': 'Present'}
2018-01-31 21:06:38,202 [salt.state       ][INFO    ][10215] Completed state [mysql_grants_nova_nova_api_%] at time 21:06:38.202947 duration_in_ms=16.762
2018-01-31 21:06:38,203 [salt.state       ][INFO    ][10215] Running state [nova] at time 21:06:38.203459
2018-01-31 21:06:38,203 [salt.state       ][INFO    ][10215] Executing state mysql_user.present for nova
2018-01-31 21:06:38,208 [salt.state       ][INFO    ][10215] User nova@192.168.10.51 is already present with the desired password
2018-01-31 21:06:38,208 [salt.state       ][INFO    ][10215] Completed state [nova] at time 21:06:38.208940 duration_in_ms=5.481
2018-01-31 21:06:38,211 [salt.state       ][INFO    ][10215] Running state [mysql_grants_nova_nova_api_192.168.10.51] at time 21:06:38.210984
2018-01-31 21:06:38,211 [salt.state       ][INFO    ][10215] Executing state mysql_grants.present for mysql_grants_nova_nova_api_192.168.10.51
2018-01-31 21:06:38,227 [salt.loaded.int.module.mysql][INFO    ][10215] Grant 'all' on 'nova_api.*' for user 'nova' has been added
2018-01-31 21:06:38,227 [salt.state       ][INFO    ][10215] {'mysql_grants_nova_nova_api_192.168.10.51': 'Present'}
2018-01-31 21:06:38,228 [salt.state       ][INFO    ][10215] Completed state [mysql_grants_nova_nova_api_192.168.10.51] at time 21:06:38.228347 duration_in_ms=17.363
2018-01-31 21:06:38,228 [salt.state       ][INFO    ][10215] Running state [keystone] at time 21:06:38.228890
2018-01-31 21:06:38,229 [salt.state       ][INFO    ][10215] Executing state mysql_database.present for keystone
2018-01-31 21:06:38,235 [salt.loaded.int.module.mysql][INFO    ][10215] DB 'keystone' created
2018-01-31 21:06:38,236 [salt.state       ][INFO    ][10215] {'keystone': 'Present'}
2018-01-31 21:06:38,236 [salt.state       ][INFO    ][10215] Completed state [keystone] at time 21:06:38.236566 duration_in_ms=7.675
2018-01-31 21:06:38,237 [salt.state       ][INFO    ][10215] Running state [keystone] at time 21:06:38.237102
2018-01-31 21:06:38,237 [salt.state       ][INFO    ][10215] Executing state mysql_user.present for keystone
2018-01-31 21:06:38,255 [salt.loaded.int.module.mysql][INFO    ][10215] User 'keystone'@'%' has been created
2018-01-31 21:06:38,255 [salt.state       ][INFO    ][10215] {'keystone': 'Present'}
2018-01-31 21:06:38,256 [salt.state       ][INFO    ][10215] Completed state [keystone] at time 21:06:38.256416 duration_in_ms=19.315
2018-01-31 21:06:38,258 [salt.state       ][INFO    ][10215] Running state [mysql_grants_keystone_keystone_%] at time 21:06:38.258829
2018-01-31 21:06:38,259 [salt.state       ][INFO    ][10215] Executing state mysql_grants.present for mysql_grants_keystone_keystone_%
2018-01-31 21:06:38,274 [salt.loaded.int.module.mysql][INFO    ][10215] Grant 'all' on 'keystone.*' for user 'keystone' has been added
2018-01-31 21:06:38,274 [salt.state       ][INFO    ][10215] {'mysql_grants_keystone_keystone_%': 'Present'}
2018-01-31 21:06:38,275 [salt.state       ][INFO    ][10215] Completed state [mysql_grants_keystone_keystone_%] at time 21:06:38.275207 duration_in_ms=16.377
2018-01-31 21:06:38,275 [salt.state       ][INFO    ][10215] Running state [keystone] at time 21:06:38.275716
2018-01-31 21:06:38,276 [salt.state       ][INFO    ][10215] Executing state mysql_user.present for keystone
2018-01-31 21:06:38,292 [salt.loaded.int.module.mysql][INFO    ][10215] User 'keystone'@'192.168.10.51' has been created
2018-01-31 21:06:38,293 [salt.state       ][INFO    ][10215] {'keystone': 'Present'}
2018-01-31 21:06:38,293 [salt.state       ][INFO    ][10215] Completed state [keystone] at time 21:06:38.293617 duration_in_ms=17.901
2018-01-31 21:06:38,296 [salt.state       ][INFO    ][10215] Running state [mysql_grants_keystone_keystone_192.168.10.51] at time 21:06:38.296032
2018-01-31 21:06:38,296 [salt.state       ][INFO    ][10215] Executing state mysql_grants.present for mysql_grants_keystone_keystone_192.168.10.51
2018-01-31 21:06:38,310 [salt.loaded.int.module.mysql][INFO    ][10215] Grant 'all' on 'keystone.*' for user 'keystone' has been added
2018-01-31 21:06:38,311 [salt.state       ][INFO    ][10215] {'mysql_grants_keystone_keystone_192.168.10.51': 'Present'}
2018-01-31 21:06:38,312 [salt.state       ][INFO    ][10215] Completed state [mysql_grants_keystone_keystone_192.168.10.51] at time 21:06:38.312330 duration_in_ms=16.297
2018-01-31 21:06:38,312 [salt.state       ][INFO    ][10215] Running state [nova_cell0] at time 21:06:38.312790
2018-01-31 21:06:38,313 [salt.state       ][INFO    ][10215] Executing state mysql_database.present for nova_cell0
2018-01-31 21:06:38,317 [salt.loaded.int.module.mysql][INFO    ][10215] DB 'nova_cell0' created
2018-01-31 21:06:38,318 [salt.state       ][INFO    ][10215] {'nova_cell0': 'Present'}
2018-01-31 21:06:38,318 [salt.state       ][INFO    ][10215] Completed state [nova_cell0] at time 21:06:38.318728 duration_in_ms=5.938
2018-01-31 21:06:38,319 [salt.state       ][INFO    ][10215] Running state [nova] at time 21:06:38.319179
2018-01-31 21:06:38,319 [salt.state       ][INFO    ][10215] Executing state mysql_user.present for nova
2018-01-31 21:06:38,323 [salt.state       ][INFO    ][10215] User nova@% is already present with the desired password
2018-01-31 21:06:38,323 [salt.state       ][INFO    ][10215] Completed state [nova] at time 21:06:38.323522 duration_in_ms=4.343
2018-01-31 21:06:38,325 [salt.state       ][INFO    ][10215] Running state [mysql_grants_nova_nova_cell0_%] at time 21:06:38.325940
2018-01-31 21:06:38,326 [salt.state       ][INFO    ][10215] Executing state mysql_grants.present for mysql_grants_nova_nova_cell0_%
2018-01-31 21:06:38,342 [salt.loaded.int.module.mysql][INFO    ][10215] Grant 'all' on 'nova_cell0.*' for user 'nova' has been added
2018-01-31 21:06:38,342 [salt.state       ][INFO    ][10215] {'mysql_grants_nova_nova_cell0_%': 'Present'}
2018-01-31 21:06:38,343 [salt.state       ][INFO    ][10215] Completed state [mysql_grants_nova_nova_cell0_%] at time 21:06:38.343230 duration_in_ms=17.29
2018-01-31 21:06:38,343 [salt.state       ][INFO    ][10215] Running state [nova] at time 21:06:38.343756
2018-01-31 21:06:38,344 [salt.state       ][INFO    ][10215] Executing state mysql_user.present for nova
2018-01-31 21:06:38,349 [salt.state       ][INFO    ][10215] User nova@192.168.10.51 is already present with the desired password
2018-01-31 21:06:38,349 [salt.state       ][INFO    ][10215] Completed state [nova] at time 21:06:38.349699 duration_in_ms=5.943
2018-01-31 21:06:38,351 [salt.state       ][INFO    ][10215] Running state [mysql_grants_nova_nova_cell0_192.168.10.51] at time 21:06:38.351760
2018-01-31 21:06:38,352 [salt.state       ][INFO    ][10215] Executing state mysql_grants.present for mysql_grants_nova_nova_cell0_192.168.10.51
2018-01-31 21:06:38,368 [salt.loaded.int.module.mysql][INFO    ][10215] Grant 'all' on 'nova_cell0.*' for user 'nova' has been added
2018-01-31 21:06:38,368 [salt.state       ][INFO    ][10215] {'mysql_grants_nova_nova_cell0_192.168.10.51': 'Present'}
2018-01-31 21:06:38,369 [salt.state       ][INFO    ][10215] Completed state [mysql_grants_nova_nova_cell0_192.168.10.51] at time 21:06:38.369280 duration_in_ms=17.52
2018-01-31 21:06:38,369 [salt.state       ][INFO    ][10215] Running state [cinder] at time 21:06:38.369777
2018-01-31 21:06:38,370 [salt.state       ][INFO    ][10215] Executing state mysql_database.present for cinder
2018-01-31 21:06:38,376 [salt.loaded.int.module.mysql][INFO    ][10215] DB 'cinder' created
2018-01-31 21:06:38,377 [salt.state       ][INFO    ][10215] {'cinder': 'Present'}
2018-01-31 21:06:38,377 [salt.state       ][INFO    ][10215] Completed state [cinder] at time 21:06:38.377832 duration_in_ms=8.055
2018-01-31 21:06:38,378 [salt.state       ][INFO    ][10215] Running state [cinder] at time 21:06:38.378373
2018-01-31 21:06:38,378 [salt.state       ][INFO    ][10215] Executing state mysql_user.present for cinder
2018-01-31 21:06:38,397 [salt.loaded.int.module.mysql][INFO    ][10215] User 'cinder'@'%' has been created
2018-01-31 21:06:38,398 [salt.state       ][INFO    ][10215] {'cinder': 'Present'}
2018-01-31 21:06:38,398 [salt.state       ][INFO    ][10215] Completed state [cinder] at time 21:06:38.398759 duration_in_ms=20.386
2018-01-31 21:06:38,401 [salt.state       ][INFO    ][10215] Running state [mysql_grants_cinder_cinder_%] at time 21:06:38.400954
2018-01-31 21:06:38,401 [salt.state       ][INFO    ][10215] Executing state mysql_grants.present for mysql_grants_cinder_cinder_%
2018-01-31 21:06:38,417 [salt.loaded.int.module.mysql][INFO    ][10215] Grant 'all' on 'cinder.*' for user 'cinder' has been added
2018-01-31 21:06:38,417 [salt.state       ][INFO    ][10215] {'mysql_grants_cinder_cinder_%': 'Present'}
2018-01-31 21:06:38,417 [salt.state       ][INFO    ][10215] Completed state [mysql_grants_cinder_cinder_%] at time 21:06:38.417939 duration_in_ms=16.985
2018-01-31 21:06:38,418 [salt.state       ][INFO    ][10215] Running state [cinder] at time 21:06:38.418462
2018-01-31 21:06:38,418 [salt.state       ][INFO    ][10215] Executing state mysql_user.present for cinder
2018-01-31 21:06:38,438 [salt.loaded.int.module.mysql][INFO    ][10215] User 'cinder'@'192.168.10.51' has been created
2018-01-31 21:06:38,438 [salt.state       ][INFO    ][10215] {'cinder': 'Present'}
2018-01-31 21:06:38,439 [salt.state       ][INFO    ][10215] Completed state [cinder] at time 21:06:38.439018 duration_in_ms=20.556
2018-01-31 21:06:38,441 [salt.state       ][INFO    ][10215] Running state [mysql_grants_cinder_cinder_192.168.10.51] at time 21:06:38.441163
2018-01-31 21:06:38,441 [salt.state       ][INFO    ][10215] Executing state mysql_grants.present for mysql_grants_cinder_cinder_192.168.10.51
2018-01-31 21:06:38,466 [salt.loaded.int.module.mysql][INFO    ][10215] Grant 'all' on 'cinder.*' for user 'cinder' has been added
2018-01-31 21:06:38,468 [salt.state       ][INFO    ][10215] {'mysql_grants_cinder_cinder_192.168.10.51': 'Present'}
2018-01-31 21:06:38,468 [salt.state       ][INFO    ][10215] Completed state [mysql_grants_cinder_cinder_192.168.10.51] at time 21:06:38.468936 duration_in_ms=27.773
2018-01-31 21:06:38,469 [salt.state       ][INFO    ][10215] Running state [glance] at time 21:06:38.469469
2018-01-31 21:06:38,470 [salt.state       ][INFO    ][10215] Executing state mysql_database.present for glance
2018-01-31 21:06:38,475 [salt.loaded.int.module.mysql][INFO    ][10215] DB 'glance' created
2018-01-31 21:06:38,476 [salt.state       ][INFO    ][10215] {'glance': 'Present'}
2018-01-31 21:06:38,476 [salt.state       ][INFO    ][10215] Completed state [glance] at time 21:06:38.476875 duration_in_ms=7.405
2018-01-31 21:06:38,477 [salt.state       ][INFO    ][10215] Running state [glance] at time 21:06:38.477403
2018-01-31 21:06:38,477 [salt.state       ][INFO    ][10215] Executing state mysql_user.present for glance
2018-01-31 21:06:38,495 [salt.loaded.int.module.mysql][INFO    ][10215] User 'glance'@'%' has been created
2018-01-31 21:06:38,496 [salt.state       ][INFO    ][10215] {'glance': 'Present'}
2018-01-31 21:06:38,497 [salt.state       ][INFO    ][10215] Completed state [glance] at time 21:06:38.497145 duration_in_ms=19.742
2018-01-31 21:06:38,499 [salt.state       ][INFO    ][10215] Running state [mysql_grants_glance_glance_%] at time 21:06:38.499634
2018-01-31 21:06:38,500 [salt.state       ][INFO    ][10215] Executing state mysql_grants.present for mysql_grants_glance_glance_%
2018-01-31 21:06:38,516 [salt.loaded.int.module.mysql][INFO    ][10215] Grant 'all' on 'glance.*' for user 'glance' has been added
2018-01-31 21:06:38,517 [salt.state       ][INFO    ][10215] {'mysql_grants_glance_glance_%': 'Present'}
2018-01-31 21:06:38,517 [salt.state       ][INFO    ][10215] Completed state [mysql_grants_glance_glance_%] at time 21:06:38.517906 duration_in_ms=18.272
2018-01-31 21:06:38,518 [salt.state       ][INFO    ][10215] Running state [glance] at time 21:06:38.518539
2018-01-31 21:06:38,519 [salt.state       ][INFO    ][10215] Executing state mysql_user.present for glance
2018-01-31 21:06:38,538 [salt.loaded.int.module.mysql][INFO    ][10215] User 'glance'@'192.168.10.51' has been created
2018-01-31 21:06:38,539 [salt.state       ][INFO    ][10215] {'glance': 'Present'}
2018-01-31 21:06:38,540 [salt.state       ][INFO    ][10215] Completed state [glance] at time 21:06:38.540493 duration_in_ms=21.953
2018-01-31 21:06:38,542 [salt.state       ][INFO    ][10215] Running state [mysql_grants_glance_glance_192.168.10.51] at time 21:06:38.542827
2018-01-31 21:06:38,543 [salt.state       ][INFO    ][10215] Executing state mysql_grants.present for mysql_grants_glance_glance_192.168.10.51
2018-01-31 21:06:38,559 [salt.loaded.int.module.mysql][INFO    ][10215] Grant 'all' on 'glance.*' for user 'glance' has been added
2018-01-31 21:06:38,560 [salt.state       ][INFO    ][10215] {'mysql_grants_glance_glance_192.168.10.51': 'Present'}
2018-01-31 21:06:38,561 [salt.state       ][INFO    ][10215] Completed state [mysql_grants_glance_glance_192.168.10.51] at time 21:06:38.561064 duration_in_ms=18.236
2018-01-31 21:06:38,561 [salt.state       ][INFO    ][10215] Running state [neutron] at time 21:06:38.561589
2018-01-31 21:06:38,562 [salt.state       ][INFO    ][10215] Executing state mysql_database.present for neutron
2018-01-31 21:06:38,567 [salt.loaded.int.module.mysql][INFO    ][10215] DB 'neutron' created
2018-01-31 21:06:38,568 [salt.state       ][INFO    ][10215] {'neutron': 'Present'}
2018-01-31 21:06:38,568 [salt.state       ][INFO    ][10215] Completed state [neutron] at time 21:06:38.568800 duration_in_ms=7.211
2018-01-31 21:06:38,569 [salt.state       ][INFO    ][10215] Running state [neutron] at time 21:06:38.569270
2018-01-31 21:06:38,569 [salt.state       ][INFO    ][10215] Executing state mysql_user.present for neutron
2018-01-31 21:06:38,586 [salt.loaded.int.module.mysql][INFO    ][10215] User 'neutron'@'%' has been created
2018-01-31 21:06:38,587 [salt.state       ][INFO    ][10215] {'neutron': 'Present'}
2018-01-31 21:06:38,587 [salt.state       ][INFO    ][10215] Completed state [neutron] at time 21:06:38.587673 duration_in_ms=18.403
2018-01-31 21:06:38,590 [salt.state       ][INFO    ][10215] Running state [mysql_grants_neutron_neutron_%] at time 21:06:38.590537
2018-01-31 21:06:38,591 [salt.state       ][INFO    ][10215] Executing state mysql_grants.present for mysql_grants_neutron_neutron_%
2018-01-31 21:06:38,605 [salt.loaded.int.module.mysql][INFO    ][10215] Grant 'all' on 'neutron.*' for user 'neutron' has been added
2018-01-31 21:06:38,606 [salt.state       ][INFO    ][10215] {'mysql_grants_neutron_neutron_%': 'Present'}
2018-01-31 21:06:38,607 [salt.state       ][INFO    ][10215] Completed state [mysql_grants_neutron_neutron_%] at time 21:06:38.606981 duration_in_ms=16.444
2018-01-31 21:06:38,607 [salt.state       ][INFO    ][10215] Running state [neutron] at time 21:06:38.607486
2018-01-31 21:06:38,608 [salt.state       ][INFO    ][10215] Executing state mysql_user.present for neutron
2018-01-31 21:06:38,625 [salt.loaded.int.module.mysql][INFO    ][10215] User 'neutron'@'192.168.10.51' has been created
2018-01-31 21:06:38,626 [salt.state       ][INFO    ][10215] {'neutron': 'Present'}
2018-01-31 21:06:38,627 [salt.state       ][INFO    ][10215] Completed state [neutron] at time 21:06:38.626971 duration_in_ms=19.485
2018-01-31 21:06:38,629 [salt.state       ][INFO    ][10215] Running state [mysql_grants_neutron_neutron_192.168.10.51] at time 21:06:38.629485
2018-01-31 21:06:38,630 [salt.state       ][INFO    ][10215] Executing state mysql_grants.present for mysql_grants_neutron_neutron_192.168.10.51
2018-01-31 21:06:38,644 [salt.loaded.int.module.mysql][INFO    ][10215] Grant 'all' on 'neutron.*' for user 'neutron' has been added
2018-01-31 21:06:38,645 [salt.state       ][INFO    ][10215] {'mysql_grants_neutron_neutron_192.168.10.51': 'Present'}
2018-01-31 21:06:38,645 [salt.state       ][INFO    ][10215] Completed state [mysql_grants_neutron_neutron_192.168.10.51] at time 21:06:38.645576 duration_in_ms=16.091
2018-01-31 21:06:38,646 [salt.state       ][INFO    ][10215] Running state [designate] at time 21:06:38.646084
2018-01-31 21:06:38,646 [salt.state       ][INFO    ][10215] Executing state mysql_database.present for designate
2018-01-31 21:06:38,652 [salt.loaded.int.module.mysql][INFO    ][10215] DB 'designate' created
2018-01-31 21:06:38,653 [salt.state       ][INFO    ][10215] {'designate': 'Present'}
2018-01-31 21:06:38,653 [salt.state       ][INFO    ][10215] Completed state [designate] at time 21:06:38.653736 duration_in_ms=7.651
2018-01-31 21:06:38,654 [salt.state       ][INFO    ][10215] Running state [designate] at time 21:06:38.654316
2018-01-31 21:06:38,655 [salt.state       ][INFO    ][10215] Executing state mysql_user.present for designate
2018-01-31 21:06:38,660 [salt.state       ][INFO    ][10215] User designate@% is already present with the desired password
2018-01-31 21:06:38,661 [salt.state       ][INFO    ][10215] Completed state [designate] at time 21:06:38.661032 duration_in_ms=6.716
2018-01-31 21:06:38,663 [salt.state       ][INFO    ][10215] Running state [mysql_grants_designate_designate_%] at time 21:06:38.663570
2018-01-31 21:06:38,664 [salt.state       ][INFO    ][10215] Executing state mysql_grants.present for mysql_grants_designate_designate_%
2018-01-31 21:06:38,680 [salt.loaded.int.module.mysql][INFO    ][10215] Grant 'all' on 'designate.*' for user 'designate' has been added
2018-01-31 21:06:38,681 [salt.state       ][INFO    ][10215] {'mysql_grants_designate_designate_%': 'Present'}
2018-01-31 21:06:38,681 [salt.state       ][INFO    ][10215] Completed state [mysql_grants_designate_designate_%] at time 21:06:38.681454 duration_in_ms=17.884
2018-01-31 21:06:38,681 [salt.state       ][INFO    ][10215] Running state [designate] at time 21:06:38.681941
2018-01-31 21:06:38,682 [salt.state       ][INFO    ][10215] Executing state mysql_user.present for designate
2018-01-31 21:06:38,687 [salt.state       ][INFO    ][10215] User designate@192.168.10.50 is already present with the desired password
2018-01-31 21:06:38,687 [salt.state       ][INFO    ][10215] Completed state [designate] at time 21:06:38.687699 duration_in_ms=5.758
2018-01-31 21:06:38,689 [salt.state       ][INFO    ][10215] Running state [mysql_grants_designate_designate_192.168.10.50] at time 21:06:38.689942
2018-01-31 21:06:38,690 [salt.state       ][INFO    ][10215] Executing state mysql_grants.present for mysql_grants_designate_designate_192.168.10.50
2018-01-31 21:06:38,706 [salt.loaded.int.module.mysql][INFO    ][10215] Grant 'all' on 'designate.*' for user 'designate' has been added
2018-01-31 21:06:38,707 [salt.state       ][INFO    ][10215] {'mysql_grants_designate_designate_192.168.10.50': 'Present'}
2018-01-31 21:06:38,708 [salt.state       ][INFO    ][10215] Completed state [mysql_grants_designate_designate_192.168.10.50] at time 21:06:38.708199 duration_in_ms=18.257
2018-01-31 21:06:38,708 [salt.state       ][INFO    ][10215] Running state [haproxy] at time 21:06:38.708735
2018-01-31 21:06:38,709 [salt.state       ][INFO    ][10215] Executing state mysql_user.present for haproxy
2018-01-31 21:06:38,728 [salt.loaded.int.module.mysql][INFO    ][10215] User 'haproxy'@'localhost' has been created with passwordless login
2018-01-31 21:06:38,728 [salt.state       ][INFO    ][10215] {'haproxy': 'Present'}
2018-01-31 21:06:38,729 [salt.state       ][INFO    ][10215] Completed state [haproxy] at time 21:06:38.729089 duration_in_ms=20.354
2018-01-31 21:06:38,729 [salt.state       ][INFO    ][10215] Running state [haproxy] at time 21:06:38.729646
2018-01-31 21:06:38,730 [salt.state       ][INFO    ][10215] Executing state mysql_user.present for haproxy
2018-01-31 21:06:38,749 [salt.loaded.int.module.mysql][INFO    ][10215] User 'haproxy'@'%' has been created with passwordless login
2018-01-31 21:06:38,749 [salt.state       ][INFO    ][10215] {'haproxy': 'Present'}
2018-01-31 21:06:38,750 [salt.state       ][INFO    ][10215] Completed state [haproxy] at time 21:06:38.750225 duration_in_ms=20.58
2018-01-31 21:06:38,750 [salt.state       ][INFO    ][10215] Running state [haproxy] at time 21:06:38.750763
2018-01-31 21:06:38,751 [salt.state       ][INFO    ][10215] Executing state mysql_user.present for haproxy
2018-01-31 21:06:38,770 [salt.loaded.int.module.mysql][INFO    ][10215] User 'haproxy'@'192.168.10.51' has been created with passwordless login
2018-01-31 21:06:38,770 [salt.state       ][INFO    ][10215] {'haproxy': 'Present'}
2018-01-31 21:06:38,771 [salt.state       ][INFO    ][10215] Completed state [haproxy] at time 21:06:38.771443 duration_in_ms=20.68
2018-01-31 21:06:38,776 [salt.minion      ][INFO    ][10215] Returning information for job: 20180131205540855952
2018-01-31 21:18:09,629 [salt.minion      ][INFO    ][7988] User sudo_ubuntu Executing command mysql.status with jid 20180131211810239237
2018-01-31 21:18:09,661 [salt.minion      ][INFO    ][16056] Starting a new job with PID 16056
2018-01-31 21:18:09,683 [salt.minion      ][INFO    ][16056] Returning information for job: 20180131211810239237
2018-01-31 21:18:23,791 [salt.minion      ][INFO    ][7988] User sudo_ubuntu Executing command state.sls with jid 20180131211824401866
2018-01-31 21:18:23,814 [salt.minion      ][INFO    ][16061] Starting a new job with PID 16061
2018-01-31 21:18:25,399 [salt.state       ][INFO    ][16061] Loading fresh modules for state activity
2018-01-31 21:18:25,446 [salt.fileclient  ][INFO    ][16061] Fetching file from saltenv 'base', ** done ** 'haproxy/init.sls'
2018-01-31 21:18:25,467 [salt.fileclient  ][INFO    ][16061] Fetching file from saltenv 'base', ** done ** 'haproxy/proxy.sls'
2018-01-31 21:18:26,462 [salt.state       ][INFO    ][16061] Running state [haproxy] at time 21:18:26.462546
2018-01-31 21:18:26,462 [salt.state       ][INFO    ][16061] Executing state pkg.installed for haproxy
2018-01-31 21:18:26,463 [salt.loaded.int.module.cmdmod][INFO    ][16061] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2018-01-31 21:18:26,955 [salt.loaded.int.module.cmdmod][INFO    ][16061] Executing command ['apt-cache', '-q', 'policy', 'haproxy'] in directory '/root'
2018-01-31 21:18:27,046 [salt.loaded.int.module.cmdmod][INFO    ][16061] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2018-01-31 21:18:28,887 [salt.loaded.int.module.cmdmod][INFO    ][16061] Executing command ['dpkg', '--get-selections', '*'] in directory '/root'
2018-01-31 21:18:28,925 [salt.loaded.int.module.cmdmod][INFO    ][16061] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'haproxy'] in directory '/root'
2018-01-31 21:18:32,106 [salt.loaded.int.module.cmdmod][INFO    ][16061] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2018-01-31 21:18:32,150 [salt.state       ][INFO    ][16061] Made the following changes:
'haproxy' changed from 'absent' to '1.6.3-1ubuntu0.1'
'liblua5.3-0' changed from 'absent' to '5.3.1-1ubuntu2'

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

2018-01-31 21:18:32,245 [salt.state       ][INFO    ][16061] Completed state [/etc/default/haproxy] at time 21:18:32.245235 duration_in_ms=36.266
2018-01-31 21:18:32,245 [salt.state       ][INFO    ][16061] Running state [/etc/haproxy/haproxy.cfg] at time 21:18:32.245583
2018-01-31 21:18:32,245 [salt.state       ][INFO    ][16061] Executing state file.managed for /etc/haproxy/haproxy.cfg
2018-01-31 21:18:32,269 [salt.fileclient  ][INFO    ][16061] Fetching file from saltenv 'base', ** done ** 'haproxy/files/haproxy.cfg'
2018-01-31 21:18:32,445 [salt.state       ][INFO    ][16061] 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 192.168.10.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 192.168.10.51:3306 check inter 20s fastinter 2s downinter 2s rise 3 fall 3
+  server dbs02 192.168.10.52:3306 backup check inter 20s fastinter 2s downinter 2s rise 3 fall 3
+  server dbs03 192.168.10.53:3306 backup check inter 20s fastinter 2s downinter 2s rise 3 fall 3

2018-01-31 21:18:32,445 [salt.state       ][INFO    ][16061] Completed state [/etc/haproxy/haproxy.cfg] at time 21:18:32.445931 duration_in_ms=200.347
2018-01-31 21:18:32,446 [salt.state       ][INFO    ][16061] Running state [/etc/haproxy/ssl] at time 21:18:32.446290
2018-01-31 21:18:32,446 [salt.state       ][INFO    ][16061] Executing state file.directory for /etc/haproxy/ssl
2018-01-31 21:18:32,448 [salt.state       ][INFO    ][16061] {'/etc/haproxy/ssl': 'New Dir'}
2018-01-31 21:18:32,448 [salt.state       ][INFO    ][16061] Completed state [/etc/haproxy/ssl] at time 21:18:32.448558 duration_in_ms=2.268
2018-01-31 21:18:32,449 [salt.state       ][INFO    ][16061] Running state [haproxy_status_packages] at time 21:18:32.449369
2018-01-31 21:18:32,449 [salt.state       ][INFO    ][16061] Executing state pkg.installed for haproxy_status_packages
2018-01-31 21:18:32,849 [salt.state       ][INFO    ][16061] All specified packages are already installed
2018-01-31 21:18:32,849 [salt.state       ][INFO    ][16061] Completed state [haproxy_status_packages] at time 21:18:32.849838 duration_in_ms=400.468
2018-01-31 21:18:32,850 [salt.state       ][INFO    ][16061] Running state [/usr/bin/haproxy-status.sh] at time 21:18:32.850607
2018-01-31 21:18:32,850 [salt.state       ][INFO    ][16061] Executing state file.managed for /usr/bin/haproxy-status.sh
2018-01-31 21:18:32,873 [salt.fileclient  ][INFO    ][16061] Fetching file from saltenv 'base', ** done ** 'haproxy/files/haproxy-status.sh'
2018-01-31 21:18:32,896 [salt.state       ][INFO    ][16061] File changed:
New file
2018-01-31 21:18:32,897 [salt.state       ][INFO    ][16061] Completed state [/usr/bin/haproxy-status.sh] at time 21:18:32.896949 duration_in_ms=46.341
2018-01-31 21:18:32,897 [salt.state       ][INFO    ][16061] Running state [net.ipv4.ip_nonlocal_bind] at time 21:18:32.897531
2018-01-31 21:18:32,897 [salt.state       ][INFO    ][16061] Executing state sysctl.present for net.ipv4.ip_nonlocal_bind
2018-01-31 21:18:32,898 [salt.loaded.int.module.cmdmod][INFO    ][16061] Executing command 'sysctl -a' in directory '/root'
2018-01-31 21:18:32,936 [salt.loaded.int.module.cmdmod][INFO    ][16061] Executing command 'sysctl -w net.ipv4.ip_nonlocal_bind="1"' in directory '/root'
2018-01-31 21:18:32,954 [salt.state       ][INFO    ][16061] {'net.ipv4.ip_nonlocal_bind': 1}
2018-01-31 21:18:32,955 [salt.state       ][INFO    ][16061] Completed state [net.ipv4.ip_nonlocal_bind] at time 21:18:32.955568 duration_in_ms=58.037
2018-01-31 21:18:32,958 [salt.state       ][INFO    ][16061] Running state [haproxy] at time 21:18:32.957985
2018-01-31 21:18:32,958 [salt.state       ][INFO    ][16061] Executing state service.running for haproxy
2018-01-31 21:18:32,959 [salt.loaded.int.module.cmdmod][INFO    ][16061] Executing command ['systemctl', 'status', 'haproxy.service', '-n', '0'] in directory '/root'
2018-01-31 21:18:32,981 [salt.loaded.int.module.cmdmod][INFO    ][16061] Executing command ['systemctl', 'is-active', 'haproxy.service'] in directory '/root'
2018-01-31 21:18:33,001 [salt.loaded.int.module.cmdmod][INFO    ][16061] Executing command ['systemctl', 'is-enabled', 'haproxy.service'] in directory '/root'
2018-01-31 21:18:33,021 [salt.state       ][INFO    ][16061] The service haproxy is already running
2018-01-31 21:18:33,021 [salt.state       ][INFO    ][16061] Completed state [haproxy] at time 21:18:33.021554 duration_in_ms=63.568
2018-01-31 21:18:33,021 [salt.state       ][INFO    ][16061] Running state [haproxy] at time 21:18:33.021855
2018-01-31 21:18:33,022 [salt.state       ][INFO    ][16061] Executing state service.mod_watch for haproxy
2018-01-31 21:18:33,023 [salt.loaded.int.module.cmdmod][INFO    ][16061] Executing command ['systemctl', 'is-active', 'haproxy.service'] in directory '/root'
2018-01-31 21:18:33,041 [salt.loaded.int.module.cmdmod][INFO    ][16061] Executing command ['systemctl', 'is-enabled', 'haproxy.service'] in directory '/root'
2018-01-31 21:18:33,062 [salt.loaded.int.module.cmdmod][INFO    ][16061] Executing command ['systemd-run', '--scope', 'systemctl', 'restart', 'haproxy.service'] in directory '/root'
2018-01-31 21:18:33,141 [salt.state       ][INFO    ][16061] {'haproxy': True}
2018-01-31 21:18:33,142 [salt.state       ][INFO    ][16061] Completed state [haproxy] at time 21:18:33.142394 duration_in_ms=120.538
2018-01-31 21:18:33,144 [salt.minion      ][INFO    ][16061] Returning information for job: 20180131211824401866
2018-01-31 21:18:38,605 [salt.minion      ][INFO    ][7988] User sudo_ubuntu Executing command service.status with jid 20180131211839213851
2018-01-31 21:18:38,634 [salt.minion      ][INFO    ][16905] Starting a new job with PID 16905
2018-01-31 21:18:38,688 [salt.loader.192.168.11.2.int.module.cmdmod][INFO    ][16905] Executing command ['systemctl', 'status', 'haproxy.service', '-n', '0'] in directory '/root'
2018-01-31 21:18:38,712 [salt.loader.192.168.11.2.int.module.cmdmod][INFO    ][16905] Executing command ['systemctl', 'is-active', 'haproxy.service'] in directory '/root'
2018-01-31 21:18:38,734 [salt.minion      ][INFO    ][16905] Returning information for job: 20180131211839213851
2018-01-31 21:18:39,477 [salt.minion      ][INFO    ][7988] User sudo_ubuntu Executing command service.restart with jid 20180131211840085093
2018-01-31 21:18:39,498 [salt.minion      ][INFO    ][16912] Starting a new job with PID 16912
2018-01-31 21:18:39,550 [salt.loader.192.168.11.2.int.module.cmdmod][INFO    ][16912] Executing command ['systemctl', 'status', 'rsyslog.service', '-n', '0'] in directory '/root'
2018-01-31 21:18:39,570 [salt.loader.192.168.11.2.int.module.cmdmod][INFO    ][16912] Executing command ['systemctl', 'is-enabled', 'rsyslog.service'] in directory '/root'
2018-01-31 21:18:39,612 [salt.loader.192.168.11.2.int.module.cmdmod][INFO    ][16912] Executing command ['systemd-run', '--scope', 'systemctl', 'restart', 'rsyslog.service'] in directory '/root'
2018-01-31 21:18:39,664 [salt.minion      ][INFO    ][16912] Returning information for job: 20180131211840085093
2018-01-31 21:42:47,311 [salt.utils.schedule][INFO    ][7988] Running scheduled job: __mine_interval
2018-01-31 21:51:49,461 [salt.minion      ][INFO    ][7988] User sudo_ubuntu Executing command cp.push_dir with jid 20180131215150069315
2018-01-31 21:51:49,490 [salt.minion      ][INFO    ][17074] Starting a new job with PID 17074
