2017-11-29 12:13:12,531 [salt.cli.daemons ][WARNING ][2098] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-11-29 12:13:29,446 [salt.state       ][ERROR   ][3678] No contents found in top file
2017-11-29 12:13:55,983 [salt.transport.ipc][ERROR   ][2098] Exception occurred while handling stream: [Errno 0] Success
2017-11-29 12:15:03,696 [salt.utils.parsers][WARNING ][2098] Minion received a SIGTERM. Exiting.
2017-11-29 12:19:33,368 [salt.cli.daemons ][WARNING ][3374] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-11-29 12:22:25,577 [py.warnings      ][WARNING ][13746] /usr/lib/python2.7/dist-packages/salt/utils/templates.py:73: DeprecationWarning: Starting in 2015.5, cmd.run uses python_shell=False by default, which doesn't support shellisms (pipes, env variables, etc). cmd.run is currently aliased to cmd.shell to prevent breakage. Please switch to cmd.shell or set python_shell=True to avoid breakage in the future, when this aliasing is removed.

2017-11-29 12:24:38,154 [salt.loaded.int.module.cmdmod][ERROR   ][13746] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-11-29 12:24:38,154 [salt.loaded.int.module.cmdmod][ERROR   ][13746] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-11-29 12:24:42,784 [salt.loaded.int.module.cmdmod][ERROR   ][13746] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-11-29 12:24:42,784 [salt.loaded.int.module.cmdmod][ERROR   ][13746] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-11-29 12:24:47,447 [salt.loaded.int.module.cmdmod][ERROR   ][13746] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-11-29 12:24:47,448 [salt.loaded.int.module.cmdmod][ERROR   ][13746] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-11-29 12:24:52,860 [salt.loaded.int.module.cmdmod][ERROR   ][13746] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-11-29 12:24:52,861 [salt.loaded.int.module.cmdmod][ERROR   ][13746] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-11-29 12:24:57,289 [salt.loaded.int.module.cmdmod][ERROR   ][13746] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-11-29 12:24:57,290 [salt.loaded.int.module.cmdmod][ERROR   ][13746] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-11-29 12:25:01,283 [salt.loaded.int.module.cmdmod][ERROR   ][13746] Command 'while true; do salt-call saltutil.running|grep fun: && continue; salt-call --local service.restart salt-minion; break; done' failed with return code: None
2017-11-29 12:25:05,025 [salt.state       ][ERROR   ][21269] No contents found in top file
2017-11-29 12:25:08,914 [salt.loaded.int.module.cmdmod][INFO    ][21495] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2017-11-29 12:25:08,921 [salt.loaded.int.module.cmdmod][INFO    ][21495] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2017-11-29 12:25:08,932 [salt.loaded.int.module.cmdmod][INFO    ][21495] Executing command ['systemd-run', '--scope', 'systemctl', 'restart', 'salt-minion.service'] in directory '/root'
2017-11-29 12:25:08,941 [salt.utils.parsers][WARNING ][3374] Minion received a SIGTERM. Exiting.
2017-11-29 12:25:09,241 [salt.cli.daemons ][INFO    ][21605] Setting up the Salt Minion "kvm03.baremetal-mcp-ocata-ovs-ha.local"
2017-11-29 12:25:09,869 [salt.minion      ][INFO    ][21605] Creating minion process manager
2017-11-29 12:25:09,870 [salt.cli.daemons ][WARNING ][21605] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-11-29 12:25:09,870 [salt.cli.daemons ][INFO    ][21605] The Salt Minion is starting up
2017-11-29 12:25:09,870 [salt.minion      ][INFO    ][21605] Minion is starting as user 'root'
2017-11-29 12:25:09,871 [salt.utils.event ][INFO    ][21605] Starting pull socket on /var/run/salt/minion/minion_event_98ff1e569f_pull.ipc
2017-11-29 12:25:11,047 [salt.loaded.int.module.cmdmod][INFO    ][21605] Executing command ['date', '+%z'] in directory '/root'
2017-11-29 12:25:11,060 [salt.utils.schedule][INFO    ][21605] Updating job settings for scheduled job: __mine_interval
2017-11-29 12:25:11,063 [salt.minion      ][INFO    ][21605] Added mine.update to scheduler
2017-11-29 12:25:11,087 [salt.minion      ][INFO    ][21605] Minion is ready to receive requests!
2017-11-29 12:25:12,089 [salt.utils.schedule][INFO    ][21605] Running scheduled job: __mine_interval
2017-11-29 12:25:17,837 [salt.minion      ][INFO    ][21605] User sudo_ubuntu Executing command saltutil.find_job with jid 20171129122517824366
2017-11-29 12:25:17,845 [salt.minion      ][INFO    ][21704] Starting a new job with PID 21704
2017-11-29 12:25:17,853 [salt.minion      ][INFO    ][21704] Returning information for job: 20171129122517824366
2017-11-29 12:25:38,781 [salt.minion      ][INFO    ][21605] User sudo_ubuntu Executing command state.sls with jid 20171129122538764378
2017-11-29 12:25:38,790 [salt.minion      ][INFO    ][21710] Starting a new job with PID 21710
2017-11-29 12:25:41,441 [salt.state       ][INFO    ][21710] Loading fresh modules for state activity
2017-11-29 12:25:41,471 [salt.fileclient  ][INFO    ][21710] Fetching file from saltenv 'base', ** done ** 'salt/control/init.sls'
2017-11-29 12:25:41,495 [salt.fileclient  ][INFO    ][21710] Fetching file from saltenv 'base', ** done ** 'salt/control/virt.sls'
2017-11-29 12:25:41,524 [salt.fileclient  ][INFO    ][21710] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-11-29 12:25:41,610 [salt.fileclient  ][INFO    ][21710] Fetching file from saltenv 'base', ** done ** 'salt/minion/init.sls'
2017-11-29 12:25:41,624 [salt.fileclient  ][INFO    ][21710] Fetching file from saltenv 'base', ** done ** 'salt/minion/service.sls'
2017-11-29 12:25:41,656 [salt.fileclient  ][INFO    ][21710] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-11-29 12:25:41,762 [salt.fileclient  ][INFO    ][21710] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-11-29 12:25:41,783 [salt.fileclient  ][INFO    ][21710] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-11-29 12:25:41,840 [salt.fileclient  ][INFO    ][21710] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-11-29 12:25:41,859 [salt.fileclient  ][INFO    ][21710] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-11-29 12:25:41,872 [salt.fileclient  ][INFO    ][21710] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-11-29 12:25:41,891 [salt.fileclient  ][INFO    ][21710] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-11-29 12:25:41,900 [salt.loaded.int.module.cmdmod][INFO    ][21710] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-11-29 12:25:41,926 [salt.fileclient  ][INFO    ][21710] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-11-29 12:25:41,944 [py.warnings      ][WARNING ][21710] /usr/lib/python2.7/dist-packages/salt/utils/templates.py:73: DeprecationWarning: Starting in 2015.5, cmd.run uses python_shell=False by default, which doesn't support shellisms (pipes, env variables, etc). cmd.run is currently aliased to cmd.shell to prevent breakage. Please switch to cmd.shell or set python_shell=True to avoid breakage in the future, when this aliasing is removed.

2017-11-29 12:25:41,944 [salt.loaded.int.module.cmdmod][INFO    ][21710] Executing command 'salt-minion --version' in directory '/root'
2017-11-29 12:25:42,200 [salt.fileclient  ][INFO    ][21710] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-11-29 12:25:42,220 [salt.fileclient  ][INFO    ][21710] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-11-29 12:25:42,231 [salt.fileclient  ][INFO    ][21710] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-11-29 12:25:42,244 [salt.fileclient  ][INFO    ][21710] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-11-29 12:25:42,287 [salt.fileclient  ][INFO    ][21710] Fetching file from saltenv 'base', ** done ** 'reclass/meta/meta.yml'
2017-11-29 12:25:42,303 [salt.fileclient  ][INFO    ][21710] Fetching file from saltenv 'base', ** done ** 'reclass/map.jinja'
2017-11-29 12:25:42,329 [salt.fileclient  ][INFO    ][21710] Fetching file from saltenv 'base', ** done ** 'ntp/meta/meta.yml'
2017-11-29 12:25:42,345 [salt.fileclient  ][INFO    ][21710] Fetching file from saltenv 'base', ** done ** 'ntp/map.jinja'
2017-11-29 12:25:42,363 [salt.fileclient  ][INFO    ][21710] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-11-29 12:25:42,404 [salt.fileclient  ][INFO    ][21710] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-11-29 12:25:42,474 [salt.fileclient  ][INFO    ][21710] Fetching file from saltenv 'base', ** done ** 'salt/minion/grains.sls'
2017-11-29 12:25:42,500 [salt.fileclient  ][INFO    ][21710] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-11-29 12:25:42,571 [salt.fileclient  ][INFO    ][21710] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-11-29 12:25:42,592 [salt.fileclient  ][INFO    ][21710] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-11-29 12:25:42,650 [salt.fileclient  ][INFO    ][21710] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-11-29 12:25:42,671 [salt.fileclient  ][INFO    ][21710] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-11-29 12:25:42,686 [salt.fileclient  ][INFO    ][21710] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-11-29 12:25:42,708 [salt.fileclient  ][INFO    ][21710] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-11-29 12:25:42,717 [salt.loaded.int.module.cmdmod][INFO    ][21710] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-11-29 12:25:42,739 [salt.fileclient  ][INFO    ][21710] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-11-29 12:25:42,758 [salt.loaded.int.module.cmdmod][INFO    ][21710] Executing command 'salt-minion --version' in directory '/root'
2017-11-29 12:25:43,019 [salt.fileclient  ][INFO    ][21710] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-11-29 12:25:43,044 [salt.fileclient  ][INFO    ][21710] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-11-29 12:25:43,055 [salt.fileclient  ][INFO    ][21710] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-11-29 12:25:43,069 [salt.fileclient  ][INFO    ][21710] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-11-29 12:25:43,113 [salt.fileclient  ][INFO    ][21710] Fetching file from saltenv 'base', ** done ** 'reclass/meta/meta.yml'
2017-11-29 12:25:43,130 [salt.fileclient  ][INFO    ][21710] Fetching file from saltenv 'base', ** done ** 'reclass/map.jinja'
2017-11-29 12:25:43,157 [salt.fileclient  ][INFO    ][21710] Fetching file from saltenv 'base', ** done ** 'ntp/meta/meta.yml'
2017-11-29 12:25:43,171 [salt.fileclient  ][INFO    ][21710] Fetching file from saltenv 'base', ** done ** 'ntp/map.jinja'
2017-11-29 12:25:43,191 [salt.fileclient  ][INFO    ][21710] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-11-29 12:25:43,231 [salt.fileclient  ][INFO    ][21710] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-11-29 12:25:43,308 [salt.fileclient  ][INFO    ][21710] Fetching file from saltenv 'base', ** done ** 'salt/minion/cert.sls'
2017-11-29 12:25:43,379 [salt.fileclient  ][INFO    ][21710] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-11-29 12:25:43,745 [salt.state       ][INFO    ][21710] Running state [salt-minion] at time 12:25:43.745140
2017-11-29 12:25:43,745 [salt.state       ][INFO    ][21710] Executing state pkg.installed for salt-minion
2017-11-29 12:25:43,746 [salt.loaded.int.module.cmdmod][INFO    ][21710] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-29 12:25:44,002 [salt.state       ][INFO    ][21710] Package salt-minion is already installed
2017-11-29 12:25:44,002 [salt.state       ][INFO    ][21710] Completed state [salt-minion] at time 12:25:44.001930 duration_in_ms=256.789
2017-11-29 12:25:44,002 [salt.state       ][INFO    ][21710] Running state [salt_minion_dependency_packages] at time 12:25:44.002211
2017-11-29 12:25:44,002 [salt.state       ][INFO    ][21710] Executing state pkg.installed for salt_minion_dependency_packages
2017-11-29 12:25:44,006 [salt.state       ][INFO    ][21710] All specified packages are already installed
2017-11-29 12:25:44,006 [salt.state       ][INFO    ][21710] Completed state [salt_minion_dependency_packages] at time 12:25:44.006366 duration_in_ms=4.155
2017-11-29 12:25:44,008 [salt.state       ][INFO    ][21710] Running state [/etc/salt/minion.d/minion.conf] at time 12:25:44.007989
2017-11-29 12:25:44,008 [salt.state       ][INFO    ][21710] Executing state file.managed for /etc/salt/minion.d/minion.conf
2017-11-29 12:25:44,031 [salt.fileclient  ][INFO    ][21710] Fetching file from saltenv 'base', ** done ** 'salt/files/minion.conf'
2017-11-29 12:25:44,089 [salt.fileclient  ][INFO    ][21710] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-11-29 12:25:44,144 [salt.fileclient  ][INFO    ][21710] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-11-29 12:25:44,190 [salt.state       ][INFO    ][21710] File /etc/salt/minion.d/minion.conf is in the correct state
2017-11-29 12:25:44,191 [salt.state       ][INFO    ][21710] Completed state [/etc/salt/minion.d/minion.conf] at time 12:25:44.190617 duration_in_ms=182.628
2017-11-29 12:25:44,191 [salt.state       ][INFO    ][21710] Running state [/etc/salt/minion.d/_virt.conf] at time 12:25:44.190988
2017-11-29 12:25:44,191 [salt.state       ][INFO    ][21710] Executing state file.managed for /etc/salt/minion.d/_virt.conf
2017-11-29 12:25:44,192 [salt.state       ][INFO    ][21710] File /etc/salt/minion.d/_virt.conf is in the correct state
2017-11-29 12:25:44,192 [salt.state       ][INFO    ][21710] Completed state [/etc/salt/minion.d/_virt.conf] at time 12:25:44.192029 duration_in_ms=1.041
2017-11-29 12:25:44,194 [salt.state       ][INFO    ][21710] Running state [salt-minion] at time 12:25:44.193635
2017-11-29 12:25:44,194 [salt.state       ][INFO    ][21710] Executing state service.running for salt-minion
2017-11-29 12:25:44,194 [salt.loaded.int.module.cmdmod][INFO    ][21710] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2017-11-29 12:25:44,209 [salt.loaded.int.module.cmdmod][INFO    ][21710] Executing command ['systemctl', 'is-active', 'salt-minion.service'] in directory '/root'
2017-11-29 12:25:44,216 [salt.loaded.int.module.cmdmod][INFO    ][21710] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2017-11-29 12:25:44,223 [salt.state       ][INFO    ][21710] The service salt-minion is already running
2017-11-29 12:25:44,224 [salt.state       ][INFO    ][21710] Completed state [salt-minion] at time 12:25:44.223676 duration_in_ms=30.041
2017-11-29 12:25:44,225 [salt.state       ][INFO    ][21710] Running state [/etc/salt/grains.d] at time 12:25:44.225166
2017-11-29 12:25:44,225 [salt.state       ][INFO    ][21710] Executing state file.directory for /etc/salt/grains.d
2017-11-29 12:25:44,226 [salt.state       ][INFO    ][21710] Directory /etc/salt/grains.d is in the correct state
2017-11-29 12:25:44,226 [salt.state       ][INFO    ][21710] Completed state [/etc/salt/grains.d] at time 12:25:44.226252 duration_in_ms=1.086
2017-11-29 12:25:44,227 [salt.state       ][INFO    ][21710] Running state [/etc/salt/grains] at time 12:25:44.226826
2017-11-29 12:25:44,227 [salt.state       ][INFO    ][21710] Executing state file.managed for /etc/salt/grains
2017-11-29 12:25:44,227 [salt.state       ][INFO    ][21710] File /etc/salt/grains exists with proper permissions. No changes made.
2017-11-29 12:25:44,228 [salt.state       ][INFO    ][21710] Completed state [/etc/salt/grains] at time 12:25:44.227591 duration_in_ms=0.764
2017-11-29 12:25:44,228 [salt.state       ][INFO    ][21710] Running state [/etc/salt/grains.d/placeholder] at time 12:25:44.227968
2017-11-29 12:25:44,228 [salt.state       ][INFO    ][21710] Executing state file.managed for /etc/salt/grains.d/placeholder
2017-11-29 12:25:44,229 [salt.state       ][INFO    ][21710] File /etc/salt/grains.d/placeholder exists with proper permissions. No changes made.
2017-11-29 12:25:44,229 [salt.state       ][INFO    ][21710] Completed state [/etc/salt/grains.d/placeholder] at time 12:25:44.228709 duration_in_ms=0.741
2017-11-29 12:25:44,229 [salt.state       ][INFO    ][21710] Running state [/etc/salt/grains.d/sphinx] at time 12:25:44.229081
2017-11-29 12:25:44,229 [salt.state       ][INFO    ][21710] Executing state file.managed for /etc/salt/grains.d/sphinx
2017-11-29 12:25:44,231 [salt.state       ][INFO    ][21710] File changed:
--- 
+++ 
@@ -49,7 +49,6 @@
               - 127.0.0.1
               - 192.168.10.143
               - 192.168.11.251
-              - 192.168.122.1
         system:
           name: System
           param:

2017-11-29 12:25:44,231 [salt.state       ][INFO    ][21710] Completed state [/etc/salt/grains.d/sphinx] at time 12:25:44.230931 duration_in_ms=1.849
2017-11-29 12:25:44,232 [salt.state       ][INFO    ][21710] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 12:25:44.231664
2017-11-29 12:25:44,232 [salt.state       ][INFO    ][21710] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-11-29 12:25:44,232 [salt.state       ][INFO    ][21710] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-11-29 12:25:44,232 [salt.state       ][INFO    ][21710] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 12:25:44.232201 duration_in_ms=0.537
2017-11-29 12:25:44,232 [salt.state       ][INFO    ][21710] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 12:25:44.232355
2017-11-29 12:25:44,233 [salt.state       ][INFO    ][21710] Executing state cmd.mod_watch for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-11-29 12:25:44,233 [salt.loaded.int.module.cmdmod][INFO    ][21710] Executing command 'python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"' in directory '/root'
2017-11-29 12:25:44,309 [salt.state       ][INFO    ][21710] {'pid': 21758, 'retcode': 0, 'stderr': '', 'stdout': ''}
2017-11-29 12:25:44,310 [salt.state       ][INFO    ][21710] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 12:25:44.309894 duration_in_ms=77.539
2017-11-29 12:25:44,311 [salt.state       ][INFO    ][21710] Running state [/etc/salt/grains.d/dns_records] at time 12:25:44.310479
2017-11-29 12:25:44,311 [salt.state       ][INFO    ][21710] Executing state file.managed for /etc/salt/grains.d/dns_records
2017-11-29 12:25:44,312 [salt.state       ][INFO    ][21710] File /etc/salt/grains.d/dns_records is in the correct state
2017-11-29 12:25:44,312 [salt.state       ][INFO    ][21710] Completed state [/etc/salt/grains.d/dns_records] at time 12:25:44.312038 duration_in_ms=1.559
2017-11-29 12:25:44,313 [salt.state       ][INFO    ][21710] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 12:25:44.312893
2017-11-29 12:25:44,313 [salt.state       ][INFO    ][21710] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"
2017-11-29 12:25:44,313 [salt.state       ][INFO    ][21710] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"
2017-11-29 12:25:44,314 [salt.state       ][INFO    ][21710] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 12:25:44.313550 duration_in_ms=0.657
2017-11-29 12:25:44,314 [salt.state       ][INFO    ][21710] Running state [/etc/salt/grains.d/salt] at time 12:25:44.313958
2017-11-29 12:25:44,314 [salt.state       ][INFO    ][21710] Executing state file.managed for /etc/salt/grains.d/salt
2017-11-29 12:25:44,315 [salt.state       ][INFO    ][21710] File /etc/salt/grains.d/salt is in the correct state
2017-11-29 12:25:44,315 [salt.state       ][INFO    ][21710] Completed state [/etc/salt/grains.d/salt] at time 12:25:44.315017 duration_in_ms=1.059
2017-11-29 12:25:44,316 [salt.state       ][INFO    ][21710] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 12:25:44.315815
2017-11-29 12:25:44,316 [salt.state       ][INFO    ][21710] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2017-11-29 12:25:44,316 [salt.state       ][INFO    ][21710] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2017-11-29 12:25:44,316 [salt.state       ][INFO    ][21710] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 12:25:44.316394 duration_in_ms=0.58
2017-11-29 12:25:44,318 [salt.state       ][INFO    ][21710] Running state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 12:25:44.318045
2017-11-29 12:25:44,318 [salt.state       ][INFO    ][21710] Executing state cmd.wait for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-11-29 12:25:44,319 [salt.state       ][INFO    ][21710] No changes made for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-11-29 12:25:44,319 [salt.state       ][INFO    ][21710] Completed state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 12:25:44.318664 duration_in_ms=0.62
2017-11-29 12:25:44,319 [salt.state       ][INFO    ][21710] Running state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 12:25:44.318817
2017-11-29 12:25:44,319 [salt.state       ][INFO    ][21710] Executing state cmd.mod_watch for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-11-29 12:25:44,321 [salt.loaded.int.module.cmdmod][INFO    ][21710] Executing command 'cat /etc/salt/grains.d/* > /etc/salt/grains' in directory '/root'
2017-11-29 12:25:44,327 [salt.state       ][INFO    ][21710] {'pid': 21760, 'retcode': 0, 'stderr': '', 'stdout': ''}
2017-11-29 12:25:44,328 [salt.state       ][INFO    ][21710] Completed state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 12:25:44.327578 duration_in_ms=8.76
2017-11-29 12:25:44,328 [salt.state       ][INFO    ][21710] Running state [mine.update] at time 12:25:44.328257
2017-11-29 12:25:44,329 [salt.state       ][INFO    ][21710] Executing state module.wait for mine.update
2017-11-29 12:25:44,329 [salt.state       ][INFO    ][21710] No changes made for mine.update
2017-11-29 12:25:44,329 [salt.state       ][INFO    ][21710] Completed state [mine.update] at time 12:25:44.328862 duration_in_ms=0.605
2017-11-29 12:25:44,329 [salt.state       ][INFO    ][21710] Running state [mine.update] at time 12:25:44.329035
2017-11-29 12:25:44,329 [salt.state       ][INFO    ][21710] Executing state module.mod_watch for mine.update
2017-11-29 12:25:44,846 [salt.state       ][INFO    ][21710] {'ret': True}
2017-11-29 12:25:44,846 [salt.state       ][INFO    ][21710] Completed state [mine.update] at time 12:25:44.846169 duration_in_ms=517.134
2017-11-29 12:25:44,846 [salt.state       ][INFO    ][21710] Running state [ca-certificates] at time 12:25:44.846426
2017-11-29 12:25:44,847 [salt.state       ][INFO    ][21710] Executing state pkg.installed for ca-certificates
2017-11-29 12:25:44,851 [salt.state       ][INFO    ][21710] Package ca-certificates is already installed
2017-11-29 12:25:44,851 [salt.state       ][INFO    ][21710] Completed state [ca-certificates] at time 12:25:44.850703 duration_in_ms=4.276
2017-11-29 12:25:44,851 [salt.state       ][INFO    ][21710] Running state [update-ca-certificates] at time 12:25:44.851364
2017-11-29 12:25:44,852 [salt.state       ][INFO    ][21710] Executing state cmd.wait for update-ca-certificates
2017-11-29 12:25:44,852 [salt.state       ][INFO    ][21710] No changes made for update-ca-certificates
2017-11-29 12:25:44,852 [salt.state       ][INFO    ][21710] Completed state [update-ca-certificates] at time 12:25:44.851933 duration_in_ms=0.57
2017-11-29 12:25:44,852 [salt.state       ][INFO    ][21710] Running state [libvirt-dev] at time 12:25:44.852109
2017-11-29 12:25:44,852 [salt.state       ][INFO    ][21710] Executing state pkg.installed for libvirt-dev
2017-11-29 12:25:44,856 [salt.state       ][INFO    ][21710] Package libvirt-dev is already installed
2017-11-29 12:25:44,856 [salt.state       ][INFO    ][21710] Completed state [libvirt-dev] at time 12:25:44.856108 duration_in_ms=3.999
2017-11-29 12:25:44,856 [salt.state       ][INFO    ][21710] Running state [pkg-config] at time 12:25:44.856286
2017-11-29 12:25:44,856 [salt.state       ][INFO    ][21710] Executing state pkg.installed for pkg-config
2017-11-29 12:25:44,860 [salt.state       ][INFO    ][21710] Package pkg-config is already installed
2017-11-29 12:25:44,860 [salt.state       ][INFO    ][21710] Completed state [pkg-config] at time 12:25:44.860297 duration_in_ms=4.011
2017-11-29 12:25:44,861 [salt.state       ][INFO    ][21710] Running state [virtng.init] at time 12:25:44.860479
2017-11-29 12:25:44,861 [salt.state       ][INFO    ][21710] Executing state module.run for virtng.init
2017-11-29 12:25:44,926 [salt.loaded.int.module.cmdmod][INFO    ][21710] Executing command ['git', '--version'] in directory '/root'
2017-11-29 12:25:44,998 [salt.loaded.int.module.cmdmod][INFO    ][21710] Executing command 'virsh list --all --name| grep -E "^mdb03.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-11-29 12:25:45,014 [salt.state       ][INFO    ][21710] unless execution succeeded
2017-11-29 12:25:45,015 [salt.state       ][INFO    ][21710] Completed state [virtng.init] at time 12:25:45.014486 duration_in_ms=154.007
2017-11-29 12:25:45,015 [salt.state       ][INFO    ][21710] Running state [virt.set_autostart] at time 12:25:45.014761
2017-11-29 12:25:45,015 [salt.state       ][INFO    ][21710] Executing state module.run for virt.set_autostart
2017-11-29 12:25:45,018 [salt.loaded.int.module.cmdmod][INFO    ][21710] Executing command 'virsh list --autostart --name| grep -E "^mdb03.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-11-29 12:25:45,033 [salt.state       ][INFO    ][21710] unless execution succeeded
2017-11-29 12:25:45,033 [salt.state       ][INFO    ][21710] Completed state [virt.set_autostart] at time 12:25:45.033379 duration_in_ms=18.618
2017-11-29 12:25:45,034 [salt.state       ][INFO    ][21710] Running state [virtng.init] at time 12:25:45.033633
2017-11-29 12:25:45,034 [salt.state       ][INFO    ][21710] Executing state module.run for virtng.init
2017-11-29 12:25:45,037 [salt.loaded.int.module.cmdmod][INFO    ][21710] Executing command 'virsh list --all --name| grep -E "^dbs03.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-11-29 12:25:45,051 [salt.state       ][INFO    ][21710] unless execution succeeded
2017-11-29 12:25:45,052 [salt.state       ][INFO    ][21710] Completed state [virtng.init] at time 12:25:45.051482 duration_in_ms=17.848
2017-11-29 12:25:45,052 [salt.state       ][INFO    ][21710] Running state [virt.set_autostart] at time 12:25:45.051757
2017-11-29 12:25:45,052 [salt.state       ][INFO    ][21710] Executing state module.run for virt.set_autostart
2017-11-29 12:25:45,055 [salt.loaded.int.module.cmdmod][INFO    ][21710] Executing command 'virsh list --autostart --name| grep -E "^dbs03.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-11-29 12:25:45,068 [salt.state       ][INFO    ][21710] unless execution succeeded
2017-11-29 12:25:45,068 [salt.state       ][INFO    ][21710] Completed state [virt.set_autostart] at time 12:25:45.068063 duration_in_ms=16.305
2017-11-29 12:25:45,068 [salt.state       ][INFO    ][21710] Running state [virtng.init] at time 12:25:45.068312
2017-11-29 12:25:45,069 [salt.state       ][INFO    ][21710] Executing state module.run for virtng.init
2017-11-29 12:25:45,071 [salt.loaded.int.module.cmdmod][INFO    ][21710] Executing command 'virsh list --all --name| grep -E "^prx02.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-11-29 12:25:45,086 [salt.state       ][INFO    ][21710] unless execution succeeded
2017-11-29 12:25:45,086 [salt.state       ][INFO    ][21710] Completed state [virtng.init] at time 12:25:45.086414 duration_in_ms=18.102
2017-11-29 12:25:45,087 [salt.state       ][INFO    ][21710] Running state [virt.set_autostart] at time 12:25:45.086663
2017-11-29 12:25:45,087 [salt.state       ][INFO    ][21710] Executing state module.run for virt.set_autostart
2017-11-29 12:25:45,089 [salt.loaded.int.module.cmdmod][INFO    ][21710] Executing command 'virsh list --autostart --name| grep -E "^prx02.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-11-29 12:25:45,104 [salt.state       ][INFO    ][21710] unless execution succeeded
2017-11-29 12:25:45,104 [salt.state       ][INFO    ][21710] Completed state [virt.set_autostart] at time 12:25:45.103877 duration_in_ms=17.214
2017-11-29 12:25:45,104 [salt.state       ][INFO    ][21710] Running state [virtng.init] at time 12:25:45.104130
2017-11-29 12:25:45,104 [salt.state       ][INFO    ][21710] Executing state module.run for virtng.init
2017-11-29 12:25:45,107 [salt.loaded.int.module.cmdmod][INFO    ][21710] Executing command 'virsh list --all --name| grep -E "^msg03.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-11-29 12:25:45,121 [salt.state       ][INFO    ][21710] unless execution succeeded
2017-11-29 12:25:45,122 [salt.state       ][INFO    ][21710] Completed state [virtng.init] at time 12:25:45.121536 duration_in_ms=17.406
2017-11-29 12:25:45,122 [salt.state       ][INFO    ][21710] Running state [virt.set_autostart] at time 12:25:45.121793
2017-11-29 12:25:45,122 [salt.state       ][INFO    ][21710] Executing state module.run for virt.set_autostart
2017-11-29 12:25:45,125 [salt.loaded.int.module.cmdmod][INFO    ][21710] Executing command 'virsh list --autostart --name| grep -E "^msg03.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-11-29 12:25:45,140 [salt.state       ][INFO    ][21710] unless execution succeeded
2017-11-29 12:25:45,140 [salt.state       ][INFO    ][21710] Completed state [virt.set_autostart] at time 12:25:45.140210 duration_in_ms=18.417
2017-11-29 12:25:45,140 [salt.state       ][INFO    ][21710] Running state [virtng.init] at time 12:25:45.140455
2017-11-29 12:25:45,141 [salt.state       ][INFO    ][21710] Executing state module.run for virtng.init
2017-11-29 12:25:45,143 [salt.loaded.int.module.cmdmod][INFO    ][21710] Executing command 'virsh list --all --name| grep -E "^ctl03.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-11-29 12:25:45,158 [salt.state       ][INFO    ][21710] unless execution succeeded
2017-11-29 12:25:45,158 [salt.state       ][INFO    ][21710] Completed state [virtng.init] at time 12:25:45.157864 duration_in_ms=17.397
2017-11-29 12:25:45,158 [salt.state       ][INFO    ][21710] Running state [virt.set_autostart] at time 12:25:45.158142
2017-11-29 12:25:45,158 [salt.state       ][INFO    ][21710] Executing state module.run for virt.set_autostart
2017-11-29 12:25:45,161 [salt.loaded.int.module.cmdmod][INFO    ][21710] Executing command 'virsh list --autostart --name| grep -E "^ctl03.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-11-29 12:25:45,176 [salt.state       ][INFO    ][21710] unless execution succeeded
2017-11-29 12:25:45,176 [salt.state       ][INFO    ][21710] Completed state [virt.set_autostart] at time 12:25:45.176292 duration_in_ms=18.15
2017-11-29 12:25:45,179 [salt.minion      ][INFO    ][21710] Returning information for job: 20171129122538764378
2017-11-29 12:26:04,813 [salt.minion      ][INFO    ][21605] User sudo_ubuntu Executing command saltutil.sync_all with jid 20171129122604803714
2017-11-29 12:26:04,829 [salt.minion      ][INFO    ][21816] Starting a new job with PID 21816
2017-11-29 12:26:09,061 [salt.state       ][INFO    ][21816] Loading fresh modules for state activity
2017-11-29 12:26:09,754 [salt.state       ][ERROR   ][21816] No contents found in top file
2017-11-29 12:26:09,754 [salt.utils.extmods][INFO    ][21816] Creating module dir '/var/cache/salt/minion/extmods/beacons'
2017-11-29 12:26:09,758 [salt.utils.extmods][INFO    ][21816] Syncing beacons for environment 'base'
2017-11-29 12:26:09,758 [salt.utils.extmods][INFO    ][21816] Loading cache from salt://_beacons, for base)
2017-11-29 12:26:09,758 [salt.fileclient  ][INFO    ][21816] Caching directory '_beacons/' for environment 'base'
2017-11-29 12:26:09,796 [salt.utils.extmods][INFO    ][21816] Syncing modules for environment 'base'
2017-11-29 12:26:09,797 [salt.utils.extmods][INFO    ][21816] Loading cache from salt://_modules, for base)
2017-11-29 12:26:09,797 [salt.fileclient  ][INFO    ][21816] Caching directory '_modules/' for environment 'base'
2017-11-29 12:26:09,851 [salt.fileclient  ][INFO    ][21816] Fetching file from saltenv 'base', ** done ** '_modules/avinetworks.py'
2017-11-29 12:26:09,868 [salt.fileclient  ][INFO    ][21816] Fetching file from saltenv 'base', ** done ** '_modules/ceph_ng.py'
2017-11-29 12:26:10,366 [salt.fileclient  ][INFO    ][21816] Fetching file from saltenv 'base', ** done ** '_modules/cinderng.py'
2017-11-29 12:26:10,397 [salt.fileclient  ][INFO    ][21816] Fetching file from saltenv 'base', ** done ** '_modules/contrail.py'
2017-11-29 12:26:10,444 [salt.fileclient  ][INFO    ][21816] Fetching file from saltenv 'base', ** done ** '_modules/creds.py'
2017-11-29 12:26:10,462 [salt.fileclient  ][INFO    ][21816] Fetching file from saltenv 'base', ** done ** '_modules/devops_utils.py'
2017-11-29 12:26:10,475 [salt.fileclient  ][INFO    ][21816] Fetching file from saltenv 'base', ** done ** '_modules/encode_json.py'
2017-11-29 12:26:10,488 [salt.fileclient  ][INFO    ][21816] Fetching file from saltenv 'base', ** done ** '_modules/gerrit.py'
2017-11-29 12:26:10,506 [salt.fileclient  ][INFO    ][21816] Fetching file from saltenv 'base', ** done ** '_modules/glanceng.py'
2017-11-29 12:26:10,526 [salt.fileclient  ][INFO    ][21816] Fetching file from saltenv 'base', ** done ** '_modules/heat.py'
2017-11-29 12:26:10,539 [salt.fileclient  ][INFO    ][21816] Fetching file from saltenv 'base', ** done ** '_modules/heka_alarming.py'
2017-11-29 12:26:10,554 [salt.fileclient  ][INFO    ][21816] Fetching file from saltenv 'base', ** done ** '_modules/helm.py'
2017-11-29 12:26:10,566 [salt.fileclient  ][INFO    ][21816] Fetching file from saltenv 'base', ** done ** '_modules/jenkins_common.py'
2017-11-29 12:26:10,595 [salt.fileclient  ][INFO    ][21816] Fetching file from saltenv 'base', ** done ** '_modules/keystone_policy.py'
2017-11-29 12:26:10,624 [salt.fileclient  ][INFO    ][21816] Fetching file from saltenv 'base', ** done ** '_modules/linux_hosts.py'
2017-11-29 12:26:10,633 [salt.fileclient  ][INFO    ][21816] Fetching file from saltenv 'base', ** done ** '_modules/linux_netlink.py'
2017-11-29 12:26:10,645 [salt.fileclient  ][INFO    ][21816] Fetching file from saltenv 'base', ** done ** '_modules/maas.py'
2017-11-29 12:26:10,663 [salt.fileclient  ][INFO    ][21816] Fetching file from saltenv 'base', ** done ** '_modules/maas_client.py'
2017-11-29 12:26:10,692 [salt.fileclient  ][INFO    ][21816] Fetching file from saltenv 'base', ** done ** '_modules/modelutils.py'
2017-11-29 12:26:10,709 [salt.fileclient  ][INFO    ][21816] Fetching file from saltenv 'base', ** done ** '_modules/multipart.py'
2017-11-29 12:26:10,734 [salt.fileclient  ][INFO    ][21816] Fetching file from saltenv 'base', ** done ** '_modules/nagios_alarming.py'
2017-11-29 12:26:10,768 [salt.fileclient  ][INFO    ][21816] Fetching file from saltenv 'base', ** done ** '_modules/neutronng.py'
2017-11-29 12:26:10,783 [salt.fileclient  ][INFO    ][21816] Fetching file from saltenv 'base', ** done ** '_modules/novang.py'
2017-11-29 12:26:10,796 [salt.fileclient  ][INFO    ][21816] Fetching file from saltenv 'base', ** done ** '_modules/reclass.py'
2017-11-29 12:26:10,807 [salt.fileclient  ][INFO    ][21816] Fetching file from saltenv 'base', ** done ** '_modules/rsyslog_util.py'
2017-11-29 12:26:10,831 [salt.fileclient  ][INFO    ][21816] Fetching file from saltenv 'base', ** done ** '_modules/rundeck.py'
2017-11-29 12:26:10,848 [salt.fileclient  ][INFO    ][21816] Fetching file from saltenv 'base', ** done ** '_modules/saltkey.py'
2017-11-29 12:26:10,868 [salt.fileclient  ][INFO    ][21816] Fetching file from saltenv 'base', ** done ** '_modules/saltresource.py'
2017-11-29 12:26:10,878 [salt.fileclient  ][INFO    ][21816] Fetching file from saltenv 'base', ** done ** '_modules/seedng.py'
2017-11-29 12:26:10,896 [salt.fileclient  ][INFO    ][21816] Fetching file from saltenv 'base', ** done ** '_modules/testing/credentials.py'
2017-11-29 12:26:10,928 [salt.fileclient  ][INFO    ][21816] Fetching file from saltenv 'base', ** done ** '_modules/testing/django.py'
2017-11-29 12:26:10,943 [salt.fileclient  ][INFO    ][21816] Fetching file from saltenv 'base', ** done ** '_modules/testing/django_client_proxy.py'
2017-11-29 12:26:10,955 [salt.fileclient  ][INFO    ][21816] Fetching file from saltenv 'base', ** done ** '_modules/utils.py'
2017-11-29 12:26:10,969 [salt.fileclient  ][INFO    ][21816] Fetching file from saltenv 'base', ** done ** '_modules/virtng.py'
2017-11-29 12:26:10,973 [salt.utils.extmods][INFO    ][21816] Copying '/var/cache/salt/minion/files/base/_modules/__init__.py' to '/var/cache/salt/minion/extmods/modules/__init__.py'
2017-11-29 12:26:10,974 [salt.utils.extmods][INFO    ][21816] Copying '/var/cache/salt/minion/files/base/_modules/avinetworks.py' to '/var/cache/salt/minion/extmods/modules/avinetworks.py'
2017-11-29 12:26:10,974 [salt.utils.extmods][INFO    ][21816] Copying '/var/cache/salt/minion/files/base/_modules/ceph_ng.py' to '/var/cache/salt/minion/extmods/modules/ceph_ng.py'
2017-11-29 12:26:10,974 [salt.utils.extmods][INFO    ][21816] Copying '/var/cache/salt/minion/files/base/_modules/cinderng.py' to '/var/cache/salt/minion/extmods/modules/cinderng.py'
2017-11-29 12:26:10,974 [salt.utils.extmods][INFO    ][21816] Copying '/var/cache/salt/minion/files/base/_modules/contrail.py' to '/var/cache/salt/minion/extmods/modules/contrail.py'
2017-11-29 12:26:10,975 [salt.utils.extmods][INFO    ][21816] Copying '/var/cache/salt/minion/files/base/_modules/creds.py' to '/var/cache/salt/minion/extmods/modules/creds.py'
2017-11-29 12:26:10,975 [salt.utils.extmods][INFO    ][21816] Copying '/var/cache/salt/minion/files/base/_modules/devops_utils.py' to '/var/cache/salt/minion/extmods/modules/devops_utils.py'
2017-11-29 12:26:10,975 [salt.utils.extmods][INFO    ][21816] Copying '/var/cache/salt/minion/files/base/_modules/encode_json.py' to '/var/cache/salt/minion/extmods/modules/encode_json.py'
2017-11-29 12:26:10,976 [salt.utils.extmods][INFO    ][21816] Copying '/var/cache/salt/minion/files/base/_modules/gerrit.py' to '/var/cache/salt/minion/extmods/modules/gerrit.py'
2017-11-29 12:26:10,976 [salt.utils.extmods][INFO    ][21816] Copying '/var/cache/salt/minion/files/base/_modules/glanceng.py' to '/var/cache/salt/minion/extmods/modules/glanceng.py'
2017-11-29 12:26:10,976 [salt.utils.extmods][INFO    ][21816] Copying '/var/cache/salt/minion/files/base/_modules/heat.py' to '/var/cache/salt/minion/extmods/modules/heat.py'
2017-11-29 12:26:10,976 [salt.utils.extmods][INFO    ][21816] Copying '/var/cache/salt/minion/files/base/_modules/heka_alarming.py' to '/var/cache/salt/minion/extmods/modules/heka_alarming.py'
2017-11-29 12:26:10,977 [salt.utils.extmods][INFO    ][21816] Copying '/var/cache/salt/minion/files/base/_modules/helm.py' to '/var/cache/salt/minion/extmods/modules/helm.py'
2017-11-29 12:26:10,977 [salt.utils.extmods][INFO    ][21816] Copying '/var/cache/salt/minion/files/base/_modules/jenkins_common.py' to '/var/cache/salt/minion/extmods/modules/jenkins_common.py'
2017-11-29 12:26:10,977 [salt.utils.extmods][INFO    ][21816] Copying '/var/cache/salt/minion/files/base/_modules/keystone_policy.py' to '/var/cache/salt/minion/extmods/modules/keystone_policy.py'
2017-11-29 12:26:10,978 [salt.utils.extmods][INFO    ][21816] Copying '/var/cache/salt/minion/files/base/_modules/linux_hosts.py' to '/var/cache/salt/minion/extmods/modules/linux_hosts.py'
2017-11-29 12:26:10,978 [salt.utils.extmods][INFO    ][21816] Copying '/var/cache/salt/minion/files/base/_modules/linux_netlink.py' to '/var/cache/salt/minion/extmods/modules/linux_netlink.py'
2017-11-29 12:26:10,978 [salt.utils.extmods][INFO    ][21816] Copying '/var/cache/salt/minion/files/base/_modules/maas.py' to '/var/cache/salt/minion/extmods/modules/maas.py'
2017-11-29 12:26:10,978 [salt.utils.extmods][INFO    ][21816] Copying '/var/cache/salt/minion/files/base/_modules/maas_client.py' to '/var/cache/salt/minion/extmods/modules/maas_client.py'
2017-11-29 12:26:10,979 [salt.utils.extmods][INFO    ][21816] Copying '/var/cache/salt/minion/files/base/_modules/modelutils.py' to '/var/cache/salt/minion/extmods/modules/modelutils.py'
2017-11-29 12:26:10,979 [salt.utils.extmods][INFO    ][21816] Copying '/var/cache/salt/minion/files/base/_modules/multipart.py' to '/var/cache/salt/minion/extmods/modules/multipart.py'
2017-11-29 12:26:10,979 [salt.utils.extmods][INFO    ][21816] Copying '/var/cache/salt/minion/files/base/_modules/nagios_alarming.py' to '/var/cache/salt/minion/extmods/modules/nagios_alarming.py'
2017-11-29 12:26:10,979 [salt.utils.extmods][INFO    ][21816] Copying '/var/cache/salt/minion/files/base/_modules/neutronng.py' to '/var/cache/salt/minion/extmods/modules/neutronng.py'
2017-11-29 12:26:10,980 [salt.utils.extmods][INFO    ][21816] Copying '/var/cache/salt/minion/files/base/_modules/novang.py' to '/var/cache/salt/minion/extmods/modules/novang.py'
2017-11-29 12:26:10,980 [salt.utils.extmods][INFO    ][21816] Copying '/var/cache/salt/minion/files/base/_modules/reclass.py' to '/var/cache/salt/minion/extmods/modules/reclass.py'
2017-11-29 12:26:10,981 [salt.utils.extmods][INFO    ][21816] Copying '/var/cache/salt/minion/files/base/_modules/rsyslog_util.py' to '/var/cache/salt/minion/extmods/modules/rsyslog_util.py'
2017-11-29 12:26:10,981 [salt.utils.extmods][INFO    ][21816] Copying '/var/cache/salt/minion/files/base/_modules/rundeck.py' to '/var/cache/salt/minion/extmods/modules/rundeck.py'
2017-11-29 12:26:10,981 [salt.utils.extmods][INFO    ][21816] Copying '/var/cache/salt/minion/files/base/_modules/saltkey.py' to '/var/cache/salt/minion/extmods/modules/saltkey.py'
2017-11-29 12:26:10,981 [salt.utils.extmods][INFO    ][21816] Copying '/var/cache/salt/minion/files/base/_modules/saltresource.py' to '/var/cache/salt/minion/extmods/modules/saltresource.py'
2017-11-29 12:26:10,982 [salt.utils.extmods][INFO    ][21816] Copying '/var/cache/salt/minion/files/base/_modules/seedng.py' to '/var/cache/salt/minion/extmods/modules/seedng.py'
2017-11-29 12:26:10,982 [salt.utils.extmods][INFO    ][21816] Copying '/var/cache/salt/minion/files/base/_modules/testing/__init__.py' to '/var/cache/salt/minion/extmods/modules/testing/__init__.py'
2017-11-29 12:26:10,982 [salt.utils.extmods][INFO    ][21816] Copying '/var/cache/salt/minion/files/base/_modules/testing/credentials.py' to '/var/cache/salt/minion/extmods/modules/testing/credentials.py'
2017-11-29 12:26:10,982 [salt.utils.extmods][INFO    ][21816] Copying '/var/cache/salt/minion/files/base/_modules/testing/django.py' to '/var/cache/salt/minion/extmods/modules/testing/django.py'
2017-11-29 12:26:10,983 [salt.utils.extmods][INFO    ][21816] Copying '/var/cache/salt/minion/files/base/_modules/testing/django_client_proxy.py' to '/var/cache/salt/minion/extmods/modules/testing/django_client_proxy.py'
2017-11-29 12:26:10,983 [salt.utils.extmods][INFO    ][21816] Copying '/var/cache/salt/minion/files/base/_modules/utils.py' to '/var/cache/salt/minion/extmods/modules/utils.py'
2017-11-29 12:26:10,983 [salt.utils.extmods][INFO    ][21816] Copying '/var/cache/salt/minion/files/base/_modules/virtng.py' to '/var/cache/salt/minion/extmods/modules/virtng.py'
2017-11-29 12:26:10,989 [salt.utils.extmods][INFO    ][21816] Syncing states for environment 'base'
2017-11-29 12:26:10,989 [salt.utils.extmods][INFO    ][21816] Loading cache from salt://_states, for base)
2017-11-29 12:26:10,990 [salt.fileclient  ][INFO    ][21816] Caching directory '_states/' for environment 'base'
2017-11-29 12:26:11,093 [salt.fileclient  ][INFO    ][21816] Fetching file from saltenv 'base', ** done ** '_states/avinetworks.py'
2017-11-29 12:26:11,108 [salt.fileclient  ][INFO    ][21816] Fetching file from saltenv 'base', ** done ** '_states/cinderng.py'
2017-11-29 12:26:11,129 [salt.fileclient  ][INFO    ][21816] Fetching file from saltenv 'base', ** done ** '_states/contrail.py'
2017-11-29 12:26:11,150 [salt.fileclient  ][INFO    ][21816] Fetching file from saltenv 'base', ** done ** '_states/gerrit.py'
2017-11-29 12:26:11,172 [salt.fileclient  ][INFO    ][21816] Fetching file from saltenv 'base', ** done ** '_states/glanceng.py'
2017-11-29 12:26:11,196 [salt.fileclient  ][INFO    ][21816] Fetching file from saltenv 'base', ** done ** '_states/grafana3_dashboard.py'
2017-11-29 12:26:11,215 [salt.fileclient  ][INFO    ][21816] Fetching file from saltenv 'base', ** done ** '_states/grafana3_datasource.py'
2017-11-29 12:26:11,227 [salt.fileclient  ][INFO    ][21816] Fetching file from saltenv 'base', ** done ** '_states/heat.py'
2017-11-29 12:26:11,239 [salt.fileclient  ][INFO    ][21816] Fetching file from saltenv 'base', ** done ** '_states/helm_release.py'
2017-11-29 12:26:11,255 [salt.fileclient  ][INFO    ][21816] Fetching file from saltenv 'base', ** done ** '_states/helm_repos.py'
2017-11-29 12:26:11,266 [salt.fileclient  ][INFO    ][21816] Fetching file from saltenv 'base', ** done ** '_states/jenkins_approval.py'
2017-11-29 12:26:11,280 [salt.fileclient  ][INFO    ][21816] Fetching file from saltenv 'base', ** done ** '_states/jenkins_artifactory.py'
2017-11-29 12:26:11,290 [salt.fileclient  ][INFO    ][21816] Fetching file from saltenv 'base', ** done ** '_states/jenkins_credential.py'
2017-11-29 12:26:11,303 [salt.fileclient  ][INFO    ][21816] Fetching file from saltenv 'base', ** done ** '_states/jenkins_globalenvprop.py'
2017-11-29 12:26:11,319 [salt.fileclient  ][INFO    ][21816] Fetching file from saltenv 'base', ** done ** '_states/jenkins_job.py'
2017-11-29 12:26:11,342 [salt.fileclient  ][INFO    ][21816] Fetching file from saltenv 'base', ** done ** '_states/jenkins_lib.py'
2017-11-29 12:26:11,411 [salt.fileclient  ][INFO    ][21816] Fetching file from saltenv 'base', ** done ** '_states/jenkins_node.py'
2017-11-29 12:26:11,430 [salt.fileclient  ][INFO    ][21816] Fetching file from saltenv 'base', ** done ** '_states/jenkins_plugin.py'
2017-11-29 12:26:11,440 [salt.fileclient  ][INFO    ][21816] Fetching file from saltenv 'base', ** done ** '_states/jenkins_security.py'
2017-11-29 12:26:11,450 [salt.fileclient  ][INFO    ][21816] Fetching file from saltenv 'base', ** done ** '_states/jenkins_slack.py'
2017-11-29 12:26:11,460 [salt.fileclient  ][INFO    ][21816] Fetching file from saltenv 'base', ** done ** '_states/jenkins_smtp.py'
2017-11-29 12:26:11,476 [salt.fileclient  ][INFO    ][21816] Fetching file from saltenv 'base', ** done ** '_states/jenkins_theme.py'
2017-11-29 12:26:11,484 [salt.fileclient  ][INFO    ][21816] Fetching file from saltenv 'base', ** done ** '_states/jenkins_user.py'
2017-11-29 12:26:11,499 [salt.fileclient  ][INFO    ][21816] Fetching file from saltenv 'base', ** done ** '_states/jenkins_view.py'
2017-11-29 12:26:11,511 [salt.fileclient  ][INFO    ][21816] Fetching file from saltenv 'base', ** done ** '_states/keystone_policy.py'
2017-11-29 12:26:11,529 [salt.fileclient  ][INFO    ][21816] Fetching file from saltenv 'base', ** done ** '_states/kibana_object.py'
2017-11-29 12:26:11,566 [salt.fileclient  ][INFO    ][21816] Fetching file from saltenv 'base', ** done ** '_states/neutronng.py'
2017-11-29 12:26:11,583 [salt.fileclient  ][INFO    ][21816] Fetching file from saltenv 'base', ** done ** '_states/novang.py'
2017-11-29 12:26:11,614 [salt.fileclient  ][INFO    ][21816] Fetching file from saltenv 'base', ** done ** '_states/reclass.py'
2017-11-29 12:26:11,629 [salt.fileclient  ][INFO    ][21816] Fetching file from saltenv 'base', ** done ** '_states/rundeck_project.py'
2017-11-29 12:26:11,655 [salt.fileclient  ][INFO    ][21816] Fetching file from saltenv 'base', ** done ** '_states/rundeck_scm.py'
2017-11-29 12:26:11,668 [salt.fileclient  ][INFO    ][21816] Fetching file from saltenv 'base', ** done ** '_states/rundeck_secret.py'
2017-11-29 12:26:11,673 [salt.utils.extmods][INFO    ][21816] Copying '/var/cache/salt/minion/files/base/_states/avinetworks.py' to '/var/cache/salt/minion/extmods/states/avinetworks.py'
2017-11-29 12:26:11,673 [salt.utils.extmods][INFO    ][21816] Copying '/var/cache/salt/minion/files/base/_states/cinderng.py' to '/var/cache/salt/minion/extmods/states/cinderng.py'
2017-11-29 12:26:11,674 [salt.utils.extmods][INFO    ][21816] Copying '/var/cache/salt/minion/files/base/_states/contrail.py' to '/var/cache/salt/minion/extmods/states/contrail.py'
2017-11-29 12:26:11,674 [salt.utils.extmods][INFO    ][21816] Copying '/var/cache/salt/minion/files/base/_states/gerrit.py' to '/var/cache/salt/minion/extmods/states/gerrit.py'
2017-11-29 12:26:11,674 [salt.utils.extmods][INFO    ][21816] Copying '/var/cache/salt/minion/files/base/_states/glanceng.py' to '/var/cache/salt/minion/extmods/states/glanceng.py'
2017-11-29 12:26:11,674 [salt.utils.extmods][INFO    ][21816] Copying '/var/cache/salt/minion/files/base/_states/grafana3_dashboard.py' to '/var/cache/salt/minion/extmods/states/grafana3_dashboard.py'
2017-11-29 12:26:11,675 [salt.utils.extmods][INFO    ][21816] Copying '/var/cache/salt/minion/files/base/_states/grafana3_datasource.py' to '/var/cache/salt/minion/extmods/states/grafana3_datasource.py'
2017-11-29 12:26:11,675 [salt.utils.extmods][INFO    ][21816] Copying '/var/cache/salt/minion/files/base/_states/heat.py' to '/var/cache/salt/minion/extmods/states/heat.py'
2017-11-29 12:26:11,675 [salt.utils.extmods][INFO    ][21816] Copying '/var/cache/salt/minion/files/base/_states/helm_release.py' to '/var/cache/salt/minion/extmods/states/helm_release.py'
2017-11-29 12:26:11,676 [salt.utils.extmods][INFO    ][21816] Copying '/var/cache/salt/minion/files/base/_states/helm_repos.py' to '/var/cache/salt/minion/extmods/states/helm_repos.py'
2017-11-29 12:26:11,676 [salt.utils.extmods][INFO    ][21816] Copying '/var/cache/salt/minion/files/base/_states/jenkins_approval.py' to '/var/cache/salt/minion/extmods/states/jenkins_approval.py'
2017-11-29 12:26:11,676 [salt.utils.extmods][INFO    ][21816] Copying '/var/cache/salt/minion/files/base/_states/jenkins_artifactory.py' to '/var/cache/salt/minion/extmods/states/jenkins_artifactory.py'
2017-11-29 12:26:11,676 [salt.utils.extmods][INFO    ][21816] Copying '/var/cache/salt/minion/files/base/_states/jenkins_credential.py' to '/var/cache/salt/minion/extmods/states/jenkins_credential.py'
2017-11-29 12:26:11,677 [salt.utils.extmods][INFO    ][21816] Copying '/var/cache/salt/minion/files/base/_states/jenkins_globalenvprop.py' to '/var/cache/salt/minion/extmods/states/jenkins_globalenvprop.py'
2017-11-29 12:26:11,677 [salt.utils.extmods][INFO    ][21816] Copying '/var/cache/salt/minion/files/base/_states/jenkins_job.py' to '/var/cache/salt/minion/extmods/states/jenkins_job.py'
2017-11-29 12:26:11,677 [salt.utils.extmods][INFO    ][21816] Copying '/var/cache/salt/minion/files/base/_states/jenkins_lib.py' to '/var/cache/salt/minion/extmods/states/jenkins_lib.py'
2017-11-29 12:26:11,677 [salt.utils.extmods][INFO    ][21816] Copying '/var/cache/salt/minion/files/base/_states/jenkins_node.py' to '/var/cache/salt/minion/extmods/states/jenkins_node.py'
2017-11-29 12:26:11,678 [salt.utils.extmods][INFO    ][21816] Copying '/var/cache/salt/minion/files/base/_states/jenkins_plugin.py' to '/var/cache/salt/minion/extmods/states/jenkins_plugin.py'
2017-11-29 12:26:11,678 [salt.utils.extmods][INFO    ][21816] Copying '/var/cache/salt/minion/files/base/_states/jenkins_security.py' to '/var/cache/salt/minion/extmods/states/jenkins_security.py'
2017-11-29 12:26:11,678 [salt.utils.extmods][INFO    ][21816] Copying '/var/cache/salt/minion/files/base/_states/jenkins_slack.py' to '/var/cache/salt/minion/extmods/states/jenkins_slack.py'
2017-11-29 12:26:11,678 [salt.utils.extmods][INFO    ][21816] Copying '/var/cache/salt/minion/files/base/_states/jenkins_smtp.py' to '/var/cache/salt/minion/extmods/states/jenkins_smtp.py'
2017-11-29 12:26:11,679 [salt.utils.extmods][INFO    ][21816] Copying '/var/cache/salt/minion/files/base/_states/jenkins_theme.py' to '/var/cache/salt/minion/extmods/states/jenkins_theme.py'
2017-11-29 12:26:11,679 [salt.utils.extmods][INFO    ][21816] Copying '/var/cache/salt/minion/files/base/_states/jenkins_user.py' to '/var/cache/salt/minion/extmods/states/jenkins_user.py'
2017-11-29 12:26:11,679 [salt.utils.extmods][INFO    ][21816] Copying '/var/cache/salt/minion/files/base/_states/jenkins_view.py' to '/var/cache/salt/minion/extmods/states/jenkins_view.py'
2017-11-29 12:26:11,679 [salt.utils.extmods][INFO    ][21816] Copying '/var/cache/salt/minion/files/base/_states/keystone_policy.py' to '/var/cache/salt/minion/extmods/states/keystone_policy.py'
2017-11-29 12:26:11,680 [salt.utils.extmods][INFO    ][21816] Copying '/var/cache/salt/minion/files/base/_states/kibana_object.py' to '/var/cache/salt/minion/extmods/states/kibana_object.py'
2017-11-29 12:26:11,680 [salt.utils.extmods][INFO    ][21816] Copying '/var/cache/salt/minion/files/base/_states/maas_cluster.py' to '/var/cache/salt/minion/extmods/states/maas_cluster.py'
2017-11-29 12:26:11,680 [salt.utils.extmods][INFO    ][21816] Copying '/var/cache/salt/minion/files/base/_states/neutronng.py' to '/var/cache/salt/minion/extmods/states/neutronng.py'
2017-11-29 12:26:11,681 [salt.utils.extmods][INFO    ][21816] Copying '/var/cache/salt/minion/files/base/_states/novang.py' to '/var/cache/salt/minion/extmods/states/novang.py'
2017-11-29 12:26:11,681 [salt.utils.extmods][INFO    ][21816] Copying '/var/cache/salt/minion/files/base/_states/reclass.py' to '/var/cache/salt/minion/extmods/states/reclass.py'
2017-11-29 12:26:11,681 [salt.utils.extmods][INFO    ][21816] Copying '/var/cache/salt/minion/files/base/_states/rundeck_project.py' to '/var/cache/salt/minion/extmods/states/rundeck_project.py'
2017-11-29 12:26:11,681 [salt.utils.extmods][INFO    ][21816] Copying '/var/cache/salt/minion/files/base/_states/rundeck_scm.py' to '/var/cache/salt/minion/extmods/states/rundeck_scm.py'
2017-11-29 12:26:11,682 [salt.utils.extmods][INFO    ][21816] Copying '/var/cache/salt/minion/files/base/_states/rundeck_secret.py' to '/var/cache/salt/minion/extmods/states/rundeck_secret.py'
2017-11-29 12:26:11,685 [salt.utils.extmods][INFO    ][21816] Creating module dir '/var/cache/salt/minion/extmods/sdb'
2017-11-29 12:26:11,688 [salt.utils.extmods][INFO    ][21816] Syncing sdb for environment 'base'
2017-11-29 12:26:11,688 [salt.utils.extmods][INFO    ][21816] Loading cache from salt://_sdb, for base)
2017-11-29 12:26:11,688 [salt.fileclient  ][INFO    ][21816] Caching directory '_sdb/' for environment 'base'
2017-11-29 12:26:11,745 [salt.utils.extmods][INFO    ][21816] Syncing grains for environment 'base'
2017-11-29 12:26:11,745 [salt.utils.extmods][INFO    ][21816] Loading cache from salt://_grains, for base)
2017-11-29 12:26:11,745 [salt.fileclient  ][INFO    ][21816] Caching directory '_grains/' for environment 'base'
2017-11-29 12:26:11,859 [salt.fileclient  ][INFO    ][21816] Fetching file from saltenv 'base', ** done ** '_grains/ceilometer_policy.py'
2017-11-29 12:26:11,904 [salt.fileclient  ][INFO    ][21816] Fetching file from saltenv 'base', ** done ** '_grains/ceph.py'
2017-11-29 12:26:11,913 [salt.fileclient  ][INFO    ][21816] Fetching file from saltenv 'base', ** done ** '_grains/cinder_policy.py'
2017-11-29 12:26:11,928 [salt.fileclient  ][INFO    ][21816] Fetching file from saltenv 'base', ** done ** '_grains/docker_swarm.py'
2017-11-29 12:26:11,962 [salt.fileclient  ][INFO    ][21816] Fetching file from saltenv 'base', ** done ** '_grains/glance_policy.py'
2017-11-29 12:26:11,979 [salt.fileclient  ][INFO    ][21816] Fetching file from saltenv 'base', ** done ** '_grains/heat_policy.py'
2017-11-29 12:26:11,996 [salt.fileclient  ][INFO    ][21816] Fetching file from saltenv 'base', ** done ** '_grains/jenkins_plugins.py'
2017-11-29 12:26:12,006 [salt.fileclient  ][INFO    ][21816] Fetching file from saltenv 'base', ** done ** '_grains/keystone_policy.py'
2017-11-29 12:26:12,051 [salt.fileclient  ][INFO    ][21816] Fetching file from saltenv 'base', ** done ** '_grains/kubernetes.py'
2017-11-29 12:26:12,078 [salt.fileclient  ][INFO    ][21816] Fetching file from saltenv 'base', ** done ** '_grains/neutron_policy.py'
2017-11-29 12:26:12,114 [salt.fileclient  ][INFO    ][21816] Fetching file from saltenv 'base', ** done ** '_grains/nova_policy.py'
2017-11-29 12:26:12,128 [salt.fileclient  ][INFO    ][21816] Fetching file from saltenv 'base', ** done ** '_grains/ssh_fingerprints.py'
2017-11-29 12:26:12,133 [salt.utils.extmods][INFO    ][21816] Copying '/var/cache/salt/minion/files/base/_grains/ceilometer_policy.py' to '/var/cache/salt/minion/extmods/grains/ceilometer_policy.py'
2017-11-29 12:26:12,133 [salt.utils.extmods][INFO    ][21816] Copying '/var/cache/salt/minion/files/base/_grains/ceph.py' to '/var/cache/salt/minion/extmods/grains/ceph.py'
2017-11-29 12:26:12,133 [salt.utils.extmods][INFO    ][21816] Copying '/var/cache/salt/minion/files/base/_grains/cinder_policy.py' to '/var/cache/salt/minion/extmods/grains/cinder_policy.py'
2017-11-29 12:26:12,134 [salt.utils.extmods][INFO    ][21816] Copying '/var/cache/salt/minion/files/base/_grains/docker_swarm.py' to '/var/cache/salt/minion/extmods/grains/docker_swarm.py'
2017-11-29 12:26:12,134 [salt.utils.extmods][INFO    ][21816] Copying '/var/cache/salt/minion/files/base/_grains/glance_policy.py' to '/var/cache/salt/minion/extmods/grains/glance_policy.py'
2017-11-29 12:26:12,134 [salt.utils.extmods][INFO    ][21816] Copying '/var/cache/salt/minion/files/base/_grains/heat_policy.py' to '/var/cache/salt/minion/extmods/grains/heat_policy.py'
2017-11-29 12:26:12,134 [salt.utils.extmods][INFO    ][21816] Copying '/var/cache/salt/minion/files/base/_grains/jenkins_plugins.py' to '/var/cache/salt/minion/extmods/grains/jenkins_plugins.py'
2017-11-29 12:26:12,134 [salt.utils.extmods][INFO    ][21816] Copying '/var/cache/salt/minion/files/base/_grains/keystone_policy.py' to '/var/cache/salt/minion/extmods/grains/keystone_policy.py'
2017-11-29 12:26:12,135 [salt.utils.extmods][INFO    ][21816] Copying '/var/cache/salt/minion/files/base/_grains/kubernetes.py' to '/var/cache/salt/minion/extmods/grains/kubernetes.py'
2017-11-29 12:26:12,135 [salt.utils.extmods][INFO    ][21816] Copying '/var/cache/salt/minion/files/base/_grains/neutron_policy.py' to '/var/cache/salt/minion/extmods/grains/neutron_policy.py'
2017-11-29 12:26:12,135 [salt.utils.extmods][INFO    ][21816] Copying '/var/cache/salt/minion/files/base/_grains/nova_policy.py' to '/var/cache/salt/minion/extmods/grains/nova_policy.py'
2017-11-29 12:26:12,135 [salt.utils.extmods][INFO    ][21816] Copying '/var/cache/salt/minion/files/base/_grains/ssh_fingerprints.py' to '/var/cache/salt/minion/extmods/grains/ssh_fingerprints.py'
2017-11-29 12:26:12,137 [salt.utils.extmods][INFO    ][21816] Creating module dir '/var/cache/salt/minion/extmods/renderers'
2017-11-29 12:26:12,140 [salt.utils.extmods][INFO    ][21816] Syncing renderers for environment 'base'
2017-11-29 12:26:12,140 [salt.utils.extmods][INFO    ][21816] Loading cache from salt://_renderers, for base)
2017-11-29 12:26:12,140 [salt.fileclient  ][INFO    ][21816] Caching directory '_renderers/' for environment 'base'
2017-11-29 12:26:12,222 [salt.utils.extmods][INFO    ][21816] Creating module dir '/var/cache/salt/minion/extmods/returners'
2017-11-29 12:26:12,225 [salt.utils.extmods][INFO    ][21816] Syncing returners for environment 'base'
2017-11-29 12:26:12,225 [salt.utils.extmods][INFO    ][21816] Loading cache from salt://_returners, for base)
2017-11-29 12:26:12,225 [salt.fileclient  ][INFO    ][21816] Caching directory '_returners/' for environment 'base'
2017-11-29 12:26:12,274 [salt.utils.extmods][INFO    ][21816] Creating module dir '/var/cache/salt/minion/extmods/output'
2017-11-29 12:26:12,277 [salt.utils.extmods][INFO    ][21816] Syncing output for environment 'base'
2017-11-29 12:26:12,277 [salt.utils.extmods][INFO    ][21816] Loading cache from salt://_output, for base)
2017-11-29 12:26:12,277 [salt.fileclient  ][INFO    ][21816] Caching directory '_output/' for environment 'base'
2017-11-29 12:26:12,396 [salt.utils.extmods][INFO    ][21816] Creating module dir '/var/cache/salt/minion/extmods/utils'
2017-11-29 12:26:12,402 [salt.utils.extmods][INFO    ][21816] Syncing utils for environment 'base'
2017-11-29 12:26:12,403 [salt.utils.extmods][INFO    ][21816] Loading cache from salt://_utils, for base)
2017-11-29 12:26:12,403 [salt.fileclient  ][INFO    ][21816] Caching directory '_utils/' for environment 'base'
2017-11-29 12:26:12,482 [salt.utils.extmods][INFO    ][21816] Creating module dir '/var/cache/salt/minion/extmods/log_handlers'
2017-11-29 12:26:12,488 [salt.utils.extmods][INFO    ][21816] Syncing log_handlers for environment 'base'
2017-11-29 12:26:12,488 [salt.utils.extmods][INFO    ][21816] Loading cache from salt://_log_handlers, for base)
2017-11-29 12:26:12,489 [salt.fileclient  ][INFO    ][21816] Caching directory '_log_handlers/' for environment 'base'
2017-11-29 12:26:12,604 [salt.utils.extmods][INFO    ][21816] Creating module dir '/var/cache/salt/minion/extmods/proxy'
2017-11-29 12:26:12,607 [salt.utils.extmods][INFO    ][21816] Syncing proxy for environment 'base'
2017-11-29 12:26:12,608 [salt.utils.extmods][INFO    ][21816] Loading cache from salt://_proxy, for base)
2017-11-29 12:26:12,608 [salt.fileclient  ][INFO    ][21816] Caching directory '_proxy/' for environment 'base'
2017-11-29 12:26:12,666 [salt.utils.extmods][INFO    ][21816] Creating module dir '/var/cache/salt/minion/extmods/engines'
2017-11-29 12:26:12,669 [salt.utils.extmods][INFO    ][21816] Syncing engines for environment 'base'
2017-11-29 12:26:12,669 [salt.utils.extmods][INFO    ][21816] Loading cache from salt://_engines, for base)
2017-11-29 12:26:12,669 [salt.fileclient  ][INFO    ][21816] Caching directory '_engines/' for environment 'base'
2017-11-29 12:26:12,716 [salt.minion      ][INFO    ][21816] Returning information for job: 20171129122604803714
2017-11-29 12:32:20,973 [salt.minion      ][INFO    ][21605] User sudo_ubuntu Executing command test.ping with jid 20171129123220963054
2017-11-29 12:32:20,986 [salt.minion      ][INFO    ][21992] Starting a new job with PID 21992
2017-11-29 12:32:21,023 [salt.minion      ][INFO    ][21992] Returning information for job: 20171129123220963054
2017-11-29 12:33:51,027 [salt.minion      ][INFO    ][21605] User sudo_ubuntu Executing command state.sls with jid 20171129123351009558
2017-11-29 12:33:51,037 [salt.minion      ][INFO    ][22022] Starting a new job with PID 22022
2017-11-29 12:33:51,626 [salt.state       ][INFO    ][22022] Loading fresh modules for state activity
2017-11-29 12:33:51,690 [salt.fileclient  ][INFO    ][22022] Fetching file from saltenv 'base', ** done ** 'keepalived/init.sls'
2017-11-29 12:33:51,712 [salt.fileclient  ][INFO    ][22022] Fetching file from saltenv 'base', ** done ** 'keepalived/cluster.sls'
2017-11-29 12:33:51,741 [salt.fileclient  ][INFO    ][22022] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-11-29 12:33:52,069 [salt.state       ][INFO    ][22022] Running state [lsof] at time 12:33:52.069045
2017-11-29 12:33:52,069 [salt.state       ][INFO    ][22022] Executing state pkg.installed for lsof
2017-11-29 12:33:52,070 [salt.loaded.int.module.cmdmod][INFO    ][22022] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-29 12:33:52,329 [salt.state       ][INFO    ][22022] Package lsof is already installed
2017-11-29 12:33:52,329 [salt.state       ][INFO    ][22022] Completed state [lsof] at time 12:33:52.329370 duration_in_ms=260.326
2017-11-29 12:33:52,330 [salt.state       ][INFO    ][22022] Running state [keepalived] at time 12:33:52.329643
2017-11-29 12:33:52,330 [salt.state       ][INFO    ][22022] Executing state pkg.installed for keepalived
2017-11-29 12:33:52,347 [salt.loaded.int.module.cmdmod][INFO    ][22022] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-11-29 12:33:53,637 [salt.loaded.int.module.cmdmod][INFO    ][22022] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'keepalived'] in directory '/root'
2017-11-29 12:33:56,250 [salt.loaded.int.module.cmdmod][INFO    ][22022] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-29 12:33:56,277 [salt.state       ][INFO    ][22022] Made the following changes:
'libsnmp30' changed from 'absent' to '5.7.3+dfsg-1ubuntu4'
'libsnmp-base' changed from 'absent' to '5.7.3+dfsg-1ubuntu4'
'keepalived' changed from 'absent' to '1:1.2.19-1ubuntu0.2'
'ipvsadm' changed from 'absent' to '1:1.28-3'
'libsensors4' changed from 'absent' to '1:3.4.0-2'

2017-11-29 12:33:56,288 [salt.state       ][INFO    ][22022] Loading fresh modules for state activity
2017-11-29 12:33:56,305 [salt.state       ][INFO    ][22022] Completed state [keepalived] at time 12:33:56.305422 duration_in_ms=3975.778
2017-11-29 12:33:56,308 [salt.state       ][INFO    ][22022] Running state [/etc/keepalived/keepalived.conf] at time 12:33:56.307988
2017-11-29 12:33:56,308 [salt.state       ][INFO    ][22022] Executing state file.managed for /etc/keepalived/keepalived.conf
2017-11-29 12:33:56,337 [salt.fileclient  ][INFO    ][22022] Fetching file from saltenv 'base', ** done ** 'keepalived/files/keepalived.conf'
2017-11-29 12:33:56,377 [salt.fileclient  ][INFO    ][22022] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-11-29 12:33:56,385 [salt.state       ][INFO    ][22022] File changed:
New file
2017-11-29 12:33:56,385 [salt.state       ][INFO    ][22022] Completed state [/etc/keepalived/keepalived.conf] at time 12:33:56.385180 duration_in_ms=77.192
2017-11-29 12:33:56,456 [salt.state       ][INFO    ][22022] Running state [keepalived] at time 12:33:56.456380
2017-11-29 12:33:56,457 [salt.state       ][INFO    ][22022] Executing state service.running for keepalived
2017-11-29 12:33:56,458 [salt.loaded.int.module.cmdmod][INFO    ][22022] Executing command ['systemctl', 'status', 'keepalived.service', '-n', '0'] in directory '/root'
2017-11-29 12:33:56,466 [salt.loaded.int.module.cmdmod][INFO    ][22022] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2017-11-29 12:33:56,474 [salt.loaded.int.module.cmdmod][INFO    ][22022] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-11-29 12:33:56,482 [salt.loaded.int.module.cmdmod][INFO    ][22022] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-11-29 12:33:56,490 [salt.loaded.int.module.cmdmod][INFO    ][22022] Executing command ['systemd-run', '--scope', 'systemctl', 'start', 'keepalived.service'] in directory '/root'
2017-11-29 12:33:56,520 [salt.loaded.int.module.cmdmod][INFO    ][22022] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2017-11-29 12:33:56,528 [salt.loaded.int.module.cmdmod][INFO    ][22022] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-11-29 12:33:56,535 [salt.loaded.int.module.cmdmod][INFO    ][22022] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-11-29 12:33:56,542 [salt.state       ][INFO    ][22022] {'keepalived': True}
2017-11-29 12:33:56,543 [salt.state       ][INFO    ][22022] Completed state [keepalived] at time 12:33:56.542567 duration_in_ms=86.188
2017-11-29 12:33:56,544 [salt.minion      ][INFO    ][22022] Returning information for job: 20171129123351009558
2017-11-29 12:34:10,985 [salt.minion      ][INFO    ][21605] User sudo_ubuntu Executing command pillar.get with jid 20171129123410972280
2017-11-29 12:34:10,997 [salt.minion      ][INFO    ][23445] Starting a new job with PID 23445
2017-11-29 12:34:11,004 [salt.minion      ][INFO    ][23445] Returning information for job: 20171129123410972280
2017-11-29 12:39:03,553 [salt.minion      ][INFO    ][21605] User sudo_ubuntu Executing command state.sls with jid 20171129123903542564
2017-11-29 12:39:03,563 [salt.minion      ][INFO    ][23541] Starting a new job with PID 23541
2017-11-29 12:39:06,188 [salt.state       ][INFO    ][23541] Loading fresh modules for state activity
2017-11-29 12:39:06,213 [salt.fileclient  ][INFO    ][23541] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-11-29 12:39:06,237 [salt.fileclient  ][INFO    ][23541] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-11-29 12:39:06,530 [salt.state       ][INFO    ][23541] Running state [attr] at time 12:39:06.530166
2017-11-29 12:39:06,530 [salt.state       ][INFO    ][23541] Executing state pkg.installed for attr
2017-11-29 12:39:06,531 [salt.loaded.int.module.cmdmod][INFO    ][23541] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-29 12:39:06,830 [salt.loaded.int.module.cmdmod][INFO    ][23541] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-11-29 12:39:08,094 [salt.loaded.int.module.cmdmod][INFO    ][23541] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'attr'] in directory '/root'
2017-11-29 12:39:09,400 [salt.loaded.int.module.cmdmod][INFO    ][23541] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-29 12:39:09,428 [salt.state       ][INFO    ][23541] Made the following changes:
'attr' changed from 'absent' to '1:2.4.47-2'

2017-11-29 12:39:09,438 [salt.state       ][INFO    ][23541] Loading fresh modules for state activity
2017-11-29 12:39:09,456 [salt.state       ][INFO    ][23541] Completed state [attr] at time 12:39:09.455503 duration_in_ms=2925.336
2017-11-29 12:39:09,461 [salt.state       ][INFO    ][23541] Running state [glusterfs-server] at time 12:39:09.461033
2017-11-29 12:39:09,461 [salt.state       ][INFO    ][23541] Executing state pkg.installed for glusterfs-server
2017-11-29 12:39:09,668 [salt.loaded.int.module.cmdmod][INFO    ][23541] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'glusterfs-server'] in directory '/root'
2017-11-29 12:39:13,669 [salt.minion      ][INFO    ][21605] User sudo_ubuntu Executing command saltutil.find_job with jid 20171129123913647448
2017-11-29 12:39:13,680 [salt.minion      ][INFO    ][25381] Starting a new job with PID 25381
2017-11-29 12:39:13,696 [salt.minion      ][INFO    ][25381] Returning information for job: 20171129123913647448
2017-11-29 12:39:16,588 [salt.loaded.int.module.cmdmod][INFO    ][23541] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-29 12:39:16,617 [salt.state       ][INFO    ][23541] Made the following changes:
'keyutils' changed from 'absent' to '1.5.9-8ubuntu1'
'glusterfs-client' changed from 'absent' to '3.10.7-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.7-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.7-ubuntu1~xenial1'

2017-11-29 12:39:16,627 [salt.state       ][INFO    ][23541] Loading fresh modules for state activity
2017-11-29 12:39:16,645 [salt.state       ][INFO    ][23541] Completed state [glusterfs-server] at time 12:39:16.644823 duration_in_ms=7183.789
2017-11-29 12:39:16,650 [salt.state       ][INFO    ][23541] Running state [bc] at time 12:39:16.650276
2017-11-29 12:39:16,651 [salt.state       ][INFO    ][23541] Executing state pkg.installed for bc
2017-11-29 12:39:16,913 [salt.loaded.int.module.cmdmod][INFO    ][23541] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'bc'] in directory '/root'
2017-11-29 12:39:18,277 [salt.loaded.int.module.cmdmod][INFO    ][23541] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-29 12:39:18,310 [salt.state       ][INFO    ][23541] Made the following changes:
'bc' changed from 'absent' to '1.06.95-9build1'

2017-11-29 12:39:18,320 [salt.state       ][INFO    ][23541] Loading fresh modules for state activity
2017-11-29 12:39:18,337 [salt.state       ][INFO    ][23541] Completed state [bc] at time 12:39:18.336506 duration_in_ms=1686.229
2017-11-29 12:39:18,406 [salt.state       ][INFO    ][23541] Running state [glusterfs-server] at time 12:39:18.406074
2017-11-29 12:39:18,406 [salt.state       ][INFO    ][23541] Executing state service.running for glusterfs-server
2017-11-29 12:39:18,408 [salt.loaded.int.module.cmdmod][INFO    ][23541] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-11-29 12:39:18,417 [salt.loaded.int.module.cmdmod][INFO    ][23541] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-11-29 12:39:18,423 [salt.loaded.int.module.cmdmod][INFO    ][23541] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-11-29 12:39:18,431 [salt.state       ][INFO    ][23541] The service glusterfs-server is already running
2017-11-29 12:39:18,431 [salt.state       ][INFO    ][23541] Completed state [glusterfs-server] at time 12:39:18.431342 duration_in_ms=25.267
2017-11-29 12:39:18,433 [salt.state       ][INFO    ][23541] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 12:39:18.433311
2017-11-29 12:39:18,434 [salt.state       ][INFO    ][23541] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-11-29 12:39:18,438 [salt.state       ][INFO    ][23541] File changed:
New file
2017-11-29 12:39:18,438 [salt.state       ][INFO    ][23541] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 12:39:18.438459 duration_in_ms=5.147
2017-11-29 12:39:18,439 [salt.state       ][INFO    ][23541] Running state [/srv/glusterfs/glance] at time 12:39:18.438636
2017-11-29 12:39:18,439 [salt.state       ][INFO    ][23541] Executing state file.directory for /srv/glusterfs/glance
2017-11-29 12:39:18,439 [salt.state       ][INFO    ][23541] {'/srv/glusterfs/glance': 'New Dir'}
2017-11-29 12:39:18,440 [salt.state       ][INFO    ][23541] Completed state [/srv/glusterfs/glance] at time 12:39:18.439583 duration_in_ms=0.947
2017-11-29 12:39:18,440 [salt.state       ][INFO    ][23541] Running state [/srv/glusterfs/keystone-keys] at time 12:39:18.439741
2017-11-29 12:39:18,440 [salt.state       ][INFO    ][23541] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-11-29 12:39:18,440 [salt.state       ][INFO    ][23541] {'/srv/glusterfs/keystone-keys': 'New Dir'}
2017-11-29 12:39:18,440 [salt.state       ][INFO    ][23541] Completed state [/srv/glusterfs/keystone-keys] at time 12:39:18.440464 duration_in_ms=0.723
2017-11-29 12:39:18,441 [salt.state       ][INFO    ][23541] Running state [/srv/glusterfs/nova_instances] at time 12:39:18.440620
2017-11-29 12:39:18,441 [salt.state       ][INFO    ][23541] Executing state file.directory for /srv/glusterfs/nova_instances
2017-11-29 12:39:18,441 [salt.state       ][INFO    ][23541] {'/srv/glusterfs/nova_instances': 'New Dir'}
2017-11-29 12:39:18,441 [salt.state       ][INFO    ][23541] Completed state [/srv/glusterfs/nova_instances] at time 12:39:18.441329 duration_in_ms=0.709
2017-11-29 12:39:18,442 [salt.state       ][INFO    ][23541] Running state [/srv/glusterfs/keystone-credential-keys] at time 12:39:18.441494
2017-11-29 12:39:18,442 [salt.state       ][INFO    ][23541] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-11-29 12:39:18,442 [salt.state       ][INFO    ][23541] {'/srv/glusterfs/keystone-credential-keys': 'New Dir'}
2017-11-29 12:39:18,442 [salt.state       ][INFO    ][23541] Completed state [/srv/glusterfs/keystone-credential-keys] at time 12:39:18.442264 duration_in_ms=0.771
2017-11-29 12:39:18,443 [salt.minion      ][INFO    ][23541] Returning information for job: 20171129123903542564
2017-11-29 12:39:20,298 [salt.minion      ][INFO    ][21605] User sudo_ubuntu Executing command test.ping with jid 20171129123920286536
2017-11-29 12:39:20,308 [salt.minion      ][INFO    ][26341] Starting a new job with PID 26341
2017-11-29 12:39:20,343 [salt.minion      ][INFO    ][26341] Returning information for job: 20171129123920286536
2017-11-29 12:39:38,994 [salt.minion      ][INFO    ][21605] User sudo_ubuntu Executing command state.sls with jid 20171129123938984371
2017-11-29 12:39:39,003 [salt.minion      ][INFO    ][26972] Starting a new job with PID 26972
2017-11-29 12:39:41,340 [salt.state       ][INFO    ][26972] Loading fresh modules for state activity
2017-11-29 12:39:41,373 [salt.fileclient  ][INFO    ][26972] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/setup.sls'
2017-11-29 12:39:41,415 [salt.fileclient  ][INFO    ][26972] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-11-29 12:39:41,502 [salt.fileclient  ][INFO    ][26972] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-11-29 12:39:41,524 [salt.fileclient  ][INFO    ][26972] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-11-29 12:39:41,846 [salt.state       ][INFO    ][26972] Running state [attr] at time 12:39:41.846452
2017-11-29 12:39:41,847 [salt.state       ][INFO    ][26972] Executing state pkg.installed for attr
2017-11-29 12:39:41,847 [salt.loaded.int.module.cmdmod][INFO    ][26972] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-29 12:39:42,114 [salt.state       ][INFO    ][26972] Package attr is already installed
2017-11-29 12:39:42,115 [salt.state       ][INFO    ][26972] Completed state [attr] at time 12:39:42.114698 duration_in_ms=268.245
2017-11-29 12:39:42,115 [salt.state       ][INFO    ][26972] Running state [glusterfs-server] at time 12:39:42.114975
2017-11-29 12:39:42,115 [salt.state       ][INFO    ][26972] Executing state pkg.installed for glusterfs-server
2017-11-29 12:39:42,119 [salt.state       ][INFO    ][26972] Package glusterfs-server is already installed
2017-11-29 12:39:42,119 [salt.state       ][INFO    ][26972] Completed state [glusterfs-server] at time 12:39:42.119188 duration_in_ms=4.213
2017-11-29 12:39:42,119 [salt.state       ][INFO    ][26972] Running state [bc] at time 12:39:42.119384
2017-11-29 12:39:42,120 [salt.state       ][INFO    ][26972] Executing state pkg.installed for bc
2017-11-29 12:39:42,123 [salt.state       ][INFO    ][26972] Package bc is already installed
2017-11-29 12:39:42,123 [salt.state       ][INFO    ][26972] Completed state [bc] at time 12:39:42.123404 duration_in_ms=4.021
2017-11-29 12:39:42,124 [salt.state       ][INFO    ][26972] Running state [glusterfs-server] at time 12:39:42.124415
2017-11-29 12:39:42,125 [salt.state       ][INFO    ][26972] Executing state service.running for glusterfs-server
2017-11-29 12:39:42,125 [salt.loaded.int.module.cmdmod][INFO    ][26972] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-11-29 12:39:42,134 [salt.loaded.int.module.cmdmod][INFO    ][26972] Executing command ['systemctl', '--system', 'daemon-reload'] in directory '/root'
2017-11-29 12:39:42,183 [salt.loaded.int.module.cmdmod][INFO    ][26972] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-11-29 12:39:42,197 [salt.loaded.int.module.cmdmod][INFO    ][26972] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-11-29 12:39:42,204 [salt.loaded.int.module.cmdmod][INFO    ][26972] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-11-29 12:39:42,212 [salt.state       ][INFO    ][26972] The service glusterfs-server is already running
2017-11-29 12:39:42,212 [salt.state       ][INFO    ][26972] Completed state [glusterfs-server] at time 12:39:42.211918 duration_in_ms=87.503
2017-11-29 12:39:42,213 [salt.state       ][INFO    ][26972] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 12:39:42.213366
2017-11-29 12:39:42,214 [salt.state       ][INFO    ][26972] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-11-29 12:39:42,215 [salt.state       ][INFO    ][26972] File /etc/systemd/system/glusterfs-server.service.d/override.conf is in the correct state
2017-11-29 12:39:42,216 [salt.state       ][INFO    ][26972] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 12:39:42.215624 duration_in_ms=2.259
2017-11-29 12:39:42,216 [salt.state       ][INFO    ][26972] Running state [/srv/glusterfs/glance] at time 12:39:42.215802
2017-11-29 12:39:42,216 [salt.state       ][INFO    ][26972] Executing state file.directory for /srv/glusterfs/glance
2017-11-29 12:39:42,216 [salt.state       ][INFO    ][26972] Directory /srv/glusterfs/glance is in the correct state
2017-11-29 12:39:42,216 [salt.state       ][INFO    ][26972] Completed state [/srv/glusterfs/glance] at time 12:39:42.216465 duration_in_ms=0.663
2017-11-29 12:39:42,217 [salt.state       ][INFO    ][26972] Running state [/srv/glusterfs/keystone-keys] at time 12:39:42.216632
2017-11-29 12:39:42,217 [salt.state       ][INFO    ][26972] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-11-29 12:39:42,217 [salt.state       ][INFO    ][26972] Directory /srv/glusterfs/keystone-keys is in the correct state
2017-11-29 12:39:42,217 [salt.state       ][INFO    ][26972] Completed state [/srv/glusterfs/keystone-keys] at time 12:39:42.217258 duration_in_ms=0.627
2017-11-29 12:39:42,217 [salt.state       ][INFO    ][26972] Running state [/srv/glusterfs/nova_instances] at time 12:39:42.217422
2017-11-29 12:39:42,218 [salt.state       ][INFO    ][26972] Executing state file.directory for /srv/glusterfs/nova_instances
2017-11-29 12:39:42,218 [salt.state       ][INFO    ][26972] Directory /srv/glusterfs/nova_instances is in the correct state
2017-11-29 12:39:42,218 [salt.state       ][INFO    ][26972] Completed state [/srv/glusterfs/nova_instances] at time 12:39:42.218108 duration_in_ms=0.685
2017-11-29 12:39:42,218 [salt.state       ][INFO    ][26972] Running state [/srv/glusterfs/keystone-credential-keys] at time 12:39:42.218288
2017-11-29 12:39:42,218 [salt.state       ][INFO    ][26972] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-11-29 12:39:42,219 [salt.state       ][INFO    ][26972] Directory /srv/glusterfs/keystone-credential-keys is in the correct state
2017-11-29 12:39:42,219 [salt.state       ][INFO    ][26972] Completed state [/srv/glusterfs/keystone-credential-keys] at time 12:39:42.218940 duration_in_ms=0.651
2017-11-29 12:39:42,286 [salt.loaded.int.module.cmdmod][INFO    ][26972] Executing command ['git', '--version'] in directory '/root'
2017-11-29 12:39:42,364 [salt.state       ][INFO    ][26972] Running state [sleep 5] at time 12:39:42.363569
2017-11-29 12:39:42,364 [salt.state       ][INFO    ][26972] Executing state cmd.wait for sleep 5
2017-11-29 12:39:42,364 [salt.state       ][INFO    ][26972] No changes made for sleep 5
2017-11-29 12:39:42,364 [salt.state       ][INFO    ][26972] Completed state [sleep 5] at time 12:39:42.364186 duration_in_ms=0.617
2017-11-29 12:39:42,365 [salt.state       ][INFO    ][26972] Running state [192.168.10.143] at time 12:39:42.364715
2017-11-29 12:39:42,365 [salt.state       ][INFO    ][26972] Executing state glusterfs.peered for 192.168.10.143
2017-11-29 12:39:42,365 [salt.loaded.int.module.cmdmod][INFO    ][26972] Executing command 'gluster --version' in directory '/root'
2017-11-29 12:39:42,374 [salt.loaded.int.module.cmdmod][INFO    ][26972] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-29 12:39:42,431 [salt.loaded.int.module.cmdmod][INFO    ][26972] Executing command 'gluster --version' in directory '/root'
2017-11-29 12:39:42,439 [salt.loaded.int.module.cmdmod][INFO    ][26972] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-29 12:39:42,494 [salt.loaded.int.module.cmdmod][INFO    ][26972] Executing command 'gluster --version' in directory '/root'
2017-11-29 12:39:42,503 [salt.loaded.int.module.cmdmod][INFO    ][26972] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-29 12:39:42,559 [salt.loaded.int.module.cmdmod][INFO    ][26972] Executing command 'gluster --version' in directory '/root'
2017-11-29 12:39:42,567 [salt.loaded.int.module.cmdmod][INFO    ][26972] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-29 12:39:42,623 [salt.state       ][INFO    ][26972] Peering with localhost is not needed
2017-11-29 12:39:42,624 [salt.state       ][INFO    ][26972] Completed state [192.168.10.143] at time 12:39:42.623470 duration_in_ms=258.754
2017-11-29 12:39:42,627 [salt.state       ][INFO    ][26972] Running state [192.168.10.142] at time 12:39:42.626612
2017-11-29 12:39:42,627 [salt.state       ][INFO    ][26972] Executing state glusterfs.peered for 192.168.10.142
2017-11-29 12:39:42,627 [salt.loaded.int.module.cmdmod][INFO    ][26972] Executing command 'gluster --version' in directory '/root'
2017-11-29 12:39:42,635 [salt.loaded.int.module.cmdmod][INFO    ][26972] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-29 12:39:42,691 [salt.loaded.int.module.cmdmod][INFO    ][26972] Executing command 'gluster --version' in directory '/root'
2017-11-29 12:39:42,699 [salt.loaded.int.module.cmdmod][INFO    ][26972] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-29 12:39:42,754 [salt.loaded.int.module.cmdmod][INFO    ][26972] Executing command 'gluster --version' in directory '/root'
2017-11-29 12:39:42,760 [salt.loaded.int.module.cmdmod][INFO    ][26972] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-29 12:39:42,816 [salt.loaded.int.module.cmdmod][INFO    ][26972] Executing command 'gluster --version' in directory '/root'
2017-11-29 12:39:42,824 [salt.loaded.int.module.cmdmod][INFO    ][26972] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-29 12:39:42,879 [salt.state       ][INFO    ][26972] {'new': {'192.168.10.141': [], 'kvm02.baremetal-mcp-ocata-ovs-ha.local': ['192.168.10.142']}, 'old': {'192.168.10.141': [], 'kvm02.baremetal-mcp-ocata-ovs-ha.local': []}}
2017-11-29 12:39:42,879 [salt.state       ][INFO    ][26972] Completed state [192.168.10.142] at time 12:39:42.879128 duration_in_ms=252.515
2017-11-29 12:39:42,882 [salt.state       ][INFO    ][26972] Running state [192.168.10.141] at time 12:39:42.882091
2017-11-29 12:39:42,882 [salt.state       ][INFO    ][26972] Executing state glusterfs.peered for 192.168.10.141
2017-11-29 12:39:42,883 [salt.loaded.int.module.cmdmod][INFO    ][26972] Executing command 'gluster --version' in directory '/root'
2017-11-29 12:39:42,891 [salt.loaded.int.module.cmdmod][INFO    ][26972] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-29 12:39:42,948 [salt.state       ][INFO    ][26972] Host 192.168.10.141 already peered
2017-11-29 12:39:42,948 [salt.state       ][INFO    ][26972] Completed state [192.168.10.141] at time 12:39:42.947704 duration_in_ms=65.613
2017-11-29 12:39:42,949 [salt.state       ][INFO    ][26972] Running state [glance] at time 12:39:42.948666
2017-11-29 12:39:42,949 [salt.state       ][INFO    ][26972] Executing state glusterfs.created for glance
2017-11-29 12:39:42,949 [salt.loaded.int.module.cmdmod][INFO    ][26972] Executing command 'gluster --version' in directory '/root'
2017-11-29 12:39:42,957 [salt.loaded.int.module.cmdmod][INFO    ][26972] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-29 12:39:43,013 [salt.loaded.int.module.cmdmod][INFO    ][26972] Executing command 'gluster --version' in directory '/root'
2017-11-29 12:39:43,021 [salt.loaded.int.module.cmdmod][INFO    ][26972] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-29 12:39:43,079 [salt.state       ][INFO    ][26972] Volume glance already exists and is started.
2017-11-29 12:39:43,080 [salt.state       ][INFO    ][26972] Completed state [glance] at time 12:39:43.079575 duration_in_ms=130.909
2017-11-29 12:39:43,084 [salt.state       ][INFO    ][26972] Running state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 12:39:43.083732
2017-11-29 12:39:43,084 [salt.state       ][INFO    ][26972] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'
2017-11-29 12:39:43,084 [salt.loaded.int.module.cmdmod][INFO    ][26972] Executing command 'gluster volume info 'glance' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-11-29 12:39:43,140 [salt.state       ][INFO    ][26972] unless execution succeeded
2017-11-29 12:39:43,140 [salt.state       ][INFO    ][26972] Completed state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 12:39:43.140047 duration_in_ms=56.315
2017-11-29 12:39:43,141 [salt.state       ][INFO    ][26972] Running state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 12:39:43.140601
2017-11-29 12:39:43,141 [salt.state       ][INFO    ][26972] Executing state cmd.run for gluster volume set 'glance' 'network.remote-dio' 'True'
2017-11-29 12:39:43,141 [salt.loaded.int.module.cmdmod][INFO    ][26972] Executing command 'gluster volume info 'glance' | grep 'network.remote-dio: True'' in directory '/root'
2017-11-29 12:39:43,197 [salt.state       ][INFO    ][26972] unless execution succeeded
2017-11-29 12:39:43,197 [salt.state       ][INFO    ][26972] Completed state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 12:39:43.197060 duration_in_ms=56.459
2017-11-29 12:39:43,198 [salt.state       ][INFO    ][26972] Running state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 12:39:43.197642
2017-11-29 12:39:43,198 [salt.state       ][INFO    ][26972] Executing state cmd.run for gluster volume set 'glance' 'nfs.disable' 'True'
2017-11-29 12:39:43,198 [salt.loaded.int.module.cmdmod][INFO    ][26972] Executing command 'gluster volume info 'glance' | grep 'nfs.disable: True'' in directory '/root'
2017-11-29 12:39:43,254 [salt.state       ][INFO    ][26972] unless execution succeeded
2017-11-29 12:39:43,254 [salt.state       ][INFO    ][26972] Completed state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 12:39:43.254159 duration_in_ms=56.517
2017-11-29 12:39:43,255 [salt.state       ][INFO    ][26972] Running state [gluster volume set 'glance' 'cluster.favorite-child-policy' 'mtime'] at time 12:39:43.254834
2017-11-29 12:39:43,255 [salt.state       ][INFO    ][26972] Executing state cmd.run for gluster volume set 'glance' 'cluster.favorite-child-policy' 'mtime'
2017-11-29 12:39:43,256 [salt.loaded.int.module.cmdmod][INFO    ][26972] Executing command 'gluster volume info 'glance' | grep 'cluster.favorite-child-policy: mtime'' in directory '/root'
2017-11-29 12:39:43,309 [salt.state       ][INFO    ][26972] unless execution succeeded
2017-11-29 12:39:43,309 [salt.state       ][INFO    ][26972] Completed state [gluster volume set 'glance' 'cluster.favorite-child-policy' 'mtime'] at time 12:39:43.308856 duration_in_ms=54.022
2017-11-29 12:39:43,309 [salt.state       ][INFO    ][26972] Running state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 12:39:43.309415
2017-11-29 12:39:43,310 [salt.state       ][INFO    ][26972] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'
2017-11-29 12:39:43,312 [salt.loaded.int.module.cmdmod][INFO    ][26972] Executing command 'gluster volume info 'glance' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-11-29 12:39:43,367 [salt.state       ][INFO    ][26972] unless execution succeeded
2017-11-29 12:39:43,368 [salt.state       ][INFO    ][26972] Completed state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 12:39:43.367712 duration_in_ms=58.297
2017-11-29 12:39:43,369 [salt.state       ][INFO    ][26972] Running state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 12:39:43.368947
2017-11-29 12:39:43,369 [salt.state       ][INFO    ][26972] Executing state cmd.run for gluster volume set 'glance' 'cluster.readdir-optimize' 'True'
2017-11-29 12:39:43,370 [salt.loaded.int.module.cmdmod][INFO    ][26972] Executing command 'gluster volume info 'glance' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-11-29 12:39:43,428 [salt.state       ][INFO    ][26972] unless execution succeeded
2017-11-29 12:39:43,428 [salt.state       ][INFO    ][26972] Completed state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 12:39:43.427875 duration_in_ms=58.927
2017-11-29 12:39:43,429 [salt.state       ][INFO    ][26972] Running state [glance] at time 12:39:43.429371
2017-11-29 12:39:43,430 [salt.state       ][INFO    ][26972] Executing state glusterfs.started for glance
2017-11-29 12:39:43,430 [salt.loaded.int.module.cmdmod][INFO    ][26972] Executing command 'gluster --version' in directory '/root'
2017-11-29 12:39:43,438 [salt.loaded.int.module.cmdmod][INFO    ][26972] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-29 12:39:43,493 [salt.loaded.int.module.cmdmod][INFO    ][26972] Executing command 'gluster --version' in directory '/root'
2017-11-29 12:39:43,502 [salt.loaded.int.module.cmdmod][INFO    ][26972] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-29 12:39:43,561 [salt.state       ][INFO    ][26972] Volume glance is already started
2017-11-29 12:39:43,562 [salt.state       ][INFO    ][26972] Completed state [glance] at time 12:39:43.561533 duration_in_ms=132.162
2017-11-29 12:39:43,563 [salt.state       ][INFO    ][26972] Running state [keystone-keys] at time 12:39:43.562814
2017-11-29 12:39:43,563 [salt.state       ][INFO    ][26972] Executing state glusterfs.created for keystone-keys
2017-11-29 12:39:43,564 [salt.loaded.int.module.cmdmod][INFO    ][26972] Executing command 'gluster --version' in directory '/root'
2017-11-29 12:39:43,571 [salt.loaded.int.module.cmdmod][INFO    ][26972] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-29 12:39:43,626 [salt.loaded.int.module.cmdmod][INFO    ][26972] Executing command 'gluster --version' in directory '/root'
2017-11-29 12:39:43,633 [salt.loaded.int.module.cmdmod][INFO    ][26972] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-29 12:39:43,691 [salt.state       ][INFO    ][26972] Volume keystone-keys already exists and is started.
2017-11-29 12:39:43,691 [salt.state       ][INFO    ][26972] Completed state [keystone-keys] at time 12:39:43.691336 duration_in_ms=128.52
2017-11-29 12:39:43,697 [salt.state       ][INFO    ][26972] Running state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 12:39:43.696707
2017-11-29 12:39:43,697 [salt.state       ][INFO    ][26972] Executing state cmd.run for gluster volume set 'keystone-keys' 'network.remote-dio' 'True'
2017-11-29 12:39:43,697 [salt.loaded.int.module.cmdmod][INFO    ][26972] Executing command 'gluster volume info 'keystone-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-11-29 12:39:43,751 [salt.state       ][INFO    ][26972] unless execution succeeded
2017-11-29 12:39:43,751 [salt.state       ][INFO    ][26972] Completed state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 12:39:43.750930 duration_in_ms=54.223
2017-11-29 12:39:43,752 [salt.state       ][INFO    ][26972] Running state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 12:39:43.751566
2017-11-29 12:39:43,752 [salt.state       ][INFO    ][26972] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-11-29 12:39:43,752 [salt.loaded.int.module.cmdmod][INFO    ][26972] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-11-29 12:39:43,806 [salt.state       ][INFO    ][26972] unless execution succeeded
2017-11-29 12:39:43,806 [salt.state       ][INFO    ][26972] Completed state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 12:39:43.805957 duration_in_ms=54.391
2017-11-29 12:39:43,807 [salt.state       ][INFO    ][26972] Running state [gluster volume set 'keystone-keys' 'cluster.favorite-child-policy' 'mtime'] at time 12:39:43.806642
2017-11-29 12:39:43,807 [salt.state       ][INFO    ][26972] Executing state cmd.run for gluster volume set 'keystone-keys' 'cluster.favorite-child-policy' 'mtime'
2017-11-29 12:39:43,807 [salt.loaded.int.module.cmdmod][INFO    ][26972] Executing command 'gluster volume info 'keystone-keys' | grep 'cluster.favorite-child-policy: mtime'' in directory '/root'
2017-11-29 12:39:43,863 [salt.state       ][INFO    ][26972] unless execution succeeded
2017-11-29 12:39:43,864 [salt.state       ][INFO    ][26972] Completed state [gluster volume set 'keystone-keys' 'cluster.favorite-child-policy' 'mtime'] at time 12:39:43.863649 duration_in_ms=57.007
2017-11-29 12:39:43,864 [salt.state       ][INFO    ][26972] Running state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 12:39:43.864241
2017-11-29 12:39:43,865 [salt.state       ][INFO    ][26972] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'
2017-11-29 12:39:43,865 [salt.loaded.int.module.cmdmod][INFO    ][26972] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-11-29 12:39:43,919 [salt.state       ][INFO    ][26972] unless execution succeeded
2017-11-29 12:39:43,919 [salt.state       ][INFO    ][26972] Completed state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 12:39:43.918758 duration_in_ms=54.515
2017-11-29 12:39:43,919 [salt.state       ][INFO    ][26972] Running state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 12:39:43.919396
2017-11-29 12:39:43,920 [salt.state       ][INFO    ][26972] Executing state cmd.run for gluster volume set 'keystone-keys' 'nfs.disable' 'True'
2017-11-29 12:39:43,920 [salt.loaded.int.module.cmdmod][INFO    ][26972] Executing command 'gluster volume info 'keystone-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-11-29 12:39:43,978 [salt.state       ][INFO    ][26972] unless execution succeeded
2017-11-29 12:39:43,978 [salt.state       ][INFO    ][26972] Completed state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 12:39:43.977962 duration_in_ms=58.566
2017-11-29 12:39:43,979 [salt.state       ][INFO    ][26972] Running state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 12:39:43.978600
2017-11-29 12:39:43,979 [salt.state       ][INFO    ][26972] Executing state cmd.run for gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'
2017-11-29 12:39:43,979 [salt.loaded.int.module.cmdmod][INFO    ][26972] Executing command 'gluster volume info 'keystone-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-11-29 12:39:44,035 [salt.state       ][INFO    ][26972] unless execution succeeded
2017-11-29 12:39:44,035 [salt.state       ][INFO    ][26972] Completed state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 12:39:44.035291 duration_in_ms=56.681
2017-11-29 12:39:44,037 [salt.state       ][INFO    ][26972] Running state [keystone-keys] at time 12:39:44.036884
2017-11-29 12:39:44,037 [salt.state       ][INFO    ][26972] Executing state glusterfs.started for keystone-keys
2017-11-29 12:39:44,038 [salt.loaded.int.module.cmdmod][INFO    ][26972] Executing command 'gluster --version' in directory '/root'
2017-11-29 12:39:44,046 [salt.loaded.int.module.cmdmod][INFO    ][26972] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-29 12:39:44,100 [salt.loaded.int.module.cmdmod][INFO    ][26972] Executing command 'gluster --version' in directory '/root'
2017-11-29 12:39:44,106 [salt.loaded.int.module.cmdmod][INFO    ][26972] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-29 12:39:44,166 [salt.state       ][INFO    ][26972] Volume keystone-keys is already started
2017-11-29 12:39:44,167 [salt.state       ][INFO    ][26972] Completed state [keystone-keys] at time 12:39:44.166577 duration_in_ms=129.692
2017-11-29 12:39:44,168 [salt.state       ][INFO    ][26972] Running state [nova_instances] at time 12:39:44.167623
2017-11-29 12:39:44,168 [salt.state       ][INFO    ][26972] Executing state glusterfs.created for nova_instances
2017-11-29 12:39:44,168 [salt.loaded.int.module.cmdmod][INFO    ][26972] Executing command 'gluster --version' in directory '/root'
2017-11-29 12:39:44,176 [salt.loaded.int.module.cmdmod][INFO    ][26972] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-29 12:39:44,231 [salt.loaded.int.module.cmdmod][INFO    ][26972] Executing command 'gluster --version' in directory '/root'
2017-11-29 12:39:44,238 [salt.loaded.int.module.cmdmod][INFO    ][26972] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-29 12:39:44,297 [salt.state       ][INFO    ][26972] Volume nova_instances already exists and is started.
2017-11-29 12:39:44,297 [salt.state       ][INFO    ][26972] Completed state [nova_instances] at time 12:39:44.297154 duration_in_ms=129.531
2017-11-29 12:39:44,302 [salt.state       ][INFO    ][26972] Running state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 12:39:44.301858
2017-11-29 12:39:44,302 [salt.state       ][INFO    ][26972] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'
2017-11-29 12:39:44,303 [salt.loaded.int.module.cmdmod][INFO    ][26972] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-11-29 12:39:44,357 [salt.state       ][INFO    ][26972] unless execution succeeded
2017-11-29 12:39:44,357 [salt.state       ][INFO    ][26972] Completed state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 12:39:44.357092 duration_in_ms=55.24
2017-11-29 12:39:44,358 [salt.state       ][INFO    ][26972] Running state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'True'] at time 12:39:44.357735
2017-11-29 12:39:44,358 [salt.state       ][INFO    ][26972] Executing state cmd.run for gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'True'
2017-11-29 12:39:44,359 [salt.loaded.int.module.cmdmod][INFO    ][26972] Executing command 'gluster volume info 'nova_instances' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-11-29 12:39:44,413 [salt.state       ][INFO    ][26972] unless execution succeeded
2017-11-29 12:39:44,414 [salt.state       ][INFO    ][26972] Completed state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'True'] at time 12:39:44.413691 duration_in_ms=55.955
2017-11-29 12:39:44,414 [salt.state       ][INFO    ][26972] Running state [gluster volume set 'nova_instances' 'network.remote-dio' 'True'] at time 12:39:44.414331
2017-11-29 12:39:44,415 [salt.state       ][INFO    ][26972] Executing state cmd.run for gluster volume set 'nova_instances' 'network.remote-dio' 'True'
2017-11-29 12:39:44,415 [salt.loaded.int.module.cmdmod][INFO    ][26972] Executing command 'gluster volume info 'nova_instances' | grep 'network.remote-dio: True'' in directory '/root'
2017-11-29 12:39:44,471 [salt.state       ][INFO    ][26972] unless execution succeeded
2017-11-29 12:39:44,471 [salt.state       ][INFO    ][26972] Completed state [gluster volume set 'nova_instances' 'network.remote-dio' 'True'] at time 12:39:44.471356 duration_in_ms=57.024
2017-11-29 12:39:44,472 [salt.state       ][INFO    ][26972] Running state [gluster volume set 'nova_instances' 'cluster.favorite-child-policy' 'mtime'] at time 12:39:44.472049
2017-11-29 12:39:44,472 [salt.state       ][INFO    ][26972] Executing state cmd.run for gluster volume set 'nova_instances' 'cluster.favorite-child-policy' 'mtime'
2017-11-29 12:39:44,473 [salt.loaded.int.module.cmdmod][INFO    ][26972] Executing command 'gluster volume info 'nova_instances' | grep 'cluster.favorite-child-policy: mtime'' in directory '/root'
2017-11-29 12:39:44,529 [salt.state       ][INFO    ][26972] unless execution succeeded
2017-11-29 12:39:44,529 [salt.state       ][INFO    ][26972] Completed state [gluster volume set 'nova_instances' 'cluster.favorite-child-policy' 'mtime'] at time 12:39:44.528755 duration_in_ms=56.705
2017-11-29 12:39:44,529 [salt.state       ][INFO    ][26972] Running state [gluster volume set 'nova_instances' 'nfs.disable' 'True'] at time 12:39:44.529429
2017-11-29 12:39:44,530 [salt.state       ][INFO    ][26972] Executing state cmd.run for gluster volume set 'nova_instances' 'nfs.disable' 'True'
2017-11-29 12:39:44,530 [salt.loaded.int.module.cmdmod][INFO    ][26972] Executing command 'gluster volume info 'nova_instances' | grep 'nfs.disable: True'' in directory '/root'
2017-11-29 12:39:44,585 [salt.state       ][INFO    ][26972] unless execution succeeded
2017-11-29 12:39:44,585 [salt.state       ][INFO    ][26972] Completed state [gluster volume set 'nova_instances' 'nfs.disable' 'True'] at time 12:39:44.585184 duration_in_ms=55.754
2017-11-29 12:39:44,586 [salt.state       ][INFO    ][26972] Running state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 12:39:44.585782
2017-11-29 12:39:44,586 [salt.state       ][INFO    ][26972] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'
2017-11-29 12:39:44,587 [salt.loaded.int.module.cmdmod][INFO    ][26972] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-11-29 12:39:44,641 [salt.state       ][INFO    ][26972] unless execution succeeded
2017-11-29 12:39:44,642 [salt.state       ][INFO    ][26972] Completed state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 12:39:44.641492 duration_in_ms=55.71
2017-11-29 12:39:44,643 [salt.state       ][INFO    ][26972] Running state [nova_instances] at time 12:39:44.643089
2017-11-29 12:39:44,643 [salt.state       ][INFO    ][26972] Executing state glusterfs.started for nova_instances
2017-11-29 12:39:44,644 [salt.loaded.int.module.cmdmod][INFO    ][26972] Executing command 'gluster --version' in directory '/root'
2017-11-29 12:39:44,651 [salt.loaded.int.module.cmdmod][INFO    ][26972] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-29 12:39:44,706 [salt.loaded.int.module.cmdmod][INFO    ][26972] Executing command 'gluster --version' in directory '/root'
2017-11-29 12:39:44,714 [salt.loaded.int.module.cmdmod][INFO    ][26972] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-29 12:39:44,772 [salt.state       ][INFO    ][26972] Volume nova_instances is already started
2017-11-29 12:39:44,773 [salt.state       ][INFO    ][26972] Completed state [nova_instances] at time 12:39:44.772544 duration_in_ms=129.455
2017-11-29 12:39:44,774 [salt.state       ][INFO    ][26972] Running state [keystone-credential-keys] at time 12:39:44.773749
2017-11-29 12:39:44,774 [salt.state       ][INFO    ][26972] Executing state glusterfs.created for keystone-credential-keys
2017-11-29 12:39:44,775 [salt.loaded.int.module.cmdmod][INFO    ][26972] Executing command 'gluster --version' in directory '/root'
2017-11-29 12:39:44,783 [salt.loaded.int.module.cmdmod][INFO    ][26972] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-29 12:39:44,838 [salt.loaded.int.module.cmdmod][INFO    ][26972] Executing command 'gluster --version' in directory '/root'
2017-11-29 12:39:44,847 [salt.loaded.int.module.cmdmod][INFO    ][26972] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-29 12:39:44,905 [salt.state       ][INFO    ][26972] Volume keystone-credential-keys already exists and is started.
2017-11-29 12:39:44,905 [salt.state       ][INFO    ][26972] Completed state [keystone-credential-keys] at time 12:39:44.905129 duration_in_ms=131.379
2017-11-29 12:39:44,910 [salt.state       ][INFO    ][26972] Running state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 12:39:44.909948
2017-11-29 12:39:44,910 [salt.state       ][INFO    ][26972] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'
2017-11-29 12:39:44,911 [salt.loaded.int.module.cmdmod][INFO    ][26972] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-11-29 12:39:44,966 [salt.state       ][INFO    ][26972] unless execution succeeded
2017-11-29 12:39:44,967 [salt.state       ][INFO    ][26972] Completed state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 12:39:44.966467 duration_in_ms=56.519
2017-11-29 12:39:44,967 [salt.state       ][INFO    ][26972] Running state [gluster volume set 'keystone-credential-keys' 'cluster.favorite-child-policy' 'mtime'] at time 12:39:44.967215
2017-11-29 12:39:44,968 [salt.state       ][INFO    ][26972] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'cluster.favorite-child-policy' 'mtime'
2017-11-29 12:39:44,968 [salt.loaded.int.module.cmdmod][INFO    ][26972] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'cluster.favorite-child-policy: mtime'' in directory '/root'
2017-11-29 12:39:45,024 [salt.state       ][INFO    ][26972] unless execution succeeded
2017-11-29 12:39:45,024 [salt.state       ][INFO    ][26972] Completed state [gluster volume set 'keystone-credential-keys' 'cluster.favorite-child-policy' 'mtime'] at time 12:39:45.024418 duration_in_ms=57.203
2017-11-29 12:39:45,025 [salt.state       ][INFO    ][26972] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 12:39:45.025068
2017-11-29 12:39:45,025 [salt.state       ][INFO    ][26972] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-11-29 12:39:45,026 [salt.loaded.int.module.cmdmod][INFO    ][26972] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-11-29 12:39:45,081 [salt.state       ][INFO    ][26972] unless execution succeeded
2017-11-29 12:39:45,081 [salt.state       ][INFO    ][26972] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 12:39:45.080755 duration_in_ms=55.687
2017-11-29 12:39:45,081 [salt.state       ][INFO    ][26972] Running state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 12:39:45.081328
2017-11-29 12:39:45,082 [salt.state       ][INFO    ][26972] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'
2017-11-29 12:39:45,082 [salt.loaded.int.module.cmdmod][INFO    ][26972] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-11-29 12:39:45,139 [salt.state       ][INFO    ][26972] unless execution succeeded
2017-11-29 12:39:45,139 [salt.state       ][INFO    ][26972] Completed state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 12:39:45.139023 duration_in_ms=57.695
2017-11-29 12:39:45,140 [salt.state       ][INFO    ][26972] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 12:39:45.139630
2017-11-29 12:39:45,140 [salt.state       ][INFO    ][26972] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'
2017-11-29 12:39:45,140 [salt.loaded.int.module.cmdmod][INFO    ][26972] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-11-29 12:39:45,193 [salt.state       ][INFO    ][26972] unless execution succeeded
2017-11-29 12:39:45,194 [salt.state       ][INFO    ][26972] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 12:39:45.193581 duration_in_ms=53.951
2017-11-29 12:39:45,194 [salt.state       ][INFO    ][26972] Running state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 12:39:45.194186
2017-11-29 12:39:45,194 [salt.state       ][INFO    ][26972] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'
2017-11-29 12:39:45,195 [salt.loaded.int.module.cmdmod][INFO    ][26972] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-11-29 12:39:45,250 [salt.state       ][INFO    ][26972] unless execution succeeded
2017-11-29 12:39:45,251 [salt.state       ][INFO    ][26972] Completed state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 12:39:45.250461 duration_in_ms=56.274
2017-11-29 12:39:45,252 [salt.state       ][INFO    ][26972] Running state [keystone-credential-keys] at time 12:39:45.251998
2017-11-29 12:39:45,252 [salt.state       ][INFO    ][26972] Executing state glusterfs.started for keystone-credential-keys
2017-11-29 12:39:45,253 [salt.loaded.int.module.cmdmod][INFO    ][26972] Executing command 'gluster --version' in directory '/root'
2017-11-29 12:39:45,261 [salt.loaded.int.module.cmdmod][INFO    ][26972] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-29 12:39:45,317 [salt.loaded.int.module.cmdmod][INFO    ][26972] Executing command 'gluster --version' in directory '/root'
2017-11-29 12:39:45,324 [salt.loaded.int.module.cmdmod][INFO    ][26972] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-29 12:39:45,383 [salt.state       ][INFO    ][26972] Volume keystone-credential-keys is already started
2017-11-29 12:39:45,383 [salt.state       ][INFO    ][26972] Completed state [keystone-credential-keys] at time 12:39:45.383302 duration_in_ms=131.303
2017-11-29 12:39:45,385 [salt.minion      ][INFO    ][26972] Returning information for job: 20171129123938984371
2017-11-29 12:39:51,056 [salt.minion      ][INFO    ][21605] User sudo_ubuntu Executing command test.ping with jid 20171129123951047011
2017-11-29 12:39:51,068 [salt.minion      ][INFO    ][27531] Starting a new job with PID 27531
2017-11-29 12:39:51,102 [salt.minion      ][INFO    ][27531] Returning information for job: 20171129123951047011
2017-11-29 12:39:51,490 [salt.minion      ][INFO    ][21605] User sudo_ubuntu Executing command cmd.run with jid 20171129123951480463
2017-11-29 12:39:51,501 [salt.minion      ][INFO    ][27536] Starting a new job with PID 27536
2017-11-29 12:39:51,505 [salt.loaded.int.module.cmdmod][INFO    ][27536] Executing command 'gluster peer status; gluster volume status' in directory '/root'
2017-11-29 12:39:51,624 [salt.minion      ][INFO    ][27536] Returning information for job: 20171129123951480463
2017-11-29 13:25:12,088 [salt.utils.schedule][INFO    ][21605] Running scheduled job: __mine_interval
2017-11-29 13:38:16,885 [salt.minion      ][INFO    ][21605] User sudo_ubuntu Executing command cp.push_dir with jid 20171129133816869944
2017-11-29 13:38:16,898 [salt.minion      ][INFO    ][28263] Starting a new job with PID 28263
