2017-11-01 11:24:45,411 [salt.cli.daemons ][WARNING ][2424] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-11-01 11:25:53,712 [salt.state       ][ERROR   ][3955] No contents found in top file
2017-11-01 11:26:13,208 [salt.transport.ipc][ERROR   ][2424] Exception occurred while handling stream: [Errno 0] Success
2017-11-01 11:27:37,721 [salt.utils.parsers][WARNING ][2424] Minion received a SIGTERM. Exiting.
2017-11-01 11:32:01,310 [salt.cli.daemons ][WARNING ][3834] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-11-01 11:34:06,376 [salt.loaded.int.module.cmdmod][ERROR   ][11148] Command 'virsh net-destroy default 2>&1 1>/dev/null; virsh net-undefine default' failed with return code: 1
2017-11-01 11:34:06,378 [salt.loaded.int.module.cmdmod][ERROR   ][11148] stderr: error: failed to get network 'default'
error: Network not found: no network with matching name 'default'
2017-11-01 11:34:06,378 [salt.loaded.int.module.cmdmod][ERROR   ][11148] retcode: 1
2017-11-01 11:34:06,380 [salt.state       ][ERROR   ][11148] {'pid': 16066, 'retcode': 1, 'stderr': "error: failed to get network 'default'\nerror: Network not found: no network with matching name 'default'", 'stdout': ''}
2017-11-01 11:34:23,130 [py.warnings      ][WARNING ][16143] /usr/lib/python2.7/dist-packages/salt/utils/templates.py:73: DeprecationWarning: Starting in 2015.5, cmd.run uses python_shell=False by default, which doesn't support shellisms (pipes, env variables, etc). cmd.run is currently aliased to cmd.shell to prevent breakage. Please switch to cmd.shell or set python_shell=True to avoid breakage in the future, when this aliasing is removed.

2017-11-01 11:34:50,949 [salt.loaded.int.module.cmdmod][ERROR   ][16143] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-11-01 11:34:50,950 [salt.loaded.int.module.cmdmod][ERROR   ][16143] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-11-01 11:34:55,986 [salt.loaded.int.module.cmdmod][ERROR   ][16143] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-11-01 11:34:55,987 [salt.loaded.int.module.cmdmod][ERROR   ][16143] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-11-01 11:35:00,973 [salt.loaded.int.module.cmdmod][ERROR   ][16143] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-11-01 11:35:00,973 [salt.loaded.int.module.cmdmod][ERROR   ][16143] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-11-01 11:35:06,155 [salt.loaded.int.module.cmdmod][ERROR   ][16143] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-11-01 11:35:06,156 [salt.loaded.int.module.cmdmod][ERROR   ][16143] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-11-01 11:35:10,136 [salt.loaded.int.module.cmdmod][ERROR   ][16143] Command 'while true; do salt-call saltutil.running|grep fun: && continue; salt-call --local service.restart salt-minion; break; done' failed with return code: None
2017-11-01 11:35:13,530 [salt.state       ][ERROR   ][23672] No contents found in top file
2017-11-01 11:35:17,440 [salt.loaded.int.module.cmdmod][INFO    ][23884] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2017-11-01 11:35:17,460 [salt.loaded.int.module.cmdmod][INFO    ][23884] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2017-11-01 11:35:17,489 [salt.loaded.int.module.cmdmod][INFO    ][23884] Executing command ['systemd-run', '--scope', 'systemctl', 'restart', 'salt-minion.service'] in directory '/root'
2017-11-01 11:35:17,512 [salt.utils.parsers][WARNING ][3834] Minion received a SIGTERM. Exiting.
2017-11-01 11:35:17,964 [salt.cli.daemons ][INFO    ][24030] Setting up the Salt Minion "kvm02.baremetal-mcp-ocata-ovs-ha.local"
2017-11-01 11:35:18,868 [salt.minion      ][INFO    ][24030] Creating minion process manager
2017-11-01 11:35:18,869 [salt.cli.daemons ][WARNING ][24030] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-11-01 11:35:18,869 [salt.cli.daemons ][INFO    ][24030] The Salt Minion is starting up
2017-11-01 11:35:18,869 [salt.minion      ][INFO    ][24030] Minion is starting as user 'root'
2017-11-01 11:35:18,870 [salt.utils.event ][INFO    ][24030] Starting pull socket on /var/run/salt/minion/minion_event_a1b2f32648_pull.ipc
2017-11-01 11:35:20,265 [salt.loaded.int.module.cmdmod][INFO    ][24030] Executing command ['date', '+%z'] in directory '/root'
2017-11-01 11:35:20,287 [salt.utils.schedule][INFO    ][24030] Updating job settings for scheduled job: __mine_interval
2017-11-01 11:35:20,292 [salt.minion      ][INFO    ][24030] Added mine.update to scheduler
2017-11-01 11:35:20,313 [salt.minion      ][INFO    ][24030] Minion is ready to receive requests!
2017-11-01 11:35:21,314 [salt.utils.schedule][INFO    ][24030] Running scheduled job: __mine_interval
2017-11-01 11:35:31,918 [salt.minion      ][INFO    ][24030] User sudo_ubuntu Executing command state.sls with jid 20171101113531904956
2017-11-01 11:35:31,943 [salt.minion      ][INFO    ][24156] Starting a new job with PID 24156
2017-11-01 11:35:34,548 [salt.state       ][INFO    ][24156] Loading fresh modules for state activity
2017-11-01 11:35:34,584 [salt.fileclient  ][INFO    ][24156] Fetching file from saltenv 'base', ** done ** 'salt/control/init.sls'
2017-11-01 11:35:34,612 [salt.fileclient  ][INFO    ][24156] Fetching file from saltenv 'base', ** done ** 'salt/control/virt.sls'
2017-11-01 11:35:34,650 [salt.fileclient  ][INFO    ][24156] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-11-01 11:35:34,749 [salt.fileclient  ][INFO    ][24156] Fetching file from saltenv 'base', ** done ** 'salt/minion/init.sls'
2017-11-01 11:35:34,767 [salt.fileclient  ][INFO    ][24156] Fetching file from saltenv 'base', ** done ** 'salt/minion/service.sls'
2017-11-01 11:35:34,807 [salt.fileclient  ][INFO    ][24156] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-11-01 11:35:34,884 [salt.fileclient  ][INFO    ][24156] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-11-01 11:35:34,911 [salt.fileclient  ][INFO    ][24156] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-11-01 11:35:35,068 [salt.fileclient  ][INFO    ][24156] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-11-01 11:35:35,100 [salt.fileclient  ][INFO    ][24156] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-11-01 11:35:35,121 [salt.fileclient  ][INFO    ][24156] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-11-01 11:35:35,144 [salt.fileclient  ][INFO    ][24156] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-11-01 11:35:35,160 [salt.loaded.int.module.cmdmod][INFO    ][24156] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-11-01 11:35:35,188 [salt.fileclient  ][INFO    ][24156] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-11-01 11:35:35,217 [py.warnings      ][WARNING ][24156] /usr/lib/python2.7/dist-packages/salt/utils/templates.py:73: DeprecationWarning: Starting in 2015.5, cmd.run uses python_shell=False by default, which doesn't support shellisms (pipes, env variables, etc). cmd.run is currently aliased to cmd.shell to prevent breakage. Please switch to cmd.shell or set python_shell=True to avoid breakage in the future, when this aliasing is removed.

2017-11-01 11:35:35,218 [salt.loaded.int.module.cmdmod][INFO    ][24156] Executing command 'salt-minion --version' in directory '/root'
2017-11-01 11:35:35,583 [salt.fileclient  ][INFO    ][24156] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-11-01 11:35:35,602 [salt.fileclient  ][INFO    ][24156] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-11-01 11:35:35,615 [salt.fileclient  ][INFO    ][24156] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-11-01 11:35:35,628 [salt.fileclient  ][INFO    ][24156] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-11-01 11:35:35,685 [salt.fileclient  ][INFO    ][24156] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-11-01 11:35:35,723 [salt.fileclient  ][INFO    ][24156] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-11-01 11:35:35,808 [salt.fileclient  ][INFO    ][24156] Fetching file from saltenv 'base', ** done ** 'salt/minion/grains.sls'
2017-11-01 11:35:35,836 [salt.fileclient  ][INFO    ][24156] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-11-01 11:35:35,910 [salt.fileclient  ][INFO    ][24156] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-11-01 11:35:35,931 [salt.fileclient  ][INFO    ][24156] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-11-01 11:35:36,002 [salt.fileclient  ][INFO    ][24156] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-11-01 11:35:36,027 [salt.fileclient  ][INFO    ][24156] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-11-01 11:35:36,042 [salt.fileclient  ][INFO    ][24156] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-11-01 11:35:36,076 [salt.fileclient  ][INFO    ][24156] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-11-01 11:35:36,091 [salt.loaded.int.module.cmdmod][INFO    ][24156] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-11-01 11:35:36,122 [salt.fileclient  ][INFO    ][24156] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-11-01 11:35:36,150 [salt.loaded.int.module.cmdmod][INFO    ][24156] Executing command 'salt-minion --version' in directory '/root'
2017-11-01 11:35:36,467 [salt.fileclient  ][INFO    ][24156] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-11-01 11:35:36,489 [salt.fileclient  ][INFO    ][24156] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-11-01 11:35:36,508 [salt.fileclient  ][INFO    ][24156] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-11-01 11:35:36,520 [salt.fileclient  ][INFO    ][24156] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-11-01 11:35:36,582 [salt.fileclient  ][INFO    ][24156] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-11-01 11:35:36,632 [salt.fileclient  ][INFO    ][24156] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-11-01 11:35:36,723 [salt.fileclient  ][INFO    ][24156] Fetching file from saltenv 'base', ** done ** 'salt/minion/cert.sls'
2017-11-01 11:35:36,808 [salt.fileclient  ][INFO    ][24156] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-11-01 11:35:37,254 [salt.state       ][INFO    ][24156] Running state [salt-minion] at time 11:35:37.253599
2017-11-01 11:35:37,254 [salt.state       ][INFO    ][24156] Executing state pkg.installed for salt-minion
2017-11-01 11:35:37,255 [salt.loaded.int.module.cmdmod][INFO    ][24156] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-01 11:35:37,649 [salt.state       ][INFO    ][24156] Package salt-minion is already installed
2017-11-01 11:35:37,649 [salt.state       ][INFO    ][24156] Completed state [salt-minion] at time 11:35:37.648833 duration_in_ms=395.235
2017-11-01 11:35:37,649 [salt.state       ][INFO    ][24156] Running state [salt_minion_dependency_packages] at time 11:35:37.649106
2017-11-01 11:35:37,649 [salt.state       ][INFO    ][24156] Executing state pkg.installed for salt_minion_dependency_packages
2017-11-01 11:35:37,653 [salt.state       ][INFO    ][24156] All specified packages are already installed
2017-11-01 11:35:37,654 [salt.state       ][INFO    ][24156] Completed state [salt_minion_dependency_packages] at time 11:35:37.653642 duration_in_ms=4.537
2017-11-01 11:35:37,656 [salt.state       ][INFO    ][24156] Running state [/etc/salt/minion.d/minion.conf] at time 11:35:37.656305
2017-11-01 11:35:37,657 [salt.state       ][INFO    ][24156] Executing state file.managed for /etc/salt/minion.d/minion.conf
2017-11-01 11:35:37,675 [salt.fileclient  ][INFO    ][24156] Fetching file from saltenv 'base', ** done ** 'salt/files/minion.conf'
2017-11-01 11:35:37,741 [salt.fileclient  ][INFO    ][24156] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-11-01 11:35:37,806 [salt.fileclient  ][INFO    ][24156] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-11-01 11:35:37,867 [salt.state       ][INFO    ][24156] File /etc/salt/minion.d/minion.conf is in the correct state
2017-11-01 11:35:37,867 [salt.state       ][INFO    ][24156] Completed state [/etc/salt/minion.d/minion.conf] at time 11:35:37.867304 duration_in_ms=210.999
2017-11-01 11:35:37,868 [salt.state       ][INFO    ][24156] Running state [/etc/salt/minion.d/_virt.conf] at time 11:35:37.867721
2017-11-01 11:35:37,868 [salt.state       ][INFO    ][24156] Executing state file.managed for /etc/salt/minion.d/_virt.conf
2017-11-01 11:35:37,869 [salt.state       ][INFO    ][24156] File /etc/salt/minion.d/_virt.conf is in the correct state
2017-11-01 11:35:37,869 [salt.state       ][INFO    ][24156] Completed state [/etc/salt/minion.d/_virt.conf] at time 11:35:37.869075 duration_in_ms=1.355
2017-11-01 11:35:37,871 [salt.state       ][INFO    ][24156] Running state [salt-minion] at time 11:35:37.870742
2017-11-01 11:35:37,871 [salt.state       ][INFO    ][24156] Executing state service.running for salt-minion
2017-11-01 11:35:37,871 [salt.loaded.int.module.cmdmod][INFO    ][24156] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2017-11-01 11:35:37,902 [salt.loaded.int.module.cmdmod][INFO    ][24156] Executing command ['systemctl', 'is-active', 'salt-minion.service'] in directory '/root'
2017-11-01 11:35:37,920 [salt.loaded.int.module.cmdmod][INFO    ][24156] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2017-11-01 11:35:37,938 [salt.state       ][INFO    ][24156] The service salt-minion is already running
2017-11-01 11:35:37,939 [salt.state       ][INFO    ][24156] Completed state [salt-minion] at time 11:35:37.938194 duration_in_ms=67.451
2017-11-01 11:35:37,944 [salt.state       ][INFO    ][24156] Running state [/etc/salt/grains.d] at time 11:35:37.943700
2017-11-01 11:35:37,944 [salt.state       ][INFO    ][24156] Executing state file.directory for /etc/salt/grains.d
2017-11-01 11:35:37,947 [salt.state       ][INFO    ][24156] Directory /etc/salt/grains.d is in the correct state
2017-11-01 11:35:37,947 [salt.state       ][INFO    ][24156] Completed state [/etc/salt/grains.d] at time 11:35:37.947384 duration_in_ms=3.684
2017-11-01 11:35:37,948 [salt.state       ][INFO    ][24156] Running state [/etc/salt/grains] at time 11:35:37.948035
2017-11-01 11:35:37,948 [salt.state       ][INFO    ][24156] Executing state file.managed for /etc/salt/grains
2017-11-01 11:35:37,949 [salt.state       ][INFO    ][24156] File /etc/salt/grains exists with proper permissions. No changes made.
2017-11-01 11:35:37,949 [salt.state       ][INFO    ][24156] Completed state [/etc/salt/grains] at time 11:35:37.948886 duration_in_ms=0.851
2017-11-01 11:35:37,950 [salt.state       ][INFO    ][24156] Running state [/etc/salt/grains.d/placeholder] at time 11:35:37.949587
2017-11-01 11:35:37,950 [salt.state       ][INFO    ][24156] Executing state file.managed for /etc/salt/grains.d/placeholder
2017-11-01 11:35:37,951 [salt.state       ][INFO    ][24156] File /etc/salt/grains.d/placeholder exists with proper permissions. No changes made.
2017-11-01 11:35:37,951 [salt.state       ][INFO    ][24156] Completed state [/etc/salt/grains.d/placeholder] at time 11:35:37.951273 duration_in_ms=1.686
2017-11-01 11:35:37,952 [salt.state       ][INFO    ][24156] Running state [/etc/salt/grains.d/sphinx] at time 11:35:37.951995
2017-11-01 11:35:37,952 [salt.state       ][INFO    ][24156] Executing state file.managed for /etc/salt/grains.d/sphinx
2017-11-01 11:35:37,954 [salt.state       ][INFO    ][24156] File changed:
--- 
+++ 
@@ -49,7 +49,6 @@
               - 127.0.0.1
               - 192.168.10.142
               - 192.168.11.252
-              - 192.168.122.1
         system:
           name: System
           param:

2017-11-01 11:35:37,956 [salt.state       ][INFO    ][24156] Completed state [/etc/salt/grains.d/sphinx] at time 11:35:37.955270 duration_in_ms=3.274
2017-11-01 11:35:37,957 [salt.state       ][INFO    ][24156] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 11:35:37.956986
2017-11-01 11:35:37,957 [salt.state       ][INFO    ][24156] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-11-01 11:35:37,958 [salt.state       ][INFO    ][24156] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-11-01 11:35:37,958 [salt.state       ][INFO    ][24156] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 11:35:37.957676 duration_in_ms=0.69
2017-11-01 11:35:37,958 [salt.state       ][INFO    ][24156] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 11:35:37.958145
2017-11-01 11:35:37,959 [salt.state       ][INFO    ][24156] Executing state cmd.mod_watch for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-11-01 11:35:37,960 [salt.loaded.int.module.cmdmod][INFO    ][24156] Executing command 'python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"' in directory '/root'
2017-11-01 11:35:38,064 [salt.state       ][INFO    ][24156] {'pid': 24204, 'retcode': 0, 'stderr': '', 'stdout': ''}
2017-11-01 11:35:38,065 [salt.state       ][INFO    ][24156] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 11:35:38.064616 duration_in_ms=106.469
2017-11-01 11:35:38,066 [salt.state       ][INFO    ][24156] Running state [/etc/salt/grains.d/dns_records] at time 11:35:38.065786
2017-11-01 11:35:38,066 [salt.state       ][INFO    ][24156] Executing state file.managed for /etc/salt/grains.d/dns_records
2017-11-01 11:35:38,068 [salt.state       ][INFO    ][24156] File /etc/salt/grains.d/dns_records is in the correct state
2017-11-01 11:35:38,068 [salt.state       ][INFO    ][24156] Completed state [/etc/salt/grains.d/dns_records] at time 11:35:38.068175 duration_in_ms=2.39
2017-11-01 11:35:38,070 [salt.state       ][INFO    ][24156] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 11:35:38.069618
2017-11-01 11:35:38,070 [salt.state       ][INFO    ][24156] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"
2017-11-01 11:35:38,071 [salt.state       ][INFO    ][24156] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"
2017-11-01 11:35:38,071 [salt.state       ][INFO    ][24156] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 11:35:38.070863 duration_in_ms=1.245
2017-11-01 11:35:38,072 [salt.state       ][INFO    ][24156] Running state [/etc/salt/grains.d/salt] at time 11:35:38.071494
2017-11-01 11:35:38,072 [salt.state       ][INFO    ][24156] Executing state file.managed for /etc/salt/grains.d/salt
2017-11-01 11:35:38,073 [salt.state       ][INFO    ][24156] File /etc/salt/grains.d/salt is in the correct state
2017-11-01 11:35:38,074 [salt.state       ][INFO    ][24156] Completed state [/etc/salt/grains.d/salt] at time 11:35:38.073691 duration_in_ms=2.198
2017-11-01 11:35:38,075 [salt.state       ][INFO    ][24156] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 11:35:38.075382
2017-11-01 11:35:38,076 [salt.state       ][INFO    ][24156] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2017-11-01 11:35:38,076 [salt.state       ][INFO    ][24156] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2017-11-01 11:35:38,077 [salt.state       ][INFO    ][24156] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 11:35:38.076554 duration_in_ms=1.172
2017-11-01 11:35:38,080 [salt.state       ][INFO    ][24156] Running state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 11:35:38.080312
2017-11-01 11:35:38,081 [salt.state       ][INFO    ][24156] Executing state cmd.wait for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-11-01 11:35:38,081 [salt.state       ][INFO    ][24156] No changes made for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-11-01 11:35:38,081 [salt.state       ][INFO    ][24156] Completed state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 11:35:38.080941 duration_in_ms=0.629
2017-11-01 11:35:38,081 [salt.state       ][INFO    ][24156] Running state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 11:35:38.081111
2017-11-01 11:35:38,081 [salt.state       ][INFO    ][24156] Executing state cmd.mod_watch for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-11-01 11:35:38,083 [salt.loaded.int.module.cmdmod][INFO    ][24156] Executing command 'cat /etc/salt/grains.d/* > /etc/salt/grains' in directory '/root'
2017-11-01 11:35:38,094 [salt.state       ][INFO    ][24156] {'pid': 24206, 'retcode': 0, 'stderr': '', 'stdout': ''}
2017-11-01 11:35:38,095 [salt.state       ][INFO    ][24156] Completed state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 11:35:38.095285 duration_in_ms=14.173
2017-11-01 11:35:38,096 [salt.state       ][INFO    ][24156] Running state [mine.update] at time 11:35:38.096154
2017-11-01 11:35:38,096 [salt.state       ][INFO    ][24156] Executing state module.wait for mine.update
2017-11-01 11:35:38,097 [salt.state       ][INFO    ][24156] No changes made for mine.update
2017-11-01 11:35:38,097 [salt.state       ][INFO    ][24156] Completed state [mine.update] at time 11:35:38.097145 duration_in_ms=0.991
2017-11-01 11:35:38,097 [salt.state       ][INFO    ][24156] Running state [mine.update] at time 11:35:38.097350
2017-11-01 11:35:38,098 [salt.state       ][INFO    ][24156] Executing state module.mod_watch for mine.update
2017-11-01 11:35:38,634 [salt.state       ][INFO    ][24156] {'ret': True}
2017-11-01 11:35:38,635 [salt.state       ][INFO    ][24156] Completed state [mine.update] at time 11:35:38.634208 duration_in_ms=536.857
2017-11-01 11:35:38,635 [salt.state       ][INFO    ][24156] Running state [ca-certificates] at time 11:35:38.634869
2017-11-01 11:35:38,636 [salt.state       ][INFO    ][24156] Executing state pkg.installed for ca-certificates
2017-11-01 11:35:38,644 [salt.state       ][INFO    ][24156] Package ca-certificates is already installed
2017-11-01 11:35:38,644 [salt.state       ][INFO    ][24156] Completed state [ca-certificates] at time 11:35:38.643697 duration_in_ms=8.828
2017-11-01 11:35:38,645 [salt.state       ][INFO    ][24156] Running state [update-ca-certificates] at time 11:35:38.644489
2017-11-01 11:35:38,645 [salt.state       ][INFO    ][24156] Executing state cmd.wait for update-ca-certificates
2017-11-01 11:35:38,645 [salt.state       ][INFO    ][24156] No changes made for update-ca-certificates
2017-11-01 11:35:38,646 [salt.state       ][INFO    ][24156] Completed state [update-ca-certificates] at time 11:35:38.645755 duration_in_ms=1.265
2017-11-01 11:35:38,647 [salt.state       ][INFO    ][24156] Running state [libvirt-dev] at time 11:35:38.646256
2017-11-01 11:35:38,647 [salt.state       ][INFO    ][24156] Executing state pkg.installed for libvirt-dev
2017-11-01 11:35:38,651 [salt.state       ][INFO    ][24156] Package libvirt-dev is already installed
2017-11-01 11:35:38,651 [salt.state       ][INFO    ][24156] Completed state [libvirt-dev] at time 11:35:38.651001 duration_in_ms=4.745
2017-11-01 11:35:38,651 [salt.state       ][INFO    ][24156] Running state [pkg-config] at time 11:35:38.651193
2017-11-01 11:35:38,651 [salt.state       ][INFO    ][24156] Executing state pkg.installed for pkg-config
2017-11-01 11:35:38,656 [salt.state       ][INFO    ][24156] Package pkg-config is already installed
2017-11-01 11:35:38,656 [salt.state       ][INFO    ][24156] Completed state [pkg-config] at time 11:35:38.656119 duration_in_ms=4.926
2017-11-01 11:35:38,657 [salt.state       ][INFO    ][24156] Running state [virtng.init] at time 11:35:38.656886
2017-11-01 11:35:38,657 [salt.state       ][INFO    ][24156] Executing state module.run for virtng.init
2017-11-01 11:35:38,732 [salt.loaded.int.module.cmdmod][INFO    ][24156] Executing command ['git', '--version'] in directory '/root'
2017-11-01 11:35:38,797 [salt.loaded.int.module.cmdmod][INFO    ][24156] Executing command 'virsh list --all --name| grep -E "^mdb02.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-11-01 11:35:38,820 [salt.state       ][INFO    ][24156] unless execution succeeded
2017-11-01 11:35:38,821 [salt.state       ][INFO    ][24156] Completed state [virtng.init] at time 11:35:38.820457 duration_in_ms=163.57
2017-11-01 11:35:38,821 [salt.state       ][INFO    ][24156] Running state [virt.set_autostart] at time 11:35:38.820763
2017-11-01 11:35:38,821 [salt.state       ][INFO    ][24156] Executing state module.run for virt.set_autostart
2017-11-01 11:35:38,825 [salt.loaded.int.module.cmdmod][INFO    ][24156] Executing command 'virsh list --autostart --name| grep -E "^mdb02.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-11-01 11:35:38,852 [salt.state       ][INFO    ][24156] unless execution succeeded
2017-11-01 11:35:38,853 [salt.state       ][INFO    ][24156] Completed state [virt.set_autostart] at time 11:35:38.852753 duration_in_ms=31.989
2017-11-01 11:35:38,854 [salt.state       ][INFO    ][24156] Running state [virtng.init] at time 11:35:38.853886
2017-11-01 11:35:38,854 [salt.state       ][INFO    ][24156] Executing state module.run for virtng.init
2017-11-01 11:35:38,860 [salt.loaded.int.module.cmdmod][INFO    ][24156] Executing command 'virsh list --all --name| grep -E "^dbs02.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-11-01 11:35:38,892 [salt.state       ][INFO    ][24156] unless execution succeeded
2017-11-01 11:35:38,892 [salt.state       ][INFO    ][24156] Completed state [virtng.init] at time 11:35:38.891894 duration_in_ms=38.007
2017-11-01 11:35:38,893 [salt.state       ][INFO    ][24156] Running state [virt.set_autostart] at time 11:35:38.892528
2017-11-01 11:35:38,893 [salt.state       ][INFO    ][24156] Executing state module.run for virt.set_autostart
2017-11-01 11:35:38,897 [salt.loaded.int.module.cmdmod][INFO    ][24156] Executing command 'virsh list --autostart --name| grep -E "^dbs02.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-11-01 11:35:38,935 [salt.state       ][INFO    ][24156] unless execution succeeded
2017-11-01 11:35:38,936 [salt.state       ][INFO    ][24156] Completed state [virt.set_autostart] at time 11:35:38.936008 duration_in_ms=43.478
2017-11-01 11:35:38,937 [salt.state       ][INFO    ][24156] Running state [virtng.init] at time 11:35:38.936635
2017-11-01 11:35:38,937 [salt.state       ][INFO    ][24156] Executing state module.run for virtng.init
2017-11-01 11:35:38,946 [salt.loaded.int.module.cmdmod][INFO    ][24156] Executing command 'virsh list --all --name| grep -E "^ctl02.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-11-01 11:35:38,984 [salt.state       ][INFO    ][24156] unless execution succeeded
2017-11-01 11:35:38,985 [salt.state       ][INFO    ][24156] Completed state [virtng.init] at time 11:35:38.984699 duration_in_ms=48.064
2017-11-01 11:35:38,985 [salt.state       ][INFO    ][24156] Running state [virt.set_autostart] at time 11:35:38.985464
2017-11-01 11:35:38,986 [salt.state       ][INFO    ][24156] Executing state module.run for virt.set_autostart
2017-11-01 11:35:38,993 [salt.loaded.int.module.cmdmod][INFO    ][24156] Executing command 'virsh list --autostart --name| grep -E "^ctl02.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-11-01 11:35:39,027 [salt.state       ][INFO    ][24156] unless execution succeeded
2017-11-01 11:35:39,028 [salt.state       ][INFO    ][24156] Completed state [virt.set_autostart] at time 11:35:39.027942 duration_in_ms=42.478
2017-11-01 11:35:39,028 [salt.state       ][INFO    ][24156] Running state [virtng.init] at time 11:35:39.028286
2017-11-01 11:35:39,029 [salt.state       ][INFO    ][24156] Executing state module.run for virtng.init
2017-11-01 11:35:39,036 [salt.loaded.int.module.cmdmod][INFO    ][24156] Executing command 'virsh list --all --name| grep -E "^msg02.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-11-01 11:35:39,075 [salt.state       ][INFO    ][24156] unless execution succeeded
2017-11-01 11:35:39,076 [salt.state       ][INFO    ][24156] Completed state [virtng.init] at time 11:35:39.075475 duration_in_ms=47.188
2017-11-01 11:35:39,076 [salt.state       ][INFO    ][24156] Running state [virt.set_autostart] at time 11:35:39.076158
2017-11-01 11:35:39,077 [salt.state       ][INFO    ][24156] Executing state module.run for virt.set_autostart
2017-11-01 11:35:39,086 [salt.loaded.int.module.cmdmod][INFO    ][24156] Executing command 'virsh list --autostart --name| grep -E "^msg02.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-11-01 11:35:39,121 [salt.state       ][INFO    ][24156] unless execution succeeded
2017-11-01 11:35:39,122 [salt.state       ][INFO    ][24156] Completed state [virt.set_autostart] at time 11:35:39.121493 duration_in_ms=45.336
2017-11-01 11:35:39,133 [salt.minion      ][INFO    ][24156] Returning information for job: 20171101113531904956
2017-11-01 11:36:04,545 [salt.minion      ][INFO    ][24030] User sudo_ubuntu Executing command saltutil.sync_all with jid 20171101113604533270
2017-11-01 11:36:04,576 [salt.minion      ][INFO    ][24252] Starting a new job with PID 24252
2017-11-01 11:36:08,932 [salt.state       ][INFO    ][24252] Loading fresh modules for state activity
2017-11-01 11:36:08,973 [salt.state       ][ERROR   ][24252] No contents found in top file
2017-11-01 11:36:08,975 [salt.utils.extmods][INFO    ][24252] Creating module dir '/var/cache/salt/minion/extmods/beacons'
2017-11-01 11:36:08,984 [salt.utils.extmods][INFO    ][24252] Syncing beacons for environment 'base'
2017-11-01 11:36:08,984 [salt.utils.extmods][INFO    ][24252] Loading cache from salt://_beacons, for base)
2017-11-01 11:36:08,985 [salt.fileclient  ][INFO    ][24252] Caching directory '_beacons/' for environment 'base'
2017-11-01 11:36:09,051 [salt.utils.extmods][INFO    ][24252] Syncing modules for environment 'base'
2017-11-01 11:36:09,051 [salt.utils.extmods][INFO    ][24252] Loading cache from salt://_modules, for base)
2017-11-01 11:36:09,052 [salt.fileclient  ][INFO    ][24252] Caching directory '_modules/' for environment 'base'
2017-11-01 11:36:09,142 [salt.fileclient  ][INFO    ][24252] Fetching file from saltenv 'base', ** done ** '_modules/ceph_ng.py'
2017-11-01 11:36:09,154 [salt.fileclient  ][INFO    ][24252] Fetching file from saltenv 'base', ** done ** '_modules/cinderng.py'
2017-11-01 11:36:09,272 [salt.fileclient  ][INFO    ][24252] Fetching file from saltenv 'base', ** done ** '_modules/contrail.py'
2017-11-01 11:36:09,840 [salt.fileclient  ][INFO    ][24252] Fetching file from saltenv 'base', ** done ** '_modules/creds.py'
2017-11-01 11:36:09,872 [salt.fileclient  ][INFO    ][24252] Fetching file from saltenv 'base', ** done ** '_modules/devops_utils.py'
2017-11-01 11:36:09,892 [salt.fileclient  ][INFO    ][24252] Fetching file from saltenv 'base', ** done ** '_modules/encode_json.py'
2017-11-01 11:36:09,924 [salt.fileclient  ][INFO    ][24252] Fetching file from saltenv 'base', ** done ** '_modules/gerrit.py'
2017-11-01 11:36:09,943 [salt.fileclient  ][INFO    ][24252] Fetching file from saltenv 'base', ** done ** '_modules/glanceng.py'
2017-11-01 11:36:09,978 [salt.fileclient  ][INFO    ][24252] Fetching file from saltenv 'base', ** done ** '_modules/heat.py'
2017-11-01 11:36:09,995 [salt.fileclient  ][INFO    ][24252] Fetching file from saltenv 'base', ** done ** '_modules/heka_alarming.py'
2017-11-01 11:36:10,040 [salt.fileclient  ][INFO    ][24252] Fetching file from saltenv 'base', ** done ** '_modules/helm.py'
2017-11-01 11:36:10,081 [salt.fileclient  ][INFO    ][24252] Fetching file from saltenv 'base', ** done ** '_modules/jenkins_common.py'
2017-11-01 11:36:10,104 [salt.fileclient  ][INFO    ][24252] Fetching file from saltenv 'base', ** done ** '_modules/keystone_policy.py'
2017-11-01 11:36:10,137 [salt.fileclient  ][INFO    ][24252] Fetching file from saltenv 'base', ** done ** '_modules/linux_hosts.py'
2017-11-01 11:36:10,165 [salt.fileclient  ][INFO    ][24252] Fetching file from saltenv 'base', ** done ** '_modules/linux_netlink.py'
2017-11-01 11:36:10,193 [salt.fileclient  ][INFO    ][24252] Fetching file from saltenv 'base', ** done ** '_modules/maas.py'
2017-11-01 11:36:10,214 [salt.fileclient  ][INFO    ][24252] Fetching file from saltenv 'base', ** done ** '_modules/maas_client.py'
2017-11-01 11:36:10,230 [salt.fileclient  ][INFO    ][24252] Fetching file from saltenv 'base', ** done ** '_modules/multipart.py'
2017-11-01 11:36:10,247 [salt.fileclient  ][INFO    ][24252] Fetching file from saltenv 'base', ** done ** '_modules/nagios_alarming.py'
2017-11-01 11:36:10,279 [salt.fileclient  ][INFO    ][24252] Fetching file from saltenv 'base', ** done ** '_modules/neutronng.py'
2017-11-01 11:36:10,304 [salt.fileclient  ][INFO    ][24252] Fetching file from saltenv 'base', ** done ** '_modules/novang.py'
2017-11-01 11:36:10,330 [salt.fileclient  ][INFO    ][24252] Fetching file from saltenv 'base', ** done ** '_modules/reclass.py'
2017-11-01 11:36:10,356 [salt.fileclient  ][INFO    ][24252] Fetching file from saltenv 'base', ** done ** '_modules/rsyslog_util.py'
2017-11-01 11:36:10,380 [salt.fileclient  ][INFO    ][24252] Fetching file from saltenv 'base', ** done ** '_modules/rundeck.py'
2017-11-01 11:36:10,397 [salt.fileclient  ][INFO    ][24252] Fetching file from saltenv 'base', ** done ** '_modules/saltkey.py'
2017-11-01 11:36:10,416 [salt.fileclient  ][INFO    ][24252] Fetching file from saltenv 'base', ** done ** '_modules/saltresource.py'
2017-11-01 11:36:10,448 [salt.fileclient  ][INFO    ][24252] Fetching file from saltenv 'base', ** done ** '_modules/seedng.py'
2017-11-01 11:36:10,486 [salt.fileclient  ][INFO    ][24252] Fetching file from saltenv 'base', ** done ** '_modules/testing/credentials.py'
2017-11-01 11:36:10,531 [salt.fileclient  ][INFO    ][24252] Fetching file from saltenv 'base', ** done ** '_modules/testing/django.py'
2017-11-01 11:36:10,557 [salt.fileclient  ][INFO    ][24252] Fetching file from saltenv 'base', ** done ** '_modules/testing/django_client_proxy.py'
2017-11-01 11:36:10,608 [salt.fileclient  ][INFO    ][24252] Fetching file from saltenv 'base', ** done ** '_modules/utils.py'
2017-11-01 11:36:10,650 [salt.fileclient  ][INFO    ][24252] Fetching file from saltenv 'base', ** done ** '_modules/virtng.py'
2017-11-01 11:36:10,660 [salt.utils.extmods][INFO    ][24252] Copying '/var/cache/salt/minion/files/base/_modules/__init__.py' to '/var/cache/salt/minion/extmods/modules/__init__.py'
2017-11-01 11:36:10,660 [salt.utils.extmods][INFO    ][24252] Copying '/var/cache/salt/minion/files/base/_modules/ceph_ng.py' to '/var/cache/salt/minion/extmods/modules/ceph_ng.py'
2017-11-01 11:36:10,660 [salt.utils.extmods][INFO    ][24252] Copying '/var/cache/salt/minion/files/base/_modules/cinderng.py' to '/var/cache/salt/minion/extmods/modules/cinderng.py'
2017-11-01 11:36:10,661 [salt.utils.extmods][INFO    ][24252] Copying '/var/cache/salt/minion/files/base/_modules/contrail.py' to '/var/cache/salt/minion/extmods/modules/contrail.py'
2017-11-01 11:36:10,662 [salt.utils.extmods][INFO    ][24252] Copying '/var/cache/salt/minion/files/base/_modules/creds.py' to '/var/cache/salt/minion/extmods/modules/creds.py'
2017-11-01 11:36:10,662 [salt.utils.extmods][INFO    ][24252] Copying '/var/cache/salt/minion/files/base/_modules/devops_utils.py' to '/var/cache/salt/minion/extmods/modules/devops_utils.py'
2017-11-01 11:36:10,662 [salt.utils.extmods][INFO    ][24252] Copying '/var/cache/salt/minion/files/base/_modules/encode_json.py' to '/var/cache/salt/minion/extmods/modules/encode_json.py'
2017-11-01 11:36:10,662 [salt.utils.extmods][INFO    ][24252] Copying '/var/cache/salt/minion/files/base/_modules/gerrit.py' to '/var/cache/salt/minion/extmods/modules/gerrit.py'
2017-11-01 11:36:10,663 [salt.utils.extmods][INFO    ][24252] Copying '/var/cache/salt/minion/files/base/_modules/glanceng.py' to '/var/cache/salt/minion/extmods/modules/glanceng.py'
2017-11-01 11:36:10,663 [salt.utils.extmods][INFO    ][24252] Copying '/var/cache/salt/minion/files/base/_modules/heat.py' to '/var/cache/salt/minion/extmods/modules/heat.py'
2017-11-01 11:36:10,664 [salt.utils.extmods][INFO    ][24252] Copying '/var/cache/salt/minion/files/base/_modules/heka_alarming.py' to '/var/cache/salt/minion/extmods/modules/heka_alarming.py'
2017-11-01 11:36:10,664 [salt.utils.extmods][INFO    ][24252] Copying '/var/cache/salt/minion/files/base/_modules/helm.py' to '/var/cache/salt/minion/extmods/modules/helm.py'
2017-11-01 11:36:10,665 [salt.utils.extmods][INFO    ][24252] Copying '/var/cache/salt/minion/files/base/_modules/jenkins_common.py' to '/var/cache/salt/minion/extmods/modules/jenkins_common.py'
2017-11-01 11:36:10,666 [salt.utils.extmods][INFO    ][24252] Copying '/var/cache/salt/minion/files/base/_modules/keystone_policy.py' to '/var/cache/salt/minion/extmods/modules/keystone_policy.py'
2017-11-01 11:36:10,667 [salt.utils.extmods][INFO    ][24252] Copying '/var/cache/salt/minion/files/base/_modules/linux_hosts.py' to '/var/cache/salt/minion/extmods/modules/linux_hosts.py'
2017-11-01 11:36:10,667 [salt.utils.extmods][INFO    ][24252] Copying '/var/cache/salt/minion/files/base/_modules/linux_netlink.py' to '/var/cache/salt/minion/extmods/modules/linux_netlink.py'
2017-11-01 11:36:10,667 [salt.utils.extmods][INFO    ][24252] Copying '/var/cache/salt/minion/files/base/_modules/maas.py' to '/var/cache/salt/minion/extmods/modules/maas.py'
2017-11-01 11:36:10,668 [salt.utils.extmods][INFO    ][24252] Copying '/var/cache/salt/minion/files/base/_modules/maas_client.py' to '/var/cache/salt/minion/extmods/modules/maas_client.py'
2017-11-01 11:36:10,669 [salt.utils.extmods][INFO    ][24252] Copying '/var/cache/salt/minion/files/base/_modules/multipart.py' to '/var/cache/salt/minion/extmods/modules/multipart.py'
2017-11-01 11:36:10,669 [salt.utils.extmods][INFO    ][24252] Copying '/var/cache/salt/minion/files/base/_modules/nagios_alarming.py' to '/var/cache/salt/minion/extmods/modules/nagios_alarming.py'
2017-11-01 11:36:10,669 [salt.utils.extmods][INFO    ][24252] Copying '/var/cache/salt/minion/files/base/_modules/neutronng.py' to '/var/cache/salt/minion/extmods/modules/neutronng.py'
2017-11-01 11:36:10,670 [salt.utils.extmods][INFO    ][24252] Copying '/var/cache/salt/minion/files/base/_modules/novang.py' to '/var/cache/salt/minion/extmods/modules/novang.py'
2017-11-01 11:36:10,671 [salt.utils.extmods][INFO    ][24252] Copying '/var/cache/salt/minion/files/base/_modules/reclass.py' to '/var/cache/salt/minion/extmods/modules/reclass.py'
2017-11-01 11:36:10,671 [salt.utils.extmods][INFO    ][24252] Copying '/var/cache/salt/minion/files/base/_modules/rsyslog_util.py' to '/var/cache/salt/minion/extmods/modules/rsyslog_util.py'
2017-11-01 11:36:10,671 [salt.utils.extmods][INFO    ][24252] Copying '/var/cache/salt/minion/files/base/_modules/rundeck.py' to '/var/cache/salt/minion/extmods/modules/rundeck.py'
2017-11-01 11:36:10,672 [salt.utils.extmods][INFO    ][24252] Copying '/var/cache/salt/minion/files/base/_modules/saltkey.py' to '/var/cache/salt/minion/extmods/modules/saltkey.py'
2017-11-01 11:36:10,672 [salt.utils.extmods][INFO    ][24252] Copying '/var/cache/salt/minion/files/base/_modules/saltresource.py' to '/var/cache/salt/minion/extmods/modules/saltresource.py'
2017-11-01 11:36:10,672 [salt.utils.extmods][INFO    ][24252] Copying '/var/cache/salt/minion/files/base/_modules/seedng.py' to '/var/cache/salt/minion/extmods/modules/seedng.py'
2017-11-01 11:36:10,672 [salt.utils.extmods][INFO    ][24252] Copying '/var/cache/salt/minion/files/base/_modules/testing/__init__.py' to '/var/cache/salt/minion/extmods/modules/testing/__init__.py'
2017-11-01 11:36:10,673 [salt.utils.extmods][INFO    ][24252] Copying '/var/cache/salt/minion/files/base/_modules/testing/credentials.py' to '/var/cache/salt/minion/extmods/modules/testing/credentials.py'
2017-11-01 11:36:10,673 [salt.utils.extmods][INFO    ][24252] Copying '/var/cache/salt/minion/files/base/_modules/testing/django.py' to '/var/cache/salt/minion/extmods/modules/testing/django.py'
2017-11-01 11:36:10,673 [salt.utils.extmods][INFO    ][24252] Copying '/var/cache/salt/minion/files/base/_modules/testing/django_client_proxy.py' to '/var/cache/salt/minion/extmods/modules/testing/django_client_proxy.py'
2017-11-01 11:36:10,674 [salt.utils.extmods][INFO    ][24252] Copying '/var/cache/salt/minion/files/base/_modules/utils.py' to '/var/cache/salt/minion/extmods/modules/utils.py'
2017-11-01 11:36:10,674 [salt.utils.extmods][INFO    ][24252] Copying '/var/cache/salt/minion/files/base/_modules/virtng.py' to '/var/cache/salt/minion/extmods/modules/virtng.py'
2017-11-01 11:36:10,689 [salt.utils.extmods][INFO    ][24252] Syncing states for environment 'base'
2017-11-01 11:36:10,689 [salt.utils.extmods][INFO    ][24252] Loading cache from salt://_states, for base)
2017-11-01 11:36:10,689 [salt.fileclient  ][INFO    ][24252] Caching directory '_states/' for environment 'base'
2017-11-01 11:36:10,807 [salt.fileclient  ][INFO    ][24252] Fetching file from saltenv 'base', ** done ** '_states/cinderng.py'
2017-11-01 11:36:10,828 [salt.fileclient  ][INFO    ][24252] Fetching file from saltenv 'base', ** done ** '_states/contrail.py'
2017-11-01 11:36:10,845 [salt.fileclient  ][INFO    ][24252] Fetching file from saltenv 'base', ** done ** '_states/gerrit.py'
2017-11-01 11:36:10,866 [salt.fileclient  ][INFO    ][24252] Fetching file from saltenv 'base', ** done ** '_states/glanceng.py'
2017-11-01 11:36:10,898 [salt.fileclient  ][INFO    ][24252] Fetching file from saltenv 'base', ** done ** '_states/grafana3_dashboard.py'
2017-11-01 11:36:10,945 [salt.fileclient  ][INFO    ][24252] Fetching file from saltenv 'base', ** done ** '_states/grafana3_datasource.py'
2017-11-01 11:36:10,968 [salt.fileclient  ][INFO    ][24252] Fetching file from saltenv 'base', ** done ** '_states/heat.py'
2017-11-01 11:36:10,992 [salt.fileclient  ][INFO    ][24252] Fetching file from saltenv 'base', ** done ** '_states/helm_release.py'
2017-11-01 11:36:11,011 [salt.fileclient  ][INFO    ][24252] Fetching file from saltenv 'base', ** done ** '_states/jenkins_approval.py'
2017-11-01 11:36:11,026 [salt.fileclient  ][INFO    ][24252] Fetching file from saltenv 'base', ** done ** '_states/jenkins_artifactory.py'
2017-11-01 11:36:11,057 [salt.fileclient  ][INFO    ][24252] Fetching file from saltenv 'base', ** done ** '_states/jenkins_credential.py'
2017-11-01 11:36:11,074 [salt.fileclient  ][INFO    ][24252] Fetching file from saltenv 'base', ** done ** '_states/jenkins_job.py'
2017-11-01 11:36:11,100 [salt.fileclient  ][INFO    ][24252] Fetching file from saltenv 'base', ** done ** '_states/jenkins_lib.py'
2017-11-01 11:36:11,125 [salt.fileclient  ][INFO    ][24252] Fetching file from saltenv 'base', ** done ** '_states/jenkins_node.py'
2017-11-01 11:36:11,149 [salt.fileclient  ][INFO    ][24252] Fetching file from saltenv 'base', ** done ** '_states/jenkins_plugin.py'
2017-11-01 11:36:11,177 [salt.fileclient  ][INFO    ][24252] Fetching file from saltenv 'base', ** done ** '_states/jenkins_security.py'
2017-11-01 11:36:11,207 [salt.fileclient  ][INFO    ][24252] Fetching file from saltenv 'base', ** done ** '_states/jenkins_slack.py'
2017-11-01 11:36:11,233 [salt.fileclient  ][INFO    ][24252] Fetching file from saltenv 'base', ** done ** '_states/jenkins_smtp.py'
2017-11-01 11:36:11,256 [salt.fileclient  ][INFO    ][24252] Fetching file from saltenv 'base', ** done ** '_states/jenkins_theme.py'
2017-11-01 11:36:11,292 [salt.fileclient  ][INFO    ][24252] Fetching file from saltenv 'base', ** done ** '_states/jenkins_user.py'
2017-11-01 11:36:11,377 [salt.fileclient  ][INFO    ][24252] Fetching file from saltenv 'base', ** done ** '_states/jenkins_view.py'
2017-11-01 11:36:11,413 [salt.fileclient  ][INFO    ][24252] Fetching file from saltenv 'base', ** done ** '_states/keystone_policy.py'
2017-11-01 11:36:11,429 [salt.fileclient  ][INFO    ][24252] Fetching file from saltenv 'base', ** done ** '_states/kibana_object.py'
2017-11-01 11:36:11,473 [salt.fileclient  ][INFO    ][24252] Fetching file from saltenv 'base', ** done ** '_states/neutronng.py'
2017-11-01 11:36:11,496 [salt.fileclient  ][INFO    ][24252] Fetching file from saltenv 'base', ** done ** '_states/novang.py'
2017-11-01 11:36:11,517 [salt.fileclient  ][INFO    ][24252] Fetching file from saltenv 'base', ** done ** '_states/reclass.py'
2017-11-01 11:36:11,540 [salt.fileclient  ][INFO    ][24252] Fetching file from saltenv 'base', ** done ** '_states/rundeck_project.py'
2017-11-01 11:36:11,588 [salt.fileclient  ][INFO    ][24252] Fetching file from saltenv 'base', ** done ** '_states/rundeck_scm.py'
2017-11-01 11:36:11,614 [salt.fileclient  ][INFO    ][24252] Fetching file from saltenv 'base', ** done ** '_states/rundeck_secret.py'
2017-11-01 11:36:11,624 [salt.utils.extmods][INFO    ][24252] Copying '/var/cache/salt/minion/files/base/_states/cinderng.py' to '/var/cache/salt/minion/extmods/states/cinderng.py'
2017-11-01 11:36:11,625 [salt.utils.extmods][INFO    ][24252] Copying '/var/cache/salt/minion/files/base/_states/contrail.py' to '/var/cache/salt/minion/extmods/states/contrail.py'
2017-11-01 11:36:11,625 [salt.utils.extmods][INFO    ][24252] Copying '/var/cache/salt/minion/files/base/_states/gerrit.py' to '/var/cache/salt/minion/extmods/states/gerrit.py'
2017-11-01 11:36:11,627 [salt.utils.extmods][INFO    ][24252] Copying '/var/cache/salt/minion/files/base/_states/glanceng.py' to '/var/cache/salt/minion/extmods/states/glanceng.py'
2017-11-01 11:36:11,628 [salt.utils.extmods][INFO    ][24252] Copying '/var/cache/salt/minion/files/base/_states/grafana3_dashboard.py' to '/var/cache/salt/minion/extmods/states/grafana3_dashboard.py'
2017-11-01 11:36:11,628 [salt.utils.extmods][INFO    ][24252] Copying '/var/cache/salt/minion/files/base/_states/grafana3_datasource.py' to '/var/cache/salt/minion/extmods/states/grafana3_datasource.py'
2017-11-01 11:36:11,628 [salt.utils.extmods][INFO    ][24252] Copying '/var/cache/salt/minion/files/base/_states/heat.py' to '/var/cache/salt/minion/extmods/states/heat.py'
2017-11-01 11:36:11,629 [salt.utils.extmods][INFO    ][24252] Copying '/var/cache/salt/minion/files/base/_states/helm_release.py' to '/var/cache/salt/minion/extmods/states/helm_release.py'
2017-11-01 11:36:11,629 [salt.utils.extmods][INFO    ][24252] Copying '/var/cache/salt/minion/files/base/_states/jenkins_approval.py' to '/var/cache/salt/minion/extmods/states/jenkins_approval.py'
2017-11-01 11:36:11,629 [salt.utils.extmods][INFO    ][24252] Copying '/var/cache/salt/minion/files/base/_states/jenkins_artifactory.py' to '/var/cache/salt/minion/extmods/states/jenkins_artifactory.py'
2017-11-01 11:36:11,629 [salt.utils.extmods][INFO    ][24252] Copying '/var/cache/salt/minion/files/base/_states/jenkins_credential.py' to '/var/cache/salt/minion/extmods/states/jenkins_credential.py'
2017-11-01 11:36:11,630 [salt.utils.extmods][INFO    ][24252] Copying '/var/cache/salt/minion/files/base/_states/jenkins_job.py' to '/var/cache/salt/minion/extmods/states/jenkins_job.py'
2017-11-01 11:36:11,630 [salt.utils.extmods][INFO    ][24252] Copying '/var/cache/salt/minion/files/base/_states/jenkins_lib.py' to '/var/cache/salt/minion/extmods/states/jenkins_lib.py'
2017-11-01 11:36:11,630 [salt.utils.extmods][INFO    ][24252] Copying '/var/cache/salt/minion/files/base/_states/jenkins_node.py' to '/var/cache/salt/minion/extmods/states/jenkins_node.py'
2017-11-01 11:36:11,630 [salt.utils.extmods][INFO    ][24252] Copying '/var/cache/salt/minion/files/base/_states/jenkins_plugin.py' to '/var/cache/salt/minion/extmods/states/jenkins_plugin.py'
2017-11-01 11:36:11,631 [salt.utils.extmods][INFO    ][24252] Copying '/var/cache/salt/minion/files/base/_states/jenkins_security.py' to '/var/cache/salt/minion/extmods/states/jenkins_security.py'
2017-11-01 11:36:11,631 [salt.utils.extmods][INFO    ][24252] Copying '/var/cache/salt/minion/files/base/_states/jenkins_slack.py' to '/var/cache/salt/minion/extmods/states/jenkins_slack.py'
2017-11-01 11:36:11,631 [salt.utils.extmods][INFO    ][24252] Copying '/var/cache/salt/minion/files/base/_states/jenkins_smtp.py' to '/var/cache/salt/minion/extmods/states/jenkins_smtp.py'
2017-11-01 11:36:11,632 [salt.utils.extmods][INFO    ][24252] Copying '/var/cache/salt/minion/files/base/_states/jenkins_theme.py' to '/var/cache/salt/minion/extmods/states/jenkins_theme.py'
2017-11-01 11:36:11,632 [salt.utils.extmods][INFO    ][24252] Copying '/var/cache/salt/minion/files/base/_states/jenkins_user.py' to '/var/cache/salt/minion/extmods/states/jenkins_user.py'
2017-11-01 11:36:11,632 [salt.utils.extmods][INFO    ][24252] Copying '/var/cache/salt/minion/files/base/_states/jenkins_view.py' to '/var/cache/salt/minion/extmods/states/jenkins_view.py'
2017-11-01 11:36:11,633 [salt.utils.extmods][INFO    ][24252] Copying '/var/cache/salt/minion/files/base/_states/keystone_policy.py' to '/var/cache/salt/minion/extmods/states/keystone_policy.py'
2017-11-01 11:36:11,633 [salt.utils.extmods][INFO    ][24252] Copying '/var/cache/salt/minion/files/base/_states/kibana_object.py' to '/var/cache/salt/minion/extmods/states/kibana_object.py'
2017-11-01 11:36:11,633 [salt.utils.extmods][INFO    ][24252] Copying '/var/cache/salt/minion/files/base/_states/maas_cluster.py' to '/var/cache/salt/minion/extmods/states/maas_cluster.py'
2017-11-01 11:36:11,633 [salt.utils.extmods][INFO    ][24252] Copying '/var/cache/salt/minion/files/base/_states/neutronng.py' to '/var/cache/salt/minion/extmods/states/neutronng.py'
2017-11-01 11:36:11,634 [salt.utils.extmods][INFO    ][24252] Copying '/var/cache/salt/minion/files/base/_states/novang.py' to '/var/cache/salt/minion/extmods/states/novang.py'
2017-11-01 11:36:11,634 [salt.utils.extmods][INFO    ][24252] Copying '/var/cache/salt/minion/files/base/_states/reclass.py' to '/var/cache/salt/minion/extmods/states/reclass.py'
2017-11-01 11:36:11,635 [salt.utils.extmods][INFO    ][24252] Copying '/var/cache/salt/minion/files/base/_states/rundeck_project.py' to '/var/cache/salt/minion/extmods/states/rundeck_project.py'
2017-11-01 11:36:11,635 [salt.utils.extmods][INFO    ][24252] Copying '/var/cache/salt/minion/files/base/_states/rundeck_scm.py' to '/var/cache/salt/minion/extmods/states/rundeck_scm.py'
2017-11-01 11:36:11,635 [salt.utils.extmods][INFO    ][24252] Copying '/var/cache/salt/minion/files/base/_states/rundeck_secret.py' to '/var/cache/salt/minion/extmods/states/rundeck_secret.py'
2017-11-01 11:36:11,640 [salt.utils.extmods][INFO    ][24252] Creating module dir '/var/cache/salt/minion/extmods/sdb'
2017-11-01 11:36:11,648 [salt.utils.extmods][INFO    ][24252] Syncing sdb for environment 'base'
2017-11-01 11:36:11,649 [salt.utils.extmods][INFO    ][24252] Loading cache from salt://_sdb, for base)
2017-11-01 11:36:11,649 [salt.fileclient  ][INFO    ][24252] Caching directory '_sdb/' for environment 'base'
2017-11-01 11:36:11,736 [salt.utils.extmods][INFO    ][24252] Syncing grains for environment 'base'
2017-11-01 11:36:11,736 [salt.utils.extmods][INFO    ][24252] Loading cache from salt://_grains, for base)
2017-11-01 11:36:11,737 [salt.fileclient  ][INFO    ][24252] Caching directory '_grains/' for environment 'base'
2017-11-01 11:36:11,838 [salt.fileclient  ][INFO    ][24252] Fetching file from saltenv 'base', ** done ** '_grains/ceilometer_policy.py'
2017-11-01 11:36:11,855 [salt.fileclient  ][INFO    ][24252] Fetching file from saltenv 'base', ** done ** '_grains/ceph.py'
2017-11-01 11:36:11,876 [salt.fileclient  ][INFO    ][24252] Fetching file from saltenv 'base', ** done ** '_grains/cinder_policy.py'
2017-11-01 11:36:11,910 [salt.fileclient  ][INFO    ][24252] Fetching file from saltenv 'base', ** done ** '_grains/docker_swarm.py'
2017-11-01 11:36:11,936 [salt.fileclient  ][INFO    ][24252] Fetching file from saltenv 'base', ** done ** '_grains/glance_policy.py'
2017-11-01 11:36:11,966 [salt.fileclient  ][INFO    ][24252] Fetching file from saltenv 'base', ** done ** '_grains/heat_policy.py'
2017-11-01 11:36:11,981 [salt.fileclient  ][INFO    ][24252] Fetching file from saltenv 'base', ** done ** '_grains/jenkins_plugins.py'
2017-11-01 11:36:11,997 [salt.fileclient  ][INFO    ][24252] Fetching file from saltenv 'base', ** done ** '_grains/keystone_policy.py'
2017-11-01 11:36:12,024 [salt.fileclient  ][INFO    ][24252] Fetching file from saltenv 'base', ** done ** '_grains/kubernetes.py'
2017-11-01 11:36:13,196 [salt.fileclient  ][INFO    ][24252] Fetching file from saltenv 'base', ** done ** '_grains/neutron_policy.py'
2017-11-01 11:36:13,208 [salt.fileclient  ][INFO    ][24252] Fetching file from saltenv 'base', ** done ** '_grains/nova_policy.py'
2017-11-01 11:36:13,229 [salt.fileclient  ][INFO    ][24252] Fetching file from saltenv 'base', ** done ** '_grains/ssh_fingerprints.py'
2017-11-01 11:36:13,233 [salt.utils.extmods][INFO    ][24252] Copying '/var/cache/salt/minion/files/base/_grains/ceilometer_policy.py' to '/var/cache/salt/minion/extmods/grains/ceilometer_policy.py'
2017-11-01 11:36:13,234 [salt.utils.extmods][INFO    ][24252] Copying '/var/cache/salt/minion/files/base/_grains/ceph.py' to '/var/cache/salt/minion/extmods/grains/ceph.py'
2017-11-01 11:36:13,234 [salt.utils.extmods][INFO    ][24252] Copying '/var/cache/salt/minion/files/base/_grains/cinder_policy.py' to '/var/cache/salt/minion/extmods/grains/cinder_policy.py'
2017-11-01 11:36:13,235 [salt.utils.extmods][INFO    ][24252] Copying '/var/cache/salt/minion/files/base/_grains/docker_swarm.py' to '/var/cache/salt/minion/extmods/grains/docker_swarm.py'
2017-11-01 11:36:13,235 [salt.utils.extmods][INFO    ][24252] Copying '/var/cache/salt/minion/files/base/_grains/glance_policy.py' to '/var/cache/salt/minion/extmods/grains/glance_policy.py'
2017-11-01 11:36:13,235 [salt.utils.extmods][INFO    ][24252] Copying '/var/cache/salt/minion/files/base/_grains/heat_policy.py' to '/var/cache/salt/minion/extmods/grains/heat_policy.py'
2017-11-01 11:36:13,236 [salt.utils.extmods][INFO    ][24252] Copying '/var/cache/salt/minion/files/base/_grains/jenkins_plugins.py' to '/var/cache/salt/minion/extmods/grains/jenkins_plugins.py'
2017-11-01 11:36:13,236 [salt.utils.extmods][INFO    ][24252] Copying '/var/cache/salt/minion/files/base/_grains/keystone_policy.py' to '/var/cache/salt/minion/extmods/grains/keystone_policy.py'
2017-11-01 11:36:13,236 [salt.utils.extmods][INFO    ][24252] Copying '/var/cache/salt/minion/files/base/_grains/kubernetes.py' to '/var/cache/salt/minion/extmods/grains/kubernetes.py'
2017-11-01 11:36:13,237 [salt.utils.extmods][INFO    ][24252] Copying '/var/cache/salt/minion/files/base/_grains/neutron_policy.py' to '/var/cache/salt/minion/extmods/grains/neutron_policy.py'
2017-11-01 11:36:13,237 [salt.utils.extmods][INFO    ][24252] Copying '/var/cache/salt/minion/files/base/_grains/nova_policy.py' to '/var/cache/salt/minion/extmods/grains/nova_policy.py'
2017-11-01 11:36:13,237 [salt.utils.extmods][INFO    ][24252] Copying '/var/cache/salt/minion/files/base/_grains/ssh_fingerprints.py' to '/var/cache/salt/minion/extmods/grains/ssh_fingerprints.py'
2017-11-01 11:36:13,239 [salt.utils.extmods][INFO    ][24252] Creating module dir '/var/cache/salt/minion/extmods/renderers'
2017-11-01 11:36:13,244 [salt.utils.extmods][INFO    ][24252] Syncing renderers for environment 'base'
2017-11-01 11:36:13,245 [salt.utils.extmods][INFO    ][24252] Loading cache from salt://_renderers, for base)
2017-11-01 11:36:13,245 [salt.fileclient  ][INFO    ][24252] Caching directory '_renderers/' for environment 'base'
2017-11-01 11:36:13,300 [salt.utils.extmods][INFO    ][24252] Creating module dir '/var/cache/salt/minion/extmods/returners'
2017-11-01 11:36:13,304 [salt.utils.extmods][INFO    ][24252] Syncing returners for environment 'base'
2017-11-01 11:36:13,304 [salt.utils.extmods][INFO    ][24252] Loading cache from salt://_returners, for base)
2017-11-01 11:36:13,304 [salt.fileclient  ][INFO    ][24252] Caching directory '_returners/' for environment 'base'
2017-11-01 11:36:13,343 [salt.utils.extmods][INFO    ][24252] Creating module dir '/var/cache/salt/minion/extmods/output'
2017-11-01 11:36:13,346 [salt.utils.extmods][INFO    ][24252] Syncing output for environment 'base'
2017-11-01 11:36:13,347 [salt.utils.extmods][INFO    ][24252] Loading cache from salt://_output, for base)
2017-11-01 11:36:13,347 [salt.fileclient  ][INFO    ][24252] Caching directory '_output/' for environment 'base'
2017-11-01 11:36:13,394 [salt.utils.extmods][INFO    ][24252] Creating module dir '/var/cache/salt/minion/extmods/utils'
2017-11-01 11:36:13,398 [salt.utils.extmods][INFO    ][24252] Syncing utils for environment 'base'
2017-11-01 11:36:13,398 [salt.utils.extmods][INFO    ][24252] Loading cache from salt://_utils, for base)
2017-11-01 11:36:13,398 [salt.fileclient  ][INFO    ][24252] Caching directory '_utils/' for environment 'base'
2017-11-01 11:36:13,444 [salt.utils.extmods][INFO    ][24252] Creating module dir '/var/cache/salt/minion/extmods/log_handlers'
2017-11-01 11:36:13,447 [salt.utils.extmods][INFO    ][24252] Syncing log_handlers for environment 'base'
2017-11-01 11:36:13,448 [salt.utils.extmods][INFO    ][24252] Loading cache from salt://_log_handlers, for base)
2017-11-01 11:36:13,448 [salt.fileclient  ][INFO    ][24252] Caching directory '_log_handlers/' for environment 'base'
2017-11-01 11:36:13,606 [salt.utils.extmods][INFO    ][24252] Creating module dir '/var/cache/salt/minion/extmods/proxy'
2017-11-01 11:36:13,610 [salt.utils.extmods][INFO    ][24252] Syncing proxy for environment 'base'
2017-11-01 11:36:13,610 [salt.utils.extmods][INFO    ][24252] Loading cache from salt://_proxy, for base)
2017-11-01 11:36:13,611 [salt.fileclient  ][INFO    ][24252] Caching directory '_proxy/' for environment 'base'
2017-11-01 11:36:14,313 [salt.utils.extmods][INFO    ][24252] Creating module dir '/var/cache/salt/minion/extmods/engines'
2017-11-01 11:36:14,322 [salt.utils.extmods][INFO    ][24252] Syncing engines for environment 'base'
2017-11-01 11:36:14,324 [salt.utils.extmods][INFO    ][24252] Loading cache from salt://_engines, for base)
2017-11-01 11:36:14,325 [salt.fileclient  ][INFO    ][24252] Caching directory '_engines/' for environment 'base'
2017-11-01 11:36:14,373 [salt.minion      ][INFO    ][24252] Returning information for job: 20171101113604533270
2017-11-01 11:38:38,995 [salt.minion      ][INFO    ][24030] User sudo_ubuntu Executing command test.ping with jid 20171101113838984271
2017-11-01 11:38:39,026 [salt.minion      ][INFO    ][24388] Starting a new job with PID 24388
2017-11-01 11:38:39,077 [salt.minion      ][INFO    ][24388] Returning information for job: 20171101113838984271
2017-11-01 11:40:15,314 [salt.minion      ][INFO    ][24030] User sudo_ubuntu Executing command state.sls with jid 20171101114015303746
2017-11-01 11:40:15,338 [salt.minion      ][INFO    ][24407] Starting a new job with PID 24407
2017-11-01 11:40:15,947 [salt.state       ][INFO    ][24407] Loading fresh modules for state activity
2017-11-01 11:40:15,988 [salt.fileclient  ][INFO    ][24407] Fetching file from saltenv 'base', ** done ** 'keepalived/init.sls'
2017-11-01 11:40:16,045 [salt.fileclient  ][INFO    ][24407] Fetching file from saltenv 'base', ** done ** 'keepalived/cluster.sls'
2017-11-01 11:40:16,086 [salt.fileclient  ][INFO    ][24407] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-11-01 11:40:16,496 [salt.state       ][INFO    ][24407] Running state [lsof] at time 11:40:16.495802
2017-11-01 11:40:16,496 [salt.state       ][INFO    ][24407] Executing state pkg.installed for lsof
2017-11-01 11:40:16,497 [salt.loaded.int.module.cmdmod][INFO    ][24407] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-01 11:40:16,796 [salt.state       ][INFO    ][24407] Package lsof is already installed
2017-11-01 11:40:16,797 [salt.state       ][INFO    ][24407] Completed state [lsof] at time 11:40:16.796766 duration_in_ms=300.964
2017-11-01 11:40:16,797 [salt.state       ][INFO    ][24407] Running state [keepalived] at time 11:40:16.797365
2017-11-01 11:40:16,798 [salt.state       ][INFO    ][24407] Executing state pkg.installed for keepalived
2017-11-01 11:40:16,826 [salt.loaded.int.module.cmdmod][INFO    ][24407] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-11-01 11:40:19,327 [salt.loaded.int.module.cmdmod][INFO    ][24407] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'keepalived'] in directory '/root'
2017-11-01 11:40:23,573 [salt.loaded.int.module.cmdmod][INFO    ][24407] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-01 11:40:23,628 [salt.state       ][INFO    ][24407] Made the following changes:
'libsnmp30' changed from 'absent' to '5.7.3+dfsg-1ubuntu4'
'libsnmp-base' changed from 'absent' to '5.7.3+dfsg-1ubuntu4'
'keepalived' changed from 'absent' to '1:1.2.19-1ubuntu0.2'
'ipvsadm' changed from 'absent' to '1:1.28-3'
'libsensors4' changed from 'absent' to '1:3.4.0-2'

2017-11-01 11:40:23,641 [salt.state       ][INFO    ][24407] Loading fresh modules for state activity
2017-11-01 11:40:23,660 [salt.state       ][INFO    ][24407] Completed state [keepalived] at time 11:40:23.659848 duration_in_ms=6862.481
2017-11-01 11:40:23,662 [salt.state       ][INFO    ][24407] Running state [/etc/keepalived/keepalived.conf] at time 11:40:23.662293
2017-11-01 11:40:23,663 [salt.state       ][INFO    ][24407] Executing state file.managed for /etc/keepalived/keepalived.conf
2017-11-01 11:40:23,693 [salt.fileclient  ][INFO    ][24407] Fetching file from saltenv 'base', ** done ** 'keepalived/files/keepalived.conf'
2017-11-01 11:40:23,740 [salt.fileclient  ][INFO    ][24407] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-11-01 11:40:23,754 [salt.state       ][INFO    ][24407] File changed:
New file
2017-11-01 11:40:23,755 [salt.state       ][INFO    ][24407] Completed state [/etc/keepalived/keepalived.conf] at time 11:40:23.755255 duration_in_ms=92.962
2017-11-01 11:40:23,861 [salt.state       ][INFO    ][24407] Running state [keepalived] at time 11:40:23.860845
2017-11-01 11:40:23,861 [salt.state       ][INFO    ][24407] Executing state service.running for keepalived
2017-11-01 11:40:23,870 [salt.loaded.int.module.cmdmod][INFO    ][24407] Executing command ['systemctl', 'status', 'keepalived.service', '-n', '0'] in directory '/root'
2017-11-01 11:40:23,894 [salt.loaded.int.module.cmdmod][INFO    ][24407] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2017-11-01 11:40:23,920 [salt.loaded.int.module.cmdmod][INFO    ][24407] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-11-01 11:40:23,940 [salt.loaded.int.module.cmdmod][INFO    ][24407] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-11-01 11:40:23,965 [salt.loaded.int.module.cmdmod][INFO    ][24407] Executing command ['systemd-run', '--scope', 'systemctl', 'start', 'keepalived.service'] in directory '/root'
2017-11-01 11:40:24,040 [salt.loaded.int.module.cmdmod][INFO    ][24407] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2017-11-01 11:40:24,068 [salt.loaded.int.module.cmdmod][INFO    ][24407] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-11-01 11:40:24,092 [salt.loaded.int.module.cmdmod][INFO    ][24407] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-11-01 11:40:24,105 [salt.state       ][INFO    ][24407] {'keepalived': True}
2017-11-01 11:40:24,106 [salt.state       ][INFO    ][24407] Completed state [keepalived] at time 11:40:24.105225 duration_in_ms=244.389
2017-11-01 11:40:24,110 [salt.minion      ][INFO    ][24407] Returning information for job: 20171101114015303746
2017-11-01 11:40:46,414 [salt.minion      ][INFO    ][24030] User sudo_ubuntu Executing command pillar.get with jid 20171101114046407739
2017-11-01 11:40:46,448 [salt.minion      ][INFO    ][25956] Starting a new job with PID 25956
2017-11-01 11:40:46,456 [salt.minion      ][INFO    ][25956] Returning information for job: 20171101114046407739
2017-11-01 11:45:46,192 [salt.minion      ][INFO    ][24030] User sudo_ubuntu Executing command state.sls with jid 20171101114546184978
2017-11-01 11:45:46,218 [salt.minion      ][INFO    ][26043] Starting a new job with PID 26043
2017-11-01 11:45:48,918 [salt.state       ][INFO    ][26043] Loading fresh modules for state activity
2017-11-01 11:45:48,952 [salt.fileclient  ][INFO    ][26043] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-11-01 11:45:48,991 [salt.fileclient  ][INFO    ][26043] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-11-01 11:45:49,340 [salt.state       ][INFO    ][26043] Running state [attr] at time 11:45:49.339572
2017-11-01 11:45:49,340 [salt.state       ][INFO    ][26043] Executing state pkg.installed for attr
2017-11-01 11:45:49,341 [salt.loaded.int.module.cmdmod][INFO    ][26043] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-01 11:45:49,677 [salt.loaded.int.module.cmdmod][INFO    ][26043] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-11-01 11:45:52,164 [salt.loaded.int.module.cmdmod][INFO    ][26043] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'attr'] in directory '/root'
2017-11-01 11:45:54,093 [salt.loaded.int.module.cmdmod][INFO    ][26043] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-01 11:45:54,155 [salt.state       ][INFO    ][26043] Made the following changes:
'attr' changed from 'absent' to '1:2.4.47-2'

2017-11-01 11:45:54,168 [salt.state       ][INFO    ][26043] Loading fresh modules for state activity
2017-11-01 11:45:54,217 [salt.state       ][INFO    ][26043] Completed state [attr] at time 11:45:54.217384 duration_in_ms=4877.812
2017-11-01 11:45:54,227 [salt.state       ][INFO    ][26043] Running state [glusterfs-server] at time 11:45:54.226835
2017-11-01 11:45:54,227 [salt.state       ][INFO    ][26043] Executing state pkg.installed for glusterfs-server
2017-11-01 11:45:54,560 [salt.loaded.int.module.cmdmod][INFO    ][26043] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'glusterfs-server'] in directory '/root'
2017-11-01 11:45:56,293 [salt.minion      ][INFO    ][24030] User sudo_ubuntu Executing command saltutil.find_job with jid 20171101114556283477
2017-11-01 11:45:56,317 [salt.minion      ][INFO    ][27089] Starting a new job with PID 27089
2017-11-01 11:45:56,338 [salt.minion      ][INFO    ][27089] Returning information for job: 20171101114556283477
2017-11-01 11:46:05,059 [salt.loaded.int.module.cmdmod][INFO    ][26043] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-01 11:46:05,114 [salt.state       ][INFO    ][26043] Made the following changes:
'keyutils' changed from 'absent' to '1.5.9-8ubuntu1'
'nfs-common' changed from 'absent' to '1:1.2.8-9ubuntu12.1'
'rpcbind' changed from 'absent' to '0.2.3-0.2'
'glusterfs-common' changed from 'absent' to '3.7.6-1ubuntu1'
'librdmacm1' changed from 'absent' to '1.0.21-1'
'libnfsidmap2' changed from 'absent' to '0.25-5'
'portmap' changed from 'absent' to '1'
'libattr1-dev' changed from 'absent' to '1:2.4.47-2'
'attr-dev' changed from 'absent' to '1'
'acl-dev' changed from 'absent' to '1'
'glusterfs-server' changed from 'absent' to '3.7.6-1ubuntu1'
'glusterfs-client' changed from 'absent' to '3.7.6-1ubuntu1'
'libpython2.7' changed from 'absent' to '2.7.12-1ubuntu0~16.04.1'
'nfs-client' changed from 'absent' to '1'
'liburcu4' changed from 'absent' to '0.9.1-3'
'libacl1-dev' changed from 'absent' to '2.2.52-3'
'libibverbs1' changed from 'absent' to '1.1.8-1.1ubuntu2'
'libtirpc1' changed from 'absent' to '0.2.5-1'

2017-11-01 11:46:05,129 [salt.state       ][INFO    ][26043] Loading fresh modules for state activity
2017-11-01 11:46:05,152 [salt.state       ][INFO    ][26043] Completed state [glusterfs-server] at time 11:46:05.151559 duration_in_ms=10924.724
2017-11-01 11:46:05,158 [salt.state       ][INFO    ][26043] Running state [bc] at time 11:46:05.157466
2017-11-01 11:46:05,158 [salt.state       ][INFO    ][26043] Executing state pkg.installed for bc
2017-11-01 11:46:05,543 [salt.loaded.int.module.cmdmod][INFO    ][26043] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'bc'] in directory '/root'
2017-11-01 11:46:06,480 [salt.minion      ][INFO    ][24030] User sudo_ubuntu Executing command saltutil.find_job with jid 20171101114606462054
2017-11-01 11:46:06,511 [salt.minion      ][INFO    ][30556] Starting a new job with PID 30556
2017-11-01 11:46:06,538 [salt.minion      ][INFO    ][30556] Returning information for job: 20171101114606462054
2017-11-01 11:46:07,593 [salt.loaded.int.module.cmdmod][INFO    ][26043] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-01 11:46:07,652 [salt.state       ][INFO    ][26043] Made the following changes:
'bc' changed from 'absent' to '1.06.95-9build1'

2017-11-01 11:46:07,662 [salt.state       ][INFO    ][26043] Loading fresh modules for state activity
2017-11-01 11:46:07,713 [salt.state       ][INFO    ][26043] Completed state [bc] at time 11:46:07.713118 duration_in_ms=2555.651
2017-11-01 11:46:07,800 [salt.state       ][INFO    ][26043] Running state [glusterfs-server] at time 11:46:07.799782
2017-11-01 11:46:07,800 [salt.state       ][INFO    ][26043] Executing state service.running for glusterfs-server
2017-11-01 11:46:07,802 [salt.loaded.int.module.cmdmod][INFO    ][26043] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-11-01 11:46:07,821 [salt.loaded.int.module.cmdmod][INFO    ][26043] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-11-01 11:46:07,838 [salt.loaded.int.module.cmdmod][INFO    ][26043] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-11-01 11:46:07,861 [salt.state       ][INFO    ][26043] The service glusterfs-server is already running
2017-11-01 11:46:07,862 [salt.state       ][INFO    ][26043] Completed state [glusterfs-server] at time 11:46:07.861696 duration_in_ms=61.914
2017-11-01 11:46:07,865 [salt.state       ][INFO    ][26043] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 11:46:07.865073
2017-11-01 11:46:07,865 [salt.state       ][INFO    ][26043] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-11-01 11:46:07,880 [salt.state       ][INFO    ][26043] File changed:
New file
2017-11-01 11:46:07,880 [salt.state       ][INFO    ][26043] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 11:46:07.880287 duration_in_ms=15.213
2017-11-01 11:46:07,881 [salt.state       ][INFO    ][26043] Running state [/srv/glusterfs/glance] at time 11:46:07.880997
2017-11-01 11:46:07,881 [salt.state       ][INFO    ][26043] Executing state file.directory for /srv/glusterfs/glance
2017-11-01 11:46:07,884 [salt.state       ][INFO    ][26043] {'/srv/glusterfs/glance': 'New Dir'}
2017-11-01 11:46:07,885 [salt.state       ][INFO    ][26043] Completed state [/srv/glusterfs/glance] at time 11:46:07.884515 duration_in_ms=3.517
2017-11-01 11:46:07,885 [salt.state       ][INFO    ][26043] Running state [/srv/glusterfs/keystone-keys] at time 11:46:07.884865
2017-11-01 11:46:07,885 [salt.state       ][INFO    ][26043] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-11-01 11:46:07,886 [salt.state       ][INFO    ][26043] {'/srv/glusterfs/keystone-keys': 'New Dir'}
2017-11-01 11:46:07,888 [salt.state       ][INFO    ][26043] Completed state [/srv/glusterfs/keystone-keys] at time 11:46:07.888018 duration_in_ms=3.154
2017-11-01 11:46:07,889 [salt.state       ][INFO    ][26043] Running state [/srv/glusterfs/nova_instances] at time 11:46:07.888486
2017-11-01 11:46:07,889 [salt.state       ][INFO    ][26043] Executing state file.directory for /srv/glusterfs/nova_instances
2017-11-01 11:46:07,889 [salt.state       ][INFO    ][26043] {'/srv/glusterfs/nova_instances': 'New Dir'}
2017-11-01 11:46:07,889 [salt.state       ][INFO    ][26043] Completed state [/srv/glusterfs/nova_instances] at time 11:46:07.889232 duration_in_ms=0.747
2017-11-01 11:46:07,889 [salt.state       ][INFO    ][26043] Running state [/srv/glusterfs/keystone-credential-keys] at time 11:46:07.889394
2017-11-01 11:46:07,890 [salt.state       ][INFO    ][26043] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-11-01 11:46:07,891 [salt.state       ][INFO    ][26043] {'/srv/glusterfs/keystone-credential-keys': 'New Dir'}
2017-11-01 11:46:07,891 [salt.state       ][INFO    ][26043] Completed state [/srv/glusterfs/keystone-credential-keys] at time 11:46:07.891340 duration_in_ms=1.945
2017-11-01 11:46:07,892 [salt.minion      ][INFO    ][26043] Returning information for job: 20171101114546184978
2017-11-01 11:46:08,936 [salt.minion      ][INFO    ][24030] User sudo_ubuntu Executing command test.ping with jid 20171101114608930437
2017-11-01 11:46:08,962 [salt.minion      ][INFO    ][30748] Starting a new job with PID 30748
2017-11-01 11:46:09,007 [salt.minion      ][INFO    ][30748] Returning information for job: 20171101114608930437
2017-11-01 11:46:09,136 [salt.minion      ][INFO    ][24030] User sudo_ubuntu Executing command state.sls with jid 20171101114609128356
2017-11-01 11:46:09,162 [salt.minion      ][INFO    ][30753] Starting a new job with PID 30753
2017-11-01 11:46:11,436 [salt.state       ][INFO    ][30753] Loading fresh modules for state activity
2017-11-01 11:46:11,477 [salt.fileclient  ][INFO    ][30753] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/setup.sls'
2017-11-01 11:46:11,535 [salt.fileclient  ][INFO    ][30753] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-11-01 11:46:11,633 [salt.fileclient  ][INFO    ][30753] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-11-01 11:46:11,671 [salt.fileclient  ][INFO    ][30753] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-11-01 11:46:12,051 [salt.state       ][INFO    ][30753] Running state [attr] at time 11:46:12.050824
2017-11-01 11:46:12,051 [salt.state       ][INFO    ][30753] Executing state pkg.installed for attr
2017-11-01 11:46:12,052 [salt.loaded.int.module.cmdmod][INFO    ][30753] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-01 11:46:12,368 [salt.state       ][INFO    ][30753] Package attr is already installed
2017-11-01 11:46:12,369 [salt.state       ][INFO    ][30753] Completed state [attr] at time 11:46:12.368629 duration_in_ms=317.805
2017-11-01 11:46:12,369 [salt.state       ][INFO    ][30753] Running state [glusterfs-server] at time 11:46:12.368915
2017-11-01 11:46:12,369 [salt.state       ][INFO    ][30753] Executing state pkg.installed for glusterfs-server
2017-11-01 11:46:12,373 [salt.state       ][INFO    ][30753] Package glusterfs-server is already installed
2017-11-01 11:46:12,373 [salt.state       ][INFO    ][30753] Completed state [glusterfs-server] at time 11:46:12.373426 duration_in_ms=4.511
2017-11-01 11:46:12,374 [salt.state       ][INFO    ][30753] Running state [bc] at time 11:46:12.373624
2017-11-01 11:46:12,374 [salt.state       ][INFO    ][30753] Executing state pkg.installed for bc
2017-11-01 11:46:12,377 [salt.state       ][INFO    ][30753] Package bc is already installed
2017-11-01 11:46:12,378 [salt.state       ][INFO    ][30753] Completed state [bc] at time 11:46:12.377585 duration_in_ms=3.961
2017-11-01 11:46:12,379 [salt.state       ][INFO    ][30753] Running state [glusterfs-server] at time 11:46:12.378647
2017-11-01 11:46:12,379 [salt.state       ][INFO    ][30753] Executing state service.running for glusterfs-server
2017-11-01 11:46:12,379 [salt.loaded.int.module.cmdmod][INFO    ][30753] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-11-01 11:46:12,398 [salt.loaded.int.module.cmdmod][INFO    ][30753] Executing command ['systemctl', '--system', 'daemon-reload'] in directory '/root'
2017-11-01 11:46:12,497 [salt.loaded.int.module.cmdmod][INFO    ][30753] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-11-01 11:46:12,535 [salt.loaded.int.module.cmdmod][INFO    ][30753] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-11-01 11:46:12,552 [salt.loaded.int.module.cmdmod][INFO    ][30753] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-11-01 11:46:12,576 [salt.state       ][INFO    ][30753] The service glusterfs-server is already running
2017-11-01 11:46:12,576 [salt.state       ][INFO    ][30753] Completed state [glusterfs-server] at time 11:46:12.576256 duration_in_ms=197.606
2017-11-01 11:46:12,581 [salt.state       ][INFO    ][30753] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 11:46:12.580772
2017-11-01 11:46:12,581 [salt.state       ][INFO    ][30753] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-11-01 11:46:12,585 [salt.state       ][INFO    ][30753] File /etc/systemd/system/glusterfs-server.service.d/override.conf is in the correct state
2017-11-01 11:46:12,585 [salt.state       ][INFO    ][30753] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 11:46:12.585217 duration_in_ms=4.445
2017-11-01 11:46:12,586 [salt.state       ][INFO    ][30753] Running state [/srv/glusterfs/glance] at time 11:46:12.585535
2017-11-01 11:46:12,586 [salt.state       ][INFO    ][30753] Executing state file.directory for /srv/glusterfs/glance
2017-11-01 11:46:12,587 [salt.state       ][INFO    ][30753] Directory /srv/glusterfs/glance is in the correct state
2017-11-01 11:46:12,588 [salt.state       ][INFO    ][30753] Completed state [/srv/glusterfs/glance] at time 11:46:12.588323 duration_in_ms=2.788
2017-11-01 11:46:12,589 [salt.state       ][INFO    ][30753] Running state [/srv/glusterfs/keystone-keys] at time 11:46:12.588616
2017-11-01 11:46:12,589 [salt.state       ][INFO    ][30753] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-11-01 11:46:12,590 [salt.state       ][INFO    ][30753] Directory /srv/glusterfs/keystone-keys is in the correct state
2017-11-01 11:46:12,590 [salt.state       ][INFO    ][30753] Completed state [/srv/glusterfs/keystone-keys] at time 11:46:12.589784 duration_in_ms=1.167
2017-11-01 11:46:12,593 [salt.state       ][INFO    ][30753] Running state [/srv/glusterfs/nova_instances] at time 11:46:12.591838
2017-11-01 11:46:12,593 [salt.state       ][INFO    ][30753] Executing state file.directory for /srv/glusterfs/nova_instances
2017-11-01 11:46:12,594 [salt.state       ][INFO    ][30753] Directory /srv/glusterfs/nova_instances is in the correct state
2017-11-01 11:46:12,594 [salt.state       ][INFO    ][30753] Completed state [/srv/glusterfs/nova_instances] at time 11:46:12.593797 duration_in_ms=1.959
2017-11-01 11:46:12,594 [salt.state       ][INFO    ][30753] Running state [/srv/glusterfs/keystone-credential-keys] at time 11:46:12.593953
2017-11-01 11:46:12,594 [salt.state       ][INFO    ][30753] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-11-01 11:46:12,595 [salt.state       ][INFO    ][30753] Directory /srv/glusterfs/keystone-credential-keys is in the correct state
2017-11-01 11:46:12,595 [salt.state       ][INFO    ][30753] Completed state [/srv/glusterfs/keystone-credential-keys] at time 11:46:12.594971 duration_in_ms=1.017
2017-11-01 11:46:12,662 [salt.loaded.int.module.cmdmod][INFO    ][30753] Executing command ['git', '--version'] in directory '/root'
2017-11-01 11:46:12,804 [salt.state       ][INFO    ][30753] Running state [sleep 5] at time 11:46:12.803445
2017-11-01 11:46:12,804 [salt.state       ][INFO    ][30753] Executing state cmd.wait for sleep 5
2017-11-01 11:46:12,804 [salt.state       ][INFO    ][30753] No changes made for sleep 5
2017-11-01 11:46:12,805 [salt.state       ][INFO    ][30753] Completed state [sleep 5] at time 11:46:12.804528 duration_in_ms=1.084
2017-11-01 11:46:12,805 [salt.state       ][INFO    ][30753] Running state [192.168.10.143] at time 11:46:12.805135
2017-11-01 11:46:12,805 [salt.state       ][INFO    ][30753] Executing state glusterfs.peered for 192.168.10.143
2017-11-01 11:46:12,806 [salt.loaded.int.module.cmdmod][INFO    ][30753] Executing command 'gluster --version' in directory '/root'
2017-11-01 11:46:12,825 [salt.loaded.int.module.cmdmod][INFO    ][30753] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-01 11:46:12,904 [salt.loaded.int.module.cmdmod][INFO    ][30753] Executing command 'gluster --version' in directory '/root'
2017-11-01 11:46:12,926 [salt.loaded.int.module.cmdmod][INFO    ][30753] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-01 11:46:13,030 [salt.loaded.int.module.cmdmod][INFO    ][30753] Executing command 'gluster --version' in directory '/root'
2017-11-01 11:46:13,053 [salt.loaded.int.module.cmdmod][INFO    ][30753] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-01 11:46:13,133 [salt.loaded.int.module.cmdmod][INFO    ][30753] Executing command 'gluster --version' in directory '/root'
2017-11-01 11:46:13,155 [salt.loaded.int.module.cmdmod][INFO    ][30753] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-01 11:46:13,236 [salt.state       ][INFO    ][30753] {'new': {'192.168.10.143': []}, 'old': None}
2017-11-01 11:46:13,237 [salt.state       ][INFO    ][30753] Completed state [192.168.10.143] at time 11:46:13.236732 duration_in_ms=431.595
2017-11-01 11:46:13,245 [salt.state       ][INFO    ][30753] Running state [192.168.10.142] at time 11:46:13.245280
2017-11-01 11:46:13,246 [salt.state       ][INFO    ][30753] Executing state glusterfs.peered for 192.168.10.142
2017-11-01 11:46:13,249 [salt.loaded.int.module.cmdmod][INFO    ][30753] Executing command 'gluster --version' in directory '/root'
2017-11-01 11:46:13,266 [salt.loaded.int.module.cmdmod][INFO    ][30753] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-01 11:46:13,345 [salt.loaded.int.module.cmdmod][INFO    ][30753] Executing command 'gluster --version' in directory '/root'
2017-11-01 11:46:13,366 [salt.loaded.int.module.cmdmod][INFO    ][30753] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-01 11:46:13,449 [salt.loaded.int.module.cmdmod][INFO    ][30753] Executing command 'gluster --version' in directory '/root'
2017-11-01 11:46:13,469 [salt.loaded.int.module.cmdmod][INFO    ][30753] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-01 11:46:13,567 [salt.loaded.int.module.cmdmod][INFO    ][30753] Executing command 'gluster --version' in directory '/root'
2017-11-01 11:46:13,590 [salt.loaded.int.module.cmdmod][INFO    ][30753] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-01 11:46:13,672 [salt.state       ][INFO    ][30753] Peering with localhost is not needed
2017-11-01 11:46:13,673 [salt.state       ][INFO    ][30753] Completed state [192.168.10.142] at time 11:46:13.672366 duration_in_ms=427.086
2017-11-01 11:46:13,683 [salt.state       ][INFO    ][30753] Running state [192.168.10.141] at time 11:46:13.683233
2017-11-01 11:46:13,684 [salt.state       ][INFO    ][30753] Executing state glusterfs.peered for 192.168.10.141
2017-11-01 11:46:13,685 [salt.loaded.int.module.cmdmod][INFO    ][30753] Executing command 'gluster --version' in directory '/root'
2017-11-01 11:46:13,705 [salt.loaded.int.module.cmdmod][INFO    ][30753] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-01 11:46:13,785 [salt.loaded.int.module.cmdmod][INFO    ][30753] Executing command 'gluster --version' in directory '/root'
2017-11-01 11:46:13,804 [salt.loaded.int.module.cmdmod][INFO    ][30753] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-01 11:46:13,899 [salt.loaded.int.module.cmdmod][INFO    ][30753] Executing command 'gluster --version' in directory '/root'
2017-11-01 11:46:13,924 [salt.loaded.int.module.cmdmod][INFO    ][30753] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-01 11:46:14,005 [salt.loaded.int.module.cmdmod][INFO    ][30753] Executing command 'gluster --version' in directory '/root'
2017-11-01 11:46:14,025 [salt.loaded.int.module.cmdmod][INFO    ][30753] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-01 11:46:14,106 [salt.state       ][INFO    ][30753] {'new': {'192.168.10.143': [], '192.168.10.141': []}, 'old': {'192.168.10.143': []}}
2017-11-01 11:46:14,108 [salt.state       ][INFO    ][30753] Completed state [192.168.10.141] at time 11:46:14.107728 duration_in_ms=424.494
2017-11-01 11:46:14,110 [salt.state       ][INFO    ][30753] Running state [glance] at time 11:46:14.109988
2017-11-01 11:46:14,111 [salt.state       ][INFO    ][30753] Executing state glusterfs.created for glance
2017-11-01 11:46:14,112 [salt.loaded.int.module.cmdmod][INFO    ][30753] Executing command 'gluster --version' in directory '/root'
2017-11-01 11:46:14,137 [salt.loaded.int.module.cmdmod][INFO    ][30753] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-01 11:46:14,224 [salt.loaded.int.module.cmdmod][INFO    ][30753] Executing command 'gluster --version' in directory '/root'
2017-11-01 11:46:14,246 [salt.loaded.int.module.cmdmod][INFO    ][30753] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-01 11:46:14,364 [salt.loaded.int.module.cmdmod][INFO    ][30753] Executing command 'gluster --version' in directory '/root'
2017-11-01 11:46:14,386 [salt.loaded.int.module.cmdmod][INFO    ][30753] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-01 11:46:14,883 [salt.loaded.int.module.cmdmod][INFO    ][30753] Executing command 'gluster --version' in directory '/root'
2017-11-01 11:46:14,905 [salt.loaded.int.module.cmdmod][INFO    ][30753] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-01 11:46:14,985 [salt.state       ][INFO    ][30753] {'new': ['glance'], 'old': []}
2017-11-01 11:46:14,985 [salt.state       ][INFO    ][30753] Completed state [glance] at time 11:46:14.985383 duration_in_ms=875.394
2017-11-01 11:46:14,997 [salt.state       ][INFO    ][30753] Running state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 11:46:14.996720
2017-11-01 11:46:14,997 [salt.state       ][INFO    ][30753] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'
2017-11-01 11:46:15,001 [salt.loaded.int.module.cmdmod][INFO    ][30753] Executing command 'gluster volume info 'glance' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-11-01 11:46:15,084 [salt.loaded.int.module.cmdmod][INFO    ][30753] Executing command 'gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'' in directory '/root'
2017-11-01 11:46:15,228 [salt.state       ][INFO    ][30753] {'pid': 30977, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-11-01 11:46:15,228 [salt.state       ][INFO    ][30753] Completed state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 11:46:15.228070 duration_in_ms=231.35
2017-11-01 11:46:15,230 [salt.state       ][INFO    ][30753] Running state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 11:46:15.229678
2017-11-01 11:46:15,230 [salt.state       ][INFO    ][30753] Executing state cmd.run for gluster volume set 'glance' 'network.remote-dio' 'True'
2017-11-01 11:46:15,233 [salt.loaded.int.module.cmdmod][INFO    ][30753] Executing command 'gluster volume info 'glance' | grep 'network.remote-dio: True'' in directory '/root'
2017-11-01 11:46:15,320 [salt.loaded.int.module.cmdmod][INFO    ][30753] Executing command 'gluster volume set 'glance' 'network.remote-dio' 'True'' in directory '/root'
2017-11-01 11:46:15,473 [salt.state       ][INFO    ][30753] {'pid': 30995, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-11-01 11:46:15,473 [salt.state       ][INFO    ][30753] Completed state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 11:46:15.473392 duration_in_ms=243.714
2017-11-01 11:46:15,475 [salt.state       ][INFO    ][30753] Running state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 11:46:15.475070
2017-11-01 11:46:15,476 [salt.state       ][INFO    ][30753] Executing state cmd.run for gluster volume set 'glance' 'nfs.disable' 'True'
2017-11-01 11:46:15,477 [salt.loaded.int.module.cmdmod][INFO    ][30753] Executing command 'gluster volume info 'glance' | grep 'nfs.disable: True'' in directory '/root'
2017-11-01 11:46:15,577 [salt.loaded.int.module.cmdmod][INFO    ][30753] Executing command 'gluster volume set 'glance' 'nfs.disable' 'True'' in directory '/root'
2017-11-01 11:46:17,745 [salt.state       ][INFO    ][30753] {'pid': 31012, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-11-01 11:46:17,746 [salt.state       ][INFO    ][30753] Completed state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 11:46:17.745497 duration_in_ms=2270.426
2017-11-01 11:46:17,748 [salt.state       ][INFO    ][30753] Running state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 11:46:17.747487
2017-11-01 11:46:17,748 [salt.state       ][INFO    ][30753] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'
2017-11-01 11:46:17,749 [salt.loaded.int.module.cmdmod][INFO    ][30753] Executing command 'gluster volume info 'glance' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-11-01 11:46:17,846 [salt.loaded.int.module.cmdmod][INFO    ][30753] Executing command 'gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'' in directory '/root'
2017-11-01 11:46:17,997 [salt.state       ][INFO    ][30753] {'pid': 31029, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-11-01 11:46:17,998 [salt.state       ][INFO    ][30753] Completed state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 11:46:17.997656 duration_in_ms=250.168
2017-11-01 11:46:17,1000 [salt.state       ][INFO    ][30753] Running state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 11:46:17.999864
2017-11-01 11:46:18,000 [salt.state       ][INFO    ][30753] Executing state cmd.run for gluster volume set 'glance' 'cluster.readdir-optimize' 'True'
2017-11-01 11:46:18,001 [salt.loaded.int.module.cmdmod][INFO    ][30753] Executing command 'gluster volume info 'glance' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-11-01 11:46:18,090 [salt.loaded.int.module.cmdmod][INFO    ][30753] Executing command 'gluster volume set 'glance' 'cluster.readdir-optimize' 'True'' in directory '/root'
2017-11-01 11:46:18,238 [salt.state       ][INFO    ][30753] {'pid': 31046, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-11-01 11:46:18,239 [salt.state       ][INFO    ][30753] Completed state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 11:46:18.238753 duration_in_ms=238.889
2017-11-01 11:46:18,242 [salt.state       ][INFO    ][30753] Running state [glance] at time 11:46:18.242124
2017-11-01 11:46:18,244 [salt.state       ][INFO    ][30753] Executing state glusterfs.started for glance
2017-11-01 11:46:18,245 [salt.loaded.int.module.cmdmod][INFO    ][30753] Executing command 'gluster --version' in directory '/root'
2017-11-01 11:46:18,267 [salt.loaded.int.module.cmdmod][INFO    ][30753] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-01 11:46:18,342 [salt.loaded.int.module.cmdmod][INFO    ][30753] Executing command 'gluster --version' in directory '/root'
2017-11-01 11:46:18,365 [salt.loaded.int.module.cmdmod][INFO    ][30753] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-01 11:46:18,453 [salt.state       ][INFO    ][30753] Volume glance is already started
2017-11-01 11:46:18,453 [salt.state       ][INFO    ][30753] Completed state [glance] at time 11:46:18.453229 duration_in_ms=211.104
2017-11-01 11:46:18,456 [salt.state       ][INFO    ][30753] Running state [keystone-keys] at time 11:46:18.455532
2017-11-01 11:46:18,456 [salt.state       ][INFO    ][30753] Executing state glusterfs.created for keystone-keys
2017-11-01 11:46:18,457 [salt.loaded.int.module.cmdmod][INFO    ][30753] Executing command 'gluster --version' in directory '/root'
2017-11-01 11:46:18,480 [salt.loaded.int.module.cmdmod][INFO    ][30753] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-01 11:46:18,570 [salt.loaded.int.module.cmdmod][INFO    ][30753] Executing command 'gluster --version' in directory '/root'
2017-11-01 11:46:18,588 [salt.loaded.int.module.cmdmod][INFO    ][30753] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-01 11:46:18,709 [salt.loaded.int.module.cmdmod][INFO    ][30753] Executing command 'gluster --version' in directory '/root'
2017-11-01 11:46:18,733 [salt.loaded.int.module.cmdmod][INFO    ][30753] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-01 11:46:19,204 [salt.minion      ][INFO    ][24030] User sudo_ubuntu Executing command saltutil.find_job with jid 20171101114619194110
2017-11-01 11:46:19,229 [salt.minion      ][INFO    ][31127] Starting a new job with PID 31127
2017-11-01 11:46:19,247 [salt.minion      ][INFO    ][31127] Returning information for job: 20171101114619194110
2017-11-01 11:46:20,948 [salt.loaded.int.module.cmdmod][INFO    ][30753] Executing command 'gluster --version' in directory '/root'
2017-11-01 11:46:20,974 [salt.loaded.int.module.cmdmod][INFO    ][30753] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-01 11:46:21,054 [salt.state       ][INFO    ][30753] {'new': ['glance', 'keystone-keys'], 'old': ['glance']}
2017-11-01 11:46:21,054 [salt.state       ][INFO    ][30753] Completed state [keystone-keys] at time 11:46:21.054351 duration_in_ms=2598.818
2017-11-01 11:46:21,066 [salt.state       ][INFO    ][30753] Running state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 11:46:21.065522
2017-11-01 11:46:21,066 [salt.state       ][INFO    ][30753] Executing state cmd.run for gluster volume set 'keystone-keys' 'network.remote-dio' 'True'
2017-11-01 11:46:21,067 [salt.loaded.int.module.cmdmod][INFO    ][30753] Executing command 'gluster volume info 'keystone-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-11-01 11:46:21,154 [salt.loaded.int.module.cmdmod][INFO    ][30753] Executing command 'gluster volume set 'keystone-keys' 'network.remote-dio' 'True'' in directory '/root'
2017-11-01 11:46:21,317 [salt.state       ][INFO    ][30753] {'pid': 31168, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-11-01 11:46:21,318 [salt.state       ][INFO    ][30753] Completed state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 11:46:21.317524 duration_in_ms=252.001
2017-11-01 11:46:21,320 [salt.state       ][INFO    ][30753] Running state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 11:46:21.319508
2017-11-01 11:46:21,320 [salt.state       ][INFO    ][30753] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-11-01 11:46:21,321 [salt.loaded.int.module.cmdmod][INFO    ][30753] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-11-01 11:46:21,412 [salt.loaded.int.module.cmdmod][INFO    ][30753] Executing command 'gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'' in directory '/root'
2017-11-01 11:46:21,564 [salt.state       ][INFO    ][30753] {'pid': 31185, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-11-01 11:46:21,565 [salt.state       ][INFO    ][30753] Completed state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 11:46:21.564631 duration_in_ms=245.122
2017-11-01 11:46:21,566 [salt.state       ][INFO    ][30753] Running state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 11:46:21.565819
2017-11-01 11:46:21,568 [salt.state       ][INFO    ][30753] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'
2017-11-01 11:46:21,569 [salt.loaded.int.module.cmdmod][INFO    ][30753] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-11-01 11:46:21,651 [salt.loaded.int.module.cmdmod][INFO    ][30753] Executing command 'gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'' in directory '/root'
2017-11-01 11:46:21,815 [salt.state       ][INFO    ][30753] {'pid': 31203, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-11-01 11:46:21,816 [salt.state       ][INFO    ][30753] Completed state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 11:46:21.815902 duration_in_ms=250.082
2017-11-01 11:46:21,817 [salt.state       ][INFO    ][30753] Running state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 11:46:21.817149
2017-11-01 11:46:21,818 [salt.state       ][INFO    ][30753] Executing state cmd.run for gluster volume set 'keystone-keys' 'nfs.disable' 'True'
2017-11-01 11:46:21,820 [salt.loaded.int.module.cmdmod][INFO    ][30753] Executing command 'gluster volume info 'keystone-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-11-01 11:46:21,908 [salt.loaded.int.module.cmdmod][INFO    ][30753] Executing command 'gluster volume set 'keystone-keys' 'nfs.disable' 'True'' in directory '/root'
2017-11-01 11:46:24,071 [salt.state       ][INFO    ][30753] {'pid': 31220, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-11-01 11:46:24,072 [salt.state       ][INFO    ][30753] Completed state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 11:46:24.071946 duration_in_ms=2254.796
2017-11-01 11:46:24,073 [salt.state       ][INFO    ][30753] Running state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 11:46:24.073405
2017-11-01 11:46:24,074 [salt.state       ][INFO    ][30753] Executing state cmd.run for gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'
2017-11-01 11:46:24,076 [salt.loaded.int.module.cmdmod][INFO    ][30753] Executing command 'gluster volume info 'keystone-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-11-01 11:46:24,169 [salt.loaded.int.module.cmdmod][INFO    ][30753] Executing command 'gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'' in directory '/root'
2017-11-01 11:46:24,318 [salt.state       ][INFO    ][30753] {'pid': 31238, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-11-01 11:46:24,319 [salt.state       ][INFO    ][30753] Completed state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 11:46:24.319349 duration_in_ms=245.943
2017-11-01 11:46:24,322 [salt.state       ][INFO    ][30753] Running state [keystone-keys] at time 11:46:24.321779
2017-11-01 11:46:24,322 [salt.state       ][INFO    ][30753] Executing state glusterfs.started for keystone-keys
2017-11-01 11:46:24,323 [salt.loaded.int.module.cmdmod][INFO    ][30753] Executing command 'gluster --version' in directory '/root'
2017-11-01 11:46:24,340 [salt.loaded.int.module.cmdmod][INFO    ][30753] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-01 11:46:24,428 [salt.loaded.int.module.cmdmod][INFO    ][30753] Executing command 'gluster --version' in directory '/root'
2017-11-01 11:46:24,447 [salt.loaded.int.module.cmdmod][INFO    ][30753] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-01 11:46:24,534 [salt.state       ][INFO    ][30753] Volume keystone-keys is already started
2017-11-01 11:46:24,538 [salt.state       ][INFO    ][30753] Completed state [keystone-keys] at time 11:46:24.537190 duration_in_ms=215.409
2017-11-01 11:46:24,541 [salt.state       ][INFO    ][30753] Running state [nova_instances] at time 11:46:24.540876
2017-11-01 11:46:24,541 [salt.state       ][INFO    ][30753] Executing state glusterfs.created for nova_instances
2017-11-01 11:46:24,542 [salt.loaded.int.module.cmdmod][INFO    ][30753] Executing command 'gluster --version' in directory '/root'
2017-11-01 11:46:24,564 [salt.loaded.int.module.cmdmod][INFO    ][30753] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-01 11:46:24,645 [salt.loaded.int.module.cmdmod][INFO    ][30753] Executing command 'gluster --version' in directory '/root'
2017-11-01 11:46:24,665 [salt.loaded.int.module.cmdmod][INFO    ][30753] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-01 11:46:24,781 [salt.loaded.int.module.cmdmod][INFO    ][30753] Executing command 'gluster --version' in directory '/root'
2017-11-01 11:46:24,806 [salt.loaded.int.module.cmdmod][INFO    ][30753] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-01 11:46:27,018 [salt.loaded.int.module.cmdmod][INFO    ][30753] Executing command 'gluster --version' in directory '/root'
2017-11-01 11:46:27,046 [salt.loaded.int.module.cmdmod][INFO    ][30753] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-01 11:46:27,132 [salt.state       ][INFO    ][30753] {'new': ['glance', 'keystone-keys', 'nova_instances'], 'old': ['glance', 'keystone-keys']}
2017-11-01 11:46:27,132 [salt.state       ][INFO    ][30753] Completed state [nova_instances] at time 11:46:27.132107 duration_in_ms=2591.23
2017-11-01 11:46:27,144 [salt.state       ][INFO    ][30753] Running state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 11:46:27.144069
2017-11-01 11:46:27,144 [salt.state       ][INFO    ][30753] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'
2017-11-01 11:46:27,145 [salt.loaded.int.module.cmdmod][INFO    ][30753] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-11-01 11:46:27,232 [salt.loaded.int.module.cmdmod][INFO    ][30753] Executing command 'gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'' in directory '/root'
2017-11-01 11:46:27,390 [salt.state       ][INFO    ][30753] {'pid': 31354, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-11-01 11:46:27,392 [salt.state       ][INFO    ][30753] Completed state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 11:46:27.391213 duration_in_ms=247.143
2017-11-01 11:46:27,393 [salt.state       ][INFO    ][30753] Running state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'On'] at time 11:46:27.392838
2017-11-01 11:46:27,393 [salt.state       ][INFO    ][30753] Executing state cmd.run for gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'On'
2017-11-01 11:46:27,395 [salt.loaded.int.module.cmdmod][INFO    ][30753] Executing command 'gluster volume info 'nova_instances' | grep 'cluster.readdir-optimize: On'' in directory '/root'
2017-11-01 11:46:27,485 [salt.loaded.int.module.cmdmod][INFO    ][30753] Executing command 'gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'On'' in directory '/root'
2017-11-01 11:46:27,649 [salt.state       ][INFO    ][30753] {'pid': 31372, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-11-01 11:46:27,650 [salt.state       ][INFO    ][30753] Completed state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'On'] at time 11:46:27.649663 duration_in_ms=256.823
2017-11-01 11:46:27,652 [salt.state       ][INFO    ][30753] Running state [gluster volume set 'nova_instances' 'network.remote-dio' 'On'] at time 11:46:27.651545
2017-11-01 11:46:27,652 [salt.state       ][INFO    ][30753] Executing state cmd.run for gluster volume set 'nova_instances' 'network.remote-dio' 'On'
2017-11-01 11:46:27,653 [salt.loaded.int.module.cmdmod][INFO    ][30753] Executing command 'gluster volume info 'nova_instances' | grep 'network.remote-dio: On'' in directory '/root'
2017-11-01 11:46:27,748 [salt.loaded.int.module.cmdmod][INFO    ][30753] Executing command 'gluster volume set 'nova_instances' 'network.remote-dio' 'On'' in directory '/root'
2017-11-01 11:46:27,916 [salt.state       ][INFO    ][30753] {'pid': 31389, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-11-01 11:46:27,917 [salt.state       ][INFO    ][30753] Completed state [gluster volume set 'nova_instances' 'network.remote-dio' 'On'] at time 11:46:27.916994 duration_in_ms=265.447
2017-11-01 11:46:27,920 [salt.state       ][INFO    ][30753] Running state [gluster volume set 'nova_instances' 'nfs.disable' 'On'] at time 11:46:27.919268
2017-11-01 11:46:27,920 [salt.state       ][INFO    ][30753] Executing state cmd.run for gluster volume set 'nova_instances' 'nfs.disable' 'On'
2017-11-01 11:46:27,922 [salt.loaded.int.module.cmdmod][INFO    ][30753] Executing command 'gluster volume info 'nova_instances' | grep 'nfs.disable: On'' in directory '/root'
2017-11-01 11:46:28,011 [salt.loaded.int.module.cmdmod][INFO    ][30753] Executing command 'gluster volume set 'nova_instances' 'nfs.disable' 'On'' in directory '/root'
2017-11-01 11:46:29,383 [salt.minion      ][INFO    ][24030] User sudo_ubuntu Executing command saltutil.find_job with jid 20171101114629375386
2017-11-01 11:46:29,411 [salt.minion      ][INFO    ][31416] Starting a new job with PID 31416
2017-11-01 11:46:29,427 [salt.minion      ][INFO    ][31416] Returning information for job: 20171101114629375386
2017-11-01 11:46:30,189 [salt.state       ][INFO    ][30753] {'pid': 31406, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-11-01 11:46:30,189 [salt.state       ][INFO    ][30753] Completed state [gluster volume set 'nova_instances' 'nfs.disable' 'On'] at time 11:46:30.189133 duration_in_ms=2269.864
2017-11-01 11:46:30,191 [salt.state       ][INFO    ][30753] Running state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 11:46:30.190866
2017-11-01 11:46:30,191 [salt.state       ][INFO    ][30753] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'
2017-11-01 11:46:30,193 [salt.loaded.int.module.cmdmod][INFO    ][30753] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-11-01 11:46:30,284 [salt.loaded.int.module.cmdmod][INFO    ][30753] Executing command 'gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'' in directory '/root'
2017-11-01 11:46:30,439 [salt.state       ][INFO    ][30753] {'pid': 31428, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-11-01 11:46:30,440 [salt.state       ][INFO    ][30753] Completed state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 11:46:30.439788 duration_in_ms=248.92
2017-11-01 11:46:30,443 [salt.state       ][INFO    ][30753] Running state [nova_instances] at time 11:46:30.443331
2017-11-01 11:46:30,444 [salt.state       ][INFO    ][30753] Executing state glusterfs.started for nova_instances
2017-11-01 11:46:30,444 [salt.loaded.int.module.cmdmod][INFO    ][30753] Executing command 'gluster --version' in directory '/root'
2017-11-01 11:46:30,463 [salt.loaded.int.module.cmdmod][INFO    ][30753] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-01 11:46:30,544 [salt.loaded.int.module.cmdmod][INFO    ][30753] Executing command 'gluster --version' in directory '/root'
2017-11-01 11:46:30,565 [salt.loaded.int.module.cmdmod][INFO    ][30753] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-01 11:46:30,656 [salt.state       ][INFO    ][30753] Volume nova_instances is already started
2017-11-01 11:46:30,657 [salt.state       ][INFO    ][30753] Completed state [nova_instances] at time 11:46:30.656512 duration_in_ms=213.18
2017-11-01 11:46:30,661 [salt.state       ][INFO    ][30753] Running state [keystone-credential-keys] at time 11:46:30.660886
2017-11-01 11:46:30,662 [salt.state       ][INFO    ][30753] Executing state glusterfs.created for keystone-credential-keys
2017-11-01 11:46:30,664 [salt.loaded.int.module.cmdmod][INFO    ][30753] Executing command 'gluster --version' in directory '/root'
2017-11-01 11:46:30,684 [salt.loaded.int.module.cmdmod][INFO    ][30753] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-01 11:46:30,766 [salt.loaded.int.module.cmdmod][INFO    ][30753] Executing command 'gluster --version' in directory '/root'
2017-11-01 11:46:30,788 [salt.loaded.int.module.cmdmod][INFO    ][30753] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-01 11:46:30,909 [salt.loaded.int.module.cmdmod][INFO    ][30753] Executing command 'gluster --version' in directory '/root'
2017-11-01 11:46:30,934 [salt.loaded.int.module.cmdmod][INFO    ][30753] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-01 11:46:33,156 [salt.loaded.int.module.cmdmod][INFO    ][30753] Executing command 'gluster --version' in directory '/root'
2017-11-01 11:46:33,182 [salt.loaded.int.module.cmdmod][INFO    ][30753] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-01 11:46:33,272 [salt.state       ][INFO    ][30753] {'new': ['glance', 'keystone-credential-keys', 'keystone-keys', 'nova_instances'], 'old': ['glance', 'keystone-keys', 'nova_instances']}
2017-11-01 11:46:33,273 [salt.state       ][INFO    ][30753] Completed state [keystone-credential-keys] at time 11:46:33.272568 duration_in_ms=2611.681
2017-11-01 11:46:33,285 [salt.state       ][INFO    ][30753] Running state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 11:46:33.282252
2017-11-01 11:46:33,286 [salt.state       ][INFO    ][30753] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'
2017-11-01 11:46:33,286 [salt.loaded.int.module.cmdmod][INFO    ][30753] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-11-01 11:46:33,377 [salt.loaded.int.module.cmdmod][INFO    ][30753] Executing command 'gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'' in directory '/root'
2017-11-01 11:46:33,550 [salt.state       ][INFO    ][30753] {'pid': 31547, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-11-01 11:46:33,551 [salt.state       ][INFO    ][30753] Completed state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 11:46:33.550176 duration_in_ms=267.923
2017-11-01 11:46:33,553 [salt.state       ][INFO    ][30753] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 11:46:33.552913
2017-11-01 11:46:33,554 [salt.state       ][INFO    ][30753] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-11-01 11:46:33,556 [salt.loaded.int.module.cmdmod][INFO    ][30753] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-11-01 11:46:33,652 [salt.loaded.int.module.cmdmod][INFO    ][30753] Executing command 'gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'' in directory '/root'
2017-11-01 11:46:33,822 [salt.state       ][INFO    ][30753] {'pid': 31564, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-11-01 11:46:33,823 [salt.state       ][INFO    ][30753] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 11:46:33.823020 duration_in_ms=270.106
2017-11-01 11:46:33,825 [salt.state       ][INFO    ][30753] Running state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 11:46:33.824537
2017-11-01 11:46:33,825 [salt.state       ][INFO    ][30753] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'
2017-11-01 11:46:33,826 [salt.loaded.int.module.cmdmod][INFO    ][30753] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-11-01 11:46:33,911 [salt.loaded.int.module.cmdmod][INFO    ][30753] Executing command 'gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'' in directory '/root'
2017-11-01 11:46:36,086 [salt.state       ][INFO    ][30753] {'pid': 31582, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-11-01 11:46:36,087 [salt.state       ][INFO    ][30753] Completed state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 11:46:36.086426 duration_in_ms=2261.888
2017-11-01 11:46:36,088 [salt.state       ][INFO    ][30753] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 11:46:36.087796
2017-11-01 11:46:36,088 [salt.state       ][INFO    ][30753] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'
2017-11-01 11:46:36,090 [salt.loaded.int.module.cmdmod][INFO    ][30753] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-11-01 11:46:36,184 [salt.loaded.int.module.cmdmod][INFO    ][30753] Executing command 'gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'' in directory '/root'
2017-11-01 11:46:36,340 [salt.state       ][INFO    ][30753] {'pid': 31600, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-11-01 11:46:36,341 [salt.state       ][INFO    ][30753] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 11:46:36.340745 duration_in_ms=252.949
2017-11-01 11:46:36,342 [salt.state       ][INFO    ][30753] Running state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 11:46:36.341933
2017-11-01 11:46:36,343 [salt.state       ][INFO    ][30753] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'
2017-11-01 11:46:36,345 [salt.loaded.int.module.cmdmod][INFO    ][30753] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-11-01 11:46:36,430 [salt.loaded.int.module.cmdmod][INFO    ][30753] Executing command 'gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'' in directory '/root'
2017-11-01 11:46:36,583 [salt.state       ][INFO    ][30753] {'pid': 31617, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-11-01 11:46:36,584 [salt.state       ][INFO    ][30753] Completed state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 11:46:36.584159 duration_in_ms=242.226
2017-11-01 11:46:36,589 [salt.state       ][INFO    ][30753] Running state [keystone-credential-keys] at time 11:46:36.588703
2017-11-01 11:46:36,589 [salt.state       ][INFO    ][30753] Executing state glusterfs.started for keystone-credential-keys
2017-11-01 11:46:36,592 [salt.loaded.int.module.cmdmod][INFO    ][30753] Executing command 'gluster --version' in directory '/root'
2017-11-01 11:46:36,610 [salt.loaded.int.module.cmdmod][INFO    ][30753] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-01 11:46:36,692 [salt.loaded.int.module.cmdmod][INFO    ][30753] Executing command 'gluster --version' in directory '/root'
2017-11-01 11:46:36,713 [salt.loaded.int.module.cmdmod][INFO    ][30753] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-01 11:46:36,808 [salt.state       ][INFO    ][30753] Volume keystone-credential-keys is already started
2017-11-01 11:46:36,809 [salt.state       ][INFO    ][30753] Completed state [keystone-credential-keys] at time 11:46:36.808973 duration_in_ms=220.269
2017-11-01 11:46:36,813 [salt.minion      ][INFO    ][30753] Returning information for job: 20171101114609128356
2017-11-01 11:46:48,448 [salt.minion      ][INFO    ][24030] User sudo_ubuntu Executing command test.ping with jid 20171101114648441813
2017-11-01 11:46:48,475 [salt.minion      ][INFO    ][31648] Starting a new job with PID 31648
2017-11-01 11:46:48,519 [salt.minion      ][INFO    ][31648] Returning information for job: 20171101114648441813
2017-11-01 11:46:48,650 [salt.minion      ][INFO    ][24030] User sudo_ubuntu Executing command cmd.run with jid 20171101114648640995
2017-11-01 11:46:48,673 [salt.minion      ][INFO    ][31653] Starting a new job with PID 31653
2017-11-01 11:46:48,681 [salt.loaded.int.module.cmdmod][INFO    ][31653] Executing command 'gluster peer status; gluster volume status' in directory '/root'
2017-11-01 11:46:48,864 [salt.minion      ][INFO    ][31653] Returning information for job: 20171101114648640995
2017-11-01 12:28:22,695 [salt.minion      ][INFO    ][24030] User sudo_ubuntu Executing command test.ping with jid 20171101122822689376
2017-11-01 12:28:22,729 [salt.minion      ][INFO    ][32249] Starting a new job with PID 32249
2017-11-01 12:28:22,786 [salt.minion      ][INFO    ][32249] Returning information for job: 20171101122822689376
2017-11-01 12:28:51,841 [salt.minion      ][INFO    ][24030] User sudo_ubuntu Executing command state.sls with jid 20171101122851829082
2017-11-01 12:28:51,867 [salt.minion      ][INFO    ][32257] Starting a new job with PID 32257
2017-11-01 12:28:52,475 [salt.state       ][INFO    ][32257] Loading fresh modules for state activity
2017-11-01 12:28:52,513 [salt.fileclient  ][INFO    ][32257] Fetching file from saltenv 'base', ** done ** 'keepalived/init.sls'
2017-11-01 12:28:52,541 [salt.fileclient  ][INFO    ][32257] Fetching file from saltenv 'base', ** done ** 'keepalived/cluster.sls'
2017-11-01 12:28:52,584 [salt.fileclient  ][INFO    ][32257] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-11-01 12:28:52,991 [salt.state       ][INFO    ][32257] Running state [lsof] at time 12:28:52.991066
2017-11-01 12:28:52,991 [salt.state       ][INFO    ][32257] Executing state pkg.installed for lsof
2017-11-01 12:28:52,992 [salt.loaded.int.module.cmdmod][INFO    ][32257] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-01 12:28:53,311 [salt.state       ][INFO    ][32257] Package lsof is already installed
2017-11-01 12:28:53,311 [salt.state       ][INFO    ][32257] Completed state [lsof] at time 12:28:53.311427 duration_in_ms=320.361
2017-11-01 12:28:53,312 [salt.state       ][INFO    ][32257] Running state [keepalived] at time 12:28:53.311674
2017-11-01 12:28:53,313 [salt.state       ][INFO    ][32257] Executing state pkg.installed for keepalived
2017-11-01 12:28:53,317 [salt.state       ][INFO    ][32257] Package keepalived is already installed
2017-11-01 12:28:53,317 [salt.state       ][INFO    ][32257] Completed state [keepalived] at time 12:28:53.317101 duration_in_ms=5.427
2017-11-01 12:28:53,319 [salt.state       ][INFO    ][32257] Running state [/etc/keepalived/keepalived.conf] at time 12:28:53.319003
2017-11-01 12:28:53,319 [salt.state       ][INFO    ][32257] Executing state file.managed for /etc/keepalived/keepalived.conf
2017-11-01 12:28:53,349 [salt.fileclient  ][INFO    ][32257] Fetching file from saltenv 'base', ** done ** 'keepalived/files/keepalived.conf'
2017-11-01 12:28:53,404 [salt.fileclient  ][INFO    ][32257] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-11-01 12:28:53,416 [salt.state       ][INFO    ][32257] File /etc/keepalived/keepalived.conf is in the correct state
2017-11-01 12:28:53,417 [salt.state       ][INFO    ][32257] Completed state [/etc/keepalived/keepalived.conf] at time 12:28:53.416592 duration_in_ms=97.589
2017-11-01 12:28:53,417 [salt.state       ][INFO    ][32257] Running state [keepalived] at time 12:28:53.417418
2017-11-01 12:28:53,418 [salt.state       ][INFO    ][32257] Executing state service.running for keepalived
2017-11-01 12:28:53,418 [salt.loaded.int.module.cmdmod][INFO    ][32257] Executing command ['systemctl', 'status', 'keepalived.service', '-n', '0'] in directory '/root'
2017-11-01 12:28:53,454 [salt.loaded.int.module.cmdmod][INFO    ][32257] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2017-11-01 12:28:53,476 [salt.loaded.int.module.cmdmod][INFO    ][32257] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-11-01 12:28:53,494 [salt.state       ][INFO    ][32257] The service keepalived is already running
2017-11-01 12:28:53,495 [salt.state       ][INFO    ][32257] Completed state [keepalived] at time 12:28:53.495027 duration_in_ms=77.608
2017-11-01 12:28:53,497 [salt.minion      ][INFO    ][32257] Returning information for job: 20171101122851829082
2017-11-01 12:29:00,516 [salt.minion      ][INFO    ][24030] User sudo_ubuntu Executing command pillar.get with jid 20171101122900511852
2017-11-01 12:29:00,546 [salt.minion      ][INFO    ][32284] Starting a new job with PID 32284
2017-11-01 12:29:00,561 [salt.minion      ][INFO    ][32284] Returning information for job: 20171101122900511852
2017-11-01 12:29:51,023 [salt.minion      ][INFO    ][24030] User sudo_ubuntu Executing command state.sls with jid 20171101122951017330
2017-11-01 12:29:51,056 [salt.minion      ][INFO    ][32302] Starting a new job with PID 32302
2017-11-01 12:29:53,656 [salt.state       ][INFO    ][32302] Loading fresh modules for state activity
2017-11-01 12:29:53,694 [salt.fileclient  ][INFO    ][32302] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-11-01 12:29:53,729 [salt.fileclient  ][INFO    ][32302] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-11-01 12:29:54,140 [salt.state       ][INFO    ][32302] Running state [attr] at time 12:29:54.139691
2017-11-01 12:29:54,140 [salt.state       ][INFO    ][32302] Executing state pkg.installed for attr
2017-11-01 12:29:54,142 [salt.loaded.int.module.cmdmod][INFO    ][32302] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-01 12:29:54,469 [salt.state       ][INFO    ][32302] Package attr is already installed
2017-11-01 12:29:54,469 [salt.state       ][INFO    ][32302] Completed state [attr] at time 12:29:54.468854 duration_in_ms=329.164
2017-11-01 12:29:54,469 [salt.state       ][INFO    ][32302] Running state [glusterfs-server] at time 12:29:54.469121
2017-11-01 12:29:54,469 [salt.state       ][INFO    ][32302] Executing state pkg.installed for glusterfs-server
2017-11-01 12:29:54,473 [salt.state       ][INFO    ][32302] Package glusterfs-server is already installed
2017-11-01 12:29:54,473 [salt.state       ][INFO    ][32302] Completed state [glusterfs-server] at time 12:29:54.473226 duration_in_ms=4.105
2017-11-01 12:29:54,473 [salt.state       ][INFO    ][32302] Running state [bc] at time 12:29:54.473447
2017-11-01 12:29:54,474 [salt.state       ][INFO    ][32302] Executing state pkg.installed for bc
2017-11-01 12:29:54,478 [salt.state       ][INFO    ][32302] Package bc is already installed
2017-11-01 12:29:54,478 [salt.state       ][INFO    ][32302] Completed state [bc] at time 12:29:54.478378 duration_in_ms=4.93
2017-11-01 12:29:54,479 [salt.state       ][INFO    ][32302] Running state [glusterfs-server] at time 12:29:54.479185
2017-11-01 12:29:54,479 [salt.state       ][INFO    ][32302] Executing state service.running for glusterfs-server
2017-11-01 12:29:54,480 [salt.loaded.int.module.cmdmod][INFO    ][32302] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-11-01 12:29:54,516 [salt.loaded.int.module.cmdmod][INFO    ][32302] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-11-01 12:29:54,538 [salt.loaded.int.module.cmdmod][INFO    ][32302] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-11-01 12:29:54,568 [salt.state       ][INFO    ][32302] The service glusterfs-server is already running
2017-11-01 12:29:54,569 [salt.state       ][INFO    ][32302] Completed state [glusterfs-server] at time 12:29:54.568838 duration_in_ms=89.652
2017-11-01 12:29:54,573 [salt.state       ][INFO    ][32302] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 12:29:54.572729
2017-11-01 12:29:54,573 [salt.state       ][INFO    ][32302] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-11-01 12:29:54,577 [salt.state       ][INFO    ][32302] File /etc/systemd/system/glusterfs-server.service.d/override.conf is in the correct state
2017-11-01 12:29:54,577 [salt.state       ][INFO    ][32302] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 12:29:54.577400 duration_in_ms=4.672
2017-11-01 12:29:54,578 [salt.state       ][INFO    ][32302] Running state [/srv/glusterfs/glance] at time 12:29:54.577652
2017-11-01 12:29:54,578 [salt.state       ][INFO    ][32302] Executing state file.directory for /srv/glusterfs/glance
2017-11-01 12:29:54,580 [salt.state       ][INFO    ][32302] Directory /srv/glusterfs/glance is in the correct state
2017-11-01 12:29:54,581 [salt.state       ][INFO    ][32302] Completed state [/srv/glusterfs/glance] at time 12:29:54.581027 duration_in_ms=3.375
2017-11-01 12:29:54,581 [salt.state       ][INFO    ][32302] Running state [/srv/glusterfs/keystone-keys] at time 12:29:54.581268
2017-11-01 12:29:54,582 [salt.state       ][INFO    ][32302] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-11-01 12:29:54,582 [salt.state       ][INFO    ][32302] Directory /srv/glusterfs/keystone-keys is in the correct state
2017-11-01 12:29:54,583 [salt.state       ][INFO    ][32302] Completed state [/srv/glusterfs/keystone-keys] at time 12:29:54.582265 duration_in_ms=0.997
2017-11-01 12:29:54,583 [salt.state       ][INFO    ][32302] Running state [/srv/glusterfs/nova_instances] at time 12:29:54.583094
2017-11-01 12:29:54,584 [salt.state       ][INFO    ][32302] Executing state file.directory for /srv/glusterfs/nova_instances
2017-11-01 12:29:54,584 [salt.state       ][INFO    ][32302] Directory /srv/glusterfs/nova_instances is in the correct state
2017-11-01 12:29:54,584 [salt.state       ][INFO    ][32302] Completed state [/srv/glusterfs/nova_instances] at time 12:29:54.584331 duration_in_ms=1.237
2017-11-01 12:29:54,585 [salt.state       ][INFO    ][32302] Running state [/srv/glusterfs/keystone-credential-keys] at time 12:29:54.584563
2017-11-01 12:29:54,585 [salt.state       ][INFO    ][32302] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-11-01 12:29:54,585 [salt.state       ][INFO    ][32302] Directory /srv/glusterfs/keystone-credential-keys is in the correct state
2017-11-01 12:29:54,586 [salt.state       ][INFO    ][32302] Completed state [/srv/glusterfs/keystone-credential-keys] at time 12:29:54.585574 duration_in_ms=1.011
2017-11-01 12:29:54,587 [salt.minion      ][INFO    ][32302] Returning information for job: 20171101122951017330
2017-11-01 12:29:55,594 [salt.minion      ][INFO    ][24030] User sudo_ubuntu Executing command test.ping with jid 20171101122955588550
2017-11-01 12:29:55,627 [salt.minion      ][INFO    ][32325] Starting a new job with PID 32325
2017-11-01 12:29:55,675 [salt.minion      ][INFO    ][32325] Returning information for job: 20171101122955588550
2017-11-01 12:29:55,798 [salt.minion      ][INFO    ][24030] User sudo_ubuntu Executing command state.sls with jid 20171101122955790212
2017-11-01 12:29:55,817 [salt.minion      ][INFO    ][32331] Starting a new job with PID 32331
2017-11-01 12:29:56,421 [salt.state       ][INFO    ][32331] Loading fresh modules for state activity
2017-11-01 12:29:56,460 [salt.fileclient  ][INFO    ][32331] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/setup.sls'
2017-11-01 12:29:56,511 [salt.fileclient  ][INFO    ][32331] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-11-01 12:29:56,620 [salt.fileclient  ][INFO    ][32331] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-11-01 12:29:56,652 [salt.fileclient  ][INFO    ][32331] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-11-01 12:29:57,061 [salt.state       ][INFO    ][32331] Running state [attr] at time 12:29:57.060842
2017-11-01 12:29:57,061 [salt.state       ][INFO    ][32331] Executing state pkg.installed for attr
2017-11-01 12:29:57,062 [salt.loaded.int.module.cmdmod][INFO    ][32331] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-01 12:29:57,380 [salt.state       ][INFO    ][32331] Package attr is already installed
2017-11-01 12:29:57,380 [salt.state       ][INFO    ][32331] Completed state [attr] at time 12:29:57.380207 duration_in_ms=319.366
2017-11-01 12:29:57,381 [salt.state       ][INFO    ][32331] Running state [glusterfs-server] at time 12:29:57.380489
2017-11-01 12:29:57,381 [salt.state       ][INFO    ][32331] Executing state pkg.installed for glusterfs-server
2017-11-01 12:29:57,386 [salt.state       ][INFO    ][32331] Package glusterfs-server is already installed
2017-11-01 12:29:57,386 [salt.state       ][INFO    ][32331] Completed state [glusterfs-server] at time 12:29:57.385958 duration_in_ms=5.469
2017-11-01 12:29:57,386 [salt.state       ][INFO    ][32331] Running state [bc] at time 12:29:57.386161
2017-11-01 12:29:57,387 [salt.state       ][INFO    ][32331] Executing state pkg.installed for bc
2017-11-01 12:29:57,391 [salt.state       ][INFO    ][32331] Package bc is already installed
2017-11-01 12:29:57,392 [salt.state       ][INFO    ][32331] Completed state [bc] at time 12:29:57.391616 duration_in_ms=5.455
2017-11-01 12:29:57,393 [salt.state       ][INFO    ][32331] Running state [glusterfs-server] at time 12:29:57.392607
2017-11-01 12:29:57,393 [salt.state       ][INFO    ][32331] Executing state service.running for glusterfs-server
2017-11-01 12:29:57,393 [salt.loaded.int.module.cmdmod][INFO    ][32331] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-11-01 12:29:57,436 [salt.loaded.int.module.cmdmod][INFO    ][32331] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-11-01 12:29:57,455 [salt.loaded.int.module.cmdmod][INFO    ][32331] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-11-01 12:29:57,481 [salt.state       ][INFO    ][32331] The service glusterfs-server is already running
2017-11-01 12:29:57,481 [salt.state       ][INFO    ][32331] Completed state [glusterfs-server] at time 12:29:57.481301 duration_in_ms=88.692
2017-11-01 12:29:57,486 [salt.state       ][INFO    ][32331] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 12:29:57.486177
2017-11-01 12:29:57,489 [salt.state       ][INFO    ][32331] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-11-01 12:29:57,494 [salt.state       ][INFO    ][32331] File /etc/systemd/system/glusterfs-server.service.d/override.conf is in the correct state
2017-11-01 12:29:57,497 [salt.state       ][INFO    ][32331] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 12:29:57.496309 duration_in_ms=10.133
2017-11-01 12:29:57,497 [salt.state       ][INFO    ][32331] Running state [/srv/glusterfs/glance] at time 12:29:57.496838
2017-11-01 12:29:57,497 [salt.state       ][INFO    ][32331] Executing state file.directory for /srv/glusterfs/glance
2017-11-01 12:29:57,498 [salt.state       ][INFO    ][32331] Directory /srv/glusterfs/glance is in the correct state
2017-11-01 12:29:57,498 [salt.state       ][INFO    ][32331] Completed state [/srv/glusterfs/glance] at time 12:29:57.497844 duration_in_ms=1.006
2017-11-01 12:29:57,498 [salt.state       ][INFO    ][32331] Running state [/srv/glusterfs/keystone-keys] at time 12:29:57.498083
2017-11-01 12:29:57,500 [salt.state       ][INFO    ][32331] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-11-01 12:29:57,501 [salt.state       ][INFO    ][32331] Directory /srv/glusterfs/keystone-keys is in the correct state
2017-11-01 12:29:57,501 [salt.state       ][INFO    ][32331] Completed state [/srv/glusterfs/keystone-keys] at time 12:29:57.500972 duration_in_ms=2.888
2017-11-01 12:29:57,501 [salt.state       ][INFO    ][32331] Running state [/srv/glusterfs/nova_instances] at time 12:29:57.501208
2017-11-01 12:29:57,501 [salt.state       ][INFO    ][32331] Executing state file.directory for /srv/glusterfs/nova_instances
2017-11-01 12:29:57,502 [salt.state       ][INFO    ][32331] Directory /srv/glusterfs/nova_instances is in the correct state
2017-11-01 12:29:57,502 [salt.state       ][INFO    ][32331] Completed state [/srv/glusterfs/nova_instances] at time 12:29:57.502126 duration_in_ms=0.918
2017-11-01 12:29:57,503 [salt.state       ][INFO    ][32331] Running state [/srv/glusterfs/keystone-credential-keys] at time 12:29:57.502963
2017-11-01 12:29:57,503 [salt.state       ][INFO    ][32331] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-11-01 12:29:57,504 [salt.state       ][INFO    ][32331] Directory /srv/glusterfs/keystone-credential-keys is in the correct state
2017-11-01 12:29:57,504 [salt.state       ][INFO    ][32331] Completed state [/srv/glusterfs/keystone-credential-keys] at time 12:29:57.503837 duration_in_ms=0.874
2017-11-01 12:29:57,570 [salt.loaded.int.module.cmdmod][INFO    ][32331] Executing command ['git', '--version'] in directory '/root'
2017-11-01 12:29:57,683 [salt.state       ][INFO    ][32331] Running state [sleep 5] at time 12:29:57.683220
2017-11-01 12:29:57,684 [salt.state       ][INFO    ][32331] Executing state cmd.wait for sleep 5
2017-11-01 12:29:57,684 [salt.state       ][INFO    ][32331] No changes made for sleep 5
2017-11-01 12:29:57,684 [salt.state       ][INFO    ][32331] Completed state [sleep 5] at time 12:29:57.683978 duration_in_ms=0.758
2017-11-01 12:29:57,685 [salt.state       ][INFO    ][32331] Running state [192.168.10.143] at time 12:29:57.684881
2017-11-01 12:29:57,685 [salt.state       ][INFO    ][32331] Executing state glusterfs.peered for 192.168.10.143
2017-11-01 12:29:57,686 [salt.loaded.int.module.cmdmod][INFO    ][32331] Executing command 'gluster --version' in directory '/root'
2017-11-01 12:29:57,703 [salt.loaded.int.module.cmdmod][INFO    ][32331] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-01 12:29:57,796 [salt.state       ][INFO    ][32331] Host 192.168.10.143 already peered
2017-11-01 12:29:57,797 [salt.state       ][INFO    ][32331] Completed state [192.168.10.143] at time 12:29:57.796642 duration_in_ms=111.76
2017-11-01 12:29:57,808 [salt.state       ][INFO    ][32331] Running state [192.168.10.142] at time 12:29:57.806211
2017-11-01 12:29:57,808 [salt.state       ][INFO    ][32331] Executing state glusterfs.peered for 192.168.10.142
2017-11-01 12:29:57,808 [salt.loaded.int.module.cmdmod][INFO    ][32331] Executing command 'gluster --version' in directory '/root'
2017-11-01 12:29:57,828 [salt.loaded.int.module.cmdmod][INFO    ][32331] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-01 12:29:57,920 [salt.loaded.int.module.cmdmod][INFO    ][32331] Executing command 'gluster --version' in directory '/root'
2017-11-01 12:29:57,943 [salt.loaded.int.module.cmdmod][INFO    ][32331] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-01 12:29:58,029 [salt.loaded.int.module.cmdmod][INFO    ][32331] Executing command 'gluster --version' in directory '/root'
2017-11-01 12:29:58,052 [salt.loaded.int.module.cmdmod][INFO    ][32331] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-01 12:29:58,143 [salt.loaded.int.module.cmdmod][INFO    ][32331] Executing command 'gluster --version' in directory '/root'
2017-11-01 12:29:58,165 [salt.loaded.int.module.cmdmod][INFO    ][32331] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-01 12:29:58,256 [salt.state       ][INFO    ][32331] Peering with localhost is not needed
2017-11-01 12:29:58,257 [salt.state       ][INFO    ][32331] Completed state [192.168.10.142] at time 12:29:58.256940 duration_in_ms=450.728
2017-11-01 12:29:58,268 [salt.state       ][INFO    ][32331] Running state [192.168.10.141] at time 12:29:58.267927
2017-11-01 12:29:58,268 [salt.state       ][INFO    ][32331] Executing state glusterfs.peered for 192.168.10.141
2017-11-01 12:29:58,269 [salt.loaded.int.module.cmdmod][INFO    ][32331] Executing command 'gluster --version' in directory '/root'
2017-11-01 12:29:58,289 [salt.loaded.int.module.cmdmod][INFO    ][32331] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-01 12:29:58,372 [salt.state       ][INFO    ][32331] Host 192.168.10.141 already peered
2017-11-01 12:29:58,373 [salt.state       ][INFO    ][32331] Completed state [192.168.10.141] at time 12:29:58.373237 duration_in_ms=105.309
2017-11-01 12:29:58,376 [salt.state       ][INFO    ][32331] Running state [glance] at time 12:29:58.376222
2017-11-01 12:29:58,377 [salt.state       ][INFO    ][32331] Executing state glusterfs.created for glance
2017-11-01 12:29:58,378 [salt.loaded.int.module.cmdmod][INFO    ][32331] Executing command 'gluster --version' in directory '/root'
2017-11-01 12:29:58,401 [salt.loaded.int.module.cmdmod][INFO    ][32331] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-01 12:29:58,489 [salt.loaded.int.module.cmdmod][INFO    ][32331] Executing command 'gluster --version' in directory '/root'
2017-11-01 12:29:58,513 [salt.loaded.int.module.cmdmod][INFO    ][32331] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-01 12:29:58,614 [salt.state       ][INFO    ][32331] Volume glance already exists and is started.
2017-11-01 12:29:58,615 [salt.state       ][INFO    ][32331] Completed state [glance] at time 12:29:58.615274 duration_in_ms=239.051
2017-11-01 12:29:58,625 [salt.state       ][INFO    ][32331] Running state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 12:29:58.624548
2017-11-01 12:29:58,625 [salt.state       ][INFO    ][32331] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'
2017-11-01 12:29:58,625 [salt.loaded.int.module.cmdmod][INFO    ][32331] Executing command 'gluster volume info 'glance' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-11-01 12:29:58,717 [salt.state       ][INFO    ][32331] unless execution succeeded
2017-11-01 12:29:58,717 [salt.state       ][INFO    ][32331] Completed state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 12:29:58.717269 duration_in_ms=92.719
2017-11-01 12:29:58,719 [salt.state       ][INFO    ][32331] Running state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 12:29:58.718546
2017-11-01 12:29:58,719 [salt.state       ][INFO    ][32331] Executing state cmd.run for gluster volume set 'glance' 'network.remote-dio' 'True'
2017-11-01 12:29:58,721 [salt.loaded.int.module.cmdmod][INFO    ][32331] Executing command 'gluster volume info 'glance' | grep 'network.remote-dio: True'' in directory '/root'
2017-11-01 12:29:58,821 [salt.state       ][INFO    ][32331] unless execution succeeded
2017-11-01 12:29:58,822 [salt.state       ][INFO    ][32331] Completed state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 12:29:58.821734 duration_in_ms=103.187
2017-11-01 12:29:58,824 [salt.state       ][INFO    ][32331] Running state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 12:29:58.823426
2017-11-01 12:29:58,824 [salt.state       ][INFO    ][32331] Executing state cmd.run for gluster volume set 'glance' 'nfs.disable' 'True'
2017-11-01 12:29:58,826 [salt.loaded.int.module.cmdmod][INFO    ][32331] Executing command 'gluster volume info 'glance' | grep 'nfs.disable: True'' in directory '/root'
2017-11-01 12:29:58,936 [salt.state       ][INFO    ][32331] unless execution succeeded
2017-11-01 12:29:58,936 [salt.state       ][INFO    ][32331] Completed state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 12:29:58.936278 duration_in_ms=112.853
2017-11-01 12:29:58,940 [salt.state       ][INFO    ][32331] Running state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 12:29:58.939576
2017-11-01 12:29:58,940 [salt.state       ][INFO    ][32331] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'
2017-11-01 12:29:58,941 [salt.loaded.int.module.cmdmod][INFO    ][32331] Executing command 'gluster volume info 'glance' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-11-01 12:29:59,042 [salt.state       ][INFO    ][32331] unless execution succeeded
2017-11-01 12:29:59,044 [salt.state       ][INFO    ][32331] Completed state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 12:29:59.042908 duration_in_ms=103.05
2017-11-01 12:29:59,045 [salt.state       ][INFO    ][32331] Running state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 12:29:59.044999
2017-11-01 12:29:59,046 [salt.state       ][INFO    ][32331] Executing state cmd.run for gluster volume set 'glance' 'cluster.readdir-optimize' 'True'
2017-11-01 12:29:59,047 [salt.loaded.int.module.cmdmod][INFO    ][32331] Executing command 'gluster volume info 'glance' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-11-01 12:29:59,140 [salt.state       ][INFO    ][32331] unless execution succeeded
2017-11-01 12:29:59,141 [salt.state       ][INFO    ][32331] Completed state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 12:29:59.141183 duration_in_ms=96.184
2017-11-01 12:29:59,145 [salt.state       ][INFO    ][32331] Running state [glance] at time 12:29:59.145242
2017-11-01 12:29:59,146 [salt.state       ][INFO    ][32331] Executing state glusterfs.started for glance
2017-11-01 12:29:59,147 [salt.loaded.int.module.cmdmod][INFO    ][32331] Executing command 'gluster --version' in directory '/root'
2017-11-01 12:29:59,168 [salt.loaded.int.module.cmdmod][INFO    ][32331] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-01 12:29:59,253 [salt.loaded.int.module.cmdmod][INFO    ][32331] Executing command 'gluster --version' in directory '/root'
2017-11-01 12:29:59,272 [salt.loaded.int.module.cmdmod][INFO    ][32331] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-01 12:29:59,373 [salt.state       ][INFO    ][32331] Volume glance is already started
2017-11-01 12:29:59,374 [salt.state       ][INFO    ][32331] Completed state [glance] at time 12:29:59.373769 duration_in_ms=228.525
2017-11-01 12:29:59,378 [salt.state       ][INFO    ][32331] Running state [keystone-keys] at time 12:29:59.377675
2017-11-01 12:29:59,379 [salt.state       ][INFO    ][32331] Executing state glusterfs.created for keystone-keys
2017-11-01 12:29:59,380 [salt.loaded.int.module.cmdmod][INFO    ][32331] Executing command 'gluster --version' in directory '/root'
2017-11-01 12:29:59,402 [salt.loaded.int.module.cmdmod][INFO    ][32331] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-01 12:29:59,489 [salt.loaded.int.module.cmdmod][INFO    ][32331] Executing command 'gluster --version' in directory '/root'
2017-11-01 12:29:59,509 [salt.loaded.int.module.cmdmod][INFO    ][32331] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-01 12:29:59,606 [salt.state       ][INFO    ][32331] Volume keystone-keys already exists and is started.
2017-11-01 12:29:59,606 [salt.state       ][INFO    ][32331] Completed state [keystone-keys] at time 12:29:59.606136 duration_in_ms=228.461
2017-11-01 12:29:59,617 [salt.state       ][INFO    ][32331] Running state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 12:29:59.616821
2017-11-01 12:29:59,617 [salt.state       ][INFO    ][32331] Executing state cmd.run for gluster volume set 'keystone-keys' 'network.remote-dio' 'True'
2017-11-01 12:29:59,618 [salt.loaded.int.module.cmdmod][INFO    ][32331] Executing command 'gluster volume info 'keystone-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-11-01 12:29:59,718 [salt.state       ][INFO    ][32331] unless execution succeeded
2017-11-01 12:29:59,718 [salt.state       ][INFO    ][32331] Completed state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 12:29:59.718126 duration_in_ms=101.304
2017-11-01 12:29:59,721 [salt.state       ][INFO    ][32331] Running state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 12:29:59.720866
2017-11-01 12:29:59,721 [salt.state       ][INFO    ][32331] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-11-01 12:29:59,723 [salt.loaded.int.module.cmdmod][INFO    ][32331] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-11-01 12:29:59,828 [salt.state       ][INFO    ][32331] unless execution succeeded
2017-11-01 12:29:59,829 [salt.state       ][INFO    ][32331] Completed state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 12:29:59.828689 duration_in_ms=107.823
2017-11-01 12:29:59,830 [salt.state       ][INFO    ][32331] Running state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 12:29:59.829807
2017-11-01 12:29:59,831 [salt.state       ][INFO    ][32331] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'
2017-11-01 12:29:59,832 [salt.loaded.int.module.cmdmod][INFO    ][32331] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-11-01 12:29:59,932 [salt.state       ][INFO    ][32331] unless execution succeeded
2017-11-01 12:29:59,933 [salt.state       ][INFO    ][32331] Completed state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 12:29:59.932783 duration_in_ms=102.976
2017-11-01 12:29:59,935 [salt.state       ][INFO    ][32331] Running state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 12:29:59.935361
2017-11-01 12:29:59,936 [salt.state       ][INFO    ][32331] Executing state cmd.run for gluster volume set 'keystone-keys' 'nfs.disable' 'True'
2017-11-01 12:29:59,937 [salt.loaded.int.module.cmdmod][INFO    ][32331] Executing command 'gluster volume info 'keystone-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-11-01 12:30:00,025 [salt.state       ][INFO    ][32331] unless execution succeeded
2017-11-01 12:30:00,026 [salt.state       ][INFO    ][32331] Completed state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 12:30:00.025908 duration_in_ms=90.546
2017-11-01 12:30:00,028 [salt.state       ][INFO    ][32331] Running state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 12:30:00.028078
2017-11-01 12:30:00,029 [salt.state       ][INFO    ][32331] Executing state cmd.run for gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'
2017-11-01 12:30:00,030 [salt.loaded.int.module.cmdmod][INFO    ][32331] Executing command 'gluster volume info 'keystone-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-11-01 12:30:00,120 [salt.state       ][INFO    ][32331] unless execution succeeded
2017-11-01 12:30:00,120 [salt.state       ][INFO    ][32331] Completed state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 12:30:00.120302 duration_in_ms=92.224
2017-11-01 12:30:00,125 [salt.state       ][INFO    ][32331] Running state [keystone-keys] at time 12:30:00.125370
2017-11-01 12:30:00,126 [salt.state       ][INFO    ][32331] Executing state glusterfs.started for keystone-keys
2017-11-01 12:30:00,127 [salt.loaded.int.module.cmdmod][INFO    ][32331] Executing command 'gluster --version' in directory '/root'
2017-11-01 12:30:00,149 [salt.loaded.int.module.cmdmod][INFO    ][32331] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-01 12:30:00,248 [salt.loaded.int.module.cmdmod][INFO    ][32331] Executing command 'gluster --version' in directory '/root'
2017-11-01 12:30:00,269 [salt.loaded.int.module.cmdmod][INFO    ][32331] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-01 12:30:00,368 [salt.state       ][INFO    ][32331] Volume keystone-keys is already started
2017-11-01 12:30:00,368 [salt.state       ][INFO    ][32331] Completed state [keystone-keys] at time 12:30:00.368301 duration_in_ms=242.93
2017-11-01 12:30:00,373 [salt.state       ][INFO    ][32331] Running state [nova_instances] at time 12:30:00.372649
2017-11-01 12:30:00,373 [salt.state       ][INFO    ][32331] Executing state glusterfs.created for nova_instances
2017-11-01 12:30:00,374 [salt.loaded.int.module.cmdmod][INFO    ][32331] Executing command 'gluster --version' in directory '/root'
2017-11-01 12:30:00,397 [salt.loaded.int.module.cmdmod][INFO    ][32331] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-01 12:30:00,484 [salt.loaded.int.module.cmdmod][INFO    ][32331] Executing command 'gluster --version' in directory '/root'
2017-11-01 12:30:00,507 [salt.loaded.int.module.cmdmod][INFO    ][32331] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-01 12:30:00,592 [salt.state       ][INFO    ][32331] Volume nova_instances already exists and is started.
2017-11-01 12:30:00,593 [salt.state       ][INFO    ][32331] Completed state [nova_instances] at time 12:30:00.592551 duration_in_ms=219.899
2017-11-01 12:30:00,603 [salt.state       ][INFO    ][32331] Running state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 12:30:00.603180
2017-11-01 12:30:00,603 [salt.state       ][INFO    ][32331] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'
2017-11-01 12:30:00,604 [salt.loaded.int.module.cmdmod][INFO    ][32331] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-11-01 12:30:00,698 [salt.state       ][INFO    ][32331] unless execution succeeded
2017-11-01 12:30:00,699 [salt.state       ][INFO    ][32331] Completed state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 12:30:00.698183 duration_in_ms=95.0
2017-11-01 12:30:00,701 [salt.state       ][INFO    ][32331] Running state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'On'] at time 12:30:00.700636
2017-11-01 12:30:00,701 [salt.state       ][INFO    ][32331] Executing state cmd.run for gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'On'
2017-11-01 12:30:00,702 [salt.loaded.int.module.cmdmod][INFO    ][32331] Executing command 'gluster volume info 'nova_instances' | grep 'cluster.readdir-optimize: On'' in directory '/root'
2017-11-01 12:30:00,802 [salt.state       ][INFO    ][32331] unless execution succeeded
2017-11-01 12:30:00,804 [salt.state       ][INFO    ][32331] Completed state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'On'] at time 12:30:00.803436 duration_in_ms=102.8
2017-11-01 12:30:00,805 [salt.state       ][INFO    ][32331] Running state [gluster volume set 'nova_instances' 'network.remote-dio' 'On'] at time 12:30:00.804570
2017-11-01 12:30:00,805 [salt.state       ][INFO    ][32331] Executing state cmd.run for gluster volume set 'nova_instances' 'network.remote-dio' 'On'
2017-11-01 12:30:00,807 [salt.loaded.int.module.cmdmod][INFO    ][32331] Executing command 'gluster volume info 'nova_instances' | grep 'network.remote-dio: On'' in directory '/root'
2017-11-01 12:30:00,917 [salt.state       ][INFO    ][32331] unless execution succeeded
2017-11-01 12:30:00,918 [salt.state       ][INFO    ][32331] Completed state [gluster volume set 'nova_instances' 'network.remote-dio' 'On'] at time 12:30:00.917785 duration_in_ms=113.213
2017-11-01 12:30:00,919 [salt.state       ][INFO    ][32331] Running state [gluster volume set 'nova_instances' 'nfs.disable' 'On'] at time 12:30:00.919281
2017-11-01 12:30:00,920 [salt.state       ][INFO    ][32331] Executing state cmd.run for gluster volume set 'nova_instances' 'nfs.disable' 'On'
2017-11-01 12:30:00,922 [salt.loaded.int.module.cmdmod][INFO    ][32331] Executing command 'gluster volume info 'nova_instances' | grep 'nfs.disable: On'' in directory '/root'
2017-11-01 12:30:01,022 [salt.state       ][INFO    ][32331] unless execution succeeded
2017-11-01 12:30:01,023 [salt.state       ][INFO    ][32331] Completed state [gluster volume set 'nova_instances' 'nfs.disable' 'On'] at time 12:30:01.022233 duration_in_ms=102.951
2017-11-01 12:30:01,025 [salt.state       ][INFO    ][32331] Running state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 12:30:01.025008
2017-11-01 12:30:01,025 [salt.state       ][INFO    ][32331] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'
2017-11-01 12:30:01,027 [salt.loaded.int.module.cmdmod][INFO    ][32331] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-11-01 12:30:01,120 [salt.state       ][INFO    ][32331] unless execution succeeded
2017-11-01 12:30:01,120 [salt.state       ][INFO    ][32331] Completed state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 12:30:01.120132 duration_in_ms=95.122
2017-11-01 12:30:01,124 [salt.state       ][INFO    ][32331] Running state [nova_instances] at time 12:30:01.123666
2017-11-01 12:30:01,124 [salt.state       ][INFO    ][32331] Executing state glusterfs.started for nova_instances
2017-11-01 12:30:01,125 [salt.loaded.int.module.cmdmod][INFO    ][32331] Executing command 'gluster --version' in directory '/root'
2017-11-01 12:30:01,153 [salt.loaded.int.module.cmdmod][INFO    ][32331] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-01 12:30:01,240 [salt.loaded.int.module.cmdmod][INFO    ][32331] Executing command 'gluster --version' in directory '/root'
2017-11-01 12:30:01,261 [salt.loaded.int.module.cmdmod][INFO    ][32331] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-01 12:30:01,357 [salt.state       ][INFO    ][32331] Volume nova_instances is already started
2017-11-01 12:30:01,357 [salt.state       ][INFO    ][32331] Completed state [nova_instances] at time 12:30:01.357092 duration_in_ms=233.426
2017-11-01 12:30:01,362 [salt.state       ][INFO    ][32331] Running state [keystone-credential-keys] at time 12:30:01.361504
2017-11-01 12:30:01,362 [salt.state       ][INFO    ][32331] Executing state glusterfs.created for keystone-credential-keys
2017-11-01 12:30:01,364 [salt.loaded.int.module.cmdmod][INFO    ][32331] Executing command 'gluster --version' in directory '/root'
2017-11-01 12:30:01,385 [salt.loaded.int.module.cmdmod][INFO    ][32331] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-01 12:30:01,468 [salt.loaded.int.module.cmdmod][INFO    ][32331] Executing command 'gluster --version' in directory '/root'
2017-11-01 12:30:01,489 [salt.loaded.int.module.cmdmod][INFO    ][32331] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-01 12:30:01,587 [salt.state       ][INFO    ][32331] Volume keystone-credential-keys already exists and is started.
2017-11-01 12:30:01,588 [salt.state       ][INFO    ][32331] Completed state [keystone-credential-keys] at time 12:30:01.587636 duration_in_ms=226.132
2017-11-01 12:30:01,600 [salt.state       ][INFO    ][32331] Running state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 12:30:01.599858
2017-11-01 12:30:01,600 [salt.state       ][INFO    ][32331] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'
2017-11-01 12:30:01,601 [salt.loaded.int.module.cmdmod][INFO    ][32331] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-11-01 12:30:01,703 [salt.state       ][INFO    ][32331] unless execution succeeded
2017-11-01 12:30:01,704 [salt.state       ][INFO    ][32331] Completed state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 12:30:01.703623 duration_in_ms=103.764
2017-11-01 12:30:01,705 [salt.state       ][INFO    ][32331] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 12:30:01.704543
2017-11-01 12:30:01,705 [salt.state       ][INFO    ][32331] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-11-01 12:30:01,706 [salt.loaded.int.module.cmdmod][INFO    ][32331] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-11-01 12:30:01,810 [salt.state       ][INFO    ][32331] unless execution succeeded
2017-11-01 12:30:01,812 [salt.state       ][INFO    ][32331] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 12:30:01.811248 duration_in_ms=106.704
2017-11-01 12:30:01,813 [salt.state       ][INFO    ][32331] Running state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 12:30:01.813393
2017-11-01 12:30:01,814 [salt.state       ][INFO    ][32331] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'
2017-11-01 12:30:01,815 [salt.loaded.int.module.cmdmod][INFO    ][32331] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-11-01 12:30:01,910 [salt.state       ][INFO    ][32331] unless execution succeeded
2017-11-01 12:30:01,911 [salt.state       ][INFO    ][32331] Completed state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 12:30:01.910877 duration_in_ms=97.484
2017-11-01 12:30:01,912 [salt.state       ][INFO    ][32331] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 12:30:01.911859
2017-11-01 12:30:01,912 [salt.state       ][INFO    ][32331] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'
2017-11-01 12:30:01,913 [salt.loaded.int.module.cmdmod][INFO    ][32331] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-11-01 12:30:02,004 [salt.state       ][INFO    ][32331] unless execution succeeded
2017-11-01 12:30:02,005 [salt.state       ][INFO    ][32331] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 12:30:02.004607 duration_in_ms=92.748
2017-11-01 12:30:02,006 [salt.state       ][INFO    ][32331] Running state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 12:30:02.005888
2017-11-01 12:30:02,007 [salt.state       ][INFO    ][32331] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'
2017-11-01 12:30:02,008 [salt.loaded.int.module.cmdmod][INFO    ][32331] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-11-01 12:30:02,104 [salt.state       ][INFO    ][32331] unless execution succeeded
2017-11-01 12:30:02,105 [salt.state       ][INFO    ][32331] Completed state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 12:30:02.104539 duration_in_ms=98.65
2017-11-01 12:30:02,109 [salt.state       ][INFO    ][32331] Running state [keystone-credential-keys] at time 12:30:02.108615
2017-11-01 12:30:02,109 [salt.state       ][INFO    ][32331] Executing state glusterfs.started for keystone-credential-keys
2017-11-01 12:30:02,110 [salt.loaded.int.module.cmdmod][INFO    ][32331] Executing command 'gluster --version' in directory '/root'
2017-11-01 12:30:02,128 [salt.loaded.int.module.cmdmod][INFO    ][32331] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-01 12:30:02,214 [salt.loaded.int.module.cmdmod][INFO    ][32331] Executing command 'gluster --version' in directory '/root'
2017-11-01 12:30:02,237 [salt.loaded.int.module.cmdmod][INFO    ][32331] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-01 12:30:02,340 [salt.state       ][INFO    ][32331] Volume keystone-credential-keys is already started
2017-11-01 12:30:02,341 [salt.state       ][INFO    ][32331] Completed state [keystone-credential-keys] at time 12:30:02.341171 duration_in_ms=232.556
2017-11-01 12:30:02,347 [salt.minion      ][INFO    ][32331] Returning information for job: 20171101122955790212
2017-11-01 12:30:11,767 [salt.minion      ][INFO    ][24030] User sudo_ubuntu Executing command test.ping with jid 20171101123011762122
2017-11-01 12:30:11,795 [salt.minion      ][INFO    ][32714] Starting a new job with PID 32714
2017-11-01 12:30:11,840 [salt.minion      ][INFO    ][32714] Returning information for job: 20171101123011762122
2017-11-01 12:30:11,969 [salt.minion      ][INFO    ][24030] User sudo_ubuntu Executing command cmd.run with jid 20171101123011959803
2017-11-01 12:30:11,996 [salt.minion      ][INFO    ][32719] Starting a new job with PID 32719
2017-11-01 12:30:12,004 [salt.loaded.int.module.cmdmod][INFO    ][32719] Executing command 'gluster peer status; gluster volume status' in directory '/root'
2017-11-01 12:30:12,203 [salt.minion      ][INFO    ][32719] Returning information for job: 20171101123011959803
2017-11-01 12:35:21,314 [salt.utils.schedule][INFO    ][24030] Running scheduled job: __mine_interval
2017-11-01 12:53:42,444 [salt.minion      ][INFO    ][24030] User sudo_ubuntu Executing command cp.push_dir with jid 20171101125342439250
2017-11-01 12:53:42,472 [salt.minion      ][INFO    ][32917] Starting a new job with PID 32917
