2017-10-18 12:30:55,027 [salt.cli.daemons ][WARNING ][2492] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-10-18 12:31:11,258 [salt.state       ][ERROR   ][3745] No contents found in top file
2017-10-18 12:32:35,041 [salt.utils.parsers][WARNING ][2492] Minion received a SIGTERM. Exiting.
2017-10-18 12:34:56,676 [salt.cli.daemons ][WARNING ][3335] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-10-18 12:37:39,829 [salt.loaded.int.module.cmdmod][ERROR   ][10173] Command 'virsh net-destroy default 2>&1 1>/dev/null; virsh net-undefine default' failed with return code: 1
2017-10-18 12:37:39,829 [salt.loaded.int.module.cmdmod][ERROR   ][10173] stderr: error: failed to get network 'default'
error: Network not found: no network with matching name 'default'
2017-10-18 12:37:39,829 [salt.loaded.int.module.cmdmod][ERROR   ][10173] retcode: 1
2017-10-18 12:37:39,830 [salt.state       ][ERROR   ][10173] {'pid': 15007, 'retcode': 1, 'stderr': "error: failed to get network 'default'\nerror: Network not found: no network with matching name 'default'", 'stdout': ''}
2017-10-18 12:37:57,491 [py.warnings      ][WARNING ][15084] /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-18 12:50:12,524 [salt.loaded.int.module.cmdmod][ERROR   ][15084] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-10-18 12:50:12,525 [salt.loaded.int.module.cmdmod][ERROR   ][15084] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-10-18 12:50:18,766 [salt.loaded.int.module.cmdmod][ERROR   ][15084] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-10-18 12:50:18,766 [salt.loaded.int.module.cmdmod][ERROR   ][15084] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-10-18 12:50:26,375 [salt.loaded.int.module.cmdmod][ERROR   ][15084] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-10-18 12:50:26,375 [salt.loaded.int.module.cmdmod][ERROR   ][15084] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-10-18 12:50:35,127 [salt.loaded.int.module.cmdmod][ERROR   ][15084] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-10-18 12:50:35,127 [salt.loaded.int.module.cmdmod][ERROR   ][15084] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-10-18 12:50:43,388 [salt.loaded.int.module.cmdmod][ERROR   ][15084] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-10-18 12:50:43,389 [salt.loaded.int.module.cmdmod][ERROR   ][15084] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-10-18 12:50:48,896 [salt.loaded.int.module.cmdmod][ERROR   ][15084] 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-18 12:50:50,936 [salt.loaded.int.module.cmdmod][INFO    ][23004] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2017-10-18 12:50:50,942 [salt.loaded.int.module.cmdmod][INFO    ][23004] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2017-10-18 12:50:50,951 [salt.loaded.int.module.cmdmod][INFO    ][23004] Executing command ['systemd-run', '--scope', 'systemctl', 'restart', 'salt-minion.service'] in directory '/root'
2017-10-18 12:50:50,958 [salt.utils.parsers][WARNING ][3335] Minion received a SIGTERM. Exiting.
2017-10-18 12:50:51,202 [salt.cli.daemons ][INFO    ][23091] Setting up the Salt Minion "kvm03.baremetal-mcp-ocata-ovs-ha.local"
2017-10-18 12:50:51,735 [salt.minion      ][INFO    ][23091] Creating minion process manager
2017-10-18 12:50:51,736 [salt.cli.daemons ][WARNING ][23091] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-10-18 12:50:51,736 [salt.cli.daemons ][INFO    ][23091] The Salt Minion is starting up
2017-10-18 12:50:51,736 [salt.minion      ][INFO    ][23091] Minion is starting as user 'root'
2017-10-18 12:50:51,737 [salt.utils.event ][INFO    ][23091] Starting pull socket on /var/run/salt/minion/minion_event_98ff1e569f_pull.ipc
2017-10-18 12:50:52,588 [salt.loaded.int.module.cmdmod][INFO    ][23091] Executing command ['date', '+%z'] in directory '/root'
2017-10-18 12:50:52,681 [salt.utils.schedule][INFO    ][23091] Updating job settings for scheduled job: __mine_interval
2017-10-18 12:50:52,683 [salt.minion      ][INFO    ][23091] Added mine.update to scheduler
2017-10-18 12:50:52,866 [salt.minion      ][INFO    ][23091] Minion is ready to receive requests!
2017-10-18 12:50:52,868 [salt.minion      ][INFO    ][23091] User sudo_ubuntu Executing command saltutil.sync_all with jid 20171018125051783004
2017-10-18 12:50:52,879 [salt.minion      ][INFO    ][23209] Starting a new job with PID 23209
2017-10-18 12:50:53,867 [salt.utils.schedule][INFO    ][23091] Running scheduled job: __mine_interval
2017-10-18 12:50:54,399 [salt.state       ][INFO    ][23209] Loading fresh modules for state activity
2017-10-18 12:50:54,419 [salt.state       ][ERROR   ][23209] No contents found in top file
2017-10-18 12:50:54,419 [salt.utils.extmods][INFO    ][23209] Creating module dir '/var/cache/salt/minion/extmods/beacons'
2017-10-18 12:50:54,422 [salt.utils.extmods][INFO    ][23209] Syncing beacons for environment 'base'
2017-10-18 12:50:54,422 [salt.utils.extmods][INFO    ][23209] Loading cache from salt://_beacons, for base)
2017-10-18 12:50:54,422 [salt.fileclient  ][INFO    ][23209] Caching directory '_beacons/' for environment 'base'
2017-10-18 12:50:54,444 [salt.utils.extmods][INFO    ][23209] Syncing modules for environment 'base'
2017-10-18 12:50:54,444 [salt.utils.extmods][INFO    ][23209] Loading cache from salt://_modules, for base)
2017-10-18 12:50:54,445 [salt.fileclient  ][INFO    ][23209] Caching directory '_modules/' for environment 'base'
2017-10-18 12:50:54,479 [salt.fileclient  ][INFO    ][23209] Fetching file from saltenv 'base', ** done ** '_modules/ceph_ng.py'
2017-10-18 12:50:54,488 [salt.fileclient  ][INFO    ][23209] Fetching file from saltenv 'base', ** done ** '_modules/cinderng.py'
2017-10-18 12:50:54,499 [salt.fileclient  ][INFO    ][23209] Fetching file from saltenv 'base', ** done ** '_modules/contrail.py'
2017-10-18 12:50:54,509 [salt.fileclient  ][INFO    ][23209] Fetching file from saltenv 'base', ** done ** '_modules/creds.py'
2017-10-18 12:50:54,519 [salt.fileclient  ][INFO    ][23209] Fetching file from saltenv 'base', ** done ** '_modules/devops_utils.py'
2017-10-18 12:50:54,528 [salt.fileclient  ][INFO    ][23209] Fetching file from saltenv 'base', ** done ** '_modules/encode_json.py'
2017-10-18 12:50:54,538 [salt.fileclient  ][INFO    ][23209] Fetching file from saltenv 'base', ** done ** '_modules/gerrit.py'
2017-10-18 12:50:54,548 [salt.fileclient  ][INFO    ][23209] Fetching file from saltenv 'base', ** done ** '_modules/glanceng.py'
2017-10-18 12:50:54,558 [salt.fileclient  ][INFO    ][23209] Fetching file from saltenv 'base', ** done ** '_modules/heat.py'
2017-10-18 12:50:54,568 [salt.fileclient  ][INFO    ][23209] Fetching file from saltenv 'base', ** done ** '_modules/heka_alarming.py'
2017-10-18 12:50:54,579 [salt.fileclient  ][INFO    ][23209] Fetching file from saltenv 'base', ** done ** '_modules/helm.py'
2017-10-18 12:50:54,589 [salt.fileclient  ][INFO    ][23209] Fetching file from saltenv 'base', ** done ** '_modules/jenkins_common.py'
2017-10-18 12:50:54,599 [salt.fileclient  ][INFO    ][23209] Fetching file from saltenv 'base', ** done ** '_modules/keystone_policy.py'
2017-10-18 12:50:54,610 [salt.fileclient  ][INFO    ][23209] Fetching file from saltenv 'base', ** done ** '_modules/linux_hosts.py'
2017-10-18 12:50:54,619 [salt.fileclient  ][INFO    ][23209] Fetching file from saltenv 'base', ** done ** '_modules/linux_netlink.py'
2017-10-18 12:50:54,630 [salt.fileclient  ][INFO    ][23209] Fetching file from saltenv 'base', ** done ** '_modules/maas.py'
2017-10-18 12:50:54,641 [salt.fileclient  ][INFO    ][23209] Fetching file from saltenv 'base', ** done ** '_modules/maas_client.py'
2017-10-18 12:50:54,651 [salt.fileclient  ][INFO    ][23209] Fetching file from saltenv 'base', ** done ** '_modules/multipart.py'
2017-10-18 12:50:54,661 [salt.fileclient  ][INFO    ][23209] Fetching file from saltenv 'base', ** done ** '_modules/nagios_alarming.py'
2017-10-18 12:50:54,672 [salt.fileclient  ][INFO    ][23209] Fetching file from saltenv 'base', ** done ** '_modules/neutronng.py'
2017-10-18 12:50:54,685 [salt.fileclient  ][INFO    ][23209] Fetching file from saltenv 'base', ** done ** '_modules/novang.py'
2017-10-18 12:50:54,696 [salt.fileclient  ][INFO    ][23209] Fetching file from saltenv 'base', ** done ** '_modules/reclass.py'
2017-10-18 12:50:54,706 [salt.fileclient  ][INFO    ][23209] Fetching file from saltenv 'base', ** done ** '_modules/rsyslog_util.py'
2017-10-18 12:50:54,717 [salt.fileclient  ][INFO    ][23209] Fetching file from saltenv 'base', ** done ** '_modules/rundeck.py'
2017-10-18 12:50:54,726 [salt.fileclient  ][INFO    ][23209] Fetching file from saltenv 'base', ** done ** '_modules/saltkey.py'
2017-10-18 12:50:54,736 [salt.fileclient  ][INFO    ][23209] Fetching file from saltenv 'base', ** done ** '_modules/saltresource.py'
2017-10-18 12:50:54,747 [salt.fileclient  ][INFO    ][23209] Fetching file from saltenv 'base', ** done ** '_modules/seedng.py'
2017-10-18 12:50:54,765 [salt.fileclient  ][INFO    ][23209] Fetching file from saltenv 'base', ** done ** '_modules/testing/credentials.py'
2017-10-18 12:50:54,776 [salt.fileclient  ][INFO    ][23209] Fetching file from saltenv 'base', ** done ** '_modules/testing/django.py'
2017-10-18 12:50:54,786 [salt.fileclient  ][INFO    ][23209] Fetching file from saltenv 'base', ** done ** '_modules/testing/django_client_proxy.py'
2017-10-18 12:50:54,796 [salt.fileclient  ][INFO    ][23209] Fetching file from saltenv 'base', ** done ** '_modules/utils.py'
2017-10-18 12:50:54,808 [salt.fileclient  ][INFO    ][23209] Fetching file from saltenv 'base', ** done ** '_modules/virtng.py'
2017-10-18 12:50:54,811 [salt.utils.extmods][INFO    ][23209] Copying '/var/cache/salt/minion/files/base/_modules/__init__.py' to '/var/cache/salt/minion/extmods/modules/__init__.py'
2017-10-18 12:50:54,811 [salt.utils.extmods][INFO    ][23209] Copying '/var/cache/salt/minion/files/base/_modules/ceph_ng.py' to '/var/cache/salt/minion/extmods/modules/ceph_ng.py'
2017-10-18 12:50:54,812 [salt.utils.extmods][INFO    ][23209] Copying '/var/cache/salt/minion/files/base/_modules/cinderng.py' to '/var/cache/salt/minion/extmods/modules/cinderng.py'
2017-10-18 12:50:54,812 [salt.utils.extmods][INFO    ][23209] Copying '/var/cache/salt/minion/files/base/_modules/contrail.py' to '/var/cache/salt/minion/extmods/modules/contrail.py'
2017-10-18 12:50:54,812 [salt.utils.extmods][INFO    ][23209] Copying '/var/cache/salt/minion/files/base/_modules/creds.py' to '/var/cache/salt/minion/extmods/modules/creds.py'
2017-10-18 12:50:54,812 [salt.utils.extmods][INFO    ][23209] Copying '/var/cache/salt/minion/files/base/_modules/devops_utils.py' to '/var/cache/salt/minion/extmods/modules/devops_utils.py'
2017-10-18 12:50:54,812 [salt.utils.extmods][INFO    ][23209] Copying '/var/cache/salt/minion/files/base/_modules/encode_json.py' to '/var/cache/salt/minion/extmods/modules/encode_json.py'
2017-10-18 12:50:54,813 [salt.utils.extmods][INFO    ][23209] Copying '/var/cache/salt/minion/files/base/_modules/gerrit.py' to '/var/cache/salt/minion/extmods/modules/gerrit.py'
2017-10-18 12:50:54,813 [salt.utils.extmods][INFO    ][23209] Copying '/var/cache/salt/minion/files/base/_modules/glanceng.py' to '/var/cache/salt/minion/extmods/modules/glanceng.py'
2017-10-18 12:50:54,813 [salt.utils.extmods][INFO    ][23209] Copying '/var/cache/salt/minion/files/base/_modules/heat.py' to '/var/cache/salt/minion/extmods/modules/heat.py'
2017-10-18 12:50:54,813 [salt.utils.extmods][INFO    ][23209] Copying '/var/cache/salt/minion/files/base/_modules/heka_alarming.py' to '/var/cache/salt/minion/extmods/modules/heka_alarming.py'
2017-10-18 12:50:54,814 [salt.utils.extmods][INFO    ][23209] Copying '/var/cache/salt/minion/files/base/_modules/helm.py' to '/var/cache/salt/minion/extmods/modules/helm.py'
2017-10-18 12:50:54,814 [salt.utils.extmods][INFO    ][23209] Copying '/var/cache/salt/minion/files/base/_modules/jenkins_common.py' to '/var/cache/salt/minion/extmods/modules/jenkins_common.py'
2017-10-18 12:50:54,814 [salt.utils.extmods][INFO    ][23209] Copying '/var/cache/salt/minion/files/base/_modules/keystone_policy.py' to '/var/cache/salt/minion/extmods/modules/keystone_policy.py'
2017-10-18 12:50:54,814 [salt.utils.extmods][INFO    ][23209] Copying '/var/cache/salt/minion/files/base/_modules/linux_hosts.py' to '/var/cache/salt/minion/extmods/modules/linux_hosts.py'
2017-10-18 12:50:54,814 [salt.utils.extmods][INFO    ][23209] Copying '/var/cache/salt/minion/files/base/_modules/linux_netlink.py' to '/var/cache/salt/minion/extmods/modules/linux_netlink.py'
2017-10-18 12:50:54,814 [salt.utils.extmods][INFO    ][23209] Copying '/var/cache/salt/minion/files/base/_modules/maas.py' to '/var/cache/salt/minion/extmods/modules/maas.py'
2017-10-18 12:50:54,815 [salt.utils.extmods][INFO    ][23209] Copying '/var/cache/salt/minion/files/base/_modules/maas_client.py' to '/var/cache/salt/minion/extmods/modules/maas_client.py'
2017-10-18 12:50:54,815 [salt.utils.extmods][INFO    ][23209] Copying '/var/cache/salt/minion/files/base/_modules/multipart.py' to '/var/cache/salt/minion/extmods/modules/multipart.py'
2017-10-18 12:50:54,815 [salt.utils.extmods][INFO    ][23209] Copying '/var/cache/salt/minion/files/base/_modules/nagios_alarming.py' to '/var/cache/salt/minion/extmods/modules/nagios_alarming.py'
2017-10-18 12:50:54,815 [salt.utils.extmods][INFO    ][23209] Copying '/var/cache/salt/minion/files/base/_modules/neutronng.py' to '/var/cache/salt/minion/extmods/modules/neutronng.py'
2017-10-18 12:50:54,815 [salt.utils.extmods][INFO    ][23209] Copying '/var/cache/salt/minion/files/base/_modules/novang.py' to '/var/cache/salt/minion/extmods/modules/novang.py'
2017-10-18 12:50:54,816 [salt.utils.extmods][INFO    ][23209] Copying '/var/cache/salt/minion/files/base/_modules/reclass.py' to '/var/cache/salt/minion/extmods/modules/reclass.py'
2017-10-18 12:50:54,816 [salt.utils.extmods][INFO    ][23209] Copying '/var/cache/salt/minion/files/base/_modules/rsyslog_util.py' to '/var/cache/salt/minion/extmods/modules/rsyslog_util.py'
2017-10-18 12:50:54,816 [salt.utils.extmods][INFO    ][23209] Copying '/var/cache/salt/minion/files/base/_modules/rundeck.py' to '/var/cache/salt/minion/extmods/modules/rundeck.py'
2017-10-18 12:50:54,817 [salt.utils.extmods][INFO    ][23209] Copying '/var/cache/salt/minion/files/base/_modules/saltkey.py' to '/var/cache/salt/minion/extmods/modules/saltkey.py'
2017-10-18 12:50:54,817 [salt.utils.extmods][INFO    ][23209] Copying '/var/cache/salt/minion/files/base/_modules/saltresource.py' to '/var/cache/salt/minion/extmods/modules/saltresource.py'
2017-10-18 12:50:54,817 [salt.utils.extmods][INFO    ][23209] Copying '/var/cache/salt/minion/files/base/_modules/seedng.py' to '/var/cache/salt/minion/extmods/modules/seedng.py'
2017-10-18 12:50:54,817 [salt.utils.extmods][INFO    ][23209] Copying '/var/cache/salt/minion/files/base/_modules/testing/__init__.py' to '/var/cache/salt/minion/extmods/modules/testing/__init__.py'
2017-10-18 12:50:54,817 [salt.utils.extmods][INFO    ][23209] Copying '/var/cache/salt/minion/files/base/_modules/testing/credentials.py' to '/var/cache/salt/minion/extmods/modules/testing/credentials.py'
2017-10-18 12:50:54,817 [salt.utils.extmods][INFO    ][23209] Copying '/var/cache/salt/minion/files/base/_modules/testing/django.py' to '/var/cache/salt/minion/extmods/modules/testing/django.py'
2017-10-18 12:50:54,818 [salt.utils.extmods][INFO    ][23209] 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-18 12:50:54,818 [salt.utils.extmods][INFO    ][23209] Copying '/var/cache/salt/minion/files/base/_modules/utils.py' to '/var/cache/salt/minion/extmods/modules/utils.py'
2017-10-18 12:50:54,818 [salt.utils.extmods][INFO    ][23209] Copying '/var/cache/salt/minion/files/base/_modules/virtng.py' to '/var/cache/salt/minion/extmods/modules/virtng.py'
2017-10-18 12:50:54,822 [salt.utils.extmods][INFO    ][23209] Syncing states for environment 'base'
2017-10-18 12:50:54,845 [salt.utils.extmods][INFO    ][23209] Loading cache from salt://_states, for base)
2017-10-18 12:50:54,846 [salt.fileclient  ][INFO    ][23209] Caching directory '_states/' for environment 'base'
2017-10-18 12:50:54,889 [salt.fileclient  ][INFO    ][23209] Fetching file from saltenv 'base', ** done ** '_states/cinderng.py'
2017-10-18 12:50:54,902 [salt.fileclient  ][INFO    ][23209] Fetching file from saltenv 'base', ** done ** '_states/contrail.py'
2017-10-18 12:50:54,912 [salt.fileclient  ][INFO    ][23209] Fetching file from saltenv 'base', ** done ** '_states/gerrit.py'
2017-10-18 12:50:54,934 [salt.fileclient  ][INFO    ][23209] Fetching file from saltenv 'base', ** done ** '_states/glanceng.py'
2017-10-18 12:50:54,946 [salt.fileclient  ][INFO    ][23209] Fetching file from saltenv 'base', ** done ** '_states/grafana3_dashboard.py'
2017-10-18 12:50:54,957 [salt.fileclient  ][INFO    ][23209] Fetching file from saltenv 'base', ** done ** '_states/grafana3_datasource.py'
2017-10-18 12:50:54,967 [salt.fileclient  ][INFO    ][23209] Fetching file from saltenv 'base', ** done ** '_states/heat.py'
2017-10-18 12:50:54,977 [salt.fileclient  ][INFO    ][23209] Fetching file from saltenv 'base', ** done ** '_states/helm_release.py'
2017-10-18 12:50:55,005 [salt.fileclient  ][INFO    ][23209] Fetching file from saltenv 'base', ** done ** '_states/jenkins_approval.py'
2017-10-18 12:50:55,016 [salt.fileclient  ][INFO    ][23209] Fetching file from saltenv 'base', ** done ** '_states/jenkins_artifactory.py'
2017-10-18 12:50:55,027 [salt.fileclient  ][INFO    ][23209] Fetching file from saltenv 'base', ** done ** '_states/jenkins_credential.py'
2017-10-18 12:50:55,038 [salt.fileclient  ][INFO    ][23209] Fetching file from saltenv 'base', ** done ** '_states/jenkins_job.py'
2017-10-18 12:50:55,049 [salt.fileclient  ][INFO    ][23209] Fetching file from saltenv 'base', ** done ** '_states/jenkins_lib.py'
2017-10-18 12:50:55,077 [salt.fileclient  ][INFO    ][23209] Fetching file from saltenv 'base', ** done ** '_states/jenkins_node.py'
2017-10-18 12:50:55,089 [salt.fileclient  ][INFO    ][23209] Fetching file from saltenv 'base', ** done ** '_states/jenkins_plugin.py'
2017-10-18 12:50:55,101 [salt.fileclient  ][INFO    ][23209] Fetching file from saltenv 'base', ** done ** '_states/jenkins_security.py'
2017-10-18 12:50:55,112 [salt.fileclient  ][INFO    ][23209] Fetching file from saltenv 'base', ** done ** '_states/jenkins_slack.py'
2017-10-18 12:50:55,125 [salt.fileclient  ][INFO    ][23209] Fetching file from saltenv 'base', ** done ** '_states/jenkins_smtp.py'
2017-10-18 12:50:55,137 [salt.fileclient  ][INFO    ][23209] Fetching file from saltenv 'base', ** done ** '_states/jenkins_theme.py'
2017-10-18 12:50:55,148 [salt.fileclient  ][INFO    ][23209] Fetching file from saltenv 'base', ** done ** '_states/jenkins_user.py'
2017-10-18 12:50:55,159 [salt.fileclient  ][INFO    ][23209] Fetching file from saltenv 'base', ** done ** '_states/jenkins_view.py'
2017-10-18 12:50:55,169 [salt.fileclient  ][INFO    ][23209] Fetching file from saltenv 'base', ** done ** '_states/keystone_policy.py'
2017-10-18 12:50:55,179 [salt.fileclient  ][INFO    ][23209] Fetching file from saltenv 'base', ** done ** '_states/kibana_object.py'
2017-10-18 12:50:55,198 [salt.fileclient  ][INFO    ][23209] Fetching file from saltenv 'base', ** done ** '_states/neutronng.py'
2017-10-18 12:50:55,208 [salt.fileclient  ][INFO    ][23209] Fetching file from saltenv 'base', ** done ** '_states/novang.py'
2017-10-18 12:50:55,219 [salt.fileclient  ][INFO    ][23209] Fetching file from saltenv 'base', ** done ** '_states/reclass.py'
2017-10-18 12:50:55,229 [salt.fileclient  ][INFO    ][23209] Fetching file from saltenv 'base', ** done ** '_states/rundeck_project.py'
2017-10-18 12:50:55,257 [salt.fileclient  ][INFO    ][23209] Fetching file from saltenv 'base', ** done ** '_states/rundeck_scm.py'
2017-10-18 12:50:55,266 [salt.fileclient  ][INFO    ][23209] Fetching file from saltenv 'base', ** done ** '_states/rundeck_secret.py'
2017-10-18 12:50:55,269 [salt.utils.extmods][INFO    ][23209] Copying '/var/cache/salt/minion/files/base/_states/cinderng.py' to '/var/cache/salt/minion/extmods/states/cinderng.py'
2017-10-18 12:50:55,269 [salt.utils.extmods][INFO    ][23209] Copying '/var/cache/salt/minion/files/base/_states/contrail.py' to '/var/cache/salt/minion/extmods/states/contrail.py'
2017-10-18 12:50:55,308 [salt.utils.extmods][INFO    ][23209] Copying '/var/cache/salt/minion/files/base/_states/gerrit.py' to '/var/cache/salt/minion/extmods/states/gerrit.py'
2017-10-18 12:50:55,308 [salt.utils.extmods][INFO    ][23209] Copying '/var/cache/salt/minion/files/base/_states/glanceng.py' to '/var/cache/salt/minion/extmods/states/glanceng.py'
2017-10-18 12:50:55,309 [salt.utils.extmods][INFO    ][23209] Copying '/var/cache/salt/minion/files/base/_states/grafana3_dashboard.py' to '/var/cache/salt/minion/extmods/states/grafana3_dashboard.py'
2017-10-18 12:50:55,309 [salt.utils.extmods][INFO    ][23209] Copying '/var/cache/salt/minion/files/base/_states/grafana3_datasource.py' to '/var/cache/salt/minion/extmods/states/grafana3_datasource.py'
2017-10-18 12:50:55,309 [salt.utils.extmods][INFO    ][23209] Copying '/var/cache/salt/minion/files/base/_states/heat.py' to '/var/cache/salt/minion/extmods/states/heat.py'
2017-10-18 12:50:55,309 [salt.utils.extmods][INFO    ][23209] Copying '/var/cache/salt/minion/files/base/_states/helm_release.py' to '/var/cache/salt/minion/extmods/states/helm_release.py'
2017-10-18 12:50:55,310 [salt.utils.extmods][INFO    ][23209] Copying '/var/cache/salt/minion/files/base/_states/jenkins_approval.py' to '/var/cache/salt/minion/extmods/states/jenkins_approval.py'
2017-10-18 12:50:55,310 [salt.utils.extmods][INFO    ][23209] Copying '/var/cache/salt/minion/files/base/_states/jenkins_artifactory.py' to '/var/cache/salt/minion/extmods/states/jenkins_artifactory.py'
2017-10-18 12:50:55,310 [salt.utils.extmods][INFO    ][23209] Copying '/var/cache/salt/minion/files/base/_states/jenkins_credential.py' to '/var/cache/salt/minion/extmods/states/jenkins_credential.py'
2017-10-18 12:50:55,310 [salt.utils.extmods][INFO    ][23209] Copying '/var/cache/salt/minion/files/base/_states/jenkins_job.py' to '/var/cache/salt/minion/extmods/states/jenkins_job.py'
2017-10-18 12:50:55,311 [salt.utils.extmods][INFO    ][23209] Copying '/var/cache/salt/minion/files/base/_states/jenkins_lib.py' to '/var/cache/salt/minion/extmods/states/jenkins_lib.py'
2017-10-18 12:50:55,311 [salt.utils.extmods][INFO    ][23209] Copying '/var/cache/salt/minion/files/base/_states/jenkins_node.py' to '/var/cache/salt/minion/extmods/states/jenkins_node.py'
2017-10-18 12:50:55,311 [salt.utils.extmods][INFO    ][23209] Copying '/var/cache/salt/minion/files/base/_states/jenkins_plugin.py' to '/var/cache/salt/minion/extmods/states/jenkins_plugin.py'
2017-10-18 12:50:55,311 [salt.utils.extmods][INFO    ][23209] Copying '/var/cache/salt/minion/files/base/_states/jenkins_security.py' to '/var/cache/salt/minion/extmods/states/jenkins_security.py'
2017-10-18 12:50:55,312 [salt.utils.extmods][INFO    ][23209] Copying '/var/cache/salt/minion/files/base/_states/jenkins_slack.py' to '/var/cache/salt/minion/extmods/states/jenkins_slack.py'
2017-10-18 12:50:55,312 [salt.utils.extmods][INFO    ][23209] Copying '/var/cache/salt/minion/files/base/_states/jenkins_smtp.py' to '/var/cache/salt/minion/extmods/states/jenkins_smtp.py'
2017-10-18 12:50:55,312 [salt.utils.extmods][INFO    ][23209] Copying '/var/cache/salt/minion/files/base/_states/jenkins_theme.py' to '/var/cache/salt/minion/extmods/states/jenkins_theme.py'
2017-10-18 12:50:55,312 [salt.utils.extmods][INFO    ][23209] Copying '/var/cache/salt/minion/files/base/_states/jenkins_user.py' to '/var/cache/salt/minion/extmods/states/jenkins_user.py'
2017-10-18 12:50:55,312 [salt.utils.extmods][INFO    ][23209] Copying '/var/cache/salt/minion/files/base/_states/jenkins_view.py' to '/var/cache/salt/minion/extmods/states/jenkins_view.py'
2017-10-18 12:50:55,313 [salt.utils.extmods][INFO    ][23209] Copying '/var/cache/salt/minion/files/base/_states/keystone_policy.py' to '/var/cache/salt/minion/extmods/states/keystone_policy.py'
2017-10-18 12:50:55,313 [salt.utils.extmods][INFO    ][23209] Copying '/var/cache/salt/minion/files/base/_states/kibana_object.py' to '/var/cache/salt/minion/extmods/states/kibana_object.py'
2017-10-18 12:50:55,313 [salt.utils.extmods][INFO    ][23209] Copying '/var/cache/salt/minion/files/base/_states/maas_cluster.py' to '/var/cache/salt/minion/extmods/states/maas_cluster.py'
2017-10-18 12:50:55,313 [salt.utils.extmods][INFO    ][23209] Copying '/var/cache/salt/minion/files/base/_states/neutronng.py' to '/var/cache/salt/minion/extmods/states/neutronng.py'
2017-10-18 12:50:55,314 [salt.utils.extmods][INFO    ][23209] Copying '/var/cache/salt/minion/files/base/_states/novang.py' to '/var/cache/salt/minion/extmods/states/novang.py'
2017-10-18 12:50:55,314 [salt.utils.extmods][INFO    ][23209] Copying '/var/cache/salt/minion/files/base/_states/reclass.py' to '/var/cache/salt/minion/extmods/states/reclass.py'
2017-10-18 12:50:55,314 [salt.utils.extmods][INFO    ][23209] Copying '/var/cache/salt/minion/files/base/_states/rundeck_project.py' to '/var/cache/salt/minion/extmods/states/rundeck_project.py'
2017-10-18 12:50:55,314 [salt.utils.extmods][INFO    ][23209] Copying '/var/cache/salt/minion/files/base/_states/rundeck_scm.py' to '/var/cache/salt/minion/extmods/states/rundeck_scm.py'
2017-10-18 12:50:55,315 [salt.utils.extmods][INFO    ][23209] Copying '/var/cache/salt/minion/files/base/_states/rundeck_secret.py' to '/var/cache/salt/minion/extmods/states/rundeck_secret.py'
2017-10-18 12:50:55,317 [salt.utils.extmods][INFO    ][23209] Creating module dir '/var/cache/salt/minion/extmods/sdb'
2017-10-18 12:50:55,319 [salt.utils.extmods][INFO    ][23209] Syncing sdb for environment 'base'
2017-10-18 12:50:55,319 [salt.utils.extmods][INFO    ][23209] Loading cache from salt://_sdb, for base)
2017-10-18 12:50:55,319 [salt.fileclient  ][INFO    ][23209] Caching directory '_sdb/' for environment 'base'
2017-10-18 12:50:55,352 [salt.utils.extmods][INFO    ][23209] Syncing grains for environment 'base'
2017-10-18 12:50:55,353 [salt.utils.extmods][INFO    ][23209] Loading cache from salt://_grains, for base)
2017-10-18 12:50:55,353 [salt.fileclient  ][INFO    ][23209] Caching directory '_grains/' for environment 'base'
2017-10-18 12:50:55,383 [salt.fileclient  ][INFO    ][23209] Fetching file from saltenv 'base', ** done ** '_grains/ceilometer_policy.py'
2017-10-18 12:50:55,392 [salt.fileclient  ][INFO    ][23209] Fetching file from saltenv 'base', ** done ** '_grains/ceph.py'
2017-10-18 12:50:55,401 [salt.fileclient  ][INFO    ][23209] Fetching file from saltenv 'base', ** done ** '_grains/cinder_policy.py'
2017-10-18 12:50:55,410 [salt.fileclient  ][INFO    ][23209] Fetching file from saltenv 'base', ** done ** '_grains/docker_swarm.py'
2017-10-18 12:50:55,431 [salt.fileclient  ][INFO    ][23209] Fetching file from saltenv 'base', ** done ** '_grains/glance_policy.py'
2017-10-18 12:50:55,439 [salt.fileclient  ][INFO    ][23209] Fetching file from saltenv 'base', ** done ** '_grains/heat_policy.py'
2017-10-18 12:50:55,448 [salt.fileclient  ][INFO    ][23209] Fetching file from saltenv 'base', ** done ** '_grains/jenkins_plugins.py'
2017-10-18 12:50:55,458 [salt.fileclient  ][INFO    ][23209] Fetching file from saltenv 'base', ** done ** '_grains/keystone_policy.py'
2017-10-18 12:50:55,467 [salt.fileclient  ][INFO    ][23209] Fetching file from saltenv 'base', ** done ** '_grains/kubernetes.py'
2017-10-18 12:50:55,475 [salt.fileclient  ][INFO    ][23209] Fetching file from saltenv 'base', ** done ** '_grains/neutron_policy.py'
2017-10-18 12:50:55,611 [salt.fileclient  ][INFO    ][23209] Fetching file from saltenv 'base', ** done ** '_grains/nova_policy.py'
2017-10-18 12:50:55,621 [salt.fileclient  ][INFO    ][23209] Fetching file from saltenv 'base', ** done ** '_grains/ssh_fingerprints.py'
2017-10-18 12:50:55,623 [salt.utils.extmods][INFO    ][23209] Copying '/var/cache/salt/minion/files/base/_grains/ceilometer_policy.py' to '/var/cache/salt/minion/extmods/grains/ceilometer_policy.py'
2017-10-18 12:50:55,624 [salt.utils.extmods][INFO    ][23209] Copying '/var/cache/salt/minion/files/base/_grains/ceph.py' to '/var/cache/salt/minion/extmods/grains/ceph.py'
2017-10-18 12:50:55,624 [salt.utils.extmods][INFO    ][23209] Copying '/var/cache/salt/minion/files/base/_grains/cinder_policy.py' to '/var/cache/salt/minion/extmods/grains/cinder_policy.py'
2017-10-18 12:50:55,624 [salt.utils.extmods][INFO    ][23209] Copying '/var/cache/salt/minion/files/base/_grains/docker_swarm.py' to '/var/cache/salt/minion/extmods/grains/docker_swarm.py'
2017-10-18 12:50:55,624 [salt.utils.extmods][INFO    ][23209] Copying '/var/cache/salt/minion/files/base/_grains/glance_policy.py' to '/var/cache/salt/minion/extmods/grains/glance_policy.py'
2017-10-18 12:50:55,625 [salt.utils.extmods][INFO    ][23209] Copying '/var/cache/salt/minion/files/base/_grains/heat_policy.py' to '/var/cache/salt/minion/extmods/grains/heat_policy.py'
2017-10-18 12:50:55,625 [salt.utils.extmods][INFO    ][23209] Copying '/var/cache/salt/minion/files/base/_grains/jenkins_plugins.py' to '/var/cache/salt/minion/extmods/grains/jenkins_plugins.py'
2017-10-18 12:50:55,625 [salt.utils.extmods][INFO    ][23209] Copying '/var/cache/salt/minion/files/base/_grains/keystone_policy.py' to '/var/cache/salt/minion/extmods/grains/keystone_policy.py'
2017-10-18 12:50:55,625 [salt.utils.extmods][INFO    ][23209] Copying '/var/cache/salt/minion/files/base/_grains/kubernetes.py' to '/var/cache/salt/minion/extmods/grains/kubernetes.py'
2017-10-18 12:50:55,626 [salt.utils.extmods][INFO    ][23209] Copying '/var/cache/salt/minion/files/base/_grains/neutron_policy.py' to '/var/cache/salt/minion/extmods/grains/neutron_policy.py'
2017-10-18 12:50:55,626 [salt.utils.extmods][INFO    ][23209] Copying '/var/cache/salt/minion/files/base/_grains/nova_policy.py' to '/var/cache/salt/minion/extmods/grains/nova_policy.py'
2017-10-18 12:50:55,626 [salt.utils.extmods][INFO    ][23209] Copying '/var/cache/salt/minion/files/base/_grains/ssh_fingerprints.py' to '/var/cache/salt/minion/extmods/grains/ssh_fingerprints.py'
2017-10-18 12:50:55,628 [salt.utils.extmods][INFO    ][23209] Creating module dir '/var/cache/salt/minion/extmods/renderers'
2017-10-18 12:50:55,630 [salt.utils.extmods][INFO    ][23209] Syncing renderers for environment 'base'
2017-10-18 12:50:55,630 [salt.utils.extmods][INFO    ][23209] Loading cache from salt://_renderers, for base)
2017-10-18 12:50:55,631 [salt.fileclient  ][INFO    ][23209] Caching directory '_renderers/' for environment 'base'
2017-10-18 12:50:55,665 [salt.utils.extmods][INFO    ][23209] Creating module dir '/var/cache/salt/minion/extmods/returners'
2017-10-18 12:50:55,667 [salt.utils.extmods][INFO    ][23209] Syncing returners for environment 'base'
2017-10-18 12:50:55,667 [salt.utils.extmods][INFO    ][23209] Loading cache from salt://_returners, for base)
2017-10-18 12:50:55,667 [salt.fileclient  ][INFO    ][23209] Caching directory '_returners/' for environment 'base'
2017-10-18 12:50:55,701 [salt.utils.extmods][INFO    ][23209] Creating module dir '/var/cache/salt/minion/extmods/output'
2017-10-18 12:50:55,703 [salt.utils.extmods][INFO    ][23209] Syncing output for environment 'base'
2017-10-18 12:50:55,703 [salt.utils.extmods][INFO    ][23209] Loading cache from salt://_output, for base)
2017-10-18 12:50:55,703 [salt.fileclient  ][INFO    ][23209] Caching directory '_output/' for environment 'base'
2017-10-18 12:50:55,738 [salt.utils.extmods][INFO    ][23209] Creating module dir '/var/cache/salt/minion/extmods/utils'
2017-10-18 12:50:55,741 [salt.utils.extmods][INFO    ][23209] Syncing utils for environment 'base'
2017-10-18 12:50:55,741 [salt.utils.extmods][INFO    ][23209] Loading cache from salt://_utils, for base)
2017-10-18 12:50:55,741 [salt.fileclient  ][INFO    ][23209] Caching directory '_utils/' for environment 'base'
2017-10-18 12:50:55,769 [salt.utils.extmods][INFO    ][23209] Creating module dir '/var/cache/salt/minion/extmods/log_handlers'
2017-10-18 12:50:55,772 [salt.utils.extmods][INFO    ][23209] Syncing log_handlers for environment 'base'
2017-10-18 12:50:55,772 [salt.utils.extmods][INFO    ][23209] Loading cache from salt://_log_handlers, for base)
2017-10-18 12:50:55,772 [salt.fileclient  ][INFO    ][23209] Caching directory '_log_handlers/' for environment 'base'
2017-10-18 12:50:55,797 [salt.utils.extmods][INFO    ][23209] Creating module dir '/var/cache/salt/minion/extmods/proxy'
2017-10-18 12:50:55,799 [salt.utils.extmods][INFO    ][23209] Syncing proxy for environment 'base'
2017-10-18 12:50:55,799 [salt.utils.extmods][INFO    ][23209] Loading cache from salt://_proxy, for base)
2017-10-18 12:50:55,800 [salt.fileclient  ][INFO    ][23209] Caching directory '_proxy/' for environment 'base'
2017-10-18 12:50:55,829 [salt.utils.extmods][INFO    ][23209] Creating module dir '/var/cache/salt/minion/extmods/engines'
2017-10-18 12:50:55,832 [salt.utils.extmods][INFO    ][23209] Syncing engines for environment 'base'
2017-10-18 12:50:55,832 [salt.utils.extmods][INFO    ][23209] Loading cache from salt://_engines, for base)
2017-10-18 12:50:55,832 [salt.fileclient  ][INFO    ][23209] Caching directory '_engines/' for environment 'base'
2017-10-18 12:50:55,872 [salt.minion      ][INFO    ][23209] Returning information for job: 20171018125051783004
2017-10-18 12:50:59,458 [salt.minion      ][INFO    ][23091] User sudo_ubuntu Executing command state.sls with jid 20171018125059445992
2017-10-18 12:50:59,472 [salt.minion      ][INFO    ][23345] Starting a new job with PID 23345
2017-10-18 12:50:59,887 [salt.state       ][INFO    ][23345] Loading fresh modules for state activity
2017-10-18 12:50:59,910 [salt.fileclient  ][INFO    ][23345] Fetching file from saltenv 'base', ** done ** 'salt/control/init.sls'
2017-10-18 12:50:59,937 [salt.fileclient  ][INFO    ][23345] Fetching file from saltenv 'base', ** done ** 'salt/control/virt.sls'
2017-10-18 12:50:59,975 [salt.fileclient  ][INFO    ][23345] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-10-18 12:51:00,090 [salt.fileclient  ][INFO    ][23345] Fetching file from saltenv 'base', ** done ** 'salt/minion/init.sls'
2017-10-18 12:51:00,116 [salt.fileclient  ][INFO    ][23345] Fetching file from saltenv 'base', ** done ** 'salt/minion/service.sls'
2017-10-18 12:51:00,146 [salt.fileclient  ][INFO    ][23345] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-10-18 12:51:00,198 [salt.fileclient  ][INFO    ][23345] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-10-18 12:51:00,220 [salt.fileclient  ][INFO    ][23345] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-10-18 12:51:00,270 [salt.fileclient  ][INFO    ][23345] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-10-18 12:51:00,287 [salt.fileclient  ][INFO    ][23345] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-10-18 12:51:00,327 [salt.fileclient  ][INFO    ][23345] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-10-18 12:51:00,342 [salt.fileclient  ][INFO    ][23345] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-10-18 12:51:00,349 [salt.loaded.int.module.cmdmod][INFO    ][23345] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-10-18 12:51:00,369 [salt.fileclient  ][INFO    ][23345] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-10-18 12:51:00,383 [py.warnings      ][WARNING ][23345] /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-18 12:51:00,384 [salt.loaded.int.module.cmdmod][INFO    ][23345] Executing command 'salt-minion --version' in directory '/root'
2017-10-18 12:51:00,626 [salt.fileclient  ][INFO    ][23345] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-10-18 12:51:00,662 [salt.fileclient  ][INFO    ][23345] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-10-18 12:51:00,690 [salt.fileclient  ][INFO    ][23345] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-10-18 12:51:00,703 [salt.fileclient  ][INFO    ][23345] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-10-18 12:51:00,750 [salt.fileclient  ][INFO    ][23345] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-10-18 12:51:00,787 [salt.fileclient  ][INFO    ][23345] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-10-18 12:51:00,845 [salt.fileclient  ][INFO    ][23345] Fetching file from saltenv 'base', ** done ** 'salt/minion/grains.sls'
2017-10-18 12:51:00,866 [salt.fileclient  ][INFO    ][23345] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-10-18 12:51:00,918 [salt.fileclient  ][INFO    ][23345] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-10-18 12:51:00,934 [salt.fileclient  ][INFO    ][23345] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-10-18 12:51:00,975 [salt.fileclient  ][INFO    ][23345] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-10-18 12:51:00,995 [salt.fileclient  ][INFO    ][23345] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-10-18 12:51:01,007 [salt.fileclient  ][INFO    ][23345] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-10-18 12:51:01,022 [salt.fileclient  ][INFO    ][23345] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-10-18 12:51:01,028 [salt.loaded.int.module.cmdmod][INFO    ][23345] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-10-18 12:51:01,050 [salt.fileclient  ][INFO    ][23345] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-10-18 12:51:01,065 [salt.loaded.int.module.cmdmod][INFO    ][23345] Executing command 'salt-minion --version' in directory '/root'
2017-10-18 12:51:01,317 [salt.fileclient  ][INFO    ][23345] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-10-18 12:51:01,336 [salt.fileclient  ][INFO    ][23345] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-10-18 12:51:01,350 [salt.fileclient  ][INFO    ][23345] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-10-18 12:51:01,362 [salt.fileclient  ][INFO    ][23345] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-10-18 12:51:01,415 [salt.fileclient  ][INFO    ][23345] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-10-18 12:51:01,457 [salt.fileclient  ][INFO    ][23345] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-10-18 12:51:01,525 [salt.fileclient  ][INFO    ][23345] Fetching file from saltenv 'base', ** done ** 'salt/minion/cert.sls'
2017-10-18 12:51:01,579 [salt.fileclient  ][INFO    ][23345] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-10-18 12:51:01,968 [salt.state       ][INFO    ][23345] Running state [salt-minion] at time 12:51:01.968025
2017-10-18 12:51:01,968 [salt.state       ][INFO    ][23345] Executing state pkg.installed for salt-minion
2017-10-18 12:51:01,969 [salt.loaded.int.module.cmdmod][INFO    ][23345] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-10-18 12:51:02,275 [salt.state       ][INFO    ][23345] Package salt-minion is already installed
2017-10-18 12:51:02,276 [salt.state       ][INFO    ][23345] Completed state [salt-minion] at time 12:51:02.275438 duration_in_ms=307.414
2017-10-18 12:51:02,276 [salt.state       ][INFO    ][23345] Running state [salt_minion_dependency_packages] at time 12:51:02.275790
2017-10-18 12:51:02,276 [salt.state       ][INFO    ][23345] Executing state pkg.installed for salt_minion_dependency_packages
2017-10-18 12:51:02,279 [salt.state       ][INFO    ][23345] All specified packages are already installed
2017-10-18 12:51:02,279 [salt.state       ][INFO    ][23345] Completed state [salt_minion_dependency_packages] at time 12:51:02.279042 duration_in_ms=3.252
2017-10-18 12:51:02,281 [salt.state       ][INFO    ][23345] Running state [/etc/salt/minion.d/minion.conf] at time 12:51:02.280805
2017-10-18 12:51:02,281 [salt.state       ][INFO    ][23345] Executing state file.managed for /etc/salt/minion.d/minion.conf
2017-10-18 12:51:02,302 [salt.fileclient  ][INFO    ][23345] Fetching file from saltenv 'base', ** done ** 'salt/files/minion.conf'
2017-10-18 12:51:02,350 [salt.fileclient  ][INFO    ][23345] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-10-18 12:51:02,394 [salt.fileclient  ][INFO    ][23345] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-10-18 12:51:02,428 [salt.state       ][INFO    ][23345] File /etc/salt/minion.d/minion.conf is in the correct state
2017-10-18 12:51:02,428 [salt.state       ][INFO    ][23345] Completed state [/etc/salt/minion.d/minion.conf] at time 12:51:02.428093 duration_in_ms=147.286
2017-10-18 12:51:02,429 [salt.state       ][INFO    ][23345] Running state [/etc/salt/minion.d/_virt.conf] at time 12:51:02.428499
2017-10-18 12:51:02,429 [salt.state       ][INFO    ][23345] Executing state file.managed for /etc/salt/minion.d/_virt.conf
2017-10-18 12:51:02,486 [salt.state       ][INFO    ][23345] File /etc/salt/minion.d/_virt.conf is in the correct state
2017-10-18 12:51:02,486 [salt.state       ][INFO    ][23345] Completed state [/etc/salt/minion.d/_virt.conf] at time 12:51:02.485724 duration_in_ms=57.223
2017-10-18 12:51:02,487 [salt.state       ][INFO    ][23345] Running state [salt-minion] at time 12:51:02.487321
2017-10-18 12:51:02,488 [salt.state       ][INFO    ][23345] Executing state service.running for salt-minion
2017-10-18 12:51:02,488 [salt.loaded.int.module.cmdmod][INFO    ][23345] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2017-10-18 12:51:02,505 [salt.loaded.int.module.cmdmod][INFO    ][23345] Executing command ['systemctl', 'is-active', 'salt-minion.service'] in directory '/root'
2017-10-18 12:51:02,528 [salt.loaded.int.module.cmdmod][INFO    ][23345] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2017-10-18 12:51:02,536 [salt.state       ][INFO    ][23345] The service salt-minion is already running
2017-10-18 12:51:02,537 [salt.state       ][INFO    ][23345] Completed state [salt-minion] at time 12:51:02.536598 duration_in_ms=49.276
2017-10-18 12:51:02,538 [salt.state       ][INFO    ][23345] Running state [/etc/salt/grains.d] at time 12:51:02.537946
2017-10-18 12:51:02,538 [salt.state       ][INFO    ][23345] Executing state file.directory for /etc/salt/grains.d
2017-10-18 12:51:02,539 [salt.state       ][INFO    ][23345] Directory /etc/salt/grains.d is in the correct state
2017-10-18 12:51:02,539 [salt.state       ][INFO    ][23345] Completed state [/etc/salt/grains.d] at time 12:51:02.538866 duration_in_ms=0.92
2017-10-18 12:51:02,539 [salt.state       ][INFO    ][23345] Running state [/etc/salt/grains] at time 12:51:02.539305
2017-10-18 12:51:02,540 [salt.state       ][INFO    ][23345] Executing state file.managed for /etc/salt/grains
2017-10-18 12:51:02,540 [salt.state       ][INFO    ][23345] File /etc/salt/grains exists with proper permissions. No changes made.
2017-10-18 12:51:02,540 [salt.state       ][INFO    ][23345] Completed state [/etc/salt/grains] at time 12:51:02.540000 duration_in_ms=0.695
2017-10-18 12:51:02,540 [salt.state       ][INFO    ][23345] Running state [/etc/salt/grains.d/placeholder] at time 12:51:02.540278
2017-10-18 12:51:02,540 [salt.state       ][INFO    ][23345] Executing state file.managed for /etc/salt/grains.d/placeholder
2017-10-18 12:51:02,541 [salt.state       ][INFO    ][23345] File /etc/salt/grains.d/placeholder exists with proper permissions. No changes made.
2017-10-18 12:51:02,541 [salt.state       ][INFO    ][23345] Completed state [/etc/salt/grains.d/placeholder] at time 12:51:02.540908 duration_in_ms=0.63
2017-10-18 12:51:02,541 [salt.state       ][INFO    ][23345] Running state [/etc/salt/grains.d/sphinx] at time 12:51:02.541185
2017-10-18 12:51:02,541 [salt.state       ][INFO    ][23345] Executing state file.managed for /etc/salt/grains.d/sphinx
2017-10-18 12:51:02,724 [salt.state       ][INFO    ][23345] File changed:
--- 
+++ 
@@ -49,7 +49,6 @@
               - 10.167.4.143
               - 127.0.0.1
               - 192.168.11.252
-              - 192.168.122.1
         system:
           name: System
           param:

2017-10-18 12:51:02,724 [salt.state       ][INFO    ][23345] Completed state [/etc/salt/grains.d/sphinx] at time 12:51:02.723891 duration_in_ms=182.707
2017-10-18 12:51:02,725 [salt.state       ][INFO    ][23345] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 12:51:02.725043
2017-10-18 12:51:02,725 [salt.state       ][INFO    ][23345] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-10-18 12:51:02,726 [salt.state       ][INFO    ][23345] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-10-18 12:51:02,726 [salt.state       ][INFO    ][23345] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 12:51:02.725931 duration_in_ms=0.889
2017-10-18 12:51:02,726 [salt.state       ][INFO    ][23345] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 12:51:02.726130
2017-10-18 12:51:02,726 [salt.state       ][INFO    ][23345] 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-18 12:51:02,727 [salt.loaded.int.module.cmdmod][INFO    ][23345] Executing command 'python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"' in directory '/root'
2017-10-18 12:51:02,836 [salt.state       ][INFO    ][23345] {'pid': 23393, 'retcode': 0, 'stderr': '', 'stdout': ''}
2017-10-18 12:51:02,836 [salt.state       ][INFO    ][23345] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 12:51:02.836130 duration_in_ms=110.0
2017-10-18 12:51:02,837 [salt.state       ][INFO    ][23345] Running state [/etc/salt/grains.d/dns_records] at time 12:51:02.836568
2017-10-18 12:51:02,837 [salt.state       ][INFO    ][23345] Executing state file.managed for /etc/salt/grains.d/dns_records
2017-10-18 12:51:02,897 [salt.state       ][INFO    ][23345] File /etc/salt/grains.d/dns_records is in the correct state
2017-10-18 12:51:02,898 [salt.state       ][INFO    ][23345] Completed state [/etc/salt/grains.d/dns_records] at time 12:51:02.897562 duration_in_ms=60.994
2017-10-18 12:51:02,899 [salt.state       ][INFO    ][23345] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 12:51:02.898483
2017-10-18 12:51:02,899 [salt.state       ][INFO    ][23345] 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-18 12:51:02,899 [salt.state       ][INFO    ][23345] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"
2017-10-18 12:51:02,899 [salt.state       ][INFO    ][23345] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 12:51:02.899276 duration_in_ms=0.794
2017-10-18 12:51:02,900 [salt.state       ][INFO    ][23345] Running state [/etc/salt/grains.d/salt] at time 12:51:02.899557
2017-10-18 12:51:02,900 [salt.state       ][INFO    ][23345] Executing state file.managed for /etc/salt/grains.d/salt
2017-10-18 12:51:03,019 [salt.state       ][INFO    ][23345] File /etc/salt/grains.d/salt is in the correct state
2017-10-18 12:51:03,019 [salt.state       ][INFO    ][23345] Completed state [/etc/salt/grains.d/salt] at time 12:51:03.018999 duration_in_ms=119.442
2017-10-18 12:51:03,020 [salt.state       ][INFO    ][23345] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 12:51:03.019664
2017-10-18 12:51:03,020 [salt.state       ][INFO    ][23345] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2017-10-18 12:51:03,020 [salt.state       ][INFO    ][23345] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2017-10-18 12:51:03,020 [salt.state       ][INFO    ][23345] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 12:51:03.020195 duration_in_ms=0.53
2017-10-18 12:51:03,021 [salt.state       ][INFO    ][23345] Running state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 12:51:03.021378
2017-10-18 12:51:03,022 [salt.state       ][INFO    ][23345] Executing state cmd.wait for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-10-18 12:51:03,022 [salt.state       ][INFO    ][23345] No changes made for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-10-18 12:51:03,022 [salt.state       ][INFO    ][23345] Completed state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 12:51:03.021853 duration_in_ms=0.475
2017-10-18 12:51:03,022 [salt.state       ][INFO    ][23345] Running state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 12:51:03.021976
2017-10-18 12:51:03,022 [salt.state       ][INFO    ][23345] Executing state cmd.mod_watch for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-10-18 12:51:03,023 [salt.loaded.int.module.cmdmod][INFO    ][23345] Executing command 'cat /etc/salt/grains.d/* > /etc/salt/grains' in directory '/root'
2017-10-18 12:51:03,032 [salt.state       ][INFO    ][23345] {'pid': 23395, 'retcode': 0, 'stderr': '', 'stdout': ''}
2017-10-18 12:51:03,032 [salt.state       ][INFO    ][23345] Completed state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 12:51:03.031779 duration_in_ms=9.803
2017-10-18 12:51:03,032 [salt.state       ][INFO    ][23345] Running state [mine.update] at time 12:51:03.032362
2017-10-18 12:51:03,033 [salt.state       ][INFO    ][23345] Executing state module.wait for mine.update
2017-10-18 12:51:03,033 [salt.state       ][INFO    ][23345] No changes made for mine.update
2017-10-18 12:51:03,033 [salt.state       ][INFO    ][23345] Completed state [mine.update] at time 12:51:03.032923 duration_in_ms=0.561
2017-10-18 12:51:03,033 [salt.state       ][INFO    ][23345] Running state [mine.update] at time 12:51:03.033069
2017-10-18 12:51:03,033 [salt.state       ][INFO    ][23345] Executing state module.mod_watch for mine.update
2017-10-18 12:51:03,553 [salt.state       ][INFO    ][23345] {'ret': True}
2017-10-18 12:51:03,553 [salt.state       ][INFO    ][23345] Completed state [mine.update] at time 12:51:03.553190 duration_in_ms=520.121
2017-10-18 12:51:03,554 [salt.state       ][INFO    ][23345] Running state [ca-certificates] at time 12:51:03.553479
2017-10-18 12:51:03,554 [salt.state       ][INFO    ][23345] Executing state pkg.installed for ca-certificates
2017-10-18 12:51:03,557 [salt.state       ][INFO    ][23345] Package ca-certificates is already installed
2017-10-18 12:51:03,557 [salt.state       ][INFO    ][23345] Completed state [ca-certificates] at time 12:51:03.557096 duration_in_ms=3.616
2017-10-18 12:51:03,558 [salt.state       ][INFO    ][23345] Running state [update-ca-certificates] at time 12:51:03.557671
2017-10-18 12:51:03,558 [salt.state       ][INFO    ][23345] Executing state cmd.wait for update-ca-certificates
2017-10-18 12:51:03,558 [salt.state       ][INFO    ][23345] No changes made for update-ca-certificates
2017-10-18 12:51:03,558 [salt.state       ][INFO    ][23345] Completed state [update-ca-certificates] at time 12:51:03.558286 duration_in_ms=0.616
2017-10-18 12:51:03,559 [salt.state       ][INFO    ][23345] Running state [libvirt-dev] at time 12:51:03.558475
2017-10-18 12:51:03,559 [salt.state       ][INFO    ][23345] Executing state pkg.installed for libvirt-dev
2017-10-18 12:51:03,561 [salt.state       ][INFO    ][23345] Package libvirt-dev is already installed
2017-10-18 12:51:03,562 [salt.state       ][INFO    ][23345] Completed state [libvirt-dev] at time 12:51:03.561534 duration_in_ms=3.059
2017-10-18 12:51:03,562 [salt.state       ][INFO    ][23345] Running state [pkg-config] at time 12:51:03.561720
2017-10-18 12:51:03,562 [salt.state       ][INFO    ][23345] Executing state pkg.installed for pkg-config
2017-10-18 12:51:03,565 [salt.state       ][INFO    ][23345] Package pkg-config is already installed
2017-10-18 12:51:03,565 [salt.state       ][INFO    ][23345] Completed state [pkg-config] at time 12:51:03.564791 duration_in_ms=3.071
2017-10-18 12:51:03,565 [salt.state       ][INFO    ][23345] Running state [virtng.init] at time 12:51:03.564978
2017-10-18 12:51:03,565 [salt.state       ][INFO    ][23345] Executing state module.run for virtng.init
2017-10-18 12:51:03,625 [salt.loaded.int.module.cmdmod][INFO    ][23345] Executing command ['git', '--version'] in directory '/root'
2017-10-18 12:51:03,754 [salt.loaded.int.module.cmdmod][INFO    ][23345] Executing command 'virsh list --all --name| grep -E "^mdb03.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-10-18 12:51:03,775 [salt.state       ][INFO    ][23345] unless execution succeeded
2017-10-18 12:51:03,775 [salt.state       ][INFO    ][23345] Completed state [virtng.init] at time 12:51:03.774851 duration_in_ms=209.871
2017-10-18 12:51:03,775 [salt.state       ][INFO    ][23345] Running state [virt.set_autostart] at time 12:51:03.775109
2017-10-18 12:51:03,775 [salt.state       ][INFO    ][23345] Executing state module.run for virt.set_autostart
2017-10-18 12:51:03,777 [salt.loaded.int.module.cmdmod][INFO    ][23345] Executing command 'virsh list --autostart --name| grep -E "^mdb03.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-10-18 12:51:03,795 [salt.state       ][INFO    ][23345] unless execution succeeded
2017-10-18 12:51:03,797 [salt.state       ][INFO    ][23345] Completed state [virt.set_autostart] at time 12:51:03.797082 duration_in_ms=21.973
2017-10-18 12:51:03,797 [salt.state       ][INFO    ][23345] Running state [virtng.init] at time 12:51:03.797364
2017-10-18 12:51:03,798 [salt.state       ][INFO    ][23345] Executing state module.run for virtng.init
2017-10-18 12:51:03,800 [salt.loaded.int.module.cmdmod][INFO    ][23345] Executing command 'virsh list --all --name| grep -E "^dbs03.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-10-18 12:51:03,814 [salt.state       ][INFO    ][23345] unless execution succeeded
2017-10-18 12:51:03,815 [salt.state       ][INFO    ][23345] Completed state [virtng.init] at time 12:51:03.814633 duration_in_ms=17.269
2017-10-18 12:51:03,815 [salt.state       ][INFO    ][23345] Running state [virt.set_autostart] at time 12:51:03.814850
2017-10-18 12:51:03,815 [salt.state       ][INFO    ][23345] Executing state module.run for virt.set_autostart
2017-10-18 12:51:03,817 [salt.loaded.int.module.cmdmod][INFO    ][23345] Executing command 'virsh list --autostart --name| grep -E "^dbs03.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-10-18 12:51:03,830 [salt.state       ][INFO    ][23345] unless execution succeeded
2017-10-18 12:51:03,831 [salt.state       ][INFO    ][23345] Completed state [virt.set_autostart] at time 12:51:03.830673 duration_in_ms=15.822
2017-10-18 12:51:03,831 [salt.state       ][INFO    ][23345] Running state [virtng.init] at time 12:51:03.830882
2017-10-18 12:51:03,831 [salt.state       ][INFO    ][23345] Executing state module.run for virtng.init
2017-10-18 12:51:03,833 [salt.loaded.int.module.cmdmod][INFO    ][23345] Executing command 'virsh list --all --name| grep -E "^prx02.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-10-18 12:51:03,846 [salt.state       ][INFO    ][23345] unless execution succeeded
2017-10-18 12:51:03,847 [salt.state       ][INFO    ][23345] Completed state [virtng.init] at time 12:51:03.846677 duration_in_ms=15.795
2017-10-18 12:51:03,847 [salt.state       ][INFO    ][23345] Running state [virt.set_autostart] at time 12:51:03.846887
2017-10-18 12:51:03,847 [salt.state       ][INFO    ][23345] Executing state module.run for virt.set_autostart
2017-10-18 12:51:03,849 [salt.loaded.int.module.cmdmod][INFO    ][23345] Executing command 'virsh list --autostart --name| grep -E "^prx02.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-10-18 12:51:03,862 [salt.state       ][INFO    ][23345] unless execution succeeded
2017-10-18 12:51:03,862 [salt.state       ][INFO    ][23345] Completed state [virt.set_autostart] at time 12:51:03.862277 duration_in_ms=15.39
2017-10-18 12:51:03,863 [salt.state       ][INFO    ][23345] Running state [virtng.init] at time 12:51:03.862491
2017-10-18 12:51:03,863 [salt.state       ][INFO    ][23345] Executing state module.run for virtng.init
2017-10-18 12:51:03,865 [salt.loaded.int.module.cmdmod][INFO    ][23345] Executing command 'virsh list --all --name| grep -E "^msg03.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-10-18 12:51:03,878 [salt.state       ][INFO    ][23345] unless execution succeeded
2017-10-18 12:51:03,878 [salt.state       ][INFO    ][23345] Completed state [virtng.init] at time 12:51:03.877784 duration_in_ms=15.291
2017-10-18 12:51:03,878 [salt.state       ][INFO    ][23345] Running state [virt.set_autostart] at time 12:51:03.877995
2017-10-18 12:51:03,878 [salt.state       ][INFO    ][23345] Executing state module.run for virt.set_autostart
2017-10-18 12:51:03,880 [salt.loaded.int.module.cmdmod][INFO    ][23345] Executing command 'virsh list --autostart --name| grep -E "^msg03.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-10-18 12:51:03,893 [salt.state       ][INFO    ][23345] unless execution succeeded
2017-10-18 12:51:03,894 [salt.state       ][INFO    ][23345] Completed state [virt.set_autostart] at time 12:51:03.893527 duration_in_ms=15.531
2017-10-18 12:51:03,894 [salt.state       ][INFO    ][23345] Running state [virtng.init] at time 12:51:03.893751
2017-10-18 12:51:03,894 [salt.state       ][INFO    ][23345] Executing state module.run for virtng.init
2017-10-18 12:51:03,896 [salt.loaded.int.module.cmdmod][INFO    ][23345] Executing command 'virsh list --all --name| grep -E "^ctl03.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-10-18 12:51:03,911 [salt.state       ][INFO    ][23345] unless execution succeeded
2017-10-18 12:51:03,911 [salt.state       ][INFO    ][23345] Completed state [virtng.init] at time 12:51:03.911347 duration_in_ms=17.595
2017-10-18 12:51:03,912 [salt.state       ][INFO    ][23345] Running state [virt.set_autostart] at time 12:51:03.911559
2017-10-18 12:51:03,912 [salt.state       ][INFO    ][23345] Executing state module.run for virt.set_autostart
2017-10-18 12:51:03,914 [salt.loaded.int.module.cmdmod][INFO    ][23345] Executing command 'virsh list --autostart --name| grep -E "^ctl03.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-10-18 12:51:03,929 [salt.state       ][INFO    ][23345] unless execution succeeded
2017-10-18 12:51:03,929 [salt.state       ][INFO    ][23345] Completed state [virt.set_autostart] at time 12:51:03.929231 duration_in_ms=17.672
2017-10-18 12:51:03,931 [salt.minion      ][INFO    ][23345] Returning information for job: 20171018125059445992
2017-10-18 12:52:18,871 [salt.minion      ][INFO    ][23091] User sudo_ubuntu Executing command saltutil.sync_all with jid 20171018125218857335
2017-10-18 12:52:18,886 [salt.minion      ][INFO    ][23471] Starting a new job with PID 23471
2017-10-18 12:52:22,171 [salt.state       ][INFO    ][23471] Loading fresh modules for state activity
2017-10-18 12:52:22,189 [salt.state       ][ERROR   ][23471] No contents found in top file
2017-10-18 12:52:22,190 [salt.utils.extmods][INFO    ][23471] Creating module dir '/var/cache/salt/minion/extmods/beacons'
2017-10-18 12:52:22,193 [salt.utils.extmods][INFO    ][23471] Syncing beacons for environment 'base'
2017-10-18 12:52:22,194 [salt.utils.extmods][INFO    ][23471] Loading cache from salt://_beacons, for base)
2017-10-18 12:52:22,194 [salt.fileclient  ][INFO    ][23471] Caching directory '_beacons/' for environment 'base'
2017-10-18 12:52:22,289 [salt.utils.extmods][INFO    ][23471] Syncing modules for environment 'base'
2017-10-18 12:52:22,289 [salt.utils.extmods][INFO    ][23471] Loading cache from salt://_modules, for base)
2017-10-18 12:52:22,289 [salt.fileclient  ][INFO    ][23471] Caching directory '_modules/' for environment 'base'
2017-10-18 12:52:22,396 [salt.fileclient  ][INFO    ][23471] Fetching file from saltenv 'base', ** done ** '_modules/ceph_ng.py'
2017-10-18 12:52:22,405 [salt.fileclient  ][INFO    ][23471] Fetching file from saltenv 'base', ** done ** '_modules/cinderng.py'
2017-10-18 12:52:22,416 [salt.fileclient  ][INFO    ][23471] Fetching file from saltenv 'base', ** done ** '_modules/contrail.py'
2017-10-18 12:52:22,434 [salt.fileclient  ][INFO    ][23471] Fetching file from saltenv 'base', ** done ** '_modules/creds.py'
2017-10-18 12:52:22,446 [salt.fileclient  ][INFO    ][23471] Fetching file from saltenv 'base', ** done ** '_modules/devops_utils.py'
2017-10-18 12:52:22,691 [salt.fileclient  ][INFO    ][23471] Fetching file from saltenv 'base', ** done ** '_modules/encode_json.py'
2017-10-18 12:52:22,701 [salt.fileclient  ][INFO    ][23471] Fetching file from saltenv 'base', ** done ** '_modules/gerrit.py'
2017-10-18 12:52:22,732 [salt.fileclient  ][INFO    ][23471] Fetching file from saltenv 'base', ** done ** '_modules/glanceng.py'
2017-10-18 12:52:22,751 [salt.fileclient  ][INFO    ][23471] Fetching file from saltenv 'base', ** done ** '_modules/heat.py'
2017-10-18 12:52:22,767 [salt.fileclient  ][INFO    ][23471] Fetching file from saltenv 'base', ** done ** '_modules/heka_alarming.py'
2017-10-18 12:52:22,805 [salt.fileclient  ][INFO    ][23471] Fetching file from saltenv 'base', ** done ** '_modules/helm.py'
2017-10-18 12:52:22,829 [salt.fileclient  ][INFO    ][23471] Fetching file from saltenv 'base', ** done ** '_modules/jenkins_common.py'
2017-10-18 12:52:22,845 [salt.fileclient  ][INFO    ][23471] Fetching file from saltenv 'base', ** done ** '_modules/keystone_policy.py'
2017-10-18 12:52:22,876 [salt.fileclient  ][INFO    ][23471] Fetching file from saltenv 'base', ** done ** '_modules/linux_hosts.py'
2017-10-18 12:52:22,889 [salt.fileclient  ][INFO    ][23471] Fetching file from saltenv 'base', ** done ** '_modules/linux_netlink.py'
2017-10-18 12:52:22,936 [salt.fileclient  ][INFO    ][23471] Fetching file from saltenv 'base', ** done ** '_modules/maas.py'
2017-10-18 12:52:22,952 [salt.fileclient  ][INFO    ][23471] Fetching file from saltenv 'base', ** done ** '_modules/maas_client.py'
2017-10-18 12:52:22,986 [salt.fileclient  ][INFO    ][23471] Fetching file from saltenv 'base', ** done ** '_modules/multipart.py'
2017-10-18 12:52:23,011 [salt.fileclient  ][INFO    ][23471] Fetching file from saltenv 'base', ** done ** '_modules/nagios_alarming.py'
2017-10-18 12:52:23,037 [salt.fileclient  ][INFO    ][23471] Fetching file from saltenv 'base', ** done ** '_modules/neutronng.py'
2017-10-18 12:52:23,072 [salt.fileclient  ][INFO    ][23471] Fetching file from saltenv 'base', ** done ** '_modules/novang.py'
2017-10-18 12:52:23,117 [salt.fileclient  ][INFO    ][23471] Fetching file from saltenv 'base', ** done ** '_modules/reclass.py'
2017-10-18 12:52:23,139 [salt.fileclient  ][INFO    ][23471] Fetching file from saltenv 'base', ** done ** '_modules/rsyslog_util.py'
2017-10-18 12:52:23,160 [salt.fileclient  ][INFO    ][23471] Fetching file from saltenv 'base', ** done ** '_modules/rundeck.py'
2017-10-18 12:52:23,198 [salt.fileclient  ][INFO    ][23471] Fetching file from saltenv 'base', ** done ** '_modules/saltkey.py'
2017-10-18 12:52:23,255 [salt.fileclient  ][INFO    ][23471] Fetching file from saltenv 'base', ** done ** '_modules/saltresource.py'
2017-10-18 12:52:23,291 [salt.fileclient  ][INFO    ][23471] Fetching file from saltenv 'base', ** done ** '_modules/seedng.py'
2017-10-18 12:52:23,306 [salt.fileclient  ][INFO    ][23471] Fetching file from saltenv 'base', ** done ** '_modules/testing/credentials.py'
2017-10-18 12:52:23,343 [salt.fileclient  ][INFO    ][23471] Fetching file from saltenv 'base', ** done ** '_modules/testing/django.py'
2017-10-18 12:52:23,353 [salt.fileclient  ][INFO    ][23471] Fetching file from saltenv 'base', ** done ** '_modules/testing/django_client_proxy.py'
2017-10-18 12:52:23,370 [salt.fileclient  ][INFO    ][23471] Fetching file from saltenv 'base', ** done ** '_modules/utils.py'
2017-10-18 12:52:23,392 [salt.fileclient  ][INFO    ][23471] Fetching file from saltenv 'base', ** done ** '_modules/virtng.py'
2017-10-18 12:52:23,394 [salt.utils.extmods][INFO    ][23471] Copying '/var/cache/salt/minion/files/base/_modules/__init__.py' to '/var/cache/salt/minion/extmods/modules/__init__.py'
2017-10-18 12:52:23,395 [salt.utils.extmods][INFO    ][23471] Copying '/var/cache/salt/minion/files/base/_modules/ceph_ng.py' to '/var/cache/salt/minion/extmods/modules/ceph_ng.py'
2017-10-18 12:52:23,395 [salt.utils.extmods][INFO    ][23471] Copying '/var/cache/salt/minion/files/base/_modules/cinderng.py' to '/var/cache/salt/minion/extmods/modules/cinderng.py'
2017-10-18 12:52:23,395 [salt.utils.extmods][INFO    ][23471] Copying '/var/cache/salt/minion/files/base/_modules/contrail.py' to '/var/cache/salt/minion/extmods/modules/contrail.py'
2017-10-18 12:52:23,395 [salt.utils.extmods][INFO    ][23471] Copying '/var/cache/salt/minion/files/base/_modules/creds.py' to '/var/cache/salt/minion/extmods/modules/creds.py'
2017-10-18 12:52:23,395 [salt.utils.extmods][INFO    ][23471] Copying '/var/cache/salt/minion/files/base/_modules/devops_utils.py' to '/var/cache/salt/minion/extmods/modules/devops_utils.py'
2017-10-18 12:52:23,396 [salt.utils.extmods][INFO    ][23471] Copying '/var/cache/salt/minion/files/base/_modules/encode_json.py' to '/var/cache/salt/minion/extmods/modules/encode_json.py'
2017-10-18 12:52:23,396 [salt.utils.extmods][INFO    ][23471] Copying '/var/cache/salt/minion/files/base/_modules/gerrit.py' to '/var/cache/salt/minion/extmods/modules/gerrit.py'
2017-10-18 12:52:23,396 [salt.utils.extmods][INFO    ][23471] Copying '/var/cache/salt/minion/files/base/_modules/glanceng.py' to '/var/cache/salt/minion/extmods/modules/glanceng.py'
2017-10-18 12:52:23,396 [salt.utils.extmods][INFO    ][23471] Copying '/var/cache/salt/minion/files/base/_modules/heat.py' to '/var/cache/salt/minion/extmods/modules/heat.py'
2017-10-18 12:52:23,397 [salt.utils.extmods][INFO    ][23471] Copying '/var/cache/salt/minion/files/base/_modules/heka_alarming.py' to '/var/cache/salt/minion/extmods/modules/heka_alarming.py'
2017-10-18 12:52:23,397 [salt.utils.extmods][INFO    ][23471] Copying '/var/cache/salt/minion/files/base/_modules/helm.py' to '/var/cache/salt/minion/extmods/modules/helm.py'
2017-10-18 12:52:23,397 [salt.utils.extmods][INFO    ][23471] Copying '/var/cache/salt/minion/files/base/_modules/jenkins_common.py' to '/var/cache/salt/minion/extmods/modules/jenkins_common.py'
2017-10-18 12:52:23,397 [salt.utils.extmods][INFO    ][23471] Copying '/var/cache/salt/minion/files/base/_modules/keystone_policy.py' to '/var/cache/salt/minion/extmods/modules/keystone_policy.py'
2017-10-18 12:52:23,397 [salt.utils.extmods][INFO    ][23471] Copying '/var/cache/salt/minion/files/base/_modules/linux_hosts.py' to '/var/cache/salt/minion/extmods/modules/linux_hosts.py'
2017-10-18 12:52:23,397 [salt.utils.extmods][INFO    ][23471] Copying '/var/cache/salt/minion/files/base/_modules/linux_netlink.py' to '/var/cache/salt/minion/extmods/modules/linux_netlink.py'
2017-10-18 12:52:23,398 [salt.utils.extmods][INFO    ][23471] Copying '/var/cache/salt/minion/files/base/_modules/maas.py' to '/var/cache/salt/minion/extmods/modules/maas.py'
2017-10-18 12:52:23,398 [salt.utils.extmods][INFO    ][23471] Copying '/var/cache/salt/minion/files/base/_modules/maas_client.py' to '/var/cache/salt/minion/extmods/modules/maas_client.py'
2017-10-18 12:52:23,398 [salt.utils.extmods][INFO    ][23471] Copying '/var/cache/salt/minion/files/base/_modules/multipart.py' to '/var/cache/salt/minion/extmods/modules/multipart.py'
2017-10-18 12:52:23,398 [salt.utils.extmods][INFO    ][23471] Copying '/var/cache/salt/minion/files/base/_modules/nagios_alarming.py' to '/var/cache/salt/minion/extmods/modules/nagios_alarming.py'
2017-10-18 12:52:23,398 [salt.utils.extmods][INFO    ][23471] Copying '/var/cache/salt/minion/files/base/_modules/neutronng.py' to '/var/cache/salt/minion/extmods/modules/neutronng.py'
2017-10-18 12:52:23,399 [salt.utils.extmods][INFO    ][23471] Copying '/var/cache/salt/minion/files/base/_modules/novang.py' to '/var/cache/salt/minion/extmods/modules/novang.py'
2017-10-18 12:52:23,399 [salt.utils.extmods][INFO    ][23471] Copying '/var/cache/salt/minion/files/base/_modules/reclass.py' to '/var/cache/salt/minion/extmods/modules/reclass.py'
2017-10-18 12:52:23,399 [salt.utils.extmods][INFO    ][23471] Copying '/var/cache/salt/minion/files/base/_modules/rsyslog_util.py' to '/var/cache/salt/minion/extmods/modules/rsyslog_util.py'
2017-10-18 12:52:23,399 [salt.utils.extmods][INFO    ][23471] Copying '/var/cache/salt/minion/files/base/_modules/rundeck.py' to '/var/cache/salt/minion/extmods/modules/rundeck.py'
2017-10-18 12:52:23,400 [salt.utils.extmods][INFO    ][23471] Copying '/var/cache/salt/minion/files/base/_modules/saltkey.py' to '/var/cache/salt/minion/extmods/modules/saltkey.py'
2017-10-18 12:52:23,400 [salt.utils.extmods][INFO    ][23471] Copying '/var/cache/salt/minion/files/base/_modules/saltresource.py' to '/var/cache/salt/minion/extmods/modules/saltresource.py'
2017-10-18 12:52:23,400 [salt.utils.extmods][INFO    ][23471] Copying '/var/cache/salt/minion/files/base/_modules/seedng.py' to '/var/cache/salt/minion/extmods/modules/seedng.py'
2017-10-18 12:52:23,400 [salt.utils.extmods][INFO    ][23471] Copying '/var/cache/salt/minion/files/base/_modules/testing/__init__.py' to '/var/cache/salt/minion/extmods/modules/testing/__init__.py'
2017-10-18 12:52:23,400 [salt.utils.extmods][INFO    ][23471] Copying '/var/cache/salt/minion/files/base/_modules/testing/credentials.py' to '/var/cache/salt/minion/extmods/modules/testing/credentials.py'
2017-10-18 12:52:23,401 [salt.utils.extmods][INFO    ][23471] Copying '/var/cache/salt/minion/files/base/_modules/testing/django.py' to '/var/cache/salt/minion/extmods/modules/testing/django.py'
2017-10-18 12:52:23,401 [salt.utils.extmods][INFO    ][23471] 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-18 12:52:23,401 [salt.utils.extmods][INFO    ][23471] Copying '/var/cache/salt/minion/files/base/_modules/utils.py' to '/var/cache/salt/minion/extmods/modules/utils.py'
2017-10-18 12:52:23,401 [salt.utils.extmods][INFO    ][23471] Copying '/var/cache/salt/minion/files/base/_modules/virtng.py' to '/var/cache/salt/minion/extmods/modules/virtng.py'
2017-10-18 12:52:23,407 [salt.utils.extmods][INFO    ][23471] Syncing states for environment 'base'
2017-10-18 12:52:23,407 [salt.utils.extmods][INFO    ][23471] Loading cache from salt://_states, for base)
2017-10-18 12:52:23,407 [salt.fileclient  ][INFO    ][23471] Caching directory '_states/' for environment 'base'
2017-10-18 12:52:23,448 [salt.fileclient  ][INFO    ][23471] Fetching file from saltenv 'base', ** done ** '_states/cinderng.py'
2017-10-18 12:52:23,460 [salt.fileclient  ][INFO    ][23471] Fetching file from saltenv 'base', ** done ** '_states/contrail.py'
2017-10-18 12:52:23,477 [salt.fileclient  ][INFO    ][23471] Fetching file from saltenv 'base', ** done ** '_states/gerrit.py'
2017-10-18 12:52:23,515 [salt.fileclient  ][INFO    ][23471] Fetching file from saltenv 'base', ** done ** '_states/glanceng.py'
2017-10-18 12:52:23,545 [salt.fileclient  ][INFO    ][23471] Fetching file from saltenv 'base', ** done ** '_states/grafana3_dashboard.py'
2017-10-18 12:52:23,556 [salt.fileclient  ][INFO    ][23471] Fetching file from saltenv 'base', ** done ** '_states/grafana3_datasource.py'
2017-10-18 12:52:23,568 [salt.fileclient  ][INFO    ][23471] Fetching file from saltenv 'base', ** done ** '_states/heat.py'
2017-10-18 12:52:23,609 [salt.fileclient  ][INFO    ][23471] Fetching file from saltenv 'base', ** done ** '_states/helm_release.py'
2017-10-18 12:52:23,657 [salt.fileclient  ][INFO    ][23471] Fetching file from saltenv 'base', ** done ** '_states/jenkins_approval.py'
2017-10-18 12:52:23,698 [salt.fileclient  ][INFO    ][23471] Fetching file from saltenv 'base', ** done ** '_states/jenkins_artifactory.py'
2017-10-18 12:52:23,710 [salt.fileclient  ][INFO    ][23471] Fetching file from saltenv 'base', ** done ** '_states/jenkins_credential.py'
2017-10-18 12:52:23,739 [salt.fileclient  ][INFO    ][23471] Fetching file from saltenv 'base', ** done ** '_states/jenkins_job.py'
2017-10-18 12:52:23,778 [salt.fileclient  ][INFO    ][23471] Fetching file from saltenv 'base', ** done ** '_states/jenkins_lib.py'
2017-10-18 12:52:23,821 [salt.fileclient  ][INFO    ][23471] Fetching file from saltenv 'base', ** done ** '_states/jenkins_node.py'
2017-10-18 12:52:23,835 [salt.fileclient  ][INFO    ][23471] Fetching file from saltenv 'base', ** done ** '_states/jenkins_plugin.py'
2017-10-18 12:52:23,866 [salt.fileclient  ][INFO    ][23471] Fetching file from saltenv 'base', ** done ** '_states/jenkins_security.py'
2017-10-18 12:52:23,938 [salt.fileclient  ][INFO    ][23471] Fetching file from saltenv 'base', ** done ** '_states/jenkins_slack.py'
2017-10-18 12:52:23,975 [salt.fileclient  ][INFO    ][23471] Fetching file from saltenv 'base', ** done ** '_states/jenkins_smtp.py'
2017-10-18 12:52:24,024 [salt.fileclient  ][INFO    ][23471] Fetching file from saltenv 'base', ** done ** '_states/jenkins_theme.py'
2017-10-18 12:52:24,065 [salt.fileclient  ][INFO    ][23471] Fetching file from saltenv 'base', ** done ** '_states/jenkins_user.py'
2017-10-18 12:52:24,087 [salt.fileclient  ][INFO    ][23471] Fetching file from saltenv 'base', ** done ** '_states/jenkins_view.py'
2017-10-18 12:52:24,099 [salt.fileclient  ][INFO    ][23471] Fetching file from saltenv 'base', ** done ** '_states/keystone_policy.py'
2017-10-18 12:52:24,122 [salt.fileclient  ][INFO    ][23471] Fetching file from saltenv 'base', ** done ** '_states/kibana_object.py'
2017-10-18 12:52:24,141 [salt.fileclient  ][INFO    ][23471] Fetching file from saltenv 'base', ** done ** '_states/neutronng.py'
2017-10-18 12:52:24,152 [salt.fileclient  ][INFO    ][23471] Fetching file from saltenv 'base', ** done ** '_states/novang.py'
2017-10-18 12:52:24,160 [salt.fileclient  ][INFO    ][23471] Fetching file from saltenv 'base', ** done ** '_states/reclass.py'
2017-10-18 12:52:24,169 [salt.fileclient  ][INFO    ][23471] Fetching file from saltenv 'base', ** done ** '_states/rundeck_project.py'
2017-10-18 12:52:24,183 [salt.fileclient  ][INFO    ][23471] Fetching file from saltenv 'base', ** done ** '_states/rundeck_scm.py'
2017-10-18 12:52:24,194 [salt.fileclient  ][INFO    ][23471] Fetching file from saltenv 'base', ** done ** '_states/rundeck_secret.py'
2017-10-18 12:52:24,196 [salt.utils.extmods][INFO    ][23471] Copying '/var/cache/salt/minion/files/base/_states/cinderng.py' to '/var/cache/salt/minion/extmods/states/cinderng.py'
2017-10-18 12:52:24,196 [salt.utils.extmods][INFO    ][23471] Copying '/var/cache/salt/minion/files/base/_states/contrail.py' to '/var/cache/salt/minion/extmods/states/contrail.py'
2017-10-18 12:52:24,197 [salt.utils.extmods][INFO    ][23471] Copying '/var/cache/salt/minion/files/base/_states/gerrit.py' to '/var/cache/salt/minion/extmods/states/gerrit.py'
2017-10-18 12:52:24,197 [salt.utils.extmods][INFO    ][23471] Copying '/var/cache/salt/minion/files/base/_states/glanceng.py' to '/var/cache/salt/minion/extmods/states/glanceng.py'
2017-10-18 12:52:24,197 [salt.utils.extmods][INFO    ][23471] Copying '/var/cache/salt/minion/files/base/_states/grafana3_dashboard.py' to '/var/cache/salt/minion/extmods/states/grafana3_dashboard.py'
2017-10-18 12:52:24,197 [salt.utils.extmods][INFO    ][23471] Copying '/var/cache/salt/minion/files/base/_states/grafana3_datasource.py' to '/var/cache/salt/minion/extmods/states/grafana3_datasource.py'
2017-10-18 12:52:24,198 [salt.utils.extmods][INFO    ][23471] Copying '/var/cache/salt/minion/files/base/_states/heat.py' to '/var/cache/salt/minion/extmods/states/heat.py'
2017-10-18 12:52:24,198 [salt.utils.extmods][INFO    ][23471] Copying '/var/cache/salt/minion/files/base/_states/helm_release.py' to '/var/cache/salt/minion/extmods/states/helm_release.py'
2017-10-18 12:52:24,198 [salt.utils.extmods][INFO    ][23471] Copying '/var/cache/salt/minion/files/base/_states/jenkins_approval.py' to '/var/cache/salt/minion/extmods/states/jenkins_approval.py'
2017-10-18 12:52:24,198 [salt.utils.extmods][INFO    ][23471] Copying '/var/cache/salt/minion/files/base/_states/jenkins_artifactory.py' to '/var/cache/salt/minion/extmods/states/jenkins_artifactory.py'
2017-10-18 12:52:24,198 [salt.utils.extmods][INFO    ][23471] Copying '/var/cache/salt/minion/files/base/_states/jenkins_credential.py' to '/var/cache/salt/minion/extmods/states/jenkins_credential.py'
2017-10-18 12:52:24,199 [salt.utils.extmods][INFO    ][23471] Copying '/var/cache/salt/minion/files/base/_states/jenkins_job.py' to '/var/cache/salt/minion/extmods/states/jenkins_job.py'
2017-10-18 12:52:24,199 [salt.utils.extmods][INFO    ][23471] Copying '/var/cache/salt/minion/files/base/_states/jenkins_lib.py' to '/var/cache/salt/minion/extmods/states/jenkins_lib.py'
2017-10-18 12:52:24,199 [salt.utils.extmods][INFO    ][23471] Copying '/var/cache/salt/minion/files/base/_states/jenkins_node.py' to '/var/cache/salt/minion/extmods/states/jenkins_node.py'
2017-10-18 12:52:24,199 [salt.utils.extmods][INFO    ][23471] Copying '/var/cache/salt/minion/files/base/_states/jenkins_plugin.py' to '/var/cache/salt/minion/extmods/states/jenkins_plugin.py'
2017-10-18 12:52:24,200 [salt.utils.extmods][INFO    ][23471] Copying '/var/cache/salt/minion/files/base/_states/jenkins_security.py' to '/var/cache/salt/minion/extmods/states/jenkins_security.py'
2017-10-18 12:52:24,200 [salt.utils.extmods][INFO    ][23471] Copying '/var/cache/salt/minion/files/base/_states/jenkins_slack.py' to '/var/cache/salt/minion/extmods/states/jenkins_slack.py'
2017-10-18 12:52:24,200 [salt.utils.extmods][INFO    ][23471] Copying '/var/cache/salt/minion/files/base/_states/jenkins_smtp.py' to '/var/cache/salt/minion/extmods/states/jenkins_smtp.py'
2017-10-18 12:52:24,200 [salt.utils.extmods][INFO    ][23471] Copying '/var/cache/salt/minion/files/base/_states/jenkins_theme.py' to '/var/cache/salt/minion/extmods/states/jenkins_theme.py'
2017-10-18 12:52:24,200 [salt.utils.extmods][INFO    ][23471] Copying '/var/cache/salt/minion/files/base/_states/jenkins_user.py' to '/var/cache/salt/minion/extmods/states/jenkins_user.py'
2017-10-18 12:52:24,201 [salt.utils.extmods][INFO    ][23471] Copying '/var/cache/salt/minion/files/base/_states/jenkins_view.py' to '/var/cache/salt/minion/extmods/states/jenkins_view.py'
2017-10-18 12:52:24,201 [salt.utils.extmods][INFO    ][23471] Copying '/var/cache/salt/minion/files/base/_states/keystone_policy.py' to '/var/cache/salt/minion/extmods/states/keystone_policy.py'
2017-10-18 12:52:24,201 [salt.utils.extmods][INFO    ][23471] Copying '/var/cache/salt/minion/files/base/_states/kibana_object.py' to '/var/cache/salt/minion/extmods/states/kibana_object.py'
2017-10-18 12:52:24,201 [salt.utils.extmods][INFO    ][23471] Copying '/var/cache/salt/minion/files/base/_states/maas_cluster.py' to '/var/cache/salt/minion/extmods/states/maas_cluster.py'
2017-10-18 12:52:24,201 [salt.utils.extmods][INFO    ][23471] Copying '/var/cache/salt/minion/files/base/_states/neutronng.py' to '/var/cache/salt/minion/extmods/states/neutronng.py'
2017-10-18 12:52:24,202 [salt.utils.extmods][INFO    ][23471] Copying '/var/cache/salt/minion/files/base/_states/novang.py' to '/var/cache/salt/minion/extmods/states/novang.py'
2017-10-18 12:52:24,202 [salt.utils.extmods][INFO    ][23471] Copying '/var/cache/salt/minion/files/base/_states/reclass.py' to '/var/cache/salt/minion/extmods/states/reclass.py'
2017-10-18 12:52:24,202 [salt.utils.extmods][INFO    ][23471] Copying '/var/cache/salt/minion/files/base/_states/rundeck_project.py' to '/var/cache/salt/minion/extmods/states/rundeck_project.py'
2017-10-18 12:52:24,202 [salt.utils.extmods][INFO    ][23471] Copying '/var/cache/salt/minion/files/base/_states/rundeck_scm.py' to '/var/cache/salt/minion/extmods/states/rundeck_scm.py'
2017-10-18 12:52:24,203 [salt.utils.extmods][INFO    ][23471] Copying '/var/cache/salt/minion/files/base/_states/rundeck_secret.py' to '/var/cache/salt/minion/extmods/states/rundeck_secret.py'
2017-10-18 12:52:24,204 [salt.utils.extmods][INFO    ][23471] Creating module dir '/var/cache/salt/minion/extmods/sdb'
2017-10-18 12:52:24,207 [salt.utils.extmods][INFO    ][23471] Syncing sdb for environment 'base'
2017-10-18 12:52:24,207 [salt.utils.extmods][INFO    ][23471] Loading cache from salt://_sdb, for base)
2017-10-18 12:52:24,207 [salt.fileclient  ][INFO    ][23471] Caching directory '_sdb/' for environment 'base'
2017-10-18 12:52:24,241 [salt.utils.extmods][INFO    ][23471] Syncing grains for environment 'base'
2017-10-18 12:52:24,242 [salt.utils.extmods][INFO    ][23471] Loading cache from salt://_grains, for base)
2017-10-18 12:52:24,242 [salt.fileclient  ][INFO    ][23471] Caching directory '_grains/' for environment 'base'
2017-10-18 12:52:24,292 [salt.fileclient  ][INFO    ][23471] Fetching file from saltenv 'base', ** done ** '_grains/ceilometer_policy.py'
2017-10-18 12:52:24,303 [salt.fileclient  ][INFO    ][23471] Fetching file from saltenv 'base', ** done ** '_grains/ceph.py'
2017-10-18 12:52:24,614 [salt.fileclient  ][INFO    ][23471] Fetching file from saltenv 'base', ** done ** '_grains/cinder_policy.py'
2017-10-18 12:52:24,626 [salt.fileclient  ][INFO    ][23471] Fetching file from saltenv 'base', ** done ** '_grains/docker_swarm.py'
2017-10-18 12:52:24,638 [salt.fileclient  ][INFO    ][23471] Fetching file from saltenv 'base', ** done ** '_grains/glance_policy.py'
2017-10-18 12:52:24,653 [salt.fileclient  ][INFO    ][23471] Fetching file from saltenv 'base', ** done ** '_grains/heat_policy.py'
2017-10-18 12:52:24,662 [salt.fileclient  ][INFO    ][23471] Fetching file from saltenv 'base', ** done ** '_grains/jenkins_plugins.py'
2017-10-18 12:52:24,678 [salt.fileclient  ][INFO    ][23471] Fetching file from saltenv 'base', ** done ** '_grains/keystone_policy.py'
2017-10-18 12:52:24,686 [salt.fileclient  ][INFO    ][23471] Fetching file from saltenv 'base', ** done ** '_grains/kubernetes.py'
2017-10-18 12:52:24,700 [salt.fileclient  ][INFO    ][23471] Fetching file from saltenv 'base', ** done ** '_grains/neutron_policy.py'
2017-10-18 12:52:24,708 [salt.fileclient  ][INFO    ][23471] Fetching file from saltenv 'base', ** done ** '_grains/nova_policy.py'
2017-10-18 12:52:24,720 [salt.fileclient  ][INFO    ][23471] Fetching file from saltenv 'base', ** done ** '_grains/ssh_fingerprints.py'
2017-10-18 12:52:24,723 [salt.utils.extmods][INFO    ][23471] Copying '/var/cache/salt/minion/files/base/_grains/ceilometer_policy.py' to '/var/cache/salt/minion/extmods/grains/ceilometer_policy.py'
2017-10-18 12:52:24,723 [salt.utils.extmods][INFO    ][23471] Copying '/var/cache/salt/minion/files/base/_grains/ceph.py' to '/var/cache/salt/minion/extmods/grains/ceph.py'
2017-10-18 12:52:24,723 [salt.utils.extmods][INFO    ][23471] Copying '/var/cache/salt/minion/files/base/_grains/cinder_policy.py' to '/var/cache/salt/minion/extmods/grains/cinder_policy.py'
2017-10-18 12:52:24,723 [salt.utils.extmods][INFO    ][23471] Copying '/var/cache/salt/minion/files/base/_grains/docker_swarm.py' to '/var/cache/salt/minion/extmods/grains/docker_swarm.py'
2017-10-18 12:52:24,724 [salt.utils.extmods][INFO    ][23471] Copying '/var/cache/salt/minion/files/base/_grains/glance_policy.py' to '/var/cache/salt/minion/extmods/grains/glance_policy.py'
2017-10-18 12:52:24,724 [salt.utils.extmods][INFO    ][23471] Copying '/var/cache/salt/minion/files/base/_grains/heat_policy.py' to '/var/cache/salt/minion/extmods/grains/heat_policy.py'
2017-10-18 12:52:24,724 [salt.utils.extmods][INFO    ][23471] Copying '/var/cache/salt/minion/files/base/_grains/jenkins_plugins.py' to '/var/cache/salt/minion/extmods/grains/jenkins_plugins.py'
2017-10-18 12:52:24,724 [salt.utils.extmods][INFO    ][23471] Copying '/var/cache/salt/minion/files/base/_grains/keystone_policy.py' to '/var/cache/salt/minion/extmods/grains/keystone_policy.py'
2017-10-18 12:52:24,725 [salt.utils.extmods][INFO    ][23471] Copying '/var/cache/salt/minion/files/base/_grains/kubernetes.py' to '/var/cache/salt/minion/extmods/grains/kubernetes.py'
2017-10-18 12:52:24,725 [salt.utils.extmods][INFO    ][23471] Copying '/var/cache/salt/minion/files/base/_grains/neutron_policy.py' to '/var/cache/salt/minion/extmods/grains/neutron_policy.py'
2017-10-18 12:52:24,725 [salt.utils.extmods][INFO    ][23471] Copying '/var/cache/salt/minion/files/base/_grains/nova_policy.py' to '/var/cache/salt/minion/extmods/grains/nova_policy.py'
2017-10-18 12:52:24,725 [salt.utils.extmods][INFO    ][23471] Copying '/var/cache/salt/minion/files/base/_grains/ssh_fingerprints.py' to '/var/cache/salt/minion/extmods/grains/ssh_fingerprints.py'
2017-10-18 12:52:24,726 [salt.utils.extmods][INFO    ][23471] Creating module dir '/var/cache/salt/minion/extmods/renderers'
2017-10-18 12:52:24,729 [salt.utils.extmods][INFO    ][23471] Syncing renderers for environment 'base'
2017-10-18 12:52:24,729 [salt.utils.extmods][INFO    ][23471] Loading cache from salt://_renderers, for base)
2017-10-18 12:52:24,729 [salt.fileclient  ][INFO    ][23471] Caching directory '_renderers/' for environment 'base'
2017-10-18 12:52:24,748 [salt.utils.extmods][INFO    ][23471] Creating module dir '/var/cache/salt/minion/extmods/returners'
2017-10-18 12:52:24,750 [salt.utils.extmods][INFO    ][23471] Syncing returners for environment 'base'
2017-10-18 12:52:24,751 [salt.utils.extmods][INFO    ][23471] Loading cache from salt://_returners, for base)
2017-10-18 12:52:24,751 [salt.fileclient  ][INFO    ][23471] Caching directory '_returners/' for environment 'base'
2017-10-18 12:52:24,774 [salt.utils.extmods][INFO    ][23471] Creating module dir '/var/cache/salt/minion/extmods/output'
2017-10-18 12:52:24,776 [salt.utils.extmods][INFO    ][23471] Syncing output for environment 'base'
2017-10-18 12:52:24,777 [salt.utils.extmods][INFO    ][23471] Loading cache from salt://_output, for base)
2017-10-18 12:52:24,777 [salt.fileclient  ][INFO    ][23471] Caching directory '_output/' for environment 'base'
2017-10-18 12:52:24,809 [salt.utils.extmods][INFO    ][23471] Creating module dir '/var/cache/salt/minion/extmods/utils'
2017-10-18 12:52:24,811 [salt.utils.extmods][INFO    ][23471] Syncing utils for environment 'base'
2017-10-18 12:52:24,811 [salt.utils.extmods][INFO    ][23471] Loading cache from salt://_utils, for base)
2017-10-18 12:52:24,811 [salt.fileclient  ][INFO    ][23471] Caching directory '_utils/' for environment 'base'
2017-10-18 12:52:24,831 [salt.utils.extmods][INFO    ][23471] Creating module dir '/var/cache/salt/minion/extmods/log_handlers'
2017-10-18 12:52:24,833 [salt.utils.extmods][INFO    ][23471] Syncing log_handlers for environment 'base'
2017-10-18 12:52:24,833 [salt.utils.extmods][INFO    ][23471] Loading cache from salt://_log_handlers, for base)
2017-10-18 12:52:24,833 [salt.fileclient  ][INFO    ][23471] Caching directory '_log_handlers/' for environment 'base'
2017-10-18 12:52:24,852 [salt.utils.extmods][INFO    ][23471] Creating module dir '/var/cache/salt/minion/extmods/proxy'
2017-10-18 12:52:24,855 [salt.utils.extmods][INFO    ][23471] Syncing proxy for environment 'base'
2017-10-18 12:52:24,855 [salt.utils.extmods][INFO    ][23471] Loading cache from salt://_proxy, for base)
2017-10-18 12:52:24,855 [salt.fileclient  ][INFO    ][23471] Caching directory '_proxy/' for environment 'base'
2017-10-18 12:52:24,880 [salt.utils.extmods][INFO    ][23471] Creating module dir '/var/cache/salt/minion/extmods/engines'
2017-10-18 12:52:24,883 [salt.utils.extmods][INFO    ][23471] Syncing engines for environment 'base'
2017-10-18 12:52:24,883 [salt.utils.extmods][INFO    ][23471] Loading cache from salt://_engines, for base)
2017-10-18 12:52:24,883 [salt.fileclient  ][INFO    ][23471] Caching directory '_engines/' for environment 'base'
2017-10-18 12:52:24,906 [salt.minion      ][INFO    ][23471] Returning information for job: 20171018125218857335
2017-10-18 12:56:42,151 [salt.minion      ][INFO    ][23091] User sudo_ubuntu Executing command test.ping with jid 20171018125642140633
2017-10-18 12:56:42,168 [salt.minion      ][INFO    ][23640] Starting a new job with PID 23640
2017-10-18 12:56:42,192 [salt.minion      ][INFO    ][23640] Returning information for job: 20171018125642140633
2017-10-18 13:00:00,774 [salt.minion      ][INFO    ][23091] User sudo_ubuntu Executing command state.sls with jid 20171018130000759911
2017-10-18 13:00:00,790 [salt.minion      ][INFO    ][23686] Starting a new job with PID 23686
2017-10-18 13:00:02,269 [salt.state       ][INFO    ][23686] Loading fresh modules for state activity
2017-10-18 13:00:02,297 [salt.fileclient  ][INFO    ][23686] Fetching file from saltenv 'base', ** done ** 'keepalived/init.sls'
2017-10-18 13:00:02,313 [salt.fileclient  ][INFO    ][23686] Fetching file from saltenv 'base', ** done ** 'keepalived/cluster.sls'
2017-10-18 13:00:02,337 [salt.fileclient  ][INFO    ][23686] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-10-18 13:00:02,626 [salt.state       ][INFO    ][23686] Running state [lsof] at time 13:00:02.625584
2017-10-18 13:00:02,626 [salt.state       ][INFO    ][23686] Executing state pkg.installed for lsof
2017-10-18 13:00:02,626 [salt.loaded.int.module.cmdmod][INFO    ][23686] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-10-18 13:00:02,858 [salt.state       ][INFO    ][23686] Package lsof is already installed
2017-10-18 13:00:02,858 [salt.state       ][INFO    ][23686] Completed state [lsof] at time 13:00:02.857964 duration_in_ms=232.38
2017-10-18 13:00:02,858 [salt.state       ][INFO    ][23686] Running state [keepalived] at time 13:00:02.858152
2017-10-18 13:00:02,858 [salt.state       ][INFO    ][23686] Executing state pkg.installed for keepalived
2017-10-18 13:00:02,874 [salt.loaded.int.module.cmdmod][INFO    ][23686] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-10-18 13:00:07,599 [salt.loaded.int.module.cmdmod][INFO    ][23686] 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-18 13:00:10,846 [salt.minion      ][INFO    ][23091] User sudo_ubuntu Executing command saltutil.find_job with jid 20171018130010803793
2017-10-18 13:00:10,861 [salt.minion      ][INFO    ][24317] Starting a new job with PID 24317
2017-10-18 13:00:10,872 [salt.minion      ][INFO    ][24317] Returning information for job: 20171018130010803793
2017-10-18 13:00:15,502 [salt.loaded.int.module.cmdmod][INFO    ][23686] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-10-18 13:00:15,526 [salt.state       ][INFO    ][23686] 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-18 13:00:15,534 [salt.state       ][INFO    ][23686] Loading fresh modules for state activity
2017-10-18 13:00:15,546 [salt.state       ][INFO    ][23686] Completed state [keepalived] at time 13:00:15.545550 duration_in_ms=12687.397
2017-10-18 13:00:15,547 [salt.state       ][INFO    ][23686] Running state [/etc/keepalived/keepalived.conf] at time 13:00:15.547260
2017-10-18 13:00:15,547 [salt.state       ][INFO    ][23686] Executing state file.managed for /etc/keepalived/keepalived.conf
2017-10-18 13:00:15,572 [salt.fileclient  ][INFO    ][23686] Fetching file from saltenv 'base', ** done ** 'keepalived/files/keepalived.conf'
2017-10-18 13:00:15,604 [salt.fileclient  ][INFO    ][23686] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-10-18 13:00:15,610 [salt.state       ][INFO    ][23686] File changed:
New file
2017-10-18 13:00:15,610 [salt.state       ][INFO    ][23686] Completed state [/etc/keepalived/keepalived.conf] at time 13:00:15.610347 duration_in_ms=63.086
2017-10-18 13:00:15,668 [salt.state       ][INFO    ][23686] Running state [keepalived] at time 13:00:15.667973
2017-10-18 13:00:15,668 [salt.state       ][INFO    ][23686] Executing state service.running for keepalived
2017-10-18 13:00:15,670 [salt.loaded.int.module.cmdmod][INFO    ][23686] Executing command ['systemctl', 'status', 'keepalived.service', '-n', '0'] in directory '/root'
2017-10-18 13:00:15,680 [salt.loaded.int.module.cmdmod][INFO    ][23686] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2017-10-18 13:00:15,689 [salt.loaded.int.module.cmdmod][INFO    ][23686] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-10-18 13:00:15,698 [salt.loaded.int.module.cmdmod][INFO    ][23686] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-10-18 13:00:15,707 [salt.loaded.int.module.cmdmod][INFO    ][23686] Executing command ['systemd-run', '--scope', 'systemctl', 'start', 'keepalived.service'] in directory '/root'
2017-10-18 13:00:15,760 [salt.loaded.int.module.cmdmod][INFO    ][23686] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2017-10-18 13:00:15,768 [salt.loaded.int.module.cmdmod][INFO    ][23686] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-10-18 13:00:15,777 [salt.loaded.int.module.cmdmod][INFO    ][23686] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-10-18 13:00:15,784 [salt.state       ][INFO    ][23686] {'keepalived': True}
2017-10-18 13:00:15,785 [salt.state       ][INFO    ][23686] Completed state [keepalived] at time 13:00:15.784498 duration_in_ms=116.525
2017-10-18 13:00:15,785 [salt.minion      ][INFO    ][23686] Returning information for job: 20171018130000759911
2017-10-18 13:00:42,262 [salt.minion      ][INFO    ][23091] User sudo_ubuntu Executing command pillar.get with jid 20171018130042248339
2017-10-18 13:00:42,279 [salt.minion      ][INFO    ][25256] Starting a new job with PID 25256
2017-10-18 13:00:42,286 [salt.minion      ][INFO    ][25256] Returning information for job: 20171018130042248339
2017-10-18 13:05:56,780 [salt.minion      ][INFO    ][23091] User sudo_ubuntu Executing command state.sls with jid 20171018130556770862
2017-10-18 13:05:56,794 [salt.minion      ][INFO    ][25364] Starting a new job with PID 25364
2017-10-18 13:05:58,233 [salt.state       ][INFO    ][25364] Loading fresh modules for state activity
2017-10-18 13:05:58,254 [salt.fileclient  ][INFO    ][25364] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-10-18 13:05:58,277 [salt.fileclient  ][INFO    ][25364] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-10-18 13:05:58,535 [salt.state       ][INFO    ][25364] Running state [attr] at time 13:05:58.534713
2017-10-18 13:05:58,535 [salt.state       ][INFO    ][25364] Executing state pkg.installed for attr
2017-10-18 13:05:58,535 [salt.loaded.int.module.cmdmod][INFO    ][25364] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-10-18 13:05:58,845 [salt.loaded.int.module.cmdmod][INFO    ][25364] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-10-18 13:06:01,052 [salt.loaded.int.module.cmdmod][INFO    ][25364] 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-18 13:06:03,687 [salt.loaded.int.module.cmdmod][INFO    ][25364] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-10-18 13:06:03,713 [salt.state       ][INFO    ][25364] Made the following changes:
'attr' changed from 'absent' to '1:2.4.47-2'

2017-10-18 13:06:03,721 [salt.state       ][INFO    ][25364] Loading fresh modules for state activity
2017-10-18 13:06:03,733 [salt.state       ][INFO    ][25364] Completed state [attr] at time 13:06:03.733146 duration_in_ms=5198.434
2017-10-18 13:06:03,738 [salt.state       ][INFO    ][25364] Running state [glusterfs-server] at time 13:06:03.738048
2017-10-18 13:06:03,738 [salt.state       ][INFO    ][25364] Executing state pkg.installed for glusterfs-server
2017-10-18 13:06:03,919 [salt.loaded.int.module.cmdmod][INFO    ][25364] 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-18 13:06:06,876 [salt.minion      ][INFO    ][23091] User sudo_ubuntu Executing command saltutil.find_job with jid 20171018130606861471
2017-10-18 13:06:06,899 [salt.minion      ][INFO    ][26385] Starting a new job with PID 26385
2017-10-18 13:06:06,910 [salt.minion      ][INFO    ][26385] Returning information for job: 20171018130606861471
2017-10-18 13:06:17,089 [salt.minion      ][INFO    ][23091] User sudo_ubuntu Executing command saltutil.find_job with jid 20171018130617061048
2017-10-18 13:06:17,104 [salt.minion      ][INFO    ][29216] Starting a new job with PID 29216
2017-10-18 13:06:17,124 [salt.minion      ][INFO    ][29216] Returning information for job: 20171018130617061048
2017-10-18 13:06:20,729 [salt.loaded.int.module.cmdmod][INFO    ][25364] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-10-18 13:06:20,755 [salt.state       ][INFO    ][25364] 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-18 13:06:20,762 [salt.state       ][INFO    ][25364] Loading fresh modules for state activity
2017-10-18 13:06:20,774 [salt.state       ][INFO    ][25364] Completed state [glusterfs-server] at time 13:06:20.774269 duration_in_ms=17036.221
2017-10-18 13:06:20,775 [salt.transport.ipc][ERROR   ][23091] Exception occurred while handling stream: [Errno 0] Success
2017-10-18 13:06:20,778 [salt.state       ][INFO    ][25364] Running state [bc] at time 13:06:20.778291
2017-10-18 13:06:20,778 [salt.state       ][INFO    ][25364] Executing state pkg.installed for bc
2017-10-18 13:06:21,034 [salt.loaded.int.module.cmdmod][INFO    ][25364] 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-18 13:06:23,824 [salt.loaded.int.module.cmdmod][INFO    ][25364] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-10-18 13:06:23,854 [salt.state       ][INFO    ][25364] Made the following changes:
'bc' changed from 'absent' to '1.06.95-9build1'

2017-10-18 13:06:23,863 [salt.state       ][INFO    ][25364] Loading fresh modules for state activity
2017-10-18 13:06:23,877 [salt.state       ][INFO    ][25364] Completed state [bc] at time 13:06:23.876547 duration_in_ms=3098.256
2017-10-18 13:06:23,944 [salt.state       ][INFO    ][25364] Running state [glusterfs-server] at time 13:06:23.944391
2017-10-18 13:06:23,945 [salt.state       ][INFO    ][25364] Executing state service.running for glusterfs-server
2017-10-18 13:06:23,947 [salt.loaded.int.module.cmdmod][INFO    ][25364] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-10-18 13:06:23,957 [salt.loaded.int.module.cmdmod][INFO    ][25364] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-10-18 13:06:23,965 [salt.loaded.int.module.cmdmod][INFO    ][25364] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-10-18 13:06:23,974 [salt.state       ][INFO    ][25364] The service glusterfs-server is already running
2017-10-18 13:06:23,975 [salt.state       ][INFO    ][25364] Completed state [glusterfs-server] at time 13:06:23.974715 duration_in_ms=30.324
2017-10-18 13:06:23,976 [salt.state       ][INFO    ][25364] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 13:06:23.976304
2017-10-18 13:06:23,977 [salt.state       ][INFO    ][25364] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-10-18 13:06:23,991 [salt.state       ][INFO    ][25364] File changed:
New file
2017-10-18 13:06:23,992 [salt.state       ][INFO    ][25364] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 13:06:23.991595 duration_in_ms=15.291
2017-10-18 13:06:23,992 [salt.state       ][INFO    ][25364] Running state [/srv/glusterfs/glance] at time 13:06:23.991770
2017-10-18 13:06:23,992 [salt.state       ][INFO    ][25364] Executing state file.directory for /srv/glusterfs/glance
2017-10-18 13:06:23,993 [salt.state       ][INFO    ][25364] {'/srv/glusterfs/glance': 'New Dir'}
2017-10-18 13:06:23,993 [salt.state       ][INFO    ][25364] Completed state [/srv/glusterfs/glance] at time 13:06:23.992673 duration_in_ms=0.903
2017-10-18 13:06:23,993 [salt.state       ][INFO    ][25364] Running state [/srv/glusterfs/keystone-keys] at time 13:06:23.992814
2017-10-18 13:06:23,993 [salt.state       ][INFO    ][25364] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-10-18 13:06:23,993 [salt.state       ][INFO    ][25364] {'/srv/glusterfs/keystone-keys': 'New Dir'}
2017-10-18 13:06:23,994 [salt.state       ][INFO    ][25364] Completed state [/srv/glusterfs/keystone-keys] at time 13:06:23.993505 duration_in_ms=0.691
2017-10-18 13:06:23,994 [salt.state       ][INFO    ][25364] Running state [/srv/glusterfs/nova_instances] at time 13:06:23.993646
2017-10-18 13:06:23,994 [salt.state       ][INFO    ][25364] Executing state file.directory for /srv/glusterfs/nova_instances
2017-10-18 13:06:23,994 [salt.state       ][INFO    ][25364] {'/srv/glusterfs/nova_instances': 'New Dir'}
2017-10-18 13:06:23,994 [salt.state       ][INFO    ][25364] Completed state [/srv/glusterfs/nova_instances] at time 13:06:23.994264 duration_in_ms=0.619
2017-10-18 13:06:23,994 [salt.state       ][INFO    ][25364] Running state [/srv/glusterfs/keystone-credential-keys] at time 13:06:23.994407
2017-10-18 13:06:23,995 [salt.state       ][INFO    ][25364] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-10-18 13:06:23,995 [salt.state       ][INFO    ][25364] {'/srv/glusterfs/keystone-credential-keys': 'New Dir'}
2017-10-18 13:06:23,995 [salt.state       ][INFO    ][25364] Completed state [/srv/glusterfs/keystone-credential-keys] at time 13:06:23.995022 duration_in_ms=0.615
2017-10-18 13:06:23,996 [salt.minion      ][INFO    ][25364] Returning information for job: 20171018130556770862
2017-10-18 13:06:28,292 [salt.minion      ][INFO    ][23091] User sudo_ubuntu Executing command test.ping with jid 20171018130628278558
2017-10-18 13:06:28,307 [salt.minion      ][INFO    ][30093] Starting a new job with PID 30093
2017-10-18 13:06:28,331 [salt.minion      ][INFO    ][30093] Returning information for job: 20171018130628278558
2017-10-18 13:07:08,840 [salt.minion      ][INFO    ][23091] User sudo_ubuntu Executing command state.sls with jid 20171018130708827482
2017-10-18 13:07:08,854 [salt.minion      ][INFO    ][30311] Starting a new job with PID 30311
2017-10-18 13:07:10,388 [salt.state       ][INFO    ][30311] Loading fresh modules for state activity
2017-10-18 13:07:10,409 [salt.fileclient  ][INFO    ][30311] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/setup.sls'
2017-10-18 13:07:10,439 [salt.fileclient  ][INFO    ][30311] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-10-18 13:07:10,503 [salt.fileclient  ][INFO    ][30311] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-10-18 13:07:10,522 [salt.fileclient  ][INFO    ][30311] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-10-18 13:07:10,778 [salt.state       ][INFO    ][30311] Running state [attr] at time 13:07:10.777915
2017-10-18 13:07:10,778 [salt.state       ][INFO    ][30311] Executing state pkg.installed for attr
2017-10-18 13:07:10,779 [salt.loaded.int.module.cmdmod][INFO    ][30311] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-10-18 13:07:11,009 [salt.state       ][INFO    ][30311] Package attr is already installed
2017-10-18 13:07:11,010 [salt.state       ][INFO    ][30311] Completed state [attr] at time 13:07:11.009459 duration_in_ms=231.544
2017-10-18 13:07:11,010 [salt.state       ][INFO    ][30311] Running state [glusterfs-server] at time 13:07:11.009652
2017-10-18 13:07:11,010 [salt.state       ][INFO    ][30311] Executing state pkg.installed for glusterfs-server
2017-10-18 13:07:11,012 [salt.state       ][INFO    ][30311] Package glusterfs-server is already installed
2017-10-18 13:07:11,013 [salt.state       ][INFO    ][30311] Completed state [glusterfs-server] at time 13:07:11.012481 duration_in_ms=2.828
2017-10-18 13:07:11,013 [salt.state       ][INFO    ][30311] Running state [bc] at time 13:07:11.012620
2017-10-18 13:07:11,013 [salt.state       ][INFO    ][30311] Executing state pkg.installed for bc
2017-10-18 13:07:11,015 [salt.state       ][INFO    ][30311] Package bc is already installed
2017-10-18 13:07:11,015 [salt.state       ][INFO    ][30311] Completed state [bc] at time 13:07:11.015390 duration_in_ms=2.77
2017-10-18 13:07:11,016 [salt.state       ][INFO    ][30311] Running state [glusterfs-server] at time 13:07:11.016177
2017-10-18 13:07:11,016 [salt.state       ][INFO    ][30311] Executing state service.running for glusterfs-server
2017-10-18 13:07:11,017 [salt.loaded.int.module.cmdmod][INFO    ][30311] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-10-18 13:07:11,027 [salt.loaded.int.module.cmdmod][INFO    ][30311] Executing command ['systemctl', '--system', 'daemon-reload'] in directory '/root'
2017-10-18 13:07:11,068 [salt.loaded.int.module.cmdmod][INFO    ][30311] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-10-18 13:07:11,082 [salt.loaded.int.module.cmdmod][INFO    ][30311] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-10-18 13:07:11,090 [salt.loaded.int.module.cmdmod][INFO    ][30311] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-10-18 13:07:11,099 [salt.state       ][INFO    ][30311] The service glusterfs-server is already running
2017-10-18 13:07:11,099 [salt.state       ][INFO    ][30311] Completed state [glusterfs-server] at time 13:07:11.098687 duration_in_ms=82.509
2017-10-18 13:07:11,100 [salt.state       ][INFO    ][30311] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 13:07:11.100047
2017-10-18 13:07:11,100 [salt.state       ][INFO    ][30311] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-10-18 13:07:11,109 [salt.state       ][INFO    ][30311] File /etc/systemd/system/glusterfs-server.service.d/override.conf is in the correct state
2017-10-18 13:07:11,109 [salt.state       ][INFO    ][30311] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 13:07:11.108622 duration_in_ms=8.575
2017-10-18 13:07:11,109 [salt.state       ][INFO    ][30311] Running state [/srv/glusterfs/glance] at time 13:07:11.108770
2017-10-18 13:07:11,109 [salt.state       ][INFO    ][30311] Executing state file.directory for /srv/glusterfs/glance
2017-10-18 13:07:11,109 [salt.state       ][INFO    ][30311] Directory /srv/glusterfs/glance is in the correct state
2017-10-18 13:07:11,109 [salt.state       ][INFO    ][30311] Completed state [/srv/glusterfs/glance] at time 13:07:11.109333 duration_in_ms=0.563
2017-10-18 13:07:11,109 [salt.state       ][INFO    ][30311] Running state [/srv/glusterfs/keystone-keys] at time 13:07:11.109473
2017-10-18 13:07:11,110 [salt.state       ][INFO    ][30311] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-10-18 13:07:11,110 [salt.state       ][INFO    ][30311] Directory /srv/glusterfs/keystone-keys is in the correct state
2017-10-18 13:07:11,110 [salt.state       ][INFO    ][30311] Completed state [/srv/glusterfs/keystone-keys] at time 13:07:11.110006 duration_in_ms=0.534
2017-10-18 13:07:11,110 [salt.state       ][INFO    ][30311] Running state [/srv/glusterfs/nova_instances] at time 13:07:11.110143
2017-10-18 13:07:11,110 [salt.state       ][INFO    ][30311] Executing state file.directory for /srv/glusterfs/nova_instances
2017-10-18 13:07:11,111 [salt.state       ][INFO    ][30311] Directory /srv/glusterfs/nova_instances is in the correct state
2017-10-18 13:07:11,111 [salt.state       ][INFO    ][30311] Completed state [/srv/glusterfs/nova_instances] at time 13:07:11.110675 duration_in_ms=0.533
2017-10-18 13:07:11,111 [salt.state       ][INFO    ][30311] Running state [/srv/glusterfs/keystone-credential-keys] at time 13:07:11.110810
2017-10-18 13:07:11,111 [salt.state       ][INFO    ][30311] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-10-18 13:07:11,111 [salt.state       ][INFO    ][30311] Directory /srv/glusterfs/keystone-credential-keys is in the correct state
2017-10-18 13:07:11,111 [salt.state       ][INFO    ][30311] Completed state [/srv/glusterfs/keystone-credential-keys] at time 13:07:11.111348 duration_in_ms=0.538
2017-10-18 13:07:11,156 [salt.loaded.int.module.cmdmod][INFO    ][30311] Executing command ['git', '--version'] in directory '/root'
2017-10-18 13:07:11,246 [salt.state       ][INFO    ][30311] Running state [sleep 5] at time 13:07:11.246208
2017-10-18 13:07:11,246 [salt.state       ][INFO    ][30311] Executing state cmd.wait for sleep 5
2017-10-18 13:07:11,247 [salt.state       ][INFO    ][30311] No changes made for sleep 5
2017-10-18 13:07:11,247 [salt.state       ][INFO    ][30311] Completed state [sleep 5] at time 13:07:11.246717 duration_in_ms=0.51
2017-10-18 13:07:11,247 [salt.state       ][INFO    ][30311] Running state [10.167.4.141] at time 13:07:11.247084
2017-10-18 13:07:11,247 [salt.state       ][INFO    ][30311] Executing state glusterfs.peered for 10.167.4.141
2017-10-18 13:07:11,248 [salt.loaded.int.module.cmdmod][INFO    ][30311] Executing command 'gluster --version' in directory '/root'
2017-10-18 13:07:11,256 [salt.loaded.int.module.cmdmod][INFO    ][30311] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-18 13:07:11,303 [salt.state       ][INFO    ][30311] Host 10.167.4.141 already peered
2017-10-18 13:07:11,303 [salt.state       ][INFO    ][30311] Completed state [10.167.4.141] at time 13:07:11.303079 duration_in_ms=55.994
2017-10-18 13:07:11,305 [salt.state       ][INFO    ][30311] Running state [10.167.4.142] at time 13:07:11.305099
2017-10-18 13:07:11,305 [salt.state       ][INFO    ][30311] Executing state glusterfs.peered for 10.167.4.142
2017-10-18 13:07:11,306 [salt.loaded.int.module.cmdmod][INFO    ][30311] Executing command 'gluster --version' in directory '/root'
2017-10-18 13:07:11,314 [salt.loaded.int.module.cmdmod][INFO    ][30311] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-18 13:07:11,361 [salt.loaded.int.module.cmdmod][INFO    ][30311] Executing command 'gluster --version' in directory '/root'
2017-10-18 13:07:11,368 [salt.loaded.int.module.cmdmod][INFO    ][30311] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-18 13:07:11,420 [salt.loaded.int.module.cmdmod][INFO    ][30311] Executing command 'gluster --version' in directory '/root'
2017-10-18 13:07:11,429 [salt.loaded.int.module.cmdmod][INFO    ][30311] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-18 13:07:11,495 [salt.loaded.int.module.cmdmod][INFO    ][30311] Executing command 'gluster --version' in directory '/root'
2017-10-18 13:07:11,503 [salt.loaded.int.module.cmdmod][INFO    ][30311] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-18 13:07:11,549 [salt.state       ][INFO    ][30311] {'new': {'10.167.4.141': [], 'kvm02.baremetal-mcp-ocata-ovs-ha.local': ['10.167.4.142']}, 'old': {'10.167.4.141': [], 'kvm02.baremetal-mcp-ocata-ovs-ha.local': []}}
2017-10-18 13:07:11,549 [salt.state       ][INFO    ][30311] Completed state [10.167.4.142] at time 13:07:11.549044 duration_in_ms=243.944
2017-10-18 13:07:11,551 [salt.state       ][INFO    ][30311] Running state [10.167.4.143] at time 13:07:11.551228
2017-10-18 13:07:11,551 [salt.state       ][INFO    ][30311] Executing state glusterfs.peered for 10.167.4.143
2017-10-18 13:07:11,552 [salt.loaded.int.module.cmdmod][INFO    ][30311] Executing command 'gluster --version' in directory '/root'
2017-10-18 13:07:11,560 [salt.loaded.int.module.cmdmod][INFO    ][30311] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-18 13:07:11,606 [salt.loaded.int.module.cmdmod][INFO    ][30311] Executing command 'gluster --version' in directory '/root'
2017-10-18 13:07:11,614 [salt.loaded.int.module.cmdmod][INFO    ][30311] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-18 13:07:11,663 [salt.loaded.int.module.cmdmod][INFO    ][30311] Executing command 'gluster --version' in directory '/root'
2017-10-18 13:07:11,671 [salt.loaded.int.module.cmdmod][INFO    ][30311] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-18 13:07:11,721 [salt.loaded.int.module.cmdmod][INFO    ][30311] Executing command 'gluster --version' in directory '/root'
2017-10-18 13:07:11,729 [salt.loaded.int.module.cmdmod][INFO    ][30311] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-18 13:07:11,780 [salt.state       ][INFO    ][30311] Peering with localhost is not needed
2017-10-18 13:07:11,780 [salt.state       ][INFO    ][30311] Completed state [10.167.4.143] at time 13:07:11.779940 duration_in_ms=228.711
2017-10-18 13:07:11,781 [salt.state       ][INFO    ][30311] Running state [glance] at time 13:07:11.780713
2017-10-18 13:07:11,781 [salt.state       ][INFO    ][30311] Executing state glusterfs.created for glance
2017-10-18 13:07:11,781 [salt.loaded.int.module.cmdmod][INFO    ][30311] Executing command 'gluster --version' in directory '/root'
2017-10-18 13:07:11,790 [salt.loaded.int.module.cmdmod][INFO    ][30311] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-18 13:07:11,838 [salt.loaded.int.module.cmdmod][INFO    ][30311] Executing command 'gluster --version' in directory '/root'
2017-10-18 13:07:11,846 [salt.loaded.int.module.cmdmod][INFO    ][30311] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-18 13:07:11,899 [salt.state       ][INFO    ][30311] Volume glance already exists and is started.
2017-10-18 13:07:11,899 [salt.state       ][INFO    ][30311] Completed state [glance] at time 13:07:11.899247 duration_in_ms=118.532
2017-10-18 13:07:11,902 [salt.state       ][INFO    ][30311] Running state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 13:07:11.901837
2017-10-18 13:07:11,902 [salt.state       ][INFO    ][30311] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'
2017-10-18 13:07:11,903 [salt.loaded.int.module.cmdmod][INFO    ][30311] Executing command 'gluster volume info 'glance' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-10-18 13:07:11,950 [salt.state       ][INFO    ][30311] unless execution succeeded
2017-10-18 13:07:11,950 [salt.state       ][INFO    ][30311] Completed state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 13:07:11.949997 duration_in_ms=48.16
2017-10-18 13:07:11,950 [salt.state       ][INFO    ][30311] Running state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 13:07:11.950397
2017-10-18 13:07:11,951 [salt.state       ][INFO    ][30311] Executing state cmd.run for gluster volume set 'glance' 'network.remote-dio' 'True'
2017-10-18 13:07:11,951 [salt.loaded.int.module.cmdmod][INFO    ][30311] Executing command 'gluster volume info 'glance' | grep 'network.remote-dio: True'' in directory '/root'
2017-10-18 13:07:11,998 [salt.state       ][INFO    ][30311] unless execution succeeded
2017-10-18 13:07:11,998 [salt.state       ][INFO    ][30311] Completed state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 13:07:11.998011 duration_in_ms=47.613
2017-10-18 13:07:11,998 [salt.state       ][INFO    ][30311] Running state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 13:07:11.998433
2017-10-18 13:07:11,999 [salt.state       ][INFO    ][30311] Executing state cmd.run for gluster volume set 'glance' 'nfs.disable' 'True'
2017-10-18 13:07:11,999 [salt.loaded.int.module.cmdmod][INFO    ][30311] Executing command 'gluster volume info 'glance' | grep 'nfs.disable: True'' in directory '/root'
2017-10-18 13:07:12,046 [salt.state       ][INFO    ][30311] unless execution succeeded
2017-10-18 13:07:12,046 [salt.state       ][INFO    ][30311] Completed state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 13:07:12.045884 duration_in_ms=47.451
2017-10-18 13:07:12,046 [salt.state       ][INFO    ][30311] Running state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 13:07:12.046277
2017-10-18 13:07:12,046 [salt.state       ][INFO    ][30311] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'
2017-10-18 13:07:12,047 [salt.loaded.int.module.cmdmod][INFO    ][30311] Executing command 'gluster volume info 'glance' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-10-18 13:07:12,094 [salt.state       ][INFO    ][30311] unless execution succeeded
2017-10-18 13:07:12,094 [salt.state       ][INFO    ][30311] Completed state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 13:07:12.094139 duration_in_ms=47.862
2017-10-18 13:07:12,095 [salt.state       ][INFO    ][30311] Running state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 13:07:12.094605
2017-10-18 13:07:12,095 [salt.state       ][INFO    ][30311] Executing state cmd.run for gluster volume set 'glance' 'cluster.readdir-optimize' 'True'
2017-10-18 13:07:12,095 [salt.loaded.int.module.cmdmod][INFO    ][30311] Executing command 'gluster volume info 'glance' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-10-18 13:07:12,142 [salt.state       ][INFO    ][30311] unless execution succeeded
2017-10-18 13:07:12,142 [salt.state       ][INFO    ][30311] Completed state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 13:07:12.142358 duration_in_ms=47.753
2017-10-18 13:07:12,143 [salt.state       ][INFO    ][30311] Running state [glance] at time 13:07:12.143263
2017-10-18 13:07:12,143 [salt.state       ][INFO    ][30311] Executing state glusterfs.started for glance
2017-10-18 13:07:12,144 [salt.loaded.int.module.cmdmod][INFO    ][30311] Executing command 'gluster --version' in directory '/root'
2017-10-18 13:07:12,152 [salt.loaded.int.module.cmdmod][INFO    ][30311] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-18 13:07:12,200 [salt.loaded.int.module.cmdmod][INFO    ][30311] Executing command 'gluster --version' in directory '/root'
2017-10-18 13:07:12,209 [salt.loaded.int.module.cmdmod][INFO    ][30311] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-18 13:07:12,261 [salt.state       ][INFO    ][30311] Volume glance is already started
2017-10-18 13:07:12,261 [salt.state       ][INFO    ][30311] Completed state [glance] at time 13:07:12.261217 duration_in_ms=117.953
2017-10-18 13:07:12,262 [salt.state       ][INFO    ][30311] Running state [keystone-keys] at time 13:07:12.262002
2017-10-18 13:07:12,262 [salt.state       ][INFO    ][30311] Executing state glusterfs.created for keystone-keys
2017-10-18 13:07:12,263 [salt.loaded.int.module.cmdmod][INFO    ][30311] Executing command 'gluster --version' in directory '/root'
2017-10-18 13:07:12,271 [salt.loaded.int.module.cmdmod][INFO    ][30311] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-18 13:07:12,319 [salt.loaded.int.module.cmdmod][INFO    ][30311] Executing command 'gluster --version' in directory '/root'
2017-10-18 13:07:12,327 [salt.loaded.int.module.cmdmod][INFO    ][30311] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-18 13:07:12,378 [salt.state       ][INFO    ][30311] Volume keystone-keys already exists and is started.
2017-10-18 13:07:12,379 [salt.state       ][INFO    ][30311] Completed state [keystone-keys] at time 13:07:12.378669 duration_in_ms=116.666
2017-10-18 13:07:12,381 [salt.state       ][INFO    ][30311] Running state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 13:07:12.381331
2017-10-18 13:07:12,382 [salt.state       ][INFO    ][30311] Executing state cmd.run for gluster volume set 'keystone-keys' 'network.remote-dio' 'True'
2017-10-18 13:07:12,382 [salt.loaded.int.module.cmdmod][INFO    ][30311] Executing command 'gluster volume info 'keystone-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-10-18 13:07:12,429 [salt.state       ][INFO    ][30311] unless execution succeeded
2017-10-18 13:07:12,429 [salt.state       ][INFO    ][30311] Completed state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 13:07:12.429215 duration_in_ms=47.884
2017-10-18 13:07:12,430 [salt.state       ][INFO    ][30311] Running state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 13:07:12.429670
2017-10-18 13:07:12,430 [salt.state       ][INFO    ][30311] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-10-18 13:07:12,430 [salt.loaded.int.module.cmdmod][INFO    ][30311] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-10-18 13:07:12,481 [salt.state       ][INFO    ][30311] unless execution succeeded
2017-10-18 13:07:12,481 [salt.state       ][INFO    ][30311] Completed state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 13:07:12.480790 duration_in_ms=51.119
2017-10-18 13:07:12,481 [salt.state       ][INFO    ][30311] Running state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 13:07:12.481289
2017-10-18 13:07:12,482 [salt.state       ][INFO    ][30311] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'
2017-10-18 13:07:12,482 [salt.loaded.int.module.cmdmod][INFO    ][30311] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-10-18 13:07:12,529 [salt.state       ][INFO    ][30311] unless execution succeeded
2017-10-18 13:07:12,529 [salt.state       ][INFO    ][30311] Completed state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 13:07:12.529227 duration_in_ms=47.938
2017-10-18 13:07:12,530 [salt.state       ][INFO    ][30311] Running state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 13:07:12.529695
2017-10-18 13:07:12,530 [salt.state       ][INFO    ][30311] Executing state cmd.run for gluster volume set 'keystone-keys' 'nfs.disable' 'True'
2017-10-18 13:07:12,530 [salt.loaded.int.module.cmdmod][INFO    ][30311] Executing command 'gluster volume info 'keystone-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-10-18 13:07:12,579 [salt.state       ][INFO    ][30311] unless execution succeeded
2017-10-18 13:07:12,579 [salt.state       ][INFO    ][30311] Completed state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 13:07:12.579428 duration_in_ms=49.733
2017-10-18 13:07:12,580 [salt.state       ][INFO    ][30311] Running state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 13:07:12.579835
2017-10-18 13:07:12,580 [salt.state       ][INFO    ][30311] Executing state cmd.run for gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'
2017-10-18 13:07:12,580 [salt.loaded.int.module.cmdmod][INFO    ][30311] Executing command 'gluster volume info 'keystone-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-10-18 13:07:12,628 [salt.state       ][INFO    ][30311] unless execution succeeded
2017-10-18 13:07:12,629 [salt.state       ][INFO    ][30311] Completed state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 13:07:12.628463 duration_in_ms=48.628
2017-10-18 13:07:12,629 [salt.state       ][INFO    ][30311] Running state [keystone-keys] at time 13:07:12.629430
2017-10-18 13:07:12,630 [salt.state       ][INFO    ][30311] Executing state glusterfs.started for keystone-keys
2017-10-18 13:07:12,630 [salt.loaded.int.module.cmdmod][INFO    ][30311] Executing command 'gluster --version' in directory '/root'
2017-10-18 13:07:12,639 [salt.loaded.int.module.cmdmod][INFO    ][30311] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-18 13:07:12,686 [salt.loaded.int.module.cmdmod][INFO    ][30311] Executing command 'gluster --version' in directory '/root'
2017-10-18 13:07:12,694 [salt.loaded.int.module.cmdmod][INFO    ][30311] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-18 13:07:12,746 [salt.state       ][INFO    ][30311] Volume keystone-keys is already started
2017-10-18 13:07:12,746 [salt.state       ][INFO    ][30311] Completed state [keystone-keys] at time 13:07:12.746314 duration_in_ms=116.883
2017-10-18 13:07:12,747 [salt.state       ][INFO    ][30311] Running state [nova_instances] at time 13:07:12.747150
2017-10-18 13:07:12,747 [salt.state       ][INFO    ][30311] Executing state glusterfs.created for nova_instances
2017-10-18 13:07:12,748 [salt.loaded.int.module.cmdmod][INFO    ][30311] Executing command 'gluster --version' in directory '/root'
2017-10-18 13:07:12,756 [salt.loaded.int.module.cmdmod][INFO    ][30311] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-18 13:07:12,803 [salt.loaded.int.module.cmdmod][INFO    ][30311] Executing command 'gluster --version' in directory '/root'
2017-10-18 13:07:12,811 [salt.loaded.int.module.cmdmod][INFO    ][30311] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-18 13:07:12,865 [salt.state       ][INFO    ][30311] Volume nova_instances already exists and is started.
2017-10-18 13:07:12,865 [salt.state       ][INFO    ][30311] Completed state [nova_instances] at time 13:07:12.864726 duration_in_ms=117.576
2017-10-18 13:07:12,868 [salt.state       ][INFO    ][30311] Running state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 13:07:12.867657
2017-10-18 13:07:12,868 [salt.state       ][INFO    ][30311] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'
2017-10-18 13:07:12,868 [salt.loaded.int.module.cmdmod][INFO    ][30311] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-10-18 13:07:12,915 [salt.state       ][INFO    ][30311] unless execution succeeded
2017-10-18 13:07:12,916 [salt.state       ][INFO    ][30311] Completed state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 13:07:12.915588 duration_in_ms=47.93
2017-10-18 13:07:12,916 [salt.state       ][INFO    ][30311] Running state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'On'] at time 13:07:12.916046
2017-10-18 13:07:12,916 [salt.state       ][INFO    ][30311] Executing state cmd.run for gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'On'
2017-10-18 13:07:12,917 [salt.loaded.int.module.cmdmod][INFO    ][30311] Executing command 'gluster volume info 'nova_instances' | grep 'cluster.readdir-optimize: On'' in directory '/root'
2017-10-18 13:07:12,965 [salt.state       ][INFO    ][30311] unless execution succeeded
2017-10-18 13:07:12,965 [salt.state       ][INFO    ][30311] Completed state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'On'] at time 13:07:12.965110 duration_in_ms=49.064
2017-10-18 13:07:12,966 [salt.state       ][INFO    ][30311] Running state [gluster volume set 'nova_instances' 'network.remote-dio' 'On'] at time 13:07:12.965541
2017-10-18 13:07:12,966 [salt.state       ][INFO    ][30311] Executing state cmd.run for gluster volume set 'nova_instances' 'network.remote-dio' 'On'
2017-10-18 13:07:12,966 [salt.loaded.int.module.cmdmod][INFO    ][30311] Executing command 'gluster volume info 'nova_instances' | grep 'network.remote-dio: On'' in directory '/root'
2017-10-18 13:07:13,013 [salt.state       ][INFO    ][30311] unless execution succeeded
2017-10-18 13:07:13,013 [salt.state       ][INFO    ][30311] Completed state [gluster volume set 'nova_instances' 'network.remote-dio' 'On'] at time 13:07:13.012782 duration_in_ms=47.241
2017-10-18 13:07:13,013 [salt.state       ][INFO    ][30311] Running state [gluster volume set 'nova_instances' 'nfs.disable' 'On'] at time 13:07:13.013238
2017-10-18 13:07:13,013 [salt.state       ][INFO    ][30311] Executing state cmd.run for gluster volume set 'nova_instances' 'nfs.disable' 'On'
2017-10-18 13:07:13,014 [salt.loaded.int.module.cmdmod][INFO    ][30311] Executing command 'gluster volume info 'nova_instances' | grep 'nfs.disable: On'' in directory '/root'
2017-10-18 13:07:13,062 [salt.state       ][INFO    ][30311] unless execution succeeded
2017-10-18 13:07:13,062 [salt.state       ][INFO    ][30311] Completed state [gluster volume set 'nova_instances' 'nfs.disable' 'On'] at time 13:07:13.061996 duration_in_ms=48.763
2017-10-18 13:07:13,062 [salt.state       ][INFO    ][30311] Running state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 13:07:13.062425
2017-10-18 13:07:13,063 [salt.state       ][INFO    ][30311] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'
2017-10-18 13:07:13,063 [salt.loaded.int.module.cmdmod][INFO    ][30311] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-10-18 13:07:13,110 [salt.state       ][INFO    ][30311] unless execution succeeded
2017-10-18 13:07:13,110 [salt.state       ][INFO    ][30311] Completed state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 13:07:13.109928 duration_in_ms=47.502
2017-10-18 13:07:13,111 [salt.state       ][INFO    ][30311] Running state [nova_instances] at time 13:07:13.110818
2017-10-18 13:07:13,111 [salt.state       ][INFO    ][30311] Executing state glusterfs.started for nova_instances
2017-10-18 13:07:13,111 [salt.loaded.int.module.cmdmod][INFO    ][30311] Executing command 'gluster --version' in directory '/root'
2017-10-18 13:07:13,120 [salt.loaded.int.module.cmdmod][INFO    ][30311] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-18 13:07:13,167 [salt.loaded.int.module.cmdmod][INFO    ][30311] Executing command 'gluster --version' in directory '/root'
2017-10-18 13:07:13,175 [salt.loaded.int.module.cmdmod][INFO    ][30311] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-18 13:07:13,226 [salt.state       ][INFO    ][30311] Volume nova_instances is already started
2017-10-18 13:07:13,226 [salt.state       ][INFO    ][30311] Completed state [nova_instances] at time 13:07:13.226408 duration_in_ms=115.588
2017-10-18 13:07:13,227 [salt.state       ][INFO    ][30311] Running state [keystone-credential-keys] at time 13:07:13.227248
2017-10-18 13:07:13,227 [salt.state       ][INFO    ][30311] Executing state glusterfs.created for keystone-credential-keys
2017-10-18 13:07:13,228 [salt.loaded.int.module.cmdmod][INFO    ][30311] Executing command 'gluster --version' in directory '/root'
2017-10-18 13:07:13,236 [salt.loaded.int.module.cmdmod][INFO    ][30311] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-18 13:07:13,282 [salt.loaded.int.module.cmdmod][INFO    ][30311] Executing command 'gluster --version' in directory '/root'
2017-10-18 13:07:13,291 [salt.loaded.int.module.cmdmod][INFO    ][30311] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-18 13:07:13,341 [salt.state       ][INFO    ][30311] Volume keystone-credential-keys already exists and is started.
2017-10-18 13:07:13,341 [salt.state       ][INFO    ][30311] Completed state [keystone-credential-keys] at time 13:07:13.340844 duration_in_ms=113.596
2017-10-18 13:07:13,344 [salt.state       ][INFO    ][30311] Running state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 13:07:13.343824
2017-10-18 13:07:13,344 [salt.state       ][INFO    ][30311] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'
2017-10-18 13:07:13,345 [salt.loaded.int.module.cmdmod][INFO    ][30311] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-10-18 13:07:13,393 [salt.state       ][INFO    ][30311] unless execution succeeded
2017-10-18 13:07:13,393 [salt.state       ][INFO    ][30311] Completed state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 13:07:13.392950 duration_in_ms=49.126
2017-10-18 13:07:13,396 [salt.state       ][INFO    ][30311] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 13:07:13.395084
2017-10-18 13:07:13,396 [salt.state       ][INFO    ][30311] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-10-18 13:07:13,397 [salt.loaded.int.module.cmdmod][INFO    ][30311] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-10-18 13:07:13,447 [salt.state       ][INFO    ][30311] unless execution succeeded
2017-10-18 13:07:13,448 [salt.state       ][INFO    ][30311] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 13:07:13.447639 duration_in_ms=52.556
2017-10-18 13:07:13,448 [salt.state       ][INFO    ][30311] Running state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 13:07:13.448298
2017-10-18 13:07:13,449 [salt.state       ][INFO    ][30311] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'
2017-10-18 13:07:13,449 [salt.loaded.int.module.cmdmod][INFO    ][30311] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-10-18 13:07:13,497 [salt.state       ][INFO    ][30311] unless execution succeeded
2017-10-18 13:07:13,498 [salt.state       ][INFO    ][30311] Completed state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 13:07:13.497608 duration_in_ms=49.31
2017-10-18 13:07:13,498 [salt.state       ][INFO    ][30311] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 13:07:13.498105
2017-10-18 13:07:13,498 [salt.state       ][INFO    ][30311] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'
2017-10-18 13:07:13,499 [salt.loaded.int.module.cmdmod][INFO    ][30311] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-10-18 13:07:13,550 [salt.state       ][INFO    ][30311] unless execution succeeded
2017-10-18 13:07:13,550 [salt.state       ][INFO    ][30311] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 13:07:13.549818 duration_in_ms=51.713
2017-10-18 13:07:13,550 [salt.state       ][INFO    ][30311] Running state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 13:07:13.550231
2017-10-18 13:07:13,550 [salt.state       ][INFO    ][30311] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'
2017-10-18 13:07:13,551 [salt.loaded.int.module.cmdmod][INFO    ][30311] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-10-18 13:07:13,599 [salt.state       ][INFO    ][30311] unless execution succeeded
2017-10-18 13:07:13,599 [salt.state       ][INFO    ][30311] Completed state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 13:07:13.598956 duration_in_ms=48.725
2017-10-18 13:07:13,600 [salt.state       ][INFO    ][30311] Running state [keystone-credential-keys] at time 13:07:13.599977
2017-10-18 13:07:13,600 [salt.state       ][INFO    ][30311] Executing state glusterfs.started for keystone-credential-keys
2017-10-18 13:07:13,601 [salt.loaded.int.module.cmdmod][INFO    ][30311] Executing command 'gluster --version' in directory '/root'
2017-10-18 13:07:13,609 [salt.loaded.int.module.cmdmod][INFO    ][30311] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-18 13:07:13,660 [salt.loaded.int.module.cmdmod][INFO    ][30311] Executing command 'gluster --version' in directory '/root'
2017-10-18 13:07:13,669 [salt.loaded.int.module.cmdmod][INFO    ][30311] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-18 13:07:13,722 [salt.state       ][INFO    ][30311] Volume keystone-credential-keys is already started
2017-10-18 13:07:13,722 [salt.state       ][INFO    ][30311] Completed state [keystone-credential-keys] at time 13:07:13.722391 duration_in_ms=122.414
2017-10-18 13:07:13,724 [salt.minion      ][INFO    ][30311] Returning information for job: 20171018130708827482
2017-10-18 13:07:18,472 [salt.minion      ][INFO    ][23091] User sudo_ubuntu Executing command test.ping with jid 20171018130718466413
2017-10-18 13:07:18,487 [salt.minion      ][INFO    ][30737] Starting a new job with PID 30737
2017-10-18 13:07:18,514 [salt.minion      ][INFO    ][30737] Returning information for job: 20171018130718466413
2017-10-18 13:07:18,917 [salt.minion      ][INFO    ][23091] User sudo_ubuntu Executing command cmd.run with jid 20171018130718904106
2017-10-18 13:07:18,932 [salt.minion      ][INFO    ][30743] Starting a new job with PID 30743
2017-10-18 13:07:18,936 [salt.loaded.int.module.cmdmod][INFO    ][30743] Executing command 'gluster peer status; gluster volume status' in directory '/root'
2017-10-18 13:07:19,044 [salt.minion      ][INFO    ][30743] Returning information for job: 20171018130718904106
2017-10-18 13:50:53,868 [salt.utils.schedule][INFO    ][23091] Running scheduled job: __mine_interval
2017-10-18 14:16:00,609 [salt.minion      ][INFO    ][23091] User sudo_ubuntu Executing command test.ping with jid 20171018141600599313
2017-10-18 14:16:00,633 [salt.minion      ][INFO    ][31869] Starting a new job with PID 31869
2017-10-18 14:16:00,665 [salt.minion      ][INFO    ][31869] Returning information for job: 20171018141600599313
2017-10-18 14:16:24,092 [salt.minion      ][INFO    ][23091] User sudo_ubuntu Executing command state.sls with jid 20171018141624083613
2017-10-18 14:16:24,108 [salt.minion      ][INFO    ][31877] Starting a new job with PID 31877
2017-10-18 14:16:24,515 [salt.state       ][INFO    ][31877] Loading fresh modules for state activity
2017-10-18 14:16:24,539 [salt.fileclient  ][INFO    ][31877] Fetching file from saltenv 'base', ** done ** 'keepalived/init.sls'
2017-10-18 14:16:24,556 [salt.fileclient  ][INFO    ][31877] Fetching file from saltenv 'base', ** done ** 'keepalived/cluster.sls'
2017-10-18 14:16:24,578 [salt.fileclient  ][INFO    ][31877] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-10-18 14:16:24,845 [salt.state       ][INFO    ][31877] Running state [lsof] at time 14:16:24.844981
2017-10-18 14:16:24,845 [salt.state       ][INFO    ][31877] Executing state pkg.installed for lsof
2017-10-18 14:16:24,846 [salt.loaded.int.module.cmdmod][INFO    ][31877] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-10-18 14:16:25,084 [salt.state       ][INFO    ][31877] Package lsof is already installed
2017-10-18 14:16:25,085 [salt.state       ][INFO    ][31877] Completed state [lsof] at time 14:16:25.084613 duration_in_ms=239.632
2017-10-18 14:16:25,085 [salt.state       ][INFO    ][31877] Running state [keepalived] at time 14:16:25.084821
2017-10-18 14:16:25,085 [salt.state       ][INFO    ][31877] Executing state pkg.installed for keepalived
2017-10-18 14:16:25,088 [salt.state       ][INFO    ][31877] Package keepalived is already installed
2017-10-18 14:16:25,088 [salt.state       ][INFO    ][31877] Completed state [keepalived] at time 14:16:25.087666 duration_in_ms=2.845
2017-10-18 14:16:25,089 [salt.state       ][INFO    ][31877] Running state [/etc/keepalived/keepalived.conf] at time 14:16:25.089082
2017-10-18 14:16:25,089 [salt.state       ][INFO    ][31877] Executing state file.managed for /etc/keepalived/keepalived.conf
2017-10-18 14:16:25,145 [salt.fileclient  ][INFO    ][31877] Fetching file from saltenv 'base', ** done ** 'keepalived/files/keepalived.conf'
2017-10-18 14:16:25,174 [salt.fileclient  ][INFO    ][31877] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-10-18 14:16:25,178 [salt.state       ][INFO    ][31877] File /etc/keepalived/keepalived.conf is in the correct state
2017-10-18 14:16:25,178 [salt.state       ][INFO    ][31877] Completed state [/etc/keepalived/keepalived.conf] at time 14:16:25.178425 duration_in_ms=89.342
2017-10-18 14:16:25,179 [salt.state       ][INFO    ][31877] Running state [keepalived] at time 14:16:25.178941
2017-10-18 14:16:25,179 [salt.state       ][INFO    ][31877] Executing state service.running for keepalived
2017-10-18 14:16:25,179 [salt.loaded.int.module.cmdmod][INFO    ][31877] Executing command ['systemctl', 'status', 'keepalived.service', '-n', '0'] in directory '/root'
2017-10-18 14:16:25,197 [salt.loaded.int.module.cmdmod][INFO    ][31877] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2017-10-18 14:16:25,205 [salt.loaded.int.module.cmdmod][INFO    ][31877] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-10-18 14:16:25,212 [salt.state       ][INFO    ][31877] The service keepalived is already running
2017-10-18 14:16:25,212 [salt.state       ][INFO    ][31877] Completed state [keepalived] at time 14:16:25.212061 duration_in_ms=33.119
2017-10-18 14:16:25,213 [salt.minion      ][INFO    ][31877] Returning information for job: 20171018141624083613
2017-10-18 14:16:31,410 [salt.minion      ][INFO    ][23091] User sudo_ubuntu Executing command pillar.get with jid 20171018141631401630
2017-10-18 14:16:31,438 [salt.minion      ][INFO    ][31901] Starting a new job with PID 31901
2017-10-18 14:16:31,445 [salt.minion      ][INFO    ][31901] Returning information for job: 20171018141631401630
2017-10-18 14:17:06,890 [salt.minion      ][INFO    ][23091] User sudo_ubuntu Executing command state.sls with jid 20171018141706885746
2017-10-18 14:17:06,906 [salt.minion      ][INFO    ][31910] Starting a new job with PID 31910
2017-10-18 14:17:07,335 [salt.state       ][INFO    ][31910] Loading fresh modules for state activity
2017-10-18 14:17:07,358 [salt.fileclient  ][INFO    ][31910] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-10-18 14:17:07,380 [salt.fileclient  ][INFO    ][31910] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-10-18 14:17:07,658 [salt.state       ][INFO    ][31910] Running state [attr] at time 14:17:07.657920
2017-10-18 14:17:07,658 [salt.state       ][INFO    ][31910] Executing state pkg.installed for attr
2017-10-18 14:17:07,659 [salt.loaded.int.module.cmdmod][INFO    ][31910] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-10-18 14:17:07,884 [salt.state       ][INFO    ][31910] Package attr is already installed
2017-10-18 14:17:07,884 [salt.state       ][INFO    ][31910] Completed state [attr] at time 14:17:07.883752 duration_in_ms=225.832
2017-10-18 14:17:07,884 [salt.state       ][INFO    ][31910] Running state [glusterfs-server] at time 14:17:07.883947
2017-10-18 14:17:07,884 [salt.state       ][INFO    ][31910] Executing state pkg.installed for glusterfs-server
2017-10-18 14:17:07,887 [salt.state       ][INFO    ][31910] Package glusterfs-server is already installed
2017-10-18 14:17:07,887 [salt.state       ][INFO    ][31910] Completed state [glusterfs-server] at time 14:17:07.886786 duration_in_ms=2.839
2017-10-18 14:17:07,887 [salt.state       ][INFO    ][31910] Running state [bc] at time 14:17:07.886926
2017-10-18 14:17:07,887 [salt.state       ][INFO    ][31910] Executing state pkg.installed for bc
2017-10-18 14:17:07,890 [salt.state       ][INFO    ][31910] Package bc is already installed
2017-10-18 14:17:07,890 [salt.state       ][INFO    ][31910] Completed state [bc] at time 14:17:07.889702 duration_in_ms=2.776
2017-10-18 14:17:07,890 [salt.state       ][INFO    ][31910] Running state [glusterfs-server] at time 14:17:07.890357
2017-10-18 14:17:07,891 [salt.state       ][INFO    ][31910] Executing state service.running for glusterfs-server
2017-10-18 14:17:07,891 [salt.loaded.int.module.cmdmod][INFO    ][31910] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-10-18 14:17:07,909 [salt.loaded.int.module.cmdmod][INFO    ][31910] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-10-18 14:17:07,918 [salt.loaded.int.module.cmdmod][INFO    ][31910] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-10-18 14:17:07,928 [salt.state       ][INFO    ][31910] The service glusterfs-server is already running
2017-10-18 14:17:07,928 [salt.state       ][INFO    ][31910] Completed state [glusterfs-server] at time 14:17:07.927847 duration_in_ms=37.49
2017-10-18 14:17:07,929 [salt.state       ][INFO    ][31910] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 14:17:07.929185
2017-10-18 14:17:07,929 [salt.state       ][INFO    ][31910] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-10-18 14:17:07,942 [salt.state       ][INFO    ][31910] File /etc/systemd/system/glusterfs-server.service.d/override.conf is in the correct state
2017-10-18 14:17:07,942 [salt.state       ][INFO    ][31910] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 14:17:07.942066 duration_in_ms=12.881
2017-10-18 14:17:07,942 [salt.state       ][INFO    ][31910] Running state [/srv/glusterfs/glance] at time 14:17:07.942254
2017-10-18 14:17:07,942 [salt.state       ][INFO    ][31910] Executing state file.directory for /srv/glusterfs/glance
2017-10-18 14:17:07,943 [salt.state       ][INFO    ][31910] Directory /srv/glusterfs/glance is in the correct state
2017-10-18 14:17:07,943 [salt.state       ][INFO    ][31910] Completed state [/srv/glusterfs/glance] at time 14:17:07.942896 duration_in_ms=0.641
2017-10-18 14:17:07,943 [salt.state       ][INFO    ][31910] Running state [/srv/glusterfs/keystone-keys] at time 14:17:07.943055
2017-10-18 14:17:07,943 [salt.state       ][INFO    ][31910] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-10-18 14:17:07,944 [salt.state       ][INFO    ][31910] Directory /srv/glusterfs/keystone-keys is in the correct state
2017-10-18 14:17:07,944 [salt.state       ][INFO    ][31910] Completed state [/srv/glusterfs/keystone-keys] at time 14:17:07.943685 duration_in_ms=0.629
2017-10-18 14:17:07,944 [salt.state       ][INFO    ][31910] Running state [/srv/glusterfs/nova_instances] at time 14:17:07.943833
2017-10-18 14:17:07,944 [salt.state       ][INFO    ][31910] Executing state file.directory for /srv/glusterfs/nova_instances
2017-10-18 14:17:07,944 [salt.state       ][INFO    ][31910] Directory /srv/glusterfs/nova_instances is in the correct state
2017-10-18 14:17:07,944 [salt.state       ][INFO    ][31910] Completed state [/srv/glusterfs/nova_instances] at time 14:17:07.944461 duration_in_ms=0.628
2017-10-18 14:17:07,945 [salt.state       ][INFO    ][31910] Running state [/srv/glusterfs/keystone-credential-keys] at time 14:17:07.944614
2017-10-18 14:17:07,945 [salt.state       ][INFO    ][31910] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-10-18 14:17:07,945 [salt.state       ][INFO    ][31910] Directory /srv/glusterfs/keystone-credential-keys is in the correct state
2017-10-18 14:17:07,945 [salt.state       ][INFO    ][31910] Completed state [/srv/glusterfs/keystone-credential-keys] at time 14:17:07.945246 duration_in_ms=0.632
2017-10-18 14:17:07,946 [salt.minion      ][INFO    ][31910] Returning information for job: 20171018141706885746
2017-10-18 14:17:09,134 [salt.minion      ][INFO    ][23091] User sudo_ubuntu Executing command test.ping with jid 20171018141709125199
2017-10-18 14:17:09,149 [salt.minion      ][INFO    ][31933] Starting a new job with PID 31933
2017-10-18 14:17:09,174 [salt.minion      ][INFO    ][31933] Returning information for job: 20171018141709125199
2017-10-18 14:17:14,037 [salt.minion      ][INFO    ][23091] User sudo_ubuntu Executing command state.sls with jid 20171018141714028493
2017-10-18 14:17:14,052 [salt.minion      ][INFO    ][31938] Starting a new job with PID 31938
2017-10-18 14:17:14,581 [salt.state       ][INFO    ][31938] Loading fresh modules for state activity
2017-10-18 14:17:14,604 [salt.fileclient  ][INFO    ][31938] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/setup.sls'
2017-10-18 14:17:14,637 [salt.fileclient  ][INFO    ][31938] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-10-18 14:17:14,715 [salt.fileclient  ][INFO    ][31938] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-10-18 14:17:14,735 [salt.fileclient  ][INFO    ][31938] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-10-18 14:17:15,001 [salt.state       ][INFO    ][31938] Running state [attr] at time 14:17:15.001393
2017-10-18 14:17:15,002 [salt.state       ][INFO    ][31938] Executing state pkg.installed for attr
2017-10-18 14:17:15,002 [salt.loaded.int.module.cmdmod][INFO    ][31938] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-10-18 14:17:15,250 [salt.state       ][INFO    ][31938] Package attr is already installed
2017-10-18 14:17:15,250 [salt.state       ][INFO    ][31938] Completed state [attr] at time 14:17:15.250094 duration_in_ms=248.7
2017-10-18 14:17:15,250 [salt.state       ][INFO    ][31938] Running state [glusterfs-server] at time 14:17:15.250291
2017-10-18 14:17:15,250 [salt.state       ][INFO    ][31938] Executing state pkg.installed for glusterfs-server
2017-10-18 14:17:15,253 [salt.state       ][INFO    ][31938] Package glusterfs-server is already installed
2017-10-18 14:17:15,253 [salt.state       ][INFO    ][31938] Completed state [glusterfs-server] at time 14:17:15.253156 duration_in_ms=2.864
2017-10-18 14:17:15,253 [salt.state       ][INFO    ][31938] Running state [bc] at time 14:17:15.253303
2017-10-18 14:17:15,253 [salt.state       ][INFO    ][31938] Executing state pkg.installed for bc
2017-10-18 14:17:15,256 [salt.state       ][INFO    ][31938] Package bc is already installed
2017-10-18 14:17:15,256 [salt.state       ][INFO    ][31938] Completed state [bc] at time 14:17:15.256116 duration_in_ms=2.813
2017-10-18 14:17:15,257 [salt.state       ][INFO    ][31938] Running state [glusterfs-server] at time 14:17:15.256899
2017-10-18 14:17:15,257 [salt.state       ][INFO    ][31938] Executing state service.running for glusterfs-server
2017-10-18 14:17:15,257 [salt.loaded.int.module.cmdmod][INFO    ][31938] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-10-18 14:17:15,275 [salt.loaded.int.module.cmdmod][INFO    ][31938] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-10-18 14:17:15,283 [salt.loaded.int.module.cmdmod][INFO    ][31938] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-10-18 14:17:15,294 [salt.state       ][INFO    ][31938] The service glusterfs-server is already running
2017-10-18 14:17:15,294 [salt.state       ][INFO    ][31938] Completed state [glusterfs-server] at time 14:17:15.293838 duration_in_ms=36.937
2017-10-18 14:17:15,295 [salt.state       ][INFO    ][31938] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 14:17:15.295262
2017-10-18 14:17:15,295 [salt.state       ][INFO    ][31938] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-10-18 14:17:15,307 [salt.state       ][INFO    ][31938] File /etc/systemd/system/glusterfs-server.service.d/override.conf is in the correct state
2017-10-18 14:17:15,307 [salt.state       ][INFO    ][31938] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 14:17:15.307175 duration_in_ms=11.913
2017-10-18 14:17:15,307 [salt.state       ][INFO    ][31938] Running state [/srv/glusterfs/glance] at time 14:17:15.307348
2017-10-18 14:17:15,308 [salt.state       ][INFO    ][31938] Executing state file.directory for /srv/glusterfs/glance
2017-10-18 14:17:15,308 [salt.state       ][INFO    ][31938] Directory /srv/glusterfs/glance is in the correct state
2017-10-18 14:17:15,308 [salt.state       ][INFO    ][31938] Completed state [/srv/glusterfs/glance] at time 14:17:15.308096 duration_in_ms=0.747
2017-10-18 14:17:15,308 [salt.state       ][INFO    ][31938] Running state [/srv/glusterfs/keystone-keys] at time 14:17:15.308266
2017-10-18 14:17:15,308 [salt.state       ][INFO    ][31938] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-10-18 14:17:15,309 [salt.state       ][INFO    ][31938] Directory /srv/glusterfs/keystone-keys is in the correct state
2017-10-18 14:17:15,309 [salt.state       ][INFO    ][31938] Completed state [/srv/glusterfs/keystone-keys] at time 14:17:15.308984 duration_in_ms=0.718
2017-10-18 14:17:15,309 [salt.state       ][INFO    ][31938] Running state [/srv/glusterfs/nova_instances] at time 14:17:15.309158
2017-10-18 14:17:15,309 [salt.state       ][INFO    ][31938] Executing state file.directory for /srv/glusterfs/nova_instances
2017-10-18 14:17:15,310 [salt.state       ][INFO    ][31938] Directory /srv/glusterfs/nova_instances is in the correct state
2017-10-18 14:17:15,310 [salt.state       ][INFO    ][31938] Completed state [/srv/glusterfs/nova_instances] at time 14:17:15.309890 duration_in_ms=0.731
2017-10-18 14:17:15,310 [salt.state       ][INFO    ][31938] Running state [/srv/glusterfs/keystone-credential-keys] at time 14:17:15.310056
2017-10-18 14:17:15,310 [salt.state       ][INFO    ][31938] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-10-18 14:17:15,311 [salt.state       ][INFO    ][31938] Directory /srv/glusterfs/keystone-credential-keys is in the correct state
2017-10-18 14:17:15,311 [salt.state       ][INFO    ][31938] Completed state [/srv/glusterfs/keystone-credential-keys] at time 14:17:15.310773 duration_in_ms=0.716
2017-10-18 14:17:15,346 [salt.loaded.int.module.cmdmod][INFO    ][31938] Executing command ['git', '--version'] in directory '/root'
2017-10-18 14:17:15,431 [salt.state       ][INFO    ][31938] Running state [sleep 5] at time 14:17:15.431197
2017-10-18 14:17:15,431 [salt.state       ][INFO    ][31938] Executing state cmd.wait for sleep 5
2017-10-18 14:17:15,432 [salt.state       ][INFO    ][31938] No changes made for sleep 5
2017-10-18 14:17:15,432 [salt.state       ][INFO    ][31938] Completed state [sleep 5] at time 14:17:15.431715 duration_in_ms=0.52
2017-10-18 14:17:15,432 [salt.state       ][INFO    ][31938] Running state [10.167.4.141] at time 14:17:15.432074
2017-10-18 14:17:15,432 [salt.state       ][INFO    ][31938] Executing state glusterfs.peered for 10.167.4.141
2017-10-18 14:17:15,433 [salt.loaded.int.module.cmdmod][INFO    ][31938] Executing command 'gluster --version' in directory '/root'
2017-10-18 14:17:15,443 [salt.loaded.int.module.cmdmod][INFO    ][31938] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-18 14:17:15,495 [salt.state       ][INFO    ][31938] Host 10.167.4.141 already peered
2017-10-18 14:17:15,495 [salt.state       ][INFO    ][31938] Completed state [10.167.4.141] at time 14:17:15.495374 duration_in_ms=63.3
2017-10-18 14:17:15,497 [salt.state       ][INFO    ][31938] Running state [10.167.4.142] at time 14:17:15.497386
2017-10-18 14:17:15,498 [salt.state       ][INFO    ][31938] Executing state glusterfs.peered for 10.167.4.142
2017-10-18 14:17:15,498 [salt.loaded.int.module.cmdmod][INFO    ][31938] Executing command 'gluster --version' in directory '/root'
2017-10-18 14:17:15,508 [salt.loaded.int.module.cmdmod][INFO    ][31938] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-18 14:17:15,557 [salt.state       ][INFO    ][31938] Host 10.167.4.142 already peered
2017-10-18 14:17:15,557 [salt.state       ][INFO    ][31938] Completed state [10.167.4.142] at time 14:17:15.557031 duration_in_ms=59.644
2017-10-18 14:17:15,559 [salt.state       ][INFO    ][31938] Running state [10.167.4.143] at time 14:17:15.559198
2017-10-18 14:17:15,559 [salt.state       ][INFO    ][31938] Executing state glusterfs.peered for 10.167.4.143
2017-10-18 14:17:15,560 [salt.loaded.int.module.cmdmod][INFO    ][31938] Executing command 'gluster --version' in directory '/root'
2017-10-18 14:17:15,569 [salt.loaded.int.module.cmdmod][INFO    ][31938] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-18 14:17:15,617 [salt.loaded.int.module.cmdmod][INFO    ][31938] Executing command 'gluster --version' in directory '/root'
2017-10-18 14:17:15,626 [salt.loaded.int.module.cmdmod][INFO    ][31938] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-18 14:17:15,676 [salt.loaded.int.module.cmdmod][INFO    ][31938] Executing command 'gluster --version' in directory '/root'
2017-10-18 14:17:15,685 [salt.loaded.int.module.cmdmod][INFO    ][31938] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-18 14:17:15,734 [salt.loaded.int.module.cmdmod][INFO    ][31938] Executing command 'gluster --version' in directory '/root'
2017-10-18 14:17:15,744 [salt.loaded.int.module.cmdmod][INFO    ][31938] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-18 14:17:15,793 [salt.state       ][INFO    ][31938] Peering with localhost is not needed
2017-10-18 14:17:15,793 [salt.state       ][INFO    ][31938] Completed state [10.167.4.143] at time 14:17:15.793438 duration_in_ms=234.24
2017-10-18 14:17:15,794 [salt.state       ][INFO    ][31938] Running state [glance] at time 14:17:15.794188
2017-10-18 14:17:15,794 [salt.state       ][INFO    ][31938] Executing state glusterfs.created for glance
2017-10-18 14:17:15,795 [salt.loaded.int.module.cmdmod][INFO    ][31938] Executing command 'gluster --version' in directory '/root'
2017-10-18 14:17:15,804 [salt.loaded.int.module.cmdmod][INFO    ][31938] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-18 14:17:15,851 [salt.loaded.int.module.cmdmod][INFO    ][31938] Executing command 'gluster --version' in directory '/root'
2017-10-18 14:17:15,860 [salt.loaded.int.module.cmdmod][INFO    ][31938] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-18 14:17:15,912 [salt.state       ][INFO    ][31938] Volume glance already exists and is started.
2017-10-18 14:17:15,912 [salt.state       ][INFO    ][31938] Completed state [glance] at time 14:17:15.912321 duration_in_ms=118.133
2017-10-18 14:17:15,915 [salt.state       ][INFO    ][31938] Running state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 14:17:15.914963
2017-10-18 14:17:15,915 [salt.state       ][INFO    ][31938] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'
2017-10-18 14:17:15,916 [salt.loaded.int.module.cmdmod][INFO    ][31938] Executing command 'gluster volume info 'glance' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-10-18 14:17:15,966 [salt.state       ][INFO    ][31938] unless execution succeeded
2017-10-18 14:17:15,966 [salt.state       ][INFO    ][31938] Completed state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 14:17:15.965849 duration_in_ms=50.886
2017-10-18 14:17:15,966 [salt.state       ][INFO    ][31938] Running state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 14:17:15.966286
2017-10-18 14:17:15,967 [salt.state       ][INFO    ][31938] Executing state cmd.run for gluster volume set 'glance' 'network.remote-dio' 'True'
2017-10-18 14:17:15,967 [salt.loaded.int.module.cmdmod][INFO    ][31938] Executing command 'gluster volume info 'glance' | grep 'network.remote-dio: True'' in directory '/root'
2017-10-18 14:17:16,015 [salt.state       ][INFO    ][31938] unless execution succeeded
2017-10-18 14:17:16,015 [salt.state       ][INFO    ][31938] Completed state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 14:17:16.014815 duration_in_ms=48.528
2017-10-18 14:17:16,015 [salt.state       ][INFO    ][31938] Running state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 14:17:16.015260
2017-10-18 14:17:16,015 [salt.state       ][INFO    ][31938] Executing state cmd.run for gluster volume set 'glance' 'nfs.disable' 'True'
2017-10-18 14:17:16,016 [salt.loaded.int.module.cmdmod][INFO    ][31938] Executing command 'gluster volume info 'glance' | grep 'nfs.disable: True'' in directory '/root'
2017-10-18 14:17:16,066 [salt.state       ][INFO    ][31938] unless execution succeeded
2017-10-18 14:17:16,067 [salt.state       ][INFO    ][31938] Completed state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 14:17:16.066552 duration_in_ms=51.292
2017-10-18 14:17:16,067 [salt.state       ][INFO    ][31938] Running state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 14:17:16.066986
2017-10-18 14:17:16,067 [salt.state       ][INFO    ][31938] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'
2017-10-18 14:17:16,068 [salt.loaded.int.module.cmdmod][INFO    ][31938] Executing command 'gluster volume info 'glance' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-10-18 14:17:16,115 [salt.state       ][INFO    ][31938] unless execution succeeded
2017-10-18 14:17:16,116 [salt.state       ][INFO    ][31938] Completed state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 14:17:16.115482 duration_in_ms=48.495
2017-10-18 14:17:16,116 [salt.state       ][INFO    ][31938] Running state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 14:17:16.115929
2017-10-18 14:17:16,116 [salt.state       ][INFO    ][31938] Executing state cmd.run for gluster volume set 'glance' 'cluster.readdir-optimize' 'True'
2017-10-18 14:17:16,117 [salt.loaded.int.module.cmdmod][INFO    ][31938] Executing command 'gluster volume info 'glance' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-10-18 14:17:16,165 [salt.state       ][INFO    ][31938] unless execution succeeded
2017-10-18 14:17:16,165 [salt.state       ][INFO    ][31938] Completed state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 14:17:16.164792 duration_in_ms=48.863
2017-10-18 14:17:16,166 [salt.state       ][INFO    ][31938] Running state [glance] at time 14:17:16.165746
2017-10-18 14:17:16,166 [salt.state       ][INFO    ][31938] Executing state glusterfs.started for glance
2017-10-18 14:17:16,166 [salt.loaded.int.module.cmdmod][INFO    ][31938] Executing command 'gluster --version' in directory '/root'
2017-10-18 14:17:16,175 [salt.loaded.int.module.cmdmod][INFO    ][31938] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-18 14:17:16,225 [salt.loaded.int.module.cmdmod][INFO    ][31938] Executing command 'gluster --version' in directory '/root'
2017-10-18 14:17:16,234 [salt.loaded.int.module.cmdmod][INFO    ][31938] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-18 14:17:16,285 [salt.state       ][INFO    ][31938] Volume glance is already started
2017-10-18 14:17:16,285 [salt.state       ][INFO    ][31938] Completed state [glance] at time 14:17:16.285440 duration_in_ms=119.692
2017-10-18 14:17:16,286 [salt.state       ][INFO    ][31938] Running state [keystone-keys] at time 14:17:16.286274
2017-10-18 14:17:16,287 [salt.state       ][INFO    ][31938] Executing state glusterfs.created for keystone-keys
2017-10-18 14:17:16,287 [salt.loaded.int.module.cmdmod][INFO    ][31938] Executing command 'gluster --version' in directory '/root'
2017-10-18 14:17:16,296 [salt.loaded.int.module.cmdmod][INFO    ][31938] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-18 14:17:16,343 [salt.loaded.int.module.cmdmod][INFO    ][31938] Executing command 'gluster --version' in directory '/root'
2017-10-18 14:17:16,352 [salt.loaded.int.module.cmdmod][INFO    ][31938] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-18 14:17:16,406 [salt.state       ][INFO    ][31938] Volume keystone-keys already exists and is started.
2017-10-18 14:17:16,406 [salt.state       ][INFO    ][31938] Completed state [keystone-keys] at time 14:17:16.406178 duration_in_ms=119.902
2017-10-18 14:17:16,409 [salt.state       ][INFO    ][31938] Running state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 14:17:16.408807
2017-10-18 14:17:16,409 [salt.state       ][INFO    ][31938] Executing state cmd.run for gluster volume set 'keystone-keys' 'network.remote-dio' 'True'
2017-10-18 14:17:16,409 [salt.loaded.int.module.cmdmod][INFO    ][31938] Executing command 'gluster volume info 'keystone-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-10-18 14:17:16,457 [salt.state       ][INFO    ][31938] unless execution succeeded
2017-10-18 14:17:16,457 [salt.state       ][INFO    ][31938] Completed state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 14:17:16.456692 duration_in_ms=47.885
2017-10-18 14:17:16,457 [salt.state       ][INFO    ][31938] Running state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 14:17:16.457151
2017-10-18 14:17:16,457 [salt.state       ][INFO    ][31938] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-10-18 14:17:16,458 [salt.loaded.int.module.cmdmod][INFO    ][31938] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-10-18 14:17:16,507 [salt.state       ][INFO    ][31938] unless execution succeeded
2017-10-18 14:17:16,507 [salt.state       ][INFO    ][31938] Completed state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 14:17:16.506765 duration_in_ms=49.614
2017-10-18 14:17:16,507 [salt.state       ][INFO    ][31938] Running state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 14:17:16.507210
2017-10-18 14:17:16,507 [salt.state       ][INFO    ][31938] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'
2017-10-18 14:17:16,508 [salt.loaded.int.module.cmdmod][INFO    ][31938] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-10-18 14:17:16,557 [salt.state       ][INFO    ][31938] unless execution succeeded
2017-10-18 14:17:16,557 [salt.state       ][INFO    ][31938] Completed state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 14:17:16.556903 duration_in_ms=49.692
2017-10-18 14:17:16,557 [salt.state       ][INFO    ][31938] Running state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 14:17:16.557342
2017-10-18 14:17:16,558 [salt.state       ][INFO    ][31938] Executing state cmd.run for gluster volume set 'keystone-keys' 'nfs.disable' 'True'
2017-10-18 14:17:16,558 [salt.loaded.int.module.cmdmod][INFO    ][31938] Executing command 'gluster volume info 'keystone-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-10-18 14:17:16,606 [salt.state       ][INFO    ][31938] unless execution succeeded
2017-10-18 14:17:16,606 [salt.state       ][INFO    ][31938] Completed state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 14:17:16.606053 duration_in_ms=48.71
2017-10-18 14:17:16,607 [salt.state       ][INFO    ][31938] Running state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 14:17:16.606490
2017-10-18 14:17:16,607 [salt.state       ][INFO    ][31938] Executing state cmd.run for gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'
2017-10-18 14:17:16,607 [salt.loaded.int.module.cmdmod][INFO    ][31938] Executing command 'gluster volume info 'keystone-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-10-18 14:17:16,662 [salt.state       ][INFO    ][31938] unless execution succeeded
2017-10-18 14:17:16,662 [salt.state       ][INFO    ][31938] Completed state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 14:17:16.662281 duration_in_ms=55.79
2017-10-18 14:17:16,663 [salt.state       ][INFO    ][31938] Running state [keystone-keys] at time 14:17:16.663141
2017-10-18 14:17:16,663 [salt.state       ][INFO    ][31938] Executing state glusterfs.started for keystone-keys
2017-10-18 14:17:16,664 [salt.loaded.int.module.cmdmod][INFO    ][31938] Executing command 'gluster --version' in directory '/root'
2017-10-18 14:17:16,673 [salt.loaded.int.module.cmdmod][INFO    ][31938] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-18 14:17:16,721 [salt.loaded.int.module.cmdmod][INFO    ][31938] Executing command 'gluster --version' in directory '/root'
2017-10-18 14:17:16,729 [salt.loaded.int.module.cmdmod][INFO    ][31938] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-18 14:17:16,781 [salt.state       ][INFO    ][31938] Volume keystone-keys is already started
2017-10-18 14:17:16,781 [salt.state       ][INFO    ][31938] Completed state [keystone-keys] at time 14:17:16.780888 duration_in_ms=117.747
2017-10-18 14:17:16,782 [salt.state       ][INFO    ][31938] Running state [nova_instances] at time 14:17:16.781655
2017-10-18 14:17:16,782 [salt.state       ][INFO    ][31938] Executing state glusterfs.created for nova_instances
2017-10-18 14:17:16,782 [salt.loaded.int.module.cmdmod][INFO    ][31938] Executing command 'gluster --version' in directory '/root'
2017-10-18 14:17:16,791 [salt.loaded.int.module.cmdmod][INFO    ][31938] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-18 14:17:16,838 [salt.loaded.int.module.cmdmod][INFO    ][31938] Executing command 'gluster --version' in directory '/root'
2017-10-18 14:17:16,847 [salt.loaded.int.module.cmdmod][INFO    ][31938] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-18 14:17:16,898 [salt.state       ][INFO    ][31938] Volume nova_instances already exists and is started.
2017-10-18 14:17:16,898 [salt.state       ][INFO    ][31938] Completed state [nova_instances] at time 14:17:16.898270 duration_in_ms=116.615
2017-10-18 14:17:16,901 [salt.state       ][INFO    ][31938] Running state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 14:17:16.901106
2017-10-18 14:17:16,901 [salt.state       ][INFO    ][31938] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'
2017-10-18 14:17:16,902 [salt.loaded.int.module.cmdmod][INFO    ][31938] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-10-18 14:17:16,954 [salt.state       ][INFO    ][31938] unless execution succeeded
2017-10-18 14:17:16,954 [salt.state       ][INFO    ][31938] Completed state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 14:17:16.954285 duration_in_ms=53.179
2017-10-18 14:17:16,955 [salt.state       ][INFO    ][31938] Running state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'On'] at time 14:17:16.954860
2017-10-18 14:17:16,955 [salt.state       ][INFO    ][31938] Executing state cmd.run for gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'On'
2017-10-18 14:17:16,956 [salt.loaded.int.module.cmdmod][INFO    ][31938] Executing command 'gluster volume info 'nova_instances' | grep 'cluster.readdir-optimize: On'' in directory '/root'
2017-10-18 14:17:17,004 [salt.state       ][INFO    ][31938] unless execution succeeded
2017-10-18 14:17:17,004 [salt.state       ][INFO    ][31938] Completed state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'On'] at time 14:17:17.004014 duration_in_ms=49.154
2017-10-18 14:17:17,004 [salt.state       ][INFO    ][31938] Running state [gluster volume set 'nova_instances' 'network.remote-dio' 'On'] at time 14:17:17.004434
2017-10-18 14:17:17,005 [salt.state       ][INFO    ][31938] Executing state cmd.run for gluster volume set 'nova_instances' 'network.remote-dio' 'On'
2017-10-18 14:17:17,005 [salt.loaded.int.module.cmdmod][INFO    ][31938] Executing command 'gluster volume info 'nova_instances' | grep 'network.remote-dio: On'' in directory '/root'
2017-10-18 14:17:17,052 [salt.state       ][INFO    ][31938] unless execution succeeded
2017-10-18 14:17:17,053 [salt.state       ][INFO    ][31938] Completed state [gluster volume set 'nova_instances' 'network.remote-dio' 'On'] at time 14:17:17.052541 duration_in_ms=48.107
2017-10-18 14:17:17,053 [salt.state       ][INFO    ][31938] Running state [gluster volume set 'nova_instances' 'nfs.disable' 'On'] at time 14:17:17.052971
2017-10-18 14:17:17,053 [salt.state       ][INFO    ][31938] Executing state cmd.run for gluster volume set 'nova_instances' 'nfs.disable' 'On'
2017-10-18 14:17:17,054 [salt.loaded.int.module.cmdmod][INFO    ][31938] Executing command 'gluster volume info 'nova_instances' | grep 'nfs.disable: On'' in directory '/root'
2017-10-18 14:17:17,101 [salt.state       ][INFO    ][31938] unless execution succeeded
2017-10-18 14:17:17,101 [salt.state       ][INFO    ][31938] Completed state [gluster volume set 'nova_instances' 'nfs.disable' 'On'] at time 14:17:17.101451 duration_in_ms=48.479
2017-10-18 14:17:17,102 [salt.state       ][INFO    ][31938] Running state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 14:17:17.101876
2017-10-18 14:17:17,102 [salt.state       ][INFO    ][31938] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'
2017-10-18 14:17:17,102 [salt.loaded.int.module.cmdmod][INFO    ][31938] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-10-18 14:17:17,150 [salt.state       ][INFO    ][31938] unless execution succeeded
2017-10-18 14:17:17,150 [salt.state       ][INFO    ][31938] Completed state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 14:17:17.149715 duration_in_ms=47.839
2017-10-18 14:17:17,151 [salt.state       ][INFO    ][31938] Running state [nova_instances] at time 14:17:17.150572
2017-10-18 14:17:17,151 [salt.state       ][INFO    ][31938] Executing state glusterfs.started for nova_instances
2017-10-18 14:17:17,151 [salt.loaded.int.module.cmdmod][INFO    ][31938] Executing command 'gluster --version' in directory '/root'
2017-10-18 14:17:17,160 [salt.loaded.int.module.cmdmod][INFO    ][31938] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-18 14:17:17,206 [salt.loaded.int.module.cmdmod][INFO    ][31938] Executing command 'gluster --version' in directory '/root'
2017-10-18 14:17:17,214 [salt.loaded.int.module.cmdmod][INFO    ][31938] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-18 14:17:17,266 [salt.state       ][INFO    ][31938] Volume nova_instances is already started
2017-10-18 14:17:17,266 [salt.state       ][INFO    ][31938] Completed state [nova_instances] at time 14:17:17.265901 duration_in_ms=115.328
2017-10-18 14:17:17,267 [salt.state       ][INFO    ][31938] Running state [keystone-credential-keys] at time 14:17:17.266764
2017-10-18 14:17:17,267 [salt.state       ][INFO    ][31938] Executing state glusterfs.created for keystone-credential-keys
2017-10-18 14:17:17,267 [salt.loaded.int.module.cmdmod][INFO    ][31938] Executing command 'gluster --version' in directory '/root'
2017-10-18 14:17:17,276 [salt.loaded.int.module.cmdmod][INFO    ][31938] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-18 14:17:17,322 [salt.loaded.int.module.cmdmod][INFO    ][31938] Executing command 'gluster --version' in directory '/root'
2017-10-18 14:17:17,331 [salt.loaded.int.module.cmdmod][INFO    ][31938] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-18 14:17:17,381 [salt.state       ][INFO    ][31938] Volume keystone-credential-keys already exists and is started.
2017-10-18 14:17:17,381 [salt.state       ][INFO    ][31938] Completed state [keystone-credential-keys] at time 14:17:17.381386 duration_in_ms=114.622
2017-10-18 14:17:17,384 [salt.state       ][INFO    ][31938] Running state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 14:17:17.384289
2017-10-18 14:17:17,385 [salt.state       ][INFO    ][31938] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'
2017-10-18 14:17:17,385 [salt.loaded.int.module.cmdmod][INFO    ][31938] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-10-18 14:17:17,433 [salt.state       ][INFO    ][31938] unless execution succeeded
2017-10-18 14:17:17,433 [salt.state       ][INFO    ][31938] Completed state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 14:17:17.432865 duration_in_ms=48.576
2017-10-18 14:17:17,433 [salt.state       ][INFO    ][31938] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 14:17:17.433338
2017-10-18 14:17:17,434 [salt.state       ][INFO    ][31938] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-10-18 14:17:17,434 [salt.loaded.int.module.cmdmod][INFO    ][31938] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-10-18 14:17:17,481 [salt.state       ][INFO    ][31938] unless execution succeeded
2017-10-18 14:17:17,481 [salt.state       ][INFO    ][31938] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 14:17:17.481122 duration_in_ms=47.784
2017-10-18 14:17:17,482 [salt.state       ][INFO    ][31938] Running state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 14:17:17.481612
2017-10-18 14:17:17,482 [salt.state       ][INFO    ][31938] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'
2017-10-18 14:17:17,482 [salt.loaded.int.module.cmdmod][INFO    ][31938] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-10-18 14:17:17,530 [salt.state       ][INFO    ][31938] unless execution succeeded
2017-10-18 14:17:17,530 [salt.state       ][INFO    ][31938] Completed state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 14:17:17.529881 duration_in_ms=48.268
2017-10-18 14:17:17,530 [salt.state       ][INFO    ][31938] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 14:17:17.530342
2017-10-18 14:17:17,531 [salt.state       ][INFO    ][31938] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'
2017-10-18 14:17:17,531 [salt.loaded.int.module.cmdmod][INFO    ][31938] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-10-18 14:17:17,578 [salt.state       ][INFO    ][31938] unless execution succeeded
2017-10-18 14:17:17,579 [salt.state       ][INFO    ][31938] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 14:17:17.578705 duration_in_ms=48.362
2017-10-18 14:17:17,579 [salt.state       ][INFO    ][31938] Running state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 14:17:17.579173
2017-10-18 14:17:17,579 [salt.state       ][INFO    ][31938] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'
2017-10-18 14:17:17,580 [salt.loaded.int.module.cmdmod][INFO    ][31938] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-10-18 14:17:17,628 [salt.state       ][INFO    ][31938] unless execution succeeded
2017-10-18 14:17:17,628 [salt.state       ][INFO    ][31938] Completed state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 14:17:17.628038 duration_in_ms=48.864
2017-10-18 14:17:17,629 [salt.state       ][INFO    ][31938] Running state [keystone-credential-keys] at time 14:17:17.628986
2017-10-18 14:17:17,629 [salt.state       ][INFO    ][31938] Executing state glusterfs.started for keystone-credential-keys
2017-10-18 14:17:17,630 [salt.loaded.int.module.cmdmod][INFO    ][31938] Executing command 'gluster --version' in directory '/root'
2017-10-18 14:17:17,639 [salt.loaded.int.module.cmdmod][INFO    ][31938] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-18 14:17:17,693 [salt.loaded.int.module.cmdmod][INFO    ][31938] Executing command 'gluster --version' in directory '/root'
2017-10-18 14:17:17,704 [salt.loaded.int.module.cmdmod][INFO    ][31938] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-18 14:17:17,757 [salt.state       ][INFO    ][31938] Volume keystone-credential-keys is already started
2017-10-18 14:17:17,757 [salt.state       ][INFO    ][31938] Completed state [keystone-credential-keys] at time 14:17:17.757144 duration_in_ms=128.158
2017-10-18 14:17:17,760 [salt.minion      ][INFO    ][31938] Returning information for job: 20171018141714028493
2017-10-18 14:17:22,599 [salt.minion      ][INFO    ][23091] User sudo_ubuntu Executing command test.ping with jid 20171018141722591047
2017-10-18 14:17:22,614 [salt.minion      ][INFO    ][32321] Starting a new job with PID 32321
2017-10-18 14:17:22,640 [salt.minion      ][INFO    ][32321] Returning information for job: 20171018141722591047
2017-10-18 14:17:23,028 [salt.minion      ][INFO    ][23091] User sudo_ubuntu Executing command cmd.run with jid 20171018141723020810
2017-10-18 14:17:23,044 [salt.minion      ][INFO    ][32326] Starting a new job with PID 32326
2017-10-18 14:17:23,049 [salt.loaded.int.module.cmdmod][INFO    ][32326] Executing command 'gluster peer status; gluster volume status' in directory '/root'
2017-10-18 14:17:23,158 [salt.minion      ][INFO    ][32326] Returning information for job: 20171018141723020810
2017-10-18 14:22:13,428 [salt.minion      ][INFO    ][23091] User sudo_ubuntu Executing command test.ping with jid 20171018142213422161
2017-10-18 14:22:13,451 [salt.minion      ][INFO    ][32387] Starting a new job with PID 32387
2017-10-18 14:22:13,480 [salt.minion      ][INFO    ][32387] Returning information for job: 20171018142213422161
2017-10-18 14:22:39,196 [salt.minion      ][INFO    ][23091] User sudo_ubuntu Executing command state.sls with jid 20171018142239186659
2017-10-18 14:22:39,212 [salt.minion      ][INFO    ][32395] Starting a new job with PID 32395
2017-10-18 14:22:39,665 [salt.state       ][INFO    ][32395] Loading fresh modules for state activity
2017-10-18 14:22:39,692 [salt.fileclient  ][INFO    ][32395] Fetching file from saltenv 'base', ** done ** 'keepalived/init.sls'
2017-10-18 14:22:39,711 [salt.fileclient  ][INFO    ][32395] Fetching file from saltenv 'base', ** done ** 'keepalived/cluster.sls'
2017-10-18 14:22:39,736 [salt.fileclient  ][INFO    ][32395] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-10-18 14:22:39,999 [salt.state       ][INFO    ][32395] Running state [lsof] at time 14:22:39.998487
2017-10-18 14:22:39,999 [salt.state       ][INFO    ][32395] Executing state pkg.installed for lsof
2017-10-18 14:22:39,999 [salt.loaded.int.module.cmdmod][INFO    ][32395] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-10-18 14:22:40,235 [salt.state       ][INFO    ][32395] Package lsof is already installed
2017-10-18 14:22:40,236 [salt.state       ][INFO    ][32395] Completed state [lsof] at time 14:22:40.235596 duration_in_ms=237.109
2017-10-18 14:22:40,236 [salt.state       ][INFO    ][32395] Running state [keepalived] at time 14:22:40.235883
2017-10-18 14:22:40,236 [salt.state       ][INFO    ][32395] Executing state pkg.installed for keepalived
2017-10-18 14:22:40,239 [salt.state       ][INFO    ][32395] Package keepalived is already installed
2017-10-18 14:22:40,239 [salt.state       ][INFO    ][32395] Completed state [keepalived] at time 14:22:40.238907 duration_in_ms=3.023
2017-10-18 14:22:40,240 [salt.state       ][INFO    ][32395] Running state [/etc/keepalived/keepalived.conf] at time 14:22:40.240361
2017-10-18 14:22:40,241 [salt.state       ][INFO    ][32395] Executing state file.managed for /etc/keepalived/keepalived.conf
2017-10-18 14:22:40,261 [salt.fileclient  ][INFO    ][32395] Fetching file from saltenv 'base', ** done ** 'keepalived/files/keepalived.conf'
2017-10-18 14:22:40,291 [salt.fileclient  ][INFO    ][32395] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-10-18 14:22:40,295 [salt.state       ][INFO    ][32395] File /etc/keepalived/keepalived.conf is in the correct state
2017-10-18 14:22:40,296 [salt.state       ][INFO    ][32395] Completed state [/etc/keepalived/keepalived.conf] at time 14:22:40.295485 duration_in_ms=55.123
2017-10-18 14:22:40,296 [salt.state       ][INFO    ][32395] Running state [keepalived] at time 14:22:40.296042
2017-10-18 14:22:40,296 [salt.state       ][INFO    ][32395] Executing state service.running for keepalived
2017-10-18 14:22:40,297 [salt.loaded.int.module.cmdmod][INFO    ][32395] Executing command ['systemctl', 'status', 'keepalived.service', '-n', '0'] in directory '/root'
2017-10-18 14:22:40,313 [salt.loaded.int.module.cmdmod][INFO    ][32395] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2017-10-18 14:22:40,321 [salt.loaded.int.module.cmdmod][INFO    ][32395] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-10-18 14:22:40,329 [salt.state       ][INFO    ][32395] The service keepalived is already running
2017-10-18 14:22:40,330 [salt.state       ][INFO    ][32395] Completed state [keepalived] at time 14:22:40.329543 duration_in_ms=33.5
2017-10-18 14:22:40,330 [salt.minion      ][INFO    ][32395] Returning information for job: 20171018142239186659
2017-10-18 14:22:44,064 [salt.minion      ][INFO    ][23091] User sudo_ubuntu Executing command pillar.get with jid 20171018142244056512
2017-10-18 14:22:44,085 [salt.minion      ][INFO    ][32419] Starting a new job with PID 32419
2017-10-18 14:22:44,090 [salt.minion      ][INFO    ][32419] Returning information for job: 20171018142244056512
2017-10-18 14:23:19,446 [salt.minion      ][INFO    ][23091] User sudo_ubuntu Executing command state.sls with jid 20171018142319437511
2017-10-18 14:23:19,462 [salt.minion      ][INFO    ][32436] Starting a new job with PID 32436
2017-10-18 14:23:19,875 [salt.state       ][INFO    ][32436] Loading fresh modules for state activity
2017-10-18 14:23:19,896 [salt.fileclient  ][INFO    ][32436] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-10-18 14:23:19,915 [salt.fileclient  ][INFO    ][32436] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-10-18 14:23:20,189 [salt.state       ][INFO    ][32436] Running state [attr] at time 14:23:20.189319
2017-10-18 14:23:20,190 [salt.state       ][INFO    ][32436] Executing state pkg.installed for attr
2017-10-18 14:23:20,190 [salt.loaded.int.module.cmdmod][INFO    ][32436] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-10-18 14:23:20,454 [salt.state       ][INFO    ][32436] Package attr is already installed
2017-10-18 14:23:20,455 [salt.state       ][INFO    ][32436] Completed state [attr] at time 14:23:20.454733 duration_in_ms=265.415
2017-10-18 14:23:20,455 [salt.state       ][INFO    ][32436] Running state [glusterfs-server] at time 14:23:20.454949
2017-10-18 14:23:20,455 [salt.state       ][INFO    ][32436] Executing state pkg.installed for glusterfs-server
2017-10-18 14:23:20,458 [salt.state       ][INFO    ][32436] Package glusterfs-server is already installed
2017-10-18 14:23:20,458 [salt.state       ][INFO    ][32436] Completed state [glusterfs-server] at time 14:23:20.457809 duration_in_ms=2.86
2017-10-18 14:23:20,458 [salt.state       ][INFO    ][32436] Running state [bc] at time 14:23:20.457944
2017-10-18 14:23:20,458 [salt.state       ][INFO    ][32436] Executing state pkg.installed for bc
2017-10-18 14:23:20,461 [salt.state       ][INFO    ][32436] Package bc is already installed
2017-10-18 14:23:20,461 [salt.state       ][INFO    ][32436] Completed state [bc] at time 14:23:20.460691 duration_in_ms=2.747
2017-10-18 14:23:20,461 [salt.state       ][INFO    ][32436] Running state [glusterfs-server] at time 14:23:20.461374
2017-10-18 14:23:20,462 [salt.state       ][INFO    ][32436] Executing state service.running for glusterfs-server
2017-10-18 14:23:20,462 [salt.loaded.int.module.cmdmod][INFO    ][32436] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-10-18 14:23:20,479 [salt.loaded.int.module.cmdmod][INFO    ][32436] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-10-18 14:23:20,487 [salt.loaded.int.module.cmdmod][INFO    ][32436] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-10-18 14:23:20,497 [salt.state       ][INFO    ][32436] The service glusterfs-server is already running
2017-10-18 14:23:20,497 [salt.state       ][INFO    ][32436] Completed state [glusterfs-server] at time 14:23:20.496751 duration_in_ms=35.377
2017-10-18 14:23:20,498 [salt.state       ][INFO    ][32436] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 14:23:20.498211
2017-10-18 14:23:20,498 [salt.state       ][INFO    ][32436] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-10-18 14:23:20,509 [salt.state       ][INFO    ][32436] File /etc/systemd/system/glusterfs-server.service.d/override.conf is in the correct state
2017-10-18 14:23:20,509 [salt.state       ][INFO    ][32436] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 14:23:20.509424 duration_in_ms=11.212
2017-10-18 14:23:20,510 [salt.state       ][INFO    ][32436] Running state [/srv/glusterfs/glance] at time 14:23:20.509563
2017-10-18 14:23:20,510 [salt.state       ][INFO    ][32436] Executing state file.directory for /srv/glusterfs/glance
2017-10-18 14:23:20,510 [salt.state       ][INFO    ][32436] Directory /srv/glusterfs/glance is in the correct state
2017-10-18 14:23:20,510 [salt.state       ][INFO    ][32436] Completed state [/srv/glusterfs/glance] at time 14:23:20.510197 duration_in_ms=0.634
2017-10-18 14:23:20,510 [salt.state       ][INFO    ][32436] Running state [/srv/glusterfs/keystone-keys] at time 14:23:20.510336
2017-10-18 14:23:20,510 [salt.state       ][INFO    ][32436] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-10-18 14:23:20,511 [salt.state       ][INFO    ][32436] Directory /srv/glusterfs/keystone-keys is in the correct state
2017-10-18 14:23:20,511 [salt.state       ][INFO    ][32436] Completed state [/srv/glusterfs/keystone-keys] at time 14:23:20.510910 duration_in_ms=0.574
2017-10-18 14:23:20,511 [salt.state       ][INFO    ][32436] Running state [/srv/glusterfs/nova_instances] at time 14:23:20.511046
2017-10-18 14:23:20,511 [salt.state       ][INFO    ][32436] Executing state file.directory for /srv/glusterfs/nova_instances
2017-10-18 14:23:20,512 [salt.state       ][INFO    ][32436] Directory /srv/glusterfs/nova_instances is in the correct state
2017-10-18 14:23:20,512 [salt.state       ][INFO    ][32436] Completed state [/srv/glusterfs/nova_instances] at time 14:23:20.511619 duration_in_ms=0.573
2017-10-18 14:23:20,512 [salt.state       ][INFO    ][32436] Running state [/srv/glusterfs/keystone-credential-keys] at time 14:23:20.511755
2017-10-18 14:23:20,512 [salt.state       ][INFO    ][32436] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-10-18 14:23:20,512 [salt.state       ][INFO    ][32436] Directory /srv/glusterfs/keystone-credential-keys is in the correct state
2017-10-18 14:23:20,512 [salt.state       ][INFO    ][32436] Completed state [/srv/glusterfs/keystone-credential-keys] at time 14:23:20.512344 duration_in_ms=0.589
2017-10-18 14:23:20,513 [salt.minion      ][INFO    ][32436] Returning information for job: 20171018142319437511
2017-10-18 14:23:21,737 [salt.minion      ][INFO    ][23091] User sudo_ubuntu Executing command test.ping with jid 20171018142321729547
2017-10-18 14:23:21,752 [salt.minion      ][INFO    ][32459] Starting a new job with PID 32459
2017-10-18 14:23:21,779 [salt.minion      ][INFO    ][32459] Returning information for job: 20171018142321729547
2017-10-18 14:23:26,843 [salt.minion      ][INFO    ][23091] User sudo_ubuntu Executing command state.sls with jid 20171018142326834313
2017-10-18 14:23:26,859 [salt.minion      ][INFO    ][32464] Starting a new job with PID 32464
2017-10-18 14:23:27,323 [salt.state       ][INFO    ][32464] Loading fresh modules for state activity
2017-10-18 14:23:27,345 [salt.fileclient  ][INFO    ][32464] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/setup.sls'
2017-10-18 14:23:27,377 [salt.fileclient  ][INFO    ][32464] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-10-18 14:23:27,441 [salt.fileclient  ][INFO    ][32464] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-10-18 14:23:27,461 [salt.fileclient  ][INFO    ][32464] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-10-18 14:23:27,718 [salt.state       ][INFO    ][32464] Running state [attr] at time 14:23:27.718136
2017-10-18 14:23:27,718 [salt.state       ][INFO    ][32464] Executing state pkg.installed for attr
2017-10-18 14:23:27,719 [salt.loaded.int.module.cmdmod][INFO    ][32464] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-10-18 14:23:27,998 [salt.state       ][INFO    ][32464] Package attr is already installed
2017-10-18 14:23:27,999 [salt.state       ][INFO    ][32464] Completed state [attr] at time 14:23:27.998640 duration_in_ms=280.504
2017-10-18 14:23:27,999 [salt.state       ][INFO    ][32464] Running state [glusterfs-server] at time 14:23:27.998823
2017-10-18 14:23:27,999 [salt.state       ][INFO    ][32464] Executing state pkg.installed for glusterfs-server
2017-10-18 14:23:28,002 [salt.state       ][INFO    ][32464] Package glusterfs-server is already installed
2017-10-18 14:23:28,002 [salt.state       ][INFO    ][32464] Completed state [glusterfs-server] at time 14:23:28.001674 duration_in_ms=2.85
2017-10-18 14:23:28,002 [salt.state       ][INFO    ][32464] Running state [bc] at time 14:23:28.001813
2017-10-18 14:23:28,002 [salt.state       ][INFO    ][32464] Executing state pkg.installed for bc
2017-10-18 14:23:28,004 [salt.state       ][INFO    ][32464] Package bc is already installed
2017-10-18 14:23:28,005 [salt.state       ][INFO    ][32464] Completed state [bc] at time 14:23:28.004541 duration_in_ms=2.729
2017-10-18 14:23:28,005 [salt.state       ][INFO    ][32464] Running state [glusterfs-server] at time 14:23:28.005324
2017-10-18 14:23:28,005 [salt.state       ][INFO    ][32464] Executing state service.running for glusterfs-server
2017-10-18 14:23:28,006 [salt.loaded.int.module.cmdmod][INFO    ][32464] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-10-18 14:23:28,023 [salt.loaded.int.module.cmdmod][INFO    ][32464] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-10-18 14:23:28,031 [salt.loaded.int.module.cmdmod][INFO    ][32464] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-10-18 14:23:28,041 [salt.state       ][INFO    ][32464] The service glusterfs-server is already running
2017-10-18 14:23:28,042 [salt.state       ][INFO    ][32464] Completed state [glusterfs-server] at time 14:23:28.041594 duration_in_ms=36.27
2017-10-18 14:23:28,043 [salt.state       ][INFO    ][32464] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 14:23:28.043029
2017-10-18 14:23:28,043 [salt.state       ][INFO    ][32464] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-10-18 14:23:28,050 [salt.state       ][INFO    ][32464] File /etc/systemd/system/glusterfs-server.service.d/override.conf is in the correct state
2017-10-18 14:23:28,051 [salt.state       ][INFO    ][32464] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 14:23:28.050561 duration_in_ms=7.532
2017-10-18 14:23:28,051 [salt.state       ][INFO    ][32464] Running state [/srv/glusterfs/glance] at time 14:23:28.050740
2017-10-18 14:23:28,051 [salt.state       ][INFO    ][32464] Executing state file.directory for /srv/glusterfs/glance
2017-10-18 14:23:28,051 [salt.state       ][INFO    ][32464] Directory /srv/glusterfs/glance is in the correct state
2017-10-18 14:23:28,051 [salt.state       ][INFO    ][32464] Completed state [/srv/glusterfs/glance] at time 14:23:28.051444 duration_in_ms=0.704
2017-10-18 14:23:28,052 [salt.state       ][INFO    ][32464] Running state [/srv/glusterfs/keystone-keys] at time 14:23:28.051614
2017-10-18 14:23:28,052 [salt.state       ][INFO    ][32464] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-10-18 14:23:28,052 [salt.state       ][INFO    ][32464] Directory /srv/glusterfs/keystone-keys is in the correct state
2017-10-18 14:23:28,052 [salt.state       ][INFO    ][32464] Completed state [/srv/glusterfs/keystone-keys] at time 14:23:28.052297 duration_in_ms=0.684
2017-10-18 14:23:28,052 [salt.state       ][INFO    ][32464] Running state [/srv/glusterfs/nova_instances] at time 14:23:28.052460
2017-10-18 14:23:28,053 [salt.state       ][INFO    ][32464] Executing state file.directory for /srv/glusterfs/nova_instances
2017-10-18 14:23:28,053 [salt.state       ][INFO    ][32464] Directory /srv/glusterfs/nova_instances is in the correct state
2017-10-18 14:23:28,053 [salt.state       ][INFO    ][32464] Completed state [/srv/glusterfs/nova_instances] at time 14:23:28.053130 duration_in_ms=0.671
2017-10-18 14:23:28,053 [salt.state       ][INFO    ][32464] Running state [/srv/glusterfs/keystone-credential-keys] at time 14:23:28.053336
2017-10-18 14:23:28,054 [salt.state       ][INFO    ][32464] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-10-18 14:23:28,054 [salt.state       ][INFO    ][32464] Directory /srv/glusterfs/keystone-credential-keys is in the correct state
2017-10-18 14:23:28,054 [salt.state       ][INFO    ][32464] Completed state [/srv/glusterfs/keystone-credential-keys] at time 14:23:28.054021 duration_in_ms=0.685
2017-10-18 14:23:28,090 [salt.loaded.int.module.cmdmod][INFO    ][32464] Executing command ['git', '--version'] in directory '/root'
2017-10-18 14:23:28,167 [salt.state       ][INFO    ][32464] Running state [sleep 5] at time 14:23:28.167435
2017-10-18 14:23:28,168 [salt.state       ][INFO    ][32464] Executing state cmd.wait for sleep 5
2017-10-18 14:23:28,168 [salt.state       ][INFO    ][32464] No changes made for sleep 5
2017-10-18 14:23:28,168 [salt.state       ][INFO    ][32464] Completed state [sleep 5] at time 14:23:28.168042 duration_in_ms=0.607
2017-10-18 14:23:28,168 [salt.state       ][INFO    ][32464] Running state [10.167.4.141] at time 14:23:28.168421
2017-10-18 14:23:28,169 [salt.state       ][INFO    ][32464] Executing state glusterfs.peered for 10.167.4.141
2017-10-18 14:23:28,169 [salt.loaded.int.module.cmdmod][INFO    ][32464] Executing command 'gluster --version' in directory '/root'
2017-10-18 14:23:28,179 [salt.loaded.int.module.cmdmod][INFO    ][32464] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-18 14:23:28,229 [salt.state       ][INFO    ][32464] Host 10.167.4.141 already peered
2017-10-18 14:23:28,229 [salt.state       ][INFO    ][32464] Completed state [10.167.4.141] at time 14:23:28.229431 duration_in_ms=61.01
2017-10-18 14:23:28,232 [salt.state       ][INFO    ][32464] Running state [10.167.4.142] at time 14:23:28.231500
2017-10-18 14:23:28,232 [salt.state       ][INFO    ][32464] Executing state glusterfs.peered for 10.167.4.142
2017-10-18 14:23:28,232 [salt.loaded.int.module.cmdmod][INFO    ][32464] Executing command 'gluster --version' in directory '/root'
2017-10-18 14:23:28,242 [salt.loaded.int.module.cmdmod][INFO    ][32464] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-18 14:23:28,297 [salt.state       ][INFO    ][32464] Host 10.167.4.142 already peered
2017-10-18 14:23:28,297 [salt.state       ][INFO    ][32464] Completed state [10.167.4.142] at time 14:23:28.296791 duration_in_ms=65.289
2017-10-18 14:23:28,299 [salt.state       ][INFO    ][32464] Running state [10.167.4.143] at time 14:23:28.299120
2017-10-18 14:23:28,299 [salt.state       ][INFO    ][32464] Executing state glusterfs.peered for 10.167.4.143
2017-10-18 14:23:28,300 [salt.loaded.int.module.cmdmod][INFO    ][32464] Executing command 'gluster --version' in directory '/root'
2017-10-18 14:23:28,310 [salt.loaded.int.module.cmdmod][INFO    ][32464] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-18 14:23:28,361 [salt.loaded.int.module.cmdmod][INFO    ][32464] Executing command 'gluster --version' in directory '/root'
2017-10-18 14:23:28,370 [salt.loaded.int.module.cmdmod][INFO    ][32464] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-18 14:23:28,420 [salt.loaded.int.module.cmdmod][INFO    ][32464] Executing command 'gluster --version' in directory '/root'
2017-10-18 14:23:28,429 [salt.loaded.int.module.cmdmod][INFO    ][32464] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-18 14:23:28,479 [salt.loaded.int.module.cmdmod][INFO    ][32464] Executing command 'gluster --version' in directory '/root'
2017-10-18 14:23:28,487 [salt.loaded.int.module.cmdmod][INFO    ][32464] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-18 14:23:28,535 [salt.state       ][INFO    ][32464] Peering with localhost is not needed
2017-10-18 14:23:28,535 [salt.state       ][INFO    ][32464] Completed state [10.167.4.143] at time 14:23:28.535370 duration_in_ms=236.249
2017-10-18 14:23:28,536 [salt.state       ][INFO    ][32464] Running state [glance] at time 14:23:28.536161
2017-10-18 14:23:28,536 [salt.state       ][INFO    ][32464] Executing state glusterfs.created for glance
2017-10-18 14:23:28,537 [salt.loaded.int.module.cmdmod][INFO    ][32464] Executing command 'gluster --version' in directory '/root'
2017-10-18 14:23:28,546 [salt.loaded.int.module.cmdmod][INFO    ][32464] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-18 14:23:28,595 [salt.loaded.int.module.cmdmod][INFO    ][32464] Executing command 'gluster --version' in directory '/root'
2017-10-18 14:23:28,604 [salt.loaded.int.module.cmdmod][INFO    ][32464] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-18 14:23:28,657 [salt.state       ][INFO    ][32464] Volume glance already exists and is started.
2017-10-18 14:23:28,657 [salt.state       ][INFO    ][32464] Completed state [glance] at time 14:23:28.657001 duration_in_ms=120.839
2017-10-18 14:23:28,660 [salt.state       ][INFO    ][32464] Running state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 14:23:28.659598
2017-10-18 14:23:28,660 [salt.state       ][INFO    ][32464] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'
2017-10-18 14:23:28,660 [salt.loaded.int.module.cmdmod][INFO    ][32464] Executing command 'gluster volume info 'glance' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-10-18 14:23:28,711 [salt.state       ][INFO    ][32464] unless execution succeeded
2017-10-18 14:23:28,711 [salt.state       ][INFO    ][32464] Completed state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 14:23:28.711070 duration_in_ms=51.47
2017-10-18 14:23:28,712 [salt.state       ][INFO    ][32464] Running state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 14:23:28.711500
2017-10-18 14:23:28,712 [salt.state       ][INFO    ][32464] Executing state cmd.run for gluster volume set 'glance' 'network.remote-dio' 'True'
2017-10-18 14:23:28,712 [salt.loaded.int.module.cmdmod][INFO    ][32464] Executing command 'gluster volume info 'glance' | grep 'network.remote-dio: True'' in directory '/root'
2017-10-18 14:23:28,762 [salt.state       ][INFO    ][32464] unless execution succeeded
2017-10-18 14:23:28,762 [salt.state       ][INFO    ][32464] Completed state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 14:23:28.761764 duration_in_ms=50.263
2017-10-18 14:23:28,762 [salt.state       ][INFO    ][32464] Running state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 14:23:28.762206
2017-10-18 14:23:28,762 [salt.state       ][INFO    ][32464] Executing state cmd.run for gluster volume set 'glance' 'nfs.disable' 'True'
2017-10-18 14:23:28,763 [salt.loaded.int.module.cmdmod][INFO    ][32464] Executing command 'gluster volume info 'glance' | grep 'nfs.disable: True'' in directory '/root'
2017-10-18 14:23:28,810 [salt.state       ][INFO    ][32464] unless execution succeeded
2017-10-18 14:23:28,810 [salt.state       ][INFO    ][32464] Completed state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 14:23:28.810294 duration_in_ms=48.098
2017-10-18 14:23:28,811 [salt.state       ][INFO    ][32464] Running state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 14:23:28.810729
2017-10-18 14:23:28,811 [salt.state       ][INFO    ][32464] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'
2017-10-18 14:23:28,811 [salt.loaded.int.module.cmdmod][INFO    ][32464] Executing command 'gluster volume info 'glance' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-10-18 14:23:28,858 [salt.state       ][INFO    ][32464] unless execution succeeded
2017-10-18 14:23:28,858 [salt.state       ][INFO    ][32464] Completed state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 14:23:28.858248 duration_in_ms=47.519
2017-10-18 14:23:28,859 [salt.state       ][INFO    ][32464] Running state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 14:23:28.858684
2017-10-18 14:23:28,859 [salt.state       ][INFO    ][32464] Executing state cmd.run for gluster volume set 'glance' 'cluster.readdir-optimize' 'True'
2017-10-18 14:23:28,859 [salt.loaded.int.module.cmdmod][INFO    ][32464] Executing command 'gluster volume info 'glance' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-10-18 14:23:28,907 [salt.state       ][INFO    ][32464] unless execution succeeded
2017-10-18 14:23:28,908 [salt.state       ][INFO    ][32464] Completed state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 14:23:28.907572 duration_in_ms=48.888
2017-10-18 14:23:28,909 [salt.state       ][INFO    ][32464] Running state [glance] at time 14:23:28.908507
2017-10-18 14:23:28,909 [salt.state       ][INFO    ][32464] Executing state glusterfs.started for glance
2017-10-18 14:23:28,909 [salt.loaded.int.module.cmdmod][INFO    ][32464] Executing command 'gluster --version' in directory '/root'
2017-10-18 14:23:28,918 [salt.loaded.int.module.cmdmod][INFO    ][32464] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-18 14:23:28,970 [salt.loaded.int.module.cmdmod][INFO    ][32464] Executing command 'gluster --version' in directory '/root'
2017-10-18 14:23:28,980 [salt.loaded.int.module.cmdmod][INFO    ][32464] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-18 14:23:29,035 [salt.state       ][INFO    ][32464] Volume glance is already started
2017-10-18 14:23:29,035 [salt.state       ][INFO    ][32464] Completed state [glance] at time 14:23:29.035334 duration_in_ms=126.827
2017-10-18 14:23:29,036 [salt.state       ][INFO    ][32464] Running state [keystone-keys] at time 14:23:29.036086
2017-10-18 14:23:29,036 [salt.state       ][INFO    ][32464] Executing state glusterfs.created for keystone-keys
2017-10-18 14:23:29,037 [salt.loaded.int.module.cmdmod][INFO    ][32464] Executing command 'gluster --version' in directory '/root'
2017-10-18 14:23:29,046 [salt.loaded.int.module.cmdmod][INFO    ][32464] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-18 14:23:29,095 [salt.loaded.int.module.cmdmod][INFO    ][32464] Executing command 'gluster --version' in directory '/root'
2017-10-18 14:23:29,104 [salt.loaded.int.module.cmdmod][INFO    ][32464] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-18 14:23:29,155 [salt.state       ][INFO    ][32464] Volume keystone-keys already exists and is started.
2017-10-18 14:23:29,155 [salt.state       ][INFO    ][32464] Completed state [keystone-keys] at time 14:23:29.154928 duration_in_ms=118.841
2017-10-18 14:23:29,158 [salt.state       ][INFO    ][32464] Running state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 14:23:29.157557
2017-10-18 14:23:29,158 [salt.state       ][INFO    ][32464] Executing state cmd.run for gluster volume set 'keystone-keys' 'network.remote-dio' 'True'
2017-10-18 14:23:29,158 [salt.loaded.int.module.cmdmod][INFO    ][32464] Executing command 'gluster volume info 'keystone-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-10-18 14:23:29,206 [salt.state       ][INFO    ][32464] unless execution succeeded
2017-10-18 14:23:29,206 [salt.state       ][INFO    ][32464] Completed state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 14:23:29.206116 duration_in_ms=48.557
2017-10-18 14:23:29,207 [salt.state       ][INFO    ][32464] Running state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 14:23:29.206513
2017-10-18 14:23:29,207 [salt.state       ][INFO    ][32464] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-10-18 14:23:29,207 [salt.loaded.int.module.cmdmod][INFO    ][32464] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-10-18 14:23:29,254 [salt.state       ][INFO    ][32464] unless execution succeeded
2017-10-18 14:23:29,254 [salt.state       ][INFO    ][32464] Completed state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 14:23:29.254278 duration_in_ms=47.765
2017-10-18 14:23:29,255 [salt.state       ][INFO    ][32464] Running state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 14:23:29.254693
2017-10-18 14:23:29,255 [salt.state       ][INFO    ][32464] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'
2017-10-18 14:23:29,255 [salt.loaded.int.module.cmdmod][INFO    ][32464] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-10-18 14:23:29,304 [salt.state       ][INFO    ][32464] unless execution succeeded
2017-10-18 14:23:29,304 [salt.state       ][INFO    ][32464] Completed state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 14:23:29.304341 duration_in_ms=49.647
2017-10-18 14:23:29,305 [salt.state       ][INFO    ][32464] Running state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 14:23:29.304848
2017-10-18 14:23:29,305 [salt.state       ][INFO    ][32464] Executing state cmd.run for gluster volume set 'keystone-keys' 'nfs.disable' 'True'
2017-10-18 14:23:29,306 [salt.loaded.int.module.cmdmod][INFO    ][32464] Executing command 'gluster volume info 'keystone-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-10-18 14:23:29,357 [salt.state       ][INFO    ][32464] unless execution succeeded
2017-10-18 14:23:29,358 [salt.state       ][INFO    ][32464] Completed state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 14:23:29.357669 duration_in_ms=52.821
2017-10-18 14:23:29,358 [salt.state       ][INFO    ][32464] Running state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 14:23:29.358070
2017-10-18 14:23:29,358 [salt.state       ][INFO    ][32464] Executing state cmd.run for gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'
2017-10-18 14:23:29,359 [salt.loaded.int.module.cmdmod][INFO    ][32464] Executing command 'gluster volume info 'keystone-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-10-18 14:23:29,406 [salt.state       ][INFO    ][32464] unless execution succeeded
2017-10-18 14:23:29,406 [salt.state       ][INFO    ][32464] Completed state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 14:23:29.406272 duration_in_ms=48.201
2017-10-18 14:23:29,407 [salt.state       ][INFO    ][32464] Running state [keystone-keys] at time 14:23:29.407209
2017-10-18 14:23:29,407 [salt.state       ][INFO    ][32464] Executing state glusterfs.started for keystone-keys
2017-10-18 14:23:29,408 [salt.loaded.int.module.cmdmod][INFO    ][32464] Executing command 'gluster --version' in directory '/root'
2017-10-18 14:23:29,416 [salt.loaded.int.module.cmdmod][INFO    ][32464] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-18 14:23:29,465 [salt.loaded.int.module.cmdmod][INFO    ][32464] Executing command 'gluster --version' in directory '/root'
2017-10-18 14:23:29,474 [salt.loaded.int.module.cmdmod][INFO    ][32464] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-18 14:23:29,526 [salt.state       ][INFO    ][32464] Volume keystone-keys is already started
2017-10-18 14:23:29,527 [salt.state       ][INFO    ][32464] Completed state [keystone-keys] at time 14:23:29.526510 duration_in_ms=119.3
2017-10-18 14:23:29,527 [salt.state       ][INFO    ][32464] Running state [nova_instances] at time 14:23:29.527442
2017-10-18 14:23:29,528 [salt.state       ][INFO    ][32464] Executing state glusterfs.created for nova_instances
2017-10-18 14:23:29,528 [salt.loaded.int.module.cmdmod][INFO    ][32464] Executing command 'gluster --version' in directory '/root'
2017-10-18 14:23:29,538 [salt.loaded.int.module.cmdmod][INFO    ][32464] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-18 14:23:29,589 [salt.loaded.int.module.cmdmod][INFO    ][32464] Executing command 'gluster --version' in directory '/root'
2017-10-18 14:23:29,599 [salt.loaded.int.module.cmdmod][INFO    ][32464] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-18 14:23:29,657 [salt.state       ][INFO    ][32464] Volume nova_instances already exists and is started.
2017-10-18 14:23:29,657 [salt.state       ][INFO    ][32464] Completed state [nova_instances] at time 14:23:29.657362 duration_in_ms=129.92
2017-10-18 14:23:29,660 [salt.state       ][INFO    ][32464] Running state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 14:23:29.660334
2017-10-18 14:23:29,661 [salt.state       ][INFO    ][32464] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'
2017-10-18 14:23:29,661 [salt.loaded.int.module.cmdmod][INFO    ][32464] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-10-18 14:23:29,714 [salt.state       ][INFO    ][32464] unless execution succeeded
2017-10-18 14:23:29,714 [salt.state       ][INFO    ][32464] Completed state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 14:23:29.713828 duration_in_ms=53.493
2017-10-18 14:23:29,714 [salt.state       ][INFO    ][32464] Running state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'On'] at time 14:23:29.714219
2017-10-18 14:23:29,714 [salt.state       ][INFO    ][32464] Executing state cmd.run for gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'On'
2017-10-18 14:23:29,715 [salt.loaded.int.module.cmdmod][INFO    ][32464] Executing command 'gluster volume info 'nova_instances' | grep 'cluster.readdir-optimize: On'' in directory '/root'
2017-10-18 14:23:29,764 [salt.state       ][INFO    ][32464] unless execution succeeded
2017-10-18 14:23:29,764 [salt.state       ][INFO    ][32464] Completed state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'On'] at time 14:23:29.763968 duration_in_ms=49.748
2017-10-18 14:23:29,764 [salt.state       ][INFO    ][32464] Running state [gluster volume set 'nova_instances' 'network.remote-dio' 'On'] at time 14:23:29.764410
2017-10-18 14:23:29,765 [salt.state       ][INFO    ][32464] Executing state cmd.run for gluster volume set 'nova_instances' 'network.remote-dio' 'On'
2017-10-18 14:23:29,765 [salt.loaded.int.module.cmdmod][INFO    ][32464] Executing command 'gluster volume info 'nova_instances' | grep 'network.remote-dio: On'' in directory '/root'
2017-10-18 14:23:29,816 [salt.state       ][INFO    ][32464] unless execution succeeded
2017-10-18 14:23:29,816 [salt.state       ][INFO    ][32464] Completed state [gluster volume set 'nova_instances' 'network.remote-dio' 'On'] at time 14:23:29.816068 duration_in_ms=51.658
2017-10-18 14:23:29,817 [salt.state       ][INFO    ][32464] Running state [gluster volume set 'nova_instances' 'nfs.disable' 'On'] at time 14:23:29.816514
2017-10-18 14:23:29,817 [salt.state       ][INFO    ][32464] Executing state cmd.run for gluster volume set 'nova_instances' 'nfs.disable' 'On'
2017-10-18 14:23:29,817 [salt.loaded.int.module.cmdmod][INFO    ][32464] Executing command 'gluster volume info 'nova_instances' | grep 'nfs.disable: On'' in directory '/root'
2017-10-18 14:23:29,867 [salt.state       ][INFO    ][32464] unless execution succeeded
2017-10-18 14:23:29,867 [salt.state       ][INFO    ][32464] Completed state [gluster volume set 'nova_instances' 'nfs.disable' 'On'] at time 14:23:29.867205 duration_in_ms=50.69
2017-10-18 14:23:29,868 [salt.state       ][INFO    ][32464] Running state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 14:23:29.867659
2017-10-18 14:23:29,868 [salt.state       ][INFO    ][32464] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'
2017-10-18 14:23:29,868 [salt.loaded.int.module.cmdmod][INFO    ][32464] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-10-18 14:23:29,917 [salt.state       ][INFO    ][32464] unless execution succeeded
2017-10-18 14:23:29,917 [salt.state       ][INFO    ][32464] Completed state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 14:23:29.917185 duration_in_ms=49.524
2017-10-18 14:23:29,918 [salt.state       ][INFO    ][32464] Running state [nova_instances] at time 14:23:29.918144
2017-10-18 14:23:29,918 [salt.state       ][INFO    ][32464] Executing state glusterfs.started for nova_instances
2017-10-18 14:23:29,919 [salt.loaded.int.module.cmdmod][INFO    ][32464] Executing command 'gluster --version' in directory '/root'
2017-10-18 14:23:29,927 [salt.loaded.int.module.cmdmod][INFO    ][32464] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-18 14:23:29,975 [salt.loaded.int.module.cmdmod][INFO    ][32464] Executing command 'gluster --version' in directory '/root'
2017-10-18 14:23:29,983 [salt.loaded.int.module.cmdmod][INFO    ][32464] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-18 14:23:30,034 [salt.state       ][INFO    ][32464] Volume nova_instances is already started
2017-10-18 14:23:30,035 [salt.state       ][INFO    ][32464] Completed state [nova_instances] at time 14:23:30.034667 duration_in_ms=116.523
2017-10-18 14:23:30,036 [salt.state       ][INFO    ][32464] Running state [keystone-credential-keys] at time 14:23:30.035485
2017-10-18 14:23:30,036 [salt.state       ][INFO    ][32464] Executing state glusterfs.created for keystone-credential-keys
2017-10-18 14:23:30,036 [salt.loaded.int.module.cmdmod][INFO    ][32464] Executing command 'gluster --version' in directory '/root'
2017-10-18 14:23:30,045 [salt.loaded.int.module.cmdmod][INFO    ][32464] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-18 14:23:30,094 [salt.loaded.int.module.cmdmod][INFO    ][32464] Executing command 'gluster --version' in directory '/root'
2017-10-18 14:23:30,102 [salt.loaded.int.module.cmdmod][INFO    ][32464] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-18 14:23:30,152 [salt.state       ][INFO    ][32464] Volume keystone-credential-keys already exists and is started.
2017-10-18 14:23:30,153 [salt.state       ][INFO    ][32464] Completed state [keystone-credential-keys] at time 14:23:30.152690 duration_in_ms=117.205
2017-10-18 14:23:30,156 [salt.state       ][INFO    ][32464] Running state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 14:23:30.155659
2017-10-18 14:23:30,156 [salt.state       ][INFO    ][32464] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'
2017-10-18 14:23:30,156 [salt.loaded.int.module.cmdmod][INFO    ][32464] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-10-18 14:23:30,203 [salt.state       ][INFO    ][32464] unless execution succeeded
2017-10-18 14:23:30,204 [salt.state       ][INFO    ][32464] Completed state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 14:23:30.203625 duration_in_ms=47.966
2017-10-18 14:23:30,204 [salt.state       ][INFO    ][32464] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 14:23:30.204020
2017-10-18 14:23:30,204 [salt.state       ][INFO    ][32464] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-10-18 14:23:30,205 [salt.loaded.int.module.cmdmod][INFO    ][32464] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-10-18 14:23:30,252 [salt.state       ][INFO    ][32464] unless execution succeeded
2017-10-18 14:23:30,252 [salt.state       ][INFO    ][32464] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 14:23:30.252223 duration_in_ms=48.202
2017-10-18 14:23:30,253 [salt.state       ][INFO    ][32464] Running state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 14:23:30.252646
2017-10-18 14:23:30,253 [salt.state       ][INFO    ][32464] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'
2017-10-18 14:23:30,253 [salt.loaded.int.module.cmdmod][INFO    ][32464] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-10-18 14:23:30,301 [salt.state       ][INFO    ][32464] unless execution succeeded
2017-10-18 14:23:30,301 [salt.state       ][INFO    ][32464] Completed state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 14:23:30.300955 duration_in_ms=48.308
2017-10-18 14:23:30,301 [salt.state       ][INFO    ][32464] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 14:23:30.301409
2017-10-18 14:23:30,302 [salt.state       ][INFO    ][32464] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'
2017-10-18 14:23:30,302 [salt.loaded.int.module.cmdmod][INFO    ][32464] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-10-18 14:23:30,351 [salt.state       ][INFO    ][32464] unless execution succeeded
2017-10-18 14:23:30,352 [salt.state       ][INFO    ][32464] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 14:23:30.351655 duration_in_ms=50.246
2017-10-18 14:23:30,352 [salt.state       ][INFO    ][32464] Running state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 14:23:30.352273
2017-10-18 14:23:30,353 [salt.state       ][INFO    ][32464] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'
2017-10-18 14:23:30,353 [salt.loaded.int.module.cmdmod][INFO    ][32464] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-10-18 14:23:30,401 [salt.state       ][INFO    ][32464] unless execution succeeded
2017-10-18 14:23:30,401 [salt.state       ][INFO    ][32464] Completed state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 14:23:30.401162 duration_in_ms=48.888
2017-10-18 14:23:30,402 [salt.state       ][INFO    ][32464] Running state [keystone-credential-keys] at time 14:23:30.402144
2017-10-18 14:23:30,402 [salt.state       ][INFO    ][32464] Executing state glusterfs.started for keystone-credential-keys
2017-10-18 14:23:30,403 [salt.loaded.int.module.cmdmod][INFO    ][32464] Executing command 'gluster --version' in directory '/root'
2017-10-18 14:23:30,411 [salt.loaded.int.module.cmdmod][INFO    ][32464] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-18 14:23:30,460 [salt.loaded.int.module.cmdmod][INFO    ][32464] Executing command 'gluster --version' in directory '/root'
2017-10-18 14:23:30,469 [salt.loaded.int.module.cmdmod][INFO    ][32464] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-18 14:23:30,520 [salt.state       ][INFO    ][32464] Volume keystone-credential-keys is already started
2017-10-18 14:23:30,520 [salt.state       ][INFO    ][32464] Completed state [keystone-credential-keys] at time 14:23:30.520274 duration_in_ms=118.129
2017-10-18 14:23:30,522 [salt.minion      ][INFO    ][32464] Returning information for job: 20171018142326834313
2017-10-18 14:23:35,402 [salt.minion      ][INFO    ][23091] User sudo_ubuntu Executing command test.ping with jid 20171018142335391058
2017-10-18 14:23:35,417 [salt.minion      ][INFO    ][379] Starting a new job with PID 379
2017-10-18 14:23:35,442 [salt.minion      ][INFO    ][379] Returning information for job: 20171018142335391058
2017-10-18 14:23:35,853 [salt.minion      ][INFO    ][23091] User sudo_ubuntu Executing command cmd.run with jid 20171018142335844123
2017-10-18 14:23:35,868 [salt.minion      ][INFO    ][384] Starting a new job with PID 384
2017-10-18 14:23:35,873 [salt.loaded.int.module.cmdmod][INFO    ][384] Executing command 'gluster peer status; gluster volume status' in directory '/root'
2017-10-18 14:23:35,984 [salt.minion      ][INFO    ][384] Returning information for job: 20171018142335844123
2017-10-18 14:40:49,776 [salt.minion      ][INFO    ][23091] User sudo_ubuntu Executing command cp.push_dir with jid 20171018144049762967
2017-10-18 14:40:49,794 [salt.minion      ][INFO    ][573] Starting a new job with PID 573
