2017-11-05 21:33:06,761 [salt.cli.daemons ][WARNING ][2431] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-11-05 21:34:00,087 [salt.state       ][ERROR   ][3981] No contents found in top file
2017-11-05 21:35:54,490 [salt.utils.parsers][WARNING ][2431] Minion received a SIGTERM. Exiting.
2017-11-05 21:40:21,381 [salt.cli.daemons ][WARNING ][3848] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-11-05 21:42:28,676 [salt.loaded.int.module.cmdmod][ERROR   ][11138] Command 'virsh net-destroy default 2>&1 1>/dev/null; virsh net-undefine default' failed with return code: 1
2017-11-05 21:42:28,676 [salt.loaded.int.module.cmdmod][ERROR   ][11138] stderr: error: failed to get network 'default'
error: Network not found: no network with matching name 'default'
2017-11-05 21:42:28,676 [salt.loaded.int.module.cmdmod][ERROR   ][11138] retcode: 1
2017-11-05 21:42:28,677 [salt.state       ][ERROR   ][11138] {'pid': 16092, 'retcode': 1, 'stderr': "error: failed to get network 'default'\nerror: Network not found: no network with matching name 'default'", 'stdout': ''}
2017-11-05 21:42:46,178 [py.warnings      ][WARNING ][16173] /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-05 21:43:13,608 [salt.loaded.int.module.cmdmod][ERROR   ][16173] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-11-05 21:43:13,611 [salt.loaded.int.module.cmdmod][ERROR   ][16173] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-11-05 21:43:18,563 [salt.loaded.int.module.cmdmod][ERROR   ][16173] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-11-05 21:43:18,566 [salt.loaded.int.module.cmdmod][ERROR   ][16173] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-11-05 21:43:23,570 [salt.loaded.int.module.cmdmod][ERROR   ][16173] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-11-05 21:43:23,571 [salt.loaded.int.module.cmdmod][ERROR   ][16173] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-11-05 21:43:28,874 [salt.loaded.int.module.cmdmod][ERROR   ][16173] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-11-05 21:43:28,874 [salt.loaded.int.module.cmdmod][ERROR   ][16173] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-11-05 21:43:32,815 [salt.loaded.int.module.cmdmod][ERROR   ][16173] 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-05 21:43:37,195 [salt.state       ][ERROR   ][23708] No contents found in top file
2017-11-05 21:43:41,861 [salt.loaded.int.module.cmdmod][INFO    ][23965] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2017-11-05 21:43:41,879 [salt.loaded.int.module.cmdmod][INFO    ][23965] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2017-11-05 21:43:41,902 [salt.loaded.int.module.cmdmod][INFO    ][23965] Executing command ['systemd-run', '--scope', 'systemctl', 'restart', 'salt-minion.service'] in directory '/root'
2017-11-05 21:43:41,923 [salt.utils.parsers][WARNING ][3848] Minion received a SIGTERM. Exiting.
2017-11-05 21:43:42,361 [salt.cli.daemons ][INFO    ][24110] Setting up the Salt Minion "kvm02.baremetal-mcp-ocata-ovs-ha.local"
2017-11-05 21:43:43,255 [salt.minion      ][INFO    ][24110] Creating minion process manager
2017-11-05 21:43:43,255 [salt.cli.daemons ][WARNING ][24110] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-11-05 21:43:43,256 [salt.cli.daemons ][INFO    ][24110] The Salt Minion is starting up
2017-11-05 21:43:43,256 [salt.minion      ][INFO    ][24110] Minion is starting as user 'root'
2017-11-05 21:43:43,257 [salt.utils.event ][INFO    ][24110] Starting pull socket on /var/run/salt/minion/minion_event_a1b2f32648_pull.ipc
2017-11-05 21:43:44,684 [salt.loaded.int.module.cmdmod][INFO    ][24110] Executing command ['date', '+%z'] in directory '/root'
2017-11-05 21:43:44,714 [salt.utils.schedule][INFO    ][24110] Updating job settings for scheduled job: __mine_interval
2017-11-05 21:43:44,718 [salt.minion      ][INFO    ][24110] Added mine.update to scheduler
2017-11-05 21:43:44,749 [salt.minion      ][INFO    ][24110] Minion is ready to receive requests!
2017-11-05 21:43:45,750 [salt.utils.schedule][INFO    ][24110] Running scheduled job: __mine_interval
2017-11-05 21:43:55,475 [salt.minion      ][INFO    ][24110] User sudo_ubuntu Executing command state.sls with jid 20171105214355464642
2017-11-05 21:43:55,496 [salt.minion      ][INFO    ][24234] Starting a new job with PID 24234
2017-11-05 21:43:58,123 [salt.state       ][INFO    ][24234] Loading fresh modules for state activity
2017-11-05 21:43:58,164 [salt.fileclient  ][INFO    ][24234] Fetching file from saltenv 'base', ** done ** 'salt/control/init.sls'
2017-11-05 21:43:58,193 [salt.fileclient  ][INFO    ][24234] Fetching file from saltenv 'base', ** done ** 'salt/control/virt.sls'
2017-11-05 21:43:58,229 [salt.fileclient  ][INFO    ][24234] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-11-05 21:43:58,328 [salt.fileclient  ][INFO    ][24234] Fetching file from saltenv 'base', ** done ** 'salt/minion/init.sls'
2017-11-05 21:43:58,346 [salt.fileclient  ][INFO    ][24234] Fetching file from saltenv 'base', ** done ** 'salt/minion/service.sls'
2017-11-05 21:43:58,384 [salt.fileclient  ][INFO    ][24234] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-11-05 21:43:58,463 [salt.fileclient  ][INFO    ][24234] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-11-05 21:43:58,491 [salt.fileclient  ][INFO    ][24234] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-11-05 21:43:58,640 [salt.fileclient  ][INFO    ][24234] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-11-05 21:43:58,666 [salt.fileclient  ][INFO    ][24234] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-11-05 21:43:58,680 [salt.fileclient  ][INFO    ][24234] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-11-05 21:43:58,700 [salt.fileclient  ][INFO    ][24234] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-11-05 21:43:58,717 [salt.loaded.int.module.cmdmod][INFO    ][24234] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-11-05 21:43:58,741 [salt.fileclient  ][INFO    ][24234] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-11-05 21:43:58,768 [py.warnings      ][WARNING ][24234] /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-05 21:43:58,768 [salt.loaded.int.module.cmdmod][INFO    ][24234] Executing command 'salt-minion --version' in directory '/root'
2017-11-05 21:43:59,118 [salt.fileclient  ][INFO    ][24234] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-11-05 21:43:59,140 [salt.fileclient  ][INFO    ][24234] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-11-05 21:43:59,155 [salt.fileclient  ][INFO    ][24234] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-11-05 21:43:59,171 [salt.fileclient  ][INFO    ][24234] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-11-05 21:43:59,229 [salt.fileclient  ][INFO    ][24234] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-11-05 21:43:59,275 [salt.fileclient  ][INFO    ][24234] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-11-05 21:43:59,355 [salt.fileclient  ][INFO    ][24234] Fetching file from saltenv 'base', ** done ** 'salt/minion/grains.sls'
2017-11-05 21:43:59,383 [salt.fileclient  ][INFO    ][24234] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-11-05 21:43:59,452 [salt.fileclient  ][INFO    ][24234] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-11-05 21:43:59,477 [salt.fileclient  ][INFO    ][24234] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-11-05 21:43:59,543 [salt.fileclient  ][INFO    ][24234] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-11-05 21:43:59,567 [salt.fileclient  ][INFO    ][24234] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-11-05 21:43:59,589 [salt.fileclient  ][INFO    ][24234] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-11-05 21:43:59,616 [salt.fileclient  ][INFO    ][24234] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-11-05 21:43:59,629 [salt.loaded.int.module.cmdmod][INFO    ][24234] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-11-05 21:43:59,659 [salt.fileclient  ][INFO    ][24234] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-11-05 21:43:59,683 [salt.loaded.int.module.cmdmod][INFO    ][24234] Executing command 'salt-minion --version' in directory '/root'
2017-11-05 21:44:00,037 [salt.fileclient  ][INFO    ][24234] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-11-05 21:44:00,060 [salt.fileclient  ][INFO    ][24234] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-11-05 21:44:00,076 [salt.fileclient  ][INFO    ][24234] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-11-05 21:44:00,093 [salt.fileclient  ][INFO    ][24234] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-11-05 21:44:00,173 [salt.fileclient  ][INFO    ][24234] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-11-05 21:44:00,226 [salt.fileclient  ][INFO    ][24234] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-11-05 21:44:00,331 [salt.fileclient  ][INFO    ][24234] Fetching file from saltenv 'base', ** done ** 'salt/minion/cert.sls'
2017-11-05 21:44:00,423 [salt.fileclient  ][INFO    ][24234] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-11-05 21:44:00,896 [salt.state       ][INFO    ][24234] Running state [salt-minion] at time 21:44:00.895485
2017-11-05 21:44:00,896 [salt.state       ][INFO    ][24234] Executing state pkg.installed for salt-minion
2017-11-05 21:44:00,897 [salt.loaded.int.module.cmdmod][INFO    ][24234] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-05 21:44:01,301 [salt.state       ][INFO    ][24234] Package salt-minion is already installed
2017-11-05 21:44:01,302 [salt.state       ][INFO    ][24234] Completed state [salt-minion] at time 21:44:01.301597 duration_in_ms=406.113
2017-11-05 21:44:01,302 [salt.state       ][INFO    ][24234] Running state [salt_minion_dependency_packages] at time 21:44:01.301862
2017-11-05 21:44:01,302 [salt.state       ][INFO    ][24234] Executing state pkg.installed for salt_minion_dependency_packages
2017-11-05 21:44:01,307 [salt.state       ][INFO    ][24234] All specified packages are already installed
2017-11-05 21:44:01,308 [salt.state       ][INFO    ][24234] Completed state [salt_minion_dependency_packages] at time 21:44:01.308087 duration_in_ms=6.225
2017-11-05 21:44:01,310 [salt.state       ][INFO    ][24234] Running state [/etc/salt/minion.d/minion.conf] at time 21:44:01.310172
2017-11-05 21:44:01,310 [salt.state       ][INFO    ][24234] Executing state file.managed for /etc/salt/minion.d/minion.conf
2017-11-05 21:44:01,340 [salt.fileclient  ][INFO    ][24234] Fetching file from saltenv 'base', ** done ** 'salt/files/minion.conf'
2017-11-05 21:44:01,416 [salt.fileclient  ][INFO    ][24234] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-11-05 21:44:01,485 [salt.fileclient  ][INFO    ][24234] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-11-05 21:44:01,550 [salt.state       ][INFO    ][24234] File /etc/salt/minion.d/minion.conf is in the correct state
2017-11-05 21:44:01,550 [salt.state       ][INFO    ][24234] Completed state [/etc/salt/minion.d/minion.conf] at time 21:44:01.550093 duration_in_ms=239.921
2017-11-05 21:44:01,551 [salt.state       ][INFO    ][24234] Running state [/etc/salt/minion.d/_virt.conf] at time 21:44:01.550467
2017-11-05 21:44:01,551 [salt.state       ][INFO    ][24234] Executing state file.managed for /etc/salt/minion.d/_virt.conf
2017-11-05 21:44:01,551 [salt.state       ][INFO    ][24234] File /etc/salt/minion.d/_virt.conf is in the correct state
2017-11-05 21:44:01,552 [salt.state       ][INFO    ][24234] Completed state [/etc/salt/minion.d/_virt.conf] at time 21:44:01.551554 duration_in_ms=1.087
2017-11-05 21:44:01,554 [salt.state       ][INFO    ][24234] Running state [salt-minion] at time 21:44:01.553937
2017-11-05 21:44:01,554 [salt.state       ][INFO    ][24234] Executing state service.running for salt-minion
2017-11-05 21:44:01,555 [salt.loaded.int.module.cmdmod][INFO    ][24234] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2017-11-05 21:44:01,582 [salt.loaded.int.module.cmdmod][INFO    ][24234] Executing command ['systemctl', 'is-active', 'salt-minion.service'] in directory '/root'
2017-11-05 21:44:01,596 [salt.loaded.int.module.cmdmod][INFO    ][24234] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2017-11-05 21:44:01,608 [salt.state       ][INFO    ][24234] The service salt-minion is already running
2017-11-05 21:44:01,609 [salt.state       ][INFO    ][24234] Completed state [salt-minion] at time 21:44:01.608516 duration_in_ms=54.578
2017-11-05 21:44:01,610 [salt.state       ][INFO    ][24234] Running state [/etc/salt/grains.d] at time 21:44:01.610154
2017-11-05 21:44:01,610 [salt.state       ][INFO    ][24234] Executing state file.directory for /etc/salt/grains.d
2017-11-05 21:44:01,611 [salt.state       ][INFO    ][24234] Directory /etc/salt/grains.d is in the correct state
2017-11-05 21:44:01,611 [salt.state       ][INFO    ][24234] Completed state [/etc/salt/grains.d] at time 21:44:01.611438 duration_in_ms=1.284
2017-11-05 21:44:01,613 [salt.state       ][INFO    ][24234] Running state [/etc/salt/grains] at time 21:44:01.613073
2017-11-05 21:44:01,614 [salt.state       ][INFO    ][24234] Executing state file.managed for /etc/salt/grains
2017-11-05 21:44:01,614 [salt.state       ][INFO    ][24234] File /etc/salt/grains exists with proper permissions. No changes made.
2017-11-05 21:44:01,614 [salt.state       ][INFO    ][24234] Completed state [/etc/salt/grains] at time 21:44:01.614066 duration_in_ms=0.993
2017-11-05 21:44:01,614 [salt.state       ][INFO    ][24234] Running state [/etc/salt/grains.d/placeholder] at time 21:44:01.614402
2017-11-05 21:44:01,615 [salt.state       ][INFO    ][24234] Executing state file.managed for /etc/salt/grains.d/placeholder
2017-11-05 21:44:01,615 [salt.state       ][INFO    ][24234] File /etc/salt/grains.d/placeholder exists with proper permissions. No changes made.
2017-11-05 21:44:01,615 [salt.state       ][INFO    ][24234] Completed state [/etc/salt/grains.d/placeholder] at time 21:44:01.615382 duration_in_ms=0.98
2017-11-05 21:44:01,616 [salt.state       ][INFO    ][24234] Running state [/etc/salt/grains.d/sphinx] at time 21:44:01.615712
2017-11-05 21:44:01,616 [salt.state       ][INFO    ][24234] Executing state file.managed for /etc/salt/grains.d/sphinx
2017-11-05 21:44:01,618 [salt.state       ][INFO    ][24234] 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-05 21:44:01,619 [salt.state       ][INFO    ][24234] Completed state [/etc/salt/grains.d/sphinx] at time 21:44:01.618516 duration_in_ms=2.803
2017-11-05 21:44:01,619 [salt.state       ][INFO    ][24234] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 21:44:01.619290
2017-11-05 21:44:01,620 [salt.state       ][INFO    ][24234] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-11-05 21:44:01,620 [salt.state       ][INFO    ][24234] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-11-05 21:44:01,621 [salt.state       ][INFO    ][24234] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 21:44:01.621217 duration_in_ms=1.927
2017-11-05 21:44:01,621 [salt.state       ][INFO    ][24234] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 21:44:01.621385
2017-11-05 21:44:01,622 [salt.state       ][INFO    ][24234] 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-05 21:44:01,622 [salt.loaded.int.module.cmdmod][INFO    ][24234] Executing command 'python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"' in directory '/root'
2017-11-05 21:44:01,734 [salt.state       ][INFO    ][24234] {'pid': 24282, 'retcode': 0, 'stderr': '', 'stdout': ''}
2017-11-05 21:44:01,735 [salt.state       ][INFO    ][24234] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 21:44:01.735253 duration_in_ms=113.868
2017-11-05 21:44:01,736 [salt.state       ][INFO    ][24234] Running state [/etc/salt/grains.d/dns_records] at time 21:44:01.735756
2017-11-05 21:44:01,736 [salt.state       ][INFO    ][24234] Executing state file.managed for /etc/salt/grains.d/dns_records
2017-11-05 21:44:01,737 [salt.state       ][INFO    ][24234] File /etc/salt/grains.d/dns_records is in the correct state
2017-11-05 21:44:01,738 [salt.state       ][INFO    ][24234] Completed state [/etc/salt/grains.d/dns_records] at time 21:44:01.737644 duration_in_ms=1.887
2017-11-05 21:44:01,739 [salt.state       ][INFO    ][24234] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 21:44:01.738667
2017-11-05 21:44:01,739 [salt.state       ][INFO    ][24234] 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-05 21:44:01,739 [salt.state       ][INFO    ][24234] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"
2017-11-05 21:44:01,739 [salt.state       ][INFO    ][24234] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 21:44:01.739448 duration_in_ms=0.781
2017-11-05 21:44:01,740 [salt.state       ][INFO    ][24234] Running state [/etc/salt/grains.d/salt] at time 21:44:01.740239
2017-11-05 21:44:01,740 [salt.state       ][INFO    ][24234] Executing state file.managed for /etc/salt/grains.d/salt
2017-11-05 21:44:01,741 [salt.state       ][INFO    ][24234] File /etc/salt/grains.d/salt is in the correct state
2017-11-05 21:44:01,742 [salt.state       ][INFO    ][24234] Completed state [/etc/salt/grains.d/salt] at time 21:44:01.741871 duration_in_ms=1.632
2017-11-05 21:44:01,743 [salt.state       ][INFO    ][24234] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 21:44:01.742602
2017-11-05 21:44:01,743 [salt.state       ][INFO    ][24234] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2017-11-05 21:44:01,743 [salt.state       ][INFO    ][24234] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2017-11-05 21:44:01,743 [salt.state       ][INFO    ][24234] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 21:44:01.743185 duration_in_ms=0.583
2017-11-05 21:44:01,745 [salt.state       ][INFO    ][24234] Running state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 21:44:01.744814
2017-11-05 21:44:01,745 [salt.state       ][INFO    ][24234] Executing state cmd.wait for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-11-05 21:44:01,745 [salt.state       ][INFO    ][24234] No changes made for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-11-05 21:44:01,746 [salt.state       ][INFO    ][24234] Completed state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 21:44:01.745707 duration_in_ms=0.893
2017-11-05 21:44:01,746 [salt.state       ][INFO    ][24234] Running state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 21:44:01.746130
2017-11-05 21:44:01,746 [salt.state       ][INFO    ][24234] Executing state cmd.mod_watch for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-11-05 21:44:01,749 [salt.loaded.int.module.cmdmod][INFO    ][24234] Executing command 'cat /etc/salt/grains.d/* > /etc/salt/grains' in directory '/root'
2017-11-05 21:44:01,761 [salt.state       ][INFO    ][24234] {'pid': 24284, 'retcode': 0, 'stderr': '', 'stdout': ''}
2017-11-05 21:44:01,761 [salt.state       ][INFO    ][24234] Completed state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 21:44:01.761406 duration_in_ms=15.275
2017-11-05 21:44:01,762 [salt.state       ][INFO    ][24234] Running state [mine.update] at time 21:44:01.762361
2017-11-05 21:44:01,763 [salt.state       ][INFO    ][24234] Executing state module.wait for mine.update
2017-11-05 21:44:01,764 [salt.state       ][INFO    ][24234] No changes made for mine.update
2017-11-05 21:44:01,764 [salt.state       ][INFO    ][24234] Completed state [mine.update] at time 21:44:01.764006 duration_in_ms=1.645
2017-11-05 21:44:01,764 [salt.state       ][INFO    ][24234] Running state [mine.update] at time 21:44:01.764228
2017-11-05 21:44:01,765 [salt.state       ][INFO    ][24234] Executing state module.mod_watch for mine.update
2017-11-05 21:44:02,297 [salt.state       ][INFO    ][24234] {'ret': True}
2017-11-05 21:44:02,298 [salt.state       ][INFO    ][24234] Completed state [mine.update] at time 21:44:02.297795 duration_in_ms=533.566
2017-11-05 21:44:02,298 [salt.state       ][INFO    ][24234] Running state [ca-certificates] at time 21:44:02.298137
2017-11-05 21:44:02,298 [salt.state       ][INFO    ][24234] Executing state pkg.installed for ca-certificates
2017-11-05 21:44:02,304 [salt.state       ][INFO    ][24234] Package ca-certificates is already installed
2017-11-05 21:44:02,305 [salt.state       ][INFO    ][24234] Completed state [ca-certificates] at time 21:44:02.304651 duration_in_ms=6.514
2017-11-05 21:44:02,306 [salt.state       ][INFO    ][24234] Running state [update-ca-certificates] at time 21:44:02.305776
2017-11-05 21:44:02,306 [salt.state       ][INFO    ][24234] Executing state cmd.wait for update-ca-certificates
2017-11-05 21:44:02,306 [salt.state       ][INFO    ][24234] No changes made for update-ca-certificates
2017-11-05 21:44:02,307 [salt.state       ][INFO    ][24234] Completed state [update-ca-certificates] at time 21:44:02.306561 duration_in_ms=0.785
2017-11-05 21:44:02,307 [salt.state       ][INFO    ][24234] Running state [libvirt-dev] at time 21:44:02.307089
2017-11-05 21:44:02,307 [salt.state       ][INFO    ][24234] Executing state pkg.installed for libvirt-dev
2017-11-05 21:44:02,314 [salt.state       ][INFO    ][24234] Package libvirt-dev is already installed
2017-11-05 21:44:02,314 [salt.state       ][INFO    ][24234] Completed state [libvirt-dev] at time 21:44:02.314163 duration_in_ms=7.074
2017-11-05 21:44:02,314 [salt.state       ][INFO    ][24234] Running state [pkg-config] at time 21:44:02.314407
2017-11-05 21:44:02,315 [salt.state       ][INFO    ][24234] Executing state pkg.installed for pkg-config
2017-11-05 21:44:02,320 [salt.state       ][INFO    ][24234] Package pkg-config is already installed
2017-11-05 21:44:02,320 [salt.state       ][INFO    ][24234] Completed state [pkg-config] at time 21:44:02.319997 duration_in_ms=5.59
2017-11-05 21:44:02,321 [salt.state       ][INFO    ][24234] Running state [virtng.init] at time 21:44:02.320533
2017-11-05 21:44:02,321 [salt.state       ][INFO    ][24234] Executing state module.run for virtng.init
2017-11-05 21:44:02,395 [salt.loaded.int.module.cmdmod][INFO    ][24234] Executing command ['git', '--version'] in directory '/root'
2017-11-05 21:44:02,454 [salt.loaded.int.module.cmdmod][INFO    ][24234] Executing command 'virsh list --all --name| grep -E "^mdb02.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-11-05 21:44:02,483 [salt.state       ][INFO    ][24234] unless execution succeeded
2017-11-05 21:44:02,484 [salt.state       ][INFO    ][24234] Completed state [virtng.init] at time 21:44:02.483590 duration_in_ms=163.055
2017-11-05 21:44:02,484 [salt.state       ][INFO    ][24234] Running state [virt.set_autostart] at time 21:44:02.484175
2017-11-05 21:44:02,484 [salt.state       ][INFO    ][24234] Executing state module.run for virt.set_autostart
2017-11-05 21:44:02,491 [salt.loaded.int.module.cmdmod][INFO    ][24234] Executing command 'virsh list --autostart --name| grep -E "^mdb02.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-11-05 21:44:02,526 [salt.state       ][INFO    ][24234] unless execution succeeded
2017-11-05 21:44:02,526 [salt.state       ][INFO    ][24234] Completed state [virt.set_autostart] at time 21:44:02.526287 duration_in_ms=42.112
2017-11-05 21:44:02,527 [salt.state       ][INFO    ][24234] Running state [virtng.init] at time 21:44:02.526593
2017-11-05 21:44:02,527 [salt.state       ][INFO    ][24234] Executing state module.run for virtng.init
2017-11-05 21:44:02,534 [salt.loaded.int.module.cmdmod][INFO    ][24234] Executing command 'virsh list --all --name| grep -E "^dbs02.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-11-05 21:44:02,566 [salt.state       ][INFO    ][24234] unless execution succeeded
2017-11-05 21:44:02,567 [salt.state       ][INFO    ][24234] Completed state [virtng.init] at time 21:44:02.566525 duration_in_ms=39.932
2017-11-05 21:44:02,567 [salt.state       ][INFO    ][24234] Running state [virt.set_autostart] at time 21:44:02.566838
2017-11-05 21:44:02,567 [salt.state       ][INFO    ][24234] Executing state module.run for virt.set_autostart
2017-11-05 21:44:02,574 [salt.loaded.int.module.cmdmod][INFO    ][24234] Executing command 'virsh list --autostart --name| grep -E "^dbs02.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-11-05 21:44:02,608 [salt.state       ][INFO    ][24234] unless execution succeeded
2017-11-05 21:44:02,610 [salt.state       ][INFO    ][24234] Completed state [virt.set_autostart] at time 21:44:02.610043 duration_in_ms=43.204
2017-11-05 21:44:02,611 [salt.state       ][INFO    ][24234] Running state [virtng.init] at time 21:44:02.610597
2017-11-05 21:44:02,611 [salt.state       ][INFO    ][24234] Executing state module.run for virtng.init
2017-11-05 21:44:02,617 [salt.loaded.int.module.cmdmod][INFO    ][24234] Executing command 'virsh list --all --name| grep -E "^ctl02.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-11-05 21:44:02,651 [salt.state       ][INFO    ][24234] unless execution succeeded
2017-11-05 21:44:02,651 [salt.state       ][INFO    ][24234] Completed state [virtng.init] at time 21:44:02.650791 duration_in_ms=40.194
2017-11-05 21:44:02,651 [salt.state       ][INFO    ][24234] Running state [virt.set_autostart] at time 21:44:02.651060
2017-11-05 21:44:02,652 [salt.state       ][INFO    ][24234] Executing state module.run for virt.set_autostart
2017-11-05 21:44:02,657 [salt.loaded.int.module.cmdmod][INFO    ][24234] Executing command 'virsh list --autostart --name| grep -E "^ctl02.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-11-05 21:44:02,690 [salt.state       ][INFO    ][24234] unless execution succeeded
2017-11-05 21:44:02,691 [salt.state       ][INFO    ][24234] Completed state [virt.set_autostart] at time 21:44:02.690727 duration_in_ms=39.666
2017-11-05 21:44:02,692 [salt.state       ][INFO    ][24234] Running state [virtng.init] at time 21:44:02.691544
2017-11-05 21:44:02,692 [salt.state       ][INFO    ][24234] Executing state module.run for virtng.init
2017-11-05 21:44:02,699 [salt.loaded.int.module.cmdmod][INFO    ][24234] Executing command 'virsh list --all --name| grep -E "^msg02.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-11-05 21:44:02,730 [salt.state       ][INFO    ][24234] unless execution succeeded
2017-11-05 21:44:02,730 [salt.state       ][INFO    ][24234] Completed state [virtng.init] at time 21:44:02.730394 duration_in_ms=38.849
2017-11-05 21:44:02,731 [salt.state       ][INFO    ][24234] Running state [virt.set_autostart] at time 21:44:02.730668
2017-11-05 21:44:02,731 [salt.state       ][INFO    ][24234] Executing state module.run for virt.set_autostart
2017-11-05 21:44:02,737 [salt.loaded.int.module.cmdmod][INFO    ][24234] Executing command 'virsh list --autostart --name| grep -E "^msg02.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-11-05 21:44:02,769 [salt.state       ][INFO    ][24234] unless execution succeeded
2017-11-05 21:44:02,770 [salt.state       ][INFO    ][24234] Completed state [virt.set_autostart] at time 21:44:02.769537 duration_in_ms=38.868
2017-11-05 21:44:02,775 [salt.minion      ][INFO    ][24234] Returning information for job: 20171105214355464642
2017-11-05 21:44:29,080 [salt.minion      ][INFO    ][24110] User sudo_ubuntu Executing command saltutil.sync_all with jid 20171105214429068115
2017-11-05 21:44:29,107 [salt.minion      ][INFO    ][24341] Starting a new job with PID 24341
2017-11-05 21:44:33,435 [salt.state       ][INFO    ][24341] Loading fresh modules for state activity
2017-11-05 21:44:33,913 [salt.state       ][ERROR   ][24341] No contents found in top file
2017-11-05 21:44:33,914 [salt.utils.extmods][INFO    ][24341] Creating module dir '/var/cache/salt/minion/extmods/beacons'
2017-11-05 21:44:33,924 [salt.utils.extmods][INFO    ][24341] Syncing beacons for environment 'base'
2017-11-05 21:44:33,925 [salt.utils.extmods][INFO    ][24341] Loading cache from salt://_beacons, for base)
2017-11-05 21:44:33,925 [salt.fileclient  ][INFO    ][24341] Caching directory '_beacons/' for environment 'base'
2017-11-05 21:44:33,987 [salt.utils.extmods][INFO    ][24341] Syncing modules for environment 'base'
2017-11-05 21:44:33,987 [salt.utils.extmods][INFO    ][24341] Loading cache from salt://_modules, for base)
2017-11-05 21:44:33,988 [salt.fileclient  ][INFO    ][24341] Caching directory '_modules/' for environment 'base'
2017-11-05 21:44:34,063 [salt.fileclient  ][INFO    ][24341] Fetching file from saltenv 'base', ** done ** '_modules/ceph_ng.py'
2017-11-05 21:44:34,077 [salt.fileclient  ][INFO    ][24341] Fetching file from saltenv 'base', ** done ** '_modules/cinderng.py'
2017-11-05 21:44:34,096 [salt.fileclient  ][INFO    ][24341] Fetching file from saltenv 'base', ** done ** '_modules/contrail.py'
2017-11-05 21:44:34,109 [salt.fileclient  ][INFO    ][24341] Fetching file from saltenv 'base', ** done ** '_modules/creds.py'
2017-11-05 21:44:34,121 [salt.fileclient  ][INFO    ][24341] Fetching file from saltenv 'base', ** done ** '_modules/devops_utils.py'
2017-11-05 21:44:34,133 [salt.fileclient  ][INFO    ][24341] Fetching file from saltenv 'base', ** done ** '_modules/encode_json.py'
2017-11-05 21:44:34,145 [salt.fileclient  ][INFO    ][24341] Fetching file from saltenv 'base', ** done ** '_modules/gerrit.py'
2017-11-05 21:44:34,256 [salt.fileclient  ][INFO    ][24341] Fetching file from saltenv 'base', ** done ** '_modules/glanceng.py'
2017-11-05 21:44:34,297 [salt.fileclient  ][INFO    ][24341] Fetching file from saltenv 'base', ** done ** '_modules/heat.py'
2017-11-05 21:44:34,325 [salt.fileclient  ][INFO    ][24341] Fetching file from saltenv 'base', ** done ** '_modules/heka_alarming.py'
2017-11-05 21:44:34,360 [salt.fileclient  ][INFO    ][24341] Fetching file from saltenv 'base', ** done ** '_modules/helm.py'
2017-11-05 21:44:34,372 [salt.fileclient  ][INFO    ][24341] Fetching file from saltenv 'base', ** done ** '_modules/jenkins_common.py'
2017-11-05 21:44:34,388 [salt.fileclient  ][INFO    ][24341] Fetching file from saltenv 'base', ** done ** '_modules/keystone_policy.py'
2017-11-05 21:44:34,409 [salt.fileclient  ][INFO    ][24341] Fetching file from saltenv 'base', ** done ** '_modules/linux_hosts.py'
2017-11-05 21:44:34,433 [salt.fileclient  ][INFO    ][24341] Fetching file from saltenv 'base', ** done ** '_modules/linux_netlink.py'
2017-11-05 21:44:34,464 [salt.fileclient  ][INFO    ][24341] Fetching file from saltenv 'base', ** done ** '_modules/maas.py'
2017-11-05 21:44:34,485 [salt.fileclient  ][INFO    ][24341] Fetching file from saltenv 'base', ** done ** '_modules/maas_client.py'
2017-11-05 21:44:34,503 [salt.fileclient  ][INFO    ][24341] Fetching file from saltenv 'base', ** done ** '_modules/modelutils.py'
2017-11-05 21:44:34,521 [salt.fileclient  ][INFO    ][24341] Fetching file from saltenv 'base', ** done ** '_modules/multipart.py'
2017-11-05 21:44:34,546 [salt.fileclient  ][INFO    ][24341] Fetching file from saltenv 'base', ** done ** '_modules/nagios_alarming.py'
2017-11-05 21:44:34,618 [salt.fileclient  ][INFO    ][24341] Fetching file from saltenv 'base', ** done ** '_modules/neutronng.py'
2017-11-05 21:44:34,651 [salt.fileclient  ][INFO    ][24341] Fetching file from saltenv 'base', ** done ** '_modules/novang.py'
2017-11-05 21:44:34,682 [salt.fileclient  ][INFO    ][24341] Fetching file from saltenv 'base', ** done ** '_modules/reclass.py'
2017-11-05 21:44:34,697 [salt.fileclient  ][INFO    ][24341] Fetching file from saltenv 'base', ** done ** '_modules/rsyslog_util.py'
2017-11-05 21:44:34,710 [salt.fileclient  ][INFO    ][24341] Fetching file from saltenv 'base', ** done ** '_modules/rundeck.py'
2017-11-05 21:44:34,721 [salt.fileclient  ][INFO    ][24341] Fetching file from saltenv 'base', ** done ** '_modules/saltkey.py'
2017-11-05 21:44:34,737 [salt.fileclient  ][INFO    ][24341] Fetching file from saltenv 'base', ** done ** '_modules/saltresource.py'
2017-11-05 21:44:34,752 [salt.fileclient  ][INFO    ][24341] Fetching file from saltenv 'base', ** done ** '_modules/seedng.py'
2017-11-05 21:44:34,781 [salt.fileclient  ][INFO    ][24341] Fetching file from saltenv 'base', ** done ** '_modules/testing/credentials.py'
2017-11-05 21:44:34,793 [salt.fileclient  ][INFO    ][24341] Fetching file from saltenv 'base', ** done ** '_modules/testing/django.py'
2017-11-05 21:44:34,817 [salt.fileclient  ][INFO    ][24341] Fetching file from saltenv 'base', ** done ** '_modules/testing/django_client_proxy.py'
2017-11-05 21:44:34,832 [salt.fileclient  ][INFO    ][24341] Fetching file from saltenv 'base', ** done ** '_modules/utils.py'
2017-11-05 21:44:34,856 [salt.fileclient  ][INFO    ][24341] Fetching file from saltenv 'base', ** done ** '_modules/virtng.py'
2017-11-05 21:44:34,863 [salt.utils.extmods][INFO    ][24341] Copying '/var/cache/salt/minion/files/base/_modules/__init__.py' to '/var/cache/salt/minion/extmods/modules/__init__.py'
2017-11-05 21:44:34,864 [salt.utils.extmods][INFO    ][24341] Copying '/var/cache/salt/minion/files/base/_modules/ceph_ng.py' to '/var/cache/salt/minion/extmods/modules/ceph_ng.py'
2017-11-05 21:44:34,864 [salt.utils.extmods][INFO    ][24341] Copying '/var/cache/salt/minion/files/base/_modules/cinderng.py' to '/var/cache/salt/minion/extmods/modules/cinderng.py'
2017-11-05 21:44:34,865 [salt.utils.extmods][INFO    ][24341] Copying '/var/cache/salt/minion/files/base/_modules/contrail.py' to '/var/cache/salt/minion/extmods/modules/contrail.py'
2017-11-05 21:44:34,865 [salt.utils.extmods][INFO    ][24341] Copying '/var/cache/salt/minion/files/base/_modules/creds.py' to '/var/cache/salt/minion/extmods/modules/creds.py'
2017-11-05 21:44:34,866 [salt.utils.extmods][INFO    ][24341] Copying '/var/cache/salt/minion/files/base/_modules/devops_utils.py' to '/var/cache/salt/minion/extmods/modules/devops_utils.py'
2017-11-05 21:44:34,867 [salt.utils.extmods][INFO    ][24341] Copying '/var/cache/salt/minion/files/base/_modules/encode_json.py' to '/var/cache/salt/minion/extmods/modules/encode_json.py'
2017-11-05 21:44:34,868 [salt.utils.extmods][INFO    ][24341] Copying '/var/cache/salt/minion/files/base/_modules/gerrit.py' to '/var/cache/salt/minion/extmods/modules/gerrit.py'
2017-11-05 21:44:34,868 [salt.utils.extmods][INFO    ][24341] Copying '/var/cache/salt/minion/files/base/_modules/glanceng.py' to '/var/cache/salt/minion/extmods/modules/glanceng.py'
2017-11-05 21:44:34,869 [salt.utils.extmods][INFO    ][24341] Copying '/var/cache/salt/minion/files/base/_modules/heat.py' to '/var/cache/salt/minion/extmods/modules/heat.py'
2017-11-05 21:44:34,869 [salt.utils.extmods][INFO    ][24341] Copying '/var/cache/salt/minion/files/base/_modules/heka_alarming.py' to '/var/cache/salt/minion/extmods/modules/heka_alarming.py'
2017-11-05 21:44:34,869 [salt.utils.extmods][INFO    ][24341] Copying '/var/cache/salt/minion/files/base/_modules/helm.py' to '/var/cache/salt/minion/extmods/modules/helm.py'
2017-11-05 21:44:34,870 [salt.utils.extmods][INFO    ][24341] Copying '/var/cache/salt/minion/files/base/_modules/jenkins_common.py' to '/var/cache/salt/minion/extmods/modules/jenkins_common.py'
2017-11-05 21:44:34,870 [salt.utils.extmods][INFO    ][24341] Copying '/var/cache/salt/minion/files/base/_modules/keystone_policy.py' to '/var/cache/salt/minion/extmods/modules/keystone_policy.py'
2017-11-05 21:44:34,870 [salt.utils.extmods][INFO    ][24341] Copying '/var/cache/salt/minion/files/base/_modules/linux_hosts.py' to '/var/cache/salt/minion/extmods/modules/linux_hosts.py'
2017-11-05 21:44:34,871 [salt.utils.extmods][INFO    ][24341] Copying '/var/cache/salt/minion/files/base/_modules/linux_netlink.py' to '/var/cache/salt/minion/extmods/modules/linux_netlink.py'
2017-11-05 21:44:34,871 [salt.utils.extmods][INFO    ][24341] Copying '/var/cache/salt/minion/files/base/_modules/maas.py' to '/var/cache/salt/minion/extmods/modules/maas.py'
2017-11-05 21:44:34,871 [salt.utils.extmods][INFO    ][24341] Copying '/var/cache/salt/minion/files/base/_modules/maas_client.py' to '/var/cache/salt/minion/extmods/modules/maas_client.py'
2017-11-05 21:44:34,872 [salt.utils.extmods][INFO    ][24341] Copying '/var/cache/salt/minion/files/base/_modules/modelutils.py' to '/var/cache/salt/minion/extmods/modules/modelutils.py'
2017-11-05 21:44:34,872 [salt.utils.extmods][INFO    ][24341] Copying '/var/cache/salt/minion/files/base/_modules/multipart.py' to '/var/cache/salt/minion/extmods/modules/multipart.py'
2017-11-05 21:44:34,873 [salt.utils.extmods][INFO    ][24341] Copying '/var/cache/salt/minion/files/base/_modules/nagios_alarming.py' to '/var/cache/salt/minion/extmods/modules/nagios_alarming.py'
2017-11-05 21:44:34,873 [salt.utils.extmods][INFO    ][24341] Copying '/var/cache/salt/minion/files/base/_modules/neutronng.py' to '/var/cache/salt/minion/extmods/modules/neutronng.py'
2017-11-05 21:44:34,873 [salt.utils.extmods][INFO    ][24341] Copying '/var/cache/salt/minion/files/base/_modules/novang.py' to '/var/cache/salt/minion/extmods/modules/novang.py'
2017-11-05 21:44:34,874 [salt.utils.extmods][INFO    ][24341] Copying '/var/cache/salt/minion/files/base/_modules/reclass.py' to '/var/cache/salt/minion/extmods/modules/reclass.py'
2017-11-05 21:44:34,875 [salt.utils.extmods][INFO    ][24341] Copying '/var/cache/salt/minion/files/base/_modules/rsyslog_util.py' to '/var/cache/salt/minion/extmods/modules/rsyslog_util.py'
2017-11-05 21:44:34,875 [salt.utils.extmods][INFO    ][24341] Copying '/var/cache/salt/minion/files/base/_modules/rundeck.py' to '/var/cache/salt/minion/extmods/modules/rundeck.py'
2017-11-05 21:44:34,876 [salt.utils.extmods][INFO    ][24341] Copying '/var/cache/salt/minion/files/base/_modules/saltkey.py' to '/var/cache/salt/minion/extmods/modules/saltkey.py'
2017-11-05 21:44:34,876 [salt.utils.extmods][INFO    ][24341] Copying '/var/cache/salt/minion/files/base/_modules/saltresource.py' to '/var/cache/salt/minion/extmods/modules/saltresource.py'
2017-11-05 21:44:34,877 [salt.utils.extmods][INFO    ][24341] Copying '/var/cache/salt/minion/files/base/_modules/seedng.py' to '/var/cache/salt/minion/extmods/modules/seedng.py'
2017-11-05 21:44:34,877 [salt.utils.extmods][INFO    ][24341] Copying '/var/cache/salt/minion/files/base/_modules/testing/__init__.py' to '/var/cache/salt/minion/extmods/modules/testing/__init__.py'
2017-11-05 21:44:34,877 [salt.utils.extmods][INFO    ][24341] Copying '/var/cache/salt/minion/files/base/_modules/testing/credentials.py' to '/var/cache/salt/minion/extmods/modules/testing/credentials.py'
2017-11-05 21:44:34,878 [salt.utils.extmods][INFO    ][24341] Copying '/var/cache/salt/minion/files/base/_modules/testing/django.py' to '/var/cache/salt/minion/extmods/modules/testing/django.py'
2017-11-05 21:44:34,879 [salt.utils.extmods][INFO    ][24341] 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-05 21:44:34,879 [salt.utils.extmods][INFO    ][24341] Copying '/var/cache/salt/minion/files/base/_modules/utils.py' to '/var/cache/salt/minion/extmods/modules/utils.py'
2017-11-05 21:44:34,879 [salt.utils.extmods][INFO    ][24341] Copying '/var/cache/salt/minion/files/base/_modules/virtng.py' to '/var/cache/salt/minion/extmods/modules/virtng.py'
2017-11-05 21:44:34,894 [salt.utils.extmods][INFO    ][24341] Syncing states for environment 'base'
2017-11-05 21:44:34,894 [salt.utils.extmods][INFO    ][24341] Loading cache from salt://_states, for base)
2017-11-05 21:44:34,895 [salt.fileclient  ][INFO    ][24341] Caching directory '_states/' for environment 'base'
2017-11-05 21:44:34,970 [salt.fileclient  ][INFO    ][24341] Fetching file from saltenv 'base', ** done ** '_states/cinderng.py'
2017-11-05 21:44:34,993 [salt.fileclient  ][INFO    ][24341] Fetching file from saltenv 'base', ** done ** '_states/contrail.py'
2017-11-05 21:44:35,012 [salt.fileclient  ][INFO    ][24341] Fetching file from saltenv 'base', ** done ** '_states/gerrit.py'
2017-11-05 21:44:35,033 [salt.fileclient  ][INFO    ][24341] Fetching file from saltenv 'base', ** done ** '_states/glanceng.py'
2017-11-05 21:44:35,057 [salt.fileclient  ][INFO    ][24341] Fetching file from saltenv 'base', ** done ** '_states/grafana3_dashboard.py'
2017-11-05 21:44:35,082 [salt.fileclient  ][INFO    ][24341] Fetching file from saltenv 'base', ** done ** '_states/grafana3_datasource.py'
2017-11-05 21:44:35,121 [salt.fileclient  ][INFO    ][24341] Fetching file from saltenv 'base', ** done ** '_states/heat.py'
2017-11-05 21:44:35,136 [salt.fileclient  ][INFO    ][24341] Fetching file from saltenv 'base', ** done ** '_states/helm_release.py'
2017-11-05 21:44:35,156 [salt.fileclient  ][INFO    ][24341] Fetching file from saltenv 'base', ** done ** '_states/jenkins_approval.py'
2017-11-05 21:44:35,177 [salt.fileclient  ][INFO    ][24341] Fetching file from saltenv 'base', ** done ** '_states/jenkins_artifactory.py'
2017-11-05 21:44:35,194 [salt.fileclient  ][INFO    ][24341] Fetching file from saltenv 'base', ** done ** '_states/jenkins_credential.py'
2017-11-05 21:44:35,211 [salt.fileclient  ][INFO    ][24341] Fetching file from saltenv 'base', ** done ** '_states/jenkins_job.py'
2017-11-05 21:44:35,229 [salt.fileclient  ][INFO    ][24341] Fetching file from saltenv 'base', ** done ** '_states/jenkins_lib.py'
2017-11-05 21:44:35,247 [salt.fileclient  ][INFO    ][24341] Fetching file from saltenv 'base', ** done ** '_states/jenkins_node.py'
2017-11-05 21:44:35,305 [salt.fileclient  ][INFO    ][24341] Fetching file from saltenv 'base', ** done ** '_states/jenkins_plugin.py'
2017-11-05 21:44:35,323 [salt.fileclient  ][INFO    ][24341] Fetching file from saltenv 'base', ** done ** '_states/jenkins_security.py'
2017-11-05 21:44:35,348 [salt.fileclient  ][INFO    ][24341] Fetching file from saltenv 'base', ** done ** '_states/jenkins_slack.py'
2017-11-05 21:44:35,367 [salt.fileclient  ][INFO    ][24341] Fetching file from saltenv 'base', ** done ** '_states/jenkins_smtp.py'
2017-11-05 21:44:35,390 [salt.fileclient  ][INFO    ][24341] Fetching file from saltenv 'base', ** done ** '_states/jenkins_theme.py'
2017-11-05 21:44:35,410 [salt.fileclient  ][INFO    ][24341] Fetching file from saltenv 'base', ** done ** '_states/jenkins_user.py'
2017-11-05 21:44:35,429 [salt.fileclient  ][INFO    ][24341] Fetching file from saltenv 'base', ** done ** '_states/jenkins_view.py'
2017-11-05 21:44:35,445 [salt.fileclient  ][INFO    ][24341] Fetching file from saltenv 'base', ** done ** '_states/keystone_policy.py'
2017-11-05 21:44:35,466 [salt.fileclient  ][INFO    ][24341] Fetching file from saltenv 'base', ** done ** '_states/kibana_object.py'
2017-11-05 21:44:35,508 [salt.fileclient  ][INFO    ][24341] Fetching file from saltenv 'base', ** done ** '_states/neutronng.py'
2017-11-05 21:44:35,530 [salt.fileclient  ][INFO    ][24341] Fetching file from saltenv 'base', ** done ** '_states/novang.py'
2017-11-05 21:44:35,547 [salt.fileclient  ][INFO    ][24341] Fetching file from saltenv 'base', ** done ** '_states/reclass.py'
2017-11-05 21:44:35,565 [salt.fileclient  ][INFO    ][24341] Fetching file from saltenv 'base', ** done ** '_states/rundeck_project.py'
2017-11-05 21:44:35,603 [salt.fileclient  ][INFO    ][24341] Fetching file from saltenv 'base', ** done ** '_states/rundeck_scm.py'
2017-11-05 21:44:35,635 [salt.fileclient  ][INFO    ][24341] Fetching file from saltenv 'base', ** done ** '_states/rundeck_secret.py'
2017-11-05 21:44:35,643 [salt.utils.extmods][INFO    ][24341] Copying '/var/cache/salt/minion/files/base/_states/cinderng.py' to '/var/cache/salt/minion/extmods/states/cinderng.py'
2017-11-05 21:44:35,643 [salt.utils.extmods][INFO    ][24341] Copying '/var/cache/salt/minion/files/base/_states/contrail.py' to '/var/cache/salt/minion/extmods/states/contrail.py'
2017-11-05 21:44:35,645 [salt.utils.extmods][INFO    ][24341] Copying '/var/cache/salt/minion/files/base/_states/gerrit.py' to '/var/cache/salt/minion/extmods/states/gerrit.py'
2017-11-05 21:44:35,645 [salt.utils.extmods][INFO    ][24341] Copying '/var/cache/salt/minion/files/base/_states/glanceng.py' to '/var/cache/salt/minion/extmods/states/glanceng.py'
2017-11-05 21:44:35,645 [salt.utils.extmods][INFO    ][24341] Copying '/var/cache/salt/minion/files/base/_states/grafana3_dashboard.py' to '/var/cache/salt/minion/extmods/states/grafana3_dashboard.py'
2017-11-05 21:44:35,646 [salt.utils.extmods][INFO    ][24341] Copying '/var/cache/salt/minion/files/base/_states/grafana3_datasource.py' to '/var/cache/salt/minion/extmods/states/grafana3_datasource.py'
2017-11-05 21:44:35,646 [salt.utils.extmods][INFO    ][24341] Copying '/var/cache/salt/minion/files/base/_states/heat.py' to '/var/cache/salt/minion/extmods/states/heat.py'
2017-11-05 21:44:35,646 [salt.utils.extmods][INFO    ][24341] Copying '/var/cache/salt/minion/files/base/_states/helm_release.py' to '/var/cache/salt/minion/extmods/states/helm_release.py'
2017-11-05 21:44:35,647 [salt.utils.extmods][INFO    ][24341] Copying '/var/cache/salt/minion/files/base/_states/jenkins_approval.py' to '/var/cache/salt/minion/extmods/states/jenkins_approval.py'
2017-11-05 21:44:35,647 [salt.utils.extmods][INFO    ][24341] Copying '/var/cache/salt/minion/files/base/_states/jenkins_artifactory.py' to '/var/cache/salt/minion/extmods/states/jenkins_artifactory.py'
2017-11-05 21:44:35,648 [salt.utils.extmods][INFO    ][24341] Copying '/var/cache/salt/minion/files/base/_states/jenkins_credential.py' to '/var/cache/salt/minion/extmods/states/jenkins_credential.py'
2017-11-05 21:44:35,649 [salt.utils.extmods][INFO    ][24341] Copying '/var/cache/salt/minion/files/base/_states/jenkins_job.py' to '/var/cache/salt/minion/extmods/states/jenkins_job.py'
2017-11-05 21:44:35,649 [salt.utils.extmods][INFO    ][24341] Copying '/var/cache/salt/minion/files/base/_states/jenkins_lib.py' to '/var/cache/salt/minion/extmods/states/jenkins_lib.py'
2017-11-05 21:44:35,649 [salt.utils.extmods][INFO    ][24341] Copying '/var/cache/salt/minion/files/base/_states/jenkins_node.py' to '/var/cache/salt/minion/extmods/states/jenkins_node.py'
2017-11-05 21:44:35,649 [salt.utils.extmods][INFO    ][24341] Copying '/var/cache/salt/minion/files/base/_states/jenkins_plugin.py' to '/var/cache/salt/minion/extmods/states/jenkins_plugin.py'
2017-11-05 21:44:35,650 [salt.utils.extmods][INFO    ][24341] Copying '/var/cache/salt/minion/files/base/_states/jenkins_security.py' to '/var/cache/salt/minion/extmods/states/jenkins_security.py'
2017-11-05 21:44:35,650 [salt.utils.extmods][INFO    ][24341] Copying '/var/cache/salt/minion/files/base/_states/jenkins_slack.py' to '/var/cache/salt/minion/extmods/states/jenkins_slack.py'
2017-11-05 21:44:35,651 [salt.utils.extmods][INFO    ][24341] Copying '/var/cache/salt/minion/files/base/_states/jenkins_smtp.py' to '/var/cache/salt/minion/extmods/states/jenkins_smtp.py'
2017-11-05 21:44:35,652 [salt.utils.extmods][INFO    ][24341] Copying '/var/cache/salt/minion/files/base/_states/jenkins_theme.py' to '/var/cache/salt/minion/extmods/states/jenkins_theme.py'
2017-11-05 21:44:35,652 [salt.utils.extmods][INFO    ][24341] Copying '/var/cache/salt/minion/files/base/_states/jenkins_user.py' to '/var/cache/salt/minion/extmods/states/jenkins_user.py'
2017-11-05 21:44:35,653 [salt.utils.extmods][INFO    ][24341] Copying '/var/cache/salt/minion/files/base/_states/jenkins_view.py' to '/var/cache/salt/minion/extmods/states/jenkins_view.py'
2017-11-05 21:44:35,653 [salt.utils.extmods][INFO    ][24341] Copying '/var/cache/salt/minion/files/base/_states/keystone_policy.py' to '/var/cache/salt/minion/extmods/states/keystone_policy.py'
2017-11-05 21:44:35,653 [salt.utils.extmods][INFO    ][24341] Copying '/var/cache/salt/minion/files/base/_states/kibana_object.py' to '/var/cache/salt/minion/extmods/states/kibana_object.py'
2017-11-05 21:44:35,654 [salt.utils.extmods][INFO    ][24341] Copying '/var/cache/salt/minion/files/base/_states/maas_cluster.py' to '/var/cache/salt/minion/extmods/states/maas_cluster.py'
2017-11-05 21:44:35,654 [salt.utils.extmods][INFO    ][24341] Copying '/var/cache/salt/minion/files/base/_states/neutronng.py' to '/var/cache/salt/minion/extmods/states/neutronng.py'
2017-11-05 21:44:35,654 [salt.utils.extmods][INFO    ][24341] Copying '/var/cache/salt/minion/files/base/_states/novang.py' to '/var/cache/salt/minion/extmods/states/novang.py'
2017-11-05 21:44:35,655 [salt.utils.extmods][INFO    ][24341] Copying '/var/cache/salt/minion/files/base/_states/reclass.py' to '/var/cache/salt/minion/extmods/states/reclass.py'
2017-11-05 21:44:35,655 [salt.utils.extmods][INFO    ][24341] Copying '/var/cache/salt/minion/files/base/_states/rundeck_project.py' to '/var/cache/salt/minion/extmods/states/rundeck_project.py'
2017-11-05 21:44:35,656 [salt.utils.extmods][INFO    ][24341] Copying '/var/cache/salt/minion/files/base/_states/rundeck_scm.py' to '/var/cache/salt/minion/extmods/states/rundeck_scm.py'
2017-11-05 21:44:35,656 [salt.utils.extmods][INFO    ][24341] Copying '/var/cache/salt/minion/files/base/_states/rundeck_secret.py' to '/var/cache/salt/minion/extmods/states/rundeck_secret.py'
2017-11-05 21:44:35,660 [salt.utils.extmods][INFO    ][24341] Creating module dir '/var/cache/salt/minion/extmods/sdb'
2017-11-05 21:44:35,670 [salt.utils.extmods][INFO    ][24341] Syncing sdb for environment 'base'
2017-11-05 21:44:35,671 [salt.utils.extmods][INFO    ][24341] Loading cache from salt://_sdb, for base)
2017-11-05 21:44:35,671 [salt.fileclient  ][INFO    ][24341] Caching directory '_sdb/' for environment 'base'
2017-11-05 21:44:35,738 [salt.utils.extmods][INFO    ][24341] Syncing grains for environment 'base'
2017-11-05 21:44:35,739 [salt.utils.extmods][INFO    ][24341] Loading cache from salt://_grains, for base)
2017-11-05 21:44:35,739 [salt.fileclient  ][INFO    ][24341] Caching directory '_grains/' for environment 'base'
2017-11-05 21:44:35,829 [salt.fileclient  ][INFO    ][24341] Fetching file from saltenv 'base', ** done ** '_grains/ceilometer_policy.py'
2017-11-05 21:44:35,845 [salt.fileclient  ][INFO    ][24341] Fetching file from saltenv 'base', ** done ** '_grains/ceph.py'
2017-11-05 21:44:35,862 [salt.fileclient  ][INFO    ][24341] Fetching file from saltenv 'base', ** done ** '_grains/cinder_policy.py'
2017-11-05 21:44:35,900 [salt.fileclient  ][INFO    ][24341] Fetching file from saltenv 'base', ** done ** '_grains/docker_swarm.py'
2017-11-05 21:44:35,919 [salt.fileclient  ][INFO    ][24341] Fetching file from saltenv 'base', ** done ** '_grains/glance_policy.py'
2017-11-05 21:44:35,949 [salt.fileclient  ][INFO    ][24341] Fetching file from saltenv 'base', ** done ** '_grains/heat_policy.py'
2017-11-05 21:44:35,977 [salt.fileclient  ][INFO    ][24341] Fetching file from saltenv 'base', ** done ** '_grains/jenkins_plugins.py'
2017-11-05 21:44:35,990 [salt.fileclient  ][INFO    ][24341] Fetching file from saltenv 'base', ** done ** '_grains/keystone_policy.py'
2017-11-05 21:44:36,001 [salt.fileclient  ][INFO    ][24341] Fetching file from saltenv 'base', ** done ** '_grains/kubernetes.py'
2017-11-05 21:44:36,039 [salt.fileclient  ][INFO    ][24341] Fetching file from saltenv 'base', ** done ** '_grains/neutron_policy.py'
2017-11-05 21:44:36,081 [salt.fileclient  ][INFO    ][24341] Fetching file from saltenv 'base', ** done ** '_grains/nova_policy.py'
2017-11-05 21:44:36,092 [salt.fileclient  ][INFO    ][24341] Fetching file from saltenv 'base', ** done ** '_grains/ssh_fingerprints.py'
2017-11-05 21:44:36,099 [salt.utils.extmods][INFO    ][24341] Copying '/var/cache/salt/minion/files/base/_grains/ceilometer_policy.py' to '/var/cache/salt/minion/extmods/grains/ceilometer_policy.py'
2017-11-05 21:44:36,100 [salt.utils.extmods][INFO    ][24341] Copying '/var/cache/salt/minion/files/base/_grains/ceph.py' to '/var/cache/salt/minion/extmods/grains/ceph.py'
2017-11-05 21:44:36,100 [salt.utils.extmods][INFO    ][24341] Copying '/var/cache/salt/minion/files/base/_grains/cinder_policy.py' to '/var/cache/salt/minion/extmods/grains/cinder_policy.py'
2017-11-05 21:44:36,101 [salt.utils.extmods][INFO    ][24341] Copying '/var/cache/salt/minion/files/base/_grains/docker_swarm.py' to '/var/cache/salt/minion/extmods/grains/docker_swarm.py'
2017-11-05 21:44:36,101 [salt.utils.extmods][INFO    ][24341] Copying '/var/cache/salt/minion/files/base/_grains/glance_policy.py' to '/var/cache/salt/minion/extmods/grains/glance_policy.py'
2017-11-05 21:44:36,101 [salt.utils.extmods][INFO    ][24341] Copying '/var/cache/salt/minion/files/base/_grains/heat_policy.py' to '/var/cache/salt/minion/extmods/grains/heat_policy.py'
2017-11-05 21:44:36,101 [salt.utils.extmods][INFO    ][24341] Copying '/var/cache/salt/minion/files/base/_grains/jenkins_plugins.py' to '/var/cache/salt/minion/extmods/grains/jenkins_plugins.py'
2017-11-05 21:44:36,102 [salt.utils.extmods][INFO    ][24341] Copying '/var/cache/salt/minion/files/base/_grains/keystone_policy.py' to '/var/cache/salt/minion/extmods/grains/keystone_policy.py'
2017-11-05 21:44:36,102 [salt.utils.extmods][INFO    ][24341] Copying '/var/cache/salt/minion/files/base/_grains/kubernetes.py' to '/var/cache/salt/minion/extmods/grains/kubernetes.py'
2017-11-05 21:44:36,102 [salt.utils.extmods][INFO    ][24341] Copying '/var/cache/salt/minion/files/base/_grains/neutron_policy.py' to '/var/cache/salt/minion/extmods/grains/neutron_policy.py'
2017-11-05 21:44:36,103 [salt.utils.extmods][INFO    ][24341] Copying '/var/cache/salt/minion/files/base/_grains/nova_policy.py' to '/var/cache/salt/minion/extmods/grains/nova_policy.py'
2017-11-05 21:44:36,103 [salt.utils.extmods][INFO    ][24341] Copying '/var/cache/salt/minion/files/base/_grains/ssh_fingerprints.py' to '/var/cache/salt/minion/extmods/grains/ssh_fingerprints.py'
2017-11-05 21:44:36,106 [salt.utils.extmods][INFO    ][24341] Creating module dir '/var/cache/salt/minion/extmods/renderers'
2017-11-05 21:44:36,115 [salt.utils.extmods][INFO    ][24341] Syncing renderers for environment 'base'
2017-11-05 21:44:36,115 [salt.utils.extmods][INFO    ][24341] Loading cache from salt://_renderers, for base)
2017-11-05 21:44:36,115 [salt.fileclient  ][INFO    ][24341] Caching directory '_renderers/' for environment 'base'
2017-11-05 21:44:36,181 [salt.utils.extmods][INFO    ][24341] Creating module dir '/var/cache/salt/minion/extmods/returners'
2017-11-05 21:44:36,185 [salt.utils.extmods][INFO    ][24341] Syncing returners for environment 'base'
2017-11-05 21:44:36,185 [salt.utils.extmods][INFO    ][24341] Loading cache from salt://_returners, for base)
2017-11-05 21:44:36,185 [salt.fileclient  ][INFO    ][24341] Caching directory '_returners/' for environment 'base'
2017-11-05 21:44:36,261 [salt.utils.extmods][INFO    ][24341] Creating module dir '/var/cache/salt/minion/extmods/output'
2017-11-05 21:44:36,266 [salt.utils.extmods][INFO    ][24341] Syncing output for environment 'base'
2017-11-05 21:44:36,267 [salt.utils.extmods][INFO    ][24341] Loading cache from salt://_output, for base)
2017-11-05 21:44:36,267 [salt.fileclient  ][INFO    ][24341] Caching directory '_output/' for environment 'base'
2017-11-05 21:44:36,338 [salt.utils.extmods][INFO    ][24341] Creating module dir '/var/cache/salt/minion/extmods/utils'
2017-11-05 21:44:36,341 [salt.utils.extmods][INFO    ][24341] Syncing utils for environment 'base'
2017-11-05 21:44:36,341 [salt.utils.extmods][INFO    ][24341] Loading cache from salt://_utils, for base)
2017-11-05 21:44:36,342 [salt.fileclient  ][INFO    ][24341] Caching directory '_utils/' for environment 'base'
2017-11-05 21:44:36,381 [salt.utils.extmods][INFO    ][24341] Creating module dir '/var/cache/salt/minion/extmods/log_handlers'
2017-11-05 21:44:36,385 [salt.utils.extmods][INFO    ][24341] Syncing log_handlers for environment 'base'
2017-11-05 21:44:36,385 [salt.utils.extmods][INFO    ][24341] Loading cache from salt://_log_handlers, for base)
2017-11-05 21:44:36,385 [salt.fileclient  ][INFO    ][24341] Caching directory '_log_handlers/' for environment 'base'
2017-11-05 21:44:36,429 [salt.utils.extmods][INFO    ][24341] Creating module dir '/var/cache/salt/minion/extmods/proxy'
2017-11-05 21:44:36,433 [salt.utils.extmods][INFO    ][24341] Syncing proxy for environment 'base'
2017-11-05 21:44:36,434 [salt.utils.extmods][INFO    ][24341] Loading cache from salt://_proxy, for base)
2017-11-05 21:44:36,434 [salt.fileclient  ][INFO    ][24341] Caching directory '_proxy/' for environment 'base'
2017-11-05 21:44:36,476 [salt.utils.extmods][INFO    ][24341] Creating module dir '/var/cache/salt/minion/extmods/engines'
2017-11-05 21:44:36,480 [salt.utils.extmods][INFO    ][24341] Syncing engines for environment 'base'
2017-11-05 21:44:36,480 [salt.utils.extmods][INFO    ][24341] Loading cache from salt://_engines, for base)
2017-11-05 21:44:36,480 [salt.fileclient  ][INFO    ][24341] Caching directory '_engines/' for environment 'base'
2017-11-05 21:44:36,530 [salt.minion      ][INFO    ][24341] Returning information for job: 20171105214429068115
2017-11-05 21:47:03,310 [salt.minion      ][INFO    ][24110] User sudo_ubuntu Executing command test.ping with jid 20171105214703305136
2017-11-05 21:47:03,342 [salt.minion      ][INFO    ][24469] Starting a new job with PID 24469
2017-11-05 21:47:03,392 [salt.minion      ][INFO    ][24469] Returning information for job: 20171105214703305136
2017-11-05 21:48:47,469 [salt.minion      ][INFO    ][24110] User sudo_ubuntu Executing command state.sls with jid 20171105214847459854
2017-11-05 21:48:47,494 [salt.minion      ][INFO    ][24492] Starting a new job with PID 24492
2017-11-05 21:48:48,091 [salt.state       ][INFO    ][24492] Loading fresh modules for state activity
2017-11-05 21:48:48,133 [salt.fileclient  ][INFO    ][24492] Fetching file from saltenv 'base', ** done ** 'keepalived/init.sls'
2017-11-05 21:48:48,193 [salt.fileclient  ][INFO    ][24492] Fetching file from saltenv 'base', ** done ** 'keepalived/cluster.sls'
2017-11-05 21:48:48,231 [salt.fileclient  ][INFO    ][24492] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-11-05 21:48:48,628 [salt.state       ][INFO    ][24492] Running state [lsof] at time 21:48:48.628086
2017-11-05 21:48:48,628 [salt.state       ][INFO    ][24492] Executing state pkg.installed for lsof
2017-11-05 21:48:48,629 [salt.loaded.int.module.cmdmod][INFO    ][24492] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-05 21:48:48,926 [salt.state       ][INFO    ][24492] Package lsof is already installed
2017-11-05 21:48:48,926 [salt.state       ][INFO    ][24492] Completed state [lsof] at time 21:48:48.925811 duration_in_ms=297.724
2017-11-05 21:48:48,926 [salt.state       ][INFO    ][24492] Running state [keepalived] at time 21:48:48.926085
2017-11-05 21:48:48,926 [salt.state       ][INFO    ][24492] Executing state pkg.installed for keepalived
2017-11-05 21:48:48,951 [salt.loaded.int.module.cmdmod][INFO    ][24492] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-11-05 21:48:51,437 [salt.loaded.int.module.cmdmod][INFO    ][24492] 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-05 21:48:55,765 [salt.loaded.int.module.cmdmod][INFO    ][24492] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-05 21:48:55,815 [salt.state       ][INFO    ][24492] 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-05 21:48:55,830 [salt.state       ][INFO    ][24492] Loading fresh modules for state activity
2017-11-05 21:48:55,850 [salt.state       ][INFO    ][24492] Completed state [keepalived] at time 21:48:55.849977 duration_in_ms=6923.891
2017-11-05 21:48:55,853 [salt.state       ][INFO    ][24492] Running state [/etc/keepalived/keepalived.conf] at time 21:48:55.852746
2017-11-05 21:48:55,853 [salt.state       ][INFO    ][24492] Executing state file.managed for /etc/keepalived/keepalived.conf
2017-11-05 21:48:55,890 [salt.fileclient  ][INFO    ][24492] Fetching file from saltenv 'base', ** done ** 'keepalived/files/keepalived.conf'
2017-11-05 21:48:55,949 [salt.fileclient  ][INFO    ][24492] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-11-05 21:48:55,967 [salt.state       ][INFO    ][24492] File changed:
New file
2017-11-05 21:48:55,967 [salt.state       ][INFO    ][24492] Completed state [/etc/keepalived/keepalived.conf] at time 21:48:55.967274 duration_in_ms=114.528
2017-11-05 21:48:56,101 [salt.state       ][INFO    ][24492] Running state [keepalived] at time 21:48:56.100825
2017-11-05 21:48:56,101 [salt.state       ][INFO    ][24492] Executing state service.running for keepalived
2017-11-05 21:48:56,104 [salt.loaded.int.module.cmdmod][INFO    ][24492] Executing command ['systemctl', 'status', 'keepalived.service', '-n', '0'] in directory '/root'
2017-11-05 21:48:56,128 [salt.loaded.int.module.cmdmod][INFO    ][24492] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2017-11-05 21:48:56,152 [salt.loaded.int.module.cmdmod][INFO    ][24492] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-11-05 21:48:56,171 [salt.loaded.int.module.cmdmod][INFO    ][24492] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-11-05 21:48:56,195 [salt.loaded.int.module.cmdmod][INFO    ][24492] Executing command ['systemd-run', '--scope', 'systemctl', 'start', 'keepalived.service'] in directory '/root'
2017-11-05 21:48:56,267 [salt.loaded.int.module.cmdmod][INFO    ][24492] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2017-11-05 21:48:56,291 [salt.loaded.int.module.cmdmod][INFO    ][24492] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-11-05 21:48:56,311 [salt.loaded.int.module.cmdmod][INFO    ][24492] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-11-05 21:48:56,329 [salt.state       ][INFO    ][24492] {'keepalived': True}
2017-11-05 21:48:56,329 [salt.state       ][INFO    ][24492] Completed state [keepalived] at time 21:48:56.329314 duration_in_ms=228.49
2017-11-05 21:48:56,331 [salt.minion      ][INFO    ][24492] Returning information for job: 20171105214847459854
2017-11-05 21:49:12,639 [salt.minion      ][INFO    ][24110] User sudo_ubuntu Executing command pillar.get with jid 20171105214912632103
2017-11-05 21:49:12,670 [salt.minion      ][INFO    ][26065] Starting a new job with PID 26065
2017-11-05 21:49:12,679 [salt.minion      ][INFO    ][26065] Returning information for job: 20171105214912632103
2017-11-05 21:54:16,918 [salt.minion      ][INFO    ][24110] User sudo_ubuntu Executing command state.sls with jid 20171105215416909976
2017-11-05 21:54:16,947 [salt.minion      ][INFO    ][26136] Starting a new job with PID 26136
2017-11-05 21:54:19,625 [salt.state       ][INFO    ][26136] Loading fresh modules for state activity
2017-11-05 21:54:19,658 [salt.fileclient  ][INFO    ][26136] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-11-05 21:54:19,697 [salt.fileclient  ][INFO    ][26136] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-11-05 21:54:20,055 [salt.state       ][INFO    ][26136] Running state [attr] at time 21:54:20.054859
2017-11-05 21:54:20,055 [salt.state       ][INFO    ][26136] Executing state pkg.installed for attr
2017-11-05 21:54:20,056 [salt.loaded.int.module.cmdmod][INFO    ][26136] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-05 21:54:20,379 [salt.loaded.int.module.cmdmod][INFO    ][26136] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-11-05 21:54:22,914 [salt.loaded.int.module.cmdmod][INFO    ][26136] 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-05 21:54:24,878 [salt.loaded.int.module.cmdmod][INFO    ][26136] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-05 21:54:24,933 [salt.state       ][INFO    ][26136] Made the following changes:
'attr' changed from 'absent' to '1:2.4.47-2'

2017-11-05 21:54:24,946 [salt.state       ][INFO    ][26136] Loading fresh modules for state activity
2017-11-05 21:54:24,1000 [salt.state       ][INFO    ][26136] Completed state [attr] at time 21:54:24.999474 duration_in_ms=4944.616
2017-11-05 21:54:25,010 [salt.state       ][INFO    ][26136] Running state [glusterfs-server] at time 21:54:25.010215
2017-11-05 21:54:25,011 [salt.state       ][INFO    ][26136] Executing state pkg.installed for glusterfs-server
2017-11-05 21:54:25,338 [salt.loaded.int.module.cmdmod][INFO    ][26136] 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-05 21:54:27,023 [salt.minion      ][INFO    ][24110] User sudo_ubuntu Executing command saltutil.find_job with jid 20171105215427013319
2017-11-05 21:54:27,052 [salt.minion      ][INFO    ][27205] Starting a new job with PID 27205
2017-11-05 21:54:27,074 [salt.minion      ][INFO    ][27205] Returning information for job: 20171105215427013319
2017-11-05 21:54:36,003 [salt.loaded.int.module.cmdmod][INFO    ][26136] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-05 21:54:36,058 [salt.state       ][INFO    ][26136] 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-05 21:54:36,073 [salt.state       ][INFO    ][26136] Loading fresh modules for state activity
2017-11-05 21:54:36,093 [salt.state       ][INFO    ][26136] Completed state [glusterfs-server] at time 21:54:36.092810 duration_in_ms=11082.595
2017-11-05 21:54:36,099 [salt.state       ][INFO    ][26136] Running state [bc] at time 21:54:36.099088
2017-11-05 21:54:36,099 [salt.state       ][INFO    ][26136] Executing state pkg.installed for bc
2017-11-05 21:54:36,431 [salt.loaded.int.module.cmdmod][INFO    ][26136] 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-05 21:54:37,138 [salt.minion      ][INFO    ][24110] User sudo_ubuntu Executing command saltutil.find_job with jid 20171105215437130964
2017-11-05 21:54:37,162 [salt.minion      ][INFO    ][30495] Starting a new job with PID 30495
2017-11-05 21:54:37,185 [salt.minion      ][INFO    ][30495] Returning information for job: 20171105215437130964
2017-11-05 21:54:38,768 [salt.loaded.int.module.cmdmod][INFO    ][26136] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-05 21:54:38,819 [salt.state       ][INFO    ][26136] Made the following changes:
'bc' changed from 'absent' to '1.06.95-9build1'

2017-11-05 21:54:38,830 [salt.state       ][INFO    ][26136] Loading fresh modules for state activity
2017-11-05 21:54:38,887 [salt.state       ][INFO    ][26136] Completed state [bc] at time 21:54:38.887299 duration_in_ms=2788.21
2017-11-05 21:54:38,970 [salt.state       ][INFO    ][26136] Running state [glusterfs-server] at time 21:54:38.969863
2017-11-05 21:54:38,970 [salt.state       ][INFO    ][26136] Executing state service.running for glusterfs-server
2017-11-05 21:54:38,973 [salt.loaded.int.module.cmdmod][INFO    ][26136] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-11-05 21:54:38,989 [salt.loaded.int.module.cmdmod][INFO    ][26136] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-11-05 21:54:39,002 [salt.loaded.int.module.cmdmod][INFO    ][26136] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-11-05 21:54:39,021 [salt.state       ][INFO    ][26136] The service glusterfs-server is already running
2017-11-05 21:54:39,022 [salt.state       ][INFO    ][26136] Completed state [glusterfs-server] at time 21:54:39.021718 duration_in_ms=51.853
2017-11-05 21:54:39,025 [salt.state       ][INFO    ][26136] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 21:54:39.025346
2017-11-05 21:54:39,026 [salt.state       ][INFO    ][26136] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-11-05 21:54:39,035 [salt.state       ][INFO    ][26136] File changed:
New file
2017-11-05 21:54:39,036 [salt.state       ][INFO    ][26136] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 21:54:39.035481 duration_in_ms=10.136
2017-11-05 21:54:39,036 [salt.state       ][INFO    ][26136] Running state [/srv/glusterfs/glance] at time 21:54:39.035677
2017-11-05 21:54:39,037 [salt.state       ][INFO    ][26136] Executing state file.directory for /srv/glusterfs/glance
2017-11-05 21:54:39,038 [salt.state       ][INFO    ][26136] {'/srv/glusterfs/glance': 'New Dir'}
2017-11-05 21:54:39,038 [salt.state       ][INFO    ][26136] Completed state [/srv/glusterfs/glance] at time 21:54:39.038096 duration_in_ms=2.419
2017-11-05 21:54:39,038 [salt.state       ][INFO    ][26136] Running state [/srv/glusterfs/keystone-keys] at time 21:54:39.038287
2017-11-05 21:54:39,038 [salt.state       ][INFO    ][26136] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-11-05 21:54:39,039 [salt.state       ][INFO    ][26136] {'/srv/glusterfs/keystone-keys': 'New Dir'}
2017-11-05 21:54:39,039 [salt.state       ][INFO    ][26136] Completed state [/srv/glusterfs/keystone-keys] at time 21:54:39.039089 duration_in_ms=0.802
2017-11-05 21:54:39,039 [salt.state       ][INFO    ][26136] Running state [/srv/glusterfs/nova_instances] at time 21:54:39.039264
2017-11-05 21:54:39,039 [salt.state       ][INFO    ][26136] Executing state file.directory for /srv/glusterfs/nova_instances
2017-11-05 21:54:39,042 [salt.state       ][INFO    ][26136] {'/srv/glusterfs/nova_instances': 'New Dir'}
2017-11-05 21:54:39,043 [salt.state       ][INFO    ][26136] Completed state [/srv/glusterfs/nova_instances] at time 21:54:39.042498 duration_in_ms=3.234
2017-11-05 21:54:39,043 [salt.state       ][INFO    ][26136] Running state [/srv/glusterfs/keystone-credential-keys] at time 21:54:39.042699
2017-11-05 21:54:39,043 [salt.state       ][INFO    ][26136] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-11-05 21:54:39,043 [salt.state       ][INFO    ][26136] {'/srv/glusterfs/keystone-credential-keys': 'New Dir'}
2017-11-05 21:54:39,044 [salt.state       ][INFO    ][26136] Completed state [/srv/glusterfs/keystone-credential-keys] at time 21:54:39.043518 duration_in_ms=0.82
2017-11-05 21:54:39,045 [salt.minion      ][INFO    ][26136] Returning information for job: 20171105215416909976
2017-11-05 21:54:40,097 [salt.minion      ][INFO    ][24110] User sudo_ubuntu Executing command test.ping with jid 20171105215440089048
2017-11-05 21:54:40,120 [salt.minion      ][INFO    ][30900] Starting a new job with PID 30900
2017-11-05 21:54:40,166 [salt.minion      ][INFO    ][30900] Returning information for job: 20171105215440089048
2017-11-05 21:54:40,290 [salt.minion      ][INFO    ][24110] User sudo_ubuntu Executing command state.sls with jid 20171105215440281475
2017-11-05 21:54:40,310 [salt.minion      ][INFO    ][30905] Starting a new job with PID 30905
2017-11-05 21:54:42,468 [salt.state       ][INFO    ][30905] Loading fresh modules for state activity
2017-11-05 21:54:42,503 [salt.fileclient  ][INFO    ][30905] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/setup.sls'
2017-11-05 21:54:42,554 [salt.fileclient  ][INFO    ][30905] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-11-05 21:54:42,650 [salt.fileclient  ][INFO    ][30905] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-11-05 21:54:42,680 [salt.fileclient  ][INFO    ][30905] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-11-05 21:54:43,032 [salt.state       ][INFO    ][30905] Running state [attr] at time 21:54:43.031687
2017-11-05 21:54:43,033 [salt.state       ][INFO    ][30905] Executing state pkg.installed for attr
2017-11-05 21:54:43,034 [salt.loaded.int.module.cmdmod][INFO    ][30905] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-05 21:54:43,332 [salt.state       ][INFO    ][30905] Package attr is already installed
2017-11-05 21:54:43,332 [salt.state       ][INFO    ][30905] Completed state [attr] at time 21:54:43.331798 duration_in_ms=300.111
2017-11-05 21:54:43,332 [salt.state       ][INFO    ][30905] Running state [glusterfs-server] at time 21:54:43.332028
2017-11-05 21:54:43,332 [salt.state       ][INFO    ][30905] Executing state pkg.installed for glusterfs-server
2017-11-05 21:54:43,336 [salt.state       ][INFO    ][30905] Package glusterfs-server is already installed
2017-11-05 21:54:43,336 [salt.state       ][INFO    ][30905] Completed state [glusterfs-server] at time 21:54:43.335916 duration_in_ms=3.887
2017-11-05 21:54:43,336 [salt.state       ][INFO    ][30905] Running state [bc] at time 21:54:43.336078
2017-11-05 21:54:43,336 [salt.state       ][INFO    ][30905] Executing state pkg.installed for bc
2017-11-05 21:54:43,340 [salt.state       ][INFO    ][30905] Package bc is already installed
2017-11-05 21:54:43,340 [salt.state       ][INFO    ][30905] Completed state [bc] at time 21:54:43.339870 duration_in_ms=3.792
2017-11-05 21:54:43,341 [salt.state       ][INFO    ][30905] Running state [glusterfs-server] at time 21:54:43.340846
2017-11-05 21:54:43,341 [salt.state       ][INFO    ][30905] Executing state service.running for glusterfs-server
2017-11-05 21:54:43,341 [salt.loaded.int.module.cmdmod][INFO    ][30905] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-11-05 21:54:43,362 [salt.loaded.int.module.cmdmod][INFO    ][30905] Executing command ['systemctl', '--system', 'daemon-reload'] in directory '/root'
2017-11-05 21:54:43,467 [salt.loaded.int.module.cmdmod][INFO    ][30905] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-11-05 21:54:43,498 [salt.loaded.int.module.cmdmod][INFO    ][30905] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-11-05 21:54:43,513 [salt.loaded.int.module.cmdmod][INFO    ][30905] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-11-05 21:54:43,536 [salt.state       ][INFO    ][30905] The service glusterfs-server is already running
2017-11-05 21:54:43,537 [salt.state       ][INFO    ][30905] Completed state [glusterfs-server] at time 21:54:43.536595 duration_in_ms=195.746
2017-11-05 21:54:43,542 [salt.state       ][INFO    ][30905] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 21:54:43.541693
2017-11-05 21:54:43,542 [salt.state       ][INFO    ][30905] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-11-05 21:54:43,547 [salt.state       ][INFO    ][30905] File /etc/systemd/system/glusterfs-server.service.d/override.conf is in the correct state
2017-11-05 21:54:43,547 [salt.state       ][INFO    ][30905] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 21:54:43.546740 duration_in_ms=5.048
2017-11-05 21:54:43,547 [salt.state       ][INFO    ][30905] Running state [/srv/glusterfs/glance] at time 21:54:43.547058
2017-11-05 21:54:43,547 [salt.state       ][INFO    ][30905] Executing state file.directory for /srv/glusterfs/glance
2017-11-05 21:54:43,549 [salt.state       ][INFO    ][30905] Directory /srv/glusterfs/glance is in the correct state
2017-11-05 21:54:43,549 [salt.state       ][INFO    ][30905] Completed state [/srv/glusterfs/glance] at time 21:54:43.549210 duration_in_ms=2.151
2017-11-05 21:54:43,550 [salt.state       ][INFO    ][30905] Running state [/srv/glusterfs/keystone-keys] at time 21:54:43.549514
2017-11-05 21:54:43,550 [salt.state       ][INFO    ][30905] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-11-05 21:54:43,551 [salt.state       ][INFO    ][30905] Directory /srv/glusterfs/keystone-keys is in the correct state
2017-11-05 21:54:43,551 [salt.state       ][INFO    ][30905] Completed state [/srv/glusterfs/keystone-keys] at time 21:54:43.550731 duration_in_ms=1.217
2017-11-05 21:54:43,551 [salt.state       ][INFO    ][30905] Running state [/srv/glusterfs/nova_instances] at time 21:54:43.551374
2017-11-05 21:54:43,552 [salt.state       ][INFO    ][30905] Executing state file.directory for /srv/glusterfs/nova_instances
2017-11-05 21:54:43,553 [salt.state       ][INFO    ][30905] Directory /srv/glusterfs/nova_instances is in the correct state
2017-11-05 21:54:43,554 [salt.state       ][INFO    ][30905] Completed state [/srv/glusterfs/nova_instances] at time 21:54:43.553526 duration_in_ms=2.152
2017-11-05 21:54:43,554 [salt.state       ][INFO    ][30905] Running state [/srv/glusterfs/keystone-credential-keys] at time 21:54:43.553722
2017-11-05 21:54:43,554 [salt.state       ][INFO    ][30905] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-11-05 21:54:43,554 [salt.state       ][INFO    ][30905] Directory /srv/glusterfs/keystone-credential-keys is in the correct state
2017-11-05 21:54:43,554 [salt.state       ][INFO    ][30905] Completed state [/srv/glusterfs/keystone-credential-keys] at time 21:54:43.554447 duration_in_ms=0.724
2017-11-05 21:54:43,629 [salt.loaded.int.module.cmdmod][INFO    ][30905] Executing command ['git', '--version'] in directory '/root'
2017-11-05 21:54:43,771 [salt.state       ][INFO    ][30905] Running state [sleep 5] at time 21:54:43.771357
2017-11-05 21:54:43,772 [salt.state       ][INFO    ][30905] Executing state cmd.wait for sleep 5
2017-11-05 21:54:43,772 [salt.state       ][INFO    ][30905] No changes made for sleep 5
2017-11-05 21:54:43,772 [salt.state       ][INFO    ][30905] Completed state [sleep 5] at time 21:54:43.772111 duration_in_ms=0.755
2017-11-05 21:54:43,773 [salt.state       ][INFO    ][30905] Running state [192.168.10.143] at time 21:54:43.773020
2017-11-05 21:54:43,773 [salt.state       ][INFO    ][30905] Executing state glusterfs.peered for 192.168.10.143
2017-11-05 21:54:43,774 [salt.loaded.int.module.cmdmod][INFO    ][30905] Executing command 'gluster --version' in directory '/root'
2017-11-05 21:54:43,789 [salt.loaded.int.module.cmdmod][INFO    ][30905] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-05 21:54:43,868 [salt.loaded.int.module.cmdmod][INFO    ][30905] Executing command 'gluster --version' in directory '/root'
2017-11-05 21:54:43,890 [salt.loaded.int.module.cmdmod][INFO    ][30905] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-05 21:54:43,993 [salt.loaded.int.module.cmdmod][INFO    ][30905] Executing command 'gluster --version' in directory '/root'
2017-11-05 21:54:44,015 [salt.loaded.int.module.cmdmod][INFO    ][30905] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-05 21:54:44,102 [salt.loaded.int.module.cmdmod][INFO    ][30905] Executing command 'gluster --version' in directory '/root'
2017-11-05 21:54:44,123 [salt.loaded.int.module.cmdmod][INFO    ][30905] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-05 21:54:44,194 [salt.state       ][INFO    ][30905] {'new': {'192.168.10.143': []}, 'old': None}
2017-11-05 21:54:44,195 [salt.state       ][INFO    ][30905] Completed state [192.168.10.143] at time 21:54:44.194551 duration_in_ms=421.529
2017-11-05 21:54:44,203 [salt.state       ][INFO    ][30905] Running state [192.168.10.142] at time 21:54:44.203206
2017-11-05 21:54:44,204 [salt.state       ][INFO    ][30905] Executing state glusterfs.peered for 192.168.10.142
2017-11-05 21:54:44,205 [salt.loaded.int.module.cmdmod][INFO    ][30905] Executing command 'gluster --version' in directory '/root'
2017-11-05 21:54:44,222 [salt.loaded.int.module.cmdmod][INFO    ][30905] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-05 21:54:44,301 [salt.loaded.int.module.cmdmod][INFO    ][30905] Executing command 'gluster --version' in directory '/root'
2017-11-05 21:54:44,320 [salt.loaded.int.module.cmdmod][INFO    ][30905] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-05 21:54:44,405 [salt.loaded.int.module.cmdmod][INFO    ][30905] Executing command 'gluster --version' in directory '/root'
2017-11-05 21:54:44,425 [salt.loaded.int.module.cmdmod][INFO    ][30905] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-05 21:54:44,507 [salt.loaded.int.module.cmdmod][INFO    ][30905] Executing command 'gluster --version' in directory '/root'
2017-11-05 21:54:44,524 [salt.loaded.int.module.cmdmod][INFO    ][30905] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-05 21:54:44,597 [salt.state       ][INFO    ][30905] Peering with localhost is not needed
2017-11-05 21:54:44,598 [salt.state       ][INFO    ][30905] Completed state [192.168.10.142] at time 21:54:44.597682 duration_in_ms=394.463
2017-11-05 21:54:44,606 [salt.state       ][INFO    ][30905] Running state [192.168.10.141] at time 21:54:44.605566
2017-11-05 21:54:44,606 [salt.state       ][INFO    ][30905] Executing state glusterfs.peered for 192.168.10.141
2017-11-05 21:54:44,607 [salt.loaded.int.module.cmdmod][INFO    ][30905] Executing command 'gluster --version' in directory '/root'
2017-11-05 21:54:44,625 [salt.loaded.int.module.cmdmod][INFO    ][30905] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-05 21:54:44,709 [salt.loaded.int.module.cmdmod][INFO    ][30905] Executing command 'gluster --version' in directory '/root'
2017-11-05 21:54:44,726 [salt.loaded.int.module.cmdmod][INFO    ][30905] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-05 21:54:44,823 [salt.loaded.int.module.cmdmod][INFO    ][30905] Executing command 'gluster --version' in directory '/root'
2017-11-05 21:54:44,848 [salt.loaded.int.module.cmdmod][INFO    ][30905] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-05 21:54:44,931 [salt.loaded.int.module.cmdmod][INFO    ][30905] Executing command 'gluster --version' in directory '/root'
2017-11-05 21:54:44,948 [salt.loaded.int.module.cmdmod][INFO    ][30905] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-05 21:54:45,031 [salt.state       ][INFO    ][30905] {'new': {'192.168.10.143': [], '192.168.10.141': []}, 'old': {'192.168.10.143': []}}
2017-11-05 21:54:45,032 [salt.state       ][INFO    ][30905] Completed state [192.168.10.141] at time 21:54:45.031571 duration_in_ms=426.003
2017-11-05 21:54:45,035 [salt.state       ][INFO    ][30905] Running state [glance] at time 21:54:45.034539
2017-11-05 21:54:45,035 [salt.state       ][INFO    ][30905] Executing state glusterfs.created for glance
2017-11-05 21:54:45,037 [salt.loaded.int.module.cmdmod][INFO    ][30905] Executing command 'gluster --version' in directory '/root'
2017-11-05 21:54:45,055 [salt.loaded.int.module.cmdmod][INFO    ][30905] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-05 21:54:45,141 [salt.loaded.int.module.cmdmod][INFO    ][30905] Executing command 'gluster --version' in directory '/root'
2017-11-05 21:54:45,157 [salt.loaded.int.module.cmdmod][INFO    ][30905] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-05 21:54:45,273 [salt.loaded.int.module.cmdmod][INFO    ][30905] Executing command 'gluster --version' in directory '/root'
2017-11-05 21:54:45,295 [salt.loaded.int.module.cmdmod][INFO    ][30905] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-05 21:54:45,794 [salt.loaded.int.module.cmdmod][INFO    ][30905] Executing command 'gluster --version' in directory '/root'
2017-11-05 21:54:45,815 [salt.loaded.int.module.cmdmod][INFO    ][30905] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-05 21:54:45,893 [salt.state       ][INFO    ][30905] {'new': ['glance'], 'old': []}
2017-11-05 21:54:45,894 [salt.state       ][INFO    ][30905] Completed state [glance] at time 21:54:45.893967 duration_in_ms=859.425
2017-11-05 21:54:45,904 [salt.state       ][INFO    ][30905] Running state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 21:54:45.903550
2017-11-05 21:54:45,905 [salt.state       ][INFO    ][30905] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'
2017-11-05 21:54:45,906 [salt.loaded.int.module.cmdmod][INFO    ][30905] Executing command 'gluster volume info 'glance' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-11-05 21:54:45,988 [salt.loaded.int.module.cmdmod][INFO    ][30905] Executing command 'gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'' in directory '/root'
2017-11-05 21:54:46,147 [salt.state       ][INFO    ][30905] {'pid': 31128, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-11-05 21:54:46,149 [salt.state       ][INFO    ][30905] Completed state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 21:54:46.148435 duration_in_ms=244.883
2017-11-05 21:54:46,150 [salt.state       ][INFO    ][30905] Running state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 21:54:46.149663
2017-11-05 21:54:46,150 [salt.state       ][INFO    ][30905] Executing state cmd.run for gluster volume set 'glance' 'network.remote-dio' 'True'
2017-11-05 21:54:46,151 [salt.loaded.int.module.cmdmod][INFO    ][30905] Executing command 'gluster volume info 'glance' | grep 'network.remote-dio: True'' in directory '/root'
2017-11-05 21:54:46,234 [salt.loaded.int.module.cmdmod][INFO    ][30905] Executing command 'gluster volume set 'glance' 'network.remote-dio' 'True'' in directory '/root'
2017-11-05 21:54:46,402 [salt.state       ][INFO    ][30905] {'pid': 31146, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-11-05 21:54:46,403 [salt.state       ][INFO    ][30905] Completed state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 21:54:46.402660 duration_in_ms=252.996
2017-11-05 21:54:46,405 [salt.state       ][INFO    ][30905] Running state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 21:54:46.404924
2017-11-05 21:54:46,406 [salt.state       ][INFO    ][30905] Executing state cmd.run for gluster volume set 'glance' 'nfs.disable' 'True'
2017-11-05 21:54:46,407 [salt.loaded.int.module.cmdmod][INFO    ][30905] Executing command 'gluster volume info 'glance' | grep 'nfs.disable: True'' in directory '/root'
2017-11-05 21:54:46,492 [salt.loaded.int.module.cmdmod][INFO    ][30905] Executing command 'gluster volume set 'glance' 'nfs.disable' 'True'' in directory '/root'
2017-11-05 21:54:48,653 [salt.state       ][INFO    ][30905] {'pid': 31164, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-11-05 21:54:48,654 [salt.state       ][INFO    ][30905] Completed state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 21:54:48.653966 duration_in_ms=2249.041
2017-11-05 21:54:48,656 [salt.state       ][INFO    ][30905] Running state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 21:54:48.655682
2017-11-05 21:54:48,656 [salt.state       ][INFO    ][30905] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'
2017-11-05 21:54:48,658 [salt.loaded.int.module.cmdmod][INFO    ][30905] Executing command 'gluster volume info 'glance' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-11-05 21:54:48,749 [salt.loaded.int.module.cmdmod][INFO    ][30905] Executing command 'gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'' in directory '/root'
2017-11-05 21:54:48,893 [salt.state       ][INFO    ][30905] {'pid': 31181, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-11-05 21:54:48,894 [salt.state       ][INFO    ][30905] Completed state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 21:54:48.893857 duration_in_ms=238.175
2017-11-05 21:54:48,895 [salt.state       ][INFO    ][30905] Running state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 21:54:48.895114
2017-11-05 21:54:48,896 [salt.state       ][INFO    ][30905] Executing state cmd.run for gluster volume set 'glance' 'cluster.readdir-optimize' 'True'
2017-11-05 21:54:48,897 [salt.loaded.int.module.cmdmod][INFO    ][30905] Executing command 'gluster volume info 'glance' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-11-05 21:54:48,983 [salt.loaded.int.module.cmdmod][INFO    ][30905] Executing command 'gluster volume set 'glance' 'cluster.readdir-optimize' 'True'' in directory '/root'
2017-11-05 21:54:49,130 [salt.state       ][INFO    ][30905] {'pid': 31198, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-11-05 21:54:49,131 [salt.state       ][INFO    ][30905] Completed state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 21:54:49.130604 duration_in_ms=235.489
2017-11-05 21:54:49,135 [salt.state       ][INFO    ][30905] Running state [glance] at time 21:54:49.134862
2017-11-05 21:54:49,135 [salt.state       ][INFO    ][30905] Executing state glusterfs.started for glance
2017-11-05 21:54:49,138 [salt.loaded.int.module.cmdmod][INFO    ][30905] Executing command 'gluster --version' in directory '/root'
2017-11-05 21:54:49,155 [salt.loaded.int.module.cmdmod][INFO    ][30905] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-05 21:54:49,234 [salt.loaded.int.module.cmdmod][INFO    ][30905] Executing command 'gluster --version' in directory '/root'
2017-11-05 21:54:49,253 [salt.loaded.int.module.cmdmod][INFO    ][30905] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-05 21:54:49,346 [salt.state       ][INFO    ][30905] Volume glance is already started
2017-11-05 21:54:49,347 [salt.state       ][INFO    ][30905] Completed state [glance] at time 21:54:49.346926 duration_in_ms=212.065
2017-11-05 21:54:49,351 [salt.state       ][INFO    ][30905] Running state [keystone-keys] at time 21:54:49.351094
2017-11-05 21:54:49,352 [salt.state       ][INFO    ][30905] Executing state glusterfs.created for keystone-keys
2017-11-05 21:54:49,354 [salt.loaded.int.module.cmdmod][INFO    ][30905] Executing command 'gluster --version' in directory '/root'
2017-11-05 21:54:49,375 [salt.loaded.int.module.cmdmod][INFO    ][30905] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-05 21:54:49,457 [salt.loaded.int.module.cmdmod][INFO    ][30905] Executing command 'gluster --version' in directory '/root'
2017-11-05 21:54:49,478 [salt.loaded.int.module.cmdmod][INFO    ][30905] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-05 21:54:49,593 [salt.loaded.int.module.cmdmod][INFO    ][30905] Executing command 'gluster --version' in directory '/root'
2017-11-05 21:54:49,613 [salt.loaded.int.module.cmdmod][INFO    ][30905] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-05 21:54:50,359 [salt.minion      ][INFO    ][24110] User sudo_ubuntu Executing command saltutil.find_job with jid 20171105215450349095
2017-11-05 21:54:50,389 [salt.minion      ][INFO    ][31277] Starting a new job with PID 31277
2017-11-05 21:54:50,405 [salt.minion      ][INFO    ][31277] Returning information for job: 20171105215450349095
2017-11-05 21:54:51,840 [salt.loaded.int.module.cmdmod][INFO    ][30905] Executing command 'gluster --version' in directory '/root'
2017-11-05 21:54:51,865 [salt.loaded.int.module.cmdmod][INFO    ][30905] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-05 21:54:51,943 [salt.state       ][INFO    ][30905] {'new': ['glance', 'keystone-keys'], 'old': ['glance']}
2017-11-05 21:54:51,943 [salt.state       ][INFO    ][30905] Completed state [keystone-keys] at time 21:54:51.942869 duration_in_ms=2591.774
2017-11-05 21:54:51,951 [salt.state       ][INFO    ][30905] Running state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 21:54:51.951314
2017-11-05 21:54:51,954 [salt.state       ][INFO    ][30905] Executing state cmd.run for gluster volume set 'keystone-keys' 'network.remote-dio' 'True'
2017-11-05 21:54:51,954 [salt.loaded.int.module.cmdmod][INFO    ][30905] Executing command 'gluster volume info 'keystone-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-11-05 21:54:52,041 [salt.loaded.int.module.cmdmod][INFO    ][30905] Executing command 'gluster volume set 'keystone-keys' 'network.remote-dio' 'True'' in directory '/root'
2017-11-05 21:54:52,202 [salt.state       ][INFO    ][30905] {'pid': 31317, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-11-05 21:54:52,203 [salt.state       ][INFO    ][30905] Completed state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 21:54:52.202571 duration_in_ms=251.256
2017-11-05 21:54:52,205 [salt.state       ][INFO    ][30905] Running state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 21:54:52.203745
2017-11-05 21:54:52,205 [salt.state       ][INFO    ][30905] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-11-05 21:54:52,206 [salt.loaded.int.module.cmdmod][INFO    ][30905] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-11-05 21:54:52,298 [salt.loaded.int.module.cmdmod][INFO    ][30905] Executing command 'gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'' in directory '/root'
2017-11-05 21:54:52,455 [salt.state       ][INFO    ][30905] {'pid': 31334, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-11-05 21:54:52,457 [salt.state       ][INFO    ][30905] Completed state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 21:54:52.456357 duration_in_ms=252.611
2017-11-05 21:54:52,458 [salt.state       ][INFO    ][30905] Running state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 21:54:52.457890
2017-11-05 21:54:52,458 [salt.state       ][INFO    ][30905] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'
2017-11-05 21:54:52,460 [salt.loaded.int.module.cmdmod][INFO    ][30905] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-11-05 21:54:52,545 [salt.loaded.int.module.cmdmod][INFO    ][30905] Executing command 'gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'' in directory '/root'
2017-11-05 21:54:52,708 [salt.state       ][INFO    ][30905] {'pid': 31352, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-11-05 21:54:52,709 [salt.state       ][INFO    ][30905] Completed state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 21:54:52.709078 duration_in_ms=251.187
2017-11-05 21:54:52,710 [salt.state       ][INFO    ][30905] Running state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 21:54:52.710215
2017-11-05 21:54:52,711 [salt.state       ][INFO    ][30905] Executing state cmd.run for gluster volume set 'keystone-keys' 'nfs.disable' 'True'
2017-11-05 21:54:52,713 [salt.loaded.int.module.cmdmod][INFO    ][30905] Executing command 'gluster volume info 'keystone-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-11-05 21:54:52,801 [salt.loaded.int.module.cmdmod][INFO    ][30905] Executing command 'gluster volume set 'keystone-keys' 'nfs.disable' 'True'' in directory '/root'
2017-11-05 21:54:54,967 [salt.state       ][INFO    ][30905] {'pid': 31369, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-11-05 21:54:54,968 [salt.state       ][INFO    ][30905] Completed state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 21:54:54.967572 duration_in_ms=2257.355
2017-11-05 21:54:54,970 [salt.state       ][INFO    ][30905] Running state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 21:54:54.969595
2017-11-05 21:54:54,970 [salt.state       ][INFO    ][30905] Executing state cmd.run for gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'
2017-11-05 21:54:54,971 [salt.loaded.int.module.cmdmod][INFO    ][30905] Executing command 'gluster volume info 'keystone-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-11-05 21:54:55,067 [salt.loaded.int.module.cmdmod][INFO    ][30905] Executing command 'gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'' in directory '/root'
2017-11-05 21:54:55,217 [salt.state       ][INFO    ][30905] {'pid': 31386, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-11-05 21:54:55,218 [salt.state       ][INFO    ][30905] Completed state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 21:54:55.217956 duration_in_ms=248.36
2017-11-05 21:54:55,221 [salt.state       ][INFO    ][30905] Running state [keystone-keys] at time 21:54:55.221021
2017-11-05 21:54:55,222 [salt.state       ][INFO    ][30905] Executing state glusterfs.started for keystone-keys
2017-11-05 21:54:55,223 [salt.loaded.int.module.cmdmod][INFO    ][30905] Executing command 'gluster --version' in directory '/root'
2017-11-05 21:54:55,245 [salt.loaded.int.module.cmdmod][INFO    ][30905] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-05 21:54:55,323 [salt.loaded.int.module.cmdmod][INFO    ][30905] Executing command 'gluster --version' in directory '/root'
2017-11-05 21:54:55,342 [salt.loaded.int.module.cmdmod][INFO    ][30905] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-05 21:54:55,439 [salt.state       ][INFO    ][30905] Volume keystone-keys is already started
2017-11-05 21:54:55,441 [salt.state       ][INFO    ][30905] Completed state [keystone-keys] at time 21:54:55.439750 duration_in_ms=218.728
2017-11-05 21:54:55,443 [salt.state       ][INFO    ][30905] Running state [nova_instances] at time 21:54:55.442696
2017-11-05 21:54:55,443 [salt.state       ][INFO    ][30905] Executing state glusterfs.created for nova_instances
2017-11-05 21:54:55,445 [salt.loaded.int.module.cmdmod][INFO    ][30905] Executing command 'gluster --version' in directory '/root'
2017-11-05 21:54:55,465 [salt.loaded.int.module.cmdmod][INFO    ][30905] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-05 21:54:55,546 [salt.loaded.int.module.cmdmod][INFO    ][30905] Executing command 'gluster --version' in directory '/root'
2017-11-05 21:54:55,561 [salt.loaded.int.module.cmdmod][INFO    ][30905] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-05 21:54:55,678 [salt.loaded.int.module.cmdmod][INFO    ][30905] Executing command 'gluster --version' in directory '/root'
2017-11-05 21:54:55,695 [salt.loaded.int.module.cmdmod][INFO    ][30905] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-05 21:54:57,919 [salt.loaded.int.module.cmdmod][INFO    ][30905] Executing command 'gluster --version' in directory '/root'
2017-11-05 21:54:57,946 [salt.loaded.int.module.cmdmod][INFO    ][30905] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-05 21:54:58,026 [salt.state       ][INFO    ][30905] {'new': ['glance', 'keystone-keys', 'nova_instances'], 'old': ['glance', 'keystone-keys']}
2017-11-05 21:54:58,026 [salt.state       ][INFO    ][30905] Completed state [nova_instances] at time 21:54:58.026179 duration_in_ms=2583.482
2017-11-05 21:54:58,036 [salt.state       ][INFO    ][30905] Running state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 21:54:58.035538
2017-11-05 21:54:58,037 [salt.state       ][INFO    ][30905] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'
2017-11-05 21:54:58,038 [salt.loaded.int.module.cmdmod][INFO    ][30905] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-11-05 21:54:58,127 [salt.loaded.int.module.cmdmod][INFO    ][30905] Executing command 'gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'' in directory '/root'
2017-11-05 21:54:58,278 [salt.state       ][INFO    ][30905] {'pid': 31501, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-11-05 21:54:58,279 [salt.state       ][INFO    ][30905] Completed state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 21:54:58.278819 duration_in_ms=243.28
2017-11-05 21:54:58,282 [salt.state       ][INFO    ][30905] Running state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'On'] at time 21:54:58.281429
2017-11-05 21:54:58,282 [salt.state       ][INFO    ][30905] Executing state cmd.run for gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'On'
2017-11-05 21:54:58,283 [salt.loaded.int.module.cmdmod][INFO    ][30905] Executing command 'gluster volume info 'nova_instances' | grep 'cluster.readdir-optimize: On'' in directory '/root'
2017-11-05 21:54:58,371 [salt.loaded.int.module.cmdmod][INFO    ][30905] Executing command 'gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'On'' in directory '/root'
2017-11-05 21:54:58,538 [salt.state       ][INFO    ][30905] {'pid': 31519, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-11-05 21:54:58,538 [salt.state       ][INFO    ][30905] Completed state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'On'] at time 21:54:58.538044 duration_in_ms=256.614
2017-11-05 21:54:58,539 [salt.state       ][INFO    ][30905] Running state [gluster volume set 'nova_instances' 'network.remote-dio' 'On'] at time 21:54:58.539230
2017-11-05 21:54:58,540 [salt.state       ][INFO    ][30905] Executing state cmd.run for gluster volume set 'nova_instances' 'network.remote-dio' 'On'
2017-11-05 21:54:58,542 [salt.loaded.int.module.cmdmod][INFO    ][30905] Executing command 'gluster volume info 'nova_instances' | grep 'network.remote-dio: On'' in directory '/root'
2017-11-05 21:54:58,624 [salt.loaded.int.module.cmdmod][INFO    ][30905] Executing command 'gluster volume set 'nova_instances' 'network.remote-dio' 'On'' in directory '/root'
2017-11-05 21:54:58,789 [salt.state       ][INFO    ][30905] {'pid': 31536, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-11-05 21:54:58,790 [salt.state       ][INFO    ][30905] Completed state [gluster volume set 'nova_instances' 'network.remote-dio' 'On'] at time 21:54:58.789444 duration_in_ms=250.212
2017-11-05 21:54:58,791 [salt.state       ][INFO    ][30905] Running state [gluster volume set 'nova_instances' 'nfs.disable' 'On'] at time 21:54:58.790519
2017-11-05 21:54:58,791 [salt.state       ][INFO    ][30905] Executing state cmd.run for gluster volume set 'nova_instances' 'nfs.disable' 'On'
2017-11-05 21:54:58,793 [salt.loaded.int.module.cmdmod][INFO    ][30905] Executing command 'gluster volume info 'nova_instances' | grep 'nfs.disable: On'' in directory '/root'
2017-11-05 21:54:58,879 [salt.loaded.int.module.cmdmod][INFO    ][30905] Executing command 'gluster volume set 'nova_instances' 'nfs.disable' 'On'' in directory '/root'
2017-11-05 21:55:00,538 [salt.minion      ][INFO    ][24110] User sudo_ubuntu Executing command saltutil.find_job with jid 20171105215500529555
2017-11-05 21:55:00,566 [salt.minion      ][INFO    ][31563] Starting a new job with PID 31563
2017-11-05 21:55:00,583 [salt.minion      ][INFO    ][31563] Returning information for job: 20171105215500529555
2017-11-05 21:55:01,059 [salt.state       ][INFO    ][30905] {'pid': 31553, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-11-05 21:55:01,059 [salt.state       ][INFO    ][30905] Completed state [gluster volume set 'nova_instances' 'nfs.disable' 'On'] at time 21:55:01.059173 duration_in_ms=2268.651
2017-11-05 21:55:01,061 [salt.state       ][INFO    ][30905] Running state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 21:55:01.060880
2017-11-05 21:55:01,061 [salt.state       ][INFO    ][30905] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'
2017-11-05 21:55:01,063 [salt.loaded.int.module.cmdmod][INFO    ][30905] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-11-05 21:55:01,154 [salt.loaded.int.module.cmdmod][INFO    ][30905] Executing command 'gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'' in directory '/root'
2017-11-05 21:55:01,318 [salt.state       ][INFO    ][30905] {'pid': 31575, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-11-05 21:55:01,318 [salt.state       ][INFO    ][30905] Completed state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 21:55:01.318320 duration_in_ms=257.438
2017-11-05 21:55:01,322 [salt.state       ][INFO    ][30905] Running state [nova_instances] at time 21:55:01.322364
2017-11-05 21:55:01,323 [salt.state       ][INFO    ][30905] Executing state glusterfs.started for nova_instances
2017-11-05 21:55:01,325 [salt.loaded.int.module.cmdmod][INFO    ][30905] Executing command 'gluster --version' in directory '/root'
2017-11-05 21:55:01,349 [salt.loaded.int.module.cmdmod][INFO    ][30905] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-05 21:55:01,438 [salt.loaded.int.module.cmdmod][INFO    ][30905] Executing command 'gluster --version' in directory '/root'
2017-11-05 21:55:01,458 [salt.loaded.int.module.cmdmod][INFO    ][30905] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-05 21:55:01,555 [salt.state       ][INFO    ][30905] Volume nova_instances is already started
2017-11-05 21:55:01,555 [salt.state       ][INFO    ][30905] Completed state [nova_instances] at time 21:55:01.555379 duration_in_ms=233.014
2017-11-05 21:55:01,559 [salt.state       ][INFO    ][30905] Running state [keystone-credential-keys] at time 21:55:01.558669
2017-11-05 21:55:01,559 [salt.state       ][INFO    ][30905] Executing state glusterfs.created for keystone-credential-keys
2017-11-05 21:55:01,561 [salt.loaded.int.module.cmdmod][INFO    ][30905] Executing command 'gluster --version' in directory '/root'
2017-11-05 21:55:01,584 [salt.loaded.int.module.cmdmod][INFO    ][30905] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-05 21:55:01,662 [salt.loaded.int.module.cmdmod][INFO    ][30905] Executing command 'gluster --version' in directory '/root'
2017-11-05 21:55:01,681 [salt.loaded.int.module.cmdmod][INFO    ][30905] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-05 21:55:01,802 [salt.loaded.int.module.cmdmod][INFO    ][30905] Executing command 'gluster --version' in directory '/root'
2017-11-05 21:55:01,824 [salt.loaded.int.module.cmdmod][INFO    ][30905] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-05 21:55:04,065 [salt.loaded.int.module.cmdmod][INFO    ][30905] Executing command 'gluster --version' in directory '/root'
2017-11-05 21:55:04,097 [salt.loaded.int.module.cmdmod][INFO    ][30905] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-05 21:55:04,173 [salt.state       ][INFO    ][30905] {'new': ['glance', 'keystone-credential-keys', 'keystone-keys', 'nova_instances'], 'old': ['glance', 'keystone-keys', 'nova_instances']}
2017-11-05 21:55:04,173 [salt.state       ][INFO    ][30905] Completed state [keystone-credential-keys] at time 21:55:04.173327 duration_in_ms=2614.657
2017-11-05 21:55:04,185 [salt.state       ][INFO    ][30905] Running state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 21:55:04.185143
2017-11-05 21:55:04,185 [salt.state       ][INFO    ][30905] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'
2017-11-05 21:55:04,186 [salt.loaded.int.module.cmdmod][INFO    ][30905] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-11-05 21:55:04,273 [salt.loaded.int.module.cmdmod][INFO    ][30905] Executing command 'gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'' in directory '/root'
2017-11-05 21:55:04,443 [salt.state       ][INFO    ][30905] {'pid': 31693, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-11-05 21:55:04,445 [salt.state       ][INFO    ][30905] Completed state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 21:55:04.443820 duration_in_ms=258.675
2017-11-05 21:55:04,447 [salt.state       ][INFO    ][30905] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 21:55:04.446525
2017-11-05 21:55:04,447 [salt.state       ][INFO    ][30905] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-11-05 21:55:04,449 [salt.loaded.int.module.cmdmod][INFO    ][30905] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-11-05 21:55:04,536 [salt.loaded.int.module.cmdmod][INFO    ][30905] Executing command 'gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'' in directory '/root'
2017-11-05 21:55:04,698 [salt.state       ][INFO    ][30905] {'pid': 31710, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-11-05 21:55:04,699 [salt.state       ][INFO    ][30905] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 21:55:04.698554 duration_in_ms=252.028
2017-11-05 21:55:04,701 [salt.state       ][INFO    ][30905] Running state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 21:55:04.701033
2017-11-05 21:55:04,702 [salt.state       ][INFO    ][30905] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'
2017-11-05 21:55:04,703 [salt.loaded.int.module.cmdmod][INFO    ][30905] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-11-05 21:55:04,791 [salt.loaded.int.module.cmdmod][INFO    ][30905] Executing command 'gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'' in directory '/root'
2017-11-05 21:55:06,966 [salt.state       ][INFO    ][30905] {'pid': 31728, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-11-05 21:55:06,966 [salt.state       ][INFO    ][30905] Completed state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 21:55:06.966349 duration_in_ms=2265.315
2017-11-05 21:55:06,968 [salt.state       ][INFO    ][30905] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 21:55:06.967671
2017-11-05 21:55:06,969 [salt.state       ][INFO    ][30905] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'
2017-11-05 21:55:06,970 [salt.loaded.int.module.cmdmod][INFO    ][30905] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-11-05 21:55:07,063 [salt.loaded.int.module.cmdmod][INFO    ][30905] Executing command 'gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'' in directory '/root'
2017-11-05 21:55:07,231 [salt.state       ][INFO    ][30905] {'pid': 31746, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-11-05 21:55:07,232 [salt.state       ][INFO    ][30905] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 21:55:07.231602 duration_in_ms=263.93
2017-11-05 21:55:07,233 [salt.state       ][INFO    ][30905] Running state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 21:55:07.233100
2017-11-05 21:55:07,234 [salt.state       ][INFO    ][30905] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'
2017-11-05 21:55:07,235 [salt.loaded.int.module.cmdmod][INFO    ][30905] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-11-05 21:55:07,321 [salt.loaded.int.module.cmdmod][INFO    ][30905] Executing command 'gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'' in directory '/root'
2017-11-05 21:55:07,481 [salt.state       ][INFO    ][30905] {'pid': 31763, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-11-05 21:55:07,482 [salt.state       ][INFO    ][30905] Completed state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 21:55:07.481522 duration_in_ms=248.421
2017-11-05 21:55:07,486 [salt.state       ][INFO    ][30905] Running state [keystone-credential-keys] at time 21:55:07.486049
2017-11-05 21:55:07,487 [salt.state       ][INFO    ][30905] Executing state glusterfs.started for keystone-credential-keys
2017-11-05 21:55:07,488 [salt.loaded.int.module.cmdmod][INFO    ][30905] Executing command 'gluster --version' in directory '/root'
2017-11-05 21:55:07,506 [salt.loaded.int.module.cmdmod][INFO    ][30905] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-05 21:55:07,585 [salt.loaded.int.module.cmdmod][INFO    ][30905] Executing command 'gluster --version' in directory '/root'
2017-11-05 21:55:07,606 [salt.loaded.int.module.cmdmod][INFO    ][30905] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-05 21:55:07,709 [salt.state       ][INFO    ][30905] Volume keystone-credential-keys is already started
2017-11-05 21:55:07,710 [salt.state       ][INFO    ][30905] Completed state [keystone-credential-keys] at time 21:55:07.709886 duration_in_ms=223.837
2017-11-05 21:55:07,714 [salt.minion      ][INFO    ][30905] Returning information for job: 20171105215440281475
2017-11-05 21:55:19,025 [salt.minion      ][INFO    ][24110] User sudo_ubuntu Executing command test.ping with jid 20171105215519019024
2017-11-05 21:55:19,051 [salt.minion      ][INFO    ][31803] Starting a new job with PID 31803
2017-11-05 21:55:19,107 [salt.minion      ][INFO    ][31803] Returning information for job: 20171105215519019024
2017-11-05 21:55:19,235 [salt.minion      ][INFO    ][24110] User sudo_ubuntu Executing command cmd.run with jid 20171105215519227864
2017-11-05 21:55:19,255 [salt.minion      ][INFO    ][31809] Starting a new job with PID 31809
2017-11-05 21:55:19,265 [salt.loaded.int.module.cmdmod][INFO    ][31809] Executing command 'gluster peer status; gluster volume status' in directory '/root'
2017-11-05 21:55:19,441 [salt.minion      ][INFO    ][31809] Returning information for job: 20171105215519227864
2017-11-05 22:35:11,007 [salt.minion      ][INFO    ][24110] User sudo_ubuntu Executing command test.ping with jid 20171105223510996555
2017-11-05 22:35:11,035 [salt.minion      ][INFO    ][32386] Starting a new job with PID 32386
2017-11-05 22:35:11,096 [salt.minion      ][INFO    ][32386] Returning information for job: 20171105223510996555
2017-11-05 22:35:37,772 [salt.minion      ][INFO    ][24110] User sudo_ubuntu Executing command state.sls with jid 20171105223537763898
2017-11-05 22:35:37,800 [salt.minion      ][INFO    ][32393] Starting a new job with PID 32393
2017-11-05 22:35:38,434 [salt.state       ][INFO    ][32393] Loading fresh modules for state activity
2017-11-05 22:35:38,473 [salt.fileclient  ][INFO    ][32393] Fetching file from saltenv 'base', ** done ** 'keepalived/init.sls'
2017-11-05 22:35:38,502 [salt.fileclient  ][INFO    ][32393] Fetching file from saltenv 'base', ** done ** 'keepalived/cluster.sls'
2017-11-05 22:35:38,538 [salt.fileclient  ][INFO    ][32393] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-11-05 22:35:38,916 [salt.state       ][INFO    ][32393] Running state [lsof] at time 22:35:38.916455
2017-11-05 22:35:38,917 [salt.state       ][INFO    ][32393] Executing state pkg.installed for lsof
2017-11-05 22:35:38,918 [salt.loaded.int.module.cmdmod][INFO    ][32393] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-05 22:35:39,258 [salt.state       ][INFO    ][32393] Package lsof is already installed
2017-11-05 22:35:39,258 [salt.state       ][INFO    ][32393] Completed state [lsof] at time 22:35:39.258426 duration_in_ms=341.971
2017-11-05 22:35:39,259 [salt.state       ][INFO    ][32393] Running state [keepalived] at time 22:35:39.258708
2017-11-05 22:35:39,259 [salt.state       ][INFO    ][32393] Executing state pkg.installed for keepalived
2017-11-05 22:35:39,265 [salt.state       ][INFO    ][32393] Package keepalived is already installed
2017-11-05 22:35:39,265 [salt.state       ][INFO    ][32393] Completed state [keepalived] at time 22:35:39.265213 duration_in_ms=6.505
2017-11-05 22:35:39,267 [salt.state       ][INFO    ][32393] Running state [/etc/keepalived/keepalived.conf] at time 22:35:39.267103
2017-11-05 22:35:39,267 [salt.state       ][INFO    ][32393] Executing state file.managed for /etc/keepalived/keepalived.conf
2017-11-05 22:35:39,298 [salt.fileclient  ][INFO    ][32393] Fetching file from saltenv 'base', ** done ** 'keepalived/files/keepalived.conf'
2017-11-05 22:35:39,355 [salt.fileclient  ][INFO    ][32393] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-11-05 22:35:39,367 [salt.state       ][INFO    ][32393] File /etc/keepalived/keepalived.conf is in the correct state
2017-11-05 22:35:39,368 [salt.state       ][INFO    ][32393] Completed state [/etc/keepalived/keepalived.conf] at time 22:35:39.367563 duration_in_ms=100.459
2017-11-05 22:35:39,369 [salt.state       ][INFO    ][32393] Running state [keepalived] at time 22:35:39.368722
2017-11-05 22:35:39,369 [salt.state       ][INFO    ][32393] Executing state service.running for keepalived
2017-11-05 22:35:39,370 [salt.loaded.int.module.cmdmod][INFO    ][32393] Executing command ['systemctl', 'status', 'keepalived.service', '-n', '0'] in directory '/root'
2017-11-05 22:35:39,404 [salt.loaded.int.module.cmdmod][INFO    ][32393] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2017-11-05 22:35:39,426 [salt.loaded.int.module.cmdmod][INFO    ][32393] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-11-05 22:35:39,444 [salt.state       ][INFO    ][32393] The service keepalived is already running
2017-11-05 22:35:39,445 [salt.state       ][INFO    ][32393] Completed state [keepalived] at time 22:35:39.444678 duration_in_ms=75.954
2017-11-05 22:35:39,447 [salt.minion      ][INFO    ][32393] Returning information for job: 20171105223537763898
2017-11-05 22:35:48,281 [salt.minion      ][INFO    ][24110] User sudo_ubuntu Executing command pillar.get with jid 20171105223548273355
2017-11-05 22:35:48,307 [salt.minion      ][INFO    ][32418] Starting a new job with PID 32418
2017-11-05 22:35:48,321 [salt.minion      ][INFO    ][32418] Returning information for job: 20171105223548273355
2017-11-05 22:36:38,069 [salt.minion      ][INFO    ][24110] User sudo_ubuntu Executing command state.sls with jid 20171105223638061015
2017-11-05 22:36:38,100 [salt.minion      ][INFO    ][32436] Starting a new job with PID 32436
2017-11-05 22:36:40,722 [salt.state       ][INFO    ][32436] Loading fresh modules for state activity
2017-11-05 22:36:40,769 [salt.fileclient  ][INFO    ][32436] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-11-05 22:36:40,807 [salt.fileclient  ][INFO    ][32436] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-11-05 22:36:41,226 [salt.state       ][INFO    ][32436] Running state [attr] at time 22:36:41.226287
2017-11-05 22:36:41,227 [salt.state       ][INFO    ][32436] Executing state pkg.installed for attr
2017-11-05 22:36:41,227 [salt.loaded.int.module.cmdmod][INFO    ][32436] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-05 22:36:41,578 [salt.state       ][INFO    ][32436] Package attr is already installed
2017-11-05 22:36:41,578 [salt.state       ][INFO    ][32436] Completed state [attr] at time 22:36:41.578239 duration_in_ms=351.952
2017-11-05 22:36:41,579 [salt.state       ][INFO    ][32436] Running state [glusterfs-server] at time 22:36:41.578517
2017-11-05 22:36:41,579 [salt.state       ][INFO    ][32436] Executing state pkg.installed for glusterfs-server
2017-11-05 22:36:41,583 [salt.state       ][INFO    ][32436] Package glusterfs-server is already installed
2017-11-05 22:36:41,583 [salt.state       ][INFO    ][32436] Completed state [glusterfs-server] at time 22:36:41.583252 duration_in_ms=4.735
2017-11-05 22:36:41,583 [salt.state       ][INFO    ][32436] Running state [bc] at time 22:36:41.583445
2017-11-05 22:36:41,584 [salt.state       ][INFO    ][32436] Executing state pkg.installed for bc
2017-11-05 22:36:41,589 [salt.state       ][INFO    ][32436] Package bc is already installed
2017-11-05 22:36:41,589 [salt.state       ][INFO    ][32436] Completed state [bc] at time 22:36:41.588709 duration_in_ms=5.263
2017-11-05 22:36:41,590 [salt.state       ][INFO    ][32436] Running state [glusterfs-server] at time 22:36:41.589548
2017-11-05 22:36:41,590 [salt.state       ][INFO    ][32436] Executing state service.running for glusterfs-server
2017-11-05 22:36:41,590 [salt.loaded.int.module.cmdmod][INFO    ][32436] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-11-05 22:36:41,626 [salt.loaded.int.module.cmdmod][INFO    ][32436] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-11-05 22:36:41,647 [salt.loaded.int.module.cmdmod][INFO    ][32436] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-11-05 22:36:41,671 [salt.state       ][INFO    ][32436] The service glusterfs-server is already running
2017-11-05 22:36:41,672 [salt.state       ][INFO    ][32436] Completed state [glusterfs-server] at time 22:36:41.671408 duration_in_ms=81.859
2017-11-05 22:36:41,675 [salt.state       ][INFO    ][32436] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 22:36:41.675372
2017-11-05 22:36:41,676 [salt.state       ][INFO    ][32436] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-11-05 22:36:41,681 [salt.state       ][INFO    ][32436] File /etc/systemd/system/glusterfs-server.service.d/override.conf is in the correct state
2017-11-05 22:36:41,682 [salt.state       ][INFO    ][32436] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 22:36:41.681634 duration_in_ms=6.262
2017-11-05 22:36:41,682 [salt.state       ][INFO    ][32436] Running state [/srv/glusterfs/glance] at time 22:36:41.682020
2017-11-05 22:36:41,682 [salt.state       ][INFO    ][32436] Executing state file.directory for /srv/glusterfs/glance
2017-11-05 22:36:41,683 [salt.state       ][INFO    ][32436] Directory /srv/glusterfs/glance is in the correct state
2017-11-05 22:36:41,684 [salt.state       ][INFO    ][32436] Completed state [/srv/glusterfs/glance] at time 22:36:41.683680 duration_in_ms=1.66
2017-11-05 22:36:41,684 [salt.state       ][INFO    ][32436] Running state [/srv/glusterfs/keystone-keys] at time 22:36:41.684239
2017-11-05 22:36:41,684 [salt.state       ][INFO    ][32436] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-11-05 22:36:41,685 [salt.state       ][INFO    ][32436] Directory /srv/glusterfs/keystone-keys is in the correct state
2017-11-05 22:36:41,685 [salt.state       ][INFO    ][32436] Completed state [/srv/glusterfs/keystone-keys] at time 22:36:41.685053 duration_in_ms=0.814
2017-11-05 22:36:41,686 [salt.state       ][INFO    ][32436] Running state [/srv/glusterfs/nova_instances] at time 22:36:41.686153
2017-11-05 22:36:41,686 [salt.state       ][INFO    ][32436] Executing state file.directory for /srv/glusterfs/nova_instances
2017-11-05 22:36:41,687 [salt.state       ][INFO    ][32436] Directory /srv/glusterfs/nova_instances is in the correct state
2017-11-05 22:36:41,687 [salt.state       ][INFO    ][32436] Completed state [/srv/glusterfs/nova_instances] at time 22:36:41.686929 duration_in_ms=0.776
2017-11-05 22:36:41,687 [salt.state       ][INFO    ][32436] Running state [/srv/glusterfs/keystone-credential-keys] at time 22:36:41.687120
2017-11-05 22:36:41,687 [salt.state       ][INFO    ][32436] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-11-05 22:36:41,688 [salt.state       ][INFO    ][32436] Directory /srv/glusterfs/keystone-credential-keys is in the correct state
2017-11-05 22:36:41,689 [salt.state       ][INFO    ][32436] Completed state [/srv/glusterfs/keystone-credential-keys] at time 22:36:41.688502 duration_in_ms=1.382
2017-11-05 22:36:41,689 [salt.minion      ][INFO    ][32436] Returning information for job: 20171105223638061015
2017-11-05 22:36:42,704 [salt.minion      ][INFO    ][24110] User sudo_ubuntu Executing command test.ping with jid 20171105223642694907
2017-11-05 22:36:42,739 [salt.minion      ][INFO    ][32459] Starting a new job with PID 32459
2017-11-05 22:36:42,784 [salt.minion      ][INFO    ][32459] Returning information for job: 20171105223642694907
2017-11-05 22:36:42,906 [salt.minion      ][INFO    ][24110] User sudo_ubuntu Executing command state.sls with jid 20171105223642899548
2017-11-05 22:36:42,928 [salt.minion      ][INFO    ][32464] Starting a new job with PID 32464
2017-11-05 22:36:43,517 [salt.state       ][INFO    ][32464] Loading fresh modules for state activity
2017-11-05 22:36:43,566 [salt.fileclient  ][INFO    ][32464] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/setup.sls'
2017-11-05 22:36:43,619 [salt.fileclient  ][INFO    ][32464] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-11-05 22:36:43,721 [salt.fileclient  ][INFO    ][32464] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-11-05 22:36:43,755 [salt.fileclient  ][INFO    ][32464] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-11-05 22:36:44,151 [salt.state       ][INFO    ][32464] Running state [attr] at time 22:36:44.150721
2017-11-05 22:36:44,151 [salt.state       ][INFO    ][32464] Executing state pkg.installed for attr
2017-11-05 22:36:44,152 [salt.loaded.int.module.cmdmod][INFO    ][32464] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-05 22:36:44,480 [salt.state       ][INFO    ][32464] Package attr is already installed
2017-11-05 22:36:44,480 [salt.state       ][INFO    ][32464] Completed state [attr] at time 22:36:44.480266 duration_in_ms=329.544
2017-11-05 22:36:44,481 [salt.state       ][INFO    ][32464] Running state [glusterfs-server] at time 22:36:44.480894
2017-11-05 22:36:44,481 [salt.state       ][INFO    ][32464] Executing state pkg.installed for glusterfs-server
2017-11-05 22:36:44,485 [salt.state       ][INFO    ][32464] Package glusterfs-server is already installed
2017-11-05 22:36:44,485 [salt.state       ][INFO    ][32464] Completed state [glusterfs-server] at time 22:36:44.485239 duration_in_ms=4.345
2017-11-05 22:36:44,485 [salt.state       ][INFO    ][32464] Running state [bc] at time 22:36:44.485403
2017-11-05 22:36:44,486 [salt.state       ][INFO    ][32464] Executing state pkg.installed for bc
2017-11-05 22:36:44,489 [salt.state       ][INFO    ][32464] Package bc is already installed
2017-11-05 22:36:44,490 [salt.state       ][INFO    ][32464] Completed state [bc] at time 22:36:44.489540 duration_in_ms=4.138
2017-11-05 22:36:44,491 [salt.state       ][INFO    ][32464] Running state [glusterfs-server] at time 22:36:44.490516
2017-11-05 22:36:44,491 [salt.state       ][INFO    ][32464] Executing state service.running for glusterfs-server
2017-11-05 22:36:44,492 [salt.loaded.int.module.cmdmod][INFO    ][32464] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-11-05 22:36:44,530 [salt.loaded.int.module.cmdmod][INFO    ][32464] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-11-05 22:36:44,547 [salt.loaded.int.module.cmdmod][INFO    ][32464] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-11-05 22:36:44,570 [salt.state       ][INFO    ][32464] The service glusterfs-server is already running
2017-11-05 22:36:44,571 [salt.state       ][INFO    ][32464] Completed state [glusterfs-server] at time 22:36:44.570838 duration_in_ms=80.321
2017-11-05 22:36:44,574 [salt.state       ][INFO    ][32464] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 22:36:44.574382
2017-11-05 22:36:44,575 [salt.state       ][INFO    ][32464] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-11-05 22:36:44,581 [salt.state       ][INFO    ][32464] File /etc/systemd/system/glusterfs-server.service.d/override.conf is in the correct state
2017-11-05 22:36:44,581 [salt.state       ][INFO    ][32464] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 22:36:44.580914 duration_in_ms=6.531
2017-11-05 22:36:44,581 [salt.state       ][INFO    ][32464] Running state [/srv/glusterfs/glance] at time 22:36:44.581188
2017-11-05 22:36:44,581 [salt.state       ][INFO    ][32464] Executing state file.directory for /srv/glusterfs/glance
2017-11-05 22:36:44,583 [salt.state       ][INFO    ][32464] Directory /srv/glusterfs/glance is in the correct state
2017-11-05 22:36:44,583 [salt.state       ][INFO    ][32464] Completed state [/srv/glusterfs/glance] at time 22:36:44.582964 duration_in_ms=1.776
2017-11-05 22:36:44,583 [salt.state       ][INFO    ][32464] Running state [/srv/glusterfs/keystone-keys] at time 22:36:44.583224
2017-11-05 22:36:44,584 [salt.state       ][INFO    ][32464] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-11-05 22:36:44,585 [salt.state       ][INFO    ][32464] Directory /srv/glusterfs/keystone-keys is in the correct state
2017-11-05 22:36:44,586 [salt.state       ][INFO    ][32464] Completed state [/srv/glusterfs/keystone-keys] at time 22:36:44.585552 duration_in_ms=2.328
2017-11-05 22:36:44,586 [salt.state       ][INFO    ][32464] Running state [/srv/glusterfs/nova_instances] at time 22:36:44.585809
2017-11-05 22:36:44,586 [salt.state       ][INFO    ][32464] Executing state file.directory for /srv/glusterfs/nova_instances
2017-11-05 22:36:44,587 [salt.state       ][INFO    ][32464] Directory /srv/glusterfs/nova_instances is in the correct state
2017-11-05 22:36:44,587 [salt.state       ][INFO    ][32464] Completed state [/srv/glusterfs/nova_instances] at time 22:36:44.586838 duration_in_ms=1.029
2017-11-05 22:36:44,587 [salt.state       ][INFO    ][32464] Running state [/srv/glusterfs/keystone-credential-keys] at time 22:36:44.587093
2017-11-05 22:36:44,587 [salt.state       ][INFO    ][32464] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-11-05 22:36:44,589 [salt.state       ][INFO    ][32464] Directory /srv/glusterfs/keystone-credential-keys is in the correct state
2017-11-05 22:36:44,590 [salt.state       ][INFO    ][32464] Completed state [/srv/glusterfs/keystone-credential-keys] at time 22:36:44.589796 duration_in_ms=2.703
2017-11-05 22:36:44,669 [salt.loaded.int.module.cmdmod][INFO    ][32464] Executing command ['git', '--version'] in directory '/root'
2017-11-05 22:36:44,800 [salt.state       ][INFO    ][32464] Running state [sleep 5] at time 22:36:44.799622
2017-11-05 22:36:44,800 [salt.state       ][INFO    ][32464] Executing state cmd.wait for sleep 5
2017-11-05 22:36:44,800 [salt.state       ][INFO    ][32464] No changes made for sleep 5
2017-11-05 22:36:44,801 [salt.state       ][INFO    ][32464] Completed state [sleep 5] at time 22:36:44.800665 duration_in_ms=1.043
2017-11-05 22:36:44,801 [salt.state       ][INFO    ][32464] Running state [192.168.10.143] at time 22:36:44.801194
2017-11-05 22:36:44,801 [salt.state       ][INFO    ][32464] Executing state glusterfs.peered for 192.168.10.143
2017-11-05 22:36:44,802 [salt.loaded.int.module.cmdmod][INFO    ][32464] Executing command 'gluster --version' in directory '/root'
2017-11-05 22:36:44,820 [salt.loaded.int.module.cmdmod][INFO    ][32464] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-05 22:36:44,911 [salt.state       ][INFO    ][32464] Host 192.168.10.143 already peered
2017-11-05 22:36:44,911 [salt.state       ][INFO    ][32464] Completed state [192.168.10.143] at time 22:36:44.911251 duration_in_ms=110.056
2017-11-05 22:36:44,922 [salt.state       ][INFO    ][32464] Running state [192.168.10.142] at time 22:36:44.921700
2017-11-05 22:36:44,922 [salt.state       ][INFO    ][32464] Executing state glusterfs.peered for 192.168.10.142
2017-11-05 22:36:44,923 [salt.loaded.int.module.cmdmod][INFO    ][32464] Executing command 'gluster --version' in directory '/root'
2017-11-05 22:36:44,942 [salt.loaded.int.module.cmdmod][INFO    ][32464] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-05 22:36:45,034 [salt.loaded.int.module.cmdmod][INFO    ][32464] Executing command 'gluster --version' in directory '/root'
2017-11-05 22:36:45,051 [salt.loaded.int.module.cmdmod][INFO    ][32464] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-05 22:36:45,139 [salt.loaded.int.module.cmdmod][INFO    ][32464] Executing command 'gluster --version' in directory '/root'
2017-11-05 22:36:45,159 [salt.loaded.int.module.cmdmod][INFO    ][32464] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-05 22:36:45,254 [salt.loaded.int.module.cmdmod][INFO    ][32464] Executing command 'gluster --version' in directory '/root'
2017-11-05 22:36:45,275 [salt.loaded.int.module.cmdmod][INFO    ][32464] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-05 22:36:45,365 [salt.state       ][INFO    ][32464] Peering with localhost is not needed
2017-11-05 22:36:45,367 [salt.state       ][INFO    ][32464] Completed state [192.168.10.142] at time 22:36:45.365792 duration_in_ms=444.079
2017-11-05 22:36:45,375 [salt.state       ][INFO    ][32464] Running state [192.168.10.141] at time 22:36:45.374934
2017-11-05 22:36:45,376 [salt.state       ][INFO    ][32464] Executing state glusterfs.peered for 192.168.10.141
2017-11-05 22:36:45,378 [salt.loaded.int.module.cmdmod][INFO    ][32464] Executing command 'gluster --version' in directory '/root'
2017-11-05 22:36:45,398 [salt.loaded.int.module.cmdmod][INFO    ][32464] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-05 22:36:45,486 [salt.state       ][INFO    ][32464] Host 192.168.10.141 already peered
2017-11-05 22:36:45,487 [salt.state       ][INFO    ][32464] Completed state [192.168.10.141] at time 22:36:45.486514 duration_in_ms=111.58
2017-11-05 22:36:45,489 [salt.state       ][INFO    ][32464] Running state [glance] at time 22:36:45.488854
2017-11-05 22:36:45,489 [salt.state       ][INFO    ][32464] Executing state glusterfs.created for glance
2017-11-05 22:36:45,491 [salt.loaded.int.module.cmdmod][INFO    ][32464] Executing command 'gluster --version' in directory '/root'
2017-11-05 22:36:45,511 [salt.loaded.int.module.cmdmod][INFO    ][32464] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-05 22:36:45,598 [salt.loaded.int.module.cmdmod][INFO    ][32464] Executing command 'gluster --version' in directory '/root'
2017-11-05 22:36:45,616 [salt.loaded.int.module.cmdmod][INFO    ][32464] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-05 22:36:45,709 [salt.state       ][INFO    ][32464] Volume glance already exists and is started.
2017-11-05 22:36:45,710 [salt.state       ][INFO    ][32464] Completed state [glance] at time 22:36:45.709982 duration_in_ms=221.127
2017-11-05 22:36:45,719 [salt.state       ][INFO    ][32464] Running state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 22:36:45.719030
2017-11-05 22:36:45,719 [salt.state       ][INFO    ][32464] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'
2017-11-05 22:36:45,720 [salt.loaded.int.module.cmdmod][INFO    ][32464] Executing command 'gluster volume info 'glance' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-11-05 22:36:45,811 [salt.state       ][INFO    ][32464] unless execution succeeded
2017-11-05 22:36:45,812 [salt.state       ][INFO    ][32464] Completed state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 22:36:45.811444 duration_in_ms=92.413
2017-11-05 22:36:45,814 [salt.state       ][INFO    ][32464] Running state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 22:36:45.813638
2017-11-05 22:36:45,814 [salt.state       ][INFO    ][32464] Executing state cmd.run for gluster volume set 'glance' 'network.remote-dio' 'True'
2017-11-05 22:36:45,816 [salt.loaded.int.module.cmdmod][INFO    ][32464] Executing command 'gluster volume info 'glance' | grep 'network.remote-dio: True'' in directory '/root'
2017-11-05 22:36:45,911 [salt.state       ][INFO    ][32464] unless execution succeeded
2017-11-05 22:36:45,911 [salt.state       ][INFO    ][32464] Completed state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 22:36:45.911319 duration_in_ms=97.681
2017-11-05 22:36:45,912 [salt.state       ][INFO    ][32464] Running state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 22:36:45.912419
2017-11-05 22:36:45,913 [salt.state       ][INFO    ][32464] Executing state cmd.run for gluster volume set 'glance' 'nfs.disable' 'True'
2017-11-05 22:36:45,914 [salt.loaded.int.module.cmdmod][INFO    ][32464] Executing command 'gluster volume info 'glance' | grep 'nfs.disable: True'' in directory '/root'
2017-11-05 22:36:46,011 [salt.state       ][INFO    ][32464] unless execution succeeded
2017-11-05 22:36:46,011 [salt.state       ][INFO    ][32464] Completed state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 22:36:46.011379 duration_in_ms=98.959
2017-11-05 22:36:46,014 [salt.state       ][INFO    ][32464] Running state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 22:36:46.013628
2017-11-05 22:36:46,014 [salt.state       ][INFO    ][32464] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'
2017-11-05 22:36:46,015 [salt.loaded.int.module.cmdmod][INFO    ][32464] Executing command 'gluster volume info 'glance' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-11-05 22:36:46,111 [salt.state       ][INFO    ][32464] unless execution succeeded
2017-11-05 22:36:46,111 [salt.state       ][INFO    ][32464] Completed state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 22:36:46.111289 duration_in_ms=97.661
2017-11-05 22:36:46,113 [salt.state       ][INFO    ][32464] Running state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 22:36:46.112569
2017-11-05 22:36:46,113 [salt.state       ][INFO    ][32464] Executing state cmd.run for gluster volume set 'glance' 'cluster.readdir-optimize' 'True'
2017-11-05 22:36:46,114 [salt.loaded.int.module.cmdmod][INFO    ][32464] Executing command 'gluster volume info 'glance' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-11-05 22:36:46,206 [salt.state       ][INFO    ][32464] unless execution succeeded
2017-11-05 22:36:46,206 [salt.state       ][INFO    ][32464] Completed state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 22:36:46.205944 duration_in_ms=93.374
2017-11-05 22:36:46,211 [salt.state       ][INFO    ][32464] Running state [glance] at time 22:36:46.211223
2017-11-05 22:36:46,212 [salt.state       ][INFO    ][32464] Executing state glusterfs.started for glance
2017-11-05 22:36:46,213 [salt.loaded.int.module.cmdmod][INFO    ][32464] Executing command 'gluster --version' in directory '/root'
2017-11-05 22:36:46,237 [salt.loaded.int.module.cmdmod][INFO    ][32464] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-05 22:36:46,335 [salt.loaded.int.module.cmdmod][INFO    ][32464] Executing command 'gluster --version' in directory '/root'
2017-11-05 22:36:46,358 [salt.loaded.int.module.cmdmod][INFO    ][32464] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-05 22:36:46,457 [salt.state       ][INFO    ][32464] Volume glance is already started
2017-11-05 22:36:46,458 [salt.state       ][INFO    ][32464] Completed state [glance] at time 22:36:46.457409 duration_in_ms=246.186
2017-11-05 22:36:46,460 [salt.state       ][INFO    ][32464] Running state [keystone-keys] at time 22:36:46.459709
2017-11-05 22:36:46,461 [salt.state       ][INFO    ][32464] Executing state glusterfs.created for keystone-keys
2017-11-05 22:36:46,462 [salt.loaded.int.module.cmdmod][INFO    ][32464] Executing command 'gluster --version' in directory '/root'
2017-11-05 22:36:46,482 [salt.loaded.int.module.cmdmod][INFO    ][32464] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-05 22:36:46,575 [salt.loaded.int.module.cmdmod][INFO    ][32464] Executing command 'gluster --version' in directory '/root'
2017-11-05 22:36:46,598 [salt.loaded.int.module.cmdmod][INFO    ][32464] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-05 22:36:46,699 [salt.state       ][INFO    ][32464] Volume keystone-keys already exists and is started.
2017-11-05 22:36:46,701 [salt.state       ][INFO    ][32464] Completed state [keystone-keys] at time 22:36:46.701396 duration_in_ms=241.687
2017-11-05 22:36:46,710 [salt.state       ][INFO    ][32464] Running state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 22:36:46.710009
2017-11-05 22:36:46,710 [salt.state       ][INFO    ][32464] Executing state cmd.run for gluster volume set 'keystone-keys' 'network.remote-dio' 'True'
2017-11-05 22:36:46,711 [salt.loaded.int.module.cmdmod][INFO    ][32464] Executing command 'gluster volume info 'keystone-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-11-05 22:36:46,803 [salt.state       ][INFO    ][32464] unless execution succeeded
2017-11-05 22:36:46,804 [salt.state       ][INFO    ][32464] Completed state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 22:36:46.803762 duration_in_ms=93.75
2017-11-05 22:36:46,805 [salt.state       ][INFO    ][32464] Running state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 22:36:46.805323
2017-11-05 22:36:46,806 [salt.state       ][INFO    ][32464] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-11-05 22:36:46,807 [salt.loaded.int.module.cmdmod][INFO    ][32464] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-11-05 22:36:46,906 [salt.state       ][INFO    ][32464] unless execution succeeded
2017-11-05 22:36:46,907 [salt.state       ][INFO    ][32464] Completed state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 22:36:46.906595 duration_in_ms=101.271
2017-11-05 22:36:46,909 [salt.state       ][INFO    ][32464] Running state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 22:36:46.908761
2017-11-05 22:36:46,909 [salt.state       ][INFO    ][32464] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'
2017-11-05 22:36:46,910 [salt.loaded.int.module.cmdmod][INFO    ][32464] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-11-05 22:36:47,012 [salt.state       ][INFO    ][32464] unless execution succeeded
2017-11-05 22:36:47,013 [salt.state       ][INFO    ][32464] Completed state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 22:36:47.012811 duration_in_ms=104.05
2017-11-05 22:36:47,014 [salt.state       ][INFO    ][32464] Running state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 22:36:47.013897
2017-11-05 22:36:47,014 [salt.state       ][INFO    ][32464] Executing state cmd.run for gluster volume set 'keystone-keys' 'nfs.disable' 'True'
2017-11-05 22:36:47,015 [salt.loaded.int.module.cmdmod][INFO    ][32464] Executing command 'gluster volume info 'keystone-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-11-05 22:36:47,113 [salt.state       ][INFO    ][32464] unless execution succeeded
2017-11-05 22:36:47,114 [salt.state       ][INFO    ][32464] Completed state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 22:36:47.114033 duration_in_ms=100.136
2017-11-05 22:36:47,115 [salt.state       ][INFO    ][32464] Running state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 22:36:47.115036
2017-11-05 22:36:47,116 [salt.state       ][INFO    ][32464] Executing state cmd.run for gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'
2017-11-05 22:36:47,117 [salt.loaded.int.module.cmdmod][INFO    ][32464] Executing command 'gluster volume info 'keystone-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-11-05 22:36:47,206 [salt.state       ][INFO    ][32464] unless execution succeeded
2017-11-05 22:36:47,207 [salt.state       ][INFO    ][32464] Completed state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 22:36:47.206844 duration_in_ms=91.808
2017-11-05 22:36:47,210 [salt.state       ][INFO    ][32464] Running state [keystone-keys] at time 22:36:47.209810
2017-11-05 22:36:47,210 [salt.state       ][INFO    ][32464] Executing state glusterfs.started for keystone-keys
2017-11-05 22:36:47,211 [salt.loaded.int.module.cmdmod][INFO    ][32464] Executing command 'gluster --version' in directory '/root'
2017-11-05 22:36:47,231 [salt.loaded.int.module.cmdmod][INFO    ][32464] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-05 22:36:47,321 [salt.loaded.int.module.cmdmod][INFO    ][32464] Executing command 'gluster --version' in directory '/root'
2017-11-05 22:36:47,342 [salt.loaded.int.module.cmdmod][INFO    ][32464] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-05 22:36:47,438 [salt.state       ][INFO    ][32464] Volume keystone-keys is already started
2017-11-05 22:36:47,439 [salt.state       ][INFO    ][32464] Completed state [keystone-keys] at time 22:36:47.438792 duration_in_ms=228.982
2017-11-05 22:36:47,445 [salt.state       ][INFO    ][32464] Running state [nova_instances] at time 22:36:47.444611
2017-11-05 22:36:47,445 [salt.state       ][INFO    ][32464] Executing state glusterfs.created for nova_instances
2017-11-05 22:36:47,446 [salt.loaded.int.module.cmdmod][INFO    ][32464] Executing command 'gluster --version' in directory '/root'
2017-11-05 22:36:47,465 [salt.loaded.int.module.cmdmod][INFO    ][32464] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-05 22:36:47,547 [salt.loaded.int.module.cmdmod][INFO    ][32464] Executing command 'gluster --version' in directory '/root'
2017-11-05 22:36:47,568 [salt.loaded.int.module.cmdmod][INFO    ][32464] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-05 22:36:47,666 [salt.state       ][INFO    ][32464] Volume nova_instances already exists and is started.
2017-11-05 22:36:47,667 [salt.state       ][INFO    ][32464] Completed state [nova_instances] at time 22:36:47.666425 duration_in_ms=221.813
2017-11-05 22:36:47,681 [salt.state       ][INFO    ][32464] Running state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 22:36:47.681201
2017-11-05 22:36:47,682 [salt.state       ][INFO    ][32464] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'
2017-11-05 22:36:47,683 [salt.loaded.int.module.cmdmod][INFO    ][32464] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-11-05 22:36:47,774 [salt.state       ][INFO    ][32464] unless execution succeeded
2017-11-05 22:36:47,775 [salt.state       ][INFO    ][32464] Completed state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 22:36:47.774934 duration_in_ms=93.733
2017-11-05 22:36:47,777 [salt.state       ][INFO    ][32464] Running state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'On'] at time 22:36:47.776685
2017-11-05 22:36:47,777 [salt.state       ][INFO    ][32464] Executing state cmd.run for gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'On'
2017-11-05 22:36:47,778 [salt.loaded.int.module.cmdmod][INFO    ][32464] Executing command 'gluster volume info 'nova_instances' | grep 'cluster.readdir-optimize: On'' in directory '/root'
2017-11-05 22:36:47,870 [salt.state       ][INFO    ][32464] unless execution succeeded
2017-11-05 22:36:47,871 [salt.state       ][INFO    ][32464] Completed state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'On'] at time 22:36:47.870779 duration_in_ms=94.094
2017-11-05 22:36:47,872 [salt.state       ][INFO    ][32464] Running state [gluster volume set 'nova_instances' 'network.remote-dio' 'On'] at time 22:36:47.872297
2017-11-05 22:36:47,873 [salt.state       ][INFO    ][32464] Executing state cmd.run for gluster volume set 'nova_instances' 'network.remote-dio' 'On'
2017-11-05 22:36:47,874 [salt.loaded.int.module.cmdmod][INFO    ][32464] Executing command 'gluster volume info 'nova_instances' | grep 'network.remote-dio: On'' in directory '/root'
2017-11-05 22:36:47,972 [salt.state       ][INFO    ][32464] unless execution succeeded
2017-11-05 22:36:47,973 [salt.state       ][INFO    ][32464] Completed state [gluster volume set 'nova_instances' 'network.remote-dio' 'On'] at time 22:36:47.973045 duration_in_ms=100.747
2017-11-05 22:36:47,974 [salt.state       ][INFO    ][32464] Running state [gluster volume set 'nova_instances' 'nfs.disable' 'On'] at time 22:36:47.974311
2017-11-05 22:36:47,975 [salt.state       ][INFO    ][32464] Executing state cmd.run for gluster volume set 'nova_instances' 'nfs.disable' 'On'
2017-11-05 22:36:47,976 [salt.loaded.int.module.cmdmod][INFO    ][32464] Executing command 'gluster volume info 'nova_instances' | grep 'nfs.disable: On'' in directory '/root'
2017-11-05 22:36:48,077 [salt.state       ][INFO    ][32464] unless execution succeeded
2017-11-05 22:36:48,078 [salt.state       ][INFO    ][32464] Completed state [gluster volume set 'nova_instances' 'nfs.disable' 'On'] at time 22:36:48.077739 duration_in_ms=103.427
2017-11-05 22:36:48,079 [salt.state       ][INFO    ][32464] Running state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 22:36:48.078874
2017-11-05 22:36:48,079 [salt.state       ][INFO    ][32464] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'
2017-11-05 22:36:48,081 [salt.loaded.int.module.cmdmod][INFO    ][32464] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-11-05 22:36:48,173 [salt.state       ][INFO    ][32464] unless execution succeeded
2017-11-05 22:36:48,174 [salt.state       ][INFO    ][32464] Completed state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 22:36:48.173530 duration_in_ms=94.655
2017-11-05 22:36:48,178 [salt.state       ][INFO    ][32464] Running state [nova_instances] at time 22:36:48.178248
2017-11-05 22:36:48,179 [salt.state       ][INFO    ][32464] Executing state glusterfs.started for nova_instances
2017-11-05 22:36:48,180 [salt.loaded.int.module.cmdmod][INFO    ][32464] Executing command 'gluster --version' in directory '/root'
2017-11-05 22:36:48,199 [salt.loaded.int.module.cmdmod][INFO    ][32464] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-05 22:36:48,288 [salt.loaded.int.module.cmdmod][INFO    ][32464] Executing command 'gluster --version' in directory '/root'
2017-11-05 22:36:48,312 [salt.loaded.int.module.cmdmod][INFO    ][32464] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-05 22:36:48,417 [salt.state       ][INFO    ][32464] Volume nova_instances is already started
2017-11-05 22:36:48,418 [salt.state       ][INFO    ][32464] Completed state [nova_instances] at time 22:36:48.417485 duration_in_ms=239.236
2017-11-05 22:36:48,422 [salt.state       ][INFO    ][32464] Running state [keystone-credential-keys] at time 22:36:48.421516
2017-11-05 22:36:48,422 [salt.state       ][INFO    ][32464] Executing state glusterfs.created for keystone-credential-keys
2017-11-05 22:36:48,423 [salt.loaded.int.module.cmdmod][INFO    ][32464] Executing command 'gluster --version' in directory '/root'
2017-11-05 22:36:48,446 [salt.loaded.int.module.cmdmod][INFO    ][32464] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-05 22:36:48,535 [salt.loaded.int.module.cmdmod][INFO    ][32464] Executing command 'gluster --version' in directory '/root'
2017-11-05 22:36:48,555 [salt.loaded.int.module.cmdmod][INFO    ][32464] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-05 22:36:48,662 [salt.state       ][INFO    ][32464] Volume keystone-credential-keys already exists and is started.
2017-11-05 22:36:48,663 [salt.state       ][INFO    ][32464] Completed state [keystone-credential-keys] at time 22:36:48.662593 duration_in_ms=241.076
2017-11-05 22:36:48,673 [salt.state       ][INFO    ][32464] Running state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 22:36:48.672631
2017-11-05 22:36:48,673 [salt.state       ][INFO    ][32464] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'
2017-11-05 22:36:48,673 [salt.loaded.int.module.cmdmod][INFO    ][32464] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-11-05 22:36:48,765 [salt.state       ][INFO    ][32464] unless execution succeeded
2017-11-05 22:36:48,765 [salt.state       ][INFO    ][32464] Completed state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 22:36:48.765017 duration_in_ms=92.384
2017-11-05 22:36:48,767 [salt.state       ][INFO    ][32464] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 22:36:48.766551
2017-11-05 22:36:48,767 [salt.state       ][INFO    ][32464] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-11-05 22:36:48,770 [salt.loaded.int.module.cmdmod][INFO    ][32464] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-11-05 22:36:48,866 [salt.state       ][INFO    ][32464] unless execution succeeded
2017-11-05 22:36:48,866 [salt.state       ][INFO    ][32464] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 22:36:48.866073 duration_in_ms=99.521
2017-11-05 22:36:48,867 [salt.state       ][INFO    ][32464] Running state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 22:36:48.867249
2017-11-05 22:36:48,868 [salt.state       ][INFO    ][32464] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'
2017-11-05 22:36:48,870 [salt.loaded.int.module.cmdmod][INFO    ][32464] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-11-05 22:36:48,976 [salt.state       ][INFO    ][32464] unless execution succeeded
2017-11-05 22:36:48,977 [salt.state       ][INFO    ][32464] Completed state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 22:36:48.976765 duration_in_ms=109.515
2017-11-05 22:36:48,978 [salt.state       ][INFO    ][32464] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 22:36:48.977884
2017-11-05 22:36:48,979 [salt.state       ][INFO    ][32464] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'
2017-11-05 22:36:48,981 [salt.loaded.int.module.cmdmod][INFO    ][32464] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-11-05 22:36:49,076 [salt.state       ][INFO    ][32464] unless execution succeeded
2017-11-05 22:36:49,077 [salt.state       ][INFO    ][32464] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 22:36:49.076592 duration_in_ms=98.707
2017-11-05 22:36:49,078 [salt.state       ][INFO    ][32464] Running state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 22:36:49.077733
2017-11-05 22:36:49,078 [salt.state       ][INFO    ][32464] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'
2017-11-05 22:36:49,079 [salt.loaded.int.module.cmdmod][INFO    ][32464] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-11-05 22:36:49,175 [salt.state       ][INFO    ][32464] unless execution succeeded
2017-11-05 22:36:49,176 [salt.state       ][INFO    ][32464] Completed state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 22:36:49.175696 duration_in_ms=97.962
2017-11-05 22:36:49,181 [salt.state       ][INFO    ][32464] Running state [keystone-credential-keys] at time 22:36:49.181029
2017-11-05 22:36:49,182 [salt.state       ][INFO    ][32464] Executing state glusterfs.started for keystone-credential-keys
2017-11-05 22:36:49,182 [salt.loaded.int.module.cmdmod][INFO    ][32464] Executing command 'gluster --version' in directory '/root'
2017-11-05 22:36:49,205 [salt.loaded.int.module.cmdmod][INFO    ][32464] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-05 22:36:49,298 [salt.loaded.int.module.cmdmod][INFO    ][32464] Executing command 'gluster --version' in directory '/root'
2017-11-05 22:36:49,318 [salt.loaded.int.module.cmdmod][INFO    ][32464] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-05 22:36:49,404 [salt.state       ][INFO    ][32464] Volume keystone-credential-keys is already started
2017-11-05 22:36:49,405 [salt.state       ][INFO    ][32464] Completed state [keystone-credential-keys] at time 22:36:49.405212 duration_in_ms=224.182
2017-11-05 22:36:49,411 [salt.minion      ][INFO    ][32464] Returning information for job: 20171105223642899548
2017-11-05 22:36:58,760 [salt.minion      ][INFO    ][24110] User sudo_ubuntu Executing command test.ping with jid 20171105223658751793
2017-11-05 22:36:58,789 [salt.minion      ][INFO    ][32849] Starting a new job with PID 32849
2017-11-05 22:36:58,835 [salt.minion      ][INFO    ][32849] Returning information for job: 20171105223658751793
2017-11-05 22:36:58,964 [salt.minion      ][INFO    ][24110] User sudo_ubuntu Executing command cmd.run with jid 20171105223658952576
2017-11-05 22:36:58,981 [salt.minion      ][INFO    ][32854] Starting a new job with PID 32854
2017-11-05 22:36:58,988 [salt.loaded.int.module.cmdmod][INFO    ][32854] Executing command 'gluster peer status; gluster volume status' in directory '/root'
2017-11-05 22:36:59,169 [salt.minion      ][INFO    ][32854] Returning information for job: 20171105223658952576
2017-11-05 22:43:45,750 [salt.utils.schedule][INFO    ][24110] Running scheduled job: __mine_interval
2017-11-05 23:01:33,488 [salt.minion      ][INFO    ][24110] User sudo_ubuntu Executing command cp.push_dir with jid 20171105230133476871
2017-11-05 23:01:33,518 [salt.minion      ][INFO    ][33054] Starting a new job with PID 33054
