2019-02-27 09:29:43,558 [salt.utils.decorators:613 ][WARNING ][1928] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2019-02-27 09:30:04,928 [salt.utils.decorators:613 ][WARNING ][3018] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2019-02-27 09:30:14,123 [salt.loaded.int.states.file:2298][WARNING ][3018] State for file: /boot/grub/grub.cfg - Neither 'source' nor 'contents' nor 'contents_pillar' nor 'contents_grains' was defined, yet 'replace' was set to 'True'. As there is no source to replace the file with, 'replace' has been set to 'False' to avoid reading the file unnecessarily.
2019-02-27 09:30:22,864 [salt.utils.decorators:613 ][WARNING ][3018] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2019-02-27 09:30:22,962 [salt.loaded.int.states.file:2298][WARNING ][3018] State for file: /etc/shadow - Neither 'source' nor 'contents' nor 'contents_pillar' nor 'contents_grains' was defined, yet 'replace' was set to 'True'. As there is no source to replace the file with, 'replace' has been set to 'False' to avoid reading the file unnecessarily.
2019-02-27 09:30:22,963 [salt.loaded.int.states.file:2298][WARNING ][3018] State for file: /etc/gshadow - Neither 'source' nor 'contents' nor 'contents_pillar' nor 'contents_grains' was defined, yet 'replace' was set to 'True'. As there is no source to replace the file with, 'replace' has been set to 'False' to avoid reading the file unnecessarily.
2019-02-27 09:30:22,964 [salt.loaded.int.states.file:2298][WARNING ][3018] State for file: /etc/group- - Neither 'source' nor 'contents' nor 'contents_pillar' nor 'contents_grains' was defined, yet 'replace' was set to 'True'. As there is no source to replace the file with, 'replace' has been set to 'False' to avoid reading the file unnecessarily.
2019-02-27 09:30:22,965 [salt.loaded.int.states.file:2298][WARNING ][3018] State for file: /etc/shadow- - Neither 'source' nor 'contents' nor 'contents_pillar' nor 'contents_grains' was defined, yet 'replace' was set to 'True'. As there is no source to replace the file with, 'replace' has been set to 'False' to avoid reading the file unnecessarily.
2019-02-27 09:30:22,967 [salt.loaded.int.states.file:2298][WARNING ][3018] State for file: /etc/passwd- - Neither 'source' nor 'contents' nor 'contents_pillar' nor 'contents_grains' was defined, yet 'replace' was set to 'True'. As there is no source to replace the file with, 'replace' has been set to 'False' to avoid reading the file unnecessarily.
2019-02-27 09:30:22,968 [salt.loaded.int.states.file:2298][WARNING ][3018] State for file: /etc/passwd - Neither 'source' nor 'contents' nor 'contents_pillar' nor 'contents_grains' was defined, yet 'replace' was set to 'True'. As there is no source to replace the file with, 'replace' has been set to 'False' to avoid reading the file unnecessarily.
2019-02-27 09:30:22,969 [salt.loaded.int.states.file:2298][WARNING ][3018] State for file: /etc/gshadow- - Neither 'source' nor 'contents' nor 'contents_pillar' nor 'contents_grains' was defined, yet 'replace' was set to 'True'. As there is no source to replace the file with, 'replace' has been set to 'False' to avoid reading the file unnecessarily.
2019-02-27 09:30:22,970 [salt.loaded.int.states.file:2298][WARNING ][3018] State for file: /etc/group - Neither 'source' nor 'contents' nor 'contents_pillar' nor 'contents_grains' was defined, yet 'replace' was set to 'True'. As there is no source to replace the file with, 'replace' has been set to 'False' to avoid reading the file unnecessarily.
2019-02-27 09:30:24,347 [salt.loaded.int.module.debian_ip:1964][WARNING ][3018] The network state sls is requiring a reboot of the system to properly apply network configuration.
2019-02-27 09:30:24,486 [salt.loaded.int.module.cmdmod:730 ][ERROR   ][3018] Command '['umount', '/dev/shm']' failed with return code: 32
2019-02-27 09:30:24,487 [salt.loaded.int.module.cmdmod:734 ][ERROR   ][3018] stderr: umount: /dev/shm: target is busy
        (In some cases useful info about processes that
         use the device is found by lsof(8) or fuser(1).)
2019-02-27 09:30:24,488 [salt.loaded.int.module.cmdmod:736 ][ERROR   ][3018] retcode: 32
2019-02-27 09:30:31,152 [salt.loaded.int.module.cmdmod:395 ][INFO    ][7160] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2019-02-27 09:30:31,174 [salt.loaded.int.module.cmdmod:395 ][INFO    ][7160] Executing command ['systemd-run', '--scope', 'systemctl', 'restart', 'salt-minion.service'] in directory '/root'
2019-02-27 09:30:31,189 [salt.utils.parsers:1051][WARNING ][1589] Minion received a SIGTERM. Exiting.
2019-02-27 09:30:32,010 [salt.cli.daemons :293 ][INFO    ][7214] Setting up the Salt Minion "dbs01.mcp-odl-ha.local"
2019-02-27 09:30:32,097 [salt.cli.daemons :82  ][INFO    ][7214] Starting up the Salt Minion
2019-02-27 09:30:32,098 [salt.utils.event :1017][INFO    ][7214] Starting pull socket on /var/run/salt/minion/minion_event_99e5a6d7b6_pull.ipc
2019-02-27 09:30:32,630 [salt.minion      :976 ][INFO    ][7214] Creating minion process manager
2019-02-27 09:30:33,852 [salt.loader.192.168.11.2.int.module.cmdmod:395 ][INFO    ][7214] Executing command ['date', '+%z'] in directory '/root'
2019-02-27 09:30:33,867 [salt.utils.schedule:568 ][INFO    ][7214] Updating job settings for scheduled job: __mine_interval
2019-02-27 09:30:33,869 [salt.minion      :1108][INFO    ][7214] Added mine.update to scheduler
2019-02-27 09:30:33,874 [salt.minion      :1975][INFO    ][7214] Minion is starting as user 'root'
2019-02-27 09:30:33,890 [salt.minion      :2336][INFO    ][7214] Minion is ready to receive requests!
2019-02-27 09:30:44,888 [salt.minion      :1308][INFO    ][7214] User sudo_ubuntu Executing command ssh.set_auth_key with jid 20190227093044878956
2019-02-27 09:30:44,901 [salt.minion      :1432][INFO    ][7311] Starting a new job with PID 7311
2019-02-27 09:30:44,925 [salt.minion      :1711][INFO    ][7311] Returning information for job: 20190227093044878956
2019-02-27 09:30:45,566 [salt.minion      :1308][INFO    ][7214] User sudo_ubuntu Executing command system.reboot with jid 20190227093045553721
2019-02-27 09:30:45,579 [salt.minion      :1432][INFO    ][7316] Starting a new job with PID 7316
2019-02-27 09:30:45,585 [salt.loader.192.168.11.2.int.module.cmdmod:395 ][INFO    ][7316] Executing command ['shutdown', '-r', 'now'] in directory '/root'
2019-02-27 09:30:45,672 [salt.utils.parsers:1051][WARNING ][7214] Minion received a SIGTERM. Exiting.
2019-02-27 09:30:45,673 [salt.cli.daemons :82  ][INFO    ][7214] Shutting down the Salt Minion
2019-02-27 09:30:46,371 [salt.minion      :1711][INFO    ][7316] Returning information for job: 20190227093045553721
2019-02-27 09:30:59,368 [salt.cli.daemons :293 ][INFO    ][1610] Setting up the Salt Minion "dbs01.mcp-odl-ha.local"
2019-02-27 09:31:00,129 [salt.cli.daemons :82  ][INFO    ][1610] Starting up the Salt Minion
2019-02-27 09:31:00,130 [salt.utils.event :1017][INFO    ][1610] Starting pull socket on /var/run/salt/minion/minion_event_99e5a6d7b6_pull.ipc
2019-02-27 09:31:00,945 [salt.minion      :976 ][INFO    ][1610] Creating minion process manager
2019-02-27 09:31:02,457 [salt.loader.192.168.11.2.int.module.cmdmod:395 ][INFO    ][1610] Executing command ['date', '+%z'] in directory '/root'
2019-02-27 09:31:02,500 [salt.utils.schedule:568 ][INFO    ][1610] Updating job settings for scheduled job: __mine_interval
2019-02-27 09:31:02,501 [salt.minion      :1108][INFO    ][1610] Added mine.update to scheduler
2019-02-27 09:31:02,506 [salt.minion      :1975][INFO    ][1610] Minion is starting as user 'root'
2019-02-27 09:31:02,792 [salt.minion      :2336][INFO    ][1610] Minion is ready to receive requests!
2019-02-27 09:31:02,795 [salt.minion      :1308][INFO    ][1610] User sudo_ubuntu Executing command saltutil.find_job with jid 20190227093100649706
2019-02-27 09:31:02,804 [salt.minion      :1432][INFO    ][1732] Starting a new job with PID 1732
2019-02-27 09:31:02,851 [salt.minion      :1711][INFO    ][1732] Returning information for job: 20190227093100649706
2019-02-27 09:31:32,554 [salt.minion      :1308][INFO    ][1610] User sudo_ubuntu Executing command test.ping with jid 20190227093131296691
2019-02-27 09:31:32,565 [salt.minion      :1432][INFO    ][1737] Starting a new job with PID 1737
2019-02-27 09:31:32,591 [salt.minion      :1711][INFO    ][1737] Returning information for job: 20190227093131296691
2019-02-27 09:31:33,175 [salt.minion      :1308][INFO    ][1610] User sudo_ubuntu Executing command pkg.upgrade with jid 20190227093131916219
2019-02-27 09:31:33,186 [salt.minion      :1432][INFO    ][1742] Starting a new job with PID 1742
2019-02-27 09:31:33,266 [salt.loader.192.168.11.2.int.module.cmdmod:395 ][INFO    ][1742] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}', '-W'] in directory '/root'
2019-02-27 09:31:33,741 [salt.loader.192.168.11.2.int.module.cmdmod:395 ][INFO    ][1742] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'dist-upgrade'] in directory '/root'
2019-02-27 09:31:48,247 [salt.minion      :1308][INFO    ][1610] User sudo_ubuntu Executing command saltutil.find_job with jid 20190227093146988951
2019-02-27 09:31:48,258 [salt.minion      :1432][INFO    ][9284] Starting a new job with PID 9284
2019-02-27 09:31:48,271 [salt.minion      :1711][INFO    ][9284] Returning information for job: 20190227093146988951
2019-02-27 09:32:16,710 [salt.loader.192.168.11.2.int.module.cmdmod:395 ][INFO    ][1742] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}', '-W'] in directory '/root'
2019-02-27 09:32:16,743 [salt.minion      :1711][INFO    ][1742] Returning information for job: 20190227093131916219
2019-02-27 09:33:53,957 [salt.minion      :1308][INFO    ][1610] User sudo_ubuntu Executing command test.ping with jid 20190227093353946278
2019-02-27 09:33:53,967 [salt.minion      :1432][INFO    ][18152] Starting a new job with PID 18152
2019-02-27 09:33:53,986 [salt.minion      :1711][INFO    ][18152] Returning information for job: 20190227093353946278
2019-02-27 09:34:36,476 [salt.minion      :1308][INFO    ][1610] User sudo_ubuntu Executing command state.sls with jid 20190227093436469073
2019-02-27 09:34:36,485 [salt.minion      :1432][INFO    ][18157] Starting a new job with PID 18157
2019-02-27 09:34:37,408 [salt.state       :915 ][INFO    ][18157] Loading fresh modules for state activity
2019-02-27 09:34:37,454 [salt.fileclient  :1219][INFO    ][18157] Fetching file from saltenv 'base', ** done ** 'keepalived/init.sls'
2019-02-27 09:34:37,478 [salt.fileclient  :1219][INFO    ][18157] Fetching file from saltenv 'base', ** done ** 'keepalived/cluster.sls'
2019-02-27 09:34:38,338 [salt.state       :1780][INFO    ][18157] Running state [keepalived] at time 09:34:38.338510
2019-02-27 09:34:38,339 [salt.state       :1813][INFO    ][18157] Executing state pkg.installed for [keepalived]
2019-02-27 09:34:38,339 [salt.loaded.int.module.cmdmod:395 ][INFO    ][18157] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}', '-W'] in directory '/root'
2019-02-27 09:34:38,647 [salt.loaded.int.module.cmdmod:395 ][INFO    ][18157] Executing command ['apt-cache', '-q', 'policy', 'keepalived'] in directory '/root'
2019-02-27 09:34:38,706 [salt.loaded.int.module.cmdmod:395 ][INFO    ][18157] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2019-02-27 09:34:40,406 [salt.loaded.int.module.cmdmod:395 ][INFO    ][18157] Executing command ['dpkg', '--get-selections', '*'] in directory '/root'
2019-02-27 09:34:40,425 [salt.loaded.int.module.cmdmod:395 ][INFO    ][18157] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'keepalived'] in directory '/root'
2019-02-27 09:34:43,489 [salt.loaded.int.module.cmdmod:395 ][INFO    ][18157] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}', '-W'] in directory '/root'
2019-02-27 09:34:43,519 [salt.state       :300 ][INFO    ][18157] Made the following changes:
'libsnmp30' changed from 'absent' to '5.7.3+dfsg-1ubuntu4.2'
'libsensors4' changed from 'absent' to '1:3.4.0-2'
'libsnmp-base' changed from 'absent' to '5.7.3+dfsg-1ubuntu4.2'
'keepalived' changed from 'absent' to '1:1.3.9-1.0.18.04.1~u16.04+mcp'
'ipvsadm' changed from 'absent' to '1:1.28-3'
'libnl-route-3-200' changed from 'absent' to '3.2.27-1ubuntu0.16.04.1'

2019-02-27 09:34:43,538 [salt.state       :915 ][INFO    ][18157] Loading fresh modules for state activity
2019-02-27 09:34:43,572 [salt.state       :1951][INFO    ][18157] Completed state [keepalived] at time 09:34:43.572280 duration_in_ms=5233.77
2019-02-27 09:34:43,577 [salt.state       :1780][INFO    ][18157] Running state [lsof] at time 09:34:43.577244
2019-02-27 09:34:43,577 [salt.state       :1813][INFO    ][18157] Executing state pkg.installed for [lsof]
2019-02-27 09:34:44,145 [salt.state       :300 ][INFO    ][18157] All specified packages are already installed
2019-02-27 09:34:44,145 [salt.state       :1951][INFO    ][18157] Completed state [lsof] at time 09:34:44.145890 duration_in_ms=568.645
2019-02-27 09:34:44,150 [salt.state       :1780][INFO    ][18157] Running state [/etc/keepalived/keepalived.conf] at time 09:34:44.150093
2019-02-27 09:34:44,150 [salt.state       :1813][INFO    ][18157] Executing state file.managed for [/etc/keepalived/keepalived.conf]
2019-02-27 09:34:44,173 [salt.fileclient  :1219][INFO    ][18157] Fetching file from saltenv 'base', ** done ** 'keepalived/files/keepalived.conf'
2019-02-27 09:34:44,213 [salt.state       :300 ][INFO    ][18157] File changed:
New file
2019-02-27 09:34:44,214 [salt.state       :1951][INFO    ][18157] Completed state [/etc/keepalived/keepalived.conf] at time 09:34:44.214058 duration_in_ms=63.965
2019-02-27 09:34:44,215 [salt.state       :1780][INFO    ][18157] Running state [keepalived] at time 09:34:44.215389
2019-02-27 09:34:44,215 [salt.state       :1813][INFO    ][18157] Executing state service.running for [keepalived]
2019-02-27 09:34:44,216 [salt.loaded.int.module.cmdmod:395 ][INFO    ][18157] Executing command ['systemctl', 'status', 'keepalived.service', '-n', '0'] in directory '/root'
2019-02-27 09:34:44,229 [salt.loaded.int.module.cmdmod:395 ][INFO    ][18157] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2019-02-27 09:34:44,240 [salt.loaded.int.module.cmdmod:395 ][INFO    ][18157] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2019-02-27 09:34:44,252 [salt.loaded.int.module.cmdmod:395 ][INFO    ][18157] Executing command ['systemd-run', '--scope', 'systemctl', 'start', 'keepalived.service'] in directory '/root'
2019-02-27 09:34:44,306 [salt.loaded.int.module.cmdmod:395 ][INFO    ][18157] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2019-02-27 09:34:44,319 [salt.loaded.int.module.cmdmod:395 ][INFO    ][18157] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2019-02-27 09:34:44,331 [salt.loaded.int.module.cmdmod:395 ][INFO    ][18157] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2019-02-27 09:34:44,342 [salt.state       :300 ][INFO    ][18157] {'keepalived': True}
2019-02-27 09:34:44,343 [salt.state       :1951][INFO    ][18157] Completed state [keepalived] at time 09:34:44.343060 duration_in_ms=127.668
2019-02-27 09:34:44,344 [salt.minion      :1711][INFO    ][18157] Returning information for job: 20190227093436469073
2019-02-27 09:38:10,012 [salt.minion      :1308][INFO    ][1610] User sudo_ubuntu Executing command pillar.get with jid 20190227093810006702
2019-02-27 09:38:10,024 [salt.minion      :1432][INFO    ][19476] Starting a new job with PID 19476
2019-02-27 09:38:10,031 [salt.minion      :1711][INFO    ][19476] Returning information for job: 20190227093810006702
2019-02-27 09:44:09,330 [salt.minion      :1308][INFO    ][1610] User sudo_ubuntu Executing command state.sls with jid 20190227094409324924
2019-02-27 09:44:09,341 [salt.minion      :1432][INFO    ][19481] Starting a new job with PID 19481
2019-02-27 09:44:17,172 [salt.state       :915 ][INFO    ][19481] Loading fresh modules for state activity
2019-02-27 09:44:17,224 [salt.fileclient  :1219][INFO    ][19481] Fetching file from saltenv 'base', ** done ** 'galera/init.sls'
2019-02-27 09:44:17,260 [salt.fileclient  :1219][INFO    ][19481] Fetching file from saltenv 'base', ** done ** 'galera/master.sls'
2019-02-27 09:44:17,324 [salt.loaded.int.module.cmdmod:395 ][INFO    ][19481] Executing command 'test -e /var/lib/mysql/.galera_bootstrap; echo $?' in directory '/root'
2019-02-27 09:44:17,336 [salt.loaded.int.module.cmdmod:395 ][INFO    ][19481] Executing command 'test -e /etc/salt/.galera_bootstrap; echo $?' in directory '/root'
2019-02-27 09:44:17,408 [salt.fileclient  :1219][INFO    ][19481] Fetching file from saltenv 'base', ** done ** 'galera/server.sls'
2019-02-27 09:44:18,167 [salt.state       :1780][INFO    ][19481] Running state [/etc/mysql/my.cnf] at time 09:44:18.167018
2019-02-27 09:44:18,167 [salt.state       :1813][INFO    ][19481] Executing state file.managed for [/etc/mysql/my.cnf]
2019-02-27 09:44:18,195 [salt.fileclient  :1219][INFO    ][19481] Fetching file from saltenv 'base', ** done ** 'galera/files/my.cnf.pre'
2019-02-27 09:44:18,204 [salt.state       :300 ][INFO    ][19481] File changed:
New file
2019-02-27 09:44:18,205 [salt.state       :1951][INFO    ][19481] Completed state [/etc/mysql/my.cnf] at time 09:44:18.205218 duration_in_ms=38.201
2019-02-27 09:44:18,206 [salt.state       :1780][INFO    ][19481] Running state [mysql-wsrep-5.6] at time 09:44:18.206069
2019-02-27 09:44:18,206 [salt.state       :1813][INFO    ][19481] Executing state pkg.installed for [mysql-wsrep-5.6]
2019-02-27 09:44:18,207 [salt.loaded.int.module.cmdmod:395 ][INFO    ][19481] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}', '-W'] in directory '/root'
2019-02-27 09:44:18,501 [salt.loaded.int.module.cmdmod:395 ][INFO    ][19481] Executing command ['apt-cache', '-q', 'policy', 'mysql-wsrep-5.6'] in directory '/root'
2019-02-27 09:44:18,559 [salt.loaded.int.module.cmdmod:395 ][INFO    ][19481] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2019-02-27 09:44:19,875 [salt.loaded.int.module.cmdmod:395 ][INFO    ][19481] Executing command ['dpkg', '--get-selections', '*'] in directory '/root'
2019-02-27 09:44:19,895 [salt.loaded.int.module.cmdmod:395 ][INFO    ][19481] 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'
2019-02-27 09:44:24,367 [salt.minion      :1308][INFO    ][1610] User sudo_ubuntu Executing command saltutil.find_job with jid 20190227094424360931
2019-02-27 09:44:24,376 [salt.minion      :1432][INFO    ][19823] Starting a new job with PID 19823
2019-02-27 09:44:24,388 [salt.minion      :1711][INFO    ][19823] Returning information for job: 20190227094424360931
2019-02-27 09:44:43,221 [salt.loaded.int.module.cmdmod:395 ][INFO    ][19481] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}', '-W'] in directory '/root'
2019-02-27 09:44:43,252 [salt.state       :300 ][INFO    ][19481] 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.25-0ubuntu0.16.04.2'
'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.25-0ubuntu0.16.04.2'
'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'

2019-02-27 09:44:43,269 [salt.state       :915 ][INFO    ][19481] Loading fresh modules for state activity
2019-02-27 09:44:43,301 [salt.state       :1951][INFO    ][19481] Completed state [mysql-wsrep-5.6] at time 09:44:43.301641 duration_in_ms=25095.571
2019-02-27 09:44:43,307 [salt.state       :1780][INFO    ][19481] Running state [python-mysqldb] at time 09:44:43.307097
2019-02-27 09:44:43,307 [salt.state       :1813][INFO    ][19481] Executing state pkg.installed for [python-mysqldb]
2019-02-27 09:44:43,895 [salt.loaded.int.module.cmdmod:395 ][INFO    ][19481] Executing command ['apt-cache', '-q', 'policy', 'python-mysqldb'] in directory '/root'
2019-02-27 09:44:43,941 [salt.loaded.int.module.cmdmod:395 ][INFO    ][19481] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2019-02-27 09:44:45,329 [salt.loaded.int.module.cmdmod:395 ][INFO    ][19481] Executing command ['dpkg', '--get-selections', '*'] in directory '/root'
2019-02-27 09:44:45,352 [salt.loaded.int.module.cmdmod:395 ][INFO    ][19481] 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'
2019-02-27 09:44:46,793 [salt.loaded.int.module.cmdmod:395 ][INFO    ][19481] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}', '-W'] in directory '/root'
2019-02-27 09:44:46,827 [salt.state       :300 ][INFO    ][19481] Made the following changes:
'python2.7-mysqldb' changed from 'absent' to '1'
'python-mysqldb' changed from 'absent' to '1.3.7-1build2'

2019-02-27 09:44:46,843 [salt.state       :915 ][INFO    ][19481] Loading fresh modules for state activity
2019-02-27 09:44:46,875 [salt.state       :1951][INFO    ][19481] Completed state [python-mysqldb] at time 09:44:46.875086 duration_in_ms=3567.988
2019-02-27 09:44:46,880 [salt.state       :1780][INFO    ][19481] Running state [libdbd-mysql] at time 09:44:46.880856
2019-02-27 09:44:46,881 [salt.state       :1813][INFO    ][19481] Executing state pkg.installed for [libdbd-mysql]
2019-02-27 09:44:47,464 [salt.loaded.int.module.cmdmod:395 ][INFO    ][19481] Executing command ['apt-cache', '-q', 'policy', 'libdbd-mysql'] in directory '/root'
2019-02-27 09:44:47,514 [salt.loaded.int.module.cmdmod:395 ][INFO    ][19481] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2019-02-27 09:44:48,817 [salt.loaded.int.module.cmdmod:395 ][INFO    ][19481] Executing command ['dpkg', '--get-selections', '*'] in directory '/root'
2019-02-27 09:44:48,838 [salt.loaded.int.module.cmdmod:395 ][INFO    ][19481] 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'
2019-02-27 09:44:50,484 [salt.loaded.int.module.cmdmod:395 ][INFO    ][19481] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}', '-W'] in directory '/root'
2019-02-27 09:44:50,517 [salt.state       :300 ][INFO    ][19481] Made the following changes:
'libdbd-mysql' changed from 'absent' to '0.9.0-3ubuntu2'
'libdbi1' changed from 'absent' to '0.9.0-4'

2019-02-27 09:44:50,534 [salt.state       :915 ][INFO    ][19481] Loading fresh modules for state activity
2019-02-27 09:44:50,566 [salt.state       :1951][INFO    ][19481] Completed state [libdbd-mysql] at time 09:44:50.566672 duration_in_ms=3685.815
2019-02-27 09:44:50,574 [salt.state       :1780][INFO    ][19481] Running state [percona-xtrabackup] at time 09:44:50.574125
2019-02-27 09:44:50,574 [salt.state       :1813][INFO    ][19481] Executing state pkg.installed for [percona-xtrabackup]
2019-02-27 09:44:51,245 [salt.loaded.int.module.cmdmod:395 ][INFO    ][19481] Executing command ['apt-cache', '-q', 'policy', 'percona-xtrabackup'] in directory '/root'
2019-02-27 09:44:51,294 [salt.loaded.int.module.cmdmod:395 ][INFO    ][19481] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2019-02-27 09:44:52,624 [salt.loaded.int.module.cmdmod:395 ][INFO    ][19481] Executing command ['dpkg', '--get-selections', '*'] in directory '/root'
2019-02-27 09:44:52,647 [salt.loaded.int.module.cmdmod:395 ][INFO    ][19481] 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'
2019-02-27 09:44:54,391 [salt.minion      :1308][INFO    ][1610] User sudo_ubuntu Executing command saltutil.find_job with jid 20190227094454382460
2019-02-27 09:44:54,403 [salt.minion      :1432][INFO    ][22243] Starting a new job with PID 22243
2019-02-27 09:44:54,415 [salt.minion      :1711][INFO    ][22243] Returning information for job: 20190227094454382460
2019-02-27 09:44:55,659 [salt.loaded.int.module.cmdmod:395 ][INFO    ][19481] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}', '-W'] in directory '/root'
2019-02-27 09:44:55,696 [salt.state       :300 ][INFO    ][19481] 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.12'
'percona-xtrabackup' changed from 'absent' to '2.3.7-0ubuntu0.16.04.2'

2019-02-27 09:44:55,713 [salt.state       :915 ][INFO    ][19481] Loading fresh modules for state activity
2019-02-27 09:44:55,746 [salt.state       :1951][INFO    ][19481] Completed state [percona-xtrabackup] at time 09:44:55.746181 duration_in_ms=5172.054
2019-02-27 09:44:55,752 [salt.state       :1780][INFO    ][19481] Running state [galera-3] at time 09:44:55.752070
2019-02-27 09:44:55,752 [salt.state       :1813][INFO    ][19481] Executing state pkg.installed for [galera-3]
2019-02-27 09:44:56,351 [salt.loaded.int.module.cmdmod:395 ][INFO    ][19481] Executing command ['apt-cache', '-q', 'policy', 'galera-3'] in directory '/root'
2019-02-27 09:44:56,400 [salt.loaded.int.module.cmdmod:395 ][INFO    ][19481] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2019-02-27 09:44:58,150 [salt.loaded.int.module.cmdmod:395 ][INFO    ][19481] Executing command ['dpkg', '--get-selections', '*'] in directory '/root'
2019-02-27 09:44:58,173 [salt.loaded.int.module.cmdmod:395 ][INFO    ][19481] 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'
2019-02-27 09:44:59,643 [salt.loaded.int.module.cmdmod:395 ][INFO    ][19481] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}', '-W'] in directory '/root'
2019-02-27 09:44:59,675 [salt.state       :300 ][INFO    ][19481] 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'

2019-02-27 09:44:59,691 [salt.state       :915 ][INFO    ][19481] Loading fresh modules for state activity
2019-02-27 09:44:59,723 [salt.state       :1951][INFO    ][19481] Completed state [galera-3] at time 09:44:59.723845 duration_in_ms=3971.775
2019-02-27 09:44:59,731 [salt.state       :1780][INFO    ][19481] Running state [rsync] at time 09:44:59.731129
2019-02-27 09:44:59,731 [salt.state       :1813][INFO    ][19481] Executing state pkg.installed for [rsync]
2019-02-27 09:45:00,317 [salt.state       :300 ][INFO    ][19481] All specified packages are already installed
2019-02-27 09:45:00,318 [salt.state       :1951][INFO    ][19481] Completed state [rsync] at time 09:45:00.318285 duration_in_ms=587.156
2019-02-27 09:45:00,319 [salt.state       :1780][INFO    ][19481] Running state [psmisc] at time 09:45:00.319610
2019-02-27 09:45:00,320 [salt.state       :1813][INFO    ][19481] Executing state pkg.installed for [psmisc]
2019-02-27 09:45:00,328 [salt.state       :300 ][INFO    ][19481] All specified packages are already installed
2019-02-27 09:45:00,328 [salt.state       :1951][INFO    ][19481] Completed state [psmisc] at time 09:45:00.328565 duration_in_ms=8.955
2019-02-27 09:45:00,329 [salt.state       :1780][INFO    ][19481] Running state [netcat] at time 09:45:00.329377
2019-02-27 09:45:00,329 [salt.state       :1813][INFO    ][19481] Executing state pkg.installed for [netcat]
2019-02-27 09:45:00,337 [salt.state       :300 ][INFO    ][19481] All specified packages are already installed
2019-02-27 09:45:00,337 [salt.state       :1951][INFO    ][19481] Completed state [netcat] at time 09:45:00.337436 duration_in_ms=8.059
2019-02-27 09:45:00,338 [salt.state       :1780][INFO    ][19481] Running state [socat] at time 09:45:00.338227
2019-02-27 09:45:00,338 [salt.state       :1813][INFO    ][19481] Executing state pkg.installed for [socat]
2019-02-27 09:45:00,347 [salt.state       :300 ][INFO    ][19481] All specified packages are already installed
2019-02-27 09:45:00,348 [salt.state       :1951][INFO    ][19481] Completed state [socat] at time 09:45:00.348192 duration_in_ms=9.965
2019-02-27 09:45:00,349 [salt.state       :1780][INFO    ][19481] Running state [python-pymysql] at time 09:45:00.349035
2019-02-27 09:45:00,349 [salt.state       :1813][INFO    ][19481] Executing state pkg.installed for [python-pymysql]
2019-02-27 09:45:00,356 [salt.state       :300 ][INFO    ][19481] All specified packages are already installed
2019-02-27 09:45:00,356 [salt.state       :1951][INFO    ][19481] Completed state [python-pymysql] at time 09:45:00.356888 duration_in_ms=7.852
2019-02-27 09:45:00,359 [salt.state       :1780][INFO    ][19481] Running state [/var/log/mysql] at time 09:45:00.359272
2019-02-27 09:45:00,359 [salt.state       :1813][INFO    ][19481] Executing state file.directory for [/var/log/mysql]
2019-02-27 09:45:00,360 [salt.state       :300 ][INFO    ][19481] {'mode': '0755'}
2019-02-27 09:45:00,361 [salt.state       :1951][INFO    ][19481] Completed state [/var/log/mysql] at time 09:45:00.361135 duration_in_ms=1.863
2019-02-27 09:45:00,362 [salt.state       :1780][INFO    ][19481] Running state [/etc/mysql] at time 09:45:00.362112
2019-02-27 09:45:00,362 [salt.state       :1813][INFO    ][19481] Executing state file.directory for [/etc/mysql]
2019-02-27 09:45:00,363 [salt.state       :300 ][INFO    ][19481] Directory /etc/mysql is in the correct state
Directory /etc/mysql updated
2019-02-27 09:45:00,363 [salt.state       :1951][INFO    ][19481] Completed state [/etc/mysql] at time 09:45:00.363737 duration_in_ms=1.625
2019-02-27 09:45:00,364 [salt.state       :1780][INFO    ][19481] Running state [/var/run/mysqld] at time 09:45:00.364793
2019-02-27 09:45:00,365 [salt.state       :1813][INFO    ][19481] Executing state file.directory for [/var/run/mysqld]
2019-02-27 09:45:00,366 [salt.state       :300 ][INFO    ][19481] Directory /var/run/mysqld is in the correct state
Directory /var/run/mysqld updated
2019-02-27 09:45:00,366 [salt.state       :1951][INFO    ][19481] Completed state [/var/run/mysqld] at time 09:45:00.366717 duration_in_ms=1.925
2019-02-27 09:45:00,367 [salt.state       :1780][INFO    ][19481] Running state [/etc/systemd/system/mysql.service.d] at time 09:45:00.367714
2019-02-27 09:45:00,368 [salt.state       :1813][INFO    ][19481] Executing state file.directory for [/etc/systemd/system/mysql.service.d]
2019-02-27 09:45:00,369 [salt.state       :300 ][INFO    ][19481] {'/etc/systemd/system/mysql.service.d': 'New Dir'}
2019-02-27 09:45:00,369 [salt.state       :1951][INFO    ][19481] Completed state [/etc/systemd/system/mysql.service.d] at time 09:45:00.369810 duration_in_ms=2.096
2019-02-27 09:45:00,371 [salt.state       :1780][INFO    ][19481] Running state [/etc/systemd/system/mysql.service.d/override.conf] at time 09:45:00.371500
2019-02-27 09:45:00,371 [salt.state       :1813][INFO    ][19481] Executing state file.managed for [/etc/systemd/system/mysql.service.d/override.conf]
2019-02-27 09:45:00,373 [salt.state       :300 ][INFO    ][19481] File changed:
New file
2019-02-27 09:45:00,373 [salt.state       :1951][INFO    ][19481] Completed state [/etc/systemd/system/mysql.service.d/override.conf] at time 09:45:00.373624 duration_in_ms=2.124
2019-02-27 09:45:00,375 [salt.state       :1780][INFO    ][19481] Running state [service.systemctl_reload] at time 09:45:00.375481
2019-02-27 09:45:00,375 [salt.state       :1813][INFO    ][19481] Executing state module.wait for [service.systemctl_reload]
2019-02-27 09:45:00,375 [salt.state       :300 ][INFO    ][19481] No changes made for service.systemctl_reload
2019-02-27 09:45:00,376 [salt.state       :1951][INFO    ][19481] Completed state [service.systemctl_reload] at time 09:45:00.376099 duration_in_ms=0.618
2019-02-27 09:45:00,376 [salt.state       :1780][INFO    ][19481] Running state [service.systemctl_reload] at time 09:45:00.376275
2019-02-27 09:45:00,376 [salt.state       :1813][INFO    ][19481] Executing state module.mod_watch for [service.systemctl_reload]
2019-02-27 09:45:00,376 [salt.utils.decorators:613 ][WARNING ][19481] The function "module.run" is using its deprecated version and will expire in version "Sodium".
2019-02-27 09:45:00,377 [salt.loaded.int.module.cmdmod:395 ][INFO    ][19481] Executing command ['systemctl', '--system', 'daemon-reload'] in directory '/root'
2019-02-27 09:45:00,464 [salt.state       :300 ][INFO    ][19481] {'ret': True}
2019-02-27 09:45:00,465 [salt.state       :1951][INFO    ][19481] Completed state [service.systemctl_reload] at time 09:45:00.465180 duration_in_ms=88.903
2019-02-27 09:45:00,466 [salt.state       :1780][INFO    ][19481] Running state [/etc/mysql/debian.cnf] at time 09:45:00.466763
2019-02-27 09:45:00,467 [salt.state       :1813][INFO    ][19481] Executing state file.managed for [/etc/mysql/debian.cnf]
2019-02-27 09:45:00,492 [salt.fileclient  :1219][INFO    ][19481] Fetching file from saltenv 'base', ** done ** 'galera/files/debian.cnf'
2019-02-27 09:45:00,543 [salt.state       :300 ][INFO    ][19481] File changed:
--- 
+++ 
@@ -1,12 +1,13 @@
-# Automatically generated for Debian scripts. DO NOT TOUCH!
+
 [client]
-host     = localhost
-user     = debian-sys-maint
-password = 6KTkUlUV2kWXyNZB
-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 = 6KTkUlUV2kWXyNZB
-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

2019-02-27 09:45:00,547 [salt.state       :1951][INFO    ][19481] Completed state [/etc/mysql/debian.cnf] at time 09:45:00.547705 duration_in_ms=80.941
2019-02-27 09:45:00,548 [salt.state       :1780][INFO    ][19481] Running state [/usr/local/sbin/galera_init.sh] at time 09:45:00.548110
2019-02-27 09:45:00,548 [salt.state       :1813][INFO    ][19481] Executing state file.managed for [/usr/local/sbin/galera_init.sh]
2019-02-27 09:45:00,571 [salt.fileclient  :1219][INFO    ][19481] Fetching file from saltenv 'base', ** done ** 'galera/files/init_bootstrap.sh'
2019-02-27 09:45:00,579 [salt.state       :300 ][INFO    ][19481] File changed:
New file
2019-02-27 09:45:00,580 [salt.state       :1951][INFO    ][19481] Completed state [/usr/local/sbin/galera_init.sh] at time 09:45:00.580041 duration_in_ms=31.93
2019-02-27 09:45:00,580 [salt.state       :1780][INFO    ][19481] Running state [/usr/local/sbin/galera_bootstrap.sh] at time 09:45:00.580453
2019-02-27 09:45:00,580 [salt.state       :1813][INFO    ][19481] Executing state file.managed for [/usr/local/sbin/galera_bootstrap.sh]
2019-02-27 09:45:00,603 [salt.fileclient  :1219][INFO    ][19481] Fetching file from saltenv 'base', ** done ** 'galera/files/bootstrap.sh'
2019-02-27 09:45:00,611 [salt.state       :300 ][INFO    ][19481] File changed:
New file
2019-02-27 09:45:00,612 [salt.state       :1951][INFO    ][19481] Completed state [/usr/local/sbin/galera_bootstrap.sh] at time 09:45:00.612473 duration_in_ms=32.019
2019-02-27 09:45:00,616 [salt.state       :1780][INFO    ][19481] Running state [/usr/local/sbin/galera_init.sh] at time 09:45:00.616317
2019-02-27 09:45:00,616 [salt.state       :1813][INFO    ][19481] Executing state cmd.run for [/usr/local/sbin/galera_init.sh]
2019-02-27 09:45:00,617 [salt.loaded.int.module.cmdmod:395 ][INFO    ][19481] Executing command '/usr/local/sbin/galera_init.sh' in directory '/root'
2019-02-27 09:45:04,302 [salt.state       :300 ][INFO    ][19481] {'pid': 22780, 'retcode': 0, 'stderr': '', 'stdout': 'Sucessfully connected to the MySQL service (0 retries).'}
2019-02-27 09:45:04,302 [salt.state       :1951][INFO    ][19481] Completed state [/usr/local/sbin/galera_init.sh] at time 09:45:04.302618 duration_in_ms=3686.3
2019-02-27 09:45:04,304 [salt.state       :1780][INFO    ][19481] Running state [mysqladmin password "opnfv_secret"] at time 09:45:04.304522
2019-02-27 09:45:04,304 [salt.state       :1813][INFO    ][19481] Executing state cmd.run for [mysqladmin password "opnfv_secret"]
2019-02-27 09:45:04,305 [salt.loaded.int.module.cmdmod:395 ][INFO    ][19481] Executing command 'mysqladmin password "opnfv_secret"' in directory '/root'
2019-02-27 09:45:04,321 [salt.state       :300 ][INFO    ][19481] {'pid': 23255, 'retcode': 0, 'stderr': 'Warning: Using a password on the command line interface can be insecure.', 'stdout': ''}
2019-02-27 09:45:04,321 [salt.state       :1951][INFO    ][19481] Completed state [mysqladmin password "opnfv_secret"] at time 09:45:04.321773 duration_in_ms=17.25
2019-02-27 09:45:04,323 [salt.state       :1780][INFO    ][19481] Running state [mysql -u root -popnfv_secret -e "GRANT ALL PRIVILEGES ON *.* TO 'debian-sys-maint'@'localhost' IDENTIFIED BY 'opnfv_secret';"] at time 09:45:04.323260
2019-02-27 09:45:04,323 [salt.state       :1813][INFO    ][19481] Executing state cmd.run for [mysql -u root -popnfv_secret -e "GRANT ALL PRIVILEGES ON *.* TO 'debian-sys-maint'@'localhost' IDENTIFIED BY 'opnfv_secret';"]
2019-02-27 09:45:04,324 [salt.loaded.int.module.cmdmod:395 ][INFO    ][19481] Executing command 'mysql -u root -popnfv_secret -e "GRANT ALL PRIVILEGES ON *.* TO 'debian-sys-maint'@'localhost' IDENTIFIED BY 'opnfv_secret';"' in directory '/root'
2019-02-27 09:45:04,338 [salt.state       :300 ][INFO    ][19481] {'pid': 23257, 'retcode': 0, 'stderr': 'Warning: Using a password on the command line interface can be insecure.', 'stdout': ''}
2019-02-27 09:45:04,338 [salt.state       :1951][INFO    ][19481] Completed state [mysql -u root -popnfv_secret -e "GRANT ALL PRIVILEGES ON *.* TO 'debian-sys-maint'@'localhost' IDENTIFIED BY 'opnfv_secret';"] at time 09:45:04.338906 duration_in_ms=15.644
2019-02-27 09:45:04,342 [salt.state       :1780][INFO    ][19481] Running state [mysql] at time 09:45:04.342776
2019-02-27 09:45:04,343 [salt.state       :1813][INFO    ][19481] Executing state service.dead for [mysql]
2019-02-27 09:45:04,343 [salt.loaded.int.module.cmdmod:395 ][INFO    ][19481] Executing command ['systemctl', 'status', 'mysql.service', '-n', '0'] in directory '/root'
2019-02-27 09:45:04,357 [salt.loaded.int.module.cmdmod:395 ][INFO    ][19481] Executing command ['systemctl', 'is-active', 'mysql.service'] in directory '/root'
2019-02-27 09:45:04,369 [salt.loaded.int.module.cmdmod:395 ][INFO    ][19481] Executing command ['systemctl', 'is-enabled', 'mysql.service'] in directory '/root'
2019-02-27 09:45:04,385 [salt.loaded.int.module.cmdmod:395 ][INFO    ][19481] Executing command ['systemd-run', '--scope', 'systemctl', 'stop', 'mysql.service'] in directory '/root'
2019-02-27 09:45:05,672 [salt.loaded.int.module.cmdmod:395 ][INFO    ][19481] Executing command ['systemctl', 'is-active', 'mysql.service'] in directory '/root'
2019-02-27 09:45:05,685 [salt.loaded.int.module.cmdmod:395 ][INFO    ][19481] Executing command ['systemctl', 'is-enabled', 'mysql.service'] in directory '/root'
2019-02-27 09:45:05,701 [salt.state       :300 ][INFO    ][19481] {'mysql': False}
2019-02-27 09:45:05,701 [salt.state       :1951][INFO    ][19481] Completed state [mysql] at time 09:45:05.701885 duration_in_ms=1359.105
2019-02-27 09:45:05,703 [salt.state       :1780][INFO    ][19481] Running state [/etc/mysql/my.cnf] at time 09:45:05.703529
2019-02-27 09:45:05,703 [salt.state       :1813][INFO    ][19481] Executing state file.managed for [/etc/mysql/my.cnf]
2019-02-27 09:45:05,727 [salt.fileclient  :1219][INFO    ][19481] Fetching file from saltenv 'base', ** done ** 'galera/files/my.cnf.init'
2019-02-27 09:45:05,785 [salt.state       :300 ][INFO    ][19481] File changed:
--- 
+++ 
@@ -1,36 +1,62 @@
-[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.24
+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_size		= 16M
-max_allowed_packet	= 16M
-thread_stack		= 192K
-thread_cache_size       = 8
-myisam-recover-options  = BACKUP
-query_cache_limit	= 1M
-query_cache_size        = 16M
+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
 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/
+
+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.24
+wsrep_provider_options="gcache.size = 256M"
+wsrep_provider_options="gmcast.listen_addr = tcp://192.168.10.24:4567"
+
+
+
+[xtrabackup]
+parallel=4
+
+[sst]
+streamfmt=xbstream
+transferfmt=socat
+sockopt=,nodelay,sndbuf=1048576,rcvbuf=1048576

2019-02-27 09:45:05,786 [salt.state       :1951][INFO    ][19481] Completed state [/etc/mysql/my.cnf] at time 09:45:05.786079 duration_in_ms=82.549
2019-02-27 09:45:05,787 [salt.state       :1780][INFO    ][19481] Running state [/usr/local/sbin/galera_bootstrap.sh] at time 09:45:05.787740
2019-02-27 09:45:05,787 [salt.state       :1813][INFO    ][19481] Executing state cmd.run for [/usr/local/sbin/galera_bootstrap.sh]
2019-02-27 09:45:05,788 [salt.loaded.int.module.cmdmod:395 ][INFO    ][19481] Executing command '/usr/local/sbin/galera_bootstrap.sh' in directory '/root'
2019-02-27 09:45:12,813 [salt.state       :300 ][INFO    ][19481] {'pid': 23291, 'retcode': 0, 'stderr': 'Warning: Using a password on the command line interface can be insecure.', 'stdout': 'Sucessfully connected to the MySQL service (0 retries).'}
2019-02-27 09:45:12,813 [salt.state       :1951][INFO    ][19481] Completed state [/usr/local/sbin/galera_bootstrap.sh] at time 09:45:12.813357 duration_in_ms=7025.616
2019-02-27 09:45:12,815 [salt.state       :1780][INFO    ][19481] Running state [/etc/salt/.galera_bootstrap] at time 09:45:12.815126
2019-02-27 09:45:12,815 [salt.state       :1813][INFO    ][19481] Executing state file.touch for [/etc/salt/.galera_bootstrap]
2019-02-27 09:45:12,816 [salt.state       :300 ][INFO    ][19481] {'new': '/etc/salt/.galera_bootstrap'}
2019-02-27 09:45:12,816 [salt.state       :1951][INFO    ][19481] Completed state [/etc/salt/.galera_bootstrap] at time 09:45:12.816279 duration_in_ms=1.152
2019-02-27 09:45:12,958 [salt.loaded.int.module.cmdmod:395 ][INFO    ][19481] Executing command ['git', '--version'] in directory '/root'
2019-02-27 09:45:13,195 [salt.state       :1780][INFO    ][19481] Running state [/etc/mysql/my.cnf] at time 09:45:13.195514
2019-02-27 09:45:13,195 [salt.state       :1813][INFO    ][19481] Executing state file.managed for [/etc/mysql/my.cnf]
2019-02-27 09:45:13,218 [salt.fileclient  :1219][INFO    ][19481] Fetching file from saltenv 'base', ** done ** 'galera/files/my.cnf'
2019-02-27 09:45:13,285 [salt.state       :300 ][INFO    ][19481] File changed:
--- 
+++ 
@@ -1,8 +1,14 @@
+
+
 # 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.24
@@ -14,8 +20,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
@@ -25,7 +33,6 @@
 max_allowed_packet=256M
 query_cache_size=0
 query_cache_type=0
-log_error = /var/log/mysql/error.log
 
 innodb_file_format=Barracuda
 innodb_file_per_table=1
@@ -39,8 +46,8 @@
 innodb_doublewrite=0
 innodb_autoinc_lock_mode=2
 innodb_locks_unsafe_for_binlog=1
-
-wsrep_cluster_address="gcomm://"
+wsrep_on=ON
+wsrep_cluster_address="gcomm://192.168.10.24:4567,192.168.10.25:4567,192.168.10.26:4567/?pc.wait_prim=no"
 wsrep_provider=/usr/lib/galera/libgalera_smm.so
 wsrep_cluster_name="openstack"
 

2019-02-27 09:45:13,286 [salt.state       :1951][INFO    ][19481] Completed state [/etc/mysql/my.cnf] at time 09:45:13.285959 duration_in_ms=90.445
2019-02-27 09:45:13,287 [salt.state       :1780][INFO    ][19481] Running state [mysql] at time 09:45:13.287778
2019-02-27 09:45:13,288 [salt.state       :1813][INFO    ][19481] Executing state service.running for [mysql]
2019-02-27 09:45:13,288 [salt.loaded.int.module.cmdmod:395 ][INFO    ][19481] Executing command ['systemctl', 'is-active', 'mysql.service'] in directory '/root'
2019-02-27 09:45:13,301 [salt.loaded.int.module.cmdmod:395 ][INFO    ][19481] Executing command ['systemctl', 'is-enabled', 'mysql.service'] in directory '/root'
2019-02-27 09:45:13,317 [salt.loaded.int.module.cmdmod:395 ][INFO    ][19481] Executing command ['systemctl', 'is-enabled', 'mysql.service'] in directory '/root'
2019-02-27 09:45:13,338 [salt.loaded.int.module.cmdmod:395 ][INFO    ][19481] Executing command ['systemd-run', '--scope', 'systemctl', 'enable', 'mysql.service'] in directory '/root'
2019-02-27 09:45:13,649 [salt.loaded.int.module.cmdmod:395 ][INFO    ][19481] Executing command ['systemctl', 'is-enabled', 'mysql.service'] in directory '/root'
2019-02-27 09:45:13,662 [salt.state       :300 ][INFO    ][19481] {'mysql': True}
2019-02-27 09:45:13,662 [salt.state       :1951][INFO    ][19481] Completed state [mysql] at time 09:45:13.662552 duration_in_ms=374.771
2019-02-27 09:45:13,662 [salt.state       :1780][INFO    ][19481] Running state [panko] at time 09:45:13.662921
2019-02-27 09:45:13,663 [salt.state       :1813][INFO    ][19481] Executing state mysql_database.present for [panko]
2019-02-27 09:45:13,669 [salt.loaded.int.module.mysql:1101][INFO    ][19481] DB 'panko' created
2019-02-27 09:45:13,669 [salt.state       :300 ][INFO    ][19481] {'panko': 'Present'}
2019-02-27 09:45:13,669 [salt.state       :1951][INFO    ][19481] Completed state [panko] at time 09:45:13.669522 duration_in_ms=6.6
2019-02-27 09:45:13,669 [salt.state       :1780][INFO    ][19481] Running state [panko] at time 09:45:13.669745
2019-02-27 09:45:13,669 [salt.state       :1813][INFO    ][19481] Executing state mysql_user.present for [panko]
2019-02-27 09:45:13,683 [salt.loaded.int.module.mysql:1383][INFO    ][19481] User 'panko'@'%' has been created
2019-02-27 09:45:13,683 [salt.state       :300 ][INFO    ][19481] {'panko': 'Present'}
2019-02-27 09:45:13,683 [salt.state       :1951][INFO    ][19481] Completed state [panko] at time 09:45:13.683473 duration_in_ms=13.728
2019-02-27 09:45:13,685 [salt.state       :1780][INFO    ][19481] Running state [mysql_grants_panko_panko_%] at time 09:45:13.685610
2019-02-27 09:45:13,685 [salt.state       :1813][INFO    ][19481] Executing state mysql_grants.present for [mysql_grants_panko_panko_%]
2019-02-27 09:45:13,697 [salt.loaded.int.module.mysql:1870][INFO    ][19481] Grant 'all' on 'panko.*' for user 'panko' has been added
2019-02-27 09:45:13,697 [salt.state       :300 ][INFO    ][19481] {'mysql_grants_panko_panko_%': 'Present'}
2019-02-27 09:45:13,697 [salt.state       :1951][INFO    ][19481] Completed state [mysql_grants_panko_panko_%] at time 09:45:13.697568 duration_in_ms=11.958
2019-02-27 09:45:13,697 [salt.state       :1780][INFO    ][19481] Running state [panko] at time 09:45:13.697784
2019-02-27 09:45:13,697 [salt.state       :1813][INFO    ][19481] Executing state mysql_user.present for [panko]
2019-02-27 09:45:13,710 [salt.loaded.int.module.mysql:1383][INFO    ][19481] User 'panko'@'192.168.10.24' has been created
2019-02-27 09:45:13,710 [salt.state       :300 ][INFO    ][19481] {'panko': 'Present'}
2019-02-27 09:45:13,710 [salt.state       :1951][INFO    ][19481] Completed state [panko] at time 09:45:13.710702 duration_in_ms=12.918
2019-02-27 09:45:13,712 [salt.state       :1780][INFO    ][19481] Running state [mysql_grants_panko_panko_192.168.10.24] at time 09:45:13.712330
2019-02-27 09:45:13,712 [salt.state       :1813][INFO    ][19481] Executing state mysql_grants.present for [mysql_grants_panko_panko_192.168.10.24]
2019-02-27 09:45:13,723 [salt.loaded.int.module.mysql:1870][INFO    ][19481] Grant 'all' on 'panko.*' for user 'panko' has been added
2019-02-27 09:45:13,723 [salt.state       :300 ][INFO    ][19481] {'mysql_grants_panko_panko_192.168.10.24': 'Present'}
2019-02-27 09:45:13,723 [salt.state       :1951][INFO    ][19481] Completed state [mysql_grants_panko_panko_192.168.10.24] at time 09:45:13.723730 duration_in_ms=11.4
2019-02-27 09:45:13,723 [salt.state       :1780][INFO    ][19481] Running state [ceilometer] at time 09:45:13.723930
2019-02-27 09:45:13,724 [salt.state       :1813][INFO    ][19481] Executing state mysql_database.present for [ceilometer]
2019-02-27 09:45:13,727 [salt.loaded.int.module.mysql:1101][INFO    ][19481] DB 'ceilometer' created
2019-02-27 09:45:13,728 [salt.state       :300 ][INFO    ][19481] {'ceilometer': 'Present'}
2019-02-27 09:45:13,728 [salt.state       :1951][INFO    ][19481] Completed state [ceilometer] at time 09:45:13.728363 duration_in_ms=4.433
2019-02-27 09:45:13,728 [salt.state       :1780][INFO    ][19481] Running state [ceilometer] at time 09:45:13.728572
2019-02-27 09:45:13,728 [salt.state       :1813][INFO    ][19481] Executing state mysql_user.present for [ceilometer]
2019-02-27 09:45:13,741 [salt.loaded.int.module.mysql:1383][INFO    ][19481] User 'ceilometer'@'%' has been created
2019-02-27 09:45:13,741 [salt.state       :300 ][INFO    ][19481] {'ceilometer': 'Present'}
2019-02-27 09:45:13,741 [salt.state       :1951][INFO    ][19481] Completed state [ceilometer] at time 09:45:13.741921 duration_in_ms=13.349
2019-02-27 09:45:13,743 [salt.state       :1780][INFO    ][19481] Running state [mysql_grants_ceilometer_ceilometer_%] at time 09:45:13.743602
2019-02-27 09:45:13,743 [salt.state       :1813][INFO    ][19481] Executing state mysql_grants.present for [mysql_grants_ceilometer_ceilometer_%]
2019-02-27 09:45:13,754 [salt.loaded.int.module.mysql:1870][INFO    ][19481] Grant 'all' on 'ceilometer.*' for user 'ceilometer' has been added
2019-02-27 09:45:13,754 [salt.state       :300 ][INFO    ][19481] {'mysql_grants_ceilometer_ceilometer_%': 'Present'}
2019-02-27 09:45:13,755 [salt.state       :1951][INFO    ][19481] Completed state [mysql_grants_ceilometer_ceilometer_%] at time 09:45:13.755138 duration_in_ms=11.536
2019-02-27 09:45:13,755 [salt.state       :1780][INFO    ][19481] Running state [ceilometer] at time 09:45:13.755353
2019-02-27 09:45:13,755 [salt.state       :1813][INFO    ][19481] Executing state mysql_user.present for [ceilometer]
2019-02-27 09:45:13,768 [salt.loaded.int.module.mysql:1383][INFO    ][19481] User 'ceilometer'@'192.168.10.24' has been created
2019-02-27 09:45:13,768 [salt.state       :300 ][INFO    ][19481] {'ceilometer': 'Present'}
2019-02-27 09:45:13,768 [salt.state       :1951][INFO    ][19481] Completed state [ceilometer] at time 09:45:13.768858 duration_in_ms=13.505
2019-02-27 09:45:13,770 [salt.state       :1780][INFO    ][19481] Running state [mysql_grants_ceilometer_ceilometer_192.168.10.24] at time 09:45:13.770774
2019-02-27 09:45:13,771 [salt.state       :1813][INFO    ][19481] Executing state mysql_grants.present for [mysql_grants_ceilometer_ceilometer_192.168.10.24]
2019-02-27 09:45:13,781 [salt.loaded.int.module.mysql:1870][INFO    ][19481] Grant 'all' on 'ceilometer.*' for user 'ceilometer' has been added
2019-02-27 09:45:13,782 [salt.state       :300 ][INFO    ][19481] {'mysql_grants_ceilometer_ceilometer_192.168.10.24': 'Present'}
2019-02-27 09:45:13,782 [salt.state       :1951][INFO    ][19481] Completed state [mysql_grants_ceilometer_ceilometer_192.168.10.24] at time 09:45:13.782233 duration_in_ms=11.459
2019-02-27 09:45:13,782 [salt.state       :1780][INFO    ][19481] Running state [aodh] at time 09:45:13.782437
2019-02-27 09:45:13,782 [salt.state       :1813][INFO    ][19481] Executing state mysql_database.present for [aodh]
2019-02-27 09:45:13,786 [salt.loaded.int.module.mysql:1101][INFO    ][19481] DB 'aodh' created
2019-02-27 09:45:13,786 [salt.state       :300 ][INFO    ][19481] {'aodh': 'Present'}
2019-02-27 09:45:13,786 [salt.state       :1951][INFO    ][19481] Completed state [aodh] at time 09:45:13.786796 duration_in_ms=4.358
2019-02-27 09:45:13,787 [salt.state       :1780][INFO    ][19481] Running state [aodh] at time 09:45:13.786997
2019-02-27 09:45:13,787 [salt.state       :1813][INFO    ][19481] Executing state mysql_user.present for [aodh]
2019-02-27 09:45:13,799 [salt.loaded.int.module.mysql:1383][INFO    ][19481] User 'aodh'@'%' has been created
2019-02-27 09:45:13,799 [salt.state       :300 ][INFO    ][19481] {'aodh': 'Present'}
2019-02-27 09:45:13,800 [salt.state       :1951][INFO    ][19481] Completed state [aodh] at time 09:45:13.799968 duration_in_ms=12.971
2019-02-27 09:45:13,801 [salt.state       :1780][INFO    ][19481] Running state [mysql_grants_aodh_aodh_%] at time 09:45:13.801699
2019-02-27 09:45:13,801 [salt.state       :1813][INFO    ][19481] Executing state mysql_grants.present for [mysql_grants_aodh_aodh_%]
2019-02-27 09:45:13,812 [salt.loaded.int.module.mysql:1870][INFO    ][19481] Grant 'all' on 'aodh.*' for user 'aodh' has been added
2019-02-27 09:45:13,812 [salt.state       :300 ][INFO    ][19481] {'mysql_grants_aodh_aodh_%': 'Present'}
2019-02-27 09:45:13,813 [salt.state       :1951][INFO    ][19481] Completed state [mysql_grants_aodh_aodh_%] at time 09:45:13.813016 duration_in_ms=11.317
2019-02-27 09:45:13,813 [salt.state       :1780][INFO    ][19481] Running state [aodh] at time 09:45:13.813210
2019-02-27 09:45:13,813 [salt.state       :1813][INFO    ][19481] Executing state mysql_user.present for [aodh]
2019-02-27 09:45:13,826 [salt.loaded.int.module.mysql:1383][INFO    ][19481] User 'aodh'@'192.168.10.23' has been created
2019-02-27 09:45:13,826 [salt.state       :300 ][INFO    ][19481] {'aodh': 'Present'}
2019-02-27 09:45:13,826 [salt.state       :1951][INFO    ][19481] Completed state [aodh] at time 09:45:13.826505 duration_in_ms=13.295
2019-02-27 09:45:13,828 [salt.state       :1780][INFO    ][19481] Running state [mysql_grants_aodh_aodh_192.168.10.23] at time 09:45:13.828133
2019-02-27 09:45:13,828 [salt.state       :1813][INFO    ][19481] Executing state mysql_grants.present for [mysql_grants_aodh_aodh_192.168.10.23]
2019-02-27 09:45:13,839 [salt.loaded.int.module.mysql:1870][INFO    ][19481] Grant 'all' on 'aodh.*' for user 'aodh' has been added
2019-02-27 09:45:13,839 [salt.state       :300 ][INFO    ][19481] {'mysql_grants_aodh_aodh_192.168.10.23': 'Present'}
2019-02-27 09:45:13,839 [salt.state       :1951][INFO    ][19481] Completed state [mysql_grants_aodh_aodh_192.168.10.23] at time 09:45:13.839420 duration_in_ms=11.287
2019-02-27 09:45:13,839 [salt.state       :1780][INFO    ][19481] Running state [nova] at time 09:45:13.839637
2019-02-27 09:45:13,839 [salt.state       :1813][INFO    ][19481] Executing state mysql_database.present for [nova]
2019-02-27 09:45:13,843 [salt.loaded.int.module.mysql:1101][INFO    ][19481] DB 'nova' created
2019-02-27 09:45:13,843 [salt.state       :300 ][INFO    ][19481] {'nova': 'Present'}
2019-02-27 09:45:13,844 [salt.state       :1951][INFO    ][19481] Completed state [nova] at time 09:45:13.844129 duration_in_ms=4.492
2019-02-27 09:45:13,844 [salt.state       :1780][INFO    ][19481] Running state [nova] at time 09:45:13.844349
2019-02-27 09:45:13,844 [salt.state       :1813][INFO    ][19481] Executing state mysql_user.present for [nova]
2019-02-27 09:45:13,857 [salt.loaded.int.module.mysql:1383][INFO    ][19481] User 'nova'@'%' has been created
2019-02-27 09:45:13,857 [salt.state       :300 ][INFO    ][19481] {'nova': 'Present'}
2019-02-27 09:45:13,857 [salt.state       :1951][INFO    ][19481] Completed state [nova] at time 09:45:13.857510 duration_in_ms=13.16
2019-02-27 09:45:13,859 [salt.state       :1780][INFO    ][19481] Running state [mysql_grants_nova_nova_%] at time 09:45:13.859182
2019-02-27 09:45:13,859 [salt.state       :1813][INFO    ][19481] Executing state mysql_grants.present for [mysql_grants_nova_nova_%]
2019-02-27 09:45:13,869 [salt.loaded.int.module.mysql:1870][INFO    ][19481] Grant 'all' on 'nova.*' for user 'nova' has been added
2019-02-27 09:45:13,870 [salt.state       :300 ][INFO    ][19481] {'mysql_grants_nova_nova_%': 'Present'}
2019-02-27 09:45:13,870 [salt.state       :1951][INFO    ][19481] Completed state [mysql_grants_nova_nova_%] at time 09:45:13.870317 duration_in_ms=11.135
2019-02-27 09:45:13,870 [salt.state       :1780][INFO    ][19481] Running state [nova] at time 09:45:13.870522
2019-02-27 09:45:13,870 [salt.state       :1813][INFO    ][19481] Executing state mysql_user.present for [nova]
2019-02-27 09:45:13,883 [salt.loaded.int.module.mysql:1383][INFO    ][19481] User 'nova'@'192.168.10.24' has been created
2019-02-27 09:45:13,883 [salt.state       :300 ][INFO    ][19481] {'nova': 'Present'}
2019-02-27 09:45:13,883 [salt.state       :1951][INFO    ][19481] Completed state [nova] at time 09:45:13.883519 duration_in_ms=12.996
2019-02-27 09:45:13,885 [salt.state       :1780][INFO    ][19481] Running state [mysql_grants_nova_nova_192.168.10.24] at time 09:45:13.885135
2019-02-27 09:45:13,885 [salt.state       :1813][INFO    ][19481] Executing state mysql_grants.present for [mysql_grants_nova_nova_192.168.10.24]
2019-02-27 09:45:13,895 [salt.loaded.int.module.mysql:1870][INFO    ][19481] Grant 'all' on 'nova.*' for user 'nova' has been added
2019-02-27 09:45:13,896 [salt.state       :300 ][INFO    ][19481] {'mysql_grants_nova_nova_192.168.10.24': 'Present'}
2019-02-27 09:45:13,896 [salt.state       :1951][INFO    ][19481] Completed state [mysql_grants_nova_nova_192.168.10.24] at time 09:45:13.896200 duration_in_ms=11.065
2019-02-27 09:45:13,896 [salt.state       :1780][INFO    ][19481] Running state [grafana] at time 09:45:13.896419
2019-02-27 09:45:13,896 [salt.state       :1813][INFO    ][19481] Executing state mysql_database.present for [grafana]
2019-02-27 09:45:13,900 [salt.loaded.int.module.mysql:1101][INFO    ][19481] DB 'grafana' created
2019-02-27 09:45:13,900 [salt.state       :300 ][INFO    ][19481] {'grafana': 'Present'}
2019-02-27 09:45:13,901 [salt.state       :1951][INFO    ][19481] Completed state [grafana] at time 09:45:13.900962 duration_in_ms=4.543
2019-02-27 09:45:13,901 [salt.state       :1780][INFO    ][19481] Running state [grafana] at time 09:45:13.901181
2019-02-27 09:45:13,901 [salt.state       :1813][INFO    ][19481] Executing state mysql_user.present for [grafana]
2019-02-27 09:45:13,914 [salt.loaded.int.module.mysql:1383][INFO    ][19481] User 'grafana'@'%' has been created
2019-02-27 09:45:13,914 [salt.state       :300 ][INFO    ][19481] {'grafana': 'Present'}
2019-02-27 09:45:13,914 [salt.state       :1951][INFO    ][19481] Completed state [grafana] at time 09:45:13.914408 duration_in_ms=13.227
2019-02-27 09:45:13,916 [salt.state       :1780][INFO    ][19481] Running state [mysql_grants_grafana_grafana_%] at time 09:45:13.916183
2019-02-27 09:45:13,916 [salt.state       :1813][INFO    ][19481] Executing state mysql_grants.present for [mysql_grants_grafana_grafana_%]
2019-02-27 09:45:13,927 [salt.loaded.int.module.mysql:1870][INFO    ][19481] Grant 'all' on 'grafana.*' for user 'grafana' has been added
2019-02-27 09:45:13,927 [salt.state       :300 ][INFO    ][19481] {'mysql_grants_grafana_grafana_%': 'Present'}
2019-02-27 09:45:13,927 [salt.state       :1951][INFO    ][19481] Completed state [mysql_grants_grafana_grafana_%] at time 09:45:13.927472 duration_in_ms=11.289
2019-02-27 09:45:13,927 [salt.state       :1780][INFO    ][19481] Running state [grafana] at time 09:45:13.927689
2019-02-27 09:45:13,927 [salt.state       :1813][INFO    ][19481] Executing state mysql_user.present for [grafana]
2019-02-27 09:45:13,940 [salt.loaded.int.module.mysql:1383][INFO    ][19481] User 'grafana'@'192.168.10.24' has been created
2019-02-27 09:45:13,940 [salt.state       :300 ][INFO    ][19481] {'grafana': 'Present'}
2019-02-27 09:45:13,940 [salt.state       :1951][INFO    ][19481] Completed state [grafana] at time 09:45:13.940867 duration_in_ms=13.178
2019-02-27 09:45:13,942 [salt.state       :1780][INFO    ][19481] Running state [mysql_grants_grafana_grafana_192.168.10.24] at time 09:45:13.942468
2019-02-27 09:45:13,942 [salt.state       :1813][INFO    ][19481] Executing state mysql_grants.present for [mysql_grants_grafana_grafana_192.168.10.24]
2019-02-27 09:45:13,953 [salt.loaded.int.module.mysql:1870][INFO    ][19481] Grant 'all' on 'grafana.*' for user 'grafana' has been added
2019-02-27 09:45:13,953 [salt.state       :300 ][INFO    ][19481] {'mysql_grants_grafana_grafana_192.168.10.24': 'Present'}
2019-02-27 09:45:13,953 [salt.state       :1951][INFO    ][19481] Completed state [mysql_grants_grafana_grafana_192.168.10.24] at time 09:45:13.953692 duration_in_ms=11.223
2019-02-27 09:45:13,953 [salt.state       :1780][INFO    ][19481] Running state [designate_pool_manager] at time 09:45:13.953893
2019-02-27 09:45:13,954 [salt.state       :1813][INFO    ][19481] Executing state mysql_database.present for [designate_pool_manager]
2019-02-27 09:45:13,957 [salt.loaded.int.module.mysql:1101][INFO    ][19481] DB 'designate_pool_manager' created
2019-02-27 09:45:13,958 [salt.state       :300 ][INFO    ][19481] {'designate_pool_manager': 'Present'}
2019-02-27 09:45:13,958 [salt.state       :1951][INFO    ][19481] Completed state [designate_pool_manager] at time 09:45:13.958272 duration_in_ms=4.379
2019-02-27 09:45:13,958 [salt.state       :1780][INFO    ][19481] Running state [designate] at time 09:45:13.958471
2019-02-27 09:45:13,958 [salt.state       :1813][INFO    ][19481] Executing state mysql_user.present for [designate]
2019-02-27 09:45:13,970 [salt.loaded.int.module.mysql:1383][INFO    ][19481] User 'designate'@'%' has been created
2019-02-27 09:45:13,971 [salt.state       :300 ][INFO    ][19481] {'designate': 'Present'}
2019-02-27 09:45:13,971 [salt.state       :1951][INFO    ][19481] Completed state [designate] at time 09:45:13.971251 duration_in_ms=12.78
2019-02-27 09:45:13,973 [salt.state       :1780][INFO    ][19481] Running state [mysql_grants_designate_designate_pool_manager_%] at time 09:45:13.973112
2019-02-27 09:45:13,973 [salt.state       :1813][INFO    ][19481] Executing state mysql_grants.present for [mysql_grants_designate_designate_pool_manager_%]
2019-02-27 09:45:13,983 [salt.loaded.int.module.mysql:1870][INFO    ][19481] Grant 'all' on 'designate_pool_manager.*' for user 'designate' has been added
2019-02-27 09:45:13,983 [salt.state       :300 ][INFO    ][19481] {'mysql_grants_designate_designate_pool_manager_%': 'Present'}
2019-02-27 09:45:13,984 [salt.state       :1951][INFO    ][19481] Completed state [mysql_grants_designate_designate_pool_manager_%] at time 09:45:13.984061 duration_in_ms=10.949
2019-02-27 09:45:13,984 [salt.state       :1780][INFO    ][19481] Running state [designate] at time 09:45:13.984262
2019-02-27 09:45:13,984 [salt.state       :1813][INFO    ][19481] Executing state mysql_user.present for [designate]
2019-02-27 09:45:13,997 [salt.loaded.int.module.mysql:1383][INFO    ][19481] User 'designate'@'192.168.10.23' has been created
2019-02-27 09:45:13,997 [salt.state       :300 ][INFO    ][19481] {'designate': 'Present'}
2019-02-27 09:45:13,997 [salt.state       :1951][INFO    ][19481] Completed state [designate] at time 09:45:13.997410 duration_in_ms=13.148
2019-02-27 09:45:13,999 [salt.state       :1780][INFO    ][19481] Running state [mysql_grants_designate_designate_pool_manager_192.168.10.23] at time 09:45:13.999060
2019-02-27 09:45:13,999 [salt.state       :1813][INFO    ][19481] Executing state mysql_grants.present for [mysql_grants_designate_designate_pool_manager_192.168.10.23]
2019-02-27 09:45:14,009 [salt.loaded.int.module.mysql:1870][INFO    ][19481] Grant 'all' on 'designate_pool_manager.*' for user 'designate' has been added
2019-02-27 09:45:14,010 [salt.state       :300 ][INFO    ][19481] {'mysql_grants_designate_designate_pool_manager_192.168.10.23': 'Present'}
2019-02-27 09:45:14,010 [salt.state       :1951][INFO    ][19481] Completed state [mysql_grants_designate_designate_pool_manager_192.168.10.23] at time 09:45:14.010211 duration_in_ms=11.151
2019-02-27 09:45:14,010 [salt.state       :1780][INFO    ][19481] Running state [heat] at time 09:45:14.010432
2019-02-27 09:45:14,010 [salt.state       :1813][INFO    ][19481] Executing state mysql_database.present for [heat]
2019-02-27 09:45:14,014 [salt.loaded.int.module.mysql:1101][INFO    ][19481] DB 'heat' created
2019-02-27 09:45:14,014 [salt.state       :300 ][INFO    ][19481] {'heat': 'Present'}
2019-02-27 09:45:14,014 [salt.state       :1951][INFO    ][19481] Completed state [heat] at time 09:45:14.014805 duration_in_ms=4.372
2019-02-27 09:45:14,015 [salt.state       :1780][INFO    ][19481] Running state [heat] at time 09:45:14.015021
2019-02-27 09:45:14,015 [salt.state       :1813][INFO    ][19481] Executing state mysql_user.present for [heat]
2019-02-27 09:45:14,028 [salt.loaded.int.module.mysql:1383][INFO    ][19481] User 'heat'@'%' has been created
2019-02-27 09:45:14,029 [salt.state       :300 ][INFO    ][19481] {'heat': 'Present'}
2019-02-27 09:45:14,029 [salt.state       :1951][INFO    ][19481] Completed state [heat] at time 09:45:14.029362 duration_in_ms=14.341
2019-02-27 09:45:14,031 [salt.state       :1780][INFO    ][19481] Running state [mysql_grants_heat_heat_%] at time 09:45:14.031051
2019-02-27 09:45:14,031 [salt.state       :1813][INFO    ][19481] Executing state mysql_grants.present for [mysql_grants_heat_heat_%]
2019-02-27 09:45:14,041 [salt.loaded.int.module.mysql:1870][INFO    ][19481] Grant 'all' on 'heat.*' for user 'heat' has been added
2019-02-27 09:45:14,041 [salt.state       :300 ][INFO    ][19481] {'mysql_grants_heat_heat_%': 'Present'}
2019-02-27 09:45:14,041 [salt.state       :1951][INFO    ][19481] Completed state [mysql_grants_heat_heat_%] at time 09:45:14.041852 duration_in_ms=10.801
2019-02-27 09:45:14,042 [salt.state       :1780][INFO    ][19481] Running state [heat] at time 09:45:14.042046
2019-02-27 09:45:14,042 [salt.state       :1813][INFO    ][19481] Executing state mysql_user.present for [heat]
2019-02-27 09:45:14,054 [salt.loaded.int.module.mysql:1383][INFO    ][19481] User 'heat'@'192.168.10.24' has been created
2019-02-27 09:45:14,054 [salt.state       :300 ][INFO    ][19481] {'heat': 'Present'}
2019-02-27 09:45:14,054 [salt.state       :1951][INFO    ][19481] Completed state [heat] at time 09:45:14.054894 duration_in_ms=12.847
2019-02-27 09:45:14,056 [salt.state       :1780][INFO    ][19481] Running state [mysql_grants_heat_heat_192.168.10.24] at time 09:45:14.056548
2019-02-27 09:45:14,056 [salt.state       :1813][INFO    ][19481] Executing state mysql_grants.present for [mysql_grants_heat_heat_192.168.10.24]
2019-02-27 09:45:14,066 [salt.loaded.int.module.mysql:1870][INFO    ][19481] Grant 'all' on 'heat.*' for user 'heat' has been added
2019-02-27 09:45:14,067 [salt.state       :300 ][INFO    ][19481] {'mysql_grants_heat_heat_192.168.10.24': 'Present'}
2019-02-27 09:45:14,067 [salt.state       :1951][INFO    ][19481] Completed state [mysql_grants_heat_heat_192.168.10.24] at time 09:45:14.067332 duration_in_ms=10.784
2019-02-27 09:45:14,067 [salt.state       :1780][INFO    ][19481] Running state [nova_api] at time 09:45:14.067532
2019-02-27 09:45:14,067 [salt.state       :1813][INFO    ][19481] Executing state mysql_database.present for [nova_api]
2019-02-27 09:45:14,071 [salt.loaded.int.module.mysql:1101][INFO    ][19481] DB 'nova_api' created
2019-02-27 09:45:14,071 [salt.state       :300 ][INFO    ][19481] {'nova_api': 'Present'}
2019-02-27 09:45:14,071 [salt.state       :1951][INFO    ][19481] Completed state [nova_api] at time 09:45:14.071848 duration_in_ms=4.315
2019-02-27 09:45:14,072 [salt.state       :1780][INFO    ][19481] Running state [nova] at time 09:45:14.072091
2019-02-27 09:45:14,072 [salt.state       :1813][INFO    ][19481] Executing state mysql_user.present for [nova]
2019-02-27 09:45:14,075 [salt.state       :300 ][INFO    ][19481] User nova@% is already present with the desired password
2019-02-27 09:45:14,075 [salt.state       :1951][INFO    ][19481] Completed state [nova] at time 09:45:14.075333 duration_in_ms=3.242
2019-02-27 09:45:14,077 [salt.state       :1780][INFO    ][19481] Running state [mysql_grants_nova_nova_api_%] at time 09:45:14.077094
2019-02-27 09:45:14,077 [salt.state       :1813][INFO    ][19481] Executing state mysql_grants.present for [mysql_grants_nova_nova_api_%]
2019-02-27 09:45:14,087 [salt.loaded.int.module.mysql:1870][INFO    ][19481] Grant 'all' on 'nova_api.*' for user 'nova' has been added
2019-02-27 09:45:14,088 [salt.state       :300 ][INFO    ][19481] {'mysql_grants_nova_nova_api_%': 'Present'}
2019-02-27 09:45:14,088 [salt.state       :1951][INFO    ][19481] Completed state [mysql_grants_nova_nova_api_%] at time 09:45:14.088244 duration_in_ms=11.149
2019-02-27 09:45:14,088 [salt.state       :1780][INFO    ][19481] Running state [nova] at time 09:45:14.088464
2019-02-27 09:45:14,088 [salt.state       :1813][INFO    ][19481] Executing state mysql_user.present for [nova]
2019-02-27 09:45:14,091 [salt.state       :300 ][INFO    ][19481] User nova@192.168.10.24 is already present with the desired password
2019-02-27 09:45:14,091 [salt.state       :1951][INFO    ][19481] Completed state [nova] at time 09:45:14.091735 duration_in_ms=3.271
2019-02-27 09:45:14,093 [salt.state       :1780][INFO    ][19481] Running state [mysql_grants_nova_nova_api_192.168.10.24] at time 09:45:14.093388
2019-02-27 09:45:14,093 [salt.state       :1813][INFO    ][19481] Executing state mysql_grants.present for [mysql_grants_nova_nova_api_192.168.10.24]
2019-02-27 09:45:14,103 [salt.loaded.int.module.mysql:1870][INFO    ][19481] Grant 'all' on 'nova_api.*' for user 'nova' has been added
2019-02-27 09:45:14,104 [salt.state       :300 ][INFO    ][19481] {'mysql_grants_nova_nova_api_192.168.10.24': 'Present'}
2019-02-27 09:45:14,104 [salt.state       :1951][INFO    ][19481] Completed state [mysql_grants_nova_nova_api_192.168.10.24] at time 09:45:14.104303 duration_in_ms=10.915
2019-02-27 09:45:14,104 [salt.state       :1780][INFO    ][19481] Running state [keystone] at time 09:45:14.104519
2019-02-27 09:45:14,104 [salt.state       :1813][INFO    ][19481] Executing state mysql_database.present for [keystone]
2019-02-27 09:45:14,108 [salt.loaded.int.module.mysql:1101][INFO    ][19481] DB 'keystone' created
2019-02-27 09:45:14,108 [salt.state       :300 ][INFO    ][19481] {'keystone': 'Present'}
2019-02-27 09:45:14,108 [salt.state       :1951][INFO    ][19481] Completed state [keystone] at time 09:45:14.108840 duration_in_ms=4.321
2019-02-27 09:45:14,109 [salt.state       :1780][INFO    ][19481] Running state [keystone] at time 09:45:14.109071
2019-02-27 09:45:14,109 [salt.state       :1813][INFO    ][19481] Executing state mysql_user.present for [keystone]
2019-02-27 09:45:14,123 [salt.loaded.int.module.mysql:1383][INFO    ][19481] User 'keystone'@'%' has been created
2019-02-27 09:45:14,123 [salt.state       :300 ][INFO    ][19481] {'keystone': 'Present'}
2019-02-27 09:45:14,123 [salt.state       :1951][INFO    ][19481] Completed state [keystone] at time 09:45:14.123863 duration_in_ms=14.792
2019-02-27 09:45:14,125 [salt.state       :1780][INFO    ][19481] Running state [mysql_grants_keystone_keystone_%] at time 09:45:14.125731
2019-02-27 09:45:14,125 [salt.state       :1813][INFO    ][19481] Executing state mysql_grants.present for [mysql_grants_keystone_keystone_%]
2019-02-27 09:45:14,136 [salt.loaded.int.module.mysql:1870][INFO    ][19481] Grant 'all' on 'keystone.*' for user 'keystone' has been added
2019-02-27 09:45:14,136 [salt.state       :300 ][INFO    ][19481] {'mysql_grants_keystone_keystone_%': 'Present'}
2019-02-27 09:45:14,137 [salt.state       :1951][INFO    ][19481] Completed state [mysql_grants_keystone_keystone_%] at time 09:45:14.137118 duration_in_ms=11.388
2019-02-27 09:45:14,137 [salt.state       :1780][INFO    ][19481] Running state [keystone] at time 09:45:14.137329
2019-02-27 09:45:14,137 [salt.state       :1813][INFO    ][19481] Executing state mysql_user.present for [keystone]
2019-02-27 09:45:14,150 [salt.loaded.int.module.mysql:1383][INFO    ][19481] User 'keystone'@'192.168.10.24' has been created
2019-02-27 09:45:14,150 [salt.state       :300 ][INFO    ][19481] {'keystone': 'Present'}
2019-02-27 09:45:14,150 [salt.state       :1951][INFO    ][19481] Completed state [keystone] at time 09:45:14.150777 duration_in_ms=13.448
2019-02-27 09:45:14,152 [salt.state       :1780][INFO    ][19481] Running state [mysql_grants_keystone_keystone_192.168.10.24] at time 09:45:14.152560
2019-02-27 09:45:14,152 [salt.state       :1813][INFO    ][19481] Executing state mysql_grants.present for [mysql_grants_keystone_keystone_192.168.10.24]
2019-02-27 09:45:14,163 [salt.loaded.int.module.mysql:1870][INFO    ][19481] Grant 'all' on 'keystone.*' for user 'keystone' has been added
2019-02-27 09:45:14,163 [salt.state       :300 ][INFO    ][19481] {'mysql_grants_keystone_keystone_192.168.10.24': 'Present'}
2019-02-27 09:45:14,164 [salt.state       :1951][INFO    ][19481] Completed state [mysql_grants_keystone_keystone_192.168.10.24] at time 09:45:14.163967 duration_in_ms=11.407
2019-02-27 09:45:14,164 [salt.state       :1780][INFO    ][19481] Running state [nova_cell0] at time 09:45:14.164234
2019-02-27 09:45:14,164 [salt.state       :1813][INFO    ][19481] Executing state mysql_database.present for [nova_cell0]
2019-02-27 09:45:14,168 [salt.loaded.int.module.mysql:1101][INFO    ][19481] DB 'nova_cell0' created
2019-02-27 09:45:14,168 [salt.state       :300 ][INFO    ][19481] {'nova_cell0': 'Present'}
2019-02-27 09:45:14,168 [salt.state       :1951][INFO    ][19481] Completed state [nova_cell0] at time 09:45:14.168881 duration_in_ms=4.647
2019-02-27 09:45:14,169 [salt.state       :1780][INFO    ][19481] Running state [nova] at time 09:45:14.169105
2019-02-27 09:45:14,169 [salt.state       :1813][INFO    ][19481] Executing state mysql_user.present for [nova]
2019-02-27 09:45:14,172 [salt.state       :300 ][INFO    ][19481] User nova@% is already present with the desired password
2019-02-27 09:45:14,172 [salt.state       :1951][INFO    ][19481] Completed state [nova] at time 09:45:14.172430 duration_in_ms=3.324
2019-02-27 09:45:14,174 [salt.state       :1780][INFO    ][19481] Running state [mysql_grants_nova_nova_cell0_%] at time 09:45:14.174263
2019-02-27 09:45:14,174 [salt.state       :1813][INFO    ][19481] Executing state mysql_grants.present for [mysql_grants_nova_nova_cell0_%]
2019-02-27 09:45:14,186 [salt.loaded.int.module.mysql:1870][INFO    ][19481] Grant 'all' on 'nova_cell0.*' for user 'nova' has been added
2019-02-27 09:45:14,186 [salt.state       :300 ][INFO    ][19481] {'mysql_grants_nova_nova_cell0_%': 'Present'}
2019-02-27 09:45:14,186 [salt.state       :1951][INFO    ][19481] Completed state [mysql_grants_nova_nova_cell0_%] at time 09:45:14.186519 duration_in_ms=12.256
2019-02-27 09:45:14,186 [salt.state       :1780][INFO    ][19481] Running state [nova] at time 09:45:14.186722
2019-02-27 09:45:14,186 [salt.state       :1813][INFO    ][19481] Executing state mysql_user.present for [nova]
2019-02-27 09:45:14,189 [salt.state       :300 ][INFO    ][19481] User nova@192.168.10.24 is already present with the desired password
2019-02-27 09:45:14,190 [salt.state       :1951][INFO    ][19481] Completed state [nova] at time 09:45:14.190000 duration_in_ms=3.278
2019-02-27 09:45:14,191 [salt.state       :1780][INFO    ][19481] Running state [mysql_grants_nova_nova_cell0_192.168.10.24] at time 09:45:14.191645
2019-02-27 09:45:14,191 [salt.state       :1813][INFO    ][19481] Executing state mysql_grants.present for [mysql_grants_nova_nova_cell0_192.168.10.24]
2019-02-27 09:45:14,203 [salt.loaded.int.module.mysql:1870][INFO    ][19481] Grant 'all' on 'nova_cell0.*' for user 'nova' has been added
2019-02-27 09:45:14,203 [salt.state       :300 ][INFO    ][19481] {'mysql_grants_nova_nova_cell0_192.168.10.24': 'Present'}
2019-02-27 09:45:14,203 [salt.state       :1951][INFO    ][19481] Completed state [mysql_grants_nova_nova_cell0_192.168.10.24] at time 09:45:14.203654 duration_in_ms=12.009
2019-02-27 09:45:14,203 [salt.state       :1780][INFO    ][19481] Running state [cinder] at time 09:45:14.203870
2019-02-27 09:45:14,204 [salt.state       :1813][INFO    ][19481] Executing state mysql_database.present for [cinder]
2019-02-27 09:45:14,207 [salt.loaded.int.module.mysql:1101][INFO    ][19481] DB 'cinder' created
2019-02-27 09:45:14,208 [salt.state       :300 ][INFO    ][19481] {'cinder': 'Present'}
2019-02-27 09:45:14,208 [salt.state       :1951][INFO    ][19481] Completed state [cinder] at time 09:45:14.208409 duration_in_ms=4.538
2019-02-27 09:45:14,208 [salt.state       :1780][INFO    ][19481] Running state [cinder] at time 09:45:14.208634
2019-02-27 09:45:14,208 [salt.state       :1813][INFO    ][19481] Executing state mysql_user.present for [cinder]
2019-02-27 09:45:14,221 [salt.loaded.int.module.mysql:1383][INFO    ][19481] User 'cinder'@'%' has been created
2019-02-27 09:45:14,221 [salt.state       :300 ][INFO    ][19481] {'cinder': 'Present'}
2019-02-27 09:45:14,221 [salt.state       :1951][INFO    ][19481] Completed state [cinder] at time 09:45:14.221799 duration_in_ms=13.164
2019-02-27 09:45:14,223 [salt.state       :1780][INFO    ][19481] Running state [mysql_grants_cinder_cinder_%] at time 09:45:14.223634
2019-02-27 09:45:14,223 [salt.state       :1813][INFO    ][19481] Executing state mysql_grants.present for [mysql_grants_cinder_cinder_%]
2019-02-27 09:45:14,234 [salt.loaded.int.module.mysql:1870][INFO    ][19481] Grant 'all' on 'cinder.*' for user 'cinder' has been added
2019-02-27 09:45:14,234 [salt.state       :300 ][INFO    ][19481] {'mysql_grants_cinder_cinder_%': 'Present'}
2019-02-27 09:45:14,234 [salt.state       :1951][INFO    ][19481] Completed state [mysql_grants_cinder_cinder_%] at time 09:45:14.234931 duration_in_ms=11.297
2019-02-27 09:45:14,235 [salt.state       :1780][INFO    ][19481] Running state [cinder] at time 09:45:14.235145
2019-02-27 09:45:14,235 [salt.state       :1813][INFO    ][19481] Executing state mysql_user.present for [cinder]
2019-02-27 09:45:14,248 [salt.loaded.int.module.mysql:1383][INFO    ][19481] User 'cinder'@'192.168.10.24' has been created
2019-02-27 09:45:14,248 [salt.state       :300 ][INFO    ][19481] {'cinder': 'Present'}
2019-02-27 09:45:14,248 [salt.state       :1951][INFO    ][19481] Completed state [cinder] at time 09:45:14.248537 duration_in_ms=13.392
2019-02-27 09:45:14,250 [salt.state       :1780][INFO    ][19481] Running state [mysql_grants_cinder_cinder_192.168.10.24] at time 09:45:14.250269
2019-02-27 09:45:14,250 [salt.state       :1813][INFO    ][19481] Executing state mysql_grants.present for [mysql_grants_cinder_cinder_192.168.10.24]
2019-02-27 09:45:14,262 [salt.loaded.int.module.mysql:1870][INFO    ][19481] Grant 'all' on 'cinder.*' for user 'cinder' has been added
2019-02-27 09:45:14,262 [salt.state       :300 ][INFO    ][19481] {'mysql_grants_cinder_cinder_192.168.10.24': 'Present'}
2019-02-27 09:45:14,262 [salt.state       :1951][INFO    ][19481] Completed state [mysql_grants_cinder_cinder_192.168.10.24] at time 09:45:14.262669 duration_in_ms=12.399
2019-02-27 09:45:14,262 [salt.state       :1780][INFO    ][19481] Running state [barbican] at time 09:45:14.262885
2019-02-27 09:45:14,263 [salt.state       :1813][INFO    ][19481] Executing state mysql_database.present for [barbican]
2019-02-27 09:45:14,267 [salt.loaded.int.module.mysql:1101][INFO    ][19481] DB 'barbican' created
2019-02-27 09:45:14,267 [salt.state       :300 ][INFO    ][19481] {'barbican': 'Present'}
2019-02-27 09:45:14,267 [salt.state       :1951][INFO    ][19481] Completed state [barbican] at time 09:45:14.267649 duration_in_ms=4.763
2019-02-27 09:45:14,267 [salt.state       :1780][INFO    ][19481] Running state [barbican] at time 09:45:14.267852
2019-02-27 09:45:14,268 [salt.state       :1813][INFO    ][19481] Executing state mysql_user.present for [barbican]
2019-02-27 09:45:14,280 [salt.loaded.int.module.mysql:1383][INFO    ][19481] User 'barbican'@'%' has been created
2019-02-27 09:45:14,281 [salt.state       :300 ][INFO    ][19481] {'barbican': 'Present'}
2019-02-27 09:45:14,281 [salt.state       :1951][INFO    ][19481] Completed state [barbican] at time 09:45:14.281201 duration_in_ms=13.349
2019-02-27 09:45:14,283 [salt.state       :1780][INFO    ][19481] Running state [mysql_grants_barbican_barbican_%] at time 09:45:14.283027
2019-02-27 09:45:14,283 [salt.state       :1813][INFO    ][19481] Executing state mysql_grants.present for [mysql_grants_barbican_barbican_%]
2019-02-27 09:45:14,293 [salt.loaded.int.module.mysql:1870][INFO    ][19481] Grant 'all' on 'barbican.*' for user 'barbican' has been added
2019-02-27 09:45:14,293 [salt.state       :300 ][INFO    ][19481] {'mysql_grants_barbican_barbican_%': 'Present'}
2019-02-27 09:45:14,294 [salt.state       :1951][INFO    ][19481] Completed state [mysql_grants_barbican_barbican_%] at time 09:45:14.294149 duration_in_ms=11.122
2019-02-27 09:45:14,294 [salt.state       :1780][INFO    ][19481] Running state [barbican] at time 09:45:14.294374
2019-02-27 09:45:14,294 [salt.state       :1813][INFO    ][19481] Executing state mysql_user.present for [barbican]
2019-02-27 09:45:14,307 [salt.loaded.int.module.mysql:1383][INFO    ][19481] User 'barbican'@'192.168.10.23' has been created
2019-02-27 09:45:14,307 [salt.state       :300 ][INFO    ][19481] {'barbican': 'Present'}
2019-02-27 09:45:14,307 [salt.state       :1951][INFO    ][19481] Completed state [barbican] at time 09:45:14.307755 duration_in_ms=13.381
2019-02-27 09:45:14,309 [salt.state       :1780][INFO    ][19481] Running state [mysql_grants_barbican_barbican_192.168.10.23] at time 09:45:14.309503
2019-02-27 09:45:14,309 [salt.state       :1813][INFO    ][19481] Executing state mysql_grants.present for [mysql_grants_barbican_barbican_192.168.10.23]
2019-02-27 09:45:14,319 [salt.loaded.int.module.mysql:1870][INFO    ][19481] Grant 'all' on 'barbican.*' for user 'barbican' has been added
2019-02-27 09:45:14,320 [salt.state       :300 ][INFO    ][19481] {'mysql_grants_barbican_barbican_192.168.10.23': 'Present'}
2019-02-27 09:45:14,320 [salt.state       :1951][INFO    ][19481] Completed state [mysql_grants_barbican_barbican_192.168.10.23] at time 09:45:14.320358 duration_in_ms=10.854
2019-02-27 09:45:14,320 [salt.state       :1780][INFO    ][19481] Running state [gnocchi] at time 09:45:14.320566
2019-02-27 09:45:14,320 [salt.state       :1813][INFO    ][19481] Executing state mysql_database.present for [gnocchi]
2019-02-27 09:45:14,324 [salt.loaded.int.module.mysql:1101][INFO    ][19481] DB 'gnocchi' created
2019-02-27 09:45:14,324 [salt.state       :300 ][INFO    ][19481] {'gnocchi': 'Present'}
2019-02-27 09:45:14,324 [salt.state       :1951][INFO    ][19481] Completed state [gnocchi] at time 09:45:14.324910 duration_in_ms=4.343
2019-02-27 09:45:14,325 [salt.state       :1780][INFO    ][19481] Running state [gnocchi] at time 09:45:14.325115
2019-02-27 09:45:14,325 [salt.state       :1813][INFO    ][19481] Executing state mysql_user.present for [gnocchi]
2019-02-27 09:45:14,337 [salt.loaded.int.module.mysql:1383][INFO    ][19481] User 'gnocchi'@'%' has been created
2019-02-27 09:45:14,337 [salt.state       :300 ][INFO    ][19481] {'gnocchi': 'Present'}
2019-02-27 09:45:14,338 [salt.state       :1951][INFO    ][19481] Completed state [gnocchi] at time 09:45:14.338127 duration_in_ms=13.011
2019-02-27 09:45:14,340 [salt.state       :1780][INFO    ][19481] Running state [mysql_grants_gnocchi_gnocchi_%] at time 09:45:14.340155
2019-02-27 09:45:14,340 [salt.state       :1813][INFO    ][19481] Executing state mysql_grants.present for [mysql_grants_gnocchi_gnocchi_%]
2019-02-27 09:45:14,350 [salt.loaded.int.module.mysql:1870][INFO    ][19481] Grant 'all' on 'gnocchi.*' for user 'gnocchi' has been added
2019-02-27 09:45:14,351 [salt.state       :300 ][INFO    ][19481] {'mysql_grants_gnocchi_gnocchi_%': 'Present'}
2019-02-27 09:45:14,351 [salt.state       :1951][INFO    ][19481] Completed state [mysql_grants_gnocchi_gnocchi_%] at time 09:45:14.351290 duration_in_ms=11.135
2019-02-27 09:45:14,351 [salt.state       :1780][INFO    ][19481] Running state [gnocchi] at time 09:45:14.351497
2019-02-27 09:45:14,351 [salt.state       :1813][INFO    ][19481] Executing state mysql_user.present for [gnocchi]
2019-02-27 09:45:14,364 [salt.loaded.int.module.mysql:1383][INFO    ][19481] User 'gnocchi'@'192.168.10.24' has been created
2019-02-27 09:45:14,364 [salt.state       :300 ][INFO    ][19481] {'gnocchi': 'Present'}
2019-02-27 09:45:14,364 [salt.state       :1951][INFO    ][19481] Completed state [gnocchi] at time 09:45:14.364778 duration_in_ms=13.281
2019-02-27 09:45:14,366 [salt.state       :1780][INFO    ][19481] Running state [mysql_grants_gnocchi_gnocchi_192.168.10.24] at time 09:45:14.366435
2019-02-27 09:45:14,366 [salt.state       :1813][INFO    ][19481] Executing state mysql_grants.present for [mysql_grants_gnocchi_gnocchi_192.168.10.24]
2019-02-27 09:45:14,377 [salt.loaded.int.module.mysql:1870][INFO    ][19481] Grant 'all' on 'gnocchi.*' for user 'gnocchi' has been added
2019-02-27 09:45:14,377 [salt.state       :300 ][INFO    ][19481] {'mysql_grants_gnocchi_gnocchi_192.168.10.24': 'Present'}
2019-02-27 09:45:14,377 [salt.state       :1951][INFO    ][19481] Completed state [mysql_grants_gnocchi_gnocchi_192.168.10.24] at time 09:45:14.377648 duration_in_ms=11.213
2019-02-27 09:45:14,377 [salt.state       :1780][INFO    ][19481] Running state [glance] at time 09:45:14.377873
2019-02-27 09:45:14,378 [salt.state       :1813][INFO    ][19481] Executing state mysql_database.present for [glance]
2019-02-27 09:45:14,382 [salt.loaded.int.module.mysql:1101][INFO    ][19481] DB 'glance' created
2019-02-27 09:45:14,382 [salt.state       :300 ][INFO    ][19481] {'glance': 'Present'}
2019-02-27 09:45:14,382 [salt.state       :1951][INFO    ][19481] Completed state [glance] at time 09:45:14.382599 duration_in_ms=4.726
2019-02-27 09:45:14,382 [salt.state       :1780][INFO    ][19481] Running state [glance] at time 09:45:14.382816
2019-02-27 09:45:14,383 [salt.state       :1813][INFO    ][19481] Executing state mysql_user.present for [glance]
2019-02-27 09:45:14,395 [salt.loaded.int.module.mysql:1383][INFO    ][19481] User 'glance'@'%' has been created
2019-02-27 09:45:14,396 [salt.state       :300 ][INFO    ][19481] {'glance': 'Present'}
2019-02-27 09:45:14,396 [salt.state       :1951][INFO    ][19481] Completed state [glance] at time 09:45:14.396270 duration_in_ms=13.453
2019-02-27 09:45:14,398 [salt.state       :1780][INFO    ][19481] Running state [mysql_grants_glance_glance_%] at time 09:45:14.398147
2019-02-27 09:45:14,398 [salt.state       :1813][INFO    ][19481] Executing state mysql_grants.present for [mysql_grants_glance_glance_%]
2019-02-27 09:45:14,409 [salt.loaded.int.module.mysql:1870][INFO    ][19481] Grant 'all' on 'glance.*' for user 'glance' has been added
2019-02-27 09:45:14,409 [salt.state       :300 ][INFO    ][19481] {'mysql_grants_glance_glance_%': 'Present'}
2019-02-27 09:45:14,409 [salt.state       :1951][INFO    ][19481] Completed state [mysql_grants_glance_glance_%] at time 09:45:14.409472 duration_in_ms=11.325
2019-02-27 09:45:14,409 [salt.state       :1780][INFO    ][19481] Running state [glance] at time 09:45:14.409673
2019-02-27 09:45:14,409 [salt.state       :1813][INFO    ][19481] Executing state mysql_user.present for [glance]
2019-02-27 09:45:14,422 [salt.loaded.int.module.mysql:1383][INFO    ][19481] User 'glance'@'192.168.10.24' has been created
2019-02-27 09:45:14,422 [salt.state       :300 ][INFO    ][19481] {'glance': 'Present'}
2019-02-27 09:45:14,422 [salt.state       :1951][INFO    ][19481] Completed state [glance] at time 09:45:14.422952 duration_in_ms=13.277
2019-02-27 09:45:14,424 [salt.state       :1780][INFO    ][19481] Running state [mysql_grants_glance_glance_192.168.10.24] at time 09:45:14.424803
2019-02-27 09:45:14,425 [salt.state       :1813][INFO    ][19481] Executing state mysql_grants.present for [mysql_grants_glance_glance_192.168.10.24]
2019-02-27 09:45:14,435 [salt.loaded.int.module.mysql:1870][INFO    ][19481] Grant 'all' on 'glance.*' for user 'glance' has been added
2019-02-27 09:45:14,436 [salt.state       :300 ][INFO    ][19481] {'mysql_grants_glance_glance_192.168.10.24': 'Present'}
2019-02-27 09:45:14,436 [salt.state       :1951][INFO    ][19481] Completed state [mysql_grants_glance_glance_192.168.10.24] at time 09:45:14.436397 duration_in_ms=11.594
2019-02-27 09:45:14,436 [salt.state       :1780][INFO    ][19481] Running state [neutron] at time 09:45:14.436614
2019-02-27 09:45:14,436 [salt.state       :1813][INFO    ][19481] Executing state mysql_database.present for [neutron]
2019-02-27 09:45:14,441 [salt.loaded.int.module.mysql:1101][INFO    ][19481] DB 'neutron' created
2019-02-27 09:45:14,441 [salt.state       :300 ][INFO    ][19481] {'neutron': 'Present'}
2019-02-27 09:45:14,441 [salt.state       :1951][INFO    ][19481] Completed state [neutron] at time 09:45:14.441547 duration_in_ms=4.933
2019-02-27 09:45:14,441 [salt.state       :1780][INFO    ][19481] Running state [neutron] at time 09:45:14.441761
2019-02-27 09:45:14,441 [salt.state       :1813][INFO    ][19481] Executing state mysql_user.present for [neutron]
2019-02-27 09:45:14,454 [salt.loaded.int.module.mysql:1383][INFO    ][19481] User 'neutron'@'%' has been created
2019-02-27 09:45:14,455 [salt.state       :300 ][INFO    ][19481] {'neutron': 'Present'}
2019-02-27 09:45:14,455 [salt.state       :1951][INFO    ][19481] Completed state [neutron] at time 09:45:14.455227 duration_in_ms=13.466
2019-02-27 09:45:14,457 [salt.state       :1780][INFO    ][19481] Running state [mysql_grants_neutron_neutron_%] at time 09:45:14.457045
2019-02-27 09:45:14,457 [salt.state       :1813][INFO    ][19481] Executing state mysql_grants.present for [mysql_grants_neutron_neutron_%]
2019-02-27 09:45:14,467 [salt.loaded.int.module.mysql:1870][INFO    ][19481] Grant 'all' on 'neutron.*' for user 'neutron' has been added
2019-02-27 09:45:14,467 [salt.state       :300 ][INFO    ][19481] {'mysql_grants_neutron_neutron_%': 'Present'}
2019-02-27 09:45:14,467 [salt.state       :1951][INFO    ][19481] Completed state [mysql_grants_neutron_neutron_%] at time 09:45:14.467865 duration_in_ms=10.82
2019-02-27 09:45:14,468 [salt.state       :1780][INFO    ][19481] Running state [neutron] at time 09:45:14.468108
2019-02-27 09:45:14,468 [salt.state       :1813][INFO    ][19481] Executing state mysql_user.present for [neutron]
2019-02-27 09:45:14,481 [salt.loaded.int.module.mysql:1383][INFO    ][19481] User 'neutron'@'192.168.10.24' has been created
2019-02-27 09:45:14,481 [salt.state       :300 ][INFO    ][19481] {'neutron': 'Present'}
2019-02-27 09:45:14,481 [salt.state       :1951][INFO    ][19481] Completed state [neutron] at time 09:45:14.481415 duration_in_ms=13.307
2019-02-27 09:45:14,483 [salt.state       :1780][INFO    ][19481] Running state [mysql_grants_neutron_neutron_192.168.10.24] at time 09:45:14.483044
2019-02-27 09:45:14,483 [salt.state       :1813][INFO    ][19481] Executing state mysql_grants.present for [mysql_grants_neutron_neutron_192.168.10.24]
2019-02-27 09:45:14,493 [salt.loaded.int.module.mysql:1870][INFO    ][19481] Grant 'all' on 'neutron.*' for user 'neutron' has been added
2019-02-27 09:45:14,494 [salt.state       :300 ][INFO    ][19481] {'mysql_grants_neutron_neutron_192.168.10.24': 'Present'}
2019-02-27 09:45:14,494 [salt.state       :1951][INFO    ][19481] Completed state [mysql_grants_neutron_neutron_192.168.10.24] at time 09:45:14.494347 duration_in_ms=11.301
2019-02-27 09:45:14,494 [salt.state       :1780][INFO    ][19481] Running state [designate] at time 09:45:14.494549
2019-02-27 09:45:14,494 [salt.state       :1813][INFO    ][19481] Executing state mysql_database.present for [designate]
2019-02-27 09:45:14,498 [salt.loaded.int.module.mysql:1101][INFO    ][19481] DB 'designate' created
2019-02-27 09:45:14,498 [salt.state       :300 ][INFO    ][19481] {'designate': 'Present'}
2019-02-27 09:45:14,499 [salt.state       :1951][INFO    ][19481] Completed state [designate] at time 09:45:14.499001 duration_in_ms=4.452
2019-02-27 09:45:14,499 [salt.state       :1780][INFO    ][19481] Running state [designate] at time 09:45:14.499209
2019-02-27 09:45:14,499 [salt.state       :1813][INFO    ][19481] Executing state mysql_user.present for [designate]
2019-02-27 09:45:14,502 [salt.state       :300 ][INFO    ][19481] User designate@% is already present with the desired password
2019-02-27 09:45:14,502 [salt.state       :1951][INFO    ][19481] Completed state [designate] at time 09:45:14.502552 duration_in_ms=3.343
2019-02-27 09:45:14,504 [salt.state       :1780][INFO    ][19481] Running state [mysql_grants_designate_designate_%] at time 09:45:14.504445
2019-02-27 09:45:14,504 [salt.state       :1813][INFO    ][19481] Executing state mysql_grants.present for [mysql_grants_designate_designate_%]
2019-02-27 09:45:14,515 [salt.loaded.int.module.mysql:1870][INFO    ][19481] Grant 'all' on 'designate.*' for user 'designate' has been added
2019-02-27 09:45:14,515 [salt.state       :300 ][INFO    ][19481] {'mysql_grants_designate_designate_%': 'Present'}
2019-02-27 09:45:14,515 [salt.state       :1951][INFO    ][19481] Completed state [mysql_grants_designate_designate_%] at time 09:45:14.515901 duration_in_ms=11.456
2019-02-27 09:45:14,516 [salt.state       :1780][INFO    ][19481] Running state [designate] at time 09:45:14.516143
2019-02-27 09:45:14,516 [salt.state       :1813][INFO    ][19481] Executing state mysql_user.present for [designate]
2019-02-27 09:45:14,519 [salt.state       :300 ][INFO    ][19481] User designate@192.168.10.23 is already present with the desired password
2019-02-27 09:45:14,519 [salt.state       :1951][INFO    ][19481] Completed state [designate] at time 09:45:14.519339 duration_in_ms=3.195
2019-02-27 09:45:14,521 [salt.state       :1780][INFO    ][19481] Running state [mysql_grants_designate_designate_192.168.10.23] at time 09:45:14.521105
2019-02-27 09:45:14,521 [salt.state       :1813][INFO    ][19481] Executing state mysql_grants.present for [mysql_grants_designate_designate_192.168.10.23]
2019-02-27 09:45:14,532 [salt.loaded.int.module.mysql:1870][INFO    ][19481] Grant 'all' on 'designate.*' for user 'designate' has been added
2019-02-27 09:45:14,532 [salt.state       :300 ][INFO    ][19481] {'mysql_grants_designate_designate_192.168.10.23': 'Present'}
2019-02-27 09:45:14,532 [salt.state       :1951][INFO    ][19481] Completed state [mysql_grants_designate_designate_192.168.10.23] at time 09:45:14.532445 duration_in_ms=11.34
2019-02-27 09:45:14,532 [salt.state       :1780][INFO    ][19481] Running state [haproxy] at time 09:45:14.532664
2019-02-27 09:45:14,532 [salt.state       :1813][INFO    ][19481] Executing state mysql_user.present for [haproxy]
2019-02-27 09:45:14,545 [salt.loaded.int.module.mysql:1383][INFO    ][19481] User 'haproxy'@'localhost' has been created with passwordless login
2019-02-27 09:45:14,545 [salt.state       :300 ][INFO    ][19481] {'haproxy': 'Present'}
2019-02-27 09:45:14,545 [salt.state       :1951][INFO    ][19481] Completed state [haproxy] at time 09:45:14.545923 duration_in_ms=13.258
2019-02-27 09:45:14,546 [salt.state       :1780][INFO    ][19481] Running state [haproxy] at time 09:45:14.546142
2019-02-27 09:45:14,546 [salt.state       :1813][INFO    ][19481] Executing state mysql_user.present for [haproxy]
2019-02-27 09:45:14,558 [salt.loaded.int.module.mysql:1383][INFO    ][19481] User 'haproxy'@'%' has been created with passwordless login
2019-02-27 09:45:14,559 [salt.state       :300 ][INFO    ][19481] {'haproxy': 'Present'}
2019-02-27 09:45:14,559 [salt.state       :1951][INFO    ][19481] Completed state [haproxy] at time 09:45:14.559407 duration_in_ms=13.264
2019-02-27 09:45:14,559 [salt.state       :1780][INFO    ][19481] Running state [haproxy] at time 09:45:14.559612
2019-02-27 09:45:14,559 [salt.state       :1813][INFO    ][19481] Executing state mysql_user.present for [haproxy]
2019-02-27 09:45:14,572 [salt.loaded.int.module.mysql:1383][INFO    ][19481] User 'haproxy'@'192.168.10.24' has been created with passwordless login
2019-02-27 09:45:14,572 [salt.state       :300 ][INFO    ][19481] {'haproxy': 'Present'}
2019-02-27 09:45:14,572 [salt.state       :1951][INFO    ][19481] Completed state [haproxy] at time 09:45:14.572548 duration_in_ms=12.936
2019-02-27 09:45:14,576 [salt.minion      :1711][INFO    ][19481] Returning information for job: 20190227094409324924
2019-02-27 09:48:12,268 [salt.minion      :1308][INFO    ][1610] User sudo_ubuntu Executing command mysql.status with jid 20190227094812263848
2019-02-27 09:48:12,278 [salt.minion      :1432][INFO    ][24829] Starting a new job with PID 24829
2019-02-27 09:48:12,294 [salt.minion      :1711][INFO    ][24829] Returning information for job: 20190227094812263848
2019-02-27 09:48:31,458 [salt.minion      :1308][INFO    ][1610] User sudo_ubuntu Executing command state.sls with jid 20190227094831453115
2019-02-27 09:48:31,468 [salt.minion      :1432][INFO    ][24834] Starting a new job with PID 24834
2019-02-27 09:48:33,299 [salt.state       :915 ][INFO    ][24834] Loading fresh modules for state activity
2019-02-27 09:48:33,609 [salt.fileclient  :1219][INFO    ][24834] Fetching file from saltenv 'base', ** done ** 'haproxy/init.sls'
2019-02-27 09:48:33,636 [salt.fileclient  :1219][INFO    ][24834] Fetching file from saltenv 'base', ** done ** 'haproxy/proxy.sls'
2019-02-27 09:48:34,301 [salt.state       :1780][INFO    ][24834] Running state [haproxy] at time 09:48:34.301237
2019-02-27 09:48:34,302 [salt.state       :1813][INFO    ][24834] Executing state pkg.installed for [haproxy]
2019-02-27 09:48:34,302 [salt.loaded.int.module.cmdmod:395 ][INFO    ][24834] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}', '-W'] in directory '/root'
2019-02-27 09:48:34,667 [salt.loaded.int.module.cmdmod:395 ][INFO    ][24834] Executing command ['apt-cache', '-q', 'policy', 'haproxy'] in directory '/root'
2019-02-27 09:48:34,736 [salt.loaded.int.module.cmdmod:395 ][INFO    ][24834] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2019-02-27 09:48:36,255 [salt.loaded.int.module.cmdmod:395 ][INFO    ][24834] Executing command ['dpkg', '--get-selections', '*'] in directory '/root'
2019-02-27 09:48:36,279 [salt.loaded.int.module.cmdmod:395 ][INFO    ][24834] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'haproxy'] in directory '/root'
2019-02-27 09:48:39,235 [salt.loaded.int.module.cmdmod:395 ][INFO    ][24834] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}', '-W'] in directory '/root'
2019-02-27 09:48:39,269 [salt.state       :300 ][INFO    ][24834] Made the following changes:
'haproxy' changed from 'absent' to '1.6.3-1ubuntu0.2'
'liblua5.3-0' changed from 'absent' to '5.3.1-1ubuntu2'

2019-02-27 09:48:39,289 [salt.state       :915 ][INFO    ][24834] Loading fresh modules for state activity
2019-02-27 09:48:39,326 [salt.state       :1951][INFO    ][24834] Completed state [haproxy] at time 09:48:39.326339 duration_in_ms=5025.102
2019-02-27 09:48:39,330 [salt.state       :1780][INFO    ][24834] Running state [/etc/default/haproxy] at time 09:48:39.330935
2019-02-27 09:48:39,331 [salt.state       :1813][INFO    ][24834] Executing state file.managed for [/etc/default/haproxy]
2019-02-27 09:48:39,358 [salt.fileclient  :1219][INFO    ][24834] Fetching file from saltenv 'base', ** done ** 'haproxy/files/haproxy.default'
2019-02-27 09:48:39,361 [salt.state       :300 ][INFO    ][24834] 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"

2019-02-27 09:48:39,361 [salt.state       :1951][INFO    ][24834] Completed state [/etc/default/haproxy] at time 09:48:39.361903 duration_in_ms=30.966
2019-02-27 09:48:39,362 [salt.state       :1780][INFO    ][24834] Running state [/etc/haproxy/haproxy.cfg] at time 09:48:39.362245
2019-02-27 09:48:39,362 [salt.state       :1813][INFO    ][24834] Executing state file.managed for [/etc/haproxy/haproxy.cfg]
2019-02-27 09:48:39,381 [salt.fileclient  :1219][INFO    ][24834] Fetching file from saltenv 'base', ** done ** 'haproxy/files/haproxy.cfg'
2019-02-27 09:48:39,544 [salt.state       :300 ][INFO    ][24834] 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  25000
+  # SSL options
+  ca-base /etc/haproxy/ssl
+  crt-base /etc/haproxy/ssl
+  tune.ssl.default-dh-param 2048
+  ssl-default-bind-ciphers ECDHE-ECDSA-CHACHA20-POLY1305:ECDHE-RSA-CHACHA20-POLY1305:ECDHE-ECDSA-AES128-GCM-SHA256:ECDHE-RSA-AES128-GCM-SHA256:ECDHE-ECDSA-AES256-GCM-SHA384:ECDHE-RSA-AES256-GCM-SHA384:DHE-RSA-AES128-GCM-SHA256:DHE-RSA-AES256-GCM-SHA384:ECDHE-ECDSA-AES128-SHA256:ECDHE-RSA-AES128-SHA256:ECDHE-ECDSA-AES128-SHA:ECDHE-RSA-AES256-SHA384:ECDHE-RSA-AES128-SHA:ECDHE-ECDSA-AES256-SHA384:ECDHE-ECDSA-AES256-SHA:ECDHE-RSA-AES256-SHA:DHE-RSA-AES128-SHA256:DHE-RSA-AES128-SHA:DHE-RSA-AES256-SHA256:DHE-RSA-AES256-SHA:ECDHE-ECDSA-DES-CBC3-SHA:ECDHE-RSA-DES-CBC3-SHA:EDH-RSA-DES-CBC3-SHA:AES128-GCM-SHA256:AES256-GCM-SHA384:AES128-SHA256:AES256-SHA256:AES128-SHA:AES256-SHA:DES-CBC3-SHA:!DSS
+  ssl-default-bind-options no-sslv3 no-tls-tickets
+  ssl-default-server-ciphers ECDHE-ECDSA-CHACHA20-POLY1305:ECDHE-RSA-CHACHA20-POLY1305:ECDHE-ECDSA-AES128-GCM-SHA256:ECDHE-RSA-AES128-GCM-SHA256:ECDHE-ECDSA-AES256-GCM-SHA384:ECDHE-RSA-AES256-GCM-SHA384:DHE-RSA-AES128-GCM-SHA256:DHE-RSA-AES256-GCM-SHA384:ECDHE-ECDSA-AES128-SHA256:ECDHE-RSA-AES128-SHA256:ECDHE-ECDSA-AES128-SHA:ECDHE-RSA-AES256-SHA384:ECDHE-RSA-AES128-SHA:ECDHE-ECDSA-AES256-SHA384:ECDHE-ECDSA-AES256-SHA:ECDHE-RSA-AES256-SHA:DHE-RSA-AES128-SHA256:DHE-RSA-AES128-SHA:DHE-RSA-AES256-SHA256:DHE-RSA-AES256-SHA:ECDHE-ECDSA-DES-CBC3-SHA:ECDHE-RSA-DES-CBC3-SHA:EDH-RSA-DES-CBC3-SHA:AES128-GCM-SHA256:AES256-GCM-SHA384:AES128-SHA256:AES256-SHA256:AES128-SHA:AES256-SHA:DES-CBC3-SHA:!DSS
+  ssl-default-server-options no-sslv3 no-tls-tickets
 
 defaults
-	log	global
-	mode	http
-	option	httplog
-	option	dontlognull
-        timeout connect 5000
-        timeout client  50000
-        timeout server  50000
-	errorfile 400 /etc/haproxy/errors/400.http
-	errorfile 403 /etc/haproxy/errors/403.http
-	errorfile 408 /etc/haproxy/errors/408.http
-	errorfile 500 /etc/haproxy/errors/500.http
-	errorfile 502 /etc/haproxy/errors/502.http
-	errorfile 503 /etc/haproxy/errors/503.http
-	errorfile 504 /etc/haproxy/errors/504.http
+  log  global
+  mode http
+
+  maxconn 8000
+  option  redispatch
+  retries  3
+  stats  enable
+
+  timeout http-request 10s
+  timeout queue 1m
+  timeout connect 10s
+  timeout client 1m
+  timeout server 1m
+  timeout check 10s
+
+listen mysql_cluster
+  bind 192.168.10.23: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.24:3306 check inter 20s fastinter 2s downinter 2s rise 3 fall 3
+  server dbs02 192.168.10.25:3306 backup check inter 20s fastinter 2s downinter 2s rise 3 fall 3
+  server dbs03 192.168.10.26:3306 backup check inter 20s fastinter 2s downinter 2s rise 3 fall 3

2019-02-27 09:48:39,544 [salt.state       :1951][INFO    ][24834] Completed state [/etc/haproxy/haproxy.cfg] at time 09:48:39.544707 duration_in_ms=182.461
2019-02-27 09:48:39,545 [salt.state       :1780][INFO    ][24834] Running state [/etc/haproxy/ssl] at time 09:48:39.545048
2019-02-27 09:48:39,545 [salt.state       :1813][INFO    ][24834] Executing state file.directory for [/etc/haproxy/ssl]
2019-02-27 09:48:39,546 [salt.state       :300 ][INFO    ][24834] {'/etc/haproxy/ssl': 'New Dir'}
2019-02-27 09:48:39,547 [salt.state       :1951][INFO    ][24834] Completed state [/etc/haproxy/ssl] at time 09:48:39.547051 duration_in_ms=2.003
2019-02-27 09:48:39,547 [salt.state       :1780][INFO    ][24834] Running state [/etc/haproxy/errors/429.http11] at time 09:48:39.547361
2019-02-27 09:48:39,547 [salt.state       :1813][INFO    ][24834] Executing state file.managed for [/etc/haproxy/errors/429.http11]
2019-02-27 09:48:39,569 [salt.fileclient  :1219][INFO    ][24834] Fetching file from saltenv 'base', ** done ** 'haproxy/files/errors/429.http11'
2019-02-27 09:48:39,577 [salt.state       :300 ][INFO    ][24834] File changed:
New file
2019-02-27 09:48:39,577 [salt.state       :1951][INFO    ][24834] Completed state [/etc/haproxy/errors/429.http11] at time 09:48:39.577663 duration_in_ms=30.301
2019-02-27 09:48:39,578 [salt.state       :1780][INFO    ][24834] Running state [haproxy_status_packages] at time 09:48:39.578605
2019-02-27 09:48:39,578 [salt.state       :1813][INFO    ][24834] Executing state pkg.installed for [haproxy_status_packages]
2019-02-27 09:48:40,245 [salt.state       :300 ][INFO    ][24834] All specified packages are already installed
2019-02-27 09:48:40,245 [salt.state       :1951][INFO    ][24834] Completed state [haproxy_status_packages] at time 09:48:40.245868 duration_in_ms=667.263
2019-02-27 09:48:40,246 [salt.state       :1780][INFO    ][24834] Running state [/usr/bin/haproxy-status.sh] at time 09:48:40.246569
2019-02-27 09:48:40,246 [salt.state       :1813][INFO    ][24834] Executing state file.managed for [/usr/bin/haproxy-status.sh]
2019-02-27 09:48:40,271 [salt.fileclient  :1219][INFO    ][24834] Fetching file from saltenv 'base', ** done ** 'haproxy/files/haproxy-status.sh'
2019-02-27 09:48:40,297 [salt.state       :300 ][INFO    ][24834] File changed:
New file
2019-02-27 09:48:40,297 [salt.state       :1951][INFO    ][24834] Completed state [/usr/bin/haproxy-status.sh] at time 09:48:40.297843 duration_in_ms=51.274
2019-02-27 09:48:40,298 [salt.state       :1780][INFO    ][24834] Running state [net.ipv4.ip_nonlocal_bind] at time 09:48:40.298342
2019-02-27 09:48:40,298 [salt.state       :1813][INFO    ][24834] Executing state sysctl.present for [net.ipv4.ip_nonlocal_bind]
2019-02-27 09:48:40,299 [salt.loaded.int.module.cmdmod:395 ][INFO    ][24834] Executing command 'sysctl -w net.ipv4.ip_nonlocal_bind="1"' in directory '/root'
2019-02-27 09:48:40,311 [salt.state       :300 ][INFO    ][24834] {'net.ipv4.ip_nonlocal_bind': 1}
2019-02-27 09:48:40,311 [salt.state       :1951][INFO    ][24834] Completed state [net.ipv4.ip_nonlocal_bind] at time 09:48:40.311467 duration_in_ms=13.125
2019-02-27 09:48:40,313 [salt.state       :1780][INFO    ][24834] Running state [haproxy] at time 09:48:40.313188
2019-02-27 09:48:40,313 [salt.state       :1813][INFO    ][24834] Executing state service.running for [haproxy]
2019-02-27 09:48:40,314 [salt.loaded.int.module.cmdmod:395 ][INFO    ][24834] Executing command ['systemctl', 'status', 'haproxy.service', '-n', '0'] in directory '/root'
2019-02-27 09:48:40,327 [salt.loaded.int.module.cmdmod:395 ][INFO    ][24834] Executing command ['systemctl', 'is-active', 'haproxy.service'] in directory '/root'
2019-02-27 09:48:40,339 [salt.loaded.int.module.cmdmod:395 ][INFO    ][24834] Executing command ['systemctl', 'is-enabled', 'haproxy.service'] in directory '/root'
2019-02-27 09:48:40,351 [salt.state       :300 ][INFO    ][24834] The service haproxy is already running
2019-02-27 09:48:40,351 [salt.state       :1951][INFO    ][24834] Completed state [haproxy] at time 09:48:40.351779 duration_in_ms=38.589
2019-02-27 09:48:40,352 [salt.state       :1780][INFO    ][24834] Running state [haproxy] at time 09:48:40.352062
2019-02-27 09:48:40,352 [salt.state       :1813][INFO    ][24834] Executing state service.mod_watch for [haproxy]
2019-02-27 09:48:40,353 [salt.loaded.int.module.cmdmod:395 ][INFO    ][24834] Executing command ['systemctl', 'is-active', 'haproxy.service'] in directory '/root'
2019-02-27 09:48:40,364 [salt.loaded.int.module.cmdmod:395 ][INFO    ][24834] Executing command ['systemd-run', '--scope', 'systemctl', 'restart', 'haproxy.service'] in directory '/root'
2019-02-27 09:48:40,413 [salt.state       :300 ][INFO    ][24834] {'haproxy': True}
2019-02-27 09:48:40,414 [salt.state       :1951][INFO    ][24834] Completed state [haproxy] at time 09:48:40.414032 duration_in_ms=61.967
2019-02-27 09:48:40,415 [salt.minion      :1711][INFO    ][24834] Returning information for job: 20190227094831453115
2019-02-27 09:48:44,756 [salt.minion      :1308][INFO    ][1610] User sudo_ubuntu Executing command service.status with jid 20190227094844750605
2019-02-27 09:48:44,769 [salt.minion      :1432][INFO    ][25700] Starting a new job with PID 25700
2019-02-27 09:48:45,185 [salt.loader.192.168.11.2.int.module.cmdmod:395 ][INFO    ][25700] Executing command ['systemctl', 'status', 'haproxy.service', '-n', '0'] in directory '/root'
2019-02-27 09:48:45,201 [salt.loader.192.168.11.2.int.module.cmdmod:395 ][INFO    ][25700] Executing command ['systemctl', 'is-active', 'haproxy.service'] in directory '/root'
2019-02-27 09:48:45,213 [salt.minion      :1711][INFO    ][25700] Returning information for job: 20190227094844750605
2019-02-27 09:48:46,111 [salt.minion      :1308][INFO    ][1610] User sudo_ubuntu Executing command service.restart with jid 20190227094846104674
2019-02-27 09:48:46,123 [salt.minion      :1432][INFO    ][25710] Starting a new job with PID 25710
2019-02-27 09:48:46,525 [salt.loader.192.168.11.2.int.module.cmdmod:395 ][INFO    ][25710] Executing command ['systemctl', 'status', 'rsyslog.service', '-n', '0'] in directory '/root'
2019-02-27 09:48:46,548 [salt.loader.192.168.11.2.int.module.cmdmod:395 ][INFO    ][25710] Executing command ['systemd-run', '--scope', 'systemctl', 'restart', 'rsyslog.service'] in directory '/root'
2019-02-27 09:48:46,573 [salt.minion      :1711][INFO    ][25710] Returning information for job: 20190227094846104674
2019-02-27 10:24:12,607 [salt.minion      :1308][INFO    ][1610] User sudo_ubuntu Executing command cp.push_dir with jid 20190227102412600677
2019-02-27 10:24:12,621 [salt.minion      :1432][INFO    ][25951] Starting a new job with PID 25951
