2017-11-02 04:29:51,304 [salt.cli.daemons ][WARNING ][2505] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-11-02 04:30:38,127 [salt.state       ][ERROR   ][3753] No contents found in top file
2017-11-02 04:32:25,204 [salt.utils.parsers][WARNING ][2505] Minion received a SIGTERM. Exiting.
2017-11-02 04:34:49,131 [salt.cli.daemons ][WARNING ][3506] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-11-02 05:20:59,726 [salt.utils.parsers][WARNING ][3506] Minion received a SIGTERM. Exiting.
2017-11-02 05:23:37,256 [salt.cli.daemons ][WARNING ][3579] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-11-02 06:09:32,715 [salt.utils.parsers][WARNING ][3579] Minion received a SIGTERM. Exiting.
2017-11-02 06:12:09,152 [salt.cli.daemons ][WARNING ][3548] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-11-02 06:58:04,273 [salt.utils.parsers][WARNING ][3548] Minion received a SIGTERM. Exiting.
2017-11-02 07:00:28,957 [salt.cli.daemons ][WARNING ][3422] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-11-02 07:09:35,642 [salt.loaded.int.module.cmdmod][ERROR   ][11556] Command 'virsh net-destroy default 2>&1 1>/dev/null; virsh net-undefine default' failed with return code: 1
2017-11-02 07:09:35,643 [salt.loaded.int.module.cmdmod][ERROR   ][11556] stderr: error: failed to get network 'default'
error: Network not found: no network with matching name 'default'
2017-11-02 07:09:35,643 [salt.loaded.int.module.cmdmod][ERROR   ][11556] retcode: 1
2017-11-02 07:09:35,644 [salt.state       ][ERROR   ][11556] {'pid': 16460, 'retcode': 1, 'stderr': "error: failed to get network 'default'\nerror: Network not found: no network with matching name 'default'", 'stdout': ''}
2017-11-02 07:09:50,448 [py.warnings      ][WARNING ][16537] /usr/lib/python2.7/dist-packages/salt/utils/templates.py:73: DeprecationWarning: Starting in 2015.5, cmd.run uses python_shell=False by default, which doesn't support shellisms (pipes, env variables, etc). cmd.run is currently aliased to cmd.shell to prevent breakage. Please switch to cmd.shell or set python_shell=True to avoid breakage in the future, when this aliasing is removed.

2017-11-02 07:10:53,927 [salt.loaded.int.module.cmdmod][ERROR   ][16537] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-11-02 07:10:53,927 [salt.loaded.int.module.cmdmod][ERROR   ][16537] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-11-02 07:10:59,722 [salt.loaded.int.module.cmdmod][ERROR   ][16537] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-11-02 07:10:59,723 [salt.loaded.int.module.cmdmod][ERROR   ][16537] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-11-02 07:11:08,162 [salt.loaded.int.module.cmdmod][ERROR   ][16537] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-11-02 07:11:08,163 [salt.loaded.int.module.cmdmod][ERROR   ][16537] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-11-02 07:11:16,706 [salt.loaded.int.module.cmdmod][ERROR   ][16537] Command 'sfdisk -d /dev/nbd9' failed with return code: 1
2017-11-02 07:11:16,706 [salt.loaded.int.module.cmdmod][ERROR   ][16537] output: sfdisk: cannot open /dev/nbd9: Inappropriate ioctl for device
2017-11-02 07:11:26,714 [salt.loaded.int.module.cmdmod][ERROR   ][16537] Command 'while true; do salt-call saltutil.running|grep fun: && continue; salt-call --local service.restart salt-minion; break; done' failed with return code: None
2017-11-02 07:11:28,933 [salt.loaded.int.module.cmdmod][INFO    ][23905] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2017-11-02 07:11:28,939 [salt.loaded.int.module.cmdmod][INFO    ][23905] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2017-11-02 07:11:28,947 [salt.loaded.int.module.cmdmod][INFO    ][23905] Executing command ['systemd-run', '--scope', 'systemctl', 'restart', 'salt-minion.service'] in directory '/root'
2017-11-02 07:11:28,953 [salt.utils.parsers][WARNING ][3422] Minion received a SIGTERM. Exiting.
2017-11-02 07:11:29,205 [salt.cli.daemons ][INFO    ][23994] Setting up the Salt Minion "kvm02.baremetal-mcp-ocata-odl-ha.local"
2017-11-02 07:11:29,709 [salt.minion      ][INFO    ][23994] Creating minion process manager
2017-11-02 07:11:29,709 [salt.cli.daemons ][WARNING ][23994] IMPORTANT: Do not use md5 hashing algorithm! Please set "hash_type" to sha256 in Salt Minion config!
2017-11-02 07:11:29,709 [salt.cli.daemons ][INFO    ][23994] The Salt Minion is starting up
2017-11-02 07:11:29,709 [salt.minion      ][INFO    ][23994] Minion is starting as user 'root'
2017-11-02 07:11:29,710 [salt.utils.event ][INFO    ][23994] Starting pull socket on /var/run/salt/minion/minion_event_0607a05f39_pull.ipc
2017-11-02 07:11:30,608 [salt.loaded.int.module.cmdmod][INFO    ][23994] Executing command ['date', '+%z'] in directory '/root'
2017-11-02 07:11:30,618 [salt.utils.schedule][INFO    ][23994] Updating job settings for scheduled job: __mine_interval
2017-11-02 07:11:30,620 [salt.minion      ][INFO    ][23994] Added mine.update to scheduler
2017-11-02 07:11:30,804 [salt.minion      ][INFO    ][23994] Minion is ready to receive requests!
2017-11-02 07:11:31,805 [salt.utils.schedule][INFO    ][23994] Running scheduled job: __mine_interval
2017-11-02 07:11:37,559 [salt.minion      ][INFO    ][23994] User sudo_ubuntu Executing command saltutil.sync_all with jid 20171102071137558623
2017-11-02 07:11:37,574 [salt.minion      ][INFO    ][24121] Starting a new job with PID 24121
2017-11-02 07:11:40,119 [salt.state       ][INFO    ][24121] Loading fresh modules for state activity
2017-11-02 07:11:40,139 [salt.state       ][ERROR   ][24121] No contents found in top file
2017-11-02 07:11:40,140 [salt.utils.extmods][INFO    ][24121] Creating module dir '/var/cache/salt/minion/extmods/beacons'
2017-11-02 07:11:40,142 [salt.utils.extmods][INFO    ][24121] Syncing beacons for environment 'base'
2017-11-02 07:11:40,143 [salt.utils.extmods][INFO    ][24121] Loading cache from salt://_beacons, for base)
2017-11-02 07:11:40,143 [salt.fileclient  ][INFO    ][24121] Caching directory '_beacons/' for environment 'base'
2017-11-02 07:11:40,171 [salt.utils.extmods][INFO    ][24121] Syncing modules for environment 'base'
2017-11-02 07:11:40,171 [salt.utils.extmods][INFO    ][24121] Loading cache from salt://_modules, for base)
2017-11-02 07:11:40,172 [salt.fileclient  ][INFO    ][24121] Caching directory '_modules/' for environment 'base'
2017-11-02 07:11:40,223 [salt.fileclient  ][INFO    ][24121] Fetching file from saltenv 'base', ** done ** '_modules/ceph_ng.py'
2017-11-02 07:11:40,240 [salt.fileclient  ][INFO    ][24121] Fetching file from saltenv 'base', ** done ** '_modules/cinderng.py'
2017-11-02 07:11:40,254 [salt.fileclient  ][INFO    ][24121] Fetching file from saltenv 'base', ** done ** '_modules/contrail.py'
2017-11-02 07:11:40,264 [salt.fileclient  ][INFO    ][24121] Fetching file from saltenv 'base', ** done ** '_modules/creds.py'
2017-11-02 07:11:40,300 [salt.fileclient  ][INFO    ][24121] Fetching file from saltenv 'base', ** done ** '_modules/devops_utils.py'
2017-11-02 07:11:40,311 [salt.fileclient  ][INFO    ][24121] Fetching file from saltenv 'base', ** done ** '_modules/encode_json.py'
2017-11-02 07:11:40,323 [salt.fileclient  ][INFO    ][24121] Fetching file from saltenv 'base', ** done ** '_modules/gerrit.py'
2017-11-02 07:11:40,334 [salt.fileclient  ][INFO    ][24121] Fetching file from saltenv 'base', ** done ** '_modules/glanceng.py'
2017-11-02 07:11:40,346 [salt.fileclient  ][INFO    ][24121] Fetching file from saltenv 'base', ** done ** '_modules/heat.py'
2017-11-02 07:11:40,357 [salt.fileclient  ][INFO    ][24121] Fetching file from saltenv 'base', ** done ** '_modules/heka_alarming.py'
2017-11-02 07:11:40,389 [salt.fileclient  ][INFO    ][24121] Fetching file from saltenv 'base', ** done ** '_modules/helm.py'
2017-11-02 07:11:40,400 [salt.fileclient  ][INFO    ][24121] Fetching file from saltenv 'base', ** done ** '_modules/jenkins_common.py'
2017-11-02 07:11:40,426 [salt.fileclient  ][INFO    ][24121] Fetching file from saltenv 'base', ** done ** '_modules/keystone_policy.py'
2017-11-02 07:11:40,436 [salt.fileclient  ][INFO    ][24121] Fetching file from saltenv 'base', ** done ** '_modules/linux_hosts.py'
2017-11-02 07:11:40,447 [salt.fileclient  ][INFO    ][24121] Fetching file from saltenv 'base', ** done ** '_modules/linux_netlink.py'
2017-11-02 07:11:40,458 [salt.fileclient  ][INFO    ][24121] Fetching file from saltenv 'base', ** done ** '_modules/maas.py'
2017-11-02 07:11:40,469 [salt.fileclient  ][INFO    ][24121] Fetching file from saltenv 'base', ** done ** '_modules/maas_client.py'
2017-11-02 07:11:40,492 [salt.fileclient  ][INFO    ][24121] Fetching file from saltenv 'base', ** done ** '_modules/multipart.py'
2017-11-02 07:11:40,503 [salt.fileclient  ][INFO    ][24121] Fetching file from saltenv 'base', ** done ** '_modules/nagios_alarming.py'
2017-11-02 07:11:40,514 [salt.fileclient  ][INFO    ][24121] Fetching file from saltenv 'base', ** done ** '_modules/neutronng.py'
2017-11-02 07:11:40,567 [salt.fileclient  ][INFO    ][24121] Fetching file from saltenv 'base', ** done ** '_modules/novang.py'
2017-11-02 07:11:40,579 [salt.fileclient  ][INFO    ][24121] Fetching file from saltenv 'base', ** done ** '_modules/reclass.py'
2017-11-02 07:11:40,591 [salt.fileclient  ][INFO    ][24121] Fetching file from saltenv 'base', ** done ** '_modules/rsyslog_util.py'
2017-11-02 07:11:40,602 [salt.fileclient  ][INFO    ][24121] Fetching file from saltenv 'base', ** done ** '_modules/rundeck.py'
2017-11-02 07:11:40,612 [salt.fileclient  ][INFO    ][24121] Fetching file from saltenv 'base', ** done ** '_modules/saltkey.py'
2017-11-02 07:11:40,623 [salt.fileclient  ][INFO    ][24121] Fetching file from saltenv 'base', ** done ** '_modules/saltresource.py'
2017-11-02 07:11:40,633 [salt.fileclient  ][INFO    ][24121] Fetching file from saltenv 'base', ** done ** '_modules/seedng.py'
2017-11-02 07:11:40,652 [salt.fileclient  ][INFO    ][24121] Fetching file from saltenv 'base', ** done ** '_modules/testing/credentials.py'
2017-11-02 07:11:40,662 [salt.fileclient  ][INFO    ][24121] Fetching file from saltenv 'base', ** done ** '_modules/testing/django.py'
2017-11-02 07:11:40,673 [salt.fileclient  ][INFO    ][24121] Fetching file from saltenv 'base', ** done ** '_modules/testing/django_client_proxy.py'
2017-11-02 07:11:40,683 [salt.fileclient  ][INFO    ][24121] Fetching file from saltenv 'base', ** done ** '_modules/utils.py'
2017-11-02 07:11:40,696 [salt.fileclient  ][INFO    ][24121] Fetching file from saltenv 'base', ** done ** '_modules/virtng.py'
2017-11-02 07:11:40,699 [salt.utils.extmods][INFO    ][24121] Copying '/var/cache/salt/minion/files/base/_modules/__init__.py' to '/var/cache/salt/minion/extmods/modules/__init__.py'
2017-11-02 07:11:40,699 [salt.utils.extmods][INFO    ][24121] Copying '/var/cache/salt/minion/files/base/_modules/ceph_ng.py' to '/var/cache/salt/minion/extmods/modules/ceph_ng.py'
2017-11-02 07:11:40,699 [salt.utils.extmods][INFO    ][24121] Copying '/var/cache/salt/minion/files/base/_modules/cinderng.py' to '/var/cache/salt/minion/extmods/modules/cinderng.py'
2017-11-02 07:11:40,699 [salt.utils.extmods][INFO    ][24121] Copying '/var/cache/salt/minion/files/base/_modules/contrail.py' to '/var/cache/salt/minion/extmods/modules/contrail.py'
2017-11-02 07:11:40,700 [salt.utils.extmods][INFO    ][24121] Copying '/var/cache/salt/minion/files/base/_modules/creds.py' to '/var/cache/salt/minion/extmods/modules/creds.py'
2017-11-02 07:11:40,700 [salt.utils.extmods][INFO    ][24121] Copying '/var/cache/salt/minion/files/base/_modules/devops_utils.py' to '/var/cache/salt/minion/extmods/modules/devops_utils.py'
2017-11-02 07:11:40,700 [salt.utils.extmods][INFO    ][24121] Copying '/var/cache/salt/minion/files/base/_modules/encode_json.py' to '/var/cache/salt/minion/extmods/modules/encode_json.py'
2017-11-02 07:11:40,700 [salt.utils.extmods][INFO    ][24121] Copying '/var/cache/salt/minion/files/base/_modules/gerrit.py' to '/var/cache/salt/minion/extmods/modules/gerrit.py'
2017-11-02 07:11:40,701 [salt.utils.extmods][INFO    ][24121] Copying '/var/cache/salt/minion/files/base/_modules/glanceng.py' to '/var/cache/salt/minion/extmods/modules/glanceng.py'
2017-11-02 07:11:40,701 [salt.utils.extmods][INFO    ][24121] Copying '/var/cache/salt/minion/files/base/_modules/heat.py' to '/var/cache/salt/minion/extmods/modules/heat.py'
2017-11-02 07:11:40,701 [salt.utils.extmods][INFO    ][24121] Copying '/var/cache/salt/minion/files/base/_modules/heka_alarming.py' to '/var/cache/salt/minion/extmods/modules/heka_alarming.py'
2017-11-02 07:11:40,702 [salt.utils.extmods][INFO    ][24121] Copying '/var/cache/salt/minion/files/base/_modules/helm.py' to '/var/cache/salt/minion/extmods/modules/helm.py'
2017-11-02 07:11:40,702 [salt.utils.extmods][INFO    ][24121] Copying '/var/cache/salt/minion/files/base/_modules/jenkins_common.py' to '/var/cache/salt/minion/extmods/modules/jenkins_common.py'
2017-11-02 07:11:40,702 [salt.utils.extmods][INFO    ][24121] Copying '/var/cache/salt/minion/files/base/_modules/keystone_policy.py' to '/var/cache/salt/minion/extmods/modules/keystone_policy.py'
2017-11-02 07:11:40,702 [salt.utils.extmods][INFO    ][24121] Copying '/var/cache/salt/minion/files/base/_modules/linux_hosts.py' to '/var/cache/salt/minion/extmods/modules/linux_hosts.py'
2017-11-02 07:11:40,703 [salt.utils.extmods][INFO    ][24121] Copying '/var/cache/salt/minion/files/base/_modules/linux_netlink.py' to '/var/cache/salt/minion/extmods/modules/linux_netlink.py'
2017-11-02 07:11:40,703 [salt.utils.extmods][INFO    ][24121] Copying '/var/cache/salt/minion/files/base/_modules/maas.py' to '/var/cache/salt/minion/extmods/modules/maas.py'
2017-11-02 07:11:40,703 [salt.utils.extmods][INFO    ][24121] Copying '/var/cache/salt/minion/files/base/_modules/maas_client.py' to '/var/cache/salt/minion/extmods/modules/maas_client.py'
2017-11-02 07:11:40,703 [salt.utils.extmods][INFO    ][24121] Copying '/var/cache/salt/minion/files/base/_modules/multipart.py' to '/var/cache/salt/minion/extmods/modules/multipart.py'
2017-11-02 07:11:40,704 [salt.utils.extmods][INFO    ][24121] Copying '/var/cache/salt/minion/files/base/_modules/nagios_alarming.py' to '/var/cache/salt/minion/extmods/modules/nagios_alarming.py'
2017-11-02 07:11:40,722 [salt.utils.extmods][INFO    ][24121] Copying '/var/cache/salt/minion/files/base/_modules/neutronng.py' to '/var/cache/salt/minion/extmods/modules/neutronng.py'
2017-11-02 07:11:40,722 [salt.utils.extmods][INFO    ][24121] Copying '/var/cache/salt/minion/files/base/_modules/novang.py' to '/var/cache/salt/minion/extmods/modules/novang.py'
2017-11-02 07:11:40,722 [salt.utils.extmods][INFO    ][24121] Copying '/var/cache/salt/minion/files/base/_modules/reclass.py' to '/var/cache/salt/minion/extmods/modules/reclass.py'
2017-11-02 07:11:40,723 [salt.utils.extmods][INFO    ][24121] Copying '/var/cache/salt/minion/files/base/_modules/rsyslog_util.py' to '/var/cache/salt/minion/extmods/modules/rsyslog_util.py'
2017-11-02 07:11:40,723 [salt.utils.extmods][INFO    ][24121] Copying '/var/cache/salt/minion/files/base/_modules/rundeck.py' to '/var/cache/salt/minion/extmods/modules/rundeck.py'
2017-11-02 07:11:40,723 [salt.utils.extmods][INFO    ][24121] Copying '/var/cache/salt/minion/files/base/_modules/saltkey.py' to '/var/cache/salt/minion/extmods/modules/saltkey.py'
2017-11-02 07:11:40,723 [salt.utils.extmods][INFO    ][24121] Copying '/var/cache/salt/minion/files/base/_modules/saltresource.py' to '/var/cache/salt/minion/extmods/modules/saltresource.py'
2017-11-02 07:11:40,724 [salt.utils.extmods][INFO    ][24121] Copying '/var/cache/salt/minion/files/base/_modules/seedng.py' to '/var/cache/salt/minion/extmods/modules/seedng.py'
2017-11-02 07:11:40,724 [salt.utils.extmods][INFO    ][24121] Copying '/var/cache/salt/minion/files/base/_modules/testing/__init__.py' to '/var/cache/salt/minion/extmods/modules/testing/__init__.py'
2017-11-02 07:11:40,724 [salt.utils.extmods][INFO    ][24121] Copying '/var/cache/salt/minion/files/base/_modules/testing/credentials.py' to '/var/cache/salt/minion/extmods/modules/testing/credentials.py'
2017-11-02 07:11:40,725 [salt.utils.extmods][INFO    ][24121] Copying '/var/cache/salt/minion/files/base/_modules/testing/django.py' to '/var/cache/salt/minion/extmods/modules/testing/django.py'
2017-11-02 07:11:40,725 [salt.utils.extmods][INFO    ][24121] Copying '/var/cache/salt/minion/files/base/_modules/testing/django_client_proxy.py' to '/var/cache/salt/minion/extmods/modules/testing/django_client_proxy.py'
2017-11-02 07:11:40,725 [salt.utils.extmods][INFO    ][24121] Copying '/var/cache/salt/minion/files/base/_modules/utils.py' to '/var/cache/salt/minion/extmods/modules/utils.py'
2017-11-02 07:11:40,725 [salt.utils.extmods][INFO    ][24121] Copying '/var/cache/salt/minion/files/base/_modules/virtng.py' to '/var/cache/salt/minion/extmods/modules/virtng.py'
2017-11-02 07:11:40,730 [salt.utils.extmods][INFO    ][24121] Syncing states for environment 'base'
2017-11-02 07:11:40,730 [salt.utils.extmods][INFO    ][24121] Loading cache from salt://_states, for base)
2017-11-02 07:11:40,730 [salt.fileclient  ][INFO    ][24121] Caching directory '_states/' for environment 'base'
2017-11-02 07:11:40,769 [salt.fileclient  ][INFO    ][24121] Fetching file from saltenv 'base', ** done ** '_states/cinderng.py'
2017-11-02 07:11:40,781 [salt.fileclient  ][INFO    ][24121] Fetching file from saltenv 'base', ** done ** '_states/contrail.py'
2017-11-02 07:11:40,792 [salt.fileclient  ][INFO    ][24121] Fetching file from saltenv 'base', ** done ** '_states/gerrit.py'
2017-11-02 07:11:40,803 [salt.fileclient  ][INFO    ][24121] Fetching file from saltenv 'base', ** done ** '_states/glanceng.py'
2017-11-02 07:11:40,814 [salt.fileclient  ][INFO    ][24121] Fetching file from saltenv 'base', ** done ** '_states/grafana3_dashboard.py'
2017-11-02 07:11:40,825 [salt.fileclient  ][INFO    ][24121] Fetching file from saltenv 'base', ** done ** '_states/grafana3_datasource.py'
2017-11-02 07:11:40,835 [salt.fileclient  ][INFO    ][24121] Fetching file from saltenv 'base', ** done ** '_states/heat.py'
2017-11-02 07:11:40,847 [salt.fileclient  ][INFO    ][24121] Fetching file from saltenv 'base', ** done ** '_states/helm_release.py'
2017-11-02 07:11:40,984 [salt.fileclient  ][INFO    ][24121] Fetching file from saltenv 'base', ** done ** '_states/jenkins_approval.py'
2017-11-02 07:11:41,062 [salt.fileclient  ][INFO    ][24121] Fetching file from saltenv 'base', ** done ** '_states/jenkins_artifactory.py'
2017-11-02 07:11:41,113 [salt.fileclient  ][INFO    ][24121] Fetching file from saltenv 'base', ** done ** '_states/jenkins_credential.py'
2017-11-02 07:11:41,146 [salt.fileclient  ][INFO    ][24121] Fetching file from saltenv 'base', ** done ** '_states/jenkins_job.py'
2017-11-02 07:11:41,167 [salt.fileclient  ][INFO    ][24121] Fetching file from saltenv 'base', ** done ** '_states/jenkins_lib.py'
2017-11-02 07:11:41,327 [salt.fileclient  ][INFO    ][24121] Fetching file from saltenv 'base', ** done ** '_states/jenkins_node.py'
2017-11-02 07:11:41,386 [salt.fileclient  ][INFO    ][24121] Fetching file from saltenv 'base', ** done ** '_states/jenkins_plugin.py'
2017-11-02 07:11:41,463 [salt.fileclient  ][INFO    ][24121] Fetching file from saltenv 'base', ** done ** '_states/jenkins_security.py'
2017-11-02 07:11:41,491 [salt.fileclient  ][INFO    ][24121] Fetching file from saltenv 'base', ** done ** '_states/jenkins_slack.py'
2017-11-02 07:11:41,517 [salt.fileclient  ][INFO    ][24121] Fetching file from saltenv 'base', ** done ** '_states/jenkins_smtp.py'
2017-11-02 07:11:41,583 [salt.fileclient  ][INFO    ][24121] Fetching file from saltenv 'base', ** done ** '_states/jenkins_theme.py'
2017-11-02 07:11:41,606 [salt.fileclient  ][INFO    ][24121] Fetching file from saltenv 'base', ** done ** '_states/jenkins_user.py'
2017-11-02 07:11:41,658 [salt.fileclient  ][INFO    ][24121] Fetching file from saltenv 'base', ** done ** '_states/jenkins_view.py'
2017-11-02 07:11:41,691 [salt.fileclient  ][INFO    ][24121] Fetching file from saltenv 'base', ** done ** '_states/keystone_policy.py'
2017-11-02 07:11:41,728 [salt.fileclient  ][INFO    ][24121] Fetching file from saltenv 'base', ** done ** '_states/kibana_object.py'
2017-11-02 07:11:41,765 [salt.fileclient  ][INFO    ][24121] Fetching file from saltenv 'base', ** done ** '_states/neutronng.py'
2017-11-02 07:11:41,799 [salt.fileclient  ][INFO    ][24121] Fetching file from saltenv 'base', ** done ** '_states/novang.py'
2017-11-02 07:11:41,824 [salt.fileclient  ][INFO    ][24121] Fetching file from saltenv 'base', ** done ** '_states/reclass.py'
2017-11-02 07:11:41,836 [salt.fileclient  ][INFO    ][24121] Fetching file from saltenv 'base', ** done ** '_states/rundeck_project.py'
2017-11-02 07:11:41,899 [salt.fileclient  ][INFO    ][24121] Fetching file from saltenv 'base', ** done ** '_states/rundeck_scm.py'
2017-11-02 07:11:41,925 [salt.fileclient  ][INFO    ][24121] Fetching file from saltenv 'base', ** done ** '_states/rundeck_secret.py'
2017-11-02 07:11:41,928 [salt.utils.extmods][INFO    ][24121] Copying '/var/cache/salt/minion/files/base/_states/cinderng.py' to '/var/cache/salt/minion/extmods/states/cinderng.py'
2017-11-02 07:11:41,955 [salt.utils.extmods][INFO    ][24121] Copying '/var/cache/salt/minion/files/base/_states/contrail.py' to '/var/cache/salt/minion/extmods/states/contrail.py'
2017-11-02 07:11:41,978 [salt.utils.extmods][INFO    ][24121] Copying '/var/cache/salt/minion/files/base/_states/gerrit.py' to '/var/cache/salt/minion/extmods/states/gerrit.py'
2017-11-02 07:11:41,989 [salt.utils.extmods][INFO    ][24121] Copying '/var/cache/salt/minion/files/base/_states/glanceng.py' to '/var/cache/salt/minion/extmods/states/glanceng.py'
2017-11-02 07:11:42,015 [salt.utils.extmods][INFO    ][24121] Copying '/var/cache/salt/minion/files/base/_states/grafana3_dashboard.py' to '/var/cache/salt/minion/extmods/states/grafana3_dashboard.py'
2017-11-02 07:11:42,025 [salt.utils.extmods][INFO    ][24121] Copying '/var/cache/salt/minion/files/base/_states/grafana3_datasource.py' to '/var/cache/salt/minion/extmods/states/grafana3_datasource.py'
2017-11-02 07:11:42,039 [salt.utils.extmods][INFO    ][24121] Copying '/var/cache/salt/minion/files/base/_states/heat.py' to '/var/cache/salt/minion/extmods/states/heat.py'
2017-11-02 07:11:42,050 [salt.utils.extmods][INFO    ][24121] Copying '/var/cache/salt/minion/files/base/_states/helm_release.py' to '/var/cache/salt/minion/extmods/states/helm_release.py'
2017-11-02 07:11:42,073 [salt.utils.extmods][INFO    ][24121] Copying '/var/cache/salt/minion/files/base/_states/jenkins_approval.py' to '/var/cache/salt/minion/extmods/states/jenkins_approval.py'
2017-11-02 07:11:42,098 [salt.utils.extmods][INFO    ][24121] Copying '/var/cache/salt/minion/files/base/_states/jenkins_artifactory.py' to '/var/cache/salt/minion/extmods/states/jenkins_artifactory.py'
2017-11-02 07:11:42,141 [salt.utils.extmods][INFO    ][24121] Copying '/var/cache/salt/minion/files/base/_states/jenkins_credential.py' to '/var/cache/salt/minion/extmods/states/jenkins_credential.py'
2017-11-02 07:11:42,142 [salt.utils.extmods][INFO    ][24121] Copying '/var/cache/salt/minion/files/base/_states/jenkins_job.py' to '/var/cache/salt/minion/extmods/states/jenkins_job.py'
2017-11-02 07:11:42,142 [salt.utils.extmods][INFO    ][24121] Copying '/var/cache/salt/minion/files/base/_states/jenkins_lib.py' to '/var/cache/salt/minion/extmods/states/jenkins_lib.py'
2017-11-02 07:11:42,143 [salt.utils.extmods][INFO    ][24121] Copying '/var/cache/salt/minion/files/base/_states/jenkins_node.py' to '/var/cache/salt/minion/extmods/states/jenkins_node.py'
2017-11-02 07:11:42,143 [salt.utils.extmods][INFO    ][24121] Copying '/var/cache/salt/minion/files/base/_states/jenkins_plugin.py' to '/var/cache/salt/minion/extmods/states/jenkins_plugin.py'
2017-11-02 07:11:42,144 [salt.utils.extmods][INFO    ][24121] Copying '/var/cache/salt/minion/files/base/_states/jenkins_security.py' to '/var/cache/salt/minion/extmods/states/jenkins_security.py'
2017-11-02 07:11:42,149 [salt.utils.extmods][INFO    ][24121] Copying '/var/cache/salt/minion/files/base/_states/jenkins_slack.py' to '/var/cache/salt/minion/extmods/states/jenkins_slack.py'
2017-11-02 07:11:42,150 [salt.utils.extmods][INFO    ][24121] Copying '/var/cache/salt/minion/files/base/_states/jenkins_smtp.py' to '/var/cache/salt/minion/extmods/states/jenkins_smtp.py'
2017-11-02 07:11:42,151 [salt.utils.extmods][INFO    ][24121] Copying '/var/cache/salt/minion/files/base/_states/jenkins_theme.py' to '/var/cache/salt/minion/extmods/states/jenkins_theme.py'
2017-11-02 07:11:42,151 [salt.utils.extmods][INFO    ][24121] Copying '/var/cache/salt/minion/files/base/_states/jenkins_user.py' to '/var/cache/salt/minion/extmods/states/jenkins_user.py'
2017-11-02 07:11:42,152 [salt.utils.extmods][INFO    ][24121] Copying '/var/cache/salt/minion/files/base/_states/jenkins_view.py' to '/var/cache/salt/minion/extmods/states/jenkins_view.py'
2017-11-02 07:11:42,152 [salt.utils.extmods][INFO    ][24121] Copying '/var/cache/salt/minion/files/base/_states/keystone_policy.py' to '/var/cache/salt/minion/extmods/states/keystone_policy.py'
2017-11-02 07:11:42,153 [salt.utils.extmods][INFO    ][24121] Copying '/var/cache/salt/minion/files/base/_states/kibana_object.py' to '/var/cache/salt/minion/extmods/states/kibana_object.py'
2017-11-02 07:11:42,159 [salt.utils.extmods][INFO    ][24121] Copying '/var/cache/salt/minion/files/base/_states/maas_cluster.py' to '/var/cache/salt/minion/extmods/states/maas_cluster.py'
2017-11-02 07:11:42,159 [salt.utils.extmods][INFO    ][24121] Copying '/var/cache/salt/minion/files/base/_states/neutronng.py' to '/var/cache/salt/minion/extmods/states/neutronng.py'
2017-11-02 07:11:42,169 [salt.utils.extmods][INFO    ][24121] Copying '/var/cache/salt/minion/files/base/_states/novang.py' to '/var/cache/salt/minion/extmods/states/novang.py'
2017-11-02 07:11:42,170 [salt.utils.extmods][INFO    ][24121] Copying '/var/cache/salt/minion/files/base/_states/reclass.py' to '/var/cache/salt/minion/extmods/states/reclass.py'
2017-11-02 07:11:42,170 [salt.utils.extmods][INFO    ][24121] Copying '/var/cache/salt/minion/files/base/_states/rundeck_project.py' to '/var/cache/salt/minion/extmods/states/rundeck_project.py'
2017-11-02 07:11:42,171 [salt.utils.extmods][INFO    ][24121] Copying '/var/cache/salt/minion/files/base/_states/rundeck_scm.py' to '/var/cache/salt/minion/extmods/states/rundeck_scm.py'
2017-11-02 07:11:42,171 [salt.utils.extmods][INFO    ][24121] Copying '/var/cache/salt/minion/files/base/_states/rundeck_secret.py' to '/var/cache/salt/minion/extmods/states/rundeck_secret.py'
2017-11-02 07:11:42,175 [salt.utils.extmods][INFO    ][24121] Creating module dir '/var/cache/salt/minion/extmods/sdb'
2017-11-02 07:11:42,179 [salt.utils.extmods][INFO    ][24121] Syncing sdb for environment 'base'
2017-11-02 07:11:42,179 [salt.utils.extmods][INFO    ][24121] Loading cache from salt://_sdb, for base)
2017-11-02 07:11:42,179 [salt.fileclient  ][INFO    ][24121] Caching directory '_sdb/' for environment 'base'
2017-11-02 07:11:42,212 [salt.utils.extmods][INFO    ][24121] Syncing grains for environment 'base'
2017-11-02 07:11:42,212 [salt.utils.extmods][INFO    ][24121] Loading cache from salt://_grains, for base)
2017-11-02 07:11:42,212 [salt.fileclient  ][INFO    ][24121] Caching directory '_grains/' for environment 'base'
2017-11-02 07:11:42,255 [salt.fileclient  ][INFO    ][24121] Fetching file from saltenv 'base', ** done ** '_grains/ceilometer_policy.py'
2017-11-02 07:11:42,343 [salt.fileclient  ][INFO    ][24121] Fetching file from saltenv 'base', ** done ** '_grains/ceph.py'
2017-11-02 07:11:42,355 [salt.fileclient  ][INFO    ][24121] Fetching file from saltenv 'base', ** done ** '_grains/cinder_policy.py'
2017-11-02 07:11:42,368 [salt.fileclient  ][INFO    ][24121] Fetching file from saltenv 'base', ** done ** '_grains/docker_swarm.py'
2017-11-02 07:11:42,379 [salt.fileclient  ][INFO    ][24121] Fetching file from saltenv 'base', ** done ** '_grains/glance_policy.py'
2017-11-02 07:11:42,391 [salt.fileclient  ][INFO    ][24121] Fetching file from saltenv 'base', ** done ** '_grains/heat_policy.py'
2017-11-02 07:11:42,402 [salt.fileclient  ][INFO    ][24121] Fetching file from saltenv 'base', ** done ** '_grains/jenkins_plugins.py'
2017-11-02 07:11:42,415 [salt.fileclient  ][INFO    ][24121] Fetching file from saltenv 'base', ** done ** '_grains/keystone_policy.py'
2017-11-02 07:11:42,425 [salt.fileclient  ][INFO    ][24121] Fetching file from saltenv 'base', ** done ** '_grains/kubernetes.py'
2017-11-02 07:11:42,642 [salt.fileclient  ][INFO    ][24121] Fetching file from saltenv 'base', ** done ** '_grains/neutron_policy.py'
2017-11-02 07:11:42,693 [salt.fileclient  ][INFO    ][24121] Fetching file from saltenv 'base', ** done ** '_grains/nova_policy.py'
2017-11-02 07:11:42,789 [salt.fileclient  ][INFO    ][24121] Fetching file from saltenv 'base', ** done ** '_grains/ssh_fingerprints.py'
2017-11-02 07:11:42,792 [salt.utils.extmods][INFO    ][24121] Copying '/var/cache/salt/minion/files/base/_grains/ceilometer_policy.py' to '/var/cache/salt/minion/extmods/grains/ceilometer_policy.py'
2017-11-02 07:11:42,866 [salt.utils.extmods][INFO    ][24121] Copying '/var/cache/salt/minion/files/base/_grains/ceph.py' to '/var/cache/salt/minion/extmods/grains/ceph.py'
2017-11-02 07:11:42,882 [salt.utils.extmods][INFO    ][24121] Copying '/var/cache/salt/minion/files/base/_grains/cinder_policy.py' to '/var/cache/salt/minion/extmods/grains/cinder_policy.py'
2017-11-02 07:11:42,883 [salt.utils.extmods][INFO    ][24121] Copying '/var/cache/salt/minion/files/base/_grains/docker_swarm.py' to '/var/cache/salt/minion/extmods/grains/docker_swarm.py'
2017-11-02 07:11:42,883 [salt.utils.extmods][INFO    ][24121] Copying '/var/cache/salt/minion/files/base/_grains/glance_policy.py' to '/var/cache/salt/minion/extmods/grains/glance_policy.py'
2017-11-02 07:11:42,884 [salt.utils.extmods][INFO    ][24121] Copying '/var/cache/salt/minion/files/base/_grains/heat_policy.py' to '/var/cache/salt/minion/extmods/grains/heat_policy.py'
2017-11-02 07:11:42,884 [salt.utils.extmods][INFO    ][24121] Copying '/var/cache/salt/minion/files/base/_grains/jenkins_plugins.py' to '/var/cache/salt/minion/extmods/grains/jenkins_plugins.py'
2017-11-02 07:11:42,885 [salt.utils.extmods][INFO    ][24121] Copying '/var/cache/salt/minion/files/base/_grains/keystone_policy.py' to '/var/cache/salt/minion/extmods/grains/keystone_policy.py'
2017-11-02 07:11:42,885 [salt.utils.extmods][INFO    ][24121] Copying '/var/cache/salt/minion/files/base/_grains/kubernetes.py' to '/var/cache/salt/minion/extmods/grains/kubernetes.py'
2017-11-02 07:11:42,886 [salt.utils.extmods][INFO    ][24121] Copying '/var/cache/salt/minion/files/base/_grains/neutron_policy.py' to '/var/cache/salt/minion/extmods/grains/neutron_policy.py'
2017-11-02 07:11:42,886 [salt.utils.extmods][INFO    ][24121] Copying '/var/cache/salt/minion/files/base/_grains/nova_policy.py' to '/var/cache/salt/minion/extmods/grains/nova_policy.py'
2017-11-02 07:11:42,887 [salt.utils.extmods][INFO    ][24121] Copying '/var/cache/salt/minion/files/base/_grains/ssh_fingerprints.py' to '/var/cache/salt/minion/extmods/grains/ssh_fingerprints.py'
2017-11-02 07:11:42,888 [salt.utils.extmods][INFO    ][24121] Creating module dir '/var/cache/salt/minion/extmods/renderers'
2017-11-02 07:11:42,891 [salt.utils.extmods][INFO    ][24121] Syncing renderers for environment 'base'
2017-11-02 07:11:42,891 [salt.utils.extmods][INFO    ][24121] Loading cache from salt://_renderers, for base)
2017-11-02 07:11:42,891 [salt.fileclient  ][INFO    ][24121] Caching directory '_renderers/' for environment 'base'
2017-11-02 07:11:42,925 [salt.utils.extmods][INFO    ][24121] Creating module dir '/var/cache/salt/minion/extmods/returners'
2017-11-02 07:11:42,927 [salt.utils.extmods][INFO    ][24121] Syncing returners for environment 'base'
2017-11-02 07:11:42,928 [salt.utils.extmods][INFO    ][24121] Loading cache from salt://_returners, for base)
2017-11-02 07:11:42,928 [salt.fileclient  ][INFO    ][24121] Caching directory '_returners/' for environment 'base'
2017-11-02 07:11:42,967 [salt.utils.extmods][INFO    ][24121] Creating module dir '/var/cache/salt/minion/extmods/output'
2017-11-02 07:11:42,969 [salt.utils.extmods][INFO    ][24121] Syncing output for environment 'base'
2017-11-02 07:11:42,969 [salt.utils.extmods][INFO    ][24121] Loading cache from salt://_output, for base)
2017-11-02 07:11:42,969 [salt.fileclient  ][INFO    ][24121] Caching directory '_output/' for environment 'base'
2017-11-02 07:11:43,002 [salt.utils.extmods][INFO    ][24121] Creating module dir '/var/cache/salt/minion/extmods/utils'
2017-11-02 07:11:43,004 [salt.utils.extmods][INFO    ][24121] Syncing utils for environment 'base'
2017-11-02 07:11:43,004 [salt.utils.extmods][INFO    ][24121] Loading cache from salt://_utils, for base)
2017-11-02 07:11:43,005 [salt.fileclient  ][INFO    ][24121] Caching directory '_utils/' for environment 'base'
2017-11-02 07:11:43,039 [salt.utils.extmods][INFO    ][24121] Creating module dir '/var/cache/salt/minion/extmods/log_handlers'
2017-11-02 07:11:43,053 [salt.utils.extmods][INFO    ][24121] Syncing log_handlers for environment 'base'
2017-11-02 07:11:43,053 [salt.utils.extmods][INFO    ][24121] Loading cache from salt://_log_handlers, for base)
2017-11-02 07:11:43,053 [salt.fileclient  ][INFO    ][24121] Caching directory '_log_handlers/' for environment 'base'
2017-11-02 07:11:43,105 [salt.utils.extmods][INFO    ][24121] Creating module dir '/var/cache/salt/minion/extmods/proxy'
2017-11-02 07:11:43,107 [salt.utils.extmods][INFO    ][24121] Syncing proxy for environment 'base'
2017-11-02 07:11:43,107 [salt.utils.extmods][INFO    ][24121] Loading cache from salt://_proxy, for base)
2017-11-02 07:11:43,107 [salt.fileclient  ][INFO    ][24121] Caching directory '_proxy/' for environment 'base'
2017-11-02 07:11:43,139 [salt.utils.extmods][INFO    ][24121] Creating module dir '/var/cache/salt/minion/extmods/engines'
2017-11-02 07:11:43,142 [salt.utils.extmods][INFO    ][24121] Syncing engines for environment 'base'
2017-11-02 07:11:43,152 [salt.utils.extmods][INFO    ][24121] Loading cache from salt://_engines, for base)
2017-11-02 07:11:43,152 [salt.fileclient  ][INFO    ][24121] Caching directory '_engines/' for environment 'base'
2017-11-02 07:11:43,187 [salt.minion      ][INFO    ][24121] Returning information for job: 20171102071137558623
2017-11-02 07:11:48,069 [salt.minion      ][INFO    ][23994] User sudo_ubuntu Executing command state.sls with jid 20171102071148070941
2017-11-02 07:11:48,084 [salt.minion      ][INFO    ][24244] Starting a new job with PID 24244
2017-11-02 07:11:48,547 [salt.state       ][INFO    ][24244] Loading fresh modules for state activity
2017-11-02 07:11:48,572 [salt.fileclient  ][INFO    ][24244] Fetching file from saltenv 'base', ** done ** 'salt/control/init.sls'
2017-11-02 07:11:48,605 [salt.fileclient  ][INFO    ][24244] Fetching file from saltenv 'base', ** done ** 'salt/control/virt.sls'
2017-11-02 07:11:48,698 [salt.fileclient  ][INFO    ][24244] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-11-02 07:11:48,763 [salt.fileclient  ][INFO    ][24244] Fetching file from saltenv 'base', ** done ** 'salt/minion/init.sls'
2017-11-02 07:11:48,794 [salt.fileclient  ][INFO    ][24244] Fetching file from saltenv 'base', ** done ** 'salt/minion/service.sls'
2017-11-02 07:11:48,819 [salt.fileclient  ][INFO    ][24244] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-11-02 07:11:48,871 [salt.fileclient  ][INFO    ][24244] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-11-02 07:11:48,913 [salt.fileclient  ][INFO    ][24244] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-11-02 07:11:48,956 [salt.fileclient  ][INFO    ][24244] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-11-02 07:11:48,975 [salt.fileclient  ][INFO    ][24244] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-11-02 07:11:48,988 [salt.fileclient  ][INFO    ][24244] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-11-02 07:11:49,032 [salt.fileclient  ][INFO    ][24244] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-11-02 07:11:49,039 [salt.loaded.int.module.cmdmod][INFO    ][24244] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-11-02 07:11:49,073 [salt.fileclient  ][INFO    ][24244] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-11-02 07:11:49,088 [py.warnings      ][WARNING ][24244] /usr/lib/python2.7/dist-packages/salt/utils/templates.py:73: DeprecationWarning: Starting in 2015.5, cmd.run uses python_shell=False by default, which doesn't support shellisms (pipes, env variables, etc). cmd.run is currently aliased to cmd.shell to prevent breakage. Please switch to cmd.shell or set python_shell=True to avoid breakage in the future, when this aliasing is removed.

2017-11-02 07:11:49,088 [salt.loaded.int.module.cmdmod][INFO    ][24244] Executing command 'salt-minion --version' in directory '/root'
2017-11-02 07:11:49,345 [salt.fileclient  ][INFO    ][24244] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-11-02 07:11:49,385 [salt.fileclient  ][INFO    ][24244] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-11-02 07:11:49,399 [salt.fileclient  ][INFO    ][24244] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-11-02 07:11:49,411 [salt.fileclient  ][INFO    ][24244] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-11-02 07:11:49,457 [salt.fileclient  ][INFO    ][24244] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-11-02 07:11:49,499 [salt.fileclient  ][INFO    ][24244] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-11-02 07:11:49,559 [salt.fileclient  ][INFO    ][24244] Fetching file from saltenv 'base', ** done ** 'salt/minion/grains.sls'
2017-11-02 07:11:49,612 [salt.fileclient  ][INFO    ][24244] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-11-02 07:11:49,666 [salt.fileclient  ][INFO    ][24244] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-11-02 07:11:49,730 [salt.fileclient  ][INFO    ][24244] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-11-02 07:11:49,774 [salt.fileclient  ][INFO    ][24244] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-11-02 07:11:49,792 [salt.fileclient  ][INFO    ][24244] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-11-02 07:11:49,804 [salt.fileclient  ][INFO    ][24244] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-11-02 07:11:49,836 [salt.fileclient  ][INFO    ][24244] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-11-02 07:11:49,843 [salt.loaded.int.module.cmdmod][INFO    ][24244] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-11-02 07:11:49,895 [salt.fileclient  ][INFO    ][24244] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-11-02 07:11:49,912 [salt.loaded.int.module.cmdmod][INFO    ][24244] Executing command 'salt-minion --version' in directory '/root'
2017-11-02 07:11:50,187 [salt.fileclient  ][INFO    ][24244] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-11-02 07:11:50,206 [salt.fileclient  ][INFO    ][24244] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-11-02 07:11:50,219 [salt.fileclient  ][INFO    ][24244] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-11-02 07:11:50,231 [salt.fileclient  ][INFO    ][24244] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-11-02 07:11:50,280 [salt.fileclient  ][INFO    ][24244] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-11-02 07:11:50,333 [salt.fileclient  ][INFO    ][24244] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-11-02 07:11:50,397 [salt.fileclient  ][INFO    ][24244] Fetching file from saltenv 'base', ** done ** 'salt/minion/cert.sls'
2017-11-02 07:11:50,457 [salt.fileclient  ][INFO    ][24244] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-11-02 07:11:50,861 [salt.state       ][INFO    ][24244] Running state [salt-minion] at time 07:11:50.861061
2017-11-02 07:11:50,861 [salt.state       ][INFO    ][24244] Executing state pkg.installed for salt-minion
2017-11-02 07:11:50,862 [salt.loaded.int.module.cmdmod][INFO    ][24244] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-02 07:11:51,125 [salt.state       ][INFO    ][24244] Package salt-minion is already installed
2017-11-02 07:11:51,126 [salt.state       ][INFO    ][24244] Completed state [salt-minion] at time 07:11:51.125558 duration_in_ms=264.497
2017-11-02 07:11:51,126 [salt.state       ][INFO    ][24244] Running state [salt_minion_dependency_packages] at time 07:11:51.125818
2017-11-02 07:11:51,126 [salt.state       ][INFO    ][24244] Executing state pkg.installed for salt_minion_dependency_packages
2017-11-02 07:11:51,129 [salt.state       ][INFO    ][24244] All specified packages are already installed
2017-11-02 07:11:51,129 [salt.state       ][INFO    ][24244] Completed state [salt_minion_dependency_packages] at time 07:11:51.128885 duration_in_ms=3.067
2017-11-02 07:11:51,130 [salt.state       ][INFO    ][24244] Running state [/etc/salt/minion.d/minion.conf] at time 07:11:51.130467
2017-11-02 07:11:51,131 [salt.state       ][INFO    ][24244] Executing state file.managed for /etc/salt/minion.d/minion.conf
2017-11-02 07:11:51,162 [salt.fileclient  ][INFO    ][24244] Fetching file from saltenv 'base', ** done ** 'salt/files/minion.conf'
2017-11-02 07:11:51,209 [salt.fileclient  ][INFO    ][24244] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-11-02 07:11:51,253 [salt.fileclient  ][INFO    ][24244] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-11-02 07:11:51,287 [salt.state       ][INFO    ][24244] File /etc/salt/minion.d/minion.conf is in the correct state
2017-11-02 07:11:51,287 [salt.state       ][INFO    ][24244] Completed state [/etc/salt/minion.d/minion.conf] at time 07:11:51.286677 duration_in_ms=156.21
2017-11-02 07:11:51,287 [salt.state       ][INFO    ][24244] Running state [/etc/salt/minion.d/_virt.conf] at time 07:11:51.286967
2017-11-02 07:11:51,287 [salt.state       ][INFO    ][24244] Executing state file.managed for /etc/salt/minion.d/_virt.conf
2017-11-02 07:11:51,354 [salt.state       ][INFO    ][24244] File /etc/salt/minion.d/_virt.conf is in the correct state
2017-11-02 07:11:51,354 [salt.state       ][INFO    ][24244] Completed state [/etc/salt/minion.d/_virt.conf] at time 07:11:51.354370 duration_in_ms=67.403
2017-11-02 07:11:51,356 [salt.state       ][INFO    ][24244] Running state [salt-minion] at time 07:11:51.355848
2017-11-02 07:11:51,356 [salt.state       ][INFO    ][24244] Executing state service.running for salt-minion
2017-11-02 07:11:51,357 [salt.loaded.int.module.cmdmod][INFO    ][24244] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2017-11-02 07:11:51,375 [salt.loaded.int.module.cmdmod][INFO    ][24244] Executing command ['systemctl', 'is-active', 'salt-minion.service'] in directory '/root'
2017-11-02 07:11:51,384 [salt.loaded.int.module.cmdmod][INFO    ][24244] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2017-11-02 07:11:51,393 [salt.state       ][INFO    ][24244] The service salt-minion is already running
2017-11-02 07:11:51,393 [salt.state       ][INFO    ][24244] Completed state [salt-minion] at time 07:11:51.393199 duration_in_ms=37.349
2017-11-02 07:11:51,395 [salt.state       ][INFO    ][24244] Running state [/etc/salt/grains.d] at time 07:11:51.394733
2017-11-02 07:11:51,395 [salt.state       ][INFO    ][24244] Executing state file.directory for /etc/salt/grains.d
2017-11-02 07:11:51,396 [salt.state       ][INFO    ][24244] Directory /etc/salt/grains.d is in the correct state
2017-11-02 07:11:51,396 [salt.state       ][INFO    ][24244] Completed state [/etc/salt/grains.d] at time 07:11:51.395865 duration_in_ms=1.133
2017-11-02 07:11:51,396 [salt.state       ][INFO    ][24244] Running state [/etc/salt/grains] at time 07:11:51.396362
2017-11-02 07:11:51,397 [salt.state       ][INFO    ][24244] Executing state file.managed for /etc/salt/grains
2017-11-02 07:11:51,397 [salt.state       ][INFO    ][24244] File /etc/salt/grains exists with proper permissions. No changes made.
2017-11-02 07:11:51,397 [salt.state       ][INFO    ][24244] Completed state [/etc/salt/grains] at time 07:11:51.397174 duration_in_ms=0.812
2017-11-02 07:11:51,398 [salt.state       ][INFO    ][24244] Running state [/etc/salt/grains.d/placeholder] at time 07:11:51.397497
2017-11-02 07:11:51,398 [salt.state       ][INFO    ][24244] Executing state file.managed for /etc/salt/grains.d/placeholder
2017-11-02 07:11:51,398 [salt.state       ][INFO    ][24244] File /etc/salt/grains.d/placeholder exists with proper permissions. No changes made.
2017-11-02 07:11:51,398 [salt.state       ][INFO    ][24244] Completed state [/etc/salt/grains.d/placeholder] at time 07:11:51.398329 duration_in_ms=0.832
2017-11-02 07:11:51,399 [salt.state       ][INFO    ][24244] Running state [/etc/salt/grains.d/sphinx] at time 07:11:51.398652
2017-11-02 07:11:51,399 [salt.state       ][INFO    ][24244] Executing state file.managed for /etc/salt/grains.d/sphinx
2017-11-02 07:11:51,421 [salt.state       ][INFO    ][24244] File changed:
--- 
+++ 
@@ -49,7 +49,6 @@
               - 10.167.4.142
               - 127.0.0.1
               - 192.168.11.254
-              - 192.168.122.1
         system:
           name: System
           param:

2017-11-02 07:11:51,421 [salt.state       ][INFO    ][24244] Completed state [/etc/salt/grains.d/sphinx] at time 07:11:51.421353 duration_in_ms=22.701
2017-11-02 07:11:51,422 [salt.state       ][INFO    ][24244] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 07:11:51.422027
2017-11-02 07:11:51,422 [salt.state       ][INFO    ][24244] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-11-02 07:11:51,422 [salt.state       ][INFO    ][24244] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-11-02 07:11:51,423 [salt.state       ][INFO    ][24244] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 07:11:51.422560 duration_in_ms=0.533
2017-11-02 07:11:51,423 [salt.state       ][INFO    ][24244] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 07:11:51.422693
2017-11-02 07:11:51,423 [salt.state       ][INFO    ][24244] Executing state cmd.mod_watch for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-11-02 07:11:51,423 [salt.loaded.int.module.cmdmod][INFO    ][24244] Executing command 'python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"' in directory '/root'
2017-11-02 07:11:51,504 [salt.state       ][INFO    ][24244] {'pid': 24292, 'retcode': 0, 'stderr': '', 'stdout': ''}
2017-11-02 07:11:51,504 [salt.state       ][INFO    ][24244] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 07:11:51.504415 duration_in_ms=81.721
2017-11-02 07:11:51,505 [salt.state       ][INFO    ][24244] Running state [/etc/salt/grains.d/dns_records] at time 07:11:51.505099
2017-11-02 07:11:51,506 [salt.state       ][INFO    ][24244] Executing state file.managed for /etc/salt/grains.d/dns_records
2017-11-02 07:11:51,553 [salt.state       ][INFO    ][24244] File /etc/salt/grains.d/dns_records is in the correct state
2017-11-02 07:11:51,554 [salt.state       ][INFO    ][24244] Completed state [/etc/salt/grains.d/dns_records] at time 07:11:51.553516 duration_in_ms=48.418
2017-11-02 07:11:51,554 [salt.state       ][INFO    ][24244] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 07:11:51.554197
2017-11-02 07:11:51,554 [salt.state       ][INFO    ][24244] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"
2017-11-02 07:11:51,555 [salt.state       ][INFO    ][24244] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"
2017-11-02 07:11:51,555 [salt.state       ][INFO    ][24244] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 07:11:51.554674 duration_in_ms=0.477
2017-11-02 07:11:51,555 [salt.state       ][INFO    ][24244] Running state [/etc/salt/grains.d/salt] at time 07:11:51.554938
2017-11-02 07:11:51,555 [salt.state       ][INFO    ][24244] Executing state file.managed for /etc/salt/grains.d/salt
2017-11-02 07:11:51,583 [salt.state       ][INFO    ][24244] File /etc/salt/grains.d/salt is in the correct state
2017-11-02 07:11:51,584 [salt.state       ][INFO    ][24244] Completed state [/etc/salt/grains.d/salt] at time 07:11:51.583504 duration_in_ms=28.565
2017-11-02 07:11:51,584 [salt.state       ][INFO    ][24244] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 07:11:51.584015
2017-11-02 07:11:51,584 [salt.state       ][INFO    ][24244] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2017-11-02 07:11:51,584 [salt.state       ][INFO    ][24244] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2017-11-02 07:11:51,585 [salt.state       ][INFO    ][24244] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 07:11:51.584488 duration_in_ms=0.473
2017-11-02 07:11:51,586 [salt.state       ][INFO    ][24244] Running state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 07:11:51.585686
2017-11-02 07:11:51,586 [salt.state       ][INFO    ][24244] Executing state cmd.wait for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-11-02 07:11:51,586 [salt.state       ][INFO    ][24244] No changes made for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-11-02 07:11:51,586 [salt.state       ][INFO    ][24244] Completed state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 07:11:51.586177 duration_in_ms=0.492
2017-11-02 07:11:51,586 [salt.state       ][INFO    ][24244] Running state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 07:11:51.586300
2017-11-02 07:11:51,586 [salt.state       ][INFO    ][24244] Executing state cmd.mod_watch for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-11-02 07:11:51,588 [salt.loaded.int.module.cmdmod][INFO    ][24244] Executing command 'cat /etc/salt/grains.d/* > /etc/salt/grains' in directory '/root'
2017-11-02 07:11:51,626 [salt.state       ][INFO    ][24244] {'pid': 24294, 'retcode': 0, 'stderr': '', 'stdout': ''}
2017-11-02 07:11:51,627 [salt.state       ][INFO    ][24244] Completed state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 07:11:51.626511 duration_in_ms=40.211
2017-11-02 07:11:51,627 [salt.state       ][INFO    ][24244] Running state [mine.update] at time 07:11:51.627070
2017-11-02 07:11:51,627 [salt.state       ][INFO    ][24244] Executing state module.wait for mine.update
2017-11-02 07:11:51,627 [salt.state       ][INFO    ][24244] No changes made for mine.update
2017-11-02 07:11:51,628 [salt.state       ][INFO    ][24244] Completed state [mine.update] at time 07:11:51.627597 duration_in_ms=0.526
2017-11-02 07:11:51,628 [salt.state       ][INFO    ][24244] Running state [mine.update] at time 07:11:51.627732
2017-11-02 07:11:51,628 [salt.state       ][INFO    ][24244] Executing state module.mod_watch for mine.update
2017-11-02 07:11:52,151 [salt.state       ][INFO    ][24244] {'ret': True}
2017-11-02 07:11:52,152 [salt.state       ][INFO    ][24244] Completed state [mine.update] at time 07:11:52.151485 duration_in_ms=523.753
2017-11-02 07:11:52,152 [salt.state       ][INFO    ][24244] Running state [ca-certificates] at time 07:11:52.151753
2017-11-02 07:11:52,152 [salt.state       ][INFO    ][24244] Executing state pkg.installed for ca-certificates
2017-11-02 07:11:52,168 [salt.state       ][INFO    ][24244] Package ca-certificates is already installed
2017-11-02 07:11:52,168 [salt.state       ][INFO    ][24244] Completed state [ca-certificates] at time 07:11:52.168311 duration_in_ms=16.558
2017-11-02 07:11:52,169 [salt.state       ][INFO    ][24244] Running state [update-ca-certificates] at time 07:11:52.168910
2017-11-02 07:11:52,169 [salt.state       ][INFO    ][24244] Executing state cmd.wait for update-ca-certificates
2017-11-02 07:11:52,169 [salt.state       ][INFO    ][24244] No changes made for update-ca-certificates
2017-11-02 07:11:52,170 [salt.state       ][INFO    ][24244] Completed state [update-ca-certificates] at time 07:11:52.169532 duration_in_ms=0.623
2017-11-02 07:11:52,170 [salt.state       ][INFO    ][24244] Running state [libvirt-dev] at time 07:11:52.169736
2017-11-02 07:11:52,170 [salt.state       ][INFO    ][24244] Executing state pkg.installed for libvirt-dev
2017-11-02 07:11:52,173 [salt.state       ][INFO    ][24244] Package libvirt-dev is already installed
2017-11-02 07:11:52,177 [salt.state       ][INFO    ][24244] Completed state [libvirt-dev] at time 07:11:52.176980 duration_in_ms=7.242
2017-11-02 07:11:52,177 [salt.state       ][INFO    ][24244] Running state [pkg-config] at time 07:11:52.177319
2017-11-02 07:11:52,178 [salt.state       ][INFO    ][24244] Executing state pkg.installed for pkg-config
2017-11-02 07:11:52,180 [salt.state       ][INFO    ][24244] Package pkg-config is already installed
2017-11-02 07:11:52,180 [salt.state       ][INFO    ][24244] Completed state [pkg-config] at time 07:11:52.180417 duration_in_ms=3.098
2017-11-02 07:11:52,181 [salt.state       ][INFO    ][24244] Running state [virtng.init] at time 07:11:52.180613
2017-11-02 07:11:52,181 [salt.state       ][INFO    ][24244] Executing state module.run for virtng.init
2017-11-02 07:11:52,264 [salt.loaded.int.module.cmdmod][INFO    ][24244] Executing command ['git', '--version'] in directory '/root'
2017-11-02 07:11:52,386 [salt.loaded.int.module.cmdmod][INFO    ][24244] Executing command 'virsh list --all --name| grep -E "^mdb02.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-11-02 07:11:52,406 [salt.state       ][INFO    ][24244] unless execution succeeded
2017-11-02 07:11:52,412 [salt.state       ][INFO    ][24244] Completed state [virtng.init] at time 07:11:52.411594 duration_in_ms=230.98
2017-11-02 07:11:52,412 [salt.state       ][INFO    ][24244] Running state [virt.set_autostart] at time 07:11:52.411896
2017-11-02 07:11:52,412 [salt.state       ][INFO    ][24244] Executing state module.run for virt.set_autostart
2017-11-02 07:11:52,414 [salt.loaded.int.module.cmdmod][INFO    ][24244] Executing command 'virsh list --autostart --name| grep -E "^mdb02.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-11-02 07:11:52,432 [salt.state       ][INFO    ][24244] unless execution succeeded
2017-11-02 07:11:52,433 [salt.state       ][INFO    ][24244] Completed state [virt.set_autostart] at time 07:11:52.432454 duration_in_ms=20.557
2017-11-02 07:11:52,433 [salt.state       ][INFO    ][24244] Running state [virtng.init] at time 07:11:52.432713
2017-11-02 07:11:52,433 [salt.state       ][INFO    ][24244] Executing state module.run for virtng.init
2017-11-02 07:11:52,435 [salt.loaded.int.module.cmdmod][INFO    ][24244] Executing command 'virsh list --all --name| grep -E "^dbs02.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-11-02 07:11:52,451 [salt.state       ][INFO    ][24244] unless execution succeeded
2017-11-02 07:11:52,455 [salt.state       ][INFO    ][24244] Completed state [virtng.init] at time 07:11:52.454630 duration_in_ms=21.916
2017-11-02 07:11:52,455 [salt.state       ][INFO    ][24244] Running state [virt.set_autostart] at time 07:11:52.454888
2017-11-02 07:11:52,455 [salt.state       ][INFO    ][24244] Executing state module.run for virt.set_autostart
2017-11-02 07:11:52,457 [salt.loaded.int.module.cmdmod][INFO    ][24244] Executing command 'virsh list --autostart --name| grep -E "^dbs02.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-11-02 07:11:52,473 [salt.state       ][INFO    ][24244] unless execution succeeded
2017-11-02 07:11:52,484 [salt.state       ][INFO    ][24244] Completed state [virt.set_autostart] at time 07:11:52.483907 duration_in_ms=29.019
2017-11-02 07:11:52,484 [salt.state       ][INFO    ][24244] Running state [virtng.init] at time 07:11:52.484193
2017-11-02 07:11:52,484 [salt.state       ][INFO    ][24244] Executing state module.run for virtng.init
2017-11-02 07:11:52,486 [salt.loaded.int.module.cmdmod][INFO    ][24244] Executing command 'virsh list --all --name| grep -E "^ctl02.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-11-02 07:11:52,501 [salt.state       ][INFO    ][24244] unless execution succeeded
2017-11-02 07:11:52,501 [salt.state       ][INFO    ][24244] Completed state [virtng.init] at time 07:11:52.500710 duration_in_ms=16.517
2017-11-02 07:11:52,501 [salt.state       ][INFO    ][24244] Running state [virt.set_autostart] at time 07:11:52.500945
2017-11-02 07:11:52,501 [salt.state       ][INFO    ][24244] Executing state module.run for virt.set_autostart
2017-11-02 07:11:52,503 [salt.loaded.int.module.cmdmod][INFO    ][24244] Executing command 'virsh list --autostart --name| grep -E "^ctl02.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-11-02 07:11:52,518 [salt.state       ][INFO    ][24244] unless execution succeeded
2017-11-02 07:11:52,532 [salt.state       ][INFO    ][24244] Completed state [virt.set_autostart] at time 07:11:52.532040 duration_in_ms=31.094
2017-11-02 07:11:52,532 [salt.state       ][INFO    ][24244] Running state [virtng.init] at time 07:11:52.532316
2017-11-02 07:11:52,533 [salt.state       ][INFO    ][24244] Executing state module.run for virtng.init
2017-11-02 07:11:52,535 [salt.loaded.int.module.cmdmod][INFO    ][24244] Executing command 'virsh list --all --name| grep -E "^msg02.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-11-02 07:11:52,549 [salt.state       ][INFO    ][24244] unless execution succeeded
2017-11-02 07:11:52,550 [salt.state       ][INFO    ][24244] Completed state [virtng.init] at time 07:11:52.549555 duration_in_ms=17.238
2017-11-02 07:11:52,550 [salt.state       ][INFO    ][24244] Running state [virt.set_autostart] at time 07:11:52.549812
2017-11-02 07:11:52,550 [salt.state       ][INFO    ][24244] Executing state module.run for virt.set_autostart
2017-11-02 07:11:52,552 [salt.loaded.int.module.cmdmod][INFO    ][24244] Executing command 'virsh list --autostart --name| grep -E "^msg02.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-11-02 07:11:52,566 [salt.state       ][INFO    ][24244] unless execution succeeded
2017-11-02 07:11:52,569 [salt.state       ][INFO    ][24244] Completed state [virt.set_autostart] at time 07:11:52.568835 duration_in_ms=19.023
2017-11-02 07:11:52,571 [salt.minion      ][INFO    ][24244] Returning information for job: 20171102071148070941
2017-11-02 07:12:19,383 [salt.minion      ][INFO    ][23994] User sudo_ubuntu Executing command state.sls with jid 20171102071219380173
2017-11-02 07:12:19,397 [salt.minion      ][INFO    ][24356] Starting a new job with PID 24356
2017-11-02 07:12:20,977 [salt.state       ][INFO    ][24356] Loading fresh modules for state activity
2017-11-02 07:12:21,003 [salt.fileclient  ][INFO    ][24356] Fetching file from saltenv 'base', ** done ** 'salt/control/init.sls'
2017-11-02 07:12:21,022 [salt.fileclient  ][INFO    ][24356] Fetching file from saltenv 'base', ** done ** 'salt/control/virt.sls'
2017-11-02 07:12:21,085 [salt.fileclient  ][INFO    ][24356] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-11-02 07:12:21,147 [salt.fileclient  ][INFO    ][24356] Fetching file from saltenv 'base', ** done ** 'salt/minion/init.sls'
2017-11-02 07:12:21,161 [salt.fileclient  ][INFO    ][24356] Fetching file from saltenv 'base', ** done ** 'salt/minion/service.sls'
2017-11-02 07:12:21,314 [salt.fileclient  ][INFO    ][24356] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-11-02 07:12:21,367 [salt.fileclient  ][INFO    ][24356] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-11-02 07:12:21,385 [salt.fileclient  ][INFO    ][24356] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-11-02 07:12:21,429 [salt.fileclient  ][INFO    ][24356] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-11-02 07:12:21,448 [salt.fileclient  ][INFO    ][24356] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-11-02 07:12:21,595 [salt.fileclient  ][INFO    ][24356] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-11-02 07:12:21,611 [salt.fileclient  ][INFO    ][24356] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-11-02 07:12:21,618 [salt.loaded.int.module.cmdmod][INFO    ][24356] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-11-02 07:12:21,641 [salt.fileclient  ][INFO    ][24356] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-11-02 07:12:21,657 [py.warnings      ][WARNING ][24356] /usr/lib/python2.7/dist-packages/salt/utils/templates.py:73: DeprecationWarning: Starting in 2015.5, cmd.run uses python_shell=False by default, which doesn't support shellisms (pipes, env variables, etc). cmd.run is currently aliased to cmd.shell to prevent breakage. Please switch to cmd.shell or set python_shell=True to avoid breakage in the future, when this aliasing is removed.

2017-11-02 07:12:21,657 [salt.loaded.int.module.cmdmod][INFO    ][24356] Executing command 'salt-minion --version' in directory '/root'
2017-11-02 07:12:21,894 [salt.fileclient  ][INFO    ][24356] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-11-02 07:12:21,910 [salt.fileclient  ][INFO    ][24356] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-11-02 07:12:21,919 [salt.fileclient  ][INFO    ][24356] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-11-02 07:12:21,929 [salt.fileclient  ][INFO    ][24356] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-11-02 07:12:21,981 [salt.fileclient  ][INFO    ][24356] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-11-02 07:12:22,012 [salt.fileclient  ][INFO    ][24356] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-11-02 07:12:22,067 [salt.fileclient  ][INFO    ][24356] Fetching file from saltenv 'base', ** done ** 'salt/minion/grains.sls'
2017-11-02 07:12:22,137 [salt.fileclient  ][INFO    ][24356] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-11-02 07:12:22,191 [salt.fileclient  ][INFO    ][24356] Fetching file from saltenv 'base', ** done ** 'linux/meta/salt.yml'
2017-11-02 07:12:22,209 [salt.fileclient  ][INFO    ][24356] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-11-02 07:12:22,250 [salt.fileclient  ][INFO    ][24356] Fetching file from saltenv 'base', ** done ** 'linux/meta/sphinx.yml'
2017-11-02 07:12:22,268 [salt.fileclient  ][INFO    ][24356] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/sphinx.yml'
2017-11-02 07:12:22,389 [salt.fileclient  ][INFO    ][24356] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-11-02 07:12:22,404 [salt.fileclient  ][INFO    ][24356] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/sphinx.yml'
2017-11-02 07:12:22,411 [salt.loaded.int.module.cmdmod][INFO    ][24356] Executing command 'gluster --version 2>/dev/null || echo "unknown" |head -1' in directory '/root'
2017-11-02 07:12:22,431 [salt.fileclient  ][INFO    ][24356] Fetching file from saltenv 'base', ** done ** 'salt/meta/sphinx.yml'
2017-11-02 07:12:22,446 [salt.loaded.int.module.cmdmod][INFO    ][24356] Executing command 'salt-minion --version' in directory '/root'
2017-11-02 07:12:22,714 [salt.fileclient  ][INFO    ][24356] Fetching file from saltenv 'base', ** done ** 'keepalived/meta/salt.yml'
2017-11-02 07:12:22,733 [salt.fileclient  ][INFO    ][24356] Fetching file from saltenv 'base', ** done ** 'glusterfs/meta/salt.yml'
2017-11-02 07:12:22,806 [salt.fileclient  ][INFO    ][24356] Fetching file from saltenv 'base', ** done ** 'openssh/meta/salt.yml'
2017-11-02 07:12:22,818 [salt.fileclient  ][INFO    ][24356] Fetching file from saltenv 'base', ** done ** 'salt/meta/salt.yml'
2017-11-02 07:12:22,862 [salt.fileclient  ][INFO    ][24356] Fetching file from saltenv 'base', ** done ** 'linux/meta/meta.yml'
2017-11-02 07:12:22,911 [salt.fileclient  ][INFO    ][24356] Fetching file from saltenv 'base', ** done ** 'salt/meta/meta.yml'
2017-11-02 07:12:22,973 [salt.fileclient  ][INFO    ][24356] Fetching file from saltenv 'base', ** done ** 'salt/minion/cert.sls'
2017-11-02 07:12:23,031 [salt.fileclient  ][INFO    ][24356] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-11-02 07:12:23,334 [salt.state       ][INFO    ][24356] Running state [salt-minion] at time 07:12:23.333671
2017-11-02 07:12:23,334 [salt.state       ][INFO    ][24356] Executing state pkg.installed for salt-minion
2017-11-02 07:12:23,335 [salt.loaded.int.module.cmdmod][INFO    ][24356] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-02 07:12:23,625 [salt.state       ][INFO    ][24356] Package salt-minion is already installed
2017-11-02 07:12:23,625 [salt.state       ][INFO    ][24356] Completed state [salt-minion] at time 07:12:23.625424 duration_in_ms=291.753
2017-11-02 07:12:23,626 [salt.state       ][INFO    ][24356] Running state [salt_minion_dependency_packages] at time 07:12:23.625693
2017-11-02 07:12:23,626 [salt.state       ][INFO    ][24356] Executing state pkg.installed for salt_minion_dependency_packages
2017-11-02 07:12:23,629 [salt.state       ][INFO    ][24356] All specified packages are already installed
2017-11-02 07:12:23,629 [salt.state       ][INFO    ][24356] Completed state [salt_minion_dependency_packages] at time 07:12:23.628799 duration_in_ms=3.105
2017-11-02 07:12:23,630 [salt.state       ][INFO    ][24356] Running state [/etc/salt/minion.d/minion.conf] at time 07:12:23.630371
2017-11-02 07:12:23,631 [salt.state       ][INFO    ][24356] Executing state file.managed for /etc/salt/minion.d/minion.conf
2017-11-02 07:12:23,655 [salt.fileclient  ][INFO    ][24356] Fetching file from saltenv 'base', ** done ** 'salt/files/minion.conf'
2017-11-02 07:12:23,701 [salt.fileclient  ][INFO    ][24356] Fetching file from saltenv 'base', ** done ** 'salt/map.jinja'
2017-11-02 07:12:23,744 [salt.fileclient  ][INFO    ][24356] Fetching file from saltenv 'base', ** done ** 'linux/map.jinja'
2017-11-02 07:12:23,777 [salt.state       ][INFO    ][24356] File /etc/salt/minion.d/minion.conf is in the correct state
2017-11-02 07:12:23,777 [salt.state       ][INFO    ][24356] Completed state [/etc/salt/minion.d/minion.conf] at time 07:12:23.776991 duration_in_ms=146.619
2017-11-02 07:12:23,777 [salt.state       ][INFO    ][24356] Running state [/etc/salt/minion.d/_virt.conf] at time 07:12:23.777273
2017-11-02 07:12:23,777 [salt.state       ][INFO    ][24356] Executing state file.managed for /etc/salt/minion.d/_virt.conf
2017-11-02 07:12:23,834 [salt.state       ][INFO    ][24356] File /etc/salt/minion.d/_virt.conf is in the correct state
2017-11-02 07:12:23,834 [salt.state       ][INFO    ][24356] Completed state [/etc/salt/minion.d/_virt.conf] at time 07:12:23.833925 duration_in_ms=56.653
2017-11-02 07:12:23,835 [salt.state       ][INFO    ][24356] Running state [salt-minion] at time 07:12:23.835317
2017-11-02 07:12:23,836 [salt.state       ][INFO    ][24356] Executing state service.running for salt-minion
2017-11-02 07:12:23,836 [salt.loaded.int.module.cmdmod][INFO    ][24356] Executing command ['systemctl', 'status', 'salt-minion.service', '-n', '0'] in directory '/root'
2017-11-02 07:12:23,852 [salt.loaded.int.module.cmdmod][INFO    ][24356] Executing command ['systemctl', 'is-active', 'salt-minion.service'] in directory '/root'
2017-11-02 07:12:23,862 [salt.loaded.int.module.cmdmod][INFO    ][24356] Executing command ['systemctl', 'is-enabled', 'salt-minion.service'] in directory '/root'
2017-11-02 07:12:23,870 [salt.state       ][INFO    ][24356] The service salt-minion is already running
2017-11-02 07:12:23,871 [salt.state       ][INFO    ][24356] Completed state [salt-minion] at time 07:12:23.870516 duration_in_ms=35.197
2017-11-02 07:12:23,872 [salt.state       ][INFO    ][24356] Running state [/etc/salt/grains.d] at time 07:12:23.871800
2017-11-02 07:12:23,872 [salt.state       ][INFO    ][24356] Executing state file.directory for /etc/salt/grains.d
2017-11-02 07:12:23,873 [salt.state       ][INFO    ][24356] Directory /etc/salt/grains.d is in the correct state
2017-11-02 07:12:23,873 [salt.state       ][INFO    ][24356] Completed state [/etc/salt/grains.d] at time 07:12:23.872656 duration_in_ms=0.855
2017-11-02 07:12:23,873 [salt.state       ][INFO    ][24356] Running state [/etc/salt/grains] at time 07:12:23.873059
2017-11-02 07:12:23,873 [salt.state       ][INFO    ][24356] Executing state file.managed for /etc/salt/grains
2017-11-02 07:12:23,874 [salt.state       ][INFO    ][24356] File /etc/salt/grains exists with proper permissions. No changes made.
2017-11-02 07:12:23,874 [salt.state       ][INFO    ][24356] Completed state [/etc/salt/grains] at time 07:12:23.873691 duration_in_ms=0.632
2017-11-02 07:12:23,874 [salt.state       ][INFO    ][24356] Running state [/etc/salt/grains.d/placeholder] at time 07:12:23.873970
2017-11-02 07:12:23,874 [salt.state       ][INFO    ][24356] Executing state file.managed for /etc/salt/grains.d/placeholder
2017-11-02 07:12:23,874 [salt.state       ][INFO    ][24356] File /etc/salt/grains.d/placeholder exists with proper permissions. No changes made.
2017-11-02 07:12:23,875 [salt.state       ][INFO    ][24356] Completed state [/etc/salt/grains.d/placeholder] at time 07:12:23.874585 duration_in_ms=0.614
2017-11-02 07:12:23,875 [salt.state       ][INFO    ][24356] Running state [/etc/salt/grains.d/sphinx] at time 07:12:23.874851
2017-11-02 07:12:23,875 [salt.state       ][INFO    ][24356] Executing state file.managed for /etc/salt/grains.d/sphinx
2017-11-02 07:12:23,923 [salt.state       ][INFO    ][24356] File /etc/salt/grains.d/sphinx is in the correct state
2017-11-02 07:12:23,924 [salt.state       ][INFO    ][24356] Completed state [/etc/salt/grains.d/sphinx] at time 07:12:23.923500 duration_in_ms=48.649
2017-11-02 07:12:23,924 [salt.state       ][INFO    ][24356] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 07:12:23.924040
2017-11-02 07:12:23,924 [salt.state       ][INFO    ][24356] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-11-02 07:12:23,924 [salt.state       ][INFO    ][24356] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"
2017-11-02 07:12:23,925 [salt.state       ][INFO    ][24356] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/sphinx', 'r'); yaml.load(stream); stream.close()"] at time 07:12:23.924538 duration_in_ms=0.498
2017-11-02 07:12:23,925 [salt.state       ][INFO    ][24356] Running state [/etc/salt/grains.d/dns_records] at time 07:12:23.924802
2017-11-02 07:12:23,925 [salt.state       ][INFO    ][24356] Executing state file.managed for /etc/salt/grains.d/dns_records
2017-11-02 07:12:24,013 [salt.state       ][INFO    ][24356] File /etc/salt/grains.d/dns_records is in the correct state
2017-11-02 07:12:24,013 [salt.state       ][INFO    ][24356] Completed state [/etc/salt/grains.d/dns_records] at time 07:12:24.013316 duration_in_ms=88.514
2017-11-02 07:12:24,014 [salt.state       ][INFO    ][24356] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 07:12:24.013904
2017-11-02 07:12:24,014 [salt.state       ][INFO    ][24356] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"
2017-11-02 07:12:24,014 [salt.state       ][INFO    ][24356] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"
2017-11-02 07:12:24,014 [salt.state       ][INFO    ][24356] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/dns_records', 'r'); yaml.load(stream); stream.close()"] at time 07:12:24.014439 duration_in_ms=0.535
2017-11-02 07:12:24,015 [salt.state       ][INFO    ][24356] Running state [/etc/salt/grains.d/salt] at time 07:12:24.014725
2017-11-02 07:12:24,015 [salt.state       ][INFO    ][24356] Executing state file.managed for /etc/salt/grains.d/salt
2017-11-02 07:12:24,043 [salt.state       ][INFO    ][24356] File /etc/salt/grains.d/salt is in the correct state
2017-11-02 07:12:24,043 [salt.state       ][INFO    ][24356] Completed state [/etc/salt/grains.d/salt] at time 07:12:24.043429 duration_in_ms=28.703
2017-11-02 07:12:24,044 [salt.state       ][INFO    ][24356] Running state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 07:12:24.044000
2017-11-02 07:12:24,044 [salt.state       ][INFO    ][24356] Executing state cmd.wait for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2017-11-02 07:12:24,044 [salt.state       ][INFO    ][24356] No changes made for python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"
2017-11-02 07:12:24,045 [salt.state       ][INFO    ][24356] Completed state [python -c "import yaml; stream = file('/etc/salt/grains.d/salt', 'r'); yaml.load(stream); stream.close()"] at time 07:12:24.044547 duration_in_ms=0.548
2017-11-02 07:12:24,046 [salt.state       ][INFO    ][24356] Running state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 07:12:24.045773
2017-11-02 07:12:24,046 [salt.state       ][INFO    ][24356] Executing state cmd.wait for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-11-02 07:12:24,046 [salt.state       ][INFO    ][24356] No changes made for cat /etc/salt/grains.d/* > /etc/salt/grains
2017-11-02 07:12:24,046 [salt.state       ][INFO    ][24356] Completed state [cat /etc/salt/grains.d/* > /etc/salt/grains] at time 07:12:24.046316 duration_in_ms=0.543
2017-11-02 07:12:24,047 [salt.state       ][INFO    ][24356] Running state [mine.update] at time 07:12:24.046735
2017-11-02 07:12:24,047 [salt.state       ][INFO    ][24356] Executing state module.wait for mine.update
2017-11-02 07:12:24,047 [salt.state       ][INFO    ][24356] No changes made for mine.update
2017-11-02 07:12:24,047 [salt.state       ][INFO    ][24356] Completed state [mine.update] at time 07:12:24.047225 duration_in_ms=0.49
2017-11-02 07:12:24,047 [salt.state       ][INFO    ][24356] Running state [ca-certificates] at time 07:12:24.047384
2017-11-02 07:12:24,048 [salt.state       ][INFO    ][24356] Executing state pkg.installed for ca-certificates
2017-11-02 07:12:24,051 [salt.state       ][INFO    ][24356] Package ca-certificates is already installed
2017-11-02 07:12:24,051 [salt.state       ][INFO    ][24356] Completed state [ca-certificates] at time 07:12:24.050698 duration_in_ms=3.313
2017-11-02 07:12:24,051 [salt.state       ][INFO    ][24356] Running state [update-ca-certificates] at time 07:12:24.051141
2017-11-02 07:12:24,051 [salt.state       ][INFO    ][24356] Executing state cmd.wait for update-ca-certificates
2017-11-02 07:12:24,052 [salt.state       ][INFO    ][24356] No changes made for update-ca-certificates
2017-11-02 07:12:24,052 [salt.state       ][INFO    ][24356] Completed state [update-ca-certificates] at time 07:12:24.051676 duration_in_ms=0.535
2017-11-02 07:12:24,052 [salt.state       ][INFO    ][24356] Running state [libvirt-dev] at time 07:12:24.051837
2017-11-02 07:12:24,052 [salt.state       ][INFO    ][24356] Executing state pkg.installed for libvirt-dev
2017-11-02 07:12:24,055 [salt.state       ][INFO    ][24356] Package libvirt-dev is already installed
2017-11-02 07:12:24,055 [salt.state       ][INFO    ][24356] Completed state [libvirt-dev] at time 07:12:24.054761 duration_in_ms=2.923
2017-11-02 07:12:24,055 [salt.state       ][INFO    ][24356] Running state [pkg-config] at time 07:12:24.054924
2017-11-02 07:12:24,055 [salt.state       ][INFO    ][24356] Executing state pkg.installed for pkg-config
2017-11-02 07:12:24,058 [salt.state       ][INFO    ][24356] Package pkg-config is already installed
2017-11-02 07:12:24,058 [salt.state       ][INFO    ][24356] Completed state [pkg-config] at time 07:12:24.057830 duration_in_ms=2.905
2017-11-02 07:12:24,058 [salt.state       ][INFO    ][24356] Running state [virtng.init] at time 07:12:24.057994
2017-11-02 07:12:24,058 [salt.state       ][INFO    ][24356] Executing state module.run for virtng.init
2017-11-02 07:12:24,098 [salt.loaded.int.module.cmdmod][INFO    ][24356] Executing command ['git', '--version'] in directory '/root'
2017-11-02 07:12:24,178 [salt.loaded.int.module.cmdmod][INFO    ][24356] Executing command 'virsh list --all --name| grep -E "^mdb02.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-11-02 07:12:24,194 [salt.state       ][INFO    ][24356] unless execution succeeded
2017-11-02 07:12:24,194 [salt.state       ][INFO    ][24356] Completed state [virtng.init] at time 07:12:24.194416 duration_in_ms=136.421
2017-11-02 07:12:24,195 [salt.state       ][INFO    ][24356] Running state [virt.set_autostart] at time 07:12:24.194701
2017-11-02 07:12:24,195 [salt.state       ][INFO    ][24356] Executing state module.run for virt.set_autostart
2017-11-02 07:12:24,197 [salt.loaded.int.module.cmdmod][INFO    ][24356] Executing command 'virsh list --autostart --name| grep -E "^mdb02.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-11-02 07:12:24,212 [salt.state       ][INFO    ][24356] unless execution succeeded
2017-11-02 07:12:24,212 [salt.state       ][INFO    ][24356] Completed state [virt.set_autostart] at time 07:12:24.212439 duration_in_ms=17.736
2017-11-02 07:12:24,213 [salt.state       ][INFO    ][24356] Running state [virtng.init] at time 07:12:24.212709
2017-11-02 07:12:24,213 [salt.state       ][INFO    ][24356] Executing state module.run for virtng.init
2017-11-02 07:12:24,215 [salt.loaded.int.module.cmdmod][INFO    ][24356] Executing command 'virsh list --all --name| grep -E "^dbs02.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-11-02 07:12:24,228 [salt.state       ][INFO    ][24356] unless execution succeeded
2017-11-02 07:12:24,228 [salt.state       ][INFO    ][24356] Completed state [virtng.init] at time 07:12:24.228144 duration_in_ms=15.434
2017-11-02 07:12:24,228 [salt.state       ][INFO    ][24356] Running state [virt.set_autostart] at time 07:12:24.228412
2017-11-02 07:12:24,229 [salt.state       ][INFO    ][24356] Executing state module.run for virt.set_autostart
2017-11-02 07:12:24,231 [salt.loaded.int.module.cmdmod][INFO    ][24356] Executing command 'virsh list --autostart --name| grep -E "^dbs02.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-11-02 07:12:24,244 [salt.state       ][INFO    ][24356] unless execution succeeded
2017-11-02 07:12:24,245 [salt.state       ][INFO    ][24356] Completed state [virt.set_autostart] at time 07:12:24.244651 duration_in_ms=16.239
2017-11-02 07:12:24,245 [salt.state       ][INFO    ][24356] Running state [virtng.init] at time 07:12:24.244931
2017-11-02 07:12:24,245 [salt.state       ][INFO    ][24356] Executing state module.run for virtng.init
2017-11-02 07:12:24,247 [salt.loaded.int.module.cmdmod][INFO    ][24356] Executing command 'virsh list --all --name| grep -E "^ctl02.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-11-02 07:12:24,261 [salt.state       ][INFO    ][24356] unless execution succeeded
2017-11-02 07:12:24,262 [salt.state       ][INFO    ][24356] Completed state [virtng.init] at time 07:12:24.261660 duration_in_ms=16.727
2017-11-02 07:12:24,262 [salt.state       ][INFO    ][24356] Running state [virt.set_autostart] at time 07:12:24.261950
2017-11-02 07:12:24,262 [salt.state       ][INFO    ][24356] Executing state module.run for virt.set_autostart
2017-11-02 07:12:24,264 [salt.loaded.int.module.cmdmod][INFO    ][24356] Executing command 'virsh list --autostart --name| grep -E "^ctl02.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-11-02 07:12:24,279 [salt.state       ][INFO    ][24356] unless execution succeeded
2017-11-02 07:12:24,279 [salt.state       ][INFO    ][24356] Completed state [virt.set_autostart] at time 07:12:24.278813 duration_in_ms=16.862
2017-11-02 07:12:24,279 [salt.state       ][INFO    ][24356] Running state [virtng.init] at time 07:12:24.279087
2017-11-02 07:12:24,279 [salt.state       ][INFO    ][24356] Executing state module.run for virtng.init
2017-11-02 07:12:24,281 [salt.loaded.int.module.cmdmod][INFO    ][24356] Executing command 'virsh list --all --name| grep -E "^msg02.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-11-02 07:12:24,296 [salt.state       ][INFO    ][24356] unless execution succeeded
2017-11-02 07:12:24,396 [salt.state       ][INFO    ][24356] Completed state [virtng.init] at time 07:12:24.395870 duration_in_ms=116.782
2017-11-02 07:12:24,396 [salt.state       ][INFO    ][24356] Running state [virt.set_autostart] at time 07:12:24.396251
2017-11-02 07:12:24,396 [salt.state       ][INFO    ][24356] Executing state module.run for virt.set_autostart
2017-11-02 07:12:24,398 [salt.loaded.int.module.cmdmod][INFO    ][24356] Executing command 'virsh list --autostart --name| grep -E "^msg02.baremetal-mcp-ocata-odl-ha.local$"' in directory '/root'
2017-11-02 07:12:24,415 [salt.state       ][INFO    ][24356] unless execution succeeded
2017-11-02 07:12:24,415 [salt.state       ][INFO    ][24356] Completed state [virt.set_autostart] at time 07:12:24.415338 duration_in_ms=19.087
2017-11-02 07:12:24,417 [salt.minion      ][INFO    ][24356] Returning information for job: 20171102071219380173
2017-11-02 07:13:21,030 [salt.minion      ][INFO    ][23994] User sudo_ubuntu Executing command saltutil.sync_all with jid 20171102071321034607
2017-11-02 07:13:21,049 [salt.minion      ][INFO    ][24450] Starting a new job with PID 24450
2017-11-02 07:13:24,315 [salt.state       ][INFO    ][24450] Loading fresh modules for state activity
2017-11-02 07:13:24,610 [salt.state       ][ERROR   ][24450] No contents found in top file
2017-11-02 07:13:24,611 [salt.utils.extmods][INFO    ][24450] Creating module dir '/var/cache/salt/minion/extmods/beacons'
2017-11-02 07:13:24,614 [salt.utils.extmods][INFO    ][24450] Syncing beacons for environment 'base'
2017-11-02 07:13:24,614 [salt.utils.extmods][INFO    ][24450] Loading cache from salt://_beacons, for base)
2017-11-02 07:13:24,614 [salt.fileclient  ][INFO    ][24450] Caching directory '_beacons/' for environment 'base'
2017-11-02 07:13:24,635 [salt.utils.extmods][INFO    ][24450] Syncing modules for environment 'base'
2017-11-02 07:13:24,635 [salt.utils.extmods][INFO    ][24450] Loading cache from salt://_modules, for base)
2017-11-02 07:13:24,635 [salt.fileclient  ][INFO    ][24450] Caching directory '_modules/' for environment 'base'
2017-11-02 07:13:24,856 [salt.fileclient  ][INFO    ][24450] Fetching file from saltenv 'base', ** done ** '_modules/ceph_ng.py'
2017-11-02 07:13:24,871 [salt.fileclient  ][INFO    ][24450] Fetching file from saltenv 'base', ** done ** '_modules/cinderng.py'
2017-11-02 07:13:24,905 [salt.fileclient  ][INFO    ][24450] Fetching file from saltenv 'base', ** done ** '_modules/contrail.py'
2017-11-02 07:13:24,930 [salt.fileclient  ][INFO    ][24450] Fetching file from saltenv 'base', ** done ** '_modules/creds.py'
2017-11-02 07:13:25,007 [salt.fileclient  ][INFO    ][24450] Fetching file from saltenv 'base', ** done ** '_modules/devops_utils.py'
2017-11-02 07:13:25,041 [salt.fileclient  ][INFO    ][24450] Fetching file from saltenv 'base', ** done ** '_modules/encode_json.py'
2017-11-02 07:13:25,145 [salt.fileclient  ][INFO    ][24450] Fetching file from saltenv 'base', ** done ** '_modules/gerrit.py'
2017-11-02 07:13:25,183 [salt.fileclient  ][INFO    ][24450] Fetching file from saltenv 'base', ** done ** '_modules/glanceng.py'
2017-11-02 07:13:25,204 [salt.fileclient  ][INFO    ][24450] Fetching file from saltenv 'base', ** done ** '_modules/heat.py'
2017-11-02 07:13:25,245 [salt.fileclient  ][INFO    ][24450] Fetching file from saltenv 'base', ** done ** '_modules/heka_alarming.py'
2017-11-02 07:13:25,273 [salt.fileclient  ][INFO    ][24450] Fetching file from saltenv 'base', ** done ** '_modules/helm.py'
2017-11-02 07:13:25,321 [salt.fileclient  ][INFO    ][24450] Fetching file from saltenv 'base', ** done ** '_modules/jenkins_common.py'
2017-11-02 07:13:25,366 [salt.fileclient  ][INFO    ][24450] Fetching file from saltenv 'base', ** done ** '_modules/keystone_policy.py'
2017-11-02 07:13:25,389 [salt.fileclient  ][INFO    ][24450] Fetching file from saltenv 'base', ** done ** '_modules/linux_hosts.py'
2017-11-02 07:13:25,403 [salt.fileclient  ][INFO    ][24450] Fetching file from saltenv 'base', ** done ** '_modules/linux_netlink.py'
2017-11-02 07:13:25,442 [salt.fileclient  ][INFO    ][24450] Fetching file from saltenv 'base', ** done ** '_modules/maas.py'
2017-11-02 07:13:25,468 [salt.fileclient  ][INFO    ][24450] Fetching file from saltenv 'base', ** done ** '_modules/maas_client.py'
2017-11-02 07:13:25,525 [salt.fileclient  ][INFO    ][24450] Fetching file from saltenv 'base', ** done ** '_modules/multipart.py'
2017-11-02 07:13:25,537 [salt.fileclient  ][INFO    ][24450] Fetching file from saltenv 'base', ** done ** '_modules/nagios_alarming.py'
2017-11-02 07:13:25,561 [salt.fileclient  ][INFO    ][24450] Fetching file from saltenv 'base', ** done ** '_modules/neutronng.py'
2017-11-02 07:13:25,585 [salt.fileclient  ][INFO    ][24450] Fetching file from saltenv 'base', ** done ** '_modules/novang.py'
2017-11-02 07:13:25,636 [salt.fileclient  ][INFO    ][24450] Fetching file from saltenv 'base', ** done ** '_modules/reclass.py'
2017-11-02 07:13:25,678 [salt.fileclient  ][INFO    ][24450] Fetching file from saltenv 'base', ** done ** '_modules/rsyslog_util.py'
2017-11-02 07:13:25,700 [salt.fileclient  ][INFO    ][24450] Fetching file from saltenv 'base', ** done ** '_modules/rundeck.py'
2017-11-02 07:13:25,735 [salt.fileclient  ][INFO    ][24450] Fetching file from saltenv 'base', ** done ** '_modules/saltkey.py'
2017-11-02 07:13:25,751 [salt.fileclient  ][INFO    ][24450] Fetching file from saltenv 'base', ** done ** '_modules/saltresource.py'
2017-11-02 07:13:25,777 [salt.fileclient  ][INFO    ][24450] Fetching file from saltenv 'base', ** done ** '_modules/seedng.py'
2017-11-02 07:13:25,822 [salt.fileclient  ][INFO    ][24450] Fetching file from saltenv 'base', ** done ** '_modules/testing/credentials.py'
2017-11-02 07:13:25,841 [salt.fileclient  ][INFO    ][24450] Fetching file from saltenv 'base', ** done ** '_modules/testing/django.py'
2017-11-02 07:13:25,858 [salt.fileclient  ][INFO    ][24450] Fetching file from saltenv 'base', ** done ** '_modules/testing/django_client_proxy.py'
2017-11-02 07:13:25,873 [salt.fileclient  ][INFO    ][24450] Fetching file from saltenv 'base', ** done ** '_modules/utils.py'
2017-11-02 07:13:25,901 [salt.fileclient  ][INFO    ][24450] Fetching file from saltenv 'base', ** done ** '_modules/virtng.py'
2017-11-02 07:13:25,904 [salt.utils.extmods][INFO    ][24450] Copying '/var/cache/salt/minion/files/base/_modules/__init__.py' to '/var/cache/salt/minion/extmods/modules/__init__.py'
2017-11-02 07:13:25,904 [salt.utils.extmods][INFO    ][24450] Copying '/var/cache/salt/minion/files/base/_modules/ceph_ng.py' to '/var/cache/salt/minion/extmods/modules/ceph_ng.py'
2017-11-02 07:13:25,904 [salt.utils.extmods][INFO    ][24450] Copying '/var/cache/salt/minion/files/base/_modules/cinderng.py' to '/var/cache/salt/minion/extmods/modules/cinderng.py'
2017-11-02 07:13:25,904 [salt.utils.extmods][INFO    ][24450] Copying '/var/cache/salt/minion/files/base/_modules/contrail.py' to '/var/cache/salt/minion/extmods/modules/contrail.py'
2017-11-02 07:13:25,905 [salt.utils.extmods][INFO    ][24450] Copying '/var/cache/salt/minion/files/base/_modules/creds.py' to '/var/cache/salt/minion/extmods/modules/creds.py'
2017-11-02 07:13:25,905 [salt.utils.extmods][INFO    ][24450] Copying '/var/cache/salt/minion/files/base/_modules/devops_utils.py' to '/var/cache/salt/minion/extmods/modules/devops_utils.py'
2017-11-02 07:13:25,905 [salt.utils.extmods][INFO    ][24450] Copying '/var/cache/salt/minion/files/base/_modules/encode_json.py' to '/var/cache/salt/minion/extmods/modules/encode_json.py'
2017-11-02 07:13:25,905 [salt.utils.extmods][INFO    ][24450] Copying '/var/cache/salt/minion/files/base/_modules/gerrit.py' to '/var/cache/salt/minion/extmods/modules/gerrit.py'
2017-11-02 07:13:25,906 [salt.utils.extmods][INFO    ][24450] Copying '/var/cache/salt/minion/files/base/_modules/glanceng.py' to '/var/cache/salt/minion/extmods/modules/glanceng.py'
2017-11-02 07:13:25,906 [salt.utils.extmods][INFO    ][24450] Copying '/var/cache/salt/minion/files/base/_modules/heat.py' to '/var/cache/salt/minion/extmods/modules/heat.py'
2017-11-02 07:13:25,906 [salt.utils.extmods][INFO    ][24450] Copying '/var/cache/salt/minion/files/base/_modules/heka_alarming.py' to '/var/cache/salt/minion/extmods/modules/heka_alarming.py'
2017-11-02 07:13:25,906 [salt.utils.extmods][INFO    ][24450] Copying '/var/cache/salt/minion/files/base/_modules/helm.py' to '/var/cache/salt/minion/extmods/modules/helm.py'
2017-11-02 07:13:25,906 [salt.utils.extmods][INFO    ][24450] Copying '/var/cache/salt/minion/files/base/_modules/jenkins_common.py' to '/var/cache/salt/minion/extmods/modules/jenkins_common.py'
2017-11-02 07:13:25,907 [salt.utils.extmods][INFO    ][24450] Copying '/var/cache/salt/minion/files/base/_modules/keystone_policy.py' to '/var/cache/salt/minion/extmods/modules/keystone_policy.py'
2017-11-02 07:13:25,907 [salt.utils.extmods][INFO    ][24450] Copying '/var/cache/salt/minion/files/base/_modules/linux_hosts.py' to '/var/cache/salt/minion/extmods/modules/linux_hosts.py'
2017-11-02 07:13:25,907 [salt.utils.extmods][INFO    ][24450] Copying '/var/cache/salt/minion/files/base/_modules/linux_netlink.py' to '/var/cache/salt/minion/extmods/modules/linux_netlink.py'
2017-11-02 07:13:25,907 [salt.utils.extmods][INFO    ][24450] Copying '/var/cache/salt/minion/files/base/_modules/maas.py' to '/var/cache/salt/minion/extmods/modules/maas.py'
2017-11-02 07:13:25,907 [salt.utils.extmods][INFO    ][24450] Copying '/var/cache/salt/minion/files/base/_modules/maas_client.py' to '/var/cache/salt/minion/extmods/modules/maas_client.py'
2017-11-02 07:13:25,908 [salt.utils.extmods][INFO    ][24450] Copying '/var/cache/salt/minion/files/base/_modules/multipart.py' to '/var/cache/salt/minion/extmods/modules/multipart.py'
2017-11-02 07:13:25,908 [salt.utils.extmods][INFO    ][24450] Copying '/var/cache/salt/minion/files/base/_modules/nagios_alarming.py' to '/var/cache/salt/minion/extmods/modules/nagios_alarming.py'
2017-11-02 07:13:25,908 [salt.utils.extmods][INFO    ][24450] Copying '/var/cache/salt/minion/files/base/_modules/neutronng.py' to '/var/cache/salt/minion/extmods/modules/neutronng.py'
2017-11-02 07:13:25,908 [salt.utils.extmods][INFO    ][24450] Copying '/var/cache/salt/minion/files/base/_modules/novang.py' to '/var/cache/salt/minion/extmods/modules/novang.py'
2017-11-02 07:13:25,909 [salt.utils.extmods][INFO    ][24450] Copying '/var/cache/salt/minion/files/base/_modules/reclass.py' to '/var/cache/salt/minion/extmods/modules/reclass.py'
2017-11-02 07:13:25,909 [salt.utils.extmods][INFO    ][24450] Copying '/var/cache/salt/minion/files/base/_modules/rsyslog_util.py' to '/var/cache/salt/minion/extmods/modules/rsyslog_util.py'
2017-11-02 07:13:25,909 [salt.utils.extmods][INFO    ][24450] Copying '/var/cache/salt/minion/files/base/_modules/rundeck.py' to '/var/cache/salt/minion/extmods/modules/rundeck.py'
2017-11-02 07:13:25,909 [salt.utils.extmods][INFO    ][24450] Copying '/var/cache/salt/minion/files/base/_modules/saltkey.py' to '/var/cache/salt/minion/extmods/modules/saltkey.py'
2017-11-02 07:13:25,910 [salt.utils.extmods][INFO    ][24450] Copying '/var/cache/salt/minion/files/base/_modules/saltresource.py' to '/var/cache/salt/minion/extmods/modules/saltresource.py'
2017-11-02 07:13:25,910 [salt.utils.extmods][INFO    ][24450] Copying '/var/cache/salt/minion/files/base/_modules/seedng.py' to '/var/cache/salt/minion/extmods/modules/seedng.py'
2017-11-02 07:13:25,910 [salt.utils.extmods][INFO    ][24450] Copying '/var/cache/salt/minion/files/base/_modules/testing/__init__.py' to '/var/cache/salt/minion/extmods/modules/testing/__init__.py'
2017-11-02 07:13:25,910 [salt.utils.extmods][INFO    ][24450] Copying '/var/cache/salt/minion/files/base/_modules/testing/credentials.py' to '/var/cache/salt/minion/extmods/modules/testing/credentials.py'
2017-11-02 07:13:25,910 [salt.utils.extmods][INFO    ][24450] Copying '/var/cache/salt/minion/files/base/_modules/testing/django.py' to '/var/cache/salt/minion/extmods/modules/testing/django.py'
2017-11-02 07:13:25,911 [salt.utils.extmods][INFO    ][24450] Copying '/var/cache/salt/minion/files/base/_modules/testing/django_client_proxy.py' to '/var/cache/salt/minion/extmods/modules/testing/django_client_proxy.py'
2017-11-02 07:13:25,911 [salt.utils.extmods][INFO    ][24450] Copying '/var/cache/salt/minion/files/base/_modules/utils.py' to '/var/cache/salt/minion/extmods/modules/utils.py'
2017-11-02 07:13:25,911 [salt.utils.extmods][INFO    ][24450] Copying '/var/cache/salt/minion/files/base/_modules/virtng.py' to '/var/cache/salt/minion/extmods/modules/virtng.py'
2017-11-02 07:13:25,915 [salt.utils.extmods][INFO    ][24450] Syncing states for environment 'base'
2017-11-02 07:13:25,915 [salt.utils.extmods][INFO    ][24450] Loading cache from salt://_states, for base)
2017-11-02 07:13:25,916 [salt.fileclient  ][INFO    ][24450] Caching directory '_states/' for environment 'base'
2017-11-02 07:13:25,970 [salt.fileclient  ][INFO    ][24450] Fetching file from saltenv 'base', ** done ** '_states/cinderng.py'
2017-11-02 07:13:26,029 [salt.fileclient  ][INFO    ][24450] Fetching file from saltenv 'base', ** done ** '_states/contrail.py'
2017-11-02 07:13:26,040 [salt.fileclient  ][INFO    ][24450] Fetching file from saltenv 'base', ** done ** '_states/gerrit.py'
2017-11-02 07:13:26,067 [salt.fileclient  ][INFO    ][24450] Fetching file from saltenv 'base', ** done ** '_states/glanceng.py'
2017-11-02 07:13:26,083 [salt.fileclient  ][INFO    ][24450] Fetching file from saltenv 'base', ** done ** '_states/grafana3_dashboard.py'
2017-11-02 07:13:26,138 [salt.fileclient  ][INFO    ][24450] Fetching file from saltenv 'base', ** done ** '_states/grafana3_datasource.py'
2017-11-02 07:13:26,157 [salt.fileclient  ][INFO    ][24450] Fetching file from saltenv 'base', ** done ** '_states/heat.py'
2017-11-02 07:13:26,204 [salt.fileclient  ][INFO    ][24450] Fetching file from saltenv 'base', ** done ** '_states/helm_release.py'
2017-11-02 07:13:26,221 [salt.fileclient  ][INFO    ][24450] Fetching file from saltenv 'base', ** done ** '_states/jenkins_approval.py'
2017-11-02 07:13:26,241 [salt.fileclient  ][INFO    ][24450] Fetching file from saltenv 'base', ** done ** '_states/jenkins_artifactory.py'
2017-11-02 07:13:26,254 [salt.fileclient  ][INFO    ][24450] Fetching file from saltenv 'base', ** done ** '_states/jenkins_credential.py'
2017-11-02 07:13:26,280 [salt.fileclient  ][INFO    ][24450] Fetching file from saltenv 'base', ** done ** '_states/jenkins_job.py'
2017-11-02 07:13:26,290 [salt.fileclient  ][INFO    ][24450] Fetching file from saltenv 'base', ** done ** '_states/jenkins_lib.py'
2017-11-02 07:13:26,300 [salt.fileclient  ][INFO    ][24450] Fetching file from saltenv 'base', ** done ** '_states/jenkins_node.py'
2017-11-02 07:13:26,310 [salt.fileclient  ][INFO    ][24450] Fetching file from saltenv 'base', ** done ** '_states/jenkins_plugin.py'
2017-11-02 07:13:26,357 [salt.fileclient  ][INFO    ][24450] Fetching file from saltenv 'base', ** done ** '_states/jenkins_security.py'
2017-11-02 07:13:26,369 [salt.fileclient  ][INFO    ][24450] Fetching file from saltenv 'base', ** done ** '_states/jenkins_slack.py'
2017-11-02 07:13:26,379 [salt.fileclient  ][INFO    ][24450] Fetching file from saltenv 'base', ** done ** '_states/jenkins_smtp.py'
2017-11-02 07:13:26,389 [salt.fileclient  ][INFO    ][24450] Fetching file from saltenv 'base', ** done ** '_states/jenkins_theme.py'
2017-11-02 07:13:26,397 [salt.fileclient  ][INFO    ][24450] Fetching file from saltenv 'base', ** done ** '_states/jenkins_user.py'
2017-11-02 07:13:26,407 [salt.fileclient  ][INFO    ][24450] Fetching file from saltenv 'base', ** done ** '_states/jenkins_view.py'
2017-11-02 07:13:26,420 [salt.fileclient  ][INFO    ][24450] Fetching file from saltenv 'base', ** done ** '_states/keystone_policy.py'
2017-11-02 07:13:26,429 [salt.fileclient  ][INFO    ][24450] Fetching file from saltenv 'base', ** done ** '_states/kibana_object.py'
2017-11-02 07:13:26,486 [salt.fileclient  ][INFO    ][24450] Fetching file from saltenv 'base', ** done ** '_states/neutronng.py'
2017-11-02 07:13:26,501 [salt.fileclient  ][INFO    ][24450] Fetching file from saltenv 'base', ** done ** '_states/novang.py'
2017-11-02 07:13:26,519 [salt.fileclient  ][INFO    ][24450] Fetching file from saltenv 'base', ** done ** '_states/reclass.py'
2017-11-02 07:13:26,554 [salt.fileclient  ][INFO    ][24450] Fetching file from saltenv 'base', ** done ** '_states/rundeck_project.py'
2017-11-02 07:13:26,578 [salt.fileclient  ][INFO    ][24450] Fetching file from saltenv 'base', ** done ** '_states/rundeck_scm.py'
2017-11-02 07:13:26,600 [salt.fileclient  ][INFO    ][24450] Fetching file from saltenv 'base', ** done ** '_states/rundeck_secret.py'
2017-11-02 07:13:26,607 [salt.utils.extmods][INFO    ][24450] Copying '/var/cache/salt/minion/files/base/_states/cinderng.py' to '/var/cache/salt/minion/extmods/states/cinderng.py'
2017-11-02 07:13:26,607 [salt.utils.extmods][INFO    ][24450] Copying '/var/cache/salt/minion/files/base/_states/contrail.py' to '/var/cache/salt/minion/extmods/states/contrail.py'
2017-11-02 07:13:26,608 [salt.utils.extmods][INFO    ][24450] Copying '/var/cache/salt/minion/files/base/_states/gerrit.py' to '/var/cache/salt/minion/extmods/states/gerrit.py'
2017-11-02 07:13:26,608 [salt.utils.extmods][INFO    ][24450] Copying '/var/cache/salt/minion/files/base/_states/glanceng.py' to '/var/cache/salt/minion/extmods/states/glanceng.py'
2017-11-02 07:13:26,608 [salt.utils.extmods][INFO    ][24450] Copying '/var/cache/salt/minion/files/base/_states/grafana3_dashboard.py' to '/var/cache/salt/minion/extmods/states/grafana3_dashboard.py'
2017-11-02 07:13:26,608 [salt.utils.extmods][INFO    ][24450] Copying '/var/cache/salt/minion/files/base/_states/grafana3_datasource.py' to '/var/cache/salt/minion/extmods/states/grafana3_datasource.py'
2017-11-02 07:13:26,609 [salt.utils.extmods][INFO    ][24450] Copying '/var/cache/salt/minion/files/base/_states/heat.py' to '/var/cache/salt/minion/extmods/states/heat.py'
2017-11-02 07:13:26,609 [salt.utils.extmods][INFO    ][24450] Copying '/var/cache/salt/minion/files/base/_states/helm_release.py' to '/var/cache/salt/minion/extmods/states/helm_release.py'
2017-11-02 07:13:26,609 [salt.utils.extmods][INFO    ][24450] Copying '/var/cache/salt/minion/files/base/_states/jenkins_approval.py' to '/var/cache/salt/minion/extmods/states/jenkins_approval.py'
2017-11-02 07:13:26,609 [salt.utils.extmods][INFO    ][24450] Copying '/var/cache/salt/minion/files/base/_states/jenkins_artifactory.py' to '/var/cache/salt/minion/extmods/states/jenkins_artifactory.py'
2017-11-02 07:13:26,609 [salt.utils.extmods][INFO    ][24450] Copying '/var/cache/salt/minion/files/base/_states/jenkins_credential.py' to '/var/cache/salt/minion/extmods/states/jenkins_credential.py'
2017-11-02 07:13:26,610 [salt.utils.extmods][INFO    ][24450] Copying '/var/cache/salt/minion/files/base/_states/jenkins_job.py' to '/var/cache/salt/minion/extmods/states/jenkins_job.py'
2017-11-02 07:13:26,610 [salt.utils.extmods][INFO    ][24450] Copying '/var/cache/salt/minion/files/base/_states/jenkins_lib.py' to '/var/cache/salt/minion/extmods/states/jenkins_lib.py'
2017-11-02 07:13:26,610 [salt.utils.extmods][INFO    ][24450] Copying '/var/cache/salt/minion/files/base/_states/jenkins_node.py' to '/var/cache/salt/minion/extmods/states/jenkins_node.py'
2017-11-02 07:13:26,610 [salt.utils.extmods][INFO    ][24450] Copying '/var/cache/salt/minion/files/base/_states/jenkins_plugin.py' to '/var/cache/salt/minion/extmods/states/jenkins_plugin.py'
2017-11-02 07:13:26,610 [salt.utils.extmods][INFO    ][24450] Copying '/var/cache/salt/minion/files/base/_states/jenkins_security.py' to '/var/cache/salt/minion/extmods/states/jenkins_security.py'
2017-11-02 07:13:26,611 [salt.utils.extmods][INFO    ][24450] Copying '/var/cache/salt/minion/files/base/_states/jenkins_slack.py' to '/var/cache/salt/minion/extmods/states/jenkins_slack.py'
2017-11-02 07:13:26,611 [salt.utils.extmods][INFO    ][24450] Copying '/var/cache/salt/minion/files/base/_states/jenkins_smtp.py' to '/var/cache/salt/minion/extmods/states/jenkins_smtp.py'
2017-11-02 07:13:26,611 [salt.utils.extmods][INFO    ][24450] Copying '/var/cache/salt/minion/files/base/_states/jenkins_theme.py' to '/var/cache/salt/minion/extmods/states/jenkins_theme.py'
2017-11-02 07:13:26,611 [salt.utils.extmods][INFO    ][24450] Copying '/var/cache/salt/minion/files/base/_states/jenkins_user.py' to '/var/cache/salt/minion/extmods/states/jenkins_user.py'
2017-11-02 07:13:26,611 [salt.utils.extmods][INFO    ][24450] Copying '/var/cache/salt/minion/files/base/_states/jenkins_view.py' to '/var/cache/salt/minion/extmods/states/jenkins_view.py'
2017-11-02 07:13:26,612 [salt.utils.extmods][INFO    ][24450] Copying '/var/cache/salt/minion/files/base/_states/keystone_policy.py' to '/var/cache/salt/minion/extmods/states/keystone_policy.py'
2017-11-02 07:13:26,612 [salt.utils.extmods][INFO    ][24450] Copying '/var/cache/salt/minion/files/base/_states/kibana_object.py' to '/var/cache/salt/minion/extmods/states/kibana_object.py'
2017-11-02 07:13:26,612 [salt.utils.extmods][INFO    ][24450] Copying '/var/cache/salt/minion/files/base/_states/maas_cluster.py' to '/var/cache/salt/minion/extmods/states/maas_cluster.py'
2017-11-02 07:13:26,612 [salt.utils.extmods][INFO    ][24450] Copying '/var/cache/salt/minion/files/base/_states/neutronng.py' to '/var/cache/salt/minion/extmods/states/neutronng.py'
2017-11-02 07:13:26,612 [salt.utils.extmods][INFO    ][24450] Copying '/var/cache/salt/minion/files/base/_states/novang.py' to '/var/cache/salt/minion/extmods/states/novang.py'
2017-11-02 07:13:26,613 [salt.utils.extmods][INFO    ][24450] Copying '/var/cache/salt/minion/files/base/_states/reclass.py' to '/var/cache/salt/minion/extmods/states/reclass.py'
2017-11-02 07:13:26,613 [salt.utils.extmods][INFO    ][24450] Copying '/var/cache/salt/minion/files/base/_states/rundeck_project.py' to '/var/cache/salt/minion/extmods/states/rundeck_project.py'
2017-11-02 07:13:26,613 [salt.utils.extmods][INFO    ][24450] Copying '/var/cache/salt/minion/files/base/_states/rundeck_scm.py' to '/var/cache/salt/minion/extmods/states/rundeck_scm.py'
2017-11-02 07:13:26,613 [salt.utils.extmods][INFO    ][24450] Copying '/var/cache/salt/minion/files/base/_states/rundeck_secret.py' to '/var/cache/salt/minion/extmods/states/rundeck_secret.py'
2017-11-02 07:13:26,616 [salt.utils.extmods][INFO    ][24450] Creating module dir '/var/cache/salt/minion/extmods/sdb'
2017-11-02 07:13:26,619 [salt.utils.extmods][INFO    ][24450] Syncing sdb for environment 'base'
2017-11-02 07:13:26,619 [salt.utils.extmods][INFO    ][24450] Loading cache from salt://_sdb, for base)
2017-11-02 07:13:26,619 [salt.fileclient  ][INFO    ][24450] Caching directory '_sdb/' for environment 'base'
2017-11-02 07:13:26,644 [salt.utils.extmods][INFO    ][24450] Syncing grains for environment 'base'
2017-11-02 07:13:26,644 [salt.utils.extmods][INFO    ][24450] Loading cache from salt://_grains, for base)
2017-11-02 07:13:26,644 [salt.fileclient  ][INFO    ][24450] Caching directory '_grains/' for environment 'base'
2017-11-02 07:13:26,670 [salt.fileclient  ][INFO    ][24450] Fetching file from saltenv 'base', ** done ** '_grains/ceilometer_policy.py'
2017-11-02 07:13:26,693 [salt.fileclient  ][INFO    ][24450] Fetching file from saltenv 'base', ** done ** '_grains/ceph.py'
2017-11-02 07:13:26,700 [salt.fileclient  ][INFO    ][24450] Fetching file from saltenv 'base', ** done ** '_grains/cinder_policy.py'
2017-11-02 07:13:26,709 [salt.fileclient  ][INFO    ][24450] Fetching file from saltenv 'base', ** done ** '_grains/docker_swarm.py'
2017-11-02 07:13:26,972 [salt.fileclient  ][INFO    ][24450] Fetching file from saltenv 'base', ** done ** '_grains/glance_policy.py'
2017-11-02 07:13:26,983 [salt.fileclient  ][INFO    ][24450] Fetching file from saltenv 'base', ** done ** '_grains/heat_policy.py'
2017-11-02 07:13:26,996 [salt.fileclient  ][INFO    ][24450] Fetching file from saltenv 'base', ** done ** '_grains/jenkins_plugins.py'
2017-11-02 07:13:27,031 [salt.fileclient  ][INFO    ][24450] Fetching file from saltenv 'base', ** done ** '_grains/keystone_policy.py'
2017-11-02 07:13:27,045 [salt.fileclient  ][INFO    ][24450] Fetching file from saltenv 'base', ** done ** '_grains/kubernetes.py'
2017-11-02 07:13:27,058 [salt.fileclient  ][INFO    ][24450] Fetching file from saltenv 'base', ** done ** '_grains/neutron_policy.py'
2017-11-02 07:13:27,067 [salt.fileclient  ][INFO    ][24450] Fetching file from saltenv 'base', ** done ** '_grains/nova_policy.py'
2017-11-02 07:13:27,072 [salt.fileclient  ][INFO    ][24450] Fetching file from saltenv 'base', ** done ** '_grains/ssh_fingerprints.py'
2017-11-02 07:13:27,075 [salt.utils.extmods][INFO    ][24450] Copying '/var/cache/salt/minion/files/base/_grains/ceilometer_policy.py' to '/var/cache/salt/minion/extmods/grains/ceilometer_policy.py'
2017-11-02 07:13:27,075 [salt.utils.extmods][INFO    ][24450] Copying '/var/cache/salt/minion/files/base/_grains/ceph.py' to '/var/cache/salt/minion/extmods/grains/ceph.py'
2017-11-02 07:13:27,076 [salt.utils.extmods][INFO    ][24450] Copying '/var/cache/salt/minion/files/base/_grains/cinder_policy.py' to '/var/cache/salt/minion/extmods/grains/cinder_policy.py'
2017-11-02 07:13:27,076 [salt.utils.extmods][INFO    ][24450] Copying '/var/cache/salt/minion/files/base/_grains/docker_swarm.py' to '/var/cache/salt/minion/extmods/grains/docker_swarm.py'
2017-11-02 07:13:27,076 [salt.utils.extmods][INFO    ][24450] Copying '/var/cache/salt/minion/files/base/_grains/glance_policy.py' to '/var/cache/salt/minion/extmods/grains/glance_policy.py'
2017-11-02 07:13:27,076 [salt.utils.extmods][INFO    ][24450] Copying '/var/cache/salt/minion/files/base/_grains/heat_policy.py' to '/var/cache/salt/minion/extmods/grains/heat_policy.py'
2017-11-02 07:13:27,076 [salt.utils.extmods][INFO    ][24450] Copying '/var/cache/salt/minion/files/base/_grains/jenkins_plugins.py' to '/var/cache/salt/minion/extmods/grains/jenkins_plugins.py'
2017-11-02 07:13:27,077 [salt.utils.extmods][INFO    ][24450] Copying '/var/cache/salt/minion/files/base/_grains/keystone_policy.py' to '/var/cache/salt/minion/extmods/grains/keystone_policy.py'
2017-11-02 07:13:27,077 [salt.utils.extmods][INFO    ][24450] Copying '/var/cache/salt/minion/files/base/_grains/kubernetes.py' to '/var/cache/salt/minion/extmods/grains/kubernetes.py'
2017-11-02 07:13:27,077 [salt.utils.extmods][INFO    ][24450] Copying '/var/cache/salt/minion/files/base/_grains/neutron_policy.py' to '/var/cache/salt/minion/extmods/grains/neutron_policy.py'
2017-11-02 07:13:27,077 [salt.utils.extmods][INFO    ][24450] Copying '/var/cache/salt/minion/files/base/_grains/nova_policy.py' to '/var/cache/salt/minion/extmods/grains/nova_policy.py'
2017-11-02 07:13:27,077 [salt.utils.extmods][INFO    ][24450] Copying '/var/cache/salt/minion/files/base/_grains/ssh_fingerprints.py' to '/var/cache/salt/minion/extmods/grains/ssh_fingerprints.py'
2017-11-02 07:13:27,079 [salt.utils.extmods][INFO    ][24450] Creating module dir '/var/cache/salt/minion/extmods/renderers'
2017-11-02 07:13:27,081 [salt.utils.extmods][INFO    ][24450] Syncing renderers for environment 'base'
2017-11-02 07:13:27,082 [salt.utils.extmods][INFO    ][24450] Loading cache from salt://_renderers, for base)
2017-11-02 07:13:27,082 [salt.fileclient  ][INFO    ][24450] Caching directory '_renderers/' for environment 'base'
2017-11-02 07:13:27,099 [salt.utils.extmods][INFO    ][24450] Creating module dir '/var/cache/salt/minion/extmods/returners'
2017-11-02 07:13:27,101 [salt.utils.extmods][INFO    ][24450] Syncing returners for environment 'base'
2017-11-02 07:13:27,102 [salt.utils.extmods][INFO    ][24450] Loading cache from salt://_returners, for base)
2017-11-02 07:13:27,102 [salt.fileclient  ][INFO    ][24450] Caching directory '_returners/' for environment 'base'
2017-11-02 07:13:27,129 [salt.utils.extmods][INFO    ][24450] Creating module dir '/var/cache/salt/minion/extmods/output'
2017-11-02 07:13:27,132 [salt.utils.extmods][INFO    ][24450] Syncing output for environment 'base'
2017-11-02 07:13:27,132 [salt.utils.extmods][INFO    ][24450] Loading cache from salt://_output, for base)
2017-11-02 07:13:27,132 [salt.fileclient  ][INFO    ][24450] Caching directory '_output/' for environment 'base'
2017-11-02 07:13:27,150 [salt.utils.extmods][INFO    ][24450] Creating module dir '/var/cache/salt/minion/extmods/utils'
2017-11-02 07:13:27,152 [salt.utils.extmods][INFO    ][24450] Syncing utils for environment 'base'
2017-11-02 07:13:27,152 [salt.utils.extmods][INFO    ][24450] Loading cache from salt://_utils, for base)
2017-11-02 07:13:27,153 [salt.fileclient  ][INFO    ][24450] Caching directory '_utils/' for environment 'base'
2017-11-02 07:13:27,188 [salt.utils.extmods][INFO    ][24450] Creating module dir '/var/cache/salt/minion/extmods/log_handlers'
2017-11-02 07:13:27,192 [salt.utils.extmods][INFO    ][24450] Syncing log_handlers for environment 'base'
2017-11-02 07:13:27,192 [salt.utils.extmods][INFO    ][24450] Loading cache from salt://_log_handlers, for base)
2017-11-02 07:13:27,192 [salt.fileclient  ][INFO    ][24450] Caching directory '_log_handlers/' for environment 'base'
2017-11-02 07:13:27,224 [salt.utils.extmods][INFO    ][24450] Creating module dir '/var/cache/salt/minion/extmods/proxy'
2017-11-02 07:13:27,227 [salt.utils.extmods][INFO    ][24450] Syncing proxy for environment 'base'
2017-11-02 07:13:27,227 [salt.utils.extmods][INFO    ][24450] Loading cache from salt://_proxy, for base)
2017-11-02 07:13:27,227 [salt.fileclient  ][INFO    ][24450] Caching directory '_proxy/' for environment 'base'
2017-11-02 07:13:27,256 [salt.utils.extmods][INFO    ][24450] Creating module dir '/var/cache/salt/minion/extmods/engines'
2017-11-02 07:13:27,259 [salt.utils.extmods][INFO    ][24450] Syncing engines for environment 'base'
2017-11-02 07:13:27,259 [salt.utils.extmods][INFO    ][24450] Loading cache from salt://_engines, for base)
2017-11-02 07:13:27,259 [salt.fileclient  ][INFO    ][24450] Caching directory '_engines/' for environment 'base'
2017-11-02 07:13:27,283 [salt.minion      ][INFO    ][24450] Returning information for job: 20171102071321034607
2017-11-02 07:41:44,798 [salt.minion      ][INFO    ][23994] User sudo_ubuntu Executing command test.ping with jid 20171102074144787577
2017-11-02 07:41:44,817 [salt.minion      ][INFO    ][24984] Starting a new job with PID 24984
2017-11-02 07:41:44,844 [salt.minion      ][INFO    ][24984] Returning information for job: 20171102074144787577
2017-11-02 07:43:32,490 [salt.minion      ][INFO    ][23994] User sudo_ubuntu Executing command state.sls with jid 20171102074332478567
2017-11-02 07:43:32,506 [salt.minion      ][INFO    ][25009] Starting a new job with PID 25009
2017-11-02 07:43:34,167 [salt.state       ][INFO    ][25009] Loading fresh modules for state activity
2017-11-02 07:43:34,192 [salt.fileclient  ][INFO    ][25009] Fetching file from saltenv 'base', ** done ** 'keepalived/init.sls'
2017-11-02 07:43:34,212 [salt.fileclient  ][INFO    ][25009] Fetching file from saltenv 'base', ** done ** 'keepalived/cluster.sls'
2017-11-02 07:43:34,236 [salt.fileclient  ][INFO    ][25009] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-11-02 07:43:34,549 [salt.state       ][INFO    ][25009] Running state [lsof] at time 07:43:34.549452
2017-11-02 07:43:34,550 [salt.state       ][INFO    ][25009] Executing state pkg.installed for lsof
2017-11-02 07:43:34,550 [salt.loaded.int.module.cmdmod][INFO    ][25009] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-02 07:43:34,811 [salt.state       ][INFO    ][25009] Package lsof is already installed
2017-11-02 07:43:34,811 [salt.state       ][INFO    ][25009] Completed state [lsof] at time 07:43:34.811119 duration_in_ms=261.666
2017-11-02 07:43:34,811 [salt.state       ][INFO    ][25009] Running state [keepalived] at time 07:43:34.811316
2017-11-02 07:43:34,812 [salt.state       ][INFO    ][25009] Executing state pkg.installed for keepalived
2017-11-02 07:43:34,827 [salt.loaded.int.module.cmdmod][INFO    ][25009] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-11-02 07:43:36,759 [salt.loaded.int.module.cmdmod][INFO    ][25009] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'keepalived'] in directory '/root'
2017-11-02 07:43:42,533 [salt.minion      ][INFO    ][23994] User sudo_ubuntu Executing command saltutil.find_job with jid 20171102074342521406
2017-11-02 07:43:42,548 [salt.minion      ][INFO    ][25677] Starting a new job with PID 25677
2017-11-02 07:43:42,562 [salt.minion      ][INFO    ][25677] Returning information for job: 20171102074342521406
2017-11-02 07:43:47,195 [salt.loaded.int.module.cmdmod][INFO    ][25009] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-02 07:43:47,220 [salt.state       ][INFO    ][25009] Made the following changes:
'libsnmp30' changed from 'absent' to '5.7.3+dfsg-1ubuntu4'
'libsnmp-base' changed from 'absent' to '5.7.3+dfsg-1ubuntu4'
'keepalived' changed from 'absent' to '1:1.2.19-1ubuntu0.2'
'ipvsadm' changed from 'absent' to '1:1.28-3'
'libsensors4' changed from 'absent' to '1:3.4.0-2'

2017-11-02 07:43:47,228 [salt.state       ][INFO    ][25009] Loading fresh modules for state activity
2017-11-02 07:43:47,239 [salt.state       ][INFO    ][25009] Completed state [keepalived] at time 07:43:47.239369 duration_in_ms=12428.052
2017-11-02 07:43:47,241 [salt.state       ][INFO    ][25009] Running state [/etc/keepalived/keepalived.conf] at time 07:43:47.241086
2017-11-02 07:43:47,241 [salt.state       ][INFO    ][25009] Executing state file.managed for /etc/keepalived/keepalived.conf
2017-11-02 07:43:47,273 [salt.fileclient  ][INFO    ][25009] Fetching file from saltenv 'base', ** done ** 'keepalived/files/keepalived.conf'
2017-11-02 07:43:47,306 [salt.fileclient  ][INFO    ][25009] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-11-02 07:43:47,312 [salt.state       ][INFO    ][25009] File changed:
New file
2017-11-02 07:43:47,312 [salt.state       ][INFO    ][25009] Completed state [/etc/keepalived/keepalived.conf] at time 07:43:47.312387 duration_in_ms=71.301
2017-11-02 07:43:47,369 [salt.state       ][INFO    ][25009] Running state [keepalived] at time 07:43:47.369056
2017-11-02 07:43:47,369 [salt.state       ][INFO    ][25009] Executing state service.running for keepalived
2017-11-02 07:43:47,371 [salt.loaded.int.module.cmdmod][INFO    ][25009] Executing command ['systemctl', 'status', 'keepalived.service', '-n', '0'] in directory '/root'
2017-11-02 07:43:47,381 [salt.loaded.int.module.cmdmod][INFO    ][25009] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2017-11-02 07:43:47,389 [salt.loaded.int.module.cmdmod][INFO    ][25009] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-11-02 07:43:47,398 [salt.loaded.int.module.cmdmod][INFO    ][25009] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-11-02 07:43:47,406 [salt.loaded.int.module.cmdmod][INFO    ][25009] Executing command ['systemd-run', '--scope', 'systemctl', 'start', 'keepalived.service'] in directory '/root'
2017-11-02 07:43:47,468 [salt.loaded.int.module.cmdmod][INFO    ][25009] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2017-11-02 07:43:47,477 [salt.loaded.int.module.cmdmod][INFO    ][25009] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-11-02 07:43:47,485 [salt.loaded.int.module.cmdmod][INFO    ][25009] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-11-02 07:43:47,492 [salt.state       ][INFO    ][25009] {'keepalived': True}
2017-11-02 07:43:47,492 [salt.state       ][INFO    ][25009] Completed state [keepalived] at time 07:43:47.491994 duration_in_ms=122.939
2017-11-02 07:43:47,493 [salt.minion      ][INFO    ][25009] Returning information for job: 20171102074332478567
2017-11-02 07:45:53,812 [salt.minion      ][INFO    ][23994] User sudo_ubuntu Executing command pillar.get with jid 20171102074553802402
2017-11-02 07:45:53,831 [salt.minion      ][INFO    ][26641] Starting a new job with PID 26641
2017-11-02 07:45:53,837 [salt.minion      ][INFO    ][26641] Returning information for job: 20171102074553802402
2017-11-02 07:51:08,920 [salt.minion      ][INFO    ][23994] User sudo_ubuntu Executing command state.sls with jid 20171102075108910085
2017-11-02 07:51:08,936 [salt.minion      ][INFO    ][26728] Starting a new job with PID 26728
2017-11-02 07:51:11,369 [salt.state       ][INFO    ][26728] Loading fresh modules for state activity
2017-11-02 07:51:11,390 [salt.fileclient  ][INFO    ][26728] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-11-02 07:51:11,420 [salt.fileclient  ][INFO    ][26728] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-11-02 07:51:11,697 [salt.state       ][INFO    ][26728] Running state [attr] at time 07:51:11.697395
2017-11-02 07:51:11,698 [salt.state       ][INFO    ][26728] Executing state pkg.installed for attr
2017-11-02 07:51:11,698 [salt.loaded.int.module.cmdmod][INFO    ][26728] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-02 07:51:11,977 [salt.loaded.int.module.cmdmod][INFO    ][26728] Executing command ['apt-get', '-q', 'update'] in directory '/root'
2017-11-02 07:51:13,890 [salt.loaded.int.module.cmdmod][INFO    ][26728] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'attr'] in directory '/root'
2017-11-02 07:51:16,790 [salt.loaded.int.module.cmdmod][INFO    ][26728] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-02 07:51:16,813 [salt.state       ][INFO    ][26728] Made the following changes:
'attr' changed from 'absent' to '1:2.4.47-2'

2017-11-02 07:51:16,821 [salt.state       ][INFO    ][26728] Loading fresh modules for state activity
2017-11-02 07:51:16,833 [salt.state       ][INFO    ][26728] Completed state [attr] at time 07:51:16.833380 duration_in_ms=5135.984
2017-11-02 07:51:16,838 [salt.state       ][INFO    ][26728] Running state [glusterfs-server] at time 07:51:16.838227
2017-11-02 07:51:16,838 [salt.state       ][INFO    ][26728] Executing state pkg.installed for glusterfs-server
2017-11-02 07:51:17,018 [salt.loaded.int.module.cmdmod][INFO    ][26728] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'glusterfs-server'] in directory '/root'
2017-11-02 07:51:19,018 [salt.minion      ][INFO    ][23994] User sudo_ubuntu Executing command saltutil.find_job with jid 20171102075119005519
2017-11-02 07:51:19,033 [salt.minion      ][INFO    ][27759] Starting a new job with PID 27759
2017-11-02 07:51:19,043 [salt.minion      ][INFO    ][27759] Returning information for job: 20171102075119005519
2017-11-02 07:51:29,212 [salt.minion      ][INFO    ][23994] User sudo_ubuntu Executing command saltutil.find_job with jid 20171102075129200305
2017-11-02 07:51:29,227 [salt.minion      ][INFO    ][30462] Starting a new job with PID 30462
2017-11-02 07:51:29,243 [salt.minion      ][INFO    ][30462] Returning information for job: 20171102075129200305
2017-11-02 07:51:35,302 [salt.loaded.int.module.cmdmod][INFO    ][26728] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-02 07:51:35,327 [salt.state       ][INFO    ][26728] Made the following changes:
'keyutils' changed from 'absent' to '1.5.9-8ubuntu1'
'nfs-common' changed from 'absent' to '1:1.2.8-9ubuntu12.1'
'rpcbind' changed from 'absent' to '0.2.3-0.2'
'glusterfs-common' changed from 'absent' to '3.7.6-1ubuntu1'
'librdmacm1' changed from 'absent' to '1.0.21-1'
'libnfsidmap2' changed from 'absent' to '0.25-5'
'portmap' changed from 'absent' to '1'
'libattr1-dev' changed from 'absent' to '1:2.4.47-2'
'attr-dev' changed from 'absent' to '1'
'acl-dev' changed from 'absent' to '1'
'glusterfs-server' changed from 'absent' to '3.7.6-1ubuntu1'
'glusterfs-client' changed from 'absent' to '3.7.6-1ubuntu1'
'libpython2.7' changed from 'absent' to '2.7.12-1ubuntu0~16.04.1'
'nfs-client' changed from 'absent' to '1'
'liburcu4' changed from 'absent' to '0.9.1-3'
'libacl1-dev' changed from 'absent' to '2.2.52-3'
'libibverbs1' changed from 'absent' to '1.1.8-1.1ubuntu2'
'libtirpc1' changed from 'absent' to '0.2.5-1'

2017-11-02 07:51:35,334 [salt.state       ][INFO    ][26728] Loading fresh modules for state activity
2017-11-02 07:51:35,346 [salt.state       ][INFO    ][26728] Completed state [glusterfs-server] at time 07:51:35.345795 duration_in_ms=18507.567
2017-11-02 07:51:35,350 [salt.state       ][INFO    ][26728] Running state [bc] at time 07:51:35.350454
2017-11-02 07:51:35,351 [salt.state       ][INFO    ][26728] Executing state pkg.installed for bc
2017-11-02 07:51:35,608 [salt.loaded.int.module.cmdmod][INFO    ][26728] Executing command ['systemd-run', '--scope', 'apt-get', '-q', '-y', '-o', 'DPkg::Options::=--force-confold', '-o', 'DPkg::Options::=--force-confdef', 'install', 'bc'] in directory '/root'
2017-11-02 07:51:38,201 [salt.loaded.int.module.cmdmod][INFO    ][26728] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-02 07:51:38,227 [salt.state       ][INFO    ][26728] Made the following changes:
'bc' changed from 'absent' to '1.06.95-9build1'

2017-11-02 07:51:38,236 [salt.state       ][INFO    ][26728] Loading fresh modules for state activity
2017-11-02 07:51:38,249 [salt.state       ][INFO    ][26728] Completed state [bc] at time 07:51:38.248475 duration_in_ms=2898.021
2017-11-02 07:51:38,312 [salt.state       ][INFO    ][26728] Running state [glusterfs-server] at time 07:51:38.311493
2017-11-02 07:51:38,312 [salt.state       ][INFO    ][26728] Executing state service.running for glusterfs-server
2017-11-02 07:51:38,313 [salt.loaded.int.module.cmdmod][INFO    ][26728] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-11-02 07:51:38,323 [salt.loaded.int.module.cmdmod][INFO    ][26728] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-11-02 07:51:38,332 [salt.loaded.int.module.cmdmod][INFO    ][26728] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-11-02 07:51:38,341 [salt.state       ][INFO    ][26728] The service glusterfs-server is already running
2017-11-02 07:51:38,341 [salt.state       ][INFO    ][26728] Completed state [glusterfs-server] at time 07:51:38.340982 duration_in_ms=29.488
2017-11-02 07:51:38,343 [salt.state       ][INFO    ][26728] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 07:51:38.342688
2017-11-02 07:51:38,343 [salt.state       ][INFO    ][26728] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-11-02 07:51:38,360 [salt.state       ][INFO    ][26728] File changed:
New file
2017-11-02 07:51:38,361 [salt.state       ][INFO    ][26728] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 07:51:38.360512 duration_in_ms=17.824
2017-11-02 07:51:38,361 [salt.state       ][INFO    ][26728] Running state [/srv/glusterfs/glance] at time 07:51:38.360683
2017-11-02 07:51:38,361 [salt.state       ][INFO    ][26728] Executing state file.directory for /srv/glusterfs/glance
2017-11-02 07:51:38,361 [salt.state       ][INFO    ][26728] {'/srv/glusterfs/glance': 'New Dir'}
2017-11-02 07:51:38,362 [salt.state       ][INFO    ][26728] Completed state [/srv/glusterfs/glance] at time 07:51:38.361556 duration_in_ms=0.873
2017-11-02 07:51:38,362 [salt.state       ][INFO    ][26728] Running state [/srv/glusterfs/keystone-keys] at time 07:51:38.361718
2017-11-02 07:51:38,362 [salt.state       ][INFO    ][26728] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-11-02 07:51:38,362 [salt.state       ][INFO    ][26728] {'/srv/glusterfs/keystone-keys': 'New Dir'}
2017-11-02 07:51:38,362 [salt.state       ][INFO    ][26728] Completed state [/srv/glusterfs/keystone-keys] at time 07:51:38.362403 duration_in_ms=0.685
2017-11-02 07:51:38,363 [salt.state       ][INFO    ][26728] Running state [/srv/glusterfs/nova_instances] at time 07:51:38.362552
2017-11-02 07:51:38,363 [salt.state       ][INFO    ][26728] Executing state file.directory for /srv/glusterfs/nova_instances
2017-11-02 07:51:38,363 [salt.state       ][INFO    ][26728] {'/srv/glusterfs/nova_instances': 'New Dir'}
2017-11-02 07:51:38,363 [salt.state       ][INFO    ][26728] Completed state [/srv/glusterfs/nova_instances] at time 07:51:38.363223 duration_in_ms=0.672
2017-11-02 07:51:38,363 [salt.state       ][INFO    ][26728] Running state [/srv/glusterfs/keystone-credential-keys] at time 07:51:38.363372
2017-11-02 07:51:38,364 [salt.state       ][INFO    ][26728] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-11-02 07:51:38,364 [salt.state       ][INFO    ][26728] {'/srv/glusterfs/keystone-credential-keys': 'New Dir'}
2017-11-02 07:51:38,364 [salt.state       ][INFO    ][26728] Completed state [/srv/glusterfs/keystone-credential-keys] at time 07:51:38.364048 duration_in_ms=0.675
2017-11-02 07:51:38,365 [salt.minion      ][INFO    ][26728] Returning information for job: 20171102075108910085
2017-11-02 07:51:39,540 [salt.minion      ][INFO    ][23994] User sudo_ubuntu Executing command test.ping with jid 20171102075139533295
2017-11-02 07:51:39,556 [salt.minion      ][INFO    ][31492] Starting a new job with PID 31492
2017-11-02 07:51:39,583 [salt.minion      ][INFO    ][31492] Returning information for job: 20171102075139533295
2017-11-02 07:51:39,716 [salt.minion      ][INFO    ][23994] User sudo_ubuntu Executing command state.sls with jid 20171102075139706064
2017-11-02 07:51:39,731 [salt.minion      ][INFO    ][31497] Starting a new job with PID 31497
2017-11-02 07:51:41,293 [salt.state       ][INFO    ][31497] Loading fresh modules for state activity
2017-11-02 07:51:41,315 [salt.fileclient  ][INFO    ][31497] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/setup.sls'
2017-11-02 07:51:41,347 [salt.fileclient  ][INFO    ][31497] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-11-02 07:51:41,412 [salt.fileclient  ][INFO    ][31497] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-11-02 07:51:41,431 [salt.fileclient  ][INFO    ][31497] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-11-02 07:51:41,694 [salt.state       ][INFO    ][31497] Running state [attr] at time 07:51:41.693742
2017-11-02 07:51:41,694 [salt.state       ][INFO    ][31497] Executing state pkg.installed for attr
2017-11-02 07:51:41,694 [salt.loaded.int.module.cmdmod][INFO    ][31497] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-02 07:51:41,976 [salt.state       ][INFO    ][31497] Package attr is already installed
2017-11-02 07:51:41,977 [salt.state       ][INFO    ][31497] Completed state [attr] at time 07:51:41.976723 duration_in_ms=282.981
2017-11-02 07:51:41,977 [salt.state       ][INFO    ][31497] Running state [glusterfs-server] at time 07:51:41.976925
2017-11-02 07:51:41,977 [salt.state       ][INFO    ][31497] Executing state pkg.installed for glusterfs-server
2017-11-02 07:51:41,980 [salt.state       ][INFO    ][31497] Package glusterfs-server is already installed
2017-11-02 07:51:41,980 [salt.state       ][INFO    ][31497] Completed state [glusterfs-server] at time 07:51:41.979759 duration_in_ms=2.834
2017-11-02 07:51:41,980 [salt.state       ][INFO    ][31497] Running state [bc] at time 07:51:41.979900
2017-11-02 07:51:41,980 [salt.state       ][INFO    ][31497] Executing state pkg.installed for bc
2017-11-02 07:51:41,983 [salt.state       ][INFO    ][31497] Package bc is already installed
2017-11-02 07:51:41,983 [salt.state       ][INFO    ][31497] Completed state [bc] at time 07:51:41.982651 duration_in_ms=2.751
2017-11-02 07:51:41,983 [salt.state       ][INFO    ][31497] Running state [glusterfs-server] at time 07:51:41.983437
2017-11-02 07:51:41,984 [salt.state       ][INFO    ][31497] Executing state service.running for glusterfs-server
2017-11-02 07:51:41,984 [salt.loaded.int.module.cmdmod][INFO    ][31497] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-11-02 07:51:41,994 [salt.loaded.int.module.cmdmod][INFO    ][31497] Executing command ['systemctl', '--system', 'daemon-reload'] in directory '/root'
2017-11-02 07:51:42,038 [salt.loaded.int.module.cmdmod][INFO    ][31497] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-11-02 07:51:42,054 [salt.loaded.int.module.cmdmod][INFO    ][31497] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-11-02 07:51:42,061 [salt.loaded.int.module.cmdmod][INFO    ][31497] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-11-02 07:51:42,071 [salt.state       ][INFO    ][31497] The service glusterfs-server is already running
2017-11-02 07:51:42,071 [salt.state       ][INFO    ][31497] Completed state [glusterfs-server] at time 07:51:42.070740 duration_in_ms=87.302
2017-11-02 07:51:42,072 [salt.state       ][INFO    ][31497] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 07:51:42.072195
2017-11-02 07:51:42,072 [salt.state       ][INFO    ][31497] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-11-02 07:51:42,083 [salt.state       ][INFO    ][31497] File /etc/systemd/system/glusterfs-server.service.d/override.conf is in the correct state
2017-11-02 07:51:42,083 [salt.state       ][INFO    ][31497] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 07:51:42.083416 duration_in_ms=11.222
2017-11-02 07:51:42,084 [salt.state       ][INFO    ][31497] Running state [/srv/glusterfs/glance] at time 07:51:42.083591
2017-11-02 07:51:42,084 [salt.state       ][INFO    ][31497] Executing state file.directory for /srv/glusterfs/glance
2017-11-02 07:51:42,084 [salt.state       ][INFO    ][31497] Directory /srv/glusterfs/glance is in the correct state
2017-11-02 07:51:42,084 [salt.state       ][INFO    ][31497] Completed state [/srv/glusterfs/glance] at time 07:51:42.084254 duration_in_ms=0.664
2017-11-02 07:51:42,084 [salt.state       ][INFO    ][31497] Running state [/srv/glusterfs/keystone-keys] at time 07:51:42.084423
2017-11-02 07:51:42,085 [salt.state       ][INFO    ][31497] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-11-02 07:51:42,085 [salt.state       ][INFO    ][31497] Directory /srv/glusterfs/keystone-keys is in the correct state
2017-11-02 07:51:42,085 [salt.state       ][INFO    ][31497] Completed state [/srv/glusterfs/keystone-keys] at time 07:51:42.085087 duration_in_ms=0.663
2017-11-02 07:51:42,085 [salt.state       ][INFO    ][31497] Running state [/srv/glusterfs/nova_instances] at time 07:51:42.085249
2017-11-02 07:51:42,085 [salt.state       ][INFO    ][31497] Executing state file.directory for /srv/glusterfs/nova_instances
2017-11-02 07:51:42,086 [salt.state       ][INFO    ][31497] Directory /srv/glusterfs/nova_instances is in the correct state
2017-11-02 07:51:42,086 [salt.state       ][INFO    ][31497] Completed state [/srv/glusterfs/nova_instances] at time 07:51:42.085903 duration_in_ms=0.654
2017-11-02 07:51:42,086 [salt.state       ][INFO    ][31497] Running state [/srv/glusterfs/keystone-credential-keys] at time 07:51:42.086066
2017-11-02 07:51:42,086 [salt.state       ][INFO    ][31497] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-11-02 07:51:42,087 [salt.state       ][INFO    ][31497] Directory /srv/glusterfs/keystone-credential-keys is in the correct state
2017-11-02 07:51:42,087 [salt.state       ][INFO    ][31497] Completed state [/srv/glusterfs/keystone-credential-keys] at time 07:51:42.086688 duration_in_ms=0.622
2017-11-02 07:51:42,136 [salt.loaded.int.module.cmdmod][INFO    ][31497] Executing command ['git', '--version'] in directory '/root'
2017-11-02 07:51:42,220 [salt.state       ][INFO    ][31497] Running state [sleep 5] at time 07:51:42.220234
2017-11-02 07:51:42,220 [salt.state       ][INFO    ][31497] Executing state cmd.wait for sleep 5
2017-11-02 07:51:42,221 [salt.state       ][INFO    ][31497] No changes made for sleep 5
2017-11-02 07:51:42,221 [salt.state       ][INFO    ][31497] Completed state [sleep 5] at time 07:51:42.220792 duration_in_ms=0.559
2017-11-02 07:51:42,221 [salt.state       ][INFO    ][31497] Running state [10.167.4.141] at time 07:51:42.221190
2017-11-02 07:51:42,221 [salt.state       ][INFO    ][31497] Executing state glusterfs.peered for 10.167.4.141
2017-11-02 07:51:42,222 [salt.loaded.int.module.cmdmod][INFO    ][31497] Executing command 'gluster --version' in directory '/root'
2017-11-02 07:51:42,231 [salt.loaded.int.module.cmdmod][INFO    ][31497] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-02 07:51:42,281 [salt.loaded.int.module.cmdmod][INFO    ][31497] Executing command 'gluster --version' in directory '/root'
2017-11-02 07:51:42,290 [salt.loaded.int.module.cmdmod][INFO    ][31497] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-02 07:51:42,643 [salt.loaded.int.module.cmdmod][INFO    ][31497] Executing command 'gluster --version' in directory '/root'
2017-11-02 07:51:42,655 [salt.loaded.int.module.cmdmod][INFO    ][31497] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-02 07:51:42,735 [salt.loaded.int.module.cmdmod][INFO    ][31497] Executing command 'gluster --version' in directory '/root'
2017-11-02 07:51:42,746 [salt.loaded.int.module.cmdmod][INFO    ][31497] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-02 07:51:42,798 [salt.state       ][INFO    ][31497] {'new': {'10.167.4.141': []}, 'old': None}
2017-11-02 07:51:42,801 [salt.state       ][INFO    ][31497] Completed state [10.167.4.141] at time 07:51:42.800360 duration_in_ms=579.167
2017-11-02 07:51:42,803 [salt.state       ][INFO    ][31497] Running state [10.167.4.142] at time 07:51:42.802963
2017-11-02 07:51:42,803 [salt.state       ][INFO    ][31497] Executing state glusterfs.peered for 10.167.4.142
2017-11-02 07:51:42,804 [salt.loaded.int.module.cmdmod][INFO    ][31497] Executing command 'gluster --version' in directory '/root'
2017-11-02 07:51:42,820 [salt.loaded.int.module.cmdmod][INFO    ][31497] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-02 07:51:42,908 [salt.loaded.int.module.cmdmod][INFO    ][31497] Executing command 'gluster --version' in directory '/root'
2017-11-02 07:51:42,917 [salt.loaded.int.module.cmdmod][INFO    ][31497] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-02 07:51:42,969 [salt.loaded.int.module.cmdmod][INFO    ][31497] Executing command 'gluster --version' in directory '/root'
2017-11-02 07:51:42,979 [salt.loaded.int.module.cmdmod][INFO    ][31497] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-02 07:51:43,030 [salt.loaded.int.module.cmdmod][INFO    ][31497] Executing command 'gluster --version' in directory '/root'
2017-11-02 07:51:43,039 [salt.loaded.int.module.cmdmod][INFO    ][31497] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-02 07:51:43,088 [salt.state       ][INFO    ][31497] Peering with localhost is not needed
2017-11-02 07:51:43,088 [salt.state       ][INFO    ][31497] Completed state [10.167.4.142] at time 07:51:43.087929 duration_in_ms=284.965
2017-11-02 07:51:43,090 [salt.state       ][INFO    ][31497] Running state [10.167.4.143] at time 07:51:43.090236
2017-11-02 07:51:43,090 [salt.state       ][INFO    ][31497] Executing state glusterfs.peered for 10.167.4.143
2017-11-02 07:51:43,091 [salt.loaded.int.module.cmdmod][INFO    ][31497] Executing command 'gluster --version' in directory '/root'
2017-11-02 07:51:43,101 [salt.loaded.int.module.cmdmod][INFO    ][31497] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-02 07:51:43,148 [salt.loaded.int.module.cmdmod][INFO    ][31497] Executing command 'gluster --version' in directory '/root'
2017-11-02 07:51:43,158 [salt.loaded.int.module.cmdmod][INFO    ][31497] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-02 07:51:43,451 [salt.loaded.int.module.cmdmod][INFO    ][31497] Executing command 'gluster --version' in directory '/root'
2017-11-02 07:51:43,463 [salt.loaded.int.module.cmdmod][INFO    ][31497] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-02 07:51:43,556 [salt.loaded.int.module.cmdmod][INFO    ][31497] Executing command 'gluster --version' in directory '/root'
2017-11-02 07:51:43,567 [salt.loaded.int.module.cmdmod][INFO    ][31497] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-02 07:51:43,617 [salt.state       ][INFO    ][31497] {'new': {'10.167.4.141': [], '10.167.4.143': []}, 'old': {'10.167.4.141': []}}
2017-11-02 07:51:43,617 [salt.state       ][INFO    ][31497] Completed state [10.167.4.143] at time 07:51:43.617329 duration_in_ms=527.093
2017-11-02 07:51:43,618 [salt.state       ][INFO    ][31497] Running state [glance] at time 07:51:43.618167
2017-11-02 07:51:43,618 [salt.state       ][INFO    ][31497] Executing state glusterfs.created for glance
2017-11-02 07:51:43,619 [salt.loaded.int.module.cmdmod][INFO    ][31497] Executing command 'gluster --version' in directory '/root'
2017-11-02 07:51:43,629 [salt.loaded.int.module.cmdmod][INFO    ][31497] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-02 07:51:43,737 [salt.loaded.int.module.cmdmod][INFO    ][31497] Executing command 'gluster --version' in directory '/root'
2017-11-02 07:51:43,748 [salt.loaded.int.module.cmdmod][INFO    ][31497] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-02 07:51:44,928 [salt.loaded.int.module.cmdmod][INFO    ][31497] Executing command 'gluster --version' in directory '/root'
2017-11-02 07:51:44,941 [salt.loaded.int.module.cmdmod][INFO    ][31497] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-02 07:51:45,984 [salt.loaded.int.module.cmdmod][INFO    ][31497] Executing command 'gluster --version' in directory '/root'
2017-11-02 07:51:45,997 [salt.loaded.int.module.cmdmod][INFO    ][31497] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-02 07:51:46,051 [salt.state       ][INFO    ][31497] {'new': ['glance'], 'old': []}
2017-11-02 07:51:46,051 [salt.state       ][INFO    ][31497] Completed state [glance] at time 07:51:46.050999 duration_in_ms=2432.831
2017-11-02 07:51:46,054 [salt.state       ][INFO    ][31497] Running state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 07:51:46.053911
2017-11-02 07:51:46,054 [salt.state       ][INFO    ][31497] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'
2017-11-02 07:51:46,055 [salt.loaded.int.module.cmdmod][INFO    ][31497] Executing command 'gluster volume info 'glance' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-11-02 07:51:46,107 [salt.loaded.int.module.cmdmod][INFO    ][31497] Executing command 'gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'' in directory '/root'
2017-11-02 07:51:46,873 [salt.state       ][INFO    ][31497] {'pid': 31719, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-11-02 07:51:46,873 [salt.state       ][INFO    ][31497] Completed state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 07:51:46.873260 duration_in_ms=819.347
2017-11-02 07:51:46,874 [salt.state       ][INFO    ][31497] Running state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 07:51:46.873855
2017-11-02 07:51:46,874 [salt.state       ][INFO    ][31497] Executing state cmd.run for gluster volume set 'glance' 'network.remote-dio' 'True'
2017-11-02 07:51:46,875 [salt.loaded.int.module.cmdmod][INFO    ][31497] Executing command 'gluster volume info 'glance' | grep 'network.remote-dio: True'' in directory '/root'
2017-11-02 07:51:46,930 [salt.loaded.int.module.cmdmod][INFO    ][31497] Executing command 'gluster volume set 'glance' 'network.remote-dio' 'True'' in directory '/root'
2017-11-02 07:51:47,561 [salt.state       ][INFO    ][31497] {'pid': 31738, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-11-02 07:51:47,561 [salt.state       ][INFO    ][31497] Completed state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 07:51:47.561184 duration_in_ms=687.329
2017-11-02 07:51:47,562 [salt.state       ][INFO    ][31497] Running state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 07:51:47.561790
2017-11-02 07:51:47,562 [salt.state       ][INFO    ][31497] Executing state cmd.run for gluster volume set 'glance' 'nfs.disable' 'True'
2017-11-02 07:51:47,563 [salt.loaded.int.module.cmdmod][INFO    ][31497] Executing command 'gluster volume info 'glance' | grep 'nfs.disable: True'' in directory '/root'
2017-11-02 07:51:47,620 [salt.loaded.int.module.cmdmod][INFO    ][31497] Executing command 'gluster volume set 'glance' 'nfs.disable' 'True'' in directory '/root'
2017-11-02 07:51:49,758 [salt.minion      ][INFO    ][23994] User sudo_ubuntu Executing command saltutil.find_job with jid 20171102075149745691
2017-11-02 07:51:49,774 [salt.minion      ][INFO    ][31765] Starting a new job with PID 31765
2017-11-02 07:51:49,785 [salt.minion      ][INFO    ][31765] Returning information for job: 20171102075149745691
2017-11-02 07:51:50,338 [salt.state       ][INFO    ][31497] {'pid': 31755, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-11-02 07:51:50,338 [salt.state       ][INFO    ][31497] Completed state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 07:51:50.337831 duration_in_ms=2776.04
2017-11-02 07:51:50,338 [salt.state       ][INFO    ][31497] Running state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 07:51:50.338342
2017-11-02 07:51:50,339 [salt.state       ][INFO    ][31497] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'
2017-11-02 07:51:50,339 [salt.loaded.int.module.cmdmod][INFO    ][31497] Executing command 'gluster volume info 'glance' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-11-02 07:51:50,395 [salt.loaded.int.module.cmdmod][INFO    ][31497] Executing command 'gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'' in directory '/root'
2017-11-02 07:51:51,061 [salt.state       ][INFO    ][31497] {'pid': 31780, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-11-02 07:51:51,061 [salt.state       ][INFO    ][31497] Completed state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 07:51:51.061014 duration_in_ms=722.672
2017-11-02 07:51:51,062 [salt.state       ][INFO    ][31497] Running state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 07:51:51.061593
2017-11-02 07:51:51,062 [salt.state       ][INFO    ][31497] Executing state cmd.run for gluster volume set 'glance' 'cluster.readdir-optimize' 'True'
2017-11-02 07:51:51,062 [salt.loaded.int.module.cmdmod][INFO    ][31497] Executing command 'gluster volume info 'glance' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-11-02 07:51:51,119 [salt.loaded.int.module.cmdmod][INFO    ][31497] Executing command 'gluster volume set 'glance' 'cluster.readdir-optimize' 'True'' in directory '/root'
2017-11-02 07:51:51,877 [salt.state       ][INFO    ][31497] {'pid': 31797, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-11-02 07:51:51,877 [salt.state       ][INFO    ][31497] Completed state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 07:51:51.877104 duration_in_ms=815.51
2017-11-02 07:51:51,878 [salt.state       ][INFO    ][31497] Running state [glance] at time 07:51:51.878264
2017-11-02 07:51:51,879 [salt.state       ][INFO    ][31497] Executing state glusterfs.started for glance
2017-11-02 07:51:51,879 [salt.loaded.int.module.cmdmod][INFO    ][31497] Executing command 'gluster --version' in directory '/root'
2017-11-02 07:51:51,892 [salt.loaded.int.module.cmdmod][INFO    ][31497] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-02 07:51:51,946 [salt.loaded.int.module.cmdmod][INFO    ][31497] Executing command 'gluster --version' in directory '/root'
2017-11-02 07:51:51,958 [salt.loaded.int.module.cmdmod][INFO    ][31497] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-02 07:51:52,018 [salt.state       ][INFO    ][31497] Volume glance is already started
2017-11-02 07:51:52,018 [salt.state       ][INFO    ][31497] Completed state [glance] at time 07:51:52.018323 duration_in_ms=140.059
2017-11-02 07:51:52,020 [salt.state       ][INFO    ][31497] Running state [keystone-keys] at time 07:51:52.019680
2017-11-02 07:51:52,020 [salt.state       ][INFO    ][31497] Executing state glusterfs.created for keystone-keys
2017-11-02 07:51:52,021 [salt.loaded.int.module.cmdmod][INFO    ][31497] Executing command 'gluster --version' in directory '/root'
2017-11-02 07:51:52,030 [salt.loaded.int.module.cmdmod][INFO    ][31497] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-02 07:51:52,081 [salt.loaded.int.module.cmdmod][INFO    ][31497] Executing command 'gluster --version' in directory '/root'
2017-11-02 07:51:52,092 [salt.loaded.int.module.cmdmod][INFO    ][31497] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-02 07:51:52,833 [salt.loaded.int.module.cmdmod][INFO    ][31497] Executing command 'gluster --version' in directory '/root'
2017-11-02 07:51:52,845 [salt.loaded.int.module.cmdmod][INFO    ][31497] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-02 07:51:56,228 [salt.loaded.int.module.cmdmod][INFO    ][31497] Executing command 'gluster --version' in directory '/root'
2017-11-02 07:51:56,240 [salt.loaded.int.module.cmdmod][INFO    ][31497] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-02 07:51:56,293 [salt.state       ][INFO    ][31497] {'new': ['glance', 'keystone-keys'], 'old': ['glance']}
2017-11-02 07:51:56,294 [salt.state       ][INFO    ][31497] Completed state [keystone-keys] at time 07:51:56.293748 duration_in_ms=4274.068
2017-11-02 07:51:56,297 [salt.state       ][INFO    ][31497] Running state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 07:51:56.296783
2017-11-02 07:51:56,297 [salt.state       ][INFO    ][31497] Executing state cmd.run for gluster volume set 'keystone-keys' 'network.remote-dio' 'True'
2017-11-02 07:51:56,298 [salt.loaded.int.module.cmdmod][INFO    ][31497] Executing command 'gluster volume info 'keystone-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-11-02 07:51:56,348 [salt.loaded.int.module.cmdmod][INFO    ][31497] Executing command 'gluster volume set 'keystone-keys' 'network.remote-dio' 'True'' in directory '/root'
2017-11-02 07:51:57,168 [salt.state       ][INFO    ][31497] {'pid': 31912, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-11-02 07:51:57,168 [salt.state       ][INFO    ][31497] Completed state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 07:51:57.168078 duration_in_ms=871.294
2017-11-02 07:51:57,169 [salt.state       ][INFO    ][31497] Running state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 07:51:57.168706
2017-11-02 07:51:57,169 [salt.state       ][INFO    ][31497] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-11-02 07:51:57,170 [salt.loaded.int.module.cmdmod][INFO    ][31497] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-11-02 07:51:57,223 [salt.loaded.int.module.cmdmod][INFO    ][31497] Executing command 'gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'' in directory '/root'
2017-11-02 07:51:57,911 [salt.state       ][INFO    ][31497] {'pid': 31929, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-11-02 07:51:57,911 [salt.state       ][INFO    ][31497] Completed state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 07:51:57.910814 duration_in_ms=742.108
2017-11-02 07:51:57,911 [salt.state       ][INFO    ][31497] Running state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 07:51:57.911418
2017-11-02 07:51:57,912 [salt.state       ][INFO    ][31497] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'
2017-11-02 07:51:57,912 [salt.loaded.int.module.cmdmod][INFO    ][31497] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-11-02 07:51:57,968 [salt.loaded.int.module.cmdmod][INFO    ][31497] Executing command 'gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'' in directory '/root'
2017-11-02 07:51:58,658 [salt.state       ][INFO    ][31497] {'pid': 31948, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-11-02 07:51:58,659 [salt.state       ][INFO    ][31497] Completed state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 07:51:58.658575 duration_in_ms=747.156
2017-11-02 07:51:58,659 [salt.state       ][INFO    ][31497] Running state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 07:51:58.659172
2017-11-02 07:51:58,659 [salt.state       ][INFO    ][31497] Executing state cmd.run for gluster volume set 'keystone-keys' 'nfs.disable' 'True'
2017-11-02 07:51:58,660 [salt.loaded.int.module.cmdmod][INFO    ][31497] Executing command 'gluster volume info 'keystone-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-11-02 07:51:58,716 [salt.loaded.int.module.cmdmod][INFO    ][31497] Executing command 'gluster volume set 'keystone-keys' 'nfs.disable' 'True'' in directory '/root'
2017-11-02 07:51:59,899 [salt.minion      ][INFO    ][23994] User sudo_ubuntu Executing command saltutil.find_job with jid 20171102075159886653
2017-11-02 07:51:59,915 [salt.minion      ][INFO    ][31978] Starting a new job with PID 31978
2017-11-02 07:51:59,927 [salt.minion      ][INFO    ][31978] Returning information for job: 20171102075159886653
2017-11-02 07:52:01,469 [salt.state       ][INFO    ][31497] {'pid': 31968, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-11-02 07:52:01,469 [salt.state       ][INFO    ][31497] Completed state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 07:52:01.469214 duration_in_ms=2810.04
2017-11-02 07:52:01,470 [salt.state       ][INFO    ][31497] Running state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 07:52:01.469822
2017-11-02 07:52:01,470 [salt.state       ][INFO    ][31497] Executing state cmd.run for gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'
2017-11-02 07:52:01,471 [salt.loaded.int.module.cmdmod][INFO    ][31497] Executing command 'gluster volume info 'keystone-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-11-02 07:52:01,530 [salt.loaded.int.module.cmdmod][INFO    ][31497] Executing command 'gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'' in directory '/root'
2017-11-02 07:52:02,199 [salt.state       ][INFO    ][31497] {'pid': 31990, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-11-02 07:52:02,199 [salt.state       ][INFO    ][31497] Completed state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 07:52:02.199228 duration_in_ms=729.405
2017-11-02 07:52:02,201 [salt.state       ][INFO    ][31497] Running state [keystone-keys] at time 07:52:02.200586
2017-11-02 07:52:02,201 [salt.state       ][INFO    ][31497] Executing state glusterfs.started for keystone-keys
2017-11-02 07:52:02,202 [salt.loaded.int.module.cmdmod][INFO    ][31497] Executing command 'gluster --version' in directory '/root'
2017-11-02 07:52:02,214 [salt.loaded.int.module.cmdmod][INFO    ][31497] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-02 07:52:02,266 [salt.loaded.int.module.cmdmod][INFO    ][31497] Executing command 'gluster --version' in directory '/root'
2017-11-02 07:52:02,277 [salt.loaded.int.module.cmdmod][INFO    ][31497] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-02 07:52:02,331 [salt.state       ][INFO    ][31497] Volume keystone-keys is already started
2017-11-02 07:52:02,332 [salt.state       ][INFO    ][31497] Completed state [keystone-keys] at time 07:52:02.331613 duration_in_ms=131.026
2017-11-02 07:52:02,333 [salt.state       ][INFO    ][31497] Running state [nova_instances] at time 07:52:02.332944
2017-11-02 07:52:02,333 [salt.state       ][INFO    ][31497] Executing state glusterfs.created for nova_instances
2017-11-02 07:52:02,334 [salt.loaded.int.module.cmdmod][INFO    ][31497] Executing command 'gluster --version' in directory '/root'
2017-11-02 07:52:02,343 [salt.loaded.int.module.cmdmod][INFO    ][31497] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-02 07:52:02,392 [salt.loaded.int.module.cmdmod][INFO    ][31497] Executing command 'gluster --version' in directory '/root'
2017-11-02 07:52:02,402 [salt.loaded.int.module.cmdmod][INFO    ][31497] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-02 07:52:03,147 [salt.loaded.int.module.cmdmod][INFO    ][31497] Executing command 'gluster --version' in directory '/root'
2017-11-02 07:52:03,159 [salt.loaded.int.module.cmdmod][INFO    ][31497] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-02 07:52:05,988 [salt.loaded.int.module.cmdmod][INFO    ][31497] Executing command 'gluster --version' in directory '/root'
2017-11-02 07:52:06,001 [salt.loaded.int.module.cmdmod][INFO    ][31497] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-02 07:52:06,053 [salt.state       ][INFO    ][31497] {'new': ['glance', 'keystone-keys', 'nova_instances'], 'old': ['glance', 'keystone-keys']}
2017-11-02 07:52:06,053 [salt.state       ][INFO    ][31497] Completed state [nova_instances] at time 07:52:06.053042 duration_in_ms=3720.096
2017-11-02 07:52:06,056 [salt.state       ][INFO    ][31497] Running state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 07:52:06.056254
2017-11-02 07:52:06,057 [salt.state       ][INFO    ][31497] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'
2017-11-02 07:52:06,057 [salt.loaded.int.module.cmdmod][INFO    ][31497] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-11-02 07:52:06,112 [salt.loaded.int.module.cmdmod][INFO    ][31497] Executing command 'gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'' in directory '/root'
2017-11-02 07:52:06,828 [salt.state       ][INFO    ][31497] {'pid': 32104, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-11-02 07:52:06,828 [salt.state       ][INFO    ][31497] Completed state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 07:52:06.827891 duration_in_ms=771.637
2017-11-02 07:52:06,829 [salt.state       ][INFO    ][31497] Running state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'On'] at time 07:52:06.828488
2017-11-02 07:52:06,829 [salt.state       ][INFO    ][31497] Executing state cmd.run for gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'On'
2017-11-02 07:52:06,829 [salt.loaded.int.module.cmdmod][INFO    ][31497] Executing command 'gluster volume info 'nova_instances' | grep 'cluster.readdir-optimize: On'' in directory '/root'
2017-11-02 07:52:06,883 [salt.loaded.int.module.cmdmod][INFO    ][31497] Executing command 'gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'On'' in directory '/root'
2017-11-02 07:52:07,588 [salt.state       ][INFO    ][31497] {'pid': 32122, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-11-02 07:52:07,588 [salt.state       ][INFO    ][31497] Completed state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'On'] at time 07:52:07.588247 duration_in_ms=759.758
2017-11-02 07:52:07,589 [salt.state       ][INFO    ][31497] Running state [gluster volume set 'nova_instances' 'network.remote-dio' 'On'] at time 07:52:07.588820
2017-11-02 07:52:07,589 [salt.state       ][INFO    ][31497] Executing state cmd.run for gluster volume set 'nova_instances' 'network.remote-dio' 'On'
2017-11-02 07:52:07,590 [salt.loaded.int.module.cmdmod][INFO    ][31497] Executing command 'gluster volume info 'nova_instances' | grep 'network.remote-dio: On'' in directory '/root'
2017-11-02 07:52:07,646 [salt.loaded.int.module.cmdmod][INFO    ][31497] Executing command 'gluster volume set 'nova_instances' 'network.remote-dio' 'On'' in directory '/root'
2017-11-02 07:52:08,297 [salt.state       ][INFO    ][31497] {'pid': 32139, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-11-02 07:52:08,298 [salt.state       ][INFO    ][31497] Completed state [gluster volume set 'nova_instances' 'network.remote-dio' 'On'] at time 07:52:08.297509 duration_in_ms=708.689
2017-11-02 07:52:08,298 [salt.state       ][INFO    ][31497] Running state [gluster volume set 'nova_instances' 'nfs.disable' 'On'] at time 07:52:08.298150
2017-11-02 07:52:08,298 [salt.state       ][INFO    ][31497] Executing state cmd.run for gluster volume set 'nova_instances' 'nfs.disable' 'On'
2017-11-02 07:52:08,299 [salt.loaded.int.module.cmdmod][INFO    ][31497] Executing command 'gluster volume info 'nova_instances' | grep 'nfs.disable: On'' in directory '/root'
2017-11-02 07:52:08,357 [salt.loaded.int.module.cmdmod][INFO    ][31497] Executing command 'gluster volume set 'nova_instances' 'nfs.disable' 'On'' in directory '/root'
2017-11-02 07:52:10,054 [salt.minion      ][INFO    ][23994] User sudo_ubuntu Executing command saltutil.find_job with jid 20171102075210034958
2017-11-02 07:52:10,070 [salt.minion      ][INFO    ][32168] Starting a new job with PID 32168
2017-11-02 07:52:10,082 [salt.minion      ][INFO    ][32168] Returning information for job: 20171102075210034958
2017-11-02 07:52:11,057 [salt.state       ][INFO    ][31497] {'pid': 32156, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-11-02 07:52:11,057 [salt.state       ][INFO    ][31497] Completed state [gluster volume set 'nova_instances' 'nfs.disable' 'On'] at time 07:52:11.057224 duration_in_ms=2759.074
2017-11-02 07:52:11,058 [salt.state       ][INFO    ][31497] Running state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 07:52:11.057821
2017-11-02 07:52:11,058 [salt.state       ][INFO    ][31497] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'
2017-11-02 07:52:11,059 [salt.loaded.int.module.cmdmod][INFO    ][31497] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-11-02 07:52:11,112 [salt.loaded.int.module.cmdmod][INFO    ][31497] Executing command 'gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'' in directory '/root'
2017-11-02 07:52:11,750 [salt.state       ][INFO    ][31497] {'pid': 32180, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-11-02 07:52:11,751 [salt.state       ][INFO    ][31497] Completed state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 07:52:11.750515 duration_in_ms=692.693
2017-11-02 07:52:11,752 [salt.state       ][INFO    ][31497] Running state [nova_instances] at time 07:52:11.751603
2017-11-02 07:52:11,752 [salt.state       ][INFO    ][31497] Executing state glusterfs.started for nova_instances
2017-11-02 07:52:11,752 [salt.loaded.int.module.cmdmod][INFO    ][31497] Executing command 'gluster --version' in directory '/root'
2017-11-02 07:52:11,764 [salt.loaded.int.module.cmdmod][INFO    ][31497] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-02 07:52:11,819 [salt.loaded.int.module.cmdmod][INFO    ][31497] Executing command 'gluster --version' in directory '/root'
2017-11-02 07:52:11,830 [salt.loaded.int.module.cmdmod][INFO    ][31497] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-02 07:52:11,885 [salt.state       ][INFO    ][31497] Volume nova_instances is already started
2017-11-02 07:52:11,885 [salt.state       ][INFO    ][31497] Completed state [nova_instances] at time 07:52:11.884968 duration_in_ms=133.365
2017-11-02 07:52:11,886 [salt.state       ][INFO    ][31497] Running state [keystone-credential-keys] at time 07:52:11.885895
2017-11-02 07:52:11,886 [salt.state       ][INFO    ][31497] Executing state glusterfs.created for keystone-credential-keys
2017-11-02 07:52:11,887 [salt.loaded.int.module.cmdmod][INFO    ][31497] Executing command 'gluster --version' in directory '/root'
2017-11-02 07:52:11,897 [salt.loaded.int.module.cmdmod][INFO    ][31497] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-02 07:52:11,947 [salt.loaded.int.module.cmdmod][INFO    ][31497] Executing command 'gluster --version' in directory '/root'
2017-11-02 07:52:11,956 [salt.loaded.int.module.cmdmod][INFO    ][31497] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-02 07:52:12,723 [salt.loaded.int.module.cmdmod][INFO    ][31497] Executing command 'gluster --version' in directory '/root'
2017-11-02 07:52:12,736 [salt.loaded.int.module.cmdmod][INFO    ][31497] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-02 07:52:15,723 [salt.loaded.int.module.cmdmod][INFO    ][31497] Executing command 'gluster --version' in directory '/root'
2017-11-02 07:52:15,736 [salt.loaded.int.module.cmdmod][INFO    ][31497] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-02 07:52:15,787 [salt.state       ][INFO    ][31497] {'new': ['glance', 'keystone-credential-keys', 'keystone-keys', 'nova_instances'], 'old': ['glance', 'keystone-keys', 'nova_instances']}
2017-11-02 07:52:15,788 [salt.state       ][INFO    ][31497] Completed state [keystone-credential-keys] at time 07:52:15.787691 duration_in_ms=3901.795
2017-11-02 07:52:15,791 [salt.state       ][INFO    ][31497] Running state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 07:52:15.791221
2017-11-02 07:52:15,792 [salt.state       ][INFO    ][31497] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'
2017-11-02 07:52:15,792 [salt.loaded.int.module.cmdmod][INFO    ][31497] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-11-02 07:52:15,847 [salt.loaded.int.module.cmdmod][INFO    ][31497] Executing command 'gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'' in directory '/root'
2017-11-02 07:52:16,518 [salt.state       ][INFO    ][31497] {'pid': 32297, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-11-02 07:52:16,519 [salt.state       ][INFO    ][31497] Completed state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 07:52:16.518689 duration_in_ms=727.467
2017-11-02 07:52:16,519 [salt.state       ][INFO    ][31497] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 07:52:16.519232
2017-11-02 07:52:16,520 [salt.state       ][INFO    ][31497] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-11-02 07:52:16,520 [salt.loaded.int.module.cmdmod][INFO    ][31497] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-11-02 07:52:16,578 [salt.loaded.int.module.cmdmod][INFO    ][31497] Executing command 'gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'' in directory '/root'
2017-11-02 07:52:17,234 [salt.state       ][INFO    ][31497] {'pid': 32314, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-11-02 07:52:17,234 [salt.state       ][INFO    ][31497] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 07:52:17.233898 duration_in_ms=714.664
2017-11-02 07:52:17,235 [salt.state       ][INFO    ][31497] Running state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 07:52:17.234473
2017-11-02 07:52:17,235 [salt.state       ][INFO    ][31497] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'
2017-11-02 07:52:17,235 [salt.loaded.int.module.cmdmod][INFO    ][31497] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-11-02 07:52:17,289 [salt.loaded.int.module.cmdmod][INFO    ][31497] Executing command 'gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'' in directory '/root'
2017-11-02 07:52:19,994 [salt.state       ][INFO    ][31497] {'pid': 32332, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-11-02 07:52:19,995 [salt.state       ][INFO    ][31497] Completed state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 07:52:19.994664 duration_in_ms=2760.189
2017-11-02 07:52:19,995 [salt.state       ][INFO    ][31497] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 07:52:19.995238
2017-11-02 07:52:19,996 [salt.state       ][INFO    ][31497] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'
2017-11-02 07:52:19,996 [salt.loaded.int.module.cmdmod][INFO    ][31497] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-11-02 07:52:20,052 [salt.loaded.int.module.cmdmod][INFO    ][31497] Executing command 'gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'' in directory '/root'
2017-11-02 07:52:20,197 [salt.minion      ][INFO    ][23994] User sudo_ubuntu Executing command saltutil.find_job with jid 20171102075220185095
2017-11-02 07:52:20,213 [salt.minion      ][INFO    ][32361] Starting a new job with PID 32361
2017-11-02 07:52:20,228 [salt.minion      ][INFO    ][32361] Returning information for job: 20171102075220185095
2017-11-02 07:52:20,758 [salt.state       ][INFO    ][31497] {'pid': 32351, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-11-02 07:52:20,758 [salt.state       ][INFO    ][31497] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 07:52:20.758103 duration_in_ms=762.865
2017-11-02 07:52:20,759 [salt.state       ][INFO    ][31497] Running state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 07:52:20.758699
2017-11-02 07:52:20,759 [salt.state       ][INFO    ][31497] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'
2017-11-02 07:52:20,760 [salt.loaded.int.module.cmdmod][INFO    ][31497] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-11-02 07:52:20,816 [salt.loaded.int.module.cmdmod][INFO    ][31497] Executing command 'gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'' in directory '/root'
2017-11-02 07:52:21,479 [salt.state       ][INFO    ][31497] {'pid': 32373, 'retcode': 0, 'stderr': '', 'stdout': 'volume set: success'}
2017-11-02 07:52:21,479 [salt.state       ][INFO    ][31497] Completed state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 07:52:21.479166 duration_in_ms=720.466
2017-11-02 07:52:21,480 [salt.state       ][INFO    ][31497] Running state [keystone-credential-keys] at time 07:52:21.480260
2017-11-02 07:52:21,481 [salt.state       ][INFO    ][31497] Executing state glusterfs.started for keystone-credential-keys
2017-11-02 07:52:21,481 [salt.loaded.int.module.cmdmod][INFO    ][31497] Executing command 'gluster --version' in directory '/root'
2017-11-02 07:52:21,493 [salt.loaded.int.module.cmdmod][INFO    ][31497] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-02 07:52:21,546 [salt.loaded.int.module.cmdmod][INFO    ][31497] Executing command 'gluster --version' in directory '/root'
2017-11-02 07:52:21,557 [salt.loaded.int.module.cmdmod][INFO    ][31497] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-02 07:52:21,612 [salt.state       ][INFO    ][31497] Volume keystone-credential-keys is already started
2017-11-02 07:52:21,612 [salt.state       ][INFO    ][31497] Completed state [keystone-credential-keys] at time 07:52:21.612414 duration_in_ms=132.153
2017-11-02 07:52:21,615 [salt.minion      ][INFO    ][31497] Returning information for job: 20171102075139706064
2017-11-02 07:52:31,660 [salt.minion      ][INFO    ][23994] User sudo_ubuntu Executing command test.ping with jid 20171102075231649731
2017-11-02 07:52:31,676 [salt.minion      ][INFO    ][32404] Starting a new job with PID 32404
2017-11-02 07:52:31,702 [salt.minion      ][INFO    ][32404] Returning information for job: 20171102075231649731
2017-11-02 07:52:31,834 [salt.minion      ][INFO    ][23994] User sudo_ubuntu Executing command cmd.run with jid 20171102075231823126
2017-11-02 07:52:31,849 [salt.minion      ][INFO    ][32409] Starting a new job with PID 32409
2017-11-02 07:52:31,853 [salt.loaded.int.module.cmdmod][INFO    ][32409] Executing command 'gluster peer status; gluster volume status' in directory '/root'
2017-11-02 07:52:31,966 [salt.minion      ][INFO    ][32409] Returning information for job: 20171102075231823126
2017-11-02 08:11:31,805 [salt.utils.schedule][INFO    ][23994] Running scheduled job: __mine_interval
2017-11-02 08:13:25,516 [salt.minion      ][INFO    ][23994] User sudo_ubuntu Executing command saltutil.refresh_pillar with jid 20171102081325502432
2017-11-02 08:13:25,535 [salt.minion      ][INFO    ][306] Starting a new job with PID 306
2017-11-02 08:13:25,547 [salt.minion      ][INFO    ][306] Returning information for job: 20171102081325502432
2017-11-02 08:16:34,322 [salt.minion      ][INFO    ][23994] User sudo_ubuntu Executing command saltutil.refresh_pillar with jid 20171102081634289466
2017-11-02 08:16:34,339 [salt.minion      ][INFO    ][402] Starting a new job with PID 402
2017-11-02 08:16:34,358 [salt.minion      ][INFO    ][402] Returning information for job: 20171102081634289466
2017-11-02 08:17:31,401 [salt.minion      ][INFO    ][23994] User sudo_ubuntu Executing command saltutil.refresh_pillar with jid 20171102081731388331
2017-11-02 08:17:31,423 [salt.minion      ][INFO    ][465] Starting a new job with PID 465
2017-11-02 08:17:31,439 [salt.minion      ][INFO    ][465] Returning information for job: 20171102081731388331
2017-11-02 08:51:39,215 [salt.minion      ][INFO    ][23994] User sudo_ubuntu Executing command test.ping with jid 20171102085139205238
2017-11-02 08:51:39,231 [salt.minion      ][INFO    ][882] Starting a new job with PID 882
2017-11-02 08:51:39,514 [salt.minion      ][INFO    ][882] Returning information for job: 20171102085139205238
2017-11-02 08:52:00,173 [salt.minion      ][INFO    ][23994] User sudo_ubuntu Executing command state.sls with jid 20171102085200162085
2017-11-02 08:52:00,188 [salt.minion      ][INFO    ][904] Starting a new job with PID 904
2017-11-02 08:52:00,806 [salt.state       ][INFO    ][904] Loading fresh modules for state activity
2017-11-02 08:52:00,850 [salt.fileclient  ][INFO    ][904] Fetching file from saltenv 'base', ** done ** 'keepalived/init.sls'
2017-11-02 08:52:00,870 [salt.fileclient  ][INFO    ][904] Fetching file from saltenv 'base', ** done ** 'keepalived/cluster.sls'
2017-11-02 08:52:00,902 [salt.fileclient  ][INFO    ][904] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-11-02 08:52:01,615 [salt.state       ][INFO    ][904] Running state [lsof] at time 08:52:01.614910
2017-11-02 08:52:01,615 [salt.state       ][INFO    ][904] Executing state pkg.installed for lsof
2017-11-02 08:52:01,616 [salt.loaded.int.module.cmdmod][INFO    ][904] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-02 08:52:02,253 [salt.state       ][INFO    ][904] Package lsof is already installed
2017-11-02 08:52:02,253 [salt.state       ][INFO    ][904] Completed state [lsof] at time 08:52:02.253207 duration_in_ms=638.297
2017-11-02 08:52:02,253 [salt.state       ][INFO    ][904] Running state [keepalived] at time 08:52:02.253437
2017-11-02 08:52:02,254 [salt.state       ][INFO    ][904] Executing state pkg.installed for keepalived
2017-11-02 08:52:02,256 [salt.state       ][INFO    ][904] Package keepalived is already installed
2017-11-02 08:52:02,256 [salt.state       ][INFO    ][904] Completed state [keepalived] at time 08:52:02.256361 duration_in_ms=2.923
2017-11-02 08:52:02,258 [salt.state       ][INFO    ][904] Running state [/etc/keepalived/keepalived.conf] at time 08:52:02.257859
2017-11-02 08:52:02,258 [salt.state       ][INFO    ][904] Executing state file.managed for /etc/keepalived/keepalived.conf
2017-11-02 08:52:02,286 [salt.fileclient  ][INFO    ][904] Fetching file from saltenv 'base', ** done ** 'keepalived/files/keepalived.conf'
2017-11-02 08:52:02,318 [salt.fileclient  ][INFO    ][904] Fetching file from saltenv 'base', ** done ** 'keepalived/map.jinja'
2017-11-02 08:52:02,323 [salt.state       ][INFO    ][904] File /etc/keepalived/keepalived.conf is in the correct state
2017-11-02 08:52:02,323 [salt.state       ][INFO    ][904] Completed state [/etc/keepalived/keepalived.conf] at time 08:52:02.322900 duration_in_ms=65.04
2017-11-02 08:52:02,323 [salt.state       ][INFO    ][904] Running state [keepalived] at time 08:52:02.323474
2017-11-02 08:52:02,324 [salt.state       ][INFO    ][904] Executing state service.running for keepalived
2017-11-02 08:52:02,324 [salt.loaded.int.module.cmdmod][INFO    ][904] Executing command ['systemctl', 'status', 'keepalived.service', '-n', '0'] in directory '/root'
2017-11-02 08:52:02,362 [salt.loaded.int.module.cmdmod][INFO    ][904] Executing command ['systemctl', 'is-active', 'keepalived.service'] in directory '/root'
2017-11-02 08:52:02,370 [salt.loaded.int.module.cmdmod][INFO    ][904] Executing command ['systemctl', 'is-enabled', 'keepalived.service'] in directory '/root'
2017-11-02 08:52:02,378 [salt.state       ][INFO    ][904] The service keepalived is already running
2017-11-02 08:52:02,378 [salt.state       ][INFO    ][904] Completed state [keepalived] at time 08:52:02.377799 duration_in_ms=54.324
2017-11-02 08:52:02,379 [salt.minion      ][INFO    ][904] Returning information for job: 20171102085200162085
2017-11-02 08:52:16,932 [salt.minion      ][INFO    ][23994] User sudo_ubuntu Executing command pillar.get with jid 20171102085216922235
2017-11-02 08:52:16,953 [salt.minion      ][INFO    ][933] Starting a new job with PID 933
2017-11-02 08:52:17,020 [salt.minion      ][INFO    ][933] Returning information for job: 20171102085216922235
2017-11-02 08:52:55,043 [salt.minion      ][INFO    ][23994] User sudo_ubuntu Executing command state.sls with jid 20171102085255034149
2017-11-02 08:52:55,064 [salt.minion      ][INFO    ][941] Starting a new job with PID 941
2017-11-02 08:52:57,501 [salt.state       ][INFO    ][941] Loading fresh modules for state activity
2017-11-02 08:52:57,524 [salt.fileclient  ][INFO    ][941] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-11-02 08:52:57,545 [salt.fileclient  ][INFO    ][941] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-11-02 08:52:58,246 [salt.state       ][INFO    ][941] Running state [attr] at time 08:52:58.245494
2017-11-02 08:52:58,246 [salt.state       ][INFO    ][941] Executing state pkg.installed for attr
2017-11-02 08:52:58,246 [salt.loaded.int.module.cmdmod][INFO    ][941] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-02 08:52:58,525 [salt.state       ][INFO    ][941] Package attr is already installed
2017-11-02 08:52:58,525 [salt.state       ][INFO    ][941] Completed state [attr] at time 08:52:58.525104 duration_in_ms=279.611
2017-11-02 08:52:58,525 [salt.state       ][INFO    ][941] Running state [glusterfs-server] at time 08:52:58.525293
2017-11-02 08:52:58,525 [salt.state       ][INFO    ][941] Executing state pkg.installed for glusterfs-server
2017-11-02 08:52:58,528 [salt.state       ][INFO    ][941] Package glusterfs-server is already installed
2017-11-02 08:52:58,528 [salt.state       ][INFO    ][941] Completed state [glusterfs-server] at time 08:52:58.528128 duration_in_ms=2.835
2017-11-02 08:52:58,528 [salt.state       ][INFO    ][941] Running state [bc] at time 08:52:58.528264
2017-11-02 08:52:58,528 [salt.state       ][INFO    ][941] Executing state pkg.installed for bc
2017-11-02 08:52:58,531 [salt.state       ][INFO    ][941] Package bc is already installed
2017-11-02 08:52:58,531 [salt.state       ][INFO    ][941] Completed state [bc] at time 08:52:58.531009 duration_in_ms=2.745
2017-11-02 08:52:58,532 [salt.state       ][INFO    ][941] Running state [glusterfs-server] at time 08:52:58.531624
2017-11-02 08:52:58,532 [salt.state       ][INFO    ][941] Executing state service.running for glusterfs-server
2017-11-02 08:52:58,532 [salt.loaded.int.module.cmdmod][INFO    ][941] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-11-02 08:52:58,548 [salt.loaded.int.module.cmdmod][INFO    ][941] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-11-02 08:52:58,554 [salt.loaded.int.module.cmdmod][INFO    ][941] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-11-02 08:52:58,590 [salt.state       ][INFO    ][941] The service glusterfs-server is already running
2017-11-02 08:52:58,590 [salt.state       ][INFO    ][941] Completed state [glusterfs-server] at time 08:52:58.590408 duration_in_ms=58.784
2017-11-02 08:52:58,592 [salt.state       ][INFO    ][941] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 08:52:58.592072
2017-11-02 08:52:58,592 [salt.state       ][INFO    ][941] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-11-02 08:52:58,605 [salt.state       ][INFO    ][941] File /etc/systemd/system/glusterfs-server.service.d/override.conf is in the correct state
2017-11-02 08:52:58,606 [salt.state       ][INFO    ][941] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 08:52:58.605549 duration_in_ms=13.478
2017-11-02 08:52:58,606 [salt.state       ][INFO    ][941] Running state [/srv/glusterfs/glance] at time 08:52:58.605762
2017-11-02 08:52:58,606 [salt.state       ][INFO    ][941] Executing state file.directory for /srv/glusterfs/glance
2017-11-02 08:52:58,606 [salt.state       ][INFO    ][941] Directory /srv/glusterfs/glance is in the correct state
2017-11-02 08:52:58,607 [salt.state       ][INFO    ][941] Completed state [/srv/glusterfs/glance] at time 08:52:58.606629 duration_in_ms=0.866
2017-11-02 08:52:58,607 [salt.state       ][INFO    ][941] Running state [/srv/glusterfs/keystone-keys] at time 08:52:58.606819
2017-11-02 08:52:58,607 [salt.state       ][INFO    ][941] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-11-02 08:52:58,607 [salt.state       ][INFO    ][941] Directory /srv/glusterfs/keystone-keys is in the correct state
2017-11-02 08:52:58,608 [salt.state       ][INFO    ][941] Completed state [/srv/glusterfs/keystone-keys] at time 08:52:58.607591 duration_in_ms=0.772
2017-11-02 08:52:58,608 [salt.state       ][INFO    ][941] Running state [/srv/glusterfs/nova_instances] at time 08:52:58.607778
2017-11-02 08:52:58,608 [salt.state       ][INFO    ][941] Executing state file.directory for /srv/glusterfs/nova_instances
2017-11-02 08:52:58,608 [salt.state       ][INFO    ][941] Directory /srv/glusterfs/nova_instances is in the correct state
2017-11-02 08:52:58,609 [salt.state       ][INFO    ][941] Completed state [/srv/glusterfs/nova_instances] at time 08:52:58.608569 duration_in_ms=0.791
2017-11-02 08:52:58,609 [salt.state       ][INFO    ][941] Running state [/srv/glusterfs/keystone-credential-keys] at time 08:52:58.608757
2017-11-02 08:52:58,609 [salt.state       ][INFO    ][941] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-11-02 08:52:58,609 [salt.state       ][INFO    ][941] Directory /srv/glusterfs/keystone-credential-keys is in the correct state
2017-11-02 08:52:58,610 [salt.state       ][INFO    ][941] Completed state [/srv/glusterfs/keystone-credential-keys] at time 08:52:58.609558 duration_in_ms=0.8
2017-11-02 08:52:58,610 [salt.minion      ][INFO    ][941] Returning information for job: 20171102085255034149
2017-11-02 08:52:59,766 [salt.minion      ][INFO    ][23994] User sudo_ubuntu Executing command test.ping with jid 20171102085259760387
2017-11-02 08:52:59,785 [salt.minion      ][INFO    ][968] Starting a new job with PID 968
2017-11-02 08:52:59,811 [salt.minion      ][INFO    ][968] Returning information for job: 20171102085259760387
2017-11-02 08:52:59,939 [salt.minion      ][INFO    ][23994] User sudo_ubuntu Executing command state.sls with jid 20171102085259927440
2017-11-02 08:52:59,952 [salt.minion      ][INFO    ][973] Starting a new job with PID 973
2017-11-02 08:53:00,389 [salt.state       ][INFO    ][973] Loading fresh modules for state activity
2017-11-02 08:53:00,411 [salt.fileclient  ][INFO    ][973] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/setup.sls'
2017-11-02 08:53:00,442 [salt.fileclient  ][INFO    ][973] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-11-02 08:53:00,503 [salt.fileclient  ][INFO    ][973] Fetching file from saltenv 'base', ** done ** 'glusterfs/server/service.sls'
2017-11-02 08:53:00,522 [salt.fileclient  ][INFO    ][973] Fetching file from saltenv 'base', ** done ** 'glusterfs/map.jinja'
2017-11-02 08:53:00,780 [salt.state       ][INFO    ][973] Running state [attr] at time 08:53:00.779787
2017-11-02 08:53:00,780 [salt.state       ][INFO    ][973] Executing state pkg.installed for attr
2017-11-02 08:53:00,780 [salt.loaded.int.module.cmdmod][INFO    ][973] Executing command ['dpkg-query', '--showformat', '${Status} ${Package} ${Version} ${Architecture}\n', '-W'] in directory '/root'
2017-11-02 08:53:01,058 [salt.state       ][INFO    ][973] Package attr is already installed
2017-11-02 08:53:01,059 [salt.state       ][INFO    ][973] Completed state [attr] at time 08:53:01.058603 duration_in_ms=278.816
2017-11-02 08:53:01,059 [salt.state       ][INFO    ][973] Running state [glusterfs-server] at time 08:53:01.058804
2017-11-02 08:53:01,059 [salt.state       ][INFO    ][973] Executing state pkg.installed for glusterfs-server
2017-11-02 08:53:01,062 [salt.state       ][INFO    ][973] Package glusterfs-server is already installed
2017-11-02 08:53:01,062 [salt.state       ][INFO    ][973] Completed state [glusterfs-server] at time 08:53:01.061689 duration_in_ms=2.885
2017-11-02 08:53:01,062 [salt.state       ][INFO    ][973] Running state [bc] at time 08:53:01.061831
2017-11-02 08:53:01,062 [salt.state       ][INFO    ][973] Executing state pkg.installed for bc
2017-11-02 08:53:01,065 [salt.state       ][INFO    ][973] Package bc is already installed
2017-11-02 08:53:01,065 [salt.state       ][INFO    ][973] Completed state [bc] at time 08:53:01.064648 duration_in_ms=2.816
2017-11-02 08:53:01,065 [salt.state       ][INFO    ][973] Running state [glusterfs-server] at time 08:53:01.065452
2017-11-02 08:53:01,066 [salt.state       ][INFO    ][973] Executing state service.running for glusterfs-server
2017-11-02 08:53:01,066 [salt.loaded.int.module.cmdmod][INFO    ][973] Executing command ['systemctl', 'status', 'glusterfs-server.service', '-n', '0'] in directory '/root'
2017-11-02 08:53:01,082 [salt.loaded.int.module.cmdmod][INFO    ][973] Executing command ['systemctl', 'is-active', 'glusterfs-server.service'] in directory '/root'
2017-11-02 08:53:01,089 [salt.loaded.int.module.cmdmod][INFO    ][973] Executing command ['systemctl', 'is-enabled', 'glusterfs-server.service'] in directory '/root'
2017-11-02 08:53:01,099 [salt.state       ][INFO    ][973] The service glusterfs-server is already running
2017-11-02 08:53:01,099 [salt.state       ][INFO    ][973] Completed state [glusterfs-server] at time 08:53:01.099188 duration_in_ms=33.736
2017-11-02 08:53:01,101 [salt.state       ][INFO    ][973] Running state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 08:53:01.100554
2017-11-02 08:53:01,101 [salt.state       ][INFO    ][973] Executing state file.managed for /etc/systemd/system/glusterfs-server.service.d/override.conf
2017-11-02 08:53:01,109 [salt.state       ][INFO    ][973] File /etc/systemd/system/glusterfs-server.service.d/override.conf is in the correct state
2017-11-02 08:53:01,110 [salt.state       ][INFO    ][973] Completed state [/etc/systemd/system/glusterfs-server.service.d/override.conf] at time 08:53:01.109521 duration_in_ms=8.965
2017-11-02 08:53:01,110 [salt.state       ][INFO    ][973] Running state [/srv/glusterfs/glance] at time 08:53:01.109718
2017-11-02 08:53:01,110 [salt.state       ][INFO    ][973] Executing state file.directory for /srv/glusterfs/glance
2017-11-02 08:53:01,110 [salt.state       ][INFO    ][973] Directory /srv/glusterfs/glance is in the correct state
2017-11-02 08:53:01,110 [salt.state       ][INFO    ][973] Completed state [/srv/glusterfs/glance] at time 08:53:01.110396 duration_in_ms=0.678
2017-11-02 08:53:01,111 [salt.state       ][INFO    ][973] Running state [/srv/glusterfs/keystone-keys] at time 08:53:01.110561
2017-11-02 08:53:01,111 [salt.state       ][INFO    ][973] Executing state file.directory for /srv/glusterfs/keystone-keys
2017-11-02 08:53:01,111 [salt.state       ][INFO    ][973] Directory /srv/glusterfs/keystone-keys is in the correct state
2017-11-02 08:53:01,111 [salt.state       ][INFO    ][973] Completed state [/srv/glusterfs/keystone-keys] at time 08:53:01.111194 duration_in_ms=0.632
2017-11-02 08:53:01,111 [salt.state       ][INFO    ][973] Running state [/srv/glusterfs/nova_instances] at time 08:53:01.111354
2017-11-02 08:53:01,112 [salt.state       ][INFO    ][973] Executing state file.directory for /srv/glusterfs/nova_instances
2017-11-02 08:53:01,112 [salt.state       ][INFO    ][973] Directory /srv/glusterfs/nova_instances is in the correct state
2017-11-02 08:53:01,112 [salt.state       ][INFO    ][973] Completed state [/srv/glusterfs/nova_instances] at time 08:53:01.111991 duration_in_ms=0.636
2017-11-02 08:53:01,112 [salt.state       ][INFO    ][973] Running state [/srv/glusterfs/keystone-credential-keys] at time 08:53:01.112151
2017-11-02 08:53:01,112 [salt.state       ][INFO    ][973] Executing state file.directory for /srv/glusterfs/keystone-credential-keys
2017-11-02 08:53:01,113 [salt.state       ][INFO    ][973] Directory /srv/glusterfs/keystone-credential-keys is in the correct state
2017-11-02 08:53:01,113 [salt.state       ][INFO    ][973] Completed state [/srv/glusterfs/keystone-credential-keys] at time 08:53:01.112784 duration_in_ms=0.633
2017-11-02 08:53:01,249 [salt.loaded.int.module.cmdmod][INFO    ][973] Executing command ['git', '--version'] in directory '/root'
2017-11-02 08:53:01,422 [salt.state       ][INFO    ][973] Running state [sleep 5] at time 08:53:01.421458
2017-11-02 08:53:01,422 [salt.state       ][INFO    ][973] Executing state cmd.wait for sleep 5
2017-11-02 08:53:01,422 [salt.state       ][INFO    ][973] No changes made for sleep 5
2017-11-02 08:53:01,422 [salt.state       ][INFO    ][973] Completed state [sleep 5] at time 08:53:01.422223 duration_in_ms=0.767
2017-11-02 08:53:01,423 [salt.state       ][INFO    ][973] Running state [10.167.4.141] at time 08:53:01.422669
2017-11-02 08:53:01,423 [salt.state       ][INFO    ][973] Executing state glusterfs.peered for 10.167.4.141
2017-11-02 08:53:01,423 [salt.loaded.int.module.cmdmod][INFO    ][973] Executing command 'gluster --version' in directory '/root'
2017-11-02 08:53:01,434 [salt.loaded.int.module.cmdmod][INFO    ][973] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-02 08:53:01,676 [salt.state       ][INFO    ][973] Host 10.167.4.141 already peered
2017-11-02 08:53:01,676 [salt.state       ][INFO    ][973] Completed state [10.167.4.141] at time 08:53:01.676111 duration_in_ms=253.441
2017-11-02 08:53:01,679 [salt.state       ][INFO    ][973] Running state [10.167.4.142] at time 08:53:01.678602
2017-11-02 08:53:01,679 [salt.state       ][INFO    ][973] Executing state glusterfs.peered for 10.167.4.142
2017-11-02 08:53:01,679 [salt.loaded.int.module.cmdmod][INFO    ][973] Executing command 'gluster --version' in directory '/root'
2017-11-02 08:53:01,689 [salt.loaded.int.module.cmdmod][INFO    ][973] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-02 08:53:01,740 [salt.loaded.int.module.cmdmod][INFO    ][973] Executing command 'gluster --version' in directory '/root'
2017-11-02 08:53:01,748 [salt.loaded.int.module.cmdmod][INFO    ][973] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-02 08:53:01,805 [salt.loaded.int.module.cmdmod][INFO    ][973] Executing command 'gluster --version' in directory '/root'
2017-11-02 08:53:01,815 [salt.loaded.int.module.cmdmod][INFO    ][973] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-02 08:53:01,871 [salt.loaded.int.module.cmdmod][INFO    ][973] Executing command 'gluster --version' in directory '/root'
2017-11-02 08:53:01,879 [salt.loaded.int.module.cmdmod][INFO    ][973] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-02 08:53:01,930 [salt.state       ][INFO    ][973] Peering with localhost is not needed
2017-11-02 08:53:01,930 [salt.state       ][INFO    ][973] Completed state [10.167.4.142] at time 08:53:01.930075 duration_in_ms=251.473
2017-11-02 08:53:01,932 [salt.state       ][INFO    ][973] Running state [10.167.4.143] at time 08:53:01.932429
2017-11-02 08:53:01,933 [salt.state       ][INFO    ][973] Executing state glusterfs.peered for 10.167.4.143
2017-11-02 08:53:01,933 [salt.loaded.int.module.cmdmod][INFO    ][973] Executing command 'gluster --version' in directory '/root'
2017-11-02 08:53:01,942 [salt.loaded.int.module.cmdmod][INFO    ][973] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-02 08:53:01,991 [salt.state       ][INFO    ][973] Host 10.167.4.143 already peered
2017-11-02 08:53:01,992 [salt.state       ][INFO    ][973] Completed state [10.167.4.143] at time 08:53:01.991487 duration_in_ms=59.058
2017-11-02 08:53:01,992 [salt.state       ][INFO    ][973] Running state [glance] at time 08:53:01.992333
2017-11-02 08:53:01,993 [salt.state       ][INFO    ][973] Executing state glusterfs.created for glance
2017-11-02 08:53:01,993 [salt.loaded.int.module.cmdmod][INFO    ][973] Executing command 'gluster --version' in directory '/root'
2017-11-02 08:53:02,002 [salt.loaded.int.module.cmdmod][INFO    ][973] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-02 08:53:02,051 [salt.loaded.int.module.cmdmod][INFO    ][973] Executing command 'gluster --version' in directory '/root'
2017-11-02 08:53:02,060 [salt.loaded.int.module.cmdmod][INFO    ][973] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-02 08:53:02,116 [salt.state       ][INFO    ][973] Volume glance already exists and is started.
2017-11-02 08:53:02,116 [salt.state       ][INFO    ][973] Completed state [glance] at time 08:53:02.116328 duration_in_ms=123.995
2017-11-02 08:53:02,119 [salt.state       ][INFO    ][973] Running state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 08:53:02.119125
2017-11-02 08:53:02,119 [salt.state       ][INFO    ][973] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'
2017-11-02 08:53:02,120 [salt.loaded.int.module.cmdmod][INFO    ][973] Executing command 'gluster volume info 'glance' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-11-02 08:53:02,171 [salt.state       ][INFO    ][973] unless execution succeeded
2017-11-02 08:53:02,171 [salt.state       ][INFO    ][973] Completed state [gluster volume set 'glance' 'diagnostics.brick-log-level' 'WARNING'] at time 08:53:02.170956 duration_in_ms=51.831
2017-11-02 08:53:02,171 [salt.state       ][INFO    ][973] Running state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 08:53:02.171410
2017-11-02 08:53:02,172 [salt.state       ][INFO    ][973] Executing state cmd.run for gluster volume set 'glance' 'network.remote-dio' 'True'
2017-11-02 08:53:02,172 [salt.loaded.int.module.cmdmod][INFO    ][973] Executing command 'gluster volume info 'glance' | grep 'network.remote-dio: True'' in directory '/root'
2017-11-02 08:53:02,222 [salt.state       ][INFO    ][973] unless execution succeeded
2017-11-02 08:53:02,222 [salt.state       ][INFO    ][973] Completed state [gluster volume set 'glance' 'network.remote-dio' 'True'] at time 08:53:02.222210 duration_in_ms=50.798
2017-11-02 08:53:02,223 [salt.state       ][INFO    ][973] Running state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 08:53:02.222682
2017-11-02 08:53:02,223 [salt.state       ][INFO    ][973] Executing state cmd.run for gluster volume set 'glance' 'nfs.disable' 'True'
2017-11-02 08:53:02,223 [salt.loaded.int.module.cmdmod][INFO    ][973] Executing command 'gluster volume info 'glance' | grep 'nfs.disable: True'' in directory '/root'
2017-11-02 08:53:02,271 [salt.state       ][INFO    ][973] unless execution succeeded
2017-11-02 08:53:02,271 [salt.state       ][INFO    ][973] Completed state [gluster volume set 'glance' 'nfs.disable' 'True'] at time 08:53:02.271259 duration_in_ms=48.577
2017-11-02 08:53:02,272 [salt.state       ][INFO    ][973] Running state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 08:53:02.271708
2017-11-02 08:53:02,272 [salt.state       ][INFO    ][973] Executing state cmd.run for gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'
2017-11-02 08:53:02,272 [salt.loaded.int.module.cmdmod][INFO    ][973] Executing command 'gluster volume info 'glance' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-11-02 08:53:02,321 [salt.state       ][INFO    ][973] unless execution succeeded
2017-11-02 08:53:02,321 [salt.state       ][INFO    ][973] Completed state [gluster volume set 'glance' 'diagnostics.client-log-level' 'WARNING'] at time 08:53:02.321452 duration_in_ms=49.744
2017-11-02 08:53:02,322 [salt.state       ][INFO    ][973] Running state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 08:53:02.321941
2017-11-02 08:53:02,322 [salt.state       ][INFO    ][973] Executing state cmd.run for gluster volume set 'glance' 'cluster.readdir-optimize' 'True'
2017-11-02 08:53:02,323 [salt.loaded.int.module.cmdmod][INFO    ][973] Executing command 'gluster volume info 'glance' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-11-02 08:53:02,372 [salt.state       ][INFO    ][973] unless execution succeeded
2017-11-02 08:53:02,373 [salt.state       ][INFO    ][973] Completed state [gluster volume set 'glance' 'cluster.readdir-optimize' 'True'] at time 08:53:02.372516 duration_in_ms=50.575
2017-11-02 08:53:02,373 [salt.state       ][INFO    ][973] Running state [glance] at time 08:53:02.373467
2017-11-02 08:53:02,374 [salt.state       ][INFO    ][973] Executing state glusterfs.started for glance
2017-11-02 08:53:02,374 [salt.loaded.int.module.cmdmod][INFO    ][973] Executing command 'gluster --version' in directory '/root'
2017-11-02 08:53:02,381 [salt.loaded.int.module.cmdmod][INFO    ][973] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-02 08:53:02,430 [salt.loaded.int.module.cmdmod][INFO    ][973] Executing command 'gluster --version' in directory '/root'
2017-11-02 08:53:02,436 [salt.loaded.int.module.cmdmod][INFO    ][973] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-02 08:53:02,486 [salt.state       ][INFO    ][973] Volume glance is already started
2017-11-02 08:53:02,486 [salt.state       ][INFO    ][973] Completed state [glance] at time 08:53:02.486064 duration_in_ms=112.596
2017-11-02 08:53:02,487 [salt.state       ][INFO    ][973] Running state [keystone-keys] at time 08:53:02.486849
2017-11-02 08:53:02,487 [salt.state       ][INFO    ][973] Executing state glusterfs.created for keystone-keys
2017-11-02 08:53:02,487 [salt.loaded.int.module.cmdmod][INFO    ][973] Executing command 'gluster --version' in directory '/root'
2017-11-02 08:53:02,495 [salt.loaded.int.module.cmdmod][INFO    ][973] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-02 08:53:02,541 [salt.loaded.int.module.cmdmod][INFO    ][973] Executing command 'gluster --version' in directory '/root'
2017-11-02 08:53:02,548 [salt.loaded.int.module.cmdmod][INFO    ][973] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-02 08:53:02,597 [salt.state       ][INFO    ][973] Volume keystone-keys already exists and is started.
2017-11-02 08:53:02,597 [salt.state       ][INFO    ][973] Completed state [keystone-keys] at time 08:53:02.597031 duration_in_ms=110.181
2017-11-02 08:53:02,600 [salt.state       ][INFO    ][973] Running state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 08:53:02.600109
2017-11-02 08:53:02,600 [salt.state       ][INFO    ][973] Executing state cmd.run for gluster volume set 'keystone-keys' 'network.remote-dio' 'True'
2017-11-02 08:53:02,601 [salt.loaded.int.module.cmdmod][INFO    ][973] Executing command 'gluster volume info 'keystone-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-11-02 08:53:02,648 [salt.state       ][INFO    ][973] unless execution succeeded
2017-11-02 08:53:02,648 [salt.state       ][INFO    ][973] Completed state [gluster volume set 'keystone-keys' 'network.remote-dio' 'True'] at time 08:53:02.648082 duration_in_ms=47.972
2017-11-02 08:53:02,649 [salt.state       ][INFO    ][973] Running state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 08:53:02.648505
2017-11-02 08:53:02,649 [salt.state       ][INFO    ][973] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-11-02 08:53:02,649 [salt.loaded.int.module.cmdmod][INFO    ][973] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-11-02 08:53:02,693 [salt.state       ][INFO    ][973] unless execution succeeded
2017-11-02 08:53:02,694 [salt.state       ][INFO    ][973] Completed state [gluster volume set 'keystone-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 08:53:02.693504 duration_in_ms=44.998
2017-11-02 08:53:02,694 [salt.state       ][INFO    ][973] Running state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 08:53:02.693964
2017-11-02 08:53:02,694 [salt.state       ][INFO    ][973] Executing state cmd.run for gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'
2017-11-02 08:53:02,695 [salt.loaded.int.module.cmdmod][INFO    ][973] Executing command 'gluster volume info 'keystone-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-11-02 08:53:02,739 [salt.state       ][INFO    ][973] unless execution succeeded
2017-11-02 08:53:02,739 [salt.state       ][INFO    ][973] Completed state [gluster volume set 'keystone-keys' 'diagnostics.client-log-level' 'WARNING'] at time 08:53:02.739302 duration_in_ms=45.338
2017-11-02 08:53:02,740 [salt.state       ][INFO    ][973] Running state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 08:53:02.739753
2017-11-02 08:53:02,740 [salt.state       ][INFO    ][973] Executing state cmd.run for gluster volume set 'keystone-keys' 'nfs.disable' 'True'
2017-11-02 08:53:02,740 [salt.loaded.int.module.cmdmod][INFO    ][973] Executing command 'gluster volume info 'keystone-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-11-02 08:53:02,787 [salt.state       ][INFO    ][973] unless execution succeeded
2017-11-02 08:53:02,787 [salt.state       ][INFO    ][973] Completed state [gluster volume set 'keystone-keys' 'nfs.disable' 'True'] at time 08:53:02.787318 duration_in_ms=47.564
2017-11-02 08:53:02,788 [salt.state       ][INFO    ][973] Running state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 08:53:02.787762
2017-11-02 08:53:02,788 [salt.state       ][INFO    ][973] Executing state cmd.run for gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'
2017-11-02 08:53:02,788 [salt.loaded.int.module.cmdmod][INFO    ][973] Executing command 'gluster volume info 'keystone-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-11-02 08:53:02,838 [salt.state       ][INFO    ][973] unless execution succeeded
2017-11-02 08:53:02,838 [salt.state       ][INFO    ][973] Completed state [gluster volume set 'keystone-keys' 'cluster.readdir-optimize' 'True'] at time 08:53:02.838109 duration_in_ms=50.347
2017-11-02 08:53:02,839 [salt.state       ][INFO    ][973] Running state [keystone-keys] at time 08:53:02.839042
2017-11-02 08:53:02,839 [salt.state       ][INFO    ][973] Executing state glusterfs.started for keystone-keys
2017-11-02 08:53:02,840 [salt.loaded.int.module.cmdmod][INFO    ][973] Executing command 'gluster --version' in directory '/root'
2017-11-02 08:53:02,846 [salt.loaded.int.module.cmdmod][INFO    ][973] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-02 08:53:02,891 [salt.loaded.int.module.cmdmod][INFO    ][973] Executing command 'gluster --version' in directory '/root'
2017-11-02 08:53:02,899 [salt.loaded.int.module.cmdmod][INFO    ][973] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-02 08:53:02,950 [salt.state       ][INFO    ][973] Volume keystone-keys is already started
2017-11-02 08:53:02,950 [salt.state       ][INFO    ][973] Completed state [keystone-keys] at time 08:53:02.949721 duration_in_ms=110.678
2017-11-02 08:53:02,951 [salt.state       ][INFO    ][973] Running state [nova_instances] at time 08:53:02.950520
2017-11-02 08:53:02,951 [salt.state       ][INFO    ][973] Executing state glusterfs.created for nova_instances
2017-11-02 08:53:02,951 [salt.loaded.int.module.cmdmod][INFO    ][973] Executing command 'gluster --version' in directory '/root'
2017-11-02 08:53:02,957 [salt.loaded.int.module.cmdmod][INFO    ][973] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-02 08:53:03,002 [salt.loaded.int.module.cmdmod][INFO    ][973] Executing command 'gluster --version' in directory '/root'
2017-11-02 08:53:03,009 [salt.loaded.int.module.cmdmod][INFO    ][973] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-02 08:53:03,059 [salt.state       ][INFO    ][973] Volume nova_instances already exists and is started.
2017-11-02 08:53:03,059 [salt.state       ][INFO    ][973] Completed state [nova_instances] at time 08:53:03.059030 duration_in_ms=108.509
2017-11-02 08:53:03,062 [salt.state       ][INFO    ][973] Running state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 08:53:03.061947
2017-11-02 08:53:03,062 [salt.state       ][INFO    ][973] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'
2017-11-02 08:53:03,063 [salt.loaded.int.module.cmdmod][INFO    ][973] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-11-02 08:53:03,111 [salt.state       ][INFO    ][973] unless execution succeeded
2017-11-02 08:53:03,111 [salt.state       ][INFO    ][973] Completed state [gluster volume set 'nova_instances' 'diagnostics.brick-log-level' 'WARNING'] at time 08:53:03.110752 duration_in_ms=48.805
2017-11-02 08:53:03,111 [salt.state       ][INFO    ][973] Running state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'On'] at time 08:53:03.111239
2017-11-02 08:53:03,111 [salt.state       ][INFO    ][973] Executing state cmd.run for gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'On'
2017-11-02 08:53:03,112 [salt.loaded.int.module.cmdmod][INFO    ][973] Executing command 'gluster volume info 'nova_instances' | grep 'cluster.readdir-optimize: On'' in directory '/root'
2017-11-02 08:53:03,158 [salt.state       ][INFO    ][973] unless execution succeeded
2017-11-02 08:53:03,159 [salt.state       ][INFO    ][973] Completed state [gluster volume set 'nova_instances' 'cluster.readdir-optimize' 'On'] at time 08:53:03.158472 duration_in_ms=47.233
2017-11-02 08:53:03,159 [salt.state       ][INFO    ][973] Running state [gluster volume set 'nova_instances' 'network.remote-dio' 'On'] at time 08:53:03.158931
2017-11-02 08:53:03,159 [salt.state       ][INFO    ][973] Executing state cmd.run for gluster volume set 'nova_instances' 'network.remote-dio' 'On'
2017-11-02 08:53:03,160 [salt.loaded.int.module.cmdmod][INFO    ][973] Executing command 'gluster volume info 'nova_instances' | grep 'network.remote-dio: On'' in directory '/root'
2017-11-02 08:53:03,206 [salt.state       ][INFO    ][973] unless execution succeeded
2017-11-02 08:53:03,207 [salt.state       ][INFO    ][973] Completed state [gluster volume set 'nova_instances' 'network.remote-dio' 'On'] at time 08:53:03.206532 duration_in_ms=47.601
2017-11-02 08:53:03,207 [salt.state       ][INFO    ][973] Running state [gluster volume set 'nova_instances' 'nfs.disable' 'On'] at time 08:53:03.206979
2017-11-02 08:53:03,207 [salt.state       ][INFO    ][973] Executing state cmd.run for gluster volume set 'nova_instances' 'nfs.disable' 'On'
2017-11-02 08:53:03,208 [salt.loaded.int.module.cmdmod][INFO    ][973] Executing command 'gluster volume info 'nova_instances' | grep 'nfs.disable: On'' in directory '/root'
2017-11-02 08:53:03,255 [salt.state       ][INFO    ][973] unless execution succeeded
2017-11-02 08:53:03,255 [salt.state       ][INFO    ][973] Completed state [gluster volume set 'nova_instances' 'nfs.disable' 'On'] at time 08:53:03.254916 duration_in_ms=47.936
2017-11-02 08:53:03,255 [salt.state       ][INFO    ][973] Running state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 08:53:03.255337
2017-11-02 08:53:03,256 [salt.state       ][INFO    ][973] Executing state cmd.run for gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'
2017-11-02 08:53:03,256 [salt.loaded.int.module.cmdmod][INFO    ][973] Executing command 'gluster volume info 'nova_instances' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-11-02 08:53:03,304 [salt.state       ][INFO    ][973] unless execution succeeded
2017-11-02 08:53:03,304 [salt.state       ][INFO    ][973] Completed state [gluster volume set 'nova_instances' 'diagnostics.client-log-level' 'WARNING'] at time 08:53:03.304010 duration_in_ms=48.672
2017-11-02 08:53:03,305 [salt.state       ][INFO    ][973] Running state [nova_instances] at time 08:53:03.305008
2017-11-02 08:53:03,305 [salt.state       ][INFO    ][973] Executing state glusterfs.started for nova_instances
2017-11-02 08:53:03,306 [salt.loaded.int.module.cmdmod][INFO    ][973] Executing command 'gluster --version' in directory '/root'
2017-11-02 08:53:03,313 [salt.loaded.int.module.cmdmod][INFO    ][973] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-02 08:53:03,358 [salt.loaded.int.module.cmdmod][INFO    ][973] Executing command 'gluster --version' in directory '/root'
2017-11-02 08:53:03,373 [salt.loaded.int.module.cmdmod][INFO    ][973] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-02 08:53:03,425 [salt.state       ][INFO    ][973] Volume nova_instances is already started
2017-11-02 08:53:03,426 [salt.state       ][INFO    ][973] Completed state [nova_instances] at time 08:53:03.425573 duration_in_ms=120.564
2017-11-02 08:53:03,426 [salt.state       ][INFO    ][973] Running state [keystone-credential-keys] at time 08:53:03.426471
2017-11-02 08:53:03,427 [salt.state       ][INFO    ][973] Executing state glusterfs.created for keystone-credential-keys
2017-11-02 08:53:03,427 [salt.loaded.int.module.cmdmod][INFO    ][973] Executing command 'gluster --version' in directory '/root'
2017-11-02 08:53:03,435 [salt.loaded.int.module.cmdmod][INFO    ][973] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-02 08:53:03,482 [salt.loaded.int.module.cmdmod][INFO    ][973] Executing command 'gluster --version' in directory '/root'
2017-11-02 08:53:03,490 [salt.loaded.int.module.cmdmod][INFO    ][973] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-02 08:53:03,541 [salt.state       ][INFO    ][973] Volume keystone-credential-keys already exists and is started.
2017-11-02 08:53:03,541 [salt.state       ][INFO    ][973] Completed state [keystone-credential-keys] at time 08:53:03.541040 duration_in_ms=114.569
2017-11-02 08:53:03,544 [salt.state       ][INFO    ][973] Running state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 08:53:03.544108
2017-11-02 08:53:03,544 [salt.state       ][INFO    ][973] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'
2017-11-02 08:53:03,545 [salt.loaded.int.module.cmdmod][INFO    ][973] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'cluster.readdir-optimize: True'' in directory '/root'
2017-11-02 08:53:03,591 [salt.state       ][INFO    ][973] unless execution succeeded
2017-11-02 08:53:03,592 [salt.state       ][INFO    ][973] Completed state [gluster volume set 'keystone-credential-keys' 'cluster.readdir-optimize' 'True'] at time 08:53:03.591561 duration_in_ms=47.452
2017-11-02 08:53:03,592 [salt.state       ][INFO    ][973] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 08:53:03.592016
2017-11-02 08:53:03,592 [salt.state       ][INFO    ][973] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'
2017-11-02 08:53:03,593 [salt.loaded.int.module.cmdmod][INFO    ][973] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.brick-log-level: WARNING'' in directory '/root'
2017-11-02 08:53:03,639 [salt.state       ][INFO    ][973] unless execution succeeded
2017-11-02 08:53:03,639 [salt.state       ][INFO    ][973] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.brick-log-level' 'WARNING'] at time 08:53:03.639082 duration_in_ms=47.066
2017-11-02 08:53:03,640 [salt.state       ][INFO    ][973] Running state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 08:53:03.640002
2017-11-02 08:53:03,640 [salt.state       ][INFO    ][973] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'
2017-11-02 08:53:03,641 [salt.loaded.int.module.cmdmod][INFO    ][973] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'nfs.disable: True'' in directory '/root'
2017-11-02 08:53:03,689 [salt.state       ][INFO    ][973] unless execution succeeded
2017-11-02 08:53:03,689 [salt.state       ][INFO    ][973] Completed state [gluster volume set 'keystone-credential-keys' 'nfs.disable' 'True'] at time 08:53:03.688900 duration_in_ms=48.897
2017-11-02 08:53:03,689 [salt.state       ][INFO    ][973] Running state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 08:53:03.689302
2017-11-02 08:53:03,690 [salt.state       ][INFO    ][973] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'
2017-11-02 08:53:03,690 [salt.loaded.int.module.cmdmod][INFO    ][973] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'diagnostics.client-log-level: WARNING'' in directory '/root'
2017-11-02 08:53:03,736 [salt.state       ][INFO    ][973] unless execution succeeded
2017-11-02 08:53:03,736 [salt.state       ][INFO    ][973] Completed state [gluster volume set 'keystone-credential-keys' 'diagnostics.client-log-level' 'WARNING'] at time 08:53:03.735746 duration_in_ms=46.444
2017-11-02 08:53:03,736 [salt.state       ][INFO    ][973] Running state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 08:53:03.736176
2017-11-02 08:53:03,736 [salt.state       ][INFO    ][973] Executing state cmd.run for gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'
2017-11-02 08:53:03,737 [salt.loaded.int.module.cmdmod][INFO    ][973] Executing command 'gluster volume info 'keystone-credential-keys' | grep 'network.remote-dio: True'' in directory '/root'
2017-11-02 08:53:03,783 [salt.state       ][INFO    ][973] unless execution succeeded
2017-11-02 08:53:03,783 [salt.state       ][INFO    ][973] Completed state [gluster volume set 'keystone-credential-keys' 'network.remote-dio' 'True'] at time 08:53:03.783249 duration_in_ms=47.072
2017-11-02 08:53:03,784 [salt.state       ][INFO    ][973] Running state [keystone-credential-keys] at time 08:53:03.784268
2017-11-02 08:53:03,785 [salt.state       ][INFO    ][973] Executing state glusterfs.started for keystone-credential-keys
2017-11-02 08:53:03,785 [salt.loaded.int.module.cmdmod][INFO    ][973] Executing command 'gluster --version' in directory '/root'
2017-11-02 08:53:03,793 [salt.loaded.int.module.cmdmod][INFO    ][973] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-02 08:53:03,839 [salt.loaded.int.module.cmdmod][INFO    ][973] Executing command 'gluster --version' in directory '/root'
2017-11-02 08:53:03,847 [salt.loaded.int.module.cmdmod][INFO    ][973] Executing command 'gluster --xml --mode=script' in directory '/root'
2017-11-02 08:53:03,899 [salt.state       ][INFO    ][973] Volume keystone-credential-keys is already started
2017-11-02 08:53:03,899 [salt.state       ][INFO    ][973] Completed state [keystone-credential-keys] at time 08:53:03.898753 duration_in_ms=114.485
2017-11-02 08:53:03,901 [salt.minion      ][INFO    ][973] Returning information for job: 20171102085259927440
2017-11-02 08:53:12,717 [salt.minion      ][INFO    ][23994] User sudo_ubuntu Executing command test.ping with jid 20171102085312705635
2017-11-02 08:53:12,733 [salt.minion      ][INFO    ][1382] Starting a new job with PID 1382
2017-11-02 08:53:12,759 [salt.minion      ][INFO    ][1382] Returning information for job: 20171102085312705635
2017-11-02 08:53:12,896 [salt.minion      ][INFO    ][23994] User sudo_ubuntu Executing command cmd.run with jid 20171102085312884558
2017-11-02 08:53:12,910 [salt.minion      ][INFO    ][1387] Starting a new job with PID 1387
2017-11-02 08:53:12,914 [salt.loaded.int.module.cmdmod][INFO    ][1387] Executing command 'gluster peer status; gluster volume status' in directory '/root'
2017-11-02 08:53:13,019 [salt.minion      ][INFO    ][1387] Returning information for job: 20171102085312884558
2017-11-02 09:11:31,805 [salt.utils.schedule][INFO    ][23994] Running scheduled job: __mine_interval
2017-11-02 09:23:07,867 [salt.minion      ][INFO    ][23994] User sudo_ubuntu Executing command cp.push_dir with jid 20171102092307854808
2017-11-02 09:23:07,891 [salt.minion      ][INFO    ][1603] Starting a new job with PID 1603
