2017-09-15 08:47:22,338 [salt.cli.daemons ][WARNING ][2529] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-09-15 08:47:25,055 [salt.state       ][ERROR   ][2861] No contents found in top file
2017-09-15 08:47:40,929 [salt.utils.parsers][WARNING ][2529] Minion received a SIGTERM. Exiting.
2017-09-15 08:50:05,825 [salt.cli.daemons ][WARNING ][3228] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-09-15 08:55:25,047 [py.warnings      ][WARNING ][16417] /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-15 08:58:07,342 [salt.loaded.int.module.cmdmod][ERROR   ][16417] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-09-15 08:58:07,343 [salt.loaded.int.module.cmdmod][ERROR   ][16417] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-09-15 08:58:13,808 [salt.loaded.int.module.cmdmod][ERROR   ][16417] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-09-15 08:58:13,808 [salt.loaded.int.module.cmdmod][ERROR   ][16417] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-09-15 08:58:21,665 [salt.loaded.int.module.cmdmod][ERROR   ][16417] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-09-15 08:58:21,665 [salt.loaded.int.module.cmdmod][ERROR   ][16417] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-09-15 08:58:30,691 [salt.loaded.int.module.cmdmod][ERROR   ][16417] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-09-15 08:58:30,692 [salt.loaded.int.module.cmdmod][ERROR   ][16417] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-09-15 08:58:39,575 [salt.loaded.int.module.cmdmod][ERROR   ][16417] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-09-15 08:58:39,575 [salt.loaded.int.module.cmdmod][ERROR   ][16417] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-09-15 08:58:45,715 [salt.loaded.int.module.cmdmod][ERROR   ][16417] 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-15 08:58:47,822 [salt.loaded.int.module.cmdmod][INFO    ][24083] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2017-09-15 08:58:47,828 [salt.loaded.int.module.cmdmod][INFO    ][24083] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2017-09-15 08:58:47,836 [salt.loaded.int.module.cmdmod][INFO    ][24083] Executing command ['systemd-run', '--scope', 'systemctl', 'restart', 'salt-minion.service'] in directory '/root'
2017-09-15 08:58:47,842 [salt.utils.parsers][WARNING ][3228] Minion received a SIGTERM. Exiting.
2017-09-15 08:58:48,103 [salt.cli.daemons ][INFO    ][24160] Setting up the Salt Minion "kvm02.baremetal-mcp-ocata-ovs-dpdk-ha.local"
2017-09-15 08:58:48,600 [salt.minion      ][INFO    ][24160] Creating minion process manager
2017-09-15 08:58:48,623 [salt.cli.daemons ][WARNING ][24160] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-09-15 08:58:48,623 [salt.cli.daemons ][INFO    ][24160] The Salt Minion is starting up
2017-09-15 08:58:48,623 [salt.minion      ][INFO    ][24160] Minion is starting as user 'root'
2017-09-15 08:58:48,624 [salt.utils.event ][INFO    ][24160] Starting pull socket on /var/run/salt/minion/minion_event_0031115955_pull.ipc
2017-09-15 08:58:49,475 [salt.loaded.int.module.cmdmod][INFO    ][24160] Executing command ['date', '+%z'] in directory '/root'
2017-09-15 08:58:49,483 [salt.utils.schedule][INFO    ][24160] Updating job settings for scheduled job: __mine_interval
2017-09-15 08:58:49,485 [salt.minion      ][INFO    ][24160] Added mine.update to scheduler
2017-09-15 08:58:49,625 [salt.minion      ][INFO    ][24160] Minion is ready to receive requests!
2017-09-15 08:58:49,626 [salt.minion      ][INFO    ][24160] User sudo_ubuntu Executing command saltutil.sync_all with jid 20170915085849179505
2017-09-15 08:58:49,638 [salt.minion      ][INFO    ][24252] Starting a new job with PID 24252
2017-09-15 08:58:50,627 [salt.utils.schedule][INFO    ][24160] Running scheduled job: __mine_interval
2017-09-15 08:58:51,110 [salt.state       ][INFO    ][24252] Loading fresh modules for state activity
2017-09-15 08:58:51,134 [salt.state       ][ERROR   ][24252] No contents found in top file
2017-09-15 08:58:51,135 [salt.utils.extmods][INFO    ][24252] Creating module dir '/var/cache/salt/minion/extmods/beacons'
2017-09-15 08:58:51,137 [salt.utils.extmods][INFO    ][24252] Syncing beacons for environment 'base'
2017-09-15 08:58:51,137 [salt.utils.extmods][INFO    ][24252] Loading cache from salt://_beacons, for base)
2017-09-15 08:58:51,138 [salt.fileclient  ][INFO    ][24252] Caching directory '_beacons/' for environment 'base'
2017-09-15 08:58:51,170 [salt.utils.extmods][INFO    ][24252] Syncing modules for environment 'base'
2017-09-15 08:58:51,170 [salt.utils.extmods][INFO    ][24252] Loading cache from salt://_modules, for base)
2017-09-15 08:58:51,170 [salt.fileclient  ][INFO    ][24252] Caching directory '_modules/' for environment 'base'
2017-09-15 08:58:51,214 [salt.fileclient  ][INFO    ][24252] Fetching file from saltenv 'base', ** done ** '_modules/ceph_ng.py'
2017-09-15 08:58:51,227 [salt.fileclient  ][INFO    ][24252] Fetching file from saltenv 'base', ** done ** '_modules/cinderng.py'
2017-09-15 08:58:51,239 [salt.fileclient  ][INFO    ][24252] Fetching file from saltenv 'base', ** done ** '_modules/contrail.py'
2017-09-15 08:58:51,251 [salt.fileclient  ][INFO    ][24252] Fetching file from saltenv 'base', ** done ** '_modules/creds.py'
2017-09-15 08:58:51,261 [salt.fileclient  ][INFO    ][24252] Fetching file from saltenv 'base', ** done ** '_modules/devops_utils.py'
2017-09-15 08:58:51,269 [salt.fileclient  ][INFO    ][24252] Fetching file from saltenv 'base', ** done ** '_modules/encode_json.py'
2017-09-15 08:58:51,280 [salt.fileclient  ][INFO    ][24252] Fetching file from saltenv 'base', ** done ** '_modules/gerrit.py'
2017-09-15 08:58:51,290 [salt.fileclient  ][INFO    ][24252] Fetching file from saltenv 'base', ** done ** '_modules/glanceng.py'
2017-09-15 08:58:51,352 [salt.fileclient  ][INFO    ][24252] Fetching file from saltenv 'base', ** done ** '_modules/heat.py'
2017-09-15 08:58:51,376 [salt.fileclient  ][INFO    ][24252] Fetching file from saltenv 'base', ** done ** '_modules/heka_alarming.py'
2017-09-15 08:58:51,385 [salt.fileclient  ][INFO    ][24252] Fetching file from saltenv 'base', ** done ** '_modules/helm.py'
2017-09-15 08:58:51,394 [salt.fileclient  ][INFO    ][24252] Fetching file from saltenv 'base', ** done ** '_modules/jenkins_common.py'
2017-09-15 08:58:51,406 [salt.fileclient  ][INFO    ][24252] Fetching file from saltenv 'base', ** done ** '_modules/keystone_policy.py'
2017-09-15 08:58:51,415 [salt.fileclient  ][INFO    ][24252] Fetching file from saltenv 'base', ** done ** '_modules/linux_hosts.py'
2017-09-15 08:58:51,468 [salt.fileclient  ][INFO    ][24252] Fetching file from saltenv 'base', ** done ** '_modules/linux_netlink.py'
2017-09-15 08:58:51,480 [salt.fileclient  ][INFO    ][24252] Fetching file from saltenv 'base', ** done ** '_modules/maas.py'
2017-09-15 08:58:51,494 [salt.fileclient  ][INFO    ][24252] Fetching file from saltenv 'base', ** done ** '_modules/maas_client.py'
2017-09-15 08:58:51,509 [salt.fileclient  ][INFO    ][24252] Fetching file from saltenv 'base', ** done ** '_modules/multipart.py'
2017-09-15 08:58:51,518 [salt.fileclient  ][INFO    ][24252] Fetching file from saltenv 'base', ** done ** '_modules/nagios_alarming.py'
2017-09-15 08:58:51,549 [salt.fileclient  ][INFO    ][24252] Fetching file from saltenv 'base', ** done ** '_modules/neutronng.py'
2017-09-15 08:58:51,564 [salt.fileclient  ][INFO    ][24252] Fetching file from saltenv 'base', ** done ** '_modules/novang.py'
2017-09-15 08:58:51,609 [salt.fileclient  ][INFO    ][24252] Fetching file from saltenv 'base', ** done ** '_modules/reclass.py'
2017-09-15 08:58:51,620 [salt.fileclient  ][INFO    ][24252] Fetching file from saltenv 'base', ** done ** '_modules/rsyslog_util.py'
2017-09-15 08:58:51,658 [salt.fileclient  ][INFO    ][24252] Fetching file from saltenv 'base', ** done ** '_modules/rundeck.py'
2017-09-15 08:58:51,673 [salt.fileclient  ][INFO    ][24252] Fetching file from saltenv 'base', ** done ** '_modules/saltkey.py'
2017-09-15 08:58:51,687 [salt.fileclient  ][INFO    ][24252] Fetching file from saltenv 'base', ** done ** '_modules/saltresource.py'
2017-09-15 08:58:51,731 [salt.fileclient  ][INFO    ][24252] Fetching file from saltenv 'base', ** done ** '_modules/seedng.py'
2017-09-15 08:58:51,748 [salt.fileclient  ][INFO    ][24252] Fetching file from saltenv 'base', ** done ** '_modules/testing/credentials.py'
2017-09-15 08:58:51,783 [salt.fileclient  ][INFO    ][24252] Fetching file from saltenv 'base', ** done ** '_modules/testing/django.py'
2017-09-15 08:58:51,797 [salt.fileclient  ][INFO    ][24252] Fetching file from saltenv 'base', ** done ** '_modules/testing/django_client_proxy.py'
2017-09-15 08:58:51,809 [salt.fileclient  ][INFO    ][24252] Fetching file from saltenv 'base', ** done ** '_modules/utils.py'
2017-09-15 08:58:51,819 [salt.fileclient  ][INFO    ][24252] Fetching file from saltenv 'base', ** done ** '_modules/virtng.py'
2017-09-15 08:58:51,822 [salt.utils.extmods][INFO    ][24252] Copying '/var/cache/salt/minion/files/base/_modules/__init__.py' to '/var/cache/salt/minion/extmods/modules/__init__.py'
2017-09-15 08:58:51,852 [salt.utils.extmods][INFO    ][24252] Copying '/var/cache/salt/minion/files/base/_modules/ceph_ng.py' to '/var/cache/salt/minion/extmods/modules/ceph_ng.py'
2017-09-15 08:58:51,852 [salt.utils.extmods][INFO    ][24252] Copying '/var/cache/salt/minion/files/base/_modules/cinderng.py' to '/var/cache/salt/minion/extmods/modules/cinderng.py'
2017-09-15 08:58:51,853 [salt.utils.extmods][INFO    ][24252] Copying '/var/cache/salt/minion/files/base/_modules/contrail.py' to '/var/cache/salt/minion/extmods/modules/contrail.py'
2017-09-15 08:58:51,853 [salt.utils.extmods][INFO    ][24252] Copying '/var/cache/salt/minion/files/base/_modules/creds.py' to '/var/cache/salt/minion/extmods/modules/creds.py'
2017-09-15 08:58:51,853 [salt.utils.extmods][INFO    ][24252] Copying '/var/cache/salt/minion/files/base/_modules/devops_utils.py' to '/var/cache/salt/minion/extmods/modules/devops_utils.py'
2017-09-15 08:58:51,853 [salt.utils.extmods][INFO    ][24252] Copying '/var/cache/salt/minion/files/base/_modules/encode_json.py' to '/var/cache/salt/minion/extmods/modules/encode_json.py'
2017-09-15 08:58:51,854 [salt.utils.extmods][INFO    ][24252] Copying '/var/cache/salt/minion/files/base/_modules/gerrit.py' to '/var/cache/salt/minion/extmods/modules/gerrit.py'
2017-09-15 08:58:51,854 [salt.utils.extmods][INFO    ][24252] Copying '/var/cache/salt/minion/files/base/_modules/glanceng.py' to '/var/cache/salt/minion/extmods/modules/glanceng.py'
2017-09-15 08:58:51,854 [salt.utils.extmods][INFO    ][24252] Copying '/var/cache/salt/minion/files/base/_modules/heat.py' to '/var/cache/salt/minion/extmods/modules/heat.py'
2017-09-15 08:58:51,855 [salt.utils.extmods][INFO    ][24252] Copying '/var/cache/salt/minion/files/base/_modules/heka_alarming.py' to '/var/cache/salt/minion/extmods/modules/heka_alarming.py'
2017-09-15 08:58:51,855 [salt.utils.extmods][INFO    ][24252] Copying '/var/cache/salt/minion/files/base/_modules/helm.py' to '/var/cache/salt/minion/extmods/modules/helm.py'
2017-09-15 08:58:51,855 [salt.utils.extmods][INFO    ][24252] Copying '/var/cache/salt/minion/files/base/_modules/jenkins_common.py' to '/var/cache/salt/minion/extmods/modules/jenkins_common.py'
2017-09-15 08:58:51,855 [salt.utils.extmods][INFO    ][24252] Copying '/var/cache/salt/minion/files/base/_modules/keystone_policy.py' to '/var/cache/salt/minion/extmods/modules/keystone_policy.py'
2017-09-15 08:58:51,856 [salt.utils.extmods][INFO    ][24252] Copying '/var/cache/salt/minion/files/base/_modules/linux_hosts.py' to '/var/cache/salt/minion/extmods/modules/linux_hosts.py'
2017-09-15 08:58:51,856 [salt.utils.extmods][INFO    ][24252] Copying '/var/cache/salt/minion/files/base/_modules/linux_netlink.py' to '/var/cache/salt/minion/extmods/modules/linux_netlink.py'
2017-09-15 08:58:51,856 [salt.utils.extmods][INFO    ][24252] Copying '/var/cache/salt/minion/files/base/_modules/maas.py' to '/var/cache/salt/minion/extmods/modules/maas.py'
2017-09-15 08:58:51,856 [salt.utils.extmods][INFO    ][24252] Copying '/var/cache/salt/minion/files/base/_modules/maas_client.py' to '/var/cache/salt/minion/extmods/modules/maas_client.py'
2017-09-15 08:58:51,857 [salt.utils.extmods][INFO    ][24252] Copying '/var/cache/salt/minion/files/base/_modules/multipart.py' to '/var/cache/salt/minion/extmods/modules/multipart.py'
2017-09-15 08:58:51,857 [salt.utils.extmods][INFO    ][24252] Copying '/var/cache/salt/minion/files/base/_modules/nagios_alarming.py' to '/var/cache/salt/minion/extmods/modules/nagios_alarming.py'
2017-09-15 08:58:51,857 [salt.utils.extmods][INFO    ][24252] Copying '/var/cache/salt/minion/files/base/_modules/neutronng.py' to '/var/cache/salt/minion/extmods/modules/neutronng.py'
2017-09-15 08:58:51,857 [salt.utils.extmods][INFO    ][24252] Copying '/var/cache/salt/minion/files/base/_modules/novang.py' to '/var/cache/salt/minion/extmods/modules/novang.py'
2017-09-15 08:58:51,858 [salt.utils.extmods][INFO    ][24252] Copying '/var/cache/salt/minion/files/base/_modules/reclass.py' to '/var/cache/salt/minion/extmods/modules/reclass.py'
2017-09-15 08:58:51,858 [salt.utils.extmods][INFO    ][24252] Copying '/var/cache/salt/minion/files/base/_modules/rsyslog_util.py' to '/var/cache/salt/minion/extmods/modules/rsyslog_util.py'
2017-09-15 08:58:51,858 [salt.utils.extmods][INFO    ][24252] Copying '/var/cache/salt/minion/files/base/_modules/rundeck.py' to '/var/cache/salt/minion/extmods/modules/rundeck.py'
2017-09-15 08:58:51,859 [salt.utils.extmods][INFO    ][24252] Copying '/var/cache/salt/minion/files/base/_modules/saltkey.py' to '/var/cache/salt/minion/extmods/modules/saltkey.py'
2017-09-15 08:58:51,859 [salt.utils.extmods][INFO    ][24252] Copying '/var/cache/salt/minion/files/base/_modules/saltresource.py' to '/var/cache/salt/minion/extmods/modules/saltresource.py'
2017-09-15 08:58:51,859 [salt.utils.extmods][INFO    ][24252] Copying '/var/cache/salt/minion/files/base/_modules/seedng.py' to '/var/cache/salt/minion/extmods/modules/seedng.py'
2017-09-15 08:58:51,859 [salt.utils.extmods][INFO    ][24252] Copying '/var/cache/salt/minion/files/base/_modules/testing/__init__.py' to '/var/cache/salt/minion/extmods/modules/testing/__init__.py'
2017-09-15 08:58:51,860 [salt.utils.extmods][INFO    ][24252] Copying '/var/cache/salt/minion/files/base/_modules/testing/credentials.py' to '/var/cache/salt/minion/extmods/modules/testing/credentials.py'
2017-09-15 08:58:51,860 [salt.utils.extmods][INFO    ][24252] Copying '/var/cache/salt/minion/files/base/_modules/testing/django.py' to '/var/cache/salt/minion/extmods/modules/testing/django.py'
2017-09-15 08:58:51,860 [salt.utils.extmods][INFO    ][24252] 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-15 08:58:51,860 [salt.utils.extmods][INFO    ][24252] Copying '/var/cache/salt/minion/files/base/_modules/utils.py' to '/var/cache/salt/minion/extmods/modules/utils.py'
2017-09-15 08:58:51,861 [salt.utils.extmods][INFO    ][24252] Copying '/var/cache/salt/minion/files/base/_modules/virtng.py' to '/var/cache/salt/minion/extmods/modules/virtng.py'
2017-09-15 08:58:51,865 [salt.utils.extmods][INFO    ][24252] Syncing states for environment 'base'
2017-09-15 08:58:51,866 [salt.utils.extmods][INFO    ][24252] Loading cache from salt://_states, for base)
2017-09-15 08:58:51,866 [salt.fileclient  ][INFO    ][24252] Caching directory '_states/' for environment 'base'
2017-09-15 08:58:51,916 [salt.fileclient  ][INFO    ][24252] Fetching file from saltenv 'base', ** done ** '_states/cinderng.py'
2017-09-15 08:58:51,927 [salt.fileclient  ][INFO    ][24252] Fetching file from saltenv 'base', ** done ** '_states/contrail.py'
2017-09-15 08:58:51,938 [salt.fileclient  ][INFO    ][24252] Fetching file from saltenv 'base', ** done ** '_states/gerrit.py'
2017-09-15 08:58:51,949 [salt.fileclient  ][INFO    ][24252] Fetching file from saltenv 'base', ** done ** '_states/glanceng.py'
2017-09-15 08:58:51,959 [salt.fileclient  ][INFO    ][24252] Fetching file from saltenv 'base', ** done ** '_states/grafana3_dashboard.py'
2017-09-15 08:58:51,1000 [salt.fileclient  ][INFO    ][24252] Fetching file from saltenv 'base', ** done ** '_states/grafana3_datasource.py'
2017-09-15 08:58:52,010 [salt.fileclient  ][INFO    ][24252] Fetching file from saltenv 'base', ** done ** '_states/heat.py'
2017-09-15 08:58:52,047 [salt.fileclient  ][INFO    ][24252] Fetching file from saltenv 'base', ** done ** '_states/helm_release.py'
2017-09-15 08:58:52,059 [salt.fileclient  ][INFO    ][24252] Fetching file from saltenv 'base', ** done ** '_states/jenkins_approval.py'
2017-09-15 08:58:52,085 [salt.fileclient  ][INFO    ][24252] Fetching file from saltenv 'base', ** done ** '_states/jenkins_artifactory.py'
2017-09-15 08:58:52,097 [salt.fileclient  ][INFO    ][24252] Fetching file from saltenv 'base', ** done ** '_states/jenkins_credential.py'
2017-09-15 08:58:52,110 [salt.fileclient  ][INFO    ][24252] Fetching file from saltenv 'base', ** done ** '_states/jenkins_job.py'
2017-09-15 08:58:52,120 [salt.fileclient  ][INFO    ][24252] Fetching file from saltenv 'base', ** done ** '_states/jenkins_lib.py'
2017-09-15 08:58:52,129 [salt.fileclient  ][INFO    ][24252] Fetching file from saltenv 'base', ** done ** '_states/jenkins_node.py'
2017-09-15 08:58:52,168 [salt.fileclient  ][INFO    ][24252] Fetching file from saltenv 'base', ** done ** '_states/jenkins_plugin.py'
2017-09-15 08:58:52,187 [salt.fileclient  ][INFO    ][24252] Fetching file from saltenv 'base', ** done ** '_states/jenkins_security.py'
2017-09-15 08:58:52,198 [salt.fileclient  ][INFO    ][24252] Fetching file from saltenv 'base', ** done ** '_states/jenkins_slack.py'
2017-09-15 08:58:52,211 [salt.fileclient  ][INFO    ][24252] Fetching file from saltenv 'base', ** done ** '_states/jenkins_smtp.py'
2017-09-15 08:58:52,222 [salt.fileclient  ][INFO    ][24252] Fetching file from saltenv 'base', ** done ** '_states/jenkins_theme.py'
2017-09-15 08:58:52,234 [salt.fileclient  ][INFO    ][24252] Fetching file from saltenv 'base', ** done ** '_states/jenkins_user.py'
2017-09-15 08:58:52,247 [salt.fileclient  ][INFO    ][24252] Fetching file from saltenv 'base', ** done ** '_states/jenkins_view.py'
2017-09-15 08:58:52,257 [salt.fileclient  ][INFO    ][24252] Fetching file from saltenv 'base', ** done ** '_states/keystone_policy.py'
2017-09-15 08:58:52,302 [salt.fileclient  ][INFO    ][24252] Fetching file from saltenv 'base', ** done ** '_states/kibana_object.py'
2017-09-15 08:58:52,323 [salt.fileclient  ][INFO    ][24252] Fetching file from saltenv 'base', ** done ** '_states/neutronng.py'
2017-09-15 08:58:52,334 [salt.fileclient  ][INFO    ][24252] Fetching file from saltenv 'base', ** done ** '_states/novang.py'
2017-09-15 08:58:52,343 [salt.fileclient  ][INFO    ][24252] Fetching file from saltenv 'base', ** done ** '_states/reclass.py'
2017-09-15 08:58:52,352 [salt.fileclient  ][INFO    ][24252] Fetching file from saltenv 'base', ** done ** '_states/rundeck_project.py'
2017-09-15 08:58:52,407 [salt.fileclient  ][INFO    ][24252] Fetching file from saltenv 'base', ** done ** '_states/rundeck_scm.py'
2017-09-15 08:58:52,432 [salt.fileclient  ][INFO    ][24252] Fetching file from saltenv 'base', ** done ** '_states/rundeck_secret.py'
2017-09-15 08:58:52,434 [salt.utils.extmods][INFO    ][24252] Copying '/var/cache/salt/minion/files/base/_states/cinderng.py' to '/var/cache/salt/minion/extmods/states/cinderng.py'
2017-09-15 08:58:52,434 [salt.utils.extmods][INFO    ][24252] Copying '/var/cache/salt/minion/files/base/_states/contrail.py' to '/var/cache/salt/minion/extmods/states/contrail.py'
2017-09-15 08:58:52,435 [salt.utils.extmods][INFO    ][24252] Copying '/var/cache/salt/minion/files/base/_states/gerrit.py' to '/var/cache/salt/minion/extmods/states/gerrit.py'
2017-09-15 08:58:52,435 [salt.utils.extmods][INFO    ][24252] Copying '/var/cache/salt/minion/files/base/_states/glanceng.py' to '/var/cache/salt/minion/extmods/states/glanceng.py'
2017-09-15 08:58:52,435 [salt.utils.extmods][INFO    ][24252] Copying '/var/cache/salt/minion/files/base/_states/grafana3_dashboard.py' to '/var/cache/salt/minion/extmods/states/grafana3_dashboard.py'
2017-09-15 08:58:52,436 [salt.utils.extmods][INFO    ][24252] Copying '/var/cache/salt/minion/files/base/_states/grafana3_datasource.py' to '/var/cache/salt/minion/extmods/states/grafana3_datasource.py'
2017-09-15 08:58:52,436 [salt.utils.extmods][INFO    ][24252] Copying '/var/cache/salt/minion/files/base/_states/heat.py' to '/var/cache/salt/minion/extmods/states/heat.py'
2017-09-15 08:58:52,436 [salt.utils.extmods][INFO    ][24252] Copying '/var/cache/salt/minion/files/base/_states/helm_release.py' to '/var/cache/salt/minion/extmods/states/helm_release.py'
2017-09-15 08:58:52,436 [salt.utils.extmods][INFO    ][24252] Copying '/var/cache/salt/minion/files/base/_states/jenkins_approval.py' to '/var/cache/salt/minion/extmods/states/jenkins_approval.py'
2017-09-15 08:58:52,437 [salt.utils.extmods][INFO    ][24252] Copying '/var/cache/salt/minion/files/base/_states/jenkins_artifactory.py' to '/var/cache/salt/minion/extmods/states/jenkins_artifactory.py'
2017-09-15 08:58:52,437 [salt.utils.extmods][INFO    ][24252] Copying '/var/cache/salt/minion/files/base/_states/jenkins_credential.py' to '/var/cache/salt/minion/extmods/states/jenkins_credential.py'
2017-09-15 08:58:52,437 [salt.utils.extmods][INFO    ][24252] Copying '/var/cache/salt/minion/files/base/_states/jenkins_job.py' to '/var/cache/salt/minion/extmods/states/jenkins_job.py'
2017-09-15 08:58:52,437 [salt.utils.extmods][INFO    ][24252] Copying '/var/cache/salt/minion/files/base/_states/jenkins_lib.py' to '/var/cache/salt/minion/extmods/states/jenkins_lib.py'
2017-09-15 08:58:52,438 [salt.utils.extmods][INFO    ][24252] Copying '/var/cache/salt/minion/files/base/_states/jenkins_node.py' to '/var/cache/salt/minion/extmods/states/jenkins_node.py'
2017-09-15 08:58:52,438 [salt.utils.extmods][INFO    ][24252] Copying '/var/cache/salt/minion/files/base/_states/jenkins_plugin.py' to '/var/cache/salt/minion/extmods/states/jenkins_plugin.py'
2017-09-15 08:58:52,438 [salt.utils.extmods][INFO    ][24252] Copying '/var/cache/salt/minion/files/base/_states/jenkins_security.py' to '/var/cache/salt/minion/extmods/states/jenkins_security.py'
2017-09-15 08:58:52,438 [salt.utils.extmods][INFO    ][24252] Copying '/var/cache/salt/minion/files/base/_states/jenkins_slack.py' to '/var/cache/salt/minion/extmods/states/jenkins_slack.py'
2017-09-15 08:58:52,439 [salt.utils.extmods][INFO    ][24252] Copying '/var/cache/salt/minion/files/base/_states/jenkins_smtp.py' to '/var/cache/salt/minion/extmods/states/jenkins_smtp.py'
2017-09-15 08:58:52,439 [salt.utils.extmods][INFO    ][24252] Copying '/var/cache/salt/minion/files/base/_states/jenkins_theme.py' to '/var/cache/salt/minion/extmods/states/jenkins_theme.py'
2017-09-15 08:58:52,439 [salt.utils.extmods][INFO    ][24252] Copying '/var/cache/salt/minion/files/base/_states/jenkins_user.py' to '/var/cache/salt/minion/extmods/states/jenkins_user.py'
2017-09-15 08:58:52,439 [salt.utils.extmods][INFO    ][24252] Copying '/var/cache/salt/minion/files/base/_states/jenkins_view.py' to '/var/cache/salt/minion/extmods/states/jenkins_view.py'
2017-09-15 08:58:52,440 [salt.utils.extmods][INFO    ][24252] Copying '/var/cache/salt/minion/files/base/_states/keystone_policy.py' to '/var/cache/salt/minion/extmods/states/keystone_policy.py'
2017-09-15 08:58:52,440 [salt.utils.extmods][INFO    ][24252] Copying '/var/cache/salt/minion/files/base/_states/kibana_object.py' to '/var/cache/salt/minion/extmods/states/kibana_object.py'
2017-09-15 08:58:52,440 [salt.utils.extmods][INFO    ][24252] Copying '/var/cache/salt/minion/files/base/_states/maas_cluster.py' to '/var/cache/salt/minion/extmods/states/maas_cluster.py'
2017-09-15 08:58:52,441 [salt.utils.extmods][INFO    ][24252] Copying '/var/cache/salt/minion/files/base/_states/neutronng.py' to '/var/cache/salt/minion/extmods/states/neutronng.py'
2017-09-15 08:58:52,441 [salt.utils.extmods][INFO    ][24252] Copying '/var/cache/salt/minion/files/base/_states/novang.py' to '/var/cache/salt/minion/extmods/states/novang.py'
2017-09-15 08:58:52,441 [salt.utils.extmods][INFO    ][24252] Copying '/var/cache/salt/minion/files/base/_states/reclass.py' to '/var/cache/salt/minion/extmods/states/reclass.py'
2017-09-15 08:58:52,442 [salt.utils.extmods][INFO    ][24252] Copying '/var/cache/salt/minion/files/base/_states/rundeck_project.py' to '/var/cache/salt/minion/extmods/states/rundeck_project.py'
2017-09-15 08:58:52,442 [salt.utils.extmods][INFO    ][24252] Copying '/var/cache/salt/minion/files/base/_states/rundeck_scm.py' to '/var/cache/salt/minion/extmods/states/rundeck_scm.py'
2017-09-15 08:58:52,442 [salt.utils.extmods][INFO    ][24252] Copying '/var/cache/salt/minion/files/base/_states/rundeck_secret.py' to '/var/cache/salt/minion/extmods/states/rundeck_secret.py'
2017-09-15 08:58:52,444 [salt.utils.extmods][INFO    ][24252] Creating module dir '/var/cache/salt/minion/extmods/sdb'
2017-09-15 08:58:52,447 [salt.utils.extmods][INFO    ][24252] Syncing sdb for environment 'base'
2017-09-15 08:58:52,447 [salt.utils.extmods][INFO    ][24252] Loading cache from salt://_sdb, for base)
2017-09-15 08:58:52,447 [salt.fileclient  ][INFO    ][24252] Caching directory '_sdb/' for environment 'base'
2017-09-15 08:58:52,476 [salt.utils.extmods][INFO    ][24252] Syncing grains for environment 'base'
2017-09-15 08:58:52,476 [salt.utils.extmods][INFO    ][24252] Loading cache from salt://_grains, for base)
2017-09-15 08:58:52,477 [salt.fileclient  ][INFO    ][24252] Caching directory '_grains/' for environment 'base'
2017-09-15 08:58:52,503 [salt.fileclient  ][INFO    ][24252] Fetching file from saltenv 'base', ** done ** '_grains/ceilometer_policy.py'
2017-09-15 08:58:52,512 [salt.fileclient  ][INFO    ][24252] Fetching file from saltenv 'base', ** done ** '_grains/cinder_policy.py'
2017-09-15 08:58:52,521 [salt.fileclient  ][INFO    ][24252] Fetching file from saltenv 'base', ** done ** '_grains/docker_swarm.py'
2017-09-15 08:58:52,530 [salt.fileclient  ][INFO    ][24252] Fetching file from saltenv 'base', ** done ** '_grains/glance_policy.py'
2017-09-15 08:58:52,539 [salt.fileclient  ][INFO    ][24252] Fetching file from saltenv 'base', ** done ** '_grains/heat_policy.py'
2017-09-15 08:58:52,549 [salt.fileclient  ][INFO    ][24252] Fetching file from saltenv 'base', ** done ** '_grains/jenkins_plugins.py'
2017-09-15 08:58:52,558 [salt.fileclient  ][INFO    ][24252] Fetching file from saltenv 'base', ** done ** '_grains/keystone_policy.py'
2017-09-15 08:58:52,570 [salt.fileclient  ][INFO    ][24252] Fetching file from saltenv 'base', ** done ** '_grains/kubernetes.py'
2017-09-15 08:58:52,579 [salt.fileclient  ][INFO    ][24252] Fetching file from saltenv 'base', ** done ** '_grains/neutron_policy.py'
2017-09-15 08:58:52,589 [salt.fileclient  ][INFO    ][24252] Fetching file from saltenv 'base', ** done ** '_grains/nova_policy.py'
2017-09-15 08:58:52,598 [salt.fileclient  ][INFO    ][24252] Fetching file from saltenv 'base', ** done ** '_grains/ssh_fingerprints.py'
2017-09-15 08:58:52,600 [salt.utils.extmods][INFO    ][24252] Copying '/var/cache/salt/minion/files/base/_grains/ceilometer_policy.py' to '/var/cache/salt/minion/extmods/grains/ceilometer_policy.py'
2017-09-15 08:58:52,601 [salt.utils.extmods][INFO    ][24252] Copying '/var/cache/salt/minion/files/base/_grains/cinder_policy.py' to '/var/cache/salt/minion/extmods/grains/cinder_policy.py'
2017-09-15 08:58:52,601 [salt.utils.extmods][INFO    ][24252] Copying '/var/cache/salt/minion/files/base/_grains/docker_swarm.py' to '/var/cache/salt/minion/extmods/grains/docker_swarm.py'
2017-09-15 08:58:52,601 [salt.utils.extmods][INFO    ][24252] Copying '/var/cache/salt/minion/files/base/_grains/glance_policy.py' to '/var/cache/salt/minion/extmods/grains/glance_policy.py'
2017-09-15 08:58:52,601 [salt.utils.extmods][INFO    ][24252] Copying '/var/cache/salt/minion/files/base/_grains/heat_policy.py' to '/var/cache/salt/minion/extmods/grains/heat_policy.py'
2017-09-15 08:58:52,602 [salt.utils.extmods][INFO    ][24252] Copying '/var/cache/salt/minion/files/base/_grains/jenkins_plugins.py' to '/var/cache/salt/minion/extmods/grains/jenkins_plugins.py'
2017-09-15 08:58:52,602 [salt.utils.extmods][INFO    ][24252] Copying '/var/cache/salt/minion/files/base/_grains/keystone_policy.py' to '/var/cache/salt/minion/extmods/grains/keystone_policy.py'
2017-09-15 08:58:52,602 [salt.utils.extmods][INFO    ][24252] Copying '/var/cache/salt/minion/files/base/_grains/kubernetes.py' to '/var/cache/salt/minion/extmods/grains/kubernetes.py'
2017-09-15 08:58:52,602 [salt.utils.extmods][INFO    ][24252] Copying '/var/cache/salt/minion/files/base/_grains/neutron_policy.py' to '/var/cache/salt/minion/extmods/grains/neutron_policy.py'
2017-09-15 08:58:52,603 [salt.utils.extmods][INFO    ][24252] Copying '/var/cache/salt/minion/files/base/_grains/nova_policy.py' to '/var/cache/salt/minion/extmods/grains/nova_policy.py'
2017-09-15 08:58:52,603 [salt.utils.extmods][INFO    ][24252] Copying '/var/cache/salt/minion/files/base/_grains/ssh_fingerprints.py' to '/var/cache/salt/minion/extmods/grains/ssh_fingerprints.py'
2017-09-15 08:58:52,604 [salt.utils.extmods][INFO    ][24252] Creating module dir '/var/cache/salt/minion/extmods/renderers'
2017-09-15 08:58:52,607 [salt.utils.extmods][INFO    ][24252] Syncing renderers for environment 'base'
2017-09-15 08:58:52,607 [salt.utils.extmods][INFO    ][24252] Loading cache from salt://_renderers, for base)
2017-09-15 08:58:52,607 [salt.fileclient  ][INFO    ][24252] Caching directory '_renderers/' for environment 'base'
2017-09-15 08:58:52,639 [salt.utils.extmods][INFO    ][24252] Creating module dir '/var/cache/salt/minion/extmods/returners'
2017-09-15 08:58:52,641 [salt.utils.extmods][INFO    ][24252] Syncing returners for environment 'base'
2017-09-15 08:58:52,641 [salt.utils.extmods][INFO    ][24252] Loading cache from salt://_returners, for base)
2017-09-15 08:58:52,641 [salt.fileclient  ][INFO    ][24252] Caching directory '_returners/' for environment 'base'
2017-09-15 08:58:52,663 [salt.utils.extmods][INFO    ][24252] Creating module dir '/var/cache/salt/minion/extmods/output'
2017-09-15 08:58:52,665 [salt.utils.extmods][INFO    ][24252] Syncing output for environment 'base'
2017-09-15 08:58:52,665 [salt.utils.extmods][INFO    ][24252] Loading cache from salt://_output, for base)
2017-09-15 08:58:52,665 [salt.fileclient  ][INFO    ][24252] Caching directory '_output/' for environment 'base'
2017-09-15 08:58:52,695 [salt.utils.extmods][INFO    ][24252] Creating module dir '/var/cache/salt/minion/extmods/utils'
2017-09-15 08:58:52,698 [salt.utils.extmods][INFO    ][24252] Syncing utils for environment 'base'
2017-09-15 08:58:52,698 [salt.utils.extmods][INFO    ][24252] Loading cache from salt://_utils, for base)
2017-09-15 08:58:52,698 [salt.fileclient  ][INFO    ][24252] Caching directory '_utils/' for environment 'base'
2017-09-15 08:58:52,729 [salt.utils.extmods][INFO    ][24252] Creating module dir '/var/cache/salt/minion/extmods/log_handlers'
2017-09-15 08:58:52,731 [salt.utils.extmods][INFO    ][24252] Syncing log_handlers for environment 'base'
2017-09-15 08:58:52,731 [salt.utils.extmods][INFO    ][24252] Loading cache from salt://_log_handlers, for base)
2017-09-15 08:58:52,731 [salt.fileclient  ][INFO    ][24252] Caching directory '_log_handlers/' for environment 'base'
2017-09-15 08:58:52,771 [salt.utils.extmods][INFO    ][24252] Creating module dir '/var/cache/salt/minion/extmods/proxy'
2017-09-15 08:58:52,774 [salt.utils.extmods][INFO    ][24252] Syncing proxy for environment 'base'
2017-09-15 08:58:52,774 [salt.utils.extmods][INFO    ][24252] Loading cache from salt://_proxy, for base)
2017-09-15 08:58:52,774 [salt.fileclient  ][INFO    ][24252] Caching directory '_proxy/' for environment 'base'
2017-09-15 08:58:52,805 [salt.utils.extmods][INFO    ][24252] Creating module dir '/var/cache/salt/minion/extmods/engines'
2017-09-15 08:58:52,807 [salt.utils.extmods][INFO    ][24252] Syncing engines for environment 'base'
2017-09-15 08:58:52,807 [salt.utils.extmods][INFO    ][24252] Loading cache from salt://_engines, for base)
2017-09-15 08:58:52,807 [salt.fileclient  ][INFO    ][24252] Caching directory '_engines/' for environment 'base'
2017-09-15 08:58:52,852 [salt.minion      ][INFO    ][24252] Returning information for job: 20170915085849179505
2017-09-15 08:58:53,701 [salt.minion      ][INFO    ][24160] User sudo_ubuntu Executing command state.sls with jid 20170915085853697983
2017-09-15 08:58:53,715 [salt.minion      ][INFO    ][24333] Starting a new job with PID 24333
2017-09-15 08:58:54,098 [salt.state       ][INFO    ][24333] Loading fresh modules for state activity
2017-09-15 08:58:54,131 [salt.fileclient  ][INFO    ][24333] Fetching file from saltenv 'base', ** done ** 'salt/control/init.sls'
2017-09-15 08:58:54,172 [salt.fileclient  ][INFO    ][24333] Fetching file from saltenv 'base', ** done ** 'salt/control/virt.sls'
2017-09-15 08:58:54,193 [salt.fileclient  ][INFO    ][24333] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-09-15 08:58:54,305 [salt.fileclient  ][INFO    ][24333] Fetching file from saltenv 'base', ** done ** 'salt/minion/init.sls'
2017-09-15 08:58:54,316 [salt.fileclient  ][INFO    ][24333] Fetching file from saltenv 'base', ** done ** 'salt/minion/service.sls'
2017-09-15 08:58:54,335 [salt.fileclient  ][INFO    ][24333] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-09-15 08:58:54,379 [salt.fileclient  ][INFO    ][24333] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-09-15 08:58:54,392 [salt.fileclient  ][INFO    ][24333] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-09-15 08:58:54,429 [salt.fileclient  ][INFO    ][24333] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-09-15 08:58:54,444 [salt.fileclient  ][INFO    ][24333] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-09-15 08:58:54,453 [salt.fileclient  ][INFO    ][24333] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-09-15 08:58:54,464 [salt.fileclient  ][INFO    ][24333] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-09-15 08:58:54,471 [salt.loaded.int.module.cmdmod][INFO    ][24333] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-09-15 08:58:54,492 [salt.fileclient  ][INFO    ][24333] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-09-15 08:58:54,506 [py.warnings      ][WARNING ][24333] /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-15 08:58:54,506 [salt.loaded.int.module.cmdmod][INFO    ][24333] Executing command 'salt-minion --version' in directory '/root'
2017-09-15 08:58:54,761 [salt.fileclient  ][INFO    ][24333] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-09-15 08:58:54,780 [salt.fileclient  ][INFO    ][24333] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-09-15 08:58:54,791 [salt.fileclient  ][INFO    ][24333] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-09-15 08:58:54,804 [salt.fileclient  ][INFO    ][24333] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-09-15 08:58:54,871 [salt.fileclient  ][INFO    ][24333] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-09-15 08:58:54,904 [salt.fileclient  ][INFO    ][24333] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-09-15 08:58:54,954 [salt.fileclient  ][INFO    ][24333] Fetching file from saltenv 'base', ** done ** 'salt/minion/grains.sls'
2017-09-15 08:58:54,973 [salt.fileclient  ][INFO    ][24333] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-09-15 08:58:55,021 [salt.fileclient  ][INFO    ][24333] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-09-15 08:58:55,038 [salt.fileclient  ][INFO    ][24333] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-09-15 08:58:55,080 [salt.fileclient  ][INFO    ][24333] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-09-15 08:58:55,098 [salt.fileclient  ][INFO    ][24333] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-09-15 08:58:55,110 [salt.fileclient  ][INFO    ][24333] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-09-15 08:58:55,125 [salt.fileclient  ][INFO    ][24333] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-09-15 08:58:55,131 [salt.loaded.int.module.cmdmod][INFO    ][24333] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-09-15 08:58:55,174 [salt.fileclient  ][INFO    ][24333] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-09-15 08:58:55,188 [salt.loaded.int.module.cmdmod][INFO    ][24333] Executing command 'salt-minion --version' in directory '/root'
2017-09-15 08:58:55,439 [salt.fileclient  ][INFO    ][24333] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-09-15 08:58:55,457 [salt.fileclient  ][INFO    ][24333] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-09-15 08:58:55,486 [salt.fileclient  ][INFO    ][24333] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-09-15 08:58:55,513 [salt.fileclient  ][INFO    ][24333] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-09-15 08:58:55,566 [salt.fileclient  ][INFO    ][24333] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-09-15 08:58:55,605 [salt.fileclient  ][INFO    ][24333] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-09-15 08:58:55,664 [salt.fileclient  ][INFO    ][24333] Fetching file from saltenv 'base', ** done ** 'salt/minion/cert.sls'
2017-09-15 08:58:55,718 [salt.fileclient  ][INFO    ][24333] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-09-15 08:58:56,062 [salt.state       ][INFO    ][24333] Running state [salt-minion] at time 08:58:56.061938
2017-09-15 08:58:56,062 [salt.state       ][INFO    ][24333] Executing state pkg.installed for salt-minion
2017-09-15 08:58:56,063 [salt.loaded.int.module.cmdmod][INFO    ][24333] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-15 08:58:56,338 [salt.state       ][INFO    ][24333] Package salt-minion is already installed
2017-09-15 08:58:56,339 [salt.state       ][INFO    ][24333] Completed state [salt-minion] at time 08:58:56.338568 duration_in_ms=276.63
2017-09-15 08:58:56,339 [salt.state       ][INFO    ][24333] Running state [python-yaml] at time 08:58:56.338773
2017-09-15 08:58:56,339 [salt.state       ][INFO    ][24333] Executing state pkg.installed for python-yaml
2017-09-15 08:58:56,342 [salt.state       ][INFO    ][24333] Package python-yaml is already installed
2017-09-15 08:58:56,342 [salt.state       ][INFO    ][24333] Completed state [python-yaml] at time 08:58:56.341614 duration_in_ms=2.842
2017-09-15 08:58:56,342 [salt.state       ][INFO    ][24333] Running state [python-psutil] at time 08:58:56.341754
2017-09-15 08:58:56,342 [salt.state       ][INFO    ][24333] Executing state pkg.installed for python-psutil
2017-09-15 08:58:56,344 [salt.state       ][INFO    ][24333] Package python-psutil is already installed
2017-09-15 08:58:56,345 [salt.state       ][INFO    ][24333] Completed state [python-psutil] at time 08:58:56.344523 duration_in_ms=2.768
2017-09-15 08:58:56,345 [salt.state       ][INFO    ][24333] Running state [python-m2crypto] at time 08:58:56.344663
2017-09-15 08:58:56,345 [salt.state       ][INFO    ][24333] Executing state pkg.installed for python-m2crypto
2017-09-15 08:58:56,347 [salt.state       ][INFO    ][24333] Package python-m2crypto is already installed
2017-09-15 08:58:56,347 [salt.state       ][INFO    ][24333] Completed state [python-m2crypto] at time 08:58:56.347431 duration_in_ms=2.769
2017-09-15 08:58:56,349 [salt.state       ][INFO    ][24333] Running state [/etc/salt/minion.d/minion.conf] at time 08:58:56.348837
2017-09-15 08:58:56,349 [salt.state       ][INFO    ][24333] Executing state file.managed for /etc/salt/minion.d/minion.conf
2017-09-15 08:58:56,375 [salt.fileclient  ][INFO    ][24333] Fetching file from saltenv 'base', ** done ** 'salt/files/minion.conf'
2017-09-15 08:58:56,419 [salt.fileclient  ][INFO    ][24333] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-09-15 08:58:56,459 [salt.fileclient  ][INFO    ][24333] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-09-15 08:58:56,489 [salt.state       ][INFO    ][24333] File /etc/salt/minion.d/minion.conf is in the correct state
2017-09-15 08:58:56,490 [salt.state       ][INFO    ][24333] Completed state [/etc/salt/minion.d/minion.conf] at time 08:58:56.489619 duration_in_ms=140.782
2017-09-15 08:58:56,490 [salt.state       ][INFO    ][24333] Running state [/etc/salt/minion.d/_virt.conf] at time 08:58:56.489913
2017-09-15 08:58:56,490 [salt.state       ][INFO    ][24333] Executing state file.managed for /etc/salt/minion.d/_virt.conf
2017-09-15 08:58:56,510 [salt.state       ][INFO    ][24333] File /etc/salt/minion.d/_virt.conf is in the correct state
2017-09-15 08:58:56,510 [salt.state       ][INFO    ][24333] Completed state [/etc/salt/minion.d/_virt.conf] at time 08:58:56.510288 duration_in_ms=20.374
2017-09-15 08:58:56,511 [salt.state       ][INFO    ][24333] Running state [salt-minion] at time 08:58:56.511343
2017-09-15 08:58:56,512 [salt.state       ][INFO    ][24333] Executing state service.running for salt-minion
2017-09-15 08:58:56,512 [salt.loaded.int.module.cmdmod][INFO    ][24333] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2017-09-15 08:58:56,530 [salt.loaded.int.module.cmdmod][INFO    ][24333] Executing command ['systemctl', 'is-active', 'salt-minion.service'] in directory '/root'
2017-09-15 08:58:56,539 [salt.loaded.int.module.cmdmod][INFO    ][24333] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2017-09-15 08:58:56,547 [salt.state       ][INFO    ][24333] The service salt-minion is already running
2017-09-15 08:58:56,558 [salt.state       ][INFO    ][24333] Completed state [salt-minion] at time 08:58:56.558105 duration_in_ms=46.762
2017-09-15 08:58:56,559 [salt.state       ][INFO    ][24333] Running state [/etc/salt/grains.d] at time 08:58:56.559314
2017-09-15 08:58:56,560 [salt.state       ][INFO    ][24333] Executing state file.directory for /etc/salt/grains.d
2017-09-15 08:58:56,560 [salt.state       ][INFO    ][24333] Directory /etc/salt/grains.d is in the correct state
2017-09-15 08:58:56,560 [salt.state       ][INFO    ][24333] Completed state [/etc/salt/grains.d] at time 08:58:56.560335 duration_in_ms=1.02
2017-09-15 08:58:56,561 [salt.state       ][INFO    ][24333] Running state [/etc/salt/grains] at time 08:58:56.560844
2017-09-15 08:58:56,561 [salt.state       ][INFO    ][24333] Executing state file.managed for /etc/salt/grains
2017-09-15 08:58:56,561 [salt.state       ][INFO    ][24333] File /etc/salt/grains exists with proper permissions. No changes made.
2017-09-15 08:58:56,562 [salt.state       ][INFO    ][24333] Completed state [/etc/salt/grains] at time 08:58:56.561619 duration_in_ms=0.775
2017-09-15 08:58:56,562 [salt.state       ][INFO    ][24333] Running state [/etc/salt/grains.d/placeholder] at time 08:58:56.561970
2017-09-15 08:58:56,562 [salt.state       ][INFO    ][24333] Executing state file.managed for /etc/salt/grains.d/placeholder
2017-09-15 08:58:56,563 [salt.state       ][INFO    ][24333] File /etc/salt/grains.d/placeholder exists with proper permissions. No changes made.
2017-09-15 08:58:56,563 [salt.state       ][INFO    ][24333] Completed state [/etc/salt/grains.d/placeholder] at time 08:58:56.562710 duration_in_ms=0.74
2017-09-15 08:58:56,563 [salt.state       ][INFO    ][24333] Running state [/etc/salt/grains.d/sphinx] at time 08:58:56.563024
2017-09-15 08:58:56,563 [salt.state       ][INFO    ][24333] Executing state file.managed for /etc/salt/grains.d/sphinx
2017-09-15 08:58:56,591 [salt.state       ][INFO    ][24333] File /etc/salt/grains.d/sphinx is in the correct state
2017-09-15 08:58:56,592 [salt.state       ][INFO    ][24333] Completed state [/etc/salt/grains.d/sphinx] at time 08:58:56.591552 duration_in_ms=28.528
2017-09-15 08:58:56,592 [salt.state       ][INFO    ][24333] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 08:58:56.592079
2017-09-15 08:58:56,592 [salt.state       ][INFO    ][24333] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-09-15 08:58:56,593 [salt.state       ][INFO    ][24333] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-09-15 08:58:56,593 [salt.state       ][INFO    ][24333] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 08:58:56.592726 duration_in_ms=0.647
2017-09-15 08:58:56,593 [salt.state       ][INFO    ][24333] Running state [/etc/salt/grains.d/dns_records] at time 08:58:56.593047
2017-09-15 08:58:56,593 [salt.state       ][INFO    ][24333] Executing state file.managed for /etc/salt/grains.d/dns_records
2017-09-15 08:58:56,613 [salt.state       ][INFO    ][24333] File /etc/salt/grains.d/dns_records is in the correct state
2017-09-15 08:58:56,613 [salt.state       ][INFO    ][24333] Completed state [/etc/salt/grains.d/dns_records] at time 08:58:56.613414 duration_in_ms=20.367
2017-09-15 08:58:56,614 [salt.state       ][INFO    ][24333] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 08:58:56.613966
2017-09-15 08:58:56,614 [salt.state       ][INFO    ][24333] 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-15 08:58:56,614 [salt.state       ][INFO    ][24333] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"
2017-09-15 08:58:56,615 [salt.state       ][INFO    ][24333] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 08:58:56.614578 duration_in_ms=0.613
2017-09-15 08:58:56,615 [salt.state       ][INFO    ][24333] Running state [/etc/salt/grains.d/salt] at time 08:58:56.614897
2017-09-15 08:58:56,615 [salt.state       ][INFO    ][24333] Executing state file.managed for /etc/salt/grains.d/salt
2017-09-15 08:58:56,625 [salt.state       ][INFO    ][24333] File /etc/salt/grains.d/salt is in the correct state
2017-09-15 08:58:56,625 [salt.state       ][INFO    ][24333] Completed state [/etc/salt/grains.d/salt] at time 08:58:56.625321 duration_in_ms=10.424
2017-09-15 08:58:56,626 [salt.state       ][INFO    ][24333] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 08:58:56.625809
2017-09-15 08:58:56,626 [salt.state       ][INFO    ][24333] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2017-09-15 08:58:56,626 [salt.state       ][INFO    ][24333] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2017-09-15 08:58:56,626 [salt.state       ][INFO    ][24333] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 08:58:56.626452 duration_in_ms=0.643
2017-09-15 08:58:56,628 [salt.state       ][INFO    ][24333] Running state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 08:58:56.627722
2017-09-15 08:58:56,628 [salt.state       ][INFO    ][24333] Executing state cmd.wait for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-09-15 08:58:56,628 [salt.state       ][INFO    ][24333] No changes made for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-09-15 08:58:56,628 [salt.state       ][INFO    ][24333] Completed state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 08:58:56.628343 duration_in_ms=0.621
2017-09-15 08:58:56,629 [salt.state       ][INFO    ][24333] Running state [mine.update] at time 08:58:56.628796
2017-09-15 08:58:56,629 [salt.state       ][INFO    ][24333] Executing state module.wait for mine.update
2017-09-15 08:58:56,629 [salt.state       ][INFO    ][24333] No changes made for mine.update
2017-09-15 08:58:56,629 [salt.state       ][INFO    ][24333] Completed state [mine.update] at time 08:58:56.629352 duration_in_ms=0.557
2017-09-15 08:58:56,630 [salt.state       ][INFO    ][24333] Running state [ca-certificates] at time 08:58:56.629535
2017-09-15 08:58:56,630 [salt.state       ][INFO    ][24333] Executing state pkg.installed for ca-certificates
2017-09-15 08:58:56,633 [salt.state       ][INFO    ][24333] Package ca-certificates is already installed
2017-09-15 08:58:56,633 [salt.state       ][INFO    ][24333] Completed state [ca-certificates] at time 08:58:56.632961 duration_in_ms=3.426
2017-09-15 08:58:56,634 [salt.state       ][INFO    ][24333] Running state [update-ca-certificates] at time 08:58:56.633453
2017-09-15 08:58:56,634 [salt.state       ][INFO    ][24333] Executing state cmd.wait for update-ca-certificates
2017-09-15 08:58:56,634 [salt.state       ][INFO    ][24333] No changes made for update-ca-certificates
2017-09-15 08:58:56,634 [salt.state       ][INFO    ][24333] Completed state [update-ca-certificates] at time 08:58:56.634080 duration_in_ms=0.627
2017-09-15 08:58:56,634 [salt.state       ][INFO    ][24333] Running state [libvirt-dev] at time 08:58:56.634263
2017-09-15 08:58:56,634 [salt.state       ][INFO    ][24333] Executing state pkg.installed for libvirt-dev
2017-09-15 08:58:56,637 [salt.state       ][INFO    ][24333] Package libvirt-dev is already installed
2017-09-15 08:58:56,648 [salt.state       ][INFO    ][24333] Completed state [libvirt-dev] at time 08:58:56.648341 duration_in_ms=14.078
2017-09-15 08:58:56,649 [salt.state       ][INFO    ][24333] Running state [pkg-config] at time 08:58:56.648580
2017-09-15 08:58:56,649 [salt.state       ][INFO    ][24333] Executing state pkg.installed for pkg-config
2017-09-15 08:58:56,652 [salt.state       ][INFO    ][24333] Package pkg-config is already installed
2017-09-15 08:58:56,652 [salt.state       ][INFO    ][24333] Completed state [pkg-config] at time 08:58:56.651810 duration_in_ms=3.23
2017-09-15 08:58:56,652 [salt.state       ][INFO    ][24333] Running state [virtng.init] at time 08:58:56.651999
2017-09-15 08:58:56,652 [salt.state       ][INFO    ][24333] Executing state module.run for virtng.init
2017-09-15 08:58:56,716 [salt.loaded.int.module.cmdmod][INFO    ][24333] Executing command ['git', '--version'] in directory '/root'
2017-09-15 08:58:56,807 [salt.loaded.int.module.cmdmod][INFO    ][24333] Executing command 'virsh list --all --name| grep -E "^mdb02.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-09-15 08:58:56,828 [salt.state       ][INFO    ][24333] unless execution succeeded
2017-09-15 08:58:56,828 [salt.state       ][INFO    ][24333] Completed state [virtng.init] at time 08:58:56.827972 duration_in_ms=175.971
2017-09-15 08:58:56,837 [salt.state       ][INFO    ][24333] Running state [virt.set_autostart] at time 08:58:56.837459
2017-09-15 08:58:56,838 [salt.state       ][INFO    ][24333] Executing state module.run for virt.set_autostart
2017-09-15 08:58:56,840 [salt.loaded.int.module.cmdmod][INFO    ][24333] Executing command 'virsh list --autostart --name| grep -E "^mdb02.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-09-15 08:58:56,859 [salt.state       ][INFO    ][24333] unless execution succeeded
2017-09-15 08:58:56,859 [salt.state       ][INFO    ][24333] Completed state [virt.set_autostart] at time 08:58:56.858881 duration_in_ms=21.422
2017-09-15 08:58:56,859 [salt.state       ][INFO    ][24333] Running state [virtng.init] at time 08:58:56.859140
2017-09-15 08:58:56,859 [salt.state       ][INFO    ][24333] Executing state module.run for virtng.init
2017-09-15 08:58:56,861 [salt.loaded.int.module.cmdmod][INFO    ][24333] Executing command 'virsh list --all --name| grep -E "^dbs02.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-09-15 08:58:56,877 [salt.state       ][INFO    ][24333] unless execution succeeded
2017-09-15 08:58:56,886 [salt.state       ][INFO    ][24333] Completed state [virtng.init] at time 08:58:56.885597 duration_in_ms=26.457
2017-09-15 08:58:56,886 [salt.state       ][INFO    ][24333] Running state [virt.set_autostart] at time 08:58:56.885908
2017-09-15 08:58:56,886 [salt.state       ][INFO    ][24333] Executing state module.run for virt.set_autostart
2017-09-15 08:58:56,888 [salt.loaded.int.module.cmdmod][INFO    ][24333] Executing command 'virsh list --autostart --name| grep -E "^dbs02.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-09-15 08:58:56,904 [salt.state       ][INFO    ][24333] unless execution succeeded
2017-09-15 08:58:56,904 [salt.state       ][INFO    ][24333] Completed state [virt.set_autostart] at time 08:58:56.904171 duration_in_ms=18.263
2017-09-15 08:58:56,904 [salt.state       ][INFO    ][24333] Running state [virtng.init] at time 08:58:56.904430
2017-09-15 08:58:56,905 [salt.state       ][INFO    ][24333] Executing state module.run for virtng.init
2017-09-15 08:58:56,907 [salt.loaded.int.module.cmdmod][INFO    ][24333] Executing command 'virsh list --all --name| grep -E "^prx02.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-09-15 08:58:56,923 [salt.state       ][INFO    ][24333] unless execution succeeded
2017-09-15 08:58:56,923 [salt.state       ][INFO    ][24333] Completed state [virtng.init] at time 08:58:56.923090 duration_in_ms=18.66
2017-09-15 08:58:56,923 [salt.state       ][INFO    ][24333] Running state [virt.set_autostart] at time 08:58:56.923346
2017-09-15 08:58:56,924 [salt.state       ][INFO    ][24333] Executing state module.run for virt.set_autostart
2017-09-15 08:58:56,926 [salt.loaded.int.module.cmdmod][INFO    ][24333] Executing command 'virsh list --autostart --name| grep -E "^prx02.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-09-15 08:58:56,941 [salt.state       ][INFO    ][24333] unless execution succeeded
2017-09-15 08:58:56,949 [salt.state       ][INFO    ][24333] Completed state [virt.set_autostart] at time 08:58:56.948817 duration_in_ms=25.471
2017-09-15 08:58:56,949 [salt.state       ][INFO    ][24333] Running state [virtng.init] at time 08:58:56.949098
2017-09-15 08:58:56,949 [salt.state       ][INFO    ][24333] Executing state module.run for virtng.init
2017-09-15 08:58:56,951 [salt.loaded.int.module.cmdmod][INFO    ][24333] Executing command 'virsh list --all --name| grep -E "^ctl02.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-09-15 08:58:56,966 [salt.state       ][INFO    ][24333] unless execution succeeded
2017-09-15 08:58:56,970 [salt.state       ][INFO    ][24333] Completed state [virtng.init] at time 08:58:56.969729 duration_in_ms=20.63
2017-09-15 08:58:56,970 [salt.state       ][INFO    ][24333] Running state [virt.set_autostart] at time 08:58:56.970134
2017-09-15 08:58:56,970 [salt.state       ][INFO    ][24333] Executing state module.run for virt.set_autostart
2017-09-15 08:58:56,972 [salt.loaded.int.module.cmdmod][INFO    ][24333] Executing command 'virsh list --autostart --name| grep -E "^ctl02.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-09-15 08:58:56,988 [salt.state       ][INFO    ][24333] unless execution succeeded
2017-09-15 08:58:56,989 [salt.state       ][INFO    ][24333] Completed state [virt.set_autostart] at time 08:58:56.988562 duration_in_ms=18.427
2017-09-15 08:58:56,989 [salt.state       ][INFO    ][24333] Running state [virtng.init] at time 08:58:56.988789
2017-09-15 08:58:56,989 [salt.state       ][INFO    ][24333] Executing state module.run for virtng.init
2017-09-15 08:58:56,991 [salt.loaded.int.module.cmdmod][INFO    ][24333] Executing command 'virsh list --all --name| grep -E "^msg02.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-09-15 08:58:57,005 [salt.state       ][INFO    ][24333] unless execution succeeded
2017-09-15 08:58:57,012 [salt.state       ][INFO    ][24333] Completed state [virtng.init] at time 08:58:57.011807 duration_in_ms=23.016
2017-09-15 08:58:57,012 [salt.state       ][INFO    ][24333] Running state [virt.set_autostart] at time 08:58:57.012276
2017-09-15 08:58:57,013 [salt.state       ][INFO    ][24333] Executing state module.run for virt.set_autostart
2017-09-15 08:58:57,015 [salt.loaded.int.module.cmdmod][INFO    ][24333] Executing command 'virsh list --autostart --name| grep -E "^msg02.baremetal-mcp-ocata-ovs-dpdk-ha.local$"' in directory '/root'
2017-09-15 08:58:57,030 [salt.state       ][INFO    ][24333] unless execution succeeded
2017-09-15 08:58:57,030 [salt.state       ][INFO    ][24333] Completed state [virt.set_autostart] at time 08:58:57.030355 duration_in_ms=18.079
2017-09-15 08:58:57,085 [salt.minion      ][INFO    ][24333] Returning information for job: 20170915085853697983
2017-09-15 09:10:37,782 [salt.minion      ][INFO    ][24160] User sudo_ubuntu Executing command saltutil.sync_all with jid 20170915091037770686
2017-09-15 09:10:37,803 [salt.minion      ][INFO    ][24672] Starting a new job with PID 24672
2017-09-15 09:10:41,764 [salt.state       ][INFO    ][24672] Loading fresh modules for state activity
2017-09-15 09:10:41,783 [salt.state       ][ERROR   ][24672] No contents found in top file
2017-09-15 09:10:41,784 [salt.utils.extmods][INFO    ][24672] Creating module dir '/var/cache/salt/minion/extmods/beacons'
2017-09-15 09:10:41,787 [salt.utils.extmods][INFO    ][24672] Syncing beacons for environment 'base'
2017-09-15 09:10:41,787 [salt.utils.extmods][INFO    ][24672] Loading cache from salt://_beacons, for base)
2017-09-15 09:10:41,787 [salt.fileclient  ][INFO    ][24672] Caching directory '_beacons/' for environment 'base'
2017-09-15 09:10:41,814 [salt.utils.extmods][INFO    ][24672] Syncing modules for environment 'base'
2017-09-15 09:10:41,815 [salt.utils.extmods][INFO    ][24672] Loading cache from salt://_modules, for base)
2017-09-15 09:10:41,815 [salt.fileclient  ][INFO    ][24672] Caching directory '_modules/' for environment 'base'
2017-09-15 09:10:41,872 [salt.fileclient  ][INFO    ][24672] Fetching file from saltenv 'base', ** done ** '_modules/ceph_ng.py'
2017-09-15 09:10:41,896 [salt.fileclient  ][INFO    ][24672] Fetching file from saltenv 'base', ** done ** '_modules/cinderng.py'
2017-09-15 09:10:42,204 [salt.fileclient  ][INFO    ][24672] Fetching file from saltenv 'base', ** done ** '_modules/contrail.py'
2017-09-15 09:10:42,212 [salt.fileclient  ][INFO    ][24672] Fetching file from saltenv 'base', ** done ** '_modules/creds.py'
2017-09-15 09:10:42,226 [salt.fileclient  ][INFO    ][24672] Fetching file from saltenv 'base', ** done ** '_modules/devops_utils.py'
2017-09-15 09:10:42,238 [salt.fileclient  ][INFO    ][24672] Fetching file from saltenv 'base', ** done ** '_modules/encode_json.py'
2017-09-15 09:10:42,253 [salt.fileclient  ][INFO    ][24672] Fetching file from saltenv 'base', ** done ** '_modules/gerrit.py'
2017-09-15 09:10:42,264 [salt.fileclient  ][INFO    ][24672] Fetching file from saltenv 'base', ** done ** '_modules/glanceng.py'
2017-09-15 09:10:42,271 [salt.fileclient  ][INFO    ][24672] Fetching file from saltenv 'base', ** done ** '_modules/heat.py'
2017-09-15 09:10:42,284 [salt.fileclient  ][INFO    ][24672] Fetching file from saltenv 'base', ** done ** '_modules/heka_alarming.py'
2017-09-15 09:10:42,298 [salt.fileclient  ][INFO    ][24672] Fetching file from saltenv 'base', ** done ** '_modules/helm.py'
2017-09-15 09:10:42,312 [salt.fileclient  ][INFO    ][24672] Fetching file from saltenv 'base', ** done ** '_modules/jenkins_common.py'
2017-09-15 09:10:42,320 [salt.fileclient  ][INFO    ][24672] Fetching file from saltenv 'base', ** done ** '_modules/keystone_policy.py'
2017-09-15 09:10:42,340 [salt.fileclient  ][INFO    ][24672] Fetching file from saltenv 'base', ** done ** '_modules/linux_hosts.py'
2017-09-15 09:10:42,351 [salt.fileclient  ][INFO    ][24672] Fetching file from saltenv 'base', ** done ** '_modules/linux_netlink.py'
2017-09-15 09:10:42,362 [salt.fileclient  ][INFO    ][24672] Fetching file from saltenv 'base', ** done ** '_modules/maas.py'
2017-09-15 09:10:42,374 [salt.fileclient  ][INFO    ][24672] Fetching file from saltenv 'base', ** done ** '_modules/maas_client.py'
2017-09-15 09:10:42,403 [salt.fileclient  ][INFO    ][24672] Fetching file from saltenv 'base', ** done ** '_modules/multipart.py'
2017-09-15 09:10:42,420 [salt.fileclient  ][INFO    ][24672] Fetching file from saltenv 'base', ** done ** '_modules/nagios_alarming.py'
2017-09-15 09:10:42,456 [salt.fileclient  ][INFO    ][24672] Fetching file from saltenv 'base', ** done ** '_modules/neutronng.py'
2017-09-15 09:10:42,498 [salt.fileclient  ][INFO    ][24672] Fetching file from saltenv 'base', ** done ** '_modules/novang.py'
2017-09-15 09:10:42,506 [salt.fileclient  ][INFO    ][24672] Fetching file from saltenv 'base', ** done ** '_modules/reclass.py'
2017-09-15 09:10:42,542 [salt.fileclient  ][INFO    ][24672] Fetching file from saltenv 'base', ** done ** '_modules/rsyslog_util.py'
2017-09-15 09:10:42,557 [salt.fileclient  ][INFO    ][24672] Fetching file from saltenv 'base', ** done ** '_modules/rundeck.py'
2017-09-15 09:10:42,567 [salt.fileclient  ][INFO    ][24672] Fetching file from saltenv 'base', ** done ** '_modules/saltkey.py'
2017-09-15 09:10:42,576 [salt.fileclient  ][INFO    ][24672] Fetching file from saltenv 'base', ** done ** '_modules/saltresource.py'
2017-09-15 09:10:42,599 [salt.fileclient  ][INFO    ][24672] Fetching file from saltenv 'base', ** done ** '_modules/seedng.py'
2017-09-15 09:10:42,609 [salt.fileclient  ][INFO    ][24672] Fetching file from saltenv 'base', ** done ** '_modules/testing/credentials.py'
2017-09-15 09:10:42,616 [salt.fileclient  ][INFO    ][24672] Fetching file from saltenv 'base', ** done ** '_modules/testing/django.py'
2017-09-15 09:10:42,625 [salt.fileclient  ][INFO    ][24672] Fetching file from saltenv 'base', ** done ** '_modules/testing/django_client_proxy.py'
2017-09-15 09:10:42,633 [salt.fileclient  ][INFO    ][24672] Fetching file from saltenv 'base', ** done ** '_modules/utils.py'
2017-09-15 09:10:42,641 [salt.fileclient  ][INFO    ][24672] Fetching file from saltenv 'base', ** done ** '_modules/virtng.py'
2017-09-15 09:10:42,646 [salt.utils.extmods][INFO    ][24672] Copying '/var/cache/salt/minion/files/base/_modules/__init__.py' to '/var/cache/salt/minion/extmods/modules/__init__.py'
2017-09-15 09:10:42,646 [salt.utils.extmods][INFO    ][24672] Copying '/var/cache/salt/minion/files/base/_modules/ceph_ng.py' to '/var/cache/salt/minion/extmods/modules/ceph_ng.py'
2017-09-15 09:10:42,646 [salt.utils.extmods][INFO    ][24672] Copying '/var/cache/salt/minion/files/base/_modules/cinderng.py' to '/var/cache/salt/minion/extmods/modules/cinderng.py'
2017-09-15 09:10:42,646 [salt.utils.extmods][INFO    ][24672] Copying '/var/cache/salt/minion/files/base/_modules/contrail.py' to '/var/cache/salt/minion/extmods/modules/contrail.py'
2017-09-15 09:10:42,647 [salt.utils.extmods][INFO    ][24672] Copying '/var/cache/salt/minion/files/base/_modules/creds.py' to '/var/cache/salt/minion/extmods/modules/creds.py'
2017-09-15 09:10:42,647 [salt.utils.extmods][INFO    ][24672] Copying '/var/cache/salt/minion/files/base/_modules/devops_utils.py' to '/var/cache/salt/minion/extmods/modules/devops_utils.py'
2017-09-15 09:10:42,647 [salt.utils.extmods][INFO    ][24672] Copying '/var/cache/salt/minion/files/base/_modules/encode_json.py' to '/var/cache/salt/minion/extmods/modules/encode_json.py'
2017-09-15 09:10:42,647 [salt.utils.extmods][INFO    ][24672] Copying '/var/cache/salt/minion/files/base/_modules/gerrit.py' to '/var/cache/salt/minion/extmods/modules/gerrit.py'
2017-09-15 09:10:42,647 [salt.utils.extmods][INFO    ][24672] Copying '/var/cache/salt/minion/files/base/_modules/glanceng.py' to '/var/cache/salt/minion/extmods/modules/glanceng.py'
2017-09-15 09:10:42,648 [salt.utils.extmods][INFO    ][24672] Copying '/var/cache/salt/minion/files/base/_modules/heat.py' to '/var/cache/salt/minion/extmods/modules/heat.py'
2017-09-15 09:10:42,648 [salt.utils.extmods][INFO    ][24672] Copying '/var/cache/salt/minion/files/base/_modules/heka_alarming.py' to '/var/cache/salt/minion/extmods/modules/heka_alarming.py'
2017-09-15 09:10:42,648 [salt.utils.extmods][INFO    ][24672] Copying '/var/cache/salt/minion/files/base/_modules/helm.py' to '/var/cache/salt/minion/extmods/modules/helm.py'
2017-09-15 09:10:42,649 [salt.utils.extmods][INFO    ][24672] Copying '/var/cache/salt/minion/files/base/_modules/jenkins_common.py' to '/var/cache/salt/minion/extmods/modules/jenkins_common.py'
2017-09-15 09:10:42,649 [salt.utils.extmods][INFO    ][24672] Copying '/var/cache/salt/minion/files/base/_modules/keystone_policy.py' to '/var/cache/salt/minion/extmods/modules/keystone_policy.py'
2017-09-15 09:10:42,649 [salt.utils.extmods][INFO    ][24672] Copying '/var/cache/salt/minion/files/base/_modules/linux_hosts.py' to '/var/cache/salt/minion/extmods/modules/linux_hosts.py'
2017-09-15 09:10:42,649 [salt.utils.extmods][INFO    ][24672] Copying '/var/cache/salt/minion/files/base/_modules/linux_netlink.py' to '/var/cache/salt/minion/extmods/modules/linux_netlink.py'
2017-09-15 09:10:42,649 [salt.utils.extmods][INFO    ][24672] Copying '/var/cache/salt/minion/files/base/_modules/maas.py' to '/var/cache/salt/minion/extmods/modules/maas.py'
2017-09-15 09:10:42,650 [salt.utils.extmods][INFO    ][24672] Copying '/var/cache/salt/minion/files/base/_modules/maas_client.py' to '/var/cache/salt/minion/extmods/modules/maas_client.py'
2017-09-15 09:10:42,650 [salt.utils.extmods][INFO    ][24672] Copying '/var/cache/salt/minion/files/base/_modules/multipart.py' to '/var/cache/salt/minion/extmods/modules/multipart.py'
2017-09-15 09:10:42,650 [salt.utils.extmods][INFO    ][24672] Copying '/var/cache/salt/minion/files/base/_modules/nagios_alarming.py' to '/var/cache/salt/minion/extmods/modules/nagios_alarming.py'
2017-09-15 09:10:42,650 [salt.utils.extmods][INFO    ][24672] Copying '/var/cache/salt/minion/files/base/_modules/neutronng.py' to '/var/cache/salt/minion/extmods/modules/neutronng.py'
2017-09-15 09:10:42,650 [salt.utils.extmods][INFO    ][24672] Copying '/var/cache/salt/minion/files/base/_modules/novang.py' to '/var/cache/salt/minion/extmods/modules/novang.py'
2017-09-15 09:10:42,651 [salt.utils.extmods][INFO    ][24672] Copying '/var/cache/salt/minion/files/base/_modules/reclass.py' to '/var/cache/salt/minion/extmods/modules/reclass.py'
2017-09-15 09:10:42,651 [salt.utils.extmods][INFO    ][24672] Copying '/var/cache/salt/minion/files/base/_modules/rsyslog_util.py' to '/var/cache/salt/minion/extmods/modules/rsyslog_util.py'
2017-09-15 09:10:42,651 [salt.utils.extmods][INFO    ][24672] Copying '/var/cache/salt/minion/files/base/_modules/rundeck.py' to '/var/cache/salt/minion/extmods/modules/rundeck.py'
2017-09-15 09:10:42,651 [salt.utils.extmods][INFO    ][24672] Copying '/var/cache/salt/minion/files/base/_modules/saltkey.py' to '/var/cache/salt/minion/extmods/modules/saltkey.py'
2017-09-15 09:10:42,652 [salt.utils.extmods][INFO    ][24672] Copying '/var/cache/salt/minion/files/base/_modules/saltresource.py' to '/var/cache/salt/minion/extmods/modules/saltresource.py'
2017-09-15 09:10:42,652 [salt.utils.extmods][INFO    ][24672] Copying '/var/cache/salt/minion/files/base/_modules/seedng.py' to '/var/cache/salt/minion/extmods/modules/seedng.py'
2017-09-15 09:10:42,652 [salt.utils.extmods][INFO    ][24672] Copying '/var/cache/salt/minion/files/base/_modules/testing/__init__.py' to '/var/cache/salt/minion/extmods/modules/testing/__init__.py'
2017-09-15 09:10:42,652 [salt.utils.extmods][INFO    ][24672] Copying '/var/cache/salt/minion/files/base/_modules/testing/credentials.py' to '/var/cache/salt/minion/extmods/modules/testing/credentials.py'
2017-09-15 09:10:42,652 [salt.utils.extmods][INFO    ][24672] Copying '/var/cache/salt/minion/files/base/_modules/testing/django.py' to '/var/cache/salt/minion/extmods/modules/testing/django.py'
2017-09-15 09:10:42,652 [salt.utils.extmods][INFO    ][24672] 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-15 09:10:42,653 [salt.utils.extmods][INFO    ][24672] Copying '/var/cache/salt/minion/files/base/_modules/utils.py' to '/var/cache/salt/minion/extmods/modules/utils.py'
2017-09-15 09:10:42,653 [salt.utils.extmods][INFO    ][24672] Copying '/var/cache/salt/minion/files/base/_modules/virtng.py' to '/var/cache/salt/minion/extmods/modules/virtng.py'
2017-09-15 09:10:42,657 [salt.utils.extmods][INFO    ][24672] Syncing states for environment 'base'
2017-09-15 09:10:42,657 [salt.utils.extmods][INFO    ][24672] Loading cache from salt://_states, for base)
2017-09-15 09:10:42,657 [salt.fileclient  ][INFO    ][24672] Caching directory '_states/' for environment 'base'
2017-09-15 09:10:42,709 [salt.fileclient  ][INFO    ][24672] Fetching file from saltenv 'base', ** done ** '_states/cinderng.py'
2017-09-15 09:10:42,738 [salt.fileclient  ][INFO    ][24672] Fetching file from saltenv 'base', ** done ** '_states/contrail.py'
2017-09-15 09:10:42,749 [salt.fileclient  ][INFO    ][24672] Fetching file from saltenv 'base', ** done ** '_states/gerrit.py'
2017-09-15 09:10:42,772 [salt.fileclient  ][INFO    ][24672] Fetching file from saltenv 'base', ** done ** '_states/glanceng.py'
2017-09-15 09:10:42,798 [salt.fileclient  ][INFO    ][24672] Fetching file from saltenv 'base', ** done ** '_states/grafana3_dashboard.py'
2017-09-15 09:10:42,817 [salt.fileclient  ][INFO    ][24672] Fetching file from saltenv 'base', ** done ** '_states/grafana3_datasource.py'
2017-09-15 09:10:42,864 [salt.fileclient  ][INFO    ][24672] Fetching file from saltenv 'base', ** done ** '_states/heat.py'
2017-09-15 09:10:42,877 [salt.fileclient  ][INFO    ][24672] Fetching file from saltenv 'base', ** done ** '_states/helm_release.py'
2017-09-15 09:10:42,887 [salt.fileclient  ][INFO    ][24672] Fetching file from saltenv 'base', ** done ** '_states/jenkins_approval.py'
2017-09-15 09:10:42,962 [salt.fileclient  ][INFO    ][24672] Fetching file from saltenv 'base', ** done ** '_states/jenkins_artifactory.py'
2017-09-15 09:10:43,001 [salt.fileclient  ][INFO    ][24672] Fetching file from saltenv 'base', ** done ** '_states/jenkins_credential.py'
2017-09-15 09:10:43,102 [salt.fileclient  ][INFO    ][24672] Fetching file from saltenv 'base', ** done ** '_states/jenkins_job.py'
2017-09-15 09:10:43,114 [salt.fileclient  ][INFO    ][24672] Fetching file from saltenv 'base', ** done ** '_states/jenkins_lib.py'
2017-09-15 09:10:43,135 [salt.fileclient  ][INFO    ][24672] Fetching file from saltenv 'base', ** done ** '_states/jenkins_node.py'
2017-09-15 09:10:43,160 [salt.fileclient  ][INFO    ][24672] Fetching file from saltenv 'base', ** done ** '_states/jenkins_plugin.py'
2017-09-15 09:10:43,168 [salt.fileclient  ][INFO    ][24672] Fetching file from saltenv 'base', ** done ** '_states/jenkins_security.py'
2017-09-15 09:10:43,177 [salt.fileclient  ][INFO    ][24672] Fetching file from saltenv 'base', ** done ** '_states/jenkins_slack.py'
2017-09-15 09:10:43,202 [salt.fileclient  ][INFO    ][24672] Fetching file from saltenv 'base', ** done ** '_states/jenkins_smtp.py'
2017-09-15 09:10:43,218 [salt.fileclient  ][INFO    ][24672] Fetching file from saltenv 'base', ** done ** '_states/jenkins_theme.py'
2017-09-15 09:10:43,225 [salt.fileclient  ][INFO    ][24672] Fetching file from saltenv 'base', ** done ** '_states/jenkins_user.py'
2017-09-15 09:10:43,279 [salt.fileclient  ][INFO    ][24672] Fetching file from saltenv 'base', ** done ** '_states/jenkins_view.py'
2017-09-15 09:10:43,312 [salt.fileclient  ][INFO    ][24672] Fetching file from saltenv 'base', ** done ** '_states/keystone_policy.py'
2017-09-15 09:10:43,329 [salt.fileclient  ][INFO    ][24672] Fetching file from saltenv 'base', ** done ** '_states/kibana_object.py'
2017-09-15 09:10:43,362 [salt.fileclient  ][INFO    ][24672] Fetching file from saltenv 'base', ** done ** '_states/neutronng.py'
2017-09-15 09:10:43,379 [salt.fileclient  ][INFO    ][24672] Fetching file from saltenv 'base', ** done ** '_states/novang.py'
2017-09-15 09:10:43,404 [salt.fileclient  ][INFO    ][24672] Fetching file from saltenv 'base', ** done ** '_states/reclass.py'
2017-09-15 09:10:43,453 [salt.fileclient  ][INFO    ][24672] Fetching file from saltenv 'base', ** done ** '_states/rundeck_project.py'
2017-09-15 09:10:43,499 [salt.fileclient  ][INFO    ][24672] Fetching file from saltenv 'base', ** done ** '_states/rundeck_scm.py'
2017-09-15 09:10:43,512 [salt.fileclient  ][INFO    ][24672] Fetching file from saltenv 'base', ** done ** '_states/rundeck_secret.py'
2017-09-15 09:10:43,515 [salt.utils.extmods][INFO    ][24672] Copying '/var/cache/salt/minion/files/base/_states/cinderng.py' to '/var/cache/salt/minion/extmods/states/cinderng.py'
2017-09-15 09:10:43,515 [salt.utils.extmods][INFO    ][24672] Copying '/var/cache/salt/minion/files/base/_states/contrail.py' to '/var/cache/salt/minion/extmods/states/contrail.py'
2017-09-15 09:10:43,515 [salt.utils.extmods][INFO    ][24672] Copying '/var/cache/salt/minion/files/base/_states/gerrit.py' to '/var/cache/salt/minion/extmods/states/gerrit.py'
2017-09-15 09:10:43,516 [salt.utils.extmods][INFO    ][24672] Copying '/var/cache/salt/minion/files/base/_states/glanceng.py' to '/var/cache/salt/minion/extmods/states/glanceng.py'
2017-09-15 09:10:43,516 [salt.utils.extmods][INFO    ][24672] Copying '/var/cache/salt/minion/files/base/_states/grafana3_dashboard.py' to '/var/cache/salt/minion/extmods/states/grafana3_dashboard.py'
2017-09-15 09:10:43,516 [salt.utils.extmods][INFO    ][24672] Copying '/var/cache/salt/minion/files/base/_states/grafana3_datasource.py' to '/var/cache/salt/minion/extmods/states/grafana3_datasource.py'
2017-09-15 09:10:43,516 [salt.utils.extmods][INFO    ][24672] Copying '/var/cache/salt/minion/files/base/_states/heat.py' to '/var/cache/salt/minion/extmods/states/heat.py'
2017-09-15 09:10:43,517 [salt.utils.extmods][INFO    ][24672] Copying '/var/cache/salt/minion/files/base/_states/helm_release.py' to '/var/cache/salt/minion/extmods/states/helm_release.py'
2017-09-15 09:10:43,517 [salt.utils.extmods][INFO    ][24672] Copying '/var/cache/salt/minion/files/base/_states/jenkins_approval.py' to '/var/cache/salt/minion/extmods/states/jenkins_approval.py'
2017-09-15 09:10:43,517 [salt.utils.extmods][INFO    ][24672] Copying '/var/cache/salt/minion/files/base/_states/jenkins_artifactory.py' to '/var/cache/salt/minion/extmods/states/jenkins_artifactory.py'
2017-09-15 09:10:43,517 [salt.utils.extmods][INFO    ][24672] Copying '/var/cache/salt/minion/files/base/_states/jenkins_credential.py' to '/var/cache/salt/minion/extmods/states/jenkins_credential.py'
2017-09-15 09:10:43,517 [salt.utils.extmods][INFO    ][24672] Copying '/var/cache/salt/minion/files/base/_states/jenkins_job.py' to '/var/cache/salt/minion/extmods/states/jenkins_job.py'
2017-09-15 09:10:43,517 [salt.utils.extmods][INFO    ][24672] Copying '/var/cache/salt/minion/files/base/_states/jenkins_lib.py' to '/var/cache/salt/minion/extmods/states/jenkins_lib.py'
2017-09-15 09:10:43,518 [salt.utils.extmods][INFO    ][24672] Copying '/var/cache/salt/minion/files/base/_states/jenkins_node.py' to '/var/cache/salt/minion/extmods/states/jenkins_node.py'
2017-09-15 09:10:43,518 [salt.utils.extmods][INFO    ][24672] Copying '/var/cache/salt/minion/files/base/_states/jenkins_plugin.py' to '/var/cache/salt/minion/extmods/states/jenkins_plugin.py'
2017-09-15 09:10:43,518 [salt.utils.extmods][INFO    ][24672] Copying '/var/cache/salt/minion/files/base/_states/jenkins_security.py' to '/var/cache/salt/minion/extmods/states/jenkins_security.py'
2017-09-15 09:10:43,518 [salt.utils.extmods][INFO    ][24672] Copying '/var/cache/salt/minion/files/base/_states/jenkins_slack.py' to '/var/cache/salt/minion/extmods/states/jenkins_slack.py'
2017-09-15 09:10:43,519 [salt.utils.extmods][INFO    ][24672] Copying '/var/cache/salt/minion/files/base/_states/jenkins_smtp.py' to '/var/cache/salt/minion/extmods/states/jenkins_smtp.py'
2017-09-15 09:10:43,519 [salt.utils.extmods][INFO    ][24672] Copying '/var/cache/salt/minion/files/base/_states/jenkins_theme.py' to '/var/cache/salt/minion/extmods/states/jenkins_theme.py'
2017-09-15 09:10:43,519 [salt.utils.extmods][INFO    ][24672] Copying '/var/cache/salt/minion/files/base/_states/jenkins_user.py' to '/var/cache/salt/minion/extmods/states/jenkins_user.py'
2017-09-15 09:10:43,520 [salt.utils.extmods][INFO    ][24672] Copying '/var/cache/salt/minion/files/base/_states/jenkins_view.py' to '/var/cache/salt/minion/extmods/states/jenkins_view.py'
2017-09-15 09:10:43,520 [salt.utils.extmods][INFO    ][24672] Copying '/var/cache/salt/minion/files/base/_states/keystone_policy.py' to '/var/cache/salt/minion/extmods/states/keystone_policy.py'
2017-09-15 09:10:43,520 [salt.utils.extmods][INFO    ][24672] Copying '/var/cache/salt/minion/files/base/_states/kibana_object.py' to '/var/cache/salt/minion/extmods/states/kibana_object.py'
2017-09-15 09:10:43,520 [salt.utils.extmods][INFO    ][24672] Copying '/var/cache/salt/minion/files/base/_states/maas_cluster.py' to '/var/cache/salt/minion/extmods/states/maas_cluster.py'
2017-09-15 09:10:43,520 [salt.utils.extmods][INFO    ][24672] Copying '/var/cache/salt/minion/files/base/_states/neutronng.py' to '/var/cache/salt/minion/extmods/states/neutronng.py'
2017-09-15 09:10:43,521 [salt.utils.extmods][INFO    ][24672] Copying '/var/cache/salt/minion/files/base/_states/novang.py' to '/var/cache/salt/minion/extmods/states/novang.py'
2017-09-15 09:10:43,521 [salt.utils.extmods][INFO    ][24672] Copying '/var/cache/salt/minion/files/base/_states/reclass.py' to '/var/cache/salt/minion/extmods/states/reclass.py'
2017-09-15 09:10:43,521 [salt.utils.extmods][INFO    ][24672] Copying '/var/cache/salt/minion/files/base/_states/rundeck_project.py' to '/var/cache/salt/minion/extmods/states/rundeck_project.py'
2017-09-15 09:10:43,521 [salt.utils.extmods][INFO    ][24672] Copying '/var/cache/salt/minion/files/base/_states/rundeck_scm.py' to '/var/cache/salt/minion/extmods/states/rundeck_scm.py'
2017-09-15 09:10:43,522 [salt.utils.extmods][INFO    ][24672] Copying '/var/cache/salt/minion/files/base/_states/rundeck_secret.py' to '/var/cache/salt/minion/extmods/states/rundeck_secret.py'
2017-09-15 09:10:43,523 [salt.utils.extmods][INFO    ][24672] Creating module dir '/var/cache/salt/minion/extmods/sdb'
2017-09-15 09:10:43,526 [salt.utils.extmods][INFO    ][24672] Syncing sdb for environment 'base'
2017-09-15 09:10:43,526 [salt.utils.extmods][INFO    ][24672] Loading cache from salt://_sdb, for base)
2017-09-15 09:10:43,526 [salt.fileclient  ][INFO    ][24672] Caching directory '_sdb/' for environment 'base'
2017-09-15 09:10:43,658 [salt.utils.extmods][INFO    ][24672] Syncing grains for environment 'base'
2017-09-15 09:10:43,658 [salt.utils.extmods][INFO    ][24672] Loading cache from salt://_grains, for base)
2017-09-15 09:10:43,659 [salt.fileclient  ][INFO    ][24672] Caching directory '_grains/' for environment 'base'
2017-09-15 09:10:43,762 [salt.fileclient  ][INFO    ][24672] Fetching file from saltenv 'base', ** done ** '_grains/ceilometer_policy.py'
2017-09-15 09:10:43,778 [salt.fileclient  ][INFO    ][24672] Fetching file from saltenv 'base', ** done ** '_grains/cinder_policy.py'
2017-09-15 09:10:43,839 [salt.fileclient  ][INFO    ][24672] Fetching file from saltenv 'base', ** done ** '_grains/docker_swarm.py'
2017-09-15 09:10:43,850 [salt.fileclient  ][INFO    ][24672] Fetching file from saltenv 'base', ** done ** '_grains/glance_policy.py'
2017-09-15 09:10:43,860 [salt.fileclient  ][INFO    ][24672] Fetching file from saltenv 'base', ** done ** '_grains/heat_policy.py'
2017-09-15 09:10:43,886 [salt.fileclient  ][INFO    ][24672] Fetching file from saltenv 'base', ** done ** '_grains/jenkins_plugins.py'
2017-09-15 09:10:43,893 [salt.fileclient  ][INFO    ][24672] Fetching file from saltenv 'base', ** done ** '_grains/keystone_policy.py'
2017-09-15 09:10:43,910 [salt.fileclient  ][INFO    ][24672] Fetching file from saltenv 'base', ** done ** '_grains/kubernetes.py'
2017-09-15 09:10:43,922 [salt.fileclient  ][INFO    ][24672] Fetching file from saltenv 'base', ** done ** '_grains/neutron_policy.py'
2017-09-15 09:10:44,000 [salt.fileclient  ][INFO    ][24672] Fetching file from saltenv 'base', ** done ** '_grains/nova_policy.py'
2017-09-15 09:10:44,011 [salt.fileclient  ][INFO    ][24672] Fetching file from saltenv 'base', ** done ** '_grains/ssh_fingerprints.py'
2017-09-15 09:10:44,014 [salt.utils.extmods][INFO    ][24672] Copying '/var/cache/salt/minion/files/base/_grains/ceilometer_policy.py' to '/var/cache/salt/minion/extmods/grains/ceilometer_policy.py'
2017-09-15 09:10:44,014 [salt.utils.extmods][INFO    ][24672] Copying '/var/cache/salt/minion/files/base/_grains/cinder_policy.py' to '/var/cache/salt/minion/extmods/grains/cinder_policy.py'
2017-09-15 09:10:44,015 [salt.utils.extmods][INFO    ][24672] Copying '/var/cache/salt/minion/files/base/_grains/docker_swarm.py' to '/var/cache/salt/minion/extmods/grains/docker_swarm.py'
2017-09-15 09:10:44,015 [salt.utils.extmods][INFO    ][24672] Copying '/var/cache/salt/minion/files/base/_grains/glance_policy.py' to '/var/cache/salt/minion/extmods/grains/glance_policy.py'
2017-09-15 09:10:44,015 [salt.utils.extmods][INFO    ][24672] Copying '/var/cache/salt/minion/files/base/_grains/heat_policy.py' to '/var/cache/salt/minion/extmods/grains/heat_policy.py'
2017-09-15 09:10:44,015 [salt.utils.extmods][INFO    ][24672] Copying '/var/cache/salt/minion/files/base/_grains/jenkins_plugins.py' to '/var/cache/salt/minion/extmods/grains/jenkins_plugins.py'
2017-09-15 09:10:44,015 [salt.utils.extmods][INFO    ][24672] Copying '/var/cache/salt/minion/files/base/_grains/keystone_policy.py' to '/var/cache/salt/minion/extmods/grains/keystone_policy.py'
2017-09-15 09:10:44,016 [salt.utils.extmods][INFO    ][24672] Copying '/var/cache/salt/minion/files/base/_grains/kubernetes.py' to '/var/cache/salt/minion/extmods/grains/kubernetes.py'
2017-09-15 09:10:44,016 [salt.utils.extmods][INFO    ][24672] Copying '/var/cache/salt/minion/files/base/_grains/neutron_policy.py' to '/var/cache/salt/minion/extmods/grains/neutron_policy.py'
2017-09-15 09:10:44,016 [salt.utils.extmods][INFO    ][24672] Copying '/var/cache/salt/minion/files/base/_grains/nova_policy.py' to '/var/cache/salt/minion/extmods/grains/nova_policy.py'
2017-09-15 09:10:44,016 [salt.utils.extmods][INFO    ][24672] Copying '/var/cache/salt/minion/files/base/_grains/ssh_fingerprints.py' to '/var/cache/salt/minion/extmods/grains/ssh_fingerprints.py'
2017-09-15 09:10:44,017 [salt.utils.extmods][INFO    ][24672] Creating module dir '/var/cache/salt/minion/extmods/renderers'
2017-09-15 09:10:44,020 [salt.utils.extmods][INFO    ][24672] Syncing renderers for environment 'base'
2017-09-15 09:10:44,020 [salt.utils.extmods][INFO    ][24672] Loading cache from salt://_renderers, for base)
2017-09-15 09:10:44,020 [salt.fileclient  ][INFO    ][24672] Caching directory '_renderers/' for environment 'base'
2017-09-15 09:10:44,041 [salt.utils.extmods][INFO    ][24672] Creating module dir '/var/cache/salt/minion/extmods/returners'
2017-09-15 09:10:44,044 [salt.utils.extmods][INFO    ][24672] Syncing returners for environment 'base'
2017-09-15 09:10:44,044 [salt.utils.extmods][INFO    ][24672] Loading cache from salt://_returners, for base)
2017-09-15 09:10:44,044 [salt.fileclient  ][INFO    ][24672] Caching directory '_returners/' for environment 'base'
2017-09-15 09:10:44,089 [salt.utils.extmods][INFO    ][24672] Creating module dir '/var/cache/salt/minion/extmods/output'
2017-09-15 09:10:44,091 [salt.utils.extmods][INFO    ][24672] Syncing output for environment 'base'
2017-09-15 09:10:44,092 [salt.utils.extmods][INFO    ][24672] Loading cache from salt://_output, for base)
2017-09-15 09:10:44,092 [salt.fileclient  ][INFO    ][24672] Caching directory '_output/' for environment 'base'
2017-09-15 09:10:44,152 [salt.utils.extmods][INFO    ][24672] Creating module dir '/var/cache/salt/minion/extmods/utils'
2017-09-15 09:10:44,154 [salt.utils.extmods][INFO    ][24672] Syncing utils for environment 'base'
2017-09-15 09:10:44,154 [salt.utils.extmods][INFO    ][24672] Loading cache from salt://_utils, for base)
2017-09-15 09:10:44,155 [salt.fileclient  ][INFO    ][24672] Caching directory '_utils/' for environment 'base'
2017-09-15 09:10:44,214 [salt.utils.extmods][INFO    ][24672] Creating module dir '/var/cache/salt/minion/extmods/log_handlers'
2017-09-15 09:10:44,216 [salt.utils.extmods][INFO    ][24672] Syncing log_handlers for environment 'base'
2017-09-15 09:10:44,217 [salt.utils.extmods][INFO    ][24672] Loading cache from salt://_log_handlers, for base)
2017-09-15 09:10:44,217 [salt.fileclient  ][INFO    ][24672] Caching directory '_log_handlers/' for environment 'base'
2017-09-15 09:10:44,251 [salt.utils.extmods][INFO    ][24672] Creating module dir '/var/cache/salt/minion/extmods/proxy'
2017-09-15 09:10:44,253 [salt.utils.extmods][INFO    ][24672] Syncing proxy for environment 'base'
2017-09-15 09:10:44,253 [salt.utils.extmods][INFO    ][24672] Loading cache from salt://_proxy, for base)
2017-09-15 09:10:44,253 [salt.fileclient  ][INFO    ][24672] Caching directory '_proxy/' for environment 'base'
2017-09-15 09:10:44,332 [salt.utils.extmods][INFO    ][24672] Creating module dir '/var/cache/salt/minion/extmods/engines'
2017-09-15 09:10:44,334 [salt.utils.extmods][INFO    ][24672] Syncing engines for environment 'base'
2017-09-15 09:10:44,334 [salt.utils.extmods][INFO    ][24672] Loading cache from salt://_engines, for base)
2017-09-15 09:10:44,335 [salt.fileclient  ][INFO    ][24672] Caching directory '_engines/' for environment 'base'
2017-09-15 09:10:44,420 [salt.minion      ][INFO    ][24672] Returning information for job: 20170915091037770686
2017-09-15 09:20:13,290 [salt.minion      ][INFO    ][24160] User sudo_ubuntu Executing command test.ping with jid 20170915092013278957
2017-09-15 09:20:13,306 [salt.minion      ][INFO    ][24950] Starting a new job with PID 24950
2017-09-15 09:20:13,330 [salt.minion      ][INFO    ][24950] Returning information for job: 20170915092013278957
2017-09-15 09:21:35,785 [salt.minion      ][INFO    ][24160] User sudo_ubuntu Executing command state.sls with jid 20170915092135773107
2017-09-15 09:21:35,801 [salt.minion      ][INFO    ][24976] Starting a new job with PID 24976
2017-09-15 09:21:37,304 [salt.state       ][INFO    ][24976] Loading fresh modules for state activity
2017-09-15 09:21:37,331 [salt.fileclient  ][INFO    ][24976] Fetching file from saltenv 'base', ** done ** 'keepalived/init.sls'
2017-09-15 09:21:37,349 [salt.fileclient  ][INFO    ][24976] Fetching file from saltenv 'base', ** done ** 'keepalived/cluster.sls'
2017-09-15 09:21:37,374 [salt.fileclient  ][INFO    ][24976] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-09-15 09:21:37,668 [salt.state       ][INFO    ][24976] Running state [lsof] at time 09:21:37.667877
2017-09-15 09:21:37,668 [salt.state       ][INFO    ][24976] Executing state pkg.installed for lsof
2017-09-15 09:21:37,669 [salt.loaded.int.module.cmdmod][INFO    ][24976] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-15 09:21:37,949 [salt.state       ][INFO    ][24976] Package lsof is already installed
2017-09-15 09:21:37,949 [salt.state       ][INFO    ][24976] Completed state [lsof] at time 09:21:37.949407 duration_in_ms=281.529
2017-09-15 09:21:37,950 [salt.state       ][INFO    ][24976] Running state [keepalived] at time 09:21:37.949600
2017-09-15 09:21:37,950 [salt.state       ][INFO    ][24976] Executing state pkg.installed for keepalived
2017-09-15 09:21:37,966 [salt.loaded.int.module.cmdmod][INFO    ][24976] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-09-15 09:21:39,913 [salt.loaded.int.module.cmdmod][INFO    ][24976] 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-15 09:21:45,829 [salt.minion      ][INFO    ][24160] User sudo_ubuntu Executing command saltutil.find_job with jid 20170915092145816208
2017-09-15 09:21:45,844 [salt.minion      ][INFO    ][26294] Starting a new job with PID 26294
2017-09-15 09:21:45,853 [salt.minion      ][INFO    ][26294] Returning information for job: 20170915092145816208
2017-09-15 09:21:47,879 [salt.loaded.int.module.cmdmod][INFO    ][24976] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-15 09:21:47,903 [salt.state       ][INFO    ][24976] 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-15 09:21:47,912 [salt.state       ][INFO    ][24976] Loading fresh modules for state activity
2017-09-15 09:21:47,924 [salt.state       ][INFO    ][24976] Completed state [keepalived] at time 09:21:47.923509 duration_in_ms=9973.908
2017-09-15 09:21:47,925 [salt.state       ][INFO    ][24976] Running state [/etc/keepalived/keepalived.conf] at time 09:21:47.925203
2017-09-15 09:21:47,925 [salt.state       ][INFO    ][24976] Executing state file.managed for /etc/keepalived/keepalived.conf
2017-09-15 09:21:47,952 [salt.fileclient  ][INFO    ][24976] Fetching file from saltenv 'base', ** done ** 'keepalived/files/keepalived.conf'
2017-09-15 09:21:47,981 [salt.fileclient  ][INFO    ][24976] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-09-15 09:21:47,987 [salt.state       ][INFO    ][24976] File changed:
New file
2017-09-15 09:21:47,987 [salt.state       ][INFO    ][24976] Completed state [/etc/keepalived/keepalived.conf] at time 09:21:47.987331 duration_in_ms=62.128
2017-09-15 09:21:48,042 [salt.state       ][INFO    ][24976] Running state [keepalived] at time 09:21:48.042280
2017-09-15 09:21:48,043 [salt.state       ][INFO    ][24976] Executing state service.running for keepalived
2017-09-15 09:21:48,044 [salt.loaded.int.module.cmdmod][INFO    ][24976] Executing command ['systemctl', 'status', 'keepalived.service', '-n', '0'] in directory '/root'
2017-09-15 09:21:48,053 [salt.loaded.int.module.cmdmod][INFO    ][24976] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2017-09-15 09:21:48,060 [salt.loaded.int.module.cmdmod][INFO    ][24976] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-09-15 09:21:48,069 [salt.loaded.int.module.cmdmod][INFO    ][24976] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-09-15 09:21:48,078 [salt.loaded.int.module.cmdmod][INFO    ][24976] Executing command ['systemd-run', '--scope', 'systemctl', 'start', 'keepalived.service'] in directory '/root'
2017-09-15 09:21:48,133 [salt.loaded.int.module.cmdmod][INFO    ][24976] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2017-09-15 09:21:48,143 [salt.loaded.int.module.cmdmod][INFO    ][24976] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-09-15 09:21:48,152 [salt.loaded.int.module.cmdmod][INFO    ][24976] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-09-15 09:21:48,159 [salt.state       ][INFO    ][24976] {'keepalived': True}
2017-09-15 09:21:48,159 [salt.state       ][INFO    ][24976] Completed state [keepalived] at time 09:21:48.159116 duration_in_ms=116.837
2017-09-15 09:21:48,160 [salt.minion      ][INFO    ][24976] Returning information for job: 20170915092135773107
2017-09-15 09:24:12,403 [salt.minion      ][INFO    ][24160] User sudo_ubuntu Executing command pillar.get with jid 20170915092412397304
2017-09-15 09:24:12,423 [salt.minion      ][INFO    ][26606] Starting a new job with PID 26606
2017-09-15 09:24:12,427 [salt.minion      ][INFO    ][26606] Returning information for job: 20170915092412397304
2017-09-15 09:29:29,818 [salt.minion      ][INFO    ][24160] User sudo_ubuntu Executing command state.sls with jid 20170915092929810305
2017-09-15 09:29:29,834 [salt.minion      ][INFO    ][26719] Starting a new job with PID 26719
2017-09-15 09:29:31,288 [salt.state       ][INFO    ][26719] Loading fresh modules for state activity
2017-09-15 09:29:31,310 [salt.fileclient  ][INFO    ][26719] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-09-15 09:29:31,330 [salt.fileclient  ][INFO    ][26719] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-09-15 09:29:31,604 [salt.state       ][INFO    ][26719] Running state [attr] at time 09:29:31.604024
2017-09-15 09:29:31,604 [salt.state       ][INFO    ][26719] Executing state pkg.installed for attr
2017-09-15 09:29:31,605 [salt.loaded.int.module.cmdmod][INFO    ][26719] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-15 09:29:31,882 [salt.loaded.int.module.cmdmod][INFO    ][26719] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-09-15 09:29:33,824 [salt.loaded.int.module.cmdmod][INFO    ][26719] 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-15 09:29:36,370 [salt.loaded.int.module.cmdmod][INFO    ][26719] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-15 09:29:36,394 [salt.state       ][INFO    ][26719] Made the following changes:
'attr' changed from 'absent' to '1:2.4.47-2'

2017-09-15 09:29:36,402 [salt.state       ][INFO    ][26719] Loading fresh modules for state activity
2017-09-15 09:29:36,414 [salt.state       ][INFO    ][26719] Completed state [attr] at time 09:29:36.413758 duration_in_ms=4809.734
2017-09-15 09:29:36,419 [salt.state       ][INFO    ][26719] Running state [glusterfs-server] at time 09:29:36.418761
2017-09-15 09:29:36,419 [salt.state       ][INFO    ][26719] Executing state pkg.installed for glusterfs-server
2017-09-15 09:29:36,599 [salt.loaded.int.module.cmdmod][INFO    ][26719] 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-15 09:29:39,909 [salt.minion      ][INFO    ][24160] User sudo_ubuntu Executing command saltutil.find_job with jid 20170915092939894978
2017-09-15 09:29:39,924 [salt.minion      ][INFO    ][27778] Starting a new job with PID 27778
2017-09-15 09:29:39,946 [salt.minion      ][INFO    ][27778] Returning information for job: 20170915092939894978
2017-09-15 09:29:50,113 [salt.minion      ][INFO    ][24160] User sudo_ubuntu Executing command saltutil.find_job with jid 20170915092950100257
2017-09-15 09:29:50,128 [salt.minion      ][INFO    ][30615] Starting a new job with PID 30615
2017-09-15 09:29:50,139 [salt.minion      ][INFO    ][30615] Returning information for job: 20170915092950100257
2017-09-15 09:29:53,811 [salt.loaded.int.module.cmdmod][INFO    ][26719] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-15 09:29:53,835 [salt.state       ][INFO    ][26719] 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-15 09:29:53,842 [salt.state       ][INFO    ][26719] Loading fresh modules for state activity
2017-09-15 09:29:53,854 [salt.state       ][INFO    ][26719] Completed state [glusterfs-server] at time 09:29:53.853650 duration_in_ms=17434.889
2017-09-15 09:29:53,858 [salt.state       ][INFO    ][26719] Running state [bc] at time 09:29:53.857954
2017-09-15 09:29:53,858 [salt.state       ][INFO    ][26719] Executing state pkg.installed for bc
2017-09-15 09:29:54,109 [salt.loaded.int.module.cmdmod][INFO    ][26719] 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-15 09:29:56,972 [salt.loaded.int.module.cmdmod][INFO    ][26719] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-15 09:29:56,998 [salt.state       ][INFO    ][26719] Made the following changes:
'bc' changed from 'absent' to '1.06.95-9build1'

2017-09-15 09:29:57,007 [salt.state       ][INFO    ][26719] Loading fresh modules for state activity
2017-09-15 09:29:57,020 [salt.state       ][INFO    ][26719] Completed state [bc] at time 09:29:57.019566 duration_in_ms=3161.612
2017-09-15 09:29:57,091 [salt.state       ][INFO    ][26719] Running state [glusterfs-server] at time 09:29:57.091403
2017-09-15 09:29:57,092 [salt.state       ][INFO    ][26719] Executing state service.running for glusterfs-server
2017-09-15 09:29:57,093 [salt.loaded.int.module.cmdmod][INFO    ][26719] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-09-15 09:29:57,104 [salt.loaded.int.module.cmdmod][INFO    ][26719] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-09-15 09:29:57,112 [salt.loaded.int.module.cmdmod][INFO    ][26719] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-09-15 09:29:57,122 [salt.state       ][INFO    ][26719] The service glusterfs-server is already running
2017-09-15 09:29:57,122 [salt.state       ][INFO    ][26719] Completed state [glusterfs-server] at time 09:29:57.122290 duration_in_ms=30.886
2017-09-15 09:29:57,124 [salt.state       ][INFO    ][26719] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 09:29:57.123778
2017-09-15 09:29:57,124 [salt.state       ][INFO    ][26719] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-09-15 09:29:57,133 [salt.state       ][INFO    ][26719] File changed:
New file
2017-09-15 09:29:57,134 [salt.state       ][INFO    ][26719] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 09:29:57.133485 duration_in_ms=9.707
2017-09-15 09:29:57,134 [salt.state       ][INFO    ][26719] Running state [/srv/glusterfs/glance] at time 09:29:57.133664
2017-09-15 09:29:57,134 [salt.state       ][INFO    ][26719] Executing state file.directory for /srv/glusterfs/glance
2017-09-15 09:29:57,134 [salt.state       ][INFO    ][26719] {'/srv/glusterfs/glance': 'New Dir'}
2017-09-15 09:29:57,135 [salt.state       ][INFO    ][26719] Completed state [/srv/glusterfs/glance] at time 09:29:57.134583 duration_in_ms=0.92
2017-09-15 09:29:57,135 [salt.state       ][INFO    ][26719] Running state [/srv/glusterfs/keystone-keys] at time 09:29:57.134744
2017-09-15 09:29:57,135 [salt.state       ][INFO    ][26719] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-09-15 09:29:57,135 [salt.state       ][INFO    ][26719] {'/srv/glusterfs/keystone-keys': 'New Dir'}
2017-09-15 09:29:57,135 [salt.state       ][INFO    ][26719] Completed state [/srv/glusterfs/keystone-keys] at time 09:29:57.135446 duration_in_ms=0.702
2017-09-15 09:29:57,136 [salt.state       ][INFO    ][26719] Running state [/srv/glusterfs/nova_instances] at time 09:29:57.135609
2017-09-15 09:29:57,136 [salt.state       ][INFO    ][26719] Executing state file.directory for /srv/glusterfs/nova_instances
2017-09-15 09:29:57,136 [salt.state       ][INFO    ][26719] {'/srv/glusterfs/nova_instances': 'New Dir'}
2017-09-15 09:29:57,136 [salt.state       ][INFO    ][26719] Completed state [/srv/glusterfs/nova_instances] at time 09:29:57.136333 duration_in_ms=0.724
2017-09-15 09:29:57,137 [salt.state       ][INFO    ][26719] Running state [/srv/glusterfs/keystone-credential-keys] at time 09:29:57.136497
2017-09-15 09:29:57,137 [salt.state       ][INFO    ][26719] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-09-15 09:29:57,137 [salt.state       ][INFO    ][26719] {'/srv/glusterfs/keystone-credential-keys': 'New Dir'}
2017-09-15 09:29:57,137 [salt.state       ][INFO    ][26719] Completed state [/srv/glusterfs/keystone-credential-keys] at time 09:29:57.137203 duration_in_ms=0.706
2017-09-15 09:29:57,138 [salt.minion      ][INFO    ][26719] Returning information for job: 20170915092929810305
2017-09-15 09:29:59,736 [salt.minion      ][INFO    ][24160] User sudo_ubuntu Executing command test.ping with jid 20170915092959730447
2017-09-15 09:29:59,750 [salt.minion      ][INFO    ][31460] Starting a new job with PID 31460
2017-09-15 09:29:59,777 [salt.minion      ][INFO    ][31460] Returning information for job: 20170915092959730447
2017-09-15 09:30:40,813 [salt.minion      ][INFO    ][24160] User sudo_ubuntu Executing command state.sls with jid 20170915093040804826
2017-09-15 09:30:40,829 [salt.minion      ][INFO    ][31676] Starting a new job with PID 31676
2017-09-15 09:30:42,274 [salt.state       ][INFO    ][31676] Loading fresh modules for state activity
2017-09-15 09:30:42,297 [salt.fileclient  ][INFO    ][31676] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/setup.sls'
2017-09-15 09:30:42,328 [salt.fileclient  ][INFO    ][31676] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-09-15 09:30:42,385 [salt.fileclient  ][INFO    ][31676] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-09-15 09:30:42,402 [salt.fileclient  ][INFO    ][31676] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-09-15 09:30:42,655 [salt.state       ][INFO    ][31676] Running state [attr] at time 09:30:42.655192
2017-09-15 09:30:42,655 [salt.state       ][INFO    ][31676] Executing state pkg.installed for attr
2017-09-15 09:30:42,656 [salt.loaded.int.module.cmdmod][INFO    ][31676] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-09-15 09:30:42,935 [salt.state       ][INFO    ][31676] Package attr is already installed
2017-09-15 09:30:42,936 [salt.state       ][INFO    ][31676] Completed state [attr] at time 09:30:42.935547 duration_in_ms=280.355
2017-09-15 09:30:42,936 [salt.state       ][INFO    ][31676] Running state [glusterfs-server] at time 09:30:42.935745
2017-09-15 09:30:42,936 [salt.state       ][INFO    ][31676] Executing state pkg.installed for glusterfs-server
2017-09-15 09:30:42,938 [salt.state       ][INFO    ][31676] Package glusterfs-server is already installed
2017-09-15 09:30:42,939 [salt.state       ][INFO    ][31676] Completed state [glusterfs-server] at time 09:30:42.938557 duration_in_ms=2.813
2017-09-15 09:30:42,939 [salt.state       ][INFO    ][31676] Running state [bc] at time 09:30:42.938693
2017-09-15 09:30:42,939 [salt.state       ][INFO    ][31676] Executing state pkg.installed for bc
2017-09-15 09:30:42,941 [salt.state       ][INFO    ][31676] Package bc is already installed
2017-09-15 09:30:42,941 [salt.state       ][INFO    ][31676] Completed state [bc] at time 09:30:42.941363 duration_in_ms=2.67
2017-09-15 09:30:42,942 [salt.state       ][INFO    ][31676] Running state [glusterfs-server] at time 09:30:42.942152
2017-09-15 09:30:42,942 [salt.state       ][INFO    ][31676] Executing state service.running for glusterfs-server
2017-09-15 09:30:42,943 [salt.loaded.int.module.cmdmod][INFO    ][31676] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-09-15 09:30:42,953 [salt.loaded.int.module.cmdmod][INFO    ][31676] Executing command ['systemctl', '--system', 'daemon-reload'] in directory '/root'
2017-09-15 09:30:42,999 [salt.loaded.int.module.cmdmod][INFO    ][31676] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-09-15 09:30:43,013 [salt.loaded.int.module.cmdmod][INFO    ][31676] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-09-15 09:30:43,019 [salt.loaded.int.module.cmdmod][INFO    ][31676] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-09-15 09:30:43,027 [salt.state       ][INFO    ][31676] The service glusterfs-server is already running
2017-09-15 09:30:43,028 [salt.state       ][INFO    ][31676] Completed state [glusterfs-server] at time 09:30:43.027684 duration_in_ms=85.531
2017-09-15 09:30:43,029 [salt.state       ][INFO    ][31676] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 09:30:43.029053
2017-09-15 09:30:43,029 [salt.state       ][INFO    ][31676] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-09-15 09:30:43,040 [salt.state       ][INFO    ][31676] File /etc/systemd/system/glusterfs-server.service.d/override.conf is in the correct state
2017-09-15 09:30:43,040 [salt.state       ][INFO    ][31676] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 09:30:43.039924 duration_in_ms=10.871
2017-09-15 09:30:43,040 [salt.state       ][INFO    ][31676] Running state [/srv/glusterfs/glance] at time 09:30:43.040097
2017-09-15 09:30:43,040 [salt.state       ][INFO    ][31676] Executing state file.directory for /srv/glusterfs/glance
2017-09-15 09:30:43,041 [salt.state       ][INFO    ][31676] Directory /srv/glusterfs/glance is in the correct state
2017-09-15 09:30:43,041 [salt.state       ][INFO    ][31676] Completed state [/srv/glusterfs/glance] at time 09:30:43.040719 duration_in_ms=0.623
2017-09-15 09:30:43,041 [salt.state       ][INFO    ][31676] Running state [/srv/glusterfs/keystone-keys] at time 09:30:43.040860
2017-09-15 09:30:43,041 [salt.state       ][INFO    ][31676] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-09-15 09:30:43,041 [salt.state       ][INFO    ][31676] Directory /srv/glusterfs/keystone-keys is in the correct state
2017-09-15 09:30:43,041 [salt.state       ][INFO    ][31676] Completed state [/srv/glusterfs/keystone-keys] at time 09:30:43.041413 duration_in_ms=0.553
2017-09-15 09:30:43,042 [salt.state       ][INFO    ][31676] Running state [/srv/glusterfs/nova_instances] at time 09:30:43.041552
2017-09-15 09:30:43,042 [salt.state       ][INFO    ][31676] Executing state file.directory for /srv/glusterfs/nova_instances
2017-09-15 09:30:43,042 [salt.state       ][INFO    ][31676] Directory /srv/glusterfs/nova_instances is in the correct state
2017-09-15 09:30:43,042 [salt.state       ][INFO    ][31676] Completed state [/srv/glusterfs/nova_instances] at time 09:30:43.042126 duration_in_ms=0.573
2017-09-15 09:30:43,042 [salt.state       ][INFO    ][31676] Running state [/srv/glusterfs/keystone-credential-keys] at time 09:30:43.042264
2017-09-15 09:30:43,042 [salt.state       ][INFO    ][31676] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-09-15 09:30:43,043 [salt.state       ][INFO    ][31676] Directory /srv/glusterfs/keystone-credential-keys is in the correct state
2017-09-15 09:30:43,043 [salt.state       ][INFO    ][31676] Completed state [/srv/glusterfs/keystone-credential-keys] at time 09:30:43.042826 duration_in_ms=0.562
2017-09-15 09:30:43,092 [salt.loaded.int.module.cmdmod][INFO    ][31676] Executing command ['git', '--version'] in directory '/root'
2017-09-15 09:30:43,179 [salt.state       ][INFO    ][31676] Running state [sleep 5] at time 09:30:43.178783
2017-09-15 09:30:43,179 [salt.state       ][INFO    ][31676] Executing state cmd.wait for sleep 5
2017-09-15 09:30:43,179 [salt.state       ][INFO    ][31676] No changes made for sleep 5
2017-09-15 09:30:43,179 [salt.state       ][INFO    ][31676] Completed state [sleep 5] at time 09:30:43.179321 duration_in_ms=0.538
2017-09-15 09:30:43,180 [salt.state       ][INFO    ][31676] Running state [10.167.4.141] at time 09:30:43.179689
2017-09-15 09:30:43,180 [salt.state       ][INFO    ][31676] Executing state glusterfs.peered for 10.167.4.141
2017-09-15 09:30:43,180 [salt.loaded.int.module.cmdmod][INFO    ][31676] Executing command 'gluster --version' in directory '/root'
2017-09-15 09:30:43,189 [salt.loaded.int.module.cmdmod][INFO    ][31676] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-15 09:30:43,237 [salt.state       ][INFO    ][31676] Host 10.167.4.141 already peered
2017-09-15 09:30:43,237 [salt.state       ][INFO    ][31676] Completed state [10.167.4.141] at time 09:30:43.236986 duration_in_ms=57.296
2017-09-15 09:30:43,239 [salt.state       ][INFO    ][31676] Running state [10.167.4.142] at time 09:30:43.239217
2017-09-15 09:30:43,239 [salt.state       ][INFO    ][31676] Executing state glusterfs.peered for 10.167.4.142
2017-09-15 09:30:43,240 [salt.loaded.int.module.cmdmod][INFO    ][31676] Executing command 'gluster --version' in directory '/root'
2017-09-15 09:30:43,248 [salt.loaded.int.module.cmdmod][INFO    ][31676] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-15 09:30:43,297 [salt.loaded.int.module.cmdmod][INFO    ][31676] Executing command 'gluster --version' in directory '/root'
2017-09-15 09:30:43,305 [salt.loaded.int.module.cmdmod][INFO    ][31676] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-15 09:30:43,354 [salt.loaded.int.module.cmdmod][INFO    ][31676] Executing command 'gluster --version' in directory '/root'
2017-09-15 09:30:43,362 [salt.loaded.int.module.cmdmod][INFO    ][31676] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-15 09:30:43,410 [salt.loaded.int.module.cmdmod][INFO    ][31676] Executing command 'gluster --version' in directory '/root'
2017-09-15 09:30:43,418 [salt.loaded.int.module.cmdmod][INFO    ][31676] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-15 09:30:43,465 [salt.state       ][INFO    ][31676] Peering with localhost is not needed
2017-09-15 09:30:43,465 [salt.state       ][INFO    ][31676] Completed state [10.167.4.142] at time 09:30:43.464895 duration_in_ms=225.678
2017-09-15 09:30:43,467 [salt.state       ][INFO    ][31676] Running state [10.167.4.143] at time 09:30:43.467165
2017-09-15 09:30:43,467 [salt.state       ][INFO    ][31676] Executing state glusterfs.peered for 10.167.4.143
2017-09-15 09:30:43,468 [salt.loaded.int.module.cmdmod][INFO    ][31676] Executing command 'gluster --version' in directory '/root'
2017-09-15 09:30:43,477 [salt.loaded.int.module.cmdmod][INFO    ][31676] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-15 09:30:43,525 [salt.loaded.int.module.cmdmod][INFO    ][31676] Executing command 'gluster --version' in directory '/root'
2017-09-15 09:30:43,533 [salt.loaded.int.module.cmdmod][INFO    ][31676] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-15 09:30:43,589 [salt.loaded.int.module.cmdmod][INFO    ][31676] Executing command 'gluster --version' in directory '/root'
2017-09-15 09:30:43,598 [salt.loaded.int.module.cmdmod][INFO    ][31676] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-15 09:30:43,658 [salt.loaded.int.module.cmdmod][INFO    ][31676] Executing command 'gluster --version' in directory '/root'
2017-09-15 09:30:43,666 [salt.loaded.int.module.cmdmod][INFO    ][31676] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-15 09:30:43,714 [salt.state       ][INFO    ][31676] {'new': {'kvm03.baremetal-mcp-ocata-ovs-dpdk-ha.local': ['10.167.4.143'], '10.167.4.141': []}, 'old': {'kvm03.baremetal-mcp-ocata-ovs-dpdk-ha.local': [], '10.167.4.141': []}}
2017-09-15 09:30:43,715 [salt.state       ][INFO    ][31676] Completed state [10.167.4.143] at time 09:30:43.714498 duration_in_ms=247.333
2017-09-15 09:30:43,715 [salt.state       ][INFO    ][31676] Running state [glance] at time 09:30:43.715263
2017-09-15 09:30:43,715 [salt.state       ][INFO    ][31676] Executing state glusterfs.created for glance
2017-09-15 09:30:43,716 [salt.loaded.int.module.cmdmod][INFO    ][31676] Executing command 'gluster --version' in directory '/root'
2017-09-15 09:30:43,724 [salt.loaded.int.module.cmdmod][INFO    ][31676] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-15 09:30:43,772 [salt.loaded.int.module.cmdmod][INFO    ][31676] Executing command 'gluster --version' in directory '/root'
2017-09-15 09:30:43,779 [salt.loaded.int.module.cmdmod][INFO    ][31676] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-15 09:30:43,831 [salt.state       ][INFO    ][31676] Volume glance already exists and is started.
2017-09-15 09:30:43,832 [salt.state       ][INFO    ][31676] Completed state [glance] at time 09:30:43.831672 duration_in_ms=116.408
2017-09-15 09:30:43,834 [salt.state       ][INFO    ][31676] Running state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 09:30:43.834269
2017-09-15 09:30:43,835 [salt.state       ][INFO    ][31676] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'
2017-09-15 09:30:43,835 [salt.loaded.int.module.cmdmod][INFO    ][31676] Executing command 'gluster volume info 'glance' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-09-15 09:30:43,883 [salt.state       ][INFO    ][31676] unless execution succeeded
2017-09-15 09:30:43,883 [salt.state       ][INFO    ][31676] Completed state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 09:30:43.883032 duration_in_ms=48.763
2017-09-15 09:30:43,884 [salt.state       ][INFO    ][31676] Running state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 09:30:43.883486
2017-09-15 09:30:43,884 [salt.state       ][INFO    ][31676] Executing state cmd.run for gluster volume set 'glance' 'network.remote-dio' 'True'
2017-09-15 09:30:43,884 [salt.loaded.int.module.cmdmod][INFO    ][31676] Executing command 'gluster volume info 'glance' | grep 'network.remote-dio: True'' in directory '/root'
2017-09-15 09:30:43,931 [salt.state       ][INFO    ][31676] unless execution succeeded
2017-09-15 09:30:43,931 [salt.state       ][INFO    ][31676] Completed state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 09:30:43.931438 duration_in_ms=47.951
2017-09-15 09:30:43,932 [salt.state       ][INFO    ][31676] Running state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 09:30:43.931900
2017-09-15 09:30:43,932 [salt.state       ][INFO    ][31676] Executing state cmd.run for gluster volume set 'glance' 'nfs.disable' 'True'
2017-09-15 09:30:43,933 [salt.loaded.int.module.cmdmod][INFO    ][31676] Executing command 'gluster volume info 'glance' | grep 'nfs.disable: True'' in directory '/root'
2017-09-15 09:30:43,984 [salt.state       ][INFO    ][31676] unless execution succeeded
2017-09-15 09:30:43,985 [salt.state       ][INFO    ][31676] Completed state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 09:30:43.984645 duration_in_ms=52.745
2017-09-15 09:30:43,985 [salt.state       ][INFO    ][31676] Running state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 09:30:43.985054
2017-09-15 09:30:43,985 [salt.state       ][INFO    ][31676] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'
2017-09-15 09:30:43,986 [salt.loaded.int.module.cmdmod][INFO    ][31676] Executing command 'gluster volume info 'glance' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-09-15 09:30:44,034 [salt.state       ][INFO    ][31676] unless execution succeeded
2017-09-15 09:30:44,034 [salt.state       ][INFO    ][31676] Completed state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 09:30:44.033808 duration_in_ms=48.754
2017-09-15 09:30:44,034 [salt.state       ][INFO    ][31676] Running state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 09:30:44.034247
2017-09-15 09:30:44,034 [salt.state       ][INFO    ][31676] Executing state cmd.run for gluster volume set 'glance' 'cluster.readdir-optimize' 'True'
2017-09-15 09:30:44,035 [salt.loaded.int.module.cmdmod][INFO    ][31676] Executing command 'gluster volume info 'glance' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-09-15 09:30:44,082 [salt.state       ][INFO    ][31676] unless execution succeeded
2017-09-15 09:30:44,082 [salt.state       ][INFO    ][31676] Completed state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 09:30:44.082337 duration_in_ms=48.089
2017-09-15 09:30:44,083 [salt.state       ][INFO    ][31676] Running state [glance] at time 09:30:44.083266
2017-09-15 09:30:44,083 [salt.state       ][INFO    ][31676] Executing state glusterfs.started for glance
2017-09-15 09:30:44,084 [salt.loaded.int.module.cmdmod][INFO    ][31676] Executing command 'gluster --version' in directory '/root'
2017-09-15 09:30:44,092 [salt.loaded.int.module.cmdmod][INFO    ][31676] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-15 09:30:44,139 [salt.loaded.int.module.cmdmod][INFO    ][31676] Executing command 'gluster --version' in directory '/root'
2017-09-15 09:30:44,147 [salt.loaded.int.module.cmdmod][INFO    ][31676] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-15 09:30:44,195 [salt.state       ][INFO    ][31676] Volume glance is already started
2017-09-15 09:30:44,196 [salt.state       ][INFO    ][31676] Completed state [glance] at time 09:30:44.195649 duration_in_ms=112.383
2017-09-15 09:30:44,196 [salt.state       ][INFO    ][31676] Running state [keystone-keys] at time 09:30:44.196422
2017-09-15 09:30:44,197 [salt.state       ][INFO    ][31676] Executing state glusterfs.created for keystone-keys
2017-09-15 09:30:44,197 [salt.loaded.int.module.cmdmod][INFO    ][31676] Executing command 'gluster --version' in directory '/root'
2017-09-15 09:30:44,205 [salt.loaded.int.module.cmdmod][INFO    ][31676] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-15 09:30:44,251 [salt.loaded.int.module.cmdmod][INFO    ][31676] Executing command 'gluster --version' in directory '/root'
2017-09-15 09:30:44,259 [salt.loaded.int.module.cmdmod][INFO    ][31676] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-15 09:30:44,309 [salt.state       ][INFO    ][31676] Volume keystone-keys already exists and is started.
2017-09-15 09:30:44,309 [salt.state       ][INFO    ][31676] Completed state [keystone-keys] at time 09:30:44.308714 duration_in_ms=112.291
2017-09-15 09:30:44,311 [salt.state       ][INFO    ][31676] Running state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 09:30:44.311418
2017-09-15 09:30:44,312 [salt.state       ][INFO    ][31676] Executing state cmd.run for gluster volume set 'keystone-keys' 'network.remote-dio' 'True'
2017-09-15 09:30:44,312 [salt.loaded.int.module.cmdmod][INFO    ][31676] Executing command 'gluster volume info 'keystone-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-09-15 09:30:44,358 [salt.state       ][INFO    ][31676] unless execution succeeded
2017-09-15 09:30:44,359 [salt.state       ][INFO    ][31676] Completed state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 09:30:44.358599 duration_in_ms=47.181
2017-09-15 09:30:44,359 [salt.state       ][INFO    ][31676] Running state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 09:30:44.359007
2017-09-15 09:30:44,359 [salt.state       ][INFO    ][31676] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-09-15 09:30:44,360 [salt.loaded.int.module.cmdmod][INFO    ][31676] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-09-15 09:30:44,406 [salt.state       ][INFO    ][31676] unless execution succeeded
2017-09-15 09:30:44,406 [salt.state       ][INFO    ][31676] Completed state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 09:30:44.405720 duration_in_ms=46.713
2017-09-15 09:30:44,406 [salt.state       ][INFO    ][31676] Running state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 09:30:44.406172
2017-09-15 09:30:44,406 [salt.state       ][INFO    ][31676] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'
2017-09-15 09:30:44,407 [salt.loaded.int.module.cmdmod][INFO    ][31676] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-09-15 09:30:44,454 [salt.state       ][INFO    ][31676] unless execution succeeded
2017-09-15 09:30:44,454 [salt.state       ][INFO    ][31676] Completed state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 09:30:44.453686 duration_in_ms=47.514
2017-09-15 09:30:44,454 [salt.state       ][INFO    ][31676] Running state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 09:30:44.454117
2017-09-15 09:30:44,454 [salt.state       ][INFO    ][31676] Executing state cmd.run for gluster volume set 'keystone-keys' 'nfs.disable' 'True'
2017-09-15 09:30:44,455 [salt.loaded.int.module.cmdmod][INFO    ][31676] Executing command 'gluster volume info 'keystone-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-09-15 09:30:44,501 [salt.state       ][INFO    ][31676] unless execution succeeded
2017-09-15 09:30:44,501 [salt.state       ][INFO    ][31676] Completed state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 09:30:44.500916 duration_in_ms=46.799
2017-09-15 09:30:44,501 [salt.state       ][INFO    ][31676] Running state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 09:30:44.501363
2017-09-15 09:30:44,502 [salt.state       ][INFO    ][31676] Executing state cmd.run for gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'
2017-09-15 09:30:44,502 [salt.loaded.int.module.cmdmod][INFO    ][31676] Executing command 'gluster volume info 'keystone-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-09-15 09:30:44,549 [salt.state       ][INFO    ][31676] unless execution succeeded
2017-09-15 09:30:44,549 [salt.state       ][INFO    ][31676] Completed state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 09:30:44.549000 duration_in_ms=47.636
2017-09-15 09:30:44,550 [salt.state       ][INFO    ][31676] Running state [keystone-keys] at time 09:30:44.549941
2017-09-15 09:30:44,550 [salt.state       ][INFO    ][31676] Executing state glusterfs.started for keystone-keys
2017-09-15 09:30:44,551 [salt.loaded.int.module.cmdmod][INFO    ][31676] Executing command 'gluster --version' in directory '/root'
2017-09-15 09:30:44,558 [salt.loaded.int.module.cmdmod][INFO    ][31676] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-15 09:30:44,604 [salt.loaded.int.module.cmdmod][INFO    ][31676] Executing command 'gluster --version' in directory '/root'
2017-09-15 09:30:44,612 [salt.loaded.int.module.cmdmod][INFO    ][31676] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-15 09:30:44,662 [salt.state       ][INFO    ][31676] Volume keystone-keys is already started
2017-09-15 09:30:44,662 [salt.state       ][INFO    ][31676] Completed state [keystone-keys] at time 09:30:44.662390 duration_in_ms=112.448
2017-09-15 09:30:44,663 [salt.state       ][INFO    ][31676] Running state [nova_instances] at time 09:30:44.663167
2017-09-15 09:30:44,663 [salt.state       ][INFO    ][31676] Executing state glusterfs.created for nova_instances
2017-09-15 09:30:44,664 [salt.loaded.int.module.cmdmod][INFO    ][31676] Executing command 'gluster --version' in directory '/root'
2017-09-15 09:30:44,672 [salt.loaded.int.module.cmdmod][INFO    ][31676] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-15 09:30:44,719 [salt.loaded.int.module.cmdmod][INFO    ][31676] Executing command 'gluster --version' in directory '/root'
2017-09-15 09:30:44,727 [salt.loaded.int.module.cmdmod][INFO    ][31676] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-15 09:30:44,778 [salt.state       ][INFO    ][31676] Volume nova_instances already exists and is started.
2017-09-15 09:30:44,779 [salt.state       ][INFO    ][31676] Completed state [nova_instances] at time 09:30:44.778639 duration_in_ms=115.472
2017-09-15 09:30:44,782 [salt.state       ][INFO    ][31676] Running state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 09:30:44.781493
2017-09-15 09:30:44,782 [salt.state       ][INFO    ][31676] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'
2017-09-15 09:30:44,782 [salt.loaded.int.module.cmdmod][INFO    ][31676] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-09-15 09:30:44,829 [salt.state       ][INFO    ][31676] unless execution succeeded
2017-09-15 09:30:44,829 [salt.state       ][INFO    ][31676] Completed state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 09:30:44.829051 duration_in_ms=47.558
2017-09-15 09:30:44,830 [salt.state       ][INFO    ][31676] Running state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'True'] at time 09:30:44.829482
2017-09-15 09:30:44,830 [salt.state       ][INFO    ][31676] Executing state cmd.run for gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'True'
2017-09-15 09:30:44,830 [salt.loaded.int.module.cmdmod][INFO    ][31676] Executing command 'gluster volume info 'nova_instances' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-09-15 09:30:44,878 [salt.state       ][INFO    ][31676] unless execution succeeded
2017-09-15 09:30:44,879 [salt.state       ][INFO    ][31676] Completed state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'True'] at time 09:30:44.878516 duration_in_ms=49.034
2017-09-15 09:30:44,879 [salt.state       ][INFO    ][31676] Running state [gluster volume set 'nova_instances' 'network.remote-dio' 'True'] at time 09:30:44.878942
2017-09-15 09:30:44,879 [salt.state       ][INFO    ][31676] Executing state cmd.run for gluster volume set 'nova_instances' 'network.remote-dio' 'True'
2017-09-15 09:30:44,880 [salt.loaded.int.module.cmdmod][INFO    ][31676] Executing command 'gluster volume info 'nova_instances' | grep 'network.remote-dio: True'' in directory '/root'
2017-09-15 09:30:44,926 [salt.state       ][INFO    ][31676] unless execution succeeded
2017-09-15 09:30:44,926 [salt.state       ][INFO    ][31676] Completed state [gluster volume set 'nova_instances' 'network.remote-dio' 'True'] at time 09:30:44.926413 duration_in_ms=47.47
2017-09-15 09:30:44,927 [salt.state       ][INFO    ][31676] Running state [gluster volume set 'nova_instances' 'nfs.disable' 'True'] at time 09:30:44.926878
2017-09-15 09:30:44,927 [salt.state       ][INFO    ][31676] Executing state cmd.run for gluster volume set 'nova_instances' 'nfs.disable' 'True'
2017-09-15 09:30:44,928 [salt.loaded.int.module.cmdmod][INFO    ][31676] Executing command 'gluster volume info 'nova_instances' | grep 'nfs.disable: True'' in directory '/root'
2017-09-15 09:30:44,975 [salt.state       ][INFO    ][31676] unless execution succeeded
2017-09-15 09:30:44,975 [salt.state       ][INFO    ][31676] Completed state [gluster volume set 'nova_instances' 'nfs.disable' 'True'] at time 09:30:44.975199 duration_in_ms=48.321
2017-09-15 09:30:44,976 [salt.state       ][INFO    ][31676] Running state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 09:30:44.975607
2017-09-15 09:30:44,976 [salt.state       ][INFO    ][31676] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'
2017-09-15 09:30:44,976 [salt.loaded.int.module.cmdmod][INFO    ][31676] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-09-15 09:30:45,023 [salt.state       ][INFO    ][31676] unless execution succeeded
2017-09-15 09:30:45,024 [salt.state       ][INFO    ][31676] Completed state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 09:30:45.023683 duration_in_ms=48.076
2017-09-15 09:30:45,025 [salt.state       ][INFO    ][31676] Running state [nova_instances] at time 09:30:45.024664
2017-09-15 09:30:45,025 [salt.state       ][INFO    ][31676] Executing state glusterfs.started for nova_instances
2017-09-15 09:30:45,025 [salt.loaded.int.module.cmdmod][INFO    ][31676] Executing command 'gluster --version' in directory '/root'
2017-09-15 09:30:45,034 [salt.loaded.int.module.cmdmod][INFO    ][31676] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-15 09:30:45,081 [salt.loaded.int.module.cmdmod][INFO    ][31676] Executing command 'gluster --version' in directory '/root'
2017-09-15 09:30:45,090 [salt.loaded.int.module.cmdmod][INFO    ][31676] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-15 09:30:45,147 [salt.state       ][INFO    ][31676] Volume nova_instances is already started
2017-09-15 09:30:45,147 [salt.state       ][INFO    ][31676] Completed state [nova_instances] at time 09:30:45.146884 duration_in_ms=122.22
2017-09-15 09:30:45,148 [salt.state       ][INFO    ][31676] Running state [keystone-credential-keys] at time 09:30:45.147661
2017-09-15 09:30:45,148 [salt.state       ][INFO    ][31676] Executing state glusterfs.created for keystone-credential-keys
2017-09-15 09:30:45,148 [salt.loaded.int.module.cmdmod][INFO    ][31676] Executing command 'gluster --version' in directory '/root'
2017-09-15 09:30:45,156 [salt.loaded.int.module.cmdmod][INFO    ][31676] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-15 09:30:45,204 [salt.loaded.int.module.cmdmod][INFO    ][31676] Executing command 'gluster --version' in directory '/root'
2017-09-15 09:30:45,212 [salt.loaded.int.module.cmdmod][INFO    ][31676] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-15 09:30:45,263 [salt.state       ][INFO    ][31676] Volume keystone-credential-keys already exists and is started.
2017-09-15 09:30:45,263 [salt.state       ][INFO    ][31676] Completed state [keystone-credential-keys] at time 09:30:45.262893 duration_in_ms=115.231
2017-09-15 09:30:45,266 [salt.state       ][INFO    ][31676] Running state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 09:30:45.265747
2017-09-15 09:30:45,266 [salt.state       ][INFO    ][31676] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'
2017-09-15 09:30:45,266 [salt.loaded.int.module.cmdmod][INFO    ][31676] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-09-15 09:30:45,316 [salt.state       ][INFO    ][31676] unless execution succeeded
2017-09-15 09:30:45,316 [salt.state       ][INFO    ][31676] Completed state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 09:30:45.316369 duration_in_ms=50.62
2017-09-15 09:30:45,317 [salt.state       ][INFO    ][31676] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 09:30:45.316815
2017-09-15 09:30:45,317 [salt.state       ][INFO    ][31676] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-09-15 09:30:45,317 [salt.loaded.int.module.cmdmod][INFO    ][31676] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-09-15 09:30:45,365 [salt.state       ][INFO    ][31676] unless execution succeeded
2017-09-15 09:30:45,365 [salt.state       ][INFO    ][31676] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 09:30:45.365443 duration_in_ms=48.626
2017-09-15 09:30:45,366 [salt.state       ][INFO    ][31676] Running state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 09:30:45.365928
2017-09-15 09:30:45,366 [salt.state       ][INFO    ][31676] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'
2017-09-15 09:30:45,367 [salt.loaded.int.module.cmdmod][INFO    ][31676] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-09-15 09:30:45,414 [salt.state       ][INFO    ][31676] unless execution succeeded
2017-09-15 09:30:45,414 [salt.state       ][INFO    ][31676] Completed state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 09:30:45.414250 duration_in_ms=48.322
2017-09-15 09:30:45,415 [salt.state       ][INFO    ][31676] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 09:30:45.414705
2017-09-15 09:30:45,415 [salt.state       ][INFO    ][31676] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'
2017-09-15 09:30:45,415 [salt.loaded.int.module.cmdmod][INFO    ][31676] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-09-15 09:30:45,465 [salt.state       ][INFO    ][31676] unless execution succeeded
2017-09-15 09:30:45,466 [salt.state       ][INFO    ][31676] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 09:30:45.465638 duration_in_ms=50.932
2017-09-15 09:30:45,466 [salt.state       ][INFO    ][31676] Running state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 09:30:45.466087
2017-09-15 09:30:45,466 [salt.state       ][INFO    ][31676] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'
2017-09-15 09:30:45,467 [salt.loaded.int.module.cmdmod][INFO    ][31676] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-09-15 09:30:45,513 [salt.state       ][INFO    ][31676] unless execution succeeded
2017-09-15 09:30:45,513 [salt.state       ][INFO    ][31676] Completed state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 09:30:45.513361 duration_in_ms=47.273
2017-09-15 09:30:45,514 [salt.state       ][INFO    ][31676] Running state [keystone-credential-keys] at time 09:30:45.514331
2017-09-15 09:30:45,515 [salt.state       ][INFO    ][31676] Executing state glusterfs.started for keystone-credential-keys
2017-09-15 09:30:45,515 [salt.loaded.int.module.cmdmod][INFO    ][31676] Executing command 'gluster --version' in directory '/root'
2017-09-15 09:30:45,523 [salt.loaded.int.module.cmdmod][INFO    ][31676] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-15 09:30:45,573 [salt.loaded.int.module.cmdmod][INFO    ][31676] Executing command 'gluster --version' in directory '/root'
2017-09-15 09:30:45,584 [salt.loaded.int.module.cmdmod][INFO    ][31676] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-09-15 09:30:45,638 [salt.state       ][INFO    ][31676] Volume keystone-credential-keys is already started
2017-09-15 09:30:45,638 [salt.state       ][INFO    ][31676] Completed state [keystone-credential-keys] at time 09:30:45.638162 duration_in_ms=123.829
2017-09-15 09:30:45,641 [salt.minion      ][INFO    ][31676] Returning information for job: 20170915093040804826
2017-09-15 09:30:50,530 [salt.minion      ][INFO    ][24160] User sudo_ubuntu Executing command test.ping with jid 20170915093050519061
2017-09-15 09:30:50,545 [salt.minion      ][INFO    ][32102] Starting a new job with PID 32102
2017-09-15 09:30:50,571 [salt.minion      ][INFO    ][32102] Returning information for job: 20170915093050519061
2017-09-15 09:30:50,966 [salt.minion      ][INFO    ][24160] User sudo_ubuntu Executing command cmd.run with jid 20170915093050953766
2017-09-15 09:30:50,981 [salt.minion      ][INFO    ][32107] Starting a new job with PID 32107
2017-09-15 09:30:50,986 [salt.loaded.int.module.cmdmod][INFO    ][32107] Executing command 'gluster peer status; gluster volume status' in directory '/root'
2017-09-15 09:30:51,098 [salt.minion      ][INFO    ][32107] Returning information for job: 20170915093050953766
2017-09-15 09:58:50,626 [salt.utils.schedule][INFO    ][24160] Running scheduled job: __mine_interval
2017-09-15 10:32:52,555 [salt.minion      ][INFO    ][24160] User sudo_ubuntu Executing command cp.push_dir with jid 20170915103252544032
2017-09-15 10:32:52,572 [salt.minion      ][INFO    ][569] Starting a new job with PID 569
