2017-12-01 02:17:59,757 [salt.cli.daemons ][WARNING ][2349] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-12-01 02:55:49,995 [salt.state       ][ERROR   ][3689] No contents found in top file
2017-12-01 02:57:22,289 [salt.utils.parsers][WARNING ][2349] Minion received a SIGTERM. Exiting.
2017-12-01 02:59:35,158 [salt.cli.daemons ][WARNING ][3153] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-12-01 03:01:59,678 [salt.transport.ipc][ERROR   ][3153] Exception occurred while handling stream: [Errno 0] Success
2017-12-01 03:02:40,242 [py.warnings      ][WARNING ][13221] /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-12-01 03:05:17,733 [salt.loaded.int.module.cmdmod][ERROR   ][13221] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-12-01 03:05:17,734 [salt.loaded.int.module.cmdmod][ERROR   ][13221] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-12-01 03:05:24,010 [salt.loaded.int.module.cmdmod][ERROR   ][13221] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-12-01 03:05:24,010 [salt.loaded.int.module.cmdmod][ERROR   ][13221] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-12-01 03:05:31,738 [salt.loaded.int.module.cmdmod][ERROR   ][13221] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-12-01 03:05:31,738 [salt.loaded.int.module.cmdmod][ERROR   ][13221] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-12-01 03:05:40,789 [salt.loaded.int.module.cmdmod][ERROR   ][13221] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-12-01 03:05:40,824 [salt.loaded.int.module.cmdmod][ERROR   ][13221] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-12-01 03:05:48,176 [salt.loaded.int.module.cmdmod][ERROR   ][13221] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-12-01 03:05:48,176 [salt.loaded.int.module.cmdmod][ERROR   ][13221] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-12-01 03:05:53,924 [salt.loaded.int.module.cmdmod][ERROR   ][13221] 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-12-01 03:05:57,467 [salt.state       ][ERROR   ][20654] No contents found in top file
2017-12-01 03:06:04,919 [salt.loaded.int.module.cmdmod][INFO    ][21084] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2017-12-01 03:06:04,925 [salt.loaded.int.module.cmdmod][INFO    ][21084] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2017-12-01 03:06:04,938 [salt.loaded.int.module.cmdmod][INFO    ][21084] Executing command ['systemd-run', '--scope', 'systemctl', 'restart', 'salt-minion.service'] in directory '/root'
2017-12-01 03:06:04,946 [salt.utils.parsers][WARNING ][3153] Minion received a SIGTERM. Exiting.
2017-12-01 03:06:05,194 [salt.cli.daemons ][INFO    ][21188] Setting up the Salt Minion "kvm03.baremetal-mcp-ocata-ovs-ha.local"
2017-12-01 03:06:05,707 [salt.minion      ][INFO    ][21188] Creating minion process manager
2017-12-01 03:06:05,708 [salt.cli.daemons ][WARNING ][21188] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-12-01 03:06:05,708 [salt.cli.daemons ][INFO    ][21188] The Salt Minion is starting up
2017-12-01 03:06:05,708 [salt.minion      ][INFO    ][21188] Minion is starting as user 'root'
2017-12-01 03:06:05,708 [salt.utils.event ][INFO    ][21188] Starting pull socket on /var/run/salt/minion/minion_event_98ff1e569f_pull.ipc
2017-12-01 03:06:06,582 [salt.loaded.int.module.cmdmod][INFO    ][21188] Executing command ['date', '+%z'] in directory '/root'
2017-12-01 03:06:06,597 [salt.utils.schedule][INFO    ][21188] Updating job settings for scheduled job: __mine_interval
2017-12-01 03:06:06,600 [salt.minion      ][INFO    ][21188] Added mine.update to scheduler
2017-12-01 03:06:06,646 [salt.minion      ][INFO    ][21188] Minion is ready to receive requests!
2017-12-01 03:06:07,657 [salt.utils.schedule][INFO    ][21188] Running scheduled job: __mine_interval
2017-12-01 03:06:26,291 [salt.minion      ][INFO    ][21188] User sudo_ubuntu Executing command state.sls with jid 20171201030626287283
2017-12-01 03:06:26,303 [salt.minion      ][INFO    ][21290] Starting a new job with PID 21290
2017-12-01 03:06:28,765 [salt.state       ][INFO    ][21290] Loading fresh modules for state activity
2017-12-01 03:06:28,855 [salt.fileclient  ][INFO    ][21290] Fetching file from saltenv 'base', ** done ** 'salt/control/init.sls'
2017-12-01 03:06:28,877 [salt.fileclient  ][INFO    ][21290] Fetching file from saltenv 'base', ** done ** 'salt/control/virt.sls'
2017-12-01 03:06:28,903 [salt.fileclient  ][INFO    ][21290] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-12-01 03:06:28,972 [salt.fileclient  ][INFO    ][21290] Fetching file from saltenv 'base', ** done ** 'salt/minion/init.sls'
2017-12-01 03:06:28,985 [salt.fileclient  ][INFO    ][21290] Fetching file from saltenv 'base', ** done ** 'salt/minion/service.sls'
2017-12-01 03:06:29,039 [salt.fileclient  ][INFO    ][21290] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-12-01 03:06:29,159 [salt.fileclient  ][INFO    ][21290] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-12-01 03:06:29,180 [salt.fileclient  ][INFO    ][21290] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-12-01 03:06:29,222 [salt.fileclient  ][INFO    ][21290] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-12-01 03:06:29,322 [salt.fileclient  ][INFO    ][21290] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-12-01 03:06:29,336 [salt.fileclient  ][INFO    ][21290] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-12-01 03:06:29,352 [salt.fileclient  ][INFO    ][21290] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-12-01 03:06:29,360 [salt.loaded.int.module.cmdmod][INFO    ][21290] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-12-01 03:06:29,384 [salt.fileclient  ][INFO    ][21290] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-12-01 03:06:29,403 [py.warnings      ][WARNING ][21290] /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-12-01 03:06:29,403 [salt.loaded.int.module.cmdmod][INFO    ][21290] Executing command 'salt-minion --version' in directory '/root'
2017-12-01 03:06:29,674 [salt.fileclient  ][INFO    ][21290] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-12-01 03:06:29,692 [salt.fileclient  ][INFO    ][21290] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-12-01 03:06:29,704 [salt.fileclient  ][INFO    ][21290] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-12-01 03:06:29,715 [salt.fileclient  ][INFO    ][21290] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-12-01 03:06:29,749 [salt.fileclient  ][INFO    ][21290] Fetching file from saltenv 'base', ** done ** 'reclass/meta/meta.yml'
2017-12-01 03:06:29,762 [salt.fileclient  ][INFO    ][21290] Fetching file from saltenv 'base', ** done ** 'reclass/map.jinja'
2017-12-01 03:06:29,783 [salt.fileclient  ][INFO    ][21290] Fetching file from saltenv 'base', ** done ** 'ntp/meta/meta.yml'
2017-12-01 03:06:29,795 [salt.fileclient  ][INFO    ][21290] Fetching file from saltenv 'base', ** done ** 'ntp/map.jinja'
2017-12-01 03:06:29,813 [salt.fileclient  ][INFO    ][21290] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-12-01 03:06:29,911 [salt.fileclient  ][INFO    ][21290] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-12-01 03:06:29,969 [salt.fileclient  ][INFO    ][21290] Fetching file from saltenv 'base', ** done ** 'salt/minion/grains.sls'
2017-12-01 03:06:29,991 [salt.fileclient  ][INFO    ][21290] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-12-01 03:06:30,089 [salt.fileclient  ][INFO    ][21290] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-12-01 03:06:30,109 [salt.fileclient  ][INFO    ][21290] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-12-01 03:06:30,153 [salt.fileclient  ][INFO    ][21290] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-12-01 03:06:30,173 [salt.fileclient  ][INFO    ][21290] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-12-01 03:06:30,185 [salt.fileclient  ][INFO    ][21290] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-12-01 03:06:30,263 [salt.fileclient  ][INFO    ][21290] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-12-01 03:06:30,270 [salt.loaded.int.module.cmdmod][INFO    ][21290] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-12-01 03:06:30,336 [salt.fileclient  ][INFO    ][21290] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-12-01 03:06:30,352 [salt.loaded.int.module.cmdmod][INFO    ][21290] Executing command 'salt-minion --version' in directory '/root'
2017-12-01 03:06:30,618 [salt.fileclient  ][INFO    ][21290] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-12-01 03:06:30,635 [salt.fileclient  ][INFO    ][21290] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-12-01 03:06:30,647 [salt.fileclient  ][INFO    ][21290] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-12-01 03:06:30,659 [salt.fileclient  ][INFO    ][21290] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-12-01 03:06:30,704 [salt.fileclient  ][INFO    ][21290] Fetching file from saltenv 'base', ** done ** 'reclass/meta/meta.yml'
2017-12-01 03:06:30,721 [salt.fileclient  ][INFO    ][21290] Fetching file from saltenv 'base', ** done ** 'reclass/map.jinja'
2017-12-01 03:06:30,744 [salt.fileclient  ][INFO    ][21290] Fetching file from saltenv 'base', ** done ** 'ntp/meta/meta.yml'
2017-12-01 03:06:30,757 [salt.fileclient  ][INFO    ][21290] Fetching file from saltenv 'base', ** done ** 'ntp/map.jinja'
2017-12-01 03:06:30,773 [salt.fileclient  ][INFO    ][21290] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-12-01 03:06:30,830 [salt.fileclient  ][INFO    ][21290] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-12-01 03:06:30,943 [salt.fileclient  ][INFO    ][21290] Fetching file from saltenv 'base', ** done ** 'salt/minion/cert.sls'
2017-12-01 03:06:31,039 [salt.fileclient  ][INFO    ][21290] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-12-01 03:06:31,443 [salt.state       ][INFO    ][21290] Running state [salt-minion] at time 03:06:31.442798
2017-12-01 03:06:31,443 [salt.state       ][INFO    ][21290] Executing state pkg.installed for salt-minion
2017-12-01 03:06:31,444 [salt.loaded.int.module.cmdmod][INFO    ][21290] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-01 03:06:31,693 [salt.state       ][INFO    ][21290] Package salt-minion is already installed
2017-12-01 03:06:31,693 [salt.state       ][INFO    ][21290] Completed state [salt-minion] at time 03:06:31.693004 duration_in_ms=250.206
2017-12-01 03:06:31,693 [salt.state       ][INFO    ][21290] Running state [salt_minion_dependency_packages] at time 03:06:31.693213
2017-12-01 03:06:31,693 [salt.state       ][INFO    ][21290] Executing state pkg.installed for salt_minion_dependency_packages
2017-12-01 03:06:31,696 [salt.state       ][INFO    ][21290] All specified packages are already installed
2017-12-01 03:06:31,696 [salt.state       ][INFO    ][21290] Completed state [salt_minion_dependency_packages] at time 03:06:31.696097 duration_in_ms=2.885
2017-12-01 03:06:31,698 [salt.state       ][INFO    ][21290] Running state [/etc/salt/minion.d/minion.conf] at time 03:06:31.697487
2017-12-01 03:06:31,698 [salt.state       ][INFO    ][21290] Executing state file.managed for /etc/salt/minion.d/minion.conf
2017-12-01 03:06:31,720 [salt.fileclient  ][INFO    ][21290] Fetching file from saltenv 'base', ** done ** 'salt/files/minion.conf'
2017-12-01 03:06:31,764 [salt.fileclient  ][INFO    ][21290] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-12-01 03:06:31,875 [salt.fileclient  ][INFO    ][21290] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-12-01 03:06:31,910 [salt.state       ][INFO    ][21290] File /etc/salt/minion.d/minion.conf is in the correct state
2017-12-01 03:06:31,911 [salt.state       ][INFO    ][21290] Completed state [/etc/salt/minion.d/minion.conf] at time 03:06:31.910568 duration_in_ms=213.081
2017-12-01 03:06:31,911 [salt.state       ][INFO    ][21290] Running state [/etc/salt/minion.d/_virt.conf] at time 03:06:31.910886
2017-12-01 03:06:31,911 [salt.state       ][INFO    ][21290] Executing state file.managed for /etc/salt/minion.d/_virt.conf
2017-12-01 03:06:31,951 [salt.state       ][INFO    ][21290] File /etc/salt/minion.d/_virt.conf is in the correct state
2017-12-01 03:06:31,951 [salt.state       ][INFO    ][21290] Completed state [/etc/salt/minion.d/_virt.conf] at time 03:06:31.951240 duration_in_ms=40.352
2017-12-01 03:06:31,953 [salt.state       ][INFO    ][21290] Running state [salt-minion] at time 03:06:31.952940
2017-12-01 03:06:31,953 [salt.state       ][INFO    ][21290] Executing state service.running for salt-minion
2017-12-01 03:06:31,954 [salt.loaded.int.module.cmdmod][INFO    ][21290] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2017-12-01 03:06:31,968 [salt.loaded.int.module.cmdmod][INFO    ][21290] Executing command ['systemctl', 'is-active', 'salt-minion.service'] in directory '/root'
2017-12-01 03:06:31,974 [salt.loaded.int.module.cmdmod][INFO    ][21290] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2017-12-01 03:06:31,981 [salt.state       ][INFO    ][21290] The service salt-minion is already running
2017-12-01 03:06:31,981 [salt.state       ][INFO    ][21290] Completed state [salt-minion] at time 03:06:31.980928 duration_in_ms=27.987
2017-12-01 03:06:31,982 [salt.state       ][INFO    ][21290] Running state [/etc/salt/grains.d] at time 03:06:31.982273
2017-12-01 03:06:31,982 [salt.state       ][INFO    ][21290] Executing state file.directory for /etc/salt/grains.d
2017-12-01 03:06:31,983 [salt.state       ][INFO    ][21290] Directory /etc/salt/grains.d is in the correct state
2017-12-01 03:06:31,983 [salt.state       ][INFO    ][21290] Completed state [/etc/salt/grains.d] at time 03:06:31.983090 duration_in_ms=0.817
2017-12-01 03:06:31,983 [salt.state       ][INFO    ][21290] Running state [/etc/salt/grains] at time 03:06:31.983474
2017-12-01 03:06:31,984 [salt.state       ][INFO    ][21290] Executing state file.managed for /etc/salt/grains
2017-12-01 03:06:31,984 [salt.state       ][INFO    ][21290] File /etc/salt/grains exists with proper permissions. No changes made.
2017-12-01 03:06:31,984 [salt.state       ][INFO    ][21290] Completed state [/etc/salt/grains] at time 03:06:31.984032 duration_in_ms=0.559
2017-12-01 03:06:31,984 [salt.state       ][INFO    ][21290] Running state [/etc/salt/grains.d/placeholder] at time 03:06:31.984286
2017-12-01 03:06:31,984 [salt.state       ][INFO    ][21290] Executing state file.managed for /etc/salt/grains.d/placeholder
2017-12-01 03:06:31,985 [salt.state       ][INFO    ][21290] File /etc/salt/grains.d/placeholder exists with proper permissions. No changes made.
2017-12-01 03:06:31,985 [salt.state       ][INFO    ][21290] Completed state [/etc/salt/grains.d/placeholder] at time 03:06:31.984826 duration_in_ms=0.539
2017-12-01 03:06:31,985 [salt.state       ][INFO    ][21290] Running state [/etc/salt/grains.d/sphinx] at time 03:06:31.985111
2017-12-01 03:06:31,985 [salt.state       ][INFO    ][21290] Executing state file.managed for /etc/salt/grains.d/sphinx
2017-12-01 03:06:32,141 [salt.state       ][INFO    ][21290] File changed:
--- 
+++ 
@@ -49,7 +49,6 @@
               - 10.167.4.143
               - 127.0.0.1
               - 192.168.11.251
-              - 192.168.122.1
         system:
           name: System
           param:

2017-12-01 03:06:32,142 [salt.state       ][INFO    ][21290] Completed state [/etc/salt/grains.d/sphinx] at time 03:06:32.141718 duration_in_ms=156.605
2017-12-01 03:06:32,142 [salt.state       ][INFO    ][21290] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 03:06:32.142410
2017-12-01 03:06:32,143 [salt.state       ][INFO    ][21290] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-12-01 03:06:32,143 [salt.state       ][INFO    ][21290] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-12-01 03:06:32,143 [salt.state       ][INFO    ][21290] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 03:06:32.142953 duration_in_ms=0.543
2017-12-01 03:06:32,143 [salt.state       ][INFO    ][21290] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 03:06:32.143082
2017-12-01 03:06:32,143 [salt.state       ][INFO    ][21290] Executing state cmd.mod_watch for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-12-01 03:06:32,144 [salt.loaded.int.module.cmdmod][INFO    ][21290] Executing command 'python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"' in directory '/root'
2017-12-01 03:06:32,224 [salt.state       ][INFO    ][21290] {'pid': 21340, 'retcode': 0, 'stderr': '', 'stdout': ''}
2017-12-01 03:06:32,225 [salt.state       ][INFO    ][21290] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 03:06:32.224685 duration_in_ms=81.601
2017-12-01 03:06:32,225 [salt.state       ][INFO    ][21290] Running state [/etc/salt/grains.d/dns_records] at time 03:06:32.225228
2017-12-01 03:06:32,226 [salt.state       ][INFO    ][21290] Executing state file.managed for /etc/salt/grains.d/dns_records
2017-12-01 03:06:32,348 [salt.state       ][INFO    ][21290] File /etc/salt/grains.d/dns_records is in the correct state
2017-12-01 03:06:32,349 [salt.state       ][INFO    ][21290] Completed state [/etc/salt/grains.d/dns_records] at time 03:06:32.348523 duration_in_ms=123.295
2017-12-01 03:06:32,349 [salt.state       ][INFO    ][21290] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 03:06:32.349277
2017-12-01 03:06:32,350 [salt.state       ][INFO    ][21290] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"
2017-12-01 03:06:32,350 [salt.state       ][INFO    ][21290] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"
2017-12-01 03:06:32,350 [salt.state       ][INFO    ][21290] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 03:06:32.349928 duration_in_ms=0.65
2017-12-01 03:06:32,350 [salt.state       ][INFO    ][21290] Running state [/etc/salt/grains.d/salt] at time 03:06:32.350251
2017-12-01 03:06:32,351 [salt.state       ][INFO    ][21290] Executing state file.managed for /etc/salt/grains.d/salt
2017-12-01 03:06:32,561 [salt.state       ][INFO    ][21290] File /etc/salt/grains.d/salt is in the correct state
2017-12-01 03:06:32,562 [salt.state       ][INFO    ][21290] Completed state [/etc/salt/grains.d/salt] at time 03:06:32.561645 duration_in_ms=211.393
2017-12-01 03:06:32,562 [salt.state       ][INFO    ][21290] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 03:06:32.562384
2017-12-01 03:06:32,563 [salt.state       ][INFO    ][21290] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2017-12-01 03:06:32,563 [salt.state       ][INFO    ][21290] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2017-12-01 03:06:32,563 [salt.state       ][INFO    ][21290] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 03:06:32.563016 duration_in_ms=0.632
2017-12-01 03:06:32,564 [salt.state       ][INFO    ][21290] Running state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 03:06:32.564160
2017-12-01 03:06:32,564 [salt.state       ][INFO    ][21290] Executing state cmd.wait for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-12-01 03:06:32,565 [salt.state       ][INFO    ][21290] No changes made for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-12-01 03:06:32,565 [salt.state       ][INFO    ][21290] Completed state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 03:06:32.564624 duration_in_ms=0.464
2017-12-01 03:06:32,565 [salt.state       ][INFO    ][21290] Running state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 03:06:32.564740
2017-12-01 03:06:32,565 [salt.state       ][INFO    ][21290] Executing state cmd.mod_watch for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-12-01 03:06:32,566 [salt.loaded.int.module.cmdmod][INFO    ][21290] Executing command 'cat /etc/salt/grains.d/* > /etc/salt/grains' in directory '/root'
2017-12-01 03:06:32,574 [salt.state       ][INFO    ][21290] {'pid': 21342, 'retcode': 0, 'stderr': '', 'stdout': ''}
2017-12-01 03:06:32,574 [salt.state       ][INFO    ][21290] Completed state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 03:06:32.574274 duration_in_ms=9.532
2017-12-01 03:06:32,575 [salt.state       ][INFO    ][21290] Running state [mine.update] at time 03:06:32.574928
2017-12-01 03:06:32,575 [salt.state       ][INFO    ][21290] Executing state module.wait for mine.update
2017-12-01 03:06:32,575 [salt.state       ][INFO    ][21290] No changes made for mine.update
2017-12-01 03:06:32,576 [salt.state       ][INFO    ][21290] Completed state [mine.update] at time 03:06:32.575572 duration_in_ms=0.643
2017-12-01 03:06:32,576 [salt.state       ][INFO    ][21290] Running state [mine.update] at time 03:06:32.575740
2017-12-01 03:06:32,576 [salt.state       ][INFO    ][21290] Executing state module.mod_watch for mine.update
2017-12-01 03:06:33,095 [salt.state       ][INFO    ][21290] {'ret': True}
2017-12-01 03:06:33,095 [salt.state       ][INFO    ][21290] Completed state [mine.update] at time 03:06:33.094862 duration_in_ms=519.121
2017-12-01 03:06:33,095 [salt.state       ][INFO    ][21290] Running state [ca-certificates] at time 03:06:33.095139
2017-12-01 03:06:33,095 [salt.state       ][INFO    ][21290] Executing state pkg.installed for ca-certificates
2017-12-01 03:06:33,099 [salt.state       ][INFO    ][21290] Package ca-certificates is already installed
2017-12-01 03:06:33,099 [salt.state       ][INFO    ][21290] Completed state [ca-certificates] at time 03:06:33.098975 duration_in_ms=3.836
2017-12-01 03:06:33,100 [salt.state       ][INFO    ][21290] Running state [update-ca-certificates] at time 03:06:33.099598
2017-12-01 03:06:33,100 [salt.state       ][INFO    ][21290] Executing state cmd.wait for update-ca-certificates
2017-12-01 03:06:33,100 [salt.state       ][INFO    ][21290] No changes made for update-ca-certificates
2017-12-01 03:06:33,100 [salt.state       ][INFO    ][21290] Completed state [update-ca-certificates] at time 03:06:33.100227 duration_in_ms=0.629
2017-12-01 03:06:33,100 [salt.state       ][INFO    ][21290] Running state [libvirt-dev] at time 03:06:33.100418
2017-12-01 03:06:33,101 [salt.state       ][INFO    ][21290] Executing state pkg.installed for libvirt-dev
2017-12-01 03:06:33,103 [salt.state       ][INFO    ][21290] Package libvirt-dev is already installed
2017-12-01 03:06:33,104 [salt.state       ][INFO    ][21290] Completed state [libvirt-dev] at time 03:06:33.103533 duration_in_ms=3.115
2017-12-01 03:06:33,104 [salt.state       ][INFO    ][21290] Running state [pkg-config] at time 03:06:33.103728
2017-12-01 03:06:33,104 [salt.state       ][INFO    ][21290] Executing state pkg.installed for pkg-config
2017-12-01 03:06:33,107 [salt.state       ][INFO    ][21290] Package pkg-config is already installed
2017-12-01 03:06:33,107 [salt.state       ][INFO    ][21290] Completed state [pkg-config] at time 03:06:33.106827 duration_in_ms=3.1
2017-12-01 03:06:33,107 [salt.state       ][INFO    ][21290] Running state [virtng.init] at time 03:06:33.107011
2017-12-01 03:06:33,107 [salt.state       ][INFO    ][21290] Executing state module.run for virtng.init
2017-12-01 03:06:33,167 [salt.loaded.int.module.cmdmod][INFO    ][21290] Executing command ['git', '--version'] in directory '/root'
2017-12-01 03:06:33,269 [salt.loaded.int.module.cmdmod][INFO    ][21290] Executing command 'virsh list --all --name| grep -E "^mdb03.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-12-01 03:06:33,287 [salt.state       ][INFO    ][21290] unless execution succeeded
2017-12-01 03:06:33,442 [salt.state       ][INFO    ][21290] Completed state [virtng.init] at time 03:06:33.441958 duration_in_ms=334.945
2017-12-01 03:06:33,442 [salt.state       ][INFO    ][21290] Running state [virt.set_autostart] at time 03:06:33.442342
2017-12-01 03:06:33,443 [salt.state       ][INFO    ][21290] Executing state module.run for virt.set_autostart
2017-12-01 03:06:33,445 [salt.loaded.int.module.cmdmod][INFO    ][21290] Executing command 'virsh list --autostart --name| grep -E "^mdb03.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-12-01 03:06:33,464 [salt.state       ][INFO    ][21290] unless execution succeeded
2017-12-01 03:06:33,464 [salt.state       ][INFO    ][21290] Completed state [virt.set_autostart] at time 03:06:33.463732 duration_in_ms=21.389
2017-12-01 03:06:33,464 [salt.state       ][INFO    ][21290] Running state [virtng.init] at time 03:06:33.463996
2017-12-01 03:06:33,464 [salt.state       ][INFO    ][21290] Executing state module.run for virtng.init
2017-12-01 03:06:33,466 [salt.loaded.int.module.cmdmod][INFO    ][21290] Executing command 'virsh list --all --name| grep -E "^dbs03.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-12-01 03:06:33,482 [salt.state       ][INFO    ][21290] unless execution succeeded
2017-12-01 03:06:33,482 [salt.state       ][INFO    ][21290] Completed state [virtng.init] at time 03:06:33.482434 duration_in_ms=18.437
2017-12-01 03:06:33,483 [salt.state       ][INFO    ][21290] Running state [virt.set_autostart] at time 03:06:33.482701
2017-12-01 03:06:33,483 [salt.state       ][INFO    ][21290] Executing state module.run for virt.set_autostart
2017-12-01 03:06:33,485 [salt.loaded.int.module.cmdmod][INFO    ][21290] Executing command 'virsh list --autostart --name| grep -E "^dbs03.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-12-01 03:06:33,499 [salt.state       ][INFO    ][21290] unless execution succeeded
2017-12-01 03:06:33,499 [salt.state       ][INFO    ][21290] Completed state [virt.set_autostart] at time 03:06:33.499097 duration_in_ms=16.396
2017-12-01 03:06:33,499 [salt.state       ][INFO    ][21290] Running state [virtng.init] at time 03:06:33.499330
2017-12-01 03:06:33,500 [salt.state       ][INFO    ][21290] Executing state module.run for virtng.init
2017-12-01 03:06:33,502 [salt.loaded.int.module.cmdmod][INFO    ][21290] Executing command 'virsh list --all --name| grep -E "^prx02.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-12-01 03:06:33,514 [salt.state       ][INFO    ][21290] unless execution succeeded
2017-12-01 03:06:33,515 [salt.state       ][INFO    ][21290] Completed state [virtng.init] at time 03:06:33.514665 duration_in_ms=15.335
2017-12-01 03:06:33,515 [salt.state       ][INFO    ][21290] Running state [virt.set_autostart] at time 03:06:33.514909
2017-12-01 03:06:33,515 [salt.state       ][INFO    ][21290] Executing state module.run for virt.set_autostart
2017-12-01 03:06:33,517 [salt.loaded.int.module.cmdmod][INFO    ][21290] Executing command 'virsh list --autostart --name| grep -E "^prx02.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-12-01 03:06:33,530 [salt.state       ][INFO    ][21290] unless execution succeeded
2017-12-01 03:06:33,530 [salt.state       ][INFO    ][21290] Completed state [virt.set_autostart] at time 03:06:33.530053 duration_in_ms=15.144
2017-12-01 03:06:33,530 [salt.state       ][INFO    ][21290] Running state [virtng.init] at time 03:06:33.530303
2017-12-01 03:06:33,531 [salt.state       ][INFO    ][21290] Executing state module.run for virtng.init
2017-12-01 03:06:33,532 [salt.loaded.int.module.cmdmod][INFO    ][21290] Executing command 'virsh list --all --name| grep -E "^msg03.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-12-01 03:06:33,550 [salt.state       ][INFO    ][21290] unless execution succeeded
2017-12-01 03:06:33,550 [salt.state       ][INFO    ][21290] Completed state [virtng.init] at time 03:06:33.550023 duration_in_ms=19.719
2017-12-01 03:06:33,550 [salt.state       ][INFO    ][21290] Running state [virt.set_autostart] at time 03:06:33.550248
2017-12-01 03:06:33,550 [salt.state       ][INFO    ][21290] Executing state module.run for virt.set_autostart
2017-12-01 03:06:33,552 [salt.loaded.int.module.cmdmod][INFO    ][21290] Executing command 'virsh list --autostart --name| grep -E "^msg03.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-12-01 03:06:33,567 [salt.state       ][INFO    ][21290] unless execution succeeded
2017-12-01 03:06:33,567 [salt.state       ][INFO    ][21290] Completed state [virt.set_autostart] at time 03:06:33.567082 duration_in_ms=16.833
2017-12-01 03:06:33,567 [salt.state       ][INFO    ][21290] Running state [virtng.init] at time 03:06:33.567301
2017-12-01 03:06:33,567 [salt.state       ][INFO    ][21290] Executing state module.run for virtng.init
2017-12-01 03:06:33,569 [salt.loaded.int.module.cmdmod][INFO    ][21290] Executing command 'virsh list --all --name| grep -E "^ctl03.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-12-01 03:06:33,584 [salt.state       ][INFO    ][21290] unless execution succeeded
2017-12-01 03:06:33,584 [salt.state       ][INFO    ][21290] Completed state [virtng.init] at time 03:06:33.583997 duration_in_ms=16.695
2017-12-01 03:06:33,584 [salt.state       ][INFO    ][21290] Running state [virt.set_autostart] at time 03:06:33.584236
2017-12-01 03:06:33,584 [salt.state       ][INFO    ][21290] Executing state module.run for virt.set_autostart
2017-12-01 03:06:33,586 [salt.loaded.int.module.cmdmod][INFO    ][21290] Executing command 'virsh list --autostart --name| grep -E "^ctl03.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-12-01 03:06:33,603 [salt.state       ][INFO    ][21290] unless execution succeeded
2017-12-01 03:06:33,603 [salt.state       ][INFO    ][21290] Completed state [virt.set_autostart] at time 03:06:33.603296 duration_in_ms=19.06
2017-12-01 03:06:33,606 [salt.minion      ][INFO    ][21290] Returning information for job: 20171201030626287283
2017-12-01 03:07:23,019 [salt.minion      ][INFO    ][21188] User sudo_ubuntu Executing command saltutil.sync_all with jid 20171201030723012115
2017-12-01 03:07:23,036 [salt.minion      ][INFO    ][21397] Starting a new job with PID 21397
2017-12-01 03:07:26,348 [salt.state       ][INFO    ][21397] Loading fresh modules for state activity
2017-12-01 03:07:26,371 [salt.state       ][ERROR   ][21397] No contents found in top file
2017-12-01 03:07:26,372 [salt.utils.extmods][INFO    ][21397] Creating module dir '/var/cache/salt/minion/extmods/beacons'
2017-12-01 03:07:26,375 [salt.utils.extmods][INFO    ][21397] Syncing beacons for environment 'base'
2017-12-01 03:07:26,375 [salt.utils.extmods][INFO    ][21397] Loading cache from salt://_beacons, for base)
2017-12-01 03:07:26,375 [salt.fileclient  ][INFO    ][21397] Caching directory '_beacons/' for environment 'base'
2017-12-01 03:07:26,396 [salt.utils.extmods][INFO    ][21397] Syncing modules for environment 'base'
2017-12-01 03:07:26,396 [salt.utils.extmods][INFO    ][21397] Loading cache from salt://_modules, for base)
2017-12-01 03:07:26,396 [salt.fileclient  ][INFO    ][21397] Caching directory '_modules/' for environment 'base'
2017-12-01 03:07:26,437 [salt.fileclient  ][INFO    ][21397] Fetching file from saltenv 'base', ** done ** '_modules/avinetworks.py'
2017-12-01 03:07:26,471 [salt.fileclient  ][INFO    ][21397] Fetching file from saltenv 'base', ** done ** '_modules/ceph_ng.py'
2017-12-01 03:07:26,490 [salt.fileclient  ][INFO    ][21397] Fetching file from saltenv 'base', ** done ** '_modules/cinderng.py'
2017-12-01 03:07:26,503 [salt.fileclient  ][INFO    ][21397] Fetching file from saltenv 'base', ** done ** '_modules/contrail.py'
2017-12-01 03:07:26,512 [salt.fileclient  ][INFO    ][21397] Fetching file from saltenv 'base', ** done ** '_modules/creds.py'
2017-12-01 03:07:26,523 [salt.fileclient  ][INFO    ][21397] Fetching file from saltenv 'base', ** done ** '_modules/devops_utils.py'
2017-12-01 03:07:26,550 [salt.fileclient  ][INFO    ][21397] Fetching file from saltenv 'base', ** done ** '_modules/encode_json.py'
2017-12-01 03:07:26,566 [salt.fileclient  ][INFO    ][21397] Fetching file from saltenv 'base', ** done ** '_modules/gerrit.py'
2017-12-01 03:07:26,577 [salt.fileclient  ][INFO    ][21397] Fetching file from saltenv 'base', ** done ** '_modules/glanceng.py'
2017-12-01 03:07:26,591 [salt.fileclient  ][INFO    ][21397] Fetching file from saltenv 'base', ** done ** '_modules/heat.py'
2017-12-01 03:07:26,602 [salt.fileclient  ][INFO    ][21397] Fetching file from saltenv 'base', ** done ** '_modules/heka_alarming.py'
2017-12-01 03:07:26,616 [salt.fileclient  ][INFO    ][21397] Fetching file from saltenv 'base', ** done ** '_modules/helm.py'
2017-12-01 03:07:26,625 [salt.fileclient  ][INFO    ][21397] Fetching file from saltenv 'base', ** done ** '_modules/jenkins_common.py'
2017-12-01 03:07:26,636 [salt.fileclient  ][INFO    ][21397] Fetching file from saltenv 'base', ** done ** '_modules/keystone_policy.py'
2017-12-01 03:07:26,642 [salt.fileclient  ][INFO    ][21397] Fetching file from saltenv 'base', ** done ** '_modules/linux_hosts.py'
2017-12-01 03:07:26,656 [salt.fileclient  ][INFO    ][21397] Fetching file from saltenv 'base', ** done ** '_modules/linux_netlink.py'
2017-12-01 03:07:26,826 [salt.fileclient  ][INFO    ][21397] Fetching file from saltenv 'base', ** done ** '_modules/maas.py'
2017-12-01 03:07:26,838 [salt.fileclient  ][INFO    ][21397] Fetching file from saltenv 'base', ** done ** '_modules/maas_client.py'
2017-12-01 03:07:26,863 [salt.fileclient  ][INFO    ][21397] Fetching file from saltenv 'base', ** done ** '_modules/modelutils.py'
2017-12-01 03:07:26,894 [salt.fileclient  ][INFO    ][21397] Fetching file from saltenv 'base', ** done ** '_modules/multipart.py'
2017-12-01 03:07:26,904 [salt.fileclient  ][INFO    ][21397] Fetching file from saltenv 'base', ** done ** '_modules/nagios_alarming.py'
2017-12-01 03:07:26,917 [salt.fileclient  ][INFO    ][21397] Fetching file from saltenv 'base', ** done ** '_modules/neutronng.py'
2017-12-01 03:07:26,953 [salt.fileclient  ][INFO    ][21397] Fetching file from saltenv 'base', ** done ** '_modules/novang.py'
2017-12-01 03:07:26,984 [salt.fileclient  ][INFO    ][21397] Fetching file from saltenv 'base', ** done ** '_modules/reclass.py'
2017-12-01 03:07:26,993 [salt.fileclient  ][INFO    ][21397] Fetching file from saltenv 'base', ** done ** '_modules/rsyslog_util.py'
2017-12-01 03:07:27,009 [salt.fileclient  ][INFO    ][21397] Fetching file from saltenv 'base', ** done ** '_modules/rundeck.py'
2017-12-01 03:07:27,028 [salt.fileclient  ][INFO    ][21397] Fetching file from saltenv 'base', ** done ** '_modules/saltkey.py'
2017-12-01 03:07:27,038 [salt.fileclient  ][INFO    ][21397] Fetching file from saltenv 'base', ** done ** '_modules/saltresource.py'
2017-12-01 03:07:27,077 [salt.fileclient  ][INFO    ][21397] Fetching file from saltenv 'base', ** done ** '_modules/seedng.py'
2017-12-01 03:07:27,104 [salt.fileclient  ][INFO    ][21397] Fetching file from saltenv 'base', ** done ** '_modules/testing/credentials.py'
2017-12-01 03:07:27,128 [salt.fileclient  ][INFO    ][21397] Fetching file from saltenv 'base', ** done ** '_modules/testing/django.py'
2017-12-01 03:07:27,141 [salt.fileclient  ][INFO    ][21397] Fetching file from saltenv 'base', ** done ** '_modules/testing/django_client_proxy.py'
2017-12-01 03:07:27,151 [salt.fileclient  ][INFO    ][21397] Fetching file from saltenv 'base', ** done ** '_modules/utils.py'
2017-12-01 03:07:27,192 [salt.fileclient  ][INFO    ][21397] Fetching file from saltenv 'base', ** done ** '_modules/virtng.py'
2017-12-01 03:07:27,195 [salt.utils.extmods][INFO    ][21397] Copying '/var/cache/salt/minion/files/base/_modules/__init__.py' to '/var/cache/salt/minion/extmods/modules/__init__.py'
2017-12-01 03:07:27,195 [salt.utils.extmods][INFO    ][21397] Copying '/var/cache/salt/minion/files/base/_modules/avinetworks.py' to '/var/cache/salt/minion/extmods/modules/avinetworks.py'
2017-12-01 03:07:27,196 [salt.utils.extmods][INFO    ][21397] Copying '/var/cache/salt/minion/files/base/_modules/ceph_ng.py' to '/var/cache/salt/minion/extmods/modules/ceph_ng.py'
2017-12-01 03:07:27,196 [salt.utils.extmods][INFO    ][21397] Copying '/var/cache/salt/minion/files/base/_modules/cinderng.py' to '/var/cache/salt/minion/extmods/modules/cinderng.py'
2017-12-01 03:07:27,196 [salt.utils.extmods][INFO    ][21397] Copying '/var/cache/salt/minion/files/base/_modules/contrail.py' to '/var/cache/salt/minion/extmods/modules/contrail.py'
2017-12-01 03:07:27,197 [salt.utils.extmods][INFO    ][21397] Copying '/var/cache/salt/minion/files/base/_modules/creds.py' to '/var/cache/salt/minion/extmods/modules/creds.py'
2017-12-01 03:07:27,197 [salt.utils.extmods][INFO    ][21397] Copying '/var/cache/salt/minion/files/base/_modules/devops_utils.py' to '/var/cache/salt/minion/extmods/modules/devops_utils.py'
2017-12-01 03:07:27,197 [salt.utils.extmods][INFO    ][21397] Copying '/var/cache/salt/minion/files/base/_modules/encode_json.py' to '/var/cache/salt/minion/extmods/modules/encode_json.py'
2017-12-01 03:07:27,197 [salt.utils.extmods][INFO    ][21397] Copying '/var/cache/salt/minion/files/base/_modules/gerrit.py' to '/var/cache/salt/minion/extmods/modules/gerrit.py'
2017-12-01 03:07:27,197 [salt.utils.extmods][INFO    ][21397] Copying '/var/cache/salt/minion/files/base/_modules/glanceng.py' to '/var/cache/salt/minion/extmods/modules/glanceng.py'
2017-12-01 03:07:27,198 [salt.utils.extmods][INFO    ][21397] Copying '/var/cache/salt/minion/files/base/_modules/heat.py' to '/var/cache/salt/minion/extmods/modules/heat.py'
2017-12-01 03:07:27,198 [salt.utils.extmods][INFO    ][21397] Copying '/var/cache/salt/minion/files/base/_modules/heka_alarming.py' to '/var/cache/salt/minion/extmods/modules/heka_alarming.py'
2017-12-01 03:07:27,198 [salt.utils.extmods][INFO    ][21397] Copying '/var/cache/salt/minion/files/base/_modules/helm.py' to '/var/cache/salt/minion/extmods/modules/helm.py'
2017-12-01 03:07:27,198 [salt.utils.extmods][INFO    ][21397] Copying '/var/cache/salt/minion/files/base/_modules/jenkins_common.py' to '/var/cache/salt/minion/extmods/modules/jenkins_common.py'
2017-12-01 03:07:27,199 [salt.utils.extmods][INFO    ][21397] Copying '/var/cache/salt/minion/files/base/_modules/keystone_policy.py' to '/var/cache/salt/minion/extmods/modules/keystone_policy.py'
2017-12-01 03:07:27,199 [salt.utils.extmods][INFO    ][21397] Copying '/var/cache/salt/minion/files/base/_modules/linux_hosts.py' to '/var/cache/salt/minion/extmods/modules/linux_hosts.py'
2017-12-01 03:07:27,199 [salt.utils.extmods][INFO    ][21397] Copying '/var/cache/salt/minion/files/base/_modules/linux_netlink.py' to '/var/cache/salt/minion/extmods/modules/linux_netlink.py'
2017-12-01 03:07:27,199 [salt.utils.extmods][INFO    ][21397] Copying '/var/cache/salt/minion/files/base/_modules/maas.py' to '/var/cache/salt/minion/extmods/modules/maas.py'
2017-12-01 03:07:27,199 [salt.utils.extmods][INFO    ][21397] Copying '/var/cache/salt/minion/files/base/_modules/maas_client.py' to '/var/cache/salt/minion/extmods/modules/maas_client.py'
2017-12-01 03:07:27,200 [salt.utils.extmods][INFO    ][21397] Copying '/var/cache/salt/minion/files/base/_modules/modelutils.py' to '/var/cache/salt/minion/extmods/modules/modelutils.py'
2017-12-01 03:07:27,200 [salt.utils.extmods][INFO    ][21397] Copying '/var/cache/salt/minion/files/base/_modules/multipart.py' to '/var/cache/salt/minion/extmods/modules/multipart.py'
2017-12-01 03:07:27,200 [salt.utils.extmods][INFO    ][21397] Copying '/var/cache/salt/minion/files/base/_modules/nagios_alarming.py' to '/var/cache/salt/minion/extmods/modules/nagios_alarming.py'
2017-12-01 03:07:27,201 [salt.utils.extmods][INFO    ][21397] Copying '/var/cache/salt/minion/files/base/_modules/neutronng.py' to '/var/cache/salt/minion/extmods/modules/neutronng.py'
2017-12-01 03:07:27,201 [salt.utils.extmods][INFO    ][21397] Copying '/var/cache/salt/minion/files/base/_modules/novang.py' to '/var/cache/salt/minion/extmods/modules/novang.py'
2017-12-01 03:07:27,202 [salt.utils.extmods][INFO    ][21397] Copying '/var/cache/salt/minion/files/base/_modules/reclass.py' to '/var/cache/salt/minion/extmods/modules/reclass.py'
2017-12-01 03:07:27,202 [salt.utils.extmods][INFO    ][21397] Copying '/var/cache/salt/minion/files/base/_modules/rsyslog_util.py' to '/var/cache/salt/minion/extmods/modules/rsyslog_util.py'
2017-12-01 03:07:27,202 [salt.utils.extmods][INFO    ][21397] Copying '/var/cache/salt/minion/files/base/_modules/rundeck.py' to '/var/cache/salt/minion/extmods/modules/rundeck.py'
2017-12-01 03:07:27,202 [salt.utils.extmods][INFO    ][21397] Copying '/var/cache/salt/minion/files/base/_modules/saltkey.py' to '/var/cache/salt/minion/extmods/modules/saltkey.py'
2017-12-01 03:07:27,203 [salt.utils.extmods][INFO    ][21397] Copying '/var/cache/salt/minion/files/base/_modules/saltresource.py' to '/var/cache/salt/minion/extmods/modules/saltresource.py'
2017-12-01 03:07:27,203 [salt.utils.extmods][INFO    ][21397] Copying '/var/cache/salt/minion/files/base/_modules/seedng.py' to '/var/cache/salt/minion/extmods/modules/seedng.py'
2017-12-01 03:07:27,203 [salt.utils.extmods][INFO    ][21397] Copying '/var/cache/salt/minion/files/base/_modules/testing/__init__.py' to '/var/cache/salt/minion/extmods/modules/testing/__init__.py'
2017-12-01 03:07:27,203 [salt.utils.extmods][INFO    ][21397] Copying '/var/cache/salt/minion/files/base/_modules/testing/credentials.py' to '/var/cache/salt/minion/extmods/modules/testing/credentials.py'
2017-12-01 03:07:27,203 [salt.utils.extmods][INFO    ][21397] Copying '/var/cache/salt/minion/files/base/_modules/testing/django.py' to '/var/cache/salt/minion/extmods/modules/testing/django.py'
2017-12-01 03:07:27,204 [salt.utils.extmods][INFO    ][21397] 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-12-01 03:07:27,204 [salt.utils.extmods][INFO    ][21397] Copying '/var/cache/salt/minion/files/base/_modules/utils.py' to '/var/cache/salt/minion/extmods/modules/utils.py'
2017-12-01 03:07:27,204 [salt.utils.extmods][INFO    ][21397] Copying '/var/cache/salt/minion/files/base/_modules/virtng.py' to '/var/cache/salt/minion/extmods/modules/virtng.py'
2017-12-01 03:07:27,210 [salt.utils.extmods][INFO    ][21397] Syncing states for environment 'base'
2017-12-01 03:07:27,210 [salt.utils.extmods][INFO    ][21397] Loading cache from salt://_states, for base)
2017-12-01 03:07:27,210 [salt.fileclient  ][INFO    ][21397] Caching directory '_states/' for environment 'base'
2017-12-01 03:07:27,299 [salt.fileclient  ][INFO    ][21397] Fetching file from saltenv 'base', ** done ** '_states/avinetworks.py'
2017-12-01 03:07:27,369 [salt.fileclient  ][INFO    ][21397] Fetching file from saltenv 'base', ** done ** '_states/cinderng.py'
2017-12-01 03:07:27,413 [salt.fileclient  ][INFO    ][21397] Fetching file from saltenv 'base', ** done ** '_states/contrail.py'
2017-12-01 03:07:27,426 [salt.fileclient  ][INFO    ][21397] Fetching file from saltenv 'base', ** done ** '_states/gerrit.py'
2017-12-01 03:07:27,506 [salt.fileclient  ][INFO    ][21397] Fetching file from saltenv 'base', ** done ** '_states/glanceng.py'
2017-12-01 03:07:27,514 [salt.fileclient  ][INFO    ][21397] Fetching file from saltenv 'base', ** done ** '_states/grafana3_dashboard.py'
2017-12-01 03:07:27,532 [salt.fileclient  ][INFO    ][21397] Fetching file from saltenv 'base', ** done ** '_states/grafana3_datasource.py'
2017-12-01 03:07:27,563 [salt.fileclient  ][INFO    ][21397] Fetching file from saltenv 'base', ** done ** '_states/heat.py'
2017-12-01 03:07:27,605 [salt.fileclient  ][INFO    ][21397] Fetching file from saltenv 'base', ** done ** '_states/helm_release.py'
2017-12-01 03:07:27,617 [salt.fileclient  ][INFO    ][21397] Fetching file from saltenv 'base', ** done ** '_states/helm_repos.py'
2017-12-01 03:07:27,629 [salt.fileclient  ][INFO    ][21397] Fetching file from saltenv 'base', ** done ** '_states/jenkins_approval.py'
2017-12-01 03:07:27,660 [salt.fileclient  ][INFO    ][21397] Fetching file from saltenv 'base', ** done ** '_states/jenkins_artifactory.py'
2017-12-01 03:07:27,668 [salt.fileclient  ][INFO    ][21397] Fetching file from saltenv 'base', ** done ** '_states/jenkins_credential.py'
2017-12-01 03:07:27,704 [salt.fileclient  ][INFO    ][21397] Fetching file from saltenv 'base', ** done ** '_states/jenkins_globalenvprop.py'
2017-12-01 03:07:27,731 [salt.fileclient  ][INFO    ][21397] Fetching file from saltenv 'base', ** done ** '_states/jenkins_job.py'
2017-12-01 03:07:27,744 [salt.fileclient  ][INFO    ][21397] Fetching file from saltenv 'base', ** done ** '_states/jenkins_lib.py'
2017-12-01 03:07:27,779 [salt.fileclient  ][INFO    ][21397] Fetching file from saltenv 'base', ** done ** '_states/jenkins_node.py'
2017-12-01 03:07:27,805 [salt.fileclient  ][INFO    ][21397] Fetching file from saltenv 'base', ** done ** '_states/jenkins_plugin.py'
2017-12-01 03:07:27,822 [salt.fileclient  ][INFO    ][21397] Fetching file from saltenv 'base', ** done ** '_states/jenkins_security.py'
2017-12-01 03:07:27,832 [salt.fileclient  ][INFO    ][21397] Fetching file from saltenv 'base', ** done ** '_states/jenkins_slack.py'
2017-12-01 03:07:27,846 [salt.fileclient  ][INFO    ][21397] Fetching file from saltenv 'base', ** done ** '_states/jenkins_smtp.py'
2017-12-01 03:07:27,859 [salt.fileclient  ][INFO    ][21397] Fetching file from saltenv 'base', ** done ** '_states/jenkins_theme.py'
2017-12-01 03:07:27,872 [salt.fileclient  ][INFO    ][21397] Fetching file from saltenv 'base', ** done ** '_states/jenkins_user.py'
2017-12-01 03:07:27,903 [salt.fileclient  ][INFO    ][21397] Fetching file from saltenv 'base', ** done ** '_states/jenkins_view.py'
2017-12-01 03:07:27,910 [salt.fileclient  ][INFO    ][21397] Fetching file from saltenv 'base', ** done ** '_states/keystone_policy.py'
2017-12-01 03:07:27,947 [salt.fileclient  ][INFO    ][21397] Fetching file from saltenv 'base', ** done ** '_states/kibana_object.py'
2017-12-01 03:07:27,997 [salt.fileclient  ][INFO    ][21397] Fetching file from saltenv 'base', ** done ** '_states/neutronng.py'
2017-12-01 03:07:28,004 [salt.fileclient  ][INFO    ][21397] Fetching file from saltenv 'base', ** done ** '_states/novang.py'
2017-12-01 03:07:28,046 [salt.fileclient  ][INFO    ][21397] Fetching file from saltenv 'base', ** done ** '_states/reclass.py'
2017-12-01 03:07:28,057 [salt.fileclient  ][INFO    ][21397] Fetching file from saltenv 'base', ** done ** '_states/rundeck_project.py'
2017-12-01 03:07:28,070 [salt.fileclient  ][INFO    ][21397] Fetching file from saltenv 'base', ** done ** '_states/rundeck_scm.py'
2017-12-01 03:07:28,092 [salt.fileclient  ][INFO    ][21397] Fetching file from saltenv 'base', ** done ** '_states/rundeck_secret.py'
2017-12-01 03:07:28,095 [salt.utils.extmods][INFO    ][21397] Copying '/var/cache/salt/minion/files/base/_states/avinetworks.py' to '/var/cache/salt/minion/extmods/states/avinetworks.py'
2017-12-01 03:07:28,096 [salt.utils.extmods][INFO    ][21397] Copying '/var/cache/salt/minion/files/base/_states/cinderng.py' to '/var/cache/salt/minion/extmods/states/cinderng.py'
2017-12-01 03:07:28,096 [salt.utils.extmods][INFO    ][21397] Copying '/var/cache/salt/minion/files/base/_states/contrail.py' to '/var/cache/salt/minion/extmods/states/contrail.py'
2017-12-01 03:07:28,096 [salt.utils.extmods][INFO    ][21397] Copying '/var/cache/salt/minion/files/base/_states/gerrit.py' to '/var/cache/salt/minion/extmods/states/gerrit.py'
2017-12-01 03:07:28,096 [salt.utils.extmods][INFO    ][21397] Copying '/var/cache/salt/minion/files/base/_states/glanceng.py' to '/var/cache/salt/minion/extmods/states/glanceng.py'
2017-12-01 03:07:28,097 [salt.utils.extmods][INFO    ][21397] Copying '/var/cache/salt/minion/files/base/_states/grafana3_dashboard.py' to '/var/cache/salt/minion/extmods/states/grafana3_dashboard.py'
2017-12-01 03:07:28,097 [salt.utils.extmods][INFO    ][21397] Copying '/var/cache/salt/minion/files/base/_states/grafana3_datasource.py' to '/var/cache/salt/minion/extmods/states/grafana3_datasource.py'
2017-12-01 03:07:28,097 [salt.utils.extmods][INFO    ][21397] Copying '/var/cache/salt/minion/files/base/_states/heat.py' to '/var/cache/salt/minion/extmods/states/heat.py'
2017-12-01 03:07:28,097 [salt.utils.extmods][INFO    ][21397] Copying '/var/cache/salt/minion/files/base/_states/helm_release.py' to '/var/cache/salt/minion/extmods/states/helm_release.py'
2017-12-01 03:07:28,098 [salt.utils.extmods][INFO    ][21397] Copying '/var/cache/salt/minion/files/base/_states/helm_repos.py' to '/var/cache/salt/minion/extmods/states/helm_repos.py'
2017-12-01 03:07:28,098 [salt.utils.extmods][INFO    ][21397] Copying '/var/cache/salt/minion/files/base/_states/jenkins_approval.py' to '/var/cache/salt/minion/extmods/states/jenkins_approval.py'
2017-12-01 03:07:28,098 [salt.utils.extmods][INFO    ][21397] Copying '/var/cache/salt/minion/files/base/_states/jenkins_artifactory.py' to '/var/cache/salt/minion/extmods/states/jenkins_artifactory.py'
2017-12-01 03:07:28,098 [salt.utils.extmods][INFO    ][21397] Copying '/var/cache/salt/minion/files/base/_states/jenkins_credential.py' to '/var/cache/salt/minion/extmods/states/jenkins_credential.py'
2017-12-01 03:07:28,098 [salt.utils.extmods][INFO    ][21397] Copying '/var/cache/salt/minion/files/base/_states/jenkins_globalenvprop.py' to '/var/cache/salt/minion/extmods/states/jenkins_globalenvprop.py'
2017-12-01 03:07:28,099 [salt.utils.extmods][INFO    ][21397] Copying '/var/cache/salt/minion/files/base/_states/jenkins_job.py' to '/var/cache/salt/minion/extmods/states/jenkins_job.py'
2017-12-01 03:07:28,099 [salt.utils.extmods][INFO    ][21397] Copying '/var/cache/salt/minion/files/base/_states/jenkins_lib.py' to '/var/cache/salt/minion/extmods/states/jenkins_lib.py'
2017-12-01 03:07:28,099 [salt.utils.extmods][INFO    ][21397] Copying '/var/cache/salt/minion/files/base/_states/jenkins_node.py' to '/var/cache/salt/minion/extmods/states/jenkins_node.py'
2017-12-01 03:07:28,099 [salt.utils.extmods][INFO    ][21397] Copying '/var/cache/salt/minion/files/base/_states/jenkins_plugin.py' to '/var/cache/salt/minion/extmods/states/jenkins_plugin.py'
2017-12-01 03:07:28,099 [salt.utils.extmods][INFO    ][21397] Copying '/var/cache/salt/minion/files/base/_states/jenkins_security.py' to '/var/cache/salt/minion/extmods/states/jenkins_security.py'
2017-12-01 03:07:28,100 [salt.utils.extmods][INFO    ][21397] Copying '/var/cache/salt/minion/files/base/_states/jenkins_slack.py' to '/var/cache/salt/minion/extmods/states/jenkins_slack.py'
2017-12-01 03:07:28,100 [salt.utils.extmods][INFO    ][21397] Copying '/var/cache/salt/minion/files/base/_states/jenkins_smtp.py' to '/var/cache/salt/minion/extmods/states/jenkins_smtp.py'
2017-12-01 03:07:28,100 [salt.utils.extmods][INFO    ][21397] Copying '/var/cache/salt/minion/files/base/_states/jenkins_theme.py' to '/var/cache/salt/minion/extmods/states/jenkins_theme.py'
2017-12-01 03:07:28,100 [salt.utils.extmods][INFO    ][21397] Copying '/var/cache/salt/minion/files/base/_states/jenkins_user.py' to '/var/cache/salt/minion/extmods/states/jenkins_user.py'
2017-12-01 03:07:28,100 [salt.utils.extmods][INFO    ][21397] Copying '/var/cache/salt/minion/files/base/_states/jenkins_view.py' to '/var/cache/salt/minion/extmods/states/jenkins_view.py'
2017-12-01 03:07:28,101 [salt.utils.extmods][INFO    ][21397] Copying '/var/cache/salt/minion/files/base/_states/keystone_policy.py' to '/var/cache/salt/minion/extmods/states/keystone_policy.py'
2017-12-01 03:07:28,101 [salt.utils.extmods][INFO    ][21397] Copying '/var/cache/salt/minion/files/base/_states/kibana_object.py' to '/var/cache/salt/minion/extmods/states/kibana_object.py'
2017-12-01 03:07:28,101 [salt.utils.extmods][INFO    ][21397] Copying '/var/cache/salt/minion/files/base/_states/maas_cluster.py' to '/var/cache/salt/minion/extmods/states/maas_cluster.py'
2017-12-01 03:07:28,101 [salt.utils.extmods][INFO    ][21397] Copying '/var/cache/salt/minion/files/base/_states/neutronng.py' to '/var/cache/salt/minion/extmods/states/neutronng.py'
2017-12-01 03:07:28,102 [salt.utils.extmods][INFO    ][21397] Copying '/var/cache/salt/minion/files/base/_states/novang.py' to '/var/cache/salt/minion/extmods/states/novang.py'
2017-12-01 03:07:28,102 [salt.utils.extmods][INFO    ][21397] Copying '/var/cache/salt/minion/files/base/_states/reclass.py' to '/var/cache/salt/minion/extmods/states/reclass.py'
2017-12-01 03:07:28,102 [salt.utils.extmods][INFO    ][21397] Copying '/var/cache/salt/minion/files/base/_states/rundeck_project.py' to '/var/cache/salt/minion/extmods/states/rundeck_project.py'
2017-12-01 03:07:28,102 [salt.utils.extmods][INFO    ][21397] Copying '/var/cache/salt/minion/files/base/_states/rundeck_scm.py' to '/var/cache/salt/minion/extmods/states/rundeck_scm.py'
2017-12-01 03:07:28,102 [salt.utils.extmods][INFO    ][21397] Copying '/var/cache/salt/minion/files/base/_states/rundeck_secret.py' to '/var/cache/salt/minion/extmods/states/rundeck_secret.py'
2017-12-01 03:07:28,104 [salt.utils.extmods][INFO    ][21397] Creating module dir '/var/cache/salt/minion/extmods/sdb'
2017-12-01 03:07:28,107 [salt.utils.extmods][INFO    ][21397] Syncing sdb for environment 'base'
2017-12-01 03:07:28,107 [salt.utils.extmods][INFO    ][21397] Loading cache from salt://_sdb, for base)
2017-12-01 03:07:28,107 [salt.fileclient  ][INFO    ][21397] Caching directory '_sdb/' for environment 'base'
2017-12-01 03:07:28,130 [salt.utils.extmods][INFO    ][21397] Syncing grains for environment 'base'
2017-12-01 03:07:28,130 [salt.utils.extmods][INFO    ][21397] Loading cache from salt://_grains, for base)
2017-12-01 03:07:28,131 [salt.fileclient  ][INFO    ][21397] Caching directory '_grains/' for environment 'base'
2017-12-01 03:07:28,178 [salt.fileclient  ][INFO    ][21397] Fetching file from saltenv 'base', ** done ** '_grains/ceilometer_policy.py'
2017-12-01 03:07:28,188 [salt.fileclient  ][INFO    ][21397] Fetching file from saltenv 'base', ** done ** '_grains/ceph.py'
2017-12-01 03:07:28,221 [salt.fileclient  ][INFO    ][21397] Fetching file from saltenv 'base', ** done ** '_grains/cinder_policy.py'
2017-12-01 03:07:28,233 [salt.fileclient  ][INFO    ][21397] Fetching file from saltenv 'base', ** done ** '_grains/docker_swarm.py'
2017-12-01 03:07:28,251 [salt.fileclient  ][INFO    ][21397] Fetching file from saltenv 'base', ** done ** '_grains/glance_policy.py'
2017-12-01 03:07:28,262 [salt.fileclient  ][INFO    ][21397] Fetching file from saltenv 'base', ** done ** '_grains/heat_policy.py'
2017-12-01 03:07:28,272 [salt.fileclient  ][INFO    ][21397] Fetching file from saltenv 'base', ** done ** '_grains/jenkins_plugins.py'
2017-12-01 03:07:28,281 [salt.fileclient  ][INFO    ][21397] Fetching file from saltenv 'base', ** done ** '_grains/keystone_policy.py'
2017-12-01 03:07:28,289 [salt.fileclient  ][INFO    ][21397] Fetching file from saltenv 'base', ** done ** '_grains/kubernetes.py'
2017-12-01 03:07:28,304 [salt.fileclient  ][INFO    ][21397] Fetching file from saltenv 'base', ** done ** '_grains/neutron_policy.py'
2017-12-01 03:07:28,312 [salt.fileclient  ][INFO    ][21397] Fetching file from saltenv 'base', ** done ** '_grains/nova_policy.py'
2017-12-01 03:07:28,319 [salt.fileclient  ][INFO    ][21397] Fetching file from saltenv 'base', ** done ** '_grains/ssh_fingerprints.py'
2017-12-01 03:07:28,322 [salt.utils.extmods][INFO    ][21397] Copying '/var/cache/salt/minion/files/base/_grains/ceilometer_policy.py' to '/var/cache/salt/minion/extmods/grains/ceilometer_policy.py'
2017-12-01 03:07:28,323 [salt.utils.extmods][INFO    ][21397] Copying '/var/cache/salt/minion/files/base/_grains/ceph.py' to '/var/cache/salt/minion/extmods/grains/ceph.py'
2017-12-01 03:07:28,323 [salt.utils.extmods][INFO    ][21397] Copying '/var/cache/salt/minion/files/base/_grains/cinder_policy.py' to '/var/cache/salt/minion/extmods/grains/cinder_policy.py'
2017-12-01 03:07:28,323 [salt.utils.extmods][INFO    ][21397] Copying '/var/cache/salt/minion/files/base/_grains/docker_swarm.py' to '/var/cache/salt/minion/extmods/grains/docker_swarm.py'
2017-12-01 03:07:28,323 [salt.utils.extmods][INFO    ][21397] Copying '/var/cache/salt/minion/files/base/_grains/glance_policy.py' to '/var/cache/salt/minion/extmods/grains/glance_policy.py'
2017-12-01 03:07:28,324 [salt.utils.extmods][INFO    ][21397] Copying '/var/cache/salt/minion/files/base/_grains/heat_policy.py' to '/var/cache/salt/minion/extmods/grains/heat_policy.py'
2017-12-01 03:07:28,324 [salt.utils.extmods][INFO    ][21397] Copying '/var/cache/salt/minion/files/base/_grains/jenkins_plugins.py' to '/var/cache/salt/minion/extmods/grains/jenkins_plugins.py'
2017-12-01 03:07:28,324 [salt.utils.extmods][INFO    ][21397] Copying '/var/cache/salt/minion/files/base/_grains/keystone_policy.py' to '/var/cache/salt/minion/extmods/grains/keystone_policy.py'
2017-12-01 03:07:28,324 [salt.utils.extmods][INFO    ][21397] Copying '/var/cache/salt/minion/files/base/_grains/kubernetes.py' to '/var/cache/salt/minion/extmods/grains/kubernetes.py'
2017-12-01 03:07:28,325 [salt.utils.extmods][INFO    ][21397] Copying '/var/cache/salt/minion/files/base/_grains/neutron_policy.py' to '/var/cache/salt/minion/extmods/grains/neutron_policy.py'
2017-12-01 03:07:28,325 [salt.utils.extmods][INFO    ][21397] Copying '/var/cache/salt/minion/files/base/_grains/nova_policy.py' to '/var/cache/salt/minion/extmods/grains/nova_policy.py'
2017-12-01 03:07:28,325 [salt.utils.extmods][INFO    ][21397] Copying '/var/cache/salt/minion/files/base/_grains/ssh_fingerprints.py' to '/var/cache/salt/minion/extmods/grains/ssh_fingerprints.py'
2017-12-01 03:07:28,326 [salt.utils.extmods][INFO    ][21397] Creating module dir '/var/cache/salt/minion/extmods/renderers'
2017-12-01 03:07:28,328 [salt.utils.extmods][INFO    ][21397] Syncing renderers for environment 'base'
2017-12-01 03:07:28,329 [salt.utils.extmods][INFO    ][21397] Loading cache from salt://_renderers, for base)
2017-12-01 03:07:28,329 [salt.fileclient  ][INFO    ][21397] Caching directory '_renderers/' for environment 'base'
2017-12-01 03:07:28,348 [salt.utils.extmods][INFO    ][21397] Creating module dir '/var/cache/salt/minion/extmods/returners'
2017-12-01 03:07:28,350 [salt.utils.extmods][INFO    ][21397] Syncing returners for environment 'base'
2017-12-01 03:07:28,351 [salt.utils.extmods][INFO    ][21397] Loading cache from salt://_returners, for base)
2017-12-01 03:07:28,351 [salt.fileclient  ][INFO    ][21397] Caching directory '_returners/' for environment 'base'
2017-12-01 03:07:28,384 [salt.utils.extmods][INFO    ][21397] Creating module dir '/var/cache/salt/minion/extmods/output'
2017-12-01 03:07:28,386 [salt.utils.extmods][INFO    ][21397] Syncing output for environment 'base'
2017-12-01 03:07:28,387 [salt.utils.extmods][INFO    ][21397] Loading cache from salt://_output, for base)
2017-12-01 03:07:28,387 [salt.fileclient  ][INFO    ][21397] Caching directory '_output/' for environment 'base'
2017-12-01 03:07:28,424 [salt.utils.extmods][INFO    ][21397] Creating module dir '/var/cache/salt/minion/extmods/utils'
2017-12-01 03:07:28,427 [salt.utils.extmods][INFO    ][21397] Syncing utils for environment 'base'
2017-12-01 03:07:28,427 [salt.utils.extmods][INFO    ][21397] Loading cache from salt://_utils, for base)
2017-12-01 03:07:28,427 [salt.fileclient  ][INFO    ][21397] Caching directory '_utils/' for environment 'base'
2017-12-01 03:07:28,451 [salt.utils.extmods][INFO    ][21397] Creating module dir '/var/cache/salt/minion/extmods/log_handlers'
2017-12-01 03:07:28,453 [salt.utils.extmods][INFO    ][21397] Syncing log_handlers for environment 'base'
2017-12-01 03:07:28,453 [salt.utils.extmods][INFO    ][21397] Loading cache from salt://_log_handlers, for base)
2017-12-01 03:07:28,453 [salt.fileclient  ][INFO    ][21397] Caching directory '_log_handlers/' for environment 'base'
2017-12-01 03:07:28,472 [salt.utils.extmods][INFO    ][21397] Creating module dir '/var/cache/salt/minion/extmods/proxy'
2017-12-01 03:07:28,474 [salt.utils.extmods][INFO    ][21397] Syncing proxy for environment 'base'
2017-12-01 03:07:28,474 [salt.utils.extmods][INFO    ][21397] Loading cache from salt://_proxy, for base)
2017-12-01 03:07:28,474 [salt.fileclient  ][INFO    ][21397] Caching directory '_proxy/' for environment 'base'
2017-12-01 03:07:28,495 [salt.utils.extmods][INFO    ][21397] Creating module dir '/var/cache/salt/minion/extmods/engines'
2017-12-01 03:07:28,498 [salt.utils.extmods][INFO    ][21397] Syncing engines for environment 'base'
2017-12-01 03:07:28,498 [salt.utils.extmods][INFO    ][21397] Loading cache from salt://_engines, for base)
2017-12-01 03:07:28,498 [salt.fileclient  ][INFO    ][21397] Caching directory '_engines/' for environment 'base'
2017-12-01 03:07:28,532 [salt.minion      ][INFO    ][21397] Returning information for job: 20171201030723012115
2017-12-01 03:18:31,310 [salt.minion      ][INFO    ][21188] User sudo_ubuntu Executing command test.ping with jid 20171201031831303799
2017-12-01 03:18:31,325 [salt.minion      ][INFO    ][21603] Starting a new job with PID 21603
2017-12-01 03:18:31,351 [salt.minion      ][INFO    ][21603] Returning information for job: 20171201031831303799
2017-12-01 03:22:05,101 [salt.minion      ][INFO    ][21188] User sudo_ubuntu Executing command state.sls with jid 20171201032205085780
2017-12-01 03:22:05,115 [salt.minion      ][INFO    ][21662] Starting a new job with PID 21662
2017-12-01 03:22:05,621 [salt.state       ][INFO    ][21662] Loading fresh modules for state activity
2017-12-01 03:22:05,647 [salt.fileclient  ][INFO    ][21662] Fetching file from saltenv 'base', ** done ** 'keepalived/init.sls'
2017-12-01 03:22:05,664 [salt.fileclient  ][INFO    ][21662] Fetching file from saltenv 'base', ** done ** 'keepalived/cluster.sls'
2017-12-01 03:22:05,689 [salt.fileclient  ][INFO    ][21662] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-12-01 03:22:05,999 [salt.state       ][INFO    ][21662] Running state [lsof] at time 03:22:05.999173
2017-12-01 03:22:05,999 [salt.state       ][INFO    ][21662] Executing state pkg.installed for lsof
2017-12-01 03:22:05,1000 [salt.loaded.int.module.cmdmod][INFO    ][21662] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-01 03:22:06,266 [salt.state       ][INFO    ][21662] Package lsof is already installed
2017-12-01 03:22:06,266 [salt.state       ][INFO    ][21662] Completed state [lsof] at time 03:22:06.266214 duration_in_ms=267.04
2017-12-01 03:22:06,266 [salt.state       ][INFO    ][21662] Running state [keepalived] at time 03:22:06.266429
2017-12-01 03:22:06,267 [salt.state       ][INFO    ][21662] Executing state pkg.installed for keepalived
2017-12-01 03:22:06,282 [salt.loaded.int.module.cmdmod][INFO    ][21662] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-12-01 03:22:07,766 [salt.loaded.int.module.cmdmod][INFO    ][21662] 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-12-01 03:22:15,147 [salt.minion      ][INFO    ][21188] User sudo_ubuntu Executing command saltutil.find_job with jid 20171201032215132166
2017-12-01 03:22:15,160 [salt.minion      ][INFO    ][22972] Starting a new job with PID 22972
2017-12-01 03:22:15,170 [salt.minion      ][INFO    ][22972] Returning information for job: 20171201032215132166
2017-12-01 03:22:15,787 [salt.loaded.int.module.cmdmod][INFO    ][21662] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-01 03:22:15,810 [salt.state       ][INFO    ][21662] 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-12-01 03:22:15,818 [salt.state       ][INFO    ][21662] Loading fresh modules for state activity
2017-12-01 03:22:15,830 [salt.state       ][INFO    ][21662] Completed state [keepalived] at time 03:22:15.829639 duration_in_ms=9563.21
2017-12-01 03:22:15,832 [salt.state       ][INFO    ][21662] Running state [/etc/keepalived/keepalived.conf] at time 03:22:15.831655
2017-12-01 03:22:15,832 [salt.state       ][INFO    ][21662] Executing state file.managed for /etc/keepalived/keepalived.conf
2017-12-01 03:22:15,877 [salt.fileclient  ][INFO    ][21662] Fetching file from saltenv 'base', ** done ** 'keepalived/files/keepalived.conf'
2017-12-01 03:22:15,909 [salt.fileclient  ][INFO    ][21662] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-12-01 03:22:15,914 [salt.state       ][INFO    ][21662] File changed:
New file
2017-12-01 03:22:15,915 [salt.state       ][INFO    ][21662] Completed state [/etc/keepalived/keepalived.conf] at time 03:22:15.914496 duration_in_ms=82.843
2017-12-01 03:22:15,970 [salt.state       ][INFO    ][21662] Running state [keepalived] at time 03:22:15.969717
2017-12-01 03:22:15,970 [salt.state       ][INFO    ][21662] Executing state service.running for keepalived
2017-12-01 03:22:15,971 [salt.loaded.int.module.cmdmod][INFO    ][21662] Executing command ['systemctl', 'status', 'keepalived.service', '-n', '0'] in directory '/root'
2017-12-01 03:22:15,981 [salt.loaded.int.module.cmdmod][INFO    ][21662] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2017-12-01 03:22:15,989 [salt.loaded.int.module.cmdmod][INFO    ][21662] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-12-01 03:22:15,996 [salt.loaded.int.module.cmdmod][INFO    ][21662] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-12-01 03:22:16,003 [salt.loaded.int.module.cmdmod][INFO    ][21662] Executing command ['systemd-run', '--scope', 'systemctl', 'start', 'keepalived.service'] in directory '/root'
2017-12-01 03:22:16,063 [salt.loaded.int.module.cmdmod][INFO    ][21662] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2017-12-01 03:22:16,071 [salt.loaded.int.module.cmdmod][INFO    ][21662] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-12-01 03:22:16,077 [salt.loaded.int.module.cmdmod][INFO    ][21662] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-12-01 03:22:16,084 [salt.state       ][INFO    ][21662] {'keepalived': True}
2017-12-01 03:22:16,084 [salt.state       ][INFO    ][21662] Completed state [keepalived] at time 03:22:16.083694 duration_in_ms=113.977
2017-12-01 03:22:16,084 [salt.minion      ][INFO    ][21662] Returning information for job: 20171201032205085780
2017-12-01 03:22:28,604 [salt.minion      ][INFO    ][21188] User sudo_ubuntu Executing command pillar.get with jid 20171201032228592588
2017-12-01 03:22:28,631 [salt.minion      ][INFO    ][23091] Starting a new job with PID 23091
2017-12-01 03:22:28,636 [salt.minion      ][INFO    ][23091] Returning information for job: 20171201032228592588
2017-12-01 03:27:39,229 [salt.minion      ][INFO    ][21188] User sudo_ubuntu Executing command state.sls with jid 20171201032739219387
2017-12-01 03:27:39,245 [salt.minion      ][INFO    ][23178] Starting a new job with PID 23178
2017-12-01 03:27:40,968 [salt.state       ][INFO    ][23178] Loading fresh modules for state activity
2017-12-01 03:27:40,990 [salt.fileclient  ][INFO    ][23178] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-12-01 03:27:41,011 [salt.fileclient  ][INFO    ][23178] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-12-01 03:27:41,287 [salt.state       ][INFO    ][23178] Running state [attr] at time 03:27:41.287278
2017-12-01 03:27:41,288 [salt.state       ][INFO    ][23178] Executing state pkg.installed for attr
2017-12-01 03:27:41,288 [salt.loaded.int.module.cmdmod][INFO    ][23178] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-01 03:27:41,569 [salt.loaded.int.module.cmdmod][INFO    ][23178] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-12-01 03:27:43,073 [salt.loaded.int.module.cmdmod][INFO    ][23178] 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-12-01 03:27:45,244 [salt.loaded.int.module.cmdmod][INFO    ][23178] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-01 03:27:45,270 [salt.state       ][INFO    ][23178] Made the following changes:
'attr' changed from 'absent' to '1:2.4.47-2'

2017-12-01 03:27:45,278 [salt.state       ][INFO    ][23178] Loading fresh modules for state activity
2017-12-01 03:27:45,290 [salt.state       ][INFO    ][23178] Completed state [attr] at time 03:27:45.289897 duration_in_ms=4002.619
2017-12-01 03:27:45,295 [salt.state       ][INFO    ][23178] Running state [glusterfs-server] at time 03:27:45.295450
2017-12-01 03:27:45,296 [salt.state       ][INFO    ][23178] Executing state pkg.installed for glusterfs-server
2017-12-01 03:27:45,484 [salt.loaded.int.module.cmdmod][INFO    ][23178] 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-12-01 03:27:49,323 [salt.minion      ][INFO    ][21188] User sudo_ubuntu Executing command saltutil.find_job with jid 20171201032749306886
2017-12-01 03:27:49,336 [salt.minion      ][INFO    ][24007] Starting a new job with PID 24007
2017-12-01 03:27:49,347 [salt.minion      ][INFO    ][24007] Returning information for job: 20171201032749306886
2017-12-01 03:27:59,519 [salt.minion      ][INFO    ][21188] User sudo_ubuntu Executing command saltutil.find_job with jid 20171201032759504384
2017-12-01 03:27:59,533 [salt.minion      ][INFO    ][24014] Starting a new job with PID 24014
2017-12-01 03:27:59,545 [salt.minion      ][INFO    ][24014] Returning information for job: 20171201032759504384
2017-12-01 03:28:09,713 [salt.minion      ][INFO    ][21188] User sudo_ubuntu Executing command saltutil.find_job with jid 20171201032809698548
2017-12-01 03:28:09,730 [salt.minion      ][INFO    ][24103] Starting a new job with PID 24103
2017-12-01 03:28:09,749 [salt.minion      ][INFO    ][24103] Returning information for job: 20171201032809698548
2017-12-01 03:28:19,302 [salt.loaded.int.module.cmdmod][INFO    ][23178] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-01 03:28:19,327 [salt.state       ][INFO    ][23178] Made the following changes:
'keyutils' changed from 'absent' to '1.5.9-8ubuntu1'
'glusterfs-client' changed from 'absent' to '3.10.8-ubuntu1~xenial1'
'rpcbind' changed from 'absent' to '0.2.3-0.2'
'libpython2.7' changed from 'absent' to '2.7.12-1ubuntu0~16.04.2'
'nfs-common' changed from 'absent' to '1:1.2.8-9ubuntu12.1'
'librdmacm1' changed from 'absent' to '1.0.21-1'
'glusterfs-common' changed from 'absent' to '3.10.8-ubuntu1~xenial1'
'liburcu4' changed from 'absent' to '0.9.1-3'
'portmap' changed from 'absent' to '1'
'libnfsidmap2' changed from 'absent' to '0.25-5'
'libibverbs1' changed from 'absent' to '1.1.8-1.1ubuntu2'
'libtirpc1' changed from 'absent' to '0.2.5-1'
'nfs-client' changed from 'absent' to '1'
'glusterfs-server' changed from 'absent' to '3.10.8-ubuntu1~xenial1'

2017-12-01 03:28:19,334 [salt.state       ][INFO    ][23178] Loading fresh modules for state activity
2017-12-01 03:28:19,346 [salt.state       ][INFO    ][23178] Completed state [glusterfs-server] at time 03:28:19.345490 duration_in_ms=34050.039
2017-12-01 03:28:19,350 [salt.state       ][INFO    ][23178] Running state [bc] at time 03:28:19.350000
2017-12-01 03:28:19,350 [salt.state       ][INFO    ][23178] Executing state pkg.installed for bc
2017-12-01 03:28:19,614 [salt.loaded.int.module.cmdmod][INFO    ][23178] 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-12-01 03:28:19,900 [salt.minion      ][INFO    ][21188] User sudo_ubuntu Executing command saltutil.find_job with jid 20171201032819885261
2017-12-01 03:28:19,912 [salt.minion      ][INFO    ][25600] Starting a new job with PID 25600
2017-12-01 03:28:19,921 [salt.minion      ][INFO    ][25600] Returning information for job: 20171201032819885261
2017-12-01 03:28:22,368 [salt.loaded.int.module.cmdmod][INFO    ][23178] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-01 03:28:22,394 [salt.state       ][INFO    ][23178] Made the following changes:
'bc' changed from 'absent' to '1.06.95-9build1'

2017-12-01 03:28:22,402 [salt.state       ][INFO    ][23178] Loading fresh modules for state activity
2017-12-01 03:28:22,414 [salt.state       ][INFO    ][23178] Completed state [bc] at time 03:28:22.414330 duration_in_ms=3064.329
2017-12-01 03:28:22,483 [salt.state       ][INFO    ][23178] Running state [glusterfs-server] at time 03:28:22.482603
2017-12-01 03:28:22,483 [salt.state       ][INFO    ][23178] Executing state service.running for glusterfs-server
2017-12-01 03:28:22,484 [salt.loaded.int.module.cmdmod][INFO    ][23178] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-12-01 03:28:22,494 [salt.loaded.int.module.cmdmod][INFO    ][23178] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-12-01 03:28:22,501 [salt.loaded.int.module.cmdmod][INFO    ][23178] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-12-01 03:28:22,511 [salt.state       ][INFO    ][23178] The service glusterfs-server is already running
2017-12-01 03:28:22,511 [salt.state       ][INFO    ][23178] Completed state [glusterfs-server] at time 03:28:22.510849 duration_in_ms=28.246
2017-12-01 03:28:22,512 [salt.state       ][INFO    ][23178] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 03:28:22.512351
2017-12-01 03:28:22,513 [salt.state       ][INFO    ][23178] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-12-01 03:28:22,530 [salt.state       ][INFO    ][23178] File changed:
New file
2017-12-01 03:28:22,531 [salt.state       ][INFO    ][23178] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 03:28:22.530647 duration_in_ms=18.296
2017-12-01 03:28:22,531 [salt.state       ][INFO    ][23178] Running state [/srv/glusterfs/glance] at time 03:28:22.530836
2017-12-01 03:28:22,531 [salt.state       ][INFO    ][23178] Executing state file.directory for /srv/glusterfs/glance
2017-12-01 03:28:22,532 [salt.state       ][INFO    ][23178] {'/srv/glusterfs/glance': 'New Dir'}
2017-12-01 03:28:22,532 [salt.state       ][INFO    ][23178] Completed state [/srv/glusterfs/glance] at time 03:28:22.531734 duration_in_ms=0.899
2017-12-01 03:28:22,532 [salt.state       ][INFO    ][23178] Running state [/srv/glusterfs/keystone-keys] at time 03:28:22.531895
2017-12-01 03:28:22,532 [salt.state       ][INFO    ][23178] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-12-01 03:28:22,532 [salt.state       ][INFO    ][23178] {'/srv/glusterfs/keystone-keys': 'New Dir'}
2017-12-01 03:28:22,533 [salt.state       ][INFO    ][23178] Completed state [/srv/glusterfs/keystone-keys] at time 03:28:22.532589 duration_in_ms=0.694
2017-12-01 03:28:22,533 [salt.state       ][INFO    ][23178] Running state [/srv/glusterfs/nova_instances] at time 03:28:22.532748
2017-12-01 03:28:22,533 [salt.state       ][INFO    ][23178] Executing state file.directory for /srv/glusterfs/nova_instances
2017-12-01 03:28:22,533 [salt.state       ][INFO    ][23178] {'/srv/glusterfs/nova_instances': 'New Dir'}
2017-12-01 03:28:22,533 [salt.state       ][INFO    ][23178] Completed state [/srv/glusterfs/nova_instances] at time 03:28:22.533456 duration_in_ms=0.708
2017-12-01 03:28:22,534 [salt.state       ][INFO    ][23178] Running state [/srv/glusterfs/keystone-credential-keys] at time 03:28:22.533617
2017-12-01 03:28:22,534 [salt.state       ][INFO    ][23178] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-12-01 03:28:22,534 [salt.state       ][INFO    ][23178] {'/srv/glusterfs/keystone-credential-keys': 'New Dir'}
2017-12-01 03:28:22,534 [salt.state       ][INFO    ][23178] Completed state [/srv/glusterfs/keystone-credential-keys] at time 03:28:22.534294 duration_in_ms=0.677
2017-12-01 03:28:22,535 [salt.minion      ][INFO    ][23178] Returning information for job: 20171201032739219387
2017-12-01 03:28:23,617 [salt.minion      ][INFO    ][21188] User sudo_ubuntu Executing command test.ping with jid 20171201032823603569
2017-12-01 03:28:23,631 [salt.minion      ][INFO    ][25988] Starting a new job with PID 25988
2017-12-01 03:28:23,660 [salt.minion      ][INFO    ][25988] Returning information for job: 20171201032823603569
2017-12-01 03:29:00,910 [salt.minion      ][INFO    ][21188] User sudo_ubuntu Executing command state.sls with jid 20171201032900894829
2017-12-01 03:29:00,928 [salt.minion      ][INFO    ][26622] Starting a new job with PID 26622
2017-12-01 03:29:02,533 [salt.state       ][INFO    ][26622] Loading fresh modules for state activity
2017-12-01 03:29:02,555 [salt.fileclient  ][INFO    ][26622] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/setup.sls'
2017-12-01 03:29:02,590 [salt.fileclient  ][INFO    ][26622] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-12-01 03:29:02,662 [salt.fileclient  ][INFO    ][26622] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-12-01 03:29:02,682 [salt.fileclient  ][INFO    ][26622] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-12-01 03:29:02,943 [salt.state       ][INFO    ][26622] Running state [attr] at time 03:29:02.942919
2017-12-01 03:29:02,943 [salt.state       ][INFO    ][26622] Executing state pkg.installed for attr
2017-12-01 03:29:02,944 [salt.loaded.int.module.cmdmod][INFO    ][26622] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-01 03:29:03,207 [salt.state       ][INFO    ][26622] Package attr is already installed
2017-12-01 03:29:03,208 [salt.state       ][INFO    ][26622] Completed state [attr] at time 03:29:03.207665 duration_in_ms=264.747
2017-12-01 03:29:03,208 [salt.state       ][INFO    ][26622] Running state [glusterfs-server] at time 03:29:03.207885
2017-12-01 03:29:03,208 [salt.state       ][INFO    ][26622] Executing state pkg.installed for glusterfs-server
2017-12-01 03:29:03,211 [salt.state       ][INFO    ][26622] Package glusterfs-server is already installed
2017-12-01 03:29:03,211 [salt.state       ][INFO    ][26622] Completed state [glusterfs-server] at time 03:29:03.210782 duration_in_ms=2.896
2017-12-01 03:29:03,211 [salt.state       ][INFO    ][26622] Running state [bc] at time 03:29:03.210922
2017-12-01 03:29:03,211 [salt.state       ][INFO    ][26622] Executing state pkg.installed for bc
2017-12-01 03:29:03,214 [salt.state       ][INFO    ][26622] Package bc is already installed
2017-12-01 03:29:03,214 [salt.state       ][INFO    ][26622] Completed state [bc] at time 03:29:03.213691 duration_in_ms=2.77
2017-12-01 03:29:03,215 [salt.state       ][INFO    ][26622] Running state [glusterfs-server] at time 03:29:03.214501
2017-12-01 03:29:03,215 [salt.state       ][INFO    ][26622] Executing state service.running for glusterfs-server
2017-12-01 03:29:03,215 [salt.loaded.int.module.cmdmod][INFO    ][26622] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-12-01 03:29:03,225 [salt.loaded.int.module.cmdmod][INFO    ][26622] Executing command ['systemctl', '--system', 'daemon-reload'] in directory '/root'
2017-12-01 03:29:03,268 [salt.loaded.int.module.cmdmod][INFO    ][26622] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-12-01 03:29:03,281 [salt.loaded.int.module.cmdmod][INFO    ][26622] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-12-01 03:29:03,286 [salt.loaded.int.module.cmdmod][INFO    ][26622] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-12-01 03:29:03,293 [salt.state       ][INFO    ][26622] The service glusterfs-server is already running
2017-12-01 03:29:03,293 [salt.state       ][INFO    ][26622] Completed state [glusterfs-server] at time 03:29:03.293061 duration_in_ms=78.559
2017-12-01 03:29:03,294 [salt.state       ][INFO    ][26622] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 03:29:03.294384
2017-12-01 03:29:03,295 [salt.state       ][INFO    ][26622] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-12-01 03:29:03,309 [salt.state       ][INFO    ][26622] File /etc/systemd/system/glusterfs-server.service.d/override.conf is in the correct state
2017-12-01 03:29:03,309 [salt.state       ][INFO    ][26622] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 03:29:03.309346 duration_in_ms=14.961
2017-12-01 03:29:03,310 [salt.state       ][INFO    ][26622] Running state [/srv/glusterfs/glance] at time 03:29:03.309498
2017-12-01 03:29:03,310 [salt.state       ][INFO    ][26622] Executing state file.directory for /srv/glusterfs/glance
2017-12-01 03:29:03,310 [salt.state       ][INFO    ][26622] Directory /srv/glusterfs/glance is in the correct state
2017-12-01 03:29:03,310 [salt.state       ][INFO    ][26622] Completed state [/srv/glusterfs/glance] at time 03:29:03.310053 duration_in_ms=0.554
2017-12-01 03:29:03,310 [salt.state       ][INFO    ][26622] Running state [/srv/glusterfs/keystone-keys] at time 03:29:03.310195
2017-12-01 03:29:03,310 [salt.state       ][INFO    ][26622] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-12-01 03:29:03,311 [salt.state       ][INFO    ][26622] Directory /srv/glusterfs/keystone-keys is in the correct state
2017-12-01 03:29:03,311 [salt.state       ][INFO    ][26622] Completed state [/srv/glusterfs/keystone-keys] at time 03:29:03.310784 duration_in_ms=0.59
2017-12-01 03:29:03,311 [salt.state       ][INFO    ][26622] Running state [/srv/glusterfs/nova_instances] at time 03:29:03.310932
2017-12-01 03:29:03,311 [salt.state       ][INFO    ][26622] Executing state file.directory for /srv/glusterfs/nova_instances
2017-12-01 03:29:03,311 [salt.state       ][INFO    ][26622] Directory /srv/glusterfs/nova_instances is in the correct state
2017-12-01 03:29:03,312 [salt.state       ][INFO    ][26622] Completed state [/srv/glusterfs/nova_instances] at time 03:29:03.311510 duration_in_ms=0.578
2017-12-01 03:29:03,312 [salt.state       ][INFO    ][26622] Running state [/srv/glusterfs/keystone-credential-keys] at time 03:29:03.311653
2017-12-01 03:29:03,312 [salt.state       ][INFO    ][26622] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-12-01 03:29:03,312 [salt.state       ][INFO    ][26622] Directory /srv/glusterfs/keystone-credential-keys is in the correct state
2017-12-01 03:29:03,312 [salt.state       ][INFO    ][26622] Completed state [/srv/glusterfs/keystone-credential-keys] at time 03:29:03.312227 duration_in_ms=0.574
2017-12-01 03:29:03,364 [salt.loaded.int.module.cmdmod][INFO    ][26622] Executing command ['git', '--version'] in directory '/root'
2017-12-01 03:29:03,455 [salt.state       ][INFO    ][26622] Running state [sleep 5] at time 03:29:03.454943
2017-12-01 03:29:03,455 [salt.state       ][INFO    ][26622] Executing state cmd.wait for sleep 5
2017-12-01 03:29:03,455 [salt.state       ][INFO    ][26622] No changes made for sleep 5
2017-12-01 03:29:03,456 [salt.state       ][INFO    ][26622] Completed state [sleep 5] at time 03:29:03.455510 duration_in_ms=0.567
2017-12-01 03:29:03,456 [salt.state       ][INFO    ][26622] Running state [10.167.4.141] at time 03:29:03.455915
2017-12-01 03:29:03,456 [salt.state       ][INFO    ][26622] Executing state glusterfs.peered for 10.167.4.141
2017-12-01 03:29:03,456 [salt.loaded.int.module.cmdmod][INFO    ][26622] Executing command 'gluster --version' in directory '/root'
2017-12-01 03:29:03,466 [salt.loaded.int.module.cmdmod][INFO    ][26622] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-01 03:29:03,517 [salt.state       ][INFO    ][26622] Host 10.167.4.141 already peered
2017-12-01 03:29:03,517 [salt.state       ][INFO    ][26622] Completed state [10.167.4.141] at time 03:29:03.517070 duration_in_ms=61.155
2017-12-01 03:29:03,519 [salt.state       ][INFO    ][26622] Running state [10.167.4.142] at time 03:29:03.519406
2017-12-01 03:29:03,520 [salt.state       ][INFO    ][26622] Executing state glusterfs.peered for 10.167.4.142
2017-12-01 03:29:03,520 [salt.loaded.int.module.cmdmod][INFO    ][26622] Executing command 'gluster --version' in directory '/root'
2017-12-01 03:29:03,529 [salt.loaded.int.module.cmdmod][INFO    ][26622] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-01 03:29:03,581 [salt.loaded.int.module.cmdmod][INFO    ][26622] Executing command 'gluster --version' in directory '/root'
2017-12-01 03:29:03,588 [salt.loaded.int.module.cmdmod][INFO    ][26622] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-01 03:29:03,645 [salt.loaded.int.module.cmdmod][INFO    ][26622] Executing command 'gluster --version' in directory '/root'
2017-12-01 03:29:03,652 [salt.loaded.int.module.cmdmod][INFO    ][26622] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-01 03:29:03,719 [salt.loaded.int.module.cmdmod][INFO    ][26622] Executing command 'gluster --version' in directory '/root'
2017-12-01 03:29:03,726 [salt.loaded.int.module.cmdmod][INFO    ][26622] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-01 03:29:03,778 [salt.state       ][INFO    ][26622] {'new': {'10.167.4.141': [], 'kvm02.baremetal-mcp-ocata-ovs-ha.local': ['10.167.4.142']}, 'old': {'10.167.4.141': [], 'kvm02.baremetal-mcp-ocata-ovs-ha.local': []}}
2017-12-01 03:29:03,778 [salt.state       ][INFO    ][26622] Completed state [10.167.4.142] at time 03:29:03.778084 duration_in_ms=258.678
2017-12-01 03:29:03,780 [salt.state       ][INFO    ][26622] Running state [10.167.4.143] at time 03:29:03.780320
2017-12-01 03:29:03,781 [salt.state       ][INFO    ][26622] Executing state glusterfs.peered for 10.167.4.143
2017-12-01 03:29:03,781 [salt.loaded.int.module.cmdmod][INFO    ][26622] Executing command 'gluster --version' in directory '/root'
2017-12-01 03:29:03,790 [salt.loaded.int.module.cmdmod][INFO    ][26622] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-01 03:29:03,841 [salt.loaded.int.module.cmdmod][INFO    ][26622] Executing command 'gluster --version' in directory '/root'
2017-12-01 03:29:03,850 [salt.loaded.int.module.cmdmod][INFO    ][26622] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-01 03:29:03,901 [salt.loaded.int.module.cmdmod][INFO    ][26622] Executing command 'gluster --version' in directory '/root'
2017-12-01 03:29:03,910 [salt.loaded.int.module.cmdmod][INFO    ][26622] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-01 03:29:03,965 [salt.loaded.int.module.cmdmod][INFO    ][26622] Executing command 'gluster --version' in directory '/root'
2017-12-01 03:29:03,973 [salt.loaded.int.module.cmdmod][INFO    ][26622] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-01 03:29:04,022 [salt.state       ][INFO    ][26622] Peering with localhost is not needed
2017-12-01 03:29:04,022 [salt.state       ][INFO    ][26622] Completed state [10.167.4.143] at time 03:29:04.022088 duration_in_ms=241.768
2017-12-01 03:29:04,023 [salt.state       ][INFO    ][26622] Running state [glance] at time 03:29:04.022873
2017-12-01 03:29:04,023 [salt.state       ][INFO    ][26622] Executing state glusterfs.created for glance
2017-12-01 03:29:04,023 [salt.loaded.int.module.cmdmod][INFO    ][26622] Executing command 'gluster --version' in directory '/root'
2017-12-01 03:29:04,032 [salt.loaded.int.module.cmdmod][INFO    ][26622] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-01 03:29:04,082 [salt.loaded.int.module.cmdmod][INFO    ][26622] Executing command 'gluster --version' in directory '/root'
2017-12-01 03:29:04,089 [salt.loaded.int.module.cmdmod][INFO    ][26622] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-01 03:29:04,177 [salt.state       ][INFO    ][26622] Volume glance already exists and is started.
2017-12-01 03:29:04,177 [salt.state       ][INFO    ][26622] Completed state [glance] at time 03:29:04.177457 duration_in_ms=154.584
2017-12-01 03:29:04,180 [salt.state       ][INFO    ][26622] Running state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 03:29:04.180419
2017-12-01 03:29:04,181 [salt.state       ][INFO    ][26622] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'
2017-12-01 03:29:04,181 [salt.loaded.int.module.cmdmod][INFO    ][26622] Executing command 'gluster volume info 'glance' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-12-01 03:29:04,232 [salt.state       ][INFO    ][26622] unless execution succeeded
2017-12-01 03:29:04,232 [salt.state       ][INFO    ][26622] Completed state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 03:29:04.231731 duration_in_ms=51.311
2017-12-01 03:29:04,232 [salt.state       ][INFO    ][26622] Running state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 03:29:04.232235
2017-12-01 03:29:04,232 [salt.state       ][INFO    ][26622] Executing state cmd.run for gluster volume set 'glance' 'network.remote-dio' 'True'
2017-12-01 03:29:04,233 [salt.loaded.int.module.cmdmod][INFO    ][26622] Executing command 'gluster volume info 'glance' | grep 'network.remote-dio: True'' in directory '/root'
2017-12-01 03:29:04,286 [salt.state       ][INFO    ][26622] unless execution succeeded
2017-12-01 03:29:04,286 [salt.state       ][INFO    ][26622] Completed state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 03:29:04.285845 duration_in_ms=53.61
2017-12-01 03:29:04,286 [salt.state       ][INFO    ][26622] Running state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 03:29:04.286267
2017-12-01 03:29:04,286 [salt.state       ][INFO    ][26622] Executing state cmd.run for gluster volume set 'glance' 'nfs.disable' 'True'
2017-12-01 03:29:04,287 [salt.loaded.int.module.cmdmod][INFO    ][26622] Executing command 'gluster volume info 'glance' | grep 'nfs.disable: True'' in directory '/root'
2017-12-01 03:29:04,338 [salt.state       ][INFO    ][26622] unless execution succeeded
2017-12-01 03:29:04,339 [salt.state       ][INFO    ][26622] Completed state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 03:29:04.338597 duration_in_ms=52.329
2017-12-01 03:29:04,339 [salt.state       ][INFO    ][26622] Running state [gluster volume set 'glance' 'cluster.favorite-child-policy' 'mtime'] at time 03:29:04.339051
2017-12-01 03:29:04,339 [salt.state       ][INFO    ][26622] Executing state cmd.run for gluster volume set 'glance' 'cluster.favorite-child-policy' 'mtime'
2017-12-01 03:29:04,340 [salt.loaded.int.module.cmdmod][INFO    ][26622] Executing command 'gluster volume info 'glance' | grep 'cluster.favorite-child-policy: mtime'' in directory '/root'
2017-12-01 03:29:04,390 [salt.state       ][INFO    ][26622] unless execution succeeded
2017-12-01 03:29:04,390 [salt.state       ][INFO    ][26622] Completed state [gluster volume set 'glance' 'cluster.favorite-child-policy' 'mtime'] at time 03:29:04.390156 duration_in_ms=51.105
2017-12-01 03:29:04,391 [salt.state       ][INFO    ][26622] Running state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 03:29:04.390593
2017-12-01 03:29:04,391 [salt.state       ][INFO    ][26622] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'
2017-12-01 03:29:04,391 [salt.loaded.int.module.cmdmod][INFO    ][26622] Executing command 'gluster volume info 'glance' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-12-01 03:29:04,440 [salt.state       ][INFO    ][26622] unless execution succeeded
2017-12-01 03:29:04,440 [salt.state       ][INFO    ][26622] Completed state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 03:29:04.440460 duration_in_ms=49.867
2017-12-01 03:29:04,441 [salt.state       ][INFO    ][26622] Running state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 03:29:04.440899
2017-12-01 03:29:04,441 [salt.state       ][INFO    ][26622] Executing state cmd.run for gluster volume set 'glance' 'cluster.readdir-optimize' 'True'
2017-12-01 03:29:04,442 [salt.loaded.int.module.cmdmod][INFO    ][26622] Executing command 'gluster volume info 'glance' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-12-01 03:29:04,493 [salt.state       ][INFO    ][26622] unless execution succeeded
2017-12-01 03:29:04,493 [salt.state       ][INFO    ][26622] Completed state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 03:29:04.493064 duration_in_ms=52.164
2017-12-01 03:29:04,494 [salt.state       ][INFO    ][26622] Running state [glance] at time 03:29:04.494126
2017-12-01 03:29:04,494 [salt.state       ][INFO    ][26622] Executing state glusterfs.started for glance
2017-12-01 03:29:04,495 [salt.loaded.int.module.cmdmod][INFO    ][26622] Executing command 'gluster --version' in directory '/root'
2017-12-01 03:29:04,501 [salt.loaded.int.module.cmdmod][INFO    ][26622] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-01 03:29:04,552 [salt.loaded.int.module.cmdmod][INFO    ][26622] Executing command 'gluster --version' in directory '/root'
2017-12-01 03:29:04,560 [salt.loaded.int.module.cmdmod][INFO    ][26622] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-01 03:29:04,614 [salt.state       ][INFO    ][26622] Volume glance is already started
2017-12-01 03:29:04,614 [salt.state       ][INFO    ][26622] Completed state [glance] at time 03:29:04.614258 duration_in_ms=120.131
2017-12-01 03:29:04,615 [salt.state       ][INFO    ][26622] Running state [keystone-keys] at time 03:29:04.615142
2017-12-01 03:29:04,615 [salt.state       ][INFO    ][26622] Executing state glusterfs.created for keystone-keys
2017-12-01 03:29:04,616 [salt.loaded.int.module.cmdmod][INFO    ][26622] Executing command 'gluster --version' in directory '/root'
2017-12-01 03:29:04,624 [salt.loaded.int.module.cmdmod][INFO    ][26622] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-01 03:29:04,674 [salt.loaded.int.module.cmdmod][INFO    ][26622] Executing command 'gluster --version' in directory '/root'
2017-12-01 03:29:04,683 [salt.loaded.int.module.cmdmod][INFO    ][26622] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-01 03:29:04,738 [salt.state       ][INFO    ][26622] Volume keystone-keys already exists and is started.
2017-12-01 03:29:04,738 [salt.state       ][INFO    ][26622] Completed state [keystone-keys] at time 03:29:04.738315 duration_in_ms=123.172
2017-12-01 03:29:04,742 [salt.state       ][INFO    ][26622] Running state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 03:29:04.742080
2017-12-01 03:29:04,742 [salt.state       ][INFO    ][26622] Executing state cmd.run for gluster volume set 'keystone-keys' 'network.remote-dio' 'True'
2017-12-01 03:29:04,743 [salt.loaded.int.module.cmdmod][INFO    ][26622] Executing command 'gluster volume info 'keystone-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-12-01 03:29:04,800 [salt.state       ][INFO    ][26622] unless execution succeeded
2017-12-01 03:29:04,800 [salt.state       ][INFO    ][26622] Completed state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 03:29:04.799972 duration_in_ms=57.892
2017-12-01 03:29:04,800 [salt.state       ][INFO    ][26622] Running state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 03:29:04.800402
2017-12-01 03:29:04,801 [salt.state       ][INFO    ][26622] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-12-01 03:29:04,801 [salt.loaded.int.module.cmdmod][INFO    ][26622] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-12-01 03:29:04,854 [salt.state       ][INFO    ][26622] unless execution succeeded
2017-12-01 03:29:04,854 [salt.state       ][INFO    ][26622] Completed state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 03:29:04.854289 duration_in_ms=53.887
2017-12-01 03:29:04,855 [salt.state       ][INFO    ][26622] Running state [gluster volume set 'keystone-keys' 'cluster.favorite-child-policy' 'mtime'] at time 03:29:04.854833
2017-12-01 03:29:04,855 [salt.state       ][INFO    ][26622] Executing state cmd.run for gluster volume set 'keystone-keys' 'cluster.favorite-child-policy' 'mtime'
2017-12-01 03:29:04,856 [salt.loaded.int.module.cmdmod][INFO    ][26622] Executing command 'gluster volume info 'keystone-keys' | grep 'cluster.favorite-child-policy: mtime'' in directory '/root'
2017-12-01 03:29:04,906 [salt.state       ][INFO    ][26622] unless execution succeeded
2017-12-01 03:29:04,906 [salt.state       ][INFO    ][26622] Completed state [gluster volume set 'keystone-keys' 'cluster.favorite-child-policy' 'mtime'] at time 03:29:04.905882 duration_in_ms=51.049
2017-12-01 03:29:04,906 [salt.state       ][INFO    ][26622] Running state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 03:29:04.906379
2017-12-01 03:29:04,907 [salt.state       ][INFO    ][26622] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'
2017-12-01 03:29:04,907 [salt.loaded.int.module.cmdmod][INFO    ][26622] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-12-01 03:29:04,963 [salt.state       ][INFO    ][26622] unless execution succeeded
2017-12-01 03:29:04,963 [salt.state       ][INFO    ][26622] Completed state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 03:29:04.963296 duration_in_ms=56.916
2017-12-01 03:29:04,964 [salt.state       ][INFO    ][26622] Running state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 03:29:04.963810
2017-12-01 03:29:04,964 [salt.state       ][INFO    ][26622] Executing state cmd.run for gluster volume set 'keystone-keys' 'nfs.disable' 'True'
2017-12-01 03:29:04,965 [salt.loaded.int.module.cmdmod][INFO    ][26622] Executing command 'gluster volume info 'keystone-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-12-01 03:29:05,019 [salt.state       ][INFO    ][26622] unless execution succeeded
2017-12-01 03:29:05,019 [salt.state       ][INFO    ][26622] Completed state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 03:29:05.018809 duration_in_ms=54.998
2017-12-01 03:29:05,019 [salt.state       ][INFO    ][26622] Running state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 03:29:05.019245
2017-12-01 03:29:05,019 [salt.state       ][INFO    ][26622] Executing state cmd.run for gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'
2017-12-01 03:29:05,020 [salt.loaded.int.module.cmdmod][INFO    ][26622] Executing command 'gluster volume info 'keystone-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-12-01 03:29:05,071 [salt.state       ][INFO    ][26622] unless execution succeeded
2017-12-01 03:29:05,072 [salt.state       ][INFO    ][26622] Completed state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 03:29:05.071604 duration_in_ms=52.359
2017-12-01 03:29:05,073 [salt.state       ][INFO    ][26622] Running state [keystone-keys] at time 03:29:05.072697
2017-12-01 03:29:05,073 [salt.state       ][INFO    ][26622] Executing state glusterfs.started for keystone-keys
2017-12-01 03:29:05,073 [salt.loaded.int.module.cmdmod][INFO    ][26622] Executing command 'gluster --version' in directory '/root'
2017-12-01 03:29:05,083 [salt.loaded.int.module.cmdmod][INFO    ][26622] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-01 03:29:05,135 [salt.loaded.int.module.cmdmod][INFO    ][26622] Executing command 'gluster --version' in directory '/root'
2017-12-01 03:29:05,144 [salt.loaded.int.module.cmdmod][INFO    ][26622] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-01 03:29:05,201 [salt.state       ][INFO    ][26622] Volume keystone-keys is already started
2017-12-01 03:29:05,201 [salt.state       ][INFO    ][26622] Completed state [keystone-keys] at time 03:29:05.200864 duration_in_ms=128.166
2017-12-01 03:29:05,202 [salt.state       ][INFO    ][26622] Running state [nova_instances] at time 03:29:05.201857
2017-12-01 03:29:05,202 [salt.state       ][INFO    ][26622] Executing state glusterfs.created for nova_instances
2017-12-01 03:29:05,203 [salt.loaded.int.module.cmdmod][INFO    ][26622] Executing command 'gluster --version' in directory '/root'
2017-12-01 03:29:05,212 [salt.loaded.int.module.cmdmod][INFO    ][26622] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-01 03:29:05,265 [salt.loaded.int.module.cmdmod][INFO    ][26622] Executing command 'gluster --version' in directory '/root'
2017-12-01 03:29:05,274 [salt.loaded.int.module.cmdmod][INFO    ][26622] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-01 03:29:05,330 [salt.state       ][INFO    ][26622] Volume nova_instances already exists and is started.
2017-12-01 03:29:05,330 [salt.state       ][INFO    ][26622] Completed state [nova_instances] at time 03:29:05.330095 duration_in_ms=128.236
2017-12-01 03:29:05,334 [salt.state       ][INFO    ][26622] Running state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 03:29:05.333519
2017-12-01 03:29:05,334 [salt.state       ][INFO    ][26622] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'
2017-12-01 03:29:05,334 [salt.loaded.int.module.cmdmod][INFO    ][26622] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-12-01 03:29:05,390 [salt.state       ][INFO    ][26622] unless execution succeeded
2017-12-01 03:29:05,390 [salt.state       ][INFO    ][26622] Completed state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 03:29:05.390415 duration_in_ms=56.896
2017-12-01 03:29:05,391 [salt.state       ][INFO    ][26622] Running state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'True'] at time 03:29:05.390847
2017-12-01 03:29:05,391 [salt.state       ][INFO    ][26622] Executing state cmd.run for gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'True'
2017-12-01 03:29:05,391 [salt.loaded.int.module.cmdmod][INFO    ][26622] Executing command 'gluster volume info 'nova_instances' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-12-01 03:29:05,445 [salt.state       ][INFO    ][26622] unless execution succeeded
2017-12-01 03:29:05,445 [salt.state       ][INFO    ][26622] Completed state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'True'] at time 03:29:05.444899 duration_in_ms=54.052
2017-12-01 03:29:05,446 [salt.state       ][INFO    ][26622] Running state [gluster volume set 'nova_instances' 'network.remote-dio' 'True'] at time 03:29:05.445517
2017-12-01 03:29:05,446 [salt.state       ][INFO    ][26622] Executing state cmd.run for gluster volume set 'nova_instances' 'network.remote-dio' 'True'
2017-12-01 03:29:05,446 [salt.loaded.int.module.cmdmod][INFO    ][26622] Executing command 'gluster volume info 'nova_instances' | grep 'network.remote-dio: True'' in directory '/root'
2017-12-01 03:29:05,500 [salt.state       ][INFO    ][26622] unless execution succeeded
2017-12-01 03:29:05,501 [salt.state       ][INFO    ][26622] Completed state [gluster volume set 'nova_instances' 'network.remote-dio' 'True'] at time 03:29:05.500570 duration_in_ms=55.052
2017-12-01 03:29:05,501 [salt.state       ][INFO    ][26622] Running state [gluster volume set 'nova_instances' 'cluster.favorite-child-policy' 'mtime'] at time 03:29:05.501153
2017-12-01 03:29:05,501 [salt.state       ][INFO    ][26622] Executing state cmd.run for gluster volume set 'nova_instances' 'cluster.favorite-child-policy' 'mtime'
2017-12-01 03:29:05,502 [salt.loaded.int.module.cmdmod][INFO    ][26622] Executing command 'gluster volume info 'nova_instances' | grep 'cluster.favorite-child-policy: mtime'' in directory '/root'
2017-12-01 03:29:05,553 [salt.state       ][INFO    ][26622] unless execution succeeded
2017-12-01 03:29:05,553 [salt.state       ][INFO    ][26622] Completed state [gluster volume set 'nova_instances' 'cluster.favorite-child-policy' 'mtime'] at time 03:29:05.553112 duration_in_ms=51.958
2017-12-01 03:29:05,554 [salt.state       ][INFO    ][26622] Running state [gluster volume set 'nova_instances' 'nfs.disable' 'True'] at time 03:29:05.553656
2017-12-01 03:29:05,554 [salt.state       ][INFO    ][26622] Executing state cmd.run for gluster volume set 'nova_instances' 'nfs.disable' 'True'
2017-12-01 03:29:05,554 [salt.loaded.int.module.cmdmod][INFO    ][26622] Executing command 'gluster volume info 'nova_instances' | grep 'nfs.disable: True'' in directory '/root'
2017-12-01 03:29:05,609 [salt.state       ][INFO    ][26622] unless execution succeeded
2017-12-01 03:29:05,609 [salt.state       ][INFO    ][26622] Completed state [gluster volume set 'nova_instances' 'nfs.disable' 'True'] at time 03:29:05.608932 duration_in_ms=55.275
2017-12-01 03:29:05,613 [salt.state       ][INFO    ][26622] Running state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 03:29:05.613101
2017-12-01 03:29:05,614 [salt.state       ][INFO    ][26622] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'
2017-12-01 03:29:05,615 [salt.loaded.int.module.cmdmod][INFO    ][26622] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-12-01 03:29:05,669 [salt.state       ][INFO    ][26622] unless execution succeeded
2017-12-01 03:29:05,670 [salt.state       ][INFO    ][26622] Completed state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 03:29:05.669479 duration_in_ms=56.379
2017-12-01 03:29:05,671 [salt.state       ][INFO    ][26622] Running state [nova_instances] at time 03:29:05.670615
2017-12-01 03:29:05,671 [salt.state       ][INFO    ][26622] Executing state glusterfs.started for nova_instances
2017-12-01 03:29:05,671 [salt.loaded.int.module.cmdmod][INFO    ][26622] Executing command 'gluster --version' in directory '/root'
2017-12-01 03:29:05,680 [salt.loaded.int.module.cmdmod][INFO    ][26622] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-01 03:29:05,731 [salt.loaded.int.module.cmdmod][INFO    ][26622] Executing command 'gluster --version' in directory '/root'
2017-12-01 03:29:05,740 [salt.loaded.int.module.cmdmod][INFO    ][26622] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-01 03:29:05,798 [salt.state       ][INFO    ][26622] Volume nova_instances is already started
2017-12-01 03:29:05,798 [salt.state       ][INFO    ][26622] Completed state [nova_instances] at time 03:29:05.797702 duration_in_ms=127.086
2017-12-01 03:29:05,799 [salt.state       ][INFO    ][26622] Running state [keystone-credential-keys] at time 03:29:05.798819
2017-12-01 03:29:05,799 [salt.state       ][INFO    ][26622] Executing state glusterfs.created for keystone-credential-keys
2017-12-01 03:29:05,799 [salt.loaded.int.module.cmdmod][INFO    ][26622] Executing command 'gluster --version' in directory '/root'
2017-12-01 03:29:05,808 [salt.loaded.int.module.cmdmod][INFO    ][26622] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-01 03:29:05,860 [salt.loaded.int.module.cmdmod][INFO    ][26622] Executing command 'gluster --version' in directory '/root'
2017-12-01 03:29:05,867 [salt.loaded.int.module.cmdmod][INFO    ][26622] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-01 03:29:05,922 [salt.state       ][INFO    ][26622] Volume keystone-credential-keys already exists and is started.
2017-12-01 03:29:05,922 [salt.state       ][INFO    ][26622] Completed state [keystone-credential-keys] at time 03:29:05.922096 duration_in_ms=123.277
2017-12-01 03:29:05,926 [salt.state       ][INFO    ][26622] Running state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 03:29:05.925735
2017-12-01 03:29:05,926 [salt.state       ][INFO    ][26622] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'
2017-12-01 03:29:05,926 [salt.loaded.int.module.cmdmod][INFO    ][26622] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-12-01 03:29:05,978 [salt.state       ][INFO    ][26622] unless execution succeeded
2017-12-01 03:29:05,978 [salt.state       ][INFO    ][26622] Completed state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 03:29:05.978052 duration_in_ms=52.317
2017-12-01 03:29:05,979 [salt.state       ][INFO    ][26622] Running state [gluster volume set 'keystone-credential-keys' 'cluster.favorite-child-policy' 'mtime'] at time 03:29:05.978489
2017-12-01 03:29:05,979 [salt.state       ][INFO    ][26622] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'cluster.favorite-child-policy' 'mtime'
2017-12-01 03:29:05,979 [salt.loaded.int.module.cmdmod][INFO    ][26622] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'cluster.favorite-child-policy: mtime'' in directory '/root'
2017-12-01 03:29:06,029 [salt.state       ][INFO    ][26622] unless execution succeeded
2017-12-01 03:29:06,029 [salt.state       ][INFO    ][26622] Completed state [gluster volume set 'keystone-credential-keys' 'cluster.favorite-child-policy' 'mtime'] at time 03:29:06.029237 duration_in_ms=50.748
2017-12-01 03:29:06,030 [salt.state       ][INFO    ][26622] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 03:29:06.029710
2017-12-01 03:29:06,030 [salt.state       ][INFO    ][26622] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-12-01 03:29:06,030 [salt.loaded.int.module.cmdmod][INFO    ][26622] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-12-01 03:29:06,083 [salt.state       ][INFO    ][26622] unless execution succeeded
2017-12-01 03:29:06,083 [salt.state       ][INFO    ][26622] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 03:29:06.083191 duration_in_ms=53.479
2017-12-01 03:29:06,084 [salt.state       ][INFO    ][26622] Running state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 03:29:06.083625
2017-12-01 03:29:06,084 [salt.state       ][INFO    ][26622] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'
2017-12-01 03:29:06,084 [salt.loaded.int.module.cmdmod][INFO    ][26622] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-12-01 03:29:06,135 [salt.state       ][INFO    ][26622] unless execution succeeded
2017-12-01 03:29:06,135 [salt.state       ][INFO    ][26622] Completed state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 03:29:06.135432 duration_in_ms=51.807
2017-12-01 03:29:06,136 [salt.state       ][INFO    ][26622] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 03:29:06.135949
2017-12-01 03:29:06,136 [salt.state       ][INFO    ][26622] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'
2017-12-01 03:29:06,137 [salt.loaded.int.module.cmdmod][INFO    ][26622] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-12-01 03:29:06,189 [salt.state       ][INFO    ][26622] unless execution succeeded
2017-12-01 03:29:06,189 [salt.state       ][INFO    ][26622] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 03:29:06.188856 duration_in_ms=52.907
2017-12-01 03:29:06,189 [salt.state       ][INFO    ][26622] Running state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 03:29:06.189372
2017-12-01 03:29:06,190 [salt.state       ][INFO    ][26622] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'
2017-12-01 03:29:06,190 [salt.loaded.int.module.cmdmod][INFO    ][26622] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-12-01 03:29:06,241 [salt.state       ][INFO    ][26622] unless execution succeeded
2017-12-01 03:29:06,242 [salt.state       ][INFO    ][26622] Completed state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 03:29:06.241552 duration_in_ms=52.178
2017-12-01 03:29:06,243 [salt.state       ][INFO    ][26622] Running state [keystone-credential-keys] at time 03:29:06.242607
2017-12-01 03:29:06,243 [salt.state       ][INFO    ][26622] Executing state glusterfs.started for keystone-credential-keys
2017-12-01 03:29:06,243 [salt.loaded.int.module.cmdmod][INFO    ][26622] Executing command 'gluster --version' in directory '/root'
2017-12-01 03:29:06,251 [salt.loaded.int.module.cmdmod][INFO    ][26622] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-01 03:29:06,301 [salt.loaded.int.module.cmdmod][INFO    ][26622] Executing command 'gluster --version' in directory '/root'
2017-12-01 03:29:06,309 [salt.loaded.int.module.cmdmod][INFO    ][26622] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-01 03:29:06,365 [salt.state       ][INFO    ][26622] Volume keystone-credential-keys is already started
2017-12-01 03:29:06,365 [salt.state       ][INFO    ][26622] Completed state [keystone-credential-keys] at time 03:29:06.364806 duration_in_ms=122.198
2017-12-01 03:29:06,367 [salt.minion      ][INFO    ][26622] Returning information for job: 20171201032900894829
2017-12-01 03:29:11,813 [salt.minion      ][INFO    ][21188] User sudo_ubuntu Executing command test.ping with jid 20171201032911799457
2017-12-01 03:29:11,828 [salt.minion      ][INFO    ][27182] Starting a new job with PID 27182
2017-12-01 03:29:11,854 [salt.minion      ][INFO    ][27182] Returning information for job: 20171201032911799457
2017-12-01 03:29:12,248 [salt.minion      ][INFO    ][21188] User sudo_ubuntu Executing command cmd.run with jid 20171201032912234696
2017-12-01 03:29:12,263 [salt.minion      ][INFO    ][27187] Starting a new job with PID 27187
2017-12-01 03:29:12,267 [salt.loaded.int.module.cmdmod][INFO    ][27187] Executing command 'gluster peer status; gluster volume status' in directory '/root'
2017-12-01 03:29:12,384 [salt.minion      ][INFO    ][27187] Returning information for job: 20171201032912234696
2017-12-01 04:06:07,657 [salt.utils.schedule][INFO    ][21188] Running scheduled job: __mine_interval
2017-12-01 04:59:11,416 [salt.minion      ][INFO    ][21188] User sudo_ubuntu Executing command cp.push_dir with jid 20171201045911406373
2017-12-01 04:59:11,437 [salt.minion      ][INFO    ][28296] Starting a new job with PID 28296
