2017-10-27 22:00:48,930 [salt.cli.daemons ][WARNING ][2504] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-10-27 22:01:29,166 [salt.state       ][ERROR   ][3778] No contents found in top file
2017-10-27 22:03:04,890 [salt.utils.parsers][WARNING ][2504] Minion received a SIGTERM. Exiting.
2017-10-27 22:05:18,173 [salt.cli.daemons ][WARNING ][3198] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-10-27 22:08:19,353 [salt.loaded.int.module.cmdmod][ERROR   ][10990] Command 'virsh net-destroy default 2>&1 1>/dev/null; virsh net-undefine default' failed with return code: 1
2017-10-27 22:08:19,354 [salt.loaded.int.module.cmdmod][ERROR   ][10990] stderr: error: failed to get network 'default'
error: Network not found: no network with matching name 'default'
2017-10-27 22:08:19,354 [salt.loaded.int.module.cmdmod][ERROR   ][10990] retcode: 1
2017-10-27 22:08:19,355 [salt.state       ][ERROR   ][10990] {'pid': 15873, 'retcode': 1, 'stderr': "error: failed to get network 'default'\nerror: Network not found: no network with matching name 'default'", 'stdout': ''}
2017-10-27 22:08:35,395 [py.warnings      ][WARNING ][15950] /usr/lib/python2.7/dist-packages/salt/utils/templates.py:73: DeprecationWarning: Starting in 2015.5, cmd.run uses python_shell=False by default, which doesn't support shellisms (pipes, env variables, etc). cmd.run is currently aliased to cmd.shell to prevent breakage. Please switch to cmd.shell or set python_shell=True to avoid breakage in the future, when this aliasing is removed.

2017-10-27 22:09:25,865 [salt.loaded.int.module.cmdmod][ERROR   ][15950] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-10-27 22:09:25,865 [salt.loaded.int.module.cmdmod][ERROR   ][15950] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-10-27 22:09:32,550 [salt.loaded.int.module.cmdmod][ERROR   ][15950] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-10-27 22:09:32,550 [salt.loaded.int.module.cmdmod][ERROR   ][15950] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-10-27 22:09:41,447 [salt.loaded.int.module.cmdmod][ERROR   ][15950] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-10-27 22:09:41,448 [salt.loaded.int.module.cmdmod][ERROR   ][15950] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-10-27 22:09:53,057 [salt.loaded.int.module.cmdmod][ERROR   ][15950] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-10-27 22:09:53,057 [salt.loaded.int.module.cmdmod][ERROR   ][15950] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-10-27 22:10:02,312 [salt.loaded.int.module.cmdmod][ERROR   ][15950] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-10-27 22:10:02,313 [salt.loaded.int.module.cmdmod][ERROR   ][15950] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-10-27 22:10:08,850 [salt.loaded.int.module.cmdmod][ERROR   ][15950] Command 'while true; do salt-call saltutil.running|grep fun: && continue; salt-call --local service.restart salt-minion; break; done' failed with return code: None
2017-10-27 22:10:10,982 [salt.loaded.int.module.cmdmod][INFO    ][23527] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2017-10-27 22:10:10,989 [salt.loaded.int.module.cmdmod][INFO    ][23527] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2017-10-27 22:10:10,998 [salt.loaded.int.module.cmdmod][INFO    ][23527] Executing command ['systemd-run', '--scope', 'systemctl', 'restart', 'salt-minion.service'] in directory '/root'
2017-10-27 22:10:11,005 [salt.utils.parsers][WARNING ][3198] Minion received a SIGTERM. Exiting.
2017-10-27 22:10:11,260 [salt.cli.daemons ][INFO    ][23612] Setting up the Salt Minion "kvm01.baremetal-mcp-ocata-odl-ha.local"
2017-10-27 22:10:11,796 [salt.minion      ][INFO    ][23612] Creating minion process manager
2017-10-27 22:10:11,796 [salt.cli.daemons ][WARNING ][23612] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-10-27 22:10:11,796 [salt.cli.daemons ][INFO    ][23612] The Salt Minion is starting up
2017-10-27 22:10:11,796 [salt.minion      ][INFO    ][23612] Minion is starting as user 'root'
2017-10-27 22:10:11,797 [salt.utils.event ][INFO    ][23612] Starting pull socket on /var/run/salt/minion/minion_event_127643860a_pull.ipc
2017-10-27 22:10:12,645 [salt.loaded.int.module.cmdmod][INFO    ][23612] Executing command ['date', '+%z'] in directory '/root'
2017-10-27 22:10:12,653 [salt.utils.schedule][INFO    ][23612] Updating job settings for scheduled job: __mine_interval
2017-10-27 22:10:12,655 [salt.minion      ][INFO    ][23612] Added mine.update to scheduler
2017-10-27 22:10:12,748 [salt.minion      ][INFO    ][23612] Minion is ready to receive requests!
2017-10-27 22:10:13,749 [salt.utils.schedule][INFO    ][23612] Running scheduled job: __mine_interval
2017-10-27 22:10:23,402 [salt.minion      ][INFO    ][23612] User sudo_ubuntu Executing command saltutil.sync_all with jid 20171027221023398257
2017-10-27 22:10:23,415 [salt.minion      ][INFO    ][23739] Starting a new job with PID 23739
2017-10-27 22:10:24,925 [salt.state       ][INFO    ][23739] Loading fresh modules for state activity
2017-10-27 22:10:24,957 [salt.state       ][ERROR   ][23739] No contents found in top file
2017-10-27 22:10:24,958 [salt.utils.extmods][INFO    ][23739] Creating module dir '/var/cache/salt/minion/extmods/beacons'
2017-10-27 22:10:24,961 [salt.utils.extmods][INFO    ][23739] Syncing beacons for environment 'base'
2017-10-27 22:10:24,961 [salt.utils.extmods][INFO    ][23739] Loading cache from salt://_beacons, for base)
2017-10-27 22:10:24,961 [salt.fileclient  ][INFO    ][23739] Caching directory '_beacons/' for environment 'base'
2017-10-27 22:10:24,988 [salt.utils.extmods][INFO    ][23739] Syncing modules for environment 'base'
2017-10-27 22:10:24,988 [salt.utils.extmods][INFO    ][23739] Loading cache from salt://_modules, for base)
2017-10-27 22:10:24,988 [salt.fileclient  ][INFO    ][23739] Caching directory '_modules/' for environment 'base'
2017-10-27 22:10:25,137 [salt.fileclient  ][INFO    ][23739] Fetching file from saltenv 'base', ** done ** '_modules/ceph_ng.py'
2017-10-27 22:10:25,276 [salt.fileclient  ][INFO    ][23739] Fetching file from saltenv 'base', ** done ** '_modules/cinderng.py'
2017-10-27 22:10:25,401 [salt.fileclient  ][INFO    ][23739] Fetching file from saltenv 'base', ** done ** '_modules/contrail.py'
2017-10-27 22:10:25,544 [salt.fileclient  ][INFO    ][23739] Fetching file from saltenv 'base', ** done ** '_modules/creds.py'
2017-10-27 22:10:25,663 [salt.fileclient  ][INFO    ][23739] Fetching file from saltenv 'base', ** done ** '_modules/devops_utils.py'
2017-10-27 22:10:25,820 [salt.fileclient  ][INFO    ][23739] Fetching file from saltenv 'base', ** done ** '_modules/encode_json.py'
2017-10-27 22:10:25,982 [salt.fileclient  ][INFO    ][23739] Fetching file from saltenv 'base', ** done ** '_modules/gerrit.py'
2017-10-27 22:10:26,082 [salt.fileclient  ][INFO    ][23739] Fetching file from saltenv 'base', ** done ** '_modules/glanceng.py'
2017-10-27 22:10:26,162 [salt.fileclient  ][INFO    ][23739] Fetching file from saltenv 'base', ** done ** '_modules/heat.py'
2017-10-27 22:10:26,329 [salt.fileclient  ][INFO    ][23739] Fetching file from saltenv 'base', ** done ** '_modules/heka_alarming.py'
2017-10-27 22:10:26,544 [salt.fileclient  ][INFO    ][23739] Fetching file from saltenv 'base', ** done ** '_modules/helm.py'
2017-10-27 22:10:26,679 [salt.fileclient  ][INFO    ][23739] Fetching file from saltenv 'base', ** done ** '_modules/jenkins_common.py'
2017-10-27 22:10:26,758 [salt.fileclient  ][INFO    ][23739] Fetching file from saltenv 'base', ** done ** '_modules/keystone_policy.py'
2017-10-27 22:10:26,916 [salt.fileclient  ][INFO    ][23739] Fetching file from saltenv 'base', ** done ** '_modules/linux_hosts.py'
2017-10-27 22:10:27,047 [salt.fileclient  ][INFO    ][23739] Fetching file from saltenv 'base', ** done ** '_modules/linux_netlink.py'
2017-10-27 22:10:27,173 [salt.fileclient  ][INFO    ][23739] Fetching file from saltenv 'base', ** done ** '_modules/maas.py'
2017-10-27 22:10:27,266 [salt.fileclient  ][INFO    ][23739] Fetching file from saltenv 'base', ** done ** '_modules/maas_client.py'
2017-10-27 22:10:27,431 [salt.fileclient  ][INFO    ][23739] Fetching file from saltenv 'base', ** done ** '_modules/multipart.py'
2017-10-27 22:10:27,560 [salt.fileclient  ][INFO    ][23739] Fetching file from saltenv 'base', ** done ** '_modules/nagios_alarming.py'
2017-10-27 22:10:27,597 [salt.fileclient  ][INFO    ][23739] Fetching file from saltenv 'base', ** done ** '_modules/neutronng.py'
2017-10-27 22:10:27,670 [salt.fileclient  ][INFO    ][23739] Fetching file from saltenv 'base', ** done ** '_modules/novang.py'
2017-10-27 22:10:27,767 [salt.fileclient  ][INFO    ][23739] Fetching file from saltenv 'base', ** done ** '_modules/reclass.py'
2017-10-27 22:10:27,983 [salt.fileclient  ][INFO    ][23739] Fetching file from saltenv 'base', ** done ** '_modules/rsyslog_util.py'
2017-10-27 22:10:28,005 [salt.fileclient  ][INFO    ][23739] Fetching file from saltenv 'base', ** done ** '_modules/rundeck.py'
2017-10-27 22:10:28,122 [salt.fileclient  ][INFO    ][23739] Fetching file from saltenv 'base', ** done ** '_modules/saltkey.py'
2017-10-27 22:10:28,233 [salt.fileclient  ][INFO    ][23739] Fetching file from saltenv 'base', ** done ** '_modules/saltresource.py'
2017-10-27 22:10:28,361 [salt.fileclient  ][INFO    ][23739] Fetching file from saltenv 'base', ** done ** '_modules/seedng.py'
2017-10-27 22:10:28,571 [salt.fileclient  ][INFO    ][23739] Fetching file from saltenv 'base', ** done ** '_modules/testing/credentials.py'
2017-10-27 22:10:28,609 [salt.fileclient  ][INFO    ][23739] Fetching file from saltenv 'base', ** done ** '_modules/testing/django.py'
2017-10-27 22:10:28,648 [salt.fileclient  ][INFO    ][23739] Fetching file from saltenv 'base', ** done ** '_modules/testing/django_client_proxy.py'
2017-10-27 22:10:28,672 [salt.fileclient  ][INFO    ][23739] Fetching file from saltenv 'base', ** done ** '_modules/utils.py'
2017-10-27 22:10:28,720 [salt.fileclient  ][INFO    ][23739] Fetching file from saltenv 'base', ** done ** '_modules/virtng.py'
2017-10-27 22:10:28,723 [salt.utils.extmods][INFO    ][23739] Copying '/var/cache/salt/minion/files/base/_modules/__init__.py' to '/var/cache/salt/minion/extmods/modules/__init__.py'
2017-10-27 22:10:28,723 [salt.utils.extmods][INFO    ][23739] Copying '/var/cache/salt/minion/files/base/_modules/ceph_ng.py' to '/var/cache/salt/minion/extmods/modules/ceph_ng.py'
2017-10-27 22:10:28,844 [salt.utils.extmods][INFO    ][23739] Copying '/var/cache/salt/minion/files/base/_modules/cinderng.py' to '/var/cache/salt/minion/extmods/modules/cinderng.py'
2017-10-27 22:10:28,889 [salt.utils.extmods][INFO    ][23739] Copying '/var/cache/salt/minion/files/base/_modules/contrail.py' to '/var/cache/salt/minion/extmods/modules/contrail.py'
2017-10-27 22:10:28,976 [salt.utils.extmods][INFO    ][23739] Copying '/var/cache/salt/minion/files/base/_modules/creds.py' to '/var/cache/salt/minion/extmods/modules/creds.py'
2017-10-27 22:10:29,002 [salt.utils.extmods][INFO    ][23739] Copying '/var/cache/salt/minion/files/base/_modules/devops_utils.py' to '/var/cache/salt/minion/extmods/modules/devops_utils.py'
2017-10-27 22:10:29,025 [salt.utils.extmods][INFO    ][23739] Copying '/var/cache/salt/minion/files/base/_modules/encode_json.py' to '/var/cache/salt/minion/extmods/modules/encode_json.py'
2017-10-27 22:10:29,072 [salt.utils.extmods][INFO    ][23739] Copying '/var/cache/salt/minion/files/base/_modules/gerrit.py' to '/var/cache/salt/minion/extmods/modules/gerrit.py'
2017-10-27 22:10:29,159 [salt.utils.extmods][INFO    ][23739] Copying '/var/cache/salt/minion/files/base/_modules/glanceng.py' to '/var/cache/salt/minion/extmods/modules/glanceng.py'
2017-10-27 22:10:29,167 [salt.utils.extmods][INFO    ][23739] Copying '/var/cache/salt/minion/files/base/_modules/heat.py' to '/var/cache/salt/minion/extmods/modules/heat.py'
2017-10-27 22:10:29,174 [salt.utils.extmods][INFO    ][23739] Copying '/var/cache/salt/minion/files/base/_modules/heka_alarming.py' to '/var/cache/salt/minion/extmods/modules/heka_alarming.py'
2017-10-27 22:10:29,174 [salt.utils.extmods][INFO    ][23739] Copying '/var/cache/salt/minion/files/base/_modules/helm.py' to '/var/cache/salt/minion/extmods/modules/helm.py'
2017-10-27 22:10:29,174 [salt.utils.extmods][INFO    ][23739] Copying '/var/cache/salt/minion/files/base/_modules/jenkins_common.py' to '/var/cache/salt/minion/extmods/modules/jenkins_common.py'
2017-10-27 22:10:29,175 [salt.utils.extmods][INFO    ][23739] Copying '/var/cache/salt/minion/files/base/_modules/keystone_policy.py' to '/var/cache/salt/minion/extmods/modules/keystone_policy.py'
2017-10-27 22:10:29,176 [salt.utils.extmods][INFO    ][23739] Copying '/var/cache/salt/minion/files/base/_modules/linux_hosts.py' to '/var/cache/salt/minion/extmods/modules/linux_hosts.py'
2017-10-27 22:10:29,176 [salt.utils.extmods][INFO    ][23739] Copying '/var/cache/salt/minion/files/base/_modules/linux_netlink.py' to '/var/cache/salt/minion/extmods/modules/linux_netlink.py'
2017-10-27 22:10:29,176 [salt.utils.extmods][INFO    ][23739] Copying '/var/cache/salt/minion/files/base/_modules/maas.py' to '/var/cache/salt/minion/extmods/modules/maas.py'
2017-10-27 22:10:29,177 [salt.utils.extmods][INFO    ][23739] Copying '/var/cache/salt/minion/files/base/_modules/maas_client.py' to '/var/cache/salt/minion/extmods/modules/maas_client.py'
2017-10-27 22:10:29,177 [salt.utils.extmods][INFO    ][23739] Copying '/var/cache/salt/minion/files/base/_modules/multipart.py' to '/var/cache/salt/minion/extmods/modules/multipart.py'
2017-10-27 22:10:29,184 [salt.utils.extmods][INFO    ][23739] Copying '/var/cache/salt/minion/files/base/_modules/nagios_alarming.py' to '/var/cache/salt/minion/extmods/modules/nagios_alarming.py'
2017-10-27 22:10:29,185 [salt.utils.extmods][INFO    ][23739] Copying '/var/cache/salt/minion/files/base/_modules/neutronng.py' to '/var/cache/salt/minion/extmods/modules/neutronng.py'
2017-10-27 22:10:29,185 [salt.utils.extmods][INFO    ][23739] Copying '/var/cache/salt/minion/files/base/_modules/novang.py' to '/var/cache/salt/minion/extmods/modules/novang.py'
2017-10-27 22:10:29,186 [salt.utils.extmods][INFO    ][23739] Copying '/var/cache/salt/minion/files/base/_modules/reclass.py' to '/var/cache/salt/minion/extmods/modules/reclass.py'
2017-10-27 22:10:29,191 [salt.utils.extmods][INFO    ][23739] Copying '/var/cache/salt/minion/files/base/_modules/rsyslog_util.py' to '/var/cache/salt/minion/extmods/modules/rsyslog_util.py'
2017-10-27 22:10:29,191 [salt.utils.extmods][INFO    ][23739] Copying '/var/cache/salt/minion/files/base/_modules/rundeck.py' to '/var/cache/salt/minion/extmods/modules/rundeck.py'
2017-10-27 22:10:29,191 [salt.utils.extmods][INFO    ][23739] Copying '/var/cache/salt/minion/files/base/_modules/saltkey.py' to '/var/cache/salt/minion/extmods/modules/saltkey.py'
2017-10-27 22:10:29,192 [salt.utils.extmods][INFO    ][23739] Copying '/var/cache/salt/minion/files/base/_modules/saltresource.py' to '/var/cache/salt/minion/extmods/modules/saltresource.py'
2017-10-27 22:10:29,192 [salt.utils.extmods][INFO    ][23739] Copying '/var/cache/salt/minion/files/base/_modules/seedng.py' to '/var/cache/salt/minion/extmods/modules/seedng.py'
2017-10-27 22:10:29,198 [salt.utils.extmods][INFO    ][23739] Copying '/var/cache/salt/minion/files/base/_modules/testing/__init__.py' to '/var/cache/salt/minion/extmods/modules/testing/__init__.py'
2017-10-27 22:10:29,198 [salt.utils.extmods][INFO    ][23739] Copying '/var/cache/salt/minion/files/base/_modules/testing/credentials.py' to '/var/cache/salt/minion/extmods/modules/testing/credentials.py'
2017-10-27 22:10:29,199 [salt.utils.extmods][INFO    ][23739] Copying '/var/cache/salt/minion/files/base/_modules/testing/django.py' to '/var/cache/salt/minion/extmods/modules/testing/django.py'
2017-10-27 22:10:29,199 [salt.utils.extmods][INFO    ][23739] Copying '/var/cache/salt/minion/files/base/_modules/testing/django_client_proxy.py' to '/var/cache/salt/minion/extmods/modules/testing/django_client_proxy.py'
2017-10-27 22:10:29,200 [salt.utils.extmods][INFO    ][23739] Copying '/var/cache/salt/minion/files/base/_modules/utils.py' to '/var/cache/salt/minion/extmods/modules/utils.py'
2017-10-27 22:10:29,200 [salt.utils.extmods][INFO    ][23739] Copying '/var/cache/salt/minion/files/base/_modules/virtng.py' to '/var/cache/salt/minion/extmods/modules/virtng.py'
2017-10-27 22:10:29,207 [salt.utils.extmods][INFO    ][23739] Syncing states for environment 'base'
2017-10-27 22:10:29,207 [salt.utils.extmods][INFO    ][23739] Loading cache from salt://_states, for base)
2017-10-27 22:10:29,207 [salt.fileclient  ][INFO    ][23739] Caching directory '_states/' for environment 'base'
2017-10-27 22:10:29,367 [salt.fileclient  ][INFO    ][23739] Fetching file from saltenv 'base', ** done ** '_states/cinderng.py'
2017-10-27 22:10:29,590 [salt.fileclient  ][INFO    ][23739] Fetching file from saltenv 'base', ** done ** '_states/contrail.py'
2017-10-27 22:10:29,748 [salt.fileclient  ][INFO    ][23739] Fetching file from saltenv 'base', ** done ** '_states/gerrit.py'
2017-10-27 22:10:29,765 [salt.fileclient  ][INFO    ][23739] Fetching file from saltenv 'base', ** done ** '_states/glanceng.py'
2017-10-27 22:10:29,777 [salt.fileclient  ][INFO    ][23739] Fetching file from saltenv 'base', ** done ** '_states/grafana3_dashboard.py'
2017-10-27 22:10:29,882 [salt.fileclient  ][INFO    ][23739] Fetching file from saltenv 'base', ** done ** '_states/grafana3_datasource.py'
2017-10-27 22:10:29,966 [salt.fileclient  ][INFO    ][23739] Fetching file from saltenv 'base', ** done ** '_states/heat.py'
2017-10-27 22:10:30,146 [salt.fileclient  ][INFO    ][23739] Fetching file from saltenv 'base', ** done ** '_states/helm_release.py'
2017-10-27 22:10:30,219 [salt.fileclient  ][INFO    ][23739] Fetching file from saltenv 'base', ** done ** '_states/jenkins_approval.py'
2017-10-27 22:10:30,314 [salt.fileclient  ][INFO    ][23739] Fetching file from saltenv 'base', ** done ** '_states/jenkins_artifactory.py'
2017-10-27 22:10:30,399 [salt.fileclient  ][INFO    ][23739] Fetching file from saltenv 'base', ** done ** '_states/jenkins_credential.py'
2017-10-27 22:10:30,543 [salt.fileclient  ][INFO    ][23739] Fetching file from saltenv 'base', ** done ** '_states/jenkins_job.py'
2017-10-27 22:10:30,632 [salt.fileclient  ][INFO    ][23739] Fetching file from saltenv 'base', ** done ** '_states/jenkins_lib.py'
2017-10-27 22:10:30,711 [salt.fileclient  ][INFO    ][23739] Fetching file from saltenv 'base', ** done ** '_states/jenkins_node.py'
2017-10-27 22:10:30,860 [salt.fileclient  ][INFO    ][23739] Fetching file from saltenv 'base', ** done ** '_states/jenkins_plugin.py'
2017-10-27 22:10:30,932 [salt.fileclient  ][INFO    ][23739] Fetching file from saltenv 'base', ** done ** '_states/jenkins_security.py'
2017-10-27 22:10:31,084 [salt.fileclient  ][INFO    ][23739] Fetching file from saltenv 'base', ** done ** '_states/jenkins_slack.py'
2017-10-27 22:10:31,178 [salt.fileclient  ][INFO    ][23739] Fetching file from saltenv 'base', ** done ** '_states/jenkins_smtp.py'
2017-10-27 22:10:31,244 [salt.fileclient  ][INFO    ][23739] Fetching file from saltenv 'base', ** done ** '_states/jenkins_theme.py'
2017-10-27 22:10:31,388 [salt.fileclient  ][INFO    ][23739] Fetching file from saltenv 'base', ** done ** '_states/jenkins_user.py'
2017-10-27 22:10:31,424 [salt.fileclient  ][INFO    ][23739] Fetching file from saltenv 'base', ** done ** '_states/jenkins_view.py'
2017-10-27 22:10:31,533 [salt.fileclient  ][INFO    ][23739] Fetching file from saltenv 'base', ** done ** '_states/keystone_policy.py'
2017-10-27 22:10:31,628 [salt.fileclient  ][INFO    ][23739] Fetching file from saltenv 'base', ** done ** '_states/kibana_object.py'
2017-10-27 22:10:31,714 [salt.fileclient  ][INFO    ][23739] Fetching file from saltenv 'base', ** done ** '_states/neutronng.py'
2017-10-27 22:10:31,855 [salt.fileclient  ][INFO    ][23739] Fetching file from saltenv 'base', ** done ** '_states/novang.py'
2017-10-27 22:10:32,035 [salt.fileclient  ][INFO    ][23739] Fetching file from saltenv 'base', ** done ** '_states/reclass.py'
2017-10-27 22:10:32,117 [salt.fileclient  ][INFO    ][23739] Fetching file from saltenv 'base', ** done ** '_states/rundeck_project.py'
2017-10-27 22:10:32,175 [salt.fileclient  ][INFO    ][23739] Fetching file from saltenv 'base', ** done ** '_states/rundeck_scm.py'
2017-10-27 22:10:32,237 [salt.fileclient  ][INFO    ][23739] Fetching file from saltenv 'base', ** done ** '_states/rundeck_secret.py'
2017-10-27 22:10:32,240 [salt.utils.extmods][INFO    ][23739] Copying '/var/cache/salt/minion/files/base/_states/cinderng.py' to '/var/cache/salt/minion/extmods/states/cinderng.py'
2017-10-27 22:10:32,240 [salt.utils.extmods][INFO    ][23739] Copying '/var/cache/salt/minion/files/base/_states/contrail.py' to '/var/cache/salt/minion/extmods/states/contrail.py'
2017-10-27 22:10:32,241 [salt.utils.extmods][INFO    ][23739] Copying '/var/cache/salt/minion/files/base/_states/gerrit.py' to '/var/cache/salt/minion/extmods/states/gerrit.py'
2017-10-27 22:10:32,241 [salt.utils.extmods][INFO    ][23739] Copying '/var/cache/salt/minion/files/base/_states/glanceng.py' to '/var/cache/salt/minion/extmods/states/glanceng.py'
2017-10-27 22:10:32,241 [salt.utils.extmods][INFO    ][23739] Copying '/var/cache/salt/minion/files/base/_states/grafana3_dashboard.py' to '/var/cache/salt/minion/extmods/states/grafana3_dashboard.py'
2017-10-27 22:10:32,242 [salt.utils.extmods][INFO    ][23739] Copying '/var/cache/salt/minion/files/base/_states/grafana3_datasource.py' to '/var/cache/salt/minion/extmods/states/grafana3_datasource.py'
2017-10-27 22:10:32,242 [salt.utils.extmods][INFO    ][23739] Copying '/var/cache/salt/minion/files/base/_states/heat.py' to '/var/cache/salt/minion/extmods/states/heat.py'
2017-10-27 22:10:32,242 [salt.utils.extmods][INFO    ][23739] Copying '/var/cache/salt/minion/files/base/_states/helm_release.py' to '/var/cache/salt/minion/extmods/states/helm_release.py'
2017-10-27 22:10:32,242 [salt.utils.extmods][INFO    ][23739] Copying '/var/cache/salt/minion/files/base/_states/jenkins_approval.py' to '/var/cache/salt/minion/extmods/states/jenkins_approval.py'
2017-10-27 22:10:32,242 [salt.utils.extmods][INFO    ][23739] Copying '/var/cache/salt/minion/files/base/_states/jenkins_artifactory.py' to '/var/cache/salt/minion/extmods/states/jenkins_artifactory.py'
2017-10-27 22:10:32,243 [salt.utils.extmods][INFO    ][23739] Copying '/var/cache/salt/minion/files/base/_states/jenkins_credential.py' to '/var/cache/salt/minion/extmods/states/jenkins_credential.py'
2017-10-27 22:10:32,243 [salt.utils.extmods][INFO    ][23739] Copying '/var/cache/salt/minion/files/base/_states/jenkins_job.py' to '/var/cache/salt/minion/extmods/states/jenkins_job.py'
2017-10-27 22:10:32,243 [salt.utils.extmods][INFO    ][23739] Copying '/var/cache/salt/minion/files/base/_states/jenkins_lib.py' to '/var/cache/salt/minion/extmods/states/jenkins_lib.py'
2017-10-27 22:10:32,243 [salt.utils.extmods][INFO    ][23739] Copying '/var/cache/salt/minion/files/base/_states/jenkins_node.py' to '/var/cache/salt/minion/extmods/states/jenkins_node.py'
2017-10-27 22:10:32,244 [salt.utils.extmods][INFO    ][23739] Copying '/var/cache/salt/minion/files/base/_states/jenkins_plugin.py' to '/var/cache/salt/minion/extmods/states/jenkins_plugin.py'
2017-10-27 22:10:32,244 [salt.utils.extmods][INFO    ][23739] Copying '/var/cache/salt/minion/files/base/_states/jenkins_security.py' to '/var/cache/salt/minion/extmods/states/jenkins_security.py'
2017-10-27 22:10:32,244 [salt.utils.extmods][INFO    ][23739] Copying '/var/cache/salt/minion/files/base/_states/jenkins_slack.py' to '/var/cache/salt/minion/extmods/states/jenkins_slack.py'
2017-10-27 22:10:32,244 [salt.utils.extmods][INFO    ][23739] Copying '/var/cache/salt/minion/files/base/_states/jenkins_smtp.py' to '/var/cache/salt/minion/extmods/states/jenkins_smtp.py'
2017-10-27 22:10:32,245 [salt.utils.extmods][INFO    ][23739] Copying '/var/cache/salt/minion/files/base/_states/jenkins_theme.py' to '/var/cache/salt/minion/extmods/states/jenkins_theme.py'
2017-10-27 22:10:32,245 [salt.utils.extmods][INFO    ][23739] Copying '/var/cache/salt/minion/files/base/_states/jenkins_user.py' to '/var/cache/salt/minion/extmods/states/jenkins_user.py'
2017-10-27 22:10:32,245 [salt.utils.extmods][INFO    ][23739] Copying '/var/cache/salt/minion/files/base/_states/jenkins_view.py' to '/var/cache/salt/minion/extmods/states/jenkins_view.py'
2017-10-27 22:10:32,245 [salt.utils.extmods][INFO    ][23739] Copying '/var/cache/salt/minion/files/base/_states/keystone_policy.py' to '/var/cache/salt/minion/extmods/states/keystone_policy.py'
2017-10-27 22:10:32,246 [salt.utils.extmods][INFO    ][23739] Copying '/var/cache/salt/minion/files/base/_states/kibana_object.py' to '/var/cache/salt/minion/extmods/states/kibana_object.py'
2017-10-27 22:10:32,246 [salt.utils.extmods][INFO    ][23739] Copying '/var/cache/salt/minion/files/base/_states/maas_cluster.py' to '/var/cache/salt/minion/extmods/states/maas_cluster.py'
2017-10-27 22:10:32,246 [salt.utils.extmods][INFO    ][23739] Copying '/var/cache/salt/minion/files/base/_states/neutronng.py' to '/var/cache/salt/minion/extmods/states/neutronng.py'
2017-10-27 22:10:32,246 [salt.utils.extmods][INFO    ][23739] Copying '/var/cache/salt/minion/files/base/_states/novang.py' to '/var/cache/salt/minion/extmods/states/novang.py'
2017-10-27 22:10:32,247 [salt.utils.extmods][INFO    ][23739] Copying '/var/cache/salt/minion/files/base/_states/reclass.py' to '/var/cache/salt/minion/extmods/states/reclass.py'
2017-10-27 22:10:32,247 [salt.utils.extmods][INFO    ][23739] Copying '/var/cache/salt/minion/files/base/_states/rundeck_project.py' to '/var/cache/salt/minion/extmods/states/rundeck_project.py'
2017-10-27 22:10:32,247 [salt.utils.extmods][INFO    ][23739] Copying '/var/cache/salt/minion/files/base/_states/rundeck_scm.py' to '/var/cache/salt/minion/extmods/states/rundeck_scm.py'
2017-10-27 22:10:32,248 [salt.utils.extmods][INFO    ][23739] Copying '/var/cache/salt/minion/files/base/_states/rundeck_secret.py' to '/var/cache/salt/minion/extmods/states/rundeck_secret.py'
2017-10-27 22:10:32,250 [salt.utils.extmods][INFO    ][23739] Creating module dir '/var/cache/salt/minion/extmods/sdb'
2017-10-27 22:10:32,253 [salt.utils.extmods][INFO    ][23739] Syncing sdb for environment 'base'
2017-10-27 22:10:32,253 [salt.utils.extmods][INFO    ][23739] Loading cache from salt://_sdb, for base)
2017-10-27 22:10:32,253 [salt.fileclient  ][INFO    ][23739] Caching directory '_sdb/' for environment 'base'
2017-10-27 22:10:32,278 [salt.utils.extmods][INFO    ][23739] Syncing grains for environment 'base'
2017-10-27 22:10:32,279 [salt.utils.extmods][INFO    ][23739] Loading cache from salt://_grains, for base)
2017-10-27 22:10:32,279 [salt.fileclient  ][INFO    ][23739] Caching directory '_grains/' for environment 'base'
2017-10-27 22:10:32,329 [salt.fileclient  ][INFO    ][23739] Fetching file from saltenv 'base', ** done ** '_grains/ceilometer_policy.py'
2017-10-27 22:10:32,425 [salt.fileclient  ][INFO    ][23739] Fetching file from saltenv 'base', ** done ** '_grains/ceph.py'
2017-10-27 22:10:32,467 [salt.fileclient  ][INFO    ][23739] Fetching file from saltenv 'base', ** done ** '_grains/cinder_policy.py'
2017-10-27 22:10:32,586 [salt.fileclient  ][INFO    ][23739] Fetching file from saltenv 'base', ** done ** '_grains/docker_swarm.py'
2017-10-27 22:10:32,677 [salt.fileclient  ][INFO    ][23739] Fetching file from saltenv 'base', ** done ** '_grains/glance_policy.py'
2017-10-27 22:10:32,701 [salt.fileclient  ][INFO    ][23739] Fetching file from saltenv 'base', ** done ** '_grains/heat_policy.py'
2017-10-27 22:10:32,713 [salt.fileclient  ][INFO    ][23739] Fetching file from saltenv 'base', ** done ** '_grains/jenkins_plugins.py'
2017-10-27 22:10:32,850 [salt.fileclient  ][INFO    ][23739] Fetching file from saltenv 'base', ** done ** '_grains/keystone_policy.py'
2017-10-27 22:10:32,949 [salt.fileclient  ][INFO    ][23739] Fetching file from saltenv 'base', ** done ** '_grains/kubernetes.py'
2017-10-27 22:10:33,163 [salt.fileclient  ][INFO    ][23739] Fetching file from saltenv 'base', ** done ** '_grains/neutron_policy.py'
2017-10-27 22:10:33,187 [salt.fileclient  ][INFO    ][23739] Fetching file from saltenv 'base', ** done ** '_grains/nova_policy.py'
2017-10-27 22:10:33,342 [salt.fileclient  ][INFO    ][23739] Fetching file from saltenv 'base', ** done ** '_grains/ssh_fingerprints.py'
2017-10-27 22:10:33,348 [salt.utils.extmods][INFO    ][23739] Copying '/var/cache/salt/minion/files/base/_grains/ceilometer_policy.py' to '/var/cache/salt/minion/extmods/grains/ceilometer_policy.py'
2017-10-27 22:10:33,443 [salt.utils.extmods][INFO    ][23739] Copying '/var/cache/salt/minion/files/base/_grains/ceph.py' to '/var/cache/salt/minion/extmods/grains/ceph.py'
2017-10-27 22:10:33,470 [salt.minion      ][INFO    ][23612] User sudo_ubuntu Executing command saltutil.find_job with jid 20171027221033460526
2017-10-27 22:10:33,483 [salt.minion      ][INFO    ][23757] Starting a new job with PID 23757
2017-10-27 22:10:33,493 [salt.minion      ][INFO    ][23757] Returning information for job: 20171027221033460526
2017-10-27 22:10:33,550 [salt.utils.extmods][INFO    ][23739] Copying '/var/cache/salt/minion/files/base/_grains/cinder_policy.py' to '/var/cache/salt/minion/extmods/grains/cinder_policy.py'
2017-10-27 22:10:33,633 [salt.utils.extmods][INFO    ][23739] Copying '/var/cache/salt/minion/files/base/_grains/docker_swarm.py' to '/var/cache/salt/minion/extmods/grains/docker_swarm.py'
2017-10-27 22:10:33,633 [salt.utils.extmods][INFO    ][23739] Copying '/var/cache/salt/minion/files/base/_grains/glance_policy.py' to '/var/cache/salt/minion/extmods/grains/glance_policy.py'
2017-10-27 22:10:33,634 [salt.utils.extmods][INFO    ][23739] Copying '/var/cache/salt/minion/files/base/_grains/heat_policy.py' to '/var/cache/salt/minion/extmods/grains/heat_policy.py'
2017-10-27 22:10:33,657 [salt.utils.extmods][INFO    ][23739] Copying '/var/cache/salt/minion/files/base/_grains/jenkins_plugins.py' to '/var/cache/salt/minion/extmods/grains/jenkins_plugins.py'
2017-10-27 22:10:33,790 [salt.utils.extmods][INFO    ][23739] Copying '/var/cache/salt/minion/files/base/_grains/keystone_policy.py' to '/var/cache/salt/minion/extmods/grains/keystone_policy.py'
2017-10-27 22:10:33,868 [salt.utils.extmods][INFO    ][23739] Copying '/var/cache/salt/minion/files/base/_grains/kubernetes.py' to '/var/cache/salt/minion/extmods/grains/kubernetes.py'
2017-10-27 22:10:33,974 [salt.utils.extmods][INFO    ][23739] Copying '/var/cache/salt/minion/files/base/_grains/neutron_policy.py' to '/var/cache/salt/minion/extmods/grains/neutron_policy.py'
2017-10-27 22:10:34,018 [salt.utils.extmods][INFO    ][23739] Copying '/var/cache/salt/minion/files/base/_grains/nova_policy.py' to '/var/cache/salt/minion/extmods/grains/nova_policy.py'
2017-10-27 22:10:34,099 [salt.utils.extmods][INFO    ][23739] Copying '/var/cache/salt/minion/files/base/_grains/ssh_fingerprints.py' to '/var/cache/salt/minion/extmods/grains/ssh_fingerprints.py'
2017-10-27 22:10:34,211 [salt.utils.extmods][INFO    ][23739] Creating module dir '/var/cache/salt/minion/extmods/renderers'
2017-10-27 22:10:34,214 [salt.utils.extmods][INFO    ][23739] Syncing renderers for environment 'base'
2017-10-27 22:10:34,214 [salt.utils.extmods][INFO    ][23739] Loading cache from salt://_renderers, for base)
2017-10-27 22:10:34,214 [salt.fileclient  ][INFO    ][23739] Caching directory '_renderers/' for environment 'base'
2017-10-27 22:10:34,246 [salt.utils.extmods][INFO    ][23739] Creating module dir '/var/cache/salt/minion/extmods/returners'
2017-10-27 22:10:34,249 [salt.utils.extmods][INFO    ][23739] Syncing returners for environment 'base'
2017-10-27 22:10:34,249 [salt.utils.extmods][INFO    ][23739] Loading cache from salt://_returners, for base)
2017-10-27 22:10:34,249 [salt.fileclient  ][INFO    ][23739] Caching directory '_returners/' for environment 'base'
2017-10-27 22:10:34,277 [salt.utils.extmods][INFO    ][23739] Creating module dir '/var/cache/salt/minion/extmods/output'
2017-10-27 22:10:34,280 [salt.utils.extmods][INFO    ][23739] Syncing output for environment 'base'
2017-10-27 22:10:34,280 [salt.utils.extmods][INFO    ][23739] Loading cache from salt://_output, for base)
2017-10-27 22:10:34,280 [salt.fileclient  ][INFO    ][23739] Caching directory '_output/' for environment 'base'
2017-10-27 22:10:34,311 [salt.utils.extmods][INFO    ][23739] Creating module dir '/var/cache/salt/minion/extmods/utils'
2017-10-27 22:10:34,313 [salt.utils.extmods][INFO    ][23739] Syncing utils for environment 'base'
2017-10-27 22:10:34,313 [salt.utils.extmods][INFO    ][23739] Loading cache from salt://_utils, for base)
2017-10-27 22:10:34,313 [salt.fileclient  ][INFO    ][23739] Caching directory '_utils/' for environment 'base'
2017-10-27 22:10:34,345 [salt.utils.extmods][INFO    ][23739] Creating module dir '/var/cache/salt/minion/extmods/log_handlers'
2017-10-27 22:10:34,347 [salt.utils.extmods][INFO    ][23739] Syncing log_handlers for environment 'base'
2017-10-27 22:10:34,347 [salt.utils.extmods][INFO    ][23739] Loading cache from salt://_log_handlers, for base)
2017-10-27 22:10:34,347 [salt.fileclient  ][INFO    ][23739] Caching directory '_log_handlers/' for environment 'base'
2017-10-27 22:10:34,379 [salt.utils.extmods][INFO    ][23739] Creating module dir '/var/cache/salt/minion/extmods/proxy'
2017-10-27 22:10:34,381 [salt.utils.extmods][INFO    ][23739] Syncing proxy for environment 'base'
2017-10-27 22:10:34,381 [salt.utils.extmods][INFO    ][23739] Loading cache from salt://_proxy, for base)
2017-10-27 22:10:34,382 [salt.fileclient  ][INFO    ][23739] Caching directory '_proxy/' for environment 'base'
2017-10-27 22:10:34,413 [salt.utils.extmods][INFO    ][23739] Creating module dir '/var/cache/salt/minion/extmods/engines'
2017-10-27 22:10:34,415 [salt.utils.extmods][INFO    ][23739] Syncing engines for environment 'base'
2017-10-27 22:10:34,415 [salt.utils.extmods][INFO    ][23739] Loading cache from salt://_engines, for base)
2017-10-27 22:10:34,415 [salt.fileclient  ][INFO    ][23739] Caching directory '_engines/' for environment 'base'
2017-10-27 22:10:34,541 [salt.minion      ][INFO    ][23739] Returning information for job: 20171027221023398257
2017-10-27 22:10:35,805 [salt.minion      ][INFO    ][23612] User sudo_ubuntu Executing command state.sls with jid 20171027221035372952
2017-10-27 22:10:35,815 [salt.minion      ][INFO    ][23866] Starting a new job with PID 23866
2017-10-27 22:10:36,221 [salt.state       ][INFO    ][23866] Loading fresh modules for state activity
2017-10-27 22:10:36,332 [salt.fileclient  ][INFO    ][23866] Fetching file from saltenv 'base', ** done ** 'salt/control/init.sls'
2017-10-27 22:10:36,352 [salt.fileclient  ][INFO    ][23866] Fetching file from saltenv 'base', ** done ** 'salt/control/virt.sls'
2017-10-27 22:10:36,464 [salt.fileclient  ][INFO    ][23866] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-10-27 22:10:36,532 [salt.fileclient  ][INFO    ][23866] Fetching file from saltenv 'base', ** done ** 'salt/minion/init.sls'
2017-10-27 22:10:36,547 [salt.fileclient  ][INFO    ][23866] Fetching file from saltenv 'base', ** done ** 'salt/minion/service.sls'
2017-10-27 22:10:36,583 [salt.fileclient  ][INFO    ][23866] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-10-27 22:10:36,636 [salt.fileclient  ][INFO    ][23866] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-10-27 22:10:36,654 [salt.fileclient  ][INFO    ][23866] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-10-27 22:10:36,769 [salt.fileclient  ][INFO    ][23866] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-10-27 22:10:36,788 [salt.fileclient  ][INFO    ][23866] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-10-27 22:10:36,801 [salt.fileclient  ][INFO    ][23866] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-10-27 22:10:36,818 [salt.fileclient  ][INFO    ][23866] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-10-27 22:10:36,825 [salt.loaded.int.module.cmdmod][INFO    ][23866] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-10-27 22:10:36,848 [salt.fileclient  ][INFO    ][23866] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-10-27 22:10:36,863 [py.warnings      ][WARNING ][23866] /usr/lib/python2.7/dist-packages/salt/utils/templates.py:73: DeprecationWarning: Starting in 2015.5, cmd.run uses python_shell=False by default, which doesn't support shellisms (pipes, env variables, etc). cmd.run is currently aliased to cmd.shell to prevent breakage. Please switch to cmd.shell or set python_shell=True to avoid breakage in the future, when this aliasing is removed.

2017-10-27 22:10:36,863 [salt.loaded.int.module.cmdmod][INFO    ][23866] Executing command 'salt-minion --version' in directory '/root'
2017-10-27 22:10:37,202 [salt.fileclient  ][INFO    ][23866] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-10-27 22:10:37,221 [salt.fileclient  ][INFO    ][23866] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-10-27 22:10:37,234 [salt.fileclient  ][INFO    ][23866] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-10-27 22:10:37,246 [salt.fileclient  ][INFO    ][23866] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-10-27 22:10:37,300 [salt.fileclient  ][INFO    ][23866] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-10-27 22:10:37,426 [salt.fileclient  ][INFO    ][23866] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-10-27 22:10:37,492 [salt.fileclient  ][INFO    ][23866] Fetching file from saltenv 'base', ** done ** 'salt/minion/grains.sls'
2017-10-27 22:10:37,512 [salt.fileclient  ][INFO    ][23866] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-10-27 22:10:37,637 [salt.fileclient  ][INFO    ][23866] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-10-27 22:10:37,654 [salt.fileclient  ][INFO    ][23866] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-10-27 22:10:37,701 [salt.fileclient  ][INFO    ][23866] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-10-27 22:10:37,718 [salt.fileclient  ][INFO    ][23866] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-10-27 22:10:37,731 [salt.fileclient  ][INFO    ][23866] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-10-27 22:10:37,835 [salt.fileclient  ][INFO    ][23866] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-10-27 22:10:37,842 [salt.loaded.int.module.cmdmod][INFO    ][23866] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-10-27 22:10:37,865 [salt.fileclient  ][INFO    ][23866] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-10-27 22:10:37,880 [salt.loaded.int.module.cmdmod][INFO    ][23866] Executing command 'salt-minion --version' in directory '/root'
2017-10-27 22:10:38,121 [salt.fileclient  ][INFO    ][23866] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-10-27 22:10:38,145 [salt.fileclient  ][INFO    ][23866] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-10-27 22:10:38,157 [salt.fileclient  ][INFO    ][23866] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-10-27 22:10:38,188 [salt.fileclient  ][INFO    ][23866] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-10-27 22:10:38,230 [salt.fileclient  ][INFO    ][23866] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-10-27 22:10:38,263 [salt.fileclient  ][INFO    ][23866] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-10-27 22:10:38,327 [salt.fileclient  ][INFO    ][23866] Fetching file from saltenv 'base', ** done ** 'salt/minion/cert.sls'
2017-10-27 22:10:38,419 [salt.fileclient  ][INFO    ][23866] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-10-27 22:10:38,744 [salt.state       ][INFO    ][23866] Running state [salt-minion] at time 22:10:38.743987
2017-10-27 22:10:38,744 [salt.state       ][INFO    ][23866] Executing state pkg.installed for salt-minion
2017-10-27 22:10:38,745 [salt.loaded.int.module.cmdmod][INFO    ][23866] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-10-27 22:10:39,044 [salt.state       ][INFO    ][23866] Package salt-minion is already installed
2017-10-27 22:10:39,044 [salt.state       ][INFO    ][23866] Completed state [salt-minion] at time 22:10:39.043904 duration_in_ms=299.917
2017-10-27 22:10:39,044 [salt.state       ][INFO    ][23866] Running state [salt_minion_dependency_packages] at time 22:10:39.044115
2017-10-27 22:10:39,044 [salt.state       ][INFO    ][23866] Executing state pkg.installed for salt_minion_dependency_packages
2017-10-27 22:10:39,047 [salt.state       ][INFO    ][23866] All specified packages are already installed
2017-10-27 22:10:39,047 [salt.state       ][INFO    ][23866] Completed state [salt_minion_dependency_packages] at time 22:10:39.047098 duration_in_ms=2.983
2017-10-27 22:10:39,049 [salt.state       ][INFO    ][23866] Running state [/etc/salt/minion.d/minion.conf] at time 22:10:39.048556
2017-10-27 22:10:39,049 [salt.state       ][INFO    ][23866] Executing state file.managed for /etc/salt/minion.d/minion.conf
2017-10-27 22:10:39,069 [salt.fileclient  ][INFO    ][23866] Fetching file from saltenv 'base', ** done ** 'salt/files/minion.conf'
2017-10-27 22:10:39,138 [salt.fileclient  ][INFO    ][23866] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-10-27 22:10:39,180 [salt.fileclient  ][INFO    ][23866] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-10-27 22:10:39,212 [salt.state       ][INFO    ][23866] File /etc/salt/minion.d/minion.conf is in the correct state
2017-10-27 22:10:39,212 [salt.state       ][INFO    ][23866] Completed state [/etc/salt/minion.d/minion.conf] at time 22:10:39.211838 duration_in_ms=163.282
2017-10-27 22:10:39,212 [salt.state       ][INFO    ][23866] Running state [/etc/salt/minion.d/_virt.conf] at time 22:10:39.212112
2017-10-27 22:10:39,212 [salt.state       ][INFO    ][23866] Executing state file.managed for /etc/salt/minion.d/_virt.conf
2017-10-27 22:10:39,243 [salt.state       ][INFO    ][23866] File /etc/salt/minion.d/_virt.conf is in the correct state
2017-10-27 22:10:39,243 [salt.state       ][INFO    ][23866] Completed state [/etc/salt/minion.d/_virt.conf] at time 22:10:39.242846 duration_in_ms=30.733
2017-10-27 22:10:39,244 [salt.state       ][INFO    ][23866] Running state [salt-minion] at time 22:10:39.244217
2017-10-27 22:10:39,244 [salt.state       ][INFO    ][23866] Executing state service.running for salt-minion
2017-10-27 22:10:39,245 [salt.loaded.int.module.cmdmod][INFO    ][23866] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2017-10-27 22:10:39,262 [salt.loaded.int.module.cmdmod][INFO    ][23866] Executing command ['systemctl', 'is-active', 'salt-minion.service'] in directory '/root'
2017-10-27 22:10:39,272 [salt.loaded.int.module.cmdmod][INFO    ][23866] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2017-10-27 22:10:39,293 [salt.state       ][INFO    ][23866] The service salt-minion is already running
2017-10-27 22:10:39,294 [salt.state       ][INFO    ][23866] Completed state [salt-minion] at time 22:10:39.293655 duration_in_ms=49.451
2017-10-27 22:10:39,295 [salt.state       ][INFO    ][23866] Running state [/etc/salt/grains.d] at time 22:10:39.295062
2017-10-27 22:10:39,295 [salt.state       ][INFO    ][23866] Executing state file.directory for /etc/salt/grains.d
2017-10-27 22:10:39,296 [salt.state       ][INFO    ][23866] Directory /etc/salt/grains.d is in the correct state
2017-10-27 22:10:39,296 [salt.state       ][INFO    ][23866] Completed state [/etc/salt/grains.d] at time 22:10:39.296111 duration_in_ms=1.049
2017-10-27 22:10:39,297 [salt.state       ][INFO    ][23866] Running state [/etc/salt/grains] at time 22:10:39.296658
2017-10-27 22:10:39,297 [salt.state       ][INFO    ][23866] Executing state file.managed for /etc/salt/grains
2017-10-27 22:10:39,297 [salt.state       ][INFO    ][23866] File /etc/salt/grains exists with proper permissions. No changes made.
2017-10-27 22:10:39,297 [salt.state       ][INFO    ][23866] Completed state [/etc/salt/grains] at time 22:10:39.297412 duration_in_ms=0.754
2017-10-27 22:10:39,298 [salt.state       ][INFO    ][23866] Running state [/etc/salt/grains.d/placeholder] at time 22:10:39.297720
2017-10-27 22:10:39,298 [salt.state       ][INFO    ][23866] Executing state file.managed for /etc/salt/grains.d/placeholder
2017-10-27 22:10:39,298 [salt.state       ][INFO    ][23866] File /etc/salt/grains.d/placeholder exists with proper permissions. No changes made.
2017-10-27 22:10:39,298 [salt.state       ][INFO    ][23866] Completed state [/etc/salt/grains.d/placeholder] at time 22:10:39.298432 duration_in_ms=0.711
2017-10-27 22:10:39,299 [salt.state       ][INFO    ][23866] Running state [/etc/salt/grains.d/sphinx] at time 22:10:39.298737
2017-10-27 22:10:39,299 [salt.state       ][INFO    ][23866] Executing state file.managed for /etc/salt/grains.d/sphinx
2017-10-27 22:10:39,417 [salt.state       ][INFO    ][23866] File changed:
--- 
+++ 
@@ -49,7 +49,6 @@
               - 10.167.4.141
               - 127.0.0.1
               - 192.168.11.2
-              - 192.168.122.1
         system:
           name: System
           param:

2017-10-27 22:10:39,417 [salt.state       ][INFO    ][23866] Completed state [/etc/salt/grains.d/sphinx] at time 22:10:39.417163 duration_in_ms=118.424
2017-10-27 22:10:39,418 [salt.state       ][INFO    ][23866] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 22:10:39.417891
2017-10-27 22:10:39,418 [salt.state       ][INFO    ][23866] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-10-27 22:10:39,418 [salt.state       ][INFO    ][23866] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-10-27 22:10:39,419 [salt.state       ][INFO    ][23866] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 22:10:39.418491 duration_in_ms=0.6
2017-10-27 22:10:39,419 [salt.state       ][INFO    ][23866] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 22:10:39.418644
2017-10-27 22:10:39,419 [salt.state       ][INFO    ][23866] Executing state cmd.mod_watch for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-10-27 22:10:39,419 [salt.loaded.int.module.cmdmod][INFO    ][23866] Executing command 'python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"' in directory '/root'
2017-10-27 22:10:39,515 [salt.state       ][INFO    ][23866] {'pid': 23914, 'retcode': 0, 'stderr': '', 'stdout': ''}
2017-10-27 22:10:39,515 [salt.state       ][INFO    ][23866] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 22:10:39.515117 duration_in_ms=96.472
2017-10-27 22:10:39,516 [salt.state       ][INFO    ][23866] Running state [/etc/salt/grains.d/dns_records] at time 22:10:39.515635
2017-10-27 22:10:39,516 [salt.state       ][INFO    ][23866] Executing state file.managed for /etc/salt/grains.d/dns_records
2017-10-27 22:10:39,603 [salt.state       ][INFO    ][23866] File /etc/salt/grains.d/dns_records is in the correct state
2017-10-27 22:10:39,603 [salt.state       ][INFO    ][23866] Completed state [/etc/salt/grains.d/dns_records] at time 22:10:39.603377 duration_in_ms=87.74
2017-10-27 22:10:39,604 [salt.state       ][INFO    ][23866] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 22:10:39.604151
2017-10-27 22:10:39,604 [salt.state       ][INFO    ][23866] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"
2017-10-27 22:10:39,605 [salt.state       ][INFO    ][23866] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"
2017-10-27 22:10:39,605 [salt.state       ][INFO    ][23866] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 22:10:39.604915 duration_in_ms=0.763
2017-10-27 22:10:39,605 [salt.state       ][INFO    ][23866] Running state [/etc/salt/grains.d/salt] at time 22:10:39.605259
2017-10-27 22:10:39,606 [salt.state       ][INFO    ][23866] Executing state file.managed for /etc/salt/grains.d/salt
2017-10-27 22:10:39,669 [salt.state       ][INFO    ][23866] File /etc/salt/grains.d/salt is in the correct state
2017-10-27 22:10:39,669 [salt.state       ][INFO    ][23866] Completed state [/etc/salt/grains.d/salt] at time 22:10:39.669078 duration_in_ms=63.819
2017-10-27 22:10:39,670 [salt.state       ][INFO    ][23866] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 22:10:39.669724
2017-10-27 22:10:39,670 [salt.state       ][INFO    ][23866] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2017-10-27 22:10:39,670 [salt.state       ][INFO    ][23866] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2017-10-27 22:10:39,670 [salt.state       ][INFO    ][23866] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 22:10:39.670356 duration_in_ms=0.631
2017-10-27 22:10:39,672 [salt.state       ][INFO    ][23866] Running state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 22:10:39.671609
2017-10-27 22:10:39,672 [salt.state       ][INFO    ][23866] Executing state cmd.wait for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-10-27 22:10:39,672 [salt.state       ][INFO    ][23866] No changes made for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-10-27 22:10:39,672 [salt.state       ][INFO    ][23866] Completed state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 22:10:39.672279 duration_in_ms=0.67
2017-10-27 22:10:39,672 [salt.state       ][INFO    ][23866] Running state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 22:10:39.672448
2017-10-27 22:10:39,673 [salt.state       ][INFO    ][23866] Executing state cmd.mod_watch for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-10-27 22:10:39,674 [salt.loaded.int.module.cmdmod][INFO    ][23866] Executing command 'cat /etc/salt/grains.d/* > /etc/salt/grains' in directory '/root'
2017-10-27 22:10:39,684 [salt.state       ][INFO    ][23866] {'pid': 23916, 'retcode': 0, 'stderr': '', 'stdout': ''}
2017-10-27 22:10:39,685 [salt.state       ][INFO    ][23866] Completed state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 22:10:39.684604 duration_in_ms=12.155
2017-10-27 22:10:39,685 [salt.state       ][INFO    ][23866] Running state [mine.update] at time 22:10:39.685294
2017-10-27 22:10:39,686 [salt.state       ][INFO    ][23866] Executing state module.wait for mine.update
2017-10-27 22:10:39,686 [salt.state       ][INFO    ][23866] No changes made for mine.update
2017-10-27 22:10:39,686 [salt.state       ][INFO    ][23866] Completed state [mine.update] at time 22:10:39.685960 duration_in_ms=0.666
2017-10-27 22:10:39,686 [salt.state       ][INFO    ][23866] Running state [mine.update] at time 22:10:39.686125
2017-10-27 22:10:39,686 [salt.state       ][INFO    ][23866] Executing state module.mod_watch for mine.update
2017-10-27 22:10:40,208 [salt.state       ][INFO    ][23866] {'ret': True}
2017-10-27 22:10:40,208 [salt.state       ][INFO    ][23866] Completed state [mine.update] at time 22:10:40.208139 duration_in_ms=522.013
2017-10-27 22:10:40,208 [salt.state       ][INFO    ][23866] Running state [ca-certificates] at time 22:10:40.208450
2017-10-27 22:10:40,209 [salt.state       ][INFO    ][23866] Executing state pkg.installed for ca-certificates
2017-10-27 22:10:40,212 [salt.state       ][INFO    ][23866] Package ca-certificates is already installed
2017-10-27 22:10:40,212 [salt.state       ][INFO    ][23866] Completed state [ca-certificates] at time 22:10:40.212081 duration_in_ms=3.631
2017-10-27 22:10:40,213 [salt.state       ][INFO    ][23866] Running state [update-ca-certificates] at time 22:10:40.212657
2017-10-27 22:10:40,213 [salt.state       ][INFO    ][23866] Executing state cmd.wait for update-ca-certificates
2017-10-27 22:10:40,213 [salt.state       ][INFO    ][23866] No changes made for update-ca-certificates
2017-10-27 22:10:40,213 [salt.state       ][INFO    ][23866] Completed state [update-ca-certificates] at time 22:10:40.213279 duration_in_ms=0.622
2017-10-27 22:10:40,213 [salt.state       ][INFO    ][23866] Running state [libvirt-dev] at time 22:10:40.213468
2017-10-27 22:10:40,214 [salt.state       ][INFO    ][23866] Executing state pkg.installed for libvirt-dev
2017-10-27 22:10:40,216 [salt.state       ][INFO    ][23866] Package libvirt-dev is already installed
2017-10-27 22:10:40,217 [salt.state       ][INFO    ][23866] Completed state [libvirt-dev] at time 22:10:40.216520 duration_in_ms=3.052
2017-10-27 22:10:40,217 [salt.state       ][INFO    ][23866] Running state [pkg-config] at time 22:10:40.216709
2017-10-27 22:10:40,217 [salt.state       ][INFO    ][23866] Executing state pkg.installed for pkg-config
2017-10-27 22:10:40,220 [salt.state       ][INFO    ][23866] Package pkg-config is already installed
2017-10-27 22:10:40,220 [salt.state       ][INFO    ][23866] Completed state [pkg-config] at time 22:10:40.219742 duration_in_ms=3.033
2017-10-27 22:10:40,220 [salt.state       ][INFO    ][23866] Running state [virtng.init] at time 22:10:40.219939
2017-10-27 22:10:40,220 [salt.state       ][INFO    ][23866] Executing state module.run for virtng.init
2017-10-27 22:10:40,309 [salt.loaded.int.module.cmdmod][INFO    ][23866] Executing command ['git', '--version'] in directory '/root'
2017-10-27 22:10:40,417 [salt.loaded.int.module.cmdmod][INFO    ][23866] Executing command 'virsh list --all --name| grep -E "^prx01.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-10-27 22:10:40,439 [salt.state       ][INFO    ][23866] unless execution succeeded
2017-10-27 22:10:40,450 [salt.state       ][INFO    ][23866] Completed state [virtng.init] at time 22:10:40.449779 duration_in_ms=229.838
2017-10-27 22:10:40,450 [salt.state       ][INFO    ][23866] Running state [virt.set_autostart] at time 22:10:40.450100
2017-10-27 22:10:40,450 [salt.state       ][INFO    ][23866] Executing state module.run for virt.set_autostart
2017-10-27 22:10:40,452 [salt.loaded.int.module.cmdmod][INFO    ][23866] Executing command 'virsh list --autostart --name| grep -E "^prx01.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-10-27 22:10:40,472 [salt.state       ][INFO    ][23866] unless execution succeeded
2017-10-27 22:10:40,472 [salt.state       ][INFO    ][23866] Completed state [virt.set_autostart] at time 22:10:40.471980 duration_in_ms=21.879
2017-10-27 22:10:40,472 [salt.state       ][INFO    ][23866] Running state [virtng.init] at time 22:10:40.472260
2017-10-27 22:10:40,472 [salt.state       ][INFO    ][23866] Executing state module.run for virtng.init
2017-10-27 22:10:40,474 [salt.loaded.int.module.cmdmod][INFO    ][23866] Executing command 'virsh list --all --name| grep -E "^ctl01.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-10-27 22:10:40,491 [salt.state       ][INFO    ][23866] unless execution succeeded
2017-10-27 22:10:40,491 [salt.state       ][INFO    ][23866] Completed state [virtng.init] at time 22:10:40.490765 duration_in_ms=18.503
2017-10-27 22:10:40,491 [salt.state       ][INFO    ][23866] Running state [virt.set_autostart] at time 22:10:40.491018
2017-10-27 22:10:40,491 [salt.state       ][INFO    ][23866] Executing state module.run for virt.set_autostart
2017-10-27 22:10:40,493 [salt.loaded.int.module.cmdmod][INFO    ][23866] Executing command 'virsh list --autostart --name| grep -E "^ctl01.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-10-27 22:10:40,509 [salt.state       ][INFO    ][23866] unless execution succeeded
2017-10-27 22:10:40,509 [salt.state       ][INFO    ][23866] Completed state [virt.set_autostart] at time 22:10:40.509004 duration_in_ms=17.984
2017-10-27 22:10:40,509 [salt.state       ][INFO    ][23866] Running state [virtng.init] at time 22:10:40.509251
2017-10-27 22:10:40,509 [salt.state       ][INFO    ][23866] Executing state module.run for virtng.init
2017-10-27 22:10:40,511 [salt.loaded.int.module.cmdmod][INFO    ][23866] Executing command 'virsh list --all --name| grep -E "^mdb01.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-10-27 22:10:40,527 [salt.state       ][INFO    ][23866] unless execution succeeded
2017-10-27 22:10:40,527 [salt.state       ][INFO    ][23866] Completed state [virtng.init] at time 22:10:40.526927 duration_in_ms=17.675
2017-10-27 22:10:40,527 [salt.state       ][INFO    ][23866] Running state [virt.set_autostart] at time 22:10:40.527197
2017-10-27 22:10:40,527 [salt.state       ][INFO    ][23866] Executing state module.run for virt.set_autostart
2017-10-27 22:10:40,529 [salt.loaded.int.module.cmdmod][INFO    ][23866] Executing command 'virsh list --autostart --name| grep -E "^mdb01.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-10-27 22:10:40,545 [salt.state       ][INFO    ][23866] unless execution succeeded
2017-10-27 22:10:40,557 [salt.state       ][INFO    ][23866] Completed state [virt.set_autostart] at time 22:10:40.557194 duration_in_ms=29.995
2017-10-27 22:10:40,558 [salt.state       ][INFO    ][23866] Running state [virtng.init] at time 22:10:40.557557
2017-10-27 22:10:40,558 [salt.state       ][INFO    ][23866] Executing state module.run for virtng.init
2017-10-27 22:10:40,560 [salt.loaded.int.module.cmdmod][INFO    ][23866] Executing command 'virsh list --all --name| grep -E "^msg01.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-10-27 22:10:40,576 [salt.state       ][INFO    ][23866] unless execution succeeded
2017-10-27 22:10:40,576 [salt.state       ][INFO    ][23866] Completed state [virtng.init] at time 22:10:40.576059 duration_in_ms=18.502
2017-10-27 22:10:40,576 [salt.state       ][INFO    ][23866] Running state [virt.set_autostart] at time 22:10:40.576335
2017-10-27 22:10:40,577 [salt.state       ][INFO    ][23866] Executing state module.run for virt.set_autostart
2017-10-27 22:10:40,579 [salt.loaded.int.module.cmdmod][INFO    ][23866] Executing command 'virsh list --autostart --name| grep -E "^msg01.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-10-27 22:10:40,594 [salt.state       ][INFO    ][23866] unless execution succeeded
2017-10-27 22:10:40,595 [salt.state       ][INFO    ][23866] Completed state [virt.set_autostart] at time 22:10:40.594597 duration_in_ms=18.261
2017-10-27 22:10:40,595 [salt.state       ][INFO    ][23866] Running state [virtng.init] at time 22:10:40.594853
2017-10-27 22:10:40,595 [salt.state       ][INFO    ][23866] Executing state module.run for virtng.init
2017-10-27 22:10:40,597 [salt.loaded.int.module.cmdmod][INFO    ][23866] Executing command 'virsh list --all --name| grep -E "^dbs01.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-10-27 22:10:40,612 [salt.state       ][INFO    ][23866] unless execution succeeded
2017-10-27 22:10:40,612 [salt.state       ][INFO    ][23866] Completed state [virtng.init] at time 22:10:40.612444 duration_in_ms=17.59
2017-10-27 22:10:40,613 [salt.state       ][INFO    ][23866] Running state [virt.set_autostart] at time 22:10:40.612677
2017-10-27 22:10:40,613 [salt.state       ][INFO    ][23866] Executing state module.run for virt.set_autostart
2017-10-27 22:10:40,615 [salt.loaded.int.module.cmdmod][INFO    ][23866] Executing command 'virsh list --autostart --name| grep -E "^dbs01.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-10-27 22:10:40,629 [salt.state       ][INFO    ][23866] unless execution succeeded
2017-10-27 22:10:40,630 [salt.state       ][INFO    ][23866] Completed state [virt.set_autostart] at time 22:10:40.629633 duration_in_ms=16.956
2017-10-27 22:10:40,632 [salt.minion      ][INFO    ][23866] Returning information for job: 20171027221035372952
2017-10-27 22:11:06,517 [salt.minion      ][INFO    ][23612] User sudo_ubuntu Executing command state.sls with jid 20171027221106498839
2017-10-27 22:11:06,532 [salt.minion      ][INFO    ][23983] Starting a new job with PID 23983
2017-10-27 22:11:08,955 [salt.state       ][INFO    ][23983] Loading fresh modules for state activity
2017-10-27 22:11:08,980 [salt.fileclient  ][INFO    ][23983] Fetching file from saltenv 'base', ** done ** 'salt/control/init.sls'
2017-10-27 22:11:08,998 [salt.fileclient  ][INFO    ][23983] Fetching file from saltenv 'base', ** done ** 'salt/control/virt.sls'
2017-10-27 22:11:09,054 [salt.fileclient  ][INFO    ][23983] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-10-27 22:11:09,119 [salt.fileclient  ][INFO    ][23983] Fetching file from saltenv 'base', ** done ** 'salt/minion/init.sls'
2017-10-27 22:11:09,133 [salt.fileclient  ][INFO    ][23983] Fetching file from saltenv 'base', ** done ** 'salt/minion/service.sls'
2017-10-27 22:11:09,161 [salt.fileclient  ][INFO    ][23983] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-10-27 22:11:09,271 [salt.fileclient  ][INFO    ][23983] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-10-27 22:11:09,290 [salt.fileclient  ][INFO    ][23983] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-10-27 22:11:09,338 [salt.fileclient  ][INFO    ][23983] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-10-27 22:11:09,362 [salt.fileclient  ][INFO    ][23983] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-10-27 22:11:09,375 [salt.fileclient  ][INFO    ][23983] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-10-27 22:11:09,488 [salt.fileclient  ][INFO    ][23983] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-10-27 22:11:09,495 [salt.loaded.int.module.cmdmod][INFO    ][23983] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-10-27 22:11:09,518 [salt.fileclient  ][INFO    ][23983] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-10-27 22:11:09,534 [py.warnings      ][WARNING ][23983] /usr/lib/python2.7/dist-packages/salt/utils/templates.py:73: DeprecationWarning: Starting in 2015.5, cmd.run uses python_shell=False by default, which doesn't support shellisms (pipes, env variables, etc). cmd.run is currently aliased to cmd.shell to prevent breakage. Please switch to cmd.shell or set python_shell=True to avoid breakage in the future, when this aliasing is removed.

2017-10-27 22:11:09,535 [salt.loaded.int.module.cmdmod][INFO    ][23983] Executing command 'salt-minion --version' in directory '/root'
2017-10-27 22:11:09,774 [salt.fileclient  ][INFO    ][23983] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-10-27 22:11:09,879 [salt.fileclient  ][INFO    ][23983] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-10-27 22:11:09,891 [salt.fileclient  ][INFO    ][23983] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-10-27 22:11:09,903 [salt.fileclient  ][INFO    ][23983] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-10-27 22:11:10,026 [salt.fileclient  ][INFO    ][23983] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-10-27 22:11:10,061 [salt.fileclient  ][INFO    ][23983] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-10-27 22:11:10,126 [salt.fileclient  ][INFO    ][23983] Fetching file from saltenv 'base', ** done ** 'salt/minion/grains.sls'
2017-10-27 22:11:10,149 [salt.fileclient  ][INFO    ][23983] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-10-27 22:11:10,205 [salt.fileclient  ][INFO    ][23983] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-10-27 22:11:10,224 [salt.fileclient  ][INFO    ][23983] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-10-27 22:11:10,353 [salt.fileclient  ][INFO    ][23983] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-10-27 22:11:10,373 [salt.fileclient  ][INFO    ][23983] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-10-27 22:11:10,387 [salt.fileclient  ][INFO    ][23983] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-10-27 22:11:10,402 [salt.fileclient  ][INFO    ][23983] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-10-27 22:11:10,409 [salt.loaded.int.module.cmdmod][INFO    ][23983] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-10-27 22:11:10,432 [salt.fileclient  ][INFO    ][23983] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-10-27 22:11:10,447 [salt.loaded.int.module.cmdmod][INFO    ][23983] Executing command 'salt-minion --version' in directory '/root'
2017-10-27 22:11:10,687 [salt.fileclient  ][INFO    ][23983] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-10-27 22:11:10,707 [salt.fileclient  ][INFO    ][23983] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-10-27 22:11:10,721 [salt.fileclient  ][INFO    ][23983] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-10-27 22:11:10,734 [salt.fileclient  ][INFO    ][23983] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-10-27 22:11:10,830 [salt.fileclient  ][INFO    ][23983] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-10-27 22:11:10,870 [salt.fileclient  ][INFO    ][23983] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-10-27 22:11:10,933 [salt.fileclient  ][INFO    ][23983] Fetching file from saltenv 'base', ** done ** 'salt/minion/cert.sls'
2017-10-27 22:11:10,990 [salt.fileclient  ][INFO    ][23983] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-10-27 22:11:11,283 [salt.state       ][INFO    ][23983] Running state [salt-minion] at time 22:11:11.282898
2017-10-27 22:11:11,283 [salt.state       ][INFO    ][23983] Executing state pkg.installed for salt-minion
2017-10-27 22:11:11,284 [salt.loaded.int.module.cmdmod][INFO    ][23983] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-10-27 22:11:11,604 [salt.state       ][INFO    ][23983] Package salt-minion is already installed
2017-10-27 22:11:11,604 [salt.state       ][INFO    ][23983] Completed state [salt-minion] at time 22:11:11.604134 duration_in_ms=321.237
2017-10-27 22:11:11,604 [salt.state       ][INFO    ][23983] Running state [salt_minion_dependency_packages] at time 22:11:11.604391
2017-10-27 22:11:11,605 [salt.state       ][INFO    ][23983] Executing state pkg.installed for salt_minion_dependency_packages
2017-10-27 22:11:11,607 [salt.state       ][INFO    ][23983] All specified packages are already installed
2017-10-27 22:11:11,607 [salt.state       ][INFO    ][23983] Completed state [salt_minion_dependency_packages] at time 22:11:11.607318 duration_in_ms=2.927
2017-10-27 22:11:11,609 [salt.state       ][INFO    ][23983] Running state [/etc/salt/minion.d/minion.conf] at time 22:11:11.608881
2017-10-27 22:11:11,609 [salt.state       ][INFO    ][23983] Executing state file.managed for /etc/salt/minion.d/minion.conf
2017-10-27 22:11:11,670 [salt.fileclient  ][INFO    ][23983] Fetching file from saltenv 'base', ** done ** 'salt/files/minion.conf'
2017-10-27 22:11:11,714 [salt.fileclient  ][INFO    ][23983] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-10-27 22:11:11,753 [salt.fileclient  ][INFO    ][23983] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-10-27 22:11:11,849 [salt.state       ][INFO    ][23983] File /etc/salt/minion.d/minion.conf is in the correct state
2017-10-27 22:11:11,849 [salt.state       ][INFO    ][23983] Completed state [/etc/salt/minion.d/minion.conf] at time 22:11:11.849234 duration_in_ms=240.353
2017-10-27 22:11:11,850 [salt.state       ][INFO    ][23983] Running state [/etc/salt/minion.d/_virt.conf] at time 22:11:11.849559
2017-10-27 22:11:11,850 [salt.state       ][INFO    ][23983] Executing state file.managed for /etc/salt/minion.d/_virt.conf
2017-10-27 22:11:11,962 [salt.state       ][INFO    ][23983] File /etc/salt/minion.d/_virt.conf is in the correct state
2017-10-27 22:11:11,963 [salt.state       ][INFO    ][23983] Completed state [/etc/salt/minion.d/_virt.conf] at time 22:11:11.962456 duration_in_ms=112.896
2017-10-27 22:11:11,965 [salt.state       ][INFO    ][23983] Running state [salt-minion] at time 22:11:11.964680
2017-10-27 22:11:11,965 [salt.state       ][INFO    ][23983] Executing state service.running for salt-minion
2017-10-27 22:11:11,965 [salt.loaded.int.module.cmdmod][INFO    ][23983] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2017-10-27 22:11:11,984 [salt.loaded.int.module.cmdmod][INFO    ][23983] Executing command ['systemctl', 'is-active', 'salt-minion.service'] in directory '/root'
2017-10-27 22:11:11,993 [salt.loaded.int.module.cmdmod][INFO    ][23983] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2017-10-27 22:11:12,001 [salt.state       ][INFO    ][23983] The service salt-minion is already running
2017-10-27 22:11:12,002 [salt.state       ][INFO    ][23983] Completed state [salt-minion] at time 22:11:12.001546 duration_in_ms=36.865
2017-10-27 22:11:12,003 [salt.state       ][INFO    ][23983] Running state [/etc/salt/grains.d] at time 22:11:12.002786
2017-10-27 22:11:12,003 [salt.state       ][INFO    ][23983] Executing state file.directory for /etc/salt/grains.d
2017-10-27 22:11:12,004 [salt.state       ][INFO    ][23983] Directory /etc/salt/grains.d is in the correct state
2017-10-27 22:11:12,004 [salt.state       ][INFO    ][23983] Completed state [/etc/salt/grains.d] at time 22:11:12.003622 duration_in_ms=0.836
2017-10-27 22:11:12,004 [salt.state       ][INFO    ][23983] Running state [/etc/salt/grains] at time 22:11:12.004015
2017-10-27 22:11:12,004 [salt.state       ][INFO    ][23983] Executing state file.managed for /etc/salt/grains
2017-10-27 22:11:12,005 [salt.state       ][INFO    ][23983] File /etc/salt/grains exists with proper permissions. No changes made.
2017-10-27 22:11:12,005 [salt.state       ][INFO    ][23983] Completed state [/etc/salt/grains] at time 22:11:12.004637 duration_in_ms=0.622
2017-10-27 22:11:12,005 [salt.state       ][INFO    ][23983] Running state [/etc/salt/grains.d/placeholder] at time 22:11:12.004902
2017-10-27 22:11:12,005 [salt.state       ][INFO    ][23983] Executing state file.managed for /etc/salt/grains.d/placeholder
2017-10-27 22:11:12,005 [salt.state       ][INFO    ][23983] File /etc/salt/grains.d/placeholder exists with proper permissions. No changes made.
2017-10-27 22:11:12,006 [salt.state       ][INFO    ][23983] Completed state [/etc/salt/grains.d/placeholder] at time 22:11:12.005500 duration_in_ms=0.599
2017-10-27 22:11:12,006 [salt.state       ][INFO    ][23983] Running state [/etc/salt/grains.d/sphinx] at time 22:11:12.005784
2017-10-27 22:11:12,006 [salt.state       ][INFO    ][23983] Executing state file.managed for /etc/salt/grains.d/sphinx
2017-10-27 22:11:12,058 [salt.state       ][INFO    ][23983] File /etc/salt/grains.d/sphinx is in the correct state
2017-10-27 22:11:12,058 [salt.state       ][INFO    ][23983] Completed state [/etc/salt/grains.d/sphinx] at time 22:11:12.058416 duration_in_ms=52.632
2017-10-27 22:11:12,059 [salt.state       ][INFO    ][23983] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 22:11:12.059106
2017-10-27 22:11:12,059 [salt.state       ][INFO    ][23983] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-10-27 22:11:12,060 [salt.state       ][INFO    ][23983] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-10-27 22:11:12,060 [salt.state       ][INFO    ][23983] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 22:11:12.059690 duration_in_ms=0.584
2017-10-27 22:11:12,060 [salt.state       ][INFO    ][23983] Running state [/etc/salt/grains.d/dns_records] at time 22:11:12.059970
2017-10-27 22:11:12,060 [salt.state       ][INFO    ][23983] Executing state file.managed for /etc/salt/grains.d/dns_records
2017-10-27 22:11:12,077 [salt.state       ][INFO    ][23983] File /etc/salt/grains.d/dns_records is in the correct state
2017-10-27 22:11:12,077 [salt.state       ][INFO    ][23983] Completed state [/etc/salt/grains.d/dns_records] at time 22:11:12.076661 duration_in_ms=16.691
2017-10-27 22:11:12,077 [salt.state       ][INFO    ][23983] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 22:11:12.077214
2017-10-27 22:11:12,077 [salt.state       ][INFO    ][23983] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"
2017-10-27 22:11:12,078 [salt.state       ][INFO    ][23983] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"
2017-10-27 22:11:12,078 [salt.state       ][INFO    ][23983] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 22:11:12.077720 duration_in_ms=0.506
2017-10-27 22:11:12,078 [salt.state       ][INFO    ][23983] Running state [/etc/salt/grains.d/salt] at time 22:11:12.077998
2017-10-27 22:11:12,078 [salt.state       ][INFO    ][23983] Executing state file.managed for /etc/salt/grains.d/salt
2017-10-27 22:11:12,100 [salt.state       ][INFO    ][23983] File /etc/salt/grains.d/salt is in the correct state
2017-10-27 22:11:12,100 [salt.state       ][INFO    ][23983] Completed state [/etc/salt/grains.d/salt] at time 22:11:12.100300 duration_in_ms=22.302
2017-10-27 22:11:12,101 [salt.state       ][INFO    ][23983] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 22:11:12.100832
2017-10-27 22:11:12,101 [salt.state       ][INFO    ][23983] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2017-10-27 22:11:12,101 [salt.state       ][INFO    ][23983] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2017-10-27 22:11:12,101 [salt.state       ][INFO    ][23983] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 22:11:12.101317 duration_in_ms=0.485
2017-10-27 22:11:12,102 [salt.state       ][INFO    ][23983] Running state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 22:11:12.102443
2017-10-27 22:11:12,103 [salt.state       ][INFO    ][23983] Executing state cmd.wait for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-10-27 22:11:12,103 [salt.state       ][INFO    ][23983] No changes made for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-10-27 22:11:12,103 [salt.state       ][INFO    ][23983] Completed state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 22:11:12.102928 duration_in_ms=0.486
2017-10-27 22:11:12,103 [salt.state       ][INFO    ][23983] Running state [mine.update] at time 22:11:12.103323
2017-10-27 22:11:12,103 [salt.state       ][INFO    ][23983] Executing state module.wait for mine.update
2017-10-27 22:11:12,104 [salt.state       ][INFO    ][23983] No changes made for mine.update
2017-10-27 22:11:12,104 [salt.state       ][INFO    ][23983] Completed state [mine.update] at time 22:11:12.103757 duration_in_ms=0.434
2017-10-27 22:11:12,104 [salt.state       ][INFO    ][23983] Running state [ca-certificates] at time 22:11:12.103900
2017-10-27 22:11:12,104 [salt.state       ][INFO    ][23983] Executing state pkg.installed for ca-certificates
2017-10-27 22:11:12,107 [salt.state       ][INFO    ][23983] Package ca-certificates is already installed
2017-10-27 22:11:12,107 [salt.state       ][INFO    ][23983] Completed state [ca-certificates] at time 22:11:12.107117 duration_in_ms=3.217
2017-10-27 22:11:12,108 [salt.state       ][INFO    ][23983] Running state [update-ca-certificates] at time 22:11:12.107526
2017-10-27 22:11:12,108 [salt.state       ][INFO    ][23983] Executing state cmd.wait for update-ca-certificates
2017-10-27 22:11:12,108 [salt.state       ][INFO    ][23983] No changes made for update-ca-certificates
2017-10-27 22:11:12,108 [salt.state       ][INFO    ][23983] Completed state [update-ca-certificates] at time 22:11:12.107990 duration_in_ms=0.464
2017-10-27 22:11:12,108 [salt.state       ][INFO    ][23983] Running state [libvirt-dev] at time 22:11:12.108134
2017-10-27 22:11:12,108 [salt.state       ][INFO    ][23983] Executing state pkg.installed for libvirt-dev
2017-10-27 22:11:12,111 [salt.state       ][INFO    ][23983] Package libvirt-dev is already installed
2017-10-27 22:11:12,111 [salt.state       ][INFO    ][23983] Completed state [libvirt-dev] at time 22:11:12.110960 duration_in_ms=2.827
2017-10-27 22:11:12,111 [salt.state       ][INFO    ][23983] Running state [pkg-config] at time 22:11:12.111106
2017-10-27 22:11:12,111 [salt.state       ][INFO    ][23983] Executing state pkg.installed for pkg-config
2017-10-27 22:11:12,114 [salt.state       ][INFO    ][23983] Package pkg-config is already installed
2017-10-27 22:11:12,114 [salt.state       ][INFO    ][23983] Completed state [pkg-config] at time 22:11:12.113946 duration_in_ms=2.84
2017-10-27 22:11:12,114 [salt.state       ][INFO    ][23983] Running state [virtng.init] at time 22:11:12.114093
2017-10-27 22:11:12,114 [salt.state       ][INFO    ][23983] Executing state module.run for virtng.init
2017-10-27 22:11:12,167 [salt.loaded.int.module.cmdmod][INFO    ][23983] Executing command ['git', '--version'] in directory '/root'
2017-10-27 22:11:12,252 [salt.loaded.int.module.cmdmod][INFO    ][23983] Executing command 'virsh list --all --name| grep -E "^prx01.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-10-27 22:11:12,273 [salt.state       ][INFO    ][23983] unless execution succeeded
2017-10-27 22:11:12,273 [salt.state       ][INFO    ][23983] Completed state [virtng.init] at time 22:11:12.272767 duration_in_ms=158.673
2017-10-27 22:11:12,273 [salt.state       ][INFO    ][23983] Running state [virt.set_autostart] at time 22:11:12.272996
2017-10-27 22:11:12,273 [salt.state       ][INFO    ][23983] Executing state module.run for virt.set_autostart
2017-10-27 22:11:12,275 [salt.loaded.int.module.cmdmod][INFO    ][23983] Executing command 'virsh list --autostart --name| grep -E "^prx01.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-10-27 22:11:12,293 [salt.state       ][INFO    ][23983] unless execution succeeded
2017-10-27 22:11:12,293 [salt.state       ][INFO    ][23983] Completed state [virt.set_autostart] at time 22:11:12.292692 duration_in_ms=19.696
2017-10-27 22:11:12,293 [salt.state       ][INFO    ][23983] Running state [virtng.init] at time 22:11:12.292906
2017-10-27 22:11:12,293 [salt.state       ][INFO    ][23983] Executing state module.run for virtng.init
2017-10-27 22:11:12,295 [salt.loaded.int.module.cmdmod][INFO    ][23983] Executing command 'virsh list --all --name| grep -E "^ctl01.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-10-27 22:11:12,311 [salt.state       ][INFO    ][23983] unless execution succeeded
2017-10-27 22:11:12,311 [salt.state       ][INFO    ][23983] Completed state [virtng.init] at time 22:11:12.310809 duration_in_ms=17.901
2017-10-27 22:11:12,311 [salt.state       ][INFO    ][23983] Running state [virt.set_autostart] at time 22:11:12.311063
2017-10-27 22:11:12,311 [salt.state       ][INFO    ][23983] Executing state module.run for virt.set_autostart
2017-10-27 22:11:12,313 [salt.loaded.int.module.cmdmod][INFO    ][23983] Executing command 'virsh list --autostart --name| grep -E "^ctl01.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-10-27 22:11:12,330 [salt.state       ][INFO    ][23983] unless execution succeeded
2017-10-27 22:11:12,331 [salt.state       ][INFO    ][23983] Completed state [virt.set_autostart] at time 22:11:12.330505 duration_in_ms=19.441
2017-10-27 22:11:12,331 [salt.state       ][INFO    ][23983] Running state [virtng.init] at time 22:11:12.330748
2017-10-27 22:11:12,331 [salt.state       ][INFO    ][23983] Executing state module.run for virtng.init
2017-10-27 22:11:12,333 [salt.loaded.int.module.cmdmod][INFO    ][23983] Executing command 'virsh list --all --name| grep -E "^mdb01.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-10-27 22:11:12,350 [salt.state       ][INFO    ][23983] unless execution succeeded
2017-10-27 22:11:12,418 [salt.state       ][INFO    ][23983] Completed state [virtng.init] at time 22:11:12.417688 duration_in_ms=86.937
2017-10-27 22:11:12,418 [salt.state       ][INFO    ][23983] Running state [virt.set_autostart] at time 22:11:12.418080
2017-10-27 22:11:12,418 [salt.state       ][INFO    ][23983] Executing state module.run for virt.set_autostart
2017-10-27 22:11:12,420 [salt.loaded.int.module.cmdmod][INFO    ][23983] Executing command 'virsh list --autostart --name| grep -E "^mdb01.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-10-27 22:11:12,438 [salt.state       ][INFO    ][23983] unless execution succeeded
2017-10-27 22:11:12,439 [salt.state       ][INFO    ][23983] Completed state [virt.set_autostart] at time 22:11:12.438497 duration_in_ms=20.416
2017-10-27 22:11:12,439 [salt.state       ][INFO    ][23983] Running state [virtng.init] at time 22:11:12.438715
2017-10-27 22:11:12,439 [salt.state       ][INFO    ][23983] Executing state module.run for virtng.init
2017-10-27 22:11:12,441 [salt.loaded.int.module.cmdmod][INFO    ][23983] Executing command 'virsh list --all --name| grep -E "^msg01.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-10-27 22:11:12,456 [salt.state       ][INFO    ][23983] unless execution succeeded
2017-10-27 22:11:12,457 [salt.state       ][INFO    ][23983] Completed state [virtng.init] at time 22:11:12.456529 duration_in_ms=17.812
2017-10-27 22:11:12,457 [salt.state       ][INFO    ][23983] Running state [virt.set_autostart] at time 22:11:12.456746
2017-10-27 22:11:12,457 [salt.state       ][INFO    ][23983] Executing state module.run for virt.set_autostart
2017-10-27 22:11:12,459 [salt.loaded.int.module.cmdmod][INFO    ][23983] Executing command 'virsh list --autostart --name| grep -E "^msg01.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-10-27 22:11:12,475 [salt.state       ][INFO    ][23983] unless execution succeeded
2017-10-27 22:11:12,475 [salt.state       ][INFO    ][23983] Completed state [virt.set_autostart] at time 22:11:12.474807 duration_in_ms=18.059
2017-10-27 22:11:12,475 [salt.state       ][INFO    ][23983] Running state [virtng.init] at time 22:11:12.475017
2017-10-27 22:11:12,475 [salt.state       ][INFO    ][23983] Executing state module.run for virtng.init
2017-10-27 22:11:12,477 [salt.loaded.int.module.cmdmod][INFO    ][23983] Executing command 'virsh list --all --name| grep -E "^dbs01.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-10-27 22:11:12,491 [salt.state       ][INFO    ][23983] unless execution succeeded
2017-10-27 22:11:12,491 [salt.state       ][INFO    ][23983] Completed state [virtng.init] at time 22:11:12.491136 duration_in_ms=16.119
2017-10-27 22:11:12,491 [salt.state       ][INFO    ][23983] Running state [virt.set_autostart] at time 22:11:12.491349
2017-10-27 22:11:12,492 [salt.state       ][INFO    ][23983] Executing state module.run for virt.set_autostart
2017-10-27 22:11:12,493 [salt.loaded.int.module.cmdmod][INFO    ][23983] Executing command 'virsh list --autostart --name| grep -E "^dbs01.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-10-27 22:11:12,510 [salt.state       ][INFO    ][23983] unless execution succeeded
2017-10-27 22:11:12,510 [salt.state       ][INFO    ][23983] Completed state [virt.set_autostart] at time 22:11:12.509859 duration_in_ms=18.51
2017-10-27 22:11:12,512 [salt.minion      ][INFO    ][23983] Returning information for job: 20171027221106498839
2017-10-27 22:11:13,603 [salt.minion      ][INFO    ][23612] User sudo_ubuntu Executing command pillar.get with jid 20171027221113594360
2017-10-27 22:11:13,618 [salt.minion      ][INFO    ][24077] Starting a new job with PID 24077
2017-10-27 22:11:13,629 [salt.minion      ][INFO    ][24077] Returning information for job: 20171027221113594360
2017-10-27 22:11:58,488 [salt.minion      ][INFO    ][23612] User sudo_ubuntu Executing command saltutil.sync_all with jid 20171027221158485288
2017-10-27 22:11:58,508 [salt.minion      ][INFO    ][24097] Starting a new job with PID 24097
2017-10-27 22:12:01,367 [salt.state       ][INFO    ][24097] Loading fresh modules for state activity
2017-10-27 22:12:01,873 [salt.state       ][ERROR   ][24097] No contents found in top file
2017-10-27 22:12:01,874 [salt.utils.extmods][INFO    ][24097] Creating module dir '/var/cache/salt/minion/extmods/beacons'
2017-10-27 22:12:01,878 [salt.utils.extmods][INFO    ][24097] Syncing beacons for environment 'base'
2017-10-27 22:12:01,879 [salt.utils.extmods][INFO    ][24097] Loading cache from salt://_beacons, for base)
2017-10-27 22:12:01,879 [salt.fileclient  ][INFO    ][24097] Caching directory '_beacons/' for environment 'base'
2017-10-27 22:12:01,913 [salt.utils.extmods][INFO    ][24097] Syncing modules for environment 'base'
2017-10-27 22:12:01,913 [salt.utils.extmods][INFO    ][24097] Loading cache from salt://_modules, for base)
2017-10-27 22:12:01,914 [salt.fileclient  ][INFO    ][24097] Caching directory '_modules/' for environment 'base'
2017-10-27 22:12:01,964 [salt.fileclient  ][INFO    ][24097] Fetching file from saltenv 'base', ** done ** '_modules/ceph_ng.py'
2017-10-27 22:12:01,972 [salt.fileclient  ][INFO    ][24097] Fetching file from saltenv 'base', ** done ** '_modules/cinderng.py'
2017-10-27 22:12:02,240 [salt.fileclient  ][INFO    ][24097] Fetching file from saltenv 'base', ** done ** '_modules/contrail.py'
2017-10-27 22:12:02,256 [salt.fileclient  ][INFO    ][24097] Fetching file from saltenv 'base', ** done ** '_modules/creds.py'
2017-10-27 22:12:02,274 [salt.fileclient  ][INFO    ][24097] Fetching file from saltenv 'base', ** done ** '_modules/devops_utils.py'
2017-10-27 22:12:02,288 [salt.fileclient  ][INFO    ][24097] Fetching file from saltenv 'base', ** done ** '_modules/encode_json.py'
2017-10-27 22:12:02,312 [salt.fileclient  ][INFO    ][24097] Fetching file from saltenv 'base', ** done ** '_modules/gerrit.py'
2017-10-27 22:12:02,327 [salt.fileclient  ][INFO    ][24097] Fetching file from saltenv 'base', ** done ** '_modules/glanceng.py'
2017-10-27 22:12:02,361 [salt.fileclient  ][INFO    ][24097] Fetching file from saltenv 'base', ** done ** '_modules/heat.py'
2017-10-27 22:12:02,371 [salt.fileclient  ][INFO    ][24097] Fetching file from saltenv 'base', ** done ** '_modules/heka_alarming.py'
2017-10-27 22:12:02,399 [salt.fileclient  ][INFO    ][24097] Fetching file from saltenv 'base', ** done ** '_modules/helm.py'
2017-10-27 22:12:02,413 [salt.fileclient  ][INFO    ][24097] Fetching file from saltenv 'base', ** done ** '_modules/jenkins_common.py'
2017-10-27 22:12:02,431 [salt.fileclient  ][INFO    ][24097] Fetching file from saltenv 'base', ** done ** '_modules/keystone_policy.py'
2017-10-27 22:12:02,470 [salt.fileclient  ][INFO    ][24097] Fetching file from saltenv 'base', ** done ** '_modules/linux_hosts.py'
2017-10-27 22:12:02,483 [salt.fileclient  ][INFO    ][24097] Fetching file from saltenv 'base', ** done ** '_modules/linux_netlink.py'
2017-10-27 22:12:02,499 [salt.fileclient  ][INFO    ][24097] Fetching file from saltenv 'base', ** done ** '_modules/maas.py'
2017-10-27 22:12:02,541 [salt.fileclient  ][INFO    ][24097] Fetching file from saltenv 'base', ** done ** '_modules/maas_client.py'
2017-10-27 22:12:02,582 [salt.fileclient  ][INFO    ][24097] Fetching file from saltenv 'base', ** done ** '_modules/multipart.py'
2017-10-27 22:12:02,617 [salt.fileclient  ][INFO    ][24097] Fetching file from saltenv 'base', ** done ** '_modules/nagios_alarming.py'
2017-10-27 22:12:02,644 [salt.fileclient  ][INFO    ][24097] Fetching file from saltenv 'base', ** done ** '_modules/neutronng.py'
2017-10-27 22:12:02,658 [salt.fileclient  ][INFO    ][24097] Fetching file from saltenv 'base', ** done ** '_modules/novang.py'
2017-10-27 22:12:02,670 [salt.fileclient  ][INFO    ][24097] Fetching file from saltenv 'base', ** done ** '_modules/reclass.py'
2017-10-27 22:12:02,728 [salt.fileclient  ][INFO    ][24097] Fetching file from saltenv 'base', ** done ** '_modules/rsyslog_util.py'
2017-10-27 22:12:02,750 [salt.fileclient  ][INFO    ][24097] Fetching file from saltenv 'base', ** done ** '_modules/rundeck.py'
2017-10-27 22:12:02,777 [salt.fileclient  ][INFO    ][24097] Fetching file from saltenv 'base', ** done ** '_modules/saltkey.py'
2017-10-27 22:12:02,839 [salt.fileclient  ][INFO    ][24097] Fetching file from saltenv 'base', ** done ** '_modules/saltresource.py'
2017-10-27 22:12:02,854 [salt.fileclient  ][INFO    ][24097] Fetching file from saltenv 'base', ** done ** '_modules/seedng.py'
2017-10-27 22:12:02,923 [salt.fileclient  ][INFO    ][24097] Fetching file from saltenv 'base', ** done ** '_modules/testing/credentials.py'
2017-10-27 22:12:02,938 [salt.fileclient  ][INFO    ][24097] Fetching file from saltenv 'base', ** done ** '_modules/testing/django.py'
2017-10-27 22:12:02,947 [salt.fileclient  ][INFO    ][24097] Fetching file from saltenv 'base', ** done ** '_modules/testing/django_client_proxy.py'
2017-10-27 22:12:02,954 [salt.fileclient  ][INFO    ][24097] Fetching file from saltenv 'base', ** done ** '_modules/utils.py'
2017-10-27 22:12:02,967 [salt.fileclient  ][INFO    ][24097] Fetching file from saltenv 'base', ** done ** '_modules/virtng.py'
2017-10-27 22:12:02,970 [salt.utils.extmods][INFO    ][24097] Copying '/var/cache/salt/minion/files/base/_modules/__init__.py' to '/var/cache/salt/minion/extmods/modules/__init__.py'
2017-10-27 22:12:02,970 [salt.utils.extmods][INFO    ][24097] Copying '/var/cache/salt/minion/files/base/_modules/ceph_ng.py' to '/var/cache/salt/minion/extmods/modules/ceph_ng.py'
2017-10-27 22:12:02,971 [salt.utils.extmods][INFO    ][24097] Copying '/var/cache/salt/minion/files/base/_modules/cinderng.py' to '/var/cache/salt/minion/extmods/modules/cinderng.py'
2017-10-27 22:12:02,971 [salt.utils.extmods][INFO    ][24097] Copying '/var/cache/salt/minion/files/base/_modules/contrail.py' to '/var/cache/salt/minion/extmods/modules/contrail.py'
2017-10-27 22:12:02,971 [salt.utils.extmods][INFO    ][24097] Copying '/var/cache/salt/minion/files/base/_modules/creds.py' to '/var/cache/salt/minion/extmods/modules/creds.py'
2017-10-27 22:12:02,972 [salt.utils.extmods][INFO    ][24097] Copying '/var/cache/salt/minion/files/base/_modules/devops_utils.py' to '/var/cache/salt/minion/extmods/modules/devops_utils.py'
2017-10-27 22:12:02,972 [salt.utils.extmods][INFO    ][24097] Copying '/var/cache/salt/minion/files/base/_modules/encode_json.py' to '/var/cache/salt/minion/extmods/modules/encode_json.py'
2017-10-27 22:12:02,972 [salt.utils.extmods][INFO    ][24097] Copying '/var/cache/salt/minion/files/base/_modules/gerrit.py' to '/var/cache/salt/minion/extmods/modules/gerrit.py'
2017-10-27 22:12:02,973 [salt.utils.extmods][INFO    ][24097] Copying '/var/cache/salt/minion/files/base/_modules/glanceng.py' to '/var/cache/salt/minion/extmods/modules/glanceng.py'
2017-10-27 22:12:02,973 [salt.utils.extmods][INFO    ][24097] Copying '/var/cache/salt/minion/files/base/_modules/heat.py' to '/var/cache/salt/minion/extmods/modules/heat.py'
2017-10-27 22:12:02,973 [salt.utils.extmods][INFO    ][24097] Copying '/var/cache/salt/minion/files/base/_modules/heka_alarming.py' to '/var/cache/salt/minion/extmods/modules/heka_alarming.py'
2017-10-27 22:12:02,973 [salt.utils.extmods][INFO    ][24097] Copying '/var/cache/salt/minion/files/base/_modules/helm.py' to '/var/cache/salt/minion/extmods/modules/helm.py'
2017-10-27 22:12:02,974 [salt.utils.extmods][INFO    ][24097] Copying '/var/cache/salt/minion/files/base/_modules/jenkins_common.py' to '/var/cache/salt/minion/extmods/modules/jenkins_common.py'
2017-10-27 22:12:02,974 [salt.utils.extmods][INFO    ][24097] Copying '/var/cache/salt/minion/files/base/_modules/keystone_policy.py' to '/var/cache/salt/minion/extmods/modules/keystone_policy.py'
2017-10-27 22:12:02,974 [salt.utils.extmods][INFO    ][24097] Copying '/var/cache/salt/minion/files/base/_modules/linux_hosts.py' to '/var/cache/salt/minion/extmods/modules/linux_hosts.py'
2017-10-27 22:12:02,975 [salt.utils.extmods][INFO    ][24097] Copying '/var/cache/salt/minion/files/base/_modules/linux_netlink.py' to '/var/cache/salt/minion/extmods/modules/linux_netlink.py'
2017-10-27 22:12:02,975 [salt.utils.extmods][INFO    ][24097] Copying '/var/cache/salt/minion/files/base/_modules/maas.py' to '/var/cache/salt/minion/extmods/modules/maas.py'
2017-10-27 22:12:02,975 [salt.utils.extmods][INFO    ][24097] Copying '/var/cache/salt/minion/files/base/_modules/maas_client.py' to '/var/cache/salt/minion/extmods/modules/maas_client.py'
2017-10-27 22:12:02,975 [salt.utils.extmods][INFO    ][24097] Copying '/var/cache/salt/minion/files/base/_modules/multipart.py' to '/var/cache/salt/minion/extmods/modules/multipart.py'
2017-10-27 22:12:02,976 [salt.utils.extmods][INFO    ][24097] Copying '/var/cache/salt/minion/files/base/_modules/nagios_alarming.py' to '/var/cache/salt/minion/extmods/modules/nagios_alarming.py'
2017-10-27 22:12:02,976 [salt.utils.extmods][INFO    ][24097] Copying '/var/cache/salt/minion/files/base/_modules/neutronng.py' to '/var/cache/salt/minion/extmods/modules/neutronng.py'
2017-10-27 22:12:02,976 [salt.utils.extmods][INFO    ][24097] Copying '/var/cache/salt/minion/files/base/_modules/novang.py' to '/var/cache/salt/minion/extmods/modules/novang.py'
2017-10-27 22:12:02,977 [salt.utils.extmods][INFO    ][24097] Copying '/var/cache/salt/minion/files/base/_modules/reclass.py' to '/var/cache/salt/minion/extmods/modules/reclass.py'
2017-10-27 22:12:02,977 [salt.utils.extmods][INFO    ][24097] Copying '/var/cache/salt/minion/files/base/_modules/rsyslog_util.py' to '/var/cache/salt/minion/extmods/modules/rsyslog_util.py'
2017-10-27 22:12:02,977 [salt.utils.extmods][INFO    ][24097] Copying '/var/cache/salt/minion/files/base/_modules/rundeck.py' to '/var/cache/salt/minion/extmods/modules/rundeck.py'
2017-10-27 22:12:02,978 [salt.utils.extmods][INFO    ][24097] Copying '/var/cache/salt/minion/files/base/_modules/saltkey.py' to '/var/cache/salt/minion/extmods/modules/saltkey.py'
2017-10-27 22:12:02,978 [salt.utils.extmods][INFO    ][24097] Copying '/var/cache/salt/minion/files/base/_modules/saltresource.py' to '/var/cache/salt/minion/extmods/modules/saltresource.py'
2017-10-27 22:12:02,978 [salt.utils.extmods][INFO    ][24097] Copying '/var/cache/salt/minion/files/base/_modules/seedng.py' to '/var/cache/salt/minion/extmods/modules/seedng.py'
2017-10-27 22:12:02,978 [salt.utils.extmods][INFO    ][24097] Copying '/var/cache/salt/minion/files/base/_modules/testing/__init__.py' to '/var/cache/salt/minion/extmods/modules/testing/__init__.py'
2017-10-27 22:12:02,979 [salt.utils.extmods][INFO    ][24097] Copying '/var/cache/salt/minion/files/base/_modules/testing/credentials.py' to '/var/cache/salt/minion/extmods/modules/testing/credentials.py'
2017-10-27 22:12:02,979 [salt.utils.extmods][INFO    ][24097] Copying '/var/cache/salt/minion/files/base/_modules/testing/django.py' to '/var/cache/salt/minion/extmods/modules/testing/django.py'
2017-10-27 22:12:02,979 [salt.utils.extmods][INFO    ][24097] Copying '/var/cache/salt/minion/files/base/_modules/testing/django_client_proxy.py' to '/var/cache/salt/minion/extmods/modules/testing/django_client_proxy.py'
2017-10-27 22:12:02,980 [salt.utils.extmods][INFO    ][24097] Copying '/var/cache/salt/minion/files/base/_modules/utils.py' to '/var/cache/salt/minion/extmods/modules/utils.py'
2017-10-27 22:12:02,980 [salt.utils.extmods][INFO    ][24097] Copying '/var/cache/salt/minion/files/base/_modules/virtng.py' to '/var/cache/salt/minion/extmods/modules/virtng.py'
2017-10-27 22:12:02,984 [salt.utils.extmods][INFO    ][24097] Syncing states for environment 'base'
2017-10-27 22:12:02,985 [salt.utils.extmods][INFO    ][24097] Loading cache from salt://_states, for base)
2017-10-27 22:12:02,985 [salt.fileclient  ][INFO    ][24097] Caching directory '_states/' for environment 'base'
2017-10-27 22:12:03,043 [salt.fileclient  ][INFO    ][24097] Fetching file from saltenv 'base', ** done ** '_states/cinderng.py'
2017-10-27 22:12:03,081 [salt.fileclient  ][INFO    ][24097] Fetching file from saltenv 'base', ** done ** '_states/contrail.py'
2017-10-27 22:12:03,121 [salt.fileclient  ][INFO    ][24097] Fetching file from saltenv 'base', ** done ** '_states/gerrit.py'
2017-10-27 22:12:03,129 [salt.fileclient  ][INFO    ][24097] Fetching file from saltenv 'base', ** done ** '_states/glanceng.py'
2017-10-27 22:12:03,141 [salt.fileclient  ][INFO    ][24097] Fetching file from saltenv 'base', ** done ** '_states/grafana3_dashboard.py'
2017-10-27 22:12:03,169 [salt.fileclient  ][INFO    ][24097] Fetching file from saltenv 'base', ** done ** '_states/grafana3_datasource.py'
2017-10-27 22:12:03,200 [salt.fileclient  ][INFO    ][24097] Fetching file from saltenv 'base', ** done ** '_states/heat.py'
2017-10-27 22:12:03,212 [salt.fileclient  ][INFO    ][24097] Fetching file from saltenv 'base', ** done ** '_states/helm_release.py'
2017-10-27 22:12:03,227 [salt.fileclient  ][INFO    ][24097] Fetching file from saltenv 'base', ** done ** '_states/jenkins_approval.py'
2017-10-27 22:12:03,269 [salt.fileclient  ][INFO    ][24097] Fetching file from saltenv 'base', ** done ** '_states/jenkins_artifactory.py'
2017-10-27 22:12:03,286 [salt.fileclient  ][INFO    ][24097] Fetching file from saltenv 'base', ** done ** '_states/jenkins_credential.py'
2017-10-27 22:12:03,300 [salt.fileclient  ][INFO    ][24097] Fetching file from saltenv 'base', ** done ** '_states/jenkins_job.py'
2017-10-27 22:12:03,334 [salt.fileclient  ][INFO    ][24097] Fetching file from saltenv 'base', ** done ** '_states/jenkins_lib.py'
2017-10-27 22:12:03,352 [salt.fileclient  ][INFO    ][24097] Fetching file from saltenv 'base', ** done ** '_states/jenkins_node.py'
2017-10-27 22:12:03,380 [salt.fileclient  ][INFO    ][24097] Fetching file from saltenv 'base', ** done ** '_states/jenkins_plugin.py'
2017-10-27 22:12:03,392 [salt.fileclient  ][INFO    ][24097] Fetching file from saltenv 'base', ** done ** '_states/jenkins_security.py'
2017-10-27 22:12:03,405 [salt.fileclient  ][INFO    ][24097] Fetching file from saltenv 'base', ** done ** '_states/jenkins_slack.py'
2017-10-27 22:12:03,466 [salt.fileclient  ][INFO    ][24097] Fetching file from saltenv 'base', ** done ** '_states/jenkins_smtp.py'
2017-10-27 22:12:03,478 [salt.fileclient  ][INFO    ][24097] Fetching file from saltenv 'base', ** done ** '_states/jenkins_theme.py'
2017-10-27 22:12:03,506 [salt.fileclient  ][INFO    ][24097] Fetching file from saltenv 'base', ** done ** '_states/jenkins_user.py'
2017-10-27 22:12:03,602 [salt.fileclient  ][INFO    ][24097] Fetching file from saltenv 'base', ** done ** '_states/jenkins_view.py'
2017-10-27 22:12:03,685 [salt.fileclient  ][INFO    ][24097] Fetching file from saltenv 'base', ** done ** '_states/keystone_policy.py'
2017-10-27 22:12:03,710 [salt.fileclient  ][INFO    ][24097] Fetching file from saltenv 'base', ** done ** '_states/kibana_object.py'
2017-10-27 22:12:03,785 [salt.fileclient  ][INFO    ][24097] Fetching file from saltenv 'base', ** done ** '_states/neutronng.py'
2017-10-27 22:12:03,804 [salt.fileclient  ][INFO    ][24097] Fetching file from saltenv 'base', ** done ** '_states/novang.py'
2017-10-27 22:12:03,814 [salt.fileclient  ][INFO    ][24097] Fetching file from saltenv 'base', ** done ** '_states/reclass.py'
2017-10-27 22:12:03,829 [salt.fileclient  ][INFO    ][24097] Fetching file from saltenv 'base', ** done ** '_states/rundeck_project.py'
2017-10-27 22:12:03,844 [salt.fileclient  ][INFO    ][24097] Fetching file from saltenv 'base', ** done ** '_states/rundeck_scm.py'
2017-10-27 22:12:03,855 [salt.fileclient  ][INFO    ][24097] Fetching file from saltenv 'base', ** done ** '_states/rundeck_secret.py'
2017-10-27 22:12:03,858 [salt.utils.extmods][INFO    ][24097] Copying '/var/cache/salt/minion/files/base/_states/cinderng.py' to '/var/cache/salt/minion/extmods/states/cinderng.py'
2017-10-27 22:12:03,858 [salt.utils.extmods][INFO    ][24097] Copying '/var/cache/salt/minion/files/base/_states/contrail.py' to '/var/cache/salt/minion/extmods/states/contrail.py'
2017-10-27 22:12:03,858 [salt.utils.extmods][INFO    ][24097] Copying '/var/cache/salt/minion/files/base/_states/gerrit.py' to '/var/cache/salt/minion/extmods/states/gerrit.py'
2017-10-27 22:12:03,859 [salt.utils.extmods][INFO    ][24097] Copying '/var/cache/salt/minion/files/base/_states/glanceng.py' to '/var/cache/salt/minion/extmods/states/glanceng.py'
2017-10-27 22:12:03,859 [salt.utils.extmods][INFO    ][24097] Copying '/var/cache/salt/minion/files/base/_states/grafana3_dashboard.py' to '/var/cache/salt/minion/extmods/states/grafana3_dashboard.py'
2017-10-27 22:12:03,859 [salt.utils.extmods][INFO    ][24097] Copying '/var/cache/salt/minion/files/base/_states/grafana3_datasource.py' to '/var/cache/salt/minion/extmods/states/grafana3_datasource.py'
2017-10-27 22:12:03,860 [salt.utils.extmods][INFO    ][24097] Copying '/var/cache/salt/minion/files/base/_states/heat.py' to '/var/cache/salt/minion/extmods/states/heat.py'
2017-10-27 22:12:03,860 [salt.utils.extmods][INFO    ][24097] Copying '/var/cache/salt/minion/files/base/_states/helm_release.py' to '/var/cache/salt/minion/extmods/states/helm_release.py'
2017-10-27 22:12:03,860 [salt.utils.extmods][INFO    ][24097] Copying '/var/cache/salt/minion/files/base/_states/jenkins_approval.py' to '/var/cache/salt/minion/extmods/states/jenkins_approval.py'
2017-10-27 22:12:03,860 [salt.utils.extmods][INFO    ][24097] Copying '/var/cache/salt/minion/files/base/_states/jenkins_artifactory.py' to '/var/cache/salt/minion/extmods/states/jenkins_artifactory.py'
2017-10-27 22:12:03,861 [salt.utils.extmods][INFO    ][24097] Copying '/var/cache/salt/minion/files/base/_states/jenkins_credential.py' to '/var/cache/salt/minion/extmods/states/jenkins_credential.py'
2017-10-27 22:12:03,861 [salt.utils.extmods][INFO    ][24097] Copying '/var/cache/salt/minion/files/base/_states/jenkins_job.py' to '/var/cache/salt/minion/extmods/states/jenkins_job.py'
2017-10-27 22:12:03,861 [salt.utils.extmods][INFO    ][24097] Copying '/var/cache/salt/minion/files/base/_states/jenkins_lib.py' to '/var/cache/salt/minion/extmods/states/jenkins_lib.py'
2017-10-27 22:12:03,861 [salt.utils.extmods][INFO    ][24097] Copying '/var/cache/salt/minion/files/base/_states/jenkins_node.py' to '/var/cache/salt/minion/extmods/states/jenkins_node.py'
2017-10-27 22:12:03,861 [salt.utils.extmods][INFO    ][24097] Copying '/var/cache/salt/minion/files/base/_states/jenkins_plugin.py' to '/var/cache/salt/minion/extmods/states/jenkins_plugin.py'
2017-10-27 22:12:03,862 [salt.utils.extmods][INFO    ][24097] Copying '/var/cache/salt/minion/files/base/_states/jenkins_security.py' to '/var/cache/salt/minion/extmods/states/jenkins_security.py'
2017-10-27 22:12:03,862 [salt.utils.extmods][INFO    ][24097] Copying '/var/cache/salt/minion/files/base/_states/jenkins_slack.py' to '/var/cache/salt/minion/extmods/states/jenkins_slack.py'
2017-10-27 22:12:03,862 [salt.utils.extmods][INFO    ][24097] Copying '/var/cache/salt/minion/files/base/_states/jenkins_smtp.py' to '/var/cache/salt/minion/extmods/states/jenkins_smtp.py'
2017-10-27 22:12:03,862 [salt.utils.extmods][INFO    ][24097] Copying '/var/cache/salt/minion/files/base/_states/jenkins_theme.py' to '/var/cache/salt/minion/extmods/states/jenkins_theme.py'
2017-10-27 22:12:03,863 [salt.utils.extmods][INFO    ][24097] Copying '/var/cache/salt/minion/files/base/_states/jenkins_user.py' to '/var/cache/salt/minion/extmods/states/jenkins_user.py'
2017-10-27 22:12:03,863 [salt.utils.extmods][INFO    ][24097] Copying '/var/cache/salt/minion/files/base/_states/jenkins_view.py' to '/var/cache/salt/minion/extmods/states/jenkins_view.py'
2017-10-27 22:12:03,863 [salt.utils.extmods][INFO    ][24097] Copying '/var/cache/salt/minion/files/base/_states/keystone_policy.py' to '/var/cache/salt/minion/extmods/states/keystone_policy.py'
2017-10-27 22:12:03,863 [salt.utils.extmods][INFO    ][24097] Copying '/var/cache/salt/minion/files/base/_states/kibana_object.py' to '/var/cache/salt/minion/extmods/states/kibana_object.py'
2017-10-27 22:12:03,864 [salt.utils.extmods][INFO    ][24097] Copying '/var/cache/salt/minion/files/base/_states/maas_cluster.py' to '/var/cache/salt/minion/extmods/states/maas_cluster.py'
2017-10-27 22:12:03,864 [salt.utils.extmods][INFO    ][24097] Copying '/var/cache/salt/minion/files/base/_states/neutronng.py' to '/var/cache/salt/minion/extmods/states/neutronng.py'
2017-10-27 22:12:03,864 [salt.utils.extmods][INFO    ][24097] Copying '/var/cache/salt/minion/files/base/_states/novang.py' to '/var/cache/salt/minion/extmods/states/novang.py'
2017-10-27 22:12:03,864 [salt.utils.extmods][INFO    ][24097] Copying '/var/cache/salt/minion/files/base/_states/reclass.py' to '/var/cache/salt/minion/extmods/states/reclass.py'
2017-10-27 22:12:03,865 [salt.utils.extmods][INFO    ][24097] Copying '/var/cache/salt/minion/files/base/_states/rundeck_project.py' to '/var/cache/salt/minion/extmods/states/rundeck_project.py'
2017-10-27 22:12:03,865 [salt.utils.extmods][INFO    ][24097] Copying '/var/cache/salt/minion/files/base/_states/rundeck_scm.py' to '/var/cache/salt/minion/extmods/states/rundeck_scm.py'
2017-10-27 22:12:03,865 [salt.utils.extmods][INFO    ][24097] Copying '/var/cache/salt/minion/files/base/_states/rundeck_secret.py' to '/var/cache/salt/minion/extmods/states/rundeck_secret.py'
2017-10-27 22:12:03,867 [salt.utils.extmods][INFO    ][24097] Creating module dir '/var/cache/salt/minion/extmods/sdb'
2017-10-27 22:12:03,869 [salt.utils.extmods][INFO    ][24097] Syncing sdb for environment 'base'
2017-10-27 22:12:03,870 [salt.utils.extmods][INFO    ][24097] Loading cache from salt://_sdb, for base)
2017-10-27 22:12:03,870 [salt.fileclient  ][INFO    ][24097] Caching directory '_sdb/' for environment 'base'
2017-10-27 22:12:03,904 [salt.utils.extmods][INFO    ][24097] Syncing grains for environment 'base'
2017-10-27 22:12:03,904 [salt.utils.extmods][INFO    ][24097] Loading cache from salt://_grains, for base)
2017-10-27 22:12:03,904 [salt.fileclient  ][INFO    ][24097] Caching directory '_grains/' for environment 'base'
2017-10-27 22:12:03,952 [salt.fileclient  ][INFO    ][24097] Fetching file from saltenv 'base', ** done ** '_grains/ceilometer_policy.py'
2017-10-27 22:12:03,965 [salt.fileclient  ][INFO    ][24097] Fetching file from saltenv 'base', ** done ** '_grains/ceph.py'
2017-10-27 22:12:03,981 [salt.fileclient  ][INFO    ][24097] Fetching file from saltenv 'base', ** done ** '_grains/cinder_policy.py'
2017-10-27 22:12:04,009 [salt.fileclient  ][INFO    ][24097] Fetching file from saltenv 'base', ** done ** '_grains/docker_swarm.py'
2017-10-27 22:12:04,353 [salt.fileclient  ][INFO    ][24097] Fetching file from saltenv 'base', ** done ** '_grains/glance_policy.py'
2017-10-27 22:12:04,368 [salt.fileclient  ][INFO    ][24097] Fetching file from saltenv 'base', ** done ** '_grains/heat_policy.py'
2017-10-27 22:12:04,417 [salt.fileclient  ][INFO    ][24097] Fetching file from saltenv 'base', ** done ** '_grains/jenkins_plugins.py'
2017-10-27 22:12:04,426 [salt.fileclient  ][INFO    ][24097] Fetching file from saltenv 'base', ** done ** '_grains/keystone_policy.py'
2017-10-27 22:12:04,452 [salt.fileclient  ][INFO    ][24097] Fetching file from saltenv 'base', ** done ** '_grains/kubernetes.py'
2017-10-27 22:12:04,460 [salt.fileclient  ][INFO    ][24097] Fetching file from saltenv 'base', ** done ** '_grains/neutron_policy.py'
2017-10-27 22:12:04,469 [salt.fileclient  ][INFO    ][24097] Fetching file from saltenv 'base', ** done ** '_grains/nova_policy.py'
2017-10-27 22:12:04,476 [salt.fileclient  ][INFO    ][24097] Fetching file from saltenv 'base', ** done ** '_grains/ssh_fingerprints.py'
2017-10-27 22:12:04,479 [salt.utils.extmods][INFO    ][24097] Copying '/var/cache/salt/minion/files/base/_grains/ceilometer_policy.py' to '/var/cache/salt/minion/extmods/grains/ceilometer_policy.py'
2017-10-27 22:12:04,479 [salt.utils.extmods][INFO    ][24097] Copying '/var/cache/salt/minion/files/base/_grains/ceph.py' to '/var/cache/salt/minion/extmods/grains/ceph.py'
2017-10-27 22:12:04,479 [salt.utils.extmods][INFO    ][24097] Copying '/var/cache/salt/minion/files/base/_grains/cinder_policy.py' to '/var/cache/salt/minion/extmods/grains/cinder_policy.py'
2017-10-27 22:12:04,480 [salt.utils.extmods][INFO    ][24097] Copying '/var/cache/salt/minion/files/base/_grains/docker_swarm.py' to '/var/cache/salt/minion/extmods/grains/docker_swarm.py'
2017-10-27 22:12:04,480 [salt.utils.extmods][INFO    ][24097] Copying '/var/cache/salt/minion/files/base/_grains/glance_policy.py' to '/var/cache/salt/minion/extmods/grains/glance_policy.py'
2017-10-27 22:12:04,480 [salt.utils.extmods][INFO    ][24097] Copying '/var/cache/salt/minion/files/base/_grains/heat_policy.py' to '/var/cache/salt/minion/extmods/grains/heat_policy.py'
2017-10-27 22:12:04,480 [salt.utils.extmods][INFO    ][24097] Copying '/var/cache/salt/minion/files/base/_grains/jenkins_plugins.py' to '/var/cache/salt/minion/extmods/grains/jenkins_plugins.py'
2017-10-27 22:12:04,480 [salt.utils.extmods][INFO    ][24097] Copying '/var/cache/salt/minion/files/base/_grains/keystone_policy.py' to '/var/cache/salt/minion/extmods/grains/keystone_policy.py'
2017-10-27 22:12:04,481 [salt.utils.extmods][INFO    ][24097] Copying '/var/cache/salt/minion/files/base/_grains/kubernetes.py' to '/var/cache/salt/minion/extmods/grains/kubernetes.py'
2017-10-27 22:12:04,481 [salt.utils.extmods][INFO    ][24097] Copying '/var/cache/salt/minion/files/base/_grains/neutron_policy.py' to '/var/cache/salt/minion/extmods/grains/neutron_policy.py'
2017-10-27 22:12:04,481 [salt.utils.extmods][INFO    ][24097] Copying '/var/cache/salt/minion/files/base/_grains/nova_policy.py' to '/var/cache/salt/minion/extmods/grains/nova_policy.py'
2017-10-27 22:12:04,481 [salt.utils.extmods][INFO    ][24097] Copying '/var/cache/salt/minion/files/base/_grains/ssh_fingerprints.py' to '/var/cache/salt/minion/extmods/grains/ssh_fingerprints.py'
2017-10-27 22:12:04,482 [salt.utils.extmods][INFO    ][24097] Creating module dir '/var/cache/salt/minion/extmods/renderers'
2017-10-27 22:12:04,485 [salt.utils.extmods][INFO    ][24097] Syncing renderers for environment 'base'
2017-10-27 22:12:04,485 [salt.utils.extmods][INFO    ][24097] Loading cache from salt://_renderers, for base)
2017-10-27 22:12:04,485 [salt.fileclient  ][INFO    ][24097] Caching directory '_renderers/' for environment 'base'
2017-10-27 22:12:04,506 [salt.utils.extmods][INFO    ][24097] Creating module dir '/var/cache/salt/minion/extmods/returners'
2017-10-27 22:12:04,509 [salt.utils.extmods][INFO    ][24097] Syncing returners for environment 'base'
2017-10-27 22:12:04,509 [salt.utils.extmods][INFO    ][24097] Loading cache from salt://_returners, for base)
2017-10-27 22:12:04,509 [salt.fileclient  ][INFO    ][24097] Caching directory '_returners/' for environment 'base'
2017-10-27 22:12:04,538 [salt.utils.extmods][INFO    ][24097] Creating module dir '/var/cache/salt/minion/extmods/output'
2017-10-27 22:12:04,540 [salt.utils.extmods][INFO    ][24097] Syncing output for environment 'base'
2017-10-27 22:12:04,541 [salt.utils.extmods][INFO    ][24097] Loading cache from salt://_output, for base)
2017-10-27 22:12:04,541 [salt.fileclient  ][INFO    ][24097] Caching directory '_output/' for environment 'base'
2017-10-27 22:12:04,571 [salt.utils.extmods][INFO    ][24097] Creating module dir '/var/cache/salt/minion/extmods/utils'
2017-10-27 22:12:04,574 [salt.utils.extmods][INFO    ][24097] Syncing utils for environment 'base'
2017-10-27 22:12:04,574 [salt.utils.extmods][INFO    ][24097] Loading cache from salt://_utils, for base)
2017-10-27 22:12:04,574 [salt.fileclient  ][INFO    ][24097] Caching directory '_utils/' for environment 'base'
2017-10-27 22:12:04,596 [salt.utils.extmods][INFO    ][24097] Creating module dir '/var/cache/salt/minion/extmods/log_handlers'
2017-10-27 22:12:04,598 [salt.utils.extmods][INFO    ][24097] Syncing log_handlers for environment 'base'
2017-10-27 22:12:04,598 [salt.utils.extmods][INFO    ][24097] Loading cache from salt://_log_handlers, for base)
2017-10-27 22:12:04,598 [salt.fileclient  ][INFO    ][24097] Caching directory '_log_handlers/' for environment 'base'
2017-10-27 22:12:04,615 [salt.utils.extmods][INFO    ][24097] Creating module dir '/var/cache/salt/minion/extmods/proxy'
2017-10-27 22:12:04,617 [salt.utils.extmods][INFO    ][24097] Syncing proxy for environment 'base'
2017-10-27 22:12:04,617 [salt.utils.extmods][INFO    ][24097] Loading cache from salt://_proxy, for base)
2017-10-27 22:12:04,618 [salt.fileclient  ][INFO    ][24097] Caching directory '_proxy/' for environment 'base'
2017-10-27 22:12:04,635 [salt.utils.extmods][INFO    ][24097] Creating module dir '/var/cache/salt/minion/extmods/engines'
2017-10-27 22:12:04,637 [salt.utils.extmods][INFO    ][24097] Syncing engines for environment 'base'
2017-10-27 22:12:04,637 [salt.utils.extmods][INFO    ][24097] Loading cache from salt://_engines, for base)
2017-10-27 22:12:04,637 [salt.fileclient  ][INFO    ][24097] Caching directory '_engines/' for environment 'base'
2017-10-27 22:12:04,696 [salt.minion      ][INFO    ][24097] Returning information for job: 20171027221158485288
2017-10-27 22:41:42,051 [salt.minion      ][INFO    ][23612] User sudo_ubuntu Executing command test.ping with jid 20171027224142042223
2017-10-27 22:41:42,073 [salt.minion      ][INFO    ][24760] Starting a new job with PID 24760
2017-10-27 22:41:42,102 [salt.minion      ][INFO    ][24760] Returning information for job: 20171027224142042223
2017-10-27 22:42:24,200 [salt.minion      ][INFO    ][23612] User sudo_ubuntu Executing command state.sls with jid 20171027224224187588
2017-10-27 22:42:24,214 [salt.minion      ][INFO    ][24783] Starting a new job with PID 24783
2017-10-27 22:42:24,638 [salt.state       ][INFO    ][24783] Loading fresh modules for state activity
2017-10-27 22:42:24,663 [salt.fileclient  ][INFO    ][24783] Fetching file from saltenv 'base', ** done ** 'keepalived/init.sls'
2017-10-27 22:42:24,680 [salt.fileclient  ][INFO    ][24783] Fetching file from saltenv 'base', ** done ** 'keepalived/cluster.sls'
2017-10-27 22:42:24,702 [salt.fileclient  ][INFO    ][24783] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-10-27 22:42:24,995 [salt.state       ][INFO    ][24783] Running state [lsof] at time 22:42:24.994574
2017-10-27 22:42:24,995 [salt.state       ][INFO    ][24783] Executing state pkg.installed for lsof
2017-10-27 22:42:24,995 [salt.loaded.int.module.cmdmod][INFO    ][24783] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-10-27 22:42:25,272 [salt.state       ][INFO    ][24783] Package lsof is already installed
2017-10-27 22:42:25,273 [salt.state       ][INFO    ][24783] Completed state [lsof] at time 22:42:25.272579 duration_in_ms=278.005
2017-10-27 22:42:25,273 [salt.state       ][INFO    ][24783] Running state [keepalived] at time 22:42:25.272769
2017-10-27 22:42:25,273 [salt.state       ][INFO    ][24783] Executing state pkg.installed for keepalived
2017-10-27 22:42:25,288 [salt.loaded.int.module.cmdmod][INFO    ][24783] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-10-27 22:42:27,187 [salt.loaded.int.module.cmdmod][INFO    ][24783] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'keepalived'] in directory '/root'
2017-10-27 22:42:34,244 [salt.minion      ][INFO    ][23612] User sudo_ubuntu Executing command saltutil.find_job with jid 20171027224234231467
2017-10-27 22:42:34,258 [salt.minion      ][INFO    ][26252] Starting a new job with PID 26252
2017-10-27 22:42:34,278 [salt.minion      ][INFO    ][26252] Returning information for job: 20171027224234231467
2017-10-27 22:42:34,993 [salt.loaded.int.module.cmdmod][INFO    ][24783] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-10-27 22:42:35,017 [salt.state       ][INFO    ][24783] Made the following changes:
'libsnmp30' changed from 'absent' to '5.7.3+dfsg-1ubuntu4'
'libsnmp-base' changed from 'absent' to '5.7.3+dfsg-1ubuntu4'
'keepalived' changed from 'absent' to '1:1.2.19-1ubuntu0.2'
'ipvsadm' changed from 'absent' to '1:1.28-3'
'libsensors4' changed from 'absent' to '1:3.4.0-2'

2017-10-27 22:42:35,025 [salt.state       ][INFO    ][24783] Loading fresh modules for state activity
2017-10-27 22:42:35,037 [salt.state       ][INFO    ][24783] Completed state [keepalived] at time 22:42:35.036758 duration_in_ms=9763.989
2017-10-27 22:42:35,040 [salt.state       ][INFO    ][24783] Running state [/etc/keepalived/keepalived.conf] at time 22:42:35.039509
2017-10-27 22:42:35,040 [salt.state       ][INFO    ][24783] Executing state file.managed for /etc/keepalived/keepalived.conf
2017-10-27 22:42:35,067 [salt.fileclient  ][INFO    ][24783] Fetching file from saltenv 'base', ** done ** 'keepalived/files/keepalived.conf'
2017-10-27 22:42:35,101 [salt.fileclient  ][INFO    ][24783] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-10-27 22:42:35,107 [salt.state       ][INFO    ][24783] File changed:
New file
2017-10-27 22:42:35,107 [salt.state       ][INFO    ][24783] Completed state [/etc/keepalived/keepalived.conf] at time 22:42:35.107010 duration_in_ms=67.501
2017-10-27 22:42:35,165 [salt.state       ][INFO    ][24783] Running state [keepalived] at time 22:42:35.164614
2017-10-27 22:42:35,165 [salt.state       ][INFO    ][24783] Executing state service.running for keepalived
2017-10-27 22:42:35,166 [salt.loaded.int.module.cmdmod][INFO    ][24783] Executing command ['systemctl', 'status', 'keepalived.service', '-n', '0'] in directory '/root'
2017-10-27 22:42:35,177 [salt.loaded.int.module.cmdmod][INFO    ][24783] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2017-10-27 22:42:35,185 [salt.loaded.int.module.cmdmod][INFO    ][24783] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-10-27 22:42:35,192 [salt.loaded.int.module.cmdmod][INFO    ][24783] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-10-27 22:42:35,201 [salt.loaded.int.module.cmdmod][INFO    ][24783] Executing command ['systemd-run', '--scope', 'systemctl', 'start', 'keepalived.service'] in directory '/root'
2017-10-27 22:42:35,261 [salt.loaded.int.module.cmdmod][INFO    ][24783] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2017-10-27 22:42:35,270 [salt.loaded.int.module.cmdmod][INFO    ][24783] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-10-27 22:42:35,277 [salt.loaded.int.module.cmdmod][INFO    ][24783] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-10-27 22:42:35,284 [salt.state       ][INFO    ][24783] {'keepalived': True}
2017-10-27 22:42:35,285 [salt.state       ][INFO    ][24783] Completed state [keepalived] at time 22:42:35.284683 duration_in_ms=120.069
2017-10-27 22:42:35,285 [salt.minion      ][INFO    ][24783] Returning information for job: 20171027224224187588
2017-10-27 22:45:35,355 [salt.minion      ][INFO    ][23612] User sudo_ubuntu Executing command pillar.get with jid 20171027224535346310
2017-10-27 22:45:35,375 [salt.minion      ][INFO    ][26434] Starting a new job with PID 26434
2017-10-27 22:45:35,382 [salt.minion      ][INFO    ][26434] Returning information for job: 20171027224535346310
2017-10-27 22:51:50,171 [salt.minion      ][INFO    ][23612] User sudo_ubuntu Executing command state.sls with jid 20171027225150159896
2017-10-27 22:51:50,186 [salt.minion      ][INFO    ][26543] Starting a new job with PID 26543
2017-10-27 22:51:51,649 [salt.state       ][INFO    ][26543] Loading fresh modules for state activity
2017-10-27 22:51:51,672 [salt.fileclient  ][INFO    ][26543] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-10-27 22:51:51,691 [salt.fileclient  ][INFO    ][26543] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-10-27 22:51:51,954 [salt.state       ][INFO    ][26543] Running state [attr] at time 22:51:51.953630
2017-10-27 22:51:51,954 [salt.state       ][INFO    ][26543] Executing state pkg.installed for attr
2017-10-27 22:51:51,954 [salt.loaded.int.module.cmdmod][INFO    ][26543] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-10-27 22:51:52,218 [salt.loaded.int.module.cmdmod][INFO    ][26543] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-10-27 22:51:55,435 [salt.loaded.int.module.cmdmod][INFO    ][26543] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'attr'] in directory '/root'
2017-10-27 22:51:57,934 [salt.loaded.int.module.cmdmod][INFO    ][26543] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-10-27 22:51:57,957 [salt.state       ][INFO    ][26543] Made the following changes:
'attr' changed from 'absent' to '1:2.4.47-2'

2017-10-27 22:51:57,965 [salt.state       ][INFO    ][26543] Loading fresh modules for state activity
2017-10-27 22:51:57,977 [salt.state       ][INFO    ][26543] Completed state [attr] at time 22:51:57.976948 duration_in_ms=6023.319
2017-10-27 22:51:57,982 [salt.state       ][INFO    ][26543] Running state [glusterfs-server] at time 22:51:57.982293
2017-10-27 22:51:57,982 [salt.state       ][INFO    ][26543] Executing state pkg.installed for glusterfs-server
2017-10-27 22:51:58,164 [salt.loaded.int.module.cmdmod][INFO    ][26543] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'glusterfs-server'] in directory '/root'
2017-10-27 22:52:00,264 [salt.minion      ][INFO    ][23612] User sudo_ubuntu Executing command saltutil.find_job with jid 20171027225200251000
2017-10-27 22:52:00,280 [salt.minion      ][INFO    ][27592] Starting a new job with PID 27592
2017-10-27 22:52:00,293 [salt.minion      ][INFO    ][27592] Returning information for job: 20171027225200251000
2017-10-27 22:52:10,461 [salt.minion      ][INFO    ][23612] User sudo_ubuntu Executing command saltutil.find_job with jid 20171027225210449205
2017-10-27 22:52:10,476 [salt.minion      ][INFO    ][30397] Starting a new job with PID 30397
2017-10-27 22:52:10,492 [salt.minion      ][INFO    ][30397] Returning information for job: 20171027225210449205
2017-10-27 22:52:15,195 [salt.loaded.int.module.cmdmod][INFO    ][26543] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-10-27 22:52:15,221 [salt.state       ][INFO    ][26543] Made the following changes:
'keyutils' changed from 'absent' to '1.5.9-8ubuntu1'
'nfs-common' changed from 'absent' to '1:1.2.8-9ubuntu12.1'
'rpcbind' changed from 'absent' to '0.2.3-0.2'
'glusterfs-common' changed from 'absent' to '3.7.6-1ubuntu1'
'librdmacm1' changed from 'absent' to '1.0.21-1'
'libnfsidmap2' changed from 'absent' to '0.25-5'
'portmap' changed from 'absent' to '1'
'libattr1-dev' changed from 'absent' to '1:2.4.47-2'
'attr-dev' changed from 'absent' to '1'
'acl-dev' changed from 'absent' to '1'
'glusterfs-server' changed from 'absent' to '3.7.6-1ubuntu1'
'glusterfs-client' changed from 'absent' to '3.7.6-1ubuntu1'
'libpython2.7' changed from 'absent' to '2.7.12-1ubuntu0~16.04.1'
'nfs-client' changed from 'absent' to '1'
'liburcu4' changed from 'absent' to '0.9.1-3'
'libacl1-dev' changed from 'absent' to '2.2.52-3'
'libibverbs1' changed from 'absent' to '1.1.8-1.1ubuntu2'
'libtirpc1' changed from 'absent' to '0.2.5-1'

2017-10-27 22:52:15,228 [salt.state       ][INFO    ][26543] Loading fresh modules for state activity
2017-10-27 22:52:15,241 [salt.state       ][INFO    ][26543] Completed state [glusterfs-server] at time 22:52:15.240837 duration_in_ms=17258.543
2017-10-27 22:52:15,246 [salt.state       ][INFO    ][26543] Running state [bc] at time 22:52:15.245635
2017-10-27 22:52:15,246 [salt.state       ][INFO    ][26543] Executing state pkg.installed for bc
2017-10-27 22:52:15,516 [salt.loaded.int.module.cmdmod][INFO    ][26543] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'bc'] in directory '/root'
2017-10-27 22:52:18,399 [salt.loaded.int.module.cmdmod][INFO    ][26543] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-10-27 22:52:18,425 [salt.state       ][INFO    ][26543] Made the following changes:
'bc' changed from 'absent' to '1.06.95-9build1'

2017-10-27 22:52:18,434 [salt.state       ][INFO    ][26543] Loading fresh modules for state activity
2017-10-27 22:52:18,447 [salt.state       ][INFO    ][26543] Completed state [bc] at time 22:52:18.446826 duration_in_ms=3201.191
2017-10-27 22:52:18,512 [salt.state       ][INFO    ][26543] Running state [glusterfs-server] at time 22:52:18.511910
2017-10-27 22:52:18,512 [salt.state       ][INFO    ][26543] Executing state service.running for glusterfs-server
2017-10-27 22:52:18,514 [salt.loaded.int.module.cmdmod][INFO    ][26543] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-10-27 22:52:18,524 [salt.loaded.int.module.cmdmod][INFO    ][26543] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-10-27 22:52:18,534 [salt.loaded.int.module.cmdmod][INFO    ][26543] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-10-27 22:52:18,544 [salt.state       ][INFO    ][26543] The service glusterfs-server is already running
2017-10-27 22:52:18,544 [salt.state       ][INFO    ][26543] Completed state [glusterfs-server] at time 22:52:18.543887 duration_in_ms=31.977
2017-10-27 22:52:18,546 [salt.state       ][INFO    ][26543] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 22:52:18.545788
2017-10-27 22:52:18,546 [salt.state       ][INFO    ][26543] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-10-27 22:52:18,556 [salt.state       ][INFO    ][26543] File changed:
New file
2017-10-27 22:52:18,556 [salt.state       ][INFO    ][26543] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 22:52:18.556455 duration_in_ms=10.667
2017-10-27 22:52:18,557 [salt.state       ][INFO    ][26543] Running state [/srv/glusterfs/glance] at time 22:52:18.556613
2017-10-27 22:52:18,557 [salt.state       ][INFO    ][26543] Executing state file.directory for /srv/glusterfs/glance
2017-10-27 22:52:18,557 [salt.state       ][INFO    ][26543] {'/srv/glusterfs/glance': 'New Dir'}
2017-10-27 22:52:18,557 [salt.state       ][INFO    ][26543] Completed state [/srv/glusterfs/glance] at time 22:52:18.557428 duration_in_ms=0.815
2017-10-27 22:52:18,558 [salt.state       ][INFO    ][26543] Running state [/srv/glusterfs/keystone-keys] at time 22:52:18.557575
2017-10-27 22:52:18,558 [salt.state       ][INFO    ][26543] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-10-27 22:52:18,558 [salt.state       ][INFO    ][26543] {'/srv/glusterfs/keystone-keys': 'New Dir'}
2017-10-27 22:52:18,558 [salt.state       ][INFO    ][26543] Completed state [/srv/glusterfs/keystone-keys] at time 22:52:18.558186 duration_in_ms=0.611
2017-10-27 22:52:18,558 [salt.state       ][INFO    ][26543] Running state [/srv/glusterfs/nova_instances] at time 22:52:18.558324
2017-10-27 22:52:18,558 [salt.state       ][INFO    ][26543] Executing state file.directory for /srv/glusterfs/nova_instances
2017-10-27 22:52:18,559 [salt.state       ][INFO    ][26543] {'/srv/glusterfs/nova_instances': 'New Dir'}
2017-10-27 22:52:18,559 [salt.state       ][INFO    ][26543] Completed state [/srv/glusterfs/nova_instances] at time 22:52:18.558956 duration_in_ms=0.631
2017-10-27 22:52:18,559 [salt.state       ][INFO    ][26543] Running state [/srv/glusterfs/keystone-credential-keys] at time 22:52:18.559095
2017-10-27 22:52:18,559 [salt.state       ][INFO    ][26543] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-10-27 22:52:18,560 [salt.state       ][INFO    ][26543] {'/srv/glusterfs/keystone-credential-keys': 'New Dir'}
2017-10-27 22:52:18,560 [salt.state       ][INFO    ][26543] Completed state [/srv/glusterfs/keystone-credential-keys] at time 22:52:18.559705 duration_in_ms=0.61
2017-10-27 22:52:18,560 [salt.minion      ][INFO    ][26543] Returning information for job: 20171027225150159896
2017-10-27 22:52:19,900 [salt.minion      ][INFO    ][23612] User sudo_ubuntu Executing command test.ping with jid 20171027225219888051
2017-10-27 22:52:19,915 [salt.minion      ][INFO    ][31315] Starting a new job with PID 31315
2017-10-27 22:52:19,942 [salt.minion      ][INFO    ][31315] Returning information for job: 20171027225219888051
2017-10-27 22:53:05,824 [salt.minion      ][INFO    ][23612] User sudo_ubuntu Executing command state.sls with jid 20171027225305810121
2017-10-27 22:53:05,839 [salt.minion      ][INFO    ][31534] Starting a new job with PID 31534
2017-10-27 22:53:06,267 [salt.state       ][INFO    ][31534] Loading fresh modules for state activity
2017-10-27 22:53:06,289 [salt.fileclient  ][INFO    ][31534] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/setup.sls'
2017-10-27 22:53:06,321 [salt.fileclient  ][INFO    ][31534] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-10-27 22:53:06,386 [salt.fileclient  ][INFO    ][31534] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-10-27 22:53:06,405 [salt.fileclient  ][INFO    ][31534] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-10-27 22:53:06,657 [salt.state       ][INFO    ][31534] Running state [attr] at time 22:53:06.656807
2017-10-27 22:53:06,657 [salt.state       ][INFO    ][31534] Executing state pkg.installed for attr
2017-10-27 22:53:06,657 [salt.loaded.int.module.cmdmod][INFO    ][31534] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-10-27 22:53:06,939 [salt.state       ][INFO    ][31534] Package attr is already installed
2017-10-27 22:53:06,940 [salt.state       ][INFO    ][31534] Completed state [attr] at time 22:53:06.939656 duration_in_ms=282.848
2017-10-27 22:53:06,940 [salt.state       ][INFO    ][31534] Running state [glusterfs-server] at time 22:53:06.939855
2017-10-27 22:53:06,940 [salt.state       ][INFO    ][31534] Executing state pkg.installed for glusterfs-server
2017-10-27 22:53:06,943 [salt.state       ][INFO    ][31534] Package glusterfs-server is already installed
2017-10-27 22:53:06,943 [salt.state       ][INFO    ][31534] Completed state [glusterfs-server] at time 22:53:06.942718 duration_in_ms=2.864
2017-10-27 22:53:06,943 [salt.state       ][INFO    ][31534] Running state [bc] at time 22:53:06.942860
2017-10-27 22:53:06,943 [salt.state       ][INFO    ][31534] Executing state pkg.installed for bc
2017-10-27 22:53:06,946 [salt.state       ][INFO    ][31534] Package bc is already installed
2017-10-27 22:53:06,946 [salt.state       ][INFO    ][31534] Completed state [bc] at time 22:53:06.945689 duration_in_ms=2.829
2017-10-27 22:53:06,946 [salt.state       ][INFO    ][31534] Running state [glusterfs-server] at time 22:53:06.946451
2017-10-27 22:53:06,947 [salt.state       ][INFO    ][31534] Executing state service.running for glusterfs-server
2017-10-27 22:53:06,947 [salt.loaded.int.module.cmdmod][INFO    ][31534] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-10-27 22:53:06,957 [salt.loaded.int.module.cmdmod][INFO    ][31534] Executing command ['systemctl', '--system', 'daemon-reload'] in directory '/root'
2017-10-27 22:53:06,998 [salt.loaded.int.module.cmdmod][INFO    ][31534] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-10-27 22:53:07,013 [salt.loaded.int.module.cmdmod][INFO    ][31534] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-10-27 22:53:07,020 [salt.loaded.int.module.cmdmod][INFO    ][31534] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-10-27 22:53:07,028 [salt.state       ][INFO    ][31534] The service glusterfs-server is already running
2017-10-27 22:53:07,029 [salt.state       ][INFO    ][31534] Completed state [glusterfs-server] at time 22:53:07.028563 duration_in_ms=82.112
2017-10-27 22:53:07,030 [salt.state       ][INFO    ][31534] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 22:53:07.030070
2017-10-27 22:53:07,030 [salt.state       ][INFO    ][31534] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-10-27 22:53:07,042 [salt.state       ][INFO    ][31534] File /etc/systemd/system/glusterfs-server.service.d/override.conf is in the correct state
2017-10-27 22:53:07,042 [salt.state       ][INFO    ][31534] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 22:53:07.042060 duration_in_ms=11.99
2017-10-27 22:53:07,042 [salt.state       ][INFO    ][31534] Running state [/srv/glusterfs/glance] at time 22:53:07.042261
2017-10-27 22:53:07,042 [salt.state       ][INFO    ][31534] Executing state file.directory for /srv/glusterfs/glance
2017-10-27 22:53:07,043 [salt.state       ][INFO    ][31534] Directory /srv/glusterfs/glance is in the correct state
2017-10-27 22:53:07,043 [salt.state       ][INFO    ][31534] Completed state [/srv/glusterfs/glance] at time 22:53:07.042960 duration_in_ms=0.699
2017-10-27 22:53:07,043 [salt.state       ][INFO    ][31534] Running state [/srv/glusterfs/keystone-keys] at time 22:53:07.043128
2017-10-27 22:53:07,043 [salt.state       ][INFO    ][31534] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-10-27 22:53:07,044 [salt.state       ][INFO    ][31534] Directory /srv/glusterfs/keystone-keys is in the correct state
2017-10-27 22:53:07,044 [salt.state       ][INFO    ][31534] Completed state [/srv/glusterfs/keystone-keys] at time 22:53:07.043760 duration_in_ms=0.633
2017-10-27 22:53:07,044 [salt.state       ][INFO    ][31534] Running state [/srv/glusterfs/nova_instances] at time 22:53:07.043922
2017-10-27 22:53:07,044 [salt.state       ][INFO    ][31534] Executing state file.directory for /srv/glusterfs/nova_instances
2017-10-27 22:53:07,044 [salt.state       ][INFO    ][31534] Directory /srv/glusterfs/nova_instances is in the correct state
2017-10-27 22:53:07,045 [salt.state       ][INFO    ][31534] Completed state [/srv/glusterfs/nova_instances] at time 22:53:07.044607 duration_in_ms=0.685
2017-10-27 22:53:07,045 [salt.state       ][INFO    ][31534] Running state [/srv/glusterfs/keystone-credential-keys] at time 22:53:07.044773
2017-10-27 22:53:07,045 [salt.state       ][INFO    ][31534] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-10-27 22:53:07,045 [salt.state       ][INFO    ][31534] Directory /srv/glusterfs/keystone-credential-keys is in the correct state
2017-10-27 22:53:07,045 [salt.state       ][INFO    ][31534] Completed state [/srv/glusterfs/keystone-credential-keys] at time 22:53:07.045453 duration_in_ms=0.679
2017-10-27 22:53:07,100 [salt.loaded.int.module.cmdmod][INFO    ][31534] Executing command ['git', '--version'] in directory '/root'
2017-10-27 22:53:07,176 [salt.state       ][INFO    ][31534] Running state [sleep 5] at time 22:53:07.176427
2017-10-27 22:53:07,177 [salt.state       ][INFO    ][31534] Executing state cmd.wait for sleep 5
2017-10-27 22:53:07,177 [salt.state       ][INFO    ][31534] No changes made for sleep 5
2017-10-27 22:53:07,177 [salt.state       ][INFO    ][31534] Completed state [sleep 5] at time 22:53:07.176940 duration_in_ms=0.514
2017-10-27 22:53:07,177 [salt.state       ][INFO    ][31534] Running state [10.167.4.141] at time 22:53:07.177303
2017-10-27 22:53:07,177 [salt.state       ][INFO    ][31534] Executing state glusterfs.peered for 10.167.4.141
2017-10-27 22:53:07,178 [salt.loaded.int.module.cmdmod][INFO    ][31534] Executing command 'gluster --version' in directory '/root'
2017-10-27 22:53:07,186 [salt.loaded.int.module.cmdmod][INFO    ][31534] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 22:53:07,236 [salt.loaded.int.module.cmdmod][INFO    ][31534] Executing command 'gluster --version' in directory '/root'
2017-10-27 22:53:07,244 [salt.loaded.int.module.cmdmod][INFO    ][31534] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 22:53:07,294 [salt.loaded.int.module.cmdmod][INFO    ][31534] Executing command 'gluster --version' in directory '/root'
2017-10-27 22:53:07,302 [salt.loaded.int.module.cmdmod][INFO    ][31534] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 22:53:07,352 [salt.loaded.int.module.cmdmod][INFO    ][31534] Executing command 'gluster --version' in directory '/root'
2017-10-27 22:53:07,360 [salt.loaded.int.module.cmdmod][INFO    ][31534] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 22:53:07,407 [salt.state       ][INFO    ][31534] Peering with localhost is not needed
2017-10-27 22:53:07,407 [salt.state       ][INFO    ][31534] Completed state [10.167.4.141] at time 22:53:07.407109 duration_in_ms=229.806
2017-10-27 22:53:07,409 [salt.state       ][INFO    ][31534] Running state [10.167.4.142] at time 22:53:07.409326
2017-10-27 22:53:07,410 [salt.state       ][INFO    ][31534] Executing state glusterfs.peered for 10.167.4.142
2017-10-27 22:53:07,410 [salt.loaded.int.module.cmdmod][INFO    ][31534] Executing command 'gluster --version' in directory '/root'
2017-10-27 22:53:07,418 [salt.loaded.int.module.cmdmod][INFO    ][31534] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 22:53:07,465 [salt.state       ][INFO    ][31534] Host 10.167.4.142 already peered
2017-10-27 22:53:07,465 [salt.state       ][INFO    ][31534] Completed state [10.167.4.142] at time 22:53:07.465029 duration_in_ms=55.703
2017-10-27 22:53:07,467 [salt.state       ][INFO    ][31534] Running state [10.167.4.143] at time 22:53:07.467193
2017-10-27 22:53:07,467 [salt.state       ][INFO    ][31534] Executing state glusterfs.peered for 10.167.4.143
2017-10-27 22:53:07,468 [salt.loaded.int.module.cmdmod][INFO    ][31534] Executing command 'gluster --version' in directory '/root'
2017-10-27 22:53:07,476 [salt.loaded.int.module.cmdmod][INFO    ][31534] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 22:53:07,524 [salt.state       ][INFO    ][31534] Host 10.167.4.143 already peered
2017-10-27 22:53:07,524 [salt.state       ][INFO    ][31534] Completed state [10.167.4.143] at time 22:53:07.524421 duration_in_ms=57.228
2017-10-27 22:53:07,525 [salt.state       ][INFO    ][31534] Running state [glance] at time 22:53:07.525181
2017-10-27 22:53:07,525 [salt.state       ][INFO    ][31534] Executing state glusterfs.created for glance
2017-10-27 22:53:07,526 [salt.loaded.int.module.cmdmod][INFO    ][31534] Executing command 'gluster --version' in directory '/root'
2017-10-27 22:53:07,534 [salt.loaded.int.module.cmdmod][INFO    ][31534] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 22:53:07,581 [salt.loaded.int.module.cmdmod][INFO    ][31534] Executing command 'gluster --version' in directory '/root'
2017-10-27 22:53:07,588 [salt.loaded.int.module.cmdmod][INFO    ][31534] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 22:53:07,639 [salt.state       ][INFO    ][31534] Volume glance already exists and is started.
2017-10-27 22:53:07,639 [salt.state       ][INFO    ][31534] Completed state [glance] at time 22:53:07.639371 duration_in_ms=114.189
2017-10-27 22:53:07,642 [salt.state       ][INFO    ][31534] Running state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 22:53:07.641915
2017-10-27 22:53:07,642 [salt.state       ][INFO    ][31534] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'
2017-10-27 22:53:07,643 [salt.loaded.int.module.cmdmod][INFO    ][31534] Executing command 'gluster volume info 'glance' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-10-27 22:53:07,689 [salt.state       ][INFO    ][31534] unless execution succeeded
2017-10-27 22:53:07,690 [salt.state       ][INFO    ][31534] Completed state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 22:53:07.689686 duration_in_ms=47.771
2017-10-27 22:53:07,690 [salt.state       ][INFO    ][31534] Running state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 22:53:07.690139
2017-10-27 22:53:07,690 [salt.state       ][INFO    ][31534] Executing state cmd.run for gluster volume set 'glance' 'network.remote-dio' 'True'
2017-10-27 22:53:07,691 [salt.loaded.int.module.cmdmod][INFO    ][31534] Executing command 'gluster volume info 'glance' | grep 'network.remote-dio: True'' in directory '/root'
2017-10-27 22:53:07,739 [salt.state       ][INFO    ][31534] unless execution succeeded
2017-10-27 22:53:07,740 [salt.state       ][INFO    ][31534] Completed state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 22:53:07.739490 duration_in_ms=49.35
2017-10-27 22:53:07,740 [salt.state       ][INFO    ][31534] Running state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 22:53:07.739934
2017-10-27 22:53:07,740 [salt.state       ][INFO    ][31534] Executing state cmd.run for gluster volume set 'glance' 'nfs.disable' 'True'
2017-10-27 22:53:07,741 [salt.loaded.int.module.cmdmod][INFO    ][31534] Executing command 'gluster volume info 'glance' | grep 'nfs.disable: True'' in directory '/root'
2017-10-27 22:53:07,789 [salt.state       ][INFO    ][31534] unless execution succeeded
2017-10-27 22:53:07,790 [salt.state       ][INFO    ][31534] Completed state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 22:53:07.789477 duration_in_ms=49.543
2017-10-27 22:53:07,790 [salt.state       ][INFO    ][31534] Running state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 22:53:07.789914
2017-10-27 22:53:07,790 [salt.state       ][INFO    ][31534] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'
2017-10-27 22:53:07,791 [salt.loaded.int.module.cmdmod][INFO    ][31534] Executing command 'gluster volume info 'glance' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-10-27 22:53:07,838 [salt.state       ][INFO    ][31534] unless execution succeeded
2017-10-27 22:53:07,838 [salt.state       ][INFO    ][31534] Completed state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 22:53:07.837994 duration_in_ms=48.079
2017-10-27 22:53:07,838 [salt.state       ][INFO    ][31534] Running state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 22:53:07.838423
2017-10-27 22:53:07,839 [salt.state       ][INFO    ][31534] Executing state cmd.run for gluster volume set 'glance' 'cluster.readdir-optimize' 'True'
2017-10-27 22:53:07,839 [salt.loaded.int.module.cmdmod][INFO    ][31534] Executing command 'gluster volume info 'glance' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-10-27 22:53:07,886 [salt.state       ][INFO    ][31534] unless execution succeeded
2017-10-27 22:53:07,886 [salt.state       ][INFO    ][31534] Completed state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 22:53:07.886394 duration_in_ms=47.97
2017-10-27 22:53:07,887 [salt.state       ][INFO    ][31534] Running state [glance] at time 22:53:07.887292
2017-10-27 22:53:07,888 [salt.state       ][INFO    ][31534] Executing state glusterfs.started for glance
2017-10-27 22:53:07,888 [salt.loaded.int.module.cmdmod][INFO    ][31534] Executing command 'gluster --version' in directory '/root'
2017-10-27 22:53:07,895 [salt.loaded.int.module.cmdmod][INFO    ][31534] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 22:53:07,943 [salt.loaded.int.module.cmdmod][INFO    ][31534] Executing command 'gluster --version' in directory '/root'
2017-10-27 22:53:07,950 [salt.loaded.int.module.cmdmod][INFO    ][31534] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 22:53:07,1000 [salt.state       ][INFO    ][31534] Volume glance is already started
2017-10-27 22:53:07,1000 [salt.state       ][INFO    ][31534] Completed state [glance] at time 22:53:07.999760 duration_in_ms=112.468
2017-10-27 22:53:08,001 [salt.state       ][INFO    ][31534] Running state [keystone-keys] at time 22:53:08.000619
2017-10-27 22:53:08,001 [salt.state       ][INFO    ][31534] Executing state glusterfs.created for keystone-keys
2017-10-27 22:53:08,001 [salt.loaded.int.module.cmdmod][INFO    ][31534] Executing command 'gluster --version' in directory '/root'
2017-10-27 22:53:08,009 [salt.loaded.int.module.cmdmod][INFO    ][31534] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 22:53:08,056 [salt.loaded.int.module.cmdmod][INFO    ][31534] Executing command 'gluster --version' in directory '/root'
2017-10-27 22:53:08,064 [salt.loaded.int.module.cmdmod][INFO    ][31534] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 22:53:08,119 [salt.state       ][INFO    ][31534] Volume keystone-keys already exists and is started.
2017-10-27 22:53:08,119 [salt.state       ][INFO    ][31534] Completed state [keystone-keys] at time 22:53:08.118903 duration_in_ms=118.282
2017-10-27 22:53:08,122 [salt.state       ][INFO    ][31534] Running state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 22:53:08.121619
2017-10-27 22:53:08,122 [salt.state       ][INFO    ][31534] Executing state cmd.run for gluster volume set 'keystone-keys' 'network.remote-dio' 'True'
2017-10-27 22:53:08,122 [salt.loaded.int.module.cmdmod][INFO    ][31534] Executing command 'gluster volume info 'keystone-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-10-27 22:53:08,169 [salt.state       ][INFO    ][31534] unless execution succeeded
2017-10-27 22:53:08,169 [salt.state       ][INFO    ][31534] Completed state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 22:53:08.169133 duration_in_ms=47.514
2017-10-27 22:53:08,170 [salt.state       ][INFO    ][31534] Running state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 22:53:08.169612
2017-10-27 22:53:08,170 [salt.state       ][INFO    ][31534] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-10-27 22:53:08,170 [salt.loaded.int.module.cmdmod][INFO    ][31534] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-10-27 22:53:08,218 [salt.state       ][INFO    ][31534] unless execution succeeded
2017-10-27 22:53:08,219 [salt.state       ][INFO    ][31534] Completed state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 22:53:08.218608 duration_in_ms=48.996
2017-10-27 22:53:08,219 [salt.state       ][INFO    ][31534] Running state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 22:53:08.219093
2017-10-27 22:53:08,219 [salt.state       ][INFO    ][31534] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'
2017-10-27 22:53:08,220 [salt.loaded.int.module.cmdmod][INFO    ][31534] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-10-27 22:53:08,267 [salt.state       ][INFO    ][31534] unless execution succeeded
2017-10-27 22:53:08,268 [salt.state       ][INFO    ][31534] Completed state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 22:53:08.267623 duration_in_ms=48.53
2017-10-27 22:53:08,268 [salt.state       ][INFO    ][31534] Running state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 22:53:08.268099
2017-10-27 22:53:08,268 [salt.state       ][INFO    ][31534] Executing state cmd.run for gluster volume set 'keystone-keys' 'nfs.disable' 'True'
2017-10-27 22:53:08,269 [salt.loaded.int.module.cmdmod][INFO    ][31534] Executing command 'gluster volume info 'keystone-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-10-27 22:53:08,318 [salt.state       ][INFO    ][31534] unless execution succeeded
2017-10-27 22:53:08,319 [salt.state       ][INFO    ][31534] Completed state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 22:53:08.318621 duration_in_ms=50.521
2017-10-27 22:53:08,319 [salt.state       ][INFO    ][31534] Running state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 22:53:08.319103
2017-10-27 22:53:08,319 [salt.state       ][INFO    ][31534] Executing state cmd.run for gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'
2017-10-27 22:53:08,320 [salt.loaded.int.module.cmdmod][INFO    ][31534] Executing command 'gluster volume info 'keystone-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-10-27 22:53:08,373 [salt.state       ][INFO    ][31534] unless execution succeeded
2017-10-27 22:53:08,373 [salt.state       ][INFO    ][31534] Completed state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 22:53:08.373397 duration_in_ms=54.294
2017-10-27 22:53:08,374 [salt.state       ][INFO    ][31534] Running state [keystone-keys] at time 22:53:08.374318
2017-10-27 22:53:08,375 [salt.state       ][INFO    ][31534] Executing state glusterfs.started for keystone-keys
2017-10-27 22:53:08,375 [salt.loaded.int.module.cmdmod][INFO    ][31534] Executing command 'gluster --version' in directory '/root'
2017-10-27 22:53:08,383 [salt.loaded.int.module.cmdmod][INFO    ][31534] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 22:53:08,430 [salt.loaded.int.module.cmdmod][INFO    ][31534] Executing command 'gluster --version' in directory '/root'
2017-10-27 22:53:08,447 [salt.loaded.int.module.cmdmod][INFO    ][31534] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 22:53:08,509 [salt.state       ][INFO    ][31534] Volume keystone-keys is already started
2017-10-27 22:53:08,509 [salt.state       ][INFO    ][31534] Completed state [keystone-keys] at time 22:53:08.508917 duration_in_ms=134.598
2017-10-27 22:53:08,510 [salt.state       ][INFO    ][31534] Running state [nova_instances] at time 22:53:08.509882
2017-10-27 22:53:08,510 [salt.state       ][INFO    ][31534] Executing state glusterfs.created for nova_instances
2017-10-27 22:53:08,510 [salt.loaded.int.module.cmdmod][INFO    ][31534] Executing command 'gluster --version' in directory '/root'
2017-10-27 22:53:08,519 [salt.loaded.int.module.cmdmod][INFO    ][31534] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 22:53:08,567 [salt.loaded.int.module.cmdmod][INFO    ][31534] Executing command 'gluster --version' in directory '/root'
2017-10-27 22:53:08,575 [salt.loaded.int.module.cmdmod][INFO    ][31534] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 22:53:08,625 [salt.state       ][INFO    ][31534] Volume nova_instances already exists and is started.
2017-10-27 22:53:08,625 [salt.state       ][INFO    ][31534] Completed state [nova_instances] at time 22:53:08.625164 duration_in_ms=115.282
2017-10-27 22:53:08,628 [salt.state       ][INFO    ][31534] Running state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 22:53:08.627894
2017-10-27 22:53:08,628 [salt.state       ][INFO    ][31534] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'
2017-10-27 22:53:08,629 [salt.loaded.int.module.cmdmod][INFO    ][31534] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-10-27 22:53:08,678 [salt.state       ][INFO    ][31534] unless execution succeeded
2017-10-27 22:53:08,678 [salt.state       ][INFO    ][31534] Completed state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 22:53:08.678254 duration_in_ms=50.359
2017-10-27 22:53:08,679 [salt.state       ][INFO    ][31534] Running state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'On'] at time 22:53:08.678715
2017-10-27 22:53:08,679 [salt.state       ][INFO    ][31534] Executing state cmd.run for gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'On'
2017-10-27 22:53:08,679 [salt.loaded.int.module.cmdmod][INFO    ][31534] Executing command 'gluster volume info 'nova_instances' | grep 'cluster.readdir-optimize: On'' in directory '/root'
2017-10-27 22:53:08,726 [salt.state       ][INFO    ][31534] unless execution succeeded
2017-10-27 22:53:08,727 [salt.state       ][INFO    ][31534] Completed state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'On'] at time 22:53:08.726525 duration_in_ms=47.809
2017-10-27 22:53:08,727 [salt.state       ][INFO    ][31534] Running state [gluster volume set 'nova_instances' 'network.remote-dio' 'On'] at time 22:53:08.727004
2017-10-27 22:53:08,727 [salt.state       ][INFO    ][31534] Executing state cmd.run for gluster volume set 'nova_instances' 'network.remote-dio' 'On'
2017-10-27 22:53:08,728 [salt.loaded.int.module.cmdmod][INFO    ][31534] Executing command 'gluster volume info 'nova_instances' | grep 'network.remote-dio: On'' in directory '/root'
2017-10-27 22:53:08,776 [salt.state       ][INFO    ][31534] unless execution succeeded
2017-10-27 22:53:08,777 [salt.state       ][INFO    ][31534] Completed state [gluster volume set 'nova_instances' 'network.remote-dio' 'On'] at time 22:53:08.776499 duration_in_ms=49.495
2017-10-27 22:53:08,777 [salt.state       ][INFO    ][31534] Running state [gluster volume set 'nova_instances' 'nfs.disable' 'On'] at time 22:53:08.776989
2017-10-27 22:53:08,777 [salt.state       ][INFO    ][31534] Executing state cmd.run for gluster volume set 'nova_instances' 'nfs.disable' 'On'
2017-10-27 22:53:08,778 [salt.loaded.int.module.cmdmod][INFO    ][31534] Executing command 'gluster volume info 'nova_instances' | grep 'nfs.disable: On'' in directory '/root'
2017-10-27 22:53:08,824 [salt.state       ][INFO    ][31534] unless execution succeeded
2017-10-27 22:53:08,824 [salt.state       ][INFO    ][31534] Completed state [gluster volume set 'nova_instances' 'nfs.disable' 'On'] at time 22:53:08.823974 duration_in_ms=46.985
2017-10-27 22:53:08,824 [salt.state       ][INFO    ][31534] Running state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 22:53:08.824439
2017-10-27 22:53:08,825 [salt.state       ][INFO    ][31534] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'
2017-10-27 22:53:08,825 [salt.loaded.int.module.cmdmod][INFO    ][31534] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-10-27 22:53:08,873 [salt.state       ][INFO    ][31534] unless execution succeeded
2017-10-27 22:53:08,873 [salt.state       ][INFO    ][31534] Completed state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 22:53:08.873449 duration_in_ms=49.01
2017-10-27 22:53:08,874 [salt.state       ][INFO    ][31534] Running state [nova_instances] at time 22:53:08.874375
2017-10-27 22:53:08,875 [salt.state       ][INFO    ][31534] Executing state glusterfs.started for nova_instances
2017-10-27 22:53:08,875 [salt.loaded.int.module.cmdmod][INFO    ][31534] Executing command 'gluster --version' in directory '/root'
2017-10-27 22:53:08,882 [salt.loaded.int.module.cmdmod][INFO    ][31534] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 22:53:08,929 [salt.loaded.int.module.cmdmod][INFO    ][31534] Executing command 'gluster --version' in directory '/root'
2017-10-27 22:53:08,937 [salt.loaded.int.module.cmdmod][INFO    ][31534] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 22:53:08,995 [salt.state       ][INFO    ][31534] Volume nova_instances is already started
2017-10-27 22:53:08,996 [salt.state       ][INFO    ][31534] Completed state [nova_instances] at time 22:53:08.995554 duration_in_ms=121.179
2017-10-27 22:53:08,996 [salt.state       ][INFO    ][31534] Running state [keystone-credential-keys] at time 22:53:08.996451
2017-10-27 22:53:08,997 [salt.state       ][INFO    ][31534] Executing state glusterfs.created for keystone-credential-keys
2017-10-27 22:53:08,997 [salt.loaded.int.module.cmdmod][INFO    ][31534] Executing command 'gluster --version' in directory '/root'
2017-10-27 22:53:09,005 [salt.loaded.int.module.cmdmod][INFO    ][31534] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 22:53:09,050 [salt.loaded.int.module.cmdmod][INFO    ][31534] Executing command 'gluster --version' in directory '/root'
2017-10-27 22:53:09,059 [salt.loaded.int.module.cmdmod][INFO    ][31534] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 22:53:09,112 [salt.state       ][INFO    ][31534] Volume keystone-credential-keys already exists and is started.
2017-10-27 22:53:09,113 [salt.state       ][INFO    ][31534] Completed state [keystone-credential-keys] at time 22:53:09.112612 duration_in_ms=116.16
2017-10-27 22:53:09,117 [salt.state       ][INFO    ][31534] Running state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 22:53:09.116545
2017-10-27 22:53:09,117 [salt.state       ][INFO    ][31534] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'
2017-10-27 22:53:09,118 [salt.loaded.int.module.cmdmod][INFO    ][31534] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-10-27 22:53:09,170 [salt.state       ][INFO    ][31534] unless execution succeeded
2017-10-27 22:53:09,170 [salt.state       ][INFO    ][31534] Completed state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 22:53:09.169780 duration_in_ms=53.233
2017-10-27 22:53:09,170 [salt.state       ][INFO    ][31534] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 22:53:09.170264
2017-10-27 22:53:09,171 [salt.state       ][INFO    ][31534] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-10-27 22:53:09,171 [salt.loaded.int.module.cmdmod][INFO    ][31534] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-10-27 22:53:09,221 [salt.state       ][INFO    ][31534] unless execution succeeded
2017-10-27 22:53:09,221 [salt.state       ][INFO    ][31534] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 22:53:09.221115 duration_in_ms=50.851
2017-10-27 22:53:09,222 [salt.state       ][INFO    ][31534] Running state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 22:53:09.221560
2017-10-27 22:53:09,222 [salt.state       ][INFO    ][31534] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'
2017-10-27 22:53:09,222 [salt.loaded.int.module.cmdmod][INFO    ][31534] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-10-27 22:53:09,271 [salt.state       ][INFO    ][31534] unless execution succeeded
2017-10-27 22:53:09,272 [salt.state       ][INFO    ][31534] Completed state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 22:53:09.271571 duration_in_ms=50.01
2017-10-27 22:53:09,272 [salt.state       ][INFO    ][31534] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 22:53:09.272050
2017-10-27 22:53:09,272 [salt.state       ][INFO    ][31534] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'
2017-10-27 22:53:09,273 [salt.loaded.int.module.cmdmod][INFO    ][31534] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-10-27 22:53:09,321 [salt.state       ][INFO    ][31534] unless execution succeeded
2017-10-27 22:53:09,321 [salt.state       ][INFO    ][31534] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 22:53:09.320964 duration_in_ms=48.912
2017-10-27 22:53:09,321 [salt.state       ][INFO    ][31534] Running state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 22:53:09.321442
2017-10-27 22:53:09,322 [salt.state       ][INFO    ][31534] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'
2017-10-27 22:53:09,322 [salt.loaded.int.module.cmdmod][INFO    ][31534] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-10-27 22:53:09,371 [salt.state       ][INFO    ][31534] unless execution succeeded
2017-10-27 22:53:09,371 [salt.state       ][INFO    ][31534] Completed state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 22:53:09.371411 duration_in_ms=49.968
2017-10-27 22:53:09,372 [salt.state       ][INFO    ][31534] Running state [keystone-credential-keys] at time 22:53:09.372405
2017-10-27 22:53:09,373 [salt.state       ][INFO    ][31534] Executing state glusterfs.started for keystone-credential-keys
2017-10-27 22:53:09,373 [salt.loaded.int.module.cmdmod][INFO    ][31534] Executing command 'gluster --version' in directory '/root'
2017-10-27 22:53:09,381 [salt.loaded.int.module.cmdmod][INFO    ][31534] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 22:53:09,429 [salt.loaded.int.module.cmdmod][INFO    ][31534] Executing command 'gluster --version' in directory '/root'
2017-10-27 22:53:09,437 [salt.loaded.int.module.cmdmod][INFO    ][31534] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 22:53:09,489 [salt.state       ][INFO    ][31534] Volume keystone-credential-keys is already started
2017-10-27 22:53:09,489 [salt.state       ][INFO    ][31534] Completed state [keystone-credential-keys] at time 22:53:09.489069 duration_in_ms=116.664
2017-10-27 22:53:09,491 [salt.minion      ][INFO    ][31534] Returning information for job: 20171027225305810121
2017-10-27 22:53:10,688 [salt.minion      ][INFO    ][23612] User sudo_ubuntu Executing command test.ping with jid 20171027225310680841
2017-10-27 22:53:10,703 [salt.minion      ][INFO    ][31936] Starting a new job with PID 31936
2017-10-27 22:53:10,727 [salt.minion      ][INFO    ][31936] Returning information for job: 20171027225310680841
2017-10-27 22:53:11,384 [salt.minion      ][INFO    ][23612] User sudo_ubuntu Executing command cmd.run with jid 20171027225311370949
2017-10-27 22:53:11,400 [salt.minion      ][INFO    ][31941] Starting a new job with PID 31941
2017-10-27 22:53:11,404 [salt.loaded.int.module.cmdmod][INFO    ][31941] Executing command 'gluster peer status; gluster volume status' in directory '/root'
2017-10-27 22:53:11,512 [salt.minion      ][INFO    ][31941] Returning information for job: 20171027225311370949
2017-10-27 23:10:13,749 [salt.utils.schedule][INFO    ][23612] Running scheduled job: __mine_interval
2017-10-27 23:53:37,115 [salt.minion      ][INFO    ][23612] User sudo_ubuntu Executing command test.ping with jid 20171027235337112025
2017-10-27 23:53:37,140 [salt.minion      ][INFO    ][454] Starting a new job with PID 454
2017-10-27 23:53:37,173 [salt.minion      ][INFO    ][454] Returning information for job: 20171027235337112025
2017-10-27 23:53:42,703 [salt.minion      ][INFO    ][23612] User sudo_ubuntu Executing command state.sls with jid 20171027235342694623
2017-10-27 23:53:42,719 [salt.minion      ][INFO    ][459] Starting a new job with PID 459
2017-10-27 23:53:43,155 [salt.state       ][INFO    ][459] Loading fresh modules for state activity
2017-10-27 23:53:43,180 [salt.fileclient  ][INFO    ][459] Fetching file from saltenv 'base', ** done ** 'keepalived/init.sls'
2017-10-27 23:53:43,198 [salt.fileclient  ][INFO    ][459] Fetching file from saltenv 'base', ** done ** 'keepalived/cluster.sls'
2017-10-27 23:53:43,223 [salt.fileclient  ][INFO    ][459] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-10-27 23:53:43,481 [salt.state       ][INFO    ][459] Running state [lsof] at time 23:53:43.480957
2017-10-27 23:53:43,481 [salt.state       ][INFO    ][459] Executing state pkg.installed for lsof
2017-10-27 23:53:43,482 [salt.loaded.int.module.cmdmod][INFO    ][459] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-10-27 23:53:43,768 [salt.state       ][INFO    ][459] Package lsof is already installed
2017-10-27 23:53:43,768 [salt.state       ][INFO    ][459] Completed state [lsof] at time 23:53:43.767890 duration_in_ms=286.933
2017-10-27 23:53:43,768 [salt.state       ][INFO    ][459] Running state [keepalived] at time 23:53:43.768091
2017-10-27 23:53:43,768 [salt.state       ][INFO    ][459] Executing state pkg.installed for keepalived
2017-10-27 23:53:43,771 [salt.state       ][INFO    ][459] Package keepalived is already installed
2017-10-27 23:53:43,771 [salt.state       ][INFO    ][459] Completed state [keepalived] at time 23:53:43.770932 duration_in_ms=2.842
2017-10-27 23:53:43,772 [salt.state       ][INFO    ][459] Running state [/etc/keepalived/keepalived.conf] at time 23:53:43.772339
2017-10-27 23:53:43,773 [salt.state       ][INFO    ][459] Executing state file.managed for /etc/keepalived/keepalived.conf
2017-10-27 23:53:43,796 [salt.fileclient  ][INFO    ][459] Fetching file from saltenv 'base', ** done ** 'keepalived/files/keepalived.conf'
2017-10-27 23:53:43,827 [salt.fileclient  ][INFO    ][459] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-10-27 23:53:43,831 [salt.state       ][INFO    ][459] File /etc/keepalived/keepalived.conf is in the correct state
2017-10-27 23:53:43,832 [salt.state       ][INFO    ][459] Completed state [/etc/keepalived/keepalived.conf] at time 23:53:43.831596 duration_in_ms=59.257
2017-10-27 23:53:43,832 [salt.state       ][INFO    ][459] Running state [keepalived] at time 23:53:43.832088
2017-10-27 23:53:43,832 [salt.state       ][INFO    ][459] Executing state service.running for keepalived
2017-10-27 23:53:43,833 [salt.loaded.int.module.cmdmod][INFO    ][459] Executing command ['systemctl', 'status', 'keepalived.service', '-n', '0'] in directory '/root'
2017-10-27 23:53:43,849 [salt.loaded.int.module.cmdmod][INFO    ][459] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2017-10-27 23:53:43,858 [salt.loaded.int.module.cmdmod][INFO    ][459] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-10-27 23:53:43,865 [salt.state       ][INFO    ][459] The service keepalived is already running
2017-10-27 23:53:43,866 [salt.state       ][INFO    ][459] Completed state [keepalived] at time 23:53:43.865627 duration_in_ms=33.537
2017-10-27 23:53:43,866 [salt.minion      ][INFO    ][459] Returning information for job: 20171027235342694623
2017-10-27 23:54:09,173 [salt.minion      ][INFO    ][23612] User sudo_ubuntu Executing command pillar.get with jid 20171027235409166751
2017-10-27 23:54:09,196 [salt.minion      ][INFO    ][490] Starting a new job with PID 490
2017-10-27 23:54:09,201 [salt.minion      ][INFO    ][490] Returning information for job: 20171027235409166751
2017-10-27 23:54:46,123 [salt.minion      ][INFO    ][23612] User sudo_ubuntu Executing command state.sls with jid 20171027235446114974
2017-10-27 23:54:46,139 [salt.minion      ][INFO    ][497] Starting a new job with PID 497
2017-10-27 23:54:46,645 [salt.state       ][INFO    ][497] Loading fresh modules for state activity
2017-10-27 23:54:46,668 [salt.fileclient  ][INFO    ][497] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-10-27 23:54:46,691 [salt.fileclient  ][INFO    ][497] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-10-27 23:54:46,965 [salt.state       ][INFO    ][497] Running state [attr] at time 23:54:46.965439
2017-10-27 23:54:46,966 [salt.state       ][INFO    ][497] Executing state pkg.installed for attr
2017-10-27 23:54:46,966 [salt.loaded.int.module.cmdmod][INFO    ][497] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-10-27 23:54:47,218 [salt.state       ][INFO    ][497] Package attr is already installed
2017-10-27 23:54:47,218 [salt.state       ][INFO    ][497] Completed state [attr] at time 23:54:47.218280 duration_in_ms=252.841
2017-10-27 23:54:47,218 [salt.state       ][INFO    ][497] Running state [glusterfs-server] at time 23:54:47.218478
2017-10-27 23:54:47,219 [salt.state       ][INFO    ][497] Executing state pkg.installed for glusterfs-server
2017-10-27 23:54:47,221 [salt.state       ][INFO    ][497] Package glusterfs-server is already installed
2017-10-27 23:54:47,221 [salt.state       ][INFO    ][497] Completed state [glusterfs-server] at time 23:54:47.221365 duration_in_ms=2.887
2017-10-27 23:54:47,222 [salt.state       ][INFO    ][497] Running state [bc] at time 23:54:47.221503
2017-10-27 23:54:47,222 [salt.state       ][INFO    ][497] Executing state pkg.installed for bc
2017-10-27 23:54:47,224 [salt.state       ][INFO    ][497] Package bc is already installed
2017-10-27 23:54:47,224 [salt.state       ][INFO    ][497] Completed state [bc] at time 23:54:47.224269 duration_in_ms=2.766
2017-10-27 23:54:47,225 [salt.state       ][INFO    ][497] Running state [glusterfs-server] at time 23:54:47.224915
2017-10-27 23:54:47,225 [salt.state       ][INFO    ][497] Executing state service.running for glusterfs-server
2017-10-27 23:54:47,225 [salt.loaded.int.module.cmdmod][INFO    ][497] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-10-27 23:54:47,242 [salt.loaded.int.module.cmdmod][INFO    ][497] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-10-27 23:54:47,250 [salt.loaded.int.module.cmdmod][INFO    ][497] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-10-27 23:54:47,260 [salt.state       ][INFO    ][497] The service glusterfs-server is already running
2017-10-27 23:54:47,260 [salt.state       ][INFO    ][497] Completed state [glusterfs-server] at time 23:54:47.259824 duration_in_ms=34.909
2017-10-27 23:54:47,261 [salt.state       ][INFO    ][497] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 23:54:47.261196
2017-10-27 23:54:47,261 [salt.state       ][INFO    ][497] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-10-27 23:54:47,272 [salt.state       ][INFO    ][497] File /etc/systemd/system/glusterfs-server.service.d/override.conf is in the correct state
2017-10-27 23:54:47,272 [salt.state       ][INFO    ][497] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 23:54:47.272076 duration_in_ms=10.88
2017-10-27 23:54:47,272 [salt.state       ][INFO    ][497] Running state [/srv/glusterfs/glance] at time 23:54:47.272237
2017-10-27 23:54:47,272 [salt.state       ][INFO    ][497] Executing state file.directory for /srv/glusterfs/glance
2017-10-27 23:54:47,273 [salt.state       ][INFO    ][497] Directory /srv/glusterfs/glance is in the correct state
2017-10-27 23:54:47,273 [salt.state       ][INFO    ][497] Completed state [/srv/glusterfs/glance] at time 23:54:47.272881 duration_in_ms=0.644
2017-10-27 23:54:47,273 [salt.state       ][INFO    ][497] Running state [/srv/glusterfs/keystone-keys] at time 23:54:47.273021
2017-10-27 23:54:47,273 [salt.state       ][INFO    ][497] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-10-27 23:54:47,273 [salt.state       ][INFO    ][497] Directory /srv/glusterfs/keystone-keys is in the correct state
2017-10-27 23:54:47,274 [salt.state       ][INFO    ][497] Completed state [/srv/glusterfs/keystone-keys] at time 23:54:47.273602 duration_in_ms=0.581
2017-10-27 23:54:47,274 [salt.state       ][INFO    ][497] Running state [/srv/glusterfs/nova_instances] at time 23:54:47.273740
2017-10-27 23:54:47,274 [salt.state       ][INFO    ][497] Executing state file.directory for /srv/glusterfs/nova_instances
2017-10-27 23:54:47,274 [salt.state       ][INFO    ][497] Directory /srv/glusterfs/nova_instances is in the correct state
2017-10-27 23:54:47,274 [salt.state       ][INFO    ][497] Completed state [/srv/glusterfs/nova_instances] at time 23:54:47.274335 duration_in_ms=0.596
2017-10-27 23:54:47,274 [salt.state       ][INFO    ][497] Running state [/srv/glusterfs/keystone-credential-keys] at time 23:54:47.274474
2017-10-27 23:54:47,275 [salt.state       ][INFO    ][497] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-10-27 23:54:47,275 [salt.state       ][INFO    ][497] Directory /srv/glusterfs/keystone-credential-keys is in the correct state
2017-10-27 23:54:47,275 [salt.state       ][INFO    ][497] Completed state [/srv/glusterfs/keystone-credential-keys] at time 23:54:47.275062 duration_in_ms=0.588
2017-10-27 23:54:47,276 [salt.minion      ][INFO    ][497] Returning information for job: 20171027235446114974
2017-10-27 23:54:48,445 [salt.minion      ][INFO    ][23612] User sudo_ubuntu Executing command test.ping with jid 20171027235448432393
2017-10-27 23:54:48,461 [salt.minion      ][INFO    ][521] Starting a new job with PID 521
2017-10-27 23:54:48,489 [salt.minion      ][INFO    ][521] Returning information for job: 20171027235448432393
2017-10-27 23:54:57,265 [salt.minion      ][INFO    ][23612] User sudo_ubuntu Executing command state.sls with jid 20171027235457256643
2017-10-27 23:54:57,281 [salt.minion      ][INFO    ][526] Starting a new job with PID 526
2017-10-27 23:54:57,677 [salt.state       ][INFO    ][526] Loading fresh modules for state activity
2017-10-27 23:54:57,700 [salt.fileclient  ][INFO    ][526] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/setup.sls'
2017-10-27 23:54:57,732 [salt.fileclient  ][INFO    ][526] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-10-27 23:54:57,795 [salt.fileclient  ][INFO    ][526] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-10-27 23:54:57,812 [salt.fileclient  ][INFO    ][526] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-10-27 23:54:58,068 [salt.state       ][INFO    ][526] Running state [attr] at time 23:54:58.067660
2017-10-27 23:54:58,068 [salt.state       ][INFO    ][526] Executing state pkg.installed for attr
2017-10-27 23:54:58,068 [salt.loaded.int.module.cmdmod][INFO    ][526] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-10-27 23:54:58,354 [salt.state       ][INFO    ][526] Package attr is already installed
2017-10-27 23:54:58,354 [salt.state       ][INFO    ][526] Completed state [attr] at time 23:54:58.354147 duration_in_ms=286.488
2017-10-27 23:54:58,354 [salt.state       ][INFO    ][526] Running state [glusterfs-server] at time 23:54:58.354362
2017-10-27 23:54:58,355 [salt.state       ][INFO    ][526] Executing state pkg.installed for glusterfs-server
2017-10-27 23:54:58,357 [salt.state       ][INFO    ][526] Package glusterfs-server is already installed
2017-10-27 23:54:58,357 [salt.state       ][INFO    ][526] Completed state [glusterfs-server] at time 23:54:58.357200 duration_in_ms=2.839
2017-10-27 23:54:58,357 [salt.state       ][INFO    ][526] Running state [bc] at time 23:54:58.357341
2017-10-27 23:54:58,357 [salt.state       ][INFO    ][526] Executing state pkg.installed for bc
2017-10-27 23:54:58,360 [salt.state       ][INFO    ][526] Package bc is already installed
2017-10-27 23:54:58,360 [salt.state       ][INFO    ][526] Completed state [bc] at time 23:54:58.360072 duration_in_ms=2.731
2017-10-27 23:54:58,361 [salt.state       ][INFO    ][526] Running state [glusterfs-server] at time 23:54:58.360867
2017-10-27 23:54:58,361 [salt.state       ][INFO    ][526] Executing state service.running for glusterfs-server
2017-10-27 23:54:58,361 [salt.loaded.int.module.cmdmod][INFO    ][526] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-10-27 23:54:58,380 [salt.loaded.int.module.cmdmod][INFO    ][526] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-10-27 23:54:58,388 [salt.loaded.int.module.cmdmod][INFO    ][526] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-10-27 23:54:58,397 [salt.state       ][INFO    ][526] The service glusterfs-server is already running
2017-10-27 23:54:58,398 [salt.state       ][INFO    ][526] Completed state [glusterfs-server] at time 23:54:58.397648 duration_in_ms=36.775
2017-10-27 23:54:58,399 [salt.state       ][INFO    ][526] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 23:54:58.399180
2017-10-27 23:54:58,399 [salt.state       ][INFO    ][526] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-10-27 23:54:58,410 [salt.state       ][INFO    ][526] File /etc/systemd/system/glusterfs-server.service.d/override.conf is in the correct state
2017-10-27 23:54:58,410 [salt.state       ][INFO    ][526] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 23:54:58.410066 duration_in_ms=10.886
2017-10-27 23:54:58,410 [salt.state       ][INFO    ][526] Running state [/srv/glusterfs/glance] at time 23:54:58.410244
2017-10-27 23:54:58,410 [salt.state       ][INFO    ][526] Executing state file.directory for /srv/glusterfs/glance
2017-10-27 23:54:58,411 [salt.state       ][INFO    ][526] Directory /srv/glusterfs/glance is in the correct state
2017-10-27 23:54:58,411 [salt.state       ][INFO    ][526] Completed state [/srv/glusterfs/glance] at time 23:54:58.410953 duration_in_ms=0.709
2017-10-27 23:54:58,411 [salt.state       ][INFO    ][526] Running state [/srv/glusterfs/keystone-keys] at time 23:54:58.411122
2017-10-27 23:54:58,411 [salt.state       ][INFO    ][526] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-10-27 23:54:58,412 [salt.state       ][INFO    ][526] Directory /srv/glusterfs/keystone-keys is in the correct state
2017-10-27 23:54:58,412 [salt.state       ][INFO    ][526] Completed state [/srv/glusterfs/keystone-keys] at time 23:54:58.411817 duration_in_ms=0.694
2017-10-27 23:54:58,412 [salt.state       ][INFO    ][526] Running state [/srv/glusterfs/nova_instances] at time 23:54:58.411984
2017-10-27 23:54:58,412 [salt.state       ][INFO    ][526] Executing state file.directory for /srv/glusterfs/nova_instances
2017-10-27 23:54:58,413 [salt.state       ][INFO    ][526] Directory /srv/glusterfs/nova_instances is in the correct state
2017-10-27 23:54:58,413 [salt.state       ][INFO    ][526] Completed state [/srv/glusterfs/nova_instances] at time 23:54:58.412748 duration_in_ms=0.764
2017-10-27 23:54:58,413 [salt.state       ][INFO    ][526] Running state [/srv/glusterfs/keystone-credential-keys] at time 23:54:58.412929
2017-10-27 23:54:58,413 [salt.state       ][INFO    ][526] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-10-27 23:54:58,414 [salt.state       ][INFO    ][526] Directory /srv/glusterfs/keystone-credential-keys is in the correct state
2017-10-27 23:54:58,414 [salt.state       ][INFO    ][526] Completed state [/srv/glusterfs/keystone-credential-keys] at time 23:54:58.413657 duration_in_ms=0.727
2017-10-27 23:54:58,454 [salt.loaded.int.module.cmdmod][INFO    ][526] Executing command ['git', '--version'] in directory '/root'
2017-10-27 23:54:58,534 [salt.state       ][INFO    ][526] Running state [sleep 5] at time 23:54:58.533914
2017-10-27 23:54:58,534 [salt.state       ][INFO    ][526] Executing state cmd.wait for sleep 5
2017-10-27 23:54:58,534 [salt.state       ][INFO    ][526] No changes made for sleep 5
2017-10-27 23:54:58,535 [salt.state       ][INFO    ][526] Completed state [sleep 5] at time 23:54:58.534476 duration_in_ms=0.562
2017-10-27 23:54:58,535 [salt.state       ][INFO    ][526] Running state [10.167.4.141] at time 23:54:58.534841
2017-10-27 23:54:58,535 [salt.state       ][INFO    ][526] Executing state glusterfs.peered for 10.167.4.141
2017-10-27 23:54:58,535 [salt.loaded.int.module.cmdmod][INFO    ][526] Executing command 'gluster --version' in directory '/root'
2017-10-27 23:54:58,544 [salt.loaded.int.module.cmdmod][INFO    ][526] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 23:54:58,593 [salt.loaded.int.module.cmdmod][INFO    ][526] Executing command 'gluster --version' in directory '/root'
2017-10-27 23:54:58,602 [salt.loaded.int.module.cmdmod][INFO    ][526] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 23:54:58,652 [salt.loaded.int.module.cmdmod][INFO    ][526] Executing command 'gluster --version' in directory '/root'
2017-10-27 23:54:58,661 [salt.loaded.int.module.cmdmod][INFO    ][526] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 23:54:58,713 [salt.loaded.int.module.cmdmod][INFO    ][526] Executing command 'gluster --version' in directory '/root'
2017-10-27 23:54:58,721 [salt.loaded.int.module.cmdmod][INFO    ][526] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 23:54:58,769 [salt.state       ][INFO    ][526] Peering with localhost is not needed
2017-10-27 23:54:58,769 [salt.state       ][INFO    ][526] Completed state [10.167.4.141] at time 23:54:58.769101 duration_in_ms=234.26
2017-10-27 23:54:58,771 [salt.state       ][INFO    ][526] Running state [10.167.4.142] at time 23:54:58.771296
2017-10-27 23:54:58,772 [salt.state       ][INFO    ][526] Executing state glusterfs.peered for 10.167.4.142
2017-10-27 23:54:58,772 [salt.loaded.int.module.cmdmod][INFO    ][526] Executing command 'gluster --version' in directory '/root'
2017-10-27 23:54:58,781 [salt.loaded.int.module.cmdmod][INFO    ][526] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 23:54:58,829 [salt.state       ][INFO    ][526] Host 10.167.4.142 already peered
2017-10-27 23:54:58,830 [salt.state       ][INFO    ][526] Completed state [10.167.4.142] at time 23:54:58.829645 duration_in_ms=58.349
2017-10-27 23:54:58,832 [salt.state       ][INFO    ][526] Running state [10.167.4.143] at time 23:54:58.831762
2017-10-27 23:54:58,832 [salt.state       ][INFO    ][526] Executing state glusterfs.peered for 10.167.4.143
2017-10-27 23:54:58,832 [salt.loaded.int.module.cmdmod][INFO    ][526] Executing command 'gluster --version' in directory '/root'
2017-10-27 23:54:58,841 [salt.loaded.int.module.cmdmod][INFO    ][526] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 23:54:58,888 [salt.state       ][INFO    ][526] Host 10.167.4.143 already peered
2017-10-27 23:54:58,889 [salt.state       ][INFO    ][526] Completed state [10.167.4.143] at time 23:54:58.888522 duration_in_ms=56.759
2017-10-27 23:54:58,889 [salt.state       ][INFO    ][526] Running state [glance] at time 23:54:58.889270
2017-10-27 23:54:58,889 [salt.state       ][INFO    ][526] Executing state glusterfs.created for glance
2017-10-27 23:54:58,890 [salt.loaded.int.module.cmdmod][INFO    ][526] Executing command 'gluster --version' in directory '/root'
2017-10-27 23:54:58,898 [salt.loaded.int.module.cmdmod][INFO    ][526] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 23:54:58,945 [salt.loaded.int.module.cmdmod][INFO    ][526] Executing command 'gluster --version' in directory '/root'
2017-10-27 23:54:58,954 [salt.loaded.int.module.cmdmod][INFO    ][526] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 23:54:59,013 [salt.state       ][INFO    ][526] Volume glance already exists and is started.
2017-10-27 23:54:59,014 [salt.state       ][INFO    ][526] Completed state [glance] at time 23:54:59.013673 duration_in_ms=124.403
2017-10-27 23:54:59,016 [salt.state       ][INFO    ][526] Running state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 23:54:59.016176
2017-10-27 23:54:59,016 [salt.state       ][INFO    ][526] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'
2017-10-27 23:54:59,017 [salt.loaded.int.module.cmdmod][INFO    ][526] Executing command 'gluster volume info 'glance' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-10-27 23:54:59,064 [salt.state       ][INFO    ][526] unless execution succeeded
2017-10-27 23:54:59,064 [salt.state       ][INFO    ][526] Completed state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 23:54:59.063810 duration_in_ms=47.632
2017-10-27 23:54:59,064 [salt.state       ][INFO    ][526] Running state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 23:54:59.064264
2017-10-27 23:54:59,064 [salt.state       ][INFO    ][526] Executing state cmd.run for gluster volume set 'glance' 'network.remote-dio' 'True'
2017-10-27 23:54:59,065 [salt.loaded.int.module.cmdmod][INFO    ][526] Executing command 'gluster volume info 'glance' | grep 'network.remote-dio: True'' in directory '/root'
2017-10-27 23:54:59,112 [salt.state       ][INFO    ][526] unless execution succeeded
2017-10-27 23:54:59,112 [salt.state       ][INFO    ][526] Completed state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 23:54:59.112403 duration_in_ms=48.138
2017-10-27 23:54:59,113 [salt.state       ][INFO    ][526] Running state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 23:54:59.112847
2017-10-27 23:54:59,113 [salt.state       ][INFO    ][526] Executing state cmd.run for gluster volume set 'glance' 'nfs.disable' 'True'
2017-10-27 23:54:59,113 [salt.loaded.int.module.cmdmod][INFO    ][526] Executing command 'gluster volume info 'glance' | grep 'nfs.disable: True'' in directory '/root'
2017-10-27 23:54:59,165 [salt.state       ][INFO    ][526] unless execution succeeded
2017-10-27 23:54:59,165 [salt.state       ][INFO    ][526] Completed state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 23:54:59.165215 duration_in_ms=52.367
2017-10-27 23:54:59,166 [salt.state       ][INFO    ][526] Running state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 23:54:59.165655
2017-10-27 23:54:59,166 [salt.state       ][INFO    ][526] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'
2017-10-27 23:54:59,166 [salt.loaded.int.module.cmdmod][INFO    ][526] Executing command 'gluster volume info 'glance' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-10-27 23:54:59,213 [salt.state       ][INFO    ][526] unless execution succeeded
2017-10-27 23:54:59,214 [salt.state       ][INFO    ][526] Completed state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 23:54:59.213563 duration_in_ms=47.908
2017-10-27 23:54:59,214 [salt.state       ][INFO    ][526] Running state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 23:54:59.213996
2017-10-27 23:54:59,214 [salt.state       ][INFO    ][526] Executing state cmd.run for gluster volume set 'glance' 'cluster.readdir-optimize' 'True'
2017-10-27 23:54:59,215 [salt.loaded.int.module.cmdmod][INFO    ][526] Executing command 'gluster volume info 'glance' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-10-27 23:54:59,261 [salt.state       ][INFO    ][526] unless execution succeeded
2017-10-27 23:54:59,262 [salt.state       ][INFO    ][526] Completed state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 23:54:59.261638 duration_in_ms=47.641
2017-10-27 23:54:59,263 [salt.state       ][INFO    ][526] Running state [glance] at time 23:54:59.262518
2017-10-27 23:54:59,263 [salt.state       ][INFO    ][526] Executing state glusterfs.started for glance
2017-10-27 23:54:59,263 [salt.loaded.int.module.cmdmod][INFO    ][526] Executing command 'gluster --version' in directory '/root'
2017-10-27 23:54:59,272 [salt.loaded.int.module.cmdmod][INFO    ][526] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 23:54:59,318 [salt.loaded.int.module.cmdmod][INFO    ][526] Executing command 'gluster --version' in directory '/root'
2017-10-27 23:54:59,326 [salt.loaded.int.module.cmdmod][INFO    ][526] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 23:54:59,377 [salt.state       ][INFO    ][526] Volume glance is already started
2017-10-27 23:54:59,377 [salt.state       ][INFO    ][526] Completed state [glance] at time 23:54:59.376883 duration_in_ms=114.363
2017-10-27 23:54:59,378 [salt.state       ][INFO    ][526] Running state [keystone-keys] at time 23:54:59.377693
2017-10-27 23:54:59,378 [salt.state       ][INFO    ][526] Executing state glusterfs.created for keystone-keys
2017-10-27 23:54:59,378 [salt.loaded.int.module.cmdmod][INFO    ][526] Executing command 'gluster --version' in directory '/root'
2017-10-27 23:54:59,388 [salt.loaded.int.module.cmdmod][INFO    ][526] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 23:54:59,434 [salt.loaded.int.module.cmdmod][INFO    ][526] Executing command 'gluster --version' in directory '/root'
2017-10-27 23:54:59,443 [salt.loaded.int.module.cmdmod][INFO    ][526] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 23:54:59,493 [salt.state       ][INFO    ][526] Volume keystone-keys already exists and is started.
2017-10-27 23:54:59,493 [salt.state       ][INFO    ][526] Completed state [keystone-keys] at time 23:54:59.493021 duration_in_ms=115.328
2017-10-27 23:54:59,496 [salt.state       ][INFO    ][526] Running state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 23:54:59.495704
2017-10-27 23:54:59,496 [salt.state       ][INFO    ][526] Executing state cmd.run for gluster volume set 'keystone-keys' 'network.remote-dio' 'True'
2017-10-27 23:54:59,496 [salt.loaded.int.module.cmdmod][INFO    ][526] Executing command 'gluster volume info 'keystone-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-10-27 23:54:59,546 [salt.state       ][INFO    ][526] unless execution succeeded
2017-10-27 23:54:59,546 [salt.state       ][INFO    ][526] Completed state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 23:54:59.546006 duration_in_ms=50.302
2017-10-27 23:54:59,546 [salt.state       ][INFO    ][526] Running state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 23:54:59.546429
2017-10-27 23:54:59,547 [salt.state       ][INFO    ][526] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-10-27 23:54:59,547 [salt.loaded.int.module.cmdmod][INFO    ][526] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-10-27 23:54:59,594 [salt.state       ][INFO    ][526] unless execution succeeded
2017-10-27 23:54:59,595 [salt.state       ][INFO    ][526] Completed state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 23:54:59.594616 duration_in_ms=48.187
2017-10-27 23:54:59,595 [salt.state       ][INFO    ][526] Running state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 23:54:59.595034
2017-10-27 23:54:59,595 [salt.state       ][INFO    ][526] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'
2017-10-27 23:54:59,596 [salt.loaded.int.module.cmdmod][INFO    ][526] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-10-27 23:54:59,643 [salt.state       ][INFO    ][526] unless execution succeeded
2017-10-27 23:54:59,643 [salt.state       ][INFO    ][526] Completed state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 23:54:59.643380 duration_in_ms=48.346
2017-10-27 23:54:59,644 [salt.state       ][INFO    ][526] Running state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 23:54:59.643784
2017-10-27 23:54:59,644 [salt.state       ][INFO    ][526] Executing state cmd.run for gluster volume set 'keystone-keys' 'nfs.disable' 'True'
2017-10-27 23:54:59,644 [salt.loaded.int.module.cmdmod][INFO    ][526] Executing command 'gluster volume info 'keystone-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-10-27 23:54:59,693 [salt.state       ][INFO    ][526] unless execution succeeded
2017-10-27 23:54:59,694 [salt.state       ][INFO    ][526] Completed state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 23:54:59.693482 duration_in_ms=49.697
2017-10-27 23:54:59,694 [salt.state       ][INFO    ][526] Running state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 23:54:59.693900
2017-10-27 23:54:59,694 [salt.state       ][INFO    ][526] Executing state cmd.run for gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'
2017-10-27 23:54:59,695 [salt.loaded.int.module.cmdmod][INFO    ][526] Executing command 'gluster volume info 'keystone-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-10-27 23:54:59,742 [salt.state       ][INFO    ][526] unless execution succeeded
2017-10-27 23:54:59,742 [salt.state       ][INFO    ][526] Completed state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 23:54:59.742290 duration_in_ms=48.39
2017-10-27 23:54:59,743 [salt.state       ][INFO    ][526] Running state [keystone-keys] at time 23:54:59.743145
2017-10-27 23:54:59,743 [salt.state       ][INFO    ][526] Executing state glusterfs.started for keystone-keys
2017-10-27 23:54:59,744 [salt.loaded.int.module.cmdmod][INFO    ][526] Executing command 'gluster --version' in directory '/root'
2017-10-27 23:54:59,753 [salt.loaded.int.module.cmdmod][INFO    ][526] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 23:54:59,800 [salt.loaded.int.module.cmdmod][INFO    ][526] Executing command 'gluster --version' in directory '/root'
2017-10-27 23:54:59,809 [salt.loaded.int.module.cmdmod][INFO    ][526] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 23:54:59,861 [salt.state       ][INFO    ][526] Volume keystone-keys is already started
2017-10-27 23:54:59,861 [salt.state       ][INFO    ][526] Completed state [keystone-keys] at time 23:54:59.861412 duration_in_ms=118.265
2017-10-27 23:54:59,862 [salt.state       ][INFO    ][526] Running state [nova_instances] at time 23:54:59.862353
2017-10-27 23:54:59,863 [salt.state       ][INFO    ][526] Executing state glusterfs.created for nova_instances
2017-10-27 23:54:59,863 [salt.loaded.int.module.cmdmod][INFO    ][526] Executing command 'gluster --version' in directory '/root'
2017-10-27 23:54:59,871 [salt.loaded.int.module.cmdmod][INFO    ][526] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 23:54:59,917 [salt.loaded.int.module.cmdmod][INFO    ][526] Executing command 'gluster --version' in directory '/root'
2017-10-27 23:54:59,926 [salt.loaded.int.module.cmdmod][INFO    ][526] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 23:54:59,977 [salt.state       ][INFO    ][526] Volume nova_instances already exists and is started.
2017-10-27 23:54:59,977 [salt.state       ][INFO    ][526] Completed state [nova_instances] at time 23:54:59.977166 duration_in_ms=114.813
2017-10-27 23:54:59,980 [salt.state       ][INFO    ][526] Running state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 23:54:59.979889
2017-10-27 23:54:59,980 [salt.state       ][INFO    ][526] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'
2017-10-27 23:54:59,981 [salt.loaded.int.module.cmdmod][INFO    ][526] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-10-27 23:55:00,028 [salt.state       ][INFO    ][526] unless execution succeeded
2017-10-27 23:55:00,028 [salt.state       ][INFO    ][526] Completed state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 23:55:00.028292 duration_in_ms=48.403
2017-10-27 23:55:00,029 [salt.state       ][INFO    ][526] Running state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'On'] at time 23:55:00.028731
2017-10-27 23:55:00,029 [salt.state       ][INFO    ][526] Executing state cmd.run for gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'On'
2017-10-27 23:55:00,029 [salt.loaded.int.module.cmdmod][INFO    ][526] Executing command 'gluster volume info 'nova_instances' | grep 'cluster.readdir-optimize: On'' in directory '/root'
2017-10-27 23:55:00,078 [salt.state       ][INFO    ][526] unless execution succeeded
2017-10-27 23:55:00,078 [salt.state       ][INFO    ][526] Completed state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'On'] at time 23:55:00.078254 duration_in_ms=49.522
2017-10-27 23:55:00,079 [salt.state       ][INFO    ][526] Running state [gluster volume set 'nova_instances' 'network.remote-dio' 'On'] at time 23:55:00.078772
2017-10-27 23:55:00,079 [salt.state       ][INFO    ][526] Executing state cmd.run for gluster volume set 'nova_instances' 'network.remote-dio' 'On'
2017-10-27 23:55:00,080 [salt.loaded.int.module.cmdmod][INFO    ][526] Executing command 'gluster volume info 'nova_instances' | grep 'network.remote-dio: On'' in directory '/root'
2017-10-27 23:55:00,128 [salt.state       ][INFO    ][526] unless execution succeeded
2017-10-27 23:55:00,129 [salt.state       ][INFO    ][526] Completed state [gluster volume set 'nova_instances' 'network.remote-dio' 'On'] at time 23:55:00.128489 duration_in_ms=49.716
2017-10-27 23:55:00,129 [salt.state       ][INFO    ][526] Running state [gluster volume set 'nova_instances' 'nfs.disable' 'On'] at time 23:55:00.128952
2017-10-27 23:55:00,129 [salt.state       ][INFO    ][526] Executing state cmd.run for gluster volume set 'nova_instances' 'nfs.disable' 'On'
2017-10-27 23:55:00,130 [salt.loaded.int.module.cmdmod][INFO    ][526] Executing command 'gluster volume info 'nova_instances' | grep 'nfs.disable: On'' in directory '/root'
2017-10-27 23:55:00,178 [salt.state       ][INFO    ][526] unless execution succeeded
2017-10-27 23:55:00,178 [salt.state       ][INFO    ][526] Completed state [gluster volume set 'nova_instances' 'nfs.disable' 'On'] at time 23:55:00.177898 duration_in_ms=48.946
2017-10-27 23:55:00,178 [salt.state       ][INFO    ][526] Running state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 23:55:00.178354
2017-10-27 23:55:00,179 [salt.state       ][INFO    ][526] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'
2017-10-27 23:55:00,179 [salt.loaded.int.module.cmdmod][INFO    ][526] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-10-27 23:55:00,231 [salt.state       ][INFO    ][526] unless execution succeeded
2017-10-27 23:55:00,231 [salt.state       ][INFO    ][526] Completed state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 23:55:00.230766 duration_in_ms=52.411
2017-10-27 23:55:00,232 [salt.state       ][INFO    ][526] Running state [nova_instances] at time 23:55:00.231656
2017-10-27 23:55:00,232 [salt.state       ][INFO    ][526] Executing state glusterfs.started for nova_instances
2017-10-27 23:55:00,232 [salt.loaded.int.module.cmdmod][INFO    ][526] Executing command 'gluster --version' in directory '/root'
2017-10-27 23:55:00,240 [salt.loaded.int.module.cmdmod][INFO    ][526] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 23:55:00,287 [salt.loaded.int.module.cmdmod][INFO    ][526] Executing command 'gluster --version' in directory '/root'
2017-10-27 23:55:00,296 [salt.loaded.int.module.cmdmod][INFO    ][526] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 23:55:00,348 [salt.state       ][INFO    ][526] Volume nova_instances is already started
2017-10-27 23:55:00,349 [salt.state       ][INFO    ][526] Completed state [nova_instances] at time 23:55:00.348542 duration_in_ms=116.884
2017-10-27 23:55:00,349 [salt.state       ][INFO    ][526] Running state [keystone-credential-keys] at time 23:55:00.349380
2017-10-27 23:55:00,350 [salt.state       ][INFO    ][526] Executing state glusterfs.created for keystone-credential-keys
2017-10-27 23:55:00,350 [salt.loaded.int.module.cmdmod][INFO    ][526] Executing command 'gluster --version' in directory '/root'
2017-10-27 23:55:00,358 [salt.loaded.int.module.cmdmod][INFO    ][526] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 23:55:00,405 [salt.loaded.int.module.cmdmod][INFO    ][526] Executing command 'gluster --version' in directory '/root'
2017-10-27 23:55:00,414 [salt.loaded.int.module.cmdmod][INFO    ][526] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 23:55:00,466 [salt.state       ][INFO    ][526] Volume keystone-credential-keys already exists and is started.
2017-10-27 23:55:00,466 [salt.state       ][INFO    ][526] Completed state [keystone-credential-keys] at time 23:55:00.466332 duration_in_ms=116.95
2017-10-27 23:55:00,469 [salt.state       ][INFO    ][526] Running state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 23:55:00.469315
2017-10-27 23:55:00,470 [salt.state       ][INFO    ][526] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'
2017-10-27 23:55:00,470 [salt.loaded.int.module.cmdmod][INFO    ][526] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-10-27 23:55:00,521 [salt.state       ][INFO    ][526] unless execution succeeded
2017-10-27 23:55:00,521 [salt.state       ][INFO    ][526] Completed state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 23:55:00.520702 duration_in_ms=51.386
2017-10-27 23:55:00,521 [salt.state       ][INFO    ][526] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 23:55:00.521123
2017-10-27 23:55:00,521 [salt.state       ][INFO    ][526] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-10-27 23:55:00,522 [salt.loaded.int.module.cmdmod][INFO    ][526] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-10-27 23:55:00,570 [salt.state       ][INFO    ][526] unless execution succeeded
2017-10-27 23:55:00,570 [salt.state       ][INFO    ][526] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 23:55:00.569919 duration_in_ms=48.796
2017-10-27 23:55:00,570 [salt.state       ][INFO    ][526] Running state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 23:55:00.570354
2017-10-27 23:55:00,571 [salt.state       ][INFO    ][526] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'
2017-10-27 23:55:00,571 [salt.loaded.int.module.cmdmod][INFO    ][526] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-10-27 23:55:00,619 [salt.state       ][INFO    ][526] unless execution succeeded
2017-10-27 23:55:00,619 [salt.state       ][INFO    ][526] Completed state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 23:55:00.619239 duration_in_ms=48.885
2017-10-27 23:55:00,620 [salt.state       ][INFO    ][526] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 23:55:00.619675
2017-10-27 23:55:00,620 [salt.state       ][INFO    ][526] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'
2017-10-27 23:55:00,620 [salt.loaded.int.module.cmdmod][INFO    ][526] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-10-27 23:55:00,668 [salt.state       ][INFO    ][526] unless execution succeeded
2017-10-27 23:55:00,668 [salt.state       ][INFO    ][526] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 23:55:00.668001 duration_in_ms=48.326
2017-10-27 23:55:00,669 [salt.state       ][INFO    ][526] Running state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 23:55:00.668483
2017-10-27 23:55:00,669 [salt.state       ][INFO    ][526] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'
2017-10-27 23:55:00,669 [salt.loaded.int.module.cmdmod][INFO    ][526] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-10-27 23:55:00,718 [salt.state       ][INFO    ][526] unless execution succeeded
2017-10-27 23:55:00,719 [salt.state       ][INFO    ][526] Completed state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 23:55:00.718813 duration_in_ms=50.33
2017-10-27 23:55:00,720 [salt.state       ][INFO    ][526] Running state [keystone-credential-keys] at time 23:55:00.720155
2017-10-27 23:55:00,721 [salt.state       ][INFO    ][526] Executing state glusterfs.started for keystone-credential-keys
2017-10-27 23:55:00,721 [salt.loaded.int.module.cmdmod][INFO    ][526] Executing command 'gluster --version' in directory '/root'
2017-10-27 23:55:00,730 [salt.loaded.int.module.cmdmod][INFO    ][526] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 23:55:00,778 [salt.loaded.int.module.cmdmod][INFO    ][526] Executing command 'gluster --version' in directory '/root'
2017-10-27 23:55:00,787 [salt.loaded.int.module.cmdmod][INFO    ][526] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-27 23:55:00,838 [salt.state       ][INFO    ][526] Volume keystone-credential-keys is already started
2017-10-27 23:55:00,838 [salt.state       ][INFO    ][526] Completed state [keystone-credential-keys] at time 23:55:00.838336 duration_in_ms=118.181
2017-10-27 23:55:00,841 [salt.minion      ][INFO    ][526] Returning information for job: 20171027235457256643
2017-10-27 23:55:02,072 [salt.minion      ][INFO    ][23612] User sudo_ubuntu Executing command test.ping with jid 20171027235502063823
2017-10-27 23:55:02,088 [salt.minion      ][INFO    ][916] Starting a new job with PID 916
2017-10-27 23:55:02,115 [salt.minion      ][INFO    ][916] Returning information for job: 20171027235502063823
2017-10-27 23:55:02,758 [salt.minion      ][INFO    ][23612] User sudo_ubuntu Executing command cmd.run with jid 20171027235502750411
2017-10-27 23:55:02,773 [salt.minion      ][INFO    ][923] Starting a new job with PID 923
2017-10-27 23:55:02,779 [salt.loaded.int.module.cmdmod][INFO    ][923] Executing command 'gluster peer status; gluster volume status' in directory '/root'
2017-10-27 23:55:02,892 [salt.minion      ][INFO    ][923] Returning information for job: 20171027235502750411
2017-10-28 00:10:13,750 [salt.utils.schedule][INFO    ][23612] Running scheduled job: __mine_interval
2017-10-28 00:23:54,762 [salt.minion      ][INFO    ][23612] User sudo_ubuntu Executing command cp.push_dir with jid 20171028002354758856
2017-10-28 00:23:54,784 [salt.minion      ][INFO    ][1282] Starting a new job with PID 1282
