2017-11-04 21:49:49,437 [salt.cli.daemons ][WARNING ][2575] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-11-04 21:50:06,761 [salt.state       ][ERROR   ][4043] No contents found in top file
2017-11-04 21:51:59,826 [salt.utils.parsers][WARNING ][2575] Minion received a SIGTERM. Exiting.
2017-11-04 21:56:25,125 [salt.cli.daemons ][WARNING ][3954] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-11-04 21:58:16,768 [salt.loaded.int.module.cmdmod][ERROR   ][11305] Command 'virsh net-destroy default 2>&1 1>/dev/null; virsh net-undefine default' failed with return code: 1
2017-11-04 21:58:16,769 [salt.loaded.int.module.cmdmod][ERROR   ][11305] stderr: error: failed to get network 'default'
error: Network not found: no network with matching name 'default'
2017-11-04 21:58:16,769 [salt.loaded.int.module.cmdmod][ERROR   ][11305] retcode: 1
2017-11-04 21:58:16,769 [salt.state       ][ERROR   ][11305] {'pid': 16224, 'retcode': 1, 'stderr': "error: failed to get network 'default'\nerror: Network not found: no network with matching name 'default'", 'stdout': ''}
2017-11-04 21:58:43,763 [py.warnings      ][WARNING ][16305] /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-04 21:59:07,978 [salt.loaded.int.module.cmdmod][ERROR   ][16305] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-11-04 21:59:07,979 [salt.loaded.int.module.cmdmod][ERROR   ][16305] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-11-04 21:59:12,538 [salt.loaded.int.module.cmdmod][ERROR   ][16305] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-11-04 21:59:12,538 [salt.loaded.int.module.cmdmod][ERROR   ][16305] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-11-04 21:59:16,924 [salt.loaded.int.module.cmdmod][ERROR   ][16305] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-11-04 21:59:16,925 [salt.loaded.int.module.cmdmod][ERROR   ][16305] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-11-04 21:59:21,486 [salt.loaded.int.module.cmdmod][ERROR   ][16305] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-11-04 21:59:21,487 [salt.loaded.int.module.cmdmod][ERROR   ][16305] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-11-04 21:59:25,898 [salt.loaded.int.module.cmdmod][ERROR   ][16305] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-11-04 21:59:25,899 [salt.loaded.int.module.cmdmod][ERROR   ][16305] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-11-04 21:59:29,406 [salt.loaded.int.module.cmdmod][ERROR   ][16305] 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-04 21:59:32,250 [salt.loaded.int.module.cmdmod][INFO    ][24167] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2017-11-04 21:59:32,258 [salt.loaded.int.module.cmdmod][INFO    ][24167] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2017-11-04 21:59:32,268 [salt.loaded.int.module.cmdmod][INFO    ][24167] Executing command ['systemd-run', '--scope', 'systemctl', 'restart', 'salt-minion.service'] in directory '/root'
2017-11-04 21:59:32,276 [salt.utils.parsers][WARNING ][3954] Minion received a SIGTERM. Exiting.
2017-11-04 21:59:32,592 [salt.cli.daemons ][INFO    ][24259] Setting up the Salt Minion "kvm03.baremetal-mcp-ocata-ovs-ha.local"
2017-11-04 21:59:33,227 [salt.minion      ][INFO    ][24259] Creating minion process manager
2017-11-04 21:59:33,228 [salt.cli.daemons ][WARNING ][24259] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-11-04 21:59:33,228 [salt.cli.daemons ][INFO    ][24259] The Salt Minion is starting up
2017-11-04 21:59:33,228 [salt.minion      ][INFO    ][24259] Minion is starting as user 'root'
2017-11-04 21:59:33,228 [salt.utils.event ][INFO    ][24259] Starting pull socket on /var/run/salt/minion/minion_event_98ff1e569f_pull.ipc
2017-11-04 21:59:34,374 [salt.loaded.int.module.cmdmod][INFO    ][24259] Executing command ['date', '+%z'] in directory '/root'
2017-11-04 21:59:34,385 [salt.utils.schedule][INFO    ][24259] Updating job settings for scheduled job: __mine_interval
2017-11-04 21:59:34,389 [salt.minion      ][INFO    ][24259] Added mine.update to scheduler
2017-11-04 21:59:34,407 [salt.minion      ][INFO    ][24259] Minion is ready to receive requests!
2017-11-04 21:59:35,408 [salt.utils.schedule][INFO    ][24259] Running scheduled job: __mine_interval
2017-11-04 21:59:42,340 [salt.minion      ][INFO    ][24259] User sudo_ubuntu Executing command saltutil.find_job with jid 20171104215942328486
2017-11-04 21:59:42,349 [salt.minion      ][INFO    ][24384] Starting a new job with PID 24384
2017-11-04 21:59:42,356 [salt.minion      ][INFO    ][24384] Returning information for job: 20171104215942328486
2017-11-04 21:59:53,362 [salt.minion      ][INFO    ][24259] User sudo_ubuntu Executing command state.sls with jid 20171104215953354135
2017-11-04 21:59:53,371 [salt.minion      ][INFO    ][24390] Starting a new job with PID 24390
2017-11-04 21:59:55,504 [salt.state       ][INFO    ][24390] Loading fresh modules for state activity
2017-11-04 21:59:55,530 [salt.fileclient  ][INFO    ][24390] Fetching file from saltenv 'base', ** done ** 'salt/control/init.sls'
2017-11-04 21:59:55,549 [salt.fileclient  ][INFO    ][24390] Fetching file from saltenv 'base', ** done ** 'salt/control/virt.sls'
2017-11-04 21:59:55,575 [salt.fileclient  ][INFO    ][24390] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-11-04 21:59:55,656 [salt.fileclient  ][INFO    ][24390] Fetching file from saltenv 'base', ** done ** 'salt/minion/init.sls'
2017-11-04 21:59:55,669 [salt.fileclient  ][INFO    ][24390] Fetching file from saltenv 'base', ** done ** 'salt/minion/service.sls'
2017-11-04 21:59:55,697 [salt.fileclient  ][INFO    ][24390] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-11-04 21:59:55,815 [salt.fileclient  ][INFO    ][24390] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-11-04 21:59:55,832 [salt.fileclient  ][INFO    ][24390] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-11-04 21:59:55,886 [salt.fileclient  ][INFO    ][24390] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-11-04 21:59:55,904 [salt.fileclient  ][INFO    ][24390] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-11-04 21:59:55,915 [salt.fileclient  ][INFO    ][24390] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-11-04 21:59:55,985 [salt.fileclient  ][INFO    ][24390] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-11-04 21:59:55,995 [salt.loaded.int.module.cmdmod][INFO    ][24390] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-11-04 21:59:56,016 [salt.fileclient  ][INFO    ][24390] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-11-04 21:59:56,035 [py.warnings      ][WARNING ][24390] /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-04 21:59:56,035 [salt.loaded.int.module.cmdmod][INFO    ][24390] Executing command 'salt-minion --version' in directory '/root'
2017-11-04 21:59:56,292 [salt.fileclient  ][INFO    ][24390] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-11-04 21:59:56,319 [salt.fileclient  ][INFO    ][24390] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-11-04 21:59:56,330 [salt.fileclient  ][INFO    ][24390] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-11-04 21:59:56,343 [salt.fileclient  ][INFO    ][24390] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-11-04 21:59:56,400 [salt.fileclient  ][INFO    ][24390] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-11-04 21:59:56,444 [salt.fileclient  ][INFO    ][24390] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-11-04 21:59:56,520 [salt.fileclient  ][INFO    ][24390] Fetching file from saltenv 'base', ** done ** 'salt/minion/grains.sls'
2017-11-04 21:59:56,541 [salt.fileclient  ][INFO    ][24390] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-11-04 21:59:56,600 [salt.fileclient  ][INFO    ][24390] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-11-04 21:59:56,618 [salt.fileclient  ][INFO    ][24390] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-11-04 21:59:56,674 [salt.fileclient  ][INFO    ][24390] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-11-04 21:59:56,692 [salt.fileclient  ][INFO    ][24390] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-11-04 21:59:56,704 [salt.fileclient  ][INFO    ][24390] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-11-04 21:59:56,718 [salt.fileclient  ][INFO    ][24390] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-11-04 21:59:56,727 [salt.loaded.int.module.cmdmod][INFO    ][24390] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-11-04 21:59:56,747 [salt.fileclient  ][INFO    ][24390] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-11-04 21:59:56,766 [salt.loaded.int.module.cmdmod][INFO    ][24390] Executing command 'salt-minion --version' in directory '/root'
2017-11-04 21:59:57,020 [salt.fileclient  ][INFO    ][24390] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-11-04 21:59:57,042 [salt.fileclient  ][INFO    ][24390] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-11-04 21:59:57,058 [salt.fileclient  ][INFO    ][24390] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-11-04 21:59:57,072 [salt.fileclient  ][INFO    ][24390] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-11-04 21:59:57,128 [salt.fileclient  ][INFO    ][24390] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-11-04 21:59:57,168 [salt.fileclient  ][INFO    ][24390] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-11-04 21:59:57,249 [salt.fileclient  ][INFO    ][24390] Fetching file from saltenv 'base', ** done ** 'salt/minion/cert.sls'
2017-11-04 21:59:57,331 [salt.fileclient  ][INFO    ][24390] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-11-04 21:59:57,683 [salt.state       ][INFO    ][24390] Running state [salt-minion] at time 21:59:57.682796
2017-11-04 21:59:57,683 [salt.state       ][INFO    ][24390] Executing state pkg.installed for salt-minion
2017-11-04 21:59:57,684 [salt.loaded.int.module.cmdmod][INFO    ][24390] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-04 21:59:57,977 [salt.state       ][INFO    ][24390] Package salt-minion is already installed
2017-11-04 21:59:57,977 [salt.state       ][INFO    ][24390] Completed state [salt-minion] at time 21:59:57.977374 duration_in_ms=294.577
2017-11-04 21:59:57,978 [salt.state       ][INFO    ][24390] Running state [salt_minion_dependency_packages] at time 21:59:57.977662
2017-11-04 21:59:57,978 [salt.state       ][INFO    ][24390] Executing state pkg.installed for salt_minion_dependency_packages
2017-11-04 21:59:57,982 [salt.state       ][INFO    ][24390] All specified packages are already installed
2017-11-04 21:59:57,982 [salt.state       ][INFO    ][24390] Completed state [salt_minion_dependency_packages] at time 21:59:57.982099 duration_in_ms=4.437
2017-11-04 21:59:57,984 [salt.state       ][INFO    ][24390] Running state [/etc/salt/minion.d/minion.conf] at time 21:59:57.983809
2017-11-04 21:59:57,984 [salt.state       ][INFO    ][24390] Executing state file.managed for /etc/salt/minion.d/minion.conf
2017-11-04 21:59:58,005 [salt.fileclient  ][INFO    ][24390] Fetching file from saltenv 'base', ** done ** 'salt/files/minion.conf'
2017-11-04 21:59:58,063 [salt.fileclient  ][INFO    ][24390] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-11-04 21:59:58,116 [salt.fileclient  ][INFO    ][24390] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-11-04 21:59:58,166 [salt.state       ][INFO    ][24390] File /etc/salt/minion.d/minion.conf is in the correct state
2017-11-04 21:59:58,166 [salt.state       ][INFO    ][24390] Completed state [/etc/salt/minion.d/minion.conf] at time 21:59:58.166077 duration_in_ms=182.267
2017-11-04 21:59:58,167 [salt.state       ][INFO    ][24390] Running state [/etc/salt/minion.d/_virt.conf] at time 21:59:58.166483
2017-11-04 21:59:58,167 [salt.state       ][INFO    ][24390] Executing state file.managed for /etc/salt/minion.d/_virt.conf
2017-11-04 21:59:58,167 [salt.state       ][INFO    ][24390] File /etc/salt/minion.d/_virt.conf is in the correct state
2017-11-04 21:59:58,168 [salt.state       ][INFO    ][24390] Completed state [/etc/salt/minion.d/_virt.conf] at time 21:59:58.167628 duration_in_ms=1.145
2017-11-04 21:59:58,170 [salt.state       ][INFO    ][24390] Running state [salt-minion] at time 21:59:58.169512
2017-11-04 21:59:58,170 [salt.state       ][INFO    ][24390] Executing state service.running for salt-minion
2017-11-04 21:59:58,170 [salt.loaded.int.module.cmdmod][INFO    ][24390] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2017-11-04 21:59:58,186 [salt.loaded.int.module.cmdmod][INFO    ][24390] Executing command ['systemctl', 'is-active', 'salt-minion.service'] in directory '/root'
2017-11-04 21:59:58,193 [salt.loaded.int.module.cmdmod][INFO    ][24390] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2017-11-04 21:59:58,200 [salt.state       ][INFO    ][24390] The service salt-minion is already running
2017-11-04 21:59:58,201 [salt.state       ][INFO    ][24390] Completed state [salt-minion] at time 21:59:58.200723 duration_in_ms=31.211
2017-11-04 21:59:58,202 [salt.state       ][INFO    ][24390] Running state [/etc/salt/grains.d] at time 21:59:58.202416
2017-11-04 21:59:58,203 [salt.state       ][INFO    ][24390] Executing state file.directory for /etc/salt/grains.d
2017-11-04 21:59:58,203 [salt.state       ][INFO    ][24390] Directory /etc/salt/grains.d is in the correct state
2017-11-04 21:59:58,204 [salt.state       ][INFO    ][24390] Completed state [/etc/salt/grains.d] at time 21:59:58.203468 duration_in_ms=1.052
2017-11-04 21:59:58,204 [salt.state       ][INFO    ][24390] Running state [/etc/salt/grains] at time 21:59:58.204029
2017-11-04 21:59:58,204 [salt.state       ][INFO    ][24390] Executing state file.managed for /etc/salt/grains
2017-11-04 21:59:58,205 [salt.state       ][INFO    ][24390] File /etc/salt/grains exists with proper permissions. No changes made.
2017-11-04 21:59:58,205 [salt.state       ][INFO    ][24390] Completed state [/etc/salt/grains] at time 21:59:58.204770 duration_in_ms=0.741
2017-11-04 21:59:58,205 [salt.state       ][INFO    ][24390] Running state [/etc/salt/grains.d/placeholder] at time 21:59:58.205168
2017-11-04 21:59:58,205 [salt.state       ][INFO    ][24390] Executing state file.managed for /etc/salt/grains.d/placeholder
2017-11-04 21:59:58,206 [salt.state       ][INFO    ][24390] File /etc/salt/grains.d/placeholder exists with proper permissions. No changes made.
2017-11-04 21:59:58,206 [salt.state       ][INFO    ][24390] Completed state [/etc/salt/grains.d/placeholder] at time 21:59:58.205922 duration_in_ms=0.754
2017-11-04 21:59:58,206 [salt.state       ][INFO    ][24390] Running state [/etc/salt/grains.d/sphinx] at time 21:59:58.206279
2017-11-04 21:59:58,207 [salt.state       ][INFO    ][24390] Executing state file.managed for /etc/salt/grains.d/sphinx
2017-11-04 21:59:58,208 [salt.state       ][INFO    ][24390] File changed:
--- 
+++ 
@@ -49,7 +49,6 @@
               - 127.0.0.1
               - 192.168.10.143
               - 192.168.11.251
-              - 192.168.122.1
         system:
           name: System
           param:

2017-11-04 21:59:58,208 [salt.state       ][INFO    ][24390] Completed state [/etc/salt/grains.d/sphinx] at time 21:59:58.208110 duration_in_ms=1.83
2017-11-04 21:59:58,209 [salt.state       ][INFO    ][24390] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 21:59:58.208850
2017-11-04 21:59:58,209 [salt.state       ][INFO    ][24390] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-11-04 21:59:58,209 [salt.state       ][INFO    ][24390] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-11-04 21:59:58,209 [salt.state       ][INFO    ][24390] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 21:59:58.209465 duration_in_ms=0.615
2017-11-04 21:59:58,210 [salt.state       ][INFO    ][24390] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 21:59:58.209624
2017-11-04 21:59:58,210 [salt.state       ][INFO    ][24390] 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-04 21:59:58,210 [salt.loaded.int.module.cmdmod][INFO    ][24390] Executing command 'python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"' in directory '/root'
2017-11-04 21:59:58,288 [salt.state       ][INFO    ][24390] {'pid': 24438, 'retcode': 0, 'stderr': '', 'stdout': ''}
2017-11-04 21:59:58,289 [salt.state       ][INFO    ][24390] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 21:59:58.288498 duration_in_ms=78.874
2017-11-04 21:59:58,289 [salt.state       ][INFO    ][24390] Running state [/etc/salt/grains.d/dns_records] at time 21:59:58.289117
2017-11-04 21:59:58,289 [salt.state       ][INFO    ][24390] Executing state file.managed for /etc/salt/grains.d/dns_records
2017-11-04 21:59:58,290 [salt.state       ][INFO    ][24390] File /etc/salt/grains.d/dns_records is in the correct state
2017-11-04 21:59:58,291 [salt.state       ][INFO    ][24390] Completed state [/etc/salt/grains.d/dns_records] at time 21:59:58.290525 duration_in_ms=1.407
2017-11-04 21:59:58,291 [salt.state       ][INFO    ][24390] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 21:59:58.291370
2017-11-04 21:59:58,292 [salt.state       ][INFO    ][24390] 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-04 21:59:58,292 [salt.state       ][INFO    ][24390] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"
2017-11-04 21:59:58,292 [salt.state       ][INFO    ][24390] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 21:59:58.291963 duration_in_ms=0.593
2017-11-04 21:59:58,292 [salt.state       ][INFO    ][24390] Running state [/etc/salt/grains.d/salt] at time 21:59:58.292323
2017-11-04 21:59:58,293 [salt.state       ][INFO    ][24390] Executing state file.managed for /etc/salt/grains.d/salt
2017-11-04 21:59:58,293 [salt.state       ][INFO    ][24390] File /etc/salt/grains.d/salt is in the correct state
2017-11-04 21:59:58,293 [salt.state       ][INFO    ][24390] Completed state [/etc/salt/grains.d/salt] at time 21:59:58.293447 duration_in_ms=1.124
2017-11-04 21:59:58,294 [salt.state       ][INFO    ][24390] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 21:59:58.294164
2017-11-04 21:59:58,294 [salt.state       ][INFO    ][24390] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2017-11-04 21:59:58,295 [salt.state       ][INFO    ][24390] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2017-11-04 21:59:58,295 [salt.state       ][INFO    ][24390] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 21:59:58.294730 duration_in_ms=0.567
2017-11-04 21:59:58,296 [salt.state       ][INFO    ][24390] Running state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 21:59:58.296327
2017-11-04 21:59:58,297 [salt.state       ][INFO    ][24390] Executing state cmd.wait for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-11-04 21:59:58,297 [salt.state       ][INFO    ][24390] No changes made for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-11-04 21:59:58,297 [salt.state       ][INFO    ][24390] Completed state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 21:59:58.296904 duration_in_ms=0.577
2017-11-04 21:59:58,297 [salt.state       ][INFO    ][24390] Running state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 21:59:58.297089
2017-11-04 21:59:58,297 [salt.state       ][INFO    ][24390] Executing state cmd.mod_watch for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-11-04 21:59:58,299 [salt.loaded.int.module.cmdmod][INFO    ][24390] Executing command 'cat /etc/salt/grains.d/* > /etc/salt/grains' in directory '/root'
2017-11-04 21:59:58,306 [salt.state       ][INFO    ][24390] {'pid': 24440, 'retcode': 0, 'stderr': '', 'stdout': ''}
2017-11-04 21:59:58,306 [salt.state       ][INFO    ][24390] Completed state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 21:59:58.306107 duration_in_ms=9.018
2017-11-04 21:59:58,307 [salt.state       ][INFO    ][24390] Running state [mine.update] at time 21:59:58.306799
2017-11-04 21:59:58,307 [salt.state       ][INFO    ][24390] Executing state module.wait for mine.update
2017-11-04 21:59:58,307 [salt.state       ][INFO    ][24390] No changes made for mine.update
2017-11-04 21:59:58,307 [salt.state       ][INFO    ][24390] Completed state [mine.update] at time 21:59:58.307401 duration_in_ms=0.602
2017-11-04 21:59:58,308 [salt.state       ][INFO    ][24390] Running state [mine.update] at time 21:59:58.307556
2017-11-04 21:59:58,308 [salt.state       ][INFO    ][24390] Executing state module.mod_watch for mine.update
2017-11-04 21:59:58,824 [salt.state       ][INFO    ][24390] {'ret': True}
2017-11-04 21:59:58,824 [salt.state       ][INFO    ][24390] Completed state [mine.update] at time 21:59:58.823948 duration_in_ms=516.391
2017-11-04 21:59:58,824 [salt.state       ][INFO    ][24390] Running state [ca-certificates] at time 21:59:58.824189
2017-11-04 21:59:58,824 [salt.state       ][INFO    ][24390] Executing state pkg.installed for ca-certificates
2017-11-04 21:59:58,828 [salt.state       ][INFO    ][24390] Package ca-certificates is already installed
2017-11-04 21:59:58,829 [salt.state       ][INFO    ][24390] Completed state [ca-certificates] at time 21:59:58.828511 duration_in_ms=4.322
2017-11-04 21:59:58,829 [salt.state       ][INFO    ][24390] Running state [update-ca-certificates] at time 21:59:58.829216
2017-11-04 21:59:58,829 [salt.state       ][INFO    ][24390] Executing state cmd.wait for update-ca-certificates
2017-11-04 21:59:58,830 [salt.state       ][INFO    ][24390] No changes made for update-ca-certificates
2017-11-04 21:59:58,830 [salt.state       ][INFO    ][24390] Completed state [update-ca-certificates] at time 21:59:58.829799 duration_in_ms=0.583
2017-11-04 21:59:58,830 [salt.state       ][INFO    ][24390] Running state [libvirt-dev] at time 21:59:58.829971
2017-11-04 21:59:58,830 [salt.state       ][INFO    ][24390] Executing state pkg.installed for libvirt-dev
2017-11-04 21:59:58,834 [salt.state       ][INFO    ][24390] Package libvirt-dev is already installed
2017-11-04 21:59:58,834 [salt.state       ][INFO    ][24390] Completed state [libvirt-dev] at time 21:59:58.833974 duration_in_ms=4.003
2017-11-04 21:59:58,834 [salt.state       ][INFO    ][24390] Running state [pkg-config] at time 21:59:58.834149
2017-11-04 21:59:58,834 [salt.state       ][INFO    ][24390] Executing state pkg.installed for pkg-config
2017-11-04 21:59:58,838 [salt.state       ][INFO    ][24390] Package pkg-config is already installed
2017-11-04 21:59:58,838 [salt.state       ][INFO    ][24390] Completed state [pkg-config] at time 21:59:58.838101 duration_in_ms=3.953
2017-11-04 21:59:58,838 [salt.state       ][INFO    ][24390] Running state [virtng.init] at time 21:59:58.838292
2017-11-04 21:59:58,838 [salt.state       ][INFO    ][24390] Executing state module.run for virtng.init
2017-11-04 21:59:58,885 [salt.loaded.int.module.cmdmod][INFO    ][24390] Executing command ['git', '--version'] in directory '/root'
2017-11-04 21:59:58,926 [salt.loaded.int.module.cmdmod][INFO    ][24390] Executing command 'virsh list --all --name| grep -E "^mdb03.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-11-04 21:59:58,942 [salt.state       ][INFO    ][24390] unless execution succeeded
2017-11-04 21:59:58,942 [salt.state       ][INFO    ][24390] Completed state [virtng.init] at time 21:59:58.941816 duration_in_ms=103.523
2017-11-04 21:59:58,942 [salt.state       ][INFO    ][24390] Running state [virt.set_autostart] at time 21:59:58.942086
2017-11-04 21:59:58,942 [salt.state       ][INFO    ][24390] Executing state module.run for virt.set_autostart
2017-11-04 21:59:58,945 [salt.loaded.int.module.cmdmod][INFO    ][24390] Executing command 'virsh list --autostart --name| grep -E "^mdb03.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-11-04 21:59:58,960 [salt.state       ][INFO    ][24390] unless execution succeeded
2017-11-04 21:59:58,961 [salt.state       ][INFO    ][24390] Completed state [virt.set_autostart] at time 21:59:58.960580 duration_in_ms=18.494
2017-11-04 21:59:58,961 [salt.state       ][INFO    ][24390] Running state [virtng.init] at time 21:59:58.960840
2017-11-04 21:59:58,961 [salt.state       ][INFO    ][24390] Executing state module.run for virtng.init
2017-11-04 21:59:58,964 [salt.loaded.int.module.cmdmod][INFO    ][24390] Executing command 'virsh list --all --name| grep -E "^dbs03.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-11-04 21:59:58,979 [salt.state       ][INFO    ][24390] unless execution succeeded
2017-11-04 21:59:58,979 [salt.state       ][INFO    ][24390] Completed state [virtng.init] at time 21:59:58.978908 duration_in_ms=18.068
2017-11-04 21:59:58,979 [salt.state       ][INFO    ][24390] Running state [virt.set_autostart] at time 21:59:58.979169
2017-11-04 21:59:58,979 [salt.state       ][INFO    ][24390] Executing state module.run for virt.set_autostart
2017-11-04 21:59:58,982 [salt.loaded.int.module.cmdmod][INFO    ][24390] Executing command 'virsh list --autostart --name| grep -E "^dbs03.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-11-04 21:59:58,999 [salt.state       ][INFO    ][24390] unless execution succeeded
2017-11-04 21:59:58,999 [salt.state       ][INFO    ][24390] Completed state [virt.set_autostart] at time 21:59:58.998764 duration_in_ms=19.595
2017-11-04 21:59:58,999 [salt.state       ][INFO    ][24390] Running state [virtng.init] at time 21:59:58.999033
2017-11-04 21:59:58,999 [salt.state       ][INFO    ][24390] Executing state module.run for virtng.init
2017-11-04 21:59:59,002 [salt.loaded.int.module.cmdmod][INFO    ][24390] Executing command 'virsh list --all --name| grep -E "^prx02.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-11-04 21:59:59,020 [salt.state       ][INFO    ][24390] unless execution succeeded
2017-11-04 21:59:59,020 [salt.state       ][INFO    ][24390] Completed state [virtng.init] at time 21:59:59.019784 duration_in_ms=20.751
2017-11-04 21:59:59,020 [salt.state       ][INFO    ][24390] Running state [virt.set_autostart] at time 21:59:59.020042
2017-11-04 21:59:59,020 [salt.state       ][INFO    ][24390] Executing state module.run for virt.set_autostart
2017-11-04 21:59:59,023 [salt.loaded.int.module.cmdmod][INFO    ][24390] Executing command 'virsh list --autostart --name| grep -E "^prx02.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-11-04 21:59:59,040 [salt.state       ][INFO    ][24390] unless execution succeeded
2017-11-04 21:59:59,040 [salt.state       ][INFO    ][24390] Completed state [virt.set_autostart] at time 21:59:59.040183 duration_in_ms=20.14
2017-11-04 21:59:59,040 [salt.state       ][INFO    ][24390] Running state [virtng.init] at time 21:59:59.040441
2017-11-04 21:59:59,041 [salt.state       ][INFO    ][24390] Executing state module.run for virtng.init
2017-11-04 21:59:59,043 [salt.loaded.int.module.cmdmod][INFO    ][24390] Executing command 'virsh list --all --name| grep -E "^msg03.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-11-04 21:59:59,060 [salt.state       ][INFO    ][24390] unless execution succeeded
2017-11-04 21:59:59,060 [salt.state       ][INFO    ][24390] Completed state [virtng.init] at time 21:59:59.060434 duration_in_ms=19.993
2017-11-04 21:59:59,061 [salt.state       ][INFO    ][24390] Running state [virt.set_autostart] at time 21:59:59.060734
2017-11-04 21:59:59,061 [salt.state       ][INFO    ][24390] Executing state module.run for virt.set_autostart
2017-11-04 21:59:59,064 [salt.loaded.int.module.cmdmod][INFO    ][24390] Executing command 'virsh list --autostart --name| grep -E "^msg03.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-11-04 21:59:59,081 [salt.state       ][INFO    ][24390] unless execution succeeded
2017-11-04 21:59:59,081 [salt.state       ][INFO    ][24390] Completed state [virt.set_autostart] at time 21:59:59.081344 duration_in_ms=20.608
2017-11-04 21:59:59,082 [salt.state       ][INFO    ][24390] Running state [virtng.init] at time 21:59:59.081618
2017-11-04 21:59:59,082 [salt.state       ][INFO    ][24390] Executing state module.run for virtng.init
2017-11-04 21:59:59,084 [salt.loaded.int.module.cmdmod][INFO    ][24390] Executing command 'virsh list --all --name| grep -E "^ctl03.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-11-04 21:59:59,102 [salt.state       ][INFO    ][24390] unless execution succeeded
2017-11-04 21:59:59,102 [salt.state       ][INFO    ][24390] Completed state [virtng.init] at time 21:59:59.102033 duration_in_ms=20.414
2017-11-04 21:59:59,102 [salt.state       ][INFO    ][24390] Running state [virt.set_autostart] at time 21:59:59.102308
2017-11-04 21:59:59,103 [salt.state       ][INFO    ][24390] Executing state module.run for virt.set_autostart
2017-11-04 21:59:59,105 [salt.loaded.int.module.cmdmod][INFO    ][24390] Executing command 'virsh list --autostart --name| grep -E "^ctl03.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-11-04 21:59:59,123 [salt.state       ][INFO    ][24390] unless execution succeeded
2017-11-04 21:59:59,124 [salt.state       ][INFO    ][24390] Completed state [virt.set_autostart] at time 21:59:59.123616 duration_in_ms=21.308
2017-11-04 21:59:59,127 [salt.minion      ][INFO    ][24390] Returning information for job: 20171104215953354135
2017-11-04 22:00:25,911 [salt.minion      ][INFO    ][24259] User sudo_ubuntu Executing command saltutil.sync_all with jid 20171104220025901623
2017-11-04 22:00:25,925 [salt.minion      ][INFO    ][24497] Starting a new job with PID 24497
2017-11-04 22:00:28,192 [salt.state       ][INFO    ][24497] Loading fresh modules for state activity
2017-11-04 22:00:28,215 [salt.state       ][ERROR   ][24497] No contents found in top file
2017-11-04 22:00:28,215 [salt.utils.extmods][INFO    ][24497] Creating module dir '/var/cache/salt/minion/extmods/beacons'
2017-11-04 22:00:28,218 [salt.utils.extmods][INFO    ][24497] Syncing beacons for environment 'base'
2017-11-04 22:00:28,218 [salt.utils.extmods][INFO    ][24497] Loading cache from salt://_beacons, for base)
2017-11-04 22:00:28,219 [salt.fileclient  ][INFO    ][24497] Caching directory '_beacons/' for environment 'base'
2017-11-04 22:00:28,275 [salt.utils.extmods][INFO    ][24497] Syncing modules for environment 'base'
2017-11-04 22:00:28,275 [salt.utils.extmods][INFO    ][24497] Loading cache from salt://_modules, for base)
2017-11-04 22:00:28,275 [salt.fileclient  ][INFO    ][24497] Caching directory '_modules/' for environment 'base'
2017-11-04 22:00:28,326 [salt.fileclient  ][INFO    ][24497] Fetching file from saltenv 'base', ** done ** '_modules/ceph_ng.py'
2017-11-04 22:00:28,333 [salt.fileclient  ][INFO    ][24497] Fetching file from saltenv 'base', ** done ** '_modules/cinderng.py'
2017-11-04 22:00:28,343 [salt.fileclient  ][INFO    ][24497] Fetching file from saltenv 'base', ** done ** '_modules/contrail.py'
2017-11-04 22:00:28,351 [salt.fileclient  ][INFO    ][24497] Fetching file from saltenv 'base', ** done ** '_modules/creds.py'
2017-11-04 22:00:29,045 [salt.fileclient  ][INFO    ][24497] Fetching file from saltenv 'base', ** done ** '_modules/devops_utils.py'
2017-11-04 22:00:30,176 [salt.fileclient  ][INFO    ][24497] Fetching file from saltenv 'base', ** done ** '_modules/encode_json.py'
2017-11-04 22:00:30,187 [salt.fileclient  ][INFO    ][24497] Fetching file from saltenv 'base', ** done ** '_modules/gerrit.py'
2017-11-04 22:00:30,205 [salt.fileclient  ][INFO    ][24497] Fetching file from saltenv 'base', ** done ** '_modules/glanceng.py'
2017-11-04 22:00:30,220 [salt.fileclient  ][INFO    ][24497] Fetching file from saltenv 'base', ** done ** '_modules/heat.py'
2017-11-04 22:00:30,230 [salt.fileclient  ][INFO    ][24497] Fetching file from saltenv 'base', ** done ** '_modules/heka_alarming.py'
2017-11-04 22:00:30,862 [salt.fileclient  ][INFO    ][24497] Fetching file from saltenv 'base', ** done ** '_modules/helm.py'
2017-11-04 22:00:30,872 [salt.fileclient  ][INFO    ][24497] Fetching file from saltenv 'base', ** done ** '_modules/jenkins_common.py'
2017-11-04 22:00:30,888 [salt.fileclient  ][INFO    ][24497] Fetching file from saltenv 'base', ** done ** '_modules/keystone_policy.py'
2017-11-04 22:00:30,911 [salt.fileclient  ][INFO    ][24497] Fetching file from saltenv 'base', ** done ** '_modules/linux_hosts.py'
2017-11-04 22:00:30,929 [salt.fileclient  ][INFO    ][24497] Fetching file from saltenv 'base', ** done ** '_modules/linux_netlink.py'
2017-11-04 22:00:30,962 [salt.fileclient  ][INFO    ][24497] Fetching file from saltenv 'base', ** done ** '_modules/maas.py'
2017-11-04 22:00:30,978 [salt.fileclient  ][INFO    ][24497] Fetching file from saltenv 'base', ** done ** '_modules/maas_client.py'
2017-11-04 22:00:30,996 [salt.fileclient  ][INFO    ][24497] Fetching file from saltenv 'base', ** done ** '_modules/modelutils.py'
2017-11-04 22:00:31,010 [salt.fileclient  ][INFO    ][24497] Fetching file from saltenv 'base', ** done ** '_modules/multipart.py'
2017-11-04 22:00:31,026 [salt.fileclient  ][INFO    ][24497] Fetching file from saltenv 'base', ** done ** '_modules/nagios_alarming.py'
2017-11-04 22:00:31,055 [salt.fileclient  ][INFO    ][24497] Fetching file from saltenv 'base', ** done ** '_modules/neutronng.py'
2017-11-04 22:00:31,070 [salt.fileclient  ][INFO    ][24497] Fetching file from saltenv 'base', ** done ** '_modules/novang.py'
2017-11-04 22:00:31,079 [salt.fileclient  ][INFO    ][24497] Fetching file from saltenv 'base', ** done ** '_modules/reclass.py'
2017-11-04 22:00:31,093 [salt.fileclient  ][INFO    ][24497] Fetching file from saltenv 'base', ** done ** '_modules/rsyslog_util.py'
2017-11-04 22:00:31,106 [salt.fileclient  ][INFO    ][24497] Fetching file from saltenv 'base', ** done ** '_modules/rundeck.py'
2017-11-04 22:00:31,117 [salt.fileclient  ][INFO    ][24497] Fetching file from saltenv 'base', ** done ** '_modules/saltkey.py'
2017-11-04 22:00:31,127 [salt.fileclient  ][INFO    ][24497] Fetching file from saltenv 'base', ** done ** '_modules/saltresource.py'
2017-11-04 22:00:31,139 [salt.fileclient  ][INFO    ][24497] Fetching file from saltenv 'base', ** done ** '_modules/seedng.py'
2017-11-04 22:00:31,167 [salt.fileclient  ][INFO    ][24497] Fetching file from saltenv 'base', ** done ** '_modules/testing/credentials.py'
2017-11-04 22:00:31,184 [salt.fileclient  ][INFO    ][24497] Fetching file from saltenv 'base', ** done ** '_modules/testing/django.py'
2017-11-04 22:00:31,202 [salt.fileclient  ][INFO    ][24497] Fetching file from saltenv 'base', ** done ** '_modules/testing/django_client_proxy.py'
2017-11-04 22:00:31,216 [salt.fileclient  ][INFO    ][24497] Fetching file from saltenv 'base', ** done ** '_modules/utils.py'
2017-11-04 22:00:31,232 [salt.fileclient  ][INFO    ][24497] Fetching file from saltenv 'base', ** done ** '_modules/virtng.py'
2017-11-04 22:00:31,236 [salt.utils.extmods][INFO    ][24497] Copying '/var/cache/salt/minion/files/base/_modules/__init__.py' to '/var/cache/salt/minion/extmods/modules/__init__.py'
2017-11-04 22:00:31,236 [salt.utils.extmods][INFO    ][24497] Copying '/var/cache/salt/minion/files/base/_modules/ceph_ng.py' to '/var/cache/salt/minion/extmods/modules/ceph_ng.py'
2017-11-04 22:00:31,237 [salt.utils.extmods][INFO    ][24497] Copying '/var/cache/salt/minion/files/base/_modules/cinderng.py' to '/var/cache/salt/minion/extmods/modules/cinderng.py'
2017-11-04 22:00:31,237 [salt.utils.extmods][INFO    ][24497] Copying '/var/cache/salt/minion/files/base/_modules/contrail.py' to '/var/cache/salt/minion/extmods/modules/contrail.py'
2017-11-04 22:00:31,237 [salt.utils.extmods][INFO    ][24497] Copying '/var/cache/salt/minion/files/base/_modules/creds.py' to '/var/cache/salt/minion/extmods/modules/creds.py'
2017-11-04 22:00:31,237 [salt.utils.extmods][INFO    ][24497] Copying '/var/cache/salt/minion/files/base/_modules/devops_utils.py' to '/var/cache/salt/minion/extmods/modules/devops_utils.py'
2017-11-04 22:00:31,238 [salt.utils.extmods][INFO    ][24497] Copying '/var/cache/salt/minion/files/base/_modules/encode_json.py' to '/var/cache/salt/minion/extmods/modules/encode_json.py'
2017-11-04 22:00:31,238 [salt.utils.extmods][INFO    ][24497] Copying '/var/cache/salt/minion/files/base/_modules/gerrit.py' to '/var/cache/salt/minion/extmods/modules/gerrit.py'
2017-11-04 22:00:31,238 [salt.utils.extmods][INFO    ][24497] Copying '/var/cache/salt/minion/files/base/_modules/glanceng.py' to '/var/cache/salt/minion/extmods/modules/glanceng.py'
2017-11-04 22:00:31,239 [salt.utils.extmods][INFO    ][24497] Copying '/var/cache/salt/minion/files/base/_modules/heat.py' to '/var/cache/salt/minion/extmods/modules/heat.py'
2017-11-04 22:00:31,239 [salt.utils.extmods][INFO    ][24497] Copying '/var/cache/salt/minion/files/base/_modules/heka_alarming.py' to '/var/cache/salt/minion/extmods/modules/heka_alarming.py'
2017-11-04 22:00:31,239 [salt.utils.extmods][INFO    ][24497] Copying '/var/cache/salt/minion/files/base/_modules/helm.py' to '/var/cache/salt/minion/extmods/modules/helm.py'
2017-11-04 22:00:31,239 [salt.utils.extmods][INFO    ][24497] Copying '/var/cache/salt/minion/files/base/_modules/jenkins_common.py' to '/var/cache/salt/minion/extmods/modules/jenkins_common.py'
2017-11-04 22:00:31,240 [salt.utils.extmods][INFO    ][24497] Copying '/var/cache/salt/minion/files/base/_modules/keystone_policy.py' to '/var/cache/salt/minion/extmods/modules/keystone_policy.py'
2017-11-04 22:00:31,240 [salt.utils.extmods][INFO    ][24497] Copying '/var/cache/salt/minion/files/base/_modules/linux_hosts.py' to '/var/cache/salt/minion/extmods/modules/linux_hosts.py'
2017-11-04 22:00:31,240 [salt.utils.extmods][INFO    ][24497] Copying '/var/cache/salt/minion/files/base/_modules/linux_netlink.py' to '/var/cache/salt/minion/extmods/modules/linux_netlink.py'
2017-11-04 22:00:31,240 [salt.utils.extmods][INFO    ][24497] Copying '/var/cache/salt/minion/files/base/_modules/maas.py' to '/var/cache/salt/minion/extmods/modules/maas.py'
2017-11-04 22:00:31,241 [salt.utils.extmods][INFO    ][24497] Copying '/var/cache/salt/minion/files/base/_modules/maas_client.py' to '/var/cache/salt/minion/extmods/modules/maas_client.py'
2017-11-04 22:00:31,241 [salt.utils.extmods][INFO    ][24497] Copying '/var/cache/salt/minion/files/base/_modules/modelutils.py' to '/var/cache/salt/minion/extmods/modules/modelutils.py'
2017-11-04 22:00:31,241 [salt.utils.extmods][INFO    ][24497] Copying '/var/cache/salt/minion/files/base/_modules/multipart.py' to '/var/cache/salt/minion/extmods/modules/multipart.py'
2017-11-04 22:00:31,241 [salt.utils.extmods][INFO    ][24497] Copying '/var/cache/salt/minion/files/base/_modules/nagios_alarming.py' to '/var/cache/salt/minion/extmods/modules/nagios_alarming.py'
2017-11-04 22:00:31,242 [salt.utils.extmods][INFO    ][24497] Copying '/var/cache/salt/minion/files/base/_modules/neutronng.py' to '/var/cache/salt/minion/extmods/modules/neutronng.py'
2017-11-04 22:00:31,242 [salt.utils.extmods][INFO    ][24497] Copying '/var/cache/salt/minion/files/base/_modules/novang.py' to '/var/cache/salt/minion/extmods/modules/novang.py'
2017-11-04 22:00:31,242 [salt.utils.extmods][INFO    ][24497] Copying '/var/cache/salt/minion/files/base/_modules/reclass.py' to '/var/cache/salt/minion/extmods/modules/reclass.py'
2017-11-04 22:00:31,243 [salt.utils.extmods][INFO    ][24497] Copying '/var/cache/salt/minion/files/base/_modules/rsyslog_util.py' to '/var/cache/salt/minion/extmods/modules/rsyslog_util.py'
2017-11-04 22:00:31,243 [salt.utils.extmods][INFO    ][24497] Copying '/var/cache/salt/minion/files/base/_modules/rundeck.py' to '/var/cache/salt/minion/extmods/modules/rundeck.py'
2017-11-04 22:00:31,243 [salt.utils.extmods][INFO    ][24497] Copying '/var/cache/salt/minion/files/base/_modules/saltkey.py' to '/var/cache/salt/minion/extmods/modules/saltkey.py'
2017-11-04 22:00:31,243 [salt.utils.extmods][INFO    ][24497] Copying '/var/cache/salt/minion/files/base/_modules/saltresource.py' to '/var/cache/salt/minion/extmods/modules/saltresource.py'
2017-11-04 22:00:31,244 [salt.utils.extmods][INFO    ][24497] Copying '/var/cache/salt/minion/files/base/_modules/seedng.py' to '/var/cache/salt/minion/extmods/modules/seedng.py'
2017-11-04 22:00:31,244 [salt.utils.extmods][INFO    ][24497] Copying '/var/cache/salt/minion/files/base/_modules/testing/__init__.py' to '/var/cache/salt/minion/extmods/modules/testing/__init__.py'
2017-11-04 22:00:31,244 [salt.utils.extmods][INFO    ][24497] Copying '/var/cache/salt/minion/files/base/_modules/testing/credentials.py' to '/var/cache/salt/minion/extmods/modules/testing/credentials.py'
2017-11-04 22:00:31,244 [salt.utils.extmods][INFO    ][24497] Copying '/var/cache/salt/minion/files/base/_modules/testing/django.py' to '/var/cache/salt/minion/extmods/modules/testing/django.py'
2017-11-04 22:00:31,245 [salt.utils.extmods][INFO    ][24497] 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-04 22:00:31,245 [salt.utils.extmods][INFO    ][24497] Copying '/var/cache/salt/minion/files/base/_modules/utils.py' to '/var/cache/salt/minion/extmods/modules/utils.py'
2017-11-04 22:00:31,245 [salt.utils.extmods][INFO    ][24497] Copying '/var/cache/salt/minion/files/base/_modules/virtng.py' to '/var/cache/salt/minion/extmods/modules/virtng.py'
2017-11-04 22:00:31,251 [salt.utils.extmods][INFO    ][24497] Syncing states for environment 'base'
2017-11-04 22:00:31,252 [salt.utils.extmods][INFO    ][24497] Loading cache from salt://_states, for base)
2017-11-04 22:00:31,252 [salt.fileclient  ][INFO    ][24497] Caching directory '_states/' for environment 'base'
2017-11-04 22:00:31,311 [salt.fileclient  ][INFO    ][24497] Fetching file from saltenv 'base', ** done ** '_states/cinderng.py'
2017-11-04 22:00:31,334 [salt.fileclient  ][INFO    ][24497] Fetching file from saltenv 'base', ** done ** '_states/contrail.py'
2017-11-04 22:00:31,358 [salt.fileclient  ][INFO    ][24497] Fetching file from saltenv 'base', ** done ** '_states/gerrit.py'
2017-11-04 22:00:31,375 [salt.fileclient  ][INFO    ][24497] Fetching file from saltenv 'base', ** done ** '_states/glanceng.py'
2017-11-04 22:00:31,418 [salt.fileclient  ][INFO    ][24497] Fetching file from saltenv 'base', ** done ** '_states/grafana3_dashboard.py'
2017-11-04 22:00:31,430 [salt.fileclient  ][INFO    ][24497] Fetching file from saltenv 'base', ** done ** '_states/grafana3_datasource.py'
2017-11-04 22:00:31,448 [salt.fileclient  ][INFO    ][24497] Fetching file from saltenv 'base', ** done ** '_states/heat.py'
2017-11-04 22:00:31,466 [salt.fileclient  ][INFO    ][24497] Fetching file from saltenv 'base', ** done ** '_states/helm_release.py'
2017-11-04 22:00:31,481 [salt.fileclient  ][INFO    ][24497] Fetching file from saltenv 'base', ** done ** '_states/jenkins_approval.py'
2017-11-04 22:00:31,501 [salt.fileclient  ][INFO    ][24497] Fetching file from saltenv 'base', ** done ** '_states/jenkins_artifactory.py'
2017-11-04 22:00:31,516 [salt.fileclient  ][INFO    ][24497] Fetching file from saltenv 'base', ** done ** '_states/jenkins_credential.py'
2017-11-04 22:00:31,539 [salt.fileclient  ][INFO    ][24497] Fetching file from saltenv 'base', ** done ** '_states/jenkins_job.py'
2017-11-04 22:00:31,581 [salt.fileclient  ][INFO    ][24497] Fetching file from saltenv 'base', ** done ** '_states/jenkins_lib.py'
2017-11-04 22:00:31,592 [salt.fileclient  ][INFO    ][24497] Fetching file from saltenv 'base', ** done ** '_states/jenkins_node.py'
2017-11-04 22:00:31,626 [salt.fileclient  ][INFO    ][24497] Fetching file from saltenv 'base', ** done ** '_states/jenkins_plugin.py'
2017-11-04 22:00:31,656 [salt.fileclient  ][INFO    ][24497] Fetching file from saltenv 'base', ** done ** '_states/jenkins_security.py'
2017-11-04 22:00:31,672 [salt.fileclient  ][INFO    ][24497] Fetching file from saltenv 'base', ** done ** '_states/jenkins_slack.py'
2017-11-04 22:00:31,684 [salt.fileclient  ][INFO    ][24497] Fetching file from saltenv 'base', ** done ** '_states/jenkins_smtp.py'
2017-11-04 22:00:31,696 [salt.fileclient  ][INFO    ][24497] Fetching file from saltenv 'base', ** done ** '_states/jenkins_theme.py'
2017-11-04 22:00:31,710 [salt.fileclient  ][INFO    ][24497] Fetching file from saltenv 'base', ** done ** '_states/jenkins_user.py'
2017-11-04 22:00:31,720 [salt.fileclient  ][INFO    ][24497] Fetching file from saltenv 'base', ** done ** '_states/jenkins_view.py'
2017-11-04 22:00:31,763 [salt.fileclient  ][INFO    ][24497] Fetching file from saltenv 'base', ** done ** '_states/keystone_policy.py'
2017-11-04 22:00:31,803 [salt.fileclient  ][INFO    ][24497] Fetching file from saltenv 'base', ** done ** '_states/kibana_object.py'
2017-11-04 22:00:31,829 [salt.fileclient  ][INFO    ][24497] Fetching file from saltenv 'base', ** done ** '_states/neutronng.py'
2017-11-04 22:00:31,849 [salt.fileclient  ][INFO    ][24497] Fetching file from saltenv 'base', ** done ** '_states/novang.py'
2017-11-04 22:00:31,865 [salt.fileclient  ][INFO    ][24497] Fetching file from saltenv 'base', ** done ** '_states/reclass.py'
2017-11-04 22:00:31,877 [salt.fileclient  ][INFO    ][24497] Fetching file from saltenv 'base', ** done ** '_states/rundeck_project.py'
2017-11-04 22:00:31,929 [salt.fileclient  ][INFO    ][24497] Fetching file from saltenv 'base', ** done ** '_states/rundeck_scm.py'
2017-11-04 22:00:31,960 [salt.fileclient  ][INFO    ][24497] Fetching file from saltenv 'base', ** done ** '_states/rundeck_secret.py'
2017-11-04 22:00:31,966 [salt.utils.extmods][INFO    ][24497] Copying '/var/cache/salt/minion/files/base/_states/cinderng.py' to '/var/cache/salt/minion/extmods/states/cinderng.py'
2017-11-04 22:00:31,966 [salt.utils.extmods][INFO    ][24497] Copying '/var/cache/salt/minion/files/base/_states/contrail.py' to '/var/cache/salt/minion/extmods/states/contrail.py'
2017-11-04 22:00:31,966 [salt.utils.extmods][INFO    ][24497] Copying '/var/cache/salt/minion/files/base/_states/gerrit.py' to '/var/cache/salt/minion/extmods/states/gerrit.py'
2017-11-04 22:00:31,967 [salt.utils.extmods][INFO    ][24497] Copying '/var/cache/salt/minion/files/base/_states/glanceng.py' to '/var/cache/salt/minion/extmods/states/glanceng.py'
2017-11-04 22:00:31,967 [salt.utils.extmods][INFO    ][24497] Copying '/var/cache/salt/minion/files/base/_states/grafana3_dashboard.py' to '/var/cache/salt/minion/extmods/states/grafana3_dashboard.py'
2017-11-04 22:00:31,967 [salt.utils.extmods][INFO    ][24497] Copying '/var/cache/salt/minion/files/base/_states/grafana3_datasource.py' to '/var/cache/salt/minion/extmods/states/grafana3_datasource.py'
2017-11-04 22:00:31,967 [salt.utils.extmods][INFO    ][24497] Copying '/var/cache/salt/minion/files/base/_states/heat.py' to '/var/cache/salt/minion/extmods/states/heat.py'
2017-11-04 22:00:31,968 [salt.utils.extmods][INFO    ][24497] Copying '/var/cache/salt/minion/files/base/_states/helm_release.py' to '/var/cache/salt/minion/extmods/states/helm_release.py'
2017-11-04 22:00:31,968 [salt.utils.extmods][INFO    ][24497] Copying '/var/cache/salt/minion/files/base/_states/jenkins_approval.py' to '/var/cache/salt/minion/extmods/states/jenkins_approval.py'
2017-11-04 22:00:31,968 [salt.utils.extmods][INFO    ][24497] Copying '/var/cache/salt/minion/files/base/_states/jenkins_artifactory.py' to '/var/cache/salt/minion/extmods/states/jenkins_artifactory.py'
2017-11-04 22:00:31,968 [salt.utils.extmods][INFO    ][24497] Copying '/var/cache/salt/minion/files/base/_states/jenkins_credential.py' to '/var/cache/salt/minion/extmods/states/jenkins_credential.py'
2017-11-04 22:00:31,969 [salt.utils.extmods][INFO    ][24497] Copying '/var/cache/salt/minion/files/base/_states/jenkins_job.py' to '/var/cache/salt/minion/extmods/states/jenkins_job.py'
2017-11-04 22:00:31,969 [salt.utils.extmods][INFO    ][24497] Copying '/var/cache/salt/minion/files/base/_states/jenkins_lib.py' to '/var/cache/salt/minion/extmods/states/jenkins_lib.py'
2017-11-04 22:00:31,969 [salt.utils.extmods][INFO    ][24497] Copying '/var/cache/salt/minion/files/base/_states/jenkins_node.py' to '/var/cache/salt/minion/extmods/states/jenkins_node.py'
2017-11-04 22:00:31,970 [salt.utils.extmods][INFO    ][24497] Copying '/var/cache/salt/minion/files/base/_states/jenkins_plugin.py' to '/var/cache/salt/minion/extmods/states/jenkins_plugin.py'
2017-11-04 22:00:31,970 [salt.utils.extmods][INFO    ][24497] Copying '/var/cache/salt/minion/files/base/_states/jenkins_security.py' to '/var/cache/salt/minion/extmods/states/jenkins_security.py'
2017-11-04 22:00:31,971 [salt.utils.extmods][INFO    ][24497] Copying '/var/cache/salt/minion/files/base/_states/jenkins_slack.py' to '/var/cache/salt/minion/extmods/states/jenkins_slack.py'
2017-11-04 22:00:31,971 [salt.utils.extmods][INFO    ][24497] Copying '/var/cache/salt/minion/files/base/_states/jenkins_smtp.py' to '/var/cache/salt/minion/extmods/states/jenkins_smtp.py'
2017-11-04 22:00:31,971 [salt.utils.extmods][INFO    ][24497] Copying '/var/cache/salt/minion/files/base/_states/jenkins_theme.py' to '/var/cache/salt/minion/extmods/states/jenkins_theme.py'
2017-11-04 22:00:31,971 [salt.utils.extmods][INFO    ][24497] Copying '/var/cache/salt/minion/files/base/_states/jenkins_user.py' to '/var/cache/salt/minion/extmods/states/jenkins_user.py'
2017-11-04 22:00:31,972 [salt.utils.extmods][INFO    ][24497] Copying '/var/cache/salt/minion/files/base/_states/jenkins_view.py' to '/var/cache/salt/minion/extmods/states/jenkins_view.py'
2017-11-04 22:00:31,972 [salt.utils.extmods][INFO    ][24497] Copying '/var/cache/salt/minion/files/base/_states/keystone_policy.py' to '/var/cache/salt/minion/extmods/states/keystone_policy.py'
2017-11-04 22:00:31,972 [salt.utils.extmods][INFO    ][24497] Copying '/var/cache/salt/minion/files/base/_states/kibana_object.py' to '/var/cache/salt/minion/extmods/states/kibana_object.py'
2017-11-04 22:00:31,972 [salt.utils.extmods][INFO    ][24497] Copying '/var/cache/salt/minion/files/base/_states/maas_cluster.py' to '/var/cache/salt/minion/extmods/states/maas_cluster.py'
2017-11-04 22:00:31,973 [salt.utils.extmods][INFO    ][24497] Copying '/var/cache/salt/minion/files/base/_states/neutronng.py' to '/var/cache/salt/minion/extmods/states/neutronng.py'
2017-11-04 22:00:31,973 [salt.utils.extmods][INFO    ][24497] Copying '/var/cache/salt/minion/files/base/_states/novang.py' to '/var/cache/salt/minion/extmods/states/novang.py'
2017-11-04 22:00:31,973 [salt.utils.extmods][INFO    ][24497] Copying '/var/cache/salt/minion/files/base/_states/reclass.py' to '/var/cache/salt/minion/extmods/states/reclass.py'
2017-11-04 22:00:31,973 [salt.utils.extmods][INFO    ][24497] Copying '/var/cache/salt/minion/files/base/_states/rundeck_project.py' to '/var/cache/salt/minion/extmods/states/rundeck_project.py'
2017-11-04 22:00:31,974 [salt.utils.extmods][INFO    ][24497] Copying '/var/cache/salt/minion/files/base/_states/rundeck_scm.py' to '/var/cache/salt/minion/extmods/states/rundeck_scm.py'
2017-11-04 22:00:31,974 [salt.utils.extmods][INFO    ][24497] Copying '/var/cache/salt/minion/files/base/_states/rundeck_secret.py' to '/var/cache/salt/minion/extmods/states/rundeck_secret.py'
2017-11-04 22:00:31,977 [salt.utils.extmods][INFO    ][24497] Creating module dir '/var/cache/salt/minion/extmods/sdb'
2017-11-04 22:00:31,980 [salt.utils.extmods][INFO    ][24497] Syncing sdb for environment 'base'
2017-11-04 22:00:31,980 [salt.utils.extmods][INFO    ][24497] Loading cache from salt://_sdb, for base)
2017-11-04 22:00:31,981 [salt.fileclient  ][INFO    ][24497] Caching directory '_sdb/' for environment 'base'
2017-11-04 22:00:32,061 [salt.utils.extmods][INFO    ][24497] Syncing grains for environment 'base'
2017-11-04 22:00:32,062 [salt.utils.extmods][INFO    ][24497] Loading cache from salt://_grains, for base)
2017-11-04 22:00:32,062 [salt.fileclient  ][INFO    ][24497] Caching directory '_grains/' for environment 'base'
2017-11-04 22:00:32,123 [salt.fileclient  ][INFO    ][24497] Fetching file from saltenv 'base', ** done ** '_grains/ceilometer_policy.py'
2017-11-04 22:00:32,154 [salt.fileclient  ][INFO    ][24497] Fetching file from saltenv 'base', ** done ** '_grains/ceph.py'
2017-11-04 22:00:32,186 [salt.fileclient  ][INFO    ][24497] Fetching file from saltenv 'base', ** done ** '_grains/cinder_policy.py'
2017-11-04 22:00:32,203 [salt.fileclient  ][INFO    ][24497] Fetching file from saltenv 'base', ** done ** '_grains/docker_swarm.py'
2017-11-04 22:00:32,217 [salt.fileclient  ][INFO    ][24497] Fetching file from saltenv 'base', ** done ** '_grains/glance_policy.py'
2017-11-04 22:00:32,241 [salt.fileclient  ][INFO    ][24497] Fetching file from saltenv 'base', ** done ** '_grains/heat_policy.py'
2017-11-04 22:00:32,255 [salt.fileclient  ][INFO    ][24497] Fetching file from saltenv 'base', ** done ** '_grains/jenkins_plugins.py'
2017-11-04 22:00:32,272 [salt.fileclient  ][INFO    ][24497] Fetching file from saltenv 'base', ** done ** '_grains/keystone_policy.py'
2017-11-04 22:00:32,296 [salt.fileclient  ][INFO    ][24497] Fetching file from saltenv 'base', ** done ** '_grains/kubernetes.py'
2017-11-04 22:00:32,305 [salt.fileclient  ][INFO    ][24497] Fetching file from saltenv 'base', ** done ** '_grains/neutron_policy.py'
2017-11-04 22:00:32,316 [salt.fileclient  ][INFO    ][24497] Fetching file from saltenv 'base', ** done ** '_grains/nova_policy.py'
2017-11-04 22:00:32,331 [salt.fileclient  ][INFO    ][24497] Fetching file from saltenv 'base', ** done ** '_grains/ssh_fingerprints.py'
2017-11-04 22:00:32,335 [salt.utils.extmods][INFO    ][24497] Copying '/var/cache/salt/minion/files/base/_grains/ceilometer_policy.py' to '/var/cache/salt/minion/extmods/grains/ceilometer_policy.py'
2017-11-04 22:00:32,335 [salt.utils.extmods][INFO    ][24497] Copying '/var/cache/salt/minion/files/base/_grains/ceph.py' to '/var/cache/salt/minion/extmods/grains/ceph.py'
2017-11-04 22:00:32,336 [salt.utils.extmods][INFO    ][24497] Copying '/var/cache/salt/minion/files/base/_grains/cinder_policy.py' to '/var/cache/salt/minion/extmods/grains/cinder_policy.py'
2017-11-04 22:00:32,336 [salt.utils.extmods][INFO    ][24497] Copying '/var/cache/salt/minion/files/base/_grains/docker_swarm.py' to '/var/cache/salt/minion/extmods/grains/docker_swarm.py'
2017-11-04 22:00:32,336 [salt.utils.extmods][INFO    ][24497] Copying '/var/cache/salt/minion/files/base/_grains/glance_policy.py' to '/var/cache/salt/minion/extmods/grains/glance_policy.py'
2017-11-04 22:00:32,336 [salt.utils.extmods][INFO    ][24497] Copying '/var/cache/salt/minion/files/base/_grains/heat_policy.py' to '/var/cache/salt/minion/extmods/grains/heat_policy.py'
2017-11-04 22:00:32,336 [salt.utils.extmods][INFO    ][24497] Copying '/var/cache/salt/minion/files/base/_grains/jenkins_plugins.py' to '/var/cache/salt/minion/extmods/grains/jenkins_plugins.py'
2017-11-04 22:00:32,337 [salt.utils.extmods][INFO    ][24497] Copying '/var/cache/salt/minion/files/base/_grains/keystone_policy.py' to '/var/cache/salt/minion/extmods/grains/keystone_policy.py'
2017-11-04 22:00:32,337 [salt.utils.extmods][INFO    ][24497] Copying '/var/cache/salt/minion/files/base/_grains/kubernetes.py' to '/var/cache/salt/minion/extmods/grains/kubernetes.py'
2017-11-04 22:00:32,337 [salt.utils.extmods][INFO    ][24497] Copying '/var/cache/salt/minion/files/base/_grains/neutron_policy.py' to '/var/cache/salt/minion/extmods/grains/neutron_policy.py'
2017-11-04 22:00:32,337 [salt.utils.extmods][INFO    ][24497] Copying '/var/cache/salt/minion/files/base/_grains/nova_policy.py' to '/var/cache/salt/minion/extmods/grains/nova_policy.py'
2017-11-04 22:00:32,338 [salt.utils.extmods][INFO    ][24497] Copying '/var/cache/salt/minion/files/base/_grains/ssh_fingerprints.py' to '/var/cache/salt/minion/extmods/grains/ssh_fingerprints.py'
2017-11-04 22:00:32,339 [salt.utils.extmods][INFO    ][24497] Creating module dir '/var/cache/salt/minion/extmods/renderers'
2017-11-04 22:00:32,341 [salt.utils.extmods][INFO    ][24497] Syncing renderers for environment 'base'
2017-11-04 22:00:32,342 [salt.utils.extmods][INFO    ][24497] Loading cache from salt://_renderers, for base)
2017-11-04 22:00:32,342 [salt.fileclient  ][INFO    ][24497] Caching directory '_renderers/' for environment 'base'
2017-11-04 22:00:32,386 [salt.utils.extmods][INFO    ][24497] Creating module dir '/var/cache/salt/minion/extmods/returners'
2017-11-04 22:00:32,388 [salt.utils.extmods][INFO    ][24497] Syncing returners for environment 'base'
2017-11-04 22:00:32,388 [salt.utils.extmods][INFO    ][24497] Loading cache from salt://_returners, for base)
2017-11-04 22:00:32,389 [salt.fileclient  ][INFO    ][24497] Caching directory '_returners/' for environment 'base'
2017-11-04 22:00:32,439 [salt.utils.extmods][INFO    ][24497] Creating module dir '/var/cache/salt/minion/extmods/output'
2017-11-04 22:00:32,442 [salt.utils.extmods][INFO    ][24497] Syncing output for environment 'base'
2017-11-04 22:00:32,442 [salt.utils.extmods][INFO    ][24497] Loading cache from salt://_output, for base)
2017-11-04 22:00:32,443 [salt.fileclient  ][INFO    ][24497] Caching directory '_output/' for environment 'base'
2017-11-04 22:00:32,490 [salt.utils.extmods][INFO    ][24497] Creating module dir '/var/cache/salt/minion/extmods/utils'
2017-11-04 22:00:32,492 [salt.utils.extmods][INFO    ][24497] Syncing utils for environment 'base'
2017-11-04 22:00:32,493 [salt.utils.extmods][INFO    ][24497] Loading cache from salt://_utils, for base)
2017-11-04 22:00:32,493 [salt.fileclient  ][INFO    ][24497] Caching directory '_utils/' for environment 'base'
2017-11-04 22:00:32,532 [salt.utils.extmods][INFO    ][24497] Creating module dir '/var/cache/salt/minion/extmods/log_handlers'
2017-11-04 22:00:32,534 [salt.utils.extmods][INFO    ][24497] Syncing log_handlers for environment 'base'
2017-11-04 22:00:32,535 [salt.utils.extmods][INFO    ][24497] Loading cache from salt://_log_handlers, for base)
2017-11-04 22:00:32,535 [salt.fileclient  ][INFO    ][24497] Caching directory '_log_handlers/' for environment 'base'
2017-11-04 22:00:32,587 [salt.utils.extmods][INFO    ][24497] Creating module dir '/var/cache/salt/minion/extmods/proxy'
2017-11-04 22:00:32,590 [salt.utils.extmods][INFO    ][24497] Syncing proxy for environment 'base'
2017-11-04 22:00:32,590 [salt.utils.extmods][INFO    ][24497] Loading cache from salt://_proxy, for base)
2017-11-04 22:00:32,590 [salt.fileclient  ][INFO    ][24497] Caching directory '_proxy/' for environment 'base'
2017-11-04 22:00:32,655 [salt.utils.extmods][INFO    ][24497] Creating module dir '/var/cache/salt/minion/extmods/engines'
2017-11-04 22:00:32,658 [salt.utils.extmods][INFO    ][24497] Syncing engines for environment 'base'
2017-11-04 22:00:32,658 [salt.utils.extmods][INFO    ][24497] Loading cache from salt://_engines, for base)
2017-11-04 22:00:32,658 [salt.fileclient  ][INFO    ][24497] Caching directory '_engines/' for environment 'base'
2017-11-04 22:00:32,695 [salt.minion      ][INFO    ][24497] Returning information for job: 20171104220025901623
2017-11-04 22:00:33,358 [salt.transport.ipc][ERROR   ][24259] Exception occurred while handling stream: [Errno 0] Success
2017-11-04 22:03:27,038 [salt.minion      ][INFO    ][24259] User sudo_ubuntu Executing command test.ping with jid 20171104220327032213
2017-11-04 22:03:27,051 [salt.minion      ][INFO    ][24636] Starting a new job with PID 24636
2017-11-04 22:03:27,085 [salt.minion      ][INFO    ][24636] Returning information for job: 20171104220327032213
2017-11-04 22:05:19,766 [salt.minion      ][INFO    ][24259] User sudo_ubuntu Executing command state.sls with jid 20171104220519759141
2017-11-04 22:05:19,778 [salt.minion      ][INFO    ][24660] Starting a new job with PID 24660
2017-11-04 22:05:20,327 [salt.state       ][INFO    ][24660] Loading fresh modules for state activity
2017-11-04 22:05:20,357 [salt.fileclient  ][INFO    ][24660] Fetching file from saltenv 'base', ** done ** 'keepalived/init.sls'
2017-11-04 22:05:20,405 [salt.fileclient  ][INFO    ][24660] Fetching file from saltenv 'base', ** done ** 'keepalived/cluster.sls'
2017-11-04 22:05:20,433 [salt.fileclient  ][INFO    ][24660] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-11-04 22:05:20,765 [salt.state       ][INFO    ][24660] Running state [lsof] at time 22:05:20.764702
2017-11-04 22:05:20,765 [salt.state       ][INFO    ][24660] Executing state pkg.installed for lsof
2017-11-04 22:05:20,765 [salt.loaded.int.module.cmdmod][INFO    ][24660] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-04 22:05:20,993 [salt.state       ][INFO    ][24660] Package lsof is already installed
2017-11-04 22:05:20,993 [salt.state       ][INFO    ][24660] Completed state [lsof] at time 22:05:20.993399 duration_in_ms=228.697
2017-11-04 22:05:20,994 [salt.state       ][INFO    ][24660] Running state [keepalived] at time 22:05:20.993675
2017-11-04 22:05:20,994 [salt.state       ][INFO    ][24660] Executing state pkg.installed for keepalived
2017-11-04 22:05:21,011 [salt.loaded.int.module.cmdmod][INFO    ][24660] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-11-04 22:05:22,420 [salt.loaded.int.module.cmdmod][INFO    ][24660] 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-04 22:05:25,073 [salt.loaded.int.module.cmdmod][INFO    ][24660] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-04 22:05:25,101 [salt.state       ][INFO    ][24660] 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-04 22:05:25,111 [salt.state       ][INFO    ][24660] Loading fresh modules for state activity
2017-11-04 22:05:25,127 [salt.state       ][INFO    ][24660] Completed state [keepalived] at time 22:05:25.127037 duration_in_ms=4133.361
2017-11-04 22:05:25,129 [salt.state       ][INFO    ][24660] Running state [/etc/keepalived/keepalived.conf] at time 22:05:25.129374
2017-11-04 22:05:25,130 [salt.state       ][INFO    ][24660] Executing state file.managed for /etc/keepalived/keepalived.conf
2017-11-04 22:05:25,159 [salt.fileclient  ][INFO    ][24660] Fetching file from saltenv 'base', ** done ** 'keepalived/files/keepalived.conf'
2017-11-04 22:05:25,202 [salt.fileclient  ][INFO    ][24660] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-11-04 22:05:25,210 [salt.state       ][INFO    ][24660] File changed:
New file
2017-11-04 22:05:25,211 [salt.state       ][INFO    ][24660] Completed state [/etc/keepalived/keepalived.conf] at time 22:05:25.210590 duration_in_ms=81.215
2017-11-04 22:05:25,280 [salt.state       ][INFO    ][24660] Running state [keepalived] at time 22:05:25.279566
2017-11-04 22:05:25,280 [salt.state       ][INFO    ][24660] Executing state service.running for keepalived
2017-11-04 22:05:25,282 [salt.loaded.int.module.cmdmod][INFO    ][24660] Executing command ['systemctl', 'status', 'keepalived.service', '-n', '0'] in directory '/root'
2017-11-04 22:05:25,291 [salt.loaded.int.module.cmdmod][INFO    ][24660] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2017-11-04 22:05:25,299 [salt.loaded.int.module.cmdmod][INFO    ][24660] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-11-04 22:05:25,307 [salt.loaded.int.module.cmdmod][INFO    ][24660] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-11-04 22:05:25,315 [salt.loaded.int.module.cmdmod][INFO    ][24660] Executing command ['systemd-run', '--scope', 'systemctl', 'start', 'keepalived.service'] in directory '/root'
2017-11-04 22:05:25,348 [salt.loaded.int.module.cmdmod][INFO    ][24660] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2017-11-04 22:05:25,357 [salt.loaded.int.module.cmdmod][INFO    ][24660] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-11-04 22:05:25,364 [salt.loaded.int.module.cmdmod][INFO    ][24660] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-11-04 22:05:25,370 [salt.state       ][INFO    ][24660] {'keepalived': True}
2017-11-04 22:05:25,371 [salt.state       ][INFO    ][24660] Completed state [keepalived] at time 22:05:25.370532 duration_in_ms=90.967
2017-11-04 22:05:25,371 [salt.minion      ][INFO    ][24660] Returning information for job: 20171104220519759141
2017-11-04 22:05:33,428 [salt.minion      ][INFO    ][24259] User sudo_ubuntu Executing command pillar.get with jid 20171104220533422418
2017-11-04 22:05:33,441 [salt.minion      ][INFO    ][26208] Starting a new job with PID 26208
2017-11-04 22:05:33,445 [salt.minion      ][INFO    ][26208] Returning information for job: 20171104220533422418
2017-11-04 22:10:08,859 [salt.minion      ][INFO    ][24259] User sudo_ubuntu Executing command state.sls with jid 20171104221008853407
2017-11-04 22:10:08,871 [salt.minion      ][INFO    ][26303] Starting a new job with PID 26303
2017-11-04 22:10:11,466 [salt.state       ][INFO    ][26303] Loading fresh modules for state activity
2017-11-04 22:10:11,491 [salt.fileclient  ][INFO    ][26303] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-11-04 22:10:11,516 [salt.fileclient  ][INFO    ][26303] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-11-04 22:10:11,813 [salt.state       ][INFO    ][26303] Running state [attr] at time 22:10:11.813250
2017-11-04 22:10:11,814 [salt.state       ][INFO    ][26303] Executing state pkg.installed for attr
2017-11-04 22:10:11,814 [salt.loaded.int.module.cmdmod][INFO    ][26303] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-04 22:10:12,079 [salt.loaded.int.module.cmdmod][INFO    ][26303] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-11-04 22:10:13,910 [salt.loaded.int.module.cmdmod][INFO    ][26303] 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-04 22:10:15,260 [salt.loaded.int.module.cmdmod][INFO    ][26303] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-04 22:10:15,289 [salt.state       ][INFO    ][26303] Made the following changes:
'attr' changed from 'absent' to '1:2.4.47-2'

2017-11-04 22:10:15,299 [salt.state       ][INFO    ][26303] Loading fresh modules for state activity
2017-11-04 22:10:15,315 [salt.state       ][INFO    ][26303] Completed state [attr] at time 22:10:15.314980 duration_in_ms=3501.73
2017-11-04 22:10:15,321 [salt.state       ][INFO    ][26303] Running state [glusterfs-server] at time 22:10:15.320977
2017-11-04 22:10:15,321 [salt.state       ][INFO    ][26303] Executing state pkg.installed for glusterfs-server
2017-11-04 22:10:15,537 [salt.loaded.int.module.cmdmod][INFO    ][26303] 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-04 22:10:18,952 [salt.minion      ][INFO    ][24259] User sudo_ubuntu Executing command saltutil.find_job with jid 20171104221018944888
2017-11-04 22:10:18,964 [salt.minion      ][INFO    ][30090] Starting a new job with PID 30090
2017-11-04 22:10:18,975 [salt.minion      ][INFO    ][30090] Returning information for job: 20171104221018944888
2017-11-04 22:10:21,863 [salt.loaded.int.module.cmdmod][INFO    ][26303] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-04 22:10:21,892 [salt.state       ][INFO    ][26303] 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-04 22:10:21,902 [salt.state       ][INFO    ][26303] Loading fresh modules for state activity
2017-11-04 22:10:21,919 [salt.state       ][INFO    ][26303] Completed state [glusterfs-server] at time 22:10:21.918553 duration_in_ms=6597.585
2017-11-04 22:10:21,924 [salt.state       ][INFO    ][26303] Running state [bc] at time 22:10:21.924094
2017-11-04 22:10:21,924 [salt.state       ][INFO    ][26303] Executing state pkg.installed for bc
2017-11-04 22:10:22,209 [salt.loaded.int.module.cmdmod][INFO    ][26303] 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-04 22:10:23,581 [salt.loaded.int.module.cmdmod][INFO    ][26303] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-04 22:10:23,610 [salt.state       ][INFO    ][26303] Made the following changes:
'bc' changed from 'absent' to '1.06.95-9build1'

2017-11-04 22:10:23,619 [salt.state       ][INFO    ][26303] Loading fresh modules for state activity
2017-11-04 22:10:23,637 [salt.state       ][INFO    ][26303] Completed state [bc] at time 22:10:23.637165 duration_in_ms=1713.07
2017-11-04 22:10:23,707 [salt.state       ][INFO    ][26303] Running state [glusterfs-server] at time 22:10:23.706558
2017-11-04 22:10:23,707 [salt.state       ][INFO    ][26303] Executing state service.running for glusterfs-server
2017-11-04 22:10:23,708 [salt.loaded.int.module.cmdmod][INFO    ][26303] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-11-04 22:10:23,718 [salt.loaded.int.module.cmdmod][INFO    ][26303] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-11-04 22:10:23,726 [salt.loaded.int.module.cmdmod][INFO    ][26303] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-11-04 22:10:23,735 [salt.state       ][INFO    ][26303] The service glusterfs-server is already running
2017-11-04 22:10:23,735 [salt.state       ][INFO    ][26303] Completed state [glusterfs-server] at time 22:10:23.735377 duration_in_ms=28.818
2017-11-04 22:10:23,737 [salt.state       ][INFO    ][26303] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 22:10:23.736828
2017-11-04 22:10:23,737 [salt.state       ][INFO    ][26303] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-11-04 22:10:23,742 [salt.state       ][INFO    ][26303] File changed:
New file
2017-11-04 22:10:23,742 [salt.state       ][INFO    ][26303] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 22:10:23.742312 duration_in_ms=5.484
2017-11-04 22:10:23,743 [salt.state       ][INFO    ][26303] Running state [/srv/glusterfs/glance] at time 22:10:23.742493
2017-11-04 22:10:23,743 [salt.state       ][INFO    ][26303] Executing state file.directory for /srv/glusterfs/glance
2017-11-04 22:10:23,743 [salt.state       ][INFO    ][26303] {'/srv/glusterfs/glance': 'New Dir'}
2017-11-04 22:10:23,743 [salt.state       ][INFO    ][26303] Completed state [/srv/glusterfs/glance] at time 22:10:23.743424 duration_in_ms=0.93
2017-11-04 22:10:23,744 [salt.state       ][INFO    ][26303] Running state [/srv/glusterfs/keystone-keys] at time 22:10:23.743587
2017-11-04 22:10:23,744 [salt.state       ][INFO    ][26303] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-11-04 22:10:23,744 [salt.state       ][INFO    ][26303] {'/srv/glusterfs/keystone-keys': 'New Dir'}
2017-11-04 22:10:23,744 [salt.state       ][INFO    ][26303] Completed state [/srv/glusterfs/keystone-keys] at time 22:10:23.744309 duration_in_ms=0.723
2017-11-04 22:10:23,744 [salt.state       ][INFO    ][26303] Running state [/srv/glusterfs/nova_instances] at time 22:10:23.744471
2017-11-04 22:10:23,745 [salt.state       ][INFO    ][26303] Executing state file.directory for /srv/glusterfs/nova_instances
2017-11-04 22:10:23,745 [salt.state       ][INFO    ][26303] {'/srv/glusterfs/nova_instances': 'New Dir'}
2017-11-04 22:10:23,745 [salt.state       ][INFO    ][26303] Completed state [/srv/glusterfs/nova_instances] at time 22:10:23.745287 duration_in_ms=0.817
2017-11-04 22:10:23,745 [salt.state       ][INFO    ][26303] Running state [/srv/glusterfs/keystone-credential-keys] at time 22:10:23.745467
2017-11-04 22:10:23,746 [salt.state       ][INFO    ][26303] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-11-04 22:10:23,746 [salt.state       ][INFO    ][26303] {'/srv/glusterfs/keystone-credential-keys': 'New Dir'}
2017-11-04 22:10:23,746 [salt.state       ][INFO    ][26303] Completed state [/srv/glusterfs/keystone-credential-keys] at time 22:10:23.746188 duration_in_ms=0.722
2017-11-04 22:10:23,747 [salt.minion      ][INFO    ][26303] Returning information for job: 20171104221008853407
2017-11-04 22:10:31,448 [salt.minion      ][INFO    ][24259] User sudo_ubuntu Executing command test.ping with jid 20171104221031443161
2017-11-04 22:10:31,459 [salt.minion      ][INFO    ][31029] Starting a new job with PID 31029
2017-11-04 22:10:31,493 [salt.minion      ][INFO    ][31029] Returning information for job: 20171104221031443161
2017-11-04 22:10:59,256 [salt.minion      ][INFO    ][24259] User sudo_ubuntu Executing command state.sls with jid 20171104221059244621
2017-11-04 22:10:59,269 [salt.minion      ][INFO    ][31243] Starting a new job with PID 31243
2017-11-04 22:11:01,353 [salt.state       ][INFO    ][31243] Loading fresh modules for state activity
2017-11-04 22:11:01,380 [salt.fileclient  ][INFO    ][31243] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/setup.sls'
2017-11-04 22:11:01,424 [salt.fileclient  ][INFO    ][31243] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-11-04 22:11:01,502 [salt.fileclient  ][INFO    ][31243] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-11-04 22:11:01,526 [salt.fileclient  ][INFO    ][31243] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-11-04 22:11:01,821 [salt.state       ][INFO    ][31243] Running state [attr] at time 22:11:01.820906
2017-11-04 22:11:01,821 [salt.state       ][INFO    ][31243] Executing state pkg.installed for attr
2017-11-04 22:11:01,822 [salt.loaded.int.module.cmdmod][INFO    ][31243] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-04 22:11:02,061 [salt.state       ][INFO    ][31243] Package attr is already installed
2017-11-04 22:11:02,061 [salt.state       ][INFO    ][31243] Completed state [attr] at time 22:11:02.061097 duration_in_ms=240.191
2017-11-04 22:11:02,061 [salt.state       ][INFO    ][31243] Running state [glusterfs-server] at time 22:11:02.061369
2017-11-04 22:11:02,062 [salt.state       ][INFO    ][31243] Executing state pkg.installed for glusterfs-server
2017-11-04 22:11:02,065 [salt.state       ][INFO    ][31243] Package glusterfs-server is already installed
2017-11-04 22:11:02,066 [salt.state       ][INFO    ][31243] Completed state [glusterfs-server] at time 22:11:02.065489 duration_in_ms=4.119
2017-11-04 22:11:02,066 [salt.state       ][INFO    ][31243] Running state [bc] at time 22:11:02.065690
2017-11-04 22:11:02,066 [salt.state       ][INFO    ][31243] Executing state pkg.installed for bc
2017-11-04 22:11:02,070 [salt.state       ][INFO    ][31243] Package bc is already installed
2017-11-04 22:11:02,070 [salt.state       ][INFO    ][31243] Completed state [bc] at time 22:11:02.069662 duration_in_ms=3.972
2017-11-04 22:11:02,071 [salt.state       ][INFO    ][31243] Running state [glusterfs-server] at time 22:11:02.070664
2017-11-04 22:11:02,071 [salt.state       ][INFO    ][31243] Executing state service.running for glusterfs-server
2017-11-04 22:11:02,071 [salt.loaded.int.module.cmdmod][INFO    ][31243] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-11-04 22:11:02,080 [salt.loaded.int.module.cmdmod][INFO    ][31243] Executing command ['systemctl', '--system', 'daemon-reload'] in directory '/root'
2017-11-04 22:11:02,129 [salt.loaded.int.module.cmdmod][INFO    ][31243] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-11-04 22:11:02,142 [salt.loaded.int.module.cmdmod][INFO    ][31243] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-11-04 22:11:02,148 [salt.loaded.int.module.cmdmod][INFO    ][31243] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-11-04 22:11:02,155 [salt.state       ][INFO    ][31243] The service glusterfs-server is already running
2017-11-04 22:11:02,155 [salt.state       ][INFO    ][31243] Completed state [glusterfs-server] at time 22:11:02.155126 duration_in_ms=84.462
2017-11-04 22:11:02,157 [salt.state       ][INFO    ][31243] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 22:11:02.156598
2017-11-04 22:11:02,157 [salt.state       ][INFO    ][31243] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-11-04 22:11:02,159 [salt.state       ][INFO    ][31243] File /etc/systemd/system/glusterfs-server.service.d/override.conf is in the correct state
2017-11-04 22:11:02,159 [salt.state       ][INFO    ][31243] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 22:11:02.158955 duration_in_ms=2.357
2017-11-04 22:11:02,159 [salt.state       ][INFO    ][31243] Running state [/srv/glusterfs/glance] at time 22:11:02.159151
2017-11-04 22:11:02,159 [salt.state       ][INFO    ][31243] Executing state file.directory for /srv/glusterfs/glance
2017-11-04 22:11:02,160 [salt.state       ][INFO    ][31243] Directory /srv/glusterfs/glance is in the correct state
2017-11-04 22:11:02,160 [salt.state       ][INFO    ][31243] Completed state [/srv/glusterfs/glance] at time 22:11:02.159860 duration_in_ms=0.708
2017-11-04 22:11:02,160 [salt.state       ][INFO    ][31243] Running state [/srv/glusterfs/keystone-keys] at time 22:11:02.160043
2017-11-04 22:11:02,160 [salt.state       ][INFO    ][31243] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-11-04 22:11:02,161 [salt.state       ][INFO    ][31243] Directory /srv/glusterfs/keystone-keys is in the correct state
2017-11-04 22:11:02,161 [salt.state       ][INFO    ][31243] Completed state [/srv/glusterfs/keystone-keys] at time 22:11:02.160729 duration_in_ms=0.686
2017-11-04 22:11:02,161 [salt.state       ][INFO    ][31243] Running state [/srv/glusterfs/nova_instances] at time 22:11:02.160895
2017-11-04 22:11:02,161 [salt.state       ][INFO    ][31243] Executing state file.directory for /srv/glusterfs/nova_instances
2017-11-04 22:11:02,162 [salt.state       ][INFO    ][31243] Directory /srv/glusterfs/nova_instances is in the correct state
2017-11-04 22:11:02,162 [salt.state       ][INFO    ][31243] Completed state [/srv/glusterfs/nova_instances] at time 22:11:02.161682 duration_in_ms=0.786
2017-11-04 22:11:02,162 [salt.state       ][INFO    ][31243] Running state [/srv/glusterfs/keystone-credential-keys] at time 22:11:02.161877
2017-11-04 22:11:02,162 [salt.state       ][INFO    ][31243] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-11-04 22:11:02,162 [salt.state       ][INFO    ][31243] Directory /srv/glusterfs/keystone-credential-keys is in the correct state
2017-11-04 22:11:02,163 [salt.state       ][INFO    ][31243] Completed state [/srv/glusterfs/keystone-credential-keys] at time 22:11:02.162566 duration_in_ms=0.688
2017-11-04 22:11:02,220 [salt.loaded.int.module.cmdmod][INFO    ][31243] Executing command ['git', '--version'] in directory '/root'
2017-11-04 22:11:02,302 [salt.state       ][INFO    ][31243] Running state [sleep 5] at time 22:11:02.301932
2017-11-04 22:11:02,302 [salt.state       ][INFO    ][31243] Executing state cmd.wait for sleep 5
2017-11-04 22:11:02,302 [salt.state       ][INFO    ][31243] No changes made for sleep 5
2017-11-04 22:11:02,303 [salt.state       ][INFO    ][31243] Completed state [sleep 5] at time 22:11:02.302552 duration_in_ms=0.621
2017-11-04 22:11:02,303 [salt.state       ][INFO    ][31243] Running state [192.168.10.143] at time 22:11:02.303046
2017-11-04 22:11:02,303 [salt.state       ][INFO    ][31243] Executing state glusterfs.peered for 192.168.10.143
2017-11-04 22:11:02,304 [salt.loaded.int.module.cmdmod][INFO    ][31243] Executing command 'gluster --version' in directory '/root'
2017-11-04 22:11:02,312 [salt.loaded.int.module.cmdmod][INFO    ][31243] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-04 22:11:02,368 [salt.loaded.int.module.cmdmod][INFO    ][31243] Executing command 'gluster --version' in directory '/root'
2017-11-04 22:11:02,375 [salt.loaded.int.module.cmdmod][INFO    ][31243] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-04 22:11:02,427 [salt.loaded.int.module.cmdmod][INFO    ][31243] Executing command 'gluster --version' in directory '/root'
2017-11-04 22:11:02,435 [salt.loaded.int.module.cmdmod][INFO    ][31243] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-04 22:11:02,488 [salt.loaded.int.module.cmdmod][INFO    ][31243] Executing command 'gluster --version' in directory '/root'
2017-11-04 22:11:02,495 [salt.loaded.int.module.cmdmod][INFO    ][31243] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-04 22:11:02,546 [salt.state       ][INFO    ][31243] Peering with localhost is not needed
2017-11-04 22:11:02,547 [salt.state       ][INFO    ][31243] Completed state [192.168.10.143] at time 22:11:02.546707 duration_in_ms=243.66
2017-11-04 22:11:02,550 [salt.state       ][INFO    ][31243] Running state [192.168.10.142] at time 22:11:02.549697
2017-11-04 22:11:02,550 [salt.state       ][INFO    ][31243] Executing state glusterfs.peered for 192.168.10.142
2017-11-04 22:11:02,550 [salt.loaded.int.module.cmdmod][INFO    ][31243] Executing command 'gluster --version' in directory '/root'
2017-11-04 22:11:02,558 [salt.loaded.int.module.cmdmod][INFO    ][31243] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-04 22:11:02,609 [salt.loaded.int.module.cmdmod][INFO    ][31243] Executing command 'gluster --version' in directory '/root'
2017-11-04 22:11:02,617 [salt.loaded.int.module.cmdmod][INFO    ][31243] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-04 22:11:02,669 [salt.loaded.int.module.cmdmod][INFO    ][31243] Executing command 'gluster --version' in directory '/root'
2017-11-04 22:11:02,675 [salt.loaded.int.module.cmdmod][INFO    ][31243] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-04 22:11:02,728 [salt.loaded.int.module.cmdmod][INFO    ][31243] Executing command 'gluster --version' in directory '/root'
2017-11-04 22:11:02,735 [salt.loaded.int.module.cmdmod][INFO    ][31243] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-04 22:11:02,787 [salt.state       ][INFO    ][31243] {'new': {'192.168.10.141': [], 'kvm02.baremetal-mcp-ocata-ovs-ha.local': ['192.168.10.142']}, 'old': {'192.168.10.141': [], 'kvm02.baremetal-mcp-ocata-ovs-ha.local': []}}
2017-11-04 22:11:02,788 [salt.state       ][INFO    ][31243] Completed state [192.168.10.142] at time 22:11:02.787502 duration_in_ms=237.805
2017-11-04 22:11:02,791 [salt.state       ][INFO    ][31243] Running state [192.168.10.141] at time 22:11:02.790686
2017-11-04 22:11:02,791 [salt.state       ][INFO    ][31243] Executing state glusterfs.peered for 192.168.10.141
2017-11-04 22:11:02,791 [salt.loaded.int.module.cmdmod][INFO    ][31243] Executing command 'gluster --version' in directory '/root'
2017-11-04 22:11:02,799 [salt.loaded.int.module.cmdmod][INFO    ][31243] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-04 22:11:02,851 [salt.state       ][INFO    ][31243] Host 192.168.10.141 already peered
2017-11-04 22:11:02,851 [salt.state       ][INFO    ][31243] Completed state [192.168.10.141] at time 22:11:02.850919 duration_in_ms=60.233
2017-11-04 22:11:02,852 [salt.state       ][INFO    ][31243] Running state [glance] at time 22:11:02.851872
2017-11-04 22:11:02,852 [salt.state       ][INFO    ][31243] Executing state glusterfs.created for glance
2017-11-04 22:11:02,853 [salt.loaded.int.module.cmdmod][INFO    ][31243] Executing command 'gluster --version' in directory '/root'
2017-11-04 22:11:02,860 [salt.loaded.int.module.cmdmod][INFO    ][31243] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-04 22:11:02,911 [salt.loaded.int.module.cmdmod][INFO    ][31243] Executing command 'gluster --version' in directory '/root'
2017-11-04 22:11:02,918 [salt.loaded.int.module.cmdmod][INFO    ][31243] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-04 22:11:02,977 [salt.state       ][INFO    ][31243] Volume glance already exists and is started.
2017-11-04 22:11:02,977 [salt.state       ][INFO    ][31243] Completed state [glance] at time 22:11:02.976945 duration_in_ms=125.072
2017-11-04 22:11:02,981 [salt.state       ][INFO    ][31243] Running state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 22:11:02.980532
2017-11-04 22:11:02,981 [salt.state       ][INFO    ][31243] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'
2017-11-04 22:11:02,981 [salt.loaded.int.module.cmdmod][INFO    ][31243] Executing command 'gluster volume info 'glance' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-11-04 22:11:03,033 [salt.state       ][INFO    ][31243] unless execution succeeded
2017-11-04 22:11:03,033 [salt.state       ][INFO    ][31243] Completed state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 22:11:03.033359 duration_in_ms=52.827
2017-11-04 22:11:03,034 [salt.state       ][INFO    ][31243] Running state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 22:11:03.033987
2017-11-04 22:11:03,034 [salt.state       ][INFO    ][31243] Executing state cmd.run for gluster volume set 'glance' 'network.remote-dio' 'True'
2017-11-04 22:11:03,035 [salt.loaded.int.module.cmdmod][INFO    ][31243] Executing command 'gluster volume info 'glance' | grep 'network.remote-dio: True'' in directory '/root'
2017-11-04 22:11:03,087 [salt.state       ][INFO    ][31243] unless execution succeeded
2017-11-04 22:11:03,087 [salt.state       ][INFO    ][31243] Completed state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 22:11:03.086990 duration_in_ms=53.003
2017-11-04 22:11:03,088 [salt.state       ][INFO    ][31243] Running state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 22:11:03.087618
2017-11-04 22:11:03,088 [salt.state       ][INFO    ][31243] Executing state cmd.run for gluster volume set 'glance' 'nfs.disable' 'True'
2017-11-04 22:11:03,088 [salt.loaded.int.module.cmdmod][INFO    ][31243] Executing command 'gluster volume info 'glance' | grep 'nfs.disable: True'' in directory '/root'
2017-11-04 22:11:03,140 [salt.state       ][INFO    ][31243] unless execution succeeded
2017-11-04 22:11:03,141 [salt.state       ][INFO    ][31243] Completed state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 22:11:03.140469 duration_in_ms=52.85
2017-11-04 22:11:03,141 [salt.state       ][INFO    ][31243] Running state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 22:11:03.141114
2017-11-04 22:11:03,141 [salt.state       ][INFO    ][31243] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'
2017-11-04 22:11:03,142 [salt.loaded.int.module.cmdmod][INFO    ][31243] Executing command 'gluster volume info 'glance' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-11-04 22:11:03,193 [salt.state       ][INFO    ][31243] unless execution succeeded
2017-11-04 22:11:03,193 [salt.state       ][INFO    ][31243] Completed state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 22:11:03.193212 duration_in_ms=52.098
2017-11-04 22:11:03,194 [salt.state       ][INFO    ][31243] Running state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 22:11:03.193815
2017-11-04 22:11:03,194 [salt.state       ][INFO    ][31243] Executing state cmd.run for gluster volume set 'glance' 'cluster.readdir-optimize' 'True'
2017-11-04 22:11:03,195 [salt.loaded.int.module.cmdmod][INFO    ][31243] Executing command 'gluster volume info 'glance' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-11-04 22:11:03,246 [salt.state       ][INFO    ][31243] unless execution succeeded
2017-11-04 22:11:03,247 [salt.state       ][INFO    ][31243] Completed state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 22:11:03.246595 duration_in_ms=52.77
2017-11-04 22:11:03,248 [salt.state       ][INFO    ][31243] Running state [glance] at time 22:11:03.247798
2017-11-04 22:11:03,248 [salt.state       ][INFO    ][31243] Executing state glusterfs.started for glance
2017-11-04 22:11:03,248 [salt.loaded.int.module.cmdmod][INFO    ][31243] Executing command 'gluster --version' in directory '/root'
2017-11-04 22:11:03,256 [salt.loaded.int.module.cmdmod][INFO    ][31243] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-04 22:11:03,309 [salt.loaded.int.module.cmdmod][INFO    ][31243] Executing command 'gluster --version' in directory '/root'
2017-11-04 22:11:03,317 [salt.loaded.int.module.cmdmod][INFO    ][31243] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-04 22:11:03,374 [salt.state       ][INFO    ][31243] Volume glance is already started
2017-11-04 22:11:03,375 [salt.state       ][INFO    ][31243] Completed state [glance] at time 22:11:03.374635 duration_in_ms=126.836
2017-11-04 22:11:03,376 [salt.state       ][INFO    ][31243] Running state [keystone-keys] at time 22:11:03.375724
2017-11-04 22:11:03,376 [salt.state       ][INFO    ][31243] Executing state glusterfs.created for keystone-keys
2017-11-04 22:11:03,376 [salt.loaded.int.module.cmdmod][INFO    ][31243] Executing command 'gluster --version' in directory '/root'
2017-11-04 22:11:03,384 [salt.loaded.int.module.cmdmod][INFO    ][31243] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-04 22:11:03,437 [salt.loaded.int.module.cmdmod][INFO    ][31243] Executing command 'gluster --version' in directory '/root'
2017-11-04 22:11:03,444 [salt.loaded.int.module.cmdmod][INFO    ][31243] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-04 22:11:03,500 [salt.state       ][INFO    ][31243] Volume keystone-keys already exists and is started.
2017-11-04 22:11:03,501 [salt.state       ][INFO    ][31243] Completed state [keystone-keys] at time 22:11:03.500509 duration_in_ms=124.784
2017-11-04 22:11:03,504 [salt.state       ][INFO    ][31243] Running state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 22:11:03.504096
2017-11-04 22:11:03,504 [salt.state       ][INFO    ][31243] Executing state cmd.run for gluster volume set 'keystone-keys' 'network.remote-dio' 'True'
2017-11-04 22:11:03,505 [salt.loaded.int.module.cmdmod][INFO    ][31243] Executing command 'gluster volume info 'keystone-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-11-04 22:11:03,556 [salt.state       ][INFO    ][31243] unless execution succeeded
2017-11-04 22:11:03,556 [salt.state       ][INFO    ][31243] Completed state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 22:11:03.556421 duration_in_ms=52.325
2017-11-04 22:11:03,557 [salt.state       ][INFO    ][31243] Running state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 22:11:03.557051
2017-11-04 22:11:03,557 [salt.state       ][INFO    ][31243] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-11-04 22:11:03,558 [salt.loaded.int.module.cmdmod][INFO    ][31243] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-11-04 22:11:03,610 [salt.state       ][INFO    ][31243] unless execution succeeded
2017-11-04 22:11:03,610 [salt.state       ][INFO    ][31243] Completed state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 22:11:03.609841 duration_in_ms=52.79
2017-11-04 22:11:03,610 [salt.state       ][INFO    ][31243] Running state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 22:11:03.610451
2017-11-04 22:11:03,611 [salt.state       ][INFO    ][31243] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'
2017-11-04 22:11:03,611 [salt.loaded.int.module.cmdmod][INFO    ][31243] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-11-04 22:11:03,662 [salt.state       ][INFO    ][31243] unless execution succeeded
2017-11-04 22:11:03,663 [salt.state       ][INFO    ][31243] Completed state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 22:11:03.662698 duration_in_ms=52.247
2017-11-04 22:11:03,663 [salt.state       ][INFO    ][31243] Running state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 22:11:03.663224
2017-11-04 22:11:03,663 [salt.state       ][INFO    ][31243] Executing state cmd.run for gluster volume set 'keystone-keys' 'nfs.disable' 'True'
2017-11-04 22:11:03,664 [salt.loaded.int.module.cmdmod][INFO    ][31243] Executing command 'gluster volume info 'keystone-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-11-04 22:11:03,716 [salt.state       ][INFO    ][31243] unless execution succeeded
2017-11-04 22:11:03,716 [salt.state       ][INFO    ][31243] Completed state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 22:11:03.716028 duration_in_ms=52.804
2017-11-04 22:11:03,717 [salt.state       ][INFO    ][31243] Running state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 22:11:03.716579
2017-11-04 22:11:03,717 [salt.state       ][INFO    ][31243] Executing state cmd.run for gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'
2017-11-04 22:11:03,717 [salt.loaded.int.module.cmdmod][INFO    ][31243] Executing command 'gluster volume info 'keystone-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-11-04 22:11:03,769 [salt.state       ][INFO    ][31243] unless execution succeeded
2017-11-04 22:11:03,769 [salt.state       ][INFO    ][31243] Completed state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 22:11:03.769438 duration_in_ms=52.858
2017-11-04 22:11:03,771 [salt.state       ][INFO    ][31243] Running state [keystone-keys] at time 22:11:03.770720
2017-11-04 22:11:03,771 [salt.state       ][INFO    ][31243] Executing state glusterfs.started for keystone-keys
2017-11-04 22:11:03,771 [salt.loaded.int.module.cmdmod][INFO    ][31243] Executing command 'gluster --version' in directory '/root'
2017-11-04 22:11:03,780 [salt.loaded.int.module.cmdmod][INFO    ][31243] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-04 22:11:03,834 [salt.loaded.int.module.cmdmod][INFO    ][31243] Executing command 'gluster --version' in directory '/root'
2017-11-04 22:11:03,841 [salt.loaded.int.module.cmdmod][INFO    ][31243] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-04 22:11:03,899 [salt.state       ][INFO    ][31243] Volume keystone-keys is already started
2017-11-04 22:11:03,900 [salt.state       ][INFO    ][31243] Completed state [keystone-keys] at time 22:11:03.899802 duration_in_ms=129.081
2017-11-04 22:11:03,902 [salt.state       ][INFO    ][31243] Running state [nova_instances] at time 22:11:03.901516
2017-11-04 22:11:03,902 [salt.state       ][INFO    ][31243] Executing state glusterfs.created for nova_instances
2017-11-04 22:11:03,903 [salt.loaded.int.module.cmdmod][INFO    ][31243] Executing command 'gluster --version' in directory '/root'
2017-11-04 22:11:03,910 [salt.loaded.int.module.cmdmod][INFO    ][31243] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-04 22:11:03,962 [salt.loaded.int.module.cmdmod][INFO    ][31243] Executing command 'gluster --version' in directory '/root'
2017-11-04 22:11:03,969 [salt.loaded.int.module.cmdmod][INFO    ][31243] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-04 22:11:04,025 [salt.state       ][INFO    ][31243] Volume nova_instances already exists and is started.
2017-11-04 22:11:04,026 [salt.state       ][INFO    ][31243] Completed state [nova_instances] at time 22:11:04.025568 duration_in_ms=124.051
2017-11-04 22:11:04,030 [salt.state       ][INFO    ][31243] Running state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 22:11:04.030342
2017-11-04 22:11:04,031 [salt.state       ][INFO    ][31243] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'
2017-11-04 22:11:04,031 [salt.loaded.int.module.cmdmod][INFO    ][31243] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-11-04 22:11:04,083 [salt.state       ][INFO    ][31243] unless execution succeeded
2017-11-04 22:11:04,083 [salt.state       ][INFO    ][31243] Completed state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 22:11:04.082801 duration_in_ms=52.459
2017-11-04 22:11:04,083 [salt.state       ][INFO    ][31243] Running state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'On'] at time 22:11:04.083364
2017-11-04 22:11:04,084 [salt.state       ][INFO    ][31243] Executing state cmd.run for gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'On'
2017-11-04 22:11:04,084 [salt.loaded.int.module.cmdmod][INFO    ][31243] Executing command 'gluster volume info 'nova_instances' | grep 'cluster.readdir-optimize: On'' in directory '/root'
2017-11-04 22:11:04,133 [salt.state       ][INFO    ][31243] unless execution succeeded
2017-11-04 22:11:04,133 [salt.state       ][INFO    ][31243] Completed state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'On'] at time 22:11:04.133406 duration_in_ms=50.041
2017-11-04 22:11:04,134 [salt.state       ][INFO    ][31243] Running state [gluster volume set 'nova_instances' 'network.remote-dio' 'On'] at time 22:11:04.133972
2017-11-04 22:11:04,134 [salt.state       ][INFO    ][31243] Executing state cmd.run for gluster volume set 'nova_instances' 'network.remote-dio' 'On'
2017-11-04 22:11:04,135 [salt.loaded.int.module.cmdmod][INFO    ][31243] Executing command 'gluster volume info 'nova_instances' | grep 'network.remote-dio: On'' in directory '/root'
2017-11-04 22:11:04,186 [salt.state       ][INFO    ][31243] unless execution succeeded
2017-11-04 22:11:04,186 [salt.state       ][INFO    ][31243] Completed state [gluster volume set 'nova_instances' 'network.remote-dio' 'On'] at time 22:11:04.186429 duration_in_ms=52.457
2017-11-04 22:11:04,187 [salt.state       ][INFO    ][31243] Running state [gluster volume set 'nova_instances' 'nfs.disable' 'On'] at time 22:11:04.187027
2017-11-04 22:11:04,187 [salt.state       ][INFO    ][31243] Executing state cmd.run for gluster volume set 'nova_instances' 'nfs.disable' 'On'
2017-11-04 22:11:04,188 [salt.loaded.int.module.cmdmod][INFO    ][31243] Executing command 'gluster volume info 'nova_instances' | grep 'nfs.disable: On'' in directory '/root'
2017-11-04 22:11:04,237 [salt.state       ][INFO    ][31243] unless execution succeeded
2017-11-04 22:11:04,237 [salt.state       ][INFO    ][31243] Completed state [gluster volume set 'nova_instances' 'nfs.disable' 'On'] at time 22:11:04.236800 duration_in_ms=49.773
2017-11-04 22:11:04,238 [salt.state       ][INFO    ][31243] Running state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 22:11:04.237548
2017-11-04 22:11:04,238 [salt.state       ][INFO    ][31243] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'
2017-11-04 22:11:04,238 [salt.loaded.int.module.cmdmod][INFO    ][31243] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-11-04 22:11:04,290 [salt.state       ][INFO    ][31243] unless execution succeeded
2017-11-04 22:11:04,290 [salt.state       ][INFO    ][31243] Completed state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 22:11:04.290436 duration_in_ms=52.888
2017-11-04 22:11:04,292 [salt.state       ][INFO    ][31243] Running state [nova_instances] at time 22:11:04.291779
2017-11-04 22:11:04,292 [salt.state       ][INFO    ][31243] Executing state glusterfs.started for nova_instances
2017-11-04 22:11:04,293 [salt.loaded.int.module.cmdmod][INFO    ][31243] Executing command 'gluster --version' in directory '/root'
2017-11-04 22:11:04,300 [salt.loaded.int.module.cmdmod][INFO    ][31243] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-04 22:11:04,352 [salt.loaded.int.module.cmdmod][INFO    ][31243] Executing command 'gluster --version' in directory '/root'
2017-11-04 22:11:04,359 [salt.loaded.int.module.cmdmod][INFO    ][31243] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-04 22:11:04,415 [salt.state       ][INFO    ][31243] Volume nova_instances is already started
2017-11-04 22:11:04,416 [salt.state       ][INFO    ][31243] Completed state [nova_instances] at time 22:11:04.415669 duration_in_ms=123.89
2017-11-04 22:11:04,417 [salt.state       ][INFO    ][31243] Running state [keystone-credential-keys] at time 22:11:04.416849
2017-11-04 22:11:04,417 [salt.state       ][INFO    ][31243] Executing state glusterfs.created for keystone-credential-keys
2017-11-04 22:11:04,418 [salt.loaded.int.module.cmdmod][INFO    ][31243] Executing command 'gluster --version' in directory '/root'
2017-11-04 22:11:04,425 [salt.loaded.int.module.cmdmod][INFO    ][31243] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-04 22:11:04,476 [salt.loaded.int.module.cmdmod][INFO    ][31243] Executing command 'gluster --version' in directory '/root'
2017-11-04 22:11:04,484 [salt.loaded.int.module.cmdmod][INFO    ][31243] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-04 22:11:04,539 [salt.state       ][INFO    ][31243] Volume keystone-credential-keys already exists and is started.
2017-11-04 22:11:04,539 [salt.state       ][INFO    ][31243] Completed state [keystone-credential-keys] at time 22:11:04.538840 duration_in_ms=121.99
2017-11-04 22:11:04,543 [salt.state       ][INFO    ][31243] Running state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 22:11:04.542869
2017-11-04 22:11:04,543 [salt.state       ][INFO    ][31243] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'
2017-11-04 22:11:04,544 [salt.loaded.int.module.cmdmod][INFO    ][31243] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-11-04 22:11:04,596 [salt.state       ][INFO    ][31243] unless execution succeeded
2017-11-04 22:11:04,596 [salt.state       ][INFO    ][31243] Completed state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 22:11:04.596125 duration_in_ms=53.256
2017-11-04 22:11:04,597 [salt.state       ][INFO    ][31243] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 22:11:04.596787
2017-11-04 22:11:04,597 [salt.state       ][INFO    ][31243] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-11-04 22:11:04,598 [salt.loaded.int.module.cmdmod][INFO    ][31243] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-11-04 22:11:04,650 [salt.state       ][INFO    ][31243] unless execution succeeded
2017-11-04 22:11:04,650 [salt.state       ][INFO    ][31243] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 22:11:04.649926 duration_in_ms=53.138
2017-11-04 22:11:04,650 [salt.state       ][INFO    ][31243] Running state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 22:11:04.650453
2017-11-04 22:11:04,651 [salt.state       ][INFO    ][31243] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'
2017-11-04 22:11:04,651 [salt.loaded.int.module.cmdmod][INFO    ][31243] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-11-04 22:11:04,700 [salt.state       ][INFO    ][31243] unless execution succeeded
2017-11-04 22:11:04,700 [salt.state       ][INFO    ][31243] Completed state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 22:11:04.700259 duration_in_ms=49.805
2017-11-04 22:11:04,701 [salt.state       ][INFO    ][31243] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 22:11:04.700855
2017-11-04 22:11:04,701 [salt.state       ][INFO    ][31243] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'
2017-11-04 22:11:04,702 [salt.loaded.int.module.cmdmod][INFO    ][31243] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-11-04 22:11:04,754 [salt.state       ][INFO    ][31243] unless execution succeeded
2017-11-04 22:11:04,754 [salt.state       ][INFO    ][31243] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 22:11:04.754223 duration_in_ms=53.367
2017-11-04 22:11:04,755 [salt.state       ][INFO    ][31243] Running state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 22:11:04.754824
2017-11-04 22:11:04,755 [salt.state       ][INFO    ][31243] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'
2017-11-04 22:11:04,756 [salt.loaded.int.module.cmdmod][INFO    ][31243] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-11-04 22:11:04,809 [salt.state       ][INFO    ][31243] unless execution succeeded
2017-11-04 22:11:04,810 [salt.state       ][INFO    ][31243] Completed state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 22:11:04.809475 duration_in_ms=54.651
2017-11-04 22:11:04,811 [salt.state       ][INFO    ][31243] Running state [keystone-credential-keys] at time 22:11:04.810827
2017-11-04 22:11:04,811 [salt.state       ][INFO    ][31243] Executing state glusterfs.started for keystone-credential-keys
2017-11-04 22:11:04,812 [salt.loaded.int.module.cmdmod][INFO    ][31243] Executing command 'gluster --version' in directory '/root'
2017-11-04 22:11:04,820 [salt.loaded.int.module.cmdmod][INFO    ][31243] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-04 22:11:04,872 [salt.loaded.int.module.cmdmod][INFO    ][31243] Executing command 'gluster --version' in directory '/root'
2017-11-04 22:11:04,880 [salt.loaded.int.module.cmdmod][INFO    ][31243] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-04 22:11:04,935 [salt.state       ][INFO    ][31243] Volume keystone-credential-keys is already started
2017-11-04 22:11:04,936 [salt.state       ][INFO    ][31243] Completed state [keystone-credential-keys] at time 22:11:04.935591 duration_in_ms=124.762
2017-11-04 22:11:04,938 [salt.minion      ][INFO    ][31243] Returning information for job: 20171104221059244621
2017-11-04 22:11:10,106 [salt.minion      ][INFO    ][24259] User sudo_ubuntu Executing command test.ping with jid 20171104221110101023
2017-11-04 22:11:10,117 [salt.minion      ][INFO    ][31670] Starting a new job with PID 31670
2017-11-04 22:11:10,151 [salt.minion      ][INFO    ][31670] Returning information for job: 20171104221110101023
2017-11-04 22:11:10,656 [salt.minion      ][INFO    ][24259] User sudo_ubuntu Executing command cmd.run with jid 20171104221110647213
2017-11-04 22:11:10,664 [salt.minion      ][INFO    ][31675] Starting a new job with PID 31675
2017-11-04 22:11:10,669 [salt.loaded.int.module.cmdmod][INFO    ][31675] Executing command 'gluster peer status; gluster volume status' in directory '/root'
2017-11-04 22:11:10,783 [salt.minion      ][INFO    ][31675] Returning information for job: 20171104221110647213
2017-11-04 22:51:25,701 [salt.minion      ][INFO    ][24259] User sudo_ubuntu Executing command test.ping with jid 20171104225125694052
2017-11-04 22:51:25,714 [salt.minion      ][INFO    ][32387] Starting a new job with PID 32387
2017-11-04 22:51:25,752 [salt.minion      ][INFO    ][32387] Returning information for job: 20171104225125694052
2017-11-04 22:51:59,003 [salt.minion      ][INFO    ][24259] User sudo_ubuntu Executing command state.sls with jid 20171104225158993795
2017-11-04 22:51:59,013 [salt.minion      ][INFO    ][32398] Starting a new job with PID 32398
2017-11-04 22:51:59,570 [salt.state       ][INFO    ][32398] Loading fresh modules for state activity
2017-11-04 22:51:59,602 [salt.fileclient  ][INFO    ][32398] Fetching file from saltenv 'base', ** done ** 'keepalived/init.sls'
2017-11-04 22:51:59,621 [salt.fileclient  ][INFO    ][32398] Fetching file from saltenv 'base', ** done ** 'keepalived/cluster.sls'
2017-11-04 22:51:59,652 [salt.fileclient  ][INFO    ][32398] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-11-04 22:51:59,944 [salt.state       ][INFO    ][32398] Running state [lsof] at time 22:51:59.943877
2017-11-04 22:51:59,944 [salt.state       ][INFO    ][32398] Executing state pkg.installed for lsof
2017-11-04 22:51:59,945 [salt.loaded.int.module.cmdmod][INFO    ][32398] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-04 22:52:00,201 [salt.state       ][INFO    ][32398] Package lsof is already installed
2017-11-04 22:52:00,202 [salt.state       ][INFO    ][32398] Completed state [lsof] at time 22:52:00.201762 duration_in_ms=257.885
2017-11-04 22:52:00,202 [salt.state       ][INFO    ][32398] Running state [keepalived] at time 22:52:00.202038
2017-11-04 22:52:00,202 [salt.state       ][INFO    ][32398] Executing state pkg.installed for keepalived
2017-11-04 22:52:00,206 [salt.state       ][INFO    ][32398] Package keepalived is already installed
2017-11-04 22:52:00,206 [salt.state       ][INFO    ][32398] Completed state [keepalived] at time 22:52:00.206118 duration_in_ms=4.08
2017-11-04 22:52:00,208 [salt.state       ][INFO    ][32398] Running state [/etc/keepalived/keepalived.conf] at time 22:52:00.207604
2017-11-04 22:52:00,208 [salt.state       ][INFO    ][32398] Executing state file.managed for /etc/keepalived/keepalived.conf
2017-11-04 22:52:00,234 [salt.fileclient  ][INFO    ][32398] Fetching file from saltenv 'base', ** done ** 'keepalived/files/keepalived.conf'
2017-11-04 22:52:00,273 [salt.fileclient  ][INFO    ][32398] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-11-04 22:52:00,278 [salt.state       ][INFO    ][32398] File /etc/keepalived/keepalived.conf is in the correct state
2017-11-04 22:52:00,278 [salt.state       ][INFO    ][32398] Completed state [/etc/keepalived/keepalived.conf] at time 22:52:00.278218 duration_in_ms=70.613
2017-11-04 22:52:00,279 [salt.state       ][INFO    ][32398] Running state [keepalived] at time 22:52:00.278848
2017-11-04 22:52:00,279 [salt.state       ][INFO    ][32398] Executing state service.running for keepalived
2017-11-04 22:52:00,280 [salt.loaded.int.module.cmdmod][INFO    ][32398] Executing command ['systemctl', 'status', 'keepalived.service', '-n', '0'] in directory '/root'
2017-11-04 22:52:00,295 [salt.loaded.int.module.cmdmod][INFO    ][32398] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2017-11-04 22:52:00,301 [salt.loaded.int.module.cmdmod][INFO    ][32398] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-11-04 22:52:00,309 [salt.state       ][INFO    ][32398] The service keepalived is already running
2017-11-04 22:52:00,309 [salt.state       ][INFO    ][32398] Completed state [keepalived] at time 22:52:00.309112 duration_in_ms=30.264
2017-11-04 22:52:00,310 [salt.minion      ][INFO    ][32398] Returning information for job: 20171104225158993795
2017-11-04 22:52:02,593 [salt.minion      ][INFO    ][24259] User sudo_ubuntu Executing command pillar.get with jid 20171104225202586096
2017-11-04 22:52:02,606 [salt.minion      ][INFO    ][32422] Starting a new job with PID 32422
2017-11-04 22:52:02,613 [salt.minion      ][INFO    ][32422] Returning information for job: 20171104225202586096
2017-11-04 22:52:52,537 [salt.minion      ][INFO    ][24259] User sudo_ubuntu Executing command state.sls with jid 20171104225252531121
2017-11-04 22:52:52,548 [salt.minion      ][INFO    ][32432] Starting a new job with PID 32432
2017-11-04 22:52:54,624 [salt.state       ][INFO    ][32432] Loading fresh modules for state activity
2017-11-04 22:52:54,655 [salt.fileclient  ][INFO    ][32432] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-11-04 22:52:54,678 [salt.fileclient  ][INFO    ][32432] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-11-04 22:52:54,986 [salt.state       ][INFO    ][32432] Running state [attr] at time 22:52:54.985833
2017-11-04 22:52:54,986 [salt.state       ][INFO    ][32432] Executing state pkg.installed for attr
2017-11-04 22:52:54,987 [salt.loaded.int.module.cmdmod][INFO    ][32432] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-04 22:52:55,240 [salt.state       ][INFO    ][32432] Package attr is already installed
2017-11-04 22:52:55,240 [salt.state       ][INFO    ][32432] Completed state [attr] at time 22:52:55.239883 duration_in_ms=254.049
2017-11-04 22:52:55,240 [salt.state       ][INFO    ][32432] Running state [glusterfs-server] at time 22:52:55.240171
2017-11-04 22:52:55,240 [salt.state       ][INFO    ][32432] Executing state pkg.installed for glusterfs-server
2017-11-04 22:52:55,245 [salt.state       ][INFO    ][32432] Package glusterfs-server is already installed
2017-11-04 22:52:55,245 [salt.state       ][INFO    ][32432] Completed state [glusterfs-server] at time 22:52:55.244893 duration_in_ms=4.722
2017-11-04 22:52:55,245 [salt.state       ][INFO    ][32432] Running state [bc] at time 22:52:55.245106
2017-11-04 22:52:55,245 [salt.state       ][INFO    ][32432] Executing state pkg.installed for bc
2017-11-04 22:52:55,249 [salt.state       ][INFO    ][32432] Package bc is already installed
2017-11-04 22:52:55,250 [salt.state       ][INFO    ][32432] Completed state [bc] at time 22:52:55.249487 duration_in_ms=4.381
2017-11-04 22:52:55,250 [salt.state       ][INFO    ][32432] Running state [glusterfs-server] at time 22:52:55.250350
2017-11-04 22:52:55,251 [salt.state       ][INFO    ][32432] Executing state service.running for glusterfs-server
2017-11-04 22:52:55,251 [salt.loaded.int.module.cmdmod][INFO    ][32432] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-11-04 22:52:55,267 [salt.loaded.int.module.cmdmod][INFO    ][32432] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-11-04 22:52:55,272 [salt.loaded.int.module.cmdmod][INFO    ][32432] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-11-04 22:52:55,282 [salt.state       ][INFO    ][32432] The service glusterfs-server is already running
2017-11-04 22:52:55,282 [salt.state       ][INFO    ][32432] Completed state [glusterfs-server] at time 22:52:55.281993 duration_in_ms=31.642
2017-11-04 22:52:55,284 [salt.state       ][INFO    ][32432] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 22:52:55.283584
2017-11-04 22:52:55,284 [salt.state       ][INFO    ][32432] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-11-04 22:52:55,286 [salt.state       ][INFO    ][32432] File /etc/systemd/system/glusterfs-server.service.d/override.conf is in the correct state
2017-11-04 22:52:55,286 [salt.state       ][INFO    ][32432] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 22:52:55.286275 duration_in_ms=2.691
2017-11-04 22:52:55,287 [salt.state       ][INFO    ][32432] Running state [/srv/glusterfs/glance] at time 22:52:55.286504
2017-11-04 22:52:55,287 [salt.state       ][INFO    ][32432] Executing state file.directory for /srv/glusterfs/glance
2017-11-04 22:52:55,287 [salt.state       ][INFO    ][32432] Directory /srv/glusterfs/glance is in the correct state
2017-11-04 22:52:55,287 [salt.state       ][INFO    ][32432] Completed state [/srv/glusterfs/glance] at time 22:52:55.287420 duration_in_ms=0.916
2017-11-04 22:52:55,288 [salt.state       ][INFO    ][32432] Running state [/srv/glusterfs/keystone-keys] at time 22:52:55.287636
2017-11-04 22:52:55,288 [salt.state       ][INFO    ][32432] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-11-04 22:52:55,288 [salt.state       ][INFO    ][32432] Directory /srv/glusterfs/keystone-keys is in the correct state
2017-11-04 22:52:55,289 [salt.state       ][INFO    ][32432] Completed state [/srv/glusterfs/keystone-keys] at time 22:52:55.288503 duration_in_ms=0.866
2017-11-04 22:52:55,289 [salt.state       ][INFO    ][32432] Running state [/srv/glusterfs/nova_instances] at time 22:52:55.288714
2017-11-04 22:52:55,289 [salt.state       ][INFO    ][32432] Executing state file.directory for /srv/glusterfs/nova_instances
2017-11-04 22:52:55,289 [salt.state       ][INFO    ][32432] Directory /srv/glusterfs/nova_instances is in the correct state
2017-11-04 22:52:55,290 [salt.state       ][INFO    ][32432] Completed state [/srv/glusterfs/nova_instances] at time 22:52:55.289569 duration_in_ms=0.855
2017-11-04 22:52:55,290 [salt.state       ][INFO    ][32432] Running state [/srv/glusterfs/keystone-credential-keys] at time 22:52:55.289792
2017-11-04 22:52:55,290 [salt.state       ][INFO    ][32432] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-11-04 22:52:55,291 [salt.state       ][INFO    ][32432] Directory /srv/glusterfs/keystone-credential-keys is in the correct state
2017-11-04 22:52:55,291 [salt.state       ][INFO    ][32432] Completed state [/srv/glusterfs/keystone-credential-keys] at time 22:52:55.290668 duration_in_ms=0.876
2017-11-04 22:52:55,292 [salt.minion      ][INFO    ][32432] Returning information for job: 20171104225252531121
2017-11-04 22:52:57,088 [salt.minion      ][INFO    ][24259] User sudo_ubuntu Executing command test.ping with jid 20171104225257082245
2017-11-04 22:52:57,102 [salt.minion      ][INFO    ][32455] Starting a new job with PID 32455
2017-11-04 22:52:57,135 [salt.minion      ][INFO    ][32455] Returning information for job: 20171104225257082245
2017-11-04 22:53:03,888 [salt.minion      ][INFO    ][24259] User sudo_ubuntu Executing command state.sls with jid 20171104225303879512
2017-11-04 22:53:03,902 [salt.minion      ][INFO    ][32460] Starting a new job with PID 32460
2017-11-04 22:53:04,450 [salt.state       ][INFO    ][32460] Loading fresh modules for state activity
2017-11-04 22:53:04,478 [salt.fileclient  ][INFO    ][32460] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/setup.sls'
2017-11-04 22:53:04,518 [salt.fileclient  ][INFO    ][32460] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-11-04 22:53:04,594 [salt.fileclient  ][INFO    ][32460] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-11-04 22:53:04,616 [salt.fileclient  ][INFO    ][32460] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-11-04 22:53:04,914 [salt.state       ][INFO    ][32460] Running state [attr] at time 22:53:04.913736
2017-11-04 22:53:04,914 [salt.state       ][INFO    ][32460] Executing state pkg.installed for attr
2017-11-04 22:53:04,914 [salt.loaded.int.module.cmdmod][INFO    ][32460] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-04 22:53:05,165 [salt.state       ][INFO    ][32460] Package attr is already installed
2017-11-04 22:53:05,165 [salt.state       ][INFO    ][32460] Completed state [attr] at time 22:53:05.165189 duration_in_ms=251.452
2017-11-04 22:53:05,165 [salt.state       ][INFO    ][32460] Running state [glusterfs-server] at time 22:53:05.165458
2017-11-04 22:53:05,166 [salt.state       ][INFO    ][32460] Executing state pkg.installed for glusterfs-server
2017-11-04 22:53:05,169 [salt.state       ][INFO    ][32460] Package glusterfs-server is already installed
2017-11-04 22:53:05,170 [salt.state       ][INFO    ][32460] Completed state [glusterfs-server] at time 22:53:05.169546 duration_in_ms=4.087
2017-11-04 22:53:05,170 [salt.state       ][INFO    ][32460] Running state [bc] at time 22:53:05.169747
2017-11-04 22:53:05,170 [salt.state       ][INFO    ][32460] Executing state pkg.installed for bc
2017-11-04 22:53:05,174 [salt.state       ][INFO    ][32460] Package bc is already installed
2017-11-04 22:53:05,174 [salt.state       ][INFO    ][32460] Completed state [bc] at time 22:53:05.173817 duration_in_ms=4.07
2017-11-04 22:53:05,175 [salt.state       ][INFO    ][32460] Running state [glusterfs-server] at time 22:53:05.174784
2017-11-04 22:53:05,175 [salt.state       ][INFO    ][32460] Executing state service.running for glusterfs-server
2017-11-04 22:53:05,175 [salt.loaded.int.module.cmdmod][INFO    ][32460] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-11-04 22:53:05,190 [salt.loaded.int.module.cmdmod][INFO    ][32460] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-11-04 22:53:05,198 [salt.loaded.int.module.cmdmod][INFO    ][32460] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-11-04 22:53:05,207 [salt.state       ][INFO    ][32460] The service glusterfs-server is already running
2017-11-04 22:53:05,207 [salt.state       ][INFO    ][32460] Completed state [glusterfs-server] at time 22:53:05.207028 duration_in_ms=32.243
2017-11-04 22:53:05,208 [salt.state       ][INFO    ][32460] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 22:53:05.208425
2017-11-04 22:53:05,209 [salt.state       ][INFO    ][32460] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-11-04 22:53:05,211 [salt.state       ][INFO    ][32460] File /etc/systemd/system/glusterfs-server.service.d/override.conf is in the correct state
2017-11-04 22:53:05,211 [salt.state       ][INFO    ][32460] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 22:53:05.210852 duration_in_ms=2.427
2017-11-04 22:53:05,211 [salt.state       ][INFO    ][32460] Running state [/srv/glusterfs/glance] at time 22:53:05.211091
2017-11-04 22:53:05,211 [salt.state       ][INFO    ][32460] Executing state file.directory for /srv/glusterfs/glance
2017-11-04 22:53:05,212 [salt.state       ][INFO    ][32460] Directory /srv/glusterfs/glance is in the correct state
2017-11-04 22:53:05,212 [salt.state       ][INFO    ][32460] Completed state [/srv/glusterfs/glance] at time 22:53:05.211976 duration_in_ms=0.885
2017-11-04 22:53:05,212 [salt.state       ][INFO    ][32460] Running state [/srv/glusterfs/keystone-keys] at time 22:53:05.212172
2017-11-04 22:53:05,212 [salt.state       ][INFO    ][32460] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-11-04 22:53:05,213 [salt.state       ][INFO    ][32460] Directory /srv/glusterfs/keystone-keys is in the correct state
2017-11-04 22:53:05,213 [salt.state       ][INFO    ][32460] Completed state [/srv/glusterfs/keystone-keys] at time 22:53:05.212948 duration_in_ms=0.775
2017-11-04 22:53:05,213 [salt.state       ][INFO    ][32460] Running state [/srv/glusterfs/nova_instances] at time 22:53:05.213169
2017-11-04 22:53:05,213 [salt.state       ][INFO    ][32460] Executing state file.directory for /srv/glusterfs/nova_instances
2017-11-04 22:53:05,214 [salt.state       ][INFO    ][32460] Directory /srv/glusterfs/nova_instances is in the correct state
2017-11-04 22:53:05,214 [salt.state       ][INFO    ][32460] Completed state [/srv/glusterfs/nova_instances] at time 22:53:05.213925 duration_in_ms=0.756
2017-11-04 22:53:05,214 [salt.state       ][INFO    ][32460] Running state [/srv/glusterfs/keystone-credential-keys] at time 22:53:05.214116
2017-11-04 22:53:05,214 [salt.state       ][INFO    ][32460] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-11-04 22:53:05,215 [salt.state       ][INFO    ][32460] Directory /srv/glusterfs/keystone-credential-keys is in the correct state
2017-11-04 22:53:05,215 [salt.state       ][INFO    ][32460] Completed state [/srv/glusterfs/keystone-credential-keys] at time 22:53:05.214899 duration_in_ms=0.782
2017-11-04 22:53:05,264 [salt.loaded.int.module.cmdmod][INFO    ][32460] Executing command ['git', '--version'] in directory '/root'
2017-11-04 22:53:05,343 [salt.state       ][INFO    ][32460] Running state [sleep 5] at time 22:53:05.342497
2017-11-04 22:53:05,343 [salt.state       ][INFO    ][32460] Executing state cmd.wait for sleep 5
2017-11-04 22:53:05,343 [salt.state       ][INFO    ][32460] No changes made for sleep 5
2017-11-04 22:53:05,343 [salt.state       ][INFO    ][32460] Completed state [sleep 5] at time 22:53:05.343191 duration_in_ms=0.694
2017-11-04 22:53:05,344 [salt.state       ][INFO    ][32460] Running state [192.168.10.143] at time 22:53:05.343720
2017-11-04 22:53:05,344 [salt.state       ][INFO    ][32460] Executing state glusterfs.peered for 192.168.10.143
2017-11-04 22:53:05,344 [salt.loaded.int.module.cmdmod][INFO    ][32460] Executing command 'gluster --version' in directory '/root'
2017-11-04 22:53:05,353 [salt.loaded.int.module.cmdmod][INFO    ][32460] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-04 22:53:05,405 [salt.loaded.int.module.cmdmod][INFO    ][32460] Executing command 'gluster --version' in directory '/root'
2017-11-04 22:53:05,413 [salt.loaded.int.module.cmdmod][INFO    ][32460] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-04 22:53:05,466 [salt.loaded.int.module.cmdmod][INFO    ][32460] Executing command 'gluster --version' in directory '/root'
2017-11-04 22:53:05,474 [salt.loaded.int.module.cmdmod][INFO    ][32460] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-04 22:53:05,526 [salt.loaded.int.module.cmdmod][INFO    ][32460] Executing command 'gluster --version' in directory '/root'
2017-11-04 22:53:05,533 [salt.loaded.int.module.cmdmod][INFO    ][32460] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-04 22:53:05,585 [salt.state       ][INFO    ][32460] Peering with localhost is not needed
2017-11-04 22:53:05,585 [salt.state       ][INFO    ][32460] Completed state [192.168.10.143] at time 22:53:05.585131 duration_in_ms=241.41
2017-11-04 22:53:05,588 [salt.state       ][INFO    ][32460] Running state [192.168.10.142] at time 22:53:05.588237
2017-11-04 22:53:05,589 [salt.state       ][INFO    ][32460] Executing state glusterfs.peered for 192.168.10.142
2017-11-04 22:53:05,589 [salt.loaded.int.module.cmdmod][INFO    ][32460] Executing command 'gluster --version' in directory '/root'
2017-11-04 22:53:05,596 [salt.loaded.int.module.cmdmod][INFO    ][32460] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-04 22:53:05,649 [salt.state       ][INFO    ][32460] Host 192.168.10.142 already peered
2017-11-04 22:53:05,650 [salt.state       ][INFO    ][32460] Completed state [192.168.10.142] at time 22:53:05.649519 duration_in_ms=61.281
2017-11-04 22:53:05,652 [salt.state       ][INFO    ][32460] Running state [192.168.10.141] at time 22:53:05.652297
2017-11-04 22:53:05,653 [salt.state       ][INFO    ][32460] Executing state glusterfs.peered for 192.168.10.141
2017-11-04 22:53:05,653 [salt.loaded.int.module.cmdmod][INFO    ][32460] Executing command 'gluster --version' in directory '/root'
2017-11-04 22:53:05,661 [salt.loaded.int.module.cmdmod][INFO    ][32460] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-04 22:53:05,713 [salt.state       ][INFO    ][32460] Host 192.168.10.141 already peered
2017-11-04 22:53:05,713 [salt.state       ][INFO    ][32460] Completed state [192.168.10.141] at time 22:53:05.713212 duration_in_ms=60.915
2017-11-04 22:53:05,714 [salt.state       ][INFO    ][32460] Running state [glance] at time 22:53:05.714169
2017-11-04 22:53:05,714 [salt.state       ][INFO    ][32460] Executing state glusterfs.created for glance
2017-11-04 22:53:05,715 [salt.loaded.int.module.cmdmod][INFO    ][32460] Executing command 'gluster --version' in directory '/root'
2017-11-04 22:53:05,723 [salt.loaded.int.module.cmdmod][INFO    ][32460] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-04 22:53:05,776 [salt.loaded.int.module.cmdmod][INFO    ][32460] Executing command 'gluster --version' in directory '/root'
2017-11-04 22:53:05,784 [salt.loaded.int.module.cmdmod][INFO    ][32460] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-04 22:53:05,842 [salt.state       ][INFO    ][32460] Volume glance already exists and is started.
2017-11-04 22:53:05,843 [salt.state       ][INFO    ][32460] Completed state [glance] at time 22:53:05.842672 duration_in_ms=128.5
2017-11-04 22:53:05,846 [salt.state       ][INFO    ][32460] Running state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 22:53:05.846461
2017-11-04 22:53:05,847 [salt.state       ][INFO    ][32460] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'
2017-11-04 22:53:05,847 [salt.loaded.int.module.cmdmod][INFO    ][32460] Executing command 'gluster volume info 'glance' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-11-04 22:53:05,901 [salt.state       ][INFO    ][32460] unless execution succeeded
2017-11-04 22:53:05,901 [salt.state       ][INFO    ][32460] Completed state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 22:53:05.901145 duration_in_ms=54.684
2017-11-04 22:53:05,902 [salt.state       ][INFO    ][32460] Running state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 22:53:05.901789
2017-11-04 22:53:05,902 [salt.state       ][INFO    ][32460] Executing state cmd.run for gluster volume set 'glance' 'network.remote-dio' 'True'
2017-11-04 22:53:05,903 [salt.loaded.int.module.cmdmod][INFO    ][32460] Executing command 'gluster volume info 'glance' | grep 'network.remote-dio: True'' in directory '/root'
2017-11-04 22:53:05,955 [salt.state       ][INFO    ][32460] unless execution succeeded
2017-11-04 22:53:05,955 [salt.state       ][INFO    ][32460] Completed state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 22:53:05.954740 duration_in_ms=52.951
2017-11-04 22:53:05,955 [salt.state       ][INFO    ][32460] Running state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 22:53:05.955281
2017-11-04 22:53:05,956 [salt.state       ][INFO    ][32460] Executing state cmd.run for gluster volume set 'glance' 'nfs.disable' 'True'
2017-11-04 22:53:05,956 [salt.loaded.int.module.cmdmod][INFO    ][32460] Executing command 'gluster volume info 'glance' | grep 'nfs.disable: True'' in directory '/root'
2017-11-04 22:53:06,009 [salt.state       ][INFO    ][32460] unless execution succeeded
2017-11-04 22:53:06,009 [salt.state       ][INFO    ][32460] Completed state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 22:53:06.009425 duration_in_ms=54.142
2017-11-04 22:53:06,010 [salt.state       ][INFO    ][32460] Running state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 22:53:06.010008
2017-11-04 22:53:06,010 [salt.state       ][INFO    ][32460] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'
2017-11-04 22:53:06,011 [salt.loaded.int.module.cmdmod][INFO    ][32460] Executing command 'gluster volume info 'glance' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-11-04 22:53:06,062 [salt.state       ][INFO    ][32460] unless execution succeeded
2017-11-04 22:53:06,062 [salt.state       ][INFO    ][32460] Completed state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 22:53:06.062382 duration_in_ms=52.361
2017-11-04 22:53:06,063 [salt.state       ][INFO    ][32460] Running state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 22:53:06.062921
2017-11-04 22:53:06,063 [salt.state       ][INFO    ][32460] Executing state cmd.run for gluster volume set 'glance' 'cluster.readdir-optimize' 'True'
2017-11-04 22:53:06,064 [salt.loaded.int.module.cmdmod][INFO    ][32460] Executing command 'gluster volume info 'glance' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-11-04 22:53:06,119 [salt.state       ][INFO    ][32460] unless execution succeeded
2017-11-04 22:53:06,119 [salt.state       ][INFO    ][32460] Completed state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 22:53:06.119365 duration_in_ms=56.444
2017-11-04 22:53:06,121 [salt.state       ][INFO    ][32460] Running state [glance] at time 22:53:06.120652
2017-11-04 22:53:06,121 [salt.state       ][INFO    ][32460] Executing state glusterfs.started for glance
2017-11-04 22:53:06,121 [salt.loaded.int.module.cmdmod][INFO    ][32460] Executing command 'gluster --version' in directory '/root'
2017-11-04 22:53:06,129 [salt.loaded.int.module.cmdmod][INFO    ][32460] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-04 22:53:06,181 [salt.loaded.int.module.cmdmod][INFO    ][32460] Executing command 'gluster --version' in directory '/root'
2017-11-04 22:53:06,188 [salt.loaded.int.module.cmdmod][INFO    ][32460] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-04 22:53:06,245 [salt.state       ][INFO    ][32460] Volume glance is already started
2017-11-04 22:53:06,245 [salt.state       ][INFO    ][32460] Completed state [glance] at time 22:53:06.244757 duration_in_ms=124.104
2017-11-04 22:53:06,246 [salt.state       ][INFO    ][32460] Running state [keystone-keys] at time 22:53:06.245843
2017-11-04 22:53:06,246 [salt.state       ][INFO    ][32460] Executing state glusterfs.created for keystone-keys
2017-11-04 22:53:06,247 [salt.loaded.int.module.cmdmod][INFO    ][32460] Executing command 'gluster --version' in directory '/root'
2017-11-04 22:53:06,254 [salt.loaded.int.module.cmdmod][INFO    ][32460] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-04 22:53:06,305 [salt.loaded.int.module.cmdmod][INFO    ][32460] Executing command 'gluster --version' in directory '/root'
2017-11-04 22:53:06,313 [salt.loaded.int.module.cmdmod][INFO    ][32460] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-04 22:53:06,372 [salt.state       ][INFO    ][32460] Volume keystone-keys already exists and is started.
2017-11-04 22:53:06,372 [salt.state       ][INFO    ][32460] Completed state [keystone-keys] at time 22:53:06.371918 duration_in_ms=126.074
2017-11-04 22:53:06,376 [salt.state       ][INFO    ][32460] Running state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 22:53:06.375602
2017-11-04 22:53:06,376 [salt.state       ][INFO    ][32460] Executing state cmd.run for gluster volume set 'keystone-keys' 'network.remote-dio' 'True'
2017-11-04 22:53:06,376 [salt.loaded.int.module.cmdmod][INFO    ][32460] Executing command 'gluster volume info 'keystone-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-11-04 22:53:06,430 [salt.state       ][INFO    ][32460] unless execution succeeded
2017-11-04 22:53:06,431 [salt.state       ][INFO    ][32460] Completed state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 22:53:06.430719 duration_in_ms=55.117
2017-11-04 22:53:06,431 [salt.state       ][INFO    ][32460] Running state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 22:53:06.431303
2017-11-04 22:53:06,432 [salt.state       ][INFO    ][32460] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-11-04 22:53:06,432 [salt.loaded.int.module.cmdmod][INFO    ][32460] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-11-04 22:53:06,485 [salt.state       ][INFO    ][32460] unless execution succeeded
2017-11-04 22:53:06,486 [salt.state       ][INFO    ][32460] Completed state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 22:53:06.485701 duration_in_ms=54.398
2017-11-04 22:53:06,486 [salt.state       ][INFO    ][32460] Running state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 22:53:06.486253
2017-11-04 22:53:06,487 [salt.state       ][INFO    ][32460] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'
2017-11-04 22:53:06,487 [salt.loaded.int.module.cmdmod][INFO    ][32460] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-11-04 22:53:06,543 [salt.state       ][INFO    ][32460] unless execution succeeded
2017-11-04 22:53:06,543 [salt.state       ][INFO    ][32460] Completed state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 22:53:06.542805 duration_in_ms=56.551
2017-11-04 22:53:06,543 [salt.state       ][INFO    ][32460] Running state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 22:53:06.543317
2017-11-04 22:53:06,544 [salt.state       ][INFO    ][32460] Executing state cmd.run for gluster volume set 'keystone-keys' 'nfs.disable' 'True'
2017-11-04 22:53:06,544 [salt.loaded.int.module.cmdmod][INFO    ][32460] Executing command 'gluster volume info 'keystone-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-11-04 22:53:06,596 [salt.state       ][INFO    ][32460] unless execution succeeded
2017-11-04 22:53:06,596 [salt.state       ][INFO    ][32460] Completed state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 22:53:06.596414 duration_in_ms=53.095
2017-11-04 22:53:06,597 [salt.state       ][INFO    ][32460] Running state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 22:53:06.597080
2017-11-04 22:53:06,597 [salt.state       ][INFO    ][32460] Executing state cmd.run for gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'
2017-11-04 22:53:06,598 [salt.loaded.int.module.cmdmod][INFO    ][32460] Executing command 'gluster volume info 'keystone-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-11-04 22:53:06,649 [salt.state       ][INFO    ][32460] unless execution succeeded
2017-11-04 22:53:06,649 [salt.state       ][INFO    ][32460] Completed state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 22:53:06.648781 duration_in_ms=51.701
2017-11-04 22:53:06,650 [salt.state       ][INFO    ][32460] Running state [keystone-keys] at time 22:53:06.650095
2017-11-04 22:53:06,650 [salt.state       ][INFO    ][32460] Executing state glusterfs.started for keystone-keys
2017-11-04 22:53:06,651 [salt.loaded.int.module.cmdmod][INFO    ][32460] Executing command 'gluster --version' in directory '/root'
2017-11-04 22:53:06,659 [salt.loaded.int.module.cmdmod][INFO    ][32460] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-04 22:53:06,710 [salt.loaded.int.module.cmdmod][INFO    ][32460] Executing command 'gluster --version' in directory '/root'
2017-11-04 22:53:06,718 [salt.loaded.int.module.cmdmod][INFO    ][32460] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-04 22:53:06,781 [salt.state       ][INFO    ][32460] Volume keystone-keys is already started
2017-11-04 22:53:06,781 [salt.state       ][INFO    ][32460] Completed state [keystone-keys] at time 22:53:06.780788 duration_in_ms=130.693
2017-11-04 22:53:06,782 [salt.state       ][INFO    ][32460] Running state [nova_instances] at time 22:53:06.781824
2017-11-04 22:53:06,782 [salt.state       ][INFO    ][32460] Executing state glusterfs.created for nova_instances
2017-11-04 22:53:06,783 [salt.loaded.int.module.cmdmod][INFO    ][32460] Executing command 'gluster --version' in directory '/root'
2017-11-04 22:53:06,790 [salt.loaded.int.module.cmdmod][INFO    ][32460] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-04 22:53:06,844 [salt.loaded.int.module.cmdmod][INFO    ][32460] Executing command 'gluster --version' in directory '/root'
2017-11-04 22:53:06,855 [salt.loaded.int.module.cmdmod][INFO    ][32460] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-04 22:53:06,913 [salt.state       ][INFO    ][32460] Volume nova_instances already exists and is started.
2017-11-04 22:53:06,913 [salt.state       ][INFO    ][32460] Completed state [nova_instances] at time 22:53:06.912864 duration_in_ms=131.04
2017-11-04 22:53:06,918 [salt.state       ][INFO    ][32460] Running state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 22:53:06.917658
2017-11-04 22:53:06,918 [salt.state       ][INFO    ][32460] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'
2017-11-04 22:53:06,919 [salt.loaded.int.module.cmdmod][INFO    ][32460] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-11-04 22:53:06,972 [salt.state       ][INFO    ][32460] unless execution succeeded
2017-11-04 22:53:06,973 [salt.state       ][INFO    ][32460] Completed state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 22:53:06.972528 duration_in_ms=54.87
2017-11-04 22:53:06,973 [salt.state       ][INFO    ][32460] Running state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'On'] at time 22:53:06.973119
2017-11-04 22:53:06,973 [salt.state       ][INFO    ][32460] Executing state cmd.run for gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'On'
2017-11-04 22:53:06,974 [salt.loaded.int.module.cmdmod][INFO    ][32460] Executing command 'gluster volume info 'nova_instances' | grep 'cluster.readdir-optimize: On'' in directory '/root'
2017-11-04 22:53:07,024 [salt.state       ][INFO    ][32460] unless execution succeeded
2017-11-04 22:53:07,025 [salt.state       ][INFO    ][32460] Completed state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'On'] at time 22:53:07.024482 duration_in_ms=51.362
2017-11-04 22:53:07,025 [salt.state       ][INFO    ][32460] Running state [gluster volume set 'nova_instances' 'network.remote-dio' 'On'] at time 22:53:07.025091
2017-11-04 22:53:07,025 [salt.state       ][INFO    ][32460] Executing state cmd.run for gluster volume set 'nova_instances' 'network.remote-dio' 'On'
2017-11-04 22:53:07,026 [salt.loaded.int.module.cmdmod][INFO    ][32460] Executing command 'gluster volume info 'nova_instances' | grep 'network.remote-dio: On'' in directory '/root'
2017-11-04 22:53:07,078 [salt.state       ][INFO    ][32460] unless execution succeeded
2017-11-04 22:53:07,078 [salt.state       ][INFO    ][32460] Completed state [gluster volume set 'nova_instances' 'network.remote-dio' 'On'] at time 22:53:07.077918 duration_in_ms=52.826
2017-11-04 22:53:07,079 [salt.state       ][INFO    ][32460] Running state [gluster volume set 'nova_instances' 'nfs.disable' 'On'] at time 22:53:07.078509
2017-11-04 22:53:07,079 [salt.state       ][INFO    ][32460] Executing state cmd.run for gluster volume set 'nova_instances' 'nfs.disable' 'On'
2017-11-04 22:53:07,079 [salt.loaded.int.module.cmdmod][INFO    ][32460] Executing command 'gluster volume info 'nova_instances' | grep 'nfs.disable: On'' in directory '/root'
2017-11-04 22:53:07,131 [salt.state       ][INFO    ][32460] unless execution succeeded
2017-11-04 22:53:07,132 [salt.state       ][INFO    ][32460] Completed state [gluster volume set 'nova_instances' 'nfs.disable' 'On'] at time 22:53:07.131513 duration_in_ms=53.003
2017-11-04 22:53:07,132 [salt.state       ][INFO    ][32460] Running state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 22:53:07.132105
2017-11-04 22:53:07,132 [salt.state       ][INFO    ][32460] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'
2017-11-04 22:53:07,133 [salt.loaded.int.module.cmdmod][INFO    ][32460] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-11-04 22:53:07,183 [salt.state       ][INFO    ][32460] unless execution succeeded
2017-11-04 22:53:07,183 [salt.state       ][INFO    ][32460] Completed state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 22:53:07.182728 duration_in_ms=50.623
2017-11-04 22:53:07,184 [salt.state       ][INFO    ][32460] Running state [nova_instances] at time 22:53:07.183963
2017-11-04 22:53:07,184 [salt.state       ][INFO    ][32460] Executing state glusterfs.started for nova_instances
2017-11-04 22:53:07,185 [salt.loaded.int.module.cmdmod][INFO    ][32460] Executing command 'gluster --version' in directory '/root'
2017-11-04 22:53:07,191 [salt.loaded.int.module.cmdmod][INFO    ][32460] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-04 22:53:07,243 [salt.loaded.int.module.cmdmod][INFO    ][32460] Executing command 'gluster --version' in directory '/root'
2017-11-04 22:53:07,252 [salt.loaded.int.module.cmdmod][INFO    ][32460] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-04 22:53:07,306 [salt.state       ][INFO    ][32460] Volume nova_instances is already started
2017-11-04 22:53:07,307 [salt.state       ][INFO    ][32460] Completed state [nova_instances] at time 22:53:07.306644 duration_in_ms=122.68
2017-11-04 22:53:07,308 [salt.state       ][INFO    ][32460] Running state [keystone-credential-keys] at time 22:53:07.307743
2017-11-04 22:53:07,308 [salt.state       ][INFO    ][32460] Executing state glusterfs.created for keystone-credential-keys
2017-11-04 22:53:07,308 [salt.loaded.int.module.cmdmod][INFO    ][32460] Executing command 'gluster --version' in directory '/root'
2017-11-04 22:53:07,316 [salt.loaded.int.module.cmdmod][INFO    ][32460] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-04 22:53:07,366 [salt.loaded.int.module.cmdmod][INFO    ][32460] Executing command 'gluster --version' in directory '/root'
2017-11-04 22:53:07,374 [salt.loaded.int.module.cmdmod][INFO    ][32460] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-04 22:53:07,430 [salt.state       ][INFO    ][32460] Volume keystone-credential-keys already exists and is started.
2017-11-04 22:53:07,430 [salt.state       ][INFO    ][32460] Completed state [keystone-credential-keys] at time 22:53:07.430022 duration_in_ms=122.279
2017-11-04 22:53:07,435 [salt.state       ][INFO    ][32460] Running state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 22:53:07.434628
2017-11-04 22:53:07,435 [salt.state       ][INFO    ][32460] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'
2017-11-04 22:53:07,436 [salt.loaded.int.module.cmdmod][INFO    ][32460] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-11-04 22:53:07,491 [salt.state       ][INFO    ][32460] unless execution succeeded
2017-11-04 22:53:07,491 [salt.state       ][INFO    ][32460] Completed state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 22:53:07.491225 duration_in_ms=56.596
2017-11-04 22:53:07,492 [salt.state       ][INFO    ][32460] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 22:53:07.491767
2017-11-04 22:53:07,492 [salt.state       ][INFO    ][32460] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-11-04 22:53:07,493 [salt.loaded.int.module.cmdmod][INFO    ][32460] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-11-04 22:53:07,544 [salt.state       ][INFO    ][32460] unless execution succeeded
2017-11-04 22:53:07,545 [salt.state       ][INFO    ][32460] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 22:53:07.544727 duration_in_ms=52.959
2017-11-04 22:53:07,545 [salt.state       ][INFO    ][32460] Running state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 22:53:07.545419
2017-11-04 22:53:07,546 [salt.state       ][INFO    ][32460] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'
2017-11-04 22:53:07,546 [salt.loaded.int.module.cmdmod][INFO    ][32460] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-11-04 22:53:07,600 [salt.state       ][INFO    ][32460] unless execution succeeded
2017-11-04 22:53:07,600 [salt.state       ][INFO    ][32460] Completed state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 22:53:07.599891 duration_in_ms=54.471
2017-11-04 22:53:07,601 [salt.state       ][INFO    ][32460] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 22:53:07.600526
2017-11-04 22:53:07,601 [salt.state       ][INFO    ][32460] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'
2017-11-04 22:53:07,601 [salt.loaded.int.module.cmdmod][INFO    ][32460] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-11-04 22:53:07,653 [salt.state       ][INFO    ][32460] unless execution succeeded
2017-11-04 22:53:07,653 [salt.state       ][INFO    ][32460] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 22:53:07.653064 duration_in_ms=52.538
2017-11-04 22:53:07,654 [salt.state       ][INFO    ][32460] Running state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 22:53:07.653666
2017-11-04 22:53:07,654 [salt.state       ][INFO    ][32460] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'
2017-11-04 22:53:07,654 [salt.loaded.int.module.cmdmod][INFO    ][32460] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-11-04 22:53:07,707 [salt.state       ][INFO    ][32460] unless execution succeeded
2017-11-04 22:53:07,707 [salt.state       ][INFO    ][32460] Completed state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 22:53:07.707268 duration_in_ms=53.601
2017-11-04 22:53:07,709 [salt.state       ][INFO    ][32460] Running state [keystone-credential-keys] at time 22:53:07.708564
2017-11-04 22:53:07,709 [salt.state       ][INFO    ][32460] Executing state glusterfs.started for keystone-credential-keys
2017-11-04 22:53:07,710 [salt.loaded.int.module.cmdmod][INFO    ][32460] Executing command 'gluster --version' in directory '/root'
2017-11-04 22:53:07,718 [salt.loaded.int.module.cmdmod][INFO    ][32460] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-04 22:53:07,769 [salt.loaded.int.module.cmdmod][INFO    ][32460] Executing command 'gluster --version' in directory '/root'
2017-11-04 22:53:07,776 [salt.loaded.int.module.cmdmod][INFO    ][32460] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-04 22:53:07,834 [salt.state       ][INFO    ][32460] Volume keystone-credential-keys is already started
2017-11-04 22:53:07,834 [salt.state       ][INFO    ][32460] Completed state [keystone-credential-keys] at time 22:53:07.834139 duration_in_ms=125.561
2017-11-04 22:53:07,836 [salt.minion      ][INFO    ][32460] Returning information for job: 20171104225303879512
2017-11-04 22:53:12,935 [salt.minion      ][INFO    ][24259] User sudo_ubuntu Executing command test.ping with jid 20171104225312929351
2017-11-04 22:53:12,949 [salt.minion      ][INFO    ][32844] Starting a new job with PID 32844
2017-11-04 22:53:12,983 [salt.minion      ][INFO    ][32844] Returning information for job: 20171104225312929351
2017-11-04 22:53:13,488 [salt.minion      ][INFO    ][24259] User sudo_ubuntu Executing command cmd.run with jid 20171104225313478757
2017-11-04 22:53:13,498 [salt.minion      ][INFO    ][32849] Starting a new job with PID 32849
2017-11-04 22:53:13,502 [salt.loaded.int.module.cmdmod][INFO    ][32849] Executing command 'gluster peer status; gluster volume status' in directory '/root'
2017-11-04 22:53:13,619 [salt.minion      ][INFO    ][32849] Returning information for job: 20171104225313478757
2017-11-04 22:59:35,408 [salt.utils.schedule][INFO    ][24259] Running scheduled job: __mine_interval
2017-11-04 23:18:16,920 [salt.minion      ][INFO    ][24259] User sudo_ubuntu Executing command cp.push_dir with jid 20171104231816911188
2017-11-04 23:18:16,934 [salt.minion      ][INFO    ][33151] Starting a new job with PID 33151
