2017-10-29 14:48:13,806 [salt.cli.daemons ][WARNING ][2780] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-10-29 14:48:24,782 [salt.state       ][ERROR   ][3793] No contents found in top file
2017-10-29 14:50:09,209 [salt.utils.parsers][WARNING ][2780] Minion received a SIGTERM. Exiting.
2017-10-29 14:52:31,624 [salt.cli.daemons ][WARNING ][3328] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-10-29 14:55:21,513 [salt.loaded.int.module.cmdmod][ERROR   ][10260] Command 'virsh net-destroy default 2>&1 1>/dev/null; virsh net-undefine default' failed with return code: 1
2017-10-29 14:55:21,514 [salt.loaded.int.module.cmdmod][ERROR   ][10260] stderr: error: failed to get network 'default'
error: Network not found: no network with matching name 'default'
2017-10-29 14:55:21,514 [salt.loaded.int.module.cmdmod][ERROR   ][10260] retcode: 1
2017-10-29 14:55:21,514 [salt.state       ][ERROR   ][10260] {'pid': 15097, 'retcode': 1, 'stderr': "error: failed to get network 'default'\nerror: Network not found: no network with matching name 'default'", 'stdout': ''}
2017-10-29 14:55:42,578 [py.warnings      ][WARNING ][15174] /usr/lib/python2.7/dist-packages/salt/utils/templates.py:73: DeprecationWarning: Starting in 2015.5, cmd.run uses python_shell=False by default, which doesn't support shellisms (pipes, env variables, etc). cmd.run is currently aliased to cmd.shell to prevent breakage. Please switch to cmd.shell or set python_shell=True to avoid breakage in the future, when this aliasing is removed.

2017-10-29 14:56:50,075 [salt.loaded.int.module.cmdmod][ERROR   ][15174] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-10-29 14:56:50,075 [salt.loaded.int.module.cmdmod][ERROR   ][15174] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-10-29 14:56:56,659 [salt.loaded.int.module.cmdmod][ERROR   ][15174] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-10-29 14:56:56,659 [salt.loaded.int.module.cmdmod][ERROR   ][15174] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-10-29 14:57:04,308 [salt.loaded.int.module.cmdmod][ERROR   ][15174] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-10-29 14:57:04,308 [salt.loaded.int.module.cmdmod][ERROR   ][15174] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-10-29 14:57:12,186 [salt.loaded.int.module.cmdmod][ERROR   ][15174] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-10-29 14:57:12,187 [salt.loaded.int.module.cmdmod][ERROR   ][15174] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-10-29 14:57:22,003 [salt.loaded.int.module.cmdmod][ERROR   ][15174] Command 'while true; do salt-call saltutil.running|grep fun: && continue; salt-call --local service.restart salt-minion; break; done' failed with return code: None
2017-10-29 14:57:24,206 [salt.loaded.int.module.cmdmod][INFO    ][22451] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2017-10-29 14:57:24,213 [salt.loaded.int.module.cmdmod][INFO    ][22451] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2017-10-29 14:57:24,222 [salt.loaded.int.module.cmdmod][INFO    ][22451] Executing command ['systemd-run', '--scope', 'systemctl', 'restart', 'salt-minion.service'] in directory '/root'
2017-10-29 14:57:24,230 [salt.utils.parsers][WARNING ][3328] Minion received a SIGTERM. Exiting.
2017-10-29 14:57:24,480 [salt.cli.daemons ][INFO    ][22539] Setting up the Salt Minion "kvm02.baremetal-mcp-ocata-ovs-ha.local"
2017-10-29 14:57:25,002 [salt.minion      ][INFO    ][22539] Creating minion process manager
2017-10-29 14:57:25,003 [salt.cli.daemons ][WARNING ][22539] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-10-29 14:57:25,003 [salt.cli.daemons ][INFO    ][22539] The Salt Minion is starting up
2017-10-29 14:57:25,003 [salt.minion      ][INFO    ][22539] Minion is starting as user 'root'
2017-10-29 14:57:25,004 [salt.utils.event ][INFO    ][22539] Starting pull socket on /var/run/salt/minion/minion_event_a1b2f32648_pull.ipc
2017-10-29 14:57:25,877 [salt.loaded.int.module.cmdmod][INFO    ][22539] Executing command ['date', '+%z'] in directory '/root'
2017-10-29 14:57:25,886 [salt.utils.schedule][INFO    ][22539] Updating job settings for scheduled job: __mine_interval
2017-10-29 14:57:25,888 [salt.minion      ][INFO    ][22539] Added mine.update to scheduler
2017-10-29 14:57:26,024 [salt.minion      ][INFO    ][22539] Minion is ready to receive requests!
2017-10-29 14:57:26,063 [salt.minion      ][INFO    ][22539] User sudo_ubuntu Executing command saltutil.sync_all with jid 20171029145726063603
2017-10-29 14:57:26,075 [salt.minion      ][INFO    ][22658] Starting a new job with PID 22658
2017-10-29 14:57:27,026 [salt.utils.schedule][INFO    ][22539] Running scheduled job: __mine_interval
2017-10-29 14:57:27,442 [salt.state       ][INFO    ][22658] Loading fresh modules for state activity
2017-10-29 14:57:27,463 [salt.state       ][ERROR   ][22658] No contents found in top file
2017-10-29 14:57:27,463 [salt.utils.extmods][INFO    ][22658] Creating module dir '/var/cache/salt/minion/extmods/beacons'
2017-10-29 14:57:27,466 [salt.utils.extmods][INFO    ][22658] Syncing beacons for environment 'base'
2017-10-29 14:57:27,466 [salt.utils.extmods][INFO    ][22658] Loading cache from salt://_beacons, for base)
2017-10-29 14:57:27,466 [salt.fileclient  ][INFO    ][22658] Caching directory '_beacons/' for environment 'base'
2017-10-29 14:57:27,488 [salt.utils.extmods][INFO    ][22658] Syncing modules for environment 'base'
2017-10-29 14:57:27,488 [salt.utils.extmods][INFO    ][22658] Loading cache from salt://_modules, for base)
2017-10-29 14:57:27,488 [salt.fileclient  ][INFO    ][22658] Caching directory '_modules/' for environment 'base'
2017-10-29 14:57:27,523 [salt.fileclient  ][INFO    ][22658] Fetching file from saltenv 'base', ** done ** '_modules/ceph_ng.py'
2017-10-29 14:57:27,532 [salt.fileclient  ][INFO    ][22658] Fetching file from saltenv 'base', ** done ** '_modules/cinderng.py'
2017-10-29 14:57:27,543 [salt.fileclient  ][INFO    ][22658] Fetching file from saltenv 'base', ** done ** '_modules/contrail.py'
2017-10-29 14:57:27,552 [salt.fileclient  ][INFO    ][22658] Fetching file from saltenv 'base', ** done ** '_modules/creds.py'
2017-10-29 14:57:27,560 [salt.fileclient  ][INFO    ][22658] Fetching file from saltenv 'base', ** done ** '_modules/devops_utils.py'
2017-10-29 14:57:27,989 [salt.fileclient  ][INFO    ][22658] Fetching file from saltenv 'base', ** done ** '_modules/encode_json.py'
2017-10-29 14:57:28,001 [salt.fileclient  ][INFO    ][22658] Fetching file from saltenv 'base', ** done ** '_modules/gerrit.py'
2017-10-29 14:57:28,013 [salt.fileclient  ][INFO    ][22658] Fetching file from saltenv 'base', ** done ** '_modules/glanceng.py'
2017-10-29 14:57:28,024 [salt.fileclient  ][INFO    ][22658] Fetching file from saltenv 'base', ** done ** '_modules/heat.py'
2017-10-29 14:57:28,035 [salt.fileclient  ][INFO    ][22658] Fetching file from saltenv 'base', ** done ** '_modules/heka_alarming.py'
2017-10-29 14:57:28,046 [salt.fileclient  ][INFO    ][22658] Fetching file from saltenv 'base', ** done ** '_modules/helm.py'
2017-10-29 14:57:28,057 [salt.fileclient  ][INFO    ][22658] Fetching file from saltenv 'base', ** done ** '_modules/jenkins_common.py'
2017-10-29 14:57:28,068 [salt.fileclient  ][INFO    ][22658] Fetching file from saltenv 'base', ** done ** '_modules/keystone_policy.py'
2017-10-29 14:57:28,079 [salt.fileclient  ][INFO    ][22658] Fetching file from saltenv 'base', ** done ** '_modules/linux_hosts.py'
2017-10-29 14:57:28,089 [salt.fileclient  ][INFO    ][22658] Fetching file from saltenv 'base', ** done ** '_modules/linux_netlink.py'
2017-10-29 14:57:28,100 [salt.fileclient  ][INFO    ][22658] Fetching file from saltenv 'base', ** done ** '_modules/maas.py'
2017-10-29 14:57:28,111 [salt.fileclient  ][INFO    ][22658] Fetching file from saltenv 'base', ** done ** '_modules/maas_client.py'
2017-10-29 14:57:28,121 [salt.fileclient  ][INFO    ][22658] Fetching file from saltenv 'base', ** done ** '_modules/multipart.py'
2017-10-29 14:57:28,131 [salt.fileclient  ][INFO    ][22658] Fetching file from saltenv 'base', ** done ** '_modules/nagios_alarming.py'
2017-10-29 14:57:28,141 [salt.fileclient  ][INFO    ][22658] Fetching file from saltenv 'base', ** done ** '_modules/neutronng.py'
2017-10-29 14:57:28,155 [salt.fileclient  ][INFO    ][22658] Fetching file from saltenv 'base', ** done ** '_modules/novang.py'
2017-10-29 14:57:28,166 [salt.fileclient  ][INFO    ][22658] Fetching file from saltenv 'base', ** done ** '_modules/reclass.py'
2017-10-29 14:57:28,178 [salt.fileclient  ][INFO    ][22658] Fetching file from saltenv 'base', ** done ** '_modules/rsyslog_util.py'
2017-10-29 14:57:28,188 [salt.fileclient  ][INFO    ][22658] Fetching file from saltenv 'base', ** done ** '_modules/rundeck.py'
2017-10-29 14:57:28,197 [salt.fileclient  ][INFO    ][22658] Fetching file from saltenv 'base', ** done ** '_modules/saltkey.py'
2017-10-29 14:57:28,207 [salt.fileclient  ][INFO    ][22658] Fetching file from saltenv 'base', ** done ** '_modules/saltresource.py'
2017-10-29 14:57:28,216 [salt.fileclient  ][INFO    ][22658] Fetching file from saltenv 'base', ** done ** '_modules/seedng.py'
2017-10-29 14:57:28,231 [salt.fileclient  ][INFO    ][22658] Fetching file from saltenv 'base', ** done ** '_modules/testing/credentials.py'
2017-10-29 14:57:28,241 [salt.fileclient  ][INFO    ][22658] Fetching file from saltenv 'base', ** done ** '_modules/testing/django.py'
2017-10-29 14:57:28,250 [salt.fileclient  ][INFO    ][22658] Fetching file from saltenv 'base', ** done ** '_modules/testing/django_client_proxy.py'
2017-10-29 14:57:28,406 [salt.fileclient  ][INFO    ][22658] Fetching file from saltenv 'base', ** done ** '_modules/utils.py'
2017-10-29 14:57:28,418 [salt.fileclient  ][INFO    ][22658] Fetching file from saltenv 'base', ** done ** '_modules/virtng.py'
2017-10-29 14:57:28,421 [salt.utils.extmods][INFO    ][22658] Copying '/var/cache/salt/minion/files/base/_modules/__init__.py' to '/var/cache/salt/minion/extmods/modules/__init__.py'
2017-10-29 14:57:28,421 [salt.utils.extmods][INFO    ][22658] Copying '/var/cache/salt/minion/files/base/_modules/ceph_ng.py' to '/var/cache/salt/minion/extmods/modules/ceph_ng.py'
2017-10-29 14:57:28,421 [salt.utils.extmods][INFO    ][22658] Copying '/var/cache/salt/minion/files/base/_modules/cinderng.py' to '/var/cache/salt/minion/extmods/modules/cinderng.py'
2017-10-29 14:57:28,422 [salt.utils.extmods][INFO    ][22658] Copying '/var/cache/salt/minion/files/base/_modules/contrail.py' to '/var/cache/salt/minion/extmods/modules/contrail.py'
2017-10-29 14:57:28,422 [salt.utils.extmods][INFO    ][22658] Copying '/var/cache/salt/minion/files/base/_modules/creds.py' to '/var/cache/salt/minion/extmods/modules/creds.py'
2017-10-29 14:57:28,422 [salt.utils.extmods][INFO    ][22658] Copying '/var/cache/salt/minion/files/base/_modules/devops_utils.py' to '/var/cache/salt/minion/extmods/modules/devops_utils.py'
2017-10-29 14:57:28,423 [salt.utils.extmods][INFO    ][22658] Copying '/var/cache/salt/minion/files/base/_modules/encode_json.py' to '/var/cache/salt/minion/extmods/modules/encode_json.py'
2017-10-29 14:57:28,423 [salt.utils.extmods][INFO    ][22658] Copying '/var/cache/salt/minion/files/base/_modules/gerrit.py' to '/var/cache/salt/minion/extmods/modules/gerrit.py'
2017-10-29 14:57:28,423 [salt.utils.extmods][INFO    ][22658] Copying '/var/cache/salt/minion/files/base/_modules/glanceng.py' to '/var/cache/salt/minion/extmods/modules/glanceng.py'
2017-10-29 14:57:28,423 [salt.utils.extmods][INFO    ][22658] Copying '/var/cache/salt/minion/files/base/_modules/heat.py' to '/var/cache/salt/minion/extmods/modules/heat.py'
2017-10-29 14:57:28,424 [salt.utils.extmods][INFO    ][22658] Copying '/var/cache/salt/minion/files/base/_modules/heka_alarming.py' to '/var/cache/salt/minion/extmods/modules/heka_alarming.py'
2017-10-29 14:57:28,424 [salt.utils.extmods][INFO    ][22658] Copying '/var/cache/salt/minion/files/base/_modules/helm.py' to '/var/cache/salt/minion/extmods/modules/helm.py'
2017-10-29 14:57:28,424 [salt.utils.extmods][INFO    ][22658] Copying '/var/cache/salt/minion/files/base/_modules/jenkins_common.py' to '/var/cache/salt/minion/extmods/modules/jenkins_common.py'
2017-10-29 14:57:28,424 [salt.utils.extmods][INFO    ][22658] Copying '/var/cache/salt/minion/files/base/_modules/keystone_policy.py' to '/var/cache/salt/minion/extmods/modules/keystone_policy.py'
2017-10-29 14:57:28,425 [salt.utils.extmods][INFO    ][22658] Copying '/var/cache/salt/minion/files/base/_modules/linux_hosts.py' to '/var/cache/salt/minion/extmods/modules/linux_hosts.py'
2017-10-29 14:57:28,425 [salt.utils.extmods][INFO    ][22658] Copying '/var/cache/salt/minion/files/base/_modules/linux_netlink.py' to '/var/cache/salt/minion/extmods/modules/linux_netlink.py'
2017-10-29 14:57:28,425 [salt.utils.extmods][INFO    ][22658] Copying '/var/cache/salt/minion/files/base/_modules/maas.py' to '/var/cache/salt/minion/extmods/modules/maas.py'
2017-10-29 14:57:28,425 [salt.utils.extmods][INFO    ][22658] Copying '/var/cache/salt/minion/files/base/_modules/maas_client.py' to '/var/cache/salt/minion/extmods/modules/maas_client.py'
2017-10-29 14:57:28,426 [salt.utils.extmods][INFO    ][22658] Copying '/var/cache/salt/minion/files/base/_modules/multipart.py' to '/var/cache/salt/minion/extmods/modules/multipart.py'
2017-10-29 14:57:28,426 [salt.utils.extmods][INFO    ][22658] Copying '/var/cache/salt/minion/files/base/_modules/nagios_alarming.py' to '/var/cache/salt/minion/extmods/modules/nagios_alarming.py'
2017-10-29 14:57:28,426 [salt.utils.extmods][INFO    ][22658] Copying '/var/cache/salt/minion/files/base/_modules/neutronng.py' to '/var/cache/salt/minion/extmods/modules/neutronng.py'
2017-10-29 14:57:28,427 [salt.utils.extmods][INFO    ][22658] Copying '/var/cache/salt/minion/files/base/_modules/novang.py' to '/var/cache/salt/minion/extmods/modules/novang.py'
2017-10-29 14:57:28,427 [salt.utils.extmods][INFO    ][22658] Copying '/var/cache/salt/minion/files/base/_modules/reclass.py' to '/var/cache/salt/minion/extmods/modules/reclass.py'
2017-10-29 14:57:28,427 [salt.utils.extmods][INFO    ][22658] Copying '/var/cache/salt/minion/files/base/_modules/rsyslog_util.py' to '/var/cache/salt/minion/extmods/modules/rsyslog_util.py'
2017-10-29 14:57:28,428 [salt.utils.extmods][INFO    ][22658] Copying '/var/cache/salt/minion/files/base/_modules/rundeck.py' to '/var/cache/salt/minion/extmods/modules/rundeck.py'
2017-10-29 14:57:28,428 [salt.utils.extmods][INFO    ][22658] Copying '/var/cache/salt/minion/files/base/_modules/saltkey.py' to '/var/cache/salt/minion/extmods/modules/saltkey.py'
2017-10-29 14:57:28,428 [salt.utils.extmods][INFO    ][22658] Copying '/var/cache/salt/minion/files/base/_modules/saltresource.py' to '/var/cache/salt/minion/extmods/modules/saltresource.py'
2017-10-29 14:57:28,428 [salt.utils.extmods][INFO    ][22658] Copying '/var/cache/salt/minion/files/base/_modules/seedng.py' to '/var/cache/salt/minion/extmods/modules/seedng.py'
2017-10-29 14:57:28,429 [salt.utils.extmods][INFO    ][22658] Copying '/var/cache/salt/minion/files/base/_modules/testing/__init__.py' to '/var/cache/salt/minion/extmods/modules/testing/__init__.py'
2017-10-29 14:57:28,429 [salt.utils.extmods][INFO    ][22658] Copying '/var/cache/salt/minion/files/base/_modules/testing/credentials.py' to '/var/cache/salt/minion/extmods/modules/testing/credentials.py'
2017-10-29 14:57:28,429 [salt.utils.extmods][INFO    ][22658] Copying '/var/cache/salt/minion/files/base/_modules/testing/django.py' to '/var/cache/salt/minion/extmods/modules/testing/django.py'
2017-10-29 14:57:28,429 [salt.utils.extmods][INFO    ][22658] Copying '/var/cache/salt/minion/files/base/_modules/testing/django_client_proxy.py' to '/var/cache/salt/minion/extmods/modules/testing/django_client_proxy.py'
2017-10-29 14:57:28,430 [salt.utils.extmods][INFO    ][22658] Copying '/var/cache/salt/minion/files/base/_modules/utils.py' to '/var/cache/salt/minion/extmods/modules/utils.py'
2017-10-29 14:57:28,430 [salt.utils.extmods][INFO    ][22658] Copying '/var/cache/salt/minion/files/base/_modules/virtng.py' to '/var/cache/salt/minion/extmods/modules/virtng.py'
2017-10-29 14:57:28,435 [salt.utils.extmods][INFO    ][22658] Syncing states for environment 'base'
2017-10-29 14:57:28,435 [salt.utils.extmods][INFO    ][22658] Loading cache from salt://_states, for base)
2017-10-29 14:57:28,435 [salt.fileclient  ][INFO    ][22658] Caching directory '_states/' for environment 'base'
2017-10-29 14:57:28,544 [salt.fileclient  ][INFO    ][22658] Fetching file from saltenv 'base', ** done ** '_states/cinderng.py'
2017-10-29 14:57:28,554 [salt.fileclient  ][INFO    ][22658] Fetching file from saltenv 'base', ** done ** '_states/contrail.py'
2017-10-29 14:57:28,563 [salt.fileclient  ][INFO    ][22658] Fetching file from saltenv 'base', ** done ** '_states/gerrit.py'
2017-10-29 14:57:28,572 [salt.fileclient  ][INFO    ][22658] Fetching file from saltenv 'base', ** done ** '_states/glanceng.py'
2017-10-29 14:57:28,583 [salt.fileclient  ][INFO    ][22658] Fetching file from saltenv 'base', ** done ** '_states/grafana3_dashboard.py'
2017-10-29 14:57:28,593 [salt.fileclient  ][INFO    ][22658] Fetching file from saltenv 'base', ** done ** '_states/grafana3_datasource.py'
2017-10-29 14:57:28,602 [salt.fileclient  ][INFO    ][22658] Fetching file from saltenv 'base', ** done ** '_states/heat.py'
2017-10-29 14:57:28,614 [salt.fileclient  ][INFO    ][22658] Fetching file from saltenv 'base', ** done ** '_states/helm_release.py'
2017-10-29 14:57:28,624 [salt.fileclient  ][INFO    ][22658] Fetching file from saltenv 'base', ** done ** '_states/jenkins_approval.py'
2017-10-29 14:57:28,635 [salt.fileclient  ][INFO    ][22658] Fetching file from saltenv 'base', ** done ** '_states/jenkins_artifactory.py'
2017-10-29 14:57:28,649 [salt.fileclient  ][INFO    ][22658] Fetching file from saltenv 'base', ** done ** '_states/jenkins_credential.py'
2017-10-29 14:57:28,660 [salt.fileclient  ][INFO    ][22658] Fetching file from saltenv 'base', ** done ** '_states/jenkins_job.py'
2017-10-29 14:57:28,671 [salt.fileclient  ][INFO    ][22658] Fetching file from saltenv 'base', ** done ** '_states/jenkins_lib.py'
2017-10-29 14:57:28,683 [salt.fileclient  ][INFO    ][22658] Fetching file from saltenv 'base', ** done ** '_states/jenkins_node.py'
2017-10-29 14:57:28,695 [salt.fileclient  ][INFO    ][22658] Fetching file from saltenv 'base', ** done ** '_states/jenkins_plugin.py'
2017-10-29 14:57:28,706 [salt.fileclient  ][INFO    ][22658] Fetching file from saltenv 'base', ** done ** '_states/jenkins_security.py'
2017-10-29 14:57:28,717 [salt.fileclient  ][INFO    ][22658] Fetching file from saltenv 'base', ** done ** '_states/jenkins_slack.py'
2017-10-29 14:57:28,729 [salt.fileclient  ][INFO    ][22658] Fetching file from saltenv 'base', ** done ** '_states/jenkins_smtp.py'
2017-10-29 14:57:28,739 [salt.fileclient  ][INFO    ][22658] Fetching file from saltenv 'base', ** done ** '_states/jenkins_theme.py'
2017-10-29 14:57:28,751 [salt.fileclient  ][INFO    ][22658] Fetching file from saltenv 'base', ** done ** '_states/jenkins_user.py'
2017-10-29 14:57:28,763 [salt.fileclient  ][INFO    ][22658] Fetching file from saltenv 'base', ** done ** '_states/jenkins_view.py'
2017-10-29 14:57:28,775 [salt.fileclient  ][INFO    ][22658] Fetching file from saltenv 'base', ** done ** '_states/keystone_policy.py'
2017-10-29 14:57:28,786 [salt.fileclient  ][INFO    ][22658] Fetching file from saltenv 'base', ** done ** '_states/kibana_object.py'
2017-10-29 14:57:28,807 [salt.fileclient  ][INFO    ][22658] Fetching file from saltenv 'base', ** done ** '_states/neutronng.py'
2017-10-29 14:57:28,819 [salt.fileclient  ][INFO    ][22658] Fetching file from saltenv 'base', ** done ** '_states/novang.py'
2017-10-29 14:57:28,830 [salt.fileclient  ][INFO    ][22658] Fetching file from saltenv 'base', ** done ** '_states/reclass.py'
2017-10-29 14:57:28,844 [salt.fileclient  ][INFO    ][22658] Fetching file from saltenv 'base', ** done ** '_states/rundeck_project.py'
2017-10-29 14:57:28,857 [salt.fileclient  ][INFO    ][22658] Fetching file from saltenv 'base', ** done ** '_states/rundeck_scm.py'
2017-10-29 14:57:28,870 [salt.fileclient  ][INFO    ][22658] Fetching file from saltenv 'base', ** done ** '_states/rundeck_secret.py'
2017-10-29 14:57:28,874 [salt.utils.extmods][INFO    ][22658] Copying '/var/cache/salt/minion/files/base/_states/cinderng.py' to '/var/cache/salt/minion/extmods/states/cinderng.py'
2017-10-29 14:57:28,874 [salt.utils.extmods][INFO    ][22658] Copying '/var/cache/salt/minion/files/base/_states/contrail.py' to '/var/cache/salt/minion/extmods/states/contrail.py'
2017-10-29 14:57:28,874 [salt.utils.extmods][INFO    ][22658] Copying '/var/cache/salt/minion/files/base/_states/gerrit.py' to '/var/cache/salt/minion/extmods/states/gerrit.py'
2017-10-29 14:57:28,875 [salt.utils.extmods][INFO    ][22658] Copying '/var/cache/salt/minion/files/base/_states/glanceng.py' to '/var/cache/salt/minion/extmods/states/glanceng.py'
2017-10-29 14:57:28,875 [salt.utils.extmods][INFO    ][22658] Copying '/var/cache/salt/minion/files/base/_states/grafana3_dashboard.py' to '/var/cache/salt/minion/extmods/states/grafana3_dashboard.py'
2017-10-29 14:57:28,875 [salt.utils.extmods][INFO    ][22658] Copying '/var/cache/salt/minion/files/base/_states/grafana3_datasource.py' to '/var/cache/salt/minion/extmods/states/grafana3_datasource.py'
2017-10-29 14:57:28,875 [salt.utils.extmods][INFO    ][22658] Copying '/var/cache/salt/minion/files/base/_states/heat.py' to '/var/cache/salt/minion/extmods/states/heat.py'
2017-10-29 14:57:28,876 [salt.utils.extmods][INFO    ][22658] Copying '/var/cache/salt/minion/files/base/_states/helm_release.py' to '/var/cache/salt/minion/extmods/states/helm_release.py'
2017-10-29 14:57:28,876 [salt.utils.extmods][INFO    ][22658] Copying '/var/cache/salt/minion/files/base/_states/jenkins_approval.py' to '/var/cache/salt/minion/extmods/states/jenkins_approval.py'
2017-10-29 14:57:28,876 [salt.utils.extmods][INFO    ][22658] Copying '/var/cache/salt/minion/files/base/_states/jenkins_artifactory.py' to '/var/cache/salt/minion/extmods/states/jenkins_artifactory.py'
2017-10-29 14:57:28,876 [salt.utils.extmods][INFO    ][22658] Copying '/var/cache/salt/minion/files/base/_states/jenkins_credential.py' to '/var/cache/salt/minion/extmods/states/jenkins_credential.py'
2017-10-29 14:57:28,877 [salt.utils.extmods][INFO    ][22658] Copying '/var/cache/salt/minion/files/base/_states/jenkins_job.py' to '/var/cache/salt/minion/extmods/states/jenkins_job.py'
2017-10-29 14:57:28,877 [salt.utils.extmods][INFO    ][22658] Copying '/var/cache/salt/minion/files/base/_states/jenkins_lib.py' to '/var/cache/salt/minion/extmods/states/jenkins_lib.py'
2017-10-29 14:57:28,877 [salt.utils.extmods][INFO    ][22658] Copying '/var/cache/salt/minion/files/base/_states/jenkins_node.py' to '/var/cache/salt/minion/extmods/states/jenkins_node.py'
2017-10-29 14:57:28,878 [salt.utils.extmods][INFO    ][22658] Copying '/var/cache/salt/minion/files/base/_states/jenkins_plugin.py' to '/var/cache/salt/minion/extmods/states/jenkins_plugin.py'
2017-10-29 14:57:28,878 [salt.utils.extmods][INFO    ][22658] Copying '/var/cache/salt/minion/files/base/_states/jenkins_security.py' to '/var/cache/salt/minion/extmods/states/jenkins_security.py'
2017-10-29 14:57:28,878 [salt.utils.extmods][INFO    ][22658] Copying '/var/cache/salt/minion/files/base/_states/jenkins_slack.py' to '/var/cache/salt/minion/extmods/states/jenkins_slack.py'
2017-10-29 14:57:28,878 [salt.utils.extmods][INFO    ][22658] Copying '/var/cache/salt/minion/files/base/_states/jenkins_smtp.py' to '/var/cache/salt/minion/extmods/states/jenkins_smtp.py'
2017-10-29 14:57:28,879 [salt.utils.extmods][INFO    ][22658] Copying '/var/cache/salt/minion/files/base/_states/jenkins_theme.py' to '/var/cache/salt/minion/extmods/states/jenkins_theme.py'
2017-10-29 14:57:28,879 [salt.utils.extmods][INFO    ][22658] Copying '/var/cache/salt/minion/files/base/_states/jenkins_user.py' to '/var/cache/salt/minion/extmods/states/jenkins_user.py'
2017-10-29 14:57:28,879 [salt.utils.extmods][INFO    ][22658] Copying '/var/cache/salt/minion/files/base/_states/jenkins_view.py' to '/var/cache/salt/minion/extmods/states/jenkins_view.py'
2017-10-29 14:57:28,879 [salt.utils.extmods][INFO    ][22658] Copying '/var/cache/salt/minion/files/base/_states/keystone_policy.py' to '/var/cache/salt/minion/extmods/states/keystone_policy.py'
2017-10-29 14:57:28,880 [salt.utils.extmods][INFO    ][22658] Copying '/var/cache/salt/minion/files/base/_states/kibana_object.py' to '/var/cache/salt/minion/extmods/states/kibana_object.py'
2017-10-29 14:57:28,880 [salt.utils.extmods][INFO    ][22658] Copying '/var/cache/salt/minion/files/base/_states/maas_cluster.py' to '/var/cache/salt/minion/extmods/states/maas_cluster.py'
2017-10-29 14:57:28,880 [salt.utils.extmods][INFO    ][22658] Copying '/var/cache/salt/minion/files/base/_states/neutronng.py' to '/var/cache/salt/minion/extmods/states/neutronng.py'
2017-10-29 14:57:28,881 [salt.utils.extmods][INFO    ][22658] Copying '/var/cache/salt/minion/files/base/_states/novang.py' to '/var/cache/salt/minion/extmods/states/novang.py'
2017-10-29 14:57:28,881 [salt.utils.extmods][INFO    ][22658] Copying '/var/cache/salt/minion/files/base/_states/reclass.py' to '/var/cache/salt/minion/extmods/states/reclass.py'
2017-10-29 14:57:28,881 [salt.utils.extmods][INFO    ][22658] Copying '/var/cache/salt/minion/files/base/_states/rundeck_project.py' to '/var/cache/salt/minion/extmods/states/rundeck_project.py'
2017-10-29 14:57:28,882 [salt.utils.extmods][INFO    ][22658] Copying '/var/cache/salt/minion/files/base/_states/rundeck_scm.py' to '/var/cache/salt/minion/extmods/states/rundeck_scm.py'
2017-10-29 14:57:28,882 [salt.utils.extmods][INFO    ][22658] Copying '/var/cache/salt/minion/files/base/_states/rundeck_secret.py' to '/var/cache/salt/minion/extmods/states/rundeck_secret.py'
2017-10-29 14:57:28,884 [salt.utils.extmods][INFO    ][22658] Creating module dir '/var/cache/salt/minion/extmods/sdb'
2017-10-29 14:57:28,886 [salt.utils.extmods][INFO    ][22658] Syncing sdb for environment 'base'
2017-10-29 14:57:28,886 [salt.utils.extmods][INFO    ][22658] Loading cache from salt://_sdb, for base)
2017-10-29 14:57:28,887 [salt.fileclient  ][INFO    ][22658] Caching directory '_sdb/' for environment 'base'
2017-10-29 14:57:28,919 [salt.utils.extmods][INFO    ][22658] Syncing grains for environment 'base'
2017-10-29 14:57:28,919 [salt.utils.extmods][INFO    ][22658] Loading cache from salt://_grains, for base)
2017-10-29 14:57:28,919 [salt.fileclient  ][INFO    ][22658] Caching directory '_grains/' for environment 'base'
2017-10-29 14:57:28,957 [salt.fileclient  ][INFO    ][22658] Fetching file from saltenv 'base', ** done ** '_grains/ceilometer_policy.py'
2017-10-29 14:57:28,969 [salt.fileclient  ][INFO    ][22658] Fetching file from saltenv 'base', ** done ** '_grains/ceph.py'
2017-10-29 14:57:28,981 [salt.fileclient  ][INFO    ][22658] Fetching file from saltenv 'base', ** done ** '_grains/cinder_policy.py'
2017-10-29 14:57:28,991 [salt.fileclient  ][INFO    ][22658] Fetching file from saltenv 'base', ** done ** '_grains/docker_swarm.py'
2017-10-29 14:57:29,002 [salt.fileclient  ][INFO    ][22658] Fetching file from saltenv 'base', ** done ** '_grains/glance_policy.py'
2017-10-29 14:57:29,013 [salt.fileclient  ][INFO    ][22658] Fetching file from saltenv 'base', ** done ** '_grains/heat_policy.py'
2017-10-29 14:57:29,024 [salt.fileclient  ][INFO    ][22658] Fetching file from saltenv 'base', ** done ** '_grains/jenkins_plugins.py'
2017-10-29 14:57:29,035 [salt.fileclient  ][INFO    ][22658] Fetching file from saltenv 'base', ** done ** '_grains/keystone_policy.py'
2017-10-29 14:57:29,046 [salt.fileclient  ][INFO    ][22658] Fetching file from saltenv 'base', ** done ** '_grains/kubernetes.py'
2017-10-29 14:57:29,074 [salt.fileclient  ][INFO    ][22658] Fetching file from saltenv 'base', ** done ** '_grains/neutron_policy.py'
2017-10-29 14:57:29,085 [salt.fileclient  ][INFO    ][22658] Fetching file from saltenv 'base', ** done ** '_grains/nova_policy.py'
2017-10-29 14:57:29,096 [salt.fileclient  ][INFO    ][22658] Fetching file from saltenv 'base', ** done ** '_grains/ssh_fingerprints.py'
2017-10-29 14:57:29,102 [salt.utils.extmods][INFO    ][22658] Copying '/var/cache/salt/minion/files/base/_grains/ceilometer_policy.py' to '/var/cache/salt/minion/extmods/grains/ceilometer_policy.py'
2017-10-29 14:57:29,102 [salt.utils.extmods][INFO    ][22658] Copying '/var/cache/salt/minion/files/base/_grains/ceph.py' to '/var/cache/salt/minion/extmods/grains/ceph.py'
2017-10-29 14:57:29,102 [salt.utils.extmods][INFO    ][22658] Copying '/var/cache/salt/minion/files/base/_grains/cinder_policy.py' to '/var/cache/salt/minion/extmods/grains/cinder_policy.py'
2017-10-29 14:57:29,103 [salt.utils.extmods][INFO    ][22658] Copying '/var/cache/salt/minion/files/base/_grains/docker_swarm.py' to '/var/cache/salt/minion/extmods/grains/docker_swarm.py'
2017-10-29 14:57:29,103 [salt.utils.extmods][INFO    ][22658] Copying '/var/cache/salt/minion/files/base/_grains/glance_policy.py' to '/var/cache/salt/minion/extmods/grains/glance_policy.py'
2017-10-29 14:57:29,103 [salt.utils.extmods][INFO    ][22658] Copying '/var/cache/salt/minion/files/base/_grains/heat_policy.py' to '/var/cache/salt/minion/extmods/grains/heat_policy.py'
2017-10-29 14:57:29,104 [salt.utils.extmods][INFO    ][22658] Copying '/var/cache/salt/minion/files/base/_grains/jenkins_plugins.py' to '/var/cache/salt/minion/extmods/grains/jenkins_plugins.py'
2017-10-29 14:57:29,104 [salt.utils.extmods][INFO    ][22658] Copying '/var/cache/salt/minion/files/base/_grains/keystone_policy.py' to '/var/cache/salt/minion/extmods/grains/keystone_policy.py'
2017-10-29 14:57:29,104 [salt.utils.extmods][INFO    ][22658] Copying '/var/cache/salt/minion/files/base/_grains/kubernetes.py' to '/var/cache/salt/minion/extmods/grains/kubernetes.py'
2017-10-29 14:57:29,105 [salt.utils.extmods][INFO    ][22658] Copying '/var/cache/salt/minion/files/base/_grains/neutron_policy.py' to '/var/cache/salt/minion/extmods/grains/neutron_policy.py'
2017-10-29 14:57:29,105 [salt.utils.extmods][INFO    ][22658] Copying '/var/cache/salt/minion/files/base/_grains/nova_policy.py' to '/var/cache/salt/minion/extmods/grains/nova_policy.py'
2017-10-29 14:57:29,105 [salt.utils.extmods][INFO    ][22658] Copying '/var/cache/salt/minion/files/base/_grains/ssh_fingerprints.py' to '/var/cache/salt/minion/extmods/grains/ssh_fingerprints.py'
2017-10-29 14:57:29,107 [salt.utils.extmods][INFO    ][22658] Creating module dir '/var/cache/salt/minion/extmods/renderers'
2017-10-29 14:57:29,112 [salt.utils.extmods][INFO    ][22658] Syncing renderers for environment 'base'
2017-10-29 14:57:29,112 [salt.utils.extmods][INFO    ][22658] Loading cache from salt://_renderers, for base)
2017-10-29 14:57:29,112 [salt.fileclient  ][INFO    ][22658] Caching directory '_renderers/' for environment 'base'
2017-10-29 14:57:29,155 [salt.utils.extmods][INFO    ][22658] Creating module dir '/var/cache/salt/minion/extmods/returners'
2017-10-29 14:57:29,157 [salt.utils.extmods][INFO    ][22658] Syncing returners for environment 'base'
2017-10-29 14:57:29,157 [salt.utils.extmods][INFO    ][22658] Loading cache from salt://_returners, for base)
2017-10-29 14:57:29,157 [salt.fileclient  ][INFO    ][22658] Caching directory '_returners/' for environment 'base'
2017-10-29 14:57:29,181 [salt.utils.extmods][INFO    ][22658] Creating module dir '/var/cache/salt/minion/extmods/output'
2017-10-29 14:57:29,183 [salt.utils.extmods][INFO    ][22658] Syncing output for environment 'base'
2017-10-29 14:57:29,183 [salt.utils.extmods][INFO    ][22658] Loading cache from salt://_output, for base)
2017-10-29 14:57:29,184 [salt.fileclient  ][INFO    ][22658] Caching directory '_output/' for environment 'base'
2017-10-29 14:57:29,212 [salt.utils.extmods][INFO    ][22658] Creating module dir '/var/cache/salt/minion/extmods/utils'
2017-10-29 14:57:29,214 [salt.utils.extmods][INFO    ][22658] Syncing utils for environment 'base'
2017-10-29 14:57:29,214 [salt.utils.extmods][INFO    ][22658] Loading cache from salt://_utils, for base)
2017-10-29 14:57:29,215 [salt.fileclient  ][INFO    ][22658] Caching directory '_utils/' for environment 'base'
2017-10-29 14:57:29,245 [salt.utils.extmods][INFO    ][22658] Creating module dir '/var/cache/salt/minion/extmods/log_handlers'
2017-10-29 14:57:29,247 [salt.utils.extmods][INFO    ][22658] Syncing log_handlers for environment 'base'
2017-10-29 14:57:29,247 [salt.utils.extmods][INFO    ][22658] Loading cache from salt://_log_handlers, for base)
2017-10-29 14:57:29,247 [salt.fileclient  ][INFO    ][22658] Caching directory '_log_handlers/' for environment 'base'
2017-10-29 14:57:29,276 [salt.utils.extmods][INFO    ][22658] Creating module dir '/var/cache/salt/minion/extmods/proxy'
2017-10-29 14:57:29,278 [salt.utils.extmods][INFO    ][22658] Syncing proxy for environment 'base'
2017-10-29 14:57:29,278 [salt.utils.extmods][INFO    ][22658] Loading cache from salt://_proxy, for base)
2017-10-29 14:57:29,278 [salt.fileclient  ][INFO    ][22658] Caching directory '_proxy/' for environment 'base'
2017-10-29 14:57:29,305 [salt.utils.extmods][INFO    ][22658] Creating module dir '/var/cache/salt/minion/extmods/engines'
2017-10-29 14:57:29,307 [salt.utils.extmods][INFO    ][22658] Syncing engines for environment 'base'
2017-10-29 14:57:29,307 [salt.utils.extmods][INFO    ][22658] Loading cache from salt://_engines, for base)
2017-10-29 14:57:29,307 [salt.fileclient  ][INFO    ][22658] Caching directory '_engines/' for environment 'base'
2017-10-29 14:57:29,344 [salt.minion      ][INFO    ][22658] Returning information for job: 20171029145726063603
2017-10-29 14:57:39,036 [salt.minion      ][INFO    ][22539] User sudo_ubuntu Executing command state.sls with jid 20171029145739046836
2017-10-29 14:57:39,053 [salt.minion      ][INFO    ][22800] Starting a new job with PID 22800
2017-10-29 14:57:39,484 [salt.state       ][INFO    ][22800] Loading fresh modules for state activity
2017-10-29 14:57:39,511 [salt.fileclient  ][INFO    ][22800] Fetching file from saltenv 'base', ** done ** 'salt/control/init.sls'
2017-10-29 14:57:39,529 [salt.fileclient  ][INFO    ][22800] Fetching file from saltenv 'base', ** done ** 'salt/control/virt.sls'
2017-10-29 14:57:39,631 [salt.fileclient  ][INFO    ][22800] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-10-29 14:57:39,692 [salt.fileclient  ][INFO    ][22800] Fetching file from saltenv 'base', ** done ** 'salt/minion/init.sls'
2017-10-29 14:57:39,707 [salt.fileclient  ][INFO    ][22800] Fetching file from saltenv 'base', ** done ** 'salt/minion/service.sls'
2017-10-29 14:57:39,742 [salt.fileclient  ][INFO    ][22800] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-10-29 14:57:39,809 [salt.fileclient  ][INFO    ][22800] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-10-29 14:57:39,826 [salt.fileclient  ][INFO    ][22800] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-10-29 14:57:39,867 [salt.fileclient  ][INFO    ][22800] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-10-29 14:57:39,884 [salt.fileclient  ][INFO    ][22800] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-10-29 14:57:39,896 [salt.fileclient  ][INFO    ][22800] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-10-29 14:57:39,910 [salt.fileclient  ][INFO    ][22800] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-10-29 14:57:39,917 [salt.loaded.int.module.cmdmod][INFO    ][22800] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-10-29 14:57:39,952 [salt.fileclient  ][INFO    ][22800] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-10-29 14:57:39,968 [py.warnings      ][WARNING ][22800] /usr/lib/python2.7/dist-packages/salt/utils/templates.py:73: DeprecationWarning: Starting in 2015.5, cmd.run uses python_shell=False by default, which doesn't support shellisms (pipes, env variables, etc). cmd.run is currently aliased to cmd.shell to prevent breakage. Please switch to cmd.shell or set python_shell=True to avoid breakage in the future, when this aliasing is removed.

2017-10-29 14:57:39,969 [salt.loaded.int.module.cmdmod][INFO    ][22800] Executing command 'salt-minion --version' in directory '/root'
2017-10-29 14:57:40,240 [salt.fileclient  ][INFO    ][22800] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-10-29 14:57:40,271 [salt.fileclient  ][INFO    ][22800] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-10-29 14:57:40,283 [salt.fileclient  ][INFO    ][22800] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-10-29 14:57:40,296 [salt.fileclient  ][INFO    ][22800] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-10-29 14:57:40,352 [salt.fileclient  ][INFO    ][22800] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-10-29 14:57:40,394 [salt.fileclient  ][INFO    ][22800] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-10-29 14:57:40,450 [salt.fileclient  ][INFO    ][22800] Fetching file from saltenv 'base', ** done ** 'salt/minion/grains.sls'
2017-10-29 14:57:40,479 [salt.fileclient  ][INFO    ][22800] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-10-29 14:57:40,529 [salt.fileclient  ][INFO    ][22800] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-10-29 14:57:40,547 [salt.fileclient  ][INFO    ][22800] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-10-29 14:57:40,590 [salt.fileclient  ][INFO    ][22800] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-10-29 14:57:40,616 [salt.fileclient  ][INFO    ][22800] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-10-29 14:57:40,627 [salt.fileclient  ][INFO    ][22800] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-10-29 14:57:40,642 [salt.fileclient  ][INFO    ][22800] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-10-29 14:57:40,648 [salt.loaded.int.module.cmdmod][INFO    ][22800] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-10-29 14:57:40,670 [salt.fileclient  ][INFO    ][22800] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-10-29 14:57:40,684 [salt.loaded.int.module.cmdmod][INFO    ][22800] Executing command 'salt-minion --version' in directory '/root'
2017-10-29 14:57:40,930 [salt.fileclient  ][INFO    ][22800] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-10-29 14:57:40,959 [salt.fileclient  ][INFO    ][22800] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-10-29 14:57:40,972 [salt.fileclient  ][INFO    ][22800] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-10-29 14:57:40,984 [salt.fileclient  ][INFO    ][22800] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-10-29 14:57:41,028 [salt.fileclient  ][INFO    ][22800] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-10-29 14:57:41,064 [salt.fileclient  ][INFO    ][22800] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-10-29 14:57:41,130 [salt.fileclient  ][INFO    ][22800] Fetching file from saltenv 'base', ** done ** 'salt/minion/cert.sls'
2017-10-29 14:57:41,183 [salt.fileclient  ][INFO    ][22800] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-10-29 14:57:41,535 [salt.state       ][INFO    ][22800] Running state [salt-minion] at time 14:57:41.534949
2017-10-29 14:57:41,535 [salt.state       ][INFO    ][22800] Executing state pkg.installed for salt-minion
2017-10-29 14:57:41,536 [salt.loaded.int.module.cmdmod][INFO    ][22800] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-10-29 14:57:41,822 [salt.state       ][INFO    ][22800] Package salt-minion is already installed
2017-10-29 14:57:41,822 [salt.state       ][INFO    ][22800] Completed state [salt-minion] at time 14:57:41.822181 duration_in_ms=287.233
2017-10-29 14:57:41,822 [salt.state       ][INFO    ][22800] Running state [salt_minion_dependency_packages] at time 14:57:41.822407
2017-10-29 14:57:41,823 [salt.state       ][INFO    ][22800] Executing state pkg.installed for salt_minion_dependency_packages
2017-10-29 14:57:41,825 [salt.state       ][INFO    ][22800] All specified packages are already installed
2017-10-29 14:57:41,825 [salt.state       ][INFO    ][22800] Completed state [salt_minion_dependency_packages] at time 14:57:41.825402 duration_in_ms=2.994
2017-10-29 14:57:41,827 [salt.state       ][INFO    ][22800] Running state [/etc/salt/minion.d/minion.conf] at time 14:57:41.826793
2017-10-29 14:57:41,827 [salt.state       ][INFO    ][22800] Executing state file.managed for /etc/salt/minion.d/minion.conf
2017-10-29 14:57:41,848 [salt.fileclient  ][INFO    ][22800] Fetching file from saltenv 'base', ** done ** 'salt/files/minion.conf'
2017-10-29 14:57:41,920 [salt.fileclient  ][INFO    ][22800] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-10-29 14:57:41,963 [salt.fileclient  ][INFO    ][22800] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-10-29 14:57:41,995 [salt.state       ][INFO    ][22800] File /etc/salt/minion.d/minion.conf is in the correct state
2017-10-29 14:57:41,995 [salt.state       ][INFO    ][22800] Completed state [/etc/salt/minion.d/minion.conf] at time 14:57:41.995423 duration_in_ms=168.629
2017-10-29 14:57:41,996 [salt.state       ][INFO    ][22800] Running state [/etc/salt/minion.d/_virt.conf] at time 14:57:41.995770
2017-10-29 14:57:41,996 [salt.state       ][INFO    ][22800] Executing state file.managed for /etc/salt/minion.d/_virt.conf
2017-10-29 14:57:42,060 [salt.state       ][INFO    ][22800] File /etc/salt/minion.d/_virt.conf is in the correct state
2017-10-29 14:57:42,060 [salt.state       ][INFO    ][22800] Completed state [/etc/salt/minion.d/_virt.conf] at time 14:57:42.060220 duration_in_ms=64.449
2017-10-29 14:57:42,062 [salt.state       ][INFO    ][22800] Running state [salt-minion] at time 14:57:42.061681
2017-10-29 14:57:42,062 [salt.state       ][INFO    ][22800] Executing state service.running for salt-minion
2017-10-29 14:57:42,062 [salt.loaded.int.module.cmdmod][INFO    ][22800] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2017-10-29 14:57:42,083 [salt.loaded.int.module.cmdmod][INFO    ][22800] Executing command ['systemctl', 'is-active', 'salt-minion.service'] in directory '/root'
2017-10-29 14:57:42,093 [salt.loaded.int.module.cmdmod][INFO    ][22800] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2017-10-29 14:57:42,102 [salt.state       ][INFO    ][22800] The service salt-minion is already running
2017-10-29 14:57:42,126 [salt.state       ][INFO    ][22800] Completed state [salt-minion] at time 14:57:42.126103 duration_in_ms=64.422
2017-10-29 14:57:42,128 [salt.state       ][INFO    ][22800] Running state [/etc/salt/grains.d] at time 14:57:42.127559
2017-10-29 14:57:42,128 [salt.state       ][INFO    ][22800] Executing state file.directory for /etc/salt/grains.d
2017-10-29 14:57:42,128 [salt.state       ][INFO    ][22800] Directory /etc/salt/grains.d is in the correct state
2017-10-29 14:57:42,128 [salt.state       ][INFO    ][22800] Completed state [/etc/salt/grains.d] at time 14:57:42.128449 duration_in_ms=0.889
2017-10-29 14:57:42,129 [salt.state       ][INFO    ][22800] Running state [/etc/salt/grains] at time 14:57:42.128889
2017-10-29 14:57:42,129 [salt.state       ][INFO    ][22800] Executing state file.managed for /etc/salt/grains
2017-10-29 14:57:42,129 [salt.state       ][INFO    ][22800] File /etc/salt/grains exists with proper permissions. No changes made.
2017-10-29 14:57:42,130 [salt.state       ][INFO    ][22800] Completed state [/etc/salt/grains] at time 14:57:42.129532 duration_in_ms=0.643
2017-10-29 14:57:42,130 [salt.state       ][INFO    ][22800] Running state [/etc/salt/grains.d/placeholder] at time 14:57:42.129811
2017-10-29 14:57:42,130 [salt.state       ][INFO    ][22800] Executing state file.managed for /etc/salt/grains.d/placeholder
2017-10-29 14:57:42,130 [salt.state       ][INFO    ][22800] File /etc/salt/grains.d/placeholder exists with proper permissions. No changes made.
2017-10-29 14:57:42,130 [salt.state       ][INFO    ][22800] Completed state [/etc/salt/grains.d/placeholder] at time 14:57:42.130435 duration_in_ms=0.624
2017-10-29 14:57:42,131 [salt.state       ][INFO    ][22800] Running state [/etc/salt/grains.d/sphinx] at time 14:57:42.130698
2017-10-29 14:57:42,131 [salt.state       ][INFO    ][22800] Executing state file.managed for /etc/salt/grains.d/sphinx
2017-10-29 14:57:42,192 [salt.state       ][INFO    ][22800] 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-10-29 14:57:42,193 [salt.state       ][INFO    ][22800] Completed state [/etc/salt/grains.d/sphinx] at time 14:57:42.192568 duration_in_ms=61.871
2017-10-29 14:57:42,193 [salt.state       ][INFO    ][22800] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 14:57:42.193142
2017-10-29 14:57:42,193 [salt.state       ][INFO    ][22800] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-10-29 14:57:42,194 [salt.state       ][INFO    ][22800] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-10-29 14:57:42,194 [salt.state       ][INFO    ][22800] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 14:57:42.193685 duration_in_ms=0.543
2017-10-29 14:57:42,194 [salt.state       ][INFO    ][22800] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 14:57:42.193832
2017-10-29 14:57:42,194 [salt.state       ][INFO    ][22800] Executing state cmd.mod_watch for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-10-29 14:57:42,195 [salt.loaded.int.module.cmdmod][INFO    ][22800] Executing command 'python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"' in directory '/root'
2017-10-29 14:57:42,283 [salt.state       ][INFO    ][22800] {'pid': 22848, 'retcode': 0, 'stderr': '', 'stdout': ''}
2017-10-29 14:57:42,283 [salt.state       ][INFO    ][22800] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 14:57:42.283096 duration_in_ms=89.262
2017-10-29 14:57:42,284 [salt.state       ][INFO    ][22800] Running state [/etc/salt/grains.d/dns_records] at time 14:57:42.283563
2017-10-29 14:57:42,284 [salt.state       ][INFO    ][22800] Executing state file.managed for /etc/salt/grains.d/dns_records
2017-10-29 14:57:42,336 [salt.state       ][INFO    ][22800] File /etc/salt/grains.d/dns_records is in the correct state
2017-10-29 14:57:42,336 [salt.state       ][INFO    ][22800] Completed state [/etc/salt/grains.d/dns_records] at time 14:57:42.336111 duration_in_ms=52.548
2017-10-29 14:57:42,337 [salt.state       ][INFO    ][22800] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 14:57:42.337289
2017-10-29 14:57:42,338 [salt.state       ][INFO    ][22800] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"
2017-10-29 14:57:42,338 [salt.state       ][INFO    ][22800] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"
2017-10-29 14:57:42,338 [salt.state       ][INFO    ][22800] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 14:57:42.338049 duration_in_ms=0.762
2017-10-29 14:57:42,338 [salt.state       ][INFO    ][22800] Running state [/etc/salt/grains.d/salt] at time 14:57:42.338342
2017-10-29 14:57:42,339 [salt.state       ][INFO    ][22800] Executing state file.managed for /etc/salt/grains.d/salt
2017-10-29 14:57:42,363 [salt.state       ][INFO    ][22800] File /etc/salt/grains.d/salt is in the correct state
2017-10-29 14:57:42,363 [salt.state       ][INFO    ][22800] Completed state [/etc/salt/grains.d/salt] at time 14:57:42.362896 duration_in_ms=24.553
2017-10-29 14:57:42,364 [salt.state       ][INFO    ][22800] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 14:57:42.363498
2017-10-29 14:57:42,364 [salt.state       ][INFO    ][22800] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2017-10-29 14:57:42,364 [salt.state       ][INFO    ][22800] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2017-10-29 14:57:42,364 [salt.state       ][INFO    ][22800] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 14:57:42.364145 duration_in_ms=0.647
2017-10-29 14:57:42,365 [salt.state       ][INFO    ][22800] Running state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 14:57:42.365423
2017-10-29 14:57:42,366 [salt.state       ][INFO    ][22800] Executing state cmd.wait for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-10-29 14:57:42,366 [salt.state       ][INFO    ][22800] No changes made for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-10-29 14:57:42,366 [salt.state       ][INFO    ][22800] Completed state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 14:57:42.366082 duration_in_ms=0.658
2017-10-29 14:57:42,366 [salt.state       ][INFO    ][22800] Running state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 14:57:42.366273
2017-10-29 14:57:42,367 [salt.state       ][INFO    ][22800] Executing state cmd.mod_watch for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-10-29 14:57:42,368 [salt.loaded.int.module.cmdmod][INFO    ][22800] Executing command 'cat /etc/salt/grains.d/* > /etc/salt/grains' in directory '/root'
2017-10-29 14:57:42,378 [salt.state       ][INFO    ][22800] {'pid': 22850, 'retcode': 0, 'stderr': '', 'stdout': ''}
2017-10-29 14:57:42,378 [salt.state       ][INFO    ][22800] Completed state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 14:57:42.377905 duration_in_ms=11.632
2017-10-29 14:57:42,379 [salt.state       ][INFO    ][22800] Running state [mine.update] at time 14:57:42.378545
2017-10-29 14:57:42,379 [salt.state       ][INFO    ][22800] Executing state module.wait for mine.update
2017-10-29 14:57:42,379 [salt.state       ][INFO    ][22800] No changes made for mine.update
2017-10-29 14:57:42,379 [salt.state       ][INFO    ][22800] Completed state [mine.update] at time 14:57:42.379189 duration_in_ms=0.643
2017-10-29 14:57:42,379 [salt.state       ][INFO    ][22800] Running state [mine.update] at time 14:57:42.379355
2017-10-29 14:57:42,380 [salt.state       ][INFO    ][22800] Executing state module.mod_watch for mine.update
2017-10-29 14:57:42,903 [salt.state       ][INFO    ][22800] {'ret': True}
2017-10-29 14:57:42,904 [salt.state       ][INFO    ][22800] Completed state [mine.update] at time 14:57:42.903610 duration_in_ms=524.254
2017-10-29 14:57:42,904 [salt.state       ][INFO    ][22800] Running state [ca-certificates] at time 14:57:42.903853
2017-10-29 14:57:42,904 [salt.state       ][INFO    ][22800] Executing state pkg.installed for ca-certificates
2017-10-29 14:57:42,907 [salt.state       ][INFO    ][22800] Package ca-certificates is already installed
2017-10-29 14:57:42,907 [salt.state       ][INFO    ][22800] Completed state [ca-certificates] at time 14:57:42.907418 duration_in_ms=3.565
2017-10-29 14:57:42,908 [salt.state       ][INFO    ][22800] Running state [update-ca-certificates] at time 14:57:42.907978
2017-10-29 14:57:42,908 [salt.state       ][INFO    ][22800] Executing state cmd.wait for update-ca-certificates
2017-10-29 14:57:42,908 [salt.state       ][INFO    ][22800] No changes made for update-ca-certificates
2017-10-29 14:57:42,909 [salt.state       ][INFO    ][22800] Completed state [update-ca-certificates] at time 14:57:42.908579 duration_in_ms=0.601
2017-10-29 14:57:42,909 [salt.state       ][INFO    ][22800] Running state [libvirt-dev] at time 14:57:42.908758
2017-10-29 14:57:42,909 [salt.state       ][INFO    ][22800] Executing state pkg.installed for libvirt-dev
2017-10-29 14:57:42,912 [salt.state       ][INFO    ][22800] Package libvirt-dev is already installed
2017-10-29 14:57:42,912 [salt.state       ][INFO    ][22800] Completed state [libvirt-dev] at time 14:57:42.911865 duration_in_ms=3.106
2017-10-29 14:57:42,912 [salt.state       ][INFO    ][22800] Running state [pkg-config] at time 14:57:42.912048
2017-10-29 14:57:42,912 [salt.state       ][INFO    ][22800] Executing state pkg.installed for pkg-config
2017-10-29 14:57:42,915 [salt.state       ][INFO    ][22800] Package pkg-config is already installed
2017-10-29 14:57:42,915 [salt.state       ][INFO    ][22800] Completed state [pkg-config] at time 14:57:42.915285 duration_in_ms=3.238
2017-10-29 14:57:42,916 [salt.state       ][INFO    ][22800] Running state [virtng.init] at time 14:57:42.915473
2017-10-29 14:57:42,916 [salt.state       ][INFO    ][22800] Executing state module.run for virtng.init
2017-10-29 14:57:42,973 [salt.loaded.int.module.cmdmod][INFO    ][22800] Executing command ['git', '--version'] in directory '/root'
2017-10-29 14:57:43,096 [salt.loaded.int.module.cmdmod][INFO    ][22800] Executing command 'virsh list --all --name| grep -E "^mdb02.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-10-29 14:57:43,117 [salt.state       ][INFO    ][22800] unless execution succeeded
2017-10-29 14:57:43,117 [salt.state       ][INFO    ][22800] Completed state [virtng.init] at time 14:57:43.117166 duration_in_ms=201.693
2017-10-29 14:57:43,117 [salt.state       ][INFO    ][22800] Running state [virt.set_autostart] at time 14:57:43.117443
2017-10-29 14:57:43,118 [salt.state       ][INFO    ][22800] Executing state module.run for virt.set_autostart
2017-10-29 14:57:43,120 [salt.loaded.int.module.cmdmod][INFO    ][22800] Executing command 'virsh list --autostart --name| grep -E "^mdb02.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-10-29 14:57:43,136 [salt.state       ][INFO    ][22800] unless execution succeeded
2017-10-29 14:57:43,137 [salt.state       ][INFO    ][22800] Completed state [virt.set_autostart] at time 14:57:43.136568 duration_in_ms=19.124
2017-10-29 14:57:43,137 [salt.state       ][INFO    ][22800] Running state [virtng.init] at time 14:57:43.136826
2017-10-29 14:57:43,137 [salt.state       ][INFO    ][22800] Executing state module.run for virtng.init
2017-10-29 14:57:43,139 [salt.loaded.int.module.cmdmod][INFO    ][22800] Executing command 'virsh list --all --name| grep -E "^dbs02.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-10-29 14:57:43,154 [salt.state       ][INFO    ][22800] unless execution succeeded
2017-10-29 14:57:43,154 [salt.state       ][INFO    ][22800] Completed state [virtng.init] at time 14:57:43.154161 duration_in_ms=17.335
2017-10-29 14:57:43,154 [salt.state       ][INFO    ][22800] Running state [virt.set_autostart] at time 14:57:43.154389
2017-10-29 14:57:43,155 [salt.state       ][INFO    ][22800] Executing state module.run for virt.set_autostart
2017-10-29 14:57:43,156 [salt.loaded.int.module.cmdmod][INFO    ][22800] Executing command 'virsh list --autostart --name| grep -E "^dbs02.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-10-29 14:57:43,173 [salt.state       ][INFO    ][22800] unless execution succeeded
2017-10-29 14:57:43,195 [salt.state       ][INFO    ][22800] Completed state [virt.set_autostart] at time 14:57:43.194437 duration_in_ms=40.045
2017-10-29 14:57:43,195 [salt.state       ][INFO    ][22800] Running state [virtng.init] at time 14:57:43.194771
2017-10-29 14:57:43,195 [salt.state       ][INFO    ][22800] Executing state module.run for virtng.init
2017-10-29 14:57:43,197 [salt.loaded.int.module.cmdmod][INFO    ][22800] Executing command 'virsh list --all --name| grep -E "^ctl02.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-10-29 14:57:43,215 [salt.state       ][INFO    ][22800] unless execution succeeded
2017-10-29 14:57:43,242 [salt.state       ][INFO    ][22800] Completed state [virtng.init] at time 14:57:43.242300 duration_in_ms=47.529
2017-10-29 14:57:43,243 [salt.state       ][INFO    ][22800] Running state [virt.set_autostart] at time 14:57:43.242585
2017-10-29 14:57:43,243 [salt.state       ][INFO    ][22800] Executing state module.run for virt.set_autostart
2017-10-29 14:57:43,245 [salt.loaded.int.module.cmdmod][INFO    ][22800] Executing command 'virsh list --autostart --name| grep -E "^ctl02.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-10-29 14:57:43,259 [salt.state       ][INFO    ][22800] unless execution succeeded
2017-10-29 14:57:43,266 [salt.state       ][INFO    ][22800] Completed state [virt.set_autostart] at time 14:57:43.265680 duration_in_ms=23.095
2017-10-29 14:57:43,266 [salt.state       ][INFO    ][22800] Running state [virtng.init] at time 14:57:43.265989
2017-10-29 14:57:43,266 [salt.state       ][INFO    ][22800] Executing state module.run for virtng.init
2017-10-29 14:57:43,268 [salt.loaded.int.module.cmdmod][INFO    ][22800] Executing command 'virsh list --all --name| grep -E "^msg02.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-10-29 14:57:43,284 [salt.state       ][INFO    ][22800] unless execution succeeded
2017-10-29 14:57:43,284 [salt.state       ][INFO    ][22800] Completed state [virtng.init] at time 14:57:43.284276 duration_in_ms=18.287
2017-10-29 14:57:43,285 [salt.state       ][INFO    ][22800] Running state [virt.set_autostart] at time 14:57:43.284482
2017-10-29 14:57:43,285 [salt.state       ][INFO    ][22800] Executing state module.run for virt.set_autostart
2017-10-29 14:57:43,287 [salt.loaded.int.module.cmdmod][INFO    ][22800] Executing command 'virsh list --autostart --name| grep -E "^msg02.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-10-29 14:57:43,300 [salt.state       ][INFO    ][22800] unless execution succeeded
2017-10-29 14:57:43,300 [salt.state       ][INFO    ][22800] Completed state [virt.set_autostart] at time 14:57:43.299987 duration_in_ms=15.503
2017-10-29 14:57:43,302 [salt.minion      ][INFO    ][22800] Returning information for job: 20171029145739046836
2017-10-29 14:58:59,751 [salt.minion      ][INFO    ][22539] User sudo_ubuntu Executing command saltutil.sync_all with jid 20171029145859767314
2017-10-29 14:58:59,769 [salt.minion      ][INFO    ][22921] Starting a new job with PID 22921
2017-10-29 14:59:03,278 [salt.state       ][INFO    ][22921] Loading fresh modules for state activity
2017-10-29 14:59:03,377 [salt.state       ][ERROR   ][22921] No contents found in top file
2017-10-29 14:59:03,378 [salt.utils.extmods][INFO    ][22921] Creating module dir '/var/cache/salt/minion/extmods/beacons'
2017-10-29 14:59:03,380 [salt.utils.extmods][INFO    ][22921] Syncing beacons for environment 'base'
2017-10-29 14:59:03,381 [salt.utils.extmods][INFO    ][22921] Loading cache from salt://_beacons, for base)
2017-10-29 14:59:03,381 [salt.fileclient  ][INFO    ][22921] Caching directory '_beacons/' for environment 'base'
2017-10-29 14:59:03,583 [salt.utils.extmods][INFO    ][22921] Syncing modules for environment 'base'
2017-10-29 14:59:03,583 [salt.utils.extmods][INFO    ][22921] Loading cache from salt://_modules, for base)
2017-10-29 14:59:03,583 [salt.fileclient  ][INFO    ][22921] Caching directory '_modules/' for environment 'base'
2017-10-29 14:59:03,657 [salt.fileclient  ][INFO    ][22921] Fetching file from saltenv 'base', ** done ** '_modules/ceph_ng.py'
2017-10-29 14:59:03,690 [salt.fileclient  ][INFO    ][22921] Fetching file from saltenv 'base', ** done ** '_modules/cinderng.py'
2017-10-29 14:59:03,734 [salt.fileclient  ][INFO    ][22921] Fetching file from saltenv 'base', ** done ** '_modules/contrail.py'
2017-10-29 14:59:03,743 [salt.fileclient  ][INFO    ][22921] Fetching file from saltenv 'base', ** done ** '_modules/creds.py'
2017-10-29 14:59:03,751 [salt.fileclient  ][INFO    ][22921] Fetching file from saltenv 'base', ** done ** '_modules/devops_utils.py'
2017-10-29 14:59:03,790 [salt.fileclient  ][INFO    ][22921] Fetching file from saltenv 'base', ** done ** '_modules/encode_json.py'
2017-10-29 14:59:03,804 [salt.fileclient  ][INFO    ][22921] Fetching file from saltenv 'base', ** done ** '_modules/gerrit.py'
2017-10-29 14:59:03,825 [salt.fileclient  ][INFO    ][22921] Fetching file from saltenv 'base', ** done ** '_modules/glanceng.py'
2017-10-29 14:59:03,837 [salt.fileclient  ][INFO    ][22921] Fetching file from saltenv 'base', ** done ** '_modules/heat.py'
2017-10-29 14:59:03,866 [salt.fileclient  ][INFO    ][22921] Fetching file from saltenv 'base', ** done ** '_modules/heka_alarming.py'
2017-10-29 14:59:03,908 [salt.fileclient  ][INFO    ][22921] Fetching file from saltenv 'base', ** done ** '_modules/helm.py'
2017-10-29 14:59:03,963 [salt.fileclient  ][INFO    ][22921] Fetching file from saltenv 'base', ** done ** '_modules/jenkins_common.py'
2017-10-29 14:59:04,014 [salt.fileclient  ][INFO    ][22921] Fetching file from saltenv 'base', ** done ** '_modules/keystone_policy.py'
2017-10-29 14:59:04,032 [salt.fileclient  ][INFO    ][22921] Fetching file from saltenv 'base', ** done ** '_modules/linux_hosts.py'
2017-10-29 14:59:04,105 [salt.fileclient  ][INFO    ][22921] Fetching file from saltenv 'base', ** done ** '_modules/linux_netlink.py'
2017-10-29 14:59:04,115 [salt.fileclient  ][INFO    ][22921] Fetching file from saltenv 'base', ** done ** '_modules/maas.py'
2017-10-29 14:59:04,131 [salt.fileclient  ][INFO    ][22921] Fetching file from saltenv 'base', ** done ** '_modules/maas_client.py'
2017-10-29 14:59:04,148 [salt.fileclient  ][INFO    ][22921] Fetching file from saltenv 'base', ** done ** '_modules/multipart.py'
2017-10-29 14:59:04,159 [salt.fileclient  ][INFO    ][22921] Fetching file from saltenv 'base', ** done ** '_modules/nagios_alarming.py'
2017-10-29 14:59:04,168 [salt.fileclient  ][INFO    ][22921] Fetching file from saltenv 'base', ** done ** '_modules/neutronng.py'
2017-10-29 14:59:04,209 [salt.fileclient  ][INFO    ][22921] Fetching file from saltenv 'base', ** done ** '_modules/novang.py'
2017-10-29 14:59:04,221 [salt.fileclient  ][INFO    ][22921] Fetching file from saltenv 'base', ** done ** '_modules/reclass.py'
2017-10-29 14:59:04,292 [salt.fileclient  ][INFO    ][22921] Fetching file from saltenv 'base', ** done ** '_modules/rsyslog_util.py'
2017-10-29 14:59:04,329 [salt.fileclient  ][INFO    ][22921] Fetching file from saltenv 'base', ** done ** '_modules/rundeck.py'
2017-10-29 14:59:04,376 [salt.fileclient  ][INFO    ][22921] Fetching file from saltenv 'base', ** done ** '_modules/saltkey.py'
2017-10-29 14:59:04,435 [salt.fileclient  ][INFO    ][22921] Fetching file from saltenv 'base', ** done ** '_modules/saltresource.py'
2017-10-29 14:59:04,447 [salt.fileclient  ][INFO    ][22921] Fetching file from saltenv 'base', ** done ** '_modules/seedng.py'
2017-10-29 14:59:04,554 [salt.fileclient  ][INFO    ][22921] Fetching file from saltenv 'base', ** done ** '_modules/testing/credentials.py'
2017-10-29 14:59:04,576 [salt.fileclient  ][INFO    ][22921] Fetching file from saltenv 'base', ** done ** '_modules/testing/django.py'
2017-10-29 14:59:04,583 [salt.fileclient  ][INFO    ][22921] Fetching file from saltenv 'base', ** done ** '_modules/testing/django_client_proxy.py'
2017-10-29 14:59:04,596 [salt.fileclient  ][INFO    ][22921] Fetching file from saltenv 'base', ** done ** '_modules/utils.py'
2017-10-29 14:59:04,611 [salt.fileclient  ][INFO    ][22921] Fetching file from saltenv 'base', ** done ** '_modules/virtng.py'
2017-10-29 14:59:04,613 [salt.utils.extmods][INFO    ][22921] Copying '/var/cache/salt/minion/files/base/_modules/__init__.py' to '/var/cache/salt/minion/extmods/modules/__init__.py'
2017-10-29 14:59:04,614 [salt.utils.extmods][INFO    ][22921] Copying '/var/cache/salt/minion/files/base/_modules/ceph_ng.py' to '/var/cache/salt/minion/extmods/modules/ceph_ng.py'
2017-10-29 14:59:04,614 [salt.utils.extmods][INFO    ][22921] Copying '/var/cache/salt/minion/files/base/_modules/cinderng.py' to '/var/cache/salt/minion/extmods/modules/cinderng.py'
2017-10-29 14:59:04,614 [salt.utils.extmods][INFO    ][22921] Copying '/var/cache/salt/minion/files/base/_modules/contrail.py' to '/var/cache/salt/minion/extmods/modules/contrail.py'
2017-10-29 14:59:04,615 [salt.utils.extmods][INFO    ][22921] Copying '/var/cache/salt/minion/files/base/_modules/creds.py' to '/var/cache/salt/minion/extmods/modules/creds.py'
2017-10-29 14:59:04,615 [salt.utils.extmods][INFO    ][22921] Copying '/var/cache/salt/minion/files/base/_modules/devops_utils.py' to '/var/cache/salt/minion/extmods/modules/devops_utils.py'
2017-10-29 14:59:04,615 [salt.utils.extmods][INFO    ][22921] Copying '/var/cache/salt/minion/files/base/_modules/encode_json.py' to '/var/cache/salt/minion/extmods/modules/encode_json.py'
2017-10-29 14:59:04,615 [salt.utils.extmods][INFO    ][22921] Copying '/var/cache/salt/minion/files/base/_modules/gerrit.py' to '/var/cache/salt/minion/extmods/modules/gerrit.py'
2017-10-29 14:59:04,615 [salt.utils.extmods][INFO    ][22921] Copying '/var/cache/salt/minion/files/base/_modules/glanceng.py' to '/var/cache/salt/minion/extmods/modules/glanceng.py'
2017-10-29 14:59:04,616 [salt.utils.extmods][INFO    ][22921] Copying '/var/cache/salt/minion/files/base/_modules/heat.py' to '/var/cache/salt/minion/extmods/modules/heat.py'
2017-10-29 14:59:04,616 [salt.utils.extmods][INFO    ][22921] Copying '/var/cache/salt/minion/files/base/_modules/heka_alarming.py' to '/var/cache/salt/minion/extmods/modules/heka_alarming.py'
2017-10-29 14:59:04,616 [salt.utils.extmods][INFO    ][22921] Copying '/var/cache/salt/minion/files/base/_modules/helm.py' to '/var/cache/salt/minion/extmods/modules/helm.py'
2017-10-29 14:59:04,616 [salt.utils.extmods][INFO    ][22921] Copying '/var/cache/salt/minion/files/base/_modules/jenkins_common.py' to '/var/cache/salt/minion/extmods/modules/jenkins_common.py'
2017-10-29 14:59:04,616 [salt.utils.extmods][INFO    ][22921] Copying '/var/cache/salt/minion/files/base/_modules/keystone_policy.py' to '/var/cache/salt/minion/extmods/modules/keystone_policy.py'
2017-10-29 14:59:04,617 [salt.utils.extmods][INFO    ][22921] Copying '/var/cache/salt/minion/files/base/_modules/linux_hosts.py' to '/var/cache/salt/minion/extmods/modules/linux_hosts.py'
2017-10-29 14:59:04,617 [salt.utils.extmods][INFO    ][22921] Copying '/var/cache/salt/minion/files/base/_modules/linux_netlink.py' to '/var/cache/salt/minion/extmods/modules/linux_netlink.py'
2017-10-29 14:59:04,617 [salt.utils.extmods][INFO    ][22921] Copying '/var/cache/salt/minion/files/base/_modules/maas.py' to '/var/cache/salt/minion/extmods/modules/maas.py'
2017-10-29 14:59:04,617 [salt.utils.extmods][INFO    ][22921] Copying '/var/cache/salt/minion/files/base/_modules/maas_client.py' to '/var/cache/salt/minion/extmods/modules/maas_client.py'
2017-10-29 14:59:04,618 [salt.utils.extmods][INFO    ][22921] Copying '/var/cache/salt/minion/files/base/_modules/multipart.py' to '/var/cache/salt/minion/extmods/modules/multipart.py'
2017-10-29 14:59:04,618 [salt.utils.extmods][INFO    ][22921] Copying '/var/cache/salt/minion/files/base/_modules/nagios_alarming.py' to '/var/cache/salt/minion/extmods/modules/nagios_alarming.py'
2017-10-29 14:59:04,618 [salt.utils.extmods][INFO    ][22921] Copying '/var/cache/salt/minion/files/base/_modules/neutronng.py' to '/var/cache/salt/minion/extmods/modules/neutronng.py'
2017-10-29 14:59:04,618 [salt.utils.extmods][INFO    ][22921] Copying '/var/cache/salt/minion/files/base/_modules/novang.py' to '/var/cache/salt/minion/extmods/modules/novang.py'
2017-10-29 14:59:04,619 [salt.utils.extmods][INFO    ][22921] Copying '/var/cache/salt/minion/files/base/_modules/reclass.py' to '/var/cache/salt/minion/extmods/modules/reclass.py'
2017-10-29 14:59:04,619 [salt.utils.extmods][INFO    ][22921] Copying '/var/cache/salt/minion/files/base/_modules/rsyslog_util.py' to '/var/cache/salt/minion/extmods/modules/rsyslog_util.py'
2017-10-29 14:59:04,619 [salt.utils.extmods][INFO    ][22921] Copying '/var/cache/salt/minion/files/base/_modules/rundeck.py' to '/var/cache/salt/minion/extmods/modules/rundeck.py'
2017-10-29 14:59:04,619 [salt.utils.extmods][INFO    ][22921] Copying '/var/cache/salt/minion/files/base/_modules/saltkey.py' to '/var/cache/salt/minion/extmods/modules/saltkey.py'
2017-10-29 14:59:04,620 [salt.utils.extmods][INFO    ][22921] Copying '/var/cache/salt/minion/files/base/_modules/saltresource.py' to '/var/cache/salt/minion/extmods/modules/saltresource.py'
2017-10-29 14:59:04,620 [salt.utils.extmods][INFO    ][22921] Copying '/var/cache/salt/minion/files/base/_modules/seedng.py' to '/var/cache/salt/minion/extmods/modules/seedng.py'
2017-10-29 14:59:04,620 [salt.utils.extmods][INFO    ][22921] Copying '/var/cache/salt/minion/files/base/_modules/testing/__init__.py' to '/var/cache/salt/minion/extmods/modules/testing/__init__.py'
2017-10-29 14:59:04,620 [salt.utils.extmods][INFO    ][22921] Copying '/var/cache/salt/minion/files/base/_modules/testing/credentials.py' to '/var/cache/salt/minion/extmods/modules/testing/credentials.py'
2017-10-29 14:59:04,621 [salt.utils.extmods][INFO    ][22921] Copying '/var/cache/salt/minion/files/base/_modules/testing/django.py' to '/var/cache/salt/minion/extmods/modules/testing/django.py'
2017-10-29 14:59:04,621 [salt.utils.extmods][INFO    ][22921] Copying '/var/cache/salt/minion/files/base/_modules/testing/django_client_proxy.py' to '/var/cache/salt/minion/extmods/modules/testing/django_client_proxy.py'
2017-10-29 14:59:04,621 [salt.utils.extmods][INFO    ][22921] Copying '/var/cache/salt/minion/files/base/_modules/utils.py' to '/var/cache/salt/minion/extmods/modules/utils.py'
2017-10-29 14:59:04,621 [salt.utils.extmods][INFO    ][22921] Copying '/var/cache/salt/minion/files/base/_modules/virtng.py' to '/var/cache/salt/minion/extmods/modules/virtng.py'
2017-10-29 14:59:04,627 [salt.utils.extmods][INFO    ][22921] Syncing states for environment 'base'
2017-10-29 14:59:04,627 [salt.utils.extmods][INFO    ][22921] Loading cache from salt://_states, for base)
2017-10-29 14:59:04,627 [salt.fileclient  ][INFO    ][22921] Caching directory '_states/' for environment 'base'
2017-10-29 14:59:04,659 [salt.fileclient  ][INFO    ][22921] Fetching file from saltenv 'base', ** done ** '_states/cinderng.py'
2017-10-29 14:59:04,689 [salt.fileclient  ][INFO    ][22921] Fetching file from saltenv 'base', ** done ** '_states/contrail.py'
2017-10-29 14:59:04,696 [salt.fileclient  ][INFO    ][22921] Fetching file from saltenv 'base', ** done ** '_states/gerrit.py'
2017-10-29 14:59:04,706 [salt.fileclient  ][INFO    ][22921] Fetching file from saltenv 'base', ** done ** '_states/glanceng.py'
2017-10-29 14:59:04,722 [salt.fileclient  ][INFO    ][22921] Fetching file from saltenv 'base', ** done ** '_states/grafana3_dashboard.py'
2017-10-29 14:59:04,731 [salt.fileclient  ][INFO    ][22921] Fetching file from saltenv 'base', ** done ** '_states/grafana3_datasource.py'
2017-10-29 14:59:04,741 [salt.fileclient  ][INFO    ][22921] Fetching file from saltenv 'base', ** done ** '_states/heat.py'
2017-10-29 14:59:04,793 [salt.fileclient  ][INFO    ][22921] Fetching file from saltenv 'base', ** done ** '_states/helm_release.py'
2017-10-29 14:59:04,805 [salt.fileclient  ][INFO    ][22921] Fetching file from saltenv 'base', ** done ** '_states/jenkins_approval.py'
2017-10-29 14:59:04,825 [salt.fileclient  ][INFO    ][22921] Fetching file from saltenv 'base', ** done ** '_states/jenkins_artifactory.py'
2017-10-29 14:59:04,847 [salt.fileclient  ][INFO    ][22921] Fetching file from saltenv 'base', ** done ** '_states/jenkins_credential.py'
2017-10-29 14:59:04,855 [salt.fileclient  ][INFO    ][22921] Fetching file from saltenv 'base', ** done ** '_states/jenkins_job.py'
2017-10-29 14:59:04,936 [salt.fileclient  ][INFO    ][22921] Fetching file from saltenv 'base', ** done ** '_states/jenkins_lib.py'
2017-10-29 14:59:04,945 [salt.fileclient  ][INFO    ][22921] Fetching file from saltenv 'base', ** done ** '_states/jenkins_node.py'
2017-10-29 14:59:04,962 [salt.fileclient  ][INFO    ][22921] Fetching file from saltenv 'base', ** done ** '_states/jenkins_plugin.py'
2017-10-29 14:59:04,976 [salt.fileclient  ][INFO    ][22921] Fetching file from saltenv 'base', ** done ** '_states/jenkins_security.py'
2017-10-29 14:59:05,009 [salt.fileclient  ][INFO    ][22921] Fetching file from saltenv 'base', ** done ** '_states/jenkins_slack.py'
2017-10-29 14:59:05,021 [salt.fileclient  ][INFO    ][22921] Fetching file from saltenv 'base', ** done ** '_states/jenkins_smtp.py'
2017-10-29 14:59:05,033 [salt.fileclient  ][INFO    ][22921] Fetching file from saltenv 'base', ** done ** '_states/jenkins_theme.py'
2017-10-29 14:59:05,045 [salt.fileclient  ][INFO    ][22921] Fetching file from saltenv 'base', ** done ** '_states/jenkins_user.py'
2017-10-29 14:59:05,061 [salt.fileclient  ][INFO    ][22921] Fetching file from saltenv 'base', ** done ** '_states/jenkins_view.py'
2017-10-29 14:59:05,070 [salt.fileclient  ][INFO    ][22921] Fetching file from saltenv 'base', ** done ** '_states/keystone_policy.py'
2017-10-29 14:59:05,083 [salt.fileclient  ][INFO    ][22921] Fetching file from saltenv 'base', ** done ** '_states/kibana_object.py'
2017-10-29 14:59:05,114 [salt.fileclient  ][INFO    ][22921] Fetching file from saltenv 'base', ** done ** '_states/neutronng.py'
2017-10-29 14:59:05,126 [salt.fileclient  ][INFO    ][22921] Fetching file from saltenv 'base', ** done ** '_states/novang.py'
2017-10-29 14:59:05,145 [salt.fileclient  ][INFO    ][22921] Fetching file from saltenv 'base', ** done ** '_states/reclass.py'
2017-10-29 14:59:05,157 [salt.fileclient  ][INFO    ][22921] Fetching file from saltenv 'base', ** done ** '_states/rundeck_project.py'
2017-10-29 14:59:05,187 [salt.fileclient  ][INFO    ][22921] Fetching file from saltenv 'base', ** done ** '_states/rundeck_scm.py'
2017-10-29 14:59:05,479 [salt.fileclient  ][INFO    ][22921] Fetching file from saltenv 'base', ** done ** '_states/rundeck_secret.py'
2017-10-29 14:59:05,482 [salt.utils.extmods][INFO    ][22921] Copying '/var/cache/salt/minion/files/base/_states/cinderng.py' to '/var/cache/salt/minion/extmods/states/cinderng.py'
2017-10-29 14:59:05,482 [salt.utils.extmods][INFO    ][22921] Copying '/var/cache/salt/minion/files/base/_states/contrail.py' to '/var/cache/salt/minion/extmods/states/contrail.py'
2017-10-29 14:59:05,482 [salt.utils.extmods][INFO    ][22921] Copying '/var/cache/salt/minion/files/base/_states/gerrit.py' to '/var/cache/salt/minion/extmods/states/gerrit.py'
2017-10-29 14:59:05,482 [salt.utils.extmods][INFO    ][22921] Copying '/var/cache/salt/minion/files/base/_states/glanceng.py' to '/var/cache/salt/minion/extmods/states/glanceng.py'
2017-10-29 14:59:05,483 [salt.utils.extmods][INFO    ][22921] Copying '/var/cache/salt/minion/files/base/_states/grafana3_dashboard.py' to '/var/cache/salt/minion/extmods/states/grafana3_dashboard.py'
2017-10-29 14:59:05,483 [salt.utils.extmods][INFO    ][22921] Copying '/var/cache/salt/minion/files/base/_states/grafana3_datasource.py' to '/var/cache/salt/minion/extmods/states/grafana3_datasource.py'
2017-10-29 14:59:05,483 [salt.utils.extmods][INFO    ][22921] Copying '/var/cache/salt/minion/files/base/_states/heat.py' to '/var/cache/salt/minion/extmods/states/heat.py'
2017-10-29 14:59:05,483 [salt.utils.extmods][INFO    ][22921] Copying '/var/cache/salt/minion/files/base/_states/helm_release.py' to '/var/cache/salt/minion/extmods/states/helm_release.py'
2017-10-29 14:59:05,483 [salt.utils.extmods][INFO    ][22921] Copying '/var/cache/salt/minion/files/base/_states/jenkins_approval.py' to '/var/cache/salt/minion/extmods/states/jenkins_approval.py'
2017-10-29 14:59:05,484 [salt.utils.extmods][INFO    ][22921] Copying '/var/cache/salt/minion/files/base/_states/jenkins_artifactory.py' to '/var/cache/salt/minion/extmods/states/jenkins_artifactory.py'
2017-10-29 14:59:05,484 [salt.utils.extmods][INFO    ][22921] Copying '/var/cache/salt/minion/files/base/_states/jenkins_credential.py' to '/var/cache/salt/minion/extmods/states/jenkins_credential.py'
2017-10-29 14:59:05,484 [salt.utils.extmods][INFO    ][22921] Copying '/var/cache/salt/minion/files/base/_states/jenkins_job.py' to '/var/cache/salt/minion/extmods/states/jenkins_job.py'
2017-10-29 14:59:05,484 [salt.utils.extmods][INFO    ][22921] Copying '/var/cache/salt/minion/files/base/_states/jenkins_lib.py' to '/var/cache/salt/minion/extmods/states/jenkins_lib.py'
2017-10-29 14:59:05,484 [salt.utils.extmods][INFO    ][22921] Copying '/var/cache/salt/minion/files/base/_states/jenkins_node.py' to '/var/cache/salt/minion/extmods/states/jenkins_node.py'
2017-10-29 14:59:05,485 [salt.utils.extmods][INFO    ][22921] Copying '/var/cache/salt/minion/files/base/_states/jenkins_plugin.py' to '/var/cache/salt/minion/extmods/states/jenkins_plugin.py'
2017-10-29 14:59:05,485 [salt.utils.extmods][INFO    ][22921] Copying '/var/cache/salt/minion/files/base/_states/jenkins_security.py' to '/var/cache/salt/minion/extmods/states/jenkins_security.py'
2017-10-29 14:59:05,485 [salt.utils.extmods][INFO    ][22921] Copying '/var/cache/salt/minion/files/base/_states/jenkins_slack.py' to '/var/cache/salt/minion/extmods/states/jenkins_slack.py'
2017-10-29 14:59:05,485 [salt.utils.extmods][INFO    ][22921] Copying '/var/cache/salt/minion/files/base/_states/jenkins_smtp.py' to '/var/cache/salt/minion/extmods/states/jenkins_smtp.py'
2017-10-29 14:59:05,485 [salt.utils.extmods][INFO    ][22921] Copying '/var/cache/salt/minion/files/base/_states/jenkins_theme.py' to '/var/cache/salt/minion/extmods/states/jenkins_theme.py'
2017-10-29 14:59:05,485 [salt.utils.extmods][INFO    ][22921] Copying '/var/cache/salt/minion/files/base/_states/jenkins_user.py' to '/var/cache/salt/minion/extmods/states/jenkins_user.py'
2017-10-29 14:59:05,486 [salt.utils.extmods][INFO    ][22921] Copying '/var/cache/salt/minion/files/base/_states/jenkins_view.py' to '/var/cache/salt/minion/extmods/states/jenkins_view.py'
2017-10-29 14:59:05,486 [salt.utils.extmods][INFO    ][22921] Copying '/var/cache/salt/minion/files/base/_states/keystone_policy.py' to '/var/cache/salt/minion/extmods/states/keystone_policy.py'
2017-10-29 14:59:05,486 [salt.utils.extmods][INFO    ][22921] Copying '/var/cache/salt/minion/files/base/_states/kibana_object.py' to '/var/cache/salt/minion/extmods/states/kibana_object.py'
2017-10-29 14:59:05,486 [salt.utils.extmods][INFO    ][22921] Copying '/var/cache/salt/minion/files/base/_states/maas_cluster.py' to '/var/cache/salt/minion/extmods/states/maas_cluster.py'
2017-10-29 14:59:05,486 [salt.utils.extmods][INFO    ][22921] Copying '/var/cache/salt/minion/files/base/_states/neutronng.py' to '/var/cache/salt/minion/extmods/states/neutronng.py'
2017-10-29 14:59:05,487 [salt.utils.extmods][INFO    ][22921] Copying '/var/cache/salt/minion/files/base/_states/novang.py' to '/var/cache/salt/minion/extmods/states/novang.py'
2017-10-29 14:59:05,487 [salt.utils.extmods][INFO    ][22921] Copying '/var/cache/salt/minion/files/base/_states/reclass.py' to '/var/cache/salt/minion/extmods/states/reclass.py'
2017-10-29 14:59:05,487 [salt.utils.extmods][INFO    ][22921] Copying '/var/cache/salt/minion/files/base/_states/rundeck_project.py' to '/var/cache/salt/minion/extmods/states/rundeck_project.py'
2017-10-29 14:59:05,487 [salt.utils.extmods][INFO    ][22921] Copying '/var/cache/salt/minion/files/base/_states/rundeck_scm.py' to '/var/cache/salt/minion/extmods/states/rundeck_scm.py'
2017-10-29 14:59:05,487 [salt.utils.extmods][INFO    ][22921] Copying '/var/cache/salt/minion/files/base/_states/rundeck_secret.py' to '/var/cache/salt/minion/extmods/states/rundeck_secret.py'
2017-10-29 14:59:05,489 [salt.utils.extmods][INFO    ][22921] Creating module dir '/var/cache/salt/minion/extmods/sdb'
2017-10-29 14:59:05,492 [salt.utils.extmods][INFO    ][22921] Syncing sdb for environment 'base'
2017-10-29 14:59:05,492 [salt.utils.extmods][INFO    ][22921] Loading cache from salt://_sdb, for base)
2017-10-29 14:59:05,492 [salt.fileclient  ][INFO    ][22921] Caching directory '_sdb/' for environment 'base'
2017-10-29 14:59:05,523 [salt.utils.extmods][INFO    ][22921] Syncing grains for environment 'base'
2017-10-29 14:59:05,523 [salt.utils.extmods][INFO    ][22921] Loading cache from salt://_grains, for base)
2017-10-29 14:59:05,523 [salt.fileclient  ][INFO    ][22921] Caching directory '_grains/' for environment 'base'
2017-10-29 14:59:05,544 [salt.fileclient  ][INFO    ][22921] Fetching file from saltenv 'base', ** done ** '_grains/ceilometer_policy.py'
2017-10-29 14:59:05,561 [salt.fileclient  ][INFO    ][22921] Fetching file from saltenv 'base', ** done ** '_grains/ceph.py'
2017-10-29 14:59:05,567 [salt.fileclient  ][INFO    ][22921] Fetching file from saltenv 'base', ** done ** '_grains/cinder_policy.py'
2017-10-29 14:59:05,574 [salt.fileclient  ][INFO    ][22921] Fetching file from saltenv 'base', ** done ** '_grains/docker_swarm.py'
2017-10-29 14:59:05,585 [salt.fileclient  ][INFO    ][22921] Fetching file from saltenv 'base', ** done ** '_grains/glance_policy.py'
2017-10-29 14:59:05,591 [salt.fileclient  ][INFO    ][22921] Fetching file from saltenv 'base', ** done ** '_grains/heat_policy.py'
2017-10-29 14:59:05,968 [salt.fileclient  ][INFO    ][22921] Fetching file from saltenv 'base', ** done ** '_grains/jenkins_plugins.py'
2017-10-29 14:59:05,974 [salt.fileclient  ][INFO    ][22921] Fetching file from saltenv 'base', ** done ** '_grains/keystone_policy.py'
2017-10-29 14:59:05,981 [salt.fileclient  ][INFO    ][22921] Fetching file from saltenv 'base', ** done ** '_grains/kubernetes.py'
2017-10-29 14:59:05,990 [salt.fileclient  ][INFO    ][22921] Fetching file from saltenv 'base', ** done ** '_grains/neutron_policy.py'
2017-10-29 14:59:06,236 [salt.fileclient  ][INFO    ][22921] Fetching file from saltenv 'base', ** done ** '_grains/nova_policy.py'
2017-10-29 14:59:06,242 [salt.fileclient  ][INFO    ][22921] Fetching file from saltenv 'base', ** done ** '_grains/ssh_fingerprints.py'
2017-10-29 14:59:06,245 [salt.utils.extmods][INFO    ][22921] Copying '/var/cache/salt/minion/files/base/_grains/ceilometer_policy.py' to '/var/cache/salt/minion/extmods/grains/ceilometer_policy.py'
2017-10-29 14:59:06,245 [salt.utils.extmods][INFO    ][22921] Copying '/var/cache/salt/minion/files/base/_grains/ceph.py' to '/var/cache/salt/minion/extmods/grains/ceph.py'
2017-10-29 14:59:06,246 [salt.utils.extmods][INFO    ][22921] Copying '/var/cache/salt/minion/files/base/_grains/cinder_policy.py' to '/var/cache/salt/minion/extmods/grains/cinder_policy.py'
2017-10-29 14:59:06,246 [salt.utils.extmods][INFO    ][22921] Copying '/var/cache/salt/minion/files/base/_grains/docker_swarm.py' to '/var/cache/salt/minion/extmods/grains/docker_swarm.py'
2017-10-29 14:59:06,246 [salt.utils.extmods][INFO    ][22921] Copying '/var/cache/salt/minion/files/base/_grains/glance_policy.py' to '/var/cache/salt/minion/extmods/grains/glance_policy.py'
2017-10-29 14:59:06,246 [salt.utils.extmods][INFO    ][22921] Copying '/var/cache/salt/minion/files/base/_grains/heat_policy.py' to '/var/cache/salt/minion/extmods/grains/heat_policy.py'
2017-10-29 14:59:06,246 [salt.utils.extmods][INFO    ][22921] Copying '/var/cache/salt/minion/files/base/_grains/jenkins_plugins.py' to '/var/cache/salt/minion/extmods/grains/jenkins_plugins.py'
2017-10-29 14:59:06,247 [salt.utils.extmods][INFO    ][22921] Copying '/var/cache/salt/minion/files/base/_grains/keystone_policy.py' to '/var/cache/salt/minion/extmods/grains/keystone_policy.py'
2017-10-29 14:59:06,247 [salt.utils.extmods][INFO    ][22921] Copying '/var/cache/salt/minion/files/base/_grains/kubernetes.py' to '/var/cache/salt/minion/extmods/grains/kubernetes.py'
2017-10-29 14:59:06,247 [salt.utils.extmods][INFO    ][22921] Copying '/var/cache/salt/minion/files/base/_grains/neutron_policy.py' to '/var/cache/salt/minion/extmods/grains/neutron_policy.py'
2017-10-29 14:59:06,247 [salt.utils.extmods][INFO    ][22921] Copying '/var/cache/salt/minion/files/base/_grains/nova_policy.py' to '/var/cache/salt/minion/extmods/grains/nova_policy.py'
2017-10-29 14:59:06,247 [salt.utils.extmods][INFO    ][22921] Copying '/var/cache/salt/minion/files/base/_grains/ssh_fingerprints.py' to '/var/cache/salt/minion/extmods/grains/ssh_fingerprints.py'
2017-10-29 14:59:06,249 [salt.utils.extmods][INFO    ][22921] Creating module dir '/var/cache/salt/minion/extmods/renderers'
2017-10-29 14:59:06,252 [salt.utils.extmods][INFO    ][22921] Syncing renderers for environment 'base'
2017-10-29 14:59:06,252 [salt.utils.extmods][INFO    ][22921] Loading cache from salt://_renderers, for base)
2017-10-29 14:59:06,252 [salt.fileclient  ][INFO    ][22921] Caching directory '_renderers/' for environment 'base'
2017-10-29 14:59:06,275 [salt.utils.extmods][INFO    ][22921] Creating module dir '/var/cache/salt/minion/extmods/returners'
2017-10-29 14:59:06,277 [salt.utils.extmods][INFO    ][22921] Syncing returners for environment 'base'
2017-10-29 14:59:06,278 [salt.utils.extmods][INFO    ][22921] Loading cache from salt://_returners, for base)
2017-10-29 14:59:06,278 [salt.fileclient  ][INFO    ][22921] Caching directory '_returners/' for environment 'base'
2017-10-29 14:59:06,295 [salt.utils.extmods][INFO    ][22921] Creating module dir '/var/cache/salt/minion/extmods/output'
2017-10-29 14:59:06,297 [salt.utils.extmods][INFO    ][22921] Syncing output for environment 'base'
2017-10-29 14:59:06,297 [salt.utils.extmods][INFO    ][22921] Loading cache from salt://_output, for base)
2017-10-29 14:59:06,298 [salt.fileclient  ][INFO    ][22921] Caching directory '_output/' for environment 'base'
2017-10-29 14:59:06,316 [salt.utils.extmods][INFO    ][22921] Creating module dir '/var/cache/salt/minion/extmods/utils'
2017-10-29 14:59:06,318 [salt.utils.extmods][INFO    ][22921] Syncing utils for environment 'base'
2017-10-29 14:59:06,318 [salt.utils.extmods][INFO    ][22921] Loading cache from salt://_utils, for base)
2017-10-29 14:59:06,318 [salt.fileclient  ][INFO    ][22921] Caching directory '_utils/' for environment 'base'
2017-10-29 14:59:06,341 [salt.utils.extmods][INFO    ][22921] Creating module dir '/var/cache/salt/minion/extmods/log_handlers'
2017-10-29 14:59:06,344 [salt.utils.extmods][INFO    ][22921] Syncing log_handlers for environment 'base'
2017-10-29 14:59:06,344 [salt.utils.extmods][INFO    ][22921] Loading cache from salt://_log_handlers, for base)
2017-10-29 14:59:06,344 [salt.fileclient  ][INFO    ][22921] Caching directory '_log_handlers/' for environment 'base'
2017-10-29 14:59:06,362 [salt.utils.extmods][INFO    ][22921] Creating module dir '/var/cache/salt/minion/extmods/proxy'
2017-10-29 14:59:06,364 [salt.utils.extmods][INFO    ][22921] Syncing proxy for environment 'base'
2017-10-29 14:59:06,364 [salt.utils.extmods][INFO    ][22921] Loading cache from salt://_proxy, for base)
2017-10-29 14:59:06,364 [salt.fileclient  ][INFO    ][22921] Caching directory '_proxy/' for environment 'base'
2017-10-29 14:59:06,386 [salt.utils.extmods][INFO    ][22921] Creating module dir '/var/cache/salt/minion/extmods/engines'
2017-10-29 14:59:06,388 [salt.utils.extmods][INFO    ][22921] Syncing engines for environment 'base'
2017-10-29 14:59:06,388 [salt.utils.extmods][INFO    ][22921] Loading cache from salt://_engines, for base)
2017-10-29 14:59:06,389 [salt.fileclient  ][INFO    ][22921] Caching directory '_engines/' for environment 'base'
2017-10-29 14:59:06,410 [salt.minion      ][INFO    ][22921] Returning information for job: 20171029145859767314
2017-10-29 15:03:57,141 [salt.minion      ][INFO    ][22539] User sudo_ubuntu Executing command test.ping with jid 20171029150357135742
2017-10-29 15:03:57,157 [salt.minion      ][INFO    ][23084] Starting a new job with PID 23084
2017-10-29 15:03:57,191 [salt.minion      ][INFO    ][23084] Returning information for job: 20171029150357135742
2017-10-29 15:07:10,317 [salt.minion      ][INFO    ][22539] User sudo_ubuntu Executing command state.sls with jid 20171029150710310247
2017-10-29 15:07:10,332 [salt.minion      ][INFO    ][23129] Starting a new job with PID 23129
2017-10-29 15:07:10,752 [salt.state       ][INFO    ][23129] Loading fresh modules for state activity
2017-10-29 15:07:10,776 [salt.fileclient  ][INFO    ][23129] Fetching file from saltenv 'base', ** done ** 'keepalived/init.sls'
2017-10-29 15:07:10,793 [salt.fileclient  ][INFO    ][23129] Fetching file from saltenv 'base', ** done ** 'keepalived/cluster.sls'
2017-10-29 15:07:10,817 [salt.fileclient  ][INFO    ][23129] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-10-29 15:07:11,120 [salt.state       ][INFO    ][23129] Running state [lsof] at time 15:07:11.119534
2017-10-29 15:07:11,120 [salt.state       ][INFO    ][23129] Executing state pkg.installed for lsof
2017-10-29 15:07:11,120 [salt.loaded.int.module.cmdmod][INFO    ][23129] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-10-29 15:07:11,384 [salt.state       ][INFO    ][23129] Package lsof is already installed
2017-10-29 15:07:11,385 [salt.state       ][INFO    ][23129] Completed state [lsof] at time 15:07:11.384715 duration_in_ms=265.181
2017-10-29 15:07:11,385 [salt.state       ][INFO    ][23129] Running state [keepalived] at time 15:07:11.384938
2017-10-29 15:07:11,385 [salt.state       ][INFO    ][23129] Executing state pkg.installed for keepalived
2017-10-29 15:07:11,400 [salt.loaded.int.module.cmdmod][INFO    ][23129] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-10-29 15:07:13,300 [salt.loaded.int.module.cmdmod][INFO    ][23129] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'keepalived'] in directory '/root'
2017-10-29 15:07:20,363 [salt.minion      ][INFO    ][22539] User sudo_ubuntu Executing command saltutil.find_job with jid 20171029150720353869
2017-10-29 15:07:20,377 [salt.minion      ][INFO    ][24605] Starting a new job with PID 24605
2017-10-29 15:07:20,387 [salt.minion      ][INFO    ][24605] Returning information for job: 20171029150720353869
2017-10-29 15:07:20,793 [salt.loaded.int.module.cmdmod][INFO    ][23129] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-10-29 15:07:20,818 [salt.state       ][INFO    ][23129] Made the following changes:
'libsnmp30' changed from 'absent' to '5.7.3+dfsg-1ubuntu4'
'libsnmp-base' changed from 'absent' to '5.7.3+dfsg-1ubuntu4'
'keepalived' changed from 'absent' to '1:1.2.19-1ubuntu0.2'
'ipvsadm' changed from 'absent' to '1:1.28-3'
'libsensors4' changed from 'absent' to '1:3.4.0-2'

2017-10-29 15:07:20,825 [salt.state       ][INFO    ][23129] Loading fresh modules for state activity
2017-10-29 15:07:20,837 [salt.state       ][INFO    ][23129] Completed state [keepalived] at time 15:07:20.836944 duration_in_ms=9452.006
2017-10-29 15:07:20,839 [salt.state       ][INFO    ][23129] Running state [/etc/keepalived/keepalived.conf] at time 15:07:20.838928
2017-10-29 15:07:20,839 [salt.state       ][INFO    ][23129] Executing state file.managed for /etc/keepalived/keepalived.conf
2017-10-29 15:07:20,863 [salt.fileclient  ][INFO    ][23129] Fetching file from saltenv 'base', ** done ** 'keepalived/files/keepalived.conf'
2017-10-29 15:07:20,893 [salt.fileclient  ][INFO    ][23129] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-10-29 15:07:20,899 [salt.state       ][INFO    ][23129] File changed:
New file
2017-10-29 15:07:20,899 [salt.state       ][INFO    ][23129] Completed state [/etc/keepalived/keepalived.conf] at time 15:07:20.899401 duration_in_ms=60.473
2017-10-29 15:07:20,960 [salt.state       ][INFO    ][23129] Running state [keepalived] at time 15:07:20.959643
2017-10-29 15:07:20,960 [salt.state       ][INFO    ][23129] Executing state service.running for keepalived
2017-10-29 15:07:20,961 [salt.loaded.int.module.cmdmod][INFO    ][23129] Executing command ['systemctl', 'status', 'keepalived.service', '-n', '0'] in directory '/root'
2017-10-29 15:07:20,971 [salt.loaded.int.module.cmdmod][INFO    ][23129] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2017-10-29 15:07:20,980 [salt.loaded.int.module.cmdmod][INFO    ][23129] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-10-29 15:07:20,988 [salt.loaded.int.module.cmdmod][INFO    ][23129] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-10-29 15:07:20,996 [salt.loaded.int.module.cmdmod][INFO    ][23129] Executing command ['systemd-run', '--scope', 'systemctl', 'start', 'keepalived.service'] in directory '/root'
2017-10-29 15:07:21,059 [salt.loaded.int.module.cmdmod][INFO    ][23129] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2017-10-29 15:07:21,067 [salt.loaded.int.module.cmdmod][INFO    ][23129] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-10-29 15:07:21,076 [salt.loaded.int.module.cmdmod][INFO    ][23129] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-10-29 15:07:21,083 [salt.state       ][INFO    ][23129] {'keepalived': True}
2017-10-29 15:07:21,083 [salt.state       ][INFO    ][23129] Completed state [keepalived] at time 15:07:21.083297 duration_in_ms=123.655
2017-10-29 15:07:21,084 [salt.minion      ][INFO    ][23129] Returning information for job: 20171029150710310247
2017-10-29 15:07:59,732 [salt.minion      ][INFO    ][22539] User sudo_ubuntu Executing command pillar.get with jid 20171029150759721774
2017-10-29 15:07:59,754 [salt.minion      ][INFO    ][24722] Starting a new job with PID 24722
2017-10-29 15:07:59,761 [salt.minion      ][INFO    ][24722] Returning information for job: 20171029150759721774
2017-10-29 15:13:36,632 [salt.minion      ][INFO    ][22539] User sudo_ubuntu Executing command state.sls with jid 20171029151336622350
2017-10-29 15:13:36,649 [salt.minion      ][INFO    ][24813] Starting a new job with PID 24813
2017-10-29 15:13:38,049 [salt.state       ][INFO    ][24813] Loading fresh modules for state activity
2017-10-29 15:13:38,072 [salt.fileclient  ][INFO    ][24813] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-10-29 15:13:38,090 [salt.fileclient  ][INFO    ][24813] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-10-29 15:13:38,370 [salt.state       ][INFO    ][24813] Running state [attr] at time 15:13:38.370153
2017-10-29 15:13:38,370 [salt.state       ][INFO    ][24813] Executing state pkg.installed for attr
2017-10-29 15:13:38,371 [salt.loaded.int.module.cmdmod][INFO    ][24813] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-10-29 15:13:38,636 [salt.loaded.int.module.cmdmod][INFO    ][24813] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-10-29 15:13:40,573 [salt.loaded.int.module.cmdmod][INFO    ][24813] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'attr'] in directory '/root'
2017-10-29 15:13:42,999 [salt.loaded.int.module.cmdmod][INFO    ][24813] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-10-29 15:13:43,024 [salt.state       ][INFO    ][24813] Made the following changes:
'attr' changed from 'absent' to '1:2.4.47-2'

2017-10-29 15:13:43,032 [salt.state       ][INFO    ][24813] Loading fresh modules for state activity
2017-10-29 15:13:43,043 [salt.state       ][INFO    ][24813] Completed state [attr] at time 15:13:43.043455 duration_in_ms=4673.302
2017-10-29 15:13:43,048 [salt.state       ][INFO    ][24813] Running state [glusterfs-server] at time 15:13:43.048089
2017-10-29 15:13:43,048 [salt.state       ][INFO    ][24813] Executing state pkg.installed for glusterfs-server
2017-10-29 15:13:43,242 [salt.loaded.int.module.cmdmod][INFO    ][24813] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'glusterfs-server'] in directory '/root'
2017-10-29 15:13:46,731 [salt.minion      ][INFO    ][22539] User sudo_ubuntu Executing command saltutil.find_job with jid 20171029151346718685
2017-10-29 15:13:46,745 [salt.minion      ][INFO    ][25863] Starting a new job with PID 25863
2017-10-29 15:13:46,756 [salt.minion      ][INFO    ][25863] Returning information for job: 20171029151346718685
2017-10-29 15:13:56,944 [salt.minion      ][INFO    ][22539] User sudo_ubuntu Executing command saltutil.find_job with jid 20171029151356933291
2017-10-29 15:13:56,959 [salt.minion      ][INFO    ][28807] Starting a new job with PID 28807
2017-10-29 15:13:56,971 [salt.minion      ][INFO    ][28807] Returning information for job: 20171029151356933291
2017-10-29 15:13:59,356 [salt.loaded.int.module.cmdmod][INFO    ][24813] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-10-29 15:13:59,380 [salt.state       ][INFO    ][24813] Made the following changes:
'keyutils' changed from 'absent' to '1.5.9-8ubuntu1'
'nfs-common' changed from 'absent' to '1:1.2.8-9ubuntu12.1'
'rpcbind' changed from 'absent' to '0.2.3-0.2'
'glusterfs-common' changed from 'absent' to '3.7.6-1ubuntu1'
'librdmacm1' changed from 'absent' to '1.0.21-1'
'libnfsidmap2' changed from 'absent' to '0.25-5'
'portmap' changed from 'absent' to '1'
'libattr1-dev' changed from 'absent' to '1:2.4.47-2'
'attr-dev' changed from 'absent' to '1'
'acl-dev' changed from 'absent' to '1'
'glusterfs-server' changed from 'absent' to '3.7.6-1ubuntu1'
'glusterfs-client' changed from 'absent' to '3.7.6-1ubuntu1'
'libpython2.7' changed from 'absent' to '2.7.12-1ubuntu0~16.04.1'
'nfs-client' changed from 'absent' to '1'
'liburcu4' changed from 'absent' to '0.9.1-3'
'libacl1-dev' changed from 'absent' to '2.2.52-3'
'libibverbs1' changed from 'absent' to '1.1.8-1.1ubuntu2'
'libtirpc1' changed from 'absent' to '0.2.5-1'

2017-10-29 15:13:59,387 [salt.state       ][INFO    ][24813] Loading fresh modules for state activity
2017-10-29 15:13:59,399 [salt.state       ][INFO    ][24813] Completed state [glusterfs-server] at time 15:13:59.399282 duration_in_ms=16351.192
2017-10-29 15:13:59,404 [salt.state       ][INFO    ][24813] Running state [bc] at time 15:13:59.403767
2017-10-29 15:13:59,404 [salt.state       ][INFO    ][24813] Executing state pkg.installed for bc
2017-10-29 15:13:59,656 [salt.loaded.int.module.cmdmod][INFO    ][24813] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'bc'] in directory '/root'
2017-10-29 15:14:02,383 [salt.loaded.int.module.cmdmod][INFO    ][24813] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-10-29 15:14:02,409 [salt.state       ][INFO    ][24813] Made the following changes:
'bc' changed from 'absent' to '1.06.95-9build1'

2017-10-29 15:14:02,419 [salt.state       ][INFO    ][24813] Loading fresh modules for state activity
2017-10-29 15:14:02,432 [salt.state       ][INFO    ][24813] Completed state [bc] at time 15:14:02.431891 duration_in_ms=3028.123
2017-10-29 15:14:02,499 [salt.state       ][INFO    ][24813] Running state [glusterfs-server] at time 15:14:02.499414
2017-10-29 15:14:02,500 [salt.state       ][INFO    ][24813] Executing state service.running for glusterfs-server
2017-10-29 15:14:02,501 [salt.loaded.int.module.cmdmod][INFO    ][24813] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-10-29 15:14:02,511 [salt.loaded.int.module.cmdmod][INFO    ][24813] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-10-29 15:14:02,519 [salt.loaded.int.module.cmdmod][INFO    ][24813] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-10-29 15:14:02,529 [salt.state       ][INFO    ][24813] The service glusterfs-server is already running
2017-10-29 15:14:02,529 [salt.state       ][INFO    ][24813] Completed state [glusterfs-server] at time 15:14:02.529458 duration_in_ms=30.045
2017-10-29 15:14:02,531 [salt.state       ][INFO    ][24813] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 15:14:02.531043
2017-10-29 15:14:02,531 [salt.state       ][INFO    ][24813] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-10-29 15:14:02,545 [salt.state       ][INFO    ][24813] File changed:
New file
2017-10-29 15:14:02,545 [salt.state       ][INFO    ][24813] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 15:14:02.544754 duration_in_ms=13.711
2017-10-29 15:14:02,545 [salt.state       ][INFO    ][24813] Running state [/srv/glusterfs/glance] at time 15:14:02.544937
2017-10-29 15:14:02,545 [salt.state       ][INFO    ][24813] Executing state file.directory for /srv/glusterfs/glance
2017-10-29 15:14:02,546 [salt.state       ][INFO    ][24813] {'/srv/glusterfs/glance': 'New Dir'}
2017-10-29 15:14:02,546 [salt.state       ][INFO    ][24813] Completed state [/srv/glusterfs/glance] at time 15:14:02.545797 duration_in_ms=0.86
2017-10-29 15:14:02,546 [salt.state       ][INFO    ][24813] Running state [/srv/glusterfs/keystone-keys] at time 15:14:02.545936
2017-10-29 15:14:02,546 [salt.state       ][INFO    ][24813] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-10-29 15:14:02,546 [salt.state       ][INFO    ][24813] {'/srv/glusterfs/keystone-keys': 'New Dir'}
2017-10-29 15:14:02,547 [salt.state       ][INFO    ][24813] Completed state [/srv/glusterfs/keystone-keys] at time 15:14:02.546558 duration_in_ms=0.622
2017-10-29 15:14:02,547 [salt.state       ][INFO    ][24813] Running state [/srv/glusterfs/nova_instances] at time 15:14:02.546699
2017-10-29 15:14:02,547 [salt.state       ][INFO    ][24813] Executing state file.directory for /srv/glusterfs/nova_instances
2017-10-29 15:14:02,547 [salt.state       ][INFO    ][24813] {'/srv/glusterfs/nova_instances': 'New Dir'}
2017-10-29 15:14:02,547 [salt.state       ][INFO    ][24813] Completed state [/srv/glusterfs/nova_instances] at time 15:14:02.547340 duration_in_ms=0.64
2017-10-29 15:14:02,548 [salt.state       ][INFO    ][24813] Running state [/srv/glusterfs/keystone-credential-keys] at time 15:14:02.547482
2017-10-29 15:14:02,548 [salt.state       ][INFO    ][24813] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-10-29 15:14:02,548 [salt.state       ][INFO    ][24813] {'/srv/glusterfs/keystone-credential-keys': 'New Dir'}
2017-10-29 15:14:02,548 [salt.state       ][INFO    ][24813] Completed state [/srv/glusterfs/keystone-credential-keys] at time 15:14:02.548086 duration_in_ms=0.603
2017-10-29 15:14:02,549 [salt.minion      ][INFO    ][24813] Returning information for job: 20171029151336622350
2017-10-29 15:14:06,743 [salt.minion      ][INFO    ][22539] User sudo_ubuntu Executing command test.ping with jid 20171029151406736478
2017-10-29 15:14:06,758 [salt.minion      ][INFO    ][29585] Starting a new job with PID 29585
2017-10-29 15:14:06,787 [salt.minion      ][INFO    ][29585] Returning information for job: 20171029151406736478
2017-10-29 15:14:06,928 [salt.minion      ][INFO    ][22539] User sudo_ubuntu Executing command state.sls with jid 20171029151406917650
2017-10-29 15:14:06,942 [salt.minion      ][INFO    ][29590] Starting a new job with PID 29590
2017-10-29 15:14:08,387 [salt.state       ][INFO    ][29590] Loading fresh modules for state activity
2017-10-29 15:14:08,408 [salt.fileclient  ][INFO    ][29590] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/setup.sls'
2017-10-29 15:14:08,440 [salt.fileclient  ][INFO    ][29590] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-10-29 15:14:08,508 [salt.fileclient  ][INFO    ][29590] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-10-29 15:14:08,528 [salt.fileclient  ][INFO    ][29590] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-10-29 15:14:08,800 [salt.state       ][INFO    ][29590] Running state [attr] at time 15:14:08.799995
2017-10-29 15:14:08,800 [salt.state       ][INFO    ][29590] Executing state pkg.installed for attr
2017-10-29 15:14:08,801 [salt.loaded.int.module.cmdmod][INFO    ][29590] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-10-29 15:14:09,043 [salt.state       ][INFO    ][29590] Package attr is already installed
2017-10-29 15:14:09,043 [salt.state       ][INFO    ][29590] Completed state [attr] at time 15:14:09.043344 duration_in_ms=243.348
2017-10-29 15:14:09,044 [salt.state       ][INFO    ][29590] Running state [glusterfs-server] at time 15:14:09.043535
2017-10-29 15:14:09,044 [salt.state       ][INFO    ][29590] Executing state pkg.installed for glusterfs-server
2017-10-29 15:14:09,046 [salt.state       ][INFO    ][29590] Package glusterfs-server is already installed
2017-10-29 15:14:09,046 [salt.state       ][INFO    ][29590] Completed state [glusterfs-server] at time 15:14:09.046374 duration_in_ms=2.839
2017-10-29 15:14:09,047 [salt.state       ][INFO    ][29590] Running state [bc] at time 15:14:09.046525
2017-10-29 15:14:09,047 [salt.state       ][INFO    ][29590] Executing state pkg.installed for bc
2017-10-29 15:14:09,049 [salt.state       ][INFO    ][29590] Package bc is already installed
2017-10-29 15:14:09,049 [salt.state       ][INFO    ][29590] Completed state [bc] at time 15:14:09.049270 duration_in_ms=2.745
2017-10-29 15:14:09,050 [salt.state       ][INFO    ][29590] Running state [glusterfs-server] at time 15:14:09.050070
2017-10-29 15:14:09,050 [salt.state       ][INFO    ][29590] Executing state service.running for glusterfs-server
2017-10-29 15:14:09,051 [salt.loaded.int.module.cmdmod][INFO    ][29590] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-10-29 15:14:09,061 [salt.loaded.int.module.cmdmod][INFO    ][29590] Executing command ['systemctl', '--system', 'daemon-reload'] in directory '/root'
2017-10-29 15:14:09,105 [salt.loaded.int.module.cmdmod][INFO    ][29590] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-10-29 15:14:09,120 [salt.loaded.int.module.cmdmod][INFO    ][29590] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-10-29 15:14:09,127 [salt.loaded.int.module.cmdmod][INFO    ][29590] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-10-29 15:14:09,136 [salt.state       ][INFO    ][29590] The service glusterfs-server is already running
2017-10-29 15:14:09,137 [salt.state       ][INFO    ][29590] Completed state [glusterfs-server] at time 15:14:09.136517 duration_in_ms=86.447
2017-10-29 15:14:09,138 [salt.state       ][INFO    ][29590] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 15:14:09.138051
2017-10-29 15:14:09,138 [salt.state       ][INFO    ][29590] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-10-29 15:14:09,145 [salt.state       ][INFO    ][29590] File /etc/systemd/system/glusterfs-server.service.d/override.conf is in the correct state
2017-10-29 15:14:09,146 [salt.state       ][INFO    ][29590] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 15:14:09.145598 duration_in_ms=7.549
2017-10-29 15:14:09,146 [salt.state       ][INFO    ][29590] Running state [/srv/glusterfs/glance] at time 15:14:09.145800
2017-10-29 15:14:09,146 [salt.state       ][INFO    ][29590] Executing state file.directory for /srv/glusterfs/glance
2017-10-29 15:14:09,146 [salt.state       ][INFO    ][29590] Directory /srv/glusterfs/glance is in the correct state
2017-10-29 15:14:09,147 [salt.state       ][INFO    ][29590] Completed state [/srv/glusterfs/glance] at time 15:14:09.146510 duration_in_ms=0.71
2017-10-29 15:14:09,147 [salt.state       ][INFO    ][29590] Running state [/srv/glusterfs/keystone-keys] at time 15:14:09.146679
2017-10-29 15:14:09,147 [salt.state       ][INFO    ][29590] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-10-29 15:14:09,147 [salt.state       ][INFO    ][29590] Directory /srv/glusterfs/keystone-keys is in the correct state
2017-10-29 15:14:09,147 [salt.state       ][INFO    ][29590] Completed state [/srv/glusterfs/keystone-keys] at time 15:14:09.147317 duration_in_ms=0.638
2017-10-29 15:14:09,148 [salt.state       ][INFO    ][29590] Running state [/srv/glusterfs/nova_instances] at time 15:14:09.147483
2017-10-29 15:14:09,148 [salt.state       ][INFO    ][29590] Executing state file.directory for /srv/glusterfs/nova_instances
2017-10-29 15:14:09,148 [salt.state       ][INFO    ][29590] Directory /srv/glusterfs/nova_instances is in the correct state
2017-10-29 15:14:09,148 [salt.state       ][INFO    ][29590] Completed state [/srv/glusterfs/nova_instances] at time 15:14:09.148144 duration_in_ms=0.661
2017-10-29 15:14:09,148 [salt.state       ][INFO    ][29590] Running state [/srv/glusterfs/keystone-credential-keys] at time 15:14:09.148308
2017-10-29 15:14:09,148 [salt.state       ][INFO    ][29590] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-10-29 15:14:09,149 [salt.state       ][INFO    ][29590] Directory /srv/glusterfs/keystone-credential-keys is in the correct state
2017-10-29 15:14:09,149 [salt.state       ][INFO    ][29590] Completed state [/srv/glusterfs/keystone-credential-keys] at time 15:14:09.148984 duration_in_ms=0.676
2017-10-29 15:14:09,204 [salt.loaded.int.module.cmdmod][INFO    ][29590] Executing command ['git', '--version'] in directory '/root'
2017-10-29 15:14:09,288 [salt.state       ][INFO    ][29590] Running state [sleep 5] at time 15:14:09.288207
2017-10-29 15:14:09,288 [salt.state       ][INFO    ][29590] Executing state cmd.wait for sleep 5
2017-10-29 15:14:09,289 [salt.state       ][INFO    ][29590] No changes made for sleep 5
2017-10-29 15:14:09,289 [salt.state       ][INFO    ][29590] Completed state [sleep 5] at time 15:14:09.288753 duration_in_ms=0.546
2017-10-29 15:14:09,289 [salt.state       ][INFO    ][29590] Running state [10.167.4.141] at time 15:14:09.289142
2017-10-29 15:14:09,289 [salt.state       ][INFO    ][29590] Executing state glusterfs.peered for 10.167.4.141
2017-10-29 15:14:09,290 [salt.loaded.int.module.cmdmod][INFO    ][29590] Executing command 'gluster --version' in directory '/root'
2017-10-29 15:14:09,299 [salt.loaded.int.module.cmdmod][INFO    ][29590] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-29 15:14:09,350 [salt.loaded.int.module.cmdmod][INFO    ][29590] Executing command 'gluster --version' in directory '/root'
2017-10-29 15:14:09,358 [salt.loaded.int.module.cmdmod][INFO    ][29590] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-29 15:14:09,719 [salt.loaded.int.module.cmdmod][INFO    ][29590] Executing command 'gluster --version' in directory '/root'
2017-10-29 15:14:09,732 [salt.loaded.int.module.cmdmod][INFO    ][29590] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-29 15:14:09,792 [salt.loaded.int.module.cmdmod][INFO    ][29590] Executing command 'gluster --version' in directory '/root'
2017-10-29 15:14:09,803 [salt.loaded.int.module.cmdmod][INFO    ][29590] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-29 15:14:09,861 [salt.state       ][INFO    ][29590] {'new': {'10.167.4.141': []}, 'old': None}
2017-10-29 15:14:09,861 [salt.state       ][INFO    ][29590] Completed state [10.167.4.141] at time 15:14:09.860876 duration_in_ms=571.732
2017-10-29 15:14:09,863 [salt.state       ][INFO    ][29590] Running state [10.167.4.142] at time 15:14:09.863215
2017-10-29 15:14:09,863 [salt.state       ][INFO    ][29590] Executing state glusterfs.peered for 10.167.4.142
2017-10-29 15:14:09,864 [salt.loaded.int.module.cmdmod][INFO    ][29590] Executing command 'gluster --version' in directory '/root'
2017-10-29 15:14:09,875 [salt.loaded.int.module.cmdmod][INFO    ][29590] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-29 15:14:09,988 [salt.loaded.int.module.cmdmod][INFO    ][29590] Executing command 'gluster --version' in directory '/root'
2017-10-29 15:14:09,999 [salt.loaded.int.module.cmdmod][INFO    ][29590] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-29 15:14:10,055 [salt.loaded.int.module.cmdmod][INFO    ][29590] Executing command 'gluster --version' in directory '/root'
2017-10-29 15:14:10,065 [salt.loaded.int.module.cmdmod][INFO    ][29590] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-29 15:14:10,116 [salt.loaded.int.module.cmdmod][INFO    ][29590] Executing command 'gluster --version' in directory '/root'
2017-10-29 15:14:10,125 [salt.loaded.int.module.cmdmod][INFO    ][29590] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-29 15:14:10,174 [salt.state       ][INFO    ][29590] Peering with localhost is not needed
2017-10-29 15:14:10,174 [salt.state       ][INFO    ][29590] Completed state [10.167.4.142] at time 15:14:10.174309 duration_in_ms=311.094
2017-10-29 15:14:10,177 [salt.state       ][INFO    ][29590] Running state [10.167.4.143] at time 15:14:10.176522
2017-10-29 15:14:10,177 [salt.state       ][INFO    ][29590] Executing state glusterfs.peered for 10.167.4.143
2017-10-29 15:14:10,177 [salt.loaded.int.module.cmdmod][INFO    ][29590] Executing command 'gluster --version' in directory '/root'
2017-10-29 15:14:10,187 [salt.loaded.int.module.cmdmod][INFO    ][29590] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-29 15:14:10,235 [salt.loaded.int.module.cmdmod][INFO    ][29590] Executing command 'gluster --version' in directory '/root'
2017-10-29 15:14:10,244 [salt.loaded.int.module.cmdmod][INFO    ][29590] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-29 15:14:10,524 [salt.loaded.int.module.cmdmod][INFO    ][29590] Executing command 'gluster --version' in directory '/root'
2017-10-29 15:14:10,535 [salt.loaded.int.module.cmdmod][INFO    ][29590] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-29 15:14:10,600 [salt.loaded.int.module.cmdmod][INFO    ][29590] Executing command 'gluster --version' in directory '/root'
2017-10-29 15:14:10,610 [salt.loaded.int.module.cmdmod][INFO    ][29590] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-29 15:14:10,659 [salt.state       ][INFO    ][29590] {'new': {'10.167.4.141': [], '10.167.4.143': []}, 'old': {'10.167.4.141': []}}
2017-10-29 15:14:10,660 [salt.state       ][INFO    ][29590] Completed state [10.167.4.143] at time 15:14:10.659618 duration_in_ms=483.095
2017-10-29 15:14:10,660 [salt.state       ][INFO    ][29590] Running state [glance] at time 15:14:10.660455
2017-10-29 15:14:10,661 [salt.state       ][INFO    ][29590] Executing state glusterfs.created for glance
2017-10-29 15:14:10,661 [salt.loaded.int.module.cmdmod][INFO    ][29590] Executing command 'gluster --version' in directory '/root'
2017-10-29 15:14:10,671 [salt.loaded.int.module.cmdmod][INFO    ][29590] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-29 15:14:10,807 [salt.loaded.int.module.cmdmod][INFO    ][29590] Executing command 'gluster --version' in directory '/root'
2017-10-29 15:14:10,817 [salt.loaded.int.module.cmdmod][INFO    ][29590] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-29 15:14:11,617 [salt.loaded.int.module.cmdmod][INFO    ][29590] Executing command 'gluster --version' in directory '/root'
2017-10-29 15:14:11,629 [salt.loaded.int.module.cmdmod][INFO    ][29590] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-29 15:14:12,636 [salt.loaded.int.module.cmdmod][INFO    ][29590] Executing command 'gluster --version' in directory '/root'
2017-10-29 15:14:12,648 [salt.loaded.int.module.cmdmod][INFO    ][29590] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-29 15:14:12,700 [salt.state       ][INFO    ][29590] {'new': ['glance'], 'old': []}
2017-10-29 15:14:12,700 [salt.state       ][INFO    ][29590] Completed state [glance] at time 15:14:12.699972 duration_in_ms=2039.515
2017-10-29 15:14:12,703 [salt.state       ][INFO    ][29590] Running state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 15:14:12.703195
2017-10-29 15:14:12,703 [salt.state       ][INFO    ][29590] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'
2017-10-29 15:14:12,704 [salt.loaded.int.module.cmdmod][INFO    ][29590] Executing command 'gluster volume info 'glance' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-10-29 15:14:12,758 [salt.loaded.int.module.cmdmod][INFO    ][29590] Executing command 'gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'' in directory '/root'
2017-10-29 15:14:13,366 [salt.state       ][INFO    ][29590] {'pid': 29812, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-10-29 15:14:13,366 [salt.state       ][INFO    ][29590] Completed state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 15:14:13.365910 duration_in_ms=662.715
2017-10-29 15:14:13,366 [salt.state       ][INFO    ][29590] Running state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 15:14:13.366443
2017-10-29 15:14:13,367 [salt.state       ][INFO    ][29590] Executing state cmd.run for gluster volume set 'glance' 'network.remote-dio' 'True'
2017-10-29 15:14:13,367 [salt.loaded.int.module.cmdmod][INFO    ][29590] Executing command 'gluster volume info 'glance' | grep 'network.remote-dio: True'' in directory '/root'
2017-10-29 15:14:13,422 [salt.loaded.int.module.cmdmod][INFO    ][29590] Executing command 'gluster volume set 'glance' 'network.remote-dio' 'True'' in directory '/root'
2017-10-29 15:14:14,154 [salt.state       ][INFO    ][29590] {'pid': 29830, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-10-29 15:14:14,154 [salt.state       ][INFO    ][29590] Completed state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 15:14:14.154069 duration_in_ms=787.625
2017-10-29 15:14:14,155 [salt.state       ][INFO    ][29590] Running state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 15:14:14.154615
2017-10-29 15:14:14,155 [salt.state       ][INFO    ][29590] Executing state cmd.run for gluster volume set 'glance' 'nfs.disable' 'True'
2017-10-29 15:14:14,155 [salt.loaded.int.module.cmdmod][INFO    ][29590] Executing command 'gluster volume info 'glance' | grep 'nfs.disable: True'' in directory '/root'
2017-10-29 15:14:14,209 [salt.loaded.int.module.cmdmod][INFO    ][29590] Executing command 'gluster volume set 'glance' 'nfs.disable' 'True'' in directory '/root'
2017-10-29 15:14:16,970 [salt.minion      ][INFO    ][22539] User sudo_ubuntu Executing command saltutil.find_job with jid 20171029151416957527
2017-10-29 15:14:16,985 [salt.minion      ][INFO    ][29862] Starting a new job with PID 29862
2017-10-29 15:14:16,997 [salt.minion      ][INFO    ][29862] Returning information for job: 20171029151416957527
2017-10-29 15:14:17,335 [salt.state       ][INFO    ][29590] {'pid': 29850, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-10-29 15:14:17,335 [salt.state       ][INFO    ][29590] Completed state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 15:14:17.335297 duration_in_ms=3180.68
2017-10-29 15:14:17,336 [salt.state       ][INFO    ][29590] Running state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 15:14:17.335853
2017-10-29 15:14:17,336 [salt.state       ][INFO    ][29590] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'
2017-10-29 15:14:17,337 [salt.loaded.int.module.cmdmod][INFO    ][29590] Executing command 'gluster volume info 'glance' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-10-29 15:14:17,396 [salt.loaded.int.module.cmdmod][INFO    ][29590] Executing command 'gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'' in directory '/root'
2017-10-29 15:14:17,990 [salt.state       ][INFO    ][29590] {'pid': 29876, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-10-29 15:14:17,991 [salt.state       ][INFO    ][29590] Completed state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 15:14:17.990610 duration_in_ms=654.756
2017-10-29 15:14:17,991 [salt.state       ][INFO    ][29590] Running state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 15:14:17.991174
2017-10-29 15:14:17,991 [salt.state       ][INFO    ][29590] Executing state cmd.run for gluster volume set 'glance' 'cluster.readdir-optimize' 'True'
2017-10-29 15:14:17,992 [salt.loaded.int.module.cmdmod][INFO    ][29590] Executing command 'gluster volume info 'glance' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-10-29 15:14:18,047 [salt.loaded.int.module.cmdmod][INFO    ][29590] Executing command 'gluster volume set 'glance' 'cluster.readdir-optimize' 'True'' in directory '/root'
2017-10-29 15:14:18,650 [salt.state       ][INFO    ][29590] {'pid': 29893, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-10-29 15:14:18,650 [salt.state       ][INFO    ][29590] Completed state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 15:14:18.650059 duration_in_ms=658.885
2017-10-29 15:14:18,651 [salt.state       ][INFO    ][29590] Running state [glance] at time 15:14:18.651068
2017-10-29 15:14:18,651 [salt.state       ][INFO    ][29590] Executing state glusterfs.started for glance
2017-10-29 15:14:18,652 [salt.loaded.int.module.cmdmod][INFO    ][29590] Executing command 'gluster --version' in directory '/root'
2017-10-29 15:14:18,664 [salt.loaded.int.module.cmdmod][INFO    ][29590] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-29 15:14:18,715 [salt.loaded.int.module.cmdmod][INFO    ][29590] Executing command 'gluster --version' in directory '/root'
2017-10-29 15:14:18,725 [salt.loaded.int.module.cmdmod][INFO    ][29590] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-29 15:14:18,788 [salt.state       ][INFO    ][29590] Volume glance is already started
2017-10-29 15:14:18,788 [salt.state       ][INFO    ][29590] Completed state [glance] at time 15:14:18.787898 duration_in_ms=136.83
2017-10-29 15:14:18,789 [salt.state       ][INFO    ][29590] Running state [keystone-keys] at time 15:14:18.788874
2017-10-29 15:14:18,789 [salt.state       ][INFO    ][29590] Executing state glusterfs.created for keystone-keys
2017-10-29 15:14:18,790 [salt.loaded.int.module.cmdmod][INFO    ][29590] Executing command 'gluster --version' in directory '/root'
2017-10-29 15:14:18,799 [salt.loaded.int.module.cmdmod][INFO    ][29590] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-29 15:14:18,849 [salt.loaded.int.module.cmdmod][INFO    ][29590] Executing command 'gluster --version' in directory '/root'
2017-10-29 15:14:18,858 [salt.loaded.int.module.cmdmod][INFO    ][29590] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-29 15:14:19,799 [salt.loaded.int.module.cmdmod][INFO    ][29590] Executing command 'gluster --version' in directory '/root'
2017-10-29 15:14:19,812 [salt.loaded.int.module.cmdmod][INFO    ][29590] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-29 15:14:22,604 [salt.loaded.int.module.cmdmod][INFO    ][29590] Executing command 'gluster --version' in directory '/root'
2017-10-29 15:14:22,616 [salt.loaded.int.module.cmdmod][INFO    ][29590] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-29 15:14:22,669 [salt.state       ][INFO    ][29590] {'new': ['glance', 'keystone-keys'], 'old': ['glance']}
2017-10-29 15:14:22,669 [salt.state       ][INFO    ][29590] Completed state [keystone-keys] at time 15:14:22.668773 duration_in_ms=3879.899
2017-10-29 15:14:22,672 [salt.state       ][INFO    ][29590] Running state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 15:14:22.671605
2017-10-29 15:14:22,672 [salt.state       ][INFO    ][29590] Executing state cmd.run for gluster volume set 'keystone-keys' 'network.remote-dio' 'True'
2017-10-29 15:14:22,672 [salt.loaded.int.module.cmdmod][INFO    ][29590] Executing command 'gluster volume info 'keystone-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-10-29 15:14:22,723 [salt.loaded.int.module.cmdmod][INFO    ][29590] Executing command 'gluster volume set 'keystone-keys' 'network.remote-dio' 'True'' in directory '/root'
2017-10-29 15:14:23,350 [salt.state       ][INFO    ][29590] {'pid': 30004, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-10-29 15:14:23,350 [salt.state       ][INFO    ][29590] Completed state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 15:14:23.349856 duration_in_ms=678.251
2017-10-29 15:14:23,351 [salt.state       ][INFO    ][29590] Running state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 15:14:23.350996
2017-10-29 15:14:23,351 [salt.state       ][INFO    ][29590] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-10-29 15:14:23,352 [salt.loaded.int.module.cmdmod][INFO    ][29590] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-10-29 15:14:23,411 [salt.loaded.int.module.cmdmod][INFO    ][29590] Executing command 'gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'' in directory '/root'
2017-10-29 15:14:24,064 [salt.state       ][INFO    ][29590] {'pid': 30021, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-10-29 15:14:24,064 [salt.state       ][INFO    ][29590] Completed state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 15:14:24.064196 duration_in_ms=713.199
2017-10-29 15:14:24,065 [salt.state       ][INFO    ][29590] Running state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 15:14:24.064789
2017-10-29 15:14:24,065 [salt.state       ][INFO    ][29590] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'
2017-10-29 15:14:24,066 [salt.loaded.int.module.cmdmod][INFO    ][29590] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-10-29 15:14:24,120 [salt.loaded.int.module.cmdmod][INFO    ][29590] Executing command 'gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'' in directory '/root'
2017-10-29 15:14:24,760 [salt.state       ][INFO    ][29590] {'pid': 30039, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-10-29 15:14:24,760 [salt.state       ][INFO    ][29590] Completed state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 15:14:24.759795 duration_in_ms=695.005
2017-10-29 15:14:24,760 [salt.state       ][INFO    ][29590] Running state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 15:14:24.760388
2017-10-29 15:14:24,761 [salt.state       ][INFO    ][29590] Executing state cmd.run for gluster volume set 'keystone-keys' 'nfs.disable' 'True'
2017-10-29 15:14:24,761 [salt.loaded.int.module.cmdmod][INFO    ][29590] Executing command 'gluster volume info 'keystone-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-10-29 15:14:24,820 [salt.loaded.int.module.cmdmod][INFO    ][29590] Executing command 'gluster volume set 'keystone-keys' 'nfs.disable' 'True'' in directory '/root'
2017-10-29 15:14:27,113 [salt.minion      ][INFO    ][22539] User sudo_ubuntu Executing command saltutil.find_job with jid 20171029151427100656
2017-10-29 15:14:27,128 [salt.minion      ][INFO    ][30070] Starting a new job with PID 30070
2017-10-29 15:14:27,138 [salt.minion      ][INFO    ][30070] Returning information for job: 20171029151427100656
2017-10-29 15:14:27,513 [salt.state       ][INFO    ][29590] {'pid': 30056, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-10-29 15:14:27,513 [salt.state       ][INFO    ][29590] Completed state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 15:14:27.513062 duration_in_ms=2752.673
2017-10-29 15:14:27,514 [salt.state       ][INFO    ][29590] Running state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 15:14:27.514049
2017-10-29 15:14:27,514 [salt.state       ][INFO    ][29590] Executing state cmd.run for gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'
2017-10-29 15:14:27,515 [salt.loaded.int.module.cmdmod][INFO    ][29590] Executing command 'gluster volume info 'keystone-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-10-29 15:14:27,571 [salt.loaded.int.module.cmdmod][INFO    ][29590] Executing command 'gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'' in directory '/root'
2017-10-29 15:14:28,208 [salt.state       ][INFO    ][29590] {'pid': 30082, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-10-29 15:14:28,208 [salt.state       ][INFO    ][29590] Completed state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 15:14:28.208024 duration_in_ms=693.976
2017-10-29 15:14:28,209 [salt.state       ][INFO    ][29590] Running state [keystone-keys] at time 15:14:28.209205
2017-10-29 15:14:28,210 [salt.state       ][INFO    ][29590] Executing state glusterfs.started for keystone-keys
2017-10-29 15:14:28,210 [salt.loaded.int.module.cmdmod][INFO    ][29590] Executing command 'gluster --version' in directory '/root'
2017-10-29 15:14:28,222 [salt.loaded.int.module.cmdmod][INFO    ][29590] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-29 15:14:28,275 [salt.loaded.int.module.cmdmod][INFO    ][29590] Executing command 'gluster --version' in directory '/root'
2017-10-29 15:14:28,285 [salt.loaded.int.module.cmdmod][INFO    ][29590] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-29 15:14:28,339 [salt.state       ][INFO    ][29590] Volume keystone-keys is already started
2017-10-29 15:14:28,339 [salt.state       ][INFO    ][29590] Completed state [keystone-keys] at time 15:14:28.338960 duration_in_ms=129.753
2017-10-29 15:14:28,340 [salt.state       ][INFO    ][29590] Running state [nova_instances] at time 15:14:28.339978
2017-10-29 15:14:28,340 [salt.state       ][INFO    ][29590] Executing state glusterfs.created for nova_instances
2017-10-29 15:14:28,341 [salt.loaded.int.module.cmdmod][INFO    ][29590] Executing command 'gluster --version' in directory '/root'
2017-10-29 15:14:28,351 [salt.loaded.int.module.cmdmod][INFO    ][29590] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-29 15:14:28,400 [salt.loaded.int.module.cmdmod][INFO    ][29590] Executing command 'gluster --version' in directory '/root'
2017-10-29 15:14:28,409 [salt.loaded.int.module.cmdmod][INFO    ][29590] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-29 15:14:29,127 [salt.loaded.int.module.cmdmod][INFO    ][29590] Executing command 'gluster --version' in directory '/root'
2017-10-29 15:14:29,138 [salt.loaded.int.module.cmdmod][INFO    ][29590] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-29 15:14:31,990 [salt.loaded.int.module.cmdmod][INFO    ][29590] Executing command 'gluster --version' in directory '/root'
2017-10-29 15:14:32,002 [salt.loaded.int.module.cmdmod][INFO    ][29590] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-29 15:14:32,053 [salt.state       ][INFO    ][29590] {'new': ['glance', 'keystone-keys', 'nova_instances'], 'old': ['glance', 'keystone-keys']}
2017-10-29 15:14:32,053 [salt.state       ][INFO    ][29590] Completed state [nova_instances] at time 15:14:32.053056 duration_in_ms=3713.078
2017-10-29 15:14:32,057 [salt.state       ][INFO    ][29590] Running state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 15:14:32.057080
2017-10-29 15:14:32,057 [salt.state       ][INFO    ][29590] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'
2017-10-29 15:14:32,058 [salt.loaded.int.module.cmdmod][INFO    ][29590] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-10-29 15:14:32,110 [salt.loaded.int.module.cmdmod][INFO    ][29590] Executing command 'gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'' in directory '/root'
2017-10-29 15:14:32,723 [salt.state       ][INFO    ][29590] {'pid': 30194, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-10-29 15:14:32,723 [salt.state       ][INFO    ][29590] Completed state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 15:14:32.723101 duration_in_ms=666.02
2017-10-29 15:14:32,724 [salt.state       ][INFO    ][29590] Running state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'On'] at time 15:14:32.723678
2017-10-29 15:14:32,724 [salt.state       ][INFO    ][29590] Executing state cmd.run for gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'On'
2017-10-29 15:14:32,725 [salt.loaded.int.module.cmdmod][INFO    ][29590] Executing command 'gluster volume info 'nova_instances' | grep 'cluster.readdir-optimize: On'' in directory '/root'
2017-10-29 15:14:32,782 [salt.loaded.int.module.cmdmod][INFO    ][29590] Executing command 'gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'On'' in directory '/root'
2017-10-29 15:14:33,478 [salt.state       ][INFO    ][29590] {'pid': 30212, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-10-29 15:14:33,478 [salt.state       ][INFO    ][29590] Completed state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'On'] at time 15:14:33.478264 duration_in_ms=754.585
2017-10-29 15:14:33,479 [salt.state       ][INFO    ][29590] Running state [gluster volume set 'nova_instances' 'network.remote-dio' 'On'] at time 15:14:33.478964
2017-10-29 15:14:33,479 [salt.state       ][INFO    ][29590] Executing state cmd.run for gluster volume set 'nova_instances' 'network.remote-dio' 'On'
2017-10-29 15:14:33,480 [salt.loaded.int.module.cmdmod][INFO    ][29590] Executing command 'gluster volume info 'nova_instances' | grep 'network.remote-dio: On'' in directory '/root'
2017-10-29 15:14:33,535 [salt.loaded.int.module.cmdmod][INFO    ][29590] Executing command 'gluster volume set 'nova_instances' 'network.remote-dio' 'On'' in directory '/root'
2017-10-29 15:14:34,134 [salt.state       ][INFO    ][29590] {'pid': 30229, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-10-29 15:14:34,135 [salt.state       ][INFO    ][29590] Completed state [gluster volume set 'nova_instances' 'network.remote-dio' 'On'] at time 15:14:34.134615 duration_in_ms=655.651
2017-10-29 15:14:34,135 [salt.state       ][INFO    ][29590] Running state [gluster volume set 'nova_instances' 'nfs.disable' 'On'] at time 15:14:34.135198
2017-10-29 15:14:34,136 [salt.state       ][INFO    ][29590] Executing state cmd.run for gluster volume set 'nova_instances' 'nfs.disable' 'On'
2017-10-29 15:14:34,136 [salt.loaded.int.module.cmdmod][INFO    ][29590] Executing command 'gluster volume info 'nova_instances' | grep 'nfs.disable: On'' in directory '/root'
2017-10-29 15:14:34,191 [salt.loaded.int.module.cmdmod][INFO    ][29590] Executing command 'gluster volume set 'nova_instances' 'nfs.disable' 'On'' in directory '/root'
2017-10-29 15:14:36,857 [salt.state       ][INFO    ][29590] {'pid': 30246, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-10-29 15:14:36,857 [salt.state       ][INFO    ][29590] Completed state [gluster volume set 'nova_instances' 'nfs.disable' 'On'] at time 15:14:36.857360 duration_in_ms=2722.161
2017-10-29 15:14:36,858 [salt.state       ][INFO    ][29590] Running state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 15:14:36.857950
2017-10-29 15:14:36,858 [salt.state       ][INFO    ][29590] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'
2017-10-29 15:14:36,859 [salt.loaded.int.module.cmdmod][INFO    ][29590] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-10-29 15:14:36,917 [salt.loaded.int.module.cmdmod][INFO    ][29590] Executing command 'gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'' in directory '/root'
2017-10-29 15:14:37,254 [salt.minion      ][INFO    ][22539] User sudo_ubuntu Executing command saltutil.find_job with jid 20171029151437242890
2017-10-29 15:14:37,270 [salt.minion      ][INFO    ][30277] Starting a new job with PID 30277
2017-10-29 15:14:37,280 [salt.minion      ][INFO    ][30277] Returning information for job: 20171029151437242890
2017-10-29 15:14:37,534 [salt.state       ][INFO    ][29590] {'pid': 30267, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-10-29 15:14:37,535 [salt.state       ][INFO    ][29590] Completed state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 15:14:37.534702 duration_in_ms=676.751
2017-10-29 15:14:37,536 [salt.state       ][INFO    ][29590] Running state [nova_instances] at time 15:14:37.535728
2017-10-29 15:14:37,536 [salt.state       ][INFO    ][29590] Executing state glusterfs.started for nova_instances
2017-10-29 15:14:37,537 [salt.loaded.int.module.cmdmod][INFO    ][29590] Executing command 'gluster --version' in directory '/root'
2017-10-29 15:14:37,548 [salt.loaded.int.module.cmdmod][INFO    ][29590] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-29 15:14:37,602 [salt.loaded.int.module.cmdmod][INFO    ][29590] Executing command 'gluster --version' in directory '/root'
2017-10-29 15:14:37,613 [salt.loaded.int.module.cmdmod][INFO    ][29590] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-29 15:14:37,671 [salt.state       ][INFO    ][29590] Volume nova_instances is already started
2017-10-29 15:14:37,671 [salt.state       ][INFO    ][29590] Completed state [nova_instances] at time 15:14:37.670955 duration_in_ms=135.226
2017-10-29 15:14:37,672 [salt.state       ][INFO    ][29590] Running state [keystone-credential-keys] at time 15:14:37.671914
2017-10-29 15:14:37,672 [salt.state       ][INFO    ][29590] Executing state glusterfs.created for keystone-credential-keys
2017-10-29 15:14:37,673 [salt.loaded.int.module.cmdmod][INFO    ][29590] Executing command 'gluster --version' in directory '/root'
2017-10-29 15:14:37,683 [salt.loaded.int.module.cmdmod][INFO    ][29590] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-29 15:14:37,735 [salt.loaded.int.module.cmdmod][INFO    ][29590] Executing command 'gluster --version' in directory '/root'
2017-10-29 15:14:37,745 [salt.loaded.int.module.cmdmod][INFO    ][29590] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-29 15:14:38,461 [salt.loaded.int.module.cmdmod][INFO    ][29590] Executing command 'gluster --version' in directory '/root'
2017-10-29 15:14:38,473 [salt.loaded.int.module.cmdmod][INFO    ][29590] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-29 15:14:41,397 [salt.loaded.int.module.cmdmod][INFO    ][29590] Executing command 'gluster --version' in directory '/root'
2017-10-29 15:14:41,410 [salt.loaded.int.module.cmdmod][INFO    ][29590] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-29 15:14:41,462 [salt.state       ][INFO    ][29590] {'new': ['glance', 'keystone-credential-keys', 'keystone-keys', 'nova_instances'], 'old': ['glance', 'keystone-keys', 'nova_instances']}
2017-10-29 15:14:41,462 [salt.state       ][INFO    ][29590] Completed state [keystone-credential-keys] at time 15:14:41.462060 duration_in_ms=3790.145
2017-10-29 15:14:41,466 [salt.state       ][INFO    ][29590] Running state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 15:14:41.465474
2017-10-29 15:14:41,466 [salt.state       ][INFO    ][29590] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'
2017-10-29 15:14:41,466 [salt.loaded.int.module.cmdmod][INFO    ][29590] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-10-29 15:14:41,518 [salt.loaded.int.module.cmdmod][INFO    ][29590] Executing command 'gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'' in directory '/root'
2017-10-29 15:14:42,175 [salt.state       ][INFO    ][29590] {'pid': 30388, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-10-29 15:14:42,175 [salt.state       ][INFO    ][29590] Completed state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 15:14:42.175233 duration_in_ms=709.758
2017-10-29 15:14:42,176 [salt.state       ][INFO    ][29590] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 15:14:42.175819
2017-10-29 15:14:42,176 [salt.state       ][INFO    ][29590] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-10-29 15:14:42,177 [salt.loaded.int.module.cmdmod][INFO    ][29590] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-10-29 15:14:42,231 [salt.loaded.int.module.cmdmod][INFO    ][29590] Executing command 'gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'' in directory '/root'
2017-10-29 15:14:42,903 [salt.state       ][INFO    ][29590] {'pid': 30406, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-10-29 15:14:42,903 [salt.state       ][INFO    ][29590] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 15:14:42.902892 duration_in_ms=727.071
2017-10-29 15:14:42,904 [salt.state       ][INFO    ][29590] Running state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 15:14:42.903465
2017-10-29 15:14:42,904 [salt.state       ][INFO    ][29590] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'
2017-10-29 15:14:42,904 [salt.loaded.int.module.cmdmod][INFO    ][29590] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-10-29 15:14:42,961 [salt.loaded.int.module.cmdmod][INFO    ][29590] Executing command 'gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'' in directory '/root'
2017-10-29 15:14:45,603 [salt.state       ][INFO    ][29590] {'pid': 30424, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-10-29 15:14:45,604 [salt.state       ][INFO    ][29590] Completed state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 15:14:45.603661 duration_in_ms=2700.195
2017-10-29 15:14:45,604 [salt.state       ][INFO    ][29590] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 15:14:45.604258
2017-10-29 15:14:45,605 [salt.state       ][INFO    ][29590] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'
2017-10-29 15:14:45,605 [salt.loaded.int.module.cmdmod][INFO    ][29590] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-10-29 15:14:45,660 [salt.loaded.int.module.cmdmod][INFO    ][29590] Executing command 'gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'' in directory '/root'
2017-10-29 15:14:46,284 [salt.state       ][INFO    ][29590] {'pid': 30444, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-10-29 15:14:46,284 [salt.state       ][INFO    ][29590] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 15:14:46.284118 duration_in_ms=679.859
2017-10-29 15:14:46,285 [salt.state       ][INFO    ][29590] Running state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 15:14:46.284728
2017-10-29 15:14:46,285 [salt.state       ][INFO    ][29590] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'
2017-10-29 15:14:46,286 [salt.loaded.int.module.cmdmod][INFO    ][29590] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-10-29 15:14:46,346 [salt.loaded.int.module.cmdmod][INFO    ][29590] Executing command 'gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'' in directory '/root'
2017-10-29 15:14:46,972 [salt.state       ][INFO    ][29590] {'pid': 30462, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-10-29 15:14:46,972 [salt.state       ][INFO    ][29590] Completed state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 15:14:46.972184 duration_in_ms=687.454
2017-10-29 15:14:46,973 [salt.state       ][INFO    ][29590] Running state [keystone-credential-keys] at time 15:14:46.973274
2017-10-29 15:14:46,974 [salt.state       ][INFO    ][29590] Executing state glusterfs.started for keystone-credential-keys
2017-10-29 15:14:46,974 [salt.loaded.int.module.cmdmod][INFO    ][29590] Executing command 'gluster --version' in directory '/root'
2017-10-29 15:14:46,986 [salt.loaded.int.module.cmdmod][INFO    ][29590] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-29 15:14:47,039 [salt.loaded.int.module.cmdmod][INFO    ][29590] Executing command 'gluster --version' in directory '/root'
2017-10-29 15:14:47,049 [salt.loaded.int.module.cmdmod][INFO    ][29590] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-29 15:14:47,104 [salt.state       ][INFO    ][29590] Volume keystone-credential-keys is already started
2017-10-29 15:14:47,104 [salt.state       ][INFO    ][29590] Completed state [keystone-credential-keys] at time 15:14:47.104263 duration_in_ms=130.988
2017-10-29 15:14:47,107 [salt.minion      ][INFO    ][29590] Returning information for job: 20171029151406917650
2017-10-29 15:14:57,026 [salt.minion      ][INFO    ][22539] User sudo_ubuntu Executing command test.ping with jid 20171029151457018580
2017-10-29 15:14:57,043 [salt.minion      ][INFO    ][30491] Starting a new job with PID 30491
2017-10-29 15:14:57,067 [salt.minion      ][INFO    ][30491] Returning information for job: 20171029151457018580
2017-10-29 15:14:57,202 [salt.minion      ][INFO    ][22539] User sudo_ubuntu Executing command cmd.run with jid 20171029151457190172
2017-10-29 15:14:57,217 [salt.minion      ][INFO    ][30496] Starting a new job with PID 30496
2017-10-29 15:14:57,221 [salt.loaded.int.module.cmdmod][INFO    ][30496] Executing command 'gluster peer status; gluster volume status' in directory '/root'
2017-10-29 15:14:57,328 [salt.minion      ][INFO    ][30496] Returning information for job: 20171029151457190172
2017-10-29 15:52:52,806 [salt.minion      ][INFO    ][22539] User sudo_ubuntu Executing command test.ping with jid 20171029155252798637
2017-10-29 15:52:52,829 [salt.minion      ][INFO    ][31120] Starting a new job with PID 31120
2017-10-29 15:52:52,861 [salt.minion      ][INFO    ][31120] Returning information for job: 20171029155252798637
2017-10-29 15:53:15,191 [salt.minion      ][INFO    ][22539] User sudo_ubuntu Executing command state.sls with jid 20171029155315180333
2017-10-29 15:53:15,207 [salt.minion      ][INFO    ][31127] Starting a new job with PID 31127
2017-10-29 15:53:15,625 [salt.state       ][INFO    ][31127] Loading fresh modules for state activity
2017-10-29 15:53:15,651 [salt.fileclient  ][INFO    ][31127] Fetching file from saltenv 'base', ** done ** 'keepalived/init.sls'
2017-10-29 15:53:15,668 [salt.fileclient  ][INFO    ][31127] Fetching file from saltenv 'base', ** done ** 'keepalived/cluster.sls'
2017-10-29 15:53:15,692 [salt.fileclient  ][INFO    ][31127] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-10-29 15:53:15,952 [salt.state       ][INFO    ][31127] Running state [lsof] at time 15:53:15.951970
2017-10-29 15:53:15,952 [salt.state       ][INFO    ][31127] Executing state pkg.installed for lsof
2017-10-29 15:53:15,953 [salt.loaded.int.module.cmdmod][INFO    ][31127] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-10-29 15:53:16,201 [salt.state       ][INFO    ][31127] Package lsof is already installed
2017-10-29 15:53:16,201 [salt.state       ][INFO    ][31127] Completed state [lsof] at time 15:53:16.200906 duration_in_ms=248.937
2017-10-29 15:53:16,201 [salt.state       ][INFO    ][31127] Running state [keepalived] at time 15:53:16.201109
2017-10-29 15:53:16,201 [salt.state       ][INFO    ][31127] Executing state pkg.installed for keepalived
2017-10-29 15:53:16,204 [salt.state       ][INFO    ][31127] Package keepalived is already installed
2017-10-29 15:53:16,204 [salt.state       ][INFO    ][31127] Completed state [keepalived] at time 15:53:16.203952 duration_in_ms=2.844
2017-10-29 15:53:16,205 [salt.state       ][INFO    ][31127] Running state [/etc/keepalived/keepalived.conf] at time 15:53:16.205338
2017-10-29 15:53:16,206 [salt.state       ][INFO    ][31127] Executing state file.managed for /etc/keepalived/keepalived.conf
2017-10-29 15:53:16,226 [salt.fileclient  ][INFO    ][31127] Fetching file from saltenv 'base', ** done ** 'keepalived/files/keepalived.conf'
2017-10-29 15:53:16,257 [salt.fileclient  ][INFO    ][31127] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-10-29 15:53:16,261 [salt.state       ][INFO    ][31127] File /etc/keepalived/keepalived.conf is in the correct state
2017-10-29 15:53:16,261 [salt.state       ][INFO    ][31127] Completed state [/etc/keepalived/keepalived.conf] at time 15:53:16.261019 duration_in_ms=55.681
2017-10-29 15:53:16,262 [salt.state       ][INFO    ][31127] Running state [keepalived] at time 15:53:16.261505
2017-10-29 15:53:16,262 [salt.state       ][INFO    ][31127] Executing state service.running for keepalived
2017-10-29 15:53:16,262 [salt.loaded.int.module.cmdmod][INFO    ][31127] Executing command ['systemctl', 'status', 'keepalived.service', '-n', '0'] in directory '/root'
2017-10-29 15:53:16,278 [salt.loaded.int.module.cmdmod][INFO    ][31127] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2017-10-29 15:53:16,286 [salt.loaded.int.module.cmdmod][INFO    ][31127] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-10-29 15:53:16,293 [salt.state       ][INFO    ][31127] The service keepalived is already running
2017-10-29 15:53:16,293 [salt.state       ][INFO    ][31127] Completed state [keepalived] at time 15:53:16.293068 duration_in_ms=31.563
2017-10-29 15:53:16,294 [salt.minion      ][INFO    ][31127] Returning information for job: 20171029155315180333
2017-10-29 15:53:22,396 [salt.minion      ][INFO    ][22539] User sudo_ubuntu Executing command pillar.get with jid 20171029155322390677
2017-10-29 15:53:22,414 [salt.minion      ][INFO    ][31151] Starting a new job with PID 31151
2017-10-29 15:53:22,418 [salt.minion      ][INFO    ][31151] Returning information for job: 20171029155322390677
2017-10-29 15:53:56,788 [salt.minion      ][INFO    ][22539] User sudo_ubuntu Executing command state.sls with jid 20171029155356778103
2017-10-29 15:53:56,805 [salt.minion      ][INFO    ][31161] Starting a new job with PID 31161
2017-10-29 15:53:59,230 [salt.state       ][INFO    ][31161] Loading fresh modules for state activity
2017-10-29 15:53:59,251 [salt.fileclient  ][INFO    ][31161] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-10-29 15:53:59,271 [salt.fileclient  ][INFO    ][31161] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-10-29 15:53:59,537 [salt.state       ][INFO    ][31161] Running state [attr] at time 15:53:59.536519
2017-10-29 15:53:59,537 [salt.state       ][INFO    ][31161] Executing state pkg.installed for attr
2017-10-29 15:53:59,537 [salt.loaded.int.module.cmdmod][INFO    ][31161] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-10-29 15:53:59,772 [salt.state       ][INFO    ][31161] Package attr is already installed
2017-10-29 15:53:59,773 [salt.state       ][INFO    ][31161] Completed state [attr] at time 15:53:59.772720 duration_in_ms=236.202
2017-10-29 15:53:59,773 [salt.state       ][INFO    ][31161] Running state [glusterfs-server] at time 15:53:59.772940
2017-10-29 15:53:59,773 [salt.state       ][INFO    ][31161] Executing state pkg.installed for glusterfs-server
2017-10-29 15:53:59,776 [salt.state       ][INFO    ][31161] Package glusterfs-server is already installed
2017-10-29 15:53:59,776 [salt.state       ][INFO    ][31161] Completed state [glusterfs-server] at time 15:53:59.775811 duration_in_ms=2.87
2017-10-29 15:53:59,776 [salt.state       ][INFO    ][31161] Running state [bc] at time 15:53:59.775960
2017-10-29 15:53:59,776 [salt.state       ][INFO    ][31161] Executing state pkg.installed for bc
2017-10-29 15:53:59,779 [salt.state       ][INFO    ][31161] Package bc is already installed
2017-10-29 15:53:59,779 [salt.state       ][INFO    ][31161] Completed state [bc] at time 15:53:59.778761 duration_in_ms=2.801
2017-10-29 15:53:59,779 [salt.state       ][INFO    ][31161] Running state [glusterfs-server] at time 15:53:59.779446
2017-10-29 15:53:59,780 [salt.state       ][INFO    ][31161] Executing state service.running for glusterfs-server
2017-10-29 15:53:59,780 [salt.loaded.int.module.cmdmod][INFO    ][31161] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-10-29 15:53:59,799 [salt.loaded.int.module.cmdmod][INFO    ][31161] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-10-29 15:53:59,807 [salt.loaded.int.module.cmdmod][INFO    ][31161] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-10-29 15:53:59,817 [salt.state       ][INFO    ][31161] The service glusterfs-server is already running
2017-10-29 15:53:59,817 [salt.state       ][INFO    ][31161] Completed state [glusterfs-server] at time 15:53:59.817371 duration_in_ms=37.924
2017-10-29 15:53:59,819 [salt.state       ][INFO    ][31161] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 15:53:59.818707
2017-10-29 15:53:59,819 [salt.state       ][INFO    ][31161] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-10-29 15:53:59,829 [salt.state       ][INFO    ][31161] File /etc/systemd/system/glusterfs-server.service.d/override.conf is in the correct state
2017-10-29 15:53:59,829 [salt.state       ][INFO    ][31161] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 15:53:59.829076 duration_in_ms=10.368
2017-10-29 15:53:59,829 [salt.state       ][INFO    ][31161] Running state [/srv/glusterfs/glance] at time 15:53:59.829231
2017-10-29 15:53:59,829 [salt.state       ][INFO    ][31161] Executing state file.directory for /srv/glusterfs/glance
2017-10-29 15:53:59,830 [salt.state       ][INFO    ][31161] Directory /srv/glusterfs/glance is in the correct state
2017-10-29 15:53:59,830 [salt.state       ][INFO    ][31161] Completed state [/srv/glusterfs/glance] at time 15:53:59.829821 duration_in_ms=0.59
2017-10-29 15:53:59,830 [salt.state       ][INFO    ][31161] Running state [/srv/glusterfs/keystone-keys] at time 15:53:59.829980
2017-10-29 15:53:59,830 [salt.state       ][INFO    ][31161] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-10-29 15:53:59,830 [salt.state       ][INFO    ][31161] Directory /srv/glusterfs/keystone-keys is in the correct state
2017-10-29 15:53:59,831 [salt.state       ][INFO    ][31161] Completed state [/srv/glusterfs/keystone-keys] at time 15:53:59.830578 duration_in_ms=0.598
2017-10-29 15:53:59,831 [salt.state       ][INFO    ][31161] Running state [/srv/glusterfs/nova_instances] at time 15:53:59.830723
2017-10-29 15:53:59,831 [salt.state       ][INFO    ][31161] Executing state file.directory for /srv/glusterfs/nova_instances
2017-10-29 15:53:59,831 [salt.state       ][INFO    ][31161] Directory /srv/glusterfs/nova_instances is in the correct state
2017-10-29 15:53:59,831 [salt.state       ][INFO    ][31161] Completed state [/srv/glusterfs/nova_instances] at time 15:53:59.831308 duration_in_ms=0.585
2017-10-29 15:53:59,831 [salt.state       ][INFO    ][31161] Running state [/srv/glusterfs/keystone-credential-keys] at time 15:53:59.831452
2017-10-29 15:53:59,832 [salt.state       ][INFO    ][31161] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-10-29 15:53:59,832 [salt.state       ][INFO    ][31161] Directory /srv/glusterfs/keystone-credential-keys is in the correct state
2017-10-29 15:53:59,832 [salt.state       ][INFO    ][31161] Completed state [/srv/glusterfs/keystone-credential-keys] at time 15:53:59.832012 duration_in_ms=0.559
2017-10-29 15:53:59,833 [salt.minion      ][INFO    ][31161] Returning information for job: 20171029155356778103
2017-10-29 15:54:00,656 [salt.minion      ][INFO    ][22539] User sudo_ubuntu Executing command test.ping with jid 20171029155400651476
2017-10-29 15:54:00,672 [salt.minion      ][INFO    ][31184] Starting a new job with PID 31184
2017-10-29 15:54:00,697 [salt.minion      ][INFO    ][31184] Returning information for job: 20171029155400651476
2017-10-29 15:54:00,832 [salt.minion      ][INFO    ][22539] User sudo_ubuntu Executing command state.sls with jid 20171029155400822568
2017-10-29 15:54:00,846 [salt.minion      ][INFO    ][31190] Starting a new job with PID 31190
2017-10-29 15:54:01,357 [salt.state       ][INFO    ][31190] Loading fresh modules for state activity
2017-10-29 15:54:01,381 [salt.fileclient  ][INFO    ][31190] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/setup.sls'
2017-10-29 15:54:01,413 [salt.fileclient  ][INFO    ][31190] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-10-29 15:54:01,478 [salt.fileclient  ][INFO    ][31190] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-10-29 15:54:01,497 [salt.fileclient  ][INFO    ][31190] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-10-29 15:54:01,757 [salt.state       ][INFO    ][31190] Running state [attr] at time 15:54:01.756674
2017-10-29 15:54:01,757 [salt.state       ][INFO    ][31190] Executing state pkg.installed for attr
2017-10-29 15:54:01,757 [salt.loaded.int.module.cmdmod][INFO    ][31190] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-10-29 15:54:02,023 [salt.state       ][INFO    ][31190] Package attr is already installed
2017-10-29 15:54:02,023 [salt.state       ][INFO    ][31190] Completed state [attr] at time 15:54:02.023017 duration_in_ms=266.342
2017-10-29 15:54:02,023 [salt.state       ][INFO    ][31190] Running state [glusterfs-server] at time 15:54:02.023288
2017-10-29 15:54:02,024 [salt.state       ][INFO    ][31190] Executing state pkg.installed for glusterfs-server
2017-10-29 15:54:02,026 [salt.state       ][INFO    ][31190] Package glusterfs-server is already installed
2017-10-29 15:54:02,026 [salt.state       ][INFO    ][31190] Completed state [glusterfs-server] at time 15:54:02.026316 duration_in_ms=3.028
2017-10-29 15:54:02,027 [salt.state       ][INFO    ][31190] Running state [bc] at time 15:54:02.026517
2017-10-29 15:54:02,027 [salt.state       ][INFO    ][31190] Executing state pkg.installed for bc
2017-10-29 15:54:02,029 [salt.state       ][INFO    ][31190] Package bc is already installed
2017-10-29 15:54:02,030 [salt.state       ][INFO    ][31190] Completed state [bc] at time 15:54:02.029480 duration_in_ms=2.963
2017-10-29 15:54:02,030 [salt.state       ][INFO    ][31190] Running state [glusterfs-server] at time 15:54:02.030318
2017-10-29 15:54:02,031 [salt.state       ][INFO    ][31190] Executing state service.running for glusterfs-server
2017-10-29 15:54:02,031 [salt.loaded.int.module.cmdmod][INFO    ][31190] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-10-29 15:54:02,049 [salt.loaded.int.module.cmdmod][INFO    ][31190] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-10-29 15:54:02,058 [salt.loaded.int.module.cmdmod][INFO    ][31190] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-10-29 15:54:02,068 [salt.state       ][INFO    ][31190] The service glusterfs-server is already running
2017-10-29 15:54:02,069 [salt.state       ][INFO    ][31190] Completed state [glusterfs-server] at time 15:54:02.068545 duration_in_ms=38.227
2017-10-29 15:54:02,070 [salt.state       ][INFO    ][31190] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 15:54:02.069934
2017-10-29 15:54:02,070 [salt.state       ][INFO    ][31190] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-10-29 15:54:02,078 [salt.state       ][INFO    ][31190] File /etc/systemd/system/glusterfs-server.service.d/override.conf is in the correct state
2017-10-29 15:54:02,078 [salt.state       ][INFO    ][31190] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 15:54:02.077723 duration_in_ms=7.792
2017-10-29 15:54:02,078 [salt.state       ][INFO    ][31190] Running state [/srv/glusterfs/glance] at time 15:54:02.077874
2017-10-29 15:54:02,078 [salt.state       ][INFO    ][31190] Executing state file.directory for /srv/glusterfs/glance
2017-10-29 15:54:02,078 [salt.state       ][INFO    ][31190] Directory /srv/glusterfs/glance is in the correct state
2017-10-29 15:54:02,078 [salt.state       ][INFO    ][31190] Completed state [/srv/glusterfs/glance] at time 15:54:02.078456 duration_in_ms=0.582
2017-10-29 15:54:02,079 [salt.state       ][INFO    ][31190] Running state [/srv/glusterfs/keystone-keys] at time 15:54:02.078595
2017-10-29 15:54:02,079 [salt.state       ][INFO    ][31190] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-10-29 15:54:02,079 [salt.state       ][INFO    ][31190] Directory /srv/glusterfs/keystone-keys is in the correct state
2017-10-29 15:54:02,079 [salt.state       ][INFO    ][31190] Completed state [/srv/glusterfs/keystone-keys] at time 15:54:02.079142 duration_in_ms=0.547
2017-10-29 15:54:02,079 [salt.state       ][INFO    ][31190] Running state [/srv/glusterfs/nova_instances] at time 15:54:02.079281
2017-10-29 15:54:02,079 [salt.state       ][INFO    ][31190] Executing state file.directory for /srv/glusterfs/nova_instances
2017-10-29 15:54:02,080 [salt.state       ][INFO    ][31190] Directory /srv/glusterfs/nova_instances is in the correct state
2017-10-29 15:54:02,080 [salt.state       ][INFO    ][31190] Completed state [/srv/glusterfs/nova_instances] at time 15:54:02.079851 duration_in_ms=0.569
2017-10-29 15:54:02,080 [salt.state       ][INFO    ][31190] Running state [/srv/glusterfs/keystone-credential-keys] at time 15:54:02.079993
2017-10-29 15:54:02,080 [salt.state       ][INFO    ][31190] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-10-29 15:54:02,080 [salt.state       ][INFO    ][31190] Directory /srv/glusterfs/keystone-credential-keys is in the correct state
2017-10-29 15:54:02,081 [salt.state       ][INFO    ][31190] Completed state [/srv/glusterfs/keystone-credential-keys] at time 15:54:02.080536 duration_in_ms=0.543
2017-10-29 15:54:02,118 [salt.loaded.int.module.cmdmod][INFO    ][31190] Executing command ['git', '--version'] in directory '/root'
2017-10-29 15:54:02,202 [salt.state       ][INFO    ][31190] Running state [sleep 5] at time 15:54:02.201897
2017-10-29 15:54:02,202 [salt.state       ][INFO    ][31190] Executing state cmd.wait for sleep 5
2017-10-29 15:54:02,202 [salt.state       ][INFO    ][31190] No changes made for sleep 5
2017-10-29 15:54:02,203 [salt.state       ][INFO    ][31190] Completed state [sleep 5] at time 15:54:02.202500 duration_in_ms=0.604
2017-10-29 15:54:02,203 [salt.state       ][INFO    ][31190] Running state [10.167.4.141] at time 15:54:02.202889
2017-10-29 15:54:02,203 [salt.state       ][INFO    ][31190] Executing state glusterfs.peered for 10.167.4.141
2017-10-29 15:54:02,203 [salt.loaded.int.module.cmdmod][INFO    ][31190] Executing command 'gluster --version' in directory '/root'
2017-10-29 15:54:02,215 [salt.loaded.int.module.cmdmod][INFO    ][31190] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-29 15:54:02,269 [salt.state       ][INFO    ][31190] Host 10.167.4.141 already peered
2017-10-29 15:54:02,269 [salt.state       ][INFO    ][31190] Completed state [10.167.4.141] at time 15:54:02.269058 duration_in_ms=66.168
2017-10-29 15:54:02,271 [salt.state       ][INFO    ][31190] Running state [10.167.4.142] at time 15:54:02.271184
2017-10-29 15:54:02,271 [salt.state       ][INFO    ][31190] Executing state glusterfs.peered for 10.167.4.142
2017-10-29 15:54:02,272 [salt.loaded.int.module.cmdmod][INFO    ][31190] Executing command 'gluster --version' in directory '/root'
2017-10-29 15:54:02,281 [salt.loaded.int.module.cmdmod][INFO    ][31190] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-29 15:54:02,333 [salt.loaded.int.module.cmdmod][INFO    ][31190] Executing command 'gluster --version' in directory '/root'
2017-10-29 15:54:02,342 [salt.loaded.int.module.cmdmod][INFO    ][31190] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-29 15:54:02,394 [salt.loaded.int.module.cmdmod][INFO    ][31190] Executing command 'gluster --version' in directory '/root'
2017-10-29 15:54:02,402 [salt.loaded.int.module.cmdmod][INFO    ][31190] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-29 15:54:02,452 [salt.loaded.int.module.cmdmod][INFO    ][31190] Executing command 'gluster --version' in directory '/root'
2017-10-29 15:54:02,461 [salt.loaded.int.module.cmdmod][INFO    ][31190] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-29 15:54:02,510 [salt.state       ][INFO    ][31190] Peering with localhost is not needed
2017-10-29 15:54:02,510 [salt.state       ][INFO    ][31190] Completed state [10.167.4.142] at time 15:54:02.510374 duration_in_ms=239.19
2017-10-29 15:54:02,513 [salt.state       ][INFO    ][31190] Running state [10.167.4.143] at time 15:54:02.512573
2017-10-29 15:54:02,513 [salt.state       ][INFO    ][31190] Executing state glusterfs.peered for 10.167.4.143
2017-10-29 15:54:02,513 [salt.loaded.int.module.cmdmod][INFO    ][31190] Executing command 'gluster --version' in directory '/root'
2017-10-29 15:54:02,523 [salt.loaded.int.module.cmdmod][INFO    ][31190] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-29 15:54:02,572 [salt.state       ][INFO    ][31190] Host 10.167.4.143 already peered
2017-10-29 15:54:02,572 [salt.state       ][INFO    ][31190] Completed state [10.167.4.143] at time 15:54:02.571891 duration_in_ms=59.318
2017-10-29 15:54:02,573 [salt.state       ][INFO    ][31190] Running state [glance] at time 15:54:02.572656
2017-10-29 15:54:02,573 [salt.state       ][INFO    ][31190] Executing state glusterfs.created for glance
2017-10-29 15:54:02,573 [salt.loaded.int.module.cmdmod][INFO    ][31190] Executing command 'gluster --version' in directory '/root'
2017-10-29 15:54:02,582 [salt.loaded.int.module.cmdmod][INFO    ][31190] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-29 15:54:02,630 [salt.loaded.int.module.cmdmod][INFO    ][31190] Executing command 'gluster --version' in directory '/root'
2017-10-29 15:54:02,639 [salt.loaded.int.module.cmdmod][INFO    ][31190] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-29 15:54:02,708 [salt.state       ][INFO    ][31190] Volume glance already exists and is started.
2017-10-29 15:54:02,708 [salt.state       ][INFO    ][31190] Completed state [glance] at time 15:54:02.708282 duration_in_ms=135.626
2017-10-29 15:54:02,711 [salt.state       ][INFO    ][31190] Running state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 15:54:02.710953
2017-10-29 15:54:02,711 [salt.state       ][INFO    ][31190] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'
2017-10-29 15:54:02,712 [salt.loaded.int.module.cmdmod][INFO    ][31190] Executing command 'gluster volume info 'glance' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-10-29 15:54:02,760 [salt.state       ][INFO    ][31190] unless execution succeeded
2017-10-29 15:54:02,760 [salt.state       ][INFO    ][31190] Completed state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 15:54:02.760344 duration_in_ms=49.391
2017-10-29 15:54:02,761 [salt.state       ][INFO    ][31190] Running state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 15:54:02.760825
2017-10-29 15:54:02,761 [salt.state       ][INFO    ][31190] Executing state cmd.run for gluster volume set 'glance' 'network.remote-dio' 'True'
2017-10-29 15:54:02,761 [salt.loaded.int.module.cmdmod][INFO    ][31190] Executing command 'gluster volume info 'glance' | grep 'network.remote-dio: True'' in directory '/root'
2017-10-29 15:54:02,810 [salt.state       ][INFO    ][31190] unless execution succeeded
2017-10-29 15:54:02,810 [salt.state       ][INFO    ][31190] Completed state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 15:54:02.810000 duration_in_ms=49.175
2017-10-29 15:54:02,810 [salt.state       ][INFO    ][31190] Running state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 15:54:02.810439
2017-10-29 15:54:02,811 [salt.state       ][INFO    ][31190] Executing state cmd.run for gluster volume set 'glance' 'nfs.disable' 'True'
2017-10-29 15:54:02,811 [salt.loaded.int.module.cmdmod][INFO    ][31190] Executing command 'gluster volume info 'glance' | grep 'nfs.disable: True'' in directory '/root'
2017-10-29 15:54:02,859 [salt.state       ][INFO    ][31190] unless execution succeeded
2017-10-29 15:54:02,859 [salt.state       ][INFO    ][31190] Completed state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 15:54:02.858835 duration_in_ms=48.395
2017-10-29 15:54:02,859 [salt.state       ][INFO    ][31190] Running state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 15:54:02.859285
2017-10-29 15:54:02,860 [salt.state       ][INFO    ][31190] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'
2017-10-29 15:54:02,860 [salt.loaded.int.module.cmdmod][INFO    ][31190] Executing command 'gluster volume info 'glance' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-10-29 15:54:02,914 [salt.state       ][INFO    ][31190] unless execution succeeded
2017-10-29 15:54:02,914 [salt.state       ][INFO    ][31190] Completed state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 15:54:02.914411 duration_in_ms=55.125
2017-10-29 15:54:02,915 [salt.state       ][INFO    ][31190] Running state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 15:54:02.914852
2017-10-29 15:54:02,915 [salt.state       ][INFO    ][31190] Executing state cmd.run for gluster volume set 'glance' 'cluster.readdir-optimize' 'True'
2017-10-29 15:54:02,915 [salt.loaded.int.module.cmdmod][INFO    ][31190] Executing command 'gluster volume info 'glance' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-10-29 15:54:02,966 [salt.state       ][INFO    ][31190] unless execution succeeded
2017-10-29 15:54:02,966 [salt.state       ][INFO    ][31190] Completed state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 15:54:02.965754 duration_in_ms=50.901
2017-10-29 15:54:02,967 [salt.state       ][INFO    ][31190] Running state [glance] at time 15:54:02.966657
2017-10-29 15:54:02,967 [salt.state       ][INFO    ][31190] Executing state glusterfs.started for glance
2017-10-29 15:54:02,967 [salt.loaded.int.module.cmdmod][INFO    ][31190] Executing command 'gluster --version' in directory '/root'
2017-10-29 15:54:02,976 [salt.loaded.int.module.cmdmod][INFO    ][31190] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-29 15:54:03,023 [salt.loaded.int.module.cmdmod][INFO    ][31190] Executing command 'gluster --version' in directory '/root'
2017-10-29 15:54:03,034 [salt.loaded.int.module.cmdmod][INFO    ][31190] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-29 15:54:03,086 [salt.state       ][INFO    ][31190] Volume glance is already started
2017-10-29 15:54:03,086 [salt.state       ][INFO    ][31190] Completed state [glance] at time 15:54:03.086420 duration_in_ms=119.763
2017-10-29 15:54:03,087 [salt.state       ][INFO    ][31190] Running state [keystone-keys] at time 15:54:03.087182
2017-10-29 15:54:03,087 [salt.state       ][INFO    ][31190] Executing state glusterfs.created for keystone-keys
2017-10-29 15:54:03,088 [salt.loaded.int.module.cmdmod][INFO    ][31190] Executing command 'gluster --version' in directory '/root'
2017-10-29 15:54:03,098 [salt.loaded.int.module.cmdmod][INFO    ][31190] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-29 15:54:03,151 [salt.loaded.int.module.cmdmod][INFO    ][31190] Executing command 'gluster --version' in directory '/root'
2017-10-29 15:54:03,161 [salt.loaded.int.module.cmdmod][INFO    ][31190] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-29 15:54:03,216 [salt.state       ][INFO    ][31190] Volume keystone-keys already exists and is started.
2017-10-29 15:54:03,216 [salt.state       ][INFO    ][31190] Completed state [keystone-keys] at time 15:54:03.216083 duration_in_ms=128.901
2017-10-29 15:54:03,219 [salt.state       ][INFO    ][31190] Running state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 15:54:03.218818
2017-10-29 15:54:03,219 [salt.state       ][INFO    ][31190] Executing state cmd.run for gluster volume set 'keystone-keys' 'network.remote-dio' 'True'
2017-10-29 15:54:03,219 [salt.loaded.int.module.cmdmod][INFO    ][31190] Executing command 'gluster volume info 'keystone-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-10-29 15:54:03,271 [salt.state       ][INFO    ][31190] unless execution succeeded
2017-10-29 15:54:03,271 [salt.state       ][INFO    ][31190] Completed state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 15:54:03.270873 duration_in_ms=52.055
2017-10-29 15:54:03,271 [salt.state       ][INFO    ][31190] Running state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 15:54:03.271343
2017-10-29 15:54:03,272 [salt.state       ][INFO    ][31190] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-10-29 15:54:03,272 [salt.loaded.int.module.cmdmod][INFO    ][31190] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-10-29 15:54:03,321 [salt.state       ][INFO    ][31190] unless execution succeeded
2017-10-29 15:54:03,321 [salt.state       ][INFO    ][31190] Completed state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 15:54:03.321372 duration_in_ms=50.028
2017-10-29 15:54:03,322 [salt.state       ][INFO    ][31190] Running state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 15:54:03.321852
2017-10-29 15:54:03,322 [salt.state       ][INFO    ][31190] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'
2017-10-29 15:54:03,323 [salt.loaded.int.module.cmdmod][INFO    ][31190] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-10-29 15:54:03,372 [salt.state       ][INFO    ][31190] unless execution succeeded
2017-10-29 15:54:03,373 [salt.state       ][INFO    ][31190] Completed state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 15:54:03.372477 duration_in_ms=50.624
2017-10-29 15:54:03,373 [salt.state       ][INFO    ][31190] Running state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 15:54:03.372930
2017-10-29 15:54:03,373 [salt.state       ][INFO    ][31190] Executing state cmd.run for gluster volume set 'keystone-keys' 'nfs.disable' 'True'
2017-10-29 15:54:03,374 [salt.loaded.int.module.cmdmod][INFO    ][31190] Executing command 'gluster volume info 'keystone-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-10-29 15:54:03,421 [salt.state       ][INFO    ][31190] unless execution succeeded
2017-10-29 15:54:03,429 [salt.state       ][INFO    ][31190] Completed state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 15:54:03.429089 duration_in_ms=56.157
2017-10-29 15:54:03,430 [salt.state       ][INFO    ][31190] Running state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 15:54:03.429702
2017-10-29 15:54:03,430 [salt.state       ][INFO    ][31190] Executing state cmd.run for gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'
2017-10-29 15:54:03,430 [salt.loaded.int.module.cmdmod][INFO    ][31190] Executing command 'gluster volume info 'keystone-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-10-29 15:54:03,480 [salt.state       ][INFO    ][31190] unless execution succeeded
2017-10-29 15:54:03,480 [salt.state       ][INFO    ][31190] Completed state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 15:54:03.480061 duration_in_ms=50.358
2017-10-29 15:54:03,481 [salt.state       ][INFO    ][31190] Running state [keystone-keys] at time 15:54:03.481031
2017-10-29 15:54:03,481 [salt.state       ][INFO    ][31190] Executing state glusterfs.started for keystone-keys
2017-10-29 15:54:03,482 [salt.loaded.int.module.cmdmod][INFO    ][31190] Executing command 'gluster --version' in directory '/root'
2017-10-29 15:54:03,492 [salt.loaded.int.module.cmdmod][INFO    ][31190] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-29 15:54:03,541 [salt.loaded.int.module.cmdmod][INFO    ][31190] Executing command 'gluster --version' in directory '/root'
2017-10-29 15:54:03,550 [salt.loaded.int.module.cmdmod][INFO    ][31190] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-29 15:54:03,602 [salt.state       ][INFO    ][31190] Volume keystone-keys is already started
2017-10-29 15:54:03,602 [salt.state       ][INFO    ][31190] Completed state [keystone-keys] at time 15:54:03.601729 duration_in_ms=120.697
2017-10-29 15:54:03,603 [salt.state       ][INFO    ][31190] Running state [nova_instances] at time 15:54:03.602550
2017-10-29 15:54:03,603 [salt.state       ][INFO    ][31190] Executing state glusterfs.created for nova_instances
2017-10-29 15:54:03,603 [salt.loaded.int.module.cmdmod][INFO    ][31190] Executing command 'gluster --version' in directory '/root'
2017-10-29 15:54:03,613 [salt.loaded.int.module.cmdmod][INFO    ][31190] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-29 15:54:03,660 [salt.loaded.int.module.cmdmod][INFO    ][31190] Executing command 'gluster --version' in directory '/root'
2017-10-29 15:54:03,670 [salt.loaded.int.module.cmdmod][INFO    ][31190] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-29 15:54:03,722 [salt.state       ][INFO    ][31190] Volume nova_instances already exists and is started.
2017-10-29 15:54:03,722 [salt.state       ][INFO    ][31190] Completed state [nova_instances] at time 15:54:03.721968 duration_in_ms=119.417
2017-10-29 15:54:03,725 [salt.state       ][INFO    ][31190] Running state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 15:54:03.725005
2017-10-29 15:54:03,725 [salt.state       ][INFO    ][31190] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'
2017-10-29 15:54:03,726 [salt.loaded.int.module.cmdmod][INFO    ][31190] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-10-29 15:54:03,775 [salt.state       ][INFO    ][31190] unless execution succeeded
2017-10-29 15:54:03,776 [salt.state       ][INFO    ][31190] Completed state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 15:54:03.775656 duration_in_ms=50.65
2017-10-29 15:54:03,776 [salt.state       ][INFO    ][31190] Running state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'On'] at time 15:54:03.776103
2017-10-29 15:54:03,776 [salt.state       ][INFO    ][31190] Executing state cmd.run for gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'On'
2017-10-29 15:54:03,777 [salt.loaded.int.module.cmdmod][INFO    ][31190] Executing command 'gluster volume info 'nova_instances' | grep 'cluster.readdir-optimize: On'' in directory '/root'
2017-10-29 15:54:03,824 [salt.state       ][INFO    ][31190] unless execution succeeded
2017-10-29 15:54:03,825 [salt.state       ][INFO    ][31190] Completed state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'On'] at time 15:54:03.824517 duration_in_ms=48.413
2017-10-29 15:54:03,825 [salt.state       ][INFO    ][31190] Running state [gluster volume set 'nova_instances' 'network.remote-dio' 'On'] at time 15:54:03.825008
2017-10-29 15:54:03,825 [salt.state       ][INFO    ][31190] Executing state cmd.run for gluster volume set 'nova_instances' 'network.remote-dio' 'On'
2017-10-29 15:54:03,826 [salt.loaded.int.module.cmdmod][INFO    ][31190] Executing command 'gluster volume info 'nova_instances' | grep 'network.remote-dio: On'' in directory '/root'
2017-10-29 15:54:03,873 [salt.state       ][INFO    ][31190] unless execution succeeded
2017-10-29 15:54:03,873 [salt.state       ][INFO    ][31190] Completed state [gluster volume set 'nova_instances' 'network.remote-dio' 'On'] at time 15:54:03.873309 duration_in_ms=48.3
2017-10-29 15:54:03,874 [salt.state       ][INFO    ][31190] Running state [gluster volume set 'nova_instances' 'nfs.disable' 'On'] at time 15:54:03.873741
2017-10-29 15:54:03,874 [salt.state       ][INFO    ][31190] Executing state cmd.run for gluster volume set 'nova_instances' 'nfs.disable' 'On'
2017-10-29 15:54:03,874 [salt.loaded.int.module.cmdmod][INFO    ][31190] Executing command 'gluster volume info 'nova_instances' | grep 'nfs.disable: On'' in directory '/root'
2017-10-29 15:54:03,924 [salt.state       ][INFO    ][31190] unless execution succeeded
2017-10-29 15:54:03,924 [salt.state       ][INFO    ][31190] Completed state [gluster volume set 'nova_instances' 'nfs.disable' 'On'] at time 15:54:03.924303 duration_in_ms=50.561
2017-10-29 15:54:03,925 [salt.state       ][INFO    ][31190] Running state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 15:54:03.924762
2017-10-29 15:54:03,925 [salt.state       ][INFO    ][31190] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'
2017-10-29 15:54:03,925 [salt.loaded.int.module.cmdmod][INFO    ][31190] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-10-29 15:54:03,973 [salt.state       ][INFO    ][31190] unless execution succeeded
2017-10-29 15:54:03,973 [salt.state       ][INFO    ][31190] Completed state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 15:54:03.973059 duration_in_ms=48.298
2017-10-29 15:54:03,974 [salt.state       ][INFO    ][31190] Running state [nova_instances] at time 15:54:03.973985
2017-10-29 15:54:03,974 [salt.state       ][INFO    ][31190] Executing state glusterfs.started for nova_instances
2017-10-29 15:54:03,975 [salt.loaded.int.module.cmdmod][INFO    ][31190] Executing command 'gluster --version' in directory '/root'
2017-10-29 15:54:03,983 [salt.loaded.int.module.cmdmod][INFO    ][31190] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-29 15:54:04,030 [salt.loaded.int.module.cmdmod][INFO    ][31190] Executing command 'gluster --version' in directory '/root'
2017-10-29 15:54:04,040 [salt.loaded.int.module.cmdmod][INFO    ][31190] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-29 15:54:04,093 [salt.state       ][INFO    ][31190] Volume nova_instances is already started
2017-10-29 15:54:04,093 [salt.state       ][INFO    ][31190] Completed state [nova_instances] at time 15:54:04.092914 duration_in_ms=118.929
2017-10-29 15:54:04,094 [salt.state       ][INFO    ][31190] Running state [keystone-credential-keys] at time 15:54:04.093802
2017-10-29 15:54:04,094 [salt.state       ][INFO    ][31190] Executing state glusterfs.created for keystone-credential-keys
2017-10-29 15:54:04,094 [salt.loaded.int.module.cmdmod][INFO    ][31190] Executing command 'gluster --version' in directory '/root'
2017-10-29 15:54:04,105 [salt.loaded.int.module.cmdmod][INFO    ][31190] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-29 15:54:04,156 [salt.loaded.int.module.cmdmod][INFO    ][31190] Executing command 'gluster --version' in directory '/root'
2017-10-29 15:54:04,165 [salt.loaded.int.module.cmdmod][INFO    ][31190] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-29 15:54:04,218 [salt.state       ][INFO    ][31190] Volume keystone-credential-keys already exists and is started.
2017-10-29 15:54:04,219 [salt.state       ][INFO    ][31190] Completed state [keystone-credential-keys] at time 15:54:04.218505 duration_in_ms=124.702
2017-10-29 15:54:04,222 [salt.state       ][INFO    ][31190] Running state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 15:54:04.221490
2017-10-29 15:54:04,222 [salt.state       ][INFO    ][31190] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'
2017-10-29 15:54:04,222 [salt.loaded.int.module.cmdmod][INFO    ][31190] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-10-29 15:54:04,270 [salt.state       ][INFO    ][31190] unless execution succeeded
2017-10-29 15:54:04,270 [salt.state       ][INFO    ][31190] Completed state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 15:54:04.270065 duration_in_ms=48.574
2017-10-29 15:54:04,271 [salt.state       ][INFO    ][31190] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 15:54:04.270520
2017-10-29 15:54:04,271 [salt.state       ][INFO    ][31190] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-10-29 15:54:04,271 [salt.loaded.int.module.cmdmod][INFO    ][31190] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-10-29 15:54:04,320 [salt.state       ][INFO    ][31190] unless execution succeeded
2017-10-29 15:54:04,320 [salt.state       ][INFO    ][31190] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 15:54:04.320169 duration_in_ms=49.649
2017-10-29 15:54:04,321 [salt.state       ][INFO    ][31190] Running state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 15:54:04.320613
2017-10-29 15:54:04,321 [salt.state       ][INFO    ][31190] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'
2017-10-29 15:54:04,321 [salt.loaded.int.module.cmdmod][INFO    ][31190] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-10-29 15:54:04,372 [salt.state       ][INFO    ][31190] unless execution succeeded
2017-10-29 15:54:04,372 [salt.state       ][INFO    ][31190] Completed state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 15:54:04.372102 duration_in_ms=51.489
2017-10-29 15:54:04,373 [salt.state       ][INFO    ][31190] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 15:54:04.372552
2017-10-29 15:54:04,374 [salt.state       ][INFO    ][31190] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'
2017-10-29 15:54:04,376 [salt.loaded.int.module.cmdmod][INFO    ][31190] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-10-29 15:54:04,426 [salt.state       ][INFO    ][31190] unless execution succeeded
2017-10-29 15:54:04,426 [salt.state       ][INFO    ][31190] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 15:54:04.426066 duration_in_ms=53.513
2017-10-29 15:54:04,427 [salt.state       ][INFO    ][31190] Running state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 15:54:04.426990
2017-10-29 15:54:04,427 [salt.state       ][INFO    ][31190] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'
2017-10-29 15:54:04,428 [salt.loaded.int.module.cmdmod][INFO    ][31190] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-10-29 15:54:04,476 [salt.state       ][INFO    ][31190] unless execution succeeded
2017-10-29 15:54:04,477 [salt.state       ][INFO    ][31190] Completed state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 15:54:04.476575 duration_in_ms=49.583
2017-10-29 15:54:04,478 [salt.state       ][INFO    ][31190] Running state [keystone-credential-keys] at time 15:54:04.477530
2017-10-29 15:54:04,478 [salt.state       ][INFO    ][31190] Executing state glusterfs.started for keystone-credential-keys
2017-10-29 15:54:04,478 [salt.loaded.int.module.cmdmod][INFO    ][31190] Executing command 'gluster --version' in directory '/root'
2017-10-29 15:54:04,487 [salt.loaded.int.module.cmdmod][INFO    ][31190] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-29 15:54:04,534 [salt.loaded.int.module.cmdmod][INFO    ][31190] Executing command 'gluster --version' in directory '/root'
2017-10-29 15:54:04,543 [salt.loaded.int.module.cmdmod][INFO    ][31190] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-29 15:54:04,593 [salt.state       ][INFO    ][31190] Volume keystone-credential-keys is already started
2017-10-29 15:54:04,593 [salt.state       ][INFO    ][31190] Completed state [keystone-credential-keys] at time 15:54:04.593337 duration_in_ms=115.806
2017-10-29 15:54:04,595 [salt.minion      ][INFO    ][31190] Returning information for job: 20171029155400822568
2017-10-29 15:54:13,173 [salt.minion      ][INFO    ][22539] User sudo_ubuntu Executing command test.ping with jid 20171029155413161778
2017-10-29 15:54:13,190 [salt.minion      ][INFO    ][31573] Starting a new job with PID 31573
2017-10-29 15:54:13,217 [salt.minion      ][INFO    ][31573] Returning information for job: 20171029155413161778
2017-10-29 15:54:13,347 [salt.minion      ][INFO    ][22539] User sudo_ubuntu Executing command cmd.run with jid 20171029155413337667
2017-10-29 15:54:13,364 [salt.minion      ][INFO    ][31578] Starting a new job with PID 31578
2017-10-29 15:54:13,367 [salt.loaded.int.module.cmdmod][INFO    ][31578] Executing command 'gluster peer status; gluster volume status' in directory '/root'
2017-10-29 15:54:13,481 [salt.minion      ][INFO    ][31578] Returning information for job: 20171029155413337667
2017-10-29 15:57:27,025 [salt.utils.schedule][INFO    ][22539] Running scheduled job: __mine_interval
2017-10-29 16:48:09,813 [salt.minion      ][INFO    ][22539] User sudo_ubuntu Executing command cp.push_dir with jid 20171029164809806743
2017-10-29 16:48:09,832 [salt.minion      ][INFO    ][32057] Starting a new job with PID 32057
