2017-12-03 10:52:40,051 [salt.cli.daemons ][WARNING ][2177] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-12-03 10:53:22,433 [salt.state       ][ERROR   ][3655] No contents found in top file
2017-12-03 10:55:04,148 [salt.utils.parsers][WARNING ][2177] Minion received a SIGTERM. Exiting.
2017-12-03 10:59:30,868 [salt.cli.daemons ][WARNING ][3294] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-12-03 11:01:55,028 [py.warnings      ][WARNING ][14442] /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 11:09:17,288 [salt.loaded.int.module.cmdmod][ERROR   ][14442] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-12-03 11:09:17,289 [salt.loaded.int.module.cmdmod][ERROR   ][14442] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-12-03 11:09:21,994 [salt.loaded.int.module.cmdmod][ERROR   ][14442] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-12-03 11:09:21,994 [salt.loaded.int.module.cmdmod][ERROR   ][14442] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-12-03 11:09:26,340 [salt.loaded.int.module.cmdmod][ERROR   ][14442] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-12-03 11:09:26,340 [salt.loaded.int.module.cmdmod][ERROR   ][14442] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-12-03 11:09:30,519 [salt.loaded.int.module.cmdmod][ERROR   ][14442] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-12-03 11:09:30,519 [salt.loaded.int.module.cmdmod][ERROR   ][14442] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-12-03 11:09:34,850 [salt.loaded.int.module.cmdmod][ERROR   ][14442] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-12-03 11:09:34,851 [salt.loaded.int.module.cmdmod][ERROR   ][14442] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-12-03 11:09:38,425 [salt.loaded.int.module.cmdmod][ERROR   ][14442] 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 11:09:41,002 [salt.loaded.int.module.cmdmod][INFO    ][22177] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2017-12-03 11:09:41,010 [salt.loaded.int.module.cmdmod][INFO    ][22177] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2017-12-03 11:09:41,019 [salt.loaded.int.module.cmdmod][INFO    ][22177] Executing command ['systemd-run', '--scope', 'systemctl', 'restart', 'salt-minion.service'] in directory '/root'
2017-12-03 11:09:41,027 [salt.utils.parsers][WARNING ][3294] Minion received a SIGTERM. Exiting.
2017-12-03 11:09:41,347 [salt.cli.daemons ][INFO    ][22250] Setting up the Salt Minion "kvm01.baremetal-mcp-ocata-odl-ha.local"
2017-12-03 11:09:42,012 [salt.minion      ][INFO    ][22250] Creating minion process manager
2017-12-03 11:09:42,013 [salt.cli.daemons ][WARNING ][22250] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-12-03 11:09:42,013 [salt.cli.daemons ][INFO    ][22250] The Salt Minion is starting up
2017-12-03 11:09:42,013 [salt.minion      ][INFO    ][22250] Minion is starting as user 'root'
2017-12-03 11:09:42,014 [salt.utils.event ][INFO    ][22250] Starting pull socket on /var/run/salt/minion/minion_event_127643860a_pull.ipc
2017-12-03 11:09:43,161 [salt.loaded.int.module.cmdmod][INFO    ][22250] Executing command ['date', '+%z'] in directory '/root'
2017-12-03 11:09:43,175 [salt.utils.schedule][INFO    ][22250] Updating job settings for scheduled job: __mine_interval
2017-12-03 11:09:43,179 [salt.minion      ][INFO    ][22250] Added mine.update to scheduler
2017-12-03 11:09:43,206 [salt.minion      ][INFO    ][22250] Minion is ready to receive requests!
2017-12-03 11:09:44,207 [salt.utils.schedule][INFO    ][22250] Running scheduled job: __mine_interval
2017-12-03 11:12:10,239 [salt.minion      ][INFO    ][22250] User sudo_ubuntu Executing command saltutil.sync_all with jid 20171203111210231332
2017-12-03 11:12:10,251 [salt.minion      ][INFO    ][22378] Starting a new job with PID 22378
2017-12-03 11:12:12,886 [salt.state       ][INFO    ][22378] Loading fresh modules for state activity
2017-12-03 11:12:12,912 [salt.state       ][ERROR   ][22378] No contents found in top file
2017-12-03 11:12:12,913 [salt.utils.extmods][INFO    ][22378] Creating module dir '/var/cache/salt/minion/extmods/beacons'
2017-12-03 11:12:12,916 [salt.utils.extmods][INFO    ][22378] Syncing beacons for environment 'base'
2017-12-03 11:12:12,916 [salt.utils.extmods][INFO    ][22378] Loading cache from salt://_beacons, for base)
2017-12-03 11:12:12,916 [salt.fileclient  ][INFO    ][22378] Caching directory '_beacons/' for environment 'base'
2017-12-03 11:12:12,963 [salt.utils.extmods][INFO    ][22378] Syncing modules for environment 'base'
2017-12-03 11:12:12,963 [salt.utils.extmods][INFO    ][22378] Loading cache from salt://_modules, for base)
2017-12-03 11:12:12,963 [salt.fileclient  ][INFO    ][22378] Caching directory '_modules/' for environment 'base'
2017-12-03 11:12:13,017 [salt.fileclient  ][INFO    ][22378] Fetching file from saltenv 'base', ** done ** '_modules/avinetworks.py'
2017-12-03 11:12:13,029 [salt.fileclient  ][INFO    ][22378] Fetching file from saltenv 'base', ** done ** '_modules/ceph_ng.py'
2017-12-03 11:12:13,041 [salt.fileclient  ][INFO    ][22378] Fetching file from saltenv 'base', ** done ** '_modules/cinderng.py'
2017-12-03 11:12:13,053 [salt.fileclient  ][INFO    ][22378] Fetching file from saltenv 'base', ** done ** '_modules/contrail.py'
2017-12-03 11:12:13,065 [salt.fileclient  ][INFO    ][22378] Fetching file from saltenv 'base', ** done ** '_modules/creds.py'
2017-12-03 11:12:13,077 [salt.fileclient  ][INFO    ][22378] Fetching file from saltenv 'base', ** done ** '_modules/devops_utils.py'
2017-12-03 11:12:13,091 [salt.fileclient  ][INFO    ][22378] Fetching file from saltenv 'base', ** done ** '_modules/encode_json.py'
2017-12-03 11:12:13,103 [salt.fileclient  ][INFO    ][22378] Fetching file from saltenv 'base', ** done ** '_modules/gerrit.py'
2017-12-03 11:12:13,117 [salt.fileclient  ][INFO    ][22378] Fetching file from saltenv 'base', ** done ** '_modules/glanceng.py'
2017-12-03 11:12:13,128 [salt.fileclient  ][INFO    ][22378] Fetching file from saltenv 'base', ** done ** '_modules/heat.py'
2017-12-03 11:12:13,140 [salt.fileclient  ][INFO    ][22378] Fetching file from saltenv 'base', ** done ** '_modules/heka_alarming.py'
2017-12-03 11:12:13,154 [salt.fileclient  ][INFO    ][22378] Fetching file from saltenv 'base', ** done ** '_modules/helm.py'
2017-12-03 11:12:13,164 [salt.fileclient  ][INFO    ][22378] Fetching file from saltenv 'base', ** done ** '_modules/jenkins_common.py'
2017-12-03 11:12:13,176 [salt.fileclient  ][INFO    ][22378] Fetching file from saltenv 'base', ** done ** '_modules/keystone_policy.py'
2017-12-03 11:12:13,187 [salt.fileclient  ][INFO    ][22378] Fetching file from saltenv 'base', ** done ** '_modules/linux_hosts.py'
2017-12-03 11:12:13,196 [salt.fileclient  ][INFO    ][22378] Fetching file from saltenv 'base', ** done ** '_modules/linux_netlink.py'
2017-12-03 11:12:13,207 [salt.fileclient  ][INFO    ][22378] Fetching file from saltenv 'base', ** done ** '_modules/maas.py'
2017-12-03 11:12:13,219 [salt.fileclient  ][INFO    ][22378] Fetching file from saltenv 'base', ** done ** '_modules/maas_client.py'
2017-12-03 11:12:13,229 [salt.fileclient  ][INFO    ][22378] Fetching file from saltenv 'base', ** done ** '_modules/modelutils.py'
2017-12-03 11:12:13,241 [salt.fileclient  ][INFO    ][22378] Fetching file from saltenv 'base', ** done ** '_modules/multipart.py'
2017-12-03 11:12:13,250 [salt.fileclient  ][INFO    ][22378] Fetching file from saltenv 'base', ** done ** '_modules/nagios_alarming.py'
2017-12-03 11:12:13,265 [salt.fileclient  ][INFO    ][22378] Fetching file from saltenv 'base', ** done ** '_modules/neutronng.py'
2017-12-03 11:12:13,279 [salt.fileclient  ][INFO    ][22378] Fetching file from saltenv 'base', ** done ** '_modules/novang.py'
2017-12-03 11:12:13,291 [salt.fileclient  ][INFO    ][22378] Fetching file from saltenv 'base', ** done ** '_modules/reclass.py'
2017-12-03 11:12:13,301 [salt.fileclient  ][INFO    ][22378] Fetching file from saltenv 'base', ** done ** '_modules/rsyslog_util.py'
2017-12-03 11:12:13,312 [salt.fileclient  ][INFO    ][22378] Fetching file from saltenv 'base', ** done ** '_modules/rundeck.py'
2017-12-03 11:12:13,321 [salt.fileclient  ][INFO    ][22378] Fetching file from saltenv 'base', ** done ** '_modules/saltkey.py'
2017-12-03 11:12:13,331 [salt.fileclient  ][INFO    ][22378] Fetching file from saltenv 'base', ** done ** '_modules/saltresource.py'
2017-12-03 11:12:13,340 [salt.fileclient  ][INFO    ][22378] Fetching file from saltenv 'base', ** done ** '_modules/seedng.py'
2017-12-03 11:12:13,364 [salt.fileclient  ][INFO    ][22378] Fetching file from saltenv 'base', ** done ** '_modules/testing/credentials.py'
2017-12-03 11:12:13,373 [salt.fileclient  ][INFO    ][22378] Fetching file from saltenv 'base', ** done ** '_modules/testing/django.py'
2017-12-03 11:12:13,384 [salt.fileclient  ][INFO    ][22378] Fetching file from saltenv 'base', ** done ** '_modules/testing/django_client_proxy.py'
2017-12-03 11:12:13,392 [salt.fileclient  ][INFO    ][22378] Fetching file from saltenv 'base', ** done ** '_modules/utils.py'
2017-12-03 11:12:13,410 [salt.fileclient  ][INFO    ][22378] Fetching file from saltenv 'base', ** done ** '_modules/virtng.py'
2017-12-03 11:12:13,413 [salt.utils.extmods][INFO    ][22378] Copying '/var/cache/salt/minion/files/base/_modules/__init__.py' to '/var/cache/salt/minion/extmods/modules/__init__.py'
2017-12-03 11:12:13,414 [salt.utils.extmods][INFO    ][22378] Copying '/var/cache/salt/minion/files/base/_modules/avinetworks.py' to '/var/cache/salt/minion/extmods/modules/avinetworks.py'
2017-12-03 11:12:13,414 [salt.utils.extmods][INFO    ][22378] Copying '/var/cache/salt/minion/files/base/_modules/ceph_ng.py' to '/var/cache/salt/minion/extmods/modules/ceph_ng.py'
2017-12-03 11:12:13,414 [salt.utils.extmods][INFO    ][22378] Copying '/var/cache/salt/minion/files/base/_modules/cinderng.py' to '/var/cache/salt/minion/extmods/modules/cinderng.py'
2017-12-03 11:12:13,414 [salt.utils.extmods][INFO    ][22378] Copying '/var/cache/salt/minion/files/base/_modules/contrail.py' to '/var/cache/salt/minion/extmods/modules/contrail.py'
2017-12-03 11:12:13,415 [salt.utils.extmods][INFO    ][22378] Copying '/var/cache/salt/minion/files/base/_modules/creds.py' to '/var/cache/salt/minion/extmods/modules/creds.py'
2017-12-03 11:12:13,415 [salt.utils.extmods][INFO    ][22378] Copying '/var/cache/salt/minion/files/base/_modules/devops_utils.py' to '/var/cache/salt/minion/extmods/modules/devops_utils.py'
2017-12-03 11:12:13,415 [salt.utils.extmods][INFO    ][22378] Copying '/var/cache/salt/minion/files/base/_modules/encode_json.py' to '/var/cache/salt/minion/extmods/modules/encode_json.py'
2017-12-03 11:12:13,415 [salt.utils.extmods][INFO    ][22378] Copying '/var/cache/salt/minion/files/base/_modules/gerrit.py' to '/var/cache/salt/minion/extmods/modules/gerrit.py'
2017-12-03 11:12:13,416 [salt.utils.extmods][INFO    ][22378] Copying '/var/cache/salt/minion/files/base/_modules/glanceng.py' to '/var/cache/salt/minion/extmods/modules/glanceng.py'
2017-12-03 11:12:13,416 [salt.utils.extmods][INFO    ][22378] Copying '/var/cache/salt/minion/files/base/_modules/heat.py' to '/var/cache/salt/minion/extmods/modules/heat.py'
2017-12-03 11:12:13,416 [salt.utils.extmods][INFO    ][22378] Copying '/var/cache/salt/minion/files/base/_modules/heka_alarming.py' to '/var/cache/salt/minion/extmods/modules/heka_alarming.py'
2017-12-03 11:12:13,416 [salt.utils.extmods][INFO    ][22378] Copying '/var/cache/salt/minion/files/base/_modules/helm.py' to '/var/cache/salt/minion/extmods/modules/helm.py'
2017-12-03 11:12:13,417 [salt.utils.extmods][INFO    ][22378] Copying '/var/cache/salt/minion/files/base/_modules/jenkins_common.py' to '/var/cache/salt/minion/extmods/modules/jenkins_common.py'
2017-12-03 11:12:13,417 [salt.utils.extmods][INFO    ][22378] Copying '/var/cache/salt/minion/files/base/_modules/keystone_policy.py' to '/var/cache/salt/minion/extmods/modules/keystone_policy.py'
2017-12-03 11:12:13,417 [salt.utils.extmods][INFO    ][22378] Copying '/var/cache/salt/minion/files/base/_modules/linux_hosts.py' to '/var/cache/salt/minion/extmods/modules/linux_hosts.py'
2017-12-03 11:12:13,417 [salt.utils.extmods][INFO    ][22378] Copying '/var/cache/salt/minion/files/base/_modules/linux_netlink.py' to '/var/cache/salt/minion/extmods/modules/linux_netlink.py'
2017-12-03 11:12:13,418 [salt.utils.extmods][INFO    ][22378] Copying '/var/cache/salt/minion/files/base/_modules/maas.py' to '/var/cache/salt/minion/extmods/modules/maas.py'
2017-12-03 11:12:13,418 [salt.utils.extmods][INFO    ][22378] Copying '/var/cache/salt/minion/files/base/_modules/maas_client.py' to '/var/cache/salt/minion/extmods/modules/maas_client.py'
2017-12-03 11:12:13,418 [salt.utils.extmods][INFO    ][22378] Copying '/var/cache/salt/minion/files/base/_modules/modelutils.py' to '/var/cache/salt/minion/extmods/modules/modelutils.py'
2017-12-03 11:12:13,418 [salt.utils.extmods][INFO    ][22378] Copying '/var/cache/salt/minion/files/base/_modules/multipart.py' to '/var/cache/salt/minion/extmods/modules/multipart.py'
2017-12-03 11:12:13,419 [salt.utils.extmods][INFO    ][22378] Copying '/var/cache/salt/minion/files/base/_modules/nagios_alarming.py' to '/var/cache/salt/minion/extmods/modules/nagios_alarming.py'
2017-12-03 11:12:13,419 [salt.utils.extmods][INFO    ][22378] Copying '/var/cache/salt/minion/files/base/_modules/neutronng.py' to '/var/cache/salt/minion/extmods/modules/neutronng.py'
2017-12-03 11:12:13,419 [salt.utils.extmods][INFO    ][22378] Copying '/var/cache/salt/minion/files/base/_modules/novang.py' to '/var/cache/salt/minion/extmods/modules/novang.py'
2017-12-03 11:12:13,420 [salt.utils.extmods][INFO    ][22378] Copying '/var/cache/salt/minion/files/base/_modules/reclass.py' to '/var/cache/salt/minion/extmods/modules/reclass.py'
2017-12-03 11:12:13,420 [salt.utils.extmods][INFO    ][22378] Copying '/var/cache/salt/minion/files/base/_modules/rsyslog_util.py' to '/var/cache/salt/minion/extmods/modules/rsyslog_util.py'
2017-12-03 11:12:13,420 [salt.utils.extmods][INFO    ][22378] Copying '/var/cache/salt/minion/files/base/_modules/rundeck.py' to '/var/cache/salt/minion/extmods/modules/rundeck.py'
2017-12-03 11:12:13,420 [salt.utils.extmods][INFO    ][22378] Copying '/var/cache/salt/minion/files/base/_modules/saltkey.py' to '/var/cache/salt/minion/extmods/modules/saltkey.py'
2017-12-03 11:12:13,421 [salt.utils.extmods][INFO    ][22378] Copying '/var/cache/salt/minion/files/base/_modules/saltresource.py' to '/var/cache/salt/minion/extmods/modules/saltresource.py'
2017-12-03 11:12:13,421 [salt.utils.extmods][INFO    ][22378] Copying '/var/cache/salt/minion/files/base/_modules/seedng.py' to '/var/cache/salt/minion/extmods/modules/seedng.py'
2017-12-03 11:12:13,421 [salt.utils.extmods][INFO    ][22378] Copying '/var/cache/salt/minion/files/base/_modules/testing/__init__.py' to '/var/cache/salt/minion/extmods/modules/testing/__init__.py'
2017-12-03 11:12:13,421 [salt.utils.extmods][INFO    ][22378] Copying '/var/cache/salt/minion/files/base/_modules/testing/credentials.py' to '/var/cache/salt/minion/extmods/modules/testing/credentials.py'
2017-12-03 11:12:13,422 [salt.utils.extmods][INFO    ][22378] Copying '/var/cache/salt/minion/files/base/_modules/testing/django.py' to '/var/cache/salt/minion/extmods/modules/testing/django.py'
2017-12-03 11:12:13,422 [salt.utils.extmods][INFO    ][22378] 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 11:12:13,422 [salt.utils.extmods][INFO    ][22378] Copying '/var/cache/salt/minion/files/base/_modules/utils.py' to '/var/cache/salt/minion/extmods/modules/utils.py'
2017-12-03 11:12:13,422 [salt.utils.extmods][INFO    ][22378] Copying '/var/cache/salt/minion/files/base/_modules/virtng.py' to '/var/cache/salt/minion/extmods/modules/virtng.py'
2017-12-03 11:12:13,428 [salt.utils.extmods][INFO    ][22378] Syncing states for environment 'base'
2017-12-03 11:12:13,428 [salt.utils.extmods][INFO    ][22378] Loading cache from salt://_states, for base)
2017-12-03 11:12:13,428 [salt.fileclient  ][INFO    ][22378] Caching directory '_states/' for environment 'base'
2017-12-03 11:12:13,465 [salt.fileclient  ][INFO    ][22378] Fetching file from saltenv 'base', ** done ** '_states/avinetworks.py'
2017-12-03 11:12:13,476 [salt.fileclient  ][INFO    ][22378] Fetching file from saltenv 'base', ** done ** '_states/cinderng.py'
2017-12-03 11:12:13,488 [salt.fileclient  ][INFO    ][22378] Fetching file from saltenv 'base', ** done ** '_states/contrail.py'
2017-12-03 11:12:13,500 [salt.fileclient  ][INFO    ][22378] Fetching file from saltenv 'base', ** done ** '_states/gerrit.py'
2017-12-03 11:12:13,509 [salt.fileclient  ][INFO    ][22378] Fetching file from saltenv 'base', ** done ** '_states/glanceng.py'
2017-12-03 11:12:13,520 [salt.fileclient  ][INFO    ][22378] Fetching file from saltenv 'base', ** done ** '_states/grafana3_dashboard.py'
2017-12-03 11:12:13,529 [salt.fileclient  ][INFO    ][22378] Fetching file from saltenv 'base', ** done ** '_states/grafana3_datasource.py'
2017-12-03 11:12:13,540 [salt.fileclient  ][INFO    ][22378] Fetching file from saltenv 'base', ** done ** '_states/heat.py'
2017-12-03 11:12:13,553 [salt.fileclient  ][INFO    ][22378] Fetching file from saltenv 'base', ** done ** '_states/helm_release.py'
2017-12-03 11:12:13,562 [salt.fileclient  ][INFO    ][22378] Fetching file from saltenv 'base', ** done ** '_states/helm_repos.py'
2017-12-03 11:12:13,571 [salt.fileclient  ][INFO    ][22378] Fetching file from saltenv 'base', ** done ** '_states/jenkins_approval.py'
2017-12-03 11:12:13,580 [salt.fileclient  ][INFO    ][22378] Fetching file from saltenv 'base', ** done ** '_states/jenkins_artifactory.py'
2017-12-03 11:12:13,588 [salt.fileclient  ][INFO    ][22378] Fetching file from saltenv 'base', ** done ** '_states/jenkins_credential.py'
2017-12-03 11:12:13,597 [salt.fileclient  ][INFO    ][22378] Fetching file from saltenv 'base', ** done ** '_states/jenkins_globalenvprop.py'
2017-12-03 11:12:13,606 [salt.fileclient  ][INFO    ][22378] Fetching file from saltenv 'base', ** done ** '_states/jenkins_job.py'
2017-12-03 11:12:13,615 [salt.fileclient  ][INFO    ][22378] Fetching file from saltenv 'base', ** done ** '_states/jenkins_lib.py'
2017-12-03 11:12:13,624 [salt.fileclient  ][INFO    ][22378] Fetching file from saltenv 'base', ** done ** '_states/jenkins_node.py'
2017-12-03 11:12:13,933 [salt.fileclient  ][INFO    ][22378] Fetching file from saltenv 'base', ** done ** '_states/jenkins_plugin.py'
2017-12-03 11:12:13,948 [salt.fileclient  ][INFO    ][22378] Fetching file from saltenv 'base', ** done ** '_states/jenkins_security.py'
2017-12-03 11:12:13,958 [salt.fileclient  ][INFO    ][22378] Fetching file from saltenv 'base', ** done ** '_states/jenkins_slack.py'
2017-12-03 11:12:13,968 [salt.fileclient  ][INFO    ][22378] Fetching file from saltenv 'base', ** done ** '_states/jenkins_smtp.py'
2017-12-03 11:12:13,979 [salt.fileclient  ][INFO    ][22378] Fetching file from saltenv 'base', ** done ** '_states/jenkins_theme.py'
2017-12-03 11:12:13,989 [salt.fileclient  ][INFO    ][22378] Fetching file from saltenv 'base', ** done ** '_states/jenkins_user.py'
2017-12-03 11:12:14,001 [salt.fileclient  ][INFO    ][22378] Fetching file from saltenv 'base', ** done ** '_states/jenkins_view.py'
2017-12-03 11:12:14,017 [salt.fileclient  ][INFO    ][22378] Fetching file from saltenv 'base', ** done ** '_states/keystone_policy.py'
2017-12-03 11:12:14,030 [salt.fileclient  ][INFO    ][22378] Fetching file from saltenv 'base', ** done ** '_states/kibana_object.py'
2017-12-03 11:12:14,049 [salt.fileclient  ][INFO    ][22378] Fetching file from saltenv 'base', ** done ** '_states/neutronng.py'
2017-12-03 11:12:14,062 [salt.fileclient  ][INFO    ][22378] Fetching file from saltenv 'base', ** done ** '_states/novang.py'
2017-12-03 11:12:14,076 [salt.fileclient  ][INFO    ][22378] Fetching file from saltenv 'base', ** done ** '_states/reclass.py'
2017-12-03 11:12:14,090 [salt.fileclient  ][INFO    ][22378] Fetching file from saltenv 'base', ** done ** '_states/rundeck_project.py'
2017-12-03 11:12:14,101 [salt.fileclient  ][INFO    ][22378] Fetching file from saltenv 'base', ** done ** '_states/rundeck_scm.py'
2017-12-03 11:12:14,115 [salt.fileclient  ][INFO    ][22378] Fetching file from saltenv 'base', ** done ** '_states/rundeck_secret.py'
2017-12-03 11:12:14,122 [salt.utils.extmods][INFO    ][22378] Copying '/var/cache/salt/minion/files/base/_states/avinetworks.py' to '/var/cache/salt/minion/extmods/states/avinetworks.py'
2017-12-03 11:12:14,122 [salt.utils.extmods][INFO    ][22378] Copying '/var/cache/salt/minion/files/base/_states/cinderng.py' to '/var/cache/salt/minion/extmods/states/cinderng.py'
2017-12-03 11:12:14,123 [salt.utils.extmods][INFO    ][22378] Copying '/var/cache/salt/minion/files/base/_states/contrail.py' to '/var/cache/salt/minion/extmods/states/contrail.py'
2017-12-03 11:12:14,123 [salt.utils.extmods][INFO    ][22378] Copying '/var/cache/salt/minion/files/base/_states/gerrit.py' to '/var/cache/salt/minion/extmods/states/gerrit.py'
2017-12-03 11:12:14,123 [salt.utils.extmods][INFO    ][22378] Copying '/var/cache/salt/minion/files/base/_states/glanceng.py' to '/var/cache/salt/minion/extmods/states/glanceng.py'
2017-12-03 11:12:14,124 [salt.utils.extmods][INFO    ][22378] Copying '/var/cache/salt/minion/files/base/_states/grafana3_dashboard.py' to '/var/cache/salt/minion/extmods/states/grafana3_dashboard.py'
2017-12-03 11:12:14,124 [salt.utils.extmods][INFO    ][22378] Copying '/var/cache/salt/minion/files/base/_states/grafana3_datasource.py' to '/var/cache/salt/minion/extmods/states/grafana3_datasource.py'
2017-12-03 11:12:14,125 [salt.utils.extmods][INFO    ][22378] Copying '/var/cache/salt/minion/files/base/_states/heat.py' to '/var/cache/salt/minion/extmods/states/heat.py'
2017-12-03 11:12:14,125 [salt.utils.extmods][INFO    ][22378] Copying '/var/cache/salt/minion/files/base/_states/helm_release.py' to '/var/cache/salt/minion/extmods/states/helm_release.py'
2017-12-03 11:12:14,125 [salt.utils.extmods][INFO    ][22378] Copying '/var/cache/salt/minion/files/base/_states/helm_repos.py' to '/var/cache/salt/minion/extmods/states/helm_repos.py'
2017-12-03 11:12:14,125 [salt.utils.extmods][INFO    ][22378] Copying '/var/cache/salt/minion/files/base/_states/jenkins_approval.py' to '/var/cache/salt/minion/extmods/states/jenkins_approval.py'
2017-12-03 11:12:14,126 [salt.utils.extmods][INFO    ][22378] Copying '/var/cache/salt/minion/files/base/_states/jenkins_artifactory.py' to '/var/cache/salt/minion/extmods/states/jenkins_artifactory.py'
2017-12-03 11:12:14,126 [salt.utils.extmods][INFO    ][22378] Copying '/var/cache/salt/minion/files/base/_states/jenkins_credential.py' to '/var/cache/salt/minion/extmods/states/jenkins_credential.py'
2017-12-03 11:12:14,126 [salt.utils.extmods][INFO    ][22378] Copying '/var/cache/salt/minion/files/base/_states/jenkins_globalenvprop.py' to '/var/cache/salt/minion/extmods/states/jenkins_globalenvprop.py'
2017-12-03 11:12:14,127 [salt.utils.extmods][INFO    ][22378] Copying '/var/cache/salt/minion/files/base/_states/jenkins_job.py' to '/var/cache/salt/minion/extmods/states/jenkins_job.py'
2017-12-03 11:12:14,127 [salt.utils.extmods][INFO    ][22378] Copying '/var/cache/salt/minion/files/base/_states/jenkins_lib.py' to '/var/cache/salt/minion/extmods/states/jenkins_lib.py'
2017-12-03 11:12:14,127 [salt.utils.extmods][INFO    ][22378] Copying '/var/cache/salt/minion/files/base/_states/jenkins_node.py' to '/var/cache/salt/minion/extmods/states/jenkins_node.py'
2017-12-03 11:12:14,128 [salt.utils.extmods][INFO    ][22378] Copying '/var/cache/salt/minion/files/base/_states/jenkins_plugin.py' to '/var/cache/salt/minion/extmods/states/jenkins_plugin.py'
2017-12-03 11:12:14,128 [salt.utils.extmods][INFO    ][22378] Copying '/var/cache/salt/minion/files/base/_states/jenkins_security.py' to '/var/cache/salt/minion/extmods/states/jenkins_security.py'
2017-12-03 11:12:14,128 [salt.utils.extmods][INFO    ][22378] Copying '/var/cache/salt/minion/files/base/_states/jenkins_slack.py' to '/var/cache/salt/minion/extmods/states/jenkins_slack.py'
2017-12-03 11:12:14,129 [salt.utils.extmods][INFO    ][22378] Copying '/var/cache/salt/minion/files/base/_states/jenkins_smtp.py' to '/var/cache/salt/minion/extmods/states/jenkins_smtp.py'
2017-12-03 11:12:14,129 [salt.utils.extmods][INFO    ][22378] Copying '/var/cache/salt/minion/files/base/_states/jenkins_theme.py' to '/var/cache/salt/minion/extmods/states/jenkins_theme.py'
2017-12-03 11:12:14,129 [salt.utils.extmods][INFO    ][22378] Copying '/var/cache/salt/minion/files/base/_states/jenkins_user.py' to '/var/cache/salt/minion/extmods/states/jenkins_user.py'
2017-12-03 11:12:14,129 [salt.utils.extmods][INFO    ][22378] Copying '/var/cache/salt/minion/files/base/_states/jenkins_view.py' to '/var/cache/salt/minion/extmods/states/jenkins_view.py'
2017-12-03 11:12:14,130 [salt.utils.extmods][INFO    ][22378] Copying '/var/cache/salt/minion/files/base/_states/keystone_policy.py' to '/var/cache/salt/minion/extmods/states/keystone_policy.py'
2017-12-03 11:12:14,130 [salt.utils.extmods][INFO    ][22378] Copying '/var/cache/salt/minion/files/base/_states/kibana_object.py' to '/var/cache/salt/minion/extmods/states/kibana_object.py'
2017-12-03 11:12:14,130 [salt.utils.extmods][INFO    ][22378] Copying '/var/cache/salt/minion/files/base/_states/maas_cluster.py' to '/var/cache/salt/minion/extmods/states/maas_cluster.py'
2017-12-03 11:12:14,131 [salt.utils.extmods][INFO    ][22378] Copying '/var/cache/salt/minion/files/base/_states/neutronng.py' to '/var/cache/salt/minion/extmods/states/neutronng.py'
2017-12-03 11:12:14,131 [salt.utils.extmods][INFO    ][22378] Copying '/var/cache/salt/minion/files/base/_states/novang.py' to '/var/cache/salt/minion/extmods/states/novang.py'
2017-12-03 11:12:14,131 [salt.utils.extmods][INFO    ][22378] Copying '/var/cache/salt/minion/files/base/_states/reclass.py' to '/var/cache/salt/minion/extmods/states/reclass.py'
2017-12-03 11:12:14,132 [salt.utils.extmods][INFO    ][22378] Copying '/var/cache/salt/minion/files/base/_states/rundeck_project.py' to '/var/cache/salt/minion/extmods/states/rundeck_project.py'
2017-12-03 11:12:14,132 [salt.utils.extmods][INFO    ][22378] Copying '/var/cache/salt/minion/files/base/_states/rundeck_scm.py' to '/var/cache/salt/minion/extmods/states/rundeck_scm.py'
2017-12-03 11:12:14,132 [salt.utils.extmods][INFO    ][22378] Copying '/var/cache/salt/minion/files/base/_states/rundeck_secret.py' to '/var/cache/salt/minion/extmods/states/rundeck_secret.py'
2017-12-03 11:12:14,136 [salt.utils.extmods][INFO    ][22378] Creating module dir '/var/cache/salt/minion/extmods/sdb'
2017-12-03 11:12:14,140 [salt.utils.extmods][INFO    ][22378] Syncing sdb for environment 'base'
2017-12-03 11:12:14,140 [salt.utils.extmods][INFO    ][22378] Loading cache from salt://_sdb, for base)
2017-12-03 11:12:14,140 [salt.fileclient  ][INFO    ][22378] Caching directory '_sdb/' for environment 'base'
2017-12-03 11:12:14,176 [salt.utils.extmods][INFO    ][22378] Syncing grains for environment 'base'
2017-12-03 11:12:14,177 [salt.utils.extmods][INFO    ][22378] Loading cache from salt://_grains, for base)
2017-12-03 11:12:14,177 [salt.fileclient  ][INFO    ][22378] Caching directory '_grains/' for environment 'base'
2017-12-03 11:12:14,227 [salt.fileclient  ][INFO    ][22378] Fetching file from saltenv 'base', ** done ** '_grains/ceilometer_policy.py'
2017-12-03 11:12:14,237 [salt.fileclient  ][INFO    ][22378] Fetching file from saltenv 'base', ** done ** '_grains/ceph.py'
2017-12-03 11:12:14,253 [salt.fileclient  ][INFO    ][22378] Fetching file from saltenv 'base', ** done ** '_grains/cinder_policy.py'
2017-12-03 11:12:14,267 [salt.fileclient  ][INFO    ][22378] Fetching file from saltenv 'base', ** done ** '_grains/docker_swarm.py'
2017-12-03 11:12:14,281 [salt.fileclient  ][INFO    ][22378] Fetching file from saltenv 'base', ** done ** '_grains/glance_policy.py'
2017-12-03 11:12:14,302 [salt.fileclient  ][INFO    ][22378] Fetching file from saltenv 'base', ** done ** '_grains/heat_policy.py'
2017-12-03 11:12:14,315 [salt.fileclient  ][INFO    ][22378] Fetching file from saltenv 'base', ** done ** '_grains/jenkins_plugins.py'
2017-12-03 11:12:14,327 [salt.fileclient  ][INFO    ][22378] Fetching file from saltenv 'base', ** done ** '_grains/keystone_policy.py'
2017-12-03 11:12:14,337 [salt.fileclient  ][INFO    ][22378] Fetching file from saltenv 'base', ** done ** '_grains/kubernetes.py'
2017-12-03 11:12:14,347 [salt.fileclient  ][INFO    ][22378] Fetching file from saltenv 'base', ** done ** '_grains/neutron_policy.py'
2017-12-03 11:12:14,357 [salt.fileclient  ][INFO    ][22378] Fetching file from saltenv 'base', ** done ** '_grains/nova_policy.py'
2017-12-03 11:12:14,370 [salt.fileclient  ][INFO    ][22378] Fetching file from saltenv 'base', ** done ** '_grains/ssh_fingerprints.py'
2017-12-03 11:12:14,373 [salt.utils.extmods][INFO    ][22378] Copying '/var/cache/salt/minion/files/base/_grains/ceilometer_policy.py' to '/var/cache/salt/minion/extmods/grains/ceilometer_policy.py'
2017-12-03 11:12:14,374 [salt.utils.extmods][INFO    ][22378] Copying '/var/cache/salt/minion/files/base/_grains/ceph.py' to '/var/cache/salt/minion/extmods/grains/ceph.py'
2017-12-03 11:12:14,374 [salt.utils.extmods][INFO    ][22378] Copying '/var/cache/salt/minion/files/base/_grains/cinder_policy.py' to '/var/cache/salt/minion/extmods/grains/cinder_policy.py'
2017-12-03 11:12:14,374 [salt.utils.extmods][INFO    ][22378] Copying '/var/cache/salt/minion/files/base/_grains/docker_swarm.py' to '/var/cache/salt/minion/extmods/grains/docker_swarm.py'
2017-12-03 11:12:14,374 [salt.utils.extmods][INFO    ][22378] Copying '/var/cache/salt/minion/files/base/_grains/glance_policy.py' to '/var/cache/salt/minion/extmods/grains/glance_policy.py'
2017-12-03 11:12:14,374 [salt.utils.extmods][INFO    ][22378] Copying '/var/cache/salt/minion/files/base/_grains/heat_policy.py' to '/var/cache/salt/minion/extmods/grains/heat_policy.py'
2017-12-03 11:12:14,375 [salt.utils.extmods][INFO    ][22378] Copying '/var/cache/salt/minion/files/base/_grains/jenkins_plugins.py' to '/var/cache/salt/minion/extmods/grains/jenkins_plugins.py'
2017-12-03 11:12:14,375 [salt.utils.extmods][INFO    ][22378] Copying '/var/cache/salt/minion/files/base/_grains/keystone_policy.py' to '/var/cache/salt/minion/extmods/grains/keystone_policy.py'
2017-12-03 11:12:14,375 [salt.utils.extmods][INFO    ][22378] Copying '/var/cache/salt/minion/files/base/_grains/kubernetes.py' to '/var/cache/salt/minion/extmods/grains/kubernetes.py'
2017-12-03 11:12:14,375 [salt.utils.extmods][INFO    ][22378] Copying '/var/cache/salt/minion/files/base/_grains/neutron_policy.py' to '/var/cache/salt/minion/extmods/grains/neutron_policy.py'
2017-12-03 11:12:14,376 [salt.utils.extmods][INFO    ][22378] Copying '/var/cache/salt/minion/files/base/_grains/nova_policy.py' to '/var/cache/salt/minion/extmods/grains/nova_policy.py'
2017-12-03 11:12:14,376 [salt.utils.extmods][INFO    ][22378] Copying '/var/cache/salt/minion/files/base/_grains/ssh_fingerprints.py' to '/var/cache/salt/minion/extmods/grains/ssh_fingerprints.py'
2017-12-03 11:12:14,377 [salt.utils.extmods][INFO    ][22378] Creating module dir '/var/cache/salt/minion/extmods/renderers'
2017-12-03 11:12:14,380 [salt.utils.extmods][INFO    ][22378] Syncing renderers for environment 'base'
2017-12-03 11:12:14,380 [salt.utils.extmods][INFO    ][22378] Loading cache from salt://_renderers, for base)
2017-12-03 11:12:14,381 [salt.fileclient  ][INFO    ][22378] Caching directory '_renderers/' for environment 'base'
2017-12-03 11:12:14,418 [salt.utils.extmods][INFO    ][22378] Creating module dir '/var/cache/salt/minion/extmods/returners'
2017-12-03 11:12:14,421 [salt.utils.extmods][INFO    ][22378] Syncing returners for environment 'base'
2017-12-03 11:12:14,421 [salt.utils.extmods][INFO    ][22378] Loading cache from salt://_returners, for base)
2017-12-03 11:12:14,421 [salt.fileclient  ][INFO    ][22378] Caching directory '_returners/' for environment 'base'
2017-12-03 11:12:14,452 [salt.utils.extmods][INFO    ][22378] Creating module dir '/var/cache/salt/minion/extmods/output'
2017-12-03 11:12:14,455 [salt.utils.extmods][INFO    ][22378] Syncing output for environment 'base'
2017-12-03 11:12:14,455 [salt.utils.extmods][INFO    ][22378] Loading cache from salt://_output, for base)
2017-12-03 11:12:14,455 [salt.fileclient  ][INFO    ][22378] Caching directory '_output/' for environment 'base'
2017-12-03 11:12:14,487 [salt.utils.extmods][INFO    ][22378] Creating module dir '/var/cache/salt/minion/extmods/utils'
2017-12-03 11:12:14,490 [salt.utils.extmods][INFO    ][22378] Syncing utils for environment 'base'
2017-12-03 11:12:14,490 [salt.utils.extmods][INFO    ][22378] Loading cache from salt://_utils, for base)
2017-12-03 11:12:14,490 [salt.fileclient  ][INFO    ][22378] Caching directory '_utils/' for environment 'base'
2017-12-03 11:12:14,520 [salt.utils.extmods][INFO    ][22378] Creating module dir '/var/cache/salt/minion/extmods/log_handlers'
2017-12-03 11:12:14,523 [salt.utils.extmods][INFO    ][22378] Syncing log_handlers for environment 'base'
2017-12-03 11:12:14,523 [salt.utils.extmods][INFO    ][22378] Loading cache from salt://_log_handlers, for base)
2017-12-03 11:12:14,523 [salt.fileclient  ][INFO    ][22378] Caching directory '_log_handlers/' for environment 'base'
2017-12-03 11:12:14,555 [salt.utils.extmods][INFO    ][22378] Creating module dir '/var/cache/salt/minion/extmods/proxy'
2017-12-03 11:12:14,558 [salt.utils.extmods][INFO    ][22378] Syncing proxy for environment 'base'
2017-12-03 11:12:14,558 [salt.utils.extmods][INFO    ][22378] Loading cache from salt://_proxy, for base)
2017-12-03 11:12:14,558 [salt.fileclient  ][INFO    ][22378] Caching directory '_proxy/' for environment 'base'
2017-12-03 11:12:14,591 [salt.utils.extmods][INFO    ][22378] Creating module dir '/var/cache/salt/minion/extmods/engines'
2017-12-03 11:12:14,594 [salt.utils.extmods][INFO    ][22378] Syncing engines for environment 'base'
2017-12-03 11:12:14,594 [salt.utils.extmods][INFO    ][22378] Loading cache from salt://_engines, for base)
2017-12-03 11:12:14,594 [salt.fileclient  ][INFO    ][22378] Caching directory '_engines/' for environment 'base'
2017-12-03 11:12:14,628 [salt.minion      ][INFO    ][22378] Returning information for job: 20171203111210231332
2017-12-03 11:12:15,624 [salt.minion      ][INFO    ][22250] User sudo_ubuntu Executing command state.sls with jid 20171203111215616906
2017-12-03 11:12:15,633 [salt.minion      ][INFO    ][22456] Starting a new job with PID 22456
2017-12-03 11:12:16,220 [salt.state       ][INFO    ][22456] Loading fresh modules for state activity
2017-12-03 11:12:16,246 [salt.fileclient  ][INFO    ][22456] Fetching file from saltenv 'base', ** done ** 'salt/control/init.sls'
2017-12-03 11:12:16,267 [salt.fileclient  ][INFO    ][22456] Fetching file from saltenv 'base', ** done ** 'salt/control/virt.sls'
2017-12-03 11:12:16,302 [salt.fileclient  ][INFO    ][22456] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-12-03 11:12:16,462 [salt.fileclient  ][INFO    ][22456] Fetching file from saltenv 'base', ** done ** 'salt/minion/init.sls'
2017-12-03 11:12:16,481 [salt.fileclient  ][INFO    ][22456] Fetching file from saltenv 'base', ** done ** 'salt/minion/service.sls'
2017-12-03 11:12:16,516 [salt.fileclient  ][INFO    ][22456] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-12-03 11:12:16,584 [salt.fileclient  ][INFO    ][22456] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-12-03 11:12:16,605 [salt.fileclient  ][INFO    ][22456] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-12-03 11:12:16,663 [salt.fileclient  ][INFO    ][22456] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-12-03 11:12:16,685 [salt.fileclient  ][INFO    ][22456] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-12-03 11:12:16,701 [salt.fileclient  ][INFO    ][22456] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-12-03 11:12:16,719 [salt.fileclient  ][INFO    ][22456] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-12-03 11:12:16,728 [salt.loaded.int.module.cmdmod][INFO    ][22456] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-12-03 11:12:16,752 [salt.fileclient  ][INFO    ][22456] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-12-03 11:12:16,770 [py.warnings      ][WARNING ][22456] /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 11:12:16,770 [salt.loaded.int.module.cmdmod][INFO    ][22456] Executing command 'salt-minion --version' in directory '/root'
2017-12-03 11:12:17,029 [salt.fileclient  ][INFO    ][22456] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-12-03 11:12:17,050 [salt.fileclient  ][INFO    ][22456] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-12-03 11:12:17,065 [salt.fileclient  ][INFO    ][22456] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-12-03 11:12:17,077 [salt.fileclient  ][INFO    ][22456] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-12-03 11:12:17,121 [salt.fileclient  ][INFO    ][22456] Fetching file from saltenv 'base', ** done ** 'reclass/meta/meta.yml'
2017-12-03 11:12:17,139 [salt.fileclient  ][INFO    ][22456] Fetching file from saltenv 'base', ** done ** 'reclass/map.jinja'
2017-12-03 11:12:17,165 [salt.fileclient  ][INFO    ][22456] Fetching file from saltenv 'base', ** done ** 'ntp/meta/meta.yml'
2017-12-03 11:12:17,180 [salt.fileclient  ][INFO    ][22456] Fetching file from saltenv 'base', ** done ** 'ntp/map.jinja'
2017-12-03 11:12:17,202 [salt.fileclient  ][INFO    ][22456] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-12-03 11:12:17,246 [salt.fileclient  ][INFO    ][22456] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-12-03 11:12:17,317 [salt.fileclient  ][INFO    ][22456] Fetching file from saltenv 'base', ** done ** 'salt/minion/grains.sls'
2017-12-03 11:12:17,343 [salt.fileclient  ][INFO    ][22456] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-12-03 11:12:17,412 [salt.fileclient  ][INFO    ][22456] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-12-03 11:12:17,433 [salt.fileclient  ][INFO    ][22456] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-12-03 11:12:17,493 [salt.fileclient  ][INFO    ][22456] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-12-03 11:12:17,515 [salt.fileclient  ][INFO    ][22456] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-12-03 11:12:17,529 [salt.fileclient  ][INFO    ][22456] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-12-03 11:12:17,548 [salt.fileclient  ][INFO    ][22456] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-12-03 11:12:17,556 [salt.loaded.int.module.cmdmod][INFO    ][22456] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-12-03 11:12:17,581 [salt.fileclient  ][INFO    ][22456] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-12-03 11:12:17,599 [salt.loaded.int.module.cmdmod][INFO    ][22456] Executing command 'salt-minion --version' in directory '/root'
2017-12-03 11:12:17,855 [salt.fileclient  ][INFO    ][22456] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-12-03 11:12:17,871 [salt.fileclient  ][INFO    ][22456] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-12-03 11:12:17,881 [salt.fileclient  ][INFO    ][22456] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-12-03 11:12:17,891 [salt.fileclient  ][INFO    ][22456] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-12-03 11:12:17,930 [salt.fileclient  ][INFO    ][22456] Fetching file from saltenv 'base', ** done ** 'reclass/meta/meta.yml'
2017-12-03 11:12:17,942 [salt.fileclient  ][INFO    ][22456] Fetching file from saltenv 'base', ** done ** 'reclass/map.jinja'
2017-12-03 11:12:17,962 [salt.fileclient  ][INFO    ][22456] Fetching file from saltenv 'base', ** done ** 'ntp/meta/meta.yml'
2017-12-03 11:12:17,973 [salt.fileclient  ][INFO    ][22456] Fetching file from saltenv 'base', ** done ** 'ntp/map.jinja'
2017-12-03 11:12:17,990 [salt.fileclient  ][INFO    ][22456] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-12-03 11:12:18,021 [salt.fileclient  ][INFO    ][22456] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-12-03 11:12:18,096 [salt.fileclient  ][INFO    ][22456] Fetching file from saltenv 'base', ** done ** 'salt/minion/cert.sls'
2017-12-03 11:12:18,181 [salt.fileclient  ][INFO    ][22456] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-12-03 11:12:18,553 [salt.state       ][INFO    ][22456] Running state [salt-minion] at time 11:12:18.552463
2017-12-03 11:12:18,553 [salt.state       ][INFO    ][22456] Executing state pkg.installed for salt-minion
2017-12-03 11:12:18,553 [salt.loaded.int.module.cmdmod][INFO    ][22456] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-03 11:12:18,799 [salt.state       ][INFO    ][22456] Package salt-minion is already installed
2017-12-03 11:12:18,799 [salt.state       ][INFO    ][22456] Completed state [salt-minion] at time 11:12:18.799165 duration_in_ms=246.702
2017-12-03 11:12:18,799 [salt.state       ][INFO    ][22456] Running state [salt_minion_dependency_packages] at time 11:12:18.799433
2017-12-03 11:12:18,800 [salt.state       ][INFO    ][22456] Executing state pkg.installed for salt_minion_dependency_packages
2017-12-03 11:12:18,803 [salt.state       ][INFO    ][22456] All specified packages are already installed
2017-12-03 11:12:18,804 [salt.state       ][INFO    ][22456] Completed state [salt_minion_dependency_packages] at time 11:12:18.803582 duration_in_ms=4.149
2017-12-03 11:12:18,805 [salt.state       ][INFO    ][22456] Running state [/etc/salt/minion.d/minion.conf] at time 11:12:18.805242
2017-12-03 11:12:18,805 [salt.state       ][INFO    ][22456] Executing state file.managed for /etc/salt/minion.d/minion.conf
2017-12-03 11:12:18,830 [salt.fileclient  ][INFO    ][22456] Fetching file from saltenv 'base', ** done ** 'salt/files/minion.conf'
2017-12-03 11:12:18,889 [salt.fileclient  ][INFO    ][22456] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-12-03 11:12:18,944 [salt.fileclient  ][INFO    ][22456] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-12-03 11:12:18,991 [salt.state       ][INFO    ][22456] File /etc/salt/minion.d/minion.conf is in the correct state
2017-12-03 11:12:18,991 [salt.state       ][INFO    ][22456] Completed state [/etc/salt/minion.d/minion.conf] at time 11:12:18.990817 duration_in_ms=185.574
2017-12-03 11:12:18,991 [salt.state       ][INFO    ][22456] Running state [/etc/salt/minion.d/_virt.conf] at time 11:12:18.991190
2017-12-03 11:12:18,991 [salt.state       ][INFO    ][22456] Executing state file.managed for /etc/salt/minion.d/_virt.conf
2017-12-03 11:12:18,992 [salt.state       ][INFO    ][22456] File /etc/salt/minion.d/_virt.conf is in the correct state
2017-12-03 11:12:18,992 [salt.state       ][INFO    ][22456] Completed state [/etc/salt/minion.d/_virt.conf] at time 11:12:18.992241 duration_in_ms=1.051
2017-12-03 11:12:18,994 [salt.state       ][INFO    ][22456] Running state [salt-minion] at time 11:12:18.993874
2017-12-03 11:12:18,994 [salt.state       ][INFO    ][22456] Executing state service.running for salt-minion
2017-12-03 11:12:18,995 [salt.loaded.int.module.cmdmod][INFO    ][22456] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2017-12-03 11:12:19,009 [salt.loaded.int.module.cmdmod][INFO    ][22456] Executing command ['systemctl', 'is-active', 'salt-minion.service'] in directory '/root'
2017-12-03 11:12:19,017 [salt.loaded.int.module.cmdmod][INFO    ][22456] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2017-12-03 11:12:19,024 [salt.state       ][INFO    ][22456] The service salt-minion is already running
2017-12-03 11:12:19,024 [salt.state       ][INFO    ][22456] Completed state [salt-minion] at time 11:12:19.024054 duration_in_ms=30.18
2017-12-03 11:12:19,026 [salt.state       ][INFO    ][22456] Running state [/etc/salt/grains.d] at time 11:12:19.025622
2017-12-03 11:12:19,026 [salt.state       ][INFO    ][22456] Executing state file.directory for /etc/salt/grains.d
2017-12-03 11:12:19,026 [salt.state       ][INFO    ][22456] Directory /etc/salt/grains.d is in the correct state
2017-12-03 11:12:19,027 [salt.state       ][INFO    ][22456] Completed state [/etc/salt/grains.d] at time 11:12:19.026617 duration_in_ms=0.996
2017-12-03 11:12:19,027 [salt.state       ][INFO    ][22456] Running state [/etc/salt/grains] at time 11:12:19.027176
2017-12-03 11:12:19,027 [salt.state       ][INFO    ][22456] Executing state file.managed for /etc/salt/grains
2017-12-03 11:12:19,028 [salt.state       ][INFO    ][22456] File /etc/salt/grains exists with proper permissions. No changes made.
2017-12-03 11:12:19,028 [salt.state       ][INFO    ][22456] Completed state [/etc/salt/grains] at time 11:12:19.027893 duration_in_ms=0.716
2017-12-03 11:12:19,028 [salt.state       ][INFO    ][22456] Running state [/etc/salt/grains.d/placeholder] at time 11:12:19.028247
2017-12-03 11:12:19,028 [salt.state       ][INFO    ][22456] Executing state file.managed for /etc/salt/grains.d/placeholder
2017-12-03 11:12:19,029 [salt.state       ][INFO    ][22456] File /etc/salt/grains.d/placeholder exists with proper permissions. No changes made.
2017-12-03 11:12:19,029 [salt.state       ][INFO    ][22456] Completed state [/etc/salt/grains.d/placeholder] at time 11:12:19.029009 duration_in_ms=0.762
2017-12-03 11:12:19,029 [salt.state       ][INFO    ][22456] Running state [/etc/salt/grains.d/sphinx] at time 11:12:19.029396
2017-12-03 11:12:19,030 [salt.state       ][INFO    ][22456] Executing state file.managed for /etc/salt/grains.d/sphinx
2017-12-03 11:12:19,031 [salt.state       ][INFO    ][22456] 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 11:12:19,031 [salt.state       ][INFO    ][22456] Completed state [/etc/salt/grains.d/sphinx] at time 11:12:19.031082 duration_in_ms=1.686
2017-12-03 11:12:19,032 [salt.state       ][INFO    ][22456] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 11:12:19.031804
2017-12-03 11:12:19,032 [salt.state       ][INFO    ][22456] 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 11:12:19,032 [salt.state       ][INFO    ][22456] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-12-03 11:12:19,032 [salt.state       ][INFO    ][22456] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 11:12:19.032338 duration_in_ms=0.535
2017-12-03 11:12:19,033 [salt.state       ][INFO    ][22456] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 11:12:19.032497
2017-12-03 11:12:19,033 [salt.state       ][INFO    ][22456] 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 11:12:19,033 [salt.loaded.int.module.cmdmod][INFO    ][22456] 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 11:12:19,108 [salt.state       ][INFO    ][22456] {'pid': 22534, 'retcode': 0, 'stderr': '', 'stdout': ''}
2017-12-03 11:12:19,109 [salt.state       ][INFO    ][22456] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 11:12:19.108784 duration_in_ms=76.285
2017-12-03 11:12:19,109 [salt.state       ][INFO    ][22456] Running state [/etc/salt/grains.d/dns_records] at time 11:12:19.109342
2017-12-03 11:12:19,110 [salt.state       ][INFO    ][22456] Executing state file.managed for /etc/salt/grains.d/dns_records
2017-12-03 11:12:19,111 [salt.state       ][INFO    ][22456] File /etc/salt/grains.d/dns_records is in the correct state
2017-12-03 11:12:19,111 [salt.state       ][INFO    ][22456] Completed state [/etc/salt/grains.d/dns_records] at time 11:12:19.110646 duration_in_ms=1.305
2017-12-03 11:12:19,111 [salt.state       ][INFO    ][22456] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 11:12:19.111428
2017-12-03 11:12:19,112 [salt.state       ][INFO    ][22456] 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 11:12:19,112 [salt.state       ][INFO    ][22456] 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 11:12:19,112 [salt.state       ][INFO    ][22456] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 11:12:19.111967 duration_in_ms=0.539
2017-12-03 11:12:19,112 [salt.state       ][INFO    ][22456] Running state [/etc/salt/grains.d/salt] at time 11:12:19.112294
2017-12-03 11:12:19,112 [salt.state       ][INFO    ][22456] Executing state file.managed for /etc/salt/grains.d/salt
2017-12-03 11:12:19,113 [salt.state       ][INFO    ][22456] File /etc/salt/grains.d/salt is in the correct state
2017-12-03 11:12:19,113 [salt.state       ][INFO    ][22456] Completed state [/etc/salt/grains.d/salt] at time 11:12:19.113374 duration_in_ms=1.08
2017-12-03 11:12:19,114 [salt.state       ][INFO    ][22456] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 11:12:19.114074
2017-12-03 11:12:19,114 [salt.state       ][INFO    ][22456] 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 11:12:19,115 [salt.state       ][INFO    ][22456] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2017-12-03 11:12:19,115 [salt.state       ][INFO    ][22456] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 11:12:19.114623 duration_in_ms=0.549
2017-12-03 11:12:19,116 [salt.state       ][INFO    ][22456] Running state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 11:12:19.116161
2017-12-03 11:12:19,116 [salt.state       ][INFO    ][22456] Executing state cmd.wait for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-12-03 11:12:19,117 [salt.state       ][INFO    ][22456] No changes made for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-12-03 11:12:19,117 [salt.state       ][INFO    ][22456] Completed state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 11:12:19.116774 duration_in_ms=0.613
2017-12-03 11:12:19,117 [salt.state       ][INFO    ][22456] Running state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 11:12:19.116940
2017-12-03 11:12:19,117 [salt.state       ][INFO    ][22456] Executing state cmd.mod_watch for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-12-03 11:12:19,119 [salt.loaded.int.module.cmdmod][INFO    ][22456] Executing command 'cat /etc/salt/grains.d/* > /etc/salt/grains' in directory '/root'
2017-12-03 11:12:19,125 [salt.state       ][INFO    ][22456] {'pid': 22536, 'retcode': 0, 'stderr': '', 'stdout': ''}
2017-12-03 11:12:19,125 [salt.state       ][INFO    ][22456] Completed state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 11:12:19.125413 duration_in_ms=8.473
2017-12-03 11:12:19,126 [salt.state       ][INFO    ][22456] Running state [mine.update] at time 11:12:19.126134
2017-12-03 11:12:19,126 [salt.state       ][INFO    ][22456] Executing state module.wait for mine.update
2017-12-03 11:12:19,127 [salt.state       ][INFO    ][22456] No changes made for mine.update
2017-12-03 11:12:19,127 [salt.state       ][INFO    ][22456] Completed state [mine.update] at time 11:12:19.126710 duration_in_ms=0.576
2017-12-03 11:12:19,127 [salt.state       ][INFO    ][22456] Running state [mine.update] at time 11:12:19.126853
2017-12-03 11:12:19,127 [salt.state       ][INFO    ][22456] Executing state module.mod_watch for mine.update
2017-12-03 11:12:19,644 [salt.state       ][INFO    ][22456] {'ret': True}
2017-12-03 11:12:19,644 [salt.state       ][INFO    ][22456] Completed state [mine.update] at time 11:12:19.643762 duration_in_ms=516.909
2017-12-03 11:12:19,644 [salt.state       ][INFO    ][22456] Running state [ca-certificates] at time 11:12:19.644021
2017-12-03 11:12:19,644 [salt.state       ][INFO    ][22456] Executing state pkg.installed for ca-certificates
2017-12-03 11:12:19,648 [salt.state       ][INFO    ][22456] Package ca-certificates is already installed
2017-12-03 11:12:19,648 [salt.state       ][INFO    ][22456] Completed state [ca-certificates] at time 11:12:19.648260 duration_in_ms=4.239
2017-12-03 11:12:19,649 [salt.state       ][INFO    ][22456] Running state [update-ca-certificates] at time 11:12:19.648906
2017-12-03 11:12:19,649 [salt.state       ][INFO    ][22456] Executing state cmd.wait for update-ca-certificates
2017-12-03 11:12:19,649 [salt.state       ][INFO    ][22456] No changes made for update-ca-certificates
2017-12-03 11:12:19,650 [salt.state       ][INFO    ][22456] Completed state [update-ca-certificates] at time 11:12:19.649476 duration_in_ms=0.57
2017-12-03 11:12:19,650 [salt.state       ][INFO    ][22456] Running state [libvirt-dev] at time 11:12:19.649647
2017-12-03 11:12:19,650 [salt.state       ][INFO    ][22456] Executing state pkg.installed for libvirt-dev
2017-12-03 11:12:19,653 [salt.state       ][INFO    ][22456] Package libvirt-dev is already installed
2017-12-03 11:12:19,654 [salt.state       ][INFO    ][22456] Completed state [libvirt-dev] at time 11:12:19.653574 duration_in_ms=3.927
2017-12-03 11:12:19,654 [salt.state       ][INFO    ][22456] Running state [pkg-config] at time 11:12:19.653763
2017-12-03 11:12:19,654 [salt.state       ][INFO    ][22456] Executing state pkg.installed for pkg-config
2017-12-03 11:12:19,658 [salt.state       ][INFO    ][22456] Package pkg-config is already installed
2017-12-03 11:12:19,658 [salt.state       ][INFO    ][22456] Completed state [pkg-config] at time 11:12:19.657793 duration_in_ms=4.031
2017-12-03 11:12:19,658 [salt.state       ][INFO    ][22456] Running state [virtng.init] at time 11:12:19.657973
2017-12-03 11:12:19,658 [salt.state       ][INFO    ][22456] Executing state module.run for virtng.init
2017-12-03 11:12:19,721 [salt.loaded.int.module.cmdmod][INFO    ][22456] Executing command ['git', '--version'] in directory '/root'
2017-12-03 11:12:19,794 [salt.loaded.int.module.cmdmod][INFO    ][22456] Executing command 'virsh list --all --name| grep -E "^prx01.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-12-03 11:12:19,811 [salt.state       ][INFO    ][22456] unless execution succeeded
2017-12-03 11:12:19,811 [salt.state       ][INFO    ][22456] Completed state [virtng.init] at time 11:12:19.811263 duration_in_ms=153.289
2017-12-03 11:12:19,812 [salt.state       ][INFO    ][22456] Running state [virt.set_autostart] at time 11:12:19.811506
2017-12-03 11:12:19,812 [salt.state       ][INFO    ][22456] Executing state module.run for virt.set_autostart
2017-12-03 11:12:19,814 [salt.loaded.int.module.cmdmod][INFO    ][22456] Executing command 'virsh list --autostart --name| grep -E "^prx01.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-12-03 11:12:19,830 [salt.state       ][INFO    ][22456] unless execution succeeded
2017-12-03 11:12:19,830 [salt.state       ][INFO    ][22456] Completed state [virt.set_autostart] at time 11:12:19.830224 duration_in_ms=18.717
2017-12-03 11:12:19,831 [salt.state       ][INFO    ][22456] Running state [virtng.init] at time 11:12:19.830476
2017-12-03 11:12:19,831 [salt.state       ][INFO    ][22456] Executing state module.run for virtng.init
2017-12-03 11:12:19,833 [salt.loaded.int.module.cmdmod][INFO    ][22456] Executing command 'virsh list --all --name| grep -E "^ctl01.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-12-03 11:12:19,848 [salt.state       ][INFO    ][22456] unless execution succeeded
2017-12-03 11:12:19,849 [salt.state       ][INFO    ][22456] Completed state [virtng.init] at time 11:12:19.848581 duration_in_ms=18.105
2017-12-03 11:12:19,849 [salt.state       ][INFO    ][22456] Running state [virt.set_autostart] at time 11:12:19.848864
2017-12-03 11:12:19,849 [salt.state       ][INFO    ][22456] Executing state module.run for virt.set_autostart
2017-12-03 11:12:19,852 [salt.loaded.int.module.cmdmod][INFO    ][22456] Executing command 'virsh list --autostart --name| grep -E "^ctl01.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-12-03 11:12:19,867 [salt.state       ][INFO    ][22456] unless execution succeeded
2017-12-03 11:12:19,867 [salt.state       ][INFO    ][22456] Completed state [virt.set_autostart] at time 11:12:19.867253 duration_in_ms=18.389
2017-12-03 11:12:19,868 [salt.state       ][INFO    ][22456] Running state [virtng.init] at time 11:12:19.867495
2017-12-03 11:12:19,868 [salt.state       ][INFO    ][22456] Executing state module.run for virtng.init
2017-12-03 11:12:19,870 [salt.loaded.int.module.cmdmod][INFO    ][22456] Executing command 'virsh list --all --name| grep -E "^mdb01.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-12-03 11:12:19,883 [salt.state       ][INFO    ][22456] unless execution succeeded
2017-12-03 11:12:19,884 [salt.state       ][INFO    ][22456] Completed state [virtng.init] at time 11:12:19.883614 duration_in_ms=16.119
2017-12-03 11:12:19,884 [salt.state       ][INFO    ][22456] Running state [virt.set_autostart] at time 11:12:19.883852
2017-12-03 11:12:19,884 [salt.state       ][INFO    ][22456] Executing state module.run for virt.set_autostart
2017-12-03 11:12:19,887 [salt.loaded.int.module.cmdmod][INFO    ][22456] Executing command 'virsh list --autostart --name| grep -E "^mdb01.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-12-03 11:12:19,900 [salt.state       ][INFO    ][22456] unless execution succeeded
2017-12-03 11:12:19,901 [salt.state       ][INFO    ][22456] Completed state [virt.set_autostart] at time 11:12:19.900624 duration_in_ms=16.772
2017-12-03 11:12:19,901 [salt.state       ][INFO    ][22456] Running state [virtng.init] at time 11:12:19.900886
2017-12-03 11:12:19,901 [salt.state       ][INFO    ][22456] Executing state module.run for virtng.init
2017-12-03 11:12:19,904 [salt.loaded.int.module.cmdmod][INFO    ][22456] Executing command 'virsh list --all --name| grep -E "^msg01.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-12-03 11:12:19,918 [salt.state       ][INFO    ][22456] unless execution succeeded
2017-12-03 11:12:19,919 [salt.state       ][INFO    ][22456] Completed state [virtng.init] at time 11:12:19.918597 duration_in_ms=17.71
2017-12-03 11:12:19,919 [salt.state       ][INFO    ][22456] Running state [virt.set_autostart] at time 11:12:19.918855
2017-12-03 11:12:19,919 [salt.state       ][INFO    ][22456] Executing state module.run for virt.set_autostart
2017-12-03 11:12:19,922 [salt.loaded.int.module.cmdmod][INFO    ][22456] Executing command 'virsh list --autostart --name| grep -E "^msg01.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-12-03 11:12:19,936 [salt.state       ][INFO    ][22456] unless execution succeeded
2017-12-03 11:12:19,936 [salt.state       ][INFO    ][22456] Completed state [virt.set_autostart] at time 11:12:19.936196 duration_in_ms=17.341
2017-12-03 11:12:19,936 [salt.state       ][INFO    ][22456] Running state [virtng.init] at time 11:12:19.936424
2017-12-03 11:12:19,937 [salt.state       ][INFO    ][22456] Executing state module.run for virtng.init
2017-12-03 11:12:19,939 [salt.loaded.int.module.cmdmod][INFO    ][22456] Executing command 'virsh list --all --name| grep -E "^dbs01.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-12-03 11:12:19,954 [salt.state       ][INFO    ][22456] unless execution succeeded
2017-12-03 11:12:19,954 [salt.state       ][INFO    ][22456] Completed state [virtng.init] at time 11:12:19.953909 duration_in_ms=17.484
2017-12-03 11:12:19,954 [salt.state       ][INFO    ][22456] Running state [virt.set_autostart] at time 11:12:19.954178
2017-12-03 11:12:19,954 [salt.state       ][INFO    ][22456] Executing state module.run for virt.set_autostart
2017-12-03 11:12:19,957 [salt.loaded.int.module.cmdmod][INFO    ][22456] Executing command 'virsh list --autostart --name| grep -E "^dbs01.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-12-03 11:12:19,970 [salt.state       ][INFO    ][22456] unless execution succeeded
2017-12-03 11:12:19,970 [salt.state       ][INFO    ][22456] Completed state [virt.set_autostart] at time 11:12:19.970086 duration_in_ms=15.908
2017-12-03 11:12:19,973 [salt.minion      ][INFO    ][22456] Returning information for job: 20171203111215616906
2017-12-03 11:12:46,703 [salt.minion      ][INFO    ][22250] User sudo_ubuntu Executing command state.sls with jid 20171203111246694856
2017-12-03 11:12:46,714 [salt.minion      ][INFO    ][22598] Starting a new job with PID 22598
2017-12-03 11:12:49,357 [salt.state       ][INFO    ][22598] Loading fresh modules for state activity
2017-12-03 11:12:49,391 [salt.fileclient  ][INFO    ][22598] Fetching file from saltenv 'base', ** done ** 'salt/control/init.sls'
2017-12-03 11:12:49,438 [salt.fileclient  ][INFO    ][22598] Fetching file from saltenv 'base', ** done ** 'salt/control/virt.sls'
2017-12-03 11:12:49,465 [salt.fileclient  ][INFO    ][22598] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-12-03 11:12:49,548 [salt.fileclient  ][INFO    ][22598] Fetching file from saltenv 'base', ** done ** 'salt/minion/init.sls'
2017-12-03 11:12:49,566 [salt.fileclient  ][INFO    ][22598] Fetching file from saltenv 'base', ** done ** 'salt/minion/service.sls'
2017-12-03 11:12:49,593 [salt.fileclient  ][INFO    ][22598] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-12-03 11:12:49,666 [salt.fileclient  ][INFO    ][22598] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-12-03 11:12:49,686 [salt.fileclient  ][INFO    ][22598] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-12-03 11:12:49,745 [salt.fileclient  ][INFO    ][22598] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-12-03 11:12:49,765 [salt.fileclient  ][INFO    ][22598] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-12-03 11:12:49,779 [salt.fileclient  ][INFO    ][22598] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-12-03 11:12:49,797 [salt.fileclient  ][INFO    ][22598] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-12-03 11:12:49,806 [salt.loaded.int.module.cmdmod][INFO    ][22598] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-12-03 11:12:49,829 [salt.fileclient  ][INFO    ][22598] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-12-03 11:12:49,848 [py.warnings      ][WARNING ][22598] /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 11:12:49,848 [salt.loaded.int.module.cmdmod][INFO    ][22598] Executing command 'salt-minion --version' in directory '/root'
2017-12-03 11:12:50,109 [salt.fileclient  ][INFO    ][22598] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-12-03 11:12:50,129 [salt.fileclient  ][INFO    ][22598] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-12-03 11:12:50,141 [salt.fileclient  ][INFO    ][22598] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-12-03 11:12:50,153 [salt.fileclient  ][INFO    ][22598] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-12-03 11:12:50,200 [salt.fileclient  ][INFO    ][22598] Fetching file from saltenv 'base', ** done ** 'reclass/meta/meta.yml'
2017-12-03 11:12:50,217 [salt.fileclient  ][INFO    ][22598] Fetching file from saltenv 'base', ** done ** 'reclass/map.jinja'
2017-12-03 11:12:50,240 [salt.fileclient  ][INFO    ][22598] Fetching file from saltenv 'base', ** done ** 'ntp/meta/meta.yml'
2017-12-03 11:12:50,255 [salt.fileclient  ][INFO    ][22598] Fetching file from saltenv 'base', ** done ** 'ntp/map.jinja'
2017-12-03 11:12:50,285 [salt.fileclient  ][INFO    ][22598] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-12-03 11:12:50,333 [salt.fileclient  ][INFO    ][22598] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-12-03 11:12:50,402 [salt.fileclient  ][INFO    ][22598] Fetching file from saltenv 'base', ** done ** 'salt/minion/grains.sls'
2017-12-03 11:12:50,424 [salt.fileclient  ][INFO    ][22598] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-12-03 11:12:50,494 [salt.fileclient  ][INFO    ][22598] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-12-03 11:12:50,513 [salt.fileclient  ][INFO    ][22598] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-12-03 11:12:50,569 [salt.fileclient  ][INFO    ][22598] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-12-03 11:12:50,592 [salt.fileclient  ][INFO    ][22598] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-12-03 11:12:50,607 [salt.fileclient  ][INFO    ][22598] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-12-03 11:12:50,624 [salt.fileclient  ][INFO    ][22598] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-12-03 11:12:50,633 [salt.loaded.int.module.cmdmod][INFO    ][22598] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-12-03 11:12:50,656 [salt.fileclient  ][INFO    ][22598] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-12-03 11:12:50,674 [salt.loaded.int.module.cmdmod][INFO    ][22598] Executing command 'salt-minion --version' in directory '/root'
2017-12-03 11:12:50,937 [salt.fileclient  ][INFO    ][22598] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-12-03 11:12:50,959 [salt.fileclient  ][INFO    ][22598] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-12-03 11:12:50,973 [salt.fileclient  ][INFO    ][22598] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-12-03 11:12:50,988 [salt.fileclient  ][INFO    ][22598] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-12-03 11:12:51,031 [salt.fileclient  ][INFO    ][22598] Fetching file from saltenv 'base', ** done ** 'reclass/meta/meta.yml'
2017-12-03 11:12:51,046 [salt.fileclient  ][INFO    ][22598] Fetching file from saltenv 'base', ** done ** 'reclass/map.jinja'
2017-12-03 11:12:51,072 [salt.fileclient  ][INFO    ][22598] Fetching file from saltenv 'base', ** done ** 'ntp/meta/meta.yml'
2017-12-03 11:12:51,085 [salt.fileclient  ][INFO    ][22598] Fetching file from saltenv 'base', ** done ** 'ntp/map.jinja'
2017-12-03 11:12:51,108 [salt.fileclient  ][INFO    ][22598] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-12-03 11:12:51,150 [salt.fileclient  ][INFO    ][22598] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-12-03 11:12:51,234 [salt.fileclient  ][INFO    ][22598] Fetching file from saltenv 'base', ** done ** 'salt/minion/cert.sls'
2017-12-03 11:12:51,310 [salt.fileclient  ][INFO    ][22598] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-12-03 11:12:51,636 [salt.state       ][INFO    ][22598] Running state [salt-minion] at time 11:12:51.635494
2017-12-03 11:12:51,636 [salt.state       ][INFO    ][22598] Executing state pkg.installed for salt-minion
2017-12-03 11:12:51,636 [salt.loaded.int.module.cmdmod][INFO    ][22598] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-03 11:12:51,882 [salt.state       ][INFO    ][22598] Package salt-minion is already installed
2017-12-03 11:12:51,883 [salt.state       ][INFO    ][22598] Completed state [salt-minion] at time 11:12:51.882652 duration_in_ms=247.158
2017-12-03 11:12:51,883 [salt.state       ][INFO    ][22598] Running state [salt_minion_dependency_packages] at time 11:12:51.882924
2017-12-03 11:12:51,883 [salt.state       ][INFO    ][22598] Executing state pkg.installed for salt_minion_dependency_packages
2017-12-03 11:12:51,887 [salt.state       ][INFO    ][22598] All specified packages are already installed
2017-12-03 11:12:51,887 [salt.state       ][INFO    ][22598] Completed state [salt_minion_dependency_packages] at time 11:12:51.887001 duration_in_ms=4.077
2017-12-03 11:12:51,889 [salt.state       ][INFO    ][22598] Running state [/etc/salt/minion.d/minion.conf] at time 11:12:51.888645
2017-12-03 11:12:51,889 [salt.state       ][INFO    ][22598] Executing state file.managed for /etc/salt/minion.d/minion.conf
2017-12-03 11:12:51,911 [salt.fileclient  ][INFO    ][22598] Fetching file from saltenv 'base', ** done ** 'salt/files/minion.conf'
2017-12-03 11:12:51,969 [salt.fileclient  ][INFO    ][22598] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-12-03 11:12:52,024 [salt.fileclient  ][INFO    ][22598] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-12-03 11:12:52,071 [salt.state       ][INFO    ][22598] File /etc/salt/minion.d/minion.conf is in the correct state
2017-12-03 11:12:52,071 [salt.state       ][INFO    ][22598] Completed state [/etc/salt/minion.d/minion.conf] at time 11:12:52.071087 duration_in_ms=182.442
2017-12-03 11:12:52,071 [salt.state       ][INFO    ][22598] Running state [/etc/salt/minion.d/_virt.conf] at time 11:12:52.071466
2017-12-03 11:12:52,072 [salt.state       ][INFO    ][22598] Executing state file.managed for /etc/salt/minion.d/_virt.conf
2017-12-03 11:12:52,072 [salt.state       ][INFO    ][22598] File /etc/salt/minion.d/_virt.conf is in the correct state
2017-12-03 11:12:52,073 [salt.state       ][INFO    ][22598] Completed state [/etc/salt/minion.d/_virt.conf] at time 11:12:52.072500 duration_in_ms=1.035
2017-12-03 11:12:52,074 [salt.state       ][INFO    ][22598] Running state [salt-minion] at time 11:12:52.074113
2017-12-03 11:12:52,074 [salt.state       ][INFO    ][22598] Executing state service.running for salt-minion
2017-12-03 11:12:52,075 [salt.loaded.int.module.cmdmod][INFO    ][22598] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2017-12-03 11:12:52,090 [salt.loaded.int.module.cmdmod][INFO    ][22598] Executing command ['systemctl', 'is-active', 'salt-minion.service'] in directory '/root'
2017-12-03 11:12:52,097 [salt.loaded.int.module.cmdmod][INFO    ][22598] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2017-12-03 11:12:52,105 [salt.state       ][INFO    ][22598] The service salt-minion is already running
2017-12-03 11:12:52,105 [salt.state       ][INFO    ][22598] Completed state [salt-minion] at time 11:12:52.105228 duration_in_ms=31.115
2017-12-03 11:12:52,107 [salt.state       ][INFO    ][22598] Running state [/etc/salt/grains.d] at time 11:12:52.106817
2017-12-03 11:12:52,107 [salt.state       ][INFO    ][22598] Executing state file.directory for /etc/salt/grains.d
2017-12-03 11:12:52,108 [salt.state       ][INFO    ][22598] Directory /etc/salt/grains.d is in the correct state
2017-12-03 11:12:52,108 [salt.state       ][INFO    ][22598] Completed state [/etc/salt/grains.d] at time 11:12:52.107780 duration_in_ms=0.963
2017-12-03 11:12:52,108 [salt.state       ][INFO    ][22598] Running state [/etc/salt/grains] at time 11:12:52.108266
2017-12-03 11:12:52,108 [salt.state       ][INFO    ][22598] Executing state file.managed for /etc/salt/grains
2017-12-03 11:12:52,109 [salt.state       ][INFO    ][22598] File /etc/salt/grains exists with proper permissions. No changes made.
2017-12-03 11:12:52,109 [salt.state       ][INFO    ][22598] Completed state [/etc/salt/grains] at time 11:12:52.108975 duration_in_ms=0.709
2017-12-03 11:12:52,109 [salt.state       ][INFO    ][22598] Running state [/etc/salt/grains.d/placeholder] at time 11:12:52.109298
2017-12-03 11:12:52,109 [salt.state       ][INFO    ][22598] Executing state file.managed for /etc/salt/grains.d/placeholder
2017-12-03 11:12:52,110 [salt.state       ][INFO    ][22598] File /etc/salt/grains.d/placeholder exists with proper permissions. No changes made.
2017-12-03 11:12:52,110 [salt.state       ][INFO    ][22598] Completed state [/etc/salt/grains.d/placeholder] at time 11:12:52.109908 duration_in_ms=0.61
2017-12-03 11:12:52,110 [salt.state       ][INFO    ][22598] Running state [/etc/salt/grains.d/sphinx] at time 11:12:52.110228
2017-12-03 11:12:52,110 [salt.state       ][INFO    ][22598] Executing state file.managed for /etc/salt/grains.d/sphinx
2017-12-03 11:12:52,111 [salt.state       ][INFO    ][22598] File /etc/salt/grains.d/sphinx is in the correct state
2017-12-03 11:12:52,111 [salt.state       ][INFO    ][22598] Completed state [/etc/salt/grains.d/sphinx] at time 11:12:52.111264 duration_in_ms=1.036
2017-12-03 11:12:52,112 [salt.state       ][INFO    ][22598] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 11:12:52.111937
2017-12-03 11:12:52,112 [salt.state       ][INFO    ][22598] 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 11:12:52,112 [salt.state       ][INFO    ][22598] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-12-03 11:12:52,112 [salt.state       ][INFO    ][22598] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 11:12:52.112446 duration_in_ms=0.509
2017-12-03 11:12:52,113 [salt.state       ][INFO    ][22598] Running state [/etc/salt/grains.d/dns_records] at time 11:12:52.112813
2017-12-03 11:12:52,113 [salt.state       ][INFO    ][22598] Executing state file.managed for /etc/salt/grains.d/dns_records
2017-12-03 11:12:52,114 [salt.state       ][INFO    ][22598] File /etc/salt/grains.d/dns_records is in the correct state
2017-12-03 11:12:52,114 [salt.state       ][INFO    ][22598] Completed state [/etc/salt/grains.d/dns_records] at time 11:12:52.113688 duration_in_ms=0.874
2017-12-03 11:12:52,114 [salt.state       ][INFO    ][22598] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 11:12:52.114366
2017-12-03 11:12:52,115 [salt.state       ][INFO    ][22598] 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 11:12:52,115 [salt.state       ][INFO    ][22598] 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 11:12:52,115 [salt.state       ][INFO    ][22598] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 11:12:52.114871 duration_in_ms=0.505
2017-12-03 11:12:52,115 [salt.state       ][INFO    ][22598] Running state [/etc/salt/grains.d/salt] at time 11:12:52.115191
2017-12-03 11:12:52,115 [salt.state       ][INFO    ][22598] Executing state file.managed for /etc/salt/grains.d/salt
2017-12-03 11:12:52,116 [salt.state       ][INFO    ][22598] File /etc/salt/grains.d/salt is in the correct state
2017-12-03 11:12:52,116 [salt.state       ][INFO    ][22598] Completed state [/etc/salt/grains.d/salt] at time 11:12:52.116049 duration_in_ms=0.859
2017-12-03 11:12:52,117 [salt.state       ][INFO    ][22598] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 11:12:52.116724
2017-12-03 11:12:52,117 [salt.state       ][INFO    ][22598] 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 11:12:52,117 [salt.state       ][INFO    ][22598] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2017-12-03 11:12:52,117 [salt.state       ][INFO    ][22598] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 11:12:52.117242 duration_in_ms=0.519
2017-12-03 11:12:52,119 [salt.state       ][INFO    ][22598] Running state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 11:12:52.118693
2017-12-03 11:12:52,119 [salt.state       ][INFO    ][22598] Executing state cmd.wait for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-12-03 11:12:52,119 [salt.state       ][INFO    ][22598] No changes made for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-12-03 11:12:52,119 [salt.state       ][INFO    ][22598] Completed state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 11:12:52.119199 duration_in_ms=0.506
2017-12-03 11:12:52,120 [salt.state       ][INFO    ][22598] Running state [mine.update] at time 11:12:52.119665
2017-12-03 11:12:52,120 [salt.state       ][INFO    ][22598] Executing state module.wait for mine.update
2017-12-03 11:12:52,120 [salt.state       ][INFO    ][22598] No changes made for mine.update
2017-12-03 11:12:52,120 [salt.state       ][INFO    ][22598] Completed state [mine.update] at time 11:12:52.120125 duration_in_ms=0.46
2017-12-03 11:12:52,120 [salt.state       ][INFO    ][22598] Running state [ca-certificates] at time 11:12:52.120279
2017-12-03 11:12:52,120 [salt.state       ][INFO    ][22598] Executing state pkg.installed for ca-certificates
2017-12-03 11:12:52,124 [salt.state       ][INFO    ][22598] Package ca-certificates is already installed
2017-12-03 11:12:52,124 [salt.state       ][INFO    ][22598] Completed state [ca-certificates] at time 11:12:52.124375 duration_in_ms=4.097
2017-12-03 11:12:52,125 [salt.state       ][INFO    ][22598] Running state [update-ca-certificates] at time 11:12:52.124937
2017-12-03 11:12:52,125 [salt.state       ][INFO    ][22598] Executing state cmd.wait for update-ca-certificates
2017-12-03 11:12:52,125 [salt.state       ][INFO    ][22598] No changes made for update-ca-certificates
2017-12-03 11:12:52,125 [salt.state       ][INFO    ][22598] Completed state [update-ca-certificates] at time 11:12:52.125423 duration_in_ms=0.487
2017-12-03 11:12:52,126 [salt.state       ][INFO    ][22598] Running state [libvirt-dev] at time 11:12:52.125584
2017-12-03 11:12:52,126 [salt.state       ][INFO    ][22598] Executing state pkg.installed for libvirt-dev
2017-12-03 11:12:52,129 [salt.state       ][INFO    ][22598] Package libvirt-dev is already installed
2017-12-03 11:12:52,129 [salt.state       ][INFO    ][22598] Completed state [libvirt-dev] at time 11:12:52.129398 duration_in_ms=3.815
2017-12-03 11:12:52,130 [salt.state       ][INFO    ][22598] Running state [pkg-config] at time 11:12:52.129556
2017-12-03 11:12:52,130 [salt.state       ][INFO    ][22598] Executing state pkg.installed for pkg-config
2017-12-03 11:12:52,133 [salt.state       ][INFO    ][22598] Package pkg-config is already installed
2017-12-03 11:12:52,133 [salt.state       ][INFO    ][22598] Completed state [pkg-config] at time 11:12:52.133329 duration_in_ms=3.773
2017-12-03 11:12:52,134 [salt.state       ][INFO    ][22598] Running state [virtng.init] at time 11:12:52.133499
2017-12-03 11:12:52,134 [salt.state       ][INFO    ][22598] Executing state module.run for virtng.init
2017-12-03 11:12:52,225 [salt.loaded.int.module.cmdmod][INFO    ][22598] Executing command ['git', '--version'] in directory '/root'
2017-12-03 11:12:52,268 [salt.loaded.int.module.cmdmod][INFO    ][22598] Executing command 'virsh list --all --name| grep -E "^prx01.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-12-03 11:12:52,284 [salt.state       ][INFO    ][22598] unless execution succeeded
2017-12-03 11:12:52,284 [salt.state       ][INFO    ][22598] Completed state [virtng.init] at time 11:12:52.284434 duration_in_ms=150.934
2017-12-03 11:12:52,285 [salt.state       ][INFO    ][22598] Running state [virt.set_autostart] at time 11:12:52.284795
2017-12-03 11:12:52,285 [salt.state       ][INFO    ][22598] Executing state module.run for virt.set_autostart
2017-12-03 11:12:52,288 [salt.loaded.int.module.cmdmod][INFO    ][22598] Executing command 'virsh list --autostart --name| grep -E "^prx01.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-12-03 11:12:52,303 [salt.state       ][INFO    ][22598] unless execution succeeded
2017-12-03 11:12:52,304 [salt.state       ][INFO    ][22598] Completed state [virt.set_autostart] at time 11:12:52.303545 duration_in_ms=18.75
2017-12-03 11:12:52,304 [salt.state       ][INFO    ][22598] Running state [virtng.init] at time 11:12:52.303782
2017-12-03 11:12:52,304 [salt.state       ][INFO    ][22598] Executing state module.run for virtng.init
2017-12-03 11:12:52,307 [salt.loaded.int.module.cmdmod][INFO    ][22598] Executing command 'virsh list --all --name| grep -E "^ctl01.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-12-03 11:12:52,322 [salt.state       ][INFO    ][22598] unless execution succeeded
2017-12-03 11:12:52,323 [salt.state       ][INFO    ][22598] Completed state [virtng.init] at time 11:12:52.322731 duration_in_ms=18.948
2017-12-03 11:12:52,323 [salt.state       ][INFO    ][22598] Running state [virt.set_autostart] at time 11:12:52.323056
2017-12-03 11:12:52,323 [salt.state       ][INFO    ][22598] Executing state module.run for virt.set_autostart
2017-12-03 11:12:52,326 [salt.loaded.int.module.cmdmod][INFO    ][22598] Executing command 'virsh list --autostart --name| grep -E "^ctl01.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-12-03 11:12:52,340 [salt.state       ][INFO    ][22598] unless execution succeeded
2017-12-03 11:12:52,340 [salt.state       ][INFO    ][22598] Completed state [virt.set_autostart] at time 11:12:52.340209 duration_in_ms=17.153
2017-12-03 11:12:52,340 [salt.state       ][INFO    ][22598] Running state [virtng.init] at time 11:12:52.340432
2017-12-03 11:12:52,341 [salt.state       ][INFO    ][22598] Executing state module.run for virtng.init
2017-12-03 11:12:52,343 [salt.loaded.int.module.cmdmod][INFO    ][22598] Executing command 'virsh list --all --name| grep -E "^mdb01.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-12-03 11:12:52,358 [salt.state       ][INFO    ][22598] unless execution succeeded
2017-12-03 11:12:52,358 [salt.state       ][INFO    ][22598] Completed state [virtng.init] at time 11:12:52.358105 duration_in_ms=17.672
2017-12-03 11:12:52,358 [salt.state       ][INFO    ][22598] Running state [virt.set_autostart] at time 11:12:52.358414
2017-12-03 11:12:52,359 [salt.state       ][INFO    ][22598] Executing state module.run for virt.set_autostart
2017-12-03 11:12:52,361 [salt.loaded.int.module.cmdmod][INFO    ][22598] Executing command 'virsh list --autostart --name| grep -E "^mdb01.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-12-03 11:12:52,375 [salt.state       ][INFO    ][22598] unless execution succeeded
2017-12-03 11:12:52,376 [salt.state       ][INFO    ][22598] Completed state [virt.set_autostart] at time 11:12:52.375619 duration_in_ms=17.204
2017-12-03 11:12:52,376 [salt.state       ][INFO    ][22598] Running state [virtng.init] at time 11:12:52.375840
2017-12-03 11:12:52,376 [salt.state       ][INFO    ][22598] Executing state module.run for virtng.init
2017-12-03 11:12:52,379 [salt.loaded.int.module.cmdmod][INFO    ][22598] Executing command 'virsh list --all --name| grep -E "^msg01.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-12-03 11:12:52,394 [salt.state       ][INFO    ][22598] unless execution succeeded
2017-12-03 11:12:52,394 [salt.state       ][INFO    ][22598] Completed state [virtng.init] at time 11:12:52.393920 duration_in_ms=18.078
2017-12-03 11:12:52,394 [salt.state       ][INFO    ][22598] Running state [virt.set_autostart] at time 11:12:52.394167
2017-12-03 11:12:52,394 [salt.state       ][INFO    ][22598] Executing state module.run for virt.set_autostart
2017-12-03 11:12:52,397 [salt.loaded.int.module.cmdmod][INFO    ][22598] Executing command 'virsh list --autostart --name| grep -E "^msg01.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-12-03 11:12:52,411 [salt.state       ][INFO    ][22598] unless execution succeeded
2017-12-03 11:12:52,412 [salt.state       ][INFO    ][22598] Completed state [virt.set_autostart] at time 11:12:52.411568 duration_in_ms=17.4
2017-12-03 11:12:52,412 [salt.state       ][INFO    ][22598] Running state [virtng.init] at time 11:12:52.411790
2017-12-03 11:12:52,412 [salt.state       ][INFO    ][22598] Executing state module.run for virtng.init
2017-12-03 11:12:52,415 [salt.loaded.int.module.cmdmod][INFO    ][22598] Executing command 'virsh list --all --name| grep -E "^dbs01.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-12-03 11:12:52,429 [salt.state       ][INFO    ][22598] unless execution succeeded
2017-12-03 11:12:52,429 [salt.state       ][INFO    ][22598] Completed state [virtng.init] at time 11:12:52.429264 duration_in_ms=17.473
2017-12-03 11:12:52,430 [salt.state       ][INFO    ][22598] Running state [virt.set_autostart] at time 11:12:52.429515
2017-12-03 11:12:52,430 [salt.state       ][INFO    ][22598] Executing state module.run for virt.set_autostart
2017-12-03 11:12:52,432 [salt.loaded.int.module.cmdmod][INFO    ][22598] Executing command 'virsh list --autostart --name| grep -E "^dbs01.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-12-03 11:12:52,446 [salt.state       ][INFO    ][22598] unless execution succeeded
2017-12-03 11:12:52,447 [salt.state       ][INFO    ][22598] Completed state [virt.set_autostart] at time 11:12:52.446591 duration_in_ms=17.077
2017-12-03 11:12:52,450 [salt.minion      ][INFO    ][22598] Returning information for job: 20171203111246694856
2017-12-03 11:12:53,814 [salt.minion      ][INFO    ][22250] User sudo_ubuntu Executing command pillar.get with jid 20171203111253798128
2017-12-03 11:12:53,825 [salt.minion      ][INFO    ][22693] Starting a new job with PID 22693
2017-12-03 11:12:53,828 [salt.minion      ][INFO    ][22693] Returning information for job: 20171203111253798128
2017-12-03 11:13:13,021 [salt.minion      ][INFO    ][22250] User sudo_ubuntu Executing command saltutil.sync_all with jid 20171203111313010072
2017-12-03 11:13:13,034 [salt.minion      ][INFO    ][22702] Starting a new job with PID 22702
2017-12-03 11:13:16,182 [salt.state       ][INFO    ][22702] Loading fresh modules for state activity
2017-12-03 11:13:16,209 [salt.state       ][ERROR   ][22702] No contents found in top file
2017-12-03 11:13:16,210 [salt.utils.extmods][INFO    ][22702] Creating module dir '/var/cache/salt/minion/extmods/beacons'
2017-12-03 11:13:16,213 [salt.utils.extmods][INFO    ][22702] Syncing beacons for environment 'base'
2017-12-03 11:13:16,213 [salt.utils.extmods][INFO    ][22702] Loading cache from salt://_beacons, for base)
2017-12-03 11:13:16,213 [salt.fileclient  ][INFO    ][22702] Caching directory '_beacons/' for environment 'base'
2017-12-03 11:13:16,265 [salt.utils.extmods][INFO    ][22702] Syncing modules for environment 'base'
2017-12-03 11:13:16,265 [salt.utils.extmods][INFO    ][22702] Loading cache from salt://_modules, for base)
2017-12-03 11:13:16,265 [salt.fileclient  ][INFO    ][22702] Caching directory '_modules/' for environment 'base'
2017-12-03 11:13:16,307 [salt.fileclient  ][INFO    ][22702] Fetching file from saltenv 'base', ** done ** '_modules/avinetworks.py'
2017-12-03 11:13:16,315 [salt.fileclient  ][INFO    ][22702] Fetching file from saltenv 'base', ** done ** '_modules/ceph_ng.py'
2017-12-03 11:13:16,324 [salt.fileclient  ][INFO    ][22702] Fetching file from saltenv 'base', ** done ** '_modules/cinderng.py'
2017-12-03 11:13:16,334 [salt.fileclient  ][INFO    ][22702] Fetching file from saltenv 'base', ** done ** '_modules/contrail.py'
2017-12-03 11:13:17,521 [salt.fileclient  ][INFO    ][22702] Fetching file from saltenv 'base', ** done ** '_modules/creds.py'
2017-12-03 11:13:17,539 [salt.fileclient  ][INFO    ][22702] Fetching file from saltenv 'base', ** done ** '_modules/devops_utils.py'
2017-12-03 11:13:17,944 [salt.fileclient  ][INFO    ][22702] Fetching file from saltenv 'base', ** done ** '_modules/encode_json.py'
2017-12-03 11:13:17,953 [salt.fileclient  ][INFO    ][22702] Fetching file from saltenv 'base', ** done ** '_modules/gerrit.py'
2017-12-03 11:13:17,969 [salt.fileclient  ][INFO    ][22702] Fetching file from saltenv 'base', ** done ** '_modules/glanceng.py'
2017-12-03 11:13:17,981 [salt.fileclient  ][INFO    ][22702] Fetching file from saltenv 'base', ** done ** '_modules/heat.py'
2017-12-03 11:13:18,003 [salt.fileclient  ][INFO    ][22702] Fetching file from saltenv 'base', ** done ** '_modules/heka_alarming.py'
2017-12-03 11:13:18,116 [salt.fileclient  ][INFO    ][22702] Fetching file from saltenv 'base', ** done ** '_modules/helm.py'
2017-12-03 11:13:18,130 [salt.fileclient  ][INFO    ][22702] Fetching file from saltenv 'base', ** done ** '_modules/jenkins_common.py'
2017-12-03 11:13:18,150 [salt.fileclient  ][INFO    ][22702] Fetching file from saltenv 'base', ** done ** '_modules/keystone_policy.py'
2017-12-03 11:13:18,161 [salt.fileclient  ][INFO    ][22702] Fetching file from saltenv 'base', ** done ** '_modules/linux_hosts.py'
2017-12-03 11:13:18,173 [salt.fileclient  ][INFO    ][22702] Fetching file from saltenv 'base', ** done ** '_modules/linux_netlink.py'
2017-12-03 11:13:18,188 [salt.fileclient  ][INFO    ][22702] Fetching file from saltenv 'base', ** done ** '_modules/maas.py'
2017-12-03 11:13:18,203 [salt.fileclient  ][INFO    ][22702] Fetching file from saltenv 'base', ** done ** '_modules/maas_client.py'
2017-12-03 11:13:18,216 [salt.fileclient  ][INFO    ][22702] Fetching file from saltenv 'base', ** done ** '_modules/modelutils.py'
2017-12-03 11:13:18,226 [salt.fileclient  ][INFO    ][22702] Fetching file from saltenv 'base', ** done ** '_modules/multipart.py'
2017-12-03 11:13:18,237 [salt.fileclient  ][INFO    ][22702] Fetching file from saltenv 'base', ** done ** '_modules/nagios_alarming.py'
2017-12-03 11:13:18,252 [salt.fileclient  ][INFO    ][22702] Fetching file from saltenv 'base', ** done ** '_modules/neutronng.py'
2017-12-03 11:13:18,265 [salt.fileclient  ][INFO    ][22702] Fetching file from saltenv 'base', ** done ** '_modules/novang.py'
2017-12-03 11:13:18,276 [salt.fileclient  ][INFO    ][22702] Fetching file from saltenv 'base', ** done ** '_modules/reclass.py'
2017-12-03 11:13:18,290 [salt.fileclient  ][INFO    ][22702] Fetching file from saltenv 'base', ** done ** '_modules/rsyslog_util.py'
2017-12-03 11:13:18,299 [salt.fileclient  ][INFO    ][22702] Fetching file from saltenv 'base', ** done ** '_modules/rundeck.py'
2017-12-03 11:13:18,310 [salt.fileclient  ][INFO    ][22702] Fetching file from saltenv 'base', ** done ** '_modules/saltkey.py'
2017-12-03 11:13:18,321 [salt.fileclient  ][INFO    ][22702] Fetching file from saltenv 'base', ** done ** '_modules/saltresource.py'
2017-12-03 11:13:18,332 [salt.fileclient  ][INFO    ][22702] Fetching file from saltenv 'base', ** done ** '_modules/seedng.py'
2017-12-03 11:13:18,349 [salt.fileclient  ][INFO    ][22702] Fetching file from saltenv 'base', ** done ** '_modules/testing/credentials.py'
2017-12-03 11:13:18,359 [salt.fileclient  ][INFO    ][22702] Fetching file from saltenv 'base', ** done ** '_modules/testing/django.py'
2017-12-03 11:13:18,376 [salt.fileclient  ][INFO    ][22702] Fetching file from saltenv 'base', ** done ** '_modules/testing/django_client_proxy.py'
2017-12-03 11:13:18,401 [salt.fileclient  ][INFO    ][22702] Fetching file from saltenv 'base', ** done ** '_modules/utils.py'
2017-12-03 11:13:18,414 [salt.fileclient  ][INFO    ][22702] Fetching file from saltenv 'base', ** done ** '_modules/virtng.py'
2017-12-03 11:13:18,418 [salt.utils.extmods][INFO    ][22702] Copying '/var/cache/salt/minion/files/base/_modules/__init__.py' to '/var/cache/salt/minion/extmods/modules/__init__.py'
2017-12-03 11:13:18,418 [salt.utils.extmods][INFO    ][22702] Copying '/var/cache/salt/minion/files/base/_modules/avinetworks.py' to '/var/cache/salt/minion/extmods/modules/avinetworks.py'
2017-12-03 11:13:18,418 [salt.utils.extmods][INFO    ][22702] Copying '/var/cache/salt/minion/files/base/_modules/ceph_ng.py' to '/var/cache/salt/minion/extmods/modules/ceph_ng.py'
2017-12-03 11:13:18,419 [salt.utils.extmods][INFO    ][22702] Copying '/var/cache/salt/minion/files/base/_modules/cinderng.py' to '/var/cache/salt/minion/extmods/modules/cinderng.py'
2017-12-03 11:13:18,419 [salt.utils.extmods][INFO    ][22702] Copying '/var/cache/salt/minion/files/base/_modules/contrail.py' to '/var/cache/salt/minion/extmods/modules/contrail.py'
2017-12-03 11:13:18,419 [salt.utils.extmods][INFO    ][22702] Copying '/var/cache/salt/minion/files/base/_modules/creds.py' to '/var/cache/salt/minion/extmods/modules/creds.py'
2017-12-03 11:13:18,420 [salt.utils.extmods][INFO    ][22702] Copying '/var/cache/salt/minion/files/base/_modules/devops_utils.py' to '/var/cache/salt/minion/extmods/modules/devops_utils.py'
2017-12-03 11:13:18,420 [salt.utils.extmods][INFO    ][22702] Copying '/var/cache/salt/minion/files/base/_modules/encode_json.py' to '/var/cache/salt/minion/extmods/modules/encode_json.py'
2017-12-03 11:13:18,420 [salt.utils.extmods][INFO    ][22702] Copying '/var/cache/salt/minion/files/base/_modules/gerrit.py' to '/var/cache/salt/minion/extmods/modules/gerrit.py'
2017-12-03 11:13:18,420 [salt.utils.extmods][INFO    ][22702] Copying '/var/cache/salt/minion/files/base/_modules/glanceng.py' to '/var/cache/salt/minion/extmods/modules/glanceng.py'
2017-12-03 11:13:18,421 [salt.utils.extmods][INFO    ][22702] Copying '/var/cache/salt/minion/files/base/_modules/heat.py' to '/var/cache/salt/minion/extmods/modules/heat.py'
2017-12-03 11:13:18,421 [salt.utils.extmods][INFO    ][22702] Copying '/var/cache/salt/minion/files/base/_modules/heka_alarming.py' to '/var/cache/salt/minion/extmods/modules/heka_alarming.py'
2017-12-03 11:13:18,421 [salt.utils.extmods][INFO    ][22702] Copying '/var/cache/salt/minion/files/base/_modules/helm.py' to '/var/cache/salt/minion/extmods/modules/helm.py'
2017-12-03 11:13:18,421 [salt.utils.extmods][INFO    ][22702] Copying '/var/cache/salt/minion/files/base/_modules/jenkins_common.py' to '/var/cache/salt/minion/extmods/modules/jenkins_common.py'
2017-12-03 11:13:18,422 [salt.utils.extmods][INFO    ][22702] Copying '/var/cache/salt/minion/files/base/_modules/keystone_policy.py' to '/var/cache/salt/minion/extmods/modules/keystone_policy.py'
2017-12-03 11:13:18,422 [salt.utils.extmods][INFO    ][22702] Copying '/var/cache/salt/minion/files/base/_modules/linux_hosts.py' to '/var/cache/salt/minion/extmods/modules/linux_hosts.py'
2017-12-03 11:13:18,422 [salt.utils.extmods][INFO    ][22702] Copying '/var/cache/salt/minion/files/base/_modules/linux_netlink.py' to '/var/cache/salt/minion/extmods/modules/linux_netlink.py'
2017-12-03 11:13:18,422 [salt.utils.extmods][INFO    ][22702] Copying '/var/cache/salt/minion/files/base/_modules/maas.py' to '/var/cache/salt/minion/extmods/modules/maas.py'
2017-12-03 11:13:18,423 [salt.utils.extmods][INFO    ][22702] Copying '/var/cache/salt/minion/files/base/_modules/maas_client.py' to '/var/cache/salt/minion/extmods/modules/maas_client.py'
2017-12-03 11:13:18,423 [salt.utils.extmods][INFO    ][22702] Copying '/var/cache/salt/minion/files/base/_modules/modelutils.py' to '/var/cache/salt/minion/extmods/modules/modelutils.py'
2017-12-03 11:13:18,423 [salt.utils.extmods][INFO    ][22702] Copying '/var/cache/salt/minion/files/base/_modules/multipart.py' to '/var/cache/salt/minion/extmods/modules/multipart.py'
2017-12-03 11:13:18,423 [salt.utils.extmods][INFO    ][22702] Copying '/var/cache/salt/minion/files/base/_modules/nagios_alarming.py' to '/var/cache/salt/minion/extmods/modules/nagios_alarming.py'
2017-12-03 11:13:18,424 [salt.utils.extmods][INFO    ][22702] Copying '/var/cache/salt/minion/files/base/_modules/neutronng.py' to '/var/cache/salt/minion/extmods/modules/neutronng.py'
2017-12-03 11:13:18,424 [salt.utils.extmods][INFO    ][22702] Copying '/var/cache/salt/minion/files/base/_modules/novang.py' to '/var/cache/salt/minion/extmods/modules/novang.py'
2017-12-03 11:13:18,424 [salt.utils.extmods][INFO    ][22702] Copying '/var/cache/salt/minion/files/base/_modules/reclass.py' to '/var/cache/salt/minion/extmods/modules/reclass.py'
2017-12-03 11:13:18,425 [salt.utils.extmods][INFO    ][22702] Copying '/var/cache/salt/minion/files/base/_modules/rsyslog_util.py' to '/var/cache/salt/minion/extmods/modules/rsyslog_util.py'
2017-12-03 11:13:18,425 [salt.utils.extmods][INFO    ][22702] Copying '/var/cache/salt/minion/files/base/_modules/rundeck.py' to '/var/cache/salt/minion/extmods/modules/rundeck.py'
2017-12-03 11:13:18,425 [salt.utils.extmods][INFO    ][22702] Copying '/var/cache/salt/minion/files/base/_modules/saltkey.py' to '/var/cache/salt/minion/extmods/modules/saltkey.py'
2017-12-03 11:13:18,425 [salt.utils.extmods][INFO    ][22702] Copying '/var/cache/salt/minion/files/base/_modules/saltresource.py' to '/var/cache/salt/minion/extmods/modules/saltresource.py'
2017-12-03 11:13:18,426 [salt.utils.extmods][INFO    ][22702] Copying '/var/cache/salt/minion/files/base/_modules/seedng.py' to '/var/cache/salt/minion/extmods/modules/seedng.py'
2017-12-03 11:13:18,426 [salt.utils.extmods][INFO    ][22702] Copying '/var/cache/salt/minion/files/base/_modules/testing/__init__.py' to '/var/cache/salt/minion/extmods/modules/testing/__init__.py'
2017-12-03 11:13:18,426 [salt.utils.extmods][INFO    ][22702] Copying '/var/cache/salt/minion/files/base/_modules/testing/credentials.py' to '/var/cache/salt/minion/extmods/modules/testing/credentials.py'
2017-12-03 11:13:18,426 [salt.utils.extmods][INFO    ][22702] Copying '/var/cache/salt/minion/files/base/_modules/testing/django.py' to '/var/cache/salt/minion/extmods/modules/testing/django.py'
2017-12-03 11:13:18,426 [salt.utils.extmods][INFO    ][22702] 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 11:13:18,427 [salt.utils.extmods][INFO    ][22702] Copying '/var/cache/salt/minion/files/base/_modules/utils.py' to '/var/cache/salt/minion/extmods/modules/utils.py'
2017-12-03 11:13:18,427 [salt.utils.extmods][INFO    ][22702] Copying '/var/cache/salt/minion/files/base/_modules/virtng.py' to '/var/cache/salt/minion/extmods/modules/virtng.py'
2017-12-03 11:13:18,432 [salt.utils.extmods][INFO    ][22702] Syncing states for environment 'base'
2017-12-03 11:13:18,433 [salt.utils.extmods][INFO    ][22702] Loading cache from salt://_states, for base)
2017-12-03 11:13:18,433 [salt.fileclient  ][INFO    ][22702] Caching directory '_states/' for environment 'base'
2017-12-03 11:13:18,467 [salt.fileclient  ][INFO    ][22702] Fetching file from saltenv 'base', ** done ** '_states/avinetworks.py'
2017-12-03 11:13:18,476 [salt.fileclient  ][INFO    ][22702] Fetching file from saltenv 'base', ** done ** '_states/cinderng.py'
2017-12-03 11:13:18,488 [salt.fileclient  ][INFO    ][22702] Fetching file from saltenv 'base', ** done ** '_states/contrail.py'
2017-12-03 11:13:18,499 [salt.fileclient  ][INFO    ][22702] Fetching file from saltenv 'base', ** done ** '_states/gerrit.py'
2017-12-03 11:13:18,517 [salt.fileclient  ][INFO    ][22702] Fetching file from saltenv 'base', ** done ** '_states/glanceng.py'
2017-12-03 11:13:18,537 [salt.fileclient  ][INFO    ][22702] Fetching file from saltenv 'base', ** done ** '_states/grafana3_dashboard.py'
2017-12-03 11:13:18,553 [salt.fileclient  ][INFO    ][22702] Fetching file from saltenv 'base', ** done ** '_states/grafana3_datasource.py'
2017-12-03 11:13:18,578 [salt.fileclient  ][INFO    ][22702] Fetching file from saltenv 'base', ** done ** '_states/heat.py'
2017-12-03 11:13:18,605 [salt.fileclient  ][INFO    ][22702] Fetching file from saltenv 'base', ** done ** '_states/helm_release.py'
2017-12-03 11:13:18,624 [salt.fileclient  ][INFO    ][22702] Fetching file from saltenv 'base', ** done ** '_states/helm_repos.py'
2017-12-03 11:13:18,637 [salt.fileclient  ][INFO    ][22702] Fetching file from saltenv 'base', ** done ** '_states/jenkins_approval.py'
2017-12-03 11:13:18,651 [salt.fileclient  ][INFO    ][22702] Fetching file from saltenv 'base', ** done ** '_states/jenkins_artifactory.py'
2017-12-03 11:13:18,672 [salt.fileclient  ][INFO    ][22702] Fetching file from saltenv 'base', ** done ** '_states/jenkins_credential.py'
2017-12-03 11:13:18,690 [salt.fileclient  ][INFO    ][22702] Fetching file from saltenv 'base', ** done ** '_states/jenkins_globalenvprop.py'
2017-12-03 11:13:18,701 [salt.fileclient  ][INFO    ][22702] Fetching file from saltenv 'base', ** done ** '_states/jenkins_job.py'
2017-12-03 11:13:18,713 [salt.fileclient  ][INFO    ][22702] Fetching file from saltenv 'base', ** done ** '_states/jenkins_lib.py'
2017-12-03 11:13:18,737 [salt.fileclient  ][INFO    ][22702] Fetching file from saltenv 'base', ** done ** '_states/jenkins_node.py'
2017-12-03 11:13:18,745 [salt.fileclient  ][INFO    ][22702] Fetching file from saltenv 'base', ** done ** '_states/jenkins_plugin.py'
2017-12-03 11:13:18,759 [salt.fileclient  ][INFO    ][22702] Fetching file from saltenv 'base', ** done ** '_states/jenkins_security.py'
2017-12-03 11:13:18,772 [salt.fileclient  ][INFO    ][22702] Fetching file from saltenv 'base', ** done ** '_states/jenkins_slack.py'
2017-12-03 11:13:18,786 [salt.fileclient  ][INFO    ][22702] Fetching file from saltenv 'base', ** done ** '_states/jenkins_smtp.py'
2017-12-03 11:13:18,804 [salt.fileclient  ][INFO    ][22702] Fetching file from saltenv 'base', ** done ** '_states/jenkins_theme.py'
2017-12-03 11:13:18,814 [salt.fileclient  ][INFO    ][22702] Fetching file from saltenv 'base', ** done ** '_states/jenkins_user.py'
2017-12-03 11:13:18,836 [salt.fileclient  ][INFO    ][22702] Fetching file from saltenv 'base', ** done ** '_states/jenkins_view.py'
2017-12-03 11:13:18,850 [salt.fileclient  ][INFO    ][22702] Fetching file from saltenv 'base', ** done ** '_states/keystone_policy.py'
2017-12-03 11:13:18,869 [salt.fileclient  ][INFO    ][22702] Fetching file from saltenv 'base', ** done ** '_states/kibana_object.py'
2017-12-03 11:13:18,911 [salt.fileclient  ][INFO    ][22702] Fetching file from saltenv 'base', ** done ** '_states/neutronng.py'
2017-12-03 11:13:18,925 [salt.fileclient  ][INFO    ][22702] Fetching file from saltenv 'base', ** done ** '_states/novang.py'
2017-12-03 11:13:18,948 [salt.fileclient  ][INFO    ][22702] Fetching file from saltenv 'base', ** done ** '_states/reclass.py'
2017-12-03 11:13:18,997 [salt.fileclient  ][INFO    ][22702] Fetching file from saltenv 'base', ** done ** '_states/rundeck_project.py'
2017-12-03 11:13:19,008 [salt.fileclient  ][INFO    ][22702] Fetching file from saltenv 'base', ** done ** '_states/rundeck_scm.py'
2017-12-03 11:13:19,026 [salt.fileclient  ][INFO    ][22702] Fetching file from saltenv 'base', ** done ** '_states/rundeck_secret.py'
2017-12-03 11:13:19,030 [salt.utils.extmods][INFO    ][22702] Copying '/var/cache/salt/minion/files/base/_states/avinetworks.py' to '/var/cache/salt/minion/extmods/states/avinetworks.py'
2017-12-03 11:13:19,031 [salt.utils.extmods][INFO    ][22702] Copying '/var/cache/salt/minion/files/base/_states/cinderng.py' to '/var/cache/salt/minion/extmods/states/cinderng.py'
2017-12-03 11:13:19,031 [salt.utils.extmods][INFO    ][22702] Copying '/var/cache/salt/minion/files/base/_states/contrail.py' to '/var/cache/salt/minion/extmods/states/contrail.py'
2017-12-03 11:13:19,031 [salt.utils.extmods][INFO    ][22702] Copying '/var/cache/salt/minion/files/base/_states/gerrit.py' to '/var/cache/salt/minion/extmods/states/gerrit.py'
2017-12-03 11:13:19,032 [salt.utils.extmods][INFO    ][22702] Copying '/var/cache/salt/minion/files/base/_states/glanceng.py' to '/var/cache/salt/minion/extmods/states/glanceng.py'
2017-12-03 11:13:19,032 [salt.utils.extmods][INFO    ][22702] Copying '/var/cache/salt/minion/files/base/_states/grafana3_dashboard.py' to '/var/cache/salt/minion/extmods/states/grafana3_dashboard.py'
2017-12-03 11:13:19,032 [salt.utils.extmods][INFO    ][22702] Copying '/var/cache/salt/minion/files/base/_states/grafana3_datasource.py' to '/var/cache/salt/minion/extmods/states/grafana3_datasource.py'
2017-12-03 11:13:19,033 [salt.utils.extmods][INFO    ][22702] Copying '/var/cache/salt/minion/files/base/_states/heat.py' to '/var/cache/salt/minion/extmods/states/heat.py'
2017-12-03 11:13:19,033 [salt.utils.extmods][INFO    ][22702] Copying '/var/cache/salt/minion/files/base/_states/helm_release.py' to '/var/cache/salt/minion/extmods/states/helm_release.py'
2017-12-03 11:13:19,033 [salt.utils.extmods][INFO    ][22702] Copying '/var/cache/salt/minion/files/base/_states/helm_repos.py' to '/var/cache/salt/minion/extmods/states/helm_repos.py'
2017-12-03 11:13:19,033 [salt.utils.extmods][INFO    ][22702] Copying '/var/cache/salt/minion/files/base/_states/jenkins_approval.py' to '/var/cache/salt/minion/extmods/states/jenkins_approval.py'
2017-12-03 11:13:19,034 [salt.utils.extmods][INFO    ][22702] Copying '/var/cache/salt/minion/files/base/_states/jenkins_artifactory.py' to '/var/cache/salt/minion/extmods/states/jenkins_artifactory.py'
2017-12-03 11:13:19,034 [salt.utils.extmods][INFO    ][22702] Copying '/var/cache/salt/minion/files/base/_states/jenkins_credential.py' to '/var/cache/salt/minion/extmods/states/jenkins_credential.py'
2017-12-03 11:13:19,034 [salt.utils.extmods][INFO    ][22702] Copying '/var/cache/salt/minion/files/base/_states/jenkins_globalenvprop.py' to '/var/cache/salt/minion/extmods/states/jenkins_globalenvprop.py'
2017-12-03 11:13:19,034 [salt.utils.extmods][INFO    ][22702] Copying '/var/cache/salt/minion/files/base/_states/jenkins_job.py' to '/var/cache/salt/minion/extmods/states/jenkins_job.py'
2017-12-03 11:13:19,035 [salt.utils.extmods][INFO    ][22702] Copying '/var/cache/salt/minion/files/base/_states/jenkins_lib.py' to '/var/cache/salt/minion/extmods/states/jenkins_lib.py'
2017-12-03 11:13:19,035 [salt.utils.extmods][INFO    ][22702] Copying '/var/cache/salt/minion/files/base/_states/jenkins_node.py' to '/var/cache/salt/minion/extmods/states/jenkins_node.py'
2017-12-03 11:13:19,035 [salt.utils.extmods][INFO    ][22702] Copying '/var/cache/salt/minion/files/base/_states/jenkins_plugin.py' to '/var/cache/salt/minion/extmods/states/jenkins_plugin.py'
2017-12-03 11:13:19,035 [salt.utils.extmods][INFO    ][22702] Copying '/var/cache/salt/minion/files/base/_states/jenkins_security.py' to '/var/cache/salt/minion/extmods/states/jenkins_security.py'
2017-12-03 11:13:19,036 [salt.utils.extmods][INFO    ][22702] Copying '/var/cache/salt/minion/files/base/_states/jenkins_slack.py' to '/var/cache/salt/minion/extmods/states/jenkins_slack.py'
2017-12-03 11:13:19,036 [salt.utils.extmods][INFO    ][22702] Copying '/var/cache/salt/minion/files/base/_states/jenkins_smtp.py' to '/var/cache/salt/minion/extmods/states/jenkins_smtp.py'
2017-12-03 11:13:19,036 [salt.utils.extmods][INFO    ][22702] Copying '/var/cache/salt/minion/files/base/_states/jenkins_theme.py' to '/var/cache/salt/minion/extmods/states/jenkins_theme.py'
2017-12-03 11:13:19,036 [salt.utils.extmods][INFO    ][22702] Copying '/var/cache/salt/minion/files/base/_states/jenkins_user.py' to '/var/cache/salt/minion/extmods/states/jenkins_user.py'
2017-12-03 11:13:19,037 [salt.utils.extmods][INFO    ][22702] Copying '/var/cache/salt/minion/files/base/_states/jenkins_view.py' to '/var/cache/salt/minion/extmods/states/jenkins_view.py'
2017-12-03 11:13:19,037 [salt.utils.extmods][INFO    ][22702] Copying '/var/cache/salt/minion/files/base/_states/keystone_policy.py' to '/var/cache/salt/minion/extmods/states/keystone_policy.py'
2017-12-03 11:13:19,037 [salt.utils.extmods][INFO    ][22702] Copying '/var/cache/salt/minion/files/base/_states/kibana_object.py' to '/var/cache/salt/minion/extmods/states/kibana_object.py'
2017-12-03 11:13:19,037 [salt.utils.extmods][INFO    ][22702] Copying '/var/cache/salt/minion/files/base/_states/maas_cluster.py' to '/var/cache/salt/minion/extmods/states/maas_cluster.py'
2017-12-03 11:13:19,038 [salt.utils.extmods][INFO    ][22702] Copying '/var/cache/salt/minion/files/base/_states/neutronng.py' to '/var/cache/salt/minion/extmods/states/neutronng.py'
2017-12-03 11:13:19,038 [salt.utils.extmods][INFO    ][22702] Copying '/var/cache/salt/minion/files/base/_states/novang.py' to '/var/cache/salt/minion/extmods/states/novang.py'
2017-12-03 11:13:19,038 [salt.utils.extmods][INFO    ][22702] Copying '/var/cache/salt/minion/files/base/_states/reclass.py' to '/var/cache/salt/minion/extmods/states/reclass.py'
2017-12-03 11:13:19,039 [salt.utils.extmods][INFO    ][22702] Copying '/var/cache/salt/minion/files/base/_states/rundeck_project.py' to '/var/cache/salt/minion/extmods/states/rundeck_project.py'
2017-12-03 11:13:19,039 [salt.utils.extmods][INFO    ][22702] Copying '/var/cache/salt/minion/files/base/_states/rundeck_scm.py' to '/var/cache/salt/minion/extmods/states/rundeck_scm.py'
2017-12-03 11:13:19,039 [salt.utils.extmods][INFO    ][22702] Copying '/var/cache/salt/minion/files/base/_states/rundeck_secret.py' to '/var/cache/salt/minion/extmods/states/rundeck_secret.py'
2017-12-03 11:13:19,042 [salt.utils.extmods][INFO    ][22702] Creating module dir '/var/cache/salt/minion/extmods/sdb'
2017-12-03 11:13:19,045 [salt.utils.extmods][INFO    ][22702] Syncing sdb for environment 'base'
2017-12-03 11:13:19,045 [salt.utils.extmods][INFO    ][22702] Loading cache from salt://_sdb, for base)
2017-12-03 11:13:19,045 [salt.fileclient  ][INFO    ][22702] Caching directory '_sdb/' for environment 'base'
2017-12-03 11:13:19,124 [salt.utils.extmods][INFO    ][22702] Syncing grains for environment 'base'
2017-12-03 11:13:19,124 [salt.utils.extmods][INFO    ][22702] Loading cache from salt://_grains, for base)
2017-12-03 11:13:19,124 [salt.fileclient  ][INFO    ][22702] Caching directory '_grains/' for environment 'base'
2017-12-03 11:13:19,190 [salt.fileclient  ][INFO    ][22702] Fetching file from saltenv 'base', ** done ** '_grains/ceilometer_policy.py'
2017-12-03 11:13:19,210 [salt.fileclient  ][INFO    ][22702] Fetching file from saltenv 'base', ** done ** '_grains/ceph.py'
2017-12-03 11:13:19,228 [salt.fileclient  ][INFO    ][22702] Fetching file from saltenv 'base', ** done ** '_grains/cinder_policy.py'
2017-12-03 11:13:19,246 [salt.fileclient  ][INFO    ][22702] Fetching file from saltenv 'base', ** done ** '_grains/docker_swarm.py'
2017-12-03 11:13:19,274 [salt.fileclient  ][INFO    ][22702] Fetching file from saltenv 'base', ** done ** '_grains/glance_policy.py'
2017-12-03 11:13:19,317 [salt.fileclient  ][INFO    ][22702] Fetching file from saltenv 'base', ** done ** '_grains/heat_policy.py'
2017-12-03 11:13:19,345 [salt.fileclient  ][INFO    ][22702] Fetching file from saltenv 'base', ** done ** '_grains/jenkins_plugins.py'
2017-12-03 11:13:19,364 [salt.fileclient  ][INFO    ][22702] Fetching file from saltenv 'base', ** done ** '_grains/keystone_policy.py'
2017-12-03 11:13:19,385 [salt.fileclient  ][INFO    ][22702] Fetching file from saltenv 'base', ** done ** '_grains/kubernetes.py'
2017-12-03 11:13:19,406 [salt.fileclient  ][INFO    ][22702] Fetching file from saltenv 'base', ** done ** '_grains/neutron_policy.py'
2017-12-03 11:13:19,420 [salt.fileclient  ][INFO    ][22702] Fetching file from saltenv 'base', ** done ** '_grains/nova_policy.py'
2017-12-03 11:13:19,436 [salt.fileclient  ][INFO    ][22702] Fetching file from saltenv 'base', ** done ** '_grains/ssh_fingerprints.py'
2017-12-03 11:13:19,440 [salt.utils.extmods][INFO    ][22702] Copying '/var/cache/salt/minion/files/base/_grains/ceilometer_policy.py' to '/var/cache/salt/minion/extmods/grains/ceilometer_policy.py'
2017-12-03 11:13:19,440 [salt.utils.extmods][INFO    ][22702] Copying '/var/cache/salt/minion/files/base/_grains/ceph.py' to '/var/cache/salt/minion/extmods/grains/ceph.py'
2017-12-03 11:13:19,441 [salt.utils.extmods][INFO    ][22702] Copying '/var/cache/salt/minion/files/base/_grains/cinder_policy.py' to '/var/cache/salt/minion/extmods/grains/cinder_policy.py'
2017-12-03 11:13:19,441 [salt.utils.extmods][INFO    ][22702] Copying '/var/cache/salt/minion/files/base/_grains/docker_swarm.py' to '/var/cache/salt/minion/extmods/grains/docker_swarm.py'
2017-12-03 11:13:19,441 [salt.utils.extmods][INFO    ][22702] Copying '/var/cache/salt/minion/files/base/_grains/glance_policy.py' to '/var/cache/salt/minion/extmods/grains/glance_policy.py'
2017-12-03 11:13:19,441 [salt.utils.extmods][INFO    ][22702] Copying '/var/cache/salt/minion/files/base/_grains/heat_policy.py' to '/var/cache/salt/minion/extmods/grains/heat_policy.py'
2017-12-03 11:13:19,442 [salt.utils.extmods][INFO    ][22702] Copying '/var/cache/salt/minion/files/base/_grains/jenkins_plugins.py' to '/var/cache/salt/minion/extmods/grains/jenkins_plugins.py'
2017-12-03 11:13:19,442 [salt.utils.extmods][INFO    ][22702] Copying '/var/cache/salt/minion/files/base/_grains/keystone_policy.py' to '/var/cache/salt/minion/extmods/grains/keystone_policy.py'
2017-12-03 11:13:19,442 [salt.utils.extmods][INFO    ][22702] Copying '/var/cache/salt/minion/files/base/_grains/kubernetes.py' to '/var/cache/salt/minion/extmods/grains/kubernetes.py'
2017-12-03 11:13:19,442 [salt.utils.extmods][INFO    ][22702] Copying '/var/cache/salt/minion/files/base/_grains/neutron_policy.py' to '/var/cache/salt/minion/extmods/grains/neutron_policy.py'
2017-12-03 11:13:19,442 [salt.utils.extmods][INFO    ][22702] Copying '/var/cache/salt/minion/files/base/_grains/nova_policy.py' to '/var/cache/salt/minion/extmods/grains/nova_policy.py'
2017-12-03 11:13:19,443 [salt.utils.extmods][INFO    ][22702] Copying '/var/cache/salt/minion/files/base/_grains/ssh_fingerprints.py' to '/var/cache/salt/minion/extmods/grains/ssh_fingerprints.py'
2017-12-03 11:13:19,444 [salt.utils.extmods][INFO    ][22702] Creating module dir '/var/cache/salt/minion/extmods/renderers'
2017-12-03 11:13:19,447 [salt.utils.extmods][INFO    ][22702] Syncing renderers for environment 'base'
2017-12-03 11:13:19,447 [salt.utils.extmods][INFO    ][22702] Loading cache from salt://_renderers, for base)
2017-12-03 11:13:19,447 [salt.fileclient  ][INFO    ][22702] Caching directory '_renderers/' for environment 'base'
2017-12-03 11:13:19,516 [salt.utils.extmods][INFO    ][22702] Creating module dir '/var/cache/salt/minion/extmods/returners'
2017-12-03 11:13:19,519 [salt.utils.extmods][INFO    ][22702] Syncing returners for environment 'base'
2017-12-03 11:13:19,519 [salt.utils.extmods][INFO    ][22702] Loading cache from salt://_returners, for base)
2017-12-03 11:13:19,519 [salt.fileclient  ][INFO    ][22702] Caching directory '_returners/' for environment 'base'
2017-12-03 11:13:19,568 [salt.utils.extmods][INFO    ][22702] Creating module dir '/var/cache/salt/minion/extmods/output'
2017-12-03 11:13:19,571 [salt.utils.extmods][INFO    ][22702] Syncing output for environment 'base'
2017-12-03 11:13:19,571 [salt.utils.extmods][INFO    ][22702] Loading cache from salt://_output, for base)
2017-12-03 11:13:19,572 [salt.fileclient  ][INFO    ][22702] Caching directory '_output/' for environment 'base'
2017-12-03 11:13:19,636 [salt.utils.extmods][INFO    ][22702] Creating module dir '/var/cache/salt/minion/extmods/utils'
2017-12-03 11:13:19,639 [salt.utils.extmods][INFO    ][22702] Syncing utils for environment 'base'
2017-12-03 11:13:19,639 [salt.utils.extmods][INFO    ][22702] Loading cache from salt://_utils, for base)
2017-12-03 11:13:19,639 [salt.fileclient  ][INFO    ][22702] Caching directory '_utils/' for environment 'base'
2017-12-03 11:13:19,685 [salt.utils.extmods][INFO    ][22702] Creating module dir '/var/cache/salt/minion/extmods/log_handlers'
2017-12-03 11:13:19,688 [salt.utils.extmods][INFO    ][22702] Syncing log_handlers for environment 'base'
2017-12-03 11:13:19,688 [salt.utils.extmods][INFO    ][22702] Loading cache from salt://_log_handlers, for base)
2017-12-03 11:13:19,688 [salt.fileclient  ][INFO    ][22702] Caching directory '_log_handlers/' for environment 'base'
2017-12-03 11:13:19,742 [salt.utils.extmods][INFO    ][22702] Creating module dir '/var/cache/salt/minion/extmods/proxy'
2017-12-03 11:13:19,745 [salt.utils.extmods][INFO    ][22702] Syncing proxy for environment 'base'
2017-12-03 11:13:19,745 [salt.utils.extmods][INFO    ][22702] Loading cache from salt://_proxy, for base)
2017-12-03 11:13:19,745 [salt.fileclient  ][INFO    ][22702] Caching directory '_proxy/' for environment 'base'
2017-12-03 11:13:19,796 [salt.utils.extmods][INFO    ][22702] Creating module dir '/var/cache/salt/minion/extmods/engines'
2017-12-03 11:13:19,799 [salt.utils.extmods][INFO    ][22702] Syncing engines for environment 'base'
2017-12-03 11:13:19,799 [salt.utils.extmods][INFO    ][22702] Loading cache from salt://_engines, for base)
2017-12-03 11:13:19,799 [salt.fileclient  ][INFO    ][22702] Caching directory '_engines/' for environment 'base'
2017-12-03 11:13:19,919 [salt.minion      ][INFO    ][22702] Returning information for job: 20171203111313010072
2017-12-03 11:31:14,039 [salt.minion      ][INFO    ][22250] User sudo_ubuntu Executing command test.ping with jid 20171203113114030967
2017-12-03 11:31:14,054 [salt.minion      ][INFO    ][23054] Starting a new job with PID 23054
2017-12-03 11:31:14,092 [salt.minion      ][INFO    ][23054] Returning information for job: 20171203113114030967
2017-12-03 11:31:50,203 [salt.minion      ][INFO    ][22250] User sudo_ubuntu Executing command state.sls with jid 20171203113150196365
2017-12-03 11:31:50,216 [salt.minion      ][INFO    ][23066] Starting a new job with PID 23066
2017-12-03 11:31:50,855 [salt.state       ][INFO    ][23066] Loading fresh modules for state activity
2017-12-03 11:31:50,885 [salt.fileclient  ][INFO    ][23066] Fetching file from saltenv 'base', ** done ** 'keepalived/init.sls'
2017-12-03 11:31:50,904 [salt.fileclient  ][INFO    ][23066] Fetching file from saltenv 'base', ** done ** 'keepalived/cluster.sls'
2017-12-03 11:31:50,931 [salt.fileclient  ][INFO    ][23066] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-12-03 11:31:51,272 [salt.state       ][INFO    ][23066] Running state [lsof] at time 11:31:51.272043
2017-12-03 11:31:51,272 [salt.state       ][INFO    ][23066] Executing state pkg.installed for lsof
2017-12-03 11:31:51,273 [salt.loaded.int.module.cmdmod][INFO    ][23066] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-03 11:31:51,519 [salt.state       ][INFO    ][23066] Package lsof is already installed
2017-12-03 11:31:51,520 [salt.state       ][INFO    ][23066] Completed state [lsof] at time 11:31:51.519748 duration_in_ms=247.704
2017-12-03 11:31:51,520 [salt.state       ][INFO    ][23066] Running state [keepalived] at time 11:31:51.520007
2017-12-03 11:31:51,520 [salt.state       ][INFO    ][23066] Executing state pkg.installed for keepalived
2017-12-03 11:31:51,537 [salt.loaded.int.module.cmdmod][INFO    ][23066] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-12-03 11:31:53,170 [salt.loaded.int.module.cmdmod][INFO    ][23066] 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 11:31:55,767 [salt.loaded.int.module.cmdmod][INFO    ][23066] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-03 11:31:55,794 [salt.state       ][INFO    ][23066] 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 11:31:55,805 [salt.state       ][INFO    ][23066] Loading fresh modules for state activity
2017-12-03 11:31:55,821 [salt.state       ][INFO    ][23066] Completed state [keepalived] at time 11:31:55.820683 duration_in_ms=4300.675
2017-12-03 11:31:55,823 [salt.state       ][INFO    ][23066] Running state [/etc/keepalived/keepalived.conf] at time 11:31:55.822896
2017-12-03 11:31:55,823 [salt.state       ][INFO    ][23066] Executing state file.managed for /etc/keepalived/keepalived.conf
2017-12-03 11:31:55,853 [salt.fileclient  ][INFO    ][23066] Fetching file from saltenv 'base', ** done ** 'keepalived/files/keepalived.conf'
2017-12-03 11:31:55,894 [salt.fileclient  ][INFO    ][23066] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-12-03 11:31:55,902 [salt.state       ][INFO    ][23066] File changed:
New file
2017-12-03 11:31:55,902 [salt.state       ][INFO    ][23066] Completed state [/etc/keepalived/keepalived.conf] at time 11:31:55.902091 duration_in_ms=79.195
2017-12-03 11:31:55,967 [salt.state       ][INFO    ][23066] Running state [keepalived] at time 11:31:55.967441
2017-12-03 11:31:55,968 [salt.state       ][INFO    ][23066] Executing state service.running for keepalived
2017-12-03 11:31:55,969 [salt.loaded.int.module.cmdmod][INFO    ][23066] Executing command ['systemctl', 'status', 'keepalived.service', '-n', '0'] in directory '/root'
2017-12-03 11:31:55,979 [salt.loaded.int.module.cmdmod][INFO    ][23066] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2017-12-03 11:31:55,987 [salt.loaded.int.module.cmdmod][INFO    ][23066] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-12-03 11:31:55,994 [salt.loaded.int.module.cmdmod][INFO    ][23066] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-12-03 11:31:56,002 [salt.loaded.int.module.cmdmod][INFO    ][23066] Executing command ['systemd-run', '--scope', 'systemctl', 'start', 'keepalived.service'] in directory '/root'
2017-12-03 11:31:56,032 [salt.loaded.int.module.cmdmod][INFO    ][23066] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2017-12-03 11:31:56,041 [salt.loaded.int.module.cmdmod][INFO    ][23066] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-12-03 11:31:56,049 [salt.loaded.int.module.cmdmod][INFO    ][23066] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-12-03 11:31:56,056 [salt.state       ][INFO    ][23066] {'keepalived': True}
2017-12-03 11:31:56,056 [salt.state       ][INFO    ][23066] Completed state [keepalived] at time 11:31:56.056059 duration_in_ms=88.617
2017-12-03 11:31:56,057 [salt.minion      ][INFO    ][23066] Returning information for job: 20171203113150196365
2017-12-03 11:33:14,725 [salt.minion      ][INFO    ][22250] User sudo_ubuntu Executing command pillar.get with jid 20171203113314716837
2017-12-03 11:33:14,740 [salt.minion      ][INFO    ][24554] Starting a new job with PID 24554
2017-12-03 11:33:14,743 [salt.minion      ][INFO    ][24554] Returning information for job: 20171203113314716837
2017-12-03 11:37:53,757 [salt.minion      ][INFO    ][22250] User sudo_ubuntu Executing command state.sls with jid 20171203113753750711
2017-12-03 11:37:53,769 [salt.minion      ][INFO    ][24635] Starting a new job with PID 24635
2017-12-03 11:37:56,165 [salt.state       ][INFO    ][24635] Loading fresh modules for state activity
2017-12-03 11:37:56,192 [salt.fileclient  ][INFO    ][24635] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-12-03 11:37:56,218 [salt.fileclient  ][INFO    ][24635] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-12-03 11:37:56,522 [salt.state       ][INFO    ][24635] Running state [attr] at time 11:37:56.522426
2017-12-03 11:37:56,523 [salt.state       ][INFO    ][24635] Executing state pkg.installed for attr
2017-12-03 11:37:56,523 [salt.loaded.int.module.cmdmod][INFO    ][24635] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-03 11:37:56,810 [salt.loaded.int.module.cmdmod][INFO    ][24635] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-12-03 11:37:58,545 [salt.loaded.int.module.cmdmod][INFO    ][24635] 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 11:38:00,153 [salt.loaded.int.module.cmdmod][INFO    ][24635] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-03 11:38:00,182 [salt.state       ][INFO    ][24635] Made the following changes:
'attr' changed from 'absent' to '1:2.4.47-2'

2017-12-03 11:38:00,193 [salt.state       ][INFO    ][24635] Loading fresh modules for state activity
2017-12-03 11:38:00,209 [salt.state       ][INFO    ][24635] Completed state [attr] at time 11:38:00.208718 duration_in_ms=3686.293
2017-12-03 11:38:00,214 [salt.state       ][INFO    ][24635] Running state [glusterfs-server] at time 11:38:00.214357
2017-12-03 11:38:00,215 [salt.state       ][INFO    ][24635] Executing state pkg.installed for glusterfs-server
2017-12-03 11:38:00,439 [salt.loaded.int.module.cmdmod][INFO    ][24635] 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 11:38:03,876 [salt.minion      ][INFO    ][22250] User sudo_ubuntu Executing command saltutil.find_job with jid 20171203113803863028
2017-12-03 11:38:03,888 [salt.minion      ][INFO    ][25514] Starting a new job with PID 25514
2017-12-03 11:38:03,900 [salt.minion      ][INFO    ][25514] Returning information for job: 20171203113803863028
2017-12-03 11:38:10,705 [salt.loaded.int.module.cmdmod][INFO    ][24635] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-03 11:38:10,736 [salt.state       ][INFO    ][24635] 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 11:38:10,747 [salt.state       ][INFO    ][24635] Loading fresh modules for state activity
2017-12-03 11:38:10,765 [salt.state       ][INFO    ][24635] Completed state [glusterfs-server] at time 11:38:10.764594 duration_in_ms=10550.212
2017-12-03 11:38:10,770 [salt.state       ][INFO    ][24635] Running state [bc] at time 11:38:10.769705
2017-12-03 11:38:10,770 [salt.state       ][INFO    ][24635] Executing state pkg.installed for bc
2017-12-03 11:38:11,059 [salt.loaded.int.module.cmdmod][INFO    ][24635] 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 11:38:12,482 [salt.loaded.int.module.cmdmod][INFO    ][24635] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-03 11:38:12,513 [salt.state       ][INFO    ][24635] Made the following changes:
'bc' changed from 'absent' to '1.06.95-9build1'

2017-12-03 11:38:12,524 [salt.state       ][INFO    ][24635] Loading fresh modules for state activity
2017-12-03 11:38:12,543 [salt.state       ][INFO    ][24635] Completed state [bc] at time 11:38:12.542939 duration_in_ms=1773.232
2017-12-03 11:38:12,619 [salt.state       ][INFO    ][24635] Running state [glusterfs-server] at time 11:38:12.619389
2017-12-03 11:38:12,620 [salt.state       ][INFO    ][24635] Executing state service.running for glusterfs-server
2017-12-03 11:38:12,621 [salt.loaded.int.module.cmdmod][INFO    ][24635] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-12-03 11:38:12,631 [salt.loaded.int.module.cmdmod][INFO    ][24635] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-12-03 11:38:12,639 [salt.loaded.int.module.cmdmod][INFO    ][24635] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-12-03 11:38:12,649 [salt.state       ][INFO    ][24635] The service glusterfs-server is already running
2017-12-03 11:38:12,649 [salt.state       ][INFO    ][24635] Completed state [glusterfs-server] at time 11:38:12.648956 duration_in_ms=29.567
2017-12-03 11:38:12,651 [salt.state       ][INFO    ][24635] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 11:38:12.650773
2017-12-03 11:38:12,651 [salt.state       ][INFO    ][24635] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-12-03 11:38:12,656 [salt.state       ][INFO    ][24635] File changed:
New file
2017-12-03 11:38:12,656 [salt.state       ][INFO    ][24635] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 11:38:12.655850 duration_in_ms=5.077
2017-12-03 11:38:12,656 [salt.state       ][INFO    ][24635] Running state [/srv/glusterfs/glance] at time 11:38:12.656048
2017-12-03 11:38:12,656 [salt.state       ][INFO    ][24635] Executing state file.directory for /srv/glusterfs/glance
2017-12-03 11:38:12,657 [salt.state       ][INFO    ][24635] {'/srv/glusterfs/glance': 'New Dir'}
2017-12-03 11:38:12,657 [salt.state       ][INFO    ][24635] Completed state [/srv/glusterfs/glance] at time 11:38:12.657077 duration_in_ms=1.03
2017-12-03 11:38:12,657 [salt.state       ][INFO    ][24635] Running state [/srv/glusterfs/keystone-keys] at time 11:38:12.657268
2017-12-03 11:38:12,657 [salt.state       ][INFO    ][24635] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-12-03 11:38:12,658 [salt.state       ][INFO    ][24635] {'/srv/glusterfs/keystone-keys': 'New Dir'}
2017-12-03 11:38:12,658 [salt.state       ][INFO    ][24635] Completed state [/srv/glusterfs/keystone-keys] at time 11:38:12.658089 duration_in_ms=0.821
2017-12-03 11:38:12,658 [salt.state       ][INFO    ][24635] Running state [/srv/glusterfs/nova_instances] at time 11:38:12.658264
2017-12-03 11:38:12,658 [salt.state       ][INFO    ][24635] Executing state file.directory for /srv/glusterfs/nova_instances
2017-12-03 11:38:12,659 [salt.state       ][INFO    ][24635] {'/srv/glusterfs/nova_instances': 'New Dir'}
2017-12-03 11:38:12,659 [salt.state       ][INFO    ][24635] Completed state [/srv/glusterfs/nova_instances] at time 11:38:12.659055 duration_in_ms=0.79
2017-12-03 11:38:12,659 [salt.state       ][INFO    ][24635] Running state [/srv/glusterfs/keystone-credential-keys] at time 11:38:12.659241
2017-12-03 11:38:12,659 [salt.state       ][INFO    ][24635] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-12-03 11:38:12,660 [salt.state       ][INFO    ][24635] {'/srv/glusterfs/keystone-credential-keys': 'New Dir'}
2017-12-03 11:38:12,660 [salt.state       ][INFO    ][24635] Completed state [/srv/glusterfs/keystone-credential-keys] at time 11:38:12.660045 duration_in_ms=0.804
2017-12-03 11:38:12,661 [salt.minion      ][INFO    ][24635] Returning information for job: 20171203113753750711
2017-12-03 11:38:15,899 [salt.minion      ][INFO    ][22250] User sudo_ubuntu Executing command test.ping with jid 20171203113815891403
2017-12-03 11:38:15,911 [salt.minion      ][INFO    ][27489] Starting a new job with PID 27489
2017-12-03 11:38:15,952 [salt.minion      ][INFO    ][27489] Returning information for job: 20171203113815891403
2017-12-03 11:38:40,253 [salt.minion      ][INFO    ][22250] User sudo_ubuntu Executing command state.sls with jid 20171203113840245993
2017-12-03 11:38:40,265 [salt.minion      ][INFO    ][28123] Starting a new job with PID 28123
2017-12-03 11:38:42,567 [salt.state       ][INFO    ][28123] Loading fresh modules for state activity
2017-12-03 11:38:42,598 [salt.fileclient  ][INFO    ][28123] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/setup.sls'
2017-12-03 11:38:42,646 [salt.fileclient  ][INFO    ][28123] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-12-03 11:38:42,735 [salt.fileclient  ][INFO    ][28123] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-12-03 11:38:42,762 [salt.fileclient  ][INFO    ][28123] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-12-03 11:38:43,065 [salt.state       ][INFO    ][28123] Running state [attr] at time 11:38:43.065314
2017-12-03 11:38:43,066 [salt.state       ][INFO    ][28123] Executing state pkg.installed for attr
2017-12-03 11:38:43,066 [salt.loaded.int.module.cmdmod][INFO    ][28123] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-03 11:38:43,345 [salt.state       ][INFO    ][28123] Package attr is already installed
2017-12-03 11:38:43,345 [salt.state       ][INFO    ][28123] Completed state [attr] at time 11:38:43.344918 duration_in_ms=279.604
2017-12-03 11:38:43,345 [salt.state       ][INFO    ][28123] Running state [glusterfs-server] at time 11:38:43.345134
2017-12-03 11:38:43,345 [salt.state       ][INFO    ][28123] Executing state pkg.installed for glusterfs-server
2017-12-03 11:38:43,349 [salt.state       ][INFO    ][28123] Package glusterfs-server is already installed
2017-12-03 11:38:43,349 [salt.state       ][INFO    ][28123] Completed state [glusterfs-server] at time 11:38:43.348991 duration_in_ms=3.856
2017-12-03 11:38:43,349 [salt.state       ][INFO    ][28123] Running state [bc] at time 11:38:43.349162
2017-12-03 11:38:43,349 [salt.state       ][INFO    ][28123] Executing state pkg.installed for bc
2017-12-03 11:38:43,353 [salt.state       ][INFO    ][28123] Package bc is already installed
2017-12-03 11:38:43,353 [salt.state       ][INFO    ][28123] Completed state [bc] at time 11:38:43.352905 duration_in_ms=3.743
2017-12-03 11:38:43,354 [salt.state       ][INFO    ][28123] Running state [glusterfs-server] at time 11:38:43.353828
2017-12-03 11:38:43,354 [salt.state       ][INFO    ][28123] Executing state service.running for glusterfs-server
2017-12-03 11:38:43,354 [salt.loaded.int.module.cmdmod][INFO    ][28123] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-12-03 11:38:43,364 [salt.loaded.int.module.cmdmod][INFO    ][28123] Executing command ['systemctl', '--system', 'daemon-reload'] in directory '/root'
2017-12-03 11:38:43,415 [salt.loaded.int.module.cmdmod][INFO    ][28123] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-12-03 11:38:43,428 [salt.loaded.int.module.cmdmod][INFO    ][28123] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-12-03 11:38:43,434 [salt.loaded.int.module.cmdmod][INFO    ][28123] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-12-03 11:38:43,442 [salt.state       ][INFO    ][28123] The service glusterfs-server is already running
2017-12-03 11:38:43,442 [salt.state       ][INFO    ][28123] Completed state [glusterfs-server] at time 11:38:43.441753 duration_in_ms=87.925
2017-12-03 11:38:43,443 [salt.state       ][INFO    ][28123] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 11:38:43.443132
2017-12-03 11:38:43,443 [salt.state       ][INFO    ][28123] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-12-03 11:38:43,445 [salt.state       ][INFO    ][28123] File /etc/systemd/system/glusterfs-server.service.d/override.conf is in the correct state
2017-12-03 11:38:43,445 [salt.state       ][INFO    ][28123] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 11:38:43.445420 duration_in_ms=2.288
2017-12-03 11:38:43,446 [salt.state       ][INFO    ][28123] Running state [/srv/glusterfs/glance] at time 11:38:43.445602
2017-12-03 11:38:43,446 [salt.state       ][INFO    ][28123] Executing state file.directory for /srv/glusterfs/glance
2017-12-03 11:38:43,446 [salt.state       ][INFO    ][28123] Directory /srv/glusterfs/glance is in the correct state
2017-12-03 11:38:43,446 [salt.state       ][INFO    ][28123] Completed state [/srv/glusterfs/glance] at time 11:38:43.446370 duration_in_ms=0.769
2017-12-03 11:38:43,447 [salt.state       ][INFO    ][28123] Running state [/srv/glusterfs/keystone-keys] at time 11:38:43.446560
2017-12-03 11:38:43,447 [salt.state       ][INFO    ][28123] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-12-03 11:38:43,447 [salt.state       ][INFO    ][28123] Directory /srv/glusterfs/keystone-keys is in the correct state
2017-12-03 11:38:43,447 [salt.state       ][INFO    ][28123] Completed state [/srv/glusterfs/keystone-keys] at time 11:38:43.447284 duration_in_ms=0.724
2017-12-03 11:38:43,448 [salt.state       ][INFO    ][28123] Running state [/srv/glusterfs/nova_instances] at time 11:38:43.447473
2017-12-03 11:38:43,448 [salt.state       ][INFO    ][28123] Executing state file.directory for /srv/glusterfs/nova_instances
2017-12-03 11:38:43,448 [salt.state       ][INFO    ][28123] Directory /srv/glusterfs/nova_instances is in the correct state
2017-12-03 11:38:43,448 [salt.state       ][INFO    ][28123] Completed state [/srv/glusterfs/nova_instances] at time 11:38:43.448180 duration_in_ms=0.706
2017-12-03 11:38:43,448 [salt.state       ][INFO    ][28123] Running state [/srv/glusterfs/keystone-credential-keys] at time 11:38:43.448363
2017-12-03 11:38:43,449 [salt.state       ][INFO    ][28123] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-12-03 11:38:43,449 [salt.state       ][INFO    ][28123] Directory /srv/glusterfs/keystone-credential-keys is in the correct state
2017-12-03 11:38:43,449 [salt.state       ][INFO    ][28123] Completed state [/srv/glusterfs/keystone-credential-keys] at time 11:38:43.449145 duration_in_ms=0.769
2017-12-03 11:38:43,544 [salt.loaded.int.module.cmdmod][INFO    ][28123] Executing command ['git', '--version'] in directory '/root'
2017-12-03 11:38:43,594 [salt.state       ][INFO    ][28123] Running state [sleep 5] at time 11:38:43.593902
2017-12-03 11:38:43,594 [salt.state       ][INFO    ][28123] Executing state cmd.wait for sleep 5
2017-12-03 11:38:43,594 [salt.state       ][INFO    ][28123] No changes made for sleep 5
2017-12-03 11:38:43,595 [salt.state       ][INFO    ][28123] Completed state [sleep 5] at time 11:38:43.594634 duration_in_ms=0.733
2017-12-03 11:38:43,595 [salt.state       ][INFO    ][28123] Running state [192.168.10.143] at time 11:38:43.595228
2017-12-03 11:38:43,595 [salt.state       ][INFO    ][28123] Executing state glusterfs.peered for 192.168.10.143
2017-12-03 11:38:43,596 [salt.loaded.int.module.cmdmod][INFO    ][28123] Executing command 'gluster --version' in directory '/root'
2017-12-03 11:38:43,604 [salt.loaded.int.module.cmdmod][INFO    ][28123] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-03 11:38:43,660 [salt.state       ][INFO    ][28123] Host 192.168.10.143 already peered
2017-12-03 11:38:43,661 [salt.state       ][INFO    ][28123] Completed state [192.168.10.143] at time 11:38:43.660529 duration_in_ms=65.3
2017-12-03 11:38:43,663 [salt.state       ][INFO    ][28123] Running state [192.168.10.142] at time 11:38:43.663458
2017-12-03 11:38:43,664 [salt.state       ][INFO    ][28123] Executing state glusterfs.peered for 192.168.10.142
2017-12-03 11:38:43,664 [salt.loaded.int.module.cmdmod][INFO    ][28123] Executing command 'gluster --version' in directory '/root'
2017-12-03 11:38:43,673 [salt.loaded.int.module.cmdmod][INFO    ][28123] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-03 11:38:43,728 [salt.state       ][INFO    ][28123] Host 192.168.10.142 already peered
2017-12-03 11:38:43,729 [salt.state       ][INFO    ][28123] Completed state [192.168.10.142] at time 11:38:43.728469 duration_in_ms=65.011
2017-12-03 11:38:43,731 [salt.state       ][INFO    ][28123] Running state [192.168.10.141] at time 11:38:43.731342
2017-12-03 11:38:43,732 [salt.state       ][INFO    ][28123] Executing state glusterfs.peered for 192.168.10.141
2017-12-03 11:38:43,732 [salt.loaded.int.module.cmdmod][INFO    ][28123] Executing command 'gluster --version' in directory '/root'
2017-12-03 11:38:43,740 [salt.loaded.int.module.cmdmod][INFO    ][28123] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-03 11:38:43,795 [salt.loaded.int.module.cmdmod][INFO    ][28123] Executing command 'gluster --version' in directory '/root'
2017-12-03 11:38:43,804 [salt.loaded.int.module.cmdmod][INFO    ][28123] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-03 11:38:43,859 [salt.loaded.int.module.cmdmod][INFO    ][28123] Executing command 'gluster --version' in directory '/root'
2017-12-03 11:38:43,867 [salt.loaded.int.module.cmdmod][INFO    ][28123] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-03 11:38:43,922 [salt.loaded.int.module.cmdmod][INFO    ][28123] Executing command 'gluster --version' in directory '/root'
2017-12-03 11:38:43,931 [salt.loaded.int.module.cmdmod][INFO    ][28123] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-03 11:38:43,987 [salt.state       ][INFO    ][28123] Peering with localhost is not needed
2017-12-03 11:38:43,987 [salt.state       ][INFO    ][28123] Completed state [192.168.10.141] at time 11:38:43.986737 duration_in_ms=255.395
2017-12-03 11:38:43,988 [salt.state       ][INFO    ][28123] Running state [glance] at time 11:38:43.987842
2017-12-03 11:38:43,988 [salt.state       ][INFO    ][28123] Executing state glusterfs.created for glance
2017-12-03 11:38:43,989 [salt.loaded.int.module.cmdmod][INFO    ][28123] Executing command 'gluster --version' in directory '/root'
2017-12-03 11:38:43,997 [salt.loaded.int.module.cmdmod][INFO    ][28123] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-03 11:38:44,053 [salt.loaded.int.module.cmdmod][INFO    ][28123] Executing command 'gluster --version' in directory '/root'
2017-12-03 11:38:44,061 [salt.loaded.int.module.cmdmod][INFO    ][28123] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-03 11:38:44,120 [salt.state       ][INFO    ][28123] Volume glance already exists and is started.
2017-12-03 11:38:44,120 [salt.state       ][INFO    ][28123] Completed state [glance] at time 11:38:44.120214 duration_in_ms=132.372
2017-12-03 11:38:44,124 [salt.state       ][INFO    ][28123] Running state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 11:38:44.124367
2017-12-03 11:38:44,125 [salt.state       ][INFO    ][28123] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'
2017-12-03 11:38:44,125 [salt.loaded.int.module.cmdmod][INFO    ][28123] Executing command 'gluster volume info 'glance' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-12-03 11:38:44,180 [salt.state       ][INFO    ][28123] unless execution succeeded
2017-12-03 11:38:44,180 [salt.state       ][INFO    ][28123] Completed state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 11:38:44.180248 duration_in_ms=55.88
2017-12-03 11:38:44,181 [salt.state       ][INFO    ][28123] Running state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 11:38:44.180831
2017-12-03 11:38:44,181 [salt.state       ][INFO    ][28123] Executing state cmd.run for gluster volume set 'glance' 'network.remote-dio' 'True'
2017-12-03 11:38:44,182 [salt.loaded.int.module.cmdmod][INFO    ][28123] Executing command 'gluster volume info 'glance' | grep 'network.remote-dio: True'' in directory '/root'
2017-12-03 11:38:44,236 [salt.state       ][INFO    ][28123] unless execution succeeded
2017-12-03 11:38:44,236 [salt.state       ][INFO    ][28123] Completed state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 11:38:44.236114 duration_in_ms=55.282
2017-12-03 11:38:44,237 [salt.state       ][INFO    ][28123] Running state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 11:38:44.236675
2017-12-03 11:38:44,237 [salt.state       ][INFO    ][28123] Executing state cmd.run for gluster volume set 'glance' 'nfs.disable' 'True'
2017-12-03 11:38:44,237 [salt.loaded.int.module.cmdmod][INFO    ][28123] Executing command 'gluster volume info 'glance' | grep 'nfs.disable: True'' in directory '/root'
2017-12-03 11:38:44,291 [salt.state       ][INFO    ][28123] unless execution succeeded
2017-12-03 11:38:44,291 [salt.state       ][INFO    ][28123] Completed state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 11:38:44.291111 duration_in_ms=54.436
2017-12-03 11:38:44,292 [salt.state       ][INFO    ][28123] Running state [gluster volume set 'glance' 'cluster.favorite-child-policy' 'mtime'] at time 11:38:44.291692
2017-12-03 11:38:44,292 [salt.state       ][INFO    ][28123] Executing state cmd.run for gluster volume set 'glance' 'cluster.favorite-child-policy' 'mtime'
2017-12-03 11:38:44,292 [salt.loaded.int.module.cmdmod][INFO    ][28123] Executing command 'gluster volume info 'glance' | grep 'cluster.favorite-child-policy: mtime'' in directory '/root'
2017-12-03 11:38:44,345 [salt.state       ][INFO    ][28123] unless execution succeeded
2017-12-03 11:38:44,345 [salt.state       ][INFO    ][28123] Completed state [gluster volume set 'glance' 'cluster.favorite-child-policy' 'mtime'] at time 11:38:44.345058 duration_in_ms=53.366
2017-12-03 11:38:44,346 [salt.state       ][INFO    ][28123] Running state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 11:38:44.345599
2017-12-03 11:38:44,346 [salt.state       ][INFO    ][28123] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'
2017-12-03 11:38:44,346 [salt.loaded.int.module.cmdmod][INFO    ][28123] Executing command 'gluster volume info 'glance' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-12-03 11:38:44,399 [salt.state       ][INFO    ][28123] unless execution succeeded
2017-12-03 11:38:44,399 [salt.state       ][INFO    ][28123] Completed state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 11:38:44.398962 duration_in_ms=53.348
2017-12-03 11:38:44,400 [salt.state       ][INFO    ][28123] Running state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 11:38:44.399526
2017-12-03 11:38:44,400 [salt.state       ][INFO    ][28123] Executing state cmd.run for gluster volume set 'glance' 'cluster.readdir-optimize' 'True'
2017-12-03 11:38:44,400 [salt.loaded.int.module.cmdmod][INFO    ][28123] Executing command 'gluster volume info 'glance' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-12-03 11:38:44,453 [salt.state       ][INFO    ][28123] unless execution succeeded
2017-12-03 11:38:44,454 [salt.state       ][INFO    ][28123] Completed state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 11:38:44.453448 duration_in_ms=53.921
2017-12-03 11:38:44,455 [salt.state       ][INFO    ][28123] Running state [glance] at time 11:38:44.454930
2017-12-03 11:38:44,455 [salt.state       ][INFO    ][28123] Executing state glusterfs.started for glance
2017-12-03 11:38:44,456 [salt.loaded.int.module.cmdmod][INFO    ][28123] Executing command 'gluster --version' in directory '/root'
2017-12-03 11:38:44,462 [salt.loaded.int.module.cmdmod][INFO    ][28123] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-03 11:38:44,516 [salt.loaded.int.module.cmdmod][INFO    ][28123] Executing command 'gluster --version' in directory '/root'
2017-12-03 11:38:44,525 [salt.loaded.int.module.cmdmod][INFO    ][28123] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-03 11:38:44,584 [salt.state       ][INFO    ][28123] Volume glance is already started
2017-12-03 11:38:44,585 [salt.state       ][INFO    ][28123] Completed state [glance] at time 11:38:44.584467 duration_in_ms=129.537
2017-12-03 11:38:44,586 [salt.state       ][INFO    ][28123] Running state [keystone-keys] at time 11:38:44.585673
2017-12-03 11:38:44,586 [salt.state       ][INFO    ][28123] Executing state glusterfs.created for keystone-keys
2017-12-03 11:38:44,586 [salt.loaded.int.module.cmdmod][INFO    ][28123] Executing command 'gluster --version' in directory '/root'
2017-12-03 11:38:44,595 [salt.loaded.int.module.cmdmod][INFO    ][28123] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-03 11:38:44,649 [salt.loaded.int.module.cmdmod][INFO    ][28123] Executing command 'gluster --version' in directory '/root'
2017-12-03 11:38:44,657 [salt.loaded.int.module.cmdmod][INFO    ][28123] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-03 11:38:44,714 [salt.state       ][INFO    ][28123] Volume keystone-keys already exists and is started.
2017-12-03 11:38:44,714 [salt.state       ][INFO    ][28123] Completed state [keystone-keys] at time 11:38:44.714268 duration_in_ms=128.595
2017-12-03 11:38:44,722 [salt.state       ][INFO    ][28123] Running state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 11:38:44.721816
2017-12-03 11:38:44,723 [salt.state       ][INFO    ][28123] Executing state cmd.run for gluster volume set 'keystone-keys' 'network.remote-dio' 'True'
2017-12-03 11:38:44,723 [salt.loaded.int.module.cmdmod][INFO    ][28123] Executing command 'gluster volume info 'keystone-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-12-03 11:38:44,781 [salt.state       ][INFO    ][28123] unless execution succeeded
2017-12-03 11:38:44,781 [salt.state       ][INFO    ][28123] Completed state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 11:38:44.780759 duration_in_ms=58.949
2017-12-03 11:38:44,781 [salt.state       ][INFO    ][28123] Running state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 11:38:44.781330
2017-12-03 11:38:44,782 [salt.state       ][INFO    ][28123] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-12-03 11:38:44,782 [salt.loaded.int.module.cmdmod][INFO    ][28123] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-12-03 11:38:44,837 [salt.state       ][INFO    ][28123] unless execution succeeded
2017-12-03 11:38:44,838 [salt.state       ][INFO    ][28123] Completed state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 11:38:44.837547 duration_in_ms=56.217
2017-12-03 11:38:44,838 [salt.state       ][INFO    ][28123] Running state [gluster volume set 'keystone-keys' 'cluster.favorite-child-policy' 'mtime'] at time 11:38:44.838177
2017-12-03 11:38:44,838 [salt.state       ][INFO    ][28123] Executing state cmd.run for gluster volume set 'keystone-keys' 'cluster.favorite-child-policy' 'mtime'
2017-12-03 11:38:44,839 [salt.loaded.int.module.cmdmod][INFO    ][28123] Executing command 'gluster volume info 'keystone-keys' | grep 'cluster.favorite-child-policy: mtime'' in directory '/root'
2017-12-03 11:38:44,895 [salt.state       ][INFO    ][28123] unless execution succeeded
2017-12-03 11:38:44,895 [salt.state       ][INFO    ][28123] Completed state [gluster volume set 'keystone-keys' 'cluster.favorite-child-policy' 'mtime'] at time 11:38:44.895270 duration_in_ms=57.093
2017-12-03 11:38:44,896 [salt.state       ][INFO    ][28123] Running state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 11:38:44.895815
2017-12-03 11:38:44,896 [salt.state       ][INFO    ][28123] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'
2017-12-03 11:38:44,897 [salt.loaded.int.module.cmdmod][INFO    ][28123] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-12-03 11:38:44,952 [salt.state       ][INFO    ][28123] unless execution succeeded
2017-12-03 11:38:44,952 [salt.state       ][INFO    ][28123] Completed state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 11:38:44.951918 duration_in_ms=56.102
2017-12-03 11:38:44,953 [salt.state       ][INFO    ][28123] Running state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 11:38:44.952492
2017-12-03 11:38:44,953 [salt.state       ][INFO    ][28123] Executing state cmd.run for gluster volume set 'keystone-keys' 'nfs.disable' 'True'
2017-12-03 11:38:44,953 [salt.loaded.int.module.cmdmod][INFO    ][28123] Executing command 'gluster volume info 'keystone-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-12-03 11:38:45,010 [salt.state       ][INFO    ][28123] unless execution succeeded
2017-12-03 11:38:45,010 [salt.state       ][INFO    ][28123] Completed state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 11:38:45.009796 duration_in_ms=57.303
2017-12-03 11:38:45,010 [salt.state       ][INFO    ][28123] Running state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 11:38:45.010447
2017-12-03 11:38:45,011 [salt.state       ][INFO    ][28123] Executing state cmd.run for gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'
2017-12-03 11:38:45,011 [salt.loaded.int.module.cmdmod][INFO    ][28123] Executing command 'gluster volume info 'keystone-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-12-03 11:38:45,067 [salt.state       ][INFO    ][28123] unless execution succeeded
2017-12-03 11:38:45,067 [salt.state       ][INFO    ][28123] Completed state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 11:38:45.066879 duration_in_ms=56.431
2017-12-03 11:38:45,068 [salt.state       ][INFO    ][28123] Running state [keystone-keys] at time 11:38:45.068372
2017-12-03 11:38:45,069 [salt.state       ][INFO    ][28123] Executing state glusterfs.started for keystone-keys
2017-12-03 11:38:45,070 [salt.loaded.int.module.cmdmod][INFO    ][28123] Executing command 'gluster --version' in directory '/root'
2017-12-03 11:38:45,078 [salt.loaded.int.module.cmdmod][INFO    ][28123] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-03 11:38:45,134 [salt.loaded.int.module.cmdmod][INFO    ][28123] Executing command 'gluster --version' in directory '/root'
2017-12-03 11:38:45,143 [salt.loaded.int.module.cmdmod][INFO    ][28123] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-03 11:38:45,206 [salt.state       ][INFO    ][28123] Volume keystone-keys is already started
2017-12-03 11:38:45,207 [salt.state       ][INFO    ][28123] Completed state [keystone-keys] at time 11:38:45.206694 duration_in_ms=138.321
2017-12-03 11:38:45,208 [salt.state       ][INFO    ][28123] Running state [nova_instances] at time 11:38:45.207774
2017-12-03 11:38:45,208 [salt.state       ][INFO    ][28123] Executing state glusterfs.created for nova_instances
2017-12-03 11:38:45,209 [salt.loaded.int.module.cmdmod][INFO    ][28123] Executing command 'gluster --version' in directory '/root'
2017-12-03 11:38:45,217 [salt.loaded.int.module.cmdmod][INFO    ][28123] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-03 11:38:45,273 [salt.loaded.int.module.cmdmod][INFO    ][28123] Executing command 'gluster --version' in directory '/root'
2017-12-03 11:38:45,283 [salt.loaded.int.module.cmdmod][INFO    ][28123] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-03 11:38:45,341 [salt.state       ][INFO    ][28123] Volume nova_instances already exists and is started.
2017-12-03 11:38:45,341 [salt.state       ][INFO    ][28123] Completed state [nova_instances] at time 11:38:45.341285 duration_in_ms=133.511
2017-12-03 11:38:45,346 [salt.state       ][INFO    ][28123] Running state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 11:38:45.345663
2017-12-03 11:38:45,346 [salt.state       ][INFO    ][28123] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'
2017-12-03 11:38:45,346 [salt.loaded.int.module.cmdmod][INFO    ][28123] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-12-03 11:38:45,403 [salt.state       ][INFO    ][28123] unless execution succeeded
2017-12-03 11:38:45,403 [salt.state       ][INFO    ][28123] Completed state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 11:38:45.402801 duration_in_ms=57.137
2017-12-03 11:38:45,404 [salt.state       ][INFO    ][28123] Running state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'True'] at time 11:38:45.403468
2017-12-03 11:38:45,404 [salt.state       ][INFO    ][28123] Executing state cmd.run for gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'True'
2017-12-03 11:38:45,404 [salt.loaded.int.module.cmdmod][INFO    ][28123] Executing command 'gluster volume info 'nova_instances' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-12-03 11:38:45,460 [salt.state       ][INFO    ][28123] unless execution succeeded
2017-12-03 11:38:45,460 [salt.state       ][INFO    ][28123] Completed state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'True'] at time 11:38:45.459953 duration_in_ms=56.486
2017-12-03 11:38:45,461 [salt.state       ][INFO    ][28123] Running state [gluster volume set 'nova_instances' 'network.remote-dio' 'True'] at time 11:38:45.460532
2017-12-03 11:38:45,461 [salt.state       ][INFO    ][28123] Executing state cmd.run for gluster volume set 'nova_instances' 'network.remote-dio' 'True'
2017-12-03 11:38:45,461 [salt.loaded.int.module.cmdmod][INFO    ][28123] Executing command 'gluster volume info 'nova_instances' | grep 'network.remote-dio: True'' in directory '/root'
2017-12-03 11:38:45,517 [salt.state       ][INFO    ][28123] unless execution succeeded
2017-12-03 11:38:45,517 [salt.state       ][INFO    ][28123] Completed state [gluster volume set 'nova_instances' 'network.remote-dio' 'True'] at time 11:38:45.517435 duration_in_ms=56.901
2017-12-03 11:38:45,518 [salt.state       ][INFO    ][28123] Running state [gluster volume set 'nova_instances' 'cluster.favorite-child-policy' 'mtime'] at time 11:38:45.517970
2017-12-03 11:38:45,518 [salt.state       ][INFO    ][28123] Executing state cmd.run for gluster volume set 'nova_instances' 'cluster.favorite-child-policy' 'mtime'
2017-12-03 11:38:45,519 [salt.loaded.int.module.cmdmod][INFO    ][28123] Executing command 'gluster volume info 'nova_instances' | grep 'cluster.favorite-child-policy: mtime'' in directory '/root'
2017-12-03 11:38:45,575 [salt.state       ][INFO    ][28123] unless execution succeeded
2017-12-03 11:38:45,575 [salt.state       ][INFO    ][28123] Completed state [gluster volume set 'nova_instances' 'cluster.favorite-child-policy' 'mtime'] at time 11:38:45.574943 duration_in_ms=56.972
2017-12-03 11:38:45,576 [salt.state       ][INFO    ][28123] Running state [gluster volume set 'nova_instances' 'nfs.disable' 'True'] at time 11:38:45.575638
2017-12-03 11:38:45,576 [salt.state       ][INFO    ][28123] Executing state cmd.run for gluster volume set 'nova_instances' 'nfs.disable' 'True'
2017-12-03 11:38:45,576 [salt.loaded.int.module.cmdmod][INFO    ][28123] Executing command 'gluster volume info 'nova_instances' | grep 'nfs.disable: True'' in directory '/root'
2017-12-03 11:38:45,633 [salt.state       ][INFO    ][28123] unless execution succeeded
2017-12-03 11:38:45,633 [salt.state       ][INFO    ][28123] Completed state [gluster volume set 'nova_instances' 'nfs.disable' 'True'] at time 11:38:45.633301 duration_in_ms=57.663
2017-12-03 11:38:45,634 [salt.state       ][INFO    ][28123] Running state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 11:38:45.633897
2017-12-03 11:38:45,634 [salt.state       ][INFO    ][28123] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'
2017-12-03 11:38:45,635 [salt.loaded.int.module.cmdmod][INFO    ][28123] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-12-03 11:38:45,690 [salt.state       ][INFO    ][28123] unless execution succeeded
2017-12-03 11:38:45,690 [salt.state       ][INFO    ][28123] Completed state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 11:38:45.690266 duration_in_ms=56.369
2017-12-03 11:38:45,692 [salt.state       ][INFO    ][28123] Running state [nova_instances] at time 11:38:45.691721
2017-12-03 11:38:45,692 [salt.state       ][INFO    ][28123] Executing state glusterfs.started for nova_instances
2017-12-03 11:38:45,692 [salt.loaded.int.module.cmdmod][INFO    ][28123] Executing command 'gluster --version' in directory '/root'
2017-12-03 11:38:45,701 [salt.loaded.int.module.cmdmod][INFO    ][28123] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-03 11:38:45,756 [salt.loaded.int.module.cmdmod][INFO    ][28123] Executing command 'gluster --version' in directory '/root'
2017-12-03 11:38:45,764 [salt.loaded.int.module.cmdmod][INFO    ][28123] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-03 11:38:45,821 [salt.state       ][INFO    ][28123] Volume nova_instances is already started
2017-12-03 11:38:45,821 [salt.state       ][INFO    ][28123] Completed state [nova_instances] at time 11:38:45.820824 duration_in_ms=129.103
2017-12-03 11:38:45,822 [salt.state       ][INFO    ][28123] Running state [keystone-credential-keys] at time 11:38:45.821978
2017-12-03 11:38:45,822 [salt.state       ][INFO    ][28123] Executing state glusterfs.created for keystone-credential-keys
2017-12-03 11:38:45,823 [salt.loaded.int.module.cmdmod][INFO    ][28123] Executing command 'gluster --version' in directory '/root'
2017-12-03 11:38:45,830 [salt.loaded.int.module.cmdmod][INFO    ][28123] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-03 11:38:45,886 [salt.loaded.int.module.cmdmod][INFO    ][28123] Executing command 'gluster --version' in directory '/root'
2017-12-03 11:38:45,896 [salt.loaded.int.module.cmdmod][INFO    ][28123] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-03 11:38:45,955 [salt.state       ][INFO    ][28123] Volume keystone-credential-keys already exists and is started.
2017-12-03 11:38:45,955 [salt.state       ][INFO    ][28123] Completed state [keystone-credential-keys] at time 11:38:45.954908 duration_in_ms=132.93
2017-12-03 11:38:45,960 [salt.state       ][INFO    ][28123] Running state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 11:38:45.959536
2017-12-03 11:38:45,960 [salt.state       ][INFO    ][28123] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'
2017-12-03 11:38:45,960 [salt.loaded.int.module.cmdmod][INFO    ][28123] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-12-03 11:38:46,017 [salt.state       ][INFO    ][28123] unless execution succeeded
2017-12-03 11:38:46,017 [salt.state       ][INFO    ][28123] Completed state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 11:38:46.017298 duration_in_ms=57.762
2017-12-03 11:38:46,018 [salt.state       ][INFO    ][28123] Running state [gluster volume set 'keystone-credential-keys' 'cluster.favorite-child-policy' 'mtime'] at time 11:38:46.017919
2017-12-03 11:38:46,018 [salt.state       ][INFO    ][28123] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'cluster.favorite-child-policy' 'mtime'
2017-12-03 11:38:46,019 [salt.loaded.int.module.cmdmod][INFO    ][28123] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'cluster.favorite-child-policy: mtime'' in directory '/root'
2017-12-03 11:38:46,075 [salt.state       ][INFO    ][28123] unless execution succeeded
2017-12-03 11:38:46,075 [salt.state       ][INFO    ][28123] Completed state [gluster volume set 'keystone-credential-keys' 'cluster.favorite-child-policy' 'mtime'] at time 11:38:46.075024 duration_in_ms=57.105
2017-12-03 11:38:46,076 [salt.state       ][INFO    ][28123] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 11:38:46.075622
2017-12-03 11:38:46,076 [salt.state       ][INFO    ][28123] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-12-03 11:38:46,076 [salt.loaded.int.module.cmdmod][INFO    ][28123] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-12-03 11:38:46,133 [salt.state       ][INFO    ][28123] unless execution succeeded
2017-12-03 11:38:46,134 [salt.state       ][INFO    ][28123] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 11:38:46.133505 duration_in_ms=57.882
2017-12-03 11:38:46,134 [salt.state       ][INFO    ][28123] Running state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 11:38:46.134064
2017-12-03 11:38:46,134 [salt.state       ][INFO    ][28123] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'
2017-12-03 11:38:46,135 [salt.loaded.int.module.cmdmod][INFO    ][28123] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-12-03 11:38:46,187 [salt.state       ][INFO    ][28123] unless execution succeeded
2017-12-03 11:38:46,187 [salt.state       ][INFO    ][28123] Completed state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 11:38:46.187363 duration_in_ms=53.298
2017-12-03 11:38:46,188 [salt.state       ][INFO    ][28123] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 11:38:46.187939
2017-12-03 11:38:46,188 [salt.state       ][INFO    ][28123] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'
2017-12-03 11:38:46,189 [salt.loaded.int.module.cmdmod][INFO    ][28123] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-12-03 11:38:46,245 [salt.state       ][INFO    ][28123] unless execution succeeded
2017-12-03 11:38:46,245 [salt.state       ][INFO    ][28123] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 11:38:46.245236 duration_in_ms=57.296
2017-12-03 11:38:46,246 [salt.state       ][INFO    ][28123] Running state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 11:38:46.245822
2017-12-03 11:38:46,246 [salt.state       ][INFO    ][28123] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'
2017-12-03 11:38:46,247 [salt.loaded.int.module.cmdmod][INFO    ][28123] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-12-03 11:38:46,303 [salt.state       ][INFO    ][28123] unless execution succeeded
2017-12-03 11:38:46,303 [salt.state       ][INFO    ][28123] Completed state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 11:38:46.303354 duration_in_ms=57.532
2017-12-03 11:38:46,305 [salt.state       ][INFO    ][28123] Running state [keystone-credential-keys] at time 11:38:46.304860
2017-12-03 11:38:46,305 [salt.state       ][INFO    ][28123] Executing state glusterfs.started for keystone-credential-keys
2017-12-03 11:38:46,306 [salt.loaded.int.module.cmdmod][INFO    ][28123] Executing command 'gluster --version' in directory '/root'
2017-12-03 11:38:46,314 [salt.loaded.int.module.cmdmod][INFO    ][28123] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-03 11:38:46,368 [salt.loaded.int.module.cmdmod][INFO    ][28123] Executing command 'gluster --version' in directory '/root'
2017-12-03 11:38:46,376 [salt.loaded.int.module.cmdmod][INFO    ][28123] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-03 11:38:46,434 [salt.state       ][INFO    ][28123] Volume keystone-credential-keys is already started
2017-12-03 11:38:46,434 [salt.state       ][INFO    ][28123] Completed state [keystone-credential-keys] at time 11:38:46.434036 duration_in_ms=129.176
2017-12-03 11:38:46,436 [salt.minion      ][INFO    ][28123] Returning information for job: 20171203113840245993
2017-12-03 11:38:47,473 [salt.minion      ][INFO    ][22250] User sudo_ubuntu Executing command test.ping with jid 20171203113847465122
2017-12-03 11:38:47,485 [salt.minion      ][INFO    ][28651] Starting a new job with PID 28651
2017-12-03 11:38:47,523 [salt.minion      ][INFO    ][28651] Returning information for job: 20171203113847465122
2017-12-03 11:38:48,179 [salt.minion      ][INFO    ][22250] User sudo_ubuntu Executing command cmd.run with jid 20171203113848170780
2017-12-03 11:38:48,189 [salt.minion      ][INFO    ][28656] Starting a new job with PID 28656
2017-12-03 11:38:48,193 [salt.loaded.int.module.cmdmod][INFO    ][28656] Executing command 'gluster peer status; gluster volume status' in directory '/root'
2017-12-03 11:38:48,310 [salt.minion      ][INFO    ][28656] Returning information for job: 20171203113848170780
2017-12-03 12:06:18,659 [salt.minion      ][INFO    ][22250] User sudo_ubuntu Executing command test.ping with jid 20171203120618652068
2017-12-03 12:06:18,674 [salt.minion      ][INFO    ][29105] Starting a new job with PID 29105
2017-12-03 12:06:18,712 [salt.minion      ][INFO    ][29105] Returning information for job: 20171203120618652068
2017-12-03 12:06:30,205 [salt.minion      ][INFO    ][22250] User sudo_ubuntu Executing command state.sls with jid 20171203120630197214
2017-12-03 12:06:30,215 [salt.minion      ][INFO    ][29114] Starting a new job with PID 29114
2017-12-03 12:06:30,801 [salt.state       ][INFO    ][29114] Loading fresh modules for state activity
2017-12-03 12:06:30,836 [salt.fileclient  ][INFO    ][29114] Fetching file from saltenv 'base', ** done ** 'keepalived/init.sls'
2017-12-03 12:06:30,854 [salt.fileclient  ][INFO    ][29114] Fetching file from saltenv 'base', ** done ** 'keepalived/cluster.sls'
2017-12-03 12:06:30,881 [salt.fileclient  ][INFO    ][29114] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-12-03 12:06:31,178 [salt.state       ][INFO    ][29114] Running state [lsof] at time 12:06:31.177779
2017-12-03 12:06:31,178 [salt.state       ][INFO    ][29114] Executing state pkg.installed for lsof
2017-12-03 12:06:31,178 [salt.loaded.int.module.cmdmod][INFO    ][29114] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-03 12:06:31,446 [salt.state       ][INFO    ][29114] Package lsof is already installed
2017-12-03 12:06:31,447 [salt.state       ][INFO    ][29114] Completed state [lsof] at time 12:06:31.446622 duration_in_ms=268.844
2017-12-03 12:06:31,447 [salt.state       ][INFO    ][29114] Running state [keepalived] at time 12:06:31.447000
2017-12-03 12:06:31,447 [salt.state       ][INFO    ][29114] Executing state pkg.installed for keepalived
2017-12-03 12:06:31,451 [salt.state       ][INFO    ][29114] Package keepalived is already installed
2017-12-03 12:06:31,451 [salt.state       ][INFO    ][29114] Completed state [keepalived] at time 12:06:31.451211 duration_in_ms=4.211
2017-12-03 12:06:31,453 [salt.state       ][INFO    ][29114] Running state [/etc/keepalived/keepalived.conf] at time 12:06:31.452618
2017-12-03 12:06:31,453 [salt.state       ][INFO    ][29114] Executing state file.managed for /etc/keepalived/keepalived.conf
2017-12-03 12:06:31,480 [salt.fileclient  ][INFO    ][29114] Fetching file from saltenv 'base', ** done ** 'keepalived/files/keepalived.conf'
2017-12-03 12:06:31,521 [salt.fileclient  ][INFO    ][29114] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-12-03 12:06:31,526 [salt.state       ][INFO    ][29114] File /etc/keepalived/keepalived.conf is in the correct state
2017-12-03 12:06:31,526 [salt.state       ][INFO    ][29114] Completed state [/etc/keepalived/keepalived.conf] at time 12:06:31.526179 duration_in_ms=73.56
2017-12-03 12:06:31,527 [salt.state       ][INFO    ][29114] Running state [keepalived] at time 12:06:31.526731
2017-12-03 12:06:31,527 [salt.state       ][INFO    ][29114] Executing state service.running for keepalived
2017-12-03 12:06:31,527 [salt.loaded.int.module.cmdmod][INFO    ][29114] Executing command ['systemctl', 'status', 'keepalived.service', '-n', '0'] in directory '/root'
2017-12-03 12:06:31,540 [salt.loaded.int.module.cmdmod][INFO    ][29114] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2017-12-03 12:06:31,545 [salt.loaded.int.module.cmdmod][INFO    ][29114] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-12-03 12:06:31,553 [salt.state       ][INFO    ][29114] The service keepalived is already running
2017-12-03 12:06:31,553 [salt.state       ][INFO    ][29114] Completed state [keepalived] at time 12:06:31.553069 duration_in_ms=26.337
2017-12-03 12:06:31,554 [salt.minion      ][INFO    ][29114] Returning information for job: 20171203120630197214
2017-12-03 12:06:54,992 [salt.minion      ][INFO    ][22250] User sudo_ubuntu Executing command pillar.get with jid 20171203120654985621
2017-12-03 12:06:55,006 [salt.minion      ][INFO    ][29144] Starting a new job with PID 29144
2017-12-03 12:06:55,010 [salt.minion      ][INFO    ][29144] Returning information for job: 20171203120654985621
2017-12-03 12:07:38,665 [salt.minion      ][INFO    ][22250] User sudo_ubuntu Executing command state.sls with jid 20171203120738656861
2017-12-03 12:07:38,677 [salt.minion      ][INFO    ][29164] Starting a new job with PID 29164
2017-12-03 12:07:41,026 [salt.state       ][INFO    ][29164] Loading fresh modules for state activity
2017-12-03 12:07:41,051 [salt.fileclient  ][INFO    ][29164] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-12-03 12:07:41,073 [salt.fileclient  ][INFO    ][29164] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-12-03 12:07:41,373 [salt.state       ][INFO    ][29164] Running state [attr] at time 12:07:41.373205
2017-12-03 12:07:41,374 [salt.state       ][INFO    ][29164] Executing state pkg.installed for attr
2017-12-03 12:07:41,374 [salt.loaded.int.module.cmdmod][INFO    ][29164] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-03 12:07:41,659 [salt.state       ][INFO    ][29164] Package attr is already installed
2017-12-03 12:07:41,660 [salt.state       ][INFO    ][29164] Completed state [attr] at time 12:07:41.659669 duration_in_ms=286.464
2017-12-03 12:07:41,660 [salt.state       ][INFO    ][29164] Running state [glusterfs-server] at time 12:07:41.659907
2017-12-03 12:07:41,660 [salt.state       ][INFO    ][29164] Executing state pkg.installed for glusterfs-server
2017-12-03 12:07:41,664 [salt.state       ][INFO    ][29164] Package glusterfs-server is already installed
2017-12-03 12:07:41,664 [salt.state       ][INFO    ][29164] Completed state [glusterfs-server] at time 12:07:41.663966 duration_in_ms=4.058
2017-12-03 12:07:41,664 [salt.state       ][INFO    ][29164] Running state [bc] at time 12:07:41.664162
2017-12-03 12:07:41,664 [salt.state       ][INFO    ][29164] Executing state pkg.installed for bc
2017-12-03 12:07:41,668 [salt.state       ][INFO    ][29164] Package bc is already installed
2017-12-03 12:07:41,668 [salt.state       ][INFO    ][29164] Completed state [bc] at time 12:07:41.668416 duration_in_ms=4.254
2017-12-03 12:07:41,669 [salt.state       ][INFO    ][29164] Running state [glusterfs-server] at time 12:07:41.669317
2017-12-03 12:07:41,670 [salt.state       ][INFO    ][29164] Executing state service.running for glusterfs-server
2017-12-03 12:07:41,670 [salt.loaded.int.module.cmdmod][INFO    ][29164] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-12-03 12:07:41,686 [salt.loaded.int.module.cmdmod][INFO    ][29164] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-12-03 12:07:41,694 [salt.loaded.int.module.cmdmod][INFO    ][29164] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-12-03 12:07:41,704 [salt.state       ][INFO    ][29164] The service glusterfs-server is already running
2017-12-03 12:07:41,704 [salt.state       ][INFO    ][29164] Completed state [glusterfs-server] at time 12:07:41.704342 duration_in_ms=35.025
2017-12-03 12:07:41,706 [salt.state       ][INFO    ][29164] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 12:07:41.705898
2017-12-03 12:07:41,706 [salt.state       ][INFO    ][29164] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-12-03 12:07:41,708 [salt.state       ][INFO    ][29164] File /etc/systemd/system/glusterfs-server.service.d/override.conf is in the correct state
2017-12-03 12:07:41,708 [salt.state       ][INFO    ][29164] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 12:07:41.708320 duration_in_ms=2.421
2017-12-03 12:07:41,709 [salt.state       ][INFO    ][29164] Running state [/srv/glusterfs/glance] at time 12:07:41.708528
2017-12-03 12:07:41,709 [salt.state       ][INFO    ][29164] Executing state file.directory for /srv/glusterfs/glance
2017-12-03 12:07:41,709 [salt.state       ][INFO    ][29164] Directory /srv/glusterfs/glance is in the correct state
2017-12-03 12:07:41,709 [salt.state       ][INFO    ][29164] Completed state [/srv/glusterfs/glance] at time 12:07:41.709401 duration_in_ms=0.873
2017-12-03 12:07:41,710 [salt.state       ][INFO    ][29164] Running state [/srv/glusterfs/keystone-keys] at time 12:07:41.709593
2017-12-03 12:07:41,710 [salt.state       ][INFO    ][29164] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-12-03 12:07:41,710 [salt.state       ][INFO    ][29164] Directory /srv/glusterfs/keystone-keys is in the correct state
2017-12-03 12:07:41,710 [salt.state       ][INFO    ][29164] Completed state [/srv/glusterfs/keystone-keys] at time 12:07:41.710374 duration_in_ms=0.781
2017-12-03 12:07:41,711 [salt.state       ][INFO    ][29164] Running state [/srv/glusterfs/nova_instances] at time 12:07:41.710584
2017-12-03 12:07:41,711 [salt.state       ][INFO    ][29164] Executing state file.directory for /srv/glusterfs/nova_instances
2017-12-03 12:07:41,711 [salt.state       ][INFO    ][29164] Directory /srv/glusterfs/nova_instances is in the correct state
2017-12-03 12:07:41,711 [salt.state       ][INFO    ][29164] Completed state [/srv/glusterfs/nova_instances] at time 12:07:41.711297 duration_in_ms=0.712
2017-12-03 12:07:41,712 [salt.state       ][INFO    ][29164] Running state [/srv/glusterfs/keystone-credential-keys] at time 12:07:41.711487
2017-12-03 12:07:41,712 [salt.state       ][INFO    ][29164] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-12-03 12:07:41,712 [salt.state       ][INFO    ][29164] Directory /srv/glusterfs/keystone-credential-keys is in the correct state
2017-12-03 12:07:41,712 [salt.state       ][INFO    ][29164] Completed state [/srv/glusterfs/keystone-credential-keys] at time 12:07:41.712250 duration_in_ms=0.75
2017-12-03 12:07:41,713 [salt.minion      ][INFO    ][29164] Returning information for job: 20171203120738656861
2017-12-03 12:07:43,034 [salt.minion      ][INFO    ][22250] User sudo_ubuntu Executing command test.ping with jid 20171203120743024706
2017-12-03 12:07:43,045 [salt.minion      ][INFO    ][29187] Starting a new job with PID 29187
2017-12-03 12:07:43,080 [salt.minion      ][INFO    ][29187] Returning information for job: 20171203120743024706
2017-12-03 12:07:52,365 [salt.minion      ][INFO    ][22250] User sudo_ubuntu Executing command state.sls with jid 20171203120752357907
2017-12-03 12:07:52,376 [salt.minion      ][INFO    ][29194] Starting a new job with PID 29194
2017-12-03 12:07:52,965 [salt.state       ][INFO    ][29194] Loading fresh modules for state activity
2017-12-03 12:07:52,992 [salt.fileclient  ][INFO    ][29194] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/setup.sls'
2017-12-03 12:07:53,039 [salt.fileclient  ][INFO    ][29194] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-12-03 12:07:53,121 [salt.fileclient  ][INFO    ][29194] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-12-03 12:07:53,147 [salt.fileclient  ][INFO    ][29194] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-12-03 12:07:53,461 [salt.state       ][INFO    ][29194] Running state [attr] at time 12:07:53.461444
2017-12-03 12:07:53,462 [salt.state       ][INFO    ][29194] Executing state pkg.installed for attr
2017-12-03 12:07:53,462 [salt.loaded.int.module.cmdmod][INFO    ][29194] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-12-03 12:07:53,739 [salt.state       ][INFO    ][29194] Package attr is already installed
2017-12-03 12:07:53,740 [salt.state       ][INFO    ][29194] Completed state [attr] at time 12:07:53.739607 duration_in_ms=278.163
2017-12-03 12:07:53,740 [salt.state       ][INFO    ][29194] Running state [glusterfs-server] at time 12:07:53.739888
2017-12-03 12:07:53,740 [salt.state       ][INFO    ][29194] Executing state pkg.installed for glusterfs-server
2017-12-03 12:07:53,744 [salt.state       ][INFO    ][29194] Package glusterfs-server is already installed
2017-12-03 12:07:53,744 [salt.state       ][INFO    ][29194] Completed state [glusterfs-server] at time 12:07:53.744076 duration_in_ms=4.188
2017-12-03 12:07:53,744 [salt.state       ][INFO    ][29194] Running state [bc] at time 12:07:53.744278
2017-12-03 12:07:53,744 [salt.state       ][INFO    ][29194] Executing state pkg.installed for bc
2017-12-03 12:07:53,748 [salt.state       ][INFO    ][29194] Package bc is already installed
2017-12-03 12:07:53,748 [salt.state       ][INFO    ][29194] Completed state [bc] at time 12:07:53.748299 duration_in_ms=4.021
2017-12-03 12:07:53,749 [salt.state       ][INFO    ][29194] Running state [glusterfs-server] at time 12:07:53.749401
2017-12-03 12:07:53,750 [salt.state       ][INFO    ][29194] Executing state service.running for glusterfs-server
2017-12-03 12:07:53,750 [salt.loaded.int.module.cmdmod][INFO    ][29194] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-12-03 12:07:53,765 [salt.loaded.int.module.cmdmod][INFO    ][29194] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-12-03 12:07:53,772 [salt.loaded.int.module.cmdmod][INFO    ][29194] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-12-03 12:07:53,782 [salt.state       ][INFO    ][29194] The service glusterfs-server is already running
2017-12-03 12:07:53,782 [salt.state       ][INFO    ][29194] Completed state [glusterfs-server] at time 12:07:53.781876 duration_in_ms=32.474
2017-12-03 12:07:53,783 [salt.state       ][INFO    ][29194] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 12:07:53.783436
2017-12-03 12:07:53,784 [salt.state       ][INFO    ][29194] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-12-03 12:07:53,786 [salt.state       ][INFO    ][29194] File /etc/systemd/system/glusterfs-server.service.d/override.conf is in the correct state
2017-12-03 12:07:53,786 [salt.state       ][INFO    ][29194] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 12:07:53.785962 duration_in_ms=2.526
2017-12-03 12:07:53,786 [salt.state       ][INFO    ][29194] Running state [/srv/glusterfs/glance] at time 12:07:53.786171
2017-12-03 12:07:53,786 [salt.state       ][INFO    ][29194] Executing state file.directory for /srv/glusterfs/glance
2017-12-03 12:07:53,787 [salt.state       ][INFO    ][29194] Directory /srv/glusterfs/glance is in the correct state
2017-12-03 12:07:53,787 [salt.state       ][INFO    ][29194] Completed state [/srv/glusterfs/glance] at time 12:07:53.787000 duration_in_ms=0.829
2017-12-03 12:07:53,787 [salt.state       ][INFO    ][29194] Running state [/srv/glusterfs/keystone-keys] at time 12:07:53.787194
2017-12-03 12:07:53,787 [salt.state       ][INFO    ][29194] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-12-03 12:07:53,788 [salt.state       ][INFO    ][29194] Directory /srv/glusterfs/keystone-keys is in the correct state
2017-12-03 12:07:53,788 [salt.state       ][INFO    ][29194] Completed state [/srv/glusterfs/keystone-keys] at time 12:07:53.787984 duration_in_ms=0.777
2017-12-03 12:07:53,788 [salt.state       ][INFO    ][29194] Running state [/srv/glusterfs/nova_instances] at time 12:07:53.788171
2017-12-03 12:07:53,788 [salt.state       ][INFO    ][29194] Executing state file.directory for /srv/glusterfs/nova_instances
2017-12-03 12:07:53,789 [salt.state       ][INFO    ][29194] Directory /srv/glusterfs/nova_instances is in the correct state
2017-12-03 12:07:53,789 [salt.state       ][INFO    ][29194] Completed state [/srv/glusterfs/nova_instances] at time 12:07:53.788906 duration_in_ms=0.734
2017-12-03 12:07:53,789 [salt.state       ][INFO    ][29194] Running state [/srv/glusterfs/keystone-credential-keys] at time 12:07:53.789098
2017-12-03 12:07:53,789 [salt.state       ][INFO    ][29194] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-12-03 12:07:53,790 [salt.state       ][INFO    ][29194] Directory /srv/glusterfs/keystone-credential-keys is in the correct state
2017-12-03 12:07:53,790 [salt.state       ][INFO    ][29194] Completed state [/srv/glusterfs/keystone-credential-keys] at time 12:07:53.789923 duration_in_ms=0.826
2017-12-03 12:07:53,875 [salt.loaded.int.module.cmdmod][INFO    ][29194] Executing command ['git', '--version'] in directory '/root'
2017-12-03 12:07:53,917 [salt.state       ][INFO    ][29194] Running state [sleep 5] at time 12:07:53.917350
2017-12-03 12:07:53,918 [salt.state       ][INFO    ][29194] Executing state cmd.wait for sleep 5
2017-12-03 12:07:53,918 [salt.state       ][INFO    ][29194] No changes made for sleep 5
2017-12-03 12:07:53,918 [salt.state       ][INFO    ][29194] Completed state [sleep 5] at time 12:07:53.918056 duration_in_ms=0.707
2017-12-03 12:07:53,919 [salt.state       ][INFO    ][29194] Running state [192.168.10.143] at time 12:07:53.918648
2017-12-03 12:07:53,919 [salt.state       ][INFO    ][29194] Executing state glusterfs.peered for 192.168.10.143
2017-12-03 12:07:53,919 [salt.loaded.int.module.cmdmod][INFO    ][29194] Executing command 'gluster --version' in directory '/root'
2017-12-03 12:07:53,928 [salt.loaded.int.module.cmdmod][INFO    ][29194] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-03 12:07:53,985 [salt.state       ][INFO    ][29194] Host 192.168.10.143 already peered
2017-12-03 12:07:53,985 [salt.state       ][INFO    ][29194] Completed state [192.168.10.143] at time 12:07:53.984982 duration_in_ms=66.334
2017-12-03 12:07:53,988 [salt.state       ][INFO    ][29194] Running state [192.168.10.142] at time 12:07:53.987973
2017-12-03 12:07:53,988 [salt.state       ][INFO    ][29194] Executing state glusterfs.peered for 192.168.10.142
2017-12-03 12:07:53,989 [salt.loaded.int.module.cmdmod][INFO    ][29194] Executing command 'gluster --version' in directory '/root'
2017-12-03 12:07:53,998 [salt.loaded.int.module.cmdmod][INFO    ][29194] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-03 12:07:54,052 [salt.state       ][INFO    ][29194] Host 192.168.10.142 already peered
2017-12-03 12:07:54,052 [salt.state       ][INFO    ][29194] Completed state [192.168.10.142] at time 12:07:54.052221 duration_in_ms=64.248
2017-12-03 12:07:54,055 [salt.state       ][INFO    ][29194] Running state [192.168.10.141] at time 12:07:54.055215
2017-12-03 12:07:54,055 [salt.state       ][INFO    ][29194] Executing state glusterfs.peered for 192.168.10.141
2017-12-03 12:07:54,056 [salt.loaded.int.module.cmdmod][INFO    ][29194] Executing command 'gluster --version' in directory '/root'
2017-12-03 12:07:54,064 [salt.loaded.int.module.cmdmod][INFO    ][29194] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-03 12:07:54,120 [salt.loaded.int.module.cmdmod][INFO    ][29194] Executing command 'gluster --version' in directory '/root'
2017-12-03 12:07:54,129 [salt.loaded.int.module.cmdmod][INFO    ][29194] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-03 12:07:54,186 [salt.loaded.int.module.cmdmod][INFO    ][29194] Executing command 'gluster --version' in directory '/root'
2017-12-03 12:07:54,194 [salt.loaded.int.module.cmdmod][INFO    ][29194] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-03 12:07:54,248 [salt.loaded.int.module.cmdmod][INFO    ][29194] Executing command 'gluster --version' in directory '/root'
2017-12-03 12:07:54,257 [salt.loaded.int.module.cmdmod][INFO    ][29194] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-03 12:07:54,312 [salt.state       ][INFO    ][29194] Peering with localhost is not needed
2017-12-03 12:07:54,313 [salt.state       ][INFO    ][29194] Completed state [192.168.10.141] at time 12:07:54.312620 duration_in_ms=257.404
2017-12-03 12:07:54,314 [salt.state       ][INFO    ][29194] Running state [glance] at time 12:07:54.313734
2017-12-03 12:07:54,314 [salt.state       ][INFO    ][29194] Executing state glusterfs.created for glance
2017-12-03 12:07:54,315 [salt.loaded.int.module.cmdmod][INFO    ][29194] Executing command 'gluster --version' in directory '/root'
2017-12-03 12:07:54,323 [salt.loaded.int.module.cmdmod][INFO    ][29194] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-03 12:07:54,378 [salt.loaded.int.module.cmdmod][INFO    ][29194] Executing command 'gluster --version' in directory '/root'
2017-12-03 12:07:54,384 [salt.loaded.int.module.cmdmod][INFO    ][29194] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-03 12:07:54,445 [salt.state       ][INFO    ][29194] Volume glance already exists and is started.
2017-12-03 12:07:54,445 [salt.state       ][INFO    ][29194] Completed state [glance] at time 12:07:54.445102 duration_in_ms=131.367
2017-12-03 12:07:54,449 [salt.state       ][INFO    ][29194] Running state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 12:07:54.449299
2017-12-03 12:07:54,450 [salt.state       ][INFO    ][29194] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'
2017-12-03 12:07:54,450 [salt.loaded.int.module.cmdmod][INFO    ][29194] Executing command 'gluster volume info 'glance' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-12-03 12:07:54,505 [salt.state       ][INFO    ][29194] unless execution succeeded
2017-12-03 12:07:54,505 [salt.state       ][INFO    ][29194] Completed state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 12:07:54.505323 duration_in_ms=56.023
2017-12-03 12:07:54,506 [salt.state       ][INFO    ][29194] Running state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 12:07:54.505865
2017-12-03 12:07:54,506 [salt.state       ][INFO    ][29194] Executing state cmd.run for gluster volume set 'glance' 'network.remote-dio' 'True'
2017-12-03 12:07:54,507 [salt.loaded.int.module.cmdmod][INFO    ][29194] Executing command 'gluster volume info 'glance' | grep 'network.remote-dio: True'' in directory '/root'
2017-12-03 12:07:54,561 [salt.state       ][INFO    ][29194] unless execution succeeded
2017-12-03 12:07:54,561 [salt.state       ][INFO    ][29194] Completed state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 12:07:54.561396 duration_in_ms=55.53
2017-12-03 12:07:54,562 [salt.state       ][INFO    ][29194] Running state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 12:07:54.561967
2017-12-03 12:07:54,562 [salt.state       ][INFO    ][29194] Executing state cmd.run for gluster volume set 'glance' 'nfs.disable' 'True'
2017-12-03 12:07:54,563 [salt.loaded.int.module.cmdmod][INFO    ][29194] Executing command 'gluster volume info 'glance' | grep 'nfs.disable: True'' in directory '/root'
2017-12-03 12:07:54,617 [salt.state       ][INFO    ][29194] unless execution succeeded
2017-12-03 12:07:54,617 [salt.state       ][INFO    ][29194] Completed state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 12:07:54.617366 duration_in_ms=55.398
2017-12-03 12:07:54,618 [salt.state       ][INFO    ][29194] Running state [gluster volume set 'glance' 'cluster.favorite-child-policy' 'mtime'] at time 12:07:54.617970
2017-12-03 12:07:54,618 [salt.state       ][INFO    ][29194] Executing state cmd.run for gluster volume set 'glance' 'cluster.favorite-child-policy' 'mtime'
2017-12-03 12:07:54,619 [salt.loaded.int.module.cmdmod][INFO    ][29194] Executing command 'gluster volume info 'glance' | grep 'cluster.favorite-child-policy: mtime'' in directory '/root'
2017-12-03 12:07:54,673 [salt.state       ][INFO    ][29194] unless execution succeeded
2017-12-03 12:07:54,673 [salt.state       ][INFO    ][29194] Completed state [gluster volume set 'glance' 'cluster.favorite-child-policy' 'mtime'] at time 12:07:54.673168 duration_in_ms=55.197
2017-12-03 12:07:54,674 [salt.state       ][INFO    ][29194] Running state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 12:07:54.673785
2017-12-03 12:07:54,674 [salt.state       ][INFO    ][29194] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'
2017-12-03 12:07:54,675 [salt.loaded.int.module.cmdmod][INFO    ][29194] Executing command 'gluster volume info 'glance' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-12-03 12:07:54,729 [salt.state       ][INFO    ][29194] unless execution succeeded
2017-12-03 12:07:54,729 [salt.state       ][INFO    ][29194] Completed state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 12:07:54.729425 duration_in_ms=55.64
2017-12-03 12:07:54,730 [salt.state       ][INFO    ][29194] Running state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 12:07:54.729965
2017-12-03 12:07:54,730 [salt.state       ][INFO    ][29194] Executing state cmd.run for gluster volume set 'glance' 'cluster.readdir-optimize' 'True'
2017-12-03 12:07:54,731 [salt.loaded.int.module.cmdmod][INFO    ][29194] Executing command 'gluster volume info 'glance' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-12-03 12:07:54,786 [salt.state       ][INFO    ][29194] unless execution succeeded
2017-12-03 12:07:54,786 [salt.state       ][INFO    ][29194] Completed state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 12:07:54.785840 duration_in_ms=55.874
2017-12-03 12:07:54,787 [salt.state       ][INFO    ][29194] Running state [glance] at time 12:07:54.787451
2017-12-03 12:07:54,788 [salt.state       ][INFO    ][29194] Executing state glusterfs.started for glance
2017-12-03 12:07:54,788 [salt.loaded.int.module.cmdmod][INFO    ][29194] Executing command 'gluster --version' in directory '/root'
2017-12-03 12:07:54,796 [salt.loaded.int.module.cmdmod][INFO    ][29194] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-03 12:07:54,853 [salt.loaded.int.module.cmdmod][INFO    ][29194] Executing command 'gluster --version' in directory '/root'
2017-12-03 12:07:54,861 [salt.loaded.int.module.cmdmod][INFO    ][29194] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-03 12:07:54,919 [salt.state       ][INFO    ][29194] Volume glance is already started
2017-12-03 12:07:54,919 [salt.state       ][INFO    ][29194] Completed state [glance] at time 12:07:54.919182 duration_in_ms=131.731
2017-12-03 12:07:54,920 [salt.state       ][INFO    ][29194] Running state [keystone-keys] at time 12:07:54.920278
2017-12-03 12:07:54,921 [salt.state       ][INFO    ][29194] Executing state glusterfs.created for keystone-keys
2017-12-03 12:07:54,921 [salt.loaded.int.module.cmdmod][INFO    ][29194] Executing command 'gluster --version' in directory '/root'
2017-12-03 12:07:54,930 [salt.loaded.int.module.cmdmod][INFO    ][29194] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-03 12:07:54,986 [salt.loaded.int.module.cmdmod][INFO    ][29194] Executing command 'gluster --version' in directory '/root'
2017-12-03 12:07:54,994 [salt.loaded.int.module.cmdmod][INFO    ][29194] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-03 12:07:55,052 [salt.state       ][INFO    ][29194] Volume keystone-keys already exists and is started.
2017-12-03 12:07:55,053 [salt.state       ][INFO    ][29194] Completed state [keystone-keys] at time 12:07:55.052547 duration_in_ms=132.269
2017-12-03 12:07:55,057 [salt.state       ][INFO    ][29194] Running state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 12:07:55.057246
2017-12-03 12:07:55,058 [salt.state       ][INFO    ][29194] Executing state cmd.run for gluster volume set 'keystone-keys' 'network.remote-dio' 'True'
2017-12-03 12:07:55,058 [salt.loaded.int.module.cmdmod][INFO    ][29194] Executing command 'gluster volume info 'keystone-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-12-03 12:07:55,114 [salt.state       ][INFO    ][29194] unless execution succeeded
2017-12-03 12:07:55,114 [salt.state       ][INFO    ][29194] Completed state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 12:07:55.114065 duration_in_ms=56.818
2017-12-03 12:07:55,115 [salt.state       ][INFO    ][29194] Running state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 12:07:55.114617
2017-12-03 12:07:55,115 [salt.state       ][INFO    ][29194] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-12-03 12:07:55,115 [salt.loaded.int.module.cmdmod][INFO    ][29194] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-12-03 12:07:55,170 [salt.state       ][INFO    ][29194] unless execution succeeded
2017-12-03 12:07:55,170 [salt.state       ][INFO    ][29194] Completed state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 12:07:55.170123 duration_in_ms=55.505
2017-12-03 12:07:55,171 [salt.state       ][INFO    ][29194] Running state [gluster volume set 'keystone-keys' 'cluster.favorite-child-policy' 'mtime'] at time 12:07:55.170712
2017-12-03 12:07:55,171 [salt.state       ][INFO    ][29194] Executing state cmd.run for gluster volume set 'keystone-keys' 'cluster.favorite-child-policy' 'mtime'
2017-12-03 12:07:55,171 [salt.loaded.int.module.cmdmod][INFO    ][29194] Executing command 'gluster volume info 'keystone-keys' | grep 'cluster.favorite-child-policy: mtime'' in directory '/root'
2017-12-03 12:07:55,228 [salt.state       ][INFO    ][29194] unless execution succeeded
2017-12-03 12:07:55,228 [salt.state       ][INFO    ][29194] Completed state [gluster volume set 'keystone-keys' 'cluster.favorite-child-policy' 'mtime'] at time 12:07:55.228204 duration_in_ms=57.492
2017-12-03 12:07:55,229 [salt.state       ][INFO    ][29194] Running state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 12:07:55.229122
2017-12-03 12:07:55,230 [salt.state       ][INFO    ][29194] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'
2017-12-03 12:07:55,230 [salt.loaded.int.module.cmdmod][INFO    ][29194] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-12-03 12:07:55,287 [salt.state       ][INFO    ][29194] unless execution succeeded
2017-12-03 12:07:55,288 [salt.state       ][INFO    ][29194] Completed state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 12:07:55.287501 duration_in_ms=58.377
2017-12-03 12:07:55,288 [salt.state       ][INFO    ][29194] Running state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 12:07:55.288326
2017-12-03 12:07:55,289 [salt.state       ][INFO    ][29194] Executing state cmd.run for gluster volume set 'keystone-keys' 'nfs.disable' 'True'
2017-12-03 12:07:55,289 [salt.loaded.int.module.cmdmod][INFO    ][29194] Executing command 'gluster volume info 'keystone-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-12-03 12:07:55,346 [salt.state       ][INFO    ][29194] unless execution succeeded
2017-12-03 12:07:55,346 [salt.state       ][INFO    ][29194] Completed state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 12:07:55.345705 duration_in_ms=57.379
2017-12-03 12:07:55,346 [salt.state       ][INFO    ][29194] Running state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 12:07:55.346273
2017-12-03 12:07:55,347 [salt.state       ][INFO    ][29194] Executing state cmd.run for gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'
2017-12-03 12:07:55,347 [salt.loaded.int.module.cmdmod][INFO    ][29194] Executing command 'gluster volume info 'keystone-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-12-03 12:07:55,404 [salt.state       ][INFO    ][29194] unless execution succeeded
2017-12-03 12:07:55,404 [salt.state       ][INFO    ][29194] Completed state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 12:07:55.404271 duration_in_ms=57.997
2017-12-03 12:07:55,406 [salt.state       ][INFO    ][29194] Running state [keystone-keys] at time 12:07:55.405850
2017-12-03 12:07:55,406 [salt.state       ][INFO    ][29194] Executing state glusterfs.started for keystone-keys
2017-12-03 12:07:55,407 [salt.loaded.int.module.cmdmod][INFO    ][29194] Executing command 'gluster --version' in directory '/root'
2017-12-03 12:07:55,416 [salt.loaded.int.module.cmdmod][INFO    ][29194] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-03 12:07:55,472 [salt.loaded.int.module.cmdmod][INFO    ][29194] Executing command 'gluster --version' in directory '/root'
2017-12-03 12:07:55,481 [salt.loaded.int.module.cmdmod][INFO    ][29194] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-03 12:07:55,541 [salt.state       ][INFO    ][29194] Volume keystone-keys is already started
2017-12-03 12:07:55,541 [salt.state       ][INFO    ][29194] Completed state [keystone-keys] at time 12:07:55.541240 duration_in_ms=135.389
2017-12-03 12:07:55,543 [salt.state       ][INFO    ][29194] Running state [nova_instances] at time 12:07:55.542625
2017-12-03 12:07:55,543 [salt.state       ][INFO    ][29194] Executing state glusterfs.created for nova_instances
2017-12-03 12:07:55,543 [salt.loaded.int.module.cmdmod][INFO    ][29194] Executing command 'gluster --version' in directory '/root'
2017-12-03 12:07:55,552 [salt.loaded.int.module.cmdmod][INFO    ][29194] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-03 12:07:55,613 [salt.loaded.int.module.cmdmod][INFO    ][29194] Executing command 'gluster --version' in directory '/root'
2017-12-03 12:07:55,622 [salt.loaded.int.module.cmdmod][INFO    ][29194] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-03 12:07:55,681 [salt.state       ][INFO    ][29194] Volume nova_instances already exists and is started.
2017-12-03 12:07:55,681 [salt.state       ][INFO    ][29194] Completed state [nova_instances] at time 12:07:55.681423 duration_in_ms=138.797
2017-12-03 12:07:55,686 [salt.state       ][INFO    ][29194] Running state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 12:07:55.686097
2017-12-03 12:07:55,686 [salt.state       ][INFO    ][29194] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'
2017-12-03 12:07:55,687 [salt.loaded.int.module.cmdmod][INFO    ][29194] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-12-03 12:07:55,743 [salt.state       ][INFO    ][29194] unless execution succeeded
2017-12-03 12:07:55,743 [salt.state       ][INFO    ][29194] Completed state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 12:07:55.742754 duration_in_ms=56.657
2017-12-03 12:07:55,743 [salt.state       ][INFO    ][29194] Running state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'True'] at time 12:07:55.743333
2017-12-03 12:07:55,744 [salt.state       ][INFO    ][29194] Executing state cmd.run for gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'True'
2017-12-03 12:07:55,744 [salt.loaded.int.module.cmdmod][INFO    ][29194] Executing command 'gluster volume info 'nova_instances' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-12-03 12:07:55,799 [salt.state       ][INFO    ][29194] unless execution succeeded
2017-12-03 12:07:55,799 [salt.state       ][INFO    ][29194] Completed state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'True'] at time 12:07:55.799300 duration_in_ms=55.966
2017-12-03 12:07:55,800 [salt.state       ][INFO    ][29194] Running state [gluster volume set 'nova_instances' 'network.remote-dio' 'True'] at time 12:07:55.799883
2017-12-03 12:07:55,800 [salt.state       ][INFO    ][29194] Executing state cmd.run for gluster volume set 'nova_instances' 'network.remote-dio' 'True'
2017-12-03 12:07:55,801 [salt.loaded.int.module.cmdmod][INFO    ][29194] Executing command 'gluster volume info 'nova_instances' | grep 'network.remote-dio: True'' in directory '/root'
2017-12-03 12:07:55,857 [salt.state       ][INFO    ][29194] unless execution succeeded
2017-12-03 12:07:55,857 [salt.state       ][INFO    ][29194] Completed state [gluster volume set 'nova_instances' 'network.remote-dio' 'True'] at time 12:07:55.857269 duration_in_ms=57.385
2017-12-03 12:07:55,858 [salt.state       ][INFO    ][29194] Running state [gluster volume set 'nova_instances' 'cluster.favorite-child-policy' 'mtime'] at time 12:07:55.857889
2017-12-03 12:07:55,858 [salt.state       ][INFO    ][29194] Executing state cmd.run for gluster volume set 'nova_instances' 'cluster.favorite-child-policy' 'mtime'
2017-12-03 12:07:55,859 [salt.loaded.int.module.cmdmod][INFO    ][29194] Executing command 'gluster volume info 'nova_instances' | grep 'cluster.favorite-child-policy: mtime'' in directory '/root'
2017-12-03 12:07:55,913 [salt.state       ][INFO    ][29194] unless execution succeeded
2017-12-03 12:07:55,913 [salt.state       ][INFO    ][29194] Completed state [gluster volume set 'nova_instances' 'cluster.favorite-child-policy' 'mtime'] at time 12:07:55.913318 duration_in_ms=55.429
2017-12-03 12:07:55,914 [salt.state       ][INFO    ][29194] Running state [gluster volume set 'nova_instances' 'nfs.disable' 'True'] at time 12:07:55.913878
2017-12-03 12:07:55,914 [salt.state       ][INFO    ][29194] Executing state cmd.run for gluster volume set 'nova_instances' 'nfs.disable' 'True'
2017-12-03 12:07:55,915 [salt.loaded.int.module.cmdmod][INFO    ][29194] Executing command 'gluster volume info 'nova_instances' | grep 'nfs.disable: True'' in directory '/root'
2017-12-03 12:07:55,973 [salt.state       ][INFO    ][29194] unless execution succeeded
2017-12-03 12:07:55,974 [salt.state       ][INFO    ][29194] Completed state [gluster volume set 'nova_instances' 'nfs.disable' 'True'] at time 12:07:55.973538 duration_in_ms=59.66
2017-12-03 12:07:55,974 [salt.state       ][INFO    ][29194] Running state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 12:07:55.974127
2017-12-03 12:07:55,974 [salt.state       ][INFO    ][29194] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'
2017-12-03 12:07:55,975 [salt.loaded.int.module.cmdmod][INFO    ][29194] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-12-03 12:07:56,034 [salt.state       ][INFO    ][29194] unless execution succeeded
2017-12-03 12:07:56,035 [salt.state       ][INFO    ][29194] Completed state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 12:07:56.034461 duration_in_ms=60.334
2017-12-03 12:07:56,036 [salt.state       ][INFO    ][29194] Running state [nova_instances] at time 12:07:56.036131
2017-12-03 12:07:56,036 [salt.state       ][INFO    ][29194] Executing state glusterfs.started for nova_instances
2017-12-03 12:07:56,037 [salt.loaded.int.module.cmdmod][INFO    ][29194] Executing command 'gluster --version' in directory '/root'
2017-12-03 12:07:56,046 [salt.loaded.int.module.cmdmod][INFO    ][29194] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-03 12:07:56,103 [salt.loaded.int.module.cmdmod][INFO    ][29194] Executing command 'gluster --version' in directory '/root'
2017-12-03 12:07:56,112 [salt.loaded.int.module.cmdmod][INFO    ][29194] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-03 12:07:56,174 [salt.state       ][INFO    ][29194] Volume nova_instances is already started
2017-12-03 12:07:56,174 [salt.state       ][INFO    ][29194] Completed state [nova_instances] at time 12:07:56.174015 duration_in_ms=137.884
2017-12-03 12:07:56,175 [salt.state       ][INFO    ][29194] Running state [keystone-credential-keys] at time 12:07:56.175131
2017-12-03 12:07:56,175 [salt.state       ][INFO    ][29194] Executing state glusterfs.created for keystone-credential-keys
2017-12-03 12:07:56,176 [salt.loaded.int.module.cmdmod][INFO    ][29194] Executing command 'gluster --version' in directory '/root'
2017-12-03 12:07:56,184 [salt.loaded.int.module.cmdmod][INFO    ][29194] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-03 12:07:56,240 [salt.loaded.int.module.cmdmod][INFO    ][29194] Executing command 'gluster --version' in directory '/root'
2017-12-03 12:07:56,248 [salt.loaded.int.module.cmdmod][INFO    ][29194] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-03 12:07:56,308 [salt.state       ][INFO    ][29194] Volume keystone-credential-keys already exists and is started.
2017-12-03 12:07:56,309 [salt.state       ][INFO    ][29194] Completed state [keystone-credential-keys] at time 12:07:56.308520 duration_in_ms=133.387
2017-12-03 12:07:56,314 [salt.state       ][INFO    ][29194] Running state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 12:07:56.313487
2017-12-03 12:07:56,314 [salt.state       ][INFO    ][29194] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'
2017-12-03 12:07:56,314 [salt.loaded.int.module.cmdmod][INFO    ][29194] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-12-03 12:07:56,372 [salt.state       ][INFO    ][29194] unless execution succeeded
2017-12-03 12:07:56,373 [salt.state       ][INFO    ][29194] Completed state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 12:07:56.372479 duration_in_ms=58.992
2017-12-03 12:07:56,373 [salt.state       ][INFO    ][29194] Running state [gluster volume set 'keystone-credential-keys' 'cluster.favorite-child-policy' 'mtime'] at time 12:07:56.373194
2017-12-03 12:07:56,374 [salt.state       ][INFO    ][29194] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'cluster.favorite-child-policy' 'mtime'
2017-12-03 12:07:56,374 [salt.loaded.int.module.cmdmod][INFO    ][29194] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'cluster.favorite-child-policy: mtime'' in directory '/root'
2017-12-03 12:07:56,430 [salt.state       ][INFO    ][29194] unless execution succeeded
2017-12-03 12:07:56,431 [salt.state       ][INFO    ][29194] Completed state [gluster volume set 'keystone-credential-keys' 'cluster.favorite-child-policy' 'mtime'] at time 12:07:56.430571 duration_in_ms=57.377
2017-12-03 12:07:56,431 [salt.state       ][INFO    ][29194] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 12:07:56.431170
2017-12-03 12:07:56,431 [salt.state       ][INFO    ][29194] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-12-03 12:07:56,432 [salt.loaded.int.module.cmdmod][INFO    ][29194] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-12-03 12:07:56,489 [salt.state       ][INFO    ][29194] unless execution succeeded
2017-12-03 12:07:56,489 [salt.state       ][INFO    ][29194] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 12:07:56.489380 duration_in_ms=58.209
2017-12-03 12:07:56,490 [salt.state       ][INFO    ][29194] Running state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 12:07:56.489996
2017-12-03 12:07:56,490 [salt.state       ][INFO    ][29194] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'
2017-12-03 12:07:56,491 [salt.loaded.int.module.cmdmod][INFO    ][29194] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-12-03 12:07:56,547 [salt.state       ][INFO    ][29194] unless execution succeeded
2017-12-03 12:07:56,547 [salt.state       ][INFO    ][29194] Completed state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 12:07:56.546934 duration_in_ms=56.938
2017-12-03 12:07:56,548 [salt.state       ][INFO    ][29194] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 12:07:56.547527
2017-12-03 12:07:56,548 [salt.state       ][INFO    ][29194] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'
2017-12-03 12:07:56,548 [salt.loaded.int.module.cmdmod][INFO    ][29194] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-12-03 12:07:56,606 [salt.state       ][INFO    ][29194] unless execution succeeded
2017-12-03 12:07:56,606 [salt.state       ][INFO    ][29194] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 12:07:56.606027 duration_in_ms=58.5
2017-12-03 12:07:56,607 [salt.state       ][INFO    ][29194] Running state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 12:07:56.606583
2017-12-03 12:07:56,607 [salt.state       ][INFO    ][29194] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'
2017-12-03 12:07:56,607 [salt.loaded.int.module.cmdmod][INFO    ][29194] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-12-03 12:07:56,662 [salt.state       ][INFO    ][29194] unless execution succeeded
2017-12-03 12:07:56,663 [salt.state       ][INFO    ][29194] Completed state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 12:07:56.662556 duration_in_ms=55.959
2017-12-03 12:07:56,664 [salt.state       ][INFO    ][29194] Running state [keystone-credential-keys] at time 12:07:56.664028
2017-12-03 12:07:56,664 [salt.state       ][INFO    ][29194] Executing state glusterfs.started for keystone-credential-keys
2017-12-03 12:07:56,665 [salt.loaded.int.module.cmdmod][INFO    ][29194] Executing command 'gluster --version' in directory '/root'
2017-12-03 12:07:56,673 [salt.loaded.int.module.cmdmod][INFO    ][29194] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-03 12:07:56,729 [salt.loaded.int.module.cmdmod][INFO    ][29194] Executing command 'gluster --version' in directory '/root'
2017-12-03 12:07:56,738 [salt.loaded.int.module.cmdmod][INFO    ][29194] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-12-03 12:07:56,797 [salt.state       ][INFO    ][29194] Volume keystone-credential-keys is already started
2017-12-03 12:07:56,797 [salt.state       ][INFO    ][29194] Completed state [keystone-credential-keys] at time 12:07:56.797380 duration_in_ms=133.352
2017-12-03 12:07:56,800 [salt.minion      ][INFO    ][29194] Returning information for job: 20171203120752357907
2017-12-03 12:07:57,865 [salt.minion      ][INFO    ][22250] User sudo_ubuntu Executing command test.ping with jid 20171203120757857646
2017-12-03 12:07:57,877 [salt.minion      ][INFO    ][29706] Starting a new job with PID 29706
2017-12-03 12:07:57,912 [salt.minion      ][INFO    ][29706] Returning information for job: 20171203120757857646
2017-12-03 12:07:58,576 [salt.minion      ][INFO    ][22250] User sudo_ubuntu Executing command cmd.run with jid 20171203120758567343
2017-12-03 12:07:58,587 [salt.minion      ][INFO    ][29711] Starting a new job with PID 29711
2017-12-03 12:07:58,591 [salt.loaded.int.module.cmdmod][INFO    ][29711] Executing command 'gluster peer status; gluster volume status' in directory '/root'
2017-12-03 12:07:58,709 [salt.minion      ][INFO    ][29711] Returning information for job: 20171203120758567343
2017-12-03 12:09:44,207 [salt.utils.schedule][INFO    ][22250] Running scheduled job: __mine_interval
2017-12-03 12:40:27,670 [salt.minion      ][INFO    ][22250] User sudo_ubuntu Executing command cp.push_dir with jid 20171203124027655394
2017-12-03 12:40:27,685 [salt.minion      ][INFO    ][30018] Starting a new job with PID 30018
