2017-09-18 20:39:41,194 [salt.cli.daemons ][WARNING ][2520] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-09-18 21:20:56,476 [salt.state       ][ERROR   ][3863] No contents found in top file
2017-09-18 21:21:14,745 [salt.utils.parsers][WARNING ][2520] Minion received a SIGTERM. Exiting.
2017-09-18 21:23:40,748 [salt.cli.daemons ][WARNING ][3286] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-09-18 21:26:49,002 [py.warnings      ][WARNING ][15368] /usr/lib/python2.7/dist-packages/salt/utils/templates.py:73: DeprecationWarning: Starting in 2015.5, cmd.run uses python_shell=False by default, which doesn't support shellisms (pipes, env variables, etc). cmd.run is currently aliased to cmd.shell to prevent breakage. Please switch to cmd.shell or set python_shell=True to avoid breakage in the future, when this aliasing is removed.

2017-09-18 21:27:59,760 [salt.loaded.int.module.cmdmod][ERROR   ][15368] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-09-18 21:27:59,760 [salt.loaded.int.module.cmdmod][ERROR   ][15368] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-09-18 21:28:05,874 [salt.loaded.int.module.cmdmod][ERROR   ][15368] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-09-18 21:28:05,875 [salt.loaded.int.module.cmdmod][ERROR   ][15368] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-09-18 21:28:14,885 [salt.loaded.int.module.cmdmod][ERROR   ][15368] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-09-18 21:28:14,885 [salt.loaded.int.module.cmdmod][ERROR   ][15368] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-09-18 21:28:25,092 [salt.loaded.int.module.cmdmod][ERROR   ][15368] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-09-18 21:28:25,092 [salt.loaded.int.module.cmdmod][ERROR   ][15368] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-09-18 21:28:31,164 [salt.loaded.int.module.cmdmod][ERROR   ][15368] Command 'while true; do salt-call saltutil.running|grep fun: && continue; salt-call --local service.restart salt-minion; break; done' failed with return code: None
2017-09-18 21:28:33,255 [salt.loaded.int.module.cmdmod][INFO    ][22674] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2017-09-18 21:28:33,262 [salt.loaded.int.module.cmdmod][INFO    ][22674] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2017-09-18 21:28:33,271 [salt.loaded.int.module.cmdmod][INFO    ][22674] Executing command ['systemd-run', '--scope', 'systemctl', 'restart', 'salt-minion.service'] in directory '/root'
2017-09-18 21:28:33,278 [salt.utils.parsers][WARNING ][3286] Minion received a SIGTERM. Exiting.
2017-09-18 21:28:33,528 [salt.cli.daemons ][INFO    ][22749] Setting up the Salt Minion "kvm03.baremetal-mcp-ocata-ovs-ha.local"
2017-09-18 21:28:34,024 [salt.minion      ][INFO    ][22749] Creating minion process manager
2017-09-18 21:28:34,024 [salt.cli.daemons ][WARNING ][22749] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-09-18 21:28:34,024 [salt.cli.daemons ][INFO    ][22749] The Salt Minion is starting up
2017-09-18 21:28:34,025 [salt.minion      ][INFO    ][22749] Minion is starting as user 'root'
2017-09-18 21:28:34,025 [salt.utils.event ][INFO    ][22749] Starting pull socket on /var/run/salt/minion/minion_event_98ff1e569f_pull.ipc
2017-09-18 21:28:34,862 [salt.loaded.int.module.cmdmod][INFO    ][22749] Executing command ['date', '+%z'] in directory '/root'
2017-09-18 21:28:34,869 [salt.utils.schedule][INFO    ][22749] Updating job settings for scheduled job: __mine_interval
2017-09-18 21:28:34,871 [salt.minion      ][INFO    ][22749] Added mine.update to scheduler
2017-09-18 21:28:35,034 [salt.minion      ][INFO    ][22749] Minion is ready to receive requests!
2017-09-18 21:28:36,035 [salt.utils.schedule][INFO    ][22749] Running scheduled job: __mine_interval
2017-09-18 21:28:39,258 [salt.minion      ][INFO    ][22749] User sudo_ubuntu Executing command saltutil.sync_all with jid 20170918212839254941
2017-09-18 21:28:39,271 [salt.minion      ][INFO    ][22856] Starting a new job with PID 22856
2017-09-18 21:28:41,838 [salt.state       ][INFO    ][22856] Loading fresh modules for state activity
2017-09-18 21:28:41,859 [salt.state       ][ERROR   ][22856] No contents found in top file
2017-09-18 21:28:41,860 [salt.utils.extmods][INFO    ][22856] Creating module dir '/var/cache/salt/minion/extmods/beacons'
2017-09-18 21:28:41,862 [salt.utils.extmods][INFO    ][22856] Syncing beacons for environment 'base'
2017-09-18 21:28:41,862 [salt.utils.extmods][INFO    ][22856] Loading cache from salt://_beacons, for base)
2017-09-18 21:28:41,863 [salt.fileclient  ][INFO    ][22856] Caching directory '_beacons/' for environment 'base'
2017-09-18 21:28:41,884 [salt.utils.extmods][INFO    ][22856] Syncing modules for environment 'base'
2017-09-18 21:28:41,884 [salt.utils.extmods][INFO    ][22856] Loading cache from salt://_modules, for base)
2017-09-18 21:28:41,884 [salt.fileclient  ][INFO    ][22856] Caching directory '_modules/' for environment 'base'
2017-09-18 21:28:41,924 [salt.fileclient  ][INFO    ][22856] Fetching file from saltenv 'base', ** done ** '_modules/ceph_ng.py'
2017-09-18 21:28:41,943 [salt.fileclient  ][INFO    ][22856] Fetching file from saltenv 'base', ** done ** '_modules/cinderng.py'
2017-09-18 21:28:41,960 [salt.fileclient  ][INFO    ][22856] Fetching file from saltenv 'base', ** done ** '_modules/contrail.py'
2017-09-18 21:28:42,009 [salt.fileclient  ][INFO    ][22856] Fetching file from saltenv 'base', ** done ** '_modules/creds.py'
2017-09-18 21:28:42,031 [salt.fileclient  ][INFO    ][22856] Fetching file from saltenv 'base', ** done ** '_modules/devops_utils.py'
2017-09-18 21:28:42,041 [salt.fileclient  ][INFO    ][22856] Fetching file from saltenv 'base', ** done ** '_modules/encode_json.py'
2017-09-18 21:28:42,118 [salt.fileclient  ][INFO    ][22856] Fetching file from saltenv 'base', ** done ** '_modules/gerrit.py'
2017-09-18 21:28:42,130 [salt.fileclient  ][INFO    ][22856] Fetching file from saltenv 'base', ** done ** '_modules/glanceng.py'
2017-09-18 21:28:42,165 [salt.fileclient  ][INFO    ][22856] Fetching file from saltenv 'base', ** done ** '_modules/heat.py'
2017-09-18 21:28:42,189 [salt.fileclient  ][INFO    ][22856] Fetching file from saltenv 'base', ** done ** '_modules/heka_alarming.py'
2017-09-18 21:28:42,265 [salt.fileclient  ][INFO    ][22856] Fetching file from saltenv 'base', ** done ** '_modules/helm.py'
2017-09-18 21:28:42,454 [salt.fileclient  ][INFO    ][22856] Fetching file from saltenv 'base', ** done ** '_modules/jenkins_common.py'
2017-09-18 21:28:42,508 [salt.fileclient  ][INFO    ][22856] Fetching file from saltenv 'base', ** done ** '_modules/keystone_policy.py'
2017-09-18 21:28:42,549 [salt.fileclient  ][INFO    ][22856] Fetching file from saltenv 'base', ** done ** '_modules/linux_hosts.py'
2017-09-18 21:28:42,570 [salt.fileclient  ][INFO    ][22856] Fetching file from saltenv 'base', ** done ** '_modules/linux_netlink.py'
2017-09-18 21:28:42,687 [salt.fileclient  ][INFO    ][22856] Fetching file from saltenv 'base', ** done ** '_modules/maas.py'
2017-09-18 21:28:42,725 [salt.fileclient  ][INFO    ][22856] Fetching file from saltenv 'base', ** done ** '_modules/maas_client.py'
2017-09-18 21:28:42,777 [salt.fileclient  ][INFO    ][22856] Fetching file from saltenv 'base', ** done ** '_modules/multipart.py'
2017-09-18 21:28:42,807 [salt.fileclient  ][INFO    ][22856] Fetching file from saltenv 'base', ** done ** '_modules/nagios_alarming.py'
2017-09-18 21:28:43,127 [salt.fileclient  ][INFO    ][22856] Fetching file from saltenv 'base', ** done ** '_modules/neutronng.py'
2017-09-18 21:28:43,155 [salt.fileclient  ][INFO    ][22856] Fetching file from saltenv 'base', ** done ** '_modules/novang.py'
2017-09-18 21:28:43,168 [salt.fileclient  ][INFO    ][22856] Fetching file from saltenv 'base', ** done ** '_modules/reclass.py'
2017-09-18 21:28:43,209 [salt.fileclient  ][INFO    ][22856] Fetching file from saltenv 'base', ** done ** '_modules/rsyslog_util.py'
2017-09-18 21:28:43,308 [salt.fileclient  ][INFO    ][22856] Fetching file from saltenv 'base', ** done ** '_modules/rundeck.py'
2017-09-18 21:28:43,359 [salt.fileclient  ][INFO    ][22856] Fetching file from saltenv 'base', ** done ** '_modules/saltkey.py'
2017-09-18 21:28:43,397 [salt.fileclient  ][INFO    ][22856] Fetching file from saltenv 'base', ** done ** '_modules/saltresource.py'
2017-09-18 21:28:43,419 [salt.fileclient  ][INFO    ][22856] Fetching file from saltenv 'base', ** done ** '_modules/seedng.py'
2017-09-18 21:28:43,497 [salt.fileclient  ][INFO    ][22856] Fetching file from saltenv 'base', ** done ** '_modules/testing/credentials.py'
2017-09-18 21:28:43,518 [salt.fileclient  ][INFO    ][22856] Fetching file from saltenv 'base', ** done ** '_modules/testing/django.py'
2017-09-18 21:28:43,540 [salt.fileclient  ][INFO    ][22856] Fetching file from saltenv 'base', ** done ** '_modules/testing/django_client_proxy.py'
2017-09-18 21:28:43,572 [salt.fileclient  ][INFO    ][22856] Fetching file from saltenv 'base', ** done ** '_modules/utils.py'
2017-09-18 21:28:43,606 [salt.fileclient  ][INFO    ][22856] Fetching file from saltenv 'base', ** done ** '_modules/virtng.py'
2017-09-18 21:28:43,609 [salt.utils.extmods][INFO    ][22856] Copying '/var/cache/salt/minion/files/base/_modules/__init__.py' to '/var/cache/salt/minion/extmods/modules/__init__.py'
2017-09-18 21:28:43,609 [salt.utils.extmods][INFO    ][22856] Copying '/var/cache/salt/minion/files/base/_modules/ceph_ng.py' to '/var/cache/salt/minion/extmods/modules/ceph_ng.py'
2017-09-18 21:28:43,614 [salt.utils.extmods][INFO    ][22856] Copying '/var/cache/salt/minion/files/base/_modules/cinderng.py' to '/var/cache/salt/minion/extmods/modules/cinderng.py'
2017-09-18 21:28:43,637 [salt.utils.extmods][INFO    ][22856] Copying '/var/cache/salt/minion/files/base/_modules/contrail.py' to '/var/cache/salt/minion/extmods/modules/contrail.py'
2017-09-18 21:28:43,668 [salt.utils.extmods][INFO    ][22856] Copying '/var/cache/salt/minion/files/base/_modules/creds.py' to '/var/cache/salt/minion/extmods/modules/creds.py'
2017-09-18 21:28:43,679 [salt.utils.extmods][INFO    ][22856] Copying '/var/cache/salt/minion/files/base/_modules/devops_utils.py' to '/var/cache/salt/minion/extmods/modules/devops_utils.py'
2017-09-18 21:28:43,686 [salt.utils.extmods][INFO    ][22856] Copying '/var/cache/salt/minion/files/base/_modules/encode_json.py' to '/var/cache/salt/minion/extmods/modules/encode_json.py'
2017-09-18 21:28:43,712 [salt.utils.extmods][INFO    ][22856] Copying '/var/cache/salt/minion/files/base/_modules/gerrit.py' to '/var/cache/salt/minion/extmods/modules/gerrit.py'
2017-09-18 21:28:43,727 [salt.utils.extmods][INFO    ][22856] Copying '/var/cache/salt/minion/files/base/_modules/glanceng.py' to '/var/cache/salt/minion/extmods/modules/glanceng.py'
2017-09-18 21:28:43,739 [salt.utils.extmods][INFO    ][22856] Copying '/var/cache/salt/minion/files/base/_modules/heat.py' to '/var/cache/salt/minion/extmods/modules/heat.py'
2017-09-18 21:28:43,740 [salt.utils.extmods][INFO    ][22856] Copying '/var/cache/salt/minion/files/base/_modules/heka_alarming.py' to '/var/cache/salt/minion/extmods/modules/heka_alarming.py'
2017-09-18 21:28:43,740 [salt.utils.extmods][INFO    ][22856] Copying '/var/cache/salt/minion/files/base/_modules/helm.py' to '/var/cache/salt/minion/extmods/modules/helm.py'
2017-09-18 21:28:43,741 [salt.utils.extmods][INFO    ][22856] Copying '/var/cache/salt/minion/files/base/_modules/jenkins_common.py' to '/var/cache/salt/minion/extmods/modules/jenkins_common.py'
2017-09-18 21:28:43,741 [salt.utils.extmods][INFO    ][22856] Copying '/var/cache/salt/minion/files/base/_modules/keystone_policy.py' to '/var/cache/salt/minion/extmods/modules/keystone_policy.py'
2017-09-18 21:28:43,742 [salt.utils.extmods][INFO    ][22856] Copying '/var/cache/salt/minion/files/base/_modules/linux_hosts.py' to '/var/cache/salt/minion/extmods/modules/linux_hosts.py'
2017-09-18 21:28:43,742 [salt.utils.extmods][INFO    ][22856] Copying '/var/cache/salt/minion/files/base/_modules/linux_netlink.py' to '/var/cache/salt/minion/extmods/modules/linux_netlink.py'
2017-09-18 21:28:43,750 [salt.utils.extmods][INFO    ][22856] Copying '/var/cache/salt/minion/files/base/_modules/maas.py' to '/var/cache/salt/minion/extmods/modules/maas.py'
2017-09-18 21:28:43,761 [salt.utils.extmods][INFO    ][22856] Copying '/var/cache/salt/minion/files/base/_modules/maas_client.py' to '/var/cache/salt/minion/extmods/modules/maas_client.py'
2017-09-18 21:28:43,761 [salt.utils.extmods][INFO    ][22856] Copying '/var/cache/salt/minion/files/base/_modules/multipart.py' to '/var/cache/salt/minion/extmods/modules/multipart.py'
2017-09-18 21:28:43,762 [salt.utils.extmods][INFO    ][22856] Copying '/var/cache/salt/minion/files/base/_modules/nagios_alarming.py' to '/var/cache/salt/minion/extmods/modules/nagios_alarming.py'
2017-09-18 21:28:43,762 [salt.utils.extmods][INFO    ][22856] Copying '/var/cache/salt/minion/files/base/_modules/neutronng.py' to '/var/cache/salt/minion/extmods/modules/neutronng.py'
2017-09-18 21:28:43,763 [salt.utils.extmods][INFO    ][22856] Copying '/var/cache/salt/minion/files/base/_modules/novang.py' to '/var/cache/salt/minion/extmods/modules/novang.py'
2017-09-18 21:28:43,766 [salt.utils.extmods][INFO    ][22856] Copying '/var/cache/salt/minion/files/base/_modules/reclass.py' to '/var/cache/salt/minion/extmods/modules/reclass.py'
2017-09-18 21:28:43,766 [salt.utils.extmods][INFO    ][22856] Copying '/var/cache/salt/minion/files/base/_modules/rsyslog_util.py' to '/var/cache/salt/minion/extmods/modules/rsyslog_util.py'
2017-09-18 21:28:43,767 [salt.utils.extmods][INFO    ][22856] Copying '/var/cache/salt/minion/files/base/_modules/rundeck.py' to '/var/cache/salt/minion/extmods/modules/rundeck.py'
2017-09-18 21:28:43,767 [salt.utils.extmods][INFO    ][22856] Copying '/var/cache/salt/minion/files/base/_modules/saltkey.py' to '/var/cache/salt/minion/extmods/modules/saltkey.py'
2017-09-18 21:28:43,768 [salt.utils.extmods][INFO    ][22856] Copying '/var/cache/salt/minion/files/base/_modules/saltresource.py' to '/var/cache/salt/minion/extmods/modules/saltresource.py'
2017-09-18 21:28:43,768 [salt.utils.extmods][INFO    ][22856] Copying '/var/cache/salt/minion/files/base/_modules/seedng.py' to '/var/cache/salt/minion/extmods/modules/seedng.py'
2017-09-18 21:28:43,769 [salt.utils.extmods][INFO    ][22856] Copying '/var/cache/salt/minion/files/base/_modules/testing/__init__.py' to '/var/cache/salt/minion/extmods/modules/testing/__init__.py'
2017-09-18 21:28:43,769 [salt.utils.extmods][INFO    ][22856] Copying '/var/cache/salt/minion/files/base/_modules/testing/credentials.py' to '/var/cache/salt/minion/extmods/modules/testing/credentials.py'
2017-09-18 21:28:43,770 [salt.utils.extmods][INFO    ][22856] Copying '/var/cache/salt/minion/files/base/_modules/testing/django.py' to '/var/cache/salt/minion/extmods/modules/testing/django.py'
2017-09-18 21:28:43,770 [salt.utils.extmods][INFO    ][22856] Copying '/var/cache/salt/minion/files/base/_modules/testing/django_client_proxy.py' to '/var/cache/salt/minion/extmods/modules/testing/django_client_proxy.py'
2017-09-18 21:28:43,770 [salt.utils.extmods][INFO    ][22856] Copying '/var/cache/salt/minion/files/base/_modules/utils.py' to '/var/cache/salt/minion/extmods/modules/utils.py'
2017-09-18 21:28:43,771 [salt.utils.extmods][INFO    ][22856] Copying '/var/cache/salt/minion/files/base/_modules/virtng.py' to '/var/cache/salt/minion/extmods/modules/virtng.py'
2017-09-18 21:28:43,776 [salt.utils.extmods][INFO    ][22856] Syncing states for environment 'base'
2017-09-18 21:28:43,776 [salt.utils.extmods][INFO    ][22856] Loading cache from salt://_states, for base)
2017-09-18 21:28:43,777 [salt.fileclient  ][INFO    ][22856] Caching directory '_states/' for environment 'base'
2017-09-18 21:28:43,829 [salt.fileclient  ][INFO    ][22856] Fetching file from saltenv 'base', ** done ** '_states/cinderng.py'
2017-09-18 21:28:43,853 [salt.fileclient  ][INFO    ][22856] Fetching file from saltenv 'base', ** done ** '_states/contrail.py'
2017-09-18 21:28:43,881 [salt.fileclient  ][INFO    ][22856] Fetching file from saltenv 'base', ** done ** '_states/gerrit.py'
2017-09-18 21:28:43,901 [salt.fileclient  ][INFO    ][22856] Fetching file from saltenv 'base', ** done ** '_states/glanceng.py'
2017-09-18 21:28:43,914 [salt.fileclient  ][INFO    ][22856] Fetching file from saltenv 'base', ** done ** '_states/grafana3_dashboard.py'
2017-09-18 21:28:43,930 [salt.fileclient  ][INFO    ][22856] Fetching file from saltenv 'base', ** done ** '_states/grafana3_datasource.py'
2017-09-18 21:28:44,007 [salt.fileclient  ][INFO    ][22856] Fetching file from saltenv 'base', ** done ** '_states/heat.py'
2017-09-18 21:28:44,090 [salt.fileclient  ][INFO    ][22856] Fetching file from saltenv 'base', ** done ** '_states/helm_release.py'
2017-09-18 21:28:44,139 [salt.fileclient  ][INFO    ][22856] Fetching file from saltenv 'base', ** done ** '_states/jenkins_approval.py'
2017-09-18 21:28:44,241 [salt.fileclient  ][INFO    ][22856] Fetching file from saltenv 'base', ** done ** '_states/jenkins_artifactory.py'
2017-09-18 21:28:44,295 [salt.fileclient  ][INFO    ][22856] Fetching file from saltenv 'base', ** done ** '_states/jenkins_credential.py'
2017-09-18 21:28:44,392 [salt.fileclient  ][INFO    ][22856] Fetching file from saltenv 'base', ** done ** '_states/jenkins_job.py'
2017-09-18 21:28:44,439 [salt.fileclient  ][INFO    ][22856] Fetching file from saltenv 'base', ** done ** '_states/jenkins_lib.py'
2017-09-18 21:28:44,536 [salt.fileclient  ][INFO    ][22856] Fetching file from saltenv 'base', ** done ** '_states/jenkins_node.py'
2017-09-18 21:28:44,690 [salt.fileclient  ][INFO    ][22856] Fetching file from saltenv 'base', ** done ** '_states/jenkins_plugin.py'
2017-09-18 21:28:44,796 [salt.fileclient  ][INFO    ][22856] Fetching file from saltenv 'base', ** done ** '_states/jenkins_security.py'
2017-09-18 21:28:44,915 [salt.fileclient  ][INFO    ][22856] Fetching file from saltenv 'base', ** done ** '_states/jenkins_slack.py'
2017-09-18 21:28:45,035 [salt.fileclient  ][INFO    ][22856] Fetching file from saltenv 'base', ** done ** '_states/jenkins_smtp.py'
2017-09-18 21:28:45,187 [salt.fileclient  ][INFO    ][22856] Fetching file from saltenv 'base', ** done ** '_states/jenkins_theme.py'
2017-09-18 21:28:45,224 [salt.fileclient  ][INFO    ][22856] Fetching file from saltenv 'base', ** done ** '_states/jenkins_user.py'
2017-09-18 21:28:45,271 [salt.fileclient  ][INFO    ][22856] Fetching file from saltenv 'base', ** done ** '_states/jenkins_view.py'
2017-09-18 21:28:45,308 [salt.fileclient  ][INFO    ][22856] Fetching file from saltenv 'base', ** done ** '_states/keystone_policy.py'
2017-09-18 21:28:45,374 [salt.fileclient  ][INFO    ][22856] Fetching file from saltenv 'base', ** done ** '_states/kibana_object.py'
2017-09-18 21:28:45,416 [salt.fileclient  ][INFO    ][22856] Fetching file from saltenv 'base', ** done ** '_states/neutronng.py'
2017-09-18 21:28:45,470 [salt.fileclient  ][INFO    ][22856] Fetching file from saltenv 'base', ** done ** '_states/novang.py'
2017-09-18 21:28:45,513 [salt.fileclient  ][INFO    ][22856] Fetching file from saltenv 'base', ** done ** '_states/reclass.py'
2017-09-18 21:28:45,566 [salt.fileclient  ][INFO    ][22856] Fetching file from saltenv 'base', ** done ** '_states/rundeck_project.py'
2017-09-18 21:28:45,603 [salt.fileclient  ][INFO    ][22856] Fetching file from saltenv 'base', ** done ** '_states/rundeck_scm.py'
2017-09-18 21:28:45,657 [salt.fileclient  ][INFO    ][22856] Fetching file from saltenv 'base', ** done ** '_states/rundeck_secret.py'
2017-09-18 21:28:45,660 [salt.utils.extmods][INFO    ][22856] Copying '/var/cache/salt/minion/files/base/_states/cinderng.py' to '/var/cache/salt/minion/extmods/states/cinderng.py'
2017-09-18 21:28:45,660 [salt.utils.extmods][INFO    ][22856] Copying '/var/cache/salt/minion/files/base/_states/contrail.py' to '/var/cache/salt/minion/extmods/states/contrail.py'
2017-09-18 21:28:45,661 [salt.utils.extmods][INFO    ][22856] Copying '/var/cache/salt/minion/files/base/_states/gerrit.py' to '/var/cache/salt/minion/extmods/states/gerrit.py'
2017-09-18 21:28:45,661 [salt.utils.extmods][INFO    ][22856] Copying '/var/cache/salt/minion/files/base/_states/glanceng.py' to '/var/cache/salt/minion/extmods/states/glanceng.py'
2017-09-18 21:28:45,661 [salt.utils.extmods][INFO    ][22856] Copying '/var/cache/salt/minion/files/base/_states/grafana3_dashboard.py' to '/var/cache/salt/minion/extmods/states/grafana3_dashboard.py'
2017-09-18 21:28:45,662 [salt.utils.extmods][INFO    ][22856] Copying '/var/cache/salt/minion/files/base/_states/grafana3_datasource.py' to '/var/cache/salt/minion/extmods/states/grafana3_datasource.py'
2017-09-18 21:28:45,662 [salt.utils.extmods][INFO    ][22856] Copying '/var/cache/salt/minion/files/base/_states/heat.py' to '/var/cache/salt/minion/extmods/states/heat.py'
2017-09-18 21:28:45,662 [salt.utils.extmods][INFO    ][22856] Copying '/var/cache/salt/minion/files/base/_states/helm_release.py' to '/var/cache/salt/minion/extmods/states/helm_release.py'
2017-09-18 21:28:45,662 [salt.utils.extmods][INFO    ][22856] Copying '/var/cache/salt/minion/files/base/_states/jenkins_approval.py' to '/var/cache/salt/minion/extmods/states/jenkins_approval.py'
2017-09-18 21:28:45,663 [salt.utils.extmods][INFO    ][22856] Copying '/var/cache/salt/minion/files/base/_states/jenkins_artifactory.py' to '/var/cache/salt/minion/extmods/states/jenkins_artifactory.py'
2017-09-18 21:28:45,663 [salt.utils.extmods][INFO    ][22856] Copying '/var/cache/salt/minion/files/base/_states/jenkins_credential.py' to '/var/cache/salt/minion/extmods/states/jenkins_credential.py'
2017-09-18 21:28:45,663 [salt.utils.extmods][INFO    ][22856] Copying '/var/cache/salt/minion/files/base/_states/jenkins_job.py' to '/var/cache/salt/minion/extmods/states/jenkins_job.py'
2017-09-18 21:28:45,663 [salt.utils.extmods][INFO    ][22856] Copying '/var/cache/salt/minion/files/base/_states/jenkins_lib.py' to '/var/cache/salt/minion/extmods/states/jenkins_lib.py'
2017-09-18 21:28:45,664 [salt.utils.extmods][INFO    ][22856] Copying '/var/cache/salt/minion/files/base/_states/jenkins_node.py' to '/var/cache/salt/minion/extmods/states/jenkins_node.py'
2017-09-18 21:28:45,664 [salt.utils.extmods][INFO    ][22856] Copying '/var/cache/salt/minion/files/base/_states/jenkins_plugin.py' to '/var/cache/salt/minion/extmods/states/jenkins_plugin.py'
2017-09-18 21:28:45,664 [salt.utils.extmods][INFO    ][22856] Copying '/var/cache/salt/minion/files/base/_states/jenkins_security.py' to '/var/cache/salt/minion/extmods/states/jenkins_security.py'
2017-09-18 21:28:45,664 [salt.utils.extmods][INFO    ][22856] Copying '/var/cache/salt/minion/files/base/_states/jenkins_slack.py' to '/var/cache/salt/minion/extmods/states/jenkins_slack.py'
2017-09-18 21:28:45,665 [salt.utils.extmods][INFO    ][22856] Copying '/var/cache/salt/minion/files/base/_states/jenkins_smtp.py' to '/var/cache/salt/minion/extmods/states/jenkins_smtp.py'
2017-09-18 21:28:45,665 [salt.utils.extmods][INFO    ][22856] Copying '/var/cache/salt/minion/files/base/_states/jenkins_theme.py' to '/var/cache/salt/minion/extmods/states/jenkins_theme.py'
2017-09-18 21:28:45,665 [salt.utils.extmods][INFO    ][22856] Copying '/var/cache/salt/minion/files/base/_states/jenkins_user.py' to '/var/cache/salt/minion/extmods/states/jenkins_user.py'
2017-09-18 21:28:45,665 [salt.utils.extmods][INFO    ][22856] Copying '/var/cache/salt/minion/files/base/_states/jenkins_view.py' to '/var/cache/salt/minion/extmods/states/jenkins_view.py'
2017-09-18 21:28:45,666 [salt.utils.extmods][INFO    ][22856] Copying '/var/cache/salt/minion/files/base/_states/keystone_policy.py' to '/var/cache/salt/minion/extmods/states/keystone_policy.py'
2017-09-18 21:28:45,666 [salt.utils.extmods][INFO    ][22856] Copying '/var/cache/salt/minion/files/base/_states/kibana_object.py' to '/var/cache/salt/minion/extmods/states/kibana_object.py'
2017-09-18 21:28:45,666 [salt.utils.extmods][INFO    ][22856] Copying '/var/cache/salt/minion/files/base/_states/maas_cluster.py' to '/var/cache/salt/minion/extmods/states/maas_cluster.py'
2017-09-18 21:28:45,666 [salt.utils.extmods][INFO    ][22856] Copying '/var/cache/salt/minion/files/base/_states/neutronng.py' to '/var/cache/salt/minion/extmods/states/neutronng.py'
2017-09-18 21:28:45,667 [salt.utils.extmods][INFO    ][22856] Copying '/var/cache/salt/minion/files/base/_states/novang.py' to '/var/cache/salt/minion/extmods/states/novang.py'
2017-09-18 21:28:45,667 [salt.utils.extmods][INFO    ][22856] Copying '/var/cache/salt/minion/files/base/_states/reclass.py' to '/var/cache/salt/minion/extmods/states/reclass.py'
2017-09-18 21:28:45,667 [salt.utils.extmods][INFO    ][22856] Copying '/var/cache/salt/minion/files/base/_states/rundeck_project.py' to '/var/cache/salt/minion/extmods/states/rundeck_project.py'
2017-09-18 21:28:45,667 [salt.utils.extmods][INFO    ][22856] Copying '/var/cache/salt/minion/files/base/_states/rundeck_scm.py' to '/var/cache/salt/minion/extmods/states/rundeck_scm.py'
2017-09-18 21:28:45,668 [salt.utils.extmods][INFO    ][22856] Copying '/var/cache/salt/minion/files/base/_states/rundeck_secret.py' to '/var/cache/salt/minion/extmods/states/rundeck_secret.py'
2017-09-18 21:28:45,670 [salt.utils.extmods][INFO    ][22856] Creating module dir '/var/cache/salt/minion/extmods/sdb'
2017-09-18 21:28:45,673 [salt.utils.extmods][INFO    ][22856] Syncing sdb for environment 'base'
2017-09-18 21:28:45,673 [salt.utils.extmods][INFO    ][22856] Loading cache from salt://_sdb, for base)
2017-09-18 21:28:45,673 [salt.fileclient  ][INFO    ][22856] Caching directory '_sdb/' for environment 'base'
2017-09-18 21:28:45,706 [salt.utils.extmods][INFO    ][22856] Syncing grains for environment 'base'
2017-09-18 21:28:45,706 [salt.utils.extmods][INFO    ][22856] Loading cache from salt://_grains, for base)
2017-09-18 21:28:45,707 [salt.fileclient  ][INFO    ][22856] Caching directory '_grains/' for environment 'base'
2017-09-18 21:28:45,751 [salt.fileclient  ][INFO    ][22856] Fetching file from saltenv 'base', ** done ** '_grains/ceilometer_policy.py'
2017-09-18 21:28:45,765 [salt.fileclient  ][INFO    ][22856] Fetching file from saltenv 'base', ** done ** '_grains/cinder_policy.py'
2017-09-18 21:28:45,813 [salt.fileclient  ][INFO    ][22856] Fetching file from saltenv 'base', ** done ** '_grains/docker_swarm.py'
2017-09-18 21:28:45,850 [salt.fileclient  ][INFO    ][22856] Fetching file from saltenv 'base', ** done ** '_grains/glance_policy.py'
2017-09-18 21:28:45,903 [salt.fileclient  ][INFO    ][22856] Fetching file from saltenv 'base', ** done ** '_grains/heat_policy.py'
2017-09-18 21:28:45,951 [salt.fileclient  ][INFO    ][22856] Fetching file from saltenv 'base', ** done ** '_grains/jenkins_plugins.py'
2017-09-18 21:28:45,972 [salt.fileclient  ][INFO    ][22856] Fetching file from saltenv 'base', ** done ** '_grains/keystone_policy.py'
2017-09-18 21:28:46,005 [salt.fileclient  ][INFO    ][22856] Fetching file from saltenv 'base', ** done ** '_grains/kubernetes.py'
2017-09-18 21:28:46,047 [salt.fileclient  ][INFO    ][22856] Fetching file from saltenv 'base', ** done ** '_grains/neutron_policy.py'
2017-09-18 21:28:46,066 [salt.fileclient  ][INFO    ][22856] Fetching file from saltenv 'base', ** done ** '_grains/nova_policy.py'
2017-09-18 21:28:46,096 [salt.fileclient  ][INFO    ][22856] Fetching file from saltenv 'base', ** done ** '_grains/ssh_fingerprints.py'
2017-09-18 21:28:46,099 [salt.utils.extmods][INFO    ][22856] Copying '/var/cache/salt/minion/files/base/_grains/ceilometer_policy.py' to '/var/cache/salt/minion/extmods/grains/ceilometer_policy.py'
2017-09-18 21:28:46,128 [salt.utils.extmods][INFO    ][22856] Copying '/var/cache/salt/minion/files/base/_grains/cinder_policy.py' to '/var/cache/salt/minion/extmods/grains/cinder_policy.py'
2017-09-18 21:28:46,154 [salt.utils.extmods][INFO    ][22856] Copying '/var/cache/salt/minion/files/base/_grains/docker_swarm.py' to '/var/cache/salt/minion/extmods/grains/docker_swarm.py'
2017-09-18 21:28:46,162 [salt.utils.extmods][INFO    ][22856] Copying '/var/cache/salt/minion/files/base/_grains/glance_policy.py' to '/var/cache/salt/minion/extmods/grains/glance_policy.py'
2017-09-18 21:28:46,188 [salt.utils.extmods][INFO    ][22856] Copying '/var/cache/salt/minion/files/base/_grains/heat_policy.py' to '/var/cache/salt/minion/extmods/grains/heat_policy.py'
2017-09-18 21:28:46,209 [salt.utils.extmods][INFO    ][22856] Copying '/var/cache/salt/minion/files/base/_grains/jenkins_plugins.py' to '/var/cache/salt/minion/extmods/grains/jenkins_plugins.py'
2017-09-18 21:28:46,218 [salt.utils.extmods][INFO    ][22856] Copying '/var/cache/salt/minion/files/base/_grains/keystone_policy.py' to '/var/cache/salt/minion/extmods/grains/keystone_policy.py'
2017-09-18 21:28:46,233 [salt.utils.extmods][INFO    ][22856] Copying '/var/cache/salt/minion/files/base/_grains/kubernetes.py' to '/var/cache/salt/minion/extmods/grains/kubernetes.py'
2017-09-18 21:28:46,247 [salt.utils.extmods][INFO    ][22856] Copying '/var/cache/salt/minion/files/base/_grains/neutron_policy.py' to '/var/cache/salt/minion/extmods/grains/neutron_policy.py'
2017-09-18 21:28:46,247 [salt.utils.extmods][INFO    ][22856] Copying '/var/cache/salt/minion/files/base/_grains/nova_policy.py' to '/var/cache/salt/minion/extmods/grains/nova_policy.py'
2017-09-18 21:28:46,248 [salt.utils.extmods][INFO    ][22856] Copying '/var/cache/salt/minion/files/base/_grains/ssh_fingerprints.py' to '/var/cache/salt/minion/extmods/grains/ssh_fingerprints.py'
2017-09-18 21:28:46,249 [salt.utils.extmods][INFO    ][22856] Creating module dir '/var/cache/salt/minion/extmods/renderers'
2017-09-18 21:28:46,252 [salt.utils.extmods][INFO    ][22856] Syncing renderers for environment 'base'
2017-09-18 21:28:46,252 [salt.utils.extmods][INFO    ][22856] Loading cache from salt://_renderers, for base)
2017-09-18 21:28:46,252 [salt.fileclient  ][INFO    ][22856] Caching directory '_renderers/' for environment 'base'
2017-09-18 21:28:46,285 [salt.utils.extmods][INFO    ][22856] Creating module dir '/var/cache/salt/minion/extmods/returners'
2017-09-18 21:28:46,288 [salt.utils.extmods][INFO    ][22856] Syncing returners for environment 'base'
2017-09-18 21:28:46,288 [salt.utils.extmods][INFO    ][22856] Loading cache from salt://_returners, for base)
2017-09-18 21:28:46,288 [salt.fileclient  ][INFO    ][22856] Caching directory '_returners/' for environment 'base'
2017-09-18 21:28:46,318 [salt.utils.extmods][INFO    ][22856] Creating module dir '/var/cache/salt/minion/extmods/output'
2017-09-18 21:28:46,320 [salt.utils.extmods][INFO    ][22856] Syncing output for environment 'base'
2017-09-18 21:28:46,320 [salt.utils.extmods][INFO    ][22856] Loading cache from salt://_output, for base)
2017-09-18 21:28:46,320 [salt.fileclient  ][INFO    ][22856] Caching directory '_output/' for environment 'base'
2017-09-18 21:28:46,359 [salt.utils.extmods][INFO    ][22856] Creating module dir '/var/cache/salt/minion/extmods/utils'
2017-09-18 21:28:46,362 [salt.utils.extmods][INFO    ][22856] Syncing utils for environment 'base'
2017-09-18 21:28:46,362 [salt.utils.extmods][INFO    ][22856] Loading cache from salt://_utils, for base)
2017-09-18 21:28:46,362 [salt.fileclient  ][INFO    ][22856] Caching directory '_utils/' for environment 'base'
2017-09-18 21:28:46,395 [salt.utils.extmods][INFO    ][22856] Creating module dir '/var/cache/salt/minion/extmods/log_handlers'
2017-09-18 21:28:46,397 [salt.utils.extmods][INFO    ][22856] Syncing log_handlers for environment 'base'
2017-09-18 21:28:46,397 [salt.utils.extmods][INFO    ][22856] Loading cache from salt://_log_handlers, for base)
2017-09-18 21:28:46,397 [salt.fileclient  ][INFO    ][22856] Caching directory '_log_handlers/' for environment 'base'
2017-09-18 21:28:46,424 [salt.utils.extmods][INFO    ][22856] Creating module dir '/var/cache/salt/minion/extmods/proxy'
2017-09-18 21:28:46,427 [salt.utils.extmods][INFO    ][22856] Syncing proxy for environment 'base'
2017-09-18 21:28:46,427 [salt.utils.extmods][INFO    ][22856] Loading cache from salt://_proxy, for base)
2017-09-18 21:28:46,427 [salt.fileclient  ][INFO    ][22856] Caching directory '_proxy/' for environment 'base'
2017-09-18 21:28:46,464 [salt.utils.extmods][INFO    ][22856] Creating module dir '/var/cache/salt/minion/extmods/engines'
2017-09-18 21:28:46,467 [salt.utils.extmods][INFO    ][22856] Syncing engines for environment 'base'
2017-09-18 21:28:46,467 [salt.utils.extmods][INFO    ][22856] Loading cache from salt://_engines, for base)
2017-09-18 21:28:46,467 [salt.fileclient  ][INFO    ][22856] Caching directory '_engines/' for environment 'base'
2017-09-18 21:28:46,500 [salt.minion      ][INFO    ][22856] Returning information for job: 20170918212839254941
2017-09-18 21:28:47,355 [salt.minion      ][INFO    ][22749] User sudo_ubuntu Executing command state.sls with jid 20170918212847352605
2017-09-18 21:28:47,367 [salt.minion      ][INFO    ][22922] Starting a new job with PID 22922
2017-09-18 21:28:47,688 [salt.state       ][INFO    ][22922] Loading fresh modules for state activity
2017-09-18 21:28:47,708 [salt.fileclient  ][INFO    ][22922] Fetching file from saltenv 'base', ** done ** 'salt/control/init.sls'
2017-09-18 21:28:47,722 [salt.fileclient  ][INFO    ][22922] Fetching file from saltenv 'base', ** done ** 'salt/control/virt.sls'
2017-09-18 21:28:47,743 [salt.fileclient  ][INFO    ][22922] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-09-18 21:28:47,853 [salt.fileclient  ][INFO    ][22922] Fetching file from saltenv 'base', ** done ** 'salt/minion/init.sls'
2017-09-18 21:28:47,874 [salt.fileclient  ][INFO    ][22922] Fetching file from saltenv 'base', ** done ** 'salt/minion/service.sls'
2017-09-18 21:28:47,899 [salt.fileclient  ][INFO    ][22922] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-09-18 21:28:47,951 [salt.fileclient  ][INFO    ][22922] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-09-18 21:28:47,968 [salt.fileclient  ][INFO    ][22922] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-09-18 21:28:48,023 [salt.fileclient  ][INFO    ][22922] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-09-18 21:28:48,052 [salt.fileclient  ][INFO    ][22922] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-09-18 21:28:48,064 [salt.fileclient  ][INFO    ][22922] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-09-18 21:28:48,078 [salt.fileclient  ][INFO    ][22922] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-09-18 21:28:48,085 [salt.loaded.int.module.cmdmod][INFO    ][22922] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-09-18 21:28:48,119 [salt.fileclient  ][INFO    ][22922] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-09-18 21:28:48,132 [py.warnings      ][WARNING ][22922] /usr/lib/python2.7/dist-packages/salt/utils/templates.py:73: DeprecationWarning: Starting in 2015.5, cmd.run uses python_shell=False by default, which doesn't support shellisms (pipes, env variables, etc). cmd.run is currently aliased to cmd.shell to prevent breakage. Please switch to cmd.shell or set python_shell=True to avoid breakage in the future, when this aliasing is removed.

2017-09-18 21:28:48,132 [salt.loaded.int.module.cmdmod][INFO    ][22922] Executing command 'salt-minion --version' in directory '/root'
2017-09-18 21:28:48,382 [salt.fileclient  ][INFO    ][22922] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-09-18 21:28:48,402 [salt.fileclient  ][INFO    ][22922] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-09-18 21:28:48,414 [salt.fileclient  ][INFO    ][22922] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-09-18 21:28:48,426 [salt.fileclient  ][INFO    ][22922] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-09-18 21:28:48,473 [salt.fileclient  ][INFO    ][22922] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-09-18 21:28:48,510 [salt.fileclient  ][INFO    ][22922] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-09-18 21:28:48,562 [salt.fileclient  ][INFO    ][22922] Fetching file from saltenv 'base', ** done ** 'salt/minion/grains.sls'
2017-09-18 21:28:48,581 [salt.fileclient  ][INFO    ][22922] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-09-18 21:28:48,630 [salt.fileclient  ][INFO    ][22922] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-09-18 21:28:48,647 [salt.fileclient  ][INFO    ][22922] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-09-18 21:28:48,688 [salt.fileclient  ][INFO    ][22922] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-09-18 21:28:48,726 [salt.fileclient  ][INFO    ][22922] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-09-18 21:28:48,928 [salt.fileclient  ][INFO    ][22922] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-09-18 21:28:48,943 [salt.fileclient  ][INFO    ][22922] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-09-18 21:28:48,950 [salt.loaded.int.module.cmdmod][INFO    ][22922] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-09-18 21:28:48,971 [salt.fileclient  ][INFO    ][22922] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-09-18 21:28:48,985 [salt.loaded.int.module.cmdmod][INFO    ][22922] Executing command 'salt-minion --version' in directory '/root'
2017-09-18 21:28:49,252 [salt.fileclient  ][INFO    ][22922] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-09-18 21:28:49,288 [salt.fileclient  ][INFO    ][22922] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-09-18 21:28:49,302 [salt.fileclient  ][INFO    ][22922] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-09-18 21:28:49,315 [salt.fileclient  ][INFO    ][22922] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-09-18 21:28:49,364 [salt.fileclient  ][INFO    ][22922] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-09-18 21:28:49,401 [salt.fileclient  ][INFO    ][22922] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-09-18 21:28:49,463 [salt.fileclient  ][INFO    ][22922] Fetching file from saltenv 'base', ** done ** 'salt/minion/cert.sls'
2017-09-18 21:28:49,520 [salt.fileclient  ][INFO    ][22922] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-09-18 21:28:49,880 [salt.state       ][INFO    ][22922] Running state [salt-minion] at time 21:28:49.880103
2017-09-18 21:28:49,880 [salt.state       ][INFO    ][22922] Executing state pkg.installed for salt-minion
2017-09-18 21:28:49,881 [salt.loaded.int.module.cmdmod][INFO    ][22922] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-18 21:28:50,172 [salt.state       ][INFO    ][22922] Package salt-minion is already installed
2017-09-18 21:28:50,172 [salt.state       ][INFO    ][22922] Completed state [salt-minion] at time 21:28:50.172177 duration_in_ms=292.073
2017-09-18 21:28:50,172 [salt.state       ][INFO    ][22922] Running state [python-yaml] at time 21:28:50.172465
2017-09-18 21:28:50,173 [salt.state       ][INFO    ][22922] Executing state pkg.installed for python-yaml
2017-09-18 21:28:50,175 [salt.state       ][INFO    ][22922] Package python-yaml is already installed
2017-09-18 21:28:50,175 [salt.state       ][INFO    ][22922] Completed state [python-yaml] at time 21:28:50.175449 duration_in_ms=2.984
2017-09-18 21:28:50,176 [salt.state       ][INFO    ][22922] Running state [python-psutil] at time 21:28:50.175655
2017-09-18 21:28:50,176 [salt.state       ][INFO    ][22922] Executing state pkg.installed for python-psutil
2017-09-18 21:28:50,178 [salt.state       ][INFO    ][22922] Package python-psutil is already installed
2017-09-18 21:28:50,179 [salt.state       ][INFO    ][22922] Completed state [python-psutil] at time 21:28:50.178580 duration_in_ms=2.925
2017-09-18 21:28:50,179 [salt.state       ][INFO    ][22922] Running state [python-m2crypto] at time 21:28:50.178797
2017-09-18 21:28:50,179 [salt.state       ][INFO    ][22922] Executing state pkg.installed for python-m2crypto
2017-09-18 21:28:50,182 [salt.state       ][INFO    ][22922] Package python-m2crypto is already installed
2017-09-18 21:28:50,182 [salt.state       ][INFO    ][22922] Completed state [python-m2crypto] at time 21:28:50.181679 duration_in_ms=2.882
2017-09-18 21:28:50,183 [salt.state       ][INFO    ][22922] Running state [/etc/salt/minion.d/minion.conf] at time 21:28:50.183280
2017-09-18 21:28:50,184 [salt.state       ][INFO    ][22922] Executing state file.managed for /etc/salt/minion.d/minion.conf
2017-09-18 21:28:50,208 [salt.fileclient  ][INFO    ][22922] Fetching file from saltenv 'base', ** done ** 'salt/files/minion.conf'
2017-09-18 21:28:50,257 [salt.fileclient  ][INFO    ][22922] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-09-18 21:28:50,301 [salt.fileclient  ][INFO    ][22922] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-09-18 21:28:50,333 [salt.state       ][INFO    ][22922] File /etc/salt/minion.d/minion.conf is in the correct state
2017-09-18 21:28:50,333 [salt.state       ][INFO    ][22922] Completed state [/etc/salt/minion.d/minion.conf] at time 21:28:50.333230 duration_in_ms=149.949
2017-09-18 21:28:50,334 [salt.state       ][INFO    ][22922] Running state [/etc/salt/minion.d/_virt.conf] at time 21:28:50.333620
2017-09-18 21:28:50,334 [salt.state       ][INFO    ][22922] Executing state file.managed for /etc/salt/minion.d/_virt.conf
2017-09-18 21:28:50,363 [salt.state       ][INFO    ][22922] File /etc/salt/minion.d/_virt.conf is in the correct state
2017-09-18 21:28:50,363 [salt.state       ][INFO    ][22922] Completed state [/etc/salt/minion.d/_virt.conf] at time 21:28:50.363138 duration_in_ms=29.517
2017-09-18 21:28:50,364 [salt.state       ][INFO    ][22922] Running state [salt-minion] at time 21:28:50.364304
2017-09-18 21:28:50,365 [salt.state       ][INFO    ][22922] Executing state service.running for salt-minion
2017-09-18 21:28:50,365 [salt.loaded.int.module.cmdmod][INFO    ][22922] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2017-09-18 21:28:50,378 [salt.loaded.int.module.cmdmod][INFO    ][22922] Executing command ['systemctl', 'is-active', 'salt-minion.service'] in directory '/root'
2017-09-18 21:28:50,383 [salt.loaded.int.module.cmdmod][INFO    ][22922] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2017-09-18 21:28:50,392 [salt.state       ][INFO    ][22922] The service salt-minion is already running
2017-09-18 21:28:50,396 [salt.state       ][INFO    ][22922] Completed state [salt-minion] at time 21:28:50.395934 duration_in_ms=31.628
2017-09-18 21:28:50,397 [salt.state       ][INFO    ][22922] Running state [/etc/salt/grains.d] at time 21:28:50.397171
2017-09-18 21:28:50,397 [salt.state       ][INFO    ][22922] Executing state file.directory for /etc/salt/grains.d
2017-09-18 21:28:50,398 [salt.state       ][INFO    ][22922] Directory /etc/salt/grains.d is in the correct state
2017-09-18 21:28:50,398 [salt.state       ][INFO    ][22922] Completed state [/etc/salt/grains.d] at time 21:28:50.398151 duration_in_ms=0.98
2017-09-18 21:28:50,399 [salt.state       ][INFO    ][22922] Running state [/etc/salt/grains] at time 21:28:50.398632
2017-09-18 21:28:50,399 [salt.state       ][INFO    ][22922] Executing state file.managed for /etc/salt/grains
2017-09-18 21:28:50,399 [salt.state       ][INFO    ][22922] File /etc/salt/grains exists with proper permissions. No changes made.
2017-09-18 21:28:50,399 [salt.state       ][INFO    ][22922] Completed state [/etc/salt/grains] at time 21:28:50.399340 duration_in_ms=0.708
2017-09-18 21:28:50,400 [salt.state       ][INFO    ][22922] Running state [/etc/salt/grains.d/placeholder] at time 21:28:50.399620
2017-09-18 21:28:50,400 [salt.state       ][INFO    ][22922] Executing state file.managed for /etc/salt/grains.d/placeholder
2017-09-18 21:28:50,400 [salt.state       ][INFO    ][22922] File /etc/salt/grains.d/placeholder exists with proper permissions. No changes made.
2017-09-18 21:28:50,400 [salt.state       ][INFO    ][22922] Completed state [/etc/salt/grains.d/placeholder] at time 21:28:50.400323 duration_in_ms=0.703
2017-09-18 21:28:50,401 [salt.state       ][INFO    ][22922] Running state [/etc/salt/grains.d/sphinx] at time 21:28:50.400607
2017-09-18 21:28:50,401 [salt.state       ][INFO    ][22922] Executing state file.managed for /etc/salt/grains.d/sphinx
2017-09-18 21:28:50,413 [salt.state       ][INFO    ][22922] File /etc/salt/grains.d/sphinx is in the correct state
2017-09-18 21:28:50,414 [salt.state       ][INFO    ][22922] Completed state [/etc/salt/grains.d/sphinx] at time 21:28:50.413569 duration_in_ms=12.962
2017-09-18 21:28:50,414 [salt.state       ][INFO    ][22922] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 21:28:50.414041
2017-09-18 21:28:50,414 [salt.state       ][INFO    ][22922] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-09-18 21:28:50,414 [salt.state       ][INFO    ][22922] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-09-18 21:28:50,415 [salt.state       ][INFO    ][22922] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 21:28:50.414610 duration_in_ms=0.569
2017-09-18 21:28:50,415 [salt.state       ][INFO    ][22922] Running state [/etc/salt/grains.d/dns_records] at time 21:28:50.414895
2017-09-18 21:28:50,415 [salt.state       ][INFO    ][22922] Executing state file.managed for /etc/salt/grains.d/dns_records
2017-09-18 21:28:50,438 [salt.state       ][INFO    ][22922] File /etc/salt/grains.d/dns_records is in the correct state
2017-09-18 21:28:50,438 [salt.state       ][INFO    ][22922] Completed state [/etc/salt/grains.d/dns_records] at time 21:28:50.438458 duration_in_ms=23.563
2017-09-18 21:28:50,439 [salt.state       ][INFO    ][22922] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 21:28:50.438958
2017-09-18 21:28:50,439 [salt.state       ][INFO    ][22922] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"
2017-09-18 21:28:50,439 [salt.state       ][INFO    ][22922] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"
2017-09-18 21:28:50,440 [salt.state       ][INFO    ][22922] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 21:28:50.439526 duration_in_ms=0.568
2017-09-18 21:28:50,440 [salt.state       ][INFO    ][22922] Running state [/etc/salt/grains.d/salt] at time 21:28:50.439820
2017-09-18 21:28:50,440 [salt.state       ][INFO    ][22922] Executing state file.managed for /etc/salt/grains.d/salt
2017-09-18 21:28:50,450 [salt.state       ][INFO    ][22922] File /etc/salt/grains.d/salt is in the correct state
2017-09-18 21:28:50,451 [salt.state       ][INFO    ][22922] Completed state [/etc/salt/grains.d/salt] at time 21:28:50.450603 duration_in_ms=10.783
2017-09-18 21:28:50,452 [salt.state       ][INFO    ][22922] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 21:28:50.451462
2017-09-18 21:28:50,452 [salt.state       ][INFO    ][22922] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2017-09-18 21:28:50,452 [salt.state       ][INFO    ][22922] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2017-09-18 21:28:50,452 [salt.state       ][INFO    ][22922] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 21:28:50.452204 duration_in_ms=0.743
2017-09-18 21:28:50,453 [salt.state       ][INFO    ][22922] Running state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 21:28:50.453432
2017-09-18 21:28:50,454 [salt.state       ][INFO    ][22922] Executing state cmd.wait for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-09-18 21:28:50,454 [salt.state       ][INFO    ][22922] No changes made for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-09-18 21:28:50,454 [salt.state       ][INFO    ][22922] Completed state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 21:28:50.454058 duration_in_ms=0.626
2017-09-18 21:28:50,455 [salt.state       ][INFO    ][22922] Running state [mine.update] at time 21:28:50.454504
2017-09-18 21:28:50,455 [salt.state       ][INFO    ][22922] Executing state module.wait for mine.update
2017-09-18 21:28:50,455 [salt.state       ][INFO    ][22922] No changes made for mine.update
2017-09-18 21:28:50,455 [salt.state       ][INFO    ][22922] Completed state [mine.update] at time 21:28:50.455059 duration_in_ms=0.555
2017-09-18 21:28:50,455 [salt.state       ][INFO    ][22922] Running state [ca-certificates] at time 21:28:50.455235
2017-09-18 21:28:50,455 [salt.state       ][INFO    ][22922] Executing state pkg.installed for ca-certificates
2017-09-18 21:28:50,459 [salt.state       ][INFO    ][22922] Package ca-certificates is already installed
2017-09-18 21:28:50,459 [salt.state       ][INFO    ][22922] Completed state [ca-certificates] at time 21:28:50.458684 duration_in_ms=3.448
2017-09-18 21:28:50,459 [salt.state       ][INFO    ][22922] Running state [update-ca-certificates] at time 21:28:50.459131
2017-09-18 21:28:50,459 [salt.state       ][INFO    ][22922] Executing state cmd.wait for update-ca-certificates
2017-09-18 21:28:50,460 [salt.state       ][INFO    ][22922] No changes made for update-ca-certificates
2017-09-18 21:28:50,460 [salt.state       ][INFO    ][22922] Completed state [update-ca-certificates] at time 21:28:50.459695 duration_in_ms=0.565
2017-09-18 21:28:50,460 [salt.state       ][INFO    ][22922] Running state [libvirt-dev] at time 21:28:50.459877
2017-09-18 21:28:50,460 [salt.state       ][INFO    ][22922] Executing state pkg.installed for libvirt-dev
2017-09-18 21:28:50,463 [salt.state       ][INFO    ][22922] Package libvirt-dev is already installed
2017-09-18 21:28:50,463 [salt.state       ][INFO    ][22922] Completed state [libvirt-dev] at time 21:28:50.462875 duration_in_ms=2.998
2017-09-18 21:28:50,463 [salt.state       ][INFO    ][22922] Running state [pkg-config] at time 21:28:50.463054
2017-09-18 21:28:50,463 [salt.state       ][INFO    ][22922] Executing state pkg.installed for pkg-config
2017-09-18 21:28:50,466 [salt.state       ][INFO    ][22922] Package pkg-config is already installed
2017-09-18 21:28:50,466 [salt.state       ][INFO    ][22922] Completed state [pkg-config] at time 21:28:50.466060 duration_in_ms=3.006
2017-09-18 21:28:50,466 [salt.state       ][INFO    ][22922] Running state [virtng.init] at time 21:28:50.466237
2017-09-18 21:28:50,466 [salt.state       ][INFO    ][22922] Executing state module.run for virtng.init
2017-09-18 21:28:50,544 [salt.loaded.int.module.cmdmod][INFO    ][22922] Executing command ['git', '--version'] in directory '/root'
2017-09-18 21:28:50,617 [salt.loaded.int.module.cmdmod][INFO    ][22922] Executing command 'virsh list --all --name| grep -E "^mdb03.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-09-18 21:28:50,636 [salt.state       ][INFO    ][22922] unless execution succeeded
2017-09-18 21:28:50,637 [salt.state       ][INFO    ][22922] Completed state [virtng.init] at time 21:28:50.636720 duration_in_ms=170.48
2017-09-18 21:28:50,637 [salt.state       ][INFO    ][22922] Running state [virt.set_autostart] at time 21:28:50.636979
2017-09-18 21:28:50,637 [salt.state       ][INFO    ][22922] Executing state module.run for virt.set_autostart
2017-09-18 21:28:50,639 [salt.loaded.int.module.cmdmod][INFO    ][22922] Executing command 'virsh list --autostart --name| grep -E "^mdb03.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-09-18 21:28:50,657 [salt.state       ][INFO    ][22922] unless execution succeeded
2017-09-18 21:28:50,661 [salt.state       ][INFO    ][22922] Completed state [virt.set_autostart] at time 21:28:50.660420 duration_in_ms=23.441
2017-09-18 21:28:50,661 [salt.state       ][INFO    ][22922] Running state [virtng.init] at time 21:28:50.660789
2017-09-18 21:28:50,661 [salt.state       ][INFO    ][22922] Executing state module.run for virtng.init
2017-09-18 21:28:50,663 [salt.loaded.int.module.cmdmod][INFO    ][22922] Executing command 'virsh list --all --name| grep -E "^dbs03.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-09-18 21:28:50,677 [salt.state       ][INFO    ][22922] unless execution succeeded
2017-09-18 21:28:50,677 [salt.state       ][INFO    ][22922] Completed state [virtng.init] at time 21:28:50.676813 duration_in_ms=16.024
2017-09-18 21:28:50,677 [salt.state       ][INFO    ][22922] Running state [virt.set_autostart] at time 21:28:50.677021
2017-09-18 21:28:50,677 [salt.state       ][INFO    ][22922] Executing state module.run for virt.set_autostart
2017-09-18 21:28:50,679 [salt.loaded.int.module.cmdmod][INFO    ][22922] Executing command 'virsh list --autostart --name| grep -E "^dbs03.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-09-18 21:28:50,693 [salt.state       ][INFO    ][22922] unless execution succeeded
2017-09-18 21:28:50,693 [salt.state       ][INFO    ][22922] Completed state [virt.set_autostart] at time 21:28:50.692885 duration_in_ms=15.863
2017-09-18 21:28:50,693 [salt.state       ][INFO    ][22922] Running state [virtng.init] at time 21:28:50.693090
2017-09-18 21:28:50,693 [salt.state       ][INFO    ][22922] Executing state module.run for virtng.init
2017-09-18 21:28:50,695 [salt.loaded.int.module.cmdmod][INFO    ][22922] Executing command 'virsh list --all --name| grep -E "^ctl03.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-09-18 21:28:50,709 [salt.state       ][INFO    ][22922] unless execution succeeded
2017-09-18 21:28:50,709 [salt.state       ][INFO    ][22922] Completed state [virtng.init] at time 21:28:50.708940 duration_in_ms=15.85
2017-09-18 21:28:50,709 [salt.state       ][INFO    ][22922] Running state [virt.set_autostart] at time 21:28:50.709158
2017-09-18 21:28:50,709 [salt.state       ][INFO    ][22922] Executing state module.run for virt.set_autostart
2017-09-18 21:28:50,711 [salt.loaded.int.module.cmdmod][INFO    ][22922] Executing command 'virsh list --autostart --name| grep -E "^ctl03.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-09-18 21:28:50,725 [salt.state       ][INFO    ][22922] unless execution succeeded
2017-09-18 21:28:50,727 [salt.state       ][INFO    ][22922] Completed state [virt.set_autostart] at time 21:28:50.726574 duration_in_ms=17.415
2017-09-18 21:28:50,727 [salt.state       ][INFO    ][22922] Running state [virtng.init] at time 21:28:50.726927
2017-09-18 21:28:50,727 [salt.state       ][INFO    ][22922] Executing state module.run for virtng.init
2017-09-18 21:28:50,729 [salt.loaded.int.module.cmdmod][INFO    ][22922] Executing command 'virsh list --all --name| grep -E "^msg03.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-09-18 21:28:50,744 [salt.state       ][INFO    ][22922] unless execution succeeded
2017-09-18 21:28:50,745 [salt.state       ][INFO    ][22922] Completed state [virtng.init] at time 21:28:50.744628 duration_in_ms=17.701
2017-09-18 21:28:50,745 [salt.state       ][INFO    ][22922] Running state [virt.set_autostart] at time 21:28:50.744896
2017-09-18 21:28:50,745 [salt.state       ][INFO    ][22922] Executing state module.run for virt.set_autostart
2017-09-18 21:28:50,747 [salt.loaded.int.module.cmdmod][INFO    ][22922] Executing command 'virsh list --autostart --name| grep -E "^msg03.baremetal-mcp-ocata-ovs-ha.local$"' in directory '/root'
2017-09-18 21:28:50,760 [salt.state       ][INFO    ][22922] unless execution succeeded
2017-09-18 21:28:50,760 [salt.state       ][INFO    ][22922] Completed state [virt.set_autostart] at time 21:28:50.759806 duration_in_ms=14.91
2017-09-18 21:28:50,762 [salt.minion      ][INFO    ][22922] Returning information for job: 20170918212847352605
2017-09-18 21:30:08,830 [salt.minion      ][INFO    ][22749] User sudo_ubuntu Executing command saltutil.sync_all with jid 20170918213008827926
2017-09-18 21:30:08,842 [salt.minion      ][INFO    ][23057] Starting a new job with PID 23057
2017-09-18 21:30:12,405 [salt.state       ][INFO    ][23057] Loading fresh modules for state activity
2017-09-18 21:30:12,427 [salt.state       ][ERROR   ][23057] No contents found in top file
2017-09-18 21:30:12,428 [salt.utils.extmods][INFO    ][23057] Creating module dir '/var/cache/salt/minion/extmods/beacons'
2017-09-18 21:30:12,431 [salt.utils.extmods][INFO    ][23057] Syncing beacons for environment 'base'
2017-09-18 21:30:12,431 [salt.utils.extmods][INFO    ][23057] Loading cache from salt://_beacons, for base)
2017-09-18 21:30:12,431 [salt.fileclient  ][INFO    ][23057] Caching directory '_beacons/' for environment 'base'
2017-09-18 21:30:12,459 [salt.utils.extmods][INFO    ][23057] Syncing modules for environment 'base'
2017-09-18 21:30:12,460 [salt.utils.extmods][INFO    ][23057] Loading cache from salt://_modules, for base)
2017-09-18 21:30:12,460 [salt.fileclient  ][INFO    ][23057] Caching directory '_modules/' for environment 'base'
2017-09-18 21:30:12,704 [salt.fileclient  ][INFO    ][23057] Fetching file from saltenv 'base', ** done ** '_modules/ceph_ng.py'
2017-09-18 21:30:12,716 [salt.fileclient  ][INFO    ][23057] Fetching file from saltenv 'base', ** done ** '_modules/cinderng.py'
2017-09-18 21:30:13,026 [salt.fileclient  ][INFO    ][23057] Fetching file from saltenv 'base', ** done ** '_modules/contrail.py'
2017-09-18 21:30:13,050 [salt.fileclient  ][INFO    ][23057] Fetching file from saltenv 'base', ** done ** '_modules/creds.py'
2017-09-18 21:30:13,062 [salt.fileclient  ][INFO    ][23057] Fetching file from saltenv 'base', ** done ** '_modules/devops_utils.py'
2017-09-18 21:30:13,250 [salt.fileclient  ][INFO    ][23057] Fetching file from saltenv 'base', ** done ** '_modules/encode_json.py'
2017-09-18 21:30:13,498 [salt.fileclient  ][INFO    ][23057] Fetching file from saltenv 'base', ** done ** '_modules/gerrit.py'
2017-09-18 21:30:13,511 [salt.fileclient  ][INFO    ][23057] Fetching file from saltenv 'base', ** done ** '_modules/glanceng.py'
2017-09-18 21:30:13,542 [salt.fileclient  ][INFO    ][23057] Fetching file from saltenv 'base', ** done ** '_modules/heat.py'
2017-09-18 21:30:13,560 [salt.fileclient  ][INFO    ][23057] Fetching file from saltenv 'base', ** done ** '_modules/heka_alarming.py'
2017-09-18 21:30:13,589 [salt.fileclient  ][INFO    ][23057] Fetching file from saltenv 'base', ** done ** '_modules/helm.py'
2017-09-18 21:30:13,620 [salt.fileclient  ][INFO    ][23057] Fetching file from saltenv 'base', ** done ** '_modules/jenkins_common.py'
2017-09-18 21:30:13,630 [salt.fileclient  ][INFO    ][23057] Fetching file from saltenv 'base', ** done ** '_modules/keystone_policy.py'
2017-09-18 21:30:13,640 [salt.fileclient  ][INFO    ][23057] Fetching file from saltenv 'base', ** done ** '_modules/linux_hosts.py'
2017-09-18 21:30:13,655 [salt.fileclient  ][INFO    ][23057] Fetching file from saltenv 'base', ** done ** '_modules/linux_netlink.py'
2017-09-18 21:30:13,686 [salt.fileclient  ][INFO    ][23057] Fetching file from saltenv 'base', ** done ** '_modules/maas.py'
2017-09-18 21:30:13,697 [salt.fileclient  ][INFO    ][23057] Fetching file from saltenv 'base', ** done ** '_modules/maas_client.py'
2017-09-18 21:30:13,723 [salt.fileclient  ][INFO    ][23057] Fetching file from saltenv 'base', ** done ** '_modules/multipart.py'
2017-09-18 21:30:13,787 [salt.fileclient  ][INFO    ][23057] Fetching file from saltenv 'base', ** done ** '_modules/nagios_alarming.py'
2017-09-18 21:30:13,818 [salt.fileclient  ][INFO    ][23057] Fetching file from saltenv 'base', ** done ** '_modules/neutronng.py'
2017-09-18 21:30:13,829 [salt.fileclient  ][INFO    ][23057] Fetching file from saltenv 'base', ** done ** '_modules/novang.py'
2017-09-18 21:30:13,870 [salt.fileclient  ][INFO    ][23057] Fetching file from saltenv 'base', ** done ** '_modules/reclass.py'
2017-09-18 21:30:13,911 [salt.fileclient  ][INFO    ][23057] Fetching file from saltenv 'base', ** done ** '_modules/rsyslog_util.py'
2017-09-18 21:30:13,927 [salt.fileclient  ][INFO    ][23057] Fetching file from saltenv 'base', ** done ** '_modules/rundeck.py'
2017-09-18 21:30:13,980 [salt.fileclient  ][INFO    ][23057] Fetching file from saltenv 'base', ** done ** '_modules/saltkey.py'
2017-09-18 21:30:14,017 [salt.fileclient  ][INFO    ][23057] Fetching file from saltenv 'base', ** done ** '_modules/saltresource.py'
2017-09-18 21:30:14,031 [salt.fileclient  ][INFO    ][23057] Fetching file from saltenv 'base', ** done ** '_modules/seedng.py'
2017-09-18 21:30:14,048 [salt.fileclient  ][INFO    ][23057] Fetching file from saltenv 'base', ** done ** '_modules/testing/credentials.py'
2017-09-18 21:30:14,059 [salt.fileclient  ][INFO    ][23057] Fetching file from saltenv 'base', ** done ** '_modules/testing/django.py'
2017-09-18 21:30:14,141 [salt.fileclient  ][INFO    ][23057] Fetching file from saltenv 'base', ** done ** '_modules/testing/django_client_proxy.py'
2017-09-18 21:30:14,151 [salt.fileclient  ][INFO    ][23057] Fetching file from saltenv 'base', ** done ** '_modules/utils.py'
2017-09-18 21:30:14,204 [salt.fileclient  ][INFO    ][23057] Fetching file from saltenv 'base', ** done ** '_modules/virtng.py'
2017-09-18 21:30:14,206 [salt.utils.extmods][INFO    ][23057] Copying '/var/cache/salt/minion/files/base/_modules/__init__.py' to '/var/cache/salt/minion/extmods/modules/__init__.py'
2017-09-18 21:30:14,207 [salt.utils.extmods][INFO    ][23057] Copying '/var/cache/salt/minion/files/base/_modules/ceph_ng.py' to '/var/cache/salt/minion/extmods/modules/ceph_ng.py'
2017-09-18 21:30:14,207 [salt.utils.extmods][INFO    ][23057] Copying '/var/cache/salt/minion/files/base/_modules/cinderng.py' to '/var/cache/salt/minion/extmods/modules/cinderng.py'
2017-09-18 21:30:14,207 [salt.utils.extmods][INFO    ][23057] Copying '/var/cache/salt/minion/files/base/_modules/contrail.py' to '/var/cache/salt/minion/extmods/modules/contrail.py'
2017-09-18 21:30:14,208 [salt.utils.extmods][INFO    ][23057] Copying '/var/cache/salt/minion/files/base/_modules/creds.py' to '/var/cache/salt/minion/extmods/modules/creds.py'
2017-09-18 21:30:14,208 [salt.utils.extmods][INFO    ][23057] Copying '/var/cache/salt/minion/files/base/_modules/devops_utils.py' to '/var/cache/salt/minion/extmods/modules/devops_utils.py'
2017-09-18 21:30:14,208 [salt.utils.extmods][INFO    ][23057] Copying '/var/cache/salt/minion/files/base/_modules/encode_json.py' to '/var/cache/salt/minion/extmods/modules/encode_json.py'
2017-09-18 21:30:14,208 [salt.utils.extmods][INFO    ][23057] Copying '/var/cache/salt/minion/files/base/_modules/gerrit.py' to '/var/cache/salt/minion/extmods/modules/gerrit.py'
2017-09-18 21:30:14,209 [salt.utils.extmods][INFO    ][23057] Copying '/var/cache/salt/minion/files/base/_modules/glanceng.py' to '/var/cache/salt/minion/extmods/modules/glanceng.py'
2017-09-18 21:30:14,209 [salt.utils.extmods][INFO    ][23057] Copying '/var/cache/salt/minion/files/base/_modules/heat.py' to '/var/cache/salt/minion/extmods/modules/heat.py'
2017-09-18 21:30:14,209 [salt.utils.extmods][INFO    ][23057] Copying '/var/cache/salt/minion/files/base/_modules/heka_alarming.py' to '/var/cache/salt/minion/extmods/modules/heka_alarming.py'
2017-09-18 21:30:14,209 [salt.utils.extmods][INFO    ][23057] Copying '/var/cache/salt/minion/files/base/_modules/helm.py' to '/var/cache/salt/minion/extmods/modules/helm.py'
2017-09-18 21:30:14,210 [salt.utils.extmods][INFO    ][23057] Copying '/var/cache/salt/minion/files/base/_modules/jenkins_common.py' to '/var/cache/salt/minion/extmods/modules/jenkins_common.py'
2017-09-18 21:30:14,210 [salt.utils.extmods][INFO    ][23057] Copying '/var/cache/salt/minion/files/base/_modules/keystone_policy.py' to '/var/cache/salt/minion/extmods/modules/keystone_policy.py'
2017-09-18 21:30:14,210 [salt.utils.extmods][INFO    ][23057] Copying '/var/cache/salt/minion/files/base/_modules/linux_hosts.py' to '/var/cache/salt/minion/extmods/modules/linux_hosts.py'
2017-09-18 21:30:14,210 [salt.utils.extmods][INFO    ][23057] Copying '/var/cache/salt/minion/files/base/_modules/linux_netlink.py' to '/var/cache/salt/minion/extmods/modules/linux_netlink.py'
2017-09-18 21:30:14,211 [salt.utils.extmods][INFO    ][23057] Copying '/var/cache/salt/minion/files/base/_modules/maas.py' to '/var/cache/salt/minion/extmods/modules/maas.py'
2017-09-18 21:30:14,211 [salt.utils.extmods][INFO    ][23057] Copying '/var/cache/salt/minion/files/base/_modules/maas_client.py' to '/var/cache/salt/minion/extmods/modules/maas_client.py'
2017-09-18 21:30:14,211 [salt.utils.extmods][INFO    ][23057] Copying '/var/cache/salt/minion/files/base/_modules/multipart.py' to '/var/cache/salt/minion/extmods/modules/multipart.py'
2017-09-18 21:30:14,211 [salt.utils.extmods][INFO    ][23057] Copying '/var/cache/salt/minion/files/base/_modules/nagios_alarming.py' to '/var/cache/salt/minion/extmods/modules/nagios_alarming.py'
2017-09-18 21:30:14,212 [salt.utils.extmods][INFO    ][23057] Copying '/var/cache/salt/minion/files/base/_modules/neutronng.py' to '/var/cache/salt/minion/extmods/modules/neutronng.py'
2017-09-18 21:30:14,212 [salt.utils.extmods][INFO    ][23057] Copying '/var/cache/salt/minion/files/base/_modules/novang.py' to '/var/cache/salt/minion/extmods/modules/novang.py'
2017-09-18 21:30:14,212 [salt.utils.extmods][INFO    ][23057] Copying '/var/cache/salt/minion/files/base/_modules/reclass.py' to '/var/cache/salt/minion/extmods/modules/reclass.py'
2017-09-18 21:30:14,213 [salt.utils.extmods][INFO    ][23057] Copying '/var/cache/salt/minion/files/base/_modules/rsyslog_util.py' to '/var/cache/salt/minion/extmods/modules/rsyslog_util.py'
2017-09-18 21:30:14,213 [salt.utils.extmods][INFO    ][23057] Copying '/var/cache/salt/minion/files/base/_modules/rundeck.py' to '/var/cache/salt/minion/extmods/modules/rundeck.py'
2017-09-18 21:30:14,213 [salt.utils.extmods][INFO    ][23057] Copying '/var/cache/salt/minion/files/base/_modules/saltkey.py' to '/var/cache/salt/minion/extmods/modules/saltkey.py'
2017-09-18 21:30:14,213 [salt.utils.extmods][INFO    ][23057] Copying '/var/cache/salt/minion/files/base/_modules/saltresource.py' to '/var/cache/salt/minion/extmods/modules/saltresource.py'
2017-09-18 21:30:14,214 [salt.utils.extmods][INFO    ][23057] Copying '/var/cache/salt/minion/files/base/_modules/seedng.py' to '/var/cache/salt/minion/extmods/modules/seedng.py'
2017-09-18 21:30:14,214 [salt.utils.extmods][INFO    ][23057] Copying '/var/cache/salt/minion/files/base/_modules/testing/__init__.py' to '/var/cache/salt/minion/extmods/modules/testing/__init__.py'
2017-09-18 21:30:14,214 [salt.utils.extmods][INFO    ][23057] Copying '/var/cache/salt/minion/files/base/_modules/testing/credentials.py' to '/var/cache/salt/minion/extmods/modules/testing/credentials.py'
2017-09-18 21:30:14,214 [salt.utils.extmods][INFO    ][23057] Copying '/var/cache/salt/minion/files/base/_modules/testing/django.py' to '/var/cache/salt/minion/extmods/modules/testing/django.py'
2017-09-18 21:30:14,215 [salt.utils.extmods][INFO    ][23057] Copying '/var/cache/salt/minion/files/base/_modules/testing/django_client_proxy.py' to '/var/cache/salt/minion/extmods/modules/testing/django_client_proxy.py'
2017-09-18 21:30:14,215 [salt.utils.extmods][INFO    ][23057] Copying '/var/cache/salt/minion/files/base/_modules/utils.py' to '/var/cache/salt/minion/extmods/modules/utils.py'
2017-09-18 21:30:14,215 [salt.utils.extmods][INFO    ][23057] Copying '/var/cache/salt/minion/files/base/_modules/virtng.py' to '/var/cache/salt/minion/extmods/modules/virtng.py'
2017-09-18 21:30:14,220 [salt.utils.extmods][INFO    ][23057] Syncing states for environment 'base'
2017-09-18 21:30:14,220 [salt.utils.extmods][INFO    ][23057] Loading cache from salt://_states, for base)
2017-09-18 21:30:14,220 [salt.fileclient  ][INFO    ][23057] Caching directory '_states/' for environment 'base'
2017-09-18 21:30:14,304 [salt.fileclient  ][INFO    ][23057] Fetching file from saltenv 'base', ** done ** '_states/cinderng.py'
2017-09-18 21:30:14,315 [salt.fileclient  ][INFO    ][23057] Fetching file from saltenv 'base', ** done ** '_states/contrail.py'
2017-09-18 21:30:14,383 [salt.fileclient  ][INFO    ][23057] Fetching file from saltenv 'base', ** done ** '_states/gerrit.py'
2017-09-18 21:30:14,395 [salt.fileclient  ][INFO    ][23057] Fetching file from saltenv 'base', ** done ** '_states/glanceng.py'
2017-09-18 21:30:14,409 [salt.fileclient  ][INFO    ][23057] Fetching file from saltenv 'base', ** done ** '_states/grafana3_dashboard.py'
2017-09-18 21:30:14,422 [salt.fileclient  ][INFO    ][23057] Fetching file from saltenv 'base', ** done ** '_states/grafana3_datasource.py'
2017-09-18 21:30:14,523 [salt.fileclient  ][INFO    ][23057] Fetching file from saltenv 'base', ** done ** '_states/heat.py'
2017-09-18 21:30:14,535 [salt.fileclient  ][INFO    ][23057] Fetching file from saltenv 'base', ** done ** '_states/helm_release.py'
2017-09-18 21:30:14,543 [salt.fileclient  ][INFO    ][23057] Fetching file from saltenv 'base', ** done ** '_states/jenkins_approval.py'
2017-09-18 21:30:14,551 [salt.fileclient  ][INFO    ][23057] Fetching file from saltenv 'base', ** done ** '_states/jenkins_artifactory.py'
2017-09-18 21:30:14,580 [salt.fileclient  ][INFO    ][23057] Fetching file from saltenv 'base', ** done ** '_states/jenkins_credential.py'
2017-09-18 21:30:14,604 [salt.fileclient  ][INFO    ][23057] Fetching file from saltenv 'base', ** done ** '_states/jenkins_job.py'
2017-09-18 21:30:14,638 [salt.fileclient  ][INFO    ][23057] Fetching file from saltenv 'base', ** done ** '_states/jenkins_lib.py'
2017-09-18 21:30:14,687 [salt.fileclient  ][INFO    ][23057] Fetching file from saltenv 'base', ** done ** '_states/jenkins_node.py'
2017-09-18 21:30:14,707 [salt.fileclient  ][INFO    ][23057] Fetching file from saltenv 'base', ** done ** '_states/jenkins_plugin.py'
2017-09-18 21:30:14,714 [salt.fileclient  ][INFO    ][23057] Fetching file from saltenv 'base', ** done ** '_states/jenkins_security.py'
2017-09-18 21:30:14,722 [salt.fileclient  ][INFO    ][23057] Fetching file from saltenv 'base', ** done ** '_states/jenkins_slack.py'
2017-09-18 21:30:14,730 [salt.fileclient  ][INFO    ][23057] Fetching file from saltenv 'base', ** done ** '_states/jenkins_smtp.py'
2017-09-18 21:30:14,746 [salt.fileclient  ][INFO    ][23057] Fetching file from saltenv 'base', ** done ** '_states/jenkins_theme.py'
2017-09-18 21:30:14,768 [salt.fileclient  ][INFO    ][23057] Fetching file from saltenv 'base', ** done ** '_states/jenkins_user.py'
2017-09-18 21:30:14,781 [salt.fileclient  ][INFO    ][23057] Fetching file from saltenv 'base', ** done ** '_states/jenkins_view.py'
2017-09-18 21:30:14,793 [salt.fileclient  ][INFO    ][23057] Fetching file from saltenv 'base', ** done ** '_states/keystone_policy.py'
2017-09-18 21:30:14,804 [salt.fileclient  ][INFO    ][23057] Fetching file from saltenv 'base', ** done ** '_states/kibana_object.py'
2017-09-18 21:30:14,837 [salt.fileclient  ][INFO    ][23057] Fetching file from saltenv 'base', ** done ** '_states/neutronng.py'
2017-09-18 21:30:14,886 [salt.fileclient  ][INFO    ][23057] Fetching file from saltenv 'base', ** done ** '_states/novang.py'
2017-09-18 21:30:14,895 [salt.fileclient  ][INFO    ][23057] Fetching file from saltenv 'base', ** done ** '_states/reclass.py'
2017-09-18 21:30:14,902 [salt.fileclient  ][INFO    ][23057] Fetching file from saltenv 'base', ** done ** '_states/rundeck_project.py'
2017-09-18 21:30:14,920 [salt.fileclient  ][INFO    ][23057] Fetching file from saltenv 'base', ** done ** '_states/rundeck_scm.py'
2017-09-18 21:30:14,965 [salt.fileclient  ][INFO    ][23057] Fetching file from saltenv 'base', ** done ** '_states/rundeck_secret.py'
2017-09-18 21:30:14,968 [salt.utils.extmods][INFO    ][23057] Copying '/var/cache/salt/minion/files/base/_states/cinderng.py' to '/var/cache/salt/minion/extmods/states/cinderng.py'
2017-09-18 21:30:14,968 [salt.utils.extmods][INFO    ][23057] Copying '/var/cache/salt/minion/files/base/_states/contrail.py' to '/var/cache/salt/minion/extmods/states/contrail.py'
2017-09-18 21:30:14,968 [salt.utils.extmods][INFO    ][23057] Copying '/var/cache/salt/minion/files/base/_states/gerrit.py' to '/var/cache/salt/minion/extmods/states/gerrit.py'
2017-09-18 21:30:14,968 [salt.utils.extmods][INFO    ][23057] Copying '/var/cache/salt/minion/files/base/_states/glanceng.py' to '/var/cache/salt/minion/extmods/states/glanceng.py'
2017-09-18 21:30:14,969 [salt.utils.extmods][INFO    ][23057] Copying '/var/cache/salt/minion/files/base/_states/grafana3_dashboard.py' to '/var/cache/salt/minion/extmods/states/grafana3_dashboard.py'
2017-09-18 21:30:14,969 [salt.utils.extmods][INFO    ][23057] Copying '/var/cache/salt/minion/files/base/_states/grafana3_datasource.py' to '/var/cache/salt/minion/extmods/states/grafana3_datasource.py'
2017-09-18 21:30:14,969 [salt.utils.extmods][INFO    ][23057] Copying '/var/cache/salt/minion/files/base/_states/heat.py' to '/var/cache/salt/minion/extmods/states/heat.py'
2017-09-18 21:30:14,969 [salt.utils.extmods][INFO    ][23057] Copying '/var/cache/salt/minion/files/base/_states/helm_release.py' to '/var/cache/salt/minion/extmods/states/helm_release.py'
2017-09-18 21:30:14,969 [salt.utils.extmods][INFO    ][23057] Copying '/var/cache/salt/minion/files/base/_states/jenkins_approval.py' to '/var/cache/salt/minion/extmods/states/jenkins_approval.py'
2017-09-18 21:30:14,970 [salt.utils.extmods][INFO    ][23057] Copying '/var/cache/salt/minion/files/base/_states/jenkins_artifactory.py' to '/var/cache/salt/minion/extmods/states/jenkins_artifactory.py'
2017-09-18 21:30:14,970 [salt.utils.extmods][INFO    ][23057] Copying '/var/cache/salt/minion/files/base/_states/jenkins_credential.py' to '/var/cache/salt/minion/extmods/states/jenkins_credential.py'
2017-09-18 21:30:14,970 [salt.utils.extmods][INFO    ][23057] Copying '/var/cache/salt/minion/files/base/_states/jenkins_job.py' to '/var/cache/salt/minion/extmods/states/jenkins_job.py'
2017-09-18 21:30:14,970 [salt.utils.extmods][INFO    ][23057] Copying '/var/cache/salt/minion/files/base/_states/jenkins_lib.py' to '/var/cache/salt/minion/extmods/states/jenkins_lib.py'
2017-09-18 21:30:14,970 [salt.utils.extmods][INFO    ][23057] Copying '/var/cache/salt/minion/files/base/_states/jenkins_node.py' to '/var/cache/salt/minion/extmods/states/jenkins_node.py'
2017-09-18 21:30:14,971 [salt.utils.extmods][INFO    ][23057] Copying '/var/cache/salt/minion/files/base/_states/jenkins_plugin.py' to '/var/cache/salt/minion/extmods/states/jenkins_plugin.py'
2017-09-18 21:30:14,971 [salt.utils.extmods][INFO    ][23057] Copying '/var/cache/salt/minion/files/base/_states/jenkins_security.py' to '/var/cache/salt/minion/extmods/states/jenkins_security.py'
2017-09-18 21:30:14,971 [salt.utils.extmods][INFO    ][23057] Copying '/var/cache/salt/minion/files/base/_states/jenkins_slack.py' to '/var/cache/salt/minion/extmods/states/jenkins_slack.py'
2017-09-18 21:30:14,971 [salt.utils.extmods][INFO    ][23057] Copying '/var/cache/salt/minion/files/base/_states/jenkins_smtp.py' to '/var/cache/salt/minion/extmods/states/jenkins_smtp.py'
2017-09-18 21:30:14,971 [salt.utils.extmods][INFO    ][23057] Copying '/var/cache/salt/minion/files/base/_states/jenkins_theme.py' to '/var/cache/salt/minion/extmods/states/jenkins_theme.py'
2017-09-18 21:30:14,972 [salt.utils.extmods][INFO    ][23057] Copying '/var/cache/salt/minion/files/base/_states/jenkins_user.py' to '/var/cache/salt/minion/extmods/states/jenkins_user.py'
2017-09-18 21:30:14,972 [salt.utils.extmods][INFO    ][23057] Copying '/var/cache/salt/minion/files/base/_states/jenkins_view.py' to '/var/cache/salt/minion/extmods/states/jenkins_view.py'
2017-09-18 21:30:14,972 [salt.utils.extmods][INFO    ][23057] Copying '/var/cache/salt/minion/files/base/_states/keystone_policy.py' to '/var/cache/salt/minion/extmods/states/keystone_policy.py'
2017-09-18 21:30:14,972 [salt.utils.extmods][INFO    ][23057] Copying '/var/cache/salt/minion/files/base/_states/kibana_object.py' to '/var/cache/salt/minion/extmods/states/kibana_object.py'
2017-09-18 21:30:14,972 [salt.utils.extmods][INFO    ][23057] Copying '/var/cache/salt/minion/files/base/_states/maas_cluster.py' to '/var/cache/salt/minion/extmods/states/maas_cluster.py'
2017-09-18 21:30:14,973 [salt.utils.extmods][INFO    ][23057] Copying '/var/cache/salt/minion/files/base/_states/neutronng.py' to '/var/cache/salt/minion/extmods/states/neutronng.py'
2017-09-18 21:30:14,973 [salt.utils.extmods][INFO    ][23057] Copying '/var/cache/salt/minion/files/base/_states/novang.py' to '/var/cache/salt/minion/extmods/states/novang.py'
2017-09-18 21:30:14,973 [salt.utils.extmods][INFO    ][23057] Copying '/var/cache/salt/minion/files/base/_states/reclass.py' to '/var/cache/salt/minion/extmods/states/reclass.py'
2017-09-18 21:30:14,973 [salt.utils.extmods][INFO    ][23057] Copying '/var/cache/salt/minion/files/base/_states/rundeck_project.py' to '/var/cache/salt/minion/extmods/states/rundeck_project.py'
2017-09-18 21:30:14,973 [salt.utils.extmods][INFO    ][23057] Copying '/var/cache/salt/minion/files/base/_states/rundeck_scm.py' to '/var/cache/salt/minion/extmods/states/rundeck_scm.py'
2017-09-18 21:30:14,974 [salt.utils.extmods][INFO    ][23057] Copying '/var/cache/salt/minion/files/base/_states/rundeck_secret.py' to '/var/cache/salt/minion/extmods/states/rundeck_secret.py'
2017-09-18 21:30:14,975 [salt.utils.extmods][INFO    ][23057] Creating module dir '/var/cache/salt/minion/extmods/sdb'
2017-09-18 21:30:14,978 [salt.utils.extmods][INFO    ][23057] Syncing sdb for environment 'base'
2017-09-18 21:30:14,978 [salt.utils.extmods][INFO    ][23057] Loading cache from salt://_sdb, for base)
2017-09-18 21:30:14,978 [salt.fileclient  ][INFO    ][23057] Caching directory '_sdb/' for environment 'base'
2017-09-18 21:30:15,005 [salt.utils.extmods][INFO    ][23057] Syncing grains for environment 'base'
2017-09-18 21:30:15,005 [salt.utils.extmods][INFO    ][23057] Loading cache from salt://_grains, for base)
2017-09-18 21:30:15,005 [salt.fileclient  ][INFO    ][23057] Caching directory '_grains/' for environment 'base'
2017-09-18 21:30:15,094 [salt.fileclient  ][INFO    ][23057] Fetching file from saltenv 'base', ** done ** '_grains/ceilometer_policy.py'
2017-09-18 21:30:15,163 [salt.fileclient  ][INFO    ][23057] Fetching file from saltenv 'base', ** done ** '_grains/cinder_policy.py'
2017-09-18 21:30:15,175 [salt.fileclient  ][INFO    ][23057] Fetching file from saltenv 'base', ** done ** '_grains/docker_swarm.py'
2017-09-18 21:30:15,187 [salt.fileclient  ][INFO    ][23057] Fetching file from saltenv 'base', ** done ** '_grains/glance_policy.py'
2017-09-18 21:30:15,197 [salt.fileclient  ][INFO    ][23057] Fetching file from saltenv 'base', ** done ** '_grains/heat_policy.py'
2017-09-18 21:30:15,206 [salt.fileclient  ][INFO    ][23057] Fetching file from saltenv 'base', ** done ** '_grains/jenkins_plugins.py'
2017-09-18 21:30:15,258 [salt.fileclient  ][INFO    ][23057] Fetching file from saltenv 'base', ** done ** '_grains/keystone_policy.py'
2017-09-18 21:30:15,273 [salt.fileclient  ][INFO    ][23057] Fetching file from saltenv 'base', ** done ** '_grains/kubernetes.py'
2017-09-18 21:30:15,285 [salt.fileclient  ][INFO    ][23057] Fetching file from saltenv 'base', ** done ** '_grains/neutron_policy.py'
2017-09-18 21:30:16,430 [salt.fileclient  ][INFO    ][23057] Fetching file from saltenv 'base', ** done ** '_grains/nova_policy.py'
2017-09-18 21:30:16,807 [salt.fileclient  ][INFO    ][23057] Fetching file from saltenv 'base', ** done ** '_grains/ssh_fingerprints.py'
2017-09-18 21:30:16,810 [salt.utils.extmods][INFO    ][23057] Copying '/var/cache/salt/minion/files/base/_grains/ceilometer_policy.py' to '/var/cache/salt/minion/extmods/grains/ceilometer_policy.py'
2017-09-18 21:30:16,811 [salt.utils.extmods][INFO    ][23057] Copying '/var/cache/salt/minion/files/base/_grains/cinder_policy.py' to '/var/cache/salt/minion/extmods/grains/cinder_policy.py'
2017-09-18 21:30:16,811 [salt.utils.extmods][INFO    ][23057] Copying '/var/cache/salt/minion/files/base/_grains/docker_swarm.py' to '/var/cache/salt/minion/extmods/grains/docker_swarm.py'
2017-09-18 21:30:16,811 [salt.utils.extmods][INFO    ][23057] Copying '/var/cache/salt/minion/files/base/_grains/glance_policy.py' to '/var/cache/salt/minion/extmods/grains/glance_policy.py'
2017-09-18 21:30:16,812 [salt.utils.extmods][INFO    ][23057] Copying '/var/cache/salt/minion/files/base/_grains/heat_policy.py' to '/var/cache/salt/minion/extmods/grains/heat_policy.py'
2017-09-18 21:30:16,812 [salt.utils.extmods][INFO    ][23057] Copying '/var/cache/salt/minion/files/base/_grains/jenkins_plugins.py' to '/var/cache/salt/minion/extmods/grains/jenkins_plugins.py'
2017-09-18 21:30:16,812 [salt.utils.extmods][INFO    ][23057] Copying '/var/cache/salt/minion/files/base/_grains/keystone_policy.py' to '/var/cache/salt/minion/extmods/grains/keystone_policy.py'
2017-09-18 21:30:16,812 [salt.utils.extmods][INFO    ][23057] Copying '/var/cache/salt/minion/files/base/_grains/kubernetes.py' to '/var/cache/salt/minion/extmods/grains/kubernetes.py'
2017-09-18 21:30:16,813 [salt.utils.extmods][INFO    ][23057] Copying '/var/cache/salt/minion/files/base/_grains/neutron_policy.py' to '/var/cache/salt/minion/extmods/grains/neutron_policy.py'
2017-09-18 21:30:16,813 [salt.utils.extmods][INFO    ][23057] Copying '/var/cache/salt/minion/files/base/_grains/nova_policy.py' to '/var/cache/salt/minion/extmods/grains/nova_policy.py'
2017-09-18 21:30:16,813 [salt.utils.extmods][INFO    ][23057] Copying '/var/cache/salt/minion/files/base/_grains/ssh_fingerprints.py' to '/var/cache/salt/minion/extmods/grains/ssh_fingerprints.py'
2017-09-18 21:30:16,815 [salt.utils.extmods][INFO    ][23057] Creating module dir '/var/cache/salt/minion/extmods/renderers'
2017-09-18 21:30:16,818 [salt.utils.extmods][INFO    ][23057] Syncing renderers for environment 'base'
2017-09-18 21:30:16,818 [salt.utils.extmods][INFO    ][23057] Loading cache from salt://_renderers, for base)
2017-09-18 21:30:16,818 [salt.fileclient  ][INFO    ][23057] Caching directory '_renderers/' for environment 'base'
2017-09-18 21:30:16,838 [salt.utils.extmods][INFO    ][23057] Creating module dir '/var/cache/salt/minion/extmods/returners'
2017-09-18 21:30:16,840 [salt.utils.extmods][INFO    ][23057] Syncing returners for environment 'base'
2017-09-18 21:30:16,841 [salt.utils.extmods][INFO    ][23057] Loading cache from salt://_returners, for base)
2017-09-18 21:30:16,841 [salt.fileclient  ][INFO    ][23057] Caching directory '_returners/' for environment 'base'
2017-09-18 21:30:16,871 [salt.utils.extmods][INFO    ][23057] Creating module dir '/var/cache/salt/minion/extmods/output'
2017-09-18 21:30:16,873 [salt.utils.extmods][INFO    ][23057] Syncing output for environment 'base'
2017-09-18 21:30:16,874 [salt.utils.extmods][INFO    ][23057] Loading cache from salt://_output, for base)
2017-09-18 21:30:16,874 [salt.fileclient  ][INFO    ][23057] Caching directory '_output/' for environment 'base'
2017-09-18 21:30:16,890 [salt.utils.extmods][INFO    ][23057] Creating module dir '/var/cache/salt/minion/extmods/utils'
2017-09-18 21:30:16,892 [salt.utils.extmods][INFO    ][23057] Syncing utils for environment 'base'
2017-09-18 21:30:16,892 [salt.utils.extmods][INFO    ][23057] Loading cache from salt://_utils, for base)
2017-09-18 21:30:16,892 [salt.fileclient  ][INFO    ][23057] Caching directory '_utils/' for environment 'base'
2017-09-18 21:30:17,474 [salt.utils.extmods][INFO    ][23057] Creating module dir '/var/cache/salt/minion/extmods/log_handlers'
2017-09-18 21:30:17,477 [salt.utils.extmods][INFO    ][23057] Syncing log_handlers for environment 'base'
2017-09-18 21:30:17,477 [salt.utils.extmods][INFO    ][23057] Loading cache from salt://_log_handlers, for base)
2017-09-18 21:30:17,477 [salt.fileclient  ][INFO    ][23057] Caching directory '_log_handlers/' for environment 'base'
2017-09-18 21:30:17,506 [salt.utils.extmods][INFO    ][23057] Creating module dir '/var/cache/salt/minion/extmods/proxy'
2017-09-18 21:30:17,508 [salt.utils.extmods][INFO    ][23057] Syncing proxy for environment 'base'
2017-09-18 21:30:17,509 [salt.utils.extmods][INFO    ][23057] Loading cache from salt://_proxy, for base)
2017-09-18 21:30:17,509 [salt.fileclient  ][INFO    ][23057] Caching directory '_proxy/' for environment 'base'
2017-09-18 21:30:17,535 [salt.utils.extmods][INFO    ][23057] Creating module dir '/var/cache/salt/minion/extmods/engines'
2017-09-18 21:30:17,538 [salt.utils.extmods][INFO    ][23057] Syncing engines for environment 'base'
2017-09-18 21:30:17,538 [salt.utils.extmods][INFO    ][23057] Loading cache from salt://_engines, for base)
2017-09-18 21:30:17,538 [salt.fileclient  ][INFO    ][23057] Caching directory '_engines/' for environment 'base'
2017-09-18 21:30:17,562 [salt.minion      ][INFO    ][23057] Returning information for job: 20170918213008827926
2017-09-18 21:35:55,937 [salt.minion      ][INFO    ][22749] User sudo_ubuntu Executing command test.ping with jid 20170918213555927075
2017-09-18 21:35:55,956 [salt.minion      ][INFO    ][23208] Starting a new job with PID 23208
2017-09-18 21:35:55,980 [salt.minion      ][INFO    ][23208] Returning information for job: 20170918213555927075
2017-09-18 21:39:30,100 [salt.minion      ][INFO    ][22749] User sudo_ubuntu Executing command state.sls with jid 20170918213930089583
2017-09-18 21:39:30,114 [salt.minion      ][INFO    ][23281] Starting a new job with PID 23281
2017-09-18 21:39:30,504 [salt.state       ][INFO    ][23281] Loading fresh modules for state activity
2017-09-18 21:39:30,529 [salt.fileclient  ][INFO    ][23281] Fetching file from saltenv 'base', ** done ** 'keepalived/init.sls'
2017-09-18 21:39:30,545 [salt.fileclient  ][INFO    ][23281] Fetching file from saltenv 'base', ** done ** 'keepalived/cluster.sls'
2017-09-18 21:39:30,570 [salt.fileclient  ][INFO    ][23281] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-09-18 21:39:30,855 [salt.state       ][INFO    ][23281] Running state [lsof] at time 21:39:30.855248
2017-09-18 21:39:30,855 [salt.state       ][INFO    ][23281] Executing state pkg.installed for lsof
2017-09-18 21:39:30,856 [salt.loaded.int.module.cmdmod][INFO    ][23281] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-18 21:39:31,097 [salt.state       ][INFO    ][23281] Package lsof is already installed
2017-09-18 21:39:31,098 [salt.state       ][INFO    ][23281] Completed state [lsof] at time 21:39:31.097486 duration_in_ms=242.238
2017-09-18 21:39:31,098 [salt.state       ][INFO    ][23281] Running state [keepalived] at time 21:39:31.097689
2017-09-18 21:39:31,098 [salt.state       ][INFO    ][23281] Executing state pkg.installed for keepalived
2017-09-18 21:39:31,112 [salt.loaded.int.module.cmdmod][INFO    ][23281] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-09-18 21:39:32,569 [salt.loaded.int.module.cmdmod][INFO    ][23281] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'keepalived'] in directory '/root'
2017-09-18 21:39:40,145 [salt.minion      ][INFO    ][22749] User sudo_ubuntu Executing command saltutil.find_job with jid 20170918213940132630
2017-09-18 21:39:40,156 [salt.minion      ][INFO    ][24732] Starting a new job with PID 24732
2017-09-18 21:39:40,165 [salt.minion      ][INFO    ][24732] Returning information for job: 20170918213940132630
2017-09-18 21:39:40,555 [salt.loaded.int.module.cmdmod][INFO    ][23281] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-18 21:39:40,578 [salt.state       ][INFO    ][23281] Made the following changes:
'libsnmp30' changed from 'absent' to '5.7.3+dfsg-1ubuntu4'
'libsnmp-base' changed from 'absent' to '5.7.3+dfsg-1ubuntu4'
'keepalived' changed from 'absent' to '1:1.2.19-1ubuntu0.2'
'ipvsadm' changed from 'absent' to '1:1.28-3'
'libsensors4' changed from 'absent' to '1:3.4.0-2'

2017-09-18 21:39:40,586 [salt.state       ][INFO    ][23281] Loading fresh modules for state activity
2017-09-18 21:39:40,598 [salt.state       ][INFO    ][23281] Completed state [keepalived] at time 21:39:40.597484 duration_in_ms=9499.794
2017-09-18 21:39:40,600 [salt.state       ][INFO    ][23281] Running state [/etc/keepalived/keepalived.conf] at time 21:39:40.599513
2017-09-18 21:39:40,600 [salt.state       ][INFO    ][23281] Executing state file.managed for /etc/keepalived/keepalived.conf
2017-09-18 21:39:40,624 [salt.fileclient  ][INFO    ][23281] Fetching file from saltenv 'base', ** done ** 'keepalived/files/keepalived.conf'
2017-09-18 21:39:40,653 [salt.fileclient  ][INFO    ][23281] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-09-18 21:39:40,659 [salt.state       ][INFO    ][23281] File changed:
New file
2017-09-18 21:39:40,659 [salt.state       ][INFO    ][23281] Completed state [/etc/keepalived/keepalived.conf] at time 21:39:40.658845 duration_in_ms=59.331
2017-09-18 21:39:40,717 [salt.state       ][INFO    ][23281] Running state [keepalived] at time 21:39:40.716499
2017-09-18 21:39:40,717 [salt.state       ][INFO    ][23281] Executing state service.running for keepalived
2017-09-18 21:39:40,718 [salt.loaded.int.module.cmdmod][INFO    ][23281] Executing command ['systemctl', 'status', 'keepalived.service', '-n', '0'] in directory '/root'
2017-09-18 21:39:40,728 [salt.loaded.int.module.cmdmod][INFO    ][23281] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2017-09-18 21:39:40,736 [salt.loaded.int.module.cmdmod][INFO    ][23281] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-09-18 21:39:40,743 [salt.loaded.int.module.cmdmod][INFO    ][23281] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-09-18 21:39:40,752 [salt.loaded.int.module.cmdmod][INFO    ][23281] Executing command ['systemd-run', '--scope', 'systemctl', 'start', 'keepalived.service'] in directory '/root'
2017-09-18 21:39:40,814 [salt.loaded.int.module.cmdmod][INFO    ][23281] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2017-09-18 21:39:40,820 [salt.loaded.int.module.cmdmod][INFO    ][23281] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-09-18 21:39:40,826 [salt.loaded.int.module.cmdmod][INFO    ][23281] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-09-18 21:39:40,832 [salt.state       ][INFO    ][23281] {'keepalived': True}
2017-09-18 21:39:40,832 [salt.state       ][INFO    ][23281] Completed state [keepalived] at time 21:39:40.832459 duration_in_ms=115.961
2017-09-18 21:39:40,833 [salt.minion      ][INFO    ][23281] Returning information for job: 20170918213930089583
2017-09-18 21:40:09,981 [salt.minion      ][INFO    ][22749] User sudo_ubuntu Executing command pillar.get with jid 20170918214009969189
2017-09-18 21:40:09,997 [salt.minion      ][INFO    ][24828] Starting a new job with PID 24828
2017-09-18 21:40:10,003 [salt.minion      ][INFO    ][24828] Returning information for job: 20170918214009969189
2017-09-18 21:45:36,199 [salt.minion      ][INFO    ][22749] User sudo_ubuntu Executing command state.sls with jid 20170918214536188963
2017-09-18 21:45:36,213 [salt.minion      ][INFO    ][24908] Starting a new job with PID 24908
2017-09-18 21:45:38,611 [salt.state       ][INFO    ][24908] Loading fresh modules for state activity
2017-09-18 21:45:38,632 [salt.fileclient  ][INFO    ][24908] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-09-18 21:45:38,650 [salt.fileclient  ][INFO    ][24908] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-09-18 21:45:38,926 [salt.state       ][INFO    ][24908] Running state [attr] at time 21:45:38.926083
2017-09-18 21:45:38,926 [salt.state       ][INFO    ][24908] Executing state pkg.installed for attr
2017-09-18 21:45:38,927 [salt.loaded.int.module.cmdmod][INFO    ][24908] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-18 21:45:39,194 [salt.loaded.int.module.cmdmod][INFO    ][24908] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-09-18 21:45:41,155 [salt.loaded.int.module.cmdmod][INFO    ][24908] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'attr'] in directory '/root'
2017-09-18 21:45:43,585 [salt.loaded.int.module.cmdmod][INFO    ][24908] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-18 21:45:43,608 [salt.state       ][INFO    ][24908] Made the following changes:
'attr' changed from 'absent' to '1:2.4.47-2'

2017-09-18 21:45:43,615 [salt.state       ][INFO    ][24908] Loading fresh modules for state activity
2017-09-18 21:45:43,627 [salt.state       ][INFO    ][24908] Completed state [attr] at time 21:45:43.626785 duration_in_ms=4700.701
2017-09-18 21:45:43,631 [salt.state       ][INFO    ][24908] Running state [glusterfs-server] at time 21:45:43.631179
2017-09-18 21:45:43,631 [salt.state       ][INFO    ][24908] Executing state pkg.installed for glusterfs-server
2017-09-18 21:45:43,803 [salt.loaded.int.module.cmdmod][INFO    ][24908] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'glusterfs-server'] in directory '/root'
2017-09-18 21:45:46,291 [salt.minion      ][INFO    ][22749] User sudo_ubuntu Executing command saltutil.find_job with jid 20170918214546280276
2017-09-18 21:45:46,305 [salt.minion      ][INFO    ][25897] Starting a new job with PID 25897
2017-09-18 21:45:46,324 [salt.minion      ][INFO    ][25897] Returning information for job: 20170918214546280276
2017-09-18 21:45:56,498 [salt.minion      ][INFO    ][22749] User sudo_ubuntu Executing command saltutil.find_job with jid 20170918214556487145
2017-09-18 21:45:56,510 [salt.minion      ][INFO    ][28734] Starting a new job with PID 28734
2017-09-18 21:45:56,529 [salt.minion      ][INFO    ][28734] Returning information for job: 20170918214556487145
2017-09-18 21:46:00,555 [salt.loaded.int.module.cmdmod][INFO    ][24908] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-18 21:46:00,576 [salt.state       ][INFO    ][24908] Made the following changes:
'keyutils' changed from 'absent' to '1.5.9-8ubuntu1'
'nfs-common' changed from 'absent' to '1:1.2.8-9ubuntu12.1'
'rpcbind' changed from 'absent' to '0.2.3-0.2'
'glusterfs-common' changed from 'absent' to '3.7.6-1ubuntu1'
'librdmacm1' changed from 'absent' to '1.0.21-1'
'libnfsidmap2' changed from 'absent' to '0.25-5'
'portmap' changed from 'absent' to '1'
'libattr1-dev' changed from 'absent' to '1:2.4.47-2'
'attr-dev' changed from 'absent' to '1'
'acl-dev' changed from 'absent' to '1'
'glusterfs-server' changed from 'absent' to '3.7.6-1ubuntu1'
'glusterfs-client' changed from 'absent' to '3.7.6-1ubuntu1'
'libpython2.7' changed from 'absent' to '2.7.12-1ubuntu0~16.04.1'
'nfs-client' changed from 'absent' to '1'
'liburcu4' changed from 'absent' to '0.9.1-3'
'libacl1-dev' changed from 'absent' to '2.2.52-3'
'libibverbs1' changed from 'absent' to '1.1.8-1.1ubuntu2'
'libtirpc1' changed from 'absent' to '0.2.5-1'

2017-09-18 21:46:00,583 [salt.state       ][INFO    ][24908] Loading fresh modules for state activity
2017-09-18 21:46:00,595 [salt.state       ][INFO    ][24908] Completed state [glusterfs-server] at time 21:46:00.594777 duration_in_ms=16963.598
2017-09-18 21:46:00,599 [salt.state       ][INFO    ][24908] Running state [bc] at time 21:46:00.598963
2017-09-18 21:46:00,599 [salt.state       ][INFO    ][24908] Executing state pkg.installed for bc
2017-09-18 21:46:00,850 [salt.loaded.int.module.cmdmod][INFO    ][24908] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'bc'] in directory '/root'
2017-09-18 21:46:03,446 [salt.loaded.int.module.cmdmod][INFO    ][24908] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-18 21:46:03,469 [salt.state       ][INFO    ][24908] Made the following changes:
'bc' changed from 'absent' to '1.06.95-9build1'

2017-09-18 21:46:03,477 [salt.state       ][INFO    ][24908] Loading fresh modules for state activity
2017-09-18 21:46:03,489 [salt.state       ][INFO    ][24908] Completed state [bc] at time 21:46:03.489032 duration_in_ms=2890.069
2017-09-18 21:46:03,545 [salt.state       ][INFO    ][24908] Running state [glusterfs-server] at time 21:46:03.545304
2017-09-18 21:46:03,546 [salt.state       ][INFO    ][24908] Executing state service.running for glusterfs-server
2017-09-18 21:46:03,547 [salt.loaded.int.module.cmdmod][INFO    ][24908] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-09-18 21:46:03,555 [salt.loaded.int.module.cmdmod][INFO    ][24908] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-09-18 21:46:03,561 [salt.loaded.int.module.cmdmod][INFO    ][24908] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-09-18 21:46:03,568 [salt.state       ][INFO    ][24908] The service glusterfs-server is already running
2017-09-18 21:46:03,568 [salt.state       ][INFO    ][24908] Completed state [glusterfs-server] at time 21:46:03.568315 duration_in_ms=23.012
2017-09-18 21:46:03,570 [salt.state       ][INFO    ][24908] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 21:46:03.569684
2017-09-18 21:46:03,570 [salt.state       ][INFO    ][24908] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-09-18 21:46:03,586 [salt.state       ][INFO    ][24908] File changed:
New file
2017-09-18 21:46:03,586 [salt.state       ][INFO    ][24908] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 21:46:03.586282 duration_in_ms=16.597
2017-09-18 21:46:03,586 [salt.state       ][INFO    ][24908] Running state [/srv/glusterfs/glance] at time 21:46:03.586462
2017-09-18 21:46:03,587 [salt.state       ][INFO    ][24908] Executing state file.directory for /srv/glusterfs/glance
2017-09-18 21:46:03,587 [salt.state       ][INFO    ][24908] {'/srv/glusterfs/glance': 'New Dir'}
2017-09-18 21:46:03,587 [salt.state       ][INFO    ][24908] Completed state [/srv/glusterfs/glance] at time 21:46:03.587362 duration_in_ms=0.899
2017-09-18 21:46:03,588 [salt.state       ][INFO    ][24908] Running state [/srv/glusterfs/keystone-keys] at time 21:46:03.587513
2017-09-18 21:46:03,588 [salt.state       ][INFO    ][24908] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-09-18 21:46:03,588 [salt.state       ][INFO    ][24908] {'/srv/glusterfs/keystone-keys': 'New Dir'}
2017-09-18 21:46:03,588 [salt.state       ][INFO    ][24908] Completed state [/srv/glusterfs/keystone-keys] at time 21:46:03.588179 duration_in_ms=0.665
2017-09-18 21:46:03,588 [salt.state       ][INFO    ][24908] Running state [/srv/glusterfs/nova_instances] at time 21:46:03.588329
2017-09-18 21:46:03,588 [salt.state       ][INFO    ][24908] Executing state file.directory for /srv/glusterfs/nova_instances
2017-09-18 21:46:03,589 [salt.state       ][INFO    ][24908] {'/srv/glusterfs/nova_instances': 'New Dir'}
2017-09-18 21:46:03,589 [salt.state       ][INFO    ][24908] Completed state [/srv/glusterfs/nova_instances] at time 21:46:03.588969 duration_in_ms=0.64
2017-09-18 21:46:03,589 [salt.state       ][INFO    ][24908] Running state [/srv/glusterfs/keystone-credential-keys] at time 21:46:03.589117
2017-09-18 21:46:03,589 [salt.state       ][INFO    ][24908] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-09-18 21:46:03,590 [salt.state       ][INFO    ][24908] {'/srv/glusterfs/keystone-credential-keys': 'New Dir'}
2017-09-18 21:46:03,590 [salt.state       ][INFO    ][24908] Completed state [/srv/glusterfs/keystone-credential-keys] at time 21:46:03.589772 duration_in_ms=0.655
2017-09-18 21:46:03,591 [salt.minion      ][INFO    ][24908] Returning information for job: 20170918214536188963
2017-09-18 21:46:05,283 [salt.minion      ][INFO    ][22749] User sudo_ubuntu Executing command test.ping with jid 20170918214605277205
2017-09-18 21:46:05,295 [salt.minion      ][INFO    ][29596] Starting a new job with PID 29596
2017-09-18 21:46:05,322 [salt.minion      ][INFO    ][29596] Returning information for job: 20170918214605277205
2017-09-18 21:46:46,268 [salt.minion      ][INFO    ][22749] User sudo_ubuntu Executing command state.sls with jid 20170918214646257780
2017-09-18 21:46:46,282 [salt.minion      ][INFO    ][29811] Starting a new job with PID 29811
2017-09-18 21:46:47,767 [salt.state       ][INFO    ][29811] Loading fresh modules for state activity
2017-09-18 21:46:47,789 [salt.fileclient  ][INFO    ][29811] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/setup.sls'
2017-09-18 21:46:47,821 [salt.fileclient  ][INFO    ][29811] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-09-18 21:46:47,883 [salt.fileclient  ][INFO    ][29811] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-09-18 21:46:47,902 [salt.fileclient  ][INFO    ][29811] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-09-18 21:46:48,158 [salt.state       ][INFO    ][29811] Running state [attr] at time 21:46:48.157725
2017-09-18 21:46:48,158 [salt.state       ][INFO    ][29811] Executing state pkg.installed for attr
2017-09-18 21:46:48,158 [salt.loaded.int.module.cmdmod][INFO    ][29811] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-18 21:46:48,419 [salt.state       ][INFO    ][29811] Package attr is already installed
2017-09-18 21:46:48,419 [salt.state       ][INFO    ][29811] Completed state [attr] at time 21:46:48.418878 duration_in_ms=261.153
2017-09-18 21:46:48,419 [salt.state       ][INFO    ][29811] Running state [glusterfs-server] at time 21:46:48.419094
2017-09-18 21:46:48,419 [salt.state       ][INFO    ][29811] Executing state pkg.installed for glusterfs-server
2017-09-18 21:46:48,422 [salt.state       ][INFO    ][29811] Package glusterfs-server is already installed
2017-09-18 21:46:48,422 [salt.state       ][INFO    ][29811] Completed state [glusterfs-server] at time 21:46:48.421998 duration_in_ms=2.903
2017-09-18 21:46:48,422 [salt.state       ][INFO    ][29811] Running state [bc] at time 21:46:48.422157
2017-09-18 21:46:48,422 [salt.state       ][INFO    ][29811] Executing state pkg.installed for bc
2017-09-18 21:46:48,425 [salt.state       ][INFO    ][29811] Package bc is already installed
2017-09-18 21:46:48,425 [salt.state       ][INFO    ][29811] Completed state [bc] at time 21:46:48.424953 duration_in_ms=2.796
2017-09-18 21:46:48,426 [salt.state       ][INFO    ][29811] Running state [glusterfs-server] at time 21:46:48.425784
2017-09-18 21:46:48,426 [salt.state       ][INFO    ][29811] Executing state service.running for glusterfs-server
2017-09-18 21:46:48,426 [salt.loaded.int.module.cmdmod][INFO    ][29811] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-09-18 21:46:48,436 [salt.loaded.int.module.cmdmod][INFO    ][29811] Executing command ['systemctl', '--system', 'daemon-reload'] in directory '/root'
2017-09-18 21:46:48,478 [salt.loaded.int.module.cmdmod][INFO    ][29811] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-09-18 21:46:48,490 [salt.loaded.int.module.cmdmod][INFO    ][29811] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-09-18 21:46:48,497 [salt.loaded.int.module.cmdmod][INFO    ][29811] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-09-18 21:46:48,505 [salt.state       ][INFO    ][29811] The service glusterfs-server is already running
2017-09-18 21:46:48,506 [salt.state       ][INFO    ][29811] Completed state [glusterfs-server] at time 21:46:48.505530 duration_in_ms=79.745
2017-09-18 21:46:48,507 [salt.state       ][INFO    ][29811] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 21:46:48.506893
2017-09-18 21:46:48,507 [salt.state       ][INFO    ][29811] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-09-18 21:46:48,522 [salt.state       ][INFO    ][29811] File /etc/systemd/system/glusterfs-server.service.d/override.conf is in the correct state
2017-09-18 21:46:48,522 [salt.state       ][INFO    ][29811] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 21:46:48.521888 duration_in_ms=14.995
2017-09-18 21:46:48,522 [salt.state       ][INFO    ][29811] Running state [/srv/glusterfs/glance] at time 21:46:48.522030
2017-09-18 21:46:48,522 [salt.state       ][INFO    ][29811] Executing state file.directory for /srv/glusterfs/glance
2017-09-18 21:46:48,522 [salt.state       ][INFO    ][29811] Directory /srv/glusterfs/glance is in the correct state
2017-09-18 21:46:48,523 [salt.state       ][INFO    ][29811] Completed state [/srv/glusterfs/glance] at time 21:46:48.522572 duration_in_ms=0.542
2017-09-18 21:46:48,523 [salt.state       ][INFO    ][29811] Running state [/srv/glusterfs/keystone-keys] at time 21:46:48.522707
2017-09-18 21:46:48,523 [salt.state       ][INFO    ][29811] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-09-18 21:46:48,523 [salt.state       ][INFO    ][29811] Directory /srv/glusterfs/keystone-keys is in the correct state
2017-09-18 21:46:48,523 [salt.state       ][INFO    ][29811] Completed state [/srv/glusterfs/keystone-keys] at time 21:46:48.523234 duration_in_ms=0.528
2017-09-18 21:46:48,523 [salt.state       ][INFO    ][29811] Running state [/srv/glusterfs/nova_instances] at time 21:46:48.523365
2017-09-18 21:46:48,524 [salt.state       ][INFO    ][29811] Executing state file.directory for /srv/glusterfs/nova_instances
2017-09-18 21:46:48,524 [salt.state       ][INFO    ][29811] Directory /srv/glusterfs/nova_instances is in the correct state
2017-09-18 21:46:48,524 [salt.state       ][INFO    ][29811] Completed state [/srv/glusterfs/nova_instances] at time 21:46:48.523888 duration_in_ms=0.523
2017-09-18 21:46:48,524 [salt.state       ][INFO    ][29811] Running state [/srv/glusterfs/keystone-credential-keys] at time 21:46:48.524022
2017-09-18 21:46:48,524 [salt.state       ][INFO    ][29811] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-09-18 21:46:48,524 [salt.state       ][INFO    ][29811] Directory /srv/glusterfs/keystone-credential-keys is in the correct state
2017-09-18 21:46:48,525 [salt.state       ][INFO    ][29811] Completed state [/srv/glusterfs/keystone-credential-keys] at time 21:46:48.524552 duration_in_ms=0.53
2017-09-18 21:46:48,571 [salt.loaded.int.module.cmdmod][INFO    ][29811] Executing command ['git', '--version'] in directory '/root'
2017-09-18 21:46:48,657 [salt.state       ][INFO    ][29811] Running state [sleep 5] at time 21:46:48.657043
2017-09-18 21:46:48,657 [salt.state       ][INFO    ][29811] Executing state cmd.wait for sleep 5
2017-09-18 21:46:48,658 [salt.state       ][INFO    ][29811] No changes made for sleep 5
2017-09-18 21:46:48,658 [salt.state       ][INFO    ][29811] Completed state [sleep 5] at time 21:46:48.657601 duration_in_ms=0.559
2017-09-18 21:46:48,658 [salt.state       ][INFO    ][29811] Running state [10.167.4.141] at time 21:46:48.657971
2017-09-18 21:46:48,658 [salt.state       ][INFO    ][29811] Executing state glusterfs.peered for 10.167.4.141
2017-09-18 21:46:48,658 [salt.loaded.int.module.cmdmod][INFO    ][29811] Executing command 'gluster --version' in directory '/root'
2017-09-18 21:46:48,667 [salt.loaded.int.module.cmdmod][INFO    ][29811] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-18 21:46:48,718 [salt.state       ][INFO    ][29811] Host 10.167.4.141 already peered
2017-09-18 21:46:48,718 [salt.state       ][INFO    ][29811] Completed state [10.167.4.141] at time 21:46:48.718394 duration_in_ms=60.422
2017-09-18 21:46:48,721 [salt.state       ][INFO    ][29811] Running state [10.167.4.142] at time 21:46:48.720485
2017-09-18 21:46:48,721 [salt.state       ][INFO    ][29811] Executing state glusterfs.peered for 10.167.4.142
2017-09-18 21:46:48,721 [salt.loaded.int.module.cmdmod][INFO    ][29811] Executing command 'gluster --version' in directory '/root'
2017-09-18 21:46:48,729 [salt.loaded.int.module.cmdmod][INFO    ][29811] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-18 21:46:48,777 [salt.loaded.int.module.cmdmod][INFO    ][29811] Executing command 'gluster --version' in directory '/root'
2017-09-18 21:46:48,785 [salt.loaded.int.module.cmdmod][INFO    ][29811] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-18 21:46:48,838 [salt.loaded.int.module.cmdmod][INFO    ][29811] Executing command 'gluster --version' in directory '/root'
2017-09-18 21:46:48,846 [salt.loaded.int.module.cmdmod][INFO    ][29811] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-18 21:46:48,912 [salt.loaded.int.module.cmdmod][INFO    ][29811] Executing command 'gluster --version' in directory '/root'
2017-09-18 21:46:48,920 [salt.loaded.int.module.cmdmod][INFO    ][29811] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-18 21:46:48,966 [salt.state       ][INFO    ][29811] {'new': {'10.167.4.141': [], 'kvm02.baremetal-mcp-ocata-ovs-ha.local': ['10.167.4.142']}, 'old': {'10.167.4.141': [], 'kvm02.baremetal-mcp-ocata-ovs-ha.local': []}}
2017-09-18 21:46:48,967 [salt.state       ][INFO    ][29811] Completed state [10.167.4.142] at time 21:46:48.966547 duration_in_ms=246.062
2017-09-18 21:46:48,969 [salt.state       ][INFO    ][29811] Running state [10.167.4.143] at time 21:46:48.968751
2017-09-18 21:46:48,969 [salt.state       ][INFO    ][29811] Executing state glusterfs.peered for 10.167.4.143
2017-09-18 21:46:48,969 [salt.loaded.int.module.cmdmod][INFO    ][29811] Executing command 'gluster --version' in directory '/root'
2017-09-18 21:46:48,977 [salt.loaded.int.module.cmdmod][INFO    ][29811] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-18 21:46:49,023 [salt.loaded.int.module.cmdmod][INFO    ][29811] Executing command 'gluster --version' in directory '/root'
2017-09-18 21:46:49,032 [salt.loaded.int.module.cmdmod][INFO    ][29811] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-18 21:46:49,081 [salt.loaded.int.module.cmdmod][INFO    ][29811] Executing command 'gluster --version' in directory '/root'
2017-09-18 21:46:49,090 [salt.loaded.int.module.cmdmod][INFO    ][29811] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-18 21:46:49,140 [salt.loaded.int.module.cmdmod][INFO    ][29811] Executing command 'gluster --version' in directory '/root'
2017-09-18 21:46:49,148 [salt.loaded.int.module.cmdmod][INFO    ][29811] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-18 21:46:49,195 [salt.state       ][INFO    ][29811] Peering with localhost is not needed
2017-09-18 21:46:49,196 [salt.state       ][INFO    ][29811] Completed state [10.167.4.143] at time 21:46:49.195548 duration_in_ms=226.797
2017-09-18 21:46:49,196 [salt.state       ][INFO    ][29811] Running state [glance] at time 21:46:49.196412
2017-09-18 21:46:49,197 [salt.state       ][INFO    ][29811] Executing state glusterfs.created for glance
2017-09-18 21:46:49,197 [salt.loaded.int.module.cmdmod][INFO    ][29811] Executing command 'gluster --version' in directory '/root'
2017-09-18 21:46:49,206 [salt.loaded.int.module.cmdmod][INFO    ][29811] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-18 21:46:49,253 [salt.loaded.int.module.cmdmod][INFO    ][29811] Executing command 'gluster --version' in directory '/root'
2017-09-18 21:46:49,261 [salt.loaded.int.module.cmdmod][INFO    ][29811] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-18 21:46:49,312 [salt.state       ][INFO    ][29811] Volume glance already exists and is started.
2017-09-18 21:46:49,313 [salt.state       ][INFO    ][29811] Completed state [glance] at time 21:46:49.312658 duration_in_ms=116.245
2017-09-18 21:46:49,315 [salt.state       ][INFO    ][29811] Running state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 21:46:49.315368
2017-09-18 21:46:49,316 [salt.state       ][INFO    ][29811] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'
2017-09-18 21:46:49,316 [salt.loaded.int.module.cmdmod][INFO    ][29811] Executing command 'gluster volume info 'glance' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-09-18 21:46:49,364 [salt.state       ][INFO    ][29811] unless execution succeeded
2017-09-18 21:46:49,364 [salt.state       ][INFO    ][29811] Completed state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 21:46:49.364214 duration_in_ms=48.845
2017-09-18 21:46:49,365 [salt.state       ][INFO    ][29811] Running state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 21:46:49.364639
2017-09-18 21:46:49,365 [salt.state       ][INFO    ][29811] Executing state cmd.run for gluster volume set 'glance' 'network.remote-dio' 'True'
2017-09-18 21:46:49,365 [salt.loaded.int.module.cmdmod][INFO    ][29811] Executing command 'gluster volume info 'glance' | grep 'network.remote-dio: True'' in directory '/root'
2017-09-18 21:46:49,413 [salt.state       ][INFO    ][29811] unless execution succeeded
2017-09-18 21:46:49,413 [salt.state       ][INFO    ][29811] Completed state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 21:46:49.413055 duration_in_ms=48.416
2017-09-18 21:46:49,414 [salt.state       ][INFO    ][29811] Running state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 21:46:49.413518
2017-09-18 21:46:49,414 [salt.state       ][INFO    ][29811] Executing state cmd.run for gluster volume set 'glance' 'nfs.disable' 'True'
2017-09-18 21:46:49,414 [salt.loaded.int.module.cmdmod][INFO    ][29811] Executing command 'gluster volume info 'glance' | grep 'nfs.disable: True'' in directory '/root'
2017-09-18 21:46:49,466 [salt.state       ][INFO    ][29811] unless execution succeeded
2017-09-18 21:46:49,466 [salt.state       ][INFO    ][29811] Completed state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 21:46:49.465792 duration_in_ms=52.274
2017-09-18 21:46:49,466 [salt.state       ][INFO    ][29811] Running state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 21:46:49.466219
2017-09-18 21:46:49,466 [salt.state       ][INFO    ][29811] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'
2017-09-18 21:46:49,467 [salt.loaded.int.module.cmdmod][INFO    ][29811] Executing command 'gluster volume info 'glance' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-09-18 21:46:49,514 [salt.state       ][INFO    ][29811] unless execution succeeded
2017-09-18 21:46:49,515 [salt.state       ][INFO    ][29811] Completed state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 21:46:49.514499 duration_in_ms=48.28
2017-09-18 21:46:49,515 [salt.state       ][INFO    ][29811] Running state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 21:46:49.514908
2017-09-18 21:46:49,515 [salt.state       ][INFO    ][29811] Executing state cmd.run for gluster volume set 'glance' 'cluster.readdir-optimize' 'True'
2017-09-18 21:46:49,516 [salt.loaded.int.module.cmdmod][INFO    ][29811] Executing command 'gluster volume info 'glance' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-09-18 21:46:49,562 [salt.state       ][INFO    ][29811] unless execution succeeded
2017-09-18 21:46:49,562 [salt.state       ][INFO    ][29811] Completed state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 21:46:49.561936 duration_in_ms=47.027
2017-09-18 21:46:49,563 [salt.state       ][INFO    ][29811] Running state [glance] at time 21:46:49.562825
2017-09-18 21:46:49,563 [salt.state       ][INFO    ][29811] Executing state glusterfs.started for glance
2017-09-18 21:46:49,563 [salt.loaded.int.module.cmdmod][INFO    ][29811] Executing command 'gluster --version' in directory '/root'
2017-09-18 21:46:49,570 [salt.loaded.int.module.cmdmod][INFO    ][29811] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-18 21:46:49,617 [salt.loaded.int.module.cmdmod][INFO    ][29811] Executing command 'gluster --version' in directory '/root'
2017-09-18 21:46:49,625 [salt.loaded.int.module.cmdmod][INFO    ][29811] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-18 21:46:49,676 [salt.state       ][INFO    ][29811] Volume glance is already started
2017-09-18 21:46:49,677 [salt.state       ][INFO    ][29811] Completed state [glance] at time 21:46:49.676512 duration_in_ms=113.686
2017-09-18 21:46:49,677 [salt.state       ][INFO    ][29811] Running state [keystone-keys] at time 21:46:49.677327
2017-09-18 21:46:49,678 [salt.state       ][INFO    ][29811] Executing state glusterfs.created for keystone-keys
2017-09-18 21:46:49,678 [salt.loaded.int.module.cmdmod][INFO    ][29811] Executing command 'gluster --version' in directory '/root'
2017-09-18 21:46:49,687 [salt.loaded.int.module.cmdmod][INFO    ][29811] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-18 21:46:49,734 [salt.loaded.int.module.cmdmod][INFO    ][29811] Executing command 'gluster --version' in directory '/root'
2017-09-18 21:46:49,743 [salt.loaded.int.module.cmdmod][INFO    ][29811] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-18 21:46:49,797 [salt.state       ][INFO    ][29811] Volume keystone-keys already exists and is started.
2017-09-18 21:46:49,797 [salt.state       ][INFO    ][29811] Completed state [keystone-keys] at time 21:46:49.797200 duration_in_ms=119.871
2017-09-18 21:46:49,800 [salt.state       ][INFO    ][29811] Running state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 21:46:49.799949
2017-09-18 21:46:49,800 [salt.state       ][INFO    ][29811] Executing state cmd.run for gluster volume set 'keystone-keys' 'network.remote-dio' 'True'
2017-09-18 21:46:49,801 [salt.loaded.int.module.cmdmod][INFO    ][29811] Executing command 'gluster volume info 'keystone-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-09-18 21:46:49,849 [salt.state       ][INFO    ][29811] unless execution succeeded
2017-09-18 21:46:49,849 [salt.state       ][INFO    ][29811] Completed state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 21:46:49.849316 duration_in_ms=49.366
2017-09-18 21:46:49,850 [salt.state       ][INFO    ][29811] Running state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 21:46:49.849808
2017-09-18 21:46:49,850 [salt.state       ][INFO    ][29811] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-09-18 21:46:49,850 [salt.loaded.int.module.cmdmod][INFO    ][29811] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-09-18 21:46:49,899 [salt.state       ][INFO    ][29811] unless execution succeeded
2017-09-18 21:46:49,899 [salt.state       ][INFO    ][29811] Completed state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 21:46:49.899273 duration_in_ms=49.464
2017-09-18 21:46:49,900 [salt.state       ][INFO    ][29811] Running state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 21:46:49.899715
2017-09-18 21:46:49,900 [salt.state       ][INFO    ][29811] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'
2017-09-18 21:46:49,900 [salt.loaded.int.module.cmdmod][INFO    ][29811] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-09-18 21:46:49,949 [salt.state       ][INFO    ][29811] unless execution succeeded
2017-09-18 21:46:49,949 [salt.state       ][INFO    ][29811] Completed state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 21:46:49.949134 duration_in_ms=49.417
2017-09-18 21:46:49,950 [salt.state       ][INFO    ][29811] Running state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 21:46:49.949587
2017-09-18 21:46:49,950 [salt.state       ][INFO    ][29811] Executing state cmd.run for gluster volume set 'keystone-keys' 'nfs.disable' 'True'
2017-09-18 21:46:49,950 [salt.loaded.int.module.cmdmod][INFO    ][29811] Executing command 'gluster volume info 'keystone-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-09-18 21:46:50,001 [salt.state       ][INFO    ][29811] unless execution succeeded
2017-09-18 21:46:50,001 [salt.state       ][INFO    ][29811] Completed state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 21:46:50.000750 duration_in_ms=51.163
2017-09-18 21:46:50,001 [salt.state       ][INFO    ][29811] Running state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 21:46:50.001183
2017-09-18 21:46:50,001 [salt.state       ][INFO    ][29811] Executing state cmd.run for gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'
2017-09-18 21:46:50,002 [salt.loaded.int.module.cmdmod][INFO    ][29811] Executing command 'gluster volume info 'keystone-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-09-18 21:46:50,050 [salt.state       ][INFO    ][29811] unless execution succeeded
2017-09-18 21:46:50,050 [salt.state       ][INFO    ][29811] Completed state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 21:46:50.049878 duration_in_ms=48.695
2017-09-18 21:46:50,051 [salt.state       ][INFO    ][29811] Running state [keystone-keys] at time 21:46:50.050817
2017-09-18 21:46:50,051 [salt.state       ][INFO    ][29811] Executing state glusterfs.started for keystone-keys
2017-09-18 21:46:50,051 [salt.loaded.int.module.cmdmod][INFO    ][29811] Executing command 'gluster --version' in directory '/root'
2017-09-18 21:46:50,059 [salt.loaded.int.module.cmdmod][INFO    ][29811] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-18 21:46:50,106 [salt.loaded.int.module.cmdmod][INFO    ][29811] Executing command 'gluster --version' in directory '/root'
2017-09-18 21:46:50,114 [salt.loaded.int.module.cmdmod][INFO    ][29811] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-18 21:46:50,165 [salt.state       ][INFO    ][29811] Volume keystone-keys is already started
2017-09-18 21:46:50,166 [salt.state       ][INFO    ][29811] Completed state [keystone-keys] at time 21:46:50.165616 duration_in_ms=114.798
2017-09-18 21:46:50,166 [salt.state       ][INFO    ][29811] Running state [nova_instances] at time 21:46:50.166394
2017-09-18 21:46:50,167 [salt.state       ][INFO    ][29811] Executing state glusterfs.created for nova_instances
2017-09-18 21:46:50,167 [salt.loaded.int.module.cmdmod][INFO    ][29811] Executing command 'gluster --version' in directory '/root'
2017-09-18 21:46:50,174 [salt.loaded.int.module.cmdmod][INFO    ][29811] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-18 21:46:50,221 [salt.loaded.int.module.cmdmod][INFO    ][29811] Executing command 'gluster --version' in directory '/root'
2017-09-18 21:46:50,229 [salt.loaded.int.module.cmdmod][INFO    ][29811] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-18 21:46:50,280 [salt.state       ][INFO    ][29811] Volume nova_instances already exists and is started.
2017-09-18 21:46:50,280 [salt.state       ][INFO    ][29811] Completed state [nova_instances] at time 21:46:50.280224 duration_in_ms=113.83
2017-09-18 21:46:50,283 [salt.state       ][INFO    ][29811] Running state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 21:46:50.283185
2017-09-18 21:46:50,283 [salt.state       ][INFO    ][29811] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'
2017-09-18 21:46:50,284 [salt.loaded.int.module.cmdmod][INFO    ][29811] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-09-18 21:46:50,334 [salt.state       ][INFO    ][29811] unless execution succeeded
2017-09-18 21:46:50,334 [salt.state       ][INFO    ][29811] Completed state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 21:46:50.333894 duration_in_ms=50.708
2017-09-18 21:46:50,334 [salt.state       ][INFO    ][29811] Running state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'True'] at time 21:46:50.334360
2017-09-18 21:46:50,335 [salt.state       ][INFO    ][29811] Executing state cmd.run for gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'True'
2017-09-18 21:46:50,335 [salt.loaded.int.module.cmdmod][INFO    ][29811] Executing command 'gluster volume info 'nova_instances' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-09-18 21:46:50,383 [salt.state       ][INFO    ][29811] unless execution succeeded
2017-09-18 21:46:50,383 [salt.state       ][INFO    ][29811] Completed state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'True'] at time 21:46:50.383207 duration_in_ms=48.847
2017-09-18 21:46:50,384 [salt.state       ][INFO    ][29811] Running state [gluster volume set 'nova_instances' 'network.remote-dio' 'True'] at time 21:46:50.383624
2017-09-18 21:46:50,384 [salt.state       ][INFO    ][29811] Executing state cmd.run for gluster volume set 'nova_instances' 'network.remote-dio' 'True'
2017-09-18 21:46:50,384 [salt.loaded.int.module.cmdmod][INFO    ][29811] Executing command 'gluster volume info 'nova_instances' | grep 'network.remote-dio: True'' in directory '/root'
2017-09-18 21:46:50,431 [salt.state       ][INFO    ][29811] unless execution succeeded
2017-09-18 21:46:50,432 [salt.state       ][INFO    ][29811] Completed state [gluster volume set 'nova_instances' 'network.remote-dio' 'True'] at time 21:46:50.431681 duration_in_ms=48.056
2017-09-18 21:46:50,432 [salt.state       ][INFO    ][29811] Running state [gluster volume set 'nova_instances' 'nfs.disable' 'True'] at time 21:46:50.432144
2017-09-18 21:46:50,432 [salt.state       ][INFO    ][29811] Executing state cmd.run for gluster volume set 'nova_instances' 'nfs.disable' 'True'
2017-09-18 21:46:50,433 [salt.loaded.int.module.cmdmod][INFO    ][29811] Executing command 'gluster volume info 'nova_instances' | grep 'nfs.disable: True'' in directory '/root'
2017-09-18 21:46:50,480 [salt.state       ][INFO    ][29811] unless execution succeeded
2017-09-18 21:46:50,481 [salt.state       ][INFO    ][29811] Completed state [gluster volume set 'nova_instances' 'nfs.disable' 'True'] at time 21:46:50.480645 duration_in_ms=48.5
2017-09-18 21:46:50,481 [salt.state       ][INFO    ][29811] Running state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 21:46:50.481103
2017-09-18 21:46:50,481 [salt.state       ][INFO    ][29811] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'
2017-09-18 21:46:50,482 [salt.loaded.int.module.cmdmod][INFO    ][29811] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-09-18 21:46:50,532 [salt.state       ][INFO    ][29811] unless execution succeeded
2017-09-18 21:46:50,532 [salt.state       ][INFO    ][29811] Completed state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 21:46:50.532048 duration_in_ms=50.944
2017-09-18 21:46:50,533 [salt.state       ][INFO    ][29811] Running state [nova_instances] at time 21:46:50.532968
2017-09-18 21:46:50,533 [salt.state       ][INFO    ][29811] Executing state glusterfs.started for nova_instances
2017-09-18 21:46:50,534 [salt.loaded.int.module.cmdmod][INFO    ][29811] Executing command 'gluster --version' in directory '/root'
2017-09-18 21:46:50,541 [salt.loaded.int.module.cmdmod][INFO    ][29811] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-18 21:46:50,590 [salt.loaded.int.module.cmdmod][INFO    ][29811] Executing command 'gluster --version' in directory '/root'
2017-09-18 21:46:50,597 [salt.loaded.int.module.cmdmod][INFO    ][29811] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-18 21:46:50,649 [salt.state       ][INFO    ][29811] Volume nova_instances is already started
2017-09-18 21:46:50,650 [salt.state       ][INFO    ][29811] Completed state [nova_instances] at time 21:46:50.649597 duration_in_ms=116.628
2017-09-18 21:46:50,650 [salt.state       ][INFO    ][29811] Running state [keystone-credential-keys] at time 21:46:50.650459
2017-09-18 21:46:50,651 [salt.state       ][INFO    ][29811] Executing state glusterfs.created for keystone-credential-keys
2017-09-18 21:46:50,651 [salt.loaded.int.module.cmdmod][INFO    ][29811] Executing command 'gluster --version' in directory '/root'
2017-09-18 21:46:50,659 [salt.loaded.int.module.cmdmod][INFO    ][29811] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-18 21:46:50,706 [salt.loaded.int.module.cmdmod][INFO    ][29811] Executing command 'gluster --version' in directory '/root'
2017-09-18 21:46:50,715 [salt.loaded.int.module.cmdmod][INFO    ][29811] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-18 21:46:50,766 [salt.state       ][INFO    ][29811] Volume keystone-credential-keys already exists and is started.
2017-09-18 21:46:50,766 [salt.state       ][INFO    ][29811] Completed state [keystone-credential-keys] at time 21:46:50.766123 duration_in_ms=115.664
2017-09-18 21:46:50,769 [salt.state       ][INFO    ][29811] Running state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 21:46:50.769208
2017-09-18 21:46:50,769 [salt.state       ][INFO    ][29811] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'
2017-09-18 21:46:50,770 [salt.loaded.int.module.cmdmod][INFO    ][29811] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-09-18 21:46:50,817 [salt.state       ][INFO    ][29811] unless execution succeeded
2017-09-18 21:46:50,817 [salt.state       ][INFO    ][29811] Completed state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 21:46:50.817140 duration_in_ms=47.932
2017-09-18 21:46:50,819 [salt.state       ][INFO    ][29811] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 21:46:50.818702
2017-09-18 21:46:50,820 [salt.state       ][INFO    ][29811] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-09-18 21:46:50,821 [salt.loaded.int.module.cmdmod][INFO    ][29811] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-09-18 21:46:50,868 [salt.state       ][INFO    ][29811] unless execution succeeded
2017-09-18 21:46:50,869 [salt.state       ][INFO    ][29811] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 21:46:50.868464 duration_in_ms=49.765
2017-09-18 21:46:50,869 [salt.state       ][INFO    ][29811] Running state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 21:46:50.869088
2017-09-18 21:46:50,869 [salt.state       ][INFO    ][29811] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'
2017-09-18 21:46:50,870 [salt.loaded.int.module.cmdmod][INFO    ][29811] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-09-18 21:46:50,916 [salt.state       ][INFO    ][29811] unless execution succeeded
2017-09-18 21:46:50,916 [salt.state       ][INFO    ][29811] Completed state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 21:46:50.916383 duration_in_ms=47.293
2017-09-18 21:46:50,917 [salt.state       ][INFO    ][29811] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 21:46:50.916893
2017-09-18 21:46:50,917 [salt.state       ][INFO    ][29811] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'
2017-09-18 21:46:50,918 [salt.loaded.int.module.cmdmod][INFO    ][29811] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-09-18 21:46:50,967 [salt.state       ][INFO    ][29811] unless execution succeeded
2017-09-18 21:46:50,967 [salt.state       ][INFO    ][29811] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 21:46:50.966759 duration_in_ms=49.865
2017-09-18 21:46:50,967 [salt.state       ][INFO    ][29811] Running state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 21:46:50.967239
2017-09-18 21:46:50,967 [salt.state       ][INFO    ][29811] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'
2017-09-18 21:46:50,968 [salt.loaded.int.module.cmdmod][INFO    ][29811] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-09-18 21:46:51,017 [salt.state       ][INFO    ][29811] unless execution succeeded
2017-09-18 21:46:51,017 [salt.state       ][INFO    ][29811] Completed state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 21:46:51.017014 duration_in_ms=49.775
2017-09-18 21:46:51,018 [salt.state       ][INFO    ][29811] Running state [keystone-credential-keys] at time 21:46:51.018077
2017-09-18 21:46:51,018 [salt.state       ][INFO    ][29811] Executing state glusterfs.started for keystone-credential-keys
2017-09-18 21:46:51,019 [salt.loaded.int.module.cmdmod][INFO    ][29811] Executing command 'gluster --version' in directory '/root'
2017-09-18 21:46:51,027 [salt.loaded.int.module.cmdmod][INFO    ][29811] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-18 21:46:51,077 [salt.loaded.int.module.cmdmod][INFO    ][29811] Executing command 'gluster --version' in directory '/root'
2017-09-18 21:46:51,085 [salt.loaded.int.module.cmdmod][INFO    ][29811] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-18 21:46:51,135 [salt.state       ][INFO    ][29811] Volume keystone-credential-keys is already started
2017-09-18 21:46:51,135 [salt.state       ][INFO    ][29811] Completed state [keystone-credential-keys] at time 21:46:51.135266 duration_in_ms=117.189
2017-09-18 21:46:51,138 [salt.minion      ][INFO    ][29811] Returning information for job: 20170918214646257780
2017-09-18 21:46:56,042 [salt.minion      ][INFO    ][22749] User sudo_ubuntu Executing command test.ping with jid 20170918214656035742
2017-09-18 21:46:56,057 [salt.minion      ][INFO    ][30235] Starting a new job with PID 30235
2017-09-18 21:46:56,084 [salt.minion      ][INFO    ][30235] Returning information for job: 20170918214656035742
2017-09-18 21:46:56,454 [salt.minion      ][INFO    ][22749] User sudo_ubuntu Executing command cmd.run with jid 20170918214656442823
2017-09-18 21:46:56,466 [salt.minion      ][INFO    ][30240] Starting a new job with PID 30240
2017-09-18 21:46:56,471 [salt.loaded.int.module.cmdmod][INFO    ][30240] Executing command 'gluster peer status; gluster volume status' in directory '/root'
2017-09-18 21:46:56,581 [salt.minion      ][INFO    ][30240] Returning information for job: 20170918214656442823
2017-09-18 22:28:36,035 [salt.utils.schedule][INFO    ][22749] Running scheduled job: __mine_interval
2017-09-18 23:11:35,133 [salt.minion      ][INFO    ][22749] User sudo_ubuntu Executing command cp.push_dir with jid 20170918231135116596
2017-09-18 23:11:35,149 [salt.minion      ][INFO    ][31242] Starting a new job with PID 31242
