2017-11-21 08:58:29,735 [salt.cli.daemons ][WARNING ][2393] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-11-21 08:58:39,699 [salt.state       ][ERROR   ][3622] No contents found in top file
2017-11-21 09:00:24,244 [salt.utils.parsers][WARNING ][2393] Minion received a SIGTERM. Exiting.
2017-11-21 09:02:37,752 [salt.cli.daemons ][WARNING ][3143] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-11-21 09:04:20,513 [salt.transport.ipc][ERROR   ][3143] Exception occurred while handling stream: [Errno 0] Success
2017-11-21 09:05:39,178 [py.warnings      ][WARNING ][15022] /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-11-21 09:09:35,787 [salt.loaded.int.module.cmdmod][ERROR   ][15022] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-11-21 09:09:35,788 [salt.loaded.int.module.cmdmod][ERROR   ][15022] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-11-21 09:09:41,872 [salt.loaded.int.module.cmdmod][ERROR   ][15022] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-11-21 09:09:41,872 [salt.loaded.int.module.cmdmod][ERROR   ][15022] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-11-21 09:09:50,032 [salt.loaded.int.module.cmdmod][ERROR   ][15022] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-11-21 09:09:50,032 [salt.loaded.int.module.cmdmod][ERROR   ][15022] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-11-21 09:09:58,942 [salt.loaded.int.module.cmdmod][ERROR   ][15022] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-11-21 09:09:58,942 [salt.loaded.int.module.cmdmod][ERROR   ][15022] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-11-21 09:10:04,587 [salt.loaded.int.module.cmdmod][ERROR   ][15022] 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-11-21 09:10:06,748 [salt.loaded.int.module.cmdmod][INFO    ][22313] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2017-11-21 09:10:06,754 [salt.loaded.int.module.cmdmod][INFO    ][22313] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2017-11-21 09:10:06,765 [salt.loaded.int.module.cmdmod][INFO    ][22313] Executing command ['systemd-run', '--scope', 'systemctl', 'restart', 'salt-minion.service'] in directory '/root'
2017-11-21 09:10:06,773 [salt.utils.parsers][WARNING ][3143] Minion received a SIGTERM. Exiting.
2017-11-21 09:10:07,027 [salt.cli.daemons ][INFO    ][22402] Setting up the Salt Minion "kvm02.baremetal-mcp-ocata-ovs-ha.local"
2017-11-21 09:10:07,554 [salt.minion      ][INFO    ][22402] Creating minion process manager
2017-11-21 09:10:07,555 [salt.cli.daemons ][WARNING ][22402] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-11-21 09:10:07,555 [salt.cli.daemons ][INFO    ][22402] The Salt Minion is starting up
2017-11-21 09:10:07,555 [salt.minion      ][INFO    ][22402] Minion is starting as user 'root'
2017-11-21 09:10:07,555 [salt.utils.event ][INFO    ][22402] Starting pull socket on /var/run/salt/minion/minion_event_a1b2f32648_pull.ipc
2017-11-21 09:10:08,408 [salt.loaded.int.module.cmdmod][INFO    ][22402] Executing command ['date', '+%z'] in directory '/root'
2017-11-21 09:10:08,416 [salt.utils.schedule][INFO    ][22402] Updating job settings for scheduled job: __mine_interval
2017-11-21 09:10:08,418 [salt.minion      ][INFO    ][22402] Added mine.update to scheduler
2017-11-21 09:10:08,599 [salt.minion      ][INFO    ][22402] Minion is ready to receive requests!
2017-11-21 09:10:09,600 [salt.utils.schedule][INFO    ][22402] Running scheduled job: __mine_interval
2017-11-21 09:10:16,572 [salt.minion      ][INFO    ][22402] User sudo_ubuntu Executing command saltutil.sync_all with jid 20171121091016583105
2017-11-21 09:10:16,585 [salt.minion      ][INFO    ][22528] Starting a new job with PID 22528
2017-11-21 09:10:18,236 [salt.state       ][INFO    ][22528] Loading fresh modules for state activity
2017-11-21 09:10:18,258 [salt.state       ][ERROR   ][22528] No contents found in top file
2017-11-21 09:10:18,258 [salt.utils.extmods][INFO    ][22528] Creating module dir '/var/cache/salt/minion/extmods/beacons'
2017-11-21 09:10:18,261 [salt.utils.extmods][INFO    ][22528] Syncing beacons for environment 'base'
2017-11-21 09:10:18,261 [salt.utils.extmods][INFO    ][22528] Loading cache from salt://_beacons, for base)
2017-11-21 09:10:18,261 [salt.fileclient  ][INFO    ][22528] Caching directory '_beacons/' for environment 'base'
2017-11-21 09:10:18,288 [salt.utils.extmods][INFO    ][22528] Syncing modules for environment 'base'
2017-11-21 09:10:18,288 [salt.utils.extmods][INFO    ][22528] Loading cache from salt://_modules, for base)
2017-11-21 09:10:18,288 [salt.fileclient  ][INFO    ][22528] Caching directory '_modules/' for environment 'base'
2017-11-21 09:10:18,318 [salt.fileclient  ][INFO    ][22528] Fetching file from saltenv 'base', ** done ** '_modules/ceph_ng.py'
2017-11-21 09:10:18,327 [salt.fileclient  ][INFO    ][22528] Fetching file from saltenv 'base', ** done ** '_modules/cinderng.py'
2017-11-21 09:10:18,337 [salt.fileclient  ][INFO    ][22528] Fetching file from saltenv 'base', ** done ** '_modules/contrail.py'
2017-11-21 09:10:18,348 [salt.fileclient  ][INFO    ][22528] Fetching file from saltenv 'base', ** done ** '_modules/creds.py'
2017-11-21 09:10:18,358 [salt.fileclient  ][INFO    ][22528] Fetching file from saltenv 'base', ** done ** '_modules/devops_utils.py'
2017-11-21 09:10:18,679 [salt.fileclient  ][INFO    ][22528] Fetching file from saltenv 'base', ** done ** '_modules/encode_json.py'
2017-11-21 09:10:18,693 [salt.fileclient  ][INFO    ][22528] Fetching file from saltenv 'base', ** done ** '_modules/gerrit.py'
2017-11-21 09:10:18,704 [salt.fileclient  ][INFO    ][22528] Fetching file from saltenv 'base', ** done ** '_modules/glanceng.py'
2017-11-21 09:10:18,716 [salt.fileclient  ][INFO    ][22528] Fetching file from saltenv 'base', ** done ** '_modules/heat.py'
2017-11-21 09:10:18,727 [salt.fileclient  ][INFO    ][22528] Fetching file from saltenv 'base', ** done ** '_modules/heka_alarming.py'
2017-11-21 09:10:18,738 [salt.fileclient  ][INFO    ][22528] Fetching file from saltenv 'base', ** done ** '_modules/helm.py'
2017-11-21 09:10:18,749 [salt.fileclient  ][INFO    ][22528] Fetching file from saltenv 'base', ** done ** '_modules/jenkins_common.py'
2017-11-21 09:10:18,760 [salt.fileclient  ][INFO    ][22528] Fetching file from saltenv 'base', ** done ** '_modules/keystone_policy.py'
2017-11-21 09:10:18,771 [salt.fileclient  ][INFO    ][22528] Fetching file from saltenv 'base', ** done ** '_modules/linux_hosts.py'
2017-11-21 09:10:18,780 [salt.fileclient  ][INFO    ][22528] Fetching file from saltenv 'base', ** done ** '_modules/linux_netlink.py'
2017-11-21 09:10:18,792 [salt.fileclient  ][INFO    ][22528] Fetching file from saltenv 'base', ** done ** '_modules/maas.py'
2017-11-21 09:10:18,804 [salt.fileclient  ][INFO    ][22528] Fetching file from saltenv 'base', ** done ** '_modules/maas_client.py'
2017-11-21 09:10:18,815 [salt.fileclient  ][INFO    ][22528] Fetching file from saltenv 'base', ** done ** '_modules/modelutils.py'
2017-11-21 09:10:19,075 [salt.fileclient  ][INFO    ][22528] Fetching file from saltenv 'base', ** done ** '_modules/multipart.py'
2017-11-21 09:10:19,085 [salt.fileclient  ][INFO    ][22528] Fetching file from saltenv 'base', ** done ** '_modules/nagios_alarming.py'
2017-11-21 09:10:19,098 [salt.fileclient  ][INFO    ][22528] Fetching file from saltenv 'base', ** done ** '_modules/neutronng.py'
2017-11-21 09:10:19,109 [salt.fileclient  ][INFO    ][22528] Fetching file from saltenv 'base', ** done ** '_modules/novang.py'
2017-11-21 09:10:19,120 [salt.fileclient  ][INFO    ][22528] Fetching file from saltenv 'base', ** done ** '_modules/reclass.py'
2017-11-21 09:10:19,131 [salt.fileclient  ][INFO    ][22528] Fetching file from saltenv 'base', ** done ** '_modules/rsyslog_util.py'
2017-11-21 09:10:19,141 [salt.fileclient  ][INFO    ][22528] Fetching file from saltenv 'base', ** done ** '_modules/rundeck.py'
2017-11-21 09:10:19,180 [salt.fileclient  ][INFO    ][22528] Fetching file from saltenv 'base', ** done ** '_modules/saltkey.py'
2017-11-21 09:10:19,191 [salt.fileclient  ][INFO    ][22528] Fetching file from saltenv 'base', ** done ** '_modules/saltresource.py'
2017-11-21 09:10:19,215 [salt.fileclient  ][INFO    ][22528] Fetching file from saltenv 'base', ** done ** '_modules/seedng.py'
2017-11-21 09:10:19,233 [salt.fileclient  ][INFO    ][22528] Fetching file from saltenv 'base', ** done ** '_modules/testing/credentials.py'
2017-11-21 09:10:19,244 [salt.fileclient  ][INFO    ][22528] Fetching file from saltenv 'base', ** done ** '_modules/testing/django.py'
2017-11-21 09:10:19,255 [salt.fileclient  ][INFO    ][22528] Fetching file from saltenv 'base', ** done ** '_modules/testing/django_client_proxy.py'
2017-11-21 09:10:19,267 [salt.fileclient  ][INFO    ][22528] Fetching file from saltenv 'base', ** done ** '_modules/utils.py'
2017-11-21 09:10:19,288 [salt.fileclient  ][INFO    ][22528] Fetching file from saltenv 'base', ** done ** '_modules/virtng.py'
2017-11-21 09:10:19,291 [salt.utils.extmods][INFO    ][22528] Copying '/var/cache/salt/minion/files/base/_modules/__init__.py' to '/var/cache/salt/minion/extmods/modules/__init__.py'
2017-11-21 09:10:19,291 [salt.utils.extmods][INFO    ][22528] Copying '/var/cache/salt/minion/files/base/_modules/ceph_ng.py' to '/var/cache/salt/minion/extmods/modules/ceph_ng.py'
2017-11-21 09:10:19,291 [salt.utils.extmods][INFO    ][22528] Copying '/var/cache/salt/minion/files/base/_modules/cinderng.py' to '/var/cache/salt/minion/extmods/modules/cinderng.py'
2017-11-21 09:10:19,292 [salt.utils.extmods][INFO    ][22528] Copying '/var/cache/salt/minion/files/base/_modules/contrail.py' to '/var/cache/salt/minion/extmods/modules/contrail.py'
2017-11-21 09:10:19,292 [salt.utils.extmods][INFO    ][22528] Copying '/var/cache/salt/minion/files/base/_modules/creds.py' to '/var/cache/salt/minion/extmods/modules/creds.py'
2017-11-21 09:10:19,292 [salt.utils.extmods][INFO    ][22528] Copying '/var/cache/salt/minion/files/base/_modules/devops_utils.py' to '/var/cache/salt/minion/extmods/modules/devops_utils.py'
2017-11-21 09:10:19,292 [salt.utils.extmods][INFO    ][22528] Copying '/var/cache/salt/minion/files/base/_modules/encode_json.py' to '/var/cache/salt/minion/extmods/modules/encode_json.py'
2017-11-21 09:10:19,293 [salt.utils.extmods][INFO    ][22528] Copying '/var/cache/salt/minion/files/base/_modules/gerrit.py' to '/var/cache/salt/minion/extmods/modules/gerrit.py'
2017-11-21 09:10:19,293 [salt.utils.extmods][INFO    ][22528] Copying '/var/cache/salt/minion/files/base/_modules/glanceng.py' to '/var/cache/salt/minion/extmods/modules/glanceng.py'
2017-11-21 09:10:19,293 [salt.utils.extmods][INFO    ][22528] Copying '/var/cache/salt/minion/files/base/_modules/heat.py' to '/var/cache/salt/minion/extmods/modules/heat.py'
2017-11-21 09:10:19,294 [salt.utils.extmods][INFO    ][22528] Copying '/var/cache/salt/minion/files/base/_modules/heka_alarming.py' to '/var/cache/salt/minion/extmods/modules/heka_alarming.py'
2017-11-21 09:10:19,294 [salt.utils.extmods][INFO    ][22528] Copying '/var/cache/salt/minion/files/base/_modules/helm.py' to '/var/cache/salt/minion/extmods/modules/helm.py'
2017-11-21 09:10:19,294 [salt.utils.extmods][INFO    ][22528] Copying '/var/cache/salt/minion/files/base/_modules/jenkins_common.py' to '/var/cache/salt/minion/extmods/modules/jenkins_common.py'
2017-11-21 09:10:19,294 [salt.utils.extmods][INFO    ][22528] Copying '/var/cache/salt/minion/files/base/_modules/keystone_policy.py' to '/var/cache/salt/minion/extmods/modules/keystone_policy.py'
2017-11-21 09:10:19,295 [salt.utils.extmods][INFO    ][22528] Copying '/var/cache/salt/minion/files/base/_modules/linux_hosts.py' to '/var/cache/salt/minion/extmods/modules/linux_hosts.py'
2017-11-21 09:10:19,295 [salt.utils.extmods][INFO    ][22528] Copying '/var/cache/salt/minion/files/base/_modules/linux_netlink.py' to '/var/cache/salt/minion/extmods/modules/linux_netlink.py'
2017-11-21 09:10:19,295 [salt.utils.extmods][INFO    ][22528] Copying '/var/cache/salt/minion/files/base/_modules/maas.py' to '/var/cache/salt/minion/extmods/modules/maas.py'
2017-11-21 09:10:19,295 [salt.utils.extmods][INFO    ][22528] Copying '/var/cache/salt/minion/files/base/_modules/maas_client.py' to '/var/cache/salt/minion/extmods/modules/maas_client.py'
2017-11-21 09:10:19,296 [salt.utils.extmods][INFO    ][22528] Copying '/var/cache/salt/minion/files/base/_modules/modelutils.py' to '/var/cache/salt/minion/extmods/modules/modelutils.py'
2017-11-21 09:10:19,296 [salt.utils.extmods][INFO    ][22528] Copying '/var/cache/salt/minion/files/base/_modules/multipart.py' to '/var/cache/salt/minion/extmods/modules/multipart.py'
2017-11-21 09:10:19,296 [salt.utils.extmods][INFO    ][22528] Copying '/var/cache/salt/minion/files/base/_modules/nagios_alarming.py' to '/var/cache/salt/minion/extmods/modules/nagios_alarming.py'
2017-11-21 09:10:19,296 [salt.utils.extmods][INFO    ][22528] Copying '/var/cache/salt/minion/files/base/_modules/neutronng.py' to '/var/cache/salt/minion/extmods/modules/neutronng.py'
2017-11-21 09:10:19,297 [salt.utils.extmods][INFO    ][22528] Copying '/var/cache/salt/minion/files/base/_modules/novang.py' to '/var/cache/salt/minion/extmods/modules/novang.py'
2017-11-21 09:10:19,297 [salt.utils.extmods][INFO    ][22528] Copying '/var/cache/salt/minion/files/base/_modules/reclass.py' to '/var/cache/salt/minion/extmods/modules/reclass.py'
2017-11-21 09:10:19,298 [salt.utils.extmods][INFO    ][22528] Copying '/var/cache/salt/minion/files/base/_modules/rsyslog_util.py' to '/var/cache/salt/minion/extmods/modules/rsyslog_util.py'
2017-11-21 09:10:19,298 [salt.utils.extmods][INFO    ][22528] Copying '/var/cache/salt/minion/files/base/_modules/rundeck.py' to '/var/cache/salt/minion/extmods/modules/rundeck.py'
2017-11-21 09:10:19,298 [salt.utils.extmods][INFO    ][22528] Copying '/var/cache/salt/minion/files/base/_modules/saltkey.py' to '/var/cache/salt/minion/extmods/modules/saltkey.py'
2017-11-21 09:10:19,298 [salt.utils.extmods][INFO    ][22528] Copying '/var/cache/salt/minion/files/base/_modules/saltresource.py' to '/var/cache/salt/minion/extmods/modules/saltresource.py'
2017-11-21 09:10:19,299 [salt.utils.extmods][INFO    ][22528] Copying '/var/cache/salt/minion/files/base/_modules/seedng.py' to '/var/cache/salt/minion/extmods/modules/seedng.py'
2017-11-21 09:10:19,299 [salt.utils.extmods][INFO    ][22528] Copying '/var/cache/salt/minion/files/base/_modules/testing/__init__.py' to '/var/cache/salt/minion/extmods/modules/testing/__init__.py'
2017-11-21 09:10:19,299 [salt.utils.extmods][INFO    ][22528] Copying '/var/cache/salt/minion/files/base/_modules/testing/credentials.py' to '/var/cache/salt/minion/extmods/modules/testing/credentials.py'
2017-11-21 09:10:19,299 [salt.utils.extmods][INFO    ][22528] Copying '/var/cache/salt/minion/files/base/_modules/testing/django.py' to '/var/cache/salt/minion/extmods/modules/testing/django.py'
2017-11-21 09:10:19,300 [salt.utils.extmods][INFO    ][22528] 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-11-21 09:10:19,300 [salt.utils.extmods][INFO    ][22528] Copying '/var/cache/salt/minion/files/base/_modules/utils.py' to '/var/cache/salt/minion/extmods/modules/utils.py'
2017-11-21 09:10:19,300 [salt.utils.extmods][INFO    ][22528] Copying '/var/cache/salt/minion/files/base/_modules/virtng.py' to '/var/cache/salt/minion/extmods/modules/virtng.py'
2017-11-21 09:10:19,304 [salt.utils.extmods][INFO    ][22528] Syncing states for environment 'base'
2017-11-21 09:10:19,305 [salt.utils.extmods][INFO    ][22528] Loading cache from salt://_states, for base)
2017-11-21 09:10:19,305 [salt.fileclient  ][INFO    ][22528] Caching directory '_states/' for environment 'base'
2017-11-21 09:10:19,343 [salt.fileclient  ][INFO    ][22528] Fetching file from saltenv 'base', ** done ** '_states/cinderng.py'
2017-11-21 09:10:19,353 [salt.fileclient  ][INFO    ][22528] Fetching file from saltenv 'base', ** done ** '_states/contrail.py'
2017-11-21 09:10:19,363 [salt.fileclient  ][INFO    ][22528] Fetching file from saltenv 'base', ** done ** '_states/gerrit.py'
2017-11-21 09:10:19,373 [salt.fileclient  ][INFO    ][22528] Fetching file from saltenv 'base', ** done ** '_states/glanceng.py'
2017-11-21 09:10:19,402 [salt.fileclient  ][INFO    ][22528] Fetching file from saltenv 'base', ** done ** '_states/grafana3_dashboard.py'
2017-11-21 09:10:19,411 [salt.fileclient  ][INFO    ][22528] Fetching file from saltenv 'base', ** done ** '_states/grafana3_datasource.py'
2017-11-21 09:10:19,421 [salt.fileclient  ][INFO    ][22528] Fetching file from saltenv 'base', ** done ** '_states/heat.py'
2017-11-21 09:10:19,455 [salt.fileclient  ][INFO    ][22528] Fetching file from saltenv 'base', ** done ** '_states/helm_release.py'
2017-11-21 09:10:19,465 [salt.fileclient  ][INFO    ][22528] Fetching file from saltenv 'base', ** done ** '_states/jenkins_approval.py'
2017-11-21 09:10:19,680 [salt.fileclient  ][INFO    ][22528] Fetching file from saltenv 'base', ** done ** '_states/jenkins_artifactory.py'
2017-11-21 09:10:19,701 [salt.fileclient  ][INFO    ][22528] Fetching file from saltenv 'base', ** done ** '_states/jenkins_credential.py'
2017-11-21 09:10:19,711 [salt.fileclient  ][INFO    ][22528] Fetching file from saltenv 'base', ** done ** '_states/jenkins_globalenvprop.py'
2017-11-21 09:10:19,722 [salt.fileclient  ][INFO    ][22528] Fetching file from saltenv 'base', ** done ** '_states/jenkins_job.py'
2017-11-21 09:10:19,732 [salt.fileclient  ][INFO    ][22528] Fetching file from saltenv 'base', ** done ** '_states/jenkins_lib.py'
2017-11-21 09:10:19,742 [salt.fileclient  ][INFO    ][22528] Fetching file from saltenv 'base', ** done ** '_states/jenkins_node.py'
2017-11-21 09:10:19,752 [salt.fileclient  ][INFO    ][22528] Fetching file from saltenv 'base', ** done ** '_states/jenkins_plugin.py'
2017-11-21 09:10:19,763 [salt.fileclient  ][INFO    ][22528] Fetching file from saltenv 'base', ** done ** '_states/jenkins_security.py'
2017-11-21 09:10:19,774 [salt.fileclient  ][INFO    ][22528] Fetching file from saltenv 'base', ** done ** '_states/jenkins_slack.py'
2017-11-21 09:10:19,784 [salt.fileclient  ][INFO    ][22528] Fetching file from saltenv 'base', ** done ** '_states/jenkins_smtp.py'
2017-11-21 09:10:19,794 [salt.fileclient  ][INFO    ][22528] Fetching file from saltenv 'base', ** done ** '_states/jenkins_theme.py'
2017-11-21 09:10:19,819 [salt.fileclient  ][INFO    ][22528] Fetching file from saltenv 'base', ** done ** '_states/jenkins_user.py'
2017-11-21 09:10:19,829 [salt.fileclient  ][INFO    ][22528] Fetching file from saltenv 'base', ** done ** '_states/jenkins_view.py'
2017-11-21 09:10:19,838 [salt.fileclient  ][INFO    ][22528] Fetching file from saltenv 'base', ** done ** '_states/keystone_policy.py'
2017-11-21 09:10:19,847 [salt.fileclient  ][INFO    ][22528] Fetching file from saltenv 'base', ** done ** '_states/kibana_object.py'
2017-11-21 09:10:19,864 [salt.fileclient  ][INFO    ][22528] Fetching file from saltenv 'base', ** done ** '_states/neutronng.py'
2017-11-21 09:10:19,882 [salt.fileclient  ][INFO    ][22528] Fetching file from saltenv 'base', ** done ** '_states/novang.py'
2017-11-21 09:10:19,891 [salt.fileclient  ][INFO    ][22528] Fetching file from saltenv 'base', ** done ** '_states/reclass.py'
2017-11-21 09:10:19,901 [salt.fileclient  ][INFO    ][22528] Fetching file from saltenv 'base', ** done ** '_states/rundeck_project.py'
2017-11-21 09:10:19,910 [salt.fileclient  ][INFO    ][22528] Fetching file from saltenv 'base', ** done ** '_states/rundeck_scm.py'
2017-11-21 09:10:19,920 [salt.fileclient  ][INFO    ][22528] Fetching file from saltenv 'base', ** done ** '_states/rundeck_secret.py'
2017-11-21 09:10:19,923 [salt.utils.extmods][INFO    ][22528] Copying '/var/cache/salt/minion/files/base/_states/cinderng.py' to '/var/cache/salt/minion/extmods/states/cinderng.py'
2017-11-21 09:10:19,923 [salt.utils.extmods][INFO    ][22528] Copying '/var/cache/salt/minion/files/base/_states/contrail.py' to '/var/cache/salt/minion/extmods/states/contrail.py'
2017-11-21 09:10:19,924 [salt.utils.extmods][INFO    ][22528] Copying '/var/cache/salt/minion/files/base/_states/gerrit.py' to '/var/cache/salt/minion/extmods/states/gerrit.py'
2017-11-21 09:10:19,924 [salt.utils.extmods][INFO    ][22528] Copying '/var/cache/salt/minion/files/base/_states/glanceng.py' to '/var/cache/salt/minion/extmods/states/glanceng.py'
2017-11-21 09:10:19,924 [salt.utils.extmods][INFO    ][22528] Copying '/var/cache/salt/minion/files/base/_states/grafana3_dashboard.py' to '/var/cache/salt/minion/extmods/states/grafana3_dashboard.py'
2017-11-21 09:10:19,924 [salt.utils.extmods][INFO    ][22528] Copying '/var/cache/salt/minion/files/base/_states/grafana3_datasource.py' to '/var/cache/salt/minion/extmods/states/grafana3_datasource.py'
2017-11-21 09:10:19,925 [salt.utils.extmods][INFO    ][22528] Copying '/var/cache/salt/minion/files/base/_states/heat.py' to '/var/cache/salt/minion/extmods/states/heat.py'
2017-11-21 09:10:19,925 [salt.utils.extmods][INFO    ][22528] Copying '/var/cache/salt/minion/files/base/_states/helm_release.py' to '/var/cache/salt/minion/extmods/states/helm_release.py'
2017-11-21 09:10:19,925 [salt.utils.extmods][INFO    ][22528] Copying '/var/cache/salt/minion/files/base/_states/jenkins_approval.py' to '/var/cache/salt/minion/extmods/states/jenkins_approval.py'
2017-11-21 09:10:19,925 [salt.utils.extmods][INFO    ][22528] Copying '/var/cache/salt/minion/files/base/_states/jenkins_artifactory.py' to '/var/cache/salt/minion/extmods/states/jenkins_artifactory.py'
2017-11-21 09:10:19,926 [salt.utils.extmods][INFO    ][22528] Copying '/var/cache/salt/minion/files/base/_states/jenkins_credential.py' to '/var/cache/salt/minion/extmods/states/jenkins_credential.py'
2017-11-21 09:10:19,926 [salt.utils.extmods][INFO    ][22528] Copying '/var/cache/salt/minion/files/base/_states/jenkins_globalenvprop.py' to '/var/cache/salt/minion/extmods/states/jenkins_globalenvprop.py'
2017-11-21 09:10:19,926 [salt.utils.extmods][INFO    ][22528] Copying '/var/cache/salt/minion/files/base/_states/jenkins_job.py' to '/var/cache/salt/minion/extmods/states/jenkins_job.py'
2017-11-21 09:10:19,926 [salt.utils.extmods][INFO    ][22528] Copying '/var/cache/salt/minion/files/base/_states/jenkins_lib.py' to '/var/cache/salt/minion/extmods/states/jenkins_lib.py'
2017-11-21 09:10:19,927 [salt.utils.extmods][INFO    ][22528] Copying '/var/cache/salt/minion/files/base/_states/jenkins_node.py' to '/var/cache/salt/minion/extmods/states/jenkins_node.py'
2017-11-21 09:10:19,927 [salt.utils.extmods][INFO    ][22528] Copying '/var/cache/salt/minion/files/base/_states/jenkins_plugin.py' to '/var/cache/salt/minion/extmods/states/jenkins_plugin.py'
2017-11-21 09:10:19,927 [salt.utils.extmods][INFO    ][22528] Copying '/var/cache/salt/minion/files/base/_states/jenkins_security.py' to '/var/cache/salt/minion/extmods/states/jenkins_security.py'
2017-11-21 09:10:19,927 [salt.utils.extmods][INFO    ][22528] Copying '/var/cache/salt/minion/files/base/_states/jenkins_slack.py' to '/var/cache/salt/minion/extmods/states/jenkins_slack.py'
2017-11-21 09:10:19,928 [salt.utils.extmods][INFO    ][22528] Copying '/var/cache/salt/minion/files/base/_states/jenkins_smtp.py' to '/var/cache/salt/minion/extmods/states/jenkins_smtp.py'
2017-11-21 09:10:19,928 [salt.utils.extmods][INFO    ][22528] Copying '/var/cache/salt/minion/files/base/_states/jenkins_theme.py' to '/var/cache/salt/minion/extmods/states/jenkins_theme.py'
2017-11-21 09:10:19,928 [salt.utils.extmods][INFO    ][22528] Copying '/var/cache/salt/minion/files/base/_states/jenkins_user.py' to '/var/cache/salt/minion/extmods/states/jenkins_user.py'
2017-11-21 09:10:19,928 [salt.utils.extmods][INFO    ][22528] Copying '/var/cache/salt/minion/files/base/_states/jenkins_view.py' to '/var/cache/salt/minion/extmods/states/jenkins_view.py'
2017-11-21 09:10:19,929 [salt.utils.extmods][INFO    ][22528] Copying '/var/cache/salt/minion/files/base/_states/keystone_policy.py' to '/var/cache/salt/minion/extmods/states/keystone_policy.py'
2017-11-21 09:10:19,929 [salt.utils.extmods][INFO    ][22528] Copying '/var/cache/salt/minion/files/base/_states/kibana_object.py' to '/var/cache/salt/minion/extmods/states/kibana_object.py'
2017-11-21 09:10:19,929 [salt.utils.extmods][INFO    ][22528] Copying '/var/cache/salt/minion/files/base/_states/maas_cluster.py' to '/var/cache/salt/minion/extmods/states/maas_cluster.py'
2017-11-21 09:10:19,929 [salt.utils.extmods][INFO    ][22528] Copying '/var/cache/salt/minion/files/base/_states/neutronng.py' to '/var/cache/salt/minion/extmods/states/neutronng.py'
2017-11-21 09:10:19,930 [salt.utils.extmods][INFO    ][22528] Copying '/var/cache/salt/minion/files/base/_states/novang.py' to '/var/cache/salt/minion/extmods/states/novang.py'
2017-11-21 09:10:19,930 [salt.utils.extmods][INFO    ][22528] Copying '/var/cache/salt/minion/files/base/_states/reclass.py' to '/var/cache/salt/minion/extmods/states/reclass.py'
2017-11-21 09:10:19,930 [salt.utils.extmods][INFO    ][22528] Copying '/var/cache/salt/minion/files/base/_states/rundeck_project.py' to '/var/cache/salt/minion/extmods/states/rundeck_project.py'
2017-11-21 09:10:19,931 [salt.utils.extmods][INFO    ][22528] Copying '/var/cache/salt/minion/files/base/_states/rundeck_scm.py' to '/var/cache/salt/minion/extmods/states/rundeck_scm.py'
2017-11-21 09:10:19,931 [salt.utils.extmods][INFO    ][22528] Copying '/var/cache/salt/minion/files/base/_states/rundeck_secret.py' to '/var/cache/salt/minion/extmods/states/rundeck_secret.py'
2017-11-21 09:10:19,933 [salt.utils.extmods][INFO    ][22528] Creating module dir '/var/cache/salt/minion/extmods/sdb'
2017-11-21 09:10:19,935 [salt.utils.extmods][INFO    ][22528] Syncing sdb for environment 'base'
2017-11-21 09:10:19,935 [salt.utils.extmods][INFO    ][22528] Loading cache from salt://_sdb, for base)
2017-11-21 09:10:19,936 [salt.fileclient  ][INFO    ][22528] Caching directory '_sdb/' for environment 'base'
2017-11-21 09:10:19,972 [salt.utils.extmods][INFO    ][22528] Syncing grains for environment 'base'
2017-11-21 09:10:19,972 [salt.utils.extmods][INFO    ][22528] Loading cache from salt://_grains, for base)
2017-11-21 09:10:19,972 [salt.fileclient  ][INFO    ][22528] Caching directory '_grains/' for environment 'base'
2017-11-21 09:10:20,014 [salt.fileclient  ][INFO    ][22528] Fetching file from saltenv 'base', ** done ** '_grains/ceilometer_policy.py'
2017-11-21 09:10:20,023 [salt.fileclient  ][INFO    ][22528] Fetching file from saltenv 'base', ** done ** '_grains/ceph.py'
2017-11-21 09:10:20,033 [salt.fileclient  ][INFO    ][22528] Fetching file from saltenv 'base', ** done ** '_grains/cinder_policy.py'
2017-11-21 09:10:20,043 [salt.fileclient  ][INFO    ][22528] Fetching file from saltenv 'base', ** done ** '_grains/docker_swarm.py'
2017-11-21 09:10:20,067 [salt.fileclient  ][INFO    ][22528] Fetching file from saltenv 'base', ** done ** '_grains/glance_policy.py'
2017-11-21 09:10:20,077 [salt.fileclient  ][INFO    ][22528] Fetching file from saltenv 'base', ** done ** '_grains/heat_policy.py'
2017-11-21 09:10:20,101 [salt.fileclient  ][INFO    ][22528] Fetching file from saltenv 'base', ** done ** '_grains/jenkins_plugins.py'
2017-11-21 09:10:20,112 [salt.fileclient  ][INFO    ][22528] Fetching file from saltenv 'base', ** done ** '_grains/keystone_policy.py'
2017-11-21 09:10:20,121 [salt.fileclient  ][INFO    ][22528] Fetching file from saltenv 'base', ** done ** '_grains/kubernetes.py'
2017-11-21 09:10:20,131 [salt.fileclient  ][INFO    ][22528] Fetching file from saltenv 'base', ** done ** '_grains/neutron_policy.py'
2017-11-21 09:10:20,141 [salt.fileclient  ][INFO    ][22528] Fetching file from saltenv 'base', ** done ** '_grains/nova_policy.py'
2017-11-21 09:10:20,151 [salt.fileclient  ][INFO    ][22528] Fetching file from saltenv 'base', ** done ** '_grains/ssh_fingerprints.py'
2017-11-21 09:10:20,154 [salt.utils.extmods][INFO    ][22528] Copying '/var/cache/salt/minion/files/base/_grains/ceilometer_policy.py' to '/var/cache/salt/minion/extmods/grains/ceilometer_policy.py'
2017-11-21 09:10:20,154 [salt.utils.extmods][INFO    ][22528] Copying '/var/cache/salt/minion/files/base/_grains/ceph.py' to '/var/cache/salt/minion/extmods/grains/ceph.py'
2017-11-21 09:10:20,154 [salt.utils.extmods][INFO    ][22528] Copying '/var/cache/salt/minion/files/base/_grains/cinder_policy.py' to '/var/cache/salt/minion/extmods/grains/cinder_policy.py'
2017-11-21 09:10:20,154 [salt.utils.extmods][INFO    ][22528] Copying '/var/cache/salt/minion/files/base/_grains/docker_swarm.py' to '/var/cache/salt/minion/extmods/grains/docker_swarm.py'
2017-11-21 09:10:20,155 [salt.utils.extmods][INFO    ][22528] Copying '/var/cache/salt/minion/files/base/_grains/glance_policy.py' to '/var/cache/salt/minion/extmods/grains/glance_policy.py'
2017-11-21 09:10:20,155 [salt.utils.extmods][INFO    ][22528] Copying '/var/cache/salt/minion/files/base/_grains/heat_policy.py' to '/var/cache/salt/minion/extmods/grains/heat_policy.py'
2017-11-21 09:10:20,155 [salt.utils.extmods][INFO    ][22528] Copying '/var/cache/salt/minion/files/base/_grains/jenkins_plugins.py' to '/var/cache/salt/minion/extmods/grains/jenkins_plugins.py'
2017-11-21 09:10:20,155 [salt.utils.extmods][INFO    ][22528] Copying '/var/cache/salt/minion/files/base/_grains/keystone_policy.py' to '/var/cache/salt/minion/extmods/grains/keystone_policy.py'
2017-11-21 09:10:20,155 [salt.utils.extmods][INFO    ][22528] Copying '/var/cache/salt/minion/files/base/_grains/kubernetes.py' to '/var/cache/salt/minion/extmods/grains/kubernetes.py'
2017-11-21 09:10:20,156 [salt.utils.extmods][INFO    ][22528] Copying '/var/cache/salt/minion/files/base/_grains/neutron_policy.py' to '/var/cache/salt/minion/extmods/grains/neutron_policy.py'
2017-11-21 09:10:20,156 [salt.utils.extmods][INFO    ][22528] Copying '/var/cache/salt/minion/files/base/_grains/nova_policy.py' to '/var/cache/salt/minion/extmods/grains/nova_policy.py'
2017-11-21 09:10:20,156 [salt.utils.extmods][INFO    ][22528] Copying '/var/cache/salt/minion/files/base/_grains/ssh_fingerprints.py' to '/var/cache/salt/minion/extmods/grains/ssh_fingerprints.py'
2017-11-21 09:10:20,157 [salt.utils.extmods][INFO    ][22528] Creating module dir '/var/cache/salt/minion/extmods/renderers'
2017-11-21 09:10:20,160 [salt.utils.extmods][INFO    ][22528] Syncing renderers for environment 'base'
2017-11-21 09:10:20,160 [salt.utils.extmods][INFO    ][22528] Loading cache from salt://_renderers, for base)
2017-11-21 09:10:20,160 [salt.fileclient  ][INFO    ][22528] Caching directory '_renderers/' for environment 'base'
2017-11-21 09:10:20,188 [salt.utils.extmods][INFO    ][22528] Creating module dir '/var/cache/salt/minion/extmods/returners'
2017-11-21 09:10:20,190 [salt.utils.extmods][INFO    ][22528] Syncing returners for environment 'base'
2017-11-21 09:10:20,190 [salt.utils.extmods][INFO    ][22528] Loading cache from salt://_returners, for base)
2017-11-21 09:10:20,190 [salt.fileclient  ][INFO    ][22528] Caching directory '_returners/' for environment 'base'
2017-11-21 09:10:20,228 [salt.utils.extmods][INFO    ][22528] Creating module dir '/var/cache/salt/minion/extmods/output'
2017-11-21 09:10:20,230 [salt.utils.extmods][INFO    ][22528] Syncing output for environment 'base'
2017-11-21 09:10:20,230 [salt.utils.extmods][INFO    ][22528] Loading cache from salt://_output, for base)
2017-11-21 09:10:20,230 [salt.fileclient  ][INFO    ][22528] Caching directory '_output/' for environment 'base'
2017-11-21 09:10:20,263 [salt.utils.extmods][INFO    ][22528] Creating module dir '/var/cache/salt/minion/extmods/utils'
2017-11-21 09:10:20,265 [salt.utils.extmods][INFO    ][22528] Syncing utils for environment 'base'
2017-11-21 09:10:20,265 [salt.utils.extmods][INFO    ][22528] Loading cache from salt://_utils, for base)
2017-11-21 09:10:20,266 [salt.fileclient  ][INFO    ][22528] Caching directory '_utils/' for environment 'base'
2017-11-21 09:10:20,295 [salt.utils.extmods][INFO    ][22528] Creating module dir '/var/cache/salt/minion/extmods/log_handlers'
2017-11-21 09:10:20,297 [salt.utils.extmods][INFO    ][22528] Syncing log_handlers for environment 'base'
2017-11-21 09:10:20,297 [salt.utils.extmods][INFO    ][22528] Loading cache from salt://_log_handlers, for base)
2017-11-21 09:10:20,297 [salt.fileclient  ][INFO    ][22528] Caching directory '_log_handlers/' for environment 'base'
2017-11-21 09:10:20,323 [salt.utils.extmods][INFO    ][22528] Creating module dir '/var/cache/salt/minion/extmods/proxy'
2017-11-21 09:10:20,326 [salt.utils.extmods][INFO    ][22528] Syncing proxy for environment 'base'
2017-11-21 09:10:20,326 [salt.utils.extmods][INFO    ][22528] Loading cache from salt://_proxy, for base)
2017-11-21 09:10:20,326 [salt.fileclient  ][INFO    ][22528] Caching directory '_proxy/' for environment 'base'
2017-11-21 09:10:20,348 [salt.utils.extmods][INFO    ][22528] Creating module dir '/var/cache/salt/minion/extmods/engines'
2017-11-21 09:10:20,350 [salt.utils.extmods][INFO    ][22528] Syncing engines for environment 'base'
2017-11-21 09:10:20,351 [salt.utils.extmods][INFO    ][22528] Loading cache from salt://_engines, for base)
2017-11-21 09:10:20,351 [salt.fileclient  ][INFO    ][22528] Caching directory '_engines/' for environment 'base'
2017-11-21 09:10:20,374 [salt.minion      ][INFO    ][22528] Returning information for job: 20171121091016583105
2017-11-21 09:10:25,149 [salt.minion      ][INFO    ][22402] User sudo_ubuntu Executing command state.sls with jid 20171121091025159109
2017-11-21 09:10:25,162 [salt.minion      ][INFO    ][22652] Starting a new job with PID 22652
2017-11-21 09:10:25,604 [salt.state       ][INFO    ][22652] Loading fresh modules for state activity
2017-11-21 09:10:25,670 [salt.fileclient  ][INFO    ][22652] Fetching file from saltenv 'base', ** done ** 'salt/control/init.sls'
2017-11-21 09:10:25,692 [salt.fileclient  ][INFO    ][22652] Fetching file from saltenv 'base', ** done ** 'salt/control/virt.sls'
2017-11-21 09:10:25,766 [salt.fileclient  ][INFO    ][22652] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-11-21 09:10:25,845 [salt.fileclient  ][INFO    ][22652] Fetching file from saltenv 'base', ** done ** 'salt/minion/init.sls'
2017-11-21 09:10:25,872 [salt.fileclient  ][INFO    ][22652] Fetching file from saltenv 'base', ** done ** 'salt/minion/service.sls'
2017-11-21 09:10:25,908 [salt.fileclient  ][INFO    ][22652] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-11-21 09:10:25,967 [salt.fileclient  ][INFO    ][22652] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-11-21 09:10:25,997 [salt.fileclient  ][INFO    ][22652] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-11-21 09:10:26,042 [salt.fileclient  ][INFO    ][22652] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-11-21 09:10:26,074 [salt.fileclient  ][INFO    ][22652] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-11-21 09:10:26,087 [salt.fileclient  ][INFO    ][22652] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-11-21 09:10:26,123 [salt.fileclient  ][INFO    ][22652] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-11-21 09:10:26,131 [salt.loaded.int.module.cmdmod][INFO    ][22652] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-11-21 09:10:26,154 [salt.fileclient  ][INFO    ][22652] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-11-21 09:10:26,169 [py.warnings      ][WARNING ][22652] /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-11-21 09:10:26,177 [salt.loaded.int.module.cmdmod][INFO    ][22652] Executing command 'salt-minion --version' in directory '/root'
2017-11-21 09:10:26,425 [salt.fileclient  ][INFO    ][22652] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-11-21 09:10:26,443 [salt.fileclient  ][INFO    ][22652] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-11-21 09:10:26,456 [salt.fileclient  ][INFO    ][22652] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-11-21 09:10:26,468 [salt.fileclient  ][INFO    ][22652] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-11-21 09:10:26,510 [salt.fileclient  ][INFO    ][22652] Fetching file from saltenv 'base', ** done ** 'reclass/meta/meta.yml'
2017-11-21 09:10:26,524 [salt.fileclient  ][INFO    ][22652] Fetching file from saltenv 'base', ** done ** 'reclass/map.jinja'
2017-11-21 09:10:26,550 [salt.fileclient  ][INFO    ][22652] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-11-21 09:10:26,585 [salt.fileclient  ][INFO    ][22652] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-11-21 09:10:26,647 [salt.fileclient  ][INFO    ][22652] Fetching file from saltenv 'base', ** done ** 'salt/minion/grains.sls'
2017-11-21 09:10:26,670 [salt.fileclient  ][INFO    ][22652] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-11-21 09:10:26,834 [salt.fileclient  ][INFO    ][22652] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-11-21 09:10:26,851 [salt.fileclient  ][INFO    ][22652] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-11-21 09:10:26,909 [salt.fileclient  ][INFO    ][22652] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-11-21 09:10:26,926 [salt.fileclient  ][INFO    ][22652] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-11-21 09:10:26,939 [salt.fileclient  ][INFO    ][22652] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-11-21 09:10:26,951 [salt.fileclient  ][INFO    ][22652] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-11-21 09:10:26,957 [salt.loaded.int.module.cmdmod][INFO    ][22652] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-11-21 09:10:26,978 [salt.fileclient  ][INFO    ][22652] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-11-21 09:10:26,992 [salt.loaded.int.module.cmdmod][INFO    ][22652] Executing command 'salt-minion --version' in directory '/root'
2017-11-21 09:10:27,234 [salt.fileclient  ][INFO    ][22652] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-11-21 09:10:27,253 [salt.fileclient  ][INFO    ][22652] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-11-21 09:10:27,265 [salt.fileclient  ][INFO    ][22652] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-11-21 09:10:27,277 [salt.fileclient  ][INFO    ][22652] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-11-21 09:10:27,330 [salt.fileclient  ][INFO    ][22652] Fetching file from saltenv 'base', ** done ** 'reclass/meta/meta.yml'
2017-11-21 09:10:27,344 [salt.fileclient  ][INFO    ][22652] Fetching file from saltenv 'base', ** done ** 'reclass/map.jinja'
2017-11-21 09:10:27,390 [salt.fileclient  ][INFO    ][22652] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-11-21 09:10:27,447 [salt.fileclient  ][INFO    ][22652] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-11-21 09:10:27,524 [salt.fileclient  ][INFO    ][22652] Fetching file from saltenv 'base', ** done ** 'salt/minion/cert.sls'
2017-11-21 09:10:27,580 [salt.fileclient  ][INFO    ][22652] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-11-21 09:10:27,960 [salt.state       ][INFO    ][22652] Running state [salt-minion] at time 09:10:27.960177
2017-11-21 09:10:27,960 [salt.state       ][INFO    ][22652] Executing state pkg.installed for salt-minion
2017-11-21 09:10:27,961 [salt.loaded.int.module.cmdmod][INFO    ][22652] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-21 09:10:28,218 [salt.state       ][INFO    ][22652] Package salt-minion is already installed
2017-11-21 09:10:28,218 [salt.state       ][INFO    ][22652] Completed state [salt-minion] at time 09:10:28.218428 duration_in_ms=258.25
2017-11-21 09:10:28,219 [salt.state       ][INFO    ][22652] Running state [salt_minion_dependency_packages] at time 09:10:28.218637
2017-11-21 09:10:28,219 [salt.state       ][INFO    ][22652] Executing state pkg.installed for salt_minion_dependency_packages
2017-11-21 09:10:28,221 [salt.state       ][INFO    ][22652] All specified packages are already installed
2017-11-21 09:10:28,222 [salt.state       ][INFO    ][22652] Completed state [salt_minion_dependency_packages] at time 09:10:28.221541 duration_in_ms=2.905
2017-11-21 09:10:28,223 [salt.state       ][INFO    ][22652] Running state [/etc/salt/minion.d/minion.conf] at time 09:10:28.223017
2017-11-21 09:10:28,223 [salt.state       ][INFO    ][22652] Executing state file.managed for /etc/salt/minion.d/minion.conf
2017-11-21 09:10:28,267 [salt.fileclient  ][INFO    ][22652] Fetching file from saltenv 'base', ** done ** 'salt/files/minion.conf'
2017-11-21 09:10:28,311 [salt.fileclient  ][INFO    ][22652] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-11-21 09:10:28,366 [salt.fileclient  ][INFO    ][22652] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-11-21 09:10:28,432 [salt.state       ][INFO    ][22652] File /etc/salt/minion.d/minion.conf is in the correct state
2017-11-21 09:10:28,432 [salt.state       ][INFO    ][22652] Completed state [/etc/salt/minion.d/minion.conf] at time 09:10:28.431964 duration_in_ms=208.947
2017-11-21 09:10:28,432 [salt.state       ][INFO    ][22652] Running state [/etc/salt/minion.d/_virt.conf] at time 09:10:28.432252
2017-11-21 09:10:28,432 [salt.state       ][INFO    ][22652] Executing state file.managed for /etc/salt/minion.d/_virt.conf
2017-11-21 09:10:28,493 [salt.state       ][INFO    ][22652] File /etc/salt/minion.d/_virt.conf is in the correct state
2017-11-21 09:10:28,494 [salt.state       ][INFO    ][22652] Completed state [/etc/salt/minion.d/_virt.conf] at time 09:10:28.493607 duration_in_ms=61.353
2017-11-21 09:10:28,495 [salt.state       ][INFO    ][22652] Running state [salt-minion] at time 09:10:28.495287
2017-11-21 09:10:28,496 [salt.state       ][INFO    ][22652] Executing state service.running for salt-minion
2017-11-21 09:10:28,496 [salt.loaded.int.module.cmdmod][INFO    ][22652] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2017-11-21 09:10:28,512 [salt.loaded.int.module.cmdmod][INFO    ][22652] Executing command ['systemctl', 'is-active', 'salt-minion.service'] in directory '/root'
2017-11-21 09:10:28,519 [salt.loaded.int.module.cmdmod][INFO    ][22652] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2017-11-21 09:10:28,527 [salt.state       ][INFO    ][22652] The service salt-minion is already running
2017-11-21 09:10:28,527 [salt.state       ][INFO    ][22652] Completed state [salt-minion] at time 09:10:28.527436 duration_in_ms=32.149
2017-11-21 09:10:28,529 [salt.state       ][INFO    ][22652] Running state [/etc/salt/grains.d] at time 09:10:28.528867
2017-11-21 09:10:28,529 [salt.state       ][INFO    ][22652] Executing state file.directory for /etc/salt/grains.d
2017-11-21 09:10:28,530 [salt.state       ][INFO    ][22652] Directory /etc/salt/grains.d is in the correct state
2017-11-21 09:10:28,530 [salt.state       ][INFO    ][22652] Completed state [/etc/salt/grains.d] at time 09:10:28.529937 duration_in_ms=1.069
2017-11-21 09:10:28,530 [salt.state       ][INFO    ][22652] Running state [/etc/salt/grains] at time 09:10:28.530414
2017-11-21 09:10:28,531 [salt.state       ][INFO    ][22652] Executing state file.managed for /etc/salt/grains
2017-11-21 09:10:28,531 [salt.state       ][INFO    ][22652] File /etc/salt/grains exists with proper permissions. No changes made.
2017-11-21 09:10:28,531 [salt.state       ][INFO    ][22652] Completed state [/etc/salt/grains] at time 09:10:28.531175 duration_in_ms=0.761
2017-11-21 09:10:28,532 [salt.state       ][INFO    ][22652] Running state [/etc/salt/grains.d/placeholder] at time 09:10:28.531502
2017-11-21 09:10:28,532 [salt.state       ][INFO    ][22652] Executing state file.managed for /etc/salt/grains.d/placeholder
2017-11-21 09:10:28,532 [salt.state       ][INFO    ][22652] File /etc/salt/grains.d/placeholder exists with proper permissions. No changes made.
2017-11-21 09:10:28,532 [salt.state       ][INFO    ][22652] Completed state [/etc/salt/grains.d/placeholder] at time 09:10:28.532224 duration_in_ms=0.722
2017-11-21 09:10:28,533 [salt.state       ][INFO    ][22652] Running state [/etc/salt/grains.d/sphinx] at time 09:10:28.532529
2017-11-21 09:10:28,533 [salt.state       ][INFO    ][22652] Executing state file.managed for /etc/salt/grains.d/sphinx
2017-11-21 09:10:28,601 [salt.state       ][INFO    ][22652] File changed:
--- 
+++ 
@@ -49,7 +49,6 @@
               - 10.167.4.142
               - 127.0.0.1
               - 192.168.11.252
-              - 192.168.122.1
         system:
           name: System
           param:

2017-11-21 09:10:28,602 [salt.state       ][INFO    ][22652] Completed state [/etc/salt/grains.d/sphinx] at time 09:10:28.601538 duration_in_ms=69.009
2017-11-21 09:10:28,602 [salt.state       ][INFO    ][22652] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 09:10:28.602318
2017-11-21 09:10:28,603 [salt.state       ][INFO    ][22652] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-11-21 09:10:28,603 [salt.state       ][INFO    ][22652] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-11-21 09:10:28,603 [salt.state       ][INFO    ][22652] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 09:10:28.603075 duration_in_ms=0.757
2017-11-21 09:10:28,603 [salt.state       ][INFO    ][22652] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 09:10:28.603288
2017-11-21 09:10:28,604 [salt.state       ][INFO    ][22652] Executing state cmd.mod_watch for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-11-21 09:10:28,604 [salt.loaded.int.module.cmdmod][INFO    ][22652] Executing command 'python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"' in directory '/root'
2017-11-21 09:10:28,686 [salt.state       ][INFO    ][22652] {'pid': 22700, 'retcode': 0, 'stderr': '', 'stdout': ''}
2017-11-21 09:10:28,687 [salt.state       ][INFO    ][22652] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 09:10:28.686485 duration_in_ms=83.197
2017-11-21 09:10:28,687 [salt.state       ][INFO    ][22652] Running state [/etc/salt/grains.d/dns_records] at time 09:10:28.686981
2017-11-21 09:10:28,687 [salt.state       ][INFO    ][22652] Executing state file.managed for /etc/salt/grains.d/dns_records
2017-11-21 09:10:28,708 [salt.state       ][INFO    ][22652] File /etc/salt/grains.d/dns_records is in the correct state
2017-11-21 09:10:28,708 [salt.state       ][INFO    ][22652] Completed state [/etc/salt/grains.d/dns_records] at time 09:10:28.708339 duration_in_ms=21.359
2017-11-21 09:10:28,709 [salt.state       ][INFO    ][22652] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 09:10:28.709018
2017-11-21 09:10:28,709 [salt.state       ][INFO    ][22652] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"
2017-11-21 09:10:28,709 [salt.state       ][INFO    ][22652] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"
2017-11-21 09:10:28,710 [salt.state       ][INFO    ][22652] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 09:10:28.709536 duration_in_ms=0.518
2017-11-21 09:10:28,710 [salt.state       ][INFO    ][22652] Running state [/etc/salt/grains.d/salt] at time 09:10:28.709814
2017-11-21 09:10:28,710 [salt.state       ][INFO    ][22652] Executing state file.managed for /etc/salt/grains.d/salt
2017-11-21 09:10:28,743 [salt.state       ][INFO    ][22652] File /etc/salt/grains.d/salt is in the correct state
2017-11-21 09:10:28,744 [salt.state       ][INFO    ][22652] Completed state [/etc/salt/grains.d/salt] at time 09:10:28.743526 duration_in_ms=33.712
2017-11-21 09:10:28,744 [salt.state       ][INFO    ][22652] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 09:10:28.744129
2017-11-21 09:10:28,744 [salt.state       ][INFO    ][22652] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2017-11-21 09:10:28,745 [salt.state       ][INFO    ][22652] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2017-11-21 09:10:28,745 [salt.state       ][INFO    ][22652] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 09:10:28.744801 duration_in_ms=0.671
2017-11-21 09:10:28,746 [salt.state       ][INFO    ][22652] Running state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 09:10:28.746009
2017-11-21 09:10:28,746 [salt.state       ][INFO    ][22652] Executing state cmd.wait for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-11-21 09:10:28,747 [salt.state       ][INFO    ][22652] No changes made for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-11-21 09:10:28,747 [salt.state       ][INFO    ][22652] Completed state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 09:10:28.746661 duration_in_ms=0.652
2017-11-21 09:10:28,747 [salt.state       ][INFO    ][22652] Running state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 09:10:28.746847
2017-11-21 09:10:28,747 [salt.state       ][INFO    ][22652] Executing state cmd.mod_watch for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-11-21 09:10:28,748 [salt.loaded.int.module.cmdmod][INFO    ][22652] Executing command 'cat /etc/salt/grains.d/* > /etc/salt/grains' in directory '/root'
2017-11-21 09:10:28,757 [salt.state       ][INFO    ][22652] {'pid': 22702, 'retcode': 0, 'stderr': '', 'stdout': ''}
2017-11-21 09:10:28,757 [salt.state       ][INFO    ][22652] Completed state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 09:10:28.756765 duration_in_ms=9.918
2017-11-21 09:10:28,757 [salt.state       ][INFO    ][22652] Running state [mine.update] at time 09:10:28.757374
2017-11-21 09:10:28,758 [salt.state       ][INFO    ][22652] Executing state module.wait for mine.update
2017-11-21 09:10:28,758 [salt.state       ][INFO    ][22652] No changes made for mine.update
2017-11-21 09:10:28,758 [salt.state       ][INFO    ][22652] Completed state [mine.update] at time 09:10:28.757991 duration_in_ms=0.617
2017-11-21 09:10:28,758 [salt.state       ][INFO    ][22652] Running state [mine.update] at time 09:10:28.758141
2017-11-21 09:10:28,758 [salt.state       ][INFO    ][22652] Executing state module.mod_watch for mine.update
2017-11-21 09:10:29,277 [salt.state       ][INFO    ][22652] {'ret': True}
2017-11-21 09:10:29,277 [salt.state       ][INFO    ][22652] Completed state [mine.update] at time 09:10:29.277167 duration_in_ms=519.026
2017-11-21 09:10:29,277 [salt.state       ][INFO    ][22652] Running state [ca-certificates] at time 09:10:29.277462
2017-11-21 09:10:29,278 [salt.state       ][INFO    ][22652] Executing state pkg.installed for ca-certificates
2017-11-21 09:10:29,281 [salt.state       ][INFO    ][22652] Package ca-certificates is already installed
2017-11-21 09:10:29,281 [salt.state       ][INFO    ][22652] Completed state [ca-certificates] at time 09:10:29.281178 duration_in_ms=3.716
2017-11-21 09:10:29,282 [salt.state       ][INFO    ][22652] Running state [update-ca-certificates] at time 09:10:29.281736
2017-11-21 09:10:29,282 [salt.state       ][INFO    ][22652] Executing state cmd.wait for update-ca-certificates
2017-11-21 09:10:29,282 [salt.state       ][INFO    ][22652] No changes made for update-ca-certificates
2017-11-21 09:10:29,282 [salt.state       ][INFO    ][22652] Completed state [update-ca-certificates] at time 09:10:29.282359 duration_in_ms=0.622
2017-11-21 09:10:29,283 [salt.state       ][INFO    ][22652] Running state [libvirt-dev] at time 09:10:29.282547
2017-11-21 09:10:29,283 [salt.state       ][INFO    ][22652] Executing state pkg.installed for libvirt-dev
2017-11-21 09:10:29,286 [salt.state       ][INFO    ][22652] Package libvirt-dev is already installed
2017-11-21 09:10:29,286 [salt.state       ][INFO    ][22652] Completed state [libvirt-dev] at time 09:10:29.285672 duration_in_ms=3.125
2017-11-21 09:10:29,286 [salt.state       ][INFO    ][22652] Running state [pkg-config] at time 09:10:29.285861
2017-11-21 09:10:29,286 [salt.state       ][INFO    ][22652] Executing state pkg.installed for pkg-config
2017-11-21 09:10:29,289 [salt.state       ][INFO    ][22652] Package pkg-config is already installed
2017-11-21 09:10:29,289 [salt.state       ][INFO    ][22652] Completed state [pkg-config] at time 09:10:29.288972 duration_in_ms=3.111
2017-11-21 09:10:29,289 [salt.state       ][INFO    ][22652] Running state [virtng.init] at time 09:10:29.289166
2017-11-21 09:10:29,289 [salt.state       ][INFO    ][22652] Executing state module.run for virtng.init
2017-11-21 09:10:29,365 [salt.loaded.int.module.cmdmod][INFO    ][22652] Executing command ['git', '--version'] in directory '/root'
2017-11-21 09:10:29,476 [salt.loaded.int.module.cmdmod][INFO    ][22652] Executing command 'virsh list --all --name| grep -E "^mdb02.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-11-21 09:10:29,495 [salt.state       ][INFO    ][22652] unless execution succeeded
2017-11-21 09:10:29,496 [salt.state       ][INFO    ][22652] Completed state [virtng.init] at time 09:10:29.495583 duration_in_ms=206.417
2017-11-21 09:10:29,496 [salt.state       ][INFO    ][22652] Running state [virt.set_autostart] at time 09:10:29.495821
2017-11-21 09:10:29,496 [salt.state       ][INFO    ][22652] Executing state module.run for virt.set_autostart
2017-11-21 09:10:29,498 [salt.loaded.int.module.cmdmod][INFO    ][22652] Executing command 'virsh list --autostart --name| grep -E "^mdb02.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-11-21 09:10:29,515 [salt.state       ][INFO    ][22652] unless execution succeeded
2017-11-21 09:10:29,516 [salt.state       ][INFO    ][22652] Completed state [virt.set_autostart] at time 09:10:29.515683 duration_in_ms=19.861
2017-11-21 09:10:29,516 [salt.state       ][INFO    ][22652] Running state [virtng.init] at time 09:10:29.515930
2017-11-21 09:10:29,516 [salt.state       ][INFO    ][22652] Executing state module.run for virtng.init
2017-11-21 09:10:29,518 [salt.loaded.int.module.cmdmod][INFO    ][22652] Executing command 'virsh list --all --name| grep -E "^dbs02.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-11-21 09:10:29,534 [salt.state       ][INFO    ][22652] unless execution succeeded
2017-11-21 09:10:29,534 [salt.state       ][INFO    ][22652] Completed state [virtng.init] at time 09:10:29.533906 duration_in_ms=17.975
2017-11-21 09:10:29,534 [salt.state       ][INFO    ][22652] Running state [virt.set_autostart] at time 09:10:29.534143
2017-11-21 09:10:29,534 [salt.state       ][INFO    ][22652] Executing state module.run for virt.set_autostart
2017-11-21 09:10:29,536 [salt.loaded.int.module.cmdmod][INFO    ][22652] Executing command 'virsh list --autostart --name| grep -E "^dbs02.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-11-21 09:10:29,549 [salt.state       ][INFO    ][22652] unless execution succeeded
2017-11-21 09:10:29,574 [salt.state       ][INFO    ][22652] Completed state [virt.set_autostart] at time 09:10:29.573867 duration_in_ms=39.723
2017-11-21 09:10:29,574 [salt.state       ][INFO    ][22652] Running state [virtng.init] at time 09:10:29.574170
2017-11-21 09:10:29,574 [salt.state       ][INFO    ][22652] Executing state module.run for virtng.init
2017-11-21 09:10:29,576 [salt.loaded.int.module.cmdmod][INFO    ][22652] Executing command 'virsh list --all --name| grep -E "^ctl02.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-11-21 09:10:29,590 [salt.state       ][INFO    ][22652] unless execution succeeded
2017-11-21 09:10:29,590 [salt.state       ][INFO    ][22652] Completed state [virtng.init] at time 09:10:29.590079 duration_in_ms=15.909
2017-11-21 09:10:29,590 [salt.state       ][INFO    ][22652] Running state [virt.set_autostart] at time 09:10:29.590329
2017-11-21 09:10:29,591 [salt.state       ][INFO    ][22652] Executing state module.run for virt.set_autostart
2017-11-21 09:10:29,593 [salt.loaded.int.module.cmdmod][INFO    ][22652] Executing command 'virsh list --autostart --name| grep -E "^ctl02.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-11-21 09:10:29,605 [salt.state       ][INFO    ][22652] unless execution succeeded
2017-11-21 09:10:29,606 [salt.state       ][INFO    ][22652] Completed state [virt.set_autostart] at time 09:10:29.605542 duration_in_ms=15.213
2017-11-21 09:10:29,606 [salt.state       ][INFO    ][22652] Running state [virtng.init] at time 09:10:29.605812
2017-11-21 09:10:29,606 [salt.state       ][INFO    ][22652] Executing state module.run for virtng.init
2017-11-21 09:10:29,608 [salt.loaded.int.module.cmdmod][INFO    ][22652] Executing command 'virsh list --all --name| grep -E "^msg02.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-11-21 09:10:29,620 [salt.state       ][INFO    ][22652] unless execution succeeded
2017-11-21 09:10:29,621 [salt.state       ][INFO    ][22652] Completed state [virtng.init] at time 09:10:29.620533 duration_in_ms=14.72
2017-11-21 09:10:29,621 [salt.state       ][INFO    ][22652] Running state [virt.set_autostart] at time 09:10:29.620796
2017-11-21 09:10:29,621 [salt.state       ][INFO    ][22652] Executing state module.run for virt.set_autostart
2017-11-21 09:10:29,623 [salt.loaded.int.module.cmdmod][INFO    ][22652] Executing command 'virsh list --autostart --name| grep -E "^msg02.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-11-21 09:10:29,635 [salt.state       ][INFO    ][22652] unless execution succeeded
2017-11-21 09:10:29,636 [salt.state       ][INFO    ][22652] Completed state [virt.set_autostart] at time 09:10:29.635627 duration_in_ms=14.83
2017-11-21 09:10:29,638 [salt.minion      ][INFO    ][22652] Returning information for job: 20171121091025159109
2017-11-21 09:10:56,236 [salt.minion      ][INFO    ][22402] User sudo_ubuntu Executing command state.sls with jid 20171121091056239605
2017-11-21 09:10:56,249 [salt.minion      ][INFO    ][22757] Starting a new job with PID 22757
2017-11-21 09:10:57,782 [salt.state       ][INFO    ][22757] Loading fresh modules for state activity
2017-11-21 09:10:57,808 [salt.fileclient  ][INFO    ][22757] Fetching file from saltenv 'base', ** done ** 'salt/control/init.sls'
2017-11-21 09:10:57,828 [salt.fileclient  ][INFO    ][22757] Fetching file from saltenv 'base', ** done ** 'salt/control/virt.sls'
2017-11-21 09:10:57,895 [salt.fileclient  ][INFO    ][22757] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-11-21 09:10:57,957 [salt.fileclient  ][INFO    ][22757] Fetching file from saltenv 'base', ** done ** 'salt/minion/init.sls'
2017-11-21 09:10:57,972 [salt.fileclient  ][INFO    ][22757] Fetching file from saltenv 'base', ** done ** 'salt/minion/service.sls'
2017-11-21 09:10:57,998 [salt.fileclient  ][INFO    ][22757] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-11-21 09:10:58,054 [salt.fileclient  ][INFO    ][22757] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-11-21 09:10:58,072 [salt.fileclient  ][INFO    ][22757] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-11-21 09:10:58,221 [salt.fileclient  ][INFO    ][22757] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-11-21 09:10:58,248 [salt.fileclient  ][INFO    ][22757] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-11-21 09:10:58,339 [salt.fileclient  ][INFO    ][22757] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-11-21 09:10:58,355 [salt.fileclient  ][INFO    ][22757] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-11-21 09:10:58,362 [salt.loaded.int.module.cmdmod][INFO    ][22757] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-11-21 09:10:58,384 [salt.fileclient  ][INFO    ][22757] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-11-21 09:10:58,400 [py.warnings      ][WARNING ][22757] /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-11-21 09:10:58,472 [salt.loaded.int.module.cmdmod][INFO    ][22757] Executing command 'salt-minion --version' in directory '/root'
2017-11-21 09:10:58,709 [salt.fileclient  ][INFO    ][22757] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-11-21 09:10:58,723 [salt.fileclient  ][INFO    ][22757] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-11-21 09:10:58,733 [salt.fileclient  ][INFO    ][22757] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-11-21 09:10:58,742 [salt.fileclient  ][INFO    ][22757] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-11-21 09:10:58,781 [salt.fileclient  ][INFO    ][22757] Fetching file from saltenv 'base', ** done ** 'reclass/meta/meta.yml'
2017-11-21 09:10:58,794 [salt.fileclient  ][INFO    ][22757] Fetching file from saltenv 'base', ** done ** 'reclass/map.jinja'
2017-11-21 09:10:58,816 [salt.fileclient  ][INFO    ][22757] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-11-21 09:10:58,852 [salt.fileclient  ][INFO    ][22757] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-11-21 09:10:58,908 [salt.fileclient  ][INFO    ][22757] Fetching file from saltenv 'base', ** done ** 'salt/minion/grains.sls'
2017-11-21 09:10:58,927 [salt.fileclient  ][INFO    ][22757] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-11-21 09:10:58,990 [salt.fileclient  ][INFO    ][22757] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-11-21 09:10:59,009 [salt.fileclient  ][INFO    ][22757] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-11-21 09:10:59,142 [salt.fileclient  ][INFO    ][22757] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-11-21 09:10:59,161 [salt.fileclient  ][INFO    ][22757] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-11-21 09:10:59,176 [salt.fileclient  ][INFO    ][22757] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-11-21 09:10:59,190 [salt.fileclient  ][INFO    ][22757] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-11-21 09:10:59,196 [salt.loaded.int.module.cmdmod][INFO    ][22757] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-11-21 09:10:59,220 [salt.fileclient  ][INFO    ][22757] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-11-21 09:10:59,242 [salt.loaded.int.module.cmdmod][INFO    ][22757] Executing command 'salt-minion --version' in directory '/root'
2017-11-21 09:10:59,484 [salt.fileclient  ][INFO    ][22757] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-11-21 09:10:59,504 [salt.fileclient  ][INFO    ][22757] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-11-21 09:10:59,516 [salt.fileclient  ][INFO    ][22757] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-11-21 09:10:59,527 [salt.fileclient  ][INFO    ][22757] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-11-21 09:10:59,559 [salt.fileclient  ][INFO    ][22757] Fetching file from saltenv 'base', ** done ** 'reclass/meta/meta.yml'
2017-11-21 09:10:59,572 [salt.fileclient  ][INFO    ][22757] Fetching file from saltenv 'base', ** done ** 'reclass/map.jinja'
2017-11-21 09:10:59,596 [salt.fileclient  ][INFO    ][22757] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-11-21 09:10:59,630 [salt.fileclient  ][INFO    ][22757] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-11-21 09:10:59,690 [salt.fileclient  ][INFO    ][22757] Fetching file from saltenv 'base', ** done ** 'salt/minion/cert.sls'
2017-11-21 09:10:59,823 [salt.fileclient  ][INFO    ][22757] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-11-21 09:11:00,222 [salt.state       ][INFO    ][22757] Running state [salt-minion] at time 09:11:00.221654
2017-11-21 09:11:00,222 [salt.state       ][INFO    ][22757] Executing state pkg.installed for salt-minion
2017-11-21 09:11:00,223 [salt.loaded.int.module.cmdmod][INFO    ][22757] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-21 09:11:00,490 [salt.state       ][INFO    ][22757] Package salt-minion is already installed
2017-11-21 09:11:00,527 [salt.state       ][INFO    ][22757] Completed state [salt-minion] at time 09:11:00.526600 duration_in_ms=304.945
2017-11-21 09:11:00,527 [salt.state       ][INFO    ][22757] Running state [salt_minion_dependency_packages] at time 09:11:00.526889
2017-11-21 09:11:00,527 [salt.state       ][INFO    ][22757] Executing state pkg.installed for salt_minion_dependency_packages
2017-11-21 09:11:00,530 [salt.state       ][INFO    ][22757] All specified packages are already installed
2017-11-21 09:11:00,530 [salt.state       ][INFO    ][22757] Completed state [salt_minion_dependency_packages] at time 09:11:00.529884 duration_in_ms=2.995
2017-11-21 09:11:00,531 [salt.state       ][INFO    ][22757] Running state [/etc/salt/minion.d/minion.conf] at time 09:11:00.531411
2017-11-21 09:11:00,532 [salt.state       ][INFO    ][22757] Executing state file.managed for /etc/salt/minion.d/minion.conf
2017-11-21 09:11:00,550 [salt.fileclient  ][INFO    ][22757] Fetching file from saltenv 'base', ** done ** 'salt/files/minion.conf'
2017-11-21 09:11:00,645 [salt.fileclient  ][INFO    ][22757] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-11-21 09:11:00,688 [salt.fileclient  ][INFO    ][22757] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-11-21 09:11:00,721 [salt.state       ][INFO    ][22757] File /etc/salt/minion.d/minion.conf is in the correct state
2017-11-21 09:11:00,721 [salt.state       ][INFO    ][22757] Completed state [/etc/salt/minion.d/minion.conf] at time 09:11:00.721125 duration_in_ms=189.716
2017-11-21 09:11:00,721 [salt.state       ][INFO    ][22757] Running state [/etc/salt/minion.d/_virt.conf] at time 09:11:00.721416
2017-11-21 09:11:00,722 [salt.state       ][INFO    ][22757] Executing state file.managed for /etc/salt/minion.d/_virt.conf
2017-11-21 09:11:00,904 [salt.state       ][INFO    ][22757] File /etc/salt/minion.d/_virt.conf is in the correct state
2017-11-21 09:11:00,905 [salt.state       ][INFO    ][22757] Completed state [/etc/salt/minion.d/_virt.conf] at time 09:11:00.904547 duration_in_ms=183.129
2017-11-21 09:11:00,906 [salt.state       ][INFO    ][22757] Running state [salt-minion] at time 09:11:00.906184
2017-11-21 09:11:00,906 [salt.state       ][INFO    ][22757] Executing state service.running for salt-minion
2017-11-21 09:11:00,907 [salt.loaded.int.module.cmdmod][INFO    ][22757] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2017-11-21 09:11:00,922 [salt.loaded.int.module.cmdmod][INFO    ][22757] Executing command ['systemctl', 'is-active', 'salt-minion.service'] in directory '/root'
2017-11-21 09:11:00,928 [salt.loaded.int.module.cmdmod][INFO    ][22757] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2017-11-21 09:11:00,934 [salt.state       ][INFO    ][22757] The service salt-minion is already running
2017-11-21 09:11:00,934 [salt.state       ][INFO    ][22757] Completed state [salt-minion] at time 09:11:00.934341 duration_in_ms=28.156
2017-11-21 09:11:00,936 [salt.state       ][INFO    ][22757] Running state [/etc/salt/grains.d] at time 09:11:00.935689
2017-11-21 09:11:00,936 [salt.state       ][INFO    ][22757] Executing state file.directory for /etc/salt/grains.d
2017-11-21 09:11:00,937 [salt.state       ][INFO    ][22757] Directory /etc/salt/grains.d is in the correct state
2017-11-21 09:11:00,937 [salt.state       ][INFO    ][22757] Completed state [/etc/salt/grains.d] at time 09:11:00.936645 duration_in_ms=0.956
2017-11-21 09:11:00,937 [salt.state       ][INFO    ][22757] Running state [/etc/salt/grains] at time 09:11:00.937097
2017-11-21 09:11:00,937 [salt.state       ][INFO    ][22757] Executing state file.managed for /etc/salt/grains
2017-11-21 09:11:00,938 [salt.state       ][INFO    ][22757] File /etc/salt/grains exists with proper permissions. No changes made.
2017-11-21 09:11:00,938 [salt.state       ][INFO    ][22757] Completed state [/etc/salt/grains] at time 09:11:00.937809 duration_in_ms=0.712
2017-11-21 09:11:00,938 [salt.state       ][INFO    ][22757] Running state [/etc/salt/grains.d/placeholder] at time 09:11:00.938106
2017-11-21 09:11:00,938 [salt.state       ][INFO    ][22757] Executing state file.managed for /etc/salt/grains.d/placeholder
2017-11-21 09:11:00,939 [salt.state       ][INFO    ][22757] File /etc/salt/grains.d/placeholder exists with proper permissions. No changes made.
2017-11-21 09:11:00,939 [salt.state       ][INFO    ][22757] Completed state [/etc/salt/grains.d/placeholder] at time 09:11:00.938804 duration_in_ms=0.696
2017-11-21 09:11:00,939 [salt.state       ][INFO    ][22757] Running state [/etc/salt/grains.d/sphinx] at time 09:11:00.939100
2017-11-21 09:11:00,939 [salt.state       ][INFO    ][22757] Executing state file.managed for /etc/salt/grains.d/sphinx
2017-11-21 09:11:01,048 [salt.state       ][INFO    ][22757] File /etc/salt/grains.d/sphinx is in the correct state
2017-11-21 09:11:01,048 [salt.state       ][INFO    ][22757] Completed state [/etc/salt/grains.d/sphinx] at time 09:11:01.047681 duration_in_ms=108.582
2017-11-21 09:11:01,048 [salt.state       ][INFO    ][22757] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 09:11:01.048317
2017-11-21 09:11:01,049 [salt.state       ][INFO    ][22757] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-11-21 09:11:01,049 [salt.state       ][INFO    ][22757] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-11-21 09:11:01,049 [salt.state       ][INFO    ][22757] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 09:11:01.048987 duration_in_ms=0.67
2017-11-21 09:11:01,049 [salt.state       ][INFO    ][22757] Running state [/etc/salt/grains.d/dns_records] at time 09:11:01.049326
2017-11-21 09:11:01,050 [salt.state       ][INFO    ][22757] Executing state file.managed for /etc/salt/grains.d/dns_records
2017-11-21 09:11:01,180 [salt.state       ][INFO    ][22757] File /etc/salt/grains.d/dns_records is in the correct state
2017-11-21 09:11:01,180 [salt.state       ][INFO    ][22757] Completed state [/etc/salt/grains.d/dns_records] at time 09:11:01.179751 duration_in_ms=130.425
2017-11-21 09:11:01,180 [salt.state       ][INFO    ][22757] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 09:11:01.180417
2017-11-21 09:11:01,181 [salt.state       ][INFO    ][22757] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"
2017-11-21 09:11:01,181 [salt.state       ][INFO    ][22757] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"
2017-11-21 09:11:01,181 [salt.state       ][INFO    ][22757] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 09:11:01.181048 duration_in_ms=0.631
2017-11-21 09:11:01,181 [salt.state       ][INFO    ][22757] Running state [/etc/salt/grains.d/salt] at time 09:11:01.181357
2017-11-21 09:11:01,182 [salt.state       ][INFO    ][22757] Executing state file.managed for /etc/salt/grains.d/salt
2017-11-21 09:11:01,273 [salt.state       ][INFO    ][22757] File /etc/salt/grains.d/salt is in the correct state
2017-11-21 09:11:01,273 [salt.state       ][INFO    ][22757] Completed state [/etc/salt/grains.d/salt] at time 09:11:01.273267 duration_in_ms=91.91
2017-11-21 09:11:01,274 [salt.state       ][INFO    ][22757] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 09:11:01.273904
2017-11-21 09:11:01,274 [salt.state       ][INFO    ][22757] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2017-11-21 09:11:01,274 [salt.state       ][INFO    ][22757] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2017-11-21 09:11:01,275 [salt.state       ][INFO    ][22757] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 09:11:01.274625 duration_in_ms=0.721
2017-11-21 09:11:01,276 [salt.state       ][INFO    ][22757] Running state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 09:11:01.275915
2017-11-21 09:11:01,276 [salt.state       ][INFO    ][22757] Executing state cmd.wait for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-11-21 09:11:01,276 [salt.state       ][INFO    ][22757] No changes made for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-11-21 09:11:01,277 [salt.state       ][INFO    ][22757] Completed state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 09:11:01.276636 duration_in_ms=0.722
2017-11-21 09:11:01,277 [salt.state       ][INFO    ][22757] Running state [mine.update] at time 09:11:01.277125
2017-11-21 09:11:01,277 [salt.state       ][INFO    ][22757] Executing state module.wait for mine.update
2017-11-21 09:11:01,278 [salt.state       ][INFO    ][22757] No changes made for mine.update
2017-11-21 09:11:01,278 [salt.state       ][INFO    ][22757] Completed state [mine.update] at time 09:11:01.277769 duration_in_ms=0.644
2017-11-21 09:11:01,278 [salt.state       ][INFO    ][22757] Running state [ca-certificates] at time 09:11:01.277982
2017-11-21 09:11:01,278 [salt.state       ][INFO    ][22757] Executing state pkg.installed for ca-certificates
2017-11-21 09:11:01,281 [salt.state       ][INFO    ][22757] Package ca-certificates is already installed
2017-11-21 09:11:01,282 [salt.state       ][INFO    ][22757] Completed state [ca-certificates] at time 09:11:01.281564 duration_in_ms=3.582
2017-11-21 09:11:01,282 [salt.state       ][INFO    ][22757] Running state [update-ca-certificates] at time 09:11:01.282090
2017-11-21 09:11:01,282 [salt.state       ][INFO    ][22757] Executing state cmd.wait for update-ca-certificates
2017-11-21 09:11:01,283 [salt.state       ][INFO    ][22757] No changes made for update-ca-certificates
2017-11-21 09:11:01,283 [salt.state       ][INFO    ][22757] Completed state [update-ca-certificates] at time 09:11:01.282772 duration_in_ms=0.682
2017-11-21 09:11:01,283 [salt.state       ][INFO    ][22757] Running state [libvirt-dev] at time 09:11:01.282988
2017-11-21 09:11:01,283 [salt.state       ][INFO    ][22757] Executing state pkg.installed for libvirt-dev
2017-11-21 09:11:01,286 [salt.state       ][INFO    ][22757] Package libvirt-dev is already installed
2017-11-21 09:11:01,286 [salt.state       ][INFO    ][22757] Completed state [libvirt-dev] at time 09:11:01.286171 duration_in_ms=3.184
2017-11-21 09:11:01,286 [salt.state       ][INFO    ][22757] Running state [pkg-config] at time 09:11:01.286381
2017-11-21 09:11:01,287 [salt.state       ][INFO    ][22757] Executing state pkg.installed for pkg-config
2017-11-21 09:11:01,289 [salt.state       ][INFO    ][22757] Package pkg-config is already installed
2017-11-21 09:11:01,290 [salt.state       ][INFO    ][22757] Completed state [pkg-config] at time 09:11:01.289557 duration_in_ms=3.176
2017-11-21 09:11:01,290 [salt.state       ][INFO    ][22757] Running state [virtng.init] at time 09:11:01.289778
2017-11-21 09:11:01,290 [salt.state       ][INFO    ][22757] Executing state module.run for virtng.init
2017-11-21 09:11:01,332 [salt.loaded.int.module.cmdmod][INFO    ][22757] Executing command ['git', '--version'] in directory '/root'
2017-11-21 09:11:01,555 [salt.loaded.int.module.cmdmod][INFO    ][22757] Executing command 'virsh list --all --name| grep -E "^mdb02.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-11-21 09:11:01,573 [salt.state       ][INFO    ][22757] unless execution succeeded
2017-11-21 09:11:01,573 [salt.state       ][INFO    ][22757] Completed state [virtng.init] at time 09:11:01.572751 duration_in_ms=282.972
2017-11-21 09:11:01,573 [salt.state       ][INFO    ][22757] Running state [virt.set_autostart] at time 09:11:01.573024
2017-11-21 09:11:01,573 [salt.state       ][INFO    ][22757] Executing state module.run for virt.set_autostart
2017-11-21 09:11:01,575 [salt.loaded.int.module.cmdmod][INFO    ][22757] Executing command 'virsh list --autostart --name| grep -E "^mdb02.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-11-21 09:11:01,591 [salt.state       ][INFO    ][22757] unless execution succeeded
2017-11-21 09:11:01,591 [salt.state       ][INFO    ][22757] Completed state [virt.set_autostart] at time 09:11:01.590841 duration_in_ms=17.817
2017-11-21 09:11:01,591 [salt.state       ][INFO    ][22757] Running state [virtng.init] at time 09:11:01.591097
2017-11-21 09:11:01,591 [salt.state       ][INFO    ][22757] Executing state module.run for virtng.init
2017-11-21 09:11:01,593 [salt.loaded.int.module.cmdmod][INFO    ][22757] Executing command 'virsh list --all --name| grep -E "^dbs02.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-11-21 09:11:01,608 [salt.state       ][INFO    ][22757] unless execution succeeded
2017-11-21 09:11:01,608 [salt.state       ][INFO    ][22757] Completed state [virtng.init] at time 09:11:01.608110 duration_in_ms=17.013
2017-11-21 09:11:01,608 [salt.state       ][INFO    ][22757] Running state [virt.set_autostart] at time 09:11:01.608355
2017-11-21 09:11:01,609 [salt.state       ][INFO    ][22757] Executing state module.run for virt.set_autostart
2017-11-21 09:11:01,611 [salt.loaded.int.module.cmdmod][INFO    ][22757] Executing command 'virsh list --autostart --name| grep -E "^dbs02.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-11-21 09:11:01,625 [salt.state       ][INFO    ][22757] unless execution succeeded
2017-11-21 09:11:01,625 [salt.state       ][INFO    ][22757] Completed state [virt.set_autostart] at time 09:11:01.624945 duration_in_ms=16.59
2017-11-21 09:11:01,625 [salt.state       ][INFO    ][22757] Running state [virtng.init] at time 09:11:01.625191
2017-11-21 09:11:01,625 [salt.state       ][INFO    ][22757] Executing state module.run for virtng.init
2017-11-21 09:11:01,627 [salt.loaded.int.module.cmdmod][INFO    ][22757] Executing command 'virsh list --all --name| grep -E "^ctl02.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-11-21 09:11:01,642 [salt.state       ][INFO    ][22757] unless execution succeeded
2017-11-21 09:11:01,642 [salt.state       ][INFO    ][22757] Completed state [virtng.init] at time 09:11:01.642166 duration_in_ms=16.974
2017-11-21 09:11:01,642 [salt.state       ][INFO    ][22757] Running state [virt.set_autostart] at time 09:11:01.642410
2017-11-21 09:11:01,643 [salt.state       ][INFO    ][22757] Executing state module.run for virt.set_autostart
2017-11-21 09:11:01,645 [salt.loaded.int.module.cmdmod][INFO    ][22757] Executing command 'virsh list --autostart --name| grep -E "^ctl02.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-11-21 09:11:01,658 [salt.state       ][INFO    ][22757] unless execution succeeded
2017-11-21 09:11:01,659 [salt.state       ][INFO    ][22757] Completed state [virt.set_autostart] at time 09:11:01.658521 duration_in_ms=16.111
2017-11-21 09:11:01,659 [salt.state       ][INFO    ][22757] Running state [virtng.init] at time 09:11:01.658752
2017-11-21 09:11:01,659 [salt.state       ][INFO    ][22757] Executing state module.run for virtng.init
2017-11-21 09:11:01,661 [salt.loaded.int.module.cmdmod][INFO    ][22757] Executing command 'virsh list --all --name| grep -E "^msg02.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-11-21 09:11:01,675 [salt.state       ][INFO    ][22757] unless execution succeeded
2017-11-21 09:11:01,827 [salt.state       ][INFO    ][22757] Completed state [virtng.init] at time 09:11:01.827262 duration_in_ms=168.507
2017-11-21 09:11:01,828 [salt.state       ][INFO    ][22757] Running state [virt.set_autostart] at time 09:11:01.827747
2017-11-21 09:11:01,828 [salt.state       ][INFO    ][22757] Executing state module.run for virt.set_autostart
2017-11-21 09:11:01,830 [salt.loaded.int.module.cmdmod][INFO    ][22757] Executing command 'virsh list --autostart --name| grep -E "^msg02.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-11-21 09:11:01,848 [salt.state       ][INFO    ][22757] unless execution succeeded
2017-11-21 09:11:01,848 [salt.state       ][INFO    ][22757] Completed state [virt.set_autostart] at time 09:11:01.847981 duration_in_ms=20.234
2017-11-21 09:11:01,850 [salt.minion      ][INFO    ][22757] Returning information for job: 20171121091056239605
2017-11-21 09:11:44,478 [salt.minion      ][INFO    ][22402] User sudo_ubuntu Executing command saltutil.sync_all with jid 20171121091144473416
2017-11-21 09:11:44,494 [salt.minion      ][INFO    ][22857] Starting a new job with PID 22857
2017-11-21 09:11:47,704 [salt.state       ][INFO    ][22857] Loading fresh modules for state activity
2017-11-21 09:11:47,980 [salt.state       ][ERROR   ][22857] No contents found in top file
2017-11-21 09:11:47,981 [salt.utils.extmods][INFO    ][22857] Creating module dir '/var/cache/salt/minion/extmods/beacons'
2017-11-21 09:11:47,984 [salt.utils.extmods][INFO    ][22857] Syncing beacons for environment 'base'
2017-11-21 09:11:47,984 [salt.utils.extmods][INFO    ][22857] Loading cache from salt://_beacons, for base)
2017-11-21 09:11:47,984 [salt.fileclient  ][INFO    ][22857] Caching directory '_beacons/' for environment 'base'
2017-11-21 09:11:48,013 [salt.utils.extmods][INFO    ][22857] Syncing modules for environment 'base'
2017-11-21 09:11:48,013 [salt.utils.extmods][INFO    ][22857] Loading cache from salt://_modules, for base)
2017-11-21 09:11:48,013 [salt.fileclient  ][INFO    ][22857] Caching directory '_modules/' for environment 'base'
2017-11-21 09:11:48,081 [salt.fileclient  ][INFO    ][22857] Fetching file from saltenv 'base', ** done ** '_modules/ceph_ng.py'
2017-11-21 09:11:48,090 [salt.fileclient  ][INFO    ][22857] Fetching file from saltenv 'base', ** done ** '_modules/cinderng.py'
2017-11-21 09:11:48,109 [salt.fileclient  ][INFO    ][22857] Fetching file from saltenv 'base', ** done ** '_modules/contrail.py'
2017-11-21 09:11:48,116 [salt.fileclient  ][INFO    ][22857] Fetching file from saltenv 'base', ** done ** '_modules/creds.py'
2017-11-21 09:11:48,124 [salt.fileclient  ][INFO    ][22857] Fetching file from saltenv 'base', ** done ** '_modules/devops_utils.py'
2017-11-21 09:11:48,136 [salt.fileclient  ][INFO    ][22857] Fetching file from saltenv 'base', ** done ** '_modules/encode_json.py'
2017-11-21 09:11:48,145 [salt.fileclient  ][INFO    ][22857] Fetching file from saltenv 'base', ** done ** '_modules/gerrit.py'
2017-11-21 09:11:48,153 [salt.fileclient  ][INFO    ][22857] Fetching file from saltenv 'base', ** done ** '_modules/glanceng.py'
2017-11-21 09:11:48,162 [salt.fileclient  ][INFO    ][22857] Fetching file from saltenv 'base', ** done ** '_modules/heat.py'
2017-11-21 09:11:48,169 [salt.fileclient  ][INFO    ][22857] Fetching file from saltenv 'base', ** done ** '_modules/heka_alarming.py'
2017-11-21 09:11:48,180 [salt.fileclient  ][INFO    ][22857] Fetching file from saltenv 'base', ** done ** '_modules/helm.py'
2017-11-21 09:11:48,203 [salt.fileclient  ][INFO    ][22857] Fetching file from saltenv 'base', ** done ** '_modules/jenkins_common.py'
2017-11-21 09:11:48,215 [salt.fileclient  ][INFO    ][22857] Fetching file from saltenv 'base', ** done ** '_modules/keystone_policy.py'
2017-11-21 09:11:48,224 [salt.fileclient  ][INFO    ][22857] Fetching file from saltenv 'base', ** done ** '_modules/linux_hosts.py'
2017-11-21 09:11:48,233 [salt.fileclient  ][INFO    ][22857] Fetching file from saltenv 'base', ** done ** '_modules/linux_netlink.py'
2017-11-21 09:11:48,244 [salt.fileclient  ][INFO    ][22857] Fetching file from saltenv 'base', ** done ** '_modules/maas.py'
2017-11-21 09:11:48,254 [salt.fileclient  ][INFO    ][22857] Fetching file from saltenv 'base', ** done ** '_modules/maas_client.py'
2017-11-21 09:11:48,260 [salt.fileclient  ][INFO    ][22857] Fetching file from saltenv 'base', ** done ** '_modules/modelutils.py'
2017-11-21 09:11:48,269 [salt.fileclient  ][INFO    ][22857] Fetching file from saltenv 'base', ** done ** '_modules/multipart.py'
2017-11-21 09:11:48,278 [salt.fileclient  ][INFO    ][22857] Fetching file from saltenv 'base', ** done ** '_modules/nagios_alarming.py'
2017-11-21 09:11:48,287 [salt.fileclient  ][INFO    ][22857] Fetching file from saltenv 'base', ** done ** '_modules/neutronng.py'
2017-11-21 09:11:48,301 [salt.fileclient  ][INFO    ][22857] Fetching file from saltenv 'base', ** done ** '_modules/novang.py'
2017-11-21 09:11:48,311 [salt.fileclient  ][INFO    ][22857] Fetching file from saltenv 'base', ** done ** '_modules/reclass.py'
2017-11-21 09:11:48,323 [salt.fileclient  ][INFO    ][22857] Fetching file from saltenv 'base', ** done ** '_modules/rsyslog_util.py'
2017-11-21 09:11:48,334 [salt.fileclient  ][INFO    ][22857] Fetching file from saltenv 'base', ** done ** '_modules/rundeck.py'
2017-11-21 09:11:48,343 [salt.fileclient  ][INFO    ][22857] Fetching file from saltenv 'base', ** done ** '_modules/saltkey.py'
2017-11-21 09:11:48,356 [salt.fileclient  ][INFO    ][22857] Fetching file from saltenv 'base', ** done ** '_modules/saltresource.py'
2017-11-21 09:11:48,384 [salt.fileclient  ][INFO    ][22857] Fetching file from saltenv 'base', ** done ** '_modules/seedng.py'
2017-11-21 09:11:48,408 [salt.fileclient  ][INFO    ][22857] Fetching file from saltenv 'base', ** done ** '_modules/testing/credentials.py'
2017-11-21 09:11:48,420 [salt.fileclient  ][INFO    ][22857] Fetching file from saltenv 'base', ** done ** '_modules/testing/django.py'
2017-11-21 09:11:48,437 [salt.fileclient  ][INFO    ][22857] Fetching file from saltenv 'base', ** done ** '_modules/testing/django_client_proxy.py'
2017-11-21 09:11:48,446 [salt.fileclient  ][INFO    ][22857] Fetching file from saltenv 'base', ** done ** '_modules/utils.py'
2017-11-21 09:11:48,459 [salt.fileclient  ][INFO    ][22857] Fetching file from saltenv 'base', ** done ** '_modules/virtng.py'
2017-11-21 09:11:48,462 [salt.utils.extmods][INFO    ][22857] Copying '/var/cache/salt/minion/files/base/_modules/__init__.py' to '/var/cache/salt/minion/extmods/modules/__init__.py'
2017-11-21 09:11:48,463 [salt.utils.extmods][INFO    ][22857] Copying '/var/cache/salt/minion/files/base/_modules/ceph_ng.py' to '/var/cache/salt/minion/extmods/modules/ceph_ng.py'
2017-11-21 09:11:48,463 [salt.utils.extmods][INFO    ][22857] Copying '/var/cache/salt/minion/files/base/_modules/cinderng.py' to '/var/cache/salt/minion/extmods/modules/cinderng.py'
2017-11-21 09:11:48,463 [salt.utils.extmods][INFO    ][22857] Copying '/var/cache/salt/minion/files/base/_modules/contrail.py' to '/var/cache/salt/minion/extmods/modules/contrail.py'
2017-11-21 09:11:48,463 [salt.utils.extmods][INFO    ][22857] Copying '/var/cache/salt/minion/files/base/_modules/creds.py' to '/var/cache/salt/minion/extmods/modules/creds.py'
2017-11-21 09:11:48,464 [salt.utils.extmods][INFO    ][22857] Copying '/var/cache/salt/minion/files/base/_modules/devops_utils.py' to '/var/cache/salt/minion/extmods/modules/devops_utils.py'
2017-11-21 09:11:48,464 [salt.utils.extmods][INFO    ][22857] Copying '/var/cache/salt/minion/files/base/_modules/encode_json.py' to '/var/cache/salt/minion/extmods/modules/encode_json.py'
2017-11-21 09:11:48,464 [salt.utils.extmods][INFO    ][22857] Copying '/var/cache/salt/minion/files/base/_modules/gerrit.py' to '/var/cache/salt/minion/extmods/modules/gerrit.py'
2017-11-21 09:11:48,464 [salt.utils.extmods][INFO    ][22857] Copying '/var/cache/salt/minion/files/base/_modules/glanceng.py' to '/var/cache/salt/minion/extmods/modules/glanceng.py'
2017-11-21 09:11:48,465 [salt.utils.extmods][INFO    ][22857] Copying '/var/cache/salt/minion/files/base/_modules/heat.py' to '/var/cache/salt/minion/extmods/modules/heat.py'
2017-11-21 09:11:48,465 [salt.utils.extmods][INFO    ][22857] Copying '/var/cache/salt/minion/files/base/_modules/heka_alarming.py' to '/var/cache/salt/minion/extmods/modules/heka_alarming.py'
2017-11-21 09:11:48,465 [salt.utils.extmods][INFO    ][22857] Copying '/var/cache/salt/minion/files/base/_modules/helm.py' to '/var/cache/salt/minion/extmods/modules/helm.py'
2017-11-21 09:11:48,466 [salt.utils.extmods][INFO    ][22857] Copying '/var/cache/salt/minion/files/base/_modules/jenkins_common.py' to '/var/cache/salt/minion/extmods/modules/jenkins_common.py'
2017-11-21 09:11:48,466 [salt.utils.extmods][INFO    ][22857] Copying '/var/cache/salt/minion/files/base/_modules/keystone_policy.py' to '/var/cache/salt/minion/extmods/modules/keystone_policy.py'
2017-11-21 09:11:48,466 [salt.utils.extmods][INFO    ][22857] Copying '/var/cache/salt/minion/files/base/_modules/linux_hosts.py' to '/var/cache/salt/minion/extmods/modules/linux_hosts.py'
2017-11-21 09:11:48,467 [salt.utils.extmods][INFO    ][22857] Copying '/var/cache/salt/minion/files/base/_modules/linux_netlink.py' to '/var/cache/salt/minion/extmods/modules/linux_netlink.py'
2017-11-21 09:11:48,467 [salt.utils.extmods][INFO    ][22857] Copying '/var/cache/salt/minion/files/base/_modules/maas.py' to '/var/cache/salt/minion/extmods/modules/maas.py'
2017-11-21 09:11:48,467 [salt.utils.extmods][INFO    ][22857] Copying '/var/cache/salt/minion/files/base/_modules/maas_client.py' to '/var/cache/salt/minion/extmods/modules/maas_client.py'
2017-11-21 09:11:48,467 [salt.utils.extmods][INFO    ][22857] Copying '/var/cache/salt/minion/files/base/_modules/modelutils.py' to '/var/cache/salt/minion/extmods/modules/modelutils.py'
2017-11-21 09:11:48,468 [salt.utils.extmods][INFO    ][22857] Copying '/var/cache/salt/minion/files/base/_modules/multipart.py' to '/var/cache/salt/minion/extmods/modules/multipart.py'
2017-11-21 09:11:48,468 [salt.utils.extmods][INFO    ][22857] Copying '/var/cache/salt/minion/files/base/_modules/nagios_alarming.py' to '/var/cache/salt/minion/extmods/modules/nagios_alarming.py'
2017-11-21 09:11:48,468 [salt.utils.extmods][INFO    ][22857] Copying '/var/cache/salt/minion/files/base/_modules/neutronng.py' to '/var/cache/salt/minion/extmods/modules/neutronng.py'
2017-11-21 09:11:48,468 [salt.utils.extmods][INFO    ][22857] Copying '/var/cache/salt/minion/files/base/_modules/novang.py' to '/var/cache/salt/minion/extmods/modules/novang.py'
2017-11-21 09:11:48,469 [salt.utils.extmods][INFO    ][22857] Copying '/var/cache/salt/minion/files/base/_modules/reclass.py' to '/var/cache/salt/minion/extmods/modules/reclass.py'
2017-11-21 09:11:48,469 [salt.utils.extmods][INFO    ][22857] Copying '/var/cache/salt/minion/files/base/_modules/rsyslog_util.py' to '/var/cache/salt/minion/extmods/modules/rsyslog_util.py'
2017-11-21 09:11:48,469 [salt.utils.extmods][INFO    ][22857] Copying '/var/cache/salt/minion/files/base/_modules/rundeck.py' to '/var/cache/salt/minion/extmods/modules/rundeck.py'
2017-11-21 09:11:48,469 [salt.utils.extmods][INFO    ][22857] Copying '/var/cache/salt/minion/files/base/_modules/saltkey.py' to '/var/cache/salt/minion/extmods/modules/saltkey.py'
2017-11-21 09:11:48,470 [salt.utils.extmods][INFO    ][22857] Copying '/var/cache/salt/minion/files/base/_modules/saltresource.py' to '/var/cache/salt/minion/extmods/modules/saltresource.py'
2017-11-21 09:11:48,470 [salt.utils.extmods][INFO    ][22857] Copying '/var/cache/salt/minion/files/base/_modules/seedng.py' to '/var/cache/salt/minion/extmods/modules/seedng.py'
2017-11-21 09:11:48,470 [salt.utils.extmods][INFO    ][22857] Copying '/var/cache/salt/minion/files/base/_modules/testing/__init__.py' to '/var/cache/salt/minion/extmods/modules/testing/__init__.py'
2017-11-21 09:11:48,470 [salt.utils.extmods][INFO    ][22857] Copying '/var/cache/salt/minion/files/base/_modules/testing/credentials.py' to '/var/cache/salt/minion/extmods/modules/testing/credentials.py'
2017-11-21 09:11:48,471 [salt.utils.extmods][INFO    ][22857] Copying '/var/cache/salt/minion/files/base/_modules/testing/django.py' to '/var/cache/salt/minion/extmods/modules/testing/django.py'
2017-11-21 09:11:48,471 [salt.utils.extmods][INFO    ][22857] 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-11-21 09:11:48,471 [salt.utils.extmods][INFO    ][22857] Copying '/var/cache/salt/minion/files/base/_modules/utils.py' to '/var/cache/salt/minion/extmods/modules/utils.py'
2017-11-21 09:11:48,472 [salt.utils.extmods][INFO    ][22857] Copying '/var/cache/salt/minion/files/base/_modules/virtng.py' to '/var/cache/salt/minion/extmods/modules/virtng.py'
2017-11-21 09:11:48,476 [salt.utils.extmods][INFO    ][22857] Syncing states for environment 'base'
2017-11-21 09:11:48,477 [salt.utils.extmods][INFO    ][22857] Loading cache from salt://_states, for base)
2017-11-21 09:11:48,477 [salt.fileclient  ][INFO    ][22857] Caching directory '_states/' for environment 'base'
2017-11-21 09:11:48,541 [salt.fileclient  ][INFO    ][22857] Fetching file from saltenv 'base', ** done ** '_states/cinderng.py'
2017-11-21 09:11:48,563 [salt.fileclient  ][INFO    ][22857] Fetching file from saltenv 'base', ** done ** '_states/contrail.py'
2017-11-21 09:11:48,577 [salt.fileclient  ][INFO    ][22857] Fetching file from saltenv 'base', ** done ** '_states/gerrit.py'
2017-11-21 09:11:48,592 [salt.fileclient  ][INFO    ][22857] Fetching file from saltenv 'base', ** done ** '_states/glanceng.py'
2017-11-21 09:11:48,610 [salt.fileclient  ][INFO    ][22857] Fetching file from saltenv 'base', ** done ** '_states/grafana3_dashboard.py'
2017-11-21 09:11:48,621 [salt.fileclient  ][INFO    ][22857] Fetching file from saltenv 'base', ** done ** '_states/grafana3_datasource.py'
2017-11-21 09:11:48,672 [salt.fileclient  ][INFO    ][22857] Fetching file from saltenv 'base', ** done ** '_states/heat.py'
2017-11-21 09:11:48,689 [salt.fileclient  ][INFO    ][22857] Fetching file from saltenv 'base', ** done ** '_states/helm_release.py'
2017-11-21 09:11:48,698 [salt.fileclient  ][INFO    ][22857] Fetching file from saltenv 'base', ** done ** '_states/jenkins_approval.py'
2017-11-21 09:11:48,707 [salt.fileclient  ][INFO    ][22857] Fetching file from saltenv 'base', ** done ** '_states/jenkins_artifactory.py'
2017-11-21 09:11:48,717 [salt.fileclient  ][INFO    ][22857] Fetching file from saltenv 'base', ** done ** '_states/jenkins_credential.py'
2017-11-21 09:11:48,795 [salt.fileclient  ][INFO    ][22857] Fetching file from saltenv 'base', ** done ** '_states/jenkins_globalenvprop.py'
2017-11-21 09:11:48,806 [salt.fileclient  ][INFO    ][22857] Fetching file from saltenv 'base', ** done ** '_states/jenkins_job.py'
2017-11-21 09:11:48,820 [salt.fileclient  ][INFO    ][22857] Fetching file from saltenv 'base', ** done ** '_states/jenkins_lib.py'
2017-11-21 09:11:48,837 [salt.fileclient  ][INFO    ][22857] Fetching file from saltenv 'base', ** done ** '_states/jenkins_node.py'
2017-11-21 09:11:48,854 [salt.fileclient  ][INFO    ][22857] Fetching file from saltenv 'base', ** done ** '_states/jenkins_plugin.py'
2017-11-21 09:11:48,863 [salt.fileclient  ][INFO    ][22857] Fetching file from saltenv 'base', ** done ** '_states/jenkins_security.py'
2017-11-21 09:11:48,871 [salt.fileclient  ][INFO    ][22857] Fetching file from saltenv 'base', ** done ** '_states/jenkins_slack.py'
2017-11-21 09:11:48,881 [salt.fileclient  ][INFO    ][22857] Fetching file from saltenv 'base', ** done ** '_states/jenkins_smtp.py'
2017-11-21 09:11:48,891 [salt.fileclient  ][INFO    ][22857] Fetching file from saltenv 'base', ** done ** '_states/jenkins_theme.py'
2017-11-21 09:11:48,899 [salt.fileclient  ][INFO    ][22857] Fetching file from saltenv 'base', ** done ** '_states/jenkins_user.py'
2017-11-21 09:11:48,927 [salt.fileclient  ][INFO    ][22857] Fetching file from saltenv 'base', ** done ** '_states/jenkins_view.py'
2017-11-21 09:11:48,942 [salt.fileclient  ][INFO    ][22857] Fetching file from saltenv 'base', ** done ** '_states/keystone_policy.py'
2017-11-21 09:11:48,953 [salt.fileclient  ][INFO    ][22857] Fetching file from saltenv 'base', ** done ** '_states/kibana_object.py'
2017-11-21 09:11:48,973 [salt.fileclient  ][INFO    ][22857] Fetching file from saltenv 'base', ** done ** '_states/neutronng.py'
2017-11-21 09:11:49,008 [salt.fileclient  ][INFO    ][22857] Fetching file from saltenv 'base', ** done ** '_states/novang.py'
2017-11-21 09:11:49,023 [salt.fileclient  ][INFO    ][22857] Fetching file from saltenv 'base', ** done ** '_states/reclass.py'
2017-11-21 09:11:49,032 [salt.fileclient  ][INFO    ][22857] Fetching file from saltenv 'base', ** done ** '_states/rundeck_project.py'
2017-11-21 09:11:49,040 [salt.fileclient  ][INFO    ][22857] Fetching file from saltenv 'base', ** done ** '_states/rundeck_scm.py'
2017-11-21 09:11:49,059 [salt.fileclient  ][INFO    ][22857] Fetching file from saltenv 'base', ** done ** '_states/rundeck_secret.py'
2017-11-21 09:11:49,062 [salt.utils.extmods][INFO    ][22857] Copying '/var/cache/salt/minion/files/base/_states/cinderng.py' to '/var/cache/salt/minion/extmods/states/cinderng.py'
2017-11-21 09:11:49,062 [salt.utils.extmods][INFO    ][22857] Copying '/var/cache/salt/minion/files/base/_states/contrail.py' to '/var/cache/salt/minion/extmods/states/contrail.py'
2017-11-21 09:11:49,062 [salt.utils.extmods][INFO    ][22857] Copying '/var/cache/salt/minion/files/base/_states/gerrit.py' to '/var/cache/salt/minion/extmods/states/gerrit.py'
2017-11-21 09:11:49,062 [salt.utils.extmods][INFO    ][22857] Copying '/var/cache/salt/minion/files/base/_states/glanceng.py' to '/var/cache/salt/minion/extmods/states/glanceng.py'
2017-11-21 09:11:49,063 [salt.utils.extmods][INFO    ][22857] Copying '/var/cache/salt/minion/files/base/_states/grafana3_dashboard.py' to '/var/cache/salt/minion/extmods/states/grafana3_dashboard.py'
2017-11-21 09:11:49,063 [salt.utils.extmods][INFO    ][22857] Copying '/var/cache/salt/minion/files/base/_states/grafana3_datasource.py' to '/var/cache/salt/minion/extmods/states/grafana3_datasource.py'
2017-11-21 09:11:49,063 [salt.utils.extmods][INFO    ][22857] Copying '/var/cache/salt/minion/files/base/_states/heat.py' to '/var/cache/salt/minion/extmods/states/heat.py'
2017-11-21 09:11:49,063 [salt.utils.extmods][INFO    ][22857] Copying '/var/cache/salt/minion/files/base/_states/helm_release.py' to '/var/cache/salt/minion/extmods/states/helm_release.py'
2017-11-21 09:11:49,064 [salt.utils.extmods][INFO    ][22857] Copying '/var/cache/salt/minion/files/base/_states/jenkins_approval.py' to '/var/cache/salt/minion/extmods/states/jenkins_approval.py'
2017-11-21 09:11:49,064 [salt.utils.extmods][INFO    ][22857] Copying '/var/cache/salt/minion/files/base/_states/jenkins_artifactory.py' to '/var/cache/salt/minion/extmods/states/jenkins_artifactory.py'
2017-11-21 09:11:49,064 [salt.utils.extmods][INFO    ][22857] Copying '/var/cache/salt/minion/files/base/_states/jenkins_credential.py' to '/var/cache/salt/minion/extmods/states/jenkins_credential.py'
2017-11-21 09:11:49,064 [salt.utils.extmods][INFO    ][22857] Copying '/var/cache/salt/minion/files/base/_states/jenkins_globalenvprop.py' to '/var/cache/salt/minion/extmods/states/jenkins_globalenvprop.py'
2017-11-21 09:11:49,065 [salt.utils.extmods][INFO    ][22857] Copying '/var/cache/salt/minion/files/base/_states/jenkins_job.py' to '/var/cache/salt/minion/extmods/states/jenkins_job.py'
2017-11-21 09:11:49,065 [salt.utils.extmods][INFO    ][22857] Copying '/var/cache/salt/minion/files/base/_states/jenkins_lib.py' to '/var/cache/salt/minion/extmods/states/jenkins_lib.py'
2017-11-21 09:11:49,065 [salt.utils.extmods][INFO    ][22857] Copying '/var/cache/salt/minion/files/base/_states/jenkins_node.py' to '/var/cache/salt/minion/extmods/states/jenkins_node.py'
2017-11-21 09:11:49,065 [salt.utils.extmods][INFO    ][22857] Copying '/var/cache/salt/minion/files/base/_states/jenkins_plugin.py' to '/var/cache/salt/minion/extmods/states/jenkins_plugin.py'
2017-11-21 09:11:49,065 [salt.utils.extmods][INFO    ][22857] Copying '/var/cache/salt/minion/files/base/_states/jenkins_security.py' to '/var/cache/salt/minion/extmods/states/jenkins_security.py'
2017-11-21 09:11:49,066 [salt.utils.extmods][INFO    ][22857] Copying '/var/cache/salt/minion/files/base/_states/jenkins_slack.py' to '/var/cache/salt/minion/extmods/states/jenkins_slack.py'
2017-11-21 09:11:49,066 [salt.utils.extmods][INFO    ][22857] Copying '/var/cache/salt/minion/files/base/_states/jenkins_smtp.py' to '/var/cache/salt/minion/extmods/states/jenkins_smtp.py'
2017-11-21 09:11:49,066 [salt.utils.extmods][INFO    ][22857] Copying '/var/cache/salt/minion/files/base/_states/jenkins_theme.py' to '/var/cache/salt/minion/extmods/states/jenkins_theme.py'
2017-11-21 09:11:49,066 [salt.utils.extmods][INFO    ][22857] Copying '/var/cache/salt/minion/files/base/_states/jenkins_user.py' to '/var/cache/salt/minion/extmods/states/jenkins_user.py'
2017-11-21 09:11:49,066 [salt.utils.extmods][INFO    ][22857] Copying '/var/cache/salt/minion/files/base/_states/jenkins_view.py' to '/var/cache/salt/minion/extmods/states/jenkins_view.py'
2017-11-21 09:11:49,067 [salt.utils.extmods][INFO    ][22857] Copying '/var/cache/salt/minion/files/base/_states/keystone_policy.py' to '/var/cache/salt/minion/extmods/states/keystone_policy.py'
2017-11-21 09:11:49,067 [salt.utils.extmods][INFO    ][22857] Copying '/var/cache/salt/minion/files/base/_states/kibana_object.py' to '/var/cache/salt/minion/extmods/states/kibana_object.py'
2017-11-21 09:11:49,067 [salt.utils.extmods][INFO    ][22857] Copying '/var/cache/salt/minion/files/base/_states/maas_cluster.py' to '/var/cache/salt/minion/extmods/states/maas_cluster.py'
2017-11-21 09:11:49,067 [salt.utils.extmods][INFO    ][22857] Copying '/var/cache/salt/minion/files/base/_states/neutronng.py' to '/var/cache/salt/minion/extmods/states/neutronng.py'
2017-11-21 09:11:49,068 [salt.utils.extmods][INFO    ][22857] Copying '/var/cache/salt/minion/files/base/_states/novang.py' to '/var/cache/salt/minion/extmods/states/novang.py'
2017-11-21 09:11:49,068 [salt.utils.extmods][INFO    ][22857] Copying '/var/cache/salt/minion/files/base/_states/reclass.py' to '/var/cache/salt/minion/extmods/states/reclass.py'
2017-11-21 09:11:49,068 [salt.utils.extmods][INFO    ][22857] Copying '/var/cache/salt/minion/files/base/_states/rundeck_project.py' to '/var/cache/salt/minion/extmods/states/rundeck_project.py'
2017-11-21 09:11:49,068 [salt.utils.extmods][INFO    ][22857] Copying '/var/cache/salt/minion/files/base/_states/rundeck_scm.py' to '/var/cache/salt/minion/extmods/states/rundeck_scm.py'
2017-11-21 09:11:49,069 [salt.utils.extmods][INFO    ][22857] Copying '/var/cache/salt/minion/files/base/_states/rundeck_secret.py' to '/var/cache/salt/minion/extmods/states/rundeck_secret.py'
2017-11-21 09:11:49,071 [salt.utils.extmods][INFO    ][22857] Creating module dir '/var/cache/salt/minion/extmods/sdb'
2017-11-21 09:11:49,073 [salt.utils.extmods][INFO    ][22857] Syncing sdb for environment 'base'
2017-11-21 09:11:49,073 [salt.utils.extmods][INFO    ][22857] Loading cache from salt://_sdb, for base)
2017-11-21 09:11:49,073 [salt.fileclient  ][INFO    ][22857] Caching directory '_sdb/' for environment 'base'
2017-11-21 09:11:49,122 [salt.utils.extmods][INFO    ][22857] Syncing grains for environment 'base'
2017-11-21 09:11:49,122 [salt.utils.extmods][INFO    ][22857] Loading cache from salt://_grains, for base)
2017-11-21 09:11:49,122 [salt.fileclient  ][INFO    ][22857] Caching directory '_grains/' for environment 'base'
2017-11-21 09:11:49,168 [salt.fileclient  ][INFO    ][22857] Fetching file from saltenv 'base', ** done ** '_grains/ceilometer_policy.py'
2017-11-21 09:11:49,178 [salt.fileclient  ][INFO    ][22857] Fetching file from saltenv 'base', ** done ** '_grains/ceph.py'
2017-11-21 09:11:49,189 [salt.fileclient  ][INFO    ][22857] Fetching file from saltenv 'base', ** done ** '_grains/cinder_policy.py'
2017-11-21 09:11:49,198 [salt.fileclient  ][INFO    ][22857] Fetching file from saltenv 'base', ** done ** '_grains/docker_swarm.py'
2017-11-21 09:11:49,206 [salt.fileclient  ][INFO    ][22857] Fetching file from saltenv 'base', ** done ** '_grains/glance_policy.py'
2017-11-21 09:11:49,216 [salt.fileclient  ][INFO    ][22857] Fetching file from saltenv 'base', ** done ** '_grains/heat_policy.py'
2017-11-21 09:11:49,233 [salt.fileclient  ][INFO    ][22857] Fetching file from saltenv 'base', ** done ** '_grains/jenkins_plugins.py'
2017-11-21 09:11:49,242 [salt.fileclient  ][INFO    ][22857] Fetching file from saltenv 'base', ** done ** '_grains/keystone_policy.py'
2017-11-21 09:11:49,250 [salt.fileclient  ][INFO    ][22857] Fetching file from saltenv 'base', ** done ** '_grains/kubernetes.py'
2017-11-21 09:11:49,259 [salt.fileclient  ][INFO    ][22857] Fetching file from saltenv 'base', ** done ** '_grains/neutron_policy.py'
2017-11-21 09:11:49,273 [salt.fileclient  ][INFO    ][22857] Fetching file from saltenv 'base', ** done ** '_grains/nova_policy.py'
2017-11-21 09:11:49,281 [salt.fileclient  ][INFO    ][22857] Fetching file from saltenv 'base', ** done ** '_grains/ssh_fingerprints.py'
2017-11-21 09:11:49,284 [salt.utils.extmods][INFO    ][22857] Copying '/var/cache/salt/minion/files/base/_grains/ceilometer_policy.py' to '/var/cache/salt/minion/extmods/grains/ceilometer_policy.py'
2017-11-21 09:11:49,284 [salt.utils.extmods][INFO    ][22857] Copying '/var/cache/salt/minion/files/base/_grains/ceph.py' to '/var/cache/salt/minion/extmods/grains/ceph.py'
2017-11-21 09:11:49,285 [salt.utils.extmods][INFO    ][22857] Copying '/var/cache/salt/minion/files/base/_grains/cinder_policy.py' to '/var/cache/salt/minion/extmods/grains/cinder_policy.py'
2017-11-21 09:11:49,285 [salt.utils.extmods][INFO    ][22857] Copying '/var/cache/salt/minion/files/base/_grains/docker_swarm.py' to '/var/cache/salt/minion/extmods/grains/docker_swarm.py'
2017-11-21 09:11:49,285 [salt.utils.extmods][INFO    ][22857] Copying '/var/cache/salt/minion/files/base/_grains/glance_policy.py' to '/var/cache/salt/minion/extmods/grains/glance_policy.py'
2017-11-21 09:11:49,285 [salt.utils.extmods][INFO    ][22857] Copying '/var/cache/salt/minion/files/base/_grains/heat_policy.py' to '/var/cache/salt/minion/extmods/grains/heat_policy.py'
2017-11-21 09:11:49,286 [salt.utils.extmods][INFO    ][22857] Copying '/var/cache/salt/minion/files/base/_grains/jenkins_plugins.py' to '/var/cache/salt/minion/extmods/grains/jenkins_plugins.py'
2017-11-21 09:11:49,286 [salt.utils.extmods][INFO    ][22857] Copying '/var/cache/salt/minion/files/base/_grains/keystone_policy.py' to '/var/cache/salt/minion/extmods/grains/keystone_policy.py'
2017-11-21 09:11:49,286 [salt.utils.extmods][INFO    ][22857] Copying '/var/cache/salt/minion/files/base/_grains/kubernetes.py' to '/var/cache/salt/minion/extmods/grains/kubernetes.py'
2017-11-21 09:11:49,286 [salt.utils.extmods][INFO    ][22857] Copying '/var/cache/salt/minion/files/base/_grains/neutron_policy.py' to '/var/cache/salt/minion/extmods/grains/neutron_policy.py'
2017-11-21 09:11:49,287 [salt.utils.extmods][INFO    ][22857] Copying '/var/cache/salt/minion/files/base/_grains/nova_policy.py' to '/var/cache/salt/minion/extmods/grains/nova_policy.py'
2017-11-21 09:11:49,287 [salt.utils.extmods][INFO    ][22857] Copying '/var/cache/salt/minion/files/base/_grains/ssh_fingerprints.py' to '/var/cache/salt/minion/extmods/grains/ssh_fingerprints.py'
2017-11-21 09:11:49,288 [salt.utils.extmods][INFO    ][22857] Creating module dir '/var/cache/salt/minion/extmods/renderers'
2017-11-21 09:11:49,290 [salt.utils.extmods][INFO    ][22857] Syncing renderers for environment 'base'
2017-11-21 09:11:49,291 [salt.utils.extmods][INFO    ][22857] Loading cache from salt://_renderers, for base)
2017-11-21 09:11:49,291 [salt.fileclient  ][INFO    ][22857] Caching directory '_renderers/' for environment 'base'
2017-11-21 09:11:49,318 [salt.utils.extmods][INFO    ][22857] Creating module dir '/var/cache/salt/minion/extmods/returners'
2017-11-21 09:11:49,321 [salt.utils.extmods][INFO    ][22857] Syncing returners for environment 'base'
2017-11-21 09:11:49,321 [salt.utils.extmods][INFO    ][22857] Loading cache from salt://_returners, for base)
2017-11-21 09:11:49,321 [salt.fileclient  ][INFO    ][22857] Caching directory '_returners/' for environment 'base'
2017-11-21 09:11:49,350 [salt.utils.extmods][INFO    ][22857] Creating module dir '/var/cache/salt/minion/extmods/output'
2017-11-21 09:11:49,353 [salt.utils.extmods][INFO    ][22857] Syncing output for environment 'base'
2017-11-21 09:11:49,353 [salt.utils.extmods][INFO    ][22857] Loading cache from salt://_output, for base)
2017-11-21 09:11:49,353 [salt.fileclient  ][INFO    ][22857] Caching directory '_output/' for environment 'base'
2017-11-21 09:11:49,373 [salt.utils.extmods][INFO    ][22857] Creating module dir '/var/cache/salt/minion/extmods/utils'
2017-11-21 09:11:49,376 [salt.utils.extmods][INFO    ][22857] Syncing utils for environment 'base'
2017-11-21 09:11:49,376 [salt.utils.extmods][INFO    ][22857] Loading cache from salt://_utils, for base)
2017-11-21 09:11:49,376 [salt.fileclient  ][INFO    ][22857] Caching directory '_utils/' for environment 'base'
2017-11-21 09:11:49,399 [salt.utils.extmods][INFO    ][22857] Creating module dir '/var/cache/salt/minion/extmods/log_handlers'
2017-11-21 09:11:49,401 [salt.utils.extmods][INFO    ][22857] Syncing log_handlers for environment 'base'
2017-11-21 09:11:49,402 [salt.utils.extmods][INFO    ][22857] Loading cache from salt://_log_handlers, for base)
2017-11-21 09:11:49,402 [salt.fileclient  ][INFO    ][22857] Caching directory '_log_handlers/' for environment 'base'
2017-11-21 09:11:49,427 [salt.utils.extmods][INFO    ][22857] Creating module dir '/var/cache/salt/minion/extmods/proxy'
2017-11-21 09:11:49,429 [salt.utils.extmods][INFO    ][22857] Syncing proxy for environment 'base'
2017-11-21 09:11:49,429 [salt.utils.extmods][INFO    ][22857] Loading cache from salt://_proxy, for base)
2017-11-21 09:11:49,430 [salt.fileclient  ][INFO    ][22857] Caching directory '_proxy/' for environment 'base'
2017-11-21 09:11:49,466 [salt.utils.extmods][INFO    ][22857] Creating module dir '/var/cache/salt/minion/extmods/engines'
2017-11-21 09:11:49,468 [salt.utils.extmods][INFO    ][22857] Syncing engines for environment 'base'
2017-11-21 09:11:49,469 [salt.utils.extmods][INFO    ][22857] Loading cache from salt://_engines, for base)
2017-11-21 09:11:49,469 [salt.fileclient  ][INFO    ][22857] Caching directory '_engines/' for environment 'base'
2017-11-21 09:11:49,490 [salt.minion      ][INFO    ][22857] Returning information for job: 20171121091144473416
2017-11-21 09:21:47,367 [salt.minion      ][INFO    ][22402] User sudo_ubuntu Executing command test.ping with jid 20171121092147370175
2017-11-21 09:21:47,384 [salt.minion      ][INFO    ][23070] Starting a new job with PID 23070
2017-11-21 09:21:47,411 [salt.minion      ][INFO    ][23070] Returning information for job: 20171121092147370175
2017-11-21 09:25:00,415 [salt.minion      ][INFO    ][22402] User sudo_ubuntu Executing command state.sls with jid 20171121092500413078
2017-11-21 09:25:00,427 [salt.minion      ][INFO    ][23104] Starting a new job with PID 23104
2017-11-21 09:25:00,860 [salt.state       ][INFO    ][23104] Loading fresh modules for state activity
2017-11-21 09:25:00,884 [salt.fileclient  ][INFO    ][23104] Fetching file from saltenv 'base', ** done ** 'keepalived/init.sls'
2017-11-21 09:25:00,902 [salt.fileclient  ][INFO    ][23104] Fetching file from saltenv 'base', ** done ** 'keepalived/cluster.sls'
2017-11-21 09:25:00,927 [salt.fileclient  ][INFO    ][23104] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-11-21 09:25:01,237 [salt.state       ][INFO    ][23104] Running state [lsof] at time 09:25:01.236669
2017-11-21 09:25:01,237 [salt.state       ][INFO    ][23104] Executing state pkg.installed for lsof
2017-11-21 09:25:01,237 [salt.loaded.int.module.cmdmod][INFO    ][23104] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-21 09:25:01,495 [salt.state       ][INFO    ][23104] Package lsof is already installed
2017-11-21 09:25:01,496 [salt.state       ][INFO    ][23104] Completed state [lsof] at time 09:25:01.495713 duration_in_ms=259.045
2017-11-21 09:25:01,496 [salt.state       ][INFO    ][23104] Running state [keepalived] at time 09:25:01.495930
2017-11-21 09:25:01,496 [salt.state       ][INFO    ][23104] Executing state pkg.installed for keepalived
2017-11-21 09:25:01,512 [salt.loaded.int.module.cmdmod][INFO    ][23104] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-11-21 09:25:03,047 [salt.loaded.int.module.cmdmod][INFO    ][23104] 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-11-21 09:25:10,371 [salt.loaded.int.module.cmdmod][INFO    ][23104] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-21 09:25:10,394 [salt.state       ][INFO    ][23104] 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-11-21 09:25:10,402 [salt.state       ][INFO    ][23104] Loading fresh modules for state activity
2017-11-21 09:25:10,414 [salt.state       ][INFO    ][23104] Completed state [keepalived] at time 09:25:10.414135 duration_in_ms=8918.204
2017-11-21 09:25:10,416 [salt.state       ][INFO    ][23104] Running state [/etc/keepalived/keepalived.conf] at time 09:25:10.415849
2017-11-21 09:25:10,416 [salt.state       ][INFO    ][23104] Executing state file.managed for /etc/keepalived/keepalived.conf
2017-11-21 09:25:10,442 [salt.fileclient  ][INFO    ][23104] Fetching file from saltenv 'base', ** done ** 'keepalived/files/keepalived.conf'
2017-11-21 09:25:10,472 [salt.fileclient  ][INFO    ][23104] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-11-21 09:25:10,478 [salt.state       ][INFO    ][23104] File changed:
New file
2017-11-21 09:25:10,478 [salt.state       ][INFO    ][23104] Completed state [/etc/keepalived/keepalived.conf] at time 09:25:10.477891 duration_in_ms=62.042
2017-11-21 09:25:10,532 [salt.state       ][INFO    ][23104] Running state [keepalived] at time 09:25:10.532179
2017-11-21 09:25:10,532 [salt.state       ][INFO    ][23104] Executing state service.running for keepalived
2017-11-21 09:25:10,534 [salt.loaded.int.module.cmdmod][INFO    ][23104] Executing command ['systemctl', 'status', 'keepalived.service', '-n', '0'] in directory '/root'
2017-11-21 09:25:10,543 [salt.loaded.int.module.cmdmod][INFO    ][23104] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2017-11-21 09:25:10,551 [salt.loaded.int.module.cmdmod][INFO    ][23104] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-11-21 09:25:10,557 [salt.loaded.int.module.cmdmod][INFO    ][23104] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-11-21 09:25:10,564 [salt.loaded.int.module.cmdmod][INFO    ][23104] Executing command ['systemd-run', '--scope', 'systemctl', 'start', 'keepalived.service'] in directory '/root'
2017-11-21 09:25:10,629 [salt.loaded.int.module.cmdmod][INFO    ][23104] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2017-11-21 09:25:10,637 [salt.loaded.int.module.cmdmod][INFO    ][23104] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-11-21 09:25:10,644 [salt.loaded.int.module.cmdmod][INFO    ][23104] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-11-21 09:25:10,651 [salt.state       ][INFO    ][23104] {'keepalived': True}
2017-11-21 09:25:10,652 [salt.state       ][INFO    ][23104] Completed state [keepalived] at time 09:25:10.651621 duration_in_ms=119.442
2017-11-21 09:25:10,652 [salt.minion      ][INFO    ][23104] Returning information for job: 20171121092500413078
2017-11-21 09:25:10,917 [salt.minion      ][INFO    ][22402] User sudo_ubuntu Executing command saltutil.find_job with jid 20171121092510457989
2017-11-21 09:25:10,927 [salt.minion      ][INFO    ][24647] Starting a new job with PID 24647
2017-11-21 09:25:10,938 [salt.minion      ][INFO    ][24647] Returning information for job: 20171121092510457989
2017-11-21 09:25:48,200 [salt.minion      ][INFO    ][22402] User sudo_ubuntu Executing command pillar.get with jid 20171121092548200613
2017-11-21 09:25:48,223 [salt.minion      ][INFO    ][24674] Starting a new job with PID 24674
2017-11-21 09:25:48,229 [salt.minion      ][INFO    ][24674] Returning information for job: 20171121092548200613
2017-11-21 09:30:56,984 [salt.minion      ][INFO    ][22402] User sudo_ubuntu Executing command state.sls with jid 20171121093056966325
2017-11-21 09:30:56,998 [salt.minion      ][INFO    ][24757] Starting a new job with PID 24757
2017-11-21 09:30:59,438 [salt.state       ][INFO    ][24757] Loading fresh modules for state activity
2017-11-21 09:30:59,462 [salt.fileclient  ][INFO    ][24757] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-11-21 09:30:59,481 [salt.fileclient  ][INFO    ][24757] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-11-21 09:30:59,765 [salt.state       ][INFO    ][24757] Running state [attr] at time 09:30:59.764534
2017-11-21 09:30:59,765 [salt.state       ][INFO    ][24757] Executing state pkg.installed for attr
2017-11-21 09:30:59,765 [salt.loaded.int.module.cmdmod][INFO    ][24757] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-21 09:31:00,023 [salt.loaded.int.module.cmdmod][INFO    ][24757] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-11-21 09:31:01,521 [salt.loaded.int.module.cmdmod][INFO    ][24757] 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-11-21 09:31:04,114 [salt.loaded.int.module.cmdmod][INFO    ][24757] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-21 09:31:04,137 [salt.state       ][INFO    ][24757] Made the following changes:
'attr' changed from 'absent' to '1:2.4.47-2'

2017-11-21 09:31:04,145 [salt.state       ][INFO    ][24757] Loading fresh modules for state activity
2017-11-21 09:31:04,157 [salt.state       ][INFO    ][24757] Completed state [attr] at time 09:31:04.156587 duration_in_ms=4392.053
2017-11-21 09:31:04,161 [salt.state       ][INFO    ][24757] Running state [glusterfs-server] at time 09:31:04.161252
2017-11-21 09:31:04,161 [salt.state       ][INFO    ][24757] Executing state pkg.installed for glusterfs-server
2017-11-21 09:31:04,348 [salt.loaded.int.module.cmdmod][INFO    ][24757] 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-11-21 09:31:07,080 [salt.minion      ][INFO    ][22402] User sudo_ubuntu Executing command saltutil.find_job with jid 20171121093107076675
2017-11-21 09:31:07,094 [salt.minion      ][INFO    ][25721] Starting a new job with PID 25721
2017-11-21 09:31:07,105 [salt.minion      ][INFO    ][25721] Returning information for job: 20171121093107076675
2017-11-21 09:31:17,283 [salt.minion      ][INFO    ][22402] User sudo_ubuntu Executing command saltutil.find_job with jid 20171121093117279013
2017-11-21 09:31:17,295 [salt.minion      ][INFO    ][28391] Starting a new job with PID 28391
2017-11-21 09:31:17,306 [salt.minion      ][INFO    ][28391] Returning information for job: 20171121093117279013
2017-11-21 09:31:24,869 [salt.loaded.int.module.cmdmod][INFO    ][24757] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-21 09:31:24,891 [salt.state       ][INFO    ][24757] Made the following changes:
'keyutils' changed from 'absent' to '1.5.9-8ubuntu1'
'nfs-common' changed from 'absent' to '1:1.2.8-9ubuntu12.1'
'rpcbind' changed from 'absent' to '0.2.3-0.2'
'glusterfs-common' changed from 'absent' to '3.7.6-1ubuntu1'
'librdmacm1' changed from 'absent' to '1.0.21-1'
'libnfsidmap2' changed from 'absent' to '0.25-5'
'portmap' changed from 'absent' to '1'
'libattr1-dev' changed from 'absent' to '1:2.4.47-2'
'attr-dev' changed from 'absent' to '1'
'acl-dev' changed from 'absent' to '1'
'glusterfs-server' changed from 'absent' to '3.7.6-1ubuntu1'
'glusterfs-client' changed from 'absent' to '3.7.6-1ubuntu1'
'libpython2.7' changed from 'absent' to '2.7.12-1ubuntu0~16.04.1'
'nfs-client' changed from 'absent' to '1'
'liburcu4' changed from 'absent' to '0.9.1-3'
'libacl1-dev' changed from 'absent' to '2.2.52-3'
'libibverbs1' changed from 'absent' to '1.1.8-1.1ubuntu2'
'libtirpc1' changed from 'absent' to '0.2.5-1'

2017-11-21 09:31:24,898 [salt.state       ][INFO    ][24757] Loading fresh modules for state activity
2017-11-21 09:31:24,910 [salt.state       ][INFO    ][24757] Completed state [glusterfs-server] at time 09:31:24.910380 duration_in_ms=20749.128
2017-11-21 09:31:24,915 [salt.state       ][INFO    ][24757] Running state [bc] at time 09:31:24.914742
2017-11-21 09:31:24,915 [salt.state       ][INFO    ][24757] Executing state pkg.installed for bc
2017-11-21 09:31:25,172 [salt.loaded.int.module.cmdmod][INFO    ][24757] 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-11-21 09:31:27,483 [salt.minion      ][INFO    ][22402] User sudo_ubuntu Executing command saltutil.find_job with jid 20171121093127479393
2017-11-21 09:31:27,496 [salt.minion      ][INFO    ][29399] Starting a new job with PID 29399
2017-11-21 09:31:27,508 [salt.minion      ][INFO    ][29399] Returning information for job: 20171121093127479393
2017-11-21 09:31:28,045 [salt.loaded.int.module.cmdmod][INFO    ][24757] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-21 09:31:28,072 [salt.state       ][INFO    ][24757] Made the following changes:
'bc' changed from 'absent' to '1.06.95-9build1'

2017-11-21 09:31:28,081 [salt.state       ][INFO    ][24757] Loading fresh modules for state activity
2017-11-21 09:31:28,093 [salt.state       ][INFO    ][24757] Completed state [bc] at time 09:31:28.093226 duration_in_ms=3178.484
2017-11-21 09:31:28,163 [salt.state       ][INFO    ][24757] Running state [glusterfs-server] at time 09:31:28.163096
2017-11-21 09:31:28,163 [salt.state       ][INFO    ][24757] Executing state service.running for glusterfs-server
2017-11-21 09:31:28,165 [salt.loaded.int.module.cmdmod][INFO    ][24757] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-11-21 09:31:28,174 [salt.loaded.int.module.cmdmod][INFO    ][24757] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-11-21 09:31:28,182 [salt.loaded.int.module.cmdmod][INFO    ][24757] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-11-21 09:31:28,191 [salt.state       ][INFO    ][24757] The service glusterfs-server is already running
2017-11-21 09:31:28,191 [salt.state       ][INFO    ][24757] Completed state [glusterfs-server] at time 09:31:28.190765 duration_in_ms=27.669
2017-11-21 09:31:28,192 [salt.state       ][INFO    ][24757] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 09:31:28.192279
2017-11-21 09:31:28,192 [salt.state       ][INFO    ][24757] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-11-21 09:31:28,203 [salt.state       ][INFO    ][24757] File changed:
New file
2017-11-21 09:31:28,203 [salt.state       ][INFO    ][24757] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 09:31:28.203321 duration_in_ms=11.042
2017-11-21 09:31:28,204 [salt.state       ][INFO    ][24757] Running state [/srv/glusterfs/glance] at time 09:31:28.203495
2017-11-21 09:31:28,204 [salt.state       ][INFO    ][24757] Executing state file.directory for /srv/glusterfs/glance
2017-11-21 09:31:28,204 [salt.state       ][INFO    ][24757] {'/srv/glusterfs/glance': 'New Dir'}
2017-11-21 09:31:28,204 [salt.state       ][INFO    ][24757] Completed state [/srv/glusterfs/glance] at time 09:31:28.204358 duration_in_ms=0.864
2017-11-21 09:31:28,205 [salt.state       ][INFO    ][24757] Running state [/srv/glusterfs/keystone-keys] at time 09:31:28.204498
2017-11-21 09:31:28,205 [salt.state       ][INFO    ][24757] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-11-21 09:31:28,205 [salt.state       ][INFO    ][24757] {'/srv/glusterfs/keystone-keys': 'New Dir'}
2017-11-21 09:31:28,205 [salt.state       ][INFO    ][24757] Completed state [/srv/glusterfs/keystone-keys] at time 09:31:28.205141 duration_in_ms=0.643
2017-11-21 09:31:28,205 [salt.state       ][INFO    ][24757] Running state [/srv/glusterfs/nova_instances] at time 09:31:28.205296
2017-11-21 09:31:28,205 [salt.state       ][INFO    ][24757] Executing state file.directory for /srv/glusterfs/nova_instances
2017-11-21 09:31:28,206 [salt.state       ][INFO    ][24757] {'/srv/glusterfs/nova_instances': 'New Dir'}
2017-11-21 09:31:28,206 [salt.state       ][INFO    ][24757] Completed state [/srv/glusterfs/nova_instances] at time 09:31:28.205932 duration_in_ms=0.636
2017-11-21 09:31:28,206 [salt.state       ][INFO    ][24757] Running state [/srv/glusterfs/keystone-credential-keys] at time 09:31:28.206082
2017-11-21 09:31:28,206 [salt.state       ][INFO    ][24757] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-11-21 09:31:28,207 [salt.state       ][INFO    ][24757] {'/srv/glusterfs/keystone-credential-keys': 'New Dir'}
2017-11-21 09:31:28,207 [salt.state       ][INFO    ][24757] Completed state [/srv/glusterfs/keystone-credential-keys] at time 09:31:28.206743 duration_in_ms=0.66
2017-11-21 09:31:28,208 [salt.minion      ][INFO    ][24757] Returning information for job: 20171121093056966325
2017-11-21 09:31:29,439 [salt.minion      ][INFO    ][22402] User sudo_ubuntu Executing command test.ping with jid 20171121093129436748
2017-11-21 09:31:29,451 [salt.minion      ][INFO    ][29466] Starting a new job with PID 29466
2017-11-21 09:31:29,480 [salt.minion      ][INFO    ][29466] Returning information for job: 20171121093129436748
2017-11-21 09:31:29,618 [salt.minion      ][INFO    ][22402] User sudo_ubuntu Executing command state.sls with jid 20171121093129615520
2017-11-21 09:31:29,630 [salt.minion      ][INFO    ][29471] Starting a new job with PID 29471
2017-11-21 09:31:31,271 [salt.state       ][INFO    ][29471] Loading fresh modules for state activity
2017-11-21 09:31:31,294 [salt.fileclient  ][INFO    ][29471] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/setup.sls'
2017-11-21 09:31:31,329 [salt.fileclient  ][INFO    ][29471] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-11-21 09:31:31,392 [salt.fileclient  ][INFO    ][29471] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-11-21 09:31:31,411 [salt.fileclient  ][INFO    ][29471] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-11-21 09:31:31,671 [salt.state       ][INFO    ][29471] Running state [attr] at time 09:31:31.671376
2017-11-21 09:31:31,672 [salt.state       ][INFO    ][29471] Executing state pkg.installed for attr
2017-11-21 09:31:31,672 [salt.loaded.int.module.cmdmod][INFO    ][29471] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-21 09:31:31,937 [salt.state       ][INFO    ][29471] Package attr is already installed
2017-11-21 09:31:31,937 [salt.state       ][INFO    ][29471] Completed state [attr] at time 09:31:31.936866 duration_in_ms=265.49
2017-11-21 09:31:31,937 [salt.state       ][INFO    ][29471] Running state [glusterfs-server] at time 09:31:31.937064
2017-11-21 09:31:31,937 [salt.state       ][INFO    ][29471] Executing state pkg.installed for glusterfs-server
2017-11-21 09:31:31,940 [salt.state       ][INFO    ][29471] Package glusterfs-server is already installed
2017-11-21 09:31:31,940 [salt.state       ][INFO    ][29471] Completed state [glusterfs-server] at time 09:31:31.940024 duration_in_ms=2.961
2017-11-21 09:31:31,940 [salt.state       ][INFO    ][29471] Running state [bc] at time 09:31:31.940160
2017-11-21 09:31:31,940 [salt.state       ][INFO    ][29471] Executing state pkg.installed for bc
2017-11-21 09:31:31,943 [salt.state       ][INFO    ][29471] Package bc is already installed
2017-11-21 09:31:31,943 [salt.state       ][INFO    ][29471] Completed state [bc] at time 09:31:31.943047 duration_in_ms=2.886
2017-11-21 09:31:31,944 [salt.state       ][INFO    ][29471] Running state [glusterfs-server] at time 09:31:31.943858
2017-11-21 09:31:31,944 [salt.state       ][INFO    ][29471] Executing state service.running for glusterfs-server
2017-11-21 09:31:31,944 [salt.loaded.int.module.cmdmod][INFO    ][29471] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-11-21 09:31:31,954 [salt.loaded.int.module.cmdmod][INFO    ][29471] Executing command ['systemctl', '--system', 'daemon-reload'] in directory '/root'
2017-11-21 09:31:31,995 [salt.loaded.int.module.cmdmod][INFO    ][29471] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-11-21 09:31:32,010 [salt.loaded.int.module.cmdmod][INFO    ][29471] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-11-21 09:31:32,018 [salt.loaded.int.module.cmdmod][INFO    ][29471] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-11-21 09:31:32,028 [salt.state       ][INFO    ][29471] The service glusterfs-server is already running
2017-11-21 09:31:32,028 [salt.state       ][INFO    ][29471] Completed state [glusterfs-server] at time 09:31:32.028221 duration_in_ms=84.362
2017-11-21 09:31:32,030 [salt.state       ][INFO    ][29471] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 09:31:32.029658
2017-11-21 09:31:32,030 [salt.state       ][INFO    ][29471] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-11-21 09:31:32,043 [salt.state       ][INFO    ][29471] File /etc/systemd/system/glusterfs-server.service.d/override.conf is in the correct state
2017-11-21 09:31:32,043 [salt.state       ][INFO    ][29471] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 09:31:32.043039 duration_in_ms=13.381
2017-11-21 09:31:32,043 [salt.state       ][INFO    ][29471] Running state [/srv/glusterfs/glance] at time 09:31:32.043230
2017-11-21 09:31:32,043 [salt.state       ][INFO    ][29471] Executing state file.directory for /srv/glusterfs/glance
2017-11-21 09:31:32,044 [salt.state       ][INFO    ][29471] Directory /srv/glusterfs/glance is in the correct state
2017-11-21 09:31:32,044 [salt.state       ][INFO    ][29471] Completed state [/srv/glusterfs/glance] at time 09:31:32.043840 duration_in_ms=0.61
2017-11-21 09:31:32,044 [salt.state       ][INFO    ][29471] Running state [/srv/glusterfs/keystone-keys] at time 09:31:32.043977
2017-11-21 09:31:32,044 [salt.state       ][INFO    ][29471] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-11-21 09:31:32,044 [salt.state       ][INFO    ][29471] Directory /srv/glusterfs/keystone-keys is in the correct state
2017-11-21 09:31:32,045 [salt.state       ][INFO    ][29471] Completed state [/srv/glusterfs/keystone-keys] at time 09:31:32.044538 duration_in_ms=0.561
2017-11-21 09:31:32,045 [salt.state       ][INFO    ][29471] Running state [/srv/glusterfs/nova_instances] at time 09:31:32.044674
2017-11-21 09:31:32,045 [salt.state       ][INFO    ][29471] Executing state file.directory for /srv/glusterfs/nova_instances
2017-11-21 09:31:32,045 [salt.state       ][INFO    ][29471] Directory /srv/glusterfs/nova_instances is in the correct state
2017-11-21 09:31:32,045 [salt.state       ][INFO    ][29471] Completed state [/srv/glusterfs/nova_instances] at time 09:31:32.045209 duration_in_ms=0.535
2017-11-21 09:31:32,045 [salt.state       ][INFO    ][29471] Running state [/srv/glusterfs/keystone-credential-keys] at time 09:31:32.045346
2017-11-21 09:31:32,045 [salt.state       ][INFO    ][29471] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-11-21 09:31:32,046 [salt.state       ][INFO    ][29471] Directory /srv/glusterfs/keystone-credential-keys is in the correct state
2017-11-21 09:31:32,046 [salt.state       ][INFO    ][29471] Completed state [/srv/glusterfs/keystone-credential-keys] at time 09:31:32.045878 duration_in_ms=0.533
2017-11-21 09:31:32,095 [salt.loaded.int.module.cmdmod][INFO    ][29471] Executing command ['git', '--version'] in directory '/root'
2017-11-21 09:31:32,181 [salt.state       ][INFO    ][29471] Running state [sleep 5] at time 09:31:32.180570
2017-11-21 09:31:32,181 [salt.state       ][INFO    ][29471] Executing state cmd.wait for sleep 5
2017-11-21 09:31:32,181 [salt.state       ][INFO    ][29471] No changes made for sleep 5
2017-11-21 09:31:32,181 [salt.state       ][INFO    ][29471] Completed state [sleep 5] at time 09:31:32.181145 duration_in_ms=0.577
2017-11-21 09:31:32,182 [salt.state       ][INFO    ][29471] Running state [10.167.4.141] at time 09:31:32.181527
2017-11-21 09:31:32,182 [salt.state       ][INFO    ][29471] Executing state glusterfs.peered for 10.167.4.141
2017-11-21 09:31:32,182 [salt.loaded.int.module.cmdmod][INFO    ][29471] Executing command 'gluster --version' in directory '/root'
2017-11-21 09:31:32,192 [salt.loaded.int.module.cmdmod][INFO    ][29471] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-21 09:31:32,247 [salt.loaded.int.module.cmdmod][INFO    ][29471] Executing command 'gluster --version' in directory '/root'
2017-11-21 09:31:32,256 [salt.loaded.int.module.cmdmod][INFO    ][29471] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-21 09:31:32,597 [salt.loaded.int.module.cmdmod][INFO    ][29471] Executing command 'gluster --version' in directory '/root'
2017-11-21 09:31:32,606 [salt.loaded.int.module.cmdmod][INFO    ][29471] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-21 09:31:32,664 [salt.loaded.int.module.cmdmod][INFO    ][29471] Executing command 'gluster --version' in directory '/root'
2017-11-21 09:31:32,676 [salt.loaded.int.module.cmdmod][INFO    ][29471] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-21 09:31:32,729 [salt.state       ][INFO    ][29471] {'new': {'10.167.4.141': []}, 'old': None}
2017-11-21 09:31:32,729 [salt.state       ][INFO    ][29471] Completed state [10.167.4.141] at time 09:31:32.729021 duration_in_ms=547.492
2017-11-21 09:31:32,731 [salt.state       ][INFO    ][29471] Running state [10.167.4.142] at time 09:31:32.731431
2017-11-21 09:31:32,732 [salt.state       ][INFO    ][29471] Executing state glusterfs.peered for 10.167.4.142
2017-11-21 09:31:32,732 [salt.loaded.int.module.cmdmod][INFO    ][29471] Executing command 'gluster --version' in directory '/root'
2017-11-21 09:31:32,743 [salt.loaded.int.module.cmdmod][INFO    ][29471] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-21 09:31:32,886 [salt.loaded.int.module.cmdmod][INFO    ][29471] Executing command 'gluster --version' in directory '/root'
2017-11-21 09:31:32,896 [salt.loaded.int.module.cmdmod][INFO    ][29471] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-21 09:31:32,950 [salt.loaded.int.module.cmdmod][INFO    ][29471] Executing command 'gluster --version' in directory '/root'
2017-11-21 09:31:32,960 [salt.loaded.int.module.cmdmod][INFO    ][29471] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-21 09:31:33,013 [salt.loaded.int.module.cmdmod][INFO    ][29471] Executing command 'gluster --version' in directory '/root'
2017-11-21 09:31:33,021 [salt.loaded.int.module.cmdmod][INFO    ][29471] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-21 09:31:33,072 [salt.state       ][INFO    ][29471] Peering with localhost is not needed
2017-11-21 09:31:33,073 [salt.state       ][INFO    ][29471] Completed state [10.167.4.142] at time 09:31:33.072596 duration_in_ms=341.165
2017-11-21 09:31:33,075 [salt.state       ][INFO    ][29471] Running state [10.167.4.143] at time 09:31:33.074859
2017-11-21 09:31:33,075 [salt.state       ][INFO    ][29471] Executing state glusterfs.peered for 10.167.4.143
2017-11-21 09:31:33,076 [salt.loaded.int.module.cmdmod][INFO    ][29471] Executing command 'gluster --version' in directory '/root'
2017-11-21 09:31:33,084 [salt.loaded.int.module.cmdmod][INFO    ][29471] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-21 09:31:33,135 [salt.loaded.int.module.cmdmod][INFO    ][29471] Executing command 'gluster --version' in directory '/root'
2017-11-21 09:31:33,145 [salt.loaded.int.module.cmdmod][INFO    ][29471] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-21 09:31:33,456 [salt.loaded.int.module.cmdmod][INFO    ][29471] Executing command 'gluster --version' in directory '/root'
2017-11-21 09:31:33,468 [salt.loaded.int.module.cmdmod][INFO    ][29471] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-21 09:31:33,551 [salt.loaded.int.module.cmdmod][INFO    ][29471] Executing command 'gluster --version' in directory '/root'
2017-11-21 09:31:33,560 [salt.loaded.int.module.cmdmod][INFO    ][29471] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-21 09:31:33,708 [salt.state       ][INFO    ][29471] {'new': {'10.167.4.141': [], '10.167.4.143': []}, 'old': {'10.167.4.141': []}}
2017-11-21 09:31:33,708 [salt.state       ][INFO    ][29471] Completed state [10.167.4.143] at time 09:31:33.708390 duration_in_ms=633.53
2017-11-21 09:31:33,709 [salt.state       ][INFO    ][29471] Running state [glance] at time 09:31:33.709308
2017-11-21 09:31:33,710 [salt.state       ][INFO    ][29471] Executing state glusterfs.created for glance
2017-11-21 09:31:33,710 [salt.loaded.int.module.cmdmod][INFO    ][29471] Executing command 'gluster --version' in directory '/root'
2017-11-21 09:31:33,722 [salt.loaded.int.module.cmdmod][INFO    ][29471] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-21 09:31:33,795 [salt.loaded.int.module.cmdmod][INFO    ][29471] Executing command 'gluster --version' in directory '/root'
2017-11-21 09:31:33,805 [salt.loaded.int.module.cmdmod][INFO    ][29471] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-21 09:31:34,638 [salt.loaded.int.module.cmdmod][INFO    ][29471] Executing command 'gluster --version' in directory '/root'
2017-11-21 09:31:34,650 [salt.loaded.int.module.cmdmod][INFO    ][29471] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-21 09:31:35,664 [salt.loaded.int.module.cmdmod][INFO    ][29471] Executing command 'gluster --version' in directory '/root'
2017-11-21 09:31:35,677 [salt.loaded.int.module.cmdmod][INFO    ][29471] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-21 09:31:35,730 [salt.state       ][INFO    ][29471] {'new': ['glance'], 'old': []}
2017-11-21 09:31:35,730 [salt.state       ][INFO    ][29471] Completed state [glance] at time 09:31:35.730418 duration_in_ms=2021.109
2017-11-21 09:31:35,733 [salt.state       ][INFO    ][29471] Running state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 09:31:35.733219
2017-11-21 09:31:35,733 [salt.state       ][INFO    ][29471] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'
2017-11-21 09:31:35,734 [salt.loaded.int.module.cmdmod][INFO    ][29471] Executing command 'gluster volume info 'glance' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-11-21 09:31:35,786 [salt.loaded.int.module.cmdmod][INFO    ][29471] Executing command 'gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'' in directory '/root'
2017-11-21 09:31:36,403 [salt.state       ][INFO    ][29471] {'pid': 29695, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-11-21 09:31:36,404 [salt.state       ][INFO    ][29471] Completed state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 09:31:36.403515 duration_in_ms=670.295
2017-11-21 09:31:36,404 [salt.state       ][INFO    ][29471] Running state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 09:31:36.404071
2017-11-21 09:31:36,404 [salt.state       ][INFO    ][29471] Executing state cmd.run for gluster volume set 'glance' 'network.remote-dio' 'True'
2017-11-21 09:31:36,405 [salt.loaded.int.module.cmdmod][INFO    ][29471] Executing command 'gluster volume info 'glance' | grep 'network.remote-dio: True'' in directory '/root'
2017-11-21 09:31:36,461 [salt.loaded.int.module.cmdmod][INFO    ][29471] Executing command 'gluster volume set 'glance' 'network.remote-dio' 'True'' in directory '/root'
2017-11-21 09:31:37,085 [salt.state       ][INFO    ][29471] {'pid': 29713, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-11-21 09:31:37,085 [salt.state       ][INFO    ][29471] Completed state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 09:31:37.085361 duration_in_ms=681.289
2017-11-21 09:31:37,086 [salt.state       ][INFO    ][29471] Running state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 09:31:37.085955
2017-11-21 09:31:37,086 [salt.state       ][INFO    ][29471] Executing state cmd.run for gluster volume set 'glance' 'nfs.disable' 'True'
2017-11-21 09:31:37,087 [salt.loaded.int.module.cmdmod][INFO    ][29471] Executing command 'gluster volume info 'glance' | grep 'nfs.disable: True'' in directory '/root'
2017-11-21 09:31:37,146 [salt.loaded.int.module.cmdmod][INFO    ][29471] Executing command 'gluster volume set 'glance' 'nfs.disable' 'True'' in directory '/root'
2017-11-21 09:31:39,656 [salt.minion      ][INFO    ][22402] User sudo_ubuntu Executing command saltutil.find_job with jid 20171121093139653447
2017-11-21 09:31:39,670 [salt.minion      ][INFO    ][29741] Starting a new job with PID 29741
2017-11-21 09:31:39,684 [salt.minion      ][INFO    ][29741] Returning information for job: 20171121093139653447
2017-11-21 09:31:39,793 [salt.state       ][INFO    ][29471] {'pid': 29730, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-11-21 09:31:39,793 [salt.state       ][INFO    ][29471] Completed state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 09:31:39.793206 duration_in_ms=2707.251
2017-11-21 09:31:39,794 [salt.state       ][INFO    ][29471] Running state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 09:31:39.793783
2017-11-21 09:31:39,794 [salt.state       ][INFO    ][29471] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'
2017-11-21 09:31:39,795 [salt.loaded.int.module.cmdmod][INFO    ][29471] Executing command 'gluster volume info 'glance' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-11-21 09:31:39,852 [salt.loaded.int.module.cmdmod][INFO    ][29471] Executing command 'gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'' in directory '/root'
2017-11-21 09:31:40,438 [salt.state       ][INFO    ][29471] {'pid': 29756, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-11-21 09:31:40,439 [salt.state       ][INFO    ][29471] Completed state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 09:31:40.438448 duration_in_ms=644.664
2017-11-21 09:31:40,439 [salt.state       ][INFO    ][29471] Running state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 09:31:40.439024
2017-11-21 09:31:40,439 [salt.state       ][INFO    ][29471] Executing state cmd.run for gluster volume set 'glance' 'cluster.readdir-optimize' 'True'
2017-11-21 09:31:40,440 [salt.loaded.int.module.cmdmod][INFO    ][29471] Executing command 'gluster volume info 'glance' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-11-21 09:31:40,497 [salt.loaded.int.module.cmdmod][INFO    ][29471] Executing command 'gluster volume set 'glance' 'cluster.readdir-optimize' 'True'' in directory '/root'
2017-11-21 09:31:41,081 [salt.state       ][INFO    ][29471] {'pid': 29774, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-11-21 09:31:41,082 [salt.state       ][INFO    ][29471] Completed state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 09:31:41.081772 duration_in_ms=642.747
2017-11-21 09:31:41,083 [salt.state       ][INFO    ][29471] Running state [glance] at time 09:31:41.082790
2017-11-21 09:31:41,083 [salt.state       ][INFO    ][29471] Executing state glusterfs.started for glance
2017-11-21 09:31:41,084 [salt.loaded.int.module.cmdmod][INFO    ][29471] Executing command 'gluster --version' in directory '/root'
2017-11-21 09:31:41,094 [salt.loaded.int.module.cmdmod][INFO    ][29471] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-21 09:31:41,148 [salt.loaded.int.module.cmdmod][INFO    ][29471] Executing command 'gluster --version' in directory '/root'
2017-11-21 09:31:41,157 [salt.loaded.int.module.cmdmod][INFO    ][29471] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-21 09:31:41,215 [salt.state       ][INFO    ][29471] Volume glance is already started
2017-11-21 09:31:41,216 [salt.state       ][INFO    ][29471] Completed state [glance] at time 09:31:41.215721 duration_in_ms=132.931
2017-11-21 09:31:41,217 [salt.state       ][INFO    ][29471] Running state [keystone-keys] at time 09:31:41.216589
2017-11-21 09:31:41,217 [salt.state       ][INFO    ][29471] Executing state glusterfs.created for keystone-keys
2017-11-21 09:31:41,217 [salt.loaded.int.module.cmdmod][INFO    ][29471] Executing command 'gluster --version' in directory '/root'
2017-11-21 09:31:41,228 [salt.loaded.int.module.cmdmod][INFO    ][29471] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-21 09:31:41,279 [salt.loaded.int.module.cmdmod][INFO    ][29471] Executing command 'gluster --version' in directory '/root'
2017-11-21 09:31:41,290 [salt.loaded.int.module.cmdmod][INFO    ][29471] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-21 09:31:42,018 [salt.loaded.int.module.cmdmod][INFO    ][29471] Executing command 'gluster --version' in directory '/root'
2017-11-21 09:31:42,030 [salt.loaded.int.module.cmdmod][INFO    ][29471] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-21 09:31:44,832 [salt.loaded.int.module.cmdmod][INFO    ][29471] Executing command 'gluster --version' in directory '/root'
2017-11-21 09:31:44,843 [salt.loaded.int.module.cmdmod][INFO    ][29471] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-21 09:31:44,899 [salt.state       ][INFO    ][29471] {'new': ['glance', 'keystone-keys'], 'old': ['glance']}
2017-11-21 09:31:44,899 [salt.state       ][INFO    ][29471] Completed state [keystone-keys] at time 09:31:44.899309 duration_in_ms=3682.719
2017-11-21 09:31:44,903 [salt.state       ][INFO    ][29471] Running state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 09:31:44.902962
2017-11-21 09:31:44,903 [salt.state       ][INFO    ][29471] Executing state cmd.run for gluster volume set 'keystone-keys' 'network.remote-dio' 'True'
2017-11-21 09:31:44,904 [salt.loaded.int.module.cmdmod][INFO    ][29471] Executing command 'gluster volume info 'keystone-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-11-21 09:31:44,957 [salt.loaded.int.module.cmdmod][INFO    ][29471] Executing command 'gluster volume set 'keystone-keys' 'network.remote-dio' 'True'' in directory '/root'
2017-11-21 09:31:45,611 [salt.state       ][INFO    ][29471] {'pid': 29885, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-11-21 09:31:45,611 [salt.state       ][INFO    ][29471] Completed state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 09:31:45.611262 duration_in_ms=708.299
2017-11-21 09:31:45,612 [salt.state       ][INFO    ][29471] Running state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 09:31:45.611854
2017-11-21 09:31:45,612 [salt.state       ][INFO    ][29471] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-11-21 09:31:45,613 [salt.loaded.int.module.cmdmod][INFO    ][29471] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-11-21 09:31:45,669 [salt.loaded.int.module.cmdmod][INFO    ][29471] Executing command 'gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'' in directory '/root'
2017-11-21 09:31:46,279 [salt.state       ][INFO    ][29471] {'pid': 29902, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-11-21 09:31:46,280 [salt.state       ][INFO    ][29471] Completed state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 09:31:46.279743 duration_in_ms=667.887
2017-11-21 09:31:46,280 [salt.state       ][INFO    ][29471] Running state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 09:31:46.280332
2017-11-21 09:31:46,281 [salt.state       ][INFO    ][29471] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'
2017-11-21 09:31:46,281 [salt.loaded.int.module.cmdmod][INFO    ][29471] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-11-21 09:31:46,336 [salt.loaded.int.module.cmdmod][INFO    ][29471] Executing command 'gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'' in directory '/root'
2017-11-21 09:31:46,964 [salt.state       ][INFO    ][29471] {'pid': 29920, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-11-21 09:31:46,964 [salt.state       ][INFO    ][29471] Completed state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 09:31:46.964253 duration_in_ms=683.92
2017-11-21 09:31:46,965 [salt.state       ][INFO    ][29471] Running state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 09:31:46.964856
2017-11-21 09:31:46,965 [salt.state       ][INFO    ][29471] Executing state cmd.run for gluster volume set 'keystone-keys' 'nfs.disable' 'True'
2017-11-21 09:31:46,966 [salt.loaded.int.module.cmdmod][INFO    ][29471] Executing command 'gluster volume info 'keystone-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-11-21 09:31:47,024 [salt.loaded.int.module.cmdmod][INFO    ][29471] Executing command 'gluster volume set 'keystone-keys' 'nfs.disable' 'True'' in directory '/root'
2017-11-21 09:31:49,715 [salt.state       ][INFO    ][29471] {'pid': 29937, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-11-21 09:31:49,715 [salt.state       ][INFO    ][29471] Completed state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 09:31:49.715126 duration_in_ms=2750.269
2017-11-21 09:31:49,716 [salt.state       ][INFO    ][29471] Running state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 09:31:49.715877
2017-11-21 09:31:49,716 [salt.state       ][INFO    ][29471] Executing state cmd.run for gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'
2017-11-21 09:31:49,717 [salt.loaded.int.module.cmdmod][INFO    ][29471] Executing command 'gluster volume info 'keystone-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-11-21 09:31:49,775 [salt.loaded.int.module.cmdmod][INFO    ][29471] Executing command 'gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'' in directory '/root'
2017-11-21 09:31:49,798 [salt.minion      ][INFO    ][22402] User sudo_ubuntu Executing command saltutil.find_job with jid 20171121093149795169
2017-11-21 09:31:49,812 [salt.minion      ][INFO    ][29962] Starting a new job with PID 29962
2017-11-21 09:31:49,823 [salt.minion      ][INFO    ][29962] Returning information for job: 20171121093149795169
2017-11-21 09:31:50,385 [salt.state       ][INFO    ][29471] {'pid': 29956, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-11-21 09:31:50,386 [salt.state       ][INFO    ][29471] Completed state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 09:31:50.385445 duration_in_ms=669.569
2017-11-21 09:31:50,387 [salt.state       ][INFO    ][29471] Running state [keystone-keys] at time 09:31:50.386506
2017-11-21 09:31:50,387 [salt.state       ][INFO    ][29471] Executing state glusterfs.started for keystone-keys
2017-11-21 09:31:50,388 [salt.loaded.int.module.cmdmod][INFO    ][29471] Executing command 'gluster --version' in directory '/root'
2017-11-21 09:31:50,400 [salt.loaded.int.module.cmdmod][INFO    ][29471] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-21 09:31:50,453 [salt.loaded.int.module.cmdmod][INFO    ][29471] Executing command 'gluster --version' in directory '/root'
2017-11-21 09:31:50,462 [salt.loaded.int.module.cmdmod][INFO    ][29471] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-21 09:31:50,523 [salt.state       ][INFO    ][29471] Volume keystone-keys is already started
2017-11-21 09:31:50,523 [salt.state       ][INFO    ][29471] Completed state [keystone-keys] at time 09:31:50.523051 duration_in_ms=136.543
2017-11-21 09:31:50,525 [salt.state       ][INFO    ][29471] Running state [nova_instances] at time 09:31:50.524898
2017-11-21 09:31:50,525 [salt.state       ][INFO    ][29471] Executing state glusterfs.created for nova_instances
2017-11-21 09:31:50,526 [salt.loaded.int.module.cmdmod][INFO    ][29471] Executing command 'gluster --version' in directory '/root'
2017-11-21 09:31:50,536 [salt.loaded.int.module.cmdmod][INFO    ][29471] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-21 09:31:50,589 [salt.loaded.int.module.cmdmod][INFO    ][29471] Executing command 'gluster --version' in directory '/root'
2017-11-21 09:31:50,598 [salt.loaded.int.module.cmdmod][INFO    ][29471] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-21 09:31:51,362 [salt.loaded.int.module.cmdmod][INFO    ][29471] Executing command 'gluster --version' in directory '/root'
2017-11-21 09:31:51,374 [salt.loaded.int.module.cmdmod][INFO    ][29471] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-21 09:31:54,170 [salt.loaded.int.module.cmdmod][INFO    ][29471] Executing command 'gluster --version' in directory '/root'
2017-11-21 09:31:54,184 [salt.loaded.int.module.cmdmod][INFO    ][29471] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-21 09:31:54,236 [salt.state       ][INFO    ][29471] {'new': ['glance', 'keystone-keys', 'nova_instances'], 'old': ['glance', 'keystone-keys']}
2017-11-21 09:31:54,236 [salt.state       ][INFO    ][29471] Completed state [nova_instances] at time 09:31:54.235982 duration_in_ms=3711.082
2017-11-21 09:31:54,239 [salt.state       ][INFO    ][29471] Running state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 09:31:54.239313
2017-11-21 09:31:54,240 [salt.state       ][INFO    ][29471] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'
2017-11-21 09:31:54,240 [salt.loaded.int.module.cmdmod][INFO    ][29471] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-11-21 09:31:54,293 [salt.loaded.int.module.cmdmod][INFO    ][29471] Executing command 'gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'' in directory '/root'
2017-11-21 09:31:54,953 [salt.state       ][INFO    ][29471] {'pid': 30076, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-11-21 09:31:54,954 [salt.state       ][INFO    ][29471] Completed state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 09:31:54.953522 duration_in_ms=714.208
2017-11-21 09:31:54,954 [salt.state       ][INFO    ][29471] Running state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'On'] at time 09:31:54.954267
2017-11-21 09:31:54,955 [salt.state       ][INFO    ][29471] Executing state cmd.run for gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'On'
2017-11-21 09:31:54,955 [salt.loaded.int.module.cmdmod][INFO    ][29471] Executing command 'gluster volume info 'nova_instances' | grep 'cluster.readdir-optimize: On'' in directory '/root'
2017-11-21 09:31:55,014 [salt.loaded.int.module.cmdmod][INFO    ][29471] Executing command 'gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'On'' in directory '/root'
2017-11-21 09:31:55,658 [salt.state       ][INFO    ][29471] {'pid': 30094, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-11-21 09:31:55,658 [salt.state       ][INFO    ][29471] Completed state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'On'] at time 09:31:55.658020 duration_in_ms=703.754
2017-11-21 09:31:55,659 [salt.state       ][INFO    ][29471] Running state [gluster volume set 'nova_instances' 'network.remote-dio' 'On'] at time 09:31:55.658605
2017-11-21 09:31:55,659 [salt.state       ][INFO    ][29471] Executing state cmd.run for gluster volume set 'nova_instances' 'network.remote-dio' 'On'
2017-11-21 09:31:55,660 [salt.loaded.int.module.cmdmod][INFO    ][29471] Executing command 'gluster volume info 'nova_instances' | grep 'network.remote-dio: On'' in directory '/root'
2017-11-21 09:31:55,718 [salt.loaded.int.module.cmdmod][INFO    ][29471] Executing command 'gluster volume set 'nova_instances' 'network.remote-dio' 'On'' in directory '/root'
2017-11-21 09:31:56,581 [salt.state       ][INFO    ][29471] {'pid': 30111, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-11-21 09:31:56,582 [salt.state       ][INFO    ][29471] Completed state [gluster volume set 'nova_instances' 'network.remote-dio' 'On'] at time 09:31:56.581689 duration_in_ms=923.082
2017-11-21 09:31:56,582 [salt.state       ][INFO    ][29471] Running state [gluster volume set 'nova_instances' 'nfs.disable' 'On'] at time 09:31:56.582290
2017-11-21 09:31:56,583 [salt.state       ][INFO    ][29471] Executing state cmd.run for gluster volume set 'nova_instances' 'nfs.disable' 'On'
2017-11-21 09:31:56,583 [salt.loaded.int.module.cmdmod][INFO    ][29471] Executing command 'gluster volume info 'nova_instances' | grep 'nfs.disable: On'' in directory '/root'
2017-11-21 09:31:56,640 [salt.loaded.int.module.cmdmod][INFO    ][29471] Executing command 'gluster volume set 'nova_instances' 'nfs.disable' 'On'' in directory '/root'
2017-11-21 09:31:59,284 [salt.state       ][INFO    ][29471] {'pid': 30129, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-11-21 09:31:59,284 [salt.state       ][INFO    ][29471] Completed state [gluster volume set 'nova_instances' 'nfs.disable' 'On'] at time 09:31:59.283914 duration_in_ms=2701.624
2017-11-21 09:31:59,285 [salt.state       ][INFO    ][29471] Running state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 09:31:59.284529
2017-11-21 09:31:59,285 [salt.state       ][INFO    ][29471] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'
2017-11-21 09:31:59,285 [salt.loaded.int.module.cmdmod][INFO    ][29471] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-11-21 09:31:59,343 [salt.loaded.int.module.cmdmod][INFO    ][29471] Executing command 'gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'' in directory '/root'
2017-11-21 09:31:59,937 [salt.minion      ][INFO    ][22402] User sudo_ubuntu Executing command saltutil.find_job with jid 20171121093159934059
2017-11-21 09:31:59,950 [salt.minion      ][INFO    ][30159] Starting a new job with PID 30159
2017-11-21 09:31:59,962 [salt.minion      ][INFO    ][30159] Returning information for job: 20171121093159934059
2017-11-21 09:32:00,065 [salt.state       ][INFO    ][29471] {'pid': 30149, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-11-21 09:32:00,065 [salt.state       ][INFO    ][29471] Completed state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 09:32:00.064919 duration_in_ms=780.389
2017-11-21 09:32:00,066 [salt.state       ][INFO    ][29471] Running state [nova_instances] at time 09:32:00.065941
2017-11-21 09:32:00,066 [salt.state       ][INFO    ][29471] Executing state glusterfs.started for nova_instances
2017-11-21 09:32:00,067 [salt.loaded.int.module.cmdmod][INFO    ][29471] Executing command 'gluster --version' in directory '/root'
2017-11-21 09:32:00,078 [salt.loaded.int.module.cmdmod][INFO    ][29471] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-21 09:32:00,132 [salt.loaded.int.module.cmdmod][INFO    ][29471] Executing command 'gluster --version' in directory '/root'
2017-11-21 09:32:00,142 [salt.loaded.int.module.cmdmod][INFO    ][29471] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-21 09:32:00,200 [salt.state       ][INFO    ][29471] Volume nova_instances is already started
2017-11-21 09:32:00,200 [salt.state       ][INFO    ][29471] Completed state [nova_instances] at time 09:32:00.199804 duration_in_ms=133.861
2017-11-21 09:32:00,201 [salt.state       ][INFO    ][29471] Running state [keystone-credential-keys] at time 09:32:00.200791
2017-11-21 09:32:00,201 [salt.state       ][INFO    ][29471] Executing state glusterfs.created for keystone-credential-keys
2017-11-21 09:32:00,202 [salt.loaded.int.module.cmdmod][INFO    ][29471] Executing command 'gluster --version' in directory '/root'
2017-11-21 09:32:00,212 [salt.loaded.int.module.cmdmod][INFO    ][29471] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-21 09:32:00,264 [salt.loaded.int.module.cmdmod][INFO    ][29471] Executing command 'gluster --version' in directory '/root'
2017-11-21 09:32:00,273 [salt.loaded.int.module.cmdmod][INFO    ][29471] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-21 09:32:00,975 [salt.loaded.int.module.cmdmod][INFO    ][29471] Executing command 'gluster --version' in directory '/root'
2017-11-21 09:32:00,987 [salt.loaded.int.module.cmdmod][INFO    ][29471] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-21 09:32:03,863 [salt.loaded.int.module.cmdmod][INFO    ][29471] Executing command 'gluster --version' in directory '/root'
2017-11-21 09:32:03,876 [salt.loaded.int.module.cmdmod][INFO    ][29471] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-21 09:32:03,929 [salt.state       ][INFO    ][29471] {'new': ['glance', 'keystone-credential-keys', 'keystone-keys', 'nova_instances'], 'old': ['glance', 'keystone-keys', 'nova_instances']}
2017-11-21 09:32:03,930 [salt.state       ][INFO    ][29471] Completed state [keystone-credential-keys] at time 09:32:03.929745 duration_in_ms=3728.952
2017-11-21 09:32:03,933 [salt.state       ][INFO    ][29471] Running state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 09:32:03.933358
2017-11-21 09:32:03,934 [salt.state       ][INFO    ][29471] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'
2017-11-21 09:32:03,934 [salt.loaded.int.module.cmdmod][INFO    ][29471] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-11-21 09:32:03,987 [salt.loaded.int.module.cmdmod][INFO    ][29471] Executing command 'gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'' in directory '/root'
2017-11-21 09:32:04,607 [salt.state       ][INFO    ][29471] {'pid': 30271, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-11-21 09:32:04,608 [salt.state       ][INFO    ][29471] Completed state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 09:32:04.607488 duration_in_ms=674.129
2017-11-21 09:32:04,608 [salt.state       ][INFO    ][29471] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 09:32:04.608064
2017-11-21 09:32:04,608 [salt.state       ][INFO    ][29471] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-11-21 09:32:04,609 [salt.loaded.int.module.cmdmod][INFO    ][29471] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-11-21 09:32:04,665 [salt.loaded.int.module.cmdmod][INFO    ][29471] Executing command 'gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'' in directory '/root'
2017-11-21 09:32:05,347 [salt.state       ][INFO    ][29471] {'pid': 30288, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-11-21 09:32:05,347 [salt.state       ][INFO    ][29471] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 09:32:05.347001 duration_in_ms=738.937
2017-11-21 09:32:05,348 [salt.state       ][INFO    ][29471] Running state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 09:32:05.347749
2017-11-21 09:32:05,348 [salt.state       ][INFO    ][29471] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'
2017-11-21 09:32:05,349 [salt.loaded.int.module.cmdmod][INFO    ][29471] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-11-21 09:32:05,407 [salt.loaded.int.module.cmdmod][INFO    ][29471] Executing command 'gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'' in directory '/root'
2017-11-21 09:32:08,085 [salt.state       ][INFO    ][29471] {'pid': 30306, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-11-21 09:32:08,086 [salt.state       ][INFO    ][29471] Completed state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 09:32:08.085613 duration_in_ms=2737.865
2017-11-21 09:32:08,086 [salt.state       ][INFO    ][29471] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 09:32:08.086150
2017-11-21 09:32:08,086 [salt.state       ][INFO    ][29471] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'
2017-11-21 09:32:08,087 [salt.loaded.int.module.cmdmod][INFO    ][29471] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-11-21 09:32:08,140 [salt.loaded.int.module.cmdmod][INFO    ][29471] Executing command 'gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'' in directory '/root'
2017-11-21 09:32:08,797 [salt.state       ][INFO    ][29471] {'pid': 30326, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-11-21 09:32:08,797 [salt.state       ][INFO    ][29471] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 09:32:08.797296 duration_in_ms=711.144
2017-11-21 09:32:08,798 [salt.state       ][INFO    ][29471] Running state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 09:32:08.797858
2017-11-21 09:32:08,798 [salt.state       ][INFO    ][29471] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'
2017-11-21 09:32:08,799 [salt.loaded.int.module.cmdmod][INFO    ][29471] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-11-21 09:32:08,854 [salt.loaded.int.module.cmdmod][INFO    ][29471] Executing command 'gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'' in directory '/root'
2017-11-21 09:32:09,465 [salt.state       ][INFO    ][29471] {'pid': 30344, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-11-21 09:32:09,466 [salt.state       ][INFO    ][29471] Completed state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 09:32:09.465710 duration_in_ms=667.852
2017-11-21 09:32:09,467 [salt.state       ][INFO    ][29471] Running state [keystone-credential-keys] at time 09:32:09.466749
2017-11-21 09:32:09,467 [salt.state       ][INFO    ][29471] Executing state glusterfs.started for keystone-credential-keys
2017-11-21 09:32:09,468 [salt.loaded.int.module.cmdmod][INFO    ][29471] Executing command 'gluster --version' in directory '/root'
2017-11-21 09:32:09,480 [salt.loaded.int.module.cmdmod][INFO    ][29471] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-21 09:32:09,536 [salt.loaded.int.module.cmdmod][INFO    ][29471] Executing command 'gluster --version' in directory '/root'
2017-11-21 09:32:09,545 [salt.loaded.int.module.cmdmod][INFO    ][29471] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-21 09:32:09,605 [salt.state       ][INFO    ][29471] Volume keystone-credential-keys is already started
2017-11-21 09:32:09,605 [salt.state       ][INFO    ][29471] Completed state [keystone-credential-keys] at time 09:32:09.604765 duration_in_ms=138.015
2017-11-21 09:32:09,607 [salt.minion      ][INFO    ][29471] Returning information for job: 20171121093129615520
2017-11-21 09:32:19,804 [salt.minion      ][INFO    ][22402] User sudo_ubuntu Executing command test.ping with jid 20171121093219806109
2017-11-21 09:32:19,818 [salt.minion      ][INFO    ][30373] Starting a new job with PID 30373
2017-11-21 09:32:19,846 [salt.minion      ][INFO    ][30373] Returning information for job: 20171121093219806109
2017-11-21 09:32:19,979 [salt.minion      ][INFO    ][22402] User sudo_ubuntu Executing command cmd.run with jid 20171121093219972094
2017-11-21 09:32:19,992 [salt.minion      ][INFO    ][30378] Starting a new job with PID 30378
2017-11-21 09:32:19,996 [salt.loaded.int.module.cmdmod][INFO    ][30378] Executing command 'gluster peer status; gluster volume status' in directory '/root'
2017-11-21 09:32:20,110 [salt.minion      ][INFO    ][30378] Returning information for job: 20171121093219972094
2017-11-21 10:10:09,600 [salt.utils.schedule][INFO    ][22402] Running scheduled job: __mine_interval
2017-11-21 10:11:50,636 [salt.minion      ][INFO    ][22402] User sudo_ubuntu Executing command test.ping with jid 20171121101150644260
2017-11-21 10:11:50,653 [salt.minion      ][INFO    ][30996] Starting a new job with PID 30996
2017-11-21 10:11:50,708 [salt.minion      ][INFO    ][30996] Returning information for job: 20171121101150644260
2017-11-21 10:12:14,961 [salt.minion      ][INFO    ][22402] User sudo_ubuntu Executing command state.sls with jid 20171121101214964386
2017-11-21 10:12:14,973 [salt.minion      ][INFO    ][31006] Starting a new job with PID 31006
2017-11-21 10:12:15,401 [salt.state       ][INFO    ][31006] Loading fresh modules for state activity
2017-11-21 10:12:15,425 [salt.fileclient  ][INFO    ][31006] Fetching file from saltenv 'base', ** done ** 'keepalived/init.sls'
2017-11-21 10:12:15,444 [salt.fileclient  ][INFO    ][31006] Fetching file from saltenv 'base', ** done ** 'keepalived/cluster.sls'
2017-11-21 10:12:15,467 [salt.fileclient  ][INFO    ][31006] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-11-21 10:12:15,727 [salt.state       ][INFO    ][31006] Running state [lsof] at time 10:12:15.727070
2017-11-21 10:12:15,727 [salt.state       ][INFO    ][31006] Executing state pkg.installed for lsof
2017-11-21 10:12:15,728 [salt.loaded.int.module.cmdmod][INFO    ][31006] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-21 10:12:15,966 [salt.state       ][INFO    ][31006] Package lsof is already installed
2017-11-21 10:12:15,966 [salt.state       ][INFO    ][31006] Completed state [lsof] at time 10:12:15.965922 duration_in_ms=238.852
2017-11-21 10:12:15,966 [salt.state       ][INFO    ][31006] Running state [keepalived] at time 10:12:15.966113
2017-11-21 10:12:15,966 [salt.state       ][INFO    ][31006] Executing state pkg.installed for keepalived
2017-11-21 10:12:15,969 [salt.state       ][INFO    ][31006] Package keepalived is already installed
2017-11-21 10:12:15,969 [salt.state       ][INFO    ][31006] Completed state [keepalived] at time 10:12:15.969088 duration_in_ms=2.975
2017-11-21 10:12:15,970 [salt.state       ][INFO    ][31006] Running state [/etc/keepalived/keepalived.conf] at time 10:12:15.970415
2017-11-21 10:12:15,971 [salt.state       ][INFO    ][31006] Executing state file.managed for /etc/keepalived/keepalived.conf
2017-11-21 10:12:16,027 [salt.fileclient  ][INFO    ][31006] Fetching file from saltenv 'base', ** done ** 'keepalived/files/keepalived.conf'
2017-11-21 10:12:16,058 [salt.fileclient  ][INFO    ][31006] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-11-21 10:12:16,062 [salt.state       ][INFO    ][31006] File /etc/keepalived/keepalived.conf is in the correct state
2017-11-21 10:12:16,062 [salt.state       ][INFO    ][31006] Completed state [/etc/keepalived/keepalived.conf] at time 10:12:16.062209 duration_in_ms=91.794
2017-11-21 10:12:16,063 [salt.state       ][INFO    ][31006] Running state [keepalived] at time 10:12:16.062711
2017-11-21 10:12:16,063 [salt.state       ][INFO    ][31006] Executing state service.running for keepalived
2017-11-21 10:12:16,063 [salt.loaded.int.module.cmdmod][INFO    ][31006] Executing command ['systemctl', 'status', 'keepalived.service', '-n', '0'] in directory '/root'
2017-11-21 10:12:16,080 [salt.loaded.int.module.cmdmod][INFO    ][31006] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2017-11-21 10:12:16,088 [salt.loaded.int.module.cmdmod][INFO    ][31006] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-11-21 10:12:16,096 [salt.state       ][INFO    ][31006] The service keepalived is already running
2017-11-21 10:12:16,096 [salt.state       ][INFO    ][31006] Completed state [keepalived] at time 10:12:16.096214 duration_in_ms=33.502
2017-11-21 10:12:16,097 [salt.minion      ][INFO    ][31006] Returning information for job: 20171121101214964386
2017-11-21 10:12:21,075 [salt.minion      ][INFO    ][22402] User sudo_ubuntu Executing command pillar.get with jid 20171121101221078428
2017-11-21 10:12:21,091 [salt.minion      ][INFO    ][31030] Starting a new job with PID 31030
2017-11-21 10:12:21,096 [salt.minion      ][INFO    ][31030] Returning information for job: 20171121101221078428
2017-11-21 10:12:57,403 [salt.minion      ][INFO    ][22402] User sudo_ubuntu Executing command state.sls with jid 20171121101257407267
2017-11-21 10:12:57,417 [salt.minion      ][INFO    ][31040] Starting a new job with PID 31040
2017-11-21 10:12:57,841 [salt.state       ][INFO    ][31040] Loading fresh modules for state activity
2017-11-21 10:12:57,886 [salt.fileclient  ][INFO    ][31040] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-11-21 10:12:57,905 [salt.fileclient  ][INFO    ][31040] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-11-21 10:12:58,172 [salt.state       ][INFO    ][31040] Running state [attr] at time 10:12:58.171850
2017-11-21 10:12:58,172 [salt.state       ][INFO    ][31040] Executing state pkg.installed for attr
2017-11-21 10:12:58,172 [salt.loaded.int.module.cmdmod][INFO    ][31040] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-21 10:12:58,440 [salt.state       ][INFO    ][31040] Package attr is already installed
2017-11-21 10:12:58,440 [salt.state       ][INFO    ][31040] Completed state [attr] at time 10:12:58.440412 duration_in_ms=268.562
2017-11-21 10:12:58,441 [salt.state       ][INFO    ][31040] Running state [glusterfs-server] at time 10:12:58.440610
2017-11-21 10:12:58,441 [salt.state       ][INFO    ][31040] Executing state pkg.installed for glusterfs-server
2017-11-21 10:12:58,443 [salt.state       ][INFO    ][31040] Package glusterfs-server is already installed
2017-11-21 10:12:58,443 [salt.state       ][INFO    ][31040] Completed state [glusterfs-server] at time 10:12:58.443456 duration_in_ms=2.846
2017-11-21 10:12:58,444 [salt.state       ][INFO    ][31040] Running state [bc] at time 10:12:58.443591
2017-11-21 10:12:58,444 [salt.state       ][INFO    ][31040] Executing state pkg.installed for bc
2017-11-21 10:12:58,446 [salt.state       ][INFO    ][31040] Package bc is already installed
2017-11-21 10:12:58,446 [salt.state       ][INFO    ][31040] Completed state [bc] at time 10:12:58.446419 duration_in_ms=2.828
2017-11-21 10:12:58,447 [salt.state       ][INFO    ][31040] Running state [glusterfs-server] at time 10:12:58.447060
2017-11-21 10:12:58,447 [salt.state       ][INFO    ][31040] Executing state service.running for glusterfs-server
2017-11-21 10:12:58,448 [salt.loaded.int.module.cmdmod][INFO    ][31040] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-11-21 10:12:58,464 [salt.loaded.int.module.cmdmod][INFO    ][31040] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-11-21 10:12:58,472 [salt.loaded.int.module.cmdmod][INFO    ][31040] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-11-21 10:12:58,481 [salt.state       ][INFO    ][31040] The service glusterfs-server is already running
2017-11-21 10:12:58,481 [salt.state       ][INFO    ][31040] Completed state [glusterfs-server] at time 10:12:58.481249 duration_in_ms=34.189
2017-11-21 10:12:58,483 [salt.state       ][INFO    ][31040] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 10:12:58.482599
2017-11-21 10:12:58,483 [salt.state       ][INFO    ][31040] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-11-21 10:12:58,491 [salt.state       ][INFO    ][31040] File /etc/systemd/system/glusterfs-server.service.d/override.conf is in the correct state
2017-11-21 10:12:58,491 [salt.state       ][INFO    ][31040] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 10:12:58.491460 duration_in_ms=8.861
2017-11-21 10:12:58,492 [salt.state       ][INFO    ][31040] Running state [/srv/glusterfs/glance] at time 10:12:58.491606
2017-11-21 10:12:58,492 [salt.state       ][INFO    ][31040] Executing state file.directory for /srv/glusterfs/glance
2017-11-21 10:12:58,492 [salt.state       ][INFO    ][31040] Directory /srv/glusterfs/glance is in the correct state
2017-11-21 10:12:58,492 [salt.state       ][INFO    ][31040] Completed state [/srv/glusterfs/glance] at time 10:12:58.492230 duration_in_ms=0.625
2017-11-21 10:12:58,492 [salt.state       ][INFO    ][31040] Running state [/srv/glusterfs/keystone-keys] at time 10:12:58.492367
2017-11-21 10:12:58,493 [salt.state       ][INFO    ][31040] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-11-21 10:12:58,493 [salt.state       ][INFO    ][31040] Directory /srv/glusterfs/keystone-keys is in the correct state
2017-11-21 10:12:58,493 [salt.state       ][INFO    ][31040] Completed state [/srv/glusterfs/keystone-keys] at time 10:12:58.492944 duration_in_ms=0.577
2017-11-21 10:12:58,493 [salt.state       ][INFO    ][31040] Running state [/srv/glusterfs/nova_instances] at time 10:12:58.493080
2017-11-21 10:12:58,493 [salt.state       ][INFO    ][31040] Executing state file.directory for /srv/glusterfs/nova_instances
2017-11-21 10:12:58,494 [salt.state       ][INFO    ][31040] Directory /srv/glusterfs/nova_instances is in the correct state
2017-11-21 10:12:58,494 [salt.state       ][INFO    ][31040] Completed state [/srv/glusterfs/nova_instances] at time 10:12:58.493620 duration_in_ms=0.54
2017-11-21 10:12:58,494 [salt.state       ][INFO    ][31040] Running state [/srv/glusterfs/keystone-credential-keys] at time 10:12:58.493753
2017-11-21 10:12:58,494 [salt.state       ][INFO    ][31040] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-11-21 10:12:58,494 [salt.state       ][INFO    ][31040] Directory /srv/glusterfs/keystone-credential-keys is in the correct state
2017-11-21 10:12:58,494 [salt.state       ][INFO    ][31040] Completed state [/srv/glusterfs/keystone-credential-keys] at time 10:12:58.494351 duration_in_ms=0.597
2017-11-21 10:12:58,495 [salt.minion      ][INFO    ][31040] Returning information for job: 20171121101257407267
2017-11-21 10:12:59,726 [salt.minion      ][INFO    ][22402] User sudo_ubuntu Executing command test.ping with jid 20171121101259728831
2017-11-21 10:12:59,739 [salt.minion      ][INFO    ][31063] Starting a new job with PID 31063
2017-11-21 10:12:59,766 [salt.minion      ][INFO    ][31063] Returning information for job: 20171121101259728831
2017-11-21 10:12:59,901 [salt.minion      ][INFO    ][22402] User sudo_ubuntu Executing command state.sls with jid 20171121101259903572
2017-11-21 10:12:59,913 [salt.minion      ][INFO    ][31068] Starting a new job with PID 31068
2017-11-21 10:13:01,496 [salt.state       ][INFO    ][31068] Loading fresh modules for state activity
2017-11-21 10:13:01,518 [salt.fileclient  ][INFO    ][31068] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/setup.sls'
2017-11-21 10:13:01,553 [salt.fileclient  ][INFO    ][31068] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-11-21 10:13:01,619 [salt.fileclient  ][INFO    ][31068] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-11-21 10:13:01,639 [salt.fileclient  ][INFO    ][31068] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-11-21 10:13:01,917 [salt.state       ][INFO    ][31068] Running state [attr] at time 10:13:01.917410
2017-11-21 10:13:01,918 [salt.state       ][INFO    ][31068] Executing state pkg.installed for attr
2017-11-21 10:13:01,918 [salt.loaded.int.module.cmdmod][INFO    ][31068] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-21 10:13:02,193 [salt.state       ][INFO    ][31068] Package attr is already installed
2017-11-21 10:13:02,193 [salt.state       ][INFO    ][31068] Completed state [attr] at time 10:13:02.193250 duration_in_ms=275.839
2017-11-21 10:13:02,193 [salt.state       ][INFO    ][31068] Running state [glusterfs-server] at time 10:13:02.193452
2017-11-21 10:13:02,194 [salt.state       ][INFO    ][31068] Executing state pkg.installed for glusterfs-server
2017-11-21 10:13:02,196 [salt.state       ][INFO    ][31068] Package glusterfs-server is already installed
2017-11-21 10:13:02,196 [salt.state       ][INFO    ][31068] Completed state [glusterfs-server] at time 10:13:02.196384 duration_in_ms=2.932
2017-11-21 10:13:02,197 [salt.state       ][INFO    ][31068] Running state [bc] at time 10:13:02.196524
2017-11-21 10:13:02,197 [salt.state       ][INFO    ][31068] Executing state pkg.installed for bc
2017-11-21 10:13:02,199 [salt.state       ][INFO    ][31068] Package bc is already installed
2017-11-21 10:13:02,199 [salt.state       ][INFO    ][31068] Completed state [bc] at time 10:13:02.199358 duration_in_ms=2.834
2017-11-21 10:13:02,200 [salt.state       ][INFO    ][31068] Running state [glusterfs-server] at time 10:13:02.200128
2017-11-21 10:13:02,200 [salt.state       ][INFO    ][31068] Executing state service.running for glusterfs-server
2017-11-21 10:13:02,201 [salt.loaded.int.module.cmdmod][INFO    ][31068] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-11-21 10:13:02,217 [salt.loaded.int.module.cmdmod][INFO    ][31068] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-11-21 10:13:02,225 [salt.loaded.int.module.cmdmod][INFO    ][31068] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-11-21 10:13:02,234 [salt.state       ][INFO    ][31068] The service glusterfs-server is already running
2017-11-21 10:13:02,234 [salt.state       ][INFO    ][31068] Completed state [glusterfs-server] at time 10:13:02.234187 duration_in_ms=34.059
2017-11-21 10:13:02,236 [salt.state       ][INFO    ][31068] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 10:13:02.235532
2017-11-21 10:13:02,236 [salt.state       ][INFO    ][31068] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-11-21 10:13:02,248 [salt.state       ][INFO    ][31068] File /etc/systemd/system/glusterfs-server.service.d/override.conf is in the correct state
2017-11-21 10:13:02,248 [salt.state       ][INFO    ][31068] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 10:13:02.248386 duration_in_ms=12.854
2017-11-21 10:13:02,249 [salt.state       ][INFO    ][31068] Running state [/srv/glusterfs/glance] at time 10:13:02.248533
2017-11-21 10:13:02,249 [salt.state       ][INFO    ][31068] Executing state file.directory for /srv/glusterfs/glance
2017-11-21 10:13:02,249 [salt.state       ][INFO    ][31068] Directory /srv/glusterfs/glance is in the correct state
2017-11-21 10:13:02,249 [salt.state       ][INFO    ][31068] Completed state [/srv/glusterfs/glance] at time 10:13:02.249133 duration_in_ms=0.6
2017-11-21 10:13:02,249 [salt.state       ][INFO    ][31068] Running state [/srv/glusterfs/keystone-keys] at time 10:13:02.249272
2017-11-21 10:13:02,249 [salt.state       ][INFO    ][31068] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-11-21 10:13:02,250 [salt.state       ][INFO    ][31068] Directory /srv/glusterfs/keystone-keys is in the correct state
2017-11-21 10:13:02,250 [salt.state       ][INFO    ][31068] Completed state [/srv/glusterfs/keystone-keys] at time 10:13:02.249859 duration_in_ms=0.588
2017-11-21 10:13:02,250 [salt.state       ][INFO    ][31068] Running state [/srv/glusterfs/nova_instances] at time 10:13:02.249998
2017-11-21 10:13:02,250 [salt.state       ][INFO    ][31068] Executing state file.directory for /srv/glusterfs/nova_instances
2017-11-21 10:13:02,250 [salt.state       ][INFO    ][31068] Directory /srv/glusterfs/nova_instances is in the correct state
2017-11-21 10:13:02,251 [salt.state       ][INFO    ][31068] Completed state [/srv/glusterfs/nova_instances] at time 10:13:02.250544 duration_in_ms=0.546
2017-11-21 10:13:02,251 [salt.state       ][INFO    ][31068] Running state [/srv/glusterfs/keystone-credential-keys] at time 10:13:02.250683
2017-11-21 10:13:02,251 [salt.state       ][INFO    ][31068] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-11-21 10:13:02,251 [salt.state       ][INFO    ][31068] Directory /srv/glusterfs/keystone-credential-keys is in the correct state
2017-11-21 10:13:02,251 [salt.state       ][INFO    ][31068] Completed state [/srv/glusterfs/keystone-credential-keys] at time 10:13:02.251271 duration_in_ms=0.588
2017-11-21 10:13:02,287 [salt.loaded.int.module.cmdmod][INFO    ][31068] Executing command ['git', '--version'] in directory '/root'
2017-11-21 10:13:02,371 [salt.state       ][INFO    ][31068] Running state [sleep 5] at time 10:13:02.370959
2017-11-21 10:13:02,371 [salt.state       ][INFO    ][31068] Executing state cmd.wait for sleep 5
2017-11-21 10:13:02,371 [salt.state       ][INFO    ][31068] No changes made for sleep 5
2017-11-21 10:13:02,372 [salt.state       ][INFO    ][31068] Completed state [sleep 5] at time 10:13:02.371528 duration_in_ms=0.569
2017-11-21 10:13:02,372 [salt.state       ][INFO    ][31068] Running state [10.167.4.141] at time 10:13:02.371890
2017-11-21 10:13:02,372 [salt.state       ][INFO    ][31068] Executing state glusterfs.peered for 10.167.4.141
2017-11-21 10:13:02,372 [salt.loaded.int.module.cmdmod][INFO    ][31068] Executing command 'gluster --version' in directory '/root'
2017-11-21 10:13:02,383 [salt.loaded.int.module.cmdmod][INFO    ][31068] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-21 10:13:02,434 [salt.state       ][INFO    ][31068] Host 10.167.4.141 already peered
2017-11-21 10:13:02,434 [salt.state       ][INFO    ][31068] Completed state [10.167.4.141] at time 10:13:02.433955 duration_in_ms=62.065
2017-11-21 10:13:02,436 [salt.state       ][INFO    ][31068] Running state [10.167.4.142] at time 10:13:02.436117
2017-11-21 10:13:02,436 [salt.state       ][INFO    ][31068] Executing state glusterfs.peered for 10.167.4.142
2017-11-21 10:13:02,437 [salt.loaded.int.module.cmdmod][INFO    ][31068] Executing command 'gluster --version' in directory '/root'
2017-11-21 10:13:02,446 [salt.loaded.int.module.cmdmod][INFO    ][31068] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-21 10:13:02,498 [salt.loaded.int.module.cmdmod][INFO    ][31068] Executing command 'gluster --version' in directory '/root'
2017-11-21 10:13:02,507 [salt.loaded.int.module.cmdmod][INFO    ][31068] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-21 10:13:02,558 [salt.loaded.int.module.cmdmod][INFO    ][31068] Executing command 'gluster --version' in directory '/root'
2017-11-21 10:13:02,567 [salt.loaded.int.module.cmdmod][INFO    ][31068] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-21 10:13:02,616 [salt.loaded.int.module.cmdmod][INFO    ][31068] Executing command 'gluster --version' in directory '/root'
2017-11-21 10:13:02,625 [salt.loaded.int.module.cmdmod][INFO    ][31068] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-21 10:13:02,673 [salt.state       ][INFO    ][31068] Peering with localhost is not needed
2017-11-21 10:13:02,673 [salt.state       ][INFO    ][31068] Completed state [10.167.4.142] at time 10:13:02.672845 duration_in_ms=236.727
2017-11-21 10:13:02,675 [salt.state       ][INFO    ][31068] Running state [10.167.4.143] at time 10:13:02.675045
2017-11-21 10:13:02,675 [salt.state       ][INFO    ][31068] Executing state glusterfs.peered for 10.167.4.143
2017-11-21 10:13:02,676 [salt.loaded.int.module.cmdmod][INFO    ][31068] Executing command 'gluster --version' in directory '/root'
2017-11-21 10:13:02,684 [salt.loaded.int.module.cmdmod][INFO    ][31068] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-21 10:13:02,731 [salt.state       ][INFO    ][31068] Host 10.167.4.143 already peered
2017-11-21 10:13:02,731 [salt.state       ][INFO    ][31068] Completed state [10.167.4.143] at time 10:13:02.731042 duration_in_ms=55.996
2017-11-21 10:13:02,732 [salt.state       ][INFO    ][31068] Running state [glance] at time 10:13:02.731891
2017-11-21 10:13:02,732 [salt.state       ][INFO    ][31068] Executing state glusterfs.created for glance
2017-11-21 10:13:02,733 [salt.loaded.int.module.cmdmod][INFO    ][31068] Executing command 'gluster --version' in directory '/root'
2017-11-21 10:13:02,741 [salt.loaded.int.module.cmdmod][INFO    ][31068] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-21 10:13:02,788 [salt.loaded.int.module.cmdmod][INFO    ][31068] Executing command 'gluster --version' in directory '/root'
2017-11-21 10:13:02,797 [salt.loaded.int.module.cmdmod][INFO    ][31068] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-21 10:13:02,853 [salt.state       ][INFO    ][31068] Volume glance already exists and is started.
2017-11-21 10:13:02,853 [salt.state       ][INFO    ][31068] Completed state [glance] at time 10:13:02.853440 duration_in_ms=121.548
2017-11-21 10:13:02,856 [salt.state       ][INFO    ][31068] Running state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 10:13:02.855974
2017-11-21 10:13:02,856 [salt.state       ][INFO    ][31068] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'
2017-11-21 10:13:02,857 [salt.loaded.int.module.cmdmod][INFO    ][31068] Executing command 'gluster volume info 'glance' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-11-21 10:13:02,904 [salt.state       ][INFO    ][31068] unless execution succeeded
2017-11-21 10:13:02,904 [salt.state       ][INFO    ][31068] Completed state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 10:13:02.904320 duration_in_ms=48.344
2017-11-21 10:13:02,905 [salt.state       ][INFO    ][31068] Running state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 10:13:02.904814
2017-11-21 10:13:02,905 [salt.state       ][INFO    ][31068] Executing state cmd.run for gluster volume set 'glance' 'network.remote-dio' 'True'
2017-11-21 10:13:02,906 [salt.loaded.int.module.cmdmod][INFO    ][31068] Executing command 'gluster volume info 'glance' | grep 'network.remote-dio: True'' in directory '/root'
2017-11-21 10:13:02,958 [salt.state       ][INFO    ][31068] unless execution succeeded
2017-11-21 10:13:02,958 [salt.state       ][INFO    ][31068] Completed state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 10:13:02.957709 duration_in_ms=52.895
2017-11-21 10:13:02,958 [salt.state       ][INFO    ][31068] Running state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 10:13:02.958127
2017-11-21 10:13:02,958 [salt.state       ][INFO    ][31068] Executing state cmd.run for gluster volume set 'glance' 'nfs.disable' 'True'
2017-11-21 10:13:02,959 [salt.loaded.int.module.cmdmod][INFO    ][31068] Executing command 'gluster volume info 'glance' | grep 'nfs.disable: True'' in directory '/root'
2017-11-21 10:13:03,006 [salt.state       ][INFO    ][31068] unless execution succeeded
2017-11-21 10:13:03,006 [salt.state       ][INFO    ][31068] Completed state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 10:13:03.005733 duration_in_ms=47.606
2017-11-21 10:13:03,006 [salt.state       ][INFO    ][31068] Running state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 10:13:03.006148
2017-11-21 10:13:03,006 [salt.state       ][INFO    ][31068] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'
2017-11-21 10:13:03,007 [salt.loaded.int.module.cmdmod][INFO    ][31068] Executing command 'gluster volume info 'glance' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-11-21 10:13:03,053 [salt.state       ][INFO    ][31068] unless execution succeeded
2017-11-21 10:13:03,053 [salt.state       ][INFO    ][31068] Completed state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 10:13:03.052892 duration_in_ms=46.742
2017-11-21 10:13:03,053 [salt.state       ][INFO    ][31068] Running state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 10:13:03.053333
2017-11-21 10:13:03,054 [salt.state       ][INFO    ][31068] Executing state cmd.run for gluster volume set 'glance' 'cluster.readdir-optimize' 'True'
2017-11-21 10:13:03,054 [salt.loaded.int.module.cmdmod][INFO    ][31068] Executing command 'gluster volume info 'glance' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-11-21 10:13:03,102 [salt.state       ][INFO    ][31068] unless execution succeeded
2017-11-21 10:13:03,102 [salt.state       ][INFO    ][31068] Completed state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 10:13:03.101880 duration_in_ms=48.545
2017-11-21 10:13:03,103 [salt.state       ][INFO    ][31068] Running state [glance] at time 10:13:03.102822
2017-11-21 10:13:03,103 [salt.state       ][INFO    ][31068] Executing state glusterfs.started for glance
2017-11-21 10:13:03,103 [salt.loaded.int.module.cmdmod][INFO    ][31068] Executing command 'gluster --version' in directory '/root'
2017-11-21 10:13:03,112 [salt.loaded.int.module.cmdmod][INFO    ][31068] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-21 10:13:03,160 [salt.loaded.int.module.cmdmod][INFO    ][31068] Executing command 'gluster --version' in directory '/root'
2017-11-21 10:13:03,169 [salt.loaded.int.module.cmdmod][INFO    ][31068] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-21 10:13:03,221 [salt.state       ][INFO    ][31068] Volume glance is already started
2017-11-21 10:13:03,221 [salt.state       ][INFO    ][31068] Completed state [glance] at time 10:13:03.221418 duration_in_ms=118.595
2017-11-21 10:13:03,222 [salt.state       ][INFO    ][31068] Running state [keystone-keys] at time 10:13:03.222213
2017-11-21 10:13:03,222 [salt.state       ][INFO    ][31068] Executing state glusterfs.created for keystone-keys
2017-11-21 10:13:03,223 [salt.loaded.int.module.cmdmod][INFO    ][31068] Executing command 'gluster --version' in directory '/root'
2017-11-21 10:13:03,231 [salt.loaded.int.module.cmdmod][INFO    ][31068] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-21 10:13:03,278 [salt.loaded.int.module.cmdmod][INFO    ][31068] Executing command 'gluster --version' in directory '/root'
2017-11-21 10:13:03,287 [salt.loaded.int.module.cmdmod][INFO    ][31068] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-21 10:13:03,338 [salt.state       ][INFO    ][31068] Volume keystone-keys already exists and is started.
2017-11-21 10:13:03,339 [salt.state       ][INFO    ][31068] Completed state [keystone-keys] at time 10:13:03.338508 duration_in_ms=116.294
2017-11-21 10:13:03,341 [salt.state       ][INFO    ][31068] Running state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 10:13:03.341222
2017-11-21 10:13:03,341 [salt.state       ][INFO    ][31068] Executing state cmd.run for gluster volume set 'keystone-keys' 'network.remote-dio' 'True'
2017-11-21 10:13:03,342 [salt.loaded.int.module.cmdmod][INFO    ][31068] Executing command 'gluster volume info 'keystone-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-11-21 10:13:03,389 [salt.state       ][INFO    ][31068] unless execution succeeded
2017-11-21 10:13:03,390 [salt.state       ][INFO    ][31068] Completed state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 10:13:03.389487 duration_in_ms=48.265
2017-11-21 10:13:03,390 [salt.state       ][INFO    ][31068] Running state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 10:13:03.389957
2017-11-21 10:13:03,390 [salt.state       ][INFO    ][31068] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-11-21 10:13:03,391 [salt.loaded.int.module.cmdmod][INFO    ][31068] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-11-21 10:13:03,439 [salt.state       ][INFO    ][31068] unless execution succeeded
2017-11-21 10:13:03,439 [salt.state       ][INFO    ][31068] Completed state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 10:13:03.438816 duration_in_ms=48.858
2017-11-21 10:13:03,439 [salt.state       ][INFO    ][31068] Running state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 10:13:03.439257
2017-11-21 10:13:03,439 [salt.state       ][INFO    ][31068] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'
2017-11-21 10:13:03,440 [salt.loaded.int.module.cmdmod][INFO    ][31068] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-11-21 10:13:03,487 [salt.state       ][INFO    ][31068] unless execution succeeded
2017-11-21 10:13:03,487 [salt.state       ][INFO    ][31068] Completed state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 10:13:03.487131 duration_in_ms=47.873
2017-11-21 10:13:03,488 [salt.state       ][INFO    ][31068] Running state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 10:13:03.487605
2017-11-21 10:13:03,488 [salt.state       ][INFO    ][31068] Executing state cmd.run for gluster volume set 'keystone-keys' 'nfs.disable' 'True'
2017-11-21 10:13:03,488 [salt.loaded.int.module.cmdmod][INFO    ][31068] Executing command 'gluster volume info 'keystone-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-11-21 10:13:03,536 [salt.state       ][INFO    ][31068] unless execution succeeded
2017-11-21 10:13:03,536 [salt.state       ][INFO    ][31068] Completed state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 10:13:03.535702 duration_in_ms=48.097
2017-11-21 10:13:03,536 [salt.state       ][INFO    ][31068] Running state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 10:13:03.536136
2017-11-21 10:13:03,536 [salt.state       ][INFO    ][31068] Executing state cmd.run for gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'
2017-11-21 10:13:03,537 [salt.loaded.int.module.cmdmod][INFO    ][31068] Executing command 'gluster volume info 'keystone-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-11-21 10:13:03,585 [salt.state       ][INFO    ][31068] unless execution succeeded
2017-11-21 10:13:03,585 [salt.state       ][INFO    ][31068] Completed state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 10:13:03.585029 duration_in_ms=48.892
2017-11-21 10:13:03,586 [salt.state       ][INFO    ][31068] Running state [keystone-keys] at time 10:13:03.585902
2017-11-21 10:13:03,586 [salt.state       ][INFO    ][31068] Executing state glusterfs.started for keystone-keys
2017-11-21 10:13:03,586 [salt.loaded.int.module.cmdmod][INFO    ][31068] Executing command 'gluster --version' in directory '/root'
2017-11-21 10:13:03,593 [salt.loaded.int.module.cmdmod][INFO    ][31068] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-21 10:13:03,639 [salt.loaded.int.module.cmdmod][INFO    ][31068] Executing command 'gluster --version' in directory '/root'
2017-11-21 10:13:03,647 [salt.loaded.int.module.cmdmod][INFO    ][31068] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-21 10:13:03,697 [salt.state       ][INFO    ][31068] Volume keystone-keys is already started
2017-11-21 10:13:03,697 [salt.state       ][INFO    ][31068] Completed state [keystone-keys] at time 10:13:03.697264 duration_in_ms=111.361
2017-11-21 10:13:03,698 [salt.state       ][INFO    ][31068] Running state [nova_instances] at time 10:13:03.698258
2017-11-21 10:13:03,698 [salt.state       ][INFO    ][31068] Executing state glusterfs.created for nova_instances
2017-11-21 10:13:03,699 [salt.loaded.int.module.cmdmod][INFO    ][31068] Executing command 'gluster --version' in directory '/root'
2017-11-21 10:13:03,708 [salt.loaded.int.module.cmdmod][INFO    ][31068] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-21 10:13:03,758 [salt.loaded.int.module.cmdmod][INFO    ][31068] Executing command 'gluster --version' in directory '/root'
2017-11-21 10:13:03,767 [salt.loaded.int.module.cmdmod][INFO    ][31068] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-21 10:13:03,817 [salt.state       ][INFO    ][31068] Volume nova_instances already exists and is started.
2017-11-21 10:13:03,817 [salt.state       ][INFO    ][31068] Completed state [nova_instances] at time 10:13:03.817189 duration_in_ms=118.93
2017-11-21 10:13:03,820 [salt.state       ][INFO    ][31068] Running state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 10:13:03.820093
2017-11-21 10:13:03,820 [salt.state       ][INFO    ][31068] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'
2017-11-21 10:13:03,821 [salt.loaded.int.module.cmdmod][INFO    ][31068] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-11-21 10:13:03,871 [salt.state       ][INFO    ][31068] unless execution succeeded
2017-11-21 10:13:03,872 [salt.state       ][INFO    ][31068] Completed state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 10:13:03.871599 duration_in_ms=51.505
2017-11-21 10:13:03,872 [salt.state       ][INFO    ][31068] Running state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'On'] at time 10:13:03.872020
2017-11-21 10:13:03,872 [salt.state       ][INFO    ][31068] Executing state cmd.run for gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'On'
2017-11-21 10:13:03,873 [salt.loaded.int.module.cmdmod][INFO    ][31068] Executing command 'gluster volume info 'nova_instances' | grep 'cluster.readdir-optimize: On'' in directory '/root'
2017-11-21 10:13:03,920 [salt.state       ][INFO    ][31068] unless execution succeeded
2017-11-21 10:13:03,920 [salt.state       ][INFO    ][31068] Completed state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'On'] at time 10:13:03.920193 duration_in_ms=48.171
2017-11-21 10:13:03,921 [salt.state       ][INFO    ][31068] Running state [gluster volume set 'nova_instances' 'network.remote-dio' 'On'] at time 10:13:03.920634
2017-11-21 10:13:03,921 [salt.state       ][INFO    ][31068] Executing state cmd.run for gluster volume set 'nova_instances' 'network.remote-dio' 'On'
2017-11-21 10:13:03,921 [salt.loaded.int.module.cmdmod][INFO    ][31068] Executing command 'gluster volume info 'nova_instances' | grep 'network.remote-dio: On'' in directory '/root'
2017-11-21 10:13:03,969 [salt.state       ][INFO    ][31068] unless execution succeeded
2017-11-21 10:13:03,969 [salt.state       ][INFO    ][31068] Completed state [gluster volume set 'nova_instances' 'network.remote-dio' 'On'] at time 10:13:03.969073 duration_in_ms=48.439
2017-11-21 10:13:03,970 [salt.state       ][INFO    ][31068] Running state [gluster volume set 'nova_instances' 'nfs.disable' 'On'] at time 10:13:03.969548
2017-11-21 10:13:03,970 [salt.state       ][INFO    ][31068] Executing state cmd.run for gluster volume set 'nova_instances' 'nfs.disable' 'On'
2017-11-21 10:13:03,970 [salt.loaded.int.module.cmdmod][INFO    ][31068] Executing command 'gluster volume info 'nova_instances' | grep 'nfs.disable: On'' in directory '/root'
2017-11-21 10:13:04,017 [salt.state       ][INFO    ][31068] unless execution succeeded
2017-11-21 10:13:04,017 [salt.state       ][INFO    ][31068] Completed state [gluster volume set 'nova_instances' 'nfs.disable' 'On'] at time 10:13:04.017077 duration_in_ms=47.529
2017-11-21 10:13:04,018 [salt.state       ][INFO    ][31068] Running state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 10:13:04.017578
2017-11-21 10:13:04,018 [salt.state       ][INFO    ][31068] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'
2017-11-21 10:13:04,018 [salt.loaded.int.module.cmdmod][INFO    ][31068] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-11-21 10:13:04,071 [salt.state       ][INFO    ][31068] unless execution succeeded
2017-11-21 10:13:04,071 [salt.state       ][INFO    ][31068] Completed state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 10:13:04.071364 duration_in_ms=53.785
2017-11-21 10:13:04,072 [salt.state       ][INFO    ][31068] Running state [nova_instances] at time 10:13:04.072281
2017-11-21 10:13:04,073 [salt.state       ][INFO    ][31068] Executing state glusterfs.started for nova_instances
2017-11-21 10:13:04,073 [salt.loaded.int.module.cmdmod][INFO    ][31068] Executing command 'gluster --version' in directory '/root'
2017-11-21 10:13:04,081 [salt.loaded.int.module.cmdmod][INFO    ][31068] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-21 10:13:04,130 [salt.loaded.int.module.cmdmod][INFO    ][31068] Executing command 'gluster --version' in directory '/root'
2017-11-21 10:13:04,139 [salt.loaded.int.module.cmdmod][INFO    ][31068] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-21 10:13:04,199 [salt.state       ][INFO    ][31068] Volume nova_instances is already started
2017-11-21 10:13:04,199 [salt.state       ][INFO    ][31068] Completed state [nova_instances] at time 10:13:04.198954 duration_in_ms=126.672
2017-11-21 10:13:04,200 [salt.state       ][INFO    ][31068] Running state [keystone-credential-keys] at time 10:13:04.199863
2017-11-21 10:13:04,200 [salt.state       ][INFO    ][31068] Executing state glusterfs.created for keystone-credential-keys
2017-11-21 10:13:04,201 [salt.loaded.int.module.cmdmod][INFO    ][31068] Executing command 'gluster --version' in directory '/root'
2017-11-21 10:13:04,210 [salt.loaded.int.module.cmdmod][INFO    ][31068] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-21 10:13:04,257 [salt.loaded.int.module.cmdmod][INFO    ][31068] Executing command 'gluster --version' in directory '/root'
2017-11-21 10:13:04,266 [salt.loaded.int.module.cmdmod][INFO    ][31068] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-21 10:13:04,319 [salt.state       ][INFO    ][31068] Volume keystone-credential-keys already exists and is started.
2017-11-21 10:13:04,319 [salt.state       ][INFO    ][31068] Completed state [keystone-credential-keys] at time 10:13:04.318776 duration_in_ms=118.911
2017-11-21 10:13:04,322 [salt.state       ][INFO    ][31068] Running state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 10:13:04.322129
2017-11-21 10:13:04,322 [salt.state       ][INFO    ][31068] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'
2017-11-21 10:13:04,323 [salt.loaded.int.module.cmdmod][INFO    ][31068] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-11-21 10:13:04,370 [salt.state       ][INFO    ][31068] unless execution succeeded
2017-11-21 10:13:04,370 [salt.state       ][INFO    ][31068] Completed state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 10:13:04.370170 duration_in_ms=48.041
2017-11-21 10:13:04,371 [salt.state       ][INFO    ][31068] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 10:13:04.370629
2017-11-21 10:13:04,371 [salt.state       ][INFO    ][31068] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-11-21 10:13:04,371 [salt.loaded.int.module.cmdmod][INFO    ][31068] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-11-21 10:13:04,418 [salt.state       ][INFO    ][31068] unless execution succeeded
2017-11-21 10:13:04,418 [salt.state       ][INFO    ][31068] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 10:13:04.418448 duration_in_ms=47.819
2017-11-21 10:13:04,419 [salt.state       ][INFO    ][31068] Running state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 10:13:04.418898
2017-11-21 10:13:04,419 [salt.state       ][INFO    ][31068] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'
2017-11-21 10:13:04,420 [salt.loaded.int.module.cmdmod][INFO    ][31068] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-11-21 10:13:04,467 [salt.state       ][INFO    ][31068] unless execution succeeded
2017-11-21 10:13:04,467 [salt.state       ][INFO    ][31068] Completed state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 10:13:04.467369 duration_in_ms=48.47
2017-11-21 10:13:04,468 [salt.state       ][INFO    ][31068] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 10:13:04.467811
2017-11-21 10:13:04,468 [salt.state       ][INFO    ][31068] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'
2017-11-21 10:13:04,468 [salt.loaded.int.module.cmdmod][INFO    ][31068] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-11-21 10:13:04,519 [salt.state       ][INFO    ][31068] unless execution succeeded
2017-11-21 10:13:04,519 [salt.state       ][INFO    ][31068] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 10:13:04.519253 duration_in_ms=51.442
2017-11-21 10:13:04,520 [salt.state       ][INFO    ][31068] Running state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 10:13:04.519673
2017-11-21 10:13:04,520 [salt.state       ][INFO    ][31068] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'
2017-11-21 10:13:04,520 [salt.loaded.int.module.cmdmod][INFO    ][31068] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-11-21 10:13:04,566 [salt.state       ][INFO    ][31068] unless execution succeeded
2017-11-21 10:13:04,567 [salt.state       ][INFO    ][31068] Completed state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 10:13:04.566684 duration_in_ms=47.009
2017-11-21 10:13:04,568 [salt.state       ][INFO    ][31068] Running state [keystone-credential-keys] at time 10:13:04.567619
2017-11-21 10:13:04,568 [salt.state       ][INFO    ][31068] Executing state glusterfs.started for keystone-credential-keys
2017-11-21 10:13:04,568 [salt.loaded.int.module.cmdmod][INFO    ][31068] Executing command 'gluster --version' in directory '/root'
2017-11-21 10:13:04,576 [salt.loaded.int.module.cmdmod][INFO    ][31068] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-21 10:13:04,624 [salt.loaded.int.module.cmdmod][INFO    ][31068] Executing command 'gluster --version' in directory '/root'
2017-11-21 10:13:04,632 [salt.loaded.int.module.cmdmod][INFO    ][31068] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-21 10:13:04,685 [salt.state       ][INFO    ][31068] Volume keystone-credential-keys is already started
2017-11-21 10:13:04,685 [salt.state       ][INFO    ][31068] Completed state [keystone-credential-keys] at time 10:13:04.685107 duration_in_ms=117.486
2017-11-21 10:13:04,687 [salt.minion      ][INFO    ][31068] Returning information for job: 20171121101259903572
2017-11-21 10:13:13,368 [salt.minion      ][INFO    ][22402] User sudo_ubuntu Executing command test.ping with jid 20171121101313369681
2017-11-21 10:13:13,381 [salt.minion      ][INFO    ][31451] Starting a new job with PID 31451
2017-11-21 10:13:13,408 [salt.minion      ][INFO    ][31451] Returning information for job: 20171121101313369681
2017-11-21 10:13:13,537 [salt.minion      ][INFO    ][22402] User sudo_ubuntu Executing command cmd.run with jid 20171121101313539575
2017-11-21 10:13:13,549 [salt.minion      ][INFO    ][31456] Starting a new job with PID 31456
2017-11-21 10:13:13,555 [salt.loaded.int.module.cmdmod][INFO    ][31456] Executing command 'gluster peer status; gluster volume status' in directory '/root'
2017-11-21 10:13:13,659 [salt.minion      ][INFO    ][31456] Returning information for job: 20171121101313539575
2017-11-21 11:09:58,111 [salt.minion      ][INFO    ][22402] User sudo_ubuntu Executing command cp.push_dir with jid 20171121110958109250
2017-11-21 11:09:58,128 [salt.minion      ][INFO    ][31955] Starting a new job with PID 31955
