2017-12-03 22:13:43,534 [salt.cli.daemons ][WARNING ][2294] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-12-03 22:14:20,616 [salt.state       ][ERROR   ][3674] No contents found in top file
2017-12-03 22:15:49,558 [salt.utils.parsers][WARNING ][2294] Minion received a SIGTERM. Exiting.
2017-12-03 22:20:14,286 [salt.cli.daemons ][WARNING ][3377] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-12-03 22:22:36,108 [py.warnings      ][WARNING ][13706] /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-12-03 22:23:48,558 [salt.loaded.int.module.cmdmod][ERROR   ][13706] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-12-03 22:23:48,559 [salt.loaded.int.module.cmdmod][ERROR   ][13706] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-12-03 22:23:53,387 [salt.loaded.int.module.cmdmod][ERROR   ][13706] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-12-03 22:23:53,387 [salt.loaded.int.module.cmdmod][ERROR   ][13706] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-12-03 22:23:57,512 [salt.loaded.int.module.cmdmod][ERROR   ][13706] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-12-03 22:23:57,513 [salt.loaded.int.module.cmdmod][ERROR   ][13706] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-12-03 22:24:01,847 [salt.loaded.int.module.cmdmod][ERROR   ][13706] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-12-03 22:24:01,847 [salt.loaded.int.module.cmdmod][ERROR   ][13706] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-12-03 22:24:06,189 [salt.loaded.int.module.cmdmod][ERROR   ][13706] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-12-03 22:24:06,189 [salt.loaded.int.module.cmdmod][ERROR   ][13706] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-12-03 22:24:09,685 [salt.loaded.int.module.cmdmod][ERROR   ][13706] 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-12-03 22:24:12,279 [salt.loaded.int.module.cmdmod][INFO    ][21204] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2017-12-03 22:24:12,286 [salt.loaded.int.module.cmdmod][INFO    ][21204] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2017-12-03 22:24:12,296 [salt.loaded.int.module.cmdmod][INFO    ][21204] Executing command ['systemd-run', '--scope', 'systemctl', 'restart', 'salt-minion.service'] in directory '/root'
2017-12-03 22:24:12,305 [salt.utils.parsers][WARNING ][3377] Minion received a SIGTERM. Exiting.
2017-12-03 22:24:12,606 [salt.cli.daemons ][INFO    ][21276] Setting up the Salt Minion "kvm01.baremetal-mcp-ocata-ovs-ha.local"
2017-12-03 22:24:13,251 [salt.minion      ][INFO    ][21276] Creating minion process manager
2017-12-03 22:24:13,251 [salt.cli.daemons ][WARNING ][21276] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-12-03 22:24:13,251 [salt.cli.daemons ][INFO    ][21276] The Salt Minion is starting up
2017-12-03 22:24:13,251 [salt.minion      ][INFO    ][21276] Minion is starting as user 'root'
2017-12-03 22:24:13,252 [salt.utils.event ][INFO    ][21276] Starting pull socket on /var/run/salt/minion/minion_event_fd678c5357_pull.ipc
2017-12-03 22:24:14,505 [salt.loaded.int.module.cmdmod][INFO    ][21276] Executing command ['date', '+%z'] in directory '/root'
2017-12-03 22:24:14,518 [salt.utils.schedule][INFO    ][21276] Updating job settings for scheduled job: __mine_interval
2017-12-03 22:24:14,522 [salt.minion      ][INFO    ][21276] Added mine.update to scheduler
2017-12-03 22:24:14,544 [salt.minion      ][INFO    ][21276] Minion is ready to receive requests!
2017-12-03 22:24:15,546 [salt.utils.schedule][INFO    ][21276] Running scheduled job: __mine_interval
2017-12-03 22:24:21,408 [salt.minion      ][INFO    ][21276] User sudo_ubuntu Executing command saltutil.sync_all with jid 20171203222421400186
2017-12-03 22:24:21,420 [salt.minion      ][INFO    ][21375] Starting a new job with PID 21375
2017-12-03 22:24:24,063 [salt.state       ][INFO    ][21375] Loading fresh modules for state activity
2017-12-03 22:24:24,091 [salt.state       ][ERROR   ][21375] No contents found in top file
2017-12-03 22:24:24,092 [salt.utils.extmods][INFO    ][21375] Creating module dir '/var/cache/salt/minion/extmods/beacons'
2017-12-03 22:24:24,095 [salt.utils.extmods][INFO    ][21375] Syncing beacons for environment 'base'
2017-12-03 22:24:24,095 [salt.utils.extmods][INFO    ][21375] Loading cache from salt://_beacons, for base)
2017-12-03 22:24:24,095 [salt.fileclient  ][INFO    ][21375] Caching directory '_beacons/' for environment 'base'
2017-12-03 22:24:24,137 [salt.utils.extmods][INFO    ][21375] Syncing modules for environment 'base'
2017-12-03 22:24:24,137 [salt.utils.extmods][INFO    ][21375] Loading cache from salt://_modules, for base)
2017-12-03 22:24:24,137 [salt.fileclient  ][INFO    ][21375] Caching directory '_modules/' for environment 'base'
2017-12-03 22:24:24,191 [salt.fileclient  ][INFO    ][21375] Fetching file from saltenv 'base', ** done ** '_modules/avinetworks.py'
2017-12-03 22:24:24,203 [salt.fileclient  ][INFO    ][21375] Fetching file from saltenv 'base', ** done ** '_modules/ceph_ng.py'
2017-12-03 22:24:24,214 [salt.fileclient  ][INFO    ][21375] Fetching file from saltenv 'base', ** done ** '_modules/cinderng.py'
2017-12-03 22:24:24,230 [salt.fileclient  ][INFO    ][21375] Fetching file from saltenv 'base', ** done ** '_modules/contrail.py'
2017-12-03 22:24:24,241 [salt.fileclient  ][INFO    ][21375] Fetching file from saltenv 'base', ** done ** '_modules/creds.py'
2017-12-03 22:24:24,251 [salt.fileclient  ][INFO    ][21375] Fetching file from saltenv 'base', ** done ** '_modules/devops_utils.py'
2017-12-03 22:24:24,262 [salt.fileclient  ][INFO    ][21375] Fetching file from saltenv 'base', ** done ** '_modules/encode_json.py'
2017-12-03 22:24:24,274 [salt.fileclient  ][INFO    ][21375] Fetching file from saltenv 'base', ** done ** '_modules/gerrit.py'
2017-12-03 22:24:24,286 [salt.fileclient  ][INFO    ][21375] Fetching file from saltenv 'base', ** done ** '_modules/glanceng.py'
2017-12-03 22:24:24,298 [salt.fileclient  ][INFO    ][21375] Fetching file from saltenv 'base', ** done ** '_modules/heat.py'
2017-12-03 22:24:24,309 [salt.fileclient  ][INFO    ][21375] Fetching file from saltenv 'base', ** done ** '_modules/heka_alarming.py'
2017-12-03 22:24:24,320 [salt.fileclient  ][INFO    ][21375] Fetching file from saltenv 'base', ** done ** '_modules/helm.py'
2017-12-03 22:24:24,331 [salt.fileclient  ][INFO    ][21375] Fetching file from saltenv 'base', ** done ** '_modules/jenkins_common.py'
2017-12-03 22:24:24,348 [salt.fileclient  ][INFO    ][21375] Fetching file from saltenv 'base', ** done ** '_modules/keystone_policy.py'
2017-12-03 22:24:24,358 [salt.fileclient  ][INFO    ][21375] Fetching file from saltenv 'base', ** done ** '_modules/linux_hosts.py'
2017-12-03 22:24:24,372 [salt.fileclient  ][INFO    ][21375] Fetching file from saltenv 'base', ** done ** '_modules/linux_netlink.py'
2017-12-03 22:24:24,386 [salt.fileclient  ][INFO    ][21375] Fetching file from saltenv 'base', ** done ** '_modules/maas.py'
2017-12-03 22:24:24,399 [salt.fileclient  ][INFO    ][21375] Fetching file from saltenv 'base', ** done ** '_modules/maas_client.py'
2017-12-03 22:24:24,408 [salt.fileclient  ][INFO    ][21375] Fetching file from saltenv 'base', ** done ** '_modules/modelutils.py'
2017-12-03 22:24:24,418 [salt.fileclient  ][INFO    ][21375] Fetching file from saltenv 'base', ** done ** '_modules/multipart.py'
2017-12-03 22:24:24,428 [salt.fileclient  ][INFO    ][21375] Fetching file from saltenv 'base', ** done ** '_modules/nagios_alarming.py'
2017-12-03 22:24:24,438 [salt.fileclient  ][INFO    ][21375] Fetching file from saltenv 'base', ** done ** '_modules/neutronng.py'
2017-12-03 22:24:24,452 [salt.fileclient  ][INFO    ][21375] Fetching file from saltenv 'base', ** done ** '_modules/novang.py'
2017-12-03 22:24:24,462 [salt.fileclient  ][INFO    ][21375] Fetching file from saltenv 'base', ** done ** '_modules/reclass.py'
2017-12-03 22:24:24,473 [salt.fileclient  ][INFO    ][21375] Fetching file from saltenv 'base', ** done ** '_modules/rsyslog_util.py'
2017-12-03 22:24:25,043 [salt.fileclient  ][INFO    ][21375] Fetching file from saltenv 'base', ** done ** '_modules/rundeck.py'
2017-12-03 22:24:25,055 [salt.fileclient  ][INFO    ][21375] Fetching file from saltenv 'base', ** done ** '_modules/saltkey.py'
2017-12-03 22:24:25,072 [salt.fileclient  ][INFO    ][21375] Fetching file from saltenv 'base', ** done ** '_modules/saltresource.py'
2017-12-03 22:24:25,082 [salt.fileclient  ][INFO    ][21375] Fetching file from saltenv 'base', ** done ** '_modules/seedng.py'
2017-12-03 22:24:25,102 [salt.fileclient  ][INFO    ][21375] Fetching file from saltenv 'base', ** done ** '_modules/testing/credentials.py'
2017-12-03 22:24:25,115 [salt.fileclient  ][INFO    ][21375] Fetching file from saltenv 'base', ** done ** '_modules/testing/django.py'
2017-12-03 22:24:25,125 [salt.fileclient  ][INFO    ][21375] Fetching file from saltenv 'base', ** done ** '_modules/testing/django_client_proxy.py'
2017-12-03 22:24:25,136 [salt.fileclient  ][INFO    ][21375] Fetching file from saltenv 'base', ** done ** '_modules/utils.py'
2017-12-03 22:24:25,149 [salt.fileclient  ][INFO    ][21375] Fetching file from saltenv 'base', ** done ** '_modules/virtng.py'
2017-12-03 22:24:25,153 [salt.utils.extmods][INFO    ][21375] Copying '/var/cache/salt/minion/files/base/_modules/__init__.py' to '/var/cache/salt/minion/extmods/modules/__init__.py'
2017-12-03 22:24:25,153 [salt.utils.extmods][INFO    ][21375] Copying '/var/cache/salt/minion/files/base/_modules/avinetworks.py' to '/var/cache/salt/minion/extmods/modules/avinetworks.py'
2017-12-03 22:24:25,153 [salt.utils.extmods][INFO    ][21375] Copying '/var/cache/salt/minion/files/base/_modules/ceph_ng.py' to '/var/cache/salt/minion/extmods/modules/ceph_ng.py'
2017-12-03 22:24:25,154 [salt.utils.extmods][INFO    ][21375] Copying '/var/cache/salt/minion/files/base/_modules/cinderng.py' to '/var/cache/salt/minion/extmods/modules/cinderng.py'
2017-12-03 22:24:25,154 [salt.utils.extmods][INFO    ][21375] Copying '/var/cache/salt/minion/files/base/_modules/contrail.py' to '/var/cache/salt/minion/extmods/modules/contrail.py'
2017-12-03 22:24:25,154 [salt.utils.extmods][INFO    ][21375] Copying '/var/cache/salt/minion/files/base/_modules/creds.py' to '/var/cache/salt/minion/extmods/modules/creds.py'
2017-12-03 22:24:25,155 [salt.utils.extmods][INFO    ][21375] Copying '/var/cache/salt/minion/files/base/_modules/devops_utils.py' to '/var/cache/salt/minion/extmods/modules/devops_utils.py'
2017-12-03 22:24:25,155 [salt.utils.extmods][INFO    ][21375] Copying '/var/cache/salt/minion/files/base/_modules/encode_json.py' to '/var/cache/salt/minion/extmods/modules/encode_json.py'
2017-12-03 22:24:25,155 [salt.utils.extmods][INFO    ][21375] Copying '/var/cache/salt/minion/files/base/_modules/gerrit.py' to '/var/cache/salt/minion/extmods/modules/gerrit.py'
2017-12-03 22:24:25,155 [salt.utils.extmods][INFO    ][21375] Copying '/var/cache/salt/minion/files/base/_modules/glanceng.py' to '/var/cache/salt/minion/extmods/modules/glanceng.py'
2017-12-03 22:24:25,156 [salt.utils.extmods][INFO    ][21375] Copying '/var/cache/salt/minion/files/base/_modules/heat.py' to '/var/cache/salt/minion/extmods/modules/heat.py'
2017-12-03 22:24:25,156 [salt.utils.extmods][INFO    ][21375] Copying '/var/cache/salt/minion/files/base/_modules/heka_alarming.py' to '/var/cache/salt/minion/extmods/modules/heka_alarming.py'
2017-12-03 22:24:25,156 [salt.utils.extmods][INFO    ][21375] Copying '/var/cache/salt/minion/files/base/_modules/helm.py' to '/var/cache/salt/minion/extmods/modules/helm.py'
2017-12-03 22:24:25,156 [salt.utils.extmods][INFO    ][21375] Copying '/var/cache/salt/minion/files/base/_modules/jenkins_common.py' to '/var/cache/salt/minion/extmods/modules/jenkins_common.py'
2017-12-03 22:24:25,157 [salt.utils.extmods][INFO    ][21375] Copying '/var/cache/salt/minion/files/base/_modules/keystone_policy.py' to '/var/cache/salt/minion/extmods/modules/keystone_policy.py'
2017-12-03 22:24:25,157 [salt.utils.extmods][INFO    ][21375] Copying '/var/cache/salt/minion/files/base/_modules/linux_hosts.py' to '/var/cache/salt/minion/extmods/modules/linux_hosts.py'
2017-12-03 22:24:25,157 [salt.utils.extmods][INFO    ][21375] Copying '/var/cache/salt/minion/files/base/_modules/linux_netlink.py' to '/var/cache/salt/minion/extmods/modules/linux_netlink.py'
2017-12-03 22:24:25,157 [salt.utils.extmods][INFO    ][21375] Copying '/var/cache/salt/minion/files/base/_modules/maas.py' to '/var/cache/salt/minion/extmods/modules/maas.py'
2017-12-03 22:24:25,158 [salt.utils.extmods][INFO    ][21375] Copying '/var/cache/salt/minion/files/base/_modules/maas_client.py' to '/var/cache/salt/minion/extmods/modules/maas_client.py'
2017-12-03 22:24:25,158 [salt.utils.extmods][INFO    ][21375] Copying '/var/cache/salt/minion/files/base/_modules/modelutils.py' to '/var/cache/salt/minion/extmods/modules/modelutils.py'
2017-12-03 22:24:25,158 [salt.utils.extmods][INFO    ][21375] Copying '/var/cache/salt/minion/files/base/_modules/multipart.py' to '/var/cache/salt/minion/extmods/modules/multipart.py'
2017-12-03 22:24:25,158 [salt.utils.extmods][INFO    ][21375] Copying '/var/cache/salt/minion/files/base/_modules/nagios_alarming.py' to '/var/cache/salt/minion/extmods/modules/nagios_alarming.py'
2017-12-03 22:24:25,159 [salt.utils.extmods][INFO    ][21375] Copying '/var/cache/salt/minion/files/base/_modules/neutronng.py' to '/var/cache/salt/minion/extmods/modules/neutronng.py'
2017-12-03 22:24:25,159 [salt.utils.extmods][INFO    ][21375] Copying '/var/cache/salt/minion/files/base/_modules/novang.py' to '/var/cache/salt/minion/extmods/modules/novang.py'
2017-12-03 22:24:25,159 [salt.utils.extmods][INFO    ][21375] Copying '/var/cache/salt/minion/files/base/_modules/reclass.py' to '/var/cache/salt/minion/extmods/modules/reclass.py'
2017-12-03 22:24:25,160 [salt.utils.extmods][INFO    ][21375] Copying '/var/cache/salt/minion/files/base/_modules/rsyslog_util.py' to '/var/cache/salt/minion/extmods/modules/rsyslog_util.py'
2017-12-03 22:24:25,160 [salt.utils.extmods][INFO    ][21375] Copying '/var/cache/salt/minion/files/base/_modules/rundeck.py' to '/var/cache/salt/minion/extmods/modules/rundeck.py'
2017-12-03 22:24:25,160 [salt.utils.extmods][INFO    ][21375] Copying '/var/cache/salt/minion/files/base/_modules/saltkey.py' to '/var/cache/salt/minion/extmods/modules/saltkey.py'
2017-12-03 22:24:25,161 [salt.utils.extmods][INFO    ][21375] Copying '/var/cache/salt/minion/files/base/_modules/saltresource.py' to '/var/cache/salt/minion/extmods/modules/saltresource.py'
2017-12-03 22:24:25,161 [salt.utils.extmods][INFO    ][21375] Copying '/var/cache/salt/minion/files/base/_modules/seedng.py' to '/var/cache/salt/minion/extmods/modules/seedng.py'
2017-12-03 22:24:25,161 [salt.utils.extmods][INFO    ][21375] Copying '/var/cache/salt/minion/files/base/_modules/testing/__init__.py' to '/var/cache/salt/minion/extmods/modules/testing/__init__.py'
2017-12-03 22:24:25,161 [salt.utils.extmods][INFO    ][21375] Copying '/var/cache/salt/minion/files/base/_modules/testing/credentials.py' to '/var/cache/salt/minion/extmods/modules/testing/credentials.py'
2017-12-03 22:24:25,161 [salt.utils.extmods][INFO    ][21375] Copying '/var/cache/salt/minion/files/base/_modules/testing/django.py' to '/var/cache/salt/minion/extmods/modules/testing/django.py'
2017-12-03 22:24:25,162 [salt.utils.extmods][INFO    ][21375] 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-12-03 22:24:25,162 [salt.utils.extmods][INFO    ][21375] Copying '/var/cache/salt/minion/files/base/_modules/utils.py' to '/var/cache/salt/minion/extmods/modules/utils.py'
2017-12-03 22:24:25,162 [salt.utils.extmods][INFO    ][21375] Copying '/var/cache/salt/minion/files/base/_modules/virtng.py' to '/var/cache/salt/minion/extmods/modules/virtng.py'
2017-12-03 22:24:25,168 [salt.utils.extmods][INFO    ][21375] Syncing states for environment 'base'
2017-12-03 22:24:25,168 [salt.utils.extmods][INFO    ][21375] Loading cache from salt://_states, for base)
2017-12-03 22:24:25,168 [salt.fileclient  ][INFO    ][21375] Caching directory '_states/' for environment 'base'
2017-12-03 22:24:25,214 [salt.fileclient  ][INFO    ][21375] Fetching file from saltenv 'base', ** done ** '_states/avinetworks.py'
2017-12-03 22:24:25,222 [salt.fileclient  ][INFO    ][21375] Fetching file from saltenv 'base', ** done ** '_states/cinderng.py'
2017-12-03 22:24:25,240 [salt.fileclient  ][INFO    ][21375] Fetching file from saltenv 'base', ** done ** '_states/contrail.py'
2017-12-03 22:24:25,251 [salt.fileclient  ][INFO    ][21375] Fetching file from saltenv 'base', ** done ** '_states/gerrit.py'
2017-12-03 22:24:25,262 [salt.fileclient  ][INFO    ][21375] Fetching file from saltenv 'base', ** done ** '_states/glanceng.py'
2017-12-03 22:24:25,274 [salt.fileclient  ][INFO    ][21375] Fetching file from saltenv 'base', ** done ** '_states/grafana3_dashboard.py'
2017-12-03 22:24:25,284 [salt.fileclient  ][INFO    ][21375] Fetching file from saltenv 'base', ** done ** '_states/grafana3_datasource.py'
2017-12-03 22:24:25,294 [salt.fileclient  ][INFO    ][21375] Fetching file from saltenv 'base', ** done ** '_states/heat.py'
2017-12-03 22:24:25,304 [salt.fileclient  ][INFO    ][21375] Fetching file from saltenv 'base', ** done ** '_states/helm_release.py'
2017-12-03 22:24:25,314 [salt.fileclient  ][INFO    ][21375] Fetching file from saltenv 'base', ** done ** '_states/helm_repos.py'
2017-12-03 22:24:25,336 [salt.fileclient  ][INFO    ][21375] Fetching file from saltenv 'base', ** done ** '_states/jenkins_approval.py'
2017-12-03 22:24:25,346 [salt.fileclient  ][INFO    ][21375] Fetching file from saltenv 'base', ** done ** '_states/jenkins_artifactory.py'
2017-12-03 22:24:25,358 [salt.fileclient  ][INFO    ][21375] Fetching file from saltenv 'base', ** done ** '_states/jenkins_credential.py'
2017-12-03 22:24:25,369 [salt.fileclient  ][INFO    ][21375] Fetching file from saltenv 'base', ** done ** '_states/jenkins_globalenvprop.py'
2017-12-03 22:24:25,382 [salt.fileclient  ][INFO    ][21375] Fetching file from saltenv 'base', ** done ** '_states/jenkins_job.py'
2017-12-03 22:24:25,391 [salt.fileclient  ][INFO    ][21375] Fetching file from saltenv 'base', ** done ** '_states/jenkins_lib.py'
2017-12-03 22:24:25,403 [salt.fileclient  ][INFO    ][21375] Fetching file from saltenv 'base', ** done ** '_states/jenkins_node.py'
2017-12-03 22:24:25,416 [salt.fileclient  ][INFO    ][21375] Fetching file from saltenv 'base', ** done ** '_states/jenkins_plugin.py'
2017-12-03 22:24:25,426 [salt.fileclient  ][INFO    ][21375] Fetching file from saltenv 'base', ** done ** '_states/jenkins_security.py'
2017-12-03 22:24:25,437 [salt.fileclient  ][INFO    ][21375] Fetching file from saltenv 'base', ** done ** '_states/jenkins_slack.py'
2017-12-03 22:24:25,447 [salt.fileclient  ][INFO    ][21375] Fetching file from saltenv 'base', ** done ** '_states/jenkins_smtp.py'
2017-12-03 22:24:25,456 [salt.fileclient  ][INFO    ][21375] Fetching file from saltenv 'base', ** done ** '_states/jenkins_theme.py'
2017-12-03 22:24:25,464 [salt.fileclient  ][INFO    ][21375] Fetching file from saltenv 'base', ** done ** '_states/jenkins_user.py'
2017-12-03 22:24:25,475 [salt.fileclient  ][INFO    ][21375] Fetching file from saltenv 'base', ** done ** '_states/jenkins_view.py'
2017-12-03 22:24:25,486 [salt.fileclient  ][INFO    ][21375] Fetching file from saltenv 'base', ** done ** '_states/keystone_policy.py'
2017-12-03 22:24:25,499 [salt.fileclient  ][INFO    ][21375] Fetching file from saltenv 'base', ** done ** '_states/kibana_object.py'
2017-12-03 22:24:25,516 [salt.fileclient  ][INFO    ][21375] Fetching file from saltenv 'base', ** done ** '_states/neutronng.py'
2017-12-03 22:24:25,526 [salt.fileclient  ][INFO    ][21375] Fetching file from saltenv 'base', ** done ** '_states/novang.py'
2017-12-03 22:24:25,535 [salt.fileclient  ][INFO    ][21375] Fetching file from saltenv 'base', ** done ** '_states/reclass.py'
2017-12-03 22:24:25,545 [salt.fileclient  ][INFO    ][21375] Fetching file from saltenv 'base', ** done ** '_states/rundeck_project.py'
2017-12-03 22:24:25,554 [salt.fileclient  ][INFO    ][21375] Fetching file from saltenv 'base', ** done ** '_states/rundeck_scm.py'
2017-12-03 22:24:25,564 [salt.fileclient  ][INFO    ][21375] Fetching file from saltenv 'base', ** done ** '_states/rundeck_secret.py'
2017-12-03 22:24:25,568 [salt.utils.extmods][INFO    ][21375] Copying '/var/cache/salt/minion/files/base/_states/avinetworks.py' to '/var/cache/salt/minion/extmods/states/avinetworks.py'
2017-12-03 22:24:25,568 [salt.utils.extmods][INFO    ][21375] Copying '/var/cache/salt/minion/files/base/_states/cinderng.py' to '/var/cache/salt/minion/extmods/states/cinderng.py'
2017-12-03 22:24:25,568 [salt.utils.extmods][INFO    ][21375] Copying '/var/cache/salt/minion/files/base/_states/contrail.py' to '/var/cache/salt/minion/extmods/states/contrail.py'
2017-12-03 22:24:25,568 [salt.utils.extmods][INFO    ][21375] Copying '/var/cache/salt/minion/files/base/_states/gerrit.py' to '/var/cache/salt/minion/extmods/states/gerrit.py'
2017-12-03 22:24:25,569 [salt.utils.extmods][INFO    ][21375] Copying '/var/cache/salt/minion/files/base/_states/glanceng.py' to '/var/cache/salt/minion/extmods/states/glanceng.py'
2017-12-03 22:24:25,569 [salt.utils.extmods][INFO    ][21375] Copying '/var/cache/salt/minion/files/base/_states/grafana3_dashboard.py' to '/var/cache/salt/minion/extmods/states/grafana3_dashboard.py'
2017-12-03 22:24:25,569 [salt.utils.extmods][INFO    ][21375] Copying '/var/cache/salt/minion/files/base/_states/grafana3_datasource.py' to '/var/cache/salt/minion/extmods/states/grafana3_datasource.py'
2017-12-03 22:24:25,570 [salt.utils.extmods][INFO    ][21375] Copying '/var/cache/salt/minion/files/base/_states/heat.py' to '/var/cache/salt/minion/extmods/states/heat.py'
2017-12-03 22:24:25,570 [salt.utils.extmods][INFO    ][21375] Copying '/var/cache/salt/minion/files/base/_states/helm_release.py' to '/var/cache/salt/minion/extmods/states/helm_release.py'
2017-12-03 22:24:25,570 [salt.utils.extmods][INFO    ][21375] Copying '/var/cache/salt/minion/files/base/_states/helm_repos.py' to '/var/cache/salt/minion/extmods/states/helm_repos.py'
2017-12-03 22:24:25,570 [salt.utils.extmods][INFO    ][21375] Copying '/var/cache/salt/minion/files/base/_states/jenkins_approval.py' to '/var/cache/salt/minion/extmods/states/jenkins_approval.py'
2017-12-03 22:24:25,570 [salt.utils.extmods][INFO    ][21375] Copying '/var/cache/salt/minion/files/base/_states/jenkins_artifactory.py' to '/var/cache/salt/minion/extmods/states/jenkins_artifactory.py'
2017-12-03 22:24:25,571 [salt.utils.extmods][INFO    ][21375] Copying '/var/cache/salt/minion/files/base/_states/jenkins_credential.py' to '/var/cache/salt/minion/extmods/states/jenkins_credential.py'
2017-12-03 22:24:25,571 [salt.utils.extmods][INFO    ][21375] Copying '/var/cache/salt/minion/files/base/_states/jenkins_globalenvprop.py' to '/var/cache/salt/minion/extmods/states/jenkins_globalenvprop.py'
2017-12-03 22:24:25,571 [salt.utils.extmods][INFO    ][21375] Copying '/var/cache/salt/minion/files/base/_states/jenkins_job.py' to '/var/cache/salt/minion/extmods/states/jenkins_job.py'
2017-12-03 22:24:25,571 [salt.utils.extmods][INFO    ][21375] Copying '/var/cache/salt/minion/files/base/_states/jenkins_lib.py' to '/var/cache/salt/minion/extmods/states/jenkins_lib.py'
2017-12-03 22:24:25,572 [salt.utils.extmods][INFO    ][21375] Copying '/var/cache/salt/minion/files/base/_states/jenkins_node.py' to '/var/cache/salt/minion/extmods/states/jenkins_node.py'
2017-12-03 22:24:25,572 [salt.utils.extmods][INFO    ][21375] Copying '/var/cache/salt/minion/files/base/_states/jenkins_plugin.py' to '/var/cache/salt/minion/extmods/states/jenkins_plugin.py'
2017-12-03 22:24:25,572 [salt.utils.extmods][INFO    ][21375] Copying '/var/cache/salt/minion/files/base/_states/jenkins_security.py' to '/var/cache/salt/minion/extmods/states/jenkins_security.py'
2017-12-03 22:24:25,572 [salt.utils.extmods][INFO    ][21375] Copying '/var/cache/salt/minion/files/base/_states/jenkins_slack.py' to '/var/cache/salt/minion/extmods/states/jenkins_slack.py'
2017-12-03 22:24:25,573 [salt.utils.extmods][INFO    ][21375] Copying '/var/cache/salt/minion/files/base/_states/jenkins_smtp.py' to '/var/cache/salt/minion/extmods/states/jenkins_smtp.py'
2017-12-03 22:24:25,573 [salt.utils.extmods][INFO    ][21375] Copying '/var/cache/salt/minion/files/base/_states/jenkins_theme.py' to '/var/cache/salt/minion/extmods/states/jenkins_theme.py'
2017-12-03 22:24:25,573 [salt.utils.extmods][INFO    ][21375] Copying '/var/cache/salt/minion/files/base/_states/jenkins_user.py' to '/var/cache/salt/minion/extmods/states/jenkins_user.py'
2017-12-03 22:24:25,573 [salt.utils.extmods][INFO    ][21375] Copying '/var/cache/salt/minion/files/base/_states/jenkins_view.py' to '/var/cache/salt/minion/extmods/states/jenkins_view.py'
2017-12-03 22:24:25,573 [salt.utils.extmods][INFO    ][21375] Copying '/var/cache/salt/minion/files/base/_states/keystone_policy.py' to '/var/cache/salt/minion/extmods/states/keystone_policy.py'
2017-12-03 22:24:25,574 [salt.utils.extmods][INFO    ][21375] Copying '/var/cache/salt/minion/files/base/_states/kibana_object.py' to '/var/cache/salt/minion/extmods/states/kibana_object.py'
2017-12-03 22:24:25,574 [salt.utils.extmods][INFO    ][21375] Copying '/var/cache/salt/minion/files/base/_states/maas_cluster.py' to '/var/cache/salt/minion/extmods/states/maas_cluster.py'
2017-12-03 22:24:25,574 [salt.utils.extmods][INFO    ][21375] Copying '/var/cache/salt/minion/files/base/_states/neutronng.py' to '/var/cache/salt/minion/extmods/states/neutronng.py'
2017-12-03 22:24:25,574 [salt.utils.extmods][INFO    ][21375] Copying '/var/cache/salt/minion/files/base/_states/novang.py' to '/var/cache/salt/minion/extmods/states/novang.py'
2017-12-03 22:24:25,575 [salt.utils.extmods][INFO    ][21375] Copying '/var/cache/salt/minion/files/base/_states/reclass.py' to '/var/cache/salt/minion/extmods/states/reclass.py'
2017-12-03 22:24:25,575 [salt.utils.extmods][INFO    ][21375] Copying '/var/cache/salt/minion/files/base/_states/rundeck_project.py' to '/var/cache/salt/minion/extmods/states/rundeck_project.py'
2017-12-03 22:24:25,575 [salt.utils.extmods][INFO    ][21375] Copying '/var/cache/salt/minion/files/base/_states/rundeck_scm.py' to '/var/cache/salt/minion/extmods/states/rundeck_scm.py'
2017-12-03 22:24:25,575 [salt.utils.extmods][INFO    ][21375] Copying '/var/cache/salt/minion/files/base/_states/rundeck_secret.py' to '/var/cache/salt/minion/extmods/states/rundeck_secret.py'
2017-12-03 22:24:25,578 [salt.utils.extmods][INFO    ][21375] Creating module dir '/var/cache/salt/minion/extmods/sdb'
2017-12-03 22:24:25,581 [salt.utils.extmods][INFO    ][21375] Syncing sdb for environment 'base'
2017-12-03 22:24:25,582 [salt.utils.extmods][INFO    ][21375] Loading cache from salt://_sdb, for base)
2017-12-03 22:24:25,582 [salt.fileclient  ][INFO    ][21375] Caching directory '_sdb/' for environment 'base'
2017-12-03 22:24:25,620 [salt.utils.extmods][INFO    ][21375] Syncing grains for environment 'base'
2017-12-03 22:24:25,621 [salt.utils.extmods][INFO    ][21375] Loading cache from salt://_grains, for base)
2017-12-03 22:24:25,621 [salt.fileclient  ][INFO    ][21375] Caching directory '_grains/' for environment 'base'
2017-12-03 22:24:25,659 [salt.fileclient  ][INFO    ][21375] Fetching file from saltenv 'base', ** done ** '_grains/ceilometer_policy.py'
2017-12-03 22:24:25,667 [salt.fileclient  ][INFO    ][21375] Fetching file from saltenv 'base', ** done ** '_grains/ceph.py'
2017-12-03 22:24:25,678 [salt.fileclient  ][INFO    ][21375] Fetching file from saltenv 'base', ** done ** '_grains/cinder_policy.py'
2017-12-03 22:24:25,689 [salt.fileclient  ][INFO    ][21375] Fetching file from saltenv 'base', ** done ** '_grains/docker_swarm.py'
2017-12-03 22:24:25,700 [salt.fileclient  ][INFO    ][21375] Fetching file from saltenv 'base', ** done ** '_grains/glance_policy.py'
2017-12-03 22:24:25,714 [salt.fileclient  ][INFO    ][21375] Fetching file from saltenv 'base', ** done ** '_grains/heat_policy.py'
2017-12-03 22:24:25,724 [salt.fileclient  ][INFO    ][21375] Fetching file from saltenv 'base', ** done ** '_grains/jenkins_plugins.py'
2017-12-03 22:24:25,738 [salt.fileclient  ][INFO    ][21375] Fetching file from saltenv 'base', ** done ** '_grains/keystone_policy.py'
2017-12-03 22:24:25,750 [salt.fileclient  ][INFO    ][21375] Fetching file from saltenv 'base', ** done ** '_grains/kubernetes.py'
2017-12-03 22:24:25,763 [salt.fileclient  ][INFO    ][21375] Fetching file from saltenv 'base', ** done ** '_grains/neutron_policy.py'
2017-12-03 22:24:25,775 [salt.fileclient  ][INFO    ][21375] Fetching file from saltenv 'base', ** done ** '_grains/nova_policy.py'
2017-12-03 22:24:25,787 [salt.fileclient  ][INFO    ][21375] Fetching file from saltenv 'base', ** done ** '_grains/ssh_fingerprints.py'
2017-12-03 22:24:25,791 [salt.utils.extmods][INFO    ][21375] Copying '/var/cache/salt/minion/files/base/_grains/ceilometer_policy.py' to '/var/cache/salt/minion/extmods/grains/ceilometer_policy.py'
2017-12-03 22:24:25,791 [salt.utils.extmods][INFO    ][21375] Copying '/var/cache/salt/minion/files/base/_grains/ceph.py' to '/var/cache/salt/minion/extmods/grains/ceph.py'
2017-12-03 22:24:25,792 [salt.utils.extmods][INFO    ][21375] Copying '/var/cache/salt/minion/files/base/_grains/cinder_policy.py' to '/var/cache/salt/minion/extmods/grains/cinder_policy.py'
2017-12-03 22:24:25,792 [salt.utils.extmods][INFO    ][21375] Copying '/var/cache/salt/minion/files/base/_grains/docker_swarm.py' to '/var/cache/salt/minion/extmods/grains/docker_swarm.py'
2017-12-03 22:24:25,792 [salt.utils.extmods][INFO    ][21375] Copying '/var/cache/salt/minion/files/base/_grains/glance_policy.py' to '/var/cache/salt/minion/extmods/grains/glance_policy.py'
2017-12-03 22:24:25,792 [salt.utils.extmods][INFO    ][21375] Copying '/var/cache/salt/minion/files/base/_grains/heat_policy.py' to '/var/cache/salt/minion/extmods/grains/heat_policy.py'
2017-12-03 22:24:25,793 [salt.utils.extmods][INFO    ][21375] Copying '/var/cache/salt/minion/files/base/_grains/jenkins_plugins.py' to '/var/cache/salt/minion/extmods/grains/jenkins_plugins.py'
2017-12-03 22:24:25,793 [salt.utils.extmods][INFO    ][21375] Copying '/var/cache/salt/minion/files/base/_grains/keystone_policy.py' to '/var/cache/salt/minion/extmods/grains/keystone_policy.py'
2017-12-03 22:24:25,793 [salt.utils.extmods][INFO    ][21375] Copying '/var/cache/salt/minion/files/base/_grains/kubernetes.py' to '/var/cache/salt/minion/extmods/grains/kubernetes.py'
2017-12-03 22:24:25,793 [salt.utils.extmods][INFO    ][21375] Copying '/var/cache/salt/minion/files/base/_grains/neutron_policy.py' to '/var/cache/salt/minion/extmods/grains/neutron_policy.py'
2017-12-03 22:24:25,793 [salt.utils.extmods][INFO    ][21375] Copying '/var/cache/salt/minion/files/base/_grains/nova_policy.py' to '/var/cache/salt/minion/extmods/grains/nova_policy.py'
2017-12-03 22:24:25,794 [salt.utils.extmods][INFO    ][21375] Copying '/var/cache/salt/minion/files/base/_grains/ssh_fingerprints.py' to '/var/cache/salt/minion/extmods/grains/ssh_fingerprints.py'
2017-12-03 22:24:25,795 [salt.utils.extmods][INFO    ][21375] Creating module dir '/var/cache/salt/minion/extmods/renderers'
2017-12-03 22:24:25,798 [salt.utils.extmods][INFO    ][21375] Syncing renderers for environment 'base'
2017-12-03 22:24:25,798 [salt.utils.extmods][INFO    ][21375] Loading cache from salt://_renderers, for base)
2017-12-03 22:24:25,798 [salt.fileclient  ][INFO    ][21375] Caching directory '_renderers/' for environment 'base'
2017-12-03 22:24:25,833 [salt.utils.extmods][INFO    ][21375] Creating module dir '/var/cache/salt/minion/extmods/returners'
2017-12-03 22:24:25,836 [salt.utils.extmods][INFO    ][21375] Syncing returners for environment 'base'
2017-12-03 22:24:25,836 [salt.utils.extmods][INFO    ][21375] Loading cache from salt://_returners, for base)
2017-12-03 22:24:25,836 [salt.fileclient  ][INFO    ][21375] Caching directory '_returners/' for environment 'base'
2017-12-03 22:24:25,868 [salt.utils.extmods][INFO    ][21375] Creating module dir '/var/cache/salt/minion/extmods/output'
2017-12-03 22:24:25,871 [salt.utils.extmods][INFO    ][21375] Syncing output for environment 'base'
2017-12-03 22:24:25,871 [salt.utils.extmods][INFO    ][21375] Loading cache from salt://_output, for base)
2017-12-03 22:24:25,871 [salt.fileclient  ][INFO    ][21375] Caching directory '_output/' for environment 'base'
2017-12-03 22:24:25,903 [salt.utils.extmods][INFO    ][21375] Creating module dir '/var/cache/salt/minion/extmods/utils'
2017-12-03 22:24:25,905 [salt.utils.extmods][INFO    ][21375] Syncing utils for environment 'base'
2017-12-03 22:24:25,906 [salt.utils.extmods][INFO    ][21375] Loading cache from salt://_utils, for base)
2017-12-03 22:24:25,906 [salt.fileclient  ][INFO    ][21375] Caching directory '_utils/' for environment 'base'
2017-12-03 22:24:25,938 [salt.utils.extmods][INFO    ][21375] Creating module dir '/var/cache/salt/minion/extmods/log_handlers'
2017-12-03 22:24:25,940 [salt.utils.extmods][INFO    ][21375] Syncing log_handlers for environment 'base'
2017-12-03 22:24:25,940 [salt.utils.extmods][INFO    ][21375] Loading cache from salt://_log_handlers, for base)
2017-12-03 22:24:25,941 [salt.fileclient  ][INFO    ][21375] Caching directory '_log_handlers/' for environment 'base'
2017-12-03 22:24:25,974 [salt.utils.extmods][INFO    ][21375] Creating module dir '/var/cache/salt/minion/extmods/proxy'
2017-12-03 22:24:25,977 [salt.utils.extmods][INFO    ][21375] Syncing proxy for environment 'base'
2017-12-03 22:24:25,977 [salt.utils.extmods][INFO    ][21375] Loading cache from salt://_proxy, for base)
2017-12-03 22:24:25,977 [salt.fileclient  ][INFO    ][21375] Caching directory '_proxy/' for environment 'base'
2017-12-03 22:24:26,008 [salt.utils.extmods][INFO    ][21375] Creating module dir '/var/cache/salt/minion/extmods/engines'
2017-12-03 22:24:26,010 [salt.utils.extmods][INFO    ][21375] Syncing engines for environment 'base'
2017-12-03 22:24:26,011 [salt.utils.extmods][INFO    ][21375] Loading cache from salt://_engines, for base)
2017-12-03 22:24:26,011 [salt.fileclient  ][INFO    ][21375] Caching directory '_engines/' for environment 'base'
2017-12-03 22:24:26,044 [salt.minion      ][INFO    ][21375] Returning information for job: 20171203222421400186
2017-12-03 22:24:26,911 [salt.minion      ][INFO    ][21276] User sudo_ubuntu Executing command state.sls with jid 20171203222426901310
2017-12-03 22:24:26,921 [salt.minion      ][INFO    ][21440] Starting a new job with PID 21440
2017-12-03 22:24:27,547 [salt.state       ][INFO    ][21440] Loading fresh modules for state activity
2017-12-03 22:24:27,574 [salt.fileclient  ][INFO    ][21440] Fetching file from saltenv 'base', ** done ** 'salt/control/init.sls'
2017-12-03 22:24:27,600 [salt.fileclient  ][INFO    ][21440] Fetching file from saltenv 'base', ** done ** 'salt/control/virt.sls'
2017-12-03 22:24:27,627 [salt.fileclient  ][INFO    ][21440] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-12-03 22:24:27,776 [salt.fileclient  ][INFO    ][21440] Fetching file from saltenv 'base', ** done ** 'salt/minion/init.sls'
2017-12-03 22:24:27,790 [salt.fileclient  ][INFO    ][21440] Fetching file from saltenv 'base', ** done ** 'salt/minion/service.sls'
2017-12-03 22:24:27,817 [salt.fileclient  ][INFO    ][21440] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-12-03 22:24:27,884 [salt.fileclient  ][INFO    ][21440] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-12-03 22:24:27,902 [salt.fileclient  ][INFO    ][21440] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-12-03 22:24:27,960 [salt.fileclient  ][INFO    ][21440] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-12-03 22:24:27,979 [salt.fileclient  ][INFO    ][21440] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-12-03 22:24:27,992 [salt.fileclient  ][INFO    ][21440] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-12-03 22:24:28,039 [salt.fileclient  ][INFO    ][21440] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-12-03 22:24:28,049 [salt.loaded.int.module.cmdmod][INFO    ][21440] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-12-03 22:24:28,072 [salt.fileclient  ][INFO    ][21440] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-12-03 22:24:28,092 [py.warnings      ][WARNING ][21440] /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-12-03 22:24:28,093 [salt.loaded.int.module.cmdmod][INFO    ][21440] Executing command 'salt-minion --version' in directory '/root'
2017-12-03 22:24:28,365 [salt.fileclient  ][INFO    ][21440] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-12-03 22:24:28,387 [salt.fileclient  ][INFO    ][21440] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-12-03 22:24:28,400 [salt.fileclient  ][INFO    ][21440] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-12-03 22:24:28,414 [salt.fileclient  ][INFO    ][21440] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-12-03 22:24:28,458 [salt.fileclient  ][INFO    ][21440] Fetching file from saltenv 'base', ** done ** 'reclass/meta/meta.yml'
2017-12-03 22:24:28,476 [salt.fileclient  ][INFO    ][21440] Fetching file from saltenv 'base', ** done ** 'reclass/map.jinja'
2017-12-03 22:24:28,503 [salt.fileclient  ][INFO    ][21440] Fetching file from saltenv 'base', ** done ** 'ntp/meta/meta.yml'
2017-12-03 22:24:28,519 [salt.fileclient  ][INFO    ][21440] Fetching file from saltenv 'base', ** done ** 'ntp/map.jinja'
2017-12-03 22:24:28,542 [salt.fileclient  ][INFO    ][21440] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-12-03 22:24:28,581 [salt.fileclient  ][INFO    ][21440] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-12-03 22:24:28,652 [salt.fileclient  ][INFO    ][21440] Fetching file from saltenv 'base', ** done ** 'salt/minion/grains.sls'
2017-12-03 22:24:28,673 [salt.fileclient  ][INFO    ][21440] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-12-03 22:24:28,743 [salt.fileclient  ][INFO    ][21440] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-12-03 22:24:28,763 [salt.fileclient  ][INFO    ][21440] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-12-03 22:24:28,821 [salt.fileclient  ][INFO    ][21440] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-12-03 22:24:29,130 [salt.fileclient  ][INFO    ][21440] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-12-03 22:24:29,143 [salt.fileclient  ][INFO    ][21440] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-12-03 22:24:29,163 [salt.fileclient  ][INFO    ][21440] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-12-03 22:24:29,172 [salt.loaded.int.module.cmdmod][INFO    ][21440] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-12-03 22:24:29,195 [salt.fileclient  ][INFO    ][21440] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-12-03 22:24:29,216 [salt.loaded.int.module.cmdmod][INFO    ][21440] Executing command 'salt-minion --version' in directory '/root'
2017-12-03 22:24:29,497 [salt.fileclient  ][INFO    ][21440] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-12-03 22:24:29,519 [salt.fileclient  ][INFO    ][21440] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-12-03 22:24:29,532 [salt.fileclient  ][INFO    ][21440] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-12-03 22:24:29,547 [salt.fileclient  ][INFO    ][21440] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-12-03 22:24:29,592 [salt.fileclient  ][INFO    ][21440] Fetching file from saltenv 'base', ** done ** 'reclass/meta/meta.yml'
2017-12-03 22:24:29,607 [salt.fileclient  ][INFO    ][21440] Fetching file from saltenv 'base', ** done ** 'reclass/map.jinja'
2017-12-03 22:24:29,631 [salt.fileclient  ][INFO    ][21440] Fetching file from saltenv 'base', ** done ** 'ntp/meta/meta.yml'
2017-12-03 22:24:29,645 [salt.fileclient  ][INFO    ][21440] Fetching file from saltenv 'base', ** done ** 'ntp/map.jinja'
2017-12-03 22:24:29,664 [salt.fileclient  ][INFO    ][21440] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-12-03 22:24:29,699 [salt.fileclient  ][INFO    ][21440] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-12-03 22:24:29,791 [salt.fileclient  ][INFO    ][21440] Fetching file from saltenv 'base', ** done ** 'salt/minion/cert.sls'
2017-12-03 22:24:29,868 [salt.fileclient  ][INFO    ][21440] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-12-03 22:24:30,281 [salt.state       ][INFO    ][21440] Running state [salt-minion] at time 22:24:30.281106
2017-12-03 22:24:30,281 [salt.state       ][INFO    ][21440] Executing state pkg.installed for salt-minion
2017-12-03 22:24:30,282 [salt.loaded.int.module.cmdmod][INFO    ][21440] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-03 22:24:30,569 [salt.state       ][INFO    ][21440] Package salt-minion is already installed
2017-12-03 22:24:30,569 [salt.state       ][INFO    ][21440] Completed state [salt-minion] at time 22:24:30.568947 duration_in_ms=287.842
2017-12-03 22:24:30,569 [salt.state       ][INFO    ][21440] Running state [salt_minion_dependency_packages] at time 22:24:30.569207
2017-12-03 22:24:30,569 [salt.state       ][INFO    ][21440] Executing state pkg.installed for salt_minion_dependency_packages
2017-12-03 22:24:30,573 [salt.state       ][INFO    ][21440] All specified packages are already installed
2017-12-03 22:24:30,574 [salt.state       ][INFO    ][21440] Completed state [salt_minion_dependency_packages] at time 22:24:30.573672 duration_in_ms=4.464
2017-12-03 22:24:30,576 [salt.state       ][INFO    ][21440] Running state [/etc/salt/minion.d/minion.conf] at time 22:24:30.575754
2017-12-03 22:24:30,576 [salt.state       ][INFO    ][21440] Executing state file.managed for /etc/salt/minion.d/minion.conf
2017-12-03 22:24:30,594 [salt.fileclient  ][INFO    ][21440] Fetching file from saltenv 'base', ** done ** 'salt/files/minion.conf'
2017-12-03 22:24:30,654 [salt.fileclient  ][INFO    ][21440] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-12-03 22:24:30,705 [salt.fileclient  ][INFO    ][21440] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-12-03 22:24:30,751 [salt.state       ][INFO    ][21440] File /etc/salt/minion.d/minion.conf is in the correct state
2017-12-03 22:24:30,751 [salt.state       ][INFO    ][21440] Completed state [/etc/salt/minion.d/minion.conf] at time 22:24:30.751350 duration_in_ms=175.596
2017-12-03 22:24:30,752 [salt.state       ][INFO    ][21440] Running state [/etc/salt/minion.d/_virt.conf] at time 22:24:30.751794
2017-12-03 22:24:30,752 [salt.state       ][INFO    ][21440] Executing state file.managed for /etc/salt/minion.d/_virt.conf
2017-12-03 22:24:30,753 [salt.state       ][INFO    ][21440] File /etc/salt/minion.d/_virt.conf is in the correct state
2017-12-03 22:24:30,753 [salt.state       ][INFO    ][21440] Completed state [/etc/salt/minion.d/_virt.conf] at time 22:24:30.752838 duration_in_ms=1.043
2017-12-03 22:24:30,755 [salt.state       ][INFO    ][21440] Running state [salt-minion] at time 22:24:30.754576
2017-12-03 22:24:30,755 [salt.state       ][INFO    ][21440] Executing state service.running for salt-minion
2017-12-03 22:24:30,755 [salt.loaded.int.module.cmdmod][INFO    ][21440] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2017-12-03 22:24:30,769 [salt.loaded.int.module.cmdmod][INFO    ][21440] Executing command ['systemctl', 'is-active', 'salt-minion.service'] in directory '/root'
2017-12-03 22:24:30,778 [salt.loaded.int.module.cmdmod][INFO    ][21440] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2017-12-03 22:24:30,783 [salt.state       ][INFO    ][21440] The service salt-minion is already running
2017-12-03 22:24:30,783 [salt.state       ][INFO    ][21440] Completed state [salt-minion] at time 22:24:30.783350 duration_in_ms=28.774
2017-12-03 22:24:30,785 [salt.state       ][INFO    ][21440] Running state [/etc/salt/grains.d] at time 22:24:30.784961
2017-12-03 22:24:30,785 [salt.state       ][INFO    ][21440] Executing state file.directory for /etc/salt/grains.d
2017-12-03 22:24:30,786 [salt.state       ][INFO    ][21440] Directory /etc/salt/grains.d is in the correct state
2017-12-03 22:24:30,786 [salt.state       ][INFO    ][21440] Completed state [/etc/salt/grains.d] at time 22:24:30.785971 duration_in_ms=1.011
2017-12-03 22:24:30,787 [salt.state       ][INFO    ][21440] Running state [/etc/salt/grains] at time 22:24:30.786533
2017-12-03 22:24:30,787 [salt.state       ][INFO    ][21440] Executing state file.managed for /etc/salt/grains
2017-12-03 22:24:30,787 [salt.state       ][INFO    ][21440] File /etc/salt/grains exists with proper permissions. No changes made.
2017-12-03 22:24:30,787 [salt.state       ][INFO    ][21440] Completed state [/etc/salt/grains] at time 22:24:30.787288 duration_in_ms=0.754
2017-12-03 22:24:30,788 [salt.state       ][INFO    ][21440] Running state [/etc/salt/grains.d/placeholder] at time 22:24:30.787691
2017-12-03 22:24:30,788 [salt.state       ][INFO    ][21440] Executing state file.managed for /etc/salt/grains.d/placeholder
2017-12-03 22:24:30,788 [salt.state       ][INFO    ][21440] File /etc/salt/grains.d/placeholder exists with proper permissions. No changes made.
2017-12-03 22:24:30,788 [salt.state       ][INFO    ][21440] Completed state [/etc/salt/grains.d/placeholder] at time 22:24:30.788404 duration_in_ms=0.712
2017-12-03 22:24:30,789 [salt.state       ][INFO    ][21440] Running state [/etc/salt/grains.d/sphinx] at time 22:24:30.788779
2017-12-03 22:24:30,789 [salt.state       ][INFO    ][21440] Executing state file.managed for /etc/salt/grains.d/sphinx
2017-12-03 22:24:30,790 [salt.state       ][INFO    ][21440] File changed:
--- 
+++ 
@@ -49,7 +49,6 @@
               - 127.0.0.1
               - 192.168.10.141
               - 192.168.11.2
-              - 192.168.122.1
         system:
           name: System
           param:

2017-12-03 22:24:30,791 [salt.state       ][INFO    ][21440] Completed state [/etc/salt/grains.d/sphinx] at time 22:24:30.790555 duration_in_ms=1.775
2017-12-03 22:24:30,791 [salt.state       ][INFO    ][21440] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 22:24:30.791303
2017-12-03 22:24:30,792 [salt.state       ][INFO    ][21440] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-12-03 22:24:30,792 [salt.state       ][INFO    ][21440] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-12-03 22:24:30,792 [salt.state       ][INFO    ][21440] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 22:24:30.791906 duration_in_ms=0.603
2017-12-03 22:24:30,792 [salt.state       ][INFO    ][21440] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 22:24:30.792069
2017-12-03 22:24:30,792 [salt.state       ][INFO    ][21440] Executing state cmd.mod_watch for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-12-03 22:24:30,793 [salt.loaded.int.module.cmdmod][INFO    ][21440] Executing command 'python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"' in directory '/root'
2017-12-03 22:24:30,865 [salt.state       ][INFO    ][21440] {'pid': 21518, 'retcode': 0, 'stderr': '', 'stdout': ''}
2017-12-03 22:24:30,866 [salt.state       ][INFO    ][21440] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 22:24:30.865835 duration_in_ms=73.765
2017-12-03 22:24:30,866 [salt.state       ][INFO    ][21440] Running state [/etc/salt/grains.d/dns_records] at time 22:24:30.866434
2017-12-03 22:24:30,867 [salt.state       ][INFO    ][21440] Executing state file.managed for /etc/salt/grains.d/dns_records
2017-12-03 22:24:30,868 [salt.state       ][INFO    ][21440] File /etc/salt/grains.d/dns_records is in the correct state
2017-12-03 22:24:30,868 [salt.state       ][INFO    ][21440] Completed state [/etc/salt/grains.d/dns_records] at time 22:24:30.867930 duration_in_ms=1.496
2017-12-03 22:24:30,869 [salt.state       ][INFO    ][21440] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 22:24:30.868815
2017-12-03 22:24:30,869 [salt.state       ][INFO    ][21440] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"
2017-12-03 22:24:30,869 [salt.state       ][INFO    ][21440] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"
2017-12-03 22:24:30,869 [salt.state       ][INFO    ][21440] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 22:24:30.869447 duration_in_ms=0.632
2017-12-03 22:24:30,870 [salt.state       ][INFO    ][21440] Running state [/etc/salt/grains.d/salt] at time 22:24:30.869856
2017-12-03 22:24:30,870 [salt.state       ][INFO    ][21440] Executing state file.managed for /etc/salt/grains.d/salt
2017-12-03 22:24:30,871 [salt.state       ][INFO    ][21440] File /etc/salt/grains.d/salt is in the correct state
2017-12-03 22:24:30,871 [salt.state       ][INFO    ][21440] Completed state [/etc/salt/grains.d/salt] at time 22:24:30.870927 duration_in_ms=1.07
2017-12-03 22:24:30,872 [salt.state       ][INFO    ][21440] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 22:24:30.871731
2017-12-03 22:24:30,872 [salt.state       ][INFO    ][21440] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2017-12-03 22:24:30,872 [salt.state       ][INFO    ][21440] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2017-12-03 22:24:30,872 [salt.state       ][INFO    ][21440] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 22:24:30.872359 duration_in_ms=0.628
2017-12-03 22:24:30,874 [salt.state       ][INFO    ][21440] Running state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 22:24:30.873976
2017-12-03 22:24:30,874 [salt.state       ][INFO    ][21440] Executing state cmd.wait for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-12-03 22:24:30,874 [salt.state       ][INFO    ][21440] No changes made for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-12-03 22:24:30,875 [salt.state       ][INFO    ][21440] Completed state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 22:24:30.874593 duration_in_ms=0.616
2017-12-03 22:24:30,875 [salt.state       ][INFO    ][21440] Running state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 22:24:30.874752
2017-12-03 22:24:30,875 [salt.state       ][INFO    ][21440] Executing state cmd.mod_watch for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-12-03 22:24:30,877 [salt.loaded.int.module.cmdmod][INFO    ][21440] Executing command 'cat /etc/salt/grains.d/* > /etc/salt/grains' in directory '/root'
2017-12-03 22:24:30,885 [salt.state       ][INFO    ][21440] {'pid': 21520, 'retcode': 0, 'stderr': '', 'stdout': ''}
2017-12-03 22:24:30,886 [salt.state       ][INFO    ][21440] Completed state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 22:24:30.885652 duration_in_ms=10.899
2017-12-03 22:24:30,887 [salt.state       ][INFO    ][21440] Running state [mine.update] at time 22:24:30.886986
2017-12-03 22:24:30,887 [salt.state       ][INFO    ][21440] Executing state module.wait for mine.update
2017-12-03 22:24:30,888 [salt.state       ][INFO    ][21440] No changes made for mine.update
2017-12-03 22:24:30,888 [salt.state       ][INFO    ][21440] Completed state [mine.update] at time 22:24:30.887703 duration_in_ms=0.717
2017-12-03 22:24:30,888 [salt.state       ][INFO    ][21440] Running state [mine.update] at time 22:24:30.887902
2017-12-03 22:24:30,888 [salt.state       ][INFO    ][21440] Executing state module.mod_watch for mine.update
2017-12-03 22:24:31,404 [salt.state       ][INFO    ][21440] {'ret': True}
2017-12-03 22:24:31,405 [salt.state       ][INFO    ][21440] Completed state [mine.update] at time 22:24:31.404500 duration_in_ms=516.598
2017-12-03 22:24:31,405 [salt.state       ][INFO    ][21440] Running state [ca-certificates] at time 22:24:31.404799
2017-12-03 22:24:31,405 [salt.state       ][INFO    ][21440] Executing state pkg.installed for ca-certificates
2017-12-03 22:24:31,409 [salt.state       ][INFO    ][21440] Package ca-certificates is already installed
2017-12-03 22:24:31,409 [salt.state       ][INFO    ][21440] Completed state [ca-certificates] at time 22:24:31.409263 duration_in_ms=4.464
2017-12-03 22:24:31,410 [salt.state       ][INFO    ][21440] Running state [update-ca-certificates] at time 22:24:31.409937
2017-12-03 22:24:31,410 [salt.state       ][INFO    ][21440] Executing state cmd.wait for update-ca-certificates
2017-12-03 22:24:31,410 [salt.state       ][INFO    ][21440] No changes made for update-ca-certificates
2017-12-03 22:24:31,411 [salt.state       ][INFO    ][21440] Completed state [update-ca-certificates] at time 22:24:31.410515 duration_in_ms=0.578
2017-12-03 22:24:31,411 [salt.state       ][INFO    ][21440] Running state [libvirt-dev] at time 22:24:31.410692
2017-12-03 22:24:31,411 [salt.state       ][INFO    ][21440] Executing state pkg.installed for libvirt-dev
2017-12-03 22:24:31,415 [salt.state       ][INFO    ][21440] Package libvirt-dev is already installed
2017-12-03 22:24:31,415 [salt.state       ][INFO    ][21440] Completed state [libvirt-dev] at time 22:24:31.414679 duration_in_ms=3.986
2017-12-03 22:24:31,415 [salt.state       ][INFO    ][21440] Running state [pkg-config] at time 22:24:31.414857
2017-12-03 22:24:31,415 [salt.state       ][INFO    ][21440] Executing state pkg.installed for pkg-config
2017-12-03 22:24:31,419 [salt.state       ][INFO    ][21440] Package pkg-config is already installed
2017-12-03 22:24:31,419 [salt.state       ][INFO    ][21440] Completed state [pkg-config] at time 22:24:31.418850 duration_in_ms=3.992
2017-12-03 22:24:31,419 [salt.state       ][INFO    ][21440] Running state [virtng.init] at time 22:24:31.419032
2017-12-03 22:24:31,419 [salt.state       ][INFO    ][21440] Executing state module.run for virtng.init
2017-12-03 22:24:31,485 [salt.loaded.int.module.cmdmod][INFO    ][21440] Executing command ['git', '--version'] in directory '/root'
2017-12-03 22:24:31,564 [salt.loaded.int.module.cmdmod][INFO    ][21440] Executing command 'virsh list --all --name| grep -E "^prx01.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-12-03 22:24:31,593 [salt.state       ][INFO    ][21440] unless execution succeeded
2017-12-03 22:24:31,593 [salt.state       ][INFO    ][21440] Completed state [virtng.init] at time 22:24:31.593214 duration_in_ms=174.181
2017-12-03 22:24:31,594 [salt.state       ][INFO    ][21440] Running state [virt.set_autostart] at time 22:24:31.593484
2017-12-03 22:24:31,594 [salt.state       ][INFO    ][21440] Executing state module.run for virt.set_autostart
2017-12-03 22:24:31,596 [salt.loaded.int.module.cmdmod][INFO    ][21440] Executing command 'virsh list --autostart --name| grep -E "^prx01.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-12-03 22:24:31,613 [salt.state       ][INFO    ][21440] unless execution succeeded
2017-12-03 22:24:31,614 [salt.state       ][INFO    ][21440] Completed state [virt.set_autostart] at time 22:24:31.613412 duration_in_ms=19.926
2017-12-03 22:24:31,614 [salt.state       ][INFO    ][21440] Running state [virtng.init] at time 22:24:31.614078
2017-12-03 22:24:31,615 [salt.state       ][INFO    ][21440] Executing state module.run for virtng.init
2017-12-03 22:24:31,621 [salt.loaded.int.module.cmdmod][INFO    ][21440] Executing command 'virsh list --all --name| grep -E "^mdb01.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-12-03 22:24:31,643 [salt.state       ][INFO    ][21440] unless execution succeeded
2017-12-03 22:24:31,643 [salt.state       ][INFO    ][21440] Completed state [virtng.init] at time 22:24:31.643147 duration_in_ms=29.07
2017-12-03 22:24:31,643 [salt.state       ][INFO    ][21440] Running state [virt.set_autostart] at time 22:24:31.643382
2017-12-03 22:24:31,644 [salt.state       ][INFO    ][21440] Executing state module.run for virt.set_autostart
2017-12-03 22:24:31,646 [salt.loaded.int.module.cmdmod][INFO    ][21440] Executing command 'virsh list --autostart --name| grep -E "^mdb01.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-12-03 22:24:31,662 [salt.state       ][INFO    ][21440] unless execution succeeded
2017-12-03 22:24:31,663 [salt.state       ][INFO    ][21440] Completed state [virt.set_autostart] at time 22:24:31.662583 duration_in_ms=19.2
2017-12-03 22:24:31,663 [salt.state       ][INFO    ][21440] Running state [virtng.init] at time 22:24:31.662825
2017-12-03 22:24:31,663 [salt.state       ][INFO    ][21440] Executing state module.run for virtng.init
2017-12-03 22:24:31,666 [salt.loaded.int.module.cmdmod][INFO    ][21440] Executing command 'virsh list --all --name| grep -E "^ctl01.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-12-03 22:24:31,680 [salt.state       ][INFO    ][21440] unless execution succeeded
2017-12-03 22:24:31,680 [salt.state       ][INFO    ][21440] Completed state [virtng.init] at time 22:24:31.679893 duration_in_ms=17.068
2017-12-03 22:24:31,681 [salt.state       ][INFO    ][21440] Running state [virt.set_autostart] at time 22:24:31.680507
2017-12-03 22:24:31,681 [salt.state       ][INFO    ][21440] Executing state module.run for virt.set_autostart
2017-12-03 22:24:31,687 [salt.loaded.int.module.cmdmod][INFO    ][21440] Executing command 'virsh list --autostart --name| grep -E "^ctl01.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-12-03 22:24:31,711 [salt.state       ][INFO    ][21440] unless execution succeeded
2017-12-03 22:24:31,712 [salt.state       ][INFO    ][21440] Completed state [virt.set_autostart] at time 22:24:31.711718 duration_in_ms=31.212
2017-12-03 22:24:31,712 [salt.state       ][INFO    ][21440] Running state [virtng.init] at time 22:24:31.712050
2017-12-03 22:24:31,713 [salt.state       ][INFO    ][21440] Executing state module.run for virtng.init
2017-12-03 22:24:31,719 [salt.loaded.int.module.cmdmod][INFO    ][21440] Executing command 'virsh list --all --name| grep -E "^msg01.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-12-03 22:24:31,737 [salt.state       ][INFO    ][21440] unless execution succeeded
2017-12-03 22:24:31,737 [salt.state       ][INFO    ][21440] Completed state [virtng.init] at time 22:24:31.737008 duration_in_ms=24.959
2017-12-03 22:24:31,737 [salt.state       ][INFO    ][21440] Running state [virt.set_autostart] at time 22:24:31.737281
2017-12-03 22:24:31,738 [salt.state       ][INFO    ][21440] Executing state module.run for virt.set_autostart
2017-12-03 22:24:31,740 [salt.loaded.int.module.cmdmod][INFO    ][21440] Executing command 'virsh list --autostart --name| grep -E "^msg01.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-12-03 22:24:31,755 [salt.state       ][INFO    ][21440] unless execution succeeded
2017-12-03 22:24:31,756 [salt.state       ][INFO    ][21440] Completed state [virt.set_autostart] at time 22:24:31.755494 duration_in_ms=18.213
2017-12-03 22:24:31,756 [salt.state       ][INFO    ][21440] Running state [virtng.init] at time 22:24:31.755768
2017-12-03 22:24:31,756 [salt.state       ][INFO    ][21440] Executing state module.run for virtng.init
2017-12-03 22:24:31,759 [salt.loaded.int.module.cmdmod][INFO    ][21440] Executing command 'virsh list --all --name| grep -E "^dbs01.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-12-03 22:24:31,774 [salt.state       ][INFO    ][21440] unless execution succeeded
2017-12-03 22:24:31,774 [salt.state       ][INFO    ][21440] Completed state [virtng.init] at time 22:24:31.773977 duration_in_ms=18.209
2017-12-03 22:24:31,774 [salt.state       ][INFO    ][21440] Running state [virt.set_autostart] at time 22:24:31.774199
2017-12-03 22:24:31,774 [salt.state       ][INFO    ][21440] Executing state module.run for virt.set_autostart
2017-12-03 22:24:31,777 [salt.loaded.int.module.cmdmod][INFO    ][21440] Executing command 'virsh list --autostart --name| grep -E "^dbs01.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-12-03 22:24:31,793 [salt.state       ][INFO    ][21440] unless execution succeeded
2017-12-03 22:24:31,793 [salt.state       ][INFO    ][21440] Completed state [virt.set_autostart] at time 22:24:31.792803 duration_in_ms=18.603
2017-12-03 22:24:31,796 [salt.minion      ][INFO    ][21440] Returning information for job: 20171203222426901310
2017-12-03 22:24:58,074 [salt.minion      ][INFO    ][21276] User sudo_ubuntu Executing command state.sls with jid 20171203222458060640
2017-12-03 22:24:58,086 [salt.minion      ][INFO    ][21573] Starting a new job with PID 21573
2017-12-03 22:25:00,483 [salt.state       ][INFO    ][21573] Loading fresh modules for state activity
2017-12-03 22:25:00,514 [salt.fileclient  ][INFO    ][21573] Fetching file from saltenv 'base', ** done ** 'salt/control/init.sls'
2017-12-03 22:25:00,535 [salt.fileclient  ][INFO    ][21573] Fetching file from saltenv 'base', ** done ** 'salt/control/virt.sls'
2017-12-03 22:25:00,592 [salt.fileclient  ][INFO    ][21573] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-12-03 22:25:00,675 [salt.fileclient  ][INFO    ][21573] Fetching file from saltenv 'base', ** done ** 'salt/minion/init.sls'
2017-12-03 22:25:00,692 [salt.fileclient  ][INFO    ][21573] Fetching file from saltenv 'base', ** done ** 'salt/minion/service.sls'
2017-12-03 22:25:00,725 [salt.fileclient  ][INFO    ][21573] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-12-03 22:25:00,792 [salt.fileclient  ][INFO    ][21573] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-12-03 22:25:00,813 [salt.fileclient  ][INFO    ][21573] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-12-03 22:25:00,871 [salt.fileclient  ][INFO    ][21573] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-12-03 22:25:00,890 [salt.fileclient  ][INFO    ][21573] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-12-03 22:25:00,905 [salt.fileclient  ][INFO    ][21573] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-12-03 22:25:00,923 [salt.fileclient  ][INFO    ][21573] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-12-03 22:25:00,932 [salt.loaded.int.module.cmdmod][INFO    ][21573] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-12-03 22:25:00,955 [salt.fileclient  ][INFO    ][21573] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-12-03 22:25:00,974 [py.warnings      ][WARNING ][21573] /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-12-03 22:25:00,975 [salt.loaded.int.module.cmdmod][INFO    ][21573] Executing command 'salt-minion --version' in directory '/root'
2017-12-03 22:25:01,238 [salt.fileclient  ][INFO    ][21573] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-12-03 22:25:01,260 [salt.fileclient  ][INFO    ][21573] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-12-03 22:25:01,274 [salt.fileclient  ][INFO    ][21573] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-12-03 22:25:01,289 [salt.fileclient  ][INFO    ][21573] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-12-03 22:25:01,334 [salt.fileclient  ][INFO    ][21573] Fetching file from saltenv 'base', ** done ** 'reclass/meta/meta.yml'
2017-12-03 22:25:01,350 [salt.fileclient  ][INFO    ][21573] Fetching file from saltenv 'base', ** done ** 'reclass/map.jinja'
2017-12-03 22:25:01,375 [salt.fileclient  ][INFO    ][21573] Fetching file from saltenv 'base', ** done ** 'ntp/meta/meta.yml'
2017-12-03 22:25:01,391 [salt.fileclient  ][INFO    ][21573] Fetching file from saltenv 'base', ** done ** 'ntp/map.jinja'
2017-12-03 22:25:01,411 [salt.fileclient  ][INFO    ][21573] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-12-03 22:25:01,454 [salt.fileclient  ][INFO    ][21573] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-12-03 22:25:01,524 [salt.fileclient  ][INFO    ][21573] Fetching file from saltenv 'base', ** done ** 'salt/minion/grains.sls'
2017-12-03 22:25:01,553 [salt.fileclient  ][INFO    ][21573] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-12-03 22:25:01,622 [salt.fileclient  ][INFO    ][21573] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-12-03 22:25:01,643 [salt.fileclient  ][INFO    ][21573] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-12-03 22:25:01,698 [salt.fileclient  ][INFO    ][21573] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-12-03 22:25:01,719 [salt.fileclient  ][INFO    ][21573] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-12-03 22:25:01,732 [salt.fileclient  ][INFO    ][21573] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-12-03 22:25:01,749 [salt.fileclient  ][INFO    ][21573] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-12-03 22:25:01,757 [salt.loaded.int.module.cmdmod][INFO    ][21573] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-12-03 22:25:01,791 [salt.fileclient  ][INFO    ][21573] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-12-03 22:25:01,810 [salt.loaded.int.module.cmdmod][INFO    ][21573] Executing command 'salt-minion --version' in directory '/root'
2017-12-03 22:25:02,067 [salt.fileclient  ][INFO    ][21573] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-12-03 22:25:02,088 [salt.fileclient  ][INFO    ][21573] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-12-03 22:25:02,101 [salt.fileclient  ][INFO    ][21573] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-12-03 22:25:02,115 [salt.fileclient  ][INFO    ][21573] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-12-03 22:25:02,159 [salt.fileclient  ][INFO    ][21573] Fetching file from saltenv 'base', ** done ** 'reclass/meta/meta.yml'
2017-12-03 22:25:02,175 [salt.fileclient  ][INFO    ][21573] Fetching file from saltenv 'base', ** done ** 'reclass/map.jinja'
2017-12-03 22:25:02,200 [salt.fileclient  ][INFO    ][21573] Fetching file from saltenv 'base', ** done ** 'ntp/meta/meta.yml'
2017-12-03 22:25:02,216 [salt.fileclient  ][INFO    ][21573] Fetching file from saltenv 'base', ** done ** 'ntp/map.jinja'
2017-12-03 22:25:02,238 [salt.fileclient  ][INFO    ][21573] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-12-03 22:25:02,278 [salt.fileclient  ][INFO    ][21573] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-12-03 22:25:02,356 [salt.fileclient  ][INFO    ][21573] Fetching file from saltenv 'base', ** done ** 'salt/minion/cert.sls'
2017-12-03 22:25:02,440 [salt.fileclient  ][INFO    ][21573] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-12-03 22:25:02,784 [salt.state       ][INFO    ][21573] Running state [salt-minion] at time 22:25:02.783613
2017-12-03 22:25:02,784 [salt.state       ][INFO    ][21573] Executing state pkg.installed for salt-minion
2017-12-03 22:25:02,784 [salt.loaded.int.module.cmdmod][INFO    ][21573] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-03 22:25:03,042 [salt.state       ][INFO    ][21573] Package salt-minion is already installed
2017-12-03 22:25:03,042 [salt.state       ][INFO    ][21573] Completed state [salt-minion] at time 22:25:03.041760 duration_in_ms=258.147
2017-12-03 22:25:03,042 [salt.state       ][INFO    ][21573] Running state [salt_minion_dependency_packages] at time 22:25:03.041992
2017-12-03 22:25:03,042 [salt.state       ][INFO    ][21573] Executing state pkg.installed for salt_minion_dependency_packages
2017-12-03 22:25:03,046 [salt.state       ][INFO    ][21573] All specified packages are already installed
2017-12-03 22:25:03,046 [salt.state       ][INFO    ][21573] Completed state [salt_minion_dependency_packages] at time 22:25:03.045966 duration_in_ms=3.974
2017-12-03 22:25:03,048 [salt.state       ][INFO    ][21573] Running state [/etc/salt/minion.d/minion.conf] at time 22:25:03.047562
2017-12-03 22:25:03,048 [salt.state       ][INFO    ][21573] Executing state file.managed for /etc/salt/minion.d/minion.conf
2017-12-03 22:25:03,072 [salt.fileclient  ][INFO    ][21573] Fetching file from saltenv 'base', ** done ** 'salt/files/minion.conf'
2017-12-03 22:25:03,134 [salt.fileclient  ][INFO    ][21573] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-12-03 22:25:03,191 [salt.fileclient  ][INFO    ][21573] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-12-03 22:25:03,239 [salt.state       ][INFO    ][21573] File /etc/salt/minion.d/minion.conf is in the correct state
2017-12-03 22:25:03,239 [salt.state       ][INFO    ][21573] Completed state [/etc/salt/minion.d/minion.conf] at time 22:25:03.239073 duration_in_ms=191.51
2017-12-03 22:25:03,239 [salt.state       ][INFO    ][21573] Running state [/etc/salt/minion.d/_virt.conf] at time 22:25:03.239448
2017-12-03 22:25:03,240 [salt.state       ][INFO    ][21573] Executing state file.managed for /etc/salt/minion.d/_virt.conf
2017-12-03 22:25:03,240 [salt.state       ][INFO    ][21573] File /etc/salt/minion.d/_virt.conf is in the correct state
2017-12-03 22:25:03,240 [salt.state       ][INFO    ][21573] Completed state [/etc/salt/minion.d/_virt.conf] at time 22:25:03.240416 duration_in_ms=0.969
2017-12-03 22:25:03,242 [salt.state       ][INFO    ][21573] Running state [salt-minion] at time 22:25:03.242031
2017-12-03 22:25:03,242 [salt.state       ][INFO    ][21573] Executing state service.running for salt-minion
2017-12-03 22:25:03,243 [salt.loaded.int.module.cmdmod][INFO    ][21573] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2017-12-03 22:25:03,258 [salt.loaded.int.module.cmdmod][INFO    ][21573] Executing command ['systemctl', 'is-active', 'salt-minion.service'] in directory '/root'
2017-12-03 22:25:03,266 [salt.loaded.int.module.cmdmod][INFO    ][21573] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2017-12-03 22:25:03,274 [salt.state       ][INFO    ][21573] The service salt-minion is already running
2017-12-03 22:25:03,274 [salt.state       ][INFO    ][21573] Completed state [salt-minion] at time 22:25:03.274257 duration_in_ms=32.226
2017-12-03 22:25:03,276 [salt.state       ][INFO    ][21573] Running state [/etc/salt/grains.d] at time 22:25:03.275788
2017-12-03 22:25:03,276 [salt.state       ][INFO    ][21573] Executing state file.directory for /etc/salt/grains.d
2017-12-03 22:25:03,277 [salt.state       ][INFO    ][21573] Directory /etc/salt/grains.d is in the correct state
2017-12-03 22:25:03,277 [salt.state       ][INFO    ][21573] Completed state [/etc/salt/grains.d] at time 22:25:03.276689 duration_in_ms=0.901
2017-12-03 22:25:03,277 [salt.state       ][INFO    ][21573] Running state [/etc/salt/grains] at time 22:25:03.277186
2017-12-03 22:25:03,277 [salt.state       ][INFO    ][21573] Executing state file.managed for /etc/salt/grains
2017-12-03 22:25:03,278 [salt.state       ][INFO    ][21573] File /etc/salt/grains exists with proper permissions. No changes made.
2017-12-03 22:25:03,278 [salt.state       ][INFO    ][21573] Completed state [/etc/salt/grains] at time 22:25:03.277820 duration_in_ms=0.634
2017-12-03 22:25:03,278 [salt.state       ][INFO    ][21573] Running state [/etc/salt/grains.d/placeholder] at time 22:25:03.278144
2017-12-03 22:25:03,278 [salt.state       ][INFO    ][21573] Executing state file.managed for /etc/salt/grains.d/placeholder
2017-12-03 22:25:03,279 [salt.state       ][INFO    ][21573] File /etc/salt/grains.d/placeholder exists with proper permissions. No changes made.
2017-12-03 22:25:03,279 [salt.state       ][INFO    ][21573] Completed state [/etc/salt/grains.d/placeholder] at time 22:25:03.278755 duration_in_ms=0.61
2017-12-03 22:25:03,279 [salt.state       ][INFO    ][21573] Running state [/etc/salt/grains.d/sphinx] at time 22:25:03.279087
2017-12-03 22:25:03,279 [salt.state       ][INFO    ][21573] Executing state file.managed for /etc/salt/grains.d/sphinx
2017-12-03 22:25:03,280 [salt.state       ][INFO    ][21573] File /etc/salt/grains.d/sphinx is in the correct state
2017-12-03 22:25:03,280 [salt.state       ][INFO    ][21573] Completed state [/etc/salt/grains.d/sphinx] at time 22:25:03.280140 duration_in_ms=1.052
2017-12-03 22:25:03,281 [salt.state       ][INFO    ][21573] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 22:25:03.280815
2017-12-03 22:25:03,281 [salt.state       ][INFO    ][21573] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-12-03 22:25:03,281 [salt.state       ][INFO    ][21573] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-12-03 22:25:03,281 [salt.state       ][INFO    ][21573] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 22:25:03.281326 duration_in_ms=0.511
2017-12-03 22:25:03,282 [salt.state       ][INFO    ][21573] Running state [/etc/salt/grains.d/dns_records] at time 22:25:03.281661
2017-12-03 22:25:03,282 [salt.state       ][INFO    ][21573] Executing state file.managed for /etc/salt/grains.d/dns_records
2017-12-03 22:25:03,282 [salt.state       ][INFO    ][21573] File /etc/salt/grains.d/dns_records is in the correct state
2017-12-03 22:25:03,283 [salt.state       ][INFO    ][21573] Completed state [/etc/salt/grains.d/dns_records] at time 22:25:03.282508 duration_in_ms=0.847
2017-12-03 22:25:03,283 [salt.state       ][INFO    ][21573] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 22:25:03.283196
2017-12-03 22:25:03,283 [salt.state       ][INFO    ][21573] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"
2017-12-03 22:25:03,284 [salt.state       ][INFO    ][21573] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"
2017-12-03 22:25:03,284 [salt.state       ][INFO    ][21573] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 22:25:03.283741 duration_in_ms=0.545
2017-12-03 22:25:03,284 [salt.state       ][INFO    ][21573] Running state [/etc/salt/grains.d/salt] at time 22:25:03.284100
2017-12-03 22:25:03,284 [salt.state       ][INFO    ][21573] Executing state file.managed for /etc/salt/grains.d/salt
2017-12-03 22:25:03,285 [salt.state       ][INFO    ][21573] File /etc/salt/grains.d/salt is in the correct state
2017-12-03 22:25:03,285 [salt.state       ][INFO    ][21573] Completed state [/etc/salt/grains.d/salt] at time 22:25:03.284965 duration_in_ms=0.865
2017-12-03 22:25:03,286 [salt.state       ][INFO    ][21573] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 22:25:03.285637
2017-12-03 22:25:03,286 [salt.state       ][INFO    ][21573] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2017-12-03 22:25:03,286 [salt.state       ][INFO    ][21573] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2017-12-03 22:25:03,286 [salt.state       ][INFO    ][21573] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 22:25:03.286160 duration_in_ms=0.522
2017-12-03 22:25:03,288 [salt.state       ][INFO    ][21573] Running state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 22:25:03.287678
2017-12-03 22:25:03,288 [salt.state       ][INFO    ][21573] Executing state cmd.wait for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-12-03 22:25:03,288 [salt.state       ][INFO    ][21573] No changes made for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-12-03 22:25:03,288 [salt.state       ][INFO    ][21573] Completed state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 22:25:03.288289 duration_in_ms=0.611
2017-12-03 22:25:03,289 [salt.state       ][INFO    ][21573] Running state [mine.update] at time 22:25:03.288765
2017-12-03 22:25:03,289 [salt.state       ][INFO    ][21573] Executing state module.wait for mine.update
2017-12-03 22:25:03,289 [salt.state       ][INFO    ][21573] No changes made for mine.update
2017-12-03 22:25:03,289 [salt.state       ][INFO    ][21573] Completed state [mine.update] at time 22:25:03.289238 duration_in_ms=0.473
2017-12-03 22:25:03,289 [salt.state       ][INFO    ][21573] Running state [ca-certificates] at time 22:25:03.289395
2017-12-03 22:25:03,290 [salt.state       ][INFO    ][21573] Executing state pkg.installed for ca-certificates
2017-12-03 22:25:03,293 [salt.state       ][INFO    ][21573] Package ca-certificates is already installed
2017-12-03 22:25:03,294 [salt.state       ][INFO    ][21573] Completed state [ca-certificates] at time 22:25:03.293569 duration_in_ms=4.173
2017-12-03 22:25:03,294 [salt.state       ][INFO    ][21573] Running state [update-ca-certificates] at time 22:25:03.294065
2017-12-03 22:25:03,294 [salt.state       ][INFO    ][21573] Executing state cmd.wait for update-ca-certificates
2017-12-03 22:25:03,294 [salt.state       ][INFO    ][21573] No changes made for update-ca-certificates
2017-12-03 22:25:03,295 [salt.state       ][INFO    ][21573] Completed state [update-ca-certificates] at time 22:25:03.294556 duration_in_ms=0.491
2017-12-03 22:25:03,295 [salt.state       ][INFO    ][21573] Running state [libvirt-dev] at time 22:25:03.294721
2017-12-03 22:25:03,295 [salt.state       ][INFO    ][21573] Executing state pkg.installed for libvirt-dev
2017-12-03 22:25:03,298 [salt.state       ][INFO    ][21573] Package libvirt-dev is already installed
2017-12-03 22:25:03,299 [salt.state       ][INFO    ][21573] Completed state [libvirt-dev] at time 22:25:03.298554 duration_in_ms=3.832
2017-12-03 22:25:03,299 [salt.state       ][INFO    ][21573] Running state [pkg-config] at time 22:25:03.298724
2017-12-03 22:25:03,299 [salt.state       ][INFO    ][21573] Executing state pkg.installed for pkg-config
2017-12-03 22:25:03,302 [salt.state       ][INFO    ][21573] Package pkg-config is already installed
2017-12-03 22:25:03,303 [salt.state       ][INFO    ][21573] Completed state [pkg-config] at time 22:25:03.302531 duration_in_ms=3.806
2017-12-03 22:25:03,303 [salt.state       ][INFO    ][21573] Running state [virtng.init] at time 22:25:03.302698
2017-12-03 22:25:03,303 [salt.state       ][INFO    ][21573] Executing state module.run for virtng.init
2017-12-03 22:25:03,387 [salt.loaded.int.module.cmdmod][INFO    ][21573] Executing command ['git', '--version'] in directory '/root'
2017-12-03 22:25:03,428 [salt.loaded.int.module.cmdmod][INFO    ][21573] Executing command 'virsh list --all --name| grep -E "^prx01.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-12-03 22:25:03,445 [salt.state       ][INFO    ][21573] unless execution succeeded
2017-12-03 22:25:03,445 [salt.state       ][INFO    ][21573] Completed state [virtng.init] at time 22:25:03.444855 duration_in_ms=142.157
2017-12-03 22:25:03,445 [salt.state       ][INFO    ][21573] Running state [virt.set_autostart] at time 22:25:03.445145
2017-12-03 22:25:03,445 [salt.state       ][INFO    ][21573] Executing state module.run for virt.set_autostart
2017-12-03 22:25:03,448 [salt.loaded.int.module.cmdmod][INFO    ][21573] Executing command 'virsh list --autostart --name| grep -E "^prx01.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-12-03 22:25:03,463 [salt.state       ][INFO    ][21573] unless execution succeeded
2017-12-03 22:25:03,463 [salt.state       ][INFO    ][21573] Completed state [virt.set_autostart] at time 22:25:03.463050 duration_in_ms=17.904
2017-12-03 22:25:03,463 [salt.state       ][INFO    ][21573] Running state [virtng.init] at time 22:25:03.463314
2017-12-03 22:25:03,464 [salt.state       ][INFO    ][21573] Executing state module.run for virtng.init
2017-12-03 22:25:03,466 [salt.loaded.int.module.cmdmod][INFO    ][21573] Executing command 'virsh list --all --name| grep -E "^mdb01.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-12-03 22:25:03,482 [salt.state       ][INFO    ][21573] unless execution succeeded
2017-12-03 22:25:03,482 [salt.state       ][INFO    ][21573] Completed state [virtng.init] at time 22:25:03.481981 duration_in_ms=18.666
2017-12-03 22:25:03,482 [salt.state       ][INFO    ][21573] Running state [virt.set_autostart] at time 22:25:03.482238
2017-12-03 22:25:03,482 [salt.state       ][INFO    ][21573] Executing state module.run for virt.set_autostart
2017-12-03 22:25:03,485 [salt.loaded.int.module.cmdmod][INFO    ][21573] Executing command 'virsh list --autostart --name| grep -E "^mdb01.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-12-03 22:25:03,500 [salt.state       ][INFO    ][21573] unless execution succeeded
2017-12-03 22:25:03,500 [salt.state       ][INFO    ][21573] Completed state [virt.set_autostart] at time 22:25:03.500348 duration_in_ms=18.109
2017-12-03 22:25:03,501 [salt.state       ][INFO    ][21573] Running state [virtng.init] at time 22:25:03.500613
2017-12-03 22:25:03,501 [salt.state       ][INFO    ][21573] Executing state module.run for virtng.init
2017-12-03 22:25:03,504 [salt.loaded.int.module.cmdmod][INFO    ][21573] Executing command 'virsh list --all --name| grep -E "^ctl01.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-12-03 22:25:03,520 [salt.state       ][INFO    ][21573] unless execution succeeded
2017-12-03 22:25:03,520 [salt.state       ][INFO    ][21573] Completed state [virtng.init] at time 22:25:03.520396 duration_in_ms=19.782
2017-12-03 22:25:03,521 [salt.state       ][INFO    ][21573] Running state [virt.set_autostart] at time 22:25:03.520663
2017-12-03 22:25:03,521 [salt.state       ][INFO    ][21573] Executing state module.run for virt.set_autostart
2017-12-03 22:25:03,524 [salt.loaded.int.module.cmdmod][INFO    ][21573] Executing command 'virsh list --autostart --name| grep -E "^ctl01.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-12-03 22:25:03,538 [salt.state       ][INFO    ][21573] unless execution succeeded
2017-12-03 22:25:03,538 [salt.state       ][INFO    ][21573] Completed state [virt.set_autostart] at time 22:25:03.537876 duration_in_ms=17.212
2017-12-03 22:25:03,538 [salt.state       ][INFO    ][21573] Running state [virtng.init] at time 22:25:03.538141
2017-12-03 22:25:03,538 [salt.state       ][INFO    ][21573] Executing state module.run for virtng.init
2017-12-03 22:25:03,541 [salt.loaded.int.module.cmdmod][INFO    ][21573] Executing command 'virsh list --all --name| grep -E "^msg01.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-12-03 22:25:03,556 [salt.state       ][INFO    ][21573] unless execution succeeded
2017-12-03 22:25:03,556 [salt.state       ][INFO    ][21573] Completed state [virtng.init] at time 22:25:03.556087 duration_in_ms=17.946
2017-12-03 22:25:03,556 [salt.state       ][INFO    ][21573] Running state [virt.set_autostart] at time 22:25:03.556345
2017-12-03 22:25:03,557 [salt.state       ][INFO    ][21573] Executing state module.run for virt.set_autostart
2017-12-03 22:25:03,559 [salt.loaded.int.module.cmdmod][INFO    ][21573] Executing command 'virsh list --autostart --name| grep -E "^msg01.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-12-03 22:25:03,574 [salt.state       ][INFO    ][21573] unless execution succeeded
2017-12-03 22:25:03,574 [salt.state       ][INFO    ][21573] Completed state [virt.set_autostart] at time 22:25:03.574231 duration_in_ms=17.886
2017-12-03 22:25:03,575 [salt.state       ][INFO    ][21573] Running state [virtng.init] at time 22:25:03.574487
2017-12-03 22:25:03,575 [salt.state       ][INFO    ][21573] Executing state module.run for virtng.init
2017-12-03 22:25:03,577 [salt.loaded.int.module.cmdmod][INFO    ][21573] Executing command 'virsh list --all --name| grep -E "^dbs01.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-12-03 22:25:03,592 [salt.state       ][INFO    ][21573] unless execution succeeded
2017-12-03 22:25:03,593 [salt.state       ][INFO    ][21573] Completed state [virtng.init] at time 22:25:03.592514 duration_in_ms=18.027
2017-12-03 22:25:03,593 [salt.state       ][INFO    ][21573] Running state [virt.set_autostart] at time 22:25:03.592763
2017-12-03 22:25:03,593 [salt.state       ][INFO    ][21573] Executing state module.run for virt.set_autostart
2017-12-03 22:25:03,596 [salt.loaded.int.module.cmdmod][INFO    ][21573] Executing command 'virsh list --autostart --name| grep -E "^dbs01.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-12-03 22:25:03,611 [salt.state       ][INFO    ][21573] unless execution succeeded
2017-12-03 22:25:03,611 [salt.state       ][INFO    ][21573] Completed state [virt.set_autostart] at time 22:25:03.610955 duration_in_ms=18.192
2017-12-03 22:25:03,614 [salt.minion      ][INFO    ][21573] Returning information for job: 20171203222458060640
2017-12-03 22:25:05,313 [salt.minion      ][INFO    ][21276] User sudo_ubuntu Executing command pillar.get with jid 20171203222505304288
2017-12-03 22:25:05,325 [salt.minion      ][INFO    ][21667] Starting a new job with PID 21667
2017-12-03 22:25:05,328 [salt.minion      ][INFO    ][21667] Returning information for job: 20171203222505304288
2017-12-03 22:25:23,555 [salt.minion      ][INFO    ][21276] User sudo_ubuntu Executing command saltutil.sync_all with jid 20171203222523545684
2017-12-03 22:25:23,567 [salt.minion      ][INFO    ][21676] Starting a new job with PID 21676
2017-12-03 22:25:26,830 [salt.state       ][INFO    ][21676] Loading fresh modules for state activity
2017-12-03 22:25:26,856 [salt.state       ][ERROR   ][21676] No contents found in top file
2017-12-03 22:25:26,857 [salt.utils.extmods][INFO    ][21676] Creating module dir '/var/cache/salt/minion/extmods/beacons'
2017-12-03 22:25:26,860 [salt.utils.extmods][INFO    ][21676] Syncing beacons for environment 'base'
2017-12-03 22:25:26,860 [salt.utils.extmods][INFO    ][21676] Loading cache from salt://_beacons, for base)
2017-12-03 22:25:26,860 [salt.fileclient  ][INFO    ][21676] Caching directory '_beacons/' for environment 'base'
2017-12-03 22:25:26,910 [salt.utils.extmods][INFO    ][21676] Syncing modules for environment 'base'
2017-12-03 22:25:26,911 [salt.utils.extmods][INFO    ][21676] Loading cache from salt://_modules, for base)
2017-12-03 22:25:26,911 [salt.fileclient  ][INFO    ][21676] Caching directory '_modules/' for environment 'base'
2017-12-03 22:25:26,988 [salt.fileclient  ][INFO    ][21676] Fetching file from saltenv 'base', ** done ** '_modules/avinetworks.py'
2017-12-03 22:25:26,997 [salt.fileclient  ][INFO    ][21676] Fetching file from saltenv 'base', ** done ** '_modules/ceph_ng.py'
2017-12-03 22:25:27,007 [salt.fileclient  ][INFO    ][21676] Fetching file from saltenv 'base', ** done ** '_modules/cinderng.py'
2017-12-03 22:25:27,018 [salt.fileclient  ][INFO    ][21676] Fetching file from saltenv 'base', ** done ** '_modules/contrail.py'
2017-12-03 22:25:27,784 [salt.fileclient  ][INFO    ][21676] Fetching file from saltenv 'base', ** done ** '_modules/creds.py'
2017-12-03 22:25:28,051 [salt.fileclient  ][INFO    ][21676] Fetching file from saltenv 'base', ** done ** '_modules/devops_utils.py'
2017-12-03 22:25:28,071 [salt.fileclient  ][INFO    ][21676] Fetching file from saltenv 'base', ** done ** '_modules/encode_json.py'
2017-12-03 22:25:28,118 [salt.fileclient  ][INFO    ][21676] Fetching file from saltenv 'base', ** done ** '_modules/gerrit.py'
2017-12-03 22:25:28,137 [salt.fileclient  ][INFO    ][21676] Fetching file from saltenv 'base', ** done ** '_modules/glanceng.py'
2017-12-03 22:25:28,147 [salt.fileclient  ][INFO    ][21676] Fetching file from saltenv 'base', ** done ** '_modules/heat.py'
2017-12-03 22:25:28,575 [salt.fileclient  ][INFO    ][21676] Fetching file from saltenv 'base', ** done ** '_modules/heka_alarming.py'
2017-12-03 22:25:28,587 [salt.fileclient  ][INFO    ][21676] Fetching file from saltenv 'base', ** done ** '_modules/helm.py'
2017-12-03 22:25:28,600 [salt.fileclient  ][INFO    ][21676] Fetching file from saltenv 'base', ** done ** '_modules/jenkins_common.py'
2017-12-03 22:25:28,623 [salt.fileclient  ][INFO    ][21676] Fetching file from saltenv 'base', ** done ** '_modules/keystone_policy.py'
2017-12-03 22:25:28,640 [salt.fileclient  ][INFO    ][21676] Fetching file from saltenv 'base', ** done ** '_modules/linux_hosts.py'
2017-12-03 22:25:28,659 [salt.fileclient  ][INFO    ][21676] Fetching file from saltenv 'base', ** done ** '_modules/linux_netlink.py'
2017-12-03 22:25:28,679 [salt.fileclient  ][INFO    ][21676] Fetching file from saltenv 'base', ** done ** '_modules/maas.py'
2017-12-03 22:25:28,692 [salt.fileclient  ][INFO    ][21676] Fetching file from saltenv 'base', ** done ** '_modules/maas_client.py'
2017-12-03 22:25:28,703 [salt.fileclient  ][INFO    ][21676] Fetching file from saltenv 'base', ** done ** '_modules/modelutils.py'
2017-12-03 22:25:28,717 [salt.fileclient  ][INFO    ][21676] Fetching file from saltenv 'base', ** done ** '_modules/multipart.py'
2017-12-03 22:25:28,732 [salt.fileclient  ][INFO    ][21676] Fetching file from saltenv 'base', ** done ** '_modules/nagios_alarming.py'
2017-12-03 22:25:28,769 [salt.fileclient  ][INFO    ][21676] Fetching file from saltenv 'base', ** done ** '_modules/neutronng.py'
2017-12-03 22:25:28,790 [salt.fileclient  ][INFO    ][21676] Fetching file from saltenv 'base', ** done ** '_modules/novang.py'
2017-12-03 22:25:28,808 [salt.fileclient  ][INFO    ][21676] Fetching file from saltenv 'base', ** done ** '_modules/reclass.py'
2017-12-03 22:25:28,820 [salt.fileclient  ][INFO    ][21676] Fetching file from saltenv 'base', ** done ** '_modules/rsyslog_util.py'
2017-12-03 22:25:28,835 [salt.fileclient  ][INFO    ][21676] Fetching file from saltenv 'base', ** done ** '_modules/rundeck.py'
2017-12-03 22:25:28,846 [salt.fileclient  ][INFO    ][21676] Fetching file from saltenv 'base', ** done ** '_modules/saltkey.py'
2017-12-03 22:25:28,857 [salt.fileclient  ][INFO    ][21676] Fetching file from saltenv 'base', ** done ** '_modules/saltresource.py'
2017-12-03 22:25:28,875 [salt.fileclient  ][INFO    ][21676] Fetching file from saltenv 'base', ** done ** '_modules/seedng.py'
2017-12-03 22:25:28,923 [salt.fileclient  ][INFO    ][21676] Fetching file from saltenv 'base', ** done ** '_modules/testing/credentials.py'
2017-12-03 22:25:28,940 [salt.fileclient  ][INFO    ][21676] Fetching file from saltenv 'base', ** done ** '_modules/testing/django.py'
2017-12-03 22:25:28,958 [salt.fileclient  ][INFO    ][21676] Fetching file from saltenv 'base', ** done ** '_modules/testing/django_client_proxy.py'
2017-12-03 22:25:28,970 [salt.fileclient  ][INFO    ][21676] Fetching file from saltenv 'base', ** done ** '_modules/utils.py'
2017-12-03 22:25:28,990 [salt.fileclient  ][INFO    ][21676] Fetching file from saltenv 'base', ** done ** '_modules/virtng.py'
2017-12-03 22:25:28,994 [salt.utils.extmods][INFO    ][21676] Copying '/var/cache/salt/minion/files/base/_modules/__init__.py' to '/var/cache/salt/minion/extmods/modules/__init__.py'
2017-12-03 22:25:28,995 [salt.utils.extmods][INFO    ][21676] Copying '/var/cache/salt/minion/files/base/_modules/avinetworks.py' to '/var/cache/salt/minion/extmods/modules/avinetworks.py'
2017-12-03 22:25:28,995 [salt.utils.extmods][INFO    ][21676] Copying '/var/cache/salt/minion/files/base/_modules/ceph_ng.py' to '/var/cache/salt/minion/extmods/modules/ceph_ng.py'
2017-12-03 22:25:28,995 [salt.utils.extmods][INFO    ][21676] Copying '/var/cache/salt/minion/files/base/_modules/cinderng.py' to '/var/cache/salt/minion/extmods/modules/cinderng.py'
2017-12-03 22:25:28,996 [salt.utils.extmods][INFO    ][21676] Copying '/var/cache/salt/minion/files/base/_modules/contrail.py' to '/var/cache/salt/minion/extmods/modules/contrail.py'
2017-12-03 22:25:28,996 [salt.utils.extmods][INFO    ][21676] Copying '/var/cache/salt/minion/files/base/_modules/creds.py' to '/var/cache/salt/minion/extmods/modules/creds.py'
2017-12-03 22:25:28,996 [salt.utils.extmods][INFO    ][21676] Copying '/var/cache/salt/minion/files/base/_modules/devops_utils.py' to '/var/cache/salt/minion/extmods/modules/devops_utils.py'
2017-12-03 22:25:28,997 [salt.utils.extmods][INFO    ][21676] Copying '/var/cache/salt/minion/files/base/_modules/encode_json.py' to '/var/cache/salt/minion/extmods/modules/encode_json.py'
2017-12-03 22:25:28,997 [salt.utils.extmods][INFO    ][21676] Copying '/var/cache/salt/minion/files/base/_modules/gerrit.py' to '/var/cache/salt/minion/extmods/modules/gerrit.py'
2017-12-03 22:25:28,997 [salt.utils.extmods][INFO    ][21676] Copying '/var/cache/salt/minion/files/base/_modules/glanceng.py' to '/var/cache/salt/minion/extmods/modules/glanceng.py'
2017-12-03 22:25:28,997 [salt.utils.extmods][INFO    ][21676] Copying '/var/cache/salt/minion/files/base/_modules/heat.py' to '/var/cache/salt/minion/extmods/modules/heat.py'
2017-12-03 22:25:28,998 [salt.utils.extmods][INFO    ][21676] Copying '/var/cache/salt/minion/files/base/_modules/heka_alarming.py' to '/var/cache/salt/minion/extmods/modules/heka_alarming.py'
2017-12-03 22:25:28,998 [salt.utils.extmods][INFO    ][21676] Copying '/var/cache/salt/minion/files/base/_modules/helm.py' to '/var/cache/salt/minion/extmods/modules/helm.py'
2017-12-03 22:25:28,998 [salt.utils.extmods][INFO    ][21676] Copying '/var/cache/salt/minion/files/base/_modules/jenkins_common.py' to '/var/cache/salt/minion/extmods/modules/jenkins_common.py'
2017-12-03 22:25:28,998 [salt.utils.extmods][INFO    ][21676] Copying '/var/cache/salt/minion/files/base/_modules/keystone_policy.py' to '/var/cache/salt/minion/extmods/modules/keystone_policy.py'
2017-12-03 22:25:28,999 [salt.utils.extmods][INFO    ][21676] Copying '/var/cache/salt/minion/files/base/_modules/linux_hosts.py' to '/var/cache/salt/minion/extmods/modules/linux_hosts.py'
2017-12-03 22:25:28,999 [salt.utils.extmods][INFO    ][21676] Copying '/var/cache/salt/minion/files/base/_modules/linux_netlink.py' to '/var/cache/salt/minion/extmods/modules/linux_netlink.py'
2017-12-03 22:25:28,999 [salt.utils.extmods][INFO    ][21676] Copying '/var/cache/salt/minion/files/base/_modules/maas.py' to '/var/cache/salt/minion/extmods/modules/maas.py'
2017-12-03 22:25:28,1000 [salt.utils.extmods][INFO    ][21676] Copying '/var/cache/salt/minion/files/base/_modules/maas_client.py' to '/var/cache/salt/minion/extmods/modules/maas_client.py'
2017-12-03 22:25:28,1000 [salt.utils.extmods][INFO    ][21676] Copying '/var/cache/salt/minion/files/base/_modules/modelutils.py' to '/var/cache/salt/minion/extmods/modules/modelutils.py'
2017-12-03 22:25:29,000 [salt.utils.extmods][INFO    ][21676] Copying '/var/cache/salt/minion/files/base/_modules/multipart.py' to '/var/cache/salt/minion/extmods/modules/multipart.py'
2017-12-03 22:25:29,000 [salt.utils.extmods][INFO    ][21676] Copying '/var/cache/salt/minion/files/base/_modules/nagios_alarming.py' to '/var/cache/salt/minion/extmods/modules/nagios_alarming.py'
2017-12-03 22:25:29,001 [salt.utils.extmods][INFO    ][21676] Copying '/var/cache/salt/minion/files/base/_modules/neutronng.py' to '/var/cache/salt/minion/extmods/modules/neutronng.py'
2017-12-03 22:25:29,001 [salt.utils.extmods][INFO    ][21676] Copying '/var/cache/salt/minion/files/base/_modules/novang.py' to '/var/cache/salt/minion/extmods/modules/novang.py'
2017-12-03 22:25:29,001 [salt.utils.extmods][INFO    ][21676] Copying '/var/cache/salt/minion/files/base/_modules/reclass.py' to '/var/cache/salt/minion/extmods/modules/reclass.py'
2017-12-03 22:25:29,002 [salt.utils.extmods][INFO    ][21676] Copying '/var/cache/salt/minion/files/base/_modules/rsyslog_util.py' to '/var/cache/salt/minion/extmods/modules/rsyslog_util.py'
2017-12-03 22:25:29,002 [salt.utils.extmods][INFO    ][21676] Copying '/var/cache/salt/minion/files/base/_modules/rundeck.py' to '/var/cache/salt/minion/extmods/modules/rundeck.py'
2017-12-03 22:25:29,002 [salt.utils.extmods][INFO    ][21676] Copying '/var/cache/salt/minion/files/base/_modules/saltkey.py' to '/var/cache/salt/minion/extmods/modules/saltkey.py'
2017-12-03 22:25:29,003 [salt.utils.extmods][INFO    ][21676] Copying '/var/cache/salt/minion/files/base/_modules/saltresource.py' to '/var/cache/salt/minion/extmods/modules/saltresource.py'
2017-12-03 22:25:29,003 [salt.utils.extmods][INFO    ][21676] Copying '/var/cache/salt/minion/files/base/_modules/seedng.py' to '/var/cache/salt/minion/extmods/modules/seedng.py'
2017-12-03 22:25:29,003 [salt.utils.extmods][INFO    ][21676] Copying '/var/cache/salt/minion/files/base/_modules/testing/__init__.py' to '/var/cache/salt/minion/extmods/modules/testing/__init__.py'
2017-12-03 22:25:29,003 [salt.utils.extmods][INFO    ][21676] Copying '/var/cache/salt/minion/files/base/_modules/testing/credentials.py' to '/var/cache/salt/minion/extmods/modules/testing/credentials.py'
2017-12-03 22:25:29,004 [salt.utils.extmods][INFO    ][21676] Copying '/var/cache/salt/minion/files/base/_modules/testing/django.py' to '/var/cache/salt/minion/extmods/modules/testing/django.py'
2017-12-03 22:25:29,004 [salt.utils.extmods][INFO    ][21676] 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-12-03 22:25:29,004 [salt.utils.extmods][INFO    ][21676] Copying '/var/cache/salt/minion/files/base/_modules/utils.py' to '/var/cache/salt/minion/extmods/modules/utils.py'
2017-12-03 22:25:29,004 [salt.utils.extmods][INFO    ][21676] Copying '/var/cache/salt/minion/files/base/_modules/virtng.py' to '/var/cache/salt/minion/extmods/modules/virtng.py'
2017-12-03 22:25:29,010 [salt.utils.extmods][INFO    ][21676] Syncing states for environment 'base'
2017-12-03 22:25:29,010 [salt.utils.extmods][INFO    ][21676] Loading cache from salt://_states, for base)
2017-12-03 22:25:29,010 [salt.fileclient  ][INFO    ][21676] Caching directory '_states/' for environment 'base'
2017-12-03 22:25:29,064 [salt.fileclient  ][INFO    ][21676] Fetching file from saltenv 'base', ** done ** '_states/avinetworks.py'
2017-12-03 22:25:29,080 [salt.fileclient  ][INFO    ][21676] Fetching file from saltenv 'base', ** done ** '_states/cinderng.py'
2017-12-03 22:25:29,092 [salt.fileclient  ][INFO    ][21676] Fetching file from saltenv 'base', ** done ** '_states/contrail.py'
2017-12-03 22:25:29,101 [salt.fileclient  ][INFO    ][21676] Fetching file from saltenv 'base', ** done ** '_states/gerrit.py'
2017-12-03 22:25:29,124 [salt.fileclient  ][INFO    ][21676] Fetching file from saltenv 'base', ** done ** '_states/glanceng.py'
2017-12-03 22:25:29,132 [salt.fileclient  ][INFO    ][21676] Fetching file from saltenv 'base', ** done ** '_states/grafana3_dashboard.py'
2017-12-03 22:25:29,142 [salt.fileclient  ][INFO    ][21676] Fetching file from saltenv 'base', ** done ** '_states/grafana3_datasource.py'
2017-12-03 22:25:29,215 [salt.fileclient  ][INFO    ][21676] Fetching file from saltenv 'base', ** done ** '_states/heat.py'
2017-12-03 22:25:29,227 [salt.fileclient  ][INFO    ][21676] Fetching file from saltenv 'base', ** done ** '_states/helm_release.py'
2017-12-03 22:25:29,241 [salt.fileclient  ][INFO    ][21676] Fetching file from saltenv 'base', ** done ** '_states/helm_repos.py'
2017-12-03 22:25:29,260 [salt.fileclient  ][INFO    ][21676] Fetching file from saltenv 'base', ** done ** '_states/jenkins_approval.py'
2017-12-03 22:25:29,277 [salt.fileclient  ][INFO    ][21676] Fetching file from saltenv 'base', ** done ** '_states/jenkins_artifactory.py'
2017-12-03 22:25:29,285 [salt.fileclient  ][INFO    ][21676] Fetching file from saltenv 'base', ** done ** '_states/jenkins_credential.py'
2017-12-03 22:25:29,304 [salt.fileclient  ][INFO    ][21676] Fetching file from saltenv 'base', ** done ** '_states/jenkins_globalenvprop.py'
2017-12-03 22:25:29,322 [salt.fileclient  ][INFO    ][21676] Fetching file from saltenv 'base', ** done ** '_states/jenkins_job.py'
2017-12-03 22:25:29,348 [salt.fileclient  ][INFO    ][21676] Fetching file from saltenv 'base', ** done ** '_states/jenkins_lib.py'
2017-12-03 22:25:29,370 [salt.fileclient  ][INFO    ][21676] Fetching file from saltenv 'base', ** done ** '_states/jenkins_node.py'
2017-12-03 22:25:29,384 [salt.fileclient  ][INFO    ][21676] Fetching file from saltenv 'base', ** done ** '_states/jenkins_plugin.py'
2017-12-03 22:25:29,399 [salt.fileclient  ][INFO    ][21676] Fetching file from saltenv 'base', ** done ** '_states/jenkins_security.py'
2017-12-03 22:25:29,424 [salt.fileclient  ][INFO    ][21676] Fetching file from saltenv 'base', ** done ** '_states/jenkins_slack.py'
2017-12-03 22:25:29,436 [salt.fileclient  ][INFO    ][21676] Fetching file from saltenv 'base', ** done ** '_states/jenkins_smtp.py'
2017-12-03 22:25:29,482 [salt.fileclient  ][INFO    ][21676] Fetching file from saltenv 'base', ** done ** '_states/jenkins_theme.py'
2017-12-03 22:25:29,503 [salt.fileclient  ][INFO    ][21676] Fetching file from saltenv 'base', ** done ** '_states/jenkins_user.py'
2017-12-03 22:25:29,516 [salt.fileclient  ][INFO    ][21676] Fetching file from saltenv 'base', ** done ** '_states/jenkins_view.py'
2017-12-03 22:25:29,532 [salt.fileclient  ][INFO    ][21676] Fetching file from saltenv 'base', ** done ** '_states/keystone_policy.py'
2017-12-03 22:25:29,557 [salt.fileclient  ][INFO    ][21676] Fetching file from saltenv 'base', ** done ** '_states/kibana_object.py'
2017-12-03 22:25:29,582 [salt.fileclient  ][INFO    ][21676] Fetching file from saltenv 'base', ** done ** '_states/neutronng.py'
2017-12-03 22:25:29,594 [salt.fileclient  ][INFO    ][21676] Fetching file from saltenv 'base', ** done ** '_states/novang.py'
2017-12-03 22:25:29,606 [salt.fileclient  ][INFO    ][21676] Fetching file from saltenv 'base', ** done ** '_states/reclass.py'
2017-12-03 22:25:29,619 [salt.fileclient  ][INFO    ][21676] Fetching file from saltenv 'base', ** done ** '_states/rundeck_project.py'
2017-12-03 22:25:29,634 [salt.fileclient  ][INFO    ][21676] Fetching file from saltenv 'base', ** done ** '_states/rundeck_scm.py'
2017-12-03 22:25:29,655 [salt.fileclient  ][INFO    ][21676] Fetching file from saltenv 'base', ** done ** '_states/rundeck_secret.py'
2017-12-03 22:25:29,660 [salt.utils.extmods][INFO    ][21676] Copying '/var/cache/salt/minion/files/base/_states/avinetworks.py' to '/var/cache/salt/minion/extmods/states/avinetworks.py'
2017-12-03 22:25:29,660 [salt.utils.extmods][INFO    ][21676] Copying '/var/cache/salt/minion/files/base/_states/cinderng.py' to '/var/cache/salt/minion/extmods/states/cinderng.py'
2017-12-03 22:25:29,660 [salt.utils.extmods][INFO    ][21676] Copying '/var/cache/salt/minion/files/base/_states/contrail.py' to '/var/cache/salt/minion/extmods/states/contrail.py'
2017-12-03 22:25:29,661 [salt.utils.extmods][INFO    ][21676] Copying '/var/cache/salt/minion/files/base/_states/gerrit.py' to '/var/cache/salt/minion/extmods/states/gerrit.py'
2017-12-03 22:25:29,661 [salt.utils.extmods][INFO    ][21676] Copying '/var/cache/salt/minion/files/base/_states/glanceng.py' to '/var/cache/salt/minion/extmods/states/glanceng.py'
2017-12-03 22:25:29,661 [salt.utils.extmods][INFO    ][21676] Copying '/var/cache/salt/minion/files/base/_states/grafana3_dashboard.py' to '/var/cache/salt/minion/extmods/states/grafana3_dashboard.py'
2017-12-03 22:25:29,661 [salt.utils.extmods][INFO    ][21676] Copying '/var/cache/salt/minion/files/base/_states/grafana3_datasource.py' to '/var/cache/salt/minion/extmods/states/grafana3_datasource.py'
2017-12-03 22:25:29,662 [salt.utils.extmods][INFO    ][21676] Copying '/var/cache/salt/minion/files/base/_states/heat.py' to '/var/cache/salt/minion/extmods/states/heat.py'
2017-12-03 22:25:29,662 [salt.utils.extmods][INFO    ][21676] Copying '/var/cache/salt/minion/files/base/_states/helm_release.py' to '/var/cache/salt/minion/extmods/states/helm_release.py'
2017-12-03 22:25:29,662 [salt.utils.extmods][INFO    ][21676] Copying '/var/cache/salt/minion/files/base/_states/helm_repos.py' to '/var/cache/salt/minion/extmods/states/helm_repos.py'
2017-12-03 22:25:29,663 [salt.utils.extmods][INFO    ][21676] Copying '/var/cache/salt/minion/files/base/_states/jenkins_approval.py' to '/var/cache/salt/minion/extmods/states/jenkins_approval.py'
2017-12-03 22:25:29,663 [salt.utils.extmods][INFO    ][21676] Copying '/var/cache/salt/minion/files/base/_states/jenkins_artifactory.py' to '/var/cache/salt/minion/extmods/states/jenkins_artifactory.py'
2017-12-03 22:25:29,663 [salt.utils.extmods][INFO    ][21676] Copying '/var/cache/salt/minion/files/base/_states/jenkins_credential.py' to '/var/cache/salt/minion/extmods/states/jenkins_credential.py'
2017-12-03 22:25:29,663 [salt.utils.extmods][INFO    ][21676] Copying '/var/cache/salt/minion/files/base/_states/jenkins_globalenvprop.py' to '/var/cache/salt/minion/extmods/states/jenkins_globalenvprop.py'
2017-12-03 22:25:29,664 [salt.utils.extmods][INFO    ][21676] Copying '/var/cache/salt/minion/files/base/_states/jenkins_job.py' to '/var/cache/salt/minion/extmods/states/jenkins_job.py'
2017-12-03 22:25:29,664 [salt.utils.extmods][INFO    ][21676] Copying '/var/cache/salt/minion/files/base/_states/jenkins_lib.py' to '/var/cache/salt/minion/extmods/states/jenkins_lib.py'
2017-12-03 22:25:29,664 [salt.utils.extmods][INFO    ][21676] Copying '/var/cache/salt/minion/files/base/_states/jenkins_node.py' to '/var/cache/salt/minion/extmods/states/jenkins_node.py'
2017-12-03 22:25:29,664 [salt.utils.extmods][INFO    ][21676] Copying '/var/cache/salt/minion/files/base/_states/jenkins_plugin.py' to '/var/cache/salt/minion/extmods/states/jenkins_plugin.py'
2017-12-03 22:25:29,665 [salt.utils.extmods][INFO    ][21676] Copying '/var/cache/salt/minion/files/base/_states/jenkins_security.py' to '/var/cache/salt/minion/extmods/states/jenkins_security.py'
2017-12-03 22:25:29,665 [salt.utils.extmods][INFO    ][21676] Copying '/var/cache/salt/minion/files/base/_states/jenkins_slack.py' to '/var/cache/salt/minion/extmods/states/jenkins_slack.py'
2017-12-03 22:25:29,665 [salt.utils.extmods][INFO    ][21676] Copying '/var/cache/salt/minion/files/base/_states/jenkins_smtp.py' to '/var/cache/salt/minion/extmods/states/jenkins_smtp.py'
2017-12-03 22:25:29,665 [salt.utils.extmods][INFO    ][21676] Copying '/var/cache/salt/minion/files/base/_states/jenkins_theme.py' to '/var/cache/salt/minion/extmods/states/jenkins_theme.py'
2017-12-03 22:25:29,666 [salt.utils.extmods][INFO    ][21676] Copying '/var/cache/salt/minion/files/base/_states/jenkins_user.py' to '/var/cache/salt/minion/extmods/states/jenkins_user.py'
2017-12-03 22:25:29,666 [salt.utils.extmods][INFO    ][21676] Copying '/var/cache/salt/minion/files/base/_states/jenkins_view.py' to '/var/cache/salt/minion/extmods/states/jenkins_view.py'
2017-12-03 22:25:29,666 [salt.utils.extmods][INFO    ][21676] Copying '/var/cache/salt/minion/files/base/_states/keystone_policy.py' to '/var/cache/salt/minion/extmods/states/keystone_policy.py'
2017-12-03 22:25:29,666 [salt.utils.extmods][INFO    ][21676] Copying '/var/cache/salt/minion/files/base/_states/kibana_object.py' to '/var/cache/salt/minion/extmods/states/kibana_object.py'
2017-12-03 22:25:29,667 [salt.utils.extmods][INFO    ][21676] Copying '/var/cache/salt/minion/files/base/_states/maas_cluster.py' to '/var/cache/salt/minion/extmods/states/maas_cluster.py'
2017-12-03 22:25:29,667 [salt.utils.extmods][INFO    ][21676] Copying '/var/cache/salt/minion/files/base/_states/neutronng.py' to '/var/cache/salt/minion/extmods/states/neutronng.py'
2017-12-03 22:25:29,667 [salt.utils.extmods][INFO    ][21676] Copying '/var/cache/salt/minion/files/base/_states/novang.py' to '/var/cache/salt/minion/extmods/states/novang.py'
2017-12-03 22:25:29,668 [salt.utils.extmods][INFO    ][21676] Copying '/var/cache/salt/minion/files/base/_states/reclass.py' to '/var/cache/salt/minion/extmods/states/reclass.py'
2017-12-03 22:25:29,668 [salt.utils.extmods][INFO    ][21676] Copying '/var/cache/salt/minion/files/base/_states/rundeck_project.py' to '/var/cache/salt/minion/extmods/states/rundeck_project.py'
2017-12-03 22:25:29,668 [salt.utils.extmods][INFO    ][21676] Copying '/var/cache/salt/minion/files/base/_states/rundeck_scm.py' to '/var/cache/salt/minion/extmods/states/rundeck_scm.py'
2017-12-03 22:25:29,668 [salt.utils.extmods][INFO    ][21676] Copying '/var/cache/salt/minion/files/base/_states/rundeck_secret.py' to '/var/cache/salt/minion/extmods/states/rundeck_secret.py'
2017-12-03 22:25:29,671 [salt.utils.extmods][INFO    ][21676] Creating module dir '/var/cache/salt/minion/extmods/sdb'
2017-12-03 22:25:29,674 [salt.utils.extmods][INFO    ][21676] Syncing sdb for environment 'base'
2017-12-03 22:25:29,674 [salt.utils.extmods][INFO    ][21676] Loading cache from salt://_sdb, for base)
2017-12-03 22:25:29,674 [salt.fileclient  ][INFO    ][21676] Caching directory '_sdb/' for environment 'base'
2017-12-03 22:25:29,744 [salt.utils.extmods][INFO    ][21676] Syncing grains for environment 'base'
2017-12-03 22:25:29,744 [salt.utils.extmods][INFO    ][21676] Loading cache from salt://_grains, for base)
2017-12-03 22:25:29,744 [salt.fileclient  ][INFO    ][21676] Caching directory '_grains/' for environment 'base'
2017-12-03 22:25:29,795 [salt.fileclient  ][INFO    ][21676] Fetching file from saltenv 'base', ** done ** '_grains/ceilometer_policy.py'
2017-12-03 22:25:29,817 [salt.fileclient  ][INFO    ][21676] Fetching file from saltenv 'base', ** done ** '_grains/ceph.py'
2017-12-03 22:25:29,838 [salt.fileclient  ][INFO    ][21676] Fetching file from saltenv 'base', ** done ** '_grains/cinder_policy.py'
2017-12-03 22:25:29,851 [salt.fileclient  ][INFO    ][21676] Fetching file from saltenv 'base', ** done ** '_grains/docker_swarm.py'
2017-12-03 22:25:29,880 [salt.fileclient  ][INFO    ][21676] Fetching file from saltenv 'base', ** done ** '_grains/glance_policy.py'
2017-12-03 22:25:29,900 [salt.fileclient  ][INFO    ][21676] Fetching file from saltenv 'base', ** done ** '_grains/heat_policy.py'
2017-12-03 22:25:29,911 [salt.fileclient  ][INFO    ][21676] Fetching file from saltenv 'base', ** done ** '_grains/jenkins_plugins.py'
2017-12-03 22:25:29,927 [salt.fileclient  ][INFO    ][21676] Fetching file from saltenv 'base', ** done ** '_grains/keystone_policy.py'
2017-12-03 22:25:30,004 [salt.fileclient  ][INFO    ][21676] Fetching file from saltenv 'base', ** done ** '_grains/kubernetes.py'
2017-12-03 22:25:30,103 [salt.fileclient  ][INFO    ][21676] Fetching file from saltenv 'base', ** done ** '_grains/neutron_policy.py'
2017-12-03 22:25:30,132 [salt.fileclient  ][INFO    ][21676] Fetching file from saltenv 'base', ** done ** '_grains/nova_policy.py'
2017-12-03 22:25:30,143 [salt.fileclient  ][INFO    ][21676] Fetching file from saltenv 'base', ** done ** '_grains/ssh_fingerprints.py'
2017-12-03 22:25:30,148 [salt.utils.extmods][INFO    ][21676] Copying '/var/cache/salt/minion/files/base/_grains/ceilometer_policy.py' to '/var/cache/salt/minion/extmods/grains/ceilometer_policy.py'
2017-12-03 22:25:30,148 [salt.utils.extmods][INFO    ][21676] Copying '/var/cache/salt/minion/files/base/_grains/ceph.py' to '/var/cache/salt/minion/extmods/grains/ceph.py'
2017-12-03 22:25:30,149 [salt.utils.extmods][INFO    ][21676] Copying '/var/cache/salt/minion/files/base/_grains/cinder_policy.py' to '/var/cache/salt/minion/extmods/grains/cinder_policy.py'
2017-12-03 22:25:30,149 [salt.utils.extmods][INFO    ][21676] Copying '/var/cache/salt/minion/files/base/_grains/docker_swarm.py' to '/var/cache/salt/minion/extmods/grains/docker_swarm.py'
2017-12-03 22:25:30,149 [salt.utils.extmods][INFO    ][21676] Copying '/var/cache/salt/minion/files/base/_grains/glance_policy.py' to '/var/cache/salt/minion/extmods/grains/glance_policy.py'
2017-12-03 22:25:30,149 [salt.utils.extmods][INFO    ][21676] Copying '/var/cache/salt/minion/files/base/_grains/heat_policy.py' to '/var/cache/salt/minion/extmods/grains/heat_policy.py'
2017-12-03 22:25:30,150 [salt.utils.extmods][INFO    ][21676] Copying '/var/cache/salt/minion/files/base/_grains/jenkins_plugins.py' to '/var/cache/salt/minion/extmods/grains/jenkins_plugins.py'
2017-12-03 22:25:30,150 [salt.utils.extmods][INFO    ][21676] Copying '/var/cache/salt/minion/files/base/_grains/keystone_policy.py' to '/var/cache/salt/minion/extmods/grains/keystone_policy.py'
2017-12-03 22:25:30,150 [salt.utils.extmods][INFO    ][21676] Copying '/var/cache/salt/minion/files/base/_grains/kubernetes.py' to '/var/cache/salt/minion/extmods/grains/kubernetes.py'
2017-12-03 22:25:30,150 [salt.utils.extmods][INFO    ][21676] Copying '/var/cache/salt/minion/files/base/_grains/neutron_policy.py' to '/var/cache/salt/minion/extmods/grains/neutron_policy.py'
2017-12-03 22:25:30,151 [salt.utils.extmods][INFO    ][21676] Copying '/var/cache/salt/minion/files/base/_grains/nova_policy.py' to '/var/cache/salt/minion/extmods/grains/nova_policy.py'
2017-12-03 22:25:30,151 [salt.utils.extmods][INFO    ][21676] Copying '/var/cache/salt/minion/files/base/_grains/ssh_fingerprints.py' to '/var/cache/salt/minion/extmods/grains/ssh_fingerprints.py'
2017-12-03 22:25:30,152 [salt.utils.extmods][INFO    ][21676] Creating module dir '/var/cache/salt/minion/extmods/renderers'
2017-12-03 22:25:30,155 [salt.utils.extmods][INFO    ][21676] Syncing renderers for environment 'base'
2017-12-03 22:25:30,155 [salt.utils.extmods][INFO    ][21676] Loading cache from salt://_renderers, for base)
2017-12-03 22:25:30,155 [salt.fileclient  ][INFO    ][21676] Caching directory '_renderers/' for environment 'base'
2017-12-03 22:25:30,195 [salt.utils.extmods][INFO    ][21676] Creating module dir '/var/cache/salt/minion/extmods/returners'
2017-12-03 22:25:30,198 [salt.utils.extmods][INFO    ][21676] Syncing returners for environment 'base'
2017-12-03 22:25:30,198 [salt.utils.extmods][INFO    ][21676] Loading cache from salt://_returners, for base)
2017-12-03 22:25:30,198 [salt.fileclient  ][INFO    ][21676] Caching directory '_returners/' for environment 'base'
2017-12-03 22:25:30,283 [salt.utils.extmods][INFO    ][21676] Creating module dir '/var/cache/salt/minion/extmods/output'
2017-12-03 22:25:30,286 [salt.utils.extmods][INFO    ][21676] Syncing output for environment 'base'
2017-12-03 22:25:30,286 [salt.utils.extmods][INFO    ][21676] Loading cache from salt://_output, for base)
2017-12-03 22:25:30,286 [salt.fileclient  ][INFO    ][21676] Caching directory '_output/' for environment 'base'
2017-12-03 22:25:30,330 [salt.utils.extmods][INFO    ][21676] Creating module dir '/var/cache/salt/minion/extmods/utils'
2017-12-03 22:25:30,333 [salt.utils.extmods][INFO    ][21676] Syncing utils for environment 'base'
2017-12-03 22:25:30,333 [salt.utils.extmods][INFO    ][21676] Loading cache from salt://_utils, for base)
2017-12-03 22:25:30,333 [salt.fileclient  ][INFO    ][21676] Caching directory '_utils/' for environment 'base'
2017-12-03 22:25:30,367 [salt.utils.extmods][INFO    ][21676] Creating module dir '/var/cache/salt/minion/extmods/log_handlers'
2017-12-03 22:25:30,369 [salt.utils.extmods][INFO    ][21676] Syncing log_handlers for environment 'base'
2017-12-03 22:25:30,369 [salt.utils.extmods][INFO    ][21676] Loading cache from salt://_log_handlers, for base)
2017-12-03 22:25:30,370 [salt.fileclient  ][INFO    ][21676] Caching directory '_log_handlers/' for environment 'base'
2017-12-03 22:25:30,405 [salt.utils.extmods][INFO    ][21676] Creating module dir '/var/cache/salt/minion/extmods/proxy'
2017-12-03 22:25:30,408 [salt.utils.extmods][INFO    ][21676] Syncing proxy for environment 'base'
2017-12-03 22:25:30,408 [salt.utils.extmods][INFO    ][21676] Loading cache from salt://_proxy, for base)
2017-12-03 22:25:30,408 [salt.fileclient  ][INFO    ][21676] Caching directory '_proxy/' for environment 'base'
2017-12-03 22:25:30,454 [salt.utils.extmods][INFO    ][21676] Creating module dir '/var/cache/salt/minion/extmods/engines'
2017-12-03 22:25:30,457 [salt.utils.extmods][INFO    ][21676] Syncing engines for environment 'base'
2017-12-03 22:25:30,457 [salt.utils.extmods][INFO    ][21676] Loading cache from salt://_engines, for base)
2017-12-03 22:25:30,458 [salt.fileclient  ][INFO    ][21676] Caching directory '_engines/' for environment 'base'
2017-12-03 22:25:30,538 [salt.minion      ][INFO    ][21676] Returning information for job: 20171203222523545684
2017-12-03 22:33:00,492 [salt.minion      ][INFO    ][21276] User sudo_ubuntu Executing command test.ping with jid 20171203223300483255
2017-12-03 22:33:00,510 [salt.minion      ][INFO    ][21826] Starting a new job with PID 21826
2017-12-03 22:33:00,550 [salt.minion      ][INFO    ][21826] Returning information for job: 20171203223300483255
2017-12-03 22:34:43,639 [salt.minion      ][INFO    ][21276] User sudo_ubuntu Executing command state.sls with jid 20171203223443629000
2017-12-03 22:34:43,653 [salt.minion      ][INFO    ][21862] Starting a new job with PID 21862
2017-12-03 22:34:44,255 [salt.state       ][INFO    ][21862] Loading fresh modules for state activity
2017-12-03 22:34:44,287 [salt.fileclient  ][INFO    ][21862] Fetching file from saltenv 'base', ** done ** 'keepalived/init.sls'
2017-12-03 22:34:44,309 [salt.fileclient  ][INFO    ][21862] Fetching file from saltenv 'base', ** done ** 'keepalived/cluster.sls'
2017-12-03 22:34:44,338 [salt.fileclient  ][INFO    ][21862] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-12-03 22:34:44,675 [salt.state       ][INFO    ][21862] Running state [lsof] at time 22:34:44.674915
2017-12-03 22:34:44,675 [salt.state       ][INFO    ][21862] Executing state pkg.installed for lsof
2017-12-03 22:34:44,676 [salt.loaded.int.module.cmdmod][INFO    ][21862] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-03 22:34:44,947 [salt.state       ][INFO    ][21862] Package lsof is already installed
2017-12-03 22:34:44,947 [salt.state       ][INFO    ][21862] Completed state [lsof] at time 22:34:44.947376 duration_in_ms=272.46
2017-12-03 22:34:44,948 [salt.state       ][INFO    ][21862] Running state [keepalived] at time 22:34:44.947663
2017-12-03 22:34:44,948 [salt.state       ][INFO    ][21862] Executing state pkg.installed for keepalived
2017-12-03 22:34:44,965 [salt.loaded.int.module.cmdmod][INFO    ][21862] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-12-03 22:34:46,268 [salt.loaded.int.module.cmdmod][INFO    ][21862] 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-12-03 22:34:49,002 [salt.loaded.int.module.cmdmod][INFO    ][21862] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-03 22:34:49,030 [salt.state       ][INFO    ][21862] 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-12-03 22:34:49,040 [salt.state       ][INFO    ][21862] Loading fresh modules for state activity
2017-12-03 22:34:49,057 [salt.state       ][INFO    ][21862] Completed state [keepalived] at time 22:34:49.056884 duration_in_ms=4109.22
2017-12-03 22:34:49,059 [salt.state       ][INFO    ][21862] Running state [/etc/keepalived/keepalived.conf] at time 22:34:49.058869
2017-12-03 22:34:49,059 [salt.state       ][INFO    ][21862] Executing state file.managed for /etc/keepalived/keepalived.conf
2017-12-03 22:34:49,089 [salt.fileclient  ][INFO    ][21862] Fetching file from saltenv 'base', ** done ** 'keepalived/files/keepalived.conf'
2017-12-03 22:34:49,133 [salt.fileclient  ][INFO    ][21862] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-12-03 22:34:49,141 [salt.state       ][INFO    ][21862] File changed:
New file
2017-12-03 22:34:49,141 [salt.state       ][INFO    ][21862] Completed state [/etc/keepalived/keepalived.conf] at time 22:34:49.141193 duration_in_ms=82.324
2017-12-03 22:34:49,209 [salt.state       ][INFO    ][21862] Running state [keepalived] at time 22:34:49.208912
2017-12-03 22:34:49,209 [salt.state       ][INFO    ][21862] Executing state service.running for keepalived
2017-12-03 22:34:49,211 [salt.loaded.int.module.cmdmod][INFO    ][21862] Executing command ['systemctl', 'status', 'keepalived.service', '-n', '0'] in directory '/root'
2017-12-03 22:34:49,221 [salt.loaded.int.module.cmdmod][INFO    ][21862] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2017-12-03 22:34:49,229 [salt.loaded.int.module.cmdmod][INFO    ][21862] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-12-03 22:34:49,237 [salt.loaded.int.module.cmdmod][INFO    ][21862] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-12-03 22:34:49,246 [salt.loaded.int.module.cmdmod][INFO    ][21862] Executing command ['systemd-run', '--scope', 'systemctl', 'start', 'keepalived.service'] in directory '/root'
2017-12-03 22:34:49,277 [salt.loaded.int.module.cmdmod][INFO    ][21862] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2017-12-03 22:34:49,286 [salt.loaded.int.module.cmdmod][INFO    ][21862] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-12-03 22:34:49,293 [salt.loaded.int.module.cmdmod][INFO    ][21862] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-12-03 22:34:49,300 [salt.state       ][INFO    ][21862] {'keepalived': True}
2017-12-03 22:34:49,300 [salt.state       ][INFO    ][21862] Completed state [keepalived] at time 22:34:49.300203 duration_in_ms=91.291
2017-12-03 22:34:49,301 [salt.minion      ][INFO    ][21862] Returning information for job: 20171203223443629000
2017-12-03 22:34:56,466 [salt.minion      ][INFO    ][21276] User sudo_ubuntu Executing command pillar.get with jid 20171203223456459201
2017-12-03 22:34:56,481 [salt.minion      ][INFO    ][23273] Starting a new job with PID 23273
2017-12-03 22:34:56,486 [salt.minion      ][INFO    ][23273] Returning information for job: 20171203223456459201
2017-12-03 22:39:36,081 [salt.minion      ][INFO    ][21276] User sudo_ubuntu Executing command state.sls with jid 20171203223936072099
2017-12-03 22:39:36,094 [salt.minion      ][INFO    ][23359] Starting a new job with PID 23359
2017-12-03 22:39:38,744 [salt.state       ][INFO    ][23359] Loading fresh modules for state activity
2017-12-03 22:39:38,774 [salt.fileclient  ][INFO    ][23359] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-12-03 22:39:38,799 [salt.fileclient  ][INFO    ][23359] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-12-03 22:39:39,102 [salt.state       ][INFO    ][23359] Running state [attr] at time 22:39:39.102205
2017-12-03 22:39:39,103 [salt.state       ][INFO    ][23359] Executing state pkg.installed for attr
2017-12-03 22:39:39,103 [salt.loaded.int.module.cmdmod][INFO    ][23359] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-03 22:39:39,390 [salt.loaded.int.module.cmdmod][INFO    ][23359] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-12-03 22:39:40,685 [salt.loaded.int.module.cmdmod][INFO    ][23359] 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-12-03 22:39:42,005 [salt.loaded.int.module.cmdmod][INFO    ][23359] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-03 22:39:42,033 [salt.state       ][INFO    ][23359] Made the following changes:
'attr' changed from 'absent' to '1:2.4.47-2'

2017-12-03 22:39:42,044 [salt.state       ][INFO    ][23359] Loading fresh modules for state activity
2017-12-03 22:39:42,061 [salt.state       ][INFO    ][23359] Completed state [attr] at time 22:39:42.060456 duration_in_ms=2958.251
2017-12-03 22:39:42,067 [salt.state       ][INFO    ][23359] Running state [glusterfs-server] at time 22:39:42.066678
2017-12-03 22:39:42,067 [salt.state       ][INFO    ][23359] Executing state pkg.installed for glusterfs-server
2017-12-03 22:39:42,282 [salt.loaded.int.module.cmdmod][INFO    ][23359] 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-12-03 22:39:46,188 [salt.minion      ][INFO    ][21276] User sudo_ubuntu Executing command saltutil.find_job with jid 20171203223946168397
2017-12-03 22:39:46,201 [salt.minion      ][INFO    ][24184] Starting a new job with PID 24184
2017-12-03 22:39:46,216 [salt.minion      ][INFO    ][24184] Returning information for job: 20171203223946168397
2017-12-03 22:39:55,148 [salt.loaded.int.module.cmdmod][INFO    ][23359] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-03 22:39:55,177 [salt.state       ][INFO    ][23359] Made the following changes:
'keyutils' changed from 'absent' to '1.5.9-8ubuntu1'
'glusterfs-client' changed from 'absent' to '3.10.8-ubuntu1~xenial1'
'rpcbind' changed from 'absent' to '0.2.3-0.2'
'libpython2.7' changed from 'absent' to '2.7.12-1ubuntu0~16.04.2'
'nfs-common' changed from 'absent' to '1:1.2.8-9ubuntu12.1'
'librdmacm1' changed from 'absent' to '1.0.21-1'
'glusterfs-common' changed from 'absent' to '3.10.8-ubuntu1~xenial1'
'liburcu4' changed from 'absent' to '0.9.1-3'
'portmap' changed from 'absent' to '1'
'libnfsidmap2' changed from 'absent' to '0.25-5'
'libibverbs1' changed from 'absent' to '1.1.8-1.1ubuntu2'
'libtirpc1' changed from 'absent' to '0.2.5-1'
'nfs-client' changed from 'absent' to '1'
'glusterfs-server' changed from 'absent' to '3.10.8-ubuntu1~xenial1'

2017-12-03 22:39:55,187 [salt.state       ][INFO    ][23359] Loading fresh modules for state activity
2017-12-03 22:39:55,204 [salt.state       ][INFO    ][23359] Completed state [glusterfs-server] at time 22:39:55.203886 duration_in_ms=13137.195
2017-12-03 22:39:55,209 [salt.state       ][INFO    ][23359] Running state [bc] at time 22:39:55.209113
2017-12-03 22:39:55,209 [salt.state       ][INFO    ][23359] Executing state pkg.installed for bc
2017-12-03 22:39:55,477 [salt.loaded.int.module.cmdmod][INFO    ][23359] 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-12-03 22:39:56,250 [salt.minion      ][INFO    ][21276] User sudo_ubuntu Executing command saltutil.find_job with jid 20171203223956234714
2017-12-03 22:39:56,262 [salt.minion      ][INFO    ][25767] Starting a new job with PID 25767
2017-12-03 22:39:56,274 [salt.minion      ][INFO    ][25767] Returning information for job: 20171203223956234714
2017-12-03 22:39:57,105 [salt.loaded.int.module.cmdmod][INFO    ][23359] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-03 22:39:57,138 [salt.state       ][INFO    ][23359] Made the following changes:
'bc' changed from 'absent' to '1.06.95-9build1'

2017-12-03 22:39:57,151 [salt.state       ][INFO    ][23359] Loading fresh modules for state activity
2017-12-03 22:39:57,169 [salt.state       ][INFO    ][23359] Completed state [bc] at time 22:39:57.168478 duration_in_ms=1959.364
2017-12-03 22:39:57,243 [salt.state       ][INFO    ][23359] Running state [glusterfs-server] at time 22:39:57.242947
2017-12-03 22:39:57,243 [salt.state       ][INFO    ][23359] Executing state service.running for glusterfs-server
2017-12-03 22:39:57,245 [salt.loaded.int.module.cmdmod][INFO    ][23359] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-12-03 22:39:57,255 [salt.loaded.int.module.cmdmod][INFO    ][23359] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-12-03 22:39:57,263 [salt.loaded.int.module.cmdmod][INFO    ][23359] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-12-03 22:39:57,273 [salt.state       ][INFO    ][23359] The service glusterfs-server is already running
2017-12-03 22:39:57,273 [salt.state       ][INFO    ][23359] Completed state [glusterfs-server] at time 22:39:57.272992 duration_in_ms=30.045
2017-12-03 22:39:57,274 [salt.state       ][INFO    ][23359] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 22:39:57.274414
2017-12-03 22:39:57,275 [salt.state       ][INFO    ][23359] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-12-03 22:39:57,280 [salt.state       ][INFO    ][23359] File changed:
New file
2017-12-03 22:39:57,280 [salt.state       ][INFO    ][23359] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 22:39:57.279703 duration_in_ms=5.289
2017-12-03 22:39:57,280 [salt.state       ][INFO    ][23359] Running state [/srv/glusterfs/glance] at time 22:39:57.279900
2017-12-03 22:39:57,280 [salt.state       ][INFO    ][23359] Executing state file.directory for /srv/glusterfs/glance
2017-12-03 22:39:57,281 [salt.state       ][INFO    ][23359] {'/srv/glusterfs/glance': 'New Dir'}
2017-12-03 22:39:57,281 [salt.state       ][INFO    ][23359] Completed state [/srv/glusterfs/glance] at time 22:39:57.280972 duration_in_ms=1.071
2017-12-03 22:39:57,281 [salt.state       ][INFO    ][23359] Running state [/srv/glusterfs/keystone-keys] at time 22:39:57.281169
2017-12-03 22:39:57,281 [salt.state       ][INFO    ][23359] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-12-03 22:39:57,282 [salt.state       ][INFO    ][23359] {'/srv/glusterfs/keystone-keys': 'New Dir'}
2017-12-03 22:39:57,282 [salt.state       ][INFO    ][23359] Completed state [/srv/glusterfs/keystone-keys] at time 22:39:57.282007 duration_in_ms=0.838
2017-12-03 22:39:57,282 [salt.state       ][INFO    ][23359] Running state [/srv/glusterfs/nova_instances] at time 22:39:57.282199
2017-12-03 22:39:57,282 [salt.state       ][INFO    ][23359] Executing state file.directory for /srv/glusterfs/nova_instances
2017-12-03 22:39:57,283 [salt.state       ][INFO    ][23359] {'/srv/glusterfs/nova_instances': 'New Dir'}
2017-12-03 22:39:57,283 [salt.state       ][INFO    ][23359] Completed state [/srv/glusterfs/nova_instances] at time 22:39:57.283043 duration_in_ms=0.844
2017-12-03 22:39:57,283 [salt.state       ][INFO    ][23359] Running state [/srv/glusterfs/keystone-credential-keys] at time 22:39:57.283225
2017-12-03 22:39:57,283 [salt.state       ][INFO    ][23359] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-12-03 22:39:57,284 [salt.state       ][INFO    ][23359] {'/srv/glusterfs/keystone-credential-keys': 'New Dir'}
2017-12-03 22:39:57,284 [salt.state       ][INFO    ][23359] Completed state [/srv/glusterfs/keystone-credential-keys] at time 22:39:57.284082 duration_in_ms=0.857
2017-12-03 22:39:57,285 [salt.minion      ][INFO    ][23359] Returning information for job: 20171203223936072099
2017-12-03 22:39:58,301 [salt.minion      ][INFO    ][21276] User sudo_ubuntu Executing command test.ping with jid 20171203223958291716
2017-12-03 22:39:58,313 [salt.minion      ][INFO    ][26142] Starting a new job with PID 26142
2017-12-03 22:39:58,347 [salt.minion      ][INFO    ][26142] Returning information for job: 20171203223958291716
2017-12-03 22:40:22,477 [salt.minion      ][INFO    ][21276] User sudo_ubuntu Executing command state.sls with jid 20171203224022468390
2017-12-03 22:40:22,490 [salt.minion      ][INFO    ][26772] Starting a new job with PID 26772
2017-12-03 22:40:24,843 [salt.state       ][INFO    ][26772] Loading fresh modules for state activity
2017-12-03 22:40:24,871 [salt.fileclient  ][INFO    ][26772] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/setup.sls'
2017-12-03 22:40:24,911 [salt.fileclient  ][INFO    ][26772] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-12-03 22:40:24,998 [salt.fileclient  ][INFO    ][26772] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-12-03 22:40:25,021 [salt.fileclient  ][INFO    ][26772] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-12-03 22:40:25,325 [salt.state       ][INFO    ][26772] Running state [attr] at time 22:40:25.324479
2017-12-03 22:40:25,325 [salt.state       ][INFO    ][26772] Executing state pkg.installed for attr
2017-12-03 22:40:25,325 [salt.loaded.int.module.cmdmod][INFO    ][26772] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-03 22:40:25,582 [salt.state       ][INFO    ][26772] Package attr is already installed
2017-12-03 22:40:25,582 [salt.state       ][INFO    ][26772] Completed state [attr] at time 22:40:25.581807 duration_in_ms=257.329
2017-12-03 22:40:25,582 [salt.state       ][INFO    ][26772] Running state [glusterfs-server] at time 22:40:25.582033
2017-12-03 22:40:25,582 [salt.state       ][INFO    ][26772] Executing state pkg.installed for glusterfs-server
2017-12-03 22:40:25,586 [salt.state       ][INFO    ][26772] Package glusterfs-server is already installed
2017-12-03 22:40:25,586 [salt.state       ][INFO    ][26772] Completed state [glusterfs-server] at time 22:40:25.586232 duration_in_ms=4.198
2017-12-03 22:40:25,586 [salt.state       ][INFO    ][26772] Running state [bc] at time 22:40:25.586447
2017-12-03 22:40:25,587 [salt.state       ][INFO    ][26772] Executing state pkg.installed for bc
2017-12-03 22:40:25,590 [salt.state       ][INFO    ][26772] Package bc is already installed
2017-12-03 22:40:25,591 [salt.state       ][INFO    ][26772] Completed state [bc] at time 22:40:25.590516 duration_in_ms=4.069
2017-12-03 22:40:25,592 [salt.state       ][INFO    ][26772] Running state [glusterfs-server] at time 22:40:25.591609
2017-12-03 22:40:25,592 [salt.state       ][INFO    ][26772] Executing state service.running for glusterfs-server
2017-12-03 22:40:25,592 [salt.loaded.int.module.cmdmod][INFO    ][26772] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-12-03 22:40:25,602 [salt.loaded.int.module.cmdmod][INFO    ][26772] Executing command ['systemctl', '--system', 'daemon-reload'] in directory '/root'
2017-12-03 22:40:25,657 [salt.loaded.int.module.cmdmod][INFO    ][26772] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-12-03 22:40:25,672 [salt.loaded.int.module.cmdmod][INFO    ][26772] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-12-03 22:40:25,680 [salt.loaded.int.module.cmdmod][INFO    ][26772] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-12-03 22:40:25,688 [salt.state       ][INFO    ][26772] The service glusterfs-server is already running
2017-12-03 22:40:25,688 [salt.state       ][INFO    ][26772] Completed state [glusterfs-server] at time 22:40:25.687851 duration_in_ms=96.241
2017-12-03 22:40:25,690 [salt.state       ][INFO    ][26772] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 22:40:25.689563
2017-12-03 22:40:25,690 [salt.state       ][INFO    ][26772] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-12-03 22:40:25,692 [salt.state       ][INFO    ][26772] File /etc/systemd/system/glusterfs-server.service.d/override.conf is in the correct state
2017-12-03 22:40:25,692 [salt.state       ][INFO    ][26772] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 22:40:25.691979 duration_in_ms=2.416
2017-12-03 22:40:25,692 [salt.state       ][INFO    ][26772] Running state [/srv/glusterfs/glance] at time 22:40:25.692196
2017-12-03 22:40:25,692 [salt.state       ][INFO    ][26772] Executing state file.directory for /srv/glusterfs/glance
2017-12-03 22:40:25,693 [salt.state       ][INFO    ][26772] Directory /srv/glusterfs/glance is in the correct state
2017-12-03 22:40:25,693 [salt.state       ][INFO    ][26772] Completed state [/srv/glusterfs/glance] at time 22:40:25.692970 duration_in_ms=0.773
2017-12-03 22:40:25,693 [salt.state       ][INFO    ][26772] Running state [/srv/glusterfs/keystone-keys] at time 22:40:25.693167
2017-12-03 22:40:25,693 [salt.state       ][INFO    ][26772] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-12-03 22:40:25,694 [salt.state       ][INFO    ][26772] Directory /srv/glusterfs/keystone-keys is in the correct state
2017-12-03 22:40:25,694 [salt.state       ][INFO    ][26772] Completed state [/srv/glusterfs/keystone-keys] at time 22:40:25.693931 duration_in_ms=0.763
2017-12-03 22:40:25,694 [salt.state       ][INFO    ][26772] Running state [/srv/glusterfs/nova_instances] at time 22:40:25.694122
2017-12-03 22:40:25,694 [salt.state       ][INFO    ][26772] Executing state file.directory for /srv/glusterfs/nova_instances
2017-12-03 22:40:25,695 [salt.state       ][INFO    ][26772] Directory /srv/glusterfs/nova_instances is in the correct state
2017-12-03 22:40:25,695 [salt.state       ][INFO    ][26772] Completed state [/srv/glusterfs/nova_instances] at time 22:40:25.694861 duration_in_ms=0.738
2017-12-03 22:40:25,695 [salt.state       ][INFO    ][26772] Running state [/srv/glusterfs/keystone-credential-keys] at time 22:40:25.695050
2017-12-03 22:40:25,695 [salt.state       ][INFO    ][26772] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-12-03 22:40:25,696 [salt.state       ][INFO    ][26772] Directory /srv/glusterfs/keystone-credential-keys is in the correct state
2017-12-03 22:40:25,696 [salt.state       ][INFO    ][26772] Completed state [/srv/glusterfs/keystone-credential-keys] at time 22:40:25.695779 duration_in_ms=0.729
2017-12-03 22:40:25,763 [salt.loaded.int.module.cmdmod][INFO    ][26772] Executing command ['git', '--version'] in directory '/root'
2017-12-03 22:40:25,849 [salt.state       ][INFO    ][26772] Running state [sleep 5] at time 22:40:25.848601
2017-12-03 22:40:25,849 [salt.state       ][INFO    ][26772] Executing state cmd.wait for sleep 5
2017-12-03 22:40:25,849 [salt.state       ][INFO    ][26772] No changes made for sleep 5
2017-12-03 22:40:25,849 [salt.state       ][INFO    ][26772] Completed state [sleep 5] at time 22:40:25.849318 duration_in_ms=0.718
2017-12-03 22:40:25,850 [salt.state       ][INFO    ][26772] Running state [192.168.10.143] at time 22:40:25.849913
2017-12-03 22:40:25,850 [salt.state       ][INFO    ][26772] Executing state glusterfs.peered for 192.168.10.143
2017-12-03 22:40:25,851 [salt.loaded.int.module.cmdmod][INFO    ][26772] Executing command 'gluster --version' in directory '/root'
2017-12-03 22:40:25,859 [salt.loaded.int.module.cmdmod][INFO    ][26772] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-03 22:40:25,917 [salt.state       ][INFO    ][26772] Host 192.168.10.143 already peered
2017-12-03 22:40:25,917 [salt.state       ][INFO    ][26772] Completed state [192.168.10.143] at time 22:40:25.916943 duration_in_ms=67.028
2017-12-03 22:40:25,920 [salt.state       ][INFO    ][26772] Running state [192.168.10.142] at time 22:40:25.919960
2017-12-03 22:40:25,920 [salt.state       ][INFO    ][26772] Executing state glusterfs.peered for 192.168.10.142
2017-12-03 22:40:25,921 [salt.loaded.int.module.cmdmod][INFO    ][26772] Executing command 'gluster --version' in directory '/root'
2017-12-03 22:40:25,929 [salt.loaded.int.module.cmdmod][INFO    ][26772] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-03 22:40:25,985 [salt.state       ][INFO    ][26772] Host 192.168.10.142 already peered
2017-12-03 22:40:25,985 [salt.state       ][INFO    ][26772] Completed state [192.168.10.142] at time 22:40:25.985351 duration_in_ms=65.39
2017-12-03 22:40:25,988 [salt.state       ][INFO    ][26772] Running state [192.168.10.141] at time 22:40:25.988403
2017-12-03 22:40:25,989 [salt.state       ][INFO    ][26772] Executing state glusterfs.peered for 192.168.10.141
2017-12-03 22:40:25,989 [salt.loaded.int.module.cmdmod][INFO    ][26772] Executing command 'gluster --version' in directory '/root'
2017-12-03 22:40:25,997 [salt.loaded.int.module.cmdmod][INFO    ][26772] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-03 22:40:26,053 [salt.loaded.int.module.cmdmod][INFO    ][26772] Executing command 'gluster --version' in directory '/root'
2017-12-03 22:40:26,060 [salt.loaded.int.module.cmdmod][INFO    ][26772] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-03 22:40:26,118 [salt.loaded.int.module.cmdmod][INFO    ][26772] Executing command 'gluster --version' in directory '/root'
2017-12-03 22:40:26,126 [salt.loaded.int.module.cmdmod][INFO    ][26772] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-03 22:40:26,181 [salt.loaded.int.module.cmdmod][INFO    ][26772] Executing command 'gluster --version' in directory '/root'
2017-12-03 22:40:26,190 [salt.loaded.int.module.cmdmod][INFO    ][26772] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-03 22:40:26,245 [salt.state       ][INFO    ][26772] Peering with localhost is not needed
2017-12-03 22:40:26,246 [salt.state       ][INFO    ][26772] Completed state [192.168.10.141] at time 22:40:26.245622 duration_in_ms=257.218
2017-12-03 22:40:26,247 [salt.state       ][INFO    ][26772] Running state [glance] at time 22:40:26.246718
2017-12-03 22:40:26,247 [salt.state       ][INFO    ][26772] Executing state glusterfs.created for glance
2017-12-03 22:40:26,248 [salt.loaded.int.module.cmdmod][INFO    ][26772] Executing command 'gluster --version' in directory '/root'
2017-12-03 22:40:26,257 [salt.loaded.int.module.cmdmod][INFO    ][26772] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-03 22:40:26,312 [salt.loaded.int.module.cmdmod][INFO    ][26772] Executing command 'gluster --version' in directory '/root'
2017-12-03 22:40:26,320 [salt.loaded.int.module.cmdmod][INFO    ][26772] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-03 22:40:26,381 [salt.state       ][INFO    ][26772] Volume glance already exists and is started.
2017-12-03 22:40:26,381 [salt.state       ][INFO    ][26772] Completed state [glance] at time 22:40:26.380905 duration_in_ms=134.187
2017-12-03 22:40:26,385 [salt.state       ][INFO    ][26772] Running state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 22:40:26.385207
2017-12-03 22:40:26,385 [salt.state       ][INFO    ][26772] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'
2017-12-03 22:40:26,386 [salt.loaded.int.module.cmdmod][INFO    ][26772] Executing command 'gluster volume info 'glance' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-12-03 22:40:26,442 [salt.state       ][INFO    ][26772] unless execution succeeded
2017-12-03 22:40:26,442 [salt.state       ][INFO    ][26772] Completed state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 22:40:26.441911 duration_in_ms=56.704
2017-12-03 22:40:26,442 [salt.state       ][INFO    ][26772] Running state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 22:40:26.442466
2017-12-03 22:40:26,443 [salt.state       ][INFO    ][26772] Executing state cmd.run for gluster volume set 'glance' 'network.remote-dio' 'True'
2017-12-03 22:40:26,443 [salt.loaded.int.module.cmdmod][INFO    ][26772] Executing command 'gluster volume info 'glance' | grep 'network.remote-dio: True'' in directory '/root'
2017-12-03 22:40:26,497 [salt.state       ][INFO    ][26772] unless execution succeeded
2017-12-03 22:40:26,498 [salt.state       ][INFO    ][26772] Completed state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 22:40:26.497516 duration_in_ms=55.05
2017-12-03 22:40:26,498 [salt.state       ][INFO    ][26772] Running state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 22:40:26.498145
2017-12-03 22:40:26,498 [salt.state       ][INFO    ][26772] Executing state cmd.run for gluster volume set 'glance' 'nfs.disable' 'True'
2017-12-03 22:40:26,499 [salt.loaded.int.module.cmdmod][INFO    ][26772] Executing command 'gluster volume info 'glance' | grep 'nfs.disable: True'' in directory '/root'
2017-12-03 22:40:26,554 [salt.state       ][INFO    ][26772] unless execution succeeded
2017-12-03 22:40:26,554 [salt.state       ][INFO    ][26772] Completed state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 22:40:26.554133 duration_in_ms=55.988
2017-12-03 22:40:26,555 [salt.state       ][INFO    ][26772] Running state [gluster volume set 'glance' 'cluster.favorite-child-policy' 'mtime'] at time 22:40:26.554742
2017-12-03 22:40:26,555 [salt.state       ][INFO    ][26772] Executing state cmd.run for gluster volume set 'glance' 'cluster.favorite-child-policy' 'mtime'
2017-12-03 22:40:26,555 [salt.loaded.int.module.cmdmod][INFO    ][26772] Executing command 'gluster volume info 'glance' | grep 'cluster.favorite-child-policy: mtime'' in directory '/root'
2017-12-03 22:40:26,612 [salt.state       ][INFO    ][26772] unless execution succeeded
2017-12-03 22:40:26,613 [salt.state       ][INFO    ][26772] Completed state [gluster volume set 'glance' 'cluster.favorite-child-policy' 'mtime'] at time 22:40:26.612519 duration_in_ms=57.776
2017-12-03 22:40:26,613 [salt.state       ][INFO    ][26772] Running state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 22:40:26.613157
2017-12-03 22:40:26,613 [salt.state       ][INFO    ][26772] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'
2017-12-03 22:40:26,614 [salt.loaded.int.module.cmdmod][INFO    ][26772] Executing command 'gluster volume info 'glance' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-12-03 22:40:26,668 [salt.state       ][INFO    ][26772] unless execution succeeded
2017-12-03 22:40:26,668 [salt.state       ][INFO    ][26772] Completed state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 22:40:26.668375 duration_in_ms=55.218
2017-12-03 22:40:26,669 [salt.state       ][INFO    ][26772] Running state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 22:40:26.668961
2017-12-03 22:40:26,669 [salt.state       ][INFO    ][26772] Executing state cmd.run for gluster volume set 'glance' 'cluster.readdir-optimize' 'True'
2017-12-03 22:40:26,670 [salt.loaded.int.module.cmdmod][INFO    ][26772] Executing command 'gluster volume info 'glance' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-12-03 22:40:26,726 [salt.state       ][INFO    ][26772] unless execution succeeded
2017-12-03 22:40:26,726 [salt.state       ][INFO    ][26772] Completed state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 22:40:26.726255 duration_in_ms=57.294
2017-12-03 22:40:26,728 [salt.state       ][INFO    ][26772] Running state [glance] at time 22:40:26.727939
2017-12-03 22:40:26,728 [salt.state       ][INFO    ][26772] Executing state glusterfs.started for glance
2017-12-03 22:40:26,729 [salt.loaded.int.module.cmdmod][INFO    ][26772] Executing command 'gluster --version' in directory '/root'
2017-12-03 22:40:26,737 [salt.loaded.int.module.cmdmod][INFO    ][26772] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-03 22:40:26,793 [salt.loaded.int.module.cmdmod][INFO    ][26772] Executing command 'gluster --version' in directory '/root'
2017-12-03 22:40:26,799 [salt.loaded.int.module.cmdmod][INFO    ][26772] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-03 22:40:26,860 [salt.state       ][INFO    ][26772] Volume glance is already started
2017-12-03 22:40:26,861 [salt.state       ][INFO    ][26772] Completed state [glance] at time 22:40:26.860588 duration_in_ms=132.649
2017-12-03 22:40:26,862 [salt.state       ][INFO    ][26772] Running state [keystone-keys] at time 22:40:26.861645
2017-12-03 22:40:26,862 [salt.state       ][INFO    ][26772] Executing state glusterfs.created for keystone-keys
2017-12-03 22:40:26,862 [salt.loaded.int.module.cmdmod][INFO    ][26772] Executing command 'gluster --version' in directory '/root'
2017-12-03 22:40:26,871 [salt.loaded.int.module.cmdmod][INFO    ][26772] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-03 22:40:26,927 [salt.loaded.int.module.cmdmod][INFO    ][26772] Executing command 'gluster --version' in directory '/root'
2017-12-03 22:40:26,935 [salt.loaded.int.module.cmdmod][INFO    ][26772] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-03 22:40:26,994 [salt.state       ][INFO    ][26772] Volume keystone-keys already exists and is started.
2017-12-03 22:40:26,994 [salt.state       ][INFO    ][26772] Completed state [keystone-keys] at time 22:40:26.994202 duration_in_ms=132.556
2017-12-03 22:40:26,999 [salt.state       ][INFO    ][26772] Running state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 22:40:26.999003
2017-12-03 22:40:26,999 [salt.state       ][INFO    ][26772] Executing state cmd.run for gluster volume set 'keystone-keys' 'network.remote-dio' 'True'
2017-12-03 22:40:26,1000 [salt.loaded.int.module.cmdmod][INFO    ][26772] Executing command 'gluster volume info 'keystone-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-12-03 22:40:27,057 [salt.state       ][INFO    ][26772] unless execution succeeded
2017-12-03 22:40:27,058 [salt.state       ][INFO    ][26772] Completed state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 22:40:27.057911 duration_in_ms=58.907
2017-12-03 22:40:27,059 [salt.state       ][INFO    ][26772] Running state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 22:40:27.058867
2017-12-03 22:40:27,059 [salt.state       ][INFO    ][26772] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-12-03 22:40:27,060 [salt.loaded.int.module.cmdmod][INFO    ][26772] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-12-03 22:40:27,114 [salt.state       ][INFO    ][26772] unless execution succeeded
2017-12-03 22:40:27,114 [salt.state       ][INFO    ][26772] Completed state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 22:40:27.114179 duration_in_ms=55.311
2017-12-03 22:40:27,115 [salt.state       ][INFO    ][26772] Running state [gluster volume set 'keystone-keys' 'cluster.favorite-child-policy' 'mtime'] at time 22:40:27.114802
2017-12-03 22:40:27,115 [salt.state       ][INFO    ][26772] Executing state cmd.run for gluster volume set 'keystone-keys' 'cluster.favorite-child-policy' 'mtime'
2017-12-03 22:40:27,116 [salt.loaded.int.module.cmdmod][INFO    ][26772] Executing command 'gluster volume info 'keystone-keys' | grep 'cluster.favorite-child-policy: mtime'' in directory '/root'
2017-12-03 22:40:27,169 [salt.state       ][INFO    ][26772] unless execution succeeded
2017-12-03 22:40:27,169 [salt.state       ][INFO    ][26772] Completed state [gluster volume set 'keystone-keys' 'cluster.favorite-child-policy' 'mtime'] at time 22:40:27.169164 duration_in_ms=54.362
2017-12-03 22:40:27,170 [salt.state       ][INFO    ][26772] Running state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 22:40:27.169753
2017-12-03 22:40:27,170 [salt.state       ][INFO    ][26772] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'
2017-12-03 22:40:27,171 [salt.loaded.int.module.cmdmod][INFO    ][26772] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-12-03 22:40:27,225 [salt.state       ][INFO    ][26772] unless execution succeeded
2017-12-03 22:40:27,225 [salt.state       ][INFO    ][26772] Completed state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 22:40:27.225300 duration_in_ms=55.547
2017-12-03 22:40:27,226 [salt.state       ][INFO    ][26772] Running state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 22:40:27.225942
2017-12-03 22:40:27,226 [salt.state       ][INFO    ][26772] Executing state cmd.run for gluster volume set 'keystone-keys' 'nfs.disable' 'True'
2017-12-03 22:40:27,227 [salt.loaded.int.module.cmdmod][INFO    ][26772] Executing command 'gluster volume info 'keystone-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-12-03 22:40:27,281 [salt.state       ][INFO    ][26772] unless execution succeeded
2017-12-03 22:40:27,282 [salt.state       ][INFO    ][26772] Completed state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 22:40:27.281729 duration_in_ms=55.787
2017-12-03 22:40:27,283 [salt.state       ][INFO    ][26772] Running state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 22:40:27.282470
2017-12-03 22:40:27,283 [salt.state       ][INFO    ][26772] Executing state cmd.run for gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'
2017-12-03 22:40:27,283 [salt.loaded.int.module.cmdmod][INFO    ][26772] Executing command 'gluster volume info 'keystone-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-12-03 22:40:27,340 [salt.state       ][INFO    ][26772] unless execution succeeded
2017-12-03 22:40:27,341 [salt.state       ][INFO    ][26772] Completed state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 22:40:27.340643 duration_in_ms=58.172
2017-12-03 22:40:27,342 [salt.state       ][INFO    ][26772] Running state [keystone-keys] at time 22:40:27.342124
2017-12-03 22:40:27,342 [salt.state       ][INFO    ][26772] Executing state glusterfs.started for keystone-keys
2017-12-03 22:40:27,343 [salt.loaded.int.module.cmdmod][INFO    ][26772] Executing command 'gluster --version' in directory '/root'
2017-12-03 22:40:27,351 [salt.loaded.int.module.cmdmod][INFO    ][26772] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-03 22:40:27,408 [salt.loaded.int.module.cmdmod][INFO    ][26772] Executing command 'gluster --version' in directory '/root'
2017-12-03 22:40:27,417 [salt.loaded.int.module.cmdmod][INFO    ][26772] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-03 22:40:27,477 [salt.state       ][INFO    ][26772] Volume keystone-keys is already started
2017-12-03 22:40:27,477 [salt.state       ][INFO    ][26772] Completed state [keystone-keys] at time 22:40:27.476795 duration_in_ms=134.67
2017-12-03 22:40:27,478 [salt.state       ][INFO    ][26772] Running state [nova_instances] at time 22:40:27.478077
2017-12-03 22:40:27,478 [salt.state       ][INFO    ][26772] Executing state glusterfs.created for nova_instances
2017-12-03 22:40:27,479 [salt.loaded.int.module.cmdmod][INFO    ][26772] Executing command 'gluster --version' in directory '/root'
2017-12-03 22:40:27,487 [salt.loaded.int.module.cmdmod][INFO    ][26772] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-03 22:40:27,551 [salt.loaded.int.module.cmdmod][INFO    ][26772] Executing command 'gluster --version' in directory '/root'
2017-12-03 22:40:27,561 [salt.loaded.int.module.cmdmod][INFO    ][26772] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-03 22:40:27,621 [salt.state       ][INFO    ][26772] Volume nova_instances already exists and is started.
2017-12-03 22:40:27,621 [salt.state       ][INFO    ][26772] Completed state [nova_instances] at time 22:40:27.621161 duration_in_ms=143.084
2017-12-03 22:40:27,626 [salt.state       ][INFO    ][26772] Running state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 22:40:27.625913
2017-12-03 22:40:27,626 [salt.state       ][INFO    ][26772] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'
2017-12-03 22:40:27,627 [salt.loaded.int.module.cmdmod][INFO    ][26772] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-12-03 22:40:27,684 [salt.state       ][INFO    ][26772] unless execution succeeded
2017-12-03 22:40:27,685 [salt.state       ][INFO    ][26772] Completed state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 22:40:27.684586 duration_in_ms=58.673
2017-12-03 22:40:27,685 [salt.state       ][INFO    ][26772] Running state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'True'] at time 22:40:27.685256
2017-12-03 22:40:27,686 [salt.state       ][INFO    ][26772] Executing state cmd.run for gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'True'
2017-12-03 22:40:27,686 [salt.loaded.int.module.cmdmod][INFO    ][26772] Executing command 'gluster volume info 'nova_instances' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-12-03 22:40:27,742 [salt.state       ][INFO    ][26772] unless execution succeeded
2017-12-03 22:40:27,742 [salt.state       ][INFO    ][26772] Completed state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'True'] at time 22:40:27.742358 duration_in_ms=57.101
2017-12-03 22:40:27,743 [salt.state       ][INFO    ][26772] Running state [gluster volume set 'nova_instances' 'network.remote-dio' 'True'] at time 22:40:27.742951
2017-12-03 22:40:27,743 [salt.state       ][INFO    ][26772] Executing state cmd.run for gluster volume set 'nova_instances' 'network.remote-dio' 'True'
2017-12-03 22:40:27,744 [salt.loaded.int.module.cmdmod][INFO    ][26772] Executing command 'gluster volume info 'nova_instances' | grep 'network.remote-dio: True'' in directory '/root'
2017-12-03 22:40:27,800 [salt.state       ][INFO    ][26772] unless execution succeeded
2017-12-03 22:40:27,800 [salt.state       ][INFO    ][26772] Completed state [gluster volume set 'nova_instances' 'network.remote-dio' 'True'] at time 22:40:27.799854 duration_in_ms=56.902
2017-12-03 22:40:27,801 [salt.state       ][INFO    ][26772] Running state [gluster volume set 'nova_instances' 'cluster.favorite-child-policy' 'mtime'] at time 22:40:27.800562
2017-12-03 22:40:27,801 [salt.state       ][INFO    ][26772] Executing state cmd.run for gluster volume set 'nova_instances' 'cluster.favorite-child-policy' 'mtime'
2017-12-03 22:40:27,802 [salt.loaded.int.module.cmdmod][INFO    ][26772] Executing command 'gluster volume info 'nova_instances' | grep 'cluster.favorite-child-policy: mtime'' in directory '/root'
2017-12-03 22:40:27,858 [salt.state       ][INFO    ][26772] unless execution succeeded
2017-12-03 22:40:27,859 [salt.state       ][INFO    ][26772] Completed state [gluster volume set 'nova_instances' 'cluster.favorite-child-policy' 'mtime'] at time 22:40:27.858635 duration_in_ms=58.073
2017-12-03 22:40:27,859 [salt.state       ][INFO    ][26772] Running state [gluster volume set 'nova_instances' 'nfs.disable' 'True'] at time 22:40:27.859237
2017-12-03 22:40:27,860 [salt.state       ][INFO    ][26772] Executing state cmd.run for gluster volume set 'nova_instances' 'nfs.disable' 'True'
2017-12-03 22:40:27,860 [salt.loaded.int.module.cmdmod][INFO    ][26772] Executing command 'gluster volume info 'nova_instances' | grep 'nfs.disable: True'' in directory '/root'
2017-12-03 22:40:27,913 [salt.state       ][INFO    ][26772] unless execution succeeded
2017-12-03 22:40:27,914 [salt.state       ][INFO    ][26772] Completed state [gluster volume set 'nova_instances' 'nfs.disable' 'True'] at time 22:40:27.913588 duration_in_ms=54.35
2017-12-03 22:40:27,914 [salt.state       ][INFO    ][26772] Running state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 22:40:27.914362
2017-12-03 22:40:27,915 [salt.state       ][INFO    ][26772] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'
2017-12-03 22:40:27,915 [salt.loaded.int.module.cmdmod][INFO    ][26772] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-12-03 22:40:27,971 [salt.state       ][INFO    ][26772] unless execution succeeded
2017-12-03 22:40:27,971 [salt.state       ][INFO    ][26772] Completed state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 22:40:27.971040 duration_in_ms=56.678
2017-12-03 22:40:27,973 [salt.state       ][INFO    ][26772] Running state [nova_instances] at time 22:40:27.972611
2017-12-03 22:40:27,973 [salt.state       ][INFO    ][26772] Executing state glusterfs.started for nova_instances
2017-12-03 22:40:27,973 [salt.loaded.int.module.cmdmod][INFO    ][26772] Executing command 'gluster --version' in directory '/root'
2017-12-03 22:40:27,981 [salt.loaded.int.module.cmdmod][INFO    ][26772] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-03 22:40:28,037 [salt.loaded.int.module.cmdmod][INFO    ][26772] Executing command 'gluster --version' in directory '/root'
2017-12-03 22:40:28,045 [salt.loaded.int.module.cmdmod][INFO    ][26772] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-03 22:40:28,104 [salt.state       ][INFO    ][26772] Volume nova_instances is already started
2017-12-03 22:40:28,104 [salt.state       ][INFO    ][26772] Completed state [nova_instances] at time 22:40:28.103967 duration_in_ms=131.356
2017-12-03 22:40:28,105 [salt.state       ][INFO    ][26772] Running state [keystone-credential-keys] at time 22:40:28.105161
2017-12-03 22:40:28,105 [salt.state       ][INFO    ][26772] Executing state glusterfs.created for keystone-credential-keys
2017-12-03 22:40:28,106 [salt.loaded.int.module.cmdmod][INFO    ][26772] Executing command 'gluster --version' in directory '/root'
2017-12-03 22:40:28,114 [salt.loaded.int.module.cmdmod][INFO    ][26772] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-03 22:40:28,234 [salt.loaded.int.module.cmdmod][INFO    ][26772] Executing command 'gluster --version' in directory '/root'
2017-12-03 22:40:28,242 [salt.loaded.int.module.cmdmod][INFO    ][26772] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-03 22:40:28,300 [salt.state       ][INFO    ][26772] Volume keystone-credential-keys already exists and is started.
2017-12-03 22:40:28,300 [salt.state       ][INFO    ][26772] Completed state [keystone-credential-keys] at time 22:40:28.300031 duration_in_ms=194.868
2017-12-03 22:40:28,305 [salt.state       ][INFO    ][26772] Running state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 22:40:28.304925
2017-12-03 22:40:28,305 [salt.state       ][INFO    ][26772] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'
2017-12-03 22:40:28,306 [salt.loaded.int.module.cmdmod][INFO    ][26772] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-12-03 22:40:28,364 [salt.state       ][INFO    ][26772] unless execution succeeded
2017-12-03 22:40:28,364 [salt.state       ][INFO    ][26772] Completed state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 22:40:28.364149 duration_in_ms=59.224
2017-12-03 22:40:28,365 [salt.state       ][INFO    ][26772] Running state [gluster volume set 'keystone-credential-keys' 'cluster.favorite-child-policy' 'mtime'] at time 22:40:28.364717
2017-12-03 22:40:28,365 [salt.state       ][INFO    ][26772] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'cluster.favorite-child-policy' 'mtime'
2017-12-03 22:40:28,365 [salt.loaded.int.module.cmdmod][INFO    ][26772] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'cluster.favorite-child-policy: mtime'' in directory '/root'
2017-12-03 22:40:28,427 [salt.state       ][INFO    ][26772] unless execution succeeded
2017-12-03 22:40:28,427 [salt.state       ][INFO    ][26772] Completed state [gluster volume set 'keystone-credential-keys' 'cluster.favorite-child-policy' 'mtime'] at time 22:40:28.426875 duration_in_ms=62.158
2017-12-03 22:40:28,428 [salt.state       ][INFO    ][26772] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 22:40:28.427501
2017-12-03 22:40:28,428 [salt.state       ][INFO    ][26772] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-12-03 22:40:28,428 [salt.loaded.int.module.cmdmod][INFO    ][26772] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-12-03 22:40:28,483 [salt.state       ][INFO    ][26772] unless execution succeeded
2017-12-03 22:40:28,483 [salt.state       ][INFO    ][26772] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 22:40:28.483380 duration_in_ms=55.878
2017-12-03 22:40:28,484 [salt.state       ][INFO    ][26772] Running state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 22:40:28.484037
2017-12-03 22:40:28,484 [salt.state       ][INFO    ][26772] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'
2017-12-03 22:40:28,485 [salt.loaded.int.module.cmdmod][INFO    ][26772] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-12-03 22:40:28,555 [salt.state       ][INFO    ][26772] unless execution succeeded
2017-12-03 22:40:28,555 [salt.state       ][INFO    ][26772] Completed state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 22:40:28.555239 duration_in_ms=71.202
2017-12-03 22:40:28,556 [salt.state       ][INFO    ][26772] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 22:40:28.555903
2017-12-03 22:40:28,556 [salt.state       ][INFO    ][26772] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'
2017-12-03 22:40:28,557 [salt.loaded.int.module.cmdmod][INFO    ][26772] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-12-03 22:40:28,612 [salt.state       ][INFO    ][26772] unless execution succeeded
2017-12-03 22:40:28,613 [salt.state       ][INFO    ][26772] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 22:40:28.612631 duration_in_ms=56.729
2017-12-03 22:40:28,613 [salt.state       ][INFO    ][26772] Running state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 22:40:28.613237
2017-12-03 22:40:28,613 [salt.state       ][INFO    ][26772] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'
2017-12-03 22:40:28,614 [salt.loaded.int.module.cmdmod][INFO    ][26772] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-12-03 22:40:28,668 [salt.state       ][INFO    ][26772] unless execution succeeded
2017-12-03 22:40:28,668 [salt.state       ][INFO    ][26772] Completed state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 22:40:28.668339 duration_in_ms=55.101
2017-12-03 22:40:28,670 [salt.state       ][INFO    ][26772] Running state [keystone-credential-keys] at time 22:40:28.669841
2017-12-03 22:40:28,670 [salt.state       ][INFO    ][26772] Executing state glusterfs.started for keystone-credential-keys
2017-12-03 22:40:28,671 [salt.loaded.int.module.cmdmod][INFO    ][26772] Executing command 'gluster --version' in directory '/root'
2017-12-03 22:40:28,679 [salt.loaded.int.module.cmdmod][INFO    ][26772] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-03 22:40:28,732 [salt.loaded.int.module.cmdmod][INFO    ][26772] Executing command 'gluster --version' in directory '/root'
2017-12-03 22:40:28,740 [salt.loaded.int.module.cmdmod][INFO    ][26772] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-03 22:40:28,798 [salt.state       ][INFO    ][26772] Volume keystone-credential-keys is already started
2017-12-03 22:40:28,799 [salt.state       ][INFO    ][26772] Completed state [keystone-credential-keys] at time 22:40:28.798659 duration_in_ms=128.816
2017-12-03 22:40:28,801 [salt.minion      ][INFO    ][26772] Returning information for job: 20171203224022468390
2017-12-03 22:40:29,829 [salt.minion      ][INFO    ][21276] User sudo_ubuntu Executing command test.ping with jid 20171203224029820799
2017-12-03 22:40:29,841 [salt.minion      ][INFO    ][27300] Starting a new job with PID 27300
2017-12-03 22:40:29,876 [salt.minion      ][INFO    ][27300] Returning information for job: 20171203224029820799
2017-12-03 22:40:30,532 [salt.minion      ][INFO    ][21276] User sudo_ubuntu Executing command cmd.run with jid 20171203224030521114
2017-12-03 22:40:30,544 [salt.minion      ][INFO    ][27306] Starting a new job with PID 27306
2017-12-03 22:40:30,548 [salt.loaded.int.module.cmdmod][INFO    ][27306] Executing command 'gluster peer status; gluster volume status' in directory '/root'
2017-12-03 22:40:30,665 [salt.minion      ][INFO    ][27306] Returning information for job: 20171203224030521114
2017-12-03 23:24:15,545 [salt.utils.schedule][INFO    ][21276] Running scheduled job: __mine_interval
2017-12-03 23:38:25,644 [salt.minion      ][INFO    ][21276] User sudo_ubuntu Executing command cp.push_dir with jid 20171203233825634867
2017-12-03 23:38:25,659 [salt.minion      ][INFO    ][28056] Starting a new job with PID 28056
