2017-11-21 23:39:31,531 [salt.cli.daemons ][WARNING ][2447] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-11-21 23:56:31,937 [salt.state       ][ERROR   ][3763] No contents found in top file
2017-11-21 23:56:46,761 [salt.transport.ipc][ERROR   ][2447] Exception occurred while handling stream: [Errno 0] Success
2017-11-21 23:58:15,195 [salt.utils.parsers][WARNING ][2447] Minion received a SIGTERM. Exiting.
2017-11-22 00:00:27,567 [salt.cli.daemons ][WARNING ][3155] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-11-22 00:03:31,022 [py.warnings      ][WARNING ][15122] /usr/lib/python2.7/dist-packages/salt/utils/templates.py:73: DeprecationWarning: Starting in 2015.5, cmd.run uses python_shell=False by default, which doesn't support shellisms (pipes, env variables, etc). cmd.run is currently aliased to cmd.shell to prevent breakage. Please switch to cmd.shell or set python_shell=True to avoid breakage in the future, when this aliasing is removed.

2017-11-22 00:14:50,228 [salt.loaded.int.module.cmdmod][ERROR   ][15122] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-11-22 00:14:50,229 [salt.loaded.int.module.cmdmod][ERROR   ][15122] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-11-22 00:14:56,475 [salt.loaded.int.module.cmdmod][ERROR   ][15122] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-11-22 00:14:56,475 [salt.loaded.int.module.cmdmod][ERROR   ][15122] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-11-22 00:15:04,384 [salt.loaded.int.module.cmdmod][ERROR   ][15122] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-11-22 00:15:04,384 [salt.loaded.int.module.cmdmod][ERROR   ][15122] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-11-22 00:15:13,622 [salt.loaded.int.module.cmdmod][ERROR   ][15122] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-11-22 00:15:13,622 [salt.loaded.int.module.cmdmod][ERROR   ][15122] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-11-22 00:15:21,087 [salt.loaded.int.module.cmdmod][ERROR   ][15122] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-11-22 00:15:21,088 [salt.loaded.int.module.cmdmod][ERROR   ][15122] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-11-22 00:15:27,239 [salt.loaded.int.module.cmdmod][ERROR   ][15122] Command 'while true; do salt-call saltutil.running|grep fun: && continue; salt-call --local service.restart salt-minion; break; done' failed with return code: None
2017-11-22 00:15:29,350 [salt.loaded.int.module.cmdmod][INFO    ][23045] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2017-11-22 00:15:29,356 [salt.loaded.int.module.cmdmod][INFO    ][23045] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2017-11-22 00:15:29,364 [salt.loaded.int.module.cmdmod][INFO    ][23045] Executing command ['systemd-run', '--scope', 'systemctl', 'restart', 'salt-minion.service'] in directory '/root'
2017-11-22 00:15:29,372 [salt.utils.parsers][WARNING ][3155] Minion received a SIGTERM. Exiting.
2017-11-22 00:15:29,626 [salt.cli.daemons ][INFO    ][23142] Setting up the Salt Minion "kvm03.baremetal-mcp-ocata-ovs-ha.local"
2017-11-22 00:15:30,140 [salt.minion      ][INFO    ][23142] Creating minion process manager
2017-11-22 00:15:30,140 [salt.cli.daemons ][WARNING ][23142] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-11-22 00:15:30,140 [salt.cli.daemons ][INFO    ][23142] The Salt Minion is starting up
2017-11-22 00:15:30,140 [salt.minion      ][INFO    ][23142] Minion is starting as user 'root'
2017-11-22 00:15:30,141 [salt.utils.event ][INFO    ][23142] Starting pull socket on /var/run/salt/minion/minion_event_98ff1e569f_pull.ipc
2017-11-22 00:15:31,082 [salt.loaded.int.module.cmdmod][INFO    ][23142] Executing command ['date', '+%z'] in directory '/root'
2017-11-22 00:15:31,092 [salt.utils.schedule][INFO    ][23142] Updating job settings for scheduled job: __mine_interval
2017-11-22 00:15:31,094 [salt.minion      ][INFO    ][23142] Added mine.update to scheduler
2017-11-22 00:15:31,360 [salt.minion      ][INFO    ][23142] Minion is ready to receive requests!
2017-11-22 00:15:32,361 [salt.utils.schedule][INFO    ][23142] Running scheduled job: __mine_interval
2017-11-22 00:15:39,335 [salt.minion      ][INFO    ][23142] User sudo_ubuntu Executing command saltutil.find_job with jid 20171122001539330856
2017-11-22 00:15:39,349 [salt.minion      ][INFO    ][23282] Starting a new job with PID 23282
2017-11-22 00:15:39,357 [salt.minion      ][INFO    ][23282] Returning information for job: 20171122001539330856
2017-11-22 00:15:50,400 [salt.minion      ][INFO    ][23142] User sudo_ubuntu Executing command state.sls with jid 20171122001550394936
2017-11-22 00:15:50,414 [salt.minion      ][INFO    ][23293] Starting a new job with PID 23293
2017-11-22 00:15:51,969 [salt.state       ][INFO    ][23293] Loading fresh modules for state activity
2017-11-22 00:15:52,021 [salt.fileclient  ][INFO    ][23293] Fetching file from saltenv 'base', ** done ** 'salt/control/init.sls'
2017-11-22 00:15:52,041 [salt.fileclient  ][INFO    ][23293] Fetching file from saltenv 'base', ** done ** 'salt/control/virt.sls'
2017-11-22 00:15:52,080 [salt.fileclient  ][INFO    ][23293] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-11-22 00:15:52,150 [salt.fileclient  ][INFO    ][23293] Fetching file from saltenv 'base', ** done ** 'salt/minion/init.sls'
2017-11-22 00:15:52,165 [salt.fileclient  ][INFO    ][23293] Fetching file from saltenv 'base', ** done ** 'salt/minion/service.sls'
2017-11-22 00:15:52,200 [salt.fileclient  ][INFO    ][23293] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-11-22 00:15:52,295 [salt.fileclient  ][INFO    ][23293] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-11-22 00:15:52,313 [salt.fileclient  ][INFO    ][23293] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-11-22 00:15:52,367 [salt.fileclient  ][INFO    ][23293] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-11-22 00:15:52,385 [salt.fileclient  ][INFO    ][23293] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-11-22 00:15:52,502 [salt.fileclient  ][INFO    ][23293] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-11-22 00:15:52,563 [salt.fileclient  ][INFO    ][23293] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-11-22 00:15:52,570 [salt.loaded.int.module.cmdmod][INFO    ][23293] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-11-22 00:15:52,593 [salt.fileclient  ][INFO    ][23293] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-11-22 00:15:52,608 [py.warnings      ][WARNING ][23293] /usr/lib/python2.7/dist-packages/salt/utils/templates.py:73: DeprecationWarning: Starting in 2015.5, cmd.run uses python_shell=False by default, which doesn't support shellisms (pipes, env variables, etc). cmd.run is currently aliased to cmd.shell to prevent breakage. Please switch to cmd.shell or set python_shell=True to avoid breakage in the future, when this aliasing is removed.

2017-11-22 00:15:52,608 [salt.loaded.int.module.cmdmod][INFO    ][23293] Executing command 'salt-minion --version' in directory '/root'
2017-11-22 00:15:52,867 [salt.fileclient  ][INFO    ][23293] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-11-22 00:15:52,884 [salt.fileclient  ][INFO    ][23293] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-11-22 00:15:52,897 [salt.fileclient  ][INFO    ][23293] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-11-22 00:15:52,909 [salt.fileclient  ][INFO    ][23293] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-11-22 00:15:52,965 [salt.fileclient  ][INFO    ][23293] Fetching file from saltenv 'base', ** done ** 'reclass/meta/meta.yml'
2017-11-22 00:15:52,979 [salt.fileclient  ][INFO    ][23293] Fetching file from saltenv 'base', ** done ** 'reclass/map.jinja'
2017-11-22 00:15:53,025 [salt.fileclient  ][INFO    ][23293] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-11-22 00:15:53,093 [salt.fileclient  ][INFO    ][23293] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-11-22 00:15:53,165 [salt.fileclient  ][INFO    ][23293] Fetching file from saltenv 'base', ** done ** 'salt/minion/grains.sls'
2017-11-22 00:15:53,215 [salt.fileclient  ][INFO    ][23293] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-11-22 00:15:53,280 [salt.fileclient  ][INFO    ][23293] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-11-22 00:15:53,298 [salt.fileclient  ][INFO    ][23293] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-11-22 00:15:53,344 [salt.fileclient  ][INFO    ][23293] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-11-22 00:15:53,362 [salt.fileclient  ][INFO    ][23293] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-11-22 00:15:53,374 [salt.fileclient  ][INFO    ][23293] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-11-22 00:15:53,389 [salt.fileclient  ][INFO    ][23293] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-11-22 00:15:53,395 [salt.loaded.int.module.cmdmod][INFO    ][23293] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-11-22 00:15:53,480 [salt.fileclient  ][INFO    ][23293] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-11-22 00:15:53,495 [salt.loaded.int.module.cmdmod][INFO    ][23293] Executing command 'salt-minion --version' in directory '/root'
2017-11-22 00:15:53,747 [salt.fileclient  ][INFO    ][23293] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-11-22 00:15:53,812 [salt.fileclient  ][INFO    ][23293] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-11-22 00:15:53,824 [salt.fileclient  ][INFO    ][23293] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-11-22 00:15:53,836 [salt.fileclient  ][INFO    ][23293] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-11-22 00:15:53,872 [salt.fileclient  ][INFO    ][23293] Fetching file from saltenv 'base', ** done ** 'reclass/meta/meta.yml'
2017-11-22 00:15:53,887 [salt.fileclient  ][INFO    ][23293] Fetching file from saltenv 'base', ** done ** 'reclass/map.jinja'
2017-11-22 00:15:53,913 [salt.fileclient  ][INFO    ][23293] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-11-22 00:15:53,950 [salt.fileclient  ][INFO    ][23293] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-11-22 00:15:54,021 [salt.fileclient  ][INFO    ][23293] Fetching file from saltenv 'base', ** done ** 'salt/minion/cert.sls'
2017-11-22 00:15:54,075 [salt.fileclient  ][INFO    ][23293] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-11-22 00:15:54,376 [salt.state       ][INFO    ][23293] Running state [salt-minion] at time 00:15:54.375636
2017-11-22 00:15:54,376 [salt.state       ][INFO    ][23293] Executing state pkg.installed for salt-minion
2017-11-22 00:15:54,377 [salt.loaded.int.module.cmdmod][INFO    ][23293] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-22 00:15:54,643 [salt.state       ][INFO    ][23293] Package salt-minion is already installed
2017-11-22 00:15:54,643 [salt.state       ][INFO    ][23293] Completed state [salt-minion] at time 00:15:54.643129 duration_in_ms=267.492
2017-11-22 00:15:54,643 [salt.state       ][INFO    ][23293] Running state [salt_minion_dependency_packages] at time 00:15:54.643357
2017-11-22 00:15:54,644 [salt.state       ][INFO    ][23293] Executing state pkg.installed for salt_minion_dependency_packages
2017-11-22 00:15:54,646 [salt.state       ][INFO    ][23293] All specified packages are already installed
2017-11-22 00:15:54,646 [salt.state       ][INFO    ][23293] Completed state [salt_minion_dependency_packages] at time 00:15:54.646355 duration_in_ms=2.997
2017-11-22 00:15:54,648 [salt.state       ][INFO    ][23293] Running state [/etc/salt/minion.d/minion.conf] at time 00:15:54.647950
2017-11-22 00:15:54,648 [salt.state       ][INFO    ][23293] Executing state file.managed for /etc/salt/minion.d/minion.conf
2017-11-22 00:15:54,664 [salt.fileclient  ][INFO    ][23293] Fetching file from saltenv 'base', ** done ** 'salt/files/minion.conf'
2017-11-22 00:15:54,705 [salt.fileclient  ][INFO    ][23293] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-11-22 00:15:54,745 [salt.fileclient  ][INFO    ][23293] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-11-22 00:15:54,779 [salt.state       ][INFO    ][23293] File /etc/salt/minion.d/minion.conf is in the correct state
2017-11-22 00:15:54,779 [salt.state       ][INFO    ][23293] Completed state [/etc/salt/minion.d/minion.conf] at time 00:15:54.779279 duration_in_ms=131.328
2017-11-22 00:15:54,780 [salt.state       ][INFO    ][23293] Running state [/etc/salt/minion.d/_virt.conf] at time 00:15:54.779561
2017-11-22 00:15:54,780 [salt.state       ][INFO    ][23293] Executing state file.managed for /etc/salt/minion.d/_virt.conf
2017-11-22 00:15:54,890 [salt.state       ][INFO    ][23293] File /etc/salt/minion.d/_virt.conf is in the correct state
2017-11-22 00:15:54,891 [salt.state       ][INFO    ][23293] Completed state [/etc/salt/minion.d/_virt.conf] at time 00:15:54.890531 duration_in_ms=110.97
2017-11-22 00:15:54,892 [salt.state       ][INFO    ][23293] Running state [salt-minion] at time 00:15:54.891999
2017-11-22 00:15:54,892 [salt.state       ][INFO    ][23293] Executing state service.running for salt-minion
2017-11-22 00:15:54,893 [salt.loaded.int.module.cmdmod][INFO    ][23293] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2017-11-22 00:15:54,906 [salt.loaded.int.module.cmdmod][INFO    ][23293] Executing command ['systemctl', 'is-active', 'salt-minion.service'] in directory '/root'
2017-11-22 00:15:54,912 [salt.loaded.int.module.cmdmod][INFO    ][23293] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2017-11-22 00:15:54,918 [salt.state       ][INFO    ][23293] The service salt-minion is already running
2017-11-22 00:15:54,918 [salt.state       ][INFO    ][23293] Completed state [salt-minion] at time 00:15:54.917831 duration_in_ms=25.832
2017-11-22 00:15:54,919 [salt.state       ][INFO    ][23293] Running state [/etc/salt/grains.d] at time 00:15:54.919106
2017-11-22 00:15:54,919 [salt.state       ][INFO    ][23293] Executing state file.directory for /etc/salt/grains.d
2017-11-22 00:15:54,920 [salt.state       ][INFO    ][23293] Directory /etc/salt/grains.d is in the correct state
2017-11-22 00:15:54,920 [salt.state       ][INFO    ][23293] Completed state [/etc/salt/grains.d] at time 00:15:54.919986 duration_in_ms=0.881
2017-11-22 00:15:54,920 [salt.state       ][INFO    ][23293] Running state [/etc/salt/grains] at time 00:15:54.920422
2017-11-22 00:15:54,921 [salt.state       ][INFO    ][23293] Executing state file.managed for /etc/salt/grains
2017-11-22 00:15:54,921 [salt.state       ][INFO    ][23293] File /etc/salt/grains exists with proper permissions. No changes made.
2017-11-22 00:15:54,921 [salt.state       ][INFO    ][23293] Completed state [/etc/salt/grains] at time 00:15:54.921059 duration_in_ms=0.637
2017-11-22 00:15:54,921 [salt.state       ][INFO    ][23293] Running state [/etc/salt/grains.d/placeholder] at time 00:15:54.921325
2017-11-22 00:15:54,921 [salt.state       ][INFO    ][23293] Executing state file.managed for /etc/salt/grains.d/placeholder
2017-11-22 00:15:54,922 [salt.state       ][INFO    ][23293] File /etc/salt/grains.d/placeholder exists with proper permissions. No changes made.
2017-11-22 00:15:54,922 [salt.state       ][INFO    ][23293] Completed state [/etc/salt/grains.d/placeholder] at time 00:15:54.921935 duration_in_ms=0.61
2017-11-22 00:15:54,922 [salt.state       ][INFO    ][23293] Running state [/etc/salt/grains.d/sphinx] at time 00:15:54.922202
2017-11-22 00:15:54,922 [salt.state       ][INFO    ][23293] Executing state file.managed for /etc/salt/grains.d/sphinx
2017-11-22 00:15:55,088 [salt.state       ][INFO    ][23293] File changed:
--- 
+++ 
@@ -49,7 +49,6 @@
               - 10.167.4.143
               - 127.0.0.1
               - 192.168.11.252
-              - 192.168.122.1
         system:
           name: System
           param:

2017-11-22 00:15:55,088 [salt.state       ][INFO    ][23293] Completed state [/etc/salt/grains.d/sphinx] at time 00:15:55.088412 duration_in_ms=166.209
2017-11-22 00:15:55,089 [salt.state       ][INFO    ][23293] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 00:15:55.089172
2017-11-22 00:15:55,089 [salt.state       ][INFO    ][23293] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-11-22 00:15:55,090 [salt.state       ][INFO    ][23293] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-11-22 00:15:55,090 [salt.state       ][INFO    ][23293] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 00:15:55.089849 duration_in_ms=0.677
2017-11-22 00:15:55,090 [salt.state       ][INFO    ][23293] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 00:15:55.090031
2017-11-22 00:15:55,090 [salt.state       ][INFO    ][23293] Executing state cmd.mod_watch for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-11-22 00:15:55,091 [salt.loaded.int.module.cmdmod][INFO    ][23293] Executing command 'python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"' in directory '/root'
2017-11-22 00:15:55,172 [salt.state       ][INFO    ][23293] {'pid': 23341, 'retcode': 0, 'stderr': '', 'stdout': ''}
2017-11-22 00:15:55,172 [salt.state       ][INFO    ][23293] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 00:15:55.172349 duration_in_ms=82.317
2017-11-22 00:15:55,173 [salt.state       ][INFO    ][23293] Running state [/etc/salt/grains.d/dns_records] at time 00:15:55.172802
2017-11-22 00:15:55,173 [salt.state       ][INFO    ][23293] Executing state file.managed for /etc/salt/grains.d/dns_records
2017-11-22 00:15:55,279 [salt.state       ][INFO    ][23293] File /etc/salt/grains.d/dns_records is in the correct state
2017-11-22 00:15:55,280 [salt.state       ][INFO    ][23293] Completed state [/etc/salt/grains.d/dns_records] at time 00:15:55.279500 duration_in_ms=106.697
2017-11-22 00:15:55,280 [salt.state       ][INFO    ][23293] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 00:15:55.280310
2017-11-22 00:15:55,281 [salt.state       ][INFO    ][23293] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"
2017-11-22 00:15:55,281 [salt.state       ][INFO    ][23293] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"
2017-11-22 00:15:55,281 [salt.state       ][INFO    ][23293] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 00:15:55.280938 duration_in_ms=0.629
2017-11-22 00:15:55,281 [salt.state       ][INFO    ][23293] Running state [/etc/salt/grains.d/salt] at time 00:15:55.281258
2017-11-22 00:15:55,281 [salt.state       ][INFO    ][23293] Executing state file.managed for /etc/salt/grains.d/salt
2017-11-22 00:15:55,416 [salt.state       ][INFO    ][23293] File /etc/salt/grains.d/salt is in the correct state
2017-11-22 00:15:55,416 [salt.state       ][INFO    ][23293] Completed state [/etc/salt/grains.d/salt] at time 00:15:55.416242 duration_in_ms=134.984
2017-11-22 00:15:55,417 [salt.state       ][INFO    ][23293] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 00:15:55.416882
2017-11-22 00:15:55,417 [salt.state       ][INFO    ][23293] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2017-11-22 00:15:55,417 [salt.state       ][INFO    ][23293] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2017-11-22 00:15:55,418 [salt.state       ][INFO    ][23293] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 00:15:55.417561 duration_in_ms=0.679
2017-11-22 00:15:55,419 [salt.state       ][INFO    ][23293] Running state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 00:15:55.418852
2017-11-22 00:15:55,419 [salt.state       ][INFO    ][23293] Executing state cmd.wait for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-11-22 00:15:55,419 [salt.state       ][INFO    ][23293] No changes made for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-11-22 00:15:55,420 [salt.state       ][INFO    ][23293] Completed state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 00:15:55.419534 duration_in_ms=0.682
2017-11-22 00:15:55,420 [salt.state       ][INFO    ][23293] Running state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 00:15:55.419713
2017-11-22 00:15:55,420 [salt.state       ][INFO    ][23293] Executing state cmd.mod_watch for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-11-22 00:15:55,421 [salt.loaded.int.module.cmdmod][INFO    ][23293] Executing command 'cat /etc/salt/grains.d/* > /etc/salt/grains' in directory '/root'
2017-11-22 00:15:55,430 [salt.state       ][INFO    ][23293] {'pid': 23343, 'retcode': 0, 'stderr': '', 'stdout': ''}
2017-11-22 00:15:55,430 [salt.state       ][INFO    ][23293] Completed state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 00:15:55.430204 duration_in_ms=10.491
2017-11-22 00:15:55,431 [salt.state       ][INFO    ][23293] Running state [mine.update] at time 00:15:55.430864
2017-11-22 00:15:55,431 [salt.state       ][INFO    ][23293] Executing state module.wait for mine.update
2017-11-22 00:15:55,431 [salt.state       ][INFO    ][23293] No changes made for mine.update
2017-11-22 00:15:55,432 [salt.state       ][INFO    ][23293] Completed state [mine.update] at time 00:15:55.431547 duration_in_ms=0.683
2017-11-22 00:15:55,432 [salt.state       ][INFO    ][23293] Running state [mine.update] at time 00:15:55.431729
2017-11-22 00:15:55,432 [salt.state       ][INFO    ][23293] Executing state module.mod_watch for mine.update
2017-11-22 00:15:55,951 [salt.state       ][INFO    ][23293] {'ret': True}
2017-11-22 00:15:55,951 [salt.state       ][INFO    ][23293] Completed state [mine.update] at time 00:15:55.950869 duration_in_ms=519.138
2017-11-22 00:15:55,951 [salt.state       ][INFO    ][23293] Running state [ca-certificates] at time 00:15:55.951103
2017-11-22 00:15:55,951 [salt.state       ][INFO    ][23293] Executing state pkg.installed for ca-certificates
2017-11-22 00:15:55,954 [salt.state       ][INFO    ][23293] Package ca-certificates is already installed
2017-11-22 00:15:55,955 [salt.state       ][INFO    ][23293] Completed state [ca-certificates] at time 00:15:55.954510 duration_in_ms=3.407
2017-11-22 00:15:55,955 [salt.state       ][INFO    ][23293] Running state [update-ca-certificates] at time 00:15:55.955051
2017-11-22 00:15:55,955 [salt.state       ][INFO    ][23293] Executing state cmd.wait for update-ca-certificates
2017-11-22 00:15:55,955 [salt.state       ][INFO    ][23293] No changes made for update-ca-certificates
2017-11-22 00:15:55,956 [salt.state       ][INFO    ][23293] Completed state [update-ca-certificates] at time 00:15:55.955564 duration_in_ms=0.513
2017-11-22 00:15:55,956 [salt.state       ][INFO    ][23293] Running state [libvirt-dev] at time 00:15:55.955721
2017-11-22 00:15:55,956 [salt.state       ][INFO    ][23293] Executing state pkg.installed for libvirt-dev
2017-11-22 00:15:55,958 [salt.state       ][INFO    ][23293] Package libvirt-dev is already installed
2017-11-22 00:15:55,959 [salt.state       ][INFO    ][23293] Completed state [libvirt-dev] at time 00:15:55.958575 duration_in_ms=2.854
2017-11-22 00:15:55,959 [salt.state       ][INFO    ][23293] Running state [pkg-config] at time 00:15:55.958737
2017-11-22 00:15:55,959 [salt.state       ][INFO    ][23293] Executing state pkg.installed for pkg-config
2017-11-22 00:15:55,961 [salt.state       ][INFO    ][23293] Package pkg-config is already installed
2017-11-22 00:15:55,962 [salt.state       ][INFO    ][23293] Completed state [pkg-config] at time 00:15:55.961596 duration_in_ms=2.859
2017-11-22 00:15:55,962 [salt.state       ][INFO    ][23293] Running state [virtng.init] at time 00:15:55.961759
2017-11-22 00:15:55,962 [salt.state       ][INFO    ][23293] Executing state module.run for virtng.init
2017-11-22 00:15:56,004 [salt.loaded.int.module.cmdmod][INFO    ][23293] Executing command ['git', '--version'] in directory '/root'
2017-11-22 00:15:56,079 [salt.loaded.int.module.cmdmod][INFO    ][23293] Executing command 'virsh list --all --name| grep -E "^mdb03.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-11-22 00:15:56,177 [salt.state       ][INFO    ][23293] unless execution succeeded
2017-11-22 00:15:56,177 [salt.state       ][INFO    ][23293] Completed state [virtng.init] at time 00:15:56.177075 duration_in_ms=215.315
2017-11-22 00:15:56,177 [salt.state       ][INFO    ][23293] Running state [virt.set_autostart] at time 00:15:56.177312
2017-11-22 00:15:56,178 [salt.state       ][INFO    ][23293] Executing state module.run for virt.set_autostart
2017-11-22 00:15:56,180 [salt.loaded.int.module.cmdmod][INFO    ][23293] Executing command 'virsh list --autostart --name| grep -E "^mdb03.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-11-22 00:15:56,194 [salt.state       ][INFO    ][23293] unless execution succeeded
2017-11-22 00:15:56,194 [salt.state       ][INFO    ][23293] Completed state [virt.set_autostart] at time 00:15:56.194260 duration_in_ms=16.947
2017-11-22 00:15:56,195 [salt.state       ][INFO    ][23293] Running state [virtng.init] at time 00:15:56.194504
2017-11-22 00:15:56,195 [salt.state       ][INFO    ][23293] Executing state module.run for virtng.init
2017-11-22 00:15:56,198 [salt.loaded.int.module.cmdmod][INFO    ][23293] Executing command 'virsh list --all --name| grep -E "^dbs03.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-11-22 00:15:56,215 [salt.state       ][INFO    ][23293] unless execution succeeded
2017-11-22 00:15:56,215 [salt.state       ][INFO    ][23293] Completed state [virtng.init] at time 00:15:56.214969 duration_in_ms=20.464
2017-11-22 00:15:56,215 [salt.state       ][INFO    ][23293] Running state [virt.set_autostart] at time 00:15:56.215202
2017-11-22 00:15:56,215 [salt.state       ][INFO    ][23293] Executing state module.run for virt.set_autostart
2017-11-22 00:15:56,218 [salt.loaded.int.module.cmdmod][INFO    ][23293] Executing command 'virsh list --autostart --name| grep -E "^dbs03.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-11-22 00:15:56,233 [salt.state       ][INFO    ][23293] unless execution succeeded
2017-11-22 00:15:56,234 [salt.state       ][INFO    ][23293] Completed state [virt.set_autostart] at time 00:15:56.233637 duration_in_ms=18.435
2017-11-22 00:15:56,234 [salt.state       ][INFO    ][23293] Running state [virtng.init] at time 00:15:56.233859
2017-11-22 00:15:56,234 [salt.state       ][INFO    ][23293] Executing state module.run for virtng.init
2017-11-22 00:15:56,236 [salt.loaded.int.module.cmdmod][INFO    ][23293] Executing command 'virsh list --all --name| grep -E "^prx02.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-11-22 00:15:56,251 [salt.state       ][INFO    ][23293] unless execution succeeded
2017-11-22 00:15:56,251 [salt.state       ][INFO    ][23293] Completed state [virtng.init] at time 00:15:56.251317 duration_in_ms=17.456
2017-11-22 00:15:56,252 [salt.state       ][INFO    ][23293] Running state [virt.set_autostart] at time 00:15:56.251610
2017-11-22 00:15:56,252 [salt.state       ][INFO    ][23293] Executing state module.run for virt.set_autostart
2017-11-22 00:15:56,254 [salt.loaded.int.module.cmdmod][INFO    ][23293] Executing command 'virsh list --autostart --name| grep -E "^prx02.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-11-22 00:15:56,269 [salt.state       ][INFO    ][23293] unless execution succeeded
2017-11-22 00:15:56,269 [salt.state       ][INFO    ][23293] Completed state [virt.set_autostart] at time 00:15:56.269019 duration_in_ms=17.408
2017-11-22 00:15:56,269 [salt.state       ][INFO    ][23293] Running state [virtng.init] at time 00:15:56.269235
2017-11-22 00:15:56,269 [salt.state       ][INFO    ][23293] Executing state module.run for virtng.init
2017-11-22 00:15:56,271 [salt.loaded.int.module.cmdmod][INFO    ][23293] Executing command 'virsh list --all --name| grep -E "^msg03.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-11-22 00:15:56,285 [salt.state       ][INFO    ][23293] unless execution succeeded
2017-11-22 00:15:56,394 [salt.state       ][INFO    ][23293] Completed state [virtng.init] at time 00:15:56.393835 duration_in_ms=124.598
2017-11-22 00:15:56,394 [salt.state       ][INFO    ][23293] Running state [virt.set_autostart] at time 00:15:56.394294
2017-11-22 00:15:56,395 [salt.state       ][INFO    ][23293] Executing state module.run for virt.set_autostart
2017-11-22 00:15:56,403 [salt.loaded.int.module.cmdmod][INFO    ][23293] Executing command 'virsh list --autostart --name| grep -E "^msg03.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-11-22 00:15:56,420 [salt.state       ][INFO    ][23293] unless execution succeeded
2017-11-22 00:15:56,421 [salt.state       ][INFO    ][23293] Completed state [virt.set_autostart] at time 00:15:56.420617 duration_in_ms=26.321
2017-11-22 00:15:56,421 [salt.state       ][INFO    ][23293] Running state [virtng.init] at time 00:15:56.420843
2017-11-22 00:15:56,421 [salt.state       ][INFO    ][23293] Executing state module.run for virtng.init
2017-11-22 00:15:56,423 [salt.loaded.int.module.cmdmod][INFO    ][23293] Executing command 'virsh list --all --name| grep -E "^ctl03.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-11-22 00:15:56,436 [salt.state       ][INFO    ][23293] unless execution succeeded
2017-11-22 00:15:56,436 [salt.state       ][INFO    ][23293] Completed state [virtng.init] at time 00:15:56.435781 duration_in_ms=14.938
2017-11-22 00:15:56,436 [salt.state       ][INFO    ][23293] Running state [virt.set_autostart] at time 00:15:56.435988
2017-11-22 00:15:56,436 [salt.state       ][INFO    ][23293] Executing state module.run for virt.set_autostart
2017-11-22 00:15:56,438 [salt.loaded.int.module.cmdmod][INFO    ][23293] Executing command 'virsh list --autostart --name| grep -E "^ctl03.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-11-22 00:15:56,450 [salt.state       ][INFO    ][23293] unless execution succeeded
2017-11-22 00:15:56,450 [salt.state       ][INFO    ][23293] Completed state [virt.set_autostart] at time 00:15:56.450330 duration_in_ms=14.342
2017-11-22 00:15:56,452 [salt.minion      ][INFO    ][23293] Returning information for job: 20171122001550394936
2017-11-22 00:16:56,370 [salt.minion      ][INFO    ][23142] User sudo_ubuntu Executing command saltutil.sync_all with jid 20171122001656367856
2017-11-22 00:16:56,387 [salt.minion      ][INFO    ][23405] Starting a new job with PID 23405
2017-11-22 00:16:59,864 [salt.state       ][INFO    ][23405] Loading fresh modules for state activity
2017-11-22 00:16:59,887 [salt.state       ][ERROR   ][23405] No contents found in top file
2017-11-22 00:16:59,888 [salt.utils.extmods][INFO    ][23405] Creating module dir '/var/cache/salt/minion/extmods/beacons'
2017-11-22 00:16:59,890 [salt.utils.extmods][INFO    ][23405] Syncing beacons for environment 'base'
2017-11-22 00:16:59,891 [salt.utils.extmods][INFO    ][23405] Loading cache from salt://_beacons, for base)
2017-11-22 00:16:59,891 [salt.fileclient  ][INFO    ][23405] Caching directory '_beacons/' for environment 'base'
2017-11-22 00:16:59,913 [salt.utils.extmods][INFO    ][23405] Syncing modules for environment 'base'
2017-11-22 00:16:59,913 [salt.utils.extmods][INFO    ][23405] Loading cache from salt://_modules, for base)
2017-11-22 00:16:59,913 [salt.fileclient  ][INFO    ][23405] Caching directory '_modules/' for environment 'base'
2017-11-22 00:16:59,952 [salt.fileclient  ][INFO    ][23405] Fetching file from saltenv 'base', ** done ** '_modules/ceph_ng.py'
2017-11-22 00:17:00,020 [salt.fileclient  ][INFO    ][23405] Fetching file from saltenv 'base', ** done ** '_modules/cinderng.py'
2017-11-22 00:17:00,042 [salt.fileclient  ][INFO    ][23405] Fetching file from saltenv 'base', ** done ** '_modules/contrail.py'
2017-11-22 00:17:00,069 [salt.fileclient  ][INFO    ][23405] Fetching file from saltenv 'base', ** done ** '_modules/creds.py'
2017-11-22 00:17:00,262 [salt.fileclient  ][INFO    ][23405] Fetching file from saltenv 'base', ** done ** '_modules/devops_utils.py'
2017-11-22 00:17:00,279 [salt.fileclient  ][INFO    ][23405] Fetching file from saltenv 'base', ** done ** '_modules/encode_json.py'
2017-11-22 00:17:00,290 [salt.fileclient  ][INFO    ][23405] Fetching file from saltenv 'base', ** done ** '_modules/gerrit.py'
2017-11-22 00:17:00,325 [salt.fileclient  ][INFO    ][23405] Fetching file from saltenv 'base', ** done ** '_modules/glanceng.py'
2017-11-22 00:17:00,354 [salt.fileclient  ][INFO    ][23405] Fetching file from saltenv 'base', ** done ** '_modules/heat.py'
2017-11-22 00:17:00,365 [salt.fileclient  ][INFO    ][23405] Fetching file from saltenv 'base', ** done ** '_modules/heka_alarming.py'
2017-11-22 00:17:00,395 [salt.fileclient  ][INFO    ][23405] Fetching file from saltenv 'base', ** done ** '_modules/helm.py'
2017-11-22 00:17:00,437 [salt.fileclient  ][INFO    ][23405] Fetching file from saltenv 'base', ** done ** '_modules/jenkins_common.py'
2017-11-22 00:17:00,488 [salt.fileclient  ][INFO    ][23405] Fetching file from saltenv 'base', ** done ** '_modules/keystone_policy.py'
2017-11-22 00:17:00,518 [salt.fileclient  ][INFO    ][23405] Fetching file from saltenv 'base', ** done ** '_modules/linux_hosts.py'
2017-11-22 00:17:00,545 [salt.fileclient  ][INFO    ][23405] Fetching file from saltenv 'base', ** done ** '_modules/linux_netlink.py'
2017-11-22 00:17:00,579 [salt.fileclient  ][INFO    ][23405] Fetching file from saltenv 'base', ** done ** '_modules/maas.py'
2017-11-22 00:17:00,645 [salt.fileclient  ][INFO    ][23405] Fetching file from saltenv 'base', ** done ** '_modules/maas_client.py'
2017-11-22 00:17:00,662 [salt.fileclient  ][INFO    ][23405] Fetching file from saltenv 'base', ** done ** '_modules/modelutils.py'
2017-11-22 00:17:00,690 [salt.fileclient  ][INFO    ][23405] Fetching file from saltenv 'base', ** done ** '_modules/multipart.py'
2017-11-22 00:17:00,705 [salt.fileclient  ][INFO    ][23405] Fetching file from saltenv 'base', ** done ** '_modules/nagios_alarming.py'
2017-11-22 00:17:00,745 [salt.fileclient  ][INFO    ][23405] Fetching file from saltenv 'base', ** done ** '_modules/neutronng.py'
2017-11-22 00:17:00,761 [salt.fileclient  ][INFO    ][23405] Fetching file from saltenv 'base', ** done ** '_modules/novang.py'
2017-11-22 00:17:00,782 [salt.fileclient  ][INFO    ][23405] Fetching file from saltenv 'base', ** done ** '_modules/reclass.py'
2017-11-22 00:17:00,820 [salt.fileclient  ][INFO    ][23405] Fetching file from saltenv 'base', ** done ** '_modules/rsyslog_util.py'
2017-11-22 00:17:00,832 [salt.fileclient  ][INFO    ][23405] Fetching file from saltenv 'base', ** done ** '_modules/rundeck.py'
2017-11-22 00:17:00,848 [salt.fileclient  ][INFO    ][23405] Fetching file from saltenv 'base', ** done ** '_modules/saltkey.py'
2017-11-22 00:17:00,866 [salt.fileclient  ][INFO    ][23405] Fetching file from saltenv 'base', ** done ** '_modules/saltresource.py'
2017-11-22 00:17:00,879 [salt.fileclient  ][INFO    ][23405] Fetching file from saltenv 'base', ** done ** '_modules/seedng.py'
2017-11-22 00:17:00,895 [salt.fileclient  ][INFO    ][23405] Fetching file from saltenv 'base', ** done ** '_modules/testing/credentials.py'
2017-11-22 00:17:00,904 [salt.fileclient  ][INFO    ][23405] Fetching file from saltenv 'base', ** done ** '_modules/testing/django.py'
2017-11-22 00:17:00,944 [salt.fileclient  ][INFO    ][23405] Fetching file from saltenv 'base', ** done ** '_modules/testing/django_client_proxy.py'
2017-11-22 00:17:00,957 [salt.fileclient  ][INFO    ][23405] Fetching file from saltenv 'base', ** done ** '_modules/utils.py'
2017-11-22 00:17:00,969 [salt.fileclient  ][INFO    ][23405] Fetching file from saltenv 'base', ** done ** '_modules/virtng.py'
2017-11-22 00:17:00,971 [salt.utils.extmods][INFO    ][23405] Copying '/var/cache/salt/minion/files/base/_modules/__init__.py' to '/var/cache/salt/minion/extmods/modules/__init__.py'
2017-11-22 00:17:00,972 [salt.utils.extmods][INFO    ][23405] Copying '/var/cache/salt/minion/files/base/_modules/ceph_ng.py' to '/var/cache/salt/minion/extmods/modules/ceph_ng.py'
2017-11-22 00:17:00,972 [salt.utils.extmods][INFO    ][23405] Copying '/var/cache/salt/minion/files/base/_modules/cinderng.py' to '/var/cache/salt/minion/extmods/modules/cinderng.py'
2017-11-22 00:17:00,981 [salt.utils.extmods][INFO    ][23405] Copying '/var/cache/salt/minion/files/base/_modules/contrail.py' to '/var/cache/salt/minion/extmods/modules/contrail.py'
2017-11-22 00:17:00,986 [salt.utils.extmods][INFO    ][23405] Copying '/var/cache/salt/minion/files/base/_modules/creds.py' to '/var/cache/salt/minion/extmods/modules/creds.py'
2017-11-22 00:17:00,986 [salt.utils.extmods][INFO    ][23405] Copying '/var/cache/salt/minion/files/base/_modules/devops_utils.py' to '/var/cache/salt/minion/extmods/modules/devops_utils.py'
2017-11-22 00:17:00,987 [salt.utils.extmods][INFO    ][23405] Copying '/var/cache/salt/minion/files/base/_modules/encode_json.py' to '/var/cache/salt/minion/extmods/modules/encode_json.py'
2017-11-22 00:17:00,987 [salt.utils.extmods][INFO    ][23405] Copying '/var/cache/salt/minion/files/base/_modules/gerrit.py' to '/var/cache/salt/minion/extmods/modules/gerrit.py'
2017-11-22 00:17:00,987 [salt.utils.extmods][INFO    ][23405] Copying '/var/cache/salt/minion/files/base/_modules/glanceng.py' to '/var/cache/salt/minion/extmods/modules/glanceng.py'
2017-11-22 00:17:00,988 [salt.utils.extmods][INFO    ][23405] Copying '/var/cache/salt/minion/files/base/_modules/heat.py' to '/var/cache/salt/minion/extmods/modules/heat.py'
2017-11-22 00:17:00,988 [salt.utils.extmods][INFO    ][23405] Copying '/var/cache/salt/minion/files/base/_modules/heka_alarming.py' to '/var/cache/salt/minion/extmods/modules/heka_alarming.py'
2017-11-22 00:17:00,989 [salt.utils.extmods][INFO    ][23405] Copying '/var/cache/salt/minion/files/base/_modules/helm.py' to '/var/cache/salt/minion/extmods/modules/helm.py'
2017-11-22 00:17:00,991 [salt.utils.extmods][INFO    ][23405] Copying '/var/cache/salt/minion/files/base/_modules/jenkins_common.py' to '/var/cache/salt/minion/extmods/modules/jenkins_common.py'
2017-11-22 00:17:00,991 [salt.utils.extmods][INFO    ][23405] Copying '/var/cache/salt/minion/files/base/_modules/keystone_policy.py' to '/var/cache/salt/minion/extmods/modules/keystone_policy.py'
2017-11-22 00:17:00,992 [salt.utils.extmods][INFO    ][23405] Copying '/var/cache/salt/minion/files/base/_modules/linux_hosts.py' to '/var/cache/salt/minion/extmods/modules/linux_hosts.py'
2017-11-22 00:17:00,992 [salt.utils.extmods][INFO    ][23405] Copying '/var/cache/salt/minion/files/base/_modules/linux_netlink.py' to '/var/cache/salt/minion/extmods/modules/linux_netlink.py'
2017-11-22 00:17:00,992 [salt.utils.extmods][INFO    ][23405] Copying '/var/cache/salt/minion/files/base/_modules/maas.py' to '/var/cache/salt/minion/extmods/modules/maas.py'
2017-11-22 00:17:00,993 [salt.utils.extmods][INFO    ][23405] Copying '/var/cache/salt/minion/files/base/_modules/maas_client.py' to '/var/cache/salt/minion/extmods/modules/maas_client.py'
2017-11-22 00:17:00,994 [salt.utils.extmods][INFO    ][23405] Copying '/var/cache/salt/minion/files/base/_modules/modelutils.py' to '/var/cache/salt/minion/extmods/modules/modelutils.py'
2017-11-22 00:17:00,994 [salt.utils.extmods][INFO    ][23405] Copying '/var/cache/salt/minion/files/base/_modules/multipart.py' to '/var/cache/salt/minion/extmods/modules/multipart.py'
2017-11-22 00:17:00,994 [salt.utils.extmods][INFO    ][23405] Copying '/var/cache/salt/minion/files/base/_modules/nagios_alarming.py' to '/var/cache/salt/minion/extmods/modules/nagios_alarming.py'
2017-11-22 00:17:00,995 [salt.utils.extmods][INFO    ][23405] Copying '/var/cache/salt/minion/files/base/_modules/neutronng.py' to '/var/cache/salt/minion/extmods/modules/neutronng.py'
2017-11-22 00:17:00,995 [salt.utils.extmods][INFO    ][23405] Copying '/var/cache/salt/minion/files/base/_modules/novang.py' to '/var/cache/salt/minion/extmods/modules/novang.py'
2017-11-22 00:17:00,996 [salt.utils.extmods][INFO    ][23405] Copying '/var/cache/salt/minion/files/base/_modules/reclass.py' to '/var/cache/salt/minion/extmods/modules/reclass.py'
2017-11-22 00:17:00,996 [salt.utils.extmods][INFO    ][23405] Copying '/var/cache/salt/minion/files/base/_modules/rsyslog_util.py' to '/var/cache/salt/minion/extmods/modules/rsyslog_util.py'
2017-11-22 00:17:01,002 [salt.utils.extmods][INFO    ][23405] Copying '/var/cache/salt/minion/files/base/_modules/rundeck.py' to '/var/cache/salt/minion/extmods/modules/rundeck.py'
2017-11-22 00:17:01,003 [salt.utils.extmods][INFO    ][23405] Copying '/var/cache/salt/minion/files/base/_modules/saltkey.py' to '/var/cache/salt/minion/extmods/modules/saltkey.py'
2017-11-22 00:17:01,003 [salt.utils.extmods][INFO    ][23405] Copying '/var/cache/salt/minion/files/base/_modules/saltresource.py' to '/var/cache/salt/minion/extmods/modules/saltresource.py'
2017-11-22 00:17:01,004 [salt.utils.extmods][INFO    ][23405] Copying '/var/cache/salt/minion/files/base/_modules/seedng.py' to '/var/cache/salt/minion/extmods/modules/seedng.py'
2017-11-22 00:17:01,008 [salt.utils.extmods][INFO    ][23405] Copying '/var/cache/salt/minion/files/base/_modules/testing/__init__.py' to '/var/cache/salt/minion/extmods/modules/testing/__init__.py'
2017-11-22 00:17:01,009 [salt.utils.extmods][INFO    ][23405] Copying '/var/cache/salt/minion/files/base/_modules/testing/credentials.py' to '/var/cache/salt/minion/extmods/modules/testing/credentials.py'
2017-11-22 00:17:01,009 [salt.utils.extmods][INFO    ][23405] Copying '/var/cache/salt/minion/files/base/_modules/testing/django.py' to '/var/cache/salt/minion/extmods/modules/testing/django.py'
2017-11-22 00:17:01,009 [salt.utils.extmods][INFO    ][23405] Copying '/var/cache/salt/minion/files/base/_modules/testing/django_client_proxy.py' to '/var/cache/salt/minion/extmods/modules/testing/django_client_proxy.py'
2017-11-22 00:17:01,009 [salt.utils.extmods][INFO    ][23405] Copying '/var/cache/salt/minion/files/base/_modules/utils.py' to '/var/cache/salt/minion/extmods/modules/utils.py'
2017-11-22 00:17:01,010 [salt.utils.extmods][INFO    ][23405] Copying '/var/cache/salt/minion/files/base/_modules/virtng.py' to '/var/cache/salt/minion/extmods/modules/virtng.py'
2017-11-22 00:17:01,015 [salt.utils.extmods][INFO    ][23405] Syncing states for environment 'base'
2017-11-22 00:17:01,015 [salt.utils.extmods][INFO    ][23405] Loading cache from salt://_states, for base)
2017-11-22 00:17:01,015 [salt.fileclient  ][INFO    ][23405] Caching directory '_states/' for environment 'base'
2017-11-22 00:17:01,063 [salt.fileclient  ][INFO    ][23405] Fetching file from saltenv 'base', ** done ** '_states/cinderng.py'
2017-11-22 00:17:01,126 [salt.fileclient  ][INFO    ][23405] Fetching file from saltenv 'base', ** done ** '_states/contrail.py'
2017-11-22 00:17:01,149 [salt.fileclient  ][INFO    ][23405] Fetching file from saltenv 'base', ** done ** '_states/gerrit.py'
2017-11-22 00:17:01,173 [salt.fileclient  ][INFO    ][23405] Fetching file from saltenv 'base', ** done ** '_states/glanceng.py'
2017-11-22 00:17:01,215 [salt.fileclient  ][INFO    ][23405] Fetching file from saltenv 'base', ** done ** '_states/grafana3_dashboard.py'
2017-11-22 00:17:01,300 [salt.fileclient  ][INFO    ][23405] Fetching file from saltenv 'base', ** done ** '_states/grafana3_datasource.py'
2017-11-22 00:17:01,313 [salt.fileclient  ][INFO    ][23405] Fetching file from saltenv 'base', ** done ** '_states/heat.py'
2017-11-22 00:17:01,336 [salt.fileclient  ][INFO    ][23405] Fetching file from saltenv 'base', ** done ** '_states/helm_release.py'
2017-11-22 00:17:01,348 [salt.fileclient  ][INFO    ][23405] Fetching file from saltenv 'base', ** done ** '_states/jenkins_approval.py'
2017-11-22 00:17:01,371 [salt.fileclient  ][INFO    ][23405] Fetching file from saltenv 'base', ** done ** '_states/jenkins_artifactory.py'
2017-11-22 00:17:01,385 [salt.fileclient  ][INFO    ][23405] Fetching file from saltenv 'base', ** done ** '_states/jenkins_credential.py'
2017-11-22 00:17:01,417 [salt.fileclient  ][INFO    ][23405] Fetching file from saltenv 'base', ** done ** '_states/jenkins_globalenvprop.py'
2017-11-22 00:17:01,467 [salt.fileclient  ][INFO    ][23405] Fetching file from saltenv 'base', ** done ** '_states/jenkins_job.py'
2017-11-22 00:17:01,514 [salt.fileclient  ][INFO    ][23405] Fetching file from saltenv 'base', ** done ** '_states/jenkins_lib.py'
2017-11-22 00:17:01,614 [salt.fileclient  ][INFO    ][23405] Fetching file from saltenv 'base', ** done ** '_states/jenkins_node.py'
2017-11-22 00:17:01,623 [salt.fileclient  ][INFO    ][23405] Fetching file from saltenv 'base', ** done ** '_states/jenkins_plugin.py'
2017-11-22 00:17:01,642 [salt.fileclient  ][INFO    ][23405] Fetching file from saltenv 'base', ** done ** '_states/jenkins_security.py'
2017-11-22 00:17:01,655 [salt.fileclient  ][INFO    ][23405] Fetching file from saltenv 'base', ** done ** '_states/jenkins_slack.py'
2017-11-22 00:17:01,673 [salt.fileclient  ][INFO    ][23405] Fetching file from saltenv 'base', ** done ** '_states/jenkins_smtp.py'
2017-11-22 00:17:01,686 [salt.fileclient  ][INFO    ][23405] Fetching file from saltenv 'base', ** done ** '_states/jenkins_theme.py'
2017-11-22 00:17:01,723 [salt.fileclient  ][INFO    ][23405] Fetching file from saltenv 'base', ** done ** '_states/jenkins_user.py'
2017-11-22 00:17:01,773 [salt.fileclient  ][INFO    ][23405] Fetching file from saltenv 'base', ** done ** '_states/jenkins_view.py'
2017-11-22 00:17:01,788 [salt.fileclient  ][INFO    ][23405] Fetching file from saltenv 'base', ** done ** '_states/keystone_policy.py'
2017-11-22 00:17:01,837 [salt.fileclient  ][INFO    ][23405] Fetching file from saltenv 'base', ** done ** '_states/kibana_object.py'
2017-11-22 00:17:01,895 [salt.fileclient  ][INFO    ][23405] Fetching file from saltenv 'base', ** done ** '_states/neutronng.py'
2017-11-22 00:17:01,924 [salt.fileclient  ][INFO    ][23405] Fetching file from saltenv 'base', ** done ** '_states/novang.py'
2017-11-22 00:17:01,936 [salt.fileclient  ][INFO    ][23405] Fetching file from saltenv 'base', ** done ** '_states/reclass.py'
2017-11-22 00:17:01,961 [salt.fileclient  ][INFO    ][23405] Fetching file from saltenv 'base', ** done ** '_states/rundeck_project.py'
2017-11-22 00:17:01,984 [salt.fileclient  ][INFO    ][23405] Fetching file from saltenv 'base', ** done ** '_states/rundeck_scm.py'
2017-11-22 00:17:01,995 [salt.fileclient  ][INFO    ][23405] Fetching file from saltenv 'base', ** done ** '_states/rundeck_secret.py'
2017-11-22 00:17:01,1000 [salt.utils.extmods][INFO    ][23405] Copying '/var/cache/salt/minion/files/base/_states/cinderng.py' to '/var/cache/salt/minion/extmods/states/cinderng.py'
2017-11-22 00:17:01,1000 [salt.utils.extmods][INFO    ][23405] Copying '/var/cache/salt/minion/files/base/_states/contrail.py' to '/var/cache/salt/minion/extmods/states/contrail.py'
2017-11-22 00:17:02,000 [salt.utils.extmods][INFO    ][23405] Copying '/var/cache/salt/minion/files/base/_states/gerrit.py' to '/var/cache/salt/minion/extmods/states/gerrit.py'
2017-11-22 00:17:02,000 [salt.utils.extmods][INFO    ][23405] Copying '/var/cache/salt/minion/files/base/_states/glanceng.py' to '/var/cache/salt/minion/extmods/states/glanceng.py'
2017-11-22 00:17:02,001 [salt.utils.extmods][INFO    ][23405] Copying '/var/cache/salt/minion/files/base/_states/grafana3_dashboard.py' to '/var/cache/salt/minion/extmods/states/grafana3_dashboard.py'
2017-11-22 00:17:02,001 [salt.utils.extmods][INFO    ][23405] Copying '/var/cache/salt/minion/files/base/_states/grafana3_datasource.py' to '/var/cache/salt/minion/extmods/states/grafana3_datasource.py'
2017-11-22 00:17:02,001 [salt.utils.extmods][INFO    ][23405] Copying '/var/cache/salt/minion/files/base/_states/heat.py' to '/var/cache/salt/minion/extmods/states/heat.py'
2017-11-22 00:17:02,001 [salt.utils.extmods][INFO    ][23405] Copying '/var/cache/salt/minion/files/base/_states/helm_release.py' to '/var/cache/salt/minion/extmods/states/helm_release.py'
2017-11-22 00:17:02,001 [salt.utils.extmods][INFO    ][23405] Copying '/var/cache/salt/minion/files/base/_states/jenkins_approval.py' to '/var/cache/salt/minion/extmods/states/jenkins_approval.py'
2017-11-22 00:17:02,002 [salt.utils.extmods][INFO    ][23405] Copying '/var/cache/salt/minion/files/base/_states/jenkins_artifactory.py' to '/var/cache/salt/minion/extmods/states/jenkins_artifactory.py'
2017-11-22 00:17:02,002 [salt.utils.extmods][INFO    ][23405] Copying '/var/cache/salt/minion/files/base/_states/jenkins_credential.py' to '/var/cache/salt/minion/extmods/states/jenkins_credential.py'
2017-11-22 00:17:02,002 [salt.utils.extmods][INFO    ][23405] Copying '/var/cache/salt/minion/files/base/_states/jenkins_globalenvprop.py' to '/var/cache/salt/minion/extmods/states/jenkins_globalenvprop.py'
2017-11-22 00:17:02,002 [salt.utils.extmods][INFO    ][23405] Copying '/var/cache/salt/minion/files/base/_states/jenkins_job.py' to '/var/cache/salt/minion/extmods/states/jenkins_job.py'
2017-11-22 00:17:02,002 [salt.utils.extmods][INFO    ][23405] Copying '/var/cache/salt/minion/files/base/_states/jenkins_lib.py' to '/var/cache/salt/minion/extmods/states/jenkins_lib.py'
2017-11-22 00:17:02,003 [salt.utils.extmods][INFO    ][23405] Copying '/var/cache/salt/minion/files/base/_states/jenkins_node.py' to '/var/cache/salt/minion/extmods/states/jenkins_node.py'
2017-11-22 00:17:02,003 [salt.utils.extmods][INFO    ][23405] Copying '/var/cache/salt/minion/files/base/_states/jenkins_plugin.py' to '/var/cache/salt/minion/extmods/states/jenkins_plugin.py'
2017-11-22 00:17:02,003 [salt.utils.extmods][INFO    ][23405] Copying '/var/cache/salt/minion/files/base/_states/jenkins_security.py' to '/var/cache/salt/minion/extmods/states/jenkins_security.py'
2017-11-22 00:17:02,003 [salt.utils.extmods][INFO    ][23405] Copying '/var/cache/salt/minion/files/base/_states/jenkins_slack.py' to '/var/cache/salt/minion/extmods/states/jenkins_slack.py'
2017-11-22 00:17:02,003 [salt.utils.extmods][INFO    ][23405] Copying '/var/cache/salt/minion/files/base/_states/jenkins_smtp.py' to '/var/cache/salt/minion/extmods/states/jenkins_smtp.py'
2017-11-22 00:17:02,004 [salt.utils.extmods][INFO    ][23405] Copying '/var/cache/salt/minion/files/base/_states/jenkins_theme.py' to '/var/cache/salt/minion/extmods/states/jenkins_theme.py'
2017-11-22 00:17:02,004 [salt.utils.extmods][INFO    ][23405] Copying '/var/cache/salt/minion/files/base/_states/jenkins_user.py' to '/var/cache/salt/minion/extmods/states/jenkins_user.py'
2017-11-22 00:17:02,004 [salt.utils.extmods][INFO    ][23405] Copying '/var/cache/salt/minion/files/base/_states/jenkins_view.py' to '/var/cache/salt/minion/extmods/states/jenkins_view.py'
2017-11-22 00:17:02,004 [salt.utils.extmods][INFO    ][23405] Copying '/var/cache/salt/minion/files/base/_states/keystone_policy.py' to '/var/cache/salt/minion/extmods/states/keystone_policy.py'
2017-11-22 00:17:02,004 [salt.utils.extmods][INFO    ][23405] Copying '/var/cache/salt/minion/files/base/_states/kibana_object.py' to '/var/cache/salt/minion/extmods/states/kibana_object.py'
2017-11-22 00:17:02,004 [salt.utils.extmods][INFO    ][23405] Copying '/var/cache/salt/minion/files/base/_states/maas_cluster.py' to '/var/cache/salt/minion/extmods/states/maas_cluster.py'
2017-11-22 00:17:02,005 [salt.utils.extmods][INFO    ][23405] Copying '/var/cache/salt/minion/files/base/_states/neutronng.py' to '/var/cache/salt/minion/extmods/states/neutronng.py'
2017-11-22 00:17:02,005 [salt.utils.extmods][INFO    ][23405] Copying '/var/cache/salt/minion/files/base/_states/novang.py' to '/var/cache/salt/minion/extmods/states/novang.py'
2017-11-22 00:17:02,005 [salt.utils.extmods][INFO    ][23405] Copying '/var/cache/salt/minion/files/base/_states/reclass.py' to '/var/cache/salt/minion/extmods/states/reclass.py'
2017-11-22 00:17:02,005 [salt.utils.extmods][INFO    ][23405] Copying '/var/cache/salt/minion/files/base/_states/rundeck_project.py' to '/var/cache/salt/minion/extmods/states/rundeck_project.py'
2017-11-22 00:17:02,005 [salt.utils.extmods][INFO    ][23405] Copying '/var/cache/salt/minion/files/base/_states/rundeck_scm.py' to '/var/cache/salt/minion/extmods/states/rundeck_scm.py'
2017-11-22 00:17:02,006 [salt.utils.extmods][INFO    ][23405] Copying '/var/cache/salt/minion/files/base/_states/rundeck_secret.py' to '/var/cache/salt/minion/extmods/states/rundeck_secret.py'
2017-11-22 00:17:02,008 [salt.utils.extmods][INFO    ][23405] Creating module dir '/var/cache/salt/minion/extmods/sdb'
2017-11-22 00:17:02,011 [salt.utils.extmods][INFO    ][23405] Syncing sdb for environment 'base'
2017-11-22 00:17:02,011 [salt.utils.extmods][INFO    ][23405] Loading cache from salt://_sdb, for base)
2017-11-22 00:17:02,011 [salt.fileclient  ][INFO    ][23405] Caching directory '_sdb/' for environment 'base'
2017-11-22 00:17:02,038 [salt.utils.extmods][INFO    ][23405] Syncing grains for environment 'base'
2017-11-22 00:17:02,038 [salt.utils.extmods][INFO    ][23405] Loading cache from salt://_grains, for base)
2017-11-22 00:17:02,039 [salt.fileclient  ][INFO    ][23405] Caching directory '_grains/' for environment 'base'
2017-11-22 00:17:02,075 [salt.fileclient  ][INFO    ][23405] Fetching file from saltenv 'base', ** done ** '_grains/ceilometer_policy.py'
2017-11-22 00:17:02,089 [salt.fileclient  ][INFO    ][23405] Fetching file from saltenv 'base', ** done ** '_grains/ceph.py'
2017-11-22 00:17:02,097 [salt.fileclient  ][INFO    ][23405] Fetching file from saltenv 'base', ** done ** '_grains/cinder_policy.py'
2017-11-22 00:17:02,107 [salt.fileclient  ][INFO    ][23405] Fetching file from saltenv 'base', ** done ** '_grains/docker_swarm.py'
2017-11-22 00:17:02,569 [salt.fileclient  ][INFO    ][23405] Fetching file from saltenv 'base', ** done ** '_grains/glance_policy.py'
2017-11-22 00:17:02,576 [salt.fileclient  ][INFO    ][23405] Fetching file from saltenv 'base', ** done ** '_grains/heat_policy.py'
2017-11-22 00:17:02,586 [salt.fileclient  ][INFO    ][23405] Fetching file from saltenv 'base', ** done ** '_grains/jenkins_plugins.py'
2017-11-22 00:17:02,598 [salt.fileclient  ][INFO    ][23405] Fetching file from saltenv 'base', ** done ** '_grains/keystone_policy.py'
2017-11-22 00:17:02,604 [salt.fileclient  ][INFO    ][23405] Fetching file from saltenv 'base', ** done ** '_grains/kubernetes.py'
2017-11-22 00:17:02,612 [salt.fileclient  ][INFO    ][23405] Fetching file from saltenv 'base', ** done ** '_grains/neutron_policy.py'
2017-11-22 00:17:02,726 [salt.fileclient  ][INFO    ][23405] Fetching file from saltenv 'base', ** done ** '_grains/nova_policy.py'
2017-11-22 00:17:02,740 [salt.fileclient  ][INFO    ][23405] Fetching file from saltenv 'base', ** done ** '_grains/ssh_fingerprints.py'
2017-11-22 00:17:02,743 [salt.utils.extmods][INFO    ][23405] Copying '/var/cache/salt/minion/files/base/_grains/ceilometer_policy.py' to '/var/cache/salt/minion/extmods/grains/ceilometer_policy.py'
2017-11-22 00:17:02,743 [salt.utils.extmods][INFO    ][23405] Copying '/var/cache/salt/minion/files/base/_grains/ceph.py' to '/var/cache/salt/minion/extmods/grains/ceph.py'
2017-11-22 00:17:02,743 [salt.utils.extmods][INFO    ][23405] Copying '/var/cache/salt/minion/files/base/_grains/cinder_policy.py' to '/var/cache/salt/minion/extmods/grains/cinder_policy.py'
2017-11-22 00:17:02,744 [salt.utils.extmods][INFO    ][23405] Copying '/var/cache/salt/minion/files/base/_grains/docker_swarm.py' to '/var/cache/salt/minion/extmods/grains/docker_swarm.py'
2017-11-22 00:17:02,744 [salt.utils.extmods][INFO    ][23405] Copying '/var/cache/salt/minion/files/base/_grains/glance_policy.py' to '/var/cache/salt/minion/extmods/grains/glance_policy.py'
2017-11-22 00:17:02,746 [salt.utils.extmods][INFO    ][23405] Copying '/var/cache/salt/minion/files/base/_grains/heat_policy.py' to '/var/cache/salt/minion/extmods/grains/heat_policy.py'
2017-11-22 00:17:02,746 [salt.utils.extmods][INFO    ][23405] Copying '/var/cache/salt/minion/files/base/_grains/jenkins_plugins.py' to '/var/cache/salt/minion/extmods/grains/jenkins_plugins.py'
2017-11-22 00:17:02,746 [salt.utils.extmods][INFO    ][23405] Copying '/var/cache/salt/minion/files/base/_grains/keystone_policy.py' to '/var/cache/salt/minion/extmods/grains/keystone_policy.py'
2017-11-22 00:17:02,746 [salt.utils.extmods][INFO    ][23405] Copying '/var/cache/salt/minion/files/base/_grains/kubernetes.py' to '/var/cache/salt/minion/extmods/grains/kubernetes.py'
2017-11-22 00:17:02,747 [salt.utils.extmods][INFO    ][23405] Copying '/var/cache/salt/minion/files/base/_grains/neutron_policy.py' to '/var/cache/salt/minion/extmods/grains/neutron_policy.py'
2017-11-22 00:17:02,747 [salt.utils.extmods][INFO    ][23405] Copying '/var/cache/salt/minion/files/base/_grains/nova_policy.py' to '/var/cache/salt/minion/extmods/grains/nova_policy.py'
2017-11-22 00:17:02,747 [salt.utils.extmods][INFO    ][23405] Copying '/var/cache/salt/minion/files/base/_grains/ssh_fingerprints.py' to '/var/cache/salt/minion/extmods/grains/ssh_fingerprints.py'
2017-11-22 00:17:02,748 [salt.utils.extmods][INFO    ][23405] Creating module dir '/var/cache/salt/minion/extmods/renderers'
2017-11-22 00:17:02,751 [salt.utils.extmods][INFO    ][23405] Syncing renderers for environment 'base'
2017-11-22 00:17:02,751 [salt.utils.extmods][INFO    ][23405] Loading cache from salt://_renderers, for base)
2017-11-22 00:17:02,751 [salt.fileclient  ][INFO    ][23405] Caching directory '_renderers/' for environment 'base'
2017-11-22 00:17:02,769 [salt.utils.extmods][INFO    ][23405] Creating module dir '/var/cache/salt/minion/extmods/returners'
2017-11-22 00:17:02,771 [salt.utils.extmods][INFO    ][23405] Syncing returners for environment 'base'
2017-11-22 00:17:02,772 [salt.utils.extmods][INFO    ][23405] Loading cache from salt://_returners, for base)
2017-11-22 00:17:02,772 [salt.fileclient  ][INFO    ][23405] Caching directory '_returners/' for environment 'base'
2017-11-22 00:17:02,792 [salt.utils.extmods][INFO    ][23405] Creating module dir '/var/cache/salt/minion/extmods/output'
2017-11-22 00:17:02,795 [salt.utils.extmods][INFO    ][23405] Syncing output for environment 'base'
2017-11-22 00:17:02,795 [salt.utils.extmods][INFO    ][23405] Loading cache from salt://_output, for base)
2017-11-22 00:17:02,795 [salt.fileclient  ][INFO    ][23405] Caching directory '_output/' for environment 'base'
2017-11-22 00:17:02,816 [salt.utils.extmods][INFO    ][23405] Creating module dir '/var/cache/salt/minion/extmods/utils'
2017-11-22 00:17:02,818 [salt.utils.extmods][INFO    ][23405] Syncing utils for environment 'base'
2017-11-22 00:17:02,819 [salt.utils.extmods][INFO    ][23405] Loading cache from salt://_utils, for base)
2017-11-22 00:17:02,819 [salt.fileclient  ][INFO    ][23405] Caching directory '_utils/' for environment 'base'
2017-11-22 00:17:02,841 [salt.utils.extmods][INFO    ][23405] Creating module dir '/var/cache/salt/minion/extmods/log_handlers'
2017-11-22 00:17:02,843 [salt.utils.extmods][INFO    ][23405] Syncing log_handlers for environment 'base'
2017-11-22 00:17:02,843 [salt.utils.extmods][INFO    ][23405] Loading cache from salt://_log_handlers, for base)
2017-11-22 00:17:02,843 [salt.fileclient  ][INFO    ][23405] Caching directory '_log_handlers/' for environment 'base'
2017-11-22 00:17:02,860 [salt.utils.extmods][INFO    ][23405] Creating module dir '/var/cache/salt/minion/extmods/proxy'
2017-11-22 00:17:02,863 [salt.utils.extmods][INFO    ][23405] Syncing proxy for environment 'base'
2017-11-22 00:17:02,863 [salt.utils.extmods][INFO    ][23405] Loading cache from salt://_proxy, for base)
2017-11-22 00:17:02,863 [salt.fileclient  ][INFO    ][23405] Caching directory '_proxy/' for environment 'base'
2017-11-22 00:17:02,881 [salt.utils.extmods][INFO    ][23405] Creating module dir '/var/cache/salt/minion/extmods/engines'
2017-11-22 00:17:02,883 [salt.utils.extmods][INFO    ][23405] Syncing engines for environment 'base'
2017-11-22 00:17:02,883 [salt.utils.extmods][INFO    ][23405] Loading cache from salt://_engines, for base)
2017-11-22 00:17:02,883 [salt.fileclient  ][INFO    ][23405] Caching directory '_engines/' for environment 'base'
2017-11-22 00:17:02,904 [salt.minion      ][INFO    ][23405] Returning information for job: 20171122001656367856
2017-11-22 00:27:06,105 [salt.minion      ][INFO    ][23142] User sudo_ubuntu Executing command test.ping with jid 20171122002706090250
2017-11-22 00:27:06,123 [salt.minion      ][INFO    ][23605] Starting a new job with PID 23605
2017-11-22 00:27:06,158 [salt.minion      ][INFO    ][23605] Returning information for job: 20171122002706090250
2017-11-22 00:30:50,549 [salt.minion      ][INFO    ][23142] User sudo_ubuntu Executing command state.sls with jid 20171122003050538875
2017-11-22 00:30:50,563 [salt.minion      ][INFO    ][23664] Starting a new job with PID 23664
2017-11-22 00:30:51,036 [salt.state       ][INFO    ][23664] Loading fresh modules for state activity
2017-11-22 00:30:51,060 [salt.fileclient  ][INFO    ][23664] Fetching file from saltenv 'base', ** done ** 'keepalived/init.sls'
2017-11-22 00:30:51,077 [salt.fileclient  ][INFO    ][23664] Fetching file from saltenv 'base', ** done ** 'keepalived/cluster.sls'
2017-11-22 00:30:51,099 [salt.fileclient  ][INFO    ][23664] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-11-22 00:30:51,383 [salt.state       ][INFO    ][23664] Running state [lsof] at time 00:30:51.383079
2017-11-22 00:30:51,383 [salt.state       ][INFO    ][23664] Executing state pkg.installed for lsof
2017-11-22 00:30:51,384 [salt.loaded.int.module.cmdmod][INFO    ][23664] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-22 00:30:51,616 [salt.state       ][INFO    ][23664] Package lsof is already installed
2017-11-22 00:30:51,616 [salt.state       ][INFO    ][23664] Completed state [lsof] at time 00:30:51.615809 duration_in_ms=232.73
2017-11-22 00:30:51,616 [salt.state       ][INFO    ][23664] Running state [keepalived] at time 00:30:51.616016
2017-11-22 00:30:51,616 [salt.state       ][INFO    ][23664] Executing state pkg.installed for keepalived
2017-11-22 00:30:51,630 [salt.loaded.int.module.cmdmod][INFO    ][23664] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-11-22 00:30:55,461 [salt.loaded.int.module.cmdmod][INFO    ][23664] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'keepalived'] in directory '/root'
2017-11-22 00:31:00,596 [salt.minion      ][INFO    ][23142] User sudo_ubuntu Executing command saltutil.find_job with jid 20171122003100584161
2017-11-22 00:31:00,610 [salt.minion      ][INFO    ][24951] Starting a new job with PID 24951
2017-11-22 00:31:00,620 [salt.minion      ][INFO    ][24951] Returning information for job: 20171122003100584161
2017-11-22 00:31:03,164 [salt.loaded.int.module.cmdmod][INFO    ][23664] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-22 00:31:03,187 [salt.state       ][INFO    ][23664] Made the following changes:
'libsnmp30' changed from 'absent' to '5.7.3+dfsg-1ubuntu4'
'libsnmp-base' changed from 'absent' to '5.7.3+dfsg-1ubuntu4'
'keepalived' changed from 'absent' to '1:1.2.19-1ubuntu0.2'
'ipvsadm' changed from 'absent' to '1:1.28-3'
'libsensors4' changed from 'absent' to '1:3.4.0-2'

2017-11-22 00:31:03,195 [salt.state       ][INFO    ][23664] Loading fresh modules for state activity
2017-11-22 00:31:03,206 [salt.state       ][INFO    ][23664] Completed state [keepalived] at time 00:31:03.206225 duration_in_ms=11590.207
2017-11-22 00:31:03,208 [salt.state       ][INFO    ][23664] Running state [/etc/keepalived/keepalived.conf] at time 00:31:03.208265
2017-11-22 00:31:03,208 [salt.state       ][INFO    ][23664] Executing state file.managed for /etc/keepalived/keepalived.conf
2017-11-22 00:31:03,235 [salt.fileclient  ][INFO    ][23664] Fetching file from saltenv 'base', ** done ** 'keepalived/files/keepalived.conf'
2017-11-22 00:31:03,265 [salt.fileclient  ][INFO    ][23664] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-11-22 00:31:03,272 [salt.state       ][INFO    ][23664] File changed:
New file
2017-11-22 00:31:03,272 [salt.state       ][INFO    ][23664] Completed state [/etc/keepalived/keepalived.conf] at time 00:31:03.271687 duration_in_ms=63.421
2017-11-22 00:31:03,328 [salt.state       ][INFO    ][23664] Running state [keepalived] at time 00:31:03.327973
2017-11-22 00:31:03,328 [salt.state       ][INFO    ][23664] Executing state service.running for keepalived
2017-11-22 00:31:03,329 [salt.loaded.int.module.cmdmod][INFO    ][23664] Executing command ['systemctl', 'status', 'keepalived.service', '-n', '0'] in directory '/root'
2017-11-22 00:31:03,337 [salt.loaded.int.module.cmdmod][INFO    ][23664] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2017-11-22 00:31:03,343 [salt.loaded.int.module.cmdmod][INFO    ][23664] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-11-22 00:31:03,350 [salt.loaded.int.module.cmdmod][INFO    ][23664] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-11-22 00:31:03,357 [salt.loaded.int.module.cmdmod][INFO    ][23664] Executing command ['systemd-run', '--scope', 'systemctl', 'start', 'keepalived.service'] in directory '/root'
2017-11-22 00:31:03,417 [salt.loaded.int.module.cmdmod][INFO    ][23664] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2017-11-22 00:31:03,425 [salt.loaded.int.module.cmdmod][INFO    ][23664] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-11-22 00:31:03,432 [salt.loaded.int.module.cmdmod][INFO    ][23664] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-11-22 00:31:03,439 [salt.state       ][INFO    ][23664] {'keepalived': True}
2017-11-22 00:31:03,439 [salt.state       ][INFO    ][23664] Completed state [keepalived] at time 00:31:03.438840 duration_in_ms=110.867
2017-11-22 00:31:03,440 [salt.minion      ][INFO    ][23664] Returning information for job: 20171122003050538875
2017-11-22 00:31:18,974 [salt.minion      ][INFO    ][23142] User sudo_ubuntu Executing command pillar.get with jid 20171122003118963770
2017-11-22 00:31:18,992 [salt.minion      ][INFO    ][25245] Starting a new job with PID 25245
2017-11-22 00:31:18,998 [salt.minion      ][INFO    ][25245] Returning information for job: 20171122003118963770
2017-11-22 00:36:35,783 [salt.minion      ][INFO    ][23142] User sudo_ubuntu Executing command state.sls with jid 20171122003635782496
2017-11-22 00:36:35,799 [salt.minion      ][INFO    ][25333] Starting a new job with PID 25333
2017-11-22 00:36:38,491 [salt.state       ][INFO    ][25333] Loading fresh modules for state activity
2017-11-22 00:36:38,513 [salt.fileclient  ][INFO    ][25333] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-11-22 00:36:38,535 [salt.fileclient  ][INFO    ][25333] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-11-22 00:36:38,798 [salt.state       ][INFO    ][25333] Running state [attr] at time 00:36:38.798047
2017-11-22 00:36:38,798 [salt.state       ][INFO    ][25333] Executing state pkg.installed for attr
2017-11-22 00:36:38,799 [salt.loaded.int.module.cmdmod][INFO    ][25333] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-22 00:36:39,079 [salt.loaded.int.module.cmdmod][INFO    ][25333] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-11-22 00:36:41,127 [salt.loaded.int.module.cmdmod][INFO    ][25333] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'attr'] in directory '/root'
2017-11-22 00:36:43,348 [salt.loaded.int.module.cmdmod][INFO    ][25333] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-22 00:36:43,372 [salt.state       ][INFO    ][25333] Made the following changes:
'attr' changed from 'absent' to '1:2.4.47-2'

2017-11-22 00:36:43,381 [salt.state       ][INFO    ][25333] Loading fresh modules for state activity
2017-11-22 00:36:43,394 [salt.state       ][INFO    ][25333] Completed state [attr] at time 00:36:43.393448 duration_in_ms=4595.4
2017-11-22 00:36:43,401 [salt.state       ][INFO    ][25333] Running state [glusterfs-server] at time 00:36:43.401064
2017-11-22 00:36:43,401 [salt.state       ][INFO    ][25333] Executing state pkg.installed for glusterfs-server
2017-11-22 00:36:43,590 [salt.loaded.int.module.cmdmod][INFO    ][25333] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'glusterfs-server'] in directory '/root'
2017-11-22 00:36:45,877 [salt.minion      ][INFO    ][23142] User sudo_ubuntu Executing command saltutil.find_job with jid 20171122003645873298
2017-11-22 00:36:45,893 [salt.minion      ][INFO    ][26310] Starting a new job with PID 26310
2017-11-22 00:36:45,907 [salt.minion      ][INFO    ][26310] Returning information for job: 20171122003645873298
2017-11-22 00:36:56,075 [salt.minion      ][INFO    ][23142] User sudo_ubuntu Executing command saltutil.find_job with jid 20171122003656072751
2017-11-22 00:36:56,089 [salt.minion      ][INFO    ][29049] Starting a new job with PID 29049
2017-11-22 00:36:56,110 [salt.minion      ][INFO    ][29049] Returning information for job: 20171122003656072751
2017-11-22 00:37:01,379 [salt.loaded.int.module.cmdmod][INFO    ][25333] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-22 00:37:01,403 [salt.state       ][INFO    ][25333] Made the following changes:
'keyutils' changed from 'absent' to '1.5.9-8ubuntu1'
'nfs-common' changed from 'absent' to '1:1.2.8-9ubuntu12.1'
'rpcbind' changed from 'absent' to '0.2.3-0.2'
'glusterfs-common' changed from 'absent' to '3.7.6-1ubuntu1'
'librdmacm1' changed from 'absent' to '1.0.21-1'
'libnfsidmap2' changed from 'absent' to '0.25-5'
'portmap' changed from 'absent' to '1'
'libattr1-dev' changed from 'absent' to '1:2.4.47-2'
'attr-dev' changed from 'absent' to '1'
'acl-dev' changed from 'absent' to '1'
'glusterfs-server' changed from 'absent' to '3.7.6-1ubuntu1'
'glusterfs-client' changed from 'absent' to '3.7.6-1ubuntu1'
'libpython2.7' changed from 'absent' to '2.7.12-1ubuntu0~16.04.1'
'nfs-client' changed from 'absent' to '1'
'liburcu4' changed from 'absent' to '0.9.1-3'
'libacl1-dev' changed from 'absent' to '2.2.52-3'
'libibverbs1' changed from 'absent' to '1.1.8-1.1ubuntu2'
'libtirpc1' changed from 'absent' to '0.2.5-1'

2017-11-22 00:37:01,410 [salt.state       ][INFO    ][25333] Loading fresh modules for state activity
2017-11-22 00:37:01,423 [salt.state       ][INFO    ][25333] Completed state [glusterfs-server] at time 00:37:01.422511 duration_in_ms=18021.445
2017-11-22 00:37:01,429 [salt.state       ][INFO    ][25333] Running state [bc] at time 00:37:01.429211
2017-11-22 00:37:01,429 [salt.state       ][INFO    ][25333] Executing state pkg.installed for bc
2017-11-22 00:37:01,698 [salt.loaded.int.module.cmdmod][INFO    ][25333] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'bc'] in directory '/root'
2017-11-22 00:37:04,561 [salt.loaded.int.module.cmdmod][INFO    ][25333] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-22 00:37:04,589 [salt.state       ][INFO    ][25333] Made the following changes:
'bc' changed from 'absent' to '1.06.95-9build1'

2017-11-22 00:37:04,599 [salt.state       ][INFO    ][25333] Loading fresh modules for state activity
2017-11-22 00:37:04,611 [salt.state       ][INFO    ][25333] Completed state [bc] at time 00:37:04.611387 duration_in_ms=3182.176
2017-11-22 00:37:04,678 [salt.state       ][INFO    ][25333] Running state [glusterfs-server] at time 00:37:04.678208
2017-11-22 00:37:04,678 [salt.state       ][INFO    ][25333] Executing state service.running for glusterfs-server
2017-11-22 00:37:04,680 [salt.loaded.int.module.cmdmod][INFO    ][25333] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-11-22 00:37:04,688 [salt.loaded.int.module.cmdmod][INFO    ][25333] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-11-22 00:37:04,694 [salt.loaded.int.module.cmdmod][INFO    ][25333] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-11-22 00:37:04,702 [salt.state       ][INFO    ][25333] The service glusterfs-server is already running
2017-11-22 00:37:04,703 [salt.state       ][INFO    ][25333] Completed state [glusterfs-server] at time 00:37:04.702538 duration_in_ms=24.33
2017-11-22 00:37:04,705 [salt.state       ][INFO    ][25333] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 00:37:04.704678
2017-11-22 00:37:04,705 [salt.state       ][INFO    ][25333] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-11-22 00:37:04,714 [salt.state       ][INFO    ][25333] File changed:
New file
2017-11-22 00:37:04,714 [salt.state       ][INFO    ][25333] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 00:37:04.714162 duration_in_ms=9.484
2017-11-22 00:37:04,714 [salt.state       ][INFO    ][25333] Running state [/srv/glusterfs/glance] at time 00:37:04.714323
2017-11-22 00:37:04,715 [salt.state       ][INFO    ][25333] Executing state file.directory for /srv/glusterfs/glance
2017-11-22 00:37:04,715 [salt.state       ][INFO    ][25333] {'/srv/glusterfs/glance': 'New Dir'}
2017-11-22 00:37:04,715 [salt.state       ][INFO    ][25333] Completed state [/srv/glusterfs/glance] at time 00:37:04.715198 duration_in_ms=0.874
2017-11-22 00:37:04,715 [salt.state       ][INFO    ][25333] Running state [/srv/glusterfs/keystone-keys] at time 00:37:04.715348
2017-11-22 00:37:04,716 [salt.state       ][INFO    ][25333] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-11-22 00:37:04,716 [salt.state       ][INFO    ][25333] {'/srv/glusterfs/keystone-keys': 'New Dir'}
2017-11-22 00:37:04,716 [salt.state       ][INFO    ][25333] Completed state [/srv/glusterfs/keystone-keys] at time 00:37:04.716083 duration_in_ms=0.735
2017-11-22 00:37:04,716 [salt.state       ][INFO    ][25333] Running state [/srv/glusterfs/nova_instances] at time 00:37:04.716239
2017-11-22 00:37:04,716 [salt.state       ][INFO    ][25333] Executing state file.directory for /srv/glusterfs/nova_instances
2017-11-22 00:37:04,717 [salt.state       ][INFO    ][25333] {'/srv/glusterfs/nova_instances': 'New Dir'}
2017-11-22 00:37:04,717 [salt.state       ][INFO    ][25333] Completed state [/srv/glusterfs/nova_instances] at time 00:37:04.716894 duration_in_ms=0.655
2017-11-22 00:37:04,717 [salt.state       ][INFO    ][25333] Running state [/srv/glusterfs/keystone-credential-keys] at time 00:37:04.717045
2017-11-22 00:37:04,717 [salt.state       ][INFO    ][25333] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-11-22 00:37:04,718 [salt.state       ][INFO    ][25333] {'/srv/glusterfs/keystone-credential-keys': 'New Dir'}
2017-11-22 00:37:04,718 [salt.state       ][INFO    ][25333] Completed state [/srv/glusterfs/keystone-credential-keys] at time 00:37:04.717695 duration_in_ms=0.651
2017-11-22 00:37:04,718 [salt.minion      ][INFO    ][25333] Returning information for job: 20171122003635782496
2017-11-22 00:37:05,751 [salt.minion      ][INFO    ][23142] User sudo_ubuntu Executing command test.ping with jid 20171122003705755555
2017-11-22 00:37:05,764 [salt.minion      ][INFO    ][30093] Starting a new job with PID 30093
2017-11-22 00:37:05,793 [salt.minion      ][INFO    ][30093] Returning information for job: 20171122003705755555
2017-11-22 00:37:46,250 [salt.minion      ][INFO    ][23142] User sudo_ubuntu Executing command state.sls with jid 20171122003746250658
2017-11-22 00:37:46,269 [salt.minion      ][INFO    ][30307] Starting a new job with PID 30307
2017-11-22 00:37:47,977 [salt.state       ][INFO    ][30307] Loading fresh modules for state activity
2017-11-22 00:37:48,002 [salt.fileclient  ][INFO    ][30307] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/setup.sls'
2017-11-22 00:37:48,038 [salt.fileclient  ][INFO    ][30307] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-11-22 00:37:48,103 [salt.fileclient  ][INFO    ][30307] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-11-22 00:37:48,122 [salt.fileclient  ][INFO    ][30307] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-11-22 00:37:48,406 [salt.state       ][INFO    ][30307] Running state [attr] at time 00:37:48.405986
2017-11-22 00:37:48,406 [salt.state       ][INFO    ][30307] Executing state pkg.installed for attr
2017-11-22 00:37:48,407 [salt.loaded.int.module.cmdmod][INFO    ][30307] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-22 00:37:48,649 [salt.state       ][INFO    ][30307] Package attr is already installed
2017-11-22 00:37:48,649 [salt.state       ][INFO    ][30307] Completed state [attr] at time 00:37:48.648841 duration_in_ms=242.855
2017-11-22 00:37:48,649 [salt.state       ][INFO    ][30307] Running state [glusterfs-server] at time 00:37:48.649048
2017-11-22 00:37:48,649 [salt.state       ][INFO    ][30307] Executing state pkg.installed for glusterfs-server
2017-11-22 00:37:48,652 [salt.state       ][INFO    ][30307] Package glusterfs-server is already installed
2017-11-22 00:37:48,652 [salt.state       ][INFO    ][30307] Completed state [glusterfs-server] at time 00:37:48.651856 duration_in_ms=2.808
2017-11-22 00:37:48,652 [salt.state       ][INFO    ][30307] Running state [bc] at time 00:37:48.651994
2017-11-22 00:37:48,652 [salt.state       ][INFO    ][30307] Executing state pkg.installed for bc
2017-11-22 00:37:48,655 [salt.state       ][INFO    ][30307] Package bc is already installed
2017-11-22 00:37:48,655 [salt.state       ][INFO    ][30307] Completed state [bc] at time 00:37:48.654714 duration_in_ms=2.719
2017-11-22 00:37:48,655 [salt.state       ][INFO    ][30307] Running state [glusterfs-server] at time 00:37:48.655476
2017-11-22 00:37:48,656 [salt.state       ][INFO    ][30307] Executing state service.running for glusterfs-server
2017-11-22 00:37:48,656 [salt.loaded.int.module.cmdmod][INFO    ][30307] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-11-22 00:37:48,665 [salt.loaded.int.module.cmdmod][INFO    ][30307] Executing command ['systemctl', '--system', 'daemon-reload'] in directory '/root'
2017-11-22 00:37:48,705 [salt.loaded.int.module.cmdmod][INFO    ][30307] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-11-22 00:37:48,718 [salt.loaded.int.module.cmdmod][INFO    ][30307] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-11-22 00:37:48,725 [salt.loaded.int.module.cmdmod][INFO    ][30307] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-11-22 00:37:48,733 [salt.state       ][INFO    ][30307] The service glusterfs-server is already running
2017-11-22 00:37:48,733 [salt.state       ][INFO    ][30307] Completed state [glusterfs-server] at time 00:37:48.733395 duration_in_ms=77.919
2017-11-22 00:37:48,735 [salt.state       ][INFO    ][30307] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 00:37:48.734959
2017-11-22 00:37:48,735 [salt.state       ][INFO    ][30307] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-11-22 00:37:48,745 [salt.state       ][INFO    ][30307] File /etc/systemd/system/glusterfs-server.service.d/override.conf is in the correct state
2017-11-22 00:37:48,745 [salt.state       ][INFO    ][30307] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 00:37:48.745156 duration_in_ms=10.196
2017-11-22 00:37:48,745 [salt.state       ][INFO    ][30307] Running state [/srv/glusterfs/glance] at time 00:37:48.745351
2017-11-22 00:37:48,746 [salt.state       ][INFO    ][30307] Executing state file.directory for /srv/glusterfs/glance
2017-11-22 00:37:48,746 [salt.state       ][INFO    ][30307] Directory /srv/glusterfs/glance is in the correct state
2017-11-22 00:37:48,746 [salt.state       ][INFO    ][30307] Completed state [/srv/glusterfs/glance] at time 00:37:48.746099 duration_in_ms=0.749
2017-11-22 00:37:48,746 [salt.state       ][INFO    ][30307] Running state [/srv/glusterfs/keystone-keys] at time 00:37:48.746279
2017-11-22 00:37:48,746 [salt.state       ][INFO    ][30307] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-11-22 00:37:48,747 [salt.state       ][INFO    ][30307] Directory /srv/glusterfs/keystone-keys is in the correct state
2017-11-22 00:37:48,747 [salt.state       ][INFO    ][30307] Completed state [/srv/glusterfs/keystone-keys] at time 00:37:48.746984 duration_in_ms=0.706
2017-11-22 00:37:48,747 [salt.state       ][INFO    ][30307] Running state [/srv/glusterfs/nova_instances] at time 00:37:48.747167
2017-11-22 00:37:48,747 [salt.state       ][INFO    ][30307] Executing state file.directory for /srv/glusterfs/nova_instances
2017-11-22 00:37:48,748 [salt.state       ][INFO    ][30307] Directory /srv/glusterfs/nova_instances is in the correct state
2017-11-22 00:37:48,748 [salt.state       ][INFO    ][30307] Completed state [/srv/glusterfs/nova_instances] at time 00:37:48.747919 duration_in_ms=0.752
2017-11-22 00:37:48,748 [salt.state       ][INFO    ][30307] Running state [/srv/glusterfs/keystone-credential-keys] at time 00:37:48.748135
2017-11-22 00:37:48,748 [salt.state       ][INFO    ][30307] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-11-22 00:37:48,749 [salt.state       ][INFO    ][30307] Directory /srv/glusterfs/keystone-credential-keys is in the correct state
2017-11-22 00:37:48,749 [salt.state       ][INFO    ][30307] Completed state [/srv/glusterfs/keystone-credential-keys] at time 00:37:48.748858 duration_in_ms=0.724
2017-11-22 00:37:48,806 [salt.loaded.int.module.cmdmod][INFO    ][30307] Executing command ['git', '--version'] in directory '/root'
2017-11-22 00:37:48,891 [salt.state       ][INFO    ][30307] Running state [sleep 5] at time 00:37:48.891279
2017-11-22 00:37:48,892 [salt.state       ][INFO    ][30307] Executing state cmd.wait for sleep 5
2017-11-22 00:37:48,892 [salt.state       ][INFO    ][30307] No changes made for sleep 5
2017-11-22 00:37:48,892 [salt.state       ][INFO    ][30307] Completed state [sleep 5] at time 00:37:48.891837 duration_in_ms=0.558
2017-11-22 00:37:48,892 [salt.state       ][INFO    ][30307] Running state [10.167.4.141] at time 00:37:48.892207
2017-11-22 00:37:48,892 [salt.state       ][INFO    ][30307] Executing state glusterfs.peered for 10.167.4.141
2017-11-22 00:37:48,893 [salt.loaded.int.module.cmdmod][INFO    ][30307] Executing command 'gluster --version' in directory '/root'
2017-11-22 00:37:48,902 [salt.loaded.int.module.cmdmod][INFO    ][30307] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-22 00:37:48,952 [salt.state       ][INFO    ][30307] Host 10.167.4.141 already peered
2017-11-22 00:37:48,953 [salt.state       ][INFO    ][30307] Completed state [10.167.4.141] at time 00:37:48.952546 duration_in_ms=60.338
2017-11-22 00:37:48,955 [salt.state       ][INFO    ][30307] Running state [10.167.4.142] at time 00:37:48.954690
2017-11-22 00:37:48,955 [salt.state       ][INFO    ][30307] Executing state glusterfs.peered for 10.167.4.142
2017-11-22 00:37:48,955 [salt.loaded.int.module.cmdmod][INFO    ][30307] Executing command 'gluster --version' in directory '/root'
2017-11-22 00:37:48,963 [salt.loaded.int.module.cmdmod][INFO    ][30307] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-22 00:37:49,011 [salt.loaded.int.module.cmdmod][INFO    ][30307] Executing command 'gluster --version' in directory '/root'
2017-11-22 00:37:49,018 [salt.loaded.int.module.cmdmod][INFO    ][30307] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-22 00:37:49,069 [salt.loaded.int.module.cmdmod][INFO    ][30307] Executing command 'gluster --version' in directory '/root'
2017-11-22 00:37:49,077 [salt.loaded.int.module.cmdmod][INFO    ][30307] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-22 00:37:49,144 [salt.loaded.int.module.cmdmod][INFO    ][30307] Executing command 'gluster --version' in directory '/root'
2017-11-22 00:37:49,151 [salt.loaded.int.module.cmdmod][INFO    ][30307] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-22 00:37:49,200 [salt.state       ][INFO    ][30307] {'new': {'10.167.4.141': [], 'kvm02.baremetal-mcp-ocata-ovs-ha.local': ['10.167.4.142']}, 'old': {'10.167.4.141': [], 'kvm02.baremetal-mcp-ocata-ovs-ha.local': []}}
2017-11-22 00:37:49,201 [salt.state       ][INFO    ][30307] Completed state [10.167.4.142] at time 00:37:49.200576 duration_in_ms=245.884
2017-11-22 00:37:49,203 [salt.state       ][INFO    ][30307] Running state [10.167.4.143] at time 00:37:49.202916
2017-11-22 00:37:49,203 [salt.state       ][INFO    ][30307] Executing state glusterfs.peered for 10.167.4.143
2017-11-22 00:37:49,204 [salt.loaded.int.module.cmdmod][INFO    ][30307] Executing command 'gluster --version' in directory '/root'
2017-11-22 00:37:49,211 [salt.loaded.int.module.cmdmod][INFO    ][30307] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-22 00:37:49,258 [salt.loaded.int.module.cmdmod][INFO    ][30307] Executing command 'gluster --version' in directory '/root'
2017-11-22 00:37:49,264 [salt.loaded.int.module.cmdmod][INFO    ][30307] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-22 00:37:49,312 [salt.loaded.int.module.cmdmod][INFO    ][30307] Executing command 'gluster --version' in directory '/root'
2017-11-22 00:37:49,320 [salt.loaded.int.module.cmdmod][INFO    ][30307] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-22 00:37:49,369 [salt.loaded.int.module.cmdmod][INFO    ][30307] Executing command 'gluster --version' in directory '/root'
2017-11-22 00:37:49,377 [salt.loaded.int.module.cmdmod][INFO    ][30307] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-22 00:37:49,424 [salt.state       ][INFO    ][30307] Peering with localhost is not needed
2017-11-22 00:37:49,424 [salt.state       ][INFO    ][30307] Completed state [10.167.4.143] at time 00:37:49.423781 duration_in_ms=220.865
2017-11-22 00:37:49,425 [salt.state       ][INFO    ][30307] Running state [glance] at time 00:37:49.424582
2017-11-22 00:37:49,425 [salt.state       ][INFO    ][30307] Executing state glusterfs.created for glance
2017-11-22 00:37:49,425 [salt.loaded.int.module.cmdmod][INFO    ][30307] Executing command 'gluster --version' in directory '/root'
2017-11-22 00:37:49,432 [salt.loaded.int.module.cmdmod][INFO    ][30307] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-22 00:37:49,478 [salt.loaded.int.module.cmdmod][INFO    ][30307] Executing command 'gluster --version' in directory '/root'
2017-11-22 00:37:49,484 [salt.loaded.int.module.cmdmod][INFO    ][30307] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-22 00:37:49,534 [salt.state       ][INFO    ][30307] Volume glance already exists and is started.
2017-11-22 00:37:49,535 [salt.state       ][INFO    ][30307] Completed state [glance] at time 00:37:49.534586 duration_in_ms=110.004
2017-11-22 00:37:49,537 [salt.state       ][INFO    ][30307] Running state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 00:37:49.537213
2017-11-22 00:37:49,537 [salt.state       ][INFO    ][30307] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'
2017-11-22 00:37:49,538 [salt.loaded.int.module.cmdmod][INFO    ][30307] Executing command 'gluster volume info 'glance' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-11-22 00:37:49,587 [salt.state       ][INFO    ][30307] unless execution succeeded
2017-11-22 00:37:49,587 [salt.state       ][INFO    ][30307] Completed state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 00:37:49.587146 duration_in_ms=49.932
2017-11-22 00:37:49,588 [salt.state       ][INFO    ][30307] Running state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 00:37:49.587587
2017-11-22 00:37:49,588 [salt.state       ][INFO    ][30307] Executing state cmd.run for gluster volume set 'glance' 'network.remote-dio' 'True'
2017-11-22 00:37:49,588 [salt.loaded.int.module.cmdmod][INFO    ][30307] Executing command 'gluster volume info 'glance' | grep 'network.remote-dio: True'' in directory '/root'
2017-11-22 00:37:49,635 [salt.state       ][INFO    ][30307] unless execution succeeded
2017-11-22 00:37:49,635 [salt.state       ][INFO    ][30307] Completed state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 00:37:49.635254 duration_in_ms=47.667
2017-11-22 00:37:49,636 [salt.state       ][INFO    ][30307] Running state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 00:37:49.635716
2017-11-22 00:37:49,636 [salt.state       ][INFO    ][30307] Executing state cmd.run for gluster volume set 'glance' 'nfs.disable' 'True'
2017-11-22 00:37:49,636 [salt.loaded.int.module.cmdmod][INFO    ][30307] Executing command 'gluster volume info 'glance' | grep 'nfs.disable: True'' in directory '/root'
2017-11-22 00:37:49,683 [salt.state       ][INFO    ][30307] unless execution succeeded
2017-11-22 00:37:49,683 [salt.state       ][INFO    ][30307] Completed state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 00:37:49.683315 duration_in_ms=47.599
2017-11-22 00:37:49,684 [salt.state       ][INFO    ][30307] Running state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 00:37:49.683760
2017-11-22 00:37:49,684 [salt.state       ][INFO    ][30307] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'
2017-11-22 00:37:49,684 [salt.loaded.int.module.cmdmod][INFO    ][30307] Executing command 'gluster volume info 'glance' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-11-22 00:37:49,733 [salt.state       ][INFO    ][30307] unless execution succeeded
2017-11-22 00:37:49,733 [salt.state       ][INFO    ][30307] Completed state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 00:37:49.733357 duration_in_ms=49.596
2017-11-22 00:37:49,734 [salt.state       ][INFO    ][30307] Running state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 00:37:49.733741
2017-11-22 00:37:49,734 [salt.state       ][INFO    ][30307] Executing state cmd.run for gluster volume set 'glance' 'cluster.readdir-optimize' 'True'
2017-11-22 00:37:49,734 [salt.loaded.int.module.cmdmod][INFO    ][30307] Executing command 'gluster volume info 'glance' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-11-22 00:37:49,779 [salt.state       ][INFO    ][30307] unless execution succeeded
2017-11-22 00:37:49,779 [salt.state       ][INFO    ][30307] Completed state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 00:37:49.779240 duration_in_ms=45.497
2017-11-22 00:37:49,780 [salt.state       ][INFO    ][30307] Running state [glance] at time 00:37:49.780196
2017-11-22 00:37:49,780 [salt.state       ][INFO    ][30307] Executing state glusterfs.started for glance
2017-11-22 00:37:49,781 [salt.loaded.int.module.cmdmod][INFO    ][30307] Executing command 'gluster --version' in directory '/root'
2017-11-22 00:37:49,787 [salt.loaded.int.module.cmdmod][INFO    ][30307] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-22 00:37:49,834 [salt.loaded.int.module.cmdmod][INFO    ][30307] Executing command 'gluster --version' in directory '/root'
2017-11-22 00:37:49,842 [salt.loaded.int.module.cmdmod][INFO    ][30307] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-22 00:37:49,891 [salt.state       ][INFO    ][30307] Volume glance is already started
2017-11-22 00:37:49,891 [salt.state       ][INFO    ][30307] Completed state [glance] at time 00:37:49.890770 duration_in_ms=110.573
2017-11-22 00:37:49,892 [salt.state       ][INFO    ][30307] Running state [keystone-keys] at time 00:37:49.891583
2017-11-22 00:37:49,892 [salt.state       ][INFO    ][30307] Executing state glusterfs.created for keystone-keys
2017-11-22 00:37:49,892 [salt.loaded.int.module.cmdmod][INFO    ][30307] Executing command 'gluster --version' in directory '/root'
2017-11-22 00:37:49,899 [salt.loaded.int.module.cmdmod][INFO    ][30307] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-22 00:37:49,948 [salt.loaded.int.module.cmdmod][INFO    ][30307] Executing command 'gluster --version' in directory '/root'
2017-11-22 00:37:49,955 [salt.loaded.int.module.cmdmod][INFO    ][30307] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-22 00:37:50,007 [salt.state       ][INFO    ][30307] Volume keystone-keys already exists and is started.
2017-11-22 00:37:50,007 [salt.state       ][INFO    ][30307] Completed state [keystone-keys] at time 00:37:50.007330 duration_in_ms=115.747
2017-11-22 00:37:50,010 [salt.state       ][INFO    ][30307] Running state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 00:37:50.010017
2017-11-22 00:37:50,010 [salt.state       ][INFO    ][30307] Executing state cmd.run for gluster volume set 'keystone-keys' 'network.remote-dio' 'True'
2017-11-22 00:37:50,011 [salt.loaded.int.module.cmdmod][INFO    ][30307] Executing command 'gluster volume info 'keystone-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-11-22 00:37:50,058 [salt.state       ][INFO    ][30307] unless execution succeeded
2017-11-22 00:37:50,058 [salt.state       ][INFO    ][30307] Completed state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 00:37:50.057996 duration_in_ms=47.978
2017-11-22 00:37:50,058 [salt.state       ][INFO    ][30307] Running state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 00:37:50.058441
2017-11-22 00:37:50,059 [salt.state       ][INFO    ][30307] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-11-22 00:37:50,059 [salt.loaded.int.module.cmdmod][INFO    ][30307] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-11-22 00:37:50,107 [salt.state       ][INFO    ][30307] unless execution succeeded
2017-11-22 00:37:50,107 [salt.state       ][INFO    ][30307] Completed state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 00:37:50.106949 duration_in_ms=48.506
2017-11-22 00:37:50,107 [salt.state       ][INFO    ][30307] Running state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 00:37:50.107417
2017-11-22 00:37:50,108 [salt.state       ][INFO    ][30307] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'
2017-11-22 00:37:50,108 [salt.loaded.int.module.cmdmod][INFO    ][30307] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-11-22 00:37:50,157 [salt.state       ][INFO    ][30307] unless execution succeeded
2017-11-22 00:37:50,158 [salt.state       ][INFO    ][30307] Completed state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 00:37:50.157499 duration_in_ms=50.081
2017-11-22 00:37:50,158 [salt.state       ][INFO    ][30307] Running state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 00:37:50.157925
2017-11-22 00:37:50,158 [salt.state       ][INFO    ][30307] Executing state cmd.run for gluster volume set 'keystone-keys' 'nfs.disable' 'True'
2017-11-22 00:37:50,159 [salt.loaded.int.module.cmdmod][INFO    ][30307] Executing command 'gluster volume info 'keystone-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-11-22 00:37:50,206 [salt.state       ][INFO    ][30307] unless execution succeeded
2017-11-22 00:37:50,206 [salt.state       ][INFO    ][30307] Completed state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 00:37:50.205750 duration_in_ms=47.825
2017-11-22 00:37:50,206 [salt.state       ][INFO    ][30307] Running state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 00:37:50.206201
2017-11-22 00:37:50,206 [salt.state       ][INFO    ][30307] Executing state cmd.run for gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'
2017-11-22 00:37:50,207 [salt.loaded.int.module.cmdmod][INFO    ][30307] Executing command 'gluster volume info 'keystone-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-11-22 00:37:50,254 [salt.state       ][INFO    ][30307] unless execution succeeded
2017-11-22 00:37:50,254 [salt.state       ][INFO    ][30307] Completed state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 00:37:50.254241 duration_in_ms=48.04
2017-11-22 00:37:50,255 [salt.state       ][INFO    ][30307] Running state [keystone-keys] at time 00:37:50.255134
2017-11-22 00:37:50,255 [salt.state       ][INFO    ][30307] Executing state glusterfs.started for keystone-keys
2017-11-22 00:37:50,256 [salt.loaded.int.module.cmdmod][INFO    ][30307] Executing command 'gluster --version' in directory '/root'
2017-11-22 00:37:50,263 [salt.loaded.int.module.cmdmod][INFO    ][30307] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-22 00:37:50,310 [salt.loaded.int.module.cmdmod][INFO    ][30307] Executing command 'gluster --version' in directory '/root'
2017-11-22 00:37:50,318 [salt.loaded.int.module.cmdmod][INFO    ][30307] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-22 00:37:50,369 [salt.state       ][INFO    ][30307] Volume keystone-keys is already started
2017-11-22 00:37:50,369 [salt.state       ][INFO    ][30307] Completed state [keystone-keys] at time 00:37:50.368988 duration_in_ms=113.853
2017-11-22 00:37:50,370 [salt.state       ][INFO    ][30307] Running state [nova_instances] at time 00:37:50.369996
2017-11-22 00:37:50,370 [salt.state       ][INFO    ][30307] Executing state glusterfs.created for nova_instances
2017-11-22 00:37:50,371 [salt.loaded.int.module.cmdmod][INFO    ][30307] Executing command 'gluster --version' in directory '/root'
2017-11-22 00:37:50,379 [salt.loaded.int.module.cmdmod][INFO    ][30307] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-22 00:37:50,427 [salt.loaded.int.module.cmdmod][INFO    ][30307] Executing command 'gluster --version' in directory '/root'
2017-11-22 00:37:50,435 [salt.loaded.int.module.cmdmod][INFO    ][30307] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-22 00:37:50,487 [salt.state       ][INFO    ][30307] Volume nova_instances already exists and is started.
2017-11-22 00:37:50,488 [salt.state       ][INFO    ][30307] Completed state [nova_instances] at time 00:37:50.487635 duration_in_ms=117.639
2017-11-22 00:37:50,491 [salt.state       ][INFO    ][30307] Running state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 00:37:50.490565
2017-11-22 00:37:50,491 [salt.state       ][INFO    ][30307] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'
2017-11-22 00:37:50,491 [salt.loaded.int.module.cmdmod][INFO    ][30307] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-11-22 00:37:50,544 [salt.state       ][INFO    ][30307] unless execution succeeded
2017-11-22 00:37:50,544 [salt.state       ][INFO    ][30307] Completed state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 00:37:50.544432 duration_in_ms=53.866
2017-11-22 00:37:50,545 [salt.state       ][INFO    ][30307] Running state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'On'] at time 00:37:50.544852
2017-11-22 00:37:50,545 [salt.state       ][INFO    ][30307] Executing state cmd.run for gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'On'
2017-11-22 00:37:50,545 [salt.loaded.int.module.cmdmod][INFO    ][30307] Executing command 'gluster volume info 'nova_instances' | grep 'cluster.readdir-optimize: On'' in directory '/root'
2017-11-22 00:37:50,594 [salt.state       ][INFO    ][30307] unless execution succeeded
2017-11-22 00:37:50,594 [salt.state       ][INFO    ][30307] Completed state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'On'] at time 00:37:50.594097 duration_in_ms=49.244
2017-11-22 00:37:50,595 [salt.state       ][INFO    ][30307] Running state [gluster volume set 'nova_instances' 'network.remote-dio' 'On'] at time 00:37:50.594491
2017-11-22 00:37:50,595 [salt.state       ][INFO    ][30307] Executing state cmd.run for gluster volume set 'nova_instances' 'network.remote-dio' 'On'
2017-11-22 00:37:50,595 [salt.loaded.int.module.cmdmod][INFO    ][30307] Executing command 'gluster volume info 'nova_instances' | grep 'network.remote-dio: On'' in directory '/root'
2017-11-22 00:37:50,643 [salt.state       ][INFO    ][30307] unless execution succeeded
2017-11-22 00:37:50,643 [salt.state       ][INFO    ][30307] Completed state [gluster volume set 'nova_instances' 'network.remote-dio' 'On'] at time 00:37:50.642742 duration_in_ms=48.251
2017-11-22 00:37:50,643 [salt.state       ][INFO    ][30307] Running state [gluster volume set 'nova_instances' 'nfs.disable' 'On'] at time 00:37:50.643208
2017-11-22 00:37:50,643 [salt.state       ][INFO    ][30307] Executing state cmd.run for gluster volume set 'nova_instances' 'nfs.disable' 'On'
2017-11-22 00:37:50,644 [salt.loaded.int.module.cmdmod][INFO    ][30307] Executing command 'gluster volume info 'nova_instances' | grep 'nfs.disable: On'' in directory '/root'
2017-11-22 00:37:50,693 [salt.state       ][INFO    ][30307] unless execution succeeded
2017-11-22 00:37:50,693 [salt.state       ][INFO    ][30307] Completed state [gluster volume set 'nova_instances' 'nfs.disable' 'On'] at time 00:37:50.692950 duration_in_ms=49.742
2017-11-22 00:37:50,693 [salt.state       ][INFO    ][30307] Running state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 00:37:50.693429
2017-11-22 00:37:50,694 [salt.state       ][INFO    ][30307] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'
2017-11-22 00:37:50,694 [salt.loaded.int.module.cmdmod][INFO    ][30307] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-11-22 00:37:50,743 [salt.state       ][INFO    ][30307] unless execution succeeded
2017-11-22 00:37:50,743 [salt.state       ][INFO    ][30307] Completed state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 00:37:50.742713 duration_in_ms=49.283
2017-11-22 00:37:50,744 [salt.state       ][INFO    ][30307] Running state [nova_instances] at time 00:37:50.743602
2017-11-22 00:37:50,744 [salt.state       ][INFO    ][30307] Executing state glusterfs.started for nova_instances
2017-11-22 00:37:50,744 [salt.loaded.int.module.cmdmod][INFO    ][30307] Executing command 'gluster --version' in directory '/root'
2017-11-22 00:37:50,752 [salt.loaded.int.module.cmdmod][INFO    ][30307] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-22 00:37:50,805 [salt.loaded.int.module.cmdmod][INFO    ][30307] Executing command 'gluster --version' in directory '/root'
2017-11-22 00:37:50,813 [salt.loaded.int.module.cmdmod][INFO    ][30307] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-22 00:37:50,865 [salt.state       ][INFO    ][30307] Volume nova_instances is already started
2017-11-22 00:37:50,866 [salt.state       ][INFO    ][30307] Completed state [nova_instances] at time 00:37:50.865608 duration_in_ms=122.006
2017-11-22 00:37:50,867 [salt.state       ][INFO    ][30307] Running state [keystone-credential-keys] at time 00:37:50.866879
2017-11-22 00:37:50,867 [salt.state       ][INFO    ][30307] Executing state glusterfs.created for keystone-credential-keys
2017-11-22 00:37:50,868 [salt.loaded.int.module.cmdmod][INFO    ][30307] Executing command 'gluster --version' in directory '/root'
2017-11-22 00:37:50,876 [salt.loaded.int.module.cmdmod][INFO    ][30307] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-22 00:37:50,923 [salt.loaded.int.module.cmdmod][INFO    ][30307] Executing command 'gluster --version' in directory '/root'
2017-11-22 00:37:50,932 [salt.loaded.int.module.cmdmod][INFO    ][30307] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-22 00:37:50,987 [salt.state       ][INFO    ][30307] Volume keystone-credential-keys already exists and is started.
2017-11-22 00:37:50,987 [salt.state       ][INFO    ][30307] Completed state [keystone-credential-keys] at time 00:37:50.986977 duration_in_ms=120.096
2017-11-22 00:37:50,990 [salt.state       ][INFO    ][30307] Running state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 00:37:50.990042
2017-11-22 00:37:50,990 [salt.state       ][INFO    ][30307] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'
2017-11-22 00:37:50,991 [salt.loaded.int.module.cmdmod][INFO    ][30307] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-11-22 00:37:51,039 [salt.state       ][INFO    ][30307] unless execution succeeded
2017-11-22 00:37:51,039 [salt.state       ][INFO    ][30307] Completed state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 00:37:51.039248 duration_in_ms=49.205
2017-11-22 00:37:51,040 [salt.state       ][INFO    ][30307] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 00:37:51.039697
2017-11-22 00:37:51,040 [salt.state       ][INFO    ][30307] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-11-22 00:37:51,040 [salt.loaded.int.module.cmdmod][INFO    ][30307] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-11-22 00:37:51,087 [salt.state       ][INFO    ][30307] unless execution succeeded
2017-11-22 00:37:51,087 [salt.state       ][INFO    ][30307] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 00:37:51.087135 duration_in_ms=47.438
2017-11-22 00:37:51,088 [salt.state       ][INFO    ][30307] Running state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 00:37:51.087568
2017-11-22 00:37:51,088 [salt.state       ][INFO    ][30307] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'
2017-11-22 00:37:51,088 [salt.loaded.int.module.cmdmod][INFO    ][30307] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-11-22 00:37:51,135 [salt.state       ][INFO    ][30307] unless execution succeeded
2017-11-22 00:37:51,135 [salt.state       ][INFO    ][30307] Completed state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 00:37:51.134803 duration_in_ms=47.234
2017-11-22 00:37:51,135 [salt.state       ][INFO    ][30307] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 00:37:51.135253
2017-11-22 00:37:51,135 [salt.state       ][INFO    ][30307] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'
2017-11-22 00:37:51,136 [salt.loaded.int.module.cmdmod][INFO    ][30307] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-11-22 00:37:51,183 [salt.state       ][INFO    ][30307] unless execution succeeded
2017-11-22 00:37:51,183 [salt.state       ][INFO    ][30307] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 00:37:51.182802 duration_in_ms=47.549
2017-11-22 00:37:51,183 [salt.state       ][INFO    ][30307] Running state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 00:37:51.183254
2017-11-22 00:37:51,183 [salt.state       ][INFO    ][30307] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'
2017-11-22 00:37:51,184 [salt.loaded.int.module.cmdmod][INFO    ][30307] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-11-22 00:37:51,232 [salt.state       ][INFO    ][30307] unless execution succeeded
2017-11-22 00:37:51,232 [salt.state       ][INFO    ][30307] Completed state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 00:37:51.232090 duration_in_ms=48.836
2017-11-22 00:37:51,233 [salt.state       ][INFO    ][30307] Running state [keystone-credential-keys] at time 00:37:51.232999
2017-11-22 00:37:51,233 [salt.state       ][INFO    ][30307] Executing state glusterfs.started for keystone-credential-keys
2017-11-22 00:37:51,234 [salt.loaded.int.module.cmdmod][INFO    ][30307] Executing command 'gluster --version' in directory '/root'
2017-11-22 00:37:51,241 [salt.loaded.int.module.cmdmod][INFO    ][30307] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-22 00:37:51,288 [salt.loaded.int.module.cmdmod][INFO    ][30307] Executing command 'gluster --version' in directory '/root'
2017-11-22 00:37:51,295 [salt.loaded.int.module.cmdmod][INFO    ][30307] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-22 00:37:51,346 [salt.state       ][INFO    ][30307] Volume keystone-credential-keys is already started
2017-11-22 00:37:51,347 [salt.state       ][INFO    ][30307] Completed state [keystone-credential-keys] at time 00:37:51.346709 duration_in_ms=113.71
2017-11-22 00:37:51,349 [salt.minion      ][INFO    ][30307] Returning information for job: 20171122003746250658
2017-11-22 00:37:56,413 [salt.minion      ][INFO    ][23142] User sudo_ubuntu Executing command test.ping with jid 20171122003756413281
2017-11-22 00:37:56,428 [salt.minion      ][INFO    ][30733] Starting a new job with PID 30733
2017-11-22 00:37:56,453 [salt.minion      ][INFO    ][30733] Returning information for job: 20171122003756413281
2017-11-22 00:37:56,845 [salt.minion      ][INFO    ][23142] User sudo_ubuntu Executing command cmd.run with jid 20171122003756844253
2017-11-22 00:37:56,861 [salt.minion      ][INFO    ][30738] Starting a new job with PID 30738
2017-11-22 00:37:56,865 [salt.loaded.int.module.cmdmod][INFO    ][30738] Executing command 'gluster peer status; gluster volume status' in directory '/root'
2017-11-22 00:37:56,982 [salt.minion      ][INFO    ][30738] Returning information for job: 20171122003756844253
2017-11-22 01:15:32,361 [salt.utils.schedule][INFO    ][23142] Running scheduled job: __mine_interval
2017-11-22 02:08:36,331 [salt.minion      ][INFO    ][23142] User sudo_ubuntu Executing command cp.push_dir with jid 20171122020836323506
2017-11-22 02:08:36,354 [salt.minion      ][INFO    ][31791] Starting a new job with PID 31791
