2017-11-02 21:34:52,929 [salt.cli.daemons ][WARNING ][2478] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-11-02 21:35:07,455 [salt.state       ][ERROR   ][3928] No contents found in top file
2017-11-02 21:37:01,806 [salt.utils.parsers][WARNING ][2478] Minion received a SIGTERM. Exiting.
2017-11-02 21:41:27,507 [salt.cli.daemons ][WARNING ][3924] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-11-02 21:43:18,369 [salt.loaded.int.module.cmdmod][ERROR   ][11253] Command 'virsh net-destroy default 2>&1 1>/dev/null; virsh net-undefine default' failed with return code: 1
2017-11-02 21:43:18,370 [salt.loaded.int.module.cmdmod][ERROR   ][11253] stderr: error: failed to get network 'default'
error: Network not found: no network with matching name 'default'
2017-11-02 21:43:18,370 [salt.loaded.int.module.cmdmod][ERROR   ][11253] retcode: 1
2017-11-02 21:43:18,370 [salt.state       ][ERROR   ][11253] {'pid': 16148, 'retcode': 1, 'stderr': "error: failed to get network 'default'\nerror: Network not found: no network with matching name 'default'", 'stdout': ''}
2017-11-02 21:43:45,771 [py.warnings      ][WARNING ][16229] /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-02 21:44:09,054 [salt.loaded.int.module.cmdmod][ERROR   ][16229] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-11-02 21:44:09,054 [salt.loaded.int.module.cmdmod][ERROR   ][16229] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-11-02 21:44:13,678 [salt.loaded.int.module.cmdmod][ERROR   ][16229] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-11-02 21:44:13,679 [salt.loaded.int.module.cmdmod][ERROR   ][16229] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-11-02 21:44:18,158 [salt.loaded.int.module.cmdmod][ERROR   ][16229] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-11-02 21:44:18,158 [salt.loaded.int.module.cmdmod][ERROR   ][16229] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-11-02 21:44:22,591 [salt.loaded.int.module.cmdmod][ERROR   ][16229] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-11-02 21:44:22,591 [salt.loaded.int.module.cmdmod][ERROR   ][16229] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-11-02 21:44:27,009 [salt.loaded.int.module.cmdmod][ERROR   ][16229] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-11-02 21:44:27,009 [salt.loaded.int.module.cmdmod][ERROR   ][16229] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-11-02 21:44:30,528 [salt.loaded.int.module.cmdmod][ERROR   ][16229] 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-02 21:44:32,989 [salt.loaded.int.module.cmdmod][INFO    ][24109] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2017-11-02 21:44:32,995 [salt.loaded.int.module.cmdmod][INFO    ][24109] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2017-11-02 21:44:33,004 [salt.loaded.int.module.cmdmod][INFO    ][24109] Executing command ['systemd-run', '--scope', 'systemctl', 'restart', 'salt-minion.service'] in directory '/root'
2017-11-02 21:44:33,012 [salt.utils.parsers][WARNING ][3924] Minion received a SIGTERM. Exiting.
2017-11-02 21:44:33,331 [salt.cli.daemons ][INFO    ][24196] Setting up the Salt Minion "kvm03.baremetal-mcp-ocata-ovs-ha.local"
2017-11-02 21:44:33,995 [salt.minion      ][INFO    ][24196] Creating minion process manager
2017-11-02 21:44:33,995 [salt.cli.daemons ][WARNING ][24196] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-11-02 21:44:33,995 [salt.cli.daemons ][INFO    ][24196] The Salt Minion is starting up
2017-11-02 21:44:33,996 [salt.minion      ][INFO    ][24196] Minion is starting as user 'root'
2017-11-02 21:44:33,996 [salt.utils.event ][INFO    ][24196] Starting pull socket on /var/run/salt/minion/minion_event_98ff1e569f_pull.ipc
2017-11-02 21:44:35,190 [salt.loaded.int.module.cmdmod][INFO    ][24196] Executing command ['date', '+%z'] in directory '/root'
2017-11-02 21:44:35,203 [salt.utils.schedule][INFO    ][24196] Updating job settings for scheduled job: __mine_interval
2017-11-02 21:44:35,207 [salt.minion      ][INFO    ][24196] Added mine.update to scheduler
2017-11-02 21:44:35,227 [salt.minion      ][INFO    ][24196] Minion is ready to receive requests!
2017-11-02 21:44:36,228 [salt.utils.schedule][INFO    ][24196] Running scheduled job: __mine_interval
2017-11-02 21:44:43,417 [salt.minion      ][INFO    ][24196] User sudo_ubuntu Executing command saltutil.find_job with jid 20171102214443406539
2017-11-02 21:44:43,428 [salt.minion      ][INFO    ][24321] Starting a new job with PID 24321
2017-11-02 21:44:43,437 [salt.minion      ][INFO    ][24321] Returning information for job: 20171102214443406539
2017-11-02 21:44:54,307 [salt.minion      ][INFO    ][24196] User sudo_ubuntu Executing command state.sls with jid 20171102214454300587
2017-11-02 21:44:54,317 [salt.minion      ][INFO    ][24326] Starting a new job with PID 24326
2017-11-02 21:44:56,951 [salt.state       ][INFO    ][24326] Loading fresh modules for state activity
2017-11-02 21:44:56,979 [salt.fileclient  ][INFO    ][24326] Fetching file from saltenv 'base', ** done ** 'salt/control/init.sls'
2017-11-02 21:44:57,001 [salt.fileclient  ][INFO    ][24326] Fetching file from saltenv 'base', ** done ** 'salt/control/virt.sls'
2017-11-02 21:44:57,029 [salt.fileclient  ][INFO    ][24326] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-11-02 21:44:57,113 [salt.fileclient  ][INFO    ][24326] Fetching file from saltenv 'base', ** done ** 'salt/minion/init.sls'
2017-11-02 21:44:57,128 [salt.fileclient  ][INFO    ][24326] Fetching file from saltenv 'base', ** done ** 'salt/minion/service.sls'
2017-11-02 21:44:57,157 [salt.fileclient  ][INFO    ][24326] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-11-02 21:44:57,257 [salt.fileclient  ][INFO    ][24326] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-11-02 21:44:57,280 [salt.fileclient  ][INFO    ][24326] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-11-02 21:44:57,339 [salt.fileclient  ][INFO    ][24326] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-11-02 21:44:57,360 [salt.fileclient  ][INFO    ][24326] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-11-02 21:44:57,376 [salt.fileclient  ][INFO    ][24326] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-11-02 21:44:57,392 [salt.fileclient  ][INFO    ][24326] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-11-02 21:44:57,401 [salt.loaded.int.module.cmdmod][INFO    ][24326] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-11-02 21:44:57,423 [salt.fileclient  ][INFO    ][24326] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-11-02 21:44:57,441 [py.warnings      ][WARNING ][24326] /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-02 21:44:57,441 [salt.loaded.int.module.cmdmod][INFO    ][24326] Executing command 'salt-minion --version' in directory '/root'
2017-11-02 21:44:57,701 [salt.fileclient  ][INFO    ][24326] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-11-02 21:44:57,721 [salt.fileclient  ][INFO    ][24326] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-11-02 21:44:57,735 [salt.fileclient  ][INFO    ][24326] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-11-02 21:44:57,748 [salt.fileclient  ][INFO    ][24326] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-11-02 21:44:57,807 [salt.fileclient  ][INFO    ][24326] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-11-02 21:44:57,848 [salt.fileclient  ][INFO    ][24326] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-11-02 21:44:57,917 [salt.fileclient  ][INFO    ][24326] Fetching file from saltenv 'base', ** done ** 'salt/minion/grains.sls'
2017-11-02 21:44:57,941 [salt.fileclient  ][INFO    ][24326] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-11-02 21:44:58,003 [salt.fileclient  ][INFO    ][24326] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-11-02 21:44:58,025 [salt.fileclient  ][INFO    ][24326] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-11-02 21:44:58,083 [salt.fileclient  ][INFO    ][24326] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-11-02 21:44:58,104 [salt.fileclient  ][INFO    ][24326] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-11-02 21:44:58,117 [salt.fileclient  ][INFO    ][24326] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-11-02 21:44:58,135 [salt.fileclient  ][INFO    ][24326] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-11-02 21:44:58,144 [salt.loaded.int.module.cmdmod][INFO    ][24326] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-11-02 21:44:58,163 [salt.fileclient  ][INFO    ][24326] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-11-02 21:44:58,182 [salt.loaded.int.module.cmdmod][INFO    ][24326] Executing command 'salt-minion --version' in directory '/root'
2017-11-02 21:44:58,441 [salt.fileclient  ][INFO    ][24326] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-11-02 21:44:58,461 [salt.fileclient  ][INFO    ][24326] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-11-02 21:44:58,476 [salt.fileclient  ][INFO    ][24326] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-11-02 21:44:58,489 [salt.fileclient  ][INFO    ][24326] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-11-02 21:44:58,549 [salt.fileclient  ][INFO    ][24326] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-11-02 21:44:58,590 [salt.fileclient  ][INFO    ][24326] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-11-02 21:44:58,674 [salt.fileclient  ][INFO    ][24326] Fetching file from saltenv 'base', ** done ** 'salt/minion/cert.sls'
2017-11-02 21:44:58,751 [salt.fileclient  ][INFO    ][24326] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-11-02 21:44:59,106 [salt.state       ][INFO    ][24326] Running state [salt-minion] at time 21:44:59.106031
2017-11-02 21:44:59,106 [salt.state       ][INFO    ][24326] Executing state pkg.installed for salt-minion
2017-11-02 21:44:59,107 [salt.loaded.int.module.cmdmod][INFO    ][24326] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-02 21:44:59,393 [salt.state       ][INFO    ][24326] Package salt-minion is already installed
2017-11-02 21:44:59,393 [salt.state       ][INFO    ][24326] Completed state [salt-minion] at time 21:44:59.392854 duration_in_ms=286.823
2017-11-02 21:44:59,393 [salt.state       ][INFO    ][24326] Running state [salt_minion_dependency_packages] at time 21:44:59.393141
2017-11-02 21:44:59,393 [salt.state       ][INFO    ][24326] Executing state pkg.installed for salt_minion_dependency_packages
2017-11-02 21:44:59,398 [salt.state       ][INFO    ][24326] All specified packages are already installed
2017-11-02 21:44:59,398 [salt.state       ][INFO    ][24326] Completed state [salt_minion_dependency_packages] at time 21:44:59.397642 duration_in_ms=4.501
2017-11-02 21:44:59,400 [salt.state       ][INFO    ][24326] Running state [/etc/salt/minion.d/minion.conf] at time 21:44:59.399539
2017-11-02 21:44:59,400 [salt.state       ][INFO    ][24326] Executing state file.managed for /etc/salt/minion.d/minion.conf
2017-11-02 21:44:59,417 [salt.fileclient  ][INFO    ][24326] Fetching file from saltenv 'base', ** done ** 'salt/files/minion.conf'
2017-11-02 21:44:59,973 [salt.fileclient  ][INFO    ][24326] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-11-02 21:45:00,034 [salt.fileclient  ][INFO    ][24326] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-11-02 21:45:00,085 [salt.state       ][INFO    ][24326] File /etc/salt/minion.d/minion.conf is in the correct state
2017-11-02 21:45:00,085 [salt.state       ][INFO    ][24326] Completed state [/etc/salt/minion.d/minion.conf] at time 21:45:00.085289 duration_in_ms=685.75
2017-11-02 21:45:00,086 [salt.state       ][INFO    ][24326] Running state [/etc/salt/minion.d/_virt.conf] at time 21:45:00.085787
2017-11-02 21:45:00,086 [salt.state       ][INFO    ][24326] Executing state file.managed for /etc/salt/minion.d/_virt.conf
2017-11-02 21:45:00,087 [salt.state       ][INFO    ][24326] File /etc/salt/minion.d/_virt.conf is in the correct state
2017-11-02 21:45:00,087 [salt.state       ][INFO    ][24326] Completed state [/etc/salt/minion.d/_virt.conf] at time 21:45:00.086919 duration_in_ms=1.132
2017-11-02 21:45:00,089 [salt.state       ][INFO    ][24326] Running state [salt-minion] at time 21:45:00.088801
2017-11-02 21:45:00,089 [salt.state       ][INFO    ][24326] Executing state service.running for salt-minion
2017-11-02 21:45:00,090 [salt.loaded.int.module.cmdmod][INFO    ][24326] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2017-11-02 21:45:00,105 [salt.loaded.int.module.cmdmod][INFO    ][24326] Executing command ['systemctl', 'is-active', 'salt-minion.service'] in directory '/root'
2017-11-02 21:45:00,111 [salt.loaded.int.module.cmdmod][INFO    ][24326] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2017-11-02 21:45:00,117 [salt.state       ][INFO    ][24326] The service salt-minion is already running
2017-11-02 21:45:00,117 [salt.state       ][INFO    ][24326] Completed state [salt-minion] at time 21:45:00.117389 duration_in_ms=28.588
2017-11-02 21:45:00,119 [salt.state       ][INFO    ][24326] Running state [/etc/salt/grains.d] at time 21:45:00.119149
2017-11-02 21:45:00,119 [salt.state       ][INFO    ][24326] Executing state file.directory for /etc/salt/grains.d
2017-11-02 21:45:00,120 [salt.state       ][INFO    ][24326] Directory /etc/salt/grains.d is in the correct state
2017-11-02 21:45:00,120 [salt.state       ][INFO    ][24326] Completed state [/etc/salt/grains.d] at time 21:45:00.120225 duration_in_ms=1.076
2017-11-02 21:45:00,121 [salt.state       ][INFO    ][24326] Running state [/etc/salt/grains] at time 21:45:00.120857
2017-11-02 21:45:00,121 [salt.state       ][INFO    ][24326] Executing state file.managed for /etc/salt/grains
2017-11-02 21:45:00,122 [salt.state       ][INFO    ][24326] File /etc/salt/grains exists with proper permissions. No changes made.
2017-11-02 21:45:00,122 [salt.state       ][INFO    ][24326] Completed state [/etc/salt/grains] at time 21:45:00.121674 duration_in_ms=0.817
2017-11-02 21:45:00,122 [salt.state       ][INFO    ][24326] Running state [/etc/salt/grains.d/placeholder] at time 21:45:00.122116
2017-11-02 21:45:00,122 [salt.state       ][INFO    ][24326] Executing state file.managed for /etc/salt/grains.d/placeholder
2017-11-02 21:45:00,123 [salt.state       ][INFO    ][24326] File /etc/salt/grains.d/placeholder exists with proper permissions. No changes made.
2017-11-02 21:45:00,123 [salt.state       ][INFO    ][24326] Completed state [/etc/salt/grains.d/placeholder] at time 21:45:00.122871 duration_in_ms=0.755
2017-11-02 21:45:00,123 [salt.state       ][INFO    ][24326] Running state [/etc/salt/grains.d/sphinx] at time 21:45:00.123282
2017-11-02 21:45:00,124 [salt.state       ][INFO    ][24326] Executing state file.managed for /etc/salt/grains.d/sphinx
2017-11-02 21:45:00,125 [salt.state       ][INFO    ][24326] 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-02 21:45:00,125 [salt.state       ][INFO    ][24326] Completed state [/etc/salt/grains.d/sphinx] at time 21:45:00.125135 duration_in_ms=1.852
2017-11-02 21:45:00,126 [salt.state       ][INFO    ][24326] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 21:45:00.125972
2017-11-02 21:45:00,126 [salt.state       ][INFO    ][24326] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-11-02 21:45:00,126 [salt.state       ][INFO    ][24326] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-11-02 21:45:00,127 [salt.state       ][INFO    ][24326] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 21:45:00.126627 duration_in_ms=0.655
2017-11-02 21:45:00,127 [salt.state       ][INFO    ][24326] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 21:45:00.126789
2017-11-02 21:45:00,127 [salt.state       ][INFO    ][24326] 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-02 21:45:00,128 [salt.loaded.int.module.cmdmod][INFO    ][24326] Executing command 'python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"' in directory '/root'
2017-11-02 21:45:00,204 [salt.state       ][INFO    ][24326] {'pid': 24374, 'retcode': 0, 'stderr': '', 'stdout': ''}
2017-11-02 21:45:00,205 [salt.state       ][INFO    ][24326] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 21:45:00.204835 duration_in_ms=78.044
2017-11-02 21:45:00,205 [salt.state       ][INFO    ][24326] Running state [/etc/salt/grains.d/dns_records] at time 21:45:00.205460
2017-11-02 21:45:00,206 [salt.state       ][INFO    ][24326] Executing state file.managed for /etc/salt/grains.d/dns_records
2017-11-02 21:45:00,207 [salt.state       ][INFO    ][24326] File /etc/salt/grains.d/dns_records is in the correct state
2017-11-02 21:45:00,207 [salt.state       ][INFO    ][24326] Completed state [/etc/salt/grains.d/dns_records] at time 21:45:00.206974 duration_in_ms=1.513
2017-11-02 21:45:00,208 [salt.state       ][INFO    ][24326] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 21:45:00.207869
2017-11-02 21:45:00,208 [salt.state       ][INFO    ][24326] 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-02 21:45:00,208 [salt.state       ][INFO    ][24326] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"
2017-11-02 21:45:00,209 [salt.state       ][INFO    ][24326] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 21:45:00.208495 duration_in_ms=0.627
2017-11-02 21:45:00,209 [salt.state       ][INFO    ][24326] Running state [/etc/salt/grains.d/salt] at time 21:45:00.208910
2017-11-02 21:45:00,209 [salt.state       ][INFO    ][24326] Executing state file.managed for /etc/salt/grains.d/salt
2017-11-02 21:45:00,210 [salt.state       ][INFO    ][24326] File /etc/salt/grains.d/salt is in the correct state
2017-11-02 21:45:00,210 [salt.state       ][INFO    ][24326] Completed state [/etc/salt/grains.d/salt] at time 21:45:00.209988 duration_in_ms=1.078
2017-11-02 21:45:00,211 [salt.state       ][INFO    ][24326] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 21:45:00.210819
2017-11-02 21:45:00,211 [salt.state       ][INFO    ][24326] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2017-11-02 21:45:00,211 [salt.state       ][INFO    ][24326] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2017-11-02 21:45:00,211 [salt.state       ][INFO    ][24326] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 21:45:00.211422 duration_in_ms=0.602
2017-11-02 21:45:00,213 [salt.state       ][INFO    ][24326] Running state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 21:45:00.213151
2017-11-02 21:45:00,213 [salt.state       ][INFO    ][24326] Executing state cmd.wait for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-11-02 21:45:00,214 [salt.state       ][INFO    ][24326] No changes made for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-11-02 21:45:00,214 [salt.state       ][INFO    ][24326] Completed state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 21:45:00.213766 duration_in_ms=0.614
2017-11-02 21:45:00,214 [salt.state       ][INFO    ][24326] Running state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 21:45:00.213926
2017-11-02 21:45:00,214 [salt.state       ][INFO    ][24326] Executing state cmd.mod_watch for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-11-02 21:45:00,216 [salt.loaded.int.module.cmdmod][INFO    ][24326] Executing command 'cat /etc/salt/grains.d/* > /etc/salt/grains' in directory '/root'
2017-11-02 21:45:00,223 [salt.state       ][INFO    ][24326] {'pid': 24376, 'retcode': 0, 'stderr': '', 'stdout': ''}
2017-11-02 21:45:00,223 [salt.state       ][INFO    ][24326] Completed state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 21:45:00.222919 duration_in_ms=8.991
2017-11-02 21:45:00,224 [salt.state       ][INFO    ][24326] Running state [mine.update] at time 21:45:00.223651
2017-11-02 21:45:00,224 [salt.state       ][INFO    ][24326] Executing state module.wait for mine.update
2017-11-02 21:45:00,224 [salt.state       ][INFO    ][24326] No changes made for mine.update
2017-11-02 21:45:00,224 [salt.state       ][INFO    ][24326] Completed state [mine.update] at time 21:45:00.224315 duration_in_ms=0.664
2017-11-02 21:45:00,225 [salt.state       ][INFO    ][24326] Running state [mine.update] at time 21:45:00.224479
2017-11-02 21:45:00,225 [salt.state       ][INFO    ][24326] Executing state module.mod_watch for mine.update
2017-11-02 21:45:00,740 [salt.state       ][INFO    ][24326] {'ret': True}
2017-11-02 21:45:00,740 [salt.state       ][INFO    ][24326] Completed state [mine.update] at time 21:45:00.740423 duration_in_ms=515.942
2017-11-02 21:45:00,741 [salt.state       ][INFO    ][24326] Running state [ca-certificates] at time 21:45:00.740688
2017-11-02 21:45:00,741 [salt.state       ][INFO    ][24326] Executing state pkg.installed for ca-certificates
2017-11-02 21:45:00,745 [salt.state       ][INFO    ][24326] Package ca-certificates is already installed
2017-11-02 21:45:00,745 [salt.state       ][INFO    ][24326] Completed state [ca-certificates] at time 21:45:00.745378 duration_in_ms=4.689
2017-11-02 21:45:00,746 [salt.state       ][INFO    ][24326] Running state [update-ca-certificates] at time 21:45:00.746189
2017-11-02 21:45:00,746 [salt.state       ][INFO    ][24326] Executing state cmd.wait for update-ca-certificates
2017-11-02 21:45:00,747 [salt.state       ][INFO    ][24326] No changes made for update-ca-certificates
2017-11-02 21:45:00,747 [salt.state       ][INFO    ][24326] Completed state [update-ca-certificates] at time 21:45:00.746816 duration_in_ms=0.627
2017-11-02 21:45:00,747 [salt.state       ][INFO    ][24326] Running state [libvirt-dev] at time 21:45:00.747004
2017-11-02 21:45:00,747 [salt.state       ][INFO    ][24326] Executing state pkg.installed for libvirt-dev
2017-11-02 21:45:00,751 [salt.state       ][INFO    ][24326] Package libvirt-dev is already installed
2017-11-02 21:45:00,751 [salt.state       ][INFO    ][24326] Completed state [libvirt-dev] at time 21:45:00.751308 duration_in_ms=4.304
2017-11-02 21:45:00,752 [salt.state       ][INFO    ][24326] Running state [pkg-config] at time 21:45:00.751500
2017-11-02 21:45:00,752 [salt.state       ][INFO    ][24326] Executing state pkg.installed for pkg-config
2017-11-02 21:45:00,756 [salt.state       ][INFO    ][24326] Package pkg-config is already installed
2017-11-02 21:45:00,756 [salt.state       ][INFO    ][24326] Completed state [pkg-config] at time 21:45:00.755694 duration_in_ms=4.194
2017-11-02 21:45:00,756 [salt.state       ][INFO    ][24326] Running state [virtng.init] at time 21:45:00.755905
2017-11-02 21:45:00,756 [salt.state       ][INFO    ][24326] Executing state module.run for virtng.init
2017-11-02 21:45:00,799 [salt.loaded.int.module.cmdmod][INFO    ][24326] Executing command ['git', '--version'] in directory '/root'
2017-11-02 21:45:00,879 [salt.loaded.int.module.cmdmod][INFO    ][24326] Executing command 'virsh list --all --name| grep -E "^mdb03.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-11-02 21:45:00,896 [salt.state       ][INFO    ][24326] unless execution succeeded
2017-11-02 21:45:00,897 [salt.state       ][INFO    ][24326] Completed state [virtng.init] at time 21:45:00.896601 duration_in_ms=140.694
2017-11-02 21:45:00,897 [salt.state       ][INFO    ][24326] Running state [virt.set_autostart] at time 21:45:00.896986
2017-11-02 21:45:00,897 [salt.state       ][INFO    ][24326] Executing state module.run for virt.set_autostart
2017-11-02 21:45:00,900 [salt.loaded.int.module.cmdmod][INFO    ][24326] Executing command 'virsh list --autostart --name| grep -E "^mdb03.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-11-02 21:45:00,918 [salt.state       ][INFO    ][24326] unless execution succeeded
2017-11-02 21:45:00,919 [salt.state       ][INFO    ][24326] Completed state [virt.set_autostart] at time 21:45:00.918767 duration_in_ms=21.779
2017-11-02 21:45:00,919 [salt.state       ][INFO    ][24326] Running state [virtng.init] at time 21:45:00.919165
2017-11-02 21:45:00,920 [salt.state       ][INFO    ][24326] Executing state module.run for virtng.init
2017-11-02 21:45:00,923 [salt.loaded.int.module.cmdmod][INFO    ][24326] Executing command 'virsh list --all --name| grep -E "^dbs03.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-11-02 21:45:00,939 [salt.state       ][INFO    ][24326] unless execution succeeded
2017-11-02 21:45:00,939 [salt.state       ][INFO    ][24326] Completed state [virtng.init] at time 21:45:00.939341 duration_in_ms=20.175
2017-11-02 21:45:00,940 [salt.state       ][INFO    ][24326] Running state [virt.set_autostart] at time 21:45:00.939692
2017-11-02 21:45:00,940 [salt.state       ][INFO    ][24326] Executing state module.run for virt.set_autostart
2017-11-02 21:45:00,943 [salt.loaded.int.module.cmdmod][INFO    ][24326] Executing command 'virsh list --autostart --name| grep -E "^dbs03.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-11-02 21:45:00,958 [salt.state       ][INFO    ][24326] unless execution succeeded
2017-11-02 21:45:00,959 [salt.state       ][INFO    ][24326] Completed state [virt.set_autostart] at time 21:45:00.958681 duration_in_ms=18.988
2017-11-02 21:45:00,959 [salt.state       ][INFO    ][24326] Running state [virtng.init] at time 21:45:00.959029
2017-11-02 21:45:00,959 [salt.state       ][INFO    ][24326] Executing state module.run for virtng.init
2017-11-02 21:45:00,962 [salt.loaded.int.module.cmdmod][INFO    ][24326] Executing command 'virsh list --all --name| grep -E "^prx02.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-11-02 21:45:00,978 [salt.state       ][INFO    ][24326] unless execution succeeded
2017-11-02 21:45:00,978 [salt.state       ][INFO    ][24326] Completed state [virtng.init] at time 21:45:00.977958 duration_in_ms=18.928
2017-11-02 21:45:00,978 [salt.state       ][INFO    ][24326] Running state [virt.set_autostart] at time 21:45:00.978327
2017-11-02 21:45:00,979 [salt.state       ][INFO    ][24326] Executing state module.run for virt.set_autostart
2017-11-02 21:45:00,982 [salt.loaded.int.module.cmdmod][INFO    ][24326] Executing command 'virsh list --autostart --name| grep -E "^prx02.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-11-02 21:45:00,997 [salt.state       ][INFO    ][24326] unless execution succeeded
2017-11-02 21:45:00,997 [salt.state       ][INFO    ][24326] Completed state [virt.set_autostart] at time 21:45:00.997209 duration_in_ms=18.881
2017-11-02 21:45:00,998 [salt.state       ][INFO    ][24326] Running state [virtng.init] at time 21:45:00.997563
2017-11-02 21:45:00,998 [salt.state       ][INFO    ][24326] Executing state module.run for virtng.init
2017-11-02 21:45:01,001 [salt.loaded.int.module.cmdmod][INFO    ][24326] Executing command 'virsh list --all --name| grep -E "^msg03.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-11-02 21:45:01,016 [salt.state       ][INFO    ][24326] unless execution succeeded
2017-11-02 21:45:01,016 [salt.state       ][INFO    ][24326] Completed state [virtng.init] at time 21:45:01.016264 duration_in_ms=18.7
2017-11-02 21:45:01,017 [salt.state       ][INFO    ][24326] Running state [virt.set_autostart] at time 21:45:01.016605
2017-11-02 21:45:01,017 [salt.state       ][INFO    ][24326] Executing state module.run for virt.set_autostart
2017-11-02 21:45:01,020 [salt.loaded.int.module.cmdmod][INFO    ][24326] Executing command 'virsh list --autostart --name| grep -E "^msg03.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-11-02 21:45:01,035 [salt.state       ][INFO    ][24326] unless execution succeeded
2017-11-02 21:45:01,036 [salt.state       ][INFO    ][24326] Completed state [virt.set_autostart] at time 21:45:01.035658 duration_in_ms=19.052
2017-11-02 21:45:01,036 [salt.state       ][INFO    ][24326] Running state [virtng.init] at time 21:45:01.036011
2017-11-02 21:45:01,036 [salt.state       ][INFO    ][24326] Executing state module.run for virtng.init
2017-11-02 21:45:01,039 [salt.loaded.int.module.cmdmod][INFO    ][24326] Executing command 'virsh list --all --name| grep -E "^ctl03.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-11-02 21:45:01,055 [salt.state       ][INFO    ][24326] unless execution succeeded
2017-11-02 21:45:01,055 [salt.state       ][INFO    ][24326] Completed state [virtng.init] at time 21:45:01.054947 duration_in_ms=18.934
2017-11-02 21:45:01,055 [salt.state       ][INFO    ][24326] Running state [virt.set_autostart] at time 21:45:01.055308
2017-11-02 21:45:01,056 [salt.state       ][INFO    ][24326] Executing state module.run for virt.set_autostart
2017-11-02 21:45:01,059 [salt.loaded.int.module.cmdmod][INFO    ][24326] Executing command 'virsh list --autostart --name| grep -E "^ctl03.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-11-02 21:45:01,074 [salt.state       ][INFO    ][24326] unless execution succeeded
2017-11-02 21:45:01,074 [salt.state       ][INFO    ][24326] Completed state [virt.set_autostart] at time 21:45:01.074183 duration_in_ms=18.874
2017-11-02 21:45:01,078 [salt.minion      ][INFO    ][24326] Returning information for job: 20171102214454300587
2017-11-02 21:45:27,513 [salt.minion      ][INFO    ][24196] User sudo_ubuntu Executing command saltutil.sync_all with jid 20171102214527505192
2017-11-02 21:45:27,526 [salt.minion      ][INFO    ][24442] Starting a new job with PID 24442
2017-11-02 21:45:31,788 [salt.state       ][INFO    ][24442] Loading fresh modules for state activity
2017-11-02 21:45:31,813 [salt.state       ][ERROR   ][24442] No contents found in top file
2017-11-02 21:45:31,814 [salt.utils.extmods][INFO    ][24442] Creating module dir '/var/cache/salt/minion/extmods/beacons'
2017-11-02 21:45:31,817 [salt.utils.extmods][INFO    ][24442] Syncing beacons for environment 'base'
2017-11-02 21:45:31,817 [salt.utils.extmods][INFO    ][24442] Loading cache from salt://_beacons, for base)
2017-11-02 21:45:31,818 [salt.fileclient  ][INFO    ][24442] Caching directory '_beacons/' for environment 'base'
2017-11-02 21:45:31,866 [salt.utils.extmods][INFO    ][24442] Syncing modules for environment 'base'
2017-11-02 21:45:31,866 [salt.utils.extmods][INFO    ][24442] Loading cache from salt://_modules, for base)
2017-11-02 21:45:31,866 [salt.fileclient  ][INFO    ][24442] Caching directory '_modules/' for environment 'base'
2017-11-02 21:45:32,444 [salt.fileclient  ][INFO    ][24442] Fetching file from saltenv 'base', ** done ** '_modules/ceph_ng.py'
2017-11-02 21:45:32,463 [salt.fileclient  ][INFO    ][24442] Fetching file from saltenv 'base', ** done ** '_modules/cinderng.py'
2017-11-02 21:45:32,485 [salt.fileclient  ][INFO    ][24442] Fetching file from saltenv 'base', ** done ** '_modules/contrail.py'
2017-11-02 21:45:32,501 [salt.fileclient  ][INFO    ][24442] Fetching file from saltenv 'base', ** done ** '_modules/creds.py'
2017-11-02 21:45:32,523 [salt.fileclient  ][INFO    ][24442] Fetching file from saltenv 'base', ** done ** '_modules/devops_utils.py'
2017-11-02 21:45:32,546 [salt.fileclient  ][INFO    ][24442] Fetching file from saltenv 'base', ** done ** '_modules/encode_json.py'
2017-11-02 21:45:32,566 [salt.fileclient  ][INFO    ][24442] Fetching file from saltenv 'base', ** done ** '_modules/gerrit.py'
2017-11-02 21:45:32,583 [salt.fileclient  ][INFO    ][24442] Fetching file from saltenv 'base', ** done ** '_modules/glanceng.py'
2017-11-02 21:45:32,598 [salt.fileclient  ][INFO    ][24442] Fetching file from saltenv 'base', ** done ** '_modules/heat.py'
2017-11-02 21:45:32,616 [salt.fileclient  ][INFO    ][24442] Fetching file from saltenv 'base', ** done ** '_modules/heka_alarming.py'
2017-11-02 21:45:32,654 [salt.fileclient  ][INFO    ][24442] Fetching file from saltenv 'base', ** done ** '_modules/helm.py'
2017-11-02 21:45:32,682 [salt.fileclient  ][INFO    ][24442] Fetching file from saltenv 'base', ** done ** '_modules/jenkins_common.py'
2017-11-02 21:45:32,692 [salt.fileclient  ][INFO    ][24442] Fetching file from saltenv 'base', ** done ** '_modules/keystone_policy.py'
2017-11-02 21:45:32,721 [salt.fileclient  ][INFO    ][24442] Fetching file from saltenv 'base', ** done ** '_modules/linux_hosts.py'
2017-11-02 21:45:32,731 [salt.fileclient  ][INFO    ][24442] Fetching file from saltenv 'base', ** done ** '_modules/linux_netlink.py'
2017-11-02 21:45:32,766 [salt.fileclient  ][INFO    ][24442] Fetching file from saltenv 'base', ** done ** '_modules/maas.py'
2017-11-02 21:45:32,778 [salt.fileclient  ][INFO    ][24442] Fetching file from saltenv 'base', ** done ** '_modules/maas_client.py'
2017-11-02 21:45:32,805 [salt.fileclient  ][INFO    ][24442] Fetching file from saltenv 'base', ** done ** '_modules/modelutils.py'
2017-11-02 21:45:32,863 [salt.fileclient  ][INFO    ][24442] Fetching file from saltenv 'base', ** done ** '_modules/multipart.py'
2017-11-02 21:45:32,881 [salt.fileclient  ][INFO    ][24442] Fetching file from saltenv 'base', ** done ** '_modules/nagios_alarming.py'
2017-11-02 21:45:32,891 [salt.fileclient  ][INFO    ][24442] Fetching file from saltenv 'base', ** done ** '_modules/neutronng.py'
2017-11-02 21:45:32,909 [salt.fileclient  ][INFO    ][24442] Fetching file from saltenv 'base', ** done ** '_modules/novang.py'
2017-11-02 21:45:32,919 [salt.fileclient  ][INFO    ][24442] Fetching file from saltenv 'base', ** done ** '_modules/reclass.py'
2017-11-02 21:45:32,936 [salt.fileclient  ][INFO    ][24442] Fetching file from saltenv 'base', ** done ** '_modules/rsyslog_util.py'
2017-11-02 21:45:32,952 [salt.fileclient  ][INFO    ][24442] Fetching file from saltenv 'base', ** done ** '_modules/rundeck.py'
2017-11-02 21:45:32,995 [salt.fileclient  ][INFO    ][24442] Fetching file from saltenv 'base', ** done ** '_modules/saltkey.py'
2017-11-02 21:45:33,013 [salt.fileclient  ][INFO    ][24442] Fetching file from saltenv 'base', ** done ** '_modules/saltresource.py'
2017-11-02 21:45:33,057 [salt.fileclient  ][INFO    ][24442] Fetching file from saltenv 'base', ** done ** '_modules/seedng.py'
2017-11-02 21:45:33,079 [salt.fileclient  ][INFO    ][24442] Fetching file from saltenv 'base', ** done ** '_modules/testing/credentials.py'
2017-11-02 21:45:33,149 [salt.fileclient  ][INFO    ][24442] Fetching file from saltenv 'base', ** done ** '_modules/testing/django.py'
2017-11-02 21:45:33,162 [salt.fileclient  ][INFO    ][24442] Fetching file from saltenv 'base', ** done ** '_modules/testing/django_client_proxy.py'
2017-11-02 21:45:33,172 [salt.fileclient  ][INFO    ][24442] Fetching file from saltenv 'base', ** done ** '_modules/utils.py'
2017-11-02 21:45:33,181 [salt.fileclient  ][INFO    ][24442] Fetching file from saltenv 'base', ** done ** '_modules/virtng.py'
2017-11-02 21:45:33,186 [salt.utils.extmods][INFO    ][24442] Copying '/var/cache/salt/minion/files/base/_modules/__init__.py' to '/var/cache/salt/minion/extmods/modules/__init__.py'
2017-11-02 21:45:33,186 [salt.utils.extmods][INFO    ][24442] Copying '/var/cache/salt/minion/files/base/_modules/ceph_ng.py' to '/var/cache/salt/minion/extmods/modules/ceph_ng.py'
2017-11-02 21:45:33,186 [salt.utils.extmods][INFO    ][24442] Copying '/var/cache/salt/minion/files/base/_modules/cinderng.py' to '/var/cache/salt/minion/extmods/modules/cinderng.py'
2017-11-02 21:45:33,186 [salt.utils.extmods][INFO    ][24442] Copying '/var/cache/salt/minion/files/base/_modules/contrail.py' to '/var/cache/salt/minion/extmods/modules/contrail.py'
2017-11-02 21:45:33,187 [salt.utils.extmods][INFO    ][24442] Copying '/var/cache/salt/minion/files/base/_modules/creds.py' to '/var/cache/salt/minion/extmods/modules/creds.py'
2017-11-02 21:45:33,187 [salt.utils.extmods][INFO    ][24442] Copying '/var/cache/salt/minion/files/base/_modules/devops_utils.py' to '/var/cache/salt/minion/extmods/modules/devops_utils.py'
2017-11-02 21:45:33,187 [salt.utils.extmods][INFO    ][24442] Copying '/var/cache/salt/minion/files/base/_modules/encode_json.py' to '/var/cache/salt/minion/extmods/modules/encode_json.py'
2017-11-02 21:45:33,188 [salt.utils.extmods][INFO    ][24442] Copying '/var/cache/salt/minion/files/base/_modules/gerrit.py' to '/var/cache/salt/minion/extmods/modules/gerrit.py'
2017-11-02 21:45:33,188 [salt.utils.extmods][INFO    ][24442] Copying '/var/cache/salt/minion/files/base/_modules/glanceng.py' to '/var/cache/salt/minion/extmods/modules/glanceng.py'
2017-11-02 21:45:33,188 [salt.utils.extmods][INFO    ][24442] Copying '/var/cache/salt/minion/files/base/_modules/heat.py' to '/var/cache/salt/minion/extmods/modules/heat.py'
2017-11-02 21:45:33,189 [salt.utils.extmods][INFO    ][24442] Copying '/var/cache/salt/minion/files/base/_modules/heka_alarming.py' to '/var/cache/salt/minion/extmods/modules/heka_alarming.py'
2017-11-02 21:45:33,189 [salt.utils.extmods][INFO    ][24442] Copying '/var/cache/salt/minion/files/base/_modules/helm.py' to '/var/cache/salt/minion/extmods/modules/helm.py'
2017-11-02 21:45:33,189 [salt.utils.extmods][INFO    ][24442] Copying '/var/cache/salt/minion/files/base/_modules/jenkins_common.py' to '/var/cache/salt/minion/extmods/modules/jenkins_common.py'
2017-11-02 21:45:33,189 [salt.utils.extmods][INFO    ][24442] Copying '/var/cache/salt/minion/files/base/_modules/keystone_policy.py' to '/var/cache/salt/minion/extmods/modules/keystone_policy.py'
2017-11-02 21:45:33,190 [salt.utils.extmods][INFO    ][24442] Copying '/var/cache/salt/minion/files/base/_modules/linux_hosts.py' to '/var/cache/salt/minion/extmods/modules/linux_hosts.py'
2017-11-02 21:45:33,190 [salt.utils.extmods][INFO    ][24442] Copying '/var/cache/salt/minion/files/base/_modules/linux_netlink.py' to '/var/cache/salt/minion/extmods/modules/linux_netlink.py'
2017-11-02 21:45:33,190 [salt.utils.extmods][INFO    ][24442] Copying '/var/cache/salt/minion/files/base/_modules/maas.py' to '/var/cache/salt/minion/extmods/modules/maas.py'
2017-11-02 21:45:33,191 [salt.utils.extmods][INFO    ][24442] Copying '/var/cache/salt/minion/files/base/_modules/maas_client.py' to '/var/cache/salt/minion/extmods/modules/maas_client.py'
2017-11-02 21:45:33,191 [salt.utils.extmods][INFO    ][24442] Copying '/var/cache/salt/minion/files/base/_modules/modelutils.py' to '/var/cache/salt/minion/extmods/modules/modelutils.py'
2017-11-02 21:45:33,191 [salt.utils.extmods][INFO    ][24442] Copying '/var/cache/salt/minion/files/base/_modules/multipart.py' to '/var/cache/salt/minion/extmods/modules/multipart.py'
2017-11-02 21:45:33,191 [salt.utils.extmods][INFO    ][24442] Copying '/var/cache/salt/minion/files/base/_modules/nagios_alarming.py' to '/var/cache/salt/minion/extmods/modules/nagios_alarming.py'
2017-11-02 21:45:33,192 [salt.utils.extmods][INFO    ][24442] Copying '/var/cache/salt/minion/files/base/_modules/neutronng.py' to '/var/cache/salt/minion/extmods/modules/neutronng.py'
2017-11-02 21:45:33,192 [salt.utils.extmods][INFO    ][24442] Copying '/var/cache/salt/minion/files/base/_modules/novang.py' to '/var/cache/salt/minion/extmods/modules/novang.py'
2017-11-02 21:45:33,192 [salt.utils.extmods][INFO    ][24442] Copying '/var/cache/salt/minion/files/base/_modules/reclass.py' to '/var/cache/salt/minion/extmods/modules/reclass.py'
2017-11-02 21:45:33,193 [salt.utils.extmods][INFO    ][24442] Copying '/var/cache/salt/minion/files/base/_modules/rsyslog_util.py' to '/var/cache/salt/minion/extmods/modules/rsyslog_util.py'
2017-11-02 21:45:33,193 [salt.utils.extmods][INFO    ][24442] Copying '/var/cache/salt/minion/files/base/_modules/rundeck.py' to '/var/cache/salt/minion/extmods/modules/rundeck.py'
2017-11-02 21:45:33,193 [salt.utils.extmods][INFO    ][24442] Copying '/var/cache/salt/minion/files/base/_modules/saltkey.py' to '/var/cache/salt/minion/extmods/modules/saltkey.py'
2017-11-02 21:45:33,193 [salt.utils.extmods][INFO    ][24442] Copying '/var/cache/salt/minion/files/base/_modules/saltresource.py' to '/var/cache/salt/minion/extmods/modules/saltresource.py'
2017-11-02 21:45:33,194 [salt.utils.extmods][INFO    ][24442] Copying '/var/cache/salt/minion/files/base/_modules/seedng.py' to '/var/cache/salt/minion/extmods/modules/seedng.py'
2017-11-02 21:45:33,194 [salt.utils.extmods][INFO    ][24442] Copying '/var/cache/salt/minion/files/base/_modules/testing/__init__.py' to '/var/cache/salt/minion/extmods/modules/testing/__init__.py'
2017-11-02 21:45:33,194 [salt.utils.extmods][INFO    ][24442] Copying '/var/cache/salt/minion/files/base/_modules/testing/credentials.py' to '/var/cache/salt/minion/extmods/modules/testing/credentials.py'
2017-11-02 21:45:33,195 [salt.utils.extmods][INFO    ][24442] Copying '/var/cache/salt/minion/files/base/_modules/testing/django.py' to '/var/cache/salt/minion/extmods/modules/testing/django.py'
2017-11-02 21:45:33,195 [salt.utils.extmods][INFO    ][24442] 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-02 21:45:33,195 [salt.utils.extmods][INFO    ][24442] Copying '/var/cache/salt/minion/files/base/_modules/utils.py' to '/var/cache/salt/minion/extmods/modules/utils.py'
2017-11-02 21:45:33,195 [salt.utils.extmods][INFO    ][24442] Copying '/var/cache/salt/minion/files/base/_modules/virtng.py' to '/var/cache/salt/minion/extmods/modules/virtng.py'
2017-11-02 21:45:33,201 [salt.utils.extmods][INFO    ][24442] Syncing states for environment 'base'
2017-11-02 21:45:33,202 [salt.utils.extmods][INFO    ][24442] Loading cache from salt://_states, for base)
2017-11-02 21:45:33,202 [salt.fileclient  ][INFO    ][24442] Caching directory '_states/' for environment 'base'
2017-11-02 21:45:33,279 [salt.fileclient  ][INFO    ][24442] Fetching file from saltenv 'base', ** done ** '_states/cinderng.py'
2017-11-02 21:45:33,305 [salt.fileclient  ][INFO    ][24442] Fetching file from saltenv 'base', ** done ** '_states/contrail.py'
2017-11-02 21:45:33,334 [salt.fileclient  ][INFO    ][24442] Fetching file from saltenv 'base', ** done ** '_states/gerrit.py'
2017-11-02 21:45:33,380 [salt.fileclient  ][INFO    ][24442] Fetching file from saltenv 'base', ** done ** '_states/glanceng.py'
2017-11-02 21:45:33,399 [salt.fileclient  ][INFO    ][24442] Fetching file from saltenv 'base', ** done ** '_states/grafana3_dashboard.py'
2017-11-02 21:45:33,410 [salt.fileclient  ][INFO    ][24442] Fetching file from saltenv 'base', ** done ** '_states/grafana3_datasource.py'
2017-11-02 21:45:33,422 [salt.fileclient  ][INFO    ][24442] Fetching file from saltenv 'base', ** done ** '_states/heat.py'
2017-11-02 21:45:33,436 [salt.fileclient  ][INFO    ][24442] Fetching file from saltenv 'base', ** done ** '_states/helm_release.py'
2017-11-02 21:45:33,456 [salt.fileclient  ][INFO    ][24442] Fetching file from saltenv 'base', ** done ** '_states/jenkins_approval.py'
2017-11-02 21:45:33,476 [salt.fileclient  ][INFO    ][24442] Fetching file from saltenv 'base', ** done ** '_states/jenkins_artifactory.py'
2017-11-02 21:45:33,487 [salt.fileclient  ][INFO    ][24442] Fetching file from saltenv 'base', ** done ** '_states/jenkins_credential.py'
2017-11-02 21:45:33,500 [salt.fileclient  ][INFO    ][24442] Fetching file from saltenv 'base', ** done ** '_states/jenkins_job.py'
2017-11-02 21:45:33,527 [salt.fileclient  ][INFO    ][24442] Fetching file from saltenv 'base', ** done ** '_states/jenkins_lib.py'
2017-11-02 21:45:33,545 [salt.fileclient  ][INFO    ][24442] Fetching file from saltenv 'base', ** done ** '_states/jenkins_node.py'
2017-11-02 21:45:33,559 [salt.fileclient  ][INFO    ][24442] Fetching file from saltenv 'base', ** done ** '_states/jenkins_plugin.py'
2017-11-02 21:45:33,576 [salt.fileclient  ][INFO    ][24442] Fetching file from saltenv 'base', ** done ** '_states/jenkins_security.py'
2017-11-02 21:45:33,595 [salt.fileclient  ][INFO    ][24442] Fetching file from saltenv 'base', ** done ** '_states/jenkins_slack.py'
2017-11-02 21:45:33,624 [salt.fileclient  ][INFO    ][24442] Fetching file from saltenv 'base', ** done ** '_states/jenkins_smtp.py'
2017-11-02 21:45:33,641 [salt.fileclient  ][INFO    ][24442] Fetching file from saltenv 'base', ** done ** '_states/jenkins_theme.py'
2017-11-02 21:45:33,655 [salt.fileclient  ][INFO    ][24442] Fetching file from saltenv 'base', ** done ** '_states/jenkins_user.py'
2017-11-02 21:45:33,668 [salt.fileclient  ][INFO    ][24442] Fetching file from saltenv 'base', ** done ** '_states/jenkins_view.py'
2017-11-02 21:45:33,687 [salt.fileclient  ][INFO    ][24442] Fetching file from saltenv 'base', ** done ** '_states/keystone_policy.py'
2017-11-02 21:45:33,730 [salt.fileclient  ][INFO    ][24442] Fetching file from saltenv 'base', ** done ** '_states/kibana_object.py'
2017-11-02 21:45:33,759 [salt.fileclient  ][INFO    ][24442] Fetching file from saltenv 'base', ** done ** '_states/neutronng.py'
2017-11-02 21:45:33,787 [salt.fileclient  ][INFO    ][24442] Fetching file from saltenv 'base', ** done ** '_states/novang.py'
2017-11-02 21:45:33,810 [salt.fileclient  ][INFO    ][24442] Fetching file from saltenv 'base', ** done ** '_states/reclass.py'
2017-11-02 21:45:33,833 [salt.fileclient  ][INFO    ][24442] Fetching file from saltenv 'base', ** done ** '_states/rundeck_project.py'
2017-11-02 21:45:33,847 [salt.fileclient  ][INFO    ][24442] Fetching file from saltenv 'base', ** done ** '_states/rundeck_scm.py'
2017-11-02 21:45:33,858 [salt.fileclient  ][INFO    ][24442] Fetching file from saltenv 'base', ** done ** '_states/rundeck_secret.py'
2017-11-02 21:45:33,862 [salt.utils.extmods][INFO    ][24442] Copying '/var/cache/salt/minion/files/base/_states/cinderng.py' to '/var/cache/salt/minion/extmods/states/cinderng.py'
2017-11-02 21:45:33,863 [salt.utils.extmods][INFO    ][24442] Copying '/var/cache/salt/minion/files/base/_states/contrail.py' to '/var/cache/salt/minion/extmods/states/contrail.py'
2017-11-02 21:45:33,863 [salt.utils.extmods][INFO    ][24442] Copying '/var/cache/salt/minion/files/base/_states/gerrit.py' to '/var/cache/salt/minion/extmods/states/gerrit.py'
2017-11-02 21:45:33,863 [salt.utils.extmods][INFO    ][24442] Copying '/var/cache/salt/minion/files/base/_states/glanceng.py' to '/var/cache/salt/minion/extmods/states/glanceng.py'
2017-11-02 21:45:33,864 [salt.utils.extmods][INFO    ][24442] Copying '/var/cache/salt/minion/files/base/_states/grafana3_dashboard.py' to '/var/cache/salt/minion/extmods/states/grafana3_dashboard.py'
2017-11-02 21:45:33,864 [salt.utils.extmods][INFO    ][24442] Copying '/var/cache/salt/minion/files/base/_states/grafana3_datasource.py' to '/var/cache/salt/minion/extmods/states/grafana3_datasource.py'
2017-11-02 21:45:33,864 [salt.utils.extmods][INFO    ][24442] Copying '/var/cache/salt/minion/files/base/_states/heat.py' to '/var/cache/salt/minion/extmods/states/heat.py'
2017-11-02 21:45:33,865 [salt.utils.extmods][INFO    ][24442] Copying '/var/cache/salt/minion/files/base/_states/helm_release.py' to '/var/cache/salt/minion/extmods/states/helm_release.py'
2017-11-02 21:45:33,865 [salt.utils.extmods][INFO    ][24442] Copying '/var/cache/salt/minion/files/base/_states/jenkins_approval.py' to '/var/cache/salt/minion/extmods/states/jenkins_approval.py'
2017-11-02 21:45:33,865 [salt.utils.extmods][INFO    ][24442] Copying '/var/cache/salt/minion/files/base/_states/jenkins_artifactory.py' to '/var/cache/salt/minion/extmods/states/jenkins_artifactory.py'
2017-11-02 21:45:33,865 [salt.utils.extmods][INFO    ][24442] Copying '/var/cache/salt/minion/files/base/_states/jenkins_credential.py' to '/var/cache/salt/minion/extmods/states/jenkins_credential.py'
2017-11-02 21:45:33,866 [salt.utils.extmods][INFO    ][24442] Copying '/var/cache/salt/minion/files/base/_states/jenkins_job.py' to '/var/cache/salt/minion/extmods/states/jenkins_job.py'
2017-11-02 21:45:33,866 [salt.utils.extmods][INFO    ][24442] Copying '/var/cache/salt/minion/files/base/_states/jenkins_lib.py' to '/var/cache/salt/minion/extmods/states/jenkins_lib.py'
2017-11-02 21:45:33,866 [salt.utils.extmods][INFO    ][24442] Copying '/var/cache/salt/minion/files/base/_states/jenkins_node.py' to '/var/cache/salt/minion/extmods/states/jenkins_node.py'
2017-11-02 21:45:33,866 [salt.utils.extmods][INFO    ][24442] Copying '/var/cache/salt/minion/files/base/_states/jenkins_plugin.py' to '/var/cache/salt/minion/extmods/states/jenkins_plugin.py'
2017-11-02 21:45:33,867 [salt.utils.extmods][INFO    ][24442] Copying '/var/cache/salt/minion/files/base/_states/jenkins_security.py' to '/var/cache/salt/minion/extmods/states/jenkins_security.py'
2017-11-02 21:45:33,867 [salt.utils.extmods][INFO    ][24442] Copying '/var/cache/salt/minion/files/base/_states/jenkins_slack.py' to '/var/cache/salt/minion/extmods/states/jenkins_slack.py'
2017-11-02 21:45:33,867 [salt.utils.extmods][INFO    ][24442] Copying '/var/cache/salt/minion/files/base/_states/jenkins_smtp.py' to '/var/cache/salt/minion/extmods/states/jenkins_smtp.py'
2017-11-02 21:45:33,867 [salt.utils.extmods][INFO    ][24442] Copying '/var/cache/salt/minion/files/base/_states/jenkins_theme.py' to '/var/cache/salt/minion/extmods/states/jenkins_theme.py'
2017-11-02 21:45:33,868 [salt.utils.extmods][INFO    ][24442] Copying '/var/cache/salt/minion/files/base/_states/jenkins_user.py' to '/var/cache/salt/minion/extmods/states/jenkins_user.py'
2017-11-02 21:45:33,868 [salt.utils.extmods][INFO    ][24442] Copying '/var/cache/salt/minion/files/base/_states/jenkins_view.py' to '/var/cache/salt/minion/extmods/states/jenkins_view.py'
2017-11-02 21:45:33,868 [salt.utils.extmods][INFO    ][24442] Copying '/var/cache/salt/minion/files/base/_states/keystone_policy.py' to '/var/cache/salt/minion/extmods/states/keystone_policy.py'
2017-11-02 21:45:33,869 [salt.utils.extmods][INFO    ][24442] Copying '/var/cache/salt/minion/files/base/_states/kibana_object.py' to '/var/cache/salt/minion/extmods/states/kibana_object.py'
2017-11-02 21:45:33,869 [salt.utils.extmods][INFO    ][24442] Copying '/var/cache/salt/minion/files/base/_states/maas_cluster.py' to '/var/cache/salt/minion/extmods/states/maas_cluster.py'
2017-11-02 21:45:33,869 [salt.utils.extmods][INFO    ][24442] Copying '/var/cache/salt/minion/files/base/_states/neutronng.py' to '/var/cache/salt/minion/extmods/states/neutronng.py'
2017-11-02 21:45:33,869 [salt.utils.extmods][INFO    ][24442] Copying '/var/cache/salt/minion/files/base/_states/novang.py' to '/var/cache/salt/minion/extmods/states/novang.py'
2017-11-02 21:45:33,870 [salt.utils.extmods][INFO    ][24442] Copying '/var/cache/salt/minion/files/base/_states/reclass.py' to '/var/cache/salt/minion/extmods/states/reclass.py'
2017-11-02 21:45:33,870 [salt.utils.extmods][INFO    ][24442] Copying '/var/cache/salt/minion/files/base/_states/rundeck_project.py' to '/var/cache/salt/minion/extmods/states/rundeck_project.py'
2017-11-02 21:45:33,870 [salt.utils.extmods][INFO    ][24442] Copying '/var/cache/salt/minion/files/base/_states/rundeck_scm.py' to '/var/cache/salt/minion/extmods/states/rundeck_scm.py'
2017-11-02 21:45:33,870 [salt.utils.extmods][INFO    ][24442] Copying '/var/cache/salt/minion/files/base/_states/rundeck_secret.py' to '/var/cache/salt/minion/extmods/states/rundeck_secret.py'
2017-11-02 21:45:33,873 [salt.utils.extmods][INFO    ][24442] Creating module dir '/var/cache/salt/minion/extmods/sdb'
2017-11-02 21:45:33,877 [salt.utils.extmods][INFO    ][24442] Syncing sdb for environment 'base'
2017-11-02 21:45:33,877 [salt.utils.extmods][INFO    ][24442] Loading cache from salt://_sdb, for base)
2017-11-02 21:45:33,877 [salt.fileclient  ][INFO    ][24442] Caching directory '_sdb/' for environment 'base'
2017-11-02 21:45:33,919 [salt.utils.extmods][INFO    ][24442] Syncing grains for environment 'base'
2017-11-02 21:45:33,919 [salt.utils.extmods][INFO    ][24442] Loading cache from salt://_grains, for base)
2017-11-02 21:45:33,920 [salt.fileclient  ][INFO    ][24442] Caching directory '_grains/' for environment 'base'
2017-11-02 21:45:33,996 [salt.fileclient  ][INFO    ][24442] Fetching file from saltenv 'base', ** done ** '_grains/ceilometer_policy.py'
2017-11-02 21:45:34,023 [salt.fileclient  ][INFO    ][24442] Fetching file from saltenv 'base', ** done ** '_grains/ceph.py'
2017-11-02 21:45:34,050 [salt.fileclient  ][INFO    ][24442] Fetching file from saltenv 'base', ** done ** '_grains/cinder_policy.py'
2017-11-02 21:45:34,068 [salt.fileclient  ][INFO    ][24442] Fetching file from saltenv 'base', ** done ** '_grains/docker_swarm.py'
2017-11-02 21:45:34,083 [salt.fileclient  ][INFO    ][24442] Fetching file from saltenv 'base', ** done ** '_grains/glance_policy.py'
2017-11-02 21:45:34,101 [salt.fileclient  ][INFO    ][24442] Fetching file from saltenv 'base', ** done ** '_grains/heat_policy.py'
2017-11-02 21:45:34,115 [salt.fileclient  ][INFO    ][24442] Fetching file from saltenv 'base', ** done ** '_grains/jenkins_plugins.py'
2017-11-02 21:45:34,133 [salt.fileclient  ][INFO    ][24442] Fetching file from saltenv 'base', ** done ** '_grains/keystone_policy.py'
2017-11-02 21:45:34,174 [salt.fileclient  ][INFO    ][24442] Fetching file from saltenv 'base', ** done ** '_grains/kubernetes.py'
2017-11-02 21:45:34,225 [salt.fileclient  ][INFO    ][24442] Fetching file from saltenv 'base', ** done ** '_grains/neutron_policy.py'
2017-11-02 21:45:34,244 [salt.fileclient  ][INFO    ][24442] Fetching file from saltenv 'base', ** done ** '_grains/nova_policy.py'
2017-11-02 21:45:34,264 [salt.fileclient  ][INFO    ][24442] Fetching file from saltenv 'base', ** done ** '_grains/ssh_fingerprints.py'
2017-11-02 21:45:34,268 [salt.utils.extmods][INFO    ][24442] Copying '/var/cache/salt/minion/files/base/_grains/ceilometer_policy.py' to '/var/cache/salt/minion/extmods/grains/ceilometer_policy.py'
2017-11-02 21:45:34,268 [salt.utils.extmods][INFO    ][24442] Copying '/var/cache/salt/minion/files/base/_grains/ceph.py' to '/var/cache/salt/minion/extmods/grains/ceph.py'
2017-11-02 21:45:34,269 [salt.utils.extmods][INFO    ][24442] Copying '/var/cache/salt/minion/files/base/_grains/cinder_policy.py' to '/var/cache/salt/minion/extmods/grains/cinder_policy.py'
2017-11-02 21:45:34,269 [salt.utils.extmods][INFO    ][24442] Copying '/var/cache/salt/minion/files/base/_grains/docker_swarm.py' to '/var/cache/salt/minion/extmods/grains/docker_swarm.py'
2017-11-02 21:45:34,269 [salt.utils.extmods][INFO    ][24442] Copying '/var/cache/salt/minion/files/base/_grains/glance_policy.py' to '/var/cache/salt/minion/extmods/grains/glance_policy.py'
2017-11-02 21:45:34,269 [salt.utils.extmods][INFO    ][24442] Copying '/var/cache/salt/minion/files/base/_grains/heat_policy.py' to '/var/cache/salt/minion/extmods/grains/heat_policy.py'
2017-11-02 21:45:34,270 [salt.utils.extmods][INFO    ][24442] Copying '/var/cache/salt/minion/files/base/_grains/jenkins_plugins.py' to '/var/cache/salt/minion/extmods/grains/jenkins_plugins.py'
2017-11-02 21:45:34,270 [salt.utils.extmods][INFO    ][24442] Copying '/var/cache/salt/minion/files/base/_grains/keystone_policy.py' to '/var/cache/salt/minion/extmods/grains/keystone_policy.py'
2017-11-02 21:45:34,270 [salt.utils.extmods][INFO    ][24442] Copying '/var/cache/salt/minion/files/base/_grains/kubernetes.py' to '/var/cache/salt/minion/extmods/grains/kubernetes.py'
2017-11-02 21:45:34,270 [salt.utils.extmods][INFO    ][24442] Copying '/var/cache/salt/minion/files/base/_grains/neutron_policy.py' to '/var/cache/salt/minion/extmods/grains/neutron_policy.py'
2017-11-02 21:45:34,271 [salt.utils.extmods][INFO    ][24442] Copying '/var/cache/salt/minion/files/base/_grains/nova_policy.py' to '/var/cache/salt/minion/extmods/grains/nova_policy.py'
2017-11-02 21:45:34,271 [salt.utils.extmods][INFO    ][24442] Copying '/var/cache/salt/minion/files/base/_grains/ssh_fingerprints.py' to '/var/cache/salt/minion/extmods/grains/ssh_fingerprints.py'
2017-11-02 21:45:34,272 [salt.utils.extmods][INFO    ][24442] Creating module dir '/var/cache/salt/minion/extmods/renderers'
2017-11-02 21:45:34,276 [salt.utils.extmods][INFO    ][24442] Syncing renderers for environment 'base'
2017-11-02 21:45:34,276 [salt.utils.extmods][INFO    ][24442] Loading cache from salt://_renderers, for base)
2017-11-02 21:45:34,276 [salt.fileclient  ][INFO    ][24442] Caching directory '_renderers/' for environment 'base'
2017-11-02 21:45:34,340 [salt.utils.extmods][INFO    ][24442] Creating module dir '/var/cache/salt/minion/extmods/returners'
2017-11-02 21:45:34,344 [salt.utils.extmods][INFO    ][24442] Syncing returners for environment 'base'
2017-11-02 21:45:34,344 [salt.utils.extmods][INFO    ][24442] Loading cache from salt://_returners, for base)
2017-11-02 21:45:34,344 [salt.fileclient  ][INFO    ][24442] Caching directory '_returners/' for environment 'base'
2017-11-02 21:45:34,399 [salt.utils.extmods][INFO    ][24442] Creating module dir '/var/cache/salt/minion/extmods/output'
2017-11-02 21:45:34,402 [salt.utils.extmods][INFO    ][24442] Syncing output for environment 'base'
2017-11-02 21:45:34,402 [salt.utils.extmods][INFO    ][24442] Loading cache from salt://_output, for base)
2017-11-02 21:45:34,403 [salt.fileclient  ][INFO    ][24442] Caching directory '_output/' for environment 'base'
2017-11-02 21:45:34,467 [salt.utils.extmods][INFO    ][24442] Creating module dir '/var/cache/salt/minion/extmods/utils'
2017-11-02 21:45:34,470 [salt.utils.extmods][INFO    ][24442] Syncing utils for environment 'base'
2017-11-02 21:45:34,470 [salt.utils.extmods][INFO    ][24442] Loading cache from salt://_utils, for base)
2017-11-02 21:45:34,470 [salt.fileclient  ][INFO    ][24442] Caching directory '_utils/' for environment 'base'
2017-11-02 21:45:34,520 [salt.utils.extmods][INFO    ][24442] Creating module dir '/var/cache/salt/minion/extmods/log_handlers'
2017-11-02 21:45:34,524 [salt.utils.extmods][INFO    ][24442] Syncing log_handlers for environment 'base'
2017-11-02 21:45:34,524 [salt.utils.extmods][INFO    ][24442] Loading cache from salt://_log_handlers, for base)
2017-11-02 21:45:34,524 [salt.fileclient  ][INFO    ][24442] Caching directory '_log_handlers/' for environment 'base'
2017-11-02 21:45:34,581 [salt.utils.extmods][INFO    ][24442] Creating module dir '/var/cache/salt/minion/extmods/proxy'
2017-11-02 21:45:34,584 [salt.utils.extmods][INFO    ][24442] Syncing proxy for environment 'base'
2017-11-02 21:45:34,584 [salt.utils.extmods][INFO    ][24442] Loading cache from salt://_proxy, for base)
2017-11-02 21:45:34,584 [salt.fileclient  ][INFO    ][24442] Caching directory '_proxy/' for environment 'base'
2017-11-02 21:45:34,623 [salt.utils.extmods][INFO    ][24442] Creating module dir '/var/cache/salt/minion/extmods/engines'
2017-11-02 21:45:34,627 [salt.utils.extmods][INFO    ][24442] Syncing engines for environment 'base'
2017-11-02 21:45:34,627 [salt.utils.extmods][INFO    ][24442] Loading cache from salt://_engines, for base)
2017-11-02 21:45:34,627 [salt.fileclient  ][INFO    ][24442] Caching directory '_engines/' for environment 'base'
2017-11-02 21:45:34,662 [salt.minion      ][INFO    ][24442] Returning information for job: 20171102214527505192
2017-11-02 21:48:06,773 [salt.minion      ][INFO    ][24196] User sudo_ubuntu Executing command test.ping with jid 20171102214806766302
2017-11-02 21:48:06,788 [salt.minion      ][INFO    ][24567] Starting a new job with PID 24567
2017-11-02 21:48:06,824 [salt.minion      ][INFO    ][24567] Returning information for job: 20171102214806766302
2017-11-02 21:49:53,904 [salt.minion      ][INFO    ][24196] User sudo_ubuntu Executing command state.sls with jid 20171102214953896491
2017-11-02 21:49:53,915 [salt.minion      ][INFO    ][24603] Starting a new job with PID 24603
2017-11-02 21:49:54,484 [salt.state       ][INFO    ][24603] Loading fresh modules for state activity
2017-11-02 21:49:54,519 [salt.fileclient  ][INFO    ][24603] Fetching file from saltenv 'base', ** done ** 'keepalived/init.sls'
2017-11-02 21:49:54,571 [salt.fileclient  ][INFO    ][24603] Fetching file from saltenv 'base', ** done ** 'keepalived/cluster.sls'
2017-11-02 21:49:54,604 [salt.fileclient  ][INFO    ][24603] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-11-02 21:49:54,938 [salt.state       ][INFO    ][24603] Running state [lsof] at time 21:49:54.937958
2017-11-02 21:49:54,938 [salt.state       ][INFO    ][24603] Executing state pkg.installed for lsof
2017-11-02 21:49:54,939 [salt.loaded.int.module.cmdmod][INFO    ][24603] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-02 21:49:55,192 [salt.state       ][INFO    ][24603] Package lsof is already installed
2017-11-02 21:49:55,192 [salt.state       ][INFO    ][24603] Completed state [lsof] at time 21:49:55.192007 duration_in_ms=254.048
2017-11-02 21:49:55,192 [salt.state       ][INFO    ][24603] Running state [keepalived] at time 21:49:55.192287
2017-11-02 21:49:55,193 [salt.state       ][INFO    ][24603] Executing state pkg.installed for keepalived
2017-11-02 21:49:55,210 [salt.loaded.int.module.cmdmod][INFO    ][24603] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-11-02 21:49:57,105 [salt.loaded.int.module.cmdmod][INFO    ][24603] 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-02 21:49:59,763 [salt.loaded.int.module.cmdmod][INFO    ][24603] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-02 21:49:59,791 [salt.state       ][INFO    ][24603] 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-02 21:49:59,802 [salt.state       ][INFO    ][24603] Loading fresh modules for state activity
2017-11-02 21:49:59,818 [salt.state       ][INFO    ][24603] Completed state [keepalived] at time 21:49:59.817648 duration_in_ms=4625.36
2017-11-02 21:49:59,820 [salt.state       ][INFO    ][24603] Running state [/etc/keepalived/keepalived.conf] at time 21:49:59.819953
2017-11-02 21:49:59,820 [salt.state       ][INFO    ][24603] Executing state file.managed for /etc/keepalived/keepalived.conf
2017-11-02 21:49:59,850 [salt.fileclient  ][INFO    ][24603] Fetching file from saltenv 'base', ** done ** 'keepalived/files/keepalived.conf'
2017-11-02 21:49:59,889 [salt.fileclient  ][INFO    ][24603] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-11-02 21:49:59,897 [salt.state       ][INFO    ][24603] File changed:
New file
2017-11-02 21:49:59,897 [salt.state       ][INFO    ][24603] Completed state [/etc/keepalived/keepalived.conf] at time 21:49:59.896704 duration_in_ms=76.751
2017-11-02 21:49:59,967 [salt.state       ][INFO    ][24603] Running state [keepalived] at time 21:49:59.967178
2017-11-02 21:49:59,968 [salt.state       ][INFO    ][24603] Executing state service.running for keepalived
2017-11-02 21:49:59,969 [salt.loaded.int.module.cmdmod][INFO    ][24603] Executing command ['systemctl', 'status', 'keepalived.service', '-n', '0'] in directory '/root'
2017-11-02 21:49:59,978 [salt.loaded.int.module.cmdmod][INFO    ][24603] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2017-11-02 21:49:59,985 [salt.loaded.int.module.cmdmod][INFO    ][24603] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-11-02 21:49:59,993 [salt.loaded.int.module.cmdmod][INFO    ][24603] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-11-02 21:50:00,002 [salt.loaded.int.module.cmdmod][INFO    ][24603] Executing command ['systemd-run', '--scope', 'systemctl', 'start', 'keepalived.service'] in directory '/root'
2017-11-02 21:50:00,035 [salt.loaded.int.module.cmdmod][INFO    ][24603] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2017-11-02 21:50:00,045 [salt.loaded.int.module.cmdmod][INFO    ][24603] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-11-02 21:50:00,052 [salt.loaded.int.module.cmdmod][INFO    ][24603] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-11-02 21:50:00,059 [salt.state       ][INFO    ][24603] {'keepalived': True}
2017-11-02 21:50:00,060 [salt.state       ][INFO    ][24603] Completed state [keepalived] at time 21:50:00.059573 duration_in_ms=92.394
2017-11-02 21:50:00,061 [salt.minion      ][INFO    ][24603] Returning information for job: 20171102214953896491
2017-11-02 21:50:16,093 [salt.minion      ][INFO    ][24196] User sudo_ubuntu Executing command pillar.get with jid 20171102215016084314
2017-11-02 21:50:16,107 [salt.minion      ][INFO    ][26143] Starting a new job with PID 26143
2017-11-02 21:50:16,112 [salt.minion      ][INFO    ][26143] Returning information for job: 20171102215016084314
2017-11-02 21:54:59,427 [salt.minion      ][INFO    ][24196] User sudo_ubuntu Executing command state.sls with jid 20171102215459420033
2017-11-02 21:54:59,438 [salt.minion      ][INFO    ][26240] Starting a new job with PID 26240
2017-11-02 21:55:02,029 [salt.state       ][INFO    ][26240] Loading fresh modules for state activity
2017-11-02 21:55:02,056 [salt.fileclient  ][INFO    ][26240] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-11-02 21:55:02,078 [salt.fileclient  ][INFO    ][26240] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-11-02 21:55:02,381 [salt.state       ][INFO    ][26240] Running state [attr] at time 21:55:02.380948
2017-11-02 21:55:02,381 [salt.state       ][INFO    ][26240] Executing state pkg.installed for attr
2017-11-02 21:55:02,382 [salt.loaded.int.module.cmdmod][INFO    ][26240] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-02 21:55:02,647 [salt.loaded.int.module.cmdmod][INFO    ][26240] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-11-02 21:55:04,496 [salt.loaded.int.module.cmdmod][INFO    ][26240] 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-02 21:55:05,823 [salt.loaded.int.module.cmdmod][INFO    ][26240] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-02 21:55:05,852 [salt.state       ][INFO    ][26240] Made the following changes:
'attr' changed from 'absent' to '1:2.4.47-2'

2017-11-02 21:55:05,862 [salt.state       ][INFO    ][26240] Loading fresh modules for state activity
2017-11-02 21:55:05,879 [salt.state       ][INFO    ][26240] Completed state [attr] at time 21:55:05.878821 duration_in_ms=3497.872
2017-11-02 21:55:05,886 [salt.state       ][INFO    ][26240] Running state [glusterfs-server] at time 21:55:05.885889
2017-11-02 21:55:05,886 [salt.state       ][INFO    ][26240] Executing state pkg.installed for glusterfs-server
2017-11-02 21:55:06,114 [salt.loaded.int.module.cmdmod][INFO    ][26240] 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-02 21:55:09,530 [salt.minion      ][INFO    ][24196] User sudo_ubuntu Executing command saltutil.find_job with jid 20171102215509516410
2017-11-02 21:55:09,541 [salt.minion      ][INFO    ][30029] Starting a new job with PID 30029
2017-11-02 21:55:09,552 [salt.minion      ][INFO    ][30029] Returning information for job: 20171102215509516410
2017-11-02 21:55:12,123 [salt.loaded.int.module.cmdmod][INFO    ][26240] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-02 21:55:12,152 [salt.state       ][INFO    ][26240] 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-02 21:55:12,162 [salt.state       ][INFO    ][26240] Loading fresh modules for state activity
2017-11-02 21:55:12,179 [salt.state       ][INFO    ][26240] Completed state [glusterfs-server] at time 21:55:12.179239 duration_in_ms=6293.349
2017-11-02 21:55:12,185 [salt.state       ][INFO    ][26240] Running state [bc] at time 21:55:12.184608
2017-11-02 21:55:12,185 [salt.state       ][INFO    ][26240] Executing state pkg.installed for bc
2017-11-02 21:55:12,480 [salt.loaded.int.module.cmdmod][INFO    ][26240] 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-02 21:55:13,875 [salt.loaded.int.module.cmdmod][INFO    ][26240] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-02 21:55:13,904 [salt.state       ][INFO    ][26240] Made the following changes:
'bc' changed from 'absent' to '1.06.95-9build1'

2017-11-02 21:55:13,913 [salt.state       ][INFO    ][26240] Loading fresh modules for state activity
2017-11-02 21:55:13,931 [salt.state       ][INFO    ][26240] Completed state [bc] at time 21:55:13.931268 duration_in_ms=1746.66
2017-11-02 21:55:14,003 [salt.state       ][INFO    ][26240] Running state [glusterfs-server] at time 21:55:14.002922
2017-11-02 21:55:14,003 [salt.state       ][INFO    ][26240] Executing state service.running for glusterfs-server
2017-11-02 21:55:14,005 [salt.loaded.int.module.cmdmod][INFO    ][26240] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-11-02 21:55:14,015 [salt.loaded.int.module.cmdmod][INFO    ][26240] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-11-02 21:55:14,023 [salt.loaded.int.module.cmdmod][INFO    ][26240] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-11-02 21:55:14,033 [salt.state       ][INFO    ][26240] The service glusterfs-server is already running
2017-11-02 21:55:14,033 [salt.state       ][INFO    ][26240] Completed state [glusterfs-server] at time 21:55:14.033280 duration_in_ms=30.359
2017-11-02 21:55:14,035 [salt.state       ][INFO    ][26240] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 21:55:14.034767
2017-11-02 21:55:14,035 [salt.state       ][INFO    ][26240] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-11-02 21:55:14,040 [salt.state       ][INFO    ][26240] File changed:
New file
2017-11-02 21:55:14,040 [salt.state       ][INFO    ][26240] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 21:55:14.040193 duration_in_ms=5.426
2017-11-02 21:55:14,040 [salt.state       ][INFO    ][26240] Running state [/srv/glusterfs/glance] at time 21:55:14.040399
2017-11-02 21:55:14,041 [salt.state       ][INFO    ][26240] Executing state file.directory for /srv/glusterfs/glance
2017-11-02 21:55:14,041 [salt.state       ][INFO    ][26240] {'/srv/glusterfs/glance': 'New Dir'}
2017-11-02 21:55:14,041 [salt.state       ][INFO    ][26240] Completed state [/srv/glusterfs/glance] at time 21:55:14.041462 duration_in_ms=1.063
2017-11-02 21:55:14,042 [salt.state       ][INFO    ][26240] Running state [/srv/glusterfs/keystone-keys] at time 21:55:14.041649
2017-11-02 21:55:14,042 [salt.state       ][INFO    ][26240] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-11-02 21:55:14,042 [salt.state       ][INFO    ][26240] {'/srv/glusterfs/keystone-keys': 'New Dir'}
2017-11-02 21:55:14,043 [salt.state       ][INFO    ][26240] Completed state [/srv/glusterfs/keystone-keys] at time 21:55:14.042515 duration_in_ms=0.866
2017-11-02 21:55:14,043 [salt.state       ][INFO    ][26240] Running state [/srv/glusterfs/nova_instances] at time 21:55:14.042698
2017-11-02 21:55:14,043 [salt.state       ][INFO    ][26240] Executing state file.directory for /srv/glusterfs/nova_instances
2017-11-02 21:55:14,043 [salt.state       ][INFO    ][26240] {'/srv/glusterfs/nova_instances': 'New Dir'}
2017-11-02 21:55:14,044 [salt.state       ][INFO    ][26240] Completed state [/srv/glusterfs/nova_instances] at time 21:55:14.043524 duration_in_ms=0.826
2017-11-02 21:55:14,044 [salt.state       ][INFO    ][26240] Running state [/srv/glusterfs/keystone-credential-keys] at time 21:55:14.043720
2017-11-02 21:55:14,044 [salt.state       ][INFO    ][26240] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-11-02 21:55:14,044 [salt.state       ][INFO    ][26240] {'/srv/glusterfs/keystone-credential-keys': 'New Dir'}
2017-11-02 21:55:14,045 [salt.state       ][INFO    ][26240] Completed state [/srv/glusterfs/keystone-credential-keys] at time 21:55:14.044565 duration_in_ms=0.845
2017-11-02 21:55:14,045 [salt.minion      ][INFO    ][26240] Returning information for job: 20171102215459420033
2017-11-02 21:55:22,344 [salt.minion      ][INFO    ][24196] User sudo_ubuntu Executing command test.ping with jid 20171102215522336449
2017-11-02 21:55:22,355 [salt.minion      ][INFO    ][30937] Starting a new job with PID 30937
2017-11-02 21:55:22,391 [salt.minion      ][INFO    ][30937] Returning information for job: 20171102215522336449
2017-11-02 21:55:50,206 [salt.minion      ][INFO    ][24196] User sudo_ubuntu Executing command state.sls with jid 20171102215550199108
2017-11-02 21:55:50,219 [salt.minion      ][INFO    ][31151] Starting a new job with PID 31151
2017-11-02 21:55:52,333 [salt.state       ][INFO    ][31151] Loading fresh modules for state activity
2017-11-02 21:55:52,367 [salt.fileclient  ][INFO    ][31151] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/setup.sls'
2017-11-02 21:55:52,408 [salt.fileclient  ][INFO    ][31151] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-11-02 21:55:52,487 [salt.fileclient  ][INFO    ][31151] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-11-02 21:55:52,515 [salt.fileclient  ][INFO    ][31151] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-11-02 21:55:52,822 [salt.state       ][INFO    ][31151] Running state [attr] at time 21:55:52.821971
2017-11-02 21:55:52,822 [salt.state       ][INFO    ][31151] Executing state pkg.installed for attr
2017-11-02 21:55:52,823 [salt.loaded.int.module.cmdmod][INFO    ][31151] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-02 21:55:53,076 [salt.state       ][INFO    ][31151] Package attr is already installed
2017-11-02 21:55:53,077 [salt.state       ][INFO    ][31151] Completed state [attr] at time 21:55:53.076470 duration_in_ms=254.499
2017-11-02 21:55:53,077 [salt.state       ][INFO    ][31151] Running state [glusterfs-server] at time 21:55:53.076768
2017-11-02 21:55:53,077 [salt.state       ][INFO    ][31151] Executing state pkg.installed for glusterfs-server
2017-11-02 21:55:53,081 [salt.state       ][INFO    ][31151] Package glusterfs-server is already installed
2017-11-02 21:55:53,081 [salt.state       ][INFO    ][31151] Completed state [glusterfs-server] at time 21:55:53.080868 duration_in_ms=4.099
2017-11-02 21:55:53,081 [salt.state       ][INFO    ][31151] Running state [bc] at time 21:55:53.081069
2017-11-02 21:55:53,081 [salt.state       ][INFO    ][31151] Executing state pkg.installed for bc
2017-11-02 21:55:53,085 [salt.state       ][INFO    ][31151] Package bc is already installed
2017-11-02 21:55:53,085 [salt.state       ][INFO    ][31151] Completed state [bc] at time 21:55:53.085025 duration_in_ms=3.956
2017-11-02 21:55:53,086 [salt.state       ][INFO    ][31151] Running state [glusterfs-server] at time 21:55:53.086038
2017-11-02 21:55:53,086 [salt.state       ][INFO    ][31151] Executing state service.running for glusterfs-server
2017-11-02 21:55:53,087 [salt.loaded.int.module.cmdmod][INFO    ][31151] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-11-02 21:55:53,096 [salt.loaded.int.module.cmdmod][INFO    ][31151] Executing command ['systemctl', '--system', 'daemon-reload'] in directory '/root'
2017-11-02 21:55:53,145 [salt.loaded.int.module.cmdmod][INFO    ][31151] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-11-02 21:55:53,159 [salt.loaded.int.module.cmdmod][INFO    ][31151] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-11-02 21:55:53,166 [salt.loaded.int.module.cmdmod][INFO    ][31151] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-11-02 21:55:53,175 [salt.state       ][INFO    ][31151] The service glusterfs-server is already running
2017-11-02 21:55:53,175 [salt.state       ][INFO    ][31151] Completed state [glusterfs-server] at time 21:55:53.174987 duration_in_ms=88.949
2017-11-02 21:55:53,176 [salt.state       ][INFO    ][31151] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 21:55:53.176439
2017-11-02 21:55:53,177 [salt.state       ][INFO    ][31151] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-11-02 21:55:53,179 [salt.state       ][INFO    ][31151] File /etc/systemd/system/glusterfs-server.service.d/override.conf is in the correct state
2017-11-02 21:55:53,179 [salt.state       ][INFO    ][31151] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 21:55:53.178884 duration_in_ms=2.445
2017-11-02 21:55:53,179 [salt.state       ][INFO    ][31151] Running state [/srv/glusterfs/glance] at time 21:55:53.179094
2017-11-02 21:55:53,179 [salt.state       ][INFO    ][31151] Executing state file.directory for /srv/glusterfs/glance
2017-11-02 21:55:53,180 [salt.state       ][INFO    ][31151] Directory /srv/glusterfs/glance is in the correct state
2017-11-02 21:55:53,180 [salt.state       ][INFO    ][31151] Completed state [/srv/glusterfs/glance] at time 21:55:53.179873 duration_in_ms=0.778
2017-11-02 21:55:53,180 [salt.state       ][INFO    ][31151] Running state [/srv/glusterfs/keystone-keys] at time 21:55:53.180069
2017-11-02 21:55:53,180 [salt.state       ][INFO    ][31151] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-11-02 21:55:53,181 [salt.state       ][INFO    ][31151] Directory /srv/glusterfs/keystone-keys is in the correct state
2017-11-02 21:55:53,181 [salt.state       ][INFO    ][31151] Completed state [/srv/glusterfs/keystone-keys] at time 21:55:53.180817 duration_in_ms=0.748
2017-11-02 21:55:53,181 [salt.state       ][INFO    ][31151] Running state [/srv/glusterfs/nova_instances] at time 21:55:53.181002
2017-11-02 21:55:53,181 [salt.state       ][INFO    ][31151] Executing state file.directory for /srv/glusterfs/nova_instances
2017-11-02 21:55:53,182 [salt.state       ][INFO    ][31151] Directory /srv/glusterfs/nova_instances is in the correct state
2017-11-02 21:55:53,182 [salt.state       ][INFO    ][31151] Completed state [/srv/glusterfs/nova_instances] at time 21:55:53.181751 duration_in_ms=0.749
2017-11-02 21:55:53,182 [salt.state       ][INFO    ][31151] Running state [/srv/glusterfs/keystone-credential-keys] at time 21:55:53.181943
2017-11-02 21:55:53,182 [salt.state       ][INFO    ][31151] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-11-02 21:55:53,183 [salt.state       ][INFO    ][31151] Directory /srv/glusterfs/keystone-credential-keys is in the correct state
2017-11-02 21:55:53,183 [salt.state       ][INFO    ][31151] Completed state [/srv/glusterfs/keystone-credential-keys] at time 21:55:53.182773 duration_in_ms=0.83
2017-11-02 21:55:53,238 [salt.loaded.int.module.cmdmod][INFO    ][31151] Executing command ['git', '--version'] in directory '/root'
2017-11-02 21:55:53,318 [salt.state       ][INFO    ][31151] Running state [sleep 5] at time 21:55:53.318197
2017-11-02 21:55:53,319 [salt.state       ][INFO    ][31151] Executing state cmd.wait for sleep 5
2017-11-02 21:55:53,319 [salt.state       ][INFO    ][31151] No changes made for sleep 5
2017-11-02 21:55:53,319 [salt.state       ][INFO    ][31151] Completed state [sleep 5] at time 21:55:53.318939 duration_in_ms=0.742
2017-11-02 21:55:53,320 [salt.state       ][INFO    ][31151] Running state [192.168.10.143] at time 21:55:53.319543
2017-11-02 21:55:53,320 [salt.state       ][INFO    ][31151] Executing state glusterfs.peered for 192.168.10.143
2017-11-02 21:55:53,320 [salt.loaded.int.module.cmdmod][INFO    ][31151] Executing command 'gluster --version' in directory '/root'
2017-11-02 21:55:53,328 [salt.loaded.int.module.cmdmod][INFO    ][31151] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-02 21:55:53,380 [salt.loaded.int.module.cmdmod][INFO    ][31151] Executing command 'gluster --version' in directory '/root'
2017-11-02 21:55:53,387 [salt.loaded.int.module.cmdmod][INFO    ][31151] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-02 21:55:53,439 [salt.loaded.int.module.cmdmod][INFO    ][31151] Executing command 'gluster --version' in directory '/root'
2017-11-02 21:55:53,447 [salt.loaded.int.module.cmdmod][INFO    ][31151] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-02 21:55:53,499 [salt.loaded.int.module.cmdmod][INFO    ][31151] Executing command 'gluster --version' in directory '/root'
2017-11-02 21:55:53,505 [salt.loaded.int.module.cmdmod][INFO    ][31151] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-02 21:55:53,557 [salt.state       ][INFO    ][31151] Peering with localhost is not needed
2017-11-02 21:55:53,557 [salt.state       ][INFO    ][31151] Completed state [192.168.10.143] at time 21:55:53.556910 duration_in_ms=237.366
2017-11-02 21:55:53,560 [salt.state       ][INFO    ][31151] Running state [192.168.10.142] at time 21:55:53.560121
2017-11-02 21:55:53,560 [salt.state       ][INFO    ][31151] Executing state glusterfs.peered for 192.168.10.142
2017-11-02 21:55:53,561 [salt.loaded.int.module.cmdmod][INFO    ][31151] Executing command 'gluster --version' in directory '/root'
2017-11-02 21:55:53,568 [salt.loaded.int.module.cmdmod][INFO    ][31151] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-02 21:55:53,622 [salt.loaded.int.module.cmdmod][INFO    ][31151] Executing command 'gluster --version' in directory '/root'
2017-11-02 21:55:53,630 [salt.loaded.int.module.cmdmod][INFO    ][31151] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-02 21:55:53,684 [salt.loaded.int.module.cmdmod][INFO    ][31151] Executing command 'gluster --version' in directory '/root'
2017-11-02 21:55:53,692 [salt.loaded.int.module.cmdmod][INFO    ][31151] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-02 21:55:53,744 [salt.loaded.int.module.cmdmod][INFO    ][31151] Executing command 'gluster --version' in directory '/root'
2017-11-02 21:55:53,752 [salt.loaded.int.module.cmdmod][INFO    ][31151] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-02 21:55:53,803 [salt.state       ][INFO    ][31151] {'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-02 21:55:53,803 [salt.state       ][INFO    ][31151] Completed state [192.168.10.142] at time 21:55:53.803145 duration_in_ms=243.023
2017-11-02 21:55:53,806 [salt.state       ][INFO    ][31151] Running state [192.168.10.141] at time 21:55:53.806297
2017-11-02 21:55:53,807 [salt.state       ][INFO    ][31151] Executing state glusterfs.peered for 192.168.10.141
2017-11-02 21:55:53,807 [salt.loaded.int.module.cmdmod][INFO    ][31151] Executing command 'gluster --version' in directory '/root'
2017-11-02 21:55:53,815 [salt.loaded.int.module.cmdmod][INFO    ][31151] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-02 21:55:53,866 [salt.state       ][INFO    ][31151] Host 192.168.10.141 already peered
2017-11-02 21:55:53,866 [salt.state       ][INFO    ][31151] Completed state [192.168.10.141] at time 21:55:53.866238 duration_in_ms=59.941
2017-11-02 21:55:53,867 [salt.state       ][INFO    ][31151] Running state [glance] at time 21:55:53.867282
2017-11-02 21:55:53,868 [salt.state       ][INFO    ][31151] Executing state glusterfs.created for glance
2017-11-02 21:55:53,868 [salt.loaded.int.module.cmdmod][INFO    ][31151] Executing command 'gluster --version' in directory '/root'
2017-11-02 21:55:53,876 [salt.loaded.int.module.cmdmod][INFO    ][31151] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-02 21:55:53,926 [salt.loaded.int.module.cmdmod][INFO    ][31151] Executing command 'gluster --version' in directory '/root'
2017-11-02 21:55:53,934 [salt.loaded.int.module.cmdmod][INFO    ][31151] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-02 21:55:53,990 [salt.state       ][INFO    ][31151] Volume glance already exists and is started.
2017-11-02 21:55:53,990 [salt.state       ][INFO    ][31151] Completed state [glance] at time 21:55:53.990328 duration_in_ms=123.045
2017-11-02 21:55:53,994 [salt.state       ][INFO    ][31151] Running state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 21:55:53.994236
2017-11-02 21:55:53,995 [salt.state       ][INFO    ][31151] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'
2017-11-02 21:55:53,995 [salt.loaded.int.module.cmdmod][INFO    ][31151] Executing command 'gluster volume info 'glance' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-11-02 21:55:54,046 [salt.state       ][INFO    ][31151] unless execution succeeded
2017-11-02 21:55:54,047 [salt.state       ][INFO    ][31151] Completed state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 21:55:54.046709 duration_in_ms=52.463
2017-11-02 21:55:54,047 [salt.state       ][INFO    ][31151] Running state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 21:55:54.047252
2017-11-02 21:55:54,048 [salt.state       ][INFO    ][31151] Executing state cmd.run for gluster volume set 'glance' 'network.remote-dio' 'True'
2017-11-02 21:55:54,048 [salt.loaded.int.module.cmdmod][INFO    ][31151] Executing command 'gluster volume info 'glance' | grep 'network.remote-dio: True'' in directory '/root'
2017-11-02 21:55:54,097 [salt.state       ][INFO    ][31151] unless execution succeeded
2017-11-02 21:55:54,097 [salt.state       ][INFO    ][31151] Completed state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 21:55:54.097234 duration_in_ms=49.982
2017-11-02 21:55:54,098 [salt.state       ][INFO    ][31151] Running state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 21:55:54.097847
2017-11-02 21:55:54,098 [salt.state       ][INFO    ][31151] Executing state cmd.run for gluster volume set 'glance' 'nfs.disable' 'True'
2017-11-02 21:55:54,099 [salt.loaded.int.module.cmdmod][INFO    ][31151] Executing command 'gluster volume info 'glance' | grep 'nfs.disable: True'' in directory '/root'
2017-11-02 21:55:54,150 [salt.state       ][INFO    ][31151] unless execution succeeded
2017-11-02 21:55:54,151 [salt.state       ][INFO    ][31151] Completed state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 21:55:54.150738 duration_in_ms=52.891
2017-11-02 21:55:54,151 [salt.state       ][INFO    ][31151] Running state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 21:55:54.151392
2017-11-02 21:55:54,152 [salt.state       ][INFO    ][31151] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'
2017-11-02 21:55:54,152 [salt.loaded.int.module.cmdmod][INFO    ][31151] Executing command 'gluster volume info 'glance' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-11-02 21:55:54,204 [salt.state       ][INFO    ][31151] unless execution succeeded
2017-11-02 21:55:54,204 [salt.state       ][INFO    ][31151] Completed state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 21:55:54.204182 duration_in_ms=52.79
2017-11-02 21:55:54,205 [salt.state       ][INFO    ][31151] Running state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 21:55:54.204740
2017-11-02 21:55:54,205 [salt.state       ][INFO    ][31151] Executing state cmd.run for gluster volume set 'glance' 'cluster.readdir-optimize' 'True'
2017-11-02 21:55:54,205 [salt.loaded.int.module.cmdmod][INFO    ][31151] Executing command 'gluster volume info 'glance' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-11-02 21:55:54,258 [salt.state       ][INFO    ][31151] unless execution succeeded
2017-11-02 21:55:54,258 [salt.state       ][INFO    ][31151] Completed state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 21:55:54.258004 duration_in_ms=53.263
2017-11-02 21:55:54,259 [salt.state       ][INFO    ][31151] Running state [glance] at time 21:55:54.259458
2017-11-02 21:55:54,260 [salt.state       ][INFO    ][31151] Executing state glusterfs.started for glance
2017-11-02 21:55:54,260 [salt.loaded.int.module.cmdmod][INFO    ][31151] Executing command 'gluster --version' in directory '/root'
2017-11-02 21:55:54,268 [salt.loaded.int.module.cmdmod][INFO    ][31151] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-02 21:55:54,321 [salt.loaded.int.module.cmdmod][INFO    ][31151] Executing command 'gluster --version' in directory '/root'
2017-11-02 21:55:54,329 [salt.loaded.int.module.cmdmod][INFO    ][31151] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-02 21:55:54,385 [salt.state       ][INFO    ][31151] Volume glance is already started
2017-11-02 21:55:54,385 [salt.state       ][INFO    ][31151] Completed state [glance] at time 21:55:54.385053 duration_in_ms=125.595
2017-11-02 21:55:54,386 [salt.state       ][INFO    ][31151] Running state [keystone-keys] at time 21:55:54.386100
2017-11-02 21:55:54,386 [salt.state       ][INFO    ][31151] Executing state glusterfs.created for keystone-keys
2017-11-02 21:55:54,387 [salt.loaded.int.module.cmdmod][INFO    ][31151] Executing command 'gluster --version' in directory '/root'
2017-11-02 21:55:54,395 [salt.loaded.int.module.cmdmod][INFO    ][31151] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-02 21:55:54,446 [salt.loaded.int.module.cmdmod][INFO    ][31151] Executing command 'gluster --version' in directory '/root'
2017-11-02 21:55:54,454 [salt.loaded.int.module.cmdmod][INFO    ][31151] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-02 21:55:54,513 [salt.state       ][INFO    ][31151] Volume keystone-keys already exists and is started.
2017-11-02 21:55:54,513 [salt.state       ][INFO    ][31151] Completed state [keystone-keys] at time 21:55:54.513162 duration_in_ms=127.062
2017-11-02 21:55:54,518 [salt.state       ][INFO    ][31151] Running state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 21:55:54.517659
2017-11-02 21:55:54,518 [salt.state       ][INFO    ][31151] Executing state cmd.run for gluster volume set 'keystone-keys' 'network.remote-dio' 'True'
2017-11-02 21:55:54,519 [salt.loaded.int.module.cmdmod][INFO    ][31151] Executing command 'gluster volume info 'keystone-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-11-02 21:55:54,572 [salt.state       ][INFO    ][31151] unless execution succeeded
2017-11-02 21:55:54,572 [salt.state       ][INFO    ][31151] Completed state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 21:55:54.571992 duration_in_ms=54.332
2017-11-02 21:55:54,573 [salt.state       ][INFO    ][31151] Running state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 21:55:54.572654
2017-11-02 21:55:54,573 [salt.state       ][INFO    ][31151] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-11-02 21:55:54,574 [salt.loaded.int.module.cmdmod][INFO    ][31151] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-11-02 21:55:54,627 [salt.state       ][INFO    ][31151] unless execution succeeded
2017-11-02 21:55:54,628 [salt.state       ][INFO    ][31151] Completed state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 21:55:54.627528 duration_in_ms=54.873
2017-11-02 21:55:54,628 [salt.state       ][INFO    ][31151] Running state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 21:55:54.628188
2017-11-02 21:55:54,628 [salt.state       ][INFO    ][31151] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'
2017-11-02 21:55:54,629 [salt.loaded.int.module.cmdmod][INFO    ][31151] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-11-02 21:55:54,680 [salt.state       ][INFO    ][31151] unless execution succeeded
2017-11-02 21:55:54,680 [salt.state       ][INFO    ][31151] Completed state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 21:55:54.679875 duration_in_ms=51.674
2017-11-02 21:55:54,681 [salt.state       ][INFO    ][31151] Running state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 21:55:54.680471
2017-11-02 21:55:54,681 [salt.state       ][INFO    ][31151] Executing state cmd.run for gluster volume set 'keystone-keys' 'nfs.disable' 'True'
2017-11-02 21:55:54,681 [salt.loaded.int.module.cmdmod][INFO    ][31151] Executing command 'gluster volume info 'keystone-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-11-02 21:55:54,731 [salt.state       ][INFO    ][31151] unless execution succeeded
2017-11-02 21:55:54,731 [salt.state       ][INFO    ][31151] Completed state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 21:55:54.731234 duration_in_ms=50.763
2017-11-02 21:55:54,732 [salt.state       ][INFO    ][31151] Running state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 21:55:54.731804
2017-11-02 21:55:54,732 [salt.state       ][INFO    ][31151] Executing state cmd.run for gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'
2017-11-02 21:55:54,733 [salt.loaded.int.module.cmdmod][INFO    ][31151] Executing command 'gluster volume info 'keystone-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-11-02 21:55:54,783 [salt.state       ][INFO    ][31151] unless execution succeeded
2017-11-02 21:55:54,783 [salt.state       ][INFO    ][31151] Completed state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 21:55:54.782941 duration_in_ms=51.137
2017-11-02 21:55:54,784 [salt.state       ][INFO    ][31151] Running state [keystone-keys] at time 21:55:54.784326
2017-11-02 21:55:54,785 [salt.state       ][INFO    ][31151] Executing state glusterfs.started for keystone-keys
2017-11-02 21:55:54,785 [salt.loaded.int.module.cmdmod][INFO    ][31151] Executing command 'gluster --version' in directory '/root'
2017-11-02 21:55:54,792 [salt.loaded.int.module.cmdmod][INFO    ][31151] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-02 21:55:54,843 [salt.loaded.int.module.cmdmod][INFO    ][31151] Executing command 'gluster --version' in directory '/root'
2017-11-02 21:55:54,851 [salt.loaded.int.module.cmdmod][INFO    ][31151] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-02 21:55:54,906 [salt.state       ][INFO    ][31151] Volume keystone-keys is already started
2017-11-02 21:55:54,907 [salt.state       ][INFO    ][31151] Completed state [keystone-keys] at time 21:55:54.906523 duration_in_ms=122.197
2017-11-02 21:55:54,908 [salt.state       ][INFO    ][31151] Running state [nova_instances] at time 21:55:54.907541
2017-11-02 21:55:54,908 [salt.state       ][INFO    ][31151] Executing state glusterfs.created for nova_instances
2017-11-02 21:55:54,908 [salt.loaded.int.module.cmdmod][INFO    ][31151] Executing command 'gluster --version' in directory '/root'
2017-11-02 21:55:54,916 [salt.loaded.int.module.cmdmod][INFO    ][31151] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-02 21:55:54,969 [salt.loaded.int.module.cmdmod][INFO    ][31151] Executing command 'gluster --version' in directory '/root'
2017-11-02 21:55:54,977 [salt.loaded.int.module.cmdmod][INFO    ][31151] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-02 21:55:55,035 [salt.state       ][INFO    ][31151] Volume nova_instances already exists and is started.
2017-11-02 21:55:55,035 [salt.state       ][INFO    ][31151] Completed state [nova_instances] at time 21:55:55.035158 duration_in_ms=127.616
2017-11-02 21:55:55,040 [salt.state       ][INFO    ][31151] Running state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 21:55:55.039606
2017-11-02 21:55:55,040 [salt.state       ][INFO    ][31151] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'
2017-11-02 21:55:55,040 [salt.loaded.int.module.cmdmod][INFO    ][31151] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-11-02 21:55:55,092 [salt.state       ][INFO    ][31151] unless execution succeeded
2017-11-02 21:55:55,092 [salt.state       ][INFO    ][31151] Completed state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 21:55:55.092221 duration_in_ms=52.606
2017-11-02 21:55:55,093 [salt.state       ][INFO    ][31151] Running state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'On'] at time 21:55:55.092828
2017-11-02 21:55:55,093 [salt.state       ][INFO    ][31151] Executing state cmd.run for gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'On'
2017-11-02 21:55:55,094 [salt.loaded.int.module.cmdmod][INFO    ][31151] Executing command 'gluster volume info 'nova_instances' | grep 'cluster.readdir-optimize: On'' in directory '/root'
2017-11-02 21:55:55,146 [salt.state       ][INFO    ][31151] unless execution succeeded
2017-11-02 21:55:55,146 [salt.state       ][INFO    ][31151] Completed state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'On'] at time 21:55:55.146230 duration_in_ms=53.402
2017-11-02 21:55:55,147 [salt.state       ][INFO    ][31151] Running state [gluster volume set 'nova_instances' 'network.remote-dio' 'On'] at time 21:55:55.146825
2017-11-02 21:55:55,147 [salt.state       ][INFO    ][31151] Executing state cmd.run for gluster volume set 'nova_instances' 'network.remote-dio' 'On'
2017-11-02 21:55:55,148 [salt.loaded.int.module.cmdmod][INFO    ][31151] Executing command 'gluster volume info 'nova_instances' | grep 'network.remote-dio: On'' in directory '/root'
2017-11-02 21:55:55,198 [salt.state       ][INFO    ][31151] unless execution succeeded
2017-11-02 21:55:55,199 [salt.state       ][INFO    ][31151] Completed state [gluster volume set 'nova_instances' 'network.remote-dio' 'On'] at time 21:55:55.198453 duration_in_ms=51.628
2017-11-02 21:55:55,199 [salt.state       ][INFO    ][31151] Running state [gluster volume set 'nova_instances' 'nfs.disable' 'On'] at time 21:55:55.199047
2017-11-02 21:55:55,199 [salt.state       ][INFO    ][31151] Executing state cmd.run for gluster volume set 'nova_instances' 'nfs.disable' 'On'
2017-11-02 21:55:55,200 [salt.loaded.int.module.cmdmod][INFO    ][31151] Executing command 'gluster volume info 'nova_instances' | grep 'nfs.disable: On'' in directory '/root'
2017-11-02 21:55:55,251 [salt.state       ][INFO    ][31151] unless execution succeeded
2017-11-02 21:55:55,252 [salt.state       ][INFO    ][31151] Completed state [gluster volume set 'nova_instances' 'nfs.disable' 'On'] at time 21:55:55.251710 duration_in_ms=52.662
2017-11-02 21:55:55,252 [salt.state       ][INFO    ][31151] Running state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 21:55:55.252285
2017-11-02 21:55:55,253 [salt.state       ][INFO    ][31151] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'
2017-11-02 21:55:55,253 [salt.loaded.int.module.cmdmod][INFO    ][31151] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-11-02 21:55:55,305 [salt.state       ][INFO    ][31151] unless execution succeeded
2017-11-02 21:55:55,305 [salt.state       ][INFO    ][31151] Completed state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 21:55:55.305211 duration_in_ms=52.926
2017-11-02 21:55:55,307 [salt.state       ][INFO    ][31151] Running state [nova_instances] at time 21:55:55.306664
2017-11-02 21:55:55,307 [salt.state       ][INFO    ][31151] Executing state glusterfs.started for nova_instances
2017-11-02 21:55:55,307 [salt.loaded.int.module.cmdmod][INFO    ][31151] Executing command 'gluster --version' in directory '/root'
2017-11-02 21:55:55,314 [salt.loaded.int.module.cmdmod][INFO    ][31151] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-02 21:55:55,362 [salt.loaded.int.module.cmdmod][INFO    ][31151] Executing command 'gluster --version' in directory '/root'
2017-11-02 21:55:55,370 [salt.loaded.int.module.cmdmod][INFO    ][31151] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-02 21:55:55,427 [salt.state       ][INFO    ][31151] Volume nova_instances is already started
2017-11-02 21:55:55,428 [salt.state       ][INFO    ][31151] Completed state [nova_instances] at time 21:55:55.427505 duration_in_ms=120.841
2017-11-02 21:55:55,429 [salt.state       ][INFO    ][31151] Running state [keystone-credential-keys] at time 21:55:55.428524
2017-11-02 21:55:55,429 [salt.state       ][INFO    ][31151] Executing state glusterfs.created for keystone-credential-keys
2017-11-02 21:55:55,429 [salt.loaded.int.module.cmdmod][INFO    ][31151] Executing command 'gluster --version' in directory '/root'
2017-11-02 21:55:55,437 [salt.loaded.int.module.cmdmod][INFO    ][31151] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-02 21:55:55,488 [salt.loaded.int.module.cmdmod][INFO    ][31151] Executing command 'gluster --version' in directory '/root'
2017-11-02 21:55:55,496 [salt.loaded.int.module.cmdmod][INFO    ][31151] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-02 21:55:55,552 [salt.state       ][INFO    ][31151] Volume keystone-credential-keys already exists and is started.
2017-11-02 21:55:55,552 [salt.state       ][INFO    ][31151] Completed state [keystone-credential-keys] at time 21:55:55.552249 duration_in_ms=123.724
2017-11-02 21:55:55,557 [salt.state       ][INFO    ][31151] Running state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 21:55:55.556521
2017-11-02 21:55:55,557 [salt.state       ][INFO    ][31151] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'
2017-11-02 21:55:55,557 [salt.loaded.int.module.cmdmod][INFO    ][31151] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-11-02 21:55:55,609 [salt.state       ][INFO    ][31151] unless execution succeeded
2017-11-02 21:55:55,609 [salt.state       ][INFO    ][31151] Completed state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 21:55:55.609090 duration_in_ms=52.568
2017-11-02 21:55:55,610 [salt.state       ][INFO    ][31151] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 21:55:55.609716
2017-11-02 21:55:55,610 [salt.state       ][INFO    ][31151] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-11-02 21:55:55,611 [salt.loaded.int.module.cmdmod][INFO    ][31151] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-11-02 21:55:55,664 [salt.state       ][INFO    ][31151] unless execution succeeded
2017-11-02 21:55:55,664 [salt.state       ][INFO    ][31151] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 21:55:55.664037 duration_in_ms=54.321
2017-11-02 21:55:55,665 [salt.state       ][INFO    ][31151] Running state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 21:55:55.664613
2017-11-02 21:55:55,665 [salt.state       ][INFO    ][31151] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'
2017-11-02 21:55:55,665 [salt.loaded.int.module.cmdmod][INFO    ][31151] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-11-02 21:55:55,718 [salt.state       ][INFO    ][31151] unless execution succeeded
2017-11-02 21:55:55,718 [salt.state       ][INFO    ][31151] Completed state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 21:55:55.717751 duration_in_ms=53.138
2017-11-02 21:55:55,718 [salt.state       ][INFO    ][31151] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 21:55:55.718394
2017-11-02 21:55:55,719 [salt.state       ][INFO    ][31151] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'
2017-11-02 21:55:55,719 [salt.loaded.int.module.cmdmod][INFO    ][31151] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-11-02 21:55:55,773 [salt.state       ][INFO    ][31151] unless execution succeeded
2017-11-02 21:55:55,773 [salt.state       ][INFO    ][31151] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 21:55:55.773223 duration_in_ms=54.829
2017-11-02 21:55:55,774 [salt.state       ][INFO    ][31151] Running state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 21:55:55.773851
2017-11-02 21:55:55,774 [salt.state       ][INFO    ][31151] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'
2017-11-02 21:55:55,775 [salt.loaded.int.module.cmdmod][INFO    ][31151] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-11-02 21:55:55,826 [salt.state       ][INFO    ][31151] unless execution succeeded
2017-11-02 21:55:55,826 [salt.state       ][INFO    ][31151] Completed state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 21:55:55.826073 duration_in_ms=52.221
2017-11-02 21:55:55,828 [salt.state       ][INFO    ][31151] Running state [keystone-credential-keys] at time 21:55:55.827571
2017-11-02 21:55:55,828 [salt.state       ][INFO    ][31151] Executing state glusterfs.started for keystone-credential-keys
2017-11-02 21:55:55,829 [salt.loaded.int.module.cmdmod][INFO    ][31151] Executing command 'gluster --version' in directory '/root'
2017-11-02 21:55:55,837 [salt.loaded.int.module.cmdmod][INFO    ][31151] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-02 21:55:55,889 [salt.loaded.int.module.cmdmod][INFO    ][31151] Executing command 'gluster --version' in directory '/root'
2017-11-02 21:55:55,897 [salt.loaded.int.module.cmdmod][INFO    ][31151] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-02 21:55:55,952 [salt.state       ][INFO    ][31151] Volume keystone-credential-keys is already started
2017-11-02 21:55:55,952 [salt.state       ][INFO    ][31151] Completed state [keystone-credential-keys] at time 21:55:55.951865 duration_in_ms=124.294
2017-11-02 21:55:55,954 [salt.minion      ][INFO    ][31151] Returning information for job: 20171102215550199108
2017-11-02 21:56:01,120 [salt.minion      ][INFO    ][24196] User sudo_ubuntu Executing command test.ping with jid 20171102215601113540
2017-11-02 21:56:01,132 [salt.minion      ][INFO    ][31577] Starting a new job with PID 31577
2017-11-02 21:56:01,167 [salt.minion      ][INFO    ][31577] Returning information for job: 20171102215601113540
2017-11-02 21:56:01,644 [salt.minion      ][INFO    ][24196] User sudo_ubuntu Executing command cmd.run with jid 20171102215601634386
2017-11-02 21:56:01,654 [salt.minion      ][INFO    ][31582] Starting a new job with PID 31582
2017-11-02 21:56:01,658 [salt.loaded.int.module.cmdmod][INFO    ][31582] Executing command 'gluster peer status; gluster volume status' in directory '/root'
2017-11-02 21:56:01,776 [salt.minion      ][INFO    ][31582] Returning information for job: 20171102215601634386
2017-11-02 22:35:27,305 [salt.minion      ][INFO    ][24196] User sudo_ubuntu Executing command test.ping with jid 20171102223527297145
2017-11-02 22:35:27,321 [salt.minion      ][INFO    ][32288] Starting a new job with PID 32288
2017-11-02 22:35:27,362 [salt.minion      ][INFO    ][32288] Returning information for job: 20171102223527297145
2017-11-02 22:35:55,693 [salt.minion      ][INFO    ][24196] User sudo_ubuntu Executing command state.sls with jid 20171102223555679163
2017-11-02 22:35:55,705 [salt.minion      ][INFO    ][32297] Starting a new job with PID 32297
2017-11-02 22:35:56,260 [salt.state       ][INFO    ][32297] Loading fresh modules for state activity
2017-11-02 22:35:56,294 [salt.fileclient  ][INFO    ][32297] Fetching file from saltenv 'base', ** done ** 'keepalived/init.sls'
2017-11-02 22:35:56,315 [salt.fileclient  ][INFO    ][32297] Fetching file from saltenv 'base', ** done ** 'keepalived/cluster.sls'
2017-11-02 22:35:56,344 [salt.fileclient  ][INFO    ][32297] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-11-02 22:35:56,647 [salt.state       ][INFO    ][32297] Running state [lsof] at time 22:35:56.647155
2017-11-02 22:35:56,648 [salt.state       ][INFO    ][32297] Executing state pkg.installed for lsof
2017-11-02 22:35:56,648 [salt.loaded.int.module.cmdmod][INFO    ][32297] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-02 22:35:56,907 [salt.state       ][INFO    ][32297] Package lsof is already installed
2017-11-02 22:35:56,908 [salt.state       ][INFO    ][32297] Completed state [lsof] at time 22:35:56.907623 duration_in_ms=260.469
2017-11-02 22:35:56,908 [salt.state       ][INFO    ][32297] Running state [keepalived] at time 22:35:56.907904
2017-11-02 22:35:56,908 [salt.state       ][INFO    ][32297] Executing state pkg.installed for keepalived
2017-11-02 22:35:56,912 [salt.state       ][INFO    ][32297] Package keepalived is already installed
2017-11-02 22:35:56,912 [salt.state       ][INFO    ][32297] Completed state [keepalived] at time 22:35:56.911993 duration_in_ms=4.09
2017-11-02 22:35:56,914 [salt.state       ][INFO    ][32297] Running state [/etc/keepalived/keepalived.conf] at time 22:35:56.913553
2017-11-02 22:35:56,914 [salt.state       ][INFO    ][32297] Executing state file.managed for /etc/keepalived/keepalived.conf
2017-11-02 22:35:56,940 [salt.fileclient  ][INFO    ][32297] Fetching file from saltenv 'base', ** done ** 'keepalived/files/keepalived.conf'
2017-11-02 22:35:56,979 [salt.fileclient  ][INFO    ][32297] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-11-02 22:35:56,985 [salt.state       ][INFO    ][32297] File /etc/keepalived/keepalived.conf is in the correct state
2017-11-02 22:35:56,985 [salt.state       ][INFO    ][32297] Completed state [/etc/keepalived/keepalived.conf] at time 22:35:56.985077 duration_in_ms=71.524
2017-11-02 22:35:56,986 [salt.state       ][INFO    ][32297] Running state [keepalived] at time 22:35:56.985700
2017-11-02 22:35:56,986 [salt.state       ][INFO    ][32297] Executing state service.running for keepalived
2017-11-02 22:35:56,986 [salt.loaded.int.module.cmdmod][INFO    ][32297] Executing command ['systemctl', 'status', 'keepalived.service', '-n', '0'] in directory '/root'
2017-11-02 22:35:57,003 [salt.loaded.int.module.cmdmod][INFO    ][32297] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2017-11-02 22:35:57,011 [salt.loaded.int.module.cmdmod][INFO    ][32297] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-11-02 22:35:57,019 [salt.state       ][INFO    ][32297] The service keepalived is already running
2017-11-02 22:35:57,019 [salt.state       ][INFO    ][32297] Completed state [keepalived] at time 22:35:57.018830 duration_in_ms=33.129
2017-11-02 22:35:57,020 [salt.minion      ][INFO    ][32297] Returning information for job: 20171102223555679163
2017-11-02 22:36:04,268 [salt.minion      ][INFO    ][24196] User sudo_ubuntu Executing command pillar.get with jid 20171102223604258991
2017-11-02 22:36:04,283 [salt.minion      ][INFO    ][32322] Starting a new job with PID 32322
2017-11-02 22:36:04,290 [salt.minion      ][INFO    ][32322] Returning information for job: 20171102223604258991
2017-11-02 22:36:55,009 [salt.minion      ][INFO    ][24196] User sudo_ubuntu Executing command state.sls with jid 20171102223655000540
2017-11-02 22:36:55,023 [salt.minion      ][INFO    ][32333] Starting a new job with PID 32333
2017-11-02 22:36:57,587 [salt.state       ][INFO    ][32333] Loading fresh modules for state activity
2017-11-02 22:36:57,614 [salt.fileclient  ][INFO    ][32333] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-11-02 22:36:57,643 [salt.fileclient  ][INFO    ][32333] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-11-02 22:36:57,961 [salt.state       ][INFO    ][32333] Running state [attr] at time 22:36:57.960507
2017-11-02 22:36:57,961 [salt.state       ][INFO    ][32333] Executing state pkg.installed for attr
2017-11-02 22:36:57,961 [salt.loaded.int.module.cmdmod][INFO    ][32333] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-02 22:36:58,217 [salt.state       ][INFO    ][32333] Package attr is already installed
2017-11-02 22:36:58,218 [salt.state       ][INFO    ][32333] Completed state [attr] at time 22:36:58.217685 duration_in_ms=257.179
2017-11-02 22:36:58,218 [salt.state       ][INFO    ][32333] Running state [glusterfs-server] at time 22:36:58.217919
2017-11-02 22:36:58,218 [salt.state       ][INFO    ][32333] Executing state pkg.installed for glusterfs-server
2017-11-02 22:36:58,222 [salt.state       ][INFO    ][32333] Package glusterfs-server is already installed
2017-11-02 22:36:58,222 [salt.state       ][INFO    ][32333] Completed state [glusterfs-server] at time 22:36:58.221969 duration_in_ms=4.05
2017-11-02 22:36:58,222 [salt.state       ][INFO    ][32333] Running state [bc] at time 22:36:58.222164
2017-11-02 22:36:58,222 [salt.state       ][INFO    ][32333] Executing state pkg.installed for bc
2017-11-02 22:36:58,226 [salt.state       ][INFO    ][32333] Package bc is already installed
2017-11-02 22:36:58,226 [salt.state       ][INFO    ][32333] Completed state [bc] at time 22:36:58.226099 duration_in_ms=3.935
2017-11-02 22:36:58,227 [salt.state       ][INFO    ][32333] Running state [glusterfs-server] at time 22:36:58.226861
2017-11-02 22:36:58,227 [salt.state       ][INFO    ][32333] Executing state service.running for glusterfs-server
2017-11-02 22:36:58,227 [salt.loaded.int.module.cmdmod][INFO    ][32333] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-11-02 22:36:58,245 [salt.loaded.int.module.cmdmod][INFO    ][32333] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-11-02 22:36:58,253 [salt.loaded.int.module.cmdmod][INFO    ][32333] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-11-02 22:36:58,263 [salt.state       ][INFO    ][32333] The service glusterfs-server is already running
2017-11-02 22:36:58,263 [salt.state       ][INFO    ][32333] Completed state [glusterfs-server] at time 22:36:58.262822 duration_in_ms=35.961
2017-11-02 22:36:58,264 [salt.state       ][INFO    ][32333] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 22:36:58.264294
2017-11-02 22:36:58,265 [salt.state       ][INFO    ][32333] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-11-02 22:36:58,267 [salt.state       ][INFO    ][32333] File /etc/systemd/system/glusterfs-server.service.d/override.conf is in the correct state
2017-11-02 22:36:58,267 [salt.state       ][INFO    ][32333] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 22:36:58.266716 duration_in_ms=2.423
2017-11-02 22:36:58,267 [salt.state       ][INFO    ][32333] Running state [/srv/glusterfs/glance] at time 22:36:58.266895
2017-11-02 22:36:58,267 [salt.state       ][INFO    ][32333] Executing state file.directory for /srv/glusterfs/glance
2017-11-02 22:36:58,267 [salt.state       ][INFO    ][32333] Directory /srv/glusterfs/glance is in the correct state
2017-11-02 22:36:58,268 [salt.state       ][INFO    ][32333] Completed state [/srv/glusterfs/glance] at time 22:36:58.267607 duration_in_ms=0.712
2017-11-02 22:36:58,268 [salt.state       ][INFO    ][32333] Running state [/srv/glusterfs/keystone-keys] at time 22:36:58.267782
2017-11-02 22:36:58,268 [salt.state       ][INFO    ][32333] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-11-02 22:36:58,268 [salt.state       ][INFO    ][32333] Directory /srv/glusterfs/keystone-keys is in the correct state
2017-11-02 22:36:58,269 [salt.state       ][INFO    ][32333] Completed state [/srv/glusterfs/keystone-keys] at time 22:36:58.268475 duration_in_ms=0.693
2017-11-02 22:36:58,269 [salt.state       ][INFO    ][32333] Running state [/srv/glusterfs/nova_instances] at time 22:36:58.268632
2017-11-02 22:36:58,269 [salt.state       ][INFO    ][32333] Executing state file.directory for /srv/glusterfs/nova_instances
2017-11-02 22:36:58,269 [salt.state       ][INFO    ][32333] Directory /srv/glusterfs/nova_instances is in the correct state
2017-11-02 22:36:58,269 [salt.state       ][INFO    ][32333] Completed state [/srv/glusterfs/nova_instances] at time 22:36:58.269281 duration_in_ms=0.649
2017-11-02 22:36:58,269 [salt.state       ][INFO    ][32333] Running state [/srv/glusterfs/keystone-credential-keys] at time 22:36:58.269443
2017-11-02 22:36:58,270 [salt.state       ][INFO    ][32333] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-11-02 22:36:58,270 [salt.state       ][INFO    ][32333] Directory /srv/glusterfs/keystone-credential-keys is in the correct state
2017-11-02 22:36:58,270 [salt.state       ][INFO    ][32333] Completed state [/srv/glusterfs/keystone-credential-keys] at time 22:36:58.270171 duration_in_ms=0.728
2017-11-02 22:36:58,271 [salt.minion      ][INFO    ][32333] Returning information for job: 20171102223655000540
2017-11-02 22:36:59,576 [salt.minion      ][INFO    ][24196] User sudo_ubuntu Executing command test.ping with jid 20171102223659564878
2017-11-02 22:36:59,589 [salt.minion      ][INFO    ][32357] Starting a new job with PID 32357
2017-11-02 22:36:59,624 [salt.minion      ][INFO    ][32357] Returning information for job: 20171102223659564878
2017-11-02 22:37:06,457 [salt.minion      ][INFO    ][24196] User sudo_ubuntu Executing command state.sls with jid 20171102223706448681
2017-11-02 22:37:06,471 [salt.minion      ][INFO    ][32362] Starting a new job with PID 32362
2017-11-02 22:37:07,022 [salt.state       ][INFO    ][32362] Loading fresh modules for state activity
2017-11-02 22:37:07,051 [salt.fileclient  ][INFO    ][32362] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/setup.sls'
2017-11-02 22:37:07,089 [salt.fileclient  ][INFO    ][32362] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-11-02 22:37:07,167 [salt.fileclient  ][INFO    ][32362] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-11-02 22:37:07,185 [salt.fileclient  ][INFO    ][32362] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-11-02 22:37:07,521 [salt.state       ][INFO    ][32362] Running state [attr] at time 22:37:07.521412
2017-11-02 22:37:07,522 [salt.state       ][INFO    ][32362] Executing state pkg.installed for attr
2017-11-02 22:37:07,522 [salt.loaded.int.module.cmdmod][INFO    ][32362] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-02 22:37:07,776 [salt.state       ][INFO    ][32362] Package attr is already installed
2017-11-02 22:37:07,776 [salt.state       ][INFO    ][32362] Completed state [attr] at time 22:37:07.775927 duration_in_ms=254.515
2017-11-02 22:37:07,776 [salt.state       ][INFO    ][32362] Running state [glusterfs-server] at time 22:37:07.776201
2017-11-02 22:37:07,776 [salt.state       ][INFO    ][32362] Executing state pkg.installed for glusterfs-server
2017-11-02 22:37:07,780 [salt.state       ][INFO    ][32362] Package glusterfs-server is already installed
2017-11-02 22:37:07,781 [salt.state       ][INFO    ][32362] Completed state [glusterfs-server] at time 22:37:07.780501 duration_in_ms=4.3
2017-11-02 22:37:07,781 [salt.state       ][INFO    ][32362] Running state [bc] at time 22:37:07.780717
2017-11-02 22:37:07,781 [salt.state       ][INFO    ][32362] Executing state pkg.installed for bc
2017-11-02 22:37:07,785 [salt.state       ][INFO    ][32362] Package bc is already installed
2017-11-02 22:37:07,785 [salt.state       ][INFO    ][32362] Completed state [bc] at time 22:37:07.785111 duration_in_ms=4.394
2017-11-02 22:37:07,786 [salt.state       ][INFO    ][32362] Running state [glusterfs-server] at time 22:37:07.786245
2017-11-02 22:37:07,786 [salt.state       ][INFO    ][32362] Executing state service.running for glusterfs-server
2017-11-02 22:37:07,787 [salt.loaded.int.module.cmdmod][INFO    ][32362] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-11-02 22:37:07,803 [salt.loaded.int.module.cmdmod][INFO    ][32362] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-11-02 22:37:07,811 [salt.loaded.int.module.cmdmod][INFO    ][32362] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-11-02 22:37:07,821 [salt.state       ][INFO    ][32362] The service glusterfs-server is already running
2017-11-02 22:37:07,821 [salt.state       ][INFO    ][32362] Completed state [glusterfs-server] at time 22:37:07.820764 duration_in_ms=34.519
2017-11-02 22:37:07,822 [salt.state       ][INFO    ][32362] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 22:37:07.822349
2017-11-02 22:37:07,823 [salt.state       ][INFO    ][32362] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-11-02 22:37:07,825 [salt.state       ][INFO    ][32362] File /etc/systemd/system/glusterfs-server.service.d/override.conf is in the correct state
2017-11-02 22:37:07,825 [salt.state       ][INFO    ][32362] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 22:37:07.824880 duration_in_ms=2.531
2017-11-02 22:37:07,825 [salt.state       ][INFO    ][32362] Running state [/srv/glusterfs/glance] at time 22:37:07.825096
2017-11-02 22:37:07,825 [salt.state       ][INFO    ][32362] Executing state file.directory for /srv/glusterfs/glance
2017-11-02 22:37:07,826 [salt.state       ][INFO    ][32362] Directory /srv/glusterfs/glance is in the correct state
2017-11-02 22:37:07,826 [salt.state       ][INFO    ][32362] Completed state [/srv/glusterfs/glance] at time 22:37:07.825943 duration_in_ms=0.847
2017-11-02 22:37:07,826 [salt.state       ][INFO    ][32362] Running state [/srv/glusterfs/keystone-keys] at time 22:37:07.826151
2017-11-02 22:37:07,826 [salt.state       ][INFO    ][32362] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-11-02 22:37:07,827 [salt.state       ][INFO    ][32362] Directory /srv/glusterfs/keystone-keys is in the correct state
2017-11-02 22:37:07,827 [salt.state       ][INFO    ][32362] Completed state [/srv/glusterfs/keystone-keys] at time 22:37:07.826982 duration_in_ms=0.83
2017-11-02 22:37:07,827 [salt.state       ][INFO    ][32362] Running state [/srv/glusterfs/nova_instances] at time 22:37:07.827167
2017-11-02 22:37:07,827 [salt.state       ][INFO    ][32362] Executing state file.directory for /srv/glusterfs/nova_instances
2017-11-02 22:37:07,828 [salt.state       ][INFO    ][32362] Directory /srv/glusterfs/nova_instances is in the correct state
2017-11-02 22:37:07,828 [salt.state       ][INFO    ][32362] Completed state [/srv/glusterfs/nova_instances] at time 22:37:07.827927 duration_in_ms=0.76
2017-11-02 22:37:07,828 [salt.state       ][INFO    ][32362] Running state [/srv/glusterfs/keystone-credential-keys] at time 22:37:07.828122
2017-11-02 22:37:07,828 [salt.state       ][INFO    ][32362] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-11-02 22:37:07,829 [salt.state       ][INFO    ][32362] Directory /srv/glusterfs/keystone-credential-keys is in the correct state
2017-11-02 22:37:07,829 [salt.state       ][INFO    ][32362] Completed state [/srv/glusterfs/keystone-credential-keys] at time 22:37:07.828939 duration_in_ms=0.818
2017-11-02 22:37:07,873 [salt.loaded.int.module.cmdmod][INFO    ][32362] Executing command ['git', '--version'] in directory '/root'
2017-11-02 22:37:07,963 [salt.state       ][INFO    ][32362] Running state [sleep 5] at time 22:37:07.962571
2017-11-02 22:37:07,963 [salt.state       ][INFO    ][32362] Executing state cmd.wait for sleep 5
2017-11-02 22:37:07,963 [salt.state       ][INFO    ][32362] No changes made for sleep 5
2017-11-02 22:37:07,963 [salt.state       ][INFO    ][32362] Completed state [sleep 5] at time 22:37:07.963368 duration_in_ms=0.797
2017-11-02 22:37:07,964 [salt.state       ][INFO    ][32362] Running state [192.168.10.143] at time 22:37:07.963970
2017-11-02 22:37:07,964 [salt.state       ][INFO    ][32362] Executing state glusterfs.peered for 192.168.10.143
2017-11-02 22:37:07,965 [salt.loaded.int.module.cmdmod][INFO    ][32362] Executing command 'gluster --version' in directory '/root'
2017-11-02 22:37:07,974 [salt.loaded.int.module.cmdmod][INFO    ][32362] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-02 22:37:08,027 [salt.loaded.int.module.cmdmod][INFO    ][32362] Executing command 'gluster --version' in directory '/root'
2017-11-02 22:37:08,036 [salt.loaded.int.module.cmdmod][INFO    ][32362] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-02 22:37:08,088 [salt.loaded.int.module.cmdmod][INFO    ][32362] Executing command 'gluster --version' in directory '/root'
2017-11-02 22:37:08,097 [salt.loaded.int.module.cmdmod][INFO    ][32362] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-02 22:37:08,151 [salt.loaded.int.module.cmdmod][INFO    ][32362] Executing command 'gluster --version' in directory '/root'
2017-11-02 22:37:08,159 [salt.loaded.int.module.cmdmod][INFO    ][32362] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-02 22:37:08,213 [salt.state       ][INFO    ][32362] Peering with localhost is not needed
2017-11-02 22:37:08,213 [salt.state       ][INFO    ][32362] Completed state [192.168.10.143] at time 22:37:08.212744 duration_in_ms=248.774
2017-11-02 22:37:08,216 [salt.state       ][INFO    ][32362] Running state [192.168.10.142] at time 22:37:08.215820
2017-11-02 22:37:08,216 [salt.state       ][INFO    ][32362] Executing state glusterfs.peered for 192.168.10.142
2017-11-02 22:37:08,217 [salt.loaded.int.module.cmdmod][INFO    ][32362] Executing command 'gluster --version' in directory '/root'
2017-11-02 22:37:08,224 [salt.loaded.int.module.cmdmod][INFO    ][32362] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-02 22:37:08,276 [salt.state       ][INFO    ][32362] Host 192.168.10.142 already peered
2017-11-02 22:37:08,276 [salt.state       ][INFO    ][32362] Completed state [192.168.10.142] at time 22:37:08.276375 duration_in_ms=60.554
2017-11-02 22:37:08,279 [salt.state       ][INFO    ][32362] Running state [192.168.10.141] at time 22:37:08.279398
2017-11-02 22:37:08,280 [salt.state       ][INFO    ][32362] Executing state glusterfs.peered for 192.168.10.141
2017-11-02 22:37:08,280 [salt.loaded.int.module.cmdmod][INFO    ][32362] Executing command 'gluster --version' in directory '/root'
2017-11-02 22:37:08,288 [salt.loaded.int.module.cmdmod][INFO    ][32362] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-02 22:37:08,340 [salt.state       ][INFO    ][32362] Host 192.168.10.141 already peered
2017-11-02 22:37:08,340 [salt.state       ][INFO    ][32362] Completed state [192.168.10.141] at time 22:37:08.340037 duration_in_ms=60.639
2017-11-02 22:37:08,341 [salt.state       ][INFO    ][32362] Running state [glance] at time 22:37:08.341076
2017-11-02 22:37:08,341 [salt.state       ][INFO    ][32362] Executing state glusterfs.created for glance
2017-11-02 22:37:08,342 [salt.loaded.int.module.cmdmod][INFO    ][32362] Executing command 'gluster --version' in directory '/root'
2017-11-02 22:37:08,349 [salt.loaded.int.module.cmdmod][INFO    ][32362] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-02 22:37:08,399 [salt.loaded.int.module.cmdmod][INFO    ][32362] Executing command 'gluster --version' in directory '/root'
2017-11-02 22:37:08,408 [salt.loaded.int.module.cmdmod][INFO    ][32362] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-02 22:37:08,465 [salt.state       ][INFO    ][32362] Volume glance already exists and is started.
2017-11-02 22:37:08,466 [salt.state       ][INFO    ][32362] Completed state [glance] at time 22:37:08.465738 duration_in_ms=124.661
2017-11-02 22:37:08,470 [salt.state       ][INFO    ][32362] Running state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 22:37:08.469650
2017-11-02 22:37:08,470 [salt.state       ][INFO    ][32362] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'
2017-11-02 22:37:08,470 [salt.loaded.int.module.cmdmod][INFO    ][32362] Executing command 'gluster volume info 'glance' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-11-02 22:37:08,524 [salt.state       ][INFO    ][32362] unless execution succeeded
2017-11-02 22:37:08,525 [salt.state       ][INFO    ][32362] Completed state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 22:37:08.524629 duration_in_ms=54.979
2017-11-02 22:37:08,525 [salt.state       ][INFO    ][32362] Running state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 22:37:08.525254
2017-11-02 22:37:08,526 [salt.state       ][INFO    ][32362] Executing state cmd.run for gluster volume set 'glance' 'network.remote-dio' 'True'
2017-11-02 22:37:08,526 [salt.loaded.int.module.cmdmod][INFO    ][32362] Executing command 'gluster volume info 'glance' | grep 'network.remote-dio: True'' in directory '/root'
2017-11-02 22:37:08,581 [salt.state       ][INFO    ][32362] unless execution succeeded
2017-11-02 22:37:08,582 [salt.state       ][INFO    ][32362] Completed state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 22:37:08.581441 duration_in_ms=56.187
2017-11-02 22:37:08,582 [salt.state       ][INFO    ][32362] Running state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 22:37:08.582022
2017-11-02 22:37:08,582 [salt.state       ][INFO    ][32362] Executing state cmd.run for gluster volume set 'glance' 'nfs.disable' 'True'
2017-11-02 22:37:08,583 [salt.loaded.int.module.cmdmod][INFO    ][32362] Executing command 'gluster volume info 'glance' | grep 'nfs.disable: True'' in directory '/root'
2017-11-02 22:37:08,638 [salt.state       ][INFO    ][32362] unless execution succeeded
2017-11-02 22:37:08,638 [salt.state       ][INFO    ][32362] Completed state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 22:37:08.637939 duration_in_ms=55.915
2017-11-02 22:37:08,639 [salt.state       ][INFO    ][32362] Running state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 22:37:08.638586
2017-11-02 22:37:08,639 [salt.state       ][INFO    ][32362] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'
2017-11-02 22:37:08,639 [salt.loaded.int.module.cmdmod][INFO    ][32362] Executing command 'gluster volume info 'glance' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-11-02 22:37:08,692 [salt.state       ][INFO    ][32362] unless execution succeeded
2017-11-02 22:37:08,693 [salt.state       ][INFO    ][32362] Completed state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 22:37:08.692608 duration_in_ms=54.022
2017-11-02 22:37:08,693 [salt.state       ][INFO    ][32362] Running state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 22:37:08.693184
2017-11-02 22:37:08,693 [salt.state       ][INFO    ][32362] Executing state cmd.run for gluster volume set 'glance' 'cluster.readdir-optimize' 'True'
2017-11-02 22:37:08,694 [salt.loaded.int.module.cmdmod][INFO    ][32362] Executing command 'gluster volume info 'glance' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-11-02 22:37:08,747 [salt.state       ][INFO    ][32362] unless execution succeeded
2017-11-02 22:37:08,748 [salt.state       ][INFO    ][32362] Completed state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 22:37:08.747545 duration_in_ms=54.36
2017-11-02 22:37:08,749 [salt.state       ][INFO    ][32362] Running state [glance] at time 22:37:08.749077
2017-11-02 22:37:08,749 [salt.state       ][INFO    ][32362] Executing state glusterfs.started for glance
2017-11-02 22:37:08,750 [salt.loaded.int.module.cmdmod][INFO    ][32362] Executing command 'gluster --version' in directory '/root'
2017-11-02 22:37:08,759 [salt.loaded.int.module.cmdmod][INFO    ][32362] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-02 22:37:08,812 [salt.loaded.int.module.cmdmod][INFO    ][32362] Executing command 'gluster --version' in directory '/root'
2017-11-02 22:37:08,821 [salt.loaded.int.module.cmdmod][INFO    ][32362] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-02 22:37:08,883 [salt.state       ][INFO    ][32362] Volume glance is already started
2017-11-02 22:37:08,883 [salt.state       ][INFO    ][32362] Completed state [glance] at time 22:37:08.883242 duration_in_ms=134.165
2017-11-02 22:37:08,885 [salt.state       ][INFO    ][32362] Running state [keystone-keys] at time 22:37:08.884842
2017-11-02 22:37:08,885 [salt.state       ][INFO    ][32362] Executing state glusterfs.created for keystone-keys
2017-11-02 22:37:08,886 [salt.loaded.int.module.cmdmod][INFO    ][32362] Executing command 'gluster --version' in directory '/root'
2017-11-02 22:37:08,895 [salt.loaded.int.module.cmdmod][INFO    ][32362] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-02 22:37:08,947 [salt.loaded.int.module.cmdmod][INFO    ][32362] Executing command 'gluster --version' in directory '/root'
2017-11-02 22:37:08,956 [salt.loaded.int.module.cmdmod][INFO    ][32362] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-02 22:37:09,012 [salt.state       ][INFO    ][32362] Volume keystone-keys already exists and is started.
2017-11-02 22:37:09,012 [salt.state       ][INFO    ][32362] Completed state [keystone-keys] at time 22:37:09.012101 duration_in_ms=127.259
2017-11-02 22:37:09,017 [salt.state       ][INFO    ][32362] Running state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 22:37:09.016541
2017-11-02 22:37:09,017 [salt.state       ][INFO    ][32362] Executing state cmd.run for gluster volume set 'keystone-keys' 'network.remote-dio' 'True'
2017-11-02 22:37:09,018 [salt.loaded.int.module.cmdmod][INFO    ][32362] Executing command 'gluster volume info 'keystone-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-11-02 22:37:09,069 [salt.state       ][INFO    ][32362] unless execution succeeded
2017-11-02 22:37:09,070 [salt.state       ][INFO    ][32362] Completed state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 22:37:09.069531 duration_in_ms=52.99
2017-11-02 22:37:09,070 [salt.state       ][INFO    ][32362] Running state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 22:37:09.070130
2017-11-02 22:37:09,070 [salt.state       ][INFO    ][32362] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-11-02 22:37:09,071 [salt.loaded.int.module.cmdmod][INFO    ][32362] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-11-02 22:37:09,123 [salt.state       ][INFO    ][32362] unless execution succeeded
2017-11-02 22:37:09,123 [salt.state       ][INFO    ][32362] Completed state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 22:37:09.123164 duration_in_ms=53.033
2017-11-02 22:37:09,124 [salt.state       ][INFO    ][32362] Running state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 22:37:09.123723
2017-11-02 22:37:09,124 [salt.state       ][INFO    ][32362] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'
2017-11-02 22:37:09,125 [salt.loaded.int.module.cmdmod][INFO    ][32362] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-11-02 22:37:09,177 [salt.state       ][INFO    ][32362] unless execution succeeded
2017-11-02 22:37:09,177 [salt.state       ][INFO    ][32362] Completed state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 22:37:09.177044 duration_in_ms=53.32
2017-11-02 22:37:09,178 [salt.state       ][INFO    ][32362] Running state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 22:37:09.177675
2017-11-02 22:37:09,178 [salt.state       ][INFO    ][32362] Executing state cmd.run for gluster volume set 'keystone-keys' 'nfs.disable' 'True'
2017-11-02 22:37:09,178 [salt.loaded.int.module.cmdmod][INFO    ][32362] Executing command 'gluster volume info 'keystone-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-11-02 22:37:09,233 [salt.state       ][INFO    ][32362] unless execution succeeded
2017-11-02 22:37:09,233 [salt.state       ][INFO    ][32362] Completed state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 22:37:09.232996 duration_in_ms=55.32
2017-11-02 22:37:09,234 [salt.state       ][INFO    ][32362] Running state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 22:37:09.233560
2017-11-02 22:37:09,234 [salt.state       ][INFO    ][32362] Executing state cmd.run for gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'
2017-11-02 22:37:09,234 [salt.loaded.int.module.cmdmod][INFO    ][32362] Executing command 'gluster volume info 'keystone-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-11-02 22:37:09,287 [salt.state       ][INFO    ][32362] unless execution succeeded
2017-11-02 22:37:09,288 [salt.state       ][INFO    ][32362] Completed state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 22:37:09.287533 duration_in_ms=53.963
2017-11-02 22:37:09,289 [salt.state       ][INFO    ][32362] Running state [keystone-keys] at time 22:37:09.288848
2017-11-02 22:37:09,289 [salt.state       ][INFO    ][32362] Executing state glusterfs.started for keystone-keys
2017-11-02 22:37:09,290 [salt.loaded.int.module.cmdmod][INFO    ][32362] Executing command 'gluster --version' in directory '/root'
2017-11-02 22:37:09,298 [salt.loaded.int.module.cmdmod][INFO    ][32362] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-02 22:37:09,351 [salt.loaded.int.module.cmdmod][INFO    ][32362] Executing command 'gluster --version' in directory '/root'
2017-11-02 22:37:09,360 [salt.loaded.int.module.cmdmod][INFO    ][32362] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-02 22:37:09,416 [salt.state       ][INFO    ][32362] Volume keystone-keys is already started
2017-11-02 22:37:09,417 [salt.state       ][INFO    ][32362] Completed state [keystone-keys] at time 22:37:09.416663 duration_in_ms=127.814
2017-11-02 22:37:09,418 [salt.state       ][INFO    ][32362] Running state [nova_instances] at time 22:37:09.417824
2017-11-02 22:37:09,418 [salt.state       ][INFO    ][32362] Executing state glusterfs.created for nova_instances
2017-11-02 22:37:09,419 [salt.loaded.int.module.cmdmod][INFO    ][32362] Executing command 'gluster --version' in directory '/root'
2017-11-02 22:37:09,427 [salt.loaded.int.module.cmdmod][INFO    ][32362] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-02 22:37:09,481 [salt.loaded.int.module.cmdmod][INFO    ][32362] Executing command 'gluster --version' in directory '/root'
2017-11-02 22:37:09,490 [salt.loaded.int.module.cmdmod][INFO    ][32362] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-02 22:37:09,548 [salt.state       ][INFO    ][32362] Volume nova_instances already exists and is started.
2017-11-02 22:37:09,548 [salt.state       ][INFO    ][32362] Completed state [nova_instances] at time 22:37:09.548052 duration_in_ms=130.227
2017-11-02 22:37:09,553 [salt.state       ][INFO    ][32362] Running state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 22:37:09.553070
2017-11-02 22:37:09,553 [salt.state       ][INFO    ][32362] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'
2017-11-02 22:37:09,554 [salt.loaded.int.module.cmdmod][INFO    ][32362] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-11-02 22:37:09,605 [salt.state       ][INFO    ][32362] unless execution succeeded
2017-11-02 22:37:09,605 [salt.state       ][INFO    ][32362] Completed state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 22:37:09.605103 duration_in_ms=52.032
2017-11-02 22:37:09,606 [salt.state       ][INFO    ][32362] Running state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'On'] at time 22:37:09.605659
2017-11-02 22:37:09,606 [salt.state       ][INFO    ][32362] Executing state cmd.run for gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'On'
2017-11-02 22:37:09,606 [salt.loaded.int.module.cmdmod][INFO    ][32362] Executing command 'gluster volume info 'nova_instances' | grep 'cluster.readdir-optimize: On'' in directory '/root'
2017-11-02 22:37:09,658 [salt.state       ][INFO    ][32362] unless execution succeeded
2017-11-02 22:37:09,659 [salt.state       ][INFO    ][32362] Completed state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'On'] at time 22:37:09.658553 duration_in_ms=52.892
2017-11-02 22:37:09,659 [salt.state       ][INFO    ][32362] Running state [gluster volume set 'nova_instances' 'network.remote-dio' 'On'] at time 22:37:09.659167
2017-11-02 22:37:09,659 [salt.state       ][INFO    ][32362] Executing state cmd.run for gluster volume set 'nova_instances' 'network.remote-dio' 'On'
2017-11-02 22:37:09,660 [salt.loaded.int.module.cmdmod][INFO    ][32362] Executing command 'gluster volume info 'nova_instances' | grep 'network.remote-dio: On'' in directory '/root'
2017-11-02 22:37:09,713 [salt.state       ][INFO    ][32362] unless execution succeeded
2017-11-02 22:37:09,713 [salt.state       ][INFO    ][32362] Completed state [gluster volume set 'nova_instances' 'network.remote-dio' 'On'] at time 22:37:09.712884 duration_in_ms=53.717
2017-11-02 22:37:09,714 [salt.state       ][INFO    ][32362] Running state [gluster volume set 'nova_instances' 'nfs.disable' 'On'] at time 22:37:09.713551
2017-11-02 22:37:09,714 [salt.state       ][INFO    ][32362] Executing state cmd.run for gluster volume set 'nova_instances' 'nfs.disable' 'On'
2017-11-02 22:37:09,714 [salt.loaded.int.module.cmdmod][INFO    ][32362] Executing command 'gluster volume info 'nova_instances' | grep 'nfs.disable: On'' in directory '/root'
2017-11-02 22:37:09,767 [salt.state       ][INFO    ][32362] unless execution succeeded
2017-11-02 22:37:09,767 [salt.state       ][INFO    ][32362] Completed state [gluster volume set 'nova_instances' 'nfs.disable' 'On'] at time 22:37:09.766889 duration_in_ms=53.328
2017-11-02 22:37:09,768 [salt.state       ][INFO    ][32362] Running state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 22:37:09.767585
2017-11-02 22:37:09,768 [salt.state       ][INFO    ][32362] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'
2017-11-02 22:37:09,769 [salt.loaded.int.module.cmdmod][INFO    ][32362] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-11-02 22:37:09,823 [salt.state       ][INFO    ][32362] unless execution succeeded
2017-11-02 22:37:09,824 [salt.state       ][INFO    ][32362] Completed state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 22:37:09.823927 duration_in_ms=56.342
2017-11-02 22:37:09,825 [salt.state       ][INFO    ][32362] Running state [nova_instances] at time 22:37:09.825362
2017-11-02 22:37:09,826 [salt.state       ][INFO    ][32362] Executing state glusterfs.started for nova_instances
2017-11-02 22:37:09,826 [salt.loaded.int.module.cmdmod][INFO    ][32362] Executing command 'gluster --version' in directory '/root'
2017-11-02 22:37:09,836 [salt.loaded.int.module.cmdmod][INFO    ][32362] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-02 22:37:09,888 [salt.loaded.int.module.cmdmod][INFO    ][32362] Executing command 'gluster --version' in directory '/root'
2017-11-02 22:37:09,896 [salt.loaded.int.module.cmdmod][INFO    ][32362] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-02 22:37:09,955 [salt.state       ][INFO    ][32362] Volume nova_instances is already started
2017-11-02 22:37:09,955 [salt.state       ][INFO    ][32362] Completed state [nova_instances] at time 22:37:09.954784 duration_in_ms=129.422
2017-11-02 22:37:09,956 [salt.state       ][INFO    ][32362] Running state [keystone-credential-keys] at time 22:37:09.955990
2017-11-02 22:37:09,956 [salt.state       ][INFO    ][32362] Executing state glusterfs.created for keystone-credential-keys
2017-11-02 22:37:09,957 [salt.loaded.int.module.cmdmod][INFO    ][32362] Executing command 'gluster --version' in directory '/root'
2017-11-02 22:37:09,965 [salt.loaded.int.module.cmdmod][INFO    ][32362] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-02 22:37:10,020 [salt.loaded.int.module.cmdmod][INFO    ][32362] Executing command 'gluster --version' in directory '/root'
2017-11-02 22:37:10,028 [salt.loaded.int.module.cmdmod][INFO    ][32362] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-02 22:37:10,084 [salt.state       ][INFO    ][32362] Volume keystone-credential-keys already exists and is started.
2017-11-02 22:37:10,084 [salt.state       ][INFO    ][32362] Completed state [keystone-credential-keys] at time 22:37:10.084276 duration_in_ms=128.286
2017-11-02 22:37:10,089 [salt.state       ][INFO    ][32362] Running state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 22:37:10.088769
2017-11-02 22:37:10,089 [salt.state       ][INFO    ][32362] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'
2017-11-02 22:37:10,090 [salt.loaded.int.module.cmdmod][INFO    ][32362] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-11-02 22:37:10,142 [salt.state       ][INFO    ][32362] unless execution succeeded
2017-11-02 22:37:10,142 [salt.state       ][INFO    ][32362] Completed state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 22:37:10.142025 duration_in_ms=53.256
2017-11-02 22:37:10,143 [salt.state       ][INFO    ][32362] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 22:37:10.142672
2017-11-02 22:37:10,143 [salt.state       ][INFO    ][32362] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-11-02 22:37:10,143 [salt.loaded.int.module.cmdmod][INFO    ][32362] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-11-02 22:37:10,198 [salt.state       ][INFO    ][32362] unless execution succeeded
2017-11-02 22:37:10,199 [salt.state       ][INFO    ][32362] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 22:37:10.198525 duration_in_ms=55.853
2017-11-02 22:37:10,199 [salt.state       ][INFO    ][32362] Running state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 22:37:10.199195
2017-11-02 22:37:10,199 [salt.state       ][INFO    ][32362] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'
2017-11-02 22:37:10,200 [salt.loaded.int.module.cmdmod][INFO    ][32362] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-11-02 22:37:10,251 [salt.state       ][INFO    ][32362] unless execution succeeded
2017-11-02 22:37:10,252 [salt.state       ][INFO    ][32362] Completed state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 22:37:10.251545 duration_in_ms=52.349
2017-11-02 22:37:10,252 [salt.state       ][INFO    ][32362] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 22:37:10.252123
2017-11-02 22:37:10,252 [salt.state       ][INFO    ][32362] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'
2017-11-02 22:37:10,253 [salt.loaded.int.module.cmdmod][INFO    ][32362] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-11-02 22:37:10,306 [salt.state       ][INFO    ][32362] unless execution succeeded
2017-11-02 22:37:10,306 [salt.state       ][INFO    ][32362] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 22:37:10.306231 duration_in_ms=54.108
2017-11-02 22:37:10,307 [salt.state       ][INFO    ][32362] Running state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 22:37:10.306889
2017-11-02 22:37:10,307 [salt.state       ][INFO    ][32362] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'
2017-11-02 22:37:10,308 [salt.loaded.int.module.cmdmod][INFO    ][32362] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-11-02 22:37:10,361 [salt.state       ][INFO    ][32362] unless execution succeeded
2017-11-02 22:37:10,361 [salt.state       ][INFO    ][32362] Completed state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 22:37:10.360811 duration_in_ms=53.922
2017-11-02 22:37:10,362 [salt.state       ][INFO    ][32362] Running state [keystone-credential-keys] at time 22:37:10.362225
2017-11-02 22:37:10,363 [salt.state       ][INFO    ][32362] Executing state glusterfs.started for keystone-credential-keys
2017-11-02 22:37:10,363 [salt.loaded.int.module.cmdmod][INFO    ][32362] Executing command 'gluster --version' in directory '/root'
2017-11-02 22:37:10,371 [salt.loaded.int.module.cmdmod][INFO    ][32362] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-02 22:37:10,424 [salt.loaded.int.module.cmdmod][INFO    ][32362] Executing command 'gluster --version' in directory '/root'
2017-11-02 22:37:10,432 [salt.loaded.int.module.cmdmod][INFO    ][32362] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-02 22:37:10,491 [salt.state       ][INFO    ][32362] Volume keystone-credential-keys is already started
2017-11-02 22:37:10,491 [salt.state       ][INFO    ][32362] Completed state [keystone-credential-keys] at time 22:37:10.490788 duration_in_ms=128.561
2017-11-02 22:37:10,493 [salt.minion      ][INFO    ][32362] Returning information for job: 20171102223706448681
2017-11-02 22:37:15,690 [salt.minion      ][INFO    ][24196] User sudo_ubuntu Executing command test.ping with jid 20171102223715681034
2017-11-02 22:37:15,701 [salt.minion      ][INFO    ][32746] Starting a new job with PID 32746
2017-11-02 22:37:15,739 [salt.minion      ][INFO    ][32746] Returning information for job: 20171102223715681034
2017-11-02 22:37:16,271 [salt.minion      ][INFO    ][24196] User sudo_ubuntu Executing command cmd.run with jid 20171102223716258235
2017-11-02 22:37:16,281 [salt.minion      ][INFO    ][32751] Starting a new job with PID 32751
2017-11-02 22:37:16,285 [salt.loaded.int.module.cmdmod][INFO    ][32751] Executing command 'gluster peer status; gluster volume status' in directory '/root'
2017-11-02 22:37:16,406 [salt.minion      ][INFO    ][32751] Returning information for job: 20171102223716258235
2017-11-02 22:44:36,228 [salt.utils.schedule][INFO    ][24196] Running scheduled job: __mine_interval
2017-11-02 23:00:20,721 [salt.minion      ][INFO    ][24196] User sudo_ubuntu Executing command cp.push_dir with jid 20171102230020710633
2017-11-02 23:00:20,735 [salt.minion      ][INFO    ][33028] Starting a new job with PID 33028
