2017-09-14 00:59:32,432 [salt.cli.daemons ][WARNING ][2524] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-09-14 00:59:46,606 [salt.utils.parsers][WARNING ][2524] Minion received a SIGTERM. Exiting.
2017-09-14 01:02:11,517 [salt.cli.daemons ][WARNING ][3146] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-09-14 01:05:07,516 [py.warnings      ][WARNING ][15375] /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-09-14 01:06:01,786 [salt.state       ][ERROR   ][15375] Module function virtng.init is not available
2017-09-14 01:06:01,830 [salt.state       ][ERROR   ][15375] Module function virt.set_autostart threw an exception. Exception: No virtual machines found.
2017-09-14 01:06:01,873 [salt.state       ][ERROR   ][15375] Module function virtng.init is not available
2017-09-14 01:06:01,916 [salt.state       ][ERROR   ][15375] Module function virt.set_autostart threw an exception. Exception: No virtual machines found.
2017-09-14 01:06:01,963 [salt.state       ][ERROR   ][15375] Module function virtng.init is not available
2017-09-14 01:06:02,006 [salt.state       ][ERROR   ][15375] Module function virt.set_autostart threw an exception. Exception: No virtual machines found.
2017-09-14 01:06:02,054 [salt.state       ][ERROR   ][15375] Module function virtng.init is not available
2017-09-14 01:06:02,097 [salt.state       ][ERROR   ][15375] Module function virt.set_autostart threw an exception. Exception: No virtual machines found.
2017-09-14 01:06:02,112 [salt.loaded.int.module.cmdmod][ERROR   ][15375] 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-09-14 01:06:04,438 [salt.loaded.int.module.cmdmod][INFO    ][21483] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2017-09-14 01:06:04,452 [salt.loaded.int.module.cmdmod][INFO    ][21483] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2017-09-14 01:06:04,476 [salt.loaded.int.module.cmdmod][INFO    ][21483] Executing command ['systemd-run', '--scope', 'systemctl', 'restart', 'salt-minion.service'] in directory '/root'
2017-09-14 01:06:04,494 [salt.utils.parsers][WARNING ][3146] Minion received a SIGTERM. Exiting.
2017-09-14 01:06:04,929 [salt.cli.daemons ][INFO    ][21560] Setting up the Salt Minion "kvm03.baremetal-mcp-ocata-ovs-ha.local"
2017-09-14 01:06:05,390 [salt.minion      ][INFO    ][21560] Creating minion process manager
2017-09-14 01:06:05,391 [salt.cli.daemons ][WARNING ][21560] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-09-14 01:06:05,391 [salt.cli.daemons ][INFO    ][21560] The Salt Minion is starting up
2017-09-14 01:06:05,392 [salt.minion      ][INFO    ][21560] Minion is starting as user 'root'
2017-09-14 01:06:05,392 [salt.utils.event ][INFO    ][21560] Starting pull socket on /var/run/salt/minion/minion_event_98ff1e569f_pull.ipc
2017-09-14 01:06:06,221 [salt.loaded.int.module.cmdmod][INFO    ][21560] Executing command ['date', '+%z'] in directory '/root'
2017-09-14 01:06:06,239 [salt.utils.schedule][INFO    ][21560] Updating job settings for scheduled job: __mine_interval
2017-09-14 01:06:06,245 [salt.minion      ][INFO    ][21560] Added mine.update to scheduler
2017-09-14 01:06:06,281 [salt.minion      ][INFO    ][21560] Minion is ready to receive requests!
2017-09-14 01:06:07,282 [salt.utils.schedule][INFO    ][21560] Running scheduled job: __mine_interval
2017-09-14 01:07:39,056 [salt.minion      ][INFO    ][21560] User sudo_ubuntu Executing command saltutil.sync_all with jid 20170914010739051452
2017-09-14 01:07:39,078 [salt.minion      ][INFO    ][21663] Starting a new job with PID 21663
2017-09-14 01:07:41,589 [salt.state       ][INFO    ][21663] Loading fresh modules for state activity
2017-09-14 01:07:41,629 [salt.state       ][ERROR   ][21663] No contents found in top file
2017-09-14 01:07:41,630 [salt.utils.extmods][INFO    ][21663] Creating module dir '/var/cache/salt/minion/extmods/beacons'
2017-09-14 01:07:41,636 [salt.utils.extmods][INFO    ][21663] Syncing beacons for environment 'base'
2017-09-14 01:07:41,637 [salt.utils.extmods][INFO    ][21663] Loading cache from salt://_beacons, for base)
2017-09-14 01:07:41,637 [salt.fileclient  ][INFO    ][21663] Caching directory '_beacons/' for environment 'base'
2017-09-14 01:07:41,668 [salt.utils.extmods][INFO    ][21663] Creating module dir '/var/cache/salt/minion/extmods/modules'
2017-09-14 01:07:41,673 [salt.utils.extmods][INFO    ][21663] Syncing modules for environment 'base'
2017-09-14 01:07:41,673 [salt.utils.extmods][INFO    ][21663] Loading cache from salt://_modules, for base)
2017-09-14 01:07:41,674 [salt.fileclient  ][INFO    ][21663] Caching directory '_modules/' for environment 'base'
2017-09-14 01:07:41,716 [salt.fileclient  ][INFO    ][21663] Fetching file from saltenv 'base', ** done ** '_modules/ceph_ng.py'
2017-09-14 01:07:41,731 [salt.fileclient  ][INFO    ][21663] Fetching file from saltenv 'base', ** done ** '_modules/cinderng.py'
2017-09-14 01:07:41,745 [salt.fileclient  ][INFO    ][21663] Fetching file from saltenv 'base', ** done ** '_modules/contrail.py'
2017-09-14 01:07:41,757 [salt.fileclient  ][INFO    ][21663] Fetching file from saltenv 'base', ** done ** '_modules/creds.py'
2017-09-14 01:07:41,771 [salt.fileclient  ][INFO    ][21663] Fetching file from saltenv 'base', ** done ** '_modules/devops_utils.py'
2017-09-14 01:07:41,784 [salt.fileclient  ][INFO    ][21663] Fetching file from saltenv 'base', ** done ** '_modules/encode_json.py'
2017-09-14 01:07:41,797 [salt.fileclient  ][INFO    ][21663] Fetching file from saltenv 'base', ** done ** '_modules/gerrit.py'
2017-09-14 01:07:41,810 [salt.fileclient  ][INFO    ][21663] Fetching file from saltenv 'base', ** done ** '_modules/glanceng.py'
2017-09-14 01:07:41,824 [salt.fileclient  ][INFO    ][21663] Fetching file from saltenv 'base', ** done ** '_modules/heat.py'
2017-09-14 01:07:41,836 [salt.fileclient  ][INFO    ][21663] Fetching file from saltenv 'base', ** done ** '_modules/heka_alarming.py'
2017-09-14 01:07:41,850 [salt.fileclient  ][INFO    ][21663] Fetching file from saltenv 'base', ** done ** '_modules/helm.py'
2017-09-14 01:07:41,866 [salt.fileclient  ][INFO    ][21663] Fetching file from saltenv 'base', ** done ** '_modules/jenkins_common.py'
2017-09-14 01:07:41,879 [salt.fileclient  ][INFO    ][21663] Fetching file from saltenv 'base', ** done ** '_modules/keystone_policy.py'
2017-09-14 01:07:41,892 [salt.fileclient  ][INFO    ][21663] Fetching file from saltenv 'base', ** done ** '_modules/linux_hosts.py'
2017-09-14 01:07:41,906 [salt.fileclient  ][INFO    ][21663] Fetching file from saltenv 'base', ** done ** '_modules/linux_netlink.py'
2017-09-14 01:07:41,920 [salt.fileclient  ][INFO    ][21663] Fetching file from saltenv 'base', ** done ** '_modules/maas.py'
2017-09-14 01:07:41,934 [salt.fileclient  ][INFO    ][21663] Fetching file from saltenv 'base', ** done ** '_modules/maas_client.py'
2017-09-14 01:07:41,948 [salt.fileclient  ][INFO    ][21663] Fetching file from saltenv 'base', ** done ** '_modules/multipart.py'
2017-09-14 01:07:41,961 [salt.fileclient  ][INFO    ][21663] Fetching file from saltenv 'base', ** done ** '_modules/nagios_alarming.py'
2017-09-14 01:07:41,976 [salt.fileclient  ][INFO    ][21663] Fetching file from saltenv 'base', ** done ** '_modules/neutronng.py'
2017-09-14 01:07:41,994 [salt.fileclient  ][INFO    ][21663] Fetching file from saltenv 'base', ** done ** '_modules/novang.py'
2017-09-14 01:07:42,009 [salt.fileclient  ][INFO    ][21663] Fetching file from saltenv 'base', ** done ** '_modules/reclass.py'
2017-09-14 01:07:42,025 [salt.fileclient  ][INFO    ][21663] Fetching file from saltenv 'base', ** done ** '_modules/rsyslog_util.py'
2017-09-14 01:07:42,040 [salt.fileclient  ][INFO    ][21663] Fetching file from saltenv 'base', ** done ** '_modules/rundeck.py'
2017-09-14 01:07:42,055 [salt.fileclient  ][INFO    ][21663] Fetching file from saltenv 'base', ** done ** '_modules/saltkey.py'
2017-09-14 01:07:42,068 [salt.fileclient  ][INFO    ][21663] Fetching file from saltenv 'base', ** done ** '_modules/saltresource.py'
2017-09-14 01:07:42,082 [salt.fileclient  ][INFO    ][21663] Fetching file from saltenv 'base', ** done ** '_modules/seedng.py'
2017-09-14 01:07:42,104 [salt.fileclient  ][INFO    ][21663] Fetching file from saltenv 'base', ** done ** '_modules/testing/credentials.py'
2017-09-14 01:07:42,117 [salt.fileclient  ][INFO    ][21663] Fetching file from saltenv 'base', ** done ** '_modules/testing/django.py'
2017-09-14 01:07:42,131 [salt.fileclient  ][INFO    ][21663] Fetching file from saltenv 'base', ** done ** '_modules/testing/django_client_proxy.py'
2017-09-14 01:07:42,147 [salt.fileclient  ][INFO    ][21663] Fetching file from saltenv 'base', ** done ** '_modules/utils.py'
2017-09-14 01:07:42,165 [salt.fileclient  ][INFO    ][21663] Fetching file from saltenv 'base', ** done ** '_modules/virtng.py'
2017-09-14 01:07:42,172 [salt.utils.extmods][INFO    ][21663] Copying '/var/cache/salt/minion/files/base/_modules/__init__.py' to '/var/cache/salt/minion/extmods/modules/__init__.py'
2017-09-14 01:07:42,172 [salt.utils.extmods][INFO    ][21663] Copying '/var/cache/salt/minion/files/base/_modules/ceph_ng.py' to '/var/cache/salt/minion/extmods/modules/ceph_ng.py'
2017-09-14 01:07:42,173 [salt.utils.extmods][INFO    ][21663] Copying '/var/cache/salt/minion/files/base/_modules/cinderng.py' to '/var/cache/salt/minion/extmods/modules/cinderng.py'
2017-09-14 01:07:42,173 [salt.utils.extmods][INFO    ][21663] Copying '/var/cache/salt/minion/files/base/_modules/contrail.py' to '/var/cache/salt/minion/extmods/modules/contrail.py'
2017-09-14 01:07:42,174 [salt.utils.extmods][INFO    ][21663] Copying '/var/cache/salt/minion/files/base/_modules/creds.py' to '/var/cache/salt/minion/extmods/modules/creds.py'
2017-09-14 01:07:42,174 [salt.utils.extmods][INFO    ][21663] Copying '/var/cache/salt/minion/files/base/_modules/devops_utils.py' to '/var/cache/salt/minion/extmods/modules/devops_utils.py'
2017-09-14 01:07:42,175 [salt.utils.extmods][INFO    ][21663] Copying '/var/cache/salt/minion/files/base/_modules/encode_json.py' to '/var/cache/salt/minion/extmods/modules/encode_json.py'
2017-09-14 01:07:42,175 [salt.utils.extmods][INFO    ][21663] Copying '/var/cache/salt/minion/files/base/_modules/gerrit.py' to '/var/cache/salt/minion/extmods/modules/gerrit.py'
2017-09-14 01:07:42,175 [salt.utils.extmods][INFO    ][21663] Copying '/var/cache/salt/minion/files/base/_modules/glanceng.py' to '/var/cache/salt/minion/extmods/modules/glanceng.py'
2017-09-14 01:07:42,176 [salt.utils.extmods][INFO    ][21663] Copying '/var/cache/salt/minion/files/base/_modules/heat.py' to '/var/cache/salt/minion/extmods/modules/heat.py'
2017-09-14 01:07:42,176 [salt.utils.extmods][INFO    ][21663] Copying '/var/cache/salt/minion/files/base/_modules/heka_alarming.py' to '/var/cache/salt/minion/extmods/modules/heka_alarming.py'
2017-09-14 01:07:42,177 [salt.utils.extmods][INFO    ][21663] Copying '/var/cache/salt/minion/files/base/_modules/helm.py' to '/var/cache/salt/minion/extmods/modules/helm.py'
2017-09-14 01:07:42,177 [salt.utils.extmods][INFO    ][21663] Copying '/var/cache/salt/minion/files/base/_modules/jenkins_common.py' to '/var/cache/salt/minion/extmods/modules/jenkins_common.py'
2017-09-14 01:07:42,178 [salt.utils.extmods][INFO    ][21663] Copying '/var/cache/salt/minion/files/base/_modules/keystone_policy.py' to '/var/cache/salt/minion/extmods/modules/keystone_policy.py'
2017-09-14 01:07:42,178 [salt.utils.extmods][INFO    ][21663] Copying '/var/cache/salt/minion/files/base/_modules/linux_hosts.py' to '/var/cache/salt/minion/extmods/modules/linux_hosts.py'
2017-09-14 01:07:42,179 [salt.utils.extmods][INFO    ][21663] Copying '/var/cache/salt/minion/files/base/_modules/linux_netlink.py' to '/var/cache/salt/minion/extmods/modules/linux_netlink.py'
2017-09-14 01:07:42,179 [salt.utils.extmods][INFO    ][21663] Copying '/var/cache/salt/minion/files/base/_modules/maas.py' to '/var/cache/salt/minion/extmods/modules/maas.py'
2017-09-14 01:07:42,180 [salt.utils.extmods][INFO    ][21663] Copying '/var/cache/salt/minion/files/base/_modules/maas_client.py' to '/var/cache/salt/minion/extmods/modules/maas_client.py'
2017-09-14 01:07:42,180 [salt.utils.extmods][INFO    ][21663] Copying '/var/cache/salt/minion/files/base/_modules/multipart.py' to '/var/cache/salt/minion/extmods/modules/multipart.py'
2017-09-14 01:07:42,181 [salt.utils.extmods][INFO    ][21663] Copying '/var/cache/salt/minion/files/base/_modules/nagios_alarming.py' to '/var/cache/salt/minion/extmods/modules/nagios_alarming.py'
2017-09-14 01:07:42,181 [salt.utils.extmods][INFO    ][21663] Copying '/var/cache/salt/minion/files/base/_modules/neutronng.py' to '/var/cache/salt/minion/extmods/modules/neutronng.py'
2017-09-14 01:07:42,182 [salt.utils.extmods][INFO    ][21663] Copying '/var/cache/salt/minion/files/base/_modules/novang.py' to '/var/cache/salt/minion/extmods/modules/novang.py'
2017-09-14 01:07:42,182 [salt.utils.extmods][INFO    ][21663] Copying '/var/cache/salt/minion/files/base/_modules/reclass.py' to '/var/cache/salt/minion/extmods/modules/reclass.py'
2017-09-14 01:07:42,183 [salt.utils.extmods][INFO    ][21663] Copying '/var/cache/salt/minion/files/base/_modules/rsyslog_util.py' to '/var/cache/salt/minion/extmods/modules/rsyslog_util.py'
2017-09-14 01:07:42,183 [salt.utils.extmods][INFO    ][21663] Copying '/var/cache/salt/minion/files/base/_modules/rundeck.py' to '/var/cache/salt/minion/extmods/modules/rundeck.py'
2017-09-14 01:07:42,183 [salt.utils.extmods][INFO    ][21663] Copying '/var/cache/salt/minion/files/base/_modules/saltkey.py' to '/var/cache/salt/minion/extmods/modules/saltkey.py'
2017-09-14 01:07:42,184 [salt.utils.extmods][INFO    ][21663] Copying '/var/cache/salt/minion/files/base/_modules/saltresource.py' to '/var/cache/salt/minion/extmods/modules/saltresource.py'
2017-09-14 01:07:42,184 [salt.utils.extmods][INFO    ][21663] Copying '/var/cache/salt/minion/files/base/_modules/seedng.py' to '/var/cache/salt/minion/extmods/modules/seedng.py'
2017-09-14 01:07:42,185 [salt.utils.extmods][INFO    ][21663] Copying '/var/cache/salt/minion/files/base/_modules/testing/__init__.py' to '/var/cache/salt/minion/extmods/modules/testing/__init__.py'
2017-09-14 01:07:42,185 [salt.utils.extmods][INFO    ][21663] Copying '/var/cache/salt/minion/files/base/_modules/testing/credentials.py' to '/var/cache/salt/minion/extmods/modules/testing/credentials.py'
2017-09-14 01:07:42,186 [salt.utils.extmods][INFO    ][21663] Copying '/var/cache/salt/minion/files/base/_modules/testing/django.py' to '/var/cache/salt/minion/extmods/modules/testing/django.py'
2017-09-14 01:07:42,186 [salt.utils.extmods][INFO    ][21663] 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-09-14 01:07:42,187 [salt.utils.extmods][INFO    ][21663] Copying '/var/cache/salt/minion/files/base/_modules/utils.py' to '/var/cache/salt/minion/extmods/modules/utils.py'
2017-09-14 01:07:42,187 [salt.utils.extmods][INFO    ][21663] Copying '/var/cache/salt/minion/files/base/_modules/virtng.py' to '/var/cache/salt/minion/extmods/modules/virtng.py'
2017-09-14 01:07:42,189 [salt.utils.extmods][INFO    ][21663] Creating module dir '/var/cache/salt/minion/extmods/states'
2017-09-14 01:07:42,194 [salt.utils.extmods][INFO    ][21663] Syncing states for environment 'base'
2017-09-14 01:07:42,194 [salt.utils.extmods][INFO    ][21663] Loading cache from salt://_states, for base)
2017-09-14 01:07:42,194 [salt.fileclient  ][INFO    ][21663] Caching directory '_states/' for environment 'base'
2017-09-14 01:07:42,240 [salt.fileclient  ][INFO    ][21663] Fetching file from saltenv 'base', ** done ** '_states/cinderng.py'
2017-09-14 01:07:42,254 [salt.fileclient  ][INFO    ][21663] Fetching file from saltenv 'base', ** done ** '_states/contrail.py'
2017-09-14 01:07:42,266 [salt.fileclient  ][INFO    ][21663] Fetching file from saltenv 'base', ** done ** '_states/gerrit.py'
2017-09-14 01:07:42,280 [salt.fileclient  ][INFO    ][21663] Fetching file from saltenv 'base', ** done ** '_states/glanceng.py'
2017-09-14 01:07:42,294 [salt.fileclient  ][INFO    ][21663] Fetching file from saltenv 'base', ** done ** '_states/grafana3_dashboard.py'
2017-09-14 01:07:42,308 [salt.fileclient  ][INFO    ][21663] Fetching file from saltenv 'base', ** done ** '_states/grafana3_datasource.py'
2017-09-14 01:07:42,321 [salt.fileclient  ][INFO    ][21663] Fetching file from saltenv 'base', ** done ** '_states/heat.py'
2017-09-14 01:07:42,335 [salt.fileclient  ][INFO    ][21663] Fetching file from saltenv 'base', ** done ** '_states/helm_release.py'
2017-09-14 01:07:42,349 [salt.fileclient  ][INFO    ][21663] Fetching file from saltenv 'base', ** done ** '_states/jenkins_approval.py'
2017-09-14 01:07:42,365 [salt.fileclient  ][INFO    ][21663] Fetching file from saltenv 'base', ** done ** '_states/jenkins_artifactory.py'
2017-09-14 01:07:42,378 [salt.fileclient  ][INFO    ][21663] Fetching file from saltenv 'base', ** done ** '_states/jenkins_credential.py'
2017-09-14 01:07:42,391 [salt.fileclient  ][INFO    ][21663] Fetching file from saltenv 'base', ** done ** '_states/jenkins_job.py'
2017-09-14 01:07:42,405 [salt.fileclient  ][INFO    ][21663] Fetching file from saltenv 'base', ** done ** '_states/jenkins_lib.py'
2017-09-14 01:07:42,419 [salt.fileclient  ][INFO    ][21663] Fetching file from saltenv 'base', ** done ** '_states/jenkins_node.py'
2017-09-14 01:07:42,432 [salt.fileclient  ][INFO    ][21663] Fetching file from saltenv 'base', ** done ** '_states/jenkins_plugin.py'
2017-09-14 01:07:42,445 [salt.fileclient  ][INFO    ][21663] Fetching file from saltenv 'base', ** done ** '_states/jenkins_security.py'
2017-09-14 01:07:42,458 [salt.fileclient  ][INFO    ][21663] Fetching file from saltenv 'base', ** done ** '_states/jenkins_slack.py'
2017-09-14 01:07:42,472 [salt.fileclient  ][INFO    ][21663] Fetching file from saltenv 'base', ** done ** '_states/jenkins_smtp.py'
2017-09-14 01:07:42,485 [salt.fileclient  ][INFO    ][21663] Fetching file from saltenv 'base', ** done ** '_states/jenkins_theme.py'
2017-09-14 01:07:42,499 [salt.fileclient  ][INFO    ][21663] Fetching file from saltenv 'base', ** done ** '_states/jenkins_user.py'
2017-09-14 01:07:42,513 [salt.fileclient  ][INFO    ][21663] Fetching file from saltenv 'base', ** done ** '_states/jenkins_view.py'
2017-09-14 01:07:42,528 [salt.fileclient  ][INFO    ][21663] Fetching file from saltenv 'base', ** done ** '_states/keystone_policy.py'
2017-09-14 01:07:42,541 [salt.fileclient  ][INFO    ][21663] Fetching file from saltenv 'base', ** done ** '_states/kibana_object.py'
2017-09-14 01:07:42,565 [salt.fileclient  ][INFO    ][21663] Fetching file from saltenv 'base', ** done ** '_states/neutronng.py'
2017-09-14 01:07:42,579 [salt.fileclient  ][INFO    ][21663] Fetching file from saltenv 'base', ** done ** '_states/novang.py'
2017-09-14 01:07:42,592 [salt.fileclient  ][INFO    ][21663] Fetching file from saltenv 'base', ** done ** '_states/reclass.py'
2017-09-14 01:07:42,605 [salt.fileclient  ][INFO    ][21663] Fetching file from saltenv 'base', ** done ** '_states/rundeck_project.py'
2017-09-14 01:07:42,618 [salt.fileclient  ][INFO    ][21663] Fetching file from saltenv 'base', ** done ** '_states/rundeck_scm.py'
2017-09-14 01:07:42,631 [salt.fileclient  ][INFO    ][21663] Fetching file from saltenv 'base', ** done ** '_states/rundeck_secret.py'
2017-09-14 01:07:42,637 [salt.utils.extmods][INFO    ][21663] Copying '/var/cache/salt/minion/files/base/_states/cinderng.py' to '/var/cache/salt/minion/extmods/states/cinderng.py'
2017-09-14 01:07:42,638 [salt.utils.extmods][INFO    ][21663] Copying '/var/cache/salt/minion/files/base/_states/contrail.py' to '/var/cache/salt/minion/extmods/states/contrail.py'
2017-09-14 01:07:42,638 [salt.utils.extmods][INFO    ][21663] Copying '/var/cache/salt/minion/files/base/_states/gerrit.py' to '/var/cache/salt/minion/extmods/states/gerrit.py'
2017-09-14 01:07:42,638 [salt.utils.extmods][INFO    ][21663] Copying '/var/cache/salt/minion/files/base/_states/glanceng.py' to '/var/cache/salt/minion/extmods/states/glanceng.py'
2017-09-14 01:07:42,639 [salt.utils.extmods][INFO    ][21663] Copying '/var/cache/salt/minion/files/base/_states/grafana3_dashboard.py' to '/var/cache/salt/minion/extmods/states/grafana3_dashboard.py'
2017-09-14 01:07:42,639 [salt.utils.extmods][INFO    ][21663] Copying '/var/cache/salt/minion/files/base/_states/grafana3_datasource.py' to '/var/cache/salt/minion/extmods/states/grafana3_datasource.py'
2017-09-14 01:07:42,640 [salt.utils.extmods][INFO    ][21663] Copying '/var/cache/salt/minion/files/base/_states/heat.py' to '/var/cache/salt/minion/extmods/states/heat.py'
2017-09-14 01:07:42,640 [salt.utils.extmods][INFO    ][21663] Copying '/var/cache/salt/minion/files/base/_states/helm_release.py' to '/var/cache/salt/minion/extmods/states/helm_release.py'
2017-09-14 01:07:42,641 [salt.utils.extmods][INFO    ][21663] Copying '/var/cache/salt/minion/files/base/_states/jenkins_approval.py' to '/var/cache/salt/minion/extmods/states/jenkins_approval.py'
2017-09-14 01:07:42,641 [salt.utils.extmods][INFO    ][21663] Copying '/var/cache/salt/minion/files/base/_states/jenkins_artifactory.py' to '/var/cache/salt/minion/extmods/states/jenkins_artifactory.py'
2017-09-14 01:07:42,641 [salt.utils.extmods][INFO    ][21663] Copying '/var/cache/salt/minion/files/base/_states/jenkins_credential.py' to '/var/cache/salt/minion/extmods/states/jenkins_credential.py'
2017-09-14 01:07:42,642 [salt.utils.extmods][INFO    ][21663] Copying '/var/cache/salt/minion/files/base/_states/jenkins_job.py' to '/var/cache/salt/minion/extmods/states/jenkins_job.py'
2017-09-14 01:07:42,642 [salt.utils.extmods][INFO    ][21663] Copying '/var/cache/salt/minion/files/base/_states/jenkins_lib.py' to '/var/cache/salt/minion/extmods/states/jenkins_lib.py'
2017-09-14 01:07:42,643 [salt.utils.extmods][INFO    ][21663] Copying '/var/cache/salt/minion/files/base/_states/jenkins_node.py' to '/var/cache/salt/minion/extmods/states/jenkins_node.py'
2017-09-14 01:07:42,643 [salt.utils.extmods][INFO    ][21663] Copying '/var/cache/salt/minion/files/base/_states/jenkins_plugin.py' to '/var/cache/salt/minion/extmods/states/jenkins_plugin.py'
2017-09-14 01:07:42,644 [salt.utils.extmods][INFO    ][21663] Copying '/var/cache/salt/minion/files/base/_states/jenkins_security.py' to '/var/cache/salt/minion/extmods/states/jenkins_security.py'
2017-09-14 01:07:42,644 [salt.utils.extmods][INFO    ][21663] Copying '/var/cache/salt/minion/files/base/_states/jenkins_slack.py' to '/var/cache/salt/minion/extmods/states/jenkins_slack.py'
2017-09-14 01:07:42,644 [salt.utils.extmods][INFO    ][21663] Copying '/var/cache/salt/minion/files/base/_states/jenkins_smtp.py' to '/var/cache/salt/minion/extmods/states/jenkins_smtp.py'
2017-09-14 01:07:42,645 [salt.utils.extmods][INFO    ][21663] Copying '/var/cache/salt/minion/files/base/_states/jenkins_theme.py' to '/var/cache/salt/minion/extmods/states/jenkins_theme.py'
2017-09-14 01:07:42,645 [salt.utils.extmods][INFO    ][21663] Copying '/var/cache/salt/minion/files/base/_states/jenkins_user.py' to '/var/cache/salt/minion/extmods/states/jenkins_user.py'
2017-09-14 01:07:42,646 [salt.utils.extmods][INFO    ][21663] Copying '/var/cache/salt/minion/files/base/_states/jenkins_view.py' to '/var/cache/salt/minion/extmods/states/jenkins_view.py'
2017-09-14 01:07:42,646 [salt.utils.extmods][INFO    ][21663] Copying '/var/cache/salt/minion/files/base/_states/keystone_policy.py' to '/var/cache/salt/minion/extmods/states/keystone_policy.py'
2017-09-14 01:07:42,647 [salt.utils.extmods][INFO    ][21663] Copying '/var/cache/salt/minion/files/base/_states/kibana_object.py' to '/var/cache/salt/minion/extmods/states/kibana_object.py'
2017-09-14 01:07:42,647 [salt.utils.extmods][INFO    ][21663] Copying '/var/cache/salt/minion/files/base/_states/maas_cluster.py' to '/var/cache/salt/minion/extmods/states/maas_cluster.py'
2017-09-14 01:07:42,647 [salt.utils.extmods][INFO    ][21663] Copying '/var/cache/salt/minion/files/base/_states/neutronng.py' to '/var/cache/salt/minion/extmods/states/neutronng.py'
2017-09-14 01:07:42,648 [salt.utils.extmods][INFO    ][21663] Copying '/var/cache/salt/minion/files/base/_states/novang.py' to '/var/cache/salt/minion/extmods/states/novang.py'
2017-09-14 01:07:42,648 [salt.utils.extmods][INFO    ][21663] Copying '/var/cache/salt/minion/files/base/_states/reclass.py' to '/var/cache/salt/minion/extmods/states/reclass.py'
2017-09-14 01:07:42,649 [salt.utils.extmods][INFO    ][21663] Copying '/var/cache/salt/minion/files/base/_states/rundeck_project.py' to '/var/cache/salt/minion/extmods/states/rundeck_project.py'
2017-09-14 01:07:42,649 [salt.utils.extmods][INFO    ][21663] Copying '/var/cache/salt/minion/files/base/_states/rundeck_scm.py' to '/var/cache/salt/minion/extmods/states/rundeck_scm.py'
2017-09-14 01:07:42,650 [salt.utils.extmods][INFO    ][21663] Copying '/var/cache/salt/minion/files/base/_states/rundeck_secret.py' to '/var/cache/salt/minion/extmods/states/rundeck_secret.py'
2017-09-14 01:07:42,652 [salt.utils.extmods][INFO    ][21663] Creating module dir '/var/cache/salt/minion/extmods/sdb'
2017-09-14 01:07:42,657 [salt.utils.extmods][INFO    ][21663] Syncing sdb for environment 'base'
2017-09-14 01:07:42,658 [salt.utils.extmods][INFO    ][21663] Loading cache from salt://_sdb, for base)
2017-09-14 01:07:42,658 [salt.fileclient  ][INFO    ][21663] Caching directory '_sdb/' for environment 'base'
2017-09-14 01:07:42,701 [salt.utils.extmods][INFO    ][21663] Creating module dir '/var/cache/salt/minion/extmods/grains'
2017-09-14 01:07:42,706 [salt.utils.extmods][INFO    ][21663] Syncing grains for environment 'base'
2017-09-14 01:07:42,707 [salt.utils.extmods][INFO    ][21663] Loading cache from salt://_grains, for base)
2017-09-14 01:07:42,707 [salt.fileclient  ][INFO    ][21663] Caching directory '_grains/' for environment 'base'
2017-09-14 01:07:42,762 [salt.fileclient  ][INFO    ][21663] Fetching file from saltenv 'base', ** done ** '_grains/ceilometer_policy.py'
2017-09-14 01:07:42,780 [salt.fileclient  ][INFO    ][21663] Fetching file from saltenv 'base', ** done ** '_grains/cinder_policy.py'
2017-09-14 01:07:42,794 [salt.fileclient  ][INFO    ][21663] Fetching file from saltenv 'base', ** done ** '_grains/docker_swarm.py'
2017-09-14 01:07:42,808 [salt.fileclient  ][INFO    ][21663] Fetching file from saltenv 'base', ** done ** '_grains/glance_policy.py'
2017-09-14 01:07:42,822 [salt.fileclient  ][INFO    ][21663] Fetching file from saltenv 'base', ** done ** '_grains/heat_policy.py'
2017-09-14 01:07:42,841 [salt.fileclient  ][INFO    ][21663] Fetching file from saltenv 'base', ** done ** '_grains/jenkins_plugins.py'
2017-09-14 01:07:42,854 [salt.fileclient  ][INFO    ][21663] Fetching file from saltenv 'base', ** done ** '_grains/keystone_policy.py'
2017-09-14 01:07:42,869 [salt.fileclient  ][INFO    ][21663] Fetching file from saltenv 'base', ** done ** '_grains/kubernetes.py'
2017-09-14 01:07:42,882 [salt.fileclient  ][INFO    ][21663] Fetching file from saltenv 'base', ** done ** '_grains/neutron_policy.py'
2017-09-14 01:07:42,895 [salt.fileclient  ][INFO    ][21663] Fetching file from saltenv 'base', ** done ** '_grains/nova_policy.py'
2017-09-14 01:07:42,908 [salt.fileclient  ][INFO    ][21663] Fetching file from saltenv 'base', ** done ** '_grains/ssh_fingerprints.py'
2017-09-14 01:07:42,915 [salt.utils.extmods][INFO    ][21663] Copying '/var/cache/salt/minion/files/base/_grains/ceilometer_policy.py' to '/var/cache/salt/minion/extmods/grains/ceilometer_policy.py'
2017-09-14 01:07:42,915 [salt.utils.extmods][INFO    ][21663] Copying '/var/cache/salt/minion/files/base/_grains/cinder_policy.py' to '/var/cache/salt/minion/extmods/grains/cinder_policy.py'
2017-09-14 01:07:42,916 [salt.utils.extmods][INFO    ][21663] Copying '/var/cache/salt/minion/files/base/_grains/docker_swarm.py' to '/var/cache/salt/minion/extmods/grains/docker_swarm.py'
2017-09-14 01:07:42,916 [salt.utils.extmods][INFO    ][21663] Copying '/var/cache/salt/minion/files/base/_grains/glance_policy.py' to '/var/cache/salt/minion/extmods/grains/glance_policy.py'
2017-09-14 01:07:42,917 [salt.utils.extmods][INFO    ][21663] Copying '/var/cache/salt/minion/files/base/_grains/heat_policy.py' to '/var/cache/salt/minion/extmods/grains/heat_policy.py'
2017-09-14 01:07:42,917 [salt.utils.extmods][INFO    ][21663] Copying '/var/cache/salt/minion/files/base/_grains/jenkins_plugins.py' to '/var/cache/salt/minion/extmods/grains/jenkins_plugins.py'
2017-09-14 01:07:42,918 [salt.utils.extmods][INFO    ][21663] Copying '/var/cache/salt/minion/files/base/_grains/keystone_policy.py' to '/var/cache/salt/minion/extmods/grains/keystone_policy.py'
2017-09-14 01:07:42,918 [salt.utils.extmods][INFO    ][21663] Copying '/var/cache/salt/minion/files/base/_grains/kubernetes.py' to '/var/cache/salt/minion/extmods/grains/kubernetes.py'
2017-09-14 01:07:42,919 [salt.utils.extmods][INFO    ][21663] Copying '/var/cache/salt/minion/files/base/_grains/neutron_policy.py' to '/var/cache/salt/minion/extmods/grains/neutron_policy.py'
2017-09-14 01:07:42,919 [salt.utils.extmods][INFO    ][21663] Copying '/var/cache/salt/minion/files/base/_grains/nova_policy.py' to '/var/cache/salt/minion/extmods/grains/nova_policy.py'
2017-09-14 01:07:42,920 [salt.utils.extmods][INFO    ][21663] Copying '/var/cache/salt/minion/files/base/_grains/ssh_fingerprints.py' to '/var/cache/salt/minion/extmods/grains/ssh_fingerprints.py'
2017-09-14 01:07:42,921 [salt.utils.extmods][INFO    ][21663] Creating module dir '/var/cache/salt/minion/extmods/renderers'
2017-09-14 01:07:42,926 [salt.utils.extmods][INFO    ][21663] Syncing renderers for environment 'base'
2017-09-14 01:07:42,926 [salt.utils.extmods][INFO    ][21663] Loading cache from salt://_renderers, for base)
2017-09-14 01:07:42,927 [salt.fileclient  ][INFO    ][21663] Caching directory '_renderers/' for environment 'base'
2017-09-14 01:07:42,971 [salt.utils.extmods][INFO    ][21663] Creating module dir '/var/cache/salt/minion/extmods/returners'
2017-09-14 01:07:42,976 [salt.utils.extmods][INFO    ][21663] Syncing returners for environment 'base'
2017-09-14 01:07:42,976 [salt.utils.extmods][INFO    ][21663] Loading cache from salt://_returners, for base)
2017-09-14 01:07:42,976 [salt.fileclient  ][INFO    ][21663] Caching directory '_returners/' for environment 'base'
2017-09-14 01:07:43,009 [salt.utils.extmods][INFO    ][21663] Creating module dir '/var/cache/salt/minion/extmods/output'
2017-09-14 01:07:43,014 [salt.utils.extmods][INFO    ][21663] Syncing output for environment 'base'
2017-09-14 01:07:43,014 [salt.utils.extmods][INFO    ][21663] Loading cache from salt://_output, for base)
2017-09-14 01:07:43,015 [salt.fileclient  ][INFO    ][21663] Caching directory '_output/' for environment 'base'
2017-09-14 01:07:43,049 [salt.utils.extmods][INFO    ][21663] Creating module dir '/var/cache/salt/minion/extmods/utils'
2017-09-14 01:07:43,053 [salt.utils.extmods][INFO    ][21663] Syncing utils for environment 'base'
2017-09-14 01:07:43,053 [salt.utils.extmods][INFO    ][21663] Loading cache from salt://_utils, for base)
2017-09-14 01:07:43,053 [salt.fileclient  ][INFO    ][21663] Caching directory '_utils/' for environment 'base'
2017-09-14 01:07:43,086 [salt.utils.extmods][INFO    ][21663] Creating module dir '/var/cache/salt/minion/extmods/log_handlers'
2017-09-14 01:07:43,090 [salt.utils.extmods][INFO    ][21663] Syncing log_handlers for environment 'base'
2017-09-14 01:07:43,090 [salt.utils.extmods][INFO    ][21663] Loading cache from salt://_log_handlers, for base)
2017-09-14 01:07:43,090 [salt.fileclient  ][INFO    ][21663] Caching directory '_log_handlers/' for environment 'base'
2017-09-14 01:07:43,128 [salt.utils.extmods][INFO    ][21663] Creating module dir '/var/cache/salt/minion/extmods/proxy'
2017-09-14 01:07:43,133 [salt.utils.extmods][INFO    ][21663] Syncing proxy for environment 'base'
2017-09-14 01:07:43,134 [salt.utils.extmods][INFO    ][21663] Loading cache from salt://_proxy, for base)
2017-09-14 01:07:43,134 [salt.fileclient  ][INFO    ][21663] Caching directory '_proxy/' for environment 'base'
2017-09-14 01:07:43,171 [salt.utils.extmods][INFO    ][21663] Creating module dir '/var/cache/salt/minion/extmods/engines'
2017-09-14 01:07:43,176 [salt.utils.extmods][INFO    ][21663] Syncing engines for environment 'base'
2017-09-14 01:07:43,176 [salt.utils.extmods][INFO    ][21663] Loading cache from salt://_engines, for base)
2017-09-14 01:07:43,176 [salt.fileclient  ][INFO    ][21663] Caching directory '_engines/' for environment 'base'
2017-09-14 01:07:43,224 [salt.minion      ][INFO    ][21663] Returning information for job: 20170914010739051452
2017-09-14 01:07:49,939 [salt.minion      ][INFO    ][21560] User sudo_ubuntu Executing command state.sls with jid 20170914010749936456
2017-09-14 01:07:49,960 [salt.minion      ][INFO    ][21758] Starting a new job with PID 21758
2017-09-14 01:07:50,391 [salt.state       ][INFO    ][21758] Loading fresh modules for state activity
2017-09-14 01:07:50,433 [salt.fileclient  ][INFO    ][21758] Fetching file from saltenv 'base', ** done ** 'salt/control/init.sls'
2017-09-14 01:07:50,459 [salt.fileclient  ][INFO    ][21758] Fetching file from saltenv 'base', ** done ** 'salt/control/virt.sls'
2017-09-14 01:07:50,601 [salt.fileclient  ][INFO    ][21758] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-09-14 01:07:50,682 [salt.fileclient  ][INFO    ][21758] Fetching file from saltenv 'base', ** done ** 'salt/minion/init.sls'
2017-09-14 01:07:50,698 [salt.fileclient  ][INFO    ][21758] Fetching file from saltenv 'base', ** done ** 'salt/minion/service.sls'
2017-09-14 01:07:50,726 [salt.fileclient  ][INFO    ][21758] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-09-14 01:07:50,789 [salt.fileclient  ][INFO    ][21758] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-09-14 01:07:50,811 [salt.fileclient  ][INFO    ][21758] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-09-14 01:07:50,863 [salt.fileclient  ][INFO    ][21758] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-09-14 01:07:50,884 [salt.fileclient  ][INFO    ][21758] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-09-14 01:07:50,899 [salt.fileclient  ][INFO    ][21758] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-09-14 01:07:50,917 [salt.fileclient  ][INFO    ][21758] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-09-14 01:07:50,927 [salt.loaded.int.module.cmdmod][INFO    ][21758] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-09-14 01:07:50,964 [salt.fileclient  ][INFO    ][21758] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-09-14 01:07:50,998 [py.warnings      ][WARNING ][21758] /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-09-14 01:07:50,999 [salt.loaded.int.module.cmdmod][INFO    ][21758] Executing command 'salt-minion --version' in directory '/root'
2017-09-14 01:07:51,392 [salt.fileclient  ][INFO    ][21758] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-09-14 01:07:51,415 [salt.fileclient  ][INFO    ][21758] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-09-14 01:07:51,741 [salt.fileclient  ][INFO    ][21758] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-09-14 01:07:51,759 [salt.fileclient  ][INFO    ][21758] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-09-14 01:07:51,841 [salt.fileclient  ][INFO    ][21758] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-09-14 01:07:51,893 [salt.fileclient  ][INFO    ][21758] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-09-14 01:07:51,987 [salt.fileclient  ][INFO    ][21758] Fetching file from saltenv 'base', ** done ** 'salt/minion/grains.sls'
2017-09-14 01:07:52,017 [salt.fileclient  ][INFO    ][21758] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-09-14 01:07:52,091 [salt.fileclient  ][INFO    ][21758] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-09-14 01:07:52,128 [salt.fileclient  ][INFO    ][21758] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-09-14 01:07:52,205 [salt.fileclient  ][INFO    ][21758] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-09-14 01:07:52,245 [salt.fileclient  ][INFO    ][21758] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-09-14 01:07:52,262 [salt.fileclient  ][INFO    ][21758] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-09-14 01:07:52,283 [salt.fileclient  ][INFO    ][21758] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-09-14 01:07:52,295 [salt.loaded.int.module.cmdmod][INFO    ][21758] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-09-14 01:07:52,331 [salt.fileclient  ][INFO    ][21758] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-09-14 01:07:52,368 [salt.loaded.int.module.cmdmod][INFO    ][21758] Executing command 'salt-minion --version' in directory '/root'
2017-09-14 01:07:52,761 [salt.fileclient  ][INFO    ][21758] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-09-14 01:07:52,785 [salt.fileclient  ][INFO    ][21758] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-09-14 01:07:52,805 [salt.fileclient  ][INFO    ][21758] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-09-14 01:07:52,821 [salt.fileclient  ][INFO    ][21758] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-09-14 01:07:52,899 [salt.fileclient  ][INFO    ][21758] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-09-14 01:07:52,948 [salt.fileclient  ][INFO    ][21758] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-09-14 01:07:53,052 [salt.fileclient  ][INFO    ][21758] Fetching file from saltenv 'base', ** done ** 'salt/minion/cert.sls'
2017-09-14 01:07:53,124 [salt.fileclient  ][INFO    ][21758] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-09-14 01:07:53,633 [salt.state       ][INFO    ][21758] Running state [salt-minion] at time 01:07:53.632985
2017-09-14 01:07:53,633 [salt.state       ][INFO    ][21758] Executing state pkg.installed for salt-minion
2017-09-14 01:07:53,634 [salt.loaded.int.module.cmdmod][INFO    ][21758] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-14 01:07:54,002 [salt.state       ][INFO    ][21758] Package salt-minion is already installed
2017-09-14 01:07:54,003 [salt.state       ][INFO    ][21758] Completed state [salt-minion] at time 01:07:54.002597 duration_in_ms=369.612
2017-09-14 01:07:54,003 [salt.state       ][INFO    ][21758] Running state [python-yaml] at time 01:07:54.002881
2017-09-14 01:07:54,003 [salt.state       ][INFO    ][21758] Executing state pkg.installed for python-yaml
2017-09-14 01:07:54,007 [salt.state       ][INFO    ][21758] Package python-yaml is already installed
2017-09-14 01:07:54,007 [salt.state       ][INFO    ][21758] Completed state [python-yaml] at time 01:07:54.007087 duration_in_ms=4.206
2017-09-14 01:07:54,007 [salt.state       ][INFO    ][21758] Running state [python-psutil] at time 01:07:54.007297
2017-09-14 01:07:54,008 [salt.state       ][INFO    ][21758] Executing state pkg.installed for python-psutil
2017-09-14 01:07:54,011 [salt.state       ][INFO    ][21758] Package python-psutil is already installed
2017-09-14 01:07:54,011 [salt.state       ][INFO    ][21758] Completed state [python-psutil] at time 01:07:54.011381 duration_in_ms=4.084
2017-09-14 01:07:54,012 [salt.state       ][INFO    ][21758] Running state [python-m2crypto] at time 01:07:54.011593
2017-09-14 01:07:54,012 [salt.state       ][INFO    ][21758] Executing state pkg.installed for python-m2crypto
2017-09-14 01:07:54,015 [salt.state       ][INFO    ][21758] Package python-m2crypto is already installed
2017-09-14 01:07:54,016 [salt.state       ][INFO    ][21758] Completed state [python-m2crypto] at time 01:07:54.015612 duration_in_ms=4.019
2017-09-14 01:07:54,018 [salt.state       ][INFO    ][21758] Running state [/etc/salt/minion.d/minion.conf] at time 01:07:54.017576
2017-09-14 01:07:54,018 [salt.state       ][INFO    ][21758] Executing state file.managed for /etc/salt/minion.d/minion.conf
2017-09-14 01:07:54,044 [salt.fileclient  ][INFO    ][21758] Fetching file from saltenv 'base', ** done ** 'salt/files/minion.conf'
2017-09-14 01:07:54,106 [salt.fileclient  ][INFO    ][21758] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-09-14 01:07:54,161 [salt.fileclient  ][INFO    ][21758] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-09-14 01:07:54,199 [salt.state       ][INFO    ][21758] File /etc/salt/minion.d/minion.conf is in the correct state
2017-09-14 01:07:54,199 [salt.state       ][INFO    ][21758] Completed state [/etc/salt/minion.d/minion.conf] at time 01:07:54.198855 duration_in_ms=181.279
2017-09-14 01:07:54,199 [salt.state       ][INFO    ][21758] Running state [/etc/salt/minion.d/_virt.conf] at time 01:07:54.199188
2017-09-14 01:07:54,199 [salt.state       ][INFO    ][21758] Executing state file.managed for /etc/salt/minion.d/_virt.conf
2017-09-14 01:07:54,206 [salt.state       ][INFO    ][21758] File /etc/salt/minion.d/_virt.conf is in the correct state
2017-09-14 01:07:54,206 [salt.state       ][INFO    ][21758] Completed state [/etc/salt/minion.d/_virt.conf] at time 01:07:54.205849 duration_in_ms=6.661
2017-09-14 01:07:54,207 [salt.state       ][INFO    ][21758] Running state [salt-minion] at time 01:07:54.207021
2017-09-14 01:07:54,207 [salt.state       ][INFO    ][21758] Executing state service.running for salt-minion
2017-09-14 01:07:54,208 [salt.loaded.int.module.cmdmod][INFO    ][21758] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2017-09-14 01:07:54,238 [salt.loaded.int.module.cmdmod][INFO    ][21758] Executing command ['systemctl', 'is-active', 'salt-minion.service'] in directory '/root'
2017-09-14 01:07:54,255 [salt.loaded.int.module.cmdmod][INFO    ][21758] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2017-09-14 01:07:54,271 [salt.state       ][INFO    ][21758] The service salt-minion is already running
2017-09-14 01:07:54,272 [salt.state       ][INFO    ][21758] Completed state [salt-minion] at time 01:07:54.271772 duration_in_ms=64.749
2017-09-14 01:07:54,275 [salt.state       ][INFO    ][21758] Running state [/etc/salt/grains.d] at time 01:07:54.274531
2017-09-14 01:07:54,275 [salt.state       ][INFO    ][21758] Executing state file.directory for /etc/salt/grains.d
2017-09-14 01:07:54,277 [salt.state       ][INFO    ][21758] Directory /etc/salt/grains.d is in the correct state
2017-09-14 01:07:54,277 [salt.state       ][INFO    ][21758] Completed state [/etc/salt/grains.d] at time 01:07:54.276845 duration_in_ms=2.314
2017-09-14 01:07:54,278 [salt.state       ][INFO    ][21758] Running state [/etc/salt/grains] at time 01:07:54.278216
2017-09-14 01:07:54,279 [salt.state       ][INFO    ][21758] Executing state file.managed for /etc/salt/grains
2017-09-14 01:07:54,280 [salt.state       ][INFO    ][21758] File /etc/salt/grains exists with proper permissions. No changes made.
2017-09-14 01:07:54,280 [salt.state       ][INFO    ][21758] Completed state [/etc/salt/grains] at time 01:07:54.280073 duration_in_ms=1.858
2017-09-14 01:07:54,281 [salt.state       ][INFO    ][21758] Running state [/etc/salt/grains.d/placeholder] at time 01:07:54.280842
2017-09-14 01:07:54,281 [salt.state       ][INFO    ][21758] Executing state file.managed for /etc/salt/grains.d/placeholder
2017-09-14 01:07:54,282 [salt.state       ][INFO    ][21758] File /etc/salt/grains.d/placeholder exists with proper permissions. No changes made.
2017-09-14 01:07:54,282 [salt.state       ][INFO    ][21758] Completed state [/etc/salt/grains.d/placeholder] at time 01:07:54.282425 duration_in_ms=1.583
2017-09-14 01:07:54,283 [salt.state       ][INFO    ][21758] Running state [/etc/salt/grains.d/sphinx] at time 01:07:54.283113
2017-09-14 01:07:54,284 [salt.state       ][INFO    ][21758] Executing state file.managed for /etc/salt/grains.d/sphinx
2017-09-14 01:07:54,290 [salt.state       ][INFO    ][21758] File /etc/salt/grains.d/sphinx is in the correct state
2017-09-14 01:07:54,290 [salt.state       ][INFO    ][21758] Completed state [/etc/salt/grains.d/sphinx] at time 01:07:54.290099 duration_in_ms=6.986
2017-09-14 01:07:54,291 [salt.state       ][INFO    ][21758] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 01:07:54.291249
2017-09-14 01:07:54,292 [salt.state       ][INFO    ][21758] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-09-14 01:07:54,292 [salt.state       ][INFO    ][21758] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-09-14 01:07:54,293 [salt.state       ][INFO    ][21758] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 01:07:54.292485 duration_in_ms=1.236
2017-09-14 01:07:54,293 [salt.state       ][INFO    ][21758] Running state [/etc/salt/grains.d/dns_records] at time 01:07:54.293186
2017-09-14 01:07:54,294 [salt.state       ][INFO    ][21758] Executing state file.managed for /etc/salt/grains.d/dns_records
2017-09-14 01:07:54,296 [salt.state       ][INFO    ][21758] File /etc/salt/grains.d/dns_records is in the correct state
2017-09-14 01:07:54,296 [salt.state       ][INFO    ][21758] Completed state [/etc/salt/grains.d/dns_records] at time 01:07:54.296079 duration_in_ms=2.894
2017-09-14 01:07:54,297 [salt.state       ][INFO    ][21758] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 01:07:54.297208
2017-09-14 01:07:54,298 [salt.state       ][INFO    ][21758] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"
2017-09-14 01:07:54,298 [salt.state       ][INFO    ][21758] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"
2017-09-14 01:07:54,299 [salt.state       ][INFO    ][21758] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 01:07:54.298471 duration_in_ms=1.263
2017-09-14 01:07:54,299 [salt.state       ][INFO    ][21758] Running state [/etc/salt/grains.d/salt] at time 01:07:54.299181
2017-09-14 01:07:54,300 [salt.state       ][INFO    ][21758] Executing state file.managed for /etc/salt/grains.d/salt
2017-09-14 01:07:54,302 [salt.state       ][INFO    ][21758] File /etc/salt/grains.d/salt is in the correct state
2017-09-14 01:07:54,302 [salt.state       ][INFO    ][21758] Completed state [/etc/salt/grains.d/salt] at time 01:07:54.302024 duration_in_ms=2.843
2017-09-14 01:07:54,303 [salt.state       ][INFO    ][21758] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 01:07:54.303096
2017-09-14 01:07:54,304 [salt.state       ][INFO    ][21758] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2017-09-14 01:07:54,304 [salt.state       ][INFO    ][21758] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2017-09-14 01:07:54,304 [salt.state       ][INFO    ][21758] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 01:07:54.304323 duration_in_ms=1.228
2017-09-14 01:07:54,307 [salt.state       ][INFO    ][21758] Running state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 01:07:54.307296
2017-09-14 01:07:54,308 [salt.state       ][INFO    ][21758] Executing state cmd.wait for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-09-14 01:07:54,308 [salt.state       ][INFO    ][21758] No changes made for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-09-14 01:07:54,309 [salt.state       ][INFO    ][21758] Completed state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 01:07:54.308469 duration_in_ms=1.172
2017-09-14 01:07:54,310 [salt.state       ][INFO    ][21758] Running state [mine.update] at time 01:07:54.309444
2017-09-14 01:07:54,310 [salt.state       ][INFO    ][21758] Executing state module.wait for mine.update
2017-09-14 01:07:54,310 [salt.state       ][INFO    ][21758] No changes made for mine.update
2017-09-14 01:07:54,311 [salt.state       ][INFO    ][21758] Completed state [mine.update] at time 01:07:54.310498 duration_in_ms=1.054
2017-09-14 01:07:54,311 [salt.state       ][INFO    ][21758] Running state [ca-certificates] at time 01:07:54.310839
2017-09-14 01:07:54,311 [salt.state       ][INFO    ][21758] Executing state pkg.installed for ca-certificates
2017-09-14 01:07:54,318 [salt.state       ][INFO    ][21758] Package ca-certificates is already installed
2017-09-14 01:07:54,319 [salt.state       ][INFO    ][21758] Completed state [ca-certificates] at time 01:07:54.318590 duration_in_ms=7.752
2017-09-14 01:07:54,320 [salt.state       ][INFO    ][21758] Running state [update-ca-certificates] at time 01:07:54.319522
2017-09-14 01:07:54,320 [salt.state       ][INFO    ][21758] Executing state cmd.wait for update-ca-certificates
2017-09-14 01:07:54,320 [salt.state       ][INFO    ][21758] No changes made for update-ca-certificates
2017-09-14 01:07:54,321 [salt.state       ][INFO    ][21758] Completed state [update-ca-certificates] at time 01:07:54.320572 duration_in_ms=1.05
2017-09-14 01:07:54,321 [salt.state       ][INFO    ][21758] Running state [libvirt-dev] at time 01:07:54.320902
2017-09-14 01:07:54,321 [salt.state       ][INFO    ][21758] Executing state pkg.installed for libvirt-dev
2017-09-14 01:07:54,327 [salt.state       ][INFO    ][21758] Package libvirt-dev is already installed
2017-09-14 01:07:54,328 [salt.state       ][INFO    ][21758] Completed state [libvirt-dev] at time 01:07:54.327668 duration_in_ms=6.765
2017-09-14 01:07:54,328 [salt.state       ][INFO    ][21758] Running state [pkg-config] at time 01:07:54.327998
2017-09-14 01:07:54,328 [salt.state       ][INFO    ][21758] Executing state pkg.installed for pkg-config
2017-09-14 01:07:54,334 [salt.state       ][INFO    ][21758] Package pkg-config is already installed
2017-09-14 01:07:54,335 [salt.state       ][INFO    ][21758] Completed state [pkg-config] at time 01:07:54.334460 duration_in_ms=6.461
2017-09-14 01:07:54,335 [salt.state       ][INFO    ][21758] Running state [virtng.init] at time 01:07:54.334785
2017-09-14 01:07:54,335 [salt.state       ][INFO    ][21758] Executing state module.run for virtng.init
2017-09-14 01:07:54,432 [salt.loaded.int.module.cmdmod][INFO    ][21758] Executing command ['git', '--version'] in directory '/root'
2017-09-14 01:07:54,582 [salt.loaded.int.module.cmdmod][INFO    ][21758] Executing command 'virsh list --all --name| grep -E "^mdb03.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-09-14 01:08:00,020 [salt.minion      ][INFO    ][21560] User sudo_ubuntu Executing command saltutil.find_job with jid 20170914010800017322
2017-09-14 01:08:00,041 [salt.minion      ][INFO    ][21814] Starting a new job with PID 21814
2017-09-14 01:08:00,061 [salt.minion      ][INFO    ][21814] Returning information for job: 20170914010800017322
2017-09-14 01:08:10,048 [salt.minion      ][INFO    ][21560] User sudo_ubuntu Executing command saltutil.find_job with jid 20170914010810045444
2017-09-14 01:08:10,071 [salt.minion      ][INFO    ][21819] Starting a new job with PID 21819
2017-09-14 01:08:10,090 [salt.minion      ][INFO    ][21819] Returning information for job: 20170914010810045444
2017-09-14 01:08:20,239 [salt.minion      ][INFO    ][21560] User sudo_ubuntu Executing command saltutil.find_job with jid 20170914010820237412
2017-09-14 01:08:20,261 [salt.minion      ][INFO    ][21824] Starting a new job with PID 21824
2017-09-14 01:08:20,281 [salt.minion      ][INFO    ][21824] Returning information for job: 20170914010820237412
2017-09-14 01:08:30,416 [salt.minion      ][INFO    ][21560] User sudo_ubuntu Executing command saltutil.find_job with jid 20170914010830416615
2017-09-14 01:08:30,441 [salt.minion      ][INFO    ][21829] Starting a new job with PID 21829
2017-09-14 01:08:30,459 [salt.minion      ][INFO    ][21829] Returning information for job: 20170914010830416615
2017-09-14 01:08:39,077 [salt.loaded.int.module.cmdmod][INFO    ][21758] Executing command 'modprobe nbd max_part=63' in directory '/root'
2017-09-14 01:08:39,115 [salt.loaded.int.module.cmdmod][INFO    ][21758] Executing command 'sfdisk -d /dev/nbd9' in directory '/root'
2017-09-14 01:08:39,169 [salt.loaded.int.module.cmdmod][ERROR   ][21758] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-09-14 01:08:39,170 [salt.loaded.int.module.cmdmod][ERROR   ][21758] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-09-14 01:08:39,171 [salt.loaded.int.module.cmdmod][INFO    ][21758] Executing command 'qemu-nbd -c /dev/nbd9 /var/lib/libvirt/images/mdb03.baremetal-mcp-ocata-ovs-ha.local/system.qcow2' in directory '/root'
2017-09-14 01:08:39,202 [salt.loaded.int.module.cmdmod][INFO    ][21758] Executing command 'sfdisk -d /dev/nbd9' in directory '/root'
2017-09-14 01:08:39,215 [salt.loaded.int.module.cmdmod][INFO    ][21758] Executing command 'partprobe /dev/nbd9' in directory '/root'
2017-09-14 01:08:40,271 [salt.loaded.int.module.cmdmod][INFO    ][21758] Executing command 'mount -o defaults /dev/nbd9p1 /tmp/nbd/nbd9/nbd9p1 ' in directory '/root'
2017-09-14 01:08:40,484 [salt.minion      ][INFO    ][21560] User sudo_ubuntu Executing command saltutil.find_job with jid 20170914010840481045
2017-09-14 01:08:40,506 [salt.minion      ][INFO    ][21986] Starting a new job with PID 21986
2017-09-14 01:08:40,525 [salt.minion      ][INFO    ][21986] Returning information for job: 20170914010840481045
2017-09-14 01:08:41,127 [salt.loaded.ext.module.seedng][INFO    ][21758] salt-minion pre-installed on image, configuring as mdb03.baremetal-mcp-ocata-ovs-ha.local
2017-09-14 01:08:41,137 [salt.loaded.int.module.cmdmod][INFO    ][21758] Executing command 'mount -l' in directory '/root'
2017-09-14 01:08:41,189 [salt.loaded.int.module.cmdmod][INFO    ][21758] Executing command 'umount /tmp/nbd/nbd9/nbd9p1' in directory '/root'
2017-09-14 01:08:42,035 [salt.loaded.int.module.cmdmod][INFO    ][21758] Executing command 'qemu-nbd -d /dev/nbd9' in directory '/root'
2017-09-14 01:08:44,304 [salt.state       ][INFO    ][21758] {'ret': True}
2017-09-14 01:08:44,305 [salt.state       ][INFO    ][21758] Completed state [virtng.init] at time 01:08:44.304850 duration_in_ms=49970.064
2017-09-14 01:08:44,306 [salt.state       ][INFO    ][21758] Running state [virt.set_autostart] at time 01:08:44.305611
2017-09-14 01:08:44,306 [salt.state       ][INFO    ][21758] Executing state module.run for virt.set_autostart
2017-09-14 01:08:44,312 [salt.loaded.int.module.cmdmod][INFO    ][21758] Executing command 'virsh list --autostart --name| grep -E "^mdb03.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-09-14 01:08:44,352 [salt.state       ][INFO    ][21758] {'ret': True}
2017-09-14 01:08:44,353 [salt.state       ][INFO    ][21758] Completed state [virt.set_autostart] at time 01:08:44.352451 duration_in_ms=46.839
2017-09-14 01:08:44,353 [salt.state       ][INFO    ][21758] Running state [virtng.init] at time 01:08:44.352909
2017-09-14 01:08:44,353 [salt.state       ][INFO    ][21758] Executing state module.run for virtng.init
2017-09-14 01:08:44,358 [salt.loaded.int.module.cmdmod][INFO    ][21758] Executing command 'virsh list --all --name| grep -E "^dbs03.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-09-14 01:08:47,226 [salt.loaded.int.module.cmdmod][INFO    ][21758] Executing command 'modprobe nbd max_part=63' in directory '/root'
2017-09-14 01:08:47,241 [salt.loaded.int.module.cmdmod][INFO    ][21758] Executing command 'sfdisk -d /dev/nbd9' in directory '/root'
2017-09-14 01:08:47,252 [salt.loaded.int.module.cmdmod][ERROR   ][21758] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-09-14 01:08:47,252 [salt.loaded.int.module.cmdmod][ERROR   ][21758] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-09-14 01:08:47,253 [salt.loaded.int.module.cmdmod][INFO    ][21758] Executing command 'qemu-nbd -c /dev/nbd9 /var/lib/libvirt/images/dbs03.baremetal-mcp-ocata-ovs-ha.local/system.qcow2' in directory '/root'
2017-09-14 01:08:47,283 [salt.loaded.int.module.cmdmod][INFO    ][21758] Executing command 'sfdisk -d /dev/nbd9' in directory '/root'
2017-09-14 01:08:47,297 [salt.loaded.int.module.cmdmod][INFO    ][21758] Executing command 'partprobe /dev/nbd9' in directory '/root'
2017-09-14 01:08:48,353 [salt.loaded.int.module.cmdmod][INFO    ][21758] Executing command 'mount -o defaults /dev/nbd9p1 /tmp/nbd/nbd9/nbd9p1 ' in directory '/root'
2017-09-14 01:08:49,020 [salt.loaded.ext.module.seedng][INFO    ][21758] salt-minion pre-installed on image, configuring as dbs03.baremetal-mcp-ocata-ovs-ha.local
2017-09-14 01:08:49,028 [salt.loaded.int.module.cmdmod][INFO    ][21758] Executing command 'mount -l' in directory '/root'
2017-09-14 01:08:49,243 [salt.loaded.int.module.cmdmod][INFO    ][21758] Executing command 'umount /tmp/nbd/nbd9/nbd9p1' in directory '/root'
2017-09-14 01:08:50,660 [salt.minion      ][INFO    ][21560] User sudo_ubuntu Executing command saltutil.find_job with jid 20170914010850655928
2017-09-14 01:08:50,683 [salt.minion      ][INFO    ][22276] Starting a new job with PID 22276
2017-09-14 01:08:50,702 [salt.minion      ][INFO    ][22276] Returning information for job: 20170914010850655928
2017-09-14 01:08:52,624 [salt.loaded.int.module.cmdmod][INFO    ][21758] Executing command 'qemu-nbd -d /dev/nbd9' in directory '/root'
2017-09-14 01:08:54,839 [salt.state       ][INFO    ][21758] {'ret': True}
2017-09-14 01:08:54,840 [salt.state       ][INFO    ][21758] Completed state [virtng.init] at time 01:08:54.840028 duration_in_ms=10487.116
2017-09-14 01:08:54,841 [salt.state       ][INFO    ][21758] Running state [virt.set_autostart] at time 01:08:54.840719
2017-09-14 01:08:54,841 [salt.state       ][INFO    ][21758] Executing state module.run for virt.set_autostart
2017-09-14 01:08:54,847 [salt.loaded.int.module.cmdmod][INFO    ][21758] Executing command 'virsh list --autostart --name| grep -E "^dbs03.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-09-14 01:08:54,885 [salt.state       ][INFO    ][21758] {'ret': True}
2017-09-14 01:08:54,886 [salt.state       ][INFO    ][21758] Completed state [virt.set_autostart] at time 01:08:54.885845 duration_in_ms=45.128
2017-09-14 01:08:54,886 [salt.state       ][INFO    ][21758] Running state [virtng.init] at time 01:08:54.886303
2017-09-14 01:08:54,887 [salt.state       ][INFO    ][21758] Executing state module.run for virtng.init
2017-09-14 01:08:54,891 [salt.loaded.int.module.cmdmod][INFO    ][21758] Executing command 'virsh list --all --name| grep -E "^ctl03.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-09-14 01:08:57,725 [salt.loaded.int.module.cmdmod][INFO    ][21758] Executing command 'modprobe nbd max_part=63' in directory '/root'
2017-09-14 01:08:57,741 [salt.loaded.int.module.cmdmod][INFO    ][21758] Executing command 'sfdisk -d /dev/nbd9' in directory '/root'
2017-09-14 01:08:57,752 [salt.loaded.int.module.cmdmod][ERROR   ][21758] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-09-14 01:08:57,753 [salt.loaded.int.module.cmdmod][ERROR   ][21758] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-09-14 01:08:57,754 [salt.loaded.int.module.cmdmod][INFO    ][21758] Executing command 'qemu-nbd -c /dev/nbd9 /var/lib/libvirt/images/ctl03.baremetal-mcp-ocata-ovs-ha.local/system.qcow2' in directory '/root'
2017-09-14 01:08:57,786 [salt.loaded.int.module.cmdmod][INFO    ][21758] Executing command 'sfdisk -d /dev/nbd9' in directory '/root'
2017-09-14 01:08:57,800 [salt.loaded.int.module.cmdmod][INFO    ][21758] Executing command 'partprobe /dev/nbd9' in directory '/root'
2017-09-14 01:08:58,841 [salt.loaded.int.module.cmdmod][INFO    ][21758] Executing command 'mount -o defaults /dev/nbd9p1 /tmp/nbd/nbd9/nbd9p1 ' in directory '/root'
2017-09-14 01:08:59,543 [salt.loaded.ext.module.seedng][INFO    ][21758] salt-minion pre-installed on image, configuring as ctl03.baremetal-mcp-ocata-ovs-ha.local
2017-09-14 01:08:59,552 [salt.loaded.int.module.cmdmod][INFO    ][21758] Executing command 'mount -l' in directory '/root'
2017-09-14 01:08:59,710 [salt.loaded.int.module.cmdmod][INFO    ][21758] Executing command 'umount /tmp/nbd/nbd9/nbd9p1' in directory '/root'
2017-09-14 01:09:00,732 [salt.minion      ][INFO    ][21560] User sudo_ubuntu Executing command saltutil.find_job with jid 20170914010900726877
2017-09-14 01:09:00,753 [salt.minion      ][INFO    ][22552] Starting a new job with PID 22552
2017-09-14 01:09:00,800 [salt.minion      ][INFO    ][22552] Returning information for job: 20170914010900726877
2017-09-14 01:09:03,205 [salt.loaded.int.module.cmdmod][INFO    ][21758] Executing command 'qemu-nbd -d /dev/nbd9' in directory '/root'
2017-09-14 01:09:05,426 [salt.state       ][INFO    ][21758] {'ret': True}
2017-09-14 01:09:05,426 [salt.state       ][INFO    ][21758] Completed state [virtng.init] at time 01:09:05.426282 duration_in_ms=10539.976
2017-09-14 01:09:05,427 [salt.state       ][INFO    ][21758] Running state [virt.set_autostart] at time 01:09:05.427017
2017-09-14 01:09:05,428 [salt.state       ][INFO    ][21758] Executing state module.run for virt.set_autostart
2017-09-14 01:09:05,433 [salt.loaded.int.module.cmdmod][INFO    ][21758] Executing command 'virsh list --autostart --name| grep -E "^ctl03.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-09-14 01:09:05,474 [salt.state       ][INFO    ][21758] {'ret': True}
2017-09-14 01:09:05,475 [salt.state       ][INFO    ][21758] Completed state [virt.set_autostart] at time 01:09:05.474591 duration_in_ms=47.573
2017-09-14 01:09:05,475 [salt.state       ][INFO    ][21758] Running state [virtng.init] at time 01:09:05.475089
2017-09-14 01:09:05,476 [salt.state       ][INFO    ][21758] Executing state module.run for virtng.init
2017-09-14 01:09:05,480 [salt.loaded.int.module.cmdmod][INFO    ][21758] Executing command 'virsh list --all --name| grep -E "^msg03.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-09-14 01:09:08,126 [salt.loaded.int.module.cmdmod][INFO    ][21758] Executing command 'modprobe nbd max_part=63' in directory '/root'
2017-09-14 01:09:08,142 [salt.loaded.int.module.cmdmod][INFO    ][21758] Executing command 'sfdisk -d /dev/nbd9' in directory '/root'
2017-09-14 01:09:08,154 [salt.loaded.int.module.cmdmod][ERROR   ][21758] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-09-14 01:09:08,154 [salt.loaded.int.module.cmdmod][ERROR   ][21758] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-09-14 01:09:08,155 [salt.loaded.int.module.cmdmod][INFO    ][21758] Executing command 'qemu-nbd -c /dev/nbd9 /var/lib/libvirt/images/msg03.baremetal-mcp-ocata-ovs-ha.local/system.qcow2' in directory '/root'
2017-09-14 01:09:08,187 [salt.loaded.int.module.cmdmod][INFO    ][21758] Executing command 'sfdisk -d /dev/nbd9' in directory '/root'
2017-09-14 01:09:08,201 [salt.loaded.int.module.cmdmod][INFO    ][21758] Executing command 'partprobe /dev/nbd9' in directory '/root'
2017-09-14 01:09:09,270 [salt.loaded.int.module.cmdmod][INFO    ][21758] Executing command 'mount -o defaults /dev/nbd9p1 /tmp/nbd/nbd9/nbd9p1 ' in directory '/root'
2017-09-14 01:09:09,962 [salt.loaded.ext.module.seedng][INFO    ][21758] salt-minion pre-installed on image, configuring as msg03.baremetal-mcp-ocata-ovs-ha.local
2017-09-14 01:09:09,973 [salt.loaded.int.module.cmdmod][INFO    ][21758] Executing command 'mount -l' in directory '/root'
2017-09-14 01:09:10,342 [salt.loaded.int.module.cmdmod][INFO    ][21758] Executing command 'umount /tmp/nbd/nbd9/nbd9p1' in directory '/root'
2017-09-14 01:09:10,758 [salt.minion      ][INFO    ][21560] User sudo_ubuntu Executing command saltutil.find_job with jid 20170914010910752737
2017-09-14 01:09:10,780 [salt.minion      ][INFO    ][22822] Starting a new job with PID 22822
2017-09-14 01:09:10,799 [salt.minion      ][INFO    ][22822] Returning information for job: 20170914010910752737
2017-09-14 01:09:13,871 [salt.loaded.int.module.cmdmod][INFO    ][21758] Executing command 'qemu-nbd -d /dev/nbd9' in directory '/root'
2017-09-14 01:09:16,003 [salt.state       ][INFO    ][21758] {'ret': True}
2017-09-14 01:09:16,004 [salt.state       ][INFO    ][21758] Completed state [virtng.init] at time 01:09:16.003458 duration_in_ms=10528.364
2017-09-14 01:09:16,004 [salt.state       ][INFO    ][21758] Running state [virt.set_autostart] at time 01:09:16.004273
2017-09-14 01:09:16,005 [salt.state       ][INFO    ][21758] Executing state module.run for virt.set_autostart
2017-09-14 01:09:16,011 [salt.loaded.int.module.cmdmod][INFO    ][21758] Executing command 'virsh list --autostart --name| grep -E "^msg03.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-09-14 01:09:16,059 [salt.state       ][INFO    ][21758] {'ret': True}
2017-09-14 01:09:16,060 [salt.state       ][INFO    ][21758] Completed state [virt.set_autostart] at time 01:09:16.059568 duration_in_ms=55.294
2017-09-14 01:09:16,067 [salt.minion      ][INFO    ][21758] Returning information for job: 20170914010749936456
2017-09-14 01:10:40,703 [salt.minion      ][INFO    ][21560] User sudo_ubuntu Executing command saltutil.sync_all with jid 20170914011040696760
2017-09-14 01:10:40,728 [salt.minion      ][INFO    ][23074] Starting a new job with PID 23074
2017-09-14 01:10:44,586 [salt.state       ][INFO    ][23074] Loading fresh modules for state activity
2017-09-14 01:10:44,622 [salt.state       ][ERROR   ][23074] No contents found in top file
2017-09-14 01:10:44,623 [salt.utils.extmods][INFO    ][23074] Creating module dir '/var/cache/salt/minion/extmods/beacons'
2017-09-14 01:10:44,629 [salt.utils.extmods][INFO    ][23074] Syncing beacons for environment 'base'
2017-09-14 01:10:44,630 [salt.utils.extmods][INFO    ][23074] Loading cache from salt://_beacons, for base)
2017-09-14 01:10:44,630 [salt.fileclient  ][INFO    ][23074] Caching directory '_beacons/' for environment 'base'
2017-09-14 01:10:44,682 [salt.utils.extmods][INFO    ][23074] Syncing modules for environment 'base'
2017-09-14 01:10:44,682 [salt.utils.extmods][INFO    ][23074] Loading cache from salt://_modules, for base)
2017-09-14 01:10:44,683 [salt.fileclient  ][INFO    ][23074] Caching directory '_modules/' for environment 'base'
2017-09-14 01:10:44,747 [salt.fileclient  ][INFO    ][23074] Fetching file from saltenv 'base', ** done ** '_modules/ceph_ng.py'
2017-09-14 01:10:44,773 [salt.fileclient  ][INFO    ][23074] Fetching file from saltenv 'base', ** done ** '_modules/cinderng.py'
2017-09-14 01:10:44,807 [salt.fileclient  ][INFO    ][23074] Fetching file from saltenv 'base', ** done ** '_modules/contrail.py'
2017-09-14 01:10:44,822 [salt.fileclient  ][INFO    ][23074] Fetching file from saltenv 'base', ** done ** '_modules/creds.py'
2017-09-14 01:10:44,832 [salt.fileclient  ][INFO    ][23074] Fetching file from saltenv 'base', ** done ** '_modules/devops_utils.py'
2017-09-14 01:10:44,860 [salt.fileclient  ][INFO    ][23074] Fetching file from saltenv 'base', ** done ** '_modules/encode_json.py'
2017-09-14 01:10:44,976 [salt.fileclient  ][INFO    ][23074] Fetching file from saltenv 'base', ** done ** '_modules/gerrit.py'
2017-09-14 01:10:44,992 [salt.fileclient  ][INFO    ][23074] Fetching file from saltenv 'base', ** done ** '_modules/glanceng.py'
2017-09-14 01:10:45,012 [salt.fileclient  ][INFO    ][23074] Fetching file from saltenv 'base', ** done ** '_modules/heat.py'
2017-09-14 01:10:45,025 [salt.fileclient  ][INFO    ][23074] Fetching file from saltenv 'base', ** done ** '_modules/heka_alarming.py'
2017-09-14 01:10:45,035 [salt.fileclient  ][INFO    ][23074] Fetching file from saltenv 'base', ** done ** '_modules/helm.py'
2017-09-14 01:10:45,048 [salt.fileclient  ][INFO    ][23074] Fetching file from saltenv 'base', ** done ** '_modules/jenkins_common.py'
2017-09-14 01:10:45,071 [salt.fileclient  ][INFO    ][23074] Fetching file from saltenv 'base', ** done ** '_modules/keystone_policy.py'
2017-09-14 01:10:45,086 [salt.fileclient  ][INFO    ][23074] Fetching file from saltenv 'base', ** done ** '_modules/linux_hosts.py'
2017-09-14 01:10:45,100 [salt.fileclient  ][INFO    ][23074] Fetching file from saltenv 'base', ** done ** '_modules/linux_netlink.py'
2017-09-14 01:10:45,114 [salt.fileclient  ][INFO    ][23074] Fetching file from saltenv 'base', ** done ** '_modules/maas.py'
2017-09-14 01:10:45,127 [salt.fileclient  ][INFO    ][23074] Fetching file from saltenv 'base', ** done ** '_modules/maas_client.py'
2017-09-14 01:10:45,140 [salt.fileclient  ][INFO    ][23074] Fetching file from saltenv 'base', ** done ** '_modules/multipart.py'
2017-09-14 01:10:45,157 [salt.fileclient  ][INFO    ][23074] Fetching file from saltenv 'base', ** done ** '_modules/nagios_alarming.py'
2017-09-14 01:10:45,175 [salt.fileclient  ][INFO    ][23074] Fetching file from saltenv 'base', ** done ** '_modules/neutronng.py'
2017-09-14 01:10:45,192 [salt.fileclient  ][INFO    ][23074] Fetching file from saltenv 'base', ** done ** '_modules/novang.py'
2017-09-14 01:10:45,291 [salt.fileclient  ][INFO    ][23074] Fetching file from saltenv 'base', ** done ** '_modules/reclass.py'
2017-09-14 01:10:45,324 [salt.fileclient  ][INFO    ][23074] Fetching file from saltenv 'base', ** done ** '_modules/rsyslog_util.py'
2017-09-14 01:10:45,336 [salt.fileclient  ][INFO    ][23074] Fetching file from saltenv 'base', ** done ** '_modules/rundeck.py'
2017-09-14 01:10:45,395 [salt.fileclient  ][INFO    ][23074] Fetching file from saltenv 'base', ** done ** '_modules/saltkey.py'
2017-09-14 01:10:45,443 [salt.fileclient  ][INFO    ][23074] Fetching file from saltenv 'base', ** done ** '_modules/saltresource.py'
2017-09-14 01:10:45,459 [salt.fileclient  ][INFO    ][23074] Fetching file from saltenv 'base', ** done ** '_modules/seedng.py'
2017-09-14 01:10:45,560 [salt.fileclient  ][INFO    ][23074] Fetching file from saltenv 'base', ** done ** '_modules/testing/credentials.py'
2017-09-14 01:10:45,578 [salt.fileclient  ][INFO    ][23074] Fetching file from saltenv 'base', ** done ** '_modules/testing/django.py'
2017-09-14 01:10:45,591 [salt.fileclient  ][INFO    ][23074] Fetching file from saltenv 'base', ** done ** '_modules/testing/django_client_proxy.py'
2017-09-14 01:10:45,605 [salt.fileclient  ][INFO    ][23074] Fetching file from saltenv 'base', ** done ** '_modules/utils.py'
2017-09-14 01:10:45,620 [salt.fileclient  ][INFO    ][23074] Fetching file from saltenv 'base', ** done ** '_modules/virtng.py'
2017-09-14 01:10:45,624 [salt.utils.extmods][INFO    ][23074] Copying '/var/cache/salt/minion/files/base/_modules/__init__.py' to '/var/cache/salt/minion/extmods/modules/__init__.py'
2017-09-14 01:10:45,625 [salt.utils.extmods][INFO    ][23074] Copying '/var/cache/salt/minion/files/base/_modules/ceph_ng.py' to '/var/cache/salt/minion/extmods/modules/ceph_ng.py'
2017-09-14 01:10:45,625 [salt.utils.extmods][INFO    ][23074] Copying '/var/cache/salt/minion/files/base/_modules/cinderng.py' to '/var/cache/salt/minion/extmods/modules/cinderng.py'
2017-09-14 01:10:45,626 [salt.utils.extmods][INFO    ][23074] Copying '/var/cache/salt/minion/files/base/_modules/contrail.py' to '/var/cache/salt/minion/extmods/modules/contrail.py'
2017-09-14 01:10:45,626 [salt.utils.extmods][INFO    ][23074] Copying '/var/cache/salt/minion/files/base/_modules/creds.py' to '/var/cache/salt/minion/extmods/modules/creds.py'
2017-09-14 01:10:45,626 [salt.utils.extmods][INFO    ][23074] Copying '/var/cache/salt/minion/files/base/_modules/devops_utils.py' to '/var/cache/salt/minion/extmods/modules/devops_utils.py'
2017-09-14 01:10:45,627 [salt.utils.extmods][INFO    ][23074] Copying '/var/cache/salt/minion/files/base/_modules/encode_json.py' to '/var/cache/salt/minion/extmods/modules/encode_json.py'
2017-09-14 01:10:45,627 [salt.utils.extmods][INFO    ][23074] Copying '/var/cache/salt/minion/files/base/_modules/gerrit.py' to '/var/cache/salt/minion/extmods/modules/gerrit.py'
2017-09-14 01:10:45,627 [salt.utils.extmods][INFO    ][23074] Copying '/var/cache/salt/minion/files/base/_modules/glanceng.py' to '/var/cache/salt/minion/extmods/modules/glanceng.py'
2017-09-14 01:10:45,628 [salt.utils.extmods][INFO    ][23074] Copying '/var/cache/salt/minion/files/base/_modules/heat.py' to '/var/cache/salt/minion/extmods/modules/heat.py'
2017-09-14 01:10:45,628 [salt.utils.extmods][INFO    ][23074] Copying '/var/cache/salt/minion/files/base/_modules/heka_alarming.py' to '/var/cache/salt/minion/extmods/modules/heka_alarming.py'
2017-09-14 01:10:45,628 [salt.utils.extmods][INFO    ][23074] Copying '/var/cache/salt/minion/files/base/_modules/helm.py' to '/var/cache/salt/minion/extmods/modules/helm.py'
2017-09-14 01:10:45,629 [salt.utils.extmods][INFO    ][23074] Copying '/var/cache/salt/minion/files/base/_modules/jenkins_common.py' to '/var/cache/salt/minion/extmods/modules/jenkins_common.py'
2017-09-14 01:10:45,629 [salt.utils.extmods][INFO    ][23074] Copying '/var/cache/salt/minion/files/base/_modules/keystone_policy.py' to '/var/cache/salt/minion/extmods/modules/keystone_policy.py'
2017-09-14 01:10:45,629 [salt.utils.extmods][INFO    ][23074] Copying '/var/cache/salt/minion/files/base/_modules/linux_hosts.py' to '/var/cache/salt/minion/extmods/modules/linux_hosts.py'
2017-09-14 01:10:45,630 [salt.utils.extmods][INFO    ][23074] Copying '/var/cache/salt/minion/files/base/_modules/linux_netlink.py' to '/var/cache/salt/minion/extmods/modules/linux_netlink.py'
2017-09-14 01:10:45,630 [salt.utils.extmods][INFO    ][23074] Copying '/var/cache/salt/minion/files/base/_modules/maas.py' to '/var/cache/salt/minion/extmods/modules/maas.py'
2017-09-14 01:10:45,630 [salt.utils.extmods][INFO    ][23074] Copying '/var/cache/salt/minion/files/base/_modules/maas_client.py' to '/var/cache/salt/minion/extmods/modules/maas_client.py'
2017-09-14 01:10:45,631 [salt.utils.extmods][INFO    ][23074] Copying '/var/cache/salt/minion/files/base/_modules/multipart.py' to '/var/cache/salt/minion/extmods/modules/multipart.py'
2017-09-14 01:10:45,631 [salt.utils.extmods][INFO    ][23074] Copying '/var/cache/salt/minion/files/base/_modules/nagios_alarming.py' to '/var/cache/salt/minion/extmods/modules/nagios_alarming.py'
2017-09-14 01:10:45,631 [salt.utils.extmods][INFO    ][23074] Copying '/var/cache/salt/minion/files/base/_modules/neutronng.py' to '/var/cache/salt/minion/extmods/modules/neutronng.py'
2017-09-14 01:10:45,632 [salt.utils.extmods][INFO    ][23074] Copying '/var/cache/salt/minion/files/base/_modules/novang.py' to '/var/cache/salt/minion/extmods/modules/novang.py'
2017-09-14 01:10:45,632 [salt.utils.extmods][INFO    ][23074] Copying '/var/cache/salt/minion/files/base/_modules/reclass.py' to '/var/cache/salt/minion/extmods/modules/reclass.py'
2017-09-14 01:10:45,633 [salt.utils.extmods][INFO    ][23074] Copying '/var/cache/salt/minion/files/base/_modules/rsyslog_util.py' to '/var/cache/salt/minion/extmods/modules/rsyslog_util.py'
2017-09-14 01:10:45,633 [salt.utils.extmods][INFO    ][23074] Copying '/var/cache/salt/minion/files/base/_modules/rundeck.py' to '/var/cache/salt/minion/extmods/modules/rundeck.py'
2017-09-14 01:10:45,634 [salt.utils.extmods][INFO    ][23074] Copying '/var/cache/salt/minion/files/base/_modules/saltkey.py' to '/var/cache/salt/minion/extmods/modules/saltkey.py'
2017-09-14 01:10:45,634 [salt.utils.extmods][INFO    ][23074] Copying '/var/cache/salt/minion/files/base/_modules/saltresource.py' to '/var/cache/salt/minion/extmods/modules/saltresource.py'
2017-09-14 01:10:45,634 [salt.utils.extmods][INFO    ][23074] Copying '/var/cache/salt/minion/files/base/_modules/seedng.py' to '/var/cache/salt/minion/extmods/modules/seedng.py'
2017-09-14 01:10:45,635 [salt.utils.extmods][INFO    ][23074] Copying '/var/cache/salt/minion/files/base/_modules/testing/__init__.py' to '/var/cache/salt/minion/extmods/modules/testing/__init__.py'
2017-09-14 01:10:45,635 [salt.utils.extmods][INFO    ][23074] Copying '/var/cache/salt/minion/files/base/_modules/testing/credentials.py' to '/var/cache/salt/minion/extmods/modules/testing/credentials.py'
2017-09-14 01:10:45,635 [salt.utils.extmods][INFO    ][23074] Copying '/var/cache/salt/minion/files/base/_modules/testing/django.py' to '/var/cache/salt/minion/extmods/modules/testing/django.py'
2017-09-14 01:10:45,636 [salt.utils.extmods][INFO    ][23074] 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-09-14 01:10:45,636 [salt.utils.extmods][INFO    ][23074] Copying '/var/cache/salt/minion/files/base/_modules/utils.py' to '/var/cache/salt/minion/extmods/modules/utils.py'
2017-09-14 01:10:45,636 [salt.utils.extmods][INFO    ][23074] Copying '/var/cache/salt/minion/files/base/_modules/virtng.py' to '/var/cache/salt/minion/extmods/modules/virtng.py'
2017-09-14 01:10:45,642 [salt.utils.extmods][INFO    ][23074] Syncing states for environment 'base'
2017-09-14 01:10:45,642 [salt.utils.extmods][INFO    ][23074] Loading cache from salt://_states, for base)
2017-09-14 01:10:45,643 [salt.fileclient  ][INFO    ][23074] Caching directory '_states/' for environment 'base'
2017-09-14 01:10:45,775 [salt.fileclient  ][INFO    ][23074] Fetching file from saltenv 'base', ** done ** '_states/cinderng.py'
2017-09-14 01:10:45,827 [salt.fileclient  ][INFO    ][23074] Fetching file from saltenv 'base', ** done ** '_states/contrail.py'
2017-09-14 01:10:45,847 [salt.fileclient  ][INFO    ][23074] Fetching file from saltenv 'base', ** done ** '_states/gerrit.py'
2017-09-14 01:10:45,895 [salt.fileclient  ][INFO    ][23074] Fetching file from saltenv 'base', ** done ** '_states/glanceng.py'
2017-09-14 01:10:45,919 [salt.fileclient  ][INFO    ][23074] Fetching file from saltenv 'base', ** done ** '_states/grafana3_dashboard.py'
2017-09-14 01:10:45,931 [salt.fileclient  ][INFO    ][23074] Fetching file from saltenv 'base', ** done ** '_states/grafana3_datasource.py'
2017-09-14 01:10:45,953 [salt.fileclient  ][INFO    ][23074] Fetching file from saltenv 'base', ** done ** '_states/heat.py'
2017-09-14 01:10:45,963 [salt.fileclient  ][INFO    ][23074] Fetching file from saltenv 'base', ** done ** '_states/helm_release.py'
2017-09-14 01:10:45,988 [salt.fileclient  ][INFO    ][23074] Fetching file from saltenv 'base', ** done ** '_states/jenkins_approval.py'
2017-09-14 01:10:46,044 [salt.fileclient  ][INFO    ][23074] Fetching file from saltenv 'base', ** done ** '_states/jenkins_artifactory.py'
2017-09-14 01:10:46,059 [salt.fileclient  ][INFO    ][23074] Fetching file from saltenv 'base', ** done ** '_states/jenkins_credential.py'
2017-09-14 01:10:46,149 [salt.fileclient  ][INFO    ][23074] Fetching file from saltenv 'base', ** done ** '_states/jenkins_job.py'
2017-09-14 01:10:46,161 [salt.fileclient  ][INFO    ][23074] Fetching file from saltenv 'base', ** done ** '_states/jenkins_lib.py'
2017-09-14 01:10:46,181 [salt.fileclient  ][INFO    ][23074] Fetching file from saltenv 'base', ** done ** '_states/jenkins_node.py'
2017-09-14 01:10:46,239 [salt.fileclient  ][INFO    ][23074] Fetching file from saltenv 'base', ** done ** '_states/jenkins_plugin.py'
2017-09-14 01:10:46,254 [salt.fileclient  ][INFO    ][23074] Fetching file from saltenv 'base', ** done ** '_states/jenkins_security.py'
2017-09-14 01:10:46,273 [salt.fileclient  ][INFO    ][23074] Fetching file from saltenv 'base', ** done ** '_states/jenkins_slack.py'
2017-09-14 01:10:46,282 [salt.fileclient  ][INFO    ][23074] Fetching file from saltenv 'base', ** done ** '_states/jenkins_smtp.py'
2017-09-14 01:10:46,292 [salt.fileclient  ][INFO    ][23074] Fetching file from saltenv 'base', ** done ** '_states/jenkins_theme.py'
2017-09-14 01:10:46,302 [salt.fileclient  ][INFO    ][23074] Fetching file from saltenv 'base', ** done ** '_states/jenkins_user.py'
2017-09-14 01:10:46,316 [salt.fileclient  ][INFO    ][23074] Fetching file from saltenv 'base', ** done ** '_states/jenkins_view.py'
2017-09-14 01:10:46,394 [salt.fileclient  ][INFO    ][23074] Fetching file from saltenv 'base', ** done ** '_states/keystone_policy.py'
2017-09-14 01:10:46,421 [salt.fileclient  ][INFO    ][23074] Fetching file from saltenv 'base', ** done ** '_states/kibana_object.py'
2017-09-14 01:10:46,492 [salt.fileclient  ][INFO    ][23074] Fetching file from saltenv 'base', ** done ** '_states/neutronng.py'
2017-09-14 01:10:46,508 [salt.fileclient  ][INFO    ][23074] Fetching file from saltenv 'base', ** done ** '_states/novang.py'
2017-09-14 01:10:46,617 [salt.fileclient  ][INFO    ][23074] Fetching file from saltenv 'base', ** done ** '_states/reclass.py'
2017-09-14 01:10:46,736 [salt.fileclient  ][INFO    ][23074] Fetching file from saltenv 'base', ** done ** '_states/rundeck_project.py'
2017-09-14 01:10:46,772 [salt.fileclient  ][INFO    ][23074] Fetching file from saltenv 'base', ** done ** '_states/rundeck_scm.py'
2017-09-14 01:10:46,787 [salt.fileclient  ][INFO    ][23074] Fetching file from saltenv 'base', ** done ** '_states/rundeck_secret.py'
2017-09-14 01:10:46,793 [salt.utils.extmods][INFO    ][23074] Copying '/var/cache/salt/minion/files/base/_states/cinderng.py' to '/var/cache/salt/minion/extmods/states/cinderng.py'
2017-09-14 01:10:46,794 [salt.utils.extmods][INFO    ][23074] Copying '/var/cache/salt/minion/files/base/_states/contrail.py' to '/var/cache/salt/minion/extmods/states/contrail.py'
2017-09-14 01:10:46,795 [salt.utils.extmods][INFO    ][23074] Copying '/var/cache/salt/minion/files/base/_states/gerrit.py' to '/var/cache/salt/minion/extmods/states/gerrit.py'
2017-09-14 01:10:46,795 [salt.utils.extmods][INFO    ][23074] Copying '/var/cache/salt/minion/files/base/_states/glanceng.py' to '/var/cache/salt/minion/extmods/states/glanceng.py'
2017-09-14 01:10:46,796 [salt.utils.extmods][INFO    ][23074] Copying '/var/cache/salt/minion/files/base/_states/grafana3_dashboard.py' to '/var/cache/salt/minion/extmods/states/grafana3_dashboard.py'
2017-09-14 01:10:46,796 [salt.utils.extmods][INFO    ][23074] Copying '/var/cache/salt/minion/files/base/_states/grafana3_datasource.py' to '/var/cache/salt/minion/extmods/states/grafana3_datasource.py'
2017-09-14 01:10:46,797 [salt.utils.extmods][INFO    ][23074] Copying '/var/cache/salt/minion/files/base/_states/heat.py' to '/var/cache/salt/minion/extmods/states/heat.py'
2017-09-14 01:10:46,797 [salt.utils.extmods][INFO    ][23074] Copying '/var/cache/salt/minion/files/base/_states/helm_release.py' to '/var/cache/salt/minion/extmods/states/helm_release.py'
2017-09-14 01:10:46,798 [salt.utils.extmods][INFO    ][23074] Copying '/var/cache/salt/minion/files/base/_states/jenkins_approval.py' to '/var/cache/salt/minion/extmods/states/jenkins_approval.py'
2017-09-14 01:10:46,798 [salt.utils.extmods][INFO    ][23074] Copying '/var/cache/salt/minion/files/base/_states/jenkins_artifactory.py' to '/var/cache/salt/minion/extmods/states/jenkins_artifactory.py'
2017-09-14 01:10:46,799 [salt.utils.extmods][INFO    ][23074] Copying '/var/cache/salt/minion/files/base/_states/jenkins_credential.py' to '/var/cache/salt/minion/extmods/states/jenkins_credential.py'
2017-09-14 01:10:46,799 [salt.utils.extmods][INFO    ][23074] Copying '/var/cache/salt/minion/files/base/_states/jenkins_job.py' to '/var/cache/salt/minion/extmods/states/jenkins_job.py'
2017-09-14 01:10:46,799 [salt.utils.extmods][INFO    ][23074] Copying '/var/cache/salt/minion/files/base/_states/jenkins_lib.py' to '/var/cache/salt/minion/extmods/states/jenkins_lib.py'
2017-09-14 01:10:46,800 [salt.utils.extmods][INFO    ][23074] Copying '/var/cache/salt/minion/files/base/_states/jenkins_node.py' to '/var/cache/salt/minion/extmods/states/jenkins_node.py'
2017-09-14 01:10:46,800 [salt.utils.extmods][INFO    ][23074] Copying '/var/cache/salt/minion/files/base/_states/jenkins_plugin.py' to '/var/cache/salt/minion/extmods/states/jenkins_plugin.py'
2017-09-14 01:10:46,801 [salt.utils.extmods][INFO    ][23074] Copying '/var/cache/salt/minion/files/base/_states/jenkins_security.py' to '/var/cache/salt/minion/extmods/states/jenkins_security.py'
2017-09-14 01:10:46,801 [salt.utils.extmods][INFO    ][23074] Copying '/var/cache/salt/minion/files/base/_states/jenkins_slack.py' to '/var/cache/salt/minion/extmods/states/jenkins_slack.py'
2017-09-14 01:10:46,802 [salt.utils.extmods][INFO    ][23074] Copying '/var/cache/salt/minion/files/base/_states/jenkins_smtp.py' to '/var/cache/salt/minion/extmods/states/jenkins_smtp.py'
2017-09-14 01:10:46,802 [salt.utils.extmods][INFO    ][23074] Copying '/var/cache/salt/minion/files/base/_states/jenkins_theme.py' to '/var/cache/salt/minion/extmods/states/jenkins_theme.py'
2017-09-14 01:10:46,803 [salt.utils.extmods][INFO    ][23074] Copying '/var/cache/salt/minion/files/base/_states/jenkins_user.py' to '/var/cache/salt/minion/extmods/states/jenkins_user.py'
2017-09-14 01:10:46,803 [salt.utils.extmods][INFO    ][23074] Copying '/var/cache/salt/minion/files/base/_states/jenkins_view.py' to '/var/cache/salt/minion/extmods/states/jenkins_view.py'
2017-09-14 01:10:46,803 [salt.utils.extmods][INFO    ][23074] Copying '/var/cache/salt/minion/files/base/_states/keystone_policy.py' to '/var/cache/salt/minion/extmods/states/keystone_policy.py'
2017-09-14 01:10:46,804 [salt.utils.extmods][INFO    ][23074] Copying '/var/cache/salt/minion/files/base/_states/kibana_object.py' to '/var/cache/salt/minion/extmods/states/kibana_object.py'
2017-09-14 01:10:46,804 [salt.utils.extmods][INFO    ][23074] Copying '/var/cache/salt/minion/files/base/_states/maas_cluster.py' to '/var/cache/salt/minion/extmods/states/maas_cluster.py'
2017-09-14 01:10:46,805 [salt.utils.extmods][INFO    ][23074] Copying '/var/cache/salt/minion/files/base/_states/neutronng.py' to '/var/cache/salt/minion/extmods/states/neutronng.py'
2017-09-14 01:10:46,805 [salt.utils.extmods][INFO    ][23074] Copying '/var/cache/salt/minion/files/base/_states/novang.py' to '/var/cache/salt/minion/extmods/states/novang.py'
2017-09-14 01:10:46,806 [salt.utils.extmods][INFO    ][23074] Copying '/var/cache/salt/minion/files/base/_states/reclass.py' to '/var/cache/salt/minion/extmods/states/reclass.py'
2017-09-14 01:10:46,806 [salt.utils.extmods][INFO    ][23074] Copying '/var/cache/salt/minion/files/base/_states/rundeck_project.py' to '/var/cache/salt/minion/extmods/states/rundeck_project.py'
2017-09-14 01:10:46,807 [salt.utils.extmods][INFO    ][23074] Copying '/var/cache/salt/minion/files/base/_states/rundeck_scm.py' to '/var/cache/salt/minion/extmods/states/rundeck_scm.py'
2017-09-14 01:10:46,807 [salt.utils.extmods][INFO    ][23074] Copying '/var/cache/salt/minion/files/base/_states/rundeck_secret.py' to '/var/cache/salt/minion/extmods/states/rundeck_secret.py'
2017-09-14 01:10:46,811 [salt.utils.extmods][INFO    ][23074] Creating module dir '/var/cache/salt/minion/extmods/sdb'
2017-09-14 01:10:46,817 [salt.utils.extmods][INFO    ][23074] Syncing sdb for environment 'base'
2017-09-14 01:10:46,817 [salt.utils.extmods][INFO    ][23074] Loading cache from salt://_sdb, for base)
2017-09-14 01:10:46,818 [salt.fileclient  ][INFO    ][23074] Caching directory '_sdb/' for environment 'base'
2017-09-14 01:10:46,992 [salt.utils.extmods][INFO    ][23074] Syncing grains for environment 'base'
2017-09-14 01:10:46,992 [salt.utils.extmods][INFO    ][23074] Loading cache from salt://_grains, for base)
2017-09-14 01:10:46,993 [salt.fileclient  ][INFO    ][23074] Caching directory '_grains/' for environment 'base'
2017-09-14 01:10:47,063 [salt.fileclient  ][INFO    ][23074] Fetching file from saltenv 'base', ** done ** '_grains/ceilometer_policy.py'
2017-09-14 01:10:47,109 [salt.fileclient  ][INFO    ][23074] Fetching file from saltenv 'base', ** done ** '_grains/cinder_policy.py'
2017-09-14 01:10:47,145 [salt.fileclient  ][INFO    ][23074] Fetching file from saltenv 'base', ** done ** '_grains/docker_swarm.py'
2017-09-14 01:10:47,164 [salt.fileclient  ][INFO    ][23074] Fetching file from saltenv 'base', ** done ** '_grains/glance_policy.py'
2017-09-14 01:10:47,176 [salt.fileclient  ][INFO    ][23074] Fetching file from saltenv 'base', ** done ** '_grains/heat_policy.py'
2017-09-14 01:10:47,215 [salt.fileclient  ][INFO    ][23074] Fetching file from saltenv 'base', ** done ** '_grains/jenkins_plugins.py'
2017-09-14 01:10:47,230 [salt.fileclient  ][INFO    ][23074] Fetching file from saltenv 'base', ** done ** '_grains/keystone_policy.py'
2017-09-14 01:10:47,288 [salt.fileclient  ][INFO    ][23074] Fetching file from saltenv 'base', ** done ** '_grains/kubernetes.py'
2017-09-14 01:10:47,300 [salt.fileclient  ][INFO    ][23074] Fetching file from saltenv 'base', ** done ** '_grains/neutron_policy.py'
2017-09-14 01:10:47,316 [salt.fileclient  ][INFO    ][23074] Fetching file from saltenv 'base', ** done ** '_grains/nova_policy.py'
2017-09-14 01:10:47,338 [salt.fileclient  ][INFO    ][23074] Fetching file from saltenv 'base', ** done ** '_grains/ssh_fingerprints.py'
2017-09-14 01:10:47,344 [salt.utils.extmods][INFO    ][23074] Copying '/var/cache/salt/minion/files/base/_grains/ceilometer_policy.py' to '/var/cache/salt/minion/extmods/grains/ceilometer_policy.py'
2017-09-14 01:10:47,344 [salt.utils.extmods][INFO    ][23074] Copying '/var/cache/salt/minion/files/base/_grains/cinder_policy.py' to '/var/cache/salt/minion/extmods/grains/cinder_policy.py'
2017-09-14 01:10:47,345 [salt.utils.extmods][INFO    ][23074] Copying '/var/cache/salt/minion/files/base/_grains/docker_swarm.py' to '/var/cache/salt/minion/extmods/grains/docker_swarm.py'
2017-09-14 01:10:47,345 [salt.utils.extmods][INFO    ][23074] Copying '/var/cache/salt/minion/files/base/_grains/glance_policy.py' to '/var/cache/salt/minion/extmods/grains/glance_policy.py'
2017-09-14 01:10:47,346 [salt.utils.extmods][INFO    ][23074] Copying '/var/cache/salt/minion/files/base/_grains/heat_policy.py' to '/var/cache/salt/minion/extmods/grains/heat_policy.py'
2017-09-14 01:10:47,346 [salt.utils.extmods][INFO    ][23074] Copying '/var/cache/salt/minion/files/base/_grains/jenkins_plugins.py' to '/var/cache/salt/minion/extmods/grains/jenkins_plugins.py'
2017-09-14 01:10:47,346 [salt.utils.extmods][INFO    ][23074] Copying '/var/cache/salt/minion/files/base/_grains/keystone_policy.py' to '/var/cache/salt/minion/extmods/grains/keystone_policy.py'
2017-09-14 01:10:47,347 [salt.utils.extmods][INFO    ][23074] Copying '/var/cache/salt/minion/files/base/_grains/kubernetes.py' to '/var/cache/salt/minion/extmods/grains/kubernetes.py'
2017-09-14 01:10:47,347 [salt.utils.extmods][INFO    ][23074] Copying '/var/cache/salt/minion/files/base/_grains/neutron_policy.py' to '/var/cache/salt/minion/extmods/grains/neutron_policy.py'
2017-09-14 01:10:47,348 [salt.utils.extmods][INFO    ][23074] Copying '/var/cache/salt/minion/files/base/_grains/nova_policy.py' to '/var/cache/salt/minion/extmods/grains/nova_policy.py'
2017-09-14 01:10:47,348 [salt.utils.extmods][INFO    ][23074] Copying '/var/cache/salt/minion/files/base/_grains/ssh_fingerprints.py' to '/var/cache/salt/minion/extmods/grains/ssh_fingerprints.py'
2017-09-14 01:10:47,350 [salt.utils.extmods][INFO    ][23074] Creating module dir '/var/cache/salt/minion/extmods/renderers'
2017-09-14 01:10:47,358 [salt.utils.extmods][INFO    ][23074] Syncing renderers for environment 'base'
2017-09-14 01:10:47,359 [salt.utils.extmods][INFO    ][23074] Loading cache from salt://_renderers, for base)
2017-09-14 01:10:47,359 [salt.fileclient  ][INFO    ][23074] Caching directory '_renderers/' for environment 'base'
2017-09-14 01:10:47,416 [salt.utils.extmods][INFO    ][23074] Creating module dir '/var/cache/salt/minion/extmods/returners'
2017-09-14 01:10:47,421 [salt.utils.extmods][INFO    ][23074] Syncing returners for environment 'base'
2017-09-14 01:10:47,422 [salt.utils.extmods][INFO    ][23074] Loading cache from salt://_returners, for base)
2017-09-14 01:10:47,422 [salt.fileclient  ][INFO    ][23074] Caching directory '_returners/' for environment 'base'
2017-09-14 01:10:47,527 [salt.utils.extmods][INFO    ][23074] Creating module dir '/var/cache/salt/minion/extmods/output'
2017-09-14 01:10:47,533 [salt.utils.extmods][INFO    ][23074] Syncing output for environment 'base'
2017-09-14 01:10:47,533 [salt.utils.extmods][INFO    ][23074] Loading cache from salt://_output, for base)
2017-09-14 01:10:47,533 [salt.fileclient  ][INFO    ][23074] Caching directory '_output/' for environment 'base'
2017-09-14 01:10:47,582 [salt.utils.extmods][INFO    ][23074] Creating module dir '/var/cache/salt/minion/extmods/utils'
2017-09-14 01:10:47,587 [salt.utils.extmods][INFO    ][23074] Syncing utils for environment 'base'
2017-09-14 01:10:47,587 [salt.utils.extmods][INFO    ][23074] Loading cache from salt://_utils, for base)
2017-09-14 01:10:47,587 [salt.fileclient  ][INFO    ][23074] Caching directory '_utils/' for environment 'base'
2017-09-14 01:10:47,659 [salt.utils.extmods][INFO    ][23074] Creating module dir '/var/cache/salt/minion/extmods/log_handlers'
2017-09-14 01:10:47,664 [salt.utils.extmods][INFO    ][23074] Syncing log_handlers for environment 'base'
2017-09-14 01:10:47,664 [salt.utils.extmods][INFO    ][23074] Loading cache from salt://_log_handlers, for base)
2017-09-14 01:10:47,665 [salt.fileclient  ][INFO    ][23074] Caching directory '_log_handlers/' for environment 'base'
2017-09-14 01:10:47,733 [salt.utils.extmods][INFO    ][23074] Creating module dir '/var/cache/salt/minion/extmods/proxy'
2017-09-14 01:10:47,738 [salt.utils.extmods][INFO    ][23074] Syncing proxy for environment 'base'
2017-09-14 01:10:47,738 [salt.utils.extmods][INFO    ][23074] Loading cache from salt://_proxy, for base)
2017-09-14 01:10:47,739 [salt.fileclient  ][INFO    ][23074] Caching directory '_proxy/' for environment 'base'
2017-09-14 01:10:47,772 [salt.utils.extmods][INFO    ][23074] Creating module dir '/var/cache/salt/minion/extmods/engines'
2017-09-14 01:10:47,777 [salt.utils.extmods][INFO    ][23074] Syncing engines for environment 'base'
2017-09-14 01:10:47,777 [salt.utils.extmods][INFO    ][23074] Loading cache from salt://_engines, for base)
2017-09-14 01:10:47,777 [salt.fileclient  ][INFO    ][23074] Caching directory '_engines/' for environment 'base'
2017-09-14 01:10:47,859 [salt.minion      ][INFO    ][23074] Returning information for job: 20170914011040696760
2017-09-14 01:16:45,919 [salt.minion      ][INFO    ][21560] User sudo_ubuntu Executing command test.ping with jid 20170914011645900577
2017-09-14 01:16:45,941 [salt.minion      ][INFO    ][23243] Starting a new job with PID 23243
2017-09-14 01:16:46,001 [salt.minion      ][INFO    ][23243] Returning information for job: 20170914011645900577
2017-09-14 01:20:23,273 [salt.minion      ][INFO    ][21560] User sudo_ubuntu Executing command state.sls with jid 20170914012023264630
2017-09-14 01:20:23,295 [salt.minion      ][INFO    ][23321] Starting a new job with PID 23321
2017-09-14 01:20:24,653 [salt.state       ][INFO    ][23321] Loading fresh modules for state activity
2017-09-14 01:20:24,699 [salt.fileclient  ][INFO    ][23321] Fetching file from saltenv 'base', ** done ** 'keepalived/init.sls'
2017-09-14 01:20:24,725 [salt.fileclient  ][INFO    ][23321] Fetching file from saltenv 'base', ** done ** 'keepalived/cluster.sls'
2017-09-14 01:20:24,766 [salt.fileclient  ][INFO    ][23321] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-09-14 01:20:25,235 [salt.state       ][INFO    ][23321] Running state [lsof] at time 01:20:25.235402
2017-09-14 01:20:25,236 [salt.state       ][INFO    ][23321] Executing state pkg.installed for lsof
2017-09-14 01:20:25,236 [salt.loaded.int.module.cmdmod][INFO    ][23321] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-14 01:20:25,583 [salt.state       ][INFO    ][23321] Package lsof is already installed
2017-09-14 01:20:25,584 [salt.state       ][INFO    ][23321] Completed state [lsof] at time 01:20:25.583660 duration_in_ms=348.257
2017-09-14 01:20:25,584 [salt.state       ][INFO    ][23321] Running state [keepalived] at time 01:20:25.583879
2017-09-14 01:20:25,584 [salt.state       ][INFO    ][23321] Executing state pkg.installed for keepalived
2017-09-14 01:20:25,604 [salt.loaded.int.module.cmdmod][INFO    ][23321] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-09-14 01:20:27,704 [salt.loaded.int.module.cmdmod][INFO    ][23321] 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-09-14 01:20:33,317 [salt.minion      ][INFO    ][21560] User sudo_ubuntu Executing command saltutil.find_job with jid 20170914012033306627
2017-09-14 01:20:33,339 [salt.minion      ][INFO    ][24585] Starting a new job with PID 24585
2017-09-14 01:20:33,358 [salt.minion      ][INFO    ][24585] Returning information for job: 20170914012033306627
2017-09-14 01:20:37,313 [salt.loaded.int.module.cmdmod][INFO    ][23321] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-14 01:20:37,366 [salt.state       ][INFO    ][23321] 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-09-14 01:20:37,396 [salt.state       ][INFO    ][23321] Loading fresh modules for state activity
2017-09-14 01:20:37,424 [salt.state       ][INFO    ][23321] Completed state [keepalived] at time 01:20:37.423574 duration_in_ms=11839.694
2017-09-14 01:20:37,428 [salt.state       ][INFO    ][23321] Running state [/etc/keepalived/keepalived.conf] at time 01:20:37.428120
2017-09-14 01:20:37,429 [salt.state       ][INFO    ][23321] Executing state file.managed for /etc/keepalived/keepalived.conf
2017-09-14 01:20:37,461 [salt.fileclient  ][INFO    ][23321] Fetching file from saltenv 'base', ** done ** 'keepalived/files/keepalived.conf'
2017-09-14 01:20:37,506 [salt.fileclient  ][INFO    ][23321] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-09-14 01:20:37,521 [salt.state       ][INFO    ][23321] File changed:
New file
2017-09-14 01:20:37,522 [salt.state       ][INFO    ][23321] Completed state [/etc/keepalived/keepalived.conf] at time 01:20:37.521726 duration_in_ms=93.604
2017-09-14 01:20:37,626 [salt.state       ][INFO    ][23321] Running state [keepalived] at time 01:20:37.625793
2017-09-14 01:20:37,626 [salt.state       ][INFO    ][23321] Executing state service.running for keepalived
2017-09-14 01:20:37,629 [salt.loaded.int.module.cmdmod][INFO    ][23321] Executing command ['systemctl', 'status', 'keepalived.service', '-n', '0'] in directory '/root'
2017-09-14 01:20:37,645 [salt.loaded.int.module.cmdmod][INFO    ][23321] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2017-09-14 01:20:37,662 [salt.loaded.int.module.cmdmod][INFO    ][23321] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-09-14 01:20:37,675 [salt.loaded.int.module.cmdmod][INFO    ][23321] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-09-14 01:20:37,690 [salt.loaded.int.module.cmdmod][INFO    ][23321] Executing command ['systemd-run', '--scope', 'systemctl', 'start', 'keepalived.service'] in directory '/root'
2017-09-14 01:20:37,771 [salt.loaded.int.module.cmdmod][INFO    ][23321] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2017-09-14 01:20:37,787 [salt.loaded.int.module.cmdmod][INFO    ][23321] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-09-14 01:20:37,803 [salt.loaded.int.module.cmdmod][INFO    ][23321] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-09-14 01:20:37,817 [salt.state       ][INFO    ][23321] {'keepalived': True}
2017-09-14 01:20:37,818 [salt.state       ][INFO    ][23321] Completed state [keepalived] at time 01:20:37.817671 duration_in_ms=191.878
2017-09-14 01:20:37,819 [salt.minion      ][INFO    ][23321] Returning information for job: 20170914012023264630
2017-09-14 01:21:06,937 [salt.minion      ][INFO    ][21560] User sudo_ubuntu Executing command pillar.get with jid 20170914012106932850
2017-09-14 01:21:06,963 [salt.minion      ][INFO    ][24886] Starting a new job with PID 24886
2017-09-14 01:21:06,973 [salt.minion      ][INFO    ][24886] Returning information for job: 20170914012106932850
2017-09-14 01:26:40,119 [salt.minion      ][INFO    ][21560] User sudo_ubuntu Executing command state.sls with jid 20170914012640109929
2017-09-14 01:26:40,142 [salt.minion      ][INFO    ][24974] Starting a new job with PID 24974
2017-09-14 01:26:42,611 [salt.state       ][INFO    ][24974] Loading fresh modules for state activity
2017-09-14 01:26:42,654 [salt.fileclient  ][INFO    ][24974] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-09-14 01:26:42,689 [salt.fileclient  ][INFO    ][24974] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-09-14 01:26:43,105 [salt.state       ][INFO    ][24974] Running state [attr] at time 01:26:43.105318
2017-09-14 01:26:43,106 [salt.state       ][INFO    ][24974] Executing state pkg.installed for attr
2017-09-14 01:26:43,106 [salt.loaded.int.module.cmdmod][INFO    ][24974] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-14 01:26:43,495 [salt.loaded.int.module.cmdmod][INFO    ][24974] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-09-14 01:26:45,815 [salt.loaded.int.module.cmdmod][INFO    ][24974] 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-09-14 01:26:48,943 [salt.loaded.int.module.cmdmod][INFO    ][24974] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-14 01:26:48,995 [salt.state       ][INFO    ][24974] Made the following changes:
'attr' changed from 'absent' to '1:2.4.47-2'

2017-09-14 01:26:49,010 [salt.state       ][INFO    ][24974] Loading fresh modules for state activity
2017-09-14 01:26:49,031 [salt.state       ][INFO    ][24974] Completed state [attr] at time 01:26:49.031184 duration_in_ms=5925.866
2017-09-14 01:26:49,040 [salt.state       ][INFO    ][24974] Running state [glusterfs-server] at time 01:26:49.040314
2017-09-14 01:26:49,041 [salt.state       ][INFO    ][24974] Executing state pkg.installed for glusterfs-server
2017-09-14 01:26:49,340 [salt.loaded.int.module.cmdmod][INFO    ][24974] 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-09-14 01:26:50,210 [salt.minion      ][INFO    ][21560] User sudo_ubuntu Executing command saltutil.find_job with jid 20170914012650201240
2017-09-14 01:26:50,232 [salt.minion      ][INFO    ][25936] Starting a new job with PID 25936
2017-09-14 01:26:50,254 [salt.minion      ][INFO    ][25936] Returning information for job: 20170914012650201240
2017-09-14 01:27:00,417 [salt.minion      ][INFO    ][21560] User sudo_ubuntu Executing command saltutil.find_job with jid 20170914012700407684
2017-09-14 01:27:00,440 [salt.minion      ][INFO    ][28636] Starting a new job with PID 28636
2017-09-14 01:27:00,466 [salt.minion      ][INFO    ][28636] Returning information for job: 20170914012700407684
2017-09-14 01:27:10,503 [salt.minion      ][INFO    ][21560] User sudo_ubuntu Executing command saltutil.find_job with jid 20170914012710493061
2017-09-14 01:27:10,525 [salt.minion      ][INFO    ][29237] Starting a new job with PID 29237
2017-09-14 01:27:10,541 [salt.minion      ][INFO    ][29237] Returning information for job: 20170914012710493061
2017-09-14 01:27:11,134 [salt.loaded.int.module.cmdmod][INFO    ][24974] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-14 01:27:11,187 [salt.state       ][INFO    ][24974] 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-09-14 01:27:11,203 [salt.state       ][INFO    ][24974] Loading fresh modules for state activity
2017-09-14 01:27:11,228 [salt.state       ][INFO    ][24974] Completed state [glusterfs-server] at time 01:27:11.227660 duration_in_ms=22187.345
2017-09-14 01:27:11,236 [salt.state       ][INFO    ][24974] Running state [bc] at time 01:27:11.235902
2017-09-14 01:27:11,236 [salt.state       ][INFO    ][24974] Executing state pkg.installed for bc
2017-09-14 01:27:11,532 [salt.loaded.int.module.cmdmod][INFO    ][24974] 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-09-14 01:27:15,096 [salt.loaded.int.module.cmdmod][INFO    ][24974] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-14 01:27:15,151 [salt.state       ][INFO    ][24974] Made the following changes:
'bc' changed from 'absent' to '1.06.95-9build1'

2017-09-14 01:27:15,165 [salt.state       ][INFO    ][24974] Loading fresh modules for state activity
2017-09-14 01:27:15,190 [salt.state       ][INFO    ][24974] Completed state [bc] at time 01:27:15.190009 duration_in_ms=3954.105
2017-09-14 01:27:15,290 [salt.state       ][INFO    ][24974] Running state [glusterfs-server] at time 01:27:15.289757
2017-09-14 01:27:15,290 [salt.state       ][INFO    ][24974] Executing state service.running for glusterfs-server
2017-09-14 01:27:15,292 [salt.loaded.int.module.cmdmod][INFO    ][24974] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-09-14 01:27:15,309 [salt.loaded.int.module.cmdmod][INFO    ][24974] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-09-14 01:27:15,324 [salt.loaded.int.module.cmdmod][INFO    ][24974] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-09-14 01:27:15,342 [salt.state       ][INFO    ][24974] The service glusterfs-server is already running
2017-09-14 01:27:15,342 [salt.state       ][INFO    ][24974] Completed state [glusterfs-server] at time 01:27:15.341797 duration_in_ms=52.041
2017-09-14 01:27:15,344 [salt.state       ][INFO    ][24974] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 01:27:15.343958
2017-09-14 01:27:15,344 [salt.state       ][INFO    ][24974] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-09-14 01:27:15,353 [salt.state       ][INFO    ][24974] File changed:
New file
2017-09-14 01:27:15,353 [salt.state       ][INFO    ][24974] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 01:27:15.353292 duration_in_ms=9.334
2017-09-14 01:27:15,354 [salt.state       ][INFO    ][24974] Running state [/srv/glusterfs/glance] at time 01:27:15.353567
2017-09-14 01:27:15,354 [salt.state       ][INFO    ][24974] Executing state file.directory for /srv/glusterfs/glance
2017-09-14 01:27:15,380 [salt.state       ][INFO    ][24974] {'/srv/glusterfs/glance': 'New Dir'}
2017-09-14 01:27:15,380 [salt.state       ][INFO    ][24974] Completed state [/srv/glusterfs/glance] at time 01:27:15.380409 duration_in_ms=26.842
2017-09-14 01:27:15,381 [salt.state       ][INFO    ][24974] Running state [/srv/glusterfs/keystone-keys] at time 01:27:15.380741
2017-09-14 01:27:15,381 [salt.state       ][INFO    ][24974] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-09-14 01:27:15,382 [salt.state       ][INFO    ][24974] {'/srv/glusterfs/keystone-keys': 'New Dir'}
2017-09-14 01:27:15,382 [salt.state       ][INFO    ][24974] Completed state [/srv/glusterfs/keystone-keys] at time 01:27:15.382205 duration_in_ms=1.465
2017-09-14 01:27:15,383 [salt.state       ][INFO    ][24974] Running state [/srv/glusterfs/nova_instances] at time 01:27:15.382537
2017-09-14 01:27:15,383 [salt.state       ][INFO    ][24974] Executing state file.directory for /srv/glusterfs/nova_instances
2017-09-14 01:27:15,384 [salt.state       ][INFO    ][24974] {'/srv/glusterfs/nova_instances': 'New Dir'}
2017-09-14 01:27:15,384 [salt.state       ][INFO    ][24974] Completed state [/srv/glusterfs/nova_instances] at time 01:27:15.383947 duration_in_ms=1.409
2017-09-14 01:27:15,384 [salt.state       ][INFO    ][24974] Running state [/srv/glusterfs/keystone-credential-keys] at time 01:27:15.384286
2017-09-14 01:27:15,385 [salt.state       ][INFO    ][24974] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-09-14 01:27:15,385 [salt.state       ][INFO    ][24974] {'/srv/glusterfs/keystone-credential-keys': 'New Dir'}
2017-09-14 01:27:15,386 [salt.state       ][INFO    ][24974] Completed state [/srv/glusterfs/keystone-credential-keys] at time 01:27:15.385741 duration_in_ms=1.455
2017-09-14 01:27:15,387 [salt.minion      ][INFO    ][24974] Returning information for job: 20170914012640109929
2017-09-14 01:27:16,931 [salt.minion      ][INFO    ][21560] User sudo_ubuntu Executing command test.ping with jid 20170914012716922970
2017-09-14 01:27:16,953 [salt.minion      ][INFO    ][29692] Starting a new job with PID 29692
2017-09-14 01:27:17,013 [salt.minion      ][INFO    ][29692] Returning information for job: 20170914012716922970
2017-09-14 01:28:03,374 [salt.minion      ][INFO    ][21560] User sudo_ubuntu Executing command state.sls with jid 20170914012803368723
2017-09-14 01:28:03,398 [salt.minion      ][INFO    ][29909] Starting a new job with PID 29909
2017-09-14 01:28:04,759 [salt.state       ][INFO    ][29909] Loading fresh modules for state activity
2017-09-14 01:28:04,799 [salt.fileclient  ][INFO    ][29909] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/setup.sls'
2017-09-14 01:28:04,853 [salt.fileclient  ][INFO    ][29909] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-09-14 01:28:04,953 [salt.fileclient  ][INFO    ][29909] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-09-14 01:28:04,983 [salt.fileclient  ][INFO    ][29909] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-09-14 01:28:05,413 [salt.state       ][INFO    ][29909] Running state [attr] at time 01:28:05.412890
2017-09-14 01:28:05,413 [salt.state       ][INFO    ][29909] Executing state pkg.installed for attr
2017-09-14 01:28:05,414 [salt.loaded.int.module.cmdmod][INFO    ][29909] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-14 01:28:05,827 [salt.state       ][INFO    ][29909] Package attr is already installed
2017-09-14 01:28:05,828 [salt.state       ][INFO    ][29909] Completed state [attr] at time 01:28:05.828152 duration_in_ms=415.261
2017-09-14 01:28:05,829 [salt.state       ][INFO    ][29909] Running state [glusterfs-server] at time 01:28:05.828846
2017-09-14 01:28:05,829 [salt.state       ][INFO    ][29909] Executing state pkg.installed for glusterfs-server
2017-09-14 01:28:05,835 [salt.state       ][INFO    ][29909] Package glusterfs-server is already installed
2017-09-14 01:28:05,835 [salt.state       ][INFO    ][29909] Completed state [glusterfs-server] at time 01:28:05.835034 duration_in_ms=6.188
2017-09-14 01:28:05,835 [salt.state       ][INFO    ][29909] Running state [bc] at time 01:28:05.835378
2017-09-14 01:28:05,836 [salt.state       ][INFO    ][29909] Executing state pkg.installed for bc
2017-09-14 01:28:05,841 [salt.state       ][INFO    ][29909] Package bc is already installed
2017-09-14 01:28:05,841 [salt.state       ][INFO    ][29909] Completed state [bc] at time 01:28:05.840992 duration_in_ms=5.614
2017-09-14 01:28:05,843 [salt.state       ][INFO    ][29909] Running state [glusterfs-server] at time 01:28:05.843368
2017-09-14 01:28:05,844 [salt.state       ][INFO    ][29909] Executing state service.running for glusterfs-server
2017-09-14 01:28:05,845 [salt.loaded.int.module.cmdmod][INFO    ][29909] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-09-14 01:28:05,865 [salt.loaded.int.module.cmdmod][INFO    ][29909] Executing command ['systemctl', '--system', 'daemon-reload'] in directory '/root'
2017-09-14 01:28:05,950 [salt.loaded.int.module.cmdmod][INFO    ][29909] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-09-14 01:28:05,981 [salt.loaded.int.module.cmdmod][INFO    ][29909] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-09-14 01:28:05,997 [salt.loaded.int.module.cmdmod][INFO    ][29909] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-09-14 01:28:06,016 [salt.state       ][INFO    ][29909] The service glusterfs-server is already running
2017-09-14 01:28:06,016 [salt.state       ][INFO    ][29909] Completed state [glusterfs-server] at time 01:28:06.016259 duration_in_ms=172.89
2017-09-14 01:28:06,022 [salt.state       ][INFO    ][29909] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 01:28:06.021877
2017-09-14 01:28:06,022 [salt.state       ][INFO    ][29909] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-09-14 01:28:06,045 [salt.state       ][INFO    ][29909] File /etc/systemd/system/glusterfs-server.service.d/override.conf is in the correct state
2017-09-14 01:28:06,046 [salt.state       ][INFO    ][29909] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 01:28:06.045460 duration_in_ms=23.582
2017-09-14 01:28:06,046 [salt.state       ][INFO    ][29909] Running state [/srv/glusterfs/glance] at time 01:28:06.045868
2017-09-14 01:28:06,046 [salt.state       ][INFO    ][29909] Executing state file.directory for /srv/glusterfs/glance
2017-09-14 01:28:06,047 [salt.state       ][INFO    ][29909] Directory /srv/glusterfs/glance is in the correct state
2017-09-14 01:28:06,047 [salt.state       ][INFO    ][29909] Completed state [/srv/glusterfs/glance] at time 01:28:06.047335 duration_in_ms=1.467
2017-09-14 01:28:06,048 [salt.state       ][INFO    ][29909] Running state [/srv/glusterfs/keystone-keys] at time 01:28:06.047693
2017-09-14 01:28:06,048 [salt.state       ][INFO    ][29909] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-09-14 01:28:06,049 [salt.state       ][INFO    ][29909] Directory /srv/glusterfs/keystone-keys is in the correct state
2017-09-14 01:28:06,049 [salt.state       ][INFO    ][29909] Completed state [/srv/glusterfs/keystone-keys] at time 01:28:06.049093 duration_in_ms=1.4
2017-09-14 01:28:06,050 [salt.state       ][INFO    ][29909] Running state [/srv/glusterfs/nova_instances] at time 01:28:06.049532
2017-09-14 01:28:06,050 [salt.state       ][INFO    ][29909] Executing state file.directory for /srv/glusterfs/nova_instances
2017-09-14 01:28:06,051 [salt.state       ][INFO    ][29909] Directory /srv/glusterfs/nova_instances is in the correct state
2017-09-14 01:28:06,051 [salt.state       ][INFO    ][29909] Completed state [/srv/glusterfs/nova_instances] at time 01:28:06.050862 duration_in_ms=1.331
2017-09-14 01:28:06,051 [salt.state       ][INFO    ][29909] Running state [/srv/glusterfs/keystone-credential-keys] at time 01:28:06.051177
2017-09-14 01:28:06,052 [salt.state       ][INFO    ][29909] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-09-14 01:28:06,052 [salt.state       ][INFO    ][29909] Directory /srv/glusterfs/keystone-credential-keys is in the correct state
2017-09-14 01:28:06,052 [salt.state       ][INFO    ][29909] Completed state [/srv/glusterfs/keystone-credential-keys] at time 01:28:06.052436 duration_in_ms=1.259
2017-09-14 01:28:06,155 [salt.loaded.int.module.cmdmod][INFO    ][29909] Executing command ['git', '--version'] in directory '/root'
2017-09-14 01:28:06,276 [salt.state       ][INFO    ][29909] Running state [sleep 5] at time 01:28:06.276125
2017-09-14 01:28:06,276 [salt.state       ][INFO    ][29909] Executing state cmd.wait for sleep 5
2017-09-14 01:28:06,277 [salt.state       ][INFO    ][29909] No changes made for sleep 5
2017-09-14 01:28:06,277 [salt.state       ][INFO    ][29909] Completed state [sleep 5] at time 01:28:06.276740 duration_in_ms=0.615
2017-09-14 01:28:06,277 [salt.state       ][INFO    ][29909] Running state [10.167.4.141] at time 01:28:06.277148
2017-09-14 01:28:06,277 [salt.state       ][INFO    ][29909] Executing state glusterfs.peered for 10.167.4.141
2017-09-14 01:28:06,278 [salt.loaded.int.module.cmdmod][INFO    ][29909] Executing command 'gluster --version' in directory '/root'
2017-09-14 01:28:06,293 [salt.loaded.int.module.cmdmod][INFO    ][29909] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-14 01:28:06,399 [salt.state       ][INFO    ][29909] Host 10.167.4.141 already peered
2017-09-14 01:28:06,399 [salt.state       ][INFO    ][29909] Completed state [10.167.4.141] at time 01:28:06.399150 duration_in_ms=122.001
2017-09-14 01:28:06,405 [salt.state       ][INFO    ][29909] Running state [10.167.4.142] at time 01:28:06.404765
2017-09-14 01:28:06,405 [salt.state       ][INFO    ][29909] Executing state glusterfs.peered for 10.167.4.142
2017-09-14 01:28:06,406 [salt.loaded.int.module.cmdmod][INFO    ][29909] Executing command 'gluster --version' in directory '/root'
2017-09-14 01:28:06,425 [salt.loaded.int.module.cmdmod][INFO    ][29909] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-14 01:28:06,531 [salt.loaded.int.module.cmdmod][INFO    ][29909] Executing command 'gluster --version' in directory '/root'
2017-09-14 01:28:06,545 [salt.loaded.int.module.cmdmod][INFO    ][29909] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-14 01:28:06,662 [salt.loaded.int.module.cmdmod][INFO    ][29909] Executing command 'gluster --version' in directory '/root'
2017-09-14 01:28:06,681 [salt.loaded.int.module.cmdmod][INFO    ][29909] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-14 01:28:06,791 [salt.loaded.int.module.cmdmod][INFO    ][29909] Executing command 'gluster --version' in directory '/root'
2017-09-14 01:28:06,810 [salt.loaded.int.module.cmdmod][INFO    ][29909] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-14 01:28:06,916 [salt.state       ][INFO    ][29909] {'new': {'10.167.4.141': [], 'kvm02.baremetal-mcp-ocata-ovs-ha.local': ['10.167.4.142']}, 'old': {'10.167.4.141': [], 'kvm02.baremetal-mcp-ocata-ovs-ha.local': []}}
2017-09-14 01:28:06,916 [salt.state       ][INFO    ][29909] Completed state [10.167.4.142] at time 01:28:06.916070 duration_in_ms=511.305
2017-09-14 01:28:06,922 [salt.state       ][INFO    ][29909] Running state [10.167.4.143] at time 01:28:06.921954
2017-09-14 01:28:06,922 [salt.state       ][INFO    ][29909] Executing state glusterfs.peered for 10.167.4.143
2017-09-14 01:28:06,923 [salt.loaded.int.module.cmdmod][INFO    ][29909] Executing command 'gluster --version' in directory '/root'
2017-09-14 01:28:06,940 [salt.loaded.int.module.cmdmod][INFO    ][29909] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-14 01:28:07,044 [salt.loaded.int.module.cmdmod][INFO    ][29909] Executing command 'gluster --version' in directory '/root'
2017-09-14 01:28:07,062 [salt.loaded.int.module.cmdmod][INFO    ][29909] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-14 01:28:07,169 [salt.loaded.int.module.cmdmod][INFO    ][29909] Executing command 'gluster --version' in directory '/root'
2017-09-14 01:28:07,187 [salt.loaded.int.module.cmdmod][INFO    ][29909] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-14 01:28:07,292 [salt.loaded.int.module.cmdmod][INFO    ][29909] Executing command 'gluster --version' in directory '/root'
2017-09-14 01:28:07,309 [salt.loaded.int.module.cmdmod][INFO    ][29909] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-14 01:28:07,416 [salt.state       ][INFO    ][29909] Peering with localhost is not needed
2017-09-14 01:28:07,416 [salt.state       ][INFO    ][29909] Completed state [10.167.4.143] at time 01:28:07.416206 duration_in_ms=494.25
2017-09-14 01:28:07,418 [salt.state       ][INFO    ][29909] Running state [glance] at time 01:28:07.418200
2017-09-14 01:28:07,419 [salt.state       ][INFO    ][29909] Executing state glusterfs.created for glance
2017-09-14 01:28:07,420 [salt.loaded.int.module.cmdmod][INFO    ][29909] Executing command 'gluster --version' in directory '/root'
2017-09-14 01:28:07,435 [salt.loaded.int.module.cmdmod][INFO    ][29909] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-14 01:28:07,544 [salt.loaded.int.module.cmdmod][INFO    ][29909] Executing command 'gluster --version' in directory '/root'
2017-09-14 01:28:07,562 [salt.loaded.int.module.cmdmod][INFO    ][29909] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-14 01:28:07,674 [salt.state       ][INFO    ][29909] Volume glance already exists and is started.
2017-09-14 01:28:07,675 [salt.state       ][INFO    ][29909] Completed state [glance] at time 01:28:07.674395 duration_in_ms=256.195
2017-09-14 01:28:07,681 [salt.state       ][INFO    ][29909] Running state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 01:28:07.681234
2017-09-14 01:28:07,682 [salt.state       ][INFO    ][29909] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'
2017-09-14 01:28:07,683 [salt.loaded.int.module.cmdmod][INFO    ][29909] Executing command 'gluster volume info 'glance' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-09-14 01:28:07,792 [salt.state       ][INFO    ][29909] unless execution succeeded
2017-09-14 01:28:07,792 [salt.state       ][INFO    ][29909] Completed state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 01:28:07.791993 duration_in_ms=110.758
2017-09-14 01:28:07,793 [salt.state       ][INFO    ][29909] Running state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 01:28:07.793120
2017-09-14 01:28:07,794 [salt.state       ][INFO    ][29909] Executing state cmd.run for gluster volume set 'glance' 'network.remote-dio' 'True'
2017-09-14 01:28:07,795 [salt.loaded.int.module.cmdmod][INFO    ][29909] Executing command 'gluster volume info 'glance' | grep 'network.remote-dio: True'' in directory '/root'
2017-09-14 01:28:07,898 [salt.state       ][INFO    ][29909] unless execution succeeded
2017-09-14 01:28:07,898 [salt.state       ][INFO    ][29909] Completed state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 01:28:07.898007 duration_in_ms=104.886
2017-09-14 01:28:07,899 [salt.state       ][INFO    ][29909] Running state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 01:28:07.899228
2017-09-14 01:28:07,900 [salt.state       ][INFO    ][29909] Executing state cmd.run for gluster volume set 'glance' 'nfs.disable' 'True'
2017-09-14 01:28:07,901 [salt.loaded.int.module.cmdmod][INFO    ][29909] Executing command 'gluster volume info 'glance' | grep 'nfs.disable: True'' in directory '/root'
2017-09-14 01:28:08,001 [salt.state       ][INFO    ][29909] unless execution succeeded
2017-09-14 01:28:08,002 [salt.state       ][INFO    ][29909] Completed state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 01:28:08.001843 duration_in_ms=102.616
2017-09-14 01:28:08,003 [salt.state       ][INFO    ][29909] Running state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 01:28:08.002970
2017-09-14 01:28:08,004 [salt.state       ][INFO    ][29909] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'
2017-09-14 01:28:08,005 [salt.loaded.int.module.cmdmod][INFO    ][29909] Executing command 'gluster volume info 'glance' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-09-14 01:28:08,098 [salt.state       ][INFO    ][29909] unless execution succeeded
2017-09-14 01:28:08,099 [salt.state       ][INFO    ][29909] Completed state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 01:28:08.098554 duration_in_ms=95.583
2017-09-14 01:28:08,100 [salt.state       ][INFO    ][29909] Running state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 01:28:08.099640
2017-09-14 01:28:08,100 [salt.state       ][INFO    ][29909] Executing state cmd.run for gluster volume set 'glance' 'cluster.readdir-optimize' 'True'
2017-09-14 01:28:08,101 [salt.loaded.int.module.cmdmod][INFO    ][29909] Executing command 'gluster volume info 'glance' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-09-14 01:28:08,203 [salt.state       ][INFO    ][29909] unless execution succeeded
2017-09-14 01:28:08,203 [salt.state       ][INFO    ][29909] Completed state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 01:28:08.202970 duration_in_ms=103.329
2017-09-14 01:28:08,206 [salt.state       ][INFO    ][29909] Running state [glance] at time 01:28:08.205506
2017-09-14 01:28:08,206 [salt.state       ][INFO    ][29909] Executing state glusterfs.started for glance
2017-09-14 01:28:08,207 [salt.loaded.int.module.cmdmod][INFO    ][29909] Executing command 'gluster --version' in directory '/root'
2017-09-14 01:28:08,223 [salt.loaded.int.module.cmdmod][INFO    ][29909] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-14 01:28:08,328 [salt.loaded.int.module.cmdmod][INFO    ][29909] Executing command 'gluster --version' in directory '/root'
2017-09-14 01:28:08,345 [salt.loaded.int.module.cmdmod][INFO    ][29909] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-14 01:28:08,457 [salt.state       ][INFO    ][29909] Volume glance is already started
2017-09-14 01:28:08,458 [salt.state       ][INFO    ][29909] Completed state [glance] at time 01:28:08.457817 duration_in_ms=252.309
2017-09-14 01:28:08,460 [salt.state       ][INFO    ][29909] Running state [keystone-keys] at time 01:28:08.459581
2017-09-14 01:28:08,460 [salt.state       ][INFO    ][29909] Executing state glusterfs.created for keystone-keys
2017-09-14 01:28:08,461 [salt.loaded.int.module.cmdmod][INFO    ][29909] Executing command 'gluster --version' in directory '/root'
2017-09-14 01:28:08,479 [salt.loaded.int.module.cmdmod][INFO    ][29909] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-14 01:28:08,580 [salt.loaded.int.module.cmdmod][INFO    ][29909] Executing command 'gluster --version' in directory '/root'
2017-09-14 01:28:08,599 [salt.loaded.int.module.cmdmod][INFO    ][29909] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-14 01:28:08,707 [salt.state       ][INFO    ][29909] Volume keystone-keys already exists and is started.
2017-09-14 01:28:08,708 [salt.state       ][INFO    ][29909] Completed state [keystone-keys] at time 01:28:08.707443 duration_in_ms=247.86
2017-09-14 01:28:08,715 [salt.state       ][INFO    ][29909] Running state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 01:28:08.715187
2017-09-14 01:28:08,716 [salt.state       ][INFO    ][29909] Executing state cmd.run for gluster volume set 'keystone-keys' 'network.remote-dio' 'True'
2017-09-14 01:28:08,717 [salt.loaded.int.module.cmdmod][INFO    ][29909] Executing command 'gluster volume info 'keystone-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-09-14 01:28:08,820 [salt.state       ][INFO    ][29909] unless execution succeeded
2017-09-14 01:28:08,821 [salt.state       ][INFO    ][29909] Completed state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 01:28:08.820928 duration_in_ms=105.74
2017-09-14 01:28:08,822 [salt.state       ][INFO    ][29909] Running state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 01:28:08.821990
2017-09-14 01:28:08,823 [salt.state       ][INFO    ][29909] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-09-14 01:28:08,823 [salt.loaded.int.module.cmdmod][INFO    ][29909] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-09-14 01:28:08,934 [salt.state       ][INFO    ][29909] unless execution succeeded
2017-09-14 01:28:08,935 [salt.state       ][INFO    ][29909] Completed state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 01:28:08.934770 duration_in_ms=112.779
2017-09-14 01:28:08,936 [salt.state       ][INFO    ][29909] Running state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 01:28:08.935918
2017-09-14 01:28:08,936 [salt.state       ][INFO    ][29909] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'
2017-09-14 01:28:08,938 [salt.loaded.int.module.cmdmod][INFO    ][29909] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-09-14 01:28:09,033 [salt.state       ][INFO    ][29909] unless execution succeeded
2017-09-14 01:28:09,033 [salt.state       ][INFO    ][29909] Completed state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 01:28:09.033266 duration_in_ms=97.348
2017-09-14 01:28:09,034 [salt.state       ][INFO    ][29909] Running state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 01:28:09.034245
2017-09-14 01:28:09,035 [salt.state       ][INFO    ][29909] Executing state cmd.run for gluster volume set 'keystone-keys' 'nfs.disable' 'True'
2017-09-14 01:28:09,036 [salt.loaded.int.module.cmdmod][INFO    ][29909] Executing command 'gluster volume info 'keystone-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-09-14 01:28:09,139 [salt.state       ][INFO    ][29909] unless execution succeeded
2017-09-14 01:28:09,140 [salt.state       ][INFO    ][29909] Completed state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 01:28:09.139656 duration_in_ms=105.41
2017-09-14 01:28:09,141 [salt.state       ][INFO    ][29909] Running state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 01:28:09.140791
2017-09-14 01:28:09,141 [salt.state       ][INFO    ][29909] Executing state cmd.run for gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'
2017-09-14 01:28:09,142 [salt.loaded.int.module.cmdmod][INFO    ][29909] Executing command 'gluster volume info 'keystone-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-09-14 01:28:09,252 [salt.state       ][INFO    ][29909] unless execution succeeded
2017-09-14 01:28:09,252 [salt.state       ][INFO    ][29909] Completed state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 01:28:09.252074 duration_in_ms=111.282
2017-09-14 01:28:09,255 [salt.state       ][INFO    ][29909] Running state [keystone-keys] at time 01:28:09.254632
2017-09-14 01:28:09,255 [salt.state       ][INFO    ][29909] Executing state glusterfs.started for keystone-keys
2017-09-14 01:28:09,256 [salt.loaded.int.module.cmdmod][INFO    ][29909] Executing command 'gluster --version' in directory '/root'
2017-09-14 01:28:09,272 [salt.loaded.int.module.cmdmod][INFO    ][29909] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-14 01:28:09,376 [salt.loaded.int.module.cmdmod][INFO    ][29909] Executing command 'gluster --version' in directory '/root'
2017-09-14 01:28:09,395 [salt.loaded.int.module.cmdmod][INFO    ][29909] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-14 01:28:09,507 [salt.state       ][INFO    ][29909] Volume keystone-keys is already started
2017-09-14 01:28:09,508 [salt.state       ][INFO    ][29909] Completed state [keystone-keys] at time 01:28:09.507828 duration_in_ms=253.195
2017-09-14 01:28:09,510 [salt.state       ][INFO    ][29909] Running state [nova_instances] at time 01:28:09.509875
2017-09-14 01:28:09,510 [salt.state       ][INFO    ][29909] Executing state glusterfs.created for nova_instances
2017-09-14 01:28:09,511 [salt.loaded.int.module.cmdmod][INFO    ][29909] Executing command 'gluster --version' in directory '/root'
2017-09-14 01:28:09,529 [salt.loaded.int.module.cmdmod][INFO    ][29909] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-14 01:28:09,636 [salt.loaded.int.module.cmdmod][INFO    ][29909] Executing command 'gluster --version' in directory '/root'
2017-09-14 01:28:09,653 [salt.loaded.int.module.cmdmod][INFO    ][29909] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-14 01:28:09,768 [salt.state       ][INFO    ][29909] Volume nova_instances already exists and is started.
2017-09-14 01:28:09,768 [salt.state       ][INFO    ][29909] Completed state [nova_instances] at time 01:28:09.768272 duration_in_ms=258.396
2017-09-14 01:28:09,777 [salt.state       ][INFO    ][29909] Running state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 01:28:09.776923
2017-09-14 01:28:09,778 [salt.state       ][INFO    ][29909] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'
2017-09-14 01:28:09,779 [salt.loaded.int.module.cmdmod][INFO    ][29909] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-09-14 01:28:09,887 [salt.state       ][INFO    ][29909] unless execution succeeded
2017-09-14 01:28:09,887 [salt.state       ][INFO    ][29909] Completed state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 01:28:09.887120 duration_in_ms=110.199
2017-09-14 01:28:09,888 [salt.state       ][INFO    ][29909] Running state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'True'] at time 01:28:09.888236
2017-09-14 01:28:09,889 [salt.state       ][INFO    ][29909] Executing state cmd.run for gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'True'
2017-09-14 01:28:09,890 [salt.loaded.int.module.cmdmod][INFO    ][29909] Executing command 'gluster volume info 'nova_instances' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-09-14 01:28:09,994 [salt.state       ][INFO    ][29909] unless execution succeeded
2017-09-14 01:28:09,994 [salt.state       ][INFO    ][29909] Completed state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'True'] at time 01:28:09.994203 duration_in_ms=105.966
2017-09-14 01:28:09,995 [salt.state       ][INFO    ][29909] Running state [gluster volume set 'nova_instances' 'network.remote-dio' 'True'] at time 01:28:09.994988
2017-09-14 01:28:09,995 [salt.state       ][INFO    ][29909] Executing state cmd.run for gluster volume set 'nova_instances' 'network.remote-dio' 'True'
2017-09-14 01:28:09,996 [salt.loaded.int.module.cmdmod][INFO    ][29909] Executing command 'gluster volume info 'nova_instances' | grep 'network.remote-dio: True'' in directory '/root'
2017-09-14 01:28:10,088 [salt.state       ][INFO    ][29909] unless execution succeeded
2017-09-14 01:28:10,089 [salt.state       ][INFO    ][29909] Completed state [gluster volume set 'nova_instances' 'network.remote-dio' 'True'] at time 01:28:10.088508 duration_in_ms=93.518
2017-09-14 01:28:10,090 [salt.state       ][INFO    ][29909] Running state [gluster volume set 'nova_instances' 'nfs.disable' 'True'] at time 01:28:10.089681
2017-09-14 01:28:10,090 [salt.state       ][INFO    ][29909] Executing state cmd.run for gluster volume set 'nova_instances' 'nfs.disable' 'True'
2017-09-14 01:28:10,091 [salt.loaded.int.module.cmdmod][INFO    ][29909] Executing command 'gluster volume info 'nova_instances' | grep 'nfs.disable: True'' in directory '/root'
2017-09-14 01:28:10,197 [salt.state       ][INFO    ][29909] unless execution succeeded
2017-09-14 01:28:10,198 [salt.state       ][INFO    ][29909] Completed state [gluster volume set 'nova_instances' 'nfs.disable' 'True'] at time 01:28:10.197543 duration_in_ms=107.862
2017-09-14 01:28:10,199 [salt.state       ][INFO    ][29909] Running state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 01:28:10.198644
2017-09-14 01:28:10,199 [salt.state       ][INFO    ][29909] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'
2017-09-14 01:28:10,200 [salt.loaded.int.module.cmdmod][INFO    ][29909] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-09-14 01:28:10,303 [salt.state       ][INFO    ][29909] unless execution succeeded
2017-09-14 01:28:10,304 [salt.state       ][INFO    ][29909] Completed state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 01:28:10.303446 duration_in_ms=104.802
2017-09-14 01:28:10,306 [salt.state       ][INFO    ][29909] Running state [nova_instances] at time 01:28:10.306028
2017-09-14 01:28:10,307 [salt.state       ][INFO    ][29909] Executing state glusterfs.started for nova_instances
2017-09-14 01:28:10,308 [salt.loaded.int.module.cmdmod][INFO    ][29909] Executing command 'gluster --version' in directory '/root'
2017-09-14 01:28:10,322 [salt.loaded.int.module.cmdmod][INFO    ][29909] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-14 01:28:10,431 [salt.loaded.int.module.cmdmod][INFO    ][29909] Executing command 'gluster --version' in directory '/root'
2017-09-14 01:28:10,447 [salt.loaded.int.module.cmdmod][INFO    ][29909] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-14 01:28:10,561 [salt.state       ][INFO    ][29909] Volume nova_instances is already started
2017-09-14 01:28:10,562 [salt.state       ][INFO    ][29909] Completed state [nova_instances] at time 01:28:10.561534 duration_in_ms=255.504
2017-09-14 01:28:10,564 [salt.state       ][INFO    ][29909] Running state [keystone-credential-keys] at time 01:28:10.563738
2017-09-14 01:28:10,564 [salt.state       ][INFO    ][29909] Executing state glusterfs.created for keystone-credential-keys
2017-09-14 01:28:10,565 [salt.loaded.int.module.cmdmod][INFO    ][29909] Executing command 'gluster --version' in directory '/root'
2017-09-14 01:28:10,584 [salt.loaded.int.module.cmdmod][INFO    ][29909] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-14 01:28:10,695 [salt.loaded.int.module.cmdmod][INFO    ][29909] Executing command 'gluster --version' in directory '/root'
2017-09-14 01:28:10,711 [salt.loaded.int.module.cmdmod][INFO    ][29909] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-14 01:28:10,806 [salt.state       ][INFO    ][29909] Volume keystone-credential-keys already exists and is started.
2017-09-14 01:28:10,807 [salt.state       ][INFO    ][29909] Completed state [keystone-credential-keys] at time 01:28:10.806811 duration_in_ms=243.072
2017-09-14 01:28:10,815 [salt.state       ][INFO    ][29909] Running state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 01:28:10.815099
2017-09-14 01:28:10,816 [salt.state       ][INFO    ][29909] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'
2017-09-14 01:28:10,817 [salt.loaded.int.module.cmdmod][INFO    ][29909] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-09-14 01:28:10,928 [salt.state       ][INFO    ][29909] unless execution succeeded
2017-09-14 01:28:10,928 [salt.state       ][INFO    ][29909] Completed state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 01:28:10.928132 duration_in_ms=113.033
2017-09-14 01:28:10,929 [salt.state       ][INFO    ][29909] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 01:28:10.929223
2017-09-14 01:28:10,930 [salt.state       ][INFO    ][29909] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-09-14 01:28:10,931 [salt.loaded.int.module.cmdmod][INFO    ][29909] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-09-14 01:28:11,034 [salt.state       ][INFO    ][29909] unless execution succeeded
2017-09-14 01:28:11,035 [salt.state       ][INFO    ][29909] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 01:28:11.034900 duration_in_ms=105.677
2017-09-14 01:28:11,036 [salt.state       ][INFO    ][29909] Running state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 01:28:11.035961
2017-09-14 01:28:11,036 [salt.state       ][INFO    ][29909] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'
2017-09-14 01:28:11,038 [salt.loaded.int.module.cmdmod][INFO    ][29909] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-09-14 01:28:11,146 [salt.state       ][INFO    ][29909] unless execution succeeded
2017-09-14 01:28:11,147 [salt.state       ][INFO    ][29909] Completed state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 01:28:11.146838 duration_in_ms=110.876
2017-09-14 01:28:11,148 [salt.state       ][INFO    ][29909] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 01:28:11.147954
2017-09-14 01:28:11,149 [salt.state       ][INFO    ][29909] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'
2017-09-14 01:28:11,150 [salt.loaded.int.module.cmdmod][INFO    ][29909] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-09-14 01:28:11,259 [salt.state       ][INFO    ][29909] unless execution succeeded
2017-09-14 01:28:11,259 [salt.state       ][INFO    ][29909] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 01:28:11.259189 duration_in_ms=111.234
2017-09-14 01:28:11,260 [salt.state       ][INFO    ][29909] Running state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 01:28:11.260330
2017-09-14 01:28:11,261 [salt.state       ][INFO    ][29909] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'
2017-09-14 01:28:11,262 [salt.loaded.int.module.cmdmod][INFO    ][29909] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-09-14 01:28:11,372 [salt.state       ][INFO    ][29909] unless execution succeeded
2017-09-14 01:28:11,372 [salt.state       ][INFO    ][29909] Completed state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 01:28:11.372084 duration_in_ms=111.753
2017-09-14 01:28:11,375 [salt.state       ][INFO    ][29909] Running state [keystone-credential-keys] at time 01:28:11.374636
2017-09-14 01:28:11,375 [salt.state       ][INFO    ][29909] Executing state glusterfs.started for keystone-credential-keys
2017-09-14 01:28:11,376 [salt.loaded.int.module.cmdmod][INFO    ][29909] Executing command 'gluster --version' in directory '/root'
2017-09-14 01:28:11,393 [salt.loaded.int.module.cmdmod][INFO    ][29909] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-14 01:28:11,504 [salt.loaded.int.module.cmdmod][INFO    ][29909] Executing command 'gluster --version' in directory '/root'
2017-09-14 01:28:11,523 [salt.loaded.int.module.cmdmod][INFO    ][29909] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-14 01:28:11,632 [salt.state       ][INFO    ][29909] Volume keystone-credential-keys is already started
2017-09-14 01:28:11,632 [salt.state       ][INFO    ][29909] Completed state [keystone-credential-keys] at time 01:28:11.632237 duration_in_ms=257.6
2017-09-14 01:28:11,636 [salt.minion      ][INFO    ][29909] Returning information for job: 20170914012803368723
2017-09-14 01:28:16,567 [salt.minion      ][INFO    ][21560] User sudo_ubuntu Executing command test.ping with jid 20170914012816560281
2017-09-14 01:28:16,591 [salt.minion      ][INFO    ][30345] Starting a new job with PID 30345
2017-09-14 01:28:16,647 [salt.minion      ][INFO    ][30345] Returning information for job: 20170914012816560281
2017-09-14 01:28:17,151 [salt.minion      ][INFO    ][21560] User sudo_ubuntu Executing command cmd.run with jid 20170914012817142872
2017-09-14 01:28:17,174 [salt.minion      ][INFO    ][30350] Starting a new job with PID 30350
2017-09-14 01:28:17,183 [salt.loaded.int.module.cmdmod][INFO    ][30350] Executing command 'gluster peer status; gluster volume status' in directory '/root'
2017-09-14 01:28:17,404 [salt.minion      ][INFO    ][30350] Returning information for job: 20170914012817142872
2017-09-14 02:06:07,282 [salt.utils.schedule][INFO    ][21560] Running scheduled job: __mine_interval
2017-09-14 02:33:50,645 [salt.minion      ][INFO    ][21560] User sudo_ubuntu Executing command cp.push_dir with jid 20170914023350637259
2017-09-14 02:33:50,673 [salt.minion      ][INFO    ][31072] Starting a new job with PID 31072
