2017-11-20 09:16:44,611 [salt.cli.daemons ][WARNING ][2171] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-11-20 09:17:09,105 [salt.state       ][ERROR   ][3633] No contents found in top file
2017-11-20 09:19:08,511 [salt.utils.parsers][WARNING ][2171] Minion received a SIGTERM. Exiting.
2017-11-20 09:23:39,743 [salt.cli.daemons ][WARNING ][3399] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-11-20 09:25:06,990 [salt.transport.ipc][ERROR   ][3399] Exception occurred while handling stream: [Errno 0] Success
2017-11-20 09:25:52,378 [py.warnings      ][WARNING ][16497] /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-20 09:26:15,294 [salt.loaded.int.module.cmdmod][ERROR   ][16497] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-11-20 09:26:15,295 [salt.loaded.int.module.cmdmod][ERROR   ][16497] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-11-20 09:26:19,895 [salt.loaded.int.module.cmdmod][ERROR   ][16497] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-11-20 09:26:19,896 [salt.loaded.int.module.cmdmod][ERROR   ][16497] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-11-20 09:26:24,351 [salt.loaded.int.module.cmdmod][ERROR   ][16497] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-11-20 09:26:24,352 [salt.loaded.int.module.cmdmod][ERROR   ][16497] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-11-20 09:26:29,256 [salt.loaded.int.module.cmdmod][ERROR   ][16497] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-11-20 09:26:29,256 [salt.loaded.int.module.cmdmod][ERROR   ][16497] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-11-20 09:26:33,784 [salt.loaded.int.module.cmdmod][ERROR   ][16497] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-11-20 09:26:33,785 [salt.loaded.int.module.cmdmod][ERROR   ][16497] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-11-20 09:26:38,321 [salt.loaded.int.module.cmdmod][ERROR   ][16497] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-11-20 09:26:38,321 [salt.loaded.int.module.cmdmod][ERROR   ][16497] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-11-20 09:26:41,774 [salt.loaded.int.module.cmdmod][ERROR   ][16497] 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-20 09:26:45,361 [salt.state       ][ERROR   ][24427] No contents found in top file
2017-11-20 09:26:49,161 [salt.loaded.int.module.cmdmod][INFO    ][24707] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2017-11-20 09:26:49,169 [salt.loaded.int.module.cmdmod][INFO    ][24707] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2017-11-20 09:26:49,181 [salt.loaded.int.module.cmdmod][INFO    ][24707] Executing command ['systemd-run', '--scope', 'systemctl', 'restart', 'salt-minion.service'] in directory '/root'
2017-11-20 09:26:49,189 [salt.utils.parsers][WARNING ][3399] Minion received a SIGTERM. Exiting.
2017-11-20 09:26:49,505 [salt.cli.daemons ][INFO    ][24842] Setting up the Salt Minion "kvm03.baremetal-mcp-ocata-odl-ha.local"
2017-11-20 09:26:50,161 [salt.minion      ][INFO    ][24842] Creating minion process manager
2017-11-20 09:26:50,162 [salt.cli.daemons ][WARNING ][24842] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-11-20 09:26:50,162 [salt.cli.daemons ][INFO    ][24842] The Salt Minion is starting up
2017-11-20 09:26:50,162 [salt.minion      ][INFO    ][24842] Minion is starting as user 'root'
2017-11-20 09:26:50,163 [salt.utils.event ][INFO    ][24842] Starting pull socket on /var/run/salt/minion/minion_event_2d6d7b82d1_pull.ipc
2017-11-20 09:26:51,307 [salt.loaded.int.module.cmdmod][INFO    ][24842] Executing command ['date', '+%z'] in directory '/root'
2017-11-20 09:26:51,319 [salt.utils.schedule][INFO    ][24842] Updating job settings for scheduled job: __mine_interval
2017-11-20 09:26:51,322 [salt.minion      ][INFO    ][24842] Added mine.update to scheduler
2017-11-20 09:26:51,350 [salt.minion      ][INFO    ][24842] Minion is ready to receive requests!
2017-11-20 09:26:52,351 [salt.utils.schedule][INFO    ][24842] Running scheduled job: __mine_interval
2017-11-20 09:27:03,812 [salt.minion      ][INFO    ][24842] User sudo_ubuntu Executing command state.sls with jid 20171120092703798908
2017-11-20 09:27:03,823 [salt.minion      ][INFO    ][24962] Starting a new job with PID 24962
2017-11-20 09:27:06,083 [salt.state       ][INFO    ][24962] Loading fresh modules for state activity
2017-11-20 09:27:06,112 [salt.fileclient  ][INFO    ][24962] Fetching file from saltenv 'base', ** done ** 'salt/control/init.sls'
2017-11-20 09:27:06,133 [salt.fileclient  ][INFO    ][24962] Fetching file from saltenv 'base', ** done ** 'salt/control/virt.sls'
2017-11-20 09:27:06,163 [salt.fileclient  ][INFO    ][24962] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-11-20 09:27:06,304 [salt.fileclient  ][INFO    ][24962] Fetching file from saltenv 'base', ** done ** 'salt/minion/init.sls'
2017-11-20 09:27:06,320 [salt.fileclient  ][INFO    ][24962] Fetching file from saltenv 'base', ** done ** 'salt/minion/service.sls'
2017-11-20 09:27:06,353 [salt.fileclient  ][INFO    ][24962] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-11-20 09:27:06,426 [salt.fileclient  ][INFO    ][24962] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-11-20 09:27:06,461 [salt.fileclient  ][INFO    ][24962] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-11-20 09:27:06,517 [salt.fileclient  ][INFO    ][24962] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-11-20 09:27:06,539 [salt.fileclient  ][INFO    ][24962] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-11-20 09:27:06,554 [salt.fileclient  ][INFO    ][24962] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-11-20 09:27:06,572 [salt.fileclient  ][INFO    ][24962] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-11-20 09:27:06,581 [salt.loaded.int.module.cmdmod][INFO    ][24962] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-11-20 09:27:06,601 [salt.fileclient  ][INFO    ][24962] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-11-20 09:27:06,620 [py.warnings      ][WARNING ][24962] /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-20 09:27:06,620 [salt.loaded.int.module.cmdmod][INFO    ][24962] Executing command 'salt-minion --version' in directory '/root'
2017-11-20 09:27:06,885 [salt.fileclient  ][INFO    ][24962] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-11-20 09:27:06,901 [salt.fileclient  ][INFO    ][24962] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-11-20 09:27:06,912 [salt.fileclient  ][INFO    ][24962] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-11-20 09:27:06,923 [salt.fileclient  ][INFO    ][24962] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-11-20 09:27:06,964 [salt.fileclient  ][INFO    ][24962] Fetching file from saltenv 'base', ** done ** 'reclass/meta/meta.yml'
2017-11-20 09:27:06,985 [salt.fileclient  ][INFO    ][24962] Fetching file from saltenv 'base', ** done ** 'reclass/map.jinja'
2017-11-20 09:27:07,013 [salt.fileclient  ][INFO    ][24962] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-11-20 09:27:07,053 [salt.fileclient  ][INFO    ][24962] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-11-20 09:27:07,124 [salt.fileclient  ][INFO    ][24962] Fetching file from saltenv 'base', ** done ** 'salt/minion/grains.sls'
2017-11-20 09:27:07,148 [salt.fileclient  ][INFO    ][24962] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-11-20 09:27:07,221 [salt.fileclient  ][INFO    ][24962] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-11-20 09:27:07,246 [salt.fileclient  ][INFO    ][24962] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-11-20 09:27:07,305 [salt.fileclient  ][INFO    ][24962] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-11-20 09:27:07,328 [salt.fileclient  ][INFO    ][24962] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-11-20 09:27:07,765 [salt.fileclient  ][INFO    ][24962] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-11-20 09:27:07,790 [salt.fileclient  ][INFO    ][24962] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-11-20 09:27:07,800 [salt.loaded.int.module.cmdmod][INFO    ][24962] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-11-20 09:27:07,825 [salt.fileclient  ][INFO    ][24962] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-11-20 09:27:07,846 [salt.loaded.int.module.cmdmod][INFO    ][24962] Executing command 'salt-minion --version' in directory '/root'
2017-11-20 09:27:08,134 [salt.fileclient  ][INFO    ][24962] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-11-20 09:27:08,157 [salt.fileclient  ][INFO    ][24962] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-11-20 09:27:08,173 [salt.fileclient  ][INFO    ][24962] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-11-20 09:27:08,190 [salt.fileclient  ][INFO    ][24962] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-11-20 09:27:08,242 [salt.fileclient  ][INFO    ][24962] Fetching file from saltenv 'base', ** done ** 'reclass/meta/meta.yml'
2017-11-20 09:27:08,261 [salt.fileclient  ][INFO    ][24962] Fetching file from saltenv 'base', ** done ** 'reclass/map.jinja'
2017-11-20 09:27:08,292 [salt.fileclient  ][INFO    ][24962] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-11-20 09:27:08,334 [salt.fileclient  ][INFO    ][24962] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-11-20 09:27:08,425 [salt.fileclient  ][INFO    ][24962] Fetching file from saltenv 'base', ** done ** 'salt/minion/cert.sls'
2017-11-20 09:27:08,505 [salt.fileclient  ][INFO    ][24962] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-11-20 09:27:08,876 [salt.state       ][INFO    ][24962] Running state [salt-minion] at time 09:27:08.876385
2017-11-20 09:27:08,877 [salt.state       ][INFO    ][24962] Executing state pkg.installed for salt-minion
2017-11-20 09:27:08,877 [salt.loaded.int.module.cmdmod][INFO    ][24962] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-20 09:27:09,147 [salt.state       ][INFO    ][24962] Package salt-minion is already installed
2017-11-20 09:27:09,147 [salt.state       ][INFO    ][24962] Completed state [salt-minion] at time 09:27:09.146849 duration_in_ms=270.452
2017-11-20 09:27:09,147 [salt.state       ][INFO    ][24962] Running state [salt_minion_dependency_packages] at time 09:27:09.147097
2017-11-20 09:27:09,147 [salt.state       ][INFO    ][24962] Executing state pkg.installed for salt_minion_dependency_packages
2017-11-20 09:27:09,151 [salt.state       ][INFO    ][24962] All specified packages are already installed
2017-11-20 09:27:09,151 [salt.state       ][INFO    ][24962] Completed state [salt_minion_dependency_packages] at time 09:27:09.151319 duration_in_ms=4.223
2017-11-20 09:27:09,153 [salt.state       ][INFO    ][24962] Running state [/etc/salt/minion.d/minion.conf] at time 09:27:09.152997
2017-11-20 09:27:09,153 [salt.state       ][INFO    ][24962] Executing state file.managed for /etc/salt/minion.d/minion.conf
2017-11-20 09:27:09,177 [salt.fileclient  ][INFO    ][24962] Fetching file from saltenv 'base', ** done ** 'salt/files/minion.conf'
2017-11-20 09:27:09,233 [salt.fileclient  ][INFO    ][24962] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-11-20 09:27:09,288 [salt.fileclient  ][INFO    ][24962] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-11-20 09:27:09,337 [salt.state       ][INFO    ][24962] File /etc/salt/minion.d/minion.conf is in the correct state
2017-11-20 09:27:09,338 [salt.state       ][INFO    ][24962] Completed state [/etc/salt/minion.d/minion.conf] at time 09:27:09.337456 duration_in_ms=184.459
2017-11-20 09:27:09,338 [salt.state       ][INFO    ][24962] Running state [/etc/salt/minion.d/_virt.conf] at time 09:27:09.337874
2017-11-20 09:27:09,338 [salt.state       ][INFO    ][24962] Executing state file.managed for /etc/salt/minion.d/_virt.conf
2017-11-20 09:27:09,339 [salt.state       ][INFO    ][24962] File /etc/salt/minion.d/_virt.conf is in the correct state
2017-11-20 09:27:09,339 [salt.state       ][INFO    ][24962] Completed state [/etc/salt/minion.d/_virt.conf] at time 09:27:09.339009 duration_in_ms=1.136
2017-11-20 09:27:09,341 [salt.state       ][INFO    ][24962] Running state [salt-minion] at time 09:27:09.340744
2017-11-20 09:27:09,341 [salt.state       ][INFO    ][24962] Executing state service.running for salt-minion
2017-11-20 09:27:09,341 [salt.loaded.int.module.cmdmod][INFO    ][24962] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2017-11-20 09:27:09,358 [salt.loaded.int.module.cmdmod][INFO    ][24962] Executing command ['systemctl', 'is-active', 'salt-minion.service'] in directory '/root'
2017-11-20 09:27:09,365 [salt.loaded.int.module.cmdmod][INFO    ][24962] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2017-11-20 09:27:09,372 [salt.state       ][INFO    ][24962] The service salt-minion is already running
2017-11-20 09:27:09,373 [salt.state       ][INFO    ][24962] Completed state [salt-minion] at time 09:27:09.372475 duration_in_ms=31.729
2017-11-20 09:27:09,374 [salt.state       ][INFO    ][24962] Running state [/etc/salt/grains.d] at time 09:27:09.374174
2017-11-20 09:27:09,374 [salt.state       ][INFO    ][24962] Executing state file.directory for /etc/salt/grains.d
2017-11-20 09:27:09,375 [salt.state       ][INFO    ][24962] Directory /etc/salt/grains.d is in the correct state
2017-11-20 09:27:09,375 [salt.state       ][INFO    ][24962] Completed state [/etc/salt/grains.d] at time 09:27:09.375166 duration_in_ms=0.991
2017-11-20 09:27:09,376 [salt.state       ][INFO    ][24962] Running state [/etc/salt/grains] at time 09:27:09.375779
2017-11-20 09:27:09,376 [salt.state       ][INFO    ][24962] Executing state file.managed for /etc/salt/grains
2017-11-20 09:27:09,376 [salt.state       ][INFO    ][24962] File /etc/salt/grains exists with proper permissions. No changes made.
2017-11-20 09:27:09,377 [salt.state       ][INFO    ][24962] Completed state [/etc/salt/grains] at time 09:27:09.376470 duration_in_ms=0.691
2017-11-20 09:27:09,377 [salt.state       ][INFO    ][24962] Running state [/etc/salt/grains.d/placeholder] at time 09:27:09.376831
2017-11-20 09:27:09,377 [salt.state       ][INFO    ][24962] Executing state file.managed for /etc/salt/grains.d/placeholder
2017-11-20 09:27:09,377 [salt.state       ][INFO    ][24962] File /etc/salt/grains.d/placeholder exists with proper permissions. No changes made.
2017-11-20 09:27:09,378 [salt.state       ][INFO    ][24962] Completed state [/etc/salt/grains.d/placeholder] at time 09:27:09.377507 duration_in_ms=0.675
2017-11-20 09:27:09,378 [salt.state       ][INFO    ][24962] Running state [/etc/salt/grains.d/sphinx] at time 09:27:09.377874
2017-11-20 09:27:09,378 [salt.state       ][INFO    ][24962] Executing state file.managed for /etc/salt/grains.d/sphinx
2017-11-20 09:27:09,380 [salt.state       ][INFO    ][24962] 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-20 09:27:09,380 [salt.state       ][INFO    ][24962] Completed state [/etc/salt/grains.d/sphinx] at time 09:27:09.379817 duration_in_ms=1.943
2017-11-20 09:27:09,381 [salt.state       ][INFO    ][24962] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 09:27:09.380555
2017-11-20 09:27:09,381 [salt.state       ][INFO    ][24962] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-11-20 09:27:09,381 [salt.state       ][INFO    ][24962] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-11-20 09:27:09,381 [salt.state       ][INFO    ][24962] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 09:27:09.381092 duration_in_ms=0.537
2017-11-20 09:27:09,381 [salt.state       ][INFO    ][24962] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 09:27:09.381247
2017-11-20 09:27:09,381 [salt.state       ][INFO    ][24962] 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-20 09:27:09,382 [salt.loaded.int.module.cmdmod][INFO    ][24962] Executing command 'python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"' in directory '/root'
2017-11-20 09:27:09,472 [salt.state       ][INFO    ][24962] {'pid': 25010, 'retcode': 0, 'stderr': '', 'stdout': ''}
2017-11-20 09:27:09,472 [salt.state       ][INFO    ][24962] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 09:27:09.472220 duration_in_ms=90.973
2017-11-20 09:27:09,473 [salt.state       ][INFO    ][24962] Running state [/etc/salt/grains.d/dns_records] at time 09:27:09.472856
2017-11-20 09:27:09,473 [salt.state       ][INFO    ][24962] Executing state file.managed for /etc/salt/grains.d/dns_records
2017-11-20 09:27:09,474 [salt.state       ][INFO    ][24962] File /etc/salt/grains.d/dns_records is in the correct state
2017-11-20 09:27:09,474 [salt.state       ][INFO    ][24962] Completed state [/etc/salt/grains.d/dns_records] at time 09:27:09.474438 duration_in_ms=1.581
2017-11-20 09:27:09,475 [salt.state       ][INFO    ][24962] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 09:27:09.475410
2017-11-20 09:27:09,476 [salt.state       ][INFO    ][24962] 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-20 09:27:09,476 [salt.state       ][INFO    ][24962] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"
2017-11-20 09:27:09,476 [salt.state       ][INFO    ][24962] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 09:27:09.476036 duration_in_ms=0.626
2017-11-20 09:27:09,476 [salt.state       ][INFO    ][24962] Running state [/etc/salt/grains.d/salt] at time 09:27:09.476440
2017-11-20 09:27:09,477 [salt.state       ][INFO    ][24962] Executing state file.managed for /etc/salt/grains.d/salt
2017-11-20 09:27:09,477 [salt.state       ][INFO    ][24962] File /etc/salt/grains.d/salt is in the correct state
2017-11-20 09:27:09,478 [salt.state       ][INFO    ][24962] Completed state [/etc/salt/grains.d/salt] at time 09:27:09.477522 duration_in_ms=1.082
2017-11-20 09:27:09,478 [salt.state       ][INFO    ][24962] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 09:27:09.478308
2017-11-20 09:27:09,479 [salt.state       ][INFO    ][24962] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2017-11-20 09:27:09,479 [salt.state       ][INFO    ][24962] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2017-11-20 09:27:09,479 [salt.state       ][INFO    ][24962] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 09:27:09.478909 duration_in_ms=0.601
2017-11-20 09:27:09,481 [salt.state       ][INFO    ][24962] Running state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 09:27:09.480658
2017-11-20 09:27:09,481 [salt.state       ][INFO    ][24962] Executing state cmd.wait for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-11-20 09:27:09,481 [salt.state       ][INFO    ][24962] No changes made for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-11-20 09:27:09,481 [salt.state       ][INFO    ][24962] Completed state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 09:27:09.481280 duration_in_ms=0.621
2017-11-20 09:27:09,481 [salt.state       ][INFO    ][24962] Running state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 09:27:09.481448
2017-11-20 09:27:09,482 [salt.state       ][INFO    ][24962] Executing state cmd.mod_watch for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-11-20 09:27:09,484 [salt.loaded.int.module.cmdmod][INFO    ][24962] Executing command 'cat /etc/salt/grains.d/* > /etc/salt/grains' in directory '/root'
2017-11-20 09:27:09,491 [salt.state       ][INFO    ][24962] {'pid': 25012, 'retcode': 0, 'stderr': '', 'stdout': ''}
2017-11-20 09:27:09,492 [salt.state       ][INFO    ][24962] Completed state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 09:27:09.491801 duration_in_ms=10.353
2017-11-20 09:27:09,493 [salt.state       ][INFO    ][24962] Running state [mine.update] at time 09:27:09.492486
2017-11-20 09:27:09,493 [salt.state       ][INFO    ][24962] Executing state module.wait for mine.update
2017-11-20 09:27:09,493 [salt.state       ][INFO    ][24962] No changes made for mine.update
2017-11-20 09:27:09,493 [salt.state       ][INFO    ][24962] Completed state [mine.update] at time 09:27:09.493037 duration_in_ms=0.551
2017-11-20 09:27:09,493 [salt.state       ][INFO    ][24962] Running state [mine.update] at time 09:27:09.493183
2017-11-20 09:27:09,493 [salt.state       ][INFO    ][24962] Executing state module.mod_watch for mine.update
2017-11-20 09:27:10,008 [salt.state       ][INFO    ][24962] {'ret': True}
2017-11-20 09:27:10,008 [salt.state       ][INFO    ][24962] Completed state [mine.update] at time 09:27:10.008424 duration_in_ms=515.241
2017-11-20 09:27:10,009 [salt.state       ][INFO    ][24962] Running state [ca-certificates] at time 09:27:10.008684
2017-11-20 09:27:10,009 [salt.state       ][INFO    ][24962] Executing state pkg.installed for ca-certificates
2017-11-20 09:27:10,013 [salt.state       ][INFO    ][24962] Package ca-certificates is already installed
2017-11-20 09:27:10,013 [salt.state       ][INFO    ][24962] Completed state [ca-certificates] at time 09:27:10.013184 duration_in_ms=4.5
2017-11-20 09:27:10,014 [salt.state       ][INFO    ][24962] Running state [update-ca-certificates] at time 09:27:10.013862
2017-11-20 09:27:10,014 [salt.state       ][INFO    ][24962] Executing state cmd.wait for update-ca-certificates
2017-11-20 09:27:10,014 [salt.state       ][INFO    ][24962] No changes made for update-ca-certificates
2017-11-20 09:27:10,014 [salt.state       ][INFO    ][24962] Completed state [update-ca-certificates] at time 09:27:10.014441 duration_in_ms=0.579
2017-11-20 09:27:10,015 [salt.state       ][INFO    ][24962] Running state [libvirt-dev] at time 09:27:10.014612
2017-11-20 09:27:10,015 [salt.state       ][INFO    ][24962] Executing state pkg.installed for libvirt-dev
2017-11-20 09:27:10,019 [salt.state       ][INFO    ][24962] Package libvirt-dev is already installed
2017-11-20 09:27:10,019 [salt.state       ][INFO    ][24962] Completed state [libvirt-dev] at time 09:27:10.018647 duration_in_ms=4.035
2017-11-20 09:27:10,019 [salt.state       ][INFO    ][24962] Running state [pkg-config] at time 09:27:10.018836
2017-11-20 09:27:10,019 [salt.state       ][INFO    ][24962] Executing state pkg.installed for pkg-config
2017-11-20 09:27:10,023 [salt.state       ][INFO    ][24962] Package pkg-config is already installed
2017-11-20 09:27:10,023 [salt.state       ][INFO    ][24962] Completed state [pkg-config] at time 09:27:10.022874 duration_in_ms=4.038
2017-11-20 09:27:10,023 [salt.state       ][INFO    ][24962] Running state [virtng.init] at time 09:27:10.023053
2017-11-20 09:27:10,023 [salt.state       ][INFO    ][24962] Executing state module.run for virtng.init
2017-11-20 09:27:10,079 [salt.loaded.int.module.cmdmod][INFO    ][24962] Executing command ['git', '--version'] in directory '/root'
2017-11-20 09:27:10,163 [salt.loaded.int.module.cmdmod][INFO    ][24962] Executing command 'virsh list --all --name| grep -E "^mdb03.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-11-20 09:27:10,181 [salt.state       ][INFO    ][24962] unless execution succeeded
2017-11-20 09:27:10,181 [salt.state       ][INFO    ][24962] Completed state [virtng.init] at time 09:27:10.181034 duration_in_ms=157.98
2017-11-20 09:27:10,181 [salt.state       ][INFO    ][24962] Running state [virt.set_autostart] at time 09:27:10.181310
2017-11-20 09:27:10,182 [salt.state       ][INFO    ][24962] Executing state module.run for virt.set_autostart
2017-11-20 09:27:10,185 [salt.loaded.int.module.cmdmod][INFO    ][24962] Executing command 'virsh list --autostart --name| grep -E "^mdb03.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-11-20 09:27:10,201 [salt.state       ][INFO    ][24962] unless execution succeeded
2017-11-20 09:27:10,201 [salt.state       ][INFO    ][24962] Completed state [virt.set_autostart] at time 09:27:10.200838 duration_in_ms=19.527
2017-11-20 09:27:10,201 [salt.state       ][INFO    ][24962] Running state [virtng.init] at time 09:27:10.201099
2017-11-20 09:27:10,201 [salt.state       ][INFO    ][24962] Executing state module.run for virtng.init
2017-11-20 09:27:10,204 [salt.loaded.int.module.cmdmod][INFO    ][24962] Executing command 'virsh list --all --name| grep -E "^dbs03.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-11-20 09:27:10,221 [salt.state       ][INFO    ][24962] unless execution succeeded
2017-11-20 09:27:10,222 [salt.state       ][INFO    ][24962] Completed state [virtng.init] at time 09:27:10.221662 duration_in_ms=20.563
2017-11-20 09:27:10,222 [salt.state       ][INFO    ][24962] Running state [virt.set_autostart] at time 09:27:10.221950
2017-11-20 09:27:10,222 [salt.state       ][INFO    ][24962] Executing state module.run for virt.set_autostart
2017-11-20 09:27:10,225 [salt.loaded.int.module.cmdmod][INFO    ][24962] Executing command 'virsh list --autostart --name| grep -E "^dbs03.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-11-20 09:27:10,243 [salt.state       ][INFO    ][24962] unless execution succeeded
2017-11-20 09:27:10,243 [salt.state       ][INFO    ][24962] Completed state [virt.set_autostart] at time 09:27:10.243207 duration_in_ms=21.256
2017-11-20 09:27:10,244 [salt.state       ][INFO    ][24962] Running state [virtng.init] at time 09:27:10.243518
2017-11-20 09:27:10,244 [salt.state       ][INFO    ][24962] Executing state module.run for virtng.init
2017-11-20 09:27:10,247 [salt.loaded.int.module.cmdmod][INFO    ][24962] Executing command 'virsh list --all --name| grep -E "^prx02.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-11-20 09:27:10,265 [salt.state       ][INFO    ][24962] unless execution succeeded
2017-11-20 09:27:10,265 [salt.state       ][INFO    ][24962] Completed state [virtng.init] at time 09:27:10.264836 duration_in_ms=21.317
2017-11-20 09:27:10,265 [salt.state       ][INFO    ][24962] Running state [virt.set_autostart] at time 09:27:10.265121
2017-11-20 09:27:10,265 [salt.state       ][INFO    ][24962] Executing state module.run for virt.set_autostart
2017-11-20 09:27:10,268 [salt.loaded.int.module.cmdmod][INFO    ][24962] Executing command 'virsh list --autostart --name| grep -E "^prx02.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-11-20 09:27:10,287 [salt.state       ][INFO    ][24962] unless execution succeeded
2017-11-20 09:27:10,287 [salt.state       ][INFO    ][24962] Completed state [virt.set_autostart] at time 09:27:10.287228 duration_in_ms=22.106
2017-11-20 09:27:10,288 [salt.state       ][INFO    ][24962] Running state [virtng.init] at time 09:27:10.287559
2017-11-20 09:27:10,288 [salt.state       ][INFO    ][24962] Executing state module.run for virtng.init
2017-11-20 09:27:10,291 [salt.loaded.int.module.cmdmod][INFO    ][24962] Executing command 'virsh list --all --name| grep -E "^odl01.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-11-20 09:27:10,308 [salt.state       ][INFO    ][24962] unless execution succeeded
2017-11-20 09:27:10,309 [salt.state       ][INFO    ][24962] Completed state [virtng.init] at time 09:27:10.308639 duration_in_ms=21.079
2017-11-20 09:27:10,309 [salt.state       ][INFO    ][24962] Running state [virt.set_autostart] at time 09:27:10.308933
2017-11-20 09:27:10,309 [salt.state       ][INFO    ][24962] Executing state module.run for virt.set_autostart
2017-11-20 09:27:10,312 [salt.loaded.int.module.cmdmod][INFO    ][24962] Executing command 'virsh list --autostart --name| grep -E "^odl01.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-11-20 09:27:10,329 [salt.state       ][INFO    ][24962] unless execution succeeded
2017-11-20 09:27:10,329 [salt.state       ][INFO    ][24962] Completed state [virt.set_autostart] at time 09:27:10.329313 duration_in_ms=20.379
2017-11-20 09:27:10,330 [salt.state       ][INFO    ][24962] Running state [virtng.init] at time 09:27:10.329590
2017-11-20 09:27:10,330 [salt.state       ][INFO    ][24962] Executing state module.run for virtng.init
2017-11-20 09:27:10,333 [salt.loaded.int.module.cmdmod][INFO    ][24962] Executing command 'virsh list --all --name| grep -E "^msg03.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-11-20 09:27:10,352 [salt.state       ][INFO    ][24962] unless execution succeeded
2017-11-20 09:27:10,353 [salt.state       ][INFO    ][24962] Completed state [virtng.init] at time 09:27:10.352500 duration_in_ms=22.909
2017-11-20 09:27:10,353 [salt.state       ][INFO    ][24962] Running state [virt.set_autostart] at time 09:27:10.352824
2017-11-20 09:27:10,353 [salt.state       ][INFO    ][24962] Executing state module.run for virt.set_autostart
2017-11-20 09:27:10,357 [salt.loaded.int.module.cmdmod][INFO    ][24962] Executing command 'virsh list --autostart --name| grep -E "^msg03.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-11-20 09:27:10,376 [salt.state       ][INFO    ][24962] unless execution succeeded
2017-11-20 09:27:10,376 [salt.state       ][INFO    ][24962] Completed state [virt.set_autostart] at time 09:27:10.376067 duration_in_ms=23.243
2017-11-20 09:27:10,376 [salt.state       ][INFO    ][24962] Running state [virtng.init] at time 09:27:10.376444
2017-11-20 09:27:10,377 [salt.state       ][INFO    ][24962] Executing state module.run for virtng.init
2017-11-20 09:27:10,381 [salt.loaded.int.module.cmdmod][INFO    ][24962] Executing command 'virsh list --all --name| grep -E "^ctl03.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-11-20 09:27:10,400 [salt.state       ][INFO    ][24962] unless execution succeeded
2017-11-20 09:27:10,400 [salt.state       ][INFO    ][24962] Completed state [virtng.init] at time 09:27:10.400101 duration_in_ms=23.657
2017-11-20 09:27:10,400 [salt.state       ][INFO    ][24962] Running state [virt.set_autostart] at time 09:27:10.400403
2017-11-20 09:27:10,401 [salt.state       ][INFO    ][24962] Executing state module.run for virt.set_autostart
2017-11-20 09:27:10,405 [salt.loaded.int.module.cmdmod][INFO    ][24962] Executing command 'virsh list --autostart --name| grep -E "^ctl03.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-11-20 09:27:10,425 [salt.state       ][INFO    ][24962] unless execution succeeded
2017-11-20 09:27:10,425 [salt.state       ][INFO    ][24962] Completed state [virt.set_autostart] at time 09:27:10.424905 duration_in_ms=24.502
2017-11-20 09:27:10,428 [salt.minion      ][INFO    ][24962] Returning information for job: 20171120092703798908
2017-11-20 09:27:38,272 [salt.minion      ][INFO    ][24842] User sudo_ubuntu Executing command saltutil.sync_all with jid 20171120092738256730
2017-11-20 09:27:38,288 [salt.minion      ][INFO    ][25077] Starting a new job with PID 25077
2017-11-20 09:27:42,819 [salt.state       ][INFO    ][25077] Loading fresh modules for state activity
2017-11-20 09:27:42,846 [salt.state       ][ERROR   ][25077] No contents found in top file
2017-11-20 09:27:42,847 [salt.utils.extmods][INFO    ][25077] Creating module dir '/var/cache/salt/minion/extmods/beacons'
2017-11-20 09:27:42,850 [salt.utils.extmods][INFO    ][25077] Syncing beacons for environment 'base'
2017-11-20 09:27:42,850 [salt.utils.extmods][INFO    ][25077] Loading cache from salt://_beacons, for base)
2017-11-20 09:27:42,851 [salt.fileclient  ][INFO    ][25077] Caching directory '_beacons/' for environment 'base'
2017-11-20 09:27:42,878 [salt.utils.extmods][INFO    ][25077] Syncing modules for environment 'base'
2017-11-20 09:27:42,878 [salt.utils.extmods][INFO    ][25077] Loading cache from salt://_modules, for base)
2017-11-20 09:27:42,878 [salt.fileclient  ][INFO    ][25077] Caching directory '_modules/' for environment 'base'
2017-11-20 09:27:43,586 [salt.fileclient  ][INFO    ][25077] Fetching file from saltenv 'base', ** done ** '_modules/ceph_ng.py'
2017-11-20 09:27:43,613 [salt.fileclient  ][INFO    ][25077] Fetching file from saltenv 'base', ** done ** '_modules/cinderng.py'
2017-11-20 09:27:43,633 [salt.fileclient  ][INFO    ][25077] Fetching file from saltenv 'base', ** done ** '_modules/contrail.py'
2017-11-20 09:27:43,656 [salt.fileclient  ][INFO    ][25077] Fetching file from saltenv 'base', ** done ** '_modules/creds.py'
2017-11-20 09:27:43,668 [salt.fileclient  ][INFO    ][25077] Fetching file from saltenv 'base', ** done ** '_modules/devops_utils.py'
2017-11-20 09:27:43,682 [salt.fileclient  ][INFO    ][25077] Fetching file from saltenv 'base', ** done ** '_modules/encode_json.py'
2017-11-20 09:27:43,708 [salt.fileclient  ][INFO    ][25077] Fetching file from saltenv 'base', ** done ** '_modules/gerrit.py'
2017-11-20 09:27:43,718 [salt.fileclient  ][INFO    ][25077] Fetching file from saltenv 'base', ** done ** '_modules/glanceng.py'
2017-11-20 09:27:43,727 [salt.fileclient  ][INFO    ][25077] Fetching file from saltenv 'base', ** done ** '_modules/heat.py'
2017-11-20 09:27:43,740 [salt.fileclient  ][INFO    ][25077] Fetching file from saltenv 'base', ** done ** '_modules/heka_alarming.py'
2017-11-20 09:27:43,768 [salt.fileclient  ][INFO    ][25077] Fetching file from saltenv 'base', ** done ** '_modules/helm.py'
2017-11-20 09:27:43,788 [salt.fileclient  ][INFO    ][25077] Fetching file from saltenv 'base', ** done ** '_modules/jenkins_common.py'
2017-11-20 09:27:43,798 [salt.fileclient  ][INFO    ][25077] Fetching file from saltenv 'base', ** done ** '_modules/keystone_policy.py'
2017-11-20 09:27:43,816 [salt.fileclient  ][INFO    ][25077] Fetching file from saltenv 'base', ** done ** '_modules/linux_hosts.py'
2017-11-20 09:27:43,853 [salt.fileclient  ][INFO    ][25077] Fetching file from saltenv 'base', ** done ** '_modules/linux_netlink.py'
2017-11-20 09:27:43,877 [salt.fileclient  ][INFO    ][25077] Fetching file from saltenv 'base', ** done ** '_modules/maas.py'
2017-11-20 09:27:43,915 [salt.fileclient  ][INFO    ][25077] Fetching file from saltenv 'base', ** done ** '_modules/maas_client.py'
2017-11-20 09:27:43,927 [salt.fileclient  ][INFO    ][25077] Fetching file from saltenv 'base', ** done ** '_modules/modelutils.py'
2017-11-20 09:27:43,945 [salt.fileclient  ][INFO    ][25077] Fetching file from saltenv 'base', ** done ** '_modules/multipart.py'
2017-11-20 09:27:43,955 [salt.fileclient  ][INFO    ][25077] Fetching file from saltenv 'base', ** done ** '_modules/nagios_alarming.py'
2017-11-20 09:27:43,985 [salt.fileclient  ][INFO    ][25077] Fetching file from saltenv 'base', ** done ** '_modules/neutronng.py'
2017-11-20 09:27:44,002 [salt.fileclient  ][INFO    ][25077] Fetching file from saltenv 'base', ** done ** '_modules/novang.py'
2017-11-20 09:27:44,063 [salt.fileclient  ][INFO    ][25077] Fetching file from saltenv 'base', ** done ** '_modules/reclass.py'
2017-11-20 09:27:44,083 [salt.fileclient  ][INFO    ][25077] Fetching file from saltenv 'base', ** done ** '_modules/rsyslog_util.py'
2017-11-20 09:27:44,130 [salt.fileclient  ][INFO    ][25077] Fetching file from saltenv 'base', ** done ** '_modules/rundeck.py'
2017-11-20 09:27:44,156 [salt.fileclient  ][INFO    ][25077] Fetching file from saltenv 'base', ** done ** '_modules/saltkey.py'
2017-11-20 09:27:44,171 [salt.fileclient  ][INFO    ][25077] Fetching file from saltenv 'base', ** done ** '_modules/saltresource.py'
2017-11-20 09:27:44,188 [salt.fileclient  ][INFO    ][25077] Fetching file from saltenv 'base', ** done ** '_modules/seedng.py'
2017-11-20 09:27:44,210 [salt.fileclient  ][INFO    ][25077] Fetching file from saltenv 'base', ** done ** '_modules/testing/credentials.py'
2017-11-20 09:27:44,237 [salt.fileclient  ][INFO    ][25077] Fetching file from saltenv 'base', ** done ** '_modules/testing/django.py'
2017-11-20 09:27:44,252 [salt.fileclient  ][INFO    ][25077] Fetching file from saltenv 'base', ** done ** '_modules/testing/django_client_proxy.py'
2017-11-20 09:27:44,287 [salt.fileclient  ][INFO    ][25077] Fetching file from saltenv 'base', ** done ** '_modules/utils.py'
2017-11-20 09:27:44,299 [salt.fileclient  ][INFO    ][25077] Fetching file from saltenv 'base', ** done ** '_modules/virtng.py'
2017-11-20 09:27:44,304 [salt.utils.extmods][INFO    ][25077] Copying '/var/cache/salt/minion/files/base/_modules/__init__.py' to '/var/cache/salt/minion/extmods/modules/__init__.py'
2017-11-20 09:27:44,304 [salt.utils.extmods][INFO    ][25077] Copying '/var/cache/salt/minion/files/base/_modules/ceph_ng.py' to '/var/cache/salt/minion/extmods/modules/ceph_ng.py'
2017-11-20 09:27:44,304 [salt.utils.extmods][INFO    ][25077] Copying '/var/cache/salt/minion/files/base/_modules/cinderng.py' to '/var/cache/salt/minion/extmods/modules/cinderng.py'
2017-11-20 09:27:44,305 [salt.utils.extmods][INFO    ][25077] Copying '/var/cache/salt/minion/files/base/_modules/contrail.py' to '/var/cache/salt/minion/extmods/modules/contrail.py'
2017-11-20 09:27:44,305 [salt.utils.extmods][INFO    ][25077] Copying '/var/cache/salt/minion/files/base/_modules/creds.py' to '/var/cache/salt/minion/extmods/modules/creds.py'
2017-11-20 09:27:44,305 [salt.utils.extmods][INFO    ][25077] Copying '/var/cache/salt/minion/files/base/_modules/devops_utils.py' to '/var/cache/salt/minion/extmods/modules/devops_utils.py'
2017-11-20 09:27:44,305 [salt.utils.extmods][INFO    ][25077] Copying '/var/cache/salt/minion/files/base/_modules/encode_json.py' to '/var/cache/salt/minion/extmods/modules/encode_json.py'
2017-11-20 09:27:44,306 [salt.utils.extmods][INFO    ][25077] Copying '/var/cache/salt/minion/files/base/_modules/gerrit.py' to '/var/cache/salt/minion/extmods/modules/gerrit.py'
2017-11-20 09:27:44,306 [salt.utils.extmods][INFO    ][25077] Copying '/var/cache/salt/minion/files/base/_modules/glanceng.py' to '/var/cache/salt/minion/extmods/modules/glanceng.py'
2017-11-20 09:27:44,306 [salt.utils.extmods][INFO    ][25077] Copying '/var/cache/salt/minion/files/base/_modules/heat.py' to '/var/cache/salt/minion/extmods/modules/heat.py'
2017-11-20 09:27:44,307 [salt.utils.extmods][INFO    ][25077] Copying '/var/cache/salt/minion/files/base/_modules/heka_alarming.py' to '/var/cache/salt/minion/extmods/modules/heka_alarming.py'
2017-11-20 09:27:44,307 [salt.utils.extmods][INFO    ][25077] Copying '/var/cache/salt/minion/files/base/_modules/helm.py' to '/var/cache/salt/minion/extmods/modules/helm.py'
2017-11-20 09:27:44,307 [salt.utils.extmods][INFO    ][25077] Copying '/var/cache/salt/minion/files/base/_modules/jenkins_common.py' to '/var/cache/salt/minion/extmods/modules/jenkins_common.py'
2017-11-20 09:27:44,307 [salt.utils.extmods][INFO    ][25077] Copying '/var/cache/salt/minion/files/base/_modules/keystone_policy.py' to '/var/cache/salt/minion/extmods/modules/keystone_policy.py'
2017-11-20 09:27:44,308 [salt.utils.extmods][INFO    ][25077] Copying '/var/cache/salt/minion/files/base/_modules/linux_hosts.py' to '/var/cache/salt/minion/extmods/modules/linux_hosts.py'
2017-11-20 09:27:44,308 [salt.utils.extmods][INFO    ][25077] Copying '/var/cache/salt/minion/files/base/_modules/linux_netlink.py' to '/var/cache/salt/minion/extmods/modules/linux_netlink.py'
2017-11-20 09:27:44,308 [salt.utils.extmods][INFO    ][25077] Copying '/var/cache/salt/minion/files/base/_modules/maas.py' to '/var/cache/salt/minion/extmods/modules/maas.py'
2017-11-20 09:27:44,309 [salt.utils.extmods][INFO    ][25077] Copying '/var/cache/salt/minion/files/base/_modules/maas_client.py' to '/var/cache/salt/minion/extmods/modules/maas_client.py'
2017-11-20 09:27:44,309 [salt.utils.extmods][INFO    ][25077] Copying '/var/cache/salt/minion/files/base/_modules/modelutils.py' to '/var/cache/salt/minion/extmods/modules/modelutils.py'
2017-11-20 09:27:44,309 [salt.utils.extmods][INFO    ][25077] Copying '/var/cache/salt/minion/files/base/_modules/multipart.py' to '/var/cache/salt/minion/extmods/modules/multipart.py'
2017-11-20 09:27:44,310 [salt.utils.extmods][INFO    ][25077] Copying '/var/cache/salt/minion/files/base/_modules/nagios_alarming.py' to '/var/cache/salt/minion/extmods/modules/nagios_alarming.py'
2017-11-20 09:27:44,310 [salt.utils.extmods][INFO    ][25077] Copying '/var/cache/salt/minion/files/base/_modules/neutronng.py' to '/var/cache/salt/minion/extmods/modules/neutronng.py'
2017-11-20 09:27:44,311 [salt.utils.extmods][INFO    ][25077] Copying '/var/cache/salt/minion/files/base/_modules/novang.py' to '/var/cache/salt/minion/extmods/modules/novang.py'
2017-11-20 09:27:44,311 [salt.utils.extmods][INFO    ][25077] Copying '/var/cache/salt/minion/files/base/_modules/reclass.py' to '/var/cache/salt/minion/extmods/modules/reclass.py'
2017-11-20 09:27:44,312 [salt.utils.extmods][INFO    ][25077] Copying '/var/cache/salt/minion/files/base/_modules/rsyslog_util.py' to '/var/cache/salt/minion/extmods/modules/rsyslog_util.py'
2017-11-20 09:27:44,312 [salt.utils.extmods][INFO    ][25077] Copying '/var/cache/salt/minion/files/base/_modules/rundeck.py' to '/var/cache/salt/minion/extmods/modules/rundeck.py'
2017-11-20 09:27:44,312 [salt.utils.extmods][INFO    ][25077] Copying '/var/cache/salt/minion/files/base/_modules/saltkey.py' to '/var/cache/salt/minion/extmods/modules/saltkey.py'
2017-11-20 09:27:44,313 [salt.utils.extmods][INFO    ][25077] Copying '/var/cache/salt/minion/files/base/_modules/saltresource.py' to '/var/cache/salt/minion/extmods/modules/saltresource.py'
2017-11-20 09:27:44,313 [salt.utils.extmods][INFO    ][25077] Copying '/var/cache/salt/minion/files/base/_modules/seedng.py' to '/var/cache/salt/minion/extmods/modules/seedng.py'
2017-11-20 09:27:44,313 [salt.utils.extmods][INFO    ][25077] Copying '/var/cache/salt/minion/files/base/_modules/testing/__init__.py' to '/var/cache/salt/minion/extmods/modules/testing/__init__.py'
2017-11-20 09:27:44,313 [salt.utils.extmods][INFO    ][25077] Copying '/var/cache/salt/minion/files/base/_modules/testing/credentials.py' to '/var/cache/salt/minion/extmods/modules/testing/credentials.py'
2017-11-20 09:27:44,314 [salt.utils.extmods][INFO    ][25077] Copying '/var/cache/salt/minion/files/base/_modules/testing/django.py' to '/var/cache/salt/minion/extmods/modules/testing/django.py'
2017-11-20 09:27:44,314 [salt.utils.extmods][INFO    ][25077] 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-20 09:27:44,314 [salt.utils.extmods][INFO    ][25077] Copying '/var/cache/salt/minion/files/base/_modules/utils.py' to '/var/cache/salt/minion/extmods/modules/utils.py'
2017-11-20 09:27:44,314 [salt.utils.extmods][INFO    ][25077] Copying '/var/cache/salt/minion/files/base/_modules/virtng.py' to '/var/cache/salt/minion/extmods/modules/virtng.py'
2017-11-20 09:27:44,321 [salt.utils.extmods][INFO    ][25077] Syncing states for environment 'base'
2017-11-20 09:27:44,321 [salt.utils.extmods][INFO    ][25077] Loading cache from salt://_states, for base)
2017-11-20 09:27:44,321 [salt.fileclient  ][INFO    ][25077] Caching directory '_states/' for environment 'base'
2017-11-20 09:27:44,416 [salt.fileclient  ][INFO    ][25077] Fetching file from saltenv 'base', ** done ** '_states/cinderng.py'
2017-11-20 09:27:44,446 [salt.fileclient  ][INFO    ][25077] Fetching file from saltenv 'base', ** done ** '_states/contrail.py'
2017-11-20 09:27:44,456 [salt.fileclient  ][INFO    ][25077] Fetching file from saltenv 'base', ** done ** '_states/gerrit.py'
2017-11-20 09:27:44,470 [salt.fileclient  ][INFO    ][25077] Fetching file from saltenv 'base', ** done ** '_states/glanceng.py'
2017-11-20 09:27:44,485 [salt.fileclient  ][INFO    ][25077] Fetching file from saltenv 'base', ** done ** '_states/grafana3_dashboard.py'
2017-11-20 09:27:44,499 [salt.fileclient  ][INFO    ][25077] Fetching file from saltenv 'base', ** done ** '_states/grafana3_datasource.py'
2017-11-20 09:27:44,507 [salt.fileclient  ][INFO    ][25077] Fetching file from saltenv 'base', ** done ** '_states/heat.py'
2017-11-20 09:27:44,516 [salt.fileclient  ][INFO    ][25077] Fetching file from saltenv 'base', ** done ** '_states/helm_release.py'
2017-11-20 09:27:44,526 [salt.fileclient  ][INFO    ][25077] Fetching file from saltenv 'base', ** done ** '_states/jenkins_approval.py'
2017-11-20 09:27:44,536 [salt.fileclient  ][INFO    ][25077] Fetching file from saltenv 'base', ** done ** '_states/jenkins_artifactory.py'
2017-11-20 09:27:44,570 [salt.fileclient  ][INFO    ][25077] Fetching file from saltenv 'base', ** done ** '_states/jenkins_credential.py'
2017-11-20 09:27:44,612 [salt.fileclient  ][INFO    ][25077] Fetching file from saltenv 'base', ** done ** '_states/jenkins_globalenvprop.py'
2017-11-20 09:27:44,635 [salt.fileclient  ][INFO    ][25077] Fetching file from saltenv 'base', ** done ** '_states/jenkins_job.py'
2017-11-20 09:27:44,652 [salt.fileclient  ][INFO    ][25077] Fetching file from saltenv 'base', ** done ** '_states/jenkins_lib.py'
2017-11-20 09:27:44,681 [salt.fileclient  ][INFO    ][25077] Fetching file from saltenv 'base', ** done ** '_states/jenkins_node.py'
2017-11-20 09:27:44,707 [salt.fileclient  ][INFO    ][25077] Fetching file from saltenv 'base', ** done ** '_states/jenkins_plugin.py'
2017-11-20 09:27:44,741 [salt.fileclient  ][INFO    ][25077] Fetching file from saltenv 'base', ** done ** '_states/jenkins_security.py'
2017-11-20 09:27:44,753 [salt.fileclient  ][INFO    ][25077] Fetching file from saltenv 'base', ** done ** '_states/jenkins_slack.py'
2017-11-20 09:27:44,770 [salt.fileclient  ][INFO    ][25077] Fetching file from saltenv 'base', ** done ** '_states/jenkins_smtp.py'
2017-11-20 09:27:44,793 [salt.fileclient  ][INFO    ][25077] Fetching file from saltenv 'base', ** done ** '_states/jenkins_theme.py'
2017-11-20 09:27:44,809 [salt.fileclient  ][INFO    ][25077] Fetching file from saltenv 'base', ** done ** '_states/jenkins_user.py'
2017-11-20 09:27:44,822 [salt.fileclient  ][INFO    ][25077] Fetching file from saltenv 'base', ** done ** '_states/jenkins_view.py'
2017-11-20 09:27:44,839 [salt.fileclient  ][INFO    ][25077] Fetching file from saltenv 'base', ** done ** '_states/keystone_policy.py'
2017-11-20 09:27:44,856 [salt.fileclient  ][INFO    ][25077] Fetching file from saltenv 'base', ** done ** '_states/kibana_object.py'
2017-11-20 09:27:44,876 [salt.fileclient  ][INFO    ][25077] Fetching file from saltenv 'base', ** done ** '_states/neutronng.py'
2017-11-20 09:27:44,890 [salt.fileclient  ][INFO    ][25077] Fetching file from saltenv 'base', ** done ** '_states/novang.py'
2017-11-20 09:27:44,903 [salt.fileclient  ][INFO    ][25077] Fetching file from saltenv 'base', ** done ** '_states/reclass.py'
2017-11-20 09:27:44,942 [salt.fileclient  ][INFO    ][25077] Fetching file from saltenv 'base', ** done ** '_states/rundeck_project.py'
2017-11-20 09:27:44,963 [salt.fileclient  ][INFO    ][25077] Fetching file from saltenv 'base', ** done ** '_states/rundeck_scm.py'
2017-11-20 09:27:44,978 [salt.fileclient  ][INFO    ][25077] Fetching file from saltenv 'base', ** done ** '_states/rundeck_secret.py'
2017-11-20 09:27:44,985 [salt.utils.extmods][INFO    ][25077] Copying '/var/cache/salt/minion/files/base/_states/cinderng.py' to '/var/cache/salt/minion/extmods/states/cinderng.py'
2017-11-20 09:27:44,985 [salt.utils.extmods][INFO    ][25077] Copying '/var/cache/salt/minion/files/base/_states/contrail.py' to '/var/cache/salt/minion/extmods/states/contrail.py'
2017-11-20 09:27:44,986 [salt.utils.extmods][INFO    ][25077] Copying '/var/cache/salt/minion/files/base/_states/gerrit.py' to '/var/cache/salt/minion/extmods/states/gerrit.py'
2017-11-20 09:27:44,986 [salt.utils.extmods][INFO    ][25077] Copying '/var/cache/salt/minion/files/base/_states/glanceng.py' to '/var/cache/salt/minion/extmods/states/glanceng.py'
2017-11-20 09:27:44,987 [salt.utils.extmods][INFO    ][25077] Copying '/var/cache/salt/minion/files/base/_states/grafana3_dashboard.py' to '/var/cache/salt/minion/extmods/states/grafana3_dashboard.py'
2017-11-20 09:27:44,987 [salt.utils.extmods][INFO    ][25077] Copying '/var/cache/salt/minion/files/base/_states/grafana3_datasource.py' to '/var/cache/salt/minion/extmods/states/grafana3_datasource.py'
2017-11-20 09:27:44,988 [salt.utils.extmods][INFO    ][25077] Copying '/var/cache/salt/minion/files/base/_states/heat.py' to '/var/cache/salt/minion/extmods/states/heat.py'
2017-11-20 09:27:44,988 [salt.utils.extmods][INFO    ][25077] Copying '/var/cache/salt/minion/files/base/_states/helm_release.py' to '/var/cache/salt/minion/extmods/states/helm_release.py'
2017-11-20 09:27:44,989 [salt.utils.extmods][INFO    ][25077] Copying '/var/cache/salt/minion/files/base/_states/jenkins_approval.py' to '/var/cache/salt/minion/extmods/states/jenkins_approval.py'
2017-11-20 09:27:44,989 [salt.utils.extmods][INFO    ][25077] Copying '/var/cache/salt/minion/files/base/_states/jenkins_artifactory.py' to '/var/cache/salt/minion/extmods/states/jenkins_artifactory.py'
2017-11-20 09:27:44,990 [salt.utils.extmods][INFO    ][25077] Copying '/var/cache/salt/minion/files/base/_states/jenkins_credential.py' to '/var/cache/salt/minion/extmods/states/jenkins_credential.py'
2017-11-20 09:27:44,990 [salt.utils.extmods][INFO    ][25077] Copying '/var/cache/salt/minion/files/base/_states/jenkins_globalenvprop.py' to '/var/cache/salt/minion/extmods/states/jenkins_globalenvprop.py'
2017-11-20 09:27:44,990 [salt.utils.extmods][INFO    ][25077] Copying '/var/cache/salt/minion/files/base/_states/jenkins_job.py' to '/var/cache/salt/minion/extmods/states/jenkins_job.py'
2017-11-20 09:27:44,991 [salt.utils.extmods][INFO    ][25077] Copying '/var/cache/salt/minion/files/base/_states/jenkins_lib.py' to '/var/cache/salt/minion/extmods/states/jenkins_lib.py'
2017-11-20 09:27:44,991 [salt.utils.extmods][INFO    ][25077] Copying '/var/cache/salt/minion/files/base/_states/jenkins_node.py' to '/var/cache/salt/minion/extmods/states/jenkins_node.py'
2017-11-20 09:27:44,992 [salt.utils.extmods][INFO    ][25077] Copying '/var/cache/salt/minion/files/base/_states/jenkins_plugin.py' to '/var/cache/salt/minion/extmods/states/jenkins_plugin.py'
2017-11-20 09:27:44,992 [salt.utils.extmods][INFO    ][25077] Copying '/var/cache/salt/minion/files/base/_states/jenkins_security.py' to '/var/cache/salt/minion/extmods/states/jenkins_security.py'
2017-11-20 09:27:44,993 [salt.utils.extmods][INFO    ][25077] Copying '/var/cache/salt/minion/files/base/_states/jenkins_slack.py' to '/var/cache/salt/minion/extmods/states/jenkins_slack.py'
2017-11-20 09:27:44,993 [salt.utils.extmods][INFO    ][25077] Copying '/var/cache/salt/minion/files/base/_states/jenkins_smtp.py' to '/var/cache/salt/minion/extmods/states/jenkins_smtp.py'
2017-11-20 09:27:44,994 [salt.utils.extmods][INFO    ][25077] Copying '/var/cache/salt/minion/files/base/_states/jenkins_theme.py' to '/var/cache/salt/minion/extmods/states/jenkins_theme.py'
2017-11-20 09:27:44,994 [salt.utils.extmods][INFO    ][25077] Copying '/var/cache/salt/minion/files/base/_states/jenkins_user.py' to '/var/cache/salt/minion/extmods/states/jenkins_user.py'
2017-11-20 09:27:44,994 [salt.utils.extmods][INFO    ][25077] Copying '/var/cache/salt/minion/files/base/_states/jenkins_view.py' to '/var/cache/salt/minion/extmods/states/jenkins_view.py'
2017-11-20 09:27:44,995 [salt.utils.extmods][INFO    ][25077] Copying '/var/cache/salt/minion/files/base/_states/keystone_policy.py' to '/var/cache/salt/minion/extmods/states/keystone_policy.py'
2017-11-20 09:27:44,995 [salt.utils.extmods][INFO    ][25077] Copying '/var/cache/salt/minion/files/base/_states/kibana_object.py' to '/var/cache/salt/minion/extmods/states/kibana_object.py'
2017-11-20 09:27:44,996 [salt.utils.extmods][INFO    ][25077] Copying '/var/cache/salt/minion/files/base/_states/maas_cluster.py' to '/var/cache/salt/minion/extmods/states/maas_cluster.py'
2017-11-20 09:27:44,996 [salt.utils.extmods][INFO    ][25077] Copying '/var/cache/salt/minion/files/base/_states/neutronng.py' to '/var/cache/salt/minion/extmods/states/neutronng.py'
2017-11-20 09:27:44,997 [salt.utils.extmods][INFO    ][25077] Copying '/var/cache/salt/minion/files/base/_states/novang.py' to '/var/cache/salt/minion/extmods/states/novang.py'
2017-11-20 09:27:44,997 [salt.utils.extmods][INFO    ][25077] Copying '/var/cache/salt/minion/files/base/_states/reclass.py' to '/var/cache/salt/minion/extmods/states/reclass.py'
2017-11-20 09:27:44,998 [salt.utils.extmods][INFO    ][25077] Copying '/var/cache/salt/minion/files/base/_states/rundeck_project.py' to '/var/cache/salt/minion/extmods/states/rundeck_project.py'
2017-11-20 09:27:44,998 [salt.utils.extmods][INFO    ][25077] Copying '/var/cache/salt/minion/files/base/_states/rundeck_scm.py' to '/var/cache/salt/minion/extmods/states/rundeck_scm.py'
2017-11-20 09:27:44,998 [salt.utils.extmods][INFO    ][25077] Copying '/var/cache/salt/minion/files/base/_states/rundeck_secret.py' to '/var/cache/salt/minion/extmods/states/rundeck_secret.py'
2017-11-20 09:27:45,003 [salt.utils.extmods][INFO    ][25077] Creating module dir '/var/cache/salt/minion/extmods/sdb'
2017-11-20 09:27:45,009 [salt.utils.extmods][INFO    ][25077] Syncing sdb for environment 'base'
2017-11-20 09:27:45,010 [salt.utils.extmods][INFO    ][25077] Loading cache from salt://_sdb, for base)
2017-11-20 09:27:45,010 [salt.fileclient  ][INFO    ][25077] Caching directory '_sdb/' for environment 'base'
2017-11-20 09:27:45,072 [salt.utils.extmods][INFO    ][25077] Syncing grains for environment 'base'
2017-11-20 09:27:45,072 [salt.utils.extmods][INFO    ][25077] Loading cache from salt://_grains, for base)
2017-11-20 09:27:45,073 [salt.fileclient  ][INFO    ][25077] Caching directory '_grains/' for environment 'base'
2017-11-20 09:27:45,163 [salt.fileclient  ][INFO    ][25077] Fetching file from saltenv 'base', ** done ** '_grains/ceilometer_policy.py'
2017-11-20 09:27:45,173 [salt.fileclient  ][INFO    ][25077] Fetching file from saltenv 'base', ** done ** '_grains/ceph.py'
2017-11-20 09:27:45,197 [salt.fileclient  ][INFO    ][25077] Fetching file from saltenv 'base', ** done ** '_grains/cinder_policy.py'
2017-11-20 09:27:45,260 [salt.fileclient  ][INFO    ][25077] Fetching file from saltenv 'base', ** done ** '_grains/docker_swarm.py'
2017-11-20 09:27:45,281 [salt.fileclient  ][INFO    ][25077] Fetching file from saltenv 'base', ** done ** '_grains/glance_policy.py'
2017-11-20 09:27:45,379 [salt.fileclient  ][INFO    ][25077] Fetching file from saltenv 'base', ** done ** '_grains/heat_policy.py'
2017-11-20 09:27:45,395 [salt.fileclient  ][INFO    ][25077] Fetching file from saltenv 'base', ** done ** '_grains/jenkins_plugins.py'
2017-11-20 09:27:45,429 [salt.fileclient  ][INFO    ][25077] Fetching file from saltenv 'base', ** done ** '_grains/keystone_policy.py'
2017-11-20 09:27:45,465 [salt.fileclient  ][INFO    ][25077] Fetching file from saltenv 'base', ** done ** '_grains/kubernetes.py'
2017-11-20 09:27:45,494 [salt.fileclient  ][INFO    ][25077] Fetching file from saltenv 'base', ** done ** '_grains/neutron_policy.py'
2017-11-20 09:27:45,505 [salt.fileclient  ][INFO    ][25077] Fetching file from saltenv 'base', ** done ** '_grains/nova_policy.py'
2017-11-20 09:27:45,516 [salt.fileclient  ][INFO    ][25077] Fetching file from saltenv 'base', ** done ** '_grains/ssh_fingerprints.py'
2017-11-20 09:27:45,520 [salt.utils.extmods][INFO    ][25077] Copying '/var/cache/salt/minion/files/base/_grains/ceilometer_policy.py' to '/var/cache/salt/minion/extmods/grains/ceilometer_policy.py'
2017-11-20 09:27:45,520 [salt.utils.extmods][INFO    ][25077] Copying '/var/cache/salt/minion/files/base/_grains/ceph.py' to '/var/cache/salt/minion/extmods/grains/ceph.py'
2017-11-20 09:27:45,520 [salt.utils.extmods][INFO    ][25077] Copying '/var/cache/salt/minion/files/base/_grains/cinder_policy.py' to '/var/cache/salt/minion/extmods/grains/cinder_policy.py'
2017-11-20 09:27:45,520 [salt.utils.extmods][INFO    ][25077] Copying '/var/cache/salt/minion/files/base/_grains/docker_swarm.py' to '/var/cache/salt/minion/extmods/grains/docker_swarm.py'
2017-11-20 09:27:45,521 [salt.utils.extmods][INFO    ][25077] Copying '/var/cache/salt/minion/files/base/_grains/glance_policy.py' to '/var/cache/salt/minion/extmods/grains/glance_policy.py'
2017-11-20 09:27:45,521 [salt.utils.extmods][INFO    ][25077] Copying '/var/cache/salt/minion/files/base/_grains/heat_policy.py' to '/var/cache/salt/minion/extmods/grains/heat_policy.py'
2017-11-20 09:27:45,521 [salt.utils.extmods][INFO    ][25077] Copying '/var/cache/salt/minion/files/base/_grains/jenkins_plugins.py' to '/var/cache/salt/minion/extmods/grains/jenkins_plugins.py'
2017-11-20 09:27:45,521 [salt.utils.extmods][INFO    ][25077] Copying '/var/cache/salt/minion/files/base/_grains/keystone_policy.py' to '/var/cache/salt/minion/extmods/grains/keystone_policy.py'
2017-11-20 09:27:45,522 [salt.utils.extmods][INFO    ][25077] Copying '/var/cache/salt/minion/files/base/_grains/kubernetes.py' to '/var/cache/salt/minion/extmods/grains/kubernetes.py'
2017-11-20 09:27:45,522 [salt.utils.extmods][INFO    ][25077] Copying '/var/cache/salt/minion/files/base/_grains/neutron_policy.py' to '/var/cache/salt/minion/extmods/grains/neutron_policy.py'
2017-11-20 09:27:45,522 [salt.utils.extmods][INFO    ][25077] Copying '/var/cache/salt/minion/files/base/_grains/nova_policy.py' to '/var/cache/salt/minion/extmods/grains/nova_policy.py'
2017-11-20 09:27:45,522 [salt.utils.extmods][INFO    ][25077] Copying '/var/cache/salt/minion/files/base/_grains/ssh_fingerprints.py' to '/var/cache/salt/minion/extmods/grains/ssh_fingerprints.py'
2017-11-20 09:27:45,524 [salt.utils.extmods][INFO    ][25077] Creating module dir '/var/cache/salt/minion/extmods/renderers'
2017-11-20 09:27:45,527 [salt.utils.extmods][INFO    ][25077] Syncing renderers for environment 'base'
2017-11-20 09:27:45,527 [salt.utils.extmods][INFO    ][25077] Loading cache from salt://_renderers, for base)
2017-11-20 09:27:45,528 [salt.fileclient  ][INFO    ][25077] Caching directory '_renderers/' for environment 'base'
2017-11-20 09:27:45,560 [salt.utils.extmods][INFO    ][25077] Creating module dir '/var/cache/salt/minion/extmods/returners'
2017-11-20 09:27:45,563 [salt.utils.extmods][INFO    ][25077] Syncing returners for environment 'base'
2017-11-20 09:27:45,563 [salt.utils.extmods][INFO    ][25077] Loading cache from salt://_returners, for base)
2017-11-20 09:27:45,563 [salt.fileclient  ][INFO    ][25077] Caching directory '_returners/' for environment 'base'
2017-11-20 09:27:45,649 [salt.utils.extmods][INFO    ][25077] Creating module dir '/var/cache/salt/minion/extmods/output'
2017-11-20 09:27:45,652 [salt.utils.extmods][INFO    ][25077] Syncing output for environment 'base'
2017-11-20 09:27:45,652 [salt.utils.extmods][INFO    ][25077] Loading cache from salt://_output, for base)
2017-11-20 09:27:45,652 [salt.fileclient  ][INFO    ][25077] Caching directory '_output/' for environment 'base'
2017-11-20 09:27:45,706 [salt.utils.extmods][INFO    ][25077] Creating module dir '/var/cache/salt/minion/extmods/utils'
2017-11-20 09:27:45,709 [salt.utils.extmods][INFO    ][25077] Syncing utils for environment 'base'
2017-11-20 09:27:45,709 [salt.utils.extmods][INFO    ][25077] Loading cache from salt://_utils, for base)
2017-11-20 09:27:45,709 [salt.fileclient  ][INFO    ][25077] Caching directory '_utils/' for environment 'base'
2017-11-20 09:27:45,784 [salt.utils.extmods][INFO    ][25077] Creating module dir '/var/cache/salt/minion/extmods/log_handlers'
2017-11-20 09:27:45,787 [salt.utils.extmods][INFO    ][25077] Syncing log_handlers for environment 'base'
2017-11-20 09:27:45,788 [salt.utils.extmods][INFO    ][25077] Loading cache from salt://_log_handlers, for base)
2017-11-20 09:27:45,788 [salt.fileclient  ][INFO    ][25077] Caching directory '_log_handlers/' for environment 'base'
2017-11-20 09:27:45,867 [salt.utils.extmods][INFO    ][25077] Creating module dir '/var/cache/salt/minion/extmods/proxy'
2017-11-20 09:27:45,870 [salt.utils.extmods][INFO    ][25077] Syncing proxy for environment 'base'
2017-11-20 09:27:45,870 [salt.utils.extmods][INFO    ][25077] Loading cache from salt://_proxy, for base)
2017-11-20 09:27:45,871 [salt.fileclient  ][INFO    ][25077] Caching directory '_proxy/' for environment 'base'
2017-11-20 09:27:45,947 [salt.utils.extmods][INFO    ][25077] Creating module dir '/var/cache/salt/minion/extmods/engines'
2017-11-20 09:27:45,950 [salt.utils.extmods][INFO    ][25077] Syncing engines for environment 'base'
2017-11-20 09:27:45,950 [salt.utils.extmods][INFO    ][25077] Loading cache from salt://_engines, for base)
2017-11-20 09:27:45,950 [salt.fileclient  ][INFO    ][25077] Caching directory '_engines/' for environment 'base'
2017-11-20 09:27:45,990 [salt.minion      ][INFO    ][25077] Returning information for job: 20171120092738256730
2017-11-20 09:37:41,135 [salt.minion      ][INFO    ][24842] User sudo_ubuntu Executing command test.ping with jid 20171120093741126200
2017-11-20 09:37:41,148 [salt.minion      ][INFO    ][25361] Starting a new job with PID 25361
2017-11-20 09:37:41,186 [salt.minion      ][INFO    ][25361] Returning information for job: 20171120093741126200
2017-11-20 09:38:05,413 [salt.minion      ][INFO    ][24842] User sudo_ubuntu Executing command state.sls with jid 20171120093805403962
2017-11-20 09:38:05,422 [salt.minion      ][INFO    ][25371] Starting a new job with PID 25371
2017-11-20 09:38:07,764 [salt.state       ][INFO    ][25371] Loading fresh modules for state activity
2017-11-20 09:38:07,797 [salt.fileclient  ][INFO    ][25371] Fetching file from saltenv 'base', ** done ** 'keepalived/init.sls'
2017-11-20 09:38:07,816 [salt.fileclient  ][INFO    ][25371] Fetching file from saltenv 'base', ** done ** 'keepalived/cluster.sls'
2017-11-20 09:38:07,847 [salt.fileclient  ][INFO    ][25371] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-11-20 09:38:08,171 [salt.state       ][INFO    ][25371] Running state [lsof] at time 09:38:08.170974
2017-11-20 09:38:08,171 [salt.state       ][INFO    ][25371] Executing state pkg.installed for lsof
2017-11-20 09:38:08,172 [salt.loaded.int.module.cmdmod][INFO    ][25371] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-20 09:38:08,424 [salt.state       ][INFO    ][25371] Package lsof is already installed
2017-11-20 09:38:08,424 [salt.state       ][INFO    ][25371] Completed state [lsof] at time 09:38:08.424317 duration_in_ms=253.344
2017-11-20 09:38:08,425 [salt.state       ][INFO    ][25371] Running state [keepalived] at time 09:38:08.424568
2017-11-20 09:38:08,425 [salt.state       ][INFO    ][25371] Executing state pkg.installed for keepalived
2017-11-20 09:38:08,441 [salt.loaded.int.module.cmdmod][INFO    ][25371] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-11-20 09:38:10,382 [salt.loaded.int.module.cmdmod][INFO    ][25371] 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-20 09:38:13,010 [salt.loaded.int.module.cmdmod][INFO    ][25371] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-20 09:38:13,035 [salt.state       ][INFO    ][25371] 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-20 09:38:13,046 [salt.state       ][INFO    ][25371] Loading fresh modules for state activity
2017-11-20 09:38:13,063 [salt.state       ][INFO    ][25371] Completed state [keepalived] at time 09:38:13.062465 duration_in_ms=4637.897
2017-11-20 09:38:13,065 [salt.state       ][INFO    ][25371] Running state [/etc/keepalived/keepalived.conf] at time 09:38:13.064845
2017-11-20 09:38:13,065 [salt.state       ][INFO    ][25371] Executing state file.managed for /etc/keepalived/keepalived.conf
2017-11-20 09:38:13,093 [salt.fileclient  ][INFO    ][25371] Fetching file from saltenv 'base', ** done ** 'keepalived/files/keepalived.conf'
2017-11-20 09:38:13,132 [salt.fileclient  ][INFO    ][25371] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-11-20 09:38:13,139 [salt.state       ][INFO    ][25371] File changed:
New file
2017-11-20 09:38:13,140 [salt.state       ][INFO    ][25371] Completed state [/etc/keepalived/keepalived.conf] at time 09:38:13.139561 duration_in_ms=74.714
2017-11-20 09:38:13,206 [salt.state       ][INFO    ][25371] Running state [keepalived] at time 09:38:13.205495
2017-11-20 09:38:13,206 [salt.state       ][INFO    ][25371] Executing state service.running for keepalived
2017-11-20 09:38:13,208 [salt.loaded.int.module.cmdmod][INFO    ][25371] Executing command ['systemctl', 'status', 'keepalived.service', '-n', '0'] in directory '/root'
2017-11-20 09:38:13,217 [salt.loaded.int.module.cmdmod][INFO    ][25371] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2017-11-20 09:38:13,223 [salt.loaded.int.module.cmdmod][INFO    ][25371] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-11-20 09:38:13,231 [salt.loaded.int.module.cmdmod][INFO    ][25371] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-11-20 09:38:13,238 [salt.loaded.int.module.cmdmod][INFO    ][25371] Executing command ['systemd-run', '--scope', 'systemctl', 'start', 'keepalived.service'] in directory '/root'
2017-11-20 09:38:13,269 [salt.loaded.int.module.cmdmod][INFO    ][25371] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2017-11-20 09:38:13,277 [salt.loaded.int.module.cmdmod][INFO    ][25371] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-11-20 09:38:13,285 [salt.loaded.int.module.cmdmod][INFO    ][25371] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-11-20 09:38:13,292 [salt.state       ][INFO    ][25371] {'keepalived': True}
2017-11-20 09:38:13,292 [salt.state       ][INFO    ][25371] Completed state [keepalived] at time 09:38:13.292073 duration_in_ms=86.577
2017-11-20 09:38:13,293 [salt.minion      ][INFO    ][25371] Returning information for job: 20171120093805403962
2017-11-20 09:39:55,886 [salt.minion      ][INFO    ][24842] User sudo_ubuntu Executing command pillar.get with jid 20171120093955878042
2017-11-20 09:39:55,901 [salt.minion      ][INFO    ][27006] Starting a new job with PID 27006
2017-11-20 09:39:55,906 [salt.minion      ][INFO    ][27006] Returning information for job: 20171120093955878042
2017-11-20 09:44:25,234 [salt.minion      ][INFO    ][24842] User sudo_ubuntu Executing command state.sls with jid 20171120094425212606
2017-11-20 09:44:25,245 [salt.minion      ][INFO    ][27105] Starting a new job with PID 27105
2017-11-20 09:44:27,953 [salt.state       ][INFO    ][27105] Loading fresh modules for state activity
2017-11-20 09:44:27,985 [salt.fileclient  ][INFO    ][27105] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-11-20 09:44:28,012 [salt.fileclient  ][INFO    ][27105] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-11-20 09:44:28,326 [salt.state       ][INFO    ][27105] Running state [attr] at time 09:44:28.325567
2017-11-20 09:44:28,326 [salt.state       ][INFO    ][27105] Executing state pkg.installed for attr
2017-11-20 09:44:28,326 [salt.loaded.int.module.cmdmod][INFO    ][27105] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-20 09:44:28,604 [salt.loaded.int.module.cmdmod][INFO    ][27105] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-11-20 09:44:30,568 [salt.loaded.int.module.cmdmod][INFO    ][27105] 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-20 09:44:31,986 [salt.loaded.int.module.cmdmod][INFO    ][27105] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-20 09:44:32,015 [salt.state       ][INFO    ][27105] Made the following changes:
'attr' changed from 'absent' to '1:2.4.47-2'

2017-11-20 09:44:32,027 [salt.state       ][INFO    ][27105] Loading fresh modules for state activity
2017-11-20 09:44:32,044 [salt.state       ][INFO    ][27105] Completed state [attr] at time 09:44:32.044379 duration_in_ms=3718.811
2017-11-20 09:44:32,050 [salt.state       ][INFO    ][27105] Running state [glusterfs-server] at time 09:44:32.050292
2017-11-20 09:44:32,051 [salt.state       ][INFO    ][27105] Executing state pkg.installed for glusterfs-server
2017-11-20 09:44:32,281 [salt.loaded.int.module.cmdmod][INFO    ][27105] 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-20 09:44:35,374 [salt.minion      ][INFO    ][24842] User sudo_ubuntu Executing command saltutil.find_job with jid 20171120094435330565
2017-11-20 09:44:35,383 [salt.minion      ][INFO    ][30945] Starting a new job with PID 30945
2017-11-20 09:44:35,395 [salt.minion      ][INFO    ][30945] Returning information for job: 20171120094435330565
2017-11-20 09:44:38,403 [salt.loaded.int.module.cmdmod][INFO    ][27105] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-20 09:44:38,433 [salt.state       ][INFO    ][27105] 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-20 09:44:38,443 [salt.state       ][INFO    ][27105] Loading fresh modules for state activity
2017-11-20 09:44:38,461 [salt.state       ][INFO    ][27105] Completed state [glusterfs-server] at time 09:44:38.461008 duration_in_ms=6410.716
2017-11-20 09:44:38,467 [salt.state       ][INFO    ][27105] Running state [bc] at time 09:44:38.466475
2017-11-20 09:44:38,467 [salt.state       ][INFO    ][27105] Executing state pkg.installed for bc
2017-11-20 09:44:38,736 [salt.loaded.int.module.cmdmod][INFO    ][27105] 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-20 09:44:40,129 [salt.loaded.int.module.cmdmod][INFO    ][27105] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-20 09:44:40,160 [salt.state       ][INFO    ][27105] Made the following changes:
'bc' changed from 'absent' to '1.06.95-9build1'

2017-11-20 09:44:40,169 [salt.state       ][INFO    ][27105] Loading fresh modules for state activity
2017-11-20 09:44:40,185 [salt.state       ][INFO    ][27105] Completed state [bc] at time 09:44:40.185392 duration_in_ms=1718.916
2017-11-20 09:44:40,256 [salt.state       ][INFO    ][27105] Running state [glusterfs-server] at time 09:44:40.255586
2017-11-20 09:44:40,256 [salt.state       ][INFO    ][27105] Executing state service.running for glusterfs-server
2017-11-20 09:44:40,258 [salt.loaded.int.module.cmdmod][INFO    ][27105] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-11-20 09:44:40,267 [salt.loaded.int.module.cmdmod][INFO    ][27105] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-11-20 09:44:40,274 [salt.loaded.int.module.cmdmod][INFO    ][27105] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-11-20 09:44:40,283 [salt.state       ][INFO    ][27105] The service glusterfs-server is already running
2017-11-20 09:44:40,283 [salt.state       ][INFO    ][27105] Completed state [glusterfs-server] at time 09:44:40.282981 duration_in_ms=27.396
2017-11-20 09:44:40,285 [salt.state       ][INFO    ][27105] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 09:44:40.284609
2017-11-20 09:44:40,285 [salt.state       ][INFO    ][27105] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-11-20 09:44:40,290 [salt.state       ][INFO    ][27105] File changed:
New file
2017-11-20 09:44:40,290 [salt.state       ][INFO    ][27105] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 09:44:40.289952 duration_in_ms=5.343
2017-11-20 09:44:40,290 [salt.state       ][INFO    ][27105] Running state [/srv/glusterfs/glance] at time 09:44:40.290175
2017-11-20 09:44:40,290 [salt.state       ][INFO    ][27105] Executing state file.directory for /srv/glusterfs/glance
2017-11-20 09:44:40,291 [salt.state       ][INFO    ][27105] {'/srv/glusterfs/glance': 'New Dir'}
2017-11-20 09:44:40,291 [salt.state       ][INFO    ][27105] Completed state [/srv/glusterfs/glance] at time 09:44:40.291230 duration_in_ms=1.056
2017-11-20 09:44:40,292 [salt.state       ][INFO    ][27105] Running state [/srv/glusterfs/keystone-keys] at time 09:44:40.291473
2017-11-20 09:44:40,292 [salt.state       ][INFO    ][27105] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-11-20 09:44:40,292 [salt.state       ][INFO    ][27105] {'/srv/glusterfs/keystone-keys': 'New Dir'}
2017-11-20 09:44:40,292 [salt.state       ][INFO    ][27105] Completed state [/srv/glusterfs/keystone-keys] at time 09:44:40.292381 duration_in_ms=0.908
2017-11-20 09:44:40,293 [salt.state       ][INFO    ][27105] Running state [/srv/glusterfs/nova_instances] at time 09:44:40.292580
2017-11-20 09:44:40,293 [salt.state       ][INFO    ][27105] Executing state file.directory for /srv/glusterfs/nova_instances
2017-11-20 09:44:40,293 [salt.state       ][INFO    ][27105] {'/srv/glusterfs/nova_instances': 'New Dir'}
2017-11-20 09:44:40,293 [salt.state       ][INFO    ][27105] Completed state [/srv/glusterfs/nova_instances] at time 09:44:40.293414 duration_in_ms=0.834
2017-11-20 09:44:40,294 [salt.state       ][INFO    ][27105] Running state [/srv/glusterfs/keystone-credential-keys] at time 09:44:40.293619
2017-11-20 09:44:40,294 [salt.state       ][INFO    ][27105] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-11-20 09:44:40,294 [salt.state       ][INFO    ][27105] {'/srv/glusterfs/keystone-credential-keys': 'New Dir'}
2017-11-20 09:44:40,295 [salt.state       ][INFO    ][27105] Completed state [/srv/glusterfs/keystone-credential-keys] at time 09:44:40.294486 duration_in_ms=0.867
2017-11-20 09:44:40,295 [salt.minion      ][INFO    ][27105] Returning information for job: 20171120094425212606
2017-11-20 09:44:48,250 [salt.minion      ][INFO    ][24842] User sudo_ubuntu Executing command test.ping with jid 20171120094448236503
2017-11-20 09:44:48,260 [salt.minion      ][INFO    ][31890] Starting a new job with PID 31890
2017-11-20 09:44:48,296 [salt.minion      ][INFO    ][31890] Returning information for job: 20171120094448236503
2017-11-20 09:45:16,550 [salt.minion      ][INFO    ][24842] User sudo_ubuntu Executing command state.sls with jid 20171120094516521815
2017-11-20 09:45:16,560 [salt.minion      ][INFO    ][32103] Starting a new job with PID 32103
2017-11-20 09:45:19,345 [salt.state       ][INFO    ][32103] Loading fresh modules for state activity
2017-11-20 09:45:19,385 [salt.fileclient  ][INFO    ][32103] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/setup.sls'
2017-11-20 09:45:19,437 [salt.fileclient  ][INFO    ][32103] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-11-20 09:45:19,523 [salt.fileclient  ][INFO    ][32103] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-11-20 09:45:19,549 [salt.fileclient  ][INFO    ][32103] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-11-20 09:45:19,861 [salt.state       ][INFO    ][32103] Running state [attr] at time 09:45:19.860480
2017-11-20 09:45:19,861 [salt.state       ][INFO    ][32103] Executing state pkg.installed for attr
2017-11-20 09:45:19,861 [salt.loaded.int.module.cmdmod][INFO    ][32103] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-20 09:45:20,142 [salt.state       ][INFO    ][32103] Package attr is already installed
2017-11-20 09:45:20,142 [salt.state       ][INFO    ][32103] Completed state [attr] at time 09:45:20.142226 duration_in_ms=281.746
2017-11-20 09:45:20,143 [salt.state       ][INFO    ][32103] Running state [glusterfs-server] at time 09:45:20.142478
2017-11-20 09:45:20,143 [salt.state       ][INFO    ][32103] Executing state pkg.installed for glusterfs-server
2017-11-20 09:45:20,147 [salt.state       ][INFO    ][32103] Package glusterfs-server is already installed
2017-11-20 09:45:20,147 [salt.state       ][INFO    ][32103] Completed state [glusterfs-server] at time 09:45:20.146790 duration_in_ms=4.313
2017-11-20 09:45:20,147 [salt.state       ][INFO    ][32103] Running state [bc] at time 09:45:20.146990
2017-11-20 09:45:20,147 [salt.state       ][INFO    ][32103] Executing state pkg.installed for bc
2017-11-20 09:45:20,151 [salt.state       ][INFO    ][32103] Package bc is already installed
2017-11-20 09:45:20,151 [salt.state       ][INFO    ][32103] Completed state [bc] at time 09:45:20.151208 duration_in_ms=4.217
2017-11-20 09:45:20,152 [salt.state       ][INFO    ][32103] Running state [glusterfs-server] at time 09:45:20.152260
2017-11-20 09:45:20,152 [salt.state       ][INFO    ][32103] Executing state service.running for glusterfs-server
2017-11-20 09:45:20,153 [salt.loaded.int.module.cmdmod][INFO    ][32103] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-11-20 09:45:20,161 [salt.loaded.int.module.cmdmod][INFO    ][32103] Executing command ['systemctl', '--system', 'daemon-reload'] in directory '/root'
2017-11-20 09:45:20,209 [salt.loaded.int.module.cmdmod][INFO    ][32103] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-11-20 09:45:20,224 [salt.loaded.int.module.cmdmod][INFO    ][32103] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-11-20 09:45:20,231 [salt.loaded.int.module.cmdmod][INFO    ][32103] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-11-20 09:45:20,240 [salt.state       ][INFO    ][32103] The service glusterfs-server is already running
2017-11-20 09:45:20,240 [salt.state       ][INFO    ][32103] Completed state [glusterfs-server] at time 09:45:20.240171 duration_in_ms=87.91
2017-11-20 09:45:20,242 [salt.state       ][INFO    ][32103] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 09:45:20.241685
2017-11-20 09:45:20,242 [salt.state       ][INFO    ][32103] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-11-20 09:45:20,244 [salt.state       ][INFO    ][32103] File /etc/systemd/system/glusterfs-server.service.d/override.conf is in the correct state
2017-11-20 09:45:20,244 [salt.state       ][INFO    ][32103] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 09:45:20.244051 duration_in_ms=2.366
2017-11-20 09:45:20,244 [salt.state       ][INFO    ][32103] Running state [/srv/glusterfs/glance] at time 09:45:20.244228
2017-11-20 09:45:20,244 [salt.state       ][INFO    ][32103] Executing state file.directory for /srv/glusterfs/glance
2017-11-20 09:45:20,245 [salt.state       ][INFO    ][32103] Directory /srv/glusterfs/glance is in the correct state
2017-11-20 09:45:20,245 [salt.state       ][INFO    ][32103] Completed state [/srv/glusterfs/glance] at time 09:45:20.244914 duration_in_ms=0.686
2017-11-20 09:45:20,245 [salt.state       ][INFO    ][32103] Running state [/srv/glusterfs/keystone-keys] at time 09:45:20.245077
2017-11-20 09:45:20,245 [salt.state       ][INFO    ][32103] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-11-20 09:45:20,246 [salt.state       ][INFO    ][32103] Directory /srv/glusterfs/keystone-keys is in the correct state
2017-11-20 09:45:20,246 [salt.state       ][INFO    ][32103] Completed state [/srv/glusterfs/keystone-keys] at time 09:45:20.245756 duration_in_ms=0.679
2017-11-20 09:45:20,246 [salt.state       ][INFO    ][32103] Running state [/srv/glusterfs/nova_instances] at time 09:45:20.245925
2017-11-20 09:45:20,246 [salt.state       ][INFO    ][32103] Executing state file.directory for /srv/glusterfs/nova_instances
2017-11-20 09:45:20,246 [salt.state       ][INFO    ][32103] Directory /srv/glusterfs/nova_instances is in the correct state
2017-11-20 09:45:20,247 [salt.state       ][INFO    ][32103] Completed state [/srv/glusterfs/nova_instances] at time 09:45:20.246553 duration_in_ms=0.628
2017-11-20 09:45:20,247 [salt.state       ][INFO    ][32103] Running state [/srv/glusterfs/keystone-credential-keys] at time 09:45:20.246728
2017-11-20 09:45:20,247 [salt.state       ][INFO    ][32103] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-11-20 09:45:20,247 [salt.state       ][INFO    ][32103] Directory /srv/glusterfs/keystone-credential-keys is in the correct state
2017-11-20 09:45:20,247 [salt.state       ][INFO    ][32103] Completed state [/srv/glusterfs/keystone-credential-keys] at time 09:45:20.247403 duration_in_ms=0.676
2017-11-20 09:45:20,307 [salt.loaded.int.module.cmdmod][INFO    ][32103] Executing command ['git', '--version'] in directory '/root'
2017-11-20 09:45:20,398 [salt.state       ][INFO    ][32103] Running state [sleep 5] at time 09:45:20.398376
2017-11-20 09:45:20,399 [salt.state       ][INFO    ][32103] Executing state cmd.wait for sleep 5
2017-11-20 09:45:20,399 [salt.state       ][INFO    ][32103] No changes made for sleep 5
2017-11-20 09:45:20,399 [salt.state       ][INFO    ][32103] Completed state [sleep 5] at time 09:45:20.399029 duration_in_ms=0.655
2017-11-20 09:45:20,400 [salt.state       ][INFO    ][32103] Running state [192.168.10.143] at time 09:45:20.399646
2017-11-20 09:45:20,400 [salt.state       ][INFO    ][32103] Executing state glusterfs.peered for 192.168.10.143
2017-11-20 09:45:20,400 [salt.loaded.int.module.cmdmod][INFO    ][32103] Executing command 'gluster --version' in directory '/root'
2017-11-20 09:45:20,408 [salt.loaded.int.module.cmdmod][INFO    ][32103] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-20 09:45:20,463 [salt.loaded.int.module.cmdmod][INFO    ][32103] Executing command 'gluster --version' in directory '/root'
2017-11-20 09:45:20,471 [salt.loaded.int.module.cmdmod][INFO    ][32103] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-20 09:45:20,525 [salt.loaded.int.module.cmdmod][INFO    ][32103] Executing command 'gluster --version' in directory '/root'
2017-11-20 09:45:20,533 [salt.loaded.int.module.cmdmod][INFO    ][32103] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-20 09:45:20,585 [salt.loaded.int.module.cmdmod][INFO    ][32103] Executing command 'gluster --version' in directory '/root'
2017-11-20 09:45:20,593 [salt.loaded.int.module.cmdmod][INFO    ][32103] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-20 09:45:20,644 [salt.state       ][INFO    ][32103] Peering with localhost is not needed
2017-11-20 09:45:20,645 [salt.state       ][INFO    ][32103] Completed state [192.168.10.143] at time 09:45:20.644582 duration_in_ms=244.935
2017-11-20 09:45:20,648 [salt.state       ][INFO    ][32103] Running state [192.168.10.142] at time 09:45:20.647871
2017-11-20 09:45:20,648 [salt.state       ][INFO    ][32103] Executing state glusterfs.peered for 192.168.10.142
2017-11-20 09:45:20,649 [salt.loaded.int.module.cmdmod][INFO    ][32103] Executing command 'gluster --version' in directory '/root'
2017-11-20 09:45:20,656 [salt.loaded.int.module.cmdmod][INFO    ][32103] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-20 09:45:20,709 [salt.loaded.int.module.cmdmod][INFO    ][32103] Executing command 'gluster --version' in directory '/root'
2017-11-20 09:45:20,716 [salt.loaded.int.module.cmdmod][INFO    ][32103] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-20 09:45:20,769 [salt.loaded.int.module.cmdmod][INFO    ][32103] Executing command 'gluster --version' in directory '/root'
2017-11-20 09:45:20,777 [salt.loaded.int.module.cmdmod][INFO    ][32103] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-20 09:45:20,831 [salt.loaded.int.module.cmdmod][INFO    ][32103] Executing command 'gluster --version' in directory '/root'
2017-11-20 09:45:20,838 [salt.loaded.int.module.cmdmod][INFO    ][32103] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-20 09:45:20,889 [salt.state       ][INFO    ][32103] {'new': {'192.168.10.141': [], 'kvm02.baremetal-mcp-ocata-odl-ha.local': ['192.168.10.142']}, 'old': {'192.168.10.141': [], 'kvm02.baremetal-mcp-ocata-odl-ha.local': []}}
2017-11-20 09:45:20,889 [salt.state       ][INFO    ][32103] Completed state [192.168.10.142] at time 09:45:20.889435 duration_in_ms=241.563
2017-11-20 09:45:20,893 [salt.state       ][INFO    ][32103] Running state [192.168.10.141] at time 09:45:20.892693
2017-11-20 09:45:20,893 [salt.state       ][INFO    ][32103] Executing state glusterfs.peered for 192.168.10.141
2017-11-20 09:45:20,893 [salt.loaded.int.module.cmdmod][INFO    ][32103] Executing command 'gluster --version' in directory '/root'
2017-11-20 09:45:20,901 [salt.loaded.int.module.cmdmod][INFO    ][32103] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-20 09:45:20,954 [salt.state       ][INFO    ][32103] Host 192.168.10.141 already peered
2017-11-20 09:45:20,954 [salt.state       ][INFO    ][32103] Completed state [192.168.10.141] at time 09:45:20.954077 duration_in_ms=61.383
2017-11-20 09:45:20,955 [salt.state       ][INFO    ][32103] Running state [glance] at time 09:45:20.955183
2017-11-20 09:45:20,955 [salt.state       ][INFO    ][32103] Executing state glusterfs.created for glance
2017-11-20 09:45:20,956 [salt.loaded.int.module.cmdmod][INFO    ][32103] Executing command 'gluster --version' in directory '/root'
2017-11-20 09:45:20,964 [salt.loaded.int.module.cmdmod][INFO    ][32103] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-20 09:45:21,016 [salt.loaded.int.module.cmdmod][INFO    ][32103] Executing command 'gluster --version' in directory '/root'
2017-11-20 09:45:21,023 [salt.loaded.int.module.cmdmod][INFO    ][32103] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-20 09:45:21,079 [salt.state       ][INFO    ][32103] Volume glance already exists and is started.
2017-11-20 09:45:21,079 [salt.state       ][INFO    ][32103] Completed state [glance] at time 09:45:21.079203 duration_in_ms=124.019
2017-11-20 09:45:21,083 [salt.state       ][INFO    ][32103] Running state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 09:45:21.082663
2017-11-20 09:45:21,083 [salt.state       ][INFO    ][32103] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'
2017-11-20 09:45:21,083 [salt.loaded.int.module.cmdmod][INFO    ][32103] Executing command 'gluster volume info 'glance' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-11-20 09:45:21,134 [salt.state       ][INFO    ][32103] unless execution succeeded
2017-11-20 09:45:21,135 [salt.state       ][INFO    ][32103] Completed state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 09:45:21.134656 duration_in_ms=51.992
2017-11-20 09:45:21,135 [salt.state       ][INFO    ][32103] Running state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 09:45:21.135234
2017-11-20 09:45:21,136 [salt.state       ][INFO    ][32103] Executing state cmd.run for gluster volume set 'glance' 'network.remote-dio' 'True'
2017-11-20 09:45:21,136 [salt.loaded.int.module.cmdmod][INFO    ][32103] Executing command 'gluster volume info 'glance' | grep 'network.remote-dio: True'' in directory '/root'
2017-11-20 09:45:21,191 [salt.state       ][INFO    ][32103] unless execution succeeded
2017-11-20 09:45:21,191 [salt.state       ][INFO    ][32103] Completed state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 09:45:21.190925 duration_in_ms=55.69
2017-11-20 09:45:21,192 [salt.state       ][INFO    ][32103] Running state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 09:45:21.191479
2017-11-20 09:45:21,192 [salt.state       ][INFO    ][32103] Executing state cmd.run for gluster volume set 'glance' 'nfs.disable' 'True'
2017-11-20 09:45:21,192 [salt.loaded.int.module.cmdmod][INFO    ][32103] Executing command 'gluster volume info 'glance' | grep 'nfs.disable: True'' in directory '/root'
2017-11-20 09:45:21,242 [salt.state       ][INFO    ][32103] unless execution succeeded
2017-11-20 09:45:21,242 [salt.state       ][INFO    ][32103] Completed state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 09:45:21.242346 duration_in_ms=50.867
2017-11-20 09:45:21,243 [salt.state       ][INFO    ][32103] Running state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 09:45:21.242893
2017-11-20 09:45:21,243 [salt.state       ][INFO    ][32103] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'
2017-11-20 09:45:21,244 [salt.loaded.int.module.cmdmod][INFO    ][32103] Executing command 'gluster volume info 'glance' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-11-20 09:45:21,293 [salt.state       ][INFO    ][32103] unless execution succeeded
2017-11-20 09:45:21,293 [salt.state       ][INFO    ][32103] Completed state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 09:45:21.293361 duration_in_ms=50.468
2017-11-20 09:45:21,294 [salt.state       ][INFO    ][32103] Running state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 09:45:21.293930
2017-11-20 09:45:21,294 [salt.state       ][INFO    ][32103] Executing state cmd.run for gluster volume set 'glance' 'cluster.readdir-optimize' 'True'
2017-11-20 09:45:21,295 [salt.loaded.int.module.cmdmod][INFO    ][32103] Executing command 'gluster volume info 'glance' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-11-20 09:45:21,346 [salt.state       ][INFO    ][32103] unless execution succeeded
2017-11-20 09:45:21,346 [salt.state       ][INFO    ][32103] Completed state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 09:45:21.346382 duration_in_ms=52.452
2017-11-20 09:45:21,349 [salt.state       ][INFO    ][32103] Running state [glance] at time 09:45:21.348507
2017-11-20 09:45:21,349 [salt.state       ][INFO    ][32103] Executing state glusterfs.started for glance
2017-11-20 09:45:21,350 [salt.loaded.int.module.cmdmod][INFO    ][32103] Executing command 'gluster --version' in directory '/root'
2017-11-20 09:45:21,359 [salt.loaded.int.module.cmdmod][INFO    ][32103] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-20 09:45:21,413 [salt.loaded.int.module.cmdmod][INFO    ][32103] Executing command 'gluster --version' in directory '/root'
2017-11-20 09:45:21,421 [salt.loaded.int.module.cmdmod][INFO    ][32103] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-20 09:45:21,477 [salt.state       ][INFO    ][32103] Volume glance is already started
2017-11-20 09:45:21,478 [salt.state       ][INFO    ][32103] Completed state [glance] at time 09:45:21.477661 duration_in_ms=129.158
2017-11-20 09:45:21,479 [salt.state       ][INFO    ][32103] Running state [keystone-keys] at time 09:45:21.479009
2017-11-20 09:45:21,479 [salt.state       ][INFO    ][32103] Executing state glusterfs.created for keystone-keys
2017-11-20 09:45:21,480 [salt.loaded.int.module.cmdmod][INFO    ][32103] Executing command 'gluster --version' in directory '/root'
2017-11-20 09:45:21,488 [salt.loaded.int.module.cmdmod][INFO    ][32103] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-20 09:45:21,541 [salt.loaded.int.module.cmdmod][INFO    ][32103] Executing command 'gluster --version' in directory '/root'
2017-11-20 09:45:21,548 [salt.loaded.int.module.cmdmod][INFO    ][32103] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-20 09:45:21,605 [salt.state       ][INFO    ][32103] Volume keystone-keys already exists and is started.
2017-11-20 09:45:21,605 [salt.state       ][INFO    ][32103] Completed state [keystone-keys] at time 09:45:21.605006 duration_in_ms=125.997
2017-11-20 09:45:21,609 [salt.state       ][INFO    ][32103] Running state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 09:45:21.608916
2017-11-20 09:45:21,609 [salt.state       ][INFO    ][32103] Executing state cmd.run for gluster volume set 'keystone-keys' 'network.remote-dio' 'True'
2017-11-20 09:45:21,610 [salt.loaded.int.module.cmdmod][INFO    ][32103] Executing command 'gluster volume info 'keystone-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-11-20 09:45:21,661 [salt.state       ][INFO    ][32103] unless execution succeeded
2017-11-20 09:45:21,661 [salt.state       ][INFO    ][32103] Completed state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 09:45:21.661387 duration_in_ms=52.47
2017-11-20 09:45:21,662 [salt.state       ][INFO    ][32103] Running state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 09:45:21.661996
2017-11-20 09:45:21,662 [salt.state       ][INFO    ][32103] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-11-20 09:45:21,663 [salt.loaded.int.module.cmdmod][INFO    ][32103] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-11-20 09:45:21,716 [salt.state       ][INFO    ][32103] unless execution succeeded
2017-11-20 09:45:21,717 [salt.state       ][INFO    ][32103] Completed state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 09:45:21.716603 duration_in_ms=54.606
2017-11-20 09:45:21,717 [salt.state       ][INFO    ][32103] Running state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 09:45:21.717150
2017-11-20 09:45:21,717 [salt.state       ][INFO    ][32103] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'
2017-11-20 09:45:21,718 [salt.loaded.int.module.cmdmod][INFO    ][32103] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-11-20 09:45:21,769 [salt.state       ][INFO    ][32103] unless execution succeeded
2017-11-20 09:45:21,769 [salt.state       ][INFO    ][32103] Completed state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 09:45:21.768747 duration_in_ms=51.597
2017-11-20 09:45:21,769 [salt.state       ][INFO    ][32103] Running state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 09:45:21.769326
2017-11-20 09:45:21,770 [salt.state       ][INFO    ][32103] Executing state cmd.run for gluster volume set 'keystone-keys' 'nfs.disable' 'True'
2017-11-20 09:45:21,770 [salt.loaded.int.module.cmdmod][INFO    ][32103] Executing command 'gluster volume info 'keystone-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-11-20 09:45:21,822 [salt.state       ][INFO    ][32103] unless execution succeeded
2017-11-20 09:45:21,822 [salt.state       ][INFO    ][32103] Completed state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 09:45:21.821849 duration_in_ms=52.523
2017-11-20 09:45:21,822 [salt.state       ][INFO    ][32103] Running state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 09:45:21.822376
2017-11-20 09:45:21,823 [salt.state       ][INFO    ][32103] Executing state cmd.run for gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'
2017-11-20 09:45:21,823 [salt.loaded.int.module.cmdmod][INFO    ][32103] Executing command 'gluster volume info 'keystone-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-11-20 09:45:21,875 [salt.state       ][INFO    ][32103] unless execution succeeded
2017-11-20 09:45:21,875 [salt.state       ][INFO    ][32103] Completed state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 09:45:21.875285 duration_in_ms=52.907
2017-11-20 09:45:21,877 [salt.state       ][INFO    ][32103] Running state [keystone-keys] at time 09:45:21.876615
2017-11-20 09:45:21,877 [salt.state       ][INFO    ][32103] Executing state glusterfs.started for keystone-keys
2017-11-20 09:45:21,877 [salt.loaded.int.module.cmdmod][INFO    ][32103] Executing command 'gluster --version' in directory '/root'
2017-11-20 09:45:21,884 [salt.loaded.int.module.cmdmod][INFO    ][32103] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-20 09:45:21,937 [salt.loaded.int.module.cmdmod][INFO    ][32103] Executing command 'gluster --version' in directory '/root'
2017-11-20 09:45:21,944 [salt.loaded.int.module.cmdmod][INFO    ][32103] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-20 09:45:22,001 [salt.state       ][INFO    ][32103] Volume keystone-keys is already started
2017-11-20 09:45:22,001 [salt.state       ][INFO    ][32103] Completed state [keystone-keys] at time 09:45:22.001356 duration_in_ms=124.74
2017-11-20 09:45:22,003 [salt.state       ][INFO    ][32103] Running state [nova_instances] at time 09:45:22.002936
2017-11-20 09:45:22,003 [salt.state       ][INFO    ][32103] Executing state glusterfs.created for nova_instances
2017-11-20 09:45:22,004 [salt.loaded.int.module.cmdmod][INFO    ][32103] Executing command 'gluster --version' in directory '/root'
2017-11-20 09:45:22,012 [salt.loaded.int.module.cmdmod][INFO    ][32103] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-20 09:45:22,065 [salt.loaded.int.module.cmdmod][INFO    ][32103] Executing command 'gluster --version' in directory '/root'
2017-11-20 09:45:22,073 [salt.loaded.int.module.cmdmod][INFO    ][32103] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-20 09:45:22,132 [salt.state       ][INFO    ][32103] Volume nova_instances already exists and is started.
2017-11-20 09:45:22,132 [salt.state       ][INFO    ][32103] Completed state [nova_instances] at time 09:45:22.131729 duration_in_ms=128.793
2017-11-20 09:45:22,135 [salt.state       ][INFO    ][32103] Running state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 09:45:22.135458
2017-11-20 09:45:22,136 [salt.state       ][INFO    ][32103] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'
2017-11-20 09:45:22,136 [salt.loaded.int.module.cmdmod][INFO    ][32103] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-11-20 09:45:22,189 [salt.state       ][INFO    ][32103] unless execution succeeded
2017-11-20 09:45:22,189 [salt.state       ][INFO    ][32103] Completed state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 09:45:22.188820 duration_in_ms=53.361
2017-11-20 09:45:22,189 [salt.state       ][INFO    ][32103] Running state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'On'] at time 09:45:22.189449
2017-11-20 09:45:22,190 [salt.state       ][INFO    ][32103] Executing state cmd.run for gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'On'
2017-11-20 09:45:22,190 [salt.loaded.int.module.cmdmod][INFO    ][32103] Executing command 'gluster volume info 'nova_instances' | grep 'cluster.readdir-optimize: On'' in directory '/root'
2017-11-20 09:45:22,247 [salt.state       ][INFO    ][32103] unless execution succeeded
2017-11-20 09:45:22,247 [salt.state       ][INFO    ][32103] Completed state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'On'] at time 09:45:22.246868 duration_in_ms=57.419
2017-11-20 09:45:22,248 [salt.state       ][INFO    ][32103] Running state [gluster volume set 'nova_instances' 'network.remote-dio' 'On'] at time 09:45:22.247473
2017-11-20 09:45:22,248 [salt.state       ][INFO    ][32103] Executing state cmd.run for gluster volume set 'nova_instances' 'network.remote-dio' 'On'
2017-11-20 09:45:22,248 [salt.loaded.int.module.cmdmod][INFO    ][32103] Executing command 'gluster volume info 'nova_instances' | grep 'network.remote-dio: On'' in directory '/root'
2017-11-20 09:45:22,299 [salt.state       ][INFO    ][32103] unless execution succeeded
2017-11-20 09:45:22,299 [salt.state       ][INFO    ][32103] Completed state [gluster volume set 'nova_instances' 'network.remote-dio' 'On'] at time 09:45:22.298770 duration_in_ms=51.297
2017-11-20 09:45:22,299 [salt.state       ][INFO    ][32103] Running state [gluster volume set 'nova_instances' 'nfs.disable' 'On'] at time 09:45:22.299375
2017-11-20 09:45:22,300 [salt.state       ][INFO    ][32103] Executing state cmd.run for gluster volume set 'nova_instances' 'nfs.disable' 'On'
2017-11-20 09:45:22,300 [salt.loaded.int.module.cmdmod][INFO    ][32103] Executing command 'gluster volume info 'nova_instances' | grep 'nfs.disable: On'' in directory '/root'
2017-11-20 09:45:22,350 [salt.state       ][INFO    ][32103] unless execution succeeded
2017-11-20 09:45:22,350 [salt.state       ][INFO    ][32103] Completed state [gluster volume set 'nova_instances' 'nfs.disable' 'On'] at time 09:45:22.350369 duration_in_ms=50.993
2017-11-20 09:45:22,351 [salt.state       ][INFO    ][32103] Running state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 09:45:22.350961
2017-11-20 09:45:22,351 [salt.state       ][INFO    ][32103] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'
2017-11-20 09:45:22,352 [salt.loaded.int.module.cmdmod][INFO    ][32103] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-11-20 09:45:22,402 [salt.state       ][INFO    ][32103] unless execution succeeded
2017-11-20 09:45:22,402 [salt.state       ][INFO    ][32103] Completed state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 09:45:22.402237 duration_in_ms=51.275
2017-11-20 09:45:22,404 [salt.state       ][INFO    ][32103] Running state [nova_instances] at time 09:45:22.403600
2017-11-20 09:45:22,404 [salt.state       ][INFO    ][32103] Executing state glusterfs.started for nova_instances
2017-11-20 09:45:22,404 [salt.loaded.int.module.cmdmod][INFO    ][32103] Executing command 'gluster --version' in directory '/root'
2017-11-20 09:45:22,411 [salt.loaded.int.module.cmdmod][INFO    ][32103] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-20 09:45:22,462 [salt.loaded.int.module.cmdmod][INFO    ][32103] Executing command 'gluster --version' in directory '/root'
2017-11-20 09:45:22,468 [salt.loaded.int.module.cmdmod][INFO    ][32103] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-20 09:45:22,526 [salt.state       ][INFO    ][32103] Volume nova_instances is already started
2017-11-20 09:45:22,526 [salt.state       ][INFO    ][32103] Completed state [nova_instances] at time 09:45:22.526272 duration_in_ms=122.672
2017-11-20 09:45:22,528 [salt.state       ][INFO    ][32103] Running state [keystone-credential-keys] at time 09:45:22.527589
2017-11-20 09:45:22,528 [salt.state       ][INFO    ][32103] Executing state glusterfs.created for keystone-credential-keys
2017-11-20 09:45:22,528 [salt.loaded.int.module.cmdmod][INFO    ][32103] Executing command 'gluster --version' in directory '/root'
2017-11-20 09:45:22,536 [salt.loaded.int.module.cmdmod][INFO    ][32103] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-20 09:45:22,588 [salt.loaded.int.module.cmdmod][INFO    ][32103] Executing command 'gluster --version' in directory '/root'
2017-11-20 09:45:22,596 [salt.loaded.int.module.cmdmod][INFO    ][32103] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-20 09:45:22,655 [salt.state       ][INFO    ][32103] Volume keystone-credential-keys already exists and is started.
2017-11-20 09:45:22,656 [salt.state       ][INFO    ][32103] Completed state [keystone-credential-keys] at time 09:45:22.655697 duration_in_ms=128.107
2017-11-20 09:45:22,660 [salt.state       ][INFO    ][32103] Running state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 09:45:22.659641
2017-11-20 09:45:22,660 [salt.state       ][INFO    ][32103] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'
2017-11-20 09:45:22,660 [salt.loaded.int.module.cmdmod][INFO    ][32103] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-11-20 09:45:22,712 [salt.state       ][INFO    ][32103] unless execution succeeded
2017-11-20 09:45:22,713 [salt.state       ][INFO    ][32103] Completed state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 09:45:22.712617 duration_in_ms=52.976
2017-11-20 09:45:22,713 [salt.state       ][INFO    ][32103] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 09:45:22.713251
2017-11-20 09:45:22,714 [salt.state       ][INFO    ][32103] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-11-20 09:45:22,714 [salt.loaded.int.module.cmdmod][INFO    ][32103] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-11-20 09:45:22,766 [salt.state       ][INFO    ][32103] unless execution succeeded
2017-11-20 09:45:22,766 [salt.state       ][INFO    ][32103] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 09:45:22.765784 duration_in_ms=52.533
2017-11-20 09:45:22,766 [salt.state       ][INFO    ][32103] Running state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 09:45:22.766341
2017-11-20 09:45:22,767 [salt.state       ][INFO    ][32103] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'
2017-11-20 09:45:22,767 [salt.loaded.int.module.cmdmod][INFO    ][32103] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-11-20 09:45:22,819 [salt.state       ][INFO    ][32103] unless execution succeeded
2017-11-20 09:45:22,820 [salt.state       ][INFO    ][32103] Completed state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 09:45:22.819505 duration_in_ms=53.164
2017-11-20 09:45:22,820 [salt.state       ][INFO    ][32103] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 09:45:22.820036
2017-11-20 09:45:22,820 [salt.state       ][INFO    ][32103] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'
2017-11-20 09:45:22,821 [salt.loaded.int.module.cmdmod][INFO    ][32103] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-11-20 09:45:22,873 [salt.state       ][INFO    ][32103] unless execution succeeded
2017-11-20 09:45:22,873 [salt.state       ][INFO    ][32103] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 09:45:22.873420 duration_in_ms=53.384
2017-11-20 09:45:22,874 [salt.state       ][INFO    ][32103] Running state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 09:45:22.874101
2017-11-20 09:45:22,874 [salt.state       ][INFO    ][32103] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'
2017-11-20 09:45:22,875 [salt.loaded.int.module.cmdmod][INFO    ][32103] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-11-20 09:45:22,927 [salt.state       ][INFO    ][32103] unless execution succeeded
2017-11-20 09:45:22,928 [salt.state       ][INFO    ][32103] Completed state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 09:45:22.927643 duration_in_ms=53.542
2017-11-20 09:45:22,929 [salt.state       ][INFO    ][32103] Running state [keystone-credential-keys] at time 09:45:22.928937
2017-11-20 09:45:22,929 [salt.state       ][INFO    ][32103] Executing state glusterfs.started for keystone-credential-keys
2017-11-20 09:45:22,930 [salt.loaded.int.module.cmdmod][INFO    ][32103] Executing command 'gluster --version' in directory '/root'
2017-11-20 09:45:22,937 [salt.loaded.int.module.cmdmod][INFO    ][32103] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-20 09:45:22,989 [salt.loaded.int.module.cmdmod][INFO    ][32103] Executing command 'gluster --version' in directory '/root'
2017-11-20 09:45:22,995 [salt.loaded.int.module.cmdmod][INFO    ][32103] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-20 09:45:23,054 [salt.state       ][INFO    ][32103] Volume keystone-credential-keys is already started
2017-11-20 09:45:23,054 [salt.state       ][INFO    ][32103] Completed state [keystone-credential-keys] at time 09:45:23.054297 duration_in_ms=125.36
2017-11-20 09:45:23,056 [salt.minion      ][INFO    ][32103] Returning information for job: 20171120094516521815
2017-11-20 09:45:28,613 [salt.minion      ][INFO    ][24842] User sudo_ubuntu Executing command test.ping with jid 20171120094528599279
2017-11-20 09:45:28,625 [salt.minion      ][INFO    ][32530] Starting a new job with PID 32530
2017-11-20 09:45:28,659 [salt.minion      ][INFO    ][32530] Returning information for job: 20171120094528599279
2017-11-20 09:45:29,158 [salt.minion      ][INFO    ][24842] User sudo_ubuntu Executing command cmd.run with jid 20171120094529147190
2017-11-20 09:45:29,167 [salt.minion      ][INFO    ][32535] Starting a new job with PID 32535
2017-11-20 09:45:29,171 [salt.loaded.int.module.cmdmod][INFO    ][32535] Executing command 'gluster peer status; gluster volume status' in directory '/root'
2017-11-20 09:45:29,290 [salt.minion      ][INFO    ][32535] Returning information for job: 20171120094529147190
2017-11-20 10:26:18,192 [salt.minion      ][INFO    ][24842] User sudo_ubuntu Executing command test.ping with jid 20171120102618182232
2017-11-20 10:26:18,207 [salt.minion      ][INFO    ][33364] Starting a new job with PID 33364
2017-11-20 10:26:18,249 [salt.minion      ][INFO    ][33364] Returning information for job: 20171120102618182232
2017-11-20 10:26:23,924 [salt.minion      ][INFO    ][24842] User sudo_ubuntu Executing command state.sls with jid 20171120102623914983
2017-11-20 10:26:23,936 [salt.minion      ][INFO    ][33371] Starting a new job with PID 33371
2017-11-20 10:26:25,020 [salt.state       ][INFO    ][33371] Loading fresh modules for state activity
2017-11-20 10:26:25,050 [salt.fileclient  ][INFO    ][33371] Fetching file from saltenv 'base', ** done ** 'keepalived/init.sls'
2017-11-20 10:26:25,069 [salt.fileclient  ][INFO    ][33371] Fetching file from saltenv 'base', ** done ** 'keepalived/cluster.sls'
2017-11-20 10:26:25,094 [salt.fileclient  ][INFO    ][33371] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-11-20 10:26:25,400 [salt.state       ][INFO    ][33371] Running state [lsof] at time 10:26:25.399625
2017-11-20 10:26:25,400 [salt.state       ][INFO    ][33371] Executing state pkg.installed for lsof
2017-11-20 10:26:25,400 [salt.loaded.int.module.cmdmod][INFO    ][33371] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-20 10:26:25,678 [salt.state       ][INFO    ][33371] Package lsof is already installed
2017-11-20 10:26:25,678 [salt.state       ][INFO    ][33371] Completed state [lsof] at time 10:26:25.678231 duration_in_ms=278.606
2017-11-20 10:26:25,679 [salt.state       ][INFO    ][33371] Running state [keepalived] at time 10:26:25.678500
2017-11-20 10:26:25,679 [salt.state       ][INFO    ][33371] Executing state pkg.installed for keepalived
2017-11-20 10:26:25,683 [salt.state       ][INFO    ][33371] Package keepalived is already installed
2017-11-20 10:26:25,683 [salt.state       ][INFO    ][33371] Completed state [keepalived] at time 10:26:25.682703 duration_in_ms=4.203
2017-11-20 10:26:25,684 [salt.state       ][INFO    ][33371] Running state [/etc/keepalived/keepalived.conf] at time 10:26:25.684245
2017-11-20 10:26:25,684 [salt.state       ][INFO    ][33371] Executing state file.managed for /etc/keepalived/keepalived.conf
2017-11-20 10:26:25,706 [salt.fileclient  ][INFO    ][33371] Fetching file from saltenv 'base', ** done ** 'keepalived/files/keepalived.conf'
2017-11-20 10:26:25,745 [salt.fileclient  ][INFO    ][33371] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-11-20 10:26:25,751 [salt.state       ][INFO    ][33371] File /etc/keepalived/keepalived.conf is in the correct state
2017-11-20 10:26:25,751 [salt.state       ][INFO    ][33371] Completed state [/etc/keepalived/keepalived.conf] at time 10:26:25.750793 duration_in_ms=66.548
2017-11-20 10:26:25,751 [salt.state       ][INFO    ][33371] Running state [keepalived] at time 10:26:25.751461
2017-11-20 10:26:25,752 [salt.state       ][INFO    ][33371] Executing state service.running for keepalived
2017-11-20 10:26:25,752 [salt.loaded.int.module.cmdmod][INFO    ][33371] Executing command ['systemctl', 'status', 'keepalived.service', '-n', '0'] in directory '/root'
2017-11-20 10:26:25,769 [salt.loaded.int.module.cmdmod][INFO    ][33371] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2017-11-20 10:26:25,778 [salt.loaded.int.module.cmdmod][INFO    ][33371] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-11-20 10:26:25,786 [salt.state       ][INFO    ][33371] The service keepalived is already running
2017-11-20 10:26:25,786 [salt.state       ][INFO    ][33371] Completed state [keepalived] at time 10:26:25.786404 duration_in_ms=34.942
2017-11-20 10:26:25,788 [salt.minion      ][INFO    ][33371] Returning information for job: 20171120102623914983
2017-11-20 10:26:52,351 [salt.utils.schedule][INFO    ][24842] Running scheduled job: __mine_interval
2017-11-20 10:27:00,678 [salt.minion      ][INFO    ][24842] User sudo_ubuntu Executing command pillar.get with jid 20171120102700671330
2017-11-20 10:27:00,692 [salt.minion      ][INFO    ][33420] Starting a new job with PID 33420
2017-11-20 10:27:00,696 [salt.minion      ][INFO    ][33420] Returning information for job: 20171120102700671330
2017-11-20 10:27:51,158 [salt.minion      ][INFO    ][24842] User sudo_ubuntu Executing command state.sls with jid 20171120102751145412
2017-11-20 10:27:51,169 [salt.minion      ][INFO    ][33435] Starting a new job with PID 33435
2017-11-20 10:27:53,787 [salt.state       ][INFO    ][33435] Loading fresh modules for state activity
2017-11-20 10:27:53,814 [salt.fileclient  ][INFO    ][33435] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-11-20 10:27:53,838 [salt.fileclient  ][INFO    ][33435] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-11-20 10:27:54,155 [salt.state       ][INFO    ][33435] Running state [attr] at time 10:27:54.154522
2017-11-20 10:27:54,155 [salt.state       ][INFO    ][33435] Executing state pkg.installed for attr
2017-11-20 10:27:54,155 [salt.loaded.int.module.cmdmod][INFO    ][33435] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-20 10:27:54,480 [salt.state       ][INFO    ][33435] Package attr is already installed
2017-11-20 10:27:54,481 [salt.state       ][INFO    ][33435] Completed state [attr] at time 10:27:54.480722 duration_in_ms=326.201
2017-11-20 10:27:54,481 [salt.state       ][INFO    ][33435] Running state [glusterfs-server] at time 10:27:54.480981
2017-11-20 10:27:54,481 [salt.state       ][INFO    ][33435] Executing state pkg.installed for glusterfs-server
2017-11-20 10:27:54,485 [salt.state       ][INFO    ][33435] Package glusterfs-server is already installed
2017-11-20 10:27:54,485 [salt.state       ][INFO    ][33435] Completed state [glusterfs-server] at time 10:27:54.485060 duration_in_ms=4.079
2017-11-20 10:27:54,485 [salt.state       ][INFO    ][33435] Running state [bc] at time 10:27:54.485243
2017-11-20 10:27:54,485 [salt.state       ][INFO    ][33435] Executing state pkg.installed for bc
2017-11-20 10:27:54,489 [salt.state       ][INFO    ][33435] Package bc is already installed
2017-11-20 10:27:54,489 [salt.state       ][INFO    ][33435] Completed state [bc] at time 10:27:54.489222 duration_in_ms=3.98
2017-11-20 10:27:54,490 [salt.state       ][INFO    ][33435] Running state [glusterfs-server] at time 10:27:54.490007
2017-11-20 10:27:54,490 [salt.state       ][INFO    ][33435] Executing state service.running for glusterfs-server
2017-11-20 10:27:54,491 [salt.loaded.int.module.cmdmod][INFO    ][33435] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-11-20 10:27:54,506 [salt.loaded.int.module.cmdmod][INFO    ][33435] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-11-20 10:27:54,513 [salt.loaded.int.module.cmdmod][INFO    ][33435] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-11-20 10:27:54,522 [salt.state       ][INFO    ][33435] The service glusterfs-server is already running
2017-11-20 10:27:54,522 [salt.state       ][INFO    ][33435] Completed state [glusterfs-server] at time 10:27:54.522273 duration_in_ms=32.266
2017-11-20 10:27:54,524 [salt.state       ][INFO    ][33435] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 10:27:54.523909
2017-11-20 10:27:54,524 [salt.state       ][INFO    ][33435] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-11-20 10:27:54,526 [salt.state       ][INFO    ][33435] File /etc/systemd/system/glusterfs-server.service.d/override.conf is in the correct state
2017-11-20 10:27:54,526 [salt.state       ][INFO    ][33435] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 10:27:54.526384 duration_in_ms=2.475
2017-11-20 10:27:54,527 [salt.state       ][INFO    ][33435] Running state [/srv/glusterfs/glance] at time 10:27:54.526557
2017-11-20 10:27:54,527 [salt.state       ][INFO    ][33435] Executing state file.directory for /srv/glusterfs/glance
2017-11-20 10:27:54,527 [salt.state       ][INFO    ][33435] Directory /srv/glusterfs/glance is in the correct state
2017-11-20 10:27:54,527 [salt.state       ][INFO    ][33435] Completed state [/srv/glusterfs/glance] at time 10:27:54.527295 duration_in_ms=0.738
2017-11-20 10:27:54,527 [salt.state       ][INFO    ][33435] Running state [/srv/glusterfs/keystone-keys] at time 10:27:54.527469
2017-11-20 10:27:54,528 [salt.state       ][INFO    ][33435] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-11-20 10:27:54,528 [salt.state       ][INFO    ][33435] Directory /srv/glusterfs/keystone-keys is in the correct state
2017-11-20 10:27:54,528 [salt.state       ][INFO    ][33435] Completed state [/srv/glusterfs/keystone-keys] at time 10:27:54.528173 duration_in_ms=0.704
2017-11-20 10:27:54,528 [salt.state       ][INFO    ][33435] Running state [/srv/glusterfs/nova_instances] at time 10:27:54.528348
2017-11-20 10:27:54,529 [salt.state       ][INFO    ][33435] Executing state file.directory for /srv/glusterfs/nova_instances
2017-11-20 10:27:54,529 [salt.state       ][INFO    ][33435] Directory /srv/glusterfs/nova_instances is in the correct state
2017-11-20 10:27:54,529 [salt.state       ][INFO    ][33435] Completed state [/srv/glusterfs/nova_instances] at time 10:27:54.529023 duration_in_ms=0.676
2017-11-20 10:27:54,529 [salt.state       ][INFO    ][33435] Running state [/srv/glusterfs/keystone-credential-keys] at time 10:27:54.529183
2017-11-20 10:27:54,529 [salt.state       ][INFO    ][33435] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-11-20 10:27:54,530 [salt.state       ][INFO    ][33435] Directory /srv/glusterfs/keystone-credential-keys is in the correct state
2017-11-20 10:27:54,530 [salt.state       ][INFO    ][33435] Completed state [/srv/glusterfs/keystone-credential-keys] at time 10:27:54.529894 duration_in_ms=0.711
2017-11-20 10:27:54,531 [salt.minion      ][INFO    ][33435] Returning information for job: 20171120102751145412
2017-11-20 10:27:55,804 [salt.minion      ][INFO    ][24842] User sudo_ubuntu Executing command test.ping with jid 20171120102755796295
2017-11-20 10:27:55,814 [salt.minion      ][INFO    ][33459] Starting a new job with PID 33459
2017-11-20 10:27:55,849 [salt.minion      ][INFO    ][33459] Returning information for job: 20171120102755796295
2017-11-20 10:28:02,900 [salt.minion      ][INFO    ][24842] User sudo_ubuntu Executing command state.sls with jid 20171120102802890636
2017-11-20 10:28:02,911 [salt.minion      ][INFO    ][33466] Starting a new job with PID 33466
2017-11-20 10:28:03,995 [salt.state       ][INFO    ][33466] Loading fresh modules for state activity
2017-11-20 10:28:04,019 [salt.fileclient  ][INFO    ][33466] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/setup.sls'
2017-11-20 10:28:04,056 [salt.fileclient  ][INFO    ][33466] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-11-20 10:28:04,133 [salt.fileclient  ][INFO    ][33466] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-11-20 10:28:04,152 [salt.fileclient  ][INFO    ][33466] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-11-20 10:28:04,457 [salt.state       ][INFO    ][33466] Running state [attr] at time 10:28:04.456592
2017-11-20 10:28:04,457 [salt.state       ][INFO    ][33466] Executing state pkg.installed for attr
2017-11-20 10:28:04,457 [salt.loaded.int.module.cmdmod][INFO    ][33466] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-20 10:28:04,718 [salt.state       ][INFO    ][33466] Package attr is already installed
2017-11-20 10:28:04,719 [salt.state       ][INFO    ][33466] Completed state [attr] at time 10:28:04.718632 duration_in_ms=262.049
2017-11-20 10:28:04,719 [salt.state       ][INFO    ][33466] Running state [glusterfs-server] at time 10:28:04.718887
2017-11-20 10:28:04,719 [salt.state       ][INFO    ][33466] Executing state pkg.installed for glusterfs-server
2017-11-20 10:28:04,723 [salt.state       ][INFO    ][33466] Package glusterfs-server is already installed
2017-11-20 10:28:04,723 [salt.state       ][INFO    ][33466] Completed state [glusterfs-server] at time 10:28:04.722882 duration_in_ms=3.995
2017-11-20 10:28:04,723 [salt.state       ][INFO    ][33466] Running state [bc] at time 10:28:04.723063
2017-11-20 10:28:04,723 [salt.state       ][INFO    ][33466] Executing state pkg.installed for bc
2017-11-20 10:28:04,727 [salt.state       ][INFO    ][33466] Package bc is already installed
2017-11-20 10:28:04,727 [salt.state       ][INFO    ][33466] Completed state [bc] at time 10:28:04.726940 duration_in_ms=3.877
2017-11-20 10:28:04,728 [salt.state       ][INFO    ][33466] Running state [glusterfs-server] at time 10:28:04.727919
2017-11-20 10:28:04,728 [salt.state       ][INFO    ][33466] Executing state service.running for glusterfs-server
2017-11-20 10:28:04,729 [salt.loaded.int.module.cmdmod][INFO    ][33466] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-11-20 10:28:04,745 [salt.loaded.int.module.cmdmod][INFO    ][33466] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-11-20 10:28:04,753 [salt.loaded.int.module.cmdmod][INFO    ][33466] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-11-20 10:28:04,762 [salt.state       ][INFO    ][33466] The service glusterfs-server is already running
2017-11-20 10:28:04,763 [salt.state       ][INFO    ][33466] Completed state [glusterfs-server] at time 10:28:04.762680 duration_in_ms=34.76
2017-11-20 10:28:04,764 [salt.state       ][INFO    ][33466] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 10:28:04.764200
2017-11-20 10:28:04,764 [salt.state       ][INFO    ][33466] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-11-20 10:28:04,766 [salt.state       ][INFO    ][33466] File /etc/systemd/system/glusterfs-server.service.d/override.conf is in the correct state
2017-11-20 10:28:04,766 [salt.state       ][INFO    ][33466] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 10:28:04.766397 duration_in_ms=2.197
2017-11-20 10:28:04,767 [salt.state       ][INFO    ][33466] Running state [/srv/glusterfs/glance] at time 10:28:04.766569
2017-11-20 10:28:04,767 [salt.state       ][INFO    ][33466] Executing state file.directory for /srv/glusterfs/glance
2017-11-20 10:28:04,767 [salt.state       ][INFO    ][33466] Directory /srv/glusterfs/glance is in the correct state
2017-11-20 10:28:04,767 [salt.state       ][INFO    ][33466] Completed state [/srv/glusterfs/glance] at time 10:28:04.767323 duration_in_ms=0.754
2017-11-20 10:28:04,768 [salt.state       ][INFO    ][33466] Running state [/srv/glusterfs/keystone-keys] at time 10:28:04.767490
2017-11-20 10:28:04,768 [salt.state       ][INFO    ][33466] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-11-20 10:28:04,768 [salt.state       ][INFO    ][33466] Directory /srv/glusterfs/keystone-keys is in the correct state
2017-11-20 10:28:04,768 [salt.state       ][INFO    ][33466] Completed state [/srv/glusterfs/keystone-keys] at time 10:28:04.768204 duration_in_ms=0.713
2017-11-20 10:28:04,768 [salt.state       ][INFO    ][33466] Running state [/srv/glusterfs/nova_instances] at time 10:28:04.768358
2017-11-20 10:28:04,769 [salt.state       ][INFO    ][33466] Executing state file.directory for /srv/glusterfs/nova_instances
2017-11-20 10:28:04,769 [salt.state       ][INFO    ][33466] Directory /srv/glusterfs/nova_instances is in the correct state
2017-11-20 10:28:04,769 [salt.state       ][INFO    ][33466] Completed state [/srv/glusterfs/nova_instances] at time 10:28:04.768995 duration_in_ms=0.636
2017-11-20 10:28:04,769 [salt.state       ][INFO    ][33466] Running state [/srv/glusterfs/keystone-credential-keys] at time 10:28:04.769161
2017-11-20 10:28:04,769 [salt.state       ][INFO    ][33466] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-11-20 10:28:04,770 [salt.state       ][INFO    ][33466] Directory /srv/glusterfs/keystone-credential-keys is in the correct state
2017-11-20 10:28:04,770 [salt.state       ][INFO    ][33466] Completed state [/srv/glusterfs/keystone-credential-keys] at time 10:28:04.769824 duration_in_ms=0.663
2017-11-20 10:28:04,812 [salt.loaded.int.module.cmdmod][INFO    ][33466] Executing command ['git', '--version'] in directory '/root'
2017-11-20 10:28:04,890 [salt.state       ][INFO    ][33466] Running state [sleep 5] at time 10:28:04.889703
2017-11-20 10:28:04,890 [salt.state       ][INFO    ][33466] Executing state cmd.wait for sleep 5
2017-11-20 10:28:04,890 [salt.state       ][INFO    ][33466] No changes made for sleep 5
2017-11-20 10:28:04,890 [salt.state       ][INFO    ][33466] Completed state [sleep 5] at time 10:28:04.890339 duration_in_ms=0.636
2017-11-20 10:28:04,891 [salt.state       ][INFO    ][33466] Running state [192.168.10.143] at time 10:28:04.890840
2017-11-20 10:28:04,891 [salt.state       ][INFO    ][33466] Executing state glusterfs.peered for 192.168.10.143
2017-11-20 10:28:04,891 [salt.loaded.int.module.cmdmod][INFO    ][33466] Executing command 'gluster --version' in directory '/root'
2017-11-20 10:28:04,900 [salt.loaded.int.module.cmdmod][INFO    ][33466] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-20 10:28:04,958 [salt.loaded.int.module.cmdmod][INFO    ][33466] Executing command 'gluster --version' in directory '/root'
2017-11-20 10:28:04,967 [salt.loaded.int.module.cmdmod][INFO    ][33466] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-20 10:28:05,022 [salt.loaded.int.module.cmdmod][INFO    ][33466] Executing command 'gluster --version' in directory '/root'
2017-11-20 10:28:05,030 [salt.loaded.int.module.cmdmod][INFO    ][33466] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-20 10:28:05,085 [salt.loaded.int.module.cmdmod][INFO    ][33466] Executing command 'gluster --version' in directory '/root'
2017-11-20 10:28:05,093 [salt.loaded.int.module.cmdmod][INFO    ][33466] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-20 10:28:05,147 [salt.state       ][INFO    ][33466] Peering with localhost is not needed
2017-11-20 10:28:05,148 [salt.state       ][INFO    ][33466] Completed state [192.168.10.143] at time 10:28:05.147454 duration_in_ms=256.614
2017-11-20 10:28:05,151 [salt.state       ][INFO    ][33466] Running state [192.168.10.142] at time 10:28:05.150850
2017-11-20 10:28:05,151 [salt.state       ][INFO    ][33466] Executing state glusterfs.peered for 192.168.10.142
2017-11-20 10:28:05,152 [salt.loaded.int.module.cmdmod][INFO    ][33466] Executing command 'gluster --version' in directory '/root'
2017-11-20 10:28:05,160 [salt.loaded.int.module.cmdmod][INFO    ][33466] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-20 10:28:05,213 [salt.state       ][INFO    ][33466] Host 192.168.10.142 already peered
2017-11-20 10:28:05,213 [salt.state       ][INFO    ][33466] Completed state [192.168.10.142] at time 10:28:05.212755 duration_in_ms=61.905
2017-11-20 10:28:05,216 [salt.state       ][INFO    ][33466] Running state [192.168.10.141] at time 10:28:05.215993
2017-11-20 10:28:05,216 [salt.state       ][INFO    ][33466] Executing state glusterfs.peered for 192.168.10.141
2017-11-20 10:28:05,217 [salt.loaded.int.module.cmdmod][INFO    ][33466] Executing command 'gluster --version' in directory '/root'
2017-11-20 10:28:05,225 [salt.loaded.int.module.cmdmod][INFO    ][33466] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-20 10:28:05,276 [salt.state       ][INFO    ][33466] Host 192.168.10.141 already peered
2017-11-20 10:28:05,276 [salt.state       ][INFO    ][33466] Completed state [192.168.10.141] at time 10:28:05.275943 duration_in_ms=59.95
2017-11-20 10:28:05,277 [salt.state       ][INFO    ][33466] Running state [glance] at time 10:28:05.276974
2017-11-20 10:28:05,277 [salt.state       ][INFO    ][33466] Executing state glusterfs.created for glance
2017-11-20 10:28:05,278 [salt.loaded.int.module.cmdmod][INFO    ][33466] Executing command 'gluster --version' in directory '/root'
2017-11-20 10:28:05,285 [salt.loaded.int.module.cmdmod][INFO    ][33466] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-20 10:28:05,337 [salt.loaded.int.module.cmdmod][INFO    ][33466] Executing command 'gluster --version' in directory '/root'
2017-11-20 10:28:05,344 [salt.loaded.int.module.cmdmod][INFO    ][33466] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-20 10:28:05,404 [salt.state       ][INFO    ][33466] Volume glance already exists and is started.
2017-11-20 10:28:05,405 [salt.state       ][INFO    ][33466] Completed state [glance] at time 10:28:05.404514 duration_in_ms=127.538
2017-11-20 10:28:05,408 [salt.state       ][INFO    ][33466] Running state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 10:28:05.408464
2017-11-20 10:28:05,409 [salt.state       ][INFO    ][33466] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'
2017-11-20 10:28:05,409 [salt.loaded.int.module.cmdmod][INFO    ][33466] Executing command 'gluster volume info 'glance' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-11-20 10:28:05,462 [salt.state       ][INFO    ][33466] unless execution succeeded
2017-11-20 10:28:05,463 [salt.state       ][INFO    ][33466] Completed state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 10:28:05.462680 duration_in_ms=54.215
2017-11-20 10:28:05,463 [salt.state       ][INFO    ][33466] Running state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 10:28:05.463208
2017-11-20 10:28:05,463 [salt.state       ][INFO    ][33466] Executing state cmd.run for gluster volume set 'glance' 'network.remote-dio' 'True'
2017-11-20 10:28:05,464 [salt.loaded.int.module.cmdmod][INFO    ][33466] Executing command 'gluster volume info 'glance' | grep 'network.remote-dio: True'' in directory '/root'
2017-11-20 10:28:05,515 [salt.state       ][INFO    ][33466] unless execution succeeded
2017-11-20 10:28:05,515 [salt.state       ][INFO    ][33466] Completed state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 10:28:05.514959 duration_in_ms=51.751
2017-11-20 10:28:05,516 [salt.state       ][INFO    ][33466] Running state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 10:28:05.515537
2017-11-20 10:28:05,516 [salt.state       ][INFO    ][33466] Executing state cmd.run for gluster volume set 'glance' 'nfs.disable' 'True'
2017-11-20 10:28:05,516 [salt.loaded.int.module.cmdmod][INFO    ][33466] Executing command 'gluster volume info 'glance' | grep 'nfs.disable: True'' in directory '/root'
2017-11-20 10:28:05,568 [salt.state       ][INFO    ][33466] unless execution succeeded
2017-11-20 10:28:05,568 [salt.state       ][INFO    ][33466] Completed state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 10:28:05.568209 duration_in_ms=52.672
2017-11-20 10:28:05,569 [salt.state       ][INFO    ][33466] Running state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 10:28:05.568819
2017-11-20 10:28:05,569 [salt.state       ][INFO    ][33466] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'
2017-11-20 10:28:05,570 [salt.loaded.int.module.cmdmod][INFO    ][33466] Executing command 'gluster volume info 'glance' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-11-20 10:28:05,620 [salt.state       ][INFO    ][33466] unless execution succeeded
2017-11-20 10:28:05,621 [salt.state       ][INFO    ][33466] Completed state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 10:28:05.620482 duration_in_ms=51.663
2017-11-20 10:28:05,621 [salt.state       ][INFO    ][33466] Running state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 10:28:05.621043
2017-11-20 10:28:05,621 [salt.state       ][INFO    ][33466] Executing state cmd.run for gluster volume set 'glance' 'cluster.readdir-optimize' 'True'
2017-11-20 10:28:05,622 [salt.loaded.int.module.cmdmod][INFO    ][33466] Executing command 'gluster volume info 'glance' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-11-20 10:28:05,678 [salt.state       ][INFO    ][33466] unless execution succeeded
2017-11-20 10:28:05,678 [salt.state       ][INFO    ][33466] Completed state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 10:28:05.678177 duration_in_ms=57.134
2017-11-20 10:28:05,679 [salt.state       ][INFO    ][33466] Running state [glance] at time 10:28:05.679456
2017-11-20 10:28:05,680 [salt.state       ][INFO    ][33466] Executing state glusterfs.started for glance
2017-11-20 10:28:05,680 [salt.loaded.int.module.cmdmod][INFO    ][33466] Executing command 'gluster --version' in directory '/root'
2017-11-20 10:28:05,689 [salt.loaded.int.module.cmdmod][INFO    ][33466] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-20 10:28:05,740 [salt.loaded.int.module.cmdmod][INFO    ][33466] Executing command 'gluster --version' in directory '/root'
2017-11-20 10:28:05,749 [salt.loaded.int.module.cmdmod][INFO    ][33466] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-20 10:28:05,809 [salt.state       ][INFO    ][33466] Volume glance is already started
2017-11-20 10:28:05,809 [salt.state       ][INFO    ][33466] Completed state [glance] at time 10:28:05.809012 duration_in_ms=129.556
2017-11-20 10:28:05,810 [salt.state       ][INFO    ][33466] Running state [keystone-keys] at time 10:28:05.809994
2017-11-20 10:28:05,810 [salt.state       ][INFO    ][33466] Executing state glusterfs.created for keystone-keys
2017-11-20 10:28:05,811 [salt.loaded.int.module.cmdmod][INFO    ][33466] Executing command 'gluster --version' in directory '/root'
2017-11-20 10:28:05,819 [salt.loaded.int.module.cmdmod][INFO    ][33466] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-20 10:28:05,873 [salt.loaded.int.module.cmdmod][INFO    ][33466] Executing command 'gluster --version' in directory '/root'
2017-11-20 10:28:05,881 [salt.loaded.int.module.cmdmod][INFO    ][33466] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-20 10:28:05,940 [salt.state       ][INFO    ][33466] Volume keystone-keys already exists and is started.
2017-11-20 10:28:05,940 [salt.state       ][INFO    ][33466] Completed state [keystone-keys] at time 10:28:05.940285 duration_in_ms=130.282
2017-11-20 10:28:05,944 [salt.state       ][INFO    ][33466] Running state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 10:28:05.943991
2017-11-20 10:28:05,944 [salt.state       ][INFO    ][33466] Executing state cmd.run for gluster volume set 'keystone-keys' 'network.remote-dio' 'True'
2017-11-20 10:28:05,945 [salt.loaded.int.module.cmdmod][INFO    ][33466] Executing command 'gluster volume info 'keystone-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-11-20 10:28:06,000 [salt.state       ][INFO    ][33466] unless execution succeeded
2017-11-20 10:28:06,000 [salt.state       ][INFO    ][33466] Completed state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 10:28:06.000323 duration_in_ms=56.332
2017-11-20 10:28:06,001 [salt.state       ][INFO    ][33466] Running state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 10:28:06.000923
2017-11-20 10:28:06,001 [salt.state       ][INFO    ][33466] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-11-20 10:28:06,002 [salt.loaded.int.module.cmdmod][INFO    ][33466] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-11-20 10:28:06,056 [salt.state       ][INFO    ][33466] unless execution succeeded
2017-11-20 10:28:06,056 [salt.state       ][INFO    ][33466] Completed state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 10:28:06.055837 duration_in_ms=54.913
2017-11-20 10:28:06,056 [salt.state       ][INFO    ][33466] Running state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 10:28:06.056441
2017-11-20 10:28:06,057 [salt.state       ][INFO    ][33466] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'
2017-11-20 10:28:06,057 [salt.loaded.int.module.cmdmod][INFO    ][33466] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-11-20 10:28:06,109 [salt.state       ][INFO    ][33466] unless execution succeeded
2017-11-20 10:28:06,109 [salt.state       ][INFO    ][33466] Completed state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 10:28:06.109172 duration_in_ms=52.731
2017-11-20 10:28:06,110 [salt.state       ][INFO    ][33466] Running state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 10:28:06.109801
2017-11-20 10:28:06,110 [salt.state       ][INFO    ][33466] Executing state cmd.run for gluster volume set 'keystone-keys' 'nfs.disable' 'True'
2017-11-20 10:28:06,111 [salt.loaded.int.module.cmdmod][INFO    ][33466] Executing command 'gluster volume info 'keystone-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-11-20 10:28:06,163 [salt.state       ][INFO    ][33466] unless execution succeeded
2017-11-20 10:28:06,164 [salt.state       ][INFO    ][33466] Completed state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 10:28:06.163704 duration_in_ms=53.902
2017-11-20 10:28:06,164 [salt.state       ][INFO    ][33466] Running state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 10:28:06.164296
2017-11-20 10:28:06,165 [salt.state       ][INFO    ][33466] Executing state cmd.run for gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'
2017-11-20 10:28:06,165 [salt.loaded.int.module.cmdmod][INFO    ][33466] Executing command 'gluster volume info 'keystone-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-11-20 10:28:06,221 [salt.state       ][INFO    ][33466] unless execution succeeded
2017-11-20 10:28:06,222 [salt.state       ][INFO    ][33466] Completed state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 10:28:06.221528 duration_in_ms=57.231
2017-11-20 10:28:06,223 [salt.state       ][INFO    ][33466] Running state [keystone-keys] at time 10:28:06.222761
2017-11-20 10:28:06,223 [salt.state       ][INFO    ][33466] Executing state glusterfs.started for keystone-keys
2017-11-20 10:28:06,224 [salt.loaded.int.module.cmdmod][INFO    ][33466] Executing command 'gluster --version' in directory '/root'
2017-11-20 10:28:06,230 [salt.loaded.int.module.cmdmod][INFO    ][33466] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-20 10:28:06,283 [salt.loaded.int.module.cmdmod][INFO    ][33466] Executing command 'gluster --version' in directory '/root'
2017-11-20 10:28:06,292 [salt.loaded.int.module.cmdmod][INFO    ][33466] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-20 10:28:06,351 [salt.state       ][INFO    ][33466] Volume keystone-keys is already started
2017-11-20 10:28:06,351 [salt.state       ][INFO    ][33466] Completed state [keystone-keys] at time 10:28:06.351314 duration_in_ms=128.552
2017-11-20 10:28:06,353 [salt.state       ][INFO    ][33466] Running state [nova_instances] at time 10:28:06.352684
2017-11-20 10:28:06,353 [salt.state       ][INFO    ][33466] Executing state glusterfs.created for nova_instances
2017-11-20 10:28:06,353 [salt.loaded.int.module.cmdmod][INFO    ][33466] Executing command 'gluster --version' in directory '/root'
2017-11-20 10:28:06,362 [salt.loaded.int.module.cmdmod][INFO    ][33466] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-20 10:28:06,417 [salt.loaded.int.module.cmdmod][INFO    ][33466] Executing command 'gluster --version' in directory '/root'
2017-11-20 10:28:06,426 [salt.loaded.int.module.cmdmod][INFO    ][33466] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-20 10:28:06,488 [salt.state       ][INFO    ][33466] Volume nova_instances already exists and is started.
2017-11-20 10:28:06,488 [salt.state       ][INFO    ][33466] Completed state [nova_instances] at time 10:28:06.488100 duration_in_ms=135.414
2017-11-20 10:28:06,493 [salt.state       ][INFO    ][33466] Running state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 10:28:06.492598
2017-11-20 10:28:06,493 [salt.state       ][INFO    ][33466] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'
2017-11-20 10:28:06,494 [salt.loaded.int.module.cmdmod][INFO    ][33466] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-11-20 10:28:06,546 [salt.state       ][INFO    ][33466] unless execution succeeded
2017-11-20 10:28:06,546 [salt.state       ][INFO    ][33466] Completed state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 10:28:06.545832 duration_in_ms=53.233
2017-11-20 10:28:06,546 [salt.state       ][INFO    ][33466] Running state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'On'] at time 10:28:06.546456
2017-11-20 10:28:06,547 [salt.state       ][INFO    ][33466] Executing state cmd.run for gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'On'
2017-11-20 10:28:06,547 [salt.loaded.int.module.cmdmod][INFO    ][33466] Executing command 'gluster volume info 'nova_instances' | grep 'cluster.readdir-optimize: On'' in directory '/root'
2017-11-20 10:28:06,599 [salt.state       ][INFO    ][33466] unless execution succeeded
2017-11-20 10:28:06,599 [salt.state       ][INFO    ][33466] Completed state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'On'] at time 10:28:06.599450 duration_in_ms=52.993
2017-11-20 10:28:06,600 [salt.state       ][INFO    ][33466] Running state [gluster volume set 'nova_instances' 'network.remote-dio' 'On'] at time 10:28:06.600096
2017-11-20 10:28:06,600 [salt.state       ][INFO    ][33466] Executing state cmd.run for gluster volume set 'nova_instances' 'network.remote-dio' 'On'
2017-11-20 10:28:06,601 [salt.loaded.int.module.cmdmod][INFO    ][33466] Executing command 'gluster volume info 'nova_instances' | grep 'network.remote-dio: On'' in directory '/root'
2017-11-20 10:28:06,651 [salt.state       ][INFO    ][33466] unless execution succeeded
2017-11-20 10:28:06,652 [salt.state       ][INFO    ][33466] Completed state [gluster volume set 'nova_instances' 'network.remote-dio' 'On'] at time 10:28:06.651662 duration_in_ms=51.565
2017-11-20 10:28:06,652 [salt.state       ][INFO    ][33466] Running state [gluster volume set 'nova_instances' 'nfs.disable' 'On'] at time 10:28:06.652284
2017-11-20 10:28:06,653 [salt.state       ][INFO    ][33466] Executing state cmd.run for gluster volume set 'nova_instances' 'nfs.disable' 'On'
2017-11-20 10:28:06,653 [salt.loaded.int.module.cmdmod][INFO    ][33466] Executing command 'gluster volume info 'nova_instances' | grep 'nfs.disable: On'' in directory '/root'
2017-11-20 10:28:06,708 [salt.state       ][INFO    ][33466] unless execution succeeded
2017-11-20 10:28:06,708 [salt.state       ][INFO    ][33466] Completed state [gluster volume set 'nova_instances' 'nfs.disable' 'On'] at time 10:28:06.708260 duration_in_ms=55.963
2017-11-20 10:28:06,709 [salt.state       ][INFO    ][33466] Running state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 10:28:06.708801
2017-11-20 10:28:06,709 [salt.state       ][INFO    ][33466] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'
2017-11-20 10:28:06,710 [salt.loaded.int.module.cmdmod][INFO    ][33466] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-11-20 10:28:06,762 [salt.state       ][INFO    ][33466] unless execution succeeded
2017-11-20 10:28:06,762 [salt.state       ][INFO    ][33466] Completed state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 10:28:06.762205 duration_in_ms=53.403
2017-11-20 10:28:06,763 [salt.state       ][INFO    ][33466] Running state [nova_instances] at time 10:28:06.763463
2017-11-20 10:28:06,764 [salt.state       ][INFO    ][33466] Executing state glusterfs.started for nova_instances
2017-11-20 10:28:06,764 [salt.loaded.int.module.cmdmod][INFO    ][33466] Executing command 'gluster --version' in directory '/root'
2017-11-20 10:28:06,773 [salt.loaded.int.module.cmdmod][INFO    ][33466] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-20 10:28:06,826 [salt.loaded.int.module.cmdmod][INFO    ][33466] Executing command 'gluster --version' in directory '/root'
2017-11-20 10:28:06,834 [salt.loaded.int.module.cmdmod][INFO    ][33466] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-20 10:28:06,891 [salt.state       ][INFO    ][33466] Volume nova_instances is already started
2017-11-20 10:28:06,892 [salt.state       ][INFO    ][33466] Completed state [nova_instances] at time 10:28:06.891617 duration_in_ms=128.153
2017-11-20 10:28:06,893 [salt.state       ][INFO    ][33466] Running state [keystone-credential-keys] at time 10:28:06.892717
2017-11-20 10:28:06,893 [salt.state       ][INFO    ][33466] Executing state glusterfs.created for keystone-credential-keys
2017-11-20 10:28:06,894 [salt.loaded.int.module.cmdmod][INFO    ][33466] Executing command 'gluster --version' in directory '/root'
2017-11-20 10:28:06,902 [salt.loaded.int.module.cmdmod][INFO    ][33466] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-20 10:28:06,956 [salt.loaded.int.module.cmdmod][INFO    ][33466] Executing command 'gluster --version' in directory '/root'
2017-11-20 10:28:06,965 [salt.loaded.int.module.cmdmod][INFO    ][33466] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-20 10:28:07,022 [salt.state       ][INFO    ][33466] Volume keystone-credential-keys already exists and is started.
2017-11-20 10:28:07,022 [salt.state       ][INFO    ][33466] Completed state [keystone-credential-keys] at time 10:28:07.022021 duration_in_ms=129.303
2017-11-20 10:28:07,026 [salt.state       ][INFO    ][33466] Running state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 10:28:07.026203
2017-11-20 10:28:07,027 [salt.state       ][INFO    ][33466] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'
2017-11-20 10:28:07,027 [salt.loaded.int.module.cmdmod][INFO    ][33466] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-11-20 10:28:07,080 [salt.state       ][INFO    ][33466] unless execution succeeded
2017-11-20 10:28:07,080 [salt.state       ][INFO    ][33466] Completed state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 10:28:07.080212 duration_in_ms=54.008
2017-11-20 10:28:07,081 [salt.state       ][INFO    ][33466] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 10:28:07.080844
2017-11-20 10:28:07,081 [salt.state       ][INFO    ][33466] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-11-20 10:28:07,082 [salt.loaded.int.module.cmdmod][INFO    ][33466] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-11-20 10:28:07,136 [salt.state       ][INFO    ][33466] unless execution succeeded
2017-11-20 10:28:07,136 [salt.state       ][INFO    ][33466] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 10:28:07.136187 duration_in_ms=55.342
2017-11-20 10:28:07,137 [salt.state       ][INFO    ][33466] Running state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 10:28:07.136725
2017-11-20 10:28:07,137 [salt.state       ][INFO    ][33466] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'
2017-11-20 10:28:07,137 [salt.loaded.int.module.cmdmod][INFO    ][33466] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-11-20 10:28:07,192 [salt.state       ][INFO    ][33466] unless execution succeeded
2017-11-20 10:28:07,193 [salt.state       ][INFO    ][33466] Completed state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 10:28:07.192574 duration_in_ms=55.848
2017-11-20 10:28:07,193 [salt.state       ][INFO    ][33466] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 10:28:07.193076
2017-11-20 10:28:07,193 [salt.state       ][INFO    ][33466] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'
2017-11-20 10:28:07,194 [salt.loaded.int.module.cmdmod][INFO    ][33466] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-11-20 10:28:07,248 [salt.state       ][INFO    ][33466] unless execution succeeded
2017-11-20 10:28:07,248 [salt.state       ][INFO    ][33466] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 10:28:07.247787 duration_in_ms=54.71
2017-11-20 10:28:07,248 [salt.state       ][INFO    ][33466] Running state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 10:28:07.248410
2017-11-20 10:28:07,249 [salt.state       ][INFO    ][33466] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'
2017-11-20 10:28:07,249 [salt.loaded.int.module.cmdmod][INFO    ][33466] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-11-20 10:28:07,303 [salt.state       ][INFO    ][33466] unless execution succeeded
2017-11-20 10:28:07,303 [salt.state       ][INFO    ][33466] Completed state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 10:28:07.302757 duration_in_ms=54.345
2017-11-20 10:28:07,304 [salt.state       ][INFO    ][33466] Running state [keystone-credential-keys] at time 10:28:07.304156
2017-11-20 10:28:07,304 [salt.state       ][INFO    ][33466] Executing state glusterfs.started for keystone-credential-keys
2017-11-20 10:28:07,305 [salt.loaded.int.module.cmdmod][INFO    ][33466] Executing command 'gluster --version' in directory '/root'
2017-11-20 10:28:07,313 [salt.loaded.int.module.cmdmod][INFO    ][33466] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-20 10:28:07,366 [salt.loaded.int.module.cmdmod][INFO    ][33466] Executing command 'gluster --version' in directory '/root'
2017-11-20 10:28:07,374 [salt.loaded.int.module.cmdmod][INFO    ][33466] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-20 10:28:07,434 [salt.state       ][INFO    ][33466] Volume keystone-credential-keys is already started
2017-11-20 10:28:07,434 [salt.state       ][INFO    ][33466] Completed state [keystone-credential-keys] at time 10:28:07.434203 duration_in_ms=130.047
2017-11-20 10:28:07,437 [salt.minion      ][INFO    ][33466] Returning information for job: 20171120102802890636
2017-11-20 10:28:12,629 [salt.minion      ][INFO    ][24842] User sudo_ubuntu Executing command test.ping with jid 20171120102812619198
2017-11-20 10:28:12,640 [salt.minion      ][INFO    ][33850] Starting a new job with PID 33850
2017-11-20 10:28:12,679 [salt.minion      ][INFO    ][33850] Returning information for job: 20171120102812619198
2017-11-20 10:28:13,208 [salt.minion      ][INFO    ][24842] User sudo_ubuntu Executing command cmd.run with jid 20171120102813186661
2017-11-20 10:28:13,219 [salt.minion      ][INFO    ][33855] Starting a new job with PID 33855
2017-11-20 10:28:13,223 [salt.loaded.int.module.cmdmod][INFO    ][33855] Executing command 'gluster peer status; gluster volume status' in directory '/root'
2017-11-20 10:28:13,349 [salt.minion      ][INFO    ][33855] Returning information for job: 20171120102813186661
2017-11-20 10:52:56,505 [salt.minion      ][INFO    ][24842] User sudo_ubuntu Executing command cp.push_dir with jid 20171120105256496788
2017-11-20 10:52:56,521 [salt.minion      ][INFO    ][34189] Starting a new job with PID 34189
