2017-10-27 19:37:01,515 [salt.cli.daemons ][WARNING ][2492] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-10-27 19:37:40,289 [salt.state       ][ERROR   ][3954] No contents found in top file
2017-10-27 19:39:35,982 [salt.utils.parsers][WARNING ][2492] Minion received a SIGTERM. Exiting.
2017-10-27 19:43:57,586 [salt.cli.daemons ][WARNING ][3651] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-10-27 19:45:56,119 [salt.loaded.int.module.cmdmod][ERROR   ][11793] Command 'virsh net-destroy default 2>&1 1>/dev/null; virsh net-undefine default' failed with return code: 1
2017-10-27 19:45:56,119 [salt.loaded.int.module.cmdmod][ERROR   ][11793] stderr: error: failed to get network 'default'
error: Network not found: no network with matching name 'default'
2017-10-27 19:45:56,119 [salt.loaded.int.module.cmdmod][ERROR   ][11793] retcode: 1
2017-10-27 19:45:56,120 [salt.state       ][ERROR   ][11793] {'pid': 16712, 'retcode': 1, 'stderr': "error: failed to get network 'default'\nerror: Network not found: no network with matching name 'default'", 'stdout': ''}
2017-10-27 19:46:22,117 [py.warnings      ][WARNING ][16789] /usr/lib/python2.7/dist-packages/salt/utils/templates.py:73: DeprecationWarning: Starting in 2015.5, cmd.run uses python_shell=False by default, which doesn't support shellisms (pipes, env variables, etc). cmd.run is currently aliased to cmd.shell to prevent breakage. Please switch to cmd.shell or set python_shell=True to avoid breakage in the future, when this aliasing is removed.

2017-10-27 19:47:41,320 [salt.loaded.int.module.cmdmod][ERROR   ][16789] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-10-27 19:47:41,321 [salt.loaded.int.module.cmdmod][ERROR   ][16789] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-10-27 19:47:45,533 [salt.loaded.int.module.cmdmod][ERROR   ][16789] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-10-27 19:47:45,534 [salt.loaded.int.module.cmdmod][ERROR   ][16789] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-10-27 19:47:49,708 [salt.loaded.int.module.cmdmod][ERROR   ][16789] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-10-27 19:47:49,708 [salt.loaded.int.module.cmdmod][ERROR   ][16789] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-10-27 19:47:53,897 [salt.loaded.int.module.cmdmod][ERROR   ][16789] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-10-27 19:47:53,897 [salt.loaded.int.module.cmdmod][ERROR   ][16789] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-10-27 19:47:58,014 [salt.loaded.int.module.cmdmod][ERROR   ][16789] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-10-27 19:47:58,014 [salt.loaded.int.module.cmdmod][ERROR   ][16789] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-10-27 19:48:01,456 [salt.loaded.int.module.cmdmod][ERROR   ][16789] Command 'while true; do salt-call saltutil.running|grep fun: && continue; salt-call --local service.restart salt-minion; break; done' failed with return code: None
2017-10-27 19:48:03,980 [salt.loaded.int.module.cmdmod][INFO    ][24628] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2017-10-27 19:48:03,987 [salt.loaded.int.module.cmdmod][INFO    ][24628] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2017-10-27 19:48:03,996 [salt.loaded.int.module.cmdmod][INFO    ][24628] Executing command ['systemd-run', '--scope', 'systemctl', 'restart', 'salt-minion.service'] in directory '/root'
2017-10-27 19:48:04,004 [salt.utils.parsers][WARNING ][3651] Minion received a SIGTERM. Exiting.
2017-10-27 19:48:04,308 [salt.cli.daemons ][INFO    ][24712] Setting up the Salt Minion "kvm01.baremetal-mcp-ocata-odl-ha.local"
2017-10-27 19:48:04,937 [salt.minion      ][INFO    ][24712] Creating minion process manager
2017-10-27 19:48:04,938 [salt.cli.daemons ][WARNING ][24712] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-10-27 19:48:04,938 [salt.cli.daemons ][INFO    ][24712] The Salt Minion is starting up
2017-10-27 19:48:04,938 [salt.minion      ][INFO    ][24712] Minion is starting as user 'root'
2017-10-27 19:48:04,938 [salt.utils.event ][INFO    ][24712] Starting pull socket on /var/run/salt/minion/minion_event_127643860a_pull.ipc
2017-10-27 19:48:06,064 [salt.loaded.int.module.cmdmod][INFO    ][24712] Executing command ['date', '+%z'] in directory '/root'
2017-10-27 19:48:06,075 [salt.utils.schedule][INFO    ][24712] Updating job settings for scheduled job: __mine_interval
2017-10-27 19:48:06,078 [salt.minion      ][INFO    ][24712] Added mine.update to scheduler
2017-10-27 19:48:06,103 [salt.minion      ][INFO    ][24712] Minion is ready to receive requests!
2017-10-27 19:48:07,104 [salt.utils.schedule][INFO    ][24712] Running scheduled job: __mine_interval
2017-10-27 19:48:08,192 [salt.minion      ][INFO    ][24712] User sudo_ubuntu Executing command saltutil.sync_all with jid 20171027194808181861
2017-10-27 19:48:08,202 [salt.minion      ][INFO    ][24837] Starting a new job with PID 24837
2017-10-27 19:48:10,367 [salt.state       ][INFO    ][24837] Loading fresh modules for state activity
2017-10-27 19:48:10,393 [salt.state       ][ERROR   ][24837] No contents found in top file
2017-10-27 19:48:10,393 [salt.utils.extmods][INFO    ][24837] Creating module dir '/var/cache/salt/minion/extmods/beacons'
2017-10-27 19:48:10,396 [salt.utils.extmods][INFO    ][24837] Syncing beacons for environment 'base'
2017-10-27 19:48:10,396 [salt.utils.extmods][INFO    ][24837] Loading cache from salt://_beacons, for base)
2017-10-27 19:48:10,396 [salt.fileclient  ][INFO    ][24837] Caching directory '_beacons/' for environment 'base'
2017-10-27 19:48:10,426 [salt.utils.extmods][INFO    ][24837] Syncing modules for environment 'base'
2017-10-27 19:48:10,426 [salt.utils.extmods][INFO    ][24837] Loading cache from salt://_modules, for base)
2017-10-27 19:48:10,426 [salt.fileclient  ][INFO    ][24837] Caching directory '_modules/' for environment 'base'
2017-10-27 19:48:10,468 [salt.fileclient  ][INFO    ][24837] Fetching file from saltenv 'base', ** done ** '_modules/ceph_ng.py'
2017-10-27 19:48:10,480 [salt.fileclient  ][INFO    ][24837] Fetching file from saltenv 'base', ** done ** '_modules/cinderng.py'
2017-10-27 19:48:10,491 [salt.fileclient  ][INFO    ][24837] Fetching file from saltenv 'base', ** done ** '_modules/contrail.py'
2017-10-27 19:48:10,501 [salt.fileclient  ][INFO    ][24837] Fetching file from saltenv 'base', ** done ** '_modules/creds.py'
2017-10-27 19:48:10,510 [salt.fileclient  ][INFO    ][24837] Fetching file from saltenv 'base', ** done ** '_modules/devops_utils.py'
2017-10-27 19:48:10,520 [salt.fileclient  ][INFO    ][24837] Fetching file from saltenv 'base', ** done ** '_modules/encode_json.py'
2017-10-27 19:48:10,530 [salt.fileclient  ][INFO    ][24837] Fetching file from saltenv 'base', ** done ** '_modules/gerrit.py'
2017-10-27 19:48:10,541 [salt.fileclient  ][INFO    ][24837] Fetching file from saltenv 'base', ** done ** '_modules/glanceng.py'
2017-10-27 19:48:10,550 [salt.fileclient  ][INFO    ][24837] Fetching file from saltenv 'base', ** done ** '_modules/heat.py'
2017-10-27 19:48:10,558 [salt.fileclient  ][INFO    ][24837] Fetching file from saltenv 'base', ** done ** '_modules/heka_alarming.py'
2017-10-27 19:48:10,862 [salt.fileclient  ][INFO    ][24837] Fetching file from saltenv 'base', ** done ** '_modules/helm.py'
2017-10-27 19:48:10,871 [salt.fileclient  ][INFO    ][24837] Fetching file from saltenv 'base', ** done ** '_modules/jenkins_common.py'
2017-10-27 19:48:10,881 [salt.fileclient  ][INFO    ][24837] Fetching file from saltenv 'base', ** done ** '_modules/keystone_policy.py'
2017-10-27 19:48:10,893 [salt.fileclient  ][INFO    ][24837] Fetching file from saltenv 'base', ** done ** '_modules/linux_hosts.py'
2017-10-27 19:48:10,905 [salt.fileclient  ][INFO    ][24837] Fetching file from saltenv 'base', ** done ** '_modules/linux_netlink.py'
2017-10-27 19:48:10,917 [salt.fileclient  ][INFO    ][24837] Fetching file from saltenv 'base', ** done ** '_modules/maas.py'
2017-10-27 19:48:10,927 [salt.fileclient  ][INFO    ][24837] Fetching file from saltenv 'base', ** done ** '_modules/maas_client.py'
2017-10-27 19:48:10,937 [salt.fileclient  ][INFO    ][24837] Fetching file from saltenv 'base', ** done ** '_modules/multipart.py'
2017-10-27 19:48:10,946 [salt.fileclient  ][INFO    ][24837] Fetching file from saltenv 'base', ** done ** '_modules/nagios_alarming.py'
2017-10-27 19:48:10,957 [salt.fileclient  ][INFO    ][24837] Fetching file from saltenv 'base', ** done ** '_modules/neutronng.py'
2017-10-27 19:48:10,973 [salt.fileclient  ][INFO    ][24837] Fetching file from saltenv 'base', ** done ** '_modules/novang.py'
2017-10-27 19:48:10,983 [salt.fileclient  ][INFO    ][24837] Fetching file from saltenv 'base', ** done ** '_modules/reclass.py'
2017-10-27 19:48:10,993 [salt.fileclient  ][INFO    ][24837] Fetching file from saltenv 'base', ** done ** '_modules/rsyslog_util.py'
2017-10-27 19:48:11,003 [salt.fileclient  ][INFO    ][24837] Fetching file from saltenv 'base', ** done ** '_modules/rundeck.py'
2017-10-27 19:48:11,012 [salt.fileclient  ][INFO    ][24837] Fetching file from saltenv 'base', ** done ** '_modules/saltkey.py'
2017-10-27 19:48:11,022 [salt.fileclient  ][INFO    ][24837] Fetching file from saltenv 'base', ** done ** '_modules/saltresource.py'
2017-10-27 19:48:11,033 [salt.fileclient  ][INFO    ][24837] Fetching file from saltenv 'base', ** done ** '_modules/seedng.py'
2017-10-27 19:48:11,050 [salt.fileclient  ][INFO    ][24837] Fetching file from saltenv 'base', ** done ** '_modules/testing/credentials.py'
2017-10-27 19:48:11,062 [salt.fileclient  ][INFO    ][24837] Fetching file from saltenv 'base', ** done ** '_modules/testing/django.py'
2017-10-27 19:48:11,074 [salt.fileclient  ][INFO    ][24837] Fetching file from saltenv 'base', ** done ** '_modules/testing/django_client_proxy.py'
2017-10-27 19:48:11,084 [salt.fileclient  ][INFO    ][24837] Fetching file from saltenv 'base', ** done ** '_modules/utils.py'
2017-10-27 19:48:11,097 [salt.fileclient  ][INFO    ][24837] Fetching file from saltenv 'base', ** done ** '_modules/virtng.py'
2017-10-27 19:48:11,101 [salt.utils.extmods][INFO    ][24837] Copying '/var/cache/salt/minion/files/base/_modules/__init__.py' to '/var/cache/salt/minion/extmods/modules/__init__.py'
2017-10-27 19:48:11,101 [salt.utils.extmods][INFO    ][24837] Copying '/var/cache/salt/minion/files/base/_modules/ceph_ng.py' to '/var/cache/salt/minion/extmods/modules/ceph_ng.py'
2017-10-27 19:48:11,101 [salt.utils.extmods][INFO    ][24837] Copying '/var/cache/salt/minion/files/base/_modules/cinderng.py' to '/var/cache/salt/minion/extmods/modules/cinderng.py'
2017-10-27 19:48:11,101 [salt.utils.extmods][INFO    ][24837] Copying '/var/cache/salt/minion/files/base/_modules/contrail.py' to '/var/cache/salt/minion/extmods/modules/contrail.py'
2017-10-27 19:48:11,102 [salt.utils.extmods][INFO    ][24837] Copying '/var/cache/salt/minion/files/base/_modules/creds.py' to '/var/cache/salt/minion/extmods/modules/creds.py'
2017-10-27 19:48:11,102 [salt.utils.extmods][INFO    ][24837] Copying '/var/cache/salt/minion/files/base/_modules/devops_utils.py' to '/var/cache/salt/minion/extmods/modules/devops_utils.py'
2017-10-27 19:48:11,102 [salt.utils.extmods][INFO    ][24837] Copying '/var/cache/salt/minion/files/base/_modules/encode_json.py' to '/var/cache/salt/minion/extmods/modules/encode_json.py'
2017-10-27 19:48:11,103 [salt.utils.extmods][INFO    ][24837] Copying '/var/cache/salt/minion/files/base/_modules/gerrit.py' to '/var/cache/salt/minion/extmods/modules/gerrit.py'
2017-10-27 19:48:11,103 [salt.utils.extmods][INFO    ][24837] Copying '/var/cache/salt/minion/files/base/_modules/glanceng.py' to '/var/cache/salt/minion/extmods/modules/glanceng.py'
2017-10-27 19:48:11,103 [salt.utils.extmods][INFO    ][24837] Copying '/var/cache/salt/minion/files/base/_modules/heat.py' to '/var/cache/salt/minion/extmods/modules/heat.py'
2017-10-27 19:48:11,104 [salt.utils.extmods][INFO    ][24837] Copying '/var/cache/salt/minion/files/base/_modules/heka_alarming.py' to '/var/cache/salt/minion/extmods/modules/heka_alarming.py'
2017-10-27 19:48:11,104 [salt.utils.extmods][INFO    ][24837] Copying '/var/cache/salt/minion/files/base/_modules/helm.py' to '/var/cache/salt/minion/extmods/modules/helm.py'
2017-10-27 19:48:11,104 [salt.utils.extmods][INFO    ][24837] Copying '/var/cache/salt/minion/files/base/_modules/jenkins_common.py' to '/var/cache/salt/minion/extmods/modules/jenkins_common.py'
2017-10-27 19:48:11,104 [salt.utils.extmods][INFO    ][24837] Copying '/var/cache/salt/minion/files/base/_modules/keystone_policy.py' to '/var/cache/salt/minion/extmods/modules/keystone_policy.py'
2017-10-27 19:48:11,105 [salt.utils.extmods][INFO    ][24837] Copying '/var/cache/salt/minion/files/base/_modules/linux_hosts.py' to '/var/cache/salt/minion/extmods/modules/linux_hosts.py'
2017-10-27 19:48:11,105 [salt.utils.extmods][INFO    ][24837] Copying '/var/cache/salt/minion/files/base/_modules/linux_netlink.py' to '/var/cache/salt/minion/extmods/modules/linux_netlink.py'
2017-10-27 19:48:11,105 [salt.utils.extmods][INFO    ][24837] Copying '/var/cache/salt/minion/files/base/_modules/maas.py' to '/var/cache/salt/minion/extmods/modules/maas.py'
2017-10-27 19:48:11,105 [salt.utils.extmods][INFO    ][24837] Copying '/var/cache/salt/minion/files/base/_modules/maas_client.py' to '/var/cache/salt/minion/extmods/modules/maas_client.py'
2017-10-27 19:48:11,106 [salt.utils.extmods][INFO    ][24837] Copying '/var/cache/salt/minion/files/base/_modules/multipart.py' to '/var/cache/salt/minion/extmods/modules/multipart.py'
2017-10-27 19:48:11,106 [salt.utils.extmods][INFO    ][24837] Copying '/var/cache/salt/minion/files/base/_modules/nagios_alarming.py' to '/var/cache/salt/minion/extmods/modules/nagios_alarming.py'
2017-10-27 19:48:11,106 [salt.utils.extmods][INFO    ][24837] Copying '/var/cache/salt/minion/files/base/_modules/neutronng.py' to '/var/cache/salt/minion/extmods/modules/neutronng.py'
2017-10-27 19:48:11,106 [salt.utils.extmods][INFO    ][24837] Copying '/var/cache/salt/minion/files/base/_modules/novang.py' to '/var/cache/salt/minion/extmods/modules/novang.py'
2017-10-27 19:48:11,107 [salt.utils.extmods][INFO    ][24837] Copying '/var/cache/salt/minion/files/base/_modules/reclass.py' to '/var/cache/salt/minion/extmods/modules/reclass.py'
2017-10-27 19:48:11,107 [salt.utils.extmods][INFO    ][24837] Copying '/var/cache/salt/minion/files/base/_modules/rsyslog_util.py' to '/var/cache/salt/minion/extmods/modules/rsyslog_util.py'
2017-10-27 19:48:11,107 [salt.utils.extmods][INFO    ][24837] Copying '/var/cache/salt/minion/files/base/_modules/rundeck.py' to '/var/cache/salt/minion/extmods/modules/rundeck.py'
2017-10-27 19:48:11,108 [salt.utils.extmods][INFO    ][24837] Copying '/var/cache/salt/minion/files/base/_modules/saltkey.py' to '/var/cache/salt/minion/extmods/modules/saltkey.py'
2017-10-27 19:48:11,108 [salt.utils.extmods][INFO    ][24837] Copying '/var/cache/salt/minion/files/base/_modules/saltresource.py' to '/var/cache/salt/minion/extmods/modules/saltresource.py'
2017-10-27 19:48:11,108 [salt.utils.extmods][INFO    ][24837] Copying '/var/cache/salt/minion/files/base/_modules/seedng.py' to '/var/cache/salt/minion/extmods/modules/seedng.py'
2017-10-27 19:48:11,108 [salt.utils.extmods][INFO    ][24837] Copying '/var/cache/salt/minion/files/base/_modules/testing/__init__.py' to '/var/cache/salt/minion/extmods/modules/testing/__init__.py'
2017-10-27 19:48:11,109 [salt.utils.extmods][INFO    ][24837] Copying '/var/cache/salt/minion/files/base/_modules/testing/credentials.py' to '/var/cache/salt/minion/extmods/modules/testing/credentials.py'
2017-10-27 19:48:11,109 [salt.utils.extmods][INFO    ][24837] Copying '/var/cache/salt/minion/files/base/_modules/testing/django.py' to '/var/cache/salt/minion/extmods/modules/testing/django.py'
2017-10-27 19:48:11,109 [salt.utils.extmods][INFO    ][24837] Copying '/var/cache/salt/minion/files/base/_modules/testing/django_client_proxy.py' to '/var/cache/salt/minion/extmods/modules/testing/django_client_proxy.py'
2017-10-27 19:48:11,109 [salt.utils.extmods][INFO    ][24837] Copying '/var/cache/salt/minion/files/base/_modules/utils.py' to '/var/cache/salt/minion/extmods/modules/utils.py'
2017-10-27 19:48:11,109 [salt.utils.extmods][INFO    ][24837] Copying '/var/cache/salt/minion/files/base/_modules/virtng.py' to '/var/cache/salt/minion/extmods/modules/virtng.py'
2017-10-27 19:48:11,115 [salt.utils.extmods][INFO    ][24837] Syncing states for environment 'base'
2017-10-27 19:48:11,115 [salt.utils.extmods][INFO    ][24837] Loading cache from salt://_states, for base)
2017-10-27 19:48:11,115 [salt.fileclient  ][INFO    ][24837] Caching directory '_states/' for environment 'base'
2017-10-27 19:48:11,157 [salt.fileclient  ][INFO    ][24837] Fetching file from saltenv 'base', ** done ** '_states/cinderng.py'
2017-10-27 19:48:11,169 [salt.fileclient  ][INFO    ][24837] Fetching file from saltenv 'base', ** done ** '_states/contrail.py'
2017-10-27 19:48:11,179 [salt.fileclient  ][INFO    ][24837] Fetching file from saltenv 'base', ** done ** '_states/gerrit.py'
2017-10-27 19:48:11,192 [salt.fileclient  ][INFO    ][24837] Fetching file from saltenv 'base', ** done ** '_states/glanceng.py'
2017-10-27 19:48:11,206 [salt.fileclient  ][INFO    ][24837] Fetching file from saltenv 'base', ** done ** '_states/grafana3_dashboard.py'
2017-10-27 19:48:11,216 [salt.fileclient  ][INFO    ][24837] Fetching file from saltenv 'base', ** done ** '_states/grafana3_datasource.py'
2017-10-27 19:48:11,226 [salt.fileclient  ][INFO    ][24837] Fetching file from saltenv 'base', ** done ** '_states/heat.py'
2017-10-27 19:48:11,234 [salt.fileclient  ][INFO    ][24837] Fetching file from saltenv 'base', ** done ** '_states/helm_release.py'
2017-10-27 19:48:11,246 [salt.fileclient  ][INFO    ][24837] Fetching file from saltenv 'base', ** done ** '_states/jenkins_approval.py'
2017-10-27 19:48:11,254 [salt.fileclient  ][INFO    ][24837] Fetching file from saltenv 'base', ** done ** '_states/jenkins_artifactory.py'
2017-10-27 19:48:11,265 [salt.fileclient  ][INFO    ][24837] Fetching file from saltenv 'base', ** done ** '_states/jenkins_credential.py'
2017-10-27 19:48:11,286 [salt.fileclient  ][INFO    ][24837] Fetching file from saltenv 'base', ** done ** '_states/jenkins_job.py'
2017-10-27 19:48:11,295 [salt.fileclient  ][INFO    ][24837] Fetching file from saltenv 'base', ** done ** '_states/jenkins_lib.py'
2017-10-27 19:48:11,304 [salt.fileclient  ][INFO    ][24837] Fetching file from saltenv 'base', ** done ** '_states/jenkins_node.py'
2017-10-27 19:48:11,825 [salt.fileclient  ][INFO    ][24837] Fetching file from saltenv 'base', ** done ** '_states/jenkins_plugin.py'
2017-10-27 19:48:11,838 [salt.fileclient  ][INFO    ][24837] Fetching file from saltenv 'base', ** done ** '_states/jenkins_security.py'
2017-10-27 19:48:11,851 [salt.fileclient  ][INFO    ][24837] Fetching file from saltenv 'base', ** done ** '_states/jenkins_slack.py'
2017-10-27 19:48:11,867 [salt.fileclient  ][INFO    ][24837] Fetching file from saltenv 'base', ** done ** '_states/jenkins_smtp.py'
2017-10-27 19:48:11,878 [salt.fileclient  ][INFO    ][24837] Fetching file from saltenv 'base', ** done ** '_states/jenkins_theme.py'
2017-10-27 19:48:11,889 [salt.fileclient  ][INFO    ][24837] Fetching file from saltenv 'base', ** done ** '_states/jenkins_user.py'
2017-10-27 19:48:11,902 [salt.fileclient  ][INFO    ][24837] Fetching file from saltenv 'base', ** done ** '_states/jenkins_view.py'
2017-10-27 19:48:11,913 [salt.fileclient  ][INFO    ][24837] Fetching file from saltenv 'base', ** done ** '_states/keystone_policy.py'
2017-10-27 19:48:11,924 [salt.fileclient  ][INFO    ][24837] Fetching file from saltenv 'base', ** done ** '_states/kibana_object.py'
2017-10-27 19:48:11,945 [salt.fileclient  ][INFO    ][24837] Fetching file from saltenv 'base', ** done ** '_states/neutronng.py'
2017-10-27 19:48:11,958 [salt.fileclient  ][INFO    ][24837] Fetching file from saltenv 'base', ** done ** '_states/novang.py'
2017-10-27 19:48:11,971 [salt.fileclient  ][INFO    ][24837] Fetching file from saltenv 'base', ** done ** '_states/reclass.py'
2017-10-27 19:48:11,982 [salt.fileclient  ][INFO    ][24837] Fetching file from saltenv 'base', ** done ** '_states/rundeck_project.py'
2017-10-27 19:48:11,994 [salt.fileclient  ][INFO    ][24837] Fetching file from saltenv 'base', ** done ** '_states/rundeck_scm.py'
2017-10-27 19:48:12,004 [salt.fileclient  ][INFO    ][24837] Fetching file from saltenv 'base', ** done ** '_states/rundeck_secret.py'
2017-10-27 19:48:12,008 [salt.utils.extmods][INFO    ][24837] Copying '/var/cache/salt/minion/files/base/_states/cinderng.py' to '/var/cache/salt/minion/extmods/states/cinderng.py'
2017-10-27 19:48:12,008 [salt.utils.extmods][INFO    ][24837] Copying '/var/cache/salt/minion/files/base/_states/contrail.py' to '/var/cache/salt/minion/extmods/states/contrail.py'
2017-10-27 19:48:12,009 [salt.utils.extmods][INFO    ][24837] Copying '/var/cache/salt/minion/files/base/_states/gerrit.py' to '/var/cache/salt/minion/extmods/states/gerrit.py'
2017-10-27 19:48:12,009 [salt.utils.extmods][INFO    ][24837] Copying '/var/cache/salt/minion/files/base/_states/glanceng.py' to '/var/cache/salt/minion/extmods/states/glanceng.py'
2017-10-27 19:48:12,009 [salt.utils.extmods][INFO    ][24837] Copying '/var/cache/salt/minion/files/base/_states/grafana3_dashboard.py' to '/var/cache/salt/minion/extmods/states/grafana3_dashboard.py'
2017-10-27 19:48:12,009 [salt.utils.extmods][INFO    ][24837] Copying '/var/cache/salt/minion/files/base/_states/grafana3_datasource.py' to '/var/cache/salt/minion/extmods/states/grafana3_datasource.py'
2017-10-27 19:48:12,010 [salt.utils.extmods][INFO    ][24837] Copying '/var/cache/salt/minion/files/base/_states/heat.py' to '/var/cache/salt/minion/extmods/states/heat.py'
2017-10-27 19:48:12,010 [salt.utils.extmods][INFO    ][24837] Copying '/var/cache/salt/minion/files/base/_states/helm_release.py' to '/var/cache/salt/minion/extmods/states/helm_release.py'
2017-10-27 19:48:12,010 [salt.utils.extmods][INFO    ][24837] Copying '/var/cache/salt/minion/files/base/_states/jenkins_approval.py' to '/var/cache/salt/minion/extmods/states/jenkins_approval.py'
2017-10-27 19:48:12,010 [salt.utils.extmods][INFO    ][24837] Copying '/var/cache/salt/minion/files/base/_states/jenkins_artifactory.py' to '/var/cache/salt/minion/extmods/states/jenkins_artifactory.py'
2017-10-27 19:48:12,011 [salt.utils.extmods][INFO    ][24837] Copying '/var/cache/salt/minion/files/base/_states/jenkins_credential.py' to '/var/cache/salt/minion/extmods/states/jenkins_credential.py'
2017-10-27 19:48:12,011 [salt.utils.extmods][INFO    ][24837] Copying '/var/cache/salt/minion/files/base/_states/jenkins_job.py' to '/var/cache/salt/minion/extmods/states/jenkins_job.py'
2017-10-27 19:48:12,011 [salt.utils.extmods][INFO    ][24837] Copying '/var/cache/salt/minion/files/base/_states/jenkins_lib.py' to '/var/cache/salt/minion/extmods/states/jenkins_lib.py'
2017-10-27 19:48:12,011 [salt.utils.extmods][INFO    ][24837] Copying '/var/cache/salt/minion/files/base/_states/jenkins_node.py' to '/var/cache/salt/minion/extmods/states/jenkins_node.py'
2017-10-27 19:48:12,012 [salt.utils.extmods][INFO    ][24837] Copying '/var/cache/salt/minion/files/base/_states/jenkins_plugin.py' to '/var/cache/salt/minion/extmods/states/jenkins_plugin.py'
2017-10-27 19:48:12,012 [salt.utils.extmods][INFO    ][24837] Copying '/var/cache/salt/minion/files/base/_states/jenkins_security.py' to '/var/cache/salt/minion/extmods/states/jenkins_security.py'
2017-10-27 19:48:12,012 [salt.utils.extmods][INFO    ][24837] Copying '/var/cache/salt/minion/files/base/_states/jenkins_slack.py' to '/var/cache/salt/minion/extmods/states/jenkins_slack.py'
2017-10-27 19:48:12,012 [salt.utils.extmods][INFO    ][24837] Copying '/var/cache/salt/minion/files/base/_states/jenkins_smtp.py' to '/var/cache/salt/minion/extmods/states/jenkins_smtp.py'
2017-10-27 19:48:12,013 [salt.utils.extmods][INFO    ][24837] Copying '/var/cache/salt/minion/files/base/_states/jenkins_theme.py' to '/var/cache/salt/minion/extmods/states/jenkins_theme.py'
2017-10-27 19:48:12,013 [salt.utils.extmods][INFO    ][24837] Copying '/var/cache/salt/minion/files/base/_states/jenkins_user.py' to '/var/cache/salt/minion/extmods/states/jenkins_user.py'
2017-10-27 19:48:12,013 [salt.utils.extmods][INFO    ][24837] Copying '/var/cache/salt/minion/files/base/_states/jenkins_view.py' to '/var/cache/salt/minion/extmods/states/jenkins_view.py'
2017-10-27 19:48:12,013 [salt.utils.extmods][INFO    ][24837] Copying '/var/cache/salt/minion/files/base/_states/keystone_policy.py' to '/var/cache/salt/minion/extmods/states/keystone_policy.py'
2017-10-27 19:48:12,013 [salt.utils.extmods][INFO    ][24837] Copying '/var/cache/salt/minion/files/base/_states/kibana_object.py' to '/var/cache/salt/minion/extmods/states/kibana_object.py'
2017-10-27 19:48:12,014 [salt.utils.extmods][INFO    ][24837] Copying '/var/cache/salt/minion/files/base/_states/maas_cluster.py' to '/var/cache/salt/minion/extmods/states/maas_cluster.py'
2017-10-27 19:48:12,014 [salt.utils.extmods][INFO    ][24837] Copying '/var/cache/salt/minion/files/base/_states/neutronng.py' to '/var/cache/salt/minion/extmods/states/neutronng.py'
2017-10-27 19:48:12,014 [salt.utils.extmods][INFO    ][24837] Copying '/var/cache/salt/minion/files/base/_states/novang.py' to '/var/cache/salt/minion/extmods/states/novang.py'
2017-10-27 19:48:12,015 [salt.utils.extmods][INFO    ][24837] Copying '/var/cache/salt/minion/files/base/_states/reclass.py' to '/var/cache/salt/minion/extmods/states/reclass.py'
2017-10-27 19:48:12,015 [salt.utils.extmods][INFO    ][24837] Copying '/var/cache/salt/minion/files/base/_states/rundeck_project.py' to '/var/cache/salt/minion/extmods/states/rundeck_project.py'
2017-10-27 19:48:12,015 [salt.utils.extmods][INFO    ][24837] Copying '/var/cache/salt/minion/files/base/_states/rundeck_scm.py' to '/var/cache/salt/minion/extmods/states/rundeck_scm.py'
2017-10-27 19:48:12,015 [salt.utils.extmods][INFO    ][24837] Copying '/var/cache/salt/minion/files/base/_states/rundeck_secret.py' to '/var/cache/salt/minion/extmods/states/rundeck_secret.py'
2017-10-27 19:48:12,018 [salt.utils.extmods][INFO    ][24837] Creating module dir '/var/cache/salt/minion/extmods/sdb'
2017-10-27 19:48:12,021 [salt.utils.extmods][INFO    ][24837] Syncing sdb for environment 'base'
2017-10-27 19:48:12,021 [salt.utils.extmods][INFO    ][24837] Loading cache from salt://_sdb, for base)
2017-10-27 19:48:12,021 [salt.fileclient  ][INFO    ][24837] Caching directory '_sdb/' for environment 'base'
2017-10-27 19:48:12,061 [salt.utils.extmods][INFO    ][24837] Syncing grains for environment 'base'
2017-10-27 19:48:12,061 [salt.utils.extmods][INFO    ][24837] Loading cache from salt://_grains, for base)
2017-10-27 19:48:12,061 [salt.fileclient  ][INFO    ][24837] Caching directory '_grains/' for environment 'base'
2017-10-27 19:48:12,101 [salt.fileclient  ][INFO    ][24837] Fetching file from saltenv 'base', ** done ** '_grains/ceilometer_policy.py'
2017-10-27 19:48:12,111 [salt.fileclient  ][INFO    ][24837] Fetching file from saltenv 'base', ** done ** '_grains/ceph.py'
2017-10-27 19:48:12,121 [salt.fileclient  ][INFO    ][24837] Fetching file from saltenv 'base', ** done ** '_grains/cinder_policy.py'
2017-10-27 19:48:12,133 [salt.fileclient  ][INFO    ][24837] Fetching file from saltenv 'base', ** done ** '_grains/docker_swarm.py'
2017-10-27 19:48:12,151 [salt.fileclient  ][INFO    ][24837] Fetching file from saltenv 'base', ** done ** '_grains/glance_policy.py'
2017-10-27 19:48:12,165 [salt.fileclient  ][INFO    ][24837] Fetching file from saltenv 'base', ** done ** '_grains/heat_policy.py'
2017-10-27 19:48:12,177 [salt.fileclient  ][INFO    ][24837] Fetching file from saltenv 'base', ** done ** '_grains/jenkins_plugins.py'
2017-10-27 19:48:12,188 [salt.fileclient  ][INFO    ][24837] Fetching file from saltenv 'base', ** done ** '_grains/keystone_policy.py'
2017-10-27 19:48:12,198 [salt.fileclient  ][INFO    ][24837] Fetching file from saltenv 'base', ** done ** '_grains/kubernetes.py'
2017-10-27 19:48:12,210 [salt.fileclient  ][INFO    ][24837] Fetching file from saltenv 'base', ** done ** '_grains/neutron_policy.py'
2017-10-27 19:48:12,222 [salt.fileclient  ][INFO    ][24837] Fetching file from saltenv 'base', ** done ** '_grains/nova_policy.py'
2017-10-27 19:48:12,233 [salt.fileclient  ][INFO    ][24837] Fetching file from saltenv 'base', ** done ** '_grains/ssh_fingerprints.py'
2017-10-27 19:48:12,237 [salt.utils.extmods][INFO    ][24837] Copying '/var/cache/salt/minion/files/base/_grains/ceilometer_policy.py' to '/var/cache/salt/minion/extmods/grains/ceilometer_policy.py'
2017-10-27 19:48:12,237 [salt.utils.extmods][INFO    ][24837] Copying '/var/cache/salt/minion/files/base/_grains/ceph.py' to '/var/cache/salt/minion/extmods/grains/ceph.py'
2017-10-27 19:48:12,237 [salt.utils.extmods][INFO    ][24837] Copying '/var/cache/salt/minion/files/base/_grains/cinder_policy.py' to '/var/cache/salt/minion/extmods/grains/cinder_policy.py'
2017-10-27 19:48:12,237 [salt.utils.extmods][INFO    ][24837] Copying '/var/cache/salt/minion/files/base/_grains/docker_swarm.py' to '/var/cache/salt/minion/extmods/grains/docker_swarm.py'
2017-10-27 19:48:12,238 [salt.utils.extmods][INFO    ][24837] Copying '/var/cache/salt/minion/files/base/_grains/glance_policy.py' to '/var/cache/salt/minion/extmods/grains/glance_policy.py'
2017-10-27 19:48:12,238 [salt.utils.extmods][INFO    ][24837] Copying '/var/cache/salt/minion/files/base/_grains/heat_policy.py' to '/var/cache/salt/minion/extmods/grains/heat_policy.py'
2017-10-27 19:48:12,238 [salt.utils.extmods][INFO    ][24837] Copying '/var/cache/salt/minion/files/base/_grains/jenkins_plugins.py' to '/var/cache/salt/minion/extmods/grains/jenkins_plugins.py'
2017-10-27 19:48:12,238 [salt.utils.extmods][INFO    ][24837] Copying '/var/cache/salt/minion/files/base/_grains/keystone_policy.py' to '/var/cache/salt/minion/extmods/grains/keystone_policy.py'
2017-10-27 19:48:12,238 [salt.utils.extmods][INFO    ][24837] Copying '/var/cache/salt/minion/files/base/_grains/kubernetes.py' to '/var/cache/salt/minion/extmods/grains/kubernetes.py'
2017-10-27 19:48:12,239 [salt.utils.extmods][INFO    ][24837] Copying '/var/cache/salt/minion/files/base/_grains/neutron_policy.py' to '/var/cache/salt/minion/extmods/grains/neutron_policy.py'
2017-10-27 19:48:12,239 [salt.utils.extmods][INFO    ][24837] Copying '/var/cache/salt/minion/files/base/_grains/nova_policy.py' to '/var/cache/salt/minion/extmods/grains/nova_policy.py'
2017-10-27 19:48:12,239 [salt.utils.extmods][INFO    ][24837] Copying '/var/cache/salt/minion/files/base/_grains/ssh_fingerprints.py' to '/var/cache/salt/minion/extmods/grains/ssh_fingerprints.py'
2017-10-27 19:48:12,240 [salt.utils.extmods][INFO    ][24837] Creating module dir '/var/cache/salt/minion/extmods/renderers'
2017-10-27 19:48:12,244 [salt.utils.extmods][INFO    ][24837] Syncing renderers for environment 'base'
2017-10-27 19:48:12,244 [salt.utils.extmods][INFO    ][24837] Loading cache from salt://_renderers, for base)
2017-10-27 19:48:12,244 [salt.fileclient  ][INFO    ][24837] Caching directory '_renderers/' for environment 'base'
2017-10-27 19:48:12,279 [salt.utils.extmods][INFO    ][24837] Creating module dir '/var/cache/salt/minion/extmods/returners'
2017-10-27 19:48:12,282 [salt.utils.extmods][INFO    ][24837] Syncing returners for environment 'base'
2017-10-27 19:48:12,282 [salt.utils.extmods][INFO    ][24837] Loading cache from salt://_returners, for base)
2017-10-27 19:48:12,282 [salt.fileclient  ][INFO    ][24837] Caching directory '_returners/' for environment 'base'
2017-10-27 19:48:12,310 [salt.utils.extmods][INFO    ][24837] Creating module dir '/var/cache/salt/minion/extmods/output'
2017-10-27 19:48:12,313 [salt.utils.extmods][INFO    ][24837] Syncing output for environment 'base'
2017-10-27 19:48:12,313 [salt.utils.extmods][INFO    ][24837] Loading cache from salt://_output, for base)
2017-10-27 19:48:12,313 [salt.fileclient  ][INFO    ][24837] Caching directory '_output/' for environment 'base'
2017-10-27 19:48:12,342 [salt.utils.extmods][INFO    ][24837] Creating module dir '/var/cache/salt/minion/extmods/utils'
2017-10-27 19:48:12,344 [salt.utils.extmods][INFO    ][24837] Syncing utils for environment 'base'
2017-10-27 19:48:12,345 [salt.utils.extmods][INFO    ][24837] Loading cache from salt://_utils, for base)
2017-10-27 19:48:12,345 [salt.fileclient  ][INFO    ][24837] Caching directory '_utils/' for environment 'base'
2017-10-27 19:48:12,384 [salt.utils.extmods][INFO    ][24837] Creating module dir '/var/cache/salt/minion/extmods/log_handlers'
2017-10-27 19:48:12,387 [salt.utils.extmods][INFO    ][24837] Syncing log_handlers for environment 'base'
2017-10-27 19:48:12,387 [salt.utils.extmods][INFO    ][24837] Loading cache from salt://_log_handlers, for base)
2017-10-27 19:48:12,388 [salt.fileclient  ][INFO    ][24837] Caching directory '_log_handlers/' for environment 'base'
2017-10-27 19:48:12,422 [salt.utils.extmods][INFO    ][24837] Creating module dir '/var/cache/salt/minion/extmods/proxy'
2017-10-27 19:48:12,425 [salt.utils.extmods][INFO    ][24837] Syncing proxy for environment 'base'
2017-10-27 19:48:12,425 [salt.utils.extmods][INFO    ][24837] Loading cache from salt://_proxy, for base)
2017-10-27 19:48:12,425 [salt.fileclient  ][INFO    ][24837] Caching directory '_proxy/' for environment 'base'
2017-10-27 19:48:12,455 [salt.utils.extmods][INFO    ][24837] Creating module dir '/var/cache/salt/minion/extmods/engines'
2017-10-27 19:48:12,458 [salt.utils.extmods][INFO    ][24837] Syncing engines for environment 'base'
2017-10-27 19:48:12,459 [salt.utils.extmods][INFO    ][24837] Loading cache from salt://_engines, for base)
2017-10-27 19:48:12,459 [salt.fileclient  ][INFO    ][24837] Caching directory '_engines/' for environment 'base'
2017-10-27 19:48:12,492 [salt.minion      ][INFO    ][24837] Returning information for job: 20171027194808181861
2017-10-27 19:48:13,541 [salt.minion      ][INFO    ][24712] User sudo_ubuntu Executing command state.sls with jid 20171027194813533269
2017-10-27 19:48:13,551 [salt.minion      ][INFO    ][24915] Starting a new job with PID 24915
2017-10-27 19:48:14,149 [salt.state       ][INFO    ][24915] Loading fresh modules for state activity
2017-10-27 19:48:14,174 [salt.fileclient  ][INFO    ][24915] Fetching file from saltenv 'base', ** done ** 'salt/control/init.sls'
2017-10-27 19:48:14,194 [salt.fileclient  ][INFO    ][24915] Fetching file from saltenv 'base', ** done ** 'salt/control/virt.sls'
2017-10-27 19:48:14,222 [salt.fileclient  ][INFO    ][24915] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-10-27 19:48:14,337 [salt.fileclient  ][INFO    ][24915] Fetching file from saltenv 'base', ** done ** 'salt/minion/init.sls'
2017-10-27 19:48:14,351 [salt.fileclient  ][INFO    ][24915] Fetching file from saltenv 'base', ** done ** 'salt/minion/service.sls'
2017-10-27 19:48:14,383 [salt.fileclient  ][INFO    ][24915] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-10-27 19:48:14,445 [salt.fileclient  ][INFO    ][24915] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-10-27 19:48:14,467 [salt.fileclient  ][INFO    ][24915] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-10-27 19:48:14,523 [salt.fileclient  ][INFO    ][24915] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-10-27 19:48:14,545 [salt.fileclient  ][INFO    ][24915] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-10-27 19:48:14,561 [salt.fileclient  ][INFO    ][24915] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-10-27 19:48:14,579 [salt.fileclient  ][INFO    ][24915] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-10-27 19:48:14,588 [salt.loaded.int.module.cmdmod][INFO    ][24915] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-10-27 19:48:14,608 [salt.fileclient  ][INFO    ][24915] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-10-27 19:48:14,626 [py.warnings      ][WARNING ][24915] /usr/lib/python2.7/dist-packages/salt/utils/templates.py:73: DeprecationWarning: Starting in 2015.5, cmd.run uses python_shell=False by default, which doesn't support shellisms (pipes, env variables, etc). cmd.run is currently aliased to cmd.shell to prevent breakage. Please switch to cmd.shell or set python_shell=True to avoid breakage in the future, when this aliasing is removed.

2017-10-27 19:48:14,627 [salt.loaded.int.module.cmdmod][INFO    ][24915] Executing command 'salt-minion --version' in directory '/root'
2017-10-27 19:48:14,885 [salt.fileclient  ][INFO    ][24915] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-10-27 19:48:14,907 [salt.fileclient  ][INFO    ][24915] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-10-27 19:48:14,921 [salt.fileclient  ][INFO    ][24915] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-10-27 19:48:14,934 [salt.fileclient  ][INFO    ][24915] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-10-27 19:48:14,984 [salt.fileclient  ][INFO    ][24915] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-10-27 19:48:15,026 [salt.fileclient  ][INFO    ][24915] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-10-27 19:48:15,095 [salt.fileclient  ][INFO    ][24915] Fetching file from saltenv 'base', ** done ** 'salt/minion/grains.sls'
2017-10-27 19:48:15,122 [salt.fileclient  ][INFO    ][24915] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-10-27 19:48:15,186 [salt.fileclient  ][INFO    ][24915] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-10-27 19:48:15,207 [salt.fileclient  ][INFO    ][24915] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-10-27 19:48:15,267 [salt.fileclient  ][INFO    ][24915] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-10-27 19:48:15,290 [salt.fileclient  ][INFO    ][24915] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-10-27 19:48:15,305 [salt.fileclient  ][INFO    ][24915] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-10-27 19:48:15,323 [salt.fileclient  ][INFO    ][24915] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-10-27 19:48:15,331 [salt.loaded.int.module.cmdmod][INFO    ][24915] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-10-27 19:48:15,353 [salt.fileclient  ][INFO    ][24915] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-10-27 19:48:15,371 [salt.loaded.int.module.cmdmod][INFO    ][24915] Executing command 'salt-minion --version' in directory '/root'
2017-10-27 19:48:15,618 [salt.fileclient  ][INFO    ][24915] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-10-27 19:48:15,633 [salt.fileclient  ][INFO    ][24915] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-10-27 19:48:15,644 [salt.fileclient  ][INFO    ][24915] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-10-27 19:48:15,656 [salt.fileclient  ][INFO    ][24915] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-10-27 19:48:15,986 [salt.fileclient  ][INFO    ][24915] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-10-27 19:48:16,030 [salt.fileclient  ][INFO    ][24915] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-10-27 19:48:16,111 [salt.fileclient  ][INFO    ][24915] Fetching file from saltenv 'base', ** done ** 'salt/minion/cert.sls'
2017-10-27 19:48:16,183 [salt.fileclient  ][INFO    ][24915] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-10-27 19:48:16,555 [salt.state       ][INFO    ][24915] Running state [salt-minion] at time 19:48:16.555058
2017-10-27 19:48:16,555 [salt.state       ][INFO    ][24915] Executing state pkg.installed for salt-minion
2017-10-27 19:48:16,556 [salt.loaded.int.module.cmdmod][INFO    ][24915] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-10-27 19:48:16,803 [salt.state       ][INFO    ][24915] Package salt-minion is already installed
2017-10-27 19:48:16,803 [salt.state       ][INFO    ][24915] Completed state [salt-minion] at time 19:48:16.802898 duration_in_ms=247.827
2017-10-27 19:48:16,803 [salt.state       ][INFO    ][24915] Running state [salt_minion_dependency_packages] at time 19:48:16.803202
2017-10-27 19:48:16,803 [salt.state       ][INFO    ][24915] Executing state pkg.installed for salt_minion_dependency_packages
2017-10-27 19:48:16,807 [salt.state       ][INFO    ][24915] All specified packages are already installed
2017-10-27 19:48:16,807 [salt.state       ][INFO    ][24915] Completed state [salt_minion_dependency_packages] at time 19:48:16.807307 duration_in_ms=4.104
2017-10-27 19:48:16,809 [salt.state       ][INFO    ][24915] Running state [/etc/salt/minion.d/minion.conf] at time 19:48:16.808957
2017-10-27 19:48:16,809 [salt.state       ][INFO    ][24915] Executing state file.managed for /etc/salt/minion.d/minion.conf
2017-10-27 19:48:16,834 [salt.fileclient  ][INFO    ][24915] Fetching file from saltenv 'base', ** done ** 'salt/files/minion.conf'
2017-10-27 19:48:16,895 [salt.fileclient  ][INFO    ][24915] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-10-27 19:48:16,950 [salt.fileclient  ][INFO    ][24915] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-10-27 19:48:16,996 [salt.state       ][INFO    ][24915] File /etc/salt/minion.d/minion.conf is in the correct state
2017-10-27 19:48:16,996 [salt.state       ][INFO    ][24915] Completed state [/etc/salt/minion.d/minion.conf] at time 19:48:16.996365 duration_in_ms=187.407
2017-10-27 19:48:16,997 [salt.state       ][INFO    ][24915] Running state [/etc/salt/minion.d/_virt.conf] at time 19:48:16.996744
2017-10-27 19:48:16,997 [salt.state       ][INFO    ][24915] Executing state file.managed for /etc/salt/minion.d/_virt.conf
2017-10-27 19:48:16,998 [salt.state       ][INFO    ][24915] File /etc/salt/minion.d/_virt.conf is in the correct state
2017-10-27 19:48:16,998 [salt.state       ][INFO    ][24915] Completed state [/etc/salt/minion.d/_virt.conf] at time 19:48:16.997764 duration_in_ms=1.019
2017-10-27 19:48:16,999 [salt.state       ][INFO    ][24915] Running state [salt-minion] at time 19:48:16.999451
2017-10-27 19:48:16,1000 [salt.state       ][INFO    ][24915] Executing state service.running for salt-minion
2017-10-27 19:48:17,000 [salt.loaded.int.module.cmdmod][INFO    ][24915] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2017-10-27 19:48:17,012 [salt.loaded.int.module.cmdmod][INFO    ][24915] Executing command ['systemctl', 'is-active', 'salt-minion.service'] in directory '/root'
2017-10-27 19:48:17,019 [salt.loaded.int.module.cmdmod][INFO    ][24915] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2017-10-27 19:48:17,026 [salt.state       ][INFO    ][24915] The service salt-minion is already running
2017-10-27 19:48:17,026 [salt.state       ][INFO    ][24915] Completed state [salt-minion] at time 19:48:17.026080 duration_in_ms=26.629
2017-10-27 19:48:17,028 [salt.state       ][INFO    ][24915] Running state [/etc/salt/grains.d] at time 19:48:17.027812
2017-10-27 19:48:17,028 [salt.state       ][INFO    ][24915] Executing state file.directory for /etc/salt/grains.d
2017-10-27 19:48:17,029 [salt.state       ][INFO    ][24915] Directory /etc/salt/grains.d is in the correct state
2017-10-27 19:48:17,029 [salt.state       ][INFO    ][24915] Completed state [/etc/salt/grains.d] at time 19:48:17.028821 duration_in_ms=1.009
2017-10-27 19:48:17,029 [salt.state       ][INFO    ][24915] Running state [/etc/salt/grains] at time 19:48:17.029380
2017-10-27 19:48:17,030 [salt.state       ][INFO    ][24915] Executing state file.managed for /etc/salt/grains
2017-10-27 19:48:17,030 [salt.state       ][INFO    ][24915] File /etc/salt/grains exists with proper permissions. No changes made.
2017-10-27 19:48:17,030 [salt.state       ][INFO    ][24915] Completed state [/etc/salt/grains] at time 19:48:17.030152 duration_in_ms=0.772
2017-10-27 19:48:17,031 [salt.state       ][INFO    ][24915] Running state [/etc/salt/grains.d/placeholder] at time 19:48:17.030521
2017-10-27 19:48:17,031 [salt.state       ][INFO    ][24915] Executing state file.managed for /etc/salt/grains.d/placeholder
2017-10-27 19:48:17,031 [salt.state       ][INFO    ][24915] File /etc/salt/grains.d/placeholder exists with proper permissions. No changes made.
2017-10-27 19:48:17,031 [salt.state       ][INFO    ][24915] Completed state [/etc/salt/grains.d/placeholder] at time 19:48:17.031270 duration_in_ms=0.749
2017-10-27 19:48:17,032 [salt.state       ][INFO    ][24915] Running state [/etc/salt/grains.d/sphinx] at time 19:48:17.031664
2017-10-27 19:48:17,032 [salt.state       ][INFO    ][24915] Executing state file.managed for /etc/salt/grains.d/sphinx
2017-10-27 19:48:17,033 [salt.state       ][INFO    ][24915] File changed:
--- 
+++ 
@@ -49,7 +49,6 @@
               - 127.0.0.1
               - 192.168.10.141
               - 192.168.11.2
-              - 192.168.122.1
         system:
           name: System
           param:

2017-10-27 19:48:17,033 [salt.state       ][INFO    ][24915] Completed state [/etc/salt/grains.d/sphinx] at time 19:48:17.033446 duration_in_ms=1.782
2017-10-27 19:48:17,034 [salt.state       ][INFO    ][24915] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 19:48:17.034175
2017-10-27 19:48:17,034 [salt.state       ][INFO    ][24915] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-10-27 19:48:17,035 [salt.state       ][INFO    ][24915] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-10-27 19:48:17,035 [salt.state       ][INFO    ][24915] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 19:48:17.034709 duration_in_ms=0.535
2017-10-27 19:48:17,035 [salt.state       ][INFO    ][24915] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 19:48:17.034862
2017-10-27 19:48:17,035 [salt.state       ][INFO    ][24915] Executing state cmd.mod_watch for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-10-27 19:48:17,036 [salt.loaded.int.module.cmdmod][INFO    ][24915] Executing command 'python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"' in directory '/root'
2017-10-27 19:48:17,111 [salt.state       ][INFO    ][24915] {'pid': 25006, 'retcode': 0, 'stderr': '', 'stdout': ''}
2017-10-27 19:48:17,112 [salt.state       ][INFO    ][24915] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 19:48:17.111720 duration_in_ms=76.858
2017-10-27 19:48:17,112 [salt.state       ][INFO    ][24915] Running state [/etc/salt/grains.d/dns_records] at time 19:48:17.112252
2017-10-27 19:48:17,113 [salt.state       ][INFO    ][24915] Executing state file.managed for /etc/salt/grains.d/dns_records
2017-10-27 19:48:17,113 [salt.state       ][INFO    ][24915] File /etc/salt/grains.d/dns_records is in the correct state
2017-10-27 19:48:17,114 [salt.state       ][INFO    ][24915] Completed state [/etc/salt/grains.d/dns_records] at time 19:48:17.113552 duration_in_ms=1.3
2017-10-27 19:48:17,114 [salt.state       ][INFO    ][24915] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 19:48:17.114323
2017-10-27 19:48:17,115 [salt.state       ][INFO    ][24915] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"
2017-10-27 19:48:17,115 [salt.state       ][INFO    ][24915] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"
2017-10-27 19:48:17,115 [salt.state       ][INFO    ][24915] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 19:48:17.114909 duration_in_ms=0.585
2017-10-27 19:48:17,115 [salt.state       ][INFO    ][24915] Running state [/etc/salt/grains.d/salt] at time 19:48:17.115284
2017-10-27 19:48:17,116 [salt.state       ][INFO    ][24915] Executing state file.managed for /etc/salt/grains.d/salt
2017-10-27 19:48:17,116 [salt.state       ][INFO    ][24915] File /etc/salt/grains.d/salt is in the correct state
2017-10-27 19:48:17,116 [salt.state       ][INFO    ][24915] Completed state [/etc/salt/grains.d/salt] at time 19:48:17.116301 duration_in_ms=1.017
2017-10-27 19:48:17,117 [salt.state       ][INFO    ][24915] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 19:48:17.117001
2017-10-27 19:48:17,117 [salt.state       ][INFO    ][24915] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2017-10-27 19:48:17,117 [salt.state       ][INFO    ][24915] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2017-10-27 19:48:17,118 [salt.state       ][INFO    ][24915] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 19:48:17.117551 duration_in_ms=0.55
2017-10-27 19:48:17,119 [salt.state       ][INFO    ][24915] Running state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 19:48:17.119108
2017-10-27 19:48:17,119 [salt.state       ][INFO    ][24915] Executing state cmd.wait for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-10-27 19:48:17,120 [salt.state       ][INFO    ][24915] No changes made for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-10-27 19:48:17,120 [salt.state       ][INFO    ][24915] Completed state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 19:48:17.119673 duration_in_ms=0.565
2017-10-27 19:48:17,120 [salt.state       ][INFO    ][24915] Running state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 19:48:17.119821
2017-10-27 19:48:17,120 [salt.state       ][INFO    ][24915] Executing state cmd.mod_watch for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-10-27 19:48:17,122 [salt.loaded.int.module.cmdmod][INFO    ][24915] Executing command 'cat /etc/salt/grains.d/* > /etc/salt/grains' in directory '/root'
2017-10-27 19:48:17,128 [salt.state       ][INFO    ][24915] {'pid': 25008, 'retcode': 0, 'stderr': '', 'stdout': ''}
2017-10-27 19:48:17,128 [salt.state       ][INFO    ][24915] Completed state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 19:48:17.127901 duration_in_ms=8.08
2017-10-27 19:48:17,129 [salt.state       ][INFO    ][24915] Running state [mine.update] at time 19:48:17.128569
2017-10-27 19:48:17,129 [salt.state       ][INFO    ][24915] Executing state module.wait for mine.update
2017-10-27 19:48:17,129 [salt.state       ][INFO    ][24915] No changes made for mine.update
2017-10-27 19:48:17,129 [salt.state       ][INFO    ][24915] Completed state [mine.update] at time 19:48:17.129129 duration_in_ms=0.559
2017-10-27 19:48:17,129 [salt.state       ][INFO    ][24915] Running state [mine.update] at time 19:48:17.129278
2017-10-27 19:48:17,129 [salt.state       ][INFO    ][24915] Executing state module.mod_watch for mine.update
2017-10-27 19:48:17,646 [salt.state       ][INFO    ][24915] {'ret': True}
2017-10-27 19:48:17,646 [salt.state       ][INFO    ][24915] Completed state [mine.update] at time 19:48:17.645907 duration_in_ms=516.629
2017-10-27 19:48:17,646 [salt.state       ][INFO    ][24915] Running state [ca-certificates] at time 19:48:17.646154
2017-10-27 19:48:17,646 [salt.state       ][INFO    ][24915] Executing state pkg.installed for ca-certificates
2017-10-27 19:48:17,650 [salt.state       ][INFO    ][24915] Package ca-certificates is already installed
2017-10-27 19:48:17,650 [salt.state       ][INFO    ][24915] Completed state [ca-certificates] at time 19:48:17.650456 duration_in_ms=4.302
2017-10-27 19:48:17,651 [salt.state       ][INFO    ][24915] Running state [update-ca-certificates] at time 19:48:17.651097
2017-10-27 19:48:17,651 [salt.state       ][INFO    ][24915] Executing state cmd.wait for update-ca-certificates
2017-10-27 19:48:17,652 [salt.state       ][INFO    ][24915] No changes made for update-ca-certificates
2017-10-27 19:48:17,652 [salt.state       ][INFO    ][24915] Completed state [update-ca-certificates] at time 19:48:17.651660 duration_in_ms=0.563
2017-10-27 19:48:17,652 [salt.state       ][INFO    ][24915] Running state [libvirt-dev] at time 19:48:17.651831
2017-10-27 19:48:17,652 [salt.state       ][INFO    ][24915] Executing state pkg.installed for libvirt-dev
2017-10-27 19:48:17,656 [salt.state       ][INFO    ][24915] Package libvirt-dev is already installed
2017-10-27 19:48:17,656 [salt.state       ][INFO    ][24915] Completed state [libvirt-dev] at time 19:48:17.655786 duration_in_ms=3.955
2017-10-27 19:48:17,656 [salt.state       ][INFO    ][24915] Running state [pkg-config] at time 19:48:17.655974
2017-10-27 19:48:17,656 [salt.state       ][INFO    ][24915] Executing state pkg.installed for pkg-config
2017-10-27 19:48:17,660 [salt.state       ][INFO    ][24915] Package pkg-config is already installed
2017-10-27 19:48:17,660 [salt.state       ][INFO    ][24915] Completed state [pkg-config] at time 19:48:17.659944 duration_in_ms=3.971
2017-10-27 19:48:17,660 [salt.state       ][INFO    ][24915] Running state [virtng.init] at time 19:48:17.660136
2017-10-27 19:48:17,660 [salt.state       ][INFO    ][24915] Executing state module.run for virtng.init
2017-10-27 19:48:17,724 [salt.loaded.int.module.cmdmod][INFO    ][24915] Executing command ['git', '--version'] in directory '/root'
2017-10-27 19:48:17,795 [salt.loaded.int.module.cmdmod][INFO    ][24915] Executing command 'virsh list --all --name| grep -E "^prx01.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-10-27 19:48:17,811 [salt.state       ][INFO    ][24915] unless execution succeeded
2017-10-27 19:48:17,811 [salt.state       ][INFO    ][24915] Completed state [virtng.init] at time 19:48:17.811257 duration_in_ms=151.12
2017-10-27 19:48:17,812 [salt.state       ][INFO    ][24915] Running state [virt.set_autostart] at time 19:48:17.811550
2017-10-27 19:48:17,812 [salt.state       ][INFO    ][24915] Executing state module.run for virt.set_autostart
2017-10-27 19:48:17,814 [salt.loaded.int.module.cmdmod][INFO    ][24915] Executing command 'virsh list --autostart --name| grep -E "^prx01.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-10-27 19:48:17,831 [salt.state       ][INFO    ][24915] unless execution succeeded
2017-10-27 19:48:17,831 [salt.state       ][INFO    ][24915] Completed state [virt.set_autostart] at time 19:48:17.830895 duration_in_ms=19.344
2017-10-27 19:48:17,831 [salt.state       ][INFO    ][24915] Running state [virtng.init] at time 19:48:17.831171
2017-10-27 19:48:17,831 [salt.state       ][INFO    ][24915] Executing state module.run for virtng.init
2017-10-27 19:48:17,834 [salt.loaded.int.module.cmdmod][INFO    ][24915] Executing command 'virsh list --all --name| grep -E "^ctl01.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-10-27 19:48:17,849 [salt.state       ][INFO    ][24915] unless execution succeeded
2017-10-27 19:48:17,849 [salt.state       ][INFO    ][24915] Completed state [virtng.init] at time 19:48:17.849340 duration_in_ms=18.168
2017-10-27 19:48:17,850 [salt.state       ][INFO    ][24915] Running state [virt.set_autostart] at time 19:48:17.849612
2017-10-27 19:48:17,850 [salt.state       ][INFO    ][24915] Executing state module.run for virt.set_autostart
2017-10-27 19:48:17,853 [salt.loaded.int.module.cmdmod][INFO    ][24915] Executing command 'virsh list --autostart --name| grep -E "^ctl01.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-10-27 19:48:17,867 [salt.state       ][INFO    ][24915] unless execution succeeded
2017-10-27 19:48:17,867 [salt.state       ][INFO    ][24915] Completed state [virt.set_autostart] at time 19:48:17.867005 duration_in_ms=17.392
2017-10-27 19:48:17,867 [salt.state       ][INFO    ][24915] Running state [virtng.init] at time 19:48:17.867282
2017-10-27 19:48:17,868 [salt.state       ][INFO    ][24915] Executing state module.run for virtng.init
2017-10-27 19:48:17,870 [salt.loaded.int.module.cmdmod][INFO    ][24915] Executing command 'virsh list --all --name| grep -E "^mdb01.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-10-27 19:48:17,883 [salt.state       ][INFO    ][24915] unless execution succeeded
2017-10-27 19:48:17,884 [salt.state       ][INFO    ][24915] Completed state [virtng.init] at time 19:48:17.883647 duration_in_ms=16.351
2017-10-27 19:48:17,884 [salt.state       ][INFO    ][24915] Running state [virt.set_autostart] at time 19:48:17.883897
2017-10-27 19:48:17,884 [salt.state       ][INFO    ][24915] Executing state module.run for virt.set_autostart
2017-10-27 19:48:17,887 [salt.loaded.int.module.cmdmod][INFO    ][24915] Executing command 'virsh list --autostart --name| grep -E "^mdb01.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-10-27 19:48:17,900 [salt.state       ][INFO    ][24915] unless execution succeeded
2017-10-27 19:48:17,900 [salt.state       ][INFO    ][24915] Completed state [virt.set_autostart] at time 19:48:17.900218 duration_in_ms=16.32
2017-10-27 19:48:17,900 [salt.state       ][INFO    ][24915] Running state [virtng.init] at time 19:48:17.900466
2017-10-27 19:48:17,901 [salt.state       ][INFO    ][24915] Executing state module.run for virtng.init
2017-10-27 19:48:17,903 [salt.loaded.int.module.cmdmod][INFO    ][24915] Executing command 'virsh list --all --name| grep -E "^msg01.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-10-27 19:48:17,917 [salt.state       ][INFO    ][24915] unless execution succeeded
2017-10-27 19:48:17,917 [salt.state       ][INFO    ][24915] Completed state [virtng.init] at time 19:48:17.916925 duration_in_ms=16.457
2017-10-27 19:48:17,917 [salt.state       ][INFO    ][24915] Running state [virt.set_autostart] at time 19:48:17.917178
2017-10-27 19:48:17,917 [salt.state       ][INFO    ][24915] Executing state module.run for virt.set_autostart
2017-10-27 19:48:17,920 [salt.loaded.int.module.cmdmod][INFO    ][24915] Executing command 'virsh list --autostart --name| grep -E "^msg01.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-10-27 19:48:17,933 [salt.state       ][INFO    ][24915] unless execution succeeded
2017-10-27 19:48:17,933 [salt.state       ][INFO    ][24915] Completed state [virt.set_autostart] at time 19:48:17.933195 duration_in_ms=16.004
2017-10-27 19:48:17,933 [salt.state       ][INFO    ][24915] Running state [virtng.init] at time 19:48:17.933422
2017-10-27 19:48:17,934 [salt.state       ][INFO    ][24915] Executing state module.run for virtng.init
2017-10-27 19:48:17,936 [salt.loaded.int.module.cmdmod][INFO    ][24915] Executing command 'virsh list --all --name| grep -E "^dbs01.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-10-27 19:48:17,951 [salt.state       ][INFO    ][24915] unless execution succeeded
2017-10-27 19:48:17,951 [salt.state       ][INFO    ][24915] Completed state [virtng.init] at time 19:48:17.950911 duration_in_ms=17.488
2017-10-27 19:48:17,951 [salt.state       ][INFO    ][24915] Running state [virt.set_autostart] at time 19:48:17.951200
2017-10-27 19:48:17,951 [salt.state       ][INFO    ][24915] Executing state module.run for virt.set_autostart
2017-10-27 19:48:17,954 [salt.loaded.int.module.cmdmod][INFO    ][24915] Executing command 'virsh list --autostart --name| grep -E "^dbs01.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-10-27 19:48:17,968 [salt.state       ][INFO    ][24915] unless execution succeeded
2017-10-27 19:48:17,968 [salt.state       ][INFO    ][24915] Completed state [virt.set_autostart] at time 19:48:17.968280 duration_in_ms=17.079
2017-10-27 19:48:17,971 [salt.minion      ][INFO    ][24915] Returning information for job: 20171027194813533269
2017-10-27 19:48:44,659 [salt.minion      ][INFO    ][24712] User sudo_ubuntu Executing command state.sls with jid 20171027194844647321
2017-10-27 19:48:44,670 [salt.minion      ][INFO    ][25072] Starting a new job with PID 25072
2017-10-27 19:48:46,867 [salt.state       ][INFO    ][25072] Loading fresh modules for state activity
2017-10-27 19:48:46,895 [salt.fileclient  ][INFO    ][25072] Fetching file from saltenv 'base', ** done ** 'salt/control/init.sls'
2017-10-27 19:48:46,913 [salt.fileclient  ][INFO    ][25072] Fetching file from saltenv 'base', ** done ** 'salt/control/virt.sls'
2017-10-27 19:48:46,970 [salt.fileclient  ][INFO    ][25072] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-10-27 19:48:47,051 [salt.fileclient  ][INFO    ][25072] Fetching file from saltenv 'base', ** done ** 'salt/minion/init.sls'
2017-10-27 19:48:47,065 [salt.fileclient  ][INFO    ][25072] Fetching file from saltenv 'base', ** done ** 'salt/minion/service.sls'
2017-10-27 19:48:47,093 [salt.fileclient  ][INFO    ][25072] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-10-27 19:48:47,155 [salt.fileclient  ][INFO    ][25072] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-10-27 19:48:47,174 [salt.fileclient  ][INFO    ][25072] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-10-27 19:48:47,227 [salt.fileclient  ][INFO    ][25072] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-10-27 19:48:47,245 [salt.fileclient  ][INFO    ][25072] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-10-27 19:48:47,257 [salt.fileclient  ][INFO    ][25072] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-10-27 19:48:47,355 [salt.fileclient  ][INFO    ][25072] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-10-27 19:48:47,364 [salt.loaded.int.module.cmdmod][INFO    ][25072] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-10-27 19:48:47,389 [salt.fileclient  ][INFO    ][25072] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-10-27 19:48:47,408 [py.warnings      ][WARNING ][25072] /usr/lib/python2.7/dist-packages/salt/utils/templates.py:73: DeprecationWarning: Starting in 2015.5, cmd.run uses python_shell=False by default, which doesn't support shellisms (pipes, env variables, etc). cmd.run is currently aliased to cmd.shell to prevent breakage. Please switch to cmd.shell or set python_shell=True to avoid breakage in the future, when this aliasing is removed.

2017-10-27 19:48:47,408 [salt.loaded.int.module.cmdmod][INFO    ][25072] Executing command 'salt-minion --version' in directory '/root'
2017-10-27 19:48:47,666 [salt.fileclient  ][INFO    ][25072] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-10-27 19:48:47,687 [salt.fileclient  ][INFO    ][25072] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-10-27 19:48:47,700 [salt.fileclient  ][INFO    ][25072] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-10-27 19:48:47,714 [salt.fileclient  ][INFO    ][25072] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-10-27 19:48:47,767 [salt.fileclient  ][INFO    ][25072] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-10-27 19:48:47,810 [salt.fileclient  ][INFO    ][25072] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-10-27 19:48:47,882 [salt.fileclient  ][INFO    ][25072] Fetching file from saltenv 'base', ** done ** 'salt/minion/grains.sls'
2017-10-27 19:48:47,907 [salt.fileclient  ][INFO    ][25072] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-10-27 19:48:47,971 [salt.fileclient  ][INFO    ][25072] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-10-27 19:48:47,993 [salt.fileclient  ][INFO    ][25072] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-10-27 19:48:48,050 [salt.fileclient  ][INFO    ][25072] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-10-27 19:48:48,070 [salt.fileclient  ][INFO    ][25072] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-10-27 19:48:48,085 [salt.fileclient  ][INFO    ][25072] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-10-27 19:48:48,103 [salt.fileclient  ][INFO    ][25072] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-10-27 19:48:48,111 [salt.loaded.int.module.cmdmod][INFO    ][25072] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-10-27 19:48:48,132 [salt.fileclient  ][INFO    ][25072] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-10-27 19:48:48,150 [salt.loaded.int.module.cmdmod][INFO    ][25072] Executing command 'salt-minion --version' in directory '/root'
2017-10-27 19:48:48,424 [salt.fileclient  ][INFO    ][25072] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-10-27 19:48:48,446 [salt.fileclient  ][INFO    ][25072] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-10-27 19:48:48,458 [salt.fileclient  ][INFO    ][25072] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-10-27 19:48:48,470 [salt.fileclient  ][INFO    ][25072] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-10-27 19:48:48,525 [salt.fileclient  ][INFO    ][25072] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-10-27 19:48:48,567 [salt.fileclient  ][INFO    ][25072] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-10-27 19:48:48,647 [salt.fileclient  ][INFO    ][25072] Fetching file from saltenv 'base', ** done ** 'salt/minion/cert.sls'
2017-10-27 19:48:48,720 [salt.fileclient  ][INFO    ][25072] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-10-27 19:48:49,050 [salt.state       ][INFO    ][25072] Running state [salt-minion] at time 19:48:49.050446
2017-10-27 19:48:49,051 [salt.state       ][INFO    ][25072] Executing state pkg.installed for salt-minion
2017-10-27 19:48:49,051 [salt.loaded.int.module.cmdmod][INFO    ][25072] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-10-27 19:48:49,300 [salt.state       ][INFO    ][25072] Package salt-minion is already installed
2017-10-27 19:48:49,300 [salt.state       ][INFO    ][25072] Completed state [salt-minion] at time 19:48:49.299809 duration_in_ms=249.364
2017-10-27 19:48:49,300 [salt.state       ][INFO    ][25072] Running state [salt_minion_dependency_packages] at time 19:48:49.300061
2017-10-27 19:48:49,300 [salt.state       ][INFO    ][25072] Executing state pkg.installed for salt_minion_dependency_packages
2017-10-27 19:48:49,304 [salt.state       ][INFO    ][25072] All specified packages are already installed
2017-10-27 19:48:49,304 [salt.state       ][INFO    ][25072] Completed state [salt_minion_dependency_packages] at time 19:48:49.304061 duration_in_ms=4.0
2017-10-27 19:48:49,306 [salt.state       ][INFO    ][25072] Running state [/etc/salt/minion.d/minion.conf] at time 19:48:49.305671
2017-10-27 19:48:49,306 [salt.state       ][INFO    ][25072] Executing state file.managed for /etc/salt/minion.d/minion.conf
2017-10-27 19:48:49,331 [salt.fileclient  ][INFO    ][25072] Fetching file from saltenv 'base', ** done ** 'salt/files/minion.conf'
2017-10-27 19:48:49,393 [salt.fileclient  ][INFO    ][25072] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-10-27 19:48:49,446 [salt.fileclient  ][INFO    ][25072] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-10-27 19:48:49,492 [salt.state       ][INFO    ][25072] File /etc/salt/minion.d/minion.conf is in the correct state
2017-10-27 19:48:49,492 [salt.state       ][INFO    ][25072] Completed state [/etc/salt/minion.d/minion.conf] at time 19:48:49.492168 duration_in_ms=186.496
2017-10-27 19:48:49,493 [salt.state       ][INFO    ][25072] Running state [/etc/salt/minion.d/_virt.conf] at time 19:48:49.492505
2017-10-27 19:48:49,493 [salt.state       ][INFO    ][25072] Executing state file.managed for /etc/salt/minion.d/_virt.conf
2017-10-27 19:48:49,493 [salt.state       ][INFO    ][25072] File /etc/salt/minion.d/_virt.conf is in the correct state
2017-10-27 19:48:49,493 [salt.state       ][INFO    ][25072] Completed state [/etc/salt/minion.d/_virt.conf] at time 19:48:49.493386 duration_in_ms=0.881
2017-10-27 19:48:49,495 [salt.state       ][INFO    ][25072] Running state [salt-minion] at time 19:48:49.494948
2017-10-27 19:48:49,495 [salt.state       ][INFO    ][25072] Executing state service.running for salt-minion
2017-10-27 19:48:49,496 [salt.loaded.int.module.cmdmod][INFO    ][25072] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2017-10-27 19:48:49,509 [salt.loaded.int.module.cmdmod][INFO    ][25072] Executing command ['systemctl', 'is-active', 'salt-minion.service'] in directory '/root'
2017-10-27 19:48:49,517 [salt.loaded.int.module.cmdmod][INFO    ][25072] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2017-10-27 19:48:49,524 [salt.state       ][INFO    ][25072] The service salt-minion is already running
2017-10-27 19:48:49,524 [salt.state       ][INFO    ][25072] Completed state [salt-minion] at time 19:48:49.523793 duration_in_ms=28.845
2017-10-27 19:48:49,525 [salt.state       ][INFO    ][25072] Running state [/etc/salt/grains.d] at time 19:48:49.525263
2017-10-27 19:48:49,525 [salt.state       ][INFO    ][25072] Executing state file.directory for /etc/salt/grains.d
2017-10-27 19:48:49,526 [salt.state       ][INFO    ][25072] Directory /etc/salt/grains.d is in the correct state
2017-10-27 19:48:49,526 [salt.state       ][INFO    ][25072] Completed state [/etc/salt/grains.d] at time 19:48:49.526234 duration_in_ms=0.97
2017-10-27 19:48:49,527 [salt.state       ][INFO    ][25072] Running state [/etc/salt/grains] at time 19:48:49.526729
2017-10-27 19:48:49,527 [salt.state       ][INFO    ][25072] Executing state file.managed for /etc/salt/grains
2017-10-27 19:48:49,527 [salt.state       ][INFO    ][25072] File /etc/salt/grains exists with proper permissions. No changes made.
2017-10-27 19:48:49,527 [salt.state       ][INFO    ][25072] Completed state [/etc/salt/grains] at time 19:48:49.527451 duration_in_ms=0.722
2017-10-27 19:48:49,528 [salt.state       ][INFO    ][25072] Running state [/etc/salt/grains.d/placeholder] at time 19:48:49.527802
2017-10-27 19:48:49,528 [salt.state       ][INFO    ][25072] Executing state file.managed for /etc/salt/grains.d/placeholder
2017-10-27 19:48:49,528 [salt.state       ][INFO    ][25072] File /etc/salt/grains.d/placeholder exists with proper permissions. No changes made.
2017-10-27 19:48:49,528 [salt.state       ][INFO    ][25072] Completed state [/etc/salt/grains.d/placeholder] at time 19:48:49.528410 duration_in_ms=0.608
2017-10-27 19:48:49,529 [salt.state       ][INFO    ][25072] Running state [/etc/salt/grains.d/sphinx] at time 19:48:49.528725
2017-10-27 19:48:49,529 [salt.state       ][INFO    ][25072] Executing state file.managed for /etc/salt/grains.d/sphinx
2017-10-27 19:48:49,530 [salt.state       ][INFO    ][25072] File /etc/salt/grains.d/sphinx is in the correct state
2017-10-27 19:48:49,530 [salt.state       ][INFO    ][25072] Completed state [/etc/salt/grains.d/sphinx] at time 19:48:49.529726 duration_in_ms=1.001
2017-10-27 19:48:49,530 [salt.state       ][INFO    ][25072] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 19:48:49.530422
2017-10-27 19:48:49,531 [salt.state       ][INFO    ][25072] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-10-27 19:48:49,531 [salt.state       ][INFO    ][25072] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-10-27 19:48:49,531 [salt.state       ][INFO    ][25072] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 19:48:49.530932 duration_in_ms=0.509
2017-10-27 19:48:49,531 [salt.state       ][INFO    ][25072] Running state [/etc/salt/grains.d/dns_records] at time 19:48:49.531303
2017-10-27 19:48:49,532 [salt.state       ][INFO    ][25072] Executing state file.managed for /etc/salt/grains.d/dns_records
2017-10-27 19:48:49,532 [salt.state       ][INFO    ][25072] File /etc/salt/grains.d/dns_records is in the correct state
2017-10-27 19:48:49,532 [salt.state       ][INFO    ][25072] Completed state [/etc/salt/grains.d/dns_records] at time 19:48:49.532166 duration_in_ms=0.864
2017-10-27 19:48:49,533 [salt.state       ][INFO    ][25072] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 19:48:49.532834
2017-10-27 19:48:49,533 [salt.state       ][INFO    ][25072] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"
2017-10-27 19:48:49,533 [salt.state       ][INFO    ][25072] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"
2017-10-27 19:48:49,533 [salt.state       ][INFO    ][25072] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 19:48:49.533332 duration_in_ms=0.498
2017-10-27 19:48:49,534 [salt.state       ][INFO    ][25072] Running state [/etc/salt/grains.d/salt] at time 19:48:49.533648
2017-10-27 19:48:49,534 [salt.state       ][INFO    ][25072] Executing state file.managed for /etc/salt/grains.d/salt
2017-10-27 19:48:49,534 [salt.state       ][INFO    ][25072] File /etc/salt/grains.d/salt is in the correct state
2017-10-27 19:48:49,535 [salt.state       ][INFO    ][25072] Completed state [/etc/salt/grains.d/salt] at time 19:48:49.534498 duration_in_ms=0.85
2017-10-27 19:48:49,535 [salt.state       ][INFO    ][25072] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 19:48:49.535175
2017-10-27 19:48:49,535 [salt.state       ][INFO    ][25072] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2017-10-27 19:48:49,536 [salt.state       ][INFO    ][25072] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2017-10-27 19:48:49,536 [salt.state       ][INFO    ][25072] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 19:48:49.535704 duration_in_ms=0.528
2017-10-27 19:48:49,537 [salt.state       ][INFO    ][25072] Running state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 19:48:49.537171
2017-10-27 19:48:49,537 [salt.state       ][INFO    ][25072] Executing state cmd.wait for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-10-27 19:48:49,538 [salt.state       ][INFO    ][25072] No changes made for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-10-27 19:48:49,538 [salt.state       ][INFO    ][25072] Completed state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 19:48:49.537675 duration_in_ms=0.505
2017-10-27 19:48:49,538 [salt.state       ][INFO    ][25072] Running state [mine.update] at time 19:48:49.538141
2017-10-27 19:48:49,538 [salt.state       ][INFO    ][25072] Executing state module.wait for mine.update
2017-10-27 19:48:49,538 [salt.state       ][INFO    ][25072] No changes made for mine.update
2017-10-27 19:48:49,539 [salt.state       ][INFO    ][25072] Completed state [mine.update] at time 19:48:49.538598 duration_in_ms=0.457
2017-10-27 19:48:49,539 [salt.state       ][INFO    ][25072] Running state [ca-certificates] at time 19:48:49.538751
2017-10-27 19:48:49,539 [salt.state       ][INFO    ][25072] Executing state pkg.installed for ca-certificates
2017-10-27 19:48:49,543 [salt.state       ][INFO    ][25072] Package ca-certificates is already installed
2017-10-27 19:48:49,543 [salt.state       ][INFO    ][25072] Completed state [ca-certificates] at time 19:48:49.542787 duration_in_ms=4.036
2017-10-27 19:48:49,543 [salt.state       ][INFO    ][25072] Running state [update-ca-certificates] at time 19:48:49.543335
2017-10-27 19:48:49,544 [salt.state       ][INFO    ][25072] Executing state cmd.wait for update-ca-certificates
2017-10-27 19:48:49,544 [salt.state       ][INFO    ][25072] No changes made for update-ca-certificates
2017-10-27 19:48:49,544 [salt.state       ][INFO    ][25072] Completed state [update-ca-certificates] at time 19:48:49.543858 duration_in_ms=0.523
2017-10-27 19:48:49,544 [salt.state       ][INFO    ][25072] Running state [libvirt-dev] at time 19:48:49.544014
2017-10-27 19:48:49,544 [salt.state       ][INFO    ][25072] Executing state pkg.installed for libvirt-dev
2017-10-27 19:48:49,548 [salt.state       ][INFO    ][25072] Package libvirt-dev is already installed
2017-10-27 19:48:49,548 [salt.state       ][INFO    ][25072] Completed state [libvirt-dev] at time 19:48:49.547837 duration_in_ms=3.823
2017-10-27 19:48:49,548 [salt.state       ][INFO    ][25072] Running state [pkg-config] at time 19:48:49.548003
2017-10-27 19:48:49,548 [salt.state       ][INFO    ][25072] Executing state pkg.installed for pkg-config
2017-10-27 19:48:49,552 [salt.state       ][INFO    ][25072] Package pkg-config is already installed
2017-10-27 19:48:49,552 [salt.state       ][INFO    ][25072] Completed state [pkg-config] at time 19:48:49.551800 duration_in_ms=3.796
2017-10-27 19:48:49,552 [salt.state       ][INFO    ][25072] Running state [virtng.init] at time 19:48:49.551964
2017-10-27 19:48:49,552 [salt.state       ][INFO    ][25072] Executing state module.run for virtng.init
2017-10-27 19:48:49,603 [salt.loaded.int.module.cmdmod][INFO    ][25072] Executing command ['git', '--version'] in directory '/root'
2017-10-27 19:48:49,684 [salt.loaded.int.module.cmdmod][INFO    ][25072] Executing command 'virsh list --all --name| grep -E "^prx01.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-10-27 19:48:49,701 [salt.state       ][INFO    ][25072] unless execution succeeded
2017-10-27 19:48:49,701 [salt.state       ][INFO    ][25072] Completed state [virtng.init] at time 19:48:49.701303 duration_in_ms=149.338
2017-10-27 19:48:49,702 [salt.state       ][INFO    ][25072] Running state [virt.set_autostart] at time 19:48:49.701540
2017-10-27 19:48:49,702 [salt.state       ][INFO    ][25072] Executing state module.run for virt.set_autostart
2017-10-27 19:48:49,704 [salt.loaded.int.module.cmdmod][INFO    ][25072] Executing command 'virsh list --autostart --name| grep -E "^prx01.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-10-27 19:48:49,721 [salt.state       ][INFO    ][25072] unless execution succeeded
2017-10-27 19:48:49,721 [salt.state       ][INFO    ][25072] Completed state [virt.set_autostart] at time 19:48:49.721303 duration_in_ms=19.762
2017-10-27 19:48:49,722 [salt.state       ][INFO    ][25072] Running state [virtng.init] at time 19:48:49.721545
2017-10-27 19:48:49,722 [salt.state       ][INFO    ][25072] Executing state module.run for virtng.init
2017-10-27 19:48:49,724 [salt.loaded.int.module.cmdmod][INFO    ][25072] Executing command 'virsh list --all --name| grep -E "^ctl01.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-10-27 19:48:49,740 [salt.state       ][INFO    ][25072] unless execution succeeded
2017-10-27 19:48:49,740 [salt.state       ][INFO    ][25072] Completed state [virtng.init] at time 19:48:49.739886 duration_in_ms=18.34
2017-10-27 19:48:49,740 [salt.state       ][INFO    ][25072] Running state [virt.set_autostart] at time 19:48:49.740120
2017-10-27 19:48:49,740 [salt.state       ][INFO    ][25072] Executing state module.run for virt.set_autostart
2017-10-27 19:48:49,743 [salt.loaded.int.module.cmdmod][INFO    ][25072] Executing command 'virsh list --autostart --name| grep -E "^ctl01.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-10-27 19:48:49,758 [salt.state       ][INFO    ][25072] unless execution succeeded
2017-10-27 19:48:49,759 [salt.state       ][INFO    ][25072] Completed state [virt.set_autostart] at time 19:48:49.758551 duration_in_ms=18.43
2017-10-27 19:48:49,759 [salt.state       ][INFO    ][25072] Running state [virtng.init] at time 19:48:49.758811
2017-10-27 19:48:49,759 [salt.state       ][INFO    ][25072] Executing state module.run for virtng.init
2017-10-27 19:48:49,762 [salt.loaded.int.module.cmdmod][INFO    ][25072] Executing command 'virsh list --all --name| grep -E "^mdb01.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-10-27 19:48:49,776 [salt.state       ][INFO    ][25072] unless execution succeeded
2017-10-27 19:48:49,776 [salt.state       ][INFO    ][25072] Completed state [virtng.init] at time 19:48:49.776253 duration_in_ms=17.442
2017-10-27 19:48:49,776 [salt.state       ][INFO    ][25072] Running state [virt.set_autostart] at time 19:48:49.776473
2017-10-27 19:48:49,777 [salt.state       ][INFO    ][25072] Executing state module.run for virt.set_autostart
2017-10-27 19:48:49,779 [salt.loaded.int.module.cmdmod][INFO    ][25072] Executing command 'virsh list --autostart --name| grep -E "^mdb01.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-10-27 19:48:49,795 [salt.state       ][INFO    ][25072] unless execution succeeded
2017-10-27 19:48:49,795 [salt.state       ][INFO    ][25072] Completed state [virt.set_autostart] at time 19:48:49.795190 duration_in_ms=18.717
2017-10-27 19:48:49,795 [salt.state       ][INFO    ][25072] Running state [virtng.init] at time 19:48:49.795461
2017-10-27 19:48:49,796 [salt.state       ][INFO    ][25072] Executing state module.run for virtng.init
2017-10-27 19:48:49,798 [salt.loaded.int.module.cmdmod][INFO    ][25072] Executing command 'virsh list --all --name| grep -E "^msg01.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-10-27 19:48:49,813 [salt.state       ][INFO    ][25072] unless execution succeeded
2017-10-27 19:48:49,813 [salt.state       ][INFO    ][25072] Completed state [virtng.init] at time 19:48:49.812944 duration_in_ms=17.483
2017-10-27 19:48:49,813 [salt.state       ][INFO    ][25072] Running state [virt.set_autostart] at time 19:48:49.813174
2017-10-27 19:48:49,813 [salt.state       ][INFO    ][25072] Executing state module.run for virt.set_autostart
2017-10-27 19:48:49,816 [salt.loaded.int.module.cmdmod][INFO    ][25072] Executing command 'virsh list --autostart --name| grep -E "^msg01.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-10-27 19:48:49,829 [salt.state       ][INFO    ][25072] unless execution succeeded
2017-10-27 19:48:49,829 [salt.state       ][INFO    ][25072] Completed state [virt.set_autostart] at time 19:48:49.829402 duration_in_ms=16.228
2017-10-27 19:48:49,830 [salt.state       ][INFO    ][25072] Running state [virtng.init] at time 19:48:49.829659
2017-10-27 19:48:49,830 [salt.state       ][INFO    ][25072] Executing state module.run for virtng.init
2017-10-27 19:48:49,832 [salt.loaded.int.module.cmdmod][INFO    ][25072] Executing command 'virsh list --all --name| grep -E "^dbs01.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-10-27 19:48:49,848 [salt.state       ][INFO    ][25072] unless execution succeeded
2017-10-27 19:48:49,848 [salt.state       ][INFO    ][25072] Completed state [virtng.init] at time 19:48:49.847946 duration_in_ms=18.287
2017-10-27 19:48:49,848 [salt.state       ][INFO    ][25072] Running state [virt.set_autostart] at time 19:48:49.848177
2017-10-27 19:48:49,848 [salt.state       ][INFO    ][25072] Executing state module.run for virt.set_autostart
2017-10-27 19:48:49,851 [salt.loaded.int.module.cmdmod][INFO    ][25072] Executing command 'virsh list --autostart --name| grep -E "^dbs01.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-10-27 19:48:49,866 [salt.state       ][INFO    ][25072] unless execution succeeded
2017-10-27 19:48:49,866 [salt.state       ][INFO    ][25072] Completed state [virt.set_autostart] at time 19:48:49.865820 duration_in_ms=17.643
2017-10-27 19:48:49,868 [salt.minion      ][INFO    ][25072] Returning information for job: 20171027194844647321
2017-10-27 19:48:52,144 [salt.minion      ][INFO    ][24712] User sudo_ubuntu Executing command pillar.get with jid 20171027194852132959
2017-10-27 19:48:52,154 [salt.minion      ][INFO    ][25166] Starting a new job with PID 25166
2017-10-27 19:48:52,156 [salt.minion      ][INFO    ][25166] Returning information for job: 20171027194852132959
2017-10-27 19:49:11,310 [salt.minion      ][INFO    ][24712] User sudo_ubuntu Executing command saltutil.sync_all with jid 20171027194911295492
2017-10-27 19:49:11,326 [salt.minion      ][INFO    ][25173] Starting a new job with PID 25173
2017-10-27 19:49:15,887 [salt.state       ][INFO    ][25173] Loading fresh modules for state activity
2017-10-27 19:49:15,918 [salt.state       ][ERROR   ][25173] No contents found in top file
2017-10-27 19:49:15,919 [salt.utils.extmods][INFO    ][25173] Creating module dir '/var/cache/salt/minion/extmods/beacons'
2017-10-27 19:49:15,923 [salt.utils.extmods][INFO    ][25173] Syncing beacons for environment 'base'
2017-10-27 19:49:15,923 [salt.utils.extmods][INFO    ][25173] Loading cache from salt://_beacons, for base)
2017-10-27 19:49:15,923 [salt.fileclient  ][INFO    ][25173] Caching directory '_beacons/' for environment 'base'
2017-10-27 19:49:16,211 [salt.utils.extmods][INFO    ][25173] Syncing modules for environment 'base'
2017-10-27 19:49:16,212 [salt.utils.extmods][INFO    ][25173] Loading cache from salt://_modules, for base)
2017-10-27 19:49:16,212 [salt.fileclient  ][INFO    ][25173] Caching directory '_modules/' for environment 'base'
2017-10-27 19:49:16,284 [salt.fileclient  ][INFO    ][25173] Fetching file from saltenv 'base', ** done ** '_modules/ceph_ng.py'
2017-10-27 19:49:16,294 [salt.fileclient  ][INFO    ][25173] Fetching file from saltenv 'base', ** done ** '_modules/cinderng.py'
2017-10-27 19:49:16,307 [salt.fileclient  ][INFO    ][25173] Fetching file from saltenv 'base', ** done ** '_modules/contrail.py'
2017-10-27 19:49:16,318 [salt.fileclient  ][INFO    ][25173] Fetching file from saltenv 'base', ** done ** '_modules/creds.py'
2017-10-27 19:49:16,331 [salt.fileclient  ][INFO    ][25173] Fetching file from saltenv 'base', ** done ** '_modules/devops_utils.py'
2017-10-27 19:49:16,347 [salt.fileclient  ][INFO    ][25173] Fetching file from saltenv 'base', ** done ** '_modules/encode_json.py'
2017-10-27 19:49:16,359 [salt.fileclient  ][INFO    ][25173] Fetching file from saltenv 'base', ** done ** '_modules/gerrit.py'
2017-10-27 19:49:16,371 [salt.fileclient  ][INFO    ][25173] Fetching file from saltenv 'base', ** done ** '_modules/glanceng.py'
2017-10-27 19:49:16,383 [salt.fileclient  ][INFO    ][25173] Fetching file from saltenv 'base', ** done ** '_modules/heat.py'
2017-10-27 19:49:16,394 [salt.fileclient  ][INFO    ][25173] Fetching file from saltenv 'base', ** done ** '_modules/heka_alarming.py'
2017-10-27 19:49:16,408 [salt.fileclient  ][INFO    ][25173] Fetching file from saltenv 'base', ** done ** '_modules/helm.py'
2017-10-27 19:49:16,421 [salt.fileclient  ][INFO    ][25173] Fetching file from saltenv 'base', ** done ** '_modules/jenkins_common.py'
2017-10-27 19:49:16,430 [salt.fileclient  ][INFO    ][25173] Fetching file from saltenv 'base', ** done ** '_modules/keystone_policy.py'
2017-10-27 19:49:16,444 [salt.fileclient  ][INFO    ][25173] Fetching file from saltenv 'base', ** done ** '_modules/linux_hosts.py'
2017-10-27 19:49:16,459 [salt.fileclient  ][INFO    ][25173] Fetching file from saltenv 'base', ** done ** '_modules/linux_netlink.py'
2017-10-27 19:49:16,476 [salt.fileclient  ][INFO    ][25173] Fetching file from saltenv 'base', ** done ** '_modules/maas.py'
2017-10-27 19:49:16,492 [salt.fileclient  ][INFO    ][25173] Fetching file from saltenv 'base', ** done ** '_modules/maas_client.py'
2017-10-27 19:49:16,506 [salt.fileclient  ][INFO    ][25173] Fetching file from saltenv 'base', ** done ** '_modules/multipart.py'
2017-10-27 19:49:16,519 [salt.fileclient  ][INFO    ][25173] Fetching file from saltenv 'base', ** done ** '_modules/nagios_alarming.py'
2017-10-27 19:49:16,544 [salt.fileclient  ][INFO    ][25173] Fetching file from saltenv 'base', ** done ** '_modules/neutronng.py'
2017-10-27 19:49:16,562 [salt.fileclient  ][INFO    ][25173] Fetching file from saltenv 'base', ** done ** '_modules/novang.py'
2017-10-27 19:49:16,608 [salt.fileclient  ][INFO    ][25173] Fetching file from saltenv 'base', ** done ** '_modules/reclass.py'
2017-10-27 19:49:16,618 [salt.fileclient  ][INFO    ][25173] Fetching file from saltenv 'base', ** done ** '_modules/rsyslog_util.py'
2017-10-27 19:49:16,630 [salt.fileclient  ][INFO    ][25173] Fetching file from saltenv 'base', ** done ** '_modules/rundeck.py'
2017-10-27 19:49:16,641 [salt.fileclient  ][INFO    ][25173] Fetching file from saltenv 'base', ** done ** '_modules/saltkey.py'
2017-10-27 19:49:16,662 [salt.fileclient  ][INFO    ][25173] Fetching file from saltenv 'base', ** done ** '_modules/saltresource.py'
2017-10-27 19:49:16,677 [salt.fileclient  ][INFO    ][25173] Fetching file from saltenv 'base', ** done ** '_modules/seedng.py'
2017-10-27 19:49:16,695 [salt.fileclient  ][INFO    ][25173] Fetching file from saltenv 'base', ** done ** '_modules/testing/credentials.py'
2017-10-27 19:49:16,706 [salt.fileclient  ][INFO    ][25173] Fetching file from saltenv 'base', ** done ** '_modules/testing/django.py'
2017-10-27 19:49:16,718 [salt.fileclient  ][INFO    ][25173] Fetching file from saltenv 'base', ** done ** '_modules/testing/django_client_proxy.py'
2017-10-27 19:49:16,731 [salt.fileclient  ][INFO    ][25173] Fetching file from saltenv 'base', ** done ** '_modules/utils.py'
2017-10-27 19:49:16,783 [salt.fileclient  ][INFO    ][25173] Fetching file from saltenv 'base', ** done ** '_modules/virtng.py'
2017-10-27 19:49:16,787 [salt.utils.extmods][INFO    ][25173] Copying '/var/cache/salt/minion/files/base/_modules/__init__.py' to '/var/cache/salt/minion/extmods/modules/__init__.py'
2017-10-27 19:49:16,788 [salt.utils.extmods][INFO    ][25173] Copying '/var/cache/salt/minion/files/base/_modules/ceph_ng.py' to '/var/cache/salt/minion/extmods/modules/ceph_ng.py'
2017-10-27 19:49:16,788 [salt.utils.extmods][INFO    ][25173] Copying '/var/cache/salt/minion/files/base/_modules/cinderng.py' to '/var/cache/salt/minion/extmods/modules/cinderng.py'
2017-10-27 19:49:16,788 [salt.utils.extmods][INFO    ][25173] Copying '/var/cache/salt/minion/files/base/_modules/contrail.py' to '/var/cache/salt/minion/extmods/modules/contrail.py'
2017-10-27 19:49:16,789 [salt.utils.extmods][INFO    ][25173] Copying '/var/cache/salt/minion/files/base/_modules/creds.py' to '/var/cache/salt/minion/extmods/modules/creds.py'
2017-10-27 19:49:16,789 [salt.utils.extmods][INFO    ][25173] Copying '/var/cache/salt/minion/files/base/_modules/devops_utils.py' to '/var/cache/salt/minion/extmods/modules/devops_utils.py'
2017-10-27 19:49:16,789 [salt.utils.extmods][INFO    ][25173] Copying '/var/cache/salt/minion/files/base/_modules/encode_json.py' to '/var/cache/salt/minion/extmods/modules/encode_json.py'
2017-10-27 19:49:16,789 [salt.utils.extmods][INFO    ][25173] Copying '/var/cache/salt/minion/files/base/_modules/gerrit.py' to '/var/cache/salt/minion/extmods/modules/gerrit.py'
2017-10-27 19:49:16,790 [salt.utils.extmods][INFO    ][25173] Copying '/var/cache/salt/minion/files/base/_modules/glanceng.py' to '/var/cache/salt/minion/extmods/modules/glanceng.py'
2017-10-27 19:49:16,790 [salt.utils.extmods][INFO    ][25173] Copying '/var/cache/salt/minion/files/base/_modules/heat.py' to '/var/cache/salt/minion/extmods/modules/heat.py'
2017-10-27 19:49:16,790 [salt.utils.extmods][INFO    ][25173] Copying '/var/cache/salt/minion/files/base/_modules/heka_alarming.py' to '/var/cache/salt/minion/extmods/modules/heka_alarming.py'
2017-10-27 19:49:16,791 [salt.utils.extmods][INFO    ][25173] Copying '/var/cache/salt/minion/files/base/_modules/helm.py' to '/var/cache/salt/minion/extmods/modules/helm.py'
2017-10-27 19:49:16,791 [salt.utils.extmods][INFO    ][25173] Copying '/var/cache/salt/minion/files/base/_modules/jenkins_common.py' to '/var/cache/salt/minion/extmods/modules/jenkins_common.py'
2017-10-27 19:49:16,791 [salt.utils.extmods][INFO    ][25173] Copying '/var/cache/salt/minion/files/base/_modules/keystone_policy.py' to '/var/cache/salt/minion/extmods/modules/keystone_policy.py'
2017-10-27 19:49:16,791 [salt.utils.extmods][INFO    ][25173] Copying '/var/cache/salt/minion/files/base/_modules/linux_hosts.py' to '/var/cache/salt/minion/extmods/modules/linux_hosts.py'
2017-10-27 19:49:16,792 [salt.utils.extmods][INFO    ][25173] Copying '/var/cache/salt/minion/files/base/_modules/linux_netlink.py' to '/var/cache/salt/minion/extmods/modules/linux_netlink.py'
2017-10-27 19:49:16,792 [salt.utils.extmods][INFO    ][25173] Copying '/var/cache/salt/minion/files/base/_modules/maas.py' to '/var/cache/salt/minion/extmods/modules/maas.py'
2017-10-27 19:49:16,792 [salt.utils.extmods][INFO    ][25173] Copying '/var/cache/salt/minion/files/base/_modules/maas_client.py' to '/var/cache/salt/minion/extmods/modules/maas_client.py'
2017-10-27 19:49:16,792 [salt.utils.extmods][INFO    ][25173] Copying '/var/cache/salt/minion/files/base/_modules/multipart.py' to '/var/cache/salt/minion/extmods/modules/multipart.py'
2017-10-27 19:49:16,793 [salt.utils.extmods][INFO    ][25173] Copying '/var/cache/salt/minion/files/base/_modules/nagios_alarming.py' to '/var/cache/salt/minion/extmods/modules/nagios_alarming.py'
2017-10-27 19:49:16,793 [salt.utils.extmods][INFO    ][25173] Copying '/var/cache/salt/minion/files/base/_modules/neutronng.py' to '/var/cache/salt/minion/extmods/modules/neutronng.py'
2017-10-27 19:49:16,793 [salt.utils.extmods][INFO    ][25173] Copying '/var/cache/salt/minion/files/base/_modules/novang.py' to '/var/cache/salt/minion/extmods/modules/novang.py'
2017-10-27 19:49:16,794 [salt.utils.extmods][INFO    ][25173] Copying '/var/cache/salt/minion/files/base/_modules/reclass.py' to '/var/cache/salt/minion/extmods/modules/reclass.py'
2017-10-27 19:49:16,794 [salt.utils.extmods][INFO    ][25173] Copying '/var/cache/salt/minion/files/base/_modules/rsyslog_util.py' to '/var/cache/salt/minion/extmods/modules/rsyslog_util.py'
2017-10-27 19:49:16,794 [salt.utils.extmods][INFO    ][25173] Copying '/var/cache/salt/minion/files/base/_modules/rundeck.py' to '/var/cache/salt/minion/extmods/modules/rundeck.py'
2017-10-27 19:49:16,795 [salt.utils.extmods][INFO    ][25173] Copying '/var/cache/salt/minion/files/base/_modules/saltkey.py' to '/var/cache/salt/minion/extmods/modules/saltkey.py'
2017-10-27 19:49:16,795 [salt.utils.extmods][INFO    ][25173] Copying '/var/cache/salt/minion/files/base/_modules/saltresource.py' to '/var/cache/salt/minion/extmods/modules/saltresource.py'
2017-10-27 19:49:16,795 [salt.utils.extmods][INFO    ][25173] Copying '/var/cache/salt/minion/files/base/_modules/seedng.py' to '/var/cache/salt/minion/extmods/modules/seedng.py'
2017-10-27 19:49:16,795 [salt.utils.extmods][INFO    ][25173] Copying '/var/cache/salt/minion/files/base/_modules/testing/__init__.py' to '/var/cache/salt/minion/extmods/modules/testing/__init__.py'
2017-10-27 19:49:16,796 [salt.utils.extmods][INFO    ][25173] Copying '/var/cache/salt/minion/files/base/_modules/testing/credentials.py' to '/var/cache/salt/minion/extmods/modules/testing/credentials.py'
2017-10-27 19:49:16,796 [salt.utils.extmods][INFO    ][25173] Copying '/var/cache/salt/minion/files/base/_modules/testing/django.py' to '/var/cache/salt/minion/extmods/modules/testing/django.py'
2017-10-27 19:49:16,796 [salt.utils.extmods][INFO    ][25173] Copying '/var/cache/salt/minion/files/base/_modules/testing/django_client_proxy.py' to '/var/cache/salt/minion/extmods/modules/testing/django_client_proxy.py'
2017-10-27 19:49:16,796 [salt.utils.extmods][INFO    ][25173] Copying '/var/cache/salt/minion/files/base/_modules/utils.py' to '/var/cache/salt/minion/extmods/modules/utils.py'
2017-10-27 19:49:16,797 [salt.utils.extmods][INFO    ][25173] Copying '/var/cache/salt/minion/files/base/_modules/virtng.py' to '/var/cache/salt/minion/extmods/modules/virtng.py'
2017-10-27 19:49:16,802 [salt.utils.extmods][INFO    ][25173] Syncing states for environment 'base'
2017-10-27 19:49:16,802 [salt.utils.extmods][INFO    ][25173] Loading cache from salt://_states, for base)
2017-10-27 19:49:16,803 [salt.fileclient  ][INFO    ][25173] Caching directory '_states/' for environment 'base'
2017-10-27 19:49:16,909 [salt.fileclient  ][INFO    ][25173] Fetching file from saltenv 'base', ** done ** '_states/cinderng.py'
2017-10-27 19:49:16,926 [salt.fileclient  ][INFO    ][25173] Fetching file from saltenv 'base', ** done ** '_states/contrail.py'
2017-10-27 19:49:16,962 [salt.fileclient  ][INFO    ][25173] Fetching file from saltenv 'base', ** done ** '_states/gerrit.py'
2017-10-27 19:49:16,986 [salt.fileclient  ][INFO    ][25173] Fetching file from saltenv 'base', ** done ** '_states/glanceng.py'
2017-10-27 19:49:17,014 [salt.fileclient  ][INFO    ][25173] Fetching file from saltenv 'base', ** done ** '_states/grafana3_dashboard.py'
2017-10-27 19:49:17,027 [salt.fileclient  ][INFO    ][25173] Fetching file from saltenv 'base', ** done ** '_states/grafana3_datasource.py'
2017-10-27 19:49:17,039 [salt.fileclient  ][INFO    ][25173] Fetching file from saltenv 'base', ** done ** '_states/heat.py'
2017-10-27 19:49:17,052 [salt.fileclient  ][INFO    ][25173] Fetching file from saltenv 'base', ** done ** '_states/helm_release.py'
2017-10-27 19:49:17,066 [salt.fileclient  ][INFO    ][25173] Fetching file from saltenv 'base', ** done ** '_states/jenkins_approval.py'
2017-10-27 19:49:17,080 [salt.fileclient  ][INFO    ][25173] Fetching file from saltenv 'base', ** done ** '_states/jenkins_artifactory.py'
2017-10-27 19:49:17,095 [salt.fileclient  ][INFO    ][25173] Fetching file from saltenv 'base', ** done ** '_states/jenkins_credential.py'
2017-10-27 19:49:17,133 [salt.fileclient  ][INFO    ][25173] Fetching file from saltenv 'base', ** done ** '_states/jenkins_job.py'
2017-10-27 19:49:17,143 [salt.fileclient  ][INFO    ][25173] Fetching file from saltenv 'base', ** done ** '_states/jenkins_lib.py'
2017-10-27 19:49:17,158 [salt.fileclient  ][INFO    ][25173] Fetching file from saltenv 'base', ** done ** '_states/jenkins_node.py'
2017-10-27 19:49:17,191 [salt.fileclient  ][INFO    ][25173] Fetching file from saltenv 'base', ** done ** '_states/jenkins_plugin.py'
2017-10-27 19:49:17,205 [salt.fileclient  ][INFO    ][25173] Fetching file from saltenv 'base', ** done ** '_states/jenkins_security.py'
2017-10-27 19:49:17,220 [salt.fileclient  ][INFO    ][25173] Fetching file from saltenv 'base', ** done ** '_states/jenkins_slack.py'
2017-10-27 19:49:17,238 [salt.fileclient  ][INFO    ][25173] Fetching file from saltenv 'base', ** done ** '_states/jenkins_smtp.py'
2017-10-27 19:49:17,253 [salt.fileclient  ][INFO    ][25173] Fetching file from saltenv 'base', ** done ** '_states/jenkins_theme.py'
2017-10-27 19:49:17,266 [salt.fileclient  ][INFO    ][25173] Fetching file from saltenv 'base', ** done ** '_states/jenkins_user.py'
2017-10-27 19:49:17,295 [salt.fileclient  ][INFO    ][25173] Fetching file from saltenv 'base', ** done ** '_states/jenkins_view.py'
2017-10-27 19:49:17,311 [salt.fileclient  ][INFO    ][25173] Fetching file from saltenv 'base', ** done ** '_states/keystone_policy.py'
2017-10-27 19:49:17,323 [salt.fileclient  ][INFO    ][25173] Fetching file from saltenv 'base', ** done ** '_states/kibana_object.py'
2017-10-27 19:49:17,350 [salt.fileclient  ][INFO    ][25173] Fetching file from saltenv 'base', ** done ** '_states/neutronng.py'
2017-10-27 19:49:17,371 [salt.fileclient  ][INFO    ][25173] Fetching file from saltenv 'base', ** done ** '_states/novang.py'
2017-10-27 19:49:17,402 [salt.fileclient  ][INFO    ][25173] Fetching file from saltenv 'base', ** done ** '_states/reclass.py'
2017-10-27 19:49:17,451 [salt.fileclient  ][INFO    ][25173] Fetching file from saltenv 'base', ** done ** '_states/rundeck_project.py'
2017-10-27 19:49:17,490 [salt.fileclient  ][INFO    ][25173] Fetching file from saltenv 'base', ** done ** '_states/rundeck_scm.py'
2017-10-27 19:49:17,508 [salt.fileclient  ][INFO    ][25173] Fetching file from saltenv 'base', ** done ** '_states/rundeck_secret.py'
2017-10-27 19:49:17,512 [salt.utils.extmods][INFO    ][25173] Copying '/var/cache/salt/minion/files/base/_states/cinderng.py' to '/var/cache/salt/minion/extmods/states/cinderng.py'
2017-10-27 19:49:17,513 [salt.utils.extmods][INFO    ][25173] Copying '/var/cache/salt/minion/files/base/_states/contrail.py' to '/var/cache/salt/minion/extmods/states/contrail.py'
2017-10-27 19:49:17,513 [salt.utils.extmods][INFO    ][25173] Copying '/var/cache/salt/minion/files/base/_states/gerrit.py' to '/var/cache/salt/minion/extmods/states/gerrit.py'
2017-10-27 19:49:17,513 [salt.utils.extmods][INFO    ][25173] Copying '/var/cache/salt/minion/files/base/_states/glanceng.py' to '/var/cache/salt/minion/extmods/states/glanceng.py'
2017-10-27 19:49:17,514 [salt.utils.extmods][INFO    ][25173] Copying '/var/cache/salt/minion/files/base/_states/grafana3_dashboard.py' to '/var/cache/salt/minion/extmods/states/grafana3_dashboard.py'
2017-10-27 19:49:17,514 [salt.utils.extmods][INFO    ][25173] Copying '/var/cache/salt/minion/files/base/_states/grafana3_datasource.py' to '/var/cache/salt/minion/extmods/states/grafana3_datasource.py'
2017-10-27 19:49:17,514 [salt.utils.extmods][INFO    ][25173] Copying '/var/cache/salt/minion/files/base/_states/heat.py' to '/var/cache/salt/minion/extmods/states/heat.py'
2017-10-27 19:49:17,514 [salt.utils.extmods][INFO    ][25173] Copying '/var/cache/salt/minion/files/base/_states/helm_release.py' to '/var/cache/salt/minion/extmods/states/helm_release.py'
2017-10-27 19:49:17,515 [salt.utils.extmods][INFO    ][25173] Copying '/var/cache/salt/minion/files/base/_states/jenkins_approval.py' to '/var/cache/salt/minion/extmods/states/jenkins_approval.py'
2017-10-27 19:49:17,515 [salt.utils.extmods][INFO    ][25173] Copying '/var/cache/salt/minion/files/base/_states/jenkins_artifactory.py' to '/var/cache/salt/minion/extmods/states/jenkins_artifactory.py'
2017-10-27 19:49:17,515 [salt.utils.extmods][INFO    ][25173] Copying '/var/cache/salt/minion/files/base/_states/jenkins_credential.py' to '/var/cache/salt/minion/extmods/states/jenkins_credential.py'
2017-10-27 19:49:17,515 [salt.utils.extmods][INFO    ][25173] Copying '/var/cache/salt/minion/files/base/_states/jenkins_job.py' to '/var/cache/salt/minion/extmods/states/jenkins_job.py'
2017-10-27 19:49:17,516 [salt.utils.extmods][INFO    ][25173] Copying '/var/cache/salt/minion/files/base/_states/jenkins_lib.py' to '/var/cache/salt/minion/extmods/states/jenkins_lib.py'
2017-10-27 19:49:17,516 [salt.utils.extmods][INFO    ][25173] Copying '/var/cache/salt/minion/files/base/_states/jenkins_node.py' to '/var/cache/salt/minion/extmods/states/jenkins_node.py'
2017-10-27 19:49:17,516 [salt.utils.extmods][INFO    ][25173] Copying '/var/cache/salt/minion/files/base/_states/jenkins_plugin.py' to '/var/cache/salt/minion/extmods/states/jenkins_plugin.py'
2017-10-27 19:49:17,516 [salt.utils.extmods][INFO    ][25173] Copying '/var/cache/salt/minion/files/base/_states/jenkins_security.py' to '/var/cache/salt/minion/extmods/states/jenkins_security.py'
2017-10-27 19:49:17,517 [salt.utils.extmods][INFO    ][25173] Copying '/var/cache/salt/minion/files/base/_states/jenkins_slack.py' to '/var/cache/salt/minion/extmods/states/jenkins_slack.py'
2017-10-27 19:49:17,517 [salt.utils.extmods][INFO    ][25173] Copying '/var/cache/salt/minion/files/base/_states/jenkins_smtp.py' to '/var/cache/salt/minion/extmods/states/jenkins_smtp.py'
2017-10-27 19:49:17,517 [salt.utils.extmods][INFO    ][25173] Copying '/var/cache/salt/minion/files/base/_states/jenkins_theme.py' to '/var/cache/salt/minion/extmods/states/jenkins_theme.py'
2017-10-27 19:49:17,517 [salt.utils.extmods][INFO    ][25173] Copying '/var/cache/salt/minion/files/base/_states/jenkins_user.py' to '/var/cache/salt/minion/extmods/states/jenkins_user.py'
2017-10-27 19:49:17,518 [salt.utils.extmods][INFO    ][25173] Copying '/var/cache/salt/minion/files/base/_states/jenkins_view.py' to '/var/cache/salt/minion/extmods/states/jenkins_view.py'
2017-10-27 19:49:17,518 [salt.utils.extmods][INFO    ][25173] Copying '/var/cache/salt/minion/files/base/_states/keystone_policy.py' to '/var/cache/salt/minion/extmods/states/keystone_policy.py'
2017-10-27 19:49:17,518 [salt.utils.extmods][INFO    ][25173] Copying '/var/cache/salt/minion/files/base/_states/kibana_object.py' to '/var/cache/salt/minion/extmods/states/kibana_object.py'
2017-10-27 19:49:17,518 [salt.utils.extmods][INFO    ][25173] Copying '/var/cache/salt/minion/files/base/_states/maas_cluster.py' to '/var/cache/salt/minion/extmods/states/maas_cluster.py'
2017-10-27 19:49:17,519 [salt.utils.extmods][INFO    ][25173] Copying '/var/cache/salt/minion/files/base/_states/neutronng.py' to '/var/cache/salt/minion/extmods/states/neutronng.py'
2017-10-27 19:49:17,519 [salt.utils.extmods][INFO    ][25173] Copying '/var/cache/salt/minion/files/base/_states/novang.py' to '/var/cache/salt/minion/extmods/states/novang.py'
2017-10-27 19:49:17,519 [salt.utils.extmods][INFO    ][25173] Copying '/var/cache/salt/minion/files/base/_states/reclass.py' to '/var/cache/salt/minion/extmods/states/reclass.py'
2017-10-27 19:49:17,519 [salt.utils.extmods][INFO    ][25173] Copying '/var/cache/salt/minion/files/base/_states/rundeck_project.py' to '/var/cache/salt/minion/extmods/states/rundeck_project.py'
2017-10-27 19:49:17,520 [salt.utils.extmods][INFO    ][25173] Copying '/var/cache/salt/minion/files/base/_states/rundeck_scm.py' to '/var/cache/salt/minion/extmods/states/rundeck_scm.py'
2017-10-27 19:49:17,520 [salt.utils.extmods][INFO    ][25173] Copying '/var/cache/salt/minion/files/base/_states/rundeck_secret.py' to '/var/cache/salt/minion/extmods/states/rundeck_secret.py'
2017-10-27 19:49:17,523 [salt.utils.extmods][INFO    ][25173] Creating module dir '/var/cache/salt/minion/extmods/sdb'
2017-10-27 19:49:17,526 [salt.utils.extmods][INFO    ][25173] Syncing sdb for environment 'base'
2017-10-27 19:49:17,526 [salt.utils.extmods][INFO    ][25173] Loading cache from salt://_sdb, for base)
2017-10-27 19:49:17,526 [salt.fileclient  ][INFO    ][25173] Caching directory '_sdb/' for environment 'base'
2017-10-27 19:49:17,573 [salt.utils.extmods][INFO    ][25173] Syncing grains for environment 'base'
2017-10-27 19:49:17,573 [salt.utils.extmods][INFO    ][25173] Loading cache from salt://_grains, for base)
2017-10-27 19:49:17,573 [salt.fileclient  ][INFO    ][25173] Caching directory '_grains/' for environment 'base'
2017-10-27 19:49:17,623 [salt.fileclient  ][INFO    ][25173] Fetching file from saltenv 'base', ** done ** '_grains/ceilometer_policy.py'
2017-10-27 19:49:17,642 [salt.fileclient  ][INFO    ][25173] Fetching file from saltenv 'base', ** done ** '_grains/ceph.py'
2017-10-27 19:49:17,652 [salt.fileclient  ][INFO    ][25173] Fetching file from saltenv 'base', ** done ** '_grains/cinder_policy.py'
2017-10-27 19:49:17,666 [salt.fileclient  ][INFO    ][25173] Fetching file from saltenv 'base', ** done ** '_grains/docker_swarm.py'
2017-10-27 19:49:17,717 [salt.fileclient  ][INFO    ][25173] Fetching file from saltenv 'base', ** done ** '_grains/glance_policy.py'
2017-10-27 19:49:17,732 [salt.fileclient  ][INFO    ][25173] Fetching file from saltenv 'base', ** done ** '_grains/heat_policy.py'
2017-10-27 19:49:17,747 [salt.fileclient  ][INFO    ][25173] Fetching file from saltenv 'base', ** done ** '_grains/jenkins_plugins.py'
2017-10-27 19:49:17,770 [salt.fileclient  ][INFO    ][25173] Fetching file from saltenv 'base', ** done ** '_grains/keystone_policy.py'
2017-10-27 19:49:17,782 [salt.fileclient  ][INFO    ][25173] Fetching file from saltenv 'base', ** done ** '_grains/kubernetes.py'
2017-10-27 19:49:17,796 [salt.fileclient  ][INFO    ][25173] Fetching file from saltenv 'base', ** done ** '_grains/neutron_policy.py'
2017-10-27 19:49:17,810 [salt.fileclient  ][INFO    ][25173] Fetching file from saltenv 'base', ** done ** '_grains/nova_policy.py'
2017-10-27 19:49:17,831 [salt.fileclient  ][INFO    ][25173] Fetching file from saltenv 'base', ** done ** '_grains/ssh_fingerprints.py'
2017-10-27 19:49:17,835 [salt.utils.extmods][INFO    ][25173] Copying '/var/cache/salt/minion/files/base/_grains/ceilometer_policy.py' to '/var/cache/salt/minion/extmods/grains/ceilometer_policy.py'
2017-10-27 19:49:17,835 [salt.utils.extmods][INFO    ][25173] Copying '/var/cache/salt/minion/files/base/_grains/ceph.py' to '/var/cache/salt/minion/extmods/grains/ceph.py'
2017-10-27 19:49:17,835 [salt.utils.extmods][INFO    ][25173] Copying '/var/cache/salt/minion/files/base/_grains/cinder_policy.py' to '/var/cache/salt/minion/extmods/grains/cinder_policy.py'
2017-10-27 19:49:17,835 [salt.utils.extmods][INFO    ][25173] Copying '/var/cache/salt/minion/files/base/_grains/docker_swarm.py' to '/var/cache/salt/minion/extmods/grains/docker_swarm.py'
2017-10-27 19:49:17,836 [salt.utils.extmods][INFO    ][25173] Copying '/var/cache/salt/minion/files/base/_grains/glance_policy.py' to '/var/cache/salt/minion/extmods/grains/glance_policy.py'
2017-10-27 19:49:17,836 [salt.utils.extmods][INFO    ][25173] Copying '/var/cache/salt/minion/files/base/_grains/heat_policy.py' to '/var/cache/salt/minion/extmods/grains/heat_policy.py'
2017-10-27 19:49:17,836 [salt.utils.extmods][INFO    ][25173] Copying '/var/cache/salt/minion/files/base/_grains/jenkins_plugins.py' to '/var/cache/salt/minion/extmods/grains/jenkins_plugins.py'
2017-10-27 19:49:17,836 [salt.utils.extmods][INFO    ][25173] Copying '/var/cache/salt/minion/files/base/_grains/keystone_policy.py' to '/var/cache/salt/minion/extmods/grains/keystone_policy.py'
2017-10-27 19:49:17,837 [salt.utils.extmods][INFO    ][25173] Copying '/var/cache/salt/minion/files/base/_grains/kubernetes.py' to '/var/cache/salt/minion/extmods/grains/kubernetes.py'
2017-10-27 19:49:17,837 [salt.utils.extmods][INFO    ][25173] Copying '/var/cache/salt/minion/files/base/_grains/neutron_policy.py' to '/var/cache/salt/minion/extmods/grains/neutron_policy.py'
2017-10-27 19:49:17,837 [salt.utils.extmods][INFO    ][25173] Copying '/var/cache/salt/minion/files/base/_grains/nova_policy.py' to '/var/cache/salt/minion/extmods/grains/nova_policy.py'
2017-10-27 19:49:17,837 [salt.utils.extmods][INFO    ][25173] Copying '/var/cache/salt/minion/files/base/_grains/ssh_fingerprints.py' to '/var/cache/salt/minion/extmods/grains/ssh_fingerprints.py'
2017-10-27 19:49:17,839 [salt.utils.extmods][INFO    ][25173] Creating module dir '/var/cache/salt/minion/extmods/renderers'
2017-10-27 19:49:17,842 [salt.utils.extmods][INFO    ][25173] Syncing renderers for environment 'base'
2017-10-27 19:49:17,842 [salt.utils.extmods][INFO    ][25173] Loading cache from salt://_renderers, for base)
2017-10-27 19:49:17,842 [salt.fileclient  ][INFO    ][25173] Caching directory '_renderers/' for environment 'base'
2017-10-27 19:49:17,962 [salt.utils.extmods][INFO    ][25173] Creating module dir '/var/cache/salt/minion/extmods/returners'
2017-10-27 19:49:17,965 [salt.utils.extmods][INFO    ][25173] Syncing returners for environment 'base'
2017-10-27 19:49:17,965 [salt.utils.extmods][INFO    ][25173] Loading cache from salt://_returners, for base)
2017-10-27 19:49:17,966 [salt.fileclient  ][INFO    ][25173] Caching directory '_returners/' for environment 'base'
2017-10-27 19:49:18,032 [salt.utils.extmods][INFO    ][25173] Creating module dir '/var/cache/salt/minion/extmods/output'
2017-10-27 19:49:18,035 [salt.utils.extmods][INFO    ][25173] Syncing output for environment 'base'
2017-10-27 19:49:18,035 [salt.utils.extmods][INFO    ][25173] Loading cache from salt://_output, for base)
2017-10-27 19:49:18,036 [salt.fileclient  ][INFO    ][25173] Caching directory '_output/' for environment 'base'
2017-10-27 19:49:18,135 [salt.utils.extmods][INFO    ][25173] Creating module dir '/var/cache/salt/minion/extmods/utils'
2017-10-27 19:49:18,138 [salt.utils.extmods][INFO    ][25173] Syncing utils for environment 'base'
2017-10-27 19:49:18,139 [salt.utils.extmods][INFO    ][25173] Loading cache from salt://_utils, for base)
2017-10-27 19:49:18,139 [salt.fileclient  ][INFO    ][25173] Caching directory '_utils/' for environment 'base'
2017-10-27 19:49:18,234 [salt.utils.extmods][INFO    ][25173] Creating module dir '/var/cache/salt/minion/extmods/log_handlers'
2017-10-27 19:49:18,237 [salt.utils.extmods][INFO    ][25173] Syncing log_handlers for environment 'base'
2017-10-27 19:49:18,237 [salt.utils.extmods][INFO    ][25173] Loading cache from salt://_log_handlers, for base)
2017-10-27 19:49:18,237 [salt.fileclient  ][INFO    ][25173] Caching directory '_log_handlers/' for environment 'base'
2017-10-27 19:49:18,375 [salt.utils.extmods][INFO    ][25173] Creating module dir '/var/cache/salt/minion/extmods/proxy'
2017-10-27 19:49:18,378 [salt.utils.extmods][INFO    ][25173] Syncing proxy for environment 'base'
2017-10-27 19:49:18,378 [salt.utils.extmods][INFO    ][25173] Loading cache from salt://_proxy, for base)
2017-10-27 19:49:18,378 [salt.fileclient  ][INFO    ][25173] Caching directory '_proxy/' for environment 'base'
2017-10-27 19:49:18,445 [salt.utils.extmods][INFO    ][25173] Creating module dir '/var/cache/salt/minion/extmods/engines'
2017-10-27 19:49:18,449 [salt.utils.extmods][INFO    ][25173] Syncing engines for environment 'base'
2017-10-27 19:49:18,449 [salt.utils.extmods][INFO    ][25173] Loading cache from salt://_engines, for base)
2017-10-27 19:49:18,449 [salt.fileclient  ][INFO    ][25173] Caching directory '_engines/' for environment 'base'
2017-10-27 19:49:18,502 [salt.minion      ][INFO    ][25173] Returning information for job: 20171027194911295492
2017-10-27 19:58:19,565 [salt.minion      ][INFO    ][24712] User sudo_ubuntu Executing command test.ping with jid 20171027195819553040
2017-10-27 19:58:19,580 [salt.minion      ][INFO    ][25431] Starting a new job with PID 25431
2017-10-27 19:58:19,636 [salt.minion      ][INFO    ][25431] Returning information for job: 20171027195819553040
2017-10-27 19:59:42,829 [salt.minion      ][INFO    ][24712] User sudo_ubuntu Executing command state.sls with jid 20171027195942813314
2017-10-27 19:59:42,840 [salt.minion      ][INFO    ][25465] Starting a new job with PID 25465
2017-10-27 19:59:43,403 [salt.state       ][INFO    ][25465] Loading fresh modules for state activity
2017-10-27 19:59:43,437 [salt.fileclient  ][INFO    ][25465] Fetching file from saltenv 'base', ** done ** 'keepalived/init.sls'
2017-10-27 19:59:43,458 [salt.fileclient  ][INFO    ][25465] Fetching file from saltenv 'base', ** done ** 'keepalived/cluster.sls'
2017-10-27 19:59:43,487 [salt.fileclient  ][INFO    ][25465] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-10-27 19:59:43,815 [salt.state       ][INFO    ][25465] Running state [lsof] at time 19:59:43.814943
2017-10-27 19:59:43,815 [salt.state       ][INFO    ][25465] Executing state pkg.installed for lsof
2017-10-27 19:59:43,816 [salt.loaded.int.module.cmdmod][INFO    ][25465] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-10-27 19:59:44,070 [salt.state       ][INFO    ][25465] Package lsof is already installed
2017-10-27 19:59:44,071 [salt.state       ][INFO    ][25465] Completed state [lsof] at time 19:59:44.070588 duration_in_ms=255.644
2017-10-27 19:59:44,071 [salt.state       ][INFO    ][25465] Running state [keepalived] at time 19:59:44.070939
2017-10-27 19:59:44,071 [salt.state       ][INFO    ][25465] Executing state pkg.installed for keepalived
2017-10-27 19:59:44,088 [salt.loaded.int.module.cmdmod][INFO    ][25465] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-10-27 19:59:45,987 [salt.loaded.int.module.cmdmod][INFO    ][25465] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'keepalived'] in directory '/root'
2017-10-27 19:59:48,587 [salt.loaded.int.module.cmdmod][INFO    ][25465] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-10-27 19:59:48,612 [salt.state       ][INFO    ][25465] Made the following changes:
'libsnmp30' changed from 'absent' to '5.7.3+dfsg-1ubuntu4'
'libsnmp-base' changed from 'absent' to '5.7.3+dfsg-1ubuntu4'
'keepalived' changed from 'absent' to '1:1.2.19-1ubuntu0.2'
'ipvsadm' changed from 'absent' to '1:1.28-3'
'libsensors4' changed from 'absent' to '1:3.4.0-2'

2017-10-27 19:59:48,622 [salt.state       ][INFO    ][25465] Loading fresh modules for state activity
2017-10-27 19:59:48,638 [salt.state       ][INFO    ][25465] Completed state [keepalived] at time 19:59:48.638186 duration_in_ms=4567.246
2017-10-27 19:59:48,640 [salt.state       ][INFO    ][25465] Running state [/etc/keepalived/keepalived.conf] at time 19:59:48.640236
2017-10-27 19:59:48,640 [salt.state       ][INFO    ][25465] Executing state file.managed for /etc/keepalived/keepalived.conf
2017-10-27 19:59:48,673 [salt.fileclient  ][INFO    ][25465] Fetching file from saltenv 'base', ** done ** 'keepalived/files/keepalived.conf'
2017-10-27 19:59:48,716 [salt.fileclient  ][INFO    ][25465] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-10-27 19:59:48,724 [salt.state       ][INFO    ][25465] File changed:
New file
2017-10-27 19:59:48,724 [salt.state       ][INFO    ][25465] Completed state [/etc/keepalived/keepalived.conf] at time 19:59:48.723872 duration_in_ms=83.636
2017-10-27 19:59:48,789 [salt.state       ][INFO    ][25465] Running state [keepalived] at time 19:59:48.789296
2017-10-27 19:59:48,790 [salt.state       ][INFO    ][25465] Executing state service.running for keepalived
2017-10-27 19:59:48,791 [salt.loaded.int.module.cmdmod][INFO    ][25465] Executing command ['systemctl', 'status', 'keepalived.service', '-n', '0'] in directory '/root'
2017-10-27 19:59:48,800 [salt.loaded.int.module.cmdmod][INFO    ][25465] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2017-10-27 19:59:48,807 [salt.loaded.int.module.cmdmod][INFO    ][25465] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-10-27 19:59:48,814 [salt.loaded.int.module.cmdmod][INFO    ][25465] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-10-27 19:59:48,822 [salt.loaded.int.module.cmdmod][INFO    ][25465] Executing command ['systemd-run', '--scope', 'systemctl', 'start', 'keepalived.service'] in directory '/root'
2017-10-27 19:59:48,854 [salt.loaded.int.module.cmdmod][INFO    ][25465] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2017-10-27 19:59:48,862 [salt.loaded.int.module.cmdmod][INFO    ][25465] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-10-27 19:59:48,869 [salt.loaded.int.module.cmdmod][INFO    ][25465] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-10-27 19:59:48,875 [salt.state       ][INFO    ][25465] {'keepalived': True}
2017-10-27 19:59:48,876 [salt.state       ][INFO    ][25465] Completed state [keepalived] at time 19:59:48.875603 duration_in_ms=86.306
2017-10-27 19:59:48,877 [salt.minion      ][INFO    ][25465] Returning information for job: 20171027195942813314
2017-10-27 20:00:33,642 [salt.minion      ][INFO    ][24712] User sudo_ubuntu Executing command pillar.get with jid 20171027200033630413
2017-10-27 20:00:33,657 [salt.minion      ][INFO    ][27063] Starting a new job with PID 27063
2017-10-27 20:00:33,661 [salt.minion      ][INFO    ][27063] Returning information for job: 20171027200033630413
2017-10-27 20:05:11,449 [salt.minion      ][INFO    ][24712] User sudo_ubuntu Executing command state.sls with jid 20171027200511435264
2017-10-27 20:05:11,461 [salt.minion      ][INFO    ][27149] Starting a new job with PID 27149
2017-10-27 20:05:13,626 [salt.state       ][INFO    ][27149] Loading fresh modules for state activity
2017-10-27 20:05:13,656 [salt.fileclient  ][INFO    ][27149] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-10-27 20:05:13,682 [salt.fileclient  ][INFO    ][27149] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-10-27 20:05:13,983 [salt.state       ][INFO    ][27149] Running state [attr] at time 20:05:13.982597
2017-10-27 20:05:13,983 [salt.state       ][INFO    ][27149] Executing state pkg.installed for attr
2017-10-27 20:05:13,983 [salt.loaded.int.module.cmdmod][INFO    ][27149] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-10-27 20:05:14,278 [salt.loaded.int.module.cmdmod][INFO    ][27149] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-10-27 20:05:16,176 [salt.loaded.int.module.cmdmod][INFO    ][27149] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'attr'] in directory '/root'
2017-10-27 20:05:17,460 [salt.loaded.int.module.cmdmod][INFO    ][27149] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-10-27 20:05:17,487 [salt.state       ][INFO    ][27149] Made the following changes:
'attr' changed from 'absent' to '1:2.4.47-2'

2017-10-27 20:05:17,498 [salt.state       ][INFO    ][27149] Loading fresh modules for state activity
2017-10-27 20:05:17,515 [salt.state       ][INFO    ][27149] Completed state [attr] at time 20:05:17.515222 duration_in_ms=3532.626
2017-10-27 20:05:17,521 [salt.state       ][INFO    ][27149] Running state [glusterfs-server] at time 20:05:17.520603
2017-10-27 20:05:17,521 [salt.state       ][INFO    ][27149] Executing state pkg.installed for glusterfs-server
2017-10-27 20:05:17,745 [salt.loaded.int.module.cmdmod][INFO    ][27149] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'glusterfs-server'] in directory '/root'
2017-10-27 20:05:21,561 [salt.minion      ][INFO    ][24712] User sudo_ubuntu Executing command saltutil.find_job with jid 20171027200521544322
2017-10-27 20:05:21,571 [salt.minion      ][INFO    ][31017] Starting a new job with PID 31017
2017-10-27 20:05:21,581 [salt.minion      ][INFO    ][31017] Returning information for job: 20171027200521544322
2017-10-27 20:05:23,872 [salt.loaded.int.module.cmdmod][INFO    ][27149] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-10-27 20:05:23,901 [salt.state       ][INFO    ][27149] Made the following changes:
'keyutils' changed from 'absent' to '1.5.9-8ubuntu1'
'nfs-common' changed from 'absent' to '1:1.2.8-9ubuntu12.1'
'rpcbind' changed from 'absent' to '0.2.3-0.2'
'glusterfs-common' changed from 'absent' to '3.7.6-1ubuntu1'
'librdmacm1' changed from 'absent' to '1.0.21-1'
'libnfsidmap2' changed from 'absent' to '0.25-5'
'portmap' changed from 'absent' to '1'
'libattr1-dev' changed from 'absent' to '1:2.4.47-2'
'attr-dev' changed from 'absent' to '1'
'acl-dev' changed from 'absent' to '1'
'glusterfs-server' changed from 'absent' to '3.7.6-1ubuntu1'
'glusterfs-client' changed from 'absent' to '3.7.6-1ubuntu1'
'libpython2.7' changed from 'absent' to '2.7.12-1ubuntu0~16.04.1'
'nfs-client' changed from 'absent' to '1'
'liburcu4' changed from 'absent' to '0.9.1-3'
'libacl1-dev' changed from 'absent' to '2.2.52-3'
'libibverbs1' changed from 'absent' to '1.1.8-1.1ubuntu2'
'libtirpc1' changed from 'absent' to '0.2.5-1'

2017-10-27 20:05:23,911 [salt.state       ][INFO    ][27149] Loading fresh modules for state activity
2017-10-27 20:05:23,928 [salt.state       ][INFO    ][27149] Completed state [glusterfs-server] at time 20:05:23.928136 duration_in_ms=6407.532
2017-10-27 20:05:23,934 [salt.state       ][INFO    ][27149] Running state [bc] at time 20:05:23.933700
2017-10-27 20:05:23,934 [salt.state       ][INFO    ][27149] Executing state pkg.installed for bc
2017-10-27 20:05:24,230 [salt.loaded.int.module.cmdmod][INFO    ][27149] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'bc'] in directory '/root'
2017-10-27 20:05:25,585 [salt.loaded.int.module.cmdmod][INFO    ][27149] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-10-27 20:05:25,616 [salt.state       ][INFO    ][27149] Made the following changes:
'bc' changed from 'absent' to '1.06.95-9build1'

2017-10-27 20:05:25,625 [salt.state       ][INFO    ][27149] Loading fresh modules for state activity
2017-10-27 20:05:25,642 [salt.state       ][INFO    ][27149] Completed state [bc] at time 20:05:25.642125 duration_in_ms=1708.424
2017-10-27 20:05:25,713 [salt.state       ][INFO    ][27149] Running state [glusterfs-server] at time 20:05:25.712797
2017-10-27 20:05:25,713 [salt.state       ][INFO    ][27149] Executing state service.running for glusterfs-server
2017-10-27 20:05:25,715 [salt.loaded.int.module.cmdmod][INFO    ][27149] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-10-27 20:05:25,725 [salt.loaded.int.module.cmdmod][INFO    ][27149] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-10-27 20:05:25,732 [salt.loaded.int.module.cmdmod][INFO    ][27149] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-10-27 20:05:25,740 [salt.state       ][INFO    ][27149] The service glusterfs-server is already running
2017-10-27 20:05:25,741 [salt.state       ][INFO    ][27149] Completed state [glusterfs-server] at time 20:05:25.740662 duration_in_ms=27.866
2017-10-27 20:05:25,742 [salt.state       ][INFO    ][27149] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 20:05:25.742145
2017-10-27 20:05:25,742 [salt.state       ][INFO    ][27149] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-10-27 20:05:25,749 [salt.state       ][INFO    ][27149] File changed:
New file
2017-10-27 20:05:25,749 [salt.state       ][INFO    ][27149] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 20:05:25.749289 duration_in_ms=7.144
2017-10-27 20:05:25,749 [salt.state       ][INFO    ][27149] Running state [/srv/glusterfs/glance] at time 20:05:25.749467
2017-10-27 20:05:25,750 [salt.state       ][INFO    ][27149] Executing state file.directory for /srv/glusterfs/glance
2017-10-27 20:05:25,750 [salt.state       ][INFO    ][27149] {'/srv/glusterfs/glance': 'New Dir'}
2017-10-27 20:05:25,751 [salt.state       ][INFO    ][27149] Completed state [/srv/glusterfs/glance] at time 20:05:25.750471 duration_in_ms=1.004
2017-10-27 20:05:25,751 [salt.state       ][INFO    ][27149] Running state [/srv/glusterfs/keystone-keys] at time 20:05:25.750645
2017-10-27 20:05:25,751 [salt.state       ][INFO    ][27149] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-10-27 20:05:25,751 [salt.state       ][INFO    ][27149] {'/srv/glusterfs/keystone-keys': 'New Dir'}
2017-10-27 20:05:25,752 [salt.state       ][INFO    ][27149] Completed state [/srv/glusterfs/keystone-keys] at time 20:05:25.751509 duration_in_ms=0.864
2017-10-27 20:05:25,752 [salt.state       ][INFO    ][27149] Running state [/srv/glusterfs/nova_instances] at time 20:05:25.751678
2017-10-27 20:05:25,752 [salt.state       ][INFO    ][27149] Executing state file.directory for /srv/glusterfs/nova_instances
2017-10-27 20:05:25,752 [salt.state       ][INFO    ][27149] {'/srv/glusterfs/nova_instances': 'New Dir'}
2017-10-27 20:05:25,753 [salt.state       ][INFO    ][27149] Completed state [/srv/glusterfs/nova_instances] at time 20:05:25.752491 duration_in_ms=0.812
2017-10-27 20:05:25,753 [salt.state       ][INFO    ][27149] Running state [/srv/glusterfs/keystone-credential-keys] at time 20:05:25.752666
2017-10-27 20:05:25,753 [salt.state       ][INFO    ][27149] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-10-27 20:05:25,753 [salt.state       ][INFO    ][27149] {'/srv/glusterfs/keystone-credential-keys': 'New Dir'}
2017-10-27 20:05:25,754 [salt.state       ][INFO    ][27149] Completed state [/srv/glusterfs/keystone-credential-keys] at time 20:05:25.753476 duration_in_ms=0.81
2017-10-27 20:05:25,754 [salt.minion      ][INFO    ][27149] Returning information for job: 20171027200511435264
2017-10-27 20:05:34,902 [salt.minion      ][INFO    ][24712] User sudo_ubuntu Executing command test.ping with jid 20171027200534888220
2017-10-27 20:05:34,914 [salt.minion      ][INFO    ][31908] Starting a new job with PID 31908
2017-10-27 20:05:34,949 [salt.minion      ][INFO    ][31908] Returning information for job: 20171027200534888220
2017-10-27 20:06:08,840 [salt.minion      ][INFO    ][24712] User sudo_ubuntu Executing command state.sls with jid 20171027200608820361
2017-10-27 20:06:08,850 [salt.minion      ][INFO    ][32133] Starting a new job with PID 32133
2017-10-27 20:06:09,428 [salt.state       ][INFO    ][32133] Loading fresh modules for state activity
2017-10-27 20:06:09,462 [salt.fileclient  ][INFO    ][32133] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/setup.sls'
2017-10-27 20:06:09,507 [salt.fileclient  ][INFO    ][32133] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-10-27 20:06:09,592 [salt.fileclient  ][INFO    ][32133] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-10-27 20:06:09,620 [salt.fileclient  ][INFO    ][32133] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-10-27 20:06:09,921 [salt.state       ][INFO    ][32133] Running state [attr] at time 20:06:09.921415
2017-10-27 20:06:09,922 [salt.state       ][INFO    ][32133] Executing state pkg.installed for attr
2017-10-27 20:06:09,922 [salt.loaded.int.module.cmdmod][INFO    ][32133] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-10-27 20:06:10,221 [salt.state       ][INFO    ][32133] Package attr is already installed
2017-10-27 20:06:10,221 [salt.state       ][INFO    ][32133] Completed state [attr] at time 20:06:10.221319 duration_in_ms=299.904
2017-10-27 20:06:10,222 [salt.state       ][INFO    ][32133] Running state [glusterfs-server] at time 20:06:10.221613
2017-10-27 20:06:10,222 [salt.state       ][INFO    ][32133] Executing state pkg.installed for glusterfs-server
2017-10-27 20:06:10,226 [salt.state       ][INFO    ][32133] Package glusterfs-server is already installed
2017-10-27 20:06:10,226 [salt.state       ][INFO    ][32133] Completed state [glusterfs-server] at time 20:06:10.225729 duration_in_ms=4.115
2017-10-27 20:06:10,226 [salt.state       ][INFO    ][32133] Running state [bc] at time 20:06:10.225925
2017-10-27 20:06:10,226 [salt.state       ][INFO    ][32133] Executing state pkg.installed for bc
2017-10-27 20:06:10,230 [salt.state       ][INFO    ][32133] Package bc is already installed
2017-10-27 20:06:10,230 [salt.state       ][INFO    ][32133] Completed state [bc] at time 20:06:10.229870 duration_in_ms=3.945
2017-10-27 20:06:10,231 [salt.state       ][INFO    ][32133] Running state [glusterfs-server] at time 20:06:10.230857
2017-10-27 20:06:10,231 [salt.state       ][INFO    ][32133] Executing state service.running for glusterfs-server
2017-10-27 20:06:10,232 [salt.loaded.int.module.cmdmod][INFO    ][32133] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-10-27 20:06:10,241 [salt.loaded.int.module.cmdmod][INFO    ][32133] Executing command ['systemctl', '--system', 'daemon-reload'] in directory '/root'
2017-10-27 20:06:10,288 [salt.loaded.int.module.cmdmod][INFO    ][32133] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-10-27 20:06:10,300 [salt.loaded.int.module.cmdmod][INFO    ][32133] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-10-27 20:06:10,305 [salt.loaded.int.module.cmdmod][INFO    ][32133] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-10-27 20:06:10,312 [salt.state       ][INFO    ][32133] The service glusterfs-server is already running
2017-10-27 20:06:10,313 [salt.state       ][INFO    ][32133] Completed state [glusterfs-server] at time 20:06:10.312553 duration_in_ms=81.695
2017-10-27 20:06:10,314 [salt.state       ][INFO    ][32133] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 20:06:10.313965
2017-10-27 20:06:10,314 [salt.state       ][INFO    ][32133] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-10-27 20:06:10,316 [salt.state       ][INFO    ][32133] File /etc/systemd/system/glusterfs-server.service.d/override.conf is in the correct state
2017-10-27 20:06:10,316 [salt.state       ][INFO    ][32133] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 20:06:10.316377 duration_in_ms=2.413
2017-10-27 20:06:10,317 [salt.state       ][INFO    ][32133] Running state [/srv/glusterfs/glance] at time 20:06:10.316583
2017-10-27 20:06:10,317 [salt.state       ][INFO    ][32133] Executing state file.directory for /srv/glusterfs/glance
2017-10-27 20:06:10,317 [salt.state       ][INFO    ][32133] Directory /srv/glusterfs/glance is in the correct state
2017-10-27 20:06:10,317 [salt.state       ][INFO    ][32133] Completed state [/srv/glusterfs/glance] at time 20:06:10.317344 duration_in_ms=0.761
2017-10-27 20:06:10,318 [salt.state       ][INFO    ][32133] Running state [/srv/glusterfs/keystone-keys] at time 20:06:10.317534
2017-10-27 20:06:10,318 [salt.state       ][INFO    ][32133] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-10-27 20:06:10,318 [salt.state       ][INFO    ][32133] Directory /srv/glusterfs/keystone-keys is in the correct state
2017-10-27 20:06:10,318 [salt.state       ][INFO    ][32133] Completed state [/srv/glusterfs/keystone-keys] at time 20:06:10.318272 duration_in_ms=0.738
2017-10-27 20:06:10,319 [salt.state       ][INFO    ][32133] Running state [/srv/glusterfs/nova_instances] at time 20:06:10.318498
2017-10-27 20:06:10,319 [salt.state       ][INFO    ][32133] Executing state file.directory for /srv/glusterfs/nova_instances
2017-10-27 20:06:10,319 [salt.state       ][INFO    ][32133] Directory /srv/glusterfs/nova_instances is in the correct state
2017-10-27 20:06:10,319 [salt.state       ][INFO    ][32133] Completed state [/srv/glusterfs/nova_instances] at time 20:06:10.319276 duration_in_ms=0.778
2017-10-27 20:06:10,319 [salt.state       ][INFO    ][32133] Running state [/srv/glusterfs/keystone-credential-keys] at time 20:06:10.319470
2017-10-27 20:06:10,320 [salt.state       ][INFO    ][32133] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-10-27 20:06:10,320 [salt.state       ][INFO    ][32133] Directory /srv/glusterfs/keystone-credential-keys is in the correct state
2017-10-27 20:06:10,320 [salt.state       ][INFO    ][32133] Completed state [/srv/glusterfs/keystone-credential-keys] at time 20:06:10.320168 duration_in_ms=0.697
2017-10-27 20:06:10,387 [salt.loaded.int.module.cmdmod][INFO    ][32133] Executing command ['git', '--version'] in directory '/root'
2017-10-27 20:06:10,463 [salt.state       ][INFO    ][32133] Running state [sleep 5] at time 20:06:10.462774
2017-10-27 20:06:10,463 [salt.state       ][INFO    ][32133] Executing state cmd.wait for sleep 5
2017-10-27 20:06:10,463 [salt.state       ][INFO    ][32133] No changes made for sleep 5
2017-10-27 20:06:10,464 [salt.state       ][INFO    ][32133] Completed state [sleep 5] at time 20:06:10.463477 duration_in_ms=0.704
2017-10-27 20:06:10,464 [salt.state       ][INFO    ][32133] Running state [192.168.10.143] at time 20:06:10.464023
2017-10-27 20:06:10,464 [salt.state       ][INFO    ][32133] Executing state glusterfs.peered for 192.168.10.143
2017-10-27 20:06:10,465 [salt.loaded.int.module.cmdmod][INFO    ][32133] Executing command 'gluster --version' in directory '/root'
2017-10-27 20:06:10,473 [salt.loaded.int.module.cmdmod][INFO    ][32133] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 20:06:10,525 [salt.state       ][INFO    ][32133] Host 192.168.10.143 already peered
2017-10-27 20:06:10,526 [salt.state       ][INFO    ][32133] Completed state [192.168.10.143] at time 20:06:10.525473 duration_in_ms=61.45
2017-10-27 20:06:10,528 [salt.state       ][INFO    ][32133] Running state [192.168.10.142] at time 20:06:10.528460
2017-10-27 20:06:10,529 [salt.state       ][INFO    ][32133] Executing state glusterfs.peered for 192.168.10.142
2017-10-27 20:06:10,529 [salt.loaded.int.module.cmdmod][INFO    ][32133] Executing command 'gluster --version' in directory '/root'
2017-10-27 20:06:10,537 [salt.loaded.int.module.cmdmod][INFO    ][32133] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 20:06:10,587 [salt.state       ][INFO    ][32133] Host 192.168.10.142 already peered
2017-10-27 20:06:10,588 [salt.state       ][INFO    ][32133] Completed state [192.168.10.142] at time 20:06:10.587653 duration_in_ms=59.193
2017-10-27 20:06:10,591 [salt.state       ][INFO    ][32133] Running state [192.168.10.141] at time 20:06:10.590473
2017-10-27 20:06:10,591 [salt.state       ][INFO    ][32133] Executing state glusterfs.peered for 192.168.10.141
2017-10-27 20:06:10,591 [salt.loaded.int.module.cmdmod][INFO    ][32133] Executing command 'gluster --version' in directory '/root'
2017-10-27 20:06:10,599 [salt.loaded.int.module.cmdmod][INFO    ][32133] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 20:06:10,648 [salt.loaded.int.module.cmdmod][INFO    ][32133] Executing command 'gluster --version' in directory '/root'
2017-10-27 20:06:10,655 [salt.loaded.int.module.cmdmod][INFO    ][32133] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 20:06:10,708 [salt.loaded.int.module.cmdmod][INFO    ][32133] Executing command 'gluster --version' in directory '/root'
2017-10-27 20:06:10,715 [salt.loaded.int.module.cmdmod][INFO    ][32133] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 20:06:10,765 [salt.loaded.int.module.cmdmod][INFO    ][32133] Executing command 'gluster --version' in directory '/root'
2017-10-27 20:06:10,773 [salt.loaded.int.module.cmdmod][INFO    ][32133] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 20:06:10,823 [salt.state       ][INFO    ][32133] Peering with localhost is not needed
2017-10-27 20:06:10,824 [salt.state       ][INFO    ][32133] Completed state [192.168.10.141] at time 20:06:10.823489 duration_in_ms=233.015
2017-10-27 20:06:10,824 [salt.state       ][INFO    ][32133] Running state [glance] at time 20:06:10.824452
2017-10-27 20:06:10,825 [salt.state       ][INFO    ][32133] Executing state glusterfs.created for glance
2017-10-27 20:06:10,825 [salt.loaded.int.module.cmdmod][INFO    ][32133] Executing command 'gluster --version' in directory '/root'
2017-10-27 20:06:10,833 [salt.loaded.int.module.cmdmod][INFO    ][32133] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 20:06:10,885 [salt.loaded.int.module.cmdmod][INFO    ][32133] Executing command 'gluster --version' in directory '/root'
2017-10-27 20:06:10,892 [salt.loaded.int.module.cmdmod][INFO    ][32133] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 20:06:10,949 [salt.state       ][INFO    ][32133] Volume glance already exists and is started.
2017-10-27 20:06:10,950 [salt.state       ][INFO    ][32133] Completed state [glance] at time 20:06:10.949480 duration_in_ms=125.027
2017-10-27 20:06:10,953 [salt.state       ][INFO    ][32133] Running state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 20:06:10.953173
2017-10-27 20:06:10,953 [salt.state       ][INFO    ][32133] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'
2017-10-27 20:06:10,954 [salt.loaded.int.module.cmdmod][INFO    ][32133] Executing command 'gluster volume info 'glance' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-10-27 20:06:11,005 [salt.state       ][INFO    ][32133] unless execution succeeded
2017-10-27 20:06:11,005 [salt.state       ][INFO    ][32133] Completed state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 20:06:11.005129 duration_in_ms=51.955
2017-10-27 20:06:11,006 [salt.state       ][INFO    ][32133] Running state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 20:06:11.005656
2017-10-27 20:06:11,006 [salt.state       ][INFO    ][32133] Executing state cmd.run for gluster volume set 'glance' 'network.remote-dio' 'True'
2017-10-27 20:06:11,006 [salt.loaded.int.module.cmdmod][INFO    ][32133] Executing command 'gluster volume info 'glance' | grep 'network.remote-dio: True'' in directory '/root'
2017-10-27 20:06:11,058 [salt.state       ][INFO    ][32133] unless execution succeeded
2017-10-27 20:06:11,058 [salt.state       ][INFO    ][32133] Completed state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 20:06:11.057755 duration_in_ms=52.099
2017-10-27 20:06:11,058 [salt.state       ][INFO    ][32133] Running state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 20:06:11.058297
2017-10-27 20:06:11,059 [salt.state       ][INFO    ][32133] Executing state cmd.run for gluster volume set 'glance' 'nfs.disable' 'True'
2017-10-27 20:06:11,059 [salt.loaded.int.module.cmdmod][INFO    ][32133] Executing command 'gluster volume info 'glance' | grep 'nfs.disable: True'' in directory '/root'
2017-10-27 20:06:11,110 [salt.state       ][INFO    ][32133] unless execution succeeded
2017-10-27 20:06:11,110 [salt.state       ][INFO    ][32133] Completed state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 20:06:11.110171 duration_in_ms=51.873
2017-10-27 20:06:11,111 [salt.state       ][INFO    ][32133] Running state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 20:06:11.110762
2017-10-27 20:06:11,111 [salt.state       ][INFO    ][32133] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'
2017-10-27 20:06:11,112 [salt.loaded.int.module.cmdmod][INFO    ][32133] Executing command 'gluster volume info 'glance' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-10-27 20:06:11,161 [salt.state       ][INFO    ][32133] unless execution succeeded
2017-10-27 20:06:11,161 [salt.state       ][INFO    ][32133] Completed state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 20:06:11.160873 duration_in_ms=50.111
2017-10-27 20:06:11,162 [salt.state       ][INFO    ][32133] Running state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 20:06:11.161489
2017-10-27 20:06:11,162 [salt.state       ][INFO    ][32133] Executing state cmd.run for gluster volume set 'glance' 'cluster.readdir-optimize' 'True'
2017-10-27 20:06:11,162 [salt.loaded.int.module.cmdmod][INFO    ][32133] Executing command 'gluster volume info 'glance' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-10-27 20:06:11,214 [salt.state       ][INFO    ][32133] unless execution succeeded
2017-10-27 20:06:11,214 [salt.state       ][INFO    ][32133] Completed state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 20:06:11.214162 duration_in_ms=52.672
2017-10-27 20:06:11,216 [salt.state       ][INFO    ][32133] Running state [glance] at time 20:06:11.215564
2017-10-27 20:06:11,216 [salt.state       ][INFO    ][32133] Executing state glusterfs.started for glance
2017-10-27 20:06:11,216 [salt.loaded.int.module.cmdmod][INFO    ][32133] Executing command 'gluster --version' in directory '/root'
2017-10-27 20:06:11,224 [salt.loaded.int.module.cmdmod][INFO    ][32133] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 20:06:11,275 [salt.loaded.int.module.cmdmod][INFO    ][32133] Executing command 'gluster --version' in directory '/root'
2017-10-27 20:06:11,282 [salt.loaded.int.module.cmdmod][INFO    ][32133] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 20:06:11,339 [salt.state       ][INFO    ][32133] Volume glance is already started
2017-10-27 20:06:11,339 [salt.state       ][INFO    ][32133] Completed state [glance] at time 20:06:11.339417 duration_in_ms=123.843
2017-10-27 20:06:11,341 [salt.state       ][INFO    ][32133] Running state [keystone-keys] at time 20:06:11.340498
2017-10-27 20:06:11,341 [salt.state       ][INFO    ][32133] Executing state glusterfs.created for keystone-keys
2017-10-27 20:06:11,341 [salt.loaded.int.module.cmdmod][INFO    ][32133] Executing command 'gluster --version' in directory '/root'
2017-10-27 20:06:11,349 [salt.loaded.int.module.cmdmod][INFO    ][32133] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 20:06:11,400 [salt.loaded.int.module.cmdmod][INFO    ][32133] Executing command 'gluster --version' in directory '/root'
2017-10-27 20:06:11,408 [salt.loaded.int.module.cmdmod][INFO    ][32133] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 20:06:11,465 [salt.state       ][INFO    ][32133] Volume keystone-keys already exists and is started.
2017-10-27 20:06:11,465 [salt.state       ][INFO    ][32133] Completed state [keystone-keys] at time 20:06:11.465043 duration_in_ms=124.544
2017-10-27 20:06:11,473 [salt.state       ][INFO    ][32133] Running state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 20:06:11.472593
2017-10-27 20:06:11,474 [salt.state       ][INFO    ][32133] Executing state cmd.run for gluster volume set 'keystone-keys' 'network.remote-dio' 'True'
2017-10-27 20:06:11,475 [salt.loaded.int.module.cmdmod][INFO    ][32133] Executing command 'gluster volume info 'keystone-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-10-27 20:06:11,529 [salt.state       ][INFO    ][32133] unless execution succeeded
2017-10-27 20:06:11,529 [salt.state       ][INFO    ][32133] Completed state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 20:06:11.528745 duration_in_ms=56.157
2017-10-27 20:06:11,529 [salt.state       ][INFO    ][32133] Running state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 20:06:11.529314
2017-10-27 20:06:11,530 [salt.state       ][INFO    ][32133] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-10-27 20:06:11,530 [salt.loaded.int.module.cmdmod][INFO    ][32133] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-10-27 20:06:11,582 [salt.state       ][INFO    ][32133] unless execution succeeded
2017-10-27 20:06:11,582 [salt.state       ][INFO    ][32133] Completed state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 20:06:11.581933 duration_in_ms=52.619
2017-10-27 20:06:11,582 [salt.state       ][INFO    ][32133] Running state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 20:06:11.582453
2017-10-27 20:06:11,583 [salt.state       ][INFO    ][32133] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'
2017-10-27 20:06:11,583 [salt.loaded.int.module.cmdmod][INFO    ][32133] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-10-27 20:06:11,635 [salt.state       ][INFO    ][32133] unless execution succeeded
2017-10-27 20:06:11,635 [salt.state       ][INFO    ][32133] Completed state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 20:06:11.635212 duration_in_ms=52.759
2017-10-27 20:06:11,636 [salt.state       ][INFO    ][32133] Running state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 20:06:11.635858
2017-10-27 20:06:11,636 [salt.state       ][INFO    ][32133] Executing state cmd.run for gluster volume set 'keystone-keys' 'nfs.disable' 'True'
2017-10-27 20:06:11,637 [salt.loaded.int.module.cmdmod][INFO    ][32133] Executing command 'gluster volume info 'keystone-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-10-27 20:06:11,688 [salt.state       ][INFO    ][32133] unless execution succeeded
2017-10-27 20:06:11,688 [salt.state       ][INFO    ][32133] Completed state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 20:06:11.687717 duration_in_ms=51.858
2017-10-27 20:06:11,688 [salt.state       ][INFO    ][32133] Running state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 20:06:11.688259
2017-10-27 20:06:11,689 [salt.state       ][INFO    ][32133] Executing state cmd.run for gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'
2017-10-27 20:06:11,689 [salt.loaded.int.module.cmdmod][INFO    ][32133] Executing command 'gluster volume info 'keystone-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-10-27 20:06:11,741 [salt.state       ][INFO    ][32133] unless execution succeeded
2017-10-27 20:06:11,741 [salt.state       ][INFO    ][32133] Completed state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 20:06:11.741131 duration_in_ms=52.872
2017-10-27 20:06:11,743 [salt.state       ][INFO    ][32133] Running state [keystone-keys] at time 20:06:11.742546
2017-10-27 20:06:11,743 [salt.state       ][INFO    ][32133] Executing state glusterfs.started for keystone-keys
2017-10-27 20:06:11,744 [salt.loaded.int.module.cmdmod][INFO    ][32133] Executing command 'gluster --version' in directory '/root'
2017-10-27 20:06:11,752 [salt.loaded.int.module.cmdmod][INFO    ][32133] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 20:06:11,802 [salt.loaded.int.module.cmdmod][INFO    ][32133] Executing command 'gluster --version' in directory '/root'
2017-10-27 20:06:11,809 [salt.loaded.int.module.cmdmod][INFO    ][32133] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 20:06:11,865 [salt.state       ][INFO    ][32133] Volume keystone-keys is already started
2017-10-27 20:06:11,865 [salt.state       ][INFO    ][32133] Completed state [keystone-keys] at time 20:06:11.865095 duration_in_ms=122.548
2017-10-27 20:06:11,867 [salt.state       ][INFO    ][32133] Running state [nova_instances] at time 20:06:11.866932
2017-10-27 20:06:11,867 [salt.state       ][INFO    ][32133] Executing state glusterfs.created for nova_instances
2017-10-27 20:06:11,868 [salt.loaded.int.module.cmdmod][INFO    ][32133] Executing command 'gluster --version' in directory '/root'
2017-10-27 20:06:11,875 [salt.loaded.int.module.cmdmod][INFO    ][32133] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 20:06:11,925 [salt.loaded.int.module.cmdmod][INFO    ][32133] Executing command 'gluster --version' in directory '/root'
2017-10-27 20:06:11,933 [salt.loaded.int.module.cmdmod][INFO    ][32133] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 20:06:11,990 [salt.state       ][INFO    ][32133] Volume nova_instances already exists and is started.
2017-10-27 20:06:11,990 [salt.state       ][INFO    ][32133] Completed state [nova_instances] at time 20:06:11.989749 duration_in_ms=122.815
2017-10-27 20:06:11,994 [salt.state       ][INFO    ][32133] Running state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 20:06:11.993745
2017-10-27 20:06:11,994 [salt.state       ][INFO    ][32133] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'
2017-10-27 20:06:11,995 [salt.loaded.int.module.cmdmod][INFO    ][32133] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-10-27 20:06:12,045 [salt.state       ][INFO    ][32133] unless execution succeeded
2017-10-27 20:06:12,045 [salt.state       ][INFO    ][32133] Completed state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 20:06:12.045338 duration_in_ms=51.592
2017-10-27 20:06:12,046 [salt.state       ][INFO    ][32133] Running state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'On'] at time 20:06:12.045921
2017-10-27 20:06:12,046 [salt.state       ][INFO    ][32133] Executing state cmd.run for gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'On'
2017-10-27 20:06:12,047 [salt.loaded.int.module.cmdmod][INFO    ][32133] Executing command 'gluster volume info 'nova_instances' | grep 'cluster.readdir-optimize: On'' in directory '/root'
2017-10-27 20:06:12,097 [salt.state       ][INFO    ][32133] unless execution succeeded
2017-10-27 20:06:12,097 [salt.state       ][INFO    ][32133] Completed state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'On'] at time 20:06:12.097255 duration_in_ms=51.334
2017-10-27 20:06:12,098 [salt.state       ][INFO    ][32133] Running state [gluster volume set 'nova_instances' 'network.remote-dio' 'On'] at time 20:06:12.097840
2017-10-27 20:06:12,098 [salt.state       ][INFO    ][32133] Executing state cmd.run for gluster volume set 'nova_instances' 'network.remote-dio' 'On'
2017-10-27 20:06:12,099 [salt.loaded.int.module.cmdmod][INFO    ][32133] Executing command 'gluster volume info 'nova_instances' | grep 'network.remote-dio: On'' in directory '/root'
2017-10-27 20:06:12,150 [salt.state       ][INFO    ][32133] unless execution succeeded
2017-10-27 20:06:12,150 [salt.state       ][INFO    ][32133] Completed state [gluster volume set 'nova_instances' 'network.remote-dio' 'On'] at time 20:06:12.150028 duration_in_ms=52.188
2017-10-27 20:06:12,151 [salt.state       ][INFO    ][32133] Running state [gluster volume set 'nova_instances' 'nfs.disable' 'On'] at time 20:06:12.150653
2017-10-27 20:06:12,151 [salt.state       ][INFO    ][32133] Executing state cmd.run for gluster volume set 'nova_instances' 'nfs.disable' 'On'
2017-10-27 20:06:12,151 [salt.loaded.int.module.cmdmod][INFO    ][32133] Executing command 'gluster volume info 'nova_instances' | grep 'nfs.disable: On'' in directory '/root'
2017-10-27 20:06:12,203 [salt.state       ][INFO    ][32133] unless execution succeeded
2017-10-27 20:06:12,203 [salt.state       ][INFO    ][32133] Completed state [gluster volume set 'nova_instances' 'nfs.disable' 'On'] at time 20:06:12.202849 duration_in_ms=52.196
2017-10-27 20:06:12,204 [salt.state       ][INFO    ][32133] Running state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 20:06:12.203482
2017-10-27 20:06:12,204 [salt.state       ][INFO    ][32133] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'
2017-10-27 20:06:12,204 [salt.loaded.int.module.cmdmod][INFO    ][32133] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-10-27 20:06:12,256 [salt.state       ][INFO    ][32133] unless execution succeeded
2017-10-27 20:06:12,257 [salt.state       ][INFO    ][32133] Completed state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 20:06:12.256690 duration_in_ms=53.207
2017-10-27 20:06:12,258 [salt.state       ][INFO    ][32133] Running state [nova_instances] at time 20:06:12.257910
2017-10-27 20:06:12,258 [salt.state       ][INFO    ][32133] Executing state glusterfs.started for nova_instances
2017-10-27 20:06:12,259 [salt.loaded.int.module.cmdmod][INFO    ][32133] Executing command 'gluster --version' in directory '/root'
2017-10-27 20:06:12,266 [salt.loaded.int.module.cmdmod][INFO    ][32133] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 20:06:12,317 [salt.loaded.int.module.cmdmod][INFO    ][32133] Executing command 'gluster --version' in directory '/root'
2017-10-27 20:06:12,326 [salt.loaded.int.module.cmdmod][INFO    ][32133] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 20:06:12,383 [salt.state       ][INFO    ][32133] Volume nova_instances is already started
2017-10-27 20:06:12,383 [salt.state       ][INFO    ][32133] Completed state [nova_instances] at time 20:06:12.382747 duration_in_ms=124.837
2017-10-27 20:06:12,384 [salt.state       ][INFO    ][32133] Running state [keystone-credential-keys] at time 20:06:12.383852
2017-10-27 20:06:12,384 [salt.state       ][INFO    ][32133] Executing state glusterfs.created for keystone-credential-keys
2017-10-27 20:06:12,385 [salt.loaded.int.module.cmdmod][INFO    ][32133] Executing command 'gluster --version' in directory '/root'
2017-10-27 20:06:12,393 [salt.loaded.int.module.cmdmod][INFO    ][32133] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 20:06:12,443 [salt.loaded.int.module.cmdmod][INFO    ][32133] Executing command 'gluster --version' in directory '/root'
2017-10-27 20:06:12,450 [salt.loaded.int.module.cmdmod][INFO    ][32133] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 20:06:12,504 [salt.state       ][INFO    ][32133] Volume keystone-credential-keys already exists and is started.
2017-10-27 20:06:12,505 [salt.state       ][INFO    ][32133] Completed state [keystone-credential-keys] at time 20:06:12.504508 duration_in_ms=120.654
2017-10-27 20:06:12,509 [salt.state       ][INFO    ][32133] Running state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 20:06:12.508550
2017-10-27 20:06:12,509 [salt.state       ][INFO    ][32133] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'
2017-10-27 20:06:12,509 [salt.loaded.int.module.cmdmod][INFO    ][32133] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-10-27 20:06:12,560 [salt.state       ][INFO    ][32133] unless execution succeeded
2017-10-27 20:06:12,560 [salt.state       ][INFO    ][32133] Completed state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 20:06:12.560240 duration_in_ms=51.69
2017-10-27 20:06:12,561 [salt.state       ][INFO    ][32133] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 20:06:12.560824
2017-10-27 20:06:12,561 [salt.state       ][INFO    ][32133] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-10-27 20:06:12,562 [salt.loaded.int.module.cmdmod][INFO    ][32133] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-10-27 20:06:12,610 [salt.state       ][INFO    ][32133] unless execution succeeded
2017-10-27 20:06:12,610 [salt.state       ][INFO    ][32133] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 20:06:12.609929 duration_in_ms=49.104
2017-10-27 20:06:12,610 [salt.state       ][INFO    ][32133] Running state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 20:06:12.610469
2017-10-27 20:06:12,611 [salt.state       ][INFO    ][32133] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'
2017-10-27 20:06:12,611 [salt.loaded.int.module.cmdmod][INFO    ][32133] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-10-27 20:06:12,662 [salt.state       ][INFO    ][32133] unless execution succeeded
2017-10-27 20:06:12,662 [salt.state       ][INFO    ][32133] Completed state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 20:06:12.662057 duration_in_ms=51.588
2017-10-27 20:06:12,663 [salt.state       ][INFO    ][32133] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 20:06:12.662707
2017-10-27 20:06:12,663 [salt.state       ][INFO    ][32133] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'
2017-10-27 20:06:12,664 [salt.loaded.int.module.cmdmod][INFO    ][32133] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-10-27 20:06:12,715 [salt.state       ][INFO    ][32133] unless execution succeeded
2017-10-27 20:06:12,716 [salt.state       ][INFO    ][32133] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 20:06:12.715473 duration_in_ms=52.765
2017-10-27 20:06:12,716 [salt.state       ][INFO    ][32133] Running state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 20:06:12.716081
2017-10-27 20:06:12,716 [salt.state       ][INFO    ][32133] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'
2017-10-27 20:06:12,717 [salt.loaded.int.module.cmdmod][INFO    ][32133] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-10-27 20:06:12,768 [salt.state       ][INFO    ][32133] unless execution succeeded
2017-10-27 20:06:12,769 [salt.state       ][INFO    ][32133] Completed state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 20:06:12.768725 duration_in_ms=52.631
2017-10-27 20:06:12,770 [salt.state       ][INFO    ][32133] Running state [keystone-credential-keys] at time 20:06:12.770030
2017-10-27 20:06:12,770 [salt.state       ][INFO    ][32133] Executing state glusterfs.started for keystone-credential-keys
2017-10-27 20:06:12,771 [salt.loaded.int.module.cmdmod][INFO    ][32133] Executing command 'gluster --version' in directory '/root'
2017-10-27 20:06:12,778 [salt.loaded.int.module.cmdmod][INFO    ][32133] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 20:06:12,828 [salt.loaded.int.module.cmdmod][INFO    ][32133] Executing command 'gluster --version' in directory '/root'
2017-10-27 20:06:12,836 [salt.loaded.int.module.cmdmod][INFO    ][32133] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 20:06:12,891 [salt.state       ][INFO    ][32133] Volume keystone-credential-keys is already started
2017-10-27 20:06:12,892 [salt.state       ][INFO    ][32133] Completed state [keystone-credential-keys] at time 20:06:12.891685 duration_in_ms=121.655
2017-10-27 20:06:12,894 [salt.minion      ][INFO    ][32133] Returning information for job: 20171027200608820361
2017-10-27 20:06:13,944 [salt.minion      ][INFO    ][24712] User sudo_ubuntu Executing command test.ping with jid 20171027200613929097
2017-10-27 20:06:13,954 [salt.minion      ][INFO    ][32535] Starting a new job with PID 32535
2017-10-27 20:06:13,988 [salt.minion      ][INFO    ][32535] Returning information for job: 20171027200613929097
2017-10-27 20:06:14,741 [salt.minion      ][INFO    ][24712] User sudo_ubuntu Executing command cmd.run with jid 20171027200614725035
2017-10-27 20:06:14,752 [salt.minion      ][INFO    ][32540] Starting a new job with PID 32540
2017-10-27 20:06:14,756 [salt.loaded.int.module.cmdmod][INFO    ][32540] Executing command 'gluster peer status; gluster volume status' in directory '/root'
2017-10-27 20:06:14,871 [salt.minion      ][INFO    ][32540] Returning information for job: 20171027200614725035
2017-10-27 20:46:11,325 [salt.minion      ][INFO    ][24712] User sudo_ubuntu Executing command test.ping with jid 20171027204611312459
2017-10-27 20:46:11,341 [salt.minion      ][INFO    ][33263] Starting a new job with PID 33263
2017-10-27 20:46:11,393 [salt.minion      ][INFO    ][33263] Returning information for job: 20171027204611312459
2017-10-27 20:46:18,179 [salt.minion      ][INFO    ][24712] User sudo_ubuntu Executing command state.sls with jid 20171027204618166914
2017-10-27 20:46:18,191 [salt.minion      ][INFO    ][33269] Starting a new job with PID 33269
2017-10-27 20:46:18,771 [salt.state       ][INFO    ][33269] Loading fresh modules for state activity
2017-10-27 20:46:18,799 [salt.fileclient  ][INFO    ][33269] Fetching file from saltenv 'base', ** done ** 'keepalived/init.sls'
2017-10-27 20:46:18,818 [salt.fileclient  ][INFO    ][33269] Fetching file from saltenv 'base', ** done ** 'keepalived/cluster.sls'
2017-10-27 20:46:18,850 [salt.fileclient  ][INFO    ][33269] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-10-27 20:46:19,143 [salt.state       ][INFO    ][33269] Running state [lsof] at time 20:46:19.143315
2017-10-27 20:46:19,144 [salt.state       ][INFO    ][33269] Executing state pkg.installed for lsof
2017-10-27 20:46:19,144 [salt.loaded.int.module.cmdmod][INFO    ][33269] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-10-27 20:46:19,398 [salt.state       ][INFO    ][33269] Package lsof is already installed
2017-10-27 20:46:19,399 [salt.state       ][INFO    ][33269] Completed state [lsof] at time 20:46:19.398590 duration_in_ms=255.275
2017-10-27 20:46:19,399 [salt.state       ][INFO    ][33269] Running state [keepalived] at time 20:46:19.398861
2017-10-27 20:46:19,399 [salt.state       ][INFO    ][33269] Executing state pkg.installed for keepalived
2017-10-27 20:46:19,403 [salt.state       ][INFO    ][33269] Package keepalived is already installed
2017-10-27 20:46:19,403 [salt.state       ][INFO    ][33269] Completed state [keepalived] at time 20:46:19.402879 duration_in_ms=4.018
2017-10-27 20:46:19,404 [salt.state       ][INFO    ][33269] Running state [/etc/keepalived/keepalived.conf] at time 20:46:19.404386
2017-10-27 20:46:19,405 [salt.state       ][INFO    ][33269] Executing state file.managed for /etc/keepalived/keepalived.conf
2017-10-27 20:46:19,434 [salt.fileclient  ][INFO    ][33269] Fetching file from saltenv 'base', ** done ** 'keepalived/files/keepalived.conf'
2017-10-27 20:46:19,474 [salt.fileclient  ][INFO    ][33269] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-10-27 20:46:19,480 [salt.state       ][INFO    ][33269] File /etc/keepalived/keepalived.conf is in the correct state
2017-10-27 20:46:19,480 [salt.state       ][INFO    ][33269] Completed state [/etc/keepalived/keepalived.conf] at time 20:46:19.479836 duration_in_ms=75.449
2017-10-27 20:46:19,480 [salt.state       ][INFO    ][33269] Running state [keepalived] at time 20:46:19.480456
2017-10-27 20:46:19,481 [salt.state       ][INFO    ][33269] Executing state service.running for keepalived
2017-10-27 20:46:19,481 [salt.loaded.int.module.cmdmod][INFO    ][33269] Executing command ['systemctl', 'status', 'keepalived.service', '-n', '0'] in directory '/root'
2017-10-27 20:46:19,496 [salt.loaded.int.module.cmdmod][INFO    ][33269] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2017-10-27 20:46:19,503 [salt.loaded.int.module.cmdmod][INFO    ][33269] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-10-27 20:46:19,510 [salt.state       ][INFO    ][33269] The service keepalived is already running
2017-10-27 20:46:19,510 [salt.state       ][INFO    ][33269] Completed state [keepalived] at time 20:46:19.510220 duration_in_ms=29.763
2017-10-27 20:46:19,511 [salt.minion      ][INFO    ][33269] Returning information for job: 20171027204618166914
2017-10-27 20:46:49,261 [salt.minion      ][INFO    ][24712] User sudo_ubuntu Executing command pillar.get with jid 20171027204649246891
2017-10-27 20:46:49,280 [salt.minion      ][INFO    ][33297] Starting a new job with PID 33297
2017-10-27 20:46:49,284 [salt.minion      ][INFO    ][33297] Returning information for job: 20171027204649246891
2017-10-27 20:47:39,830 [salt.minion      ][INFO    ][24712] User sudo_ubuntu Executing command state.sls with jid 20171027204739817899
2017-10-27 20:47:39,841 [salt.minion      ][INFO    ][33308] Starting a new job with PID 33308
2017-10-27 20:47:42,038 [salt.state       ][INFO    ][33308] Loading fresh modules for state activity
2017-10-27 20:47:42,063 [salt.fileclient  ][INFO    ][33308] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-10-27 20:47:42,085 [salt.fileclient  ][INFO    ][33308] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-10-27 20:47:42,390 [salt.state       ][INFO    ][33308] Running state [attr] at time 20:47:42.390096
2017-10-27 20:47:42,390 [salt.state       ][INFO    ][33308] Executing state pkg.installed for attr
2017-10-27 20:47:42,391 [salt.loaded.int.module.cmdmod][INFO    ][33308] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-10-27 20:47:42,661 [salt.state       ][INFO    ][33308] Package attr is already installed
2017-10-27 20:47:42,662 [salt.state       ][INFO    ][33308] Completed state [attr] at time 20:47:42.661747 duration_in_ms=271.65
2017-10-27 20:47:42,662 [salt.state       ][INFO    ][33308] Running state [glusterfs-server] at time 20:47:42.662034
2017-10-27 20:47:42,662 [salt.state       ][INFO    ][33308] Executing state pkg.installed for glusterfs-server
2017-10-27 20:47:42,666 [salt.state       ][INFO    ][33308] Package glusterfs-server is already installed
2017-10-27 20:47:42,666 [salt.state       ][INFO    ][33308] Completed state [glusterfs-server] at time 20:47:42.666146 duration_in_ms=4.111
2017-10-27 20:47:42,666 [salt.state       ][INFO    ][33308] Running state [bc] at time 20:47:42.666345
2017-10-27 20:47:42,667 [salt.state       ][INFO    ][33308] Executing state pkg.installed for bc
2017-10-27 20:47:42,670 [salt.state       ][INFO    ][33308] Package bc is already installed
2017-10-27 20:47:42,670 [salt.state       ][INFO    ][33308] Completed state [bc] at time 20:47:42.670341 duration_in_ms=3.996
2017-10-27 20:47:42,671 [salt.state       ][INFO    ][33308] Running state [glusterfs-server] at time 20:47:42.671186
2017-10-27 20:47:42,671 [salt.state       ][INFO    ][33308] Executing state service.running for glusterfs-server
2017-10-27 20:47:42,672 [salt.loaded.int.module.cmdmod][INFO    ][33308] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-10-27 20:47:42,687 [salt.loaded.int.module.cmdmod][INFO    ][33308] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-10-27 20:47:42,695 [salt.loaded.int.module.cmdmod][INFO    ][33308] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-10-27 20:47:42,704 [salt.state       ][INFO    ][33308] The service glusterfs-server is already running
2017-10-27 20:47:42,704 [salt.state       ][INFO    ][33308] Completed state [glusterfs-server] at time 20:47:42.704097 duration_in_ms=32.911
2017-10-27 20:47:42,706 [salt.state       ][INFO    ][33308] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 20:47:42.705819
2017-10-27 20:47:42,706 [salt.state       ][INFO    ][33308] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-10-27 20:47:42,708 [salt.state       ][INFO    ][33308] File /etc/systemd/system/glusterfs-server.service.d/override.conf is in the correct state
2017-10-27 20:47:42,708 [salt.state       ][INFO    ][33308] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 20:47:42.708137 duration_in_ms=2.319
2017-10-27 20:47:42,708 [salt.state       ][INFO    ][33308] Running state [/srv/glusterfs/glance] at time 20:47:42.708320
2017-10-27 20:47:42,708 [salt.state       ][INFO    ][33308] Executing state file.directory for /srv/glusterfs/glance
2017-10-27 20:47:42,709 [salt.state       ][INFO    ][33308] Directory /srv/glusterfs/glance is in the correct state
2017-10-27 20:47:42,709 [salt.state       ][INFO    ][33308] Completed state [/srv/glusterfs/glance] at time 20:47:42.709061 duration_in_ms=0.741
2017-10-27 20:47:42,709 [salt.state       ][INFO    ][33308] Running state [/srv/glusterfs/keystone-keys] at time 20:47:42.709226
2017-10-27 20:47:42,709 [salt.state       ][INFO    ][33308] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-10-27 20:47:42,710 [salt.state       ][INFO    ][33308] Directory /srv/glusterfs/keystone-keys is in the correct state
2017-10-27 20:47:42,710 [salt.state       ][INFO    ][33308] Completed state [/srv/glusterfs/keystone-keys] at time 20:47:42.709975 duration_in_ms=0.749
2017-10-27 20:47:42,710 [salt.state       ][INFO    ][33308] Running state [/srv/glusterfs/nova_instances] at time 20:47:42.710158
2017-10-27 20:47:42,710 [salt.state       ][INFO    ][33308] Executing state file.directory for /srv/glusterfs/nova_instances
2017-10-27 20:47:42,711 [salt.state       ][INFO    ][33308] Directory /srv/glusterfs/nova_instances is in the correct state
2017-10-27 20:47:42,711 [salt.state       ][INFO    ][33308] Completed state [/srv/glusterfs/nova_instances] at time 20:47:42.710810 duration_in_ms=0.653
2017-10-27 20:47:42,711 [salt.state       ][INFO    ][33308] Running state [/srv/glusterfs/keystone-credential-keys] at time 20:47:42.710969
2017-10-27 20:47:42,711 [salt.state       ][INFO    ][33308] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-10-27 20:47:42,712 [salt.state       ][INFO    ][33308] Directory /srv/glusterfs/keystone-credential-keys is in the correct state
2017-10-27 20:47:42,712 [salt.state       ][INFO    ][33308] Completed state [/srv/glusterfs/keystone-credential-keys] at time 20:47:42.711736 duration_in_ms=0.767
2017-10-27 20:47:42,712 [salt.minion      ][INFO    ][33308] Returning information for job: 20171027204739817899
2017-10-27 20:47:44,493 [salt.minion      ][INFO    ][24712] User sudo_ubuntu Executing command test.ping with jid 20171027204744475551
2017-10-27 20:47:44,503 [salt.minion      ][INFO    ][33333] Starting a new job with PID 33333
2017-10-27 20:47:44,538 [salt.minion      ][INFO    ][33333] Returning information for job: 20171027204744475551
2017-10-27 20:47:55,809 [salt.minion      ][INFO    ][24712] User sudo_ubuntu Executing command state.sls with jid 20171027204755793377
2017-10-27 20:47:55,819 [salt.minion      ][INFO    ][33340] Starting a new job with PID 33340
2017-10-27 20:47:56,430 [salt.state       ][INFO    ][33340] Loading fresh modules for state activity
2017-10-27 20:47:56,462 [salt.fileclient  ][INFO    ][33340] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/setup.sls'
2017-10-27 20:47:56,507 [salt.fileclient  ][INFO    ][33340] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-10-27 20:47:56,589 [salt.fileclient  ][INFO    ][33340] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-10-27 20:47:56,614 [salt.fileclient  ][INFO    ][33340] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-10-27 20:47:56,927 [salt.state       ][INFO    ][33340] Running state [attr] at time 20:47:56.927016
2017-10-27 20:47:56,927 [salt.state       ][INFO    ][33340] Executing state pkg.installed for attr
2017-10-27 20:47:56,928 [salt.loaded.int.module.cmdmod][INFO    ][33340] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-10-27 20:47:57,207 [salt.state       ][INFO    ][33340] Package attr is already installed
2017-10-27 20:47:57,208 [salt.state       ][INFO    ][33340] Completed state [attr] at time 20:47:57.207765 duration_in_ms=280.749
2017-10-27 20:47:57,208 [salt.state       ][INFO    ][33340] Running state [glusterfs-server] at time 20:47:57.208050
2017-10-27 20:47:57,208 [salt.state       ][INFO    ][33340] Executing state pkg.installed for glusterfs-server
2017-10-27 20:47:57,212 [salt.state       ][INFO    ][33340] Package glusterfs-server is already installed
2017-10-27 20:47:57,212 [salt.state       ][INFO    ][33340] Completed state [glusterfs-server] at time 20:47:57.212184 duration_in_ms=4.134
2017-10-27 20:47:57,212 [salt.state       ][INFO    ][33340] Running state [bc] at time 20:47:57.212381
2017-10-27 20:47:57,213 [salt.state       ][INFO    ][33340] Executing state pkg.installed for bc
2017-10-27 20:47:57,216 [salt.state       ][INFO    ][33340] Package bc is already installed
2017-10-27 20:47:57,217 [salt.state       ][INFO    ][33340] Completed state [bc] at time 20:47:57.216470 duration_in_ms=4.088
2017-10-27 20:47:57,218 [salt.state       ][INFO    ][33340] Running state [glusterfs-server] at time 20:47:57.217533
2017-10-27 20:47:57,218 [salt.state       ][INFO    ][33340] Executing state service.running for glusterfs-server
2017-10-27 20:47:57,218 [salt.loaded.int.module.cmdmod][INFO    ][33340] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-10-27 20:47:57,234 [salt.loaded.int.module.cmdmod][INFO    ][33340] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-10-27 20:47:57,242 [salt.loaded.int.module.cmdmod][INFO    ][33340] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-10-27 20:47:57,252 [salt.state       ][INFO    ][33340] The service glusterfs-server is already running
2017-10-27 20:47:57,252 [salt.state       ][INFO    ][33340] Completed state [glusterfs-server] at time 20:47:57.252005 duration_in_ms=34.472
2017-10-27 20:47:57,254 [salt.state       ][INFO    ][33340] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 20:47:57.253492
2017-10-27 20:47:57,254 [salt.state       ][INFO    ][33340] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-10-27 20:47:57,256 [salt.state       ][INFO    ][33340] File /etc/systemd/system/glusterfs-server.service.d/override.conf is in the correct state
2017-10-27 20:47:57,256 [salt.state       ][INFO    ][33340] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 20:47:57.255953 duration_in_ms=2.461
2017-10-27 20:47:57,256 [salt.state       ][INFO    ][33340] Running state [/srv/glusterfs/glance] at time 20:47:57.256160
2017-10-27 20:47:57,256 [salt.state       ][INFO    ][33340] Executing state file.directory for /srv/glusterfs/glance
2017-10-27 20:47:57,257 [salt.state       ][INFO    ][33340] Directory /srv/glusterfs/glance is in the correct state
2017-10-27 20:47:57,257 [salt.state       ][INFO    ][33340] Completed state [/srv/glusterfs/glance] at time 20:47:57.257001 duration_in_ms=0.841
2017-10-27 20:47:57,257 [salt.state       ][INFO    ][33340] Running state [/srv/glusterfs/keystone-keys] at time 20:47:57.257190
2017-10-27 20:47:57,257 [salt.state       ][INFO    ][33340] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-10-27 20:47:57,258 [salt.state       ][INFO    ][33340] Directory /srv/glusterfs/keystone-keys is in the correct state
2017-10-27 20:47:57,258 [salt.state       ][INFO    ][33340] Completed state [/srv/glusterfs/keystone-keys] at time 20:47:57.257975 duration_in_ms=0.785
2017-10-27 20:47:57,258 [salt.state       ][INFO    ][33340] Running state [/srv/glusterfs/nova_instances] at time 20:47:57.258149
2017-10-27 20:47:57,258 [salt.state       ][INFO    ][33340] Executing state file.directory for /srv/glusterfs/nova_instances
2017-10-27 20:47:57,259 [salt.state       ][INFO    ][33340] Directory /srv/glusterfs/nova_instances is in the correct state
2017-10-27 20:47:57,259 [salt.state       ][INFO    ][33340] Completed state [/srv/glusterfs/nova_instances] at time 20:47:57.258904 duration_in_ms=0.754
2017-10-27 20:47:57,259 [salt.state       ][INFO    ][33340] Running state [/srv/glusterfs/keystone-credential-keys] at time 20:47:57.259129
2017-10-27 20:47:57,259 [salt.state       ][INFO    ][33340] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-10-27 20:47:57,260 [salt.state       ][INFO    ][33340] Directory /srv/glusterfs/keystone-credential-keys is in the correct state
2017-10-27 20:47:57,260 [salt.state       ][INFO    ][33340] Completed state [/srv/glusterfs/keystone-credential-keys] at time 20:47:57.259927 duration_in_ms=0.799
2017-10-27 20:47:57,312 [salt.loaded.int.module.cmdmod][INFO    ][33340] Executing command ['git', '--version'] in directory '/root'
2017-10-27 20:47:57,385 [salt.state       ][INFO    ][33340] Running state [sleep 5] at time 20:47:57.384630
2017-10-27 20:47:57,385 [salt.state       ][INFO    ][33340] Executing state cmd.wait for sleep 5
2017-10-27 20:47:57,385 [salt.state       ][INFO    ][33340] No changes made for sleep 5
2017-10-27 20:47:57,385 [salt.state       ][INFO    ][33340] Completed state [sleep 5] at time 20:47:57.385235 duration_in_ms=0.605
2017-10-27 20:47:57,386 [salt.state       ][INFO    ][33340] Running state [192.168.10.143] at time 20:47:57.385720
2017-10-27 20:47:57,386 [salt.state       ][INFO    ][33340] Executing state glusterfs.peered for 192.168.10.143
2017-10-27 20:47:57,386 [salt.loaded.int.module.cmdmod][INFO    ][33340] Executing command 'gluster --version' in directory '/root'
2017-10-27 20:47:57,395 [salt.loaded.int.module.cmdmod][INFO    ][33340] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 20:47:57,448 [salt.state       ][INFO    ][33340] Host 192.168.10.143 already peered
2017-10-27 20:47:57,448 [salt.state       ][INFO    ][33340] Completed state [192.168.10.143] at time 20:47:57.448352 duration_in_ms=62.631
2017-10-27 20:47:57,451 [salt.state       ][INFO    ][33340] Running state [192.168.10.142] at time 20:47:57.451092
2017-10-27 20:47:57,451 [salt.state       ][INFO    ][33340] Executing state glusterfs.peered for 192.168.10.142
2017-10-27 20:47:57,452 [salt.loaded.int.module.cmdmod][INFO    ][33340] Executing command 'gluster --version' in directory '/root'
2017-10-27 20:47:57,461 [salt.loaded.int.module.cmdmod][INFO    ][33340] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 20:47:57,514 [salt.state       ][INFO    ][33340] Host 192.168.10.142 already peered
2017-10-27 20:47:57,514 [salt.state       ][INFO    ][33340] Completed state [192.168.10.142] at time 20:47:57.514292 duration_in_ms=63.2
2017-10-27 20:47:57,517 [salt.state       ][INFO    ][33340] Running state [192.168.10.141] at time 20:47:57.517101
2017-10-27 20:47:57,517 [salt.state       ][INFO    ][33340] Executing state glusterfs.peered for 192.168.10.141
2017-10-27 20:47:57,518 [salt.loaded.int.module.cmdmod][INFO    ][33340] Executing command 'gluster --version' in directory '/root'
2017-10-27 20:47:57,524 [salt.loaded.int.module.cmdmod][INFO    ][33340] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 20:47:57,576 [salt.loaded.int.module.cmdmod][INFO    ][33340] Executing command 'gluster --version' in directory '/root'
2017-10-27 20:47:57,583 [salt.loaded.int.module.cmdmod][INFO    ][33340] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 20:47:57,635 [salt.loaded.int.module.cmdmod][INFO    ][33340] Executing command 'gluster --version' in directory '/root'
2017-10-27 20:47:57,643 [salt.loaded.int.module.cmdmod][INFO    ][33340] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 20:47:57,695 [salt.loaded.int.module.cmdmod][INFO    ][33340] Executing command 'gluster --version' in directory '/root'
2017-10-27 20:47:57,703 [salt.loaded.int.module.cmdmod][INFO    ][33340] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 20:47:57,754 [salt.state       ][INFO    ][33340] Peering with localhost is not needed
2017-10-27 20:47:57,755 [salt.state       ][INFO    ][33340] Completed state [192.168.10.141] at time 20:47:57.754522 duration_in_ms=237.42
2017-10-27 20:47:57,756 [salt.state       ][INFO    ][33340] Running state [glance] at time 20:47:57.755609
2017-10-27 20:47:57,756 [salt.state       ][INFO    ][33340] Executing state glusterfs.created for glance
2017-10-27 20:47:57,756 [salt.loaded.int.module.cmdmod][INFO    ][33340] Executing command 'gluster --version' in directory '/root'
2017-10-27 20:47:57,764 [salt.loaded.int.module.cmdmod][INFO    ][33340] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 20:47:57,817 [salt.loaded.int.module.cmdmod][INFO    ][33340] Executing command 'gluster --version' in directory '/root'
2017-10-27 20:47:57,825 [salt.loaded.int.module.cmdmod][INFO    ][33340] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 20:47:57,882 [salt.state       ][INFO    ][33340] Volume glance already exists and is started.
2017-10-27 20:47:57,882 [salt.state       ][INFO    ][33340] Completed state [glance] at time 20:47:57.882436 duration_in_ms=126.827
2017-10-27 20:47:57,886 [salt.state       ][INFO    ][33340] Running state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 20:47:57.885944
2017-10-27 20:47:57,886 [salt.state       ][INFO    ][33340] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'
2017-10-27 20:47:57,887 [salt.loaded.int.module.cmdmod][INFO    ][33340] Executing command 'gluster volume info 'glance' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-10-27 20:47:57,940 [salt.state       ][INFO    ][33340] unless execution succeeded
2017-10-27 20:47:57,940 [salt.state       ][INFO    ][33340] Completed state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 20:47:57.940102 duration_in_ms=54.157
2017-10-27 20:47:57,941 [salt.state       ][INFO    ][33340] Running state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 20:47:57.940688
2017-10-27 20:47:57,941 [salt.state       ][INFO    ][33340] Executing state cmd.run for gluster volume set 'glance' 'network.remote-dio' 'True'
2017-10-27 20:47:57,941 [salt.loaded.int.module.cmdmod][INFO    ][33340] Executing command 'gluster volume info 'glance' | grep 'network.remote-dio: True'' in directory '/root'
2017-10-27 20:47:57,992 [salt.state       ][INFO    ][33340] unless execution succeeded
2017-10-27 20:47:57,993 [salt.state       ][INFO    ][33340] Completed state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 20:47:57.992524 duration_in_ms=51.836
2017-10-27 20:47:57,993 [salt.state       ][INFO    ][33340] Running state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 20:47:57.993085
2017-10-27 20:47:57,993 [salt.state       ][INFO    ][33340] Executing state cmd.run for gluster volume set 'glance' 'nfs.disable' 'True'
2017-10-27 20:47:57,994 [salt.loaded.int.module.cmdmod][INFO    ][33340] Executing command 'gluster volume info 'glance' | grep 'nfs.disable: True'' in directory '/root'
2017-10-27 20:47:58,048 [salt.state       ][INFO    ][33340] unless execution succeeded
2017-10-27 20:47:58,048 [salt.state       ][INFO    ][33340] Completed state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 20:47:58.047755 duration_in_ms=54.67
2017-10-27 20:47:58,048 [salt.state       ][INFO    ][33340] Running state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 20:47:58.048330
2017-10-27 20:47:58,049 [salt.state       ][INFO    ][33340] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'
2017-10-27 20:47:58,049 [salt.loaded.int.module.cmdmod][INFO    ][33340] Executing command 'gluster volume info 'glance' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-10-27 20:47:58,101 [salt.state       ][INFO    ][33340] unless execution succeeded
2017-10-27 20:47:58,102 [salt.state       ][INFO    ][33340] Completed state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 20:47:58.101608 duration_in_ms=53.278
2017-10-27 20:47:58,102 [salt.state       ][INFO    ][33340] Running state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 20:47:58.102167
2017-10-27 20:47:58,102 [salt.state       ][INFO    ][33340] Executing state cmd.run for gluster volume set 'glance' 'cluster.readdir-optimize' 'True'
2017-10-27 20:47:58,103 [salt.loaded.int.module.cmdmod][INFO    ][33340] Executing command 'gluster volume info 'glance' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-10-27 20:47:58,156 [salt.state       ][INFO    ][33340] unless execution succeeded
2017-10-27 20:47:58,156 [salt.state       ][INFO    ][33340] Completed state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 20:47:58.155925 duration_in_ms=53.757
2017-10-27 20:47:58,157 [salt.state       ][INFO    ][33340] Running state [glance] at time 20:47:58.157131
2017-10-27 20:47:58,157 [salt.state       ][INFO    ][33340] Executing state glusterfs.started for glance
2017-10-27 20:47:58,158 [salt.loaded.int.module.cmdmod][INFO    ][33340] Executing command 'gluster --version' in directory '/root'
2017-10-27 20:47:58,166 [salt.loaded.int.module.cmdmod][INFO    ][33340] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 20:47:58,218 [salt.loaded.int.module.cmdmod][INFO    ][33340] Executing command 'gluster --version' in directory '/root'
2017-10-27 20:47:58,226 [salt.loaded.int.module.cmdmod][INFO    ][33340] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 20:47:58,285 [salt.state       ][INFO    ][33340] Volume glance is already started
2017-10-27 20:47:58,285 [salt.state       ][INFO    ][33340] Completed state [glance] at time 20:47:58.284920 duration_in_ms=127.789
2017-10-27 20:47:58,286 [salt.state       ][INFO    ][33340] Running state [keystone-keys] at time 20:47:58.285967
2017-10-27 20:47:58,286 [salt.state       ][INFO    ][33340] Executing state glusterfs.created for keystone-keys
2017-10-27 20:47:58,287 [salt.loaded.int.module.cmdmod][INFO    ][33340] Executing command 'gluster --version' in directory '/root'
2017-10-27 20:47:58,293 [salt.loaded.int.module.cmdmod][INFO    ][33340] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 20:47:58,345 [salt.loaded.int.module.cmdmod][INFO    ][33340] Executing command 'gluster --version' in directory '/root'
2017-10-27 20:47:58,353 [salt.loaded.int.module.cmdmod][INFO    ][33340] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 20:47:58,411 [salt.state       ][INFO    ][33340] Volume keystone-keys already exists and is started.
2017-10-27 20:47:58,411 [salt.state       ][INFO    ][33340] Completed state [keystone-keys] at time 20:47:58.411186 duration_in_ms=125.219
2017-10-27 20:47:58,415 [salt.state       ][INFO    ][33340] Running state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 20:47:58.414808
2017-10-27 20:47:58,415 [salt.state       ][INFO    ][33340] Executing state cmd.run for gluster volume set 'keystone-keys' 'network.remote-dio' 'True'
2017-10-27 20:47:58,416 [salt.loaded.int.module.cmdmod][INFO    ][33340] Executing command 'gluster volume info 'keystone-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-10-27 20:47:58,467 [salt.state       ][INFO    ][33340] unless execution succeeded
2017-10-27 20:47:58,467 [salt.state       ][INFO    ][33340] Completed state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 20:47:58.466933 duration_in_ms=52.124
2017-10-27 20:47:58,468 [salt.state       ][INFO    ][33340] Running state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 20:47:58.467562
2017-10-27 20:47:58,468 [salt.state       ][INFO    ][33340] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-10-27 20:47:58,468 [salt.loaded.int.module.cmdmod][INFO    ][33340] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-10-27 20:47:58,519 [salt.state       ][INFO    ][33340] unless execution succeeded
2017-10-27 20:47:58,519 [salt.state       ][INFO    ][33340] Completed state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 20:47:58.519286 duration_in_ms=51.722
2017-10-27 20:47:58,520 [salt.state       ][INFO    ][33340] Running state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 20:47:58.519900
2017-10-27 20:47:58,520 [salt.state       ][INFO    ][33340] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'
2017-10-27 20:47:58,521 [salt.loaded.int.module.cmdmod][INFO    ][33340] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-10-27 20:47:58,572 [salt.state       ][INFO    ][33340] unless execution succeeded
2017-10-27 20:47:58,573 [salt.state       ][INFO    ][33340] Completed state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 20:47:58.572528 duration_in_ms=52.627
2017-10-27 20:47:58,573 [salt.state       ][INFO    ][33340] Running state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 20:47:58.573078
2017-10-27 20:47:58,573 [salt.state       ][INFO    ][33340] Executing state cmd.run for gluster volume set 'keystone-keys' 'nfs.disable' 'True'
2017-10-27 20:47:58,574 [salt.loaded.int.module.cmdmod][INFO    ][33340] Executing command 'gluster volume info 'keystone-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-10-27 20:47:58,626 [salt.state       ][INFO    ][33340] unless execution succeeded
2017-10-27 20:47:58,626 [salt.state       ][INFO    ][33340] Completed state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 20:47:58.626068 duration_in_ms=52.99
2017-10-27 20:47:58,627 [salt.state       ][INFO    ][33340] Running state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 20:47:58.626732
2017-10-27 20:47:58,627 [salt.state       ][INFO    ][33340] Executing state cmd.run for gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'
2017-10-27 20:47:58,630 [salt.loaded.int.module.cmdmod][INFO    ][33340] Executing command 'gluster volume info 'keystone-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-10-27 20:47:58,684 [salt.state       ][INFO    ][33340] unless execution succeeded
2017-10-27 20:47:58,684 [salt.state       ][INFO    ][33340] Completed state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 20:47:58.683958 duration_in_ms=57.225
2017-10-27 20:47:58,686 [salt.state       ][INFO    ][33340] Running state [keystone-keys] at time 20:47:58.686114
2017-10-27 20:47:58,686 [salt.state       ][INFO    ][33340] Executing state glusterfs.started for keystone-keys
2017-10-27 20:47:58,687 [salt.loaded.int.module.cmdmod][INFO    ][33340] Executing command 'gluster --version' in directory '/root'
2017-10-27 20:47:58,696 [salt.loaded.int.module.cmdmod][INFO    ][33340] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 20:47:58,748 [salt.loaded.int.module.cmdmod][INFO    ][33340] Executing command 'gluster --version' in directory '/root'
2017-10-27 20:47:58,757 [salt.loaded.int.module.cmdmod][INFO    ][33340] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 20:47:58,814 [salt.state       ][INFO    ][33340] Volume keystone-keys is already started
2017-10-27 20:47:58,814 [salt.state       ][INFO    ][33340] Completed state [keystone-keys] at time 20:47:58.814307 duration_in_ms=128.191
2017-10-27 20:47:58,817 [salt.state       ][INFO    ][33340] Running state [nova_instances] at time 20:47:58.816533
2017-10-27 20:47:58,817 [salt.state       ][INFO    ][33340] Executing state glusterfs.created for nova_instances
2017-10-27 20:47:58,817 [salt.loaded.int.module.cmdmod][INFO    ][33340] Executing command 'gluster --version' in directory '/root'
2017-10-27 20:47:58,826 [salt.loaded.int.module.cmdmod][INFO    ][33340] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 20:47:58,877 [salt.loaded.int.module.cmdmod][INFO    ][33340] Executing command 'gluster --version' in directory '/root'
2017-10-27 20:47:58,884 [salt.loaded.int.module.cmdmod][INFO    ][33340] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 20:47:58,941 [salt.state       ][INFO    ][33340] Volume nova_instances already exists and is started.
2017-10-27 20:47:58,942 [salt.state       ][INFO    ][33340] Completed state [nova_instances] at time 20:47:58.941559 duration_in_ms=125.025
2017-10-27 20:47:58,946 [salt.state       ][INFO    ][33340] Running state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 20:47:58.945651
2017-10-27 20:47:58,946 [salt.state       ][INFO    ][33340] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'
2017-10-27 20:47:58,946 [salt.loaded.int.module.cmdmod][INFO    ][33340] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-10-27 20:47:58,998 [salt.state       ][INFO    ][33340] unless execution succeeded
2017-10-27 20:47:58,999 [salt.state       ][INFO    ][33340] Completed state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 20:47:58.998547 duration_in_ms=52.896
2017-10-27 20:47:58,999 [salt.state       ][INFO    ][33340] Running state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'On'] at time 20:47:58.999144
2017-10-27 20:47:58,999 [salt.state       ][INFO    ][33340] Executing state cmd.run for gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'On'
2017-10-27 20:47:58,1000 [salt.loaded.int.module.cmdmod][INFO    ][33340] Executing command 'gluster volume info 'nova_instances' | grep 'cluster.readdir-optimize: On'' in directory '/root'
2017-10-27 20:47:59,054 [salt.state       ][INFO    ][33340] unless execution succeeded
2017-10-27 20:47:59,054 [salt.state       ][INFO    ][33340] Completed state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'On'] at time 20:47:59.053768 duration_in_ms=54.623
2017-10-27 20:47:59,054 [salt.state       ][INFO    ][33340] Running state [gluster volume set 'nova_instances' 'network.remote-dio' 'On'] at time 20:47:59.054381
2017-10-27 20:47:59,055 [salt.state       ][INFO    ][33340] Executing state cmd.run for gluster volume set 'nova_instances' 'network.remote-dio' 'On'
2017-10-27 20:47:59,055 [salt.loaded.int.module.cmdmod][INFO    ][33340] Executing command 'gluster volume info 'nova_instances' | grep 'network.remote-dio: On'' in directory '/root'
2017-10-27 20:47:59,108 [salt.state       ][INFO    ][33340] unless execution succeeded
2017-10-27 20:47:59,108 [salt.state       ][INFO    ][33340] Completed state [gluster volume set 'nova_instances' 'network.remote-dio' 'On'] at time 20:47:59.108292 duration_in_ms=53.911
2017-10-27 20:47:59,109 [salt.state       ][INFO    ][33340] Running state [gluster volume set 'nova_instances' 'nfs.disable' 'On'] at time 20:47:59.108934
2017-10-27 20:47:59,109 [salt.state       ][INFO    ][33340] Executing state cmd.run for gluster volume set 'nova_instances' 'nfs.disable' 'On'
2017-10-27 20:47:59,110 [salt.loaded.int.module.cmdmod][INFO    ][33340] Executing command 'gluster volume info 'nova_instances' | grep 'nfs.disable: On'' in directory '/root'
2017-10-27 20:47:59,162 [salt.state       ][INFO    ][33340] unless execution succeeded
2017-10-27 20:47:59,162 [salt.state       ][INFO    ][33340] Completed state [gluster volume set 'nova_instances' 'nfs.disable' 'On'] at time 20:47:59.162114 duration_in_ms=53.179
2017-10-27 20:47:59,163 [salt.state       ][INFO    ][33340] Running state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 20:47:59.162658
2017-10-27 20:47:59,163 [salt.state       ][INFO    ][33340] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'
2017-10-27 20:47:59,163 [salt.loaded.int.module.cmdmod][INFO    ][33340] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-10-27 20:47:59,215 [salt.state       ][INFO    ][33340] unless execution succeeded
2017-10-27 20:47:59,215 [salt.state       ][INFO    ][33340] Completed state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 20:47:59.215332 duration_in_ms=52.672
2017-10-27 20:47:59,217 [salt.state       ][INFO    ][33340] Running state [nova_instances] at time 20:47:59.216571
2017-10-27 20:47:59,217 [salt.state       ][INFO    ][33340] Executing state glusterfs.started for nova_instances
2017-10-27 20:47:59,217 [salt.loaded.int.module.cmdmod][INFO    ][33340] Executing command 'gluster --version' in directory '/root'
2017-10-27 20:47:59,224 [salt.loaded.int.module.cmdmod][INFO    ][33340] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 20:47:59,276 [salt.loaded.int.module.cmdmod][INFO    ][33340] Executing command 'gluster --version' in directory '/root'
2017-10-27 20:47:59,284 [salt.loaded.int.module.cmdmod][INFO    ][33340] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 20:47:59,342 [salt.state       ][INFO    ][33340] Volume nova_instances is already started
2017-10-27 20:47:59,343 [salt.state       ][INFO    ][33340] Completed state [nova_instances] at time 20:47:59.342676 duration_in_ms=126.104
2017-10-27 20:47:59,344 [salt.state       ][INFO    ][33340] Running state [keystone-credential-keys] at time 20:47:59.343936
2017-10-27 20:47:59,344 [salt.state       ][INFO    ][33340] Executing state glusterfs.created for keystone-credential-keys
2017-10-27 20:47:59,345 [salt.loaded.int.module.cmdmod][INFO    ][33340] Executing command 'gluster --version' in directory '/root'
2017-10-27 20:47:59,353 [salt.loaded.int.module.cmdmod][INFO    ][33340] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 20:47:59,405 [salt.loaded.int.module.cmdmod][INFO    ][33340] Executing command 'gluster --version' in directory '/root'
2017-10-27 20:47:59,413 [salt.loaded.int.module.cmdmod][INFO    ][33340] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 20:47:59,469 [salt.state       ][INFO    ][33340] Volume keystone-credential-keys already exists and is started.
2017-10-27 20:47:59,470 [salt.state       ][INFO    ][33340] Completed state [keystone-credential-keys] at time 20:47:59.469666 duration_in_ms=125.729
2017-10-27 20:47:59,474 [salt.state       ][INFO    ][33340] Running state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 20:47:59.473840
2017-10-27 20:47:59,474 [salt.state       ][INFO    ][33340] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'
2017-10-27 20:47:59,475 [salt.loaded.int.module.cmdmod][INFO    ][33340] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-10-27 20:47:59,527 [salt.state       ][INFO    ][33340] unless execution succeeded
2017-10-27 20:47:59,528 [salt.state       ][INFO    ][33340] Completed state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 20:47:59.527656 duration_in_ms=53.816
2017-10-27 20:47:59,528 [salt.state       ][INFO    ][33340] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 20:47:59.528216
2017-10-27 20:47:59,528 [salt.state       ][INFO    ][33340] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-10-27 20:47:59,529 [salt.loaded.int.module.cmdmod][INFO    ][33340] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-10-27 20:47:59,581 [salt.state       ][INFO    ][33340] unless execution succeeded
2017-10-27 20:47:59,581 [salt.state       ][INFO    ][33340] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 20:47:59.581214 duration_in_ms=52.997
2017-10-27 20:47:59,582 [salt.state       ][INFO    ][33340] Running state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 20:47:59.581801
2017-10-27 20:47:59,582 [salt.state       ][INFO    ][33340] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'
2017-10-27 20:47:59,583 [salt.loaded.int.module.cmdmod][INFO    ][33340] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-10-27 20:47:59,634 [salt.state       ][INFO    ][33340] unless execution succeeded
2017-10-27 20:47:59,634 [salt.state       ][INFO    ][33340] Completed state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 20:47:59.633895 duration_in_ms=52.094
2017-10-27 20:47:59,635 [salt.state       ][INFO    ][33340] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 20:47:59.634515
2017-10-27 20:47:59,635 [salt.state       ][INFO    ][33340] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'
2017-10-27 20:47:59,635 [salt.loaded.int.module.cmdmod][INFO    ][33340] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-10-27 20:47:59,687 [salt.state       ][INFO    ][33340] unless execution succeeded
2017-10-27 20:47:59,687 [salt.state       ][INFO    ][33340] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 20:47:59.686994 duration_in_ms=52.479
2017-10-27 20:47:59,688 [salt.state       ][INFO    ][33340] Running state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 20:47:59.687635
2017-10-27 20:47:59,688 [salt.state       ][INFO    ][33340] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'
2017-10-27 20:47:59,688 [salt.loaded.int.module.cmdmod][INFO    ][33340] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-10-27 20:47:59,738 [salt.state       ][INFO    ][33340] unless execution succeeded
2017-10-27 20:47:59,738 [salt.state       ][INFO    ][33340] Completed state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 20:47:59.737709 duration_in_ms=50.074
2017-10-27 20:47:59,739 [salt.state       ][INFO    ][33340] Running state [keystone-credential-keys] at time 20:47:59.738957
2017-10-27 20:47:59,739 [salt.state       ][INFO    ][33340] Executing state glusterfs.started for keystone-credential-keys
2017-10-27 20:47:59,740 [salt.loaded.int.module.cmdmod][INFO    ][33340] Executing command 'gluster --version' in directory '/root'
2017-10-27 20:47:59,747 [salt.loaded.int.module.cmdmod][INFO    ][33340] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 20:47:59,802 [salt.loaded.int.module.cmdmod][INFO    ][33340] Executing command 'gluster --version' in directory '/root'
2017-10-27 20:47:59,809 [salt.loaded.int.module.cmdmod][INFO    ][33340] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 20:47:59,867 [salt.state       ][INFO    ][33340] Volume keystone-credential-keys is already started
2017-10-27 20:47:59,868 [salt.state       ][INFO    ][33340] Completed state [keystone-credential-keys] at time 20:47:59.867698 duration_in_ms=128.741
2017-10-27 20:47:59,870 [salt.minion      ][INFO    ][33340] Returning information for job: 20171027204755793377
2017-10-27 20:48:00,879 [salt.minion      ][INFO    ][24712] User sudo_ubuntu Executing command test.ping with jid 20171027204800862008
2017-10-27 20:48:00,891 [salt.minion      ][INFO    ][33723] Starting a new job with PID 33723
2017-10-27 20:48:00,926 [salt.minion      ][INFO    ][33723] Returning information for job: 20171027204800862008
2017-10-27 20:48:01,721 [salt.minion      ][INFO    ][24712] User sudo_ubuntu Executing command cmd.run with jid 20171027204801706571
2017-10-27 20:48:01,732 [salt.minion      ][INFO    ][33729] Starting a new job with PID 33729
2017-10-27 20:48:01,736 [salt.loaded.int.module.cmdmod][INFO    ][33729] Executing command 'gluster peer status; gluster volume status' in directory '/root'
2017-10-27 20:48:01,857 [salt.minion      ][INFO    ][33729] Returning information for job: 20171027204801706571
2017-10-27 20:48:07,104 [salt.utils.schedule][INFO    ][24712] Running scheduled job: __mine_interval
2017-10-27 21:12:43,266 [salt.minion      ][INFO    ][24712] User sudo_ubuntu Executing command cp.push_dir with jid 20171027211243247102
2017-10-27 21:12:43,281 [salt.minion      ][INFO    ][34003] Starting a new job with PID 34003
