2017-10-25 00:51:15,510 [salt.cli.daemons ][WARNING ][2515] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-10-25 01:27:44,039 [salt.state       ][ERROR   ][3900] No contents found in top file
2017-10-25 01:29:30,055 [salt.utils.parsers][WARNING ][2515] Minion received a SIGTERM. Exiting.
2017-10-25 01:31:42,371 [salt.cli.daemons ][WARNING ][3229] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-10-25 01:34:43,883 [salt.loaded.int.module.cmdmod][ERROR   ][11080] Command 'virsh net-destroy default 2>&1 1>/dev/null; virsh net-undefine default' failed with return code: 1
2017-10-25 01:34:43,884 [salt.loaded.int.module.cmdmod][ERROR   ][11080] stderr: error: failed to get network 'default'
error: Network not found: no network with matching name 'default'
2017-10-25 01:34:43,884 [salt.loaded.int.module.cmdmod][ERROR   ][11080] retcode: 1
2017-10-25 01:34:43,884 [salt.state       ][ERROR   ][11080] {'pid': 15975, 'retcode': 1, 'stderr': "error: failed to get network 'default'\nerror: Network not found: no network with matching name 'default'", 'stdout': ''}
2017-10-25 01:35:00,832 [py.warnings      ][WARNING ][16052] /usr/lib/python2.7/dist-packages/salt/utils/templates.py:73: DeprecationWarning: Starting in 2015.5, cmd.run uses python_shell=False by default, which doesn't support shellisms (pipes, env variables, etc). cmd.run is currently aliased to cmd.shell to prevent breakage. Please switch to cmd.shell or set python_shell=True to avoid breakage in the future, when this aliasing is removed.

2017-10-25 01:38:17,974 [salt.loaded.int.module.cmdmod][ERROR   ][16052] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-10-25 01:38:17,975 [salt.loaded.int.module.cmdmod][ERROR   ][16052] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-10-25 01:38:25,506 [salt.loaded.int.module.cmdmod][ERROR   ][16052] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-10-25 01:38:25,507 [salt.loaded.int.module.cmdmod][ERROR   ][16052] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-10-25 01:38:34,548 [salt.loaded.int.module.cmdmod][ERROR   ][16052] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-10-25 01:38:34,549 [salt.loaded.int.module.cmdmod][ERROR   ][16052] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-10-25 01:38:43,339 [salt.loaded.int.module.cmdmod][ERROR   ][16052] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-10-25 01:38:43,339 [salt.loaded.int.module.cmdmod][ERROR   ][16052] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-10-25 01:38:52,327 [salt.loaded.int.module.cmdmod][ERROR   ][16052] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-10-25 01:38:52,328 [salt.loaded.int.module.cmdmod][ERROR   ][16052] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-10-25 01:38:58,609 [salt.loaded.int.module.cmdmod][ERROR   ][16052] Command 'while true; do salt-call saltutil.running|grep fun: && continue; salt-call --local service.restart salt-minion; break; done' failed with return code: None
2017-10-25 01:39:00,780 [salt.loaded.int.module.cmdmod][INFO    ][23718] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2017-10-25 01:39:00,787 [salt.loaded.int.module.cmdmod][INFO    ][23718] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2017-10-25 01:39:00,798 [salt.loaded.int.module.cmdmod][INFO    ][23718] Executing command ['systemd-run', '--scope', 'systemctl', 'restart', 'salt-minion.service'] in directory '/root'
2017-10-25 01:39:00,805 [salt.utils.parsers][WARNING ][3229] Minion received a SIGTERM. Exiting.
2017-10-25 01:39:01,057 [salt.cli.daemons ][INFO    ][23807] Setting up the Salt Minion "kvm01.baremetal-mcp-ocata-odl-ha.local"
2017-10-25 01:39:01,581 [salt.minion      ][INFO    ][23807] Creating minion process manager
2017-10-25 01:39:01,581 [salt.cli.daemons ][WARNING ][23807] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-10-25 01:39:01,582 [salt.cli.daemons ][INFO    ][23807] The Salt Minion is starting up
2017-10-25 01:39:01,582 [salt.minion      ][INFO    ][23807] Minion is starting as user 'root'
2017-10-25 01:39:01,582 [salt.utils.event ][INFO    ][23807] Starting pull socket on /var/run/salt/minion/minion_event_127643860a_pull.ipc
2017-10-25 01:39:02,478 [salt.loaded.int.module.cmdmod][INFO    ][23807] Executing command ['date', '+%z'] in directory '/root'
2017-10-25 01:39:02,488 [salt.utils.schedule][INFO    ][23807] Updating job settings for scheduled job: __mine_interval
2017-10-25 01:39:02,490 [salt.minion      ][INFO    ][23807] Added mine.update to scheduler
2017-10-25 01:39:02,672 [salt.minion      ][INFO    ][23807] Minion is ready to receive requests!
2017-10-25 01:39:03,672 [salt.utils.schedule][INFO    ][23807] Running scheduled job: __mine_interval
2017-10-25 01:39:06,019 [salt.minion      ][INFO    ][23807] User sudo_ubuntu Executing command saltutil.sync_all with jid 20171025013906015235
2017-10-25 01:39:06,034 [salt.minion      ][INFO    ][23936] Starting a new job with PID 23936
2017-10-25 01:39:08,546 [salt.state       ][INFO    ][23936] Loading fresh modules for state activity
2017-10-25 01:39:08,566 [salt.state       ][ERROR   ][23936] No contents found in top file
2017-10-25 01:39:08,567 [salt.utils.extmods][INFO    ][23936] Creating module dir '/var/cache/salt/minion/extmods/beacons'
2017-10-25 01:39:08,570 [salt.utils.extmods][INFO    ][23936] Syncing beacons for environment 'base'
2017-10-25 01:39:08,570 [salt.utils.extmods][INFO    ][23936] Loading cache from salt://_beacons, for base)
2017-10-25 01:39:08,570 [salt.fileclient  ][INFO    ][23936] Caching directory '_beacons/' for environment 'base'
2017-10-25 01:39:08,602 [salt.utils.extmods][INFO    ][23936] Syncing modules for environment 'base'
2017-10-25 01:39:08,602 [salt.utils.extmods][INFO    ][23936] Loading cache from salt://_modules, for base)
2017-10-25 01:39:08,602 [salt.fileclient  ][INFO    ][23936] Caching directory '_modules/' for environment 'base'
2017-10-25 01:39:08,713 [salt.fileclient  ][INFO    ][23936] Fetching file from saltenv 'base', ** done ** '_modules/ceph_ng.py'
2017-10-25 01:39:08,729 [salt.fileclient  ][INFO    ][23936] Fetching file from saltenv 'base', ** done ** '_modules/cinderng.py'
2017-10-25 01:39:08,847 [salt.fileclient  ][INFO    ][23936] Fetching file from saltenv 'base', ** done ** '_modules/contrail.py'
2017-10-25 01:39:08,950 [salt.fileclient  ][INFO    ][23936] Fetching file from saltenv 'base', ** done ** '_modules/creds.py'
2017-10-25 01:39:09,066 [salt.fileclient  ][INFO    ][23936] Fetching file from saltenv 'base', ** done ** '_modules/devops_utils.py'
2017-10-25 01:39:09,135 [salt.fileclient  ][INFO    ][23936] Fetching file from saltenv 'base', ** done ** '_modules/encode_json.py'
2017-10-25 01:39:09,235 [salt.fileclient  ][INFO    ][23936] Fetching file from saltenv 'base', ** done ** '_modules/gerrit.py'
2017-10-25 01:39:09,333 [salt.fileclient  ][INFO    ][23936] Fetching file from saltenv 'base', ** done ** '_modules/glanceng.py'
2017-10-25 01:39:09,443 [salt.fileclient  ][INFO    ][23936] Fetching file from saltenv 'base', ** done ** '_modules/heat.py'
2017-10-25 01:39:09,553 [salt.fileclient  ][INFO    ][23936] Fetching file from saltenv 'base', ** done ** '_modules/heka_alarming.py'
2017-10-25 01:39:09,662 [salt.fileclient  ][INFO    ][23936] Fetching file from saltenv 'base', ** done ** '_modules/helm.py'
2017-10-25 01:39:09,853 [salt.fileclient  ][INFO    ][23936] Fetching file from saltenv 'base', ** done ** '_modules/jenkins_common.py'
2017-10-25 01:39:10,019 [salt.fileclient  ][INFO    ][23936] Fetching file from saltenv 'base', ** done ** '_modules/keystone_policy.py'
2017-10-25 01:39:10,091 [salt.fileclient  ][INFO    ][23936] Fetching file from saltenv 'base', ** done ** '_modules/linux_hosts.py'
2017-10-25 01:39:10,324 [salt.fileclient  ][INFO    ][23936] Fetching file from saltenv 'base', ** done ** '_modules/linux_netlink.py'
2017-10-25 01:39:10,464 [salt.fileclient  ][INFO    ][23936] Fetching file from saltenv 'base', ** done ** '_modules/maas.py'
2017-10-25 01:39:10,554 [salt.fileclient  ][INFO    ][23936] Fetching file from saltenv 'base', ** done ** '_modules/maas_client.py'
2017-10-25 01:39:10,664 [salt.fileclient  ][INFO    ][23936] Fetching file from saltenv 'base', ** done ** '_modules/multipart.py'
2017-10-25 01:39:10,743 [salt.fileclient  ][INFO    ][23936] Fetching file from saltenv 'base', ** done ** '_modules/nagios_alarming.py'
2017-10-25 01:39:10,829 [salt.fileclient  ][INFO    ][23936] Fetching file from saltenv 'base', ** done ** '_modules/neutronng.py'
2017-10-25 01:39:10,942 [salt.fileclient  ][INFO    ][23936] Fetching file from saltenv 'base', ** done ** '_modules/novang.py'
2017-10-25 01:39:11,054 [salt.fileclient  ][INFO    ][23936] Fetching file from saltenv 'base', ** done ** '_modules/reclass.py'
2017-10-25 01:39:11,066 [salt.fileclient  ][INFO    ][23936] Fetching file from saltenv 'base', ** done ** '_modules/rsyslog_util.py'
2017-10-25 01:39:11,122 [salt.fileclient  ][INFO    ][23936] Fetching file from saltenv 'base', ** done ** '_modules/rundeck.py'
2017-10-25 01:39:11,256 [salt.fileclient  ][INFO    ][23936] Fetching file from saltenv 'base', ** done ** '_modules/saltkey.py'
2017-10-25 01:39:11,325 [salt.fileclient  ][INFO    ][23936] Fetching file from saltenv 'base', ** done ** '_modules/saltresource.py'
2017-10-25 01:39:11,603 [salt.fileclient  ][INFO    ][23936] Fetching file from saltenv 'base', ** done ** '_modules/seedng.py'
2017-10-25 01:39:11,817 [salt.fileclient  ][INFO    ][23936] Fetching file from saltenv 'base', ** done ** '_modules/testing/credentials.py'
2017-10-25 01:39:11,915 [salt.fileclient  ][INFO    ][23936] Fetching file from saltenv 'base', ** done ** '_modules/testing/django.py'
2017-10-25 01:39:12,053 [salt.fileclient  ][INFO    ][23936] Fetching file from saltenv 'base', ** done ** '_modules/testing/django_client_proxy.py'
2017-10-25 01:39:12,189 [salt.fileclient  ][INFO    ][23936] Fetching file from saltenv 'base', ** done ** '_modules/utils.py'
2017-10-25 01:39:12,385 [salt.fileclient  ][INFO    ][23936] Fetching file from saltenv 'base', ** done ** '_modules/virtng.py'
2017-10-25 01:39:12,388 [salt.utils.extmods][INFO    ][23936] Copying '/var/cache/salt/minion/files/base/_modules/__init__.py' to '/var/cache/salt/minion/extmods/modules/__init__.py'
2017-10-25 01:39:12,389 [salt.utils.extmods][INFO    ][23936] Copying '/var/cache/salt/minion/files/base/_modules/ceph_ng.py' to '/var/cache/salt/minion/extmods/modules/ceph_ng.py'
2017-10-25 01:39:12,510 [salt.utils.extmods][INFO    ][23936] Copying '/var/cache/salt/minion/files/base/_modules/cinderng.py' to '/var/cache/salt/minion/extmods/modules/cinderng.py'
2017-10-25 01:39:12,678 [salt.utils.extmods][INFO    ][23936] Copying '/var/cache/salt/minion/files/base/_modules/contrail.py' to '/var/cache/salt/minion/extmods/modules/contrail.py'
2017-10-25 01:39:12,754 [salt.utils.extmods][INFO    ][23936] Copying '/var/cache/salt/minion/files/base/_modules/creds.py' to '/var/cache/salt/minion/extmods/modules/creds.py'
2017-10-25 01:39:12,843 [salt.utils.extmods][INFO    ][23936] Copying '/var/cache/salt/minion/files/base/_modules/devops_utils.py' to '/var/cache/salt/minion/extmods/modules/devops_utils.py'
2017-10-25 01:39:12,887 [salt.utils.extmods][INFO    ][23936] Copying '/var/cache/salt/minion/files/base/_modules/encode_json.py' to '/var/cache/salt/minion/extmods/modules/encode_json.py'
2017-10-25 01:39:12,984 [salt.utils.extmods][INFO    ][23936] Copying '/var/cache/salt/minion/files/base/_modules/gerrit.py' to '/var/cache/salt/minion/extmods/modules/gerrit.py'
2017-10-25 01:39:13,042 [salt.utils.extmods][INFO    ][23936] Copying '/var/cache/salt/minion/files/base/_modules/glanceng.py' to '/var/cache/salt/minion/extmods/modules/glanceng.py'
2017-10-25 01:39:13,131 [salt.utils.extmods][INFO    ][23936] Copying '/var/cache/salt/minion/files/base/_modules/heat.py' to '/var/cache/salt/minion/extmods/modules/heat.py'
2017-10-25 01:39:13,131 [salt.utils.extmods][INFO    ][23936] Copying '/var/cache/salt/minion/files/base/_modules/heka_alarming.py' to '/var/cache/salt/minion/extmods/modules/heka_alarming.py'
2017-10-25 01:39:13,132 [salt.utils.extmods][INFO    ][23936] Copying '/var/cache/salt/minion/files/base/_modules/helm.py' to '/var/cache/salt/minion/extmods/modules/helm.py'
2017-10-25 01:39:13,132 [salt.utils.extmods][INFO    ][23936] Copying '/var/cache/salt/minion/files/base/_modules/jenkins_common.py' to '/var/cache/salt/minion/extmods/modules/jenkins_common.py'
2017-10-25 01:39:13,133 [salt.utils.extmods][INFO    ][23936] Copying '/var/cache/salt/minion/files/base/_modules/keystone_policy.py' to '/var/cache/salt/minion/extmods/modules/keystone_policy.py'
2017-10-25 01:39:13,133 [salt.utils.extmods][INFO    ][23936] Copying '/var/cache/salt/minion/files/base/_modules/linux_hosts.py' to '/var/cache/salt/minion/extmods/modules/linux_hosts.py'
2017-10-25 01:39:13,134 [salt.utils.extmods][INFO    ][23936] Copying '/var/cache/salt/minion/files/base/_modules/linux_netlink.py' to '/var/cache/salt/minion/extmods/modules/linux_netlink.py'
2017-10-25 01:39:13,142 [salt.utils.extmods][INFO    ][23936] Copying '/var/cache/salt/minion/files/base/_modules/maas.py' to '/var/cache/salt/minion/extmods/modules/maas.py'
2017-10-25 01:39:13,143 [salt.utils.extmods][INFO    ][23936] Copying '/var/cache/salt/minion/files/base/_modules/maas_client.py' to '/var/cache/salt/minion/extmods/modules/maas_client.py'
2017-10-25 01:39:13,149 [salt.utils.extmods][INFO    ][23936] Copying '/var/cache/salt/minion/files/base/_modules/multipart.py' to '/var/cache/salt/minion/extmods/modules/multipart.py'
2017-10-25 01:39:13,149 [salt.utils.extmods][INFO    ][23936] Copying '/var/cache/salt/minion/files/base/_modules/nagios_alarming.py' to '/var/cache/salt/minion/extmods/modules/nagios_alarming.py'
2017-10-25 01:39:13,150 [salt.utils.extmods][INFO    ][23936] Copying '/var/cache/salt/minion/files/base/_modules/neutronng.py' to '/var/cache/salt/minion/extmods/modules/neutronng.py'
2017-10-25 01:39:13,150 [salt.utils.extmods][INFO    ][23936] Copying '/var/cache/salt/minion/files/base/_modules/novang.py' to '/var/cache/salt/minion/extmods/modules/novang.py'
2017-10-25 01:39:13,151 [salt.utils.extmods][INFO    ][23936] Copying '/var/cache/salt/minion/files/base/_modules/reclass.py' to '/var/cache/salt/minion/extmods/modules/reclass.py'
2017-10-25 01:39:13,152 [salt.utils.extmods][INFO    ][23936] Copying '/var/cache/salt/minion/files/base/_modules/rsyslog_util.py' to '/var/cache/salt/minion/extmods/modules/rsyslog_util.py'
2017-10-25 01:39:13,152 [salt.utils.extmods][INFO    ][23936] Copying '/var/cache/salt/minion/files/base/_modules/rundeck.py' to '/var/cache/salt/minion/extmods/modules/rundeck.py'
2017-10-25 01:39:13,159 [salt.utils.extmods][INFO    ][23936] Copying '/var/cache/salt/minion/files/base/_modules/saltkey.py' to '/var/cache/salt/minion/extmods/modules/saltkey.py'
2017-10-25 01:39:13,159 [salt.utils.extmods][INFO    ][23936] Copying '/var/cache/salt/minion/files/base/_modules/saltresource.py' to '/var/cache/salt/minion/extmods/modules/saltresource.py'
2017-10-25 01:39:13,159 [salt.utils.extmods][INFO    ][23936] Copying '/var/cache/salt/minion/files/base/_modules/seedng.py' to '/var/cache/salt/minion/extmods/modules/seedng.py'
2017-10-25 01:39:13,166 [salt.utils.extmods][INFO    ][23936] Copying '/var/cache/salt/minion/files/base/_modules/testing/__init__.py' to '/var/cache/salt/minion/extmods/modules/testing/__init__.py'
2017-10-25 01:39:13,167 [salt.utils.extmods][INFO    ][23936] Copying '/var/cache/salt/minion/files/base/_modules/testing/credentials.py' to '/var/cache/salt/minion/extmods/modules/testing/credentials.py'
2017-10-25 01:39:13,167 [salt.utils.extmods][INFO    ][23936] Copying '/var/cache/salt/minion/files/base/_modules/testing/django.py' to '/var/cache/salt/minion/extmods/modules/testing/django.py'
2017-10-25 01:39:13,168 [salt.utils.extmods][INFO    ][23936] Copying '/var/cache/salt/minion/files/base/_modules/testing/django_client_proxy.py' to '/var/cache/salt/minion/extmods/modules/testing/django_client_proxy.py'
2017-10-25 01:39:13,168 [salt.utils.extmods][INFO    ][23936] Copying '/var/cache/salt/minion/files/base/_modules/utils.py' to '/var/cache/salt/minion/extmods/modules/utils.py'
2017-10-25 01:39:13,169 [salt.utils.extmods][INFO    ][23936] Copying '/var/cache/salt/minion/files/base/_modules/virtng.py' to '/var/cache/salt/minion/extmods/modules/virtng.py'
2017-10-25 01:39:13,174 [salt.utils.extmods][INFO    ][23936] Syncing states for environment 'base'
2017-10-25 01:39:13,175 [salt.utils.extmods][INFO    ][23936] Loading cache from salt://_states, for base)
2017-10-25 01:39:13,175 [salt.fileclient  ][INFO    ][23936] Caching directory '_states/' for environment 'base'
2017-10-25 01:39:13,363 [salt.fileclient  ][INFO    ][23936] Fetching file from saltenv 'base', ** done ** '_states/cinderng.py'
2017-10-25 01:39:13,587 [salt.fileclient  ][INFO    ][23936] Fetching file from saltenv 'base', ** done ** '_states/contrail.py'
2017-10-25 01:39:13,791 [salt.fileclient  ][INFO    ][23936] Fetching file from saltenv 'base', ** done ** '_states/gerrit.py'
2017-10-25 01:39:14,037 [salt.fileclient  ][INFO    ][23936] Fetching file from saltenv 'base', ** done ** '_states/glanceng.py'
2017-10-25 01:39:14,219 [salt.fileclient  ][INFO    ][23936] Fetching file from saltenv 'base', ** done ** '_states/grafana3_dashboard.py'
2017-10-25 01:39:14,327 [salt.fileclient  ][INFO    ][23936] Fetching file from saltenv 'base', ** done ** '_states/grafana3_datasource.py'
2017-10-25 01:39:14,528 [salt.fileclient  ][INFO    ][23936] Fetching file from saltenv 'base', ** done ** '_states/heat.py'
2017-10-25 01:39:14,759 [salt.fileclient  ][INFO    ][23936] Fetching file from saltenv 'base', ** done ** '_states/helm_release.py'
2017-10-25 01:39:14,937 [salt.fileclient  ][INFO    ][23936] Fetching file from saltenv 'base', ** done ** '_states/jenkins_approval.py'
2017-10-25 01:39:15,097 [salt.fileclient  ][INFO    ][23936] Fetching file from saltenv 'base', ** done ** '_states/jenkins_artifactory.py'
2017-10-25 01:39:15,246 [salt.fileclient  ][INFO    ][23936] Fetching file from saltenv 'base', ** done ** '_states/jenkins_credential.py'
2017-10-25 01:39:15,424 [salt.fileclient  ][INFO    ][23936] Fetching file from saltenv 'base', ** done ** '_states/jenkins_job.py'
2017-10-25 01:39:15,534 [salt.fileclient  ][INFO    ][23936] Fetching file from saltenv 'base', ** done ** '_states/jenkins_lib.py'
2017-10-25 01:39:15,720 [salt.fileclient  ][INFO    ][23936] Fetching file from saltenv 'base', ** done ** '_states/jenkins_node.py'
2017-10-25 01:39:15,757 [salt.fileclient  ][INFO    ][23936] Fetching file from saltenv 'base', ** done ** '_states/jenkins_plugin.py'
2017-10-25 01:39:15,775 [salt.fileclient  ][INFO    ][23936] Fetching file from saltenv 'base', ** done ** '_states/jenkins_security.py'
2017-10-25 01:39:15,800 [salt.fileclient  ][INFO    ][23936] Fetching file from saltenv 'base', ** done ** '_states/jenkins_slack.py'
2017-10-25 01:39:15,863 [salt.fileclient  ][INFO    ][23936] Fetching file from saltenv 'base', ** done ** '_states/jenkins_smtp.py'
2017-10-25 01:39:15,904 [salt.fileclient  ][INFO    ][23936] Fetching file from saltenv 'base', ** done ** '_states/jenkins_theme.py'
2017-10-25 01:39:15,923 [salt.fileclient  ][INFO    ][23936] Fetching file from saltenv 'base', ** done ** '_states/jenkins_user.py'
2017-10-25 01:39:15,940 [salt.fileclient  ][INFO    ][23936] Fetching file from saltenv 'base', ** done ** '_states/jenkins_view.py'
2017-10-25 01:39:15,956 [salt.fileclient  ][INFO    ][23936] Fetching file from saltenv 'base', ** done ** '_states/keystone_policy.py'
2017-10-25 01:39:16,045 [salt.minion      ][INFO    ][23807] User sudo_ubuntu Executing command saltutil.find_job with jid 20171025013916041296
2017-10-25 01:39:16,050 [salt.fileclient  ][INFO    ][23936] Fetching file from saltenv 'base', ** done ** '_states/kibana_object.py'
2017-10-25 01:39:16,063 [salt.minion      ][INFO    ][23950] Starting a new job with PID 23950
2017-10-25 01:39:16,071 [salt.minion      ][INFO    ][23950] Returning information for job: 20171025013916041296
2017-10-25 01:39:16,116 [salt.fileclient  ][INFO    ][23936] Fetching file from saltenv 'base', ** done ** '_states/neutronng.py'
2017-10-25 01:39:16,157 [salt.fileclient  ][INFO    ][23936] Fetching file from saltenv 'base', ** done ** '_states/novang.py'
2017-10-25 01:39:16,170 [salt.fileclient  ][INFO    ][23936] Fetching file from saltenv 'base', ** done ** '_states/reclass.py'
2017-10-25 01:39:16,195 [salt.fileclient  ][INFO    ][23936] Fetching file from saltenv 'base', ** done ** '_states/rundeck_project.py'
2017-10-25 01:39:16,210 [salt.fileclient  ][INFO    ][23936] Fetching file from saltenv 'base', ** done ** '_states/rundeck_scm.py'
2017-10-25 01:39:16,227 [salt.fileclient  ][INFO    ][23936] Fetching file from saltenv 'base', ** done ** '_states/rundeck_secret.py'
2017-10-25 01:39:16,230 [salt.utils.extmods][INFO    ][23936] Copying '/var/cache/salt/minion/files/base/_states/cinderng.py' to '/var/cache/salt/minion/extmods/states/cinderng.py'
2017-10-25 01:39:16,230 [salt.utils.extmods][INFO    ][23936] Copying '/var/cache/salt/minion/files/base/_states/contrail.py' to '/var/cache/salt/minion/extmods/states/contrail.py'
2017-10-25 01:39:16,231 [salt.utils.extmods][INFO    ][23936] Copying '/var/cache/salt/minion/files/base/_states/gerrit.py' to '/var/cache/salt/minion/extmods/states/gerrit.py'
2017-10-25 01:39:16,231 [salt.utils.extmods][INFO    ][23936] Copying '/var/cache/salt/minion/files/base/_states/glanceng.py' to '/var/cache/salt/minion/extmods/states/glanceng.py'
2017-10-25 01:39:16,231 [salt.utils.extmods][INFO    ][23936] Copying '/var/cache/salt/minion/files/base/_states/grafana3_dashboard.py' to '/var/cache/salt/minion/extmods/states/grafana3_dashboard.py'
2017-10-25 01:39:16,232 [salt.utils.extmods][INFO    ][23936] Copying '/var/cache/salt/minion/files/base/_states/grafana3_datasource.py' to '/var/cache/salt/minion/extmods/states/grafana3_datasource.py'
2017-10-25 01:39:16,232 [salt.utils.extmods][INFO    ][23936] Copying '/var/cache/salt/minion/files/base/_states/heat.py' to '/var/cache/salt/minion/extmods/states/heat.py'
2017-10-25 01:39:16,232 [salt.utils.extmods][INFO    ][23936] Copying '/var/cache/salt/minion/files/base/_states/helm_release.py' to '/var/cache/salt/minion/extmods/states/helm_release.py'
2017-10-25 01:39:16,232 [salt.utils.extmods][INFO    ][23936] Copying '/var/cache/salt/minion/files/base/_states/jenkins_approval.py' to '/var/cache/salt/minion/extmods/states/jenkins_approval.py'
2017-10-25 01:39:16,233 [salt.utils.extmods][INFO    ][23936] Copying '/var/cache/salt/minion/files/base/_states/jenkins_artifactory.py' to '/var/cache/salt/minion/extmods/states/jenkins_artifactory.py'
2017-10-25 01:39:16,233 [salt.utils.extmods][INFO    ][23936] Copying '/var/cache/salt/minion/files/base/_states/jenkins_credential.py' to '/var/cache/salt/minion/extmods/states/jenkins_credential.py'
2017-10-25 01:39:16,233 [salt.utils.extmods][INFO    ][23936] Copying '/var/cache/salt/minion/files/base/_states/jenkins_job.py' to '/var/cache/salt/minion/extmods/states/jenkins_job.py'
2017-10-25 01:39:16,233 [salt.utils.extmods][INFO    ][23936] Copying '/var/cache/salt/minion/files/base/_states/jenkins_lib.py' to '/var/cache/salt/minion/extmods/states/jenkins_lib.py'
2017-10-25 01:39:16,234 [salt.utils.extmods][INFO    ][23936] Copying '/var/cache/salt/minion/files/base/_states/jenkins_node.py' to '/var/cache/salt/minion/extmods/states/jenkins_node.py'
2017-10-25 01:39:16,234 [salt.utils.extmods][INFO    ][23936] Copying '/var/cache/salt/minion/files/base/_states/jenkins_plugin.py' to '/var/cache/salt/minion/extmods/states/jenkins_plugin.py'
2017-10-25 01:39:16,234 [salt.utils.extmods][INFO    ][23936] Copying '/var/cache/salt/minion/files/base/_states/jenkins_security.py' to '/var/cache/salt/minion/extmods/states/jenkins_security.py'
2017-10-25 01:39:16,234 [salt.utils.extmods][INFO    ][23936] Copying '/var/cache/salt/minion/files/base/_states/jenkins_slack.py' to '/var/cache/salt/minion/extmods/states/jenkins_slack.py'
2017-10-25 01:39:16,235 [salt.utils.extmods][INFO    ][23936] Copying '/var/cache/salt/minion/files/base/_states/jenkins_smtp.py' to '/var/cache/salt/minion/extmods/states/jenkins_smtp.py'
2017-10-25 01:39:16,235 [salt.utils.extmods][INFO    ][23936] Copying '/var/cache/salt/minion/files/base/_states/jenkins_theme.py' to '/var/cache/salt/minion/extmods/states/jenkins_theme.py'
2017-10-25 01:39:16,235 [salt.utils.extmods][INFO    ][23936] Copying '/var/cache/salt/minion/files/base/_states/jenkins_user.py' to '/var/cache/salt/minion/extmods/states/jenkins_user.py'
2017-10-25 01:39:16,235 [salt.utils.extmods][INFO    ][23936] Copying '/var/cache/salt/minion/files/base/_states/jenkins_view.py' to '/var/cache/salt/minion/extmods/states/jenkins_view.py'
2017-10-25 01:39:16,236 [salt.utils.extmods][INFO    ][23936] Copying '/var/cache/salt/minion/files/base/_states/keystone_policy.py' to '/var/cache/salt/minion/extmods/states/keystone_policy.py'
2017-10-25 01:39:16,236 [salt.utils.extmods][INFO    ][23936] Copying '/var/cache/salt/minion/files/base/_states/kibana_object.py' to '/var/cache/salt/minion/extmods/states/kibana_object.py'
2017-10-25 01:39:16,236 [salt.utils.extmods][INFO    ][23936] Copying '/var/cache/salt/minion/files/base/_states/maas_cluster.py' to '/var/cache/salt/minion/extmods/states/maas_cluster.py'
2017-10-25 01:39:16,236 [salt.utils.extmods][INFO    ][23936] Copying '/var/cache/salt/minion/files/base/_states/neutronng.py' to '/var/cache/salt/minion/extmods/states/neutronng.py'
2017-10-25 01:39:16,237 [salt.utils.extmods][INFO    ][23936] Copying '/var/cache/salt/minion/files/base/_states/novang.py' to '/var/cache/salt/minion/extmods/states/novang.py'
2017-10-25 01:39:16,237 [salt.utils.extmods][INFO    ][23936] Copying '/var/cache/salt/minion/files/base/_states/reclass.py' to '/var/cache/salt/minion/extmods/states/reclass.py'
2017-10-25 01:39:16,237 [salt.utils.extmods][INFO    ][23936] Copying '/var/cache/salt/minion/files/base/_states/rundeck_project.py' to '/var/cache/salt/minion/extmods/states/rundeck_project.py'
2017-10-25 01:39:16,238 [salt.utils.extmods][INFO    ][23936] Copying '/var/cache/salt/minion/files/base/_states/rundeck_scm.py' to '/var/cache/salt/minion/extmods/states/rundeck_scm.py'
2017-10-25 01:39:16,238 [salt.utils.extmods][INFO    ][23936] Copying '/var/cache/salt/minion/files/base/_states/rundeck_secret.py' to '/var/cache/salt/minion/extmods/states/rundeck_secret.py'
2017-10-25 01:39:16,240 [salt.utils.extmods][INFO    ][23936] Creating module dir '/var/cache/salt/minion/extmods/sdb'
2017-10-25 01:39:16,243 [salt.utils.extmods][INFO    ][23936] Syncing sdb for environment 'base'
2017-10-25 01:39:16,243 [salt.utils.extmods][INFO    ][23936] Loading cache from salt://_sdb, for base)
2017-10-25 01:39:16,243 [salt.fileclient  ][INFO    ][23936] Caching directory '_sdb/' for environment 'base'
2017-10-25 01:39:16,283 [salt.utils.extmods][INFO    ][23936] Syncing grains for environment 'base'
2017-10-25 01:39:16,284 [salt.utils.extmods][INFO    ][23936] Loading cache from salt://_grains, for base)
2017-10-25 01:39:16,284 [salt.fileclient  ][INFO    ][23936] Caching directory '_grains/' for environment 'base'
2017-10-25 01:39:16,433 [salt.fileclient  ][INFO    ][23936] Fetching file from saltenv 'base', ** done ** '_grains/ceilometer_policy.py'
2017-10-25 01:39:16,529 [salt.fileclient  ][INFO    ][23936] Fetching file from saltenv 'base', ** done ** '_grains/ceph.py'
2017-10-25 01:39:16,641 [salt.fileclient  ][INFO    ][23936] Fetching file from saltenv 'base', ** done ** '_grains/cinder_policy.py'
2017-10-25 01:39:16,706 [salt.fileclient  ][INFO    ][23936] Fetching file from saltenv 'base', ** done ** '_grains/docker_swarm.py'
2017-10-25 01:39:16,778 [salt.fileclient  ][INFO    ][23936] Fetching file from saltenv 'base', ** done ** '_grains/glance_policy.py'
2017-10-25 01:39:16,809 [salt.fileclient  ][INFO    ][23936] Fetching file from saltenv 'base', ** done ** '_grains/heat_policy.py'
2017-10-25 01:39:16,887 [salt.fileclient  ][INFO    ][23936] Fetching file from saltenv 'base', ** done ** '_grains/jenkins_plugins.py'
2017-10-25 01:39:16,934 [salt.fileclient  ][INFO    ][23936] Fetching file from saltenv 'base', ** done ** '_grains/keystone_policy.py'
2017-10-25 01:39:17,013 [salt.fileclient  ][INFO    ][23936] Fetching file from saltenv 'base', ** done ** '_grains/kubernetes.py'
2017-10-25 01:39:17,091 [salt.fileclient  ][INFO    ][23936] Fetching file from saltenv 'base', ** done ** '_grains/neutron_policy.py'
2017-10-25 01:39:17,133 [salt.fileclient  ][INFO    ][23936] Fetching file from saltenv 'base', ** done ** '_grains/nova_policy.py'
2017-10-25 01:39:17,175 [salt.fileclient  ][INFO    ][23936] Fetching file from saltenv 'base', ** done ** '_grains/ssh_fingerprints.py'
2017-10-25 01:39:17,178 [salt.utils.extmods][INFO    ][23936] Copying '/var/cache/salt/minion/files/base/_grains/ceilometer_policy.py' to '/var/cache/salt/minion/extmods/grains/ceilometer_policy.py'
2017-10-25 01:39:17,208 [salt.utils.extmods][INFO    ][23936] Copying '/var/cache/salt/minion/files/base/_grains/ceph.py' to '/var/cache/salt/minion/extmods/grains/ceph.py'
2017-10-25 01:39:17,221 [salt.utils.extmods][INFO    ][23936] Copying '/var/cache/salt/minion/files/base/_grains/cinder_policy.py' to '/var/cache/salt/minion/extmods/grains/cinder_policy.py'
2017-10-25 01:39:17,231 [salt.utils.extmods][INFO    ][23936] Copying '/var/cache/salt/minion/files/base/_grains/docker_swarm.py' to '/var/cache/salt/minion/extmods/grains/docker_swarm.py'
2017-10-25 01:39:17,244 [salt.utils.extmods][INFO    ][23936] Copying '/var/cache/salt/minion/files/base/_grains/glance_policy.py' to '/var/cache/salt/minion/extmods/grains/glance_policy.py'
2017-10-25 01:39:17,264 [salt.utils.extmods][INFO    ][23936] Copying '/var/cache/salt/minion/files/base/_grains/heat_policy.py' to '/var/cache/salt/minion/extmods/grains/heat_policy.py'
2017-10-25 01:39:17,278 [salt.utils.extmods][INFO    ][23936] Copying '/var/cache/salt/minion/files/base/_grains/jenkins_plugins.py' to '/var/cache/salt/minion/extmods/grains/jenkins_plugins.py'
2017-10-25 01:39:17,305 [salt.utils.extmods][INFO    ][23936] Copying '/var/cache/salt/minion/files/base/_grains/keystone_policy.py' to '/var/cache/salt/minion/extmods/grains/keystone_policy.py'
2017-10-25 01:39:17,315 [salt.utils.extmods][INFO    ][23936] Copying '/var/cache/salt/minion/files/base/_grains/kubernetes.py' to '/var/cache/salt/minion/extmods/grains/kubernetes.py'
2017-10-25 01:39:17,315 [salt.utils.extmods][INFO    ][23936] Copying '/var/cache/salt/minion/files/base/_grains/neutron_policy.py' to '/var/cache/salt/minion/extmods/grains/neutron_policy.py'
2017-10-25 01:39:17,315 [salt.utils.extmods][INFO    ][23936] Copying '/var/cache/salt/minion/files/base/_grains/nova_policy.py' to '/var/cache/salt/minion/extmods/grains/nova_policy.py'
2017-10-25 01:39:17,323 [salt.utils.extmods][INFO    ][23936] Copying '/var/cache/salt/minion/files/base/_grains/ssh_fingerprints.py' to '/var/cache/salt/minion/extmods/grains/ssh_fingerprints.py'
2017-10-25 01:39:17,324 [salt.utils.extmods][INFO    ][23936] Creating module dir '/var/cache/salt/minion/extmods/renderers'
2017-10-25 01:39:17,327 [salt.utils.extmods][INFO    ][23936] Syncing renderers for environment 'base'
2017-10-25 01:39:17,327 [salt.utils.extmods][INFO    ][23936] Loading cache from salt://_renderers, for base)
2017-10-25 01:39:17,327 [salt.fileclient  ][INFO    ][23936] Caching directory '_renderers/' for environment 'base'
2017-10-25 01:39:17,358 [salt.utils.extmods][INFO    ][23936] Creating module dir '/var/cache/salt/minion/extmods/returners'
2017-10-25 01:39:17,361 [salt.utils.extmods][INFO    ][23936] Syncing returners for environment 'base'
2017-10-25 01:39:17,361 [salt.utils.extmods][INFO    ][23936] Loading cache from salt://_returners, for base)
2017-10-25 01:39:17,361 [salt.fileclient  ][INFO    ][23936] Caching directory '_returners/' for environment 'base'
2017-10-25 01:39:17,394 [salt.utils.extmods][INFO    ][23936] Creating module dir '/var/cache/salt/minion/extmods/output'
2017-10-25 01:39:17,396 [salt.utils.extmods][INFO    ][23936] Syncing output for environment 'base'
2017-10-25 01:39:17,396 [salt.utils.extmods][INFO    ][23936] Loading cache from salt://_output, for base)
2017-10-25 01:39:17,396 [salt.fileclient  ][INFO    ][23936] Caching directory '_output/' for environment 'base'
2017-10-25 01:39:17,428 [salt.utils.extmods][INFO    ][23936] Creating module dir '/var/cache/salt/minion/extmods/utils'
2017-10-25 01:39:17,430 [salt.utils.extmods][INFO    ][23936] Syncing utils for environment 'base'
2017-10-25 01:39:17,430 [salt.utils.extmods][INFO    ][23936] Loading cache from salt://_utils, for base)
2017-10-25 01:39:17,431 [salt.fileclient  ][INFO    ][23936] Caching directory '_utils/' for environment 'base'
2017-10-25 01:39:17,463 [salt.utils.extmods][INFO    ][23936] Creating module dir '/var/cache/salt/minion/extmods/log_handlers'
2017-10-25 01:39:17,465 [salt.utils.extmods][INFO    ][23936] Syncing log_handlers for environment 'base'
2017-10-25 01:39:17,466 [salt.utils.extmods][INFO    ][23936] Loading cache from salt://_log_handlers, for base)
2017-10-25 01:39:17,466 [salt.fileclient  ][INFO    ][23936] Caching directory '_log_handlers/' for environment 'base'
2017-10-25 01:39:17,497 [salt.utils.extmods][INFO    ][23936] Creating module dir '/var/cache/salt/minion/extmods/proxy'
2017-10-25 01:39:17,500 [salt.utils.extmods][INFO    ][23936] Syncing proxy for environment 'base'
2017-10-25 01:39:17,500 [salt.utils.extmods][INFO    ][23936] Loading cache from salt://_proxy, for base)
2017-10-25 01:39:17,500 [salt.fileclient  ][INFO    ][23936] Caching directory '_proxy/' for environment 'base'
2017-10-25 01:39:17,532 [salt.utils.extmods][INFO    ][23936] Creating module dir '/var/cache/salt/minion/extmods/engines'
2017-10-25 01:39:17,534 [salt.utils.extmods][INFO    ][23936] Syncing engines for environment 'base'
2017-10-25 01:39:17,534 [salt.utils.extmods][INFO    ][23936] Loading cache from salt://_engines, for base)
2017-10-25 01:39:17,534 [salt.fileclient  ][INFO    ][23936] Caching directory '_engines/' for environment 'base'
2017-10-25 01:39:17,572 [salt.minion      ][INFO    ][23936] Returning information for job: 20171025013906015235
2017-10-25 01:39:18,919 [salt.minion      ][INFO    ][23807] User sudo_ubuntu Executing command state.sls with jid 20171025013918484277
2017-10-25 01:39:18,931 [salt.minion      ][INFO    ][24067] Starting a new job with PID 24067
2017-10-25 01:39:19,353 [salt.state       ][INFO    ][24067] Loading fresh modules for state activity
2017-10-25 01:39:19,379 [salt.fileclient  ][INFO    ][24067] Fetching file from saltenv 'base', ** done ** 'salt/control/init.sls'
2017-10-25 01:39:19,412 [salt.fileclient  ][INFO    ][24067] Fetching file from saltenv 'base', ** done ** 'salt/control/virt.sls'
2017-10-25 01:39:19,482 [salt.fileclient  ][INFO    ][24067] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-10-25 01:39:19,551 [salt.fileclient  ][INFO    ][24067] Fetching file from saltenv 'base', ** done ** 'salt/minion/init.sls'
2017-10-25 01:39:19,565 [salt.fileclient  ][INFO    ][24067] Fetching file from saltenv 'base', ** done ** 'salt/minion/service.sls'
2017-10-25 01:39:19,591 [salt.fileclient  ][INFO    ][24067] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-10-25 01:39:19,643 [salt.fileclient  ][INFO    ][24067] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-10-25 01:39:19,663 [salt.fileclient  ][INFO    ][24067] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-10-25 01:39:19,709 [salt.fileclient  ][INFO    ][24067] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-10-25 01:39:19,727 [salt.fileclient  ][INFO    ][24067] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-10-25 01:39:19,743 [salt.fileclient  ][INFO    ][24067] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-10-25 01:39:19,757 [salt.fileclient  ][INFO    ][24067] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-10-25 01:39:19,765 [salt.loaded.int.module.cmdmod][INFO    ][24067] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-10-25 01:39:19,787 [salt.fileclient  ][INFO    ][24067] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-10-25 01:39:19,802 [py.warnings      ][WARNING ][24067] /usr/lib/python2.7/dist-packages/salt/utils/templates.py:73: DeprecationWarning: Starting in 2015.5, cmd.run uses python_shell=False by default, which doesn't support shellisms (pipes, env variables, etc). cmd.run is currently aliased to cmd.shell to prevent breakage. Please switch to cmd.shell or set python_shell=True to avoid breakage in the future, when this aliasing is removed.

2017-10-25 01:39:19,803 [salt.loaded.int.module.cmdmod][INFO    ][24067] Executing command 'salt-minion --version' in directory '/root'
2017-10-25 01:39:20,061 [salt.fileclient  ][INFO    ][24067] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-10-25 01:39:20,078 [salt.fileclient  ][INFO    ][24067] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-10-25 01:39:20,089 [salt.fileclient  ][INFO    ][24067] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-10-25 01:39:20,100 [salt.fileclient  ][INFO    ][24067] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-10-25 01:39:20,144 [salt.fileclient  ][INFO    ][24067] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-10-25 01:39:20,178 [salt.fileclient  ][INFO    ][24067] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-10-25 01:39:20,235 [salt.fileclient  ][INFO    ][24067] Fetching file from saltenv 'base', ** done ** 'salt/minion/grains.sls'
2017-10-25 01:39:20,315 [salt.fileclient  ][INFO    ][24067] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-10-25 01:39:20,367 [salt.fileclient  ][INFO    ][24067] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-10-25 01:39:20,384 [salt.fileclient  ][INFO    ][24067] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-10-25 01:39:20,425 [salt.fileclient  ][INFO    ][24067] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-10-25 01:39:20,443 [salt.fileclient  ][INFO    ][24067] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-10-25 01:39:20,456 [salt.fileclient  ][INFO    ][24067] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-10-25 01:39:20,474 [salt.fileclient  ][INFO    ][24067] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-10-25 01:39:20,481 [salt.loaded.int.module.cmdmod][INFO    ][24067] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-10-25 01:39:20,503 [salt.fileclient  ][INFO    ][24067] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-10-25 01:39:20,518 [salt.loaded.int.module.cmdmod][INFO    ][24067] Executing command 'salt-minion --version' in directory '/root'
2017-10-25 01:39:20,764 [salt.fileclient  ][INFO    ][24067] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-10-25 01:39:20,784 [salt.fileclient  ][INFO    ][24067] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-10-25 01:39:20,831 [salt.fileclient  ][INFO    ][24067] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-10-25 01:39:20,844 [salt.fileclient  ][INFO    ][24067] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-10-25 01:39:20,888 [salt.fileclient  ][INFO    ][24067] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-10-25 01:39:20,922 [salt.fileclient  ][INFO    ][24067] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-10-25 01:39:21,021 [salt.fileclient  ][INFO    ][24067] Fetching file from saltenv 'base', ** done ** 'salt/minion/cert.sls'
2017-10-25 01:39:21,079 [salt.fileclient  ][INFO    ][24067] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-10-25 01:39:21,522 [salt.state       ][INFO    ][24067] Running state [salt-minion] at time 01:39:21.521790
2017-10-25 01:39:21,522 [salt.state       ][INFO    ][24067] Executing state pkg.installed for salt-minion
2017-10-25 01:39:21,523 [salt.loaded.int.module.cmdmod][INFO    ][24067] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-10-25 01:39:21,790 [salt.state       ][INFO    ][24067] Package salt-minion is already installed
2017-10-25 01:39:21,790 [salt.state       ][INFO    ][24067] Completed state [salt-minion] at time 01:39:21.790072 duration_in_ms=268.281
2017-10-25 01:39:21,790 [salt.state       ][INFO    ][24067] Running state [salt_minion_dependency_packages] at time 01:39:21.790396
2017-10-25 01:39:21,791 [salt.state       ][INFO    ][24067] Executing state pkg.installed for salt_minion_dependency_packages
2017-10-25 01:39:21,795 [salt.state       ][INFO    ][24067] All specified packages are already installed
2017-10-25 01:39:21,795 [salt.state       ][INFO    ][24067] Completed state [salt_minion_dependency_packages] at time 01:39:21.794772 duration_in_ms=4.377
2017-10-25 01:39:21,797 [salt.state       ][INFO    ][24067] Running state [/etc/salt/minion.d/minion.conf] at time 01:39:21.796674
2017-10-25 01:39:21,797 [salt.state       ][INFO    ][24067] Executing state file.managed for /etc/salt/minion.d/minion.conf
2017-10-25 01:39:21,818 [salt.fileclient  ][INFO    ][24067] Fetching file from saltenv 'base', ** done ** 'salt/files/minion.conf'
2017-10-25 01:39:21,867 [salt.fileclient  ][INFO    ][24067] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-10-25 01:39:21,909 [salt.fileclient  ][INFO    ][24067] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-10-25 01:39:21,941 [salt.state       ][INFO    ][24067] File /etc/salt/minion.d/minion.conf is in the correct state
2017-10-25 01:39:21,941 [salt.state       ][INFO    ][24067] Completed state [/etc/salt/minion.d/minion.conf] at time 01:39:21.941264 duration_in_ms=144.59
2017-10-25 01:39:21,942 [salt.state       ][INFO    ][24067] Running state [/etc/salt/minion.d/_virt.conf] at time 01:39:21.941576
2017-10-25 01:39:21,942 [salt.state       ][INFO    ][24067] Executing state file.managed for /etc/salt/minion.d/_virt.conf
2017-10-25 01:39:22,048 [salt.state       ][INFO    ][24067] File /etc/salt/minion.d/_virt.conf is in the correct state
2017-10-25 01:39:22,049 [salt.state       ][INFO    ][24067] Completed state [/etc/salt/minion.d/_virt.conf] at time 01:39:22.048580 duration_in_ms=107.004
2017-10-25 01:39:22,050 [salt.state       ][INFO    ][24067] Running state [salt-minion] at time 01:39:22.050264
2017-10-25 01:39:22,050 [salt.state       ][INFO    ][24067] Executing state service.running for salt-minion
2017-10-25 01:39:22,051 [salt.loaded.int.module.cmdmod][INFO    ][24067] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2017-10-25 01:39:22,070 [salt.loaded.int.module.cmdmod][INFO    ][24067] Executing command ['systemctl', 'is-active', 'salt-minion.service'] in directory '/root'
2017-10-25 01:39:22,079 [salt.loaded.int.module.cmdmod][INFO    ][24067] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2017-10-25 01:39:22,087 [salt.state       ][INFO    ][24067] The service salt-minion is already running
2017-10-25 01:39:22,088 [salt.state       ][INFO    ][24067] Completed state [salt-minion] at time 01:39:22.087603 duration_in_ms=37.339
2017-10-25 01:39:22,089 [salt.state       ][INFO    ][24067] Running state [/etc/salt/grains.d] at time 01:39:22.088943
2017-10-25 01:39:22,089 [salt.state       ][INFO    ][24067] Executing state file.directory for /etc/salt/grains.d
2017-10-25 01:39:22,090 [salt.state       ][INFO    ][24067] Directory /etc/salt/grains.d is in the correct state
2017-10-25 01:39:22,090 [salt.state       ][INFO    ][24067] Completed state [/etc/salt/grains.d] at time 01:39:22.089904 duration_in_ms=0.96
2017-10-25 01:39:22,090 [salt.state       ][INFO    ][24067] Running state [/etc/salt/grains] at time 01:39:22.090371
2017-10-25 01:39:22,091 [salt.state       ][INFO    ][24067] Executing state file.managed for /etc/salt/grains
2017-10-25 01:39:22,091 [salt.state       ][INFO    ][24067] File /etc/salt/grains exists with proper permissions. No changes made.
2017-10-25 01:39:22,091 [salt.state       ][INFO    ][24067] Completed state [/etc/salt/grains] at time 01:39:22.091090 duration_in_ms=0.719
2017-10-25 01:39:22,091 [salt.state       ][INFO    ][24067] Running state [/etc/salt/grains.d/placeholder] at time 01:39:22.091401
2017-10-25 01:39:22,092 [salt.state       ][INFO    ][24067] Executing state file.managed for /etc/salt/grains.d/placeholder
2017-10-25 01:39:22,092 [salt.state       ][INFO    ][24067] File /etc/salt/grains.d/placeholder exists with proper permissions. No changes made.
2017-10-25 01:39:22,092 [salt.state       ][INFO    ][24067] Completed state [/etc/salt/grains.d/placeholder] at time 01:39:22.092101 duration_in_ms=0.7
2017-10-25 01:39:22,092 [salt.state       ][INFO    ][24067] Running state [/etc/salt/grains.d/sphinx] at time 01:39:22.092388
2017-10-25 01:39:22,093 [salt.state       ][INFO    ][24067] Executing state file.managed for /etc/salt/grains.d/sphinx
2017-10-25 01:39:22,222 [salt.state       ][INFO    ][24067] File changed:
--- 
+++ 
@@ -49,7 +49,6 @@
               - 10.167.4.141
               - 127.0.0.1
               - 192.168.11.2
-              - 192.168.122.1
         system:
           name: System
           param:

2017-10-25 01:39:22,222 [salt.state       ][INFO    ][24067] Completed state [/etc/salt/grains.d/sphinx] at time 01:39:22.222416 duration_in_ms=130.027
2017-10-25 01:39:22,223 [salt.state       ][INFO    ][24067] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 01:39:22.223039
2017-10-25 01:39:22,223 [salt.state       ][INFO    ][24067] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-10-25 01:39:22,223 [salt.state       ][INFO    ][24067] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-10-25 01:39:22,224 [salt.state       ][INFO    ][24067] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 01:39:22.223548 duration_in_ms=0.51
2017-10-25 01:39:22,224 [salt.state       ][INFO    ][24067] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 01:39:22.223666
2017-10-25 01:39:22,224 [salt.state       ][INFO    ][24067] Executing state cmd.mod_watch for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-10-25 01:39:22,224 [salt.loaded.int.module.cmdmod][INFO    ][24067] Executing command 'python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"' in directory '/root'
2017-10-25 01:39:22,309 [salt.state       ][INFO    ][24067] {'pid': 24116, 'retcode': 0, 'stderr': '', 'stdout': ''}
2017-10-25 01:39:22,342 [salt.state       ][INFO    ][24067] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 01:39:22.341722 duration_in_ms=118.055
2017-10-25 01:39:22,342 [salt.state       ][INFO    ][24067] Running state [/etc/salt/grains.d/dns_records] at time 01:39:22.342238
2017-10-25 01:39:22,343 [salt.state       ][INFO    ][24067] Executing state file.managed for /etc/salt/grains.d/dns_records
2017-10-25 01:39:22,477 [salt.state       ][INFO    ][24067] File /etc/salt/grains.d/dns_records is in the correct state
2017-10-25 01:39:22,478 [salt.state       ][INFO    ][24067] Completed state [/etc/salt/grains.d/dns_records] at time 01:39:22.477570 duration_in_ms=135.331
2017-10-25 01:39:22,478 [salt.state       ][INFO    ][24067] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 01:39:22.478346
2017-10-25 01:39:22,479 [salt.state       ][INFO    ][24067] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"
2017-10-25 01:39:22,479 [salt.state       ][INFO    ][24067] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"
2017-10-25 01:39:22,479 [salt.state       ][INFO    ][24067] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 01:39:22.479145 duration_in_ms=0.799
2017-10-25 01:39:22,480 [salt.state       ][INFO    ][24067] Running state [/etc/salt/grains.d/salt] at time 01:39:22.479576
2017-10-25 01:39:22,480 [salt.state       ][INFO    ][24067] Executing state file.managed for /etc/salt/grains.d/salt
2017-10-25 01:39:22,611 [salt.state       ][INFO    ][24067] File /etc/salt/grains.d/salt is in the correct state
2017-10-25 01:39:22,611 [salt.state       ][INFO    ][24067] Completed state [/etc/salt/grains.d/salt] at time 01:39:22.611307 duration_in_ms=131.73
2017-10-25 01:39:22,612 [salt.state       ][INFO    ][24067] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 01:39:22.612009
2017-10-25 01:39:22,612 [salt.state       ][INFO    ][24067] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2017-10-25 01:39:22,613 [salt.state       ][INFO    ][24067] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2017-10-25 01:39:22,613 [salt.state       ][INFO    ][24067] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 01:39:22.612632 duration_in_ms=0.623
2017-10-25 01:39:22,614 [salt.state       ][INFO    ][24067] Running state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 01:39:22.613907
2017-10-25 01:39:22,614 [salt.state       ][INFO    ][24067] Executing state cmd.wait for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-10-25 01:39:22,614 [salt.state       ][INFO    ][24067] No changes made for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-10-25 01:39:22,614 [salt.state       ][INFO    ][24067] Completed state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 01:39:22.614444 duration_in_ms=0.537
2017-10-25 01:39:22,615 [salt.state       ][INFO    ][24067] Running state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 01:39:22.614579
2017-10-25 01:39:22,615 [salt.state       ][INFO    ][24067] Executing state cmd.mod_watch for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-10-25 01:39:22,616 [salt.loaded.int.module.cmdmod][INFO    ][24067] Executing command 'cat /etc/salt/grains.d/* > /etc/salt/grains' in directory '/root'
2017-10-25 01:39:22,626 [salt.state       ][INFO    ][24067] {'pid': 24118, 'retcode': 0, 'stderr': '', 'stdout': ''}
2017-10-25 01:39:22,626 [salt.state       ][INFO    ][24067] Completed state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 01:39:22.626294 duration_in_ms=11.714
2017-10-25 01:39:22,627 [salt.state       ][INFO    ][24067] Running state [mine.update] at time 01:39:22.626906
2017-10-25 01:39:22,627 [salt.state       ][INFO    ][24067] Executing state module.wait for mine.update
2017-10-25 01:39:22,627 [salt.state       ][INFO    ][24067] No changes made for mine.update
2017-10-25 01:39:22,628 [salt.state       ][INFO    ][24067] Completed state [mine.update] at time 01:39:22.627627 duration_in_ms=0.721
2017-10-25 01:39:22,628 [salt.state       ][INFO    ][24067] Running state [mine.update] at time 01:39:22.627791
2017-10-25 01:39:22,628 [salt.state       ][INFO    ][24067] Executing state module.mod_watch for mine.update
2017-10-25 01:39:23,150 [salt.state       ][INFO    ][24067] {'ret': True}
2017-10-25 01:39:23,151 [salt.state       ][INFO    ][24067] Completed state [mine.update] at time 01:39:23.150484 duration_in_ms=522.692
2017-10-25 01:39:23,151 [salt.state       ][INFO    ][24067] Running state [ca-certificates] at time 01:39:23.150772
2017-10-25 01:39:23,151 [salt.state       ][INFO    ][24067] Executing state pkg.installed for ca-certificates
2017-10-25 01:39:23,154 [salt.state       ][INFO    ][24067] Package ca-certificates is already installed
2017-10-25 01:39:23,154 [salt.state       ][INFO    ][24067] Completed state [ca-certificates] at time 01:39:23.154439 duration_in_ms=3.667
2017-10-25 01:39:23,155 [salt.state       ][INFO    ][24067] Running state [update-ca-certificates] at time 01:39:23.155047
2017-10-25 01:39:23,155 [salt.state       ][INFO    ][24067] Executing state cmd.wait for update-ca-certificates
2017-10-25 01:39:23,156 [salt.state       ][INFO    ][24067] No changes made for update-ca-certificates
2017-10-25 01:39:23,156 [salt.state       ][INFO    ][24067] Completed state [update-ca-certificates] at time 01:39:23.155738 duration_in_ms=0.69
2017-10-25 01:39:23,156 [salt.state       ][INFO    ][24067] Running state [libvirt-dev] at time 01:39:23.155926
2017-10-25 01:39:23,156 [salt.state       ][INFO    ][24067] Executing state pkg.installed for libvirt-dev
2017-10-25 01:39:23,159 [salt.state       ][INFO    ][24067] Package libvirt-dev is already installed
2017-10-25 01:39:23,159 [salt.state       ][INFO    ][24067] Completed state [libvirt-dev] at time 01:39:23.159007 duration_in_ms=3.08
2017-10-25 01:39:23,159 [salt.state       ][INFO    ][24067] Running state [pkg-config] at time 01:39:23.159196
2017-10-25 01:39:23,159 [salt.state       ][INFO    ][24067] Executing state pkg.installed for pkg-config
2017-10-25 01:39:23,162 [salt.state       ][INFO    ][24067] Package pkg-config is already installed
2017-10-25 01:39:23,162 [salt.state       ][INFO    ][24067] Completed state [pkg-config] at time 01:39:23.162263 duration_in_ms=3.067
2017-10-25 01:39:23,162 [salt.state       ][INFO    ][24067] Running state [virtng.init] at time 01:39:23.162463
2017-10-25 01:39:23,163 [salt.state       ][INFO    ][24067] Executing state module.run for virtng.init
2017-10-25 01:39:23,222 [salt.loaded.int.module.cmdmod][INFO    ][24067] Executing command ['git', '--version'] in directory '/root'
2017-10-25 01:39:23,322 [salt.loaded.int.module.cmdmod][INFO    ][24067] Executing command 'virsh list --all --name| grep -E "^prx01.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-10-25 01:39:23,340 [salt.state       ][INFO    ][24067] unless execution succeeded
2017-10-25 01:39:23,340 [salt.state       ][INFO    ][24067] Completed state [virtng.init] at time 01:39:23.340297 duration_in_ms=177.833
2017-10-25 01:39:23,341 [salt.state       ][INFO    ][24067] Running state [virt.set_autostart] at time 01:39:23.340536
2017-10-25 01:39:23,341 [salt.state       ][INFO    ][24067] Executing state module.run for virt.set_autostart
2017-10-25 01:39:23,343 [salt.loaded.int.module.cmdmod][INFO    ][24067] Executing command 'virsh list --autostart --name| grep -E "^prx01.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-10-25 01:39:23,358 [salt.state       ][INFO    ][24067] unless execution succeeded
2017-10-25 01:39:23,359 [salt.state       ][INFO    ][24067] Completed state [virt.set_autostart] at time 01:39:23.358465 duration_in_ms=17.928
2017-10-25 01:39:23,359 [salt.state       ][INFO    ][24067] Running state [virtng.init] at time 01:39:23.358685
2017-10-25 01:39:23,359 [salt.state       ][INFO    ][24067] Executing state module.run for virtng.init
2017-10-25 01:39:23,361 [salt.loaded.int.module.cmdmod][INFO    ][24067] Executing command 'virsh list --all --name| grep -E "^ctl01.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-10-25 01:39:23,376 [salt.state       ][INFO    ][24067] unless execution succeeded
2017-10-25 01:39:23,376 [salt.state       ][INFO    ][24067] Completed state [virtng.init] at time 01:39:23.376016 duration_in_ms=17.33
2017-10-25 01:39:23,376 [salt.state       ][INFO    ][24067] Running state [virt.set_autostart] at time 01:39:23.376249
2017-10-25 01:39:23,376 [salt.state       ][INFO    ][24067] Executing state module.run for virt.set_autostart
2017-10-25 01:39:23,378 [salt.loaded.int.module.cmdmod][INFO    ][24067] Executing command 'virsh list --autostart --name| grep -E "^ctl01.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-10-25 01:39:23,392 [salt.state       ][INFO    ][24067] unless execution succeeded
2017-10-25 01:39:23,392 [salt.state       ][INFO    ][24067] Completed state [virt.set_autostart] at time 01:39:23.391869 duration_in_ms=15.62
2017-10-25 01:39:23,392 [salt.state       ][INFO    ][24067] Running state [virtng.init] at time 01:39:23.392082
2017-10-25 01:39:23,392 [salt.state       ][INFO    ][24067] Executing state module.run for virtng.init
2017-10-25 01:39:23,394 [salt.loaded.int.module.cmdmod][INFO    ][24067] Executing command 'virsh list --all --name| grep -E "^mdb01.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-10-25 01:39:23,409 [salt.state       ][INFO    ][24067] unless execution succeeded
2017-10-25 01:39:23,439 [salt.state       ][INFO    ][24067] Completed state [virtng.init] at time 01:39:23.438500 duration_in_ms=46.418
2017-10-25 01:39:23,439 [salt.state       ][INFO    ][24067] Running state [virt.set_autostart] at time 01:39:23.438732
2017-10-25 01:39:23,439 [salt.state       ][INFO    ][24067] Executing state module.run for virt.set_autostart
2017-10-25 01:39:23,441 [salt.loaded.int.module.cmdmod][INFO    ][24067] Executing command 'virsh list --autostart --name| grep -E "^mdb01.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-10-25 01:39:23,457 [salt.state       ][INFO    ][24067] unless execution succeeded
2017-10-25 01:39:23,457 [salt.state       ][INFO    ][24067] Completed state [virt.set_autostart] at time 01:39:23.456936 duration_in_ms=18.202
2017-10-25 01:39:23,457 [salt.state       ][INFO    ][24067] Running state [virtng.init] at time 01:39:23.457142
2017-10-25 01:39:23,457 [salt.state       ][INFO    ][24067] Executing state module.run for virtng.init
2017-10-25 01:39:23,459 [salt.loaded.int.module.cmdmod][INFO    ][24067] Executing command 'virsh list --all --name| grep -E "^msg01.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-10-25 01:39:23,473 [salt.state       ][INFO    ][24067] unless execution succeeded
2017-10-25 01:39:23,473 [salt.state       ][INFO    ][24067] Completed state [virtng.init] at time 01:39:23.472837 duration_in_ms=15.695
2017-10-25 01:39:23,473 [salt.state       ][INFO    ][24067] Running state [virt.set_autostart] at time 01:39:23.473036
2017-10-25 01:39:23,473 [salt.state       ][INFO    ][24067] Executing state module.run for virt.set_autostart
2017-10-25 01:39:23,475 [salt.loaded.int.module.cmdmod][INFO    ][24067] Executing command 'virsh list --autostart --name| grep -E "^msg01.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-10-25 01:39:23,488 [salt.state       ][INFO    ][24067] unless execution succeeded
2017-10-25 01:39:23,498 [salt.state       ][INFO    ][24067] Completed state [virt.set_autostart] at time 01:39:23.498432 duration_in_ms=25.396
2017-10-25 01:39:23,499 [salt.state       ][INFO    ][24067] Running state [virtng.init] at time 01:39:23.498674
2017-10-25 01:39:23,499 [salt.state       ][INFO    ][24067] Executing state module.run for virtng.init
2017-10-25 01:39:23,501 [salt.loaded.int.module.cmdmod][INFO    ][24067] Executing command 'virsh list --all --name| grep -E "^dbs01.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-10-25 01:39:23,514 [salt.state       ][INFO    ][24067] unless execution succeeded
2017-10-25 01:39:23,514 [salt.state       ][INFO    ][24067] Completed state [virtng.init] at time 01:39:23.513944 duration_in_ms=15.27
2017-10-25 01:39:23,514 [salt.state       ][INFO    ][24067] Running state [virt.set_autostart] at time 01:39:23.514143
2017-10-25 01:39:23,514 [salt.state       ][INFO    ][24067] Executing state module.run for virt.set_autostart
2017-10-25 01:39:23,516 [salt.loaded.int.module.cmdmod][INFO    ][24067] Executing command 'virsh list --autostart --name| grep -E "^dbs01.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-10-25 01:39:23,531 [salt.state       ][INFO    ][24067] unless execution succeeded
2017-10-25 01:39:23,559 [salt.state       ][INFO    ][24067] Completed state [virt.set_autostart] at time 01:39:23.558487 duration_in_ms=44.344
2017-10-25 01:39:23,561 [salt.minion      ][INFO    ][24067] Returning information for job: 20171025013918484277
2017-10-25 01:39:24,543 [salt.minion      ][INFO    ][23807] User sudo_ubuntu Executing command pillar.get with jid 20171025013924538441
2017-10-25 01:39:24,555 [salt.minion      ][INFO    ][24171] Starting a new job with PID 24171
2017-10-25 01:39:24,612 [salt.minion      ][INFO    ][24171] Returning information for job: 20171025013924538441
2017-10-25 01:40:44,083 [salt.minion      ][INFO    ][23807] User sudo_ubuntu Executing command saltutil.sync_all with jid 20171025014044076787
2017-10-25 01:40:44,102 [salt.minion      ][INFO    ][24202] Starting a new job with PID 24202
2017-10-25 01:40:47,076 [salt.state       ][INFO    ][24202] Loading fresh modules for state activity
2017-10-25 01:40:47,095 [salt.state       ][ERROR   ][24202] No contents found in top file
2017-10-25 01:40:47,096 [salt.utils.extmods][INFO    ][24202] Creating module dir '/var/cache/salt/minion/extmods/beacons'
2017-10-25 01:40:47,099 [salt.utils.extmods][INFO    ][24202] Syncing beacons for environment 'base'
2017-10-25 01:40:47,099 [salt.utils.extmods][INFO    ][24202] Loading cache from salt://_beacons, for base)
2017-10-25 01:40:47,099 [salt.fileclient  ][INFO    ][24202] Caching directory '_beacons/' for environment 'base'
2017-10-25 01:40:47,126 [salt.utils.extmods][INFO    ][24202] Syncing modules for environment 'base'
2017-10-25 01:40:47,127 [salt.utils.extmods][INFO    ][24202] Loading cache from salt://_modules, for base)
2017-10-25 01:40:47,127 [salt.fileclient  ][INFO    ][24202] Caching directory '_modules/' for environment 'base'
2017-10-25 01:40:47,398 [salt.fileclient  ][INFO    ][24202] Fetching file from saltenv 'base', ** done ** '_modules/ceph_ng.py'
2017-10-25 01:40:47,419 [salt.fileclient  ][INFO    ][24202] Fetching file from saltenv 'base', ** done ** '_modules/cinderng.py'
2017-10-25 01:40:47,432 [salt.fileclient  ][INFO    ][24202] Fetching file from saltenv 'base', ** done ** '_modules/contrail.py'
2017-10-25 01:40:47,470 [salt.fileclient  ][INFO    ][24202] Fetching file from saltenv 'base', ** done ** '_modules/creds.py'
2017-10-25 01:40:47,498 [salt.fileclient  ][INFO    ][24202] Fetching file from saltenv 'base', ** done ** '_modules/devops_utils.py'
2017-10-25 01:40:47,515 [salt.fileclient  ][INFO    ][24202] Fetching file from saltenv 'base', ** done ** '_modules/encode_json.py'
2017-10-25 01:40:47,528 [salt.fileclient  ][INFO    ][24202] Fetching file from saltenv 'base', ** done ** '_modules/gerrit.py'
2017-10-25 01:40:47,574 [salt.fileclient  ][INFO    ][24202] Fetching file from saltenv 'base', ** done ** '_modules/glanceng.py'
2017-10-25 01:40:47,590 [salt.fileclient  ][INFO    ][24202] Fetching file from saltenv 'base', ** done ** '_modules/heat.py'
2017-10-25 01:40:47,630 [salt.fileclient  ][INFO    ][24202] Fetching file from saltenv 'base', ** done ** '_modules/heka_alarming.py'
2017-10-25 01:40:47,640 [salt.fileclient  ][INFO    ][24202] Fetching file from saltenv 'base', ** done ** '_modules/helm.py'
2017-10-25 01:40:47,680 [salt.fileclient  ][INFO    ][24202] Fetching file from saltenv 'base', ** done ** '_modules/jenkins_common.py'
2017-10-25 01:40:47,709 [salt.fileclient  ][INFO    ][24202] Fetching file from saltenv 'base', ** done ** '_modules/keystone_policy.py'
2017-10-25 01:40:47,718 [salt.fileclient  ][INFO    ][24202] Fetching file from saltenv 'base', ** done ** '_modules/linux_hosts.py'
2017-10-25 01:40:47,747 [salt.fileclient  ][INFO    ][24202] Fetching file from saltenv 'base', ** done ** '_modules/linux_netlink.py'
2017-10-25 01:40:47,797 [salt.fileclient  ][INFO    ][24202] Fetching file from saltenv 'base', ** done ** '_modules/maas.py'
2017-10-25 01:40:47,811 [salt.fileclient  ][INFO    ][24202] Fetching file from saltenv 'base', ** done ** '_modules/maas_client.py'
2017-10-25 01:40:47,821 [salt.fileclient  ][INFO    ][24202] Fetching file from saltenv 'base', ** done ** '_modules/multipart.py'
2017-10-25 01:40:47,852 [salt.fileclient  ][INFO    ][24202] Fetching file from saltenv 'base', ** done ** '_modules/nagios_alarming.py'
2017-10-25 01:40:47,871 [salt.fileclient  ][INFO    ][24202] Fetching file from saltenv 'base', ** done ** '_modules/neutronng.py'
2017-10-25 01:40:47,890 [salt.fileclient  ][INFO    ][24202] Fetching file from saltenv 'base', ** done ** '_modules/novang.py'
2017-10-25 01:40:47,925 [salt.fileclient  ][INFO    ][24202] Fetching file from saltenv 'base', ** done ** '_modules/reclass.py'
2017-10-25 01:40:47,932 [salt.fileclient  ][INFO    ][24202] Fetching file from saltenv 'base', ** done ** '_modules/rsyslog_util.py'
2017-10-25 01:40:47,981 [salt.fileclient  ][INFO    ][24202] Fetching file from saltenv 'base', ** done ** '_modules/rundeck.py'
2017-10-25 01:40:47,993 [salt.fileclient  ][INFO    ][24202] Fetching file from saltenv 'base', ** done ** '_modules/saltkey.py'
2017-10-25 01:40:48,015 [salt.fileclient  ][INFO    ][24202] Fetching file from saltenv 'base', ** done ** '_modules/saltresource.py'
2017-10-25 01:40:48,041 [salt.fileclient  ][INFO    ][24202] Fetching file from saltenv 'base', ** done ** '_modules/seedng.py'
2017-10-25 01:40:48,080 [salt.fileclient  ][INFO    ][24202] Fetching file from saltenv 'base', ** done ** '_modules/testing/credentials.py'
2017-10-25 01:40:48,095 [salt.fileclient  ][INFO    ][24202] Fetching file from saltenv 'base', ** done ** '_modules/testing/django.py'
2017-10-25 01:40:48,117 [salt.fileclient  ][INFO    ][24202] Fetching file from saltenv 'base', ** done ** '_modules/testing/django_client_proxy.py'
2017-10-25 01:40:48,136 [salt.fileclient  ][INFO    ][24202] Fetching file from saltenv 'base', ** done ** '_modules/utils.py'
2017-10-25 01:40:48,180 [salt.fileclient  ][INFO    ][24202] Fetching file from saltenv 'base', ** done ** '_modules/virtng.py'
2017-10-25 01:40:48,183 [salt.utils.extmods][INFO    ][24202] Copying '/var/cache/salt/minion/files/base/_modules/__init__.py' to '/var/cache/salt/minion/extmods/modules/__init__.py'
2017-10-25 01:40:48,183 [salt.utils.extmods][INFO    ][24202] Copying '/var/cache/salt/minion/files/base/_modules/ceph_ng.py' to '/var/cache/salt/minion/extmods/modules/ceph_ng.py'
2017-10-25 01:40:48,184 [salt.utils.extmods][INFO    ][24202] Copying '/var/cache/salt/minion/files/base/_modules/cinderng.py' to '/var/cache/salt/minion/extmods/modules/cinderng.py'
2017-10-25 01:40:48,184 [salt.utils.extmods][INFO    ][24202] Copying '/var/cache/salt/minion/files/base/_modules/contrail.py' to '/var/cache/salt/minion/extmods/modules/contrail.py'
2017-10-25 01:40:48,184 [salt.utils.extmods][INFO    ][24202] Copying '/var/cache/salt/minion/files/base/_modules/creds.py' to '/var/cache/salt/minion/extmods/modules/creds.py'
2017-10-25 01:40:48,184 [salt.utils.extmods][INFO    ][24202] Copying '/var/cache/salt/minion/files/base/_modules/devops_utils.py' to '/var/cache/salt/minion/extmods/modules/devops_utils.py'
2017-10-25 01:40:48,185 [salt.utils.extmods][INFO    ][24202] Copying '/var/cache/salt/minion/files/base/_modules/encode_json.py' to '/var/cache/salt/minion/extmods/modules/encode_json.py'
2017-10-25 01:40:48,185 [salt.utils.extmods][INFO    ][24202] Copying '/var/cache/salt/minion/files/base/_modules/gerrit.py' to '/var/cache/salt/minion/extmods/modules/gerrit.py'
2017-10-25 01:40:48,185 [salt.utils.extmods][INFO    ][24202] Copying '/var/cache/salt/minion/files/base/_modules/glanceng.py' to '/var/cache/salt/minion/extmods/modules/glanceng.py'
2017-10-25 01:40:48,185 [salt.utils.extmods][INFO    ][24202] Copying '/var/cache/salt/minion/files/base/_modules/heat.py' to '/var/cache/salt/minion/extmods/modules/heat.py'
2017-10-25 01:40:48,185 [salt.utils.extmods][INFO    ][24202] Copying '/var/cache/salt/minion/files/base/_modules/heka_alarming.py' to '/var/cache/salt/minion/extmods/modules/heka_alarming.py'
2017-10-25 01:40:48,186 [salt.utils.extmods][INFO    ][24202] Copying '/var/cache/salt/minion/files/base/_modules/helm.py' to '/var/cache/salt/minion/extmods/modules/helm.py'
2017-10-25 01:40:48,186 [salt.utils.extmods][INFO    ][24202] Copying '/var/cache/salt/minion/files/base/_modules/jenkins_common.py' to '/var/cache/salt/minion/extmods/modules/jenkins_common.py'
2017-10-25 01:40:48,186 [salt.utils.extmods][INFO    ][24202] Copying '/var/cache/salt/minion/files/base/_modules/keystone_policy.py' to '/var/cache/salt/minion/extmods/modules/keystone_policy.py'
2017-10-25 01:40:48,186 [salt.utils.extmods][INFO    ][24202] Copying '/var/cache/salt/minion/files/base/_modules/linux_hosts.py' to '/var/cache/salt/minion/extmods/modules/linux_hosts.py'
2017-10-25 01:40:48,186 [salt.utils.extmods][INFO    ][24202] Copying '/var/cache/salt/minion/files/base/_modules/linux_netlink.py' to '/var/cache/salt/minion/extmods/modules/linux_netlink.py'
2017-10-25 01:40:48,186 [salt.utils.extmods][INFO    ][24202] Copying '/var/cache/salt/minion/files/base/_modules/maas.py' to '/var/cache/salt/minion/extmods/modules/maas.py'
2017-10-25 01:40:48,187 [salt.utils.extmods][INFO    ][24202] Copying '/var/cache/salt/minion/files/base/_modules/maas_client.py' to '/var/cache/salt/minion/extmods/modules/maas_client.py'
2017-10-25 01:40:48,187 [salt.utils.extmods][INFO    ][24202] Copying '/var/cache/salt/minion/files/base/_modules/multipart.py' to '/var/cache/salt/minion/extmods/modules/multipart.py'
2017-10-25 01:40:48,187 [salt.utils.extmods][INFO    ][24202] Copying '/var/cache/salt/minion/files/base/_modules/nagios_alarming.py' to '/var/cache/salt/minion/extmods/modules/nagios_alarming.py'
2017-10-25 01:40:48,187 [salt.utils.extmods][INFO    ][24202] Copying '/var/cache/salt/minion/files/base/_modules/neutronng.py' to '/var/cache/salt/minion/extmods/modules/neutronng.py'
2017-10-25 01:40:48,187 [salt.utils.extmods][INFO    ][24202] Copying '/var/cache/salt/minion/files/base/_modules/novang.py' to '/var/cache/salt/minion/extmods/modules/novang.py'
2017-10-25 01:40:48,188 [salt.utils.extmods][INFO    ][24202] Copying '/var/cache/salt/minion/files/base/_modules/reclass.py' to '/var/cache/salt/minion/extmods/modules/reclass.py'
2017-10-25 01:40:48,188 [salt.utils.extmods][INFO    ][24202] Copying '/var/cache/salt/minion/files/base/_modules/rsyslog_util.py' to '/var/cache/salt/minion/extmods/modules/rsyslog_util.py'
2017-10-25 01:40:48,188 [salt.utils.extmods][INFO    ][24202] Copying '/var/cache/salt/minion/files/base/_modules/rundeck.py' to '/var/cache/salt/minion/extmods/modules/rundeck.py'
2017-10-25 01:40:48,188 [salt.utils.extmods][INFO    ][24202] Copying '/var/cache/salt/minion/files/base/_modules/saltkey.py' to '/var/cache/salt/minion/extmods/modules/saltkey.py'
2017-10-25 01:40:48,189 [salt.utils.extmods][INFO    ][24202] Copying '/var/cache/salt/minion/files/base/_modules/saltresource.py' to '/var/cache/salt/minion/extmods/modules/saltresource.py'
2017-10-25 01:40:48,189 [salt.utils.extmods][INFO    ][24202] Copying '/var/cache/salt/minion/files/base/_modules/seedng.py' to '/var/cache/salt/minion/extmods/modules/seedng.py'
2017-10-25 01:40:48,189 [salt.utils.extmods][INFO    ][24202] Copying '/var/cache/salt/minion/files/base/_modules/testing/__init__.py' to '/var/cache/salt/minion/extmods/modules/testing/__init__.py'
2017-10-25 01:40:48,189 [salt.utils.extmods][INFO    ][24202] Copying '/var/cache/salt/minion/files/base/_modules/testing/credentials.py' to '/var/cache/salt/minion/extmods/modules/testing/credentials.py'
2017-10-25 01:40:48,189 [salt.utils.extmods][INFO    ][24202] Copying '/var/cache/salt/minion/files/base/_modules/testing/django.py' to '/var/cache/salt/minion/extmods/modules/testing/django.py'
2017-10-25 01:40:48,190 [salt.utils.extmods][INFO    ][24202] Copying '/var/cache/salt/minion/files/base/_modules/testing/django_client_proxy.py' to '/var/cache/salt/minion/extmods/modules/testing/django_client_proxy.py'
2017-10-25 01:40:48,190 [salt.utils.extmods][INFO    ][24202] Copying '/var/cache/salt/minion/files/base/_modules/utils.py' to '/var/cache/salt/minion/extmods/modules/utils.py'
2017-10-25 01:40:48,190 [salt.utils.extmods][INFO    ][24202] Copying '/var/cache/salt/minion/files/base/_modules/virtng.py' to '/var/cache/salt/minion/extmods/modules/virtng.py'
2017-10-25 01:40:48,195 [salt.utils.extmods][INFO    ][24202] Syncing states for environment 'base'
2017-10-25 01:40:48,195 [salt.utils.extmods][INFO    ][24202] Loading cache from salt://_states, for base)
2017-10-25 01:40:48,195 [salt.fileclient  ][INFO    ][24202] Caching directory '_states/' for environment 'base'
2017-10-25 01:40:48,251 [salt.fileclient  ][INFO    ][24202] Fetching file from saltenv 'base', ** done ** '_states/cinderng.py'
2017-10-25 01:40:48,261 [salt.fileclient  ][INFO    ][24202] Fetching file from saltenv 'base', ** done ** '_states/contrail.py'
2017-10-25 01:40:48,273 [salt.fileclient  ][INFO    ][24202] Fetching file from saltenv 'base', ** done ** '_states/gerrit.py'
2017-10-25 01:40:48,281 [salt.fileclient  ][INFO    ][24202] Fetching file from saltenv 'base', ** done ** '_states/glanceng.py'
2017-10-25 01:40:48,289 [salt.fileclient  ][INFO    ][24202] Fetching file from saltenv 'base', ** done ** '_states/grafana3_dashboard.py'
2017-10-25 01:40:48,350 [salt.fileclient  ][INFO    ][24202] Fetching file from saltenv 'base', ** done ** '_states/grafana3_datasource.py'
2017-10-25 01:40:48,381 [salt.fileclient  ][INFO    ][24202] Fetching file from saltenv 'base', ** done ** '_states/heat.py'
2017-10-25 01:40:48,397 [salt.fileclient  ][INFO    ][24202] Fetching file from saltenv 'base', ** done ** '_states/helm_release.py'
2017-10-25 01:40:48,419 [salt.fileclient  ][INFO    ][24202] Fetching file from saltenv 'base', ** done ** '_states/jenkins_approval.py'
2017-10-25 01:40:48,443 [salt.fileclient  ][INFO    ][24202] Fetching file from saltenv 'base', ** done ** '_states/jenkins_artifactory.py'
2017-10-25 01:40:48,452 [salt.fileclient  ][INFO    ][24202] Fetching file from saltenv 'base', ** done ** '_states/jenkins_credential.py'
2017-10-25 01:40:48,459 [salt.fileclient  ][INFO    ][24202] Fetching file from saltenv 'base', ** done ** '_states/jenkins_job.py'
2017-10-25 01:40:48,474 [salt.fileclient  ][INFO    ][24202] Fetching file from saltenv 'base', ** done ** '_states/jenkins_lib.py'
2017-10-25 01:40:48,527 [salt.fileclient  ][INFO    ][24202] Fetching file from saltenv 'base', ** done ** '_states/jenkins_node.py'
2017-10-25 01:40:48,535 [salt.fileclient  ][INFO    ][24202] Fetching file from saltenv 'base', ** done ** '_states/jenkins_plugin.py'
2017-10-25 01:40:48,566 [salt.fileclient  ][INFO    ][24202] Fetching file from saltenv 'base', ** done ** '_states/jenkins_security.py'
2017-10-25 01:40:48,576 [salt.fileclient  ][INFO    ][24202] Fetching file from saltenv 'base', ** done ** '_states/jenkins_slack.py'
2017-10-25 01:40:48,590 [salt.fileclient  ][INFO    ][24202] Fetching file from saltenv 'base', ** done ** '_states/jenkins_smtp.py'
2017-10-25 01:40:48,616 [salt.fileclient  ][INFO    ][24202] Fetching file from saltenv 'base', ** done ** '_states/jenkins_theme.py'
2017-10-25 01:40:48,633 [salt.fileclient  ][INFO    ][24202] Fetching file from saltenv 'base', ** done ** '_states/jenkins_user.py'
2017-10-25 01:40:48,659 [salt.fileclient  ][INFO    ][24202] Fetching file from saltenv 'base', ** done ** '_states/jenkins_view.py'
2017-10-25 01:40:48,674 [salt.fileclient  ][INFO    ][24202] Fetching file from saltenv 'base', ** done ** '_states/keystone_policy.py'
2017-10-25 01:40:48,683 [salt.fileclient  ][INFO    ][24202] Fetching file from saltenv 'base', ** done ** '_states/kibana_object.py'
2017-10-25 01:40:48,749 [salt.fileclient  ][INFO    ][24202] Fetching file from saltenv 'base', ** done ** '_states/neutronng.py'
2017-10-25 01:40:48,772 [salt.fileclient  ][INFO    ][24202] Fetching file from saltenv 'base', ** done ** '_states/novang.py'
2017-10-25 01:40:48,783 [salt.fileclient  ][INFO    ][24202] Fetching file from saltenv 'base', ** done ** '_states/reclass.py'
2017-10-25 01:40:48,797 [salt.fileclient  ][INFO    ][24202] Fetching file from saltenv 'base', ** done ** '_states/rundeck_project.py'
2017-10-25 01:40:48,806 [salt.fileclient  ][INFO    ][24202] Fetching file from saltenv 'base', ** done ** '_states/rundeck_scm.py'
2017-10-25 01:40:48,813 [salt.fileclient  ][INFO    ][24202] Fetching file from saltenv 'base', ** done ** '_states/rundeck_secret.py'
2017-10-25 01:40:48,816 [salt.utils.extmods][INFO    ][24202] Copying '/var/cache/salt/minion/files/base/_states/cinderng.py' to '/var/cache/salt/minion/extmods/states/cinderng.py'
2017-10-25 01:40:48,816 [salt.utils.extmods][INFO    ][24202] Copying '/var/cache/salt/minion/files/base/_states/contrail.py' to '/var/cache/salt/minion/extmods/states/contrail.py'
2017-10-25 01:40:48,816 [salt.utils.extmods][INFO    ][24202] Copying '/var/cache/salt/minion/files/base/_states/gerrit.py' to '/var/cache/salt/minion/extmods/states/gerrit.py'
2017-10-25 01:40:48,816 [salt.utils.extmods][INFO    ][24202] Copying '/var/cache/salt/minion/files/base/_states/glanceng.py' to '/var/cache/salt/minion/extmods/states/glanceng.py'
2017-10-25 01:40:48,816 [salt.utils.extmods][INFO    ][24202] Copying '/var/cache/salt/minion/files/base/_states/grafana3_dashboard.py' to '/var/cache/salt/minion/extmods/states/grafana3_dashboard.py'
2017-10-25 01:40:48,817 [salt.utils.extmods][INFO    ][24202] Copying '/var/cache/salt/minion/files/base/_states/grafana3_datasource.py' to '/var/cache/salt/minion/extmods/states/grafana3_datasource.py'
2017-10-25 01:40:48,817 [salt.utils.extmods][INFO    ][24202] Copying '/var/cache/salt/minion/files/base/_states/heat.py' to '/var/cache/salt/minion/extmods/states/heat.py'
2017-10-25 01:40:48,817 [salt.utils.extmods][INFO    ][24202] Copying '/var/cache/salt/minion/files/base/_states/helm_release.py' to '/var/cache/salt/minion/extmods/states/helm_release.py'
2017-10-25 01:40:48,817 [salt.utils.extmods][INFO    ][24202] Copying '/var/cache/salt/minion/files/base/_states/jenkins_approval.py' to '/var/cache/salt/minion/extmods/states/jenkins_approval.py'
2017-10-25 01:40:48,817 [salt.utils.extmods][INFO    ][24202] Copying '/var/cache/salt/minion/files/base/_states/jenkins_artifactory.py' to '/var/cache/salt/minion/extmods/states/jenkins_artifactory.py'
2017-10-25 01:40:48,818 [salt.utils.extmods][INFO    ][24202] Copying '/var/cache/salt/minion/files/base/_states/jenkins_credential.py' to '/var/cache/salt/minion/extmods/states/jenkins_credential.py'
2017-10-25 01:40:48,818 [salt.utils.extmods][INFO    ][24202] Copying '/var/cache/salt/minion/files/base/_states/jenkins_job.py' to '/var/cache/salt/minion/extmods/states/jenkins_job.py'
2017-10-25 01:40:48,818 [salt.utils.extmods][INFO    ][24202] Copying '/var/cache/salt/minion/files/base/_states/jenkins_lib.py' to '/var/cache/salt/minion/extmods/states/jenkins_lib.py'
2017-10-25 01:40:48,818 [salt.utils.extmods][INFO    ][24202] Copying '/var/cache/salt/minion/files/base/_states/jenkins_node.py' to '/var/cache/salt/minion/extmods/states/jenkins_node.py'
2017-10-25 01:40:48,818 [salt.utils.extmods][INFO    ][24202] Copying '/var/cache/salt/minion/files/base/_states/jenkins_plugin.py' to '/var/cache/salt/minion/extmods/states/jenkins_plugin.py'
2017-10-25 01:40:48,819 [salt.utils.extmods][INFO    ][24202] Copying '/var/cache/salt/minion/files/base/_states/jenkins_security.py' to '/var/cache/salt/minion/extmods/states/jenkins_security.py'
2017-10-25 01:40:48,819 [salt.utils.extmods][INFO    ][24202] Copying '/var/cache/salt/minion/files/base/_states/jenkins_slack.py' to '/var/cache/salt/minion/extmods/states/jenkins_slack.py'
2017-10-25 01:40:48,819 [salt.utils.extmods][INFO    ][24202] Copying '/var/cache/salt/minion/files/base/_states/jenkins_smtp.py' to '/var/cache/salt/minion/extmods/states/jenkins_smtp.py'
2017-10-25 01:40:48,819 [salt.utils.extmods][INFO    ][24202] Copying '/var/cache/salt/minion/files/base/_states/jenkins_theme.py' to '/var/cache/salt/minion/extmods/states/jenkins_theme.py'
2017-10-25 01:40:48,819 [salt.utils.extmods][INFO    ][24202] Copying '/var/cache/salt/minion/files/base/_states/jenkins_user.py' to '/var/cache/salt/minion/extmods/states/jenkins_user.py'
2017-10-25 01:40:48,819 [salt.utils.extmods][INFO    ][24202] Copying '/var/cache/salt/minion/files/base/_states/jenkins_view.py' to '/var/cache/salt/minion/extmods/states/jenkins_view.py'
2017-10-25 01:40:48,820 [salt.utils.extmods][INFO    ][24202] Copying '/var/cache/salt/minion/files/base/_states/keystone_policy.py' to '/var/cache/salt/minion/extmods/states/keystone_policy.py'
2017-10-25 01:40:48,820 [salt.utils.extmods][INFO    ][24202] Copying '/var/cache/salt/minion/files/base/_states/kibana_object.py' to '/var/cache/salt/minion/extmods/states/kibana_object.py'
2017-10-25 01:40:48,820 [salt.utils.extmods][INFO    ][24202] Copying '/var/cache/salt/minion/files/base/_states/maas_cluster.py' to '/var/cache/salt/minion/extmods/states/maas_cluster.py'
2017-10-25 01:40:48,820 [salt.utils.extmods][INFO    ][24202] Copying '/var/cache/salt/minion/files/base/_states/neutronng.py' to '/var/cache/salt/minion/extmods/states/neutronng.py'
2017-10-25 01:40:48,820 [salt.utils.extmods][INFO    ][24202] Copying '/var/cache/salt/minion/files/base/_states/novang.py' to '/var/cache/salt/minion/extmods/states/novang.py'
2017-10-25 01:40:48,821 [salt.utils.extmods][INFO    ][24202] Copying '/var/cache/salt/minion/files/base/_states/reclass.py' to '/var/cache/salt/minion/extmods/states/reclass.py'
2017-10-25 01:40:48,821 [salt.utils.extmods][INFO    ][24202] Copying '/var/cache/salt/minion/files/base/_states/rundeck_project.py' to '/var/cache/salt/minion/extmods/states/rundeck_project.py'
2017-10-25 01:40:48,821 [salt.utils.extmods][INFO    ][24202] Copying '/var/cache/salt/minion/files/base/_states/rundeck_scm.py' to '/var/cache/salt/minion/extmods/states/rundeck_scm.py'
2017-10-25 01:40:48,821 [salt.utils.extmods][INFO    ][24202] Copying '/var/cache/salt/minion/files/base/_states/rundeck_secret.py' to '/var/cache/salt/minion/extmods/states/rundeck_secret.py'
2017-10-25 01:40:48,823 [salt.utils.extmods][INFO    ][24202] Creating module dir '/var/cache/salt/minion/extmods/sdb'
2017-10-25 01:40:48,826 [salt.utils.extmods][INFO    ][24202] Syncing sdb for environment 'base'
2017-10-25 01:40:48,826 [salt.utils.extmods][INFO    ][24202] Loading cache from salt://_sdb, for base)
2017-10-25 01:40:48,826 [salt.fileclient  ][INFO    ][24202] Caching directory '_sdb/' for environment 'base'
2017-10-25 01:40:48,848 [salt.utils.extmods][INFO    ][24202] Syncing grains for environment 'base'
2017-10-25 01:40:48,849 [salt.utils.extmods][INFO    ][24202] Loading cache from salt://_grains, for base)
2017-10-25 01:40:48,849 [salt.fileclient  ][INFO    ][24202] Caching directory '_grains/' for environment 'base'
2017-10-25 01:40:48,902 [salt.fileclient  ][INFO    ][24202] Fetching file from saltenv 'base', ** done ** '_grains/ceilometer_policy.py'
2017-10-25 01:40:48,920 [salt.fileclient  ][INFO    ][24202] Fetching file from saltenv 'base', ** done ** '_grains/ceph.py'
2017-10-25 01:40:48,933 [salt.fileclient  ][INFO    ][24202] Fetching file from saltenv 'base', ** done ** '_grains/cinder_policy.py'
2017-10-25 01:40:48,954 [salt.fileclient  ][INFO    ][24202] Fetching file from saltenv 'base', ** done ** '_grains/docker_swarm.py'
2017-10-25 01:40:48,986 [salt.fileclient  ][INFO    ][24202] Fetching file from saltenv 'base', ** done ** '_grains/glance_policy.py'
2017-10-25 01:40:48,999 [salt.fileclient  ][INFO    ][24202] Fetching file from saltenv 'base', ** done ** '_grains/heat_policy.py'
2017-10-25 01:40:49,011 [salt.fileclient  ][INFO    ][24202] Fetching file from saltenv 'base', ** done ** '_grains/jenkins_plugins.py'
2017-10-25 01:40:49,021 [salt.fileclient  ][INFO    ][24202] Fetching file from saltenv 'base', ** done ** '_grains/keystone_policy.py'
2017-10-25 01:40:49,042 [salt.fileclient  ][INFO    ][24202] Fetching file from saltenv 'base', ** done ** '_grains/kubernetes.py'
2017-10-25 01:40:49,071 [salt.fileclient  ][INFO    ][24202] Fetching file from saltenv 'base', ** done ** '_grains/neutron_policy.py'
2017-10-25 01:40:49,098 [salt.fileclient  ][INFO    ][24202] Fetching file from saltenv 'base', ** done ** '_grains/nova_policy.py'
2017-10-25 01:40:49,109 [salt.fileclient  ][INFO    ][24202] Fetching file from saltenv 'base', ** done ** '_grains/ssh_fingerprints.py'
2017-10-25 01:40:49,112 [salt.utils.extmods][INFO    ][24202] Copying '/var/cache/salt/minion/files/base/_grains/ceilometer_policy.py' to '/var/cache/salt/minion/extmods/grains/ceilometer_policy.py'
2017-10-25 01:40:49,112 [salt.utils.extmods][INFO    ][24202] Copying '/var/cache/salt/minion/files/base/_grains/ceph.py' to '/var/cache/salt/minion/extmods/grains/ceph.py'
2017-10-25 01:40:49,112 [salt.utils.extmods][INFO    ][24202] Copying '/var/cache/salt/minion/files/base/_grains/cinder_policy.py' to '/var/cache/salt/minion/extmods/grains/cinder_policy.py'
2017-10-25 01:40:49,112 [salt.utils.extmods][INFO    ][24202] Copying '/var/cache/salt/minion/files/base/_grains/docker_swarm.py' to '/var/cache/salt/minion/extmods/grains/docker_swarm.py'
2017-10-25 01:40:49,113 [salt.utils.extmods][INFO    ][24202] Copying '/var/cache/salt/minion/files/base/_grains/glance_policy.py' to '/var/cache/salt/minion/extmods/grains/glance_policy.py'
2017-10-25 01:40:49,113 [salt.utils.extmods][INFO    ][24202] Copying '/var/cache/salt/minion/files/base/_grains/heat_policy.py' to '/var/cache/salt/minion/extmods/grains/heat_policy.py'
2017-10-25 01:40:49,113 [salt.utils.extmods][INFO    ][24202] Copying '/var/cache/salt/minion/files/base/_grains/jenkins_plugins.py' to '/var/cache/salt/minion/extmods/grains/jenkins_plugins.py'
2017-10-25 01:40:49,113 [salt.utils.extmods][INFO    ][24202] Copying '/var/cache/salt/minion/files/base/_grains/keystone_policy.py' to '/var/cache/salt/minion/extmods/grains/keystone_policy.py'
2017-10-25 01:40:49,113 [salt.utils.extmods][INFO    ][24202] Copying '/var/cache/salt/minion/files/base/_grains/kubernetes.py' to '/var/cache/salt/minion/extmods/grains/kubernetes.py'
2017-10-25 01:40:49,114 [salt.utils.extmods][INFO    ][24202] Copying '/var/cache/salt/minion/files/base/_grains/neutron_policy.py' to '/var/cache/salt/minion/extmods/grains/neutron_policy.py'
2017-10-25 01:40:49,114 [salt.utils.extmods][INFO    ][24202] Copying '/var/cache/salt/minion/files/base/_grains/nova_policy.py' to '/var/cache/salt/minion/extmods/grains/nova_policy.py'
2017-10-25 01:40:49,114 [salt.utils.extmods][INFO    ][24202] Copying '/var/cache/salt/minion/files/base/_grains/ssh_fingerprints.py' to '/var/cache/salt/minion/extmods/grains/ssh_fingerprints.py'
2017-10-25 01:40:49,115 [salt.utils.extmods][INFO    ][24202] Creating module dir '/var/cache/salt/minion/extmods/renderers'
2017-10-25 01:40:49,117 [salt.utils.extmods][INFO    ][24202] Syncing renderers for environment 'base'
2017-10-25 01:40:49,118 [salt.utils.extmods][INFO    ][24202] Loading cache from salt://_renderers, for base)
2017-10-25 01:40:49,118 [salt.fileclient  ][INFO    ][24202] Caching directory '_renderers/' for environment 'base'
2017-10-25 01:40:49,180 [salt.utils.extmods][INFO    ][24202] Creating module dir '/var/cache/salt/minion/extmods/returners'
2017-10-25 01:40:49,182 [salt.utils.extmods][INFO    ][24202] Syncing returners for environment 'base'
2017-10-25 01:40:49,183 [salt.utils.extmods][INFO    ][24202] Loading cache from salt://_returners, for base)
2017-10-25 01:40:49,183 [salt.fileclient  ][INFO    ][24202] Caching directory '_returners/' for environment 'base'
2017-10-25 01:40:49,234 [salt.utils.extmods][INFO    ][24202] Creating module dir '/var/cache/salt/minion/extmods/output'
2017-10-25 01:40:49,237 [salt.utils.extmods][INFO    ][24202] Syncing output for environment 'base'
2017-10-25 01:40:49,237 [salt.utils.extmods][INFO    ][24202] Loading cache from salt://_output, for base)
2017-10-25 01:40:49,237 [salt.fileclient  ][INFO    ][24202] Caching directory '_output/' for environment 'base'
2017-10-25 01:40:49,322 [salt.utils.extmods][INFO    ][24202] Creating module dir '/var/cache/salt/minion/extmods/utils'
2017-10-25 01:40:49,325 [salt.utils.extmods][INFO    ][24202] Syncing utils for environment 'base'
2017-10-25 01:40:49,325 [salt.utils.extmods][INFO    ][24202] Loading cache from salt://_utils, for base)
2017-10-25 01:40:49,325 [salt.fileclient  ][INFO    ][24202] Caching directory '_utils/' for environment 'base'
2017-10-25 01:40:49,349 [salt.utils.extmods][INFO    ][24202] Creating module dir '/var/cache/salt/minion/extmods/log_handlers'
2017-10-25 01:40:49,351 [salt.utils.extmods][INFO    ][24202] Syncing log_handlers for environment 'base'
2017-10-25 01:40:49,352 [salt.utils.extmods][INFO    ][24202] Loading cache from salt://_log_handlers, for base)
2017-10-25 01:40:49,352 [salt.fileclient  ][INFO    ][24202] Caching directory '_log_handlers/' for environment 'base'
2017-10-25 01:40:49,383 [salt.utils.extmods][INFO    ][24202] Creating module dir '/var/cache/salt/minion/extmods/proxy'
2017-10-25 01:40:49,385 [salt.utils.extmods][INFO    ][24202] Syncing proxy for environment 'base'
2017-10-25 01:40:49,385 [salt.utils.extmods][INFO    ][24202] Loading cache from salt://_proxy, for base)
2017-10-25 01:40:49,386 [salt.fileclient  ][INFO    ][24202] Caching directory '_proxy/' for environment 'base'
2017-10-25 01:40:49,430 [salt.utils.extmods][INFO    ][24202] Creating module dir '/var/cache/salt/minion/extmods/engines'
2017-10-25 01:40:49,432 [salt.utils.extmods][INFO    ][24202] Syncing engines for environment 'base'
2017-10-25 01:40:49,432 [salt.utils.extmods][INFO    ][24202] Loading cache from salt://_engines, for base)
2017-10-25 01:40:49,432 [salt.fileclient  ][INFO    ][24202] Caching directory '_engines/' for environment 'base'
2017-10-25 01:40:49,459 [salt.minion      ][INFO    ][24202] Returning information for job: 20171025014044076787
2017-10-25 02:09:58,477 [salt.minion      ][INFO    ][23807] User sudo_ubuntu Executing command test.ping with jid 20171025020958470940
2017-10-25 02:09:58,498 [salt.minion      ][INFO    ][24839] Starting a new job with PID 24839
2017-10-25 02:09:58,526 [salt.minion      ][INFO    ][24839] Returning information for job: 20171025020958470940
2017-10-25 02:10:52,535 [salt.minion      ][INFO    ][23807] User sudo_ubuntu Executing command state.sls with jid 20171025021052522594
2017-10-25 02:10:52,552 [salt.minion      ][INFO    ][24865] Starting a new job with PID 24865
2017-10-25 02:10:54,152 [salt.state       ][INFO    ][24865] Loading fresh modules for state activity
2017-10-25 02:10:54,177 [salt.fileclient  ][INFO    ][24865] Fetching file from saltenv 'base', ** done ** 'keepalived/init.sls'
2017-10-25 02:10:54,195 [salt.fileclient  ][INFO    ][24865] Fetching file from saltenv 'base', ** done ** 'keepalived/cluster.sls'
2017-10-25 02:10:54,219 [salt.fileclient  ][INFO    ][24865] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-10-25 02:10:54,520 [salt.state       ][INFO    ][24865] Running state [lsof] at time 02:10:54.519477
2017-10-25 02:10:54,520 [salt.state       ][INFO    ][24865] Executing state pkg.installed for lsof
2017-10-25 02:10:54,520 [salt.loaded.int.module.cmdmod][INFO    ][24865] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-10-25 02:10:54,781 [salt.state       ][INFO    ][24865] Package lsof is already installed
2017-10-25 02:10:54,781 [salt.state       ][INFO    ][24865] Completed state [lsof] at time 02:10:54.780816 duration_in_ms=261.34
2017-10-25 02:10:54,781 [salt.state       ][INFO    ][24865] Running state [keepalived] at time 02:10:54.781004
2017-10-25 02:10:54,781 [salt.state       ][INFO    ][24865] Executing state pkg.installed for keepalived
2017-10-25 02:10:54,797 [salt.loaded.int.module.cmdmod][INFO    ][24865] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-10-25 02:10:57,934 [salt.loaded.int.module.cmdmod][INFO    ][24865] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'keepalived'] in directory '/root'
2017-10-25 02:11:02,579 [salt.minion      ][INFO    ][23807] User sudo_ubuntu Executing command saltutil.find_job with jid 20171025021102568145
2017-10-25 02:11:02,596 [salt.minion      ][INFO    ][26161] Starting a new job with PID 26161
2017-10-25 02:11:02,606 [salt.minion      ][INFO    ][26161] Returning information for job: 20171025021102568145
2017-10-25 02:11:05,724 [salt.loaded.int.module.cmdmod][INFO    ][24865] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-10-25 02:11:05,749 [salt.state       ][INFO    ][24865] Made the following changes:
'libsnmp30' changed from 'absent' to '5.7.3+dfsg-1ubuntu4'
'libsnmp-base' changed from 'absent' to '5.7.3+dfsg-1ubuntu4'
'keepalived' changed from 'absent' to '1:1.2.19-1ubuntu0.2'
'ipvsadm' changed from 'absent' to '1:1.28-3'
'libsensors4' changed from 'absent' to '1:3.4.0-2'

2017-10-25 02:11:05,757 [salt.state       ][INFO    ][24865] Loading fresh modules for state activity
2017-10-25 02:11:05,769 [salt.state       ][INFO    ][24865] Completed state [keepalived] at time 02:11:05.768982 duration_in_ms=10987.978
2017-10-25 02:11:05,771 [salt.state       ][INFO    ][24865] Running state [/etc/keepalived/keepalived.conf] at time 02:11:05.770978
2017-10-25 02:11:05,771 [salt.state       ][INFO    ][24865] Executing state file.managed for /etc/keepalived/keepalived.conf
2017-10-25 02:11:05,796 [salt.fileclient  ][INFO    ][24865] Fetching file from saltenv 'base', ** done ** 'keepalived/files/keepalived.conf'
2017-10-25 02:11:05,826 [salt.fileclient  ][INFO    ][24865] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-10-25 02:11:05,833 [salt.state       ][INFO    ][24865] File changed:
New file
2017-10-25 02:11:05,833 [salt.state       ][INFO    ][24865] Completed state [/etc/keepalived/keepalived.conf] at time 02:11:05.833309 duration_in_ms=62.33
2017-10-25 02:11:05,890 [salt.state       ][INFO    ][24865] Running state [keepalived] at time 02:11:05.889921
2017-10-25 02:11:05,890 [salt.state       ][INFO    ][24865] Executing state service.running for keepalived
2017-10-25 02:11:05,892 [salt.loaded.int.module.cmdmod][INFO    ][24865] Executing command ['systemctl', 'status', 'keepalived.service', '-n', '0'] in directory '/root'
2017-10-25 02:11:05,901 [salt.loaded.int.module.cmdmod][INFO    ][24865] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2017-10-25 02:11:05,909 [salt.loaded.int.module.cmdmod][INFO    ][24865] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-10-25 02:11:05,917 [salt.loaded.int.module.cmdmod][INFO    ][24865] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-10-25 02:11:05,927 [salt.loaded.int.module.cmdmod][INFO    ][24865] Executing command ['systemd-run', '--scope', 'systemctl', 'start', 'keepalived.service'] in directory '/root'
2017-10-25 02:11:05,998 [salt.loaded.int.module.cmdmod][INFO    ][24865] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2017-10-25 02:11:06,006 [salt.loaded.int.module.cmdmod][INFO    ][24865] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-10-25 02:11:06,014 [salt.loaded.int.module.cmdmod][INFO    ][24865] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-10-25 02:11:06,021 [salt.state       ][INFO    ][24865] {'keepalived': True}
2017-10-25 02:11:06,022 [salt.state       ][INFO    ][24865] Completed state [keepalived] at time 02:11:06.021575 duration_in_ms=131.654
2017-10-25 02:11:06,022 [salt.minion      ][INFO    ][24865] Returning information for job: 20171025021052522594
2017-10-25 02:13:52,328 [salt.minion      ][INFO    ][23807] User sudo_ubuntu Executing command pillar.get with jid 20171025021352322077
2017-10-25 02:13:52,349 [salt.minion      ][INFO    ][26531] Starting a new job with PID 26531
2017-10-25 02:13:52,352 [salt.minion      ][INFO    ][26531] Returning information for job: 20171025021352322077
2017-10-25 02:19:29,968 [salt.minion      ][INFO    ][23807] User sudo_ubuntu Executing command state.sls with jid 20171025021929957407
2017-10-25 02:19:29,985 [salt.minion      ][INFO    ][26650] Starting a new job with PID 26650
2017-10-25 02:19:32,463 [salt.state       ][INFO    ][26650] Loading fresh modules for state activity
2017-10-25 02:19:32,488 [salt.fileclient  ][INFO    ][26650] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-10-25 02:19:32,510 [salt.fileclient  ][INFO    ][26650] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-10-25 02:19:32,790 [salt.state       ][INFO    ][26650] Running state [attr] at time 02:19:32.789931
2017-10-25 02:19:32,790 [salt.state       ][INFO    ][26650] Executing state pkg.installed for attr
2017-10-25 02:19:32,791 [salt.loaded.int.module.cmdmod][INFO    ][26650] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-10-25 02:19:33,062 [salt.loaded.int.module.cmdmod][INFO    ][26650] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-10-25 02:19:34,374 [salt.loaded.int.module.cmdmod][INFO    ][26650] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'attr'] in directory '/root'
2017-10-25 02:19:36,814 [salt.loaded.int.module.cmdmod][INFO    ][26650] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-10-25 02:19:36,838 [salt.state       ][INFO    ][26650] Made the following changes:
'attr' changed from 'absent' to '1:2.4.47-2'

2017-10-25 02:19:36,847 [salt.state       ][INFO    ][26650] Loading fresh modules for state activity
2017-10-25 02:19:36,859 [salt.state       ][INFO    ][26650] Completed state [attr] at time 02:19:36.858663 duration_in_ms=4068.733
2017-10-25 02:19:36,864 [salt.state       ][INFO    ][26650] Running state [glusterfs-server] at time 02:19:36.864240
2017-10-25 02:19:36,864 [salt.state       ][INFO    ][26650] Executing state pkg.installed for glusterfs-server
2017-10-25 02:19:37,055 [salt.loaded.int.module.cmdmod][INFO    ][26650] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'glusterfs-server'] in directory '/root'
2017-10-25 02:19:40,061 [salt.minion      ][INFO    ][23807] User sudo_ubuntu Executing command saltutil.find_job with jid 20171025021940048295
2017-10-25 02:19:40,077 [salt.minion      ][INFO    ][27702] Starting a new job with PID 27702
2017-10-25 02:19:40,088 [salt.minion      ][INFO    ][27702] Returning information for job: 20171025021940048295
2017-10-25 02:19:50,271 [salt.minion      ][INFO    ][23807] User sudo_ubuntu Executing command saltutil.find_job with jid 20171025021950259301
2017-10-25 02:19:50,287 [salt.minion      ][INFO    ][30528] Starting a new job with PID 30528
2017-10-25 02:19:50,298 [salt.minion      ][INFO    ][30528] Returning information for job: 20171025021950259301
2017-10-25 02:19:54,496 [salt.loaded.int.module.cmdmod][INFO    ][26650] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-10-25 02:19:54,520 [salt.state       ][INFO    ][26650] Made the following changes:
'keyutils' changed from 'absent' to '1.5.9-8ubuntu1'
'nfs-common' changed from 'absent' to '1:1.2.8-9ubuntu12.1'
'rpcbind' changed from 'absent' to '0.2.3-0.2'
'glusterfs-common' changed from 'absent' to '3.7.6-1ubuntu1'
'librdmacm1' changed from 'absent' to '1.0.21-1'
'libnfsidmap2' changed from 'absent' to '0.25-5'
'portmap' changed from 'absent' to '1'
'libattr1-dev' changed from 'absent' to '1:2.4.47-2'
'attr-dev' changed from 'absent' to '1'
'acl-dev' changed from 'absent' to '1'
'glusterfs-server' changed from 'absent' to '3.7.6-1ubuntu1'
'glusterfs-client' changed from 'absent' to '3.7.6-1ubuntu1'
'libpython2.7' changed from 'absent' to '2.7.12-1ubuntu0~16.04.1'
'nfs-client' changed from 'absent' to '1'
'liburcu4' changed from 'absent' to '0.9.1-3'
'libacl1-dev' changed from 'absent' to '2.2.52-3'
'libibverbs1' changed from 'absent' to '1.1.8-1.1ubuntu2'
'libtirpc1' changed from 'absent' to '0.2.5-1'

2017-10-25 02:19:54,527 [salt.state       ][INFO    ][26650] Loading fresh modules for state activity
2017-10-25 02:19:54,538 [salt.state       ][INFO    ][26650] Completed state [glusterfs-server] at time 02:19:54.538303 duration_in_ms=17674.061
2017-10-25 02:19:54,543 [salt.state       ][INFO    ][26650] Running state [bc] at time 02:19:54.542858
2017-10-25 02:19:54,543 [salt.state       ][INFO    ][26650] Executing state pkg.installed for bc
2017-10-25 02:19:54,806 [salt.loaded.int.module.cmdmod][INFO    ][26650] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'bc'] in directory '/root'
2017-10-25 02:19:57,614 [salt.loaded.int.module.cmdmod][INFO    ][26650] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-10-25 02:19:57,638 [salt.state       ][INFO    ][26650] Made the following changes:
'bc' changed from 'absent' to '1.06.95-9build1'

2017-10-25 02:19:57,647 [salt.state       ][INFO    ][26650] Loading fresh modules for state activity
2017-10-25 02:19:57,660 [salt.state       ][INFO    ][26650] Completed state [bc] at time 02:19:57.660303 duration_in_ms=3117.444
2017-10-25 02:19:57,721 [salt.state       ][INFO    ][26650] Running state [glusterfs-server] at time 02:19:57.720725
2017-10-25 02:19:57,721 [salt.state       ][INFO    ][26650] Executing state service.running for glusterfs-server
2017-10-25 02:19:57,723 [salt.loaded.int.module.cmdmod][INFO    ][26650] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-10-25 02:19:57,733 [salt.loaded.int.module.cmdmod][INFO    ][26650] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-10-25 02:19:57,741 [salt.loaded.int.module.cmdmod][INFO    ][26650] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-10-25 02:19:57,750 [salt.state       ][INFO    ][26650] The service glusterfs-server is already running
2017-10-25 02:19:57,751 [salt.state       ][INFO    ][26650] Completed state [glusterfs-server] at time 02:19:57.750563 duration_in_ms=29.837
2017-10-25 02:19:57,752 [salt.state       ][INFO    ][26650] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 02:19:57.751996
2017-10-25 02:19:57,752 [salt.state       ][INFO    ][26650] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-10-25 02:19:57,768 [salt.state       ][INFO    ][26650] File changed:
New file
2017-10-25 02:19:57,769 [salt.state       ][INFO    ][26650] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 02:19:57.768528 duration_in_ms=16.532
2017-10-25 02:19:57,769 [salt.state       ][INFO    ][26650] Running state [/srv/glusterfs/glance] at time 02:19:57.768686
2017-10-25 02:19:57,769 [salt.state       ][INFO    ][26650] Executing state file.directory for /srv/glusterfs/glance
2017-10-25 02:19:57,769 [salt.state       ][INFO    ][26650] {'/srv/glusterfs/glance': 'New Dir'}
2017-10-25 02:19:57,770 [salt.state       ][INFO    ][26650] Completed state [/srv/glusterfs/glance] at time 02:19:57.769510 duration_in_ms=0.824
2017-10-25 02:19:57,770 [salt.state       ][INFO    ][26650] Running state [/srv/glusterfs/keystone-keys] at time 02:19:57.769652
2017-10-25 02:19:57,770 [salt.state       ][INFO    ][26650] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-10-25 02:19:57,770 [salt.state       ][INFO    ][26650] {'/srv/glusterfs/keystone-keys': 'New Dir'}
2017-10-25 02:19:57,770 [salt.state       ][INFO    ][26650] Completed state [/srv/glusterfs/keystone-keys] at time 02:19:57.770268 duration_in_ms=0.616
2017-10-25 02:19:57,770 [salt.state       ][INFO    ][26650] Running state [/srv/glusterfs/nova_instances] at time 02:19:57.770411
2017-10-25 02:19:57,771 [salt.state       ][INFO    ][26650] Executing state file.directory for /srv/glusterfs/nova_instances
2017-10-25 02:19:57,771 [salt.state       ][INFO    ][26650] {'/srv/glusterfs/nova_instances': 'New Dir'}
2017-10-25 02:19:57,771 [salt.state       ][INFO    ][26650] Completed state [/srv/glusterfs/nova_instances] at time 02:19:57.771021 duration_in_ms=0.61
2017-10-25 02:19:57,771 [salt.state       ][INFO    ][26650] Running state [/srv/glusterfs/keystone-credential-keys] at time 02:19:57.771182
2017-10-25 02:19:57,771 [salt.state       ][INFO    ][26650] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-10-25 02:19:57,772 [salt.state       ][INFO    ][26650] {'/srv/glusterfs/keystone-credential-keys': 'New Dir'}
2017-10-25 02:19:57,772 [salt.state       ][INFO    ][26650] Completed state [/srv/glusterfs/keystone-credential-keys] at time 02:19:57.771806 duration_in_ms=0.624
2017-10-25 02:19:57,773 [salt.minion      ][INFO    ][26650] Returning information for job: 20171025021929957407
2017-10-25 02:19:59,940 [salt.minion      ][INFO    ][23807] User sudo_ubuntu Executing command test.ping with jid 20171025021959932650
2017-10-25 02:19:59,955 [salt.minion      ][INFO    ][31440] Starting a new job with PID 31440
2017-10-25 02:19:59,981 [salt.minion      ][INFO    ][31440] Returning information for job: 20171025021959932650
2017-10-25 02:20:46,360 [salt.minion      ][INFO    ][23807] User sudo_ubuntu Executing command state.sls with jid 20171025022046353100
2017-10-25 02:20:46,377 [salt.minion      ][INFO    ][31657] Starting a new job with PID 31657
2017-10-25 02:20:46,765 [salt.state       ][INFO    ][31657] Loading fresh modules for state activity
2017-10-25 02:20:46,788 [salt.fileclient  ][INFO    ][31657] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/setup.sls'
2017-10-25 02:20:46,820 [salt.fileclient  ][INFO    ][31657] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-10-25 02:20:46,883 [salt.fileclient  ][INFO    ][31657] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-10-25 02:20:46,901 [salt.fileclient  ][INFO    ][31657] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-10-25 02:20:47,154 [salt.state       ][INFO    ][31657] Running state [attr] at time 02:20:47.153623
2017-10-25 02:20:47,154 [salt.state       ][INFO    ][31657] Executing state pkg.installed for attr
2017-10-25 02:20:47,154 [salt.loaded.int.module.cmdmod][INFO    ][31657] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-10-25 02:20:47,425 [salt.state       ][INFO    ][31657] Package attr is already installed
2017-10-25 02:20:47,425 [salt.state       ][INFO    ][31657] Completed state [attr] at time 02:20:47.425367 duration_in_ms=271.745
2017-10-25 02:20:47,426 [salt.state       ][INFO    ][31657] Running state [glusterfs-server] at time 02:20:47.425551
2017-10-25 02:20:47,426 [salt.state       ][INFO    ][31657] Executing state pkg.installed for glusterfs-server
2017-10-25 02:20:47,428 [salt.state       ][INFO    ][31657] Package glusterfs-server is already installed
2017-10-25 02:20:47,428 [salt.state       ][INFO    ][31657] Completed state [glusterfs-server] at time 02:20:47.428437 duration_in_ms=2.886
2017-10-25 02:20:47,429 [salt.state       ][INFO    ][31657] Running state [bc] at time 02:20:47.428574
2017-10-25 02:20:47,429 [salt.state       ][INFO    ][31657] Executing state pkg.installed for bc
2017-10-25 02:20:47,431 [salt.state       ][INFO    ][31657] Package bc is already installed
2017-10-25 02:20:47,431 [salt.state       ][INFO    ][31657] Completed state [bc] at time 02:20:47.431321 duration_in_ms=2.747
2017-10-25 02:20:47,432 [salt.state       ][INFO    ][31657] Running state [glusterfs-server] at time 02:20:47.432085
2017-10-25 02:20:47,432 [salt.state       ][INFO    ][31657] Executing state service.running for glusterfs-server
2017-10-25 02:20:47,433 [salt.loaded.int.module.cmdmod][INFO    ][31657] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-10-25 02:20:47,442 [salt.loaded.int.module.cmdmod][INFO    ][31657] Executing command ['systemctl', '--system', 'daemon-reload'] in directory '/root'
2017-10-25 02:20:47,485 [salt.loaded.int.module.cmdmod][INFO    ][31657] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-10-25 02:20:47,500 [salt.loaded.int.module.cmdmod][INFO    ][31657] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-10-25 02:20:47,506 [salt.loaded.int.module.cmdmod][INFO    ][31657] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-10-25 02:20:47,515 [salt.state       ][INFO    ][31657] The service glusterfs-server is already running
2017-10-25 02:20:47,515 [salt.state       ][INFO    ][31657] Completed state [glusterfs-server] at time 02:20:47.515047 duration_in_ms=82.961
2017-10-25 02:20:47,516 [salt.state       ][INFO    ][31657] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 02:20:47.516368
2017-10-25 02:20:47,517 [salt.state       ][INFO    ][31657] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-10-25 02:20:47,525 [salt.state       ][INFO    ][31657] File /etc/systemd/system/glusterfs-server.service.d/override.conf is in the correct state
2017-10-25 02:20:47,525 [salt.state       ][INFO    ][31657] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 02:20:47.525449 duration_in_ms=9.081
2017-10-25 02:20:47,526 [salt.state       ][INFO    ][31657] Running state [/srv/glusterfs/glance] at time 02:20:47.525598
2017-10-25 02:20:47,526 [salt.state       ][INFO    ][31657] Executing state file.directory for /srv/glusterfs/glance
2017-10-25 02:20:47,526 [salt.state       ][INFO    ][31657] Directory /srv/glusterfs/glance is in the correct state
2017-10-25 02:20:47,526 [salt.state       ][INFO    ][31657] Completed state [/srv/glusterfs/glance] at time 02:20:47.526175 duration_in_ms=0.577
2017-10-25 02:20:47,526 [salt.state       ][INFO    ][31657] Running state [/srv/glusterfs/keystone-keys] at time 02:20:47.526312
2017-10-25 02:20:47,526 [salt.state       ][INFO    ][31657] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-10-25 02:20:47,527 [salt.state       ][INFO    ][31657] Directory /srv/glusterfs/keystone-keys is in the correct state
2017-10-25 02:20:47,527 [salt.state       ][INFO    ][31657] Completed state [/srv/glusterfs/keystone-keys] at time 02:20:47.526853 duration_in_ms=0.54
2017-10-25 02:20:47,527 [salt.state       ][INFO    ][31657] Running state [/srv/glusterfs/nova_instances] at time 02:20:47.526990
2017-10-25 02:20:47,527 [salt.state       ][INFO    ][31657] Executing state file.directory for /srv/glusterfs/nova_instances
2017-10-25 02:20:47,527 [salt.state       ][INFO    ][31657] Directory /srv/glusterfs/nova_instances is in the correct state
2017-10-25 02:20:47,528 [salt.state       ][INFO    ][31657] Completed state [/srv/glusterfs/nova_instances] at time 02:20:47.527589 duration_in_ms=0.598
2017-10-25 02:20:47,528 [salt.state       ][INFO    ][31657] Running state [/srv/glusterfs/keystone-credential-keys] at time 02:20:47.527729
2017-10-25 02:20:47,528 [salt.state       ][INFO    ][31657] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-10-25 02:20:47,528 [salt.state       ][INFO    ][31657] Directory /srv/glusterfs/keystone-credential-keys is in the correct state
2017-10-25 02:20:47,528 [salt.state       ][INFO    ][31657] Completed state [/srv/glusterfs/keystone-credential-keys] at time 02:20:47.528266 duration_in_ms=0.538
2017-10-25 02:20:47,576 [salt.loaded.int.module.cmdmod][INFO    ][31657] Executing command ['git', '--version'] in directory '/root'
2017-10-25 02:20:47,655 [salt.state       ][INFO    ][31657] Running state [sleep 5] at time 02:20:47.654472
2017-10-25 02:20:47,655 [salt.state       ][INFO    ][31657] Executing state cmd.wait for sleep 5
2017-10-25 02:20:47,655 [salt.state       ][INFO    ][31657] No changes made for sleep 5
2017-10-25 02:20:47,655 [salt.state       ][INFO    ][31657] Completed state [sleep 5] at time 02:20:47.655021 duration_in_ms=0.55
2017-10-25 02:20:47,655 [salt.state       ][INFO    ][31657] Running state [10.167.4.141] at time 02:20:47.655392
2017-10-25 02:20:47,656 [salt.state       ][INFO    ][31657] Executing state glusterfs.peered for 10.167.4.141
2017-10-25 02:20:47,656 [salt.loaded.int.module.cmdmod][INFO    ][31657] Executing command 'gluster --version' in directory '/root'
2017-10-25 02:20:47,666 [salt.loaded.int.module.cmdmod][INFO    ][31657] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-25 02:20:47,715 [salt.loaded.int.module.cmdmod][INFO    ][31657] Executing command 'gluster --version' in directory '/root'
2017-10-25 02:20:47,724 [salt.loaded.int.module.cmdmod][INFO    ][31657] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-25 02:20:47,774 [salt.loaded.int.module.cmdmod][INFO    ][31657] Executing command 'gluster --version' in directory '/root'
2017-10-25 02:20:47,783 [salt.loaded.int.module.cmdmod][INFO    ][31657] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-25 02:20:47,834 [salt.loaded.int.module.cmdmod][INFO    ][31657] Executing command 'gluster --version' in directory '/root'
2017-10-25 02:20:47,842 [salt.loaded.int.module.cmdmod][INFO    ][31657] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-25 02:20:47,891 [salt.state       ][INFO    ][31657] Peering with localhost is not needed
2017-10-25 02:20:47,891 [salt.state       ][INFO    ][31657] Completed state [10.167.4.141] at time 02:20:47.891366 duration_in_ms=235.974
2017-10-25 02:20:47,894 [salt.state       ][INFO    ][31657] Running state [10.167.4.142] at time 02:20:47.893478
2017-10-25 02:20:47,894 [salt.state       ][INFO    ][31657] Executing state glusterfs.peered for 10.167.4.142
2017-10-25 02:20:47,894 [salt.loaded.int.module.cmdmod][INFO    ][31657] Executing command 'gluster --version' in directory '/root'
2017-10-25 02:20:47,902 [salt.loaded.int.module.cmdmod][INFO    ][31657] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-25 02:20:47,951 [salt.state       ][INFO    ][31657] Host 10.167.4.142 already peered
2017-10-25 02:20:47,951 [salt.state       ][INFO    ][31657] Completed state [10.167.4.142] at time 02:20:47.950959 duration_in_ms=57.481
2017-10-25 02:20:47,953 [salt.state       ][INFO    ][31657] Running state [10.167.4.143] at time 02:20:47.953100
2017-10-25 02:20:47,953 [salt.state       ][INFO    ][31657] Executing state glusterfs.peered for 10.167.4.143
2017-10-25 02:20:47,954 [salt.loaded.int.module.cmdmod][INFO    ][31657] Executing command 'gluster --version' in directory '/root'
2017-10-25 02:20:47,961 [salt.loaded.int.module.cmdmod][INFO    ][31657] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-25 02:20:48,009 [salt.state       ][INFO    ][31657] Host 10.167.4.143 already peered
2017-10-25 02:20:48,009 [salt.state       ][INFO    ][31657] Completed state [10.167.4.143] at time 02:20:48.009049 duration_in_ms=55.949
2017-10-25 02:20:48,010 [salt.state       ][INFO    ][31657] Running state [glance] at time 02:20:48.009779
2017-10-25 02:20:48,010 [salt.state       ][INFO    ][31657] Executing state glusterfs.created for glance
2017-10-25 02:20:48,010 [salt.loaded.int.module.cmdmod][INFO    ][31657] Executing command 'gluster --version' in directory '/root'
2017-10-25 02:20:48,018 [salt.loaded.int.module.cmdmod][INFO    ][31657] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-25 02:20:48,065 [salt.loaded.int.module.cmdmod][INFO    ][31657] Executing command 'gluster --version' in directory '/root'
2017-10-25 02:20:48,073 [salt.loaded.int.module.cmdmod][INFO    ][31657] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-25 02:20:48,124 [salt.state       ][INFO    ][31657] Volume glance already exists and is started.
2017-10-25 02:20:48,124 [salt.state       ][INFO    ][31657] Completed state [glance] at time 02:20:48.124136 duration_in_ms=114.357
2017-10-25 02:20:48,127 [salt.state       ][INFO    ][31657] Running state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 02:20:48.126754
2017-10-25 02:20:48,127 [salt.state       ][INFO    ][31657] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'
2017-10-25 02:20:48,127 [salt.loaded.int.module.cmdmod][INFO    ][31657] Executing command 'gluster volume info 'glance' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-10-25 02:20:48,175 [salt.state       ][INFO    ][31657] unless execution succeeded
2017-10-25 02:20:48,176 [salt.state       ][INFO    ][31657] Completed state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 02:20:48.175660 duration_in_ms=48.906
2017-10-25 02:20:48,176 [salt.state       ][INFO    ][31657] Running state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 02:20:48.176148
2017-10-25 02:20:48,176 [salt.state       ][INFO    ][31657] Executing state cmd.run for gluster volume set 'glance' 'network.remote-dio' 'True'
2017-10-25 02:20:48,177 [salt.loaded.int.module.cmdmod][INFO    ][31657] Executing command 'gluster volume info 'glance' | grep 'network.remote-dio: True'' in directory '/root'
2017-10-25 02:20:48,228 [salt.state       ][INFO    ][31657] unless execution succeeded
2017-10-25 02:20:48,230 [salt.state       ][INFO    ][31657] Completed state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 02:20:48.229988 duration_in_ms=53.838
2017-10-25 02:20:48,230 [salt.state       ][INFO    ][31657] Running state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 02:20:48.230452
2017-10-25 02:20:48,231 [salt.state       ][INFO    ][31657] Executing state cmd.run for gluster volume set 'glance' 'nfs.disable' 'True'
2017-10-25 02:20:48,231 [salt.loaded.int.module.cmdmod][INFO    ][31657] Executing command 'gluster volume info 'glance' | grep 'nfs.disable: True'' in directory '/root'
2017-10-25 02:20:48,279 [salt.state       ][INFO    ][31657] unless execution succeeded
2017-10-25 02:20:48,279 [salt.state       ][INFO    ][31657] Completed state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 02:20:48.279234 duration_in_ms=48.782
2017-10-25 02:20:48,280 [salt.state       ][INFO    ][31657] Running state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 02:20:48.279699
2017-10-25 02:20:48,280 [salt.state       ][INFO    ][31657] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'
2017-10-25 02:20:48,280 [salt.loaded.int.module.cmdmod][INFO    ][31657] Executing command 'gluster volume info 'glance' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-10-25 02:20:48,330 [salt.state       ][INFO    ][31657] unless execution succeeded
2017-10-25 02:20:48,331 [salt.state       ][INFO    ][31657] Completed state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 02:20:48.330619 duration_in_ms=50.92
2017-10-25 02:20:48,331 [salt.state       ][INFO    ][31657] Running state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 02:20:48.331042
2017-10-25 02:20:48,331 [salt.state       ][INFO    ][31657] Executing state cmd.run for gluster volume set 'glance' 'cluster.readdir-optimize' 'True'
2017-10-25 02:20:48,332 [salt.loaded.int.module.cmdmod][INFO    ][31657] Executing command 'gluster volume info 'glance' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-10-25 02:20:48,378 [salt.state       ][INFO    ][31657] unless execution succeeded
2017-10-25 02:20:48,379 [salt.state       ][INFO    ][31657] Completed state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 02:20:48.378695 duration_in_ms=47.653
2017-10-25 02:20:48,380 [salt.state       ][INFO    ][31657] Running state [glance] at time 02:20:48.379649
2017-10-25 02:20:48,380 [salt.state       ][INFO    ][31657] Executing state glusterfs.started for glance
2017-10-25 02:20:48,380 [salt.loaded.int.module.cmdmod][INFO    ][31657] Executing command 'gluster --version' in directory '/root'
2017-10-25 02:20:48,388 [salt.loaded.int.module.cmdmod][INFO    ][31657] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-25 02:20:48,436 [salt.loaded.int.module.cmdmod][INFO    ][31657] Executing command 'gluster --version' in directory '/root'
2017-10-25 02:20:48,445 [salt.loaded.int.module.cmdmod][INFO    ][31657] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-25 02:20:48,496 [salt.state       ][INFO    ][31657] Volume glance is already started
2017-10-25 02:20:48,496 [salt.state       ][INFO    ][31657] Completed state [glance] at time 02:20:48.496384 duration_in_ms=116.734
2017-10-25 02:20:48,497 [salt.state       ][INFO    ][31657] Running state [keystone-keys] at time 02:20:48.497168
2017-10-25 02:20:48,497 [salt.state       ][INFO    ][31657] Executing state glusterfs.created for keystone-keys
2017-10-25 02:20:48,498 [salt.loaded.int.module.cmdmod][INFO    ][31657] Executing command 'gluster --version' in directory '/root'
2017-10-25 02:20:48,505 [salt.loaded.int.module.cmdmod][INFO    ][31657] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-25 02:20:48,551 [salt.loaded.int.module.cmdmod][INFO    ][31657] Executing command 'gluster --version' in directory '/root'
2017-10-25 02:20:48,560 [salt.loaded.int.module.cmdmod][INFO    ][31657] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-25 02:20:48,611 [salt.state       ][INFO    ][31657] Volume keystone-keys already exists and is started.
2017-10-25 02:20:48,611 [salt.state       ][INFO    ][31657] Completed state [keystone-keys] at time 02:20:48.611353 duration_in_ms=114.185
2017-10-25 02:20:48,614 [salt.state       ][INFO    ][31657] Running state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 02:20:48.614085
2017-10-25 02:20:48,614 [salt.state       ][INFO    ][31657] Executing state cmd.run for gluster volume set 'keystone-keys' 'network.remote-dio' 'True'
2017-10-25 02:20:48,615 [salt.loaded.int.module.cmdmod][INFO    ][31657] Executing command 'gluster volume info 'keystone-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-10-25 02:20:48,663 [salt.state       ][INFO    ][31657] unless execution succeeded
2017-10-25 02:20:48,663 [salt.state       ][INFO    ][31657] Completed state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 02:20:48.663200 duration_in_ms=49.115
2017-10-25 02:20:48,664 [salt.state       ][INFO    ][31657] Running state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 02:20:48.663638
2017-10-25 02:20:48,664 [salt.state       ][INFO    ][31657] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-10-25 02:20:48,664 [salt.loaded.int.module.cmdmod][INFO    ][31657] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-10-25 02:20:48,711 [salt.state       ][INFO    ][31657] unless execution succeeded
2017-10-25 02:20:48,711 [salt.state       ][INFO    ][31657] Completed state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 02:20:48.710966 duration_in_ms=47.327
2017-10-25 02:20:48,711 [salt.state       ][INFO    ][31657] Running state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 02:20:48.711462
2017-10-25 02:20:48,712 [salt.state       ][INFO    ][31657] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'
2017-10-25 02:20:48,712 [salt.loaded.int.module.cmdmod][INFO    ][31657] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-10-25 02:20:48,761 [salt.state       ][INFO    ][31657] unless execution succeeded
2017-10-25 02:20:48,761 [salt.state       ][INFO    ][31657] Completed state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 02:20:48.761144 duration_in_ms=49.682
2017-10-25 02:20:48,762 [salt.state       ][INFO    ][31657] Running state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 02:20:48.761601
2017-10-25 02:20:48,762 [salt.state       ][INFO    ][31657] Executing state cmd.run for gluster volume set 'keystone-keys' 'nfs.disable' 'True'
2017-10-25 02:20:48,762 [salt.loaded.int.module.cmdmod][INFO    ][31657] Executing command 'gluster volume info 'keystone-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-10-25 02:20:48,809 [salt.state       ][INFO    ][31657] unless execution succeeded
2017-10-25 02:20:48,809 [salt.state       ][INFO    ][31657] Completed state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 02:20:48.809224 duration_in_ms=47.623
2017-10-25 02:20:48,810 [salt.state       ][INFO    ][31657] Running state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 02:20:48.809680
2017-10-25 02:20:48,810 [salt.state       ][INFO    ][31657] Executing state cmd.run for gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'
2017-10-25 02:20:48,810 [salt.loaded.int.module.cmdmod][INFO    ][31657] Executing command 'gluster volume info 'keystone-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-10-25 02:20:48,856 [salt.state       ][INFO    ][31657] unless execution succeeded
2017-10-25 02:20:48,856 [salt.state       ][INFO    ][31657] Completed state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 02:20:48.856291 duration_in_ms=46.611
2017-10-25 02:20:48,857 [salt.state       ][INFO    ][31657] Running state [keystone-keys] at time 02:20:48.857188
2017-10-25 02:20:48,857 [salt.state       ][INFO    ][31657] Executing state glusterfs.started for keystone-keys
2017-10-25 02:20:48,858 [salt.loaded.int.module.cmdmod][INFO    ][31657] Executing command 'gluster --version' in directory '/root'
2017-10-25 02:20:48,866 [salt.loaded.int.module.cmdmod][INFO    ][31657] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-25 02:20:48,914 [salt.loaded.int.module.cmdmod][INFO    ][31657] Executing command 'gluster --version' in directory '/root'
2017-10-25 02:20:48,922 [salt.loaded.int.module.cmdmod][INFO    ][31657] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-25 02:20:48,987 [salt.state       ][INFO    ][31657] Volume keystone-keys is already started
2017-10-25 02:20:48,987 [salt.state       ][INFO    ][31657] Completed state [keystone-keys] at time 02:20:48.987145 duration_in_ms=129.955
2017-10-25 02:20:48,988 [salt.state       ][INFO    ][31657] Running state [nova_instances] at time 02:20:48.988237
2017-10-25 02:20:48,989 [salt.state       ][INFO    ][31657] Executing state glusterfs.created for nova_instances
2017-10-25 02:20:48,989 [salt.loaded.int.module.cmdmod][INFO    ][31657] Executing command 'gluster --version' in directory '/root'
2017-10-25 02:20:48,998 [salt.loaded.int.module.cmdmod][INFO    ][31657] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-25 02:20:49,045 [salt.loaded.int.module.cmdmod][INFO    ][31657] Executing command 'gluster --version' in directory '/root'
2017-10-25 02:20:49,054 [salt.loaded.int.module.cmdmod][INFO    ][31657] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-25 02:20:49,107 [salt.state       ][INFO    ][31657] Volume nova_instances already exists and is started.
2017-10-25 02:20:49,107 [salt.state       ][INFO    ][31657] Completed state [nova_instances] at time 02:20:49.107089 duration_in_ms=118.851
2017-10-25 02:20:49,110 [salt.state       ][INFO    ][31657] Running state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 02:20:49.109975
2017-10-25 02:20:49,110 [salt.state       ][INFO    ][31657] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'
2017-10-25 02:20:49,111 [salt.loaded.int.module.cmdmod][INFO    ][31657] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-10-25 02:20:49,163 [salt.state       ][INFO    ][31657] unless execution succeeded
2017-10-25 02:20:49,164 [salt.state       ][INFO    ][31657] Completed state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 02:20:49.163487 duration_in_ms=53.512
2017-10-25 02:20:49,164 [salt.state       ][INFO    ][31657] Running state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'On'] at time 02:20:49.163932
2017-10-25 02:20:49,164 [salt.state       ][INFO    ][31657] Executing state cmd.run for gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'On'
2017-10-25 02:20:49,165 [salt.loaded.int.module.cmdmod][INFO    ][31657] Executing command 'gluster volume info 'nova_instances' | grep 'cluster.readdir-optimize: On'' in directory '/root'
2017-10-25 02:20:49,212 [salt.state       ][INFO    ][31657] unless execution succeeded
2017-10-25 02:20:49,212 [salt.state       ][INFO    ][31657] Completed state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'On'] at time 02:20:49.212108 duration_in_ms=48.175
2017-10-25 02:20:49,213 [salt.state       ][INFO    ][31657] Running state [gluster volume set 'nova_instances' 'network.remote-dio' 'On'] at time 02:20:49.212582
2017-10-25 02:20:49,213 [salt.state       ][INFO    ][31657] Executing state cmd.run for gluster volume set 'nova_instances' 'network.remote-dio' 'On'
2017-10-25 02:20:49,213 [salt.loaded.int.module.cmdmod][INFO    ][31657] Executing command 'gluster volume info 'nova_instances' | grep 'network.remote-dio: On'' in directory '/root'
2017-10-25 02:20:49,262 [salt.state       ][INFO    ][31657] unless execution succeeded
2017-10-25 02:20:49,262 [salt.state       ][INFO    ][31657] Completed state [gluster volume set 'nova_instances' 'network.remote-dio' 'On'] at time 02:20:49.261856 duration_in_ms=49.274
2017-10-25 02:20:49,262 [salt.state       ][INFO    ][31657] Running state [gluster volume set 'nova_instances' 'nfs.disable' 'On'] at time 02:20:49.262303
2017-10-25 02:20:49,263 [salt.state       ][INFO    ][31657] Executing state cmd.run for gluster volume set 'nova_instances' 'nfs.disable' 'On'
2017-10-25 02:20:49,263 [salt.loaded.int.module.cmdmod][INFO    ][31657] Executing command 'gluster volume info 'nova_instances' | grep 'nfs.disable: On'' in directory '/root'
2017-10-25 02:20:49,311 [salt.state       ][INFO    ][31657] unless execution succeeded
2017-10-25 02:20:49,311 [salt.state       ][INFO    ][31657] Completed state [gluster volume set 'nova_instances' 'nfs.disable' 'On'] at time 02:20:49.311429 duration_in_ms=49.124
2017-10-25 02:20:49,312 [salt.state       ][INFO    ][31657] Running state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 02:20:49.311865
2017-10-25 02:20:49,312 [salt.state       ][INFO    ][31657] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'
2017-10-25 02:20:49,312 [salt.loaded.int.module.cmdmod][INFO    ][31657] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-10-25 02:20:49,360 [salt.state       ][INFO    ][31657] unless execution succeeded
2017-10-25 02:20:49,360 [salt.state       ][INFO    ][31657] Completed state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 02:20:49.360115 duration_in_ms=48.25
2017-10-25 02:20:49,361 [salt.state       ][INFO    ][31657] Running state [nova_instances] at time 02:20:49.361027
2017-10-25 02:20:49,361 [salt.state       ][INFO    ][31657] Executing state glusterfs.started for nova_instances
2017-10-25 02:20:49,362 [salt.loaded.int.module.cmdmod][INFO    ][31657] Executing command 'gluster --version' in directory '/root'
2017-10-25 02:20:49,369 [salt.loaded.int.module.cmdmod][INFO    ][31657] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-25 02:20:49,415 [salt.loaded.int.module.cmdmod][INFO    ][31657] Executing command 'gluster --version' in directory '/root'
2017-10-25 02:20:49,424 [salt.loaded.int.module.cmdmod][INFO    ][31657] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-25 02:20:49,474 [salt.state       ][INFO    ][31657] Volume nova_instances is already started
2017-10-25 02:20:49,474 [salt.state       ][INFO    ][31657] Completed state [nova_instances] at time 02:20:49.474017 duration_in_ms=112.99
2017-10-25 02:20:49,475 [salt.state       ][INFO    ][31657] Running state [keystone-credential-keys] at time 02:20:49.474810
2017-10-25 02:20:49,475 [salt.state       ][INFO    ][31657] Executing state glusterfs.created for keystone-credential-keys
2017-10-25 02:20:49,475 [salt.loaded.int.module.cmdmod][INFO    ][31657] Executing command 'gluster --version' in directory '/root'
2017-10-25 02:20:49,483 [salt.loaded.int.module.cmdmod][INFO    ][31657] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-25 02:20:49,530 [salt.loaded.int.module.cmdmod][INFO    ][31657] Executing command 'gluster --version' in directory '/root'
2017-10-25 02:20:49,537 [salt.loaded.int.module.cmdmod][INFO    ][31657] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-25 02:20:49,589 [salt.state       ][INFO    ][31657] Volume keystone-credential-keys already exists and is started.
2017-10-25 02:20:49,589 [salt.state       ][INFO    ][31657] Completed state [keystone-credential-keys] at time 02:20:49.588890 duration_in_ms=114.079
2017-10-25 02:20:49,592 [salt.state       ][INFO    ][31657] Running state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 02:20:49.591798
2017-10-25 02:20:49,592 [salt.state       ][INFO    ][31657] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'
2017-10-25 02:20:49,592 [salt.loaded.int.module.cmdmod][INFO    ][31657] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-10-25 02:20:49,640 [salt.state       ][INFO    ][31657] unless execution succeeded
2017-10-25 02:20:49,640 [salt.state       ][INFO    ][31657] Completed state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 02:20:49.639912 duration_in_ms=48.113
2017-10-25 02:20:49,640 [salt.state       ][INFO    ][31657] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 02:20:49.640353
2017-10-25 02:20:49,641 [salt.state       ][INFO    ][31657] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-10-25 02:20:49,641 [salt.loaded.int.module.cmdmod][INFO    ][31657] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-10-25 02:20:49,687 [salt.state       ][INFO    ][31657] unless execution succeeded
2017-10-25 02:20:49,687 [salt.state       ][INFO    ][31657] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 02:20:49.687245 duration_in_ms=46.892
2017-10-25 02:20:49,688 [salt.state       ][INFO    ][31657] Running state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 02:20:49.687667
2017-10-25 02:20:49,688 [salt.state       ][INFO    ][31657] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'
2017-10-25 02:20:49,688 [salt.loaded.int.module.cmdmod][INFO    ][31657] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-10-25 02:20:49,737 [salt.state       ][INFO    ][31657] unless execution succeeded
2017-10-25 02:20:49,738 [salt.state       ][INFO    ][31657] Completed state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 02:20:49.737777 duration_in_ms=50.109
2017-10-25 02:20:49,738 [salt.state       ][INFO    ][31657] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 02:20:49.738421
2017-10-25 02:20:49,739 [salt.state       ][INFO    ][31657] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'
2017-10-25 02:20:49,739 [salt.loaded.int.module.cmdmod][INFO    ][31657] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-10-25 02:20:49,788 [salt.state       ][INFO    ][31657] unless execution succeeded
2017-10-25 02:20:49,788 [salt.state       ][INFO    ][31657] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 02:20:49.788032 duration_in_ms=49.61
2017-10-25 02:20:49,789 [salt.state       ][INFO    ][31657] Running state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 02:20:49.788490
2017-10-25 02:20:49,789 [salt.state       ][INFO    ][31657] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'
2017-10-25 02:20:49,789 [salt.loaded.int.module.cmdmod][INFO    ][31657] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-10-25 02:20:49,838 [salt.state       ][INFO    ][31657] unless execution succeeded
2017-10-25 02:20:49,838 [salt.state       ][INFO    ][31657] Completed state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 02:20:49.838233 duration_in_ms=49.742
2017-10-25 02:20:49,839 [salt.state       ][INFO    ][31657] Running state [keystone-credential-keys] at time 02:20:49.839201
2017-10-25 02:20:49,839 [salt.state       ][INFO    ][31657] Executing state glusterfs.started for keystone-credential-keys
2017-10-25 02:20:49,840 [salt.loaded.int.module.cmdmod][INFO    ][31657] Executing command 'gluster --version' in directory '/root'
2017-10-25 02:20:49,848 [salt.loaded.int.module.cmdmod][INFO    ][31657] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-25 02:20:49,895 [salt.loaded.int.module.cmdmod][INFO    ][31657] Executing command 'gluster --version' in directory '/root'
2017-10-25 02:20:49,903 [salt.loaded.int.module.cmdmod][INFO    ][31657] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-25 02:20:49,956 [salt.state       ][INFO    ][31657] Volume keystone-credential-keys is already started
2017-10-25 02:20:49,957 [salt.state       ][INFO    ][31657] Completed state [keystone-credential-keys] at time 02:20:49.956544 duration_in_ms=117.343
2017-10-25 02:20:49,958 [salt.minion      ][INFO    ][31657] Returning information for job: 20171025022046353100
2017-10-25 02:20:51,058 [salt.minion      ][INFO    ][23807] User sudo_ubuntu Executing command test.ping with jid 20171025022051047319
2017-10-25 02:20:51,074 [salt.minion      ][INFO    ][32058] Starting a new job with PID 32058
2017-10-25 02:20:51,099 [salt.minion      ][INFO    ][32058] Returning information for job: 20171025022051047319
2017-10-25 02:20:51,754 [salt.minion      ][INFO    ][23807] User sudo_ubuntu Executing command cmd.run with jid 20171025022051743612
2017-10-25 02:20:51,770 [salt.minion      ][INFO    ][32064] Starting a new job with PID 32064
2017-10-25 02:20:51,774 [salt.loaded.int.module.cmdmod][INFO    ][32064] Executing command 'gluster peer status; gluster volume status' in directory '/root'
2017-10-25 02:20:51,884 [salt.minion      ][INFO    ][32064] Returning information for job: 20171025022051743612
2017-10-25 02:39:03,673 [salt.utils.schedule][INFO    ][23807] Running scheduled job: __mine_interval
2017-10-25 03:19:05,196 [salt.minion      ][INFO    ][23807] User sudo_ubuntu Executing command test.ping with jid 20171025031905186811
2017-10-25 03:19:05,221 [salt.minion      ][INFO    ][578] Starting a new job with PID 578
2017-10-25 03:19:05,479 [salt.minion      ][INFO    ][578] Returning information for job: 20171025031905186811
2017-10-25 03:19:18,642 [salt.minion      ][INFO    ][23807] User sudo_ubuntu Executing command state.sls with jid 20171025031918624194
2017-10-25 03:19:18,658 [salt.minion      ][INFO    ][594] Starting a new job with PID 594
2017-10-25 03:19:19,171 [salt.state       ][INFO    ][594] Loading fresh modules for state activity
2017-10-25 03:19:19,197 [salt.fileclient  ][INFO    ][594] Fetching file from saltenv 'base', ** done ** 'keepalived/init.sls'
2017-10-25 03:19:19,231 [salt.fileclient  ][INFO    ][594] Fetching file from saltenv 'base', ** done ** 'keepalived/cluster.sls'
2017-10-25 03:19:19,265 [salt.fileclient  ][INFO    ][594] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-10-25 03:19:19,816 [salt.state       ][INFO    ][594] Running state [lsof] at time 03:19:19.815849
2017-10-25 03:19:19,816 [salt.state       ][INFO    ][594] Executing state pkg.installed for lsof
2017-10-25 03:19:19,817 [salt.loaded.int.module.cmdmod][INFO    ][594] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-10-25 03:19:20,744 [salt.state       ][INFO    ][594] Package lsof is already installed
2017-10-25 03:19:20,744 [salt.state       ][INFO    ][594] Completed state [lsof] at time 03:19:20.744404 duration_in_ms=928.556
2017-10-25 03:19:20,745 [salt.state       ][INFO    ][594] Running state [keepalived] at time 03:19:20.744626
2017-10-25 03:19:20,745 [salt.state       ][INFO    ][594] Executing state pkg.installed for keepalived
2017-10-25 03:19:20,747 [salt.state       ][INFO    ][594] Package keepalived is already installed
2017-10-25 03:19:20,748 [salt.state       ][INFO    ][594] Completed state [keepalived] at time 03:19:20.747553 duration_in_ms=2.927
2017-10-25 03:19:20,749 [salt.state       ][INFO    ][594] Running state [/etc/keepalived/keepalived.conf] at time 03:19:20.749045
2017-10-25 03:19:20,749 [salt.state       ][INFO    ][594] Executing state file.managed for /etc/keepalived/keepalived.conf
2017-10-25 03:19:20,773 [salt.fileclient  ][INFO    ][594] Fetching file from saltenv 'base', ** done ** 'keepalived/files/keepalived.conf'
2017-10-25 03:19:20,802 [salt.fileclient  ][INFO    ][594] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-10-25 03:19:20,807 [salt.state       ][INFO    ][594] File /etc/keepalived/keepalived.conf is in the correct state
2017-10-25 03:19:20,807 [salt.state       ][INFO    ][594] Completed state [/etc/keepalived/keepalived.conf] at time 03:19:20.806707 duration_in_ms=57.661
2017-10-25 03:19:20,868 [salt.state       ][INFO    ][594] Running state [keepalived] at time 03:19:20.867622
2017-10-25 03:19:20,878 [salt.state       ][INFO    ][594] Executing state service.running for keepalived
2017-10-25 03:19:20,879 [salt.loaded.int.module.cmdmod][INFO    ][594] Executing command ['systemctl', 'status', 'keepalived.service', '-n', '0'] in directory '/root'
2017-10-25 03:19:20,918 [salt.loaded.int.module.cmdmod][INFO    ][594] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2017-10-25 03:19:20,927 [salt.loaded.int.module.cmdmod][INFO    ][594] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-10-25 03:19:20,936 [salt.state       ][INFO    ][594] The service keepalived is already running
2017-10-25 03:19:20,938 [salt.state       ][INFO    ][594] Completed state [keepalived] at time 03:19:20.937962 duration_in_ms=70.339
2017-10-25 03:19:20,939 [salt.minion      ][INFO    ][594] Returning information for job: 20171025031918624194
2017-10-25 03:19:47,653 [salt.minion      ][INFO    ][23807] User sudo_ubuntu Executing command pillar.get with jid 20171025031947642652
2017-10-25 03:19:47,672 [salt.minion      ][INFO    ][621] Starting a new job with PID 621
2017-10-25 03:19:47,678 [salt.minion      ][INFO    ][621] Returning information for job: 20171025031947642652
2017-10-25 03:20:25,342 [salt.minion      ][INFO    ][23807] User sudo_ubuntu Executing command state.sls with jid 20171025032025329553
2017-10-25 03:20:25,356 [salt.minion      ][INFO    ][630] Starting a new job with PID 630
2017-10-25 03:20:25,808 [salt.state       ][INFO    ][630] Loading fresh modules for state activity
2017-10-25 03:20:25,826 [salt.fileclient  ][INFO    ][630] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-10-25 03:20:25,845 [salt.fileclient  ][INFO    ][630] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-10-25 03:20:26,106 [salt.state       ][INFO    ][630] Running state [attr] at time 03:20:26.106016
2017-10-25 03:20:26,106 [salt.state       ][INFO    ][630] Executing state pkg.installed for attr
2017-10-25 03:20:26,107 [salt.loaded.int.module.cmdmod][INFO    ][630] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-10-25 03:20:26,360 [salt.state       ][INFO    ][630] Package attr is already installed
2017-10-25 03:20:26,360 [salt.state       ][INFO    ][630] Completed state [attr] at time 03:20:26.360222 duration_in_ms=254.206
2017-10-25 03:20:26,360 [salt.state       ][INFO    ][630] Running state [glusterfs-server] at time 03:20:26.360406
2017-10-25 03:20:26,361 [salt.state       ][INFO    ][630] Executing state pkg.installed for glusterfs-server
2017-10-25 03:20:26,363 [salt.state       ][INFO    ][630] Package glusterfs-server is already installed
2017-10-25 03:20:26,363 [salt.state       ][INFO    ][630] Completed state [glusterfs-server] at time 03:20:26.363237 duration_in_ms=2.83
2017-10-25 03:20:26,363 [salt.state       ][INFO    ][630] Running state [bc] at time 03:20:26.363378
2017-10-25 03:20:26,364 [salt.state       ][INFO    ][630] Executing state pkg.installed for bc
2017-10-25 03:20:26,366 [salt.state       ][INFO    ][630] Package bc is already installed
2017-10-25 03:20:26,366 [salt.state       ][INFO    ][630] Completed state [bc] at time 03:20:26.366115 duration_in_ms=2.737
2017-10-25 03:20:26,367 [salt.state       ][INFO    ][630] Running state [glusterfs-server] at time 03:20:26.366750
2017-10-25 03:20:26,367 [salt.state       ][INFO    ][630] Executing state service.running for glusterfs-server
2017-10-25 03:20:26,367 [salt.loaded.int.module.cmdmod][INFO    ][630] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-10-25 03:20:26,382 [salt.loaded.int.module.cmdmod][INFO    ][630] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-10-25 03:20:26,390 [salt.loaded.int.module.cmdmod][INFO    ][630] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-10-25 03:20:26,407 [salt.state       ][INFO    ][630] The service glusterfs-server is already running
2017-10-25 03:20:26,408 [salt.state       ][INFO    ][630] Completed state [glusterfs-server] at time 03:20:26.407557 duration_in_ms=40.807
2017-10-25 03:20:26,409 [salt.state       ][INFO    ][630] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 03:20:26.408886
2017-10-25 03:20:26,409 [salt.state       ][INFO    ][630] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-10-25 03:20:26,420 [salt.state       ][INFO    ][630] File /etc/systemd/system/glusterfs-server.service.d/override.conf is in the correct state
2017-10-25 03:20:26,420 [salt.state       ][INFO    ][630] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 03:20:26.420114 duration_in_ms=11.228
2017-10-25 03:20:26,420 [salt.state       ][INFO    ][630] Running state [/srv/glusterfs/glance] at time 03:20:26.420283
2017-10-25 03:20:26,420 [salt.state       ][INFO    ][630] Executing state file.directory for /srv/glusterfs/glance
2017-10-25 03:20:26,421 [salt.state       ][INFO    ][630] Directory /srv/glusterfs/glance is in the correct state
2017-10-25 03:20:26,421 [salt.state       ][INFO    ][630] Completed state [/srv/glusterfs/glance] at time 03:20:26.420919 duration_in_ms=0.636
2017-10-25 03:20:26,421 [salt.state       ][INFO    ][630] Running state [/srv/glusterfs/keystone-keys] at time 03:20:26.421077
2017-10-25 03:20:26,421 [salt.state       ][INFO    ][630] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-10-25 03:20:26,422 [salt.state       ][INFO    ][630] Directory /srv/glusterfs/keystone-keys is in the correct state
2017-10-25 03:20:26,422 [salt.state       ][INFO    ][630] Completed state [/srv/glusterfs/keystone-keys] at time 03:20:26.421739 duration_in_ms=0.662
2017-10-25 03:20:26,422 [salt.state       ][INFO    ][630] Running state [/srv/glusterfs/nova_instances] at time 03:20:26.421888
2017-10-25 03:20:26,422 [salt.state       ][INFO    ][630] Executing state file.directory for /srv/glusterfs/nova_instances
2017-10-25 03:20:26,422 [salt.state       ][INFO    ][630] Directory /srv/glusterfs/nova_instances is in the correct state
2017-10-25 03:20:26,423 [salt.state       ][INFO    ][630] Completed state [/srv/glusterfs/nova_instances] at time 03:20:26.422491 duration_in_ms=0.604
2017-10-25 03:20:26,423 [salt.state       ][INFO    ][630] Running state [/srv/glusterfs/keystone-credential-keys] at time 03:20:26.422640
2017-10-25 03:20:26,423 [salt.state       ][INFO    ][630] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-10-25 03:20:26,423 [salt.state       ][INFO    ][630] Directory /srv/glusterfs/keystone-credential-keys is in the correct state
2017-10-25 03:20:26,423 [salt.state       ][INFO    ][630] Completed state [/srv/glusterfs/keystone-credential-keys] at time 03:20:26.423275 duration_in_ms=0.634
2017-10-25 03:20:26,424 [salt.minion      ][INFO    ][630] Returning information for job: 20171025032025329553
2017-10-25 03:20:27,636 [salt.minion      ][INFO    ][23807] User sudo_ubuntu Executing command test.ping with jid 20171025032027624038
2017-10-25 03:20:27,650 [salt.minion      ][INFO    ][653] Starting a new job with PID 653
2017-10-25 03:20:27,678 [salt.minion      ][INFO    ][653] Returning information for job: 20171025032027624038
2017-10-25 03:20:36,720 [salt.minion      ][INFO    ][23807] User sudo_ubuntu Executing command state.sls with jid 20171025032036706675
2017-10-25 03:20:36,735 [salt.minion      ][INFO    ][658] Starting a new job with PID 658
2017-10-25 03:20:37,208 [salt.state       ][INFO    ][658] Loading fresh modules for state activity
2017-10-25 03:20:37,228 [salt.fileclient  ][INFO    ][658] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/setup.sls'
2017-10-25 03:20:37,257 [salt.fileclient  ][INFO    ][658] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-10-25 03:20:37,320 [salt.fileclient  ][INFO    ][658] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-10-25 03:20:37,337 [salt.fileclient  ][INFO    ][658] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-10-25 03:20:37,607 [salt.state       ][INFO    ][658] Running state [attr] at time 03:20:37.607410
2017-10-25 03:20:37,608 [salt.state       ][INFO    ][658] Executing state pkg.installed for attr
2017-10-25 03:20:37,608 [salt.loaded.int.module.cmdmod][INFO    ][658] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-10-25 03:20:37,889 [salt.state       ][INFO    ][658] Package attr is already installed
2017-10-25 03:20:37,889 [salt.state       ][INFO    ][658] Completed state [attr] at time 03:20:37.889248 duration_in_ms=281.839
2017-10-25 03:20:37,889 [salt.state       ][INFO    ][658] Running state [glusterfs-server] at time 03:20:37.889452
2017-10-25 03:20:37,890 [salt.state       ][INFO    ][658] Executing state pkg.installed for glusterfs-server
2017-10-25 03:20:37,892 [salt.state       ][INFO    ][658] Package glusterfs-server is already installed
2017-10-25 03:20:37,892 [salt.state       ][INFO    ][658] Completed state [glusterfs-server] at time 03:20:37.892299 duration_in_ms=2.846
2017-10-25 03:20:37,892 [salt.state       ][INFO    ][658] Running state [bc] at time 03:20:37.892431
2017-10-25 03:20:37,893 [salt.state       ][INFO    ][658] Executing state pkg.installed for bc
2017-10-25 03:20:37,895 [salt.state       ][INFO    ][658] Package bc is already installed
2017-10-25 03:20:37,895 [salt.state       ][INFO    ][658] Completed state [bc] at time 03:20:37.895178 duration_in_ms=2.747
2017-10-25 03:20:37,896 [salt.state       ][INFO    ][658] Running state [glusterfs-server] at time 03:20:37.895933
2017-10-25 03:20:37,896 [salt.state       ][INFO    ][658] Executing state service.running for glusterfs-server
2017-10-25 03:20:37,896 [salt.loaded.int.module.cmdmod][INFO    ][658] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-10-25 03:20:37,909 [salt.loaded.int.module.cmdmod][INFO    ][658] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-10-25 03:20:37,915 [salt.loaded.int.module.cmdmod][INFO    ][658] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-10-25 03:20:37,923 [salt.state       ][INFO    ][658] The service glusterfs-server is already running
2017-10-25 03:20:37,923 [salt.state       ][INFO    ][658] Completed state [glusterfs-server] at time 03:20:37.922949 duration_in_ms=27.015
2017-10-25 03:20:37,924 [salt.state       ][INFO    ][658] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 03:20:37.924326
2017-10-25 03:20:37,925 [salt.state       ][INFO    ][658] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-10-25 03:20:37,929 [salt.state       ][INFO    ][658] File /etc/systemd/system/glusterfs-server.service.d/override.conf is in the correct state
2017-10-25 03:20:37,929 [salt.state       ][INFO    ][658] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 03:20:37.929288 duration_in_ms=4.962
2017-10-25 03:20:37,929 [salt.state       ][INFO    ][658] Running state [/srv/glusterfs/glance] at time 03:20:37.929475
2017-10-25 03:20:37,930 [salt.state       ][INFO    ][658] Executing state file.directory for /srv/glusterfs/glance
2017-10-25 03:20:37,930 [salt.state       ][INFO    ][658] Directory /srv/glusterfs/glance is in the correct state
2017-10-25 03:20:37,930 [salt.state       ][INFO    ][658] Completed state [/srv/glusterfs/glance] at time 03:20:37.930144 duration_in_ms=0.668
2017-10-25 03:20:37,930 [salt.state       ][INFO    ][658] Running state [/srv/glusterfs/keystone-keys] at time 03:20:37.930294
2017-10-25 03:20:37,930 [salt.state       ][INFO    ][658] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-10-25 03:20:37,931 [salt.state       ][INFO    ][658] Directory /srv/glusterfs/keystone-keys is in the correct state
2017-10-25 03:20:37,931 [salt.state       ][INFO    ][658] Completed state [/srv/glusterfs/keystone-keys] at time 03:20:37.930902 duration_in_ms=0.607
2017-10-25 03:20:37,931 [salt.state       ][INFO    ][658] Running state [/srv/glusterfs/nova_instances] at time 03:20:37.931051
2017-10-25 03:20:37,931 [salt.state       ][INFO    ][658] Executing state file.directory for /srv/glusterfs/nova_instances
2017-10-25 03:20:37,932 [salt.state       ][INFO    ][658] Directory /srv/glusterfs/nova_instances is in the correct state
2017-10-25 03:20:37,932 [salt.state       ][INFO    ][658] Completed state [/srv/glusterfs/nova_instances] at time 03:20:37.931696 duration_in_ms=0.644
2017-10-25 03:20:37,932 [salt.state       ][INFO    ][658] Running state [/srv/glusterfs/keystone-credential-keys] at time 03:20:37.931851
2017-10-25 03:20:37,932 [salt.state       ][INFO    ][658] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-10-25 03:20:37,932 [salt.state       ][INFO    ][658] Directory /srv/glusterfs/keystone-credential-keys is in the correct state
2017-10-25 03:20:37,933 [salt.state       ][INFO    ][658] Completed state [/srv/glusterfs/keystone-credential-keys] at time 03:20:37.932480 duration_in_ms=0.628
2017-10-25 03:20:37,971 [salt.loaded.int.module.cmdmod][INFO    ][658] Executing command ['git', '--version'] in directory '/root'
2017-10-25 03:20:38,109 [salt.state       ][INFO    ][658] Running state [sleep 5] at time 03:20:38.108899
2017-10-25 03:20:38,109 [salt.state       ][INFO    ][658] Executing state cmd.wait for sleep 5
2017-10-25 03:20:38,109 [salt.state       ][INFO    ][658] No changes made for sleep 5
2017-10-25 03:20:38,109 [salt.state       ][INFO    ][658] Completed state [sleep 5] at time 03:20:38.109444 duration_in_ms=0.546
2017-10-25 03:20:38,110 [salt.state       ][INFO    ][658] Running state [10.167.4.141] at time 03:20:38.109803
2017-10-25 03:20:38,110 [salt.state       ][INFO    ][658] Executing state glusterfs.peered for 10.167.4.141
2017-10-25 03:20:38,110 [salt.loaded.int.module.cmdmod][INFO    ][658] Executing command 'gluster --version' in directory '/root'
2017-10-25 03:20:38,118 [salt.loaded.int.module.cmdmod][INFO    ][658] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-25 03:20:38,393 [salt.loaded.int.module.cmdmod][INFO    ][658] Executing command 'gluster --version' in directory '/root'
2017-10-25 03:20:38,402 [salt.loaded.int.module.cmdmod][INFO    ][658] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-25 03:20:38,454 [salt.loaded.int.module.cmdmod][INFO    ][658] Executing command 'gluster --version' in directory '/root'
2017-10-25 03:20:38,461 [salt.loaded.int.module.cmdmod][INFO    ][658] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-25 03:20:38,511 [salt.loaded.int.module.cmdmod][INFO    ][658] Executing command 'gluster --version' in directory '/root'
2017-10-25 03:20:38,519 [salt.loaded.int.module.cmdmod][INFO    ][658] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-25 03:20:38,566 [salt.state       ][INFO    ][658] Peering with localhost is not needed
2017-10-25 03:20:38,566 [salt.state       ][INFO    ][658] Completed state [10.167.4.141] at time 03:20:38.566140 duration_in_ms=456.336
2017-10-25 03:20:38,569 [salt.state       ][INFO    ][658] Running state [10.167.4.142] at time 03:20:38.568489
2017-10-25 03:20:38,569 [salt.state       ][INFO    ][658] Executing state glusterfs.peered for 10.167.4.142
2017-10-25 03:20:38,569 [salt.loaded.int.module.cmdmod][INFO    ][658] Executing command 'gluster --version' in directory '/root'
2017-10-25 03:20:38,577 [salt.loaded.int.module.cmdmod][INFO    ][658] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-25 03:20:38,624 [salt.state       ][INFO    ][658] Host 10.167.4.142 already peered
2017-10-25 03:20:38,625 [salt.state       ][INFO    ][658] Completed state [10.167.4.142] at time 03:20:38.624538 duration_in_ms=56.049
2017-10-25 03:20:38,627 [salt.state       ][INFO    ][658] Running state [10.167.4.143] at time 03:20:38.626778
2017-10-25 03:20:38,627 [salt.state       ][INFO    ][658] Executing state glusterfs.peered for 10.167.4.143
2017-10-25 03:20:38,628 [salt.loaded.int.module.cmdmod][INFO    ][658] Executing command 'gluster --version' in directory '/root'
2017-10-25 03:20:38,635 [salt.loaded.int.module.cmdmod][INFO    ][658] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-25 03:20:38,685 [salt.state       ][INFO    ][658] Host 10.167.4.143 already peered
2017-10-25 03:20:38,686 [salt.state       ][INFO    ][658] Completed state [10.167.4.143] at time 03:20:38.685489 duration_in_ms=58.71
2017-10-25 03:20:38,686 [salt.state       ][INFO    ][658] Running state [glance] at time 03:20:38.686278
2017-10-25 03:20:38,687 [salt.state       ][INFO    ][658] Executing state glusterfs.created for glance
2017-10-25 03:20:38,687 [salt.loaded.int.module.cmdmod][INFO    ][658] Executing command 'gluster --version' in directory '/root'
2017-10-25 03:20:38,695 [salt.loaded.int.module.cmdmod][INFO    ][658] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-25 03:20:38,742 [salt.loaded.int.module.cmdmod][INFO    ][658] Executing command 'gluster --version' in directory '/root'
2017-10-25 03:20:38,749 [salt.loaded.int.module.cmdmod][INFO    ][658] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-25 03:20:38,800 [salt.state       ][INFO    ][658] Volume glance already exists and is started.
2017-10-25 03:20:38,800 [salt.state       ][INFO    ][658] Completed state [glance] at time 03:20:38.800203 duration_in_ms=113.925
2017-10-25 03:20:38,803 [salt.state       ][INFO    ][658] Running state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 03:20:38.803035
2017-10-25 03:20:38,803 [salt.state       ][INFO    ][658] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'
2017-10-25 03:20:38,804 [salt.loaded.int.module.cmdmod][INFO    ][658] Executing command 'gluster volume info 'glance' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-10-25 03:20:38,855 [salt.state       ][INFO    ][658] unless execution succeeded
2017-10-25 03:20:38,855 [salt.state       ][INFO    ][658] Completed state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 03:20:38.855350 duration_in_ms=52.315
2017-10-25 03:20:38,856 [salt.state       ][INFO    ][658] Running state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 03:20:38.855756
2017-10-25 03:20:38,856 [salt.state       ][INFO    ][658] Executing state cmd.run for gluster volume set 'glance' 'network.remote-dio' 'True'
2017-10-25 03:20:38,856 [salt.loaded.int.module.cmdmod][INFO    ][658] Executing command 'gluster volume info 'glance' | grep 'network.remote-dio: True'' in directory '/root'
2017-10-25 03:20:38,902 [salt.state       ][INFO    ][658] unless execution succeeded
2017-10-25 03:20:38,902 [salt.state       ][INFO    ][658] Completed state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 03:20:38.902239 duration_in_ms=46.483
2017-10-25 03:20:38,903 [salt.state       ][INFO    ][658] Running state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 03:20:38.902666
2017-10-25 03:20:38,903 [salt.state       ][INFO    ][658] Executing state cmd.run for gluster volume set 'glance' 'nfs.disable' 'True'
2017-10-25 03:20:38,903 [salt.loaded.int.module.cmdmod][INFO    ][658] Executing command 'gluster volume info 'glance' | grep 'nfs.disable: True'' in directory '/root'
2017-10-25 03:20:38,952 [salt.state       ][INFO    ][658] unless execution succeeded
2017-10-25 03:20:38,952 [salt.state       ][INFO    ][658] Completed state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 03:20:38.951939 duration_in_ms=49.272
2017-10-25 03:20:38,952 [salt.state       ][INFO    ][658] Running state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 03:20:38.952448
2017-10-25 03:20:38,953 [salt.state       ][INFO    ][658] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'
2017-10-25 03:20:38,953 [salt.loaded.int.module.cmdmod][INFO    ][658] Executing command 'gluster volume info 'glance' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-10-25 03:20:39,002 [salt.state       ][INFO    ][658] unless execution succeeded
2017-10-25 03:20:39,002 [salt.state       ][INFO    ][658] Completed state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 03:20:39.002069 duration_in_ms=49.621
2017-10-25 03:20:39,003 [salt.state       ][INFO    ][658] Running state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 03:20:39.002483
2017-10-25 03:20:39,003 [salt.state       ][INFO    ][658] Executing state cmd.run for gluster volume set 'glance' 'cluster.readdir-optimize' 'True'
2017-10-25 03:20:39,003 [salt.loaded.int.module.cmdmod][INFO    ][658] Executing command 'gluster volume info 'glance' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-10-25 03:20:39,056 [salt.state       ][INFO    ][658] unless execution succeeded
2017-10-25 03:20:39,056 [salt.state       ][INFO    ][658] Completed state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 03:20:39.055877 duration_in_ms=53.394
2017-10-25 03:20:39,057 [salt.state       ][INFO    ][658] Running state [glance] at time 03:20:39.056716
2017-10-25 03:20:39,057 [salt.state       ][INFO    ][658] Executing state glusterfs.started for glance
2017-10-25 03:20:39,057 [salt.loaded.int.module.cmdmod][INFO    ][658] Executing command 'gluster --version' in directory '/root'
2017-10-25 03:20:39,063 [salt.loaded.int.module.cmdmod][INFO    ][658] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-25 03:20:39,113 [salt.loaded.int.module.cmdmod][INFO    ][658] Executing command 'gluster --version' in directory '/root'
2017-10-25 03:20:39,122 [salt.loaded.int.module.cmdmod][INFO    ][658] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-25 03:20:39,173 [salt.state       ][INFO    ][658] Volume glance is already started
2017-10-25 03:20:39,173 [salt.state       ][INFO    ][658] Completed state [glance] at time 03:20:39.173391 duration_in_ms=116.674
2017-10-25 03:20:39,174 [salt.state       ][INFO    ][658] Running state [keystone-keys] at time 03:20:39.174253
2017-10-25 03:20:39,175 [salt.state       ][INFO    ][658] Executing state glusterfs.created for keystone-keys
2017-10-25 03:20:39,175 [salt.loaded.int.module.cmdmod][INFO    ][658] Executing command 'gluster --version' in directory '/root'
2017-10-25 03:20:39,183 [salt.loaded.int.module.cmdmod][INFO    ][658] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-25 03:20:39,230 [salt.loaded.int.module.cmdmod][INFO    ][658] Executing command 'gluster --version' in directory '/root'
2017-10-25 03:20:39,239 [salt.loaded.int.module.cmdmod][INFO    ][658] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-25 03:20:39,289 [salt.state       ][INFO    ][658] Volume keystone-keys already exists and is started.
2017-10-25 03:20:39,289 [salt.state       ][INFO    ][658] Completed state [keystone-keys] at time 03:20:39.289278 duration_in_ms=115.025
2017-10-25 03:20:39,292 [salt.state       ][INFO    ][658] Running state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 03:20:39.292270
2017-10-25 03:20:39,293 [salt.state       ][INFO    ][658] Executing state cmd.run for gluster volume set 'keystone-keys' 'network.remote-dio' 'True'
2017-10-25 03:20:39,293 [salt.loaded.int.module.cmdmod][INFO    ][658] Executing command 'gluster volume info 'keystone-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-10-25 03:20:39,344 [salt.state       ][INFO    ][658] unless execution succeeded
2017-10-25 03:20:39,345 [salt.state       ][INFO    ][658] Completed state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 03:20:39.344483 duration_in_ms=52.213
2017-10-25 03:20:39,345 [salt.state       ][INFO    ][658] Running state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 03:20:39.344884
2017-10-25 03:20:39,345 [salt.state       ][INFO    ][658] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-10-25 03:20:39,346 [salt.loaded.int.module.cmdmod][INFO    ][658] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-10-25 03:20:39,394 [salt.state       ][INFO    ][658] unless execution succeeded
2017-10-25 03:20:39,394 [salt.state       ][INFO    ][658] Completed state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 03:20:39.394212 duration_in_ms=49.328
2017-10-25 03:20:39,395 [salt.state       ][INFO    ][658] Running state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 03:20:39.394607
2017-10-25 03:20:39,395 [salt.state       ][INFO    ][658] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'
2017-10-25 03:20:39,395 [salt.loaded.int.module.cmdmod][INFO    ][658] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-10-25 03:20:39,445 [salt.state       ][INFO    ][658] unless execution succeeded
2017-10-25 03:20:39,446 [salt.state       ][INFO    ][658] Completed state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 03:20:39.445495 duration_in_ms=50.887
2017-10-25 03:20:39,446 [salt.state       ][INFO    ][658] Running state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 03:20:39.445914
2017-10-25 03:20:39,446 [salt.state       ][INFO    ][658] Executing state cmd.run for gluster volume set 'keystone-keys' 'nfs.disable' 'True'
2017-10-25 03:20:39,447 [salt.loaded.int.module.cmdmod][INFO    ][658] Executing command 'gluster volume info 'keystone-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-10-25 03:20:39,496 [salt.state       ][INFO    ][658] unless execution succeeded
2017-10-25 03:20:39,497 [salt.state       ][INFO    ][658] Completed state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 03:20:39.496460 duration_in_ms=50.545
2017-10-25 03:20:39,497 [salt.state       ][INFO    ][658] Running state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 03:20:39.496890
2017-10-25 03:20:39,497 [salt.state       ][INFO    ][658] Executing state cmd.run for gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'
2017-10-25 03:20:39,498 [salt.loaded.int.module.cmdmod][INFO    ][658] Executing command 'gluster volume info 'keystone-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-10-25 03:20:39,546 [salt.state       ][INFO    ][658] unless execution succeeded
2017-10-25 03:20:39,546 [salt.state       ][INFO    ][658] Completed state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 03:20:39.546077 duration_in_ms=49.187
2017-10-25 03:20:39,547 [salt.state       ][INFO    ][658] Running state [keystone-keys] at time 03:20:39.546922
2017-10-25 03:20:39,547 [salt.state       ][INFO    ][658] Executing state glusterfs.started for keystone-keys
2017-10-25 03:20:39,548 [salt.loaded.int.module.cmdmod][INFO    ][658] Executing command 'gluster --version' in directory '/root'
2017-10-25 03:20:39,553 [salt.loaded.int.module.cmdmod][INFO    ][658] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-25 03:20:39,600 [salt.loaded.int.module.cmdmod][INFO    ][658] Executing command 'gluster --version' in directory '/root'
2017-10-25 03:20:39,608 [salt.loaded.int.module.cmdmod][INFO    ][658] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-25 03:20:39,658 [salt.state       ][INFO    ][658] Volume keystone-keys is already started
2017-10-25 03:20:39,658 [salt.state       ][INFO    ][658] Completed state [keystone-keys] at time 03:20:39.657760 duration_in_ms=110.837
2017-10-25 03:20:39,659 [salt.state       ][INFO    ][658] Running state [nova_instances] at time 03:20:39.658721
2017-10-25 03:20:39,659 [salt.state       ][INFO    ][658] Executing state glusterfs.created for nova_instances
2017-10-25 03:20:39,659 [salt.loaded.int.module.cmdmod][INFO    ][658] Executing command 'gluster --version' in directory '/root'
2017-10-25 03:20:39,667 [salt.loaded.int.module.cmdmod][INFO    ][658] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-25 03:20:39,713 [salt.loaded.int.module.cmdmod][INFO    ][658] Executing command 'gluster --version' in directory '/root'
2017-10-25 03:20:39,719 [salt.loaded.int.module.cmdmod][INFO    ][658] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-25 03:20:39,768 [salt.state       ][INFO    ][658] Volume nova_instances already exists and is started.
2017-10-25 03:20:39,769 [salt.state       ][INFO    ][658] Completed state [nova_instances] at time 03:20:39.768635 duration_in_ms=109.913
2017-10-25 03:20:39,771 [salt.state       ][INFO    ][658] Running state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 03:20:39.771377
2017-10-25 03:20:39,772 [salt.state       ][INFO    ][658] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'
2017-10-25 03:20:39,772 [salt.loaded.int.module.cmdmod][INFO    ][658] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-10-25 03:20:39,818 [salt.state       ][INFO    ][658] unless execution succeeded
2017-10-25 03:20:39,818 [salt.state       ][INFO    ][658] Completed state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 03:20:39.818444 duration_in_ms=47.067
2017-10-25 03:20:39,819 [salt.state       ][INFO    ][658] Running state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'On'] at time 03:20:39.818869
2017-10-25 03:20:39,819 [salt.state       ][INFO    ][658] Executing state cmd.run for gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'On'
2017-10-25 03:20:39,819 [salt.loaded.int.module.cmdmod][INFO    ][658] Executing command 'gluster volume info 'nova_instances' | grep 'cluster.readdir-optimize: On'' in directory '/root'
2017-10-25 03:20:39,865 [salt.state       ][INFO    ][658] unless execution succeeded
2017-10-25 03:20:39,865 [salt.state       ][INFO    ][658] Completed state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'On'] at time 03:20:39.865154 duration_in_ms=46.283
2017-10-25 03:20:39,866 [salt.state       ][INFO    ][658] Running state [gluster volume set 'nova_instances' 'network.remote-dio' 'On'] at time 03:20:39.865624
2017-10-25 03:20:39,866 [salt.state       ][INFO    ][658] Executing state cmd.run for gluster volume set 'nova_instances' 'network.remote-dio' 'On'
2017-10-25 03:20:39,866 [salt.loaded.int.module.cmdmod][INFO    ][658] Executing command 'gluster volume info 'nova_instances' | grep 'network.remote-dio: On'' in directory '/root'
2017-10-25 03:20:39,913 [salt.state       ][INFO    ][658] unless execution succeeded
2017-10-25 03:20:39,913 [salt.state       ][INFO    ][658] Completed state [gluster volume set 'nova_instances' 'network.remote-dio' 'On'] at time 03:20:39.912765 duration_in_ms=47.141
2017-10-25 03:20:39,913 [salt.state       ][INFO    ][658] Running state [gluster volume set 'nova_instances' 'nfs.disable' 'On'] at time 03:20:39.913197
2017-10-25 03:20:39,913 [salt.state       ][INFO    ][658] Executing state cmd.run for gluster volume set 'nova_instances' 'nfs.disable' 'On'
2017-10-25 03:20:39,914 [salt.loaded.int.module.cmdmod][INFO    ][658] Executing command 'gluster volume info 'nova_instances' | grep 'nfs.disable: On'' in directory '/root'
2017-10-25 03:20:39,959 [salt.state       ][INFO    ][658] unless execution succeeded
2017-10-25 03:20:39,959 [salt.state       ][INFO    ][658] Completed state [gluster volume set 'nova_instances' 'nfs.disable' 'On'] at time 03:20:39.959239 duration_in_ms=46.041
2017-10-25 03:20:39,960 [salt.state       ][INFO    ][658] Running state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 03:20:39.959663
2017-10-25 03:20:39,960 [salt.state       ][INFO    ][658] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'
2017-10-25 03:20:39,960 [salt.loaded.int.module.cmdmod][INFO    ][658] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-10-25 03:20:40,006 [salt.state       ][INFO    ][658] unless execution succeeded
2017-10-25 03:20:40,006 [salt.state       ][INFO    ][658] Completed state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 03:20:40.006440 duration_in_ms=46.776
2017-10-25 03:20:40,007 [salt.state       ][INFO    ][658] Running state [nova_instances] at time 03:20:40.007380
2017-10-25 03:20:40,008 [salt.state       ][INFO    ][658] Executing state glusterfs.started for nova_instances
2017-10-25 03:20:40,008 [salt.loaded.int.module.cmdmod][INFO    ][658] Executing command 'gluster --version' in directory '/root'
2017-10-25 03:20:40,015 [salt.loaded.int.module.cmdmod][INFO    ][658] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-25 03:20:40,060 [salt.loaded.int.module.cmdmod][INFO    ][658] Executing command 'gluster --version' in directory '/root'
2017-10-25 03:20:40,067 [salt.loaded.int.module.cmdmod][INFO    ][658] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-25 03:20:40,117 [salt.state       ][INFO    ][658] Volume nova_instances is already started
2017-10-25 03:20:40,117 [salt.state       ][INFO    ][658] Completed state [nova_instances] at time 03:20:40.117179 duration_in_ms=109.798
2017-10-25 03:20:40,118 [salt.state       ][INFO    ][658] Running state [keystone-credential-keys] at time 03:20:40.117956
2017-10-25 03:20:40,118 [salt.state       ][INFO    ][658] Executing state glusterfs.created for keystone-credential-keys
2017-10-25 03:20:40,119 [salt.loaded.int.module.cmdmod][INFO    ][658] Executing command 'gluster --version' in directory '/root'
2017-10-25 03:20:40,125 [salt.loaded.int.module.cmdmod][INFO    ][658] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-25 03:20:40,169 [salt.loaded.int.module.cmdmod][INFO    ][658] Executing command 'gluster --version' in directory '/root'
2017-10-25 03:20:40,177 [salt.loaded.int.module.cmdmod][INFO    ][658] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-25 03:20:40,230 [salt.state       ][INFO    ][658] Volume keystone-credential-keys already exists and is started.
2017-10-25 03:20:40,230 [salt.state       ][INFO    ][658] Completed state [keystone-credential-keys] at time 03:20:40.230219 duration_in_ms=112.262
2017-10-25 03:20:40,233 [salt.state       ][INFO    ][658] Running state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 03:20:40.233163
2017-10-25 03:20:40,233 [salt.state       ][INFO    ][658] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'
2017-10-25 03:20:40,234 [salt.loaded.int.module.cmdmod][INFO    ][658] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-10-25 03:20:40,281 [salt.state       ][INFO    ][658] unless execution succeeded
2017-10-25 03:20:40,281 [salt.state       ][INFO    ][658] Completed state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 03:20:40.281392 duration_in_ms=48.228
2017-10-25 03:20:40,282 [salt.state       ][INFO    ][658] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 03:20:40.281803
2017-10-25 03:20:40,282 [salt.state       ][INFO    ][658] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-10-25 03:20:40,282 [salt.loaded.int.module.cmdmod][INFO    ][658] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-10-25 03:20:40,329 [salt.state       ][INFO    ][658] unless execution succeeded
2017-10-25 03:20:40,329 [salt.state       ][INFO    ][658] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 03:20:40.329013 duration_in_ms=47.21
2017-10-25 03:20:40,329 [salt.state       ][INFO    ][658] Running state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 03:20:40.329451
2017-10-25 03:20:40,330 [salt.state       ][INFO    ][658] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'
2017-10-25 03:20:40,330 [salt.loaded.int.module.cmdmod][INFO    ][658] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-10-25 03:20:40,375 [salt.state       ][INFO    ][658] unless execution succeeded
2017-10-25 03:20:40,375 [salt.state       ][INFO    ][658] Completed state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 03:20:40.375438 duration_in_ms=45.987
2017-10-25 03:20:40,376 [salt.state       ][INFO    ][658] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 03:20:40.375871
2017-10-25 03:20:40,376 [salt.state       ][INFO    ][658] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'
2017-10-25 03:20:40,376 [salt.loaded.int.module.cmdmod][INFO    ][658] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-10-25 03:20:40,423 [salt.state       ][INFO    ][658] unless execution succeeded
2017-10-25 03:20:40,423 [salt.state       ][INFO    ][658] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 03:20:40.422750 duration_in_ms=46.879
2017-10-25 03:20:40,424 [salt.state       ][INFO    ][658] Running state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 03:20:40.423134
2017-10-25 03:20:40,424 [salt.state       ][INFO    ][658] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'
2017-10-25 03:20:40,425 [salt.loaded.int.module.cmdmod][INFO    ][658] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-10-25 03:20:40,470 [salt.state       ][INFO    ][658] unless execution succeeded
2017-10-25 03:20:40,470 [salt.state       ][INFO    ][658] Completed state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 03:20:40.470287 duration_in_ms=47.153
2017-10-25 03:20:40,471 [salt.state       ][INFO    ][658] Running state [keystone-credential-keys] at time 03:20:40.471235
2017-10-25 03:20:40,471 [salt.state       ][INFO    ][658] Executing state glusterfs.started for keystone-credential-keys
2017-10-25 03:20:40,472 [salt.loaded.int.module.cmdmod][INFO    ][658] Executing command 'gluster --version' in directory '/root'
2017-10-25 03:20:40,479 [salt.loaded.int.module.cmdmod][INFO    ][658] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-25 03:20:40,525 [salt.loaded.int.module.cmdmod][INFO    ][658] Executing command 'gluster --version' in directory '/root'
2017-10-25 03:20:40,532 [salt.loaded.int.module.cmdmod][INFO    ][658] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-25 03:20:40,584 [salt.state       ][INFO    ][658] Volume keystone-credential-keys is already started
2017-10-25 03:20:40,584 [salt.state       ][INFO    ][658] Completed state [keystone-credential-keys] at time 03:20:40.583761 duration_in_ms=112.526
2017-10-25 03:20:40,587 [salt.minion      ][INFO    ][658] Returning information for job: 20171025032036706675
2017-10-25 03:20:41,584 [salt.minion      ][INFO    ][23807] User sudo_ubuntu Executing command test.ping with jid 20171025032041574433
2017-10-25 03:20:41,600 [salt.minion      ][INFO    ][1080] Starting a new job with PID 1080
2017-10-25 03:20:41,625 [salt.minion      ][INFO    ][1080] Returning information for job: 20171025032041574433
2017-10-25 03:20:42,271 [salt.minion      ][INFO    ][23807] User sudo_ubuntu Executing command cmd.run with jid 20171025032042260323
2017-10-25 03:20:42,287 [salt.minion      ][INFO    ][1085] Starting a new job with PID 1085
2017-10-25 03:20:42,291 [salt.loaded.int.module.cmdmod][INFO    ][1085] Executing command 'gluster peer status; gluster volume status' in directory '/root'
2017-10-25 03:20:42,401 [salt.minion      ][INFO    ][1085] Returning information for job: 20171025032042260323
2017-10-25 03:31:43,912 [salt.minion      ][INFO    ][23807] User sudo_ubuntu Executing command test.ping with jid 20171025033143899778
2017-10-25 03:31:43,934 [salt.minion      ][INFO    ][1220] Starting a new job with PID 1220
2017-10-25 03:31:43,971 [salt.minion      ][INFO    ][1220] Returning information for job: 20171025033143899778
2017-10-25 03:31:53,658 [salt.minion      ][INFO    ][23807] User sudo_ubuntu Executing command state.sls with jid 20171025033153646050
2017-10-25 03:31:53,675 [salt.minion      ][INFO    ][1226] Starting a new job with PID 1226
2017-10-25 03:31:54,106 [salt.state       ][INFO    ][1226] Loading fresh modules for state activity
2017-10-25 03:31:54,130 [salt.fileclient  ][INFO    ][1226] Fetching file from saltenv 'base', ** done ** 'keepalived/init.sls'
2017-10-25 03:31:54,146 [salt.fileclient  ][INFO    ][1226] Fetching file from saltenv 'base', ** done ** 'keepalived/cluster.sls'
2017-10-25 03:31:54,170 [salt.fileclient  ][INFO    ][1226] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-10-25 03:31:54,440 [salt.state       ][INFO    ][1226] Running state [lsof] at time 03:31:54.440050
2017-10-25 03:31:54,440 [salt.state       ][INFO    ][1226] Executing state pkg.installed for lsof
2017-10-25 03:31:54,441 [salt.loaded.int.module.cmdmod][INFO    ][1226] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-10-25 03:31:54,754 [salt.state       ][INFO    ][1226] Package lsof is already installed
2017-10-25 03:31:54,755 [salt.state       ][INFO    ][1226] Completed state [lsof] at time 03:31:54.754690 duration_in_ms=314.639
2017-10-25 03:31:54,755 [salt.state       ][INFO    ][1226] Running state [keepalived] at time 03:31:54.754882
2017-10-25 03:31:54,755 [salt.state       ][INFO    ][1226] Executing state pkg.installed for keepalived
2017-10-25 03:31:54,758 [salt.state       ][INFO    ][1226] Package keepalived is already installed
2017-10-25 03:31:54,758 [salt.state       ][INFO    ][1226] Completed state [keepalived] at time 03:31:54.757747 duration_in_ms=2.864
2017-10-25 03:31:54,759 [salt.state       ][INFO    ][1226] Running state [/etc/keepalived/keepalived.conf] at time 03:31:54.759153
2017-10-25 03:31:54,759 [salt.state       ][INFO    ][1226] Executing state file.managed for /etc/keepalived/keepalived.conf
2017-10-25 03:31:54,787 [salt.fileclient  ][INFO    ][1226] Fetching file from saltenv 'base', ** done ** 'keepalived/files/keepalived.conf'
2017-10-25 03:31:54,816 [salt.fileclient  ][INFO    ][1226] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-10-25 03:31:54,820 [salt.state       ][INFO    ][1226] File /etc/keepalived/keepalived.conf is in the correct state
2017-10-25 03:31:54,821 [salt.state       ][INFO    ][1226] Completed state [/etc/keepalived/keepalived.conf] at time 03:31:54.820543 duration_in_ms=61.39
2017-10-25 03:31:54,821 [salt.state       ][INFO    ][1226] Running state [keepalived] at time 03:31:54.821035
2017-10-25 03:31:54,821 [salt.state       ][INFO    ][1226] Executing state service.running for keepalived
2017-10-25 03:31:54,822 [salt.loaded.int.module.cmdmod][INFO    ][1226] Executing command ['systemctl', 'status', 'keepalived.service', '-n', '0'] in directory '/root'
2017-10-25 03:31:54,837 [salt.loaded.int.module.cmdmod][INFO    ][1226] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2017-10-25 03:31:54,844 [salt.loaded.int.module.cmdmod][INFO    ][1226] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-10-25 03:31:54,852 [salt.state       ][INFO    ][1226] The service keepalived is already running
2017-10-25 03:31:54,852 [salt.state       ][INFO    ][1226] Completed state [keepalived] at time 03:31:54.851695 duration_in_ms=30.659
2017-10-25 03:31:54,852 [salt.minion      ][INFO    ][1226] Returning information for job: 20171025033153646050
2017-10-25 03:32:17,896 [salt.minion      ][INFO    ][23807] User sudo_ubuntu Executing command pillar.get with jid 20171025033217883738
2017-10-25 03:32:17,921 [salt.minion      ][INFO    ][1254] Starting a new job with PID 1254
2017-10-25 03:32:17,925 [salt.minion      ][INFO    ][1254] Returning information for job: 20171025033217883738
2017-10-25 03:32:55,975 [salt.minion      ][INFO    ][23807] User sudo_ubuntu Executing command state.sls with jid 20171025033255962940
2017-10-25 03:32:55,992 [salt.minion      ][INFO    ][1262] Starting a new job with PID 1262
2017-10-25 03:32:56,494 [salt.state       ][INFO    ][1262] Loading fresh modules for state activity
2017-10-25 03:32:56,517 [salt.fileclient  ][INFO    ][1262] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-10-25 03:32:56,539 [salt.fileclient  ][INFO    ][1262] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-10-25 03:32:56,804 [salt.state       ][INFO    ][1262] Running state [attr] at time 03:32:56.803898
2017-10-25 03:32:56,804 [salt.state       ][INFO    ][1262] Executing state pkg.installed for attr
2017-10-25 03:32:56,805 [salt.loaded.int.module.cmdmod][INFO    ][1262] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-10-25 03:32:57,088 [salt.state       ][INFO    ][1262] Package attr is already installed
2017-10-25 03:32:57,088 [salt.state       ][INFO    ][1262] Completed state [attr] at time 03:32:57.087756 duration_in_ms=283.859
2017-10-25 03:32:57,088 [salt.state       ][INFO    ][1262] Running state [glusterfs-server] at time 03:32:57.087962
2017-10-25 03:32:57,088 [salt.state       ][INFO    ][1262] Executing state pkg.installed for glusterfs-server
2017-10-25 03:32:57,091 [salt.state       ][INFO    ][1262] Package glusterfs-server is already installed
2017-10-25 03:32:57,091 [salt.state       ][INFO    ][1262] Completed state [glusterfs-server] at time 03:32:57.090787 duration_in_ms=2.826
2017-10-25 03:32:57,091 [salt.state       ][INFO    ][1262] Running state [bc] at time 03:32:57.090925
2017-10-25 03:32:57,091 [salt.state       ][INFO    ][1262] Executing state pkg.installed for bc
2017-10-25 03:32:57,094 [salt.state       ][INFO    ][1262] Package bc is already installed
2017-10-25 03:32:57,094 [salt.state       ][INFO    ][1262] Completed state [bc] at time 03:32:57.093770 duration_in_ms=2.844
2017-10-25 03:32:57,094 [salt.state       ][INFO    ][1262] Running state [glusterfs-server] at time 03:32:57.094389
2017-10-25 03:32:57,095 [salt.state       ][INFO    ][1262] Executing state service.running for glusterfs-server
2017-10-25 03:32:57,095 [salt.loaded.int.module.cmdmod][INFO    ][1262] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-10-25 03:32:57,112 [salt.loaded.int.module.cmdmod][INFO    ][1262] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-10-25 03:32:57,120 [salt.loaded.int.module.cmdmod][INFO    ][1262] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-10-25 03:32:57,129 [salt.state       ][INFO    ][1262] The service glusterfs-server is already running
2017-10-25 03:32:57,129 [salt.state       ][INFO    ][1262] Completed state [glusterfs-server] at time 03:32:57.129400 duration_in_ms=35.012
2017-10-25 03:32:57,131 [salt.state       ][INFO    ][1262] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 03:32:57.130705
2017-10-25 03:32:57,131 [salt.state       ][INFO    ][1262] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-10-25 03:32:57,138 [salt.state       ][INFO    ][1262] File /etc/systemd/system/glusterfs-server.service.d/override.conf is in the correct state
2017-10-25 03:32:57,138 [salt.state       ][INFO    ][1262] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 03:32:57.137875 duration_in_ms=7.169
2017-10-25 03:32:57,138 [salt.state       ][INFO    ][1262] Running state [/srv/glusterfs/glance] at time 03:32:57.138027
2017-10-25 03:32:57,138 [salt.state       ][INFO    ][1262] Executing state file.directory for /srv/glusterfs/glance
2017-10-25 03:32:57,139 [salt.state       ][INFO    ][1262] Directory /srv/glusterfs/glance is in the correct state
2017-10-25 03:32:57,139 [salt.state       ][INFO    ][1262] Completed state [/srv/glusterfs/glance] at time 03:32:57.138657 duration_in_ms=0.63
2017-10-25 03:32:57,139 [salt.state       ][INFO    ][1262] Running state [/srv/glusterfs/keystone-keys] at time 03:32:57.138799
2017-10-25 03:32:57,139 [salt.state       ][INFO    ][1262] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-10-25 03:32:57,139 [salt.state       ][INFO    ][1262] Directory /srv/glusterfs/keystone-keys is in the correct state
2017-10-25 03:32:57,139 [salt.state       ][INFO    ][1262] Completed state [/srv/glusterfs/keystone-keys] at time 03:32:57.139413 duration_in_ms=0.613
2017-10-25 03:32:57,140 [salt.state       ][INFO    ][1262] Running state [/srv/glusterfs/nova_instances] at time 03:32:57.139548
2017-10-25 03:32:57,140 [salt.state       ][INFO    ][1262] Executing state file.directory for /srv/glusterfs/nova_instances
2017-10-25 03:32:57,140 [salt.state       ][INFO    ][1262] Directory /srv/glusterfs/nova_instances is in the correct state
2017-10-25 03:32:57,140 [salt.state       ][INFO    ][1262] Completed state [/srv/glusterfs/nova_instances] at time 03:32:57.140111 duration_in_ms=0.564
2017-10-25 03:32:57,140 [salt.state       ][INFO    ][1262] Running state [/srv/glusterfs/keystone-credential-keys] at time 03:32:57.140249
2017-10-25 03:32:57,140 [salt.state       ][INFO    ][1262] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-10-25 03:32:57,141 [salt.state       ][INFO    ][1262] Directory /srv/glusterfs/keystone-credential-keys is in the correct state
2017-10-25 03:32:57,141 [salt.state       ][INFO    ][1262] Completed state [/srv/glusterfs/keystone-credential-keys] at time 03:32:57.140814 duration_in_ms=0.565
2017-10-25 03:32:57,141 [salt.minion      ][INFO    ][1262] Returning information for job: 20171025033255962940
2017-10-25 03:32:58,302 [salt.minion      ][INFO    ][23807] User sudo_ubuntu Executing command test.ping with jid 20171025033258289139
2017-10-25 03:32:58,319 [salt.minion      ][INFO    ][1285] Starting a new job with PID 1285
2017-10-25 03:32:58,346 [salt.minion      ][INFO    ][1285] Returning information for job: 20171025033258289139
2017-10-25 03:33:07,064 [salt.minion      ][INFO    ][23807] User sudo_ubuntu Executing command state.sls with jid 20171025033307050956
2017-10-25 03:33:07,079 [salt.minion      ][INFO    ][1290] Starting a new job with PID 1290
2017-10-25 03:33:07,490 [salt.state       ][INFO    ][1290] Loading fresh modules for state activity
2017-10-25 03:33:07,512 [salt.fileclient  ][INFO    ][1290] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/setup.sls'
2017-10-25 03:33:07,544 [salt.fileclient  ][INFO    ][1290] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-10-25 03:33:07,607 [salt.fileclient  ][INFO    ][1290] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-10-25 03:33:07,626 [salt.fileclient  ][INFO    ][1290] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-10-25 03:33:07,903 [salt.state       ][INFO    ][1290] Running state [attr] at time 03:33:07.902867
2017-10-25 03:33:07,903 [salt.state       ][INFO    ][1290] Executing state pkg.installed for attr
2017-10-25 03:33:07,904 [salt.loaded.int.module.cmdmod][INFO    ][1290] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-10-25 03:33:08,200 [salt.state       ][INFO    ][1290] Package attr is already installed
2017-10-25 03:33:08,200 [salt.state       ][INFO    ][1290] Completed state [attr] at time 03:33:08.200000 duration_in_ms=297.133
2017-10-25 03:33:08,200 [salt.state       ][INFO    ][1290] Running state [glusterfs-server] at time 03:33:08.200195
2017-10-25 03:33:08,200 [salt.state       ][INFO    ][1290] Executing state pkg.installed for glusterfs-server
2017-10-25 03:33:08,203 [salt.state       ][INFO    ][1290] Package glusterfs-server is already installed
2017-10-25 03:33:08,203 [salt.state       ][INFO    ][1290] Completed state [glusterfs-server] at time 03:33:08.203131 duration_in_ms=2.937
2017-10-25 03:33:08,203 [salt.state       ][INFO    ][1290] Running state [bc] at time 03:33:08.203277
2017-10-25 03:33:08,203 [salt.state       ][INFO    ][1290] Executing state pkg.installed for bc
2017-10-25 03:33:08,206 [salt.state       ][INFO    ][1290] Package bc is already installed
2017-10-25 03:33:08,206 [salt.state       ][INFO    ][1290] Completed state [bc] at time 03:33:08.206045 duration_in_ms=2.768
2017-10-25 03:33:08,207 [salt.state       ][INFO    ][1290] Running state [glusterfs-server] at time 03:33:08.206840
2017-10-25 03:33:08,207 [salt.state       ][INFO    ][1290] Executing state service.running for glusterfs-server
2017-10-25 03:33:08,207 [salt.loaded.int.module.cmdmod][INFO    ][1290] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-10-25 03:33:08,223 [salt.loaded.int.module.cmdmod][INFO    ][1290] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-10-25 03:33:08,232 [salt.loaded.int.module.cmdmod][INFO    ][1290] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-10-25 03:33:08,242 [salt.state       ][INFO    ][1290] The service glusterfs-server is already running
2017-10-25 03:33:08,242 [salt.state       ][INFO    ][1290] Completed state [glusterfs-server] at time 03:33:08.241794 duration_in_ms=34.954
2017-10-25 03:33:08,243 [salt.state       ][INFO    ][1290] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 03:33:08.243358
2017-10-25 03:33:08,244 [salt.state       ][INFO    ][1290] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-10-25 03:33:08,255 [salt.state       ][INFO    ][1290] File /etc/systemd/system/glusterfs-server.service.d/override.conf is in the correct state
2017-10-25 03:33:08,256 [salt.state       ][INFO    ][1290] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 03:33:08.255508 duration_in_ms=12.151
2017-10-25 03:33:08,256 [salt.state       ][INFO    ][1290] Running state [/srv/glusterfs/glance] at time 03:33:08.255683
2017-10-25 03:33:08,256 [salt.state       ][INFO    ][1290] Executing state file.directory for /srv/glusterfs/glance
2017-10-25 03:33:08,256 [salt.state       ][INFO    ][1290] Directory /srv/glusterfs/glance is in the correct state
2017-10-25 03:33:08,256 [salt.state       ][INFO    ][1290] Completed state [/srv/glusterfs/glance] at time 03:33:08.256380 duration_in_ms=0.697
2017-10-25 03:33:08,257 [salt.state       ][INFO    ][1290] Running state [/srv/glusterfs/keystone-keys] at time 03:33:08.256545
2017-10-25 03:33:08,257 [salt.state       ][INFO    ][1290] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-10-25 03:33:08,257 [salt.state       ][INFO    ][1290] Directory /srv/glusterfs/keystone-keys is in the correct state
2017-10-25 03:33:08,257 [salt.state       ][INFO    ][1290] Completed state [/srv/glusterfs/keystone-keys] at time 03:33:08.257221 duration_in_ms=0.676
2017-10-25 03:33:08,257 [salt.state       ][INFO    ][1290] Running state [/srv/glusterfs/nova_instances] at time 03:33:08.257381
2017-10-25 03:33:08,258 [salt.state       ][INFO    ][1290] Executing state file.directory for /srv/glusterfs/nova_instances
2017-10-25 03:33:08,258 [salt.state       ][INFO    ][1290] Directory /srv/glusterfs/nova_instances is in the correct state
2017-10-25 03:33:08,258 [salt.state       ][INFO    ][1290] Completed state [/srv/glusterfs/nova_instances] at time 03:33:08.258050 duration_in_ms=0.669
2017-10-25 03:33:08,258 [salt.state       ][INFO    ][1290] Running state [/srv/glusterfs/keystone-credential-keys] at time 03:33:08.258220
2017-10-25 03:33:08,258 [salt.state       ][INFO    ][1290] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-10-25 03:33:08,259 [salt.state       ][INFO    ][1290] Directory /srv/glusterfs/keystone-credential-keys is in the correct state
2017-10-25 03:33:08,259 [salt.state       ][INFO    ][1290] Completed state [/srv/glusterfs/keystone-credential-keys] at time 03:33:08.258893 duration_in_ms=0.673
2017-10-25 03:33:08,300 [salt.loaded.int.module.cmdmod][INFO    ][1290] Executing command ['git', '--version'] in directory '/root'
2017-10-25 03:33:08,374 [salt.state       ][INFO    ][1290] Running state [sleep 5] at time 03:33:08.374419
2017-10-25 03:33:08,375 [salt.state       ][INFO    ][1290] Executing state cmd.wait for sleep 5
2017-10-25 03:33:08,375 [salt.state       ][INFO    ][1290] No changes made for sleep 5
2017-10-25 03:33:08,375 [salt.state       ][INFO    ][1290] Completed state [sleep 5] at time 03:33:08.374962 duration_in_ms=0.544
2017-10-25 03:33:08,375 [salt.state       ][INFO    ][1290] Running state [10.167.4.141] at time 03:33:08.375335
2017-10-25 03:33:08,375 [salt.state       ][INFO    ][1290] Executing state glusterfs.peered for 10.167.4.141
2017-10-25 03:33:08,376 [salt.loaded.int.module.cmdmod][INFO    ][1290] Executing command 'gluster --version' in directory '/root'
2017-10-25 03:33:08,384 [salt.loaded.int.module.cmdmod][INFO    ][1290] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-25 03:33:08,430 [salt.loaded.int.module.cmdmod][INFO    ][1290] Executing command 'gluster --version' in directory '/root'
2017-10-25 03:33:08,439 [salt.loaded.int.module.cmdmod][INFO    ][1290] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-25 03:33:08,486 [salt.loaded.int.module.cmdmod][INFO    ][1290] Executing command 'gluster --version' in directory '/root'
2017-10-25 03:33:08,494 [salt.loaded.int.module.cmdmod][INFO    ][1290] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-25 03:33:08,542 [salt.loaded.int.module.cmdmod][INFO    ][1290] Executing command 'gluster --version' in directory '/root'
2017-10-25 03:33:08,551 [salt.loaded.int.module.cmdmod][INFO    ][1290] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-25 03:33:08,596 [salt.state       ][INFO    ][1290] Peering with localhost is not needed
2017-10-25 03:33:08,596 [salt.state       ][INFO    ][1290] Completed state [10.167.4.141] at time 03:33:08.596340 duration_in_ms=221.004
2017-10-25 03:33:08,598 [salt.state       ][INFO    ][1290] Running state [10.167.4.142] at time 03:33:08.598451
2017-10-25 03:33:08,599 [salt.state       ][INFO    ][1290] Executing state glusterfs.peered for 10.167.4.142
2017-10-25 03:33:08,599 [salt.loaded.int.module.cmdmod][INFO    ][1290] Executing command 'gluster --version' in directory '/root'
2017-10-25 03:33:08,606 [salt.loaded.int.module.cmdmod][INFO    ][1290] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-25 03:33:08,652 [salt.state       ][INFO    ][1290] Host 10.167.4.142 already peered
2017-10-25 03:33:08,652 [salt.state       ][INFO    ][1290] Completed state [10.167.4.142] at time 03:33:08.652401 duration_in_ms=53.949
2017-10-25 03:33:08,655 [salt.state       ][INFO    ][1290] Running state [10.167.4.143] at time 03:33:08.654637
2017-10-25 03:33:08,655 [salt.state       ][INFO    ][1290] Executing state glusterfs.peered for 10.167.4.143
2017-10-25 03:33:08,655 [salt.loaded.int.module.cmdmod][INFO    ][1290] Executing command 'gluster --version' in directory '/root'
2017-10-25 03:33:08,664 [salt.loaded.int.module.cmdmod][INFO    ][1290] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-25 03:33:08,711 [salt.state       ][INFO    ][1290] Host 10.167.4.143 already peered
2017-10-25 03:33:08,711 [salt.state       ][INFO    ][1290] Completed state [10.167.4.143] at time 03:33:08.711255 duration_in_ms=56.618
2017-10-25 03:33:08,712 [salt.state       ][INFO    ][1290] Running state [glance] at time 03:33:08.712076
2017-10-25 03:33:08,712 [salt.state       ][INFO    ][1290] Executing state glusterfs.created for glance
2017-10-25 03:33:08,713 [salt.loaded.int.module.cmdmod][INFO    ][1290] Executing command 'gluster --version' in directory '/root'
2017-10-25 03:33:08,722 [salt.loaded.int.module.cmdmod][INFO    ][1290] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-25 03:33:08,768 [salt.loaded.int.module.cmdmod][INFO    ][1290] Executing command 'gluster --version' in directory '/root'
2017-10-25 03:33:08,778 [salt.loaded.int.module.cmdmod][INFO    ][1290] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-25 03:33:08,837 [salt.state       ][INFO    ][1290] Volume glance already exists and is started.
2017-10-25 03:33:08,837 [salt.state       ][INFO    ][1290] Completed state [glance] at time 03:33:08.837147 duration_in_ms=125.071
2017-10-25 03:33:08,840 [salt.state       ][INFO    ][1290] Running state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 03:33:08.839891
2017-10-25 03:33:08,840 [salt.state       ][INFO    ][1290] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'
2017-10-25 03:33:08,841 [salt.loaded.int.module.cmdmod][INFO    ][1290] Executing command 'gluster volume info 'glance' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-10-25 03:33:08,894 [salt.state       ][INFO    ][1290] unless execution succeeded
2017-10-25 03:33:08,894 [salt.state       ][INFO    ][1290] Completed state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 03:33:08.894051 duration_in_ms=54.159
2017-10-25 03:33:08,895 [salt.state       ][INFO    ][1290] Running state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 03:33:08.894515
2017-10-25 03:33:08,895 [salt.state       ][INFO    ][1290] Executing state cmd.run for gluster volume set 'glance' 'network.remote-dio' 'True'
2017-10-25 03:33:08,895 [salt.loaded.int.module.cmdmod][INFO    ][1290] Executing command 'gluster volume info 'glance' | grep 'network.remote-dio: True'' in directory '/root'
2017-10-25 03:33:08,944 [salt.state       ][INFO    ][1290] unless execution succeeded
2017-10-25 03:33:08,944 [salt.state       ][INFO    ][1290] Completed state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 03:33:08.944250 duration_in_ms=49.735
2017-10-25 03:33:08,945 [salt.state       ][INFO    ][1290] Running state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 03:33:08.944635
2017-10-25 03:33:08,945 [salt.state       ][INFO    ][1290] Executing state cmd.run for gluster volume set 'glance' 'nfs.disable' 'True'
2017-10-25 03:33:08,945 [salt.loaded.int.module.cmdmod][INFO    ][1290] Executing command 'gluster volume info 'glance' | grep 'nfs.disable: True'' in directory '/root'
2017-10-25 03:33:08,992 [salt.state       ][INFO    ][1290] unless execution succeeded
2017-10-25 03:33:08,992 [salt.state       ][INFO    ][1290] Completed state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 03:33:08.991727 duration_in_ms=47.092
2017-10-25 03:33:08,992 [salt.state       ][INFO    ][1290] Running state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 03:33:08.992154
2017-10-25 03:33:08,992 [salt.state       ][INFO    ][1290] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'
2017-10-25 03:33:08,993 [salt.loaded.int.module.cmdmod][INFO    ][1290] Executing command 'gluster volume info 'glance' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-10-25 03:33:09,039 [salt.state       ][INFO    ][1290] unless execution succeeded
2017-10-25 03:33:09,039 [salt.state       ][INFO    ][1290] Completed state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 03:33:09.039113 duration_in_ms=46.958
2017-10-25 03:33:09,040 [salt.state       ][INFO    ][1290] Running state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 03:33:09.039560
2017-10-25 03:33:09,040 [salt.state       ][INFO    ][1290] Executing state cmd.run for gluster volume set 'glance' 'cluster.readdir-optimize' 'True'
2017-10-25 03:33:09,040 [salt.loaded.int.module.cmdmod][INFO    ][1290] Executing command 'gluster volume info 'glance' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-10-25 03:33:09,087 [salt.state       ][INFO    ][1290] unless execution succeeded
2017-10-25 03:33:09,087 [salt.state       ][INFO    ][1290] Completed state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 03:33:09.086987 duration_in_ms=47.427
2017-10-25 03:33:09,088 [salt.state       ][INFO    ][1290] Running state [glance] at time 03:33:09.087890
2017-10-25 03:33:09,088 [salt.state       ][INFO    ][1290] Executing state glusterfs.started for glance
2017-10-25 03:33:09,088 [salt.loaded.int.module.cmdmod][INFO    ][1290] Executing command 'gluster --version' in directory '/root'
2017-10-25 03:33:09,095 [salt.loaded.int.module.cmdmod][INFO    ][1290] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-25 03:33:09,146 [salt.loaded.int.module.cmdmod][INFO    ][1290] Executing command 'gluster --version' in directory '/root'
2017-10-25 03:33:09,153 [salt.loaded.int.module.cmdmod][INFO    ][1290] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-25 03:33:09,204 [salt.state       ][INFO    ][1290] Volume glance is already started
2017-10-25 03:33:09,204 [salt.state       ][INFO    ][1290] Completed state [glance] at time 03:33:09.204181 duration_in_ms=116.291
2017-10-25 03:33:09,205 [salt.state       ][INFO    ][1290] Running state [keystone-keys] at time 03:33:09.205035
2017-10-25 03:33:09,205 [salt.state       ][INFO    ][1290] Executing state glusterfs.created for keystone-keys
2017-10-25 03:33:09,206 [salt.loaded.int.module.cmdmod][INFO    ][1290] Executing command 'gluster --version' in directory '/root'
2017-10-25 03:33:09,214 [salt.loaded.int.module.cmdmod][INFO    ][1290] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-25 03:33:09,262 [salt.loaded.int.module.cmdmod][INFO    ][1290] Executing command 'gluster --version' in directory '/root'
2017-10-25 03:33:09,269 [salt.loaded.int.module.cmdmod][INFO    ][1290] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-25 03:33:09,319 [salt.state       ][INFO    ][1290] Volume keystone-keys already exists and is started.
2017-10-25 03:33:09,320 [salt.state       ][INFO    ][1290] Completed state [keystone-keys] at time 03:33:09.319663 duration_in_ms=114.626
2017-10-25 03:33:09,322 [salt.state       ][INFO    ][1290] Running state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 03:33:09.322260
2017-10-25 03:33:09,322 [salt.state       ][INFO    ][1290] Executing state cmd.run for gluster volume set 'keystone-keys' 'network.remote-dio' 'True'
2017-10-25 03:33:09,323 [salt.loaded.int.module.cmdmod][INFO    ][1290] Executing command 'gluster volume info 'keystone-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-10-25 03:33:09,371 [salt.state       ][INFO    ][1290] unless execution succeeded
2017-10-25 03:33:09,371 [salt.state       ][INFO    ][1290] Completed state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 03:33:09.371084 duration_in_ms=48.823
2017-10-25 03:33:09,372 [salt.state       ][INFO    ][1290] Running state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 03:33:09.371476
2017-10-25 03:33:09,372 [salt.state       ][INFO    ][1290] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-10-25 03:33:09,372 [salt.loaded.int.module.cmdmod][INFO    ][1290] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-10-25 03:33:09,419 [salt.state       ][INFO    ][1290] unless execution succeeded
2017-10-25 03:33:09,420 [salt.state       ][INFO    ][1290] Completed state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 03:33:09.419662 duration_in_ms=48.185
2017-10-25 03:33:09,420 [salt.state       ][INFO    ][1290] Running state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 03:33:09.420088
2017-10-25 03:33:09,420 [salt.state       ][INFO    ][1290] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'
2017-10-25 03:33:09,421 [salt.loaded.int.module.cmdmod][INFO    ][1290] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-10-25 03:33:09,470 [salt.state       ][INFO    ][1290] unless execution succeeded
2017-10-25 03:33:09,471 [salt.state       ][INFO    ][1290] Completed state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 03:33:09.470471 duration_in_ms=50.383
2017-10-25 03:33:09,471 [salt.state       ][INFO    ][1290] Running state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 03:33:09.470869
2017-10-25 03:33:09,471 [salt.state       ][INFO    ][1290] Executing state cmd.run for gluster volume set 'keystone-keys' 'nfs.disable' 'True'
2017-10-25 03:33:09,471 [salt.loaded.int.module.cmdmod][INFO    ][1290] Executing command 'gluster volume info 'keystone-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-10-25 03:33:09,519 [salt.state       ][INFO    ][1290] unless execution succeeded
2017-10-25 03:33:09,519 [salt.state       ][INFO    ][1290] Completed state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 03:33:09.518773 duration_in_ms=47.903
2017-10-25 03:33:09,519 [salt.state       ][INFO    ][1290] Running state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 03:33:09.519228
2017-10-25 03:33:09,519 [salt.state       ][INFO    ][1290] Executing state cmd.run for gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'
2017-10-25 03:33:09,520 [salt.loaded.int.module.cmdmod][INFO    ][1290] Executing command 'gluster volume info 'keystone-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-10-25 03:33:09,569 [salt.state       ][INFO    ][1290] unless execution succeeded
2017-10-25 03:33:09,569 [salt.state       ][INFO    ][1290] Completed state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 03:33:09.568868 duration_in_ms=49.64
2017-10-25 03:33:09,570 [salt.state       ][INFO    ][1290] Running state [keystone-keys] at time 03:33:09.569719
2017-10-25 03:33:09,570 [salt.state       ][INFO    ][1290] Executing state glusterfs.started for keystone-keys
2017-10-25 03:33:09,570 [salt.loaded.int.module.cmdmod][INFO    ][1290] Executing command 'gluster --version' in directory '/root'
2017-10-25 03:33:09,577 [salt.loaded.int.module.cmdmod][INFO    ][1290] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-25 03:33:09,624 [salt.loaded.int.module.cmdmod][INFO    ][1290] Executing command 'gluster --version' in directory '/root'
2017-10-25 03:33:09,632 [salt.loaded.int.module.cmdmod][INFO    ][1290] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-25 03:33:09,682 [salt.state       ][INFO    ][1290] Volume keystone-keys is already started
2017-10-25 03:33:09,682 [salt.state       ][INFO    ][1290] Completed state [keystone-keys] at time 03:33:09.682052 duration_in_ms=112.332
2017-10-25 03:33:09,683 [salt.state       ][INFO    ][1290] Running state [nova_instances] at time 03:33:09.683014
2017-10-25 03:33:09,683 [salt.state       ][INFO    ][1290] Executing state glusterfs.created for nova_instances
2017-10-25 03:33:09,684 [salt.loaded.int.module.cmdmod][INFO    ][1290] Executing command 'gluster --version' in directory '/root'
2017-10-25 03:33:09,692 [salt.loaded.int.module.cmdmod][INFO    ][1290] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-25 03:33:09,737 [salt.loaded.int.module.cmdmod][INFO    ][1290] Executing command 'gluster --version' in directory '/root'
2017-10-25 03:33:09,746 [salt.loaded.int.module.cmdmod][INFO    ][1290] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-25 03:33:09,794 [salt.state       ][INFO    ][1290] Volume nova_instances already exists and is started.
2017-10-25 03:33:09,794 [salt.state       ][INFO    ][1290] Completed state [nova_instances] at time 03:33:09.794366 duration_in_ms=111.352
2017-10-25 03:33:09,797 [salt.state       ][INFO    ][1290] Running state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 03:33:09.797189
2017-10-25 03:33:09,797 [salt.state       ][INFO    ][1290] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'
2017-10-25 03:33:09,798 [salt.loaded.int.module.cmdmod][INFO    ][1290] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-10-25 03:33:09,845 [salt.state       ][INFO    ][1290] unless execution succeeded
2017-10-25 03:33:09,846 [salt.state       ][INFO    ][1290] Completed state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 03:33:09.845616 duration_in_ms=48.427
2017-10-25 03:33:09,846 [salt.state       ][INFO    ][1290] Running state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'On'] at time 03:33:09.846013
2017-10-25 03:33:09,846 [salt.state       ][INFO    ][1290] Executing state cmd.run for gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'On'
2017-10-25 03:33:09,847 [salt.loaded.int.module.cmdmod][INFO    ][1290] Executing command 'gluster volume info 'nova_instances' | grep 'cluster.readdir-optimize: On'' in directory '/root'
2017-10-25 03:33:09,893 [salt.state       ][INFO    ][1290] unless execution succeeded
2017-10-25 03:33:09,893 [salt.state       ][INFO    ][1290] Completed state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'On'] at time 03:33:09.892761 duration_in_ms=46.748
2017-10-25 03:33:09,893 [salt.state       ][INFO    ][1290] Running state [gluster volume set 'nova_instances' 'network.remote-dio' 'On'] at time 03:33:09.893177
2017-10-25 03:33:09,893 [salt.state       ][INFO    ][1290] Executing state cmd.run for gluster volume set 'nova_instances' 'network.remote-dio' 'On'
2017-10-25 03:33:09,894 [salt.loaded.int.module.cmdmod][INFO    ][1290] Executing command 'gluster volume info 'nova_instances' | grep 'network.remote-dio: On'' in directory '/root'
2017-10-25 03:33:09,941 [salt.state       ][INFO    ][1290] unless execution succeeded
2017-10-25 03:33:09,942 [salt.state       ][INFO    ][1290] Completed state [gluster volume set 'nova_instances' 'network.remote-dio' 'On'] at time 03:33:09.941599 duration_in_ms=48.421
2017-10-25 03:33:09,942 [salt.state       ][INFO    ][1290] Running state [gluster volume set 'nova_instances' 'nfs.disable' 'On'] at time 03:33:09.942050
2017-10-25 03:33:09,942 [salt.state       ][INFO    ][1290] Executing state cmd.run for gluster volume set 'nova_instances' 'nfs.disable' 'On'
2017-10-25 03:33:09,943 [salt.loaded.int.module.cmdmod][INFO    ][1290] Executing command 'gluster volume info 'nova_instances' | grep 'nfs.disable: On'' in directory '/root'
2017-10-25 03:33:09,991 [salt.state       ][INFO    ][1290] unless execution succeeded
2017-10-25 03:33:09,991 [salt.state       ][INFO    ][1290] Completed state [gluster volume set 'nova_instances' 'nfs.disable' 'On'] at time 03:33:09.990885 duration_in_ms=48.834
2017-10-25 03:33:09,991 [salt.state       ][INFO    ][1290] Running state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 03:33:09.991329
2017-10-25 03:33:09,992 [salt.state       ][INFO    ][1290] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'
2017-10-25 03:33:09,992 [salt.loaded.int.module.cmdmod][INFO    ][1290] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-10-25 03:33:10,037 [salt.state       ][INFO    ][1290] unless execution succeeded
2017-10-25 03:33:10,038 [salt.state       ][INFO    ][1290] Completed state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 03:33:10.037527 duration_in_ms=46.198
2017-10-25 03:33:10,038 [salt.state       ][INFO    ][1290] Running state [nova_instances] at time 03:33:10.038425
2017-10-25 03:33:10,039 [salt.state       ][INFO    ][1290] Executing state glusterfs.started for nova_instances
2017-10-25 03:33:10,039 [salt.loaded.int.module.cmdmod][INFO    ][1290] Executing command 'gluster --version' in directory '/root'
2017-10-25 03:33:10,046 [salt.loaded.int.module.cmdmod][INFO    ][1290] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-25 03:33:10,090 [salt.loaded.int.module.cmdmod][INFO    ][1290] Executing command 'gluster --version' in directory '/root'
2017-10-25 03:33:10,097 [salt.loaded.int.module.cmdmod][INFO    ][1290] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-25 03:33:10,146 [salt.state       ][INFO    ][1290] Volume nova_instances is already started
2017-10-25 03:33:10,146 [salt.state       ][INFO    ][1290] Completed state [nova_instances] at time 03:33:10.146195 duration_in_ms=107.77
2017-10-25 03:33:10,147 [salt.state       ][INFO    ][1290] Running state [keystone-credential-keys] at time 03:33:10.147066
2017-10-25 03:33:10,151 [salt.state       ][INFO    ][1290] Executing state glusterfs.created for keystone-credential-keys
2017-10-25 03:33:10,153 [salt.loaded.int.module.cmdmod][INFO    ][1290] Executing command 'gluster --version' in directory '/root'
2017-10-25 03:33:10,161 [salt.loaded.int.module.cmdmod][INFO    ][1290] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-25 03:33:10,208 [salt.loaded.int.module.cmdmod][INFO    ][1290] Executing command 'gluster --version' in directory '/root'
2017-10-25 03:33:10,216 [salt.loaded.int.module.cmdmod][INFO    ][1290] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-25 03:33:10,266 [salt.state       ][INFO    ][1290] Volume keystone-credential-keys already exists and is started.
2017-10-25 03:33:10,266 [salt.state       ][INFO    ][1290] Completed state [keystone-credential-keys] at time 03:33:10.265904 duration_in_ms=118.838
2017-10-25 03:33:10,270 [salt.state       ][INFO    ][1290] Running state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 03:33:10.269989
2017-10-25 03:33:10,270 [salt.state       ][INFO    ][1290] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'
2017-10-25 03:33:10,271 [salt.loaded.int.module.cmdmod][INFO    ][1290] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-10-25 03:33:10,317 [salt.state       ][INFO    ][1290] unless execution succeeded
2017-10-25 03:33:10,318 [salt.state       ][INFO    ][1290] Completed state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 03:33:10.317507 duration_in_ms=47.518
2017-10-25 03:33:10,318 [salt.state       ][INFO    ][1290] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 03:33:10.317959
2017-10-25 03:33:10,318 [salt.state       ][INFO    ][1290] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-10-25 03:33:10,319 [salt.loaded.int.module.cmdmod][INFO    ][1290] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-10-25 03:33:10,364 [salt.state       ][INFO    ][1290] unless execution succeeded
2017-10-25 03:33:10,364 [salt.state       ][INFO    ][1290] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 03:33:10.363895 duration_in_ms=45.935
2017-10-25 03:33:10,364 [salt.state       ][INFO    ][1290] Running state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 03:33:10.364368
2017-10-25 03:33:10,365 [salt.state       ][INFO    ][1290] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'
2017-10-25 03:33:10,365 [salt.loaded.int.module.cmdmod][INFO    ][1290] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-10-25 03:33:10,414 [salt.state       ][INFO    ][1290] unless execution succeeded
2017-10-25 03:33:10,414 [salt.state       ][INFO    ][1290] Completed state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 03:33:10.414157 duration_in_ms=49.788
2017-10-25 03:33:10,415 [salt.state       ][INFO    ][1290] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 03:33:10.414567
2017-10-25 03:33:10,415 [salt.state       ][INFO    ][1290] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'
2017-10-25 03:33:10,415 [salt.loaded.int.module.cmdmod][INFO    ][1290] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-10-25 03:33:10,461 [salt.state       ][INFO    ][1290] unless execution succeeded
2017-10-25 03:33:10,461 [salt.state       ][INFO    ][1290] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 03:33:10.460936 duration_in_ms=46.369
2017-10-25 03:33:10,461 [salt.state       ][INFO    ][1290] Running state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 03:33:10.461351
2017-10-25 03:33:10,462 [salt.state       ][INFO    ][1290] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'
2017-10-25 03:33:10,462 [salt.loaded.int.module.cmdmod][INFO    ][1290] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-10-25 03:33:10,511 [salt.state       ][INFO    ][1290] unless execution succeeded
2017-10-25 03:33:10,511 [salt.state       ][INFO    ][1290] Completed state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 03:33:10.511142 duration_in_ms=49.791
2017-10-25 03:33:10,512 [salt.state       ][INFO    ][1290] Running state [keystone-credential-keys] at time 03:33:10.512086
2017-10-25 03:33:10,512 [salt.state       ][INFO    ][1290] Executing state glusterfs.started for keystone-credential-keys
2017-10-25 03:33:10,513 [salt.loaded.int.module.cmdmod][INFO    ][1290] Executing command 'gluster --version' in directory '/root'
2017-10-25 03:33:10,521 [salt.loaded.int.module.cmdmod][INFO    ][1290] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-25 03:33:10,567 [salt.loaded.int.module.cmdmod][INFO    ][1290] Executing command 'gluster --version' in directory '/root'
2017-10-25 03:33:10,575 [salt.loaded.int.module.cmdmod][INFO    ][1290] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-10-25 03:33:10,625 [salt.state       ][INFO    ][1290] Volume keystone-credential-keys is already started
2017-10-25 03:33:10,625 [salt.state       ][INFO    ][1290] Completed state [keystone-credential-keys] at time 03:33:10.625082 duration_in_ms=112.996
2017-10-25 03:33:10,628 [salt.minion      ][INFO    ][1290] Returning information for job: 20171025033307050956
2017-10-25 03:33:11,692 [salt.minion      ][INFO    ][23807] User sudo_ubuntu Executing command test.ping with jid 20171025033311680481
2017-10-25 03:33:11,708 [salt.minion      ][INFO    ][1672] Starting a new job with PID 1672
2017-10-25 03:33:11,734 [salt.minion      ][INFO    ][1672] Returning information for job: 20171025033311680481
2017-10-25 03:33:12,388 [salt.minion      ][INFO    ][23807] User sudo_ubuntu Executing command cmd.run with jid 20171025033312375399
2017-10-25 03:33:12,405 [salt.minion      ][INFO    ][1677] Starting a new job with PID 1677
2017-10-25 03:33:12,409 [salt.loaded.int.module.cmdmod][INFO    ][1677] Executing command 'gluster peer status; gluster volume status' in directory '/root'
2017-10-25 03:33:12,517 [salt.minion      ][INFO    ][1677] Returning information for job: 20171025033312375399
2017-10-25 03:39:03,673 [salt.utils.schedule][INFO    ][23807] Running scheduled job: __mine_interval
2017-10-25 03:47:07,196 [salt.minion      ][INFO    ][23807] User sudo_ubuntu Executing command cp.push_dir with jid 20171025034707189205
2017-10-25 03:47:07,216 [salt.minion      ][INFO    ][1827] Starting a new job with PID 1827
