2018-03-14 02:48:29,166 [salt.utils.parsers][WARNING ][1265] Minion received a SIGTERM. Exiting.
2018-03-14 02:48:29,494 [salt.cli.daemons ][INFO    ][1939] Setting up the Salt Minion "dbs02.mcp-pike-odl-ha.local"
2018-03-14 02:48:29,568 [salt.cli.daemons ][INFO    ][1939] Starting up the Salt Minion
2018-03-14 02:48:29,568 [salt.utils.event ][INFO    ][1939] Starting pull socket on /var/run/salt/minion/minion_event_957eb30484_pull.ipc
2018-03-14 02:48:30,012 [salt.minion      ][INFO    ][1939] Creating minion process manager
2018-03-14 02:48:31,057 [salt.loader.192.168.11.2.int.module.cmdmod][INFO    ][1939] Executing command ['date', '+%z'] in directory '/root'
2018-03-14 02:48:31,086 [salt.utils.schedule][INFO    ][1939] Updating job settings for scheduled job: __mine_interval
2018-03-14 02:48:31,092 [salt.minion      ][INFO    ][1939] Added mine.update to scheduler
2018-03-14 02:48:31,106 [salt.minion      ][INFO    ][1939] Minion is starting as user 'root'
2018-03-14 02:48:31,121 [salt.minion      ][INFO    ][1939] Minion is ready to receive requests!
2018-03-14 02:48:32,122 [salt.utils.schedule][INFO    ][1939] Running scheduled job: __mine_interval
2018-03-14 02:48:38,937 [salt.minion      ][INFO    ][1939] User sudo_ubuntu Executing command saltutil.find_job with jid 20180314024838926990
2018-03-14 02:48:38,965 [salt.minion      ][INFO    ][2030] Starting a new job with PID 2030
2018-03-14 02:48:38,990 [salt.minion      ][INFO    ][2030] Returning information for job: 20180314024838926990
2018-03-14 02:48:49,012 [salt.minion      ][INFO    ][1939] User sudo_ubuntu Executing command saltutil.find_job with jid 20180314024848997298
2018-03-14 02:48:49,046 [salt.minion      ][INFO    ][2035] Starting a new job with PID 2035
2018-03-14 02:48:49,071 [salt.minion      ][INFO    ][2035] Returning information for job: 20180314024848997298
2018-03-14 02:48:59,078 [salt.minion      ][INFO    ][1939] User sudo_ubuntu Executing command saltutil.find_job with jid 20180314024859063286
2018-03-14 02:48:59,107 [salt.minion      ][INFO    ][2040] Starting a new job with PID 2040
2018-03-14 02:48:59,126 [salt.minion      ][INFO    ][2040] Returning information for job: 20180314024859063286
2018-03-14 02:49:09,173 [salt.minion      ][INFO    ][1939] User sudo_ubuntu Executing command saltutil.find_job with jid 20180314024909162613
2018-03-14 02:49:09,203 [salt.minion      ][INFO    ][2045] Starting a new job with PID 2045
2018-03-14 02:49:09,231 [salt.minion      ][INFO    ][2045] Returning information for job: 20180314024909162613
2018-03-14 02:49:19,212 [salt.minion      ][INFO    ][1939] User sudo_ubuntu Executing command saltutil.find_job with jid 20180314024919202061
2018-03-14 02:49:19,241 [salt.minion      ][INFO    ][2050] Starting a new job with PID 2050
2018-03-14 02:49:19,268 [salt.minion      ][INFO    ][2050] Returning information for job: 20180314024919202061
2018-03-14 02:49:29,287 [salt.minion      ][INFO    ][1939] User sudo_ubuntu Executing command saltutil.find_job with jid 20180314024929276727
2018-03-14 02:49:29,323 [salt.minion      ][INFO    ][2055] Starting a new job with PID 2055
2018-03-14 02:49:29,346 [salt.minion      ][INFO    ][2055] Returning information for job: 20180314024929276727
2018-03-14 02:49:39,365 [salt.minion      ][INFO    ][1939] User sudo_ubuntu Executing command saltutil.find_job with jid 20180314024939355004
2018-03-14 02:49:39,399 [salt.minion      ][INFO    ][2060] Starting a new job with PID 2060
2018-03-14 02:49:39,418 [salt.minion      ][INFO    ][2060] Returning information for job: 20180314024939355004
2018-03-14 02:49:49,427 [salt.minion      ][INFO    ][1939] User sudo_ubuntu Executing command saltutil.find_job with jid 20180314024949416946
2018-03-14 02:49:49,461 [salt.minion      ][INFO    ][2065] Starting a new job with PID 2065
2018-03-14 02:49:49,481 [salt.minion      ][INFO    ][2065] Returning information for job: 20180314024949416946
2018-03-14 02:49:59,521 [salt.minion      ][INFO    ][1939] User sudo_ubuntu Executing command saltutil.find_job with jid 20180314024959510027
2018-03-14 02:49:59,569 [salt.minion      ][INFO    ][2070] Starting a new job with PID 2070
2018-03-14 02:49:59,586 [salt.minion      ][INFO    ][2070] Returning information for job: 20180314024959510027
2018-03-14 02:50:09,617 [salt.minion      ][INFO    ][1939] User sudo_ubuntu Executing command saltutil.find_job with jid 20180314025009605503
2018-03-14 02:50:09,650 [salt.minion      ][INFO    ][2085] Starting a new job with PID 2085
2018-03-14 02:50:09,678 [salt.minion      ][INFO    ][2085] Returning information for job: 20180314025009605503
2018-03-14 02:50:30,319 [salt.minion      ][INFO    ][1939] User sudo_ubuntu Executing command state.apply with jid 20180314025030301700
2018-03-14 02:50:30,348 [salt.minion      ][INFO    ][2090] Starting a new job with PID 2090
2018-03-14 02:50:33,471 [salt.state       ][INFO    ][2090] Loading fresh modules for state activity
2018-03-14 02:50:34,008 [salt.loaded.int.module.cmdmod][INFO    ][2090] Executing command 'haproxy -v 2>/dev/null || echo unknown' in directory '/root'
2018-03-14 02:50:34,030 [salt.loaded.int.module.cmdmod][INFO    ][2090] Executing command 'haproxy -v 2>/dev/null || echo unknown' in directory '/root'
2018-03-14 02:50:34,134 [salt.loaded.int.module.cmdmod][INFO    ][2090] Executing command 'salt-minion --version' in directory '/root'
2018-03-14 02:50:34,430 [salt.loaded.int.module.cmdmod][INFO    ][2090] Executing command 'salt-minion --version' in directory '/root'
2018-03-14 02:50:35,140 [salt.loaded.int.module.cmdmod][INFO    ][2090] Executing command 'haproxy -v 2>/dev/null || echo unknown' in directory '/root'
2018-03-14 02:50:35,157 [salt.loaded.int.module.cmdmod][INFO    ][2090] Executing command 'haproxy -v 2>/dev/null || echo unknown' in directory '/root'
2018-03-14 02:50:35,243 [salt.loaded.int.module.cmdmod][INFO    ][2090] Executing command 'salt-minion --version' in directory '/root'
2018-03-14 02:50:35,452 [salt.loaded.int.module.cmdmod][INFO    ][2090] Executing command 'salt-minion --version' in directory '/root'
2018-03-14 02:50:36,468 [salt.state       ][INFO    ][2090] Running state [salt-minion] at time 02:50:36.468889
2018-03-14 02:50:36,469 [salt.state       ][INFO    ][2090] Executing state pkg.installed for salt-minion
2018-03-14 02:50:36,470 [salt.loaded.int.module.cmdmod][INFO    ][2090] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2018-03-14 02:50:36,807 [salt.state       ][INFO    ][2090] All specified packages are already installed
2018-03-14 02:50:36,808 [salt.state       ][INFO    ][2090] Completed state [salt-minion] at time 02:50:36.808313 duration_in_ms=339.424
2018-03-14 02:50:36,808 [salt.state       ][INFO    ][2090] Running state [salt_minion_dependency_packages] at time 02:50:36.808731
2018-03-14 02:50:36,809 [salt.state       ][INFO    ][2090] Executing state pkg.installed for salt_minion_dependency_packages
2018-03-14 02:50:36,813 [salt.state       ][INFO    ][2090] All specified packages are already installed
2018-03-14 02:50:36,813 [salt.state       ][INFO    ][2090] Completed state [salt_minion_dependency_packages] at time 02:50:36.813292 duration_in_ms=4.562
2018-03-14 02:50:36,815 [salt.state       ][INFO    ][2090] Running state [/etc/salt/minion.d/minion.conf] at time 02:50:36.815129
2018-03-14 02:50:36,815 [salt.state       ][INFO    ][2090] Executing state file.managed for /etc/salt/minion.d/minion.conf
2018-03-14 02:50:37,016 [salt.state       ][INFO    ][2090] File /etc/salt/minion.d/minion.conf is in the correct state
2018-03-14 02:50:37,016 [salt.state       ][INFO    ][2090] Completed state [/etc/salt/minion.d/minion.conf] at time 02:50:37.016567 duration_in_ms=201.438
2018-03-14 02:50:37,017 [salt.state       ][INFO    ][2090] Running state [/etc/salt/minion.d/_mysql.conf] at time 02:50:37.017036
2018-03-14 02:50:37,017 [salt.state       ][INFO    ][2090] Executing state file.managed for /etc/salt/minion.d/_mysql.conf
2018-03-14 02:50:37,024 [salt.state       ][INFO    ][2090] File /etc/salt/minion.d/_mysql.conf is in the correct state
2018-03-14 02:50:37,024 [salt.state       ][INFO    ][2090] Completed state [/etc/salt/minion.d/_mysql.conf] at time 02:50:37.024332 duration_in_ms=7.296
2018-03-14 02:50:37,025 [salt.state       ][INFO    ][2090] Running state [/etc/salt/minion.d/_renderer.conf] at time 02:50:37.025506
2018-03-14 02:50:37,025 [salt.state       ][INFO    ][2090] Executing state file.managed for /etc/salt/minion.d/_renderer.conf
2018-03-14 02:50:37,100 [salt.state       ][INFO    ][2090] File /etc/salt/minion.d/_renderer.conf is in the correct state
2018-03-14 02:50:37,100 [salt.state       ][INFO    ][2090] Completed state [/etc/salt/minion.d/_renderer.conf] at time 02:50:37.100614 duration_in_ms=75.108
2018-03-14 02:50:37,101 [salt.state       ][INFO    ][2090] Running state [salt-minion] at time 02:50:37.101766
2018-03-14 02:50:37,102 [salt.state       ][INFO    ][2090] Executing state service.running for salt-minion
2018-03-14 02:50:37,102 [salt.loaded.int.module.cmdmod][INFO    ][2090] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2018-03-14 02:50:37,142 [salt.loaded.int.module.cmdmod][INFO    ][2090] Executing command ['systemctl', 'is-active', 'salt-minion.service'] in directory '/root'
2018-03-14 02:50:37,160 [salt.loaded.int.module.cmdmod][INFO    ][2090] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2018-03-14 02:50:37,181 [salt.state       ][INFO    ][2090] The service salt-minion is already running
2018-03-14 02:50:37,182 [salt.state       ][INFO    ][2090] Completed state [salt-minion] at time 02:50:37.182116 duration_in_ms=80.35
2018-03-14 02:50:37,190 [salt.state       ][INFO    ][2090] Running state [/etc/salt/grains.d] at time 02:50:37.190321
2018-03-14 02:50:37,190 [salt.state       ][INFO    ][2090] Executing state file.directory for /etc/salt/grains.d
2018-03-14 02:50:37,192 [salt.state       ][INFO    ][2090] {'/etc/salt/grains.d': 'New Dir'}
2018-03-14 02:50:37,192 [salt.state       ][INFO    ][2090] Completed state [/etc/salt/grains.d] at time 02:50:37.192505 duration_in_ms=2.184
2018-03-14 02:50:37,193 [salt.state       ][INFO    ][2090] Running state [/etc/salt/grains] at time 02:50:37.193091
2018-03-14 02:50:37,193 [salt.state       ][INFO    ][2090] Executing state file.managed for /etc/salt/grains
2018-03-14 02:50:37,194 [salt.state       ][INFO    ][2090] {'new': 'file /etc/salt/grains created'}
2018-03-14 02:50:37,194 [salt.state       ][INFO    ][2090] Completed state [/etc/salt/grains] at time 02:50:37.194507 duration_in_ms=1.416
2018-03-14 02:50:37,194 [salt.state       ][INFO    ][2090] Running state [/etc/salt/grains.d/placeholder] at time 02:50:37.194939
2018-03-14 02:50:37,195 [salt.state       ][INFO    ][2090] Executing state file.managed for /etc/salt/grains.d/placeholder
2018-03-14 02:50:37,195 [salt.state       ][INFO    ][2090] {'new': 'file /etc/salt/grains.d/placeholder created'}
2018-03-14 02:50:37,196 [salt.state       ][INFO    ][2090] Completed state [/etc/salt/grains.d/placeholder] at time 02:50:37.196270 duration_in_ms=1.331
2018-03-14 02:50:37,196 [salt.state       ][INFO    ][2090] Running state [/etc/salt/grains.d/sphinx] at time 02:50:37.196707
2018-03-14 02:50:37,197 [salt.state       ][INFO    ][2090] Executing state file.managed for /etc/salt/grains.d/sphinx
2018-03-14 02:50:37,203 [salt.state       ][INFO    ][2090] File changed:
New file
2018-03-14 02:50:37,204 [salt.state       ][INFO    ][2090] Completed state [/etc/salt/grains.d/sphinx] at time 02:50:37.204312 duration_in_ms=7.605
2018-03-14 02:50:37,205 [salt.state       ][INFO    ][2090] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 02:50:37.205061
2018-03-14 02:50:37,205 [salt.state       ][INFO    ][2090] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2018-03-14 02:50:37,205 [salt.state       ][INFO    ][2090] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2018-03-14 02:50:37,206 [salt.state       ][INFO    ][2090] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 02:50:37.206141 duration_in_ms=1.081
2018-03-14 02:50:37,206 [salt.state       ][INFO    ][2090] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 02:50:37.206454
2018-03-14 02:50:37,206 [salt.state       ][INFO    ][2090] Executing state cmd.mod_watch for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2018-03-14 02:50:37,207 [salt.loaded.int.module.cmdmod][INFO    ][2090] Executing command 'python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"' in directory '/root'
2018-03-14 02:50:37,321 [salt.state       ][INFO    ][2090] {'pid': 2140, 'retcode': 0, 'stderr': '', 'stdout': ''}
2018-03-14 02:50:37,322 [salt.state       ][INFO    ][2090] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 02:50:37.322149 duration_in_ms=115.694
2018-03-14 02:50:37,323 [salt.state       ][INFO    ][2090] Running state [/etc/salt/grains.d/dns_records] at time 02:50:37.323210
2018-03-14 02:50:37,323 [salt.state       ][INFO    ][2090] Executing state file.managed for /etc/salt/grains.d/dns_records
2018-03-14 02:50:37,329 [salt.state       ][INFO    ][2090] File changed:
New file
2018-03-14 02:50:37,330 [salt.state       ][INFO    ][2090] Completed state [/etc/salt/grains.d/dns_records] at time 02:50:37.330599 duration_in_ms=7.389
2018-03-14 02:50:37,331 [salt.state       ][INFO    ][2090] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 02:50:37.331264
2018-03-14 02:50:37,331 [salt.state       ][INFO    ][2090] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"
2018-03-14 02:50:37,331 [salt.state       ][INFO    ][2090] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"
2018-03-14 02:50:37,331 [salt.state       ][INFO    ][2090] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 02:50:37.331816 duration_in_ms=0.552
2018-03-14 02:50:37,331 [salt.state       ][INFO    ][2090] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 02:50:37.331965
2018-03-14 02:50:37,332 [salt.state       ][INFO    ][2090] Executing state cmd.mod_watch for python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"
2018-03-14 02:50:37,332 [salt.loaded.int.module.cmdmod][INFO    ][2090] Executing command 'python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"' in directory '/root'
2018-03-14 02:50:37,415 [salt.state       ][INFO    ][2090] {'pid': 2142, 'retcode': 0, 'stderr': '', 'stdout': ''}
2018-03-14 02:50:37,415 [salt.state       ][INFO    ][2090] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 02:50:37.415800 duration_in_ms=83.835
2018-03-14 02:50:37,416 [salt.state       ][INFO    ][2090] Running state [/etc/salt/grains.d/salt] at time 02:50:37.416346
2018-03-14 02:50:37,416 [salt.state       ][INFO    ][2090] Executing state file.managed for /etc/salt/grains.d/salt
2018-03-14 02:50:37,421 [salt.state       ][INFO    ][2090] File changed:
New file
2018-03-14 02:50:37,421 [salt.state       ][INFO    ][2090] Completed state [/etc/salt/grains.d/salt] at time 02:50:37.421209 duration_in_ms=4.863
2018-03-14 02:50:37,422 [salt.state       ][INFO    ][2090] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 02:50:37.422940
2018-03-14 02:50:37,423 [salt.state       ][INFO    ][2090] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2018-03-14 02:50:37,423 [salt.state       ][INFO    ][2090] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2018-03-14 02:50:37,423 [salt.state       ][INFO    ][2090] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 02:50:37.423475 duration_in_ms=0.534
2018-03-14 02:50:37,423 [salt.state       ][INFO    ][2090] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 02:50:37.423612
2018-03-14 02:50:37,423 [salt.state       ][INFO    ][2090] Executing state cmd.mod_watch for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2018-03-14 02:50:37,424 [salt.loaded.int.module.cmdmod][INFO    ][2090] Executing command 'python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"' in directory '/root'
2018-03-14 02:50:37,511 [salt.state       ][INFO    ][2090] {'pid': 2144, 'retcode': 0, 'stderr': '', 'stdout': ''}
2018-03-14 02:50:37,511 [salt.state       ][INFO    ][2090] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 02:50:37.511670 duration_in_ms=88.058
2018-03-14 02:50:37,513 [salt.state       ][INFO    ][2090] Running state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 02:50:37.513263
2018-03-14 02:50:37,513 [salt.state       ][INFO    ][2090] Executing state cmd.wait for cat /etc/salt/grains.d/* > /etc/salt/grains
2018-03-14 02:50:37,513 [salt.state       ][INFO    ][2090] No changes made for cat /etc/salt/grains.d/* > /etc/salt/grains
2018-03-14 02:50:37,513 [salt.state       ][INFO    ][2090] Completed state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 02:50:37.513950 duration_in_ms=0.688
2018-03-14 02:50:37,514 [salt.state       ][INFO    ][2090] Running state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 02:50:37.514094
2018-03-14 02:50:37,514 [salt.state       ][INFO    ][2090] Executing state cmd.mod_watch for cat /etc/salt/grains.d/* > /etc/salt/grains
2018-03-14 02:50:37,515 [salt.loaded.int.module.cmdmod][INFO    ][2090] Executing command 'cat /etc/salt/grains.d/* > /etc/salt/grains' in directory '/root'
2018-03-14 02:50:37,528 [salt.state       ][INFO    ][2090] {'pid': 2146, 'retcode': 0, 'stderr': '', 'stdout': ''}
2018-03-14 02:50:37,528 [salt.state       ][INFO    ][2090] Completed state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 02:50:37.528821 duration_in_ms=14.728
2018-03-14 02:50:37,529 [salt.state       ][INFO    ][2090] Running state [mine.update] at time 02:50:37.529640
2018-03-14 02:50:37,529 [salt.state       ][INFO    ][2090] Executing state module.wait for mine.update
2018-03-14 02:50:37,530 [salt.state       ][INFO    ][2090] No changes made for mine.update
2018-03-14 02:50:37,530 [salt.state       ][INFO    ][2090] Completed state [mine.update] at time 02:50:37.530285 duration_in_ms=0.646
2018-03-14 02:50:37,530 [salt.state       ][INFO    ][2090] Running state [mine.update] at time 02:50:37.530433
2018-03-14 02:50:37,530 [salt.state       ][INFO    ][2090] Executing state module.mod_watch for mine.update
2018-03-14 02:50:38,060 [salt.state       ][INFO    ][2090] {'ret': True}
2018-03-14 02:50:38,061 [salt.state       ][INFO    ][2090] Completed state [mine.update] at time 02:50:38.061000 duration_in_ms=530.566
2018-03-14 02:50:38,061 [salt.state       ][INFO    ][2090] Running state [ca-certificates] at time 02:50:38.061709
2018-03-14 02:50:38,062 [salt.state       ][INFO    ][2090] Executing state pkg.installed for ca-certificates
2018-03-14 02:50:38,075 [salt.state       ][INFO    ][2090] All specified packages are already installed
2018-03-14 02:50:38,075 [salt.state       ][INFO    ][2090] Completed state [ca-certificates] at time 02:50:38.075723 duration_in_ms=14.014
2018-03-14 02:50:38,077 [salt.state       ][INFO    ][2090] Running state [update-ca-certificates] at time 02:50:38.077020
2018-03-14 02:50:38,077 [salt.state       ][INFO    ][2090] Executing state cmd.wait for update-ca-certificates
2018-03-14 02:50:38,077 [salt.state       ][INFO    ][2090] No changes made for update-ca-certificates
2018-03-14 02:50:38,078 [salt.state       ][INFO    ][2090] Completed state [update-ca-certificates] at time 02:50:38.078270 duration_in_ms=1.25
2018-03-14 02:50:38,082 [salt.minion      ][INFO    ][2090] Returning information for job: 20180314025030301700
2018-03-14 02:50:50,845 [salt.minion      ][INFO    ][1939] User sudo_ubuntu Executing command state.apply with jid 20180314025050827446
2018-03-14 02:50:50,896 [salt.minion      ][INFO    ][2158] Starting a new job with PID 2158
2018-03-14 02:50:53,067 [salt.state       ][INFO    ][2158] Loading fresh modules for state activity
2018-03-14 02:50:53,287 [salt.fileclient  ][INFO    ][2158] Fetching file from saltenv 'base', ** done ** 'linux/init.sls'
2018-03-14 02:50:53,322 [salt.fileclient  ][INFO    ][2158] Fetching file from saltenv 'base', ** done ** 'linux/system/init.sls'
2018-03-14 02:50:53,430 [salt.fileclient  ][INFO    ][2158] Fetching file from saltenv 'base', ** done ** 'linux/system/env.sls'
2018-03-14 02:50:53,547 [salt.fileclient  ][INFO    ][2158] Fetching file from saltenv 'base', ** done ** 'linux/system/profile.sls'
2018-03-14 02:50:53,628 [salt.fileclient  ][INFO    ][2158] Fetching file from saltenv 'base', ** done ** 'linux/system/repo.sls'
2018-03-14 02:50:53,763 [salt.fileclient  ][INFO    ][2158] Fetching file from saltenv 'base', ** done ** 'linux/system/package.sls'
2018-03-14 02:50:53,844 [salt.fileclient  ][INFO    ][2158] Fetching file from saltenv 'base', ** done ** 'linux/system/timezone.sls'
2018-03-14 02:50:53,919 [salt.fileclient  ][INFO    ][2158] Fetching file from saltenv 'base', ** done ** 'linux/system/kernel.sls'
2018-03-14 02:50:54,029 [salt.fileclient  ][INFO    ][2158] Fetching file from saltenv 'base', ** done ** 'linux/system/cpu.sls'
2018-03-14 02:50:54,111 [salt.fileclient  ][INFO    ][2158] Fetching file from saltenv 'base', ** done ** 'linux/system/sysfs.sls'
2018-03-14 02:50:54,177 [salt.fileclient  ][INFO    ][2158] Fetching file from saltenv 'base', ** done ** 'linux/system/locale.sls'
2018-03-14 02:50:54,243 [salt.fileclient  ][INFO    ][2158] Fetching file from saltenv 'base', ** done ** 'linux/system/user.sls'
2018-03-14 02:50:54,330 [salt.fileclient  ][INFO    ][2158] Fetching file from saltenv 'base', ** done ** 'linux/system/group.sls'
2018-03-14 02:50:54,398 [salt.fileclient  ][INFO    ][2158] Fetching file from saltenv 'base', ** done ** 'linux/system/limit.sls'
2018-03-14 02:50:54,472 [salt.fileclient  ][INFO    ][2158] Fetching file from saltenv 'base', ** done ** 'linux/system/systemd.sls'
2018-03-14 02:50:54,534 [salt.fileclient  ][INFO    ][2158] Fetching file from saltenv 'base', ** done ** 'linux/system/apt.sls'
2018-03-14 02:50:54,630 [salt.fileclient  ][INFO    ][2158] Fetching file from saltenv 'base', ** done ** 'linux/network/init.sls'
2018-03-14 02:50:54,702 [salt.fileclient  ][INFO    ][2158] Fetching file from saltenv 'base', ** done ** 'linux/network/hostname.sls'
2018-03-14 02:50:54,784 [salt.fileclient  ][INFO    ][2158] Fetching file from saltenv 'base', ** done ** 'linux/network/host.sls'
2018-03-14 02:50:54,914 [salt.fileclient  ][INFO    ][2158] Fetching file from saltenv 'base', ** done ** 'linux/network/interface.sls'
2018-03-14 02:50:55,105 [salt.fileclient  ][INFO    ][2158] Fetching file from saltenv 'base', ** done ** 'linux/network/proxy.sls'
2018-03-14 02:50:55,191 [salt.fileclient  ][INFO    ][2158] Fetching file from saltenv 'base', ** done ** 'linux/storage/init.sls'
2018-03-14 02:50:55,266 [salt.fileclient  ][INFO    ][2158] Fetching file from saltenv 'base', ** done ** 'ntp/init.sls'
2018-03-14 02:50:55,284 [salt.fileclient  ][INFO    ][2158] Fetching file from saltenv 'base', ** done ** 'ntp/client.sls'
2018-03-14 02:50:55,327 [salt.fileclient  ][INFO    ][2158] Fetching file from saltenv 'base', ** done ** 'ntp/server.sls'
2018-03-14 02:50:55,364 [salt.state       ][INFO    ][2158] Running state [/etc/environment] at time 02:50:55.364524
2018-03-14 02:50:55,365 [salt.state       ][INFO    ][2158] Executing state file.blockreplace for /etc/environment
2018-03-14 02:50:55,374 [salt.state       ][INFO    ][2158] File changed:
--- 
+++ 
@@ -1 +1,4 @@
 PATH="/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/games:/usr/local/games"
+# SALT MANAGED VARIABLES - DO NOT EDIT - START
+# +# SALT MANAGED VARIABLES - END

2018-03-14 02:50:55,375 [salt.state       ][INFO    ][2158] Completed state [/etc/environment] at time 02:50:55.375601 duration_in_ms=11.077
2018-03-14 02:50:55,376 [salt.state       ][INFO    ][2158] Running state [/etc/profile.d] at time 02:50:55.376107
2018-03-14 02:50:55,376 [salt.state       ][INFO    ][2158] Executing state file.directory for /etc/profile.d
2018-03-14 02:50:55,387 [salt.state       ][INFO    ][2158] Directory /etc/profile.d is in the correct state
2018-03-14 02:50:55,387 [salt.state       ][INFO    ][2158] Completed state [/etc/profile.d] at time 02:50:55.387701 duration_in_ms=11.594
2018-03-14 02:50:55,750 [salt.state       ][INFO    ][2158] Running state [/etc/apt/apt.conf.d/99prefer_ipv4-salt] at time 02:50:55.750093
2018-03-14 02:50:55,750 [salt.state       ][INFO    ][2158] Executing state file.managed for /etc/apt/apt.conf.d/99prefer_ipv4-salt
2018-03-14 02:50:55,776 [salt.fileclient  ][INFO    ][2158] Fetching file from saltenv 'base', ** done ** 'linux/files/apt.conf'
2018-03-14 02:50:55,781 [salt.state       ][INFO    ][2158] File changed:
New file
2018-03-14 02:50:55,782 [salt.state       ][INFO    ][2158] Completed state [/etc/apt/apt.conf.d/99prefer_ipv4-salt] at time 02:50:55.782528 duration_in_ms=32.436
2018-03-14 02:50:55,783 [salt.state       ][INFO    ][2158] Running state [linux_repo_prereq_pkgs] at time 02:50:55.783217
2018-03-14 02:50:55,783 [salt.state       ][INFO    ][2158] Executing state pkg.installed for linux_repo_prereq_pkgs
2018-03-14 02:50:55,784 [salt.loaded.int.module.cmdmod][INFO    ][2158] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2018-03-14 02:50:56,103 [salt.state       ][INFO    ][2158] All specified packages are already installed
2018-03-14 02:50:56,104 [salt.state       ][INFO    ][2158] Completed state [linux_repo_prereq_pkgs] at time 02:50:56.104511 duration_in_ms=321.294
2018-03-14 02:50:56,105 [salt.state       ][INFO    ][2158] Running state [/etc/apt/apt.conf.d/99proxies-salt-mk_openstack] at time 02:50:56.104982
2018-03-14 02:50:56,105 [salt.state       ][INFO    ][2158] Executing state file.absent for /etc/apt/apt.conf.d/99proxies-salt-mk_openstack
2018-03-14 02:50:56,106 [salt.state       ][INFO    ][2158] File /etc/apt/apt.conf.d/99proxies-salt-mk_openstack is not present
2018-03-14 02:50:56,106 [salt.state       ][INFO    ][2158] Completed state [/etc/apt/apt.conf.d/99proxies-salt-mk_openstack] at time 02:50:56.106296 duration_in_ms=1.314
2018-03-14 02:50:56,106 [salt.state       ][INFO    ][2158] Running state [/etc/apt/preferences.d/mk_openstack] at time 02:50:56.106661
2018-03-14 02:50:56,107 [salt.state       ][INFO    ][2158] Executing state file.managed for /etc/apt/preferences.d/mk_openstack
2018-03-14 02:50:56,128 [salt.fileclient  ][INFO    ][2158] Fetching file from saltenv 'base', ** done ** 'linux/files/preferences_repo'
2018-03-14 02:50:56,183 [salt.state       ][INFO    ][2158] File changed:
New file
2018-03-14 02:50:56,183 [salt.state       ][INFO    ][2158] Completed state [/etc/apt/preferences.d/mk_openstack] at time 02:50:56.183889 duration_in_ms=77.228
2018-03-14 02:50:56,185 [salt.state       ][INFO    ][2158] Running state [curl -s http://apt.mirantis.com/public.gpg | apt-key add -] at time 02:50:56.185268
2018-03-14 02:50:56,185 [salt.state       ][INFO    ][2158] Executing state cmd.run for curl -s http://apt.mirantis.com/public.gpg | apt-key add -
2018-03-14 02:50:56,186 [salt.loaded.int.module.cmdmod][INFO    ][2158] Executing command 'curl -s http://apt.mirantis.com/public.gpg | apt-key add -' in directory '/root'
2018-03-14 02:50:56,448 [salt.state       ][INFO    ][2158] {'pid': 2218, 'retcode': 0, 'stderr': '', 'stdout': 'OK'}
2018-03-14 02:50:56,449 [salt.state       ][INFO    ][2158] Completed state [curl -s http://apt.mirantis.com/public.gpg | apt-key add -] at time 02:50:56.449044 duration_in_ms=263.774
2018-03-14 02:50:56,478 [salt.state       ][INFO    ][2158] Running state [deb [arch=amd64] http://apt.mirantis.com/xenial/ nightly pike] at time 02:50:56.478840
2018-03-14 02:50:56,479 [salt.state       ][INFO    ][2158] Executing state pkgrepo.managed for deb [arch=amd64] http://apt.mirantis.com/xenial/ nightly pike
2018-03-14 02:50:56,642 [salt.loaded.int.module.cmdmod][INFO    ][2158] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2018-03-14 02:50:59,697 [salt.state       ][INFO    ][2158] {'repo': 'deb [arch=amd64] http://apt.mirantis.com/xenial nightly pike'}
2018-03-14 02:50:59,698 [salt.state       ][INFO    ][2158] Completed state [deb [arch=amd64] http://apt.mirantis.com/xenial/ nightly pike] at time 02:50:59.698278 duration_in_ms=3219.439
2018-03-14 02:50:59,699 [salt.state       ][INFO    ][2158] Running state [/etc/apt/apt.conf.d/99proxies-salt-mirantis_openstack] at time 02:50:59.699100
2018-03-14 02:50:59,699 [salt.state       ][INFO    ][2158] Executing state file.absent for /etc/apt/apt.conf.d/99proxies-salt-mirantis_openstack
2018-03-14 02:50:59,700 [salt.state       ][INFO    ][2158] File /etc/apt/apt.conf.d/99proxies-salt-mirantis_openstack is not present
2018-03-14 02:50:59,701 [salt.state       ][INFO    ][2158] Completed state [/etc/apt/apt.conf.d/99proxies-salt-mirantis_openstack] at time 02:50:59.701291 duration_in_ms=2.191
2018-03-14 02:50:59,701 [salt.state       ][INFO    ][2158] Running state [/etc/apt/preferences.d/mirantis_openstack] at time 02:50:59.701889
2018-03-14 02:50:59,702 [salt.state       ][INFO    ][2158] Executing state file.managed for /etc/apt/preferences.d/mirantis_openstack
2018-03-14 02:50:59,790 [salt.state       ][INFO    ][2158] File changed:
New file
2018-03-14 02:50:59,791 [salt.state       ][INFO    ][2158] Completed state [/etc/apt/preferences.d/mirantis_openstack] at time 02:50:59.791129 duration_in_ms=89.239
2018-03-14 02:50:59,791 [salt.state       ][INFO    ][2158] Running state [curl -s http://mirror.fuel-infra.org/mcp-repos/pike/xenial/archive-mcppike.key | apt-key add -] at time 02:50:59.791554
2018-03-14 02:50:59,791 [salt.state       ][INFO    ][2158] Executing state cmd.run for curl -s http://mirror.fuel-infra.org/mcp-repos/pike/xenial/archive-mcppike.key | apt-key add -
2018-03-14 02:50:59,792 [salt.loaded.int.module.cmdmod][INFO    ][2158] Executing command 'curl -s http://mirror.fuel-infra.org/mcp-repos/pike/xenial/archive-mcppike.key | apt-key add -' in directory '/root'
2018-03-14 02:51:00,266 [salt.state       ][INFO    ][2158] {'pid': 2645, 'retcode': 0, 'stderr': '', 'stdout': 'OK'}
2018-03-14 02:51:00,267 [salt.state       ][INFO    ][2158] Completed state [curl -s http://mirror.fuel-infra.org/mcp-repos/pike/xenial/archive-mcppike.key | apt-key add -] at time 02:51:00.267435 duration_in_ms=475.88
2018-03-14 02:51:00,269 [salt.state       ][INFO    ][2158] Running state [deb http://mirror.fuel-infra.org/mcp-repos/pike/xenial pike main] at time 02:51:00.269138
2018-03-14 02:51:00,269 [salt.state       ][INFO    ][2158] Executing state pkgrepo.managed for deb http://mirror.fuel-infra.org/mcp-repos/pike/xenial pike main
2018-03-14 02:51:00,327 [salt.loaded.int.module.cmdmod][INFO    ][2158] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2018-03-14 02:51:00,952 [salt.minion      ][INFO    ][1939] User sudo_ubuntu Executing command saltutil.find_job with jid 20180314025100932793
2018-03-14 02:51:00,970 [salt.minion      ][INFO    ][3116] Starting a new job with PID 3116
2018-03-14 02:51:00,990 [salt.minion      ][INFO    ][3116] Returning information for job: 20180314025100932793
2018-03-14 02:51:03,372 [salt.state       ][INFO    ][2158] {'repo': 'deb http://mirror.fuel-infra.org/mcp-repos/pike/xenial pike main'}
2018-03-14 02:51:03,372 [salt.state       ][INFO    ][2158] Completed state [deb http://mirror.fuel-infra.org/mcp-repos/pike/xenial pike main] at time 02:51:03.372820 duration_in_ms=3103.682
2018-03-14 02:51:03,373 [salt.state       ][INFO    ][2158] Running state [/etc/apt/apt.conf.d/99proxies-salt-uca] at time 02:51:03.373210
2018-03-14 02:51:03,373 [salt.state       ][INFO    ][2158] Executing state file.absent for /etc/apt/apt.conf.d/99proxies-salt-uca
2018-03-14 02:51:03,374 [salt.state       ][INFO    ][2158] File /etc/apt/apt.conf.d/99proxies-salt-uca is not present
2018-03-14 02:51:03,374 [salt.state       ][INFO    ][2158] Completed state [/etc/apt/apt.conf.d/99proxies-salt-uca] at time 02:51:03.374399 duration_in_ms=1.19
2018-03-14 02:51:03,374 [salt.state       ][INFO    ][2158] Running state [/etc/apt/preferences.d/uca] at time 02:51:03.374761
2018-03-14 02:51:03,375 [salt.state       ][INFO    ][2158] Executing state file.absent for /etc/apt/preferences.d/uca
2018-03-14 02:51:03,375 [salt.state       ][INFO    ][2158] File /etc/apt/preferences.d/uca is not present
2018-03-14 02:51:03,375 [salt.state       ][INFO    ][2158] Completed state [/etc/apt/preferences.d/uca] at time 02:51:03.375770 duration_in_ms=1.009
2018-03-14 02:51:03,376 [salt.state       ][INFO    ][2158] Running state [apt-key adv --keyserver keyserver.ubuntu.com --recv EC4926EA] at time 02:51:03.376098
2018-03-14 02:51:03,376 [salt.state       ][INFO    ][2158] Executing state cmd.run for apt-key adv --keyserver keyserver.ubuntu.com --recv EC4926EA
2018-03-14 02:51:03,377 [salt.loaded.int.module.cmdmod][INFO    ][2158] Executing command 'apt-key adv --keyserver keyserver.ubuntu.com --recv EC4926EA' in directory '/root'
2018-03-14 02:51:03,732 [salt.state       ][INFO    ][2158] {'pid': 3127, 'retcode': 0, 'stderr': 'gpg: requesting key EC4926EA from hkp server keyserver.ubuntu.com\ngpg: key EC4926EA: public key "Canonical Cloud Archive Signing Key <ftpmaster@canonical.com>" imported\ngpg: Total number processed: 1\ngpg:               imported: 1  (RSA: 1)', 'stdout': 'Executing: /tmp/tmp.Fbub2TYN6Z/gpg.1.sh --keyserver\nkeyserver.ubuntu.com\n--recv\nEC4926EA'}
2018-03-14 02:51:03,733 [salt.state       ][INFO    ][2158] Completed state [apt-key adv --keyserver keyserver.ubuntu.com --recv EC4926EA] at time 02:51:03.733299 duration_in_ms=357.2
2018-03-14 02:51:03,735 [salt.state       ][INFO    ][2158] Running state [deb http://ubuntu-cloud.archive.canonical.com/ubuntu xenial-updates/pike main] at time 02:51:03.735259
2018-03-14 02:51:03,736 [salt.state       ][INFO    ][2158] Executing state pkgrepo.managed for deb http://ubuntu-cloud.archive.canonical.com/ubuntu xenial-updates/pike main
2018-03-14 02:51:03,806 [salt.loaded.int.module.cmdmod][INFO    ][2158] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2018-03-14 02:51:08,109 [salt.state       ][INFO    ][2158] {'repo': 'deb http://ubuntu-cloud.archive.canonical.com/ubuntu xenial-updates/pike main'}
2018-03-14 02:51:08,110 [salt.state       ][INFO    ][2158] Completed state [deb http://ubuntu-cloud.archive.canonical.com/ubuntu xenial-updates/pike main] at time 02:51:08.110714 duration_in_ms=4375.454
2018-03-14 02:51:08,261 [salt.state       ][INFO    ][2158] Running state [UTC] at time 02:51:08.261005
2018-03-14 02:51:08,262 [salt.state       ][INFO    ][2158] Executing state timezone.system for UTC
2018-03-14 02:51:08,263 [salt.loaded.int.module.cmdmod][INFO    ][2158] Executing command ['timedatectl'] in directory '/root'
2018-03-14 02:51:08,547 [salt.loaded.int.module.cmdmod][INFO    ][2158] Executing command ['timedatectl'] in directory '/root'
2018-03-14 02:51:08,566 [salt.loaded.int.module.cmdmod][INFO    ][2158] Executing command 'timedatectl set-timezone UTC' in directory '/root'
2018-03-14 02:51:08,714 [salt.state       ][INFO    ][2158] {'timezone': 'UTC'}
2018-03-14 02:51:08,715 [salt.state       ][INFO    ][2158] Completed state [UTC] at time 02:51:08.714923 duration_in_ms=453.918
2018-03-14 02:51:08,719 [salt.state       ][INFO    ][2158] Running state [nf_conntrack] at time 02:51:08.719722
2018-03-14 02:51:08,720 [salt.state       ][INFO    ][2158] Executing state kmod.present for nf_conntrack
2018-03-14 02:51:08,721 [salt.loaded.int.module.cmdmod][INFO    ][2158] Executing command 'lsmod' in directory '/root'
2018-03-14 02:51:09,123 [salt.loaded.int.module.cmdmod][INFO    ][2158] Executing command 'lsmod' in directory '/root'
2018-03-14 02:51:09,152 [salt.loaded.int.module.cmdmod][INFO    ][2158] Executing command 'modprobe nf_conntrack' in directory '/root'
2018-03-14 02:51:09,275 [salt.loaded.int.module.cmdmod][INFO    ][2158] Executing command 'lsmod' in directory '/root'
2018-03-14 02:51:09,339 [salt.state       ][INFO    ][2158] {'nf_conntrack': 'loaded'}
2018-03-14 02:51:09,340 [salt.state       ][INFO    ][2158] Completed state [nf_conntrack] at time 02:51:09.340571 duration_in_ms=620.849
2018-03-14 02:51:09,438 [salt.state       ][INFO    ][2158] Running state [kernel.panic] at time 02:51:09.438234
2018-03-14 02:51:09,439 [salt.state       ][INFO    ][2158] Executing state sysctl.present for kernel.panic
2018-03-14 02:51:09,466 [salt.loaded.int.module.cmdmod][INFO    ][2158] Executing command 'sysctl -a' in directory '/root'
2018-03-14 02:51:09,841 [salt.loaded.int.module.cmdmod][INFO    ][2158] Executing command 'sysctl -w kernel.panic="60"' in directory '/root'
2018-03-14 02:51:09,866 [salt.state       ][INFO    ][2158] {'kernel.panic': 60}
2018-03-14 02:51:09,867 [salt.state       ][INFO    ][2158] Completed state [kernel.panic] at time 02:51:09.867452 duration_in_ms=429.218
2018-03-14 02:51:09,868 [salt.state       ][INFO    ][2158] Running state [net.ipv4.tcp_keepalive_probes] at time 02:51:09.868440
2018-03-14 02:51:09,869 [salt.state       ][INFO    ][2158] Executing state sysctl.present for net.ipv4.tcp_keepalive_probes
2018-03-14 02:51:09,870 [salt.loaded.int.module.cmdmod][INFO    ][2158] Executing command 'sysctl -a' in directory '/root'
2018-03-14 02:51:09,953 [salt.loaded.int.module.cmdmod][INFO    ][2158] Executing command 'sysctl -w net.ipv4.tcp_keepalive_probes="8"' in directory '/root'
2018-03-14 02:51:09,981 [salt.state       ][INFO    ][2158] {'net.ipv4.tcp_keepalive_probes': 8}
2018-03-14 02:51:09,982 [salt.state       ][INFO    ][2158] Completed state [net.ipv4.tcp_keepalive_probes] at time 02:51:09.982771 duration_in_ms=114.33
2018-03-14 02:51:09,984 [salt.state       ][INFO    ][2158] Running state [fs.file-max] at time 02:51:09.983989
2018-03-14 02:51:09,985 [salt.state       ][INFO    ][2158] Executing state sysctl.present for fs.file-max
2018-03-14 02:51:09,987 [salt.loaded.int.module.cmdmod][INFO    ][2158] Executing command 'sysctl -a' in directory '/root'
2018-03-14 02:51:10,036 [salt.loaded.int.module.cmdmod][INFO    ][2158] Executing command 'sysctl -w fs.file-max="124165"' in directory '/root'
2018-03-14 02:51:10,059 [salt.state       ][INFO    ][2158] {'fs.file-max': 124165}
2018-03-14 02:51:10,060 [salt.state       ][INFO    ][2158] Completed state [fs.file-max] at time 02:51:10.060160 duration_in_ms=76.171
2018-03-14 02:51:10,061 [salt.state       ][INFO    ][2158] Running state [net.core.somaxconn] at time 02:51:10.061085
2018-03-14 02:51:10,061 [salt.state       ][INFO    ][2158] Executing state sysctl.present for net.core.somaxconn
2018-03-14 02:51:10,063 [salt.loaded.int.module.cmdmod][INFO    ][2158] Executing command 'sysctl -a' in directory '/root'
2018-03-14 02:51:10,127 [salt.loaded.int.module.cmdmod][INFO    ][2158] Executing command 'sysctl -w net.core.somaxconn="4096"' in directory '/root'
2018-03-14 02:51:10,147 [salt.state       ][INFO    ][2158] {'net.core.somaxconn': 4096}
2018-03-14 02:51:10,147 [salt.state       ][INFO    ][2158] Completed state [net.core.somaxconn] at time 02:51:10.147870 duration_in_ms=86.784
2018-03-14 02:51:10,148 [salt.state       ][INFO    ][2158] Running state [net.ipv4.tcp_max_syn_backlog] at time 02:51:10.148605
2018-03-14 02:51:10,149 [salt.state       ][INFO    ][2158] Executing state sysctl.present for net.ipv4.tcp_max_syn_backlog
2018-03-14 02:51:10,150 [salt.loaded.int.module.cmdmod][INFO    ][2158] Executing command 'sysctl -a' in directory '/root'
2018-03-14 02:51:10,184 [salt.loaded.int.module.cmdmod][INFO    ][2158] Executing command 'sysctl -w net.ipv4.tcp_max_syn_backlog="8192"' in directory '/root'
2018-03-14 02:51:10,201 [salt.state       ][INFO    ][2158] {'net.ipv4.tcp_max_syn_backlog': 8192}
2018-03-14 02:51:10,202 [salt.state       ][INFO    ][2158] Completed state [net.ipv4.tcp_max_syn_backlog] at time 02:51:10.202232 duration_in_ms=53.626
2018-03-14 02:51:10,203 [salt.state       ][INFO    ][2158] Running state [net.ipv4.tcp_tw_reuse] at time 02:51:10.203078
2018-03-14 02:51:10,203 [salt.state       ][INFO    ][2158] Executing state sysctl.present for net.ipv4.tcp_tw_reuse
2018-03-14 02:51:10,205 [salt.loaded.int.module.cmdmod][INFO    ][2158] Executing command 'sysctl -a' in directory '/root'
2018-03-14 02:51:10,294 [salt.loaded.int.module.cmdmod][INFO    ][2158] Executing command 'sysctl -w net.ipv4.tcp_tw_reuse="1"' in directory '/root'
2018-03-14 02:51:10,313 [salt.state       ][INFO    ][2158] {'net.ipv4.tcp_tw_reuse': 1}
2018-03-14 02:51:10,314 [salt.state       ][INFO    ][2158] Completed state [net.ipv4.tcp_tw_reuse] at time 02:51:10.314354 duration_in_ms=111.275
2018-03-14 02:51:10,315 [salt.state       ][INFO    ][2158] Running state [net.ipv4.tcp_congestion_control] at time 02:51:10.315186
2018-03-14 02:51:10,315 [salt.state       ][INFO    ][2158] Executing state sysctl.present for net.ipv4.tcp_congestion_control
2018-03-14 02:51:10,317 [salt.loaded.int.module.cmdmod][INFO    ][2158] Executing command 'sysctl -a' in directory '/root'
2018-03-14 02:51:10,354 [salt.loaded.int.module.cmdmod][INFO    ][2158] Executing command 'sysctl -w net.ipv4.tcp_congestion_control="yeah"' in directory '/root'
2018-03-14 02:51:10,464 [salt.state       ][INFO    ][2158] {'net.ipv4.tcp_congestion_control': 'yeah'}
2018-03-14 02:51:10,465 [salt.state       ][INFO    ][2158] Completed state [net.ipv4.tcp_congestion_control] at time 02:51:10.464865 duration_in_ms=149.678
2018-03-14 02:51:10,465 [salt.state       ][INFO    ][2158] Running state [net.ipv4.tcp_retries2] at time 02:51:10.465603
2018-03-14 02:51:10,466 [salt.state       ][INFO    ][2158] Executing state sysctl.present for net.ipv4.tcp_retries2
2018-03-14 02:51:10,467 [salt.loaded.int.module.cmdmod][INFO    ][2158] Executing command 'sysctl -a' in directory '/root'
2018-03-14 02:51:10,515 [salt.loaded.int.module.cmdmod][INFO    ][2158] Executing command 'sysctl -w net.ipv4.tcp_retries2="5"' in directory '/root'
2018-03-14 02:51:10,532 [salt.state       ][INFO    ][2158] {'net.ipv4.tcp_retries2': 5}
2018-03-14 02:51:10,532 [salt.state       ][INFO    ][2158] Completed state [net.ipv4.tcp_retries2] at time 02:51:10.532439 duration_in_ms=66.836
2018-03-14 02:51:10,532 [salt.state       ][INFO    ][2158] Running state [net.core.netdev_max_backlog] at time 02:51:10.532817
2018-03-14 02:51:10,533 [salt.state       ][INFO    ][2158] Executing state sysctl.present for net.core.netdev_max_backlog
2018-03-14 02:51:10,533 [salt.loaded.int.module.cmdmod][INFO    ][2158] Executing command 'sysctl -a' in directory '/root'
2018-03-14 02:51:10,661 [salt.loaded.int.module.cmdmod][INFO    ][2158] Executing command 'sysctl -w net.core.netdev_max_backlog="261144"' in directory '/root'
2018-03-14 02:51:10,686 [salt.state       ][INFO    ][2158] {'net.core.netdev_max_backlog': 261144}
2018-03-14 02:51:10,687 [salt.state       ][INFO    ][2158] Completed state [net.core.netdev_max_backlog] at time 02:51:10.687304 duration_in_ms=154.486
2018-03-14 02:51:10,687 [salt.state       ][INFO    ][2158] Running state [net.ipv4.tcp_slow_start_after_idle] at time 02:51:10.687732
2018-03-14 02:51:10,688 [salt.state       ][INFO    ][2158] Executing state sysctl.present for net.ipv4.tcp_slow_start_after_idle
2018-03-14 02:51:10,689 [salt.loaded.int.module.cmdmod][INFO    ][2158] Executing command 'sysctl -a' in directory '/root'
2018-03-14 02:51:10,728 [salt.loaded.int.module.cmdmod][INFO    ][2158] Executing command 'sysctl -w net.ipv4.tcp_slow_start_after_idle="0"' in directory '/root'
2018-03-14 02:51:10,750 [salt.state       ][INFO    ][2158] {'net.ipv4.tcp_slow_start_after_idle': 0}
2018-03-14 02:51:10,752 [salt.state       ][INFO    ][2158] Completed state [net.ipv4.tcp_slow_start_after_idle] at time 02:51:10.751876 duration_in_ms=64.143
2018-03-14 02:51:10,753 [salt.state       ][INFO    ][2158] Running state [vm.swappiness] at time 02:51:10.753113
2018-03-14 02:51:10,754 [salt.state       ][INFO    ][2158] Executing state sysctl.present for vm.swappiness
2018-03-14 02:51:10,756 [salt.loaded.int.module.cmdmod][INFO    ][2158] Executing command 'sysctl -a' in directory '/root'
2018-03-14 02:51:10,809 [salt.loaded.int.module.cmdmod][INFO    ][2158] Executing command 'sysctl -w vm.swappiness="10"' in directory '/root'
2018-03-14 02:51:10,828 [salt.state       ][INFO    ][2158] {'vm.swappiness': 10}
2018-03-14 02:51:10,828 [salt.state       ][INFO    ][2158] Completed state [vm.swappiness] at time 02:51:10.828896 duration_in_ms=75.783
2018-03-14 02:51:10,829 [salt.state       ][INFO    ][2158] Running state [net.ipv4.tcp_keepalive_intvl] at time 02:51:10.829470
2018-03-14 02:51:10,830 [salt.state       ][INFO    ][2158] Executing state sysctl.present for net.ipv4.tcp_keepalive_intvl
2018-03-14 02:51:10,830 [salt.loaded.int.module.cmdmod][INFO    ][2158] Executing command 'sysctl -a' in directory '/root'
2018-03-14 02:51:10,901 [salt.loaded.int.module.cmdmod][INFO    ][2158] Executing command 'sysctl -w net.ipv4.tcp_keepalive_intvl="3"' in directory '/root'
2018-03-14 02:51:10,919 [salt.state       ][INFO    ][2158] {'net.ipv4.tcp_keepalive_intvl': 3}
2018-03-14 02:51:10,920 [salt.state       ][INFO    ][2158] Completed state [net.ipv4.tcp_keepalive_intvl] at time 02:51:10.920712 duration_in_ms=91.241
2018-03-14 02:51:10,921 [salt.state       ][INFO    ][2158] Running state [net.ipv4.neigh.default.gc_thresh1] at time 02:51:10.921437
2018-03-14 02:51:10,922 [salt.state       ][INFO    ][2158] Executing state sysctl.present for net.ipv4.neigh.default.gc_thresh1
2018-03-14 02:51:10,923 [salt.loaded.int.module.cmdmod][INFO    ][2158] Executing command 'sysctl -a' in directory '/root'
2018-03-14 02:51:10,958 [salt.loaded.int.module.cmdmod][INFO    ][2158] Executing command 'sysctl -w net.ipv4.neigh.default.gc_thresh1="4096"' in directory '/root'
2018-03-14 02:51:10,975 [salt.state       ][INFO    ][2158] {'net.ipv4.neigh.default.gc_thresh1': 4096}
2018-03-14 02:51:10,976 [salt.state       ][INFO    ][2158] Completed state [net.ipv4.neigh.default.gc_thresh1] at time 02:51:10.975969 duration_in_ms=54.532
2018-03-14 02:51:10,976 [salt.state       ][INFO    ][2158] Running state [net.ipv4.neigh.default.gc_thresh2] at time 02:51:10.976580
2018-03-14 02:51:10,977 [salt.state       ][INFO    ][2158] Executing state sysctl.present for net.ipv4.neigh.default.gc_thresh2
2018-03-14 02:51:10,978 [salt.loaded.int.module.cmdmod][INFO    ][2158] Executing command 'sysctl -a' in directory '/root'
2018-03-14 02:51:10,994 [salt.minion      ][INFO    ][1939] User sudo_ubuntu Executing command saltutil.find_job with jid 20180314025110984479
2018-03-14 02:51:11,014 [salt.minion      ][INFO    ][3705] Starting a new job with PID 3705
2018-03-14 02:51:11,029 [salt.minion      ][INFO    ][3705] Returning information for job: 20180314025110984479
2018-03-14 02:51:11,039 [salt.loaded.int.module.cmdmod][INFO    ][2158] Executing command 'sysctl -w net.ipv4.neigh.default.gc_thresh2="8192"' in directory '/root'
2018-03-14 02:51:11,053 [salt.state       ][INFO    ][2158] {'net.ipv4.neigh.default.gc_thresh2': 8192}
2018-03-14 02:51:11,054 [salt.state       ][INFO    ][2158] Completed state [net.ipv4.neigh.default.gc_thresh2] at time 02:51:11.054305 duration_in_ms=77.725
2018-03-14 02:51:11,054 [salt.state       ][INFO    ][2158] Running state [net.ipv4.neigh.default.gc_thresh3] at time 02:51:11.054875
2018-03-14 02:51:11,055 [salt.state       ][INFO    ][2158] Executing state sysctl.present for net.ipv4.neigh.default.gc_thresh3
2018-03-14 02:51:11,056 [salt.loaded.int.module.cmdmod][INFO    ][2158] Executing command 'sysctl -a' in directory '/root'
2018-03-14 02:51:11,153 [salt.loaded.int.module.cmdmod][INFO    ][2158] Executing command 'sysctl -w net.ipv4.neigh.default.gc_thresh3="16384"' in directory '/root'
2018-03-14 02:51:11,180 [salt.state       ][INFO    ][2158] {'net.ipv4.neigh.default.gc_thresh3': 16384}
2018-03-14 02:51:11,181 [salt.state       ][INFO    ][2158] Completed state [net.ipv4.neigh.default.gc_thresh3] at time 02:51:11.180840 duration_in_ms=125.962
2018-03-14 02:51:11,182 [salt.state       ][INFO    ][2158] Running state [net.ipv4.tcp_fin_timeout] at time 02:51:11.182014
2018-03-14 02:51:11,183 [salt.state       ][INFO    ][2158] Executing state sysctl.present for net.ipv4.tcp_fin_timeout
2018-03-14 02:51:11,184 [salt.loaded.int.module.cmdmod][INFO    ][2158] Executing command 'sysctl -a' in directory '/root'
2018-03-14 02:51:11,291 [salt.loaded.int.module.cmdmod][INFO    ][2158] Executing command 'sysctl -w net.ipv4.tcp_fin_timeout="30"' in directory '/root'
2018-03-14 02:51:11,317 [salt.state       ][INFO    ][2158] {'net.ipv4.tcp_fin_timeout': 30}
2018-03-14 02:51:11,318 [salt.state       ][INFO    ][2158] Completed state [net.ipv4.tcp_fin_timeout] at time 02:51:11.318448 duration_in_ms=136.435
2018-03-14 02:51:11,319 [salt.state       ][INFO    ][2158] Running state [net.ipv4.tcp_keepalive_time] at time 02:51:11.319245
2018-03-14 02:51:11,319 [salt.state       ][INFO    ][2158] Executing state sysctl.present for net.ipv4.tcp_keepalive_time
2018-03-14 02:51:11,321 [salt.loaded.int.module.cmdmod][INFO    ][2158] Executing command 'sysctl -a' in directory '/root'
2018-03-14 02:51:11,476 [salt.loaded.int.module.cmdmod][INFO    ][2158] Executing command 'sysctl -w net.ipv4.tcp_keepalive_time="30"' in directory '/root'
2018-03-14 02:51:11,504 [salt.state       ][INFO    ][2158] {'net.ipv4.tcp_keepalive_time': 30}
2018-03-14 02:51:11,505 [salt.state       ][INFO    ][2158] Completed state [net.ipv4.tcp_keepalive_time] at time 02:51:11.505165 duration_in_ms=185.92
2018-03-14 02:51:11,506 [salt.state       ][INFO    ][2158] Running state [net.nf_conntrack_max] at time 02:51:11.505937
2018-03-14 02:51:11,506 [salt.state       ][INFO    ][2158] Executing state sysctl.present for net.nf_conntrack_max
2018-03-14 02:51:11,508 [salt.loaded.int.module.cmdmod][INFO    ][2158] Executing command 'sysctl -a' in directory '/root'
2018-03-14 02:51:11,572 [salt.loaded.int.module.cmdmod][INFO    ][2158] Executing command 'sysctl -w net.nf_conntrack_max="1048576"' in directory '/root'
2018-03-14 02:51:11,597 [salt.state       ][INFO    ][2158] {'net.nf_conntrack_max': 1048576}
2018-03-14 02:51:11,598 [salt.state       ][INFO    ][2158] Completed state [net.nf_conntrack_max] at time 02:51:11.598280 duration_in_ms=92.341
2018-03-14 02:51:11,599 [salt.state       ][INFO    ][2158] Running state [linux_sysfs_package] at time 02:51:11.599257
2018-03-14 02:51:11,600 [salt.state       ][INFO    ][2158] Executing state pkg.installed for linux_sysfs_package
2018-03-14 02:51:11,628 [salt.loaded.int.module.cmdmod][INFO    ][2158] Executing command ['apt-cache', '-q', 'policy', 'sysfsutils'] in directory '/root'
2018-03-14 02:51:11,719 [salt.loaded.int.module.cmdmod][INFO    ][2158] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2018-03-14 02:51:13,535 [salt.loaded.int.module.cmdmod][INFO    ][2158] Executing command ['dpkg', '--get-selections', '*'] in directory '/root'
2018-03-14 02:51:13,572 [salt.loaded.int.module.cmdmod][INFO    ][2158] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'sysfsutils'] in directory '/root'
2018-03-14 02:51:21,226 [salt.minion      ][INFO    ][1939] User sudo_ubuntu Executing command saltutil.find_job with jid 20180314025121214544
2018-03-14 02:51:21,265 [salt.minion      ][INFO    ][4403] Starting a new job with PID 4403
2018-03-14 02:51:21,441 [salt.minion      ][INFO    ][4403] Returning information for job: 20180314025121214544
2018-03-14 02:51:25,256 [salt.loaded.int.module.cmdmod][INFO    ][2158] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2018-03-14 02:51:25,295 [salt.state       ][INFO    ][2158] Made the following changes:
'libsysfs2' changed from 'absent' to '2.1.0+repack-4'
'sysfsutils' changed from 'absent' to '2.1.0+repack-4'

2018-03-14 02:51:25,312 [salt.state       ][INFO    ][2158] Loading fresh modules for state activity
2018-03-14 02:51:25,334 [salt.state       ][INFO    ][2158] Completed state [linux_sysfs_package] at time 02:51:25.334738 duration_in_ms=13735.481
2018-03-14 02:51:25,338 [salt.state       ][INFO    ][2158] Running state [/etc/sysfs.d] at time 02:51:25.338120
2018-03-14 02:51:25,338 [salt.state       ][INFO    ][2158] Executing state file.directory for /etc/sysfs.d
2018-03-14 02:51:25,341 [salt.state       ][INFO    ][2158] Directory /etc/sysfs.d is in the correct state
2018-03-14 02:51:25,341 [salt.state       ][INFO    ][2158] Completed state [/etc/sysfs.d] at time 02:51:25.341342 duration_in_ms=3.222
2018-03-14 02:51:25,450 [salt.state       ][INFO    ][2158] Running state [ondemand] at time 02:51:25.450203
2018-03-14 02:51:25,450 [salt.state       ][INFO    ][2158] Executing state service.dead for ondemand
2018-03-14 02:51:25,452 [salt.loaded.int.module.cmdmod][INFO    ][2158] Executing command ['systemctl', 'status', 'ondemand.service', '-n', '0'] in directory '/root'
2018-03-14 02:51:25,480 [salt.loaded.int.module.cmdmod][INFO    ][2158] Executing command ['systemctl', 'is-active', 'ondemand.service'] in directory '/root'
2018-03-14 02:51:25,525 [salt.loaded.int.module.cmdmod][INFO    ][2158] Executing command ['systemctl', 'is-enabled', 'ondemand.service'] in directory '/root'
2018-03-14 02:51:25,552 [salt.loaded.int.module.cmdmod][INFO    ][2158] Executing command ['systemd-run', '--scope', 'systemctl', 'stop', 'ondemand.service'] in directory '/root'
2018-03-14 02:51:25,627 [salt.loaded.int.module.cmdmod][INFO    ][2158] Executing command ['systemctl', 'is-active', 'ondemand.service'] in directory '/root'
2018-03-14 02:51:25,646 [salt.loaded.int.module.cmdmod][INFO    ][2158] Executing command ['systemctl', 'is-enabled', 'ondemand.service'] in directory '/root'
2018-03-14 02:51:25,669 [salt.loaded.int.module.cmdmod][INFO    ][2158] Executing command ['systemctl', 'is-enabled', 'ondemand.service'] in directory '/root'
2018-03-14 02:51:25,697 [salt.loaded.int.module.cmdmod][INFO    ][2158] Executing command ['systemd-run', '--scope', '/usr/sbin/update-rc.d', '-f', 'ondemand', 'remove'] in directory '/root'
2018-03-14 02:51:25,841 [salt.loaded.int.module.cmdmod][INFO    ][2158] Executing command ['systemctl', 'is-enabled', 'ondemand.service'] in directory '/root'
2018-03-14 02:51:25,867 [salt.loaded.int.module.cmdmod][INFO    ][2158] Executing command 'runlevel' in directory '/root'
2018-03-14 02:51:25,886 [salt.state       ][INFO    ][2158] {'ondemand': True}
2018-03-14 02:51:25,886 [salt.state       ][INFO    ][2158] Completed state [ondemand] at time 02:51:25.886637 duration_in_ms=436.434
2018-03-14 02:51:25,943 [salt.state       ][INFO    ][2158] Running state [cs_CZ.UTF-8] at time 02:51:25.943761
2018-03-14 02:51:25,944 [salt.state       ][INFO    ][2158] Executing state locale.present for cs_CZ.UTF-8
2018-03-14 02:51:25,945 [salt.loaded.int.module.cmdmod][INFO    ][2158] Executing command 'locale -a' in directory '/root'
2018-03-14 02:51:25,973 [salt.loaded.int.module.cmdmod][INFO    ][2158] Executing command ['locale-gen', 'cs_CZ.utf8'] in directory '/root'
2018-03-14 02:51:26,833 [salt.state       ][INFO    ][2158] {'locale': 'cs_CZ.UTF-8'}
2018-03-14 02:51:26,834 [salt.state       ][INFO    ][2158] Completed state [cs_CZ.UTF-8] at time 02:51:26.834267 duration_in_ms=890.507
2018-03-14 02:51:26,834 [salt.state       ][INFO    ][2158] Running state [en_US.UTF-8] at time 02:51:26.834873
2018-03-14 02:51:26,835 [salt.state       ][INFO    ][2158] Executing state locale.present for en_US.UTF-8
2018-03-14 02:51:26,836 [salt.loaded.int.module.cmdmod][INFO    ][2158] Executing command 'locale -a' in directory '/root'
2018-03-14 02:51:26,851 [salt.state       ][INFO    ][2158] Locale en_US.UTF-8 is already present
2018-03-14 02:51:26,851 [salt.state       ][INFO    ][2158] Completed state [en_US.UTF-8] at time 02:51:26.851742 duration_in_ms=16.869
2018-03-14 02:51:26,853 [salt.state       ][INFO    ][2158] Running state [en_US.UTF-8] at time 02:51:26.853392
2018-03-14 02:51:26,853 [salt.state       ][INFO    ][2158] Executing state locale.system for en_US.UTF-8
2018-03-14 02:51:26,854 [salt.loaded.int.module.cmdmod][INFO    ][2158] Executing command 'localectl' in directory '/root'
2018-03-14 02:51:27,238 [salt.state       ][INFO    ][2158] System locale en_US.UTF-8 already set
2018-03-14 02:51:27,239 [salt.state       ][INFO    ][2158] Completed state [en_US.UTF-8] at time 02:51:27.239189 duration_in_ms=385.796
2018-03-14 02:51:27,275 [salt.state       ][INFO    ][2158] Running state [root] at time 02:51:27.275431
2018-03-14 02:51:27,276 [salt.state       ][INFO    ][2158] Executing state user.present for root
2018-03-14 02:51:27,281 [salt.state       ][INFO    ][2158] User root is present and up to date
2018-03-14 02:51:27,282 [salt.state       ][INFO    ][2158] Completed state [root] at time 02:51:27.281991 duration_in_ms=6.56
2018-03-14 02:51:27,284 [salt.state       ][INFO    ][2158] Running state [/root] at time 02:51:27.284019
2018-03-14 02:51:27,284 [salt.state       ][INFO    ][2158] Executing state file.directory for /root
2018-03-14 02:51:27,285 [salt.state       ][INFO    ][2158] Directory /root is in the correct state
2018-03-14 02:51:27,285 [salt.state       ][INFO    ][2158] Completed state [/root] at time 02:51:27.285909 duration_in_ms=1.889
2018-03-14 02:51:27,286 [salt.state       ][INFO    ][2158] Running state [/etc/sudoers.d/90-salt-user-root] at time 02:51:27.286307
2018-03-14 02:51:27,286 [salt.state       ][INFO    ][2158] Executing state file.absent for /etc/sudoers.d/90-salt-user-root
2018-03-14 02:51:27,287 [salt.state       ][INFO    ][2158] File /etc/sudoers.d/90-salt-user-root is not present
2018-03-14 02:51:27,287 [salt.state       ][INFO    ][2158] Completed state [/etc/sudoers.d/90-salt-user-root] at time 02:51:27.287549 duration_in_ms=1.241
2018-03-14 02:51:27,288 [salt.state       ][INFO    ][2158] Running state [ubuntu] at time 02:51:27.287953
2018-03-14 02:51:27,288 [salt.state       ][INFO    ][2158] Executing state user.present for ubuntu
2018-03-14 02:51:27,293 [salt.state       ][INFO    ][2158] {'passwd': 'XXX-REDACTED-XXX'}
2018-03-14 02:51:27,293 [salt.state       ][INFO    ][2158] Completed state [ubuntu] at time 02:51:27.293321 duration_in_ms=5.367
2018-03-14 02:51:27,294 [salt.state       ][INFO    ][2158] Running state [/home/ubuntu] at time 02:51:27.294755
2018-03-14 02:51:27,295 [salt.state       ][INFO    ][2158] Executing state file.directory for /home/ubuntu
2018-03-14 02:51:27,297 [salt.state       ][INFO    ][2158] {'mode': '0700'}
2018-03-14 02:51:27,297 [salt.state       ][INFO    ][2158] Completed state [/home/ubuntu] at time 02:51:27.297763 duration_in_ms=3.007
2018-03-14 02:51:27,298 [salt.state       ][INFO    ][2158] Running state [/etc/sudoers.d/90-salt-user-ubuntu] at time 02:51:27.298904
2018-03-14 02:51:27,299 [salt.state       ][INFO    ][2158] Executing state file.managed for /etc/sudoers.d/90-salt-user-ubuntu
2018-03-14 02:51:27,329 [salt.fileclient  ][INFO    ][2158] Fetching file from saltenv 'base', ** done ** 'linux/files/sudoer'
2018-03-14 02:51:27,334 [salt.loaded.int.module.cmdmod][INFO    ][2158] Executing command '/usr/sbin/visudo -c -f /tmp/tmpl8e9hq' in directory '/root'
2018-03-14 02:51:27,442 [salt.state       ][INFO    ][2158] File changed:
New file
2018-03-14 02:51:27,442 [salt.state       ][INFO    ][2158] Completed state [/etc/sudoers.d/90-salt-user-ubuntu] at time 02:51:27.442637 duration_in_ms=143.732
2018-03-14 02:51:27,443 [salt.state       ][INFO    ][2158] Running state [/etc/security/limits.d/90-salt-default.conf] at time 02:51:27.443024
2018-03-14 02:51:27,443 [salt.state       ][INFO    ][2158] Executing state file.managed for /etc/security/limits.d/90-salt-default.conf
2018-03-14 02:51:27,497 [salt.fileclient  ][INFO    ][2158] Fetching file from saltenv 'base', ** done ** 'linux/files/limits.conf'
2018-03-14 02:51:27,554 [salt.state       ][INFO    ][2158] File changed:
New file
2018-03-14 02:51:27,554 [salt.state       ][INFO    ][2158] Completed state [/etc/security/limits.d/90-salt-default.conf] at time 02:51:27.554755 duration_in_ms=111.73
2018-03-14 02:51:27,554 [salt.state       ][INFO    ][2158] Running state [/etc/systemd/system.conf.d/90-salt.conf] at time 02:51:27.554966
2018-03-14 02:51:27,555 [salt.state       ][INFO    ][2158] Executing state file.managed for /etc/systemd/system.conf.d/90-salt.conf
2018-03-14 02:51:27,581 [salt.fileclient  ][INFO    ][2158] Fetching file from saltenv 'base', ** done ** 'linux/files/systemd.conf'
2018-03-14 02:51:27,642 [salt.state       ][INFO    ][2158] File changed:
New file
2018-03-14 02:51:27,643 [salt.state       ][INFO    ][2158] Completed state [/etc/systemd/system.conf.d/90-salt.conf] at time 02:51:27.643132 duration_in_ms=88.164
2018-03-14 02:51:27,644 [salt.state       ][INFO    ][2158] Running state [service.systemctl_reload] at time 02:51:27.644383
2018-03-14 02:51:27,644 [salt.state       ][INFO    ][2158] Executing state module.wait for service.systemctl_reload
2018-03-14 02:51:27,644 [salt.state       ][INFO    ][2158] No changes made for service.systemctl_reload
2018-03-14 02:51:27,645 [salt.state       ][INFO    ][2158] Completed state [service.systemctl_reload] at time 02:51:27.644967 duration_in_ms=0.584
2018-03-14 02:51:27,645 [salt.state       ][INFO    ][2158] Running state [service.systemctl_reload] at time 02:51:27.645123
2018-03-14 02:51:27,645 [salt.state       ][INFO    ][2158] Executing state module.mod_watch for service.systemctl_reload
2018-03-14 02:51:27,645 [salt.loaded.int.module.cmdmod][INFO    ][2158] Executing command ['systemctl', '--system', 'daemon-reload'] in directory '/root'
2018-03-14 02:51:27,718 [salt.state       ][INFO    ][2158] {'ret': True}
2018-03-14 02:51:27,719 [salt.state       ][INFO    ][2158] Completed state [service.systemctl_reload] at time 02:51:27.718960 duration_in_ms=73.837
2018-03-14 02:51:27,719 [salt.state       ][INFO    ][2158] Running state [/etc/hostname] at time 02:51:27.719506
2018-03-14 02:51:27,719 [salt.state       ][INFO    ][2158] Executing state file.managed for /etc/hostname
2018-03-14 02:51:27,747 [salt.fileclient  ][INFO    ][2158] Fetching file from saltenv 'base', ** done ** 'linux/files/hostname'
2018-03-14 02:51:27,751 [salt.state       ][INFO    ][2158] File changed:
--- 
+++ 
@@ -1 +1 @@
-ubuntu
+dbs02

2018-03-14 02:51:27,751 [salt.state       ][INFO    ][2158] Completed state [/etc/hostname] at time 02:51:27.751215 duration_in_ms=31.709
2018-03-14 02:51:27,753 [salt.state       ][INFO    ][2158] Running state [hostname dbs02] at time 02:51:27.753468
2018-03-14 02:51:27,753 [salt.state       ][INFO    ][2158] Executing state cmd.wait for hostname dbs02
2018-03-14 02:51:27,753 [salt.state       ][INFO    ][2158] No changes made for hostname dbs02
2018-03-14 02:51:27,754 [salt.state       ][INFO    ][2158] Completed state [hostname dbs02] at time 02:51:27.754073 duration_in_ms=0.605
2018-03-14 02:51:27,754 [salt.state       ][INFO    ][2158] Running state [hostname dbs02] at time 02:51:27.754229
2018-03-14 02:51:27,754 [salt.state       ][INFO    ][2158] Executing state cmd.mod_watch for hostname dbs02
2018-03-14 02:51:27,755 [salt.loaded.int.module.cmdmod][INFO    ][2158] Executing command 'hostname dbs02' in directory '/root'
2018-03-14 02:51:27,767 [salt.state       ][INFO    ][2158] {'pid': 4612, 'retcode': 0, 'stderr': '', 'stdout': ''}
2018-03-14 02:51:27,768 [salt.state       ][INFO    ][2158] Completed state [hostname dbs02] at time 02:51:27.768104 duration_in_ms=13.873
2018-03-14 02:51:27,776 [salt.state       ][INFO    ][2158] Running state [mdb02] at time 02:51:27.776071
2018-03-14 02:51:27,776 [salt.state       ][INFO    ][2158] Executing state host.present for mdb02
2018-03-14 02:51:27,777 [salt.state       ][INFO    ][2158] {'host': 'mdb02'}
2018-03-14 02:51:27,777 [salt.state       ][INFO    ][2158] Completed state [mdb02] at time 02:51:27.777652 duration_in_ms=1.582
2018-03-14 02:51:27,777 [salt.state       ][INFO    ][2158] Running state [mdb02.mcp-pike-odl-ha.local] at time 02:51:27.777862
2018-03-14 02:51:27,778 [salt.state       ][INFO    ][2158] Executing state host.present for mdb02.mcp-pike-odl-ha.local
2018-03-14 02:51:27,784 [salt.state       ][INFO    ][2158] {'host': 'mdb02.mcp-pike-odl-ha.local'}
2018-03-14 02:51:27,784 [salt.state       ][INFO    ][2158] Completed state [mdb02.mcp-pike-odl-ha.local] at time 02:51:27.784888 duration_in_ms=7.026
2018-03-14 02:51:27,785 [salt.state       ][INFO    ][2158] Running state [mdb03] at time 02:51:27.785125
2018-03-14 02:51:27,785 [salt.state       ][INFO    ][2158] Executing state host.present for mdb03
2018-03-14 02:51:27,790 [salt.state       ][INFO    ][2158] {'host': 'mdb03'}
2018-03-14 02:51:27,790 [salt.state       ][INFO    ][2158] Completed state [mdb03] at time 02:51:27.790495 duration_in_ms=5.37
2018-03-14 02:51:27,790 [salt.state       ][INFO    ][2158] Running state [mdb03.mcp-pike-odl-ha.local] at time 02:51:27.790685
2018-03-14 02:51:27,790 [salt.state       ][INFO    ][2158] Executing state host.present for mdb03.mcp-pike-odl-ha.local
2018-03-14 02:51:27,796 [salt.state       ][INFO    ][2158] {'host': 'mdb03.mcp-pike-odl-ha.local'}
2018-03-14 02:51:27,796 [salt.state       ][INFO    ][2158] Completed state [mdb03.mcp-pike-odl-ha.local] at time 02:51:27.796845 duration_in_ms=6.158
2018-03-14 02:51:27,797 [salt.state       ][INFO    ][2158] Running state [mdb01] at time 02:51:27.797074
2018-03-14 02:51:27,797 [salt.state       ][INFO    ][2158] Executing state host.present for mdb01
2018-03-14 02:51:27,802 [salt.state       ][INFO    ][2158] {'host': 'mdb01'}
2018-03-14 02:51:27,802 [salt.state       ][INFO    ][2158] Completed state [mdb01] at time 02:51:27.802509 duration_in_ms=5.434
2018-03-14 02:51:27,802 [salt.state       ][INFO    ][2158] Running state [mdb01.mcp-pike-odl-ha.local] at time 02:51:27.802697
2018-03-14 02:51:27,802 [salt.state       ][INFO    ][2158] Executing state host.present for mdb01.mcp-pike-odl-ha.local
2018-03-14 02:51:27,809 [salt.state       ][INFO    ][2158] {'host': 'mdb01.mcp-pike-odl-ha.local'}
2018-03-14 02:51:27,809 [salt.state       ][INFO    ][2158] Completed state [mdb01.mcp-pike-odl-ha.local] at time 02:51:27.809470 duration_in_ms=6.773
2018-03-14 02:51:27,809 [salt.state       ][INFO    ][2158] Running state [mdb] at time 02:51:27.809699
2018-03-14 02:51:27,809 [salt.state       ][INFO    ][2158] Executing state host.present for mdb
2018-03-14 02:51:27,815 [salt.state       ][INFO    ][2158] {'host': 'mdb'}
2018-03-14 02:51:27,815 [salt.state       ][INFO    ][2158] Completed state [mdb] at time 02:51:27.815409 duration_in_ms=5.709
2018-03-14 02:51:27,815 [salt.state       ][INFO    ][2158] Running state [mdb.mcp-pike-odl-ha.local] at time 02:51:27.815628
2018-03-14 02:51:27,815 [salt.state       ][INFO    ][2158] Executing state host.present for mdb.mcp-pike-odl-ha.local
2018-03-14 02:51:27,821 [salt.state       ][INFO    ][2158] {'host': 'mdb.mcp-pike-odl-ha.local'}
2018-03-14 02:51:27,821 [salt.state       ][INFO    ][2158] Completed state [mdb.mcp-pike-odl-ha.local] at time 02:51:27.821233 duration_in_ms=5.606
2018-03-14 02:51:27,821 [salt.state       ][INFO    ][2158] Running state [cfg01] at time 02:51:27.821456
2018-03-14 02:51:27,821 [salt.state       ][INFO    ][2158] Executing state host.present for cfg01
2018-03-14 02:51:27,827 [salt.state       ][INFO    ][2158] {'host': 'cfg01'}
2018-03-14 02:51:27,827 [salt.state       ][INFO    ][2158] Completed state [cfg01] at time 02:51:27.827233 duration_in_ms=5.777
2018-03-14 02:51:27,827 [salt.state       ][INFO    ][2158] Running state [cfg01.mcp-pike-odl-ha.local] at time 02:51:27.827447
2018-03-14 02:51:27,827 [salt.state       ][INFO    ][2158] Executing state host.present for cfg01.mcp-pike-odl-ha.local
2018-03-14 02:51:27,833 [salt.state       ][INFO    ][2158] {'host': 'cfg01.mcp-pike-odl-ha.local'}
2018-03-14 02:51:27,833 [salt.state       ][INFO    ][2158] Completed state [cfg01.mcp-pike-odl-ha.local] at time 02:51:27.833489 duration_in_ms=6.042
2018-03-14 02:51:27,833 [salt.state       ][INFO    ][2158] Running state [prx01] at time 02:51:27.833710
2018-03-14 02:51:27,833 [salt.state       ][INFO    ][2158] Executing state host.present for prx01
2018-03-14 02:51:27,838 [salt.state       ][INFO    ][2158] {'host': 'prx01'}
2018-03-14 02:51:27,839 [salt.state       ][INFO    ][2158] Completed state [prx01] at time 02:51:27.839152 duration_in_ms=5.443
2018-03-14 02:51:27,839 [salt.state       ][INFO    ][2158] Running state [prx01.mcp-pike-odl-ha.local] at time 02:51:27.839338
2018-03-14 02:51:27,839 [salt.state       ][INFO    ][2158] Executing state host.present for prx01.mcp-pike-odl-ha.local
2018-03-14 02:51:27,845 [salt.state       ][INFO    ][2158] {'host': 'prx01.mcp-pike-odl-ha.local'}
2018-03-14 02:51:27,845 [salt.state       ][INFO    ][2158] Completed state [prx01.mcp-pike-odl-ha.local] at time 02:51:27.845494 duration_in_ms=6.156
2018-03-14 02:51:27,845 [salt.state       ][INFO    ][2158] Running state [kvm01] at time 02:51:27.845722
2018-03-14 02:51:27,845 [salt.state       ][INFO    ][2158] Executing state host.present for kvm01
2018-03-14 02:51:27,851 [salt.state       ][INFO    ][2158] {'host': 'kvm01'}
2018-03-14 02:51:27,851 [salt.state       ][INFO    ][2158] Completed state [kvm01] at time 02:51:27.851179 duration_in_ms=5.457
2018-03-14 02:51:27,851 [salt.state       ][INFO    ][2158] Running state [kvm01.mcp-pike-odl-ha.local] at time 02:51:27.851362
2018-03-14 02:51:27,851 [salt.state       ][INFO    ][2158] Executing state host.present for kvm01.mcp-pike-odl-ha.local
2018-03-14 02:51:27,857 [salt.state       ][INFO    ][2158] {'host': 'kvm01.mcp-pike-odl-ha.local'}
2018-03-14 02:51:27,857 [salt.state       ][INFO    ][2158] Completed state [kvm01.mcp-pike-odl-ha.local] at time 02:51:27.857484 duration_in_ms=6.122
2018-03-14 02:51:27,857 [salt.state       ][INFO    ][2158] Running state [kvm03] at time 02:51:27.857711
2018-03-14 02:51:27,857 [salt.state       ][INFO    ][2158] Executing state host.present for kvm03
2018-03-14 02:51:27,863 [salt.state       ][INFO    ][2158] {'host': 'kvm03'}
2018-03-14 02:51:27,863 [salt.state       ][INFO    ][2158] Completed state [kvm03] at time 02:51:27.863200 duration_in_ms=5.49
2018-03-14 02:51:27,863 [salt.state       ][INFO    ][2158] Running state [kvm03.mcp-pike-odl-ha.local] at time 02:51:27.863385
2018-03-14 02:51:27,863 [salt.state       ][INFO    ][2158] Executing state host.present for kvm03.mcp-pike-odl-ha.local
2018-03-14 02:51:27,869 [salt.state       ][INFO    ][2158] {'host': 'kvm03.mcp-pike-odl-ha.local'}
2018-03-14 02:51:27,869 [salt.state       ][INFO    ][2158] Completed state [kvm03.mcp-pike-odl-ha.local] at time 02:51:27.869199 duration_in_ms=5.814
2018-03-14 02:51:27,869 [salt.state       ][INFO    ][2158] Running state [kvm02] at time 02:51:27.869390
2018-03-14 02:51:27,869 [salt.state       ][INFO    ][2158] Executing state host.present for kvm02
2018-03-14 02:51:27,875 [salt.state       ][INFO    ][2158] {'host': 'kvm02'}
2018-03-14 02:51:27,875 [salt.state       ][INFO    ][2158] Completed state [kvm02] at time 02:51:27.875204 duration_in_ms=5.814
2018-03-14 02:51:27,875 [salt.state       ][INFO    ][2158] Running state [kvm02.mcp-pike-odl-ha.local] at time 02:51:27.875386
2018-03-14 02:51:27,875 [salt.state       ][INFO    ][2158] Executing state host.present for kvm02.mcp-pike-odl-ha.local
2018-03-14 02:51:27,941 [salt.state       ][INFO    ][2158] {'host': 'kvm02.mcp-pike-odl-ha.local'}
2018-03-14 02:51:27,941 [salt.state       ][INFO    ][2158] Completed state [kvm02.mcp-pike-odl-ha.local] at time 02:51:27.941663 duration_in_ms=66.275
2018-03-14 02:51:27,942 [salt.state       ][INFO    ][2158] Running state [dbs] at time 02:51:27.941986
2018-03-14 02:51:27,942 [salt.state       ][INFO    ][2158] Executing state host.present for dbs
2018-03-14 02:51:27,947 [salt.state       ][INFO    ][2158] {'host': 'dbs'}
2018-03-14 02:51:27,947 [salt.state       ][INFO    ][2158] Completed state [dbs] at time 02:51:27.947464 duration_in_ms=5.478
2018-03-14 02:51:27,947 [salt.state       ][INFO    ][2158] Running state [dbs.mcp-pike-odl-ha.local] at time 02:51:27.947769
2018-03-14 02:51:27,948 [salt.state       ][INFO    ][2158] Executing state host.present for dbs.mcp-pike-odl-ha.local
2018-03-14 02:51:27,953 [salt.state       ][INFO    ][2158] {'host': 'dbs.mcp-pike-odl-ha.local'}
2018-03-14 02:51:27,953 [salt.state       ][INFO    ][2158] Completed state [dbs.mcp-pike-odl-ha.local] at time 02:51:27.953355 duration_in_ms=5.587
2018-03-14 02:51:27,953 [salt.state       ][INFO    ][2158] Running state [prx] at time 02:51:27.953742
2018-03-14 02:51:27,954 [salt.state       ][INFO    ][2158] Executing state host.present for prx
2018-03-14 02:51:27,959 [salt.state       ][INFO    ][2158] {'host': 'prx'}
2018-03-14 02:51:27,959 [salt.state       ][INFO    ][2158] Completed state [prx] at time 02:51:27.959303 duration_in_ms=5.562
2018-03-14 02:51:27,959 [salt.state       ][INFO    ][2158] Running state [prx.mcp-pike-odl-ha.local] at time 02:51:27.959599
2018-03-14 02:51:27,959 [salt.state       ][INFO    ][2158] Executing state host.present for prx.mcp-pike-odl-ha.local
2018-03-14 02:51:27,964 [salt.state       ][INFO    ][2158] {'host': 'prx.mcp-pike-odl-ha.local'}
2018-03-14 02:51:27,964 [salt.state       ][INFO    ][2158] Completed state [prx.mcp-pike-odl-ha.local] at time 02:51:27.964436 duration_in_ms=4.837
2018-03-14 02:51:27,964 [salt.state       ][INFO    ][2158] Running state [prx02] at time 02:51:27.964721
2018-03-14 02:51:27,965 [salt.state       ][INFO    ][2158] Executing state host.present for prx02
2018-03-14 02:51:27,970 [salt.state       ][INFO    ][2158] {'host': 'prx02'}
2018-03-14 02:51:27,970 [salt.state       ][INFO    ][2158] Completed state [prx02] at time 02:51:27.970342 duration_in_ms=5.621
2018-03-14 02:51:27,970 [salt.state       ][INFO    ][2158] Running state [prx02.mcp-pike-odl-ha.local] at time 02:51:27.970629
2018-03-14 02:51:27,970 [salt.state       ][INFO    ][2158] Executing state host.present for prx02.mcp-pike-odl-ha.local
2018-03-14 02:51:27,976 [salt.state       ][INFO    ][2158] {'host': 'prx02.mcp-pike-odl-ha.local'}
2018-03-14 02:51:27,976 [salt.state       ][INFO    ][2158] Completed state [prx02.mcp-pike-odl-ha.local] at time 02:51:27.976360 duration_in_ms=5.731
2018-03-14 02:51:27,976 [salt.state       ][INFO    ][2158] Running state [msg02] at time 02:51:27.976634
2018-03-14 02:51:27,976 [salt.state       ][INFO    ][2158] Executing state host.present for msg02
2018-03-14 02:51:27,982 [salt.state       ][INFO    ][2158] {'host': 'msg02'}
2018-03-14 02:51:27,982 [salt.state       ][INFO    ][2158] Completed state [msg02] at time 02:51:27.982347 duration_in_ms=5.713
2018-03-14 02:51:27,982 [salt.state       ][INFO    ][2158] Running state [msg02.mcp-pike-odl-ha.local] at time 02:51:27.982634
2018-03-14 02:51:27,982 [salt.state       ][INFO    ][2158] Executing state host.present for msg02.mcp-pike-odl-ha.local
2018-03-14 02:51:27,988 [salt.state       ][INFO    ][2158] {'host': 'msg02.mcp-pike-odl-ha.local'}
2018-03-14 02:51:27,988 [salt.state       ][INFO    ][2158] Completed state [msg02.mcp-pike-odl-ha.local] at time 02:51:27.988681 duration_in_ms=6.046
2018-03-14 02:51:27,989 [salt.state       ][INFO    ][2158] Running state [msg03] at time 02:51:27.988995
2018-03-14 02:51:27,989 [salt.state       ][INFO    ][2158] Executing state host.present for msg03
2018-03-14 02:51:27,994 [salt.state       ][INFO    ][2158] {'host': 'msg03'}
2018-03-14 02:51:27,994 [salt.state       ][INFO    ][2158] Completed state [msg03] at time 02:51:27.994345 duration_in_ms=5.35
2018-03-14 02:51:27,994 [salt.state       ][INFO    ][2158] Running state [msg03.mcp-pike-odl-ha.local] at time 02:51:27.994636
2018-03-14 02:51:27,994 [salt.state       ][INFO    ][2158] Executing state host.present for msg03.mcp-pike-odl-ha.local
2018-03-14 02:51:28,000 [salt.state       ][INFO    ][2158] {'host': 'msg03.mcp-pike-odl-ha.local'}
2018-03-14 02:51:28,000 [salt.state       ][INFO    ][2158] Completed state [msg03.mcp-pike-odl-ha.local] at time 02:51:28.000589 duration_in_ms=5.953
2018-03-14 02:51:28,000 [salt.state       ][INFO    ][2158] Running state [msg01] at time 02:51:28.000903
2018-03-14 02:51:28,001 [salt.state       ][INFO    ][2158] Executing state host.present for msg01
2018-03-14 02:51:28,006 [salt.state       ][INFO    ][2158] {'host': 'msg01'}
2018-03-14 02:51:28,006 [salt.state       ][INFO    ][2158] Completed state [msg01] at time 02:51:28.006563 duration_in_ms=5.66
2018-03-14 02:51:28,006 [salt.state       ][INFO    ][2158] Running state [msg01.mcp-pike-odl-ha.local] at time 02:51:28.006835
2018-03-14 02:51:28,007 [salt.state       ][INFO    ][2158] Executing state host.present for msg01.mcp-pike-odl-ha.local
2018-03-14 02:51:28,012 [salt.state       ][INFO    ][2158] {'host': 'msg01.mcp-pike-odl-ha.local'}
2018-03-14 02:51:28,012 [salt.state       ][INFO    ][2158] Completed state [msg01.mcp-pike-odl-ha.local] at time 02:51:28.012526 duration_in_ms=5.691
2018-03-14 02:51:28,012 [salt.state       ][INFO    ][2158] Running state [msg] at time 02:51:28.012813
2018-03-14 02:51:28,013 [salt.state       ][INFO    ][2158] Executing state host.present for msg
2018-03-14 02:51:28,018 [salt.state       ][INFO    ][2158] {'host': 'msg'}
2018-03-14 02:51:28,018 [salt.state       ][INFO    ][2158] Completed state [msg] at time 02:51:28.018549 duration_in_ms=5.736
2018-03-14 02:51:28,018 [salt.state       ][INFO    ][2158] Running state [msg.mcp-pike-odl-ha.local] at time 02:51:28.018826
2018-03-14 02:51:28,019 [salt.state       ][INFO    ][2158] Executing state host.present for msg.mcp-pike-odl-ha.local
2018-03-14 02:51:28,024 [salt.state       ][INFO    ][2158] {'host': 'msg.mcp-pike-odl-ha.local'}
2018-03-14 02:51:28,024 [salt.state       ][INFO    ][2158] Completed state [msg.mcp-pike-odl-ha.local] at time 02:51:28.024579 duration_in_ms=5.752
2018-03-14 02:51:28,024 [salt.state       ][INFO    ][2158] Running state [cfg01] at time 02:51:28.024871
2018-03-14 02:51:28,025 [salt.state       ][INFO    ][2158] Executing state host.present for cfg01
2018-03-14 02:51:28,025 [salt.state       ][INFO    ][2158] Host cfg01 (10.167.4.11) already present
2018-03-14 02:51:28,025 [salt.state       ][INFO    ][2158] Completed state [cfg01] at time 02:51:28.025811 duration_in_ms=0.94
2018-03-14 02:51:28,026 [salt.state       ][INFO    ][2158] Running state [cfg01.mcp-pike-odl-ha.local] at time 02:51:28.026056
2018-03-14 02:51:28,026 [salt.state       ][INFO    ][2158] Executing state host.present for cfg01.mcp-pike-odl-ha.local
2018-03-14 02:51:28,026 [salt.state       ][INFO    ][2158] Host cfg01.mcp-pike-odl-ha.local (10.167.4.11) already present
2018-03-14 02:51:28,026 [salt.state       ][INFO    ][2158] Completed state [cfg01.mcp-pike-odl-ha.local] at time 02:51:28.026953 duration_in_ms=0.897
2018-03-14 02:51:28,027 [salt.state       ][INFO    ][2158] Running state [cmp002] at time 02:51:28.027187
2018-03-14 02:51:28,027 [salt.state       ][INFO    ][2158] Executing state host.present for cmp002
2018-03-14 02:51:28,030 [salt.state       ][INFO    ][2158] {'host': 'cmp002'}
2018-03-14 02:51:28,030 [salt.state       ][INFO    ][2158] Completed state [cmp002] at time 02:51:28.030712 duration_in_ms=3.525
2018-03-14 02:51:28,031 [salt.state       ][INFO    ][2158] Running state [cmp002.mcp-pike-odl-ha.local] at time 02:51:28.030992
2018-03-14 02:51:28,031 [salt.state       ][INFO    ][2158] Executing state host.present for cmp002.mcp-pike-odl-ha.local
2018-03-14 02:51:28,036 [salt.state       ][INFO    ][2158] {'host': 'cmp002.mcp-pike-odl-ha.local'}
2018-03-14 02:51:28,036 [salt.state       ][INFO    ][2158] Completed state [cmp002.mcp-pike-odl-ha.local] at time 02:51:28.036548 duration_in_ms=5.556
2018-03-14 02:51:28,036 [salt.state       ][INFO    ][2158] Running state [cmp001] at time 02:51:28.036831
2018-03-14 02:51:28,037 [salt.state       ][INFO    ][2158] Executing state host.present for cmp001
2018-03-14 02:51:28,042 [salt.state       ][INFO    ][2158] {'host': 'cmp001'}
2018-03-14 02:51:28,042 [salt.state       ][INFO    ][2158] Completed state [cmp001] at time 02:51:28.042779 duration_in_ms=5.947
2018-03-14 02:51:28,043 [salt.state       ][INFO    ][2158] Running state [cmp001.mcp-pike-odl-ha.local] at time 02:51:28.043040
2018-03-14 02:51:28,043 [salt.state       ][INFO    ][2158] Executing state host.present for cmp001.mcp-pike-odl-ha.local
2018-03-14 02:51:28,048 [salt.state       ][INFO    ][2158] {'host': 'cmp001.mcp-pike-odl-ha.local'}
2018-03-14 02:51:28,048 [salt.state       ][INFO    ][2158] Completed state [cmp001.mcp-pike-odl-ha.local] at time 02:51:28.048570 duration_in_ms=5.53
2018-03-14 02:51:28,048 [salt.state       ][INFO    ][2158] Running state [dbs01] at time 02:51:28.048831
2018-03-14 02:51:28,049 [salt.state       ][INFO    ][2158] Executing state host.present for dbs01
2018-03-14 02:51:28,054 [salt.state       ][INFO    ][2158] {'host': 'dbs01'}
2018-03-14 02:51:28,054 [salt.state       ][INFO    ][2158] Completed state [dbs01] at time 02:51:28.054804 duration_in_ms=5.973
2018-03-14 02:51:28,055 [salt.state       ][INFO    ][2158] Running state [dbs01.mcp-pike-odl-ha.local] at time 02:51:28.055073
2018-03-14 02:51:28,055 [salt.state       ][INFO    ][2158] Executing state host.present for dbs01.mcp-pike-odl-ha.local
2018-03-14 02:51:28,057 [salt.state       ][INFO    ][2158] {'host': 'dbs01.mcp-pike-odl-ha.local'}
2018-03-14 02:51:28,057 [salt.state       ][INFO    ][2158] Completed state [dbs01.mcp-pike-odl-ha.local] at time 02:51:28.057200 duration_in_ms=2.127
2018-03-14 02:51:28,057 [salt.state       ][INFO    ][2158] Running state [dbs02] at time 02:51:28.057423
2018-03-14 02:51:28,057 [salt.state       ][INFO    ][2158] Executing state host.present for dbs02
2018-03-14 02:51:28,063 [salt.state       ][INFO    ][2158] {'host': 'dbs02'}
2018-03-14 02:51:28,063 [salt.state       ][INFO    ][2158] Completed state [dbs02] at time 02:51:28.063220 duration_in_ms=5.797
2018-03-14 02:51:28,063 [salt.state       ][INFO    ][2158] Running state [dbs02.mcp-pike-odl-ha.local] at time 02:51:28.063446
2018-03-14 02:51:28,063 [salt.state       ][INFO    ][2158] Executing state host.present for dbs02.mcp-pike-odl-ha.local
2018-03-14 02:51:28,069 [salt.state       ][INFO    ][2158] {'host': 'dbs02.mcp-pike-odl-ha.local'}
2018-03-14 02:51:28,069 [salt.state       ][INFO    ][2158] Completed state [dbs02.mcp-pike-odl-ha.local] at time 02:51:28.069448 duration_in_ms=6.001
2018-03-14 02:51:28,069 [salt.state       ][INFO    ][2158] Running state [dbs03] at time 02:51:28.069695
2018-03-14 02:51:28,069 [salt.state       ][INFO    ][2158] Executing state host.present for dbs03
2018-03-14 02:51:28,075 [salt.state       ][INFO    ][2158] {'host': 'dbs03'}
2018-03-14 02:51:28,075 [salt.state       ][INFO    ][2158] Completed state [dbs03] at time 02:51:28.075506 duration_in_ms=5.81
2018-03-14 02:51:28,075 [salt.state       ][INFO    ][2158] Running state [dbs03.mcp-pike-odl-ha.local] at time 02:51:28.075758
2018-03-14 02:51:28,075 [salt.state       ][INFO    ][2158] Executing state host.present for dbs03.mcp-pike-odl-ha.local
2018-03-14 02:51:28,081 [salt.state       ][INFO    ][2158] {'host': 'dbs03.mcp-pike-odl-ha.local'}
2018-03-14 02:51:28,081 [salt.state       ][INFO    ][2158] Completed state [dbs03.mcp-pike-odl-ha.local] at time 02:51:28.081296 duration_in_ms=5.537
2018-03-14 02:51:28,081 [salt.state       ][INFO    ][2158] Running state [odl01] at time 02:51:28.081524
2018-03-14 02:51:28,081 [salt.state       ][INFO    ][2158] Executing state host.present for odl01
2018-03-14 02:51:28,087 [salt.state       ][INFO    ][2158] {'host': 'odl01'}
2018-03-14 02:51:28,087 [salt.state       ][INFO    ][2158] Completed state [odl01] at time 02:51:28.087438 duration_in_ms=5.914
2018-03-14 02:51:28,087 [salt.state       ][INFO    ][2158] Running state [odl01.mcp-pike-odl-ha.local] at time 02:51:28.087669
2018-03-14 02:51:28,087 [salt.state       ][INFO    ][2158] Executing state host.present for odl01.mcp-pike-odl-ha.local
2018-03-14 02:51:28,093 [salt.state       ][INFO    ][2158] {'host': 'odl01.mcp-pike-odl-ha.local'}
2018-03-14 02:51:28,093 [salt.state       ][INFO    ][2158] Completed state [odl01.mcp-pike-odl-ha.local] at time 02:51:28.093205 duration_in_ms=5.536
2018-03-14 02:51:28,093 [salt.state       ][INFO    ][2158] Running state [mas01] at time 02:51:28.093415
2018-03-14 02:51:28,093 [salt.state       ][INFO    ][2158] Executing state host.present for mas01
2018-03-14 02:51:28,099 [salt.state       ][INFO    ][2158] {'host': 'mas01'}
2018-03-14 02:51:28,099 [salt.state       ][INFO    ][2158] Completed state [mas01] at time 02:51:28.099417 duration_in_ms=6.002
2018-03-14 02:51:28,099 [salt.state       ][INFO    ][2158] Running state [mas01.mcp-pike-odl-ha.local] at time 02:51:28.099646
2018-03-14 02:51:28,099 [salt.state       ][INFO    ][2158] Executing state host.present for mas01.mcp-pike-odl-ha.local
2018-03-14 02:51:28,105 [salt.state       ][INFO    ][2158] {'host': 'mas01.mcp-pike-odl-ha.local'}
2018-03-14 02:51:28,105 [salt.state       ][INFO    ][2158] Completed state [mas01.mcp-pike-odl-ha.local] at time 02:51:28.105204 duration_in_ms=5.557
2018-03-14 02:51:28,105 [salt.state       ][INFO    ][2158] Running state [ctl02] at time 02:51:28.105409
2018-03-14 02:51:28,105 [salt.state       ][INFO    ][2158] Executing state host.present for ctl02
2018-03-14 02:51:28,111 [salt.state       ][INFO    ][2158] {'host': 'ctl02'}
2018-03-14 02:51:28,111 [salt.state       ][INFO    ][2158] Completed state [ctl02] at time 02:51:28.111199 duration_in_ms=5.789
2018-03-14 02:51:28,111 [salt.state       ][INFO    ][2158] Running state [ctl02.mcp-pike-odl-ha.local] at time 02:51:28.111391
2018-03-14 02:51:28,111 [salt.state       ][INFO    ][2158] Executing state host.present for ctl02.mcp-pike-odl-ha.local
2018-03-14 02:51:28,117 [salt.state       ][INFO    ][2158] {'host': 'ctl02.mcp-pike-odl-ha.local'}
2018-03-14 02:51:28,117 [salt.state       ][INFO    ][2158] Completed state [ctl02.mcp-pike-odl-ha.local] at time 02:51:28.117421 duration_in_ms=6.029
2018-03-14 02:51:28,117 [salt.state       ][INFO    ][2158] Running state [ctl03] at time 02:51:28.117641
2018-03-14 02:51:28,117 [salt.state       ][INFO    ][2158] Executing state host.present for ctl03
2018-03-14 02:51:28,123 [salt.state       ][INFO    ][2158] {'host': 'ctl03'}
2018-03-14 02:51:28,123 [salt.state       ][INFO    ][2158] Completed state [ctl03] at time 02:51:28.123442 duration_in_ms=5.801
2018-03-14 02:51:28,123 [salt.state       ][INFO    ][2158] Running state [ctl03.mcp-pike-odl-ha.local] at time 02:51:28.123663
2018-03-14 02:51:28,123 [salt.state       ][INFO    ][2158] Executing state host.present for ctl03.mcp-pike-odl-ha.local
2018-03-14 02:51:28,129 [salt.state       ][INFO    ][2158] {'host': 'ctl03.mcp-pike-odl-ha.local'}
2018-03-14 02:51:28,129 [salt.state       ][INFO    ][2158] Completed state [ctl03.mcp-pike-odl-ha.local] at time 02:51:28.129219 duration_in_ms=5.556
2018-03-14 02:51:28,129 [salt.state       ][INFO    ][2158] Running state [ctl01] at time 02:51:28.129408
2018-03-14 02:51:28,129 [salt.state       ][INFO    ][2158] Executing state host.present for ctl01
2018-03-14 02:51:28,135 [salt.state       ][INFO    ][2158] {'host': 'ctl01'}
2018-03-14 02:51:28,135 [salt.state       ][INFO    ][2158] Completed state [ctl01] at time 02:51:28.135454 duration_in_ms=6.046
2018-03-14 02:51:28,135 [salt.state       ][INFO    ][2158] Running state [ctl01.mcp-pike-odl-ha.local] at time 02:51:28.135672
2018-03-14 02:51:28,135 [salt.state       ][INFO    ][2158] Executing state host.present for ctl01.mcp-pike-odl-ha.local
2018-03-14 02:51:28,141 [salt.state       ][INFO    ][2158] {'host': 'ctl01.mcp-pike-odl-ha.local'}
2018-03-14 02:51:28,141 [salt.state       ][INFO    ][2158] Completed state [ctl01.mcp-pike-odl-ha.local] at time 02:51:28.141344 duration_in_ms=5.673
2018-03-14 02:51:28,141 [salt.state       ][INFO    ][2158] Running state [ctl] at time 02:51:28.141547
2018-03-14 02:51:28,141 [salt.state       ][INFO    ][2158] Executing state host.present for ctl
2018-03-14 02:51:28,147 [salt.state       ][INFO    ][2158] {'host': 'ctl'}
2018-03-14 02:51:28,147 [salt.state       ][INFO    ][2158] Completed state [ctl] at time 02:51:28.147411 duration_in_ms=5.863
2018-03-14 02:51:28,147 [salt.state       ][INFO    ][2158] Running state [ctl.mcp-pike-odl-ha.local] at time 02:51:28.147608
2018-03-14 02:51:28,147 [salt.state       ][INFO    ][2158] Executing state host.present for ctl.mcp-pike-odl-ha.local
2018-03-14 02:51:28,228 [salt.state       ][INFO    ][2158] {'host': 'ctl.mcp-pike-odl-ha.local'}
2018-03-14 02:51:28,228 [salt.state       ][INFO    ][2158] Completed state [ctl.mcp-pike-odl-ha.local] at time 02:51:28.228375 duration_in_ms=80.766
2018-03-14 02:51:28,228 [salt.state       ][INFO    ][2158] Running state [/etc/network/interfaces.d/50-cloud-init.cfg] at time 02:51:28.228623
2018-03-14 02:51:28,228 [salt.state       ][INFO    ][2158] Executing state file.absent for /etc/network/interfaces.d/50-cloud-init.cfg
2018-03-14 02:51:28,229 [salt.state       ][INFO    ][2158] {'removed': '/etc/network/interfaces.d/50-cloud-init.cfg'}
2018-03-14 02:51:28,229 [salt.state       ][INFO    ][2158] Completed state [/etc/network/interfaces.d/50-cloud-init.cfg] at time 02:51:28.229421 duration_in_ms=0.799
2018-03-14 02:51:28,243 [salt.state       ][INFO    ][2158] Running state [ens2] at time 02:51:28.243794
2018-03-14 02:51:28,244 [salt.state       ][INFO    ][2158] Executing state network.managed for ens2
2018-03-14 02:51:28,405 [salt.loaded.int.module.cmdmod][INFO    ][2158] Executing command ['ifdown', 'ens2'] in directory '/root'
2018-03-14 02:51:29,702 [salt.loaded.int.module.cmdmod][INFO    ][2158] Executing command ['ifup', 'ens2'] in directory '/root'
2018-03-14 02:51:31,385 [salt.minion      ][INFO    ][1939] User sudo_ubuntu Executing command saltutil.find_job with jid 20180314025131373171
2018-03-14 02:51:31,418 [salt.minion      ][INFO    ][4753] Starting a new job with PID 4753
2018-03-14 02:51:31,442 [salt.minion      ][INFO    ][4753] Returning information for job: 20180314025131373171
2018-03-14 02:51:31,555 [salt.state       ][INFO    ][2158] {'interface': 'Added network interface.', 'status': 'Interface ens2 restart to validate'}
2018-03-14 02:51:31,555 [salt.state       ][INFO    ][2158] Completed state [ens2] at time 02:51:31.555801 duration_in_ms=3312.006
2018-03-14 02:51:31,556 [salt.state       ][INFO    ][2158] Running state [ens3] at time 02:51:31.556502
2018-03-14 02:51:31,557 [salt.state       ][INFO    ][2158] Executing state network.managed for ens3
2018-03-14 02:51:31,597 [salt.loaded.int.module.cmdmod][INFO    ][2158] Executing command ['ifup', 'ens3'] in directory '/root'
2018-03-14 02:51:32,188 [salt.state       ][INFO    ][2158] {'interface': 'Added network interface.', 'status': 'Interface ens3 is up'}
2018-03-14 02:51:32,189 [salt.state       ][INFO    ][2158] Completed state [ens3] at time 02:51:32.189100 duration_in_ms=632.598
2018-03-14 02:51:32,189 [salt.state       ][INFO    ][2158] Running state [/etc/profile.d/proxy.sh] at time 02:51:32.189371
2018-03-14 02:51:32,189 [salt.state       ][INFO    ][2158] Executing state file.absent for /etc/profile.d/proxy.sh
2018-03-14 02:51:32,190 [salt.state       ][INFO    ][2158] File /etc/profile.d/proxy.sh is not present
2018-03-14 02:51:32,190 [salt.state       ][INFO    ][2158] Completed state [/etc/profile.d/proxy.sh] at time 02:51:32.190167 duration_in_ms=0.796
2018-03-14 02:51:32,190 [salt.state       ][INFO    ][2158] Running state [/etc/apt/apt.conf.d/95proxies] at time 02:51:32.190344
2018-03-14 02:51:32,190 [salt.state       ][INFO    ][2158] Executing state file.absent for /etc/apt/apt.conf.d/95proxies
2018-03-14 02:51:32,190 [salt.state       ][INFO    ][2158] File /etc/apt/apt.conf.d/95proxies is not present
2018-03-14 02:51:32,190 [salt.state       ][INFO    ][2158] Completed state [/etc/apt/apt.conf.d/95proxies] at time 02:51:32.190949 duration_in_ms=0.605
2018-03-14 02:51:32,194 [salt.state       ][INFO    ][2158] Running state [ntp] at time 02:51:32.194897
2018-03-14 02:51:32,195 [salt.state       ][INFO    ][2158] Executing state pkg.installed for ntp
2018-03-14 02:51:32,611 [salt.loaded.int.module.cmdmod][INFO    ][2158] Executing command ['dpkg', '--get-selections', '*'] in directory '/root'
2018-03-14 02:51:32,637 [salt.loaded.int.module.cmdmod][INFO    ][2158] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'ntp'] in directory '/root'
2018-03-14 02:51:41,503 [salt.minion      ][INFO    ][1939] User sudo_ubuntu Executing command saltutil.find_job with jid 20180314025141490661
2018-03-14 02:51:41,528 [salt.minion      ][INFO    ][5612] Starting a new job with PID 5612
2018-03-14 02:51:41,553 [salt.minion      ][INFO    ][5612] Returning information for job: 20180314025141490661
2018-03-14 02:51:43,043 [salt.loaded.int.module.cmdmod][INFO    ][2158] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2018-03-14 02:51:43,102 [salt.state       ][INFO    ][2158] Made the following changes:
'ntp' changed from 'absent' to '1:4.2.8p4+dfsg-3ubuntu5.8'
'libopts25' changed from 'absent' to '1:5.18.7-3'

2018-03-14 02:51:43,125 [salt.state       ][INFO    ][2158] Loading fresh modules for state activity
2018-03-14 02:51:43,157 [salt.state       ][INFO    ][2158] Completed state [ntp] at time 02:51:43.157344 duration_in_ms=10962.446
2018-03-14 02:51:43,161 [salt.state       ][INFO    ][2158] Running state [/etc/ntp.conf] at time 02:51:43.161510
2018-03-14 02:51:43,162 [salt.state       ][INFO    ][2158] Executing state file.managed for /etc/ntp.conf
2018-03-14 02:51:43,189 [salt.fileclient  ][INFO    ][2158] Fetching file from saltenv 'base', ** done ** 'ntp/files/ntp.conf'
2018-03-14 02:51:43,234 [salt.state       ][INFO    ][2158] File changed:
--- 
+++ 
@@ -1,66 +1,24 @@
-# /etc/ntp.conf, configuration for ntpd; see ntp.conf(5) for help
 
-driftfile /var/lib/ntp/ntp.drift
 
-# Enable this if you want statistics to be logged.
-#statsdir /var/log/ntpstats/
+# ntpd will only synchronize your clock.
 
-statistics loopstats peerstats clockstats
-filegen loopstats file loopstats type day enable
-filegen peerstats file peerstats type day enable
-filegen clockstats file clockstats type day enable
+# For details, see:
+# - the ntp.conf man page
+# - http://support.ntp.org/bin/view/Support/GettingStarted
+# - https://wiki.archlinux.org/index.php/Network_Time_Protocol_daemon
 
-# Specify one or more NTP servers.
+# Associate to cloud NTP pool servers
+server 1.pool.ntp.org iburst
+server 0.pool.ntp.org
 
-# Use servers from the NTP Pool Project. Approved by Ubuntu Technical Board
-# on 2011-02-08 (LP: #104525). See http://www.pool.ntp.org/join.html for
-# more information.
-pool 0.ubuntu.pool.ntp.org iburst
-pool 1.ubuntu.pool.ntp.org iburst
-pool 2.ubuntu.pool.ntp.org iburst
-pool 3.ubuntu.pool.ntp.org iburst
-
-# Use Ubuntu's ntp server as a fallback.
-pool ntp.ubuntu.com
-
-# Access control configuration; see /usr/share/doc/ntp-doc/html/accopt.html for
-# details.  The web page <http://support.ntp.org/bin/view/Support/AccessRestrictions>
-# might also be helpful.
-#
-# Note that "restrict" applies to both servers and clients, so a configuration
-# that might be intended to block requests from certain clients could also end
-# up blocking replies from your own upstream servers.
-
-# By default, exchange time with everybody, but don't allow configuration.
-restrict -4 default kod notrap nomodify nopeer noquery limited
-restrict -6 default kod notrap nomodify nopeer noquery limited
-
-# Local users may interrogate the ntp server more closely.
+# Only allow read-only access from localhost
+restrict default noquery nopeer
 restrict 127.0.0.1
 restrict ::1
 
-# Needed for adding pool entries
-restrict source notrap nomodify noquery
-
-# Clients from this (example!) subnet have unlimited access, but only if
-# cryptographically authenticated.
-#restrict 192.168.123.0 mask 255.255.255.0 notrust
+# mode7 is required for collectd monitoring
 
 
-# If you want to provide time to your local subnet, change the next line.
-# (Again, the address is an example only.)
-#broadcast 192.168.123.255
-
-# If you want to listen to time broadcasts on your local subnet, de-comment the
-# next lines.  Please do this only if you trust everybody on the network!
-#disable auth
-#broadcastclient
-
-#Changes recquired to use pps synchonisation as explained in documentation:
-#http://www.ntp.org/ntpfaq/NTP-s-config-adv.htm#AEN3918
-
-#server 127.127.8.1 mode 135 prefer    # Meinberg GPS167 with PPS
-#fudge 127.127.8.1 time1 0.0042        # relative to PPS for my hardware
-
-#server 127.127.22.1                   # ATOM(PPS)
-#fudge 127.127.22.1 flag3 1            # enable PPS API
+# Location of drift file
+driftfile /var/lib/ntp/ntp.drift
+logfile /var/log/ntp.log

2018-03-14 02:51:43,234 [salt.state       ][INFO    ][2158] Completed state [/etc/ntp.conf] at time 02:51:43.234774 duration_in_ms=73.263
2018-03-14 02:51:43,389 [salt.state       ][INFO    ][2158] Running state [ntp] at time 02:51:43.389494
2018-03-14 02:51:43,389 [salt.state       ][INFO    ][2158] Executing state service.running for ntp
2018-03-14 02:51:43,391 [salt.loaded.int.module.cmdmod][INFO    ][2158] Executing command ['systemctl', 'status', 'ntp.service', '-n', '0'] in directory '/root'
2018-03-14 02:51:43,414 [salt.loaded.int.module.cmdmod][INFO    ][2158] Executing command ['systemctl', 'is-active', 'ntp.service'] in directory '/root'
2018-03-14 02:51:43,432 [salt.loaded.int.module.cmdmod][INFO    ][2158] Executing command ['systemctl', 'is-enabled', 'ntp.service'] in directory '/root'
2018-03-14 02:51:43,454 [salt.state       ][INFO    ][2158] The service ntp is already running
2018-03-14 02:51:43,455 [salt.state       ][INFO    ][2158] Completed state [ntp] at time 02:51:43.454954 duration_in_ms=65.46
2018-03-14 02:51:43,455 [salt.state       ][INFO    ][2158] Running state [ntp] at time 02:51:43.455234
2018-03-14 02:51:43,455 [salt.state       ][INFO    ][2158] Executing state service.mod_watch for ntp
2018-03-14 02:51:43,456 [salt.loaded.int.module.cmdmod][INFO    ][2158] Executing command ['systemctl', 'is-active', 'ntp.service'] in directory '/root'
2018-03-14 02:51:43,483 [salt.loaded.int.module.cmdmod][INFO    ][2158] Executing command ['systemctl', 'is-enabled', 'ntp.service'] in directory '/root'
2018-03-14 02:51:43,505 [salt.loaded.int.module.cmdmod][INFO    ][2158] Executing command ['systemd-run', '--scope', 'systemctl', 'restart', 'ntp.service'] in directory '/root'
2018-03-14 02:51:43,577 [salt.state       ][INFO    ][2158] {'ntp': True}
2018-03-14 02:51:43,577 [salt.state       ][INFO    ][2158] Completed state [ntp] at time 02:51:43.577612 duration_in_ms=122.377
2018-03-14 02:51:43,583 [salt.minion      ][INFO    ][2158] Returning information for job: 20180314025050827446
2018-03-14 02:51:54,988 [salt.minion      ][INFO    ][1939] User sudo_ubuntu Executing command ssh.set_auth_key with jid 20180314025154977548
2018-03-14 02:51:55,020 [salt.minion      ][INFO    ][5733] Starting a new job with PID 5733
2018-03-14 02:51:55,035 [salt.loader.192.168.11.2.int.module.ssh][WARNING ][5733] Public Key hashing currently defaults to "md5". This will change to "sha256" in the Nitrogen release.
2018-03-14 02:51:55,039 [salt.minion      ][INFO    ][5733] Returning information for job: 20180314025154977548
2018-03-14 02:52:21,173 [salt.minion      ][INFO    ][1939] User sudo_ubuntu Executing command pkg.upgrade with jid 20180314025221165748
2018-03-14 02:52:21,213 [salt.minion      ][INFO    ][5742] Starting a new job with PID 5742
2018-03-14 02:52:21,255 [salt.loader.192.168.11.2.int.module.cmdmod][INFO    ][5742] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2018-03-14 02:52:21,624 [salt.loader.192.168.11.2.int.module.cmdmod][INFO    ][5742] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'upgrade'] in directory '/root'
2018-03-14 02:52:31,281 [salt.minion      ][INFO    ][1939] User sudo_ubuntu Executing command saltutil.find_job with jid 20180314025231269785
2018-03-14 02:52:31,320 [salt.minion      ][INFO    ][5807] Starting a new job with PID 5807
2018-03-14 02:52:31,349 [salt.minion      ][INFO    ][5807] Returning information for job: 20180314025231269785
2018-03-14 02:52:41,464 [salt.minion      ][INFO    ][1939] User sudo_ubuntu Executing command saltutil.find_job with jid 20180314025241453884
2018-03-14 02:52:41,500 [salt.minion      ][INFO    ][5874] Starting a new job with PID 5874
2018-03-14 02:52:41,598 [salt.minion      ][INFO    ][5874] Returning information for job: 20180314025241453884
2018-03-14 02:52:51,693 [salt.minion      ][INFO    ][1939] User sudo_ubuntu Executing command saltutil.find_job with jid 20180314025251681094
2018-03-14 02:52:51,726 [salt.minion      ][INFO    ][5931] Starting a new job with PID 5931
2018-03-14 02:52:51,749 [salt.minion      ][INFO    ][5931] Returning information for job: 20180314025251681094
2018-03-14 02:53:01,905 [salt.minion      ][INFO    ][1939] User sudo_ubuntu Executing command saltutil.find_job with jid 20180314025301893642
2018-03-14 02:53:01,939 [salt.minion      ][INFO    ][5987] Starting a new job with PID 5987
2018-03-14 02:53:01,960 [salt.minion      ][INFO    ][5987] Returning information for job: 20180314025301893642
2018-03-14 02:53:12,108 [salt.minion      ][INFO    ][1939] User sudo_ubuntu Executing command saltutil.find_job with jid 20180314025312097936
2018-03-14 02:53:12,134 [salt.minion      ][INFO    ][6447] Starting a new job with PID 6447
2018-03-14 02:53:12,154 [salt.minion      ][INFO    ][6447] Returning information for job: 20180314025312097936
2018-03-14 02:53:18,325 [salt.loader.192.168.11.2.int.module.cmdmod][INFO    ][5742] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2018-03-14 02:53:18,360 [salt.minion      ][INFO    ][5742] Returning information for job: 20180314025221165748
2018-03-14 03:18:29,452 [salt.minion      ][INFO    ][1939] User sudo_ubuntu Executing command test.ping with jid 20180314031829451329
2018-03-14 03:18:29,487 [salt.minion      ][INFO    ][6697] Starting a new job with PID 6697
2018-03-14 03:18:29,564 [salt.minion      ][INFO    ][6697] Returning information for job: 20180314031829451329
2018-03-14 03:22:07,797 [salt.minion      ][INFO    ][1939] User sudo_ubuntu Executing command state.sls with jid 20180314032207795615
2018-03-14 03:22:07,823 [salt.minion      ][INFO    ][6702] Starting a new job with PID 6702
2018-03-14 03:22:08,257 [salt.state       ][INFO    ][6702] Loading fresh modules for state activity
2018-03-14 03:22:08,315 [salt.fileclient  ][INFO    ][6702] Fetching file from saltenv 'base', ** done ** 'keepalived/init.sls'
2018-03-14 03:22:08,346 [salt.fileclient  ][INFO    ][6702] Fetching file from saltenv 'base', ** done ** 'keepalived/cluster.sls'
2018-03-14 03:22:08,918 [salt.state       ][INFO    ][6702] Running state [keepalived] at time 03:22:08.918129
2018-03-14 03:22:08,918 [salt.state       ][INFO    ][6702] Executing state pkg.installed for keepalived
2018-03-14 03:22:08,919 [salt.loaded.int.module.cmdmod][INFO    ][6702] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2018-03-14 03:22:09,320 [salt.loaded.int.module.cmdmod][INFO    ][6702] Executing command ['apt-cache', '-q', 'policy', 'keepalived'] in directory '/root'
2018-03-14 03:22:09,438 [salt.loaded.int.module.cmdmod][INFO    ][6702] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2018-03-14 03:22:11,561 [salt.loaded.int.module.cmdmod][INFO    ][6702] Executing command ['dpkg', '--get-selections', '*'] in directory '/root'
2018-03-14 03:22:11,611 [salt.loaded.int.module.cmdmod][INFO    ][6702] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'keepalived'] in directory '/root'
2018-03-14 03:22:17,844 [salt.minion      ][INFO    ][1939] User sudo_ubuntu Executing command saltutil.find_job with jid 20180314032217840485
2018-03-14 03:22:17,869 [salt.minion      ][INFO    ][7212] Starting a new job with PID 7212
2018-03-14 03:22:17,922 [salt.minion      ][INFO    ][7212] Returning information for job: 20180314032217840485
2018-03-14 03:22:25,657 [salt.loaded.int.module.cmdmod][INFO    ][6702] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2018-03-14 03:22:25,694 [salt.state       ][INFO    ][6702] Made the following changes:
'libsnmp30' changed from 'absent' to '5.7.3+dfsg-1ubuntu4.1'
'libnl-3-200' changed from 'absent' to '3.2.27-1ubuntu0.16.04.1'
'libsensors4' changed from 'absent' to '1:3.4.0-2'
'libsnmp-base' changed from 'absent' to '5.7.3+dfsg-1ubuntu4.1'
'keepalived' changed from 'absent' to '1:1.2.19-1ubuntu0.2'
'ipvsadm' changed from 'absent' to '1:1.28-3'
'libnl-genl-3-200' changed from 'absent' to '3.2.27-1ubuntu0.16.04.1'

2018-03-14 03:22:25,714 [salt.state       ][INFO    ][6702] Loading fresh modules for state activity
2018-03-14 03:22:25,742 [salt.state       ][INFO    ][6702] Completed state [keepalived] at time 03:22:25.742670 duration_in_ms=16824.54
2018-03-14 03:22:25,750 [salt.state       ][INFO    ][6702] Running state [lsof] at time 03:22:25.749962
2018-03-14 03:22:25,750 [salt.state       ][INFO    ][6702] Executing state pkg.installed for lsof
2018-03-14 03:22:26,087 [salt.state       ][INFO    ][6702] All specified packages are already installed
2018-03-14 03:22:26,088 [salt.state       ][INFO    ][6702] Completed state [lsof] at time 03:22:26.087968 duration_in_ms=338.006
2018-03-14 03:22:26,089 [salt.state       ][INFO    ][6702] Running state [/etc/keepalived/keepalived.conf] at time 03:22:26.089561
2018-03-14 03:22:26,089 [salt.state       ][INFO    ][6702] Executing state file.managed for /etc/keepalived/keepalived.conf
2018-03-14 03:22:26,117 [salt.fileclient  ][INFO    ][6702] Fetching file from saltenv 'base', ** done ** 'keepalived/files/keepalived.conf'
2018-03-14 03:22:26,152 [salt.state       ][INFO    ][6702] File changed:
New file
2018-03-14 03:22:26,152 [salt.state       ][INFO    ][6702] Completed state [/etc/keepalived/keepalived.conf] at time 03:22:26.152653 duration_in_ms=63.091
2018-03-14 03:22:26,153 [salt.state       ][INFO    ][6702] Running state [keepalived] at time 03:22:26.153236
2018-03-14 03:22:26,153 [salt.state       ][INFO    ][6702] Executing state service.running for keepalived
2018-03-14 03:22:26,153 [salt.loaded.int.module.cmdmod][INFO    ][6702] Executing command ['systemctl', 'status', 'keepalived.service', '-n', '0'] in directory '/root'
2018-03-14 03:22:26,185 [salt.loaded.int.module.cmdmod][INFO    ][6702] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2018-03-14 03:22:26,213 [salt.loaded.int.module.cmdmod][INFO    ][6702] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2018-03-14 03:22:26,243 [salt.loaded.int.module.cmdmod][INFO    ][6702] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2018-03-14 03:22:26,273 [salt.loaded.int.module.cmdmod][INFO    ][6702] Executing command ['systemd-run', '--scope', 'systemctl', 'start', 'keepalived.service'] in directory '/root'
2018-03-14 03:22:26,391 [salt.loaded.int.module.cmdmod][INFO    ][6702] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2018-03-14 03:22:26,417 [salt.loaded.int.module.cmdmod][INFO    ][6702] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2018-03-14 03:22:26,440 [salt.loaded.int.module.cmdmod][INFO    ][6702] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2018-03-14 03:22:26,462 [salt.state       ][INFO    ][6702] {'keepalived': True}
2018-03-14 03:22:26,463 [salt.state       ][INFO    ][6702] Completed state [keepalived] at time 03:22:26.462892 duration_in_ms=309.654
2018-03-14 03:22:26,465 [salt.minion      ][INFO    ][6702] Returning information for job: 20180314032207795615
2018-03-14 03:23:31,887 [salt.minion      ][INFO    ][1939] User sudo_ubuntu Executing command pillar.get with jid 20180314032331889754
2018-03-14 03:23:31,918 [salt.minion      ][INFO    ][8028] Starting a new job with PID 8028
2018-03-14 03:23:31,927 [salt.minion      ][INFO    ][8028] Returning information for job: 20180314032331889754
2018-03-14 03:32:50,707 [salt.minion      ][INFO    ][1939] User sudo_ubuntu Executing command state.sls with jid 20180314033250705612
2018-03-14 03:32:50,735 [salt.minion      ][INFO    ][8053] Starting a new job with PID 8053
2018-03-14 03:32:52,392 [salt.state       ][INFO    ][8053] Loading fresh modules for state activity
2018-03-14 03:32:52,450 [salt.fileclient  ][INFO    ][8053] Fetching file from saltenv 'base', ** done ** 'galera/init.sls'
2018-03-14 03:32:52,485 [salt.fileclient  ][INFO    ][8053] Fetching file from saltenv 'base', ** done ** 'galera/slave.sls'
2018-03-14 03:32:52,552 [salt.loaded.int.module.cmdmod][INFO    ][8053] Executing command 'test -e /var/lib/mysql/.galera_bootstrap; echo $?' in directory '/root'
2018-03-14 03:32:52,636 [salt.fileclient  ][INFO    ][8053] Fetching file from saltenv 'base', ** done ** 'galera/server.sls'
2018-03-14 03:32:53,174 [salt.state       ][INFO    ][8053] Running state [/etc/mysql/my.cnf] at time 03:32:53.174525
2018-03-14 03:32:53,174 [salt.state       ][INFO    ][8053] Executing state file.managed for /etc/mysql/my.cnf
2018-03-14 03:32:53,211 [salt.fileclient  ][INFO    ][8053] Fetching file from saltenv 'base', ** done ** 'galera/files/my.cnf.pre'
2018-03-14 03:32:53,215 [salt.state       ][INFO    ][8053] File changed:
New file
2018-03-14 03:32:53,216 [salt.state       ][INFO    ][8053] Completed state [/etc/mysql/my.cnf] at time 03:32:53.216198 duration_in_ms=41.673
2018-03-14 03:32:53,217 [salt.state       ][INFO    ][8053] Running state [mysql-wsrep-5.6] at time 03:32:53.216964
2018-03-14 03:32:53,217 [salt.state       ][INFO    ][8053] Executing state pkg.installed for mysql-wsrep-5.6
2018-03-14 03:32:53,217 [salt.loaded.int.module.cmdmod][INFO    ][8053] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2018-03-14 03:32:53,539 [salt.loaded.int.module.cmdmod][INFO    ][8053] Executing command ['apt-cache', '-q', 'policy', 'mysql-wsrep-5.6'] in directory '/root'
2018-03-14 03:32:53,656 [salt.loaded.int.module.cmdmod][INFO    ][8053] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2018-03-14 03:32:55,369 [salt.loaded.int.module.cmdmod][INFO    ][8053] Executing command ['dpkg', '--get-selections', '*'] in directory '/root'
2018-03-14 03:32:55,420 [salt.loaded.int.module.cmdmod][INFO    ][8053] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '--force-yes', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'mysql-wsrep-5.6'] in directory '/root'
2018-03-14 03:33:00,800 [salt.minion      ][INFO    ][1939] User sudo_ubuntu Executing command saltutil.find_job with jid 20180314033300799163
2018-03-14 03:33:00,835 [salt.minion      ][INFO    ][8525] Starting a new job with PID 8525
2018-03-14 03:33:00,855 [salt.minion      ][INFO    ][8525] Returning information for job: 20180314033300799163
2018-03-14 03:33:10,821 [salt.minion      ][INFO    ][1939] User sudo_ubuntu Executing command saltutil.find_job with jid 20180314033310816701
2018-03-14 03:33:10,850 [salt.minion      ][INFO    ][9014] Starting a new job with PID 9014
2018-03-14 03:33:10,878 [salt.minion      ][INFO    ][9014] Returning information for job: 20180314033310816701
2018-03-14 03:33:20,838 [salt.minion      ][INFO    ][1939] User sudo_ubuntu Executing command saltutil.find_job with jid 20180314033320833750
2018-03-14 03:33:20,870 [salt.minion      ][INFO    ][9484] Starting a new job with PID 9484
2018-03-14 03:33:20,891 [salt.minion      ][INFO    ][9484] Returning information for job: 20180314033320833750
2018-03-14 03:33:30,863 [salt.minion      ][INFO    ][1939] User sudo_ubuntu Executing command saltutil.find_job with jid 20180314033330857537
2018-03-14 03:33:30,970 [salt.minion      ][INFO    ][9616] Starting a new job with PID 9616
2018-03-14 03:33:31,052 [salt.minion      ][INFO    ][9616] Returning information for job: 20180314033330857537
2018-03-14 03:33:33,974 [salt.loaded.int.module.cmdmod][INFO    ][8053] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2018-03-14 03:33:34,042 [salt.state       ][INFO    ][8053] Made the following changes:
'libmysqlclient18' changed from 'absent' to '1'
'virtual-mysql-client' changed from 'absent' to '1'
'libencode-locale-perl' changed from 'absent' to '1.05-1'
'timedate' changed from 'absent' to '1'
'mysql-server-5.6' changed from 'absent' to '1'
'libdbi-perl' changed from 'absent' to '1.634-1build1'
'mysql-common' changed from 'absent' to '5.7.21-0ubuntu0.16.04.1'
'mysql-wsrep-server-5.6' changed from 'absent' to '5.6.35-0.1~u16.04+mcp2'
'socat' changed from 'absent' to '1.7.3.1-1'
'libcgi-pm-perl' changed from 'absent' to '4.26-1'
'libio-html-perl' changed from 'absent' to '1.001-1'
'mysql-wsrep-libmysqlclient18' changed from 'absent' to '5.6.35-0.1~u16.04+mcp2'
'libtimedate-perl' changed from 'absent' to '2.3000-2'
'libterm-readkey-perl' changed from 'absent' to '2.33-1build1'
'liburi-perl' changed from 'absent' to '1.71-1'
'mysql-wsrep-common-5.6' changed from 'absent' to '5.6.35-0.1~u16.04+mcp2'
'libhtml-parser-perl' changed from 'absent' to '3.72-1'
'libaio1' changed from 'absent' to '0.3.110-2'
'mysql-common-5.6' changed from 'absent' to '1'
'libhttp-message-perl' changed from 'absent' to '6.11-1'
'mysql-wsrep-client-5.6' changed from 'absent' to '5.6.35-0.1~u16.04+mcp2'
'libmysqlclient20' changed from 'absent' to '5.7.21-0ubuntu0.16.04.1'
'libfcgi-perl' changed from 'absent' to '0.77-1build1'
'libcgi-fast-perl' changed from 'absent' to '1:2.10-1'
'perl-dbdabi-94' changed from 'absent' to '1'
'libdbd-mysql-perl' changed from 'absent' to '4.033-1ubuntu0.1'
'liblwp-mediatypes-perl' changed from 'absent' to '6.02-1'
'virtual-mysql-server' changed from 'absent' to '1'
'libhtml-template-perl' changed from 'absent' to '2.95-2'
'libhttp-date-perl' changed from 'absent' to '6.02-1'
'libhtml-tagset-perl' changed from 'absent' to '3.20-2'
'mysql-wsrep-5.6' changed from 'absent' to '5.6.35-0.1~u16.04+mcp2'

2018-03-14 03:33:34,067 [salt.state       ][INFO    ][8053] Loading fresh modules for state activity
2018-03-14 03:33:34,103 [salt.state       ][INFO    ][8053] Completed state [mysql-wsrep-5.6] at time 03:33:34.103262 duration_in_ms=40886.296
2018-03-14 03:33:34,116 [salt.state       ][INFO    ][8053] Running state [galera-3] at time 03:33:34.116490
2018-03-14 03:33:34,117 [salt.state       ][INFO    ][8053] Executing state pkg.installed for galera-3
2018-03-14 03:33:34,495 [salt.loaded.int.module.cmdmod][INFO    ][8053] Executing command ['apt-cache', '-q', 'policy', 'galera-3'] in directory '/root'
2018-03-14 03:33:34,556 [salt.loaded.int.module.cmdmod][INFO    ][8053] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2018-03-14 03:33:36,698 [salt.loaded.int.module.cmdmod][INFO    ][8053] Executing command ['dpkg', '--get-selections', '*'] in directory '/root'
2018-03-14 03:33:36,736 [salt.loaded.int.module.cmdmod][INFO    ][8053] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '--force-yes', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'galera-3'] in directory '/root'
2018-03-14 03:33:39,309 [salt.loaded.int.module.cmdmod][INFO    ][8053] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2018-03-14 03:33:39,376 [salt.state       ][INFO    ][8053] Made the following changes:
'galera' changed from 'absent' to '1'
'percona-xtradb-cluster-galera-25' changed from 'absent' to '1'
'galera3' changed from 'absent' to '1'
'galera-3' changed from 'absent' to '25.3.14-1'
'wsrep' changed from 'absent' to '1'

2018-03-14 03:33:39,397 [salt.state       ][INFO    ][8053] Loading fresh modules for state activity
2018-03-14 03:33:39,426 [salt.state       ][INFO    ][8053] Completed state [galera-3] at time 03:33:39.426423 duration_in_ms=5309.933
2018-03-14 03:33:39,439 [salt.state       ][INFO    ][8053] Running state [rsync] at time 03:33:39.439090
2018-03-14 03:33:39,439 [salt.state       ][INFO    ][8053] Executing state pkg.installed for rsync
2018-03-14 03:33:39,822 [salt.state       ][INFO    ][8053] All specified packages are already installed
2018-03-14 03:33:39,823 [salt.state       ][INFO    ][8053] Completed state [rsync] at time 03:33:39.822988 duration_in_ms=383.898
2018-03-14 03:33:39,824 [salt.state       ][INFO    ][8053] Running state [python-mysqldb] at time 03:33:39.824125
2018-03-14 03:33:39,824 [salt.state       ][INFO    ][8053] Executing state pkg.installed for python-mysqldb
2018-03-14 03:33:39,840 [salt.loaded.int.module.cmdmod][INFO    ][8053] Executing command ['apt-cache', '-q', 'policy', 'python-mysqldb'] in directory '/root'
2018-03-14 03:33:39,933 [salt.loaded.int.module.cmdmod][INFO    ][8053] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2018-03-14 03:33:40,939 [salt.minion      ][INFO    ][1939] User sudo_ubuntu Executing command saltutil.find_job with jid 20180314033340937143
2018-03-14 03:33:40,970 [salt.minion      ][INFO    ][10496] Starting a new job with PID 10496
2018-03-14 03:33:40,996 [salt.minion      ][INFO    ][10496] Returning information for job: 20180314033340937143
2018-03-14 03:33:42,162 [salt.loaded.int.module.cmdmod][INFO    ][8053] Executing command ['dpkg', '--get-selections', '*'] in directory '/root'
2018-03-14 03:33:42,213 [salt.loaded.int.module.cmdmod][INFO    ][8053] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '--force-yes', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'python-mysqldb'] in directory '/root'
2018-03-14 03:33:44,810 [salt.loaded.int.module.cmdmod][INFO    ][8053] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2018-03-14 03:33:44,871 [salt.state       ][INFO    ][8053] Made the following changes:
'python2.7-mysqldb' changed from 'absent' to '1'
'python-mysqldb' changed from 'absent' to '1.3.7-1build2'

2018-03-14 03:33:44,894 [salt.state       ][INFO    ][8053] Loading fresh modules for state activity
2018-03-14 03:33:44,925 [salt.state       ][INFO    ][8053] Completed state [python-mysqldb] at time 03:33:44.925537 duration_in_ms=5101.411
2018-03-14 03:33:44,934 [salt.state       ][INFO    ][8053] Running state [libmysqlclient-dev] at time 03:33:44.934733
2018-03-14 03:33:44,935 [salt.state       ][INFO    ][8053] Executing state pkg.installed for libmysqlclient-dev
2018-03-14 03:33:45,336 [salt.loaded.int.module.cmdmod][INFO    ][8053] Executing command ['apt-cache', '-q', 'policy', 'libmysqlclient-dev'] in directory '/root'
2018-03-14 03:33:45,393 [salt.loaded.int.module.cmdmod][INFO    ][8053] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2018-03-14 03:33:47,580 [salt.loaded.int.module.cmdmod][INFO    ][8053] Executing command ['dpkg', '--get-selections', '*'] in directory '/root'
2018-03-14 03:33:47,628 [salt.loaded.int.module.cmdmod][INFO    ][8053] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '--force-yes', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'libmysqlclient-dev'] in directory '/root'
2018-03-14 03:33:50,997 [salt.minion      ][INFO    ][1939] User sudo_ubuntu Executing command saltutil.find_job with jid 20180314033350992242
2018-03-14 03:33:51,027 [salt.minion      ][INFO    ][11075] Starting a new job with PID 11075
2018-03-14 03:33:51,049 [salt.minion      ][INFO    ][11075] Returning information for job: 20180314033350992242
2018-03-14 03:34:00,087 [salt.loaded.int.module.cmdmod][INFO    ][8053] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2018-03-14 03:34:00,142 [salt.state       ][INFO    ][8053] Made the following changes:
'manpages-dev' changed from 'absent' to '4.04-2'
'libc-dev' changed from 'absent' to '1'
'libz-dev' changed from 'absent' to '1'
'libmysqlclient-dev' changed from 'absent' to '5.7.21-0ubuntu0.16.04.1'
'linux-kernel-headers' changed from 'absent' to '1'
'libc6-dev' changed from 'absent' to '2.23-0ubuntu10'
'libc-dev-bin' changed from 'absent' to '2.23-0ubuntu10'
'linux-libc-dev' changed from 'absent' to '4.4.0-116.140'
'zlib1g-dev' changed from 'absent' to '1:1.2.8.dfsg-2ubuntu4.1'

2018-03-14 03:34:00,157 [salt.state       ][INFO    ][8053] Loading fresh modules for state activity
2018-03-14 03:34:00,183 [salt.state       ][INFO    ][8053] Completed state [libmysqlclient-dev] at time 03:34:00.183209 duration_in_ms=15248.474
2018-03-14 03:34:00,196 [salt.state       ][INFO    ][8053] Running state [psmisc] at time 03:34:00.196044
2018-03-14 03:34:00,196 [salt.state       ][INFO    ][8053] Executing state pkg.installed for psmisc
2018-03-14 03:34:00,569 [salt.state       ][INFO    ][8053] All specified packages are already installed
2018-03-14 03:34:00,570 [salt.state       ][INFO    ][8053] Completed state [psmisc] at time 03:34:00.569961 duration_in_ms=373.917
2018-03-14 03:34:00,570 [salt.state       ][INFO    ][8053] Running state [netcat] at time 03:34:00.570636
2018-03-14 03:34:00,570 [salt.state       ][INFO    ][8053] Executing state pkg.installed for netcat
2018-03-14 03:34:00,574 [salt.state       ][INFO    ][8053] All specified packages are already installed
2018-03-14 03:34:00,575 [salt.state       ][INFO    ][8053] Completed state [netcat] at time 03:34:00.575034 duration_in_ms=4.398
2018-03-14 03:34:00,575 [salt.state       ][INFO    ][8053] Running state [percona-xtrabackup] at time 03:34:00.575449
2018-03-14 03:34:00,575 [salt.state       ][INFO    ][8053] Executing state pkg.installed for percona-xtrabackup
2018-03-14 03:34:00,590 [salt.loaded.int.module.cmdmod][INFO    ][8053] Executing command ['apt-cache', '-q', 'policy', 'percona-xtrabackup'] in directory '/root'
2018-03-14 03:34:00,648 [salt.loaded.int.module.cmdmod][INFO    ][8053] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2018-03-14 03:34:01,026 [salt.minion      ][INFO    ][1939] User sudo_ubuntu Executing command saltutil.find_job with jid 20180314033401019544
2018-03-14 03:34:01,051 [salt.minion      ][INFO    ][14728] Starting a new job with PID 14728
2018-03-14 03:34:01,067 [salt.minion      ][INFO    ][14728] Returning information for job: 20180314033401019544
2018-03-14 03:34:02,679 [salt.loaded.int.module.cmdmod][INFO    ][8053] Executing command ['dpkg', '--get-selections', '*'] in directory '/root'
2018-03-14 03:34:02,738 [salt.loaded.int.module.cmdmod][INFO    ][8053] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '--force-yes', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'percona-xtrabackup'] in directory '/root'
2018-03-14 03:34:06,950 [salt.loaded.int.module.cmdmod][INFO    ][8053] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2018-03-14 03:34:07,015 [salt.state       ][INFO    ][8053] 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.6'
'percona-xtrabackup' changed from 'absent' to '2.3.7-0ubuntu0.16.04.2'

2018-03-14 03:34:07,039 [salt.state       ][INFO    ][8053] Loading fresh modules for state activity
2018-03-14 03:34:07,070 [salt.state       ][INFO    ][8053] Completed state [percona-xtrabackup] at time 03:34:07.070562 duration_in_ms=6495.111
2018-03-14 03:34:07,084 [salt.state       ][INFO    ][8053] Running state [socat] at time 03:34:07.084118
2018-03-14 03:34:07,085 [salt.state       ][INFO    ][8053] Executing state pkg.installed for socat
2018-03-14 03:34:07,464 [salt.state       ][INFO    ][8053] All specified packages are already installed
2018-03-14 03:34:07,465 [salt.state       ][INFO    ][8053] Completed state [socat] at time 03:34:07.465145 duration_in_ms=381.027
2018-03-14 03:34:07,466 [salt.state       ][INFO    ][8053] Running state [libdbd-mysql] at time 03:34:07.466205
2018-03-14 03:34:07,466 [salt.state       ][INFO    ][8053] Executing state pkg.installed for libdbd-mysql
2018-03-14 03:34:07,481 [salt.loaded.int.module.cmdmod][INFO    ][8053] Executing command ['apt-cache', '-q', 'policy', 'libdbd-mysql'] in directory '/root'
2018-03-14 03:34:07,536 [salt.loaded.int.module.cmdmod][INFO    ][8053] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2018-03-14 03:34:09,581 [salt.loaded.int.module.cmdmod][INFO    ][8053] Executing command ['dpkg', '--get-selections', '*'] in directory '/root'
2018-03-14 03:34:09,624 [salt.loaded.int.module.cmdmod][INFO    ][8053] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '--force-yes', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'libdbd-mysql'] in directory '/root'
2018-03-14 03:34:11,083 [salt.minion      ][INFO    ][1939] User sudo_ubuntu Executing command saltutil.find_job with jid 20180314033411079736
2018-03-14 03:34:11,112 [salt.minion      ][INFO    ][15492] Starting a new job with PID 15492
2018-03-14 03:34:11,138 [salt.minion      ][INFO    ][15492] Returning information for job: 20180314033411079736
2018-03-14 03:34:12,418 [salt.loaded.int.module.cmdmod][INFO    ][8053] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2018-03-14 03:34:12,463 [salt.state       ][INFO    ][8053] Made the following changes:
'libdbd-mysql' changed from 'absent' to '0.9.0-3ubuntu2'
'libdbi1' changed from 'absent' to '0.9.0-4'

2018-03-14 03:34:12,476 [salt.state       ][INFO    ][8053] Loading fresh modules for state activity
2018-03-14 03:34:12,495 [salt.state       ][INFO    ][8053] Completed state [libdbd-mysql] at time 03:34:12.494974 duration_in_ms=5028.768
2018-03-14 03:34:12,500 [salt.state       ][INFO    ][8053] Running state [python-pymysql] at time 03:34:12.500714
2018-03-14 03:34:12,500 [salt.state       ][INFO    ][8053] Executing state pkg.installed for python-pymysql
2018-03-14 03:34:12,815 [salt.state       ][INFO    ][8053] All specified packages are already installed
2018-03-14 03:34:12,815 [salt.state       ][INFO    ][8053] Completed state [python-pymysql] at time 03:34:12.815602 duration_in_ms=314.888
2018-03-14 03:34:12,817 [salt.state       ][INFO    ][8053] Running state [/var/log/mysql] at time 03:34:12.817799
2018-03-14 03:34:12,818 [salt.state       ][INFO    ][8053] Executing state file.directory for /var/log/mysql
2018-03-14 03:34:12,819 [salt.state       ][INFO    ][8053] {'mode': '0755'}
2018-03-14 03:34:12,819 [salt.state       ][INFO    ][8053] Completed state [/var/log/mysql] at time 03:34:12.819668 duration_in_ms=1.869
2018-03-14 03:34:12,820 [salt.state       ][INFO    ][8053] Running state [/etc/mysql] at time 03:34:12.820384
2018-03-14 03:34:12,820 [salt.state       ][INFO    ][8053] Executing state file.directory for /etc/mysql
2018-03-14 03:34:12,821 [salt.state       ][INFO    ][8053] Directory /etc/mysql is in the correct state
2018-03-14 03:34:12,821 [salt.state       ][INFO    ][8053] Completed state [/etc/mysql] at time 03:34:12.821770 duration_in_ms=1.386
2018-03-14 03:34:12,822 [salt.state       ][INFO    ][8053] Running state [/var/run/mysqld] at time 03:34:12.822508
2018-03-14 03:34:12,822 [salt.state       ][INFO    ][8053] Executing state file.directory for /var/run/mysqld
2018-03-14 03:34:12,823 [salt.state       ][INFO    ][8053] Directory /var/run/mysqld is in the correct state
2018-03-14 03:34:12,824 [salt.state       ][INFO    ][8053] Completed state [/var/run/mysqld] at time 03:34:12.824132 duration_in_ms=1.624
2018-03-14 03:34:12,824 [salt.state       ][INFO    ][8053] Running state [/etc/systemd/system/mysql.service.d] at time 03:34:12.824845
2018-03-14 03:34:12,825 [salt.state       ][INFO    ][8053] Executing state file.directory for /etc/systemd/system/mysql.service.d
2018-03-14 03:34:12,826 [salt.state       ][INFO    ][8053] {'/etc/systemd/system/mysql.service.d': 'New Dir'}
2018-03-14 03:34:12,826 [salt.state       ][INFO    ][8053] Completed state [/etc/systemd/system/mysql.service.d] at time 03:34:12.826691 duration_in_ms=1.845
2018-03-14 03:34:12,827 [salt.state       ][INFO    ][8053] Running state [/etc/systemd/system/mysql.service.d/override.conf] at time 03:34:12.827815
2018-03-14 03:34:12,828 [salt.state       ][INFO    ][8053] Executing state file.managed for /etc/systemd/system/mysql.service.d/override.conf
2018-03-14 03:34:12,842 [salt.state       ][INFO    ][8053] File changed:
New file
2018-03-14 03:34:12,843 [salt.state       ][INFO    ][8053] Completed state [/etc/systemd/system/mysql.service.d/override.conf] at time 03:34:12.843119 duration_in_ms=15.304
2018-03-14 03:34:12,844 [salt.state       ][INFO    ][8053] Running state [service.systemctl_reload] at time 03:34:12.844765
2018-03-14 03:34:12,845 [salt.state       ][INFO    ][8053] Executing state module.wait for service.systemctl_reload
2018-03-14 03:34:12,845 [salt.state       ][INFO    ][8053] No changes made for service.systemctl_reload
2018-03-14 03:34:12,846 [salt.state       ][INFO    ][8053] Completed state [service.systemctl_reload] at time 03:34:12.845977 duration_in_ms=1.213
2018-03-14 03:34:12,846 [salt.state       ][INFO    ][8053] Running state [service.systemctl_reload] at time 03:34:12.846223
2018-03-14 03:34:12,846 [salt.state       ][INFO    ][8053] Executing state module.mod_watch for service.systemctl_reload
2018-03-14 03:34:12,847 [salt.loaded.int.module.cmdmod][INFO    ][8053] Executing command ['systemctl', '--system', 'daemon-reload'] in directory '/root'
2018-03-14 03:34:12,976 [salt.state       ][INFO    ][8053] {'ret': True}
2018-03-14 03:34:12,977 [salt.state       ][INFO    ][8053] Completed state [service.systemctl_reload] at time 03:34:12.977551 duration_in_ms=131.326
2018-03-14 03:34:12,979 [salt.state       ][INFO    ][8053] Running state [/etc/mysql/debian.cnf] at time 03:34:12.979672
2018-03-14 03:34:12,980 [salt.state       ][INFO    ][8053] Executing state file.managed for /etc/mysql/debian.cnf
2018-03-14 03:34:13,008 [salt.fileclient  ][INFO    ][8053] Fetching file from saltenv 'base', ** done ** 'galera/files/debian.cnf'
2018-03-14 03:34:13,092 [salt.state       ][INFO    ][8053] File changed:
--- 
+++ 
@@ -1,12 +1,13 @@
-# Automatically generated for Debian scripts. DO NOT TOUCH!
+
 [client]
-host     = localhost
-user     = debian-sys-maint
-password = 9sAvb9KIR0Odn2Oo
-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 = 9sAvb9KIR0Odn2Oo
-socket   = /var/run/mysqld/mysqld.sock
-basedir  = /usr
+host = localhost
+user = debian-sys-maint
+password = opnfv_secret
+socket = /var/run/mysqld/mysqld.sock
+basedir = /usr

2018-03-14 03:34:13,093 [salt.state       ][INFO    ][8053] Completed state [/etc/mysql/debian.cnf] at time 03:34:13.093150 duration_in_ms=113.478
2018-03-14 03:34:13,093 [salt.state       ][INFO    ][8053] Running state [/usr/local/sbin/galera_init.sh] at time 03:34:13.093554
2018-03-14 03:34:13,093 [salt.state       ][INFO    ][8053] Executing state file.managed for /usr/local/sbin/galera_init.sh
2018-03-14 03:34:13,117 [salt.fileclient  ][INFO    ][8053] Fetching file from saltenv 'base', ** done ** 'galera/files/init_bootstrap.sh'
2018-03-14 03:34:13,122 [salt.state       ][INFO    ][8053] File changed:
New file
2018-03-14 03:34:13,123 [salt.state       ][INFO    ][8053] Completed state [/usr/local/sbin/galera_init.sh] at time 03:34:13.122953 duration_in_ms=29.399
2018-03-14 03:34:13,123 [salt.state       ][INFO    ][8053] Running state [/usr/local/sbin/galera_bootstrap.sh] at time 03:34:13.123388
2018-03-14 03:34:13,123 [salt.state       ][INFO    ][8053] Executing state file.managed for /usr/local/sbin/galera_bootstrap.sh
2018-03-14 03:34:13,147 [salt.fileclient  ][INFO    ][8053] Fetching file from saltenv 'base', ** done ** 'galera/files/bootstrap.sh'
2018-03-14 03:34:13,152 [salt.state       ][INFO    ][8053] File changed:
New file
2018-03-14 03:34:13,152 [salt.state       ][INFO    ][8053] Completed state [/usr/local/sbin/galera_bootstrap.sh] at time 03:34:13.152381 duration_in_ms=28.993
2018-03-14 03:34:13,155 [salt.state       ][INFO    ][8053] Running state [/usr/local/sbin/galera_init.sh] at time 03:34:13.155889
2018-03-14 03:34:13,156 [salt.state       ][INFO    ][8053] Executing state cmd.run for /usr/local/sbin/galera_init.sh
2018-03-14 03:34:13,156 [salt.loaded.int.module.cmdmod][INFO    ][8053] Executing command '/usr/local/sbin/galera_init.sh' in directory '/root'
2018-03-14 03:34:17,310 [salt.state       ][INFO    ][8053] {'pid': 15582, 'retcode': 0, 'stderr': '', 'stdout': 'Sucessfully connected to the MySQL service (0 retries).'}
2018-03-14 03:34:17,311 [salt.state       ][INFO    ][8053] Completed state [/usr/local/sbin/galera_init.sh] at time 03:34:17.311409 duration_in_ms=4155.519
2018-03-14 03:34:17,314 [salt.state       ][INFO    ][8053] Running state [mysqladmin password "opnfv_secret"] at time 03:34:17.314575
2018-03-14 03:34:17,315 [salt.state       ][INFO    ][8053] Executing state cmd.run for mysqladmin password "opnfv_secret"
2018-03-14 03:34:17,316 [salt.loaded.int.module.cmdmod][INFO    ][8053] Executing command 'mysqladmin password "opnfv_secret"' in directory '/root'
2018-03-14 03:34:17,352 [salt.state       ][INFO    ][8053] {'pid': 16049, 'retcode': 0, 'stderr': 'Warning: Using a password on the command line interface can be insecure.', 'stdout': ''}
2018-03-14 03:34:17,353 [salt.state       ][INFO    ][8053] Completed state [mysqladmin password "opnfv_secret"] at time 03:34:17.353671 duration_in_ms=39.096
2018-03-14 03:34:17,356 [salt.state       ][INFO    ][8053] Running state [mysql -u root -popnfv_secret -e "GRANT ALL PRIVILEGES ON *.* TO 'debian-sys-maint'@'localhost' IDENTIFIED BY 'opnfv_secret';"] at time 03:34:17.356822
2018-03-14 03:34:17,357 [salt.state       ][INFO    ][8053] Executing state cmd.run for mysql -u root -popnfv_secret -e "GRANT ALL PRIVILEGES ON *.* TO 'debian-sys-maint'@'localhost' IDENTIFIED BY 'opnfv_secret';"
2018-03-14 03:34:17,359 [salt.loaded.int.module.cmdmod][INFO    ][8053] Executing command 'mysql -u root -popnfv_secret -e "GRANT ALL PRIVILEGES ON *.* TO 'debian-sys-maint'@'localhost' IDENTIFIED BY 'opnfv_secret';"' in directory '/root'
2018-03-14 03:34:17,392 [salt.state       ][INFO    ][8053] {'pid': 16051, 'retcode': 0, 'stderr': 'Warning: Using a password on the command line interface can be insecure.', 'stdout': ''}
2018-03-14 03:34:17,394 [salt.state       ][INFO    ][8053] Completed state [mysql -u root -popnfv_secret -e "GRANT ALL PRIVILEGES ON *.* TO 'debian-sys-maint'@'localhost' IDENTIFIED BY 'opnfv_secret';"] at time 03:34:17.393881 duration_in_ms=37.059
2018-03-14 03:34:17,398 [salt.state       ][INFO    ][8053] Running state [mysql] at time 03:34:17.397986
2018-03-14 03:34:17,398 [salt.state       ][INFO    ][8053] Executing state service.dead for mysql
2018-03-14 03:34:17,400 [salt.loaded.int.module.cmdmod][INFO    ][8053] Executing command ['systemctl', 'status', 'mysql.service', '-n', '0'] in directory '/root'
2018-03-14 03:34:17,434 [salt.loaded.int.module.cmdmod][INFO    ][8053] Executing command ['systemctl', 'is-active', 'mysql.service'] in directory '/root'
2018-03-14 03:34:17,462 [salt.loaded.int.module.cmdmod][INFO    ][8053] Executing command ['systemctl', 'is-enabled', 'mysql.service'] in directory '/root'
2018-03-14 03:34:17,491 [salt.loaded.int.module.cmdmod][INFO    ][8053] Executing command ['systemd-run', '--scope', 'systemctl', 'stop', 'mysql.service'] in directory '/root'
2018-03-14 03:34:18,621 [salt.loaded.int.module.cmdmod][INFO    ][8053] Executing command ['systemctl', 'is-active', 'mysql.service'] in directory '/root'
2018-03-14 03:34:18,651 [salt.loaded.int.module.cmdmod][INFO    ][8053] Executing command ['systemctl', 'is-enabled', 'mysql.service'] in directory '/root'
2018-03-14 03:34:18,681 [salt.state       ][INFO    ][8053] {'mysql': False}
2018-03-14 03:34:18,682 [salt.state       ][INFO    ][8053] Completed state [mysql] at time 03:34:18.682296 duration_in_ms=1284.31
2018-03-14 03:34:18,684 [salt.state       ][INFO    ][8053] Running state [/etc/mysql/my.cnf] at time 03:34:18.684566
2018-03-14 03:34:18,685 [salt.state       ][INFO    ][8053] Executing state file.managed for /etc/mysql/my.cnf
2018-03-14 03:34:18,711 [salt.fileclient  ][INFO    ][8053] Fetching file from saltenv 'base', ** done ** 'galera/files/my.cnf'
2018-03-14 03:34:18,786 [salt.state       ][INFO    ][8053] File changed:
--- 
+++ 
@@ -1,36 +1,67 @@
-[client]
-port		= 3306
-socket		= /var/run/mysqld/mysqld.sock
+# All files in this package is subject to the GPL v2 license
+# More information is in the COPYING file in the top directory of this package.
+# Copyright (C) 2011 severalnines.com
+
+[mysql]
+
+
 [mysqld_safe]
-socket		= /var/run/mysqld/mysqld.sock
-nice		= 0
 syslog
+
 [mysqld]
-user		= mysql
-pid-file	= /var/run/mysqld/mysqld.pid
-socket		= /var/run/mysqld/mysqld.sock
-port		= 3306
-basedir		= /usr
-datadir		= /var/lib/mysql
-tmpdir		= /tmp
-lc-messages-dir	= /usr/share/mysql
+datadir=/var/lib/mysql
+bind-address=10.167.4.25
+port=3306
+max_connections=3072
+default-storage-engine=innodb
+binlog_format=ROW
+collation-server=utf8_general_ci
+init-connect='SET NAMES utf8'
+character-set-server=utf8
+default-storage-engine=innodb
+#log_error = /var/log/mysql/error.log
 skip-external-locking
-bind-address		= 127.0.0.1
-key_buffer		= 16M
-max_allowed_packet	= 16M
-thread_stack		= 192K
-thread_cache_size       = 8
-myisam-recover         = BACKUP
-query_cache_limit	= 1M
-query_cache_size        = 16M
-log_error = /var/log/mysql/error.log
-expire_logs_days	= 10
-max_binlog_size         = 100M
-[mysqldump]
-quick
-quote-names
-max_allowed_packet	= 16M
-[mysql]
-[isamchk]
-key_buffer		= 16M
-!includedir /etc/mysql/conf.d/
+skip-name-resolve
+socket = /var/run/mysqld/mysqld.sock
+
+myisam_sort_buffer_size=64M
+wait_timeout=1800
+open_files_limit=102400
+table_open_cache=10000
+key_buffer_size=64M
+max_allowed_packet=256M
+query_cache_size=0
+query_cache_type=0
+
+innodb_file_format=Barracuda
+innodb_file_per_table=1
+innodb_buffer_pool_size=2048M
+innodb_log_file_size=627M
+innodb_read_io_threads=8
+innodb_write_io_threads=8
+innodb_io_capacity=500
+innodb_flush_log_at_trx_commit=2
+innodb_flush_method=O_DIRECT
+innodb_doublewrite=0
+innodb_autoinc_lock_mode=2
+innodb_locks_unsafe_for_binlog=1
+wsrep_cluster_address="gcomm://10.167.4.24:4567,10.167.4.25:4567,10.167.4.26:4567/?pc.wait_prim=no"
+wsrep_provider=/usr/lib/galera/libgalera_smm.so
+wsrep_cluster_name="openstack"
+
+wsrep_slave_threads=8
+wsrep_sst_method=xtrabackup-v2
+wsrep_sst_auth=root:opnfv_secret
+wsrep_node_address=10.167.4.25
+wsrep_provider_options="gcache.size = 256M"
+wsrep_provider_options="gmcast.listen_addr = tcp://10.167.4.25:4567"
+
+
+
+[xtrabackup]
+parallel=4
+
+[sst]
+streamfmt=xbstream
+transferfmt=socat
+sockopt=,nodelay,sndbuf=1048576,rcvbuf=1048576

2018-03-14 03:34:18,786 [salt.state       ][INFO    ][8053] Completed state [/etc/mysql/my.cnf] at time 03:34:18.786751 duration_in_ms=102.186
2018-03-14 03:34:18,788 [salt.state       ][INFO    ][8053] Running state [/usr/local/sbin/galera_bootstrap.sh] at time 03:34:18.788324
2018-03-14 03:34:18,788 [salt.state       ][INFO    ][8053] Executing state cmd.run for /usr/local/sbin/galera_bootstrap.sh
2018-03-14 03:34:18,789 [salt.loaded.int.module.cmdmod][INFO    ][8053] Executing command '/usr/local/sbin/galera_bootstrap.sh' in directory '/root'
2018-03-14 03:34:21,108 [salt.minion      ][INFO    ][1939] User sudo_ubuntu Executing command saltutil.find_job with jid 20180314033421101860
2018-03-14 03:34:21,142 [salt.minion      ][INFO    ][16798] Starting a new job with PID 16798
2018-03-14 03:34:21,169 [salt.minion      ][INFO    ][16798] Returning information for job: 20180314033421101860
2018-03-14 03:34:31,134 [salt.minion      ][INFO    ][1939] User sudo_ubuntu Executing command saltutil.find_job with jid 20180314033431129126
2018-03-14 03:34:31,162 [salt.minion      ][INFO    ][17147] Starting a new job with PID 17147
2018-03-14 03:34:31,186 [salt.minion      ][INFO    ][17147] Returning information for job: 20180314033431129126
2018-03-14 03:34:41,165 [salt.minion      ][INFO    ][1939] User sudo_ubuntu Executing command saltutil.find_job with jid 20180314033441159836
2018-03-14 03:34:41,192 [salt.minion      ][INFO    ][17172] Starting a new job with PID 17172
2018-03-14 03:34:41,228 [salt.minion      ][INFO    ][17172] Returning information for job: 20180314033441159836
2018-03-14 03:34:51,200 [salt.minion      ][INFO    ][1939] User sudo_ubuntu Executing command saltutil.find_job with jid 20180314033451196653
2018-03-14 03:34:51,227 [salt.minion      ][INFO    ][17247] Starting a new job with PID 17247
2018-03-14 03:34:51,251 [salt.minion      ][INFO    ][17247] Returning information for job: 20180314033451196653
2018-03-14 03:35:00,978 [salt.state       ][INFO    ][8053] {'pid': 16068, 'retcode': 0, 'stderr': "Warning: Using a password on the command line interface can be insecure.\nERROR 2002 (HY000): Can't connect to local MySQL server through socket '/var/run/mysqld/mysqld.sock' (111)\nWarning: Using a password on the command line interface can be insecure.", 'stdout': 'Sucessfully connected to the MySQL service (1 retries).'}
2018-03-14 03:35:00,980 [salt.state       ][INFO    ][8053] Completed state [/usr/local/sbin/galera_bootstrap.sh] at time 03:35:00.980112 duration_in_ms=42191.786
2018-03-14 03:35:00,983 [salt.state       ][INFO    ][8053] Running state [/var/lib/mysql/.galera_bootstrap] at time 03:35:00.983783
2018-03-14 03:35:00,985 [salt.state       ][INFO    ][8053] Executing state file.touch for /var/lib/mysql/.galera_bootstrap
2018-03-14 03:35:00,986 [salt.state       ][INFO    ][8053] {'new': '/var/lib/mysql/.galera_bootstrap'}
2018-03-14 03:35:00,987 [salt.state       ][INFO    ][8053] Completed state [/var/lib/mysql/.galera_bootstrap] at time 03:35:00.987758 duration_in_ms=3.976
2018-03-14 03:35:01,151 [salt.loaded.int.module.cmdmod][INFO    ][8053] Executing command ['git', '--version'] in directory '/root'
2018-03-14 03:35:01,232 [salt.minion      ][INFO    ][1939] User sudo_ubuntu Executing command saltutil.find_job with jid 20180314033501227261
2018-03-14 03:35:01,260 [salt.minion      ][INFO    ][17318] Starting a new job with PID 17318
2018-03-14 03:35:01,288 [salt.minion      ][INFO    ][17318] Returning information for job: 20180314033501227261
2018-03-14 03:35:01,611 [salt.state       ][INFO    ][8053] Running state [/etc/mysql/my.cnf] at time 03:35:01.611536
2018-03-14 03:35:01,613 [salt.state       ][INFO    ][8053] Executing state file.managed for /etc/mysql/my.cnf
2018-03-14 03:35:01,716 [salt.state       ][INFO    ][8053] File /etc/mysql/my.cnf is in the correct state
2018-03-14 03:35:01,717 [salt.state       ][INFO    ][8053] Completed state [/etc/mysql/my.cnf] at time 03:35:01.717271 duration_in_ms=105.737
2018-03-14 03:35:01,719 [salt.state       ][INFO    ][8053] Running state [mysql] at time 03:35:01.719807
2018-03-14 03:35:01,720 [salt.state       ][INFO    ][8053] Executing state service.running for mysql
2018-03-14 03:35:01,721 [salt.loaded.int.module.cmdmod][INFO    ][8053] Executing command ['systemctl', 'is-active', 'mysql.service'] in directory '/root'
2018-03-14 03:35:01,757 [salt.loaded.int.module.cmdmod][INFO    ][8053] Executing command ['systemctl', 'is-enabled', 'mysql.service'] in directory '/root'
2018-03-14 03:35:01,796 [salt.loaded.int.module.cmdmod][INFO    ][8053] Executing command ['systemctl', 'is-enabled', 'mysql.service'] in directory '/root'
2018-03-14 03:35:01,831 [salt.loaded.int.module.cmdmod][INFO    ][8053] Executing command ['systemctl', 'is-enabled', 'mysql.service'] in directory '/root'
2018-03-14 03:35:01,873 [salt.loaded.int.module.cmdmod][INFO    ][8053] Executing command ['systemd-run', '--scope', 'systemctl', 'enable', 'mysql.service'] in directory '/root'
2018-03-14 03:35:02,383 [salt.loaded.int.module.cmdmod][INFO    ][8053] Executing command ['systemctl', 'is-enabled', 'mysql.service'] in directory '/root'
2018-03-14 03:35:02,421 [salt.state       ][INFO    ][8053] {'mysql': True}
2018-03-14 03:35:02,423 [salt.state       ][INFO    ][8053] Completed state [mysql] at time 03:35:02.423120 duration_in_ms=703.311
2018-03-14 03:35:02,424 [salt.state       ][INFO    ][8053] Running state [ceilometer] at time 03:35:02.424458
2018-03-14 03:35:02,425 [salt.state       ][INFO    ][8053] Executing state mysql_database.present for ceilometer
2018-03-14 03:35:02,441 [salt.state       ][INFO    ][8053] Database ceilometer is already present
2018-03-14 03:35:02,442 [salt.state       ][INFO    ][8053] Completed state [ceilometer] at time 03:35:02.442682 duration_in_ms=18.224
2018-03-14 03:35:02,443 [salt.state       ][INFO    ][8053] Running state [ceilometer] at time 03:35:02.443665
2018-03-14 03:35:02,444 [salt.state       ][INFO    ][8053] Executing state mysql_user.present for ceilometer
2018-03-14 03:35:02,452 [salt.state       ][INFO    ][8053] User ceilometer@% is already present with the desired password
2018-03-14 03:35:02,452 [salt.state       ][INFO    ][8053] Completed state [ceilometer] at time 03:35:02.452768 duration_in_ms=9.103
2018-03-14 03:35:02,456 [salt.state       ][INFO    ][8053] Running state [mysql_grants_ceilometer_ceilometer_%] at time 03:35:02.456468
2018-03-14 03:35:02,457 [salt.state       ][INFO    ][8053] Executing state mysql_grants.present for mysql_grants_ceilometer_ceilometer_%
2018-03-14 03:35:02,467 [salt.state       ][INFO    ][8053] Grant all on ceilometer.* to ceilometer@% is already present
2018-03-14 03:35:02,468 [salt.state       ][INFO    ][8053] Completed state [mysql_grants_ceilometer_ceilometer_%] at time 03:35:02.468301 duration_in_ms=11.833
2018-03-14 03:35:02,469 [salt.state       ][INFO    ][8053] Running state [ceilometer] at time 03:35:02.469081
2018-03-14 03:35:02,469 [salt.state       ][INFO    ][8053] Executing state mysql_user.present for ceilometer
2018-03-14 03:35:02,522 [salt.loaded.int.module.mysql][INFO    ][8053] User 'ceilometer'@'10.167.4.25' has been created
2018-03-14 03:35:02,523 [salt.state       ][INFO    ][8053] {'ceilometer': 'Present'}
2018-03-14 03:35:02,523 [salt.state       ][INFO    ][8053] Completed state [ceilometer] at time 03:35:02.523787 duration_in_ms=54.705
2018-03-14 03:35:02,526 [salt.state       ][INFO    ][8053] Running state [mysql_grants_ceilometer_ceilometer_10.167.4.25] at time 03:35:02.526557
2018-03-14 03:35:02,527 [salt.state       ][INFO    ][8053] Executing state mysql_grants.present for mysql_grants_ceilometer_ceilometer_10.167.4.25
2018-03-14 03:35:02,567 [salt.loaded.int.module.mysql][INFO    ][8053] Grant 'all' on 'ceilometer.*' for user 'ceilometer' has been added
2018-03-14 03:35:02,568 [salt.state       ][INFO    ][8053] {'mysql_grants_ceilometer_ceilometer_10.167.4.25': 'Present'}
2018-03-14 03:35:02,569 [salt.state       ][INFO    ][8053] Completed state [mysql_grants_ceilometer_ceilometer_10.167.4.25] at time 03:35:02.569214 duration_in_ms=42.657
2018-03-14 03:35:02,570 [salt.state       ][INFO    ][8053] Running state [aodh] at time 03:35:02.570069
2018-03-14 03:35:02,571 [salt.state       ][INFO    ][8053] Executing state mysql_database.present for aodh
2018-03-14 03:35:02,576 [salt.state       ][INFO    ][8053] Database aodh is already present
2018-03-14 03:35:02,577 [salt.state       ][INFO    ][8053] Completed state [aodh] at time 03:35:02.577108 duration_in_ms=7.039
2018-03-14 03:35:02,577 [salt.state       ][INFO    ][8053] Running state [aodh] at time 03:35:02.577919
2018-03-14 03:35:02,578 [salt.state       ][INFO    ][8053] Executing state mysql_user.present for aodh
2018-03-14 03:35:02,585 [salt.state       ][INFO    ][8053] User aodh@% is already present with the desired password
2018-03-14 03:35:02,585 [salt.state       ][INFO    ][8053] Completed state [aodh] at time 03:35:02.585768 duration_in_ms=7.849
2018-03-14 03:35:02,588 [salt.state       ][INFO    ][8053] Running state [mysql_grants_aodh_aodh_%] at time 03:35:02.588633
2018-03-14 03:35:02,589 [salt.state       ][INFO    ][8053] Executing state mysql_grants.present for mysql_grants_aodh_aodh_%
2018-03-14 03:35:02,598 [salt.state       ][INFO    ][8053] Grant all on aodh.* to aodh@% is already present
2018-03-14 03:35:02,599 [salt.state       ][INFO    ][8053] Completed state [mysql_grants_aodh_aodh_%] at time 03:35:02.599392 duration_in_ms=10.759
2018-03-14 03:35:02,600 [salt.state       ][INFO    ][8053] Running state [aodh] at time 03:35:02.600152
2018-03-14 03:35:02,600 [salt.state       ][INFO    ][8053] Executing state mysql_user.present for aodh
2018-03-14 03:35:02,607 [salt.state       ][INFO    ][8053] User aodh@10.167.4.23 is already present with the desired password
2018-03-14 03:35:02,607 [salt.state       ][INFO    ][8053] Completed state [aodh] at time 03:35:02.607850 duration_in_ms=7.699
2018-03-14 03:35:02,610 [salt.state       ][INFO    ][8053] Running state [mysql_grants_aodh_aodh_10.167.4.23] at time 03:35:02.610187
2018-03-14 03:35:02,611 [salt.state       ][INFO    ][8053] Executing state mysql_grants.present for mysql_grants_aodh_aodh_10.167.4.23
2018-03-14 03:35:02,620 [salt.state       ][INFO    ][8053] Grant all on aodh.* to aodh@10.167.4.23 is already present
2018-03-14 03:35:02,620 [salt.state       ][INFO    ][8053] Completed state [mysql_grants_aodh_aodh_10.167.4.23] at time 03:35:02.620863 duration_in_ms=10.676
2018-03-14 03:35:02,621 [salt.state       ][INFO    ][8053] Running state [nova] at time 03:35:02.621588
2018-03-14 03:35:02,622 [salt.state       ][INFO    ][8053] Executing state mysql_database.present for nova
2018-03-14 03:35:02,627 [salt.state       ][INFO    ][8053] Database nova is already present
2018-03-14 03:35:02,628 [salt.state       ][INFO    ][8053] Completed state [nova] at time 03:35:02.628130 duration_in_ms=6.542
2018-03-14 03:35:02,628 [salt.state       ][INFO    ][8053] Running state [nova] at time 03:35:02.628856
2018-03-14 03:35:02,629 [salt.state       ][INFO    ][8053] Executing state mysql_user.present for nova
2018-03-14 03:35:02,635 [salt.state       ][INFO    ][8053] User nova@% is already present with the desired password
2018-03-14 03:35:02,636 [salt.state       ][INFO    ][8053] Completed state [nova] at time 03:35:02.636350 duration_in_ms=7.493
2018-03-14 03:35:02,638 [salt.state       ][INFO    ][8053] Running state [mysql_grants_nova_nova_%] at time 03:35:02.638883
2018-03-14 03:35:02,639 [salt.state       ][INFO    ][8053] Executing state mysql_grants.present for mysql_grants_nova_nova_%
2018-03-14 03:35:02,649 [salt.state       ][INFO    ][8053] Grant all on nova.* to nova@% is already present
2018-03-14 03:35:02,650 [salt.state       ][INFO    ][8053] Completed state [mysql_grants_nova_nova_%] at time 03:35:02.650074 duration_in_ms=11.191
2018-03-14 03:35:02,650 [salt.state       ][INFO    ][8053] Running state [nova] at time 03:35:02.650881
2018-03-14 03:35:02,651 [salt.state       ][INFO    ][8053] Executing state mysql_user.present for nova
2018-03-14 03:35:02,692 [salt.loaded.int.module.mysql][INFO    ][8053] User 'nova'@'10.167.4.25' has been created
2018-03-14 03:35:02,693 [salt.state       ][INFO    ][8053] {'nova': 'Present'}
2018-03-14 03:35:02,694 [salt.state       ][INFO    ][8053] Completed state [nova] at time 03:35:02.694367 duration_in_ms=43.485
2018-03-14 03:35:02,696 [salt.state       ][INFO    ][8053] Running state [mysql_grants_nova_nova_10.167.4.25] at time 03:35:02.696921
2018-03-14 03:35:02,697 [salt.state       ][INFO    ][8053] Executing state mysql_grants.present for mysql_grants_nova_nova_10.167.4.25
2018-03-14 03:35:02,735 [salt.loaded.int.module.mysql][INFO    ][8053] Grant 'all' on 'nova.*' for user 'nova' has been added
2018-03-14 03:35:02,736 [salt.state       ][INFO    ][8053] {'mysql_grants_nova_nova_10.167.4.25': 'Present'}
2018-03-14 03:35:02,736 [salt.state       ][INFO    ][8053] Completed state [mysql_grants_nova_nova_10.167.4.25] at time 03:35:02.736730 duration_in_ms=39.808
2018-03-14 03:35:02,737 [salt.state       ][INFO    ][8053] Running state [grafana] at time 03:35:02.737589
2018-03-14 03:35:02,738 [salt.state       ][INFO    ][8053] Executing state mysql_database.present for grafana
2018-03-14 03:35:02,744 [salt.state       ][INFO    ][8053] Database grafana is already present
2018-03-14 03:35:02,744 [salt.state       ][INFO    ][8053] Completed state [grafana] at time 03:35:02.744875 duration_in_ms=7.286
2018-03-14 03:35:02,745 [salt.state       ][INFO    ][8053] Running state [grafana] at time 03:35:02.745712
2018-03-14 03:35:02,746 [salt.state       ][INFO    ][8053] Executing state mysql_user.present for grafana
2018-03-14 03:35:02,752 [salt.state       ][INFO    ][8053] User grafana@% is already present with the desired password
2018-03-14 03:35:02,753 [salt.state       ][INFO    ][8053] Completed state [grafana] at time 03:35:02.753611 duration_in_ms=7.899
2018-03-14 03:35:02,756 [salt.state       ][INFO    ][8053] Running state [mysql_grants_grafana_grafana_%] at time 03:35:02.756395
2018-03-14 03:35:02,757 [salt.state       ][INFO    ][8053] Executing state mysql_grants.present for mysql_grants_grafana_grafana_%
2018-03-14 03:35:02,766 [salt.state       ][INFO    ][8053] Grant all on grafana.* to grafana@% is already present
2018-03-14 03:35:02,767 [salt.state       ][INFO    ][8053] Completed state [mysql_grants_grafana_grafana_%] at time 03:35:02.767343 duration_in_ms=10.948
2018-03-14 03:35:02,768 [salt.state       ][INFO    ][8053] Running state [grafana] at time 03:35:02.768086
2018-03-14 03:35:02,768 [salt.state       ][INFO    ][8053] Executing state mysql_user.present for grafana
2018-03-14 03:35:02,813 [salt.loaded.int.module.mysql][INFO    ][8053] User 'grafana'@'10.167.4.25' has been created
2018-03-14 03:35:02,814 [salt.state       ][INFO    ][8053] {'grafana': 'Present'}
2018-03-14 03:35:02,815 [salt.state       ][INFO    ][8053] Completed state [grafana] at time 03:35:02.815119 duration_in_ms=47.032
2018-03-14 03:35:02,818 [salt.state       ][INFO    ][8053] Running state [mysql_grants_grafana_grafana_10.167.4.25] at time 03:35:02.818195
2018-03-14 03:35:02,819 [salt.state       ][INFO    ][8053] Executing state mysql_grants.present for mysql_grants_grafana_grafana_10.167.4.25
2018-03-14 03:35:02,854 [salt.loaded.int.module.mysql][INFO    ][8053] Grant 'all' on 'grafana.*' for user 'grafana' has been added
2018-03-14 03:35:02,855 [salt.state       ][INFO    ][8053] {'mysql_grants_grafana_grafana_10.167.4.25': 'Present'}
2018-03-14 03:35:02,855 [salt.state       ][INFO    ][8053] Completed state [mysql_grants_grafana_grafana_10.167.4.25] at time 03:35:02.855716 duration_in_ms=37.521
2018-03-14 03:35:02,856 [salt.state       ][INFO    ][8053] Running state [designate_pool_manager] at time 03:35:02.856478
2018-03-14 03:35:02,857 [salt.state       ][INFO    ][8053] Executing state mysql_database.present for designate_pool_manager
2018-03-14 03:35:02,862 [salt.state       ][INFO    ][8053] Database designate_pool_manager is already present
2018-03-14 03:35:02,863 [salt.state       ][INFO    ][8053] Completed state [designate_pool_manager] at time 03:35:02.863391 duration_in_ms=6.913
2018-03-14 03:35:02,864 [salt.state       ][INFO    ][8053] Running state [designate] at time 03:35:02.864186
2018-03-14 03:35:02,864 [salt.state       ][INFO    ][8053] Executing state mysql_user.present for designate
2018-03-14 03:35:02,871 [salt.state       ][INFO    ][8053] User designate@% is already present with the desired password
2018-03-14 03:35:02,872 [salt.state       ][INFO    ][8053] Completed state [designate] at time 03:35:02.872078 duration_in_ms=7.892
2018-03-14 03:35:02,874 [salt.state       ][INFO    ][8053] Running state [mysql_grants_designate_designate_pool_manager_%] at time 03:35:02.874880
2018-03-14 03:35:02,875 [salt.state       ][INFO    ][8053] Executing state mysql_grants.present for mysql_grants_designate_designate_pool_manager_%
2018-03-14 03:35:02,885 [salt.state       ][INFO    ][8053] Grant all on designate_pool_manager.* to designate@% is already present
2018-03-14 03:35:02,885 [salt.state       ][INFO    ][8053] Completed state [mysql_grants_designate_designate_pool_manager_%] at time 03:35:02.885778 duration_in_ms=10.898
2018-03-14 03:35:02,886 [salt.state       ][INFO    ][8053] Running state [designate] at time 03:35:02.886552
2018-03-14 03:35:02,887 [salt.state       ][INFO    ][8053] Executing state mysql_user.present for designate
2018-03-14 03:35:02,893 [salt.state       ][INFO    ][8053] User designate@10.167.4.23 is already present with the desired password
2018-03-14 03:35:02,894 [salt.state       ][INFO    ][8053] Completed state [designate] at time 03:35:02.894126 duration_in_ms=7.574
2018-03-14 03:35:02,896 [salt.state       ][INFO    ][8053] Running state [mysql_grants_designate_designate_pool_manager_10.167.4.23] at time 03:35:02.896520
2018-03-14 03:35:02,897 [salt.state       ][INFO    ][8053] Executing state mysql_grants.present for mysql_grants_designate_designate_pool_manager_10.167.4.23
2018-03-14 03:35:02,906 [salt.state       ][INFO    ][8053] Grant all on designate_pool_manager.* to designate@10.167.4.23 is already present
2018-03-14 03:35:02,907 [salt.state       ][INFO    ][8053] Completed state [mysql_grants_designate_designate_pool_manager_10.167.4.23] at time 03:35:02.907172 duration_in_ms=10.653
2018-03-14 03:35:02,907 [salt.state       ][INFO    ][8053] Running state [heat] at time 03:35:02.907867
2018-03-14 03:35:02,908 [salt.state       ][INFO    ][8053] Executing state mysql_database.present for heat
2018-03-14 03:35:02,913 [salt.state       ][INFO    ][8053] Database heat is already present
2018-03-14 03:35:02,913 [salt.state       ][INFO    ][8053] Completed state [heat] at time 03:35:02.913893 duration_in_ms=6.027
2018-03-14 03:35:02,914 [salt.state       ][INFO    ][8053] Running state [heat] at time 03:35:02.914626
2018-03-14 03:35:02,915 [salt.state       ][INFO    ][8053] Executing state mysql_user.present for heat
2018-03-14 03:35:02,921 [salt.state       ][INFO    ][8053] User heat@% is already present with the desired password
2018-03-14 03:35:02,922 [salt.state       ][INFO    ][8053] Completed state [heat] at time 03:35:02.921995 duration_in_ms=7.369
2018-03-14 03:35:02,924 [salt.state       ][INFO    ][8053] Running state [mysql_grants_heat_heat_%] at time 03:35:02.924276
2018-03-14 03:35:02,925 [salt.state       ][INFO    ][8053] Executing state mysql_grants.present for mysql_grants_heat_heat_%
2018-03-14 03:35:02,933 [salt.state       ][INFO    ][8053] Grant all on heat.* to heat@% is already present
2018-03-14 03:35:02,934 [salt.state       ][INFO    ][8053] Completed state [mysql_grants_heat_heat_%] at time 03:35:02.934159 duration_in_ms=9.883
2018-03-14 03:35:02,934 [salt.state       ][INFO    ][8053] Running state [heat] at time 03:35:02.934891
2018-03-14 03:35:02,935 [salt.state       ][INFO    ][8053] Executing state mysql_user.present for heat
2018-03-14 03:35:02,981 [salt.loaded.int.module.mysql][INFO    ][8053] User 'heat'@'10.167.4.25' has been created
2018-03-14 03:35:02,982 [salt.state       ][INFO    ][8053] {'heat': 'Present'}
2018-03-14 03:35:02,982 [salt.state       ][INFO    ][8053] Completed state [heat] at time 03:35:02.982893 duration_in_ms=48.003
2018-03-14 03:35:02,985 [salt.state       ][INFO    ][8053] Running state [mysql_grants_heat_heat_10.167.4.25] at time 03:35:02.985490
2018-03-14 03:35:02,986 [salt.state       ][INFO    ][8053] Executing state mysql_grants.present for mysql_grants_heat_heat_10.167.4.25
2018-03-14 03:35:03,019 [salt.loaded.int.module.mysql][INFO    ][8053] Grant 'all' on 'heat.*' for user 'heat' has been added
2018-03-14 03:35:03,020 [salt.state       ][INFO    ][8053] {'mysql_grants_heat_heat_10.167.4.25': 'Present'}
2018-03-14 03:35:03,021 [salt.state       ][INFO    ][8053] Completed state [mysql_grants_heat_heat_10.167.4.25] at time 03:35:03.021191 duration_in_ms=35.701
2018-03-14 03:35:03,021 [salt.state       ][INFO    ][8053] Running state [nova_api] at time 03:35:03.021880
2018-03-14 03:35:03,022 [salt.state       ][INFO    ][8053] Executing state mysql_database.present for nova_api
2018-03-14 03:35:03,027 [salt.state       ][INFO    ][8053] Database nova_api is already present
2018-03-14 03:35:03,027 [salt.state       ][INFO    ][8053] Completed state [nova_api] at time 03:35:03.027672 duration_in_ms=5.792
2018-03-14 03:35:03,028 [salt.state       ][INFO    ][8053] Running state [nova] at time 03:35:03.028373
2018-03-14 03:35:03,029 [salt.state       ][INFO    ][8053] Executing state mysql_user.present for nova
2018-03-14 03:35:03,034 [salt.state       ][INFO    ][8053] User nova@% is already present with the desired password
2018-03-14 03:35:03,035 [salt.state       ][INFO    ][8053] Completed state [nova] at time 03:35:03.035248 duration_in_ms=6.875
2018-03-14 03:35:03,037 [salt.state       ][INFO    ][8053] Running state [mysql_grants_nova_nova_api_%] at time 03:35:03.037597
2018-03-14 03:35:03,038 [salt.state       ][INFO    ][8053] Executing state mysql_grants.present for mysql_grants_nova_nova_api_%
2018-03-14 03:35:03,047 [salt.state       ][INFO    ][8053] Grant all on nova_api.* to nova@% is already present
2018-03-14 03:35:03,047 [salt.state       ][INFO    ][8053] Completed state [mysql_grants_nova_nova_api_%] at time 03:35:03.047627 duration_in_ms=10.029
2018-03-14 03:35:03,048 [salt.state       ][INFO    ][8053] Running state [nova] at time 03:35:03.048306
2018-03-14 03:35:03,049 [salt.state       ][INFO    ][8053] Executing state mysql_user.present for nova
2018-03-14 03:35:03,053 [salt.state       ][INFO    ][8053] User nova@10.167.4.25 is already present with the desired password
2018-03-14 03:35:03,054 [salt.state       ][INFO    ][8053] Completed state [nova] at time 03:35:03.054317 duration_in_ms=6.01
2018-03-14 03:35:03,056 [salt.state       ][INFO    ][8053] Running state [mysql_grants_nova_nova_api_10.167.4.25] at time 03:35:03.056361
2018-03-14 03:35:03,057 [salt.state       ][INFO    ][8053] Executing state mysql_grants.present for mysql_grants_nova_nova_api_10.167.4.25
2018-03-14 03:35:03,087 [salt.loaded.int.module.mysql][INFO    ][8053] Grant 'all' on 'nova_api.*' for user 'nova' has been added
2018-03-14 03:35:03,087 [salt.state       ][INFO    ][8053] {'mysql_grants_nova_nova_api_10.167.4.25': 'Present'}
2018-03-14 03:35:03,088 [salt.state       ][INFO    ][8053] Completed state [mysql_grants_nova_nova_api_10.167.4.25] at time 03:35:03.088090 duration_in_ms=31.729
2018-03-14 03:35:03,088 [salt.state       ][INFO    ][8053] Running state [keystone] at time 03:35:03.088662
2018-03-14 03:35:03,089 [salt.state       ][INFO    ][8053] Executing state mysql_database.present for keystone
2018-03-14 03:35:03,093 [salt.state       ][INFO    ][8053] Database keystone is already present
2018-03-14 03:35:03,093 [salt.state       ][INFO    ][8053] Completed state [keystone] at time 03:35:03.093648 duration_in_ms=4.986
2018-03-14 03:35:03,094 [salt.state       ][INFO    ][8053] Running state [keystone] at time 03:35:03.094239
2018-03-14 03:35:03,094 [salt.state       ][INFO    ][8053] Executing state mysql_user.present for keystone
2018-03-14 03:35:03,100 [salt.state       ][INFO    ][8053] User keystone@% is already present with the desired password
2018-03-14 03:35:03,100 [salt.state       ][INFO    ][8053] Completed state [keystone] at time 03:35:03.100827 duration_in_ms=6.587
2018-03-14 03:35:03,103 [salt.state       ][INFO    ][8053] Running state [mysql_grants_keystone_keystone_%] at time 03:35:03.103258
2018-03-14 03:35:03,103 [salt.state       ][INFO    ][8053] Executing state mysql_grants.present for mysql_grants_keystone_keystone_%
2018-03-14 03:35:03,111 [salt.state       ][INFO    ][8053] Grant all on keystone.* to keystone@% is already present
2018-03-14 03:35:03,111 [salt.state       ][INFO    ][8053] Completed state [mysql_grants_keystone_keystone_%] at time 03:35:03.111624 duration_in_ms=8.367
2018-03-14 03:35:03,112 [salt.state       ][INFO    ][8053] Running state [keystone] at time 03:35:03.112179
2018-03-14 03:35:03,112 [salt.state       ][INFO    ][8053] Executing state mysql_user.present for keystone
2018-03-14 03:35:03,148 [salt.loaded.int.module.mysql][INFO    ][8053] User 'keystone'@'10.167.4.25' has been created
2018-03-14 03:35:03,148 [salt.state       ][INFO    ][8053] {'keystone': 'Present'}
2018-03-14 03:35:03,149 [salt.state       ][INFO    ][8053] Completed state [keystone] at time 03:35:03.149332 duration_in_ms=37.153
2018-03-14 03:35:03,151 [salt.state       ][INFO    ][8053] Running state [mysql_grants_keystone_keystone_10.167.4.25] at time 03:35:03.151171
2018-03-14 03:35:03,151 [salt.state       ][INFO    ][8053] Executing state mysql_grants.present for mysql_grants_keystone_keystone_10.167.4.25
2018-03-14 03:35:03,188 [salt.loaded.int.module.mysql][INFO    ][8053] Grant 'all' on 'keystone.*' for user 'keystone' has been added
2018-03-14 03:35:03,189 [salt.state       ][INFO    ][8053] {'mysql_grants_keystone_keystone_10.167.4.25': 'Present'}
2018-03-14 03:35:03,190 [salt.state       ][INFO    ][8053] Completed state [mysql_grants_keystone_keystone_10.167.4.25] at time 03:35:03.190003 duration_in_ms=38.832
2018-03-14 03:35:03,190 [salt.state       ][INFO    ][8053] Running state [nova_cell0] at time 03:35:03.190607
2018-03-14 03:35:03,191 [salt.state       ][INFO    ][8053] Executing state mysql_database.present for nova_cell0
2018-03-14 03:35:03,195 [salt.state       ][INFO    ][8053] Database nova_cell0 is already present
2018-03-14 03:35:03,196 [salt.state       ][INFO    ][8053] Completed state [nova_cell0] at time 03:35:03.196143 duration_in_ms=5.536
2018-03-14 03:35:03,196 [salt.state       ][INFO    ][8053] Running state [nova] at time 03:35:03.196830
2018-03-14 03:35:03,197 [salt.state       ][INFO    ][8053] Executing state mysql_user.present for nova
2018-03-14 03:35:03,203 [salt.state       ][INFO    ][8053] User nova@% is already present with the desired password
2018-03-14 03:35:03,206 [salt.state       ][INFO    ][8053] Completed state [nova] at time 03:35:03.206659 duration_in_ms=9.828
2018-03-14 03:35:03,208 [salt.state       ][INFO    ][8053] Running state [mysql_grants_nova_nova_cell0_%] at time 03:35:03.208529
2018-03-14 03:35:03,209 [salt.state       ][INFO    ][8053] Executing state mysql_grants.present for mysql_grants_nova_nova_cell0_%
2018-03-14 03:35:03,217 [salt.state       ][INFO    ][8053] Grant all on nova_cell0.* to nova@% is already present
2018-03-14 03:35:03,218 [salt.state       ][INFO    ][8053] Completed state [mysql_grants_nova_nova_cell0_%] at time 03:35:03.218095 duration_in_ms=9.566
2018-03-14 03:35:03,218 [salt.state       ][INFO    ][8053] Running state [nova] at time 03:35:03.218698
2018-03-14 03:35:03,219 [salt.state       ][INFO    ][8053] Executing state mysql_user.present for nova
2018-03-14 03:35:03,224 [salt.state       ][INFO    ][8053] User nova@10.167.4.25 is already present with the desired password
2018-03-14 03:35:03,225 [salt.state       ][INFO    ][8053] Completed state [nova] at time 03:35:03.225387 duration_in_ms=6.689
2018-03-14 03:35:03,227 [salt.state       ][INFO    ][8053] Running state [mysql_grants_nova_nova_cell0_10.167.4.25] at time 03:35:03.227134
2018-03-14 03:35:03,227 [salt.state       ][INFO    ][8053] Executing state mysql_grants.present for mysql_grants_nova_nova_cell0_10.167.4.25
2018-03-14 03:35:03,261 [salt.loaded.int.module.mysql][INFO    ][8053] Grant 'all' on 'nova_cell0.*' for user 'nova' has been added
2018-03-14 03:35:03,262 [salt.state       ][INFO    ][8053] {'mysql_grants_nova_nova_cell0_10.167.4.25': 'Present'}
2018-03-14 03:35:03,263 [salt.state       ][INFO    ][8053] Completed state [mysql_grants_nova_nova_cell0_10.167.4.25] at time 03:35:03.263266 duration_in_ms=36.132
2018-03-14 03:35:03,264 [salt.state       ][INFO    ][8053] Running state [cinder] at time 03:35:03.263964
2018-03-14 03:35:03,264 [salt.state       ][INFO    ][8053] Executing state mysql_database.present for cinder
2018-03-14 03:35:03,269 [salt.state       ][INFO    ][8053] Database cinder is already present
2018-03-14 03:35:03,270 [salt.state       ][INFO    ][8053] Completed state [cinder] at time 03:35:03.270254 duration_in_ms=6.291
2018-03-14 03:35:03,271 [salt.state       ][INFO    ][8053] Running state [cinder] at time 03:35:03.270986
2018-03-14 03:35:03,271 [salt.state       ][INFO    ][8053] Executing state mysql_user.present for cinder
2018-03-14 03:35:03,277 [salt.state       ][INFO    ][8053] User cinder@% is already present with the desired password
2018-03-14 03:35:03,278 [salt.state       ][INFO    ][8053] Completed state [cinder] at time 03:35:03.278332 duration_in_ms=7.346
2018-03-14 03:35:03,280 [salt.state       ][INFO    ][8053] Running state [mysql_grants_cinder_cinder_%] at time 03:35:03.280646
2018-03-14 03:35:03,281 [salt.state       ][INFO    ][8053] Executing state mysql_grants.present for mysql_grants_cinder_cinder_%
2018-03-14 03:35:03,290 [salt.state       ][INFO    ][8053] Grant all on cinder.* to cinder@% is already present
2018-03-14 03:35:03,290 [salt.state       ][INFO    ][8053] Completed state [mysql_grants_cinder_cinder_%] at time 03:35:03.290593 duration_in_ms=9.948
2018-03-14 03:35:03,291 [salt.state       ][INFO    ][8053] Running state [cinder] at time 03:35:03.291234
2018-03-14 03:35:03,291 [salt.state       ][INFO    ][8053] Executing state mysql_user.present for cinder
2018-03-14 03:35:03,335 [salt.loaded.int.module.mysql][INFO    ][8053] User 'cinder'@'10.167.4.25' has been created
2018-03-14 03:35:03,336 [salt.state       ][INFO    ][8053] {'cinder': 'Present'}
2018-03-14 03:35:03,336 [salt.state       ][INFO    ][8053] Completed state [cinder] at time 03:35:03.336708 duration_in_ms=45.475
2018-03-14 03:35:03,339 [salt.state       ][INFO    ][8053] Running state [mysql_grants_cinder_cinder_10.167.4.25] at time 03:35:03.339110
2018-03-14 03:35:03,339 [salt.state       ][INFO    ][8053] Executing state mysql_grants.present for mysql_grants_cinder_cinder_10.167.4.25
2018-03-14 03:35:03,375 [salt.loaded.int.module.mysql][INFO    ][8053] Grant 'all' on 'cinder.*' for user 'cinder' has been added
2018-03-14 03:35:03,376 [salt.state       ][INFO    ][8053] {'mysql_grants_cinder_cinder_10.167.4.25': 'Present'}
2018-03-14 03:35:03,376 [salt.state       ][INFO    ][8053] Completed state [mysql_grants_cinder_cinder_10.167.4.25] at time 03:35:03.376548 duration_in_ms=37.438
2018-03-14 03:35:03,377 [salt.state       ][INFO    ][8053] Running state [glance] at time 03:35:03.377185
2018-03-14 03:35:03,377 [salt.state       ][INFO    ][8053] Executing state mysql_database.present for glance
2018-03-14 03:35:03,382 [salt.state       ][INFO    ][8053] Database glance is already present
2018-03-14 03:35:03,383 [salt.state       ][INFO    ][8053] Completed state [glance] at time 03:35:03.383003 duration_in_ms=5.818
2018-03-14 03:35:03,383 [salt.state       ][INFO    ][8053] Running state [glance] at time 03:35:03.383648
2018-03-14 03:35:03,384 [salt.state       ][INFO    ][8053] Executing state mysql_user.present for glance
2018-03-14 03:35:03,390 [salt.state       ][INFO    ][8053] User glance@% is already present with the desired password
2018-03-14 03:35:03,390 [salt.state       ][INFO    ][8053] Completed state [glance] at time 03:35:03.390872 duration_in_ms=7.224
2018-03-14 03:35:03,393 [salt.state       ][INFO    ][8053] Running state [mysql_grants_glance_glance_%] at time 03:35:03.393037
2018-03-14 03:35:03,393 [salt.state       ][INFO    ][8053] Executing state mysql_grants.present for mysql_grants_glance_glance_%
2018-03-14 03:35:03,402 [salt.state       ][INFO    ][8053] Grant all on glance.* to glance@% is already present
2018-03-14 03:35:03,403 [salt.state       ][INFO    ][8053] Completed state [mysql_grants_glance_glance_%] at time 03:35:03.403176 duration_in_ms=10.139
2018-03-14 03:35:03,403 [salt.state       ][INFO    ][8053] Running state [glance] at time 03:35:03.403794
2018-03-14 03:35:03,404 [salt.state       ][INFO    ][8053] Executing state mysql_user.present for glance
2018-03-14 03:35:03,443 [salt.loaded.int.module.mysql][INFO    ][8053] User 'glance'@'10.167.4.25' has been created
2018-03-14 03:35:03,444 [salt.state       ][INFO    ][8053] {'glance': 'Present'}
2018-03-14 03:35:03,445 [salt.state       ][INFO    ][8053] Completed state [glance] at time 03:35:03.445401 duration_in_ms=41.607
2018-03-14 03:35:03,448 [salt.state       ][INFO    ][8053] Running state [mysql_grants_glance_glance_10.167.4.25] at time 03:35:03.448278
2018-03-14 03:35:03,449 [salt.state       ][INFO    ][8053] Executing state mysql_grants.present for mysql_grants_glance_glance_10.167.4.25
2018-03-14 03:35:03,491 [salt.loaded.int.module.mysql][INFO    ][8053] Grant 'all' on 'glance.*' for user 'glance' has been added
2018-03-14 03:35:03,492 [salt.state       ][INFO    ][8053] {'mysql_grants_glance_glance_10.167.4.25': 'Present'}
2018-03-14 03:35:03,493 [salt.state       ][INFO    ][8053] Completed state [mysql_grants_glance_glance_10.167.4.25] at time 03:35:03.493340 duration_in_ms=45.061
2018-03-14 03:35:03,494 [salt.state       ][INFO    ][8053] Running state [neutron] at time 03:35:03.494273
2018-03-14 03:35:03,495 [salt.state       ][INFO    ][8053] Executing state mysql_database.present for neutron
2018-03-14 03:35:03,500 [salt.state       ][INFO    ][8053] Database neutron is already present
2018-03-14 03:35:03,501 [salt.state       ][INFO    ][8053] Completed state [neutron] at time 03:35:03.501695 duration_in_ms=7.422
2018-03-14 03:35:03,502 [salt.state       ][INFO    ][8053] Running state [neutron] at time 03:35:03.502620
2018-03-14 03:35:03,503 [salt.state       ][INFO    ][8053] Executing state mysql_user.present for neutron
2018-03-14 03:35:03,510 [salt.state       ][INFO    ][8053] User neutron@% is already present with the desired password
2018-03-14 03:35:03,511 [salt.state       ][INFO    ][8053] Completed state [neutron] at time 03:35:03.511261 duration_in_ms=8.641
2018-03-14 03:35:03,514 [salt.state       ][INFO    ][8053] Running state [mysql_grants_neutron_neutron_%] at time 03:35:03.514324
2018-03-14 03:35:03,515 [salt.state       ][INFO    ][8053] Executing state mysql_grants.present for mysql_grants_neutron_neutron_%
2018-03-14 03:35:03,525 [salt.state       ][INFO    ][8053] Grant all on neutron.* to neutron@% is already present
2018-03-14 03:35:03,526 [salt.state       ][INFO    ][8053] Completed state [mysql_grants_neutron_neutron_%] at time 03:35:03.526132 duration_in_ms=11.808
2018-03-14 03:35:03,527 [salt.state       ][INFO    ][8053] Running state [neutron] at time 03:35:03.527022
2018-03-14 03:35:03,527 [salt.state       ][INFO    ][8053] Executing state mysql_user.present for neutron
2018-03-14 03:35:03,573 [salt.loaded.int.module.mysql][INFO    ][8053] User 'neutron'@'10.167.4.25' has been created
2018-03-14 03:35:03,574 [salt.state       ][INFO    ][8053] {'neutron': 'Present'}
2018-03-14 03:35:03,575 [salt.state       ][INFO    ][8053] Completed state [neutron] at time 03:35:03.575624 duration_in_ms=48.602
2018-03-14 03:35:03,578 [salt.state       ][INFO    ][8053] Running state [mysql_grants_neutron_neutron_10.167.4.25] at time 03:35:03.578428
2018-03-14 03:35:03,579 [salt.state       ][INFO    ][8053] Executing state mysql_grants.present for mysql_grants_neutron_neutron_10.167.4.25
2018-03-14 03:35:03,617 [salt.loaded.int.module.mysql][INFO    ][8053] Grant 'all' on 'neutron.*' for user 'neutron' has been added
2018-03-14 03:35:03,618 [salt.state       ][INFO    ][8053] {'mysql_grants_neutron_neutron_10.167.4.25': 'Present'}
2018-03-14 03:35:03,619 [salt.state       ][INFO    ][8053] Completed state [mysql_grants_neutron_neutron_10.167.4.25] at time 03:35:03.619155 duration_in_ms=40.727
2018-03-14 03:35:03,620 [salt.state       ][INFO    ][8053] Running state [designate] at time 03:35:03.619959
2018-03-14 03:35:03,620 [salt.state       ][INFO    ][8053] Executing state mysql_database.present for designate
2018-03-14 03:35:03,626 [salt.state       ][INFO    ][8053] Database designate is already present
2018-03-14 03:35:03,627 [salt.state       ][INFO    ][8053] Completed state [designate] at time 03:35:03.627119 duration_in_ms=7.16
2018-03-14 03:35:03,627 [salt.state       ][INFO    ][8053] Running state [designate] at time 03:35:03.627925
2018-03-14 03:35:03,628 [salt.state       ][INFO    ][8053] Executing state mysql_user.present for designate
2018-03-14 03:35:03,635 [salt.state       ][INFO    ][8053] User designate@% is already present with the desired password
2018-03-14 03:35:03,636 [salt.state       ][INFO    ][8053] Completed state [designate] at time 03:35:03.636159 duration_in_ms=8.234
2018-03-14 03:35:03,639 [salt.state       ][INFO    ][8053] Running state [mysql_grants_designate_designate_%] at time 03:35:03.638956
2018-03-14 03:35:03,639 [salt.state       ][INFO    ][8053] Executing state mysql_grants.present for mysql_grants_designate_designate_%
2018-03-14 03:35:03,649 [salt.state       ][INFO    ][8053] Grant all on designate.* to designate@% is already present
2018-03-14 03:35:03,650 [salt.state       ][INFO    ][8053] Completed state [mysql_grants_designate_designate_%] at time 03:35:03.650251 duration_in_ms=11.295
2018-03-14 03:35:03,651 [salt.state       ][INFO    ][8053] Running state [designate] at time 03:35:03.651019
2018-03-14 03:35:03,651 [salt.state       ][INFO    ][8053] Executing state mysql_user.present for designate
2018-03-14 03:35:03,657 [salt.state       ][INFO    ][8053] User designate@10.167.4.23 is already present with the desired password
2018-03-14 03:35:03,658 [salt.state       ][INFO    ][8053] Completed state [designate] at time 03:35:03.658621 duration_in_ms=7.601
2018-03-14 03:35:03,660 [salt.state       ][INFO    ][8053] Running state [mysql_grants_designate_designate_10.167.4.23] at time 03:35:03.660846
2018-03-14 03:35:03,661 [salt.state       ][INFO    ][8053] Executing state mysql_grants.present for mysql_grants_designate_designate_10.167.4.23
2018-03-14 03:35:03,671 [salt.state       ][INFO    ][8053] Grant all on designate.* to designate@10.167.4.23 is already present
2018-03-14 03:35:03,671 [salt.state       ][INFO    ][8053] Completed state [mysql_grants_designate_designate_10.167.4.23] at time 03:35:03.671588 duration_in_ms=10.742
2018-03-14 03:35:03,672 [salt.state       ][INFO    ][8053] Running state [haproxy] at time 03:35:03.672256
2018-03-14 03:35:03,672 [salt.state       ][INFO    ][8053] Executing state mysql_user.present for haproxy
2018-03-14 03:35:03,679 [salt.state       ][INFO    ][8053] User haproxy@localhost is already present with passwordless login
2018-03-14 03:35:03,679 [salt.state       ][INFO    ][8053] Completed state [haproxy] at time 03:35:03.679637 duration_in_ms=7.381
2018-03-14 03:35:03,680 [salt.state       ][INFO    ][8053] Running state [haproxy] at time 03:35:03.680298
2018-03-14 03:35:03,680 [salt.state       ][INFO    ][8053] Executing state mysql_user.present for haproxy
2018-03-14 03:35:03,687 [salt.state       ][INFO    ][8053] User haproxy@% is already present with passwordless login
2018-03-14 03:35:03,688 [salt.state       ][INFO    ][8053] Completed state [haproxy] at time 03:35:03.687943 duration_in_ms=7.645
2018-03-14 03:35:03,688 [salt.state       ][INFO    ][8053] Running state [haproxy] at time 03:35:03.688610
2018-03-14 03:35:03,689 [salt.state       ][INFO    ][8053] Executing state mysql_user.present for haproxy
2018-03-14 03:35:03,732 [salt.loaded.int.module.mysql][INFO    ][8053] User 'haproxy'@'10.167.4.25' has been created with passwordless login
2018-03-14 03:35:03,733 [salt.state       ][INFO    ][8053] {'haproxy': 'Present'}
2018-03-14 03:35:03,734 [salt.state       ][INFO    ][8053] Completed state [haproxy] at time 03:35:03.733984 duration_in_ms=45.373
2018-03-14 03:35:03,741 [salt.minion      ][INFO    ][8053] Returning information for job: 20180314033250705612
2018-03-14 03:35:31,308 [salt.minion      ][INFO    ][1939] User sudo_ubuntu Executing command state.sls with jid 20180314033531310625
2018-03-14 03:35:31,347 [salt.minion      ][INFO    ][17403] Starting a new job with PID 17403
2018-03-14 03:35:32,196 [salt.state       ][INFO    ][17403] Loading fresh modules for state activity
2018-03-14 03:35:32,260 [salt.fileclient  ][INFO    ][17403] Fetching file from saltenv 'base', ** done ** 'haproxy/init.sls'
2018-03-14 03:35:32,287 [salt.fileclient  ][INFO    ][17403] Fetching file from saltenv 'base', ** done ** 'haproxy/proxy.sls'
2018-03-14 03:35:32,920 [salt.state       ][INFO    ][17403] Running state [haproxy] at time 03:35:32.920654
2018-03-14 03:35:32,921 [salt.state       ][INFO    ][17403] Executing state pkg.installed for haproxy
2018-03-14 03:35:32,921 [salt.loaded.int.module.cmdmod][INFO    ][17403] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2018-03-14 03:35:33,259 [salt.loaded.int.module.cmdmod][INFO    ][17403] Executing command ['apt-cache', '-q', 'policy', 'haproxy'] in directory '/root'
2018-03-14 03:35:33,355 [salt.loaded.int.module.cmdmod][INFO    ][17403] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2018-03-14 03:35:35,129 [salt.loaded.int.module.cmdmod][INFO    ][17403] Executing command ['dpkg', '--get-selections', '*'] in directory '/root'
2018-03-14 03:35:35,153 [salt.loaded.int.module.cmdmod][INFO    ][17403] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'haproxy'] in directory '/root'
2018-03-14 03:35:41,400 [salt.minion      ][INFO    ][1939] User sudo_ubuntu Executing command saltutil.find_job with jid 20180314033541396311
2018-03-14 03:35:41,433 [salt.minion      ][INFO    ][18059] Starting a new job with PID 18059
2018-03-14 03:35:41,456 [salt.minion      ][INFO    ][18059] Returning information for job: 20180314033541396311
2018-03-14 03:35:43,661 [salt.loaded.int.module.cmdmod][INFO    ][17403] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2018-03-14 03:35:43,693 [salt.state       ][INFO    ][17403] Made the following changes:
'haproxy' changed from 'absent' to '1.6.3-1ubuntu0.1'
'liblua5.3-0' changed from 'absent' to '5.3.1-1ubuntu2'

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

2018-03-14 03:35:43,805 [salt.state       ][INFO    ][17403] Completed state [/etc/default/haproxy] at time 03:35:43.805710 duration_in_ms=33.894
2018-03-14 03:35:43,806 [salt.state       ][INFO    ][17403] Running state [/etc/haproxy/haproxy.cfg] at time 03:35:43.806380
2018-03-14 03:35:43,807 [salt.state       ][INFO    ][17403] Executing state file.managed for /etc/haproxy/haproxy.cfg
2018-03-14 03:35:43,835 [salt.fileclient  ][INFO    ][17403] Fetching file from saltenv 'base', ** done ** 'haproxy/files/haproxy.cfg'
2018-03-14 03:35:43,963 [salt.state       ][INFO    ][17403] File changed:
--- 
+++ 
@@ -1,35 +1,54 @@
 global
-	log /dev/log	local0
-	log /dev/log	local1 notice
-	chroot /var/lib/haproxy
-	stats socket /run/haproxy/admin.sock mode 660 level admin
-	stats timeout 30s
-	user haproxy
-	group haproxy
-	daemon
-
-	# Default SSL material locations
-	ca-base /etc/ssl/certs
-	crt-base /etc/ssl/private
-
-	# Default ciphers to use on SSL-enabled listening sockets.
-	# For more information, see ciphers(1SSL). This list is from:
-	#  https://hynek.me/articles/hardening-your-web-servers-ssl-ciphers/
-	ssl-default-bind-ciphers ECDH+AESGCM:DH+AESGCM:ECDH+AES256:DH+AES256:ECDH+AES128:DH+AES:ECDH+3DES:DH+3DES:RSA+AESGCM:RSA+AES:RSA+3DES:!aNULL:!MD5:!DSS
-	ssl-default-bind-options no-sslv3
+  log /dev/log  local0
+  log /dev/log  local1 notice
+  chroot /var/lib/haproxy
+  stats  socket /run/haproxy/admin.sock mode 660 level admin
+  stats timeout 30s
+  user  haproxy
+  group haproxy
+  daemon
+  pidfile  /var/run/haproxy.pid
+  spread-checks 4
+  tune.maxrewrite 1024
+  tune.bufsize 32768
+  maxconn  16000
+  # SSL options
+  ca-base /etc/haproxy/ssl
+  crt-base /etc/haproxy/ssl
+  tune.ssl.default-dh-param 2048
+  ssl-default-bind-ciphers ECDHE-ECDSA-CHACHA20-POLY1305:ECDHE-RSA-CHACHA20-POLY1305:ECDHE-ECDSA-AES128-GCM-SHA256:ECDHE-RSA-AES128-GCM-SHA256:ECDHE-ECDSA-AES256-GCM-SHA384:ECDHE-RSA-AES256-GCM-SHA384:DHE-RSA-AES128-GCM-SHA256:DHE-RSA-AES256-GCM-SHA384:ECDHE-ECDSA-AES128-SHA256:ECDHE-RSA-AES128-SHA256:ECDHE-ECDSA-AES128-SHA:ECDHE-RSA-AES256-SHA384:ECDHE-RSA-AES128-SHA:ECDHE-ECDSA-AES256-SHA384:ECDHE-ECDSA-AES256-SHA:ECDHE-RSA-AES256-SHA:DHE-RSA-AES128-SHA256:DHE-RSA-AES128-SHA:DHE-RSA-AES256-SHA256:DHE-RSA-AES256-SHA:ECDHE-ECDSA-DES-CBC3-SHA:ECDHE-RSA-DES-CBC3-SHA:EDH-RSA-DES-CBC3-SHA:AES128-GCM-SHA256:AES256-GCM-SHA384:AES128-SHA256:AES256-SHA256:AES128-SHA:AES256-SHA:DES-CBC3-SHA:!DSS
+  ssl-default-bind-options no-sslv3 no-tls-tickets
+  ssl-default-server-ciphers ECDHE-ECDSA-CHACHA20-POLY1305:ECDHE-RSA-CHACHA20-POLY1305:ECDHE-ECDSA-AES128-GCM-SHA256:ECDHE-RSA-AES128-GCM-SHA256:ECDHE-ECDSA-AES256-GCM-SHA384:ECDHE-RSA-AES256-GCM-SHA384:DHE-RSA-AES128-GCM-SHA256:DHE-RSA-AES256-GCM-SHA384:ECDHE-ECDSA-AES128-SHA256:ECDHE-RSA-AES128-SHA256:ECDHE-ECDSA-AES128-SHA:ECDHE-RSA-AES256-SHA384:ECDHE-RSA-AES128-SHA:ECDHE-ECDSA-AES256-SHA384:ECDHE-ECDSA-AES256-SHA:ECDHE-RSA-AES256-SHA:DHE-RSA-AES128-SHA256:DHE-RSA-AES128-SHA:DHE-RSA-AES256-SHA256:DHE-RSA-AES256-SHA:ECDHE-ECDSA-DES-CBC3-SHA:ECDHE-RSA-DES-CBC3-SHA:EDH-RSA-DES-CBC3-SHA:AES128-GCM-SHA256:AES256-GCM-SHA384:AES128-SHA256:AES256-SHA256:AES128-SHA:AES256-SHA:DES-CBC3-SHA:!DSS
+  ssl-default-server-options no-sslv3 no-tls-tickets
 
 defaults
-	log	global
-	mode	http
-	option	httplog
-	option	dontlognull
-        timeout connect 5000
-        timeout client  50000
-        timeout server  50000
-	errorfile 400 /etc/haproxy/errors/400.http
-	errorfile 403 /etc/haproxy/errors/403.http
-	errorfile 408 /etc/haproxy/errors/408.http
-	errorfile 500 /etc/haproxy/errors/500.http
-	errorfile 502 /etc/haproxy/errors/502.http
-	errorfile 503 /etc/haproxy/errors/503.http
-	errorfile 504 /etc/haproxy/errors/504.http
+  log  global
+  mode http
+
+  maxconn 8000
+  option  redispatch
+  retries  3
+  stats  enable
+
+  timeout http-request 10s
+  timeout queue 10s
+  timeout connect 10s
+  timeout client 10s
+  timeout server 10s
+  timeout check 10s
+
+listen mysql_cluster
+  bind 10.167.4.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 10.167.4.24:3306 check inter 20s fastinter 2s downinter 2s rise 3 fall 3
+  server dbs02 10.167.4.25:3306 backup check inter 20s fastinter 2s downinter 2s rise 3 fall 3
+  server dbs03 10.167.4.26:3306 backup check inter 20s fastinter 2s downinter 2s rise 3 fall 3

2018-03-14 03:35:43,967 [salt.state       ][INFO    ][17403] Completed state [/etc/haproxy/haproxy.cfg] at time 03:35:43.967325 duration_in_ms=160.945
2018-03-14 03:35:43,967 [salt.state       ][INFO    ][17403] Running state [/etc/haproxy/ssl] at time 03:35:43.967646
2018-03-14 03:35:43,967 [salt.state       ][INFO    ][17403] Executing state file.directory for /etc/haproxy/ssl
2018-03-14 03:35:43,969 [salt.state       ][INFO    ][17403] {'/etc/haproxy/ssl': 'New Dir'}
2018-03-14 03:35:43,969 [salt.state       ][INFO    ][17403] Completed state [/etc/haproxy/ssl] at time 03:35:43.969301 duration_in_ms=1.656
2018-03-14 03:35:43,969 [salt.state       ][INFO    ][17403] Running state [/etc/haproxy/errors/429.http11] at time 03:35:43.969537
2018-03-14 03:35:43,969 [salt.state       ][INFO    ][17403] Executing state file.managed for /etc/haproxy/errors/429.http11
2018-03-14 03:35:43,991 [salt.fileclient  ][INFO    ][17403] Fetching file from saltenv 'base', ** done ** 'haproxy/files/errors/429.http11'
2018-03-14 03:35:43,993 [salt.state       ][INFO    ][17403] File changed:
New file
2018-03-14 03:35:43,993 [salt.state       ][INFO    ][17403] Completed state [/etc/haproxy/errors/429.http11] at time 03:35:43.993815 duration_in_ms=24.277
2018-03-14 03:35:43,994 [salt.state       ][INFO    ][17403] Running state [haproxy_status_packages] at time 03:35:43.994660
2018-03-14 03:35:43,994 [salt.state       ][INFO    ][17403] Executing state pkg.installed for haproxy_status_packages
2018-03-14 03:35:44,279 [salt.state       ][INFO    ][17403] All specified packages are already installed
2018-03-14 03:35:44,280 [salt.state       ][INFO    ][17403] Completed state [haproxy_status_packages] at time 03:35:44.279962 duration_in_ms=285.302
2018-03-14 03:35:44,280 [salt.state       ][INFO    ][17403] Running state [/usr/bin/haproxy-status.sh] at time 03:35:44.280485
2018-03-14 03:35:44,280 [salt.state       ][INFO    ][17403] Executing state file.managed for /usr/bin/haproxy-status.sh
2018-03-14 03:35:44,298 [salt.fileclient  ][INFO    ][17403] Fetching file from saltenv 'base', ** done ** 'haproxy/files/haproxy-status.sh'
2018-03-14 03:35:44,317 [salt.state       ][INFO    ][17403] File changed:
New file
2018-03-14 03:35:44,317 [salt.state       ][INFO    ][17403] Completed state [/usr/bin/haproxy-status.sh] at time 03:35:44.317892 duration_in_ms=37.406
2018-03-14 03:35:44,318 [salt.state       ][INFO    ][17403] Running state [net.ipv4.ip_nonlocal_bind] at time 03:35:44.318297
2018-03-14 03:35:44,318 [salt.state       ][INFO    ][17403] Executing state sysctl.present for net.ipv4.ip_nonlocal_bind
2018-03-14 03:35:44,318 [salt.loaded.int.module.cmdmod][INFO    ][17403] Executing command 'sysctl -a' in directory '/root'
2018-03-14 03:35:44,374 [salt.loaded.int.module.cmdmod][INFO    ][17403] Executing command 'sysctl -w net.ipv4.ip_nonlocal_bind="1"' in directory '/root'
2018-03-14 03:35:44,394 [salt.state       ][INFO    ][17403] {'net.ipv4.ip_nonlocal_bind': 1}
2018-03-14 03:35:44,394 [salt.state       ][INFO    ][17403] Completed state [net.ipv4.ip_nonlocal_bind] at time 03:35:44.394787 duration_in_ms=76.49
2018-03-14 03:35:44,396 [salt.state       ][INFO    ][17403] Running state [haproxy] at time 03:35:44.396166
2018-03-14 03:35:44,396 [salt.state       ][INFO    ][17403] Executing state service.running for haproxy
2018-03-14 03:35:44,397 [salt.loaded.int.module.cmdmod][INFO    ][17403] Executing command ['systemctl', 'status', 'haproxy.service', '-n', '0'] in directory '/root'
2018-03-14 03:35:44,413 [salt.loaded.int.module.cmdmod][INFO    ][17403] Executing command ['systemctl', 'is-active', 'haproxy.service'] in directory '/root'
2018-03-14 03:35:44,428 [salt.loaded.int.module.cmdmod][INFO    ][17403] Executing command ['systemctl', 'is-enabled', 'haproxy.service'] in directory '/root'
2018-03-14 03:35:44,444 [salt.state       ][INFO    ][17403] The service haproxy is already running
2018-03-14 03:35:44,445 [salt.state       ][INFO    ][17403] Completed state [haproxy] at time 03:35:44.445091 duration_in_ms=48.924
2018-03-14 03:35:44,445 [salt.state       ][INFO    ][17403] Running state [haproxy] at time 03:35:44.445350
2018-03-14 03:35:44,445 [salt.state       ][INFO    ][17403] Executing state service.mod_watch for haproxy
2018-03-14 03:35:44,446 [salt.loaded.int.module.cmdmod][INFO    ][17403] Executing command ['systemctl', 'is-active', 'haproxy.service'] in directory '/root'
2018-03-14 03:35:44,460 [salt.loaded.int.module.cmdmod][INFO    ][17403] Executing command ['systemctl', 'is-enabled', 'haproxy.service'] in directory '/root'
2018-03-14 03:35:44,475 [salt.loaded.int.module.cmdmod][INFO    ][17403] Executing command ['systemd-run', '--scope', 'systemctl', 'restart', 'haproxy.service'] in directory '/root'
2018-03-14 03:35:44,560 [salt.state       ][INFO    ][17403] {'haproxy': True}
2018-03-14 03:35:44,560 [salt.state       ][INFO    ][17403] Completed state [haproxy] at time 03:35:44.560445 duration_in_ms=115.09
2018-03-14 03:35:44,561 [salt.minion      ][INFO    ][17403] Returning information for job: 20180314033531310625
2018-03-14 03:35:53,673 [salt.minion      ][INFO    ][1939] User sudo_ubuntu Executing command service.status with jid 20180314033553670765
2018-03-14 03:35:53,708 [salt.minion      ][INFO    ][18279] Starting a new job with PID 18279
2018-03-14 03:35:53,935 [salt.loader.192.168.11.2.int.module.cmdmod][INFO    ][18279] Executing command ['systemctl', 'status', 'haproxy.service', '-n', '0'] in directory '/root'
2018-03-14 03:35:53,960 [salt.loader.192.168.11.2.int.module.cmdmod][INFO    ][18279] Executing command ['systemctl', 'is-active', 'haproxy.service'] in directory '/root'
2018-03-14 03:35:53,982 [salt.minion      ][INFO    ][18279] Returning information for job: 20180314033553670765
2018-03-14 03:35:54,915 [salt.minion      ][INFO    ][1939] User sudo_ubuntu Executing command service.restart with jid 20180314033554911609
2018-03-14 03:35:54,947 [salt.minion      ][INFO    ][18286] Starting a new job with PID 18286
2018-03-14 03:35:55,144 [salt.loader.192.168.11.2.int.module.cmdmod][INFO    ][18286] Executing command ['systemctl', 'status', 'rsyslog.service', '-n', '0'] in directory '/root'
2018-03-14 03:35:55,164 [salt.loader.192.168.11.2.int.module.cmdmod][INFO    ][18286] Executing command ['systemctl', 'is-enabled', 'rsyslog.service'] in directory '/root'
2018-03-14 03:35:55,209 [salt.loader.192.168.11.2.int.module.cmdmod][INFO    ][18286] Executing command ['systemd-run', '--scope', 'systemctl', 'restart', 'rsyslog.service'] in directory '/root'
2018-03-14 03:35:55,256 [salt.minion      ][INFO    ][18286] Returning information for job: 20180314033554911609
2018-03-14 03:48:32,123 [salt.utils.schedule][INFO    ][1939] Running scheduled job: __mine_interval
2018-03-14 04:28:59,542 [salt.minion      ][INFO    ][1939] User sudo_ubuntu Executing command cp.push_dir with jid 20180314042859533262
2018-03-14 04:28:59,625 [salt.minion      ][INFO    ][18438] Starting a new job with PID 18438
