2017-10-27 19:37:17,691 [salt.cli.daemons ][WARNING ][2488] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-10-27 19:37:40,155 [salt.state       ][ERROR   ][3950] No contents found in top file
2017-10-27 19:39:36,016 [salt.utils.parsers][WARNING ][2488] Minion received a SIGTERM. Exiting.
2017-10-27 19:43:59,157 [salt.cli.daemons ][WARNING ][3574] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-10-27 19:45:54,934 [salt.loaded.int.module.cmdmod][ERROR   ][11710] Command 'virsh net-destroy default 2>&1 1>/dev/null; virsh net-undefine default' failed with return code: 1
2017-10-27 19:45:54,935 [salt.loaded.int.module.cmdmod][ERROR   ][11710] stderr: error: failed to get network 'default'
error: Network not found: no network with matching name 'default'
2017-10-27 19:45:54,935 [salt.loaded.int.module.cmdmod][ERROR   ][11710] retcode: 1
2017-10-27 19:45:54,935 [salt.state       ][ERROR   ][11710] {'pid': 16648, 'retcode': 1, 'stderr': "error: failed to get network 'default'\nerror: Network not found: no network with matching name 'default'", 'stdout': ''}
2017-10-27 19:46:21,934 [py.warnings      ][WARNING ][16725] /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-10-27 19:47:41,414 [salt.loaded.int.module.cmdmod][ERROR   ][16725] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-10-27 19:47:41,414 [salt.loaded.int.module.cmdmod][ERROR   ][16725] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-10-27 19:47:45,851 [salt.loaded.int.module.cmdmod][ERROR   ][16725] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-10-27 19:47:45,852 [salt.loaded.int.module.cmdmod][ERROR   ][16725] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-10-27 19:47:50,321 [salt.loaded.int.module.cmdmod][ERROR   ][16725] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-10-27 19:47:50,322 [salt.loaded.int.module.cmdmod][ERROR   ][16725] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-10-27 19:47:54,770 [salt.loaded.int.module.cmdmod][ERROR   ][16725] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-10-27 19:47:54,770 [salt.loaded.int.module.cmdmod][ERROR   ][16725] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-10-27 19:47:59,321 [salt.loaded.int.module.cmdmod][ERROR   ][16725] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-10-27 19:47:59,322 [salt.loaded.int.module.cmdmod][ERROR   ][16725] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-10-27 19:48:03,793 [salt.loaded.int.module.cmdmod][ERROR   ][16725] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-10-27 19:48:03,793 [salt.loaded.int.module.cmdmod][ERROR   ][16725] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-10-27 19:48:07,288 [salt.loaded.int.module.cmdmod][ERROR   ][16725] 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-10-27 19:48:10,821 [salt.state       ][ERROR   ][24908] No contents found in top file
2017-10-27 19:48:14,408 [salt.loaded.int.module.cmdmod][INFO    ][25183] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2017-10-27 19:48:14,415 [salt.loaded.int.module.cmdmod][INFO    ][25183] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2017-10-27 19:48:14,423 [salt.loaded.int.module.cmdmod][INFO    ][25183] Executing command ['systemd-run', '--scope', 'systemctl', 'restart', 'salt-minion.service'] in directory '/root'
2017-10-27 19:48:14,430 [salt.utils.parsers][WARNING ][3574] Minion received a SIGTERM. Exiting.
2017-10-27 19:48:14,736 [salt.cli.daemons ][INFO    ][25322] Setting up the Salt Minion "kvm03.baremetal-mcp-ocata-odl-ha.local"
2017-10-27 19:48:15,389 [salt.minion      ][INFO    ][25322] Creating minion process manager
2017-10-27 19:48:15,390 [salt.cli.daemons ][WARNING ][25322] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-10-27 19:48:15,390 [salt.cli.daemons ][INFO    ][25322] The Salt Minion is starting up
2017-10-27 19:48:15,390 [salt.minion      ][INFO    ][25322] Minion is starting as user 'root'
2017-10-27 19:48:15,391 [salt.utils.event ][INFO    ][25322] Starting pull socket on /var/run/salt/minion/minion_event_2d6d7b82d1_pull.ipc
2017-10-27 19:48:16,590 [salt.loaded.int.module.cmdmod][INFO    ][25322] Executing command ['date', '+%z'] in directory '/root'
2017-10-27 19:48:16,601 [salt.utils.schedule][INFO    ][25322] Updating job settings for scheduled job: __mine_interval
2017-10-27 19:48:16,605 [salt.minion      ][INFO    ][25322] Added mine.update to scheduler
2017-10-27 19:48:16,629 [salt.minion      ][INFO    ][25322] Minion is ready to receive requests!
2017-10-27 19:48:17,630 [salt.utils.schedule][INFO    ][25322] Running scheduled job: __mine_interval
2017-10-27 19:48:23,636 [salt.minion      ][INFO    ][25322] User sudo_ubuntu Executing command saltutil.find_job with jid 20171027194823628875
2017-10-27 19:48:23,646 [salt.minion      ][INFO    ][25446] Starting a new job with PID 25446
2017-10-27 19:48:23,653 [salt.minion      ][INFO    ][25446] Returning information for job: 20171027194823628875
2017-10-27 19:48:44,658 [salt.minion      ][INFO    ][25322] User sudo_ubuntu Executing command state.sls with jid 20171027194844647321
2017-10-27 19:48:44,669 [salt.minion      ][INFO    ][25451] Starting a new job with PID 25451
2017-10-27 19:48:47,294 [salt.state       ][INFO    ][25451] Loading fresh modules for state activity
2017-10-27 19:48:47,321 [salt.fileclient  ][INFO    ][25451] Fetching file from saltenv 'base', ** done ** 'salt/control/init.sls'
2017-10-27 19:48:47,340 [salt.fileclient  ][INFO    ][25451] Fetching file from saltenv 'base', ** done ** 'salt/control/virt.sls'
2017-10-27 19:48:47,376 [salt.fileclient  ][INFO    ][25451] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-10-27 19:48:47,532 [salt.fileclient  ][INFO    ][25451] Fetching file from saltenv 'base', ** done ** 'salt/minion/init.sls'
2017-10-27 19:48:47,549 [salt.fileclient  ][INFO    ][25451] Fetching file from saltenv 'base', ** done ** 'salt/minion/service.sls'
2017-10-27 19:48:47,584 [salt.fileclient  ][INFO    ][25451] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-10-27 19:48:47,647 [salt.fileclient  ][INFO    ][25451] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-10-27 19:48:47,669 [salt.fileclient  ][INFO    ][25451] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-10-27 19:48:47,724 [salt.fileclient  ][INFO    ][25451] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-10-27 19:48:47,744 [salt.fileclient  ][INFO    ][25451] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-10-27 19:48:47,761 [salt.fileclient  ][INFO    ][25451] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-10-27 19:48:47,776 [salt.fileclient  ][INFO    ][25451] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-10-27 19:48:47,786 [salt.loaded.int.module.cmdmod][INFO    ][25451] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-10-27 19:48:47,809 [salt.fileclient  ][INFO    ][25451] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-10-27 19:48:47,827 [py.warnings      ][WARNING ][25451] /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-10-27 19:48:47,827 [salt.loaded.int.module.cmdmod][INFO    ][25451] Executing command 'salt-minion --version' in directory '/root'
2017-10-27 19:48:48,087 [salt.fileclient  ][INFO    ][25451] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-10-27 19:48:48,109 [salt.fileclient  ][INFO    ][25451] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-10-27 19:48:48,122 [salt.fileclient  ][INFO    ][25451] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-10-27 19:48:48,136 [salt.fileclient  ][INFO    ][25451] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-10-27 19:48:48,193 [salt.fileclient  ][INFO    ][25451] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-10-27 19:48:48,249 [salt.fileclient  ][INFO    ][25451] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-10-27 19:48:48,321 [salt.fileclient  ][INFO    ][25451] Fetching file from saltenv 'base', ** done ** 'salt/minion/grains.sls'
2017-10-27 19:48:48,349 [salt.fileclient  ][INFO    ][25451] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-10-27 19:48:48,413 [salt.fileclient  ][INFO    ][25451] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-10-27 19:48:48,433 [salt.fileclient  ][INFO    ][25451] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-10-27 19:48:48,488 [salt.fileclient  ][INFO    ][25451] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-10-27 19:48:48,508 [salt.fileclient  ][INFO    ][25451] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-10-27 19:48:48,523 [salt.fileclient  ][INFO    ][25451] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-10-27 19:48:48,540 [salt.fileclient  ][INFO    ][25451] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-10-27 19:48:48,549 [salt.loaded.int.module.cmdmod][INFO    ][25451] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-10-27 19:48:48,573 [salt.fileclient  ][INFO    ][25451] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-10-27 19:48:48,593 [salt.loaded.int.module.cmdmod][INFO    ][25451] Executing command 'salt-minion --version' in directory '/root'
2017-10-27 19:48:48,848 [salt.fileclient  ][INFO    ][25451] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-10-27 19:48:48,871 [salt.fileclient  ][INFO    ][25451] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-10-27 19:48:48,886 [salt.fileclient  ][INFO    ][25451] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-10-27 19:48:48,900 [salt.fileclient  ][INFO    ][25451] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-10-27 19:48:48,953 [salt.fileclient  ][INFO    ][25451] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-10-27 19:48:48,993 [salt.fileclient  ][INFO    ][25451] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-10-27 19:48:49,072 [salt.fileclient  ][INFO    ][25451] Fetching file from saltenv 'base', ** done ** 'salt/minion/cert.sls'
2017-10-27 19:48:49,145 [salt.fileclient  ][INFO    ][25451] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-10-27 19:48:49,510 [salt.state       ][INFO    ][25451] Running state [salt-minion] at time 19:48:49.509966
2017-10-27 19:48:49,510 [salt.state       ][INFO    ][25451] Executing state pkg.installed for salt-minion
2017-10-27 19:48:49,511 [salt.loaded.int.module.cmdmod][INFO    ][25451] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-10-27 19:48:49,768 [salt.state       ][INFO    ][25451] Package salt-minion is already installed
2017-10-27 19:48:49,768 [salt.state       ][INFO    ][25451] Completed state [salt-minion] at time 19:48:49.768026 duration_in_ms=258.059
2017-10-27 19:48:49,768 [salt.state       ][INFO    ][25451] Running state [salt_minion_dependency_packages] at time 19:48:49.768313
2017-10-27 19:48:49,769 [salt.state       ][INFO    ][25451] Executing state pkg.installed for salt_minion_dependency_packages
2017-10-27 19:48:49,772 [salt.state       ][INFO    ][25451] All specified packages are already installed
2017-10-27 19:48:49,772 [salt.state       ][INFO    ][25451] Completed state [salt_minion_dependency_packages] at time 19:48:49.772427 duration_in_ms=4.113
2017-10-27 19:48:49,774 [salt.state       ][INFO    ][25451] Running state [/etc/salt/minion.d/minion.conf] at time 19:48:49.774021
2017-10-27 19:48:49,774 [salt.state       ][INFO    ][25451] Executing state file.managed for /etc/salt/minion.d/minion.conf
2017-10-27 19:48:49,799 [salt.fileclient  ][INFO    ][25451] Fetching file from saltenv 'base', ** done ** 'salt/files/minion.conf'
2017-10-27 19:48:49,858 [salt.fileclient  ][INFO    ][25451] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-10-27 19:48:49,912 [salt.fileclient  ][INFO    ][25451] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-10-27 19:48:49,958 [salt.state       ][INFO    ][25451] File /etc/salt/minion.d/minion.conf is in the correct state
2017-10-27 19:48:49,959 [salt.state       ][INFO    ][25451] Completed state [/etc/salt/minion.d/minion.conf] at time 19:48:49.958588 duration_in_ms=184.567
2017-10-27 19:48:49,959 [salt.state       ][INFO    ][25451] Running state [/etc/salt/minion.d/_virt.conf] at time 19:48:49.958970
2017-10-27 19:48:49,959 [salt.state       ][INFO    ][25451] Executing state file.managed for /etc/salt/minion.d/_virt.conf
2017-10-27 19:48:49,960 [salt.state       ][INFO    ][25451] File /etc/salt/minion.d/_virt.conf is in the correct state
2017-10-27 19:48:49,960 [salt.state       ][INFO    ][25451] Completed state [/etc/salt/minion.d/_virt.conf] at time 19:48:49.960037 duration_in_ms=1.067
2017-10-27 19:48:49,962 [salt.state       ][INFO    ][25451] Running state [salt-minion] at time 19:48:49.961665
2017-10-27 19:48:49,962 [salt.state       ][INFO    ][25451] Executing state service.running for salt-minion
2017-10-27 19:48:49,962 [salt.loaded.int.module.cmdmod][INFO    ][25451] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2017-10-27 19:48:49,977 [salt.loaded.int.module.cmdmod][INFO    ][25451] Executing command ['systemctl', 'is-active', 'salt-minion.service'] in directory '/root'
2017-10-27 19:48:49,985 [salt.loaded.int.module.cmdmod][INFO    ][25451] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2017-10-27 19:48:49,992 [salt.state       ][INFO    ][25451] The service salt-minion is already running
2017-10-27 19:48:49,993 [salt.state       ][INFO    ][25451] Completed state [salt-minion] at time 19:48:49.992464 duration_in_ms=30.799
2017-10-27 19:48:49,994 [salt.state       ][INFO    ][25451] Running state [/etc/salt/grains.d] at time 19:48:49.993981
2017-10-27 19:48:49,994 [salt.state       ][INFO    ][25451] Executing state file.directory for /etc/salt/grains.d
2017-10-27 19:48:49,995 [salt.state       ][INFO    ][25451] Directory /etc/salt/grains.d is in the correct state
2017-10-27 19:48:49,995 [salt.state       ][INFO    ][25451] Completed state [/etc/salt/grains.d] at time 19:48:49.994992 duration_in_ms=1.011
2017-10-27 19:48:49,996 [salt.state       ][INFO    ][25451] Running state [/etc/salt/grains] at time 19:48:49.995623
2017-10-27 19:48:49,996 [salt.state       ][INFO    ][25451] Executing state file.managed for /etc/salt/grains
2017-10-27 19:48:49,996 [salt.state       ][INFO    ][25451] File /etc/salt/grains exists with proper permissions. No changes made.
2017-10-27 19:48:49,996 [salt.state       ][INFO    ][25451] Completed state [/etc/salt/grains] at time 19:48:49.996374 duration_in_ms=0.75
2017-10-27 19:48:49,997 [salt.state       ][INFO    ][25451] Running state [/etc/salt/grains.d/placeholder] at time 19:48:49.996764
2017-10-27 19:48:49,997 [salt.state       ][INFO    ][25451] Executing state file.managed for /etc/salt/grains.d/placeholder
2017-10-27 19:48:49,997 [salt.state       ][INFO    ][25451] File /etc/salt/grains.d/placeholder exists with proper permissions. No changes made.
2017-10-27 19:48:49,998 [salt.state       ][INFO    ][25451] Completed state [/etc/salt/grains.d/placeholder] at time 19:48:49.997496 duration_in_ms=0.733
2017-10-27 19:48:49,998 [salt.state       ][INFO    ][25451] Running state [/etc/salt/grains.d/sphinx] at time 19:48:49.997870
2017-10-27 19:48:49,998 [salt.state       ][INFO    ][25451] Executing state file.managed for /etc/salt/grains.d/sphinx
2017-10-27 19:48:49,1000 [salt.state       ][INFO    ][25451] 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-10-27 19:48:49,1000 [salt.state       ][INFO    ][25451] Completed state [/etc/salt/grains.d/sphinx] at time 19:48:49.999730 duration_in_ms=1.86
2017-10-27 19:48:50,000 [salt.state       ][INFO    ][25451] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 19:48:50.000467
2017-10-27 19:48:50,001 [salt.state       ][INFO    ][25451] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-10-27 19:48:50,001 [salt.state       ][INFO    ][25451] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-10-27 19:48:50,001 [salt.state       ][INFO    ][25451] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 19:48:50.001008 duration_in_ms=0.541
2017-10-27 19:48:50,001 [salt.state       ][INFO    ][25451] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 19:48:50.001161
2017-10-27 19:48:50,001 [salt.state       ][INFO    ][25451] Executing state cmd.mod_watch for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-10-27 19:48:50,002 [salt.loaded.int.module.cmdmod][INFO    ][25451] Executing command 'python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"' in directory '/root'
2017-10-27 19:48:50,075 [salt.state       ][INFO    ][25451] {'pid': 25500, 'retcode': 0, 'stderr': '', 'stdout': ''}
2017-10-27 19:48:50,076 [salt.state       ][INFO    ][25451] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 19:48:50.075628 duration_in_ms=74.465
2017-10-27 19:48:50,076 [salt.state       ][INFO    ][25451] Running state [/etc/salt/grains.d/dns_records] at time 19:48:50.076166
2017-10-27 19:48:50,076 [salt.state       ][INFO    ][25451] Executing state file.managed for /etc/salt/grains.d/dns_records
2017-10-27 19:48:50,077 [salt.state       ][INFO    ][25451] File /etc/salt/grains.d/dns_records is in the correct state
2017-10-27 19:48:50,078 [salt.state       ][INFO    ][25451] Completed state [/etc/salt/grains.d/dns_records] at time 19:48:50.077525 duration_in_ms=1.359
2017-10-27 19:48:50,078 [salt.state       ][INFO    ][25451] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 19:48:50.078352
2017-10-27 19:48:50,079 [salt.state       ][INFO    ][25451] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"
2017-10-27 19:48:50,079 [salt.state       ][INFO    ][25451] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"
2017-10-27 19:48:50,079 [salt.state       ][INFO    ][25451] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 19:48:50.078920 duration_in_ms=0.568
2017-10-27 19:48:50,079 [salt.state       ][INFO    ][25451] Running state [/etc/salt/grains.d/salt] at time 19:48:50.079321
2017-10-27 19:48:50,080 [salt.state       ][INFO    ][25451] Executing state file.managed for /etc/salt/grains.d/salt
2017-10-27 19:48:50,080 [salt.state       ][INFO    ][25451] File /etc/salt/grains.d/salt is in the correct state
2017-10-27 19:48:50,080 [salt.state       ][INFO    ][25451] Completed state [/etc/salt/grains.d/salt] at time 19:48:50.080295 duration_in_ms=0.974
2017-10-27 19:48:50,081 [salt.state       ][INFO    ][25451] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 19:48:50.080985
2017-10-27 19:48:50,081 [salt.state       ][INFO    ][25451] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2017-10-27 19:48:50,081 [salt.state       ][INFO    ][25451] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2017-10-27 19:48:50,082 [salt.state       ][INFO    ][25451] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 19:48:50.081504 duration_in_ms=0.519
2017-10-27 19:48:50,083 [salt.state       ][INFO    ][25451] Running state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 19:48:50.083069
2017-10-27 19:48:50,083 [salt.state       ][INFO    ][25451] Executing state cmd.wait for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-10-27 19:48:50,084 [salt.state       ][INFO    ][25451] No changes made for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-10-27 19:48:50,084 [salt.state       ][INFO    ][25451] Completed state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 19:48:50.083648 duration_in_ms=0.579
2017-10-27 19:48:50,084 [salt.state       ][INFO    ][25451] Running state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 19:48:50.083795
2017-10-27 19:48:50,084 [salt.state       ][INFO    ][25451] Executing state cmd.mod_watch for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-10-27 19:48:50,086 [salt.loaded.int.module.cmdmod][INFO    ][25451] Executing command 'cat /etc/salt/grains.d/* > /etc/salt/grains' in directory '/root'
2017-10-27 19:48:50,092 [salt.state       ][INFO    ][25451] {'pid': 25502, 'retcode': 0, 'stderr': '', 'stdout': ''}
2017-10-27 19:48:50,092 [salt.state       ][INFO    ][25451] Completed state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 19:48:50.092172 duration_in_ms=8.376
2017-10-27 19:48:50,093 [salt.state       ][INFO    ][25451] Running state [mine.update] at time 19:48:50.092906
2017-10-27 19:48:50,093 [salt.state       ][INFO    ][25451] Executing state module.wait for mine.update
2017-10-27 19:48:50,093 [salt.state       ][INFO    ][25451] No changes made for mine.update
2017-10-27 19:48:50,094 [salt.state       ][INFO    ][25451] Completed state [mine.update] at time 19:48:50.093548 duration_in_ms=0.641
2017-10-27 19:48:50,094 [salt.state       ][INFO    ][25451] Running state [mine.update] at time 19:48:50.093715
2017-10-27 19:48:50,094 [salt.state       ][INFO    ][25451] Executing state module.mod_watch for mine.update
2017-10-27 19:48:50,611 [salt.state       ][INFO    ][25451] {'ret': True}
2017-10-27 19:48:50,611 [salt.state       ][INFO    ][25451] Completed state [mine.update] at time 19:48:50.610778 duration_in_ms=517.063
2017-10-27 19:48:50,611 [salt.state       ][INFO    ][25451] Running state [ca-certificates] at time 19:48:50.611034
2017-10-27 19:48:50,611 [salt.state       ][INFO    ][25451] Executing state pkg.installed for ca-certificates
2017-10-27 19:48:50,615 [salt.state       ][INFO    ][25451] Package ca-certificates is already installed
2017-10-27 19:48:50,615 [salt.state       ][INFO    ][25451] Completed state [ca-certificates] at time 19:48:50.615294 duration_in_ms=4.259
2017-10-27 19:48:50,616 [salt.state       ][INFO    ][25451] Running state [update-ca-certificates] at time 19:48:50.615951
2017-10-27 19:48:50,616 [salt.state       ][INFO    ][25451] Executing state cmd.wait for update-ca-certificates
2017-10-27 19:48:50,616 [salt.state       ][INFO    ][25451] No changes made for update-ca-certificates
2017-10-27 19:48:50,617 [salt.state       ][INFO    ][25451] Completed state [update-ca-certificates] at time 19:48:50.616525 duration_in_ms=0.574
2017-10-27 19:48:50,617 [salt.state       ][INFO    ][25451] Running state [libvirt-dev] at time 19:48:50.616697
2017-10-27 19:48:50,617 [salt.state       ][INFO    ][25451] Executing state pkg.installed for libvirt-dev
2017-10-27 19:48:50,620 [salt.state       ][INFO    ][25451] Package libvirt-dev is already installed
2017-10-27 19:48:50,621 [salt.state       ][INFO    ][25451] Completed state [libvirt-dev] at time 19:48:50.620633 duration_in_ms=3.937
2017-10-27 19:48:50,621 [salt.state       ][INFO    ][25451] Running state [pkg-config] at time 19:48:50.620821
2017-10-27 19:48:50,621 [salt.state       ][INFO    ][25451] Executing state pkg.installed for pkg-config
2017-10-27 19:48:50,625 [salt.state       ][INFO    ][25451] Package pkg-config is already installed
2017-10-27 19:48:50,625 [salt.state       ][INFO    ][25451] Completed state [pkg-config] at time 19:48:50.624824 duration_in_ms=4.002
2017-10-27 19:48:50,625 [salt.state       ][INFO    ][25451] Running state [virtng.init] at time 19:48:50.625000
2017-10-27 19:48:50,625 [salt.state       ][INFO    ][25451] Executing state module.run for virtng.init
2017-10-27 19:48:50,676 [salt.loaded.int.module.cmdmod][INFO    ][25451] Executing command ['git', '--version'] in directory '/root'
2017-10-27 19:48:50,759 [salt.loaded.int.module.cmdmod][INFO    ][25451] Executing command 'virsh list --all --name| grep -E "^mdb03.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-10-27 19:48:50,777 [salt.state       ][INFO    ][25451] unless execution succeeded
2017-10-27 19:48:50,777 [salt.state       ][INFO    ][25451] Completed state [virtng.init] at time 19:48:50.777231 duration_in_ms=152.23
2017-10-27 19:48:50,778 [salt.state       ][INFO    ][25451] Running state [virt.set_autostart] at time 19:48:50.777501
2017-10-27 19:48:50,778 [salt.state       ][INFO    ][25451] Executing state module.run for virt.set_autostart
2017-10-27 19:48:50,780 [salt.loaded.int.module.cmdmod][INFO    ][25451] Executing command 'virsh list --autostart --name| grep -E "^mdb03.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-10-27 19:48:50,797 [salt.state       ][INFO    ][25451] unless execution succeeded
2017-10-27 19:48:50,797 [salt.state       ][INFO    ][25451] Completed state [virt.set_autostart] at time 19:48:50.796929 duration_in_ms=19.419
2017-10-27 19:48:50,797 [salt.state       ][INFO    ][25451] Running state [virtng.init] at time 19:48:50.797161
2017-10-27 19:48:50,797 [salt.state       ][INFO    ][25451] Executing state module.run for virtng.init
2017-10-27 19:48:50,800 [salt.loaded.int.module.cmdmod][INFO    ][25451] Executing command 'virsh list --all --name| grep -E "^dbs03.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-10-27 19:48:50,816 [salt.state       ][INFO    ][25451] unless execution succeeded
2017-10-27 19:48:50,816 [salt.state       ][INFO    ][25451] Completed state [virtng.init] at time 19:48:50.815884 duration_in_ms=18.722
2017-10-27 19:48:50,816 [salt.state       ][INFO    ][25451] Running state [virt.set_autostart] at time 19:48:50.816155
2017-10-27 19:48:50,816 [salt.state       ][INFO    ][25451] Executing state module.run for virt.set_autostart
2017-10-27 19:48:50,819 [salt.loaded.int.module.cmdmod][INFO    ][25451] Executing command 'virsh list --autostart --name| grep -E "^dbs03.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-10-27 19:48:50,835 [salt.state       ][INFO    ][25451] unless execution succeeded
2017-10-27 19:48:50,835 [salt.state       ][INFO    ][25451] Completed state [virt.set_autostart] at time 19:48:50.834911 duration_in_ms=18.756
2017-10-27 19:48:50,835 [salt.state       ][INFO    ][25451] Running state [virtng.init] at time 19:48:50.835192
2017-10-27 19:48:50,835 [salt.state       ][INFO    ][25451] Executing state module.run for virtng.init
2017-10-27 19:48:50,838 [salt.loaded.int.module.cmdmod][INFO    ][25451] Executing command 'virsh list --all --name| grep -E "^prx02.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-10-27 19:48:50,853 [salt.state       ][INFO    ][25451] unless execution succeeded
2017-10-27 19:48:50,853 [salt.state       ][INFO    ][25451] Completed state [virtng.init] at time 19:48:50.853083 duration_in_ms=17.891
2017-10-27 19:48:50,853 [salt.state       ][INFO    ][25451] Running state [virt.set_autostart] at time 19:48:50.853339
2017-10-27 19:48:50,854 [salt.state       ][INFO    ][25451] Executing state module.run for virt.set_autostart
2017-10-27 19:48:50,856 [salt.loaded.int.module.cmdmod][INFO    ][25451] Executing command 'virsh list --autostart --name| grep -E "^prx02.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-10-27 19:48:50,872 [salt.state       ][INFO    ][25451] unless execution succeeded
2017-10-27 19:48:50,872 [salt.state       ][INFO    ][25451] Completed state [virt.set_autostart] at time 19:48:50.872415 duration_in_ms=19.076
2017-10-27 19:48:50,873 [salt.state       ][INFO    ][25451] Running state [virtng.init] at time 19:48:50.872658
2017-10-27 19:48:50,873 [salt.state       ][INFO    ][25451] Executing state module.run for virtng.init
2017-10-27 19:48:50,876 [salt.loaded.int.module.cmdmod][INFO    ][25451] Executing command 'virsh list --all --name| grep -E "^odl01.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-10-27 19:48:50,891 [salt.state       ][INFO    ][25451] unless execution succeeded
2017-10-27 19:48:50,891 [salt.state       ][INFO    ][25451] Completed state [virtng.init] at time 19:48:50.891090 duration_in_ms=18.431
2017-10-27 19:48:50,891 [salt.state       ][INFO    ][25451] Running state [virt.set_autostart] at time 19:48:50.891386
2017-10-27 19:48:50,892 [salt.state       ][INFO    ][25451] Executing state module.run for virt.set_autostart
2017-10-27 19:48:50,894 [salt.loaded.int.module.cmdmod][INFO    ][25451] Executing command 'virsh list --autostart --name| grep -E "^odl01.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-10-27 19:48:50,910 [salt.state       ][INFO    ][25451] unless execution succeeded
2017-10-27 19:48:50,911 [salt.state       ][INFO    ][25451] Completed state [virt.set_autostart] at time 19:48:50.910690 duration_in_ms=19.303
2017-10-27 19:48:50,911 [salt.state       ][INFO    ][25451] Running state [virtng.init] at time 19:48:50.910951
2017-10-27 19:48:50,911 [salt.state       ][INFO    ][25451] Executing state module.run for virtng.init
2017-10-27 19:48:50,914 [salt.loaded.int.module.cmdmod][INFO    ][25451] Executing command 'virsh list --all --name| grep -E "^msg03.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-10-27 19:48:50,931 [salt.state       ][INFO    ][25451] unless execution succeeded
2017-10-27 19:48:50,931 [salt.state       ][INFO    ][25451] Completed state [virtng.init] at time 19:48:50.930934 duration_in_ms=19.983
2017-10-27 19:48:50,931 [salt.state       ][INFO    ][25451] Running state [virt.set_autostart] at time 19:48:50.931274
2017-10-27 19:48:50,932 [salt.state       ][INFO    ][25451] Executing state module.run for virt.set_autostart
2017-10-27 19:48:50,934 [salt.loaded.int.module.cmdmod][INFO    ][25451] Executing command 'virsh list --autostart --name| grep -E "^msg03.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-10-27 19:48:50,949 [salt.state       ][INFO    ][25451] unless execution succeeded
2017-10-27 19:48:50,950 [salt.state       ][INFO    ][25451] Completed state [virt.set_autostart] at time 19:48:50.949487 duration_in_ms=18.213
2017-10-27 19:48:50,950 [salt.state       ][INFO    ][25451] Running state [virtng.init] at time 19:48:50.949757
2017-10-27 19:48:50,950 [salt.state       ][INFO    ][25451] Executing state module.run for virtng.init
2017-10-27 19:48:50,953 [salt.loaded.int.module.cmdmod][INFO    ][25451] Executing command 'virsh list --all --name| grep -E "^ctl03.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-10-27 19:48:50,968 [salt.state       ][INFO    ][25451] unless execution succeeded
2017-10-27 19:48:50,968 [salt.state       ][INFO    ][25451] Completed state [virtng.init] at time 19:48:50.967792 duration_in_ms=18.035
2017-10-27 19:48:50,968 [salt.state       ][INFO    ][25451] Running state [virt.set_autostart] at time 19:48:50.968054
2017-10-27 19:48:50,968 [salt.state       ][INFO    ][25451] Executing state module.run for virt.set_autostart
2017-10-27 19:48:50,971 [salt.loaded.int.module.cmdmod][INFO    ][25451] Executing command 'virsh list --autostart --name| grep -E "^ctl03.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-10-27 19:48:50,986 [salt.state       ][INFO    ][25451] unless execution succeeded
2017-10-27 19:48:50,986 [salt.state       ][INFO    ][25451] Completed state [virt.set_autostart] at time 19:48:50.985996 duration_in_ms=17.942
2017-10-27 19:48:50,989 [salt.minion      ][INFO    ][25451] Returning information for job: 20171027194844647321
2017-10-27 19:49:11,308 [salt.minion      ][INFO    ][25322] User sudo_ubuntu Executing command saltutil.sync_all with jid 20171027194911295492
2017-10-27 19:49:11,327 [salt.minion      ][INFO    ][25567] Starting a new job with PID 25567
2017-10-27 19:49:15,761 [salt.state       ][INFO    ][25567] Loading fresh modules for state activity
2017-10-27 19:49:15,786 [salt.state       ][ERROR   ][25567] No contents found in top file
2017-10-27 19:49:15,787 [salt.utils.extmods][INFO    ][25567] Creating module dir '/var/cache/salt/minion/extmods/beacons'
2017-10-27 19:49:15,790 [salt.utils.extmods][INFO    ][25567] Syncing beacons for environment 'base'
2017-10-27 19:49:15,790 [salt.utils.extmods][INFO    ][25567] Loading cache from salt://_beacons, for base)
2017-10-27 19:49:15,790 [salt.fileclient  ][INFO    ][25567] Caching directory '_beacons/' for environment 'base'
2017-10-27 19:49:15,825 [salt.utils.extmods][INFO    ][25567] Syncing modules for environment 'base'
2017-10-27 19:49:15,825 [salt.utils.extmods][INFO    ][25567] Loading cache from salt://_modules, for base)
2017-10-27 19:49:15,825 [salt.fileclient  ][INFO    ][25567] Caching directory '_modules/' for environment 'base'
2017-10-27 19:49:16,387 [salt.fileclient  ][INFO    ][25567] Fetching file from saltenv 'base', ** done ** '_modules/ceph_ng.py'
2017-10-27 19:49:16,400 [salt.fileclient  ][INFO    ][25567] Fetching file from saltenv 'base', ** done ** '_modules/cinderng.py'
2017-10-27 19:49:16,417 [salt.fileclient  ][INFO    ][25567] Fetching file from saltenv 'base', ** done ** '_modules/contrail.py'
2017-10-27 19:49:16,429 [salt.fileclient  ][INFO    ][25567] Fetching file from saltenv 'base', ** done ** '_modules/creds.py'
2017-10-27 19:49:16,524 [salt.fileclient  ][INFO    ][25567] Fetching file from saltenv 'base', ** done ** '_modules/devops_utils.py'
2017-10-27 19:49:16,537 [salt.fileclient  ][INFO    ][25567] Fetching file from saltenv 'base', ** done ** '_modules/encode_json.py'
2017-10-27 19:49:16,560 [salt.fileclient  ][INFO    ][25567] Fetching file from saltenv 'base', ** done ** '_modules/gerrit.py'
2017-10-27 19:49:16,573 [salt.fileclient  ][INFO    ][25567] Fetching file from saltenv 'base', ** done ** '_modules/glanceng.py'
2017-10-27 19:49:16,586 [salt.fileclient  ][INFO    ][25567] Fetching file from saltenv 'base', ** done ** '_modules/heat.py'
2017-10-27 19:49:16,601 [salt.fileclient  ][INFO    ][25567] Fetching file from saltenv 'base', ** done ** '_modules/heka_alarming.py'
2017-10-27 19:49:16,640 [salt.fileclient  ][INFO    ][25567] Fetching file from saltenv 'base', ** done ** '_modules/helm.py'
2017-10-27 19:49:16,652 [salt.fileclient  ][INFO    ][25567] Fetching file from saltenv 'base', ** done ** '_modules/jenkins_common.py'
2017-10-27 19:49:16,661 [salt.fileclient  ][INFO    ][25567] Fetching file from saltenv 'base', ** done ** '_modules/keystone_policy.py'
2017-10-27 19:49:16,670 [salt.fileclient  ][INFO    ][25567] Fetching file from saltenv 'base', ** done ** '_modules/linux_hosts.py'
2017-10-27 19:49:16,679 [salt.fileclient  ][INFO    ][25567] Fetching file from saltenv 'base', ** done ** '_modules/linux_netlink.py'
2017-10-27 19:49:16,693 [salt.fileclient  ][INFO    ][25567] Fetching file from saltenv 'base', ** done ** '_modules/maas.py'
2017-10-27 19:49:16,705 [salt.fileclient  ][INFO    ][25567] Fetching file from saltenv 'base', ** done ** '_modules/maas_client.py'
2017-10-27 19:49:16,722 [salt.fileclient  ][INFO    ][25567] Fetching file from saltenv 'base', ** done ** '_modules/multipart.py'
2017-10-27 19:49:16,732 [salt.fileclient  ][INFO    ][25567] Fetching file from saltenv 'base', ** done ** '_modules/nagios_alarming.py'
2017-10-27 19:49:16,782 [salt.fileclient  ][INFO    ][25567] Fetching file from saltenv 'base', ** done ** '_modules/neutronng.py'
2017-10-27 19:49:16,797 [salt.fileclient  ][INFO    ][25567] Fetching file from saltenv 'base', ** done ** '_modules/novang.py'
2017-10-27 19:49:16,813 [salt.fileclient  ][INFO    ][25567] Fetching file from saltenv 'base', ** done ** '_modules/reclass.py'
2017-10-27 19:49:16,898 [salt.fileclient  ][INFO    ][25567] Fetching file from saltenv 'base', ** done ** '_modules/rsyslog_util.py'
2017-10-27 19:49:16,911 [salt.fileclient  ][INFO    ][25567] Fetching file from saltenv 'base', ** done ** '_modules/rundeck.py'
2017-10-27 19:49:16,927 [salt.fileclient  ][INFO    ][25567] Fetching file from saltenv 'base', ** done ** '_modules/saltkey.py'
2017-10-27 19:49:16,941 [salt.fileclient  ][INFO    ][25567] Fetching file from saltenv 'base', ** done ** '_modules/saltresource.py'
2017-10-27 19:49:16,963 [salt.fileclient  ][INFO    ][25567] Fetching file from saltenv 'base', ** done ** '_modules/seedng.py'
2017-10-27 19:49:16,983 [salt.fileclient  ][INFO    ][25567] Fetching file from saltenv 'base', ** done ** '_modules/testing/credentials.py'
2017-10-27 19:49:17,000 [salt.fileclient  ][INFO    ][25567] Fetching file from saltenv 'base', ** done ** '_modules/testing/django.py'
2017-10-27 19:49:17,030 [salt.fileclient  ][INFO    ][25567] Fetching file from saltenv 'base', ** done ** '_modules/testing/django_client_proxy.py'
2017-10-27 19:49:17,066 [salt.fileclient  ][INFO    ][25567] Fetching file from saltenv 'base', ** done ** '_modules/utils.py'
2017-10-27 19:49:17,087 [salt.fileclient  ][INFO    ][25567] Fetching file from saltenv 'base', ** done ** '_modules/virtng.py'
2017-10-27 19:49:17,092 [salt.utils.extmods][INFO    ][25567] Copying '/var/cache/salt/minion/files/base/_modules/__init__.py' to '/var/cache/salt/minion/extmods/modules/__init__.py'
2017-10-27 19:49:17,092 [salt.utils.extmods][INFO    ][25567] Copying '/var/cache/salt/minion/files/base/_modules/ceph_ng.py' to '/var/cache/salt/minion/extmods/modules/ceph_ng.py'
2017-10-27 19:49:17,092 [salt.utils.extmods][INFO    ][25567] Copying '/var/cache/salt/minion/files/base/_modules/cinderng.py' to '/var/cache/salt/minion/extmods/modules/cinderng.py'
2017-10-27 19:49:17,093 [salt.utils.extmods][INFO    ][25567] Copying '/var/cache/salt/minion/files/base/_modules/contrail.py' to '/var/cache/salt/minion/extmods/modules/contrail.py'
2017-10-27 19:49:17,093 [salt.utils.extmods][INFO    ][25567] Copying '/var/cache/salt/minion/files/base/_modules/creds.py' to '/var/cache/salt/minion/extmods/modules/creds.py'
2017-10-27 19:49:17,093 [salt.utils.extmods][INFO    ][25567] Copying '/var/cache/salt/minion/files/base/_modules/devops_utils.py' to '/var/cache/salt/minion/extmods/modules/devops_utils.py'
2017-10-27 19:49:17,094 [salt.utils.extmods][INFO    ][25567] Copying '/var/cache/salt/minion/files/base/_modules/encode_json.py' to '/var/cache/salt/minion/extmods/modules/encode_json.py'
2017-10-27 19:49:17,094 [salt.utils.extmods][INFO    ][25567] Copying '/var/cache/salt/minion/files/base/_modules/gerrit.py' to '/var/cache/salt/minion/extmods/modules/gerrit.py'
2017-10-27 19:49:17,094 [salt.utils.extmods][INFO    ][25567] Copying '/var/cache/salt/minion/files/base/_modules/glanceng.py' to '/var/cache/salt/minion/extmods/modules/glanceng.py'
2017-10-27 19:49:17,095 [salt.utils.extmods][INFO    ][25567] Copying '/var/cache/salt/minion/files/base/_modules/heat.py' to '/var/cache/salt/minion/extmods/modules/heat.py'
2017-10-27 19:49:17,095 [salt.utils.extmods][INFO    ][25567] Copying '/var/cache/salt/minion/files/base/_modules/heka_alarming.py' to '/var/cache/salt/minion/extmods/modules/heka_alarming.py'
2017-10-27 19:49:17,095 [salt.utils.extmods][INFO    ][25567] Copying '/var/cache/salt/minion/files/base/_modules/helm.py' to '/var/cache/salt/minion/extmods/modules/helm.py'
2017-10-27 19:49:17,095 [salt.utils.extmods][INFO    ][25567] Copying '/var/cache/salt/minion/files/base/_modules/jenkins_common.py' to '/var/cache/salt/minion/extmods/modules/jenkins_common.py'
2017-10-27 19:49:17,096 [salt.utils.extmods][INFO    ][25567] Copying '/var/cache/salt/minion/files/base/_modules/keystone_policy.py' to '/var/cache/salt/minion/extmods/modules/keystone_policy.py'
2017-10-27 19:49:17,096 [salt.utils.extmods][INFO    ][25567] Copying '/var/cache/salt/minion/files/base/_modules/linux_hosts.py' to '/var/cache/salt/minion/extmods/modules/linux_hosts.py'
2017-10-27 19:49:17,096 [salt.utils.extmods][INFO    ][25567] Copying '/var/cache/salt/minion/files/base/_modules/linux_netlink.py' to '/var/cache/salt/minion/extmods/modules/linux_netlink.py'
2017-10-27 19:49:17,096 [salt.utils.extmods][INFO    ][25567] Copying '/var/cache/salt/minion/files/base/_modules/maas.py' to '/var/cache/salt/minion/extmods/modules/maas.py'
2017-10-27 19:49:17,097 [salt.utils.extmods][INFO    ][25567] Copying '/var/cache/salt/minion/files/base/_modules/maas_client.py' to '/var/cache/salt/minion/extmods/modules/maas_client.py'
2017-10-27 19:49:17,097 [salt.utils.extmods][INFO    ][25567] Copying '/var/cache/salt/minion/files/base/_modules/multipart.py' to '/var/cache/salt/minion/extmods/modules/multipart.py'
2017-10-27 19:49:17,097 [salt.utils.extmods][INFO    ][25567] Copying '/var/cache/salt/minion/files/base/_modules/nagios_alarming.py' to '/var/cache/salt/minion/extmods/modules/nagios_alarming.py'
2017-10-27 19:49:17,098 [salt.utils.extmods][INFO    ][25567] Copying '/var/cache/salt/minion/files/base/_modules/neutronng.py' to '/var/cache/salt/minion/extmods/modules/neutronng.py'
2017-10-27 19:49:17,098 [salt.utils.extmods][INFO    ][25567] Copying '/var/cache/salt/minion/files/base/_modules/novang.py' to '/var/cache/salt/minion/extmods/modules/novang.py'
2017-10-27 19:49:17,098 [salt.utils.extmods][INFO    ][25567] Copying '/var/cache/salt/minion/files/base/_modules/reclass.py' to '/var/cache/salt/minion/extmods/modules/reclass.py'
2017-10-27 19:49:17,099 [salt.utils.extmods][INFO    ][25567] Copying '/var/cache/salt/minion/files/base/_modules/rsyslog_util.py' to '/var/cache/salt/minion/extmods/modules/rsyslog_util.py'
2017-10-27 19:49:17,099 [salt.utils.extmods][INFO    ][25567] Copying '/var/cache/salt/minion/files/base/_modules/rundeck.py' to '/var/cache/salt/minion/extmods/modules/rundeck.py'
2017-10-27 19:49:17,099 [salt.utils.extmods][INFO    ][25567] Copying '/var/cache/salt/minion/files/base/_modules/saltkey.py' to '/var/cache/salt/minion/extmods/modules/saltkey.py'
2017-10-27 19:49:17,100 [salt.utils.extmods][INFO    ][25567] Copying '/var/cache/salt/minion/files/base/_modules/saltresource.py' to '/var/cache/salt/minion/extmods/modules/saltresource.py'
2017-10-27 19:49:17,100 [salt.utils.extmods][INFO    ][25567] Copying '/var/cache/salt/minion/files/base/_modules/seedng.py' to '/var/cache/salt/minion/extmods/modules/seedng.py'
2017-10-27 19:49:17,100 [salt.utils.extmods][INFO    ][25567] Copying '/var/cache/salt/minion/files/base/_modules/testing/__init__.py' to '/var/cache/salt/minion/extmods/modules/testing/__init__.py'
2017-10-27 19:49:17,100 [salt.utils.extmods][INFO    ][25567] Copying '/var/cache/salt/minion/files/base/_modules/testing/credentials.py' to '/var/cache/salt/minion/extmods/modules/testing/credentials.py'
2017-10-27 19:49:17,101 [salt.utils.extmods][INFO    ][25567] Copying '/var/cache/salt/minion/files/base/_modules/testing/django.py' to '/var/cache/salt/minion/extmods/modules/testing/django.py'
2017-10-27 19:49:17,101 [salt.utils.extmods][INFO    ][25567] 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-10-27 19:49:17,101 [salt.utils.extmods][INFO    ][25567] Copying '/var/cache/salt/minion/files/base/_modules/utils.py' to '/var/cache/salt/minion/extmods/modules/utils.py'
2017-10-27 19:49:17,101 [salt.utils.extmods][INFO    ][25567] Copying '/var/cache/salt/minion/files/base/_modules/virtng.py' to '/var/cache/salt/minion/extmods/modules/virtng.py'
2017-10-27 19:49:17,107 [salt.utils.extmods][INFO    ][25567] Syncing states for environment 'base'
2017-10-27 19:49:17,108 [salt.utils.extmods][INFO    ][25567] Loading cache from salt://_states, for base)
2017-10-27 19:49:17,108 [salt.fileclient  ][INFO    ][25567] Caching directory '_states/' for environment 'base'
2017-10-27 19:49:17,172 [salt.fileclient  ][INFO    ][25567] Fetching file from saltenv 'base', ** done ** '_states/cinderng.py'
2017-10-27 19:49:17,186 [salt.fileclient  ][INFO    ][25567] Fetching file from saltenv 'base', ** done ** '_states/contrail.py'
2017-10-27 19:49:17,224 [salt.fileclient  ][INFO    ][25567] Fetching file from saltenv 'base', ** done ** '_states/gerrit.py'
2017-10-27 19:49:17,238 [salt.fileclient  ][INFO    ][25567] Fetching file from saltenv 'base', ** done ** '_states/glanceng.py'
2017-10-27 19:49:17,252 [salt.fileclient  ][INFO    ][25567] Fetching file from saltenv 'base', ** done ** '_states/grafana3_dashboard.py'
2017-10-27 19:49:17,307 [salt.fileclient  ][INFO    ][25567] Fetching file from saltenv 'base', ** done ** '_states/grafana3_datasource.py'
2017-10-27 19:49:17,354 [salt.fileclient  ][INFO    ][25567] Fetching file from saltenv 'base', ** done ** '_states/heat.py'
2017-10-27 19:49:17,370 [salt.fileclient  ][INFO    ][25567] Fetching file from saltenv 'base', ** done ** '_states/helm_release.py'
2017-10-27 19:49:17,399 [salt.fileclient  ][INFO    ][25567] Fetching file from saltenv 'base', ** done ** '_states/jenkins_approval.py'
2017-10-27 19:49:17,425 [salt.fileclient  ][INFO    ][25567] Fetching file from saltenv 'base', ** done ** '_states/jenkins_artifactory.py'
2017-10-27 19:49:17,439 [salt.fileclient  ][INFO    ][25567] Fetching file from saltenv 'base', ** done ** '_states/jenkins_credential.py'
2017-10-27 19:49:17,462 [salt.fileclient  ][INFO    ][25567] Fetching file from saltenv 'base', ** done ** '_states/jenkins_job.py'
2017-10-27 19:49:17,484 [salt.fileclient  ][INFO    ][25567] Fetching file from saltenv 'base', ** done ** '_states/jenkins_lib.py'
2017-10-27 19:49:17,540 [salt.fileclient  ][INFO    ][25567] Fetching file from saltenv 'base', ** done ** '_states/jenkins_node.py'
2017-10-27 19:49:17,556 [salt.fileclient  ][INFO    ][25567] Fetching file from saltenv 'base', ** done ** '_states/jenkins_plugin.py'
2017-10-27 19:49:17,575 [salt.fileclient  ][INFO    ][25567] Fetching file from saltenv 'base', ** done ** '_states/jenkins_security.py'
2017-10-27 19:49:17,615 [salt.fileclient  ][INFO    ][25567] Fetching file from saltenv 'base', ** done ** '_states/jenkins_slack.py'
2017-10-27 19:49:17,669 [salt.fileclient  ][INFO    ][25567] Fetching file from saltenv 'base', ** done ** '_states/jenkins_smtp.py'
2017-10-27 19:49:17,694 [salt.fileclient  ][INFO    ][25567] Fetching file from saltenv 'base', ** done ** '_states/jenkins_theme.py'
2017-10-27 19:49:17,733 [salt.fileclient  ][INFO    ][25567] Fetching file from saltenv 'base', ** done ** '_states/jenkins_user.py'
2017-10-27 19:49:17,745 [salt.fileclient  ][INFO    ][25567] Fetching file from saltenv 'base', ** done ** '_states/jenkins_view.py'
2017-10-27 19:49:17,763 [salt.fileclient  ][INFO    ][25567] Fetching file from saltenv 'base', ** done ** '_states/keystone_policy.py'
2017-10-27 19:49:17,797 [salt.fileclient  ][INFO    ][25567] Fetching file from saltenv 'base', ** done ** '_states/kibana_object.py'
2017-10-27 19:49:17,834 [salt.fileclient  ][INFO    ][25567] Fetching file from saltenv 'base', ** done ** '_states/neutronng.py'
2017-10-27 19:49:17,848 [salt.fileclient  ][INFO    ][25567] Fetching file from saltenv 'base', ** done ** '_states/novang.py'
2017-10-27 19:49:17,861 [salt.fileclient  ][INFO    ][25567] Fetching file from saltenv 'base', ** done ** '_states/reclass.py'
2017-10-27 19:49:17,873 [salt.fileclient  ][INFO    ][25567] Fetching file from saltenv 'base', ** done ** '_states/rundeck_project.py'
2017-10-27 19:49:17,924 [salt.fileclient  ][INFO    ][25567] Fetching file from saltenv 'base', ** done ** '_states/rundeck_scm.py'
2017-10-27 19:49:17,942 [salt.fileclient  ][INFO    ][25567] Fetching file from saltenv 'base', ** done ** '_states/rundeck_secret.py'
2017-10-27 19:49:17,946 [salt.utils.extmods][INFO    ][25567] Copying '/var/cache/salt/minion/files/base/_states/cinderng.py' to '/var/cache/salt/minion/extmods/states/cinderng.py'
2017-10-27 19:49:17,946 [salt.utils.extmods][INFO    ][25567] Copying '/var/cache/salt/minion/files/base/_states/contrail.py' to '/var/cache/salt/minion/extmods/states/contrail.py'
2017-10-27 19:49:17,947 [salt.utils.extmods][INFO    ][25567] Copying '/var/cache/salt/minion/files/base/_states/gerrit.py' to '/var/cache/salt/minion/extmods/states/gerrit.py'
2017-10-27 19:49:17,947 [salt.utils.extmods][INFO    ][25567] Copying '/var/cache/salt/minion/files/base/_states/glanceng.py' to '/var/cache/salt/minion/extmods/states/glanceng.py'
2017-10-27 19:49:17,947 [salt.utils.extmods][INFO    ][25567] Copying '/var/cache/salt/minion/files/base/_states/grafana3_dashboard.py' to '/var/cache/salt/minion/extmods/states/grafana3_dashboard.py'
2017-10-27 19:49:17,948 [salt.utils.extmods][INFO    ][25567] Copying '/var/cache/salt/minion/files/base/_states/grafana3_datasource.py' to '/var/cache/salt/minion/extmods/states/grafana3_datasource.py'
2017-10-27 19:49:17,948 [salt.utils.extmods][INFO    ][25567] Copying '/var/cache/salt/minion/files/base/_states/heat.py' to '/var/cache/salt/minion/extmods/states/heat.py'
2017-10-27 19:49:17,948 [salt.utils.extmods][INFO    ][25567] Copying '/var/cache/salt/minion/files/base/_states/helm_release.py' to '/var/cache/salt/minion/extmods/states/helm_release.py'
2017-10-27 19:49:17,948 [salt.utils.extmods][INFO    ][25567] Copying '/var/cache/salt/minion/files/base/_states/jenkins_approval.py' to '/var/cache/salt/minion/extmods/states/jenkins_approval.py'
2017-10-27 19:49:17,949 [salt.utils.extmods][INFO    ][25567] Copying '/var/cache/salt/minion/files/base/_states/jenkins_artifactory.py' to '/var/cache/salt/minion/extmods/states/jenkins_artifactory.py'
2017-10-27 19:49:17,949 [salt.utils.extmods][INFO    ][25567] Copying '/var/cache/salt/minion/files/base/_states/jenkins_credential.py' to '/var/cache/salt/minion/extmods/states/jenkins_credential.py'
2017-10-27 19:49:17,949 [salt.utils.extmods][INFO    ][25567] Copying '/var/cache/salt/minion/files/base/_states/jenkins_job.py' to '/var/cache/salt/minion/extmods/states/jenkins_job.py'
2017-10-27 19:49:17,950 [salt.utils.extmods][INFO    ][25567] Copying '/var/cache/salt/minion/files/base/_states/jenkins_lib.py' to '/var/cache/salt/minion/extmods/states/jenkins_lib.py'
2017-10-27 19:49:17,950 [salt.utils.extmods][INFO    ][25567] Copying '/var/cache/salt/minion/files/base/_states/jenkins_node.py' to '/var/cache/salt/minion/extmods/states/jenkins_node.py'
2017-10-27 19:49:17,950 [salt.utils.extmods][INFO    ][25567] Copying '/var/cache/salt/minion/files/base/_states/jenkins_plugin.py' to '/var/cache/salt/minion/extmods/states/jenkins_plugin.py'
2017-10-27 19:49:17,950 [salt.utils.extmods][INFO    ][25567] Copying '/var/cache/salt/minion/files/base/_states/jenkins_security.py' to '/var/cache/salt/minion/extmods/states/jenkins_security.py'
2017-10-27 19:49:17,951 [salt.utils.extmods][INFO    ][25567] Copying '/var/cache/salt/minion/files/base/_states/jenkins_slack.py' to '/var/cache/salt/minion/extmods/states/jenkins_slack.py'
2017-10-27 19:49:17,951 [salt.utils.extmods][INFO    ][25567] Copying '/var/cache/salt/minion/files/base/_states/jenkins_smtp.py' to '/var/cache/salt/minion/extmods/states/jenkins_smtp.py'
2017-10-27 19:49:17,951 [salt.utils.extmods][INFO    ][25567] Copying '/var/cache/salt/minion/files/base/_states/jenkins_theme.py' to '/var/cache/salt/minion/extmods/states/jenkins_theme.py'
2017-10-27 19:49:17,951 [salt.utils.extmods][INFO    ][25567] Copying '/var/cache/salt/minion/files/base/_states/jenkins_user.py' to '/var/cache/salt/minion/extmods/states/jenkins_user.py'
2017-10-27 19:49:17,952 [salt.utils.extmods][INFO    ][25567] Copying '/var/cache/salt/minion/files/base/_states/jenkins_view.py' to '/var/cache/salt/minion/extmods/states/jenkins_view.py'
2017-10-27 19:49:17,952 [salt.utils.extmods][INFO    ][25567] Copying '/var/cache/salt/minion/files/base/_states/keystone_policy.py' to '/var/cache/salt/minion/extmods/states/keystone_policy.py'
2017-10-27 19:49:17,952 [salt.utils.extmods][INFO    ][25567] Copying '/var/cache/salt/minion/files/base/_states/kibana_object.py' to '/var/cache/salt/minion/extmods/states/kibana_object.py'
2017-10-27 19:49:17,952 [salt.utils.extmods][INFO    ][25567] Copying '/var/cache/salt/minion/files/base/_states/maas_cluster.py' to '/var/cache/salt/minion/extmods/states/maas_cluster.py'
2017-10-27 19:49:17,953 [salt.utils.extmods][INFO    ][25567] Copying '/var/cache/salt/minion/files/base/_states/neutronng.py' to '/var/cache/salt/minion/extmods/states/neutronng.py'
2017-10-27 19:49:17,953 [salt.utils.extmods][INFO    ][25567] Copying '/var/cache/salt/minion/files/base/_states/novang.py' to '/var/cache/salt/minion/extmods/states/novang.py'
2017-10-27 19:49:17,953 [salt.utils.extmods][INFO    ][25567] Copying '/var/cache/salt/minion/files/base/_states/reclass.py' to '/var/cache/salt/minion/extmods/states/reclass.py'
2017-10-27 19:49:17,953 [salt.utils.extmods][INFO    ][25567] Copying '/var/cache/salt/minion/files/base/_states/rundeck_project.py' to '/var/cache/salt/minion/extmods/states/rundeck_project.py'
2017-10-27 19:49:17,954 [salt.utils.extmods][INFO    ][25567] Copying '/var/cache/salt/minion/files/base/_states/rundeck_scm.py' to '/var/cache/salt/minion/extmods/states/rundeck_scm.py'
2017-10-27 19:49:17,954 [salt.utils.extmods][INFO    ][25567] Copying '/var/cache/salt/minion/files/base/_states/rundeck_secret.py' to '/var/cache/salt/minion/extmods/states/rundeck_secret.py'
2017-10-27 19:49:17,957 [salt.utils.extmods][INFO    ][25567] Creating module dir '/var/cache/salt/minion/extmods/sdb'
2017-10-27 19:49:17,960 [salt.utils.extmods][INFO    ][25567] Syncing sdb for environment 'base'
2017-10-27 19:49:17,960 [salt.utils.extmods][INFO    ][25567] Loading cache from salt://_sdb, for base)
2017-10-27 19:49:17,960 [salt.fileclient  ][INFO    ][25567] Caching directory '_sdb/' for environment 'base'
2017-10-27 19:49:18,021 [salt.utils.extmods][INFO    ][25567] Syncing grains for environment 'base'
2017-10-27 19:49:18,022 [salt.utils.extmods][INFO    ][25567] Loading cache from salt://_grains, for base)
2017-10-27 19:49:18,022 [salt.fileclient  ][INFO    ][25567] Caching directory '_grains/' for environment 'base'
2017-10-27 19:49:18,195 [salt.fileclient  ][INFO    ][25567] Fetching file from saltenv 'base', ** done ** '_grains/ceilometer_policy.py'
2017-10-27 19:49:18,209 [salt.fileclient  ][INFO    ][25567] Fetching file from saltenv 'base', ** done ** '_grains/ceph.py'
2017-10-27 19:49:18,222 [salt.fileclient  ][INFO    ][25567] Fetching file from saltenv 'base', ** done ** '_grains/cinder_policy.py'
2017-10-27 19:49:18,289 [salt.fileclient  ][INFO    ][25567] Fetching file from saltenv 'base', ** done ** '_grains/docker_swarm.py'
2017-10-27 19:49:18,302 [salt.fileclient  ][INFO    ][25567] Fetching file from saltenv 'base', ** done ** '_grains/glance_policy.py'
2017-10-27 19:49:18,314 [salt.fileclient  ][INFO    ][25567] Fetching file from saltenv 'base', ** done ** '_grains/heat_policy.py'
2017-10-27 19:49:18,341 [salt.fileclient  ][INFO    ][25567] Fetching file from saltenv 'base', ** done ** '_grains/jenkins_plugins.py'
2017-10-27 19:49:18,373 [salt.fileclient  ][INFO    ][25567] Fetching file from saltenv 'base', ** done ** '_grains/keystone_policy.py'
2017-10-27 19:49:18,387 [salt.fileclient  ][INFO    ][25567] Fetching file from saltenv 'base', ** done ** '_grains/kubernetes.py'
2017-10-27 19:49:18,400 [salt.fileclient  ][INFO    ][25567] Fetching file from saltenv 'base', ** done ** '_grains/neutron_policy.py'
2017-10-27 19:49:18,461 [salt.fileclient  ][INFO    ][25567] Fetching file from saltenv 'base', ** done ** '_grains/nova_policy.py'
2017-10-27 19:49:18,475 [salt.fileclient  ][INFO    ][25567] Fetching file from saltenv 'base', ** done ** '_grains/ssh_fingerprints.py'
2017-10-27 19:49:18,480 [salt.utils.extmods][INFO    ][25567] Copying '/var/cache/salt/minion/files/base/_grains/ceilometer_policy.py' to '/var/cache/salt/minion/extmods/grains/ceilometer_policy.py'
2017-10-27 19:49:18,480 [salt.utils.extmods][INFO    ][25567] Copying '/var/cache/salt/minion/files/base/_grains/ceph.py' to '/var/cache/salt/minion/extmods/grains/ceph.py'
2017-10-27 19:49:18,481 [salt.utils.extmods][INFO    ][25567] Copying '/var/cache/salt/minion/files/base/_grains/cinder_policy.py' to '/var/cache/salt/minion/extmods/grains/cinder_policy.py'
2017-10-27 19:49:18,481 [salt.utils.extmods][INFO    ][25567] Copying '/var/cache/salt/minion/files/base/_grains/docker_swarm.py' to '/var/cache/salt/minion/extmods/grains/docker_swarm.py'
2017-10-27 19:49:18,481 [salt.utils.extmods][INFO    ][25567] Copying '/var/cache/salt/minion/files/base/_grains/glance_policy.py' to '/var/cache/salt/minion/extmods/grains/glance_policy.py'
2017-10-27 19:49:18,481 [salt.utils.extmods][INFO    ][25567] Copying '/var/cache/salt/minion/files/base/_grains/heat_policy.py' to '/var/cache/salt/minion/extmods/grains/heat_policy.py'
2017-10-27 19:49:18,482 [salt.utils.extmods][INFO    ][25567] Copying '/var/cache/salt/minion/files/base/_grains/jenkins_plugins.py' to '/var/cache/salt/minion/extmods/grains/jenkins_plugins.py'
2017-10-27 19:49:18,482 [salt.utils.extmods][INFO    ][25567] Copying '/var/cache/salt/minion/files/base/_grains/keystone_policy.py' to '/var/cache/salt/minion/extmods/grains/keystone_policy.py'
2017-10-27 19:49:18,482 [salt.utils.extmods][INFO    ][25567] Copying '/var/cache/salt/minion/files/base/_grains/kubernetes.py' to '/var/cache/salt/minion/extmods/grains/kubernetes.py'
2017-10-27 19:49:18,482 [salt.utils.extmods][INFO    ][25567] Copying '/var/cache/salt/minion/files/base/_grains/neutron_policy.py' to '/var/cache/salt/minion/extmods/grains/neutron_policy.py'
2017-10-27 19:49:18,483 [salt.utils.extmods][INFO    ][25567] Copying '/var/cache/salt/minion/files/base/_grains/nova_policy.py' to '/var/cache/salt/minion/extmods/grains/nova_policy.py'
2017-10-27 19:49:18,483 [salt.utils.extmods][INFO    ][25567] Copying '/var/cache/salt/minion/files/base/_grains/ssh_fingerprints.py' to '/var/cache/salt/minion/extmods/grains/ssh_fingerprints.py'
2017-10-27 19:49:18,484 [salt.utils.extmods][INFO    ][25567] Creating module dir '/var/cache/salt/minion/extmods/renderers'
2017-10-27 19:49:18,488 [salt.utils.extmods][INFO    ][25567] Syncing renderers for environment 'base'
2017-10-27 19:49:18,488 [salt.utils.extmods][INFO    ][25567] Loading cache from salt://_renderers, for base)
2017-10-27 19:49:18,488 [salt.fileclient  ][INFO    ][25567] Caching directory '_renderers/' for environment 'base'
2017-10-27 19:49:18,557 [salt.utils.extmods][INFO    ][25567] Creating module dir '/var/cache/salt/minion/extmods/returners'
2017-10-27 19:49:18,561 [salt.utils.extmods][INFO    ][25567] Syncing returners for environment 'base'
2017-10-27 19:49:18,561 [salt.utils.extmods][INFO    ][25567] Loading cache from salt://_returners, for base)
2017-10-27 19:49:18,561 [salt.fileclient  ][INFO    ][25567] Caching directory '_returners/' for environment 'base'
2017-10-27 19:49:18,617 [salt.utils.extmods][INFO    ][25567] Creating module dir '/var/cache/salt/minion/extmods/output'
2017-10-27 19:49:18,621 [salt.utils.extmods][INFO    ][25567] Syncing output for environment 'base'
2017-10-27 19:49:18,621 [salt.utils.extmods][INFO    ][25567] Loading cache from salt://_output, for base)
2017-10-27 19:49:18,621 [salt.fileclient  ][INFO    ][25567] Caching directory '_output/' for environment 'base'
2017-10-27 19:49:18,736 [salt.utils.extmods][INFO    ][25567] Creating module dir '/var/cache/salt/minion/extmods/utils'
2017-10-27 19:49:18,739 [salt.utils.extmods][INFO    ][25567] Syncing utils for environment 'base'
2017-10-27 19:49:18,740 [salt.utils.extmods][INFO    ][25567] Loading cache from salt://_utils, for base)
2017-10-27 19:49:18,740 [salt.fileclient  ][INFO    ][25567] Caching directory '_utils/' for environment 'base'
2017-10-27 19:49:18,787 [salt.utils.extmods][INFO    ][25567] Creating module dir '/var/cache/salt/minion/extmods/log_handlers'
2017-10-27 19:49:18,791 [salt.utils.extmods][INFO    ][25567] Syncing log_handlers for environment 'base'
2017-10-27 19:49:18,791 [salt.utils.extmods][INFO    ][25567] Loading cache from salt://_log_handlers, for base)
2017-10-27 19:49:18,791 [salt.fileclient  ][INFO    ][25567] Caching directory '_log_handlers/' for environment 'base'
2017-10-27 19:49:18,855 [salt.utils.extmods][INFO    ][25567] Creating module dir '/var/cache/salt/minion/extmods/proxy'
2017-10-27 19:49:18,858 [salt.utils.extmods][INFO    ][25567] Syncing proxy for environment 'base'
2017-10-27 19:49:18,859 [salt.utils.extmods][INFO    ][25567] Loading cache from salt://_proxy, for base)
2017-10-27 19:49:18,859 [salt.fileclient  ][INFO    ][25567] Caching directory '_proxy/' for environment 'base'
2017-10-27 19:49:20,127 [salt.utils.extmods][INFO    ][25567] Creating module dir '/var/cache/salt/minion/extmods/engines'
2017-10-27 19:49:20,131 [salt.utils.extmods][INFO    ][25567] Syncing engines for environment 'base'
2017-10-27 19:49:20,131 [salt.utils.extmods][INFO    ][25567] Loading cache from salt://_engines, for base)
2017-10-27 19:49:20,131 [salt.fileclient  ][INFO    ][25567] Caching directory '_engines/' for environment 'base'
2017-10-27 19:49:20,160 [salt.minion      ][INFO    ][25567] Returning information for job: 20171027194911295492
2017-10-27 19:58:19,565 [salt.minion      ][INFO    ][25322] User sudo_ubuntu Executing command test.ping with jid 20171027195819553040
2017-10-27 19:58:19,580 [salt.minion      ][INFO    ][25830] Starting a new job with PID 25830
2017-10-27 19:58:19,617 [salt.minion      ][INFO    ][25830] Returning information for job: 20171027195819553040
2017-10-27 19:58:35,561 [salt.minion      ][INFO    ][25322] User sudo_ubuntu Executing command state.sls with jid 20171027195835541304
2017-10-27 19:58:35,572 [salt.minion      ][INFO    ][25836] Starting a new job with PID 25836
2017-10-27 19:58:36,134 [salt.state       ][INFO    ][25836] Loading fresh modules for state activity
2017-10-27 19:58:36,191 [salt.fileclient  ][INFO    ][25836] Fetching file from saltenv 'base', ** done ** 'keepalived/init.sls'
2017-10-27 19:58:36,209 [salt.fileclient  ][INFO    ][25836] Fetching file from saltenv 'base', ** done ** 'keepalived/cluster.sls'
2017-10-27 19:58:36,241 [salt.fileclient  ][INFO    ][25836] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-10-27 19:58:36,599 [salt.state       ][INFO    ][25836] Running state [lsof] at time 19:58:36.598620
2017-10-27 19:58:36,599 [salt.state       ][INFO    ][25836] Executing state pkg.installed for lsof
2017-10-27 19:58:36,599 [salt.loaded.int.module.cmdmod][INFO    ][25836] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-10-27 19:58:36,941 [salt.state       ][INFO    ][25836] Package lsof is already installed
2017-10-27 19:58:36,941 [salt.state       ][INFO    ][25836] Completed state [lsof] at time 19:58:36.941388 duration_in_ms=342.769
2017-10-27 19:58:36,942 [salt.state       ][INFO    ][25836] Running state [keepalived] at time 19:58:36.941681
2017-10-27 19:58:36,942 [salt.state       ][INFO    ][25836] Executing state pkg.installed for keepalived
2017-10-27 19:58:36,961 [salt.loaded.int.module.cmdmod][INFO    ][25836] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-10-27 19:58:38,400 [salt.loaded.int.module.cmdmod][INFO    ][25836] 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-10-27 19:58:41,158 [salt.loaded.int.module.cmdmod][INFO    ][25836] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-10-27 19:58:41,189 [salt.state       ][INFO    ][25836] 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-10-27 19:58:41,208 [salt.state       ][INFO    ][25836] Loading fresh modules for state activity
2017-10-27 19:58:41,226 [salt.state       ][INFO    ][25836] Completed state [keepalived] at time 19:58:41.225908 duration_in_ms=4284.227
2017-10-27 19:58:41,229 [salt.state       ][INFO    ][25836] Running state [/etc/keepalived/keepalived.conf] at time 19:58:41.228548
2017-10-27 19:58:41,229 [salt.state       ][INFO    ][25836] Executing state file.managed for /etc/keepalived/keepalived.conf
2017-10-27 19:58:41,254 [salt.fileclient  ][INFO    ][25836] Fetching file from saltenv 'base', ** done ** 'keepalived/files/keepalived.conf'
2017-10-27 19:58:41,293 [salt.fileclient  ][INFO    ][25836] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-10-27 19:58:41,301 [salt.state       ][INFO    ][25836] File changed:
New file
2017-10-27 19:58:41,301 [salt.state       ][INFO    ][25836] Completed state [/etc/keepalived/keepalived.conf] at time 19:58:41.301088 duration_in_ms=72.538
2017-10-27 19:58:41,374 [salt.state       ][INFO    ][25836] Running state [keepalived] at time 19:58:41.373839
2017-10-27 19:58:41,374 [salt.state       ][INFO    ][25836] Executing state service.running for keepalived
2017-10-27 19:58:41,376 [salt.loaded.int.module.cmdmod][INFO    ][25836] Executing command ['systemctl', 'status', 'keepalived.service', '-n', '0'] in directory '/root'
2017-10-27 19:58:41,386 [salt.loaded.int.module.cmdmod][INFO    ][25836] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2017-10-27 19:58:41,393 [salt.loaded.int.module.cmdmod][INFO    ][25836] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-10-27 19:58:41,400 [salt.loaded.int.module.cmdmod][INFO    ][25836] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-10-27 19:58:41,409 [salt.loaded.int.module.cmdmod][INFO    ][25836] Executing command ['systemd-run', '--scope', 'systemctl', 'start', 'keepalived.service'] in directory '/root'
2017-10-27 19:58:41,442 [salt.loaded.int.module.cmdmod][INFO    ][25836] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2017-10-27 19:58:41,452 [salt.loaded.int.module.cmdmod][INFO    ][25836] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-10-27 19:58:41,458 [salt.loaded.int.module.cmdmod][INFO    ][25836] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-10-27 19:58:41,464 [salt.state       ][INFO    ][25836] {'keepalived': True}
2017-10-27 19:58:41,465 [salt.state       ][INFO    ][25836] Completed state [keepalived] at time 19:58:41.464589 duration_in_ms=90.738
2017-10-27 19:58:41,466 [salt.minion      ][INFO    ][25836] Returning information for job: 20171027195835541304
2017-10-27 20:00:33,643 [salt.minion      ][INFO    ][25322] User sudo_ubuntu Executing command pillar.get with jid 20171027200033630413
2017-10-27 20:00:33,668 [salt.minion      ][INFO    ][27465] Starting a new job with PID 27465
2017-10-27 20:00:33,672 [salt.minion      ][INFO    ][27465] Returning information for job: 20171027200033630413
2017-10-27 20:05:11,450 [salt.minion      ][INFO    ][25322] User sudo_ubuntu Executing command state.sls with jid 20171027200511435264
2017-10-27 20:05:11,463 [salt.minion      ][INFO    ][27568] Starting a new job with PID 27568
2017-10-27 20:05:14,074 [salt.state       ][INFO    ][27568] Loading fresh modules for state activity
2017-10-27 20:05:14,101 [salt.fileclient  ][INFO    ][27568] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-10-27 20:05:14,125 [salt.fileclient  ][INFO    ][27568] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-10-27 20:05:14,424 [salt.state       ][INFO    ][27568] Running state [attr] at time 20:05:14.424204
2017-10-27 20:05:14,425 [salt.state       ][INFO    ][27568] Executing state pkg.installed for attr
2017-10-27 20:05:14,425 [salt.loaded.int.module.cmdmod][INFO    ][27568] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-10-27 20:05:14,702 [salt.loaded.int.module.cmdmod][INFO    ][27568] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-10-27 20:05:16,134 [salt.loaded.int.module.cmdmod][INFO    ][27568] 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-10-27 20:05:17,476 [salt.loaded.int.module.cmdmod][INFO    ][27568] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-10-27 20:05:17,504 [salt.state       ][INFO    ][27568] Made the following changes:
'attr' changed from 'absent' to '1:2.4.47-2'

2017-10-27 20:05:17,515 [salt.state       ][INFO    ][27568] Loading fresh modules for state activity
2017-10-27 20:05:17,533 [salt.state       ][INFO    ][27568] Completed state [attr] at time 20:05:17.532929 duration_in_ms=3108.725
2017-10-27 20:05:17,539 [salt.state       ][INFO    ][27568] Running state [glusterfs-server] at time 20:05:17.538940
2017-10-27 20:05:17,539 [salt.state       ][INFO    ][27568] Executing state pkg.installed for glusterfs-server
2017-10-27 20:05:17,762 [salt.loaded.int.module.cmdmod][INFO    ][27568] 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-10-27 20:05:21,562 [salt.minion      ][INFO    ][25322] User sudo_ubuntu Executing command saltutil.find_job with jid 20171027200521544322
2017-10-27 20:05:21,574 [salt.minion      ][INFO    ][31331] Starting a new job with PID 31331
2017-10-27 20:05:21,585 [salt.minion      ][INFO    ][31331] Returning information for job: 20171027200521544322
2017-10-27 20:05:24,800 [salt.loaded.int.module.cmdmod][INFO    ][27568] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-10-27 20:05:24,828 [salt.state       ][INFO    ][27568] 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-10-27 20:05:24,838 [salt.state       ][INFO    ][27568] Loading fresh modules for state activity
2017-10-27 20:05:24,854 [salt.state       ][INFO    ][27568] Completed state [glusterfs-server] at time 20:05:24.854218 duration_in_ms=7315.277
2017-10-27 20:05:24,860 [salt.state       ][INFO    ][27568] Running state [bc] at time 20:05:24.859731
2017-10-27 20:05:24,860 [salt.state       ][INFO    ][27568] Executing state pkg.installed for bc
2017-10-27 20:05:25,157 [salt.loaded.int.module.cmdmod][INFO    ][27568] 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-10-27 20:05:26,567 [salt.loaded.int.module.cmdmod][INFO    ][27568] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-10-27 20:05:26,595 [salt.state       ][INFO    ][27568] Made the following changes:
'bc' changed from 'absent' to '1.06.95-9build1'

2017-10-27 20:05:26,604 [salt.state       ][INFO    ][27568] Loading fresh modules for state activity
2017-10-27 20:05:26,621 [salt.state       ][INFO    ][27568] Completed state [bc] at time 20:05:26.620664 duration_in_ms=1760.931
2017-10-27 20:05:26,694 [salt.state       ][INFO    ][27568] Running state [glusterfs-server] at time 20:05:26.693981
2017-10-27 20:05:26,694 [salt.state       ][INFO    ][27568] Executing state service.running for glusterfs-server
2017-10-27 20:05:26,696 [salt.loaded.int.module.cmdmod][INFO    ][27568] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-10-27 20:05:26,706 [salt.loaded.int.module.cmdmod][INFO    ][27568] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-10-27 20:05:26,714 [salt.loaded.int.module.cmdmod][INFO    ][27568] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-10-27 20:05:26,725 [salt.state       ][INFO    ][27568] The service glusterfs-server is already running
2017-10-27 20:05:26,725 [salt.state       ][INFO    ][27568] Completed state [glusterfs-server] at time 20:05:26.724763 duration_in_ms=30.781
2017-10-27 20:05:26,726 [salt.state       ][INFO    ][27568] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 20:05:26.726304
2017-10-27 20:05:26,727 [salt.state       ][INFO    ][27568] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-10-27 20:05:26,732 [salt.state       ][INFO    ][27568] File changed:
New file
2017-10-27 20:05:26,732 [salt.state       ][INFO    ][27568] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 20:05:26.731942 duration_in_ms=5.638
2017-10-27 20:05:26,732 [salt.state       ][INFO    ][27568] Running state [/srv/glusterfs/glance] at time 20:05:26.732126
2017-10-27 20:05:26,732 [salt.state       ][INFO    ][27568] Executing state file.directory for /srv/glusterfs/glance
2017-10-27 20:05:26,733 [salt.state       ][INFO    ][27568] {'/srv/glusterfs/glance': 'New Dir'}
2017-10-27 20:05:26,733 [salt.state       ][INFO    ][27568] Completed state [/srv/glusterfs/glance] at time 20:05:26.733089 duration_in_ms=0.964
2017-10-27 20:05:26,733 [salt.state       ][INFO    ][27568] Running state [/srv/glusterfs/keystone-keys] at time 20:05:26.733261
2017-10-27 20:05:26,733 [salt.state       ][INFO    ][27568] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-10-27 20:05:26,734 [salt.state       ][INFO    ][27568] {'/srv/glusterfs/keystone-keys': 'New Dir'}
2017-10-27 20:05:26,734 [salt.state       ][INFO    ][27568] Completed state [/srv/glusterfs/keystone-keys] at time 20:05:26.734006 duration_in_ms=0.745
2017-10-27 20:05:26,734 [salt.state       ][INFO    ][27568] Running state [/srv/glusterfs/nova_instances] at time 20:05:26.734169
2017-10-27 20:05:26,734 [salt.state       ][INFO    ][27568] Executing state file.directory for /srv/glusterfs/nova_instances
2017-10-27 20:05:26,735 [salt.state       ][INFO    ][27568] {'/srv/glusterfs/nova_instances': 'New Dir'}
2017-10-27 20:05:26,735 [salt.state       ][INFO    ][27568] Completed state [/srv/glusterfs/nova_instances] at time 20:05:26.734877 duration_in_ms=0.708
2017-10-27 20:05:26,735 [salt.state       ][INFO    ][27568] Running state [/srv/glusterfs/keystone-credential-keys] at time 20:05:26.735032
2017-10-27 20:05:26,735 [salt.state       ][INFO    ][27568] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-10-27 20:05:26,736 [salt.state       ][INFO    ][27568] {'/srv/glusterfs/keystone-credential-keys': 'New Dir'}
2017-10-27 20:05:26,736 [salt.state       ][INFO    ][27568] Completed state [/srv/glusterfs/keystone-credential-keys] at time 20:05:26.735859 duration_in_ms=0.827
2017-10-27 20:05:26,737 [salt.minion      ][INFO    ][27568] Returning information for job: 20171027200511435264
2017-10-27 20:05:34,903 [salt.minion      ][INFO    ][25322] User sudo_ubuntu Executing command test.ping with jid 20171027200534888220
2017-10-27 20:05:34,915 [salt.minion      ][INFO    ][32348] Starting a new job with PID 32348
2017-10-27 20:05:34,951 [salt.minion      ][INFO    ][32348] Returning information for job: 20171027200534888220
2017-10-27 20:06:02,855 [salt.minion      ][INFO    ][25322] User sudo_ubuntu Executing command state.sls with jid 20171027200602834442
2017-10-27 20:06:02,869 [salt.minion      ][INFO    ][32574] Starting a new job with PID 32574
2017-10-27 20:06:04,981 [salt.state       ][INFO    ][32574] Loading fresh modules for state activity
2017-10-27 20:06:05,016 [salt.fileclient  ][INFO    ][32574] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/setup.sls'
2017-10-27 20:06:05,060 [salt.fileclient  ][INFO    ][32574] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-10-27 20:06:05,138 [salt.fileclient  ][INFO    ][32574] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-10-27 20:06:05,164 [salt.fileclient  ][INFO    ][32574] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-10-27 20:06:05,473 [salt.state       ][INFO    ][32574] Running state [attr] at time 20:06:05.472855
2017-10-27 20:06:05,473 [salt.state       ][INFO    ][32574] Executing state pkg.installed for attr
2017-10-27 20:06:05,474 [salt.loaded.int.module.cmdmod][INFO    ][32574] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-10-27 20:06:05,725 [salt.state       ][INFO    ][32574] Package attr is already installed
2017-10-27 20:06:05,726 [salt.state       ][INFO    ][32574] Completed state [attr] at time 20:06:05.725610 duration_in_ms=252.756
2017-10-27 20:06:05,726 [salt.state       ][INFO    ][32574] Running state [glusterfs-server] at time 20:06:05.725842
2017-10-27 20:06:05,726 [salt.state       ][INFO    ][32574] Executing state pkg.installed for glusterfs-server
2017-10-27 20:06:05,730 [salt.state       ][INFO    ][32574] Package glusterfs-server is already installed
2017-10-27 20:06:05,730 [salt.state       ][INFO    ][32574] Completed state [glusterfs-server] at time 20:06:05.729834 duration_in_ms=3.993
2017-10-27 20:06:05,730 [salt.state       ][INFO    ][32574] Running state [bc] at time 20:06:05.730004
2017-10-27 20:06:05,730 [salt.state       ][INFO    ][32574] Executing state pkg.installed for bc
2017-10-27 20:06:05,734 [salt.state       ][INFO    ][32574] Package bc is already installed
2017-10-27 20:06:05,734 [salt.state       ][INFO    ][32574] Completed state [bc] at time 20:06:05.733882 duration_in_ms=3.878
2017-10-27 20:06:05,735 [salt.state       ][INFO    ][32574] Running state [glusterfs-server] at time 20:06:05.734812
2017-10-27 20:06:05,735 [salt.state       ][INFO    ][32574] Executing state service.running for glusterfs-server
2017-10-27 20:06:05,735 [salt.loaded.int.module.cmdmod][INFO    ][32574] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-10-27 20:06:05,745 [salt.loaded.int.module.cmdmod][INFO    ][32574] Executing command ['systemctl', '--system', 'daemon-reload'] in directory '/root'
2017-10-27 20:06:05,794 [salt.loaded.int.module.cmdmod][INFO    ][32574] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-10-27 20:06:05,808 [salt.loaded.int.module.cmdmod][INFO    ][32574] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-10-27 20:06:05,813 [salt.loaded.int.module.cmdmod][INFO    ][32574] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-10-27 20:06:05,823 [salt.state       ][INFO    ][32574] The service glusterfs-server is already running
2017-10-27 20:06:05,823 [salt.state       ][INFO    ][32574] Completed state [glusterfs-server] at time 20:06:05.822960 duration_in_ms=88.147
2017-10-27 20:06:05,825 [salt.state       ][INFO    ][32574] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 20:06:05.824719
2017-10-27 20:06:05,825 [salt.state       ][INFO    ][32574] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-10-27 20:06:05,827 [salt.state       ][INFO    ][32574] File /etc/systemd/system/glusterfs-server.service.d/override.conf is in the correct state
2017-10-27 20:06:05,827 [salt.state       ][INFO    ][32574] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 20:06:05.827311 duration_in_ms=2.592
2017-10-27 20:06:05,828 [salt.state       ][INFO    ][32574] Running state [/srv/glusterfs/glance] at time 20:06:05.827619
2017-10-27 20:06:05,828 [salt.state       ][INFO    ][32574] Executing state file.directory for /srv/glusterfs/glance
2017-10-27 20:06:05,828 [salt.state       ][INFO    ][32574] Directory /srv/glusterfs/glance is in the correct state
2017-10-27 20:06:05,829 [salt.state       ][INFO    ][32574] Completed state [/srv/glusterfs/glance] at time 20:06:05.828620 duration_in_ms=0.988
2017-10-27 20:06:05,829 [salt.state       ][INFO    ][32574] Running state [/srv/glusterfs/keystone-keys] at time 20:06:05.828886
2017-10-27 20:06:05,829 [salt.state       ][INFO    ][32574] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-10-27 20:06:05,830 [salt.state       ][INFO    ][32574] Directory /srv/glusterfs/keystone-keys is in the correct state
2017-10-27 20:06:05,830 [salt.state       ][INFO    ][32574] Completed state [/srv/glusterfs/keystone-keys] at time 20:06:05.829872 duration_in_ms=0.986
2017-10-27 20:06:05,830 [salt.state       ][INFO    ][32574] Running state [/srv/glusterfs/nova_instances] at time 20:06:05.830136
2017-10-27 20:06:05,830 [salt.state       ][INFO    ][32574] Executing state file.directory for /srv/glusterfs/nova_instances
2017-10-27 20:06:05,831 [salt.state       ][INFO    ][32574] Directory /srv/glusterfs/nova_instances is in the correct state
2017-10-27 20:06:05,831 [salt.state       ][INFO    ][32574] Completed state [/srv/glusterfs/nova_instances] at time 20:06:05.831080 duration_in_ms=0.943
2017-10-27 20:06:05,831 [salt.state       ][INFO    ][32574] Running state [/srv/glusterfs/keystone-credential-keys] at time 20:06:05.831373
2017-10-27 20:06:05,832 [salt.state       ][INFO    ][32574] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-10-27 20:06:05,832 [salt.state       ][INFO    ][32574] Directory /srv/glusterfs/keystone-credential-keys is in the correct state
2017-10-27 20:06:05,832 [salt.state       ][INFO    ][32574] Completed state [/srv/glusterfs/keystone-credential-keys] at time 20:06:05.832350 duration_in_ms=0.977
2017-10-27 20:06:05,886 [salt.loaded.int.module.cmdmod][INFO    ][32574] Executing command ['git', '--version'] in directory '/root'
2017-10-27 20:06:05,984 [salt.state       ][INFO    ][32574] Running state [sleep 5] at time 20:06:05.983830
2017-10-27 20:06:05,984 [salt.state       ][INFO    ][32574] Executing state cmd.wait for sleep 5
2017-10-27 20:06:05,985 [salt.state       ][INFO    ][32574] No changes made for sleep 5
2017-10-27 20:06:05,985 [salt.state       ][INFO    ][32574] Completed state [sleep 5] at time 20:06:05.984772 duration_in_ms=0.941
2017-10-27 20:06:05,985 [salt.state       ][INFO    ][32574] Running state [192.168.10.143] at time 20:06:05.985423
2017-10-27 20:06:05,986 [salt.state       ][INFO    ][32574] Executing state glusterfs.peered for 192.168.10.143
2017-10-27 20:06:05,986 [salt.loaded.int.module.cmdmod][INFO    ][32574] Executing command 'gluster --version' in directory '/root'
2017-10-27 20:06:05,994 [salt.loaded.int.module.cmdmod][INFO    ][32574] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 20:06:06,047 [salt.loaded.int.module.cmdmod][INFO    ][32574] Executing command 'gluster --version' in directory '/root'
2017-10-27 20:06:06,055 [salt.loaded.int.module.cmdmod][INFO    ][32574] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 20:06:06,108 [salt.loaded.int.module.cmdmod][INFO    ][32574] Executing command 'gluster --version' in directory '/root'
2017-10-27 20:06:06,117 [salt.loaded.int.module.cmdmod][INFO    ][32574] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 20:06:06,172 [salt.loaded.int.module.cmdmod][INFO    ][32574] Executing command 'gluster --version' in directory '/root'
2017-10-27 20:06:06,180 [salt.loaded.int.module.cmdmod][INFO    ][32574] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 20:06:06,232 [salt.state       ][INFO    ][32574] Peering with localhost is not needed
2017-10-27 20:06:06,233 [salt.state       ][INFO    ][32574] Completed state [192.168.10.143] at time 20:06:06.232579 duration_in_ms=247.155
2017-10-27 20:06:06,236 [salt.state       ][INFO    ][32574] Running state [192.168.10.142] at time 20:06:06.235617
2017-10-27 20:06:06,236 [salt.state       ][INFO    ][32574] Executing state glusterfs.peered for 192.168.10.142
2017-10-27 20:06:06,236 [salt.loaded.int.module.cmdmod][INFO    ][32574] Executing command 'gluster --version' in directory '/root'
2017-10-27 20:06:06,245 [salt.loaded.int.module.cmdmod][INFO    ][32574] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 20:06:06,297 [salt.loaded.int.module.cmdmod][INFO    ][32574] Executing command 'gluster --version' in directory '/root'
2017-10-27 20:06:06,306 [salt.loaded.int.module.cmdmod][INFO    ][32574] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 20:06:06,360 [salt.loaded.int.module.cmdmod][INFO    ][32574] Executing command 'gluster --version' in directory '/root'
2017-10-27 20:06:06,368 [salt.loaded.int.module.cmdmod][INFO    ][32574] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 20:06:06,424 [salt.loaded.int.module.cmdmod][INFO    ][32574] Executing command 'gluster --version' in directory '/root'
2017-10-27 20:06:06,431 [salt.loaded.int.module.cmdmod][INFO    ][32574] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 20:06:06,481 [salt.state       ][INFO    ][32574] {'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-10-27 20:06:06,481 [salt.state       ][INFO    ][32574] Completed state [192.168.10.142] at time 20:06:06.481313 duration_in_ms=245.695
2017-10-27 20:06:06,484 [salt.state       ][INFO    ][32574] Running state [192.168.10.141] at time 20:06:06.484376
2017-10-27 20:06:06,485 [salt.state       ][INFO    ][32574] Executing state glusterfs.peered for 192.168.10.141
2017-10-27 20:06:06,485 [salt.loaded.int.module.cmdmod][INFO    ][32574] Executing command 'gluster --version' in directory '/root'
2017-10-27 20:06:06,493 [salt.loaded.int.module.cmdmod][INFO    ][32574] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 20:06:06,547 [salt.state       ][INFO    ][32574] Host 192.168.10.141 already peered
2017-10-27 20:06:06,547 [salt.state       ][INFO    ][32574] Completed state [192.168.10.141] at time 20:06:06.547155 duration_in_ms=62.779
2017-10-27 20:06:06,548 [salt.state       ][INFO    ][32574] Running state [glance] at time 20:06:06.548086
2017-10-27 20:06:06,548 [salt.state       ][INFO    ][32574] Executing state glusterfs.created for glance
2017-10-27 20:06:06,549 [salt.loaded.int.module.cmdmod][INFO    ][32574] Executing command 'gluster --version' in directory '/root'
2017-10-27 20:06:06,557 [salt.loaded.int.module.cmdmod][INFO    ][32574] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 20:06:06,610 [salt.loaded.int.module.cmdmod][INFO    ][32574] Executing command 'gluster --version' in directory '/root'
2017-10-27 20:06:06,616 [salt.loaded.int.module.cmdmod][INFO    ][32574] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 20:06:06,677 [salt.state       ][INFO    ][32574] Volume glance already exists and is started.
2017-10-27 20:06:06,677 [salt.state       ][INFO    ][32574] Completed state [glance] at time 20:06:06.677274 duration_in_ms=129.188
2017-10-27 20:06:06,681 [salt.state       ][INFO    ][32574] Running state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 20:06:06.681244
2017-10-27 20:06:06,682 [salt.state       ][INFO    ][32574] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'
2017-10-27 20:06:06,682 [salt.loaded.int.module.cmdmod][INFO    ][32574] Executing command 'gluster volume info 'glance' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-10-27 20:06:06,736 [salt.state       ][INFO    ][32574] unless execution succeeded
2017-10-27 20:06:06,736 [salt.state       ][INFO    ][32574] Completed state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 20:06:06.736388 duration_in_ms=55.133
2017-10-27 20:06:06,737 [salt.state       ][INFO    ][32574] Running state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 20:06:06.736919
2017-10-27 20:06:06,737 [salt.state       ][INFO    ][32574] Executing state cmd.run for gluster volume set 'glance' 'network.remote-dio' 'True'
2017-10-27 20:06:06,738 [salt.loaded.int.module.cmdmod][INFO    ][32574] Executing command 'gluster volume info 'glance' | grep 'network.remote-dio: True'' in directory '/root'
2017-10-27 20:06:06,792 [salt.state       ][INFO    ][32574] unless execution succeeded
2017-10-27 20:06:06,793 [salt.state       ][INFO    ][32574] Completed state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 20:06:06.792604 duration_in_ms=55.684
2017-10-27 20:06:06,793 [salt.state       ][INFO    ][32574] Running state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 20:06:06.793153
2017-10-27 20:06:06,793 [salt.state       ][INFO    ][32574] Executing state cmd.run for gluster volume set 'glance' 'nfs.disable' 'True'
2017-10-27 20:06:06,794 [salt.loaded.int.module.cmdmod][INFO    ][32574] Executing command 'gluster volume info 'glance' | grep 'nfs.disable: True'' in directory '/root'
2017-10-27 20:06:06,845 [salt.state       ][INFO    ][32574] unless execution succeeded
2017-10-27 20:06:06,845 [salt.state       ][INFO    ][32574] Completed state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 20:06:06.844950 duration_in_ms=51.796
2017-10-27 20:06:06,846 [salt.state       ][INFO    ][32574] Running state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 20:06:06.845563
2017-10-27 20:06:06,846 [salt.state       ][INFO    ][32574] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'
2017-10-27 20:06:06,846 [salt.loaded.int.module.cmdmod][INFO    ][32574] Executing command 'gluster volume info 'glance' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-10-27 20:06:06,897 [salt.state       ][INFO    ][32574] unless execution succeeded
2017-10-27 20:06:06,898 [salt.state       ][INFO    ][32574] Completed state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 20:06:06.897466 duration_in_ms=51.902
2017-10-27 20:06:06,898 [salt.state       ][INFO    ][32574] Running state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 20:06:06.898045
2017-10-27 20:06:06,898 [salt.state       ][INFO    ][32574] Executing state cmd.run for gluster volume set 'glance' 'cluster.readdir-optimize' 'True'
2017-10-27 20:06:06,899 [salt.loaded.int.module.cmdmod][INFO    ][32574] Executing command 'gluster volume info 'glance' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-10-27 20:06:06,950 [salt.state       ][INFO    ][32574] unless execution succeeded
2017-10-27 20:06:06,951 [salt.state       ][INFO    ][32574] Completed state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 20:06:06.950598 duration_in_ms=52.553
2017-10-27 20:06:06,952 [salt.state       ][INFO    ][32574] Running state [glance] at time 20:06:06.951939
2017-10-27 20:06:06,952 [salt.state       ][INFO    ][32574] Executing state glusterfs.started for glance
2017-10-27 20:06:06,953 [salt.loaded.int.module.cmdmod][INFO    ][32574] Executing command 'gluster --version' in directory '/root'
2017-10-27 20:06:06,961 [salt.loaded.int.module.cmdmod][INFO    ][32574] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 20:06:07,014 [salt.loaded.int.module.cmdmod][INFO    ][32574] Executing command 'gluster --version' in directory '/root'
2017-10-27 20:06:07,023 [salt.loaded.int.module.cmdmod][INFO    ][32574] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 20:06:07,082 [salt.state       ][INFO    ][32574] Volume glance is already started
2017-10-27 20:06:07,083 [salt.state       ][INFO    ][32574] Completed state [glance] at time 20:06:07.082701 duration_in_ms=130.762
2017-10-27 20:06:07,084 [salt.state       ][INFO    ][32574] Running state [keystone-keys] at time 20:06:07.083713
2017-10-27 20:06:07,084 [salt.state       ][INFO    ][32574] Executing state glusterfs.created for keystone-keys
2017-10-27 20:06:07,084 [salt.loaded.int.module.cmdmod][INFO    ][32574] Executing command 'gluster --version' in directory '/root'
2017-10-27 20:06:07,091 [salt.loaded.int.module.cmdmod][INFO    ][32574] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 20:06:07,143 [salt.loaded.int.module.cmdmod][INFO    ][32574] Executing command 'gluster --version' in directory '/root'
2017-10-27 20:06:07,151 [salt.loaded.int.module.cmdmod][INFO    ][32574] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 20:06:07,209 [salt.state       ][INFO    ][32574] Volume keystone-keys already exists and is started.
2017-10-27 20:06:07,209 [salt.state       ][INFO    ][32574] Completed state [keystone-keys] at time 20:06:07.209023 duration_in_ms=125.31
2017-10-27 20:06:07,213 [salt.state       ][INFO    ][32574] Running state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 20:06:07.212840
2017-10-27 20:06:07,213 [salt.state       ][INFO    ][32574] Executing state cmd.run for gluster volume set 'keystone-keys' 'network.remote-dio' 'True'
2017-10-27 20:06:07,214 [salt.loaded.int.module.cmdmod][INFO    ][32574] Executing command 'gluster volume info 'keystone-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-10-27 20:06:07,267 [salt.state       ][INFO    ][32574] unless execution succeeded
2017-10-27 20:06:07,268 [salt.state       ][INFO    ][32574] Completed state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 20:06:07.267057 duration_in_ms=54.208
2017-10-27 20:06:07,270 [salt.state       ][INFO    ][32574] Running state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 20:06:07.269991
2017-10-27 20:06:07,270 [salt.state       ][INFO    ][32574] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-10-27 20:06:07,272 [salt.loaded.int.module.cmdmod][INFO    ][32574] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-10-27 20:06:07,327 [salt.state       ][INFO    ][32574] unless execution succeeded
2017-10-27 20:06:07,327 [salt.state       ][INFO    ][32574] Completed state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 20:06:07.326858 duration_in_ms=56.866
2017-10-27 20:06:07,328 [salt.state       ][INFO    ][32574] Running state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 20:06:07.327602
2017-10-27 20:06:07,328 [salt.state       ][INFO    ][32574] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'
2017-10-27 20:06:07,328 [salt.loaded.int.module.cmdmod][INFO    ][32574] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-10-27 20:06:07,383 [salt.state       ][INFO    ][32574] unless execution succeeded
2017-10-27 20:06:07,383 [salt.state       ][INFO    ][32574] Completed state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 20:06:07.382843 duration_in_ms=55.241
2017-10-27 20:06:07,383 [salt.state       ][INFO    ][32574] Running state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 20:06:07.383437
2017-10-27 20:06:07,384 [salt.state       ][INFO    ][32574] Executing state cmd.run for gluster volume set 'keystone-keys' 'nfs.disable' 'True'
2017-10-27 20:06:07,384 [salt.loaded.int.module.cmdmod][INFO    ][32574] Executing command 'gluster volume info 'keystone-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-10-27 20:06:07,437 [salt.state       ][INFO    ][32574] unless execution succeeded
2017-10-27 20:06:07,437 [salt.state       ][INFO    ][32574] Completed state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 20:06:07.437071 duration_in_ms=53.633
2017-10-27 20:06:07,438 [salt.state       ][INFO    ][32574] Running state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 20:06:07.437724
2017-10-27 20:06:07,438 [salt.state       ][INFO    ][32574] Executing state cmd.run for gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'
2017-10-27 20:06:07,439 [salt.loaded.int.module.cmdmod][INFO    ][32574] Executing command 'gluster volume info 'keystone-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-10-27 20:06:07,492 [salt.state       ][INFO    ][32574] unless execution succeeded
2017-10-27 20:06:07,492 [salt.state       ][INFO    ][32574] Completed state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 20:06:07.492255 duration_in_ms=54.53
2017-10-27 20:06:07,493 [salt.state       ][INFO    ][32574] Running state [keystone-keys] at time 20:06:07.493438
2017-10-27 20:06:07,494 [salt.state       ][INFO    ][32574] Executing state glusterfs.started for keystone-keys
2017-10-27 20:06:07,494 [salt.loaded.int.module.cmdmod][INFO    ][32574] Executing command 'gluster --version' in directory '/root'
2017-10-27 20:06:07,503 [salt.loaded.int.module.cmdmod][INFO    ][32574] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 20:06:07,557 [salt.loaded.int.module.cmdmod][INFO    ][32574] Executing command 'gluster --version' in directory '/root'
2017-10-27 20:06:07,565 [salt.loaded.int.module.cmdmod][INFO    ][32574] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 20:06:07,625 [salt.state       ][INFO    ][32574] Volume keystone-keys is already started
2017-10-27 20:06:07,625 [salt.state       ][INFO    ][32574] Completed state [keystone-keys] at time 20:06:07.624739 duration_in_ms=131.301
2017-10-27 20:06:07,627 [salt.state       ][INFO    ][32574] Running state [nova_instances] at time 20:06:07.626483
2017-10-27 20:06:07,627 [salt.state       ][INFO    ][32574] Executing state glusterfs.created for nova_instances
2017-10-27 20:06:07,627 [salt.loaded.int.module.cmdmod][INFO    ][32574] Executing command 'gluster --version' in directory '/root'
2017-10-27 20:06:07,636 [salt.loaded.int.module.cmdmod][INFO    ][32574] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 20:06:07,687 [salt.loaded.int.module.cmdmod][INFO    ][32574] Executing command 'gluster --version' in directory '/root'
2017-10-27 20:06:07,695 [salt.loaded.int.module.cmdmod][INFO    ][32574] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 20:06:07,756 [salt.state       ][INFO    ][32574] Volume nova_instances already exists and is started.
2017-10-27 20:06:07,756 [salt.state       ][INFO    ][32574] Completed state [nova_instances] at time 20:06:07.755935 duration_in_ms=129.451
2017-10-27 20:06:07,760 [salt.state       ][INFO    ][32574] Running state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 20:06:07.759867
2017-10-27 20:06:07,760 [salt.state       ][INFO    ][32574] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'
2017-10-27 20:06:07,761 [salt.loaded.int.module.cmdmod][INFO    ][32574] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-10-27 20:06:07,814 [salt.state       ][INFO    ][32574] unless execution succeeded
2017-10-27 20:06:07,814 [salt.state       ][INFO    ][32574] Completed state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 20:06:07.814054 duration_in_ms=54.186
2017-10-27 20:06:07,815 [salt.state       ][INFO    ][32574] Running state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'On'] at time 20:06:07.814719
2017-10-27 20:06:07,815 [salt.state       ][INFO    ][32574] Executing state cmd.run for gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'On'
2017-10-27 20:06:07,816 [salt.loaded.int.module.cmdmod][INFO    ][32574] Executing command 'gluster volume info 'nova_instances' | grep 'cluster.readdir-optimize: On'' in directory '/root'
2017-10-27 20:06:07,867 [salt.state       ][INFO    ][32574] unless execution succeeded
2017-10-27 20:06:07,868 [salt.state       ][INFO    ][32574] Completed state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'On'] at time 20:06:07.867699 duration_in_ms=52.979
2017-10-27 20:06:07,868 [salt.state       ][INFO    ][32574] Running state [gluster volume set 'nova_instances' 'network.remote-dio' 'On'] at time 20:06:07.868316
2017-10-27 20:06:07,869 [salt.state       ][INFO    ][32574] Executing state cmd.run for gluster volume set 'nova_instances' 'network.remote-dio' 'On'
2017-10-27 20:06:07,869 [salt.loaded.int.module.cmdmod][INFO    ][32574] Executing command 'gluster volume info 'nova_instances' | grep 'network.remote-dio: On'' in directory '/root'
2017-10-27 20:06:07,923 [salt.state       ][INFO    ][32574] unless execution succeeded
2017-10-27 20:06:07,924 [salt.state       ][INFO    ][32574] Completed state [gluster volume set 'nova_instances' 'network.remote-dio' 'On'] at time 20:06:07.923546 duration_in_ms=55.229
2017-10-27 20:06:07,924 [salt.state       ][INFO    ][32574] Running state [gluster volume set 'nova_instances' 'nfs.disable' 'On'] at time 20:06:07.924061
2017-10-27 20:06:07,924 [salt.state       ][INFO    ][32574] Executing state cmd.run for gluster volume set 'nova_instances' 'nfs.disable' 'On'
2017-10-27 20:06:07,925 [salt.loaded.int.module.cmdmod][INFO    ][32574] Executing command 'gluster volume info 'nova_instances' | grep 'nfs.disable: On'' in directory '/root'
2017-10-27 20:06:07,978 [salt.state       ][INFO    ][32574] unless execution succeeded
2017-10-27 20:06:07,978 [salt.state       ][INFO    ][32574] Completed state [gluster volume set 'nova_instances' 'nfs.disable' 'On'] at time 20:06:07.978059 duration_in_ms=53.998
2017-10-27 20:06:07,979 [salt.state       ][INFO    ][32574] Running state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 20:06:07.978636
2017-10-27 20:06:07,979 [salt.state       ][INFO    ][32574] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'
2017-10-27 20:06:07,979 [salt.loaded.int.module.cmdmod][INFO    ][32574] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-10-27 20:06:08,030 [salt.state       ][INFO    ][32574] unless execution succeeded
2017-10-27 20:06:08,030 [salt.state       ][INFO    ][32574] Completed state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 20:06:08.030145 duration_in_ms=51.508
2017-10-27 20:06:08,031 [salt.state       ][INFO    ][32574] Running state [nova_instances] at time 20:06:08.031432
2017-10-27 20:06:08,032 [salt.state       ][INFO    ][32574] Executing state glusterfs.started for nova_instances
2017-10-27 20:06:08,032 [salt.loaded.int.module.cmdmod][INFO    ][32574] Executing command 'gluster --version' in directory '/root'
2017-10-27 20:06:08,041 [salt.loaded.int.module.cmdmod][INFO    ][32574] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 20:06:08,096 [salt.loaded.int.module.cmdmod][INFO    ][32574] Executing command 'gluster --version' in directory '/root'
2017-10-27 20:06:08,103 [salt.loaded.int.module.cmdmod][INFO    ][32574] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 20:06:08,162 [salt.state       ][INFO    ][32574] Volume nova_instances is already started
2017-10-27 20:06:08,163 [salt.state       ][INFO    ][32574] Completed state [nova_instances] at time 20:06:08.162539 duration_in_ms=131.107
2017-10-27 20:06:08,164 [salt.state       ][INFO    ][32574] Running state [keystone-credential-keys] at time 20:06:08.163831
2017-10-27 20:06:08,164 [salt.state       ][INFO    ][32574] Executing state glusterfs.created for keystone-credential-keys
2017-10-27 20:06:08,165 [salt.loaded.int.module.cmdmod][INFO    ][32574] Executing command 'gluster --version' in directory '/root'
2017-10-27 20:06:08,173 [salt.loaded.int.module.cmdmod][INFO    ][32574] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 20:06:08,225 [salt.loaded.int.module.cmdmod][INFO    ][32574] Executing command 'gluster --version' in directory '/root'
2017-10-27 20:06:08,232 [salt.loaded.int.module.cmdmod][INFO    ][32574] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 20:06:08,289 [salt.state       ][INFO    ][32574] Volume keystone-credential-keys already exists and is started.
2017-10-27 20:06:08,290 [salt.state       ][INFO    ][32574] Completed state [keystone-credential-keys] at time 20:06:08.289709 duration_in_ms=125.877
2017-10-27 20:06:08,294 [salt.state       ][INFO    ][32574] Running state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 20:06:08.293714
2017-10-27 20:06:08,294 [salt.state       ][INFO    ][32574] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'
2017-10-27 20:06:08,294 [salt.loaded.int.module.cmdmod][INFO    ][32574] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-10-27 20:06:08,346 [salt.state       ][INFO    ][32574] unless execution succeeded
2017-10-27 20:06:08,346 [salt.state       ][INFO    ][32574] Completed state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 20:06:08.346096 duration_in_ms=52.381
2017-10-27 20:06:08,347 [salt.state       ][INFO    ][32574] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 20:06:08.346635
2017-10-27 20:06:08,347 [salt.state       ][INFO    ][32574] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-10-27 20:06:08,347 [salt.loaded.int.module.cmdmod][INFO    ][32574] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-10-27 20:06:08,403 [salt.state       ][INFO    ][32574] unless execution succeeded
2017-10-27 20:06:08,403 [salt.state       ][INFO    ][32574] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 20:06:08.403132 duration_in_ms=56.496
2017-10-27 20:06:08,404 [salt.state       ][INFO    ][32574] Running state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 20:06:08.403718
2017-10-27 20:06:08,404 [salt.state       ][INFO    ][32574] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'
2017-10-27 20:06:08,404 [salt.loaded.int.module.cmdmod][INFO    ][32574] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-10-27 20:06:08,455 [salt.state       ][INFO    ][32574] unless execution succeeded
2017-10-27 20:06:08,456 [salt.state       ][INFO    ][32574] Completed state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 20:06:08.455692 duration_in_ms=51.974
2017-10-27 20:06:08,456 [salt.state       ][INFO    ][32574] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 20:06:08.456217
2017-10-27 20:06:08,456 [salt.state       ][INFO    ][32574] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'
2017-10-27 20:06:08,457 [salt.loaded.int.module.cmdmod][INFO    ][32574] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-10-27 20:06:08,509 [salt.state       ][INFO    ][32574] unless execution succeeded
2017-10-27 20:06:08,509 [salt.state       ][INFO    ][32574] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 20:06:08.509101 duration_in_ms=52.884
2017-10-27 20:06:08,510 [salt.state       ][INFO    ][32574] Running state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 20:06:08.509766
2017-10-27 20:06:08,510 [salt.state       ][INFO    ][32574] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'
2017-10-27 20:06:08,511 [salt.loaded.int.module.cmdmod][INFO    ][32574] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-10-27 20:06:08,563 [salt.state       ][INFO    ][32574] unless execution succeeded
2017-10-27 20:06:08,564 [salt.state       ][INFO    ][32574] Completed state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 20:06:08.563591 duration_in_ms=53.825
2017-10-27 20:06:08,565 [salt.state       ][INFO    ][32574] Running state [keystone-credential-keys] at time 20:06:08.564864
2017-10-27 20:06:08,565 [salt.state       ][INFO    ][32574] Executing state glusterfs.started for keystone-credential-keys
2017-10-27 20:06:08,566 [salt.loaded.int.module.cmdmod][INFO    ][32574] Executing command 'gluster --version' in directory '/root'
2017-10-27 20:06:08,573 [salt.loaded.int.module.cmdmod][INFO    ][32574] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 20:06:08,625 [salt.loaded.int.module.cmdmod][INFO    ][32574] Executing command 'gluster --version' in directory '/root'
2017-10-27 20:06:08,633 [salt.loaded.int.module.cmdmod][INFO    ][32574] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 20:06:08,691 [salt.state       ][INFO    ][32574] Volume keystone-credential-keys is already started
2017-10-27 20:06:08,692 [salt.state       ][INFO    ][32574] Completed state [keystone-credential-keys] at time 20:06:08.691698 duration_in_ms=126.834
2017-10-27 20:06:08,694 [salt.minion      ][INFO    ][32574] Returning information for job: 20171027200602834442
2017-10-27 20:06:13,945 [salt.minion      ][INFO    ][25322] User sudo_ubuntu Executing command test.ping with jid 20171027200613929097
2017-10-27 20:06:13,957 [salt.minion      ][INFO    ][32999] Starting a new job with PID 32999
2017-10-27 20:06:13,991 [salt.minion      ][INFO    ][32999] Returning information for job: 20171027200613929097
2017-10-27 20:06:14,477 [salt.minion      ][INFO    ][25322] User sudo_ubuntu Executing command cmd.run with jid 20171027200614463147
2017-10-27 20:06:14,487 [salt.minion      ][INFO    ][33004] Starting a new job with PID 33004
2017-10-27 20:06:14,491 [salt.loaded.int.module.cmdmod][INFO    ][33004] Executing command 'gluster peer status; gluster volume status' in directory '/root'
2017-10-27 20:06:14,609 [salt.minion      ][INFO    ][33004] Returning information for job: 20171027200614463147
2017-10-27 20:46:11,327 [salt.minion      ][INFO    ][25322] User sudo_ubuntu Executing command test.ping with jid 20171027204611312459
2017-10-27 20:46:11,343 [salt.minion      ][INFO    ][33798] Starting a new job with PID 33798
2017-10-27 20:46:11,386 [salt.minion      ][INFO    ][33798] Returning information for job: 20171027204611312459
2017-10-27 20:46:14,878 [salt.minion      ][INFO    ][25322] User sudo_ubuntu Executing command state.sls with jid 20171027204614861042
2017-10-27 20:46:14,890 [salt.minion      ][INFO    ][33803] Starting a new job with PID 33803
2017-10-27 20:46:15,454 [salt.state       ][INFO    ][33803] Loading fresh modules for state activity
2017-10-27 20:46:15,486 [salt.fileclient  ][INFO    ][33803] Fetching file from saltenv 'base', ** done ** 'keepalived/init.sls'
2017-10-27 20:46:15,504 [salt.fileclient  ][INFO    ][33803] Fetching file from saltenv 'base', ** done ** 'keepalived/cluster.sls'
2017-10-27 20:46:15,532 [salt.fileclient  ][INFO    ][33803] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-10-27 20:46:15,851 [salt.state       ][INFO    ][33803] Running state [lsof] at time 20:46:15.850587
2017-10-27 20:46:15,851 [salt.state       ][INFO    ][33803] Executing state pkg.installed for lsof
2017-10-27 20:46:15,851 [salt.loaded.int.module.cmdmod][INFO    ][33803] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-10-27 20:46:16,185 [salt.state       ][INFO    ][33803] Package lsof is already installed
2017-10-27 20:46:16,185 [salt.state       ][INFO    ][33803] Completed state [lsof] at time 20:46:16.184827 duration_in_ms=334.24
2017-10-27 20:46:16,185 [salt.state       ][INFO    ][33803] Running state [keepalived] at time 20:46:16.185095
2017-10-27 20:46:16,185 [salt.state       ][INFO    ][33803] Executing state pkg.installed for keepalived
2017-10-27 20:46:16,189 [salt.state       ][INFO    ][33803] Package keepalived is already installed
2017-10-27 20:46:16,190 [salt.state       ][INFO    ][33803] Completed state [keepalived] at time 20:46:16.189504 duration_in_ms=4.409
2017-10-27 20:46:16,191 [salt.state       ][INFO    ][33803] Running state [/etc/keepalived/keepalived.conf] at time 20:46:16.191226
2017-10-27 20:46:16,191 [salt.state       ][INFO    ][33803] Executing state file.managed for /etc/keepalived/keepalived.conf
2017-10-27 20:46:16,220 [salt.fileclient  ][INFO    ][33803] Fetching file from saltenv 'base', ** done ** 'keepalived/files/keepalived.conf'
2017-10-27 20:46:16,265 [salt.fileclient  ][INFO    ][33803] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-10-27 20:46:16,272 [salt.state       ][INFO    ][33803] File /etc/keepalived/keepalived.conf is in the correct state
2017-10-27 20:46:16,272 [salt.state       ][INFO    ][33803] Completed state [/etc/keepalived/keepalived.conf] at time 20:46:16.271853 duration_in_ms=80.627
2017-10-27 20:46:16,273 [salt.state       ][INFO    ][33803] Running state [keepalived] at time 20:46:16.272532
2017-10-27 20:46:16,273 [salt.state       ][INFO    ][33803] Executing state service.running for keepalived
2017-10-27 20:46:16,273 [salt.loaded.int.module.cmdmod][INFO    ][33803] Executing command ['systemctl', 'status', 'keepalived.service', '-n', '0'] in directory '/root'
2017-10-27 20:46:16,289 [salt.loaded.int.module.cmdmod][INFO    ][33803] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2017-10-27 20:46:16,297 [salt.loaded.int.module.cmdmod][INFO    ][33803] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-10-27 20:46:16,304 [salt.state       ][INFO    ][33803] The service keepalived is already running
2017-10-27 20:46:16,305 [salt.state       ][INFO    ][33803] Completed state [keepalived] at time 20:46:16.304725 duration_in_ms=32.193
2017-10-27 20:46:16,306 [salt.minion      ][INFO    ][33803] Returning information for job: 20171027204614861042
2017-10-27 20:46:49,263 [salt.minion      ][INFO    ][25322] User sudo_ubuntu Executing command pillar.get with jid 20171027204649246891
2017-10-27 20:46:49,277 [salt.minion      ][INFO    ][33844] Starting a new job with PID 33844
2017-10-27 20:46:49,284 [salt.minion      ][INFO    ][33844] Returning information for job: 20171027204649246891
2017-10-27 20:47:39,833 [salt.minion      ][INFO    ][25322] User sudo_ubuntu Executing command state.sls with jid 20171027204739817899
2017-10-27 20:47:39,844 [salt.minion      ][INFO    ][33859] Starting a new job with PID 33859
2017-10-27 20:47:42,422 [salt.state       ][INFO    ][33859] Loading fresh modules for state activity
2017-10-27 20:47:42,447 [salt.fileclient  ][INFO    ][33859] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-10-27 20:47:42,469 [salt.fileclient  ][INFO    ][33859] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-10-27 20:47:42,784 [salt.state       ][INFO    ][33859] Running state [attr] at time 20:47:42.783903
2017-10-27 20:47:42,784 [salt.state       ][INFO    ][33859] Executing state pkg.installed for attr
2017-10-27 20:47:42,785 [salt.loaded.int.module.cmdmod][INFO    ][33859] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-10-27 20:47:43,075 [salt.state       ][INFO    ][33859] Package attr is already installed
2017-10-27 20:47:43,076 [salt.state       ][INFO    ][33859] Completed state [attr] at time 20:47:43.075501 duration_in_ms=291.585
2017-10-27 20:47:43,076 [salt.state       ][INFO    ][33859] Running state [glusterfs-server] at time 20:47:43.075789
2017-10-27 20:47:43,076 [salt.state       ][INFO    ][33859] Executing state pkg.installed for glusterfs-server
2017-10-27 20:47:43,080 [salt.state       ][INFO    ][33859] Package glusterfs-server is already installed
2017-10-27 20:47:43,080 [salt.state       ][INFO    ][33859] Completed state [glusterfs-server] at time 20:47:43.080089 duration_in_ms=4.3
2017-10-27 20:47:43,080 [salt.state       ][INFO    ][33859] Running state [bc] at time 20:47:43.080286
2017-10-27 20:47:43,080 [salt.state       ][INFO    ][33859] Executing state pkg.installed for bc
2017-10-27 20:47:43,084 [salt.state       ][INFO    ][33859] Package bc is already installed
2017-10-27 20:47:43,084 [salt.state       ][INFO    ][33859] Completed state [bc] at time 20:47:43.084278 duration_in_ms=3.992
2017-10-27 20:47:43,085 [salt.state       ][INFO    ][33859] Running state [glusterfs-server] at time 20:47:43.085120
2017-10-27 20:47:43,085 [salt.state       ][INFO    ][33859] Executing state service.running for glusterfs-server
2017-10-27 20:47:43,086 [salt.loaded.int.module.cmdmod][INFO    ][33859] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-10-27 20:47:43,103 [salt.loaded.int.module.cmdmod][INFO    ][33859] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-10-27 20:47:43,111 [salt.loaded.int.module.cmdmod][INFO    ][33859] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-10-27 20:47:43,120 [salt.state       ][INFO    ][33859] The service glusterfs-server is already running
2017-10-27 20:47:43,121 [salt.state       ][INFO    ][33859] Completed state [glusterfs-server] at time 20:47:43.120512 duration_in_ms=35.391
2017-10-27 20:47:43,122 [salt.state       ][INFO    ][33859] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 20:47:43.122033
2017-10-27 20:47:43,122 [salt.state       ][INFO    ][33859] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-10-27 20:47:43,124 [salt.state       ][INFO    ][33859] File /etc/systemd/system/glusterfs-server.service.d/override.conf is in the correct state
2017-10-27 20:47:43,124 [salt.state       ][INFO    ][33859] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 20:47:43.124394 duration_in_ms=2.361
2017-10-27 20:47:43,125 [salt.state       ][INFO    ][33859] Running state [/srv/glusterfs/glance] at time 20:47:43.124572
2017-10-27 20:47:43,125 [salt.state       ][INFO    ][33859] Executing state file.directory for /srv/glusterfs/glance
2017-10-27 20:47:43,125 [salt.state       ][INFO    ][33859] Directory /srv/glusterfs/glance is in the correct state
2017-10-27 20:47:43,125 [salt.state       ][INFO    ][33859] Completed state [/srv/glusterfs/glance] at time 20:47:43.125323 duration_in_ms=0.751
2017-10-27 20:47:43,126 [salt.state       ][INFO    ][33859] Running state [/srv/glusterfs/keystone-keys] at time 20:47:43.125495
2017-10-27 20:47:43,126 [salt.state       ][INFO    ][33859] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-10-27 20:47:43,126 [salt.state       ][INFO    ][33859] Directory /srv/glusterfs/keystone-keys is in the correct state
2017-10-27 20:47:43,126 [salt.state       ][INFO    ][33859] Completed state [/srv/glusterfs/keystone-keys] at time 20:47:43.126209 duration_in_ms=0.715
2017-10-27 20:47:43,126 [salt.state       ][INFO    ][33859] Running state [/srv/glusterfs/nova_instances] at time 20:47:43.126386
2017-10-27 20:47:43,127 [salt.state       ][INFO    ][33859] Executing state file.directory for /srv/glusterfs/nova_instances
2017-10-27 20:47:43,127 [salt.state       ][INFO    ][33859] Directory /srv/glusterfs/nova_instances is in the correct state
2017-10-27 20:47:43,127 [salt.state       ][INFO    ][33859] Completed state [/srv/glusterfs/nova_instances] at time 20:47:43.127035 duration_in_ms=0.649
2017-10-27 20:47:43,127 [salt.state       ][INFO    ][33859] Running state [/srv/glusterfs/keystone-credential-keys] at time 20:47:43.127269
2017-10-27 20:47:43,128 [salt.state       ][INFO    ][33859] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-10-27 20:47:43,128 [salt.state       ][INFO    ][33859] Directory /srv/glusterfs/keystone-credential-keys is in the correct state
2017-10-27 20:47:43,128 [salt.state       ][INFO    ][33859] Completed state [/srv/glusterfs/keystone-credential-keys] at time 20:47:43.128026 duration_in_ms=0.757
2017-10-27 20:47:43,129 [salt.minion      ][INFO    ][33859] Returning information for job: 20171027204739817899
2017-10-27 20:47:44,495 [salt.minion      ][INFO    ][25322] User sudo_ubuntu Executing command test.ping with jid 20171027204744475551
2017-10-27 20:47:44,510 [salt.minion      ][INFO    ][33882] Starting a new job with PID 33882
2017-10-27 20:47:44,546 [salt.minion      ][INFO    ][33882] Returning information for job: 20171027204744475551
2017-10-27 20:47:51,502 [salt.minion      ][INFO    ][25322] User sudo_ubuntu Executing command state.sls with jid 20171027204751482272
2017-10-27 20:47:51,519 [salt.minion      ][INFO    ][33887] Starting a new job with PID 33887
2017-10-27 20:47:52,112 [salt.state       ][INFO    ][33887] Loading fresh modules for state activity
2017-10-27 20:47:52,140 [salt.fileclient  ][INFO    ][33887] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/setup.sls'
2017-10-27 20:47:52,182 [salt.fileclient  ][INFO    ][33887] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-10-27 20:47:52,268 [salt.fileclient  ][INFO    ][33887] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-10-27 20:47:52,291 [salt.fileclient  ][INFO    ][33887] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-10-27 20:47:52,610 [salt.state       ][INFO    ][33887] Running state [attr] at time 20:47:52.610382
2017-10-27 20:47:52,611 [salt.state       ][INFO    ][33887] Executing state pkg.installed for attr
2017-10-27 20:47:52,611 [salt.loaded.int.module.cmdmod][INFO    ][33887] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-10-27 20:47:52,895 [salt.state       ][INFO    ][33887] Package attr is already installed
2017-10-27 20:47:52,895 [salt.state       ][INFO    ][33887] Completed state [attr] at time 20:47:52.894860 duration_in_ms=284.477
2017-10-27 20:47:52,895 [salt.state       ][INFO    ][33887] Running state [glusterfs-server] at time 20:47:52.895172
2017-10-27 20:47:52,895 [salt.state       ][INFO    ][33887] Executing state pkg.installed for glusterfs-server
2017-10-27 20:47:52,899 [salt.state       ][INFO    ][33887] Package glusterfs-server is already installed
2017-10-27 20:47:52,899 [salt.state       ][INFO    ][33887] Completed state [glusterfs-server] at time 20:47:52.899277 duration_in_ms=4.105
2017-10-27 20:47:52,900 [salt.state       ][INFO    ][33887] Running state [bc] at time 20:47:52.899477
2017-10-27 20:47:52,900 [salt.state       ][INFO    ][33887] Executing state pkg.installed for bc
2017-10-27 20:47:52,904 [salt.state       ][INFO    ][33887] Package bc is already installed
2017-10-27 20:47:52,904 [salt.state       ][INFO    ][33887] Completed state [bc] at time 20:47:52.903681 duration_in_ms=4.191
2017-10-27 20:47:52,905 [salt.state       ][INFO    ][33887] Running state [glusterfs-server] at time 20:47:52.904684
2017-10-27 20:47:52,905 [salt.state       ][INFO    ][33887] Executing state service.running for glusterfs-server
2017-10-27 20:47:52,905 [salt.loaded.int.module.cmdmod][INFO    ][33887] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-10-27 20:47:52,922 [salt.loaded.int.module.cmdmod][INFO    ][33887] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-10-27 20:47:52,929 [salt.loaded.int.module.cmdmod][INFO    ][33887] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-10-27 20:47:52,939 [salt.state       ][INFO    ][33887] The service glusterfs-server is already running
2017-10-27 20:47:52,940 [salt.state       ][INFO    ][33887] Completed state [glusterfs-server] at time 20:47:52.939720 duration_in_ms=35.034
2017-10-27 20:47:52,941 [salt.state       ][INFO    ][33887] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 20:47:52.941298
2017-10-27 20:47:52,942 [salt.state       ][INFO    ][33887] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-10-27 20:47:52,944 [salt.state       ][INFO    ][33887] File /etc/systemd/system/glusterfs-server.service.d/override.conf is in the correct state
2017-10-27 20:47:52,944 [salt.state       ][INFO    ][33887] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 20:47:52.943804 duration_in_ms=2.506
2017-10-27 20:47:52,944 [salt.state       ][INFO    ][33887] Running state [/srv/glusterfs/glance] at time 20:47:52.944001
2017-10-27 20:47:52,944 [salt.state       ][INFO    ][33887] Executing state file.directory for /srv/glusterfs/glance
2017-10-27 20:47:52,945 [salt.state       ][INFO    ][33887] Directory /srv/glusterfs/glance is in the correct state
2017-10-27 20:47:52,945 [salt.state       ][INFO    ][33887] Completed state [/srv/glusterfs/glance] at time 20:47:52.944719 duration_in_ms=0.718
2017-10-27 20:47:52,945 [salt.state       ][INFO    ][33887] Running state [/srv/glusterfs/keystone-keys] at time 20:47:52.944871
2017-10-27 20:47:52,945 [salt.state       ][INFO    ][33887] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-10-27 20:47:52,945 [salt.state       ][INFO    ][33887] Directory /srv/glusterfs/keystone-keys is in the correct state
2017-10-27 20:47:52,946 [salt.state       ][INFO    ][33887] Completed state [/srv/glusterfs/keystone-keys] at time 20:47:52.945576 duration_in_ms=0.704
2017-10-27 20:47:52,946 [salt.state       ][INFO    ][33887] Running state [/srv/glusterfs/nova_instances] at time 20:47:52.945757
2017-10-27 20:47:52,946 [salt.state       ][INFO    ][33887] Executing state file.directory for /srv/glusterfs/nova_instances
2017-10-27 20:47:52,946 [salt.state       ][INFO    ][33887] Directory /srv/glusterfs/nova_instances is in the correct state
2017-10-27 20:47:52,946 [salt.state       ][INFO    ][33887] Completed state [/srv/glusterfs/nova_instances] at time 20:47:52.946470 duration_in_ms=0.714
2017-10-27 20:47:52,947 [salt.state       ][INFO    ][33887] Running state [/srv/glusterfs/keystone-credential-keys] at time 20:47:52.946625
2017-10-27 20:47:52,947 [salt.state       ][INFO    ][33887] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-10-27 20:47:52,947 [salt.state       ][INFO    ][33887] Directory /srv/glusterfs/keystone-credential-keys is in the correct state
2017-10-27 20:47:52,947 [salt.state       ][INFO    ][33887] Completed state [/srv/glusterfs/keystone-credential-keys] at time 20:47:52.947342 duration_in_ms=0.717
2017-10-27 20:47:52,990 [salt.loaded.int.module.cmdmod][INFO    ][33887] Executing command ['git', '--version'] in directory '/root'
2017-10-27 20:47:53,088 [salt.state       ][INFO    ][33887] Running state [sleep 5] at time 20:47:53.087462
2017-10-27 20:47:53,088 [salt.state       ][INFO    ][33887] Executing state cmd.wait for sleep 5
2017-10-27 20:47:53,088 [salt.state       ][INFO    ][33887] No changes made for sleep 5
2017-10-27 20:47:53,088 [salt.state       ][INFO    ][33887] Completed state [sleep 5] at time 20:47:53.088117 duration_in_ms=0.655
2017-10-27 20:47:53,089 [salt.state       ][INFO    ][33887] Running state [192.168.10.143] at time 20:47:53.088610
2017-10-27 20:47:53,089 [salt.state       ][INFO    ][33887] Executing state glusterfs.peered for 192.168.10.143
2017-10-27 20:47:53,089 [salt.loaded.int.module.cmdmod][INFO    ][33887] Executing command 'gluster --version' in directory '/root'
2017-10-27 20:47:53,098 [salt.loaded.int.module.cmdmod][INFO    ][33887] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 20:47:53,151 [salt.loaded.int.module.cmdmod][INFO    ][33887] Executing command 'gluster --version' in directory '/root'
2017-10-27 20:47:53,161 [salt.loaded.int.module.cmdmod][INFO    ][33887] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 20:47:53,215 [salt.loaded.int.module.cmdmod][INFO    ][33887] Executing command 'gluster --version' in directory '/root'
2017-10-27 20:47:53,223 [salt.loaded.int.module.cmdmod][INFO    ][33887] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 20:47:53,277 [salt.loaded.int.module.cmdmod][INFO    ][33887] Executing command 'gluster --version' in directory '/root'
2017-10-27 20:47:53,285 [salt.loaded.int.module.cmdmod][INFO    ][33887] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 20:47:53,339 [salt.state       ][INFO    ][33887] Peering with localhost is not needed
2017-10-27 20:47:53,339 [salt.state       ][INFO    ][33887] Completed state [192.168.10.143] at time 20:47:53.338779 duration_in_ms=250.167
2017-10-27 20:47:53,342 [salt.state       ][INFO    ][33887] Running state [192.168.10.142] at time 20:47:53.342147
2017-10-27 20:47:53,342 [salt.state       ][INFO    ][33887] Executing state glusterfs.peered for 192.168.10.142
2017-10-27 20:47:53,343 [salt.loaded.int.module.cmdmod][INFO    ][33887] Executing command 'gluster --version' in directory '/root'
2017-10-27 20:47:53,351 [salt.loaded.int.module.cmdmod][INFO    ][33887] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 20:47:53,406 [salt.state       ][INFO    ][33887] Host 192.168.10.142 already peered
2017-10-27 20:47:53,406 [salt.state       ][INFO    ][33887] Completed state [192.168.10.142] at time 20:47:53.406417 duration_in_ms=64.269
2017-10-27 20:47:53,410 [salt.state       ][INFO    ][33887] Running state [192.168.10.141] at time 20:47:53.409539
2017-10-27 20:47:53,410 [salt.state       ][INFO    ][33887] Executing state glusterfs.peered for 192.168.10.141
2017-10-27 20:47:53,410 [salt.loaded.int.module.cmdmod][INFO    ][33887] Executing command 'gluster --version' in directory '/root'
2017-10-27 20:47:53,419 [salt.loaded.int.module.cmdmod][INFO    ][33887] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 20:47:53,472 [salt.state       ][INFO    ][33887] Host 192.168.10.141 already peered
2017-10-27 20:47:53,473 [salt.state       ][INFO    ][33887] Completed state [192.168.10.141] at time 20:47:53.472519 duration_in_ms=62.98
2017-10-27 20:47:53,473 [salt.state       ][INFO    ][33887] Running state [glance] at time 20:47:53.473452
2017-10-27 20:47:53,474 [salt.state       ][INFO    ][33887] Executing state glusterfs.created for glance
2017-10-27 20:47:53,474 [salt.loaded.int.module.cmdmod][INFO    ][33887] Executing command 'gluster --version' in directory '/root'
2017-10-27 20:47:53,482 [salt.loaded.int.module.cmdmod][INFO    ][33887] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 20:47:53,536 [salt.loaded.int.module.cmdmod][INFO    ][33887] Executing command 'gluster --version' in directory '/root'
2017-10-27 20:47:53,544 [salt.loaded.int.module.cmdmod][INFO    ][33887] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 20:47:53,602 [salt.state       ][INFO    ][33887] Volume glance already exists and is started.
2017-10-27 20:47:53,602 [salt.state       ][INFO    ][33887] Completed state [glance] at time 20:47:53.602120 duration_in_ms=128.668
2017-10-27 20:47:53,606 [salt.state       ][INFO    ][33887] Running state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 20:47:53.606078
2017-10-27 20:47:53,606 [salt.state       ][INFO    ][33887] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'
2017-10-27 20:47:53,607 [salt.loaded.int.module.cmdmod][INFO    ][33887] Executing command 'gluster volume info 'glance' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-10-27 20:47:53,662 [salt.state       ][INFO    ][33887] unless execution succeeded
2017-10-27 20:47:53,662 [salt.state       ][INFO    ][33887] Completed state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 20:47:53.662352 duration_in_ms=56.274
2017-10-27 20:47:53,663 [salt.state       ][INFO    ][33887] Running state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 20:47:53.662892
2017-10-27 20:47:53,663 [salt.state       ][INFO    ][33887] Executing state cmd.run for gluster volume set 'glance' 'network.remote-dio' 'True'
2017-10-27 20:47:53,664 [salt.loaded.int.module.cmdmod][INFO    ][33887] Executing command 'gluster volume info 'glance' | grep 'network.remote-dio: True'' in directory '/root'
2017-10-27 20:47:53,716 [salt.state       ][INFO    ][33887] unless execution succeeded
2017-10-27 20:47:53,716 [salt.state       ][INFO    ][33887] Completed state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 20:47:53.716360 duration_in_ms=53.468
2017-10-27 20:47:53,717 [salt.state       ][INFO    ][33887] Running state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 20:47:53.716909
2017-10-27 20:47:53,717 [salt.state       ][INFO    ][33887] Executing state cmd.run for gluster volume set 'glance' 'nfs.disable' 'True'
2017-10-27 20:47:53,718 [salt.loaded.int.module.cmdmod][INFO    ][33887] Executing command 'gluster volume info 'glance' | grep 'nfs.disable: True'' in directory '/root'
2017-10-27 20:47:53,769 [salt.state       ][INFO    ][33887] unless execution succeeded
2017-10-27 20:47:53,770 [salt.state       ][INFO    ][33887] Completed state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 20:47:53.769493 duration_in_ms=52.582
2017-10-27 20:47:53,770 [salt.state       ][INFO    ][33887] Running state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 20:47:53.770082
2017-10-27 20:47:53,770 [salt.state       ][INFO    ][33887] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'
2017-10-27 20:47:53,771 [salt.loaded.int.module.cmdmod][INFO    ][33887] Executing command 'gluster volume info 'glance' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-10-27 20:47:53,823 [salt.state       ][INFO    ][33887] unless execution succeeded
2017-10-27 20:47:53,823 [salt.state       ][INFO    ][33887] Completed state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 20:47:53.823062 duration_in_ms=52.98
2017-10-27 20:47:53,824 [salt.state       ][INFO    ][33887] Running state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 20:47:53.823690
2017-10-27 20:47:53,824 [salt.state       ][INFO    ][33887] Executing state cmd.run for gluster volume set 'glance' 'cluster.readdir-optimize' 'True'
2017-10-27 20:47:53,824 [salt.loaded.int.module.cmdmod][INFO    ][33887] Executing command 'gluster volume info 'glance' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-10-27 20:47:53,879 [salt.state       ][INFO    ][33887] unless execution succeeded
2017-10-27 20:47:53,879 [salt.state       ][INFO    ][33887] Completed state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 20:47:53.878761 duration_in_ms=55.069
2017-10-27 20:47:53,880 [salt.state       ][INFO    ][33887] Running state [glance] at time 20:47:53.880013
2017-10-27 20:47:53,880 [salt.state       ][INFO    ][33887] Executing state glusterfs.started for glance
2017-10-27 20:47:53,881 [salt.loaded.int.module.cmdmod][INFO    ][33887] Executing command 'gluster --version' in directory '/root'
2017-10-27 20:47:53,889 [salt.loaded.int.module.cmdmod][INFO    ][33887] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 20:47:53,944 [salt.loaded.int.module.cmdmod][INFO    ][33887] Executing command 'gluster --version' in directory '/root'
2017-10-27 20:47:53,954 [salt.loaded.int.module.cmdmod][INFO    ][33887] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 20:47:54,019 [salt.state       ][INFO    ][33887] Volume glance is already started
2017-10-27 20:47:54,019 [salt.state       ][INFO    ][33887] Completed state [glance] at time 20:47:54.018746 duration_in_ms=138.732
2017-10-27 20:47:54,020 [salt.state       ][INFO    ][33887] Running state [keystone-keys] at time 20:47:54.019791
2017-10-27 20:47:54,020 [salt.state       ][INFO    ][33887] Executing state glusterfs.created for keystone-keys
2017-10-27 20:47:54,021 [salt.loaded.int.module.cmdmod][INFO    ][33887] Executing command 'gluster --version' in directory '/root'
2017-10-27 20:47:54,029 [salt.loaded.int.module.cmdmod][INFO    ][33887] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 20:47:54,081 [salt.loaded.int.module.cmdmod][INFO    ][33887] Executing command 'gluster --version' in directory '/root'
2017-10-27 20:47:54,089 [salt.loaded.int.module.cmdmod][INFO    ][33887] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 20:47:54,149 [salt.state       ][INFO    ][33887] Volume keystone-keys already exists and is started.
2017-10-27 20:47:54,149 [salt.state       ][INFO    ][33887] Completed state [keystone-keys] at time 20:47:54.148829 duration_in_ms=129.026
2017-10-27 20:47:54,153 [salt.state       ][INFO    ][33887] Running state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 20:47:54.152845
2017-10-27 20:47:54,153 [salt.state       ][INFO    ][33887] Executing state cmd.run for gluster volume set 'keystone-keys' 'network.remote-dio' 'True'
2017-10-27 20:47:54,154 [salt.loaded.int.module.cmdmod][INFO    ][33887] Executing command 'gluster volume info 'keystone-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-10-27 20:47:54,205 [salt.state       ][INFO    ][33887] unless execution succeeded
2017-10-27 20:47:54,206 [salt.state       ][INFO    ][33887] Completed state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 20:47:54.205693 duration_in_ms=52.848
2017-10-27 20:47:54,206 [salt.state       ][INFO    ][33887] Running state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 20:47:54.206202
2017-10-27 20:47:54,206 [salt.state       ][INFO    ][33887] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-10-27 20:47:54,207 [salt.loaded.int.module.cmdmod][INFO    ][33887] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-10-27 20:47:54,262 [salt.state       ][INFO    ][33887] unless execution succeeded
2017-10-27 20:47:54,262 [salt.state       ][INFO    ][33887] Completed state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 20:47:54.261911 duration_in_ms=55.709
2017-10-27 20:47:54,262 [salt.state       ][INFO    ][33887] Running state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 20:47:54.262465
2017-10-27 20:47:54,263 [salt.state       ][INFO    ][33887] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'
2017-10-27 20:47:54,265 [salt.loaded.int.module.cmdmod][INFO    ][33887] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-10-27 20:47:54,318 [salt.state       ][INFO    ][33887] unless execution succeeded
2017-10-27 20:47:54,319 [salt.state       ][INFO    ][33887] Completed state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 20:47:54.318676 duration_in_ms=56.2
2017-10-27 20:47:54,320 [salt.state       ][INFO    ][33887] Running state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 20:47:54.319674
2017-10-27 20:47:54,320 [salt.state       ][INFO    ][33887] Executing state cmd.run for gluster volume set 'keystone-keys' 'nfs.disable' 'True'
2017-10-27 20:47:54,321 [salt.loaded.int.module.cmdmod][INFO    ][33887] Executing command 'gluster volume info 'keystone-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-10-27 20:47:54,373 [salt.state       ][INFO    ][33887] unless execution succeeded
2017-10-27 20:47:54,373 [salt.state       ][INFO    ][33887] Completed state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 20:47:54.373082 duration_in_ms=53.407
2017-10-27 20:47:54,374 [salt.state       ][INFO    ][33887] Running state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 20:47:54.373677
2017-10-27 20:47:54,374 [salt.state       ][INFO    ][33887] Executing state cmd.run for gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'
2017-10-27 20:47:54,374 [salt.loaded.int.module.cmdmod][INFO    ][33887] Executing command 'gluster volume info 'keystone-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-10-27 20:47:54,429 [salt.state       ][INFO    ][33887] unless execution succeeded
2017-10-27 20:47:54,429 [salt.state       ][INFO    ][33887] Completed state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 20:47:54.429004 duration_in_ms=55.326
2017-10-27 20:47:54,430 [salt.state       ][INFO    ][33887] Running state [keystone-keys] at time 20:47:54.430300
2017-10-27 20:47:54,431 [salt.state       ][INFO    ][33887] Executing state glusterfs.started for keystone-keys
2017-10-27 20:47:54,431 [salt.loaded.int.module.cmdmod][INFO    ][33887] Executing command 'gluster --version' in directory '/root'
2017-10-27 20:47:54,439 [salt.loaded.int.module.cmdmod][INFO    ][33887] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 20:47:54,493 [salt.loaded.int.module.cmdmod][INFO    ][33887] Executing command 'gluster --version' in directory '/root'
2017-10-27 20:47:54,501 [salt.loaded.int.module.cmdmod][INFO    ][33887] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 20:47:54,562 [salt.state       ][INFO    ][33887] Volume keystone-keys is already started
2017-10-27 20:47:54,562 [salt.state       ][INFO    ][33887] Completed state [keystone-keys] at time 20:47:54.561943 duration_in_ms=131.643
2017-10-27 20:47:54,564 [salt.state       ][INFO    ][33887] Running state [nova_instances] at time 20:47:54.564093
2017-10-27 20:47:54,564 [salt.state       ][INFO    ][33887] Executing state glusterfs.created for nova_instances
2017-10-27 20:47:54,565 [salt.loaded.int.module.cmdmod][INFO    ][33887] Executing command 'gluster --version' in directory '/root'
2017-10-27 20:47:54,574 [salt.loaded.int.module.cmdmod][INFO    ][33887] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 20:47:54,626 [salt.loaded.int.module.cmdmod][INFO    ][33887] Executing command 'gluster --version' in directory '/root'
2017-10-27 20:47:54,634 [salt.loaded.int.module.cmdmod][INFO    ][33887] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 20:47:54,692 [salt.state       ][INFO    ][33887] Volume nova_instances already exists and is started.
2017-10-27 20:47:54,693 [salt.state       ][INFO    ][33887] Completed state [nova_instances] at time 20:47:54.692505 duration_in_ms=128.412
2017-10-27 20:47:54,696 [salt.state       ][INFO    ][33887] Running state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 20:47:54.696419
2017-10-27 20:47:54,697 [salt.state       ][INFO    ][33887] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'
2017-10-27 20:47:54,697 [salt.loaded.int.module.cmdmod][INFO    ][33887] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-10-27 20:47:54,751 [salt.state       ][INFO    ][33887] unless execution succeeded
2017-10-27 20:47:54,751 [salt.state       ][INFO    ][33887] Completed state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 20:47:54.750939 duration_in_ms=54.52
2017-10-27 20:47:54,752 [salt.state       ][INFO    ][33887] Running state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'On'] at time 20:47:54.751639
2017-10-27 20:47:54,752 [salt.state       ][INFO    ][33887] Executing state cmd.run for gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'On'
2017-10-27 20:47:54,752 [salt.loaded.int.module.cmdmod][INFO    ][33887] Executing command 'gluster volume info 'nova_instances' | grep 'cluster.readdir-optimize: On'' in directory '/root'
2017-10-27 20:47:54,806 [salt.state       ][INFO    ][33887] unless execution succeeded
2017-10-27 20:47:54,806 [salt.state       ][INFO    ][33887] Completed state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'On'] at time 20:47:54.806351 duration_in_ms=54.711
2017-10-27 20:47:54,807 [salt.state       ][INFO    ][33887] Running state [gluster volume set 'nova_instances' 'network.remote-dio' 'On'] at time 20:47:54.806880
2017-10-27 20:47:54,807 [salt.state       ][INFO    ][33887] Executing state cmd.run for gluster volume set 'nova_instances' 'network.remote-dio' 'On'
2017-10-27 20:47:54,808 [salt.loaded.int.module.cmdmod][INFO    ][33887] Executing command 'gluster volume info 'nova_instances' | grep 'network.remote-dio: On'' in directory '/root'
2017-10-27 20:47:54,862 [salt.state       ][INFO    ][33887] unless execution succeeded
2017-10-27 20:47:54,862 [salt.state       ][INFO    ][33887] Completed state [gluster volume set 'nova_instances' 'network.remote-dio' 'On'] at time 20:47:54.862054 duration_in_ms=55.174
2017-10-27 20:47:54,863 [salt.state       ][INFO    ][33887] Running state [gluster volume set 'nova_instances' 'nfs.disable' 'On'] at time 20:47:54.862590
2017-10-27 20:47:54,863 [salt.state       ][INFO    ][33887] Executing state cmd.run for gluster volume set 'nova_instances' 'nfs.disable' 'On'
2017-10-27 20:47:54,863 [salt.loaded.int.module.cmdmod][INFO    ][33887] Executing command 'gluster volume info 'nova_instances' | grep 'nfs.disable: On'' in directory '/root'
2017-10-27 20:47:54,917 [salt.state       ][INFO    ][33887] unless execution succeeded
2017-10-27 20:47:54,918 [salt.state       ][INFO    ][33887] Completed state [gluster volume set 'nova_instances' 'nfs.disable' 'On'] at time 20:47:54.917614 duration_in_ms=55.024
2017-10-27 20:47:54,918 [salt.state       ][INFO    ][33887] Running state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 20:47:54.918207
2017-10-27 20:47:54,918 [salt.state       ][INFO    ][33887] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'
2017-10-27 20:47:54,919 [salt.loaded.int.module.cmdmod][INFO    ][33887] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-10-27 20:47:54,975 [salt.state       ][INFO    ][33887] unless execution succeeded
2017-10-27 20:47:54,976 [salt.state       ][INFO    ][33887] Completed state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 20:47:54.975619 duration_in_ms=57.412
2017-10-27 20:47:54,977 [salt.state       ][INFO    ][33887] Running state [nova_instances] at time 20:47:54.976862
2017-10-27 20:47:54,977 [salt.state       ][INFO    ][33887] Executing state glusterfs.started for nova_instances
2017-10-27 20:47:54,978 [salt.loaded.int.module.cmdmod][INFO    ][33887] Executing command 'gluster --version' in directory '/root'
2017-10-27 20:47:54,986 [salt.loaded.int.module.cmdmod][INFO    ][33887] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 20:47:55,042 [salt.loaded.int.module.cmdmod][INFO    ][33887] Executing command 'gluster --version' in directory '/root'
2017-10-27 20:47:55,051 [salt.loaded.int.module.cmdmod][INFO    ][33887] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 20:47:55,111 [salt.state       ][INFO    ][33887] Volume nova_instances is already started
2017-10-27 20:47:55,111 [salt.state       ][INFO    ][33887] Completed state [nova_instances] at time 20:47:55.111342 duration_in_ms=134.48
2017-10-27 20:47:55,113 [salt.state       ][INFO    ][33887] Running state [keystone-credential-keys] at time 20:47:55.112478
2017-10-27 20:47:55,113 [salt.state       ][INFO    ][33887] Executing state glusterfs.created for keystone-credential-keys
2017-10-27 20:47:55,113 [salt.loaded.int.module.cmdmod][INFO    ][33887] Executing command 'gluster --version' in directory '/root'
2017-10-27 20:47:55,122 [salt.loaded.int.module.cmdmod][INFO    ][33887] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 20:47:55,176 [salt.loaded.int.module.cmdmod][INFO    ][33887] Executing command 'gluster --version' in directory '/root'
2017-10-27 20:47:55,186 [salt.loaded.int.module.cmdmod][INFO    ][33887] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 20:47:55,246 [salt.state       ][INFO    ][33887] Volume keystone-credential-keys already exists and is started.
2017-10-27 20:47:55,247 [salt.state       ][INFO    ][33887] Completed state [keystone-credential-keys] at time 20:47:55.246485 duration_in_ms=134.006
2017-10-27 20:47:55,251 [salt.state       ][INFO    ][33887] Running state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 20:47:55.250584
2017-10-27 20:47:55,251 [salt.state       ][INFO    ][33887] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'
2017-10-27 20:47:55,251 [salt.loaded.int.module.cmdmod][INFO    ][33887] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-10-27 20:47:55,307 [salt.state       ][INFO    ][33887] unless execution succeeded
2017-10-27 20:47:55,307 [salt.state       ][INFO    ][33887] Completed state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 20:47:55.307285 duration_in_ms=56.701
2017-10-27 20:47:55,308 [salt.state       ][INFO    ][33887] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 20:47:55.307974
2017-10-27 20:47:55,308 [salt.state       ][INFO    ][33887] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-10-27 20:47:55,309 [salt.loaded.int.module.cmdmod][INFO    ][33887] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-10-27 20:47:55,366 [salt.state       ][INFO    ][33887] unless execution succeeded
2017-10-27 20:47:55,366 [salt.state       ][INFO    ][33887] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 20:47:55.366000 duration_in_ms=58.026
2017-10-27 20:47:55,367 [salt.state       ][INFO    ][33887] Running state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 20:47:55.366591
2017-10-27 20:47:55,367 [salt.state       ][INFO    ][33887] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'
2017-10-27 20:47:55,367 [salt.loaded.int.module.cmdmod][INFO    ][33887] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-10-27 20:47:55,421 [salt.state       ][INFO    ][33887] unless execution succeeded
2017-10-27 20:47:55,422 [salt.state       ][INFO    ][33887] Completed state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 20:47:55.421583 duration_in_ms=54.991
2017-10-27 20:47:55,422 [salt.state       ][INFO    ][33887] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 20:47:55.422145
2017-10-27 20:47:55,422 [salt.state       ][INFO    ][33887] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'
2017-10-27 20:47:55,423 [salt.loaded.int.module.cmdmod][INFO    ][33887] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-10-27 20:47:55,477 [salt.state       ][INFO    ][33887] unless execution succeeded
2017-10-27 20:47:55,478 [salt.state       ][INFO    ][33887] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 20:47:55.477723 duration_in_ms=55.578
2017-10-27 20:47:55,478 [salt.state       ][INFO    ][33887] Running state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 20:47:55.478364
2017-10-27 20:47:55,479 [salt.state       ][INFO    ][33887] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'
2017-10-27 20:47:55,479 [salt.loaded.int.module.cmdmod][INFO    ][33887] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-10-27 20:47:55,533 [salt.state       ][INFO    ][33887] unless execution succeeded
2017-10-27 20:47:55,533 [salt.state       ][INFO    ][33887] Completed state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 20:47:55.532831 duration_in_ms=54.466
2017-10-27 20:47:55,534 [salt.state       ][INFO    ][33887] Running state [keystone-credential-keys] at time 20:47:55.534181
2017-10-27 20:47:55,534 [salt.state       ][INFO    ][33887] Executing state glusterfs.started for keystone-credential-keys
2017-10-27 20:47:55,535 [salt.loaded.int.module.cmdmod][INFO    ][33887] Executing command 'gluster --version' in directory '/root'
2017-10-27 20:47:55,543 [salt.loaded.int.module.cmdmod][INFO    ][33887] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 20:47:55,598 [salt.loaded.int.module.cmdmod][INFO    ][33887] Executing command 'gluster --version' in directory '/root'
2017-10-27 20:47:55,605 [salt.loaded.int.module.cmdmod][INFO    ][33887] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 20:47:55,665 [salt.state       ][INFO    ][33887] Volume keystone-credential-keys is already started
2017-10-27 20:47:55,665 [salt.state       ][INFO    ][33887] Completed state [keystone-credential-keys] at time 20:47:55.664847 duration_in_ms=130.665
2017-10-27 20:47:55,667 [salt.minion      ][INFO    ][33887] Returning information for job: 20171027204751482272
2017-10-27 20:48:00,881 [salt.minion      ][INFO    ][25322] User sudo_ubuntu Executing command test.ping with jid 20171027204800862008
2017-10-27 20:48:00,897 [salt.minion      ][INFO    ][34272] Starting a new job with PID 34272
2017-10-27 20:48:00,932 [salt.minion      ][INFO    ][34272] Returning information for job: 20171027204800862008
2017-10-27 20:48:01,457 [salt.minion      ][INFO    ][25322] User sudo_ubuntu Executing command cmd.run with jid 20171027204801439242
2017-10-27 20:48:01,470 [salt.minion      ][INFO    ][34277] Starting a new job with PID 34277
2017-10-27 20:48:01,475 [salt.loaded.int.module.cmdmod][INFO    ][34277] Executing command 'gluster peer status; gluster volume status' in directory '/root'
2017-10-27 20:48:01,591 [salt.minion      ][INFO    ][34277] Returning information for job: 20171027204801439242
2017-10-27 20:48:17,630 [salt.utils.schedule][INFO    ][25322] Running scheduled job: __mine_interval
2017-10-27 21:12:43,269 [salt.minion      ][INFO    ][25322] User sudo_ubuntu Executing command cp.push_dir with jid 20171027211243247102
2017-10-27 21:12:43,283 [salt.minion      ][INFO    ][34618] Starting a new job with PID 34618
